[Xen-devel] Stub domains broken in Xen 4.0?

[Jason Sonnek <jsonnek@xxxxxxxxx>]

When I try to use stubdom-dm in lieu of qemu-dm, the guest domain crashes almost immediately if I specify an emulated NIC ('vif=') in the guest configuration file. If I don't specify a vif, it works fine. If I use the same configuration with qemu-dm instead of sutbdom-dm, it works fine. Is there some reason QEMU emulated networking doesn't work with stub domains in Xen 4.0?

I'm running Xen stable 4.0.1, pv_ops 2.6.32.25 kernel for Dom0. Posted below are the contents of my guest configuration file and the qemu, qemu-dm and xend log files.

Thanks for your help,

Jason

== guest config ==

name="caitlin"
description="None"
uuid="42c1f0c1-276d-19ad-9000-e679938bdcd1"
memory=512
maxmem=512
vcpus=1
>>
>localtime=0
keymap="en-us"

builder="hvm"
#device_model="/usr/lib/xen/bin/qemu-dm"
device_model="/usr/lib/xen/bin/stubdom-dm"
kernel="/usr/lib/xen/boot/hvmloader"
boot="c"
disk=[ 'file:/etc/xen/myimages/caitlin/disk0.raw,hda,w',]
# NB: If I comment out the following line, everything works fine.
vif=[ 'mac=00:16:3e:63:a5:20' ]
#pci = ['00:1a.*']

stdvga=0
vnc=1
vncunused=1
extid=0
apic=0
acpi=1
pae=1


serial="pty"

== qemu-dm-caitlin.log ==

Using config file "/etc/xen/stubdoms/caitlin-dm".
Started domain caitlin-dm (id=2)
Using config file "/etc/xen/stubdoms/caitlin-dm".
Domain has already finished
Could not start console


== qemu-dm-caitlin-dm.log ==

domid: 2
Warning: vlan 0 is not connected to host network
Using file /etc/xen/myimages/caitlin/disk0.raw in read-write mode
Watching /local/domain/0/device-model/2/logdirty/cmd
Watching /local/domain/0/device-model/2/command
char device redirected to /dev/pts/1
char device redirected to /dev/pts/2
/usr/src/packages/BUILD/xen-4.0.1-testing/tools/ioemu-dir/hw/xen_blktap.c:700: Init blktap pipes
xs_read(): vncpasswd get error. /vm/86207a57-273e-09cf-a79c-dc2854ad8553/vncpasswd.
Log-dirty: no command yet.

== xend.log (excerpt) ==

