[Xen-users] xl create unable to connect to console, 4.4.1-rc1 build from source

["David A. Van Arnem" <dvanarnem@xxxxxxxxx>]

Hello,

I am trying to create a PV guest (Ubuntu 14.04) on a host with Xen v4.4.1-rc1, built from source (checked out stable-4.4 branch) on a machine running Fedora 20.  Xl is unable to connect to the console of the guest, giving the error : libxl: error: libxl_exec.c:118:libxl_report_child_exitstatus: console child [0] exited with error status 1.  I have verified that xenconsoled is running.  I followed the instructions here to create my config file: https://help.ubuntu.com/community/Xen

I was able to do this and connect to the console when I installed Xen via the Fedora repositories (v4.3.2).  Based on my searches, aside from verifying that xenconsoled is running (as well as xencommons and xendomains, though xendomains shows "active (exited)" as it's status), I am unsure how to debug this problem.  Is there anything else I should be aware of when installing from source that might be causing this problem, or any suggestions on how to debug it?

Here's the command and output I used to create the PV guest, with the error underlined.  It is curious to me that the elf parser is seeing linux 2.6 and xen-3.0 when I would assume Ubuntu 14.04 contains newer versions of both...
# xl -vvv create /etc/xen/xen-domU-0.cfg -c

Parsing config from /etc/xen/xen-domU-0.cfg
libxl: debug: libxl_create.c:1342:do_domain_create: ao 0x256e490: create: how=(nil) callback=(nil) poller=0x256e190
libxl: debug: libxl_device.c:251:libxl__device_disk_set_backend: Disk vdev=xvda spec.backend=unknown
libxl: debug: libxl_device.c:286:libxl__device_disk_set_backend: Disk vdev=xvda, using backend phy
libxl: debug: libxl_create.c:797:initiate_domain_create: running bootloader
libxl: debug: libxl_bootloader.c:327:libxl__bootloader_run: no bootloader configured, using user supplied kernel
libxl: debug: libxl_event.c:618:libxl__ev_xswatch_deregister: watch w=0x256ade8: 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=10, free_memkb=2289
libxl: detail: libxl_dom.c:195:numa_place_domain: NUMA placement candidate with 1 nodes, 8 cpus and 2289 KB free selected
domainbuilder: detail: xc_dom_allocate: cmdline="debian-installer/exit/always_halt=true -- console=hvc0", features="(null)"
libxl: debug: libxl_dom.c:357:libxl__build_pv: pv kernel mapped 0 path /var/lib/xen/images/ubuntu-netboot/vmlinuz
domainbuilder: detail: xc_dom_kernel_file: filename="/var/lib/xen/images/ubuntu-netboot/vmlinuz"
domainbuilder: detail: xc_dom_malloc_filemap    : 5643 kB
domainbuilder: detail: xc_dom_ramdisk_file: filename="/var/lib/xen/images/ubuntu-netboot/initrd.gz"
domainbuilder: detail: xc_dom_malloc_filemap    : 20758 kB
domainbuilder: detail: xc_dom_boot_xen_init: ver 4.4, caps xen-3.0-x86_64 xen-3.0-x86_32p 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 Linux bzImage loader ...
domainbuilder: detail: xc_dom_malloc            : 18898 kB
domainbuilder: detail: xc_dom_do_gunzip: unzip ok, 0x5761bf -> 0x12749b8
domainbuilder: detail: loader probe OK
xc: detail: elf_parse_binary: phdr: paddr=0x1000000 memsz=0xb4f000
xc: detail: elf_parse_binary: phdr: paddr=0x1c00000 memsz=0x11d0f0
xc: detail: elf_parse_binary: phdr: paddr=0x1d1e000 memsz=0x15140
xc: detail: elf_parse_binary: phdr: paddr=0x1d34000 memsz=0x6cb000
xc: detail: elf_parse_binary: memory: 0x1000000 -> 0x23ff000
xc: detail: elf_xen_parse_note: GUEST_OS = "linux"
xc: detail: elf_xen_parse_note: GUEST_VERSION = "2.6"
xc: detail: elf_xen_parse_note: XEN_VERSION = "xen-3.0"
xc: detail: elf_xen_parse_note: VIRT_BASE = 0xffffffff80000000
xc: detail: elf_xen_parse_note: ENTRY = 0xffffffff81d341f0
xc: detail: elf_xen_parse_note: HYPERCALL_PAGE = 0xffffffff81001000
xc: detail: elf_xen_parse_note: FEATURES = "!writable_page_tables|pae_pgdir_above_4gb"
xc: detail: elf_xen_parse_note: PAE_MODE = "yes"
xc: detail: elf_xen_parse_note: LOADER = "generic"
xc: detail: elf_xen_parse_note: unknown xen elf note (0xd)
xc: detail: elf_xen_parse_note: SUSPEND_CANCEL = 0x1
xc: detail: elf_xen_parse_note: HV_START_LOW = 0xffff800000000000
xc: detail: elf_xen_parse_note: PADDR_OFFSET = 0x0
xc: detail: elf_xen_addr_calc_check: addresses:
xc: detail:     virt_base        = 0xffffffff80000000
xc: detail:     elf_paddr_offset = 0x0
xc: detail:     virt_offset      = 0xffffffff80000000
xc: detail:     virt_kstart      = 0xffffffff81000000
xc: detail:     virt_kend        = 0xffffffff823ff000
xc: detail:     virt_entry       = 0xffffffff81d341f0
xc: detail:     p2m_base         = 0xffffffffffffffff
domainbuilder: detail: xc_dom_parse_elf_kernel: xen-3.0-x86_64: 0xffffffff81000000 -> 0xffffffff823ff000
domainbuilder: detail: xc_dom_mem_init: mem 2048 MB, pages 0x80000 pages, 4k each
domainbuilder: detail: xc_dom_mem_init: 0x80000 pages
domainbuilder: detail: xc_dom_boot_mem_init: called
domainbuilder: detail: x86_compat: guest xen-3.0-x86_64, address size 64
domainbuilder: detail: xc_dom_malloc            : 4096 kB
domainbuilder: detail: xc_dom_build_image: called
domainbuilder: detail: xc_dom_alloc_segment:   kernel       : 0xffffffff81000000 -> 0xffffffff823ff000  (pfn 0x1000 + 0x13ff pages)
domainbuilder: detail: xc_dom_malloc            : 119 kB
domainbuilder: detail: xc_dom_pfn_to_ptr_retcount: domU mapping: pfn 0x1000+0x13ff at 0x7f037e4d8000
xc: detail: elf_load_binary: phdr 0 at 0x7f037e4d8000 -> 0x7f037f027000
xc: detail: elf_load_binary: phdr 1 at 0x7f037f0d8000 -> 0x7f037f1f50f0
xc: detail: elf_load_binary: phdr 2 at 0x7f037f1f6000 -> 0x7f037f20b140
xc: detail: elf_load_binary: phdr 3 at 0x7f037f20c000 -> 0x7f037f34c000
domainbuilder: detail: xc_dom_alloc_segment:   ramdisk      : 0xffffffff823ff000 -> 0xffffffff857ac000  (pfn 0x23ff + 0x33ad pages)
domainbuilder: detail: xc_dom_malloc            : 310 kB
domainbuilder: detail: xc_dom_pfn_to_ptr_retcount: domU mapping: pfn 0x23ff+0x33ad at 0x7f037b0d8000
domainbuilder: detail: xc_dom_do_gunzip: unzip ok, 0x1445a43 -> 0x33ac010
domainbuilder: detail: xc_dom_alloc_segment:   phys2mach    : 0xffffffff857ac000 -> 0xffffffff85bac000  (pfn 0x57ac + 0x400 pages)
domainbuilder: detail: xc_dom_pfn_to_ptr_retcount: domU mapping: pfn 0x57ac+0x400 at 0x7f037acd8000
domainbuilder: detail: xc_dom_alloc_page   :   start info   : 0xffffffff85bac000 (pfn 0x5bac)
domainbuilder: detail: xc_dom_alloc_page   :   xenstore     : 0xffffffff85bad000 (pfn 0x5bad)
domainbuilder: detail: xc_dom_alloc_page   :   console      : 0xffffffff85bae000 (pfn 0x5bae)
domainbuilder: detail: nr_page_tables: 0x0000ffffffffffff/48: 0xffff000000000000 -> 0xffffffffffffffff, 1 table(s)
domainbuilder: detail: nr_page_tables: 0x0000007fffffffff/39: 0xffffff8000000000 -> 0xffffffffffffffff, 1 table(s)
domainbuilder: detail: nr_page_tables: 0x000000003fffffff/30: 0xffffffff80000000 -> 0xffffffffbfffffff, 1 table(s)
domainbuilder: detail: nr_page_tables: 0x00000000001fffff/21: 0xffffffff80000000 -> 0xffffffff85ffffff, 48 table(s)
domainbuilder: detail: xc_dom_alloc_segment:   page tables  : 0xffffffff85baf000 -> 0xffffffff85be2000  (pfn 0x5baf + 0x33 pages)
domainbuilder: detail: xc_dom_pfn_to_ptr_retcount: domU mapping: pfn 0x5baf+0x33 at 0x7f037aca0000
domainbuilder: detail: xc_dom_alloc_page   :   boot stack   : 0xffffffff85be2000 (pfn 0x5be2)
domainbuilder: detail: xc_dom_build_image  : virt_alloc_end : 0xffffffff85be3000
domainbuilder: detail: xc_dom_build_image  : virt_pgtab_end : 0xffffffff86000000
domainbuilder: detail: xc_dom_boot_image: called
domainbuilder: detail: arch_setup_bootearly: doing nothing
domainbuilder: detail: xc_dom_compat_check: supported guest type: xen-3.0-x86_64 <= matches
domainbuilder: detail: xc_dom_compat_check: supported guest type: xen-3.0-x86_32p
domainbuilder: detail: xc_dom_compat_check: supported guest type: hvm-3.0-x86_32
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_update_guest_p2m: dst 64bit, pages 0x80000
domainbuilder: detail: clear_page: pfn 0x5bae, mfn 0x177abb
domainbuilder: detail: clear_page: pfn 0x5bad, mfn 0x177abc
domainbuilder: detail: xc_dom_pfn_to_ptr_retcount: domU mapping: pfn 0x5bac+0x1 at 0x7f0382b98000
domainbuilder: detail: start_info_x86_64: called
domainbuilder: detail: setup_hypercall_page: vaddr=0xffffffff81001000 pfn=0x1001
domainbuilder: detail: domain builder memory footprint
domainbuilder: detail:    allocated
domainbuilder: detail:       malloc             : 23452 kB
domainbuilder: detail:       anon mmap          : 0 bytes
domainbuilder: detail:    mapped
domainbuilder: detail:       file mmap          : 26402 kB
domainbuilder: detail:       domU mmap          : 75 MB
domainbuilder: detail: arch_setup_bootlate: shared_info: pfn 0x0, mfn 0xba692
domainbuilder: detail: shared_info_x86_64: called
domainbuilder: detail: vcpu_x86_64: called
domainbuilder: detail: vcpu_x86_64: cr3: pfn 0x5baf mfn 0x177aba
domainbuilder: detail: launch_vm: called, ctxt=0x7f0382ba1004
domainbuilder: detail: xc_dom_release: called
libxl: debug: libxl_device.c:251:libxl__device_disk_set_backend: Disk vdev=xvda spec.backend=phy
libxl: debug: libxl_event.c:570:libxl__ev_xswatch_register: watch w=0x256ba98 wpath=/local/domain/0/backend/vbd/3/51712/state token=3/0: register slotnum=3
libxl: debug: libxl_create.c:1356:do_domain_create: ao 0x256e490: inprogress: poller=0x256e190, flags=i
libxl: debug: libxl_event.c:514:watchfd_callback: watch w=0x256ba98 wpath=/local/domain/0/backend/vbd/3/51712/state token=3/0: event epath=/local/domain/0/backend/vbd/3/51712/state
libxl: debug: libxl_event.c:657:devstate_watch_callback: backend /local/domain/0/backend/vbd/3/51712/state wanted state 2 still waiting state 1
libxl: debug: libxl_event.c:514:watchfd_callback: watch w=0x256ba98 wpath=/local/domain/0/backend/vbd/3/51712/state token=3/0: event epath=/local/domain/0/backend/vbd/3/51712/state
libxl: debug: libxl_event.c:653:devstate_watch_callback: backend /local/domain/0/backend/vbd/3/51712/state wanted state 2 ok
libxl: debug: libxl_event.c:606:libxl__ev_xswatch_deregister: watch w=0x256ba98 wpath=/local/domain/0/backend/vbd/3/51712/state token=3/0: deregister slotnum=3
libxl: debug: libxl_event.c:618:libxl__ev_xswatch_deregister: watch w=0x256ba98: deregister unregistered
libxl: debug: libxl_device.c:1022:device_hotplug: calling hotplug script: /etc/xen/scripts/block add
libxl: debug: libxl_event.c:618:libxl__ev_xswatch_deregister: watch w=0x256bb20: deregister unregistered
libxl: debug: libxl_event.c:618:libxl__ev_xswatch_deregister: watch w=0x256bb20: deregister unregistered
libxl: debug: libxl_event.c:570:libxl__ev_xswatch_register: watch w=0x256e918 wpath=/local/domain/0/backend/vif/3/0/state token=3/1: register slotnum=3
libxl: debug: libxl_event.c:514:watchfd_callback: watch w=0x256e918 wpath=/local/domain/0/backend/vif/3/0/state token=3/1: event epath=/local/domain/0/backend/vif/3/0/state
libxl: debug: libxl_event.c:657:devstate_watch_callback: backend /local/domain/0/backend/vif/3/0/state wanted state 2 still waiting state 1
libxl: debug: libxl_event.c:514:watchfd_callback: watch w=0x256e918 wpath=/local/domain/0/backend/vif/3/0/state token=3/1: event epath=/local/domain/0/backend/vif/3/0/state
libxl: debug: libxl_event.c:653:devstate_watch_callback: backend /local/domain/0/backend/vif/3/0/state wanted state 2 ok
libxl: debug: libxl_event.c:606:libxl__ev_xswatch_deregister: watch w=0x256e918 wpath=/local/domain/0/backend/vif/3/0/state token=3/1: deregister slotnum=3
libxl: debug: libxl_event.c:618:libxl__ev_xswatch_deregister: watch w=0x256e918: deregister unregistered
libxl: debug: libxl_device.c:1022:device_hotplug: calling hotplug script: /etc/xen/scripts/vif-bridge online
libxl: debug: libxl_event.c:618:libxl__ev_xswatch_deregister: watch w=0x256e9a0: deregister unregistered
libxl: debug: libxl_event.c:618:libxl__ev_xswatch_deregister: watch w=0x256e9a0: deregister unregistered
libxl: debug: libxl_event.c:1771:libxl__ao_progress_report: ao 0x256e490: progress report: callback queued aop=0x256ff30
libxl: debug: libxl_event.c:1591:libxl__ao_complete: ao 0x256e490: complete, rc=0
libxl: debug: libxl_event.c:1155:egc_run_callbacks: ao 0x256e490: progress report: callback aop=0x256ff30
libxl: debug: libxl_event.c:1563:libxl__ao__destroy: ao 0x256e490: destroy
Unable to attach console
libxl: error: libxl_exec.c:118:libxl_report_child_exitstatus: console child [0] exited with error status 1
xc: debug: hypercall buffer: total allocations:579 total releases:579
xc: debug: hypercall buffer: current allocations:0 maximum allocations:4
xc: debug: hypercall buffer: cache current size:4
xc: debug: hypercall buffer: cache hits:568 misses:4 toobig:7


Thank you,

David

_______________________________________________
Xen-users mailing list
Xen-users@xxxxxxxxxxxxx
http://lists.xen.org/xen-users