early console in setup code Probing EDD (edd=off to disable)... ok early console in decompress_kernel Decompressing Linux... Parsing ELF... done. Booting the kernel. [ 0.000000] Initializing cgroup subsys cpuset [ 0.000000] Initializing cgroup subsys cpu [ 0.000000] Linux version 4.1.0-rc2-00101-g5025fe5 (kbuild@athens) (gcc version 4.9.2 (Debian 4.9.2-10) ) #1 SMP Fri May 29 13:38:16 CST 2015 [ 0.000000] Command line: root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-kbuild-1G-15/bisect_xfstests-4HDD-btrfs-generic-slow1-debian-x86_64-2015-02-07.cgz-x86_64-rhel-5025fe55d485e2f08e99dce41e107c5b724ddf9c-4-20150529-13367-1c9wmmp.yaml ARCH=x86_64 kconfig=x86_64-rhel branch=cgroup/review-cgroup-writeback-switch-20150522 commit=5025fe55d485e2f08e99dce41e107c5b724ddf9c BOOT_IMAGE=/pkg/linux/x86_64-rhel/gcc-4.9/5025fe55d485e2f08e99dce41e107c5b724ddf9c/vmlinuz-4.1.0-rc2-00101-g5025fe5 max_uptime=3600 RESULT_ROOT=/result/xfstests/4HDD-btrfs-generic-slow1/vm-kbuild-1G/debian-x86_64-2015-02-07.cgz/x86_64-rhel/gcc-4.9/5025fe55d485e2f08e99dce41e107c5b724ddf9c/0 LKP_SERVER=inn earlyprintk=ttyS0,115200 systemd.log_level=err debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 console=ttyS0,115200 console=tty0 vga=normal rw ip=::::vm-kbuild-1G-15::dhcp [ 0.000000] e820: BIOS-provided physical RAM map: [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffdffff] usable [ 0.000000] BIOS-e820: [mem 0x000000003ffe0000-0x000000003fffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved [ 0.000000] bootconsole [earlyser0] enabled [ 0.000000] earlycon: no match for ttyS0,115200 [ 0.000000] earlycon: no match for tty0 [ 0.000000] NX (Execute Disable) protection: active [ 0.000000] SMBIOS 2.8 present. [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.7.5-20140531_083030-gandalf 04/01/2014 [ 0.000000] Hypervisor detected: KVM [ 0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved [ 0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable [ 0.000000] AGP: No AGP bridge found [ 0.000000] e820: last_pfn = 0x3ffe0 max_arch_pfn = 0x400000000 [ 0.000000] MTRR default type: write-back [ 0.000000] MTRR fixed ranges enabled: [ 0.000000] 00000-9FFFF write-back [ 0.000000] A0000-BFFFF uncachable [ 0.000000] C0000-FFFFF write-protect [ 0.000000] MTRR variable ranges enabled: [ 0.000000] 0 base 0080000000 mask FF80000000 uncachable [ 0.000000] 1 disabled [ 0.000000] 2 disabled [ 0.000000] 3 disabled [ 0.000000] 4 disabled [ 0.000000] 5 disabled [ 0.000000] 6 disabled [ 0.000000] 7 disabled [ 0.000000] PAT configuration [0-7]: WB WC UC- UC WB WC UC- UC [ 0.000000] Scan for SMP in [mem 0x00000000-0x000003ff] [ 0.000000] Scan for SMP in [mem 0x0009fc00-0x0009ffff] [ 0.000000] Scan for SMP in [mem 0x000f0000-0x000fffff] [ 0.000000] found SMP MP-table at [mem 0x000f0eb0-0x000f0ebf] mapped at [ffff8800000f0eb0] [ 0.000000] mpc: f0ec0-f0fac [ 0.000000] Base memory trampoline at [ffff880000099000] 99000 size 24576 [ 0.000000] init_memory_mapping: [mem 0x00000000-0x000fffff] [ 0.000000] [mem 0x00000000-0x000fffff] page 4k [ 0.000000] BRK [0x02214000, 0x02214fff] PGTABLE [ 0.000000] BRK [0x02215000, 0x02215fff] PGTABLE [ 0.000000] BRK [0x02216000, 0x02216fff] PGTABLE [ 0.000000] init_memory_mapping: [mem 0x36c00000-0x36dfffff] [ 0.000000] [mem 0x36c00000-0x36dfffff] page 2M [ 0.000000] init_memory_mapping: [mem 0x20000000-0x36bfffff] [ 0.000000] [mem 0x20000000-0x36bfffff] page 2M [ 0.000000] init_memory_mapping: [mem 0x00100000-0x1fffffff] [ 0.000000] [mem 0x00100000-0x001fffff] page 4k [ 0.000000] [mem 0x00200000-0x1fffffff] page 2M [ 0.000000] init_memory_mapping: [mem 0x36e00000-0x3ffdffff] [ 0.000000] [mem 0x36e00000-0x3fdfffff] page 2M [ 0.000000] [mem 0x3fe00000-0x3ffdffff] page 4k [ 0.000000] BRK [0x02217000, 0x02217fff] PGTABLE [ 0.000000] RAMDISK: [mem 0x36f3b000-0x3ffd7fff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F0C90 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x000000003FFE18BD 000034 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x000000003FFE0B37 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x000000003FFE0040 000AF7 (v01 BOCHS BXPCDSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x000000003FFE0000 000040 [ 0.000000] ACPI: SSDT 0x000000003FFE0BAB 000C5A (v01 BOCHS BXPCSSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: APIC 0x000000003FFE1805 000080 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x000000003FFE1885 000038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001) [ 0.000000] ACPI: Local APIC address 0xfee00000 [ 0.000000] mapped APIC to ffffffffff57c000 ( fee00000) [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x000000003ffdffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x36f15000-0x36f3afff] [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000000] kvm-clock: cpu 0, msr 0:36e95001, primary cpu clock [ 0.000000] clocksource kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] [ffffea0000000000-ffffea0000ffffff] PMD -> [ffff880035600000-ffff8800365fffff] on node 0 [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x000000003ffdffff] [ 0.000000] Normal 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-0x000000003ffdffff] [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffdffff] [ 0.000000] On node 0 totalpages: 262014 [ 0.000000] DMA zone: 64 pages used for memmap [ 0.000000] DMA zone: 21 pages reserved [ 0.000000] DMA zone: 3998 pages, LIFO batch:0 [ 0.000000] DMA32 zone: 4032 pages used for memmap [ 0.000000] DMA32 zone: 258016 pages, LIFO batch:31 [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: Local APIC address 0xfee00000 [ 0.000000] mapped APIC to ffffffffff57c000 ( fee00000) [ 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_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 00, APIC ID 0, APIC INT 02 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 05, APIC ID 0, APIC INT 05 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 09, APIC ID 0, APIC INT 09 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 0a, APIC ID 0, APIC INT 0a [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 0b, APIC ID 0, APIC INT 0b [ 0.000000] ACPI: IRQ0 used by override. [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 01, APIC ID 0, APIC INT 01 [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 03, APIC ID 0, APIC INT 03 [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 04, APIC ID 0, APIC INT 04 [ 0.000000] ACPI: IRQ5 used by override. [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 06, APIC ID 0, APIC INT 06 [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 07, APIC ID 0, APIC INT 07 [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 08, APIC ID 0, APIC INT 08 [ 0.000000] ACPI: IRQ9 used by override. [ 0.000000] ACPI: IRQ10 used by override. [ 0.000000] ACPI: IRQ11 used by override. [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0c, APIC ID 0, APIC INT 0c [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0d, APIC ID 0, APIC INT 0d [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0e, APIC ID 0, APIC INT 0e [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0f, APIC ID 0, APIC INT 0f [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] smpboot: Allowing 2 CPUs, 0 hotplug CPUs [ 0.000000] mapped IOAPIC to ffffffffff57b000 (fec00000) [ 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 0x40000000-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:2 nr_cpu_ids:2 nr_node_ids:1 [ 0.000000] PERCPU: Embedded 34 pages/cpu @ffff880036c00000 s102360 r8192 d28712 u1048576 [ 0.000000] pcpu-alloc: s102360 r8192 d28712 u1048576 alloc=1*2097152 [ 0.000000] pcpu-alloc: [0] 0 1 [ 0.000000] KVM setup async PF for cpu 0 [ 0.000000] kvm-stealtime: cpu 0, msr 36c0e380 [ 0.000000] Built 1 zonelists in Node order, mobility grouping on. Total pages: 257897 [ 0.000000] Policy zone: DMA32 [ 0.000000] Kernel command line: root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-kbuild-1G-15/bisect_xfstests-4HDD-btrfs-generic-slow1-debian-x86_64-2015-02-07.cgz-x86_64-rhel-5025fe55d485e2f08e99dce41e107c5b724ddf9c-4-20150529-13367-1c9wmmp.yaml ARCH=x86_64 kconfig=x86_64-rhel branch=cgroup/review-cgroup-writeback-switch-20150522 commit=5025fe55d485e2f08e99dce41e107c5b724ddf9c BOOT_IMAGE=/pkg/linux/x86_64-rhel/gcc-4.9/5025fe55d485e2f08e99dce41e107c5b724ddf9c/vmlinuz-4.1.0-rc2-00101-g5025fe5 max_uptime=3600 RESULT_ROOT=/result/xfstests/4HDD-btrfs-generic-slow1/vm-kbuild-1G/debian-x86_64-2015-02-07.cgz/x86_64-rhel/gcc-4.9/5025fe55d485e2f08e99dce41e107c5b724ddf9c/0 LKP_SERVER=inn earlyprintk=ttyS0,115200 systemd.log_level=err debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 console=ttyS0,115200 console=tty0 vga=normal rw ip=::::vm-kbuild-1G-15::dhcp [ 0.000000] sysrq: sysrq always enabled. [ 0.000000] PID hash table entries: 4096 (order: 3, 32768 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: 863776K/1048056K available (9029K kernel code, 1837K rwdata, 3908K rodata, 1812K init, 1868K bss, 184280K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 [ 0.000000] Hierarchical RCU implementation. [ 0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 [ 0.000000] NR_IRQS:524544 nr_irqs:440 16 [ 0.000000] Console: colour VGA+ 80x25 [ 0.000000] console [tty0] enabled [ 0.000000] bootconsole [earlyser0] disabled [ 0.000000] Initializing cgroup subsys cpuset [ 0.000000] Initializing cgroup subsys cpu [ 0.000000] Linux version 4.1.0-rc2-00101-g5025fe5 (kbuild@athens) (gcc version 4.9.2 (Debian 4.9.2-10) ) #1 SMP Fri May 29 13:38:16 CST 2015 [ 0.000000] Command line: root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-kbuild-1G-15/bisect_xfstests-4HDD-btrfs-generic-slow1-debian-x86_64-2015-02-07.cgz-x86_64-rhel-5025fe55d485e2f08e99dce41e107c5b724ddf9c-4-20150529-13367-1c9wmmp.yaml ARCH=x86_64 kconfig=x86_64-rhel branch=cgroup/review-cgroup-writeback-switch-20150522 commit=5025fe55d485e2f08e99dce41e107c5b724ddf9c BOOT_IMAGE=/pkg/linux/x86_64-rhel/gcc-4.9/5025fe55d485e2f08e99dce41e107c5b724ddf9c/vmlinuz-4.1.0-rc2-00101-g5025fe5 max_uptime=3600 RESULT_ROOT=/result/xfstests/4HDD-btrfs-generic-slow1/vm-kbuild-1G/debian-x86_64-2015-02-07.cgz/x86_64-rhel/gcc-4.9/5025fe55d485e2f08e99dce41e107c5b724ddf9c/0 LKP_SERVER=inn earlyprintk=ttyS0,115200 systemd.log_level=err debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 console=ttyS0,115200 console=tty0 vga=normal rw ip=::::vm-kbuild-1G-15::dhcp [ 0.000000] e820: BIOS-provided physical RAM map: [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffdffff] usable [ 0.000000] BIOS-e820: [mem 0x000000003ffe0000-0x000000003fffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved [ 0.000000] bootconsole [earlyser0] enabled [ 0.000000] earlycon: no match for ttyS0,115200 [ 0.000000] earlycon: no match for tty0 [ 0.000000] NX (Execute Disable) protection: active [ 0.000000] SMBIOS 2.8 present. [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.7.5-20140531_083030-gandalf 04/01/2014 [ 0.000000] Hypervisor detected: KVM [ 0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved [ 0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable [ 0.000000] AGP: No AGP bridge found [ 0.000000] e820: last_pfn = 0x3ffe0 max_arch_pfn = 0x400000000 [ 0.000000] MTRR default type: write-back [ 0.000000] MTRR fixed ranges enabled: [ 0.000000] 00000-9FFFF write-back [ 0.000000] A0000-BFFFF uncachable [ 0.000000] C0000-FFFFF write-protect [ 0.000000] MTRR variable ranges enabled: [ 0.000000] 0 base 0080000000 mask FF80000000 uncachable [ 0.000000] 1 disabled [ 0.000000] 2 disabled [ 0.000000] 3 disabled [ 0.000000] 4 disabled [ 0.000000] 5 disabled [ 0.000000] 6 disabled [ 0.000000] 7 disabled [ 0.000000] PAT configuration [0-7]: WB WC UC- UC WB WC UC- UC [ 0.000000] Scan for SMP in [mem 0x00000000-0x000003ff] [ 0.000000] Scan for SMP in [mem 0x0009fc00-0x0009ffff] [ 0.000000] Scan for SMP in [mem 0x000f0000-0x000fffff] [ 0.000000] found SMP MP-table at [mem 0x000f0eb0-0x000f0ebf] mapped at [ffff8800000f0eb0] [ 0.000000] mpc: f0ec0-f0fac [ 0.000000] Base memory trampoline at [ffff880000099000] 99000 size 24576 [ 0.000000] init_memory_mapping: [mem 0x00000000-0x000fffff] [ 0.000000] [mem 0x00000000-0x000fffff] page 4k [ 0.000000] BRK [0x02214000, 0x02214fff] PGTABLE [ 0.000000] BRK [0x02215000, 0x02215fff] PGTABLE [ 0.000000] BRK [0x02216000, 0x02216fff] PGTABLE [ 0.000000] init_memory_mapping: [mem 0x36c00000-0x36dfffff] [ 0.000000] [mem 0x36c00000-0x36dfffff] page 2M [ 0.000000] init_memory_mapping: [mem 0x20000000-0x36bfffff] [ 0.000000] [mem 0x20000000-0x36bfffff] page 2M [ 0.000000] init_memory_mapping: [mem 0x00100000-0x1fffffff] [ 0.000000] [mem 0x00100000-0x001fffff] page 4k [ 0.000000] [mem 0x00200000-0x1fffffff] page 2M [ 0.000000] init_memory_mapping: [mem 0x36e00000-0x3ffdffff] [ 0.000000] [mem 0x36e00000-0x3fdfffff] page 2M [ 0.000000] [mem 0x3fe00000-0x3ffdffff] page 4k [ 0.000000] BRK [0x02217000, 0x02217fff] PGTABLE [ 0.000000] RAMDISK: [mem 0x36f3b000-0x3ffd7fff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F0C90 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x000000003FFE18BD 000034 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x000000003FFE0B37 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x000000003FFE0040 000AF7 (v01 BOCHS BXPCDSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x000000003FFE0000 000040 [ 0.000000] ACPI: SSDT 0x000000003FFE0BAB 000C5A (v01 BOCHS BXPCSSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: APIC 0x000000003FFE1805 000080 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x000000003FFE1885 000038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001) [ 0.000000] ACPI: Local APIC address 0xfee00000 [ 0.000000] mapped APIC to ffffffffff57c000 ( fee00000) [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x000000003ffdffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x36f15000-0x36f3afff] [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000000] kvm-clock: cpu 0, msr 0:36e95001, primary cpu clock [ 0.000000] clocksource kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] [ffffea0000000000-ffffea0000ffffff] PMD -> [ffff880035600000-ffff8800365fffff] on node 0 [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x000000003ffdffff] [ 0.000000] Normal 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-0x000000003ffdffff] [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffdffff] [ 0.000000] On node 0 totalpages: 262014 [ 0.000000] DMA zone: 64 pages used for memmap [ 0.000000] DMA zone: 21 pages reserved [ 0.000000] DMA zone: 3998 pages, LIFO batch:0 [ 0.000000] DMA32 zone: 4032 pages used for memmap [ 0.000000] DMA32 zone: 258016 pages, LIFO batch:31 [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: Local APIC address 0xfee00000 [ 0.000000] mapped APIC to ffffffffff57c000 ( fee00000) [ 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_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 00, APIC ID 0, APIC INT 02 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 05, APIC ID 0, APIC INT 05 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 09, APIC ID 0, APIC INT 09 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 0a, APIC ID 0, APIC INT 0a [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 0b, APIC ID 0, APIC INT 0b [ 0.000000] ACPI: IRQ0 used by override. [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 01, APIC ID 0, APIC INT 01 [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 03, APIC ID 0, APIC INT 03 [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 04, APIC ID 0, APIC INT 04 [ 0.000000] ACPI: IRQ5 used by override. [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 06, APIC ID 0, APIC INT 06 [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 07, APIC ID 0, APIC INT 07 [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 08, APIC ID 0, APIC INT 08 [ 0.000000] ACPI: IRQ9 used by override. [ 0.000000] ACPI: IRQ10 used by override. [ 0.000000] ACPI: IRQ11 used by override. [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0c, APIC ID 0, APIC INT 0c [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0d, APIC ID 0, APIC INT 0d [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0e, APIC ID 0, APIC INT 0e [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0f, APIC ID 0, APIC INT 0f [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] smpboot: Allowing 2 CPUs, 0 hotplug CPUs [ 0.000000] mapped IOAPIC to ffffffffff57b000 (fec00000) [ 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 0x40000000-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:2 nr_cpu_ids:2 nr_node_ids:1 [ 0.000000] PERCPU: Embedded 34 pages/cpu @ffff880036c00000 s102360 r8192 d28712 u1048576 [ 0.000000] pcpu-alloc: s102360 r8192 d28712 u1048576 alloc=1*2097152 [ 0.000000] pcpu-alloc: [0] 0 1 [ 0.000000] KVM setup async PF for cpu 0 [ 0.000000] kvm-stealtime: cpu 0, msr 36c0e380 [ 0.000000] Built 1 zonelists in Node order, mobility grouping on. Total pages: 257897 [ 0.000000] Policy zone: DMA32 [ 0.000000] Kernel command line: root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-kbuild-1G-15/bisect_xfstests-4HDD-btrfs-generic-slow1-debian-x86_64-2015-02-07.cgz-x86_64-rhel-5025fe55d485e2f08e99dce41e107c5b724ddf9c-4-20150529-13367-1c9wmmp.yaml ARCH=x86_64 kconfig=x86_64-rhel branch=cgroup/review-cgroup-writeback-switch-20150522 commit=5025fe55d485e2f08e99dce41e107c5b724ddf9c BOOT_IMAGE=/pkg/linux/x86_64-rhel/gcc-4.9/5025fe55d485e2f08e99dce41e107c5b724ddf9c/vmlinuz-4.1.0-rc2-00101-g5025fe5 max_uptime=3600 RESULT_ROOT=/result/xfstests/4HDD-btrfs-generic-slow1/vm-kbuild-1G/debian-x86_64-2015-02-07.cgz/x86_64-rhel/gcc-4.9/5025fe55d485e2f08e99dce41e107c5b724ddf9c/0 LKP_SERVER=inn earlyprintk=ttyS0,115200 systemd.log_level=err debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 console=ttyS0,115200 console=tty0 vga=normal rw ip=::::vm-kbuild-1G-15::dhcp [ 0.000000] sysrq: sysrq always enabled. [ 0.000000] PID hash table entries: 4096 (order: 3, 32768 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: 863776K/1048056K available (9029K kernel code, 1837K rwdata, 3908K rodata, 1812K init, 1868K bss, 184280K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 [ 0.000000] Hierarchical RCU implementation. [ 0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 [ 0.000000] NR_IRQS:524544 nr_irqs:440 16 [ 0.000000] Console: colour VGA+ 80x25 [ 0.000000] console [tty0] enabled [ 0.000000] bootconsole [earlyser0] disabled [ 0.000000] console [ttyS0] enabled [ 0.000000] clocksource hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.000000] hpet clockevent registered [ 0.000000] tsc: Detected 2693.508 MHz processor [ 0.003000] Calibrating delay loop (skipped) preset value.. 5387.01 BogoMIPS (lpj=2693508) [ 0.004005] pid_max: default: 32768 minimum: 301 [ 0.005014] ACPI: Core revision 20150410 [ 0.009259] ACPI: All ACPI Tables successfully acquired [ 0.011100] Security Framework initialized [ 0.012010] SELinux: Initializing. [ 0.013011] SELinux: Starting in permissive mode [ 0.014102] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes) [ 0.016120] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes) [ 0.018508] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes) [ 0.019010] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes) [ 0.020199] Initializing cgroup subsys blkio [ 0.021008] Initializing cgroup subsys memory [ 0.022017] Initializing cgroup subsys devices [ 0.023008] Initializing cgroup subsys freezer [ 0.024008] Initializing cgroup subsys net_cls [ 0.025008] Initializing cgroup subsys perf_event [ 0.026009] Initializing cgroup subsys hugetlb [ 0.027111] mce: CPU supports 10 MCE banks [ 0.028051] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.029006] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.030336] Freeing SMP alternatives memory: 32K (ffffffff82037000 - ffffffff8203f000) [ 0.036435] ftrace: allocating 32121 entries in 126 pages [ 0.046319] x2apic enabled [ 0.047006] Switched APIC routing to physical x2apic. [ 0.049137] enabled ExtINT on CPU#0 [ 0.051531] ENABLING IO-APIC IRQs [ 0.052007] init IO_APIC IRQs [ 0.053005] apic 0 pin 0 not connected [ 0.054010] IOAPIC[0]: Set routing entry (0-1 -> 0x31 -> IRQ 1 Mode:0 Active:0 Dest:0) [ 0.055027] IOAPIC[0]: Set routing entry (0-2 -> 0x30 -> IRQ 0 Mode:0 Active:0 Dest:0) [ 0.056025] IOAPIC[0]: Set routing entry (0-2 -> 0x30 -> IRQ 0 Mode:0 Active:0 Dest:0) [ 0.057027] IOAPIC[0]: Set routing entry (0-3 -> 0x33 -> IRQ 3 Mode:0 Active:0 Dest:0) [ 0.058025] IOAPIC[0]: Set routing entry (0-4 -> 0x34 -> IRQ 4 Mode:0 Active:0 Dest:0) [ 0.059030] IOAPIC[0]: Set routing entry (0-5 -> 0x35 -> IRQ 5 Mode:1 Active:0 Dest:0) [ 0.060027] IOAPIC[0]: Set routing entry (0-6 -> 0x36 -> IRQ 6 Mode:0 Active:0 Dest:0) [ 0.061024] IOAPIC[0]: Set routing entry (0-7 -> 0x37 -> IRQ 7 Mode:0 Active:0 Dest:0) [ 0.062026] IOAPIC[0]: Set routing entry (0-8 -> 0x38 -> IRQ 8 Mode:0 Active:0 Dest:0) [ 0.063025] IOAPIC[0]: Set routing entry (0-9 -> 0x39 -> IRQ 9 Mode:1 Active:0 Dest:0) [ 0.064028] IOAPIC[0]: Set routing entry (0-10 -> 0x3a -> IRQ 10 Mode:1 Active:0 Dest:0) [ 0.065028] IOAPIC[0]: Set routing entry (0-11 -> 0x3b -> IRQ 11 Mode:1 Active:0 Dest:0) [ 0.066026] IOAPIC[0]: Set routing entry (0-12 -> 0x3c -> IRQ 12 Mode:0 Active:0 Dest:0) [ 0.067027] IOAPIC[0]: Set routing entry (0-13 -> 0x3d -> IRQ 13 Mode:0 Active:0 Dest:0) [ 0.068027] IOAPIC[0]: Set routing entry (0-14 -> 0x3e -> IRQ 14 Mode:0 Active:0 Dest:0) [ 0.069026] IOAPIC[0]: Set routing entry (0-15 -> 0x3f -> IRQ 15 Mode:0 Active:0 Dest:0) [ 0.070024] apic 0 pin 16 not connected [ 0.071003] apic 0 pin 17 not connected [ 0.072004] apic 0 pin 18 not connected [ 0.073004] apic 0 pin 19 not connected [ 0.074004] apic 0 pin 20 not connected [ 0.075003] apic 0 pin 21 not connected [ 0.076003] apic 0 pin 22 not connected [ 0.077004] apic 0 pin 23 not connected [ 0.078178] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.079035] TSC deadline timer enabled [ 0.080000] smpboot: CPU0: Intel Core Processor (Haswell) (fam: 06, model: 3c, stepping: 01) [ 0.081033] Performance Events: unsupported p6 CPU model 60 no PMU driver, software events only. [ 0.084214] x86: Booting SMP configuration: [ 0.085009] .... node #0, CPUs: #1 [ 0.084082] kvm-clock: cpu 1, msr 0:36e95041, secondary cpu clock [ 0.084082] masked ExtINT on CPU#1 [ 0.105025] x86: Booted up 1 node, 2 CPUs [ 0.106007] smpboot: Total of 2 processors activated (10774.03 BogoMIPS) [ 0.116007] KVM setup async PF for cpu 1 [ 0.117000] kvm-stealtime: cpu 1, msr 36d0e380 [ 0.117459] devtmpfs: initialized [ 0.120410] evm: security.selinux [ 0.121006] evm: security.ima [ 0.122006] evm: security.capability [ 0.124257] clocksource jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.125099] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 0.126248] NET: Registered protocol family 16 [ 0.130016] cpuidle: using governor menu [ 0.138499] ACPI: bus type PCI registered [ 0.139007] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.140148] PCI: Using configuration type 1 for base access [ 0.147116] ACPI: Added _OSI(Module Device) [ 0.148007] ACPI: Added _OSI(Processor Device) [ 0.149007] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.150008] ACPI: Added _OSI(Processor Aggregator Device) [ 0.151636] IOAPIC[0]: Set routing entry (0-9 -> 0x39 -> IRQ 9 Mode:1 Active:0 Dest:0) [ 0.153402] ACPI: Interpreter enabled [ 0.154011] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [\_S1_] (20150410/hwxface-580) [ 0.156008] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [\_S2_] (20150410/hwxface-580) [ 0.158022] ACPI: (supports S0 S3 S4 S5) [ 0.159006] ACPI: Using IOAPIC for interrupt routing [ 0.160031] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.165796] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.166012] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI] [ 0.167014] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM [ 0.168112] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.169442] acpiphp: Slot [3] registered [ 0.170040] acpiphp: Slot [4] registered [ 0.171040] acpiphp: Slot [5] registered [ 0.172038] acpiphp: Slot [6] registered [ 0.173037] acpiphp: Slot [7] registered [ 0.174038] acpiphp: Slot [8] registered [ 0.175040] acpiphp: Slot [9] registered [ 0.176042] acpiphp: Slot [10] registered [ 0.177037] acpiphp: Slot [11] registered [ 0.178043] acpiphp: Slot [12] registered [ 0.179038] acpiphp: Slot [13] registered [ 0.180037] acpiphp: Slot [14] registered [ 0.181037] acpiphp: Slot [15] registered [ 0.182046] acpiphp: Slot [16] registered [ 0.183040] acpiphp: Slot [17] registered [ 0.184037] acpiphp: Slot [18] registered [ 0.185038] acpiphp: Slot [19] registered [ 0.186036] acpiphp: Slot [20] registered [ 0.187042] acpiphp: Slot [21] registered [ 0.188036] acpiphp: Slot [22] registered [ 0.189056] acpiphp: Slot [23] registered [ 0.190040] acpiphp: Slot [24] registered [ 0.191037] acpiphp: Slot [25] registered [ 0.192037] acpiphp: Slot [26] registered [ 0.193038] acpiphp: Slot [27] registered [ 0.194036] acpiphp: Slot [28] registered [ 0.195220] acpiphp: Slot [29] registered [ 0.196037] acpiphp: Slot [30] registered [ 0.197045] acpiphp: Slot [31] registered [ 0.198024] PCI host bridge to bus 0000:00 [ 0.199009] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.200007] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.201007] pci_bus 0000:00: root bus resource [io 0x0d00-0xadff window] [ 0.202007] pci_bus 0000:00: root bus resource [io 0xae0f-0xaeff window] [ 0.203007] pci_bus 0000:00: root bus resource [io 0xaf20-0xafdf window] [ 0.204008] pci_bus 0000:00: root bus resource [io 0xafe4-0xffff window] [ 0.205008] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.206007] pci_bus 0000:00: root bus resource [mem 0x40000000-0xfebfffff window] [ 0.207054] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.208545] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.209635] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.213847] pci 0000:00:01.1: reg 0x20: [io 0xc080-0xc08f] [ 0.215469] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.216008] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.217008] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.218008] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.220274] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.220430] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.220430] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.221000] pci 0000:00:02.0: [1013:00b8] type 00 class 0x030000 [ 0.222000] pci 0000:00:02.0: reg 0x10: [mem 0xfc000000-0xfdffffff pref] [ 0.226876] pci 0000:00:02.0: reg 0x14: [mem 0xfebf0000-0xfebf0fff] [ 0.237974] pci 0000:00:02.0: reg 0x30: [mem 0xfebe0000-0xfebeffff pref] [ 0.240286] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000 [ 0.243008] pci 0000:00:03.0: reg 0x10: [mem 0xfebc0000-0xfebdffff] [ 0.247007] pci 0000:00:03.0: reg 0x14: [io 0xc000-0xc03f] [ 0.257010] pci 0000:00:03.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.259299] pci 0000:00:04.0: [1af4:1004] type 00 class 0x010000 [ 0.263008] pci 0000:00:04.0: reg 0x10: [io 0xc040-0xc07f] [ 0.265852] pci 0000:00:04.0: reg 0x14: [mem 0xfebf1000-0xfebf1fff] [ 0.277406] pci 0000:00:05.0: [8086:25ab] type 00 class 0x088000 [ 0.279903] pci 0000:00:05.0: reg 0x10: [mem 0xfebf2000-0xfebf200f] [ 0.286911] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11) [ 0.290184] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11) [ 0.292183] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11) [ 0.318214] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11) [ 0.320087] ACPI: PCI Interrupt Link [LNKS] (IRQs *9) [ 0.322467] ACPI: Enabled 16 GPEs in block 00 to 0F [ 0.325185] vgaarb: setting as boot device: PCI:0000:00:02.0 [ 0.326000] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none [ 0.329007] vgaarb: loaded [ 0.330007] vgaarb: bridge control possible 0000:00:02.0 [ 0.332116] SCSI subsystem initialized [ 0.334048] ACPI: bus type USB registered [ 0.335037] usbcore: registered new interface driver usbfs [ 0.337022] usbcore: registered new interface driver hub [ 0.340008] usbcore: registered new device driver usb [ 0.340008] pps_core: LinuxPPS API ver. 1 registered [ 0.340008] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.343016] PTP clock support registered [ 0.345064] PCI: Using ACPI for IRQ routing [ 0.346000] PCI: pci_cache_line_size set to 64 bytes [ 0.346000] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] [ 0.349009] e820: reserve RAM buffer [mem 0x3ffe0000-0x3fffffff] [ 0.352182] NetLabel: Initializing [ 0.355006] NetLabel: domain hash size = 128 [ 0.358006] NetLabel: protocols = UNLABELED CIPSOv4 [ 0.363034] NetLabel: unlabeled traffic allowed by default [ 0.366189] HPET: 3 timers in total, 0 timers will be used for per-cpu timer [ 0.371030] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.374007] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.387040] Switched to clocksource kvm-clock [ 0.414385] pnp: PnP ACPI init [ 0.415815] IOAPIC[0]: Set routing entry (0-8 -> 0x38 -> IRQ 8 Mode:0 Active:0 Dest:0) [ 0.418483] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active) [ 0.420481] IOAPIC[0]: Set routing entry (0-1 -> 0x31 -> IRQ 1 Mode:0 Active:0 Dest:0) [ 0.423232] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active) [ 0.425110] IOAPIC[0]: Set routing entry (0-12 -> 0x3c -> IRQ 12 Mode:0 Active:0 Dest:0) [ 0.428107] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active) [ 0.429954] IOAPIC[0]: Set routing entry (0-6 -> 0x36 -> IRQ 6 Mode:0 Active:0 Dest:0) [ 0.432695] pnp 00:03: [dma 2] [ 0.433949] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active) [ 0.435916] IOAPIC[0]: Set routing entry (0-7 -> 0x37 -> IRQ 7 Mode:0 Active:0 Dest:0) [ 0.438558] pnp 00:04: Plug and Play ACPI device, IDs PNP0400 (active) [ 0.440522] IOAPIC[0]: Set routing entry (0-4 -> 0x34 -> IRQ 4 Mode:0 Active:0 Dest:0) [ 0.443278] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active) [ 0.445420] pnp: PnP ACPI: found 6 devices [ 0.455949] clocksource acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.459164] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.461093] pci_bus 0000:00: resource 5 [io 0x0d00-0xadff window] [ 0.463145] pci_bus 0000:00: resource 6 [io 0xae0f-0xaeff window] [ 0.465151] pci_bus 0000:00: resource 7 [io 0xaf20-0xafdf window] [ 0.467166] pci_bus 0000:00: resource 8 [io 0xafe4-0xffff window] [ 0.469130] pci_bus 0000:00: resource 9 [mem 0x000a0000-0x000bffff window] [ 0.471161] pci_bus 0000:00: resource 10 [mem 0x40000000-0xfebfffff window] [ 0.473233] NET: Registered protocol family 2 [ 0.475053] TCP established hash table entries: 8192 (order: 4, 65536 bytes) [ 0.477047] TCP bind hash table entries: 8192 (order: 5, 131072 bytes) [ 0.478964] TCP: Hash tables configured (established 8192 bind 8192) [ 0.481357] UDP hash table entries: 512 (order: 2, 16384 bytes) [ 0.483210] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes) [ 0.485118] NET: Registered protocol family 1 [ 0.499057] RPC: Registered named UNIX socket transport module. [ 0.500861] RPC: Registered udp transport module. [ 0.502404] RPC: Registered tcp transport module. [ 0.503962] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.505937] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.507762] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.509518] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.511403] pci 0000:00:02.0: Video device with shadowed ROM [ 0.513221] PCI: CLS 0 bytes, default 64 [ 0.514813] Unpacking initramfs... [ 3.999495] Freeing initrd memory: 148084K (ffff880036f3b000 - ffff88003ffd8000) [ 4.048417] futex hash table entries: 512 (order: 3, 32768 bytes) [ 4.050328] Initialise system trusted keyring [ 4.051759] audit: initializing netlink subsys (disabled) [ 4.053477] audit: type=2000 audit(1432878521.498:1): initialized [ 4.055922] HugeTLB registered 2 MB page size, pre-allocated 0 pages [ 4.059799] zpool: loaded [ 4.060997] zbud: loaded [ 4.075178] VFS: Disk quotas dquot_6.6.0 [ 4.076662] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 4.079352] SGI XFS with ACLs, security attributes, no debug enabled [ 4.081557] 9p: Installing v9fs 9p2000 file system support [ 4.083334] Key type big_key registered [ 4.084727] SELinux: Registering netfilter hooks [ 4.103950] NET: Registered protocol family 38 [ 4.105411] Key type asymmetric registered [ 4.106891] Asymmetric key parser 'x509' registered [ 4.108627] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) [ 4.123941] io scheduler noop registered [ 4.125445] io scheduler deadline registered (default) [ 4.127030] io scheduler cfq registered [ 4.128536] pci_hotplug: PCI Hot Plug PCI Core version: 0.5 [ 4.130223] pciehp: PCI Express Hot Plug Controller Driver version: 0.4 [ 4.132042] intel_idle: does not run on family 6 model 60 [ 4.133723] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 4.136286] ACPI: Power Button [PWRF] [ 4.146829] GHES: HEST is not enabled! [ 4.200828] ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 11 [ 4.202547] IOAPIC[0]: Set routing entry (0-11 -> 0x3b -> IRQ 11 Mode:1 Active:0 Dest:0) [ 4.205325] virtio-pci 0000:00:04.0: virtio_pci: leaving for legacy driver [ 4.207822] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 4.244279] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 4.247682] Non-volatile memory driver v1.3 [ 4.249136] Linux agpgart interface v0.103 [ 4.250894] rdac: device handler registered [ 4.252420] hp_sw: device handler registered [ 4.253920] emc: device handler registered [ 4.255266] alua: device handler registered [ 4.256741] libphy: Fixed MDIO Bus: probed [ 4.258235] e1000: Intel(R) PRO/1000 Network Driver - version 7.3.21-k8-NAPI [ 4.260086] e1000: Copyright (c) 1999-2006 Intel Corporation. [ 4.337264] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 10 [ 4.338949] IOAPIC[0]: Set routing entry (0-10 -> 0x3a -> IRQ 10 Mode:1 Active:0 Dest:0) [ 4.812711] e1000 0000:00:03.0 eth0: (PCI:33MHz:32-bit) 52:54:00:12:34:56 [ 4.816698] e1000 0000:00:03.0 eth0: Intel(R) PRO/1000 Network Connection [ 4.820768] e1000e: Intel(R) PRO/1000 Network Driver - 2.3.2-k [ 4.823478] e1000e: Copyright(c) 1999 - 2014 Intel Corporation. [ 4.827283] igb: Intel(R) Gigabit Ethernet Network Driver - version 5.2.15-k [ 4.838901] igb: Copyright (c) 2007-2014 Intel Corporation. [ 4.842733] ixgbe: Intel(R) 10 Gigabit PCI Express Network Driver - version 4.0.1-k [ 4.847375] ixgbe: Copyright (c) 1999-2014 Intel Corporation. [ 4.851209] usbcore: registered new interface driver catc [ 4.855057] usbcore: registered new interface driver kaweth [ 4.859854] pegasus: v0.9.3 (2013/04/25), Pegasus/Pegasus II USB Ethernet driver [ 4.865748] usbcore: registered new interface driver pegasus [ 4.868564] usbcore: registered new interface driver rtl8150 [ 4.872423] usbcore: registered new interface driver asix [ 4.876244] usbcore: registered new interface driver cdc_ether [ 4.880081] usbcore: registered new interface driver cdc_eem [ 4.883876] usbcore: registered new interface driver dm9601 [ 4.886618] usbcore: registered new interface driver smsc75xx [ 4.890369] usbcore: registered new interface driver smsc95xx [ 4.894174] usbcore: registered new interface driver gl620a [ 4.897688] usbcore: registered new interface driver net1080 [ 4.901732] usbcore: registered new interface driver plusb [ 4.904714] usbcore: registered new interface driver rndis_host [ 4.908714] usbcore: registered new interface driver cdc_subset [ 4.912709] usbcore: registered new interface driver zaurus [ 4.915690] usbcore: registered new interface driver MOSCHIP usb-ethernet driver [ 4.919446] usbcore: registered new interface driver int51x1 [ 4.921194] usbcore: registered new interface driver ipheth [ 4.922909] usbcore: registered new interface driver sierra_net [ 4.924697] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver [ 4.926528] ehci-pci: EHCI PCI platform driver [ 4.928038] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver [ 4.929827] ohci-pci: OHCI PCI platform driver [ 4.931282] uhci_hcd: USB Universal Host Controller Interface driver [ 4.933167] usbcore: registered new interface driver usbserial [ 4.934972] usbcore: registered new interface driver usbserial_generic [ 4.936825] usbserial: USB Serial support registered for generic [ 4.938699] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 4.961117] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 4.962752] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 4.964591] mousedev: PS/2 mouse device common for all mice [ 4.966827] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 4.976034] rtc_cmos 00:00: RTC can wake from S4 [ 4.978721] rtc_cmos 00:00: rtc core: registered rtc_cmos as rtc0 [ 4.981820] rtc_cmos 00:00: alarms up to one day, 114 bytes nvram, hpet irqs [ 4.984064] i6300esb: Intel 6300ESB WatchDog Timer Driver v0.05 [ 4.986185] i6300esb: initialized (0xffffc90000222000). heartbeat=30 sec (nowayout=0) [ 4.988998] iTCO_wdt: Intel TCO WatchDog Timer Driver v1.11 [ 4.990800] iTCO_vendor_support: vendor-support=0 [ 5.005069] tsc: Refined TSC clocksource calibration: 2693.513 MHz [ 5.005071] clocksource tsc: mask: 0xffffffffffffffff max_cycles: 0x26d34e52b35, max_idle_ns: 440795258001 ns [ 5.031694] hidraw: raw HID events driver (C) Jiri Kosina [ 5.033377] usbcore: registered new interface driver usbhid [ 5.034880] usbhid: USB HID core driver [ 5.037108] drop_monitor: Initializing network drop monitor service [ 5.038781] Initializing XFRM netlink socket [ 5.040288] NET: Registered protocol family 10 [ 5.057338] NET: Registered protocol family 17 [ 5.058699] 9pnet: Installing 9P2000 support [ 5.060382] ... APIC ID: 00000000 (0) [ 5.061155] ... APIC VERSION: 01050014 [ 5.061155] 0000000000000000000000000000000000000000000000000000000000000000 [ 5.061155] 000000000e200000000000000000000000000000000000000000000000000000 [ 5.061155] 0000000000000000000000000000000000000000000000000000000000008000 [ 5.061155] [ 5.071261] number of MP IRQ sources: 15. [ 5.072513] number of IO-APIC #0 registers: 24. [ 5.073841] testing the IO APIC....................... [ 5.075278] IO APIC #0...... [ 5.076360] .... register #00: 00000000 [ 5.077667] ....... : physical APIC id: 00 [ 5.079253] ....... : Delivery Type: 0 [ 5.080758] ....... : LTS : 0 [ 5.082227] .... register #01: 00170011 [ 5.083649] ....... : max redirection entries: 17 [ 5.085261] ....... : PRQ implemented: 0 [ 5.086689] ....... : IO APIC version: 11 [ 5.088246] .... register #02: 00000000 [ 5.089519] ....... : arbitration: 00 [ 5.090771] .... IRQ redirection table: [ 5.092025] 1 0 0 0 0 0 0 00 [ 5.093372] 0 0 0 0 0 0 0 31 [ 5.094705] 0 0 0 0 0 0 0 30 [ 5.096046] 0 0 0 0 0 0 0 33 [ 5.097418] 1 0 0 0 0 0 0 34 [ 5.098755] 1 1 0 0 0 0 0 35 [ 5.100133] 0 0 0 0 0 0 0 36 [ 5.101705] 0 0 0 0 0 0 0 37 [ 5.103606] 0 0 0 0 0 0 0 38 [ 5.105501] 0 1 0 0 0 0 0 39 [ 5.107430] 1 1 0 0 0 0 0 3A [ 5.108877] 1 1 0 0 0 0 0 3B [ 5.110241] 0 0 0 0 0 0 0 3C [ 5.111574] 0 0 0 0 0 0 0 3D [ 5.112913] 0 0 0 0 0 0 0 3E [ 5.114251] 0 0 0 0 0 0 0 3F [ 5.115586] 1 0 0 0 0 0 0 00 [ 5.116935] 1 0 0 0 0 0 0 00 [ 5.118306] 1 0 0 0 0 0 0 00 [ 5.119654] 1 0 0 0 0 0 0 00 [ 5.121014] 1 0 0 0 0 0 0 00 [ 5.122351] 1 0 0 0 0 0 0 00 [ 5.123682] 1 0 0 0 0 0 0 00 [ 5.125026] 1 0 0 0 0 0 0 00 [ 5.126347] IRQ to pin mappings: [ 5.127520] IRQ0 -> 0:2 [ 5.128728] IRQ1 -> 0:1 [ 5.129970] IRQ3 -> 0:3 [ 5.131195] IRQ4 -> 0:4 [ 5.132408] IRQ5 -> 0:5 [ 5.133620] IRQ6 -> 0:6 [ 5.134836] IRQ7 -> 0:7 [ 5.136062] IRQ8 -> 0:8 [ 5.137362] IRQ9 -> 0:9 [ 5.138715] IRQ10 -> 0:10 [ 5.140016] IRQ11 -> 0:11 [ 5.141249] IRQ12 -> 0:12 [ 5.142489] IRQ13 -> 0:13 [ 5.143727] IRQ14 -> 0:14 [ 5.144969] IRQ15 -> 0:15 [ 5.146394] .................................... done. [ 5.148237] Loading compiled-in X.509 certificates [ 5.150810] Loaded X.509 cert 'Build time autogenerated kernel key: 6f6c0ead2c943b497529de99172f1f80325c0de6' [ 5.162035] registered taskstats version 1 [ 5.168131] Key type trusted registered [ 5.180675] Key type encrypted registered [ 5.182135] ima: No TPM chip found, activating TPM-bypass! [ 5.183937] evm: HMAC attrs: 0x1 [ 5.197123] rtc_cmos 00:00: setting system clock to 2015-05-29 13:48:42 UTC (1432907322) [ 5.203723] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [ 5.810469] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input3 [ 7.207509] e1000: eth0 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: RX [ 7.210212] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 7.221056] Sending DHCP requests ., OK [ 7.228079] IP-Config: Got DHCP answer from 10.0.2.2, my address is 10.0.2.15 [ 7.230347] IP-Config: Complete: [ 7.231567] device=eth0, hwaddr=52:54:00:12:34:56, ipaddr=10.0.2.15, mask=255.255.255.0, gw=10.0.2.2 [ 7.234056] host=vm-kbuild-1G-15, domain=, nis-domain=(none) [ 7.235525] bootserver=10.0.2.2, rootserver=10.0.2.2, rootpath= [ 7.236480] nameserver0=10.0.2.3 [ 7.238760] PM: Hibernation image not present or could not be loaded. [ 7.242619] Freeing unused kernel memory: 1812K (ffffffff81e72000 - ffffffff82037000) [ 7.279004] systemd[1]: RTC configured in localtime, applying delta of 480 minutes to system time. [ 7.281982] random: systemd urandom read with 6 bits of entropy available [ 7.325212] systemd-default-display-manager-generator[80]: No /etc/X11/default-display-manager file, nothing to generate [ 7.346833] systemd-gpt-auto-generator[81]: Root file system not on a (single) block device. [ 7.350256] systemd-fstab-generator[82]: Parsing /etc/fstab [ 7.350922] systemd-rc-local-generator[83]: Automatically adding rc-local.service. [ 7.351914] systemd-sysv-generator[84]: Looking for unit files in (higher priority first): [ 7.351932] systemd-sysv-generator[84]: Looking for SysV init scripts in: [ 7.351937] systemd-sysv-generator[84]: Looking for SysV rcN.d links in: [ 7.353407] systemd-sysv-generator[84]: Ignoring S03mountdevsubfs.sh symlink in rcS.d, not generating mountdevsubfs.service. [ 7.353412] systemd-sysv-generator[84]: Ignoring S10udev-finish symlink in rcS.d, not generating udev-finish.service. [ 7.353415] systemd-sysv-generator[84]: Ignoring S16x11-common symlink in rcS.d, not generating x11-common.service. [ 7.353419] systemd-sysv-generator[84]: Ignoring S10procps symlink in rcS.d, not generating procps.service. [ 7.353422] systemd-sysv-generator[84]: Ignoring S14mountnfs.sh symlink in rcS.d, not generating mountnfs.service. [ 7.353426] systemd-sysv-generator[84]: Ignoring S15mountnfs-bootclean.sh symlink in rcS.d, not generating mountnfs-bootclean.service. [ 7.353430] systemd-sysv-generator[84]: Ignoring S07checkroot-bootclean.sh symlink in rcS.d, not generating checkroot-bootclean.service. [ 7.353434] systemd-sysv-generator[84]: Ignoring S05checkroot.sh symlink in rcS.d, not generating checkroot.service. [ 7.353439] systemd-sysv-generator[84]: Ignoring S04hwclock.sh symlink in rcS.d, not generating hwclock.service. [ 7.353444] systemd-sysv-generator[84]: Ignoring S09mountall-bootclean.sh symlink in rcS.d, not generating mountall-bootclean.service. [ 7.353448] systemd-sysv-generator[84]: Ignoring S10urandom symlink in rcS.d, not generating urandom.service. [ 7.353451] systemd-sysv-generator[84]: Ignoring S07kmod symlink in rcS.d, not generating kmod.service. [ 7.353454] systemd-sysv-generator[84]: Ignoring S16bootmisc.sh symlink in rcS.d, not generating bootmisc.service. [ 7.353457] systemd-sysv-generator[84]: Ignoring S01mountkernfs.sh symlink in rcS.d, not generating mountkernfs.service. [ 7.353461] systemd-sysv-generator[84]: Ignoring S01hostname.sh symlink in rcS.d, not generating hostname.service. [ 7.353464] systemd-sysv-generator[84]: Ignoring S02udev symlink in rcS.d, not generating udev.service. [ 7.353468] systemd-sysv-generator[84]: Ignoring S06checkfs.sh symlink in rcS.d, not generating checkfs.service. [ 7.353471] systemd-sysv-generator[84]: Ignoring S08mountall.sh symlink in rcS.d, not generating mountall.service. [ 7.353484] systemd-sysv-generator[84]: Ignoring K02ipmievd symlink in rc1.d, not generating ipmievd.service. [ 7.353487] systemd-sysv-generator[84]: Ignoring S01bootlogs symlink in rc1.d, not generating bootlogs.service. [ 7.353491] systemd-sysv-generator[84]: Ignoring S01killprocs symlink in rc1.d, not generating killprocs.service. [ 7.353494] systemd-sysv-generator[84]: Ignoring S01motd symlink in rc1.d, not generating motd.service. [ 7.353497] systemd-sysv-generator[84]: Ignoring K02mdadm symlink in rc1.d, not generating mdadm.service. [ 7.353503] systemd-sysv-generator[84]: Ignoring S02single symlink in rc1.d, not generating single.service. [ 7.353508] systemd-sysv-generator[84]: Ignoring K01watchdog symlink in rc1.d, not generating watchdog.service. [ 7.353522] systemd-sysv-generator[84]: Ignoring S77lkp-bootstrap symlink in rc2.d, not generating lkp-bootstrap.service. [ 7.353526] systemd-sysv-generator[84]: Ignoring S15wd_keepalive symlink in rc2.d, not generating wd_keepalive.service. [ 7.353529] systemd-sysv-generator[84]: Ignoring S01bootlogs symlink in rc2.d, not generating bootlogs.service. [ 7.353534] systemd-sysv-generator[84]: Ignoring S15ssh symlink in rc2.d, not generating ssh.service. [ 7.353538] systemd-sysv-generator[84]: Ignoring S15dbus symlink in rc2.d, not generating dbus.service. [ 7.353543] systemd-sysv-generator[84]: Ignoring S16watchdog symlink in rc2.d, not generating watchdog.service. [ 7.353547] systemd-sysv-generator[84]: Ignoring S01motd symlink in rc2.d, not generating motd.service. [ 7.353552] systemd-sysv-generator[84]: Ignoring S16rmnologin symlink in rc2.d, not generating rmnologin.service. [ 7.353555] systemd-sysv-generator[84]: Ignoring S15cron symlink in rc2.d, not generating cron.service. [ 7.353558] systemd-sysv-generator[84]: Ignoring S01mdadm symlink in rc2.d, not generating mdadm.service. [ 7.353561] systemd-sysv-generator[84]: Ignoring S15ipmievd symlink in rc2.d, not generating ipmievd.service. [ 7.353566] systemd-sysv-generator[84]: Ignoring S16rc.local symlink in rc2.d, not generating rc.local.service. [ 7.353579] systemd-sysv-generator[84]: Ignoring S15wd_keepalive symlink in rc3.d, not generating wd_keepalive.service. [ 7.353582] systemd-sysv-generator[84]: Ignoring S01bootlogs symlink in rc3.d, not generating bootlogs.service. [ 7.353587] systemd-sysv-generator[84]: Ignoring S15ssh symlink in rc3.d, not generating ssh.service. [ 7.353591] systemd-sysv-generator[84]: Ignoring S15dbus symlink in rc3.d, not generating dbus.service. [ 7.353596] systemd-sysv-generator[84]: Ignoring S16watchdog symlink in rc3.d, not generating watchdog.service. [ 7.353599] systemd-sysv-generator[84]: Ignoring S01motd symlink in rc3.d, not generating motd.service. [ 7.353605] systemd-sysv-generator[84]: Ignoring S16rmnologin symlink in rc3.d, not generating rmnologin.service. [ 7.353608] systemd-sysv-generator[84]: Ignoring S15cron symlink in rc3.d, not generating cron.service. [ 7.353611] systemd-sysv-generator[84]: Ignoring S01mdadm symlink in rc3.d, not generating mdadm.service. [ 7.353615] systemd-sysv-generator[84]: Ignoring S15ipmievd symlink in rc3.d, not generating ipmievd.service. [ 7.353620] systemd-sysv-generator[84]: Ignoring S16rc.local symlink in rc3.d, not generating rc.local.service. [ 7.353637] systemd-sysv-generator[84]: Ignoring S15wd_keepalive symlink in rc4.d, not generating wd_keepalive.service. [ 7.353641] systemd-sysv-generator[84]: Ignoring S01bootlogs symlink in rc4.d, not generating bootlogs.service. [ 7.353647] systemd-sysv-generator[84]: Ignoring S15ssh symlink in rc4.d, not generating ssh.service. [ 7.353650] systemd-sysv-generator[84]: Ignoring S15dbus symlink in rc4.d, not generating dbus.service. [ 7.353657] systemd-sysv-generator[84]: Ignoring S16watchdog symlink in rc4.d, not generating watchdog.service. [ 7.353660] systemd-sysv-generator[84]: Ignoring S01motd symlink in rc4.d, not generating motd.service. [ 7.353666] systemd-sysv-generator[84]: Ignoring S16rmnologin symlink in rc4.d, not generating rmnologin.service. [ 7.353670] systemd-sysv-generator[84]: Ignoring S15cron symlink in rc4.d, not generating cron.service. [ 7.353674] systemd-sysv-generator[84]: Ignoring S01mdadm symlink in rc4.d, not generating mdadm.service. [ 7.353678] systemd-sysv-generator[84]: Ignoring S15ipmievd symlink in rc4.d, not generating ipmievd.service. [ 7.353683] systemd-sysv-generator[84]: Ignoring S16rc.local symlink in rc4.d, not generating rc.local.service. [ 7.353699] systemd-sysv-generator[84]: Ignoring S15wd_keepalive symlink in rc5.d, not generating wd_keepalive.service. [ 7.353702] systemd-sysv-generator[84]: Ignoring S01bootlogs symlink in rc5.d, not generating bootlogs.service. [ 7.353708] systemd-sysv-generator[84]: Ignoring S15ssh symlink in rc5.d, not generating ssh.service. [ 7.353711] systemd-sysv-generator[84]: Ignoring S15dbus symlink in rc5.d, not generating dbus.service. [ 7.353716] systemd-sysv-generator[84]: Ignoring S16watchdog symlink in rc5.d, not generating watchdog.service. [ 7.353719] systemd-sysv-generator[84]: Ignoring S01motd symlink in rc5.d, not generating motd.service. [ 7.353725] systemd-sysv-generator[84]: Ignoring S16rmnologin symlink in rc5.d, not generating rmnologin.service. [ 7.353728] systemd-sysv-generator[84]: Ignoring S15cron symlink in rc5.d, not generating cron.service. [ 7.353731] systemd-sysv-generator[84]: Ignoring S01mdadm symlink in rc5.d, not generating mdadm.service. [ 7.353734] systemd-sysv-generator[84]: Ignoring S15ipmievd symlink in rc5.d, not generating ipmievd.service. [ 7.353741] systemd-sysv-generator[84]: Ignoring S16rc.local symlink in rc5.d, not generating rc.local.service. [ 7.353755] systemd-sysv-generator[84]: Ignoring K02ipmievd symlink in rc0.d, not generating ipmievd.service. [ 7.353760] systemd-sysv-generator[84]: Ignoring K09umountroot symlink in rc0.d, not generating umountroot.service. [ 7.353764] systemd-sysv-generator[84]: Ignoring K10mdadm-waitidle symlink in rc0.d, not generating mdadm-waitidle.service. [ 7.353767] systemd-sysv-generator[84]: Ignoring K11halt symlink in rc0.d, not generating halt.service. [ 7.353771] systemd-sysv-generator[84]: Ignoring K04sendsigs symlink in rc0.d, not generating sendsigs.service. [ 7.353774] systemd-sysv-generator[84]: Ignoring K02mdadm symlink in rc0.d, not generating mdadm.service. [ 7.353777] systemd-sysv-generator[84]: Ignoring K08umountfs symlink in rc0.d, not generating umountfs.service. [ 7.353783] systemd-sysv-generator[84]: Ignoring K05umountnfs.sh symlink in rc0.d, not generating umountnfs.service. [ 7.353786] systemd-sysv-generator[84]: Ignoring K02urandom symlink in rc0.d, not generating urandom.service. [ 7.353790] systemd-sysv-generator[84]: Ignoring K07hwclock.sh symlink in rc0.d, not generating hwclock.service. [ 7.353794] systemd-sysv-generator[84]: Ignoring K01watchdog symlink in rc0.d, not generating watchdog.service. [ 7.353807] systemd-sysv-generator[84]: Ignoring K02ipmievd symlink in rc6.d, not generating ipmievd.service. [ 7.353812] systemd-sysv-generator[84]: Ignoring K09umountroot symlink in rc6.d, not generating umountroot.service. [ 7.353817] systemd-sysv-generator[84]: Ignoring K10mdadm-waitidle symlink in rc6.d, not generating mdadm-waitidle.service. [ 7.353820] systemd-sysv-generator[84]: Ignoring K04sendsigs symlink in rc6.d, not generating sendsigs.service. [ 7.353823] systemd-sysv-generator[84]: Ignoring K12reboot symlink in rc6.d, not generating reboot.service. [ 7.353826] systemd-sysv-generator[84]: Ignoring K02mdadm symlink in rc6.d, not generating mdadm.service. [ 7.353830] systemd-sysv-generator[84]: Ignoring K08umountfs symlink in rc6.d, not generating umountfs.service. [ 7.353835] systemd-sysv-generator[84]: Ignoring K05umountnfs.sh symlink in rc6.d, not generating umountnfs.service. [ 7.353838] systemd-sysv-generator[84]: Ignoring K02urandom symlink in rc6.d, not generating urandom.service. [ 7.353842] systemd-sysv-generator[84]: Ignoring K07hwclock.sh symlink in rc6.d, not generating hwclock.service. [ 7.353848] systemd-sysv-generator[84]: Ignoring K01watchdog symlink in rc6.d, not generating watchdog.service. [ 8.148195] systemd-journald[100]: Fixed max_use=49.5M max_size=6.1M min_size=4.0M keep_free=74.2M [ 8.152355] systemd-journald[100]: Reserving 11264 entries in hash table. [ 8.154539] systemd-journald[100]: Vacuuming... [ 8.156055] systemd-journald[100]: Vacuuming done, freed 0 bytes [ 8.157910] systemd-journald[100]: Flushing /dev/kmsg... [ 8.187222] systemd-journald[100]: Compressed data object 960 -> 632 [ 8.199948] systemd-journald[100]: Compressed data object 967 -> 636 [ 8.216021] systemd-journald[100]: systemd-journald running as pid 100 [ 8.362094] systemd-udevd[121]: starting version 215 [ 8.551773] systemd-journald[100]: Received request to flush runtime journal from PID 1 [ 8.555356] systemd-journald[100]: Vacuuming... [ 8.556986] systemd-journald[100]: Vacuuming done, freed 0 bytes [ 8.639765] parport_pc 00:04: reported by Plug and Play ACPI [ 8.641848] parport0: PC-style at 0x378, irq 7 [PCSPP,TRISTATE] [ 8.645305] Floppy drive(s): fd0 is 1.44M [ 8.674908] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 8.706279] FDC 0 is a S82078B [ 8.726076] input: PC Speaker as /devices/platform/pcspkr/input/input4 [ 8.727814] scsi host0: Virtio SCSI HBA [ 8.747255] scsi 0:0:1:0: Direct-Access QEMU QEMU HARDDISK 2.1. PQ: 0 ANSI: 5 [ 8.750756] scsi 0:0:1:4: Direct-Access QEMU QEMU HARDDISK 2.1. PQ: 0 ANSI: 5 [ 8.759926] scsi 0:0:1:3: Direct-Access QEMU QEMU HARDDISK 2.1. PQ: 0 ANSI: 5 [ 8.766855] libata version 3.00 loaded. [ 8.767015] scsi 0:0:1:2: Direct-Access QEMU QEMU HARDDISK 2.1. PQ: 0 ANSI: 5 [ 8.768879] scsi 0:0:1:1: Direct-Access QEMU QEMU HARDDISK 2.1. PQ: 0 ANSI: 5 [ 8.834567] [drm] Initialized drm 1.1.0 20060810 ==> /tmp/stdout <== ==> /tmp/stderr <== [ 8.898310] ata_piix 0000:00:01.1: version 2.13 [ 8.900382] microcode: CPU0 sig=0x306c1, pf=0x1, revision=0x1 [ 8.902767] microcode: CPU1 sig=0x306c1, pf=0x1, revision=0x1 LKP: HOSTNAME vm-kbuild-1G-15, MAC 52:54:00:12:34:56, kernel 4.1.0-rc2-00101-g5025fe5 1, serial console /dev/ttyS0 ==> /tmp/stdout <== Kernel tests: Boot OK! [ 8.954265] scsi host1: ata_piix [ 8.957801] microcode: Microcode Update Driver: v2.00 , Peter Oruba [ 8.992838] scsi host2: ata_piix [ 8.992915] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc080 irq 14 [ 8.992917] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc088 irq 15 [ 9.027097] ppdev: user-space parallel port driver [ 9.152773] ata2.01: NODEV after polling detection [ 9.153099] ata2.00: ATAPI: QEMU DVD-ROM, 2.1.2, max UDMA/100 [ 9.153573] ata2.00: configured for MWDMA2 [ 9.186973] Error: Driver 'pcspkr' is already registered, aborting... [ 9.203055] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.1. PQ: 0 ANSI: 5 [ 9.297374] AVX version of gcm_enc/dec engaged. [ 9.297374] AES CTR mode by8 optimization enabled [ 9.320703] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray [ 9.320705] cdrom: Uniform CD-ROM driver Revision: 3.20 [ 9.320834] sr 2:0:0:0: Attached scsi CD-ROM sr0 [ 9.325785] sd 0:0:1:0: [sda] 536870912 512-byte logical blocks: (274 GB/256 GiB) [ 9.325803] sd 0:0:1:4: [sdb] 536870912 512-byte logical blocks: (274 GB/256 GiB) [ 9.325865] sd 0:0:1:3: [sdc] 536870912 512-byte logical blocks: (274 GB/256 GiB) [ 9.325893] sd 0:0:1:2: [sdd] 536870912 512-byte logical blocks: (274 GB/256 GiB) [ 9.326104] sd 0:0:1:4: [sdb] Write Protect is off [ 9.326107] sd 0:0:1:4: [sdb] Mode Sense: 63 00 00 08 [ 9.326188] sd 0:0:1:4: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 9.326238] sd 0:0:1:0: [sda] Write Protect is off [ 9.326240] sd 0:0:1:0: [sda] Mode Sense: 63 00 00 08 [ 9.326294] sd 0:0:1:3: [sdc] Write Protect is off [ 9.326296] sd 0:0:1:3: [sdc] Mode Sense: 63 00 00 08 [ 9.326414] sd 0:0:1:2: [sdd] Write Protect is off [ 9.326417] sd 0:0:1:2: [sdd] Mode Sense: 63 00 00 08 [ 9.326431] sd 0:0:1:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 9.326487] sd 0:0:1:3: [sdc] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 9.326563] sd 0:0:1:2: [sdd] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 9.330584] sd 0:0:1:0: [sda] Attached SCSI disk [ 9.330603] sd 0:0:1:2: [sdd] Attached SCSI disk [ 9.330607] sd 0:0:1:4: [sdb] Attached SCSI disk [ 9.330822] sd 0:0:1:1: [sde] 536870912 512-byte logical blocks: (274 GB/256 GiB) [ 9.330990] sd 0:0:1:3: [sdc] Attached SCSI disk [ 9.331101] sd 0:0:1:1: [sde] Write Protect is off [ 9.331103] sd 0:0:1:1: [sde] Mode Sense: 63 00 00 08 [ 9.331184] sd 0:0:1:1: [sde] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 9.360619] sd 0:0:1:0: Attached scsi generic sg0 type 0 [ 9.360641] sd 0:0:1:1: [sde] Attached SCSI disk [ 9.371020] sd 0:0:1:4: Attached scsi generic sg1 type 0 [ 9.371064] sd 0:0:1:3: Attached scsi generic sg2 type 0 [ 9.371105] sd 0:0:1:2: Attached scsi generic sg3 type 0 [ 9.371141] sd 0:0:1:1: Attached scsi generic sg4 type 0 [ 9.371183] sr 2:0:0:0: Attached scsi generic sg5 type 5 [ 9.468908] [TTM] Zone kernel: Available graphics memory: 506852 kiB [ 9.468909] [TTM] Initializing pool allocator [ 9.468915] [TTM] Initializing DMA pool allocator [ 9.470196] [drm] fb mappable at 0xFC000000 [ 9.470197] [drm] vram aper at 0xFC000000 [ 9.470197] [drm] size 33554432 [ 9.470198] [drm] fb depth is 24 [ 9.470198] [drm] pitch is 3072 [ 9.489299] fbcon: cirrusdrmfb (fb0) is primary device [ 9.522458] Console: switching to colour frame buffer device 128x48 [ 9.526200] random: nonblocking pool is initialized [ 9.570041] cirrus 0000:00:02.0: fb0: cirrusdrmfb frame buffer device [ 9.570912] cirrus 0000:00:02.0: registered panic notifier [ 9.616579] [drm] Initialized cirrus 1.0.0 20110418 for 0000:00:02.0 on minor 0 29 May 13:49:34 ntpdate[252]: step time server 192.168.1.1 offset 42.069199 sec PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/lkp/lkp/src/bin /lkp/lkp/src/bin/run-lkp RESULT_ROOT=/result/xfstests/4HDD-btrfs-generic-slow1/vm-kbuild-1G/debian-x86_64-2015-02-07.cgz/x86_64-rhel/gcc-4.9/5025fe55d485e2f08e99dce41e107c5b724ddf9c/0 job=/lkp/scheduled/vm-kbuild-1G-15/bisect_xfstests-4HDD-btrfs-generic-slow1-debian-x86_64-2015-02-07.cgz-x86_64-rhel-5025fe55d485e2f08e99dce41e107c5b724ddf9c-4-20150529-13367-1c9wmmp.yaml [ 15.207077] Key type dns_resolver registered [ 15.225033] NFS: Registering the id_resolver key type [ 15.225850] Key type id_resolver registered [ 15.226633] Key type id_legacy registered run-job /lkp/scheduled/vm-kbuild-1G-15/bisect_xfstests-4HDD-btrfs-generic-slow1-debian-x86_64-2015-02-07.cgz-x86_64-rhel-5025fe55d485e2f08e99dce41e107c5b724ddf9c-4-20150529-13367-1c9wmmp.yaml 2015-05-29 13:49:35 mkfs -t btrfs /dev/sdd 2015-05-29 13:49:35 mkfs -t btrfs /dev/sdc 2015-05-29 13:49:35 mkfs -t btrfs /dev/sdb 2015-05-29 13:49:35 mkfs -t btrfs /dev/sda ==> /tmp/stderr <== Performing full device TRIM (256.00GiB) ... Performing full device TRIM (256.00GiB) ... Performing full device TRIM (256.00GiB) ... Performing full device TRIM (256.00GiB) ... [ 15.856357] ------------[ cut here ]------------ [ 15.857129] WARNING: CPU: 0 PID: 419 at mm/memcontrol.c:627 mem_cgroup_css_from_page+0x4e/0x60() [ 15.868902] Modules linked in: rpcsec_gss_krb5 auth_rpcgss nfsv4 dns_resolver crct10dif_pclmul crc32_pclmul crc32c_intel ghash_clmulni_intel sg sd_mod sr_mod cirrus cdrom ata_generic pata_acpi syscopyarea aesni_intel sysfillrect lrw gf128mul snd_pcm sysimgblt ttm ppdev drm_kms_helper glue_helper ablk_helper cryptd snd_timer snd ata_piix microcode soundcore libata drm pcspkr serio_raw virtio_scsi i2c_piix4 parport_pc parport floppy acpi_cpufreq [ 15.885082] CPU: 0 PID: 419 Comm: mkfs.btrfs Not tainted 4.1.0-rc2-00101-g5025fe5 #1 [ 15.886202] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.7.5-20140531_083030-gandalf 04/01/2014 [ 15.887822] ffffffff81b9bc10 ffff88003e4b7b58 ffffffff818c3f17 ffff880036c12338 [ 15.904717] 0000000000000000 ffff88003e4b7b98 ffffffff8107666a 0000000000000010 [ 15.905950] ffff88003e4b7e78 0000000000001000 0000000000000001 0000000000000000 [ 15.907771] Call Trace: [ 15.908222] [] dump_stack+0x4c/0x65 [ 15.908969] [] warn_slowpath_common+0x8a/0xc0 [ 15.920923] [] warn_slowpath_null+0x1a/0x20 [ 15.932553] [] mem_cgroup_css_from_page+0x4e/0x60 [ 15.933750] [] wbc_account_io+0x21/0x90 [ 15.934775] [] submit_bh_wbc+0xa7/0x1a0 [ 15.935740] [] __block_write_full_page+0x13c/0x440 [ 15.937103] [] ? I_BDEV+0x10/0x10 [ 15.938077] [] block_write_full_page+0x105/0x120 [ 15.939035] [] blkdev_writepage+0x18/0x20 [ 15.941867] [] __writepage+0x17/0x40 [ 15.942803] ------------[ cut here ]------------ [ 15.942809] WARNING: CPU: 1 PID: 418 at mm/memcontrol.c:627 mem_cgroup_css_from_page+0x4e/0x60() [ 15.942831] Modules linked in: rpcsec_gss_krb5 auth_rpcgss nfsv4 dns_resolver crct10dif_pclmul crc32_pclmul crc32c_intel ghash_clmulni_intel sg sd_mod sr_mod cirrus cdrom ata_generic pata_acpi syscopyarea aesni_intel sysfillrect lrw gf128mul snd_pcm sysimgblt ttm ppdev drm_kms_helper glue_helper ablk_helper cryptd snd_timer snd ata_piix microcode soundcore libata drm pcspkr serio_raw virtio_scsi i2c_piix4 parport_pc parport floppy acpi_cpufreq [ 15.991279] [] write_cache_pages+0x234/0x4f0 [ 15.994214] [] ? wb_position_ratio+0x1f0/0x1f0 [ 15.997117] [] generic_writepages+0x40/0x60 [ 16.000039] [] do_writepages+0x1e/0x30 [ 16.009577] [] __filemap_fdatawrite_range+0xb0/0x100 [ 16.012747] [] SyS_fadvise64+0x101/0x2a0 [ 16.015664] [] ? schedule+0x37/0x90 [ 16.018353] [] system_call_fastpath+0x12/0x71 [ 16.034223] ---[ end trace 02e9712fa0a6fa2e ]--- [ 16.034227] CPU: 1 PID: 418 Comm: mkfs.btrfs Not tainted 4.1.0-rc2-00101-g5025fe5 #1 [ 16.034228] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.7.5-20140531_083030-gandalf 04/01/2014 [ 16.034233] ffffffff81b9bc10 ffff88003ed6fb58 ffffffff818c3f17 000000004d5e4d5e [ 16.034234] 0000000000000000 ffff88003ed6fb98 ffffffff8107666a 0000000000000010 [ 16.034236] ffff88003ed6fe78 0000000000001000 0000000000000001 0000000000000000 [ 16.034236] Call Trace: [ 16.034244] [] dump_stack+0x4c/0x65 [ 16.034248] [] warn_slowpath_common+0x8a/0xc0 [ 16.034249] [] warn_slowpath_null+0x1a/0x20 [ 16.034255] [] mem_cgroup_css_from_page+0x4e/0x60 [ 16.034258] [] wbc_account_io+0x21/0x90 [ 16.034261] [] submit_bh_wbc+0xa7/0x1a0 [ 16.034263] [] __block_write_full_page+0x13c/0x440 [ 16.034265] [] ? I_BDEV+0x10/0x10 [ 16.034266] [] block_write_full_page+0x105/0x120 [ 16.034268] [] blkdev_writepage+0x18/0x20 [ 16.034272] [] __writepage+0x17/0x40 [ 16.034273] [] write_cache_pages+0x234/0x4f0 [ 16.034275] [] ? wb_position_ratio+0x1f0/0x1f0 [ 16.034277] [] generic_writepages+0x40/0x60 [ 16.034278] [] do_writepages+0x1e/0x30 [ 16.034280] [] __filemap_fdatawrite_range+0xb0/0x100 [ 16.034283] [] SyS_fadvise64+0x101/0x2a0 [ 16.034285] [] system_call_fastpath+0x12/0x71 [ 16.034286] ---[ end trace 02e9712fa0a6fa2f ]--- [ 16.268308] raid6: sse2x1 gen() 2804 MB/s [ 16.286018] raid6: sse2x1 xor() 3679 MB/s [ 16.305016] raid6: sse2x2 gen() 6652 MB/s [ 16.325018] raid6: sse2x2 xor() 4669 MB/s [ 16.344021] raid6: sse2x4 gen() 7750 MB/s [ 16.363017] raid6: sse2x4 xor() 5152 MB/s [ 16.365348] raid6: using algorithm sse2x4 gen() 7750 MB/s [ 16.367781] raid6: .... xor() 5152 MB/s, rmw enabled [ 16.370139] raid6: using ssse3x2 recovery algorithm [ 16.374028] xor: automatically using best checksumming function: [ 16.386012] avx : 13860.000 MB/sec [ 16.431455] Btrfs loaded [ 16.433670] BTRFS: device fsid 01436339-51ad-4c03-9444-57ee2e1b0e5b devid 1 transid 3 /dev/sdb [ 18.672710] BTRFS: device fsid dfd03890-2d5c-439f-96a9-88ba36cb93fb devid 1 transid 3 /dev/sda [ 18.676328] BTRFS: device fsid aadf8825-2ffb-48da-9b5b-69de11a96b3d devid 1 transid 3 /dev/sdd [ 19.034230] BTRFS: device fsid 1d22d391-e047-4d38-9e29-bdd83009f6ba devid 1 transid 3 /dev/sdc ==> /tmp/stdout <== Btrfs v3.17 See http://btrfs.wiki.kernel.org for more information. Turning ON incompat feature 'extref': increased hardlink limit per file to 65536 fs created label (null) on /dev/sdb Btrfs v3.17 See http://btrfs.wiki.kernel.org for more information. Turning ON incompat feature 'extref': increased hardlink limit per file to 65536 fs created label (null) on /dev/sdd Btrfs v3.17 See http://btrfs.wiki.kernel.org for more information. Turning ON incompat feature 'extref': increased hardlink limit per file to 65536 fs created label (null) on /dev/sdc Btrfs v3.17 See http://btrfs.wiki.kernel.org for more information. Turning ON incompat feature 'extref': increased hardlink limit per file to 65536 fs created label (null) on /dev/sda 2015-05-29 13:49:39 mount -t btrfs /dev/sda /fs/sda [ 20.522264] BTRFS info (device sda): disk space caching is enabled [ 20.525004] BTRFS: flagging fs with big metadata feature [ 20.645337] BTRFS: creating UUID tree 2015-05-29 13:49:40 mount -t btrfs /dev/sdb /fs/sdb [ 21.210796] BTRFS info (device sdb): disk space caching is enabled [ 21.213631] BTRFS: flagging fs with big metadata feature [ 21.392131] BTRFS: creating UUID tree 2015-05-29 13:49:41 mount -t btrfs /dev/sdc /fs/sdc [ 22.069929] BTRFS info (device sdc): disk space caching is enabled [ 22.075148] BTRFS: flagging fs with big metadata feature [ 22.382897] BTRFS: creating UUID tree 2015-05-29 13:49:42 mount -t btrfs /dev/sdd /fs/sdd [ 22.851961] BTRFS info (device sdd): disk space caching is enabled [ 22.855022] BTRFS: flagging fs with big metadata feature [ 22.980971] BTRFS: creating UUID tree 2015-05-29 13:49:46 export TEST_DIR=/fs/sda 2015-05-29 13:49:46 export TEST_DEV=/dev/sda 2015-05-29 13:49:46 export FSTYP= 2015-05-29 13:49:46 export SCRATCH_MNT=/fs/scratch 2015-05-29 13:49:46 mkdir /fs/scratch -p 2015-05-29 13:49:46 export SCRATCH_DEV=/dev/sdd 2015-05-29 13:49:46 ./check generic/074 generic/075 generic/112 generic/132 generic/133 [ 28.413415] BTRFS info (device sda): disk space caching is enabled FSTYP -- btrfs PLATFORM -- Linux/x86_64 vm-kbuild-1G-15 4.1.0-rc2-00101-g5025fe5 MKFS_OPTIONS -- /dev/sdd MOUNT_OPTIONS -- /dev/sdd /fs/scratch [ 29.083965] BTRFS: device fsid 8ace08c6-53ec-4ff2-8662-4ddbb19c6230 devid 1 transid 3 /dev/sdd [ 29.511158] BTRFS info (device sdd): disk space caching is enabled [ 29.514060] BTRFS: flagging fs with big metadata feature [ 29.523848] BTRFS: creating UUID tree [ 29.977283] BTRFS info (device sda): disk space caching is enabled [ 32.312055] BTRFS info (device sda): disk space caching is enabled [ 35.272018] BTRFS info (device sda): disk space caching is enabled [ 75.690581] ipmi message handler version 39.2 [ 75.704314] IPMI Watchdog: driver initialized [ 203.232149] BTRFS info (device sda): disk space caching is enabled [ 310.379611] sched: RT throttling activated [ 384.319468] BTRFS info (device sda): disk space caching is enabled [ 440.547392] BTRFS info (device sda): disk space caching is enabled 410s [ 442.443260] BTRFS info (device sda): disk space caching is enabled [ 527.753309] BTRFS info (device sda): disk space caching is enabled [ 1257.072106] BTRFS info (device sda): disk space caching is enabled 814s [ 1257.859589] BTRFS info (device sda): disk space caching is enabled [ 1275.164090] BTRFS info (device sda): disk space caching is enabled [ 1426.069938] BTRFS info (device sda): disk space caching is enabled 168s [ 1426.670027] BTRFS info (device sda): disk space caching is enabled [ 1428.148454] BTRFS info (device sdd): disk space caching is enabled [ 1428.151159] BTRFS: flagging fs with big metadata feature [ 1428.172284] BTRFS: creating UUID tree [ 1447.121014] hrtimer: interrupt took 17004040 ns 86s [ 1513.147299] BTRFS info (device sda): disk space caching is enabled [ 1640.138957] BTRFS info (device sda): disk space caching is enabled Ran: generic/074 generic/075 generic/112 generic/132 generic/133 Passed all 5 tests [ 1641.164972] i6300esb: Unexpected close, not stopping watchdog! wget --local-encoding=UTF-8 http://inn:/~lkp/cgi-bin/lkp-post-run?job_file=/lkp/scheduled/vm-kbuild-1G-15/bisect_xfstests-4HDD-btrfs-generic-slow1-debian-x86_64-2015-02-07.cgz-x86_64-rhel-5025fe55d485e2f08e99dce41e107c5b724ddf9c-4-20150529-13367-1c9wmmp.yaml Elapsed time: 1640 qemu-system-x86_64 -enable-kvm -cpu Haswell,+smep,+smap -kernel /pkg/linux/x86_64-rhel/gcc-4.9/5025fe55d485e2f08e99dce41e107c5b724ddf9c/vmlinuz-4.1.0-rc2-00101-g5025fe5 -append 'root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-kbuild-1G-15/bisect_xfstests-4HDD-btrfs-generic-slow1-debian-x86_64-2015-02-07.cgz-x86_64-rhel-5025fe55d485e2f08e99dce41e107c5b724ddf9c-4-20150529-13367-1c9wmmp.yaml ARCH=x86_64 kconfig=x86_64-rhel branch=cgroup/review-cgroup-writeback-switch-20150522 commit=5025fe55d485e2f08e99dce41e107c5b724ddf9c BOOT_IMAGE=/pkg/linux/x86_64-rhel/gcc-4.9/5025fe55d485e2f08e99dce41e107c5b724ddf9c/vmlinuz-4.1.0-rc2-00101-g5025fe5 max_uptime=3600 RESULT_ROOT=/result/xfstests/4HDD-btrfs-generic-slow1/vm-kbuild-1G/debian-x86_64-2015-02-07.cgz/x86_64-rhel/gcc-4.9/5025fe55d485e2f08e99dce41e107c5b724ddf9c/0 LKP_SERVER=inn earlyprintk=ttyS0,115200 systemd.log_level=err debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 console=ttyS0,115200 console=tty0 vga=normal rw ip=::::vm-kbuild-1G-15::dhcp' -initrd /fs/sda1/initrd-vm-kbuild-1G-15 -m 1024 -smp 2 -device e1000,netdev=net0 -netdev user,id=net0 -boot order=nc -no-reboot -watchdog i6300esb -rtc base=localtime -device virtio-scsi-pci,id=scsi0 -drive file=/fs/sda1/disk0-vm-kbuild-1G-15,if=none,id=hd0,media=disk,aio=native,cache=none -device scsi-hd,bus=scsi0.0,drive=hd0,scsi-id=1,lun=0 -drive file=/fs/sda1/disk1-vm-kbuild-1G-15,if=none,id=hd1,media=disk,aio=native,cache=none -device scsi-hd,bus=scsi0.0,drive=hd1,scsi-id=1,lun=1 -drive file=/fs/sda1/disk2-vm-kbuild-1G-15,if=none,id=hd2,media=disk,aio=native,cache=none -device scsi-hd,bus=scsi0.0,drive=hd2,scsi-id=1,lun=2 -drive file=/fs/sda1/disk3-vm-kbuild-1G-15,if=none,id=hd3,media=disk,aio=native,cache=none -device scsi-hd,bus=scsi0.0,drive=hd3,scsi-id=1,lun=3 -drive file=/fs/sda1/disk4-vm-kbuild-1G-15,if=none,id=hd4,media=disk,aio=native,cache=none -device scsi-hd,bus=scsi0.0,drive=hd4,scsi-id=1,lun=4 -pidfile /dev/shm/kboot/pid-vm-kbuild-1G-15 -serial file:/dev/shm/kboot/serial-vm-kbuild-1G-15 -daemonize -display none -monitor null