[ovirt-users] getVdsCapabilites unexpected exception [was: Re: AIO 3.4 on fedora 19 initial errors before coming up]

[Gianluca Cecchi]

Actually it seems that today datacenter comes up but starting a windows XP
vm remains in "waiting for launch"

Yesterday I ran an update that impied gluster but I don't think it is
relevant in my environment...

yum.log contains:
May 10 21:24:20 Updated: openstack-java-client-3.0.4-1.fc19.noarch
May 10 21:24:20 Updated: audit-libs-2.3.6-1.fc19.x86_64
May 10 21:24:20 Updated: libjpeg-turbo-1.3.1-2.fc19.x86_64
May 10 21:24:20 Installed: rsyslog-mmjsonparse-7.2.6-1.fc19.x86_64
May 10 21:24:21 Updated: glusterfs-libs-3.5.0-3.fc19.x86_64
May 10 21:24:21 Updated: glusterfs-3.5.0-3.fc19.x86_64
May 10 21:24:21 Updated: openstack-java-quantum-model-3.0.4-1.fc19.noarch
May 10 21:24:21 Updated: openstack-java-glance-model-3.0.4-1.fc19.noarch
May 10 21:24:21 Updated: openstack-java-keystone-model-3.0.4-1.fc19.noarch
May 10 21:24:21 Updated: openstack-java-keystone-client-3.0.4-1.fc19.noarch
May 10 21:24:21 Updated: openstack-java-glance-client-3.0.4-1.fc19.noarch
May 10 21:24:21 Updated: openstack-java-quantum-client-3.0.4-1.fc19.noarch
May 10 21:24:22 Updated: glusterfs-fuse-3.5.0-3.fc19.x86_64
May 10 21:24:22 Updated: glusterfs-api-3.5.0-3.fc19.x86_64
May 10 21:24:22 Updated: glusterfs-rdma-3.5.0-3.fc19.x86_64
May 10 21:24:22 Updated: glusterfs-cli-3.5.0-3.fc19.x86_64
May 10 21:24:22 Updated: libjpeg-turbo-devel-1.3.1-2.fc19.x86_64
May 10 21:24:22 Updated: audit-2.3.6-1.fc19.x86_64
May 10 21:24:22 Updated: audit-libs-python-2.3.6-1.fc19.x86_64
May 10 21:24:23 Updated:
openstack-java-resteasy-connector-3.0.4-1.fc19.noarch
May 10 21:24:23 Updated: 2:microcode_ctl-2.0-7.fc19.x86_64
May 10 21:24:23 Updated: python-ethtool-0.9-2.fc19.x86_64
May 10 21:24:23 Updated: htop-1.0.3-1.fc19.x86_64
May 10 21:24:23 Updated: python-lxml-3.3.5-1.fc19.x86_64
May 10 21:24:28 Updated:
kmod-nvidia-304xx-3.13.11-100.fc19.x86_64-304.119-2.fc19.11.x86_64
May 10 21:24:28 Updated: audit-libs-2.3.6-1.fc19.i686


In my engine.log I see error about getting capabilities...

2014-05-11 10:15:26,759 ERROR
[org.ovirt.engine.core.vdsbroker.vdsbroker.GetCapabilitiesVDSCommand]
(DefaultQuartzScheduler_W
orker-67) Failed in GetCapabilitiesVDS method
2014-05-11 10:15:26,759 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.GetCapabilitiesVDSCommand]
(DefaultQuartzScheduler_W
orker-67) Command
org.ovirt.engine.core.vdsbroker.vdsbroker.GetCapabilitiesVDSCommand return
value
 org.ovirt.engine.core.vdsbroker.vdsbroker.VDSInfoReturnForXmlRpc at 792fc59f
2014-05-11 10:15:26,760 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.GetCapabilitiesVDSCommand]
(DefaultQuartzScheduler_W
orker-67) HostName = local_host
2014-05-11 10:15:26,760 ERROR
[org.ovirt.engine.core.vdsbroker.vdsbroker.GetCapabilitiesVDSCommand]
(DefaultQuartzScheduler_W
orker-67) Command GetCapabilitiesVDSCommand(HostName = local_host, HostId =
aab9571f-da17-4c3c-9e6b-d0224b84c31e, vds=Host[lo
cal_host]) execution failed. Exception: VDSErrorException:
VDSGenericException: VDSErrorException: Failed to GetCapabilitiesV
DS, error = Unexpected exception, code = 16
2014-05-11 10:15:26,771 WARN  [org.ovirt.engine.core.vdsbroker.VdsManager]
(DefaultQuartzScheduler_Worker-67) Failed to refre
sh VDS , vds = aab9571f-da17-4c3c-9e6b-d0224b84c31e : local_host, error =
org.ovirt.engine.core.vdsbroker.vdsbroker.VDSErrorException:
VDSGenericException: VDSErrorException: Failed to GetCapabilitiesVDS, error
= Unexpected exception, code = 16, continuing.:
org.ovirt.engine.core.vdsbroker.vdsbroker.VDSErrorException:
VDSGenericException: VDSErrorException: Failed to GetCapabilitiesVDS, error
= Unexpected exception, code = 16
        at
