Re: device model: spawn failed (rc=-3)

[Ronny Wagner <starchip2000@xxxxxx>]

Okay, i found the problem (look in the right logfile) :-(

My problem is libpulse0. it not on my system, i don't know why.

i install, and the system is online again.

Thank you @all and sorry.

Am 12.01.2022 um 15:32 schrieb Ronny Wagner:
> Hello,
>
> i restart my windows domU today.
>
> And now, the domU don't start. Have anyone a idea, why? I am not change
> any config on the Host.
>
> Thank you for helping!
>
> Fail-Message:
> root@server ~ # xl create -f /etc/xen/domU.cfg
> Parsing config from /etc/xen/domU.cfg
> libxl: error: libxl_dm.c:3131:device_model_spawn_outcome: Domain
> 24:domain 24 device model: spawn failed (rc=-3)
> libxl: error: libxl_dm.c:3351:device_model_postconfig_done: Domain
> 24:Post DM startup configs failed, rc=-3
> libxl: error: libxl_create.c:1867:domcreate_devmodel_started: Domain
> 24:device model did not start: -3
> libxl: error: libxl_aoutils.c:646:libxl__kill_xs_path: Device Model
> already exited
> libxl: error: libxl_domain.c:1183:libxl__destroy_domid: Domain
> 24:Non-existant domain
> libxl: error: libxl_domain.c:1137:domain_destroy_callback: Domain
> 24:Unable to destroy guest
> libxl: error: libxl_domain.c:1064:domain_destroy_cb: Domain
> 24:Destruction of domain failed
>
> xl info:
> host                   : server
> release                : 5.10.0-10-amd64
> version                : #1 SMP Debian 5.10.84-1 (2021-12-08)
> machine                : x86_64
> nr_cpus                : 12
> max_cpu_id             : 11
> nr_nodes               : 1
> cores_per_socket       : 6
> threads_per_core       : 2
> cpu_mhz                : 3500.033
> hw_caps                :
> bfebfbff:77bee3ff:2c100800:00000001:00000001:00000281:00000000:00000100
> virt_caps              : pv hvm hvm_directio pv_directio hap shadow
> iommu_hap_pt_share gnttab-v1 gnttab-v2
> total_memory           : 65501
> free_memory            : 25760
> sharing_freed_memory   : 0
> sharing_used_memory    : 0
> outstanding_claims     : 0
> free_cpus              : 0
> xen_major              : 4
> xen_minor              : 16
> xen_extra              : .0
> xen_version            : 4.16.0
> xen_caps               : xen-3.0-x86_64 hvm-3.0-x86_32 hvm-3.0-x86_32p
> hvm-3.0-x86_64
> xen_scheduler          : credit2
> xen_pagesize           : 4096
> platform_params        : virt_start=0xffff800000000000
> xen_changeset          :
> xen_commandline        : placeholder dom0_mem=1024M,max:2048M
> dom0_max_vcpus=8 dom0_vcpus_pin
> cc_compiler            : gcc (Debian 10.2.1-6) 10.2.1 20210110
> cc_compile_by          : root
> cc_compile_domain      :
> cc_compile_date        : Sat Dec 25 21:39:55 CET 2021
> build_id               : 7d1546babc012bbc675a954b2be5ff1f9474863e
> xend_config_format     : 4
>
> Detail message:
> Parsing config from /etc/xen/domU.cfg
> libxl: debug: libxl_create.c:2052:do_domain_create: ao 0x55dd8566e6f0:
> create: how=(nil) callback=(nil) poller=0x55dd8566e790
> libxl: detail: libxl_create.c:653:libxl__domain_make: passthrough: disabled
> libxl: debug: libxl_device.c:379:libxl__device_disk_set_backend: Disk
> vdev=hda spec.backend=unknown
> libxl: debug: libxl_device.c:413:libxl__device_disk_set_backend: Disk
> vdev=hda, using backend phy
> libxl: debug: libxl_device.c:379:libxl__device_disk_set_backend: Disk
> vdev=hdb spec.backend=unknown
> libxl: debug: libxl_device.c:413:libxl__device_disk_set_backend: Disk
> vdev=hdb, using backend phy
> libxl: debug: libxl_create.c:1313:initiate_domain_create: Domain
> 25:running bootloader
> libxl: debug: libxl_bootloader.c:328:libxl__bootloader_run: Domain
> 25:not a PV/PVH domain, skipping bootloader
> libxl: debug: libxl_event.c:864:libxl__ev_xswatch_deregister: watch
> w=0x55dd856687d0: deregister unregistered
> libxl: detail: libxl_x86.c:342:hvm_set_viridian_features: base group enabled
> libxl: detail: libxl_x86.c:342:hvm_set_viridian_features: freq group enabled
> libxl: detail: libxl_x86.c:342:hvm_set_viridian_features: time_ref_count
> group enabled
> libxl: detail: libxl_x86.c:342:hvm_set_viridian_features: apic_assist
> group enabled
> libxl: detail: libxl_x86.c:342:hvm_set_viridian_features: crash_ctl
> group enabled
> libxl: detail: libxl_x86.c:342:hvm_set_viridian_features: no_vp_limit
> group enabled
> libxl: detail: libxl_x86.c:342:hvm_set_viridian_features: cpu_hotplug
> group enabled
> domainbuilder: detail: xc_dom_allocate: cmdline="", features=""
> domainbuilder: detail: xc_dom_kernel_file:
> filename="/usr/local/lib/xen/boot/hvmloader"
> domainbuilder: detail: xc_dom_malloc_filemap    : 178 kB
> libxl: debug: libxl_dom.c:822:libxl__load_hvm_firmware_module: Loading
> BIOS: /usr/local/lib/xen/boot/seabios.bin
> domainbuilder: detail: xc_dom_boot_xen_init: ver 4.16, caps
> xen-3.0-x86_64 hvm-3.0-x86_32 hvm-3.0-x86_32p hvm-3.0-x86_64
> domainbuilder: detail: xc_dom_parse_image: called
> domainbuilder: detail: xc_dom_find_loader: trying multiboot-binary
> loader ...
> domainbuilder: detail: loader probe failed
> domainbuilder: detail: xc_dom_find_loader: trying HVM-generic loader ...
> domainbuilder: detail: loader probe OK
> xc: detail: ELF: phdr: paddr=0x100000 memsz=0x34a20
> xc: detail: ELF: memory: 0x100000 -> 0x134a20
> domainbuilder: detail: xc_dom_compat_check: supported guest type:
> xen-3.0-x86_64
> domainbuilder: detail: xc_dom_compat_check: supported guest type:
> hvm-3.0-x86_32 <= matches
> domainbuilder: detail: xc_dom_compat_check: supported guest type:
> hvm-3.0-x86_32p
> domainbuilder: detail: xc_dom_compat_check: supported guest type:
> hvm-3.0-x86_64
> domainbuilder: detail: xc_dom_mem_init: mem 24560 MB, pages 0x5ff000
> pages, 4k each
> domainbuilder: detail: xc_dom_mem_init: 0x5ff000 pages
> domainbuilder: detail: xc_dom_boot_mem_init: called
> domainbuilder: detail: range: start=0x0 end=0xf0000000
> domainbuilder: detail: range: start=0x100000000 end=0x60f000000
> xc: detail: PHYSICAL MEMORY ALLOCATION:
> xc: detail:   4KB PAGES: 0x0000000000000200
> xc: detail:   2MB PAGES: 0x00000000000003f7
> xc: detail:   1GB PAGES: 0x0000000000000016
> domainbuilder: detail: xc_dom_build_image: called
> domainbuilder: detail: xc_dom_pfn_to_ptr_retcount: domU mapping: pfn
> 0x100+0x35 at 0x7fbb592a5000
> domainbuilder: detail: xc_dom_alloc_segment:   kernel       : 0x100000
> -> 0x135000  (pfn 0x100 + 0x35 pages)
> xc: detail: ELF: phdr 0 at 0x7fbb59270000 -> 0x7fbb5929afa0
> domainbuilder: detail: xc_dom_pfn_to_ptr_retcount: domU mapping: pfn
> 0x135+0x40 at 0x7fbb59265000
> domainbuilder: detail: xc_dom_alloc_segment:   System Firmware module :
> 0x135000 -> 0x175000  (pfn 0x135 + 0x40 pages)
> domainbuilder: detail: xc_dom_pfn_to_ptr_retcount: domU mapping: pfn
> 0x175+0x1 at 0x7fbb59814000
> domainbuilder: detail: xc_dom_alloc_segment:   HVM start info : 0x175000
> -> 0x176000  (pfn 0x175 + 0x1 pages)
> domainbuilder: detail: xc_dom_build_image  : virt_alloc_end : 0x176000
> domainbuilder: detail: xc_dom_build_image  : virt_pgtab_end : 0x0
> domainbuilder: detail: xc_dom_boot_image: called
> domainbuilder: detail: domain builder memory footprint
> domainbuilder: detail:    allocated
> domainbuilder: detail:       malloc             : 5928 bytes
> domainbuilder: detail:       anon mmap          : 0 bytes
> domainbuilder: detail:    mapped
> domainbuilder: detail:       file mmap          : 178 kB
> domainbuilder: detail:       domU mmap          : 472 kB
> domainbuilder: detail: vcpu_hvm: called
> domainbuilder: detail: xc_dom_set_gnttab_entry: d25 gnt[0] -> d0 0xfefff
> domainbuilder: detail: xc_dom_set_gnttab_entry: d25 gnt[1] -> d0 0xfeffc
> domainbuilder: detail: xc_dom_release: called
> libxl: debug: libxl_device.c:379:libxl__device_disk_set_backend: Disk
> vdev=hda spec.backend=phy
> libxl: debug: libxl_event.c:813:libxl__ev_xswatch_register: watch
> w=0x55dd8566fea0 wpath=/local/domain/0/backend/vbd/25/768/state
> token=3/0: register slotnum=3
> libxl: debug: libxl_device.c:379:libxl__device_disk_set_backend: Disk
> vdev=hdb spec.backend=phy
> libxl: debug: libxl_event.c:813:libxl__ev_xswatch_register: watch
> w=0x55dd8566c780 wpath=/local/domain/0/backend/vbd/25/832/state
> token=2/1: register slotnum=2
> libxl: debug: libxl_create.c:2090:do_domain_create: ao 0x55dd8566e6f0:
> inprogress: poller=0x55dd8566e790, flags=i
> libxl: debug: libxl_event.c:750:watchfd_callback: watch w=0x55dd8566fea0
> wpath=/local/domain/0/backend/vbd/25/768/state token=3/0: event
> epath=/local/domain/0/backend/vbd/25/768/state
> libxl: debug: libxl_event.c:1052:devstate_callback: backend
> /local/domain/0/backend/vbd/25/768/state wanted state 2 ok
> libxl: debug: libxl_event.c:850:libxl__ev_xswatch_deregister: watch
> w=0x55dd8566fea0 wpath=/local/domain/0/backend/vbd/25/768/state
> token=3/0: deregister slotnum=3
> libxl: debug: libxl_device.c:1096:device_backend_callback: Domain
> 25:calling device_backend_cleanup
> libxl: debug: libxl_event.c:864:libxl__ev_xswatch_deregister: watch
> w=0x55dd8566fea0: deregister unregistered
> libxl: debug: libxl_linux.c:194:libxl__hotplug_disk: Domain 25:Args and
> environment ready
> libxl: debug: libxl_device.c:1197:device_hotplug: Domain 25:calling
> hotplug script: /etc/xen/scripts/block add
> libxl: debug: libxl_device.c:1198:device_hotplug: Domain 25:extra args:
> libxl: debug: libxl_device.c:1206:device_hotplug: Domain 25:env:
> libxl: debug: libxl_device.c:1213:device_hotplug: Domain 25:    script:
> /etc/xen/scripts/block
> libxl: debug: libxl_device.c:1213:device_hotplug: Domain 25:   
> XENBUS_TYPE: vbd
> libxl: debug: libxl_device.c:1213:device_hotplug: Domain 25:   
> XENBUS_PATH: backend/vbd/25/768
> libxl: debug: libxl_device.c:1213:device_hotplug: Domain 25:   
> XENBUS_BASE_PATH: backend
> libxl: debug: libxl_aoutils.c:593:libxl__async_exec_start: forking to
> execute: /etc/xen/scripts/block add
> libxl: debug: libxl_event.c:720:watchfd_callback: watch
> epath=/local/domain/0/backend/vbd/25/768/state token=3/0: empty slot
> libxl: debug: libxl_event.c:750:watchfd_callback: watch w=0x55dd8566c780
> wpath=/local/domain/0/backend/vbd/25/832/state token=2/1: event
> epath=/local/domain/0/backend/vbd/25/832/state
> libxl: debug: libxl_event.c:1052:devstate_callback: backend
> /local/domain/0/backend/vbd/25/832/state wanted state 2 ok
> libxl: debug: libxl_event.c:850:libxl__ev_xswatch_deregister: watch
> w=0x55dd8566c780 wpath=/local/domain/0/backend/vbd/25/832/state
> token=2/1: deregister slotnum=2
> libxl: debug: libxl_device.c:1096:device_backend_callback: Domain
> 25:calling device_backend_cleanup
> libxl: debug: libxl_event.c:864:libxl__ev_xswatch_deregister: watch
> w=0x55dd8566c780: deregister unregistered
> libxl: debug: libxl_linux.c:194:libxl__hotplug_disk: Domain 25:Args and
> environment ready
> libxl: debug: libxl_device.c:1197:device_hotplug: Domain 25:calling
> hotplug script: /etc/xen/scripts/block add
> libxl: debug: libxl_device.c:1198:device_hotplug: Domain 25:extra args:
> libxl: debug: libxl_device.c:1206:device_hotplug: Domain 25:env:
> libxl: debug: libxl_device.c:1213:device_hotplug: Domain 25:    script:
> /etc/xen/scripts/block
> libxl: debug: libxl_device.c:1213:device_hotplug: Domain 25:   
> XENBUS_TYPE: vbd
> libxl: debug: libxl_device.c:1213:device_hotplug: Domain 25:   
> XENBUS_PATH: backend/vbd/25/832
> libxl: debug: libxl_device.c:1213:device_hotplug: Domain 25:   
> XENBUS_BASE_PATH: backend
> libxl: debug: libxl_aoutils.c:593:libxl__async_exec_start: forking to
> execute: /etc/xen/scripts/block add
> libxl: debug: libxl_event.c:720:watchfd_callback: watch
> epath=/local/domain/0/backend/vbd/25/832/state token=2/1: empty slot
> libxl: debug: libxl_event.c:864:libxl__ev_xswatch_deregister: watch
> w=0x55dd8566ffa0: deregister unregistered
> libxl: debug: libxl_linux.c:211:libxl__get_hotplug_script_info: Domain
> 25:num_exec 1, not running hotplug scripts
> libxl: debug: libxl_device.c:1182:device_hotplug: Domain 25:No hotplug
> script to execute
> libxl: debug: libxl_event.c:864:libxl__ev_xswatch_deregister: watch
> w=0x55dd8566ffa0: deregister unregistered
> libxl: debug: libxl_event.c:864:libxl__ev_xswatch_deregister: watch
> w=0x55dd8566c880: deregister unregistered
> libxl: debug: libxl_linux.c:211:libxl__get_hotplug_script_info: Domain
> 25:num_exec 1, not running hotplug scripts
> libxl: debug: libxl_device.c:1182:device_hotplug: Domain 25:No hotplug
> script to execute
> libxl: debug: libxl_event.c:864:libxl__ev_xswatch_deregister: watch
> w=0x55dd8566c880: deregister unregistered
> libxl: debug: libxl_dm.c:179:libxl__domain_get_device_model_uid: Domain
> 25:dm_restrict disabled, starting QEMU as root
> libxl: debug: libxl_disk.c:1158:libxl__device_disk_find_local_path:
> Directly accessing local RAW disk /dev/vg0/Legolas-disk
> libxl: debug: libxl_disk.c:1158:libxl__device_disk_find_local_path:
> Directly accessing local RAW disk /dev/vg0/Legolas-disk-exchange-backup
> libxl: debug: libxl_dm.c:2975:libxl__spawn_local_dm: Domain 25:Spawning
> device-model /usr/local/lib/xen/bin/qemu-system-i386 with arguments:
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25: 
> /usr/local/lib/xen/bin/qemu-system-i386
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25:  -xen-domid
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25:  25
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25: 
> -no-shutdown
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25:  -chardev
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25: 
> socket,id=libxl-cmd,path=/var/run/xen/qmp-libxl-25,server=on,wait=off
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25:  -mon
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25: 
> chardev=libxl-cmd,mode=control
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25:  -chardev
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25: 
> socket,id=libxenstat-cmd,path=/var/run/xen/qmp-libxenstat-25,server=on,wait=off
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25:  -mon
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25: 
> chardev=libxenstat-cmd,mode=control
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25:  -nodefaults
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25: 
> -no-user-config
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25:  -name
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25:  domU
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25:  -vnc
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25: 
> 127.0.0.1:20,password=on,to=99
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25:  -display
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25:  none
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25:  -k
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25:  de
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25:  -serial
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25:  pty
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25:  -device
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25: 
> VGA,vgamem_mb=16
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25:  -boot
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25:  order=c
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25:  -usb
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25:  -smp
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25:  6,maxcpus=6
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25:  -device
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25: 
> rtl8139,id=nic0,netdev=net0,mac=X:Y:Z
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25:  -netdev
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25: 
> type=tap,id=net0,ifname=vif25.0-emu,br=xenbr0,script=no,downscript=no
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25:  -machine
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25: 
> xenfv,suppress-vmdesc=on
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25:  -m
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25:  24560
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25:  -drive
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25: 
> file=/dev/vg0/Legolas-disk,if=ide,index=0,media=disk,format=raw,cache=writeback
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25:  -drive
> libxl: debug: libxl_dm.c:2977:libxl__spawn_local_dm: Domain 25: 
> file=/dev/vg0/Legolas-disk-exchange-backup,if=ide,index=1,media=disk,format=raw,cache=writeback
> libxl: debug: libxl_dm.c:2979:libxl__spawn_local_dm: Domain 25:Spawning
> device-model /usr/local/lib/xen/bin/qemu-system-i386 with additional
> environment:
> libxl: debug: libxl_dm.c:2981:libxl__spawn_local_dm: Domain 25: 
> XEN_QEMU_CONSOLE_LIMIT=1048576
> libxl: debug: libxl_dm.c:2981:libxl__spawn_local_dm: Domain 25: 
> XEN_DOMAIN_ID=25
> libxl: debug: libxl_event.c:813:libxl__ev_xswatch_register: watch
> w=0x55dd85668ac8 wpath=/local/domain/0/device-model/25/state token=2/2:
> register slotnum=2
> libxl: debug: libxl_event.c:750:watchfd_callback: watch w=0x55dd85668ac8
> wpath=/local/domain/0/device-model/25/state token=2/2: event
> epath=/local/domain/0/device-model/25/state
> libxl: debug: libxl_exec.c:407:spawn_watch_event: domain 25 device
> model: spawn watch p=(null)
> libxl: debug: libxl_event.c:850:libxl__ev_xswatch_deregister: watch
> w=0x55dd85668ac8 wpath=/local/domain/0/device-model/25/state token=2/2:
> deregister slotnum=2
> libxl: error: libxl_dm.c:3131:device_model_spawn_outcome: Domain
> 25:domain 25 device model: spawn failed (rc=-3)
> libxl: error: libxl_dm.c:3351:device_model_postconfig_done: Domain
> 25:Post DM startup configs failed, rc=-3
> libxl: debug: libxl_qmp.c:1921:libxl__ev_qmp_dispose:  ev 0x55dd85668ae0
> libxl: error: libxl_create.c:1867:domcreate_devmodel_started: Domain
> 25:device model did not start: -3
> libxl: debug: libxl_event.c:864:libxl__ev_xswatch_deregister: watch
> w=0x55dd8566a198: deregister unregistered
> libxl: debug: libxl_dm.c:3565:libxl__destroy_device_model: Domain
> 25:Didn't find dm UID; destroying by pid
> libxl: error: libxl_aoutils.c:646:libxl__kill_xs_path: Device Model
> already exited
>
>