[2010-09-27 16:58:37 1691] INFO (SrvDaemon:332) Xend Daemon started
[2010-09-27 16:58:37 1691] INFO (SrvDaemon:336) Xend changeset: unavailable.
[2010-09-27 16:58:38 1691] DEBUG (XendDomainInfo:149) XendDomainInfo.recreate({'max_vcpu_id': 3, 'cpu_time': 11533024558L, 'ssidref': 0, 'hvm': 0, 'shutdown_reason': 255, 'dying': 0, 'online_vcpus': 4, 'domid':
 0, 'paused': 0, 'crashed': 0, 'running': 1, 'maxmem_kb': 17179869180L, 'shutdown': 0, 'mem_kb': 3663104L, 'handle': [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0], 'blocked': 0, 'name': 'Domain-0'})
[2010-09-27 16:58:38 1691] INFO (XendDomainInfo:167) Recreating domain 0, UUID 00000000-0000-0000-0000-000000000000. at /local/domain/0
[2010-09-27 16:58:38 1691] DEBUG (XendDomainInfo:3400) Storing VM details: {'on_xend_stop': 'ignore', 'shadow_memory': '0', 'uuid': '00000000-0000-0000-0000-000000000000', 'on_reboot': 'restart', 'image': '(lin
ux (kernel ) (superpages 0) (tsc_mode 0) (nomigrate 0))', 'on_poweroff': 'destroy', 'bootloader_args': '', 'on_xend_start': 'ignore', 'on_crash': 'restart', 'xend/restart_count': '0', 'vcpus': '4', 'vcpu_avail'
: '15', 'bootloader': '', 'name': 'Domain-0'}
[2010-09-27 16:58:39 1691] DEBUG (XendDomainInfo:1804) Storing domain details: {'cpu/3/availability': 'online', 'description': '', 'console/limit': '1048576', 'memory/target': '3663104', 'cpu/2/availability': '
online', 'vm': '/vm/00000000-0000-0000-0000-000000000000-10', 'domid': '0', 'cpu/0/availability': 'online', 'cpu/1/availability': 'online', 'control/platform-feature-multiprocessor-suspend': '1', 'console/type'
: 'xenconsoled', 'name': 'Domain-0'}
[2010-09-27 16:58:39 1691] DEBUG (XendDomain:464) Adding Domain: 0
[2010-09-27 16:58:39 1691] DEBUG (XendDomain:398) number of vcpus to use is 0
[2010-09-27 16:58:39 1691] DEBUG (XendDomainInfo:1891) XendDomainInfo.handleShutdownWatch
[2010-09-27 16:58:39 1691] WARNING (XendAPI:705) API call: VBD.set_device not found
[2010-09-27 16:58:39 1691] WARNING (XendAPI:705) API call: VBD.set_type not found
[2010-09-27 16:58:39 1691] WARNING (XendAPI:705) API call: session.get_all_records not found
[2010-09-27 16:58:39 1691] WARNING (XendAPI:705) API call: event.get_record not found
[2010-09-27 16:58:39 1691] WARNING (XendAPI:705) API call: event.get_all not found
[2010-09-27 16:58:39 1691] WARNING (XendAPI:705) API call: VIF.set_device not found
[2010-09-27 16:58:39 1691] WARNING (XendAPI:705) API call: VIF.set_MAC not found
[2010-09-27 16:58:39 1691] WARNING (XendAPI:705) API call: VIF.set_MTU not found
[2010-09-27 16:58:39 1691] WARNING (XendAPI:705) API call: debug.get_all not found
[2010-09-27 16:58:39 1691] INFO (XMLRPCServer:156) Opening Unix domain socket XML-RPC server on /var/run/xend/xen-api.sock; authentication has been disabled for this server.
[2010-09-27 16:58:39 1691] INFO (XMLRPCServer:156) Opening Unix domain socket XML-RPC server on /var/run/xend/xmlrpc.sock.
[2010-09-27 16:58:40 1691] DEBUG (XendDomainInfo:235) XendDomainInfo.restore(['domain', ['domid', '1'], ['cpu_weight', '256'], ['cpu_cap', '0'], ['on_crash', 'restart'], ['uuid', '7502719d-2d2c-9c3f-94ba-d6692dfc44bd'], ['bootloader_args'], ['vcpus', '1'], ['name', 'my-xen1'], ['on_poweroff', 'destroy'], ['on_reboot', 'restart'], ['cpus', [[]]], ['description'], ['bootloader'], ['maxmem', '128'], ['memory', '128'], ['shadow_memory', '0'], ['vcpu_avail', '1'], ['features'], ['on_xend_start', 'ignore'], ['on_xend_stop', 'ignore'], ['start_time', '1285599190.32'], ['cpu_time', '3.12954646'], ['online_vcpus', '1'], ['image', ['linux', ['kernel', '/boot/vmlinuz-2.6.32-5-xen-amd64'], ['ramdisk', '/boot/initrd.img-2.6.32-5-xen-amd64'], ['args', 'root=/dev/xvda2 ro ip=:127.0.255.255::::eth0:dhcp '], ['superpages', '0'], ['tsc_mode', '0'], ['videoram', '4'], ['pci', []], ['nomigrate', '0'], ['notes', ['HV_START_LOW', '18446603336221196288'], ['FEATURES', '!writable_page_tables|pae_pgd
 
 ir_above_4gb'], ['VIRT_BASE', '18446744071562067968'], ['GUEST_VERSION', '2.6'], ['PADDR_OFFSET', '0'], ['GUEST_OS', 'linux'], ['HYPERCALL_PAGE', '18446744071578882048'], ['LOADER', 'generic'], ['SUSPEND_CANCEL', '1'], ['PAE_MODE', 'yes'], ['ENTRY', '18446744071584096768'], ['XEN_VERSION', 'xen-3.0']]]], ['status', '2'], ['state', '-b----'], ['store_mfn', '1201561'], ['console_mfn', '1201560'], ['device', ['vif', ['mac', '00:16:3E:40:E4:3D'], ['script', '/etc/xen/scripts/vif-bridge'], ['uuid', 'e19feca1-7707-723c-f244-0163259129d4'], ['backend', '0']]], ['device', ['vbd', ['protocol', 'x86_64-abi'], ['uuid', 'dbcf9f90-4744-5302-f95d-cca10584bbeb'], ['bootable', '1'], ['dev', 'xvda2:disk'], ['uname', 'file:/var/xen/my-xen1/domains/my-xen1/disk.img'], ['mode', 'w'], ['backend', '0'], ['VDI']]], ['device', ['vbd', ['protocol', 'x86_64-abi'], ['uuid', 'd448faa6-38a4-9c2e-1c17-12f56d5f1ff4'], ['bootable', '0'], ['dev', 'xvda1:disk'], ['uname', 'file:/var/xen/my-xen1/domains/my-xe
 
 n1/swap.img'], ['mode', 'w'], ['backend', '0'], ['VDI']]], ['device', ['console', ['protocol', 'vt100'], ['location', '2'], ['uuid', 'a0546653-e446-f4c3-2998-c47a581c40f4']]]])
[2010-09-27 16:58:40 1691] DEBUG (XendDomainInfo:2508) XendDomainInfo.constructDomain
[2010-09-27 16:58:40 1691] DEBUG (balloon:220) Balloon: 477412 KiB free; need 16384; done.
[2010-09-27 16:58:40 1691] DEBUG (XendDomain:464) Adding Domain: 1
[2010-09-27 16:58:40 1691] DEBUG (XendDomainInfo:3400) Storing VM details: {'on_xend_stop': 'ignore', 'shadow_memory': '0', 'uuid': '7502719d-2d2c-9c3f-94ba-d6692dfc44bd', 'on_reboot': 'restart', 'start_time': '1285599190.32', 'on_poweroff': 'destroy', 'bootloader_args': '', 'on_xend_start': 'ignore', 'on_crash': 'restart', 'xend/restart_count': '0', 'vcpus': '1', 'vcpu_avail': '1', 'bootloader': '', 'image': "(linux (kernel /boot/vmlinuz-2.6.32-5-xen-amd64) (ramdisk /boot/initrd.img-2.6.32-5-xen-amd64) (args 'root=/dev/xvda2 ro ip=:127.0.255.255::::eth0:dhcp ') (superpages 0) (tsc_mode 0) (videoram 4) (pci ()) (nomigrate 0) (notes (HV_START_LOW 18446603336221196288) (FEATURES '!writable_page_tables|pae_pgdir_above_4gb') (VIRT_BASE 18446744071562067968) (GUEST_VERSION 2.6) (PADDR_OFFSET 0) (GUEST_OS linux) (HYPERCALL_PAGE 18446744071578882048) (LOADER generic) (SUSPEND_CANCEL 1) (PAE_MODE yes) (ENTRY 18446744071584096768) (XEN_VERSION xen-3.0)))", 'name': 'my-xen1'}
[2010-09-27 16:58:40 1691] INFO (XendDomainInfo:2367) createDevice: console : {'protocol': 'vt100', 'location': '2', 'uuid': 'a0546653-e446-f4c3-2998-c47a581c40f4'}
[2010-09-27 16:58:40 1691] DEBUG (DevController:95) DevController: writing {'state': '1', 'backend-id': '0', 'backend': '/local/domain/0/backend/console/1/0'} to /local/domain/1/device/console/0.
[2010-09-27 16:58:40 1691] DEBUG (DevController:97) DevController: writing {'domain': 'my-xen1', 'frontend': '/local/domain/1/device/console/0', 'uuid': 'a0546653-e446-f4c3-2998-c47a581c40f4', 'frontend-id': '1', 'state': '1', 'location': '2', 'online': '1', 'protocol': 'vt100'} to /local/domain/0/backend/console/1/0.
[2010-09-27 16:58:40 1691] INFO (XendDomainInfo:2367) createDevice: vbd : {'protocol': 'x86_64-abi', 'uuid': 'dbcf9f90-4744-5302-f95d-cca10584bbeb', 'bootable': 1, 'driver': 'paravirtualised', 'dev': 'xvda2:disk', 'uname': 'file:/var/xen/my-xen1/domains/my-xen1/disk.img', 'mode': 'w', 'backend': '0'}
[2010-09-27 16:58:40 1691] DEBUG (DevController:95) DevController: writing {'virtual-device': '51714', 'protocol': 'x86_64-abi', 'device-type': 'disk', 'backend-id': '0', 'state': '1', 'backend': '/local/domain/0/backend/vbd/1/51714'} to /local/domain/1/device/vbd/51714.
[2010-09-27 16:58:40 1691] DEBUG (DevController:97) DevController: writing {'domain': 'my-xen1', 'frontend': '/local/domain/1/device/vbd/51714', 'uuid': 'dbcf9f90-4744-5302-f95d-cca10584bbeb', 'bootable': '1', 'dev': 'xvda2', 'state': '1', 'params': '/var/xen/my-xen1/domains/my-xen1/disk.img', 'mode': 'w', 'online': '1', 'frontend-id': '1', 'type': 'file'} to /local/domain/0/backend/vbd/1/51714.
[2010-09-27 16:58:40 1691] INFO (XendDomainInfo:2367) createDevice: vbd : {'protocol': 'x86_64-abi', 'uuid': 'd448faa6-38a4-9c2e-1c17-12f56d5f1ff4', 'bootable': 0, 'driver': 'paravirtualised', 'dev': 'xvda1:disk', 'uname': 'file:/var/xen/my-xen1/domains/my-xen1/swap.img', 'mode': 'w', 'backend': '0'}
[2010-09-27 16:58:40 1691] DEBUG (DevController:95) DevController: writing {'virtual-device': '51713', 'protocol': 'x86_64-abi', 'device-type': 'disk', 'backend-id': '0', 'state': '1', 'backend': '/local/domain/0/backend/vbd/1/51713'} to /local/domain/1/device/vbd/51713.
[2010-09-27 16:58:40 1691] DEBUG (DevController:97) DevController: writing {'domain': 'my-xen1', 'frontend': '/local/domain/1/device/vbd/51713', 'uuid': 'd448faa6-38a4-9c2e-1c17-12f56d5f1ff4', 'bootable': '0', 'dev': 'xvda1', 'state': '1', 'params': '/var/xen/my-xen1/domains/my-xen1/swap.img', 'mode': 'w', 'online': '1', 'frontend-id': '1', 'type': 'file'} to /local/domain/0/backend/vbd/1/51713.
[2010-09-27 16:58:40 1691] INFO (XendDomainInfo:2367) createDevice: vif : {'mac': '00:16:3E:40:E4:3D', 'script': '/etc/xen/scripts/vif-bridge', 'uuid': 'e19feca1-7707-723c-f244-0163259129d4', 'backend': '0'}
[2010-09-27 16:58:40 1691] DEBUG (DevController:95) DevController: writing {'backend-id': '0', 'mac': '00:16:3E:40:E4:3D', 'handle': '0', 'state': '1', 'backend': '/local/domain/0/backend/vif/1/0'} to /local/domain/1/device/vif/0.
[2010-09-27 16:58:40 1691] DEBUG (DevController:97) DevController: writing {'domain': 'my-xen1', 'frontend': '/local/domain/1/device/vif/0', 'uuid': 'e19feca1-7707-723c-f244-0163259129d4', 'script': '/etc/xen/scripts/vif-bridge', 'mac': '00:16:3E:40:E4:3D', 'frontend-id': '1', 'state': '1', 'online': '1', 'handle': '0'} to /local/domain/0/backend/vif/1/0.
[2010-09-27 16:58:40 1691] DEBUG (XendDomainInfo:1804) Storing domain details: {'image/entry': '18446744071584096768', 'console/port': '2', 'image/loader': 'generic', 'vm': '/vm/7502719d-2d2c-9c3f-94ba-d6692dfc44bd', 'control/platform-feature-multiprocessor-suspend': '1', 'image/hv-start-low': '18446603336221196288', 'image/guest-os': 'linux', 'image/virt-base': '18446744071562067968', 'memory/target': '131072', 'image/guest-version': '2.6', 'image/pae-mode': 'yes', 'description': '', 'console/limit': '1048576', 'image/paddr-offset': '0', 'image/hypercall-page': '18446744071578882048', 'image/suspend-cancel': '1', 'cpu/0/availability': 'online', 'image/features/pae-pgdir-above-4gb': '1', 'image/features/writable-page-tables': '0', 'console/type': 'xenconsoled', 'name': 'my-xen1', 'domid': '1', 'image/xen-version': 'xen-3.0', 'store/port': '1'}
[2010-09-27 16:58:40 1691] DEBUG (XendCheckpoint:286) restore:shadow=0x0, _static_max=0x8000000, _static_min=0x0, 
[2010-09-27 16:58:40 1691] DEBUG (XendCheckpoint:305) [xc_restore]: /usr/lib/xen-4.0/bin/xc_restore 45 1 1 2 0 0 0 0
[2010-09-27 16:58:40 1691] INFO (XendCheckpoint:423) xc_domain_restore start: p2m_size = 8000
[2010-09-27 16:58:40 1691] INFO (XendCheckpoint:423) Reloading memory pages:   0%
[2010-09-27 16:58:42 1691] INFO (XendCheckpoint:423) ERROR Internal error: Error when reading batch size
[2010-09-27 16:58:42 1691] INFO (XendCheckpoint:423) ERROR Internal error: error when buffering batch, finishing
[2010-09-27 16:58:42 1691] INFO (XendCheckpoint:423) 
[2010-09-27 16:58:42 1691] INFO (XendCheckpoint:4100%
[2010-09-27 16:58:42 1691] INFO (XendCheckpoint:423) Memory reloaded (12781 pages)
[2010-09-27 16:58:42 1691] INFO (XendCheckpoint:423) read VCPU 0
[2010-09-27 16:58:42 1691] INFO (XendCheckpoint:423) Completed checkpoint load
[2010-09-27 16:58:42 1691] INFO (XendCheckpoint:423) Domain ready to be built.
[2010-09-27 16:58:42 1691] DEBUG (XendCheckpoint:394) store-mfn 170005
[2010-09-27 16:58:42 1691] INFO (XendCheckpoint:423) Restore exit with rc=0
[2010-09-27 16:58:42 1691] DEBUG (XendCheckpoint:394) console-mfn 170004
[2010-09-27 16:58:42 1691] DEBUG (XendDomainInfo:2992) XendDomainInfo.completeRestore
[2010-09-27 16:58:42 1691] DEBUG (XendDomainInfo:1804) Storing domain details: {'console/ring-ref': '170004', 'image/entry': '18446744071584096768', 'console/port': '2', 'store/ring-ref': '170005', 'image/loader': 'generic', 'vm': '/vm/7502719d-2d2c-9c3f-94ba-d6692dfc44bd', 'control/platform-feature-multiprocessor-suspend': '1', 'image/hv-start-low': '18446603336221196288', 'image/guest-os': 'linux', 'image/virt-base': '18446744071562067968', 'memory/target': '131072', 'image/guest-version': '2.6', 'image/pae-mode': 'yes', 'description': '', 'console/limit': '1048576', 'image/paddr-offset': '0', 'image/hypercall-page': '18446744071578882048', 'image/suspend-cancel': '1', 'cpu/0/availability': 'online', 'image/features/pae-pgdir-above-4gb': '1', 'image/features/writable-page-tables': '0', 'console/type': 'xenconsoled', 'name': 'my-xen1', 'domid': '1', 'image/xen-version': 'xen-3.0', 'store/port': '1'}
[2010-09-27 16:58:42 1691] DEBUG (XendDomainInfo:3005) XendDomainInfo.completeRestore done
[2010-09-27 16:58:42 1691] DEBUG (DevController:139) Waiting for devices vif2.
[2010-09-27 16:58:42 1691] DEBUG (XendDomainInfo:1891) XendDomainInfo.handleShutdownWatch
[2010-09-27 16:58:42 1691] DEBUG (DevController:139) Waiting for devices vif.
[2010-09-27 16:58:42 1691] DEBUG (DevController:144) Waiting for 0.
[2010-09-27 16:58:42 1691] DEBUG (DevController:628) hotplugStatusCallback /local/domain/0/backend/vif/1/0/hotplug-status.
[2010-09-27 16:58:42 1691] DEBUG (DevController:642) hotplugStatusCallback 1.
[2010-09-27 16:58:42 1691] DEBUG (DevController:139) Waiting for devices vscsi.
[2010-09-27 16:58:42 1691] DEBUG (DevController:139) Waiting for devices vbd.
[2010-09-27 16:58:42 1691] DEBUG (DevController:144) Waiting for 51714.
[2010-09-27 16:58:42 1691] DEBUG (DevController:628) hotplugStatusCallback /local/domain/0/backend/vbd/1/51714/hotplug-status.
[2010-09-27 16:58:42 1691] DEBUG (DevController:642) hotplugStatusCallback 1.
[2010-09-27 16:58:42 1691] DEBUG (DevController:144) Waiting for 51713.
[2010-09-27 16:58:42 1691] DEBUG (DevController:628) hotplugStatusCallback /local/domain/0/backend/vbd/1/51713/hotplug-status.
[2010-09-27 16:58:42 1691] DEBUG (DevController:642) hotplugStatusCallback 1.
[2010-09-27 16:58:42 1691] DEBUG (DevController:139) Waiting for devices ioports.
[2010-09-27 16:58:42 1691] DEBUG (DevController:139) Waiting for devices irq.
[2010-09-27 16:58:42 1691] DEBUG (DevController:139) Waiting for devices vkbd.
[2010-09-27 16:58:42 1691] DEBUG (DevController:139) Waiting for devices vfb.
[2010-09-27 16:58:42 1691] DEBUG (DevController:139) Waiting for devices console.
[2010-09-27 16:58:42 1691] DEBUG (DevController:144) Waiting for 0.
[2010-09-27 16:58:42 1691] DEBUG (DevController:139) Waiting for devices pci.
[2010-09-27 16:58:42 1691] DEBUG (DevController:139) Waiting for devices tap2.
[2010-09-27 16:58:42 1691] DEBUG (DevController:139) Waiting for devices tap.
[2010-09-27 16:58:42 1691] DEBUG (DevController:139) Waiting for devices vusb.
[2010-09-27 16:58:42 1691] DEBUG (DevController:139) Waiting for devices vtpm.