[one-users] OpenNebula and Xen: Prolog, error getting driver vmm_xen

Nelson Mimura Gonzalez nelsonspbr at gmail.com
Wed Sep 8 12:28:40 PDT 2010


Hi all,

I'm trying to get Xen and OpenNebula to work properly, but I got some
issues. I have the front-end and one node set up and I also tested SSH, NFS,
Xen (locally at the node). Being succint, I'm having problems when I try to
deploy the VM:

  nelson at front-end:/$ *cd ~ *
nelson at front-end:~$ *onehost list *
 HID NAME                      RVM   TCPU   FCPU   ACPU    TMEM    FMEM STAT

   0 node01                      0    800 -15920    800 1598873   67584   on

nelson at front-end:~$ *onevm list *
  ID     NAME STAT CPU     MEM        HOSTNAME        TIME

nelson at front-end:~$ *onevm create vm-test.template  *
nelson at front-end:~$ *onevm list *
  ID     NAME STAT CPU     MEM        HOSTNAME        TIME
  12  vm-test pend   0       0                 00 00:00:07
nelson at front-end:~$ *onevm deploy 12 0 *
nelson at front-end:~$ *onevm list *
  ID     NAME STAT CPU     MEM        HOSTNAME        TIME
  12  vm-test prol   0       0          node01 00 00:00:14
nelson at front-end:~$ *onevm list *
  ID     NAME STAT CPU     MEM        HOSTNAME        TIME
  12  vm-test fail   0       0          node01 00 00:00:14

Seeing the VM log:

*= log from VM*

Wed Sep  8 15:51:40 2010 [DiM][I]: New VM state is ACTIVE.
Wed Sep  8 15:51:41 2010 [LCM][I]: New VM state is PROLOG.
Wed Sep  8 15:51:41 2010 [TM][E]: prolog, error getting driver vmm_xen
Wed Sep  8 15:51:42 2010 [DiM][I]: New VM state is FAILED

Do you guys have any clue about this error message, "*prolog, error getting
driver vmm_xen*"? Possible mistakes I'm making? I googled for this message
and it only came up with...

http://lists.opennebula.org/pipermail/users-opennebula.org/2009-August/000643.html

...but it didn't help much.

I think I'll play a little with the script one_vmm_xen and one_vmm_xen.rb to
debug the driver, but I'm open to suggestions.

Thanks in advance,

Nelson

(Giant) PS: Here are some config files (I can provide more if necessary):

*= template for VM *(vm-test.template)

NAME = vm-test
DISK = [image="/etc/one/images/disk.img",dev="sda1",mode=w]
KERNEL = /boot/vmlinuz-2.6.19-4-server
RAMDISK = /boot/initrd.img-2.6.19-4-server
MEMORY = 512
CPU = 0.5

*= oned.conf*

HOST_MONITORING_INTERVAL = 10
VM_POLLING_INTERVAL      = 10
VM_DIR=/etc/one/images
PORT=2633
DEBUG_LEVEL=3
NETWORK_SIZE = 254
MAC_PREFIX   = "00:03"

IM_MAD = [
    name       = "im_xen",
    executable = "/usr/lib/one/mads/one_im_ssh",
    arguments  = "/etc/one/im_xen/im_xen.conf",
    default    = "/etc/one/im_xen/im_xen.conf" ]

VM_MAD = [
    name       = "vmm_xen",
    executable = "/usr/lib/one/mads/one_vmm_xen",
    default    = "/etc/one/vmm_xen/vmm_xen.conf",
    type       = "xen" ]

TM_MAD = [
    name       = "tm_nfs",
    executable = "/usr/lib/one/mads/one_tm",
    arguments  = "/etc/one/tm_nfs/tm_nfs.conf",
    default    = "/etc/one/tm_nfs/tm_nfs.conf" ]

Now some other logs:

*= log from im_xen*

5921152,USEDCPU=15921644,FREECPU=-15920844,NETTX=2168954,NETRX=65091
Wed Sep  8 16:00:52 2010: MONITOR 0 node01
Wed Sep  8 16:01:25 2010: MONITOR SUCCESS 0
ARCH=i686,HOSTNAME=node01,MODELNAME="Intel(R) Xeon(R) CPU           E5405  @
2.00GHz",TOTALCPU=800,CPUSPEED=2000,TOTALMEMORY=15988736,FREEMEMORY=67584,USEDMEMORY=1

*= log from oned*

