Seems to
work all fine, but when I start a live migration, just at the point he starts
de VM on the new server the Vm hangs.
it a windows 2003 x64 installation.
xen 3.1
opensuse 10.3
Where to start searching for the solution?
Richard
++++++++++++++++++++++++++++++
Log INFO
++++++++++++++++++++++++++++++
De debug
.log is empty
suggestions what it could be?
Richard
XEND.LOG
[2008-03-06 11:04:32 27856] INFO (SrvDaemon:331) Xend Daemon started
[2008-03-06 11:04:32 27856] INFO (SrvDaemon:335) Xend changeset: 15042.
[2008-03-06 11:04:32 27856] INFO (SrvDaemon:342) Xend version: Unknown.
[2008-03-06 11:04:33 27856] DEBUG (XendDomainInfo:126)
XendDomainInfo.recreate({'max_vcpu_id': 1, 'cpu_time': 29829924093409L,
'ssidref': 0, 'hvm': 0, 'shutdown_reason': 0, 'dying': 0, 'online_vcpus': 2,
'domid': 0, 'paused': 0, 'crashed': 0, 'running': 1, 'maxmem_kb': 17179869180L,
'shutdown': 0, 'mem_kb': 491520L, 'handle': [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0,
0, 0, 0, 0, 0], 'blocked': 0, 'name': 'Domain-0'})
[2008-03-06 11:04:33 27856] INFO (XendDomainInfo:143) Recreating domain 0, UUID
00000000-0000-0000-0000-000000000000. at /local/domain/0
[2008-03-06 11:04:33 27856] DEBUG (XendDomain:435) Adding Domain: 0
[2008-03-06 11:04:33 27856] DEBUG (XendDomain:380) number of vcpus to use is
0
[2008-03-06 11:04:33 27856] DEBUG (XendDomainInfo:916) Storing domain details:
{'name': 'Domain-0', 'console/limit': '1048576', 'memory/target': '491520',
'vm': '/vm/00000000-0000-0000-0000-000000000000', 'domid': '0',
'cpu/0/availability': 'online', 'cpu/1/availability': 'online',
'control/platform-feature-multiprocessor-suspend': '1'}
[2008-03-06 11:04:33 27856] INFO (SrvServer:181) unix
path=/var/lib/xend/xend-socket
[2008-03-06 11:04:33 27856] DEBUG (XendDomainInfo:1000)
XendDomainInfo.handleShutdownWatch
[2008-03-06 11:04:33 27856] WARNING (XendAPI:672) API call: VBD.set_device not
found
[2008-03-06 11:04:33 27856] WARNING (XendAPI:672) API call: VBD.set_type not
found
[2008-03-06 11:04:33 27856] WARNING (XendAPI:672) API call:
VM.get_auto_power_on not found
[2008-03-06 11:04:33 27856] WARNING (XendAPI:672) API call:
VM.set_auto_power_on not found
[2008-03-06 11:04:33 27856] WARNING (XendAPI:672) API call: debug.get_all not
found
[2008-03-06 11:04:33 27856] WARNING (XendAPI:672) API call: VIF.get_network not
found
[2008-03-06 11:04:33 27856] WARNING (XendAPI:672) API call: VIF.set_device not
found
[2008-03-06 11:04:33 27856] WARNING (XendAPI:672) API call: VIF.set_MAC not
found
[2008-03-06 11:04:33 27856] WARNING (XendAPI:672) API call: VIF.set_MTU not
found
[2008-03-06 11:04:33 27856] WARNING (XendAPI:672) API call:
session.get_all_records not found
[2008-03-06 11:04:33 27856] WARNING (XendAPI:672) API call: event.get_record
not found
[2008-03-06 11:04:33 27856] WARNING (XendAPI:672) API call: event.get_all not
found
[2008-03-06 11:04:33 27856] INFO (XMLRPCServer:149) Opening Unix domain socket XML-RPC
server on /var/run/xend/xen-api.sock; authentication has been disabled for this
server.
[2008-03-06 11:04:33 27856] INFO (XMLRPCServer:127) Opening TCP XML-RPC server
on all interfaces, port 8006.
[2008-03-06 11:04:33 27856] INFO (XMLRPCServer:149) Opening Unix domain socket
XML-RPC server on /var/run/xend/xmlrpc.sock.
[2008-03-06 11:04:43 27856] DEBUG (XendDomainInfo:210)
XendDomainInfo.restore(['domain', ['domid', '15'], ['on_crash', 'destroy'],
['uuid', '1641676e-c8f4-9d24-7e9d-e5a6f6debccc'], ['bootloader_args'],
['vcpus', '4'], ['name', 'windows2003x64-services'], ['on_poweroff',
'destroy'], ['on_reboot', 'restart'], ['bootloader'], ['maxmem', '1000'],
['memory', '1000'], ['shadow_memory', '12'], ['vcpu_avail', '15'],
['cpu_weight', '256'], ['cpu_cap', '0'], ['features'], ['on_xend_start',
'ignore'], ['on_xend_stop', 'ignore'], ['start_time', '1204797453.81'],
['cpu_time', '34.864158525'], ['online_vcpus', '4'], ['image', ['hvm',
['kernel', '/usr/lib/xen/boot/hvmloader'], ['acpi', '1'], ['apic', '1'],
['boot', 'c'], ['device_model', '/usr/lib64/xen/bin/qemu-dm'], ['isa', '0'],
['localtime', '0'], ['monitor', '0'], ['nographic', '0'], ['pae', '1'],
['rtc_timeoffset', '0'], ['sdl', '0'], ['stdvga', '0'], ['usb', '0'], ['vnc',
'1'], ['vncunused', '1'], ['xauthority', '/root/.Xauthority'], ['notes',
['SUSPEND_CANCEL', '1']]]], ['status', '2'], ['state', '-b----'], ['store_mfn',
'255998'], ['device', ['vif', ['bridge', 'xenbr3'], ['uuid',
'c4bda149-eae3-c691-5578-539aa0567fb7'], ['script', 'vif-bridge'], ['mac',
'00:16:3e:2a:da:c1'], ['type', 'netfront'], ['backend', '0']]], ['device',
['vif', ['bridge', 'xenbr1'], ['uuid', '13c75c94-9dc0-34be-ff4d-df19a117a5ff'],
['script', 'vif-bridge'], ['mac', '00:16:3e:2a:da:c2'], ['type', 'netfront'],
['backend', '0']]], ['device', ['vbd', ['uname',
'file:/img_xen/windows2003x64-services/disk0'], ['uuid',
'029dffca-6624-8945-a0eb-269eddf7fcce'], ['mode', 'w'], ['dev', 'hda:disk'],
['backend', '0'], ['bootable', '1']]], ['device', ['vfb', ['vncunused', '1'],
['type', 'vnc'], ['uuid', 'cf05ae37-969e-4c59-03b2-593112440c1f'], ['location',
'localhost:5900']]], ['device', ['console', ['protocol', 'vt100'], ['location',
'6'], ['uuid', '16d7c71e-d3d7-f300-19ac-b447c804027e']]]])
[2008-03-06 11:04:43 27856] DEBUG (XendDomainInfo:1512)
XendDomainInfo.constructDomain
[2008-03-06 11:04:43 27856] DEBUG (balloon:132) Balloon: 1562500 KiB free; need
2048; done.
[2008-03-06 11:04:43 27856] DEBUG (XendDomain:435) Adding Domain: 26
[2008-03-06 11:04:43 27856] DEBUG (XendDomainInfo:2073) Storing VM details:
{'on_xend_stop': 'ignore', 'shadow_memory': '12', 'uuid':
'1641676e-c8f4-9d24-7e9d-e5a6f6debccc', 'on_reboot': 'restart', 'start_time':
'1204797453.81', 'on_poweroff': 'destroy', 'on_xend_start': 'ignore',
'on_crash': 'destroy', 'xend/restart_count': '0', 'vcpus': '4', 'vcpu_avail':
'15', 'image': '(hvm (kernel /usr/lib/xen/boot/hvmloader) (acpi 1) (apic 1)
(boot c) (device_model /usr/lib64/xen/bin/qemu-dm) (isa 0) (localtime 0)
(monitor 0) (nographic 0) (pae 1) (rtc_timeoffset 0) (sdl 0) (stdvga 0) (usb 0)
(vnc 1) (vncunused 1) (xauthority /root/.Xauthority) (notes (SUSPEND_CANCEL
1)))', 'name': 'windows2003x64-services'}
[2008-03-06 11:04:43 27856] INFO (XendDomainInfo:1412) createDevice: vfb :
{'vncunused': '1', 'other_config': {'vncunused': '1', 'type': 'vnc'}, 'type':
'vnc', 'uuid': 'cf05ae37-969e-4c59-03b2-593112440c1f', 'location':
'localhost:5900'}
[2008-03-06 11:04:43 27856] DEBUG (DevController:117) DevController: writing
{'state': '1', 'backend-id': '0', 'backend': '/local/domain/0/backend/vfb/26/0'}
to /local/domain/26/device/vfb/0.
[2008-03-06 11:04:43 27856] DEBUG (DevController:119) DevController: writing
{'vncunused': '1', 'domain': 'windows2003x64-services', 'frontend':
'/local/domain/26/device/vfb/0', 'uuid': 'cf05ae37-969e-4c59-03b2-593112440c1f',
'state': '1', 'location': 'localhost:5900', 'online': '1', 'frontend-id': '26',
'type': 'vnc'} to /local/domain/0/backend/vfb/26/0.
[2008-03-06 11:04:43 27856] INFO (XendDomainInfo:1412) createDevice: console :
{'protocol': 'vt100', 'location': '6', 'uuid':
'16d7c71e-d3d7-f300-19ac-b447c804027e'}
[2008-03-06 11:04:43 27856] DEBUG (DevController:117) DevController: writing
{'state': '1', 'backend-id': '0', 'backend':
'/local/domain/0/backend/console/26/0'} to /local/domain/26/device/console/0.
[2008-03-06 11:04:43 27856] DEBUG (DevController:119) DevController: writing
{'domain': 'windows2003x64-services', 'protocol': 'vt100', 'uuid':
'16d7c71e-d3d7-f300-19ac-b447c804027e', 'frontend':
'/local/domain/26/device/console/0', 'state': '1', 'location': '6', 'online':
'1', 'frontend-id': '26'} to /local/domain/0/backend/console/26/0.
[2008-03-06 11:04:43 27856] INFO (XendDomainInfo:1412) createDevice: vbd :
{'uuid': '029dffca-6624-8945-a0eb-269eddf7fcce', 'bootable': 1, 'driver':
'paravirtualised', 'dev': 'hda:disk', 'uname':
'file:/img_xen/windows2003x64-services/disk0', 'mode': 'w', 'backend':
'0'}
[2008-03-06 11:04:43 27856] DEBUG (DevController:117) DevController: writing
{'backend-id': '0', 'virtual-device': '768', 'device-type': 'disk', 'state':
'1', 'backend': '/local/domain/0/backend/vbd/26/768'} to
/local/domain/26/device/vbd/768.
[2008-03-06 11:04:43 27856] DEBUG (DevController:119) DevController: writing
{'domain': 'windows2003x64-services', 'frontend': '/local/domain/26/device/vbd/768',
'uuid': '029dffca-6624-8945-a0eb-269eddf7fcce', 'dev': 'hda', 'state': '1',
'params': '/img_xen/windows2003x64-services/disk0', 'mode': 'w', 'online': '1',
'frontend-id': '26', 'type': 'file'} to /local/domain/0/backend/vbd/26/768.
[2008-03-06 11:04:43 27856] INFO (XendDomainInfo:1412) createDevice: vif :
{'bridge': 'xenbr3', 'uuid': 'c4bda149-eae3-c691-5578-539aa0567fb7', 'script':
'vif-bridge', 'mac': '00:16:3e:2a:da:c1', 'type': 'netfront', 'backend':
'0'}
[2008-03-06 11:04:43 27856] DEBUG (DevController:117) DevController: writing
{'backend-id': '0', 'mac': '00:16:3e:2a:da:c1', 'handle': '0', 'state': '1',
'backend': '/local/domain/0/backend/vif/26/0'} to
/local/domain/26/device/vif/0.
[2008-03-06 11:04:43 27856] DEBUG (DevController:119) DevController: writing
{'bridge': 'xenbr3', 'domain': 'windows2003x64-services', 'handle': '0',
'uuid': 'c4bda149-eae3-c691-5578-539aa0567fb7', 'script':
'/etc/xen/scripts/vif-bridge', 'state': '1', 'frontend':
'/local/domain/26/device/vif/0', 'mac': '00:16:3e:2a:da:c1', 'online': '1',
'frontend-id': '26', 'type': 'netfront'} to
/local/domain/0/backend/vif/26/0.
[2008-03-06 11:04:43 27856] INFO (XendDomainInfo:1412) createDevice: vif :
{'bridge': 'xenbr1', 'uuid': '13c75c94-9dc0-34be-ff4d-df19a117a5ff', 'script':
'vif-bridge', 'mac': '00:16:3e:2a:da:c2', 'type': 'netfront', 'backend':
'0'}
[2008-03-06 11:04:43 27856] DEBUG (DevController:117) DevController: writing
{'backend-id': '0', 'mac': '00:16:3e:2a:da:c2', 'handle': '1', 'state': '1', 'backend':
'/local/domain/0/backend/vif/26/1'} to /local/domain/26/device/vif/1.
[2008-03-06 11:04:43 27856] DEBUG (DevController:119) DevController: writing
{'bridge': 'xenbr1', 'domain': 'windows2003x64-services', 'handle': '1',
'uuid': '13c75c94-9dc0-34be-ff4d-df19a117a5ff', 'script':
'/etc/xen/scripts/vif-bridge', 'state': '1', 'frontend':
'/local/domain/26/device/vif/1', 'mac': '00:16:3e:2a:da:c2', 'online': '1',
'frontend-id': '26', 'type': 'netfront'} to
/local/domain/0/backend/vif/26/1.
[2008-03-06 11:04:43 27856] DEBUG (XendDomainInfo:916) Storing domain details:
{'console/port': '6', 'cpu/3/availability': 'online', 'name':
'windows2003x64-services', 'console/limit': '1048576', 'cpu/2/availability':
'online', 'vm': '/vm/1641676e-c8f4-9d24-7e9d-e5a6f6debccc', 'domid': '26',
'image/suspend-cancel': '1', 'cpu/0/availability': 'online', 'memory/target':
'1024000', 'control/platform-feature-multiprocessor-suspend': '1',
'cpu/1/availability': 'online', 'store/port': '5'}
[2008-03-06 11:04:43 27856] INFO (XendCheckpoint:191) restore hvm domain 26,
apic=1, pae=1
[2008-03-06 11:04:43 27856] DEBUG (XendCheckpoint:201) restore:shadow=0xc,
_static_max=0x3e800000, _static_min=0x0,
[2008-03-06 11:04:43 27856] DEBUG (balloon:132) Balloon: 1561452 KiB free; need
1036288; done.
[2008-03-06 11:04:43 27856] DEBUG (XendCheckpoint:213) [xc_restore]:
/usr/lib64/xen/bin/xc_restore 16 26 5 6 1 1 1
[2008-03-06 11:04:43 27856] INFO (XendCheckpoint:349) xc_domain_restore start:
p2m_size = 100000
[2008-03-06 11:04:43 27856] INFO (XendCheckpoint:349) Reloading memory pages:
0%
[2008-03-06 11:05:03 27856] INFO (XendCheckpoint:349) Received all pages (0
races)
[2008-03-06 11:05:03 27856] INFO (XendCheckpoint:349) Restore exit with
rc=0
[2008-03-06 11:05:03 27856] DEBUG (XendCheckpoint:320) store-mfn 255998
[2008-03-06 11:05:04 27856] DEBUG (XendDomainInfo:1700)
XendDomainInfo.completeRestore
[2008-03-06 11:05:04 27856] DEBUG (image:330) args: boot, val: c
[2008-03-06 11:05:04 27856] DEBUG (image:330) args: fda, val: None
[2008-03-06 11:05:04 27856] DEBUG (image:330) args: fdb, val: None
[2008-03-06 11:05:04 27856] DEBUG (image:330) args: soundhw, val: None
[2008-03-06 11:05:04 27856] DEBUG (image:330) args: localtime, val: 0
[2008-03-06 11:05:04 27856] DEBUG (image:330) args: serial, val: None
[2008-03-06 11:05:04 27856] DEBUG (image:330) args: std-vga, val: 0
[2008-03-06 11:05:04 27856] DEBUG (image:330) args: isa, val: 0
[2008-03-06 11:05:04 27856] DEBUG (image:330) args: acpi, val: 1
[2008-03-06 11:05:04 27856] DEBUG (image:330) args: usb, val: 0
[2008-03-06 11:05:04 27856] DEBUG (image:330) args: usbdevice, val: None
[2008-03-06 11:05:04 27856] DEBUG (image:330) args: k, val: None
[2008-03-06 11:05:04 27856] INFO (image:448) spawning device models: /usr/lib64/xen/bin/qemu-dm
['/usr/lib64/xen/bin/qemu-dm', '-d', '26', '-vcpus', '4', '-boot', 'c',
'-acpi', '-domain-name', 'windows2003x64-services', '-vncunused', '-vnclisten',
'127.0.0.1', '-loadvm', '/tmp/xen.qemu-dm.26']
[2008-03-06 11:05:04 27856] INFO (image:452) device model pid: 28259
[2008-03-06 11:05:04 27856] DEBUG (XendDomainInfo:916) Storing domain details:
{'console/port': '6', 'cpu/3/availability': 'online', 'name':
'windows2003x64-services', 'console/limit': '1048576', 'cpu/2/availability':
'online', 'vm': '/vm/1641676e-c8f4-9d24-7e9d-e5a6f6debccc', 'domid': '26',
'image/suspend-cancel': '1', 'cpu/0/availability': 'online', 'memory/target':
'1024000', 'control/platform-feature-multiprocessor-suspend': '1',
'store/ring-ref': '255998', 'cpu/1/availability': 'online', 'store/port':
'5'}
[2008-03-06 11:05:04 27856] DEBUG (XendDomainInfo:1714)
XendDomainInfo.completeRestore done
[2008-03-06 11:05:04 27856] DEBUG (DevController:150) Waiting for devices
vif.
[2008-03-06 11:05:04 27856] DEBUG (DevController:155) Waiting for 0.
[2008-03-06 11:05:04 27856] DEBUG (XendDomainInfo:1000)
XendDomainInfo.handleShutdownWatch
[2008-03-06 11:05:04 27856] DEBUG (DevController:575) hotplugStatusCallback
/local/domain/0/backend/vif/26/0/hotplug-status.
[2008-03-06 11:05:04 27856] DEBUG (DevController:589) hotplugStatusCallback
1.
[2008-03-06 11:05:04 27856] DEBUG (DevController:155) Waiting for 1.
[2008-03-06 11:05:04 27856] DEBUG (DevController:575) hotplugStatusCallback
/local/domain/0/backend/vif/26/1/hotplug-status.
[2008-03-06 11:05:04 27856] DEBUG (DevController:589) hotplugStatusCallback
1.
[2008-03-06 11:05:04 27856] DEBUG (DevController:150) Waiting for devices
usb.
[2008-03-06 11:05:04 27856] DEBUG (DevController:150) Waiting for devices
vbd.
[2008-03-06 11:05:04 27856] DEBUG (DevController:155) Waiting for 768.
[2008-03-06 11:05:04 27856] DEBUG (DevController:575) hotplugStatusCallback
/local/domain/0/backend/vbd/26/768/hotplug-status.
[2008-03-06 11:05:04 27856] DEBUG (DevController:589) hotplugStatusCallback
1.
[2008-03-06 11:05:04 27856] DEBUG (DevController:150) Waiting for devices
irq.
[2008-03-06 11:05:04 27856] DEBUG (DevController:150) Waiting for devices
vkbd.
[2008-03-06 11:05:04 27856] DEBUG (DevController:150) Waiting for devices
vfb.
[2008-03-06 11:05:04 27856] DEBUG (vfbif:94) skip waiting for HVM vfb
[2008-03-06 11:05:04 27856] DEBUG (DevController:150) Waiting for devices
console.
[2008-03-06 11:05:04 27856] DEBUG (DevController:155) Waiting for 0.
[2008-03-06 11:05:04 27856] DEBUG (DevController:150) Waiting for devices
pci.
[2008-03-06 11:05:04 27856] DEBUG (DevController:150) Waiting for devices
ioports.
[2008-03-06 11:05:04 27856] DEBUG (DevController:150) Waiting for devices
tap.
[2008-03-06 11:05:04 27856]
DEBUG (DevController:150) Waiting for devices vtpm.