Attachment 148509 Details for Bug 229016 – src log

src log

xend.log.src (text/plain), 39.18 KB, created by Jim Klein on 2007-02-21 17:36:00 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Jim Klein

Created: 2007-02-21 17:36:00 UTC

Size: 39.18 KB

patch

obsolete

>[2007-02-21 09:21:36 xend 2775] INFO (SrvDaemon:283) Xend Daemon started
>[2007-02-21 09:21:36 xend 2775] INFO (SrvDaemon:287) Xend changeset: unavailable .
>[2007-02-21 09:21:36 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:212) XendDomainInfo.recreate({'paused': 0, 'cpu_time': 20224517286L, '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': 1925312, 'maxmem_kb': -4, 'max_vcpu_id': 1, 'crashed': 0, 'running': 1, 'shutdown': 0, 'online_vcpus': 2, 'blocked': 0})
>[2007-02-21 09:21:36 xend.XendDomainInfo 2775] INFO (XendDomainInfo:224) Recreating domain 0, UUID 00000000-0000-0000-0000-000000000000.
>[2007-02-21 09:21:36 xend.XendDomainInfo 2775] WARNING (XendDomainInfo:246) No vm path in store for existing domain 0
>[2007-02-21 09:21:36 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:712) 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': '2', 'vcpu_avail': '3', 'memory': '1881', 'on_crash': 'restart', 'maxmem': '1881'}
>[2007-02-21 09:21:37 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:747) Storing domain details: {'cpu/0/availability': 'online', 'memory/target': '1926144', 'cpu/1/availability': 'online', 'name': 'Domain-0', 'console/limit': '1048576', 'vm': '/vm/00000000-0000-0000-0000-000000000000', 'domid': '0'}
>[2007-02-21 09:21:37 xend 2775] DEBUG (XendDomain:153) number of vcpus to use is 0
>[2007-02-21 09:21:37 xend 2775] INFO (SrvServer:116) unix path=/var/lib/xend/xend-socket
>[2007-02-21 09:21:37 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:933) XendDomainInfo.handleShutdownWatch
>[2007-02-21 09:22:57 xend 2775] DEBUG (tcp:66) Match 10.5.1.114 10.5.1.114
>[2007-02-21 09:22:57 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:265) XendDomainInfo.restore(['domain', ['domid', '1'], ['uuid', 'a8c2a095-687c-cf8e-d8ed-bb5f6c8174ff'], ['vcpus', '1'], ['vcpu_avail', '1'], ['cpu_weight', '1.0'], ['memory', '500'], ['shadow_memory', '0'], ['maxmem', '500'], ['bootloader', '/usr/bin/pygrub'], ['features'], ['name', 'RHEL5'], ['on_poweroff', 'destroy'], ['on_reboot', 'restart'], ['on_crash', 'restart'], ['image', ['linux', ['ramdisk', '/var/lib/xen/initrd.kk8WDW'], ['kernel', '/var/lib/xen/vmlinuz.-k-ZPY'], ['args', 'ro root=/dev/VolGroup00/LogVol00 rhgb quiet'], ['vncunused', '1'], ['vnc', '1'], ['display', ':0.0'], ['xauthority', '/root/.xauthzW02Ma']]], ['device', ['vif', ['backend', '0'], ['script', 'vif-bridge'], ['bridge', 'xenbr0'], ['mac', '00:16:3e:6f:08:aa']]], ['device', ['tap', ['backend', '0'], ['dev', 'xvda:disk'], ['uname', 'tap:aio:/vm/rhel5.img'], ['mode', 'w']]], ['state', '-b----'], ['shutdown_reason', 'poweroff'], ['cpu_time', '14.35517705'], ['online_vcpus', '1'], ['up_time', '168.137510061'], ['start_time', '1172078412.91'], ['store_mfn', '291143'], ['console_mfn', '291142']])
>[2007-02-21 09:22:57 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:296) parseConfig: config is ['domain', ['domid', '1'], ['uuid', 'a8c2a095-687c-cf8e-d8ed-bb5f6c8174ff'], ['vcpus', '1'], ['vcpu_avail', '1'], ['cpu_weight', '1.0'], ['memory', '500'], ['shadow_memory', '0'], ['maxmem', '500'], ['bootloader', '/usr/bin/pygrub'], ['features'], ['name', 'RHEL5'], ['on_poweroff', 'destroy'], ['on_reboot', 'restart'], ['on_crash', 'restart'], ['image', ['linux', ['ramdisk', '/var/lib/xen/initrd.kk8WDW'], ['kernel', '/var/lib/xen/vmlinuz.-k-ZPY'], ['args', 'ro root=/dev/VolGroup00/LogVol00 rhgb quiet'], ['vncunused', '1'], ['vnc', '1'], ['display', ':0.0'], ['xauthority', '/root/.xauthzW02Ma']]], ['device', ['vif', ['backend', '0'], ['script', 'vif-bridge'], ['bridge', 'xenbr0'], ['mac', '00:16:3e:6f:08:aa']]], ['device', ['tap', ['backend', '0'], ['dev', 'xvda:disk'], ['uname', 'tap:aio:/vm/rhel5.img'], ['mode', 'w']]], ['state', '-b----'], ['shutdown_reason', 'poweroff'], ['cpu_time', '14.35517705'], ['online_vcpus', '1'], ['up_time', '168.137510061'], ['start_time', '1172078412.91'], ['store_mfn', '291143'], ['console_mfn', '291142']]
>[2007-02-21 09:22:57 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:395) parseConfig: result is {'shadow_memory': 0, 'uuid': 'a8c2a095-687c-cf8e-d8ed-bb5f6c8174ff', 'on_crash': 'restart', 'on_reboot': 'restart', 'localtime': None, 'image': ['linux', ['ramdisk', '/var/lib/xen/initrd.kk8WDW'], ['kernel', '/var/lib/xen/vmlinuz.-k-ZPY'], ['args', 'ro root=/dev/VolGroup00/LogVol00 rhgb quiet'], ['vncunused', '1'], ['vnc', '1'], ['display', ':0.0'], ['xauthority', '/root/.xauthzW02Ma']], 'on_poweroff': 'destroy', 'bootloader_args': None, 'cpus': None, 'name': 'RHEL5', 'backend': [], 'vcpus': 1, 'cpu_weight': 1.0, 'features': None, 'vcpu_avail': 1, 'memory': 500, 'device': [('vif', ['vif', ['backend', '0'], ['script', 'vif-bridge'], ['bridge', 'xenbr0'], ['mac', '00:16:3e:6f:08:aa']]), ('tap', ['tap', ['backend', '0'], ['dev', 'xvda:disk'], ['uname', 'tap:aio:/vm/rhel5.img'], ['mode', 'w']])], 'bootloader': '/usr/bin/pygrub', 'cpu': None, 'maxmem': 500}
>[2007-02-21 09:22:57 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:1253) XendDomainInfo.construct: None
>[2007-02-21 09:22:57 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:712) Storing VM details: {'shadow_memory': '0', 'uuid': 'a8c2a095-687c-cf8e-d8ed-bb5f6c8174ff', 'on_reboot': 'restart', 'image': "(linux (ramdisk /var/lib/xen/initrd.kk8WDW) (kernel /var/lib/xen/vmlinuz.-k-ZPY) (args 'ro root=/dev/VolGroup00/LogVol00 rhgb quiet') (vncunused 1) (vnc 1) (display :0.0) (xauthority /root/.xauthzW02Ma))", 'on_poweroff': 'destroy', 'name': 'RHEL5', 'vcpus': '1', 'vcpu_avail': '1', 'memory': '500', 'on_crash': 'restart', 'maxmem': '500'}
>[2007-02-21 09:22:57 xend 2775] DEBUG (DevController:110) DevController: writing {'backend-id': '0', 'mac': '00:16:3e:6f:08:aa', 'handle': '0', 'state': '1', 'backend': '/local/domain/0/backend/vif/1/0'} to /local/domain/1/device/vif/0.
>[2007-02-21 09:22:57 xend 2775] DEBUG (DevController:112) DevController: writing {'bridge': 'xenbr0', 'domain': 'RHEL5', 'handle': '0', 'script': '/etc/xen/scripts/vif-bridge', 'state': '1', 'frontend': '/local/domain/1/device/vif/0', 'mac': '00:16:3e:6f:08:aa', 'online': '1', 'frontend-id': '1'} to /local/domain/0/backend/vif/1/0.
>[2007-02-21 09:22:57 xend 2775] DEBUG (blkif:24) exception looking up device number for xvda: [Errno 2] No such file or directory: '/dev/xvda'
>[2007-02-21 09:22:57 xend 2775] DEBUG (DevController:110) DevController: writing {'backend-id': '0', 'virtual-device': '51712', 'device-type': 'disk', 'state': '1', 'backend': '/local/domain/0/backend/tap/1/51712'} to /local/domain/1/device/vbd/51712.
>[2007-02-21 09:22:57 xend 2775] DEBUG (DevController:112) DevController: writing {'domain': 'RHEL5', 'frontend': '/local/domain/1/device/vbd/51712', 'dev': 'xvda', 'state': '1', 'params': 'aio:/vm/rhel5.img', 'mode': 'w', 'online': '1', 'frontend-id': '1', 'type': 'tap'} to /local/domain/0/backend/tap/1/51712.
>[2007-02-21 09:22:57 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:747) Storing domain details: {'console/port': '2', 'name': 'RHEL5', 'console/limit': '1048576', 'vm': '/vm/a8c2a095-687c-cf8e-d8ed-bb5f6c8174ff', 'domid': '1', 'cpu/0/availability': 'online', 'memory/target': '512000', 'store/port': '1'}
>[2007-02-21 09:22:57 xend 2775] DEBUG (balloon:133) Balloon: 129716 KiB free; 0 to scrub; need 520192; retries: 20.
>[2007-02-21 09:22:57 xend 2775] DEBUG (balloon:148) Balloon: setting dom0 target to 1498 MiB.
>[2007-02-21 09:22:57 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:1014) Setting memory target of domain Domain-0 (0) to 1498 MiB.
>[2007-02-21 09:22:58 xend 2775] DEBUG (balloon:127) Balloon: 521076 KiB free; need 520192; done.
>[2007-02-21 09:22:58 xend 2775] DEBUG (XendCheckpoint:155) [xc_restore]: /usr/lib/xen/bin/xc_restore 17 1 130048 1 2
>[2007-02-21 09:22:58 xend 2775] ERROR (XendCheckpoint:236) xc_linux_restore start: max_pfn = 1fc00
>[2007-02-21 09:22:58 xend 2775] ERROR (XendCheckpoint:236) Increased domain reservation by 7f000 KB
>[2007-02-21 09:22:58 xend 2775] ERROR (XendCheckpoint:236) Reloading memory pages:   0%
>[2007-02-21 09:23:17 xend 2775] ERROR (XendCheckpoint:236) Received all pages (0 races)
>[2007-02-21 09:23:17 xend 2775] ERROR (XendCheckpoint:236) 100%
>[2007-02-21 09:23:17 xend 2775] ERROR (XendCheckpoint:236) Memory reloaded.
>[2007-02-21 09:23:17 xend 2775] ERROR (XendCheckpoint:236) Decreased reservation by 2108 pages
>[2007-02-21 09:23:17 xend 2775] ERROR (XendCheckpoint:236) Domain ready to be built.
>[2007-02-21 09:23:17 xend 2775] ERROR (XendCheckpoint:236) Restore exit with rc=0
>[2007-02-21 09:23:17 xend 2775] DEBUG (XendCheckpoint:209) store-mfn 177557
>[2007-02-21 09:23:17 xend 2775] DEBUG (XendCheckpoint:209) console-mfn 177556
>[2007-02-21 09:23:17 xend 2775] DEBUG (DevController:143) Waiting for devices vif.
>[2007-02-21 09:23:17 xend 2775] DEBUG (DevController:149) Waiting for 0.
>[2007-02-21 09:23:17 xend 2775] DEBUG (DevController:464) hotplugStatusCallback /local/domain/0/backend/vif/1/0/hotplug-status.
>[2007-02-21 09:23:17 xend 2775] DEBUG (DevController:478) hotplugStatusCallback 1.
>[2007-02-21 09:23:17 xend 2775] DEBUG (DevController:143) Waiting for devices usb.
>[2007-02-21 09:23:17 xend 2775] DEBUG (DevController:143) Waiting for devices vbd.
>[2007-02-21 09:23:17 xend 2775] DEBUG (DevController:143) Waiting for devices irq.
>[2007-02-21 09:23:17 xend 2775] DEBUG (DevController:143) Waiting for devices pci.
>[2007-02-21 09:23:17 xend 2775] DEBUG (DevController:143) Waiting for devices ioports.
>[2007-02-21 09:23:17 xend 2775] DEBUG (DevController:143) Waiting for devices tap.
>[2007-02-21 09:23:17 xend 2775] DEBUG (DevController:149) Waiting for 51712.
>[2007-02-21 09:23:17 xend 2775] DEBUG (DevController:464) hotplugStatusCallback /local/domain/0/backend/tap/1/51712/hotplug-status.
>[2007-02-21 09:23:17 xend 2775] DEBUG (DevController:478) hotplugStatusCallback 1.
>[2007-02-21 09:23:17 xend 2775] DEBUG (DevController:143) Waiting for devices vtpm.
>[2007-02-21 09:23:17 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:672) XendDomainInfo.completeRestore
>[2007-02-21 09:23:17 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:747) Storing domain details: {'console/ring-ref': '177556', 'console/port': '2', 'name': 'RHEL5', 'console/limit': '1048576', 'vm': '/vm/a8c2a095-687c-cf8e-d8ed-bb5f6c8174ff', 'domid': '1', 'cpu/0/availability': 'online', 'memory/target': '512000', 'store/ring-ref': '177557', 'store/port': '1'}
>[2007-02-21 09:23:17 xend.XendDomainInfo 2775] WARNING (XendDomainInfo:875) Domain has crashed: name=RHEL5 id=1.
>[2007-02-21 09:23:17 xend.XendDomainInfo 2775] WARNING (XendDomainInfo:875) Domain has crashed: name=RHEL5 id=1.
>[2007-02-21 09:23:17 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:1457) XendDomainInfo.destroyDomain(1)
>[2007-02-21 09:23:18 xend 2775] ERROR (xswatch:70) read_watch failed
>Traceback (most recent call last):
>  File "/usr/lib/python2.4/site-packages/xen/xend/xenstore/xswatch.py", line 66, in watchMain
>    res = watch.fn(we[0], *watch.args, **watch.kwargs)
>  File "/usr/lib/python2.4/site-packages/xen/xend/XendDomain.py", line 129, in onChangeDomain
>    self.refresh()
>  File "/usr/lib/python2.4/site-packages/xen/xend/XendDomain.py", line 189, in refresh
>    d.update(info)
>  File "/usr/lib/python2.4/site-packages/xen/xend/XendDomainInfo.py", line 1043, in update
>    self.refreshShutdown(info)
>  File "/usr/lib/python2.4/site-packages/xen/xend/XendDomainInfo.py", line 929, in refreshShutdown
>    self.maybeRestart(restart_reason)
>  File "/usr/lib/python2.4/site-packages/xen/xend/XendDomainInfo.py", line 973, in maybeRestart
>    {"destroy"        : self.destroy,
>  File "/usr/lib/python2.4/site-packages/xen/xend/XendDomainInfo.py", line 1637, in restart
>    config = self.sxpr()
>  File "/usr/lib/python2.4/site-packages/xen/xend/XendDomainInfo.py", line 1152, in sxpr
>    for config in self.getDeviceConfigurations(cls):
>  File "/usr/lib/python2.4/site-packages/xen/xend/XendDomainInfo.py", line 1125, in getDeviceConfigurations
>    return self.getDeviceController(deviceClass).configurations()
>  File "/usr/lib/python2.4/site-packages/xen/xend/server/DevController.py", line 217, in configurations
>    return map(self.configuration, self.deviceIDs())
>  File "/usr/lib/python2.4/site-packages/xen/xend/server/netif.py", line 192, in configuration
>    result = DevController.configuration(self, devid)
>  File "/usr/lib/python2.4/site-packages/xen/xend/server/DevController.py", line 227, in configuration
>    raise VmError("Device %s not connected" % devid)
>VmError: Device 0 not connected
>[2007-02-21 09:23:18 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:190) XendDomainInfo.create(['domain', ['domid', 1], ['uuid', 'a8c2a095-687c-cf8e-d8ed-bb5f6c8174ff'], ['vcpus', 1], ['vcpu_avail', 1], ['cpu_weight', 1.0], ['memory', 500], ['shadow_memory', 0], ['maxmem', 500], ['bootloader', '/usr/bin/pygrub'], ['features', ''], ['name', 'RHEL5'], ['on_poweroff', 'destroy'], ['on_reboot', 'restart'], ['on_crash', 'restart'], ['image', ['linux', ['ramdisk', '/var/lib/xen/initrd.hsQQQZ'], ['kernel', '/var/lib/xen/vmlinuz.8z-ZjM'], ['args', 'ro root=/dev/VolGroup00/LogVol00 rhgb quiet'], ['vncunused', '1'], ['vnc', '1'], ['xauthority', '/root/.xauthzW02Ma'], ['display', ':0.0']]], ['device', ['vif', ['backend', 0], ['script', 'vif-bridge'], ['bridge', 'xenbr0'], ['mac', '00:16:3e:6f:08:aa']]], ['device', ['tap', ['backend', 0], ['dev', 'xvda:disk'], ['uname', 'tap:aio:/vm/rhel5.img'], ['mode', 'w']]], ['state', '----c-'], ['shutdown_reason', 'crash'], ['cpu_time', 0.0027018820000000001], ['online_vcpus', 1], ['store_mfn', 177557], ['console_mfn', 177556]])
>[2007-02-21 09:23:18 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:296) parseConfig: config is ['domain', ['domid', 1], ['uuid', 'a8c2a095-687c-cf8e-d8ed-bb5f6c8174ff'], ['vcpus', 1], ['vcpu_avail', 1], ['cpu_weight', 1.0], ['memory', 500], ['shadow_memory', 0], ['maxmem', 500], ['bootloader', '/usr/bin/pygrub'], ['features', ''], ['name', 'RHEL5'], ['on_poweroff', 'destroy'], ['on_reboot', 'restart'], ['on_crash', 'restart'], ['image', ['linux', ['ramdisk', '/var/lib/xen/initrd.hsQQQZ'], ['kernel', '/var/lib/xen/vmlinuz.8z-ZjM'], ['args', 'ro root=/dev/VolGroup00/LogVol00 rhgb quiet'], ['vncunused', '1'], ['vnc', '1'], ['xauthority', '/root/.xauthzW02Ma'], ['display', ':0.0']]], ['device', ['vif', ['backend', 0], ['script', 'vif-bridge'], ['bridge', 'xenbr0'], ['mac', '00:16:3e:6f:08:aa']]], ['device', ['tap', ['backend', 0], ['dev', 'xvda:disk'], ['uname', 'tap:aio:/vm/rhel5.img'], ['mode', 'w']]], ['state', '----c-'], ['shutdown_reason', 'crash'], ['cpu_time', 0.0027018820000000001], ['online_vcpus', 1], ['store_mfn', 177557], ['console_mfn', 177556]]
>[2007-02-21 09:23:18 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:395) parseConfig: result is {'shadow_memory': 0, 'uuid': 'a8c2a095-687c-cf8e-d8ed-bb5f6c8174ff', 'on_crash': 'restart', 'on_reboot': 'restart', 'localtime': None, 'image': ['linux', ['ramdisk', '/var/lib/xen/initrd.hsQQQZ'], ['kernel', '/var/lib/xen/vmlinuz.8z-ZjM'], ['args', 'ro root=/dev/VolGroup00/LogVol00 rhgb quiet'], ['vncunused', '1'], ['vnc', '1'], ['xauthority', '/root/.xauthzW02Ma'], ['display', ':0.0']], 'on_poweroff': 'destroy', 'bootloader_args': None, 'cpus': None, 'name': 'RHEL5', 'backend': [], 'vcpus': 1, 'cpu_weight': 1.0, 'features': '', 'vcpu_avail': 1, 'memory': 500, 'device': [('vif', ['vif', ['backend', 0], ['script', 'vif-bridge'], ['bridge', 'xenbr0'], ['mac', '00:16:3e:6f:08:aa']]), ('tap', ['tap', ['backend', 0], ['dev', 'xvda:disk'], ['uname', 'tap:aio:/vm/rhel5.img'], ['mode', 'w']])], 'bootloader': '/usr/bin/pygrub', 'cpu': None, 'maxmem': 500}
>[2007-02-21 09:23:18 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:1253) XendDomainInfo.construct: None
>[2007-02-21 09:23:18 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:1285) XendDomainInfo.initDomain: 2 1.0
>[2007-02-21 09:23:18 xend 2775] INFO (image:214) configuring linux guest
>[2007-02-21 09:23:18 xend 2775] INFO (image:232) setting use_graphics
>[2007-02-21 09:23:18 xend 2775] DEBUG (balloon:127) Balloon: 521076 KiB free; need 512000; done.
>[2007-02-21 09:23:18 xend 2775] INFO (image:138) buildDomain os=linux dom=2 vcpus=1
>[2007-02-21 09:23:18 xend 2775] DEBUG (image:193) dom            = 2
>[2007-02-21 09:23:18 xend 2775] DEBUG (image:194) image          = /var/lib/xen/vmlinuz.8z-ZjM
>[2007-02-21 09:23:18 xend 2775] DEBUG (image:195) store_evtchn   = 1
>[2007-02-21 09:23:18 xend 2775] DEBUG (image:196) console_evtchn = 2
>[2007-02-21 09:23:18 xend 2775] DEBUG (image:197) cmdline        =  ro root=/dev/VolGroup00/LogVol00 rhgb quiet
>[2007-02-21 09:23:18 xend 2775] DEBUG (image:198) ramdisk        = /var/lib/xen/initrd.hsQQQZ
>[2007-02-21 09:23:18 xend 2775] DEBUG (image:199) vcpus          = 1
>[2007-02-21 09:23:18 xend 2775] DEBUG (image:200) features       = 
>[2007-02-21 09:23:18 xend 2775] DEBUG (DevController:110) DevController: writing {'backend-id': '0', 'mac': '00:16:3e:6f:08:aa', 'handle': '0', 'state': '1', 'backend': '/local/domain/0/backend/vif/2/0'} to /local/domain/2/device/vif/0.
>[2007-02-21 09:23:18 xend 2775] DEBUG (DevController:112) DevController: writing {'bridge': 'xenbr0', 'domain': 'RHEL5', 'handle': '0', 'script': '/etc/xen/scripts/vif-bridge', 'state': '1', 'frontend': '/local/domain/2/device/vif/0', 'mac': '00:16:3e:6f:08:aa', 'online': '1', 'frontend-id': '2'} to /local/domain/0/backend/vif/2/0.
>[2007-02-21 09:23:18 xend 2775] DEBUG (blkif:24) exception looking up device number for xvda: [Errno 2] No such file or directory: '/dev/xvda'
>[2007-02-21 09:23:18 xend 2775] DEBUG (DevController:110) DevController: writing {'backend-id': '0', 'virtual-device': '51712', 'device-type': 'disk', 'state': '1', 'backend': '/local/domain/0/backend/tap/2/51712'} to /local/domain/2/device/vbd/51712.
>[2007-02-21 09:23:18 xend 2775] DEBUG (DevController:112) DevController: writing {'domain': 'RHEL5', 'frontend': '/local/domain/2/device/vbd/51712', 'dev': 'xvda', 'state': '1', 'params': 'aio:/vm/rhel5.img', 'mode': 'w', 'online': '1', 'frontend-id': '2', 'type': 'tap'} to /local/domain/0/backend/tap/2/51712.
>[2007-02-21 09:23:18 xend 2775] INFO (image:261) spawning video: ['/usr/lib/xen/bin/xen-vncfb', '--unused', '--listen', '127.0.0.1', '--domid', '2', '--title', 'RHEL5']
>[2007-02-21 09:23:18 xend 2775] INFO (image:263) device model pid: 3881
>[2007-02-21 09:23:18 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:712) Storing VM details: {'shadow_memory': '0', 'uuid': 'a8c2a095-687c-cf8e-d8ed-bb5f6c8174ff', 'on_reboot': 'restart', 'start_time': '1172078598.85', 'on_poweroff': 'destroy', 'name': 'RHEL5', 'vcpus': '1', 'vcpu_avail': '1', 'memory': '500', 'on_crash': 'restart', 'image': "(linux (ramdisk /var/lib/xen/initrd.hsQQQZ) (kernel /var/lib/xen/vmlinuz.8z-ZjM) (args 'ro root=/dev/VolGroup00/LogVol00 rhgb quiet') (vncunused 1) (vnc 1) (xauthority /root/.xauthzW02Ma) (display :0.0))", 'maxmem': '500'}
>[2007-02-21 09:23:18 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:747) Storing domain details: {'console/ring-ref': '132244', 'console/port': '2', 'name': 'RHEL5', 'console/limit': '1048576', 'vm': '/vm/a8c2a095-687c-cf8e-d8ed-bb5f6c8174ff', 'domid': '2', 'cpu/0/availability': 'online', 'memory/target': '512000', 'store/ring-ref': '132245', 'store/port': '1'}
>[2007-02-21 09:23:19 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:682) XendDomainInfo.completeRestore done
>[2007-02-21 09:23:19 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:933) XendDomainInfo.handleShutdownWatch
>[2007-02-21 09:24:45 xend 2775] DEBUG (balloon:127) Balloon: 9020 KiB free; need 3072; done.
>[2007-02-21 09:24:45 xend 2775] DEBUG (XendCheckpoint:83) [xc_save]: /usr/lib/xen/bin/xc_save 23 2 0 0 1
>[2007-02-21 09:24:45 xend 2775] ERROR (XendCheckpoint:236) Had 0 unexplained entries in p2m table
>[2007-02-21 09:24:47 xend 2775] ERROR (XendCheckpoint:236) Saving memory pages: iter 1   0%  5% 10%PT Race: [10000000,0] pte=8000000000be4063, mfn=00000be4
>[2007-02-21 09:24:47 xend 2775] ERROR (XendCheckpoint:236) PT Race: [10000000,1] pte=8000000000be5063, mfn=00000be5
>[2007-02-21 09:24:47 xend 2775] ERROR (XendCheckpoint:236) PT Race: [10000000,2] pte=8000000000be6063, mfn=00000be6
>[2007-02-21 09:24:47 xend 2775] ERROR (XendCheckpoint:236) PT Race: [10000000,3] pte=8000000000be7063, mfn=00000be7
>[2007-02-21 09:24:48 xend 2775] ERROR (XendCheckpoint:236)  15% 20%PT Race: [10000000,22] pte=8000000000198063, mfn=00000198
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236)  25% 30% 35% 40% 45% 50% 55% 60% 65% 70% 75% 80% 85% 90% 95%
 1: sent 127196, skipped 772, delta 8774ms, dom0 36%, target 0%, sent 475Mb/s, dirtied 3Mb/s 992 pages
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) Saving memory pages: iter 2   0%netbuf race: iter 2, pfn 1bcab. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 2, pfn 1bcb6. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 2, pfn 1c141. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 2, pfn 1c144. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 2, pfn 1bd66. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 2, pfn 1b1a8. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 2, pfn 1b1aa. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 2, pfn 1b1b0. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 2, pfn 1b1b2. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 2, pfn 1b1ce. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 2, pfn 1b1de. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 2, pfn 1b1e0. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 2, pfn 1b1e5. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 2, pfn 1b215. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 2, pfn 1b216. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 2, pfn 1b24c. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 2, pfn 1b251. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 2, pfn 1c255. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 2, pfn 1b258. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 2, pfn 1b25b. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 2, pfn 1b264. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 2, pfn 1b267. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 2, pfn 1b269. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 2, pfn 1b26d. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 2, pfn 1b26e. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 2, pfn 1b271. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 2, pfn 1c27a. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 2, pfn 1c2b7. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 2, pfn 1c2bd. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 2, pfn 1c2da. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 2, pfn 1c2ef. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 2, pfn 1c34c. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 2, pfn 1c364. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 2, pfn 1c3be. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 2, pfn 1c3d0. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) 2: sent 957, skipped 0, delta 64ms, dom0 50%, target 0%, sent 489Mb/s, dirtied 59Mb/s 117 pages
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) Saving memory pages: iter 3   0%
 3: sent 117, skipped 0, delta 4ms, dom0 100%, target 0%, sent 958Mb/s, dirtied 0Mb/s 0 pages
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) Saving memory pages: iter 4   0%
 4: sent 0, skipped 0, Start last iteration
