[Users] Problem with libvirt

Thu Jan 31 11:21:23 UTC 2013

Hello everybody,

I have installed and configured oVirt 3.1 engine in a Fedora 17 with a
Fedora 17 node connected. Ihave defined a NFS domain for my VM and another
for ISOs. I try to start a Fedora 17 Server with Run once and the machi
start without problems, after that I preceed with the installation in its
wirtual disk but when I arrive to define partitions in the virtual disk the
machine is freeze and I start to receive engine errors and the default data
center go in non responsive status.

I can see this messages in /var/log/ovirt-engine/engine.log, which I attach
to this message:

....
2013-01-31 11:43:23,957 INFO
 [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo]
(QuartzScheduler_Worker-47) [75664f2b] Recieved a Device without an address
when processing VM da09284e-3189-428b-a879-6201f7a5ca87 devices, skipping
device: {shared=false, volumeID=1d0e9fdf-c4bc-4894-8ff1-7a5e185d57a4,
index=0, propagateErrors=off, format=raw, type=disk, truesize=8589938688,
reqsize=0, bootOrder=2, iface=virtio,
volumeChain=[Ljava.lang.Object;@1ea2bdf9,
imageID=49e21bfc-384b-4bea-8013-f02b1be137c7,
domainID=57d184a0-908b-49b5-926f-cd413b9e6526, specParams={},
optional=false, needExtend=false,
path=/rhev/data-center/d6e7e8b8-49c7-11e2-a261-000a5e429f63/57d184a0-908b-49b5-926f-cd413b9e6526/images/49e21bfc-384b-4bea-8013-f02b1be137c7/1d0e9fdf-c4bc-4894-8ff1-7a5e185d57a4,
device=disk, poolID=d6e7e8b8-49c7-11e2-a261-000a5e429f63, readonly=false,
deviceId=49e21bfc-384b-4bea-8013-f02b1be137c7, apparentsize=8589934592}.
2013-01-31 11:43:23,960 ERROR
[org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo]
(QuartzScheduler_Worker-47) [75664f2b] VM
da09284e-3189-428b-a879-6201f7a5ca87 managed non plugable device was
removed unexpetedly from libvirt:
VmId=da09284e-3189-428b-a879-6201f7a5ca87,DeviceId=4dca1c64-dbf8-4e31-b359-82cf0e259f65,Device=qxl,Type=video,BootOrder=0,SpecParams={vram=65536},Address=,IsManaged=true,IsPlugged=true,IsReadOnly=false,alias=
2013-01-31 11:43:23,961 ERROR
[org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo]
(QuartzScheduler_Worker-47) [75664f2b] VM
da09284e-3189-428b-a879-6201f7a5ca87 managed non plugable device was
removed unexpetedly from libvirt:
VmId=da09284e-3189-428b-a879-6201f7a5ca87,DeviceId=aba73f2f-e951-4eba-9da4-8fb58315df2c,Device=memballoon,Type=balloon,BootOrder=0,SpecParams={model=virtio},Address=,IsManaged=true,IsPlugged=true,IsReadOnly=true,alias=
2013-01-31 11:43:23,962 ERROR
[org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo]
(QuartzScheduler_Worker-47) [75664f2b] VM
da09284e-3189-428b-a879-6201f7a5ca87 managed non plugable device was
removed unexpetedly from libvirt:
VmId=da09284e-3189-428b-a879-6201f7a5ca87,DeviceId=9bfb770c-13fa-4bf6-9f1f-414927bc31b0,Device=cdrom,Type=disk,BootOrder=0,SpecParams={path=},Address=,IsManaged=true,IsPlugged=true,IsReadOnly=true,alias=
2013-01-31 11:43:23,963 ERROR
[org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo]
(QuartzScheduler_Worker-47) [75664f2b] VM
da09284e-3189-428b-a879-6201f7a5ca87 managed non plugable device was
removed unexpetedly from libvirt:
VmId=da09284e-3189-428b-a879-6201f7a5ca87,DeviceId=614bc0b4-64d8-4058-8bf8-83db62617e00,Device=bridge,Type=interface,BootOrder=0,SpecParams={},Address=,IsManaged=true,IsPlugged=true,IsReadOnly=false,alias=
2013-01-31 11:43:23,964 ERROR
[org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo]
(QuartzScheduler_Worker-47) [75664f2b] VM
da09284e-3189-428b-a879-6201f7a5ca87 managed non plugable device was
removed unexpetedly from libvirt:
VmId=da09284e-3189-428b-a879-6201f7a5ca87,DeviceId=49e21bfc-384b-4bea-8013-f02b1be137c7,Device=disk,Type=disk,BootOrder=0,SpecParams={},Address=,IsManaged=true,IsPlugged=true,IsReadOnly=false,alias=
2013-01-31 11:43:26,063 INFO
 [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo]
(QuartzScheduler_Worker-24) [7d021319] VM Fedora17
da09284e-3189-428b-a879-6201f7a5ca87 moved from WaitForLaunch --> PoweringUp
2013-01-31 11:43:26,064 INFO
 [org.ovirt.engine.core.vdsbroker.vdsbroker.FullListVdsCommand]
(QuartzScheduler_Worker-24) [7d021319] START, FullListVdsCommand(vdsId =
7d3491e8-49ce-11e2-8b2e-000a5e429f63, vds=null,
vmIds=[da09284e-3189-428b-a879-6201f7a5ca87]), log id: f68f564
2013-01-31 11:43:26,086 INFO
 [org.ovirt.engine.core.vdsbroker.vdsbroker.FullListVdsCommand]
(QuartzScheduler_Worker-24) [7d021319] FINISH, FullListVdsCommand, return:
[Lorg.ovirt.engine.core.vdsbroker.xmlrpc.XmlRpcStruct;@33c68023, log id:
f68f564
2013-01-31 11:43:26,091 ERROR
[org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo]
(QuartzScheduler_Worker-24) [7d021319] VM
da09284e-3189-428b-a879-6201f7a5ca87 managed non plugable device was
removed unexpetedly from libvirt:
VmId=da09284e-3189-428b-a879-6201f7a5ca87,DeviceId=aba73f2f-e951-4eba-9da4-8fb58315df2c,Device=memballoon,Type=balloon,BootOrder=0,SpecParams={model=virtio},Address=,IsManaged=true,IsPlugged=true,IsReadOnly=true,alias=
2013-01-31 11:43:26,092 ERROR
[org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo]
(QuartzScheduler_Worker-24) [7d021319] VM
da09284e-3189-428b-a879-6201f7a5ca87 managed non plugable device was
removed unexpetedly from libvirt:
VmId=da09284e-3189-428b-a879-6201f7a5ca87,DeviceId=9bfb770c-13fa-4bf6-9f1f-414927bc31b0,Device=cdrom,Type=disk,BootOrder=0,SpecParams={path=},Address=,IsManaged=true,IsPlugged=true,IsReadOnly=true,alias=
2013-01-31 11:43:31,721 INFO
 [org.ovirt.engine.core.bll.SetVmTicketCommand] (ajp--0.0.0.0-8009-11)
[28d7a789] Running command: SetVmTicketCommand internal: false. Entities
affected :  ID: da09284e-3189-428b-a879-6201f7a5ca87 Type: VM
2013-01-31 11:43:31,724 INFO
 [org.ovirt.engine.core.vdsbroker.vdsbroker.SetVmTicketVDSCommand]
(ajp--0.0.0.0-8009-11) [28d7a789] START, SetVmTicketVDSCommand(vdsId =
7d3491e8-49ce-11e2-8b2e-000a5e429f63,
vmId=da09284e-3189-428b-a879-6201f7a5ca87, ticket=qmcnuOICblb3,
validTime=120,m userName=admin at internal,
userId=fdfc627c-d875-11e0-90f0-83df133b58cc), log id: 6eaacb95
2013-01-31 11:43:31,758 INFO
 [org.ovirt.engine.core.vdsbroker.vdsbroker.SetVmTicketVDSCommand]
(ajp--0.0.0.0-8009-11) [28d7a789] FINISH, SetVmTicketVDSCommand, log id:
6eaacb95

...

2013-01-31 11:49:13,392 WARN
 [org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand]
(QuartzScheduler_Worker-81) [164eaa47] domain
57d184a0-908b-49b5-926f-cd413b9e6526 in problem. vds: host1
2013-01-31 11:49:54,121 ERROR
[org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo]
(QuartzScheduler_Worker-73) [73213e4f] vds::refreshVdsStats Failed
getVdsStats,  vds = 7d3491e8-49ce-11e2-8b2e-000a5e429f63 : host1, error =
VDSNetworkException: VDSNetworkException:
2013-01-31 11:49:54,172 WARN  [org.ovirt.engine.core.vdsbroker.VdsManager]
(QuartzScheduler_Worker-73) [73213e4f]
ResourceManager::refreshVdsRunTimeInfo::Failed to refresh VDS , vds =
7d3491e8-49ce-11e2-8b2e-000a5e429f63 : host1, VDS Network Error, continuing.
VDSNetworkException:

....

In the events windows after VM freezing, I have below events:

 2013-Jan-31, 11:50:52 Failed to elect Host as Storage Pool Manager for
Data Center Default. Setting status to Non-Operational.
 2013-Jan-31, 11:50:52 VM Fedora17 was set to the Unknown status.
 2013-Jan-31, 11:50:52 Host host1 is non-responsive.
 2013-Jan-31, 11:49:55 Invalid status on Data Center Default. Setting Data
Center status to Non-Responsive (On host host1, Error: Network error during
communication with the Host.).
 2013-Jan-31, 11:44:25 VM Fedora17 started on Host host1

Any suggest about the problem?. It seem a libvirt problem, I will continue
investigating.

Many thanks in avanced,

Juanjo.
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.ovirt.org/pipermail/users/attachments/20130131/530ac3f5/attachment-0001.html>
-------------- next part --------------
A non-text attachment was scrubbed...
Name: engine.log
Type: application/octet-stream
Size: 63211 bytes
Desc: not available
URL: <http://lists.ovirt.org/pipermail/users/attachments/20130131/530ac3f5/attachment-0001.obj>