On Wed, Nov 12, 2014 at 4:28 PM, Jim Fehlig <jfeh...@suse.com> wrote:
>
> This says the device model (which appears to be qemu-dm in your case)
> failed to run.  /var/log/xen/qemu-dm-<vm_name>.log should have some info
> telling why qemu failed.
>

It says:

domid: 2
Boot device 'c' was given twice

Looking at the XML, I see there are two "boot" elements. So I've tried
to comment one of them:
  <os>
    <type arch='x86_64' machine='xenfv'>hvm</type>
    <loader>/usr/lib/xen/boot/hvmloader</loader>
    <boot dev='hd'/>
<!--
    <boot dev='hd'/>
-->
  </os>
Interestingly, these two elements were generated by libvirt with
"virsh -c xen:/// domxml-from-native xen-xm testvm.cfg"

Then, I've tried to start the VM with "virsh create", but still problems.
Appartently, it seemed to work since I see it as "running" with "virsh list".
However, (1) I'm unable to connect with vncviewer, and (2) after a
while the VM stops.

Here below is the content of the logs:

/var/log/libvirt/libxl/testvm.log:

libxl: verbose:
libxl_create.c:130:libxl__domain_build_info_setdefault: qemu-xen is
unavailable, use qemu-xen-traditional instead: No such file or
directory
libxl: debug: libxl_create.c:1243:do_domain_create: ao 0x7fb678002900:
create: how=(nil) callback=(nil) poller=0x7fb6780011b0
libxl: debug: libxl_device.c:257:libxl__device_disk_set_backend: Disk
vdev=hda spec.backend=qdisk
libxl: debug: libxl_device.c:257:libxl__device_disk_set_backend: Disk
vdev=hdc spec.backend=qdisk
libxl: debug: libxl_create.c:699:initiate_domain_create: running bootloader
libxl: debug: libxl_bootloader.c:321:libxl__bootloader_run: not a PV
domain, skipping bootloader
libxl: debug: libxl_event.c:608:libxl__ev_xswatch_deregister: watch
w=0x7fb678002c88: deregister unregistered
libxl: debug: libxl_numa.c:478:libxl__get_numa_candidate: New best
NUMA placement candidate found: nr_nodes=1, nr_cpus=8, nr_vcpus=17,
free_memkb=2698
libxl: detail: libxl_dom.c:195:numa_place_domain: NUMA placement
candidate with 1 nodes, 8 cpus and 2698 KB free selected
xc: detail: elf_parse_binary: phdr: paddr=0x100000 memsz=0xa2304
xc: detail: elf_parse_binary: memory: 0x100000 -> 0x1a2304
xc: info: VIRTUAL MEMORY ARRANGEMENT:
  Loader:        0000000000100000->00000000001a2304
  Modules:       0000000000000000->0000000000000000
  TOTAL:         0000000000000000->00000000bf800000
  ENTRY ADDRESS: 0000000000100000
xc: info: PHYSICAL MEMORY ALLOCATION:
  4KB PAGES: 0x0000000000000200
  2MB PAGES: 0x00000000000003fb
  1GB PAGES: 0x0000000000000001
