[2012-01-17 17:25:49 2335] DEBUG (XendDomainInfo:103) XendDomainInfo.create(['vm', ['name', 'exchange-hvm'], ['memory', 512], ['on_poweroff', 'destroy'], ['on_reboot', 'restart'], ['on_crash', 'restart'], ['on_xend_start', 'ignore'], ['on_xend_stop', 'ignore'], ['cpuid', {'1': {'eax': '0x06b1', 'edx': 'xxx00000xxxxxxx0xxxxxxxxx0xxxxxx', 'ecx': 'xxxxxxxxxxx0000xx00xxx0000000xx0'}, '0': {'eax': '0x3', 'edx': '0x0', 'ebx': '0x0', 'ecx': '0x0'}, '0x80000000': {'eax': '0x3', 'edx': '0x0', 'ebx': '0x0', 'ecx': '0x0'}, '4': {'eax': '0x3', 'edx': '0x0', 'ebx': '0x0', 'ecx': '0x0'}}], ['vcpus', 1], ['oos', 1], ['image', ['hvm', ['kernel', 'hvmloader'], ['videoram', 4], ['serial', 'pty'], ['acpi', 1], ['apic', 1], ['boot', 'c'], ['cpuid', {'1': {'eax': '0x06b1', 'edx': 'xxx00000xxxxxxx0xxxxxxxxx0xxxxxx', 'ecx': 'xxxxxxxxxxx0000xx00xxx0000000xx0'}, '0': {'eax': '0x3', 'edx': '0x0', 'ebx': '0x0', 'ecx': '0x0'}, '0x80000000': {'eax': '0x3', 'edx': '0x0', 'ebx': '0x0', 'ecx': '0x0'}, '4': {'eax': '0x3', 'edx': '0x0', 'ebx': '0x0', 'ecx': '0x0'}}], ['cpuid_check', []], ['device_model', 'qemu-dm'], ['display', ':0.0'], ['fda', ''], ['fdb', ''], ['guest_os_type', 'default'], ['hap', 1], ['hpet', 0], ['isa', 0], ['keymap', ''], ['localtime', 0], ['nographic', 0], ['opengl', 1], ['oos', 1], ['pae', 1], ['pci', []], ['pci_msitranslate', 1], ['pci_power_mgmt', 0], ['rtc_timeoffset', 0], ['sdl', 0], ['soundhw', ''], ['stdvga', 0], ['timer_mode', 1], ['usb', 0], ['usbdevice', ''], ['vcpus', 1], ['vnc', 1], ['vncunused', 1], ['viridian', 0], ['vpt_align', 1], ['xauthority', '/home/antoine/.Xauthority'], ['xen_platform_pci', 1], ['memory_sharing', 0], ['vncpasswd', 'XXXXXXXX'], ['tsc_mode', 0], ['nomigrate', 0]]], ['s3_integrity', 1], ['device', ['tap2', ['uname', 'tap2:remus:192.168.2.4:9000|aio:/home/remus/win2k3-exchange.img'], ['dev', 'ioemu:hda'], ['mode', 'w']]], ['device', ['tap2', ['uname', 'tap2:remus:192.168.2.4:9000|aio:/home/remus/win2k3-exchange-d.img'], ['dev', 'ioemu:hdb'], ['mode', 'w']]], ['device', ['vif', ['bridge', 'xenbr0'], ['type', 'ioemu']]]])
[2012-01-17 17:25:49 2335] DEBUG (XendDomainInfo:2498) XendDomainInfo.constructDomain
[2012-01-17 17:25:49 2335] DEBUG (balloon:187) Balloon: 538328 KiB free; need 16384; done.
[2012-01-17 17:25:49 2335] DEBUG (XendDomain:476) Adding Domain: 14
[2012-01-17 17:25:49 2335] DEBUG (XendDomainInfo:2836) XendDomainInfo.initDomain: 14 256
[2012-01-17 17:25:49 2335] DEBUG (image:339) No VNC passwd configured for vfb access
[2012-01-17 17:25:49 2335] DEBUG (image:891) args: boot, val: c
[2012-01-17 17:25:49 2335] DEBUG (image:891) args: fda, val: None
[2012-01-17 17:25:49 2335] DEBUG (image:891) args: fdb, val: None
[2012-01-17 17:25:49 2335] DEBUG (image:891) args: soundhw, val: None
[2012-01-17 17:25:49 2335] DEBUG (image:891) args: localtime, val: 0
[2012-01-17 17:25:49 2335] DEBUG (image:891) args: serial, val: ['pty']
[2012-01-17 17:25:49 2335] DEBUG (image:891) args: std-vga, val: 0
[2012-01-17 17:25:49 2335] DEBUG (image:891) args: isa, val: 0
[2012-01-17 17:25:49 2335] DEBUG (image:891) args: acpi, val: 1
[2012-01-17 17:25:49 2335] DEBUG (image:891) args: usb, val: 0
[2012-01-17 17:25:49 2335] DEBUG (image:891) args: usbdevice, val: None
[2012-01-17 17:25:49 2335] DEBUG (image:891) args: gfx_passthru, val: None
[2012-01-17 17:25:49 2335] INFO (image:822) Need to create platform device.[domid:14]
[2012-01-17 17:25:49 2335] DEBUG (XendDomainInfo:2863) _initDomain:shadow_memory=0x0, memory_static_max=0x20000000, memory_static_min=0x0.
[2012-01-17 17:25:49 2335] INFO (image:182) buildDomain os=hvm dom=14 vcpus=1
[2012-01-17 17:25:49 2335] DEBUG (image:949) domid          = 14
[2012-01-17 17:25:49 2335] DEBUG (image:950) image          = /usr/lib/xen/boot/hvmloader
[2012-01-17 17:25:49 2335] DEBUG (image:951) store_evtchn   = 2
[2012-01-17 17:25:49 2335] DEBUG (image:952) memsize        = 512
[2012-01-17 17:25:49 2335] DEBUG (image:953) target         = 512
[2012-01-17 17:25:49 2335] DEBUG (image:954) vcpus          = 1
[2012-01-17 17:25:49 2335] DEBUG (image:955) vcpu_avail     = 1
[2012-01-17 17:25:49 2335] DEBUG (image:956) acpi           = 1
[2012-01-17 17:25:49 2335] DEBUG (image:957) apic           = 1
[2012-01-17 17:25:49 2335] INFO (XendDomainInfo:2357) createDevice: vfb : {'vncunused': 1, 'other_config': {'vncunused': 1, 'vnc': '1'}, 'vnc': '1', 'uuid': 'de48a363-5889-25a6-5980-f7dbc3676cd5'}
[2012-01-17 17:25:49 2335] DEBUG (DevController:95) DevController: writing {'state': '1', 'backend-id': '0', 'backend': '/local/domain/0/backend/vfb/14/0'} to /local/domain/14/device/vfb/0.
[2012-01-17 17:25:49 2335] DEBUG (DevController:97) DevController: writing {'vncunused': '1', 'domain': 'exchange-hvm', 'frontend': '/local/domain/14/device/vfb/0', 'uuid': 'de48a363-5889-25a6-5980-f7dbc3676cd5', 'frontend-id': '14', 'state': '1', 'online': '1', 'vnc': '1'} to /local/domain/0/backend/vfb/14/0.
[2012-01-17 17:25:49 2335] INFO (XendDomainInfo:2357) createDevice: tap2 : {'bootable': 1, 'uname': 'tap2:remus:192.168.2.4:9000|aio:/home/remus/win2k3-exchange.img', 'mode': 'w', 'dev': 'ioemu:hda', 'uuid': '70debf8c-9b8c-2c45-84dc-98088b6a207a'}
[2012-01-17 17:25:49 2335] DEBUG (DevController:95) DevController: writing {'backend-id': '0', 'virtual-device': '768', 'device-type': 'disk', 'state': '1', 'backend': '/local/domain/0/backend/vbd/14/768'} to /local/domain/14/device/vbd/768.
[2012-01-17 17:25:49 2335] DEBUG (DevController:97) DevController: writing {'domain': 'exchange-hvm', 'frontend': '/local/domain/14/device/vbd/768', 'uuid': '70debf8c-9b8c-2c45-84dc-98088b6a207a', 'bootable': '1', 'dev': 'hda', 'state': '1', 'params': '/dev/xen/blktap-2/tapdev18', 'mode': 'w', 'online': '1', 'frontend-id': '14', 'type': 'phy', 'tapdisk-params': 'remus:192.168.2.4:9000|aio:/home/remus/win2k3-exchange.img'} to /local/domain/0/backend/vbd/14/768.
[2012-01-17 17:25:49 2335] INFO (XendDomainInfo:2357) createDevice: tap2 : {'bootable': 0, 'uname': 'tap2:remus:192.168.2.4:9000|aio:/home/remus/win2k3-exchange-d.img', 'mode': 'w', 'dev': 'ioemu:hdb', 'uuid': '1efcf13c-dee7-b312-66cd-d7c2952be398'}
[2012-01-17 17:25:50 2335] DEBUG (DevController:95) DevController: writing {'backend-id': '0', 'virtual-device': '832', 'device-type': 'disk', 'state': '1', 'backend': '/local/domain/0/backend/vbd/14/832'} to /local/domain/14/device/vbd/832.
[2012-01-17 17:25:50 2335] DEBUG (DevController:97) DevController: writing {'domain': 'exchange-hvm', 'frontend': '/local/domain/14/device/vbd/832', 'uuid': '1efcf13c-dee7-b312-66cd-d7c2952be398', 'bootable': '0', 'dev': 'hdb', 'state': '1', 'params': '/dev/xen/blktap-2/tapdev19', 'mode': 'w', 'online': '1', 'frontend-id': '14', 'type': 'phy', 'tapdisk-params': 'remus:192.168.2.4:9000|aio:/home/remus/win2k3-exchange-d.img'} to /local/domain/0/backend/vbd/14/832.
[2012-01-17 17:25:50 2335] INFO (XendDomainInfo:2357) createDevice: vif : {'bridge': 'xenbr0', 'mac': '00:16:3e:61:db:6b', 'type': 'ioemu', 'uuid': '95232b7e-49a6-e396-2a3f-2504d8929688'}
[2012-01-17 17:25:50 2335] DEBUG (DevController:95) DevController: writing {'state': '1', 'backend-id': '0', 'backend': '/local/domain/0/backend/vif/14/0'} to /local/domain/14/device/vif/0.
[2012-01-17 17:25:50 2335] DEBUG (DevController:97) DevController: writing {'bridge': 'xenbr0', 'domain': 'exchange-hvm', 'handle': '0', 'uuid': '95232b7e-49a6-e396-2a3f-2504d8929688', 'script': '/etc/xen/scripts/vif-bridge', 'mac': '00:16:3e:61:db:6b', 'frontend-id': '14', 'state': '1', 'online': '1', 'frontend': '/local/domain/14/device/vif/0', 'type': 'ioemu'} to /local/domain/0/backend/vif/14/0.
[2012-01-17 17:25:50 2335] INFO (image:418) spawning device models: /usr/lib/xen/bin/qemu-dm ['/usr/lib/xen/bin/qemu-dm', '-d', '14', '-domain-name', 'exchange-hvm', '-videoram', '4', '-vnc', '127.0.0.1:0', '-vncunused', '-vcpus', '1', '-vcpu_avail', '0x1', '-boot', 'c', '-serial', 'pty', '-acpi', '-net', 'nic,vlan=1,macaddr=00:16:3e:61:db:6b,model=rtl8139', '-net', 'tap,vlan=1,ifname=tap14.0,bridge=xenbr0', '-M', 'xenfv']
[2012-01-17 17:25:51 2335] INFO (image:467) device model pid: 8785
[2012-01-17 17:25:51 2335] INFO (image:590) waiting for sentinel_fifo
[2012-01-17 17:25:51 2335] DEBUG (XendDomainInfo:3420) Storing VM details: {'on_xend_stop': 'ignore', 'pool_name': 'Pool-0', 'shadow_memory': '5', 'uuid': 'cb7be9d5-8afe-0d45-e9f3-c44c6a08bfd7', 'on_reboot': 'restart', 'start_time': '1326842751.1', 'on_poweroff': 'destroy', 'bootloader_args': '', 'on_xend_start': 'ignore', 'on_crash': 'restart', 'xend/restart_count': '0', 'vcpus': '1', 'vcpu_avail': '1', 'bootloader': '', 'image': "(hvm (kernel '') (superpages 0) (videoram 4) (hpet 0) (stdvga 0) (loader /usr/lib/xen/boot/hvmloader) (xen_platform_pci 1) (opengl 1) (rtc_timeoffset 0) (pci ()) (hap 1) (localtime 0) (timer_mode 1) (pci_msitranslate 1) (oos 1) (apic 1) (sdl 0) (display :0.0) (vpt_align 1) (serial pty) (vncunused 1) (boot c) (pae 1) (viridian 0) (acpi 1) (vnc 1) (nographic 0) (nomigrate 0) (usb 0) (tsc_mode 0) (guest_os_type default) (device_model /usr/lib/xen/bin/qemu-dm) (pci_power_mgmt 0) (xauthority /home/antoine/.Xauthority) (isa 0) (notes (SUSPEND_CANCEL 1)))", 'name': 'exchange-hvm'}
[2012-01-17 17:25:51 2335] DEBUG (XendDomainInfo:1794) Storing domain details: {'console/port': '3', 'description': '', 'console/limit': '1048576', 'store/port': '2', 'vm': '/vm/cb7be9d5-8afe-0d45-e9f3-c44c6a08bfd7', 'domid': '14', 'image/suspend-cancel': '1', 'cpu/0/availability': 'online', 'memory/target': '524288', 'control/platform-feature-multiprocessor-suspend': '1', 'store/ring-ref': '1044476', 'console/type': 'ioemu', 'name': 'exchange-hvm'}
[2012-01-17 17:25:52 2335] DEBUG (DevController:95) DevController: writing {'state': '1', 'backend-id': '0', 'backend': '/local/domain/0/backend/console/14/0'} to /local/domain/14/device/console/0.
[2012-01-17 17:25:52 2335] DEBUG (DevController:97) DevController: writing {'domain': 'exchange-hvm', 'frontend': '/local/domain/14/device/console/0', 'uuid': '85f7b108-87ed-ff20-f522-4e7827a6ba87', 'frontend-id': '14', 'state': '1', 'location': '3', 'online': '1', 'protocol': 'vt100'} to /local/domain/0/backend/console/14/0.
[2012-01-17 17:25:52 2335] DEBUG (XendDomainInfo:1881) XendDomainInfo.handleShutdownWatch
[2012-01-17 17:25:52 2335] DEBUG (DevController:139) Waiting for devices tap2.
[2012-01-17 17:25:52 2335] DEBUG (DevController:144) Waiting for 768.
[2012-01-17 17:25:52 2335] DEBUG (DevController:628) hotplugStatusCallback /local/domain/0/backend/vbd/14/768/hotplug-status.
[2012-01-17 17:25:52 2335] DEBUG (DevController:642) hotplugStatusCallback 1.
[2012-01-17 17:25:52 2335] DEBUG (DevController:144) Waiting for 832.
[2012-01-17 17:25:52 2335] DEBUG (DevController:628) hotplugStatusCallback /local/domain/0/backend/vbd/14/832/hotplug-status.
[2012-01-17 17:25:52 2335] DEBUG (DevController:642) hotplugStatusCallback 1.
[2012-01-17 17:25:52 2335] DEBUG (DevController:139) Waiting for devices vif.
[2012-01-17 17:25:52 2335] DEBUG (DevController:144) Waiting for 0.
[2012-01-17 17:25:52 2335] DEBUG (DevController:628) hotplugStatusCallback /local/domain/0/backend/vif/14/0/hotplug-status.
[2012-01-17 17:25:52 2335] DEBUG (DevController:642) hotplugStatusCallback 1.
[2012-01-17 17:25:52 2335] DEBUG (DevController:139) Waiting for devices vkbd.
[2012-01-17 17:25:52 2335] DEBUG (DevController:139) Waiting for devices ioports.
[2012-01-17 17:25:52 2335] DEBUG (DevController:139) Waiting for devices tap.
[2012-01-17 17:25:52 2335] DEBUG (DevController:139) Waiting for devices vif2.
[2012-01-17 17:25:52 2335] DEBUG (DevController:139) Waiting for devices console.
[2012-01-17 17:25:52 2335] DEBUG (DevController:144) Waiting for 0.
[2012-01-17 17:25:52 2335] DEBUG (DevController:139) Waiting for devices vscsi.
[2012-01-17 17:25:52 2335] DEBUG (DevController:139) Waiting for devices vbd.
[2012-01-17 17:25:52 2335] DEBUG (DevController:139) Waiting for devices irq.
[2012-01-17 17:25:52 2335] DEBUG (DevController:139) Waiting for devices vfb.
[2012-01-17 17:25:52 2335] DEBUG (DevController:139) Waiting for devices pci.
[2012-01-17 17:25:52 2335] DEBUG (DevController:139) Waiting for devices vusb.
[2012-01-17 17:25:52 2335] DEBUG (DevController:139) Waiting for devices vtpm.
[2012-01-17 17:25:52 2335] INFO (XendDomain:1225) Domain exchange-hvm (14) unpaused.
[2012-01-17 17:25:52 2335] WARNING (XendDomainInfo:581) Could not unpause blktap disk: too many values to unpack
[2012-01-17 17:29:42 2335] DEBUG (XendDomainInfo:2406) No device model
[2012-01-17 17:29:42 2335] DEBUG (XendDomainInfo:2408) Releasing devices