From mboxrd@z Thu Jan 1 00:00:00 1970 From: Roland Paterson-Jones Subject: Re: [Xen-users] Re: tap:qcow causes dom-U to hang in 3.0.3 Date: Thu, 09 Nov 2006 11:30:18 +0200 Message-ID: <4552F52A.6080308@rolandpj.com> References: <4551EEC3.3010308@rolandpj.com> <20061108151133.GE3507@leeni.uk.xensource.com> Mime-Version: 1.0 Content-Type: multipart/mixed; boundary="------------090503040907010001070001" Return-path: In-Reply-To: <20061108151133.GE3507@leeni.uk.xensource.com> List-Unsubscribe: , List-Post: List-Help: List-Subscribe: , Sender: xen-devel-bounces@lists.xensource.com Errors-To: xen-devel-bounces@lists.xensource.com To: Ewan Mellor Cc: xen-devel@lists.xensource.com, xen-users@lists.xensource.com List-Id: xen-devel@lists.xenproject.org This is a multi-part message in MIME format. --------------090503040907010001070001 Content-Type: text/plain; charset=ISO-8859-1; format=flowed Content-Transfer-Encoding: 7bit Ewan Mellor wrote: > On Wed, Nov 08, 2006 at 04:50:43PM +0200, Roland Paterson-Jones wrote: > > >> >> [root@dom0]# xm list >> Error: Device 2050 not connected >> Usage: xm list [options] [Domain, ...] >> >> Curiously, it seems that device 2050 was a secondary block device >> exposed using phy:. >> >> So, any advice on how to debug this? >> > > > Could we see your /var/log/xen/* and the output of xenstore-ls? > > Not sure this got through first time round - I got 'quarantine' messages about the .tgz attachment. Attached here uncompressed (!) Logs attached. xenstore-ls below. I had two domains running. One with root-fs using tap:aio:/mnt/instance_image_store_1/3811, and a second dom-U on tap:qcow:/mnt/instance_image_store_0/3811.qcow, which was set up as a COW overlay of image file /mnt/instance_image_store_0/3811 (not the same as the tap:aio: image for the first domU - the directories differ in their last digit). Then both dom-U's also had/have a swap partition (vbd phy:) on /dev/VolGroupDomU/instance_swap_store_1/0 and a second vbd phy: on /dev/VolGroupDomU/instance_ephemeral_store_1/0. The 'xenstore-ls' also shows qcow:/mnt/instance_image_store_2/3811.qcow which I don't think should be there at all (maybe from a previous failed attempt). Could this be related to tap:qcow: mounts not umounting? I previously set up a test tap:qcow: device in dom0 using 'block-attach 0 ...', then mounted it, which seemed to work OK. However 'umount ...' then hung (seemingly in the kernel - I had to reboot to get rid of it). Thx Roland ----------------------------------------- [root@dom0 ~]# xenstore-ls tool = "" xenstored = "" vm = "" 00000000-0000-0000-0000-000000000000 = "" 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 = "1023" on_crash = "restart" maxmem = "1023" 00000000-0000-0000-0000-0000ec291715 = "" image = "(linux (kernel /boot/vmlinuz-2.6.16.29-xen) (ramdisk /boot/initrd-2.6.16.29-xen.img) (..." ostype = "linux" kernel = "/boot/vmlinuz-2.6.16.29-xen" cmdline = " root=/dev/sda1 ro 4" ramdisk = "/boot/initrd-2.6.16.29-xen.img" shadow_memory = "0" uuid = "00000000-0000-0000-0000-0000ec291715" on_reboot = "restart" start_time = "1162994682.56" on_poweroff = "destroy" name = "dom_91715" xend = "" restart_count = "0" vcpus = "1" vcpu_avail = "1" memory = "1700" on_crash = "restart" maxmem = "1700" local = "" domain = "" 0 = "" cpu = "" 0 = "" availability = "online" 1 = "" availability = "online" memory = "" target = "1047552" name = "Domain-0" console = "" limit = "1048576" vm = "/vm/00000000-0000-0000-0000-000000000000" domid = "0" backend = "" tap = "" 1 = "" 2049 = "" domain = "dom_91715" frontend = "/local/domain/1/device/vbd/2049" dev = "sda1" state = "4" params = "aio:/mnt/instance_image_store_1/3811" mode = "w" online = "1" frontend-id = "1" type = "tap" sectors = "3123200" sector-size = "512" info = "0" hotplug-status = "connected" 2 = "" 2049 = "" domain = "dom_91721" frontend = "/local/domain/2/device/vbd/2049" dev = "sda1" state = "4" params = "qcow:/mnt/instance_image_store_0/3811.qcow" mode = "w" online = "1" frontend-id = "2" type = "tap" sectors = "3123200" sector-size = "512" info = "0" hotplug-status = "connected" 3 = "" 2049 = "" domain = "dom_91723" frontend = "/local/domain/3/device/vbd/2049" dev = "sda1" state = "1" params = "qcow:/mnt/instance_image_store_2/3811.qcow" mode = "w" online = "1" frontend-id = "3" type = "tap" sectors = "3123200" sector-size = "512" info = "0" vbd = "" 1 = "" 2050 = "" domain = "dom_91715" frontend = "/local/domain/1/device/vbd/2050" dev = "sda2" state = "4" params = "/dev/VolGroupDomU/instance_ephemeral_store_1" mode = "w" online = "1" frontend-id = "1" type = "phy" physical-device = "fd:6" hotplug-status = "connected" sectors = "312737792" info = "0" sector-size = "512" 2051 = "" domain = "dom_91715" frontend = "/local/domain/1/device/vbd/2051" dev = "sda3" state = "4" params = "/dev/VolGroupDomU/instance_swap_store_1" mode = "w" online = "1" frontend-id = "1" type = "phy" physical-device = "fd:7" hotplug-status = "connected" sectors = "1835008" info = "0" sector-size = "512" 2 = "" 2050 = "" domain = "dom_91721" frontend = "/local/domain/2/device/vbd/2050" dev = "sda2" state = "4" params = "/dev/VolGroupDomU/instance_ephemeral_store_0" mode = "w" online = "1" frontend-id = "2" type = "phy" physical-device = "fd:3" hotplug-status = "connected" sectors = "312737792" info = "0" sector-size = "512" 2051 = "" domain = "dom_91721" frontend = "/local/domain/2/device/vbd/2051" dev = "sda3" state = "4" params = "/dev/VolGroupDomU/instance_swap_store_0" mode = "w" online = "1" frontend-id = "2" type = "phy" physical-device = "fd:4" hotplug-status = "connected" sectors = "1835008" info = "0" sector-size = "512" 3 = "" 2050 = "" domain = "dom_91723" frontend = "/local/domain/3/device/vbd/2050" dev = "sda2" state = "1" params = "/dev/VolGroupDomU/instance_ephemeral_store_2" mode = "w" online = "1" frontend-id = "3" type = "phy" 2051 = "" domain = "dom_91723" frontend = "/local/domain/3/device/vbd/2051" dev = "sda3" state = "1" params = "/dev/VolGroupDomU/instance_swap_store_2" mode = "w" online = "1" frontend-id = "3" type = "phy" vif = "" 1 = "" 0 = "" domain = "dom_91715" handle = "0" script = "/etc/xen/scripts/vif-aes" state = "4" frontend = "/local/domain/1/device/vif/0" mac = "12:31:34:00:03:8F" online = "1" frontend-id = "1" feature-sg = "1" feature-gso-tcpv4 = "1" feature-rx-copy = "1" hotplug-status = "connected" 3 = "" 0 = "" domain = "dom_91723" handle = "0" script = "/etc/xen/scripts/vif-aes" state = "5" frontend = "/local/domain/3/device/vif/0" mac = "12:31:34:00:03:8D" online = "0" frontend-id = "3" error = "" backend = "" tap = "" 1 = "" 2049 = "" error = "2 getting info" 2 = "" 2049 = "" error = "2 getting info" 1 = "" device = "" vbd = "" 2049 = "" backend-id = "0" virtual-device = "2049" device-type = "disk" state = "4" backend = "/local/domain/0/backend/tap/1/2049" ring-ref = "8" event-channel = "6" 2050 = "" backend-id = "0" virtual-device = "2050" device-type = "disk" state = "4" backend = "/local/domain/0/backend/vbd/1/2050" ring-ref = "9" event-channel = "7" 2051 = "" backend-id = "0" virtual-device = "2051" device-type = "disk" state = "4" backend = "/local/domain/0/backend/vbd/1/2051" ring-ref = "10" event-channel = "8" vif = "" 0 = "" backend-id = "0" mac = "12:31:34:00:03:8F" handle = "0" state = "4" backend = "/local/domain/0/backend/vif/1/0" tx-ring-ref = "523" rx-ring-ref = "524" event-channel = "9" request-rx-copy = "0" feature-rx-notify = "1" feature-sg = "1" feature-gso-tcpv4 = "1" device-misc = "" vif = "" nextDeviceID = "1" console = "" ring-ref = "995310" port = "2" limit = "1048576" tty = "/dev/pts/2" name = "dom_91715" vm = "/vm/00000000-0000-0000-0000-0000ec291715" domid = "1" cpu = "" 0 = "" availability = "online" memory = "" target = "1740800" store = "" ring-ref = "995311" port = "1" > Thanks, > > Ewan. > > _______________________________________________ > Xen-users mailing list > Xen-users@lists.xensource.com > http://lists.xensource.com/xen-users > > > > ------------------------------------------------------------------------ _______________________________________________ Xen-devel mailing list Xen-devel@lists.xensource.com http://lists.xensource.com/xen-devel --------------090503040907010001070001 Content-Type: text/x-log; name="xend-debug.log" Content-Transfer-Encoding: 7bit Content-Disposition: inline; filename="xend-debug.log" Nothing to flush. Nothing to flush. --------------090503040907010001070001 Content-Type: text/x-log; name="xend.log" Content-Transfer-Encoding: quoted-printable Content-Disposition: inline; filename="xend.log" [2006-11-07 12:03:33 xend 2677] INFO (SrvDaemon:283) Xend Daemon started [2006-11-07 12:03:33 xend 2677] INFO (SrvDaemon:287) Xend changeset: Sun = Oct 15 13:19:07 2006 +0100 11774:620cb0064d9b. [2006-11-07 12:03:33 xend.XendDomainInfo 2677] DEBUG (XendDomainInfo:212)= XendDomainInfo.recreate({'paused': 0, 'cpu_time': 18030905254L, 'ssidref= ': 0, 'handle': [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0], 'shutdo= wn_reason': 0, 'dying': 0, 'dom': 0, 'mem_kb': 1047296, 'maxmem_kb': -4, = 'max_vcpu_id': 1, 'crashed': 0, 'running': 1, 'shutdown': 0, 'online_vcpu= s': 2, 'blocked': 0}) [2006-11-07 12:03:33 xend.XendDomainInfo 2677] INFO (XendDomainInfo:224) = Recreating domain 0, UUID 00000000-0000-0000-0000-000000000000. [2006-11-07 12:03:33 xend.XendDomainInfo 2677] WARNING (XendDomainInfo:24= 6) No vm path in store for existing domain 0 [2006-11-07 12:03:33 xend.XendDomainInfo 2677] DEBUG (XendDomainInfo:712)= Storing VM details: {'shadow_memory': '0', 'uuid': '00000000-0000-0000-0= 000-000000000000', 'on_reboot': 'restart', 'on_poweroff': 'destroy', 'nam= e': 'Domain-0', 'xend/restart_count': '0', 'vcpus': '2', 'vcpu_avail': '3= ', 'memory': '1023', 'on_crash': 'restart', 'maxmem': '1023'} [2006-11-07 12:03:33 xend.XendDomainInfo 2677] DEBUG (XendDomainInfo:747)= Storing domain details: {'cpu/0/availability': 'online', 'memory/target'= : '1047552', 'cpu/1/availability': 'online', 'name': 'Domain-0', 'console= /limit': '1048576', 'vm': '/vm/00000000-0000-0000-0000-000000000000', 'do= mid': '0'} [2006-11-07 12:03:33 xend 2677] DEBUG (XendDomain:153) number of vcpus to= use is 0 [2006-11-07 12:03:33 xend.XendDomainInfo 2677] DEBUG (XendDomainInfo:933)= XendDomainInfo.handleShutdownWatch [2006-11-07 12:14:49 xend 2676] INFO (SrvDaemon:190) Xend stopped due to = signal 15. [2006-11-07 12:24:48 xend 2682] INFO (SrvDaemon:283) Xend Daemon started [2006-11-07 12:24:48 xend 2682] INFO (SrvDaemon:287) Xend changeset: Sun = Oct 15 13:19:07 2006 +0100 11774:620cb0064d9b. [2006-11-07 12:24:49 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:212)= XendDomainInfo.recreate({'paused': 0, 'cpu_time': 17739491734L, 'ssidref= ': 0, 'handle': [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0], 'shutdo= wn_reason': 0, 'dying': 0, 'dom': 0, 'mem_kb': 1047296, 'maxmem_kb': -4, = 'max_vcpu_id': 1, 'crashed': 0, 'running': 1, 'shutdown': 0, 'online_vcpu= s': 2, 'blocked': 0}) [2006-11-07 12:24:49 xend.XendDomainInfo 2682] INFO (XendDomainInfo:224) = Recreating domain 0, UUID 00000000-0000-0000-0000-000000000000. [2006-11-07 12:24:49 xend.XendDomainInfo 2682] WARNING (XendDomainInfo:24= 6) No vm path in store for existing domain 0 [2006-11-07 12:24:49 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:712)= Storing VM details: {'shadow_memory': '0', 'uuid': '00000000-0000-0000-0= 000-000000000000', 'on_reboot': 'restart', 'on_poweroff': 'destroy', 'nam= e': 'Domain-0', 'xend/restart_count': '0', 'vcpus': '2', 'vcpu_avail': '3= ', 'memory': '1023', 'on_crash': 'restart', 'maxmem': '1023'} [2006-11-07 12:24:49 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:747)= Storing domain details: {'cpu/0/availability': 'online', 'memory/target'= : '1047552', 'cpu/1/availability': 'online', 'name': 'Domain-0', 'console= /limit': '1048576', 'vm': '/vm/00000000-0000-0000-0000-000000000000', 'do= mid': '0'} [2006-11-07 12:24:49 xend 2682] DEBUG (XendDomain:153) number of vcpus to= use is 0 [2006-11-07 12:24:49 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:933)= XendDomainInfo.handleShutdownWatch [2006-11-07 13:27:44 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:190)= XendDomainInfo.create(['vm', ['uuid', '00000000-0000-0000-0000-0000ec291= 284'], ['name', 'dom_91284'], ['memory', '1700'], ['image', ['linux', ['k= ernel', '/boot/vmlinuz-2.6-xenU'], ['root', '/dev/sda1 ro'], ['args', '4'= ], ['vcpus', '1']]], ['device', ['vbd', ['uname', 'file:/mnt/instance_ima= ge_store_0/2866'], ['dev', 'sda1'], ['mode', 'w']]], ['device', ['vbd', [= 'uname', 'phy:/dev/VolGroupDomU/instance_ephemeral_store_0'], ['dev', 'sd= a2'], ['mode', 'w']]], ['device', ['vbd', ['uname', 'phy:/dev/VolGroupDom= U/instance_swap_store_0'], ['dev', 'sda3'], ['mode', 'w']]], ['device', [= 'vif', ['mac', '12:31:34:00:03:8E']]], ['memmap'], ['device_model'], ['de= vice_config']]) [2006-11-07 13:27:44 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:296)= parseConfig: config is ['vm', ['uuid', '00000000-0000-0000-0000-0000ec29= 1284'], ['name', 'dom_91284'], ['memory', '1700'], ['image', ['linux', ['= kernel', '/boot/vmlinuz-2.6-xenU'], ['root', '/dev/sda1 ro'], ['args', '4= '], ['vcpus', '1']]], ['device', ['vbd', ['uname', 'file:/mnt/instance_im= age_store_0/2866'], ['dev', 'sda1'], ['mode', 'w']]], ['device', ['vbd', = ['uname', 'phy:/dev/VolGroupDomU/instance_ephemeral_store_0'], ['dev', 's= da2'], ['mode', 'w']]], ['device', ['vbd', ['uname', 'phy:/dev/VolGroupDo= mU/instance_swap_store_0'], ['dev', 'sda3'], ['mode', 'w']]], ['device', = ['vif', ['mac', '12:31:34:00:03:8E']]], ['memmap'], ['device_model'], ['d= evice_config']] [2006-11-07 13:27:44 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:395)= parseConfig: result is {'shadow_memory': None, 'uuid': '00000000-0000-00= 00-0000-0000ec291284', 'on_crash': None, 'on_reboot': None, 'localtime': = None, 'image': ['linux', ['kernel', '/boot/vmlinuz-2.6-xenU'], ['root', '= /dev/sda1 ro'], ['args', '4'], ['vcpus', '1']], 'on_poweroff': None, 'boo= tloader_args': None, 'cpus': None, 'name': 'dom_91284', 'backend': [], 'v= cpus': 1, 'cpu_weight': None, 'features': None, 'vcpu_avail': None, 'memo= ry': 1700, 'device': [('vbd', ['vbd', ['uname', 'file:/mnt/instance_image= _store_0/2866'], ['dev', 'sda1'], ['mode', 'w']]), ('vbd', ['vbd', ['unam= e', 'phy:/dev/VolGroupDomU/instance_ephemeral_store_0'], ['dev', 'sda2'],= ['mode', 'w']]), ('vbd', ['vbd', ['uname', 'phy:/dev/VolGroupDomU/instan= ce_swap_store_0'], ['dev', 'sda3'], ['mode', 'w']]), ('vif', ['vif', ['ma= c', '12:31:34:00:03:8E']])], 'bootloader': None, 'cpu': None, 'maxmem': N= one} [2006-11-07 13:27:44 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:1253= ) XendDomainInfo.construct: None [2006-11-07 13:27:45 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:1285= ) XendDomainInfo.initDomain: 1 1.0 [2006-11-07 13:27:45 xend 2682] DEBUG (balloon:127) Balloon: 7268224 KiB = free; need 1740800; done. [2006-11-07 13:27:45 xend 2682] INFO (image:136) buildDomain os=3Dlinux d= om=3D1 vcpus=3D1 [2006-11-07 13:27:45 xend 2682] DEBUG (image:191) dom =3D 1 [2006-11-07 13:27:45 xend 2682] DEBUG (image:192) image =3D /boo= t/vmlinuz-2.6-xenU [2006-11-07 13:27:45 xend 2682] DEBUG (image:193) store_evtchn =3D 1 [2006-11-07 13:27:45 xend 2682] DEBUG (image:194) console_evtchn =3D 2 [2006-11-07 13:27:45 xend 2682] DEBUG (image:195) cmdline =3D roo= t=3D/dev/sda1 ro 4 [2006-11-07 13:27:45 xend 2682] DEBUG (image:196) ramdisk =3D=20 [2006-11-07 13:27:45 xend 2682] DEBUG (image:197) vcpus =3D 1 [2006-11-07 13:27:45 xend 2682] DEBUG (image:198) features =3D=20 [2006-11-07 13:27:45 xend 2682] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'virtual-device': '2049', 'device-type': 'dis= k', 'state': '1', 'backend': '/local/domain/0/backend/vbd/1/2049'} to /lo= cal/domain/1/device/vbd/2049. [2006-11-07 13:27:45 xend 2682] DEBUG (DevController:112) DevController: = writing {'domain': 'dom_91284', 'frontend': '/local/domain/1/device/vbd/2= 049', 'dev': 'sda1', 'state': '1', 'params': '/mnt/instance_image_store_0= /2866', 'mode': 'w', 'online': '1', 'frontend-id': '1', 'type': 'file'} t= o /local/domain/0/backend/vbd/1/2049. [2006-11-07 13:27:45 xend 2682] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'virtual-device': '2050', 'device-type': 'dis= k', 'state': '1', 'backend': '/local/domain/0/backend/vbd/1/2050'} to /lo= cal/domain/1/device/vbd/2050. [2006-11-07 13:27:45 xend 2682] DEBUG (DevController:112) DevController: = writing {'domain': 'dom_91284', 'frontend': '/local/domain/1/device/vbd/2= 050', 'dev': 'sda2', 'state': '1', 'params': '/dev/VolGroupDomU/instance_= ephemeral_store_0', 'mode': 'w', 'online': '1', 'frontend-id': '1', 'type= ': 'phy'} to /local/domain/0/backend/vbd/1/2050. [2006-11-07 13:27:45 xend 2682] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'virtual-device': '2051', 'device-type': 'dis= k', 'state': '1', 'backend': '/local/domain/0/backend/vbd/1/2051'} to /lo= cal/domain/1/device/vbd/2051. [2006-11-07 13:27:45 xend 2682] DEBUG (DevController:112) DevController: = writing {'domain': 'dom_91284', 'frontend': '/local/domain/1/device/vbd/2= 051', 'dev': 'sda3', 'state': '1', 'params': '/dev/VolGroupDomU/instance_= swap_store_0', 'mode': 'w', 'online': '1', 'frontend-id': '1', 'type': 'p= hy'} to /local/domain/0/backend/vbd/1/2051. [2006-11-07 13:27:45 xend 2682] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'mac': '12:31:34:00:03:8E', 'handle': '0', 's= tate': '1', 'backend': '/local/domain/0/backend/vif/1/0'} to /local/domai= n/1/device/vif/0. [2006-11-07 13:27:45 xend 2682] DEBUG (DevController:112) DevController: = writing {'domain': 'dom_91284', 'handle': '0', 'script': '/etc/xen/script= s/vif-aes', 'state': '1', 'frontend': '/local/domain/1/device/vif/0', 'ma= c': '12:31:34:00:03:8E', 'online': '1', 'frontend-id': '1'} to /local/dom= ain/0/backend/vif/1/0. [2006-11-07 13:27:45 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:712)= Storing VM details: {'shadow_memory': '0', 'uuid': '00000000-0000-0000-0= 000-0000ec291284', 'on_reboot': 'restart', 'start_time': '1162898865.35',= 'on_poweroff': 'destroy', 'name': 'dom_91284', 'xend/restart_count': '0'= , 'vcpus': '1', 'vcpu_avail': '1', 'memory': '1700', 'on_crash': 'restart= ', 'image': "(linux (kernel /boot/vmlinuz-2.6-xenU) (root '/dev/sda1 ro')= (args 4) (vcpus 1))", 'maxmem': '1700'} [2006-11-07 13:27:45 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:747)= Storing domain details: {'console/ring-ref': '870785', 'console/port': '= 2', 'name': 'dom_91284', 'console/limit': '1048576', 'vm': '/vm/00000000-= 0000-0000-0000-0000ec291284', 'domid': '1', 'cpu/0/availability': 'online= ', 'memory/target': '1740800', 'store/ring-ref': '870786', 'store/port': = '1'} [2006-11-07 13:27:45 xend 2682] DEBUG (DevController:143) Waiting for dev= ices vif. [2006-11-07 13:27:45 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:933)= XendDomainInfo.handleShutdownWatch [2006-11-07 13:27:45 xend 2682] DEBUG (DevController:149) Waiting for 0. [2006-11-07 13:27:45 xend 2682] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/vif/1/0/hotplug-status. [2006-11-07 13:27:47 xend 2682] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/vif/1/0/hotplug-status. [2006-11-07 13:27:47 xend 2682] DEBUG (DevController:478) hotplugStatusCa= llback 1. [2006-11-07 13:27:47 xend 2682] DEBUG (DevController:143) Waiting for dev= ices usb. [2006-11-07 13:27:47 xend 2682] DEBUG (DevController:143) Waiting for dev= ices vbd. [2006-11-07 13:27:47 xend 2682] DEBUG (DevController:149) Waiting for 204= 9. [2006-11-07 13:27:47 xend 2682] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/vbd/1/2049/hotplug-status. [2006-11-07 13:27:47 xend 2682] DEBUG (DevController:478) hotplugStatusCa= llback 1. [2006-11-07 13:27:47 xend 2682] DEBUG (DevController:149) Waiting for 205= 0. [2006-11-07 13:27:47 xend 2682] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/vbd/1/2050/hotplug-status. [2006-11-07 13:27:47 xend 2682] DEBUG (DevController:478) hotplugStatusCa= llback 1. [2006-11-07 13:27:47 xend 2682] DEBUG (DevController:149) Waiting for 205= 1. [2006-11-07 13:27:47 xend 2682] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/vbd/1/2051/hotplug-status. [2006-11-07 13:27:47 xend 2682] DEBUG (DevController:478) hotplugStatusCa= llback 1. [2006-11-07 13:27:47 xend 2682] DEBUG (DevController:143) Waiting for dev= ices irq. [2006-11-07 13:27:47 xend 2682] DEBUG (DevController:143) Waiting for dev= ices pci. [2006-11-07 13:27:47 xend 2682] DEBUG (DevController:143) Waiting for dev= ices ioports. [2006-11-07 13:27:47 xend 2682] DEBUG (DevController:143) Waiting for dev= ices tap. [2006-11-07 13:27:47 xend 2682] DEBUG (DevController:143) Waiting for dev= ices vtpm. [2006-11-07 13:27:47 xend 2682] INFO (XendDomain:370) Domain dom_91284 (1= ) unpaused. [2006-11-07 16:46:26 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:933)= XendDomainInfo.handleShutdownWatch [2006-11-07 16:46:26 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:933)= XendDomainInfo.handleShutdownWatch [2006-11-07 16:46:41 xend.XendDomainInfo 2682] INFO (XendDomainInfo:892) = Domain has shutdown: name=3Ddom_91284 id=3D1 reason=3Dpoweroff. [2006-11-07 16:46:41 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:1449= ) XendDomainInfo.destroy: domid=3D1 [2006-11-07 16:46:41 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:1457= ) XendDomainInfo.destroyDomain(1) [2006-11-07 17:03:10 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:190)= XendDomainInfo.create(['vm', ['uuid', '00000000-0000-0000-0000-0000ec291= 365'], ['name', 'dom_91365'], ['memory', '1700'], ['image', ['linux', ['k= ernel', '/boot/vmlinuz-2.6-xenU'], ['root', '/dev/sda1 ro'], ['args', '4'= ], ['vcpus', '1']]], ['device', ['vbd', ['uname', 'file:/mnt/instance_ima= ge_store_1/2866'], ['dev', 'sda1'], ['mode', 'w']]], ['device', ['vbd', [= 'uname', 'phy:/dev/VolGroupDomU/instance_ephemeral_store_1'], ['dev', 'sd= a2'], ['mode', 'w']]], ['device', ['vbd', ['uname', 'phy:/dev/VolGroupDom= U/instance_swap_store_1'], ['dev', 'sda3'], ['mode', 'w']]], ['device', [= 'vif', ['mac', '12:31:34:00:03:8F']]], ['memmap'], ['device_model'], ['de= vice_config']]) [2006-11-07 17:03:10 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:296)= parseConfig: config is ['vm', ['uuid', '00000000-0000-0000-0000-0000ec29= 1365'], ['name', 'dom_91365'], ['memory', '1700'], ['image', ['linux', ['= kernel', '/boot/vmlinuz-2.6-xenU'], ['root', '/dev/sda1 ro'], ['args', '4= '], ['vcpus', '1']]], ['device', ['vbd', ['uname', 'file:/mnt/instance_im= age_store_1/2866'], ['dev', 'sda1'], ['mode', 'w']]], ['device', ['vbd', = ['uname', 'phy:/dev/VolGroupDomU/instance_ephemeral_store_1'], ['dev', 's= da2'], ['mode', 'w']]], ['device', ['vbd', ['uname', 'phy:/dev/VolGroupDo= mU/instance_swap_store_1'], ['dev', 'sda3'], ['mode', 'w']]], ['device', = ['vif', ['mac', '12:31:34:00:03:8F']]], ['memmap'], ['device_model'], ['d= evice_config']] [2006-11-07 17:03:10 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:395)= parseConfig: result is {'shadow_memory': None, 'uuid': '00000000-0000-00= 00-0000-0000ec291365', 'on_crash': None, 'on_reboot': None, 'localtime': = None, 'image': ['linux', ['kernel', '/boot/vmlinuz-2.6-xenU'], ['root', '= /dev/sda1 ro'], ['args', '4'], ['vcpus', '1']], 'on_poweroff': None, 'boo= tloader_args': None, 'cpus': None, 'name': 'dom_91365', 'backend': [], 'v= cpus': 1, 'cpu_weight': None, 'features': None, 'vcpu_avail': None, 'memo= ry': 1700, 'device': [('vbd', ['vbd', ['uname', 'file:/mnt/instance_image= _store_1/2866'], ['dev', 'sda1'], ['mode', 'w']]), ('vbd', ['vbd', ['unam= e', 'phy:/dev/VolGroupDomU/instance_ephemeral_store_1'], ['dev', 'sda2'],= ['mode', 'w']]), ('vbd', ['vbd', ['uname', 'phy:/dev/VolGroupDomU/instan= ce_swap_store_1'], ['dev', 'sda3'], ['mode', 'w']]), ('vif', ['vif', ['ma= c', '12:31:34:00:03:8F']])], 'bootloader': None, 'cpu': None, 'maxmem': N= one} [2006-11-07 17:03:10 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:1253= ) XendDomainInfo.construct: None [2006-11-07 17:03:10 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:1285= ) XendDomainInfo.initDomain: 2 1.0 [2006-11-07 17:03:10 xend 2682] DEBUG (balloon:127) Balloon: 7268076 KiB = free; need 1740800; done. [2006-11-07 17:03:10 xend 2682] INFO (image:136) buildDomain os=3Dlinux d= om=3D2 vcpus=3D1 [2006-11-07 17:03:10 xend 2682] DEBUG (image:191) dom =3D 2 [2006-11-07 17:03:10 xend 2682] DEBUG (image:192) image =3D /boo= t/vmlinuz-2.6-xenU [2006-11-07 17:03:10 xend 2682] DEBUG (image:193) store_evtchn =3D 1 [2006-11-07 17:03:10 xend 2682] DEBUG (image:194) console_evtchn =3D 2 [2006-11-07 17:03:10 xend 2682] DEBUG (image:195) cmdline =3D roo= t=3D/dev/sda1 ro 4 [2006-11-07 17:03:10 xend 2682] DEBUG (image:196) ramdisk =3D=20 [2006-11-07 17:03:10 xend 2682] DEBUG (image:197) vcpus =3D 1 [2006-11-07 17:03:10 xend 2682] DEBUG (image:198) features =3D=20 [2006-11-07 17:03:10 xend 2682] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'virtual-device': '2049', 'device-type': 'dis= k', 'state': '1', 'backend': '/local/domain/0/backend/vbd/2/2049'} to /lo= cal/domain/2/device/vbd/2049. [2006-11-07 17:03:10 xend 2682] DEBUG (DevController:112) DevController: = writing {'domain': 'dom_91365', 'frontend': '/local/domain/2/device/vbd/2= 049', 'dev': 'sda1', 'state': '1', 'params': '/mnt/instance_image_store_1= /2866', 'mode': 'w', 'online': '1', 'frontend-id': '2', 'type': 'file'} t= o /local/domain/0/backend/vbd/2/2049. [2006-11-07 17:03:10 xend 2682] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'virtual-device': '2050', 'device-type': 'dis= k', 'state': '1', 'backend': '/local/domain/0/backend/vbd/2/2050'} to /lo= cal/domain/2/device/vbd/2050. [2006-11-07 17:03:10 xend 2682] DEBUG (DevController:112) DevController: = writing {'domain': 'dom_91365', 'frontend': '/local/domain/2/device/vbd/2= 050', 'dev': 'sda2', 'state': '1', 'params': '/dev/VolGroupDomU/instance_= ephemeral_store_1', 'mode': 'w', 'online': '1', 'frontend-id': '2', 'type= ': 'phy'} to /local/domain/0/backend/vbd/2/2050. [2006-11-07 17:03:10 xend 2682] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'virtual-device': '2051', 'device-type': 'dis= k', 'state': '1', 'backend': '/local/domain/0/backend/vbd/2/2051'} to /lo= cal/domain/2/device/vbd/2051. [2006-11-07 17:03:10 xend 2682] DEBUG (DevController:112) DevController: = writing {'domain': 'dom_91365', 'frontend': '/local/domain/2/device/vbd/2= 051', 'dev': 'sda3', 'state': '1', 'params': '/dev/VolGroupDomU/instance_= swap_store_1', 'mode': 'w', 'online': '1', 'frontend-id': '2', 'type': 'p= hy'} to /local/domain/0/backend/vbd/2/2051. [2006-11-07 17:03:10 xend 2682] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'mac': '12:31:34:00:03:8F', 'handle': '0', 's= tate': '1', 'backend': '/local/domain/0/backend/vif/2/0'} to /local/domai= n/2/device/vif/0. [2006-11-07 17:03:10 xend 2682] DEBUG (DevController:112) DevController: = writing {'domain': 'dom_91365', 'handle': '0', 'script': '/etc/xen/script= s/vif-aes', 'state': '1', 'frontend': '/local/domain/2/device/vif/0', 'ma= c': '12:31:34:00:03:8F', 'online': '1', 'frontend-id': '2'} to /local/dom= ain/0/backend/vif/2/0. [2006-11-07 17:03:11 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:712)= Storing VM details: {'shadow_memory': '0', 'uuid': '00000000-0000-0000-0= 000-0000ec291365', 'on_reboot': 'restart', 'start_time': '1162911791.0', = 'on_poweroff': 'destroy', 'name': 'dom_91365', 'xend/restart_count': '0',= 'vcpus': '1', 'vcpu_avail': '1', 'memory': '1700', 'on_crash': 'restart'= , 'image': "(linux (kernel /boot/vmlinuz-2.6-xenU) (root '/dev/sda1 ro') = (args 4) (vcpus 1))", 'maxmem': '1700'} [2006-11-07 17:03:11 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:747)= Storing domain details: {'console/ring-ref': '618709', 'console/port': '= 2', 'name': 'dom_91365', 'console/limit': '1048576', 'vm': '/vm/00000000-= 0000-0000-0000-0000ec291365', 'domid': '2', 'cpu/0/availability': 'online= ', 'memory/target': '1740800', 'store/ring-ref': '618710', 'store/port': = '1'} [2006-11-07 17:03:11 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:933)= XendDomainInfo.handleShutdownWatch [2006-11-07 17:03:11 xend 2682] DEBUG (DevController:143) Waiting for dev= ices vif. [2006-11-07 17:03:11 xend 2682] DEBUG (DevController:149) Waiting for 0. [2006-11-07 17:03:11 xend 2682] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/vif/2/0/hotplug-status. [2006-11-07 17:03:13 xend 2682] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/vif/2/0/hotplug-status. [2006-11-07 17:03:13 xend 2682] DEBUG (DevController:478) hotplugStatusCa= llback 1. [2006-11-07 17:03:13 xend 2682] DEBUG (DevController:143) Waiting for dev= ices usb. [2006-11-07 17:03:13 xend 2682] DEBUG (DevController:143) Waiting for dev= ices vbd. [2006-11-07 17:03:13 xend 2682] DEBUG (DevController:149) Waiting for 204= 9. [2006-11-07 17:03:13 xend 2682] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/vbd/2/2049/hotplug-status. [2006-11-07 17:03:13 xend 2682] DEBUG (DevController:478) hotplugStatusCa= llback 1. [2006-11-07 17:03:13 xend 2682] DEBUG (DevController:149) Waiting for 205= 0. [2006-11-07 17:03:13 xend 2682] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/vbd/2/2050/hotplug-status. [2006-11-07 17:03:13 xend 2682] DEBUG (DevController:478) hotplugStatusCa= llback 1. [2006-11-07 17:03:13 xend 2682] DEBUG (DevController:149) Waiting for 205= 1. [2006-11-07 17:03:13 xend 2682] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/vbd/2/2051/hotplug-status. [2006-11-07 17:03:13 xend 2682] DEBUG (DevController:478) hotplugStatusCa= llback 1. [2006-11-07 17:03:13 xend 2682] DEBUG (DevController:143) Waiting for dev= ices irq. [2006-11-07 17:03:13 xend 2682] DEBUG (DevController:143) Waiting for dev= ices pci. [2006-11-07 17:03:13 xend 2682] DEBUG (DevController:143) Waiting for dev= ices ioports. [2006-11-07 17:03:13 xend 2682] DEBUG (DevController:143) Waiting for dev= ices tap. [2006-11-07 17:03:13 xend 2682] DEBUG (DevController:143) Waiting for dev= ices vtpm. [2006-11-07 17:03:13 xend 2682] INFO (XendDomain:370) Domain dom_91365 (2= ) unpaused. [2006-11-07 17:18:08 xend 2682] INFO (XendDomain:388) Domain dom_91365 (2= ) paused. [2006-11-07 17:56:08 xend 2682] INFO (XendDomain:370) Domain dom_91365 (2= ) unpaused. [2006-11-07 18:10:46 xend 2682] DEBUG (blkif:24) exception looking up dev= ice number for /dev/xvda1: [Errno 2] No such file or directory: '/dev/xvd= a1' [2006-11-07 18:10:46 xend 2682] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'virtual-device': '51713', 'device-type': 'di= sk', 'state': '1', 'backend': '/local/domain/0/backend/tap/0/51713'} to /= local/domain/0/device/vbd/51713. [2006-11-07 18:10:46 xend 2682] DEBUG (DevController:112) DevController: = writing {'domain': 'Domain-0', 'frontend': '/local/domain/0/device/vbd/51= 713', 'dev': '/dev/xvda1', 'state': '1', 'params': 'qcow:/mnt/ami_cache/t= mp/gsg-jamesg.qcow', 'mode': 'w', 'online': '1', 'frontend-id': '0', 'typ= e': 'tap'} to /local/domain/0/backend/tap/0/51713. [2006-11-07 18:10:46 xend 2682] DEBUG (DevController:149) Waiting for 517= 13. [2006-11-07 18:10:46 xend 2682] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/tap/0/51713/hotplug-status. [2006-11-07 18:10:47 xend 2682] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/tap/0/51713/hotplug-status. [2006-11-07 18:10:47 xend 2682] DEBUG (DevController:478) hotplugStatusCa= llback 1. [2006-11-08 10:53:44 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:190)= XendDomainInfo.create(['vm', ['uuid', '00000000-0000-0000-0000-0000ec291= 641'], ['name', 'dom_91641'], ['memory', '1700'], ['image', ['linux', ['k= ernel', '/boot/vmlinuz-2.6-xenU'], ['root', '/dev/sda1 ro'], ['args', '4'= ], ['vcpus', '1']]], ['device', ['tap', ['uname', 'tap:aio:/mnt/instance_= image_store_0/2866'], ['dev', 'sda1'], ['mode', 'w']]], ['device', ['vbd'= , ['uname', 'phy:/dev/VolGroupDomU/instance_ephemeral_store_0'], ['dev', = 'sda2'], ['mode', 'w']]], ['device', ['vbd', ['uname', 'phy:/dev/VolGroup= DomU/instance_swap_store_0'], ['dev', 'sda3'], ['mode', 'w']]], ['device'= , ['vif', ['mac', '12:31:34:00:03:8E']]], ['memmap'], ['device_model'], [= 'device_config']]) [2006-11-08 10:53:44 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:296)= parseConfig: config is ['vm', ['uuid', '00000000-0000-0000-0000-0000ec29= 1641'], ['name', 'dom_91641'], ['memory', '1700'], ['image', ['linux', ['= kernel', '/boot/vmlinuz-2.6-xenU'], ['root', '/dev/sda1 ro'], ['args', '4= '], ['vcpus', '1']]], ['device', ['tap', ['uname', 'tap:aio:/mnt/instance= _image_store_0/2866'], ['dev', 'sda1'], ['mode', 'w']]], ['device', ['vbd= ', ['uname', 'phy:/dev/VolGroupDomU/instance_ephemeral_store_0'], ['dev',= 'sda2'], ['mode', 'w']]], ['device', ['vbd', ['uname', 'phy:/dev/VolGrou= pDomU/instance_swap_store_0'], ['dev', 'sda3'], ['mode', 'w']]], ['device= ', ['vif', ['mac', '12:31:34:00:03:8E']]], ['memmap'], ['device_model'], = ['device_config']] [2006-11-08 10:53:44 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:395)= parseConfig: result is {'shadow_memory': None, 'uuid': '00000000-0000-00= 00-0000-0000ec291641', 'on_crash': None, 'on_reboot': None, 'localtime': = None, 'image': ['linux', ['kernel', '/boot/vmlinuz-2.6-xenU'], ['root', '= /dev/sda1 ro'], ['args', '4'], ['vcpus', '1']], 'on_poweroff': None, 'boo= tloader_args': None, 'cpus': None, 'name': 'dom_91641', 'backend': [], 'v= cpus': 1, 'cpu_weight': None, 'features': None, 'vcpu_avail': None, 'memo= ry': 1700, 'device': [('tap', ['tap', ['uname', 'tap:aio:/mnt/instance_im= age_store_0/2866'], ['dev', 'sda1'], ['mode', 'w']]), ('vbd', ['vbd', ['u= name', 'phy:/dev/VolGroupDomU/instance_ephemeral_store_0'], ['dev', 'sda2= '], ['mode', 'w']]), ('vbd', ['vbd', ['uname', 'phy:/dev/VolGroupDomU/ins= tance_swap_store_0'], ['dev', 'sda3'], ['mode', 'w']]), ('vif', ['vif', [= 'mac', '12:31:34:00:03:8E']])], 'bootloader': None, 'cpu': None, 'maxmem'= : None} [2006-11-08 10:53:44 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:1253= ) XendDomainInfo.construct: None [2006-11-08 10:53:44 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:1285= ) XendDomainInfo.initDomain: 3 1.0 [2006-11-08 10:53:44 xend 2682] DEBUG (balloon:127) Balloon: 5527420 KiB = free; need 1740800; done. [2006-11-08 10:53:44 xend 2682] INFO (image:136) buildDomain os=3Dlinux d= om=3D3 vcpus=3D1 [2006-11-08 10:53:44 xend 2682] DEBUG (image:191) dom =3D 3 [2006-11-08 10:53:44 xend 2682] DEBUG (image:192) image =3D /boo= t/vmlinuz-2.6-xenU [2006-11-08 10:53:44 xend 2682] DEBUG (image:193) store_evtchn =3D 1 [2006-11-08 10:53:44 xend 2682] DEBUG (image:194) console_evtchn =3D 2 [2006-11-08 10:53:44 xend 2682] DEBUG (image:195) cmdline =3D roo= t=3D/dev/sda1 ro 4 [2006-11-08 10:53:44 xend 2682] DEBUG (image:196) ramdisk =3D=20 [2006-11-08 10:53:44 xend 2682] DEBUG (image:197) vcpus =3D 1 [2006-11-08 10:53:44 xend 2682] DEBUG (image:198) features =3D=20 [2006-11-08 10:53:45 xend 2682] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'virtual-device': '2049', 'device-type': 'dis= k', 'state': '1', 'backend': '/local/domain/0/backend/tap/3/2049'} to /lo= cal/domain/3/device/vbd/2049. [2006-11-08 10:53:45 xend 2682] DEBUG (DevController:112) DevController: = writing {'domain': 'dom_91641', 'frontend': '/local/domain/3/device/vbd/2= 049', 'dev': 'sda1', 'state': '1', 'params': 'aio:/mnt/instance_image_sto= re_0/2866', 'mode': 'w', 'online': '1', 'frontend-id': '3', 'type': 'tap'= } to /local/domain/0/backend/tap/3/2049. [2006-11-08 10:53:45 xend 2682] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'virtual-device': '2050', 'device-type': 'dis= k', 'state': '1', 'backend': '/local/domain/0/backend/vbd/3/2050'} to /lo= cal/domain/3/device/vbd/2050. [2006-11-08 10:53:45 xend 2682] DEBUG (DevController:112) DevController: = writing {'domain': 'dom_91641', 'frontend': '/local/domain/3/device/vbd/2= 050', 'dev': 'sda2', 'state': '1', 'params': '/dev/VolGroupDomU/instance_= ephemeral_store_0', 'mode': 'w', 'online': '1', 'frontend-id': '3', 'type= ': 'phy'} to /local/domain/0/backend/vbd/3/2050. [2006-11-08 10:53:45 xend 2682] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'virtual-device': '2051', 'device-type': 'dis= k', 'state': '1', 'backend': '/local/domain/0/backend/vbd/3/2051'} to /lo= cal/domain/3/device/vbd/2051. [2006-11-08 10:53:45 xend 2682] DEBUG (DevController:112) DevController: = writing {'domain': 'dom_91641', 'frontend': '/local/domain/3/device/vbd/2= 051', 'dev': 'sda3', 'state': '1', 'params': '/dev/VolGroupDomU/instance_= swap_store_0', 'mode': 'w', 'online': '1', 'frontend-id': '3', 'type': 'p= hy'} to /local/domain/0/backend/vbd/3/2051. [2006-11-08 10:53:45 xend 2682] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'mac': '12:31:34:00:03:8E', 'handle': '0', 's= tate': '1', 'backend': '/local/domain/0/backend/vif/3/0'} to /local/domai= n/3/device/vif/0. [2006-11-08 10:53:45 xend 2682] DEBUG (DevController:112) DevController: = writing {'domain': 'dom_91641', 'handle': '0', 'script': '/etc/xen/script= s/vif-aes', 'state': '1', 'frontend': '/local/domain/3/device/vif/0', 'ma= c': '12:31:34:00:03:8E', 'online': '1', 'frontend-id': '3'} to /local/dom= ain/0/backend/vif/3/0. [2006-11-08 10:53:45 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:712)= Storing VM details: {'shadow_memory': '0', 'uuid': '00000000-0000-0000-0= 000-0000ec291641', 'on_reboot': 'restart', 'start_time': '1162976025.11',= 'on_poweroff': 'destroy', 'name': 'dom_91641', 'xend/restart_count': '0'= , 'vcpus': '1', 'vcpu_avail': '1', 'memory': '1700', 'on_crash': 'restart= ', 'image': "(linux (kernel /boot/vmlinuz-2.6-xenU) (root '/dev/sda1 ro')= (args 4) (vcpus 1))", 'maxmem': '1700'} [2006-11-08 10:53:45 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:747)= Storing domain details: {'console/ring-ref': '2071943', 'console/port': = '2', 'name': 'dom_91641', 'console/limit': '1048576', 'vm': '/vm/00000000= -0000-0000-0000-0000ec291641', 'domid': '3', 'cpu/0/availability': 'onlin= e', 'memory/target': '1740800', 'store/ring-ref': '2071944', 'store/port'= : '1'} [2006-11-08 10:53:45 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:933)= XendDomainInfo.handleShutdownWatch [2006-11-08 10:53:45 xend 2682] DEBUG (DevController:143) Waiting for dev= ices vif. [2006-11-08 10:53:45 xend 2682] DEBUG (DevController:149) Waiting for 0. [2006-11-08 10:53:45 xend 2682] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/vif/3/0/hotplug-status. [2006-11-08 10:53:48 xend 2682] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/vif/3/0/hotplug-status. [2006-11-08 10:53:48 xend 2682] DEBUG (DevController:478) hotplugStatusCa= llback 1. [2006-11-08 10:53:48 xend 2682] DEBUG (DevController:143) Waiting for dev= ices usb. [2006-11-08 10:53:48 xend 2682] DEBUG (DevController:143) Waiting for dev= ices vbd. [2006-11-08 10:53:48 xend 2682] DEBUG (DevController:149) Waiting for 205= 0. [2006-11-08 10:53:48 xend 2682] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/vbd/3/2050/hotplug-status. [2006-11-08 10:53:48 xend 2682] DEBUG (DevController:478) hotplugStatusCa= llback 1. [2006-11-08 10:53:48 xend 2682] DEBUG (DevController:149) Waiting for 205= 1. [2006-11-08 10:53:48 xend 2682] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/vbd/3/2051/hotplug-status. [2006-11-08 10:53:48 xend 2682] DEBUG (DevController:478) hotplugStatusCa= llback 1. [2006-11-08 10:53:48 xend 2682] DEBUG (DevController:143) Waiting for dev= ices irq. [2006-11-08 10:53:48 xend 2682] DEBUG (DevController:143) Waiting for dev= ices pci. [2006-11-08 10:53:48 xend 2682] DEBUG (DevController:143) Waiting for dev= ices ioports. [2006-11-08 10:53:48 xend 2682] DEBUG (DevController:143) Waiting for dev= ices tap. [2006-11-08 10:53:48 xend 2682] DEBUG (DevController:149) Waiting for 204= 9. [2006-11-08 10:53:48 xend 2682] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/tap/3/2049/hotplug-status. [2006-11-08 10:53:48 xend 2682] DEBUG (DevController:478) hotplugStatusCa= llback 1. [2006-11-08 10:53:48 xend 2682] DEBUG (DevController:143) Waiting for dev= ices vtpm. [2006-11-08 10:53:48 xend 2682] INFO (XendDomain:370) Domain dom_91641 (3= ) unpaused. [2006-11-08 11:24:39 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:190)= XendDomainInfo.create(['vm', ['uuid', '00000000-0000-0000-0000-0000ec291= 662'], ['name', 'dom_91662'], ['memory', '1700'], ['image', ['linux', ['k= ernel', '/boot/vmlinuz-2.6-xenU'], ['root', '/dev/sda1 ro'], ['args', '4'= ], ['vcpus', '1']]], ['device', ['tap', ['uname', 'tap:qcow:/mnt/instance= _image_store_2/2866.qcow'], ['dev', 'sda1'], ['mode', 'w']]], ['device', = ['vbd', ['uname', 'phy:/dev/VolGroupDomU/instance_ephemeral_store_2'], ['= dev', 'sda2'], ['mode', 'w']]], ['device', ['vbd', ['uname', 'phy:/dev/Vo= lGroupDomU/instance_swap_store_2'], ['dev', 'sda3'], ['mode', 'w']]], ['d= evice', ['vif', ['mac', '12:31:34:00:03:8D']]], ['memmap'], ['device_mode= l'], ['device_config']]) [2006-11-08 11:24:39 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:296)= parseConfig: config is ['vm', ['uuid', '00000000-0000-0000-0000-0000ec29= 1662'], ['name', 'dom_91662'], ['memory', '1700'], ['image', ['linux', ['= kernel', '/boot/vmlinuz-2.6-xenU'], ['root', '/dev/sda1 ro'], ['args', '4= '], ['vcpus', '1']]], ['device', ['tap', ['uname', 'tap:qcow:/mnt/instanc= e_image_store_2/2866.qcow'], ['dev', 'sda1'], ['mode', 'w']]], ['device',= ['vbd', ['uname', 'phy:/dev/VolGroupDomU/instance_ephemeral_store_2'], [= 'dev', 'sda2'], ['mode', 'w']]], ['device', ['vbd', ['uname', 'phy:/dev/V= olGroupDomU/instance_swap_store_2'], ['dev', 'sda3'], ['mode', 'w']]], ['= device', ['vif', ['mac', '12:31:34:00:03:8D']]], ['memmap'], ['device_mod= el'], ['device_config']] [2006-11-08 11:24:39 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:395)= parseConfig: result is {'shadow_memory': None, 'uuid': '00000000-0000-00= 00-0000-0000ec291662', 'on_crash': None, 'on_reboot': None, 'localtime': = None, 'image': ['linux', ['kernel', '/boot/vmlinuz-2.6-xenU'], ['root', '= /dev/sda1 ro'], ['args', '4'], ['vcpus', '1']], 'on_poweroff': None, 'boo= tloader_args': None, 'cpus': None, 'name': 'dom_91662', 'backend': [], 'v= cpus': 1, 'cpu_weight': None, 'features': None, 'vcpu_avail': None, 'memo= ry': 1700, 'device': [('tap', ['tap', ['uname', 'tap:qcow:/mnt/instance_i= mage_store_2/2866.qcow'], ['dev', 'sda1'], ['mode', 'w']]), ('vbd', ['vbd= ', ['uname', 'phy:/dev/VolGroupDomU/instance_ephemeral_store_2'], ['dev',= 'sda2'], ['mode', 'w']]), ('vbd', ['vbd', ['uname', 'phy:/dev/VolGroupDo= mU/instance_swap_store_2'], ['dev', 'sda3'], ['mode', 'w']]), ('vif', ['v= if', ['mac', '12:31:34:00:03:8D']])], 'bootloader': None, 'cpu': None, 'm= axmem': None} [2006-11-08 11:24:39 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:1253= ) XendDomainInfo.construct: None [2006-11-08 11:24:39 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:1285= ) XendDomainInfo.initDomain: 4 1.0 [2006-11-08 11:24:39 xend 2682] DEBUG (balloon:127) Balloon: 3786932 KiB = free; need 1740800; done. [2006-11-08 11:24:39 xend 2682] INFO (image:136) buildDomain os=3Dlinux d= om=3D4 vcpus=3D1 [2006-11-08 11:24:39 xend 2682] DEBUG (image:191) dom =3D 4 [2006-11-08 11:24:39 xend 2682] DEBUG (image:192) image =3D /boo= t/vmlinuz-2.6-xenU [2006-11-08 11:24:39 xend 2682] DEBUG (image:193) store_evtchn =3D 1 [2006-11-08 11:24:39 xend 2682] DEBUG (image:194) console_evtchn =3D 2 [2006-11-08 11:24:39 xend 2682] DEBUG (image:195) cmdline =3D roo= t=3D/dev/sda1 ro 4 [2006-11-08 11:24:39 xend 2682] DEBUG (image:196) ramdisk =3D=20 [2006-11-08 11:24:39 xend 2682] DEBUG (image:197) vcpus =3D 1 [2006-11-08 11:24:39 xend 2682] DEBUG (image:198) features =3D=20 [2006-11-08 11:24:39 xend 2682] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'virtual-device': '2049', 'device-type': 'dis= k', 'state': '1', 'backend': '/local/domain/0/backend/tap/4/2049'} to /lo= cal/domain/4/device/vbd/2049. [2006-11-08 11:24:39 xend 2682] DEBUG (DevController:112) DevController: = writing {'domain': 'dom_91662', 'frontend': '/local/domain/4/device/vbd/2= 049', 'dev': 'sda1', 'state': '1', 'params': 'qcow:/mnt/instance_image_st= ore_2/2866.qcow', 'mode': 'w', 'online': '1', 'frontend-id': '4', 'type':= 'tap'} to /local/domain/0/backend/tap/4/2049. [2006-11-08 11:24:39 xend 2682] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'virtual-device': '2050', 'device-type': 'dis= k', 'state': '1', 'backend': '/local/domain/0/backend/vbd/4/2050'} to /lo= cal/domain/4/device/vbd/2050. [2006-11-08 11:24:39 xend 2682] DEBUG (DevController:112) DevController: = writing {'domain': 'dom_91662', 'frontend': '/local/domain/4/device/vbd/2= 050', 'dev': 'sda2', 'state': '1', 'params': '/dev/VolGroupDomU/instance_= ephemeral_store_2', 'mode': 'w', 'online': '1', 'frontend-id': '4', 'type= ': 'phy'} to /local/domain/0/backend/vbd/4/2050. [2006-11-08 11:24:39 xend 2682] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'virtual-device': '2051', 'device-type': 'dis= k', 'state': '1', 'backend': '/local/domain/0/backend/vbd/4/2051'} to /lo= cal/domain/4/device/vbd/2051. [2006-11-08 11:24:39 xend 2682] DEBUG (DevController:112) DevController: = writing {'domain': 'dom_91662', 'frontend': '/local/domain/4/device/vbd/2= 051', 'dev': 'sda3', 'state': '1', 'params': '/dev/VolGroupDomU/instance_= swap_store_2', 'mode': 'w', 'online': '1', 'frontend-id': '4', 'type': 'p= hy'} to /local/domain/0/backend/vbd/4/2051. [2006-11-08 11:24:39 xend 2682] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'mac': '12:31:34:00:03:8D', 'handle': '0', 's= tate': '1', 'backend': '/local/domain/0/backend/vif/4/0'} to /local/domai= n/4/device/vif/0. [2006-11-08 11:24:39 xend 2682] DEBUG (DevController:112) DevController: = writing {'domain': 'dom_91662', 'handle': '0', 'script': '/etc/xen/script= s/vif-aes', 'state': '1', 'frontend': '/local/domain/4/device/vif/0', 'ma= c': '12:31:34:00:03:8D', 'online': '1', 'frontend-id': '4'} to /local/dom= ain/0/backend/vif/4/0. [2006-11-08 11:24:40 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:712)= Storing VM details: {'shadow_memory': '0', 'uuid': '00000000-0000-0000-0= 000-0000ec291662', 'on_reboot': 'restart', 'start_time': '1162977879.99',= 'on_poweroff': 'destroy', 'name': 'dom_91662', 'xend/restart_count': '0'= , 'vcpus': '1', 'vcpu_avail': '1', 'memory': '1700', 'on_crash': 'restart= ', 'image': "(linux (kernel /boot/vmlinuz-2.6-xenU) (root '/dev/sda1 ro')= (args 4) (vcpus 1))", 'maxmem': '1700'} [2006-11-08 11:24:40 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:747)= Storing domain details: {'console/ring-ref': '1505780', 'console/port': = '2', 'name': 'dom_91662', 'console/limit': '1048576', 'vm': '/vm/00000000= -0000-0000-0000-0000ec291662', 'domid': '4', 'cpu/0/availability': 'onlin= e', 'memory/target': '1740800', 'store/ring-ref': '1505781', 'store/port'= : '1'} [2006-11-08 11:24:40 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:933)= XendDomainInfo.handleShutdownWatch [2006-11-08 11:24:40 xend 2682] DEBUG (DevController:143) Waiting for dev= ices vif. [2006-11-08 11:24:40 xend 2682] DEBUG (DevController:149) Waiting for 0. [2006-11-08 11:24:40 xend 2682] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/vif/4/0/hotplug-status. [2006-11-08 11:24:44 xend 2682] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/vif/4/0/hotplug-status. [2006-11-08 11:24:44 xend 2682] DEBUG (DevController:478) hotplugStatusCa= llback 1. [2006-11-08 11:24:44 xend 2682] DEBUG (DevController:143) Waiting for dev= ices usb. [2006-11-08 11:24:44 xend 2682] DEBUG (DevController:143) Waiting for dev= ices vbd. [2006-11-08 11:24:44 xend 2682] DEBUG (DevController:149) Waiting for 205= 0. [2006-11-08 11:24:44 xend 2682] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/vbd/4/2050/hotplug-status. [2006-11-08 11:24:44 xend 2682] DEBUG (DevController:478) hotplugStatusCa= llback 1. [2006-11-08 11:24:44 xend 2682] DEBUG (DevController:149) Waiting for 205= 1. [2006-11-08 11:24:44 xend 2682] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/vbd/4/2051/hotplug-status. [2006-11-08 11:24:44 xend 2682] DEBUG (DevController:478) hotplugStatusCa= llback 1. [2006-11-08 11:24:44 xend 2682] DEBUG (DevController:143) Waiting for dev= ices irq. [2006-11-08 11:24:44 xend 2682] DEBUG (DevController:143) Waiting for dev= ices pci. [2006-11-08 11:24:44 xend 2682] DEBUG (DevController:143) Waiting for dev= ices ioports. [2006-11-08 11:24:44 xend 2682] DEBUG (DevController:143) Waiting for dev= ices tap. [2006-11-08 11:24:44 xend 2682] DEBUG (DevController:149) Waiting for 204= 9. [2006-11-08 11:24:44 xend 2682] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/tap/4/2049/hotplug-status. [2006-11-08 11:24:44 xend 2682] DEBUG (DevController:478) hotplugStatusCa= llback 1. [2006-11-08 11:24:44 xend 2682] DEBUG (DevController:143) Waiting for dev= ices vtpm. [2006-11-08 11:24:44 xend 2682] INFO (XendDomain:370) Domain dom_91662 (4= ) unpaused. [2006-11-08 11:37:45 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:933)= XendDomainInfo.handleShutdownWatch [2006-11-08 11:37:45 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:933)= XendDomainInfo.handleShutdownWatch [2006-11-08 11:37:45 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:933)= XendDomainInfo.handleShutdownWatch [2006-11-08 11:37:45 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:933)= XendDomainInfo.handleShutdownWatch [2006-11-08 11:37:45 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:933)= XendDomainInfo.handleShutdownWatch [2006-11-08 11:37:45 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:933)= XendDomainInfo.handleShutdownWatch [2006-11-08 11:38:09 xend.XendDomainInfo 2682] INFO (XendDomainInfo:892) = Domain has shutdown: name=3Ddom_91641 id=3D3 reason=3Dpoweroff. [2006-11-08 11:38:09 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:1449= ) XendDomainInfo.destroy: domid=3D3 [2006-11-08 11:38:09 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:1457= ) XendDomainInfo.destroyDomain(3) [2006-11-08 11:38:10 xend.XendDomainInfo 2682] INFO (XendDomainInfo:892) = Domain has shutdown: name=3Ddom_91365 id=3D2 reason=3Dpoweroff. [2006-11-08 11:38:10 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:1449= ) XendDomainInfo.destroy: domid=3D2 [2006-11-08 11:38:10 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:1457= ) XendDomainInfo.destroyDomain(2) [2006-11-08 11:38:15 xend.XendDomainInfo 2682] INFO (XendDomainInfo:923) = Domain shutdown timeout expired: name=3Ddom_91662 id=3D4 [2006-11-08 11:38:15 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:1449= ) XendDomainInfo.destroy: domid=3D4 [2006-11-08 11:38:15 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:1457= ) XendDomainInfo.destroyDomain(4) [2006-11-08 11:43:49 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:190)= XendDomainInfo.create(['vm', ['uuid', '00000000-0000-0000-0000-0000ec291= 667'], ['name', 'dom_91667'], ['memory', '1700'], ['image', ['linux', ['k= ernel', '/boot/vmlinuz-2.6-xenU'], ['root', '/dev/sda1 ro'], ['args', '4'= ], ['vcpus', '1']]], ['device', ['tap', ['uname', 'tap:qcow:/mnt/instance= _image_store_0/3811.qcow'], ['dev', 'sda1'], ['mode', 'w']]], ['device', = ['vbd', ['uname', 'phy:/dev/VolGroupDomU/instance_ephemeral_store_0'], ['= dev', 'sda2'], ['mode', 'w']]], ['device', ['vbd', ['uname', 'phy:/dev/Vo= lGroupDomU/instance_swap_store_0'], ['dev', 'sda3'], ['mode', 'w']]], ['d= evice', ['vif', ['mac', '12:31:34:00:03:8E']]], ['memmap'], ['device_mode= l'], ['device_config']]) [2006-11-08 11:43:49 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:296)= parseConfig: config is ['vm', ['uuid', '00000000-0000-0000-0000-0000ec29= 1667'], ['name', 'dom_91667'], ['memory', '1700'], ['image', ['linux', ['= kernel', '/boot/vmlinuz-2.6-xenU'], ['root', '/dev/sda1 ro'], ['args', '4= '], ['vcpus', '1']]], ['device', ['tap', ['uname', 'tap:qcow:/mnt/instanc= e_image_store_0/3811.qcow'], ['dev', 'sda1'], ['mode', 'w']]], ['device',= ['vbd', ['uname', 'phy:/dev/VolGroupDomU/instance_ephemeral_store_0'], [= 'dev', 'sda2'], ['mode', 'w']]], ['device', ['vbd', ['uname', 'phy:/dev/V= olGroupDomU/instance_swap_store_0'], ['dev', 'sda3'], ['mode', 'w']]], ['= device', ['vif', ['mac', '12:31:34:00:03:8E']]], ['memmap'], ['device_mod= el'], ['device_config']] [2006-11-08 11:43:49 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:395)= parseConfig: result is {'shadow_memory': None, 'uuid': '00000000-0000-00= 00-0000-0000ec291667', 'on_crash': None, 'on_reboot': None, 'localtime': = None, 'image': ['linux', ['kernel', '/boot/vmlinuz-2.6-xenU'], ['root', '= /dev/sda1 ro'], ['args', '4'], ['vcpus', '1']], 'on_poweroff': None, 'boo= tloader_args': None, 'cpus': None, 'name': 'dom_91667', 'backend': [], 'v= cpus': 1, 'cpu_weight': None, 'features': None, 'vcpu_avail': None, 'memo= ry': 1700, 'device': [('tap', ['tap', ['uname', 'tap:qcow:/mnt/instance_i= mage_store_0/3811.qcow'], ['dev', 'sda1'], ['mode', 'w']]), ('vbd', ['vbd= ', ['uname', 'phy:/dev/VolGroupDomU/instance_ephemeral_store_0'], ['dev',= 'sda2'], ['mode', 'w']]), ('vbd', ['vbd', ['uname', 'phy:/dev/VolGroupDo= mU/instance_swap_store_0'], ['dev', 'sda3'], ['mode', 'w']]), ('vif', ['v= if', ['mac', '12:31:34:00:03:8E']])], 'bootloader': None, 'cpu': None, 'm= axmem': None} [2006-11-08 11:43:49 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:1253= ) XendDomainInfo.construct: None [2006-11-08 11:43:49 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:1285= ) XendDomainInfo.initDomain: 5 1.0 [2006-11-08 11:43:49 xend 2682] DEBUG (balloon:127) Balloon: 7268056 KiB = free; need 1740800; done. [2006-11-08 11:43:49 xend 2682] INFO (image:136) buildDomain os=3Dlinux d= om=3D5 vcpus=3D1 [2006-11-08 11:43:49 xend 2682] DEBUG (image:191) dom =3D 5 [2006-11-08 11:43:49 xend 2682] DEBUG (image:192) image =3D /boo= t/vmlinuz-2.6-xenU [2006-11-08 11:43:49 xend 2682] DEBUG (image:193) store_evtchn =3D 1 [2006-11-08 11:43:49 xend 2682] DEBUG (image:194) console_evtchn =3D 2 [2006-11-08 11:43:49 xend 2682] DEBUG (image:195) cmdline =3D roo= t=3D/dev/sda1 ro 4 [2006-11-08 11:43:49 xend 2682] DEBUG (image:196) ramdisk =3D=20 [2006-11-08 11:43:49 xend 2682] DEBUG (image:197) vcpus =3D 1 [2006-11-08 11:43:49 xend 2682] DEBUG (image:198) features =3D=20 [2006-11-08 11:43:49 xend 2682] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'virtual-device': '2049', 'device-type': 'dis= k', 'state': '1', 'backend': '/local/domain/0/backend/tap/5/2049'} to /lo= cal/domain/5/device/vbd/2049. [2006-11-08 11:43:49 xend 2682] DEBUG (DevController:112) DevController: = writing {'domain': 'dom_91667', 'frontend': '/local/domain/5/device/vbd/2= 049', 'dev': 'sda1', 'state': '1', 'params': 'qcow:/mnt/instance_image_st= ore_0/3811.qcow', 'mode': 'w', 'online': '1', 'frontend-id': '5', 'type':= 'tap'} to /local/domain/0/backend/tap/5/2049. [2006-11-08 11:43:49 xend 2682] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'virtual-device': '2050', 'device-type': 'dis= k', 'state': '1', 'backend': '/local/domain/0/backend/vbd/5/2050'} to /lo= cal/domain/5/device/vbd/2050. [2006-11-08 11:43:49 xend 2682] DEBUG (DevController:112) DevController: = writing {'domain': 'dom_91667', 'frontend': '/local/domain/5/device/vbd/2= 050', 'dev': 'sda2', 'state': '1', 'params': '/dev/VolGroupDomU/instance_= ephemeral_store_0', 'mode': 'w', 'online': '1', 'frontend-id': '5', 'type= ': 'phy'} to /local/domain/0/backend/vbd/5/2050. [2006-11-08 11:43:49 xend 2682] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'virtual-device': '2051', 'device-type': 'dis= k', 'state': '1', 'backend': '/local/domain/0/backend/vbd/5/2051'} to /lo= cal/domain/5/device/vbd/2051. [2006-11-08 11:43:49 xend 2682] DEBUG (DevController:112) DevController: = writing {'domain': 'dom_91667', 'frontend': '/local/domain/5/device/vbd/2= 051', 'dev': 'sda3', 'state': '1', 'params': '/dev/VolGroupDomU/instance_= swap_store_0', 'mode': 'w', 'online': '1', 'frontend-id': '5', 'type': 'p= hy'} to /local/domain/0/backend/vbd/5/2051. [2006-11-08 11:43:50 xend 2682] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'mac': '12:31:34:00:03:8E', 'handle': '0', 's= tate': '1', 'backend': '/local/domain/0/backend/vif/5/0'} to /local/domai= n/5/device/vif/0. [2006-11-08 11:43:50 xend 2682] DEBUG (DevController:112) DevController: = writing {'domain': 'dom_91667', 'handle': '0', 'script': '/etc/xen/script= s/vif-aes', 'state': '1', 'frontend': '/local/domain/5/device/vif/0', 'ma= c': '12:31:34:00:03:8E', 'online': '1', 'frontend-id': '5'} to /local/dom= ain/0/backend/vif/5/0. [2006-11-08 11:43:50 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:712)= Storing VM details: {'shadow_memory': '0', 'uuid': '00000000-0000-0000-0= 000-0000ec291667', 'on_reboot': 'restart', 'start_time': '1162979030.04',= 'on_poweroff': 'destroy', 'name': 'dom_91667', 'xend/restart_count': '0'= , 'vcpus': '1', 'vcpu_avail': '1', 'memory': '1700', 'on_crash': 'restart= ', 'image': "(linux (kernel /boot/vmlinuz-2.6-xenU) (root '/dev/sda1 ro')= (args 4) (vcpus 1))", 'maxmem': '1700'} [2006-11-08 11:43:50 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:747)= Storing domain details: {'console/ring-ref': '2065335', 'console/port': = '2', 'name': 'dom_91667', 'console/limit': '1048576', 'vm': '/vm/00000000= -0000-0000-0000-0000ec291667', 'domid': '5', 'cpu/0/availability': 'onlin= e', 'memory/target': '1740800', 'store/ring-ref': '2065186', 'store/port'= : '1'} [2006-11-08 11:43:50 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:933)= XendDomainInfo.handleShutdownWatch [2006-11-08 11:43:50 xend 2682] DEBUG (DevController:143) Waiting for dev= ices vif. [2006-11-08 11:43:50 xend 2682] DEBUG (DevController:149) Waiting for 0. [2006-11-08 11:43:50 xend 2682] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/vif/5/0/hotplug-status. [2006-11-08 11:45:30 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:1449= ) XendDomainInfo.destroy: domid=3D5 [2006-11-08 11:45:30 xend.XendDomainInfo 2682] DEBUG (XendDomainInfo:1457= ) XendDomainInfo.destroyDomain(5) [2006-11-08 12:52:34 xend 2890] INFO (SrvDaemon:283) Xend Daemon started [2006-11-08 12:52:34 xend 2890] INFO (SrvDaemon:287) Xend changeset: Sun = Oct 15 13:19:07 2006 +0100 11774:620cb0064d9b. [2006-11-08 12:52:34 xend.XendDomainInfo 2890] DEBUG (XendDomainInfo:212)= XendDomainInfo.recreate({'paused': 0, 'cpu_time': 18452402899L, 'ssidref= ': 0, 'handle': [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0], 'shutdo= wn_reason': 0, 'dying': 0, 'dom': 0, 'mem_kb': 1047296, 'maxmem_kb': -4, = 'max_vcpu_id': 1, 'crashed': 0, 'running': 1, 'shutdown': 0, 'online_vcpu= s': 2, 'blocked': 0}) [2006-11-08 12:52:34 xend.XendDomainInfo 2890] INFO (XendDomainInfo:224) = Recreating domain 0, UUID 00000000-0000-0000-0000-000000000000. [2006-11-08 12:52:34 xend.XendDomainInfo 2890] WARNING (XendDomainInfo:24= 6) No vm path in store for existing domain 0 [2006-11-08 12:52:34 xend.XendDomainInfo 2890] DEBUG (XendDomainInfo:712)= Storing VM details: {'shadow_memory': '0', 'uuid': '00000000-0000-0000-0= 000-000000000000', 'on_reboot': 'restart', 'on_poweroff': 'destroy', 'nam= e': 'Domain-0', 'xend/restart_count': '0', 'vcpus': '2', 'vcpu_avail': '3= ', 'memory': '1023', 'on_crash': 'restart', 'maxmem': '1023'} [2006-11-08 12:52:34 xend.XendDomainInfo 2890] DEBUG (XendDomainInfo:747)= Storing domain details: {'cpu/0/availability': 'online', 'memory/target'= : '1047552', 'cpu/1/availability': 'online', 'name': 'Domain-0', 'console= /limit': '1048576', 'vm': '/vm/00000000-0000-0000-0000-000000000000', 'do= mid': '0'} [2006-11-08 12:52:34 xend 2890] DEBUG (XendDomain:153) number of vcpus to= use is 0 [2006-11-08 12:52:34 xend.XendDomainInfo 2890] DEBUG (XendDomainInfo:933)= XendDomainInfo.handleShutdownWatch [2006-11-08 12:55:58 xend.XendDomainInfo 2890] DEBUG (XendDomainInfo:190)= XendDomainInfo.create(['vm', ['uuid', '00000000-0000-0000-0000-0000ec291= 677'], ['name', 'dom_91677'], ['memory', '1700'], ['image', ['linux', ['k= ernel', '/boot/vmlinuz-2.6-xenU'], ['root', '/dev/sda1 ro'], ['args', '4'= ], ['vcpus', '1']]], ['device', ['tap', ['uname', 'tap:qcow:/mnt/instance= _image_store_0/3811.qcow'], ['dev', 'sda1'], ['mode', 'w']]], ['device', = ['vbd', ['uname', 'phy:/dev/VolGroupDomU/instance_ephemeral_store_0'], ['= dev', 'sda2'], ['mode', 'w']]], ['device', ['vbd', ['uname', 'phy:/dev/Vo= lGroupDomU/instance_swap_store_0'], ['dev', 'sda3'], ['mode', 'w']]], ['d= evice', ['vif', ['mac', '12:31:34:00:03:8E']]], ['memmap'], ['device_mode= l'], ['device_config']]) [2006-11-08 12:55:58 xend.XendDomainInfo 2890] DEBUG (XendDomainInfo:296)= parseConfig: config is ['vm', ['uuid', '00000000-0000-0000-0000-0000ec29= 1677'], ['name', 'dom_91677'], ['memory', '1700'], ['image', ['linux', ['= kernel', '/boot/vmlinuz-2.6-xenU'], ['root', '/dev/sda1 ro'], ['args', '4= '], ['vcpus', '1']]], ['device', ['tap', ['uname', 'tap:qcow:/mnt/instanc= e_image_store_0/3811.qcow'], ['dev', 'sda1'], ['mode', 'w']]], ['device',= ['vbd', ['uname', 'phy:/dev/VolGroupDomU/instance_ephemeral_store_0'], [= 'dev', 'sda2'], ['mode', 'w']]], ['device', ['vbd', ['uname', 'phy:/dev/V= olGroupDomU/instance_swap_store_0'], ['dev', 'sda3'], ['mode', 'w']]], ['= device', ['vif', ['mac', '12:31:34:00:03:8E']]], ['memmap'], ['device_mod= el'], ['device_config']] [2006-11-08 12:55:58 xend.XendDomainInfo 2890] DEBUG (XendDomainInfo:395)= parseConfig: result is {'shadow_memory': None, 'uuid': '00000000-0000-00= 00-0000-0000ec291677', 'on_crash': None, 'on_reboot': None, 'localtime': = None, 'image': ['linux', ['kernel', '/boot/vmlinuz-2.6-xenU'], ['root', '= /dev/sda1 ro'], ['args', '4'], ['vcpus', '1']], 'on_poweroff': None, 'boo= tloader_args': None, 'cpus': None, 'name': 'dom_91677', 'backend': [], 'v= cpus': 1, 'cpu_weight': None, 'features': None, 'vcpu_avail': None, 'memo= ry': 1700, 'device': [('tap', ['tap', ['uname', 'tap:qcow:/mnt/instance_i= mage_store_0/3811.qcow'], ['dev', 'sda1'], ['mode', 'w']]), ('vbd', ['vbd= ', ['uname', 'phy:/dev/VolGroupDomU/instance_ephemeral_store_0'], ['dev',= 'sda2'], ['mode', 'w']]), ('vbd', ['vbd', ['uname', 'phy:/dev/VolGroupDo= mU/instance_swap_store_0'], ['dev', 'sda3'], ['mode', 'w']]), ('vif', ['v= if', ['mac', '12:31:34:00:03:8E']])], 'bootloader': None, 'cpu': None, 'm= axmem': None} [2006-11-08 12:55:58 xend.XendDomainInfo 2890] DEBUG (XendDomainInfo:1253= ) XendDomainInfo.construct: None [2006-11-08 12:55:58 xend.XendDomainInfo 2890] DEBUG (XendDomainInfo:1285= ) XendDomainInfo.initDomain: 1 1.0 [2006-11-08 12:55:58 xend 2890] DEBUG (balloon:127) Balloon: 7268224 KiB = free; need 1740800; done. [2006-11-08 12:55:58 xend 2890] INFO (image:136) buildDomain os=3Dlinux d= om=3D1 vcpus=3D1 [2006-11-08 12:55:58 xend 2890] DEBUG (image:191) dom =3D 1 [2006-11-08 12:55:58 xend 2890] DEBUG (image:192) image =3D /boo= t/vmlinuz-2.6-xenU [2006-11-08 12:55:58 xend 2890] DEBUG (image:193) store_evtchn =3D 1 [2006-11-08 12:55:58 xend 2890] DEBUG (image:194) console_evtchn =3D 2 [2006-11-08 12:55:58 xend 2890] DEBUG (image:195) cmdline =3D roo= t=3D/dev/sda1 ro 4 [2006-11-08 12:55:58 xend 2890] DEBUG (image:196) ramdisk =3D=20 [2006-11-08 12:55:58 xend 2890] DEBUG (image:197) vcpus =3D 1 [2006-11-08 12:55:58 xend 2890] DEBUG (image:198) features =3D=20 [2006-11-08 12:55:58 xend 2890] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'virtual-device': '2049', 'device-type': 'dis= k', 'state': '1', 'backend': '/local/domain/0/backend/tap/1/2049'} to /lo= cal/domain/1/device/vbd/2049. [2006-11-08 12:55:58 xend 2890] DEBUG (DevController:112) DevController: = writing {'domain': 'dom_91677', 'frontend': '/local/domain/1/device/vbd/2= 049', 'dev': 'sda1', 'state': '1', 'params': 'qcow:/mnt/instance_image_st= ore_0/3811.qcow', 'mode': 'w', 'online': '1', 'frontend-id': '1', 'type':= 'tap'} to /local/domain/0/backend/tap/1/2049. [2006-11-08 12:55:58 xend 2890] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'virtual-device': '2050', 'device-type': 'dis= k', 'state': '1', 'backend': '/local/domain/0/backend/vbd/1/2050'} to /lo= cal/domain/1/device/vbd/2050. [2006-11-08 12:55:58 xend 2890] DEBUG (DevController:112) DevController: = writing {'domain': 'dom_91677', 'frontend': '/local/domain/1/device/vbd/2= 050', 'dev': 'sda2', 'state': '1', 'params': '/dev/VolGroupDomU/instance_= ephemeral_store_0', 'mode': 'w', 'online': '1', 'frontend-id': '1', 'type= ': 'phy'} to /local/domain/0/backend/vbd/1/2050. [2006-11-08 12:55:59 xend 2890] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'virtual-device': '2051', 'device-type': 'dis= k', 'state': '1', 'backend': '/local/domain/0/backend/vbd/1/2051'} to /lo= cal/domain/1/device/vbd/2051. [2006-11-08 12:55:59 xend 2890] DEBUG (DevController:112) DevController: = writing {'domain': 'dom_91677', 'frontend': '/local/domain/1/device/vbd/2= 051', 'dev': 'sda3', 'state': '1', 'params': '/dev/VolGroupDomU/instance_= swap_store_0', 'mode': 'w', 'online': '1', 'frontend-id': '1', 'type': 'p= hy'} to /local/domain/0/backend/vbd/1/2051. [2006-11-08 12:55:59 xend 2890] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'mac': '12:31:34:00:03:8E', 'handle': '0', 's= tate': '1', 'backend': '/local/domain/0/backend/vif/1/0'} to /local/domai= n/1/device/vif/0. [2006-11-08 12:55:59 xend 2890] DEBUG (DevController:112) DevController: = writing {'domain': 'dom_91677', 'handle': '0', 'script': '/etc/xen/script= s/vif-aes', 'state': '1', 'frontend': '/local/domain/1/device/vif/0', 'ma= c': '12:31:34:00:03:8E', 'online': '1', 'frontend-id': '1'} to /local/dom= ain/0/backend/vif/1/0. [2006-11-08 12:55:59 xend.XendDomainInfo 2890] DEBUG (XendDomainInfo:712)= Storing VM details: {'shadow_memory': '0', 'uuid': '00000000-0000-0000-0= 000-0000ec291677', 'on_reboot': 'restart', 'start_time': '1162983359.04',= 'on_poweroff': 'destroy', 'name': 'dom_91677', 'xend/restart_count': '0'= , 'vcpus': '1', 'vcpu_avail': '1', 'memory': '1700', 'on_crash': 'restart= ', 'image': "(linux (kernel /boot/vmlinuz-2.6-xenU) (root '/dev/sda1 ro')= (args 4) (vcpus 1))", 'maxmem': '1700'} [2006-11-08 12:55:59 xend.XendDomainInfo 2890] DEBUG (XendDomainInfo:747)= Storing domain details: {'console/ring-ref': '1009738', 'console/port': = '2', 'name': 'dom_91677', 'console/limit': '1048576', 'vm': '/vm/00000000= -0000-0000-0000-0000ec291677', 'domid': '1', 'cpu/0/availability': 'onlin= e', 'memory/target': '1740800', 'store/ring-ref': '1009739', 'store/port'= : '1'} [2006-11-08 12:55:59 xend.XendDomainInfo 2890] DEBUG (XendDomainInfo:933)= XendDomainInfo.handleShutdownWatch [2006-11-08 12:55:59 xend 2890] DEBUG (DevController:143) Waiting for dev= ices vif. [2006-11-08 12:55:59 xend 2890] DEBUG (DevController:149) Waiting for 0. [2006-11-08 12:55:59 xend 2890] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/vif/1/0/hotplug-status. [2006-11-08 12:56:00 xend 2890] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/vif/1/0/hotplug-status. [2006-11-08 12:56:00 xend 2890] DEBUG (DevController:478) hotplugStatusCa= llback 1. [2006-11-08 12:56:00 xend 2890] DEBUG (DevController:143) Waiting for dev= ices usb. [2006-11-08 12:56:00 xend 2890] DEBUG (DevController:143) Waiting for dev= ices vbd. [2006-11-08 12:56:00 xend 2890] DEBUG (DevController:149) Waiting for 205= 0. [2006-11-08 12:56:00 xend 2890] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/vbd/1/2050/hotplug-status. [2006-11-08 12:56:00 xend 2890] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/vbd/1/2050/hotplug-status. [2006-11-08 12:56:00 xend 2890] DEBUG (DevController:478) hotplugStatusCa= llback 1. [2006-11-08 12:56:00 xend 2890] DEBUG (DevController:149) Waiting for 205= 1. [2006-11-08 12:56:00 xend 2890] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/vbd/1/2051/hotplug-status. [2006-11-08 12:56:00 xend 2890] DEBUG (DevController:478) hotplugStatusCa= llback 1. [2006-11-08 12:56:00 xend 2890] DEBUG (DevController:143) Waiting for dev= ices irq. [2006-11-08 12:56:00 xend 2890] DEBUG (DevController:143) Waiting for dev= ices pci. [2006-11-08 12:56:00 xend 2890] DEBUG (DevController:143) Waiting for dev= ices ioports. [2006-11-08 12:56:00 xend 2890] DEBUG (DevController:143) Waiting for dev= ices tap. [2006-11-08 12:56:00 xend 2890] DEBUG (DevController:149) Waiting for 204= 9. [2006-11-08 12:56:00 xend 2890] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/tap/1/2049/hotplug-status. [2006-11-08 12:56:00 xend 2890] DEBUG (DevController:478) hotplugStatusCa= llback 1. [2006-11-08 12:56:00 xend 2890] DEBUG (DevController:143) Waiting for dev= ices vtpm. [2006-11-08 12:56:00 xend 2890] INFO (XendDomain:370) Domain dom_91677 (1= ) unpaused. [2006-11-08 13:27:29 xend.XendDomainInfo 2890] DEBUG (XendDomainInfo:933)= XendDomainInfo.handleShutdownWatch [2006-11-08 13:27:29 xend.XendDomainInfo 2890] DEBUG (XendDomainInfo:933)= XendDomainInfo.handleShutdownWatch [2006-11-08 13:27:59 xend.XendDomainInfo 2890] INFO (XendDomainInfo:923) = Domain shutdown timeout expired: name=3Ddom_91677 id=3D1 [2006-11-08 13:27:59 xend.XendDomainInfo 2890] DEBUG (XendDomainInfo:1449= ) XendDomainInfo.destroy: domid=3D1 [2006-11-08 13:27:59 xend.XendDomainInfo 2890] DEBUG (XendDomainInfo:1457= ) XendDomainInfo.destroyDomain(1) [2006-11-08 15:57:17 xend 2893] INFO (SrvDaemon:283) Xend Daemon started [2006-11-08 15:57:17 xend 2893] INFO (SrvDaemon:287) Xend changeset: Sun = Oct 15 13:19:07 2006 +0100 11774:620cb0064d9b. [2006-11-08 15:57:17 xend.XendDomainInfo 2893] DEBUG (XendDomainInfo:212)= XendDomainInfo.recreate({'paused': 0, 'cpu_time': 17879451979L, 'ssidref= ': 0, 'handle': [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0], 'shutdo= wn_reason': 0, 'dying': 0, 'dom': 0, 'mem_kb': 1047296, 'maxmem_kb': -4, = 'max_vcpu_id': 1, 'crashed': 0, 'running': 1, 'shutdown': 0, 'online_vcpu= s': 2, 'blocked': 0}) [2006-11-08 15:57:17 xend.XendDomainInfo 2893] INFO (XendDomainInfo:224) = Recreating domain 0, UUID 00000000-0000-0000-0000-000000000000. [2006-11-08 15:57:17 xend.XendDomainInfo 2893] WARNING (XendDomainInfo:24= 6) No vm path in store for existing domain 0 [2006-11-08 15:57:17 xend.XendDomainInfo 2893] DEBUG (XendDomainInfo:712)= Storing VM details: {'shadow_memory': '0', 'uuid': '00000000-0000-0000-0= 000-000000000000', 'on_reboot': 'restart', 'on_poweroff': 'destroy', 'nam= e': 'Domain-0', 'xend/restart_count': '0', 'vcpus': '2', 'vcpu_avail': '3= ', 'memory': '1023', 'on_crash': 'restart', 'maxmem': '1023'} [2006-11-08 15:57:17 xend.XendDomainInfo 2893] DEBUG (XendDomainInfo:747)= Storing domain details: {'cpu/0/availability': 'online', 'memory/target'= : '1047552', 'cpu/1/availability': 'online', 'name': 'Domain-0', 'console= /limit': '1048576', 'vm': '/vm/00000000-0000-0000-0000-000000000000', 'do= mid': '0'} [2006-11-08 15:57:17 xend 2893] DEBUG (XendDomain:153) number of vcpus to= use is 0 [2006-11-08 15:57:17 xend.XendDomainInfo 2893] DEBUG (XendDomainInfo:933)= XendDomainInfo.handleShutdownWatch [2006-11-08 16:04:39 xend.XendDomainInfo 2893] DEBUG (XendDomainInfo:190)= XendDomainInfo.create(['vm', ['uuid', '00000000-0000-0000-0000-0000ec291= 715'], ['name', 'dom_91715'], ['memory', '1700'], ['image', ['linux', ['k= ernel', '/boot/vmlinuz-2.6.16.29-xen'], ['ramdisk', '/boot/initrd-2.6.16.= 29-xen.img'], ['root', '/dev/sda1 ro'], ['args', '4'], ['vcpus', '1']]], = ['device', ['tap', ['uname', 'tap:aio:/mnt/instance_image_store_1/3811'],= ['dev', 'sda1'], ['mode', 'w']]], ['device', ['vbd', ['uname', 'phy:/dev= /VolGroupDomU/instance_ephemeral_store_1'], ['dev', 'sda2'], ['mode', 'w'= ]]], ['device', ['vbd', ['uname', 'phy:/dev/VolGroupDomU/instance_swap_st= ore_1'], ['dev', 'sda3'], ['mode', 'w']]], ['device', ['vif', ['mac', '12= :31:34:00:03:8F']]], ['memmap'], ['device_model'], ['device_config']]) [2006-11-08 16:04:39 xend.XendDomainInfo 2893] DEBUG (XendDomainInfo:296)= parseConfig: config is ['vm', ['uuid', '00000000-0000-0000-0000-0000ec29= 1715'], ['name', 'dom_91715'], ['memory', '1700'], ['image', ['linux', ['= kernel', '/boot/vmlinuz-2.6.16.29-xen'], ['ramdisk', '/boot/initrd-2.6.16= =2E29-xen.img'], ['root', '/dev/sda1 ro'], ['args', '4'], ['vcpus', '1']]= ], ['device', ['tap', ['uname', 'tap:aio:/mnt/instance_image_store_1/3811= '], ['dev', 'sda1'], ['mode', 'w']]], ['device', ['vbd', ['uname', 'phy:/= dev/VolGroupDomU/instance_ephemeral_store_1'], ['dev', 'sda2'], ['mode', = 'w']]], ['device', ['vbd', ['uname', 'phy:/dev/VolGroupDomU/instance_swap= _store_1'], ['dev', 'sda3'], ['mode', 'w']]], ['device', ['vif', ['mac', = '12:31:34:00:03:8F']]], ['memmap'], ['device_model'], ['device_config']] [2006-11-08 16:04:39 xend.XendDomainInfo 2893] DEBUG (XendDomainInfo:395)= parseConfig: result is {'shadow_memory': None, 'uuid': '00000000-0000-00= 00-0000-0000ec291715', 'on_crash': None, 'on_reboot': None, 'localtime': = None, 'image': ['linux', ['kernel', '/boot/vmlinuz-2.6.16.29-xen'], ['ram= disk', '/boot/initrd-2.6.16.29-xen.img'], ['root', '/dev/sda1 ro'], ['arg= s', '4'], ['vcpus', '1']], 'on_poweroff': None, 'bootloader_args': None, = 'cpus': None, 'name': 'dom_91715', 'backend': [], 'vcpus': 1, 'cpu_weight= ': None, 'features': None, 'vcpu_avail': None, 'memory': 1700, 'device': = [('tap', ['tap', ['uname', 'tap:aio:/mnt/instance_image_store_1/3811'], [= 'dev', 'sda1'], ['mode', 'w']]), ('vbd', ['vbd', ['uname', 'phy:/dev/VolG= roupDomU/instance_ephemeral_store_1'], ['dev', 'sda2'], ['mode', 'w']]), = ('vbd', ['vbd', ['uname', 'phy:/dev/VolGroupDomU/instance_swap_store_1'],= ['dev', 'sda3'], ['mode', 'w']]), ('vif', ['vif', ['mac', '12:31:34:00:0= 3:8F']])], 'bootloader': None, 'cpu': None, 'maxmem': None} [2006-11-08 16:04:39 xend.XendDomainInfo 2893] DEBUG (XendDomainInfo:1253= ) XendDomainInfo.construct: None [2006-11-08 16:04:39 xend.XendDomainInfo 2893] DEBUG (XendDomainInfo:1285= ) XendDomainInfo.initDomain: 1 1.0 [2006-11-08 16:04:39 xend 2893] DEBUG (balloon:127) Balloon: 7268224 KiB = free; need 1740800; done. [2006-11-08 16:04:39 xend 2893] INFO (image:136) buildDomain os=3Dlinux d= om=3D1 vcpus=3D1 [2006-11-08 16:04:39 xend 2893] DEBUG (image:191) dom =3D 1 [2006-11-08 16:04:39 xend 2893] DEBUG (image:192) image =3D /boo= t/vmlinuz-2.6.16.29-xen [2006-11-08 16:04:39 xend 2893] DEBUG (image:193) store_evtchn =3D 1 [2006-11-08 16:04:39 xend 2893] DEBUG (image:194) console_evtchn =3D 2 [2006-11-08 16:04:39 xend 2893] DEBUG (image:195) cmdline =3D roo= t=3D/dev/sda1 ro 4 [2006-11-08 16:04:39 xend 2893] DEBUG (image:196) ramdisk =3D /boo= t/initrd-2.6.16.29-xen.img [2006-11-08 16:04:39 xend 2893] DEBUG (image:197) vcpus =3D 1 [2006-11-08 16:04:39 xend 2893] DEBUG (image:198) features =3D=20 [2006-11-08 16:04:42 xend 2893] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'virtual-device': '2049', 'device-type': 'dis= k', 'state': '1', 'backend': '/local/domain/0/backend/tap/1/2049'} to /lo= cal/domain/1/device/vbd/2049. [2006-11-08 16:04:42 xend 2893] DEBUG (DevController:112) DevController: = writing {'domain': 'dom_91715', 'frontend': '/local/domain/1/device/vbd/2= 049', 'dev': 'sda1', 'state': '1', 'params': 'aio:/mnt/instance_image_sto= re_1/3811', 'mode': 'w', 'online': '1', 'frontend-id': '1', 'type': 'tap'= } to /local/domain/0/backend/tap/1/2049. [2006-11-08 16:04:42 xend 2893] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'virtual-device': '2050', 'device-type': 'dis= k', 'state': '1', 'backend': '/local/domain/0/backend/vbd/1/2050'} to /lo= cal/domain/1/device/vbd/2050. [2006-11-08 16:04:42 xend 2893] DEBUG (DevController:112) DevController: = writing {'domain': 'dom_91715', 'frontend': '/local/domain/1/device/vbd/2= 050', 'dev': 'sda2', 'state': '1', 'params': '/dev/VolGroupDomU/instance_= ephemeral_store_1', 'mode': 'w', 'online': '1', 'frontend-id': '1', 'type= ': 'phy'} to /local/domain/0/backend/vbd/1/2050. [2006-11-08 16:04:42 xend 2893] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'virtual-device': '2051', 'device-type': 'dis= k', 'state': '1', 'backend': '/local/domain/0/backend/vbd/1/2051'} to /lo= cal/domain/1/device/vbd/2051. [2006-11-08 16:04:42 xend 2893] DEBUG (DevController:112) DevController: = writing {'domain': 'dom_91715', 'frontend': '/local/domain/1/device/vbd/2= 051', 'dev': 'sda3', 'state': '1', 'params': '/dev/VolGroupDomU/instance_= swap_store_1', 'mode': 'w', 'online': '1', 'frontend-id': '1', 'type': 'p= hy'} to /local/domain/0/backend/vbd/1/2051. [2006-11-08 16:04:42 xend 2893] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'mac': '12:31:34:00:03:8F', 'handle': '0', 's= tate': '1', 'backend': '/local/domain/0/backend/vif/1/0'} to /local/domai= n/1/device/vif/0. [2006-11-08 16:04:42 xend 2893] DEBUG (DevController:112) DevController: = writing {'domain': 'dom_91715', 'handle': '0', 'script': '/etc/xen/script= s/vif-aes', 'state': '1', 'frontend': '/local/domain/1/device/vif/0', 'ma= c': '12:31:34:00:03:8F', 'online': '1', 'frontend-id': '1'} to /local/dom= ain/0/backend/vif/1/0. [2006-11-08 16:04:42 xend.XendDomainInfo 2893] DEBUG (XendDomainInfo:712)= Storing VM details: {'shadow_memory': '0', 'uuid': '00000000-0000-0000-0= 000-0000ec291715', 'on_reboot': 'restart', 'start_time': '1162994682.56',= 'on_poweroff': 'destroy', 'name': 'dom_91715', 'xend/restart_count': '0'= , 'vcpus': '1', 'vcpu_avail': '1', 'memory': '1700', 'on_crash': 'restart= ', 'image': "(linux (kernel /boot/vmlinuz-2.6.16.29-xen) (ramdisk /boot/i= nitrd-2.6.16.29-xen.img) (root '/dev/sda1 ro') (args 4) (vcpus 1))", 'max= mem': '1700'} [2006-11-08 16:04:42 xend.XendDomainInfo 2893] DEBUG (XendDomainInfo:747)= Storing domain details: {'console/ring-ref': '995310', 'console/port': '= 2', 'name': 'dom_91715', 'console/limit': '1048576', 'vm': '/vm/00000000-= 0000-0000-0000-0000ec291715', 'domid': '1', 'cpu/0/availability': 'online= ', 'memory/target': '1740800', 'store/ring-ref': '995311', 'store/port': = '1'} [2006-11-08 16:04:42 xend.XendDomainInfo 2893] DEBUG (XendDomainInfo:933)= XendDomainInfo.handleShutdownWatch [2006-11-08 16:04:42 xend 2893] DEBUG (DevController:143) Waiting for dev= ices vif. [2006-11-08 16:04:42 xend 2893] DEBUG (DevController:149) Waiting for 0. [2006-11-08 16:04:42 xend 2893] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/vif/1/0/hotplug-status. [2006-11-08 16:04:45 xend 2893] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/vif/1/0/hotplug-status. [2006-11-08 16:04:45 xend 2893] DEBUG (DevController:478) hotplugStatusCa= llback 1. [2006-11-08 16:04:45 xend 2893] DEBUG (DevController:143) Waiting for dev= ices usb. [2006-11-08 16:04:45 xend 2893] DEBUG (DevController:143) Waiting for dev= ices vbd. [2006-11-08 16:04:45 xend 2893] DEBUG (DevController:149) Waiting for 205= 0. [2006-11-08 16:04:45 xend 2893] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/vbd/1/2050/hotplug-status. [2006-11-08 16:04:45 xend 2893] DEBUG (DevController:478) hotplugStatusCa= llback 1. [2006-11-08 16:04:45 xend 2893] DEBUG (DevController:149) Waiting for 205= 1. [2006-11-08 16:04:45 xend 2893] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/vbd/1/2051/hotplug-status. [2006-11-08 16:04:45 xend 2893] DEBUG (DevController:478) hotplugStatusCa= llback 1. [2006-11-08 16:04:45 xend 2893] DEBUG (DevController:143) Waiting for dev= ices irq. [2006-11-08 16:04:45 xend 2893] DEBUG (DevController:143) Waiting for dev= ices pci. [2006-11-08 16:04:45 xend 2893] DEBUG (DevController:143) Waiting for dev= ices ioports. [2006-11-08 16:04:45 xend 2893] DEBUG (DevController:143) Waiting for dev= ices tap. [2006-11-08 16:04:45 xend 2893] DEBUG (DevController:149) Waiting for 204= 9. [2006-11-08 16:04:45 xend 2893] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/tap/1/2049/hotplug-status. [2006-11-08 16:04:45 xend 2893] DEBUG (DevController:478) hotplugStatusCa= llback 1. [2006-11-08 16:04:45 xend 2893] DEBUG (DevController:143) Waiting for dev= ices vtpm. [2006-11-08 16:04:45 xend 2893] INFO (XendDomain:370) Domain dom_91715 (1= ) unpaused. [2006-11-08 16:16:08 xend.XendDomainInfo 2893] DEBUG (XendDomainInfo:190)= XendDomainInfo.create(['vm', ['uuid', '00000000-0000-0000-0000-0000ec291= 721'], ['name', 'dom_91721'], ['memory', '1700'], ['image', ['linux', ['k= ernel', '/boot/vmlinuz-2.6.16.29-xen'], ['ramdisk', '/boot/initrd-2.6.16.= 29-xen.img'], ['root', '/dev/sda1 ro'], ['args', '4'], ['vcpus', '1']]], = ['device', ['tap', ['uname', 'tap:qcow:/mnt/instance_image_store_0/3811.q= cow'], ['dev', 'sda1'], ['mode', 'w']]], ['device', ['vbd', ['uname', 'ph= y:/dev/VolGroupDomU/instance_ephemeral_store_0'], ['dev', 'sda2'], ['mode= ', 'w']]], ['device', ['vbd', ['uname', 'phy:/dev/VolGroupDomU/instance_s= wap_store_0'], ['dev', 'sda3'], ['mode', 'w']]], ['device', ['vif', ['mac= ', '12:31:34:00:03:8E']]], ['memmap'], ['device_model'], ['device_config'= ]]) [2006-11-08 16:16:08 xend.XendDomainInfo 2893] DEBUG (XendDomainInfo:296)= parseConfig: config is ['vm', ['uuid', '00000000-0000-0000-0000-0000ec29= 1721'], ['name', 'dom_91721'], ['memory', '1700'], ['image', ['linux', ['= kernel', '/boot/vmlinuz-2.6.16.29-xen'], ['ramdisk', '/boot/initrd-2.6.16= =2E29-xen.img'], ['root', '/dev/sda1 ro'], ['args', '4'], ['vcpus', '1']]= ], ['device', ['tap', ['uname', 'tap:qcow:/mnt/instance_image_store_0/381= 1.qcow'], ['dev', 'sda1'], ['mode', 'w']]], ['device', ['vbd', ['uname', = 'phy:/dev/VolGroupDomU/instance_ephemeral_store_0'], ['dev', 'sda2'], ['m= ode', 'w']]], ['device', ['vbd', ['uname', 'phy:/dev/VolGroupDomU/instanc= e_swap_store_0'], ['dev', 'sda3'], ['mode', 'w']]], ['device', ['vif', ['= mac', '12:31:34:00:03:8E']]], ['memmap'], ['device_model'], ['device_conf= ig']] [2006-11-08 16:16:08 xend.XendDomainInfo 2893] DEBUG (XendDomainInfo:395)= parseConfig: result is {'shadow_memory': None, 'uuid': '00000000-0000-00= 00-0000-0000ec291721', 'on_crash': None, 'on_reboot': None, 'localtime': = None, 'image': ['linux', ['kernel', '/boot/vmlinuz-2.6.16.29-xen'], ['ram= disk', '/boot/initrd-2.6.16.29-xen.img'], ['root', '/dev/sda1 ro'], ['arg= s', '4'], ['vcpus', '1']], 'on_poweroff': None, 'bootloader_args': None, = 'cpus': None, 'name': 'dom_91721', 'backend': [], 'vcpus': 1, 'cpu_weight= ': None, 'features': None, 'vcpu_avail': None, 'memory': 1700, 'device': = [('tap', ['tap', ['uname', 'tap:qcow:/mnt/instance_image_store_0/3811.qco= w'], ['dev', 'sda1'], ['mode', 'w']]), ('vbd', ['vbd', ['uname', 'phy:/de= v/VolGroupDomU/instance_ephemeral_store_0'], ['dev', 'sda2'], ['mode', 'w= ']]), ('vbd', ['vbd', ['uname', 'phy:/dev/VolGroupDomU/instance_swap_stor= e_0'], ['dev', 'sda3'], ['mode', 'w']]), ('vif', ['vif', ['mac', '12:31:3= 4:00:03:8E']])], 'bootloader': None, 'cpu': None, 'maxmem': None} [2006-11-08 16:16:08 xend.XendDomainInfo 2893] DEBUG (XendDomainInfo:1253= ) XendDomainInfo.construct: None [2006-11-08 16:16:08 xend.XendDomainInfo 2893] DEBUG (XendDomainInfo:1285= ) XendDomainInfo.initDomain: 2 1.0 [2006-11-08 16:16:08 xend 2893] DEBUG (balloon:127) Balloon: 5528620 KiB = free; need 1740800; done. [2006-11-08 16:16:08 xend 2893] INFO (image:136) buildDomain os=3Dlinux d= om=3D2 vcpus=3D1 [2006-11-08 16:16:08 xend 2893] DEBUG (image:191) dom =3D 2 [2006-11-08 16:16:08 xend 2893] DEBUG (image:192) image =3D /boo= t/vmlinuz-2.6.16.29-xen [2006-11-08 16:16:08 xend 2893] DEBUG (image:193) store_evtchn =3D 1 [2006-11-08 16:16:08 xend 2893] DEBUG (image:194) console_evtchn =3D 2 [2006-11-08 16:16:08 xend 2893] DEBUG (image:195) cmdline =3D roo= t=3D/dev/sda1 ro 4 [2006-11-08 16:16:08 xend 2893] DEBUG (image:196) ramdisk =3D /boo= t/initrd-2.6.16.29-xen.img [2006-11-08 16:16:08 xend 2893] DEBUG (image:197) vcpus =3D 1 [2006-11-08 16:16:08 xend 2893] DEBUG (image:198) features =3D=20 [2006-11-08 16:16:09 xend 2893] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'virtual-device': '2049', 'device-type': 'dis= k', 'state': '1', 'backend': '/local/domain/0/backend/tap/2/2049'} to /lo= cal/domain/2/device/vbd/2049. [2006-11-08 16:16:09 xend 2893] DEBUG (DevController:112) DevController: = writing {'domain': 'dom_91721', 'frontend': '/local/domain/2/device/vbd/2= 049', 'dev': 'sda1', 'state': '1', 'params': 'qcow:/mnt/instance_image_st= ore_0/3811.qcow', 'mode': 'w', 'online': '1', 'frontend-id': '2', 'type':= 'tap'} to /local/domain/0/backend/tap/2/2049. [2006-11-08 16:16:09 xend 2893] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'virtual-device': '2050', 'device-type': 'dis= k', 'state': '1', 'backend': '/local/domain/0/backend/vbd/2/2050'} to /lo= cal/domain/2/device/vbd/2050. [2006-11-08 16:16:09 xend 2893] DEBUG (DevController:112) DevController: = writing {'domain': 'dom_91721', 'frontend': '/local/domain/2/device/vbd/2= 050', 'dev': 'sda2', 'state': '1', 'params': '/dev/VolGroupDomU/instance_= ephemeral_store_0', 'mode': 'w', 'online': '1', 'frontend-id': '2', 'type= ': 'phy'} to /local/domain/0/backend/vbd/2/2050. [2006-11-08 16:16:09 xend 2893] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'virtual-device': '2051', 'device-type': 'dis= k', 'state': '1', 'backend': '/local/domain/0/backend/vbd/2/2051'} to /lo= cal/domain/2/device/vbd/2051. [2006-11-08 16:16:09 xend 2893] DEBUG (DevController:112) DevController: = writing {'domain': 'dom_91721', 'frontend': '/local/domain/2/device/vbd/2= 051', 'dev': 'sda3', 'state': '1', 'params': '/dev/VolGroupDomU/instance_= swap_store_0', 'mode': 'w', 'online': '1', 'frontend-id': '2', 'type': 'p= hy'} to /local/domain/0/backend/vbd/2/2051. [2006-11-08 16:16:09 xend 2893] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'mac': '12:31:34:00:03:8E', 'handle': '0', 's= tate': '1', 'backend': '/local/domain/0/backend/vif/2/0'} to /local/domai= n/2/device/vif/0. [2006-11-08 16:16:09 xend 2893] DEBUG (DevController:112) DevController: = writing {'domain': 'dom_91721', 'handle': '0', 'script': '/etc/xen/script= s/vif-aes', 'state': '1', 'frontend': '/local/domain/2/device/vif/0', 'ma= c': '12:31:34:00:03:8E', 'online': '1', 'frontend-id': '2'} to /local/dom= ain/0/backend/vif/2/0. [2006-11-08 16:16:09 xend.XendDomainInfo 2893] DEBUG (XendDomainInfo:712)= Storing VM details: {'shadow_memory': '0', 'uuid': '00000000-0000-0000-0= 000-0000ec291721', 'on_reboot': 'restart', 'start_time': '1162995369.36',= 'on_poweroff': 'destroy', 'name': 'dom_91721', 'xend/restart_count': '0'= , 'vcpus': '1', 'vcpu_avail': '1', 'memory': '1700', 'on_crash': 'restart= ', 'image': "(linux (kernel /boot/vmlinuz-2.6.16.29-xen) (ramdisk /boot/i= nitrd-2.6.16.29-xen.img) (root '/dev/sda1 ro') (args 4) (vcpus 1))", 'max= mem': '1700'} [2006-11-08 16:16:09 xend.XendDomainInfo 2893] DEBUG (XendDomainInfo:747)= Storing domain details: {'console/ring-ref': '1939705', 'console/port': = '2', 'name': 'dom_91721', 'console/limit': '1048576', 'vm': '/vm/00000000= -0000-0000-0000-0000ec291721', 'domid': '2', 'cpu/0/availability': 'onlin= e', 'memory/target': '1740800', 'store/ring-ref': '1939706', 'store/port'= : '1'} [2006-11-08 16:16:09 xend 2893] DEBUG (DevController:143) Waiting for dev= ices vif. [2006-11-08 16:16:09 xend.XendDomainInfo 2893] DEBUG (XendDomainInfo:933)= XendDomainInfo.handleShutdownWatch [2006-11-08 16:16:09 xend 2893] DEBUG (DevController:149) Waiting for 0. [2006-11-08 16:16:09 xend 2893] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/vif/2/0/hotplug-status. [2006-11-08 16:16:10 xend 2893] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/vif/2/0/hotplug-status. [2006-11-08 16:16:10 xend 2893] DEBUG (DevController:478) hotplugStatusCa= llback 1. [2006-11-08 16:16:11 xend 2893] DEBUG (DevController:143) Waiting for dev= ices usb. [2006-11-08 16:16:11 xend 2893] DEBUG (DevController:143) Waiting for dev= ices vbd. [2006-11-08 16:16:11 xend 2893] DEBUG (DevController:149) Waiting for 205= 0. [2006-11-08 16:16:11 xend 2893] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/vbd/2/2050/hotplug-status. [2006-11-08 16:16:11 xend 2893] DEBUG (DevController:478) hotplugStatusCa= llback 1. [2006-11-08 16:16:11 xend 2893] DEBUG (DevController:149) Waiting for 205= 1. [2006-11-08 16:16:11 xend 2893] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/vbd/2/2051/hotplug-status. [2006-11-08 16:16:11 xend 2893] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/vbd/2/2051/hotplug-status. [2006-11-08 16:16:11 xend 2893] DEBUG (DevController:478) hotplugStatusCa= llback 1. [2006-11-08 16:16:11 xend 2893] DEBUG (DevController:143) Waiting for dev= ices irq. [2006-11-08 16:16:11 xend 2893] DEBUG (DevController:143) Waiting for dev= ices pci. [2006-11-08 16:16:11 xend 2893] DEBUG (DevController:143) Waiting for dev= ices ioports. [2006-11-08 16:16:11 xend 2893] DEBUG (DevController:143) Waiting for dev= ices tap. [2006-11-08 16:16:11 xend 2893] DEBUG (DevController:149) Waiting for 204= 9. [2006-11-08 16:16:11 xend 2893] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/tap/2/2049/hotplug-status. [2006-11-08 16:16:11 xend 2893] DEBUG (DevController:478) hotplugStatusCa= llback 1. [2006-11-08 16:16:11 xend 2893] DEBUG (DevController:143) Waiting for dev= ices vtpm. [2006-11-08 16:16:11 xend 2893] INFO (XendDomain:370) Domain dom_91721 (2= ) unpaused. [2006-11-08 16:29:49 xend.XendDomainInfo 2893] DEBUG (XendDomainInfo:933)= XendDomainInfo.handleShutdownWatch [2006-11-08 16:29:49 xend.XendDomainInfo 2893] DEBUG (XendDomainInfo:933)= XendDomainInfo.handleShutdownWatch [2006-11-08 16:32:44 xend.XendDomainInfo 2893] DEBUG (XendDomainInfo:1449= ) XendDomainInfo.destroy: domid=3D2 [2006-11-08 16:32:44 xend.XendDomainInfo 2893] DEBUG (XendDomainInfo:1457= ) XendDomainInfo.destroyDomain(2) [2006-11-08 16:44:55 xend.XendDomainInfo 2893] DEBUG (XendDomainInfo:190)= XendDomainInfo.create(['vm', ['uuid', '00000000-0000-0000-0000-0000ec291= 723'], ['name', 'dom_91723'], ['memory', '1700'], ['image', ['linux', ['k= ernel', '/boot/vmlinuz-2.6.16.29-xen'], ['ramdisk', '/boot/initrd-2.6.16.= 29-xen.img'], ['root', '/dev/sda1 ro'], ['args', '4'], ['vcpus', '1']]], = ['device', ['tap', ['uname', 'tap:qcow:/mnt/instance_image_store_2/3811.q= cow'], ['dev', 'sda1'], ['mode', 'w']]], ['device', ['vbd', ['uname', 'ph= y:/dev/VolGroupDomU/instance_ephemeral_store_2'], ['dev', 'sda2'], ['mode= ', 'w']]], ['device', ['vbd', ['uname', 'phy:/dev/VolGroupDomU/instance_s= wap_store_2'], ['dev', 'sda3'], ['mode', 'w']]], ['device', ['vif', ['mac= ', '12:31:34:00:03:8D']]], ['memmap'], ['device_model'], ['device_config'= ]]) [2006-11-08 16:44:55 xend.XendDomainInfo 2893] DEBUG (XendDomainInfo:296)= parseConfig: config is ['vm', ['uuid', '00000000-0000-0000-0000-0000ec29= 1723'], ['name', 'dom_91723'], ['memory', '1700'], ['image', ['linux', ['= kernel', '/boot/vmlinuz-2.6.16.29-xen'], ['ramdisk', '/boot/initrd-2.6.16= =2E29-xen.img'], ['root', '/dev/sda1 ro'], ['args', '4'], ['vcpus', '1']]= ], ['device', ['tap', ['uname', 'tap:qcow:/mnt/instance_image_store_2/381= 1.qcow'], ['dev', 'sda1'], ['mode', 'w']]], ['device', ['vbd', ['uname', = 'phy:/dev/VolGroupDomU/instance_ephemeral_store_2'], ['dev', 'sda2'], ['m= ode', 'w']]], ['device', ['vbd', ['uname', 'phy:/dev/VolGroupDomU/instanc= e_swap_store_2'], ['dev', 'sda3'], ['mode', 'w']]], ['device', ['vif', ['= mac', '12:31:34:00:03:8D']]], ['memmap'], ['device_model'], ['device_conf= ig']] [2006-11-08 16:44:55 xend.XendDomainInfo 2893] DEBUG (XendDomainInfo:395)= parseConfig: result is {'shadow_memory': None, 'uuid': '00000000-0000-00= 00-0000-0000ec291723', 'on_crash': None, 'on_reboot': None, 'localtime': = None, 'image': ['linux', ['kernel', '/boot/vmlinuz-2.6.16.29-xen'], ['ram= disk', '/boot/initrd-2.6.16.29-xen.img'], ['root', '/dev/sda1 ro'], ['arg= s', '4'], ['vcpus', '1']], 'on_poweroff': None, 'bootloader_args': None, = 'cpus': None, 'name': 'dom_91723', 'backend': [], 'vcpus': 1, 'cpu_weight= ': None, 'features': None, 'vcpu_avail': None, 'memory': 1700, 'device': = [('tap', ['tap', ['uname', 'tap:qcow:/mnt/instance_image_store_2/3811.qco= w'], ['dev', 'sda1'], ['mode', 'w']]), ('vbd', ['vbd', ['uname', 'phy:/de= v/VolGroupDomU/instance_ephemeral_store_2'], ['dev', 'sda2'], ['mode', 'w= ']]), ('vbd', ['vbd', ['uname', 'phy:/dev/VolGroupDomU/instance_swap_stor= e_2'], ['dev', 'sda3'], ['mode', 'w']]), ('vif', ['vif', ['mac', '12:31:3= 4:00:03:8D']])], 'bootloader': None, 'cpu': None, 'maxmem': None} [2006-11-08 16:44:55 xend.XendDomainInfo 2893] DEBUG (XendDomainInfo:1253= ) XendDomainInfo.construct: None [2006-11-08 16:44:55 xend.XendDomainInfo 2893] DEBUG (XendDomainInfo:1285= ) XendDomainInfo.initDomain: 3 1.0 [2006-11-08 16:44:55 xend 2893] DEBUG (balloon:127) Balloon: 5528628 KiB = free; need 1740800; done. [2006-11-08 16:44:55 xend 2893] INFO (image:136) buildDomain os=3Dlinux d= om=3D3 vcpus=3D1 [2006-11-08 16:44:55 xend 2893] DEBUG (image:191) dom =3D 3 [2006-11-08 16:44:55 xend 2893] DEBUG (image:192) image =3D /boo= t/vmlinuz-2.6.16.29-xen [2006-11-08 16:44:55 xend 2893] DEBUG (image:193) store_evtchn =3D 1 [2006-11-08 16:44:55 xend 2893] DEBUG (image:194) console_evtchn =3D 2 [2006-11-08 16:44:55 xend 2893] DEBUG (image:195) cmdline =3D roo= t=3D/dev/sda1 ro 4 [2006-11-08 16:44:55 xend 2893] DEBUG (image:196) ramdisk =3D /boo= t/initrd-2.6.16.29-xen.img [2006-11-08 16:44:55 xend 2893] DEBUG (image:197) vcpus =3D 1 [2006-11-08 16:44:55 xend 2893] DEBUG (image:198) features =3D=20 [2006-11-08 16:44:55 xend 2893] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'virtual-device': '2049', 'device-type': 'dis= k', 'state': '1', 'backend': '/local/domain/0/backend/tap/3/2049'} to /lo= cal/domain/3/device/vbd/2049. [2006-11-08 16:44:55 xend 2893] DEBUG (DevController:112) DevController: = writing {'domain': 'dom_91723', 'frontend': '/local/domain/3/device/vbd/2= 049', 'dev': 'sda1', 'state': '1', 'params': 'qcow:/mnt/instance_image_st= ore_2/3811.qcow', 'mode': 'w', 'online': '1', 'frontend-id': '3', 'type':= 'tap'} to /local/domain/0/backend/tap/3/2049. [2006-11-08 16:44:55 xend 2893] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'virtual-device': '2050', 'device-type': 'dis= k', 'state': '1', 'backend': '/local/domain/0/backend/vbd/3/2050'} to /lo= cal/domain/3/device/vbd/2050. [2006-11-08 16:44:55 xend 2893] DEBUG (DevController:112) DevController: = writing {'domain': 'dom_91723', 'frontend': '/local/domain/3/device/vbd/2= 050', 'dev': 'sda2', 'state': '1', 'params': '/dev/VolGroupDomU/instance_= ephemeral_store_2', 'mode': 'w', 'online': '1', 'frontend-id': '3', 'type= ': 'phy'} to /local/domain/0/backend/vbd/3/2050. [2006-11-08 16:44:56 xend 2893] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'virtual-device': '2051', 'device-type': 'dis= k', 'state': '1', 'backend': '/local/domain/0/backend/vbd/3/2051'} to /lo= cal/domain/3/device/vbd/2051. [2006-11-08 16:44:56 xend 2893] DEBUG (DevController:112) DevController: = writing {'domain': 'dom_91723', 'frontend': '/local/domain/3/device/vbd/2= 051', 'dev': 'sda3', 'state': '1', 'params': '/dev/VolGroupDomU/instance_= swap_store_2', 'mode': 'w', 'online': '1', 'frontend-id': '3', 'type': 'p= hy'} to /local/domain/0/backend/vbd/3/2051. [2006-11-08 16:44:56 xend 2893] DEBUG (DevController:110) DevController: = writing {'backend-id': '0', 'mac': '12:31:34:00:03:8D', 'handle': '0', 's= tate': '1', 'backend': '/local/domain/0/backend/vif/3/0'} to /local/domai= n/3/device/vif/0. [2006-11-08 16:44:56 xend 2893] DEBUG (DevController:112) DevController: = writing {'domain': 'dom_91723', 'handle': '0', 'script': '/etc/xen/script= s/vif-aes', 'state': '1', 'frontend': '/local/domain/3/device/vif/0', 'ma= c': '12:31:34:00:03:8D', 'online': '1', 'frontend-id': '3'} to /local/dom= ain/0/backend/vif/3/0. [2006-11-08 16:44:56 xend.XendDomainInfo 2893] DEBUG (XendDomainInfo:712)= Storing VM details: {'shadow_memory': '0', 'uuid': '00000000-0000-0000-0= 000-0000ec291723', 'on_reboot': 'restart', 'start_time': '1162997096.03',= 'on_poweroff': 'destroy', 'name': 'dom_91723', 'xend/restart_count': '0'= , 'vcpus': '1', 'vcpu_avail': '1', 'memory': '1700', 'on_crash': 'restart= ', 'image': "(linux (kernel /boot/vmlinuz-2.6.16.29-xen) (ramdisk /boot/i= nitrd-2.6.16.29-xen.img) (root '/dev/sda1 ro') (args 4) (vcpus 1))", 'max= mem': '1700'} [2006-11-08 16:44:56 xend.XendDomainInfo 2893] DEBUG (XendDomainInfo:747)= Storing domain details: {'console/ring-ref': '1760378', 'console/port': = '2', 'name': 'dom_91723', 'console/limit': '1048576', 'vm': '/vm/00000000= -0000-0000-0000-0000ec291723', 'domid': '3', 'cpu/0/availability': 'onlin= e', 'memory/target': '1740800', 'store/ring-ref': '1760379', 'store/port'= : '1'} [2006-11-08 16:44:56 xend.XendDomainInfo 2893] DEBUG (XendDomainInfo:933)= XendDomainInfo.handleShutdownWatch [2006-11-08 16:44:56 xend 2893] DEBUG (DevController:143) Waiting for dev= ices vif. [2006-11-08 16:44:56 xend 2893] DEBUG (DevController:149) Waiting for 0. [2006-11-08 16:44:56 xend 2893] DEBUG (DevController:464) hotplugStatusCa= llback /local/domain/0/backend/vif/3/0/hotplug-status. [2006-11-08 16:46:36 xend.XendDomainInfo 2893] DEBUG (XendDomainInfo:1449= ) XendDomainInfo.destroy: domid=3D3 [2006-11-08 16:46:36 xend.XendDomainInfo 2893] DEBUG (XendDomainInfo:1457= ) XendDomainInfo.destroyDomain(3) --------------090503040907010001070001 Content-Type: text/x-log; name="xen-hotplug.log" Content-Transfer-Encoding: 7bit Content-Disposition: inline; filename="xen-hotplug.log" usage: ifdown RTNETLINK answers: File exists RTNETLINK answers: File exists RTNETLINK answers: File exists usage: ifdown usage: ifdown usage: ifdown usage: ifdown RTNETLINK answers: File exists usage: ifdown --------------090503040907010001070001 Content-Type: text/plain; charset="us-ascii" MIME-Version: 1.0 Content-Transfer-Encoding: 7bit Content-Disposition: inline _______________________________________________ Xen-devel mailing list Xen-devel@lists.xensource.com http://lists.xensource.com/xen-devel --------------090503040907010001070001--