[2011-01-30 12:45:21 3430] DEBUG (XendDomainInfo:103) XendDomainInfo.create(['vm', ['name', 'caitlin'], ['memory', 512], ['maxmem', 512], ['on_poweroff', 'destroy'], ['on_reboot', 'restart'], ['on_crash', 'destroy'], ['on_xend_start', 'ignore'], ['on_xend_stop', 'ignore'], ['description', 'None'], ['vcpus', 1], ['uuid', '42c1f0c1-276d-19ad-9000-e679938bdcd1'], ['oos', 1], ['image', ['hvm', ['kernel', '/usr/lib/xen/boot/hvmloader'], ['videoram', 4], ['serial', 'pty'], ['acpi', 1], ['apic', 0], ['boot', 'c'], ['cpuid', []], ['cpuid_check', []], ['device_model', '/usr/lib/xen/bin/stubdom-dm'], ['display', 'localhost:10.0'], ['fda', ''], ['fdb', ''], ['guest_os_type', 'default'], ['hap', 1], ['hpet', 0], ['isa', 0], ['keymap', 'en-us'], ['localtime', 0], ['nographic', 0], ['oos', 1], ['pae', 1], ['pci', []], ['pci_msitranslate', 1], ['pci_power_mgmt', 0], ['rtc_timeoffset', 0], ['soundhw', ''], ['stdvga', 0], ['timer_mode', 1], ['usb', 0], ['usbdevice', ''], ['vcpus', 1], ['vnc', 1], ['vncunused', 1], ['viridian', 0], ['extid', 0], ['vpt_align', 1], ['xauthority', '/root/.xauthREQBaR'], ['xen_platform_pci', 1], ['memory_sharing', 0], ['tsc_mode', 0], ['nomigrate', 0]]], ['s3_integrity', 1], ['device', ['vbd', ['uname', 'file:/etc/xen/myimages/caitlin/disk0.raw'], ['dev', 'hda'], ['mode', 'w']]], ['device', ['vif', ['mac', '00:16:3e:63:a5:20']]]])
[2011-01-30 12:45:21 3430] DEBUG (XendDomainInfo:2556) XendDomainInfo.constructDomain
[2011-01-30 12:45:21 3430] DEBUG (balloon:239) Balloon: 2464720 KiB free; need 16384; done.
[2011-01-30 12:45:21 3430] DEBUG (XendDomain:477) Adding Domain: 1
[2011-01-30 12:45:21 3430] DEBUG (XendDomainInfo:2884) XendDomainInfo.initDomain: 1 256
[2011-01-30 12:45:21 3430] DEBUG (image:354) No VNC passwd configured for vfb access
[2011-01-30 12:45:21 3430] DEBUG (image:1027) args: boot, val: c
[2011-01-30 12:45:21 3430] DEBUG (image:1027) args: fda, val: None
[2011-01-30 12:45:21 3430] DEBUG (image:1027) args: fdb, val: None
[2011-01-30 12:45:21 3430] DEBUG (image:1027) args: soundhw, val: None
[2011-01-30 12:45:21 3430] DEBUG (image:1027) args: localtime, val: 0
[2011-01-30 12:45:21 3430] DEBUG (image:1027) args: serial, val: ['pty']
[2011-01-30 12:45:21 3430] DEBUG (image:1027) args: std-vga, val: 0
[2011-01-30 12:45:21 3430] DEBUG (image:1027) args: isa, val: 0
[2011-01-30 12:45:21 3430] DEBUG (image:1027) args: acpi, val: 1
[2011-01-30 12:45:21 3430] DEBUG (image:1027) args: usb, val: 0
[2011-01-30 12:45:21 3430] DEBUG (image:1027) args: usbdevice, val: None
[2011-01-30 12:45:21 3430] DEBUG (image:1027) args: gfx_passthru, val: None
[2011-01-30 12:45:21 3430] INFO (image:957) Need to create platform device.[domid:1]
[2011-01-30 12:45:21 3430] DEBUG (XendDomainInfo:2911) _initDomain:shadow_memory=0x0, memory_static_max=0x20000000, memory_static_min=0x0.
[2011-01-30 12:45:21 3430] INFO (image:197) buildDomain os=hvm dom=1 vcpus=1
[2011-01-30 12:45:21 3430] DEBUG (image:1087) domid          = 1
[2011-01-30 12:45:21 3430] DEBUG (image:1088) image          = /usr/lib/xen/boot/hvmloader
[2011-01-30 12:45:21 3430] DEBUG (image:1089) store_evtchn   = 2
[2011-01-30 12:45:21 3430] DEBUG (image:1090) memsize        = 512
[2011-01-30 12:45:21 3430] DEBUG (image:1091) target         = 512
[2011-01-30 12:45:21 3430] DEBUG (image:1092) vcpus          = 1
[2011-01-30 12:45:21 3430] DEBUG (image:1093) vcpu_avail     = 1
[2011-01-30 12:45:21 3430] DEBUG (image:1094) extid          = 0
[2011-01-30 12:45:21 3430] DEBUG (image:1095) acpi           = 1
[2011-01-30 12:45:21 3430] DEBUG (image:1096) apic           = 0
[2011-01-30 12:45:21 3430] INFO (XendDomainInfo:2409) createDevice: vfb : {'vncunused': 1, 'keymap': 'en-us', 'vnc': '1', 'uuid': 'e90c2c55-1b42-077f-3c06-6268625de190', 'other_config': {'vncunused': 1, 'keymap': 'en-us', 'vnc': '1'}}
[2011-01-30 12:45:21 3430] DEBUG (DevController:95) DevController: writing {'state': '1', 'backend-id': '0', 'backend': '/local/domain/0/backend/vfb/1/0'} to /local/domain/1/device/vfb/0.
[2011-01-30 12:45:21 3430] DEBUG (DevController:97) DevController: writing {'vncunused': '1', 'domain': 'caitlin', 'frontend': '/local/domain/1/device/vfb/0', 'uuid': 'e90c2c55-1b42-077f-3c06-6268625de190', 'frontend-id': '1', 'state': '1', 'keymap': 'en-us', 'online': '1', 'vnc': '1'} to /local/domain/0/backend/vfb/1/0.
[2011-01-30 12:45:21 3430] INFO (XendDomainInfo:2409) createDevice: vbd : {'uuid': '735d5b71-de2c-9245-860a-f7ea90283d32', 'bootable': 1, 'driver': 'paravirtualised', 'dev': 'hda', 'uname': 'file:/etc/xen/myimages/caitlin/disk0.raw', 'mode': 'w'}
[2011-01-30 12:45:21 3430] DEBUG (DevController:95) DevController: writing {'backend-id': '0', 'virtual-device': '768', 'device-type': 'disk', 'state': '1', 'backend': '/local/domain/0/backend/vbd/1/768'} to /local/domain/1/device/vbd/768.
[2011-01-30 12:45:21 3430] DEBUG (DevController:97) DevController: writing {'domain': 'caitlin', 'frontend': '/local/domain/1/device/vbd/768', 'uuid': '735d5b71-de2c-9245-860a-f7ea90283d32', 'bootable': '1', 'dev': 'hda', 'state': '1', 'params': '/etc/xen/myimages/caitlin/disk0.raw', 'mode': 'w', 'online': '1', 'frontend-id': '1', 'type': 'file'} to /local/domain/0/backend/vbd/1/768.
[2011-01-30 12:45:21 3430] INFO (XendDomainInfo:2409) createDevice: vif : {'mac': '00:16:3e:63:a5:20', 'uuid': '00bde3e6-f155-a391-d0dc-c37199bf0f03'}
[2011-01-30 12:45:21 3430] DEBUG (DevController:95) DevController: writing {'backend-id': '0', 'mac': '00:16:3e:63:a5:20', 'handle': '0', 'state': '1', 'backend': '/local/domain/0/backend/vif/1/0'} to /local/domain/1/device/vif/0.
[2011-01-30 12:45:21 3430] DEBUG (DevController:97) DevController: writing {'domain': 'caitlin', 'frontend': '/local/domain/1/device/vif/0', 'uuid': '00bde3e6-f155-a391-d0dc-c37199bf0f03', 'script': '/etc/xen/scripts/vif-bridge', 'mac': '00:16:3e:63:a5:20', 'frontend-id': '1', 'state': '1', 'online': '1', 'handle': '0'} to /local/domain/0/backend/vif/1/0.
[2011-01-30 12:45:21 3430] INFO (image:542) spawning device models: /usr/lib/xen/bin/stubdom-dm ['/usr/lib/xen/bin/stubdom-dm', '-d', '1', '-domain-name', 'caitlin', '-videoram', '4', '-k', 'en-us', '-vnc', '127.0.0.1:0', '-vncunused', '-vcpus', '1', '-vcpu_avail', '0x1', '-boot', 'c', '-serial', 'pty', '-acpi', '-net', 'nic,vlan=1,macaddr=00:16:3e:63:a5:20,model=rtl8139', '-net', 'tap,vlan=1,ifname=tap1.0,bridge=None', '-M', 'xenfv']
[2011-01-30 12:45:22 3430] INFO (image:591) device model pid: 13714
[2011-01-30 12:45:22 3430] DEBUG (image:608) createDeviceModel 1: orig_state is None, retrying
[2011-01-30 12:45:22 3430] INFO (image:725) waiting for sentinel_fifo
[2011-01-30 12:45:22 3430] DEBUG (image:608) createDeviceModel 1: orig_state is None, retrying
[2011-01-30 12:45:22 3430] DEBUG (image:608) createDeviceModel 1: orig_state is None, retrying
[2011-01-30 12:45:22 3430] DEBUG (image:608) createDeviceModel 1: orig_state is None, retrying
[2011-01-30 12:45:22 3430] DEBUG (image:608) createDeviceModel 1: orig_state is None, retrying
[2011-01-30 12:45:22 3430] DEBUG (XendDomainInfo:103) XendDomainInfo.create(['vm', ['name', 'caitlin-dm'], ['memory', 32], ['on_xend_start', 'ignore'], ['on_xend_stop', 'ignore'], ['target', 1], ['vcpus', 1], ['oos', 1], ['image', ['linux', ['kernel', '/usr/lib/xen/boot/ioemu-stubdom.gz'], ['videoram', 4], ['args', ' -d 1'], ['tsc_mode', 0], ['nomigrate', 0]]], ['s3_integrity', 1], ['device', ['vbd', ['uname', 'file:/etc/xen/myimages/caitlin/disk0.raw'], ['dev', 'hda:disk'], ['mode', 'w']]], ['device', ['vif', ['mac', '00:16:3e:63:a5:20']]], ['device', ['vkbd']], ['device', ['vfb', ['vncunused', '1'], ['vnc', '1'], ['xauthority', '/root/.xauthREQBaR'], ['opengl', '1'], ['vnclisten', '127.0.0.1'], ['vncdisplay', '0'], ['keymap', 'en-us'], ['sdl', '0'], ['serial', 'pty'], ['display', 'localhost:10.0']]]])
[2011-01-30 12:45:22 3430] DEBUG (XendDomainInfo:2556) XendDomainInfo.constructDomain
[2011-01-30 12:45:22 3430] DEBUG (balloon:239) Balloon: 1934904 KiB free; need 16384; done.
[2011-01-30 12:45:22 3430] DEBUG (XendDomain:477) Adding Domain: 2
[2011-01-30 12:45:22 3430] DEBUG (XendDomainInfo:2884) XendDomainInfo.initDomain: 2 256
[2011-01-30 12:45:22 3430] DEBUG (image:354) No VNC passwd configured for vfb access
[2011-01-30 12:45:22 3430] DEBUG (XendDomainInfo:2911) _initDomain:shadow_memory=0x0, memory_static_max=0x2000000, memory_static_min=0x0.
[2011-01-30 12:45:22 3430] DEBUG (image:608) createDeviceModel 1: orig_state is None, retrying
[2011-01-30 12:45:22 3430] INFO (image:197) buildDomain os=linux dom=2 vcpus=1
[2011-01-30 12:45:22 3430] DEBUG (image:856) domid          = 2
[2011-01-30 12:45:22 3430] DEBUG (image:857) memsize        = 32
[2011-01-30 12:45:22 3430] DEBUG (image:858) image          = /usr/lib/xen/boot/ioemu-stubdom.gz
[2011-01-30 12:45:22 3430] DEBUG (image:859) store_evtchn   = 1
[2011-01-30 12:45:22 3430] DEBUG (image:860) console_evtchn = 2
[2011-01-30 12:45:22 3430] DEBUG (image:861) cmdline        =  -d 1
[2011-01-30 12:45:22 3430] DEBUG (image:862) ramdisk        = 
[2011-01-30 12:45:22 3430] DEBUG (image:863) vcpus          = 1
[2011-01-30 12:45:22 3430] DEBUG (image:864) features       = 
[2011-01-30 12:45:22 3430] DEBUG (image:865) flags          = 0
[2011-01-30 12:45:22 3430] DEBUG (image:866) superpages     = 0
[2011-01-30 12:45:22 3430] DEBUG (image:608) createDeviceModel 1: orig_state is None, retrying
[2011-01-30 12:45:22 3430] INFO (XendDomainInfo:2409) createDevice: vkbd : {'uuid': 'fc230c5d-194c-c365-c28b-c089c7ec3aa8'}
[2011-01-30 12:45:22 3430] DEBUG (DevController:95) DevController: writing {'protocol': 'x86_64-abi', 'state': '1', 'backend-id': '0', 'backend': '/local/domain/0/backend/vkbd/2/0'} to /local/domain/2/device/vkbd/0.
[2011-01-30 12:45:22 3430] DEBUG (DevController:97) DevController: writing {'frontend-id': '2', 'domain': 'caitlin-dm', 'frontend': '/local/domain/2/device/vkbd/0', 'state': '1', 'online': '1'} to /local/domain/0/backend/vkbd/2/0.
[2011-01-30 12:45:22 3430] INFO (XendDomainInfo:2409) createDevice: vfb : {'vncunused': '1', 'other_config': {'vncunused': '1', 'vnc': '1', 'xauthority': '/root/.xauthREQBaR', 'opengl': '1', 'vnclisten': '127.0.0.1', 'vncdisplay': '0', 'keymap': 'en-us', 'sdl': '0', 'display': 'localhost:10.0'}, 'vnc': '1', 'xauthority': '/root/.xauthREQBaR', 'opengl': '1', 'vnclisten': '127.0.0.1', 'vncdisplay': '0', 'keymap': 'en-us', 'sdl': '0', 'serial': 'pty', 'display': 'localhost:10.0', 'uuid': '227dee71-0c3e-60cd-dca3-ea1499646482'}
[2011-01-30 12:45:22 3430] DEBUG (DevController:95) DevController: writing {'protocol': 'x86_64-abi', 'state': '1', 'backend-id': '0', 'backend': '/local/domain/0/backend/vfb/2/0'} to /local/domain/2/device/vfb/0.
[2011-01-30 12:45:22 3430] DEBUG (DevController:97) DevController: writing {'vncunused': '1', 'domain': 'caitlin-dm', 'vnc': '1', 'xauthority': '/root/.xauthREQBaR', 'opengl': '1', 'vnclisten': '127.0.0.1', 'vncdisplay': '0', 'frontend-id': '2', 'state': '1', 'keymap': 'en-us', 'online': '1', 'sdl': '0', 'frontend': '/local/domain/2/device/vfb/0', 'display': 'localhost:10.0', 'uuid': '227dee71-0c3e-60cd-dca3-ea1499646482'} to /local/domain/0/backend/vfb/2/0.
[2011-01-30 12:45:22 3430] INFO (XendDomainInfo:2409) createDevice: console : {'other_config': {}, 'protocol': 'vt100', 'uuid': 'c485bb25-e956-7b6a-36d1-d95c95a5f89a', 'location': '0'}
[2011-01-30 12:45:22 3430] DEBUG (DevController:95) DevController: writing {'protocol': 'x86_64-abi', 'state': '1', 'backend-id': '0', 'backend': '/local/domain/0/backend/console/2/0'} to /local/domain/2/device/console/0.
[2011-01-30 12:45:22 3430] DEBUG (DevController:97) DevController: writing {'domain': 'caitlin-dm', 'frontend': '/local/domain/2/device/console/0', 'uuid': 'c485bb25-e956-7b6a-36d1-d95c95a5f89a', 'frontend-id': '2', 'state': '1', 'location': '0', 'online': '1', 'protocol': 'vt100'} to /local/domain/0/backend/console/2/0.
[2011-01-30 12:45:22 3430] INFO (XendDomainInfo:2409) createDevice: console : {'other_config': {}, 'protocol': 'vt100', 'uuid': 'a4ea981f-a0c6-e74a-50c5-6987fed184bc', 'location': '1'}
[2011-01-30 12:45:22 3430] DEBUG (DevController:95) DevController: writing {'protocol': 'x86_64-abi', 'state': '1', 'backend-id': '0', 'backend': '/local/domain/0/backend/console/2/1'} to /local/domain/2/device/console/1.
[2011-01-30 12:45:22 3430] DEBUG (DevController:97) DevController: writing {'domain': 'caitlin-dm', 'frontend': '/local/domain/2/device/console/1', 'uuid': 'a4ea981f-a0c6-e74a-50c5-6987fed184bc', 'frontend-id': '2', 'state': '1', 'location': '1', 'online': '1', 'protocol': 'vt100'} to /local/domain/0/backend/console/2/1.
[2011-01-30 12:45:22 3430] INFO (XendDomainInfo:2409) createDevice: vbd : {'uuid': 'f7b4a8cc-9b17-f14f-a8f0-f865e0b87022', 'bootable': 1, 'driver': 'paravirtualised', 'dev': 'hda:disk', 'uname': 'file:/etc/xen/myimages/caitlin/disk0.raw', 'mode': 'w'}
[2011-01-30 12:45:22 3430] DEBUG (DevController:95) DevController: writing {'virtual-device': '768', 'device-type': 'disk', 'protocol': 'x86_64-abi', 'backend-id': '0', 'state': '1', 'backend': '/local/domain/0/backend/vbd/2/768'} to /local/domain/2/device/vbd/768.
[2011-01-30 12:45:22 3430] DEBUG (DevController:97) DevController: writing {'domain': 'caitlin-dm', 'frontend': '/local/domain/2/device/vbd/768', 'uuid': 'f7b4a8cc-9b17-f14f-a8f0-f865e0b87022', 'bootable': '1', 'dev': 'hda', 'state': '1', 'params': '/etc/xen/myimages/caitlin/disk0.raw', 'mode': 'w', 'online': '1', 'frontend-id': '2', 'type': 'file'} to /local/domain/0/backend/vbd/2/768.
[2011-01-30 12:45:22 3430] INFO (XendDomainInfo:2409) createDevice: vif : {'mac': '00:16:3e:63:a5:20', 'uuid': 'e5a04a51-b731-888d-26b4-f5878b7482a4'}
[2011-01-30 12:45:22 3430] DEBUG (DevController:95) DevController: writing {'mac': '00:16:3e:63:a5:20', 'handle': '0', 'protocol': 'x86_64-abi', 'backend-id': '0', 'state': '1', 'backend': '/local/domain/0/backend/vif/2/0'} to /local/domain/2/device/vif/0.
[2011-01-30 12:45:22 3430] DEBUG (DevController:97) DevController: writing {'domain': 'caitlin-dm', 'frontend': '/local/domain/2/device/vif/0', 'uuid': 'e5a04a51-b731-888d-26b4-f5878b7482a4', 'script': '/etc/xen/scripts/vif-bridge', 'mac': '00:16:3e:63:a5:20', 'frontend-id': '2', 'state': '1', 'online': '1', 'handle': '0'} to /local/domain/0/backend/vif/2/0.
[2011-01-30 12:45:22 3430] INFO (image:542) spawning device models: /usr/lib/xen/bin/qemu-dm ['/usr/lib/xen/bin/qemu-dm', '-d', '2', '-serial', 'pty', '-domain-name', 'caitlin-dm', '-videoram', '4', '-serial', 'pty', '-k', 'en-us', '-vnc', '127.0.0.1:0', '-vncunused', '-M', 'xenpv']
[2011-01-30 12:45:22 3430] INFO (image:591) device model pid: 13845
[2011-01-30 12:45:22 3430] INFO (image:725) waiting for sentinel_fifo
[2011-01-30 12:45:22 3430] DEBUG (XendDomainInfo:3495) Storing VM details: {'on_xend_stop': 'ignore', 'pool_name': 'Pool-0', 'shadow_memory': '0', 'uuid': '86207a57-273e-09cf-a79c-dc2854ad8553', 'on_reboot': 'restart', 'start_time': '1296413122.8', 'on_poweroff': 'destroy', 'bootloader_args': '', 'on_xend_start': 'ignore', 'on_crash': 'restart', 'xend/restart_count': '0', 'vcpus': '1', 'vcpu_avail': '1', 'bootloader': '', 'image': "(linux (kernel /usr/lib/xen/boot/ioemu-stubdom.gz) (args ' -d 1') (superpages 0) (videoram 4) (pci ()) (nomigrate 0) (tsc_mode 0) (device_model /usr/lib/xen/bin/qemu-dm) (notes))", 'name': 'caitlin-dm'}
[2011-01-30 12:45:22 3430] DEBUG (image:608) createDeviceModel 1: orig_state is None, retrying
[2011-01-30 12:45:22 3430] DEBUG (XendDomainInfo:1842) Storing domain details: {'console/ring-ref': '634326', 'console/port': '2', 'description': '', 'console/limit': '1048576', 'vm': '/vm/86207a57-273e-09cf-a79c-dc2854ad8553', 'domid': '2', 'store/port': '1', 'cpu/0/availability': 'online', 'memory/target': '32768', 'control/platform-feature-multiprocessor-suspend': '1', 'store/ring-ref': '634327', 'console/type': 'ioemu', 'name': 'caitlin-dm'}
[2011-01-30 12:45:22 3430] DEBUG (XendDomainInfo:1929) XendDomainInfo.handleShutdownWatch
[2011-01-30 12:45:22 3430] DEBUG (DevController:139) Waiting for devices tap2.
[2011-01-30 12:45:22 3430] DEBUG (image:608) createDeviceModel 1: orig_state is None, retrying
[2011-01-30 12:45:22 3430] DEBUG (DevController:139) Waiting for devices vif.
[2011-01-30 12:45:23 3430] DEBUG (DevController:144) Waiting for 0.
[2011-01-30 12:45:23 3430] DEBUG (DevController:671) hotplugStatusCallback /local/domain/0/backend/vif/2/0/hotplug-status.
[2011-01-30 12:45:23 3430] DEBUG (DevController:685) hotplugStatusCallback 1.
[2011-01-30 12:45:23 3430] DEBUG (DevController:139) Waiting for devices vkbd.
[2011-01-30 12:45:23 3430] DEBUG (DevController:139) Waiting for devices ioports.
[2011-01-30 12:45:23 3430] DEBUG (image:608) createDeviceModel 1: orig_state is None, retrying
[2011-01-30 12:45:23 3430] DEBUG (DevController:139) Waiting for devices tap.
[2011-01-30 12:45:23 3430] DEBUG (DevController:139) Waiting for devices vif2.
[2011-01-30 12:45:23 3430] DEBUG (DevController:139) Waiting for devices console.
[2011-01-30 12:45:23 3430] DEBUG (DevController:144) Waiting for 0.
[2011-01-30 12:45:23 3430] DEBUG (DevController:144) Waiting for 1.
[2011-01-30 12:45:23 3430] DEBUG (DevController:139) Waiting for devices vscsi.
[2011-01-30 12:45:23 3430] DEBUG (DevController:139) Waiting for devices vbd.
[2011-01-30 12:45:23 3430] DEBUG (DevController:144) Waiting for 768.
[2011-01-30 12:45:23 3430] DEBUG (DevController:671) hotplugStatusCallback /local/domain/0/backend/vbd/2/768/hotplug-status.
[2011-01-30 12:45:23 3430] DEBUG (DevController:671) hotplugStatusCallback /local/domain/0/backend/vbd/2/768/hotplug-status.
[2011-01-30 12:45:23 3430] DEBUG (DevController:685) hotplugStatusCallback 1.
[2011-01-30 12:45:23 3430] DEBUG (image:608) createDeviceModel 1: orig_state is None, retrying
[2011-01-30 12:45:23 3430] DEBUG (DevController:139) Waiting for devices irq.
[2011-01-30 12:45:23 3430] DEBUG (DevController:139) Waiting for devices vfb.
[2011-01-30 12:45:23 3430] DEBUG (DevController:139) Waiting for devices pci.
[2011-01-30 12:45:23 3430] DEBUG (DevController:139) Waiting for devices vusb.
[2011-01-30 12:45:23 3430] DEBUG (DevController:139) Waiting for devices vtpm.
[2011-01-30 12:45:23 3430] INFO (XendDomain:1219) Domain caitlin-dm (2) unpaused.
[2011-01-30 12:45:23 3430] WARNING (XendDomainInfo:2109) Domain has crashed: name=caitlin-dm id=2.
[2011-01-30 12:45:23 3430] ERROR (XendDomainInfo:2243) VM caitlin-dm restarting too fast (Elapsed time: 0.422413 seconds). Refusing to restart to avoid loops.
[2011-01-30 12:45:23 3430] DEBUG (XendDomainInfo:3124) XendDomainInfo.destroy: domid=2
[2011-01-30 12:45:23 3430] DEBUG (XendDomainInfo:2454) Destroying device model
[2011-01-30 12:45:23 3430] DEBUG (image:608) createDeviceModel 1: orig_state is None, retrying
[2011-01-30 12:45:23 3430] INFO (image:750) caitlin-dm device model terminated
[2011-01-30 12:45:23 3430] DEBUG (XendDomainInfo:2459) stopping xenpaging
[2011-01-30 12:45:23 3430] DEBUG (XendDomainInfo:2466) Releasing devices
[2011-01-30 12:45:23 3430] DEBUG (XendDomainInfo:2472) Removing vif/0
[2011-01-30 12:45:23 3430] DEBUG (XendDomainInfo:1296) XendDomainInfo.destroyDevice: deviceClass = vif, device = vif/0
[2011-01-30 12:45:23 3430] DEBUG (XendDomainInfo:2472) Removing vkbd/0
[2011-01-30 12:45:23 3430] DEBUG (XendDomainInfo:1296) XendDomainInfo.destroyDevice: deviceClass = vkbd, device = vkbd/0
[2011-01-30 12:45:23 3430] DEBUG (image:608) createDeviceModel 1: orig_state is None, retrying
[2011-01-30 12:45:23 3430] DEBUG (XendDomainInfo:2472) Removing console/0
[2011-01-30 12:45:23 3430] DEBUG (XendDomainInfo:1296) XendDomainInfo.destroyDevice: deviceClass = console, device = console/0
[2011-01-30 12:45:23 3430] DEBUG (XendDomainInfo:2472) Removing console/1
[2011-01-30 12:45:23 3430] DEBUG (XendDomainInfo:1296) XendDomainInfo.destroyDevice: deviceClass = console, device = console/1
[2011-01-30 12:45:23 3430] DEBUG (XendDomainInfo:2472) Removing vbd/768
[2011-01-30 12:45:23 3430] DEBUG (XendDomainInfo:1296) XendDomainInfo.destroyDevice: deviceClass = vbd, device = vbd/768
[2011-01-30 12:45:23 3430] DEBUG (XendDomainInfo:2472) Removing vfb/0
[2011-01-30 12:45:23 3430] DEBUG (XendDomainInfo:1296) XendDomainInfo.destroyDevice: deviceClass = vfb, device = vfb/0
[2011-01-30 12:45:23 3430] DEBUG (image:608) createDeviceModel 1: orig_state is None, retrying
[2011-01-30 12:45:23 3430] DEBUG (XendDomainInfo:2464) No device model
[2011-01-30 12:45:23 3430] DEBUG (XendDomainInfo:2466) Releasing devices
[2011-01-30 12:45:23 3430] DEBUG (XendDomainInfo:2472) Removing vif/0
[2011-01-30 12:45:23 3430] DEBUG (XendDomainInfo:1296) XendDomainInfo.destroyDevice: deviceClass = vif, device = vif/0
[2011-01-30 12:45:23 3430] DEBUG (XendDomainInfo:2472) Removing vbd/768
[2011-01-30 12:45:23 3430] DEBUG (XendDomainInfo:1296) XendDomainInfo.destroyDevice: deviceClass = vbd, device = vbd/768
[2011-01-30 12:45:23 3430] DEBUG (image:608) createDeviceModel 1: orig_state is None, retrying
[2011-01-30 12:45:23 3430] DEBUG (image:608) createDeviceModel 1: orig_state is None, retrying
[2011-01-30 12:45:23 3430] DEBUG (image:608) createDeviceModel 1: orig_state is None, retrying
[2011-01-30 12:45:23 3430] DEBUG (image:608) createDeviceModel 1: orig_state is None, retrying
[2011-01-30 12:45:24 3430] DEBUG (image:608) createDeviceModel 1: orig_state is None, retrying
[2011-01-30 12:45:24 3430] DEBUG (image:608) createDeviceModel 1: orig_state is None, retrying
[2011-01-30 12:45:24 3430] DEBUG (image:608) createDeviceModel 1: orig_state is None, retrying
[2011-01-30 12:45:24 3430] DEBUG (image:608) createDeviceModel 1: orig_state is None, retrying
[2011-01-30 12:45:24 3430] DEBUG (image:608) createDeviceModel 1: orig_state is None, retrying
[2011-01-30 12:45:24 3430] DEBUG (image:608) createDeviceModel 1: orig_state is None, retrying
[2011-01-30 12:45:24 3430] WARNING (image:683) domain caitlin: device model failure: pid 13714: exited; see /var/log/xen/qemu-dm-caitlin.log 
[2011-01-30 12:45:24 3430] WARNING (XendDomainInfo:2109) Domain has crashed: name=caitlin id=1.
[2011-01-30 12:45:24 3430] DEBUG (XendDomainInfo:3124) XendDomainInfo.destroy: domid=1
[2011-01-30 12:45:24 3430] DEBUG (image:608) createDeviceModel 1: orig_state is None, retrying
[2011-01-30 12:45:24 3430] DEBUG (XendDomainInfo:2454) Destroying device model
[2011-01-30 12:45:24 3430] DEBUG (XendDomainInfo:2459) stopping xenpaging
[2011-01-30 12:45:24 3430] DEBUG (XendDomainInfo:2466) Releasing devices
[2011-01-30 12:45:24 3430] DEBUG (XendDomainInfo:2472) Removing vif/0
[2011-01-30 12:45:24 3430] DEBUG (XendDomainInfo:1296) XendDomainInfo.destroyDevice: deviceClass = vif, device = vif/0
[2011-01-30 12:45:24 3430] DEBUG (XendDomainInfo:2472) Removing vbd/768
[2011-01-30 12:45:24 3430] DEBUG (XendDomainInfo:1296) XendDomainInfo.destroyDevice: deviceClass = vbd, device = vbd/768
[2011-01-30 12:45:24 3430] DEBUG (XendDomainInfo:2472) Removing vfb/0
[2011-01-30 12:45:24 3430] DEBUG (XendDomainInfo:1296) XendDomainInfo.destroyDevice: deviceClass = vfb, device = vfb/0
[2011-01-30 12:45:24 3430] ERROR (XendDomainInfo:489) VM start failed
Traceback (most recent call last):
  File "/usr/lib64/python2.6/site-packages/xen/xend/XendDomainInfo.py", line 475, in start
    XendTask.log_progress(31, 60, self._initDomain)
  File "/usr/lib64/python2.6/site-packages/xen/xend/XendTask.py", line 209, in log_progress
    retval = func(*args, **kwds)
  File "/usr/lib64/python2.6/site-packages/xen/xend/XendDomainInfo.py", line 2962, in _initDomain
    self._createDevices()
  File "/usr/lib64/python2.6/site-packages/xen/xend/XendDomainInfo.py", line 2444, in _createDevices
    self.image.createDeviceModel()
  File "/usr/lib64/python2.6/site-packages/xen/xend/image.py", line 603, in createDeviceModel
    % self.vm.getDomid())