Wed Sep  8 15:50:25 2010 [ONE][I]: Init OpenNebula Log system
Wed Sep  8 15:50:25 2010 [ONE][I]: Log Level: 3
[0=ERROR,1=WARNING,2=INFO,3=DEBUG]
Wed Sep  8 15:50:25 2010 [ONE][I]:
----------------------------------------------
Wed Sep  8 15:50:25 2010 [ONE][I]:        OpenNebula Configuration
File
Wed Sep  8 15:50:25 2010 [ONE][I]:
----------------------------------------------
Wed Sep  8 15:50:25 2010 [ONE][I]:
--------------------------------------------
    DEBUG_LEVEL=3
    HOST_MONITORING_INTERVAL=10

IM_MAD=ARGUMENTS=/etc/one/im_xen/im_xen.conf,DEFAULT=/etc/one/im_xen/im_xen.conf,EXECUTABLE=/usr/lib/one/mads/one_im_ssh,NAME=im_xen
    MAC_PREFIX=00:03
    MANAGER_TIMER=30
    NETWORK_SIZE=254
    PORT=2633

TM_MAD=ARGUMENTS=/etc/one/tm_nfs/tm_nfs.conf,DEFAULT=/etc/one/tm_nfs/tm_nfs.conf,EXECUTABLE=/usr/lib/one/mads/one_tm,NAME=tm_nfs
    VM_DIR=/etc/one/images

VM_MAD=DEFAULT=/etc/one/vmm_xen/vmm_xen.conf,EXECUTABLE=/usr/lib/one/mads/one_vmm_xen,NAME=vmm_xen,TYPE=xen
    VM_POLLING_INTERVAL=10
--------------------------------------------
Wed Sep  8 15:50:25 2010 [ONE][E]: SQL command was: SELECT MAX(oid) FROM
network_pool, error: callback requested query abort
Wed Sep  8 15:50:25 2010 [ONE][I]: Bootstraping OpenNebula database.
Wed Sep  8 15:50:25 2010 [ONE][E]: SQL command was: CREATE TABLE vm_pool
(oid INTEGER PRIMARY KEY,uid INTEGER,last_poll INTEGER, template_id
INTEGER,state INTEGER,lcm_state INTEGER,stime INTEGER,etime
INTEGER,deploy_id TEXT,memory INTEGER,cpu INTEGER,net_tx INTEGER,net_rx
INTEGER), error: table vm_pool already exists
Wed Sep  8 15:50:25 2010 [ONE][E]: SQL command was: CREATE TABLE
vm_attributes (id INTEGER, name TEXT, type INTEGER, value TEXT), error:
table vm_attributes already exists
Wed Sep  8 15:50:25 2010 [ONE][E]: SQL command was: CREATE TABLE history
(vid INTEGER,seq INTEGER,host_name TEXT,vm_dir TEXT,hid INTEGER,vm_mad
TEXT,tm_mad TEXT,stime INTEGER,etime INTEGER,pstime INTEGER,petime
INTEGER,rstime INTEGER,retime INTEGER,estime INTEGER,eetime INTEGER,reason
INTEGER,PRIMARY KEY(vid,seq)), error: table history already exists
Wed Sep  8 15:50:25 2010 [ONE][E]: SQL command was: CREATE TABLE host_pool
(oid INTEGER PRIMARY KEY,host_name TEXT,state INTEGER,im_mad TEXT,vm_mad
TEXT,tm_mad TEXT,last_mon_time INTEGER,managed INTEGER), error: table
host_pool already exists
Wed Sep  8 15:50:25 2010 [ONE][E]: SQL command was: CREATE TABLE
host_attributes (id INTEGER, name TEXT, type INTEGER, value TEXT, PRIMARY
KEY(id,name)), error: table host_attributes already exists
Wed Sep  8 15:50:25 2010 [ONE][E]: SQL command was: CREATE TABLE host_shares
(hid INTEGER PRIMARY KEY, endpoint TEXT,disk_usage INTEGER,mem_usage
INTEGER,cpu_usage INTEGER,max_disk INTEGER,max_mem INTEGER,max_cpu
INTEGER,running_vms INTEGER), error: table host_shares already exists
Wed Sep  8 15:50:25 2010 [ONE][E]: SQL command was: CREATE TABLE
network_pool (oid INTEGER,uid INTEGER, name TEXT PRIMARY KEY,type INTEGER,
bridge TEXT), error: table network_pool already exists
Wed Sep  8 15:50:25 2010 [ONE][E]: SQL command was: CREATE TABLE vn_template
(id INTEGER, name TEXT, type INTEGER, value TEXT), error: table vn_template
already exists
Wed Sep  8 15:50:25 2010 [ONE][E]: SQL command was: CREATE TABLE leases (oid
INTEGER,ip INTEGER, mac_prefix INTEGER,mac_suffix INTEGER,vid INTEGER, used
INTEGER, PRIMARY KEY(oid,ip)), error: table leases already exists
Wed Sep  8 15:50:25 2010 [VMM][I]: Starting Virtual Machine Manager...
Wed Sep  8 15:50:25 2010 [LCM][I]: Starting Life-cycle Manager...
Wed Sep  8 15:50:25 2010 [VMM][I]: Virtual Machine Manager started.
Wed Sep  8 15:50:25 2010 [InM][I]: Starting Information Manager...
Wed Sep  8 15:50:25 2010 [LCM][I]: Life-cycle Manager started.
Wed Sep  8 15:50:25 2010 [InM][I]: Information Manager started.
Wed Sep  8 15:50:25 2010 [TrM][I]: Starting Transfer Manager...
Wed Sep  8 15:50:25 2010 [TrM][I]: Transfer Manager started.
Wed Sep  8 15:50:25 2010 [DiM][I]: Starting Dispatch Manager...
Wed Sep  8 15:50:25 2010 [DiM][I]: Dispatch Manager started.
Wed Sep  8 15:50:25 2010 [ReM][I]: Starting Request Manager...
Wed Sep  8 15:50:25 2010 [ReM][I]: Starting XML-RPC server, port 2633 ...
Wed Sep  8 15:50:25 2010 [ReM][I]: Request Manager started.
Wed Sep  8 15:50:26 2010 [VMM][I]: Virtual Machine Manager stopped.
Wed Sep  8 15:50:26 2010 [TrM][I]: Transfer Manager stopped.
Wed Sep  8 15:50:26 2010 [InM][I]: Information Manager stopped.
Wed Sep  8 15:50:26 2010 [ONE][I]: All modules finalized, exiting.

