Re: xen, guest won't start, "Hotplug scripts not working"

To: debian-user@lists.debian.org
Subject: Re: xen, guest won't start, "Hotplug scripts not working"
From: "G. Crimp" <gcrimp@vcn.bc.ca>
Date: Sun, 26 Apr 2009 02:58:35 -0700
Message-id: <[🔎] 20090426095835.GA5064@heretic.disorinet>
Mail-followup-to: Debian User Mailing List <debian-user@lists.debian.org>
Reply-to: Debian User Mailing List <debian-user@lists.debian.org>
In-reply-to: <[🔎] 81c921f30904260154u50659c65id014d8dc0381f0cf@mail.gmail.com>
References: <[🔎] 20090426081809.GA4596@heretic.disorinet> <[🔎] 81c921f30904260154u50659c65id014d8dc0381f0cf@mail.gmail.com>
On Sun, Apr 26, 2009 at 10:54:10AM +0200, Javier Barroso wrote:
> On Sun, Apr 26, 2009 at 10:18 AM,  <gcrimp@vcn.bc.ca> wrote:
> >
> > # mount
> > [irrelevant stuff deleted]
> > /dev/mapper/Bun_vg-mabelleSys_lv on /mnt type ext3 (rw)
> 
> Having partition mounted is not a good idea for xen machines, umount
> it ant try again. Latter you can see at /var/log/xend.log , it could
> give you any hints

The way I presented that wasn't clear.  Actually I only mounted the device
afterwards so I could show the contents of fstab on the guest.  When I tried
to start the guest, the partition wasn't mounted.

this is trying to start the guest machine dumps to /var/log/xen/xend.log

