[Libguestfs] [nbdkit PATCH] nbd: Fix memory leak

Richard W.M. Jones rjones at redhat.com
Sat Dec 2 18:21:48 UTC 2017


On Sat, Dec 02, 2017 at 11:52:31AM -0600, Eric Blake wrote:
> When converting from a single transaction to a linked list, I
> forgot to free the storage for each member of the list.
> 
> Reported-by: Richard W.M. Jones <rjones at redhat.com>
> Fixes: 7f5bb9bf13f041ea7702bda557d9dd668bc3423a
> Signed-off-by: Eric Blake <eblake at redhat.com>
> ---
> 
> I'm still not sure why 'make check' passes while 'make check-valgrind'
> fails for TESTS=test-nbd, but this at least avoids the memory leak.
> 
>  plugins/nbd/nbd.c | 2 ++
>  1 file changed, 2 insertions(+)
> 
> diff --git a/plugins/nbd/nbd.c b/plugins/nbd/nbd.c
> index b844bf5..425abe4 100644
> --- a/plugins/nbd/nbd.c
> +++ b/plugins/nbd/nbd.c
> @@ -334,6 +334,7 @@ nbd_reply_raw (struct handle *h, int *fd)
>    }
> 
>    *fd = trans->u.fds[1];
> +  free (trans);
>    switch (be32toh (rep.error)) {
>    case NBD_SUCCESS:
>      if (trans->buf && read_full (h->fd, trans->buf, trans->count) < 0)
> @@ -399,6 +400,7 @@ nbd_reader (void *handle)
>        abort ();
>      }
>      close (trans->u.fds[1]);
> +    free (trans);
>    }
>    return NULL;
>  }

Can this be right?  valgrind seems to be saying that there are
double-free errors when I add this patch (see below).

Rich.


FAIL: test-nbd
==============

/home/rjones/d/nbdkit/src/nbdkit -U /tmp/nbdkitwuqXQ0/sock -P /tmp/nbdkitwuqXQ0/pid -f -v -o /home/rjones/d/nbdkit/plugins/file/.libs/nbdkit-file-plugin.so file=file-data
==17992== Memcheck, a memory error detector
==17992== Copyright (C) 2002-2017, and GNU GPL'd, by Julian Seward et al.
==17992== Using Valgrind-3.13.0 and LibVEX; rerun with -h for copyright info
==17992== Command: /home/rjones/d/nbdkit/src/nbdkit -U /tmp/nbdkitwuqXQ0/sock -P /tmp/nbdkitwuqXQ0/pid -f -v -o /home/rjones/d/nbdkit/plugins/file/.libs/nbdkit-file-plugin.so file=file-data
==17992== 
nbdkit: debug: successfully loaded TLS certificates from /home/rjones/.pki/nbdkit
nbdkit: debug: TLS enabled
nbdkit: debug: registering /home/rjones/d/nbdkit/plugins/file/.libs/nbdkit-file-plugin.so
nbdkit: debug: registered /home/rjones/d/nbdkit/plugins/file/.libs/nbdkit-file-plugin.so (name file)
nbdkit: debug: /home/rjones/d/nbdkit/plugins/file/.libs/nbdkit-file-plugin.so: load
nbdkit: debug: /home/rjones/d/nbdkit/plugins/file/.libs/nbdkit-file-plugin.so: config key=file, value=file-data
nbdkit: debug: /home/rjones/d/nbdkit/plugins/file/.libs/nbdkit-file-plugin.so: config_complete
nbdkit: debug: bound to unix socket /tmp/nbdkitwuqXQ0/sock
nbdkit: debug: written pidfile /tmp/nbdkitwuqXQ0/pid
/home/rjones/d/nbdkit/src/nbdkit -U /tmp/nbdkitFCDAKC/sock -P /tmp/nbdkitFCDAKC/pid -f -v -e wrap /home/rjones/d/nbdkit/plugins/nbd/.libs/nbdkit-nbd-plugin.so socket=/tmp/nbdkitwuqXQ0/sock
==18076== Memcheck, a memory error detector
==18076== Copyright (C) 2002-2017, and GNU GPL'd, by Julian Seward et al.
==18076== Using Valgrind-3.13.0 and LibVEX; rerun with -h for copyright info
==18076== Command: /home/rjones/d/nbdkit/src/nbdkit -U /tmp/nbdkitFCDAKC/sock -P /tmp/nbdkitFCDAKC/pid -f -v -e wrap /home/rjones/d/nbdkit/plugins/nbd/.libs/nbdkit-nbd-plugin.so socket=/tmp/nbdkitwuqXQ0/sock
==18076== 
nbdkit: debug: successfully loaded TLS certificates from /home/rjones/.pki/nbdkit
nbdkit: debug: TLS enabled
nbdkit: debug: registering /home/rjones/d/nbdkit/plugins/nbd/.libs/nbdkit-nbd-plugin.so
nbdkit: debug: registered /home/rjones/d/nbdkit/plugins/nbd/.libs/nbdkit-nbd-plugin.so (name nbd)
nbdkit: debug: /home/rjones/d/nbdkit/plugins/nbd/.libs/nbdkit-nbd-plugin.so: load
nbdkit: debug: /home/rjones/d/nbdkit/plugins/nbd/.libs/nbdkit-nbd-plugin.so: config key=socket, value=/tmp/nbdkitwuqXQ0/sock
nbdkit: debug: /home/rjones/d/nbdkit/plugins/nbd/.libs/nbdkit-nbd-plugin.so: config_complete
nbdkit: debug: bound to unix socket /tmp/nbdkitFCDAKC/sock
nbdkit: debug: written pidfile /tmp/nbdkitFCDAKC/pid
/home/rjones/d/nbdkit/src/nbdkit -U /tmp/nbdkitnRE48m/sock -P /tmp/nbdkitnRE48m/pid -f -v -o /home/rjones/d/nbdkit/plugins/nbd/.libs/nbdkit-nbd-plugin.so socket=/tmp/nbdkitFCDAKC/sock export=wrap
==18105== Memcheck, a memory error detector
==18105== Copyright (C) 2002-2017, and GNU GPL'd, by Julian Seward et al.
==18105== Using Valgrind-3.13.0 and LibVEX; rerun with -h for copyright info
==18105== Command: /home/rjones/d/nbdkit/src/nbdkit -U /tmp/nbdkitnRE48m/sock -P /tmp/nbdkitnRE48m/pid -f -v -o /home/rjones/d/nbdkit/plugins/nbd/.libs/nbdkit-nbd-plugin.so socket=/tmp/nbdkitFCDAKC/sock export=wrap
==18105== 
nbdkit: debug: successfully loaded TLS certificates from /home/rjones/.pki/nbdkit
nbdkit: debug: TLS enabled
nbdkit: debug: registering /home/rjones/d/nbdkit/plugins/nbd/.libs/nbdkit-nbd-plugin.so
nbdkit: debug: registered /home/rjones/d/nbdkit/plugins/nbd/.libs/nbdkit-nbd-plugin.so (name nbd)
nbdkit: debug: /home/rjones/d/nbdkit/plugins/nbd/.libs/nbdkit-nbd-plugin.so: load
nbdkit: debug: /home/rjones/d/nbdkit/plugins/nbd/.libs/nbdkit-nbd-plugin.so: config key=socket, value=/tmp/nbdkitFCDAKC/sock
nbdkit: debug: /home/rjones/d/nbdkit/plugins/nbd/.libs/nbdkit-nbd-plugin.so: config key=export, value=wrap
nbdkit: debug: /home/rjones/d/nbdkit/plugins/nbd/.libs/nbdkit-nbd-plugin.so: config_complete
nbdkit: debug: bound to unix socket /tmp/nbdkitnRE48m/sock
nbdkit: debug: written pidfile /tmp/nbdkitnRE48m/pid
libguestfs: trace: set_verbose true
libguestfs: trace: set_verbose = 0
libguestfs: trace: set_backend "appliance"
libguestfs: trace: set_backend = 0
libguestfs: create: flags = 0, handle = 0x24282d0, program = test-nbd
libguestfs: trace: add_drive "" "format:raw" "protocol:nbd" "server:unix:/tmp/nbdkitnRE48m/sock"
libguestfs: trace: add_drive = 0
libguestfs: trace: launch
libguestfs: trace: get_tmpdir
libguestfs: trace: get_tmpdir = "/tmp"
libguestfs: trace: version
libguestfs: trace: version = <struct guestfs_version = major: 1, minor: 36, release: 7, extra: fedora=26,release=1.fc26,libvirt, >
libguestfs: trace: get_backend
libguestfs: trace: get_backend = "direct"
libguestfs: launch: program=test-nbd
libguestfs: launch: version=1.36.7fedora=26,release=1.fc26,libvirt
libguestfs: launch: backend registered: unix
libguestfs: launch: backend registered: uml
libguestfs: launch: backend registered: libvirt
libguestfs: launch: backend registered: direct
libguestfs: launch: backend=direct
libguestfs: launch: tmpdir=/tmp/libguestfsYp1w4f
libguestfs: launch: umask=0002
libguestfs: launch: euid=1000
libguestfs: trace: get_backend_setting "force_tcg"
libguestfs: trace: get_backend_setting = NULL (error)
libguestfs: trace: get_cachedir
libguestfs: trace: get_cachedir = "/var/tmp"
libguestfs: begin building supermin appliance
libguestfs: run supermin
libguestfs: command: run: /usr/bin/supermin
libguestfs: command: run: \ --build
libguestfs: command: run: \ --verbose
libguestfs: command: run: \ --if-newer
libguestfs: command: run: \ --lock /var/tmp/.guestfs-1000/lock
libguestfs: command: run: \ --copy-kernel
libguestfs: command: run: \ -f ext2
libguestfs: command: run: \ --host-cpu x86_64
libguestfs: command: run: \ /usr/lib64/guestfs/supermin.d
libguestfs: command: run: \ -o /var/tmp/.guestfs-1000/appliance.d
supermin: version: 5.1.19
supermin: rpm: detected RPM version 4.13
supermin: package handler: fedora/rpm
supermin: acquiring lock on /var/tmp/.guestfs-1000/lock
supermin: if-newer: output does not need rebuilding
libguestfs: finished building supermin appliance
libguestfs: begin testing qemu features
libguestfs: trace: get_cachedir
libguestfs: trace: get_cachedir = "/var/tmp"
libguestfs: checking for previously cached test results of /usr/bin/qemu-kvm, in /var/tmp/.guestfs-1000
libguestfs: loading previously cached test results
libguestfs: qemu version: 2.10
libguestfs: qemu mandatory locking: yes
libguestfs: trace: get_sockdir
libguestfs: trace: get_sockdir = "/run/user/1000"
libguestfs: finished testing qemu features
libguestfs: trace: get_backend_setting "gdb"
libguestfs: trace: get_backend_setting = NULL (error)
[00085ms] /usr/bin/qemu-kvm \
    -global virtio-blk-pci.scsi=off \
    -nodefconfig \
    -enable-fips \
    -nodefaults \
    -display none \
    -machine accel=kvm:tcg \
    -cpu host \
    -m 500 \
    -no-reboot \
    -rtc driftfix=slew \
    -no-hpet \
    -global kvm-pit.lost_tick_policy=discard \
    -kernel /var/tmp/.guestfs-1000/appliance.d/kernel \
    -initrd /var/tmp/.guestfs-1000/appliance.d/initrd \
    -object rng-random,filename=/dev/urandom,id=rng0 \
    -device virtio-rng-pci,rng=rng0 \
    -device virtio-scsi-pci,id=scsi \
    -drive file=nbd:unix:/tmp/nbdkitnRE48m/sock,cache=writeback,format=raw,id=hd0,if=none \
    -device scsi-hd,drive=hd0 \
    -drive file=/var/tmp/.guestfs-1000/appliance.d/root,snapshot=on,id=appliance,cache=unsafe,if=none,format=raw \
    -device scsi-hd,drive=appliance \
    -device virtio-serial-pci \
    -serial stdio \
    -device sga \
    -chardev socket,path=/run/user/1000/libguestfsUEHqc9/guestfsd.sock,id=channel0 \
    -device virtserialport,chardev=channel0,name=org.libguestfs.channel.0 \
    -append 'panic=1 console=ttyS0 edd=off udevtimeout=6000 udev.event-timeout=6000 no_timer_check printk.time=1 cgroup_disable=memory usbcore.nousb cryptomgr.notests tsc=reliable 8250.nr_uarts=1 root=/dev/sdb selinux=0 guestfs_verbose=1 TERM=xterm-256color'
