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@redhat.com> Fixes: 7f5bb9bf13f041ea7702bda557d9dd668bc3423a Signed-off-by: Eric Blake <eblake@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@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@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