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

Roy Golan rgolan at redhat.com
Sun May 11 10:10:07 EDT 2014 

On 05/11/2014 11:22 AM, Gianluca Cecchi wrote:
> 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
> ...
>
>
>
>
> _______________________________________________
> Users mailing list
> Users at ovirt.org
> http://lists.ovirt.org/mailman/listinfo/users

The vm will stay in "Waiting.." as the getVdsCaps is failing and the 
monitoring of Vms will not take place.
need to fix this "Unexpected error" first. is it a matter of ssl enabled 
configuration for host communication? i.e. can you try vdsClient -s 0 
getVdsCaps ?

-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.ovirt.org/pipermail/users/attachments/20140511/0a8a91bf/attachment-0001.html>

More information about the Users mailing list