nbdkit: debug: accepted connection
nbdkit: debug: /home/rjones/d/nbdkit/plugins/nbd/.libs/nbdkit-nbd-plugin.so: open readonly=0
nbdkit: debug: accepted connection
nbdkit: debug: /home/rjones/d/nbdkit/plugins/nbd/.libs/nbdkit-nbd-plugin.so: open readonly=0
nbdkit: debug: accepted connection
nbdkit: debug: /home/rjones/d/nbdkit/plugins/file/.libs/nbdkit-file-plugin.so: open readonly=0
nbdkit: file[1]: debug: acquire unload prevention lock
nbdkit: file[1]: debug: get_size
nbdkit: file[1]: debug: can_write
nbdkit: file[1]: debug: can_flush
nbdkit: file[1]: debug: is_rotational
nbdkit: file[1]: debug: can_trim
nbdkit: file[1]: debug: oldstyle negotiation: flags: global 0x0 export 0x4d
nbdkit: file[1]: debug: release unload prevention lock
nbdkit: file[1]: debug: handshake complete, processing requests with 16 threads
nbdkit: nbd[1]: debug: acquire unload prevention lock
nbdkit: nbd[1]: debug: newstyle negotiation: flags: global 0x3
nbdkit: nbd[1]: debug: newstyle negotiation: client flags: 0x0
nbdkit: nbd[1]: debug: newstyle negotiation: client requested export 'wrap' (ignored)
nbdkit: nbd[1]: debug: get_size
nbdkit: nbd[1]: debug: can_write
nbdkit: nbd[1]: debug: can_flush
nbdkit: nbd[1]: debug: is_rotational
nbdkit: nbd[1]: debug: can_trim
nbdkit: nbd[1]: debug: newstyle negotiation: flags: export 0x4d
nbdkit: nbd[1]: debug: release unload prevention lock
nbdkit: nbd[1]: debug: handshake complete, processing requests with 16 threads
nbdkit: debug: starting worker thread file.0
nbdkit: debug: starting worker thread file.1
nbdkit: debug: starting worker thread file.2
nbdkit: nbd[1]: debug: acquire unload prevention lock
nbdkit: nbd[1]: debug: get_size
nbdkit: nbd[1]: debug: can_write
nbdkit: nbd[1]: debug: can_flush
nbdkit: nbd[1]: debug: is_rotational
nbdkit: nbd[1]: debug: can_trim
nbdkit: nbd[1]: debug: nbdkit: debug: starting worker thread file.3
oldstyle negotiation: flags: global 0x0 export 0x4d
nbdkit: nbd[1]: debug: release unload prevention lock
nbdkit: nbd[1]: debug: handshake complete, processing requests with 16 threads
nbdkit: debug: starting worker thread nbd.0
nbdkit: debug: starting worker thread file.4
nbdkit: debug: starting worker thread nbd.1
nbdkit: debug: starting worker thread nbd.2
nbdkit: debug: starting worker thread file.5
nbdkit: debug: starting worker thread file.6
nbdkit: debug: starting worker thread file.7
nbdkit: debug: starting worker thread nbd.0
nbdkit: nbd.0: debug: acquire unload prevention lock
nbdkit: nbd.0: debug: pread count=512 offset=0
nbdkit: debug: starting worker thread file.8
nbdkit: nbd.0: debug: sending request with type 0 and cookie 0x900000008nbdkit: debug: starting worker thread file.9