org.ovirt.engine.core.vdsbroker.vdsbroker.VdsBrokerCommand.createDefaultConcreteException(VdsBrokerCommand.java:61)
[vdsbroker.jar:]
        at
org.ovirt.engine.core.vdsbroker.vdsbroker.BrokerCommandBase.createException(BrokerCommandBase.java:199)
[vdsbroker.jar:]
        at
org.ovirt.engine.core.vdsbroker.vdsbroker.BrokerCommandBase.proceedProxyReturnValue(BrokerCommandBase.java:186)
[vdsbroker.jar:]
        at
org.ovirt.engine.core.vdsbroker.vdsbroker.GetCapabilitiesVDSCommand.executeVdsBrokerCommand(GetCapabilitiesVDSCommand.java:16)
[vdsbroker.jar:]
        at
org.ovirt.engine.core.vdsbroker.vdsbroker.VdsBrokerCommand.executeVDSCommand(VdsBrokerCommand.java:96)
[vdsbroker.jar:]
        at
org.ovirt.engine.core.vdsbroker.VDSCommandBase.executeCommand(VDSCommandBase.java:56)
[vdsbroker.jar:]
        at
org.ovirt.engine.core.dal.VdcCommandBase.execute(VdcCommandBase.java:31)
[dal.jar:]
        at
org.ovirt.engine.core.vdsbroker.VdsManager.refreshCapabilities(VdsManager.java:537)
[vdsbroker.jar:]
        at
org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo.beforeFirstRefreshTreatment(VdsUpdateRunTimeInfo.java:888)
[vdsbroker.jar:]
        at
org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo.refreshVdsRunTimeInfo(VdsUpdateRunTimeInfo.java:499)
[vdsbroker.jar:]
        at
org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo.refresh(VdsUpdateRunTimeInfo.java:337)
[vdsbroker.jar:]
        at
org.ovirt.engine.core.vdsbroker.VdsManager.onTimer(VdsManager.java:236)
[vdsbroker.jar:]
        at sun.reflect.GeneratedMethodAccessor35.invoke(Unknown Source)
[:1.7.0_55]
        at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[rt.jar:1.7.0_55]
        at java.lang.reflect.Method.invoke(Method.java:606)
[rt.jar:1.7.0_55]
        at
org.ovirt.engine.core.utils.timer.JobWrapper.execute(JobWrapper.java:60)
[scheduler.jar:]
        at org.quartz.core.JobRunShell.run(JobRunShell.java:213)
[quartz.jar:]
        at
org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:557)
[quartz.jar:]

[root at tekkaman ovirt-engine]# vdsClient -s 0 getVdsCapabilities
Unexpected exception

the qemu command line is

