[2010-11-17 14:35:30 4435] DEBUG (XendDomainInfo:235) XendDomainInfo.restore(['domain', ['domid', '90'], ['cpu_weight', '256'], ['cpu_cap', '0'], ['bootloader'], ['on_crash', 'restart'], ['uuid', '55a81697-7896-601e-9302-ab9bcf8a6e38'], ['bootloader_args'], ['vcpus', '1'], ['description'], ['name', 'ox1.xxx.xxx.xxx'], ['cpus', [[]]], ['on_reboot', 'restart'], ['on_poweroff', 'destroy'], ['maxmem', '1024'], ['memory', '1024'], ['shadow_memory', '9'], ['vcpu_avail', '1'], ['features'], ['on_xend_start', 'ignore'], ['on_xend_stop', 'ignore'], ['start_time', '1290000820.94'], ['cpu_time', '0.0'], ['online_vcpus', '1'], ['image', ['hvm', ['kernel'], ['superpages', '0'], ['videoram', '4'], ['hpet', '0'], ['stdvga', '0'], ['vnclisten', '0.0.0.0'], ['loader', '/usr/lib/xen/boot/hvmloader'], ['xen_platform_pci', '1'], ['opengl', '1'], ['rtc_timeoffset', '0'], ['pci', []], ['hap', '1'], ['localtime', '0'], ['timer_mode', '1'], ['xen_extended_power_mgmt', '0'], ['pci_msitranslate', '1'], ['oos', '1'], ['apic', '1'], ['sdl', '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', '/root/.Xauthority'], ['isa', '0'], ['notes', ['SUSPEND_CANCEL', '1']]]], ['status', '2'], ['state', '--p---'], ['store_mfn', '1044476'], ['device', ['vif', ['bridge', 'br0'], ['mac', '00:16:3e:02:01:01'], ['script', '/etc/xen/scripts/vif-bridge'], ['uuid', '0a26eda3-aeb1-c443-69e1-1e4a975d3368'], ['backend', '0']]], ['device', ['console', ['protocol', 'vt100'], ['location', '3'], ['uuid', 'e224f86f-f7b4-1093-a838-fd31c45e18f0']]], ['device', ['vbd', ['protocol', 'x86_64-abi'], ['uuid', '087e1a93-27ee-d647-9b87-e3f03ee82798'], ['bootable', '1'], ['dev', 'xvda:disk'], ['uname', 'phy:/dev/vg-l2-1/ox1.xxx.xxx.xxx-DISK1'], ['mode', 'w'], ['backend', '0'], ['VDI']]], ['device', ['vbd', ['protocol', 'x86_64-abi'], ['uuid', '472dd4cf-c2a1-5666-4d24-dafddd9a740d'], ['bootable', '0'], ['dev', 'xvdb:disk'], ['uname', 'phy:/dev/vg-l2-1/ox1.xxx.xxx.xxx-DISK2'], ['mode', 'w'], ['backend', '0'], ['VDI']]], ['device', ['vfb', ['vncunused', '1'], ['vnclisten', '0.0.0.0'], ['vnc', '1'], ['uuid', '1cee2d7b-bb56-c0b5-4f48-407f6271b391'], ['location', '0.0.0.0:5900']]], ['change_home_server', 'False']])
[2010-11-17 14:35:30 4435] DEBUG (XendDomainInfo:2508) XendDomainInfo.constructDomain
[2010-11-17 14:35:30 4435] DEBUG (balloon:220) Balloon: 58012248 KiB free; need 16384; done.
[2010-11-17 14:35:30 4435] DEBUG (XendDomain:464) Adding Domain: 24
[2010-11-17 14:35:30 4435] WARNING (XendDomainInfo:501) Cannot restore CPU affinity
[2010-11-17 14:35:30 4435] DEBUG (XendDomainInfo:3400) Storing VM details: {'on_xend_stop': 'ignore', 'shadow_memory': '9', 'uuid': '55a81697-7896-601e-9302-ab9bcf8a6e38', 'on_reboot': 'restart', 'start_time': '1290000820.94', '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) (vnclisten 0.0.0.0) (loader /usr/lib/xen/boot/hvmloader) (xen_platform_pci 1) (opengl 1) (rtc_timeoffset 0) (pci ()) (hap 1) (localtime 0) (timer_mode 1) (xen_extended_power_mgmt 0) (pci_msitranslate 1) (oos 1) (apic 1) (sdl 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 /root/.Xauthority) (isa 0) (notes (SUSPEND_CANCEL 1)))', 'name': 'ox1.xxx.xxx.xxx'}
[2010-11-17 14:35:30 4435] INFO (XendDomainInfo:2367) createDevice: console : {'protocol': 'vt100', 'location': '3', 'uuid': 'e224f86f-f7b4-1093-a838-fd31c45e18f0'}
[2010-11-17 14:35:30 4435] DEBUG (DevController:95) DevController: writing {'state': '1', 'backend-id': '0', 'backend': '/local/domain/0/backend/console/24/0'} to /local/domain/24/device/console/0.
[2010-11-17 14:35:30 4435] DEBUG (DevController:97) DevController: writing {'domain': 'ox1.xxx.xxx.xxx', 'frontend': '/local/domain/24/device/console/0', 'uuid': 'e224f86f-f7b4-1093-a838-fd31c45e18f0', 'frontend-id': '24', 'state': '1', 'location': '3', 'online': '1', 'protocol': 'vt100'} to /local/domain/0/backend/console/24/0.
[2010-11-17 14:35:30 4435] INFO (XendDomainInfo:2367) createDevice: vfb : {'vncunused': '1', 'other_config': {'vncunused': '1', 'vnclisten': '0.0.0.0', 'vnc': '1'}, 'vnc': '1', 'uuid': '1cee2d7b-bb56-c0b5-4f48-407f6271b391', 'vnclisten': '0.0.0.0', 'location': '0.0.0.0:5900'}
[2010-11-17 14:35:30 4435] DEBUG (DevController:95) DevController: writing {'state': '1', 'backend-id': '0', 'backend': '/local/domain/0/backend/vfb/24/0'} to /local/domain/24/device/vfb/0.
[2010-11-17 14:35:30 4435] DEBUG (DevController:97) DevController: writing {'vncunused': '1', 'domain': 'ox1.xxx.xxx.xxx', 'frontend': '/local/domain/24/device/vfb/0', 'uuid': '1cee2d7b-bb56-c0b5-4f48-407f6271b391', 'frontend-id': '24', 'vnclisten': '0.0.0.0', 'state': '1', 'location': '0.0.0.0:5900', 'online': '1', 'vnc': '1'} to /local/domain/0/backend/vfb/24/0.
[2010-11-17 14:35:30 4435] INFO (XendDomainInfo:2367) createDevice: vbd : {'protocol': 'x86_64-abi', 'uuid': '087e1a93-27ee-d647-9b87-e3f03ee82798', 'bootable': 1, 'driver': 'paravirtualised', 'dev': 'xvda:disk', 'uname': 'phy:/dev/vg-l2-1/ox1.xxx.xxx.xxx-DISK1', 'mode': 'w', 'backend': '0'}
[2010-11-17 14:35:30 4435] DEBUG (DevController:95) DevController: writing {'virtual-device': '51712', 'protocol': 'x86_64-abi', 'device-type': 'disk', 'backend-id': '0', 'state': '1', 'backend': '/local/domain/0/backend/vbd/24/51712'} to /local/domain/24/device/vbd/51712.
[2010-11-17 14:35:30 4435] DEBUG (DevController:97) DevController: writing {'domain': 'ox1.xxx.xxx.xxx', 'frontend': '/local/domain/24/device/vbd/51712', 'uuid': '087e1a93-27ee-d647-9b87-e3f03ee82798', 'bootable': '1', 'dev': 'xvda', 'state': '1', 'params': '/dev/vg-l2-1/ox1.xxx.xxx.xxx-DISK1', 'mode': 'w', 'online': '1', 'frontend-id': '24', 'type': 'phy'} to /local/domain/0/backend/vbd/24/51712.
[2010-11-17 14:35:30 4435] INFO (XendDomainInfo:2367) createDevice: vbd : {'protocol': 'x86_64-abi', 'uuid': '472dd4cf-c2a1-5666-4d24-dafddd9a740d', 'bootable': 0, 'driver': 'paravirtualised', 'dev': 'xvdb:disk', 'uname': 'phy:/dev/vg-l2-1/ox1.xxx.xxx.xxx-DISK2', 'mode': 'w', 'backend': '0'}
[2010-11-17 14:35:30 4435] DEBUG (DevController:95) DevController: writing {'virtual-device': '51728', 'protocol': 'x86_64-abi', 'device-type': 'disk', 'backend-id': '0', 'state': '1', 'backend': '/local/domain/0/backend/vbd/24/51728'} to /local/domain/24/device/vbd/51728.
[2010-11-17 14:35:30 4435] DEBUG (DevController:97) DevController: writing {'domain': 'ox1.xxx.xxx.xxx', 'frontend': '/local/domain/24/device/vbd/51728', 'uuid': '472dd4cf-c2a1-5666-4d24-dafddd9a740d', 'bootable': '0', 'dev': 'xvdb', 'state': '1', 'params': '/dev/vg-l2-1/ox1.xxx.xxx.xxx-DISK2', 'mode': 'w', 'online': '1', 'frontend-id': '24', 'type': 'phy'} to /local/domain/0/backend/vbd/24/51728.
[2010-11-17 14:35:30 4435] INFO (XendDomainInfo:2367) createDevice: vif : {'bridge': 'br0', 'mac': '00:16:3e:02:01:01', 'script': '/etc/xen/scripts/vif-bridge', 'uuid': '0a26eda3-aeb1-c443-69e1-1e4a975d3368', 'backend': '0'}
[2010-11-17 14:35:30 4435] DEBUG (DevController:95) DevController: writing {'backend-id': '0', 'mac': '00:16:3e:02:01:01', 'handle': '0', 'state': '1', 'backend': '/local/domain/0/backend/vif/24/0'} to /local/domain/24/device/vif/0.
[2010-11-17 14:35:30 4435] DEBUG (DevController:97) DevController: writing {'bridge': 'br0', 'domain': 'ox1.xxx.xxx.xxx', 'handle': '0', 'uuid': '0a26eda3-aeb1-c443-69e1-1e4a975d3368', 'script': '/etc/xen/scripts/vif-bridge', 'mac': '00:16:3e:02:01:01', 'frontend-id': '24', 'state': '1', 'online': '1', 'frontend': '/local/domain/24/device/vif/0'} to /local/domain/0/backend/vif/24/0.
[2010-11-17 14:35:30 4435] DEBUG (XendDomainInfo:1804) Storing domain details: {'console/port': '3', 'description': '', 'console/limit': '1048576', 'image/suspend-cancel': '1', 'domid': '24', 'vm': '/vm/55a81697-7896-601e-9302-ab9bcf8a6e38', 'cpu/0/availability': 'online', 'memory/target': '1048576', 'control/platform-feature-multiprocessor-suspend': '1', 'console/type': 'ioemu', 'store/port': '2', 'name': 'ox1.xxx.xxx.xxx'}
[2010-11-17 14:35:30 4435] INFO (XendCheckpoint:268) restore hvm domain 24, apic=1, pae=1
[2010-11-17 14:35:30 4435] DEBUG (image:339) No VNC passwd configured for vfb access
[2010-11-17 14:35:30 4435] DEBUG (image:891) args: boot, val: c
[2010-11-17 14:35:30 4435] DEBUG (image:891) args: fda, val: None
[2010-11-17 14:35:30 4435] DEBUG (image:891) args: fdb, val: None
[2010-11-17 14:35:30 4435] DEBUG (image:891) args: soundhw, val: None
[2010-11-17 14:35:30 4435] DEBUG (image:891) args: localtime, val: 0
[2010-11-17 14:35:30 4435] DEBUG (image:891) args: serial, val: ['pty']
[2010-11-17 14:35:30 4435] DEBUG (image:891) args: std-vga, val: 0
[2010-11-17 14:35:30 4435] DEBUG (image:891) args: isa, val: 0
[2010-11-17 14:35:30 4435] DEBUG (image:891) args: acpi, val: 1
[2010-11-17 14:35:30 4435] DEBUG (image:891) args: usb, val: 0
[2010-11-17 14:35:30 4435] DEBUG (image:891) args: usbdevice, val: None
[2010-11-17 14:35:30 4435] DEBUG (image:891) args: gfx_passthru, val: None
[2010-11-17 14:35:30 4435] INFO (image:822) Need to create platform device.[domid:24]
[2010-11-17 14:35:30 4435] DEBUG (XendCheckpoint:286) restore:shadow=0x9, _static_max=0x40000000, _static_min=0x0, 
[2010-11-17 14:35:30 4435] DEBUG (XendCheckpoint:305) [xc_restore]: /usr/lib/xen/bin/xc_restore 4 24 2 3 1 1 1 0
[2010-11-17 14:35:31 4435] INFO (XendCheckpoint:423) xc_domain_restore start: p2m_size = 100000
[2010-11-17 14:35:31 4435] INFO (XendCheckpoint:423) Reloading memory pages:   0%
[2010-11-17 14:35:47 4435] INFO (XendCheckpoint:423) Read 7192 bytes of QEMU data
[2010-11-17 14:35:48 4435] INFO (XendCheckpoint:423) ERROR Internal error: Error when reading batch size
[2010-11-17 14:35:48 4435] INFO (XendCheckpoint:423) ERROR Internal error: error when buffering batch, finishing
[2010-11-17 14:35:48 4435] INFO (XendCheckpoint:423) 
[2010-11-17 14:35:48 4435] INFO (XendCheckpoint:423) Writing 7192 bytes of QEMU data
[2010-11-17 14:35:48 4435] INFO (XendCheckpoint:423) Restore exit with rc=0
[2010-11-17 14:35:48 4435] DEBUG (XendCheckpoint:394) store-mfn 1044476
[2010-11-17 14:35:48 4435] DEBUG (XendDomainInfo:2992) XendDomainInfo.completeRestore
[2010-11-17 14:35:48 4435] DEBUG (image:339) No VNC passwd configured for vfb access
[2010-11-17 14:35:48 4435] DEBUG (image:891) args: boot, val: c
[2010-11-17 14:35:48 4435] DEBUG (image:891) args: fda, val: None
[2010-11-17 14:35:48 4435] DEBUG (image:891) args: fdb, val: None
[2010-11-17 14:35:48 4435] DEBUG (image:891) args: soundhw, val: None
[2010-11-17 14:35:48 4435] DEBUG (image:891) args: localtime, val: 0
[2010-11-17 14:35:48 4435] DEBUG (image:891) args: serial, val: ['pty']
[2010-11-17 14:35:48 4435] DEBUG (image:891) args: std-vga, val: 0
[2010-11-17 14:35:48 4435] DEBUG (image:891) args: isa, val: 0
[2010-11-17 14:35:48 4435] DEBUG (image:891) args: acpi, val: 1
[2010-11-17 14:35:48 4435] DEBUG (image:891) args: usb, val: 0
[2010-11-17 14:35:48 4435] DEBUG (image:891) args: usbdevice, val: None
[2010-11-17 14:35:48 4435] DEBUG (image:891) args: gfx_passthru, val: None
[2010-11-17 14:35:48 4435] INFO (image:822) Need to create platform device.[domid:24]
[2010-11-17 14:35:48 4435] INFO (image:418) spawning device models: /usr/lib/xen/bin/qemu-dm ['/usr/lib/xen/bin/qemu-dm', '-d', '24', '-domain-name', 'ox1.xxx.xxx.xxx', '-videoram', '4', '-vnc', '0.0.0.0:0', '-vncunused', '-vcpus', '1', '-vcpu_avail', '0x1L', '-boot', 'c', '-serial', 'pty', '-acpi', '-net', 'nic,vlan=1,macaddr=00:16:3e:02:01:01,model=rtl8139', '-net', 'tap,vlan=1,ifname=tap24.0,bridge=br0', '-M', 'xenfv', '-loadvm', '/var/lib/xen/qemu-save.24']
[2010-11-17 14:35:48 4435] INFO (image:467) device model pid: 29119
[2010-11-17 14:35:48 4435] INFO (image:590) waiting for sentinel_fifo
[2010-11-17 14:35:48 4435] DEBUG (XendDomainInfo:1804) Storing domain details: {'console/port': '3', 'description': '', 'console/limit': '1048576', 'store/port': '2', 'vm': '/vm/55a81697-7896-601e-9302-ab9bcf8a6e38', 'domid': '24', 'image/suspend-cancel': '1', 'cpu/0/availability': 'online', 'memory/target': '1048576', 'control/platform-feature-multiprocessor-suspend': '1', 'store/ring-ref': '1044476', 'console/type': 'ioemu', 'name': 'ox1.xxx.xxx.xxx'}
[2010-11-17 14:35:48 4435] DEBUG (XendDomainInfo:3005) XendDomainInfo.completeRestore done
[2010-11-17 14:35:48 4435] DEBUG (DevController:139) Waiting for devices tap2.
[2010-11-17 14:35:48 4435] DEBUG (DevController:139) Waiting for devices vif.
[2010-11-17 14:35:48 4435] DEBUG (XendDomainInfo:1891) XendDomainInfo.handleShutdownWatch
[2010-11-17 14:35:48 4435] DEBUG (DevController:144) Waiting for 0.
[2010-11-17 14:35:48 4435] DEBUG (DevController:628) hotplugStatusCallback /local/domain/0/backend/vif/24/0/hotplug-status.
[2010-11-17 14:35:48 4435] DEBUG (DevController:642) hotplugStatusCallback 1.
[2010-11-17 14:35:48 4435] DEBUG (DevController:139) Waiting for devices vkbd.
[2010-11-17 14:35:48 4435] DEBUG (DevController:139) Waiting for devices ioports.
[2010-11-17 14:35:48 4435] DEBUG (DevController:139) Waiting for devices tap.
[2010-11-17 14:35:48 4435] DEBUG (DevController:139) Waiting for devices vif2.
[2010-11-17 14:35:48 4435] DEBUG (DevController:139) Waiting for devices console.
[2010-11-17 14:35:48 4435] DEBUG (DevController:144) Waiting for 0.
[2010-11-17 14:35:48 4435] DEBUG (DevController:139) Waiting for devices vscsi.
[2010-11-17 14:35:48 4435] DEBUG (DevController:139) Waiting for devices vbd.
[2010-11-17 14:35:48 4435] DEBUG (DevController:144) Waiting for 51712.
[2010-11-17 14:35:48 4435] DEBUG (DevController:628) hotplugStatusCallback /local/domain/0/backend/vbd/24/51712/hotplug-status.
[2010-11-17 14:35:48 4435] DEBUG (DevController:642) hotplugStatusCallback 1.
[2010-11-17 14:35:48 4435] DEBUG (DevController:144) Waiting for 51728.
[2010-11-17 14:35:48 4435] DEBUG (DevController:628) hotplugStatusCallback /local/domain/0/backend/vbd/24/51728/hotplug-status.
[2010-11-17 14:35:48 4435] DEBUG (DevController:642) hotplugStatusCallback 1.
[2010-11-17 14:35:48 4435] DEBUG (DevController:139) Waiting for devices irq.
[2010-11-17 14:35:48 4435] DEBUG (DevController:139) Waiting for devices vfb.
[2010-11-17 14:35:48 4435] DEBUG (DevController:139) Waiting for devices pci.
[2010-11-17 14:35:48 4435] DEBUG (DevController:139) Waiting for devices vusb.
[2010-11-17 14:35:48 4435] DEBUG (DevController:139) Waiting for devices vtpm.