nbdkit: debug: starting worker thread nbd.1
nbdkit: debug: starting worker thread file.10
nbdkit: debug: starting worker thread file.11
nbdkit: nbd.0: debug: acquire unload prevention lock
nbdkit: nbd.0: debug: pread count=512 offset=0
nbdkit: debug: starting worker thread nbd.3
nbdkit: nbd.0: debug: sending request with type 0 and cookie 0x900000008
nbdkit: debug: starting worker thread nbd.4
nbdkit: debug: starting worker thread nbd.2
nbdkit: debug: starting worker thread nbd.3
nbdkit: file.0: debug: acquire unload prevention lock
nbdkit: file.0: debug: pread count=512 offset=0
nbdkit: file.0: debug: release unload prevention lock
nbdkit: debug: received reply for cookie 0x900000008
==18076== Thread 3:
==18076== Invalid read of size 8
==18076==    at 0x77EBB08: nbd_reply_raw (nbd.c:340)
==18076==    by 0x77EBB08: nbd_reader (nbd.c:373)
==18076==    by 0x55DC55A: start_thread (in /usr/lib64/libpthread-2.26.9000.so)
==18076==    by 0x58E85AE: clone (in /usr/lib64/libc-2.26.9000.so)
==18076==  Address 0x7452fc8 is 8 bytes inside a block of size 32 free'd
==18076==    at 0x4C2ED18: free (vg_replace_malloc.c:530)
==18076==    by 0x77EB996: nbd_reply_raw (nbd.c:337)
==18076==    by 0x77EB996: nbd_reader (nbd.c:373)
==18076==    by 0x55DC55A: start_thread (in /usr/lib64/libpthread-2.26.9000.so)
==18076==    by 0x58E85AE: clone (in /usr/lib64/libc-2.26.9000.so)
==18076==  Block was alloc'd at
==18076==    at 0x4C2FA1E: calloc (vg_replace_malloc.c:711)
==18076==    by 0x77EBBAF: nbd_request_full (nbd.c:264)
==18076==    by 0x77EBD98: nbd_pread (nbd.c:602)
==18076==    by 0x405986: handle_request (connections.c:884)
==18076==    by 0x405986: recv_request_send_reply (connections.c:1061)
==18076==    by 0x405AE7: connection_worker (connections.c:200)
==18076==    by 0x55DC55A: start_thread (in /usr/lib64/libpthread-2.26.9000.so)
==18076==    by 0x58E85AE: clone (in /usr/lib64/libc-2.26.9000.so)
==18076== 
==18076== Invalid read of size 4
==18076==    at 0x77EBB11: nbd_reply_raw (nbd.c:340)
==18076==    by 0x77EBB11: nbd_reader (nbd.c:373)
==18076==    by 0x55DC55A: start_thread (in /usr/lib64/libpthread-2.26.9000.so)
==18076==    by 0x58E85AE: clone (in /usr/lib64/libc-2.26.9000.so)
==18076==  Address 0x7452fd0 is 16 bytes inside a block of size 32 free'd
==18076==    at 0x4C2ED18: free (vg_replace_malloc.c:530)
==18076==    by 0x77EB996: nbd_reply_raw (nbd.c:337)
==18076==    by 0x77EB996: nbd_reader (nbd.c:373)
==18076==    by 0x55DC55A: start_thread (in /usr/lib64/libpthread-2.26.9000.so)
==18076==    by 0x58E85AE: clone (in /usr/lib64/libc-2.26.9000.so)
==18076==  Block was alloc'd at
==18076==    at 0x4C2FA1E: calloc (vg_replace_malloc.c:711)
==18076==    by 0x77EBBAF: nbd_request_full (nbd.c:264)
==18076==    by 0x77EBD98: nbd_pread (nbd.c:602)
==18076==    by 0x405986: handle_request (connections.c:884)
==18076==    by 0x405986: recv_request_send_reply (connections.c:1061)
==18076==    by 0x405AE7: connection_worker (connections.c:200)
==18076==    by 0x55DC55A: start_thread (in /usr/lib64/libpthread-2.26.9000.so)
==18076==    by 0x58E85AE: clone (in /usr/lib64/libc-2.26.9000.so)
==18076== 
nbdkit: nbd.0: debug: release unload prevention lock
nbdkit: debug: starting worker thread file.12
nbdkit: debug: starting worker thread file.13
nbdkit: debug: received reply for cookie 0x900000008
==18105== Thread 3:
==18105== Invalid read of size 8
==18105==    at 0x77EBB08: nbd_reply_raw (nbd.c:340)
==18105==    by 0x77EBB08: nbd_reader (nbd.c:373)
==18105==    by 0x55DC55A: start_thread (in /usr/lib64/libpthread-2.26.9000.so)
==18105==    by 0x58E85AE: clone (in /usr/lib64/libc-2.26.9000.so)
==18105==  Address 0x74522f8 is 8 bytes inside a block of size 32 free'd
==18105==    at 0x4C2ED18: free (vg_replace_malloc.c:530)
==18105==    by 0x77EB996: nbd_reply_raw (nbd.c:337)
==18105==    by 0x77EB996: nbd_reader (nbd.c:373)
==18105==    by 0x55DC55A: start_thread (in /usr/lib64/libpthread-2.26.9000.so)
==18105==    by 0x58E85AE: clone (in /usr/lib64/libc-2.26.9000.so)
==18105==  Block was alloc'd at
==18105==    at 0x4C2FA1E: calloc (vg_replace_malloc.c:711)
==18105==    by 0x77EBBAF: nbd_request_full (nbd.c:264)
==18105==    by 0x77EBD98: nbd_pread (nbd.c:602)
==18105==    by 0x405986: handle_request (connections.c:884)
==18105==    by 0x405986: recv_request_send_reply (connections.c:1061)
==18105==    by 0x405AE7: connection_worker (connections.c:200)
==18105==    by 0x55DC55A: start_thread (in /usr/lib64/libpthread-2.26.9000.so)
==18105==    by 0x58E85AE: clone (in /usr/lib64/libc-2.26.9000.so)
==18105== 
==18105== Invalid read of size 4
==18105==    at 0x77EBB11: nbd_reply_raw (nbd.c:340)
==18105==    by 0x77EBB11: nbd_reader (nbd.c:373)
==18105==    by 0x55DC55A: start_thread (in /usr/lib64/libpthread-2.26.9000.so)
==18105==    by 0x58E85AE: clone (in /usr/lib64/libc-2.26.9000.so)
==18105==  Address 0x7452300 is 16 bytes inside a block of size 32 free'd
==18105==    at 0x4C2ED18: free (vg_replace_malloc.c:530)
==18105==    by 0x77EB996: nbd_reply_raw (nbd.c:337)
==18105==    by 0x77EB996: nbd_reader (nbd.c:373)
==18105==    by 0x55DC55A: start_thread (in /usr/lib64/libpthread-2.26.9000.so)
==18105==    by 0x58E85AE: clone (in /usr/lib64/libc-2.26.9000.so)
==18105==  Block was alloc'd at
==18105==    at 0x4C2FA1E: calloc (vg_replace_malloc.c:711)
==18105==    by 0x77EBBAF: nbd_request_full (nbd.c:264)
==18105==    by 0x77EBD98: nbd_pread (nbd.c:602)
==18105==    by 0x405986: handle_request (connections.c:884)
==18105==    by 0x405986: recv_request_send_reply (connections.c:1061)
==18105==    by 0x405AE7: connection_worker (connections.c:200)
==18105==    by 0x55DC55A: start_thread (in /usr/lib64/libpthread-2.26.9000.so)
==18105==    by 0x58E85AE: clone (in /usr/lib64/libc-2.26.9000.so)
==18105== 
nbdkit: debug: starting worker thread nbd.4
nbdkit: nbd.0: debug: release unload prevention lock
\x1blibguestfs: responding to serial console Device Status Report
[1;256r\x1b[256;256H\x1b[6n
Google, Inc.
Serial Graphics Adapter 02/12/17
SGABIOS $Id: sgabios.S 8 2010-04-22 00:03:40Z nlaredo $ (mockbuild@) Sun Feb 12 00:43:05 UTC 2017
Term: 80x24
4 0
\x1b[2J
SeaBIOS (version 1.10.2-1.fc26)

nbdkit: debug: starting worker thread nbd.5

Booting from ROM...

\x1b[2Jnbdkit: debug: starting worker thread nbd.6
nbdkit: debug: starting worker thread file.14
nbdkit: debug: starting worker thread file.15
nbdkit: debug: starting worker thread nbd.5
nbdkit: debug: starting worker thread nbd.7
nbdkit: debug: starting worker thread nbd.8
nbdkit: debug: starting worker thread nbd.6
nbdkit: debug: starting worker thread nbd.7
nbdkit: debug: starting worker thread nbd.8
nbdkit: debug: starting worker thread nbd.9
nbdkit: debug: starting worker thread nbd.10
nbdkit: debug: starting worker thread nbd.9
nbdkit: debug: starting worker thread nbd.10
nbdkit: debug: starting worker thread nbd.11
[    0.000000] random: get_random_bytes called from start_kernel+0x42/0x4e6 with crng_init=0
[    0.000000] Linux version 4.13.10-200.fc26.x86_64 (mockbuild at bkernel01.phx2.fedoraproject.org) (gcc version 7.2.1 20170915 (Red Hat 7.2.1-2) (GCC)) #1 SMP Fri Oct 27 15:34:40 UTC 2017
[    0.000000] Command line: panic=1 console=ttyS0 edd=off udevtimeout=6000 udev.event-timeout=6000 no_timer_check printk.time=1 cgroup_disable=memory usbcore.nousb cryptomgr.notests tsc=reliable 8250.nr_uarts=1 root=/dev/sdb selinux=0 guestfsnbdkit: debug: starting worker thread nbd.12
_verbose=1 TERM=xterm-256color
[    0.000000] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'
[    0.000000] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'
[    0.000000] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'
[    0.000000] x86/fpu: xstate_offset[2]:  576, xstate_sizes[2]:  256
[    0.000000] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format.
[    0.000000] e820: BIOS-provided physical RAM map:
[    0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009f7ff] usable
[    0.000000] BIOS-e820: [mem 0x000000000009f800-0x000000000009ffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
[    0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000001f3ddfff] usable
[    0.000000] BIOS-e820: [mem 0x000000001f3de000-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] random: fast init done
[    0.000000] SMBIOS 2.8 present.
[    0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1.fc26 04/01/2014
[    0.000000] Hypervisor detected: KVM
[    0.000000] tsc: Fast TSC calibration failed
[    0.000000] tsc: Using PIT calibration value
[    0.000000] e820: last_pfn = 0x1f3de max_arch_pfn = 0x400000000
[    0.000000] x86/PAT: Configuration [0-7]: WB  WC  UC- UC  WB  WC  UC- WT  
[    0.000000] found SMP MP-table at [mem 0x000f6c10-0x000f6c1f] mapped at [ffff8fe6000f6c10]
[    0.000000] Using GB pages for direct mapping
[    0.000000] RAMDISK: [mem 0x1f346000-0x1f3cffff]
[ nbdkit: debug: starting worker thread nbd.13
   0.000000] ACPI: Early table checksum verification disabled
[    0.000000] ACPI: RSDP 0x00000000000F6A40 000014 (v00 BOCHS )
[    0.000000] ACPI: RSDT 0x000000001F3E156F 00002C (v01 BOCHS  BXPCRSDT 00000001 BXPC 00000001)
[    0.000000] ACPI: FACP 0x000000001F3E1403 000074 (v01 BOCHS  BXPCFACP 00000001 BXPC 00000001)
[    0.000000] ACPI: DSDT 0x000000001F3E0040 0013C3 (v01 BOCHS  BXPCDSDT 00000001 BXPC 00000001)
[    0.000000] ACPI: FACS 0x000000001F3E0000 000040
[    0.000000] ACPI: APIC 0x000000001F3E14F7 000078 (v01 BOCHS  BXPCAPIC 00000001 BXPC 00000001)
[    0.000000] No NUMA configuration found
[    0.000000] Faking a node at [mem 0x0000000000000000-0x000000001f3ddfff]
[    0.000000] NODE_DATA(0) allocated [mem 0x1f31b000-0x1f345fff]
[    0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
[    0.000000] kvm-clock: cpu 0, msr 0:1f29b001, primary cpu clock
[    0.000000] kvm-clock: using sched offset of 1668979175 cycles
[    0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
[    0.000000] Zone ranges:
[    0.000000]   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
[    0.000000]   DMA32    [mem 0x0000000001000000-0x000000001f3ddfff]
[    0.000000]   Normal   empty
[    0.000000]   Device   empty
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x0000000000001000-0x000000000009efff]
[    0.000000]   node   0: [mem 0x0000000000100000-0x000000001f3ddfff]
[    0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x000000001f3ddfff]
[    0.000000] ACPI: PM-Timer IO Port: 0x608
[    0.000000] BIOS bug: APIC version is 0 for CPU 0/0x0, fixing up to 0x10
[    0.000000] BIOS bug: APIC version mismatch, boot CPU: 0, CPU 0: version 10
[    0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
[    0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
[    0.000000] ACPI: INT_SRC_Onbdkit: debug: starting worker thread nbd.11
VR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
[    0.000000] Using ACPI (MADT) for SMP configuration information
[    0.000000] smpboot: Allowing 1 CPUs, 0 hotplug CPUs
[    0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff]
[    0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff]
[    0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff]
[    0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff]
[    0.000000] e820: [mem 0x1f400000-0xfeffbfff] available for PCI devices
[    0.000000] Booting paravirtualized kernel on KVM
[    0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
[    0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1
[    0.000000] percpu: Embedded 37 pages/cpu @ffff8fe61f000000 s112600 r8192 d30760 u2097152
[    0.000000] KVM setup async PF for cpu 0
[    0.000000] kvm-stealtime: cpu 0, msr 1f00d940
[    0.000000] Built 1 zonelists in Node order, mobility grouping on.  Total pages: 125847
[    0.000000] Policy zone: DMA32
[    0.000000] Kernel command line: panic=1 console=ttyS0 edd=off udevtimeout=6000 udev.event-timeout=6000 no_timer_check printk.time=1 cgroup_disable=memory usbcore.nousb cryptomgr.notests tsc=reliable 8250.nr_uarts=1 root=/dev/sdb selinux=0 guestfs_verbose=1 TERM=xterm-256color
[    0.000000] PID hash table entries: 2048 (order: 2, 16384 bytes)
[    0.000000] Memory: 480652K/511472K available (8832K kernel code, 2404K rwdata, 3760K rodata, 2224K init, 1976K bss, nbdkit: debug: starting worker thread nbd.14
30820K reserved, 0K cma-reserved)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
[    0.000000] ftrace: allocnbdkit: debug: starting worker thread nbd.15
ating 34932 entries in 137 pages
[    0.001000] Hierarchical RCU implementation.
[    0.001000] \tRCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=1.
[    0.001000] \tTasks RCU enabled.
[    0.001000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
[    0.001000] NR_IRQS: 524544, nr_irqs: 256, preallocated irqs: 16
[    0.001000] \tOffload RCU callbacks from CPUs: .
[    0.001000] Console: colour *CGA 80x25
[    0.001000] console [ttyS0] enabled
[    0.001018] tsc: Detected 2593.994 MHz processor
[    0.002013] Calibrating delay loop (skipped) preset value.. 5187.98 BogoMIPS (lpj=2593994)
[    0.003012] pid_max: default: 32768 minimum: 301
[    0.004033] ACPI: Core revision 20170531
[    0.006285] ACPI: 1 ACPI AML tables successfully acquired and loaded
[    0.007059] Security Framework initialized
[    0.007520] Yama: becoming mindful.
[   nbdkit: debug: starting worker thread nbd.12
 0.007914] SELinux:  Disabled at boot.
[    0.008124] Dentry cache hash table entries: 65536 (order: 7, 524288 bytes)
[    0.009077] Inode-cache hash table entries: 32768 (order: 6, 262144 bytes)
[    0.010025] Mount-cache hash table entries: 1024 (order: 1, 8192 bytes)
[    0.011019] Mountpoint-cache hash table entries: 1024 (order: 1, 8192 bytes)
[    0.013096] Disabling memory control group subsystem
[    0.014082] CPU: Physical Processor ID: 0
[    0.014583] mce: CPU supports 10 MCE banks
[    0.015047] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
[    0.015666] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
nbdkit: debug: starting worker thread nbd.13
[    0.029447] Freeing SMP alternatives memory: 32K
[    0.031307] smpboot: Max logical packages: 1
[    0.031963] x2apic enabled
nbdkit: debug: starting worker thread nbd.14
[    0.032006] Switched APIC routing to physical x2apic.
[    0.034000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[    0.034000] smpboot: CPU0: Intel(R) Core(TM) i7-5600U nbdkit: debug: starting worker thread nbd.15
CPU @ 2.60GHz (family: 0x6, model: 0x3d, stepping: 0x4)
[    0.034071] Performance Events: Broadwell events, Intel PMU driver.
[    0.035023] ... version:                2
[    0.035529] ... bit width:              48
[    0.036007] ... generic registers:      4
[    0.036475] ... value mask:             0000ffffffffffff
[    0.037007] ... max period:             000000007fffffff
[    0.037582] ... fixed-purpose events:   3
[    0.038006] ... event mask:             000000070000000f
[    0.039142] Hierarchical SRCU implementation.
[    0.040360] smp: Bringing up secondary CPUs ...
[    0.041007] smp: Brought up 1 node, 1 CPU
[    0.041483] smpboot: Total of 1 processors activated (5187.98 BogoMIPS)
[    0.042427] devtmpfs: initialized
[    0.042950] x86/mm: Memory block size: 128MB
[    0.043416] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
[    0.044026] futex hash table entries: 256 (order: 2, 16384 bytes)
[    0.044802] pinctrl core: initialized pinctrl subsystem
[    0.045120] RTC time: 18:18:10, date: 12/02/17
[    0.045775] NET: Registered protocol family 16
[    0.046224] cpuidle: using governor menu
[    0.047013] PCCT header not found.
[    0.047582] ACPI: bus type PCI registered
[    0.048007] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
[    0.048884] PCI: Using configuration type 1 for base access
[    0.051287] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages
[    0.052014] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
[    0.053046] ACPI: Added _OSI(Module Device)
[    0.053558] ACPI: Added _OSI(Processor Device)
[    0.054005] ACPI: Added _OSI(3.0 _SCP Extensions)
[    0.054530] ACPI: Added _OSI(Processor Aggregator Device)
[    0.056216] ACPI: Interpreter enabled
[    0.056784] ACPI: (supports S0 S3 S4 S5)
[    0.057010] ACPI: Using IOAPIC for interrupt routing
[    0.057594] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[    0.060787] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[    0.061013] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI]
[    0.061754] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
[    0.062016] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
[    0.063337] acpiphp: Slot [2] registered
[    0.063793] acpiphp: Slot [3] registered
[    0.064032] acpiphp: Slot [4] registered
[    0.064484] acpiphp: Slot [5] registered
[    0.064926] acpiphp: Slot [6] registered
[    0.065028] acpiphp: Slot [7] registered
[    0.065494] acpiphp: Slot [8] registered
[    0.065970] acpiphp: Slot [9] registered
[    0.066040] acpiphp: Slot [10] registered
[    0.066533] acpiphp: Slot [11] registered
[    0.067024] acpiphp: Slot [12] registered
[    0.067507] acpiphp: Slot [13] registered
[    0.068038] acpiphp: Slot [14] registered
[    0.068528] acpiphp: Slot [15] registered
[    0.069053] acpiphp: Slot [16] registered
[    0.069556] acpiphp: Slot [17] registered
[    0.070039] acpiphp: Slot [18] registered
[    0.070529] acpiphp: Slot [19] registered
[    0.071024] acpiphp: Slot [20] registered
[    0.071517] acpiphp: Slot [21] registered
[    0.072014] acpiphp: Slot [22] registered
[    0.072506] acpiphp: Slot [23] registered
[    0.072994] acpiphp: Slot [24] registered
[    0.073042] acpiphp: Slot [25] registered
[    0.073533] acpiphp: Slot [26] registered
[    0.074025] acpiphp: Slot [27] registered
[    0.074506] acpiphp: Slot [28] registered
[    0.074983] acpiphp: Slot [29] registered
[    0.075035] acpiphp: Slot [30] registered
[    0.075527] acpiphp: Slot [31] registered
[    0.076050] PCI host bridge to bus 0000:00
[    0.076546] pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7 window]
[    0.077009] pci_bus 0000:00: root bus resource [io  0x0d00-0xffff window]
[    0.077756] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
[    0.078011] pci_bus 0000:00: root bus resource [mem 0x1f400000-0xfebfffff window]
[    0.078857] pci_bus 0000:00: root bus resource [bus 00-ff]
[    0.084033] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io  0x01f0-0x01f7]
[    0.084833] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io  0x03f6]
[    0.085021] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io  0x0170-0x0177]
[    0.085960] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io  0x0376]
[    0.086700] pci 0000:00:01.3: quirk: [io  0x0600-0x063f] claimed by PIIX4 ACPI
[    0.087028] pci 0000:00:01.3: quirk: [io  0x0700-0x070f] claimed by PIIX4 SMB
[    0.117348] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
[    0.118091] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
[    0.118819] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
[    0.119096] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
[    0.119779] ACPI: PCI Interrupt Link [LNKS] (IRQs *9)
[    0.121000] ACPI: Enabled 2 GPEs in block 00 to 0F
[    0.121131] vgaarb: loaded
[    0.121627] SCSI subsystem initialized
[    0.122084] usbcore: USB support disabled
[    0.122624] EDAC MC: Ver: 3.0.0
[    0.123181] PCI: Using ACPI for IRQ routing
[    0.124070] NetLabel: Initializing
[    0.124509] NetLabel:  domain hash size = 128
[    0.125005] NetLabel:  protocols = UNLABELED CIPSOv4 CALIPSO
[    0.125701] NetLabel:  unlabeled traffic allowed by default
[    0.126195] clocksource: Switched to clocksource kvm-clock
[    0.179195] VFS: Disk quotas dquot_6.6.0
[    0.179723] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[    0.180753] pnp: PnP ACPI init
[    0.181715] pnp: PnP ACPI: found 5 devices
[    0.194906] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
[    0.196271] NET: Registered protocol family 2
[    0.197083] TCP established hash table entries: 4096 (order: 3, 32768 bytes)
[    0.197938] TCP bind hash table entries: 4096 (order: 4, 65536 bytes)
[    0.198710] TCP: Hash tables configured (established 4096 bind 4096)
[    0.199456] UDP hash table entries: 256 (order: 1, 8192 bytes)
[    0.200089] UDP-Lite hash table entries: 256 (order: 1, 8192 bytes)
[    0.200794] NET: Registered protocol family 1
[    0.201266] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
[    0.201934] pci 0000:00:01.0: PIIX3: Enabling Passive Release
[    0.202586] pci 0000:00:01.0: Activating ISA DMA hang workarounds
[    0.203357] Unpacking initramfs...
[    0.204848] Freeing initrd memory: 552K
[    0.205719] alg: self-tests disabled
[    0.206329] audit: initializing netlink subsys (disabled)
[    0.207326] Initialise system trusted keyrings
[    0.207859] Key type blacklist registered
[    0.208359] audit: type=2000 audit(1512238691.313:1): state=initialized audit_enabled=0 res=1
[    0.209270] workingset: timestamp_bits=36 max_order=17 bucket_order=0
[    0.211488] zbud: loaded
[    0.213866] NET: Registered protocol family 38
[    0.214388] Key type asymmetric registered
[    0.214830] Asymmetric key parser 'x509' registered
[    0.215505] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)
[    0.216410] io scheduler noop registered
[    0.216867] io scheduler deadline registered
[    0.217501] io scheduler cfq registered (default)
[    0.218063] io scheduler mq-deadline registered
[    0.218671] atomic64_test: passed for x86-64 platform with CX8 and with SSE
[    0.219771] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0
[    0.220674] ACPI: Power Button [PWRF]
[    0.221322] GHES: HEST is not enabled!
[    0.221878] Serial: 8250/16550 driver, 1 ports, IRQ sharing enabled
[    0.247931] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
[    0.249137] Non-volatile memory driver v1.3
[    0.249622] Linux agpgart interface v0.103
[    0.251430] scsi host0: ata_piix
[    0.251945] scsi host1: ata_piix
[    0.252413] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc0a0 irq 14
[    0.253789] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc0a8 irq 15
[    0.254696] libphy: Fixed MDIO Bus: probed
[    0.255387] usbserial: usb_serial_init - usb_register failed
[    0.256070] usbserial: usb_serial_init - returning with error -19
[    0.256877] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
[    0.258536] serio: i8042 KBD port at 0x60,0x64 irq 1
[    0.259117] serio: i8042 AUX port at 0x60,0x64 irq 12
[    0.259762] mousedev: PS/2 mouse device common for all mice
[    0.260632] rtc_cmos 00:00: RTC can wake from S4
[    0.261453] rtc_cmos 00:00: rtc core: registered rtc_cmos as rtc0
[    0.262258] rtc_cmos 00:00: alarms up to one day, y3k, 114 bytes nvram
[    0.263145] device-mapper: uevent: version 1.0.3
[    0.263743] device-mapper: ioctl: 4.37.0-ioctl (2017-09-20) initialised: dm-devel at redhat.com
[    0.270804] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1
[    0.280238] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4
[    0.281482] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3
[    0.282926] hidraw: raw HID events driver (C) Jiri Kosina
[    0.283696] drop_monitor: Initializing network drop monitor service
[    0.288738] ip_tables: (C) 2000-2006 Netfilter Core Team
[    0.289376] Initializing XFRM netlink socket
[    0.290042] NET: Registered protocol family 10
[    0.291335] Segment Routing with IPv6
[    0.291760] mip6: Mobile IPv6
[    0.295287] NET: Registered protocol family 17
[    0.296065] RAS: Correctable Errors collector initialized.
[    0.296688] AVX2 version of gcm_enc/dec engaged.
[    0.297234] AES CTR mode by8 optimization enabled
[    0.298065] sched_clock: Marking stable (298006939, 0)->(963793643, -665786704)
[    0.301614] registered taskstats version 1
[    0.302185] Loading compiled-in X.509 certificates
[    0.303798] Loaded X.509 cert 'Fedora kernel signing key: 51c174b3b29f2bca25259469ca1630e13d5d4e40'
[    0.304866] zswap: loaded using pool lzo/zbud
[    0.306061] Key type big_key registered
[    0.306601] Key type encrypted registered
[    0.307360]   Magic number: 13:367:341
[    0.307718] rtc_cmos 00:00: setting system clock to 2017-12-02 18:18:11 UTC (1512238691)
[    0.451314] Freeing unused kernel memory: 2224K
[    0.451930] Write protecting the kernel read-only data: 14336k
[    0.453088] Freeing unused kernel memory: 1396K
[    0.455261] Freeing unused kernel memory: 336K
[    0.458145] x86/mm: Checked W+X mappings: passed, no W+X pages found.
[    0.462954] rodata_test: all tests were successful
supermin: mounting /proc
supermin: ext2 mini initrd starting up: 5.1.19 dietlibc
supermin: cmdline: panic=1 console=ttyS0 edd=off udevtimeout=6000 udev.event-timeout=6000 no_timer_check printk.time=1 cgroup_disable=memory usbcore.nousb cryptomgr.notests tsc=reliable 8250.nr_uarts=1 root=/dev/sdb selinux=0 guestfs_verbose=1 TERM=xterm-256color
supermin: uptime: 0.46 0.17
supermin: mounting /sys
supermin: internal insmod crc32-pclmul.ko
supermin: internal insmod crc32c-intel.ko
supermin: internal insmod crct10dif-pclmul.ko
supermin: internal insmod crc32_generic.ko
supermin: internal insmod nfit.ko
supermin: internal insmod virtio.ko
supermin: internal insmod virtio_ring.ko
supermin: internal insmod virtio_blk.ko
supermin: internal insmod virtio-rng.ko
supermin: internal insmod virtio_console.ko
supermin: internal insmod crypto_engine.ko
supermin: internal insmod virtio_crypto.ko
supermin: internal insmod virtio_net.ko
supermin: internal insmod nd_btt.ko
supermin: internal insmod nd_pmem.ko
supermin: internal insmod virtio_scsi.ko
supermin: internal insmod virtio_balloon.ko
supermin: internal insmod virtio_input.ko
supermin: internal insmod virtio_mmio.ko
supermin: internal insmod virtio_pci.ko
[    0.546186] ACPI: PCI Interrupt Link [LNKB] enabled at IRQ 10
[    0.611483] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 11
[    0.616020] scsi host2: Virtio SCSI HBA
[    0.694682] ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 11
[    0.725435] scsi 2:0:0:0: Direct-Access     QEMU     QEMU HARDDISK    2.5+ PQ: 0 ANSI: 5
[    0.726642] scsi 2:0:1:0: Direct-Access     QEMU     QEMU HARDDISK    2.5+ PQ: 0 ANSI: 5
[    0.773695] random: crng init done
[    0.794300] sd 2:0:0:0: Attached scsi generic sg0 type 0
[    0.795201] sd 2:0:1:0: Attached scsi generic sg1 type 0
[    0.796099] sd 2:0:0:0: [sda] 8 512-byte logical blocks: (4.10 kB/4.00 KiB)
[    0.809355] sd 2:0:0:0: [sda] Write Protect is off
[    0.809997] sd 2:0:1:0: [sdb] 8388608 512-byte logical blocks: (4.29 GB/4.00 GiB)
[    0.810842] sd 2:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[    0.811980] sd 2:0:1:0: [sdb] Write Protect is off
[    0.822165] sd 2:0:1:0: [sdb] Write cache: enabled, read cache: ennbdkit: nbd.1: debug: acquire unload prevention lock
nbdkit: nbd.1: debug: pread count=4096 offset=0
nbdkit: nbd.1: debug: sending request with type 0 and cookie 0x900000008
abled, doesn't support DPO or FUA
nbdkit: nbd.1: debug: acquire unload prevention lock
nbdkit: nbd.1: debug: pread count=4096 offset=0
nbdkit: nbd.1: debug: sending request with type 0 and cookie 0x900000008
nbdkit: file.1: debug: acquire unload prevention lock
nbdkit: file.1: debug: pread count=4096 offset=0
nbdkit: file.1: debug: release unload prevention lock
nbdkit: debug: received reply for cookie 0x900000008
nbdkit: nbd.1: debug: release unload prevention lock
nbdkit: debug: received reply for cookie 0x900000008
nbdkit: nbd.1: debug: release unload prevention lock
[    0.827525] sd 2:0:1:0: [sdb] Attached SCSI disk
[    0.828283] Dev sda: unable to read RDB block 8
[    0.828930]  sda: unable to read partition table
[    0.829520] sda: partition table beyond EOD, enabling native capacity
nbdkit: nbd.2: debug: acquire unload prevention lock
nbdkit: nbd.2: debug: pread count=4096 offset=0
nbdkit: nbd.2: debug: sending request with type 0 and cookie 0x900000008
nbdkit: nbd.2: debug: acquire unload prevention lock
nbdkit: nbd.2: debug: pread count=4096 offset=0
nbdkit: nbd.2: debug: sending request with type 0 and cookie 0x900000008
nbdkit: file.1: debug: acquire unload prevention lock
nbdkit: file.1: debug: pread count=4096 offset=0
nbdkit: file.1: debug: release unload prevention lock
nbdkit: debug: received reply for cookie 0x900000008
nbdkit: nbd.2: debug: release unload prevention lock
nbdkit: debug: received reply for cookie 0x900000008
nbdkit: nbd.2: debug: release unload prevention lock
[    0.843392] Dev sda: unable to read RDB block 8
[    0.843920]  sda: unable to read partition table
[    0.844655] sda: partition table beyond EOD, truncated
[    0.847783] sd 2:0:0:0: [sda] Attached SCSI disk
supermin: internal insmod crc-itu-t.ko
supermin: internal insmod crc4.ko
supermin: internal insmod crc7.ko
supermin: internal insmod crc8.ko
supermin: internal insmod libcrc32c.ko
supermin: picked /sys/block/sdb/dev (8:16) as root device
supermin: creating /dev/root as block special 8:16
supermin: mounting new root on /root
[    0.859706] EXT4-fs (sdb): mounting ext2 file system using the ext4 subsystem
[    0.875937] EXT4-fs (sdb): mounted filesystem without journal. Opts: 
supermin: deleting initramfs files
supermin: chroot
Starting /init script ...
+ [[ panic=1 console=ttyS0 edd=off udevtimeout=6000 udev.event-timeout=6000 no_timer_check printk.time=1 cgroup_disable=memory usbcore.nousb cryptomgr.notests tsc=reliable 8250.nr_uarts=1 root=/dev/sdb selinux=0 guestfs_verbose=1 TERM=xterm-256color == *guestfs_network=1* ]]
+ [[ panic=1 console=ttyS0 edd=off udevtimeout=6000 udev.event-timeout=6000 no_timer_check printk.time=1 cgroup_disable=memory usbcore.nousb cryptomgr.notests tsc=reliable 8250.nr_uarts=1 root=/dev/sdb selinux=0 guestfs_verbose=1 TERM=xterm-256color == *guestfs_rescue=1* ]]
+ [[ panic=1 console=ttyS0 edd=off udevtimeout=6000 udev.event-timeout=6000 no_timer_check printk.time=1 cgroup_disable=memory usbcore.nousb cryptomgr.notests tsc=reliable 8250.nr_uarts=1 root=/dev/sdb selinux=0 guestfs_verbose=1 TERM=xterm-256color == *guestfs_noreboot=1* ]]
+ [[ panic=1 console=ttyS0 edd=off udevtimeout=6000 udev.event-timeout=6000 no_timer_check printk.time=1 cgroup_disable=memory usbcore.nousb cryptomgr.notests tsc=reliable 8250.nr_uarts=1 root=/dev/sdb selinux=0 guestfs_verbose=1 TERM=xterm-256color == *guestfs_boot_analysis=1* ]]
+ '[' '!' -d /sys ']'
+ mkdir -p /sys
+ mount -t sysfs /sys /sys
+ mkdir -p /run
+ mount -t tmpfs -o nosuid,size=20%,mode=0755 tmpfs /run
+ mkdir -p /run/lock
+ ln -s ../run/lock /var/lock
+ test -e /etc/mtab
+ ln -s /proc/mounts /etc/mtab
+ mount -t devtmpfs /dev /dev
+ mkdir -p /dev/pts
+ mount -t devpts /dev/pts /dev/pts
+ [[ panic=1 console=ttyS0 edd=off udevtimeout=6000 udev.event-timeout=6000 no_timer_check printk.time=1 cgroup_disable=memory usbcore.nousb cryptomgr.notests tsc=reliable 8250.nr_uarts=1 root=/dev/sdb selinux=0 guestfs_verbose=1 TERM=xterm-256color == *selinux=1* ]]
+ mkdir -p /run/tmpfiles.d
+ kmod static-nodes --format=tmpfiles --output=/run/tmpfiles.d/kmod.conf
++ od -x -A n
++ dd if=/dev/urandom bs=16 count=1 status=none
+ machine_id=' d1e7 b532 ceb8 1e56 e068 ee3e 9e7b 76eb'
+ echo d1e7b532ceb81e56e068ee3e9e7b76eb
+ systemd-tmpfiles --prefix=/dev --prefix=/run --prefix=/var/run --create --boot
[/usr/lib/tmpfiles.d/systemd.conf:11] Unknown group 'utmp'.
[/usr/lib/tmpfiles.d/systemd.conf:19] Unknown user 'systemd-network'.
[/usr/lib/tmpfiles.d/systemd.conf:20] Unknown user 'systemd-network'.
[/usr/lib/tmpfiles.d/systemd.conf:21] Unknown user 'systemd-network'.
[/usr/lib/tmpfiles.d/systemd.conf:25] Unknown group 'systemd-journal'.
[/usr/lib/tmpfiles.d/systemd.conf:26] Unknown group 'systemd-journal'.
+ for f in /lib/systemd/systemd-udevd /usr/lib/systemd/systemd-udevd /sbin/udevd /lib/udev/udevd /usr/lib/udev/udevd
+ '[' -x /lib/systemd/systemd-udevd ']'
+ UDEVD=/lib/systemd/systemd-udevd
+ break
+ '[' -z /lib/systemd/systemd-udevd ']'
+ /lib/systemd/systemd-udevd --daemon
starting version 233
+ udevadm trigger
+ udevadm settle --timeout=600
[    1.325804] tsc: Refined TSC clocksource calibration: 2593.997 MHz
[    1.326601] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x25641593871, max_idle_ns: 440795323545 ns
[    1.530638] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0
[    1.546355] ppdev: user-space parallel port driver
nbdkit: nbd.3: debug: acquire unload prevention lock
nbdkit: nbd.3: debug: pread count=4096 offset=0
nbdkit: nbd.3: debug: sending request with type 0 and cookie 0x900000008
nbdkit: nbd.3: debug: acquire unload prevention lock
nbdkit: nbd.3: debug: pread count=4096 offset=0
nbdkit: nbd.3: debug: sending request with type 0 and cookie 0x900000008
nbdkit: file.1: debug: acquire unload prevention lock
nbdkit: file.1: debug: pread count=4096 offset=0
nbdkit: file.1: debug: release unload prevention lock
nbdkit: debug: received reply for cookie 0x900000008
nbdkit: nbd.3: debug: release unload prevention lock
nbdkit: debug: received reply for cookie 0x900000008
nbdkit: nbd.3: debug: release unload prevention lock
[    1.608491] input: PC Speaker as /devices/platform/pcspkr/input/input5
nbdkit: nbd.4: debug: acquire unload prevention lock
nbdkit: nbd.4: debug: pread count=4096 offset=0
nbdkit: nbd.4: debug: sending request with type 0 and cookie 0x900000008
nbdkit: nbd.4: debug: acquire unload prevention lock
nbdkit: nbd.4: debug: pread count=4096 offset=0
nbdkit: nbd.4: debug: sending request with type 0 and cookie 0x900000008
nbdkit: file.1: debug: acquire unload prevention lock
nbdkit: file.1: debug: pread count=4096 offset=0
nbdkit: file.1: debug: release unload prevention lock
nbdkit: debug: received reply for cookie 0x900000008
nbdkit: nbd.4: debug: release unload prevention lock
nbdkit: debug: received reply for cookie 0x900000008
nbdkit: nbd.4: debug: release unload prevention lock
+ shopt -s nullglob
+ for f in /sys/block/sd*/device/timeout
+ echo 300
+ for f in /sys/block/sd*/device/timeout
+ echo 300
+ for f in /sys/block/{h,s,ub,v}d*/queue/scheduler
+ echo noop
+ for f in /sys/block/{h,s,ub,v}d*/queue/scheduler
+ echo noop
+ shopt -u nullglob
+ ip addr add 127.0.0.1/8 brd + dev lo scope host
+ ip link set dev lo up
+ test '' = 1
+ mdadm -As --auto=yes --run
nbdkit: nbd.0: debug: acquire unload prevention lock
nbdkit: nbd.0: debug: pread count=512 offset=3072
nbdkit: nbd.0: debug: sending request with type 0 and cookie 0x900000008
nbdkit: nbd.0: debug: acquire unload prevention lock
nbdkit: nbd.0: debug: pread count=512 offset=3072
nbdkit: nbd.0: debug: sending request with type 0 and cookie 0x900000008
nbdkit: file.1: debug: acquire unload prevention lock
nbdkit: file.1: debug: pread count=512 offset=3072
nbdkit: file.1: debug: release unload prevention lock
nbdkit: debug: received reply for cookie 0x900000008
nbdkit: nbd.0: debug: release unload prevention lock
nbdkit: debug: received reply for cookie 0x900000008
nbdkit: nbd.0: debug: release unload prevention lock
nbdkit: nbd.5: debug: acquire unload prevention lock
nbdkit: nbd.5: debug: pread count=512 offset=0
nbdkit: nbd.5: debug: sending request with type 0 and cookie 0x900000008
nbdkit: nbd.5: debug: acquire unload prevention lock
nbdkit: nbd.5: debug: pread count=512 offset=0
nbdkit: nbd.5: debug: sending request with type 0 and cookie 0x900000008
nbdkit: file.1: debug: acquire unload prevention lock
nbdkit: file.1: debug: pread count=512 offset=0
nbdkit: file.1: debug: release unload prevention lock
nbdkit: debug: received reply for cookie 0x900000008
nbdkit: nbd.5: debug: release unload prevention lock
nbdkit: debug: received reply for cookie 0x900000008
nbdkit: nbd.5: debug: release unload prevention lock
nbdkit: nbd.6: debug: acquire unload prevention lock
nbdkit: nbd.6: debug: pread count=512 offset=0
nbdkit: nbd.6: debug: sending request with type 0 and cookie 0x900000008
nbdkit: nbd.6: debug: acquire unload prevention lock
nbdkit: nbd.6: debug: pread count=512 offset=0
nbdkit: nbd.6: debug: sending request with type 0 and cookie 0x900000008
nbdkit: file.1: debug: acquire unload prevention lock
nbdkit: file.1: debug: pread count=512 offset=0
nbdkit: file.1: debug: release unload prevention lock
nbdkit: debug: received reply for cookie 0x900000008
nbdkit: nbd.6: debug: release unload prevention lock
nbdkit: debug: received reply for cookie 0x900000008
nbdkit: nbd.6: debug: release unload prevention lock
mdadm: No arrays found in config file or automatically
+ modprobe dm_mod
+ lvm vgchange -aay --sysinit
  WARNING: Failed to connect to lvmetad. Falling back to device scanning.
+ ldmtool create all
nbdkit: nbd.7: debug: acquire unload prevention lock
nbdkit: nbd.7: debug: pread count=4096 offset=0
nbdkit: nbd.7: debug: sending request with type 0 and cookie 0x900000008
nbdkit: nbd.7: debug: acquire unload prevention lock
nbdkit: nbd.7: debug: pread count=4096 offset=0
nbdkit: nbd.7: debug: sending request with type 0 and cookie 0x900000008
nbdkit: file.1: debug: acquire unload prevention lock
nbdkit: file.1: debug: pread count=4096 offset=0
nbdkit: file.1: debug: release unload prevention lock
nbdkit: debug: received reply for cookie 0x900000008
nbdkit: nbd.7: debug: release unload prevention lock
nbdkit: debug: received reply for cookie 0x900000008
nbdkit: nbd.7: debug: release unload prevention lock
[
]
+ test 1 = 1
+ test '' '!=' 1
+ uname -a
Linux (none) 4.13.10-200.fc26.x86_64 #1 SMP Fri Oct 27 15:34:40 UTC 2017 x86_64 x86_64 x86_64 GNU/Linux
+ ls -lR /dev
/dev:
total 0
crw------- 1 root root  10, 235 Dec  2 18:18 autofs
drwxr-xr-x 2 root root       80 Dec  2 18:18 block
drwxr-xr-x 2 root root       80 Dec  2 18:18 bsg
crw------- 1 root root  10, 234 Dec  2 18:18 btrfs-control
drwxr-xr-x 2 root root     2300 Dec  2 18:18 char
crw------- 1 root root   5,   1 Dec  2 18:18 console
lrwxrwxrwx 1 root root       11 Dec  2 18:18 core -> /proc/kcore
drwxr-xr-x 3 root root       60 Dec  2 18:18 cpu
crw------- 1 root root  10,  62 Dec  2 18:18 cpu_dma_latency
drwxr-xr-x 5 root root      100 Dec  2 18:18 disk
lrwxrwxrwx 1 root root       13 Dec  2 18:18 fd -> /proc/self/fd
crw-rw-rw- 1 root root   1,   7 Dec  2 18:18 full
crw-rw-rw- 1 root root  10, 229 Dec  2 18:18 fuse
crw------- 1 root root  10, 228 Dec  2 18:18 hpet
crw------- 1 root root  10, 183 Dec  2 18:18 hwrng
drwxr-xr-x 3 root root      220 Dec  2 18:18 input
crw-r--r-- 1 root root   1,  11 Dec  2 18:18 kmsg
crw-rw---- 1 root disk  10, 237 Dec  2 18:18 loop-control
drwxr-xr-x 2 root root       60 Dec  2 18:18 mapper
crw------- 1 root root  10, 227 Dec  2 18:18 mcelog
crw------- 1 root root   1,   1 Dec  2 18:18 mem
crw------- 1 root root  10,  59 Dec  2 18:18 memory_bandwidth
drwxr-xr-x 2 root root       60 Dec  2 18:18 net
crw------- 1 root root  10,  61 Dec  2 18:18 network_latency
crw------- 1 root root  10,  60 Dec  2 18:18 network_throughput
crw-rw-rw- 1 root root   1,   3 Dec  2 18:18 null
crw------- 1 root root  10, 144 Dec  2 18:18 nvram
crw------- 1 root root   1,   4 Dec  2 18:18 port
crw------- 1 root root 108,   0 Dec  2 18:18 ppp
crw-rw-rw- 1 root root   5,   2 Dec  2 18:18 ptmx
drwxr-xr-x 2 root root        0 Dec  2 18:18 pts
crw-rw-rw- 1 root root   1,   8 Dec  2 18:18 random
drwxr-xr-x 2 root root       60 Dec  2 18:18 raw
lrwxrwxrwx 1 root root        4 Dec  2 18:18 rtc -> rtc0
crw------- 1 root root 250,   0 Dec  2 18:18 rtc0
brw------- 1 root root   8,   0 Dec  2 18:18 sda
brw------- 1 root root   8,  16 Dec  2 18:18 sdb
crw------- 1 root root  21,   0 Dec  2 18:18 sg0
crw------- 1 root root  21,   1 Dec  2 18:18 sg1
crw------- 1 root root  10, 231 Dec  2 18:18 snapshot
drwxr-xr-x 3 root root      140 Dec  2 18:18 snd
lrwxrwxrwx 1 root root       15 Dec  2 18:18 stderr -> /proc/self/fd/2
lrwxrwxrwx 1 root root       15 Dec  2 18:18 stdin -> /proc/self/fd/0
lrwxrwxrwx 1 root root       15 Dec  2 18:18 stdout -> /proc/self/fd/1
crw-rw-rw- 1 root root   5,   0 Dec  2 18:18 tty
crw------- 1 root root   4,   0 Dec  2 18:18 tty0
crw------- 1 root root   4,   1 Dec  2 18:18 tty1
crw------- 1 root root   4,  10 Dec  2 18:18 tty10
crw------- 1 root root   4,  11 Dec  2 18:18 tty11
crw------- 1 root root   4,  12 Dec  2 18:18 tty12
crw------- 1 root root   4,  13 Dec  2 18:18 tty13
crw------- 1 root root   4,  14 Dec  2 18:18 tty14
crw------- 1 root root   4,  15 Dec  2 18:18 tty15
crw------- 1 root root   4,  16 Dec  2 18:18 tty16
crw------- 1 root root   4,  17 Dec  2 18:18 tty17
crw------- 1 root root   4,  18 Dec  2 18:18 tty18
crw------- 1 root root   4,  19 Dec  2 18:18 tty19
crw------- 1 root root   4,   2 Dec  2 18:18 tty2
crw------- 1 root root   4,  20 Dec  2 18:18 tty20
crw------- 1 root root   4,  21 Dec  2 18:18 tty21
crw------- 1 root root   4,  22 Dec  2 18:18 tty22
crw------- 1 root root   4,  23 Dec  2 18:18 tty23
crw------- 1 root root   4,  24 Dec  2 18:18 tty24
crw------- 1 root root   4,  25 Dec  2 18:18 tty25
crw------- 1 root root   4,  26 Dec  2 18:18 tty26
crw------- 1 root root   4,  27 Dec  2 18:18 tty27
crw------- 1 root root   4,  28 Dec  2 18:18 tty28
crw------- 1 root root   4,  29 Dec  2 18:18 tty29
crw------- 1 root root   4,   3 Dec  2 18:18 tty3
crw------- 1 root root   4,  30 Dec  2 18:18 tty30
crw------- 1 root root   4,  31 Dec  2 18:18 tty31
crw------- 1 root root   4,  32 Dec  2 18:18 tty32
crw------- 1 root root   4,  33 Dec  2 18:18 tty33
crw------- 1 root root   4,  34 Dec  2 18:18 tty34
crw------- 1 root root   4,  35 Dec  2 18:18 tty35
crw------- 1 root root   4,  36 Dec  2 18:18 tty36
crw------- 1 root root   4,  37 Dec  2 18:18 tty37
crw------- 1 root root   4,  38 Dec  2 18:18 tty38
crw------- 1 root root   4,  39 Dec  2 18:18 tty39
crw------- 1 root root   4,   4 Dec  2 18:18 tty4
crw------- 1 root root   4,  40 Dec  2 18:18 tty40
crw------- 1 root root   4,  41 Dec  2 18:18 tty41
crw------- 1 root root   4,  42 Dec  2 18:18 tty42
crw------- 1 root root   4,  43 Dec  2 18:18 tty43
crw------- 1 root root   4,  44 Dec  2 18:18 tty44
crw------- 1 root root   4,  45 Dec  2 18:18 tty45
crw------- 1 root root   4,  46 Dec  2 18:18 tty46
crw------- 1 root root   4,  47 Dec  2 18:18 tty47
crw------- 1 root root   4,  48 Dec  2 18:18 tty48
crw------- 1 root root   4,  49 Dec  2 18:18 tty49
crw------- 1 root root   4,   5 Dec  2 18:18 tty5
crw------- 1 root root   4,  50 Dec  2 18:18 tty50
crw------- 1 root root   4,  51 Dec  2 18:18 tty51
crw------- 1 root root   4,  52 Dec  2 18:18 tty52
crw------- 1 root root   4,  53 Dec  2 18:18 tty53
crw------- 1 root root   4,  54 Dec  2 18:18 tty54
crw------- 1 root root   4,  55 Dec  2 18:18 tty55
crw------- 1 root root   4,  56 Dec  2 18:18 tty56
crw------- 1 root root   4,  57 Dec  2 18:18 tty57
crw------- 1 root root   4,  58 Dec  2 18:18 tty58
crw------- 1 root root   4,  59 Dec  2 18:18 tty59
crw------- 1 root root   4,   6 Dec  2 18:18 tty6
crw------- 1 root root   4,  60 Dec  2 18:18 tty60
crw------- 1 root root   4,  61 Dec  2 18:18 tty61
crw------- 1 root root   4,  62 Dec  2 18:18 tty62
crw------- 1 root root   4,  63 Dec  2 18:18 tty63
crw------- 1 root root   4,   7 Dec  2 18:18 tty7
crw------- 1 root root   4,   8 Dec  2 18:18 tty8
crw------- 1 root root   4,   9 Dec  2 18:18 tty9
crw------- 1 root root   4,  64 Dec  2 18:18 ttyS0
crw------- 1 root root  10, 239 Dec  2 18:18 uhid
crw------- 1 root root  10, 223 Dec  2 18:18 uinput
crw-rw-rw- 1 root root   1,   9 Dec  2 18:18 urandom
crw------- 1 root root 247,   0 Dec  2 18:18 usbmon0
crw------- 1 root root   7,   0 Dec  2 18:18 vcs
crw------- 1 root root   7,   1 Dec  2 18:18 vcs1
crw------- 1 root root   7, 128 Dec  2 18:18 vcsa
crw------- 1 root root   7, 129 Dec  2 18:18 vcsa1
drwxr-xr-x 2 root root       60 Dec  2 18:18 vfio
crw------- 1 root root  10,  63 Dec  2 18:18 vga_arbiter
crw------- 1 root root  10, 137 Dec  2 18:18 vhci
crw------- 1 root root  10, 238 Dec  2 18:18 vhost-net
crw------- 1 root root  10, 241 Dec  2 18:18 vhost-vsock
drwxr-xr-x 2 root root       60 Dec  2 18:18 virtio-ports
crw------- 1 root root 245,   1 Dec  2 18:18 vport2p1
crw-rw-rw- 1 root root   1,   5 Dec  2 18:18 zero

/dev/block:
total 0
lrwxrwxrwx 1 root root 6 Dec  2 18:18 8:0 -> ../sda
lrwxrwxrwx 1 root root 6 Dec  2 18:18 8:16 -> ../sdb

/dev/bsg:
total 0
crw------- 1 root root 248, 0 Dec  2 18:18 2:0:0:0
crw------- 1 root root 248, 1 Dec  2 18:18 2:0:1:0

/dev/char:
total 0
lrwxrwxrwx 1 root root  8 Dec  2 18:18 10:144 -> ../nvram
lrwxrwxrwx 1 root root  8 Dec  2 18:18 10:183 -> ../hwrng
lrwxrwxrwx 1 root root  9 Dec  2 18:18 10:227 -> ../mcelog
lrwxrwxrwx 1 root root  7 Dec  2 18:18 10:228 -> ../hpet
lrwxrwxrwx 1 root root 11 Dec  2 18:18 10:231 -> ../snapshot
lrwxrwxrwx 1 root root  9 Dec  2 18:18 10:235 -> ../autofs
lrwxrwxrwx 1 root root 17 Dec  2 18:18 10:236 -> ../mapper/control
lrwxrwxrwx 1 root root 19 Dec  2 18:18 10:59 -> ../memory_bandwidth
lrwxrwxrwx 1 root root 21 Dec  2 18:18 10:60 -> ../network_throughput
lrwxrwxrwx 1 root root 18 Dec  2 18:18 10:61 -> ../network_latency
lrwxrwxrwx 1 root root 18 Dec  2 18:18 10:62 -> ../cpu_dma_latency
lrwxrwxrwx 1 root root 14 Dec  2 18:18 10:63 -> ../vga_arbiter
lrwxrwxrwx 1 root root 16 Dec  2 18:18 116:2 -> ../snd/controlC0
lrwxrwxrwx 1 root root 15 Dec  2 18:18 116:3 -> ../snd/pcmC0D0p
lrwxrwxrwx 1 root root 12 Dec  2 18:18 116:33 -> ../snd/timer
lrwxrwxrwx 1 root root 15 Dec  2 18:18 13:32 -> ../input/mouse0
lrwxrwxrwx 1 root root 15 Dec  2 18:18 13:33 -> ../input/mouse1
lrwxrwxrwx 1 root root 13 Dec  2 18:18 13:63 -> ../input/mice
lrwxrwxrwx 1 root root 15 Dec  2 18:18 13:64 -> ../input/event0
lrwxrwxrwx 1 root root 15 Dec  2 18:18 13:65 -> ../input/event1
lrwxrwxrwx 1 root root 15 Dec  2 18:18 13:66 -> ../input/event2
lrwxrwxrwx 1 root root 15 Dec  2 18:18 13:67 -> ../input/event3
lrwxrwxrwx 1 root root 15 Dec  2 18:18 13:68 -> ../input/event4
lrwxrwxrwx 1 root root 13 Dec  2 18:18 162:0 -> ../raw/rawctl
lrwxrwxrwx 1 root root  6 Dec  2 18:18 1:1 -> ../mem
lrwxrwxrwx 1 root root  7 Dec  2 18:18 1:11 -> ../kmsg
lrwxrwxrwx 1 root root  7 Dec  2 18:18 1:3 -> ../null
lrwxrwxrwx 1 root root  7 Dec  2 18:18 1:4 -> ../port
lrwxrwxrwx 1 root root  7 Dec  2 18:18 1:5 -> ../zero
lrwxrwxrwx 1 root root  7 Dec  2 18:18 1:7 -> ../full
lrwxrwxrwx 1 root root  9 Dec  2 18:18 1:8 -> ../random
lrwxrwxrwx 1 root root 10 Dec  2 18:18 1:9 -> ../urandom
lrwxrwxrwx 1 root root 12 Dec  2 18:18 202:0 -> ../cpu/0/msr
lrwxrwxrwx 1 root root 14 Dec  2 18:18 203:0 -> ../cpu/0/cpuid
lrwxrwxrwx 1 root root  6 Dec  2 18:18 21:0 -> ../sg0
lrwxrwxrwx 1 root root  6 Dec  2 18:18 21:1 -> ../sg1
lrwxrwxrwx 1 root root 11 Dec  2 18:18 245:1 -> ../vport2p1
lrwxrwxrwx 1 root root 10 Dec  2 18:18 247:0 -> ../usbmon0
lrwxrwxrwx 1 root root 14 Dec  2 18:18 248:0 -> ../bsg/2:0:0:0
lrwxrwxrwx 1 root root 14 Dec  2 18:18 248:1 -> ../bsg/2:0:1:0
lrwxrwxrwx 1 root root  7 Dec  2 18:18 250:0 -> ../rtc0
lrwxrwxrwx 1 root root  7 Dec  2 18:18 4:0 -> ../tty0
lrwxrwxrwx 1 root root  7 Dec  2 18:18 4:1 -> ../tty1
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:10 -> ../tty10
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:11 -> ../tty11
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:12 -> ../tty12
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:13 -> ../tty13
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:14 -> ../tty14
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:15 -> ../tty15
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:16 -> ../tty16
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:17 -> ../tty17
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:18 -> ../tty18
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:19 -> ../tty19
lrwxrwxrwx 1 root root  7 Dec  2 18:18 4:2 -> ../tty2
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:20 -> ../tty20
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:21 -> ../tty21
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:22 -> ../tty22
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:23 -> ../tty23
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:24 -> ../tty24
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:25 -> ../tty25
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:26 -> ../tty26
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:27 -> ../tty27
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:28 -> ../tty28
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:29 -> ../tty29
lrwxrwxrwx 1 root root  7 Dec  2 18:18 4:3 -> ../tty3
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:30 -> ../tty30
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:31 -> ../tty31
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:32 -> ../tty32
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:33 -> ../tty33
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:34 -> ../tty34
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:35 -> ../tty35
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:36 -> ../tty36
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:37 -> ../tty37
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:38 -> ../tty38
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:39 -> ../tty39
lrwxrwxrwx 1 root root  7 Dec  2 18:18 4:4 -> ../tty4
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:40 -> ../tty40
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:41 -> ../tty41
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:42 -> ../tty42
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:43 -> ../tty43
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:44 -> ../tty44
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:45 -> ../tty45
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:46 -> ../tty46
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:47 -> ../tty47
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:48 -> ../tty48
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:49 -> ../tty49
lrwxrwxrwx 1 root root  7 Dec  2 18:18 4:5 -> ../tty5
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:50 -> ../tty50
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:51 -> ../tty51
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:52 -> ../tty52
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:53 -> ../tty53
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:54 -> ../tty54
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:55 -> ../tty55
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:56 -> ../tty56
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:57 -> ../tty57
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:58 -> ../tty58
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:59 -> ../tty59
lrwxrwxrwx 1 root root  7 Dec  2 18:18 4:6 -> ../tty6
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:60 -> ../tty60
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:61 -> ../tty61
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:62 -> ../tty62
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:63 -> ../tty63
lrwxrwxrwx 1 root root  8 Dec  2 18:18 4:64 -> ../ttyS0
lrwxrwxrwx 1 root root  7 Dec  2 18:18 4:7 -> ../tty7
lrwxrwxrwx 1 root root  7 Dec  2 18:18 4:8 -> ../tty8
lrwxrwxrwx 1 root root  7 Dec  2 18:18 4:9 -> ../tty9
lrwxrwxrwx 1 root root  6 Dec  2 18:18 5:0 -> ../tty
lrwxrwxrwx 1 root root 10 Dec  2 18:18 5:1 -> ../console
lrwxrwxrwx 1 root root  7 Dec  2 18:18 5:2 -> ../ptmx
lrwxrwxrwx 1 root root  6 Dec  2 18:18 7:0 -> ../vcs
lrwxrwxrwx 1 root root  7 Dec  2 18:18 7:1 -> ../vcs1
lrwxrwxrwx 1 root root  7 Dec  2 18:18 7:128 -> ../vcsa
lrwxrwxrwx 1 root root  8 Dec  2 18:18 7:129 -> ../vcsa1

/dev/cpu:
total 0
drwxr-xr-x 2 root root 80 Dec  2 18:18 0

/dev/cpu/0:
total 0
crw------- 1 root root 203, 0 Dec  2 18:18 cpuid
crw------- 1 root root 202, 0 Dec  2 18:18 msr

/dev/disk:
total 0
drwxr-xr-x 2 root root 80 Dec  2 18:18 by-id
drwxr-xr-x 2 root root 80 Dec  2 18:18 by-path
drwxr-xr-x 2 root root 60 Dec  2 18:18 by-uuid

/dev/disk/by-id:
total 0
lrwxrwxrwx 1 root root 9 Dec  2 18:18 scsi-0QEMU_QEMU_HARDDISK_appliance -> ../../sdb
lrwxrwxrwx 1 root root 9 Dec  2 18:18 scsi-0QEMU_QEMU_HARDDISK_hd0 -> ../../sda

/dev/disk/by-path:
total 0
lrwxrwxrwx 1 root root 9 Dec  2 18:18 pci-0000:00:03.0-scsi-0:0:0:0 -> ../../sda
lrwxrwxrwx 1 root root 9 Dec  2 18:18 pci-0000:00:03.0-scsi-0:0:1:0 -> ../../sdb

/dev/disk/by-uuid:
total 0
lrwxrwxrwx 1 root root 9 Dec  2 18:18 30008a2e-77c6-49a2-9283-7ee454762d7b -> ../../sdb

/dev/input:
total 0
drwxr-xr-x 2 root root     60 Dec  2 18:18 by-path
crw------- 1 root root 13, 64 Dec  2 18:18 event0
crw------- 1 root root 13, 65 Dec  2 18:18 event1
crw------- 1 root root 13, 66 Dec  2 18:18 event2
crw------- 1 root root 13, 67 Dec  2 18:18 event3
crw------- 1 root root 13, 68 Dec  2 18:18 event4
crw------- 1 root root 13, 63 Dec  2 18:18 mice
crw------- 1 root root 13, 32 Dec  2 18:18 mouse0
crw------- 1 root root 13, 33 Dec  2 18:18 mouse1

/dev/input/by-path:
total 0
lrwxrwxrwx 1 root root 9 Dec  2 18:18 platform-pcspkr-event-spkr -> ../event4

/dev/mapper:
total 0
crw------- 1 root root 10, 236 Dec  2 18:18 control

/dev/net:
total 0
crw-rw-rw- 1 root root 10, 200 Dec  2 18:18 tun

/dev/pts:
total 0
c--------- 1 root root 5, 2 Dec  2 18:18 ptmx

/dev/raw:
total 0
crw------- 1 root root 162, 0 Dec  2 18:18 rawctl

/dev/snd:
total 0
drwxr-xr-x 2 root root       60 Dec  2 18:18 by-path
crw-rw---- 1 root audio 116,  2 Dec  2 18:18 controlC0
crw-rw---- 1 root audio 116,  3 Dec  2 18:18 pcmC0D0p
crw-rw---- 1 root audio 116,  1 Dec  2 18:18 seq
crw-rw---- 1 root audio 116, 33 Dec  2 18:18 timer

/dev/snd/by-path:
total 0
lrwxrwxrwx 1 root root 12 Dec  2 18:18 platform-pcspkr -> ../controlC0

/dev/vfio:
total 0
crw------- 1 root root 10, 196 Dec  2 18:18 vfio

/dev/virtio-ports:
total 0
lrwxrwxrwx 1 root root 11 Dec  2 18:18 org.libguestfs.channel.0 -> ../vport2p1
+ cat /proc/mounts
/dev/root / ext2 rw,noatime,block_validity,barrier,user_xattr,acl 0 0
/proc /proc proc rw,relatime 0 0
/sys /sys sysfs rw,relatime 0 0
tmpfs /run tmpfs rw,nosuid,relatime,size=97040k,mode=755 0 0
/dev /dev devtmpfs rw,relatime,size=240340k,nr_inodes=60085,mode=755 0 0
/dev/pts /dev/pts devpts rw,relatime,mode=600,ptmxmode=000 0 0
+ lvm pvs
  WARNING: Failed to connect to lvmetad. Falling back to device scanning.
+ lvm vgs
  WARNING: Failed to connect to lvmetad. Falling back to device scanning.
+ lvm lvs
  WARNING: Failed to connect to lvmetad. Falling back to device scanning.
+ ip a
1: lo: <LOOPBACK,UP,LOWER_UP> mtu 65536 qdisc noqueue state UNKNOWN group default qlen 1000
    link/loopback 00:00:00:00:00:00 brd 00:00:00:00:00:00
    inet 127.0.0.1/8 brd 127.255.255.255 scope host lo
       valid_lft forever preferred_lft forever
    inet6 ::1/128 scope host 
       valid_lft forever preferred_lft forever
+ ip r
+ lsmod
Module                  Size  Used by
snd_pcsp               20480  0
snd_pcm                98304  1 snd_pcsp
joydev                 20480  0
serio_raw              16384  0
ppdev                  20480  0
parport_pc             28672  0
i2c_piix4              24576  0
snd_timer              32768  1 snd_pcm
snd                    81920  3 snd_pcsp,snd_timer,snd_pcm
soundcore              16384  1 snd
parport                49152  2 parport_pc,ppdev
ghash_clmulni_intel    16384  0
qemu_fw_cfg            16384  0
ata_generic            16384  0
pata_acpi              16384  0
libcrc32c              16384  0
crc8                   16384  0
crc7                   16384  0
crc4                   16384  0
crc_itu_t              16384  0
virtio_pci             24576  0
virtio_mmio            16384  0
virtio_input           16384  0
virtio_balloon         20480  0
virtio_scsi            20480  1
nd_pmem                16384  0
nd_btt                 24576  1 nd_pmem
virtio_net             40960  0
virtio_crypto          20480  0
crypto_engine          16384  1 virtio_crypto
virtio_console         28672  0
virtio_rng             16384  0
virtio_blk             20480  0
virtio_ring            24576  10 virtio_input,virtio_blk,virtio_net,virtio_rng,virtio_mmio,virtio_scsi,virtio_balloon,virtio_crypto,virtio_console,virtio_pci
virtio                 16384  10 virtio_input,virtio_blk,virtio_net,virtio_rng,virtio_mmio,virtio_scsi,virtio_balloon,virtio_crypto,virtio_console,virtio_pci
nfit                   53248  0
crc32_generic          16384  0
crct10dif_pclmul       16384  0
crc32c_intel           24576  1
crc32_pclmul           16384  0
+ date
Sat Dec  2 18:18:13 UTC 2017
+ echo -n 'clocksource: '
clocksource: + cat /sys/devices/system/clocksource/clocksource0/current_clocksource
kvm-clock
+ echo -n 'uptime: '
uptime: + cat /proc/uptime
1.98 0.19
+ cmd=guestfsd
++ grep -Eo 'guestfs_channel=[^[:space:]]+' /proc/cmdline
+ eval
+ test x '!=' x
+ test 1 = 1
+ cmd='guestfsd --verbose'
+ test '' = 1
+ test '' = 1
+ echo guestfsd --verbose
guestfsd --verbose
+ guestfsd --verbose
lvm config:
lvmetad
trying to open virtio-serial channel '/dev/virtio-ports/org.libguestfs.channel.0'
commandrvf: stdout=n stderr=y flags=0x0
commandrvf: udevadm --debug settle
calling: settle
libguestfs: recv_from_daemon: received GUESTFS_LAUNCH_FLAG
libguestfs: appliance is up
libguestfs: trace: launch = 0
libguestfs: trace: pread_device "/dev/sda" 4096 0
guestfsd: main_loop: new request, len 0x40
commandrvf: stdout=n stderr=y flags=0x0
commandrvf: udevadm --debug settle -E /dev/sda
calling: settle
nbdkit: nbd.8: debug: acquire unload prevention lock
nbdkit: nbd.8: debug: pread count=4096 offset=0
nbdkit: nbd.8: debug: sending request with type 0 and cookie 0x900000008
nbdkit: nbd.8: debug: acquire unload prevention lock
nbdkit: nbd.8: debug: pread count=4096 offset=0
nbdkit: nbd.8: debug: sending request with type 0 and cookie 0x900000008
nbdkit: file.9: debug: acquire unload prevention lock
nbdkit: file.9: debug: pread count=4096 offset=0
nbdkit: file.9: debug: release unload prevention lock
nbdkit: debug: received reply for cookie 0x900000008
nbdkit: nbd.8: debug: release unload prevention lock
nbdkit: debug: received reply for cookie 0x900000008
nbdkit: nbd.8: debug: release unload prevention lock
libguestfs: trace: pread_device = "\x01\x02\x03\x04\x05\x06\x07\x08\x01\x02\x03\x04\x05\x06\x07\x08\x01\x02\x03\x04\x05\x06\x07\x08\x01\x02\x03\x04\x05\x06\x07\x08\x01\x02\x03\x04\x05\x06\x07\x08\x01\x02\x03\x04\x05\x06\x07\x08\x01\x02\x03\x04\x05\x06\x07\x08\x01\x02\x03\x04\x05\x06\x07\x08\x01\x02\x03\x04\x05\x06\x07\x08\x01\x02\x03\x04\x05\x06\x07\x08\x01\x02\x03\x04\x05\x06\x07\x08\x01\x02\x03\x04\x05\x06\x07\x08\x01\x02\x03\x04\x05\x06\x07\x08\x01\x02\x03\x04\x05\x06\x07\x08\x01\x02\x03\x04\x05\x06\x07\x08\x01\x02\x03\x04\x05\x06\x07\x08\x01\x02\x03\x04\x05\x06\x07\x08\x01\x02\x03\x04\x05\x06\x07\x08\x01\x02\x03\x04\x05\x06\x07\x08\x01\x02\x03\x04\x05\x06\x07\x08\x01\x02\x03\x04\x05\x06\x07\x08\x01\x02\x03\x04\x05\x06\x07\x08\x01\x02\x03\x04\x05\x06\x07\x08\x01\x02\x03\x04\x05\x06\x07\x08\x01\x02\x03\x04\x05\x06\x07\x08\x01\x02\x03\x04\x05\x06\x07\x08\x01\x02\x03\x04\x05\x06\x07\x08\x01\x02\x03\x04\x05\x06\x07\x08\x01\x02\x03\x04\x05\x06\x07\x08\x01\x02\x03\x04\x05\x06\x07\x08\x01\x02\x03\x04\x05\x06\x07\x08\x01\x02\x03\x04\x05\x06\x07\x08"<truncated, original size 4096 bytes>
libguestfs: trace: close
libguestfs: closing guestfs handle 0x24282d0 (state 2)
libguestfs: trace: internal_autosync
guestfsd: main_loop: proc 276 (pread_device) took 0.00 seconds
guestfsd: main_loop: new request, len 0x28
umount-all: /proc/mounts: fsname=/dev/root dir=/ type=ext2 opts=rw,noatime,block_validity,barrier,user_xattr,acl freq=0 passno=0
umount-all: /proc/mounts: fsname=/proc dir=/proc type=proc opts=rw,relatime freq=0 passno=0
umount-all: /proc/mounts: fsname=/sys dir=/sys type=sysfs opts=rw,relatime freq=0 passno=0
umount-all: /proc/mounts: fsname=tmpfs dir=/run type=tmpfs opts=rw,nosuid,relatime,size=97040k,mode=755 freq=0 passno=0
umount-all: /proc/mounts: fsname=/dev dir=/dev type=devtmpfs opts=rw,relatime,size=240340k,nr_inodes=60085,mode=755 freq=0 passno=0
umount-all: /proc/mounts: fsname=/dev/pts dir=/dev/pts type=devpts opts=rw,relatime,mode=600,ptmxmode=000 freq=0 passno=0
commandrvf: stdout=n stderr=y flags=0x0
commandrvf: udevadm --debug settle -E /dev/sdb
calling: settle
commandrvf: stdout=n stderr=y flags=0x0
commandrvf: udevadm --debug settle -E /dev/sda
calling: settle
nbdkit: nbd.9: debug: acquire unload prevention lock
nbdkit: nbd.9: debug: flush
fsync /dev/sda
nbdkit: nbd.9: debug: sending request with type 3 and cookie 0x900000008
nbdkit: nbd.9: debug: acquire unload prevention lock
nbdkit: nbd.9: debug: flush
nbdkit: nbd.9: debug: sending request with type 3 and cookie 0x900000008
nbdkit: file.10: debug: acquire unload prevention lock
nbdkit: file.10: debug: flush
nbdkit: file.10: debug: release unload prevention lock
nbdkit: debug: received reply for cookie 0x900000008
nbdkit: nbd.9: debug: release unload prevention lock
nbdkit: debug: received reply for cookie 0x900000008
nbdkit: nbd.9: debug: release unload prevention lock
libguestfs: trace: internal_autosync = 0
libguestfs: sending SIGTERM to process 18183
nbdkit: nbd.10: debug: acquire unload prevention lock
nbdkit: nbd.10: debug: flush
nbdkit: nbd.10: debug: sending request with type 3 and cookie 0x900000008
nbdkit: nbd.10: debug: acquire unload prevention lock
nbdkit: nbd.10: debug: flush
nbdkit: nbd.10: debug: sending request with type 3 and cookie 0x900000008
nbdkit: file.11: debug: acquire unload prevention lock
nbdkit: file.11: debug: flush
nbdkit: file.11: debug: release unload prevention lock
nbdkit: debug: received reply for cookie 0x900000008
nbdkit: nbd.10: debug: release unload prevention lock
nbdkit: debug: received reply for cookie 0x900000008
nbdkit: nbd.10: debug: release unload prevention lock
nbdkit: nbd.11: debug: acquire unload prevention lock
nbdkit: nbd.11: debug: flush
nbdkit: nbd.11: debug: sending request with type 3 and cookie 0x900000008
nbdkit: nbd.11: debug: acquire unload prevention lock
nbdkit: nbd.11: debug: flush
nbdkit: nbd.11: debug: sending request with type 3 and cookie 0x900000008
nbdkit: file.0: debug: acquire unload prevention lock
nbdkit: file.0: debug: flush
nbdkit: file.0: debug: release unload prevention lock
nbdkit: debug: received reply for cookie 0x900000008
nbdkit: nbd.11: debug: release unload prevention lock
nbdkit: debug: received reply for cookie 0x900000008
nbdkit: nbd.11: debug: release unload prevention lock
nbdkit: nbd.12: debug: client sent disconnect command, closing connection
nbdkit: nbd.12: debug: exiting worker thread nbd.12
nbdkit: nbd.13: debug: client closed input socket, closing connection
nbdkit: nbd.13: debug: exiting worker thread nbd.13
nbdkit: nbd.14: debug: client closed input socket, closing connection
nbdkit: nbd.14: debug: exiting worker thread nbd.14
nbdkit: nbd.15: debug: client closed input socket, closing connection
nbdkit: nbd.15: debug: exiting worker thread nbd.15
nbdkit: nbd.1: debug: client closed input socket, closing connection
nbdkit: nbd.1: debug: exiting worker thread nbd.1
nbdkit: nbd.2: debug: client closed input socket, closing connection
nbdkit: nbd.2: debug: exiting worker thread nbd.2
nbdkit: nbd.3: debug: client closed input socket, closing connection
nbdkit: nbd.3: debug: exiting worker thread nbd.3
nbdkit: nbd.4: debug: client closed input socket, closing connection
nbdkit: nbd.4: debug: exiting worker thread nbd.4
nbdkit: nbd.0: debug: client closed input socket, closing connection
nbdkit: nbd.0: debug: exiting worker thread nbd.0
nbdkit: nbd.5: debug: client closed input socket, closing connection
nbdkit: nbd.5: debug: exiting worker thread nbd.5
nbdkit: nbd.6: debug: client closed input socket, closing connection
nbdkit: nbd.6: debug: exiting worker thread nbd.6
nbdkit: nbd.7: debug: client closed input socket, closing connection
nbdkit: nbd.7: debug: exiting worker thread nbd.7
nbdkit: nbd.8: debug: client closed input socket, closing connection
nbdkit: nbd.8: debug: exiting worker thread nbd.8
nbdkit: nbd.9: debug: client closed input socket, closing connection
nbdkit: nbd.9: debug: exiting worker thread nbd.9
nbdkit: nbd.10: debug: client closed input socket, closing connection
nbdkit: nbd.10: debug: exiting worker thread nbd.10
nbdkit: nbd.11: debug: client closed input socket, closing connection
nbdkit: nbd.11: debug: exiting worker thread nbd.11
libguestfs: qemu maxrss 166484K
libguestfs: command: run: rm
libguestfs: command: run: \ -rf /tmp/libguestfsYp1w4f
libguestfs: command: run: rm
libguestfs: command: run: \ -rf /run/user/1000/libguestfsUEHqc9
nbdkit: nbd[1]: debug: connection cleanup with final status 0
nbdkit: nbd[1]: debug: close
nbdkit: nbd[1]: debug: sending request with type 2 and cookie 0
nbdkit: nbd.12: debug: client sent disconnect command, closing connection
nbdkit: nbd.12: debug: exiting worker thread nbd.12
nbdkit: debug: /home/rjones/d/nbdkit/plugins/nbd/.libs/nbdkit-nbd-plugin.so: unload
==18105== 
nbdkit: ==18105== HEAP SUMMARY:
==18105==     in use at exit: 2,473 bytes in 16 blocks
==18105==   total heap usage: 2,298 allocs, 2,282 frees, 307,606 bytes allocated
==18105== 
nbd.13: debug: client closed input socket, closing connection
nbdkit: nbd.13: debug: exiting worker thread nbd.13
nbdkit: nbd.14: debug: client closed input socket, closing connection
nbdkit: nbd.14: debug: exiting worker thread nbd.14
nbdkit: nbd.15: debug: client closed input socket, closing connection
nbdkit: nbd.15: debug: exiting worker thread nbd.15
nbdkit: nbd.1: debug: client closed input socket, closing connection
nbdkit: nbd.1: debug: exiting worker thread nbd.1
nbdkit: nbd.2: debug: client closed input socket, closing connection
nbdkit: nbd.2: debug: exiting worker thread nbd.2
nbdkit: nbd.3: debug: client closed input socket, closing connection
nbdkit: nbd.3: debug: exiting worker thread nbd.3
nbdkit: nbd.4: debug: client closed input socket, closing connection
nbdkit: nbd.4: debug: exiting worker thread nbd.4
nbdkit: nbd.0: debug: client closed input socket, closing connection
nbdkit: nbd.0: debug: exiting worker thread nbd.0
nbdkit: nbd.5: debug: client closed input socket, closing connection
nbdkit: nbd.5: debug: exiting worker thread nbd.5
nbdkit: nbd.6: debug: client closed input socket, closing connection
nbdkit: nbd.6: debug: exiting worker thread nbd.6
nbdkit: nbd.7: debug: client closed input socket, closing connection
nbdkit: nbd.7: debug: exiting worker thread nbd.7
nbdkit: nbd.8: debug: client closed input socket, closing connection
nbdkit: nbd.8: debug: exiting worker thread nbd.8
nbdkit: nbd.9: debug: client closed input socket, closing connection
nbdkit: nbd.9: debug: exiting worker thread nbd.9
nbdkit: nbd.10: debug: client closed input socket, closing connection
nbdkit: nbd.10: debug: exiting worker thread nbd.10
nbdkit: nbd.11: debug: client closed input socket, closing connection
nbdkit: nbd.11: debug: exiting worker thread nbd.11
nbdkit: nbd[1]: debug: connection cleanup with final status 0
nbdkit: nbd[1]: debug: close
nbdkit: nbd[1]: debug: sending request with type 2 and cookie 0
nbdkit: file.12: debug: client sent disconnect command, closing connection
nbdkit: file.12: debug: exiting worker thread file.12
==18105== LEAK SUMMARY:
==18105==    definitely lost: 0 bytes in 0 blocks
==18105==    indirectly lost: 0 bytes in 0 blocks
==18105==      possibly lost: 0 bytes in 0 blocks
==18105==    still reachable: 745 bytes in 10 blocks
==18105==         suppressed: 1,728 bytes in 6 blocks
==18105== Reachable blocks (those to which a pointer was found) are not shown.
==18105== To see them, rerun with: --leak-check=full --show-leak-kinds=all
==18105== 
==18105== For counts of detected and suppressed errors, rerun with: -v
==18105== ERROR SUMMARY: 23 errors from 2 contexts (suppressed: 3 from 3)
FAIL test-nbd (exit status: 119)




-- 
Richard Jones, Virtualization Group, Red Hat http://people.redhat.com/~rjones
Read my programming and virtualization blog: http://rwmj.wordpress.com
virt-p2v converts physical machines to virtual machines.  Boot with a
live CD or over the network (PXE) and turn machines into KVM guests.
http://libguestfs.org/virt-v2v




More information about the Libguestfs mailing list