[one-users] [VMM][E]: deploy_action, error getting driver vm_kvm
Hendrik Wißmann
wissmann at gmx.de
Wed Feb 8 10:59:56 PST 2012
Hello,
I'm trying to evaluate openNebula 3.2.0 (Centos 6.1) using KVM. Doing so
I chose a two node installation environment with one frontend and one
KVM server with the following packages installed:
KVM:
libvirt-client-0.9.4-23.el6_2.4.x86_64
libvirt-devel-0.9.4-23.el6_2.4.x86_64
libvirt-python-0.9.4-23.el6_2.4.x86_64
libvirt-0.9.4-23.el6_2.4.x86_64
qemu-img-0.12.1.2-2.209.el6_2.4.x86_64
qemu-kvm-0.12.1.2-2.209.el6_2.4.x86_64
qemu-kvm-tools-0.12.1.2-2.209.el6_2.4.x86_64
gpxe-roms-qemu-0.9.7-6.9.el6.noarch
ruby-libs-1.8.7.352-3.el6.x86_64
ruby-1.8.7.352-3.el6.x86_64
Modifications of the following configuration files:
/etc/libvirt/qemu.conf
user = "oneadmin"
group = "oneadmin"
dynamic_ownership = 0
unix_sock_rw_perms = "0777"
auth_unix_ro = "none"
auth_unix_rw = "none"
/etc/libvirt/libvirtd.conf
listen-tcp = 1
File doesn't exist, but it should be an ubuntu file:
/etc/default/libvirt-bin : add -l option to libvirtd_opts
/etc/polkit-1/localauthority/50-local.d/50-org.example-libvirt-remote-access.pkla
[libvirt Management Access]
Identity=unix-group:oneadmin
Action=org.libvirt.unix.manage
ResultAny=yes
ResultInactive=yes
ResultActive=yes
frontend:
ruby-irb-1.8.7.352-4.el6_2.x86_64
rubygem-rack-test-0.5.4-1.el6.noarch
ruby-libs-1.8.7.352-4.el6_2.x86_64
ruby-devel-1.8.7.352-4.el6_2.x86_64
ruby-rdoc-1.8.7.352-4.el6_2.x86_64
rubygem-sinatra-1.0-2.el6.noarch
rubygems-1.3.7-1.el6.noarch
ruby-1.8.7.352-4.el6_2.x86_64
rubygem-rack-1.1.0-2.el6.noarch
After configuring, setting up a NFS-server (/var/lib/one) and mounting
the directory in
the same place on the KVM server, I registered the host, an image, a
template and
a network-configuration:
onehost create centos-2 im_kvm vm_kvm tm_shared ovswitch
Image
NAME = "CentOS6"
PATH = /onerep/centos.img
TYPE = OS
DESCRIPTION = "CentOS 6.1 Server"
Network
NAME = "First Lan"
TYPE = FIXED
BRIDGE = br0
LEASES = [IP=xxx.yyy.zzz.115]
LEASES = [IP=xxx.yyy.zzz.116]
NAME = CentOS-Templ
CPU = 1
MEMORY = 512
# --- kernel & boot device ---
OS = [
kernel = "/vmlinuz",
initrd = "/initrd.img",
root = "sda" ]
# --- 3 disks ---
DISK = [ IMAGE_ID = 13 ]
DISK = [
type = swap,
size = 1024,
readonly = "no" ]
# --- 1 NIC ---
NIC = [ NETWORK_ID = 0 ]
# --- Placement options ---
REQUIREMENTS = "CPUSPEED > 1000"
RANK = FREECPU
The start of a virtual machine results in an error:
Wed Feb 8 19:20:13 2012 [ONE][I]: Starting OpenNebula 3.2.0
----------------------------------------
OpenNebula Configuration File
----------------------------------------
AUTH_MAD=ARGUMENTS=--authn
ssh,x509,ldap,server_cipher,server_x509,EXECUTABLE=one_auth_mad
DB=BACKEND=sqlite
DEBUG_LEVEL=3
DEFAULT_DEVICE_PREFIX=hd
DEFAULT_IMAGE_TYPE=OS
ENABLE_OTHER_PERMISSIONS=YES
HM_MAD=EXECUTABLE=one_hm
HOST_MONITORING_INTERVAL=600
HOST_PER_INTERVAL=15
IMAGE_MAD=ARGUMENTS=fs -t 15,EXECUTABLE=one_image
IM_MAD=ARGUMENTS=-r 0 -t 15
kvm,EXECUTABLE=one_im_ssh,NAME=im_kvm,ONE_MAD_DEBUG=1
MAC_PREFIX=02:00
MANAGER_TIMER=15
NETWORK_SIZE=254
ONE_MAD_DEBUG=1
PORT=2633
SCRIPTS_REMOTE_DIR=/var/tmp/one
SESSION_EXPIRATION_TIME=900
TM_MAD=ARGUMENTS=tm_shared/tm_shared.conf,EXECUTABLE=one_tm,NAME=tm_shared
VM_DIR=/var/lib/one/
VM_MAD=ARGUMENTS=-t 15 -r 0
kvm,DEFAULT=vmm_exec/vmm_exec_kvm.conf,EXECUTABLE=one_vmm_exec,NAME=vmm_kvm,TYPE=kvm
VM_PER_INTERVAL=5
VM_POLLING_INTERVAL=600
VNC_BASE_PORT=5900
----------------------------------------
Wed Feb 8 19:20:13 2012 [ONE][I]: Log level:3
[0=ERROR,1=WARNING,2=INFO,3=DEBUG]
Wed Feb 8 19:20:13 2012 [ONE][I]: Checking database version.
Wed Feb 8 19:20:13 2012 [VMM][I]: Starting Virtual Machine Manager...
Wed Feb 8 19:20:13 2012 [VMM][I]: Virtual Machine Manager started.
Wed Feb 8 19:20:13 2012 [LCM][I]: Starting Life-cycle Manager...
Wed Feb 8 19:20:13 2012 [LCM][I]: Life-cycle Manager started.
Wed Feb 8 19:20:13 2012 [InM][I]: Starting Information Manager...
Wed Feb 8 19:20:13 2012 [InM][I]: Information Manager started.
Wed Feb 8 19:20:13 2012 [TrM][I]: Starting Transfer Manager...
Wed Feb 8 19:20:13 2012 [TrM][I]: Transfer Manager started.
Wed Feb 8 19:20:13 2012 [DiM][I]: Starting Dispatch Manager...
Wed Feb 8 19:20:13 2012 [DiM][I]: Dispatch Manager started.
Wed Feb 8 19:20:13 2012 [HKM][I]: Starting Hook Manager...
Wed Feb 8 19:20:13 2012 [HKM][I]: Hook Manager started.
Wed Feb 8 19:20:13 2012 [AuM][I]: Starting Auth Manager...
Wed Feb 8 19:20:13 2012 [AuM][I]: Authorization Manager started.
Wed Feb 8 19:20:13 2012 [ImM][I]: Starting Image Manager...
Wed Feb 8 19:20:13 2012 [ImM][I]: Image Manager started.
Wed Feb 8 19:20:13 2012 [ReM][I]: Starting Request Manager...
Wed Feb 8 19:20:13 2012 [ReM][I]: Starting XML-RPC server, port 2633 ...
Wed Feb 8 19:20:13 2012 [ReM][I]: Request Manager started.
Wed Feb 8 19:20:15 2012 [VMM][I]: Loading Virtual Machine Manager drivers.
Wed Feb 8 19:20:15 2012 [VMM][I]: Loading driver: vmm_kvm (KVM)
Wed Feb 8 19:20:15 2012 [VMM][I]: Driver vmm_kvm loaded.
Wed Feb 8 19:20:15 2012 [InM][I]: Loading Information Manager drivers.
Wed Feb 8 19:20:15 2012 [InM][I]: Loading driver: im_kvm
Wed Feb 8 19:20:15 2012 [InM][I]: Driver im_kvm loaded
Wed Feb 8 19:20:15 2012 [TM][I]: Loading Transfer Manager drivers.
Wed Feb 8 19:20:15 2012 [VMM][I]: Loading driver: tm_shared
Wed Feb 8 19:20:15 2012 [TM][I]: Driver tm_shared loaded.
Wed Feb 8 19:20:15 2012 [HKM][I]: Loading Hook Manager driver.
Wed Feb 8 19:20:15 2012 [HKM][I]: Hook Manager loaded
Wed Feb 8 19:20:15 2012 [ImM][I]: Loading Image Manager driver.
Wed Feb 8 19:20:15 2012 [ImM][I]: Image Manager loaded
Wed Feb 8 19:20:15 2012 [AuM][I]: Loading Auth. Manager driver.
Wed Feb 8 19:20:15 2012 [AuM][I]: Auth Manager loaded
Wed Feb 8 19:20:20 2012 [ReM][D]: VirtualMachinePoolInfo method invoked
Wed Feb 8 19:20:28 2012 [InM][I]: Monitoring host centos-2 (5)
Wed Feb 8 19:20:31 2012 [InM][I]: ExitCode: 0
Wed Feb 8 19:20:31 2012 [InM][D]: Host 5 successfully monitored.
Wed Feb 8 19:20:43 2012 [ReM][D]: HostPoolInfo method invoked
Wed Feb 8 19:20:43 2012 [ReM][D]: VirtualMachinePoolInfo method invoked
Wed Feb 8 19:20:43 2012 [ReM][D]: AclInfo method invoked
Wed Feb 8 19:20:43 2012 [ReM][D]: HostPoolInfo method invoked
Wed Feb 8 19:20:53 2012 [ReM][D]: HostInfo method invoked
Wed Feb 8 19:21:13 2012 [ReM][D]: HostPoolInfo method invoked
Wed Feb 8 19:21:13 2012 [ReM][D]: VirtualMachinePoolInfo method invoked
Wed Feb 8 19:21:13 2012 [ReM][D]: AclInfo method invoked
Wed Feb 8 19:21:13 2012 [ReM][D]: UserPoolInfo method invoked
Wed Feb 8 19:21:13 2012 [AuM][D]: Message received: LOG I 0 ExitCode: 0
....
Wed Feb 8 19:22:13 2012 [ReM][D]: HostPoolInfo method invoked
Wed Feb 8 19:22:13 2012 [ReM][D]: VirtualMachinePoolInfo method invoked
Wed Feb 8 19:22:13 2012 [ReM][D]: AclInfo method invoked
Wed Feb 8 19:22:13 2012 [ReM][D]: VirtualMachineDeploy method invoked
Wed Feb 8 19:22:13 2012 [DiM][D]: Deploying VM 20
Wed Feb 8 19:22:17 2012 [ReM][D]: GroupPoolInfo method invoked
Wed Feb 8 19:22:17 2012 [AuM][D]: Message received: LOG I 21 ExitCode: 0
Wed Feb 8 19:22:17 2012 [AuM][I]: ExitCode: 0
Wed Feb 8 19:22:17 2012 [AuM][D]: Message received: AUTHENTICATE
SUCCESS 21 -
Wed Feb 8 19:22:21 2012 [ReM][D]: HostPoolInfo method invoked
Wed Feb 8 19:22:26 2012 [TM][D]: Message received: LOG D 20
tm_clone.sh:
centos-1.fernuni-hagen.de:/var/lib/one/images/6ff900f642a88eede3277db946a617c3
centos-2:/var/lib/one//20/images/disk.0
Wed Feb 8 19:22:26 2012 [TM][D]: Message received: LOG D 20
tm_clone.sh: DST: /var/lib/one//20/images/disk.0
Wed Feb 8 19:22:26 2012 [TM][D]: Message received: LOG I 20
tm_clone.sh: Creating directory /var/lib/one//20/images
Wed Feb 8 19:22:26 2012 [TM][D]: Message received: LOG I 20
tm_clone.sh: Executed "mkdir -p /var/lib/one//20/images".
Wed Feb 8 19:22:26 2012 [TM][D]: Message received: LOG I 20
tm_clone.sh: Executed "chmod a+w /var/lib/one//20/images".
Wed Feb 8 19:22:26 2012 [TM][D]: Message received: LOG I 20
tm_clone.sh: Cloning /var/lib/one/images/6ff900f642a88eede3277db946a617c3
Wed Feb 8 19:22:26 2012 [TM][D]: Message received: LOG I 20
tm_clone.sh: Executed "cp -r
/var/lib/one/images/6ff900f642a88eede3277db946a617c3
/var/lib/one//20/images/disk.0".
Wed Feb 8 19:22:26 2012 [TM][D]: Message received: LOG I 20
tm_clone.sh: Executed "chmod a+rw /var/lib/one//20/images/disk.0".
Wed Feb 8 19:22:26 2012 [TM][D]: Message received: LOG I 20 ExitCode: 0
Wed Feb 8 19:22:26 2012 [AuM][D]: Message received: LOG I 22 ExitCode: 0
Wed Feb 8 19:22:26 2012 [AuM][I]: ExitCode: 0
Wed Feb 8 19:22:26 2012 [AuM][D]: Message received: AUTHENTICATE
SUCCESS 22 -
Wed Feb 8 19:22:26 2012 [TM][D]: Message received: LOG D 20
tm_mkswap.sh: Creating directory /var/lib/one//20/images
Wed Feb 8 19:22:26 2012 [TM][D]: Message received: LOG I 20
tm_mkswap.sh: Executed "mkdir -p /var/lib/one//20/images".
Wed Feb 8 19:22:26 2012 [TM][D]: Message received: LOG I 20
tm_mkswap.sh: Executed "chmod a+w /var/lib/one//20/images".
Wed Feb 8 19:22:26 2012 [TM][D]: Message received: LOG D 20
tm_mkswap.sh: Creating 1024Mb image in /var/lib/one//20/images/disk.1
Wed Feb 8 19:22:26 2012 [TM][D]: Message received: LOG I 20
tm_mkswap.sh: Executed "dd if=/dev/zero
of=/var/lib/one//20/images/disk.1 bs=1 count=1 seek=1024M".
Wed Feb 8 19:22:26 2012 [TM][D]: Message received: LOG D 20
tm_mkswap.sh: Initializing swap space
Wed Feb 8 19:22:26 2012 [TM][D]: Message received: LOG I 20
tm_mkswap.sh: Executed "mkswap /var/lib/one//20/images/disk.1".
Wed Feb 8 19:22:26 2012 [TM][D]: Message received: LOG I 20
tm_mkswap.sh: Executed "chmod a+w /var/lib/one//20/images/disk.1".
Wed Feb 8 19:22:26 2012 [TM][D]: Message received: LOG I 20 ExitCode: 0
Wed Feb 8 19:22:26 2012 [TM][D]: Message received: TRANSFER SUCCESS 20 -
Wed Feb 8 19:22:29 2012 [ReM][D]: ImagePoolInfo method invoked
Wed Feb 8 19:22:29 2012 [AuM][D]: Message received: LOG I 23 ExitCode: 0
Wed Feb 8 19:22:29 2012 [AuM][I]: ExitCode: 0
Wed Feb 8 19:22:29 2012 [AuM][D]: Message received: AUTHENTICATE
SUCCESS 23 -
Wed Feb 8 19:22:31 2012 [ReM][D]: TemplatePoolInfo method invoked
Wed Feb 8 19:22:31 2012 [AuM][D]: Message received: LOG I 24 ExitCode: 0
Wed Feb 8 19:22:31 2012 [AuM][I]: ExitCode: 0
Wed Feb 8 19:22:31 2012 [AuM][D]: Message received: AUTHENTICATE
SUCCESS 24 -
Wed Feb 8 19:22:34 2012 [ReM][D]: VirtualMachinePoolInfo method invoked
Wed Feb 8 19:22:34 2012 [AuM][D]: Message received: LOG I 25 ExitCode: 0
Wed Feb 8 19:22:34 2012 [AuM][I]: ExitCode: 0
Wed Feb 8 19:22:34 2012 [AuM][D]: Message received: AUTHENTICATE
SUCCESS 25 -
Wed Feb 8 19:22:37 2012 [ReM][D]: AclInfo method invoked
Wed Feb 8 19:22:38 2012 [AuM][D]: Message received: LOG I 26 ExitCode: 0
Wed Feb 8 19:22:38 2012 [AuM][I]: ExitCode: 0
Wed Feb 8 19:22:38 2012 [AuM][D]: Message received: AUTHENTICATE
SUCCESS 26 -
Wed Feb 8 19:22:38 2012 [AuM][D]: Message received: AUTHORIZE SUCCESS 27 -
Wed Feb 8 19:22:38 2012 [ReM][D]: UserPoolInfo method invoked
Wed Feb 8 19:22:38 2012 [AuM][D]: Message received: LOG I 28 ExitCode: 0
Wed Feb 8 19:22:38 2012 [AuM][I]: ExitCode: 0
Wed Feb 8 19:22:38 2012 [AuM][D]: Message received: AUTHENTICATE
SUCCESS 28 -
Wed Feb 8 19:22:41 2012 [ReM][D]: VirtualNetworkPoolInfo method invoked
Wed Feb 8 19:22:41 2012 [AuM][D]: Message received: LOG I 29 ExitCode: 0
Wed Feb 8 19:22:41 2012 [AuM][I]: ExitCode: 0
Wed Feb 8 19:22:41 2012 [AuM][D]: Message received: AUTHENTICATE
SUCCESS 29 -
Wed Feb 8 19:22:43 2012 [ReM][D]: HostPoolInfo method invoked
Wed Feb 8 19:22:43 2012 [ReM][D]: VirtualMachinePoolInfo method invoked
Wed Feb 8 19:22:43 2012 [ReM][D]: AclInfo method invoked
Wed Feb 8 19:22:57 2012 [ReM][D]: VirtualMachineInfo method invoked
Wed Feb 8 19:22:57 2012 [AuM][D]: Message received: LOG I 30 ExitCode: 0
Wed Feb 8 19:22:57 2012 [AuM][I]: ExitCode: 0
Wed Feb 8 19:22:57 2012 [AuM][D]: Message received: AUTHENTICATE
SUCCESS 30 -
Wed Feb 8 19:22:57 2012 [AuM][D]: Message received: AUTHORIZE SUCCESS 31 -
Wed Feb 8 19:22:57 2012 [ReM][D]: VirtualMachineInfo method invoked
Wed Feb 8 19:22:57 2012 [AuM][D]: Message received: LOG I 32 ExitCode: 0
Wed Feb 8 19:22:57 2012 [AuM][I]: ExitCode: 0
Wed Feb 8 19:22:57 2012 [AuM][D]: Message received: AUTHENTICATE
SUCCESS 32 -
Wed Feb 8 19:22:57 2012 [AuM][D]: Message received: AUTHORIZE SUCCESS 33 -
Wed Feb 8 19:23:13 2012 [ReM][D]: HostPoolInfo method invoked
Wed Feb 8 19:23:13 2012 [ReM][D]: VirtualMachinePoolInfo method invoked
Wed Feb 8 19:23:13 2012 [ReM][D]: AclInfo method invoked
Wed Feb 8 19:23:20 2012 [ReM][D]: GroupPoolInfo method invoked
Wed Feb 8 19:23:20 2012 [AuM][D]: Message received: LOG I 34 ExitCode: 0
Wed Feb 8 19:22:13 2012 [DiM][I]: New VM state is ACTIVE.
Wed Feb 8 19:22:13 2012 [LCM][I]: New VM state is PROLOG.
Wed Feb 8 19:22:13 2012 [VM][I]: Virtual Machine has no context
Wed Feb 8 19:22:26 2012 [TM][D]: tm_clone.sh:
centos-1:/var/lib/one/images/6ff900f642a88eede3277db946a617c3
centos-2:/var/lib/one//20/images/disk.0
Wed Feb 8 19:22:26 2012 [TM][D]: tm_clone.sh: DST:
/var/lib/one//20/images/disk.0
Wed Feb 8 19:22:26 2012 [TM][I]: tm_clone.sh: Creating directory
/var/lib/one//20/images
Wed Feb 8 19:22:26 2012 [TM][I]: tm_clone.sh: Executed "mkdir -p
/var/lib/one//20/images".
Wed Feb 8 19:22:26 2012 [TM][I]: tm_clone.sh: Executed "chmod a+w
/var/lib/one//20/images".
Wed Feb 8 19:22:26 2012 [TM][I]: tm_clone.sh: Cloning
/var/lib/one/images/6ff900f642a88eede3277db946a617c3
Wed Feb 8 19:22:26 2012 [TM][I]: tm_clone.sh: Executed "cp -r
/var/lib/one/images/6ff900f642a88eede3277db946a617c3
/var/lib/one//20/images/disk.0".
Wed Feb 8 19:22:26 2012 [TM][I]: tm_clone.sh: Executed "chmod a+rw
/var/lib/one//20/images/disk.0".
Wed Feb 8 19:22:26 2012 [TM][I]: ExitCode: 0
Wed Feb 8 19:22:26 2012 [TM][D]: tm_mkswap.sh: Creating directory
/var/lib/one//20/images
Wed Feb 8 19:22:26 2012 [TM][I]: tm_mkswap.sh: Executed "mkdir -p
/var/lib/one//20/images".
Wed Feb 8 19:22:26 2012 [TM][I]: tm_mkswap.sh: Executed "chmod a+w
/var/lib/one//20/images".
Wed Feb 8 19:22:26 2012 [TM][D]: tm_mkswap.sh: Creating 1024Mb image in
/var/lib/one//20/images/disk.1
Wed Feb 8 19:22:26 2012 [TM][I]: tm_mkswap.sh: Executed "dd
if=/dev/zero of=/var/lib/one//20/images/disk.1 bs=1 count=1 seek=1024M".
Wed Feb 8 19:22:26 2012 [TM][D]: tm_mkswap.sh: Initializing swap space
Wed Feb 8 19:22:26 2012 [TM][I]: tm_mkswap.sh: Executed "mkswap
/var/lib/one//20/images/disk.1".
Wed Feb 8 19:22:26 2012 [TM][I]: tm_mkswap.sh: Executed "chmod a+w
/var/lib/one//20/images/disk.1".
Wed Feb 8 19:22:26 2012 [TM][I]: ExitCode: 0
Wed Feb 8 19:22:26 2012 [LCM][I]: New VM state is BOOT
Wed Feb 8 19:22:26 2012 [VMM][E]: deploy_action, error getting driver
vm_kvm
Wed Feb 8 19:22:26 2012 [DiM][I]: New VM state is FAILED
Google or the email archive show no solution, or I didn't find any clue.
In my opinion, the frontend doesn't connect the KVM-node to execute the
virtual machine.
Does anybody know a solution or can give me some tips.
Regards Hendrik
More information about the Users
mailing list