xc: detail: elf_load_binary: phdr 0 at 0x7fb6a7af8000 -> 0x7fb6a7b9118d
libxl: debug: libxl_device.c:257:libxl__device_disk_set_backend: Disk
vdev=hda spec.backend=qdisk
libxl: debug: libxl_device.c:257:libxl__device_disk_set_backend: Disk
vdev=hdc spec.backend=qdisk
libxl: debug: libxl_dm.c:1211:libxl__spawn_local_dm: Spawning
device-model /usr/lib/xen/bin/qemu-dm with arguments:
libxl: debug: libxl_dm.c:1213:libxl__spawn_local_dm:   /usr/lib/xen/bin/qemu-dm
libxl: debug: libxl_dm.c:1213:libxl__spawn_local_dm:   -d
libxl: debug: libxl_dm.c:1213:libxl__spawn_local_dm:   9
libxl: debug: libxl_dm.c:1213:libxl__spawn_local_dm:   -domain-name
libxl: debug: libxl_dm.c:1213:libxl__spawn_local_dm:   testvm
libxl: debug: libxl_dm.c:1213:libxl__spawn_local_dm:   -vnc
libxl: debug: libxl_dm.c:1213:libxl__spawn_local_dm:   127.0.0.1:1
libxl: debug: libxl_dm.c:1213:libxl__spawn_local_dm:   -videoram
libxl: debug: libxl_dm.c:1213:libxl__spawn_local_dm:   8
libxl: debug: libxl_dm.c:1213:libxl__spawn_local_dm:   -boot
libxl: debug: libxl_dm.c:1213:libxl__spawn_local_dm:   c
libxl: debug: libxl_dm.c:1213:libxl__spawn_local_dm:   -vcpu_avail
libxl: debug: libxl_dm.c:1213:libxl__spawn_local_dm:   0x01
libxl: debug: libxl_dm.c:1213:libxl__spawn_local_dm:   -net
libxl: debug: libxl_dm.c:1213:libxl__spawn_local_dm:   none
libxl: debug: libxl_dm.c:1213:libxl__spawn_local_dm:   -M
libxl: debug: libxl_dm.c:1213:libxl__spawn_local_dm:   xenfv
libxl: debug: libxl_event.c:559:libxl__ev_xswatch_register: watch
w=0x7fb678002ec0 wpath=/local/domain/0/device-model/9/state token=3/0:
register slotnum=3
libxl: debug: libxl_create.c:1256:do_domain_create: ao 0x7fb678002900:
inprogress: poller=0x7fb6780011b0, flags=i
libxl: debug: libxl_event.c:503:watchfd_callback: watch
w=0x7fb678002ec0 wpath=/local/domain/0/device-model/9/state token=3/0:
event epath=/local/domain/0/device-model/9/state
libxl: debug: libxl_event.c:503:watchfd_callback: watch
w=0x7fb678002ec0 wpath=/local/domain/0/device-model/9/state token=3/0:
event epath=/local/domain/0/device-model/9/state
libxl: debug: libxl_event.c:596:libxl__ev_xswatch_deregister: watch
w=0x7fb678002ec0 wpath=/local/domain/0/device-model/9/state token=3/0:
deregister slotnum=3
libxl: debug: libxl_event.c:608:libxl__ev_xswatch_deregister: watch
w=0x7fb678002ec0: deregister unregistered
libxl: debug: libxl_event.c:559:libxl__ev_xswatch_register: watch
w=0x7fb678006b18 wpath=/local/domain/0/backend/vif/9/0/state
token=3/1: register slotnum=3
libxl: debug: libxl_event.c:503:watchfd_callback: watch
w=0x7fb678006b18 wpath=/local/domain/0/backend/vif/9/0/state
token=3/1: event epath=/local/domain/0/backend/vif/9/0/state
libxl: debug: libxl_event.c:643:devstate_watch_callback: backend
/local/domain/0/backend/vif/9/0/state wanted state 2 ok
libxl: debug: libxl_event.c:596:libxl__ev_xswatch_deregister: watch
w=0x7fb678006b18 wpath=/local/domain/0/backend/vif/9/0/state
token=3/1: deregister slotnum=3
libxl: debug: libxl_event.c:608:libxl__ev_xswatch_deregister: watch
w=0x7fb678006b18: deregister unregistered
libxl: debug: libxl_device.c:959:device_hotplug: calling hotplug
script: /etc/xen/scripts/vif-bridge online
libxl: debug: libxl_event.c:1737:libxl__ao_progress_report: ao
0x7fb678002900: progress report: ignored
libxl: debug: libxl_event.c:1569:libxl__ao_complete: ao
0x7fb678002900: complete, rc=0
libxl: debug: libxl_event.c:1541:libxl__ao__destroy: ao 0x7fb678002900: destroy
libxl: debug: libxl_event.c:559:libxl__ev_xswatch_register: watch
w=0x7fb678001cf0 wpath=@releaseDomain token=3/2: register slotnum=3
libxl: debug: libxl_event.c:503:watchfd_callback: watch
w=0x7fb678001cf0 wpath=@releaseDomain token=3/2: event
epath=@releaseDomain
libxl: debug: libxl.c:1004:domain_death_xswatch_callback:
[evg=0x7fb678001810:9] from domid=9 nentries=1 rc=1
libxl: debug: libxl.c:1015:domain_death_xswatch_callback:
[evg=0x7fb678001810:9]   got=domaininfos[0] got->domain=9
libxl: debug: libxl.c:1042:domain_death_xswatch_callback:  exists
shutdown_reported=0 dominf.flags=ffff0022
libxl: debug: libxl.c:1008:domain_death_xswatch_callback: [evg=0] all reported
libxl: debug: libxl.c:1072:domain_death_xswatch_callback: domain death
search done
libxl: debug: libxl_event.c:503:watchfd_callback: watch
w=0x7fb678001cf0 wpath=@releaseDomain token=3/2: event
epath=@releaseDomain
libxl: debug: libxl.c:1004:domain_death_xswatch_callback:
[evg=0x7fb678001810:9] from domid=9 nentries=1 rc=1
libxl: debug: libxl.c:1015:domain_death_xswatch_callback:
[evg=0x7fb678001810:9]   got=domaininfos[0] got->domain=9
libxl: debug: libxl.c:1042:domain_death_xswatch_callback:  exists
shutdown_reported=0 dominf.flags=6
libxl: debug: libxl.c:1054:domain_death_xswatch_callback:  shutdown reporting
libxl: debug: libxl.c:1008:domain_death_xswatch_callback: [evg=0] all reported
libxl: debug: libxl.c:1072:domain_death_xswatch_callback: domain death
search done
libxl: debug: libxl_event.c:1154:egc_run_callbacks: event
0x7fb6a99f1ad0 callback type=domain_shutdown
libxl: debug: libxl.c:1256:libxl_domain_destroy: ao 0x7fb6a99f1b60:
create: how=(nil) callback=(nil) poller=0x7fb6780011b0
libxl: debug: libxl_dm.c:1314:libxl__destroy_device_model: Device Model signaled
libxl: debug: libxl_event.c:559:libxl__ev_xswatch_register: watch
w=0x7fb6a99f08a8 wpath=/local/domain/0/backend/vif/9/0/state
token=2/3: register slotnum=2
libxl: debug: libxl.c:1265:libxl_domain_destroy: ao 0x7fb6a99f1b60:
inprogress: poller=0x7fb6780011b0, flags=i
libxl: debug: libxl_event.c:503:watchfd_callback: watch
w=0x7fb6a99f08a8 wpath=/local/domain/0/backend/vif/9/0/state
token=2/3: event epath=/local/domain/0/backend/vif/9/0/state
libxl: debug: libxl_event.c:643:devstate_watch_callback: backend
/local/domain/0/backend/vif/9/0/state wanted state 6 ok
libxl: debug: libxl_event.c:596:libxl__ev_xswatch_deregister: watch
w=0x7fb6a99f08a8 wpath=/local/domain/0/backend/vif/9/0/state
token=2/3: deregister slotnum=2
libxl: debug: libxl_event.c:608:libxl__ev_xswatch_deregister: watch
w=0x7fb6a99f08a8: deregister unregistered
libxl: debug: libxl_device.c:959:device_hotplug: calling hotplug
script: /etc/xen/scripts/vif-bridge offline
libxl: debug: libxl_event.c:472:watchfd_callback: watch
epath=/local/domain/0/backend/vif/9/0/state token=2/3: empty slot
libxl: debug: libxl_event.c:472:watchfd_callback: watch
epath=/local/domain/0/backend/vif/9/0/state token=2/3: empty slot
libxl: debug: libxl_event.c:1569:libxl__ao_complete: ao
0x7fb6a99f1b60: complete, rc=0
libxl: debug: libxl_event.c:1541:libxl__ao__destroy: ao 0x7fb6a99f1b60: destroy
libxl: debug: libxl_event.c:596:libxl__ev_xswatch_deregister: watch
w=0x7fb678001cf0 wpath=@releaseDomain token=3/2: deregister slotnum=3
libxl: debug: libxl_event.c:472:watchfd_callback: watch
epath=@releaseDomain token=3/2: empty slot


