stubdom problem

stubdom problem

[Marco Sinhoreli]

[-- Attachment #1: Type: text/plain, Size: 561 bytes --]

Hello all Xen devels,

I'm writing howto's in brazilian portuguese language about Xen-3.3.0
stubdom, pv-grub and others configurations. Following what is written
in xen-3.3.0/stubdom/README, I tried start a HVM but without success.
When I start the virtual machine calling 'xm create hvmtest' command,
in a few seconds the virtual machine is dead (see
qemu-dm-hvmtest.log). This is happening following two distincts vnc
display configurations: using a VNC server in the stub domain and
using a VNC server in dom0.

Any idea?

Best regards,

-- 
Marco Sinhoreli

[-- Warning: decoded text below may be mangled, UTF-8 assumed --]
[-- Attachment #2: qemu-dm-hvmtest.log --]
[-- Type: text/x-log; name=qemu-dm-hvmtest.log, Size: 4838 bytes --]

Using config file "/etc/xen/hvmtest-dm".
Started domain hvmtest-dm
Xen Minimal OS!
\rstart_info:   0x515000
\r  nr_pages:   8192  shared_inf: bfd5a000
\r  pt_base:    0x518000  mod_start:  0x0
\r  mod_len:    0
\r  flags:      0x0
\r  cmd_line:    -d 30
\r  stack:      0x4c3ae0-0x4e3ae0
\rMM: Init
\r  _text:        0x0
\r  _etext:       0xd0d07
\r  _erodata:     0xf9000
\r  _edata:       0x124340
\r  stack start:  0x4c3ae0
\r  _end:         0x5043f0
\r  start_pfn:    522
\r  max_pfn:      2000
\rMapping memory range 0x800000 - 0x2000000
\rsetting 0x0-0xf9000 readonly
\rskipped 0x1000
\rMM: Initialise page allocator for 52e000(52e000)-2000000(2000000)
\rMM: done
\rDemand map pfns at 2001000-2002001000.
\rHeap resides at 2002002000-4002002000.
\rInitialising timer interface
\rInitialising console ... done.
\rgnttab_table mapped at 0x2001000.
\rInitialising scheduler
\rThread "Idle": pointer: 0x2002002010, stack: 0x550000
\rInitialising xenbus
\rThread "xenstore": pointer: 0x20020027c0, stack: 0x560000
\rDummy main: start_info=0x4e3be0
\rThread "main": pointer: 0x2002002f70, stack: 0x570000
\r[main] Waiting for network.
\r************************ NETFRONT for device/vif/0 **********


\rnet TX ring size 256
\rnet RX ring size 256
\rbackend at /local/domain/0/backend/vif/31/0
\rmac is 00:16:3e:7b:11:83
\r**************************
\r[main] IP ac1ece01 netmask ffff0000 gateway 0.
\r[main] TCP/IP bringup begins.
\rThread "tcpip_thread": pointer: 0x2002005d20, stack: 0x680000
\r[tcpip_thread] TCP/IP bringup ends.
\r[main] Network is ready.
\rIniting FS fronend(s).
\rFS export [dom=0, id=0] found
\rInitialising FS fortend to backend dom 0
\rAllocating request array for import 0, nr_entries = 128.
\rOur own id is 31
\rBackend found at /local/domain/0/backend/vfs/11
\rBackend ready.
\rdom vm is at /vm/e11b0b03-b02d-deca-772e-f1c035bfde4a
\r"main" "-d" "30" "-domain-name" "hvmtest" "-k" "pt-br" "-vnc" "172.30.206.1:0,password" "-vncunused" "-vcpus" "1" "-boot" "c" "-acpi" "-net" "nic,vlan=1,macaddr=00:16:3e:49:6f:41,model=rtl8139" "-net" "tap,vlan=1,ifname=tap30.0,bridge=eth0" 
\rdomid: 30
\rqemu: the number of cpus is 1
\rxs_daemon_open -> 4, 0x120288
\rxs_read(/local/domain/31/device/vbd/5632/phantom_vbd): ENOENT
\rxs_watch(/local/domain/0/backend/vbd/31/5632/params, hdc)
\r******************* BLKFRONT for /local/domain/31/device/vbd/5632 **********


\rbackend at /local/domain/0/backend/vbd/31/5632
\rFailed to read /local/domain/0/backend/vbd/31/5632/feature-flush-cache.
\r1299724 sectors of 512 bytes
\r**************************
\rblk_open(/local/domain/31/device/vbd/5632) -> 5
\rxs_read(/local/domain/31/device/vbd/768/phantom_vbd): ENOENT
\r******************* BLKFRONT for /local/domain/31/device/vbd/768 **********


\rbackend at /local/domain/0/backend/vbd/31/768
\rFailed to read /local/domain/0/backend/vbd/31/768/feature-flush-cache.
\r20971520 sectors of 512 bytes
\r**************************
\rblk_open(/local/domain/31/device/vbd/768) -> 6
\rxs_directory(/local/domain/31/device/vkbd): ENOENT
\rxs_directory(/local/domain/31/device/vfb): ENOENT
\rxs_watch(/local/domain/0/device-model/30/logdirty/next-active, logdirty)
\rWatching /local/domain/0/device-model/30/logdirty/next-active
\rxs_watch(/local/domain/0/device-model/30/command, dm-command)
\rWatching /local/domain/0/device-model/30/command
\rxs_read(/local/domain/0/backend/pci/31/0/num_devs): EACCES
\r************************ NETFRONT for device/vif/1 **********


\rnet TX ring size 256
\rnet RX ring size 256
\rbackend at /local/domain/0/backend/vif/31/1
\rmac is 00:16:3e:2e:76:9d
\r**************************
\rtap_open(device/vif/1) -> 7
\ropen(/usr/share/xen/qemu/keymaps/pt-br, 0)-> 8
\ropen(/usr/share/xen/qemu/keymaps/common, 0)-> 9
\ropen(/usr/share/xen/qemu/keymaps/modifiers, 0)-> 10
\rclose(10)
\rclose(9)
\rclose(8)
\rsocket -> 8
\rcan't store dev null name for domid 30 in /monitor from a stub domain
\rcan't store dev vc name for domid 30 in /parallel/0 from a stub domain
\rqemu_map_cache_init nr_buckets = 10000 size 3145728
\rshared page at pfn 1fffe
\rxc_map_foreign_range(1fffe, 4096)
\rbuffered io page at pfn 1fffc
\rxc_map_foreign_range(1fffc, 4096)
\rTime offset set 0
\revtchn_open() -> 9
\rxc_evtchn_bind_interdomain(30, 4) = 0
\r******************* PCIFRONT for device/pci/0 **********


\rFailed to read device/pci/0/backend-id.
\rno backend
\rpcilib: minios_init open failed
\rRegister xen platform.
\rDone register platform.
\rxs_read_watch() -> /local/domain/0/device-model/30/command dm-command
\rxs_read(/local/domain/0/device-model/30/command): ENOENT
\rxs_read_watch() -> /local/domain/0/device-model/30/logdirty/next-active logdirty
\rxs_read(/local/domain/0/device-model/30/logdirty/key): ENOENT
\rxs_read_watch() -> /local/domain/0/backend/vbd/31/5632/params hdc
\rFailed allocation for dom 30: 2048 extents of order 0
\rFailed to populate physmap
\rFailed set_mm_mapping
\rNULL vram_pointer
\r

[-- Attachment #3: hvmtest --]
[-- Type: application/octet-stream, Size: 12192 bytes --]

#  -*- mode: python; -*-
#============================================================================
# Python configuration setup for 'xm create'.
# This script sets the parameters used when a domain is created using 'xm create'.
# You use a separate script for each domain you want to create, or 
# you can set the parameters for the domain on the xm command line.
#============================================================================
#
# This is a version using a stubdomain for device model, see
# xmexample.hvm-dm and README.stubdom for more details
# The differences with xmexample.hvm are marked with "STUBDOM"

#----------------------------------------------------------------------------
# Kernel image file.
kernel = "/usr/lib/xen/boot/hvmloader"

# The domain build function. HVM domain uses 'hvm'.
builder='hvm'

# Initial memory allocation (in megabytes) for the new domain.
#
# WARNING: Creating a domain with insufficient memory may cause out of
#          memory errors. The domain needs enough memory to boot kernel
#          and modules. Allocating less than 32MBs is not recommended.
memory = 512

# Shadow pagetable memory for the domain, in MB.
# If not explicictly set, xend will pick an appropriate value.  
# Should be at least 2KB per MB of domain memory, plus a few MB per vcpu.
# shadow_memory = 8

# A name for your domain. All domains must have different names.
name = "hvmtest"

# 128-bit UUID for the domain.  The default behavior is to generate a new UUID
# on each call to 'xm create'.
#uuid = "06ed00fe-1162-4fc4-b5d8-11993ee4a8b9"

#-----------------------------------------------------------------------------
# The number of cpus guest platform has, default=1
#vcpus=1

# Enable/disable HVM guest PAE, default=1 (enabled)
#pae=1

# Enable/disable HVM guest ACPI, default=1 (enabled)
#acpi=1

# Enable/disable HVM APIC mode, default=1 (enabled)
# Note that this option is ignored if vcpus > 1
#apic=1

# List of which CPUS this domain is allowed to use, default Xen picks
#cpus = ""         # leave to Xen to pick
#cpus = "0"        # all vcpus run on CPU0
#cpus = "0-3,5,^1" # all vcpus run on cpus 0,2,3,5
#cpus = ["2", "3"] # VCPU0 runs on CPU2, VCPU1 runs on CPU3

# Optionally define mac and/or bridge for the network interfaces.
# Random MACs are assigned if not given.
#vif = [ 'type=ioemu, mac=00:16:3e:00:00:11, bridge=xenbr0, model=ne2k_pci' ]
# type=ioemu specify the NIC is an ioemu device not netfront
vif = [ 'type=ioemu, bridge=eth0' ]

#----------------------------------------------------------------------------
# Define the disk devices you want the domain to have access to, and
# what you want them accessible as.
# Each disk entry is of the form phy:UNAME,DEV,MODE
# where UNAME is the device, DEV is the device name the domain will see,
# and MODE is r for read-only, w for read-write.
#
# STUBDOM: do not put it here but in stubdom-ExampleHVMDomain

#disk = [ 'phy:hda1,hda1,r' ]
#disk = [ 'file:/var/images/min-el3-i386.img,hda,w', ',hdc:cdrom,r' ]

#----------------------------------------------------------------------------
# Configure the behaviour when a domain exits.  There are three 'reasons'
# for a domain to stop: poweroff, reboot, and crash.  For each of these you
# may specify:
#
#   "destroy",        meaning that the domain is cleaned up as normal;
#   "restart",        meaning that a new domain is started in place of the old
#                     one;
#   "preserve",       meaning that no clean-up is done until the domain is
#                     manually destroyed (using xm destroy, for example); or
#   "rename-restart", meaning that the old domain is not cleaned up, but is
#                     renamed and a new domain started in its place.
#
# In the event a domain stops due to a crash, you have the additional options:
#
#   "coredump-destroy", meaning dump the crashed domain's core and then destroy;
#   "coredump-restart', meaning dump the crashed domain's core and the restart.
#
# The default is
#
#   on_poweroff = 'destroy'
#   on_reboot   = 'restart'
#   on_crash    = 'restart'
#
# For backwards compatibility we also support the deprecated option restart
#
# restart = 'onreboot' means on_poweroff = 'destroy'
#                            on_reboot   = 'restart'
#                            on_crash    = 'destroy'
#
# restart = 'always'   means on_poweroff = 'restart'
#                            on_reboot   = 'restart'
#                            on_crash    = 'restart'
#
# restart = 'never'    means on_poweroff = 'destroy'
#                            on_reboot   = 'destroy'
#                            on_crash    = 'destroy'

#on_poweroff = 'destroy'
#on_reboot   = 'restart'
#on_crash    = 'restart'

#============================================================================

# Device Model to be used
#
# STUBDOM: this is a script that creates the stub domain running the device
# model
device_model = '/usr/lib/xen/bin/stubdom-dm'

#-----------------------------------------------------------------------------
# boot on floppy (a), hard disk (c), Network (n) or CD-ROM (d) 
# default: hard disk, cd-rom, floppy
#boot="cda"

#-----------------------------------------------------------------------------
#  write to temporary files instead of disk image files
#snapshot=1

#----------------------------------------------------------------------------
# enable SDL library for graphics, default = 0
# 
# STUBDOM: always disable since the stub domain doesn't have direct X access
sdl=0

#----------------------------------------------------------------------------
# enable OpenGL for texture rendering inside the SDL window, default = 1
# valid only if sdl is enabled.
# 
# STUBDOM: always disable for the same reason
opengl=0

#----------------------------------------------------------------------------
# enable VNC library for graphics, default = 1
vnc=1

#----------------------------------------------------------------------------
# address that should be listened on for the VNC server if vnc is set.
# default is to use 'vnc-listen' setting from /etc/xen/xend-config.sxp
#vnclisten="127.0.0.1"
vnclisten="172.30.206.1"
#----------------------------------------------------------------------------
# set VNC display number, default = domid
#vncdisplay=1

#----------------------------------------------------------------------------
# try to find an unused port for the VNC server, default = 1
#vncunused=1

#----------------------------------------------------------------------------
# enable spawning vncviewer for domain's console
# (only valid when vnc=1), default = 0
#vncconsole=0

#----------------------------------------------------------------------------
# set password for domain's VNC console
# default is depents on vncpasswd in xend-config.sxp
vncpasswd='123456'

#----------------------------------------------------------------------------
# no graphics, use serial port
#nographic=0

#----------------------------------------------------------------------------
# enable stdvga, default = 0 (use cirrus logic device model)
stdvga=0

#-----------------------------------------------------------------------------
#   serial port re-direct to pty deivce, /dev/pts/n 
#   then xm console or minicom can connect
# 
# STUBDOM: always disable as the stub domain doesn't have access to dom0's
# ptys
#serial='pty'


#-----------------------------------------------------------------------------
#   Qemu Monitor, default is disable
#   Use ctrl-alt-2 to connect
#monitor=1


#-----------------------------------------------------------------------------
#   enable sound card support, [sb16|es1370|all|..,..], default none
# 
# STUBDOM: not supported
#soundhw='sb16'


#-----------------------------------------------------------------------------
#    set the real time clock to local time [default=0 i.e. set to utc]
#localtime=1


#-----------------------------------------------------------------------------
#    set the real time clock offset in seconds [default=0 i.e. same as dom0]
#rtc_timeoffset=3600

#-----------------------------------------------------------------------------
#    start in full screen
#full-screen=1   


#-----------------------------------------------------------------------------
#   Enable USB support (specific devices specified at runtime through the
#			monitor window)
#usb=1

#   Enable USB mouse support (only enable one of the following, `mouse' for
#			      PS/2 protocol relative mouse, `tablet' for
#			      absolute mouse)
#usbdevice='mouse'
#usbdevice='tablet'

#-----------------------------------------------------------------------------
#   Set keyboard layout, default is en-us keyboard. 
keymap='pt-br'

#-----------------------------------------------------------------------------
#   Configure guest CPUID responses:
#
#cpuid=[ '1:ecx=xxxxxxxxxxx00xxxxxxxxxxxxxxxxxxx,
#           eax=xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx' ]
# - Unset the SSE4 features (CPUID.1[ECX][20-19])
# - Default behaviour for all other bits in ECX And EAX registers.
# 
# Each successive character represent a lesser-significant bit:
#  '1' -> force the corresponding bit to 1
#  '0' -> force to 0
#  'x' -> Get a safe value (pass through and mask with the default policy)
#  'k' -> pass through the host bit value
#  's' -> as 'k' but preserve across save/restore and migration
# 
#   Expose to the guest multi-core cpu instead of multiple processors
# Example for intel, expose a 8-core processor :
#cpuid=['1:edx=xxx1xxxxxxxxxxxxxxxxxxxxxxxxxxxx,
#          ebx=xxxxxxxx00010000xxxxxxxxxxxxxxxx',
#     '4,0:eax=001111xxxxxxxxxxxxxxxxxxxxxxxxxx']
#  - CPUID.1[EDX][HT] : Enable HT
#  - CPUID.1[EBX] : Number of vcpus * 2
#  - CPUID.4,0[EAX] : Number of vcpus * 2 - 1
#vcpus=8
#
# Example for amd, expose a 5-core processor :
# cpuid = ['1:ebx=xxxxxxxx00001010xxxxxxxxxxxxxxxx,
#             edx=xxx1xxxxxxxxxxxxxxxxxxxxxxxxxxxx',
# '0x80000001:ecx=xxxxxxxxxxxxxxxxxxxxxxxxxxxxxx1x',
# '0x80000008:ecx=xxxxxxxxxxxxxxxxxxxxxxxxxx001001']
#   - CPUID.1[EBX] : Threads per Core * Cores per Socket (2 * #vcpus)
#   - CPUID.1[EDX][HT] : Enable HT
#   - CPUID.0x80000001[CmpLegacy] : Use legacy method
#   - CPUID.0x80000008[ECX] : #vcpus * 2 - 1
#vcpus=5
#
#  Downgrade the cpuid to make a better compatibility for migration :
# Look like a generic 686 :
# cpuid = [ '0:eax=0x3,ebx=0x0,ecx=0x0,edx=0x0',
#           '1:eax=0x06b1,
#              ecx=xxxxxxxxxx0000xx00xxx0000000xx0,
#              edx=xx00000xxxxxxx0xxxxxxxxx0xxxxxx',
#           '4:eax=0x3,ebx=0x0,ecx=0x0,edx=0x0',
#  '0x80000000:eax=0x3,ebx=0x0,ecx=0x0,edx=0x0']
#  with the highest leaf
#  - CPUID.0[EAX] : Set the highest leaf
#  - CPUID.1[EAX] : 686 
#  - CPUID.1[ECX] : Mask some features
#  - CPUID.1[EDX] : Mask some features
#  - CPUID.4 : Reply like the highest leaf, in our case CPUID.3
#  - CPUID.0x80000000 : No extension we are on a Pentium III, reply like the
#  highest leaf (CPUID.3).
#
#   Configure host CPUID consistency checks, which must be satisfied for this
#   VM to be allowed to run on this host's processor type:
#cpuid_check=[ '1:ecx=xxxxxxxxxxxxxxxxxxxxxxxxxx1xxxxx' ]
# - Host must have VMX feature flag set
#
# The format is similar to the above for 'cpuid':
#  '1' -> the bit must be '1'
#  '0' -> the bit must be '0'
#  'x' -> we don't care (do not check)
#  's' -> the bit must be the same as on the host that started this VM


#-----------------------------------------------------------------------------
#   Configure PVSCSI devices:
#
#vscsi=[ 'PDEV, VDEV' ]
#
#   PDEV   gives physical SCSI device to be attached to specified guest
#          domain by one of the following identifier format.
#          - XX:XX:XX:XX (4-tuples with decimal notation which shows
#                          "host:channel:target:lun")
#          - /dev/sdxx or sdx
#          - /dev/stxx or stx
#          - /dev/sgxx or sgx
#          - result of 'scsi_id -gu -s'.
#            ex. # scsi_id -gu -s /block/sdb
#                  36000b5d0006a0000006a0257004c0000
#
#   VDEV   gives virtual SCSI device by 4-tuples (XX:XX:XX:XX) as 
#          which the specified guest domain recognize.
#

#vscsi = [ '/dev/sdx, 0:0:0:0' ]

[-- Attachment #4: hvmtest-dm --]
[-- Type: application/octet-stream, Size: 223 bytes --]

kernel = "/usr/lib/xen/boot/ioemu-stubdom.gz"
vif = [ 'ip=172.30.206.1', 'bridge=eth0' ]
disk = [  'file:/home/iso/debian-LennyBeta2-amd64-CD-1.iso,hdc:cdrom,r', 'phy:/dev/empirevg/lenny.hvm,hda,w' ]
#vfb = [ 'type=vnc' ]


[-- Attachment #5: Type: text/plain, Size: 138 bytes --]

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

Re: stubdom problem

[Samuel Thibault]

Marco Sinhoreli, le Fri 29 Aug 2008 12:49:13 -0300, a écrit :
> 
Failed allocation for dom 30: 2048 extents of order 0
> 
Failed to populate physmap
> 
Failed set_mm_mapping
> 
NULL vram_pointer

See the first paragraph of the General Configuration section: there is a
ballooning race condition which was discovered too late to get fixed in
3.3, so you need to restrict dom0's memory usage thanks to the dom0_mem
option.

Samuel

Re: stubdom problem

[Marco Sinhoreli]

[-- Attachment #1: Type: text/plain, Size: 2572 bytes --]

Hello Samuel,

I haven't seen the restrict memory to dom0, sorry! I set it in
menu.lst but I have now another issue decribbed as follows:


******************* BLKFRONT for /local/domain/2/device/vbd/5632 **********


backend at /local/domain/0/backend/vbd/2/5632
Failed to read /local/domain/0/backend/vbd/2/5632/feature-flush-cache.
1299724 sectors of 512 bytes
**************************
blk_open(/local/domain/2/device/vbd/5632) -> 5
xs_read(/local/domain/2/device/vbd/768/phantom_vbd): ENOENT
******************* BLKFRONT for /local/domain/2/device/vbd/768 **********


backend at /local/domain/0/backend/vbd/2/768
Failed to read /local/domain/0/backend/vbd/2/768/feature-flush-cache.
20971520 sectors of 512 bytes
**************************
blk_open(/local/domain/2/device/vbd/768) -> 6
xs_directory(/local/domain/2/device/vkbd): ENOENT
xs_directory(/local/domain/2/device/vfb): ENOENT
xs_watch(/local/domain/0/device-model/1/logdirty/next-active, logdirty)
Watching /local/domain/0/device-model/1/logdirty/next-active
xs_watch(/local/domain/0/device-model/1/command, dm-command)
Watching /local/domain/0/device-model/1/command
xs_read(/local/domain/0/backend/pci/2/0/num_devs): EACCES
************************ NETFRONT for device/vif/1 **********

net TX ring size 256
net RX ring size 256
backend at /local/domain/0/backend/vif/2/1
mac is 00:16:3e:39:c7:b4
**************************
tap_open(device/vif/1) -> 7
open(/usr/share/xen/qemu/keymaps/pt-br, 0)-> 8
open(/usr/share/xen/qemu/keymaps/common, 0)-> 9
open(/usr/share/xen/qemu/keymaps/modifiers, 0)-> 10
close(10)
close(9)
close(8)
sxs_read_watch() -> /local/domain/0/device-model/1/command dm-command
xs_read(/local/domain/0/device-model/1/command): ENOENT
xs_read_watch() -> /local/domain/0/device-model/1/logdirty/next-active logdirty
xs_read(/local/domain/0/device-model/1/logdirty/key): ENOENT
xs_read_watch() -> /local/domain/0/backend/vbd/2/5632/params hdc



I commented only "vfb = [ 'type=vnc' ]" in hvmtest-dm file.


Best regards,

-- 
Marco Sinhoreli



On Fri, Aug 29, 2008 at 12:56 PM, Samuel Thibault
<samuel.thibault@ens-lyon.org> wrote:
> Marco Sinhoreli, le Fri 29 Aug 2008 12:49:13 -0300, a écrit :
>>
> Failed allocation for dom 30: 2048 extents of order 0
>>
> Failed to populate physmap
>>
> Failed set_mm_mapping
>>
> NULL vram_pointer
>
> See the first paragraph of the General Configuration section: there is a
> ballooning race condition which was discovered too late to get fixed in
> 3.3, so you need to restrict dom0's memory usage thanks to the dom0_mem
> option.
>
> Samuel
>

[-- Attachment #2: Type: text/plain, Size: 138 bytes --]

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

Re: stubdom problem

[Samuel Thibault]

Marco Sinhoreli, le Fri 29 Aug 2008 13:35:38 -0300, a écrit :
> Failed to read /local/domain/0/backend/vbd/2/5632/feature-flush-cache.

(That's benign)

> xs_directory(/local/domain/2/device/vkbd): ENOENT
> xs_directory(/local/domain/2/device/vfb): ENOENT

Not a problem either, since your configuration makes ioemu use a VNC
server.

> xs_read(/local/domain/0/backend/pci/2/0/num_devs): EACCES

Not a problem since you are not passing through anything.

> sxs_read_watch() -> /local/domain/0/device-model/1/command dm-command
> xs_read(/local/domain/0/device-model/1/command): ENOENT
> xs_read_watch() -> /local/domain/0/device-model/1/logdirty/next-active logdirty
> xs_read(/local/domain/0/device-model/1/logdirty/key): ENOENT

These are fine as well.

So, what's the problem? :)
Does the hvmtest-dm domain die?  Is the guest running?  Is your network
configuration OK to access the VNC server? (it may be easier to just
start by disabling VNC and use a mere PVFB).

Samuel

Re: stubdom problem

[Marco Sinhoreli]

Hi Samuel,

> So, what's the problem? :)
> Does the hvmtest-dm domain die?  Is the guest running?  Is your network
> configuration OK to access the VNC server? (it may be easier to just
> start by disabling VNC and use a mere PVFB).

The domains was started and the vnc port was opened, but after few
seconds, the domains died.  Follows the final of log file.

******************* KBDFRONT for /local/domain/30/device/vkbd/0 **********


Time offset set 0
evtchn_open() -> 8
xc_evtchn_bind_interdomain(29, 4) = 0
******************* PCIFRONT for device/pci/0 **********


Failed to read device/pci/0/backend-id.
no backend
pcilib: minios_init open failed
Register xen platform.
Done register platform.
xs_read_watch() -> /local/domain/0/device-model/29/command dm-command
xs_read(/local/domain/0/device-model/29/command): ENOENT
xs_read_watch() -> /local/domain/0/device-model/29/logdirty/next-active logdirty
xs_read(/local/domain/0/device-model/29/logdirty/key): ENOENT
xs_read_watch() -> /local/domain/0/backend/vbd/30/5632/params hdc
backend at /local/domain/0/backend/vkbd/30/0
******************* FBFRONT for /local/domain/30/device/vfb/0 **********


backend at /local/domain/0/backend/vfb/30/0
/local/domain/0/backend/vfb/30/0 connected
/local/domain/0/backend/vkbd/30/0 connected
************************** FBFRONT
************************** KBDFRONT
Thread "kbdfront" exited.
kbd_open(/local/domain/30/device/vkbd/0) -> 9
fb_open(/local/domain/30/device/vfb/0) -> 10




-- 
Marco Sinhoreli

Re: stubdom problem

[Samuel Thibault]

Marco Sinhoreli, le Fri 29 Aug 2008 13:54:28 -0300, a écrit :
> > So, what's the problem? :)
> > Does the hvmtest-dm domain die?  Is the guest running?  Is your network
> > configuration OK to access the VNC server? (it may be easier to just
> > start by disabling VNC and use a mere PVFB).
> 
> The domains was started and the vnc port was opened, but after few
> seconds, the domains died.  Follows the final of log file.

Mmm, nothing strange here, could you check other log files, like in
xend.log to know which part actually stopped working at some point?

Samuel

Re: stubdom problem

[Marco Sinhoreli]

[-- Attachment #1: Type: text/plain, Size: 790 bytes --]

Hi Samuel,

Attached /var/log/xen/xend.log and /var/log/xen/qemu-dm-hvmtest.log.

Regards,

On Fri, Aug 29, 2008 at 2:02 PM, Samuel Thibault
<samuel.thibault@ens-lyon.org> wrote:
> Marco Sinhoreli, le Fri 29 Aug 2008 13:54:28 -0300, a écrit :
>> > So, what's the problem? :)
>> > Does the hvmtest-dm domain die?  Is the guest running?  Is your network
>> > configuration OK to access the VNC server? (it may be easier to just
>> > start by disabling VNC and use a mere PVFB).
>>
>> The domains was started and the vnc port was opened, but after few
>> seconds, the domains died.  Follows the final of log file.
>
> Mmm, nothing strange here, could you check other log files, like in
> xend.log to know which part actually stopped working at some point?
>
> Samuel
>



-- 
Marco Sinhoreli

[-- Warning: decoded text below may be mangled, UTF-8 assumed --]
[-- Attachment #2: xend.log --]
[-- Type: text/x-log; name=xend.log, Size: 20180 bytes --]

[2008-08-29 14:20:23 3620] WARNING (image:472) domain hvmtest: device model failure: no longer running; see /var/log/xen/qemu-dm-hvmtest.log 
[2008-08-29 14:20:24 3620] DEBUG (XendDomainInfo:89) XendDomainInfo.create(['vm', ['name', 'hvmtest'], ['memory', 512], ['vcpus', 1], ['on_xend_start', 'ignore'], ['on_xend_stop', 'ignore'], ['image', ['hvm', ['kernel', '/usr/lib/xen/boot/hvmloader'], ['device_model', '/usr/lib/xen/bin/stubdom-dm'], ['pae', 1], ['vcpus', 1], ['boot', 'c'], ['fda', ''], ['fdb', ''], ['timer_mode', 0], ['localtime', 0], ['serial', ''], ['stdvga', 0], ['isa', 0], ['nographic', 0], ['soundhw', ''], ['vnc', 1], ['vncunused', 1], ['vnclisten', '172.30.206.1'], ['sdl', 0], ['display', ':0.0'], ['xauthority', '/home/msinhore/.Xauthority'], ['rtc_timeoffset', '0'], ['monitor', 0], ['acpi', 1], ['apic', 1], ['usb', 0], ['usbdevice', ''], ['keymap', 'pt-br'], ['pci', []], ['hpet', 0], ['guest_os_type', 'default'], ['hap', 1], ['opengl', 0], ['cpuid', []], ['cpuid_check', []], ['vncpasswd', 'XXXXXXXX']]], ['device', ['vif', ['bridge', 'eth0'], ['type', 'ioemu']]]])
[2008-08-29 14:20:24 3620] DEBUG (XendDomainInfo:2028) XendDomainInfo.constructDomain
[2008-08-29 14:20:24 3620] DEBUG (balloon:132) Balloon: 3061580 KiB free; need 2048; done.
[2008-08-29 14:20:24 3620] DEBUG (XendDomain:447) Adding Domain: 33
[2008-08-29 14:20:24 3620] DEBUG (XendDomainInfo:2134) XendDomainInfo.initDomain: 33 256
[2008-08-29 14:20:24 3620] DEBUG (image:302) No VNC passwd configured for vfb access
[2008-08-29 14:20:24 3620] DEBUG (image:743) args: boot, val: c
[2008-08-29 14:20:24 3620] DEBUG (image:743) args: fda, val: None
[2008-08-29 14:20:24 3620] DEBUG (image:743) args: fdb, val: None
[2008-08-29 14:20:24 3620] DEBUG (image:743) args: soundhw, val: None
[2008-08-29 14:20:24 3620] DEBUG (image:743) args: localtime, val: 0
[2008-08-29 14:20:24 3620] DEBUG (image:743) args: serial, val: None
[2008-08-29 14:20:24 3620] DEBUG (image:743) args: std-vga, val: 0
[2008-08-29 14:20:24 3620] DEBUG (image:743) args: isa, val: 0
[2008-08-29 14:20:24 3620] DEBUG (image:743) args: acpi, val: 1
[2008-08-29 14:20:24 3620] DEBUG (image:743) args: usb, val: 0
[2008-08-29 14:20:24 3620] DEBUG (image:743) args: usbdevice, val: None
[2008-08-29 14:20:24 3620] DEBUG (XendDomainInfo:2215) _initDomain:shadow_memory=0x0, memory_static_max=0x20000000, memory_static_min=0x0.
[2008-08-29 14:20:24 3620] DEBUG (balloon:132) Balloon: 3060288 KiB free; need 539648; done.
[2008-08-29 14:20:24 3620] INFO (image:166) buildDomain os=hvm dom=33 vcpus=1
[2008-08-29 14:20:24 3620] DEBUG (image:795) domid          = 33
[2008-08-29 14:20:24 3620] DEBUG (image:796) image          = /usr/lib/xen/boot/hvmloader
[2008-08-29 14:20:24 3620] DEBUG (image:797) store_evtchn   = 2
[2008-08-29 14:20:24 3620] DEBUG (image:798) memsize        = 512
[2008-08-29 14:20:24 3620] DEBUG (image:799) vcpus          = 1
[2008-08-29 14:20:24 3620] DEBUG (image:800) acpi           = 1
[2008-08-29 14:20:24 3620] DEBUG (image:801) apic           = 1
[2008-08-29 14:20:24 3620] INFO (XendDomainInfo:1900) createDevice: vfb : {'vncunused': 1, 'vnclisten': '172.30.206.1', 'type': 'vnc', 'uuid': 'b49008c6-4428-f1bd-f665-5993d7febee3', 'other_config': {'vncunused': 1, 'vnclisten': '172.30.206.1', 'type': 'vnc'}}
[2008-08-29 14:20:24 3620] DEBUG (DevController:122) DevController: writing {'state': '1', 'backend-id': '0', 'backend': '/local/domain/0/backend/vfb/33/0'} to /local/domain/33/device/vfb/0.
[2008-08-29 14:20:24 3620] DEBUG (DevController:124) DevController: writing {'vncunused': '1', 'domain': 'hvmtest', 'frontend': '/local/domain/33/device/vfb/0', 'uuid': 'b49008c6-4428-f1bd-f665-5993d7febee3', 'vnclisten': '172.30.206.1', 'state': '1', 'online': '1', 'frontend-id': '33', 'type': 'vnc'} to /local/domain/0/backend/vfb/33/0.
[2008-08-29 14:20:24 3620] INFO (XendDomainInfo:1900) createDevice: vif : {'bridge': 'eth0', 'mac': '00:16:3e:2f:5b:39', 'type': 'ioemu', 'uuid': '6fb8c49a-66dd-2615-7981-a29f80e79d23'}
[2008-08-29 14:20:24 3620] DEBUG (DevController:122) DevController: writing {'state': '1', 'backend-id': '0', 'backend': '/local/domain/0/backend/vif/33/0'} to /local/domain/33/device/vif/0.
[2008-08-29 14:20:24 3620] DEBUG (DevController:124) DevController: writing {'bridge': 'eth0', 'domain': 'hvmtest', 'handle': '0', 'uuid': '6fb8c49a-66dd-2615-7981-a29f80e79d23', 'script': '/etc/xen/scripts/vif-bridge', 'mac': '00:16:3e:2f:5b:39', 'frontend-id': '33', 'state': '1', 'online': '1', 'frontend': '/local/domain/33/device/vif/0', 'type': 'ioemu'} to /local/domain/0/backend/vif/33/0.
[2008-08-29 14:20:25 3620] INFO (image:375) spawning device models: /usr/lib/xen/bin/stubdom-dm ['/usr/lib/xen/bin/stubdom-dm', '-d', '33', '-domain-name', 'hvmtest', '-k', 'pt-br', '-vnc', '172.30.206.1:0', '-vncunused', '-vcpus', '1', '-boot', 'c', '-acpi', '-net', 'nic,vlan=1,macaddr=00:16:3e:2f:5b:39,model=rtl8139', '-net', 'tap,vlan=1,ifname=tap33.0,bridge=eth0', '-M', 'xenfv']
[2008-08-29 14:20:25 3620] INFO (image:422) device model pid: 15275
[2008-08-29 14:20:25 3620] INFO (image:511) waiting for sentinel_fifo
[2008-08-29 14:20:25 3620] DEBUG (XendDomainInfo:2729) Storing VM details: {'on_xend_stop': 'ignore', 'shadow_memory': '5', 'uuid': 'db0674b6-bf03-18f9-d01b-40635969be1c', 'on_reboot': 'restart', 'start_time': '1220030425.05', 'on_poweroff': 'destroy', 'on_xend_start': 'ignore', 'on_crash': 'restart', 'xend/restart_count': '0', 'vcpus': '1', 'vcpu_avail': '1', 'image': '(hvm (kernel ) (hpet 0) (stdvga 0) (vnclisten 172.30.206.1) (loader /usr/lib/xen/boot/hvmloader) (vncunused 1) (opengl 0) (boot c) (rtc_timeoffset 0) (pci ()) (pae 1) (hap 1) (acpi 1) (localtime 0) (timer_mode 0) (vnc 1) (nographic 0) (guest_os_type default) (apic 1) (sdl 0) (monitor 0) (device_model /usr/lib/xen/bin/stubdom-dm) (keymap pt-br) (usb 0) (xauthority /home/msinhore/.Xauthority) (isa 0) (display :0.0) (notes (SUSPEND_CANCEL 1)))', 'name': 'hvmtest'}
[2008-08-29 14:20:25 3620] DEBUG (XendDomainInfo:1359) Storing domain details: {'console/port': '3', 'name': 'hvmtest', 'console/limit': '1048576', 'store/port': '2', 'vm': '/vm/db0674b6-bf03-18f9-d01b-40635969be1c', 'domid': '33', 'image/suspend-cancel': '1', 'cpu/0/availability': 'online', 'memory/target': '524288', 'control/platform-feature-multiprocessor-suspend': '1', 'store/ring-ref': '131069', 'console/type': 'ioemu'}
[2008-08-29 14:20:25 3620] DEBUG (DevController:122) DevController: writing {'state': '1', 'backend-id': '0', 'backend': '/local/domain/0/backend/console/33/0'} to /local/domain/33/device/console/0.
[2008-08-29 14:20:25 3620] DEBUG (DevController:124) DevController: writing {'domain': 'hvmtest', 'frontend': '/local/domain/33/device/console/0', 'uuid': '9f1a7909-8c49-e758-80eb-2a737fb830d8', 'frontend-id': '33', 'state': '1', 'location': '3', 'online': '1', 'protocol': 'vt100'} to /local/domain/0/backend/console/33/0.
[2008-08-29 14:20:25 3620] DEBUG (XendDomainInfo:1443) XendDomainInfo.handleShutdownWatch
[2008-08-29 14:20:25 3620] DEBUG (DevController:155) Waiting for devices vif.
[2008-08-29 14:20:25 3620] DEBUG (DevController:160) Waiting for 0.
[2008-08-29 14:20:25 3620] DEBUG (DevController:645) hotplugStatusCallback /local/domain/0/backend/vif/33/0/hotplug-status.
[2008-08-29 14:20:25 3620] DEBUG (DevController:645) hotplugStatusCallback /local/domain/0/backend/vif/33/0/hotplug-status.
[2008-08-29 14:20:25 3620] DEBUG (DevController:659) hotplugStatusCallback 1.
[2008-08-29 14:20:25 3620] DEBUG (DevController:155) Waiting for devices vscsi.
[2008-08-29 14:20:25 3620] DEBUG (DevController:155) Waiting for devices vbd.
[2008-08-29 14:20:25 3620] DEBUG (DevController:155) Waiting for devices irq.
[2008-08-29 14:20:25 3620] DEBUG (DevController:155) Waiting for devices vkbd.
[2008-08-29 14:20:25 3620] DEBUG (DevController:155) Waiting for devices vfb.
[2008-08-29 14:20:25 3620] DEBUG (DevController:155) Waiting for devices console.
[2008-08-29 14:20:25 3620] DEBUG (DevController:160) Waiting for 0.
[2008-08-29 14:20:25 3620] DEBUG (DevController:155) Waiting for devices pci.
[2008-08-29 14:20:25 3620] DEBUG (DevController:155) Waiting for devices ioports.
[2008-08-29 14:20:25 3620] DEBUG (DevController:155) Waiting for devices tap.
[2008-08-29 14:20:25 3620] DEBUG (DevController:155) Waiting for devices vtpm.
[2008-08-29 14:20:25 3620] DEBUG (XendDomainInfo:89) XendDomainInfo.create(['vm', ['name', 'hvmtest-dm'], ['memory', 32], ['vcpus', 1], ['on_xend_start', 'ignore'], ['on_xend_stop', 'ignore'], ['target', 33], ['image', ['linux', ['kernel', '/usr/lib/xen/boot/ioemu-stubdom.gz'], ['args', ' -d 33']]], ['device', ['vbd', ['uname', 'phy:/dev/empirevg/lenny.hvm'], ['dev', 'hda'], ['mode', 'w']]], ['device', ['vbd', ['uname', 'file:/home/iso/debian-LennyBeta2-amd64-CD-1.iso'], ['dev', 'hdc:cdrom'], ['mode', 'r']]], ['device', ['vif', ['ip', '172.30.206.1']]], ['device', ['vif', ['bridge', 'eth0']]]])
[2008-08-29 14:20:25 3620] DEBUG (XendDomainInfo:2028) XendDomainInfo.constructDomain
[2008-08-29 14:20:25 3620] DEBUG (balloon:132) Balloon: 2532004 KiB free; need 2048; done.
[2008-08-29 14:20:25 3620] DEBUG (XendDomain:447) Adding Domain: 34
[2008-08-29 14:20:25 3620] DEBUG (XendDomainInfo:2134) XendDomainInfo.initDomain: 34 256
[2008-08-29 14:20:25 3620] DEBUG (XendDomainInfo:2215) _initDomain:shadow_memory=0x0, memory_static_max=0x2000000, memory_static_min=0x0.
[2008-08-29 14:20:25 3620] DEBUG (balloon:132) Balloon: 2531996 KiB free; need 33792; done.
[2008-08-29 14:20:25 3620] INFO (image:166) buildDomain os=linux dom=34 vcpus=1
[2008-08-29 14:20:25 3620] DEBUG (image:631) domid          = 34
[2008-08-29 14:20:25 3620] DEBUG (image:632) memsize        = 32
[2008-08-29 14:20:25 3620] DEBUG (image:633) image          = /usr/lib/xen/boot/ioemu-stubdom.gz
[2008-08-29 14:20:25 3620] DEBUG (image:634) store_evtchn   = 1
[2008-08-29 14:20:25 3620] DEBUG (image:635) console_evtchn = 2
[2008-08-29 14:20:25 3620] DEBUG (image:636) cmdline        =  -d 33
[2008-08-29 14:20:26 3620] DEBUG (image:637) ramdisk        = 
[2008-08-29 14:20:26 3620] DEBUG (image:638) vcpus          = 1
[2008-08-29 14:20:26 3620] DEBUG (image:639) features       = 
[2008-08-29 14:20:26 3620] INFO (XendDomainInfo:1900) createDevice: vbd : {'uuid': 'e17341d6-e046-069e-78ea-3f280fca4163', 'bootable': 1, 'driver': 'paravirtualised', 'dev': 'hda', 'uname': 'phy:/dev/empirevg/lenny.hvm', 'mode': 'w'}
[2008-08-29 14:20:26 3620] DEBUG (DevController:122) DevController: writing {'virtual-device': '768', 'device-type': 'disk', 'protocol': 'x86_64-abi', 'backend-id': '0', 'state': '1', 'backend': '/local/domain/0/backend/vbd/34/768'} to /local/domain/34/device/vbd/768.
[2008-08-29 14:20:26 3620] DEBUG (DevController:124) DevController: writing {'domain': 'hvmtest-dm', 'frontend': '/local/domain/34/device/vbd/768', 'uuid': 'e17341d6-e046-069e-78ea-3f280fca4163', 'dev': 'hda', 'state': '1', 'params': '/dev/empirevg/lenny.hvm', 'mode': 'w', 'online': '1', 'frontend-id': '34', 'type': 'phy'} to /local/domain/0/backend/vbd/34/768.
[2008-08-29 14:20:26 3620] INFO (XendDomainInfo:1900) createDevice: vbd : {'uuid': 'da54556d-4693-0214-fb06-67f39c6e76eb', 'bootable': 0, 'driver': 'paravirtualised', 'dev': 'hdc:cdrom', 'uname': 'file:/home/iso/debian-LennyBeta2-amd64-CD-1.iso', 'mode': 'r'}
[2008-08-29 14:20:26 3620] DEBUG (DevController:122) DevController: writing {'virtual-device': '5632', 'device-type': 'cdrom', 'protocol': 'x86_64-abi', 'backend-id': '0', 'state': '1', 'backend': '/local/domain/0/backend/vbd/34/5632'} to /local/domain/34/device/vbd/5632.
[2008-08-29 14:20:26 3620] DEBUG (DevController:124) DevController: writing {'domain': 'hvmtest-dm', 'frontend': '/local/domain/34/device/vbd/5632', 'uuid': 'da54556d-4693-0214-fb06-67f39c6e76eb', 'dev': 'hdc', 'state': '1', 'params': '/home/iso/debian-LennyBeta2-amd64-CD-1.iso', 'mode': 'r', 'online': '1', 'frontend-id': '34', 'type': 'file'} to /local/domain/0/backend/vbd/34/5632.
[2008-08-29 14:20:26 3620] INFO (XendDomainInfo:1900) createDevice: vif : {'ip': '172.30.206.1', 'mac': '00:16:3e:65:93:01', 'uuid': '32004f06-a6d2-86a7-fe1d-17fc3bd00b37'}
[2008-08-29 14:20:26 3620] DEBUG (DevController:122) DevController: writing {'mac': '00:16:3e:65:93:01', 'handle': '0', 'protocol': 'x86_64-abi', 'backend-id': '0', 'state': '1', 'backend': '/local/domain/0/backend/vif/34/0'} to /local/domain/34/device/vif/0.
[2008-08-29 14:20:26 3620] DEBUG (DevController:124) DevController: writing {'domain': 'hvmtest-dm', 'handle': '0', 'uuid': '32004f06-a6d2-86a7-fe1d-17fc3bd00b37', 'script': '/etc/xen/scripts/vif-bridge', 'ip': '172.30.206.1', 'mac': '00:16:3e:65:93:01', 'frontend-id': '34', 'state': '1', 'online': '1', 'frontend': '/local/domain/34/device/vif/0'} to /local/domain/0/backend/vif/34/0.
[2008-08-29 14:20:26 3620] INFO (XendDomainInfo:1900) createDevice: vif : {'bridge': 'eth0', 'mac': '00:16:3e:37:f3:c3', 'uuid': 'e295b168-8bd0-3e36-48dc-da2fa0c411e9'}
[2008-08-29 14:20:26 3620] DEBUG (DevController:122) DevController: writing {'mac': '00:16:3e:37:f3:c3', 'handle': '1', 'protocol': 'x86_64-abi', 'backend-id': '0', 'state': '1', 'backend': '/local/domain/0/backend/vif/34/1'} to /local/domain/34/device/vif/1.
[2008-08-29 14:20:26 3620] DEBUG (DevController:124) DevController: writing {'bridge': 'eth0', 'domain': 'hvmtest-dm', 'handle': '1', 'uuid': 'e295b168-8bd0-3e36-48dc-da2fa0c411e9', 'script': '/etc/xen/scripts/vif-bridge', 'mac': '00:16:3e:37:f3:c3', 'frontend-id': '34', 'state': '1', 'online': '1', 'frontend': '/local/domain/34/device/vif/1'} to /local/domain/0/backend/vif/34/1.
[2008-08-29 14:20:26 3620] DEBUG (XendDomainInfo:2729) Storing VM details: {'on_xend_stop': 'ignore', 'shadow_memory': '0', 'uuid': '9e3da2f9-b3d5-5299-cc8f-1cb4c2103bc5', 'on_reboot': 'restart', 'start_time': '1220030426.46', 'on_poweroff': 'destroy', 'on_xend_start': 'ignore', 'on_crash': 'restart', 'xend/restart_count': '0', 'vcpus': '1', 'vcpu_avail': '1', 'image': "(linux (kernel /usr/lib/xen/boot/ioemu-stubdom.gz) (args ' -d 33') (notes))", 'name': 'hvmtest-dm'}
[2008-08-29 14:20:26 3620] DEBUG (XendDomainInfo:1359) Storing domain details: {'console/ring-ref': '647583', 'console/port': '2', 'name': 'hvmtest-dm', 'console/limit': '1048576', 'vm': '/vm/9e3da2f9-b3d5-5299-cc8f-1cb4c2103bc5', 'domid': '34', 'store/port': '1', 'cpu/0/availability': 'online', 'memory/target': '32768', 'control/platform-feature-multiprocessor-suspend': '1', 'store/ring-ref': '781744', 'console/type': 'xenconsoled'}
[2008-08-29 14:20:26 3620] INFO (XendDomain:1172) Domain hvmtest (33) unpaused.
[2008-08-29 14:20:26 3620] DEBUG (DevController:122) DevController: writing {'protocol': 'x86_64-abi', 'state': '1', 'backend-id': '0', 'backend': '/local/domain/0/backend/console/34/0'} to /local/domain/34/device/console/0.
[2008-08-29 14:20:26 3620] DEBUG (DevController:124) DevController: writing {'domain': 'hvmtest-dm', 'frontend': '/local/domain/34/device/console/0', 'uuid': 'd4ad0ae8-3db4-1fcf-ec37-e73dbaedced6', 'frontend-id': '34', 'state': '1', 'location': '2', 'online': '1', 'protocol': 'vt100'} to /local/domain/0/backend/console/34/0.
[2008-08-29 14:20:26 3620] DEBUG (XendDomainInfo:1443) XendDomainInfo.handleShutdownWatch
[2008-08-29 14:20:26 3620] DEBUG (DevController:155) Waiting for devices vif.
[2008-08-29 14:20:26 3620] DEBUG (DevController:160) Waiting for 0.
[2008-08-29 14:20:26 3620] DEBUG (DevController:645) hotplugStatusCallback /local/domain/0/backend/vif/34/0/hotplug-status.
[2008-08-29 14:20:26 3620] DEBUG (DevController:645) hotplugStatusCallback /local/domain/0/backend/vif/34/0/hotplug-status.
[2008-08-29 14:20:26 3620] DEBUG (DevController:659) hotplugStatusCallback 1.
[2008-08-29 14:20:26 3620] DEBUG (DevController:160) Waiting for 1.
[2008-08-29 14:20:26 3620] DEBUG (DevController:645) hotplugStatusCallback /local/domain/0/backend/vif/34/1/hotplug-status.
[2008-08-29 14:20:26 3620] DEBUG (DevController:645) hotplugStatusCallback /local/domain/0/backend/vif/34/1/hotplug-status.
[2008-08-29 14:20:26 3620] DEBUG (DevController:659) hotplugStatusCallback 1.
[2008-08-29 14:20:26 3620] DEBUG (DevController:155) Waiting for devices vscsi.
[2008-08-29 14:20:26 3620] DEBUG (DevController:155) Waiting for devices vbd.
[2008-08-29 14:20:26 3620] DEBUG (DevController:160) Waiting for 768.
[2008-08-29 14:20:26 3620] DEBUG (DevController:645) hotplugStatusCallback /local/domain/0/backend/vbd/34/768/hotplug-status.
[2008-08-29 14:20:27 3620] DEBUG (DevController:645) hotplugStatusCallback /local/domain/0/backend/vbd/34/768/hotplug-status.
[2008-08-29 14:20:27 3620] DEBUG (DevController:659) hotplugStatusCallback 1.
[2008-08-29 14:20:27 3620] DEBUG (DevController:160) Waiting for 5632.
[2008-08-29 14:20:27 3620] DEBUG (DevController:645) hotplugStatusCallback /local/domain/0/backend/vbd/34/5632/hotplug-status.
[2008-08-29 14:20:27 3620] DEBUG (DevController:659) hotplugStatusCallback 1.
[2008-08-29 14:20:27 3620] DEBUG (DevController:155) Waiting for devices irq.
[2008-08-29 14:20:27 3620] DEBUG (DevController:155) Waiting for devices vkbd.
[2008-08-29 14:20:27 3620] DEBUG (DevController:155) Waiting for devices vfb.
[2008-08-29 14:20:27 3620] DEBUG (DevController:155) Waiting for devices console.
[2008-08-29 14:20:27 3620] DEBUG (DevController:160) Waiting for 0.
[2008-08-29 14:20:27 3620] DEBUG (DevController:155) Waiting for devices pci.
[2008-08-29 14:20:27 3620] DEBUG (DevController:155) Waiting for devices ioports.
[2008-08-29 14:20:27 3620] DEBUG (DevController:155) Waiting for devices tap.
[2008-08-29 14:20:27 3620] DEBUG (DevController:155) Waiting for devices vtpm.
[2008-08-29 14:20:27 3620] INFO (XendDomain:1172) Domain hvmtest-dm (34) unpaused.
[2008-08-29 14:20:29 3620] INFO (XendDomainInfo:1634) Domain has shutdown: name=hvmtest id=33 reason=poweroff.
[2008-08-29 14:20:29 3620] DEBUG (XendDomainInfo:2389) XendDomainInfo.destroy: domid=33
[2008-08-29 14:20:29 3620] DEBUG (XendDomainInfo:2406) XendDomainInfo.destroyDomain(33)
[2008-08-29 14:20:29 3620] DEBUG (XendDomainInfo:1939) Destroying device model
[2008-08-29 14:20:29 3620] DEBUG (XendDomainInfo:1946) Releasing devices
[2008-08-29 14:20:29 3620] DEBUG (XendDomainInfo:1952) Removing vif/0
[2008-08-29 14:20:29 3620] DEBUG (XendDomainInfo:888) XendDomainInfo.destroyDevice: deviceClass = vif, device = vif/0
[2008-08-29 14:20:29 3620] DEBUG (XendDomainInfo:1952) Removing vfb/0
[2008-08-29 14:20:29 3620] DEBUG (XendDomainInfo:888) XendDomainInfo.destroyDevice: deviceClass = vfb, device = vfb/0
[2008-08-29 14:20:29 3620] DEBUG (XendDomainInfo:1952) Removing console/0
[2008-08-29 14:20:29 3620] DEBUG (XendDomainInfo:888) XendDomainInfo.destroyDevice: deviceClass = console, device = console/0
[2008-08-29 14:20:29 3620] DEBUG (XendDomainInfo:2389) XendDomainInfo.destroy: domid=34
[2008-08-29 14:20:29 3620] DEBUG (XendDomainInfo:2406) XendDomainInfo.destroyDomain(34)
[2008-08-29 14:20:29 3620] DEBUG (XendDomainInfo:1939) Destroying device model
[2008-08-29 14:20:29 3620] DEBUG (XendDomainInfo:1946) Releasing devices
[2008-08-29 14:20:29 3620] DEBUG (XendDomainInfo:1952) Removing vif/0
[2008-08-29 14:20:29 3620] DEBUG (XendDomainInfo:888) XendDomainInfo.destroyDevice: deviceClass = vif, device = vif/0
[2008-08-29 14:20:29 3620] DEBUG (XendDomainInfo:1952) Removing vif/1
[2008-08-29 14:20:29 3620] DEBUG (XendDomainInfo:888) XendDomainInfo.destroyDevice: deviceClass = vif, device = vif/1
[2008-08-29 14:20:29 3620] DEBUG (XendDomainInfo:1952) Removing vbd/768
[2008-08-29 14:20:29 3620] DEBUG (XendDomainInfo:888) XendDomainInfo.destroyDevice: deviceClass = vbd, device = vbd/768
[2008-08-29 14:20:29 3620] DEBUG (XendDomainInfo:1952) Removing vbd/5632
[2008-08-29 14:20:29 3620] DEBUG (XendDomainInfo:888) XendDomainInfo.destroyDevice: deviceClass = vbd, device = vbd/5632
[2008-08-29 14:20:29 3620] DEBUG (XendDomainInfo:1952) Removing console/0
[2008-08-29 14:20:29 3620] DEBUG (XendDomainInfo:888) XendDomainInfo.destroyDevice: deviceClass = console, device = console/0
[2008-08-29 14:20:29 3620] DEBUG (XendDomainInfo:1944) No device model
[2008-08-29 14:20:30 3620] DEBUG (XendDomainInfo:1946) Releasing devices

[-- Warning: decoded text below may be mangled, UTF-8 assumed --]
[-- Attachment #3: qemu-dm-hvmtest.log --]
[-- Type: text/x-log; name=qemu-dm-hvmtest.log, Size: 4858 bytes --]

Using config file "/etc/xen/hvmtest-dm".
Started domain hvmtest-dm
Xen Minimal OS!
\rstart_info:   0x515000
\r  nr_pages:   8192  shared_inf: bf17e000
\r  pt_base:    0x518000  mod_start:  0x0
\r  mod_len:    0
\r  flags:      0x0
\r  cmd_line:    -d 33
\r  stack:      0x4c3ae0-0x4e3ae0
\rMM: Init
\r  _text:        0x0
\r  _etext:       0xd0d07
\r  _erodata:     0xf9000
\r  _edata:       0x124340
\r  stack start:  0x4c3ae0
\r  _end:         0x5043f0
\r  start_pfn:    522
\r  max_pfn:      2000
\rMapping memory range 0x800000 - 0x2000000
\rsetting 0x0-0xf9000 readonly
\rskipped 0x1000
\rMM: Initialise page allocator for 52e000(52e000)-2000000(2000000)
\rMM: done
\rDemand map pfns at 2001000-2002001000.
\rHeap resides at 2002002000-4002002000.
\rInitialising timer interface
\rInitialising console ... done.
\rgnttab_table mapped at 0x2001000.
\rInitialising scheduler
\rThread "Idle": pointer: 0x2002002010, stack: 0x550000
\rInitialising xenbus
\rThread "xenstore": pointer: 0x20020027c0, stack: 0x560000
\rDummy main: start_info=0x4e3be0
\rThread "main": pointer: 0x2002002f70, stack: 0x570000
\r[main] Waiting for network.
\r************************ NETFRONT for device/vif/0 **********


\rnet TX ring size 256
\rnet RX ring size 256
\rbackend at /local/domain/0/backend/vif/34/0
\rmac is 00:16:3e:65:93:01
\r**************************
\r[main] IP ac1ece01 netmask ffff0000 gateway 0.
\r[main] TCP/IP bringup begins.
\rThread "tcpip_thread": pointer: 0x2002005d20, stack: 0x680000
\r[tcpip_thread] TCP/IP bringup ends.
\r[main] Network is ready.
\rIniting FS fronend(s).
\rFS export [dom=0, id=0] found
\rInitialising FS fortend to backend dom 0
\rAllocating request array for import 0, nr_entries = 128.
\rOur own id is 34
\rBackend found at /local/domain/0/backend/vfs/16
\rBackend ready.
\rdom vm is at /vm/db0674b6-bf03-18f9-d01b-40635969be1c
\r"main" "-d" "33" "-domain-name" "hvmtest" "-k" "pt-br" "-vnc" "172.30.206.1:0" "-vncunused" "-vcpus" "1" "-boot" "c" "-acpi" "-net" "nic,vlan=1,macaddr=00:16:3e:2f:5b:39,model=rtl8139" "-net" "tap,vlan=1,ifname=tap33.0,bridge=eth0" 
\rdomid: 33
\rqemu: the number of cpus is 1
\rxs_daemon_open -> 4, 0x120288
\rxs_read(/local/domain/34/device/vbd/768/phantom_vbd): ENOENT
\r******************* BLKFRONT for /local/domain/34/device/vbd/768 **********


\rbackend at /local/domain/0/backend/vbd/34/768
\rFailed to read /local/domain/0/backend/vbd/34/768/feature-flush-cache.
\r20971520 sectors of 512 bytes
\r**************************
\rblk_open(/local/domain/34/device/vbd/768) -> 5
\rxs_read(/local/domain/34/device/vbd/5632/phantom_vbd): ENOENT
\rxs_watch(/local/domain/0/backend/vbd/34/5632/params, hdc)
\r******************* BLKFRONT for /local/domain/34/device/vbd/5632 **********


\rbackend at /local/domain/0/backend/vbd/34/5632
\rFailed to read /local/domain/0/backend/vbd/34/5632/feature-flush-cache.
\r1299724 sectors of 512 bytes
\r**************************
\rblk_open(/local/domain/34/device/vbd/5632) -> 6
\rxs_directory(/local/domain/34/device/vkbd): ENOENT
\rxs_directory(/local/domain/34/device/vfb): ENOENT
\rxs_watch(/local/domain/0/device-model/33/logdirty/next-active, logdirty)
\rWatching /local/domain/0/device-model/33/logdirty/next-active
\rxs_watch(/local/domain/0/device-model/33/command, dm-command)
\rWatching /local/domain/0/device-model/33/command
\rxs_read(/local/domain/0/backend/pci/34/0/num_devs): EACCES
\r************************ NETFRONT for device/vif/1 **********


\rnet TX ring size 256
\rnet RX ring size 256
\rbackend at /local/domain/0/backend/vif/34/1
\rmac is 00:16:3e:37:f3:c3
\r**************************
\rtap_open(device/vif/1) -> 7
\ropen(/usr/share/xen/qemu/keymaps/pt-br, 0)-> 8
\ropen(/usr/share/xen/qemu/keymaps/common, 0)-> 9
\ropen(/usr/share/xen/qemu/keymaps/modifiers, 0)-> 10
\rclose(10)
\rclose(9)
\rclose(8)
\rxs_read(/vm/db0674b6-bf03-18f9-d01b-40635969be1c/vncpasswd): EACCES
\rxs_read(): vncpasswd get error. /vm/db0674b6-bf03-18f9-d01b-40635969be1c/vncpasswd.
\rsocket -> 8
\rcan't store dev null name for domid 33 in /monitor from a stub domain
\rcan't store dev vc name for domid 33 in /parallel/0 from a stub domain
\rqemu_map_cache_init nr_buckets = 10000 size 3145728
\rshared page at pfn 1fffe
\rxc_map_foreign_range(1fffe, 4096)
\rbuffered io page at pfn 1fffc
\rxc_map_foreign_range(1fffc, 4096)
\rTime offset set 0
\revtchn_open() -> 9
\rxc_evtchn_bind_interdomain(33, 4) = 0
\r******************* PCIFRONT for device/pci/0 **********


\rFailed to read device/pci/0/backend-id.
\rno backend
\rpcilib: minios_init open failed
\rRegister xen platform.
\rDone register platform.
\rxs_read_watch() -> /local/domain/0/device-model/33/command dm-command
\rxs_read(/local/domain/0/device-model/33/command): ENOENT
\rxs_read_watch() -> /local/domain/0/device-model/33/logdirty/next-active logdirty
\rxs_read(/local/domain/0/device-model/33/logdirty/key): ENOENT
\rxs_read_watch() -> /local/domain/0/backend/vbd/34/5632/params hdc
\r

[-- Attachment #4: Type: text/plain, Size: 138 bytes --]

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

Re: stubdom problem

[Samuel Thibault]

Marco Sinhoreli, le Fri 29 Aug 2008 14:29:52 -0300, a écrit :
> [2008-08-29 14:20:29 3620] INFO (XendDomainInfo:1634) Domain has shutdown: name=hvmtest id=33 reason=poweroff.

Ok, so that's not the -dm domain which initiated the shutdown.  It'd
be probably useful to increase the hypervisor debug level to get the
hvmloader messages in xm dmesg.

Samuel

Re: stubdom problem

[Marco Sinhoreli]

[-- Attachment #1: Type: text/plain, Size: 978 bytes --]

Hello Samuel,

I increase the debug level of xend. There are two thinks that I looked
in xend.log:
1 - the stub domain was initialized, therefore have no problem with this domain.
2 - After unpause the domain-dm, it has shutdown but I don't understand why.
     [2008-09-01 15:06:17 15814] INFO (XendDomain:1172) Domain
hvmtest-dm (25) unpaused.
     [2008-09-01 15:06:19 15814] INFO (XendDomainInfo:1634) Domain has
shutdown: name=hvmtest id=24 reason=poweroff.

Attached the xend.log.

Regards,

On Sat, Aug 30, 2008 at 5:37 PM, Samuel Thibault
<samuel.thibault@ens-lyon.org> wrote:
> Marco Sinhoreli, le Fri 29 Aug 2008 14:29:52 -0300, a écrit :
>> [2008-08-29 14:20:29 3620] INFO (XendDomainInfo:1634) Domain has shutdown: name=hvmtest id=33 reason=poweroff.
>
> Ok, so that's not the -dm domain which initiated the shutdown.  It'd
> be probably useful to increase the hypervisor debug level to get the
> hvmloader messages in xm dmesg.
>
> Samuel
>



-- 
Marco Sinhoreli

[-- Warning: decoded text below may be mangled, UTF-8 assumed --]
[-- Attachment #2: xend.log --]
[-- Type: text/x-log; name=xend.log, Size: 21377 bytes --]

[2008-09-01 15:06:15 15814] DEBUG (XendDomainInfo:89) XendDomainInfo.create(['vm', ['name', 'hvmtest'], ['memory', 512], ['vcpus', 1], ['on_xend_start', 'ignore'], ['on_xend_stop', 'ignore'], ['image', ['hvm', ['kernel', '/usr/lib/xen/boot/hvmloader'], ['device_model', '/usr/lib/xen/bin/stubdom-dm'], ['pae', 1], ['vcpus', 1], ['boot', 'c'], ['fda', ''], ['fdb', ''], ['timer_mode', 0], ['localtime', 0], ['serial', ''], ['stdvga', 0], ['isa', 0], ['nographic', 0], ['soundhw', ''], ['vnc', 0], ['vncunused', 1], ['vnclisten', '172.30.206.1'], ['sdl', 0], ['xauthority', '/root/.Xauthority'], ['rtc_timeoffset', '0'], ['monitor', 0], ['acpi', 1], ['apic', 1], ['usb', 0], ['usbdevice', ''], ['keymap', ''], ['pci', []], ['hpet', 0], ['guest_os_type', 'default'], ['hap', 1], ['opengl', 0], ['cpuid', []], ['cpuid_check', []], ['vncpasswd', 'XXXXXXXX']]], ['device', ['vif', ['bridge', 'eth0'], ['type', 'ioemu']]]])
[2008-09-01 15:06:15 15814] DEBUG (XendDomainInfo:2028) XendDomainInfo.constructDomain
[2008-09-01 15:06:15 15814] DEBUG (balloon:132) Balloon: 3059724 KiB free; need 2048; done.
[2008-09-01 15:06:15 15814] DEBUG (XendDomain:447) Adding Domain: 24
[2008-09-01 15:06:15 15814] DEBUG (XendDomainInfo:2134) XendDomainInfo.initDomain: 24 256
[2008-09-01 15:06:15 15814] DEBUG (image:743) args: boot, val: c
[2008-09-01 15:06:15 15814] DEBUG (image:743) args: fda, val: None
[2008-09-01 15:06:15 15814] DEBUG (image:743) args: fdb, val: None
[2008-09-01 15:06:15 15814] DEBUG (image:743) args: soundhw, val: None
[2008-09-01 15:06:15 15814] DEBUG (image:743) args: localtime, val: 0
[2008-09-01 15:06:15 15814] DEBUG (image:743) args: serial, val: None
[2008-09-01 15:06:15 15814] DEBUG (image:743) args: std-vga, val: 0
[2008-09-01 15:06:15 15814] DEBUG (image:743) args: isa, val: 0
[2008-09-01 15:06:15 15814] DEBUG (image:743) args: acpi, val: 1
[2008-09-01 15:06:15 15814] DEBUG (image:743) args: usb, val: 0
[2008-09-01 15:06:15 15814] DEBUG (image:743) args: usbdevice, val: None
[2008-09-01 15:06:15 15814] DEBUG (XendDomainInfo:2215) _initDomain:shadow_memory=0x0, memory_static_max=0x20000000, memory_static_min=0x0.
[2008-09-01 15:06:15 15814] DEBUG (balloon:132) Balloon: 3058432 KiB free; need 539648; done.
[2008-09-01 15:06:15 15814] INFO (image:166) buildDomain os=hvm dom=24 vcpus=1
[2008-09-01 15:06:15 15814] DEBUG (image:795) domid          = 24
[2008-09-01 15:06:15 15814] DEBUG (image:796) image          = /usr/lib/xen/boot/hvmloader
[2008-09-01 15:06:15 15814] DEBUG (image:797) store_evtchn   = 2
[2008-09-01 15:06:15 15814] DEBUG (image:798) memsize        = 512
[2008-09-01 15:06:15 15814] DEBUG (image:799) vcpus          = 1
[2008-09-01 15:06:15 15814] DEBUG (image:800) acpi           = 1
[2008-09-01 15:06:15 15814] DEBUG (image:801) apic           = 1
[2008-09-01 15:06:15 15814] INFO (XendDomainInfo:1900) createDevice: vif : {'bridge': 'eth0', 'mac': '00:16:3e:05:9a:7d', 'type': 'ioemu', 'uuid': 'ecffd4fc-89b6-0a8e-dc51-600dc46dff24'}
[2008-09-01 15:06:15 15814] DEBUG (DevController:122) DevController: writing {'state': '1', 'backend-id': '0', 'backend': '/local/domain/0/backend/vif/24/0'} to /local/domain/24/device/vif/0.
[2008-09-01 15:06:15 15814] DEBUG (DevController:124) DevController: writing {'bridge': 'eth0', 'domain': 'hvmtest', 'handle': '0', 'uuid': 'ecffd4fc-89b6-0a8e-dc51-600dc46dff24', 'script': '/etc/xen/scripts/vif-bridge', 'mac': '00:16:3e:05:9a:7d', 'frontend-id': '24', 'state': '1', 'online': '1', 'frontend': '/local/domain/24/device/vif/0', 'type': 'ioemu'} to /local/domain/0/backend/vif/24/0.
[2008-09-01 15:06:15 15814] INFO (image:375) spawning device models: /usr/lib/xen/bin/stubdom-dm ['/usr/lib/xen/bin/stubdom-dm', '-d', '24', '-domain-name', 'hvmtest', '-nographic', '-vcpus', '1', '-boot', 'c', '-acpi', '-net', 'nic,vlan=1,macaddr=00:16:3e:05:9a:7d,model=rtl8139', '-net', 'tap,vlan=1,ifname=tap24.0,bridge=eth0', '-M', 'xenfv']
[2008-09-01 15:06:15 15814] INFO (image:422) device model pid: 16621
[2008-09-01 15:06:15 15814] DEBUG (XendDomainInfo:2729) Storing VM details: {'on_xend_stop': 'ignore', 'shadow_memory': '5', 'uuid': '08485d90-364c-bc25-0792-7fa735eebc28', 'on_reboot': 'restart', 'start_time': '1220292375.77', 'on_poweroff': 'destroy', 'on_xend_start': 'ignore', 'on_crash': 'restart', 'xend/restart_count': '0', 'vcpus': '1', 'vcpu_avail': '1', 'image': '(hvm (kernel ) (hpet 0) (stdvga 0) (vnclisten 172.30.206.1) (loader /usr/lib/xen/boot/hvmloader) (vncunused 1) (opengl 0) (boot c) (rtc_timeoffset 0) (pci ()) (pae 1) (hap 1) (acpi 1) (localtime 0) (timer_mode 0) (vnc 0) (nographic 0) (guest_os_type default) (apic 1) (sdl 0) (monitor 0) (device_model /usr/lib/xen/bin/stubdom-dm) (usb 0) (xauthority /root/.Xauthority) (isa 0) (notes (SUSPEND_CANCEL 1)))', 'name': 'hvmtest'}
[2008-09-01 15:06:15 15814] DEBUG (XendDomainInfo:1359) Storing domain details: {'console/port': '3', 'name': 'hvmtest', 'console/limit': '1048576', 'store/port': '2', 'vm': '/vm/08485d90-364c-bc25-0792-7fa735eebc28', 'domid': '24', 'image/suspend-cancel': '1', 'cpu/0/availability': 'online', 'memory/target': '524288', 'control/platform-feature-multiprocessor-suspend': '1', 'store/ring-ref': '131069', 'console/type': 'ioemu'}
[2008-09-01 15:06:15 15814] DEBUG (DevController:122) DevController: writing {'state': '1', 'backend-id': '0', 'backend': '/local/domain/0/backend/console/24/0'} to /local/domain/24/device/console/0.
[2008-09-01 15:06:15 15814] DEBUG (DevController:124) DevController: writing {'domain': 'hvmtest', 'frontend': '/local/domain/24/device/console/0', 'uuid': '8bb8dacc-7819-c709-2213-cc28cb07c8b5', 'frontend-id': '24', 'state': '1', 'location': '3', 'online': '1', 'protocol': 'vt100'} to /local/domain/0/backend/console/24/0.
[2008-09-01 15:06:15 15814] DEBUG (XendDomainInfo:1443) XendDomainInfo.handleShutdownWatch
[2008-09-01 15:06:15 15814] INFO (image:511) waiting for sentinel_fifo
[2008-09-01 15:06:15 15814] DEBUG (DevController:155) Waiting for devices vif.
[2008-09-01 15:06:15 15814] DEBUG (DevController:160) Waiting for 0.
[2008-09-01 15:06:15 15814] DEBUG (DevController:645) hotplugStatusCallback /local/domain/0/backend/vif/24/0/hotplug-status.
[2008-09-01 15:06:16 15814] DEBUG (DevController:645) hotplugStatusCallback /local/domain/0/backend/vif/24/0/hotplug-status.
[2008-09-01 15:06:16 15814] DEBUG (DevController:659) hotplugStatusCallback 1.
[2008-09-01 15:06:16 15814] DEBUG (DevController:155) Waiting for devices vscsi.
[2008-09-01 15:06:16 15814] DEBUG (DevController:155) Waiting for devices vbd.
[2008-09-01 15:06:16 15814] DEBUG (DevController:155) Waiting for devices irq.
[2008-09-01 15:06:16 15814] DEBUG (DevController:155) Waiting for devices vkbd.
[2008-09-01 15:06:16 15814] DEBUG (DevController:155) Waiting for devices vfb.
[2008-09-01 15:06:16 15814] DEBUG (DevController:155) Waiting for devices console.
[2008-09-01 15:06:16 15814] DEBUG (DevController:160) Waiting for 0.
[2008-09-01 15:06:16 15814] DEBUG (DevController:155) Waiting for devices pci.
[2008-09-01 15:06:16 15814] DEBUG (DevController:155) Waiting for devices ioports.
[2008-09-01 15:06:16 15814] DEBUG (DevController:155) Waiting for devices tap.
[2008-09-01 15:06:16 15814] DEBUG (DevController:155) Waiting for devices vtpm.
[2008-09-01 15:06:16 15814] INFO (XendDomain:1172) Domain hvmtest (24) unpaused.
[2008-09-01 15:06:16 15814] DEBUG (XendDomainInfo:89) XendDomainInfo.create(['vm', ['name', 'hvmtest-dm'], ['memory', 32], ['vcpus', 1], ['on_xend_start', 'ignore'], ['on_xend_stop', 'ignore'], ['target', 24], ['image', ['linux', ['kernel', '/usr/lib/xen/boot/ioemu-stubdom.gz'], ['args', ' -d 24']]], ['device', ['vbd', ['uname', 'phy:/dev/empirevg/lenny.hvm'], ['dev', 'hda'], ['mode', 'w']]], ['device', ['vbd', ['uname', 'file:/home/iso/debian-LennyBeta2-amd64-CD-1.iso'], ['dev', 'hdc:cdrom'], ['mode', 'r']]], ['device', ['vif', ['ip', '172.30.206.1']]], ['device', ['vif', ['bridge', 'eth0']]], ['device', ['vkbd']], ['device', ['vfb', ['type', 'vnc'], ['xauthority', '/root/.Xauthority']]]])
[2008-09-01 15:06:16 15814] DEBUG (XendDomainInfo:2028) XendDomainInfo.constructDomain
[2008-09-01 15:06:16 15814] DEBUG (balloon:132) Balloon: 2530148 KiB free; need 2048; done.
[2008-09-01 15:06:16 15814] DEBUG (XendDomain:447) Adding Domain: 25
[2008-09-01 15:06:16 15814] DEBUG (XendDomainInfo:2134) XendDomainInfo.initDomain: 25 256
[2008-09-01 15:06:16 15814] DEBUG (image:302) No VNC passwd configured for vfb access
[2008-09-01 15:06:16 15814] DEBUG (XendDomainInfo:2215) _initDomain:shadow_memory=0x0, memory_static_max=0x2000000, memory_static_min=0x0.
[2008-09-01 15:06:16 15814] DEBUG (balloon:132) Balloon: 2530140 KiB free; need 33792; done.
[2008-09-01 15:06:16 15814] INFO (image:166) buildDomain os=linux dom=25 vcpus=1
[2008-09-01 15:06:16 15814] DEBUG (image:631) domid          = 25
[2008-09-01 15:06:16 15814] DEBUG (image:632) memsize        = 32
[2008-09-01 15:06:16 15814] DEBUG (image:633) image          = /usr/lib/xen/boot/ioemu-stubdom.gz
[2008-09-01 15:06:16 15814] DEBUG (image:634) store_evtchn   = 1
[2008-09-01 15:06:16 15814] DEBUG (image:635) console_evtchn = 2
[2008-09-01 15:06:16 15814] DEBUG (image:636) cmdline        =  -d 24
[2008-09-01 15:06:16 15814] DEBUG (image:637) ramdisk        = 
[2008-09-01 15:06:16 15814] DEBUG (image:638) vcpus          = 1
[2008-09-01 15:06:16 15814] DEBUG (image:639) features       = 
[2008-09-01 15:06:16 15814] INFO (XendDomainInfo:1900) createDevice: vkbd : {'uuid': '86fca7cf-2448-2e36-7936-1a11528168bc'}
[2008-09-01 15:06:16 15814] DEBUG (DevController:122) DevController: writing {'protocol': 'x86_64-abi', 'state': '1', 'backend-id': '0', 'backend': '/local/domain/0/backend/vkbd/25/0'} to /local/domain/25/device/vkbd/0.
[2008-09-01 15:06:16 15814] DEBUG (DevController:124) DevController: writing {'frontend-id': '25', 'domain': 'hvmtest-dm', 'frontend': '/local/domain/25/device/vkbd/0', 'state': '1', 'online': '1'} to /local/domain/0/backend/vkbd/25/0.
[2008-09-01 15:06:16 15814] INFO (XendDomainInfo:1900) createDevice: vfb : {'other_config': {'type': 'vnc', 'xauthority': '/root/.Xauthority'}, 'type': 'vnc', 'xauthority': '/root/.Xauthority', 'uuid': '34c4aa01-41df-e497-e538-681d332796f1'}
[2008-09-01 15:06:16 15814] DEBUG (DevController:122) DevController: writing {'protocol': 'x86_64-abi', 'state': '1', 'backend-id': '0', 'backend': '/local/domain/0/backend/vfb/25/0'} to /local/domain/25/device/vfb/0.
[2008-09-01 15:06:16 15814] DEBUG (DevController:124) DevController: writing {'domain': 'hvmtest-dm', 'frontend': '/local/domain/25/device/vfb/0', 'xauthority': '/root/.Xauthority', 'state': '1', 'online': '1', 'frontend-id': '25', 'type': 'vnc', 'uuid': '34c4aa01-41df-e497-e538-681d332796f1'} to /local/domain/0/backend/vfb/25/0.
[2008-09-01 15:06:16 15814] INFO (XendDomainInfo:1900) createDevice: vbd : {'uuid': '179dfe76-841a-aa74-d09d-33f6b4d3e47e', 'bootable': 1, 'driver': 'paravirtualised', 'dev': 'hda', 'uname': 'phy:/dev/empirevg/lenny.hvm', 'mode': 'w'}
[2008-09-01 15:06:16 15814] DEBUG (DevController:122) DevController: writing {'virtual-device': '768', 'device-type': 'disk', 'protocol': 'x86_64-abi', 'backend-id': '0', 'state': '1', 'backend': '/local/domain/0/backend/vbd/25/768'} to /local/domain/25/device/vbd/768.
[2008-09-01 15:06:16 15814] DEBUG (DevController:124) DevController: writing {'domain': 'hvmtest-dm', 'frontend': '/local/domain/25/device/vbd/768', 'uuid': '179dfe76-841a-aa74-d09d-33f6b4d3e47e', 'dev': 'hda', 'state': '1', 'params': '/dev/empirevg/lenny.hvm', 'mode': 'w', 'online': '1', 'frontend-id': '25', 'type': 'phy'} to /local/domain/0/backend/vbd/25/768.
[2008-09-01 15:06:17 15814] INFO (XendDomainInfo:1900) createDevice: vbd : {'uuid': 'e277c390-2b58-5cb7-af60-3d3d54c2cb94', 'bootable': 0, 'driver': 'paravirtualised', 'dev': 'hdc:cdrom', 'uname': 'file:/home/iso/debian-LennyBeta2-amd64-CD-1.iso', 'mode': 'r'}
[2008-09-01 15:06:17 15814] DEBUG (DevController:122) DevController: writing {'virtual-device': '5632', 'device-type': 'cdrom', 'protocol': 'x86_64-abi', 'backend-id': '0', 'state': '1', 'backend': '/local/domain/0/backend/vbd/25/5632'} to /local/domain/25/device/vbd/5632.
[2008-09-01 15:06:17 15814] DEBUG (DevController:124) DevController: writing {'domain': 'hvmtest-dm', 'frontend': '/local/domain/25/device/vbd/5632', 'uuid': 'e277c390-2b58-5cb7-af60-3d3d54c2cb94', 'dev': 'hdc', 'state': '1', 'params': '/home/iso/debian-LennyBeta2-amd64-CD-1.iso', 'mode': 'r', 'online': '1', 'frontend-id': '25', 'type': 'file'} to /local/domain/0/backend/vbd/25/5632.
[2008-09-01 15:06:17 15814] INFO (XendDomainInfo:1900) createDevice: vif : {'ip': '172.30.206.1', 'mac': '00:16:3e:77:db:ae', 'uuid': '0f7fe708-fd04-4d71-9c3f-0f2348cefc0f'}
[2008-09-01 15:06:17 15814] DEBUG (DevController:122) DevController: writing {'mac': '00:16:3e:77:db:ae', 'handle': '0', 'protocol': 'x86_64-abi', 'backend-id': '0', 'state': '1', 'backend': '/local/domain/0/backend/vif/25/0'} to /local/domain/25/device/vif/0.
[2008-09-01 15:06:17 15814] DEBUG (DevController:124) DevController: writing {'domain': 'hvmtest-dm', 'handle': '0', 'uuid': '0f7fe708-fd04-4d71-9c3f-0f2348cefc0f', 'script': '/etc/xen/scripts/vif-bridge', 'ip': '172.30.206.1', 'mac': '00:16:3e:77:db:ae', 'frontend-id': '25', 'state': '1', 'online': '1', 'frontend': '/local/domain/25/device/vif/0'} to /local/domain/0/backend/vif/25/0.
[2008-09-01 15:06:17 15814] INFO (XendDomainInfo:1900) createDevice: vif : {'bridge': 'eth0', 'mac': '00:16:3e:02:e7:df', 'uuid': '6f78aab3-e90e-e5b6-4e3a-d1877c79b402'}
[2008-09-01 15:06:17 15814] DEBUG (DevController:122) DevController: writing {'mac': '00:16:3e:02:e7:df', 'handle': '1', 'protocol': 'x86_64-abi', 'backend-id': '0', 'state': '1', 'backend': '/local/domain/0/backend/vif/25/1'} to /local/domain/25/device/vif/1.
[2008-09-01 15:06:17 15814] DEBUG (DevController:124) DevController: writing {'bridge': 'eth0', 'domain': 'hvmtest-dm', 'handle': '1', 'uuid': '6f78aab3-e90e-e5b6-4e3a-d1877c79b402', 'script': '/etc/xen/scripts/vif-bridge', 'mac': '00:16:3e:02:e7:df', 'frontend-id': '25', 'state': '1', 'online': '1', 'frontend': '/local/domain/25/device/vif/1'} to /local/domain/0/backend/vif/25/1.
[2008-09-01 15:06:17 15814] INFO (image:375) spawning device models: /usr/lib64/xen/bin/qemu-dm ['/usr/lib64/xen/bin/qemu-dm', '-d', '25', '-domain-name', 'hvmtest-dm', '-vnc', '127.0.0.1:0', '-vncunused', '-serial', 'pty', '-M', 'xenpv']
[2008-09-01 15:06:17 15814] INFO (image:422) device model pid: 16736
[2008-09-01 15:06:17 15814] INFO (image:511) waiting for sentinel_fifo
[2008-09-01 15:06:17 15814] DEBUG (XendDomainInfo:2729) Storing VM details: {'on_xend_stop': 'ignore', 'shadow_memory': '0', 'uuid': '438fc4a8-b518-7dd2-a320-586d3ace61bc', 'on_reboot': 'restart', 'start_time': '1220292377.28', 'on_poweroff': 'destroy', 'on_xend_start': 'ignore', 'on_crash': 'restart', 'xend/restart_count': '0', 'vcpus': '1', 'vcpu_avail': '1', 'image': "(linux (kernel /usr/lib/xen/boot/ioemu-stubdom.gz) (args ' -d 24') (device_model /usr/lib64/xen/bin/qemu-dm) (notes))", 'name': 'hvmtest-dm'}
[2008-09-01 15:06:17 15814] DEBUG (XendDomainInfo:1359) Storing domain details: {'console/ring-ref': '769671', 'console/port': '2', 'name': 'hvmtest-dm', 'console/limit': '1048576', 'vm': '/vm/438fc4a8-b518-7dd2-a320-586d3ace61bc', 'domid': '25', 'store/port': '1', 'cpu/0/availability': 'online', 'memory/target': '32768', 'control/platform-feature-multiprocessor-suspend': '1', 'store/ring-ref': '769672', 'console/type': 'ioemu'}
[2008-09-01 15:06:17 15814] DEBUG (DevController:122) DevController: writing {'protocol': 'x86_64-abi', 'state': '1', 'backend-id': '0', 'backend': '/local/domain/0/backend/console/25/0'} to /local/domain/25/device/console/0.
[2008-09-01 15:06:17 15814] DEBUG (DevController:124) DevController: writing {'domain': 'hvmtest-dm', 'frontend': '/local/domain/25/device/console/0', 'uuid': '22383c2d-daa0-9425-daf0-508e7eda9cfc', 'frontend-id': '25', 'state': '1', 'location': '2', 'online': '1', 'protocol': 'vt100'} to /local/domain/0/backend/console/25/0.
[2008-09-01 15:06:17 15814] DEBUG (XendDomainInfo:1443) XendDomainInfo.handleShutdownWatch
[2008-09-01 15:06:17 15814] DEBUG (DevController:155) Waiting for devices vif.
[2008-09-01 15:06:17 15814] DEBUG (DevController:160) Waiting for 0.
[2008-09-01 15:06:17 15814] DEBUG (DevController:645) hotplugStatusCallback /local/domain/0/backend/vif/25/0/hotplug-status.
[2008-09-01 15:06:17 15814] DEBUG (DevController:645) hotplugStatusCallback /local/domain/0/backend/vif/25/0/hotplug-status.
[2008-09-01 15:06:17 15814] DEBUG (DevController:659) hotplugStatusCallback 1.
[2008-09-01 15:06:17 15814] DEBUG (DevController:160) Waiting for 1.
[2008-09-01 15:06:17 15814] DEBUG (DevController:645) hotplugStatusCallback /local/domain/0/backend/vif/25/1/hotplug-status.
[2008-09-01 15:06:17 15814] DEBUG (DevController:659) hotplugStatusCallback 1.
[2008-09-01 15:06:17 15814] DEBUG (DevController:155) Waiting for devices vscsi.
[2008-09-01 15:06:17 15814] DEBUG (DevController:155) Waiting for devices vbd.
[2008-09-01 15:06:17 15814] DEBUG (DevController:160) Waiting for 768.
[2008-09-01 15:06:17 15814] DEBUG (DevController:645) hotplugStatusCallback /local/domain/0/backend/vbd/25/768/hotplug-status.
[2008-09-01 15:06:17 15814] DEBUG (DevController:645) hotplugStatusCallback /local/domain/0/backend/vbd/25/768/hotplug-status.
[2008-09-01 15:06:17 15814] DEBUG (DevController:659) hotplugStatusCallback 1.
[2008-09-01 15:06:17 15814] DEBUG (DevController:160) Waiting for 5632.
[2008-09-01 15:06:17 15814] DEBUG (DevController:645) hotplugStatusCallback /local/domain/0/backend/vbd/25/5632/hotplug-status.
[2008-09-01 15:06:17 15814] DEBUG (DevController:659) hotplugStatusCallback 1.
[2008-09-01 15:06:17 15814] DEBUG (DevController:155) Waiting for devices irq.
[2008-09-01 15:06:17 15814] DEBUG (DevController:155) Waiting for devices vkbd.
[2008-09-01 15:06:17 15814] DEBUG (DevController:155) Waiting for devices vfb.
[2008-09-01 15:06:17 15814] DEBUG (DevController:155) Waiting for devices console.
[2008-09-01 15:06:17 15814] DEBUG (DevController:160) Waiting for 0.
[2008-09-01 15:06:17 15814] DEBUG (DevController:155) Waiting for devices pci.
[2008-09-01 15:06:17 15814] DEBUG (DevController:155) Waiting for devices ioports.
[2008-09-01 15:06:17 15814] DEBUG (DevController:155) Waiting for devices tap.
[2008-09-01 15:06:17 15814] DEBUG (DevController:155) Waiting for devices vtpm.
[2008-09-01 15:06:17 15814] INFO (XendDomain:1172) Domain hvmtest-dm (25) unpaused.
[2008-09-01 15:06:19 15814] INFO (XendDomainInfo:1634) Domain has shutdown: name=hvmtest id=24 reason=poweroff.
[2008-09-01 15:06:19 15814] DEBUG (XendDomainInfo:2389) XendDomainInfo.destroy: domid=24
[2008-09-01 15:06:19 15814] DEBUG (XendDomainInfo:2406) XendDomainInfo.destroyDomain(24)
[2008-09-01 15:06:19 15814] DEBUG (XendDomainInfo:1939) Destroying device model
[2008-09-01 15:06:19 15814] DEBUG (XendDomainInfo:1946) Releasing devices
[2008-09-01 15:06:19 15814] DEBUG (XendDomainInfo:1952) Removing vif/0
[2008-09-01 15:06:19 15814] DEBUG (XendDomainInfo:888) XendDomainInfo.destroyDevice: deviceClass = vif, device = vif/0
[2008-09-01 15:06:19 15814] DEBUG (XendDomainInfo:1952) Removing console/0
[2008-09-01 15:06:19 15814] DEBUG (XendDomainInfo:888) XendDomainInfo.destroyDevice: deviceClass = console, device = console/0
[2008-09-01 15:06:19 15814] DEBUG (XendDomainInfo:2389) XendDomainInfo.destroy: domid=25
[2008-09-01 15:06:19 15814] DEBUG (XendDomainInfo:2406) XendDomainInfo.destroyDomain(25)
[2008-09-01 15:06:19 15814] DEBUG (XendDomainInfo:1939) Destroying device model
[2008-09-01 15:06:20 15814] WARNING (image:472) domain hvmtest-dm: device model failure: no longer running; see /var/log/xen/qemu-dm-hvmtest-dm.log 
[2008-09-01 15:06:20 15814] DEBUG (XendDomainInfo:1946) Releasing devices
[2008-09-01 15:06:20 15814] DEBUG (XendDomainInfo:1952) Removing vif/0
[2008-09-01 15:06:20 15814] DEBUG (XendDomainInfo:888) XendDomainInfo.destroyDevice: deviceClass = vif, device = vif/0
[2008-09-01 15:06:20 15814] DEBUG (XendDomainInfo:1952) Removing vif/1
[2008-09-01 15:06:20 15814] DEBUG (XendDomainInfo:888) XendDomainInfo.destroyDevice: deviceClass = vif, device = vif/1
[2008-09-01 15:06:20 15814] DEBUG (XendDomainInfo:1952) Removing vbd/768
[2008-09-01 15:06:20 15814] DEBUG (XendDomainInfo:888) XendDomainInfo.destroyDevice: deviceClass = vbd, device = vbd/768
[2008-09-01 15:06:20 15814] DEBUG (XendDomainInfo:1952) Removing vbd/5632
[2008-09-01 15:06:20 15814] DEBUG (XendDomainInfo:888) XendDomainInfo.destroyDevice: deviceClass = vbd, device = vbd/5632
[2008-09-01 15:06:20 15814] DEBUG (XendDomainInfo:1952) Removing vkbd/0
[2008-09-01 15:06:20 15814] DEBUG (XendDomainInfo:888) XendDomainInfo.destroyDevice: deviceClass = vkbd, device = vkbd/0
[2008-09-01 15:06:20 15814] DEBUG (XendDomainInfo:1952) Removing vfb/0
[2008-09-01 15:06:20 15814] DEBUG (XendDomainInfo:888) XendDomainInfo.destroyDevice: deviceClass = vfb, device = vfb/0
[2008-09-01 15:06:20 15814] DEBUG (XendDomainInfo:1952) Removing console/0
[2008-09-01 15:06:20 15814] DEBUG (XendDomainInfo:888) XendDomainInfo.destroyDevice: deviceClass = console, device = console/0
[2008-09-01 15:06:20 15814] DEBUG (XendDomainInfo:1944) No device model
[2008-09-01 15:06:20 15814] DEBUG (XendDomainInfo:1946) Releasing devices

[-- Attachment #3: Type: text/plain, Size: 138 bytes --]

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

Re: stubdom problem

[Marco Sinhoreli]

[-- Attachment #1: Type: text/plain, Size: 1172 bytes --]

Sorry, attached a xend.log with TRACE loglevel.


On Mon, Sep 1, 2008 at 3:24 PM, Marco Sinhoreli <msinhore@gmail.com> wrote:
> Hello Samuel,
>
> I increase the debug level of xend. There are two thinks that I looked
> in xend.log:
> 1 - the stub domain was initialized, therefore have no problem with this domain.
> 2 - After unpause the domain-dm, it has shutdown but I don't understand why.
>     [2008-09-01 15:06:17 15814] INFO (XendDomain:1172) Domain
> hvmtest-dm (25) unpaused.
>     [2008-09-01 15:06:19 15814] INFO (XendDomainInfo:1634) Domain has
> shutdown: name=hvmtest id=24 reason=poweroff.
>
> Attached the xend.log.
>
> Regards,
>
> On Sat, Aug 30, 2008 at 5:37 PM, Samuel Thibault
> <samuel.thibault@ens-lyon.org> wrote:
>> Marco Sinhoreli, le Fri 29 Aug 2008 14:29:52 -0300, a écrit :
>>> [2008-08-29 14:20:29 3620] INFO (XendDomainInfo:1634) Domain has shutdown: name=hvmtest id=33 reason=poweroff.
>>
>> Ok, so that's not the -dm domain which initiated the shutdown.  It'd
>> be probably useful to increase the hypervisor debug level to get the
>> hvmloader messages in xm dmesg.
>>
>> Samuel
>>
>
>
>
> --
> Marco Sinhoreli
>



-- 
Marco Sinhoreli

[-- Warning: decoded text below may be mangled, UTF-8 assumed --]
[-- Attachment #2: xend.log --]
[-- Type: text/x-log; name=xend.log, Size: 54817 bytes --]

[2008-09-01 15:24:28 17368] TRACE (XendDomainInfo:2860) XendDomainInfo.update done on domain 26: {'vcpus_params': {'cap': 0, 'weight': 256}, 'PV_args': '', 'features': '', 'cpus': [[]], 'paused': 1, 'shutdown_reason': 0, 'actions_after_reboot': 'restart', 'vcpu_avail': 1, 'VCPUs_live': 1, 'PV_bootloader': '', 'actions_after_crash': 'restart', 'vbd_refs': [], 'PV_ramdisk': '', 'memory_dynamic_min': 536870912, 'name_label': 'hvmtest', 'VCPUs_at_startup': 1, 'HVM_boot_params': {'order': 'c'}, 'platform': {'hpet': 0, 'stdvga': 0, 'vnclisten': '172.30.206.1', 'loader': '/usr/lib/xen/boot/hvmloader', 'rtc_timeoffset': '0', 'vncunused': 1, 'monitor': 0, 'opengl': 0, 'boot': 'c', 'pci': [], 'pae': 1, 'hap': 1, 'acpi': 1, 'localtime': 0, 'timer_mode': 0, 'vnc': 0, 'nographic': 0, 'apic': 1, 'sdl': 0, 'usb': 0, 'guest_os_type': 'default', 'device_model': '/usr/lib/xen/bin/stubdom-dm', 'xauthority': '/root/.Xauthority', 'isa': 0}, 'PV_kernel': '', 'console_refs': ['641d720a-13a0-84fb-8c74-f2573cb52cfb'], 'shutdown': 0, 'dying': 0, 'blocked': 0, 'on_xend_stop': 'ignore', 'memory_static_min': 0, 'HVM_boot_policy': 'BIOS order', 'domid': 26, 'VCPUs_max': 1, 'start_time': 1220293468.2403619, 'online_vcpus': 1, 'memory_static_max': 536870912, 'actions_after_shutdown': 'destroy', 'on_xend_start': 'ignore', 'crashed': 0, 'memory_dynamic_max': 536870912, 'actions_after_suspend': '', 'is_a_template': False, 'is_control_domain': False, 'uuid': 'b45526b7-7afa-1697-c938-2bed6925a03f', 'cpu_time': 0.0, 'shadow_memory': 5, 'target': 0, 'PV_bootloader_args': '', 'notes': {'SUSPEND_CANCEL': 1}, 'other_config': {}, 'running': 0, 'devices': {'641d720a-13a0-84fb-8c74-f2573cb52cfb': ('console', {'other_config': {}, 'protocol': 'vt100', 'uuid': '641d720a-13a0-84fb-8c74-f2573cb52cfb', 'location': '3'}), 'db4dfe4b-b73c-290d-148b-d66e2bfb4467': ('vif', {'bridge': 'eth0', 'mac': '00:16:3e:20:7c:6c', 'devid': 0, 'type': 'ioemu', 'uuid': 'db4dfe4b-b73c-290d-148b-d66e2bfb4467'})}, 'vif_refs': ['db4dfe4b-b73c-290d-148b-d66e2bfb4467'], 'vtpm_refs': []}
[2008-09-01 15:24:28 17368] DEBUG (DevController:155) Waiting for devices vscsi.
[2008-09-01 15:24:28 17368] DEBUG (DevController:155) Waiting for devices vbd.
[2008-09-01 15:24:28 17368] DEBUG (DevController:155) Waiting for devices irq.
[2008-09-01 15:24:28 17368] DEBUG (DevController:155) Waiting for devices vkbd.
[2008-09-01 15:24:28 17368] DEBUG (DevController:155) Waiting for devices vfb.
[2008-09-01 15:24:28 17368] DEBUG (DevController:155) Waiting for devices console.
[2008-09-01 15:24:28 17368] DEBUG (DevController:160) Waiting for 0.
[2008-09-01 15:24:28 17368] DEBUG (DevController:155) Waiting for devices pci.
[2008-09-01 15:24:28 17368] DEBUG (DevController:155) Waiting for devices ioports.
[2008-09-01 15:24:28 17368] DEBUG (DevController:155) Waiting for devices tap.
[2008-09-01 15:24:28 17368] DEBUG (DevController:155) Waiting for devices vtpm.
[2008-09-01 15:24:28 17368] INFO (XendDomain:1172) Domain hvmtest (26) unpaused.
[2008-09-01 15:24:29 17368] TRACE (XendDomainInfo:2835) XendDomainInfo.update({'paused': 0, 'cpu_time': 835198212667L, 'ssidref': 0, 'hvm': 0, 'shutdown_reason': 0, 'dying': 0, 'mem_kb': 1046528L, 'domid': 0, 'max_vcpu_id': 1, 'crashed': 0, 'running': 1, 'maxmem_kb': 17179869180L, 'shutdown': 0, 'online_vcpus': 2, 'handle': [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0], 'blocked': 0}) on domain 0
[2008-09-01 15:24:29 17368] TRACE (XendDomainInfo:2860) XendDomainInfo.update done on domain 0: {'vcpus_params': {}, 'PV_args': '', 'features': '', 'cpus': [[0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30, 31], [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30, 31]], 'paused': 0, 'shutdown_reason': 0, 'actions_after_reboot': 'restart', 'shutdown': 0, 'VCPUs_live': 1, 'PV_bootloader': '', 'actions_after_crash': 'restart', 'vbd_refs': [], 'PV_ramdisk': '', 'memory_dynamic_min': 1071644672L, 'name_label': 'Domain-0', 'VCPUs_at_startup': 1, 'HVM_boot_params': {}, 'platform': {}, 'PV_kernel': '', 'console_refs': [], 'online_vcpus': 2, 'blocked': 0, 'on_xend_stop': 'ignore', 'memory_static_min': 0, 'HVM_boot_policy': '', 'domid': 0, 'VCPUs_max': 2, 'memory_static_max': 17592186040320L, 'actions_after_shutdown': 'destroy', 'on_xend_start': 'ignore', 'crashed': 0, 'memory_dynamic_max': 1071644672L, 'actions_after_suspend': '', 'is_a_template': False, 'vcpu_avail': 3, 'is_control_domain': True, 'uuid': '00000000-0000-0000-0000-000000000000', 'cpu_time': 835.19821266700001, 'shadow_memory': 0, 'target': 0, 'PV_bootloader_args': '', 'other_config': {}, 'running': 1, 'devices': {}, 'vif_refs': [], 'vtpm_refs': [], 'dying': 0}
[2008-09-01 15:24:29 17368] TRACE (XendDomainInfo:2835) XendDomainInfo.update({'paused': 0, 'cpu_time': 2135437L, 'ssidref': 0, 'hvm': 1, 'shutdown_reason': 0, 'dying': 0, 'mem_kb': 524156L, 'domid': 26, 'max_vcpu_id': 0, 'crashed': 0, 'running': 0, 'maxmem_kb': 532480L, 'shutdown': 0, 'online_vcpus': 1, 'handle': [180, 85, 38, 183, 122, 250, 22, 151, 201, 56, 43, 237, 105, 37, 160, 63], 'blocked': 0}) on domain 26
[2008-09-01 15:24:29 17368] TRACE (XendDomainInfo:2860) XendDomainInfo.update done on domain 26: {'vcpus_params': {'cap': 0, 'weight': 256}, 'PV_args': '', 'features': '', 'cpus': [[]], 'paused': 0, 'shutdown_reason': 0, 'actions_after_reboot': 'restart', 'vcpu_avail': 1, 'VCPUs_live': 1, 'PV_bootloader': '', 'actions_after_crash': 'restart', 'vbd_refs': [], 'PV_ramdisk': '', 'memory_dynamic_min': 536870912, 'name_label': 'hvmtest', 'VCPUs_at_startup': 1, 'HVM_boot_params': {'order': 'c'}, 'platform': {'hpet': 0, 'stdvga': 0, 'vnclisten': '172.30.206.1', 'loader': '/usr/lib/xen/boot/hvmloader', 'rtc_timeoffset': '0', 'vncunused': 1, 'monitor': 0, 'opengl': 0, 'boot': 'c', 'pci': [], 'pae': 1, 'hap': 1, 'acpi': 1, 'localtime': 0, 'timer_mode': 0, 'vnc': 0, 'nographic': 0, 'apic': 1, 'sdl': 0, 'usb': 0, 'guest_os_type': 'default', 'device_model': '/usr/lib/xen/bin/stubdom-dm', 'xauthority': '/root/.Xauthority', 'isa': 0}, 'PV_kernel': '', 'console_refs': ['641d720a-13a0-84fb-8c74-f2573cb52cfb'], 'shutdown': 0, 'dying': 0, 'blocked': 0, 'on_xend_stop': 'ignore', 'memory_static_min': 0, 'HVM_boot_policy': 'BIOS order', 'domid': 26, 'VCPUs_max': 1, 'start_time': 1220293468.2403619, 'online_vcpus': 1, 'memory_static_max': 536870912, 'actions_after_shutdown': 'destroy', 'on_xend_start': 'ignore', 'crashed': 0, 'memory_dynamic_max': 536870912, 'actions_after_suspend': '', 'is_a_template': False, 'is_control_domain': False, 'uuid': 'b45526b7-7afa-1697-c938-2bed6925a03f', 'cpu_time': 0.002135437, 'shadow_memory': 5, 'target': 0, 'PV_bootloader_args': '', 'notes': {'SUSPEND_CANCEL': 1}, 'other_config': {}, 'running': 0, 'devices': {'641d720a-13a0-84fb-8c74-f2573cb52cfb': ('console', {'other_config': {}, 'protocol': 'vt100', 'uuid': '641d720a-13a0-84fb-8c74-f2573cb52cfb', 'location': '3'}), 'db4dfe4b-b73c-290d-148b-d66e2bfb4467': ('vif', {'bridge': 'eth0', 'mac': '00:16:3e:20:7c:6c', 'devid': 0, 'type': 'ioemu', 'uuid': 'db4dfe4b-b73c-290d-148b-d66e2bfb4467'})}, 'vif_refs': ['db4dfe4b-b73c-290d-148b-d66e2bfb4467'], 'vtpm_refs': []}
[2008-09-01 15:24:29 17368] DEBUG (XendDomainInfo:89) XendDomainInfo.create(['vm', ['name', 'hvmtest-dm'], ['memory', 32], ['vcpus', 1], ['on_xend_start', 'ignore'], ['on_xend_stop', 'ignore'], ['target', 26], ['image', ['linux', ['kernel', '/usr/lib/xen/boot/ioemu-stubdom.gz'], ['args', ' -d 26']]], ['device', ['vbd', ['uname', 'phy:/dev/empirevg/lenny.hvm'], ['dev', 'hda'], ['mode', 'w']]], ['device', ['vbd', ['uname', 'file:/home/iso/debian-LennyBeta2-amd64-CD-1.iso'], ['dev', 'hdc:cdrom'], ['mode', 'r']]], ['device', ['vif', ['ip', '172.30.206.1']]], ['device', ['vif', ['bridge', 'eth0']]], ['device', ['vkbd']], ['device', ['vfb', ['type', 'vnc'], ['xauthority', '/root/.Xauthority']]]])
[2008-09-01 15:24:29 17368] DEBUG (XendDomainInfo:2028) XendDomainInfo.constructDomain
[2008-09-01 15:24:29 17368] DEBUG (balloon:132) Balloon: 2530332 KiB free; need 2048; done.
[2008-09-01 15:24:29 17368] DEBUG (XendDomain:447) Adding Domain: 27
[2008-09-01 15:24:29 17368] DEBUG (XendDomainInfo:2134) XendDomainInfo.initDomain: 27 256
[2008-09-01 15:24:29 17368] DEBUG (image:302) No VNC passwd configured for vfb access
[2008-09-01 15:24:29 17368] DEBUG (XendDomainInfo:2215) _initDomain:shadow_memory=0x0, memory_static_max=0x2000000, memory_static_min=0x0.
[2008-09-01 15:24:29 17368] DEBUG (balloon:132) Balloon: 2530324 KiB free; need 33792; done.
[2008-09-01 15:24:29 17368] INFO (image:166) buildDomain os=linux dom=27 vcpus=1
[2008-09-01 15:24:29 17368] DEBUG (image:631) domid          = 27
[2008-09-01 15:24:29 17368] DEBUG (image:632) memsize        = 32
[2008-09-01 15:24:29 17368] DEBUG (image:633) image          = /usr/lib/xen/boot/ioemu-stubdom.gz
[2008-09-01 15:24:29 17368] DEBUG (image:634) store_evtchn   = 1
[2008-09-01 15:24:29 17368] DEBUG (image:635) console_evtchn = 2
[2008-09-01 15:24:29 17368] DEBUG (image:636) cmdline        =  -d 26
[2008-09-01 15:24:29 17368] DEBUG (image:637) ramdisk        = 
[2008-09-01 15:24:29 17368] DEBUG (image:638) vcpus          = 1
[2008-09-01 15:24:29 17368] DEBUG (image:639) features       = 
[2008-09-01 15:24:29 17368] INFO (XendDomainInfo:1900) createDevice: vkbd : {'uuid': '246f7df4-65a1-6b94-c5d3-34ef1e5f7171'}
[2008-09-01 15:24:29 17368] DEBUG (DevController:122) DevController: writing {'protocol': 'x86_64-abi', 'state': '1', 'backend-id': '0', 'backend': '/local/domain/0/backend/vkbd/27/0'} to /local/domain/27/device/vkbd/0.
[2008-09-01 15:24:29 17368] DEBUG (DevController:124) DevController: writing {'frontend-id': '27', 'domain': 'hvmtest-dm', 'frontend': '/local/domain/27/device/vkbd/0', 'state': '1', 'online': '1'} to /local/domain/0/backend/vkbd/27/0.
[2008-09-01 15:24:29 17368] INFO (XendDomainInfo:1900) createDevice: vfb : {'other_config': {'type': 'vnc', 'xauthority': '/root/.Xauthority'}, 'type': 'vnc', 'xauthority': '/root/.Xauthority', 'uuid': '2ced39ef-df51-aadf-f21c-59e428156a05'}
[2008-09-01 15:24:29 17368] DEBUG (DevController:122) DevController: writing {'protocol': 'x86_64-abi', 'state': '1', 'backend-id': '0', 'backend': '/local/domain/0/backend/vfb/27/0'} to /local/domain/27/device/vfb/0.
[2008-09-01 15:24:29 17368] DEBUG (DevController:124) DevController: writing {'domain': 'hvmtest-dm', 'frontend': '/local/domain/27/device/vfb/0', 'xauthority': '/root/.Xauthority', 'state': '1', 'online': '1', 'frontend-id': '27', 'type': 'vnc', 'uuid': '2ced39ef-df51-aadf-f21c-59e428156a05'} to /local/domain/0/backend/vfb/27/0.
[2008-09-01 15:24:29 17368] INFO (XendDomainInfo:1900) createDevice: vbd : {'uuid': '433e6c5f-45ff-25f3-2f26-3f67fb148de5', 'bootable': 1, 'driver': 'paravirtualised', 'dev': 'hda', 'uname': 'phy:/dev/empirevg/lenny.hvm', 'mode': 'w'}
[2008-09-01 15:24:29 17368] DEBUG (DevController:122) DevController: writing {'virtual-device': '768', 'device-type': 'disk', 'protocol': 'x86_64-abi', 'backend-id': '0', 'state': '1', 'backend': '/local/domain/0/backend/vbd/27/768'} to /local/domain/27/device/vbd/768.
[2008-09-01 15:24:29 17368] DEBUG (DevController:124) DevController: writing {'domain': 'hvmtest-dm', 'frontend': '/local/domain/27/device/vbd/768', 'uuid': '433e6c5f-45ff-25f3-2f26-3f67fb148de5', 'dev': 'hda', 'state': '1', 'params': '/dev/empirevg/lenny.hvm', 'mode': 'w', 'online': '1', 'frontend-id': '27', 'type': 'phy'} to /local/domain/0/backend/vbd/27/768.
[2008-09-01 15:24:29 17368] INFO (XendDomainInfo:1900) createDevice: vbd : {'uuid': '15bd6bc8-1c3d-5737-325a-2ed58c50bb05', 'bootable': 0, 'driver': 'paravirtualised', 'dev': 'hdc:cdrom', 'uname': 'file:/home/iso/debian-LennyBeta2-amd64-CD-1.iso', 'mode': 'r'}
[2008-09-01 15:24:29 17368] DEBUG (DevController:122) DevController: writing {'virtual-device': '5632', 'device-type': 'cdrom', 'protocol': 'x86_64-abi', 'backend-id': '0', 'state': '1', 'backend': '/local/domain/0/backend/vbd/27/5632'} to /local/domain/27/device/vbd/5632.
[2008-09-01 15:24:29 17368] DEBUG (DevController:124) DevController: writing {'domain': 'hvmtest-dm', 'frontend': '/local/domain/27/device/vbd/5632', 'uuid': '15bd6bc8-1c3d-5737-325a-2ed58c50bb05', 'dev': 'hdc', 'state': '1', 'params': '/home/iso/debian-LennyBeta2-amd64-CD-1.iso', 'mode': 'r', 'online': '1', 'frontend-id': '27', 'type': 'file'} to /local/domain/0/backend/vbd/27/5632.
[2008-09-01 15:24:29 17368] INFO (XendDomainInfo:1900) createDevice: vif : {'ip': '172.30.206.1', 'mac': '00:16:3e:65:6f:6c', 'uuid': 'f0df36ec-e573-c742-a6f0-0243997be6c8'}
[2008-09-01 15:24:29 17368] DEBUG (DevController:122) DevController: writing {'mac': '00:16:3e:65:6f:6c', 'handle': '0', 'protocol': 'x86_64-abi', 'backend-id': '0', 'state': '1', 'backend': '/local/domain/0/backend/vif/27/0'} to /local/domain/27/device/vif/0.
[2008-09-01 15:24:29 17368] DEBUG (DevController:124) DevController: writing {'domain': 'hvmtest-dm', 'handle': '0', 'uuid': 'f0df36ec-e573-c742-a6f0-0243997be6c8', 'script': '/etc/xen/scripts/vif-bridge', 'ip': '172.30.206.1', 'mac': '00:16:3e:65:6f:6c', 'frontend-id': '27', 'state': '1', 'online': '1', 'frontend': '/local/domain/27/device/vif/0'} to /local/domain/0/backend/vif/27/0.
[2008-09-01 15:24:29 17368] INFO (XendDomainInfo:1900) createDevice: vif : {'bridge': 'eth0', 'mac': '00:16:3e:7d:9f:1a', 'uuid': '55b2b10f-4ebd-7beb-16e8-9b44eb3daa13'}
[2008-09-01 15:24:29 17368] DEBUG (DevController:122) DevController: writing {'mac': '00:16:3e:7d:9f:1a', 'handle': '1', 'protocol': 'x86_64-abi', 'backend-id': '0', 'state': '1', 'backend': '/local/domain/0/backend/vif/27/1'} to /local/domain/27/device/vif/1.
[2008-09-01 15:24:29 17368] DEBUG (DevController:124) DevController: writing {'bridge': 'eth0', 'domain': 'hvmtest-dm', 'handle': '1', 'uuid': '55b2b10f-4ebd-7beb-16e8-9b44eb3daa13', 'script': '/etc/xen/scripts/vif-bridge', 'mac': '00:16:3e:7d:9f:1a', 'frontend-id': '27', 'state': '1', 'online': '1', 'frontend': '/local/domain/27/device/vif/1'} to /local/domain/0/backend/vif/27/1.
[2008-09-01 15:24:29 17368] INFO (image:375) spawning device models: /usr/lib64/xen/bin/qemu-dm ['/usr/lib64/xen/bin/qemu-dm', '-d', '27', '-domain-name', 'hvmtest-dm', '-vnc', '127.0.0.1:0', '-vncunused', '-serial', 'pty', '-M', 'xenpv']
[2008-09-01 15:24:30 17368] INFO (image:422) device model pid: 17528
[2008-09-01 15:24:30 17368] DEBUG (XendDomainInfo:2729) Storing VM details: {'on_xend_stop': 'ignore', 'shadow_memory': '0', 'uuid': '5074920e-4cda-4eaa-20c1-6ced639e45d2', 'on_reboot': 'restart', 'start_time': '1220293470.02', 'on_poweroff': 'destroy', 'on_xend_start': 'ignore', 'on_crash': 'restart', 'xend/restart_count': '0', 'vcpus': '1', 'vcpu_avail': '1', 'image': "(linux (kernel /usr/lib/xen/boot/ioemu-stubdom.gz) (args ' -d 26') (device_model /usr/lib64/xen/bin/qemu-dm) (notes))", 'name': 'hvmtest-dm'}
[2008-09-01 15:24:30 17368] DEBUG (XendDomainInfo:1359) Storing domain details: {'console/ring-ref': '775093', 'console/port': '2', 'name': 'hvmtest-dm', 'console/limit': '1048576', 'vm': '/vm/5074920e-4cda-4eaa-20c1-6ced639e45d2', 'domid': '27', 'store/port': '1', 'cpu/0/availability': 'online', 'memory/target': '32768', 'control/platform-feature-multiprocessor-suspend': '1', 'store/ring-ref': '775094', 'console/type': 'ioemu'}
[2008-09-01 15:24:30 17368] TRACE (XendDomainInfo:2835) XendDomainInfo.update({'paused': 0, 'cpu_time': 836645481629L, 'ssidref': 0, 'hvm': 0, 'shutdown_reason': 0, 'dying': 0, 'mem_kb': 1046528L, 'domid': 0, 'max_vcpu_id': 1, 'crashed': 0, 'running': 1, 'maxmem_kb': 17179869180L, 'shutdown': 0, 'online_vcpus': 2, 'handle': [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0], 'blocked': 0}) on domain 0
[2008-09-01 15:24:30 17368] TRACE (XendDomainInfo:2860) XendDomainInfo.update done on domain 0: {'vcpus_params': {}, 'PV_args': '', 'features': '', 'cpus': [[0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30, 31], [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30, 31]], 'paused': 0, 'shutdown_reason': 0, 'actions_after_reboot': 'restart', 'shutdown': 0, 'VCPUs_live': 1, 'PV_bootloader': '', 'actions_after_crash': 'restart', 'vbd_refs': [], 'PV_ramdisk': '', 'memory_dynamic_min': 1071644672L, 'name_label': 'Domain-0', 'VCPUs_at_startup': 1, 'HVM_boot_params': {}, 'platform': {}, 'PV_kernel': '', 'console_refs': [], 'online_vcpus': 2, 'blocked': 0, 'on_xend_stop': 'ignore', 'memory_static_min': 0, 'HVM_boot_policy': '', 'domid': 0, 'VCPUs_max': 2, 'memory_static_max': 17592186040320L, 'actions_after_shutdown': 'destroy', 'on_xend_start': 'ignore', 'crashed': 0, 'memory_dynamic_max': 1071644672L, 'actions_after_suspend': '', 'is_a_template': False, 'vcpu_avail': 3, 'is_control_domain': True, 'uuid': '00000000-0000-0000-0000-000000000000', 'cpu_time': 836.64548162899996, 'shadow_memory': 0, 'target': 0, 'PV_bootloader_args': '', 'other_config': {}, 'running': 1, 'devices': {}, 'vif_refs': [], 'vtpm_refs': [], 'dying': 0}
[2008-09-01 15:24:30 17368] TRACE (XendDomainInfo:2835) XendDomainInfo.update({'paused': 0, 'cpu_time': 2135437L, 'ssidref': 0, 'hvm': 1, 'shutdown_reason': 0, 'dying': 0, 'mem_kb': 524156L, 'domid': 26, 'max_vcpu_id': 0, 'crashed': 0, 'running': 0, 'maxmem_kb': 532480L, 'shutdown': 0, 'online_vcpus': 1, 'handle': [180, 85, 38, 183, 122, 250, 22, 151, 201, 56, 43, 237, 105, 37, 160, 63], 'blocked': 0}) on domain 26
[2008-09-01 15:24:30 17368] TRACE (XendDomainInfo:2860) XendDomainInfo.update done on domain 26: {'vcpus_params': {'cap': 0, 'weight': 256}, 'PV_args': '', 'features': '', 'cpus': [[]], 'paused': 0, 'shutdown_reason': 0, 'actions_after_reboot': 'restart', 'vcpu_avail': 1, 'VCPUs_live': 1, 'PV_bootloader': '', 'actions_after_crash': 'restart', 'vbd_refs': [], 'PV_ramdisk': '', 'memory_dynamic_min': 536870912, 'name_label': 'hvmtest', 'VCPUs_at_startup': 1, 'HVM_boot_params': {'order': 'c'}, 'platform': {'hpet': 0, 'stdvga': 0, 'vnclisten': '172.30.206.1', 'loader': '/usr/lib/xen/boot/hvmloader', 'rtc_timeoffset': '0', 'vncunused': 1, 'monitor': 0, 'opengl': 0, 'boot': 'c', 'pci': [], 'pae': 1, 'hap': 1, 'acpi': 1, 'localtime': 0, 'timer_mode': 0, 'vnc': 0, 'nographic': 0, 'apic': 1, 'sdl': 0, 'usb': 0, 'guest_os_type': 'default', 'device_model': '/usr/lib/xen/bin/stubdom-dm', 'xauthority': '/root/.Xauthority', 'isa': 0}, 'PV_kernel': '', 'console_refs': ['641d720a-13a0-84fb-8c74-f2573cb52cfb'], 'shutdown': 0, 'dying': 0, 'blocked': 0, 'on_xend_stop': 'ignore', 'memory_static_min': 0, 'HVM_boot_policy': 'BIOS order', 'domid': 26, 'VCPUs_max': 1, 'start_time': 1220293468.2403619, 'online_vcpus': 1, 'memory_static_max': 536870912, 'actions_after_shutdown': 'destroy', 'on_xend_start': 'ignore', 'crashed': 0, 'memory_dynamic_max': 536870912, 'actions_after_suspend': '', 'is_a_template': False, 'is_control_domain': False, 'uuid': 'b45526b7-7afa-1697-c938-2bed6925a03f', 'cpu_time': 0.002135437, 'shadow_memory': 5, 'target': 0, 'PV_bootloader_args': '', 'notes': {'SUSPEND_CANCEL': 1}, 'other_config': {}, 'running': 0, 'devices': {'641d720a-13a0-84fb-8c74-f2573cb52cfb': ('console', {'other_config': {}, 'protocol': 'vt100', 'uuid': '641d720a-13a0-84fb-8c74-f2573cb52cfb', 'location': '3'}), 'db4dfe4b-b73c-290d-148b-d66e2bfb4467': ('vif', {'bridge': 'eth0', 'mac': '00:16:3e:20:7c:6c', 'devid': 0, 'type': 'ioemu', 'uuid': 'db4dfe4b-b73c-290d-148b-d66e2bfb4467'})}, 'vif_refs': ['db4dfe4b-b73c-290d-148b-d66e2bfb4467'], 'vtpm_refs': []}
[2008-09-01 15:24:30 17368] TRACE (XendDomainInfo:2835) XendDomainInfo.update({'paused': 1, 'cpu_time': 0L, 'ssidref': 0, 'hvm': 0, 'shutdown_reason': 0, 'dying': 0, 'mem_kb': 32768L, 'domid': 27, 'max_vcpu_id': 0, 'crashed': 0, 'running': 0, 'maxmem_kb': 32768L, 'shutdown': 0, 'online_vcpus': 1, 'handle': [80, 116, 146, 14, 76, 218, 78, 170, 32, 193, 108, 237, 99, 158, 69, 210], 'blocked': 0}) on domain 27
[2008-09-01 15:24:30 17368] DEBUG (DevController:122) DevController: writing {'protocol': 'x86_64-abi', 'state': '1', 'backend-id': '0', 'backend': '/local/domain/0/backend/console/27/0'} to /local/domain/27/device/console/0.
[2008-09-01 15:24:30 17368] DEBUG (DevController:124) DevController: writing {'domain': 'hvmtest-dm', 'frontend': '/local/domain/27/device/console/0', 'uuid': '4dc370c5-218d-4d6f-fcc6-b8248c558ad3', 'frontend-id': '27', 'state': '1', 'location': '2', 'online': '1', 'protocol': 'vt100'} to /local/domain/0/backend/console/27/0.
[2008-09-01 15:24:30 17368] INFO (image:511) waiting for sentinel_fifo
[2008-09-01 15:24:30 17368] TRACE (XendDomainInfo:2860) XendDomainInfo.update done on domain 27: {'vcpus_params': {'cap': 0, 'weight': 256}, 'PV_args': ' -d 26', 'features': '', 'cpus': [[]], 'paused': 1, 'shutdown_reason': 0, 'actions_after_reboot': 'restart', 'vcpu_avail': 1, 'VCPUs_live': 1, 'PV_bootloader': '', 'actions_after_crash': 'restart', 'vbd_refs': ['433e6c5f-45ff-25f3-2f26-3f67fb148de5', '15bd6bc8-1c3d-5737-325a-2ed58c50bb05'], 'PV_ramdisk': '', 'memory_dynamic_min': 33554432, 'name_label': 'hvmtest-dm', 'VCPUs_at_startup': 1, 'HVM_boot_params': {}, 'platform': {'device_model': '/usr/lib64/xen/bin/qemu-dm'}, 'PV_kernel': '/usr/lib/xen/boot/ioemu-stubdom.gz', 'console_refs': ['2ced39ef-df51-aadf-f21c-59e428156a05', '4dc370c5-218d-4d6f-fcc6-b8248c558ad3'], 'shutdown': 0, 'dying': 0, 'blocked': 0, 'on_xend_stop': 'ignore', 'memory_static_min': 0, 'HVM_boot_policy': '', 'domid': 27, 'VCPUs_max': 1, 'start_time': 1220293470.0187321, 'online_vcpus': 1, 'memory_static_max': 33554432, 'actions_after_shutdown': 'destroy', 'on_xend_start': 'ignore', 'crashed': 0, 'memory_dynamic_max': 33554432, 'actions_after_suspend': '', 'is_a_template': False, 'is_control_domain': False, 'uuid': '5074920e-4cda-4eaa-20c1-6ced639e45d2', 'cpu_time': 0.0, 'shadow_memory': 0, 'target': 26, 'PV_bootloader_args': '', 'notes': {}, 'other_config': {}, 'running': 0, 'devices': {'55b2b10f-4ebd-7beb-16e8-9b44eb3daa13': ('vif', {'bridge': 'eth0', 'mac': '00:16:3e:7d:9f:1a', 'devid': 1, 'uuid': '55b2b10f-4ebd-7beb-16e8-9b44eb3daa13'}), '4dc370c5-218d-4d6f-fcc6-b8248c558ad3': ('console', {'other_config': {}, 'protocol': 'vt100', 'uuid': '4dc370c5-218d-4d6f-fcc6-b8248c558ad3', 'location': '2'}), '433e6c5f-45ff-25f3-2f26-3f67fb148de5': ('vbd', {'uuid': '433e6c5f-45ff-25f3-2f26-3f67fb148de5', 'bootable': 1, 'devid': 768, 'driver': 'paravirtualised', 'dev': 'hda', 'uname': 'phy:/dev/empirevg/lenny.hvm', 'mode': 'w'}), '15bd6bc8-1c3d-5737-325a-2ed58c50bb05': ('vbd', {'uuid': '15bd6bc8-1c3d-5737-325a-2ed58c50bb05', 'bootable': 0, 'devid': 5632, 'driver': 'paravirtualised', 'dev': 'hdc:cdrom', 'uname': 'file:/home/iso/debian-LennyBeta2-amd64-CD-1.iso', 'mode': 'r'}), 'f0df36ec-e573-c742-a6f0-0243997be6c8': ('vif', {'ip': '172.30.206.1', 'mac': '00:16:3e:65:6f:6c', 'devid': 0, 'uuid': 'f0df36ec-e573-c742-a6f0-0243997be6c8'}), '246f7df4-65a1-6b94-c5d3-34ef1e5f7171': ('vkbd', {'devid': 0, 'uuid': '246f7df4-65a1-6b94-c5d3-34ef1e5f7171'}), '2ced39ef-df51-aadf-f21c-59e428156a05': ('vfb', {'other_config': {'type': 'vnc', 'xauthority': '/root/.Xauthority'}, 'xauthority': '/root/.Xauthority', 'devid': 0, 'location': 'localhost:5900', 'type': 'vnc', 'uuid': '2ced39ef-df51-aadf-f21c-59e428156a05'})}, 'vif_refs': ['f0df36ec-e573-c742-a6f0-0243997be6c8', '55b2b10f-4ebd-7beb-16e8-9b44eb3daa13'], 'vtpm_refs': []}
[2008-09-01 15:24:30 17368] TRACE (XendDomainInfo:1390) XendDomainInfo.storeChanged
[2008-09-01 15:24:30 17368] TRACE (XendDomainInfo:2835) XendDomainInfo.update({'paused': 0, 'cpu_time': 836869876602L, 'ssidref': 0, 'hvm': 0, 'shutdown_reason': 0, 'dying': 0, 'mem_kb': 1046528L, 'domid': 0, 'max_vcpu_id': 1, 'crashed': 0, 'running': 1, 'maxmem_kb': 17179869180L, 'shutdown': 0, 'online_vcpus': 2, 'handle': [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0], 'blocked': 0}) on domain 0
[2008-09-01 15:24:30 17368] TRACE (XendDomainInfo:2860) XendDomainInfo.update done on domain 0: {'vcpus_params': {}, 'PV_args': '', 'features': '', 'cpus': [[0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30, 31], [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30, 31]], 'paused': 0, 'shutdown_reason': 0, 'actions_after_reboot': 'restart', 'shutdown': 0, 'VCPUs_live': 1, 'PV_bootloader': '', 'actions_after_crash': 'restart', 'vbd_refs': [], 'PV_ramdisk': '', 'memory_dynamic_min': 1071644672L, 'name_label': 'Domain-0', 'VCPUs_at_startup': 1, 'HVM_boot_params': {}, 'platform': {}, 'PV_kernel': '', 'console_refs': [], 'online_vcpus': 2, 'blocked': 0, 'on_xend_stop': 'ignore', 'memory_static_min': 0, 'HVM_boot_policy': '', 'domid': 0, 'VCPUs_max': 2, 'memory_static_max': 17592186040320L, 'actions_after_shutdown': 'destroy', 'on_xend_start': 'ignore', 'crashed': 0, 'memory_dynamic_max': 1071644672L, 'actions_after_suspend': '', 'is_a_template': False, 'vcpu_avail': 3, 'is_control_domain': True, 'uuid': '00000000-0000-0000-0000-000000000000', 'cpu_time': 836.86987660199998, 'shadow_memory': 0, 'target': 0, 'PV_bootloader_args': '', 'other_config': {}, 'running': 1, 'devices': {}, 'vif_refs': [], 'vtpm_refs': [], 'dying': 0}
[2008-09-01 15:24:30 17368] TRACE (XendDomainInfo:2835) XendDomainInfo.update({'paused': 0, 'cpu_time': 2135437L, 'ssidref': 0, 'hvm': 1, 'shutdown_reason': 0, 'dying': 0, 'mem_kb': 524156L, 'domid': 26, 'max_vcpu_id': 0, 'crashed': 0, 'running': 0, 'maxmem_kb': 532480L, 'shutdown': 0, 'online_vcpus': 1, 'handle': [180, 85, 38, 183, 122, 250, 22, 151, 201, 56, 43, 237, 105, 37, 160, 63], 'blocked': 0}) on domain 26
[2008-09-01 15:24:30 17368] DEBUG (XendDomainInfo:1443) XendDomainInfo.handleShutdownWatch
[2008-09-01 15:24:30 17368] TRACE (XendDomainInfo:2860) XendDomainInfo.update done on domain 26: {'vcpus_params': {'cap': 0, 'weight': 256}, 'PV_args': '', 'features': '', 'cpus': [[]], 'paused': 0, 'shutdown_reason': 0, 'actions_after_reboot': 'restart', 'vcpu_avail': 1, 'VCPUs_live': 1, 'PV_bootloader': '', 'actions_after_crash': 'restart', 'vbd_refs': [], 'PV_ramdisk': '', 'memory_dynamic_min': 536870912, 'name_label': 'hvmtest', 'VCPUs_at_startup': 1, 'HVM_boot_params': {'order': 'c'}, 'platform': {'hpet': 0, 'stdvga': 0, 'vnclisten': '172.30.206.1', 'loader': '/usr/lib/xen/boot/hvmloader', 'rtc_timeoffset': '0', 'vncunused': 1, 'monitor': 0, 'opengl': 0, 'boot': 'c', 'pci': [], 'pae': 1, 'hap': 1, 'acpi': 1, 'localtime': 0, 'timer_mode': 0, 'vnc': 0, 'nographic': 0, 'apic': 1, 'sdl': 0, 'usb': 0, 'guest_os_type': 'default', 'device_model': '/usr/lib/xen/bin/stubdom-dm', 'xauthority': '/root/.Xauthority', 'isa': 0}, 'PV_kernel': '', 'console_refs': ['641d720a-13a0-84fb-8c74-f2573cb52cfb'], 'shutdown': 0, 'dying': 0, 'blocked': 0, 'on_xend_stop': 'ignore', 'memory_static_min': 0, 'HVM_boot_policy': 'BIOS order', 'domid': 26, 'VCPUs_max': 1, 'start_time': 1220293468.2403619, 'online_vcpus': 1, 'memory_static_max': 536870912, 'actions_after_shutdown': 'destroy', 'on_xend_start': 'ignore', 'crashed': 0, 'memory_dynamic_max': 536870912, 'actions_after_suspend': '', 'is_a_template': False, 'is_control_domain': False, 'uuid': 'b45526b7-7afa-1697-c938-2bed6925a03f', 'cpu_time': 0.002135437, 'shadow_memory': 5, 'target': 0, 'PV_bootloader_args': '', 'notes': {'SUSPEND_CANCEL': 1}, 'other_config': {}, 'running': 0, 'devices': {'641d720a-13a0-84fb-8c74-f2573cb52cfb': ('console', {'other_config': {}, 'protocol': 'vt100', 'uuid': '641d720a-13a0-84fb-8c74-f2573cb52cfb', 'location': '3'}), 'db4dfe4b-b73c-290d-148b-d66e2bfb4467': ('vif', {'bridge': 'eth0', 'mac': '00:16:3e:20:7c:6c', 'devid': 0, 'type': 'ioemu', 'uuid': 'db4dfe4b-b73c-290d-148b-d66e2bfb4467'})}, 'vif_refs': ['db4dfe4b-b73c-290d-148b-d66e2bfb4467'], 'vtpm_refs': []}
[2008-09-01 15:24:30 17368] TRACE (XendDomainInfo:2835) XendDomainInfo.update({'paused': 1, 'cpu_time': 0L, 'ssidref': 0, 'hvm': 0, 'shutdown_reason': 0, 'dying': 0, 'mem_kb': 32768L, 'domid': 27, 'max_vcpu_id': 0, 'crashed': 0, 'running': 0, 'maxmem_kb': 32768L, 'shutdown': 0, 'online_vcpus': 1, 'handle': [80, 116, 146, 14, 76, 218, 78, 170, 32, 193, 108, 237, 99, 158, 69, 210], 'blocked': 0}) on domain 27
[2008-09-01 15:24:30 17368] TRACE (XendDomainInfo:2860) XendDomainInfo.update done on domain 27: {'vcpus_params': {'cap': 0, 'weight': 256}, 'PV_args': ' -d 26', 'features': '', 'cpus': [[]], 'paused': 1, 'shutdown_reason': 0, 'actions_after_reboot': 'restart', 'vcpu_avail': 1, 'VCPUs_live': 1, 'PV_bootloader': '', 'actions_after_crash': 'restart', 'vbd_refs': ['433e6c5f-45ff-25f3-2f26-3f67fb148de5', '15bd6bc8-1c3d-5737-325a-2ed58c50bb05'], 'PV_ramdisk': '', 'memory_dynamic_min': 33554432, 'name_label': 'hvmtest-dm', 'VCPUs_at_startup': 1, 'HVM_boot_params': {}, 'platform': {'device_model': '/usr/lib64/xen/bin/qemu-dm'}, 'PV_kernel': '/usr/lib/xen/boot/ioemu-stubdom.gz', 'console_refs': ['2ced39ef-df51-aadf-f21c-59e428156a05', '4dc370c5-218d-4d6f-fcc6-b8248c558ad3'], 'shutdown': 0, 'dying': 0, 'blocked': 0, 'on_xend_stop': 'ignore', 'memory_static_min': 0, 'HVM_boot_policy': '', 'domid': 27, 'VCPUs_max': 1, 'start_time': 1220293470.0187321, 'online_vcpus': 1, 'memory_static_max': 33554432, 'actions_after_shutdown': 'destroy', 'on_xend_start': 'ignore', 'crashed': 0, 'memory_dynamic_max': 33554432, 'actions_after_suspend': '', 'is_a_template': False, 'is_control_domain': False, 'uuid': '5074920e-4cda-4eaa-20c1-6ced639e45d2', 'cpu_time': 0.0, 'shadow_memory': 0, 'target': 26, 'PV_bootloader_args': '', 'notes': {}, 'other_config': {}, 'running': 0, 'devices': {'55b2b10f-4ebd-7beb-16e8-9b44eb3daa13': ('vif', {'bridge': 'eth0', 'mac': '00:16:3e:7d:9f:1a', 'devid': 1, 'uuid': '55b2b10f-4ebd-7beb-16e8-9b44eb3daa13'}), '4dc370c5-218d-4d6f-fcc6-b8248c558ad3': ('console', {'other_config': {}, 'protocol': 'vt100', 'uuid': '4dc370c5-218d-4d6f-fcc6-b8248c558ad3', 'location': '2'}), '433e6c5f-45ff-25f3-2f26-3f67fb148de5': ('vbd', {'uuid': '433e6c5f-45ff-25f3-2f26-3f67fb148de5', 'bootable': 1, 'devid': 768, 'driver': 'paravirtualised', 'dev': 'hda', 'uname': 'phy:/dev/empirevg/lenny.hvm', 'mode': 'w'}), '15bd6bc8-1c3d-5737-325a-2ed58c50bb05': ('vbd', {'uuid': '15bd6bc8-1c3d-5737-325a-2ed58c50bb05', 'bootable': 0, 'devid': 5632, 'driver': 'paravirtualised', 'dev': 'hdc:cdrom', 'uname': 'file:/home/iso/debian-LennyBeta2-amd64-CD-1.iso', 'mode': 'r'}), 'f0df36ec-e573-c742-a6f0-0243997be6c8': ('vif', {'ip': '172.30.206.1', 'mac': '00:16:3e:65:6f:6c', 'devid': 0, 'uuid': 'f0df36ec-e573-c742-a6f0-0243997be6c8'}), '246f7df4-65a1-6b94-c5d3-34ef1e5f7171': ('vkbd', {'devid': 0, 'uuid': '246f7df4-65a1-6b94-c5d3-34ef1e5f7171'}), '2ced39ef-df51-aadf-f21c-59e428156a05': ('vfb', {'other_config': {'type': 'vnc', 'xauthority': '/root/.Xauthority'}, 'xauthority': '/root/.Xauthority', 'devid': 0, 'location': 'localhost:5900', 'type': 'vnc', 'uuid': '2ced39ef-df51-aadf-f21c-59e428156a05'})}, 'vif_refs': ['f0df36ec-e573-c742-a6f0-0243997be6c8', '55b2b10f-4ebd-7beb-16e8-9b44eb3daa13'], 'vtpm_refs': []}
[2008-09-01 15:24:30 17368] TRACE (XendDomainInfo:2835) XendDomainInfo.update({'paused': 0, 'cpu_time': 837131211323L, 'ssidref': 0, 'hvm': 0, 'shutdown_reason': 0, 'dying': 0, 'mem_kb': 1046528L, 'domid': 0, 'max_vcpu_id': 1, 'crashed': 0, 'running': 1, 'maxmem_kb': 17179869180L, 'shutdown': 0, 'online_vcpus': 2, 'handle': [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0], 'blocked': 0}) on domain 0
[2008-09-01 15:24:30 17368] TRACE (XendDomainInfo:2860) XendDomainInfo.update done on domain 0: {'vcpus_params': {}, 'PV_args': '', 'features': '', 'cpus': [[0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30, 31], [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30, 31]], 'paused': 0, 'shutdown_reason': 0, 'actions_after_reboot': 'restart', 'shutdown': 0, 'VCPUs_live': 1, 'PV_bootloader': '', 'actions_after_crash': 'restart', 'vbd_refs': [], 'PV_ramdisk': '', 'memory_dynamic_min': 1071644672L, 'name_label': 'Domain-0', 'VCPUs_at_startup': 1, 'HVM_boot_params': {}, 'platform': {}, 'PV_kernel': '', 'console_refs': [], 'online_vcpus': 2, 'blocked': 0, 'on_xend_stop': 'ignore', 'memory_static_min': 0, 'HVM_boot_policy': '', 'domid': 0, 'VCPUs_max': 2, 'memory_static_max': 17592186040320L, 'actions_after_shutdown': 'destroy', 'on_xend_start': 'ignore', 'crashed': 0, 'memory_dynamic_max': 1071644672L, 'actions_after_suspend': '', 'is_a_template': False, 'vcpu_avail': 3, 'is_control_domain': True, 'uuid': '00000000-0000-0000-0000-000000000000', 'cpu_time': 837.131211323, 'shadow_memory': 0, 'target': 0, 'PV_bootloader_args': '', 'other_config': {}, 'running': 1, 'devices': {}, 'vif_refs': [], 'vtpm_refs': [], 'dying': 0}
[2008-09-01 15:24:30 17368] TRACE (XendDomainInfo:2835) XendDomainInfo.update({'paused': 0, 'cpu_time': 2135437L, 'ssidref': 0, 'hvm': 1, 'shutdown_reason': 0, 'dying': 0, 'mem_kb': 524156L, 'domid': 26, 'max_vcpu_id': 0, 'crashed': 0, 'running': 0, 'maxmem_kb': 532480L, 'shutdown': 0, 'online_vcpus': 1, 'handle': [180, 85, 38, 183, 122, 250, 22, 151, 201, 56, 43, 237, 105, 37, 160, 63], 'blocked': 0}) on domain 26
[2008-09-01 15:24:30 17368] TRACE (XendDomainInfo:2860) XendDomainInfo.update done on domain 26: {'vcpus_params': {'cap': 0, 'weight': 256}, 'PV_args': '', 'features': '', 'cpus': [[]], 'paused': 0, 'shutdown_reason': 0, 'actions_after_reboot': 'restart', 'vcpu_avail': 1, 'VCPUs_live': 1, 'PV_bootloader': '', 'actions_after_crash': 'restart', 'vbd_refs': [], 'PV_ramdisk': '', 'memory_dynamic_min': 536870912, 'name_label': 'hvmtest', 'VCPUs_at_startup': 1, 'HVM_boot_params': {'order': 'c'}, 'platform': {'hpet': 0, 'stdvga': 0, 'vnclisten': '172.30.206.1', 'loader': '/usr/lib/xen/boot/hvmloader', 'rtc_timeoffset': '0', 'vncunused': 1, 'monitor': 0, 'opengl': 0, 'boot': 'c', 'pci': [], 'pae': 1, 'hap': 1, 'acpi': 1, 'localtime': 0, 'timer_mode': 0, 'vnc': 0, 'nographic': 0, 'apic': 1, 'sdl': 0, 'usb': 0, 'guest_os_type': 'default', 'device_model': '/usr/lib/xen/bin/stubdom-dm', 'xauthority': '/root/.Xauthority', 'isa': 0}, 'PV_kernel': '', 'console_refs': ['641d720a-13a0-84fb-8c74-f2573cb52cfb'], 'shutdown': 0, 'dying': 0, 'blocked': 0, 'on_xend_stop': 'ignore', 'memory_static_min': 0, 'HVM_boot_policy': 'BIOS order', 'domid': 26, 'VCPUs_max': 1, 'start_time': 1220293468.2403619, 'online_vcpus': 1, 'memory_static_max': 536870912, 'actions_after_shutdown': 'destroy', 'on_xend_start': 'ignore', 'crashed': 0, 'memory_dynamic_max': 536870912, 'actions_after_suspend': '', 'is_a_template': False, 'is_control_domain': False, 'uuid': 'b45526b7-7afa-1697-c938-2bed6925a03f', 'cpu_time': 0.002135437, 'shadow_memory': 5, 'target': 0, 'PV_bootloader_args': '', 'notes': {'SUSPEND_CANCEL': 1}, 'other_config': {}, 'running': 0, 'devices': {'641d720a-13a0-84fb-8c74-f2573cb52cfb': ('console', {'other_config': {}, 'protocol': 'vt100', 'uuid': '641d720a-13a0-84fb-8c74-f2573cb52cfb', 'location': '3'}), 'db4dfe4b-b73c-290d-148b-d66e2bfb4467': ('vif', {'bridge': 'eth0', 'mac': '00:16:3e:20:7c:6c', 'devid': 0, 'type': 'ioemu', 'uuid': 'db4dfe4b-b73c-290d-148b-d66e2bfb4467'})}, 'vif_refs': ['db4dfe4b-b73c-290d-148b-d66e2bfb4467'], 'vtpm_refs': []}
[2008-09-01 15:24:30 17368] TRACE (XendDomainInfo:2835) XendDomainInfo.update({'paused': 1, 'cpu_time': 0L, 'ssidref': 0, 'hvm': 0, 'shutdown_reason': 0, 'dying': 0, 'mem_kb': 32768L, 'domid': 27, 'max_vcpu_id': 0, 'crashed': 0, 'running': 0, 'maxmem_kb': 32768L, 'shutdown': 0, 'online_vcpus': 1, 'handle': [80, 116, 146, 14, 76, 218, 78, 170, 32, 193, 108, 237, 99, 158, 69, 210], 'blocked': 0}) on domain 27
[2008-09-01 15:24:30 17368] TRACE (XendDomainInfo:2860) XendDomainInfo.update done on domain 27: {'vcpus_params': {'cap': 0, 'weight': 256}, 'PV_args': ' -d 26', 'features': '', 'cpus': [[]], 'paused': 1, 'shutdown_reason': 0, 'actions_after_reboot': 'restart', 'vcpu_avail': 1, 'VCPUs_live': 1, 'PV_bootloader': '', 'actions_after_crash': 'restart', 'vbd_refs': ['433e6c5f-45ff-25f3-2f26-3f67fb148de5', '15bd6bc8-1c3d-5737-325a-2ed58c50bb05'], 'PV_ramdisk': '', 'memory_dynamic_min': 33554432, 'name_label': 'hvmtest-dm', 'VCPUs_at_startup': 1, 'HVM_boot_params': {}, 'platform': {'device_model': '/usr/lib64/xen/bin/qemu-dm'}, 'PV_kernel': '/usr/lib/xen/boot/ioemu-stubdom.gz', 'console_refs': ['2ced39ef-df51-aadf-f21c-59e428156a05', '4dc370c5-218d-4d6f-fcc6-b8248c558ad3'], 'shutdown': 0, 'dying': 0, 'blocked': 0, 'on_xend_stop': 'ignore', 'memory_static_min': 0, 'HVM_boot_policy': '', 'domid': 27, 'VCPUs_max': 1, 'start_time': 1220293470.0187321, 'online_vcpus': 1, 'memory_static_max': 33554432, 'actions_after_shutdown': 'destroy', 'on_xend_start': 'ignore', 'crashed': 0, 'memory_dynamic_max': 33554432, 'actions_after_suspend': '', 'is_a_template': False, 'is_control_domain': False, 'uuid': '5074920e-4cda-4eaa-20c1-6ced639e45d2', 'cpu_time': 0.0, 'shadow_memory': 0, 'target': 26, 'PV_bootloader_args': '', 'notes': {}, 'other_config': {}, 'running': 0, 'devices': {'55b2b10f-4ebd-7beb-16e8-9b44eb3daa13': ('vif', {'bridge': 'eth0', 'mac': '00:16:3e:7d:9f:1a', 'devid': 1, 'uuid': '55b2b10f-4ebd-7beb-16e8-9b44eb3daa13'}), '4dc370c5-218d-4d6f-fcc6-b8248c558ad3': ('console', {'other_config': {}, 'protocol': 'vt100', 'uuid': '4dc370c5-218d-4d6f-fcc6-b8248c558ad3', 'location': '2'}), '433e6c5f-45ff-25f3-2f26-3f67fb148de5': ('vbd', {'uuid': '433e6c5f-45ff-25f3-2f26-3f67fb148de5', 'bootable': 1, 'devid': 768, 'driver': 'paravirtualised', 'dev': 'hda', 'uname': 'phy:/dev/empirevg/lenny.hvm', 'mode': 'w'}), '15bd6bc8-1c3d-5737-325a-2ed58c50bb05': ('vbd', {'uuid': '15bd6bc8-1c3d-5737-325a-2ed58c50bb05', 'bootable': 0, 'devid': 5632, 'driver': 'paravirtualised', 'dev': 'hdc:cdrom', 'uname': 'file:/home/iso/debian-LennyBeta2-amd64-CD-1.iso', 'mode': 'r'}), 'f0df36ec-e573-c742-a6f0-0243997be6c8': ('vif', {'ip': '172.30.206.1', 'mac': '00:16:3e:65:6f:6c', 'devid': 0, 'uuid': 'f0df36ec-e573-c742-a6f0-0243997be6c8'}), '246f7df4-65a1-6b94-c5d3-34ef1e5f7171': ('vkbd', {'devid': 0, 'uuid': '246f7df4-65a1-6b94-c5d3-34ef1e5f7171'}), '2ced39ef-df51-aadf-f21c-59e428156a05': ('vfb', {'other_config': {'type': 'vnc', 'xauthority': '/root/.Xauthority'}, 'xauthority': '/root/.Xauthority', 'devid': 0, 'location': 'localhost:5900', 'type': 'vnc', 'uuid': '2ced39ef-df51-aadf-f21c-59e428156a05'})}, 'vif_refs': ['f0df36ec-e573-c742-a6f0-0243997be6c8', '55b2b10f-4ebd-7beb-16e8-9b44eb3daa13'], 'vtpm_refs': []}
[2008-09-01 15:24:30 17368] DEBUG (DevController:155) Waiting for devices vif.
[2008-09-01 15:24:30 17368] DEBUG (DevController:160) Waiting for 0.
[2008-09-01 15:24:30 17368] DEBUG (DevController:645) hotplugStatusCallback /local/domain/0/backend/vif/27/0/hotplug-status.
[2008-09-01 15:24:30 17368] DEBUG (DevController:659) hotplugStatusCallback 1.
[2008-09-01 15:24:30 17368] DEBUG (DevController:160) Waiting for 1.
[2008-09-01 15:24:30 17368] DEBUG (DevController:645) hotplugStatusCallback /local/domain/0/backend/vif/27/1/hotplug-status.
[2008-09-01 15:24:30 17368] DEBUG (DevController:659) hotplugStatusCallback 1.
[2008-09-01 15:24:30 17368] DEBUG (DevController:155) Waiting for devices vscsi.
[2008-09-01 15:24:30 17368] DEBUG (DevController:155) Waiting for devices vbd.
[2008-09-01 15:24:30 17368] DEBUG (DevController:160) Waiting for 768.
[2008-09-01 15:24:30 17368] DEBUG (DevController:645) hotplugStatusCallback /local/domain/0/backend/vbd/27/768/hotplug-status.
[2008-09-01 15:24:30 17368] DEBUG (DevController:645) hotplugStatusCallback /local/domain/0/backend/vbd/27/768/hotplug-status.
[2008-09-01 15:24:30 17368] DEBUG (DevController:659) hotplugStatusCallback 1.
[2008-09-01 15:24:30 17368] DEBUG (DevController:160) Waiting for 5632.
[2008-09-01 15:24:30 17368] DEBUG (DevController:645) hotplugStatusCallback /local/domain/0/backend/vbd/27/5632/hotplug-status.
[2008-09-01 15:24:30 17368] DEBUG (DevController:659) hotplugStatusCallback 1.
[2008-09-01 15:24:30 17368] DEBUG (DevController:155) Waiting for devices irq.
[2008-09-01 15:24:30 17368] DEBUG (DevController:155) Waiting for devices vkbd.
[2008-09-01 15:24:30 17368] DEBUG (DevController:155) Waiting for devices vfb.
[2008-09-01 15:24:30 17368] DEBUG (DevController:155) Waiting for devices console.
[2008-09-01 15:24:30 17368] DEBUG (DevController:160) Waiting for 0.
[2008-09-01 15:24:30 17368] DEBUG (DevController:155) Waiting for devices pci.
[2008-09-01 15:24:30 17368] DEBUG (DevController:155) Waiting for devices ioports.
[2008-09-01 15:24:30 17368] DEBUG (DevController:155) Waiting for devices tap.
[2008-09-01 15:24:30 17368] DEBUG (DevController:155) Waiting for devices vtpm.
[2008-09-01 15:24:30 17368] INFO (XendDomain:1172) Domain hvmtest-dm (27) unpaused.
[2008-09-01 15:24:32 17368] TRACE (XendDomainInfo:2835) XendDomainInfo.update({'paused': 0, 'cpu_time': 838061786222L, 'ssidref': 0, 'hvm': 0, 'shutdown_reason': 0, 'dying': 0, 'mem_kb': 1046016L, 'domid': 0, 'max_vcpu_id': 1, 'crashed': 0, 'running': 1, 'maxmem_kb': 17179869180L, 'shutdown': 0, 'online_vcpus': 2, 'handle': [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0], 'blocked': 0}) on domain 0
[2008-09-01 15:24:32 17368] TRACE (XendDomainInfo:2860) XendDomainInfo.update done on domain 0: {'vcpus_params': {}, 'PV_args': '', 'features': '', 'cpus': [[0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30, 31], [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30, 31]], 'paused': 0, 'shutdown_reason': 0, 'actions_after_reboot': 'restart', 'shutdown': 0, 'VCPUs_live': 1, 'PV_bootloader': '', 'actions_after_crash': 'restart', 'vbd_refs': [], 'PV_ramdisk': '', 'memory_dynamic_min': 1071644672L, 'name_label': 'Domain-0', 'VCPUs_at_startup': 1, 'HVM_boot_params': {}, 'platform': {}, 'PV_kernel': '', 'console_refs': [], 'online_vcpus': 2, 'blocked': 0, 'on_xend_stop': 'ignore', 'memory_static_min': 0, 'HVM_boot_policy': '', 'domid': 0, 'VCPUs_max': 2, 'memory_static_max': 17592186040320L, 'actions_after_shutdown': 'destroy', 'on_xend_start': 'ignore', 'crashed': 0, 'memory_dynamic_max': 1071644672L, 'actions_after_suspend': '', 'is_a_template': False, 'vcpu_avail': 3, 'is_control_domain': True, 'uuid': '00000000-0000-0000-0000-000000000000', 'cpu_time': 838.06178622200002, 'shadow_memory': 0, 'target': 0, 'PV_bootloader_args': '', 'other_config': {}, 'running': 1, 'devices': {}, 'vif_refs': [], 'vtpm_refs': [], 'dying': 0}
[2008-09-01 15:24:32 17368] TRACE (XendDomainInfo:2835) XendDomainInfo.update({'paused': 0, 'cpu_time': 1118818002L, 'ssidref': 0, 'hvm': 1, 'shutdown_reason': 0, 'dying': 0, 'mem_kb': 532348L, 'domid': 26, 'max_vcpu_id': 0, 'crashed': 0, 'running': 0, 'maxmem_kb': 532480L, 'shutdown': 1, 'online_vcpus': 0, 'handle': [180, 85, 38, 183, 122, 250, 22, 151, 201, 56, 43, 237, 105, 37, 160, 63], 'blocked': 0}) on domain 26
[2008-09-01 15:24:32 17368] INFO (XendDomainInfo:1634) Domain has shutdown: name=hvmtest id=26 reason=poweroff.
[2008-09-01 15:24:32 17368] DEBUG (XendDomainInfo:2389) XendDomainInfo.destroy: domid=26
[2008-09-01 15:24:32 17368] TRACE (XendDomainInfo:2860) XendDomainInfo.update done on domain 26: {'vcpus_params': {'cap': 0, 'weight': 256}, 'PV_args': '', 'features': '', 'cpus': [[]], 'paused': 0, 'shutdown_reason': 0, 'actions_after_reboot': 'restart', 'vcpu_avail': 1, 'VCPUs_live': 1, 'PV_bootloader': '', 'actions_after_crash': 'restart', 'vbd_refs': [], 'PV_ramdisk': '', 'memory_dynamic_min': 536870912, 'name_label': 'hvmtest', 'VCPUs_at_startup': 1, 'HVM_boot_params': {'order': 'c'}, 'platform': {'hpet': 0, 'stdvga': 0, 'vnclisten': '172.30.206.1', 'loader': '/usr/lib/xen/boot/hvmloader', 'rtc_timeoffset': '0', 'vncunused': 1, 'monitor': 0, 'opengl': 0, 'boot': 'c', 'pci': [], 'pae': 1, 'hap': 1, 'acpi': 1, 'localtime': 0, 'timer_mode': 0, 'vnc': 0, 'nographic': 0, 'apic': 1, 'sdl': 0, 'usb': 0, 'guest_os_type': 'default', 'device_model': '/usr/lib/xen/bin/stubdom-dm', 'xauthority': '/root/.Xauthority', 'isa': 0}, 'PV_kernel': '', 'console_refs': ['641d720a-13a0-84fb-8c74-f2573cb52cfb'], 'shutdown': 1, 'dying': 0, 'blocked': 0, 'on_xend_stop': 'ignore', 'memory_static_min': 0, 'HVM_boot_policy': 'BIOS order', 'domid': 26, 'VCPUs_max': 1, 'start_time': 1220293468.2403619, 'online_vcpus': 0, 'memory_static_max': 536870912, 'actions_after_shutdown': 'destroy', 'on_xend_start': 'ignore', 'crashed': 0, 'memory_dynamic_max': 536870912, 'actions_after_suspend': '', 'is_a_template': False, 'is_control_domain': False, 'uuid': 'b45526b7-7afa-1697-c938-2bed6925a03f', 'cpu_time': 1.118818002, 'shadow_memory': 5, 'target': 0, 'PV_bootloader_args': '', 'notes': {'SUSPEND_CANCEL': 1}, 'other_config': {}, 'running': 0, 'devices': {'641d720a-13a0-84fb-8c74-f2573cb52cfb': ('console', {'other_config': {}, 'protocol': 'vt100', 'uuid': '641d720a-13a0-84fb-8c74-f2573cb52cfb', 'location': '3'}), 'db4dfe4b-b73c-290d-148b-d66e2bfb4467': ('vif', {'bridge': 'eth0', 'mac': '00:16:3e:20:7c:6c', 'devid': 0, 'type': 'ioemu', 'uuid': 'db4dfe4b-b73c-290d-148b-d66e2bfb4467'})}, 'vif_refs': ['db4dfe4b-b73c-290d-148b-d66e2bfb4467'], 'vtpm_refs': []}
[2008-09-01 15:24:32 17368] TRACE (XendDomainInfo:2835) XendDomainInfo.update({'paused': 0, 'cpu_time': 443911820L, 'ssidref': 0, 'hvm': 0, 'shutdown_reason': 0, 'dying': 0, 'mem_kb': 32768L, 'domid': 27, 'max_vcpu_id': 0, 'crashed': 0, 'running': 0, 'maxmem_kb': 32768L, 'shutdown': 0, 'online_vcpus': 1, 'handle': [80, 116, 146, 14, 76, 218, 78, 170, 32, 193, 108, 237, 99, 158, 69, 210], 'blocked': 1}) on domain 27
[2008-09-01 15:24:32 17368] DEBUG (XendDomainInfo:2406) XendDomainInfo.destroyDomain(26)
[2008-09-01 15:24:32 17368] TRACE (XendDomainInfo:2860) XendDomainInfo.update done on domain 27: {'vcpus_params': {'cap': 0, 'weight': 256}, 'PV_args': ' -d 26', 'features': '', 'cpus': [[]], 'paused': 0, 'shutdown_reason': 0, 'actions_after_reboot': 'restart', 'vcpu_avail': 1, 'VCPUs_live': 1, 'PV_bootloader': '', 'actions_after_crash': 'restart', 'vbd_refs': ['433e6c5f-45ff-25f3-2f26-3f67fb148de5', '15bd6bc8-1c3d-5737-325a-2ed58c50bb05'], 'PV_ramdisk': '', 'memory_dynamic_min': 33554432, 'name_label': 'hvmtest-dm', 'VCPUs_at_startup': 1, 'HVM_boot_params': {}, 'platform': {'device_model': '/usr/lib64/xen/bin/qemu-dm'}, 'PV_kernel': '/usr/lib/xen/boot/ioemu-stubdom.gz', 'console_refs': ['2ced39ef-df51-aadf-f21c-59e428156a05', '4dc370c5-218d-4d6f-fcc6-b8248c558ad3'], 'shutdown': 0, 'dying': 0, 'blocked': 1, 'on_xend_stop': 'ignore', 'memory_static_min': 0, 'HVM_boot_policy': '', 'domid': 27, 'VCPUs_max': 1, 'start_time': 1220293470.0187321, 'online_vcpus': 1, 'memory_static_max': 33554432, 'actions_after_shutdown': 'destroy', 'on_xend_start': 'ignore', 'crashed': 0, 'memory_dynamic_max': 33554432, 'actions_after_suspend': '', 'is_a_template': False, 'is_control_domain': False, 'uuid': '5074920e-4cda-4eaa-20c1-6ced639e45d2', 'cpu_time': 0.44391182000000001, 'shadow_memory': 0, 'target': 26, 'PV_bootloader_args': '', 'notes': {}, 'other_config': {}, 'running': 0, 'devices': {'55b2b10f-4ebd-7beb-16e8-9b44eb3daa13': ('vif', {'bridge': 'eth0', 'mac': '00:16:3e:7d:9f:1a', 'devid': 1, 'uuid': '55b2b10f-4ebd-7beb-16e8-9b44eb3daa13'}), '4dc370c5-218d-4d6f-fcc6-b8248c558ad3': ('console', {'other_config': {}, 'protocol': 'vt100', 'uuid': '4dc370c5-218d-4d6f-fcc6-b8248c558ad3', 'location': '2'}), '433e6c5f-45ff-25f3-2f26-3f67fb148de5': ('vbd', {'uuid': '433e6c5f-45ff-25f3-2f26-3f67fb148de5', 'bootable': 1, 'devid': 768, 'driver': 'paravirtualised', 'dev': 'hda', 'uname': 'phy:/dev/empirevg/lenny.hvm', 'mode': 'w'}), '15bd6bc8-1c3d-5737-325a-2ed58c50bb05': ('vbd', {'uuid': '15bd6bc8-1c3d-5737-325a-2ed58c50bb05', 'bootable': 0, 'devid': 5632, 'driver': 'paravirtualised', 'dev': 'hdc:cdrom', 'uname': 'file:/home/iso/debian-LennyBeta2-amd64-CD-1.iso', 'mode': 'r'}), 'f0df36ec-e573-c742-a6f0-0243997be6c8': ('vif', {'ip': '172.30.206.1', 'mac': '00:16:3e:65:6f:6c', 'devid': 0, 'uuid': 'f0df36ec-e573-c742-a6f0-0243997be6c8'}), '246f7df4-65a1-6b94-c5d3-34ef1e5f7171': ('vkbd', {'devid': 0, 'uuid': '246f7df4-65a1-6b94-c5d3-34ef1e5f7171'}), '2ced39ef-df51-aadf-f21c-59e428156a05': ('vfb', {'other_config': {'type': 'vnc', 'xauthority': '/root/.Xauthority'}, 'xauthority': '/root/.Xauthority', 'devid': 0, 'location': 'localhost:5900', 'type': 'vnc', 'uuid': '2ced39ef-df51-aadf-f21c-59e428156a05'})}, 'vif_refs': ['f0df36ec-e573-c742-a6f0-0243997be6c8', '55b2b10f-4ebd-7beb-16e8-9b44eb3daa13'], 'vtpm_refs': []}
[2008-09-01 15:24:32 17368] DEBUG (XendDomainInfo:1939) Destroying device model
[2008-09-01 15:24:32 17368] DEBUG (XendDomainInfo:1946) Releasing devices
[2008-09-01 15:24:32 17368] DEBUG (XendDomainInfo:1952) Removing vif/0
[2008-09-01 15:24:32 17368] DEBUG (XendDomainInfo:888) XendDomainInfo.destroyDevice: deviceClass = vif, device = vif/0
[2008-09-01 15:24:32 17368] DEBUG (XendDomainInfo:1952) Removing console/0
[2008-09-01 15:24:32 17368] DEBUG (XendDomainInfo:888) XendDomainInfo.destroyDevice: deviceClass = console, device = console/0
[2008-09-01 15:24:32 17368] DEBUG (XendDomainInfo:2389) XendDomainInfo.destroy: domid=27
[2008-09-01 15:24:32 17368] DEBUG (XendDomainInfo:2406) XendDomainInfo.destroyDomain(27)
[2008-09-01 15:24:32 17368] DEBUG (XendDomainInfo:1939) Destroying device model
[2008-09-01 15:24:33 17368] WARNING (image:472) domain hvmtest-dm: device model failure: no longer running; see /var/log/xen/qemu-dm-hvmtest-dm.log 
[2008-09-01 15:24:33 17368] DEBUG (XendDomainInfo:1946) Releasing devices
[2008-09-01 15:24:33 17368] DEBUG (XendDomainInfo:1952) Removing vif/0
[2008-09-01 15:24:33 17368] DEBUG (XendDomainInfo:888) XendDomainInfo.destroyDevice: deviceClass = vif, device = vif/0
[2008-09-01 15:24:33 17368] DEBUG (XendDomainInfo:1952) Removing vif/1
[2008-09-01 15:24:33 17368] DEBUG (XendDomainInfo:888) XendDomainInfo.destroyDevice: deviceClass = vif, device = vif/1
[2008-09-01 15:24:33 17368] DEBUG (XendDomainInfo:1952) Removing vbd/768
[2008-09-01 15:24:33 17368] DEBUG (XendDomainInfo:888) XendDomainInfo.destroyDevice: deviceClass = vbd, device = vbd/768
[2008-09-01 15:24:33 17368] DEBUG (XendDomainInfo:1952) Removing vbd/5632
[2008-09-01 15:24:33 17368] DEBUG (XendDomainInfo:888) XendDomainInfo.destroyDevice: deviceClass = vbd, device = vbd/5632
[2008-09-01 15:24:33 17368] DEBUG (XendDomainInfo:1952) Removing vkbd/0
[2008-09-01 15:24:33 17368] DEBUG (XendDomainInfo:888) XendDomainInfo.destroyDevice: deviceClass = vkbd, device = vkbd/0
[2008-09-01 15:24:33 17368] DEBUG (XendDomainInfo:1952) Removing vfb/0
[2008-09-01 15:24:33 17368] DEBUG (XendDomainInfo:888) XendDomainInfo.destroyDevice: deviceClass = vfb, device = vfb/0
[2008-09-01 15:24:33 17368] DEBUG (XendDomainInfo:1952) Removing console/0
[2008-09-01 15:24:33 17368] DEBUG (XendDomainInfo:888) XendDomainInfo.destroyDevice: deviceClass = console, device = console/0
[2008-09-01 15:24:33 17368] TRACE (XendDomainInfo:2835) XendDomainInfo.update({'paused': 0, 'cpu_time': 839402978583L, 'ssidref': 0, 'hvm': 0, 'shutdown_reason': 0, 'dying': 0, 'mem_kb': 1046016L, 'domid': 0, 'max_vcpu_id': 1, 'crashed': 0, 'running': 1, 'maxmem_kb': 17179869180L, 'shutdown': 0, 'online_vcpus': 2, 'handle': [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0], 'blocked': 0}) on domain 0
[2008-09-01 15:24:33 17368] TRACE (XendDomainInfo:2860) XendDomainInfo.update done on domain 0: {'vcpus_params': {}, 'PV_args': '', 'features': '', 'cpus': [[0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30, 31], [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30, 31]], 'paused': 0, 'shutdown_reason': 0, 'actions_after_reboot': 'restart', 'shutdown': 0, 'VCPUs_live': 1, 'PV_bootloader': '', 'actions_after_crash': 'restart', 'vbd_refs': [], 'PV_ramdisk': '', 'memory_dynamic_min': 1071644672L, 'name_label': 'Domain-0', 'VCPUs_at_startup': 1, 'HVM_boot_params': {}, 'platform': {}, 'PV_kernel': '', 'console_refs': [], 'online_vcpus': 2, 'blocked': 0, 'on_xend_stop': 'ignore', 'memory_static_min': 0, 'HVM_boot_policy': '', 'domid': 0, 'VCPUs_max': 2, 'memory_static_max': 17592186040320L, 'actions_after_shutdown': 'destroy', 'on_xend_start': 'ignore', 'crashed': 0, 'memory_dynamic_max': 1071644672L, 'actions_after_suspend': '', 'is_a_template': False, 'vcpu_avail': 3, 'is_control_domain': True, 'uuid': '00000000-0000-0000-0000-000000000000', 'cpu_time': 839.40297858300005, 'shadow_memory': 0, 'target': 0, 'PV_bootloader_args': '', 'other_config': {}, 'running': 1, 'devices': {}, 'vif_refs': [], 'vtpm_refs': [], 'dying': 0}
[2008-09-01 15:24:33 17368] DEBUG (XendDomainInfo:1944) No device model
[2008-09-01 15:24:33 17368] DEBUG (XendDomainInfo:1946) Releasing devices
[2008-09-01 15:24:33 17368] TRACE (XendDomainInfo:2835) XendDomainInfo.update({'paused': 0, 'cpu_time': 839517351104L, 'ssidref': 0, 'hvm': 0, 'shutdown_reason': 0, 'dying': 0, 'mem_kb': 1046016L, 'domid': 0, 'max_vcpu_id': 1, 'crashed': 0, 'running': 1, 'maxmem_kb': 17179869180L, 'shutdown': 0, 'online_vcpus': 2, 'handle': [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0], 'blocked': 0}) on domain 0
[2008-09-01 15:24:33 17368] TRACE (XendDomainInfo:2860) XendDomainInfo.update done on domain 0: {'vcpus_params': {}, 'PV_args': '', 'features': '', 'cpus': [[0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30, 31], [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30, 31]], 'paused': 0, 'shutdown_reason': 0, 'actions_after_reboot': 'restart', 'shutdown': 0, 'VCPUs_live': 1, 'PV_bootloader': '', 'actions_after_crash': 'restart', 'vbd_refs': [], 'PV_ramdisk': '', 'memory_dynamic_min': 1071644672L, 'name_label': 'Domain-0', 'VCPUs_at_startup': 1, 'HVM_boot_params': {}, 'platform': {}, 'PV_kernel': '', 'console_refs': [], 'online_vcpus': 2, 'blocked': 0, 'on_xend_stop': 'ignore', 'memory_static_min': 0, 'HVM_boot_policy': '', 'domid': 0, 'VCPUs_max': 2, 'memory_static_max': 17592186040320L, 'actions_after_shutdown': 'destroy', 'on_xend_start': 'ignore', 'crashed': 0, 'memory_dynamic_max': 1071644672L, 'actions_after_suspend': '', 'is_a_template': False, 'vcpu_avail': 3, 'is_control_domain': True, 'uuid': '00000000-0000-0000-0000-000000000000', 'cpu_time': 839.517351104, 'shadow_memory': 0, 'target': 0, 'PV_bootloader_args': '', 'other_config': {}, 'running': 1, 'devices': {}, 'vif_refs': [], 'vtpm_refs': [], 'dying': 0}
[2008-09-01 15:25:28 17368] WARNING (image:472) domain hvmtest: device model failure: no longer running; see /var/log/xen/qemu-dm-hvmtest.log 

[-- Attachment #3: Type: text/plain, Size: 138 bytes --]

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

Re: stubdom problem

[Samuel Thibault]

Marco Sinhoreli, le Mon 01 Sep 2008 15:24:10 -0300, a écrit :
> I increase the debug level of xend.

I was referring to the debug level of the hypervisor. Add
guest_loglvl=all
to your hypervisor command line, and look for HVM: lines in xm dmesg.

Samuel

Re: stubdom problem

[Marco Sinhoreli]

Hi Samuel,

I found the problem:
In qemu start, the hard disk is the default bootable device.

(XEN) HVM30: HVM Loader
(XEN) HVM30: Detected Xen v3.3.0
(XEN) HVM30: CPU speed is 2810 MHz
(XEN) HVM30: Multiprocessor initialisation:
(XEN) HVM30:  - CPU0 ... 36-bit phys ... fixed MTRRs ... var MTRRs ... done.
(XEN) HVM30: Writing SMBIOS tables ...
(XEN) HVM30: Loading ROMBIOS ...
(XEN) HVM30: 9452 bytes of ROMBIOS high-memory extensions:
(XEN) HVM30:   Relocating to 0x1fff8800-0x1fffacec ... done
(XEN) irq.c:235: Dom30 PCI link 0 changed 0 -> 5
(XEN) HVM30: PCI-ISA link 0 routed to IRQ5
(XEN) irq.c:235: Dom30 PCI link 1 changed 0 -> 10
(XEN) HVM30: PCI-ISA link 1 routed to IRQ10
(XEN) irq.c:235: Dom30 PCI link 2 changed 0 -> 11
(XEN) HVM30: PCI-ISA link 2 routed to IRQ11
(XEN) irq.c:235: Dom30 PCI link 3 changed 0 -> 5
(XEN) HVM30: PCI-ISA link 3 routed to IRQ5
(XEN) HVM30: pci dev 01:2 INTA->IRQ10
(XEN) HVM30: pci dev 03:0 INTA->IRQ5
(XEN) HVM30: pci dev 04:0 INTA->IRQ5
(XEN) HVM30: pci dev 02:0 bar 10 size 02000000: f0000008
(XEN) HVM30: pci dev 03:0 bar 14 size 01000000: f2000008
(XEN) HVM30: pci dev 02:0 bar 14 size 00001000: f3000000
(XEN) HVM30: pci dev 03:0 bar 10 size 00000100: 0000c001
(XEN) HVM30: pci dev 04:0 bar 10 size 00000100: 0000c101
(XEN) HVM30: pci dev 04:0 bar 14 size 00000100: f3001000
(XEN) HVM30: pci dev 01:1 bar 20 size 00000010: 0000c201
(XEN) HVM30: Creating MP tables ...
(XEN) HVM30: Loading Cirrus VGABIOS ...
(XEN) HVM30: Loading PXE ROM ...
(XEN) HVM30:  - Manufacturer: Etherboot
(XEN) HVM30:  - Product name: rtl8139.zrom 5.4.2 (GPL) etherboot.org
(XEN) HVM30: Loading ACPI ...
(XEN) HVM30:  - Lo data: 000ea000-000ea03f
(XEN) HVM30:  - Hi data: 1fff7400-1fff87df
(XEN) HVM30: BIOS map:
(XEN) HVM30:  c0000-c8bff: VGA BIOS
(XEN) HVM30:  d0000-d7fff: Etherboot ROM
(XEN) HVM30:  e9000-e9140: SMBIOS tables
(XEN) HVM30:  f0000-fffff: Main BIOS
(XEN) HVM30: Invoking ROMBIOS ...
(XEN) HVM30:  rombios.c,v 1.138 2005/05/07 15:55:26 vruppert Exp $
(XEN) stdvga.c:147:d30 entering stdvga and caching modes
(XEN) HVM30: HVMAssist BIOS, 1 cpu, $Revision: 1.138 $ $Date:
2005/05/07 15:55:26 $
(XEN) HVM30:
(XEN) HVM30: ata0-0: PCHS=16383/16/63 translation=lba LCHS=1024/255/63
(XEN) HVM30: ata0 master: QEMU HARDDISK ATA-7 Hard-Disk (10240 MBytes)
(XEN) HVM30: ata0  slave: Unknown device
(XEN) HVM30: ata1 master: QEMU CD-ROM ATAPI-4 CD-Rom/DVD-Rom
(XEN) HVM30: ata1  slave: Unknown device
(XEN) HVM30:
(XEN) HVM30:
(XEN) HVM30:
(XEN) HVM30: Press F10 to select boot device.
(XEN) HVM30: Booting from Hard Disk...
(XEN) HVM30: Boot from Hard Disk failed: not a bootable disk
(XEN) HVM30: FATAL: No bootable device.
(XEN) hvm.c:727:d30 All CPUs offline -- powering off.

I set in config file to boot from cdrom setting the variable boot='dc'
 but it isn't working. Well, after start the virtual machine, I open
fastlly the vncviewer to connect to virtual machine and I pressed the
F10 key to select the #3 option to boot from CDrom and It worked.

(XEN) HVM32: HVM Loader
(XEN) HVM32: Detected Xen v3.3.0
(XEN) HVM32: CPU speed is 2810 MHz
(XEN) HVM32: Multiprocessor initialisation:
(XEN) HVM32:  - CPU0 ... 36-bit phys ... fixed MTRRs ... var MTRRs ... done.
(XEN) HVM32: Writing SMBIOS tables ...
(XEN) HVM32: Loading ROMBIOS ...
(XEN) HVM32: 9452 bytes of ROMBIOS high-memory extensions:
(XEN) HVM32:   Relocating to 0x1fff8800-0x1fffacec ... done
(XEN) irq.c:235: Dom32 PCI link 0 changed 0 -> 5
(XEN) HVM32: PCI-ISA link 0 routed to IRQ5
(XEN) irq.c:235: Dom32 PCI link 1 changed 0 -> 10
(XEN) HVM32: PCI-ISA link 1 routed to IRQ10
(XEN) irq.c:235: Dom32 PCI link 2 changed 0 -> 11
(XEN) HVM32: PCI-ISA link 2 routed to IRQ11
(XEN) irq.c:235: Dom32 PCI link 3 changed 0 -> 5
(XEN) HVM32: PCI-ISA link 3 routed to IRQ5
(XEN) HVM32: pci dev 01:2 INTA->IRQ10
(XEN) HVM32: pci dev 03:0 INTA->IRQ5
(XEN) HVM32: pci dev 04:0 INTA->IRQ5
(XEN) HVM32: pci dev 02:0 bar 10 size 02000000: f0000008
(XEN) HVM32: pci dev 03:0 bar 14 size 01000000: f2000008
(XEN) HVM32: pci dev 02:0 bar 14 size 00001000: f3000000
(XEN) HVM32: pci dev 03:0 bar 10 size 00000100: 0000c001
(XEN) HVM32: pci dev 04:0 bar 10 size 00000100: 0000c101
(XEN) HVM32: pci dev 04:0 bar 14 size 00000100: f3001000
(XEN) HVM32: pci dev 01:1 bar 20 size 00000010: 0000c201
(XEN) HVM32: Creating MP tables ...
(XEN) HVM32: Loading Cirrus VGABIOS ...
(XEN) HVM32: Loading PXE ROM ...
(XEN) HVM32:  - Manufacturer: Etherboot
(XEN) HVM32:  - Product name: rtl8139.zrom 5.4.2 (GPL) etherboot.org
(XEN) HVM32: Loading ACPI ...
(XEN) HVM32:  - Lo data: 000ea000-000ea03f
(XEN) HVM32:  - Hi data: 1fff7400-1fff87df
(XEN) HVM32: BIOS map:
(XEN) HVM32:  c0000-c8bff: VGA BIOS
(XEN) HVM32:  d0000-d7fff: Etherboot ROM
(XEN) HVM32:  e9000-e9140: SMBIOS tables
(XEN) HVM32:  f0000-fffff: Main BIOS
(XEN) HVM32: Invoking ROMBIOS ...
(XEN) HVM32:  rombios.c,v 1.138 2005/05/07 15:55:26 vruppert Exp $
(XEN) stdvga.c:147:d32 entering stdvga and caching modes
(XEN) HVM32: HVMAssist BIOS, 1 cpu, $Revision: 1.138 $ $Date:
2005/05/07 15:55:26 $
(XEN) HVM32:
(XEN) HVM32: ata0-0: PCHS=16383/16/63 translation=lba LCHS=1024/255/63
(XEN) HVM32: ata0 master: QEMU HARDDISK ATA-7 Hard-Disk (10240 MBytes)
(XEN) HVM32: ata0  slave: Unknown device
(XEN) HVM32: ata1 master: QEMU CD-ROM ATAPI-4 CD-Rom/DVD-Rom
(XEN) HVM32: ata1  slave: Unknown device
(XEN) HVM32:
(XEN) HVM32:
(XEN) HVM32:
(XEN) HVM32: Press F10 to select boot device.
(XEN) HVM32: Key pressed: 0044
(XEN) HVM32:
(XEN) HVM32:
(XEN) HVM32:
(XEN) HVM32:
(XEN) HVM32:
(XEN) HVM32:
(XEN) HVM32:
(XEN) HVM32:           Select boot device
(XEN) HVM32:
(XEN) HVM32:             1. Floppy
(XEN) HVM32:             2. Hard drive
(XEN) HVM32:             3. CD-ROM
(XEN) HVM32:             4. Network
(XEN) HVM32:
(XEN) HVM32:
(XEN) HVM32:           Currently selected: 3
(XEN) HVM32: Key pressed: 001C
(XEN) HVM32: Booting from CD-Rom...
(XEN) stdvga.c:151:d32 leaving stdvga
(XEN) common.c:3541:d33 tracking VRAM f0000 - f00f0

There is another way to set the default bootable device in conffile?
Something was changed? What changed?

Best regards,

-- 
Marco Sinhoreli

Re: stubdom problem

[Samuel Thibault]

Marco Sinhoreli, le Mon 01 Sep 2008 18:09:09 -0300, a écrit :
> I set in config file to boot from cdrom setting the variable boot='dc'

In hvmtest, right?

If so, can you check that the qemu-dm-hvmtest.log shows "-boot" "d"?

Samuel