------------ begin log exterpt ----------------
[2009-04-26 02:22:25 2162] DEBUG (XendDomainInfo:84) XendDomainInfo.create(['vm', ['name', 'mabelle_vm'], ['memory', 128], ['vcpus', 1], ['on_xend_start','ignore'], ['on_xend_stop', 'ignore'], ['image', ['linux', ['kernel','/boot/vmlinuz-2.6.26-2-xen-686'], ['ramdisk', '/boot/initrd.img-2.6.26-2-xen-686'],['root', '/dev/hda1 ro'], ['args', '2']]], ['device', ['vbd', ['uname', 'phy:/dev/Bun_vg/mabelleSys_lv'], ['dev', 'hda1'], ['mode', 'w']]], ['device', ['vbd',['uname', 'phy:/dev/Bun_vg/mabelleSwap_lv'], ['dev', 'hda2'], ['mode', 'w']]]])
[2009-04-26 02:22:25 2162] DEBUG (XendDomainInfo:1618)XendDomainInfo.constructDomain
[2009-04-26 02:22:25 2162] DEBUG (balloon:132) Balloon: 132032 KiB free; need 2048; done.
[2009-04-26 02:22:25 2162] DEBUG (XendDomain:443) Adding Domain: 13
[2009-04-26 02:22:25 2162] DEBUG (XendDomainInfo:1703) XendDomainInfo.initDomain: 13 256
[2009-04-26 02:22:25 2162] DEBUG (XendDomainInfo:1738) _initDomain:shadow_memory=0x0, memory_static_max=0x8000000, memory_static_min=0x0.
[2009-04-26 02:22:25 2162] DEBUG (balloon:132) Balloon: 132032 KiB free;need 131072; done.
[2009-04-26 02:22:25 2162] INFO (image:139) buildDomain os=linux dom=13 vcpus=1
[2009-04-26 02:22:25 2162] DEBUG (image:363) domid          = 13
[2009-04-26 02:22:25 2162] DEBUG (image:364) memsize        = 128
[2009-04-26 02:22:25 2162] DEBUG (image:365) image          = /boot/vmlinuz-2.6.26-2-xen-686
[2009-04-26 02:22:25 2162] DEBUG (image:366) store_evtchn   = 1
[2009-04-26 02:22:25 2162] DEBUG (image:367) console_evtchn = 2
[2009-04-26 02:22:25 2162] DEBUG (image:368) cmdline        = root=/dev/hda1 ro 2
[2009-04-26 02:22:25 2162] DEBUG (image:369) ramdisk        = /boot/initrd.img-2.6.26-2-xen-686
[2009-04-26 02:22:25 2162] DEBUG (image:370) vcpus          = 1
[2009-04-26 02:22:25 2162] DEBUG (image:371) features       = 
[2009-04-26 02:22:26 2162] INFO (XendDomainInfo:1514) createDevice: vbd :{'uuid': '5881dca0-bef6-edc9-71a0-1a0c23a0a003', 'bootable': 1, 'driver':'paravirtualised', 'dev': 'hda1', 'uname': ' phy:/dev/Bun_vg/mabelleSys_lv', 'mode': 'w'}
[2009-04-26 02:22:26 2162] DEBUG (DevController:118) DevController: writing {'virtual-device': '769', 'device-type': 'disk', 'protocol': 'x86_32-abi', 'backend-id': '0', 'state': '1', 'backend': '/local/domain/0/backend/vbd/13/769'} to /local/domain/13/device/vbd/769.
[2009-04-26 02:22:26 2162] DEBUG (DevController:120) DevController: writing {'domain': 'mabelle_vm', 'frontend': '/local/domain/13/device/vbd/769', 'uuid': '5881dca0-bef6-edc9-71a0-1a0c23a0a003', 'dev': 'hda1', 'state': '1', 'params':'/dev/Bun_vg/mabelleSys_lv', 'mode': 'w', 'online': '1', 'frontend-id': '13','type': ' phy'} to /local/domain/0/backend/vbd/13/769.
[2009-04-26 02:22:26 2162] INFO (XendDomainInfo:1514) createDevice: vbd : {'uuid': '35406b91-040e-68f4-5112-0719676b9cb9', 'bootable': 0, 'driver': 'paravirtualised', 'dev': 'hda2', 'uname': 'phy:/dev/Bun_vg/mabelleSwap_lv', 'mode': 'w'}
[2009-04-26 02:22:26 2162] DEBUG (DevController:118) DevController: writing {'virtual-device': '770', 'device-type': 'disk', 'protocol': 'x86_32-abi','backend-id': '0', 'state': '1', 'backend': '/local/domain/0/backend/vbd/13/770'} to /local/domain/13/device/vbd/770.
[2009-04-26 02:22:26 2162] DEBUG (DevController:120) DevController: writing {'domain': 'mabelle_vm', 'frontend': '/local/domain/13/device/vbd/770', 'uuid':'35406b91-040e-68f4-5112-0719676b9cb9', 'dev': 'hda2', 'state': '1', 'params': '/dev/Bun_vg/mabelleSwap_lv', 'mode': 'w', 'online': '1', 'frontend-id': '13','type': 'phy'} to /local/domain/0/backend/vbd/13/770.
[2009-04-26 02:22:26 2162] DEBUG (XendDomainInfo:2195) Storing VM details: {'on_xend_stop': 'ignore', 'shadow_memory': '0', 'uuid':'17b7bcec-beb5-f2df-2752-ca9137654204', 'on_reboot': 'restart', 'start_time': '1240737746.81','on_poweroff': 'destroy', 'on_xend_start': 'ignore', 'on_crash': 'restart','xend/restart_count': '0', 'vcpus': '1', 'vcpu_avail': '1', 'image': "(linux (kernel/boot/vmlinuz-2.6.26-2-xen-686) (ramdisk /boot/initrd.img-2.6.26-2-xen-686) (args/'root=/dev/hda1 ro 2') (notes (HV_START_LOW 4118806528) (FEATURES/'writable_page_tables|writable_descriptor_tables|auto_translated_physmap|pae_pgdir_above_4gb|supervisor_mode_kernel') (VIRT_BASE 3221225472) (GUEST_VERSION 2.6) (PADDR_OFFSET 0) (GUEST_OS linux) (HYPERCALL_PAGE 3222278144) (LOADER generic) (SUSPEND_CANCEL 1) (PAE_MODE yes) (ENTRY 3222274048) (XEN_VERSION xen-3.0)))", 'name': 'mabelle_vm'}
[2009-04-26 02:22:27 2162] DEBUG (XendDomainInfo:1008) Storing domain details: {'console/ring-ref': '118950', 'image/entry': '3222274048', 'console/port': '2', 'store/ring-ref': '118951', 'image/loader': 'generic', 'vm':'/vm/17b7bcec-beb5-f2df-2752-ca9137654204', 'control/platform-feature-multiprocessor-suspend':'1', 'image/hv-start-low': '4118806528', 'image/guest-os': 'linux','image/features/writable-descriptor-tables': '1', 'image/virt-base': '3221225472', 'memory/target': '131072', 'image/guest-version': '2.6','image/features/supervisor-mode-kernel': '1', 'image/pae-mode': 'yes', 'console/limit': '1048576','image/paddr-offset': '0', 'image/hypercall-page': '3222278144', 'image/suspend-cancel': '1','cpu/0/availability': 'online', 'image/features/pae-pgdir-above-4gb': '1','image/features/writable-page-tables': '1', 'console/type': 'xenconsoled','image/features/auto-translated-physmap': '1', 'name': 'mabelle_vm', 'domid': '13','image/xen-version': 'xen-3.0', 'store/port': '1'}
[2009-04-26 02:22:27 2162] DEBUG (DevController:118) DevController: writing {'protocol': 'x86_32-abi', 'state': '1', 'backend-id': '0', 'backend': '/local/domain/0/backend/console/13/0'} to /local/domain/13/device/console/0.
[2009-04-26 02:22:27 2162] DEBUG (DevController:120) DevController: writing {'domain': 'mabelle_vm', 'frontend': '/local/domain/13/device/console/0','uuid': 'ed9d4ee9-d13c-bb01-2a4f-7b02ab699b1c', 'frontend-id': '13', 'state': '1','location': '2', 'online': '1', 'protocol': 'vt100'} to /local/domain/0/backend/console/13/0.
[2009-04-26 02:22:27 2162] DEBUG (XendDomainInfo:1092) XendDomainInfo.handleShutdownWatch
[2009-04-26 02:22:27 2162] DEBUG (DevController:151) Waiting for devices vif.
[2009-04-26 02:22:27 2162] DEBUG (DevController:151) Waiting for devices vbd.
[2009-04-26 02:22:27 2162] DEBUG (DevController:156) Waiting for 769.
[2009-04-26 02:22:28 2162] DEBUG (DevController:595) hotplugStatusCallback /local/domain/0/backend/vbd/13/769/hotplug-status.