qemu      8470     1  5 09:58 ?        00:00:57 /usr/bin/qemu-system-x86_64
-machine accel=kvm -name winxp -S -machine pc-1.0,accel=kvm,usb=off -cpu
Opteron_G3 -m 2048 -realtime mlock=off -smp
1,maxcpus=160,sockets=160,cores=1,threads=1 -uuid
2981b979-a363-4ab9-a251-439b5774b04d -smbios
type=1,manufacturer=oVirt,product=oVirt
Node,version=19-8,serial=E0E1001E-8C00-002A-6F9A-90E6BAC9F1E1,uuid=2981b979-a363-4ab9-a251-439b5774b04d
-no-user-config -nodefaults -chardev
socket,id=charmonitor,path=/var/lib/libvirt/qemu/winxp.monitor,server,nowait
-mon chardev=charmonitor,id=monitor,mode=control -rtc
base=2014-05-11T09:58:34,driftfix=slew -no-shutdown -device
ich9-usb-ehci1,id=usb,bus=pci.0,addr=0x5.0x7 -device
ich9-usb-uhci2,masterbus=usb.0,firstport=2,bus=pci.0,addr=0x5.0x1 -device
ich9-usb-uhci1,masterbus=usb.0,firstport=0,bus=pci.0,multifunction=on,addr=0x5
-device ich9-usb-uhci3,masterbus=usb.0,firstport=4,bus=pci.0,addr=0x5.0x2
-device virtio-serial-pci,id=virtio-serial0,bus=pci.0,addr=0x7 -drive
if=none,id=drive-ide0-1-0,readonly=on,format=raw,serial= -device
ide-cd,bus=ide.1,unit=0,drive=drive-ide0-1-0,id=ide0-1-0 -drive
file=/rhev/data-center/mnt/_DATA/0a8035e6-e41d-40ff-a154-e0a374f264b2/images/75c54716-5222-4ad6-91f2-8b312eacc4b4/d4fa7785-8a89-4d13-9082-52556ab0b326,if=none,id=drive-virtio-disk0,format=raw,serial=75c54716-5222-4ad6-91f2-8b312eacc4b4,cache=none,werror=stop,rerror=stop,aio=threads
-device
virtio-blk-pci,scsi=off,bus=pci.0,addr=0x6,drive=drive-virtio-disk0,id=virtio-disk0,bootindex=1
-netdev tap,fd=26,id=hostnet0,vhost=on,vhostfd=27 -device
virtio-net-pci,netdev=hostnet0,id=net0,mac=00:1a:4a:a8:01:52,bus=pci.0,addr=0x3
-chardev
socket,id=charchannel0,path=/var/lib/libvirt/qemu/channels/2981b979-a363-4ab9-a251-439b5774b04d.com.redhat.rhevm.vdsm,server,nowait
-device
virtserialport,bus=virtio-serial0.0,nr=1,chardev=charchannel0,id=channel0,name=com.redhat.rhevm.vdsm
-chardev
socket,id=charchannel1,path=/var/lib/libvirt/qemu/channels/2981b979-a363-4ab9-a251-439b5774b04d.org.qemu.guest_agent.0,server,nowait
-device
virtserialport,bus=virtio-serial0.0,nr=2,chardev=charchannel1,id=channel1,name=org.qemu.guest_agent.0
-chardev spicevmc,id=charchannel2,name=vdagent -device
virtserialport,bus=virtio-serial0.0,nr=3,chardev=charchannel2,id=channel2,name=com.redhat.spice.0
-spice
tls-port=5900,addr=0,x509-dir=/etc/pki/vdsm/libvirt-spice,tls-channel=main,tls-channel=display,tls-channel=inputs,tls-channel=cursor,tls-channel=playback,tls-channel=record,tls-channel=smartcard,tls-channel=usbredir,seamless-migration=on
-k en-us -device
qxl-vga,id=video0,ram_size=67108864,vram_size=67108864,bus=pci.0,addr=0x2
-device AC97,id=sound0,bus=pci.0,addr=0x4 -chardev
spicevmc,id=charredir0,name=usbredir -device
usb-redir,chardev=charredir0,id=redir0 -chardev
spicevmc,id=charredir1,name=usbredir -device
usb-redir,chardev=charredir1,id=redir1 -chardev
spicevmc,id=charredir2,name=usbredir -device
usb-redir,chardev=charredir2,id=redir2 -chardev
spicevmc,id=charredir3,name=usbredir -device
usb-redir,chardev=charredir3,id=redir3 -device
virtio-balloon-pci,id=balloon0,bus=pci.0,addr=0x8


[root at tekkaman ovirt-engine]# cat /proc/cpuinfo
processor    : 0
vendor_id    : AuthenticAMD
cpu family    : 16
model        : 5
model name    : AMD Athlon(tm) II X4 630 Processor
stepping    : 2
microcode    : 0x10000db
cpu MHz        : 2800.000
cache size    : 512 KB
physical id    : 0
siblings    : 4
core id        : 0
cpu cores    : 4
apicid        : 0
initial apicid    : 0
fpu        : yes
fpu_exception    : yes
cpuid level    : 5
wp        : yes
flags        : fpu vme de pse tsc msr pae mce cx8 apic sep mtrr pge mca
cmov pat pse36 clflush mmx fxsr sse sse2 ht syscall nx mmxext fxsr_opt
pdpe1gb rdtscp lm 3dnowext 3dnow constant_tsc rep_good nopl nonstop_tsc
extd_apicid pni monitor cx16 popcnt lahf_lm cmp_legacy svm extapic
cr8_legacy abm sse4a misalignsse 3dnowprefetch osvw ibs skinit wdt
hw_pstate npt lbrv svm_lock nrip_save
bogomips    : 5600.37
TLB size    : 1024 4K pages
clflush size    : 64
cache_alignment    : 64
address sizes    : 48 bits physical, 48 bits virtual
power management: ts ttp tm stc 100mhzsteps hwpstate
...
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.ovirt.org/pipermail/users/attachments/20140511/2f83891a/attachment-0001.html>