virt-builder is very slow in git master when building ubuntu 14.04 vm
Hi All, I been using virt-builder to create testing VMs (most ubuntu) for a while, and it works great. But when I cloned the git repo today and found the process becoming extremely slow, please see the output below. log that produced by pre-installed vendor package: virt-builder ubuntu-14.04 --firstboot-command 'useradd -m -p "" myan; chage -d 0 myan; usermod -aG sudo myan;' [ 3.0] Downloading: http://libguestfs.org/download/builder/ubuntu-14.04.xz [ 4.0] Planning how to build this image [ 4.0] Uncompressing [ 6.0] Opening the new disk [ 11.0] Setting a random seed [ 11.0] Installing firstboot command: [1] useradd -m -p "" myan; chage -d 0 myan; usermod -aG sudo myan; [ 11.0] Setting passwords virt-builder: Setting random password of root to 5bRx9fpQ7kjPh0Dd [ 12.0] Finishing off Output file: ubuntu-14.04.img Output size: 4.0G Output format: raw Total usable space: 2.9G Free space: 2.0G (69%) log that produced by git master: ~/vm$../work/libguestfs/run virt-builder ubuntu-14.04 --firstboot-command 'useradd -m -p "" myan; chage -d 0 myan; usermod -aG sudo myan;' [ 0.4] Downloading: file:///home/myan/work/libguestfs/builder/website/ubuntu-14.04.xz [ 1.7] Planning how to build this image [ 1.7] Uncompressing [ 4.4] Opening the new disk [ 628.3] Setting a random seed [ 628.4] Installing firstboot command: useradd -m -p "" myan; chage -d 0 myan; usermod -aG sudo myan; [ 628.4] Setting passwords virt-builder: Setting random password of root to owA2CFqJeDYT92Sq [ 629.4] Finishing off Output file: ubuntu-14.04.img Output size: 4.0G Output format: raw Total usable space: 2.9G Free space: 2.0G (69%) Turning on debug shows that it spent most of time spinning here: [...] /sbin/dhclient-script: 31: /sbin/dhclient-script: cannot open /etc/fstab: No such file RTNETLINK answers: File exists [...] Any idea what's the problem or is it a known issue ? Thanks. Miao
On Thu, Dec 03, 2015 at 07:16:31PM +0800, 阎淼 wrote:
[...] /sbin/dhclient-script: 31: /sbin/dhclient-script: cannot open /etc/fstab: No such file RTNETLINK answers: File exists [...]
Would need to see the complete log to find out what prints this. Rich. -- Richard Jones, Virtualization Group, Red Hat http://people.redhat.com/~rjones Read my programming and virtualization blog: http://rwmj.wordpress.com libguestfs lets you edit virtual machines. Supports shell scripting, bindings from many languages. http://libguestfs.org
Hi Rich, I set LIBGUESTFS_DEBUG=1 LIBGUESTFS_TRACE=1 when calling virt-builder, and here is the log: [ 0.1] Downloading: file:///home/myan/work/libguestfs/builder/website/ubuntu-14.04.xz [ 1.4] Planning how to build this image [ 1.4] Uncompressing [ 4.4] Opening the new disk libguestfs: trace: set_verbose true libguestfs: trace: set_verbose = 0 libguestfs: trace: set_tmpdir "/home/myan/work/libguestfs/tmp" libguestfs: trace: set_tmpdir = 0 libguestfs: trace: set_cachedir "/home/myan/work/libguestfs/tmp" libguestfs: trace: set_cachedir = 0 libguestfs: trace: set_path "/home/myan/work/libguestfs/appliance" libguestfs: trace: set_path = 0 libguestfs: create: flags = 0, handle = 0x11ce170, program = virt-builder libguestfs: trace: set_network true libguestfs: trace: set_network = 0 libguestfs: trace: set_selinux false libguestfs: trace: set_selinux = 0 libguestfs: trace: add_drive "ubuntu-14.04.img" "format:raw" "cachemode:unsafe" libguestfs: trace: add_drive = 0 libguestfs: trace: launch libguestfs: trace: get_tmpdir libguestfs: trace: get_tmpdir = "/home/myan/work/libguestfs/tmp" libguestfs: trace: version libguestfs: trace: version = <struct guestfs_version *> libguestfs: trace: get_backend libguestfs: trace: get_backend = "direct" libguestfs: launch: program=virt-builder libguestfs: launch: version=1.31.28 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=/home/myan/work/libguestfs/tmp/libguestfsPNyy0w 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 = "/home/myan/work/libguestfs/tmp" libguestfs: [00000ms] begin building supermin appliance libguestfs: [00000ms] 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 /home/myan/work/libguestfs/tmp/.guestfs-1000/lock libguestfs: command: run: \ --copy-kernel libguestfs: command: run: \ -f ext2 libguestfs: command: run: \ --host-cpu x86_64 libguestfs: command: run: \ /home/myan/work/libguestfs/appliance/supermin.d libguestfs: command: run: \ -o /home/myan/work/libguestfs/tmp/.guestfs-1000/appliance.d supermin: version: 5.1.9 supermin: package handler: debian/dpkg supermin: acquiring lock on /home/myan/work/libguestfs/tmp/.guestfs-1000/lock supermin: if-newer: output does not need rebuilding libguestfs: [00009ms] finished building supermin appliance libguestfs: [00009ms] begin testing qemu features libguestfs: command: run: /usr/bin/qemu-system-x86_64 libguestfs: command: run: \ -display none libguestfs: command: run: \ -help libguestfs: command: run: /usr/bin/qemu-system-x86_64 libguestfs: command: run: \ -display none libguestfs: command: run: \ -version libguestfs: qemu version 2.4 libguestfs: command: run: /usr/bin/qemu-system-x86_64 libguestfs: command: run: \ -display none libguestfs: command: run: \ -machine accel=kvm:tcg libguestfs: command: run: \ -device ? libguestfs: [00028ms] finished testing qemu features libguestfs: trace: get_backend_setting "gdb" libguestfs: trace: get_backend_setting = NULL (error) [00029ms] /usr/bin/qemu-system-x86_64 \ -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 /home/myan/work/libguestfs/tmp/.guestfs-1000/appliance.d/kernel \ -initrd /home/myan/work/libguestfs/tmp/.guestfs-1000/appliance.d/initrd \ -device virtio-scsi-pci,id=scsi \ -drive file=/home/myan/vm/ubuntu-14.04.img,cache=unsafe,format=raw,id=hd0,if=none \ -device scsi-hd,drive=hd0 \ -drive file=/home/myan/work/libguestfs/tmp/.guestfs-1000/appliance.d/root,snapshot=on,id=appliance,cache=unsafe,if=none \ -device scsi-hd,drive=appliance \ -device virtio-serial-pci \ -serial stdio \ -device sga \ -chardev socket,path=/home/myan/work/libguestfs/tmp/libguestfsPNyy0w/guestfsd.sock,id=channel0 \ -device virtserialport,chardev=channel0,name=org.libguestfs.channel.0 \ -netdev user,id=usernet,net=169.254.0.0/16 \ -device virtio-net-pci,netdev=usernet \ -append 'panic=1 console=ttyS0 udevtimeout=6000 udev.event-timeout=6000 no_timer_check acpi=off printk.time=1 cgroup_disable=memory root=/dev/sdb selinux=0 guestfs_verbose=1 guestfs_network=1 TERM=xterm' \x1b[1;256r\x1b[256;256H\x1b[6n Google, Inc. Serial Graphics Adapter 11/03/11 SGABIOS $Id$ (pbonzini@yakj.usersys.redhat.com) Thu Nov 3 13:33:51 UTC 2011 Term: 80x24 4 0 \x1b[2J SeaBIOS (version rel-1.8.2-0-g33fbe13 by qemu-project.org) iPXE (http://ipxe.org) 00:04.0 C100 PCI2.10 PnP PMM+1F393960+1F2F3960 C100 Press Ctrl-B to configure iPXE (PCI 00:04.0)... Booting from ROM... \x1b[2J[ 0.000000] Initializing cgroup subsys cpuset [ 0.000000] Initializing cgroup subsys cpu [ 0.000000] Initializing cgroup subsys cpuacct [ 0.000000] Linux version 3.19.0-15-generic (buildd@komainu) (gcc version 4.9.2 (Ubuntu 4.9.2-10ubuntu13) ) #15-Ubuntu SMP Thu Apr 16 23:32:37 UTC 2015 (Ubuntu 3.19.0-15.15-generic 3.19.3) [ 0.000000] Command line: panic=1 console=ttyS0 udevtimeout=6000 udev.event-timeout=6000 no_timer_check acpi=off printk.time=1 cgroup_disable=memory root=/dev/sdb selinux=0 guestfs_verbose=1 guestfs_network=1 TERM=xterm [ 0.000000] KERNEL supported cpus: [ 0.000000] Intel GenuineIntel [ 0.000000] AMD AuthenticAMD [ 0.000000] Centaur CentaurHauls [ 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-0x000000001f3dffff] usable [ 0.000000] BIOS-e820: [mem 0x000000001f3e0000-0x000000001f3fffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved [ 0.000000] NX (Execute Disable) protection: active [ 0.000000] SMBIOS 2.8 present. [ 0.000000] Hypervisor detected: KVM [ 0.000000] AGP: No AGP bridge found [ 0.000000] e820: last_pfn = 0x1f3e0 max_arch_pfn = 0x400000000 [ 0.000000] PAT configuration [0-7]: WB WC UC- UC WB WC UC- UC [ 0.000000] found SMP MP-table at [mem 0x000f64b0-0x000f64bf] mapped at [ffff8800000f64b0] [ 0.000000] Scanning 1 areas for low memory corruption [ 0.000000] Using GB pages for direct mapping [ 0.000000] init_memory_mapping: [mem 0x00000000-0x000fffff] [ 0.000000] init_memory_mapping: [mem 0x1f000000-0x1f1fffff] [ 0.000000] init_memory_mapping: [mem 0x00100000-0x1effffff] [ 0.000000] init_memory_mapping: [mem 0x1f200000-0x1f3dffff] [ 0.000000] RAMDISK: [mem 0x1f256000-0x1f3dffff] [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x000000001f3dffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x1f251000-0x1f255fff] [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000000] kvm-clock: cpu 0, msr 0:1f24d001, primary cpu clock [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x00001000-0x00ffffff] [ 0.000000] DMA32 [mem 0x01000000-0x1f3dffff] [ 0.000000] Normal empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x00001000-0x0009efff] [ 0.000000] node 0: [mem 0x00100000-0x1f3dffff] [ 0.000000] Initmem setup node 0 [mem 0x00001000-0x1f3dffff] [ 0.000000] SFI: Simple Firmware Interface v0.81 http://simplefirmware.org [ 0.000000] Intel MultiProcessor Specification v1.4 [ 0.000000] MPTABLE: OEM ID: BOCHSCPU [ 0.000000] MPTABLE: Product ID: 0.1 [ 0.000000] MPTABLE: APIC at: 0xFEE00000 [ 0.000000] Processor #0 (Bootup-CPU) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] Processors: 1 [ 0.000000] smpboot: Allowing 1 CPUs, 0 hotplug CPUs [ 0.000000] PM: Registered nosave memory: [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] setup_percpu: NR_CPUS:256 nr_cpumask_bits:256 nr_cpu_ids:1 nr_node_ids:1 [ 0.000000] PERCPU: Embedded 31 pages/cpu @ffff88001f000000 s87040 r8192 d31744 u2097152 [ 0.000000] KVM setup async PF for cpu 0 [ 0.000000] kvm-stealtime: cpu 0, msr 1f00e1c0 [ 0.000000] Built 1 zonelists in Node order, mobility grouping on. Total pages: 125849 [ 0.000000] Policy zone: DMA32 [ 0.000000] Kernel command line: panic=1 console=ttyS0 udevtimeout=6000 udev.event-timeout=6000 no_timer_check acpi=off printk.time=1 cgroup_disable=memory root=/dev/sdb selinux=0 guestfs_verbose=1 guestfs_network=1 TERM=xterm [ 0.000000] Disabling memory control group subsystem [ 0.000000] PID hash table entries: 2048 (order: 2, 16384 bytes) [ 0.000000] xsave: enabled xstate_bv 0x7, cntxt size 0x340 using standard form [ 0.000000] AGP: Checking aperture... [ 0.000000] AGP: No AGP bridge found [ 0.000000] Memory: 484928K/511480K available (7993K kernel code, 1232K rwdata, 3752K rodata, 1408K init, 1300K bss, 26552K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 [ 0.000000] Hierarchical RCU implementation. [ 0.000000] \tRCU dyntick-idle grace-period acceleration is enabled. [ 0.000000] \tRCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=1. [ 0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 [ 0.000000] NR_IRQS:16640 nr_irqs:256 16 [ 0.000000] \tOffload RCU callbacks from all CPUs [ 0.000000] \tOffload RCU callbacks from CPUs: 0. [ 0.000000] Console: colour *CGA 80x25 [ 0.000000] console [ttyS0] enabled [ 0.000000] tsc: Detected 1999.999 MHz processor [ 0.008000] Calibrating delay loop (skipped) preset value.. 3999.99 BogoMIPS (lpj=7999996) [ 0.008000] pid_max: default: 32768 minimum: 301 [ 0.008000] Security Framework initialized [ 0.008000] AppArmor: AppArmor initialized [ 0.008000] Yama: becoming mindful. [ 0.008000] Dentry cache hash table entries: 65536 (order: 7, 524288 bytes) [ 0.008115] Inode-cache hash table entries: 32768 (order: 6, 262144 bytes) [ 0.008971] Mount-cache hash table entries: 1024 (order: 1, 8192 bytes) [ 0.009774] Mountpoint-cache hash table entries: 1024 (order: 1, 8192 bytes) [ 0.010784] Initializing cgroup subsys memory [ 0.011323] Initializing cgroup subsys devices [ 0.012007] Initializing cgroup subsys freezer [ 0.012546] Initializing cgroup subsys net_cls [ 0.013063] Initializing cgroup subsys blkio [ 0.013567] Initializing cgroup subsys perf_event [ 0.014154] Initializing cgroup subsys net_prio [ 0.014684] Initializing cgroup subsys hugetlb [ 0.015307] mce: CPU supports 10 MCE banks [ 0.016056] Last level iTLB entries: 4KB 512, 2MB 8, 4MB 8 [ 0.016056] Last level dTLB entries: 4KB 512, 2MB 32, 4MB 32, 1GB 0 [ 0.033990] Freeing SMP alternatives memory: 32K (ffffffff81e96000 - ffffffff81e9e000) [ 0.039358] ftrace: allocating 30078 entries in 118 pages [ 0.048282] Enabling x2apic [ 0.048635] Enabled x2apic [ 0.049179] Switched APIC routing to physical x2apic. [ 0.052814] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.053462] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2620 0 @ 2.00GHz (fam: 06, model: 2d, stepping: 07) [ 0.054591] Performance Events: 16-deep LBR, SandyBridge events, Intel PMU driver. [ 0.068233] perf_event_intel: PEBS disabled due to CPU errata, please upgrade microcode [ 0.069086] ... version: 2 [ 0.069549] ... bit width: 48 [ 0.070015] ... generic registers: 4 [ 0.070494] ... value mask: 0000ffffffffffff [ 0.071057] ... max period: 000000007fffffff [ 0.071649] ... fixed-purpose events: 3 [ 0.072004] ... event mask: 000000070000000f [ 0.079094] KVM setup paravirtual spinlock [ 0.080298] x86: Booted up 1 node, 1 CPUs [ 0.080796] smpboot: Total of 1 processors activated (3999.99 BogoMIPS) [ 0.081815] NMI watchdog: disabled (cpu0): hardware events not enabled [ 0.082632] devtmpfs: initialized [ 0.085060] evm: security.selinux [ 0.085440] evm: security.SMACK64 [ 0.085794] evm: security.SMACK64EXEC [ 0.086199] evm: security.SMACK64TRANSMUTE [ 0.086666] evm: security.SMACK64MMAP [ 0.087062] evm: security.ima [ 0.087408] evm: security.capability [ 0.088037] pinctrl core: initialized pinctrl subsystem [ 0.088790] RTC time: 9:49:03, date: 12/04/15 [ 0.089363] NET: Registered protocol family 16 [ 0.090106] cpuidle: using governor ladder [ 0.090547] cpuidle: using governor menu [ 0.091245] PCI: Using configuration type 1 for base access [ 0.093175] ACPI: Interpreter disabled. [ 0.093704] vgaarb: loaded [ 0.094240] SCSI subsystem initialized [ 0.094778] usbcore: registered new interface driver usbfs [ 0.095396] usbcore: registered new interface driver hub [ 0.096018] usbcore: registered new device driver usb [ 0.096717] PCI: Probing PCI hardware [ 0.097146] PCI host bridge to bus 0000:00 [ 0.097596] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] [ 0.098314] pci_bus 0000:00: root bus resource [mem 0x00000000-0xffffffffff] [ 0.099115] pci_bus 0000:00: No busn resource found for root bus, will use [bus 00-ff] [ 0.106260] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.107048] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.107770] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.108006] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.109228] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.110031] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.155271] pci 0000:00:01.0: PIIX/ICH IRQ router [8086:7000] [ 0.156145] NetLabel: Initializing [ 0.156547] NetLabel: domain hash size = 128 [ 0.157021] NetLabel: protocols = UNLABELED CIPSOv4 [ 0.157565] NetLabel: unlabeled traffic allowed by default [ 0.158335] Switched to clocksource kvm-clock [ 0.162550] AppArmor: AppArmor Filesystem Enabled [ 0.163159] pnp: PnP ACPI: disabled [ 0.165000] NET: Registered protocol family 2 [ 0.165660] TCP established hash table entries: 4096 (order: 3, 32768 bytes) [ 0.166475] TCP bind hash table entries: 4096 (order: 4, 65536 bytes) [ 0.167174] TCP: Hash tables configured (established 4096 bind 4096) [ 0.168353] TCP: reno registered [ 0.168749] UDP hash table entries: 256 (order: 1, 8192 bytes) [ 0.169375] UDP-Lite hash table entries: 256 (order: 1, 8192 bytes) [ 0.170100] NET: Registered protocol family 1 [ 0.170588] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.171256] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.171904] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.172685] Trying to unpack rootfs image as initramfs... [ 0.174134] Freeing initrd memory: 1576K (ffff88001f256000 - ffff88001f3e0000) [ 0.175053] platform rtc_cmos: registered platform RTC device (no PNP device found) [ 0.198232] microcode: CPU0 sig=0x206d7, pf=0x1, revision=0x1 [ 0.198912] microcode: Microcode Update Driver: v2.00 <tigran@aivazian.fsnet.co.uk>, Peter Oruba [ 0.199906] Scanning for low memory corruption every 60 seconds [ 0.200821] futex hash table entries: 256 (order: 2, 16384 bytes) [ 0.201531] Initialise system trusted keyring [ 0.202057] audit: initializing netlink subsys (disabled) [ 0.202643] audit: type=2000 audit(1449222543.383:1): initialized [ 0.203636] HugeTLB registered 2 MB page size, pre-allocated 0 pages [ 0.206143] zpool: loaded [ 0.206448] zbud: loaded [ 0.206877] VFS: Disk quotas dquot_6.5.2 [ 0.207370] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.208564] fuse init (API version 7.23) [ 0.209147] Key type big_key registered [ 0.209822] Key type asymmetric registered [ 0.210309] Asymmetric key parser 'x509' registered [ 0.210861] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252) [ 0.211733] io scheduler noop registered [ 0.212233] io scheduler deadline registered (default) [ 0.212811] io scheduler cfq registered [ 0.213350] pci_hotplug: PCI Hot Plug PCI Core version: 0.5 [ 0.213966] pciehp: PCI Express Hot Plug Controller Driver version: 0.4 [ 0.214924] virtio-pci 0000:00:02.0: PCI->APIC IRQ transform: INT A -> IRQ 25 [ 0.215952] virtio-pci 0000:00:03.0: PCI->APIC IRQ transform: INT A -> IRQ 26 [ 0.217327] virtio-pci 0000:00:04.0: PCI->APIC IRQ transform: INT A -> IRQ 26 [ 0.218724] Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled [ 0.243732] serial8250: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 0.248585] Linux agpgart interface v0.103 [ 0.250573] brd: module loaded [ 0.251942] loop: module loaded [ 0.253385] scsi host0: ata_piix [ 0.253848] scsi host1: ata_piix [ 0.254250] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc080 irq 14 [ 0.255006] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc088 irq 15 [ 0.256075] libphy: Fixed MDIO Bus: probed [ 0.256514] tun: Universal TUN/TAP device driver, 1.6 [ 0.257094] tun: (C) 1999-2004 Max Krasnyansky <maxk@qualcomm.com> [ 0.258383] PPP generic driver version 2.4.2 [ 0.259121] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver [ 0.259862] ehci-pci: EHCI PCI platform driver [ 0.260369] ehci-platform: EHCI generic platform driver [ 0.261007] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver [ 0.261668] ohci-pci: OHCI PCI platform driver [ 0.262194] ohci-platform: OHCI generic platform driver [ 0.262788] uhci_hcd: USB Universal Host Controller Interface driver [ 0.263549] i8042: PNP: No PS/2 controller found. Probing ports directly. [ 0.264967] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 0.265541] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 0.266192] mousedev: PS/2 mouse device common for all mice [ 0.267076] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 [ 0.268532] rtc_cmos rtc_cmos: rtc core: registered rtc_cmos as rtc0 [ 0.269329] rtc_cmos rtc_cmos: alarms up to one day, 114 bytes nvram [ 0.270066] i2c /dev entries driver [ 0.270504] device-mapper: uevent: version 1.0.3 [ 0.271109] device-mapper: ioctl: 4.29.0-ioctl (2014-10-28) initialised: dm-devel@redhat.com [ 0.272087] ledtrig-cpu: registered to indicate activity on CPUs [ 0.272923] TCP: cubic registered [ 0.273426] NET: Registered protocol family 10 [ 0.274100] NET: Registered protocol family 17 [ 0.274667] Key type dns_resolver registered [ 0.275420] Loading compiled-in X.509 certificates [ 0.277015] Loaded X.509 cert 'Magrathea: Glacier signing key: 9e64807092f3a6a8f66f3b7ea4cb3767fdfae08a' [ 0.278106] registered taskstats version 1 [ 0.278737] Key type trusted registered [ 0.279400] Key type encrypted registered [ 0.279879] AppArmor: AppArmor sha1 policy hashing enabled [ 0.280532] ima: No TPM chip found, activating TPM-bypass! [ 0.281218] evm: HMAC attrs: 0x1 [ 0.281803] Magic number: 11:78:828 [ 0.282318] rtc_cmos rtc_cmos: setting system clock to 2015-12-04 09:49:03 UTC (1449222543) [ 0.283317] BIOS EDD facility v0.16 2004-Jun-25, 0 devices found [ 0.283996] EDD information not available. [ 0.412624] Freeing unused kernel memory: 1408K (ffffffff81d36000 - ffffffff81e96000) [ 0.414020] Write protecting the kernel read-only data: 12288k [ 0.415388] Freeing unused kernel memory: 188K (ffff8800017d1000 - ffff880001800000) [ 0.417120] Freeing unused kernel memory: 344K (ffff880001baa000 - ffff880001c00000) supermin: mounting /proc supermin: uptime: 0.41 0.17 supermin: ext2 mini initrd starting up: 5.1.9 zlib xz supermin: cmdline: panic=1 console=ttyS0 udevtimeout=6000 udev.event-timeout=6000 no_timer_check acpi=off printk.time=1 cgroup_disable=memory root=/dev/sdb selinux=0 guestfs_verbose=1 guestfs_network=1 TERM=xterm supermin: mounting /sys supermin: internal insmod crc32-pclmul.ko supermin: internal insmod crct10dif-pclmul.ko supermin: internal insmod crc32.ko supermin: internal insmod virtio-rng.ko supermin: internal insmod ideapad_slidebar.ko [ 0.434958] ideapad_slidebar: DMI does not match insmod: init_module: ideapad_slidebar.ko: No such device supermin: internal insmod sparse-keymap.ko supermin: internal insmod ideapad-laptop.ko supermin: internal insmod megaraid.ko supermin: internal insmod megaraid_mm.ko [ 0.446542] megaraid cmm: 2.20.2.7 (Release Date: Sun Jul 16 00:01:03 EST 2006) supermin: internal insmod megaraid_mbox.ko [ 0.450288] megaraid: 2.20.5.1 (Release Date: Thu Nov 16 15:32:35 EST 2006) supermin: internal insmod megaraid_sas.ko [ 0.455842] megasas: 06.805.06.01-rc1 supermin: internal insmod scsi_transport_spi.ko supermin: internal insmod sym53c8xx.ko supermin: internal insmod virtio_scsi.ko [ 0.465334] scsi host2: Virtio SCSI HBA [ 0.466447] scsi 2:0:0:0: Direct-Access QEMU QEMU HARDDISK 2.4. PQ: 0 ANSI: 5 [ 0.467930] scsi 2:0:1:0: Direct-Access QEMU QEMU HARDDISK 2.4. PQ: 0 ANSI: 5 [ 0.485455] sd 2:0:0:0: Attached scsi generic sg0 type 0 [ 0.486142] sd 2:0:0:0: [sda] 8388608 512-byte logical blocks: (4.29 GB/4.00 GiB) [ 0.487228] sd 2:0:1:0: Attached scsi generic sg1 type 0 [ 0.488066] sd 2:0:1:0: [sdb] 8388608 512-byte logical blocks: (4.29 GB/4.00 GiB) [ 0.489121] sd 2:0:0:0: [sda] Write Protect is off [ 0.489906] sd 2:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 0.491105] sd 2:0:1:0: [sdb] Write Protect is off [ 0.491853] sd 2:0:1:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 0.495243] sda: sda1 sda2 < sda5 > [ 0.497031] sdb: unknown partition table [ 0.498717] sd 2:0:0:0: [sda] Attached SCSI disk [ 0.499371] sd 2:0:1:0: [sdb] Attached SCSI disk supermin: internal insmod crc-ccitt.ko supermin: internal insmod crc-itu-t.ko supermin: internal insmod crc7.ko supermin: internal insmod crc8.ko supermin: internal insmod libcrc32c.ko supermin: picked /sys/block/sdb/dev as root device supermin: creating /dev/root as block special 8:16 supermin: mounting new root on /root [ 0.509068] EXT4-fs (sdb): mounting ext2 file system using the ext4 subsystem [ 0.528965] EXT4-fs (sdb): mounted filesystem without journal. Opts: supermin: chroot Starting /init script ... ln: failed to create symbolic link '/etc/mtab': File exists [ 0.656446] random: systemd-tmpfile urandom read with 39 bits of entropy available [/usr/lib/tmpfiles.d/systemd.conf:26] Failed to replace specifiers: /run/log/journal/%m [/usr/lib/tmpfiles.d/systemd.conf:28] Failed to replace specifiers: /run/log/journal/%m [/usr/lib/tmpfiles.d/systemd.conf:29] Failed to replace specifiers: /run/log/journal/%m [/usr/lib/tmpfiles.d/systemd.conf:32] Failed to replace specifiers: /var/log/journal/%m [/usr/lib/tmpfiles.d/systemd.conf:34] Failed to replace specifiers: /var/log/journal/%m [/usr/lib/tmpfiles.d/systemd.conf:35] Failed to replace specifiers: /var/log/journal/%m starting version 219 specified group 'tty' unknown specified group 'dialout' unknown specified group 'kmem' unknown specified group 'input' unknown specified group 'video' unknown specified group 'audio' unknown specified group 'lp' unknown specified group 'disk' unknown specified group 'cdrom' unknown specified group 'tape' unknown [ 0.700969] ACPI Exception: AE_BAD_PARAMETER, Thread 503150016 could not acquire Mutex [0x1] (20141107/utmutex-285) [ 0.702158] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 0.783386] AVX version of gcm_enc/dec engaged. [ 0.783955] AES CTR mode by8 optimization enabled [ 0.914717] intel_rapl: no valid rapl domains found in package 0 /init: 86: /init: cannot create /sys/block/{h,s,ub,v}d*/queue/scheduler: Directory nonexistent [ 1.775004] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input2 /sbin/dhclient-script: 31: /sbin/dhclient-script: cannot open /etc/fstab: No such file RTNETLINK answers: File exists /sbin/dhclient-script: 31: /sbin/dhclient-script: cannot open /etc/fstab: No such file RTNETLINK answers: File exists /sbin/dhclient-script: 31: /sbin/dhclient-script: cannot open /etc/fstab: No such file RTNETLINK answers: File exists /sbin/dhclient-script: 31: /sbin/dhclient-script: cannot open /etc/fstab: No such file [....] Then it spins here for like 10mins or more, so I killed the process. Thanks, Miao 2015-12-04 17:38 GMT+08:00 Richard W.M. Jones <rjones@redhat.com>:
On Thu, Dec 03, 2015 at 07:16:31PM +0800, 阎淼 wrote:
[...] /sbin/dhclient-script: 31: /sbin/dhclient-script: cannot open /etc/fstab: No such file RTNETLINK answers: File exists [...]
Would need to see the complete log to find out what prints this.
Rich.
-- Richard Jones, Virtualization Group, Red Hat http://people.redhat.com/~rjones Read my programming and virtualization blog: http://rwmj.wordpress.com libguestfs lets you edit virtual machines. Supports shell scripting, bindings from many languages. http://libguestfs.org
On Fri, Dec 04, 2015 at 06:00:39PM +0800, 阎淼 wrote:
/sys/block/{h,s,ub,v}d*/queue/scheduler: Directory nonexistent [ 1.775004] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input2 /sbin/dhclient-script: 31: /sbin/dhclient-script: cannot open /etc/fstab: No such file RTNETLINK answers: File exists
The failure is here: https://github.com/libguestfs/libguestfs/blob/master/appliance/init#L110-L11... But actually it's a failure in whatever provides the dhclient / dhclient-script in your host. What is the host system? This was reported before, but not resolved: https://www.redhat.com/archives/libguestfs/2015-June/msg00361.html It can be worked around by changing the code (see above) to use dhcpcd or another dhcp server. But basically it's a bug in your host distro that they are supplying a dhclient-script that doesn't work when /etc/fstab is missing, so you need to report it there. Rich. -- 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
2015-12-04 18:22 GMT+08:00 Richard W.M. Jones <rjones@redhat.com>:
On Fri, Dec 04, 2015 at 06:00:39PM +0800, 阎淼 wrote:
/sys/block/{h,s,ub,v}d*/queue/scheduler: Directory nonexistent [ 1.775004] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input2 /sbin/dhclient-script: 31: /sbin/dhclient-script: cannot open /etc/fstab: No such file RTNETLINK answers: File exists
The failure is here:
https://github.com/libguestfs/libguestfs/blob/master/appliance/init#L110-L11...
But actually it's a failure in whatever provides the dhclient / dhclient-script in your host. What is the host system?
It's Ubuntu 15.04 server.
This was reported before, but not resolved:
https://www.redhat.com/archives/libguestfs/2015-June/msg00361.html
It can be worked around by changing the code (see above) to use dhcpcd or another dhcp server. But basically it's a bug in your host distro that they are supplying a dhclient-script that doesn't work when /etc/fstab is missing, so you need to report it there.
I'll try the workaround. Thanks for your help. Miao
Rich.
-- 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
participants (2)
-
Richard W.M. Jones -
阎淼