阎淼
2015-Dec-03 11:16 UTC
[Libguestfs] 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
Richard W.M. Jones
2015-Dec-04 09:38 UTC
Re: [Libguestfs] virt-builder is very slow in git master when building ubuntu 14.04 vm
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
阎淼
2015-Dec-04 10:00 UTC
Re: [Libguestfs] virt-builder is very slow in git master when building ubuntu 14.04 vm
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
Possibly Parallel Threads
- Re: virt-df error, help
- supermin-helper: ext2: parent directory not found: /mnt/bigdata/var: File not found by ext2_lookup
- Re: virt-builder is very slow in git master when building ubuntu 14.04 vm
- Guestfish errors (Running in VirtualBox)
- Concurrent scanning of same disk