/var/log/xen/qemu-dm-testvm.log:

domid: 9
-videoram option does not work with cirrus vga device model. Videoram set to 4M.
Strip off blktap sub-type prefix to /root/images/testvm.img (drv 'aio')
Using file /root/images/testvm.img in read-write mode
Strip off blktap sub-type prefix to
/root/iso/CentOS-7.0-1406-x86_64-Minimal.iso (drv 'aio')
Using file /root/iso/CentOS-7.0-1406-x86_64-Minimal.iso in read-only mode
Watching /local/domain/0/device-model/9/logdirty/cmd
Watching /local/domain/0/device-model/9/command
Watching /local/domain/9/cpu
qemu_map_cache_init nr_buckets = 10000 size 4194304
shared page at pfn feffd
buffered io page at pfn feffb
Guest uuid = 93f08541-bfd5-4ac4-851d-c619a4516a13
populating video RAM at ff000000
mapping video RAM from ff000000
Register xen platform.
Done register platform.
platform_fixed_ioport: changed ro/rw state of ROM memory area. now is rw state.
xs_read(/local/domain/0/device-model/9/xen_extended_power_mgmt): read error
xs_read(): vncpasswd get error.
/vm/93f08541-bfd5-4ac4-851d-c619a4516a13/vncpasswd.
medium change watch on `hdc' (index: 1):
aio:/root/iso/CentOS-7.0-1406-x86_64-Minimal.iso
I/O request not ready: 0, ptr: 0, port: 0, data: 0, count: 0, size: 0
Log-dirty: no command yet.
vcpu-set: watch node error.
[xenstore_process_vcpu_set_event]: /local/domain/9/cpu has no CPU!
xs_read(/local/domain/9/log-throttling): read error
qemu: ignoring not-understood drive `/local/domain/9/log-throttling'
medium change watch on `/local/domain/9/log-throttling' - unknown
device, ignored
cirrus vga map change while on lfb mode
mapping vram to f0000000 - f0400000
platform_fixed_ioport: changed ro/rw state of ROM memory area. now is rw state.
platform_fixed_ioport: changed ro/rw state of ROM memory area. now is ro state.


Just FYI, I've tried to start the VM directly with "xl" and it works:
the VM runs and vncviewer happily connects.
Here's the content of /var/log/xen/qemu-dm-testvm.log:

domid: 10
-videoram option does not work with cirrus vga device model. Videoram set to 4M.
Strip off blktap sub-type prefix to /root/images/testvm.img (drv 'aio')
Using file /root/images/testvm.img in read-write mode
Strip off blktap sub-type prefix to
/root/iso/CentOS-7.0-1406-x86_64-Minimal.iso (drv 'aio')
Using file /root/iso/CentOS-7.0-1406-x86_64-Minimal.iso in read-only mode
Watching /local/domain/0/device-model/10/logdirty/cmd
Watching /local/domain/0/device-model/10/command
Watching /local/domain/10/cpu
qemu_map_cache_init nr_buckets = 10000 size 4194304
shared page at pfn feffd
buffered io page at pfn feffb
Guest uuid = 93f08541-bfd5-4ac4-851d-c619a4516a13
populating video RAM at ff000000
mapping video RAM from ff000000
Register xen platform.
Done register platform.
platform_fixed_ioport: changed ro/rw state of ROM memory area. now is rw state.
xs_read(/local/domain/0/device-model/10/xen_extended_power_mgmt): read error
xs_read(): vncpasswd get error.
/vm/93f08541-bfd5-4ac4-851d-c619a4516a13/vncpasswd.
medium change watch on `hdc' (index: 1):
aio:/root/iso/CentOS-7.0-1406-x86_64-Minimal.iso
I/O request not ready: 0, ptr: 0, port: 0, data: 0, count: 0, size: 0
Log-dirty: no command yet.
vcpu-set: watch node error.
[xenstore_process_vcpu_set_event]: /local/domain/10/cpu has no CPU!
xs_read(/local/domain/10/log-throttling): read error
qemu: ignoring not-understood drive `/local/domain/10/log-throttling'
medium change watch on `/local/domain/10/log-throttling' - unknown
device, ignored
cirrus vga map change while on lfb mode
mapping vram to f0000000 - f0400000
platform_fixed_ioport: changed ro/rw state of ROM memory area. now is rw state.
platform_fixed_ioport: changed ro/rw state of ROM memory area. now is ro state.
Unknown PV product 3 loaded in guest
PV driver build 1
region type 1 at [c100,c200).
region type 0 at [f3001000,f3001100).
squash iomem [f3001000, f3001100).
ACPI:debug: write addr=0xb044, val=0x0.
ACPI:debug: write addr=0xb045, val=0x89.
ACPI:debug: write addr=0xb044, val=0x1.
ACPI:debug: write addr=0xb045, val=0x89.
...
ACPI:debug: write addr=0xb044, val=0xff.
ACPI:debug: write addr=0xb045, val=0x89.


Cheers,

-- Marco
--
xen mailing list
xen@lists.fedoraproject.org
https://admin.fedoraproject.org/mailman/listinfo/xen

Reply via email to