Hi,

I've searched google and this list but with no luck..

I have setup an opennebula cloud (4.0.1) with xen (4.1) on debian wheezy. My problem is that vm's are deployed correctly (vm is running, networking is set up, I can ssh to it, run programs within it etc.) but opennebula shows vm stuck in boot state and i can't do anything with it from either sunstone nor with the onevm command.

I can only delete the vm.

The VM is debian squeeze from marketplace ( http://marketplace.c12g.com/appliance/4fec9fb28fb81d2ebc000002 )

no errors in oned.log - only monitoring stuff.. any help is appreciated!

The deployment.0 file is:

name = 'one-19'
memory  = '2048'
vcpus  = '1'
bootloader = "/usr/lib/xen-4.1/bin/pygrub"
disk = [
    'tap2:tapdisk:aio:/var/lib/one//datastores/0/19/disk.0,xvda,w',
    'tap2:tapdisk:aio:/var/lib/one//datastores/0/19/disk.1,xvdb,r',
]
vif = [
    ' mac=02:00:12:a8:01:0a,ip=192.168.1.10,bridge=br0',
]
vfb = ['type=vnc,vnclisten=0.0.0.0,vncdisplay=19']
device_model = '/usr/lib/xen-4.1/bin/qemu-dm'

xm list command output:

root@nebula1:/var/log/xen# xm list
Name ID Mem VCPUs State Time(s) Domain-0 0 1023 4 r----- 1194.4 one-19 5 2048 1 -b---- 1.7


onevm list command output:

oneadmin@nebula0:~$ onevm list
ID USER GROUP NAME STAT UCPU UMEM HOST TIME 19 oneadmin oneadmin deb1 boot 0 2G nebula1 0d 01h05


vm log:

Wed Jun  5 08:09:59 2013 [DiM][I]: New VM state is ACTIVE.
Wed Jun  5 08:09:59 2013 [LCM][I]: New VM state is PROLOG.
Wed Jun  5 08:13:20 2013 [LCM][E]: monitor_done_action, VM in a wrong state
Wed Jun  5 08:18:37 2013 [LCM][E]: monitor_done_action, VM in a wrong state
Wed Jun 5 08:22:26 2013 [TM][I]: clone: Cloning nebula0:/var/lib/one/datastores/1/78b6cd5fe55967f183d9eabfd9cd7a28 in /var/lib/one/datastores/0/19/disk.0
Wed Jun  5 08:22:26 2013 [TM][I]: ExitCode: 0
Wed Jun 5 08:22:27 2013 [TM][I]: context: Generating context block device at nebula1:/var/lib/one//datastores/0/19/disk.1
Wed Jun  5 08:22:27 2013 [TM][I]: ExitCode: 0
Wed Jun  5 08:22:27 2013 [LCM][I]: New VM state is BOOT
Wed Jun 5 08:22:27 2013 [VMM][I]: Generating deployment file: /var/lib/one/vms/19/deployment.0
Wed Jun  5 08:22:28 2013 [VMM][I]: ExitCode: 0
Wed Jun 5 08:22:28 2013 [VMM][I]: Successfully execute network driver operation: pre.
Wed Jun  5 08:22:31 2013 [VMM][D]: deploy: Credits set to 256
Wed Jun  5 08:22:31 2013 [VMM][I]: ExitCode: 0
Wed Jun 5 08:22:31 2013 [VMM][I]: Successfully execute virtualization driver operation: deploy.

xend.log:

[2013-06-05 08:22:31 2847] DEBUG (XendDomainInfo:103) XendDomainInfo.create(['vm', ['name', 'one-19'], ['memory', '2048'], ['on_xend_start', 'ignore'], ['on_xend_stop', 'ignore'], ['vcpus', '1'], ['oos', 1], ['bootloader', '/usr/lib/xen-4.1/bin/pygrub'], ['bootloader_args', '-q'], ['image', ['linux', ['videoram', 4], ['tsc_mode', 0], ['nomigrate', 0]]], ['s3_integrity', 1], ['device', ['tap2', ['uname', 'tap2:tapdisk:aio:/var/lib/one//datastores/0/19/disk.0'], ['dev', 'xvda'], ['mode', 'w']]], ['device', ['tap2', ['uname', 'tap2:tapdisk:aio:/var/lib/one//datastores/0/19/disk.1'], ['dev', 'xvdb'], ['mode', 'r']]], ['device', ['vif', ['ip', '192.168.1.10'], ['mac', '02:00:12:a8:01:0a'], ['bridge', 'br0']]], ['device', ['vkbd']], ['device', ['vfb', ['vnc', '1'], ['vnclisten', '0.0.0.0'], ['vncdisplay', '19'], ['xauthority', '/root/.Xauthority']]]]) [2013-06-05 08:22:31 2847] DEBUG (XendDomainInfo:2498) XendDomainInfo.constructDomain [2013-06-05 08:22:31 2847] DEBUG (balloon:187) Balloon: 3089336 KiB free; need 16384; done.
[2013-06-05 08:22:31 2847] DEBUG (XendDomain:476) Adding Domain: 3
[2013-06-05 08:22:31 2847] DEBUG (XendDomainInfo:2836) XendDomainInfo.initDomain: 3 256 [2013-06-05 08:22:31 21477] DEBUG (XendBootloader:113) Launching bootloader as ['/usr/lib/xen-4.1/bin/pygrub', '--output=/var/run/xend/boot/xenbl.11474', '-q', '/var/lib/one//datastores/0/19/disk.0']. [2013-06-05 08:22:32 2847] DEBUG (image:339) No VNC passwd configured for vfb access [2013-06-05 08:22:32 2847] DEBUG (XendDomainInfo:2863) _initDomain:shadow_memory=0x0, memory_static_max=0x80000000, memory_static_min=0x0. [2013-06-05 08:22:32 2847] INFO (image:182) buildDomain os=linux dom=3 vcpus=1
[2013-06-05 08:22:32 2847] DEBUG (image:721) domid          = 3
[2013-06-05 08:22:32 2847] DEBUG (image:722) memsize        = 2048
[2013-06-05 08:22:32 2847] DEBUG (image:723) image = /var/run/xend/boot/boot_kernel.Nu5QrO
[2013-06-05 08:22:32 2847] DEBUG (image:724) store_evtchn   = 1
[2013-06-05 08:22:32 2847] DEBUG (image:725) console_evtchn = 2
[2013-06-05 08:22:32 2847] DEBUG (image:726) cmdline = root=UUID=5309b3f9-2b10-40a4-aa03-0ff45a6dab7f ro quiet [2013-06-05 08:22:32 2847] DEBUG (image:727) ramdisk = /var/run/xend/boot/boot_ramdisk.MvCdMG
[2013-06-05 08:22:32 2847] DEBUG (image:728) vcpus          = 1
[2013-06-05 08:22:32 2847] DEBUG (image:729) features       =
[2013-06-05 08:22:32 2847] DEBUG (image:730) flags          = 0
[2013-06-05 08:22:32 2847] DEBUG (image:731) superpages     = 0
[2013-06-05 08:22:32 2847] INFO (XendDomainInfo:2357) createDevice: vkbd : {'uuid': '51fad786-2987-9721-5297-2f5b4251f823'} [2013-06-05 08:22:32 2847] DEBUG (DevController:95) DevController: writing {'protocol': 'x86_64-abi', 'state': '1', 'backend-id': '0', 'backend': '/local/domain/0/backend/vkbd/3/0'} to /local/domain/3/device/vkbd/0. [2013-06-05 08:22:32 2847] DEBUG (DevController:97) DevController: writing {'frontend-id': '3', 'domain': 'one-19', 'frontend': '/local/domain/3/device/vkbd/0', 'state': '1', 'online': '1'} to /local/domain/0/backend/vkbd/3/0. [2013-06-05 08:22:32 2847] INFO (XendDomainInfo:2357) createDevice: vfb : {'other_config': {'vnclisten': '0.0.0.0', 'vnc': '1', 'vncdisplay': '19', 'xauthority': '/root/.Xauthority'}, 'vnc': '1', 'xauthority': '/root/.Xauthority', 'vnclisten': '0.0.0.0', 'vncdisplay': '19', 'uuid': '798de277-63b4-ff7a-e166-9e230c9e5934'} [2013-06-05 08:22:32 2847] DEBUG (DevController:95) DevController: writing {'protocol': 'x86_64-abi', 'state': '1', 'backend-id': '0', 'backend': '/local/domain/0/backend/vfb/3/0'} to /local/domain/3/device/vfb/0. [2013-06-05 08:22:32 2847] DEBUG (DevController:97) DevController: writing {'domain': 'one-19', 'frontend': '/local/domain/3/device/vfb/0', 'uuid': '798de277-63b4-ff7a-e166-9e230c9e5934', 'frontend-id': '3', 'vnclisten': '0.0.0.0', 'vncdisplay': '19', 'state': '1', 'online': '1', 'vnc': '1', 'xauthority': '/root/.Xauthority'} to /local/domain/0/backend/vfb/3/0. [2013-06-05 08:22:32 2847] INFO (XendDomainInfo:2357) createDevice: tap2 : {'bootable': 1, 'uname': 'tap2:tapdisk:aio:/var/lib/one//datastores/0/19/disk.0', 'mode': 'w', 'dev': 'xvda', 'uuid': '05ff560d-4e79-1b48-1af8-9885fa82ada7'} [2013-06-05 08:22:32 2847] DEBUG (DevController:95) DevController: writing {'virtual-device': '51712', 'device-type': 'disk', 'protocol': 'x86_64-abi', 'backend-id': '0', 'state': '1', 'backend': '/local/domain/0/backend/vbd/3/51712'} to /local/domain/3/device/vbd/51712. [2013-06-05 08:22:32 2847] DEBUG (DevController:97) DevController: writing {'domain': 'one-19', 'frontend': '/local/domain/3/device/vbd/51712', 'uuid': '05ff560d-4e79-1b48-1af8-9885fa82ada7', 'bootable': '1', 'dev': 'xvda', 'state': '1', 'params': '/dev/xen/blktap-2/tapdev0', 'mode': 'w', 'online': '1', 'frontend-id': '3', 'type': 'phy', 'tapdisk-params': 'tapdisk:aio:/var/lib/one//datastores/0/19/disk.0'} to /local/domain/0/backend/vbd/3/51712. [2013-06-05 08:22:32 2847] INFO (XendDomainInfo:2357) createDevice: tap2 : {'bootable': 0, 'uname': 'tap2:tapdisk:aio:/var/lib/one//datastores/0/19/disk.1', 'mode': 'r', 'dev': 'xvdb', 'uuid': '29791995-b50e-0d36-d941-c0941ba1c95c'} [2013-06-05 08:22:32 2847] DEBUG (DevController:95) DevController: writing {'virtual-device': '51728', 'device-type': 'disk', 'protocol': 'x86_64-abi', 'backend-id': '0', 'state': '1', 'backend': '/local/domain/0/backend/vbd/3/51728'} to /local/domain/3/device/vbd/51728. [2013-06-05 08:22:32 2847] DEBUG (DevController:97) DevController: writing {'domain': 'one-19', 'frontend': '/local/domain/3/device/vbd/51728', 'uuid': '29791995-b50e-0d36-d941-c0941ba1c95c', 'bootable': '0', 'dev': 'xvdb', 'state': '1', 'params': '/dev/xen/blktap-2/tapdev1', 'mode': 'r', 'online': '1', 'frontend-id': '3', 'type': 'phy', 'tapdisk-params': 'tapdisk:aio:/var/lib/one//datastores/0/19/disk.1'} to /local/domain/0/backend/vbd/3/51728. [2013-06-05 08:22:32 2847] INFO (XendDomainInfo:2357) createDevice: vif : {'ip': '192.168.1.10', 'mac': '02:00:12:a8:01:0a', 'uuid': 'a41816d8-c751-72e0-2d0e-98b09fba4212', 'bridge': 'br0'} [2013-06-05 08:22:32 2847] DEBUG (DevController:95) DevController: writing {'mac': '02:00:12:a8:01:0a', 'handle': '0', 'protocol': 'x86_64-abi', 'backend-id': '0', 'state': '1', 'backend': '/local/domain/0/backend/vif/3/0'} to /local/domain/3/device/vif/0. [2013-06-05 08:22:32 2847] DEBUG (DevController:97) DevController: writing {'bridge': 'br0', 'domain': 'one-19', 'handle': '0', 'uuid': 'a41816d8-c751-72e0-2d0e-98b09fba4212', 'script': '/etc/xen/scripts/vif-openvswitch', 'ip': '192.168.1.10', 'mac': '02:00:12:a8:01:0a', 'frontend-id': '3', 'state': '1', 'online': '1', 'frontend': '/local/domain/3/device/vif/0'} to /local/domain/0/backend/vif/3/0. [2013-06-05 08:22:32 2847] INFO (image:418) spawning device models: /usr/lib/xen-4.1/bin/qemu-dm ['/usr/lib/xen-4.1/bin/qemu-dm', '-d', '3', '-serial', 'pty', '-domain-name', 'one-19', '-videoram', '4', '-vnc', '0.0.0.0:19', '-vncunused', '-M', 'xenpv']
[2013-06-05 08:22:32 2847] INFO (image:467) device model pid: 21522
[2013-06-05 08:22:32 2847] INFO (image:590) waiting for sentinel_fifo
[2013-06-05 08:22:32 2847] DEBUG (XendDomainInfo:3420) Storing VM details: {'on_xend_stop': 'ignore', 'pool_name': 'Pool-0', 'shadow_memory': '0', 'uuid': 'b64f31a0-357e-8ce3-17e9-77ce159d67eb', 'on_reboot': 'restart', 'start_time': '1370413352.7', 'on_poweroff': 'destroy', 'bootloader_args': '-q', 'on_xend_start': 'ignore', 'on_crash': 'restart', 'xend/restart_count': '0', 'vcpus': '1', 'vcpu_avail': '1', 'bootloader': '/usr/lib/xen-4.1/bin/pygrub', 'image': "(linux (kernel '') (superpages 0) (videoram 4) (pci ()) (nomigrate 0) (tsc_mode 0) (device_model /usr/lib/xen-4.1/bin/qemu-dm) (notes (HV_START_LOW 18446603336221196288) (FEATURES '!writable_page_tables|pae_pgdir_above_4gb') (VIRT_BASE 18446744071562067968) (GUEST_VERSION 2.6) (PADDR_OFFSET 0) (GUEST_OS linux) (HYPERCALL_PAGE 18446744071578882048) (LOADER generic) (SUSPEND_CANCEL 1) (PAE_MODE yes) (ENTRY 18446744071584203264) (XEN_VERSION xen-3.0)))", 'name': 'one-19'} [2013-06-05 08:22:32 2847] DEBUG (XendDomainInfo:1794) Storing domain details: {'console/ring-ref': '799913', 'image/entry': '18446744071584203264', 'console/port': '2', 'store/ring-ref': '799914', 'image/loader': 'generic', 'vm': '/vm/b64f31a0-357e-8ce3-17e9-77ce159d67eb', 'control/platform-feature-multiprocessor-suspend': '1', 'image/hv-start-low': '18446603336221196288', 'image/guest-os': 'linux', 'image/virt-base': '18446744071562067968', 'memory/target': '2097152', 'image/guest-version': '2.6', 'image/pae-mode': 'yes', 'description': '', 'console/limit': '1048576', 'image/paddr-offset': '0', 'image/hypercall-page': '18446744071578882048', 'image/suspend-cancel': '1', 'cpu/0/availability': 'online', 'image/features/pae-pgdir-above-4gb': '1', 'image/features/writable-page-tables': '0', 'console/type': 'ioemu', 'name': 'one-19', 'domid': '3', 'image/xen-version': 'xen-3.0', 'store/port': '1'} [2013-06-05 08:22:32 2847] DEBUG (DevController:95) DevController: writing {'protocol': 'x86_64-abi', 'state': '1', 'backend-id': '0', 'backend': '/local/domain/0/backend/console/3/0'} to /local/domain/3/device/console/0. [2013-06-05 08:22:32 2847] DEBUG (DevController:97) DevController: writing {'domain': 'one-19', 'frontend': '/local/domain/3/device/console/0', 'uuid': '1d1d7212-114e-5715-55b0-dd12377f16d1', 'frontend-id': '3', 'state': '1', 'location': '2', 'online': '1', 'protocol': 'vt100'} to /local/domain/0/backend/console/3/0. [2013-06-05 08:22:32 2847] DEBUG (XendDomainInfo:1881) XendDomainInfo.handleShutdownWatch [2013-06-05 08:22:32 2847] DEBUG (DevController:139) Waiting for devices tap2.
[2013-06-05 08:22:32 2847] DEBUG (DevController:144) Waiting for 51712.
[2013-06-05 08:22:32 2847] DEBUG (DevController:628) hotplugStatusCallback /local/domain/0/backend/vbd/3/51712/hotplug-status. [2013-06-05 08:22:33 2847] DEBUG (DevController:628) hotplugStatusCallback /local/domain/0/backend/vbd/3/51712/hotplug-status. [2013-06-05 08:22:33 2847] DEBUG (DevController:642) hotplugStatusCallback 1.
[2013-06-05 08:22:33 2847] DEBUG (DevController:144) Waiting for 51728.
[2013-06-05 08:22:33 2847] DEBUG (DevController:628) hotplugStatusCallback /local/domain/0/backend/vbd/3/51728/hotplug-status. [2013-06-05 08:22:33 2847] DEBUG (DevController:628) hotplugStatusCallback /local/domain/0/backend/vbd/3/51728/hotplug-status. [2013-06-05 08:22:33 2847] DEBUG (DevController:642) hotplugStatusCallback 1. [2013-06-05 08:22:34 2847] DEBUG (DevController:139) Waiting for devices vif.
[2013-06-05 08:22:34 2847] DEBUG (DevController:144) Waiting for 0.
[2013-06-05 08:22:34 2847] DEBUG (DevController:628) hotplugStatusCallback /local/domain/0/backend/vif/3/0/hotplug-status. [2013-06-05 08:22:34 2847] DEBUG (DevController:642) hotplugStatusCallback 1. [2013-06-05 08:22:34 2847] DEBUG (DevController:139) Waiting for devices vkbd. [2013-06-05 08:22:34 2847] DEBUG (DevController:139) Waiting for devices ioports. [2013-06-05 08:22:34 2847] DEBUG (DevController:139) Waiting for devices tap. [2013-06-05 08:22:34 2847] DEBUG (DevController:139) Waiting for devices vif2. [2013-06-05 08:22:34 2847] DEBUG (DevController:139) Waiting for devices console.
[2013-06-05 08:22:34 2847] DEBUG (DevController:144) Waiting for 0.
[2013-06-05 08:22:34 2847] DEBUG (DevController:139) Waiting for devices vscsi. [2013-06-05 08:22:34 2847] DEBUG (DevController:139) Waiting for devices vbd. [2013-06-05 08:22:34 2847] DEBUG (DevController:139) Waiting for devices irq. [2013-06-05 08:22:34 2847] DEBUG (DevController:139) Waiting for devices vfb. [2013-06-05 08:22:34 2847] DEBUG (DevController:139) Waiting for devices pci. [2013-06-05 08:22:34 2847] DEBUG (DevController:139) Waiting for devices vusb. [2013-06-05 08:22:34 2847] DEBUG (DevController:139) Waiting for devices vtpm. [2013-06-05 08:22:34 2847] INFO (XendDomain:1225) Domain one-19 (3) unpaused. [2013-06-05 08:22:34 2847] WARNING (XendDomainInfo:581) Could not unpause blktap disk: ('unpause', '-p21487', '-m0') failed (5632 )

Cheers,
J

--
Jacek Jarosiewicz
_______________________________________________
Users mailing list
[email protected]
http://lists.opennebula.org/listinfo.cgi/users-opennebula.org

Reply via email to