Re: First attempt at HVM: vbd problems

[Anzi <anzi%dnainternet.net@localhost>]

Hi,

Try with

disk = [ 'file:/home/seklecki/6.3-RELEASE-i386-bootonly.iso,ioemu:hdb,r' ]

did you also created xen devices in /dev ? (from netbsd howto: Make sure 
that |/dev/xencons| and |/dev/xenev exists..) you can create them with |

# cd /dev && sh MAKEDEV xen

And one more thing, did you created network bridge and rebooted?

-antti-


Brian A. Seklecki wrote:
> All:
>
> I'm evaluating the overall functionality of Xen NetBSD. My test 
> platform is NetBSD/amd64 -current on a PowerEdge 2950 r3
>
> I can get a HVM with a VNC console to start, but only if I disable 
> disk= and vif= devices. With disk= devices, the hvm initializes, then 
> times-out after about 180 seconds.
>
> Likely this is some sort of Linux-specific code bug, like the 
> previously identified netstat(1) one.
>
> ~BAS
>
> === Crash ====
>
>
> # xm create /usr/pkg/etc/xen/winxp
> Using config file "/usr/pkg/etc/xen/winxp".
> VNC= 1
> [2008-04-10 18:00:58 21694] DEBUG (XendDomainInfo:84) 
> XendDomainInfo.create(['vm', ['name', 'winxp'], ['memory', '256'], 
> ['vcpus', 2], ['on_xend_start', 'ignore'], ['on_xend_stop', 'ignore'], 
> ['image', ['hvm', ['kernel', '/usr/pkg/lib/xen/boot/hvmloader'], 
> ['args', 'VNC_VIEWER=192.168.3.93:5501 '], ['device_model', 
> '/usr/pkg/libexec/qemu-dm'], ['pae', 1], ['vcpus', 2], ['boot', 'd'], 
> ['fda', ''], ['fdb', ''], ['timer_mode', 0], ['localtime', 0], 
> ['serial', ''], ['stdvga', 0], ['isa', 0], ['nographic', 0], 
> ['soundhw', ''], ['vnc', 1], ['vncunused', 1], ['xauthority', 
> '/root/.Xauthority'], ['rtc_timeoffset', '0'], ['monitor', 0], 
> ['acpi', 1], ['apic', 0], ['usb', 0], ['usbdevice', ''], ['keymap', 
> '']]], ['device', ['vbd', ['uname', 
> 'file:/home/seklecki/6.3-RELEASE-i386-bootonly.iso'], ['dev', 
> 'ioemu:hdc:cdrom'], ['mode', 'r']]], ['device', ['vkbd']], ['device', 
> ['vfb', ['vncunused', '0'], ['type', 'vnc'], ['xauthority', 
> '/root/.Xauthority']]]])
> [2008-04-10 18:00:58 21694] DEBUG (XendDomainInfo:1512) 
> XendDomainInfo.constructDomain
> [2008-04-10 18:00:58 21694] DEBUG (balloon:115) Balloon: 3843788 KiB 
> free; need 2048; done.
> [2008-04-10 18:00:59 21694] DEBUG (XendDomain:434) Adding Domain: 87
> [2008-04-10 18:00:59 21694] DEBUG (XendDomainInfo:1572) 
> XendDomainInfo.initDomain: 87 256
> [2008-04-10 18:00:59 21694] DEBUG (image:337) args: boot, val: d
> [2008-04-10 18:00:59 21694] DEBUG (image:337) args: fda, val: None
> [2008-04-10 18:00:59 21694] DEBUG (image:337) args: fdb, val: None
> [2008-04-10 18:00:59 21694] DEBUG (image:337) args: soundhw, val: None
> [2008-04-10 18:00:59 21694] DEBUG (image:337) args: localtime, val: 0
> [2008-04-10 18:00:59 21694] DEBUG (image:337) args: serial, val: None
> [2008-04-10 18:00:59 21694] DEBUG (image:337) args: std-vga, val: 0
> [2008-04-10 18:00:59 21694] DEBUG (image:337) args: isa, val: 0
> [2008-04-10 18:00:59 21694] DEBUG (image:337) args: acpi, val: 1
> [2008-04-10 18:00:59 21694] DEBUG (image:337) args: usb, val: 0
> [2008-04-10 18:00:59 21694] DEBUG (image:337) args: usbdevice, val: None
> [2008-04-10 18:00:59 21694] DEBUG (image:337) args: k, val: None
> [2008-04-10 18:00:59 21694] DEBUG (XendDomainInfo:1607) 
> _initDomain:shadow_memory=0x0, memory_static_max=0x10000000, 
> memory_static_min=0x0.
> [2008-04-10 18:00:59 21694] DEBUG (balloon:115) Balloon: 3842748 KiB 
> free; need 274432; done.
> [2008-04-10 18:00:59 21694] INFO (image:128) buildDomain os=hvm dom=87 
> vcpus=2
> [2008-04-10 18:00:59 21694] DEBUG (image:281) domid = 87
> [2008-04-10 18:00:59 21694] DEBUG (image:282) image = 
> /usr/pkg/lib/xen/boot/hvmloader
> [2008-04-10 18:00:59 21694] DEBUG (image:283) store_evtchn = 3
> [2008-04-10 18:00:59 21694] DEBUG (image:284) memsize = 256
> [2008-04-10 18:00:59 21694] DEBUG (image:285) vcpus = 2
> [2008-04-10 18:00:59 21694] DEBUG (image:286) acpi = 1
> [2008-04-10 18:00:59 21694] DEBUG (image:287) apic = 0
> [2008-04-10 18:00:59 21694] INFO (XendDomainInfo:1414) createDevice: 
> vkbd : {'uuid': '390fcc7e-dc18-4745-cf1e-31bf12415229'}
> [2008-04-10 18:00:59 21694] DEBUG (DevController:117) DevController: 
> writing {'state': '1', 'backend-id': '0', 'backend': 
> '/local/domain/0/backend/vkbd/87/0'} to /local/domain/87/device/vkbd/0.
> [2008-04-10 18:00:59 21694] DEBUG (DevController:119) DevController: 
> writing {'frontend-id': '87', 'domain': 'winxp', 'frontend': 
> '/local/domain/87/device/vkbd/0', 'state': '1', 'online': '1'} to 
> /local/domain/0/backend/vkbd/87/0.
> [2008-04-10 18:00:59 21694] INFO (XendDomainInfo:1414) createDevice: 
> vfb : {'vncunused': '0', 'other_config': {'vncunused': '0', 'type': 
> 'vnc', 'xauthority': '/root/.Xauthority'}, 'type': 'vnc', 
> 'xauthority': '/root/.Xauthority', 'uuid': 
> '4366e928-af8d-45f9-289b-211f8fddab90'}
> [2008-04-10 18:00:59 21694] DEBUG (DevController:117) DevController: 
> writing {'state': '1', 'backend-id': '0', 'backend': 
> '/local/domain/0/backend/vfb/87/0'} to /local/domain/87/device/vfb/0.
> [2008-04-10 18:00:59 21694] DEBUG (DevController:119) DevController: 
> writing {'vncunused': '0', 'domain': 'winxp', 'frontend': 
> '/local/domain/87/device/vfb/0', 'xauthority': '/root/.Xauthority', 
> 'state': '1', 'online': '1', 'frontend-id': '87', 'type': 'vnc', 
> 'uuid': '4366e928-af8d-45f9-289b-211f8fddab90'} to 
> /local/domain/0/backend/vfb/87/0.
> [2008-04-10 18:00:59 21694] INFO (XendDomainInfo:1414) createDevice: 
> vbd : {'uuid': '0e6857ff-8609-6c23-1b92-fedd2f3c37f6', 'bootable': 1, 
> 'driver': 'ioemu', 'dev': 'ioemu:hdc:cdrom', 'uname': 
> 'file:/home/seklecki/6.3-RELEASE-i386-bootonly.iso', 'mode': 'r'}
> [2008-04-10 18:00:59 21694] DEBUG (DevController:117) DevController: 
> writing {'backend-id': '0', 'virtual-device': '5632', 'device-type': 
> 'cdrom', 'state': '1', 'backend': 
> '/local/domain/0/backend/vbd/87/5632'} to 
> /local/domain/87/device/vbd/5632.
> [2008-04-10 18:00:59 21694] DEBUG (DevController:119) DevController: 
> writing {'domain': 'winxp', 'frontend': 
> '/local/domain/87/device/vbd/5632', 'uuid': 
> '0e6857ff-8609-6c23-1b92-fedd2f3c37f6', 'dev': 'hdc', 'state': '1', 
> 'params': '/home/seklecki/6.3-RELEASE-i386-bootonly.iso', 'mode': 'r', 
> 'online': '1', 'frontend-id': '87', 'type': 'file'} to 
> /local/domain/0/backend/vbd/87/5632.
> [2008-04-10 18:00:59 21694] INFO (image:452) spawning device models: 
> /usr/pkg/libexec/qemu-dm ['/usr/pkg/libexec/qemu-dm', '-d', '87', 
> '-vcpus', '2', '-boot', 'd', '-acpi', '-domain-name', 'winxp', 
> '-vncunused', '-vnclisten', '192.168.3.93']
> [2008-04-10 18:00:59 21694] INFO (image:456) device model pid: 26095
> [2008-04-10 18:00:59 21694] DEBUG (XendDomainInfo:2086) Storing VM 
> details: {'on_xend_stop': 'ignore', 'shadow_memory': '4', 'uuid': 
> 'fe036add-6ab1-c0db-a56c-c3369495093e', 'on_reboot': 'restart', 
> 'start_time': '1207864859.25', 'on_poweroff': 'destroy', 
> 'on_xend_start': 'ignore', 'on_crash': 'restart', 
> 'xend/restart_count': '0', 'vcpus': '2', 'vcpu_avail': '3', 'image': 
> "(hvm (kernel /usr/pkg/lib/xen/boot/hvmloader) (args 
> 'VNC_VIEWER=192.168.3.93:5501 ') (acpi 1) (apic 0) (boot d) 
> (device_model /usr/pkg/libexec/qemu-dm) (isa 0) (localtime 0) (monitor 
> 0) (nographic 0) (pae 1) (rtc_timeoffset 0) (stdvga 0) (usb 0) (vnc 1) 
> (timer_mode 0) (vncunused 1) (xauthority /root/.Xauthority) (notes 
> (SUSPEND_CANCEL 1)))", 'name': 'winxp'}
> [2008-04-10 18:00:59 21694] DEBUG (XendDomainInfo:912) Storing domain 
> details: {'console/port': '4', 'name': 'winxp', 'console/limit': 
> '1048576', 'vm': '/vm/fe036add-6ab1-c0db-a56c-c3369495093e', 'domid': 
> '87', 'image/suspend-cancel': '1', 'cpu/0/availability': 'online', 
> 'memory/target': '262144', 
> 'control/platform-feature-multiprocessor-suspend': '1', 
> 'store/ring-ref': '65534', 'cpu/1/availability': 'online', 
> 'store/port': '3'}
> [2008-04-10 18:00:59 21694] DEBUG (DevController:117) DevController: 
> writing {'state': '1', 'backend-id': '0', 'backend': 
> '/local/domain/0/backend/console/87/0'} to 
> /local/domain/87/device/console/0.
> [2008-04-10 18:00:59 21694] DEBUG (DevController:119) DevController: 
> writing {'domain': 'winxp', 'protocol': 'vt100', 'uuid': 
> '5b1088f1-0fb7-076c-b9ec-be078d5b965b', 'frontend': 
> '/local/domain/87/device/console/0', 'state': '1', 'location': '4', 
> 'online': '1', 'frontend-id': '87'} to 
> /local/domain/0/backend/console/87/0.
> [2008-04-10 18:00:59 21694] DEBUG (XendDomainInfo:996) 
> XendDomainInfo.handleShutdownWatch
> xenstore-read: couldn't read path 
> /local/domain/0/backend/console/87/0/type
> [2008-04-10 18:00:59 21694] DEBUG (DevController:150) Waiting for 
> devices vif.
> [2008-04-10 18:00:59 21694] DEBUG (DevController:150) Waiting for 
> devices usb.
> [2008-04-10 18:00:59 21694] DEBUG (DevController:150) Waiting for 
> devices vbd.
> [2008-04-10 18:00:59 21694] DEBUG (DevController:155) Waiting for 5632.
> [2008-04-10 18:00:59 21694] DEBUG (DevController:589) 
> hotplugStatusCallback /local/domain/0/backend/vbd/87/5632/hotplug-status.
>
> [2 minutes -- 30 seconds here]
>
> [2008-04-10 18:02:39 21694] DEBUG (XendDomainInfo:1772) 
> XendDomainInfo.destroy: domid=87
> [2008-04-10 18:02:39 21694] DEBUG (XendDomainInfo:1791) 
> XendDomainInfo.destroyDomain(87)
> [2008-04-10 18:02:39 21694] DEBUG (XendDomainInfo:1436) Removing vbd/5632
> [2008-04-10 18:02:39 21694] DEBUG (XendDomainInfo:574) 
> XendDomainInfo.destroyDevice: deviceClass = vbd, device = vbd/5632
> [2008-04-10 18:02:39 21694] DEBUG (XendDomainInfo:1436) Removing vkbd/0
> [2008-04-10 18:02:39 21694] DEBUG (XendDomainInfo:574) 
> XendDomainInfo.destroyDevice: deviceClass = vkbd, device = vkbd/0
> xenstore-read: couldn't read path /local/domain/0/backend/vkbd/87/0/type
> [2008-04-10 18:02:39 21694] DEBUG (XendDomainInfo:1436) Removing vfb/0
> [2008-04-10 18:02:39 21694] DEBUG (XendDomainInfo:574) 
> XendDomainInfo.destroyDevice: deviceClass = vfb, device = vfb/0
> xenstore-read: couldn't read path /local/domain/0/backend/vfb/87/0/params
> [2008-04-10 18:02:39 21694] DEBUG (XendDomainInfo:1436) Removing 
> console/0
> [2008-04-10 18:02:39 21694] DEBUG (XendDomainInfo:574) 
> XendDomainInfo.destroyDevice: deviceClass = console, device = console/0
> xenstore-read: couldn't read path 
> /local/domain/0/backend/console/87/0/type
> Error: Device 5632 (vbd) could not be connected. Hotplug scripts not 
> working.
>
>
>
> === Startup ===
>
> # /etc/rc.d/xend start && /etc/rc.d/xenbackendd start
> Starting xend.
> Apr 10 17:59:24 hv01 xenstored: Checking store ...
> Apr 10 17:59:24 hv01 xenstored: Checking store complete.
> Apr 10 17:59:24 hv01 xenstored: Checking store ...
> Apr 10 17:59:24 hv01 xenstored: Checking store complete.
> Xend started at Thu Apr 10 17:59:24 2008.
> [2008-04-10 17:59:24 21694] INFO (SrvDaemon:331) Xend Daemon started
> [2008-04-10 17:59:24 21694] INFO (SrvDaemon:335) Xend changeset: 
> unavailable.
> [2008-04-10 17:59:24 21694] INFO (SrvDaemon:342) Xend version: Unknown.
> brctl: not found
> brctl: not found
> [2008-04-10 17:59:24 21694] DEBUG (XendDomainInfo:132) 
> XendDomainInfo.recreate({'max_vcpu_id': 3, 'cpu_time': 464078074839L, 
> 'ssidref': 0, 'hvm': 0, 'shutdown_reason': 0, 'dying': 0, 
> 'online_vcpus': 1, 'domid': 0, 'paused': 0, 'crashed': 0, 'running': 
> 1, 'maxmem_kb': 17179869180L, 'shutdown': 0, 'mem_kb': 262144L, 
> 'handle': [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0], 'blocked': 
> 0, 'name': 'Domain-0'})
> [2008-04-10 17:59:24 21694] INFO (XendDomainInfo:148) Recreating 
> domain 0, UUID 00000000-0000-0000-0000-000000000000. at /local/domain/0
> [2008-04-10 17:59:24 21694] DEBUG (XendDomainInfo:2086) Storing VM 
> details: {'on_xend_stop': 'ignore', 'shadow_memory': '0', 'uuid': 
> '00000000-0000-0000-0000-000000000000', 'on_reboot': 'restart', 
> 'image': '(linux (kernel ))', 'on_poweroff': 'destroy', 
> 'on_xend_start': 'ignore', 'on_crash': 'restart', 
> 'xend/restart_count': '0', 'vcpus': '1', 'vcpu_avail': '1', 'name': 
> 'Domain-0'}
> [2008-04-10 17:59:24 21694] DEBUG (XendDomainInfo:912) Storing domain 
> details: {'name': 'Domain-0', 'console/limit': '1048576', 'vm': 
> '/vm/00000000-0000-0000-0000-000000000000', 'domid': '0', 
> 'cpu/0/availability': 'online', 'memory/target': '262144', 
> 'control/platform-feature-multiprocessor-suspend': '1'}
> [2008-04-10 17:59:24 21694] DEBUG (XendDomain:434) Adding Domain: 0
> [2008-04-10 17:59:24 21694] DEBUG (XendDomain:379) number of vcpus to 
> use is 0
> [2008-04-10 17:59:24 21694] WARNING (XendDomain:169) Ignoring dying 
> domain 55 from now on
> [2008-04-10 17:59:24 21694] DEBUG (XendDomainInfo:996) 
> XendDomainInfo.handleShutdownWatch
> [2008-04-10 17:59:24 21694] WARNING (XendAPI:672) API call: 
> VBD.set_device not found
> [2008-04-10 17:59:24 21694] WARNING (XendAPI:672) API call: 
> VBD.set_type not found
> [2008-04-10 17:59:24 21694] WARNING (XendAPI:672) API call: 
> VM.get_auto_power_on not found
> [2008-04-10 17:59:24 21694] WARNING (XendAPI:672) API call: 
> VM.set_auto_power_on not found
> [2008-04-10 17:59:24 21694] WARNING (XendAPI:672) API call: 
> debug.get_all not found
> [2008-04-10 17:59:24 21694] WARNING (XendAPI:672) API call: 
> console.get_other_config not found
> [2008-04-10 17:59:24 21694] WARNING (XendAPI:672) API call: 
> console.set_other_config not found
> [2008-04-10 17:59:24 21694] WARNING (XendAPI:672) API call: 
> VIF.get_network not found
> [2008-04-10 17:59:24 21694] WARNING (XendAPI:672) API call: 
> VIF.set_device not found
> [2008-04-10 17:59:24 21694] WARNING (XendAPI:672) API call: 
> VIF.set_MAC not found
> [2008-04-10 17:59:24 21694] WARNING (XendAPI:672) API call: 
> VIF.set_MTU not found
> [2008-04-10 17:59:24 21694] WARNING (XendAPI:672) API call: 
> session.get_all_records not found
> [2008-04-10 17:59:24 21694] WARNING (XendAPI:672) API call: 
> event.get_record not found
> [2008-04-10 17:59:24 21694] WARNING (XendAPI:672) API call: 
> event.get_all not found
> [2008-04-10 17:59:24 21694] INFO (XMLRPCServer:149) Opening Unix 
> domain socket XML-RPC server on /var/run/xend/xen-api.sock; 
> authentication has been disabled for this server.
> [2008-04-10 17:59:24 21694] INFO (XMLRPCServer:149) Opening Unix 
> domain socket XML-RPC server on /var/run/xend/xmlrpc.sock.
> Starting xenbackendd.
>
>
> === Config ===
>
>
> # egrep -vi "^$|^#" xen/xend-config.sxp
> (logfile /var/log/xen/xend.log)
> (loglevel DEBUG)
> (xend-relocation-port 8002)
> (xend-relocation-hosts-allow '^localhost$ ^localhost\\.localdomain$')
> (dom0-min-mem 196)
> (dom0-cpus 0)
> (vnc-listen '192.168.3.93')
> (vncpasswd '')
>
>
>
>
> # more xen/winxp
> kernel = '/usr/pkg/lib/xen/boot/hvmloader'
> builder = 'hvm'
> memory = '256'
> device_model='/usr/pkg/libexec/qemu-dm'
> #vifs=1
> # Any variety
> #disk = [ 'file:/home/seklecki/xp2.iso,hdc:cdrom,r' ]
> disk = [ 
> 'file:/home/seklecki/6.3-RELEASE-i386-bootonly.iso,ioemu:hdc:cdrom,r' ]
> #disk = [ 'phy:/dev/cd1a,hdc:cdrom,r' ]
> #disk = [ 'file:/opt/domains/winxp/disk.img,hda,w', 
> 'file:/home/seklecki/xp2.iso,ioemu:hdc:cdrom,r' ]
> #name = 'winxp'
> #vif = [ 'mac=00:00:a0:c0:c0:c0, bridge=bridge0' ]
> boot='d'
> vnc = 1
> #vncviewer = 1
> vcpus = 2
> #extra = 'xencons=tty'
> #acpi=1
> #apic=0
> #vfb = ["type=vnc,vncunused=0"]