TypeError: %d format: a number is required, not NoneType
[2011-01-30 12:45:24 3430] ERROR (XendDomainInfo:108) Domain construction failed
Traceback (most recent call last):
  File "/usr/lib64/python2.6/site-packages/xen/xend/XendDomainInfo.py", line 106, in create
    vm.start()
  File "/usr/lib64/python2.6/site-packages/xen/xend/XendDomainInfo.py", line 475, in start
    XendTask.log_progress(31, 60, self._initDomain)
  File "/usr/lib64/python2.6/site-packages/xen/xend/XendTask.py", line 209, in log_progress
    retval = func(*args, **kwds)
  File "/usr/lib64/python2.6/site-packages/xen/xend/XendDomainInfo.py", line 2962, in _initDomain
    self._createDevices()
  File "/usr/lib64/python2.6/site-packages/xen/xend/XendDomainInfo.py", line 2444, in _createDevices
    self.image.createDeviceModel()
  File "/usr/lib64/python2.6/site-packages/xen/xend/image.py", line 603, in createDeviceModel
    % self.vm.getDomid())
TypeError: %d format: a number is required, not NoneType
[2011-01-30 12:45:24 3430] ERROR (xmlrpclib2:181) Internal error handling xend.domain.create
Traceback (most recent call last):
  File "/usr/lib64/python2.6/site-packages/xen/util/xmlrpclib2.py", line 134, in _marshaled_dispatch
    response = self._dispatch(method, params)
  File "/usr/lib64/python2.6/SimpleXMLRPCServer.py", line 418, in _dispatch
    return func(*params)
  File "/usr/lib64/python2.6/site-packages/xen/xend/server/XMLRPCServer.py", line 80, in domain_create
    info = XendDomain.instance().domain_create(config)
  File "/usr/lib64/python2.6/site-packages/xen/xend/XendDomain.py", line 998, in domain_create
    self.domains_lock.release()
  File "/usr/lib64/python2.6/threading.py", line 138, in release
    raise RuntimeError("cannot release un-acquired lock")
RuntimeError: cannot release un-acquired lock


_______________________________________________
Xen-devel mailing list
Xen-devel@xxxxxxxxxxxxxxxxxxx
http://lists.xensource.com/xen-devel