[ovirt-users] Upgrade to 3.5 issues, vm cannot be started

James James jreg2k at gmail.com
Tue Nov 11 04:58:06 EST 2014 

Hi,

today I've decided to upgrade my 3.4 Ovirt cluster to 3.5/

The engine migration was OK. Everything was good .. after I want upgraded
the node .. I've installed the rpm on the node and follow :
http://www.ovirt.org/OVirt_3.5_Release_Notes#Install_.2F_Upgrade_from_Previous_Versions
.

Now my vms cannot be started. I've got this error message :

 2014-11-11 10:49:37,305 WARN  [org.ovirt.engine.core.bll.RunVmCommand]
(org.ovirt.thread.pool-8-thread-13) CanDoAction of action RunVm failed.
Reasons:VAR__ACTION__RUN,VAR__TYPE__VM,VAR__ACTION__RUN,VAR__TYPE__VM,VAR__ACTION__RUN,VAR__TYPE__VM,VAR__ACTION__RUN,VAR__TYPE__VM,SCHEDULING_NO_HOSTS
2014-11-11 10:49:37,307 INFO  [org.ovirt.engine.core.bll.RunVmCommand]
(org.ovirt.thread.pool-8-thread-13) Lock freed to object EngineLock
[exclusiveLocks= key: 0fdea856-9aec-4300-8d88-4cfd330cf4ff value: VM
, sharedLocks= ]

There is a full log in attachment ..

Any help will be appreciated ...

James
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.ovirt.org/pipermail/users/attachments/20141111/332f4aa9/attachment-0001.html>
-------------- next part --------------
2014-11-11 10:55:21,095 INFO  [org.ovirt.engine.core.bll.RunVmCommand] (ajp--127.0.0.1-8702-2) [bab78b2] Lock Acquired to object EngineLock [exclusiveLocks= key: 0fdea856-9aec-4300-8d88-4cfd330cf4ff value: VM
, sharedLocks= ]
2014-11-11 10:55:21,150 INFO  [org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] (ajp--127.0.0.1-8702-2) [bab78b2] START, IsVmDuringInitiatingVDSCommand( vmId = 0fdea856-9aec-4300-8d88-4cfd330cf4ff), log id: 37b8c678
2014-11-11 10:55:21,151 INFO  [org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] (ajp--127.0.0.1-8702-2) [bab78b2] FINISH, IsVmDuringInitiatingVDSCommand, return: false, log id: 37b8c678
2014-11-11 10:55:21,254 INFO  [org.ovirt.engine.core.bll.RunVmCommand] (org.ovirt.thread.pool-8-thread-7) [bab78b2] Running command: RunVmCommand internal: false. Entities affected :  ID: 0fdea856-9aec-4300-8d88-4cfd330cf4ff Type: VMAction group VM_BASIC_OPERATIONS with role type USER
2014-11-11 10:55:21,352 INFO  [org.ovirt.engine.core.bll.scheduling.policyunits.HaReservationWeightPolicyUnit] (org.ovirt.thread.pool-8-thread-7) [bab78b2] Started HA reservation scoring method
2014-11-11 10:55:21,404 INFO  [org.ovirt.engine.core.vdsbroker.UpdateVmDynamicDataVDSCommand] (org.ovirt.thread.pool-8-thread-7) [bab78b2] START, UpdateVmDynamicDataVDSCommand(HostName = ovirt-node2, HostId = 051acfd2-076f-498d-adf9-4c6692f65d50, vmDynamic=org.ovirt.engine.core.common.businessentities.VmDynamic at 51e309c6), log id: 5186ff6
2014-11-11 10:55:21,407 INFO  [org.ovirt.engine.core.vdsbroker.UpdateVmDynamicDataVDSCommand] (org.ovirt.thread.pool-8-thread-7) [bab78b2] FINISH, UpdateVmDynamicDataVDSCommand, log id: 5186ff6
2014-11-11 10:55:21,438 INFO  [org.ovirt.engine.core.vdsbroker.CreateVmVDSCommand] (org.ovirt.thread.pool-8-thread-7) [bab78b2] START, CreateVmVDSCommand(HostName = ovirt-node2, HostId = 051acfd2-076f-498d-adf9-4c6692f65d50, vmId=0fdea856-9aec-4300-8d88-4cfd330cf4ff, vm=VM [puppetdb]), log id: 3685dd2b
2014-11-11 10:55:21,467 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand] (org.ovirt.thread.pool-8-thread-7) [bab78b2] START, CreateVDSCommand(HostName = ovirt-node2, HostId = 051acfd2-076f-498d-adf9-4c6692f65d50, vmId=0fdea856-9aec-4300-8d88-4cfd330cf4ff, vm=VM [puppetdb]), log id: 5d3a82e5
2014-11-11 10:55:21,493 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand] (org.ovirt.thread.pool-8-thread-7) [bab78b2] org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand kvmEnable=true,keyboardLayout=en-us,nice=0,pitReinjection=false,displayNetwork=ovirtmgmt,copyPasteEnable=true,timeOffset=0,transparentHugePages=true,vmId=0fdea856-9aec-4300-8d88-4cfd330cf4ff,acpiEnable=true,custom={device_2837bb81-e830-4014-9cba-b95e76c8785bdevice_87f78a45-040c-4534-a19a-e7ba97f3721fdevice_b97a2abb-a9a7-4137-bc47-04ab5cb7a0b7=VmDevice {vmId=0fdea856-9aec-4300-8d88-4cfd330cf4ff, deviceId=b97a2abb-a9a7-4137-bc47-04ab5cb7a0b7, device=spicevmc, type=CHANNEL, bootOrder=0, specParams={}, address={port=3, bus=0, controller=0, type=virtio-serial}, managed=false, plugged=true, readOnly=false, deviceAlias=channel2, customProperties={}, snapshotId=null}, device_2837bb81-e830-4014-9cba-b95e76c8785bdevice_87f78a45-040c-4534-a19a-e7ba97f3721f=VmDevice {vmId=0fdea856-9aec-4300-8d88-4cfd330cf4ff, deviceId=87f78a45-040c-4534-a19a-e7ba97f3721f, device=unix, type=CHANNEL, bootOrder=0, specParams={}, address={port=2, bus=0, controller=0, type=virtio-serial}, managed=false, plugged=true, readOnly=false, deviceAlias=channel1, customProperties={}, snapshotId=null}, device_2837bb81-e830-4014-9cba-b95e76c8785b=VmDevice {vmId=0fdea856-9aec-4300-8d88-4cfd330cf4ff, deviceId=2837bb81-e830-4014-9cba-b95e76c8785b, device=unix, type=CHANNEL, bootOrder=0, specParams={}, address={port=1, bus=0, controller=0, type=virtio-serial}, managed=false, plugged=true, readOnly=false, deviceAlias=channel0, customProperties={}, snapshotId=null}, device_2837bb81-e830-4014-9cba-b95e76c8785bdevice_87f78a45-040c-4534-a19a-e7ba97f3721fdevice_b97a2abb-a9a7-4137-bc47-04ab5cb7a0b7device_2fcfabcc-5b10-458b-8377-bdbe1e98347a=VmDevice {vmId=0fdea856-9aec-4300-8d88-4cfd330cf4ff, deviceId=2fcfabcc-5b10-458b-8377-bdbe1e98347a, device=ide, type=CONTROLLER, bootOrder=0, specParams={}, address={bus=0x00, domain=0x0000, type=pci, slot=0x01, function=0x1}, managed=false, plugged=true, readOnly=false, deviceAlias=ide0, customProperties={}, snapshotId=null}},spiceSslCipherSuite=DEFAULT,memSize=2048,smp=1,emulatedMachine=rhel6.5.0,vmType=kvm,memGuaranteedSize=2048,display=qxl,smartcardEnable=false,bootMenuEnable=false,numaTune={mode=preferred, nodeset=0,1},spiceSecureChannels=smain,sinputs,scursor,splayback,srecord,sdisplay,susbredir,ssmartcard,smpCoresPerSocket=1,maxVCpus=16,devices=[{address={bus=0x00, domain=0x0000, slot=0x02, type=pci, function=0x0}, specParams={ram=65536, vram=32768, heads=1}, device=qxl, type=video, deviceId=6dd2ec1b-27cf-4669-9f93-efbc99dcab4f}, {shared=false, iface=ide, index=2, address={unit=0, bus=1, target=0, controller=0, type=drive}, specParams={path=}, path=, device=cdrom, type=disk, readonly=true, deviceId=04c6c9bb-f6e7-48df-b447-c7c7f67d1ecf}, {shared=false, index=0, volumeID=85d91525-5fad-4d19-9aed-b4aa93af0d7f, propagateErrors=off, format=raw, type=disk, iface=virtio, address={bus=0x00, domain=0x0000, slot=0x06, type=pci, function=0x0}, domainID=3dd1756b-97f5-465a-995b-b7dc91046f3b, imageID=0e710a40-017b-4547-9b47-49524777d0d4, specParams={}, optional=false, device=disk, poolID=23a2d807-70ab-49ad-a1d2-3f16458c44ea, readonly=false, deviceId=0e710a40-017b-4547-9b47-49524777d0d4}, {nicModel=pv, address={bus=0x00, domain=0x0000, slot=0x03, type=pci, function=0x0}, specParams={outbound={}, inbound={}}, macAddr=00:1a:4a:7c:94:87, device=bridge, linkActive=true, type=interface, filter=vdsm-no-mac-spoofing, network=net17, deviceId=eab61bc6-ef45-4381-b58f-f4a1f074f765}, {address={bus=0x00, domain=0x0000, slot=0x07, type=pci, function=0x0}, specParams={model=virtio}, device=memballoon, type=balloon, deviceId=8159e614-2ad3-41a1-961d-ba046a609942}, {index=0, model=virtio-scsi, address={bus=0x00, domain=0x0000, slot=0x04, type=pci, function=0x0}, specParams={}, device=scsi, type=controller, deviceId=8013dd09-45a6-4c62-a529-7ec1e79e4961}, {address={bus=0x00, domain=0x0000, slot=0x05, type=pci, function=0x0}, specParams={}, device=virtio-serial, type=controller, deviceId=76fa2cee-8c48-4b83-a451-11297c3a934e}],vmName=puppetdb,cpuType=Westmere,fileTransferEnable=true
2014-11-11 10:55:21,549 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand] (org.ovirt.thread.pool-8-thread-7) [bab78b2] FINISH, CreateVDSCommand, log id: 5d3a82e5
2014-11-11 10:55:21,553 INFO  [org.ovirt.engine.core.vdsbroker.CreateVmVDSCommand] (org.ovirt.thread.pool-8-thread-7) [bab78b2] FINISH, CreateVmVDSCommand, return: WaitForLaunch, log id: 3685dd2b
2014-11-11 10:55:21,554 INFO  [org.ovirt.engine.core.bll.RunVmCommand] (org.ovirt.thread.pool-8-thread-7) [bab78b2] Lock freed to object EngineLock [exclusiveLocks= key: 0fdea856-9aec-4300-8d88-4cfd330cf4ff value: VM
, sharedLocks= ]
2014-11-11 10:55:21,564 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-8-thread-7) [bab78b2] Correlation ID: bab78b2, Job ID: 4bdb57a6-84af-4c3d-af4f-21feb556f125, Call Stack: null, Custom Event ID: -1, Message: VM puppetdb was started by admin (Host: ovirt-node2).
2014-11-11 10:55:24,306 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand] (DefaultQuartzScheduler_Worker-5) START, DestroyVDSCommand(HostName = ovirt-node2, HostId = 051acfd2-076f-498d-adf9-4c6692f65d50, vmId=0fdea856-9aec-4300-8d88-4cfd330cf4ff, force=false, secondsToWait=0, gracefully=false, reason=), log id: 34cc190b
2014-11-11 10:55:24,736 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand] (DefaultQuartzScheduler_Worker-5) FINISH, DestroyVDSCommand, log id: 34cc190b
2014-11-11 10:55:24,798 ERROR [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-5) Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: VM puppetdb is down with error. Exit message: internal error internal error NUMA memory tuning in 'preferred' mode only supports single node.
2014-11-11 10:55:24,799 INFO  [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (DefaultQuartzScheduler_Worker-5) Running on vds during rerun failed vm: null
2014-11-11 10:55:24,801 INFO  [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (DefaultQuartzScheduler_Worker-5) VM puppetdb (0fdea856-9aec-4300-8d88-4cfd330cf4ff) is running in db and not running in VDS ovirt-node2
2014-11-11 10:55:24,837 ERROR [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (DefaultQuartzScheduler_Worker-5) Rerun vm 0fdea856-9aec-4300-8d88-4cfd330cf4ff. Called from vds ovirt-node2
2014-11-11 10:55:24,850 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-8-thread-47) Correlation ID: bab78b2, Job ID: 4bdb57a6-84af-4c3d-af4f-21feb556f125, Call Stack: null, Custom Event ID: -1, Message: Failed to run VM puppetdb on Host ovirt-node2.
2014-11-11 10:55:24,859 INFO  [org.ovirt.engine.core.bll.RunVmCommand] (org.ovirt.thread.pool-8-thread-47) Lock Acquired to object EngineLock [exclusiveLocks= key: 0fdea856-9aec-4300-8d88-4cfd330cf4ff value: VM
, sharedLocks= ]
2014-11-11 10:55:24,875 INFO  [org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] (org.ovirt.thread.pool-8-thread-47) START, IsVmDuringInitiatingVDSCommand( vmId = 0fdea856-9aec-4300-8d88-4cfd330cf4ff), log id: 5e302da
2014-11-11 10:55:24,876 INFO  [org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] (org.ovirt.thread.pool-8-thread-47) FINISH, IsVmDuringInitiatingVDSCommand, return: false, log id: 5e302da
2014-11-11 10:55:24,944 INFO  [org.ovirt.engine.core.bll.RunVmCommand] (org.ovirt.thread.pool-8-thread-47) Running command: RunVmCommand internal: false. Entities affected :  ID: 0fdea856-9aec-4300-8d88-4cfd330cf4ff Type: VMAction group VM_BASIC_OPERATIONS with role type USER
2014-11-11 10:55:25,048 INFO  [org.ovirt.engine.core.vdsbroker.UpdateVmDynamicDataVDSCommand] (org.ovirt.thread.pool-8-thread-47) START, UpdateVmDynamicDataVDSCommand(HostName = ovirt-node1, HostId = 12680126-a43f-4b49-a943-42b6ba9b47ea, vmDynamic=org.ovirt.engine.core.common.businessentities.VmDynamic at a65e7c8), log id: 1a8df7b5
2014-11-11 10:55:25,050 INFO  [org.ovirt.engine.core.vdsbroker.UpdateVmDynamicDataVDSCommand] (org.ovirt.thread.pool-8-thread-47) FINISH, UpdateVmDynamicDataVDSCommand, log id: 1a8df7b5
2014-11-11 10:55:25,076 INFO  [org.ovirt.engine.core.vdsbroker.CreateVmVDSCommand] (org.ovirt.thread.pool-8-thread-47) START, CreateVmVDSCommand(HostName = ovirt-node1, HostId = 12680126-a43f-4b49-a943-42b6ba9b47ea, vmId=0fdea856-9aec-4300-8d88-4cfd330cf4ff, vm=VM [puppetdb]), log id: 799764f1
2014-11-11 10:55:25,101 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand] (org.ovirt.thread.pool-8-thread-47) START, CreateVDSCommand(HostName = ovirt-node1, HostId = 12680126-a43f-4b49-a943-42b6ba9b47ea, vmId=0fdea856-9aec-4300-8d88-4cfd330cf4ff, vm=VM [puppetdb]), log id: 1327ae65
2014-11-11 10:55:25,117 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand] (org.ovirt.thread.pool-8-thread-47) org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand kvmEnable=true,keyboardLayout=en-us,nice=0,pitReinjection=false,displayNetwork=ovirtmgmt,copyPasteEnable=true,timeOffset=0,transparentHugePages=true,vmId=0fdea856-9aec-4300-8d88-4cfd330cf4ff,acpiEnable=true,custom={device_2837bb81-e830-4014-9cba-b95e76c8785bdevice_87f78a45-040c-4534-a19a-e7ba97f3721fdevice_b97a2abb-a9a7-4137-bc47-04ab5cb7a0b7=VmDevice {vmId=0fdea856-9aec-4300-8d88-4cfd330cf4ff, deviceId=b97a2abb-a9a7-4137-bc47-04ab5cb7a0b7, device=spicevmc, type=CHANNEL, bootOrder=0, specParams={}, address={port=3, bus=0, controller=0, type=virtio-serial}, managed=false, plugged=true, readOnly=false, deviceAlias=channel2, customProperties={}, snapshotId=null}, device_2837bb81-e830-4014-9cba-b95e76c8785bdevice_87f78a45-040c-4534-a19a-e7ba97f3721f=VmDevice {vmId=0fdea856-9aec-4300-8d88-4cfd330cf4ff, deviceId=87f78a45-040c-4534-a19a-e7ba97f3721f, device=unix, type=CHANNEL, bootOrder=0, specParams={}, address={port=2, bus=0, controller=0, type=virtio-serial}, managed=false, plugged=true, readOnly=false, deviceAlias=channel1, customProperties={}, snapshotId=null}, device_2837bb81-e830-4014-9cba-b95e76c8785b=VmDevice {vmId=0fdea856-9aec-4300-8d88-4cfd330cf4ff, deviceId=2837bb81-e830-4014-9cba-b95e76c8785b, device=unix, type=CHANNEL, bootOrder=0, specParams={}, address={port=1, bus=0, controller=0, type=virtio-serial}, managed=false, plugged=true, readOnly=false, deviceAlias=channel0, customProperties={}, snapshotId=null}, device_2837bb81-e830-4014-9cba-b95e76c8785bdevice_87f78a45-040c-4534-a19a-e7ba97f3721fdevice_b97a2abb-a9a7-4137-bc47-04ab5cb7a0b7device_2fcfabcc-5b10-458b-8377-bdbe1e98347a=VmDevice {vmId=0fdea856-9aec-4300-8d88-4cfd330cf4ff, deviceId=2fcfabcc-5b10-458b-8377-bdbe1e98347a, device=ide, type=CONTROLLER, bootOrder=0, specParams={}, address={bus=0x00, domain=0x0000, type=pci, slot=0x01, function=0x1}, managed=false, plugged=true, readOnly=false, deviceAlias=ide0, customProperties={}, snapshotId=null}},spiceSslCipherSuite=DEFAULT,memSize=2048,smp=1,emulatedMachine=rhel6.5.0,vmType=kvm,memGuaranteedSize=2048,display=qxl,smartcardEnable=false,bootMenuEnable=false,numaTune={mode=preferred, nodeset=1,0},spiceSecureChannels=smain,sinputs,scursor,splayback,srecord,sdisplay,susbredir,ssmartcard,smpCoresPerSocket=1,maxVCpus=16,devices=[{address={bus=0x00, domain=0x0000, slot=0x02, type=pci, function=0x0}, specParams={ram=65536, vram=32768, heads=1}, device=qxl, type=video, deviceId=6dd2ec1b-27cf-4669-9f93-efbc99dcab4f}, {shared=false, iface=ide, index=2, address={unit=0, bus=1, target=0, controller=0, type=drive}, specParams={path=}, path=, device=cdrom, type=disk, readonly=true, deviceId=04c6c9bb-f6e7-48df-b447-c7c7f67d1ecf}, {shared=false, index=0, volumeID=85d91525-5fad-4d19-9aed-b4aa93af0d7f, propagateErrors=off, format=raw, type=disk, iface=virtio, address={bus=0x00, domain=0x0000, slot=0x06, type=pci, function=0x0}, domainID=3dd1756b-97f5-465a-995b-b7dc91046f3b, imageID=0e710a40-017b-4547-9b47-49524777d0d4, specParams={}, optional=false, device=disk, poolID=23a2d807-70ab-49ad-a1d2-3f16458c44ea, readonly=false, deviceId=0e710a40-017b-4547-9b47-49524777d0d4}, {nicModel=pv, address={bus=0x00, domain=0x0000, slot=0x03, type=pci, function=0x0}, specParams={outbound={}, inbound={}}, macAddr=00:1a:4a:7c:94:87, device=bridge, linkActive=true, type=interface, filter=vdsm-no-mac-spoofing, network=net17, deviceId=eab61bc6-ef45-4381-b58f-f4a1f074f765}, {address={bus=0x00, domain=0x0000, slot=0x07, type=pci, function=0x0}, specParams={model=virtio}, device=memballoon, type=balloon, deviceId=8159e614-2ad3-41a1-961d-ba046a609942}, {index=0, model=virtio-scsi, address={bus=0x00, domain=0x0000, slot=0x04, type=pci, function=0x0}, specParams={}, device=scsi, type=controller, deviceId=8013dd09-45a6-4c62-a529-7ec1e79e4961}, {address={bus=0x00, domain=0x0000, slot=0x05, type=pci, function=0x0}, specParams={}, device=virtio-serial, type=controller, deviceId=76fa2cee-8c48-4b83-a451-11297c3a934e}],vmName=puppetdb,cpuType=Westmere,fileTransferEnable=true
2014-11-11 10:55:25,176 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand] (org.ovirt.thread.pool-8-thread-47) FINISH, CreateVDSCommand, log id: 1327ae65
2014-11-11 10:55:25,180 INFO  [org.ovirt.engine.core.vdsbroker.CreateVmVDSCommand] (org.ovirt.thread.pool-8-thread-47) FINISH, CreateVmVDSCommand, return: WaitForLaunch, log id: 799764f1
2014-11-11 10:55:25,181 INFO  [org.ovirt.engine.core.bll.RunVmCommand] (org.ovirt.thread.pool-8-thread-47) Lock freed to object EngineLock [exclusiveLocks= key: 0fdea856-9aec-4300-8d88-4cfd330cf4ff value: VM
, sharedLocks= ]
2014-11-11 10:55:25,184 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-8-thread-47) Correlation ID: bab78b2, Job ID: 4bdb57a6-84af-4c3d-af4f-21feb556f125, Call Stack: null, Custom Event ID: -1, Message: VM puppetdb was started by admin (Host: ovirt-node1).
2014-11-11 10:55:25,334 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.FullListVdsCommand] (DefaultQuartzScheduler_Worker-8) [3a4ccbe5] START, FullListVdsCommand(HostName = ovirt-node1, HostId = 12680126-a43f-4b49-a943-42b6ba9b47ea, vds=Host[ovirt-node1,12680126-a43f-4b49-a943-42b6ba9b47ea], vmIds=[0fdea856-9aec-4300-8d88-4cfd330cf4ff]), log id: 5aa6e6f2
2014-11-11 10:55:25,345 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.FullListVdsCommand] (DefaultQuartzScheduler_Worker-8) [3a4ccbe5] FINISH, FullListVdsCommand, return: [{displaySecurePort=-1, kvmEnable=true, nicModel=rtl8139,pv, keyboardLayout=en-us, displayIp=192.168.111.101, pitReinjection=false, nice=0, displayNetwork=ovirtmgmt, copyPasteEnable=true, timeOffset=0, transparentHugePages=true, vmId=0fdea856-9aec-4300-8d88-4cfd330cf4ff, acpiEnable=true, custom={device_2837bb81-e830-4014-9cba-b95e76c8785bdevice_87f78a45-040c-4534-a19a-e7ba97f3721fdevice_b97a2abb-a9a7-4137-bc47-04ab5cb7a0b7=VmDevice {vmId=0fdea856-9aec-4300-8d88-4cfd330cf4ff, deviceId=b97a2abb-a9a7-4137-bc47-04ab5cb7a0b7, device=spicevmc, type=CHANNEL, bootOrder=0, specParams={}, address={port=3, bus=0, controller=0, type=virtio-serial}, managed=false, plugged=true, readOnly=false, deviceAlias=channel2, customProperties={}, snapshotId=null}, device_2837bb81-e830-4014-9cba-b95e76c8785b=VmDevice {vmId=0fdea856-9aec-4300-8d88-4cfd330cf4ff, deviceId=2837bb81-e830-4014-9cba-b95e76c8785b, device=unix, type=CHANNEL, bootOrder=0, specParams={}, address={port=1, bus=0, controller=0, type=virtio-serial}, managed=false, plugged=true, readOnly=false, deviceAlias=channel0, customProperties={}, snapshotId=null}, device_2837bb81-e830-4014-9cba-b95e76c8785bdevice_87f78a45-040c-4534-a19a-e7ba97f3721f=VmDevice {vmId=0fdea856-9aec-4300-8d88-4cfd330cf4ff, deviceId=87f78a45-040c-4534-a19a-e7ba97f3721f, device=unix, type=CHANNEL, bootOrder=0, specParams={}, address={port=2, bus=0, controller=0, type=virtio-serial}, managed=false, plugged=true, readOnly=false, deviceAlias=channel1, customProperties={}, snapshotId=null}, device_2837bb81-e830-4014-9cba-b95e76c8785bdevice_87f78a45-040c-4534-a19a-e7ba97f3721fdevice_b97a2abb-a9a7-4137-bc47-04ab5cb7a0b7device_2fcfabcc-5b10-458b-8377-bdbe1e98347a=VmDevice {vmId=0fdea856-9aec-4300-8d88-4cfd330cf4ff, deviceId=2fcfabcc-5b10-458b-8377-bdbe1e98347a, device=ide, type=CONTROLLER, bootOrder=0, specParams={}, address={bus=0x00, domain=0x0000, type=pci, slot=0x01, function=0x1}, managed=false, plugged=true, readOnly=false, deviceAlias=ide0, customProperties={}, snapshotId=null}}, spiceSslCipherSuite=DEFAULT, memSize=2048, smp=1, displayPort=-1, vmType=kvm, emulatedMachine=rhel6.5.0, status=WaitForLaunch, memGuaranteedSize=2048, display=qxl, pid=0, smartcardEnable=false, bootMenuEnable=false, numaTune={nodeset=1,0, mode=preferred}, smpCoresPerSocket=1, spiceSecureChannels=smain,sinputs,scursor,splayback,srecord,sdisplay,susbredir,ssmartcard, maxVCpus=16, clientIp=, devices=[Ljava.lang.Object;@384485d, vmName=puppetdb, fileTransferEnable=true, cpuType=Westmere}], log id: 5aa6e6f2
2014-11-11 10:55:28,500 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand] (DefaultQuartzScheduler_Worker-17) START, DestroyVDSCommand(HostName = ovirt-node1, HostId = 12680126-a43f-4b49-a943-42b6ba9b47ea, vmId=0fdea856-9aec-4300-8d88-4cfd330cf4ff, force=false, secondsToWait=0, gracefully=false, reason=), log id: 74165b35
2014-11-11 10:55:28,947 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand] (DefaultQuartzScheduler_Worker-17) FINISH, DestroyVDSCommand, log id: 74165b35
2014-11-11 10:55:28,978 ERROR [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-17) Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: VM puppetdb is down with error. Exit message: internal error internal error NUMA memory tuning in 'preferred' mode only supports single node.
2014-11-11 10:55:28,980 INFO  [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (DefaultQuartzScheduler_Worker-17) Running on vds during rerun failed vm: null
2014-11-11 10:55:28,981 INFO  [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (DefaultQuartzScheduler_Worker-17) VM puppetdb (0fdea856-9aec-4300-8d88-4cfd330cf4ff) is running in db and not running in VDS ovirt-node1
2014-11-11 10:55:28,982 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.FullListVdsCommand] (DefaultQuartzScheduler_Worker-17) START, FullListVdsCommand(HostName = ovirt-node1, HostId = 12680126-a43f-4b49-a943-42b6ba9b47ea, vds=Host[ovirt-node1,12680126-a43f-4b49-a943-42b6ba9b47ea], vmIds=[0fdea856-9aec-4300-8d88-4cfd330cf4ff]), log id: 3b81dcc0
2014-11-11 10:55:29,027 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.FullListVdsCommand] (DefaultQuartzScheduler_Worker-17) FINISH, FullListVdsCommand, return: [], log id: 3b81dcc0
2014-11-11 10:55:29,034 ERROR [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (DefaultQuartzScheduler_Worker-17) Rerun vm 0fdea856-9aec-4300-8d88-4cfd330cf4ff. Called from vds ovirt-node1
2014-11-11 10:55:29,053 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-8-thread-26) Correlation ID: bab78b2, Job ID: 4bdb57a6-84af-4c3d-af4f-21feb556f125, Call Stack: null, Custom Event ID: -1, Message: Failed to run VM puppetdb on Host ovirt-node1.
2014-11-11 10:55:29,068 INFO  [org.ovirt.engine.core.bll.RunVmCommand] (org.ovirt.thread.pool-8-thread-26) Lock Acquired to object EngineLock [exclusiveLocks= key: 0fdea856-9aec-4300-8d88-4cfd330cf4ff value: VM
, sharedLocks= ]
2014-11-11 10:55:29,084 INFO  [org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] (org.ovirt.thread.pool-8-thread-26) START, IsVmDuringInitiatingVDSCommand( vmId = 0fdea856-9aec-4300-8d88-4cfd330cf4ff), log id: 886dbd7
2014-11-11 10:55:29,085 INFO  [org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] (org.ovirt.thread.pool-8-thread-26) FINISH, IsVmDuringInitiatingVDSCommand, return: false, log id: 886dbd7
2014-11-11 10:55:29,134 WARN  [org.ovirt.engine.core.bll.RunVmCommand] (org.ovirt.thread.pool-8-thread-26) CanDoAction of action RunVm failed. Reasons:VAR__ACTION__RUN,VAR__TYPE__VM,VAR__ACTION__RUN,VAR__TYPE__VM,VAR__ACTION__RUN,VAR__TYPE__VM,VAR__ACTION__RUN,VAR__TYPE__VM,SCHEDULING_NO_HOSTS
2014-11-11 10:55:29,136 INFO  [org.ovirt.engine.core.bll.RunVmCommand] (org.ovirt.thread.pool-8-thread-26) Lock freed to object EngineLock [exclusiveLocks= key: 0fdea856-9aec-4300-8d88-4cfd330cf4ff value: VM
, sharedLocks= ]
2014-11-11 10:55:29,150 ERROR [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-8-thread-26) Correlation ID: bab78b2, Job ID: 4bdb57a6-84af-4c3d-af4f-21feb556f125, Call Stack: null, Custom Event ID: -1, Message: Failed to run VM puppetdb (User: admin).
2014-11-11 10:55:29,157 INFO  [org.ovirt.engine.core.bll.ProcessDownVmCommand] (org.ovirt.thread.pool-8-thread-32) [c12c728] Running command: ProcessDownVmCommand internal: true.

More information about the Users mailing list