[Users] ovirt 3.1 - cannot boot virtual server from CD

Fri Jun 15 07:29:15 UTC 2012

Hi,

It is not a SELinux issue. I even put SELinux Permissive on both the
manager and the hypervisor node. On the hypervisor node
/var/log/vdsm/libvirt.log tells:

2012-06-15 07:16:32.511+0000: 11607: error :
virNetClientProgramDispatchError:174 : internal error unsupported
configuration: Readonly leases are not supported

After removing the DVD  the machine can start...

What's wrong here?

Winfried

Op 14-06-12 17:19, Juan Hernandez schreef:
> On 06/14/2012 04:59 PM, Winfried de Heiden wrote:
>> Hi all,
>>
>> Trying to start a virtual server from DVD fails, the (spice) console
>> gives:
>>
>> "Could not read from CDROM (code 0003)"
>
> Some other people is reporting this same problem in #ovirt. Can you
> check what is the value of the virt_use_nfs boolean in your hypervisor:
>
> getsebool virt_use_nfs
>
> If it is "off" it is wrong, you will have to change it to "on":
>
> setsebool -P virt_use_nfs on
>
>> 2012-06-14 18:53:08,630 INFO
>> [org.ovirt.engine.core.vdsbroker.irsbroker.IsoPrefixVDSCommand]
>> (ajp--0.0.0.0-8009-3) [193bc72b] START,
>> IsoPrefixVDSCommand(storagePoolId =
>> b2456911-a25e-4c33-8e46-bae35cc015e7, ignoreFailoverLimit = false,
>> compatabilityVersion = null), log id: 59f0cc1c
>> 2012-06-14 18:53:08,632 INFO
>> [org.ovirt.engine.core.vdsbroker.irsbroker.IsoPrefixVDSCommand]
>> (ajp--0.0.0.0-8009-3) [193bc72b] FINISH, IsoPrefixVDSCommand, return:
>> /rhev/data-center/b2456911-a25e-4c33-8e46-bae35cc015e7/bfb1da46-c417-472a-8905-09e687648b16/images/11111111-1111-1111-1111-111111111111,
>>
>> log id: 59f0cc1c
>> 2012-06-14 18:53:08,752 INFO
>> [org.ovirt.engine.core.vdsbroker.irsbroker.IsValidVDSCommand]
>> (ajp--0.0.0.0-8009-3) [193bc72b] START,
>> IsValidVDSCommand(storagePoolId =
>> b2456911-a25e-4c33-8e46-bae35cc015e7, ignoreFailoverLimit = false,
>> compatabilityVersion = null), log id: 2ba80f77
>> 2012-06-14 18:53:08,757 INFO
>> [org.ovirt.engine.core.vdsbroker.irsbroker.IsValidVDSCommand]
>> (ajp--0.0.0.0-8009-3) [193bc72b] FINISH, IsValidVDSCommand, return:
>> true, log
>> id: 2ba80f77
>> 2012-06-14 18:53:08,864 INFO
>> [org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand]
>> (ajp--0.0.0.0-8009-3) [193bc72b] START,
>> IsVmDuringInitiatingVDSCommand(vmId =
>> d3a1600e-9fb9-4d44-9c5e-b6278226ae57), log id: 7bafb10a
>> 2012-06-14 18:53:08,867 INFO
>> [org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand]
>> (ajp--0.0.0.0-8009-3) [193bc72b] FINISH,
>> IsVmDuringInitiatingVDSCommand, return:
>> false, log id: 7bafb10a
>> 2012-06-14 18:53:08,896 INFO
>> [org.ovirt.engine.core.bll.RunVmOnceCommand]
>> (ajp--0.0.0.0-8009-3) [193bc72b] Running command: RunVmOnceCommand
>> internal:
>> false. Entities affected : ID: d3a1600e-9fb9-4d44-9c5e-b6278226ae57
>> Type: VM
>> 2012-06-14 18:53:08,922 INFO
>> [org.ovirt.engine.core.vdsbroker.CreateVmVDSCommand]
>> (ajp--0.0.0.0-8009-3)
>> [193bc72b] START, CreateVmVDSCommand(vdsId =
>> c781df7a-b5f5-11e1-91f8-e791895bd007,
>> vmId=d3a1600e-9fb9-4d44-9c5e-b6278226ae57,
>> vm=org.ovirt.engine.core.common.businessentities.VM at 4209547b), log
>> id: 184fd2c
>> 2012-06-14 18:53:08,931 INFO
>> [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand]
>> (ajp--0.0.0.0-8009-3) [193bc72b] START, CreateVDSCommand(vdsId =
>> c781df7a-b5f5-11e1-91f8-e791895bd007,
>> vmId=d3a1600e-9fb9-4d44-9c5e-b6278226ae57,
>> vm=org.ovirt.engine.core.common.businessentities.VM at 4209547b), log
>> id: ba59fb6
>> 2012-06-14 18:53:08,997 INFO
>> [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand]
>> (ajp--0.0.0.0-8009-3) [193bc72b]
>> org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand
>> spiceSslCipherSuite=DEFAULT,memSize=1024,kvmEnable=true,smp=1,emulatedMachine=pc-0.14,vmType=kvm,keyboardLayout=en-us,pitReinjection=false,nice=0,display=qxl,smpCoresPerSocket=1,spiceSecureChannels=smain,sinputs,scursor,splayback,srecord,sdisplay,timeOffset=0,transparentHugePages=true,vmId=d3a1600e-9fb9-4d44-9c5e-b6278226ae57,devices=[Ljava.util.Map;@7525661e,acpiEnable=true,vmName=CENTOS6,cpuType=Conroe,custom={device_c27ccfac-aa9c-4b66-977a-4a12e6088533device_26088fe5-ef48-492e-bdad-a7b6e434f715device_d567a5eb-c03a-41a7-8978-3fc4c19743c8device_42361439-dce5-4349-9542-8f2200fc12cc=VmId=d3a1600e-9fb9-4d44-9c5e-b6278226ae57,DeviceId=42361439-dce5-4349-9542-8f2200fc12cc,Device=spicevmc,Type=channel,BootOrder=0,SpecParams={},Address={port=2,
>>
>> bus=0, controller=0,
>> type=virtio-serial},IsManaged=false,IsPlugged=true,IsReadOnly=false,alias=channel1,
>>
>> device_c27ccfac-aa9c-4b66-977a-4a12e6088533device_26088fe5-ef48-492e-bdad-a7b6e434f715device_d567a5eb-c03a-41a7-8978-3fc4c19743c8=VmId=d3a1600e-9fb9-4d44-9c5e-b6278226ae57,DeviceId=d567a5eb-c03a-41a7-8978-3fc4c19743c8,Device=unix,Type=channel,BootOrder=0,SpecParams={},Address={port=1,
>>
>> bus=0, controller=0,
>> type=virtio-serial},IsManaged=false,IsPlugged=true,IsReadOnly=false,alias=channel0,
>>
>> device_c27ccfac-aa9c-4b66-977a-4a12e6088533device_26088fe5-ef48-492e-bdad-a7b6e434f715=VmId=d3a1600e-9fb9-4d44-9c5e-b6278226ae57,DeviceId=26088fe5-ef48-492e-bdad-a7b6e434f715,Device=virtio-serial,Type=controller,BootOrder=0,SpecParams={},Address={bus=0x00,
>>
>> domain=0x0000, type=pci, slot=0x04,
>> function=0x0},IsManaged=false,IsPlugged=true,IsReadOnly=false,alias=virtio-serial0,
>>
>> device_c27ccfac-aa9c-4b66-977a-4a12e6088533=VmId=d3a1600e-9fb9-4d44-9c5e-b6278226ae57,DeviceId=c27ccfac-aa9c-4b66-977a-4a12e6088533,Device=usb,Type=controller,BootOrder=0,SpecParams={},Address={bus=0x00,
>>
>> domain=0x0000, type=pci, slot=0x01,
>> function=0x2},IsManaged=false,IsPlugged=true,IsReadOnly=false,alias=usb0}
>>
>> 2012-06-14 18:53:09,019 INFO
>> [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand]
>> (ajp--0.0.0.0-8009-3) [193bc72b] FINISH, CreateVDSCommand, log id:
>> ba59fb6
>> 2012-06-14 18:53:09,022 INFO
>> [org.ovirt.engine.core.vdsbroker.CreateVmVDSCommand]
>> (ajp--0.0.0.0-8009-3)
>> [193bc72b] IncreasePendingVms::CreateVmIncreasing vds kvm pending
>> vcpu count,
>> now 1. Vm: CENTOS6
>> 2012-06-14 18:53:09,024 INFO
>> [org.ovirt.engine.core.vdsbroker.CreateVmVDSCommand]
>> (ajp--0.0.0.0-8009-3)
>> [193bc72b] FINISH, CreateVmVDSCommand, return: WaitForLaunch, log id:
>> 184fd2c
>> 2012-06-14 18:53:10,394 INFO
>> [org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand]
>> (QuartzScheduler_Worker-86) START, DestroyVDSCommand(vdsId =
>> c781df7a-b5f5-11e1-91f8-e791895bd007,
>> vmId=d3a1600e-9fb9-4d44-9c5e-b6278226ae57,
>> force=false, secondsToWait=0, gracefully=false), log id: 65045e39
>> 2012-06-14 18:53:10,478 INFO
>> [org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand]
>> (QuartzScheduler_Worker-86) FINISH, DestroyVDSCommand, log id: 65045e39
>> 2012-06-14 18:53:10,495 INFO
>> [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo]
>> (QuartzScheduler_Worker-86) *Running on vds during rerun *failed vm:
>> null
>> 2012-06-14 18:53:10,499 INFO
>> [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo]
>> (QuartzScheduler_Worker-86) *vm CENTOS6 running in db and not running
>> in vds -
>> add to rerun treatment. vds kvm
>> *2012-06-14 18:53:10,500 INFO
>> [org.ovirt.engine.core.vdsbroker.vdsbroker.FullListVdsCommand]
>> (QuartzScheduler_Worker-86) START, FullListVdsCommand(vdsId =
>> c781df7a-b5f5-11e1-91f8-e791895bd007, vds=null,
>> vmIds=[d3a1600e-9fb9-4d44-9c5e-b6278226ae57]), log id: 792606bb
>> 2012-06-14 18:53:10,527 INFO
>> [org.ovirt.engine.core.vdsbroker.vdsbroker.FullListVdsCommand]
>> (QuartzScheduler_Worker-86) FINISH, FullListVdsCommand, return:
>> [Lorg.ovirt.engine.core.vdsbroker.xmlrpc.XmlRpcStruct;@2f841d20, log
>> id: 792606bb
>> 2012-06-14 18:53:10,545 ERROR
>> [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo]
>> (QuartzScheduler_Worker-86) Rerun vm
>> d3a1600e-9fb9-4d44-9c5e-b6278226ae57.
>> Called from vds kvm
>> 2012-06-14 18:53:10,549 INFO
>> [org.ovirt.engine.core.vdsbroker.UpdateVdsDynamicDataVDSCommand]
>> (pool-3-thread-48) START, UpdateVdsDynamicDataVDSCommand(vdsId =
>> c781df7a-b5f5-11e1-91f8-e791895bd007,
>> vdsDynamic=org.ovirt.engine.core.common.businessentities.VdsDynamic at 8df86a4b),
>>
>> log id: 101af892
>> 2012-06-14 18:53:10,562 INFO
>> [org.ovirt.engine.core.vdsbroker.UpdateVdsDynamicDataVDSCommand]
>> (pool-3-thread-48) FINISH, UpdateVdsDynamicDataVDSCommand, log id:
>> 101af892
>> 2012-06-14 18:53:10,605 INFO
>> [org.ovirt.engine.core.vdsbroker.irsbroker.IsValidVDSCommand]
>> (pool-3-thread-48)
>> START, IsValidVDSCommand(storagePoolId =
>> b2456911-a25e-4c33-8e46-bae35cc015e7,
>> ignoreFailoverLimit = false, compatabilityVersion = null), log id:
>> 1d9f68f5
>> 2012-06-14 18:53:10,609 INFO
>> [org.ovirt.engine.core.vdsbroker.irsbroker.IsValidVDSCommand]
>> (pool-3-thread-48)
>> FINISH, IsValidVDSCommand, return: true, log id: 1d9f68f5
>> 2012-06-14 18:53:10,664 INFO
>> [org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand]
>> (pool-3-thread-48) START, IsVmDuringInitiatingVDSCommand(vmId =
>> d3a1600e-9fb9-4d44-9c5e-b6278226ae57), log id: 329a94da
>> 2012-06-14 18:53:10,666 INFO
>> [org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand]
>> (pool-3-thread-48) FINISH, IsVmDuringInitiatingVDSCommand, return:
>> false, log
>> id: 329a94da
>> 2012-06-14 18:53:10,672 WARN
>> [org.ovirt.engine.core.bll.RunVmOnceCommand]
>> (pool-3-thread-48) CanDoAction of action RunVmOnce failed.
>> Reasons:VAR__ACTION__RUN,VAR__TYPE__VM,VAR__ACTION__RUN,VAR__TYPE__VM,ACTION_TYPE_FAILED_VDS_VM_CLUSTER
>>
>>
>>
>>
>> The machine doesn't start since the DVD is not there. On the
>> hypervisor host;
>> /var/log/vdsm/vdsm.log:
>>
>> <source
>> file="/rhev/data-center/b2456911-a25e-4c33-8e46-bae35cc015e7/bfb1da46-c417-472a-8905-09e687648b16/images/11111111-1111-1111-1111-111111111111/*.CentOS-6.2-x86_64-bin-DVD1.iso*"
>>
>> startupPolicy="optional"/>
>>
>> Aha, there is an extra<dot>  in the filename Centos-62...., which
>> should not be
>> there! And yeah, creating a symlink with an extra<dot>  does not
>> work....
>>
>>
>>
>>
>>
>>
>>
>> _______________________________________________
>> Users mailing list
>> Users at ovirt.org
>> http://lists.ovirt.org/mailman/listinfo/users
>
>