>[2007-02-21 09:24:54 xend 2775] DEBUG (XendCheckpoint:209) suspend
>[2007-02-21 09:24:54 xend 2775] DEBUG (XendCheckpoint:86) In saveInputHandler suspend
>[2007-02-21 09:24:54 xend 2775] DEBUG (XendCheckpoint:88) Suspending 2 ...
>[2007-02-21 09:24:54 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:933) XendDomainInfo.handleShutdownWatch
>[2007-02-21 09:24:54 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:933) XendDomainInfo.handleShutdownWatch
>[2007-02-21 09:24:54 xend.XendDomainInfo 2775] INFO (XendDomainInfo:892) Domain has shutdown: name=migrating-RHEL5 id=2 reason=suspend.
>[2007-02-21 09:24:54 xend 2775] INFO (XendCheckpoint:93) Domain 2 suspended.
>[2007-02-21 09:24:54 xend 2775] DEBUG (XendCheckpoint:98) Written done
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) SUSPEND shinfo 00000198 eip c04013a7 edx 00020496
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) delta 11ms, dom0 54%, target 0%, sent 0Mb/s, dirtied 265Mb/s 89 pages
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) Saving memory pages: iter 5   0%netbuf race: iter 5, pfn 1bcab. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1bcb3. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1bcb6. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1c141. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1c144. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1bd66. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1b1a8. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1b1aa. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1b1b0. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1b1b2. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1b1ce. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1b1de. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1b1e0. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1b1e5. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1b215. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1b216. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1b217. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1b24c. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1b250. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1b251. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1c255. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1b258. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1c258. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1b25b. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1b264. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1b267. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1b269. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1b26d. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1b26e. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1b271. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1c27a. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1c27e. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1c2b7. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1c2bd. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1c2da. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1c2ef. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1c2f0. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1c34c. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1c364. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1c3be. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1c3bf. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) netbuf race: iter 5, pfn 1c3d0. mfn ffffffff
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) 5: sent 89, skipped 0, delta 5ms, dom0 100%, target 0%, sent 583Mb/s, dirtied 583Mb/s 89 pages
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) Total pages sent= 128359 (0.99x)
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) (of which 0 were fixups)
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) All memory is saved
>[2007-02-21 09:24:54 xend 2775] ERROR (XendCheckpoint:236) Save exit rc=0
>[2007-02-21 09:24:54 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:1457) XendDomainInfo.destroyDomain(2)
>[2007-02-21 09:25:18 xend 2775] DEBUG (tcp:66) Match 10.5.1.114 10.5.1.114
>[2007-02-21 09:25:18 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:265) XendDomainInfo.restore(['domain', ['domid', '2'], ['uuid', 'a8c2a095-687c-cf8e-d8ed-bb5f6c8174ff'], ['vcpus', '1'], ['vcpu_avail', '1'], ['cpu_weight', '1.0'], ['memory', '500'], ['shadow_memory', '0'], ['maxmem', '500'], ['bootloader', '/usr/bin/pygrub'], ['features'], ['name', 'RHEL5'], ['on_poweroff', 'destroy'], ['on_reboot', 'restart'], ['on_crash', 'restart'], ['image', ['linux', ['ramdisk', '/var/lib/xen/initrd.hsQQQZ'], ['kernel', '/var/lib/xen/vmlinuz.8z-ZjM'], ['args', 'ro root=/dev/VolGroup00/LogVol00 rhgb quiet'], ['vncunused', '1'], ['vnc', '1'], ['xauthority', '/root/.xauthzW02Ma'], ['display', ':0.0']]], ['device', ['vif', ['backend', '0'], ['script', 'vif-bridge'], ['bridge', 'xenbr0'], ['mac', '00:16:3e:6f:08:aa']]], ['device', ['tap', ['backend', '0'], ['dev', 'xvda:disk'], ['uname', 'tap:aio:/vm/rhel5.img'], ['mode', 'w']]], ['state', '-b----'], ['shutdown_reason', 'poweroff'], ['cpu_time', '0.055518771'], ['online_vcpus', '1'], ['store_mfn', '187723'], ['console_mfn', '187722']])
>[2007-02-21 09:25:18 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:296) parseConfig: config is ['domain', ['domid', '2'], ['uuid', 'a8c2a095-687c-cf8e-d8ed-bb5f6c8174ff'], ['vcpus', '1'], ['vcpu_avail', '1'], ['cpu_weight', '1.0'], ['memory', '500'], ['shadow_memory', '0'], ['maxmem', '500'], ['bootloader', '/usr/bin/pygrub'], ['features'], ['name', 'RHEL5'], ['on_poweroff', 'destroy'], ['on_reboot', 'restart'], ['on_crash', 'restart'], ['image', ['linux', ['ramdisk', '/var/lib/xen/initrd.hsQQQZ'], ['kernel', '/var/lib/xen/vmlinuz.8z-ZjM'], ['args', 'ro root=/dev/VolGroup00/LogVol00 rhgb quiet'], ['vncunused', '1'], ['vnc', '1'], ['xauthority', '/root/.xauthzW02Ma'], ['display', ':0.0']]], ['device', ['vif', ['backend', '0'], ['script', 'vif-bridge'], ['bridge', 'xenbr0'], ['mac', '00:16:3e:6f:08:aa']]], ['device', ['tap', ['backend', '0'], ['dev', 'xvda:disk'], ['uname', 'tap:aio:/vm/rhel5.img'], ['mode', 'w']]], ['state', '-b----'], ['shutdown_reason', 'poweroff'], ['cpu_time', '0.055518771'], ['online_vcpus', '1'], ['store_mfn', '187723'], ['console_mfn', '187722']]
>[2007-02-21 09:25:18 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:395) parseConfig: result is {'shadow_memory': 0, 'uuid': 'a8c2a095-687c-cf8e-d8ed-bb5f6c8174ff', 'on_crash': 'restart', 'on_reboot': 'restart', 'localtime': None, 'image': ['linux', ['ramdisk', '/var/lib/xen/initrd.hsQQQZ'], ['kernel', '/var/lib/xen/vmlinuz.8z-ZjM'], ['args', 'ro root=/dev/VolGroup00/LogVol00 rhgb quiet'], ['vncunused', '1'], ['vnc', '1'], ['xauthority', '/root/.xauthzW02Ma'], ['display', ':0.0']], 'on_poweroff': 'destroy', 'bootloader_args': None, 'cpus': None, 'name': 'RHEL5', 'backend': [], 'vcpus': 1, 'cpu_weight': 1.0, 'features': None, 'vcpu_avail': 1, 'memory': 500, 'device': [('vif', ['vif', ['backend', '0'], ['script', 'vif-bridge'], ['bridge', 'xenbr0'], ['mac', '00:16:3e:6f:08:aa']]), ('tap', ['tap', ['backend', '0'], ['dev', 'xvda:disk'], ['uname', 'tap:aio:/vm/rhel5.img'], ['mode', 'w']])], 'bootloader': '/usr/bin/pygrub', 'cpu': None, 'maxmem': 500}
>[2007-02-21 09:25:18 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:1253) XendDomainInfo.construct: None
>[2007-02-21 09:25:18 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:712) Storing VM details: {'shadow_memory': '0', 'uuid': 'a8c2a095-687c-cf8e-d8ed-bb5f6c8174ff', 'on_reboot': 'restart', 'image': "(linux (ramdisk /var/lib/xen/initrd.hsQQQZ) (kernel /var/lib/xen/vmlinuz.8z-ZjM) (args 'ro root=/dev/VolGroup00/LogVol00 rhgb quiet') (vncunused 1) (vnc 1) (xauthority /root/.xauthzW02Ma) (display :0.0))", 'on_poweroff': 'destroy', 'name': 'RHEL5', 'vcpus': '1', 'vcpu_avail': '1', 'memory': '500', 'on_crash': 'restart', 'maxmem': '500'}
>[2007-02-21 09:25:18 xend 2775] DEBUG (DevController:110) DevController: writing {'backend-id': '0', 'mac': '00:16:3e:6f:08:aa', 'handle': '0', 'state': '1', 'backend': '/local/domain/0/backend/vif/3/0'} to /local/domain/3/device/vif/0.
>[2007-02-21 09:25:18 xend 2775] DEBUG (DevController:112) DevController: writing {'bridge': 'xenbr0', 'domain': 'RHEL5', 'handle': '0', 'script': '/etc/xen/scripts/vif-bridge', 'state': '1', 'frontend': '/local/domain/3/device/vif/0', 'mac': '00:16:3e:6f:08:aa', 'online': '1', 'frontend-id': '3'} to /local/domain/0/backend/vif/3/0.
>[2007-02-21 09:25:18 xend 2775] DEBUG (blkif:24) exception looking up device number for xvda: [Errno 2] No such file or directory: '/dev/xvda'
>[2007-02-21 09:25:18 xend 2775] DEBUG (DevController:110) DevController: writing {'backend-id': '0', 'virtual-device': '51712', 'device-type': 'disk', 'state': '1', 'backend': '/local/domain/0/backend/tap/3/51712'} to /local/domain/3/device/vbd/51712.
>[2007-02-21 09:25:18 xend 2775] DEBUG (DevController:112) DevController: writing {'domain': 'RHEL5', 'frontend': '/local/domain/3/device/vbd/51712', 'dev': 'xvda', 'state': '1', 'params': 'aio:/vm/rhel5.img', 'mode': 'w', 'online': '1', 'frontend-id': '3', 'type': 'tap'} to /local/domain/0/backend/tap/3/51712.
>[2007-02-21 09:25:18 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:747) Storing domain details: {'console/port': '2', 'name': 'RHEL5', 'console/limit': '1048576', 'vm': '/vm/a8c2a095-687c-cf8e-d8ed-bb5f6c8174ff', 'domid': '3', 'cpu/0/availability': 'online', 'memory/target': '512000', 'store/port': '1'}
>[2007-02-21 09:25:19 xend 2775] DEBUG (balloon:127) Balloon: 520852 KiB free; need 520192; done.
>[2007-02-21 09:25:19 xend 2775] DEBUG (XendCheckpoint:155) [xc_restore]: /usr/lib/xen/bin/xc_restore 19 3 130048 1 2
>[2007-02-21 09:25:19 xend 2775] ERROR (XendCheckpoint:236) xc_linux_restore start: max_pfn = 1fc00
>[2007-02-21 09:25:19 xend 2775] ERROR (XendCheckpoint:236) Increased domain reservation by 7f000 KB
>[2007-02-21 09:25:19 xend 2775] ERROR (XendCheckpoint:236) Reloading memory pages:   0%
>[2007-02-21 09:25:37 xend 2775] ERROR (XendCheckpoint:236) Received all pages (0 races)
>[2007-02-21 09:25:37 xend 2775] ERROR (XendCheckpoint:236) 100%
>[2007-02-21 09:25:37 xend 2775] ERROR (XendCheckpoint:236) Memory reloaded.
>[2007-02-21 09:25:37 xend 2775] ERROR (XendCheckpoint:236) Decreased reservation by 2090 pages
>[2007-02-21 09:25:37 xend 2775] ERROR (XendCheckpoint:236) Domain ready to be built.
>[2007-02-21 09:25:37 xend 2775] ERROR (XendCheckpoint:236) Restore exit with rc=0
>[2007-02-21 09:25:37 xend 2775] DEBUG (XendCheckpoint:209) store-mfn 277341
>[2007-02-21 09:25:37 xend 2775] DEBUG (XendCheckpoint:209) console-mfn 277340
>[2007-02-21 09:25:37 xend 2775] DEBUG (DevController:143) Waiting for devices vif.
>[2007-02-21 09:25:37 xend 2775] DEBUG (DevController:149) Waiting for 0.
>[2007-02-21 09:25:37 xend 2775] DEBUG (DevController:464) hotplugStatusCallback /local/domain/0/backend/vif/3/0/hotplug-status.
>[2007-02-21 09:25:37 xend 2775] DEBUG (DevController:478) hotplugStatusCallback 1.
>[2007-02-21 09:25:37 xend 2775] DEBUG (DevController:143) Waiting for devices usb.
>[2007-02-21 09:25:37 xend 2775] DEBUG (DevController:143) Waiting for devices vbd.
>[2007-02-21 09:25:37 xend 2775] DEBUG (DevController:143) Waiting for devices irq.
>[2007-02-21 09:25:37 xend 2775] DEBUG (DevController:143) Waiting for devices pci.
>[2007-02-21 09:25:37 xend 2775] DEBUG (DevController:143) Waiting for devices ioports.
>[2007-02-21 09:25:37 xend 2775] DEBUG (DevController:143) Waiting for devices tap.
>[2007-02-21 09:25:37 xend 2775] DEBUG (DevController:149) Waiting for 51712.
>[2007-02-21 09:25:37 xend 2775] DEBUG (DevController:464) hotplugStatusCallback /local/domain/0/backend/tap/3/51712/hotplug-status.
>[2007-02-21 09:25:37 xend 2775] DEBUG (DevController:478) hotplugStatusCallback 1.
>[2007-02-21 09:25:37 xend 2775] DEBUG (DevController:143) Waiting for devices vtpm.
>[2007-02-21 09:25:37 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:672) XendDomainInfo.completeRestore
>[2007-02-21 09:25:37 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:747) Storing domain details: {'console/ring-ref': '277340', 'console/port': '2', 'name': 'RHEL5', 'console/limit': '1048576', 'vm': '/vm/a8c2a095-687c-cf8e-d8ed-bb5f6c8174ff', 'domid': '3', 'cpu/0/availability': 'online', 'memory/target': '512000', 'store/ring-ref': '277341', 'store/port': '1'}
>[2007-02-21 09:25:37 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:933) XendDomainInfo.handleShutdownWatch
>[2007-02-21 09:25:37 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:682) XendDomainInfo.completeRestore done
>[2007-02-21 09:25:56 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:933) XendDomainInfo.handleShutdownWatch
>[2007-02-21 09:25:56 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:933) XendDomainInfo.handleShutdownWatch
>[2007-02-21 09:25:56 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:933) XendDomainInfo.handleShutdownWatch
>[2007-02-21 09:26:25 xend.XendDomainInfo 2775] INFO (XendDomainInfo:892) Domain has shutdown: name=RHEL5 id=3 reason=poweroff.
>[2007-02-21 09:26:25 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:1449) XendDomainInfo.destroy: domid=3
>[2007-02-21 09:26:25 xend.XendDomainInfo 2775] DEBUG (XendDomainInfo:1457) XendDomainInfo.destroyDomain(3)

Actions: View

Attachments on bug 229016: 148506 | 148507 | 148508 | 148509