Attachment 229941 Details for Bug 336291 – Relevant parts from /var/log/xen/xend.log

Relevant parts from /var/log/xen/xend.log

xen-log (text/plain), 10.80 KB, created by Robert Scheck on 2007-10-17 15:39:17 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Robert Scheck

Created: 2007-10-17 15:39:17 UTC

Size: 10.80 KB

patch

obsolete

>[2007-10-17 15:56:26 xend 4935] DEBUG (XendCheckpoint:83) [xc_save]: /usr/lib64/xen/bin/xc_save 4 2 0 0 0
>[2007-10-17 15:56:26 xend 4935] INFO (XendCheckpoint:239) Couldn't map p2m_frame_list_list (errno 14): 14
>[2007-10-17 15:56:26 xend 4935] INFO (XendCheckpoint:239) Save exit rc=1
>[2007-10-17 15:56:26 xend 4935] ERROR (XendCheckpoint:106) Save failed on domain central (2).
>Traceback (most recent call last):
>  File "/usr/lib64/python2.4/site-packages/xen/xend/XendCheckpoint.py", line 100, in save
>    forkHelper(cmd, fd, saveInputHandler, False)
>  File "/usr/lib64/python2.4/site-packages/xen/xend/XendCheckpoint.py", line 227, in forkHelper
>    raise XendError("%s failed" % string.join(cmd))
>XendError: /usr/lib64/xen/bin/xc_save 4 2 0 0 0 failed
>[2007-10-17 15:56:26 xend 4935] DEBUG (image:458) hvm_shutdown fired, shutdown reason=halt
>[2007-10-17 15:56:26 xend.XendDomainInfo 4935] INFO (XendDomainInfo:899) Domain has shutdown: name=central id=2 reason=halt.
>[2007-10-17 15:56:26 xend.XendDomainInfo 4935] DEBUG (XendDomainInfo:1463) XendDomainInfo.destroy: domid=2
>[2007-10-17 15:56:26 xend.XendDomainInfo 4935] DEBUG (XendDomainInfo:1471) XendDomainInfo.destroyDomain(2)
>[2007-10-17 15:56:26 xend 4935] DEBUG (image:447) hvm shutdown watch unregistered
>[2007-10-17 15:59:19 xend 4714] INFO (SrvDaemon:283) Xend Daemon started
>[2007-10-17 15:59:19 xend 4714] INFO (SrvDaemon:287) Xend changeset: unavailable .
>[2007-10-17 15:59:19 xend.XendDomainInfo 4714] DEBUG (XendDomainInfo:212) XendDomainInfo.recreate({'paused': 0, 'cpu_time': 29333323657L, 'ssidref': 0, 'handle': [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0], 'shutdown_reason': 0, 'dying': 0, 'dom': 0, 'mem_kb': 8131428, 'maxmem_kb': 17179869180, 'max_vcpu_id': 3, 'crashed': 0, 'running': 1, 'shutdown': 0, 'online_vcpus': 4, 'blocked': 0})
>[2007-10-17 15:59:19 xend.XendDomainInfo 4714] INFO (XendDomainInfo:224) Recreating domain 0, UUID 00000000-0000-0000-0000-000000000000.
>[2007-10-17 15:59:19 xend.XendDomainInfo 4714] WARNING (XendDomainInfo:246) No vm path in store for existing domain 0
>[2007-10-17 15:59:19 xend.XendDomainInfo 4714] DEBUG (XendDomainInfo:715) Storing VM details: {'shadow_memory': '0', 'uuid': '00000000-0000-0000-0000-000000000000', 'on_reboot': 'restart', 'on_poweroff': 'destroy', 'name': 'Domain-0', 'xend/restart_count': '0', 'vcpus': '4', 'vcpu_avail': '15', 'memory': '7941', 'on_crash': 'restart', 'maxmem': '7941'}
>[2007-10-17 15:59:19 xend.XendDomainInfo 4714] DEBUG (XendDomainInfo:750) Storing domain details: {'cpu/1/availability': 'online', 'cpu/3/availability': 'online', 'name': 'Domain-0', 'console/limit': '1048576', 'cpu/2/availability': 'online', 'vm': '/vm/00000000-0000-0000-0000-000000000000', 'domid': '0', 'cpu/0/availability': 'online', 'memory/target': '8131584'}
>[2007-10-17 15:59:19 xend 4714] DEBUG (XendDomain:153) number of vcpus to use is 0
>[2007-10-17 15:59:19 xend.XendDomainInfo 4714] DEBUG (XendDomainInfo:940) XendDomainInfo.handleShutdownWatch
>[2007-10-17 15:59:19 xend 4714] INFO (SrvServer:116) unix path=/var/lib/xend/xend-socket
>[2007-10-17 15:59:23 xend.XendDomainInfo 4714] DEBUG (XendDomainInfo:265) XendDomainInfo.restore(['domain', ['domid', '2'], ['uuid', '182755a8-c304-f0f5-5fab-ce8c1c2fc7f7'], ['vcpus', '1'], ['vcpu_avail', '1'], ['cpu_weight', '1.0'], ['memory', '512'], ['shadow_memory', '4'], ['maxmem', '512'], ['features'], ['localtime', '1'], ['name', 'central'], ['on_poweroff', 'destroy'], ['on_reboot', 'restart'], ['on_crash','restart'], ['image', ['hvm', ['kernel', '/usr/lib/xen/boot/hvmloader'], ['device_model', '/usr/lib64/xen/bin/qemu-dm'], ['pae', '1'], ['vcpus', '1'], ['boot', 'c'], ['localtime', '1'], ['serial', 'pty'], ['vnc', '1'], ['vncunused', '1'], ['xauthority', '/root/.Xauthority'], ['acpi', '1'], ['apic', '1'], ['vncpasswd', 'None']]], ['device', ['vif', ['backend', '0'], ['script', 'vif-bridge'], ['bridge', 'xenbr1'], ['mac', '00:16:3e:69:6d:21'], ['type', 'ioemu']]], ['device', ['vbd', ['backend', '0'], ['dev', 'hda:disk'], ['uname', 'file:/var/lib/xen/images/central/hda'], ['mode', 'w']]], ['device', ['vkbd', ['backend', '0']]], ['device', ['vfb', ['backend', '0'], ['type', 'vnc'], ['vncunused', '1'], ['xauthority', '/root/.Xauthority']]], ['state', '-b----'], ['shutdown_reason', 'poweroff'], ['cpu_time', '12961.3341755'], ['online_vcpus', '1'], ['up_time', '506367.057775'], ['start_time', '1192123019.0'], ['store_mfn', '69146']])
>[2007-10-17 15:59:23 xend.XendDomainInfo 4714] DEBUG (XendDomainInfo:296) parseConfig: config is ['domain', ['domid', '2'], ['uuid', '182755a8-c304-f0f5-5fab-ce8c1c2fc7f7'], ['vcpus', '1'], ['vcpu_avail', '1'], ['cpu_weight', '1.0'], ['memory', '512'], ['shadow_memory', '4'], ['maxmem', '512'], ['features'], ['localtime', '1'], ['name', 'central'], ['on_poweroff', 'destroy'], ['on_reboot', 'restart'], ['on_crash','restart'], ['image', ['hvm', ['kernel', '/usr/lib/xen/boot/hvmloader'], ['device_model', '/usr/lib64/xen/bin/qemu-dm'], ['pae', '1'], ['vcpus', '1'], ['boot', 'c'], ['localtime', '1'], ['serial', 'pty'], ['vnc', '1'], ['vncunused', '1'], ['xauthority', '/root/.Xauthority'], ['acpi', '1'], ['apic', '1'], ['vncpasswd', 'None']]], ['device', ['vif', ['backend', '0'], ['script', 'vif-bridge'], ['bridge', 'xenbr1'], ['mac', '00:16:3e:69:6d:21'], ['type', 'ioemu']]], ['device', ['vbd', ['backend', '0'], ['dev', 'hda:disk'], ['uname', 'file:/var/lib/xen/images/central/hda'], ['mode', 'w']]], ['device', ['vkbd', ['backend', '0']]], ['device', ['vfb', ['backend', '0'], ['type', 'vnc'], ['vncunused', '1'], ['xauthority', '/root/.Xauthority']]], ['state', '-b----'], ['shutdown_reason', 'poweroff'], ['cpu_time', '12961.3341755'], ['online_vcpus', '1'], ['up_time', '506367.057775'], ['start_time', '1192123019.0'], ['store_mfn', '69146']]
>[2007-10-17 15:59:23 xend.XendDomainInfo 4714] DEBUG (XendDomainInfo:397) parseConfig: result is {'shadow_memory': 4, 'start_time': 1192123019.0, 'uuid': '182755a8-c304-f0f5-5fab-ce8c1c2fc7f7', 'on_crash': 'restart', 'on_reboot': 'restart', 'localtime': 1, 'image': ['hvm', ['kernel', '/usr/lib/xen/boot/hvmloader'], ['device_model', '/usr/lib64/xen/bin/qemu-dm'], ['pae', '1'], ['vcpus', '1'], ['boot', 'c'], ['localtime', '1'], ['serial', 'pty'], ['vnc', '1'], ['vncunused', '1'], ['xauthority', '/root/.Xauthority'], ['acpi', '1'], ['apic', '1'], ['vncpasswd', 'None']], 'on_poweroff': 'destroy', 'bootloader_args': None, 'cpus': None, 'name': 'central', 'backend': [], 'vcpus': 1, 'cpu_weight': 1.0, 'features': None, 'vcpu_avail': 1, 'memory': 512, 'device': [('vif', ['vif', ['backend', '0'], ['script', 'vif-bridge'], ['bridge','xenbr1'], ['mac', '00:16:3e:69:6d:21'], ['type', 'ioemu']]), ('vbd', ['vbd', ['backend', '0'], ['dev', 'hda:disk'], ['uname', 'file:/var/lib/xen/images/central/hda'], ['mode', 'w']]), ('vkbd', ['vkbd', ['backend', '0']]), ('vfb', ['vfb', ['backend', '0'], ['type', 'vnc'], ['vncunused', '1'], ['xauthority', '/root/.Xauthority']])], 'bootloader': None, 'cpu': None, 'maxmem': 512}
>[2007-10-17 15:59:23 xend.XendDomainInfo 4714] DEBUG (XendDomainInfo:1264) XendDomainInfo.construct: None
>[2007-10-17 15:59:23 xend.XendDomainInfo 4714] DEBUG (XendDomainInfo:715) Storing VM details: {'shadow_memory': '4', 'uuid': '182755a8-c304-f0f5-5fab-ce8c1c2fc7f7', 'on_reboot': 'restart', 'start_time': '1192123019.0', 'on_poweroff': 'destroy', 'name': 'central', 'xend/restart_count': '0', 'vcpus': '1', 'vcpu_avail': '1', 'memory': '512', 'on_crash': 'restart', 'image': '(hvm (kernel /usr/lib/xen/boot/hvmloader) (device_model /usr/lib64/xen/bin/qemu-dm) (pae 1) (vcpus 1) (boot c) (localtime 1) (serial pty) (vnc 1) (vncunused 1) (xauthority /root/.Xauthority) (acpi 1) (apic 1) (vncpasswd None))', 'maxmem': '512'}
>[2007-10-17 15:59:23 xend 4714] DEBUG (DevController:110) DevController: writing {'state': '1', 'backend-id': '0', 'backend': '/local/domain/0/backend/vif/1/0'} to /local/domain/1/device/vif/0.
>[2007-10-17 15:59:23 xend 4714] DEBUG (DevController:112) DevController: writing {'bridge': 'xenbr1', 'domain': 'central', 'handle': '0', 'script': '/etc/xen/scripts/vif-bridge', 'state': '1', 'frontend': '/local/domain/1/device/vif/0', 'mac': '00:16:3e:69:6d:21', 'online': '1', 'frontend-id': '1', 'type': 'ioemu'} to /local/domain/0/backend/vif/1/0.
>[2007-10-17 15:59:23 xend 4714] DEBUG (DevController:110) DevController: writing {'backend-id': '0', 'virtual-device': '768', 'device-type': 'disk', 'state': '1', 'backend': '/local/domain/0/backend/vbd/1/768'} to /local/domain/1/device/vbd/768.
>[2007-10-17 15:59:23 xend 4714] DEBUG (DevController:112) DevController: writing {'domain': 'central', 'frontend': '/local/domain/1/device/vbd/768', 'dev': 'hda', 'state': '1', 'params': '/var/lib/xen/images/central/hda', 'mode': 'w', 'online': '1', 'frontend-id': '1', 'type': 'file'} to /local/domain/0/backend/vbd/1/768.
>[2007-10-17 15:59:23 xend 4714] DEBUG (DevController:110) DevController: writing {'state': '1', 'backend-id': '0', 'backend': '/local/domain/0/backend/vkbd/1/0'} to /local/domain/1/device/vkbd/0.
>[2007-10-17 15:59:23 xend 4714] DEBUG (DevController:112) DevController: writing {'frontend-id': '1', 'domain': 'central', 'frontend': '/local/domain/1/device/vkbd/0', 'state': '1', 'online': '1'} to /local/domain/0/backend/vkbd/1/0.
>[2007-10-17 15:59:23 xend 4714] DEBUG (DevController:110) DevController: writing {'state': '1', 'backend-id': '0', 'backend': '/local/domain/0/backend/vfb/1/0'} to /local/domain/1/device/vfb/0.
>[2007-10-17 15:59:23 xend 4714] DEBUG (DevController:112) DevController: writing {'vncunused': '1', 'domain': 'central', 'frontend': '/local/domain/1/device/vfb/0', 'xauthority': '/root/.Xauthority', 'state':'1', 'online': '1', 'frontend-id': '1', 'type': 'vnc'} to /local/domain/0/backend/vfb/1/0.
>[2007-10-17 15:59:23 xend 4714] DEBUG (vfbif:92) No VNC passwd configured for vfb access
>[2007-10-17 15:59:23 xend.XendDomainInfo 4714] DEBUG (XendDomainInfo:750) Storing domain details: {'console/port': '2', 'name': 'central', 'console/limit': '1048576', 'vm': '/vm/182755a8-c304-f0f5-5fab-ce8c1c2fc7f7', 'domid': '1', 'cpu/0/availability': 'online', 'memory/target': '524288', 'store/port': '1'}
>[2007-10-17 15:59:23 xend 4714] ERROR (XendCheckpoint:48) read_exact: EOF trying to read 8 (buf='')
>[2007-10-17 15:59:23 xend.XendDomainInfo 4714] DEBUG (XendDomainInfo:1463) XendDomainInfo.destroy: domid=1
>[2007-10-17 15:59:23 xend.XendDomainInfo 4714] DEBUG (XendDomainInfo:1471) XendDomainInfo.destroyDomain(1)
>[2007-10-17 15:59:23 xend 4714] ERROR (XendDomain:268) Restore failed
>Traceback (most recent call last):
>  File "/usr/lib64/python2.4/site-packages/xen/xend/XendDomain.py", line 263, in domain_restore_fd
>    return XendCheckpoint.restore(self, fd)
>  File "/usr/lib64/python2.4/site-packages/xen/xend/XendCheckpoint.py", line 144, in restore
>    "not a valid guest state file: pfn count read")
>  File "/usr/lib64/python2.4/site-packages/xen/xend/XendCheckpoint.py", line 50, in read_exact
>    raise XendError(errmsg)
>XendError: not a valid guest state file: pfn count read

Actions: View

Attachments on bug 336291: 229941