----- "Justin Clacherty" <justin at redfish-group.com> wrote:
> The problem I have now is that the node doesn't become available for
> some reason. It boots and get's the node image but "ruby
> /usr/share/ovirt-server/qmf-libvirt-example.rb" doesn't show
anything.
>
> The host-browser log shows the node though... Any ideas on where I
> look
> next?
I'm still having issues with this problem and things are starting to get
quite frustrating. I've spent the last two days installing and reinstalling
the management server (even tried getting next to work). I've currently got
a clean install of F10 in a vm and a fresh install of ovirt from the ovirt
repository. This installation is experiencing the exact same problem that
caused me to try a reinstall, it's as if one of the updates to fedora has
killed it (I think there was a qmf and a qpid update).
Here's what happens:
- management server is running
- node boots
- node details appear in /var/log/ovirt-server/host-browser.log
- node appears in GUI but appears as "unavailable (enabled)"
- running "ruby /usr/share/ovirt-server/qmf-libvirt-example.rb" yeilds
no results
Has anyone else seen this? I would appreciate it if someone could help me to
debug the problem?
I've put the output of the ruby script, taskomatic.log, and host-browser.log
below in case it's of use.
I'll start searching the wiki to see how to log in to the node and check its
logs but I think that requires a developer build which I was unable to get
working. Hopefully it's just a matter of passing something to the kernel at
boot using cobbler.
Cheers,
Justin.
ruby script
==========
[root at ovirt ovirt-server]# ruby
/usr/share/ovirt-server/qmf-libvirt-example.rb
Connecting to amqp://ovirt.redfish.local:5672..
----------------------------
----------------------------
taskomatic.log
=============
[root at ovirt ovirt-server]# cat taskomatic.log
INFO Fri Jul 31 17:33:55 +1000 2009 (5915) Connecting to
amqp://ovirt.redfish.local:5672
INFO Fri Jul 31 17:33:55 +1000 2009 (5915) Cannot implement tasks, not connected
to broker. Sleeping.
INFO Fri Jul 31 17:34:01 +1000 2009 (5915) Cannot implement tasks, not connected
to broker. Sleeping.
INFO Fri Jul 31 17:34:07 +1000 2009 (5915) Cannot implement tasks, not connected
to broker. Sleeping.
host-browser.log
===============
[root at ovirt ovirt-server]# cat host-browser.log
Connected to node3.redfish.local
Jul 31 17:54:37 192.168.50.3 Begin conversation
Jul 31 17:54:37 192.168.50.3 Determining the runtime mode.
Jul 31 17:54:37 192.168.50.3 MODE=AWAKEN
Writing keytab file: /usr/share/ipa/html/192.168.50.3-libvirt.tab
WARNING: no policy specified for libvirt/node3.redfish.local at REDFISH.LOCAL;
defaulting to no policy
Authenticating as principal root/admin at REDFISH.LOCAL with password.
Principal "libvirt/node3.redfish.local at REDFISH.LOCAL" created.
Authenticating as principal root/admin at REDFISH.LOCAL with password.
Entry for principal libvirt/node3.redfish.local at REDFISH.LOCAL with kvno 3,
encryption type AES-256 CTS mode with 96-bit SHA-1 HMAC added to keytab
WRFILE:/usr/share/ipa/html/192.168.50.3-libvirt.tab.
Entry for principal libvirt/node3.redfish.local at REDFISH.LOCAL with kvno 3,
encryption type AES-128 CTS mode with 96-bit SHA-1 HMAC added to keytab
WRFILE:/usr/share/ipa/html/192.168.50.3-libvirt.tab.
Entry for principal libvirt/node3.redfish.local at REDFISH.LOCAL with kvno 3,
encryption type Triple DES cbc mode with HMAC/sha1 added to keytab
WRFILE:/usr/share/ipa/html/192.168.50.3-libvirt.tab.
Entry for principal libvirt/node3.redfish.local at REDFISH.LOCAL with kvno 3,
encryption type ArcFour with HMAC/md5 added to keytab
WRFILE:/usr/share/ipa/html/192.168.50.3-libvirt.tab.
Entry for principal libvirt/node3.redfish.local at REDFISH.LOCAL with kvno 3,
encryption type DES with HMAC/sha1 added to keytab
WRFILE:/usr/share/ipa/html/192.168.50.3-libvirt.tab.
Entry for principal libvirt/node3.redfish.local at REDFISH.LOCAL with kvno 3,
encryption type DES cbc mode with RSA-MD5 added to keytab
WRFILE:/usr/share/ipa/html/192.168.50.3-libvirt.tab.
WARNING: no policy specified for qpidd/node3.redfish.local at REDFISH.LOCAL;
defaulting to no policy
Authenticating as principal root/admin at REDFISH.LOCAL with password.
Principal "qpidd/node3.redfish.local at REDFISH.LOCAL" created.
Authenticating as principal root/admin at REDFISH.LOCAL with password.
Entry for principal qpidd/node3.redfish.local at REDFISH.LOCAL with kvno 3,
encryption type AES-256 CTS mode with 96-bit SHA-1 HMAC added to keytab
WRFILE:/usr/share/ipa/html/192.168.50.3-libvirt.tab.
Entry for principal qpidd/node3.redfish.local at REDFISH.LOCAL with kvno 3,
encryption type AES-128 CTS mode with 96-bit SHA-1 HMAC added to keytab
WRFILE:/usr/share/ipa/html/192.168.50.3-libvirt.tab.
Entry for principal qpidd/node3.redfish.local at REDFISH.LOCAL with kvno 3,
encryption type Triple DES cbc mode with HMAC/sha1 added to keytab
WRFILE:/usr/share/ipa/html/192.168.50.3-libvirt.tab.
Entry for principal qpidd/node3.redfish.local at REDFISH.LOCAL with kvno 3,
encryption type ArcFour with HMAC/md5 added to keytab
WRFILE:/usr/share/ipa/html/192.168.50.3-libvirt.tab.
Entry for principal qpidd/node3.redfish.local at REDFISH.LOCAL with kvno 3,
encryption type DES with HMAC/sha1 added to keytab
WRFILE:/usr/share/ipa/html/192.168.50.3-libvirt.tab.
Entry for principal qpidd/node3.redfish.local at REDFISH.LOCAL with kvno 3,
encryption type DES cbc mode with RSA-MD5 added to keytab
WRFILE:/usr/share/ipa/html/192.168.50.3-libvirt.tab.
Jul 31 17:54:38 192.168.50.3 Ending conversation
Disconnected from node3.redfish.local
Connected to node3.redfish.local
Jul 31 17:54:48 192.168.50.3 Begin conversation
Jul 31 17:54:48 192.168.50.3 Determining the runtime mode.
Jul 31 17:54:48 192.168.50.3 MODE=IDENTIFY
Jul 31 17:54:48 192.168.50.3 Begin remote info collection
Received info='ARCH=x86_64'
Jul 31 17:54:48 192.168.50.3 ::Received - ARCH:x86_64
Received info='UUID=8E3B3537-7037-11DD-AF96-000BAB041352'
Jul 31 17:54:48 192.168.50.3 ::Received -
UUID:8E3B3537-7037-11DD-AF96-000BAB041352
Received info='MEMSIZE=8195028'
Jul 31 17:54:48 192.168.50.3 ::Received - MEMSIZE:8195028
Received info='CPU'
Begin receiving CPU details
Jul 31 17:54:49 192.168.50.3 ::Received - CPUNUM:0
Jul 31 17:54:49 192.168.50.3 ::Received - CORENUM:0
Jul 31 17:54:49 192.168.50.3 ::Received - NUMCORES:4
Jul 31 17:54:49 192.168.50.3 ::Received - VENDOR:GenuineIntel
Jul 31 17:54:49 192.168.50.3 ::Received - MODEL:23
Jul 31 17:54:49 192.168.50.3 ::Received - FAMILY:6
Jul 31 17:54:49 192.168.50.3 ::Received - CPUIDLVL:10
Jul 31 17:54:49 192.168.50.3 ::Received - SPEED:2000.000
Jul 31 17:54:49 192.168.50.3 ::Received - CACHE:6144 KB
Jul 31 17:54:49 192.168.50.3 ::Received - FLAGS:fpu vme de pse tsc msr pae mce
cx8 apic sep mtrr pge mca cmov pat pse36 clflush dts acpi mmx fxsr sse sse2 ss
ht tm pbe syscall nx lm constant_tsc arch_perfmon pebs bts rep_good nopl pni
monitor ds_cpl vmx smx est tm2 ssse3 cx16 xtpr sse4_1 lah
Received info='CPU'
Begin receiving CPU details
Jul 31 17:54:49 192.168.50.3 ::Received - CPUNUM:1
Jul 31 17:54:49 192.168.50.3 ::Received - CORENUM:2
Jul 31 17:54:49 192.168.50.3 ::Received - NUMCORES:4
Jul 31 17:54:49 192.168.50.3 ::Received - VENDOR:GenuineIntel
Jul 31 17:54:49 192.168.50.3 ::Received - MODEL:23
Jul 31 17:54:49 192.168.50.3 ::Received - FAMILY:6
Jul 31 17:54:49 192.168.50.3 ::Received - CPUIDLVL:10
Jul 31 17:54:49 192.168.50.3 ::Received - SPEED:2000.000
Jul 31 17:54:49 192.168.50.3 ::Received - CACHE:6144 KB
Jul 31 17:54:49 192.168.50.3 ::Received - FLAGS:fpu vme de pse tsc msr pae mce
cx8 apic sep mtrr pge mca cmov pat pse36 clflush dts acpi mmx fxsr sse sse2 ss
ht tm pbe syscall nx lm constant_tsc arch_perfmon pebs bts rep_good nopl pni
monitor ds_cpl vmx smx est tm2 ssse3 cx16 xtpr sse4_1 lah
Received info='CPU'
Begin receiving CPU details
Jul 31 17:54:50 192.168.50.3 ::Received - CPUNUM:2
Jul 31 17:54:50 192.168.50.3 ::Received - CORENUM:1
Jul 31 17:54:50 192.168.50.3 ::Received - NUMCORES:4
Jul 31 17:54:50 192.168.50.3 ::Received - VENDOR:GenuineIntel
Jul 31 17:54:50 192.168.50.3 ::Received - MODEL:23
Jul 31 17:54:50 192.168.50.3 ::Received - FAMILY:6
Jul 31 17:54:50 192.168.50.3 ::Received - CPUIDLVL:10
Jul 31 17:54:50 192.168.50.3 ::Received - SPEED:2000.000
Jul 31 17:54:50 192.168.50.3 ::Received - CACHE:6144 KB
Jul 31 17:54:50 192.168.50.3 ::Received - FLAGS:fpu vme de pse tsc msr pae mce
cx8 apic sep mtrr pge mca cmov pat pse36 clflush dts acpi mmx fxsr sse sse2 ss
ht tm pbe syscall nx lm constant_tsc arch_perfmon pebs bts rep_good nopl pni
monitor ds_cpl vmx smx est tm2 ssse3 cx16 xtpr sse4_1 lah
Received info='CPU'
Begin receiving CPU details
Jul 31 17:54:50 192.168.50.3 ::Received - CPUNUM:3
Jul 31 17:54:50 192.168.50.3 ::Received - CORENUM:3
Jul 31 17:54:50 192.168.50.3 ::Received - NUMCORES:4
Jul 31 17:54:50 192.168.50.3 ::Received - VENDOR:GenuineIntel
Jul 31 17:54:50 192.168.50.3 ::Received - MODEL:23
Jul 31 17:54:50 192.168.50.3 ::Received - FAMILY:6
Jul 31 17:54:50 192.168.50.3 ::Received - CPUIDLVL:10
Jul 31 17:54:50 192.168.50.3 ::Received - SPEED:2000.000
Jul 31 17:54:50 192.168.50.3 ::Received - CACHE:6144 KB
Jul 31 17:54:50 192.168.50.3 ::Received - FLAGS:fpu vme de pse tsc msr pae mce
cx8 apic sep mtrr pge mca cmov pat pse36 clflush dts acpi mmx fxsr sse sse2 ss
ht tm pbe syscall nx lm constant_tsc arch_perfmon pebs bts rep_good nopl pni
monitor ds_cpl vmx smx est tm2 ssse3 cx16 xtpr sse4_1 lah
Received info='NIC'
Begin receiving NIC details
Jul 31 17:54:50 192.168.50.3 ::Received - MAC:00:15:17:8d:01:1a
Jul 31 17:54:51 192.168.50.3 ::Received - BANDWIDTH:1000
Jul 31 17:54:51 192.168.50.3 ::Received - IFACE_NAME:eth0
Received info='ENDINFO'
Searching for existing host record...
Creating a new record for node3.redfish.local...
Deleting any existing CPUs
Saving new CPU records
Updating NIC records for the node
Creating a new nic: eth0 [00:15:17:8d:01:1a]
Jul 31 17:54:51 192.168.50.3 Ending conversation
Disconnected from node3.redfish.local