This much hits the log pretty much as soon as xm is run.  Then it sits
until the command returns with the error message in my OP and the rest below 
is dumped into the log.

[2009-04-26 02:24:08 2162] DEBUG (XendDomainInfo:1897) XendDomainInfo.destroy: domid=13
[2009-04-26 02:24:08 2162] DEBUG (XendDomainInfo:1914) XendDomainInfo.destroyDomain(13)
[2009-04-26 02:24:08 2162] DEBUG (XendDomainInfo:1529) Destroying device model
[2009-04-26 02:24:08 2162] DEBUG (XendDomainInfo:1536) Releasing devices
[2009-04-26 02:24:08 2162] DEBUG (XendDomainInfo:1542) Removing vbd/769
[2009-04-26 02:24:08 2162] DEBUG (XendDomainInfo:590) XendDomainInfo.destroyDevice: deviceClass = vbd, device = vbd/769
[2009-04-26 02:24:08 2162] DEBUG (XendDomainInfo:1542) Removing vbd/770
[2009-04-26 02:24:08 2162] DEBUG (XendDomainInfo:590) XendDomainInfo.destroyDevice: deviceClass = vbd, device = vbd/770
[2009-04-26 02:24:08 2162] DEBUG (XendDomainInfo:1542) Removing console/0
[2009-04-26 02:24:08 2162] DEBUG (XendDomainInfo:590) XendDomainInfo.destroyDevice: deviceClass = console, device = console/0
[2009-04-26 02:24:09 2162] DEBUG (DevController:595) hotplugStatusCallback /local/domain/0/backend/vbd/13/769/hotplug-status.
[2009-04-26 02:24:09 2162] DEBUG (DevController:595) hotplugStatusCallback /local/domain/0/backend/vbd/13/769/hotplug-status.
[2009-04-26 02:24:09 2162] DEBUG (DevController:595) hotplugStatusCallback /local/domain/0/backend/vbd/2/769/hotplug-status.
[2009-04-26 02:24:09 2162] DEBUG (DevController:595) hotplugStatusCallback /local/domain/0/backend/vbd/3/769/hotplug-status.
[2009-04-26 02:24:09 2162] DEBUG (DevController:595) hotplugStatusCallback /local/domain/0/backend/vbd/5/769/hotplug-status.
[2009-04-26 02:24:09 2162] DEBUG (DevController:595) hotplugStatusCallback /local/domain/0/backend/vbd/6/769/hotplug-status.
[2009-04-26 02:24:09 2162] DEBUG (DevController:595) hotplugStatusCallback /local/domain/0/backend/vbd/7/769/hotplug-status.
[2009-04-26 02:24:09 2162] DEBUG (DevController:595) hotplugStatusCallback /local/domain/0/backend/vbd/8/769/hotplug-status.
[2009-04-26 02:24:09 2162] DEBUG (DevController:595) hotplugStatusCallback /local/domain/0/backend/vbd/9/769/hotplug-status.
[2009-04-26 02:24:09 2162] DEBUG (DevController:595) hotplugStatusCallback /local/domain/0/backend/vbd/10/769/hotplug-status.
[2009-04-26 02:24:09 2162] DEBUG (DevController:595) hotplugStatusCallback /local/domain/0/backend/vbd/11/769/hotplug-status.
[2009-04-26 02:24:09 2162] DEBUG (DevController:595) hotplugStatusCallback /local/domain/0/backend/vbd/12/769/hotplug-status.
[2009-04-26 02:24:09 2162] DEBUG (DevController:595) hotplugStatusCallback /local/domain/0/backend/vbd/13/769/hotplug-status.
[2009-04-26 02:24:09 2162] DEBUG (DevController:595) hotplugStatusCallback /local/domain/0/backend/vbd/2/769/hotplug-status.
[2009-04-26 02:24:09 2162] DEBUG (DevController:595) hotplugStatusCallback /local/domain/0/backend/vbd/3/769/hotplug-status.
[2009-04-26 02:24:09 2162] DEBUG (DevController:595) hotplugStatusCallback /local/domain/0/backend/vbd/5/769/hotplug-status.
[2009-04-26 02:24:09 2162] DEBUG (DevController:595) hotplugStatusCallback /local/domain/0/backend/vbd/6/769/hotplug-status.
[2009-04-26 02:24:09 2162] DEBUG (DevController:595) hotplugStatusCallback /local/domain/0/backend/vbd/7/769/hotplug-status.
[2009-04-26 02:24:09 2162] DEBUG (DevController:595) hotplugStatusCallback /local/domain/0/backend/vbd/8/769/hotplug-status.
[2009-04-26 02:24:09 2162] DEBUG (DevController:595) hotplugStatusCallback /local/domain/0/backend/vbd/9/769/hotplug-status.
[2009-04-26 02:24:09 2162] DEBUG (DevController:595) hotplugStatusCallback /local/domain/0/backend/vbd/10/769/hotplug-status.
[2009-04-26 02:24:09 2162] DEBUG (DevController:595) hotplugStatusCallback /local/domain/0/backend/vbd/11/769/hotplug-status.
[2009-04-26 02:24:09 2162] DEBUG (DevController:595) hotplugStatusCallback /local/domain/0/backend/vbd/12/769/hotplug-status.
[2009-04-26 02:24:09 2162] DEBUG (DevController:595) hotplugStatusCallback /local/domain/0/backend/vbd/13/769/hotplug-status.
-------------- end log excerpt -----------------

gc
Reply to:
References:
- xen, guest won't start, "Hotplug scripts not working"
  - From: gcrimp@vcn.bc.ca
- Re: xen, guest won't start, "Hotplug scripts not working"
  - From: Javier Barroso <javibarroso@gmail.com>
Prev by Date: Re: VNC Server?
Next by Date: Re: Hal monitor detection, was hal documentation
Previous by thread: Re: xen, guest won't start, "Hotplug scripts not working"
Next by thread: Re: xen, guest won't start, "Hotplug scripts not working"
Index(es):
- Date
- Thread