Wed Sep  8 15:50:27 2010 [InM][I]: Loading Information Manager drivers.
Wed Sep  8 15:50:27 2010 [InM][I]:     Loading driver: im_xen
Wed Sep  8 15:50:27 2010 [InM][I]:     Driver im_xen loaded
Wed Sep  8 15:50:27 2010 [VMM][I]: Loading Virtual Machine Manager drivers.
Wed Sep  8 15:50:27 2010 [VMM][I]:     Loading driver: vmm_xen (XEN)
Wed Sep  8 15:50:27 2010 [VMM][I]:     Driver vmm_xen loaded.
Wed Sep  8 15:50:27 2010 [TM][I]: Loading Transfer Manager drivers.
Wed Sep  8 15:50:27 2010 [VMM][I]:     Loading driver: tm_nfs
Wed Sep  8 15:50:27 2010 [TM][I]:     Driver tm_nfs loaded.
Wed Sep  8 15:50:55 2010 [InM][I]: Monitoring host node01 (0)
Wed Sep  8 15:51:04 2010 [InM][D]: Host 0 successfully monitored.
Wed Sep  8 15:51:24 2010 [InM][I]: Monitoring host node01 (0)
Wed Sep  8 15:51:33 2010 [InM][D]: Host 0 successfully monitored.
Wed Sep  8 15:51:40 2010 [ReM][D]: VirtualMachineDeploy invoked
Wed Sep  8 15:51:40 2010 [DiM][D]: Deploying VM 12

*= log from one_vmm_xen*

Wed Sep  8 14:07:20 2010: INIT
Wed Sep  8 14:07:20 2010: INIT SUCCESS - -
Wed Sep  8 15:28:39 2010: FINALIZE
Wed Sep  8 15:28:42 2010: INIT
Wed Sep  8 15:28:42 2010: INIT SUCCESS - -
Wed Sep  8 15:50:25 2010: FINALIZE
Wed Sep  8 15:50:27 2010: INIT
Wed Sep  8 15:50:27 2010: INIT SUCCESS - -

*= log from tm_nfs*

Wed Sep  8 14:07:20 2010: INIT
Wed Sep  8 14:07:20 2010: INIT SUCCESS
Wed Sep  8 15:28:39 2010: FINALIZE
Wed Sep  8 15:28:42 2010: INIT
Wed Sep  8 15:28:42 2010: INIT SUCCESS
Wed Sep  8 15:50:25 2010: FINALIZE
Wed Sep  8 15:50:27 2010: INIT
Wed Sep  8 15:50:27 2010: INIT SUCCESS
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.opennebula.org/pipermail/users-opennebula.org/attachments/20100908/81ad466e/attachment.htm>


More information about the Users mailing list