Bug 927447

Summary: [suse] virt tools hang on disk image, but libguestfs-test-tool runs OK
Product: [Community] Virtualization Tools Reporter: Richard W.M. Jones <rjones>
Component: libguestfsAssignee: Richard W.M. Jones <rjones>
Status: CLOSED INSUFFICIENT_DATA QA Contact:
Severity: unspecified Docs Contact:
Priority: unspecified    
Version: unspecifiedCC: mbooth, rbalakri
Target Milestone: ---   
Target Release: ---   
Hardware: Unspecified   
OS: Unspecified   
Whiteboard:
Fixed In Version: Doc Type: Bug Fix
Doc Text:
Story Points: ---
Clone Of: Environment:
Last Closed: 2015-09-01 13:29:11 UTC Type: Bug
Regression: --- Mount Type: ---
Documentation: --- CRM:
Verified Versions: Category: ---
oVirt Team: --- RHEL 7.3 requirements from Atomic Host:
Cloudforms Team: --- Target Upstream Version:
Embargoed:

Description Richard W.M. Jones 2013-03-25 22:47:25 UTC 
Description of problem:

(Reported by Chris Riddoch)

libguestfs-test-tool runs OK.  However for this user, there
is a specific disk image [Fedora 17, standard LVM partitioning]
which causes libguestfs launch to hang.

See the output of
virt-filesystems -v -a disk.img --all --long -h
below.

Version-Release number of selected component (if applicable):

The host in this case is SuSE 12.3 x86_64 and the package
is libguestfs 1.20.4 from:
http://download.opensuse.org/repositories/Virtualization/openSUSE_12.3/x86_64/

How reproducible:

100%

Steps to Reproduce:
1. (eg) virt-filesystems -a disk.img --all --long -h

guestmount also hung.
  
Actual results:

virt tools hang during launch (but libguestfs-test-tool is OK).

Expected results:

should not hang

Additional info:

# virt-filesystems -v -a disk.img --all --long -h
libguestfs: command: run: no
libguestfs: command: run: \ --verbose
libguestfs: command: run: \ -f checksum
libguestfs: command: run: \ /usr/lib64/guestfs/supermin.d
libguestfs: command: run: \ x86_64
no: Not a directory
libguestfs: checksum of existing appliance: 
libguestfs: warning: supermin-helper -f checksum returned a short string
libguestfs: [00001ms] begin testing qemu features
libguestfs: command: run: /usr/bin/qemu-kvm
libguestfs: command: run: \ -nographic
libguestfs: command: run: \ -help
libguestfs: command: run: /usr/bin/qemu-kvm
libguestfs: command: run: \ -nographic
libguestfs: command: run: \ -version
libguestfs: qemu version 1.3
libguestfs: command: run: /usr/bin/qemu-kvm
libguestfs: command: run: \ -nographic
libguestfs: command: run: \ -machine accel=kvm:tcg
libguestfs: command: run: \ -device ?
libguestfs: [00036ms] finished testing qemu features
libguestfs: accept_from_daemon: 0x219efa0 g->state = 1
[00037ms] /usr/bin/qemu-kvm \
    -global virtio-blk-pci.scsi=off \
    -nodefconfig \
    -nodefaults \
    -nographic \
    -device virtio-scsi-pci,id=scsi \
    -drive file=disk.img,snapshot=on,id=hd0,if=none \
    -device scsi-hd,drive=hd0 \
    -machine accel=kvm:tcg \
    -m 500 \
    -no-reboot \
    -no-hpet \
    -device virtio-serial \
    -serial stdio \
    -device sga \
    -chardev socket,path=/tmp/libguestfsNYAKgg/guestfsd.sock,id=channel0 \
    -device virtserialport,chardev=channel0,name=org.libguestfs.channel.0 \
    -kernel /usr/lib64/guestfs/vmlinuz.x86_64 \
    -initrd /usr/lib64/guestfs/initramfs.x86_64.img \
    -append 'panic=1 console=ttyS0 udevtimeout=600 no_timer_check acpi=off printk.time=1 cgroup_disable=memory root=/dev/Xd selinux=0 guestfs_verbose=1 TERM=xterm'\x1b[1;256r\x1b[256;256H\x1b[6n
Google, Inc.
Serial Graphics Adapter 02/16/13
SGABIOS $Id: sgabios.S 8 2010-04-22 00:03:40Z nlaredo $ (abuild@build21) Sat Feb 16 07:36:06 UTC 2013
Term: 80x24
4 0
\x1b[2J
SeaBIOS (version seabios-261e870-20130216_073605)


Booting from ROM...


Probing EDD (edd=off to disable)... ok

\x1b[2J[    0.000000] Initializing cgroup subsys cpuset
[    0.000000] Initializing cgroup subsys cpu
[    0.000000] Linux version 3.7.10-1.1-default (geeko@buildhost) (gcc version 4.7.2 20130108 [gcc-4_7-branch revision 195012] (SUSE Linux) ) #1 SMP Thu Feb 28 15:06:29 UTC 2013 (82d3f21)
[    0.000000] Command line: panic=1 console=ttyS0 udevtimeout=600 no_timer_check acpi=off printk.time=1 cgroup_disable=memory root=/dev/Xd selinux=0 guestfs_verbose=1 TERM=xterm
[    0.000000] e820: BIOS-provided physical RAM map:
[    0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
[    0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
[    0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000001f3fdfff] usable
[    0.000000] BIOS-e820: [mem 0x000000001f3fe000-0x000000001f3fffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
[    0.000000] NX (Execute Disable) protection: active
[    0.000000] SMBIOS 2.4 present.
[    0.000000] Hypervisor detected: KVM
[    0.000000] No AGP bridge found
[    0.000000] e820: last_pfn = 0x1f3fe max_arch_pfn = 0x400000000
[    0.000000] PAT not supported by CPU.
[    0.000000] found SMP MP-table at [mem 0x000fdb00-0x000fdb0f] mapped at [ffff8800000fdb00]
[    0.000000] init_memory_mapping: [mem 0x00000000-0x1f3fdfff]
[    0.000000] RAMDISK: [mem 0x1e5e6000-0x1f3effff]
[    0.000000] No NUMA configuration found
[    0.000000] Faking a node at [mem 0x0000000000000000-0x000000001f3fdfff]
[    0.000000] Initmem setup node 0 [mem 0x00000000-0x1f3fdfff]
[    0.000000]   NODE_DATA [mem 0x1e5d2000-0x1e5e5fff]
[    0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
[    0.000000] kvm-clock: cpu 0, msr 0:1abc0c1, boot clock
[    0.000000] Zone ranges:
[    0.000000]   DMA      [mem 0x00010000-0x00ffffff]
[    0.000000]   DMA32    [mem 0x01000000-0xffffffff]
[    0.000000]   Normal   empty
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x00010000-0x0009efff]
[    0.000000]   node   0: [mem 0x00100000-0x1f3fdfff]
[    0.000000] Intel MultiProcessor Specification v1.4
[    0.000000] MPTABLE: OEM ID: BOCHSCPU
[    0.000000] MPTABLE: Product ID: 0.1         
[    0.000000] MPTABLE: APIC at: 0xFEE00000
[    0.000000] Processor #0 (Bootup-CPU)
[    0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
[    0.000000] Processors: 1
[    0.000000] smpboot: Allowing 1 CPUs, 0 hotplug CPUs
[    0.000000] PM: Registered nosave memory: 000000000009f000 - 00000000000a0000
[    0.000000] PM: Registered nosave memory: 00000000000a0000 - 00000000000f0000
[    0.000000] PM: Registered nosave memory: 00000000000f0000 - 0000000000100000
[    0.000000] e820: [mem 0x1f400000-0xfeffbfff] available for PCI devices
[    0.000000] Booting paravirtualized kernel on KVM
[    0.000000] setup_percpu: NR_CPUS:512 nr_cpumask_bits:512 nr_cpu_ids:1 nr_node_ids:1
[    0.000000] PERCPU: Embedded 27 pages/cpu @ffff88001e200000 s81536 r8192 d20864 u2097152
[    0.000000] kvm-clock: cpu 0, msr 0:1e2130c1, primary cpu clock
[    0.000000] KVM setup async PF for cpu 0
[    0.000000] kvm-stealtime: cpu 0, msr 1e20d200
[    0.000000] Built 1 zonelists in Node order, mobility grouping on.  Total pages: 126129
[    0.000000] Policy zone: DMA32
[    0.000000] Kernel command line: panic=1 console=ttyS0 udevtimeout=600 no_timer_check acpi=off printk.time=1 cgroup_disable=memory root=/dev/Xd selinux=0 guestfs_verbose=1 TERM=xterm
[    0.000000] Disabling memory control group subsystem
[    0.000000] PID hash table entries: 2048 (order: 2, 16384 bytes)
[    0.000000] __ex_table already sorted, skipping sort
[    0.000000] Checking aperture...
[    0.000000] No AGP bridge found
[    0.000000] Memory: 474740k/511992k available (5451k kernel code, 452k absent, 36800k reserved, 5457k data, 996k init)
[    0.000000] Hierarchical RCU implementation.
[    0.000000] \tRCU dyntick-idle grace-period acceleration is enabled.
[    0.000000] \tRCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=1.
[    0.000000] NR_IRQS:33024 nr_irqs:256 16
[    0.000000] Console: colour *CGA 80x25
[    0.000000] console [ttyS0] enabled
[    0.000000] tsc: Detected 2393.998 MHz processor
[    0.008000] Calibrating delay loop (skipped) preset value.. 4787.99 BogoMIPS (lpj=9575992)
[    0.008000] pid_max: default: 32768 minimum: 301
[    0.008000] Security Framework initialized
[    0.008000] AppArmor: AppArmor initialized
[    0.008000] Dentry cache hash table entries: 65536 (order: 7, 524288 bytes)
[    0.008000] Inode-cache hash table entries: 32768 (order: 6, 262144 bytes)
[    0.008058] Mount-cache hash table entries: 256
[    0.008649] Initializing cgroup subsys cpuacct
[    0.009107] Initializing cgroup subsys memory
[    0.009543] Initializing cgroup subsys devices
[    0.009976] Initializing cgroup subsys freezer
[    0.010394] Initializing cgroup subsys net_cls
[    0.010813] Initializing cgroup subsys blkio
[    0.011269] Initializing cgroup subsys perf_event
[    0.011711] Initializing cgroup subsys hugetlb
[    0.012063] mce: CPU supports 10 MCE banks
[    0.012489] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
[    0.012489] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0
[    0.012489] tlb_flushall_shift: 6
[    0.021526] Freeing SMP alternatives: 20k freed
[    0.025496] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[    0.026085] smpboot: CPU0: Intel QEMU Virtual CPU version 1.3.0 (fam: 06, model: 02, stepping: 03)
[    0.132051] Performance Events: unsupported p6 CPU model 2 no PMU driver, software events only.
[    0.133338] Brought up 1 CPUs
[    0.133689] smpboot: Total of 1 processors activated (4787.99 BogoMIPS)
[    0.134553] NMI watchdog: disabled (cpu0): hardware events not enabled
[    0.135253] devtmpfs: initialized
[    0.136414] RTC time: 22:43:49, date: 03/25/13
[    0.136867] NET: Registered protocol family 16
[    0.137547] PCI: Using configuration type 1 for base access
[    0.138606] bio: create slab <bio-0> at 0
[    0.139047] ACPI: Interpreter disabled.
[    0.139446] vgaarb: loaded
[    0.139770] SCSI subsystem initialized
[    0.140082] PCI: Probing PCI hardware
[    0.140447] PCI host bridge to bus 0000:00
[    0.140841] pci_bus 0000:00: root bus resource [io  0x0000-0xffff]
[    0.141408] pci_bus 0000:00: root bus resource [mem 0x00000000-0xffffffffff]
[    0.142057] pci_bus 0000:00: No busn resource found for root bus, will use [bus 00-ff]
[    0.147290] pci 0000:00:01.3: quirk: [io  0xb000-0xb03f] claimed by PIIX4 ACPI
[    0.148011] pci 0000:00:01.3: quirk: [io  0xb100-0xb10f] claimed by PIIX4 SMB
[    0.162266] pci 0000:00:01.0: PIIX/ICH IRQ router [8086:7000]
[    0.163001] NetLabel: Initializing
[    0.163320] NetLabel:  domain hash size = 128
[    0.164001] NetLabel:  protocols = UNLABELED CIPSOv4
[    0.164467] NetLabel:  unlabeled traffic allowed by default
[    0.165015] Switching to clocksource kvm-clock
[    0.166904] AppArmor: AppArmor Filesystem Enabled
[    0.167394] pnp: PnP ACPI: disabled
[    0.167873] NET: Registered protocol family 2
[    0.167988] TCP established hash table entries: 16384 (order: 6, 262144 bytes)
[    0.168730] TCP bind hash table entries: 16384 (order: 6, 262144 bytes)
[    0.169379] TCP: Hash tables configured (established 16384 bind 16384)
[    0.170007] TCP: reno registered
[    0.170312] UDP hash table entries: 256 (order: 1, 8192 bytes)
[    0.170862] UDP-Lite hash table entries: 256 (order: 1, 8192 bytes)
[    0.171470] NET: Registered protocol family 1
[    0.171894] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
[    0.172516] pci 0000:00:01.0: PIIX3: Enabling Passive Release
[    0.173085] pci 0000:00:01.0: Activating ISA DMA hang workarounds
[    0.173702] Unpacking initramfs...
[    0.389757] Freeing initrd memory: 14376k freed
[    0.393166] platform rtc_cmos: registered platform RTC device (no PNP device found)
[    0.394188] audit: initializing netlink socket (disabled)
[    0.394722] type=2000 audit(1364251430.392:1): initialized
[    0.414769] HugeTLB registered 2 MB page size, pre-allocated 0 pages
[    0.415534] VFS: Disk quotas dquot_6.5.2
[    0.415923] Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[    0.416670] msgmni has been set to 955
[    0.417152] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
[    0.417869] io scheduler noop registered
[    0.418234] io scheduler deadline registered
[    0.418647] io scheduler cfq registered (default)
[    0.419231] Serial: 8250/16550 driver, 32 ports, IRQ sharing disabled
[    0.441415] serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
[    0.442845] Non-volatile memory driver v1.3
[    0.443262] Linux agpgart interface v0.103
[    0.443762] libphy: Fixed MDIO Bus: probed
[    0.444214] i8042: PNP: No PS/2 controller found. Probing ports directly.
[    0.445416] serio: i8042 KBD port at 0x60,0x64 irq 1
[    0.445893] serio: i8042 AUX port at 0x60,0x64 irq 12
[    0.446429] mousedev: PS/2 mouse device common for all mice
[    0.447154] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
[    0.450294] rtc_cmos rtc_cmos: rtc core: registered rtc_cmos as rtc0
[    0.450960] rtc0: alarms up to one day, 114 bytes nvram
[    0.451448] cpuidle: using governor ladder
[    0.451829] cpuidle: using governor menu
[    0.452241] ledtrig-cpu: registered to indicate activity on CPUs
[    0.452833] EFI Variables Facility v0.08 2004-May-17
[    0.453399] TCP: cubic registered
[    0.453755] NET: Registered protocol family 10
[    0.454298] lib80211: common routines for IEEE802.11 drivers
[    0.454843] Key type dns_resolver registered
[    0.455384] registered taskstats version 1
[    0.455923]   Magic number: 5:878:755
[    0.456354] tty ttyS6: hash matches
[    0.456760] rtc_cmos rtc_cmos: setting system clock to 2013-03-25 22:43:50 UTC (1364251430)
[    0.458968] Freeing unused kernel memory: 996k freed
[    0.459620] Write protecting the kernel read-only data: 10240k
[    0.461643] Freeing unused kernel memory: 684k freed
[    0.462713] Freeing unused kernel memory: 260k freed
doing fast boot
[    0.490954] emc: device handler registered
[    0.492375] alua: device handler registered
[    0.493655] rdac: device handler registered
[    0.494916] hp_sw: device handler registered
Creating device nodes with udev
[    0.500197] systemd-udevd[82]: starting version 195
[    0.506285] virtio-pci 0000:00:02.0: PCI->APIC IRQ transform: INT A -> IRQ 34
[    0.508952] virtio-pci 0000:00:03.0: PCI->APIC IRQ transform: INT A -> IRQ 35
[    0.582794] scsi0 : Virtio SCSI HBA
[    0.585100] scsi 0:0:0:0: Direct-Access     QEMU     QEMU HARDDISK    1.3. PQ: 0 ANSI: 5
[    0.586253] sd 0:0:0:0: [sda] 20480000 512-byte logical blocks: (10.4 GB/9.76 GiB)
[    0.587146] sd 0:0:0:0: [sda] Write Protect is off
[    0.587787] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[    0.590668]  sda: sda1 sda2
[    0.592179] sd 0:0:0:0: [sda] Attached SCSI disk
[    0.612956] sd 0:0:0:0: Attached scsi generic sg0 type 0
[    0.659097] device-mapper: uevent: version 1.0.3
[    0.659929] device-mapper: ioctl: 4.23.0-ioctl (2012-07-25) initialised: dm-devel
mdadm: No arrays found in config file or automatically
  Reading all physical volumes.  This may take a while...
  Found volume group "vg_example" using metadata type lvm2
[    0.684330] bio: create slab <bio-1> at 1
  2 logical volume(s) in volume group "vg_example" now active
[    1.081082] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input1
Comment 1 Richard W.M. Jones 2013-03-25 22:56:18 UTC 
SuSE source package:

https://build.opensuse.org/package/show?package=libguestfs&project=Virtualization
Comment 2 Pino Toscano 2015-09-01 13:29:11 UTC 
Old libguestfs version on an old openSUSE version -- hard to debug further, especially that current libguestfs generally works well on more recent openSUSE versions.

Closing this bug, further issues can be opened in case.