Re: [Users] creating and running a vm fails

Thursday, 29 March 2012

I suspect something happened to vdsm - can you attach vdsm logs 
(/var/log/vdsm/vdsm.log) from that time and maybe sneak a pick at 
/var/log/core if we have something there.
Moran.

On 03/29/2012 08:07 AM, Rene Rosenberger wrote:
...
 Hi,

 the host on which the vm should run is up. It has a green arrow.

 Regards, rene

 -----Ursprüngliche Nachricht-----
 Von: Itamar Heim [mailto:iheim@redhat.com]
 Gesendet: Mittwoch, 28. März 2012 22:07
 An: Rene Rosenberger
 Cc: users(a)oVirt.org
 Betreff: Re: [Users] creating and running a vm fails

 On 03/28/2012 02:33 PM, Rene Rosenberger wrote:
> Hi,
>
> when i create a VM with it virtual disk and i want to run it once to
> install from imported iso file I get the following error message:
>
> 2012-03-28 14:31:35,488
> INFO[org.ovirt.engine.core.vdsbroker.CreateVmVDSCommand]
> (http--0.0.0.0-8443-5) [cf5d84e] START, CreateVmVDSCommand(vdsId =
> 0e0403a4-78ae-11e1-9c19-525400c49d2a,
> vmId=93220e0a-610a-4b20-986e-3c8b0d39e35f,
> vm=org.ovirt.engine.core.common.businessentities.VM@6e69e491), log id:
> 3fc82aad
>
> 2012-03-28 14:31:35,498
> INFO[org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand]
> (http--0.0.0.0-8443-5) [cf5d84e] START, CreateVDSCommand(vdsId =
> 0e0403a4-78ae-11e1-9c19-525400c49d2a,
> vmId=93220e0a-610a-4b20-986e-3c8b0d39e35f,
> vm=org.ovirt.engine.core.common.businessentities.VM@6e69e491), log id:
> 7e63d56b
>
> 2012-03-28 14:31:35,620
> INFO[org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand]
> (http--0.0.0.0-8443-5) [cf5d84e]
> org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand
> spiceSslCipherSuite=DEFAULT,memSize=512,kvmEnable=true,boot=dc,smp=1,e
> mulatedMachine=pc-0.14,vmType=kvm,keyboardLayout=en-us,pitReinjection=
> false,nice=0,display=vnc,tabletEnable=true,smpCoresPerSocket=1,spiceSe
> cureChannels=,spiceMonitors=1,cdrom=/rhev/data-center/13080edc-77ea-11
> e1-b6a4-525400c49d2a/93e2079e-ef3b-452f-af71-5b3e7eb32ba0/images/11111
> 111-1111-1111-1111-111111111111/CentOS-6.2-x86_64-bin-DVD1.iso,timeOff
> set=0,transparentHugePages=true,drives=[Ljava.util.Map;@7f0ba1c1,vmId=
> 93220e0a-610a-4b20-986e-3c8b0d39e35f,acpiEnable=true,vmName=test,cpuTy
> pe=Opteron_G3,custom={}
>
> 2012-03-28 14:31:35,620
> INFO[org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand]
> (http--0.0.0.0-8443-5) [cf5d84e] FINISH, CreateVDSCommand, log id:
> 7e63d56b
>
> 2012-03-28 14:31:35,625
> INFO[org.ovirt.engine.core.vdsbroker.CreateVmVDSCommand]
> (http--0.0.0.0-8443-5) [cf5d84e]
> IncreasePendingVms::CreateVmIncreasing
> vds KVM-DMZ-04 pending vcpu count, now 1. Vm: test
>
> 2012-03-28 14:31:35,631
> INFO[org.ovirt.engine.core.vdsbroker.CreateVmVDSCommand]
> (http--0.0.0.0-8443-5) [cf5d84e] FINISH, CreateVmVDSCommand, return:
> WaitForLaunch, log id: 3fc82aad
>
> 2012-03-28 14:31:39,316
> WARN[org.ovirt.engine.core.vdsbroker.VdsManager]
> (QuartzScheduler_Worker-35)
> ResourceManager::refreshVdsRunTimeInfo::Failed to refresh VDS , vds =
> 0e0403a4-78ae-11e1-9c19-525400c49d2a : KVM-DMZ-04, VDS Network Error,
> continuing.
>
> VDSNetworkException:
>
> 2012-03-28 14:31:41,328
> WARN[org.ovirt.engine.core.vdsbroker.VdsManager]
> (QuartzScheduler_Worker-29)
> ResourceManager::refreshVdsRunTimeInfo::Failed to refresh VDS , vds =
> 0e0403a4-78ae-11e1-9c19-525400c49d2a : KVM-DMZ-04, VDS Network Error,
> continuing.
>
> VDSNetworkException:
>
> 2012-03-28 14:31:43,340
> WARN[org.ovirt.engine.core.vdsbroker.VdsManager]
> (QuartzScheduler_Worker-45)
> ResourceManager::refreshVdsRunTimeInfo::Failed to refresh VDS , vds =
> 0e0403a4-78ae-11e1-9c19-525400c49d2a : KVM-DMZ-04, VDS Network Error,
> continuing.
>
> VDSNetworkException:
>
> 2012-03-28 14:31:43,519
> INFO[org.ovirt.engine.core.bll.storage.SetStoragePoolStatusCommand]
> (QuartzScheduler_Worker-38) [7ed2f412] Running command:
> SetStoragePoolStatusCommand internal: true. Entities affected :ID:
> 13080edc-77ea-11e1-b6a4-525400c49d2a Type: StoragePool
>
> 2012-03-28 14:31:43,543 ERROR
> [org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand]
> (QuartzScheduler_Worker-38) [7ed2f412]
> IrsBroker::Failed::GetStoragePoolInfoVDS due to: ConnectException:
> Connection refused
>
> 2012-03-28 14:31:45,351
> WARN[org.ovirt.engine.core.vdsbroker.VdsManager]
> (QuartzScheduler_Worker-47)
> ResourceManager::refreshVdsRunTimeInfo::Failed to refresh VDS , vds =
> 0e0403a4-78ae-11e1-9c19-525400c49d2a : KVM-DMZ-04, VDS Network Error,
> continuing.
>
> VDSNetworkException:
>
> 2012-03-28 14:31:47,363
> WARN[org.ovirt.engine.core.vdsbroker.VdsManager]
> (QuartzScheduler_Worker-71)
> ResourceManager::refreshVdsRunTimeInfo::Failed to refresh VDS , vds =
> 0e0403a4-78ae-11e1-9c19-525400c49d2a : KVM-DMZ-04, VDS Network Error,
> continuing.
>
> VDSNetworkException:
>
> 2012-03-28 14:31:51,091
> INFO[org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo]
> (QuartzScheduler_Worker-55) vm test running in db and not running in
> vds
> - add to rerun treatment. vds KVM-DMZ-04
>
> 2012-03-28 14:31:51,104
> INFO[org.ovirt.engine.core.bll.InitVdsOnUpCommand]
> (QuartzScheduler_Worker-55) [6df61eca] Running command:
> InitVdsOnUpCommand internal: true.
>
> 2012-03-28 14:31:51,182
> INFO[org.ovirt.engine.core.bll.storage.ConnectHostToStoragePoolServers
> Command]
> (QuartzScheduler_Worker-55) [48a331d9] Running command:
> ConnectHostToStoragePoolServersCommand internal: true. Entities
> affected
> :ID: 13080edc-77ea-11e1-b6a4-525400c49d2a Type: StoragePool
>
> 2012-03-28 14:31:51,185
> INFO[org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDS
> Command]
> (QuartzScheduler_Worker-55) [48a331d9] START,
> ConnectStorageServerVDSCommand(vdsId =
> 0e0403a4-78ae-11e1-9c19-525400c49d2a, storagePoolId =
> 13080edc-77ea-11e1-b6a4-525400c49d2a, storageType = ISCSI,
> connectionList = [{ id: e25e5093-9240-42ac-a21a-f0c216294944,
> connection: 192.168.200.32 };]), log id: 11a3b069
>
> 2012-03-28 14:31:51,488
> INFO[org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDS
> Command]
> (QuartzScheduler_Worker-55) [48a331d9] FINISH,
> ConnectStorageServerVDSCommand, return:
> {e25e5093-9240-42ac-a21a-f0c216294944=0}, log id: 11a3b069
>
> 2012-03-28 14:31:51,489
> INFO[org.ovirt.engine.core.bll.storage.ConnectHostToStoragePoolServers
> Command]
> (QuartzScheduler_Worker-55) [48a331d9] Host KVM-DMZ-04 storage
> connection was succeeded
>
> 2012-03-28 14:31:51,492
> INFO[org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDS
> Command]
> (QuartzScheduler_Worker-55) [48a331d9] START,
> ConnectStorageServerVDSCommand(vdsId =
> 0e0403a4-78ae-11e1-9c19-525400c49d2a, storagePoolId =
> 13080edc-77ea-11e1-b6a4-525400c49d2a, storageType = NFS,
> connectionList = [{ id: 3dd798da-77ea-11e1-969c-525400c49d2a, connection:
> oVirt.dynetic.de:/mnt/iso };]), log id: 1d73fc4e
>
> 2012-03-28 14:31:51,535
> INFO[org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDS
> Command]
> (QuartzScheduler_Worker-55) [48a331d9] FINISH,
> ConnectStorageServerVDSCommand, return:
> {3dd798da-77ea-11e1-969c-525400c49d2a=0}, log id: 1d73fc4e
>
> 2012-03-28 14:31:51,535
> INFO[org.ovirt.engine.core.bll.storage.ConnectHostToStoragePoolServers
> Command]
> (QuartzScheduler_Worker-55) [48a331d9] Host KVM-DMZ-04 storage
> connection was succeeded
>
> 2012-03-28 14:31:51,538
> INFO[org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDS
> Command]
> (QuartzScheduler_Worker-55) [48a331d9] START,
> ConnectStorageServerVDSCommand(vdsId =
> 0e0403a4-78ae-11e1-9c19-525400c49d2a, storagePoolId =
> 13080edc-77ea-11e1-b6a4-525400c49d2a, storageType = NFS,
> connectionList = [{ id: 57d6595f-1109-49f9-a7f3-f8fe255c34bd, connection:
> 192.168.200.32:/nfsexport };]), log id: 618343ee
>
> 2012-03-28 14:31:51,579
> INFO[org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDS
> Command]
> (QuartzScheduler_Worker-55) [48a331d9] FINISH,
> ConnectStorageServerVDSCommand, return:
> {57d6595f-1109-49f9-a7f3-f8fe255c34bd=0}, log id: 618343ee
>
> 2012-03-28 14:31:51,579
> INFO[org.ovirt.engine.core.bll.storage.ConnectHostToStoragePoolServers
> Command]
> (QuartzScheduler_Worker-55) [48a331d9] Host KVM-DMZ-04 storage
> connection was succeeded
>
> 2012-03-28 14:31:51,594
> INFO[org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStoragePoolVDSCo
> mmand]
> (QuartzScheduler_Worker-55) [48a331d9] START,
> ConnectStoragePoolVDSCommand(vdsId =
> 0e0403a4-78ae-11e1-9c19-525400c49d2a, storagePoolId =
> 13080edc-77ea-11e1-b6a4-525400c49d2a, vds_spm_id = 1, masterDomainId =
> 8ed25a57-f53a-4cf0-bb92-781f3ce36a48, masterVersion = 1), log id:
> 190d7dea
>
> 2012-03-28 14:32:02,207
> INFO[org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStoragePoolVDSCo
> mmand]
> (QuartzScheduler_Worker-55) [48a331d9] FINISH,
> ConnectStoragePoolVDSCommand, log id: 190d7dea
>
> 2012-03-28 14:32:02,231
> INFO[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirec
> tor]
> (QuartzScheduler_Worker-55) [48a331d9] No string for UNASSIGNED type.
> Use default Log
>
> 2012-03-28 14:32:02,234
> INFO[org.ovirt.engine.core.bll.MultipleActionsRunner]
> (pool-5-thread-47) [48a331d9] MultipleActionsRunner of type
> MigrateVmToServer invoked with no actions
>
> 2012-03-28 14:32:02,264
> INFO[org.ovirt.engine.core.bll.HandleVdsCpuFlagsOrClusterChangedComman
> d]
> (QuartzScheduler_Worker-55) [75839ca5] Running command:
> HandleVdsCpuFlagsOrClusterChangedCommand internal: true. Entities
> affected :ID: 0e0403a4-78ae-11e1-9c19-525400c49d2a Type: VDS
>
> 2012-03-28 14:32:02,272
> INFO[org.ovirt.engine.core.bll.HandleVdsVersionCommand]
> (QuartzScheduler_Worker-55) [2dd7e7a] Running command:
> HandleVdsVersionCommand internal: true. Entities affected :ID:
> 0e0403a4-78ae-11e1-9c19-525400c49d2a Type: VDS
>
> 2012-03-28 14:32:02,276 ERROR
> [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo]
> (QuartzScheduler_Worker-55) [2dd7e7a] Rerun vm
> 93220e0a-610a-4b20-986e-3c8b0d39e35f. Called from vds KVM-DMZ-04
>
> 2012-03-28 14:32:02,280
> INFO[org.ovirt.engine.core.vdsbroker.UpdateVdsDynamicDataVDSCommand]
> (pool-5-thread-47) [2dd7e7a] START,
> UpdateVdsDynamicDataVDSCommand(vdsId
> = 0e0403a4-78ae-11e1-9c19-525400c49d2a,
> vdsDynamic=org.ovirt.engine.core.common.businessentities.VdsDynamic@2f
> 1f5a9f),
> log id: 2901421c
>
> 2012-03-28 14:32:02,282
> INFO[org.ovirt.engine.core.vdsbroker.UpdateVdsDynamicDataVDSCommand]
> (pool-5-thread-47) [2dd7e7a] FINISH, UpdateVdsDynamicDataVDSCommand,
> log
> id: 2901421c
>
> 2012-03-28 14:32:02,299
> INFO[org.ovirt.engine.core.vdsbroker.irsbroker.IsValidVDSCommand]
> (pool-5-thread-47) [2dd7e7a] START, IsValidVDSCommand(storagePoolId =
> 13080edc-77ea-11e1-b6a4-525400c49d2a, ignoreFailoverLimit = false,
> compatabilityVersion = null), log id: 2d73522e
>
> 2012-03-28 14:32:02,300
> INFO[org.ovirt.engine.core.vdsbroker.irsbroker.IsValidVDSCommand]
> (pool-5-thread-47) [2dd7e7a] FINISH, IsValidVDSCommand, return: false,
> log id: 2d73522e
>
> 2012-03-28 14:32:02,301
> WARN[org.ovirt.engine.core.bll.RunVmOnceCommand]
> (pool-5-thread-47) [2dd7e7a] CanDoAction of action RunVmOnce failed.
> Reasons:VAR__ACTION__RUN,VAR__TYPE__VM,VAR__ACTION__RUN,VAR__TYPE__VM,
> ACTION_TYPE_FAILED_IMAGE_REPOSITORY_NOT_FOUND
>
> 2012-03-28 14:32:04,591
> INFO[org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand]
> (QuartzScheduler_Worker-62) hostFromVds::selectedVds - KVM-DMZ-04,
> spmStatus Free, storage pool Default
>
> 2012-03-28 14:32:05,430
> INFO[org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand]
> (QuartzScheduler_Worker-62) SpmStatus on vds
> 0e0403a4-78ae-11e1-9c19-525400c49d2a: Free
>
> 2012-03-28 14:32:05,436
> INFO[org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand]
> (QuartzScheduler_Worker-62) starting spm on vds KVM-DMZ-04, storage
> pool Default, prevId 1, LVER 0
>
> 2012-03-28 14:32:05,439
> INFO[org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand]
> (QuartzScheduler_Worker-62) START, SpmStartVDSCommand(vdsId =
> 0e0403a4-78ae-11e1-9c19-525400c49d2a, storagePoolId =
> 13080edc-77ea-11e1-b6a4-525400c49d2a, prevId=1, prevLVER=0,
> storagePoolFormatType=V2, recoveryMode=Manual, SCSIFencing=false), log
> id: 25d38cf4
>
> 2012-03-28 14:32:05,490
> INFO[org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand]
> (QuartzScheduler_Worker-62) spmStart polling started: taskId =
> c2a0d9a2-e356-4aa9-bb29-f66a0899d8cc
>
> Any idea what to do?
>
 looks like the host is no up?
 _______________________________________________
 Users mailing list
 Users(a)ovirt.org
 http://lists.ovirt.org/mailman/listinfo/users 

2024

2023

2022

2021

2020

2019

2018

2017

2016

2015

2014

2013

2012

2011

Re: [Users] creating and running a vm fails