early console in setup code 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 3.10.0-rc3-00005-g003002e (kbuild@jaketown) (gcc version 4.8.2 (Debian 4.8.2-18) ) #9 Thu Aug 28 10:08:37 CST 2014 [ 0.000000] Command line: hung_task_panic=1 earlyprintk=ttyS0,115200 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 root=/dev/ram0 rw link=/kbuild-tests/run-queue/kvm/x86_64-randconfig-ib1-08280643/next:master:003002e04ed38618fc37b92ba128f5ca79d39f4f:bisect-linux-8/.vmlinuz-003002e04ed38618fc37b92ba128f5ca79d39f4f-20140828101046-11-vp branch=next/master BOOT_IMAGE=/kernel/x86_64-randconfig-ib1-08280643/003002e04ed38618fc37b92ba128f5ca79d39f4f/vmlinuz-3.10.0-rc3-00005-g003002e drbd.minor_count=8 [ 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-0x0000000013ffdfff] usable [ 0.000000] BIOS-e820: [mem 0x0000000013ffe000-0x0000000013ffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved [ 0.000000] bootconsole [earlyser0] enabled [ 0.000000] NX (Execute Disable) protection: active [ 0.000000] SMBIOS 2.4 present. [ 0.000000] DMI: Bochs Bochs, BIOS Bochs 01/01/2011 [ 0.000000] Hypervisor detected: KVM [ 0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved [ 0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable [ 0.000000] No AGP bridge found [ 0.000000] e820: last_pfn = 0x13ffe 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] x86 PAT enabled: cpu 0, old 0x70406, new 0x7010600070106 [ 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 [0x0420f000, 0x0420ffff] PGTABLE [ 0.000000] BRK [0x04210000, 0x04210fff] PGTABLE [ 0.000000] BRK [0x04211000, 0x04211fff] PGTABLE [ 0.000000] init_memory_mapping: [mem 0x13a00000-0x13bfffff] [ 0.000000] [mem 0x13a00000-0x13bfffff] page 4k [ 0.000000] BRK [0x04212000, 0x04212fff] PGTABLE [ 0.000000] init_memory_mapping: [mem 0x10000000-0x139fffff] [ 0.000000] [mem 0x10000000-0x139fffff] page 4k [ 0.000000] BRK [0x04213000, 0x04213fff] PGTABLE [ 0.000000] init_memory_mapping: [mem 0x00100000-0x0fffffff] [ 0.000000] [mem 0x00100000-0x0fffffff] page 4k [ 0.000000] init_memory_mapping: [mem 0x13c00000-0x13ffdfff] [ 0.000000] [mem 0x13c00000-0x13ffdfff] page 4k [ 0.000000] RAMDISK: [mem 0x13ce6000-0x13feffff] [ 0.000000] ACPI: RSDP 00000000000fd970 00014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0000000013ffe4b0 00034 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0000000013ffff80 00074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0000000013ffe4f0 011A9 (v01 BXPC BXDSDT 00000001 INTL 20100528) [ 0.000000] ACPI: FACS 0000000013ffff40 00040 [ 0.000000] ACPI: SSDT 0000000013fff800 00735 (v01 BOCHS BXPCSSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: APIC 0000000013fff6e0 00078 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0000000013fff6a0 00038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001) [ 0.000000] ACPI: Local APIC address 0xfee00000 [ 0.000000] mapped APIC to ffffffffff5fa000 ( fee00000) [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000000] kvm-clock: cpu 0, msr 0:13ffd001, boot clock [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x00001000-0x00ffffff] [ 0.000000] DMA32 [mem 0x01000000-0xffffffff] [ 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-0x13ffdfff] [ 0.000000] On node 0 totalpages: 81820 [ 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: 1216 pages used for memmap [ 0.000000] DMA32 zone: 77822 pages, LIFO batch:15 [ 0.000000] ACPI: PM-Timer IO Port: 0xb008 [ 0.000000] ACPI: Local APIC address 0xfee00000 [ 0.000000] mapped APIC to ffffffffff5fa000 ( fee00000) [ 0.000000] ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled) [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] ACPI: IOAPIC (id[0x00] address[0xfec00000] gsi_base[0]) [ 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] ACPI: IRQ2 used by override. [ 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] mapped IOAPIC to ffffffffff5f9000 (fec00000) [ 0.000000] nr_irqs_gsi: 40 [ 0.000000] KVM setup async PF for cpu 0 [ 0.000000] kvm-stealtime: cpu 0, msr 27e0100 [ 0.000000] e820: [mem 0x14000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768 [ 0.000000] pcpu-alloc: [0] 0 [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 80519 [ 0.000000] Kernel command line: hung_task_panic=1 earlyprintk=ttyS0,115200 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 root=/dev/ram0 rw link=/kbuild-tests/run-queue/kvm/x86_64-randconfig-ib1-08280643/next:master:003002e04ed38618fc37b92ba128f5ca79d39f4f:bisect-linux-8/.vmlinuz-003002e04ed38618fc37b92ba128f5ca79d39f4f-20140828101046-11-vp branch=next/master BOOT_IMAGE=/kernel/x86_64-randconfig-ib1-08280643/003002e04ed38618fc37b92ba128f5ca79d39f4f/vmlinuz-3.10.0-rc3-00005-g003002e drbd.minor_count=8 [ 0.000000] sysrq: sysrq always enabled. [ 0.000000] PID hash table entries: 2048 (order: 2, 16384 bytes) [ 0.000000] Dentry cache hash table entries: 65536 (order: 7, 524288 bytes) [ 0.000000] Inode-cache hash table entries: 32768 (order: 6, 262144 bytes) [ 0.000000] Checking aperture... [ 0.000000] No AGP bridge found [ 0.000000] Memory: 265148k/327672k available (15602k kernel code, 392k absent, 62132k reserved, 19169k data, 1428k init) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 [ 0.000000] NR_IRQS:4352 nr_irqs:256 16 [ 0.000000] Console: colour VGA+ 80x25 [ 0.000000] console [tty0] enabled, bootconsole disabled [ 0.000000] Initializing cgroup subsys cpuset [ 0.000000] Initializing cgroup subsys cpu [ 0.000000] Linux version 3.10.0-rc3-00005-g003002e (kbuild@jaketown) (gcc version 4.8.2 (Debian 4.8.2-18) ) #9 Thu Aug 28 10:08:37 CST 2014 [ 0.000000] Command line: hung_task_panic=1 earlyprintk=ttyS0,115200 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 root=/dev/ram0 rw link=/kbuild-tests/run-queue/kvm/x86_64-randconfig-ib1-08280643/next:master:003002e04ed38618fc37b92ba128f5ca79d39f4f:bisect-linux-8/.vmlinuz-003002e04ed38618fc37b92ba128f5ca79d39f4f-20140828101046-11-vp branch=next/master BOOT_IMAGE=/kernel/x86_64-randconfig-ib1-08280643/003002e04ed38618fc37b92ba128f5ca79d39f4f/vmlinuz-3.10.0-rc3-00005-g003002e drbd.minor_count=8 [ 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-0x0000000013ffdfff] usable [ 0.000000] BIOS-e820: [mem 0x0000000013ffe000-0x0000000013ffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved [ 0.000000] bootconsole [earlyser0] enabled [ 0.000000] NX (Execute Disable) protection: active [ 0.000000] SMBIOS 2.4 present. [ 0.000000] DMI: Bochs Bochs, BIOS Bochs 01/01/2011 [ 0.000000] Hypervisor detected: KVM [ 0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved [ 0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable [ 0.000000] No AGP bridge found [ 0.000000] e820: last_pfn = 0x13ffe 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] x86 PAT enabled: cpu 0, old 0x70406, new 0x7010600070106 [ 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 [0x0420f000, 0x0420ffff] PGTABLE [ 0.000000] BRK [0x04210000, 0x04210fff] PGTABLE [ 0.000000] BRK [0x04211000, 0x04211fff] PGTABLE [ 0.000000] init_memory_mapping: [mem 0x13a00000-0x13bfffff] [ 0.000000] [mem 0x13a00000-0x13bfffff] page 4k [ 0.000000] BRK [0x04212000, 0x04212fff] PGTABLE [ 0.000000] init_memory_mapping: [mem 0x10000000-0x139fffff] [ 0.000000] [mem 0x10000000-0x139fffff] page 4k [ 0.000000] BRK [0x04213000, 0x04213fff] PGTABLE [ 0.000000] init_memory_mapping: [mem 0x00100000-0x0fffffff] [ 0.000000] [mem 0x00100000-0x0fffffff] page 4k [ 0.000000] init_memory_mapping: [mem 0x13c00000-0x13ffdfff] [ 0.000000] [mem 0x13c00000-0x13ffdfff] page 4k [ 0.000000] RAMDISK: [mem 0x13ce6000-0x13feffff] [ 0.000000] ACPI: RSDP 00000000000fd970 00014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0000000013ffe4b0 00034 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0000000013ffff80 00074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0000000013ffe4f0 011A9 (v01 BXPC BXDSDT 00000001 INTL 20100528) [ 0.000000] ACPI: FACS 0000000013ffff40 00040 [ 0.000000] ACPI: SSDT 0000000013fff800 00735 (v01 BOCHS BXPCSSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: APIC 0000000013fff6e0 00078 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0000000013fff6a0 00038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001) [ 0.000000] ACPI: Local APIC address 0xfee00000 [ 0.000000] mapped APIC to ffffffffff5fa000 ( fee00000) [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000000] kvm-clock: cpu 0, msr 0:13ffd001, boot clock [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x00001000-0x00ffffff] [ 0.000000] DMA32 [mem 0x01000000-0xffffffff] [ 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-0x13ffdfff] [ 0.000000] On node 0 totalpages: 81820 [ 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: 1216 pages used for memmap [ 0.000000] DMA32 zone: 77822 pages, LIFO batch:15 [ 0.000000] ACPI: PM-Timer IO Port: 0xb008 [ 0.000000] ACPI: Local APIC address 0xfee00000 [ 0.000000] mapped APIC to ffffffffff5fa000 ( fee00000) [ 0.000000] ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled) [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] ACPI: IOAPIC (id[0x00] address[0xfec00000] gsi_base[0]) [ 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] ACPI: IRQ2 used by override. [ 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] mapped IOAPIC to ffffffffff5f9000 (fec00000) [ 0.000000] nr_irqs_gsi: 40 [ 0.000000] KVM setup async PF for cpu 0 [ 0.000000] kvm-stealtime: cpu 0, msr 27e0100 [ 0.000000] e820: [mem 0x14000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768 [ 0.000000] pcpu-alloc: [0] 0 [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 80519 [ 0.000000] Kernel command line: hung_task_panic=1 earlyprintk=ttyS0,115200 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 root=/dev/ram0 rw link=/kbuild-tests/run-queue/kvm/x86_64-randconfig-ib1-08280643/next:master:003002e04ed38618fc37b92ba128f5ca79d39f4f:bisect-linux-8/.vmlinuz-003002e04ed38618fc37b92ba128f5ca79d39f4f-20140828101046-11-vp branch=next/master BOOT_IMAGE=/kernel/x86_64-randconfig-ib1-08280643/003002e04ed38618fc37b92ba128f5ca79d39f4f/vmlinuz-3.10.0-rc3-00005-g003002e drbd.minor_count=8 [ 0.000000] sysrq: sysrq always enabled. [ 0.000000] PID hash table entries: 2048 (order: 2, 16384 bytes) [ 0.000000] Dentry cache hash table entries: 65536 (order: 7, 524288 bytes) [ 0.000000] Inode-cache hash table entries: 32768 (order: 6, 262144 bytes) [ 0.000000] Checking aperture... [ 0.000000] No AGP bridge found [ 0.000000] Memory: 265148k/327672k available (15602k kernel code, 392k absent, 62132k reserved, 19169k data, 1428k init) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 [ 0.000000] NR_IRQS:4352 nr_irqs:256 16 [ 0.000000] Console: colour VGA+ 80x25 [ 0.000000] console [tty0] enabled, bootconsole disabled [ 0.000000] console [ttyS0] enabled [ 0.000000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar [ 0.000000] ... MAX_LOCKDEP_SUBCLASSES: 8 [ 0.000000] ... MAX_LOCK_DEPTH: 48 [ 0.000000] ... MAX_LOCKDEP_KEYS: 8191 [ 0.000000] ... CLASSHASH_SIZE: 4096 [ 0.000000] ... MAX_LOCKDEP_ENTRIES: 16384 [ 0.000000] ... MAX_LOCKDEP_CHAINS: 32768 [ 0.000000] ... CHAINHASH_SIZE: 16384 [ 0.000000] memory used by lock dependency info: 6335 kB [ 0.000000] per task-struct memory footprint: 2688 bytes [ 0.000000] ------------------------ [ 0.000000] | Locking API testsuite: [ 0.000000] ---------------------------------------------------------------------------- [ 0.000000] | spin |wlock |rlock |mutex | wsem | rsem | [ 0.000000] -------------------------------------------------------------------------- [ 0.000000] A-A deadlock:failed|failed| ok |failed|failed|failed| [ 0.000000] A-B-B-A deadlock:failed|failed| ok |failed|failed|failed| [ 0.000000] A-B-B-C-C-A deadlock:failed|failed| ok |failed|failed|failed| [ 0.000000] A-B-C-A-B-C deadlock:failed|failed| ok |failed|failed|failed| [ 0.000000] A-B-B-C-C-D-D-A deadlock:failed|failed| ok |failed|failed|failed| [ 0.000000] A-B-C-D-B-D-D-A deadlock:failed|failed| ok |failed|failed|failed| [ 0.000000] A-B-C-D-B-C-D-A deadlock:failed|failed| ok |failed|failed|failed| [ 0.000000] double unlock: ok | ok | ok | ok | ok | ok | [ 0.000000] initialize held: ok | ok | ok | ok | ok | ok | [ 0.000000] bad unlock order: ok | ok | ok | ok | ok | ok | [ 0.000000] -------------------------------------------------------------------------- [ 0.000000] recursive read-lock: | ok | |failed| [ 0.000000] recursive read-lock #2: | ok | |failed| [ 0.000000] mixed read-write-lock: |failed| |failed| [ 0.000000] mixed write-read-lock: |failed| |failed| [ 0.000000] -------------------------------------------------------------------------- [ 0.000000] hard-irqs-on + irq-safe-A/12:failed|failed| ok | [ 0.000000] soft-irqs-on + irq-safe-A/12:failed|failed| ok | [ 0.000000] hard-irqs-on + irq-safe-A/21:failed|failed| ok | [ 0.000000] soft-irqs-on + irq-safe-A/21:failed|failed| ok | [ 0.000000] sirq-safe-A => hirqs-on/12:failed|failed| ok | [ 0.000000] sirq-safe-A => hirqs-on/21:failed|failed| ok | [ 0.000000] hard-safe-A + irqs-on/12:failed|failed| ok | [ 0.000000] soft-safe-A + irqs-on/12:failed|failed| ok | [ 0.000000] hard-safe-A + irqs-on/21:failed|failed| ok | [ 0.000000] soft-safe-A + irqs-on/21:failed|failed| ok | [ 0.000000] hard-safe-A + unsafe-B #1/123:failed|failed| ok | [ 0.000000] soft-safe-A + unsafe-B #1/123:failed|failed| ok | [ 0.000000] hard-safe-A + unsafe-B #1/132:failed|failed| ok | [ 0.000000] soft-safe-A + unsafe-B #1/132:failed|failed| ok | [ 0.000000] hard-safe-A + unsafe-B #1/213:failed|failed| ok | [ 0.000000] soft-safe-A + unsafe-B #1/213:failed|failed| ok | [ 0.000000] hard-safe-A + unsafe-B #1/231:failed|failed| ok | [ 0.000000] soft-safe-A + unsafe-B #1/231:failed|failed| ok | [ 0.000000] hard-safe-A + unsafe-B #1/312:failed|failed| ok | [ 0.000000] soft-safe-A + unsafe-B #1/312:failed|failed| ok | [ 0.000000] hard-safe-A + unsafe-B #1/321:failed|failed| ok | [ 0.000000] soft-safe-A + unsafe-B #1/321:failed|failed| ok | [ 0.000000] hard-safe-A + unsafe-B #2/123:failed|failed| ok | [ 0.000000] soft-safe-A + unsafe-B #2/123:failed|failed| ok | [ 0.000000] hard-safe-A + unsafe-B #2/132:failed|failed| ok | [ 0.000000] soft-safe-A + unsafe-B #2/132:failed|failed| ok | [ 0.000000] hard-safe-A + unsafe-B #2/213:failed|failed| ok | [ 0.000000] soft-safe-A + unsafe-B #2/213:failed|failed| ok | [ 0.000000] hard-safe-A + unsafe-B #2/231:failed|failed| ok | [ 0.000000] soft-safe-A + unsafe-B #2/231:failed|failed| ok | [ 0.000000] hard-safe-A + unsafe-B #2/312:failed|failed| ok | [ 0.000000] soft-safe-A + unsafe-B #2/312:failed|failed| ok | [ 0.000000] hard-safe-A + unsafe-B #2/321:failed|failed| ok | [ 0.000000] soft-safe-A + unsafe-B #2/321:failed|failed| ok | [ 0.000000] hard-irq lock-inversion/123:failed|failed| ok | [ 0.000000] soft-irq lock-inversion/123:failed|failed| ok | [ 0.000000] hard-irq lock-inversion/132:failed|failed| ok | [ 0.000000] soft-irq lock-inversion/132:failed|failed| ok | [ 0.000000] hard-irq lock-inversion/213:failed|failed| ok | [ 0.000000] soft-irq lock-inversion/213:failed|failed| ok | [ 0.000000] hard-irq lock-inversion/231:failed|failed| ok | [ 0.000000] soft-irq lock-inversion/231:failed|failed| ok | [ 0.000000] hard-irq lock-inversion/312:failed|failed| ok | [ 0.000000] soft-irq lock-inversion/312:failed|failed| ok | [ 0.000000] hard-irq lock-inversion/321:failed|failed| ok | [ 0.000000] soft-irq lock-inversion/321:failed|failed| ok | [ 0.000000] hard-irq read-recursion/123: ok | [ 0.000000] soft-irq read-recursion/123: ok | [ 0.000000] hard-irq read-recursion/132: ok | [ 0.000000] soft-irq read-recursion/132: ok | [ 0.000000] hard-irq read-recursion/213: ok | [ 0.000000] soft-irq read-recursion/213: ok | [ 0.000000] hard-irq read-recursion/231: ok | [ 0.000000] soft-irq read-recursion/231: ok | [ 0.000000] hard-irq read-recursion/312: ok | [ 0.000000] soft-irq read-recursion/312: ok | [ 0.000000] hard-irq read-recursion/321: ok | [ 0.000000] soft-irq read-recursion/321: ok | [ 0.000000] -------------------------------------------------------- [ 0.000000] 133 out of 218 testcases failed, as expected. | [ 0.000000] ---------------------------------------------------- [ 0.000000] ODEBUG: 8 of 8 active objects replaced [ 0.000000] ODEBUG: selftest passed [ 0.000000] hpet clockevent registered [ 0.000000] tsc: Detected 2693.468 MHz processor [ 0.008000] Calibrating delay loop (skipped) preset value.. 5386.93 BogoMIPS (lpj=10773872) [ 0.008000] pid_max: default: 32768 minimum: 301 [ 0.008000] Security Framework initialized [ 0.008035] Smack: Initializing. [ 0.012025] AppArmor: AppArmor disabled by boot time parameter [ 0.013646] Mount-cache hash table entries: 256 [ 0.016925] Initializing cgroup subsys freezer [ 0.018260] Initializing cgroup subsys blkio [ 0.019521] Initializing cgroup subsys perf_event [ 0.020191] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.020191] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.020191] tlb_flushall_shift: 6 [ 0.024016] CPU: Intel Common KVM processor (fam: 0f, model: 06, stepping: 01) [ 0.031727] ACPI: Core revision 20130328 [ 0.038985] ACPI: All ACPI Tables successfully acquired [ 0.040584] ftrace: allocating 27614 entries in 108 pages [ 0.056550] Performance Events: unsupported Netburst CPU model 6 no PMU driver, software events only. [ 0.060126] ftrace: Allocated trace_printk buffers [ 0.063004] Testing tracer nop: PASSED [ 0.065537] Getting VERSION: 50014 [ 0.066617] Getting VERSION: 50014 [ 0.068025] Getting ID: 0 [ 0.068958] Getting ID: ff000000 [ 0.070040] Getting LVT0: 8700 [ 0.071030] Getting LVT1: 8400 [ 0.072093] enabled ExtINT on CPU#0 [ 0.074472] ENABLING IO-APIC IRQs [ 0.075563] init IO_APIC IRQs [ 0.076022] apic 0 pin 0 not connected [ 0.077256] IOAPIC[0]: Set routing entry (0-1 -> 0x31 -> IRQ 1 Mode:0 Active:0 Dest:1) [ 0.080051] IOAPIC[0]: Set routing entry (0-2 -> 0x30 -> IRQ 0 Mode:0 Active:0 Dest:1) [ 0.082344] IOAPIC[0]: Set routing entry (0-3 -> 0x33 -> IRQ 3 Mode:0 Active:0 Dest:1) [ 0.084054] IOAPIC[0]: Set routing entry (0-4 -> 0x34 -> IRQ 4 Mode:0 Active:0 Dest:1) [ 0.086288] IOAPIC[0]: Set routing entry (0-5 -> 0x35 -> IRQ 5 Mode:1 Active:0 Dest:1) [ 0.088046] IOAPIC[0]: Set routing entry (0-6 -> 0x36 -> IRQ 6 Mode:0 Active:0 Dest:1) [ 0.090256] IOAPIC[0]: Set routing entry (0-7 -> 0x37 -> IRQ 7 Mode:0 Active:0 Dest:1) [ 0.092054] IOAPIC[0]: Set routing entry (0-8 -> 0x38 -> IRQ 8 Mode:0 Active:0 Dest:1) [ 0.096058] IOAPIC[0]: Set routing entry (0-9 -> 0x39 -> IRQ 9 Mode:1 Active:0 Dest:1) [ 0.098293] IOAPIC[0]: Set routing entry (0-10 -> 0x3a -> IRQ 10 Mode:1 Active:0 Dest:1) [ 0.100050] IOAPIC[0]: Set routing entry (0-11 -> 0x3b -> IRQ 11 Mode:1 Active:0 Dest:1) [ 0.102303] IOAPIC[0]: Set routing entry (0-12 -> 0x3c -> IRQ 12 Mode:0 Active:0 Dest:1) [ 0.104046] IOAPIC[0]: Set routing entry (0-13 -> 0x3d -> IRQ 13 Mode:0 Active:0 Dest:1) [ 0.108019] IOAPIC[0]: Set routing entry (0-14 -> 0x3e -> IRQ 14 Mode:0 Active:0 Dest:1) [ 0.110304] IOAPIC[0]: Set routing entry (0-15 -> 0x3f -> IRQ 15 Mode:0 Active:0 Dest:1) [ 0.112042] apic 0 pin 16 not connected [ 0.113172] apic 0 pin 17 not connected [ 0.114347] apic 0 pin 18 not connected [ 0.116012] apic 0 pin 19 not connected [ 0.117176] apic 0 pin 20 not connected [ 0.118327] apic 0 pin 21 not connected [ 0.119468] apic 0 pin 22 not connected [ 0.120011] apic 0 pin 23 not connected [ 0.121291] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.122773] Using local APIC timer interrupts. [ 0.122773] calibrating APIC timer ... [ 0.128000] ... lapic delta = 6250577 [ 0.128000] ... PM-Timer delta = 357965 [ 0.128000] ... PM-Timer result ok [ 0.128000] ..... delta 6250577 [ 0.128000] ..... mult: 268460237 [ 0.128000] ..... calibration result: 4000369 [ 0.128000] ..... CPU clock speed is 2693.2058 MHz. [ 0.128000] ..... host bus clock speed is 1000.0369 MHz. [ 0.128879] devtmpfs: initialized [ 0.130659] EVM: security.SMACK64 [ 0.131555] EVM: security.capability [ 0.132531] Testing tracer function: PASSED [ 0.328009] Testing dynamic ftrace: PASSED [ 0.672747] Testing dynamic ftrace ops #1: (1 0 1 1 0) (1 1 2 1 0) (2 1 3 1 9) (2 2 4 1 243) PASSED [ 1.059297] Testing dynamic ftrace ops #2: (1 0 1 9 0) (1 1 2 163 0) (2 1 3 1 15) (2 2 4 176 190) PASSED [ 1.477649] Testing ftrace recursion: PASSED [ 1.521243] Testing ftrace recursion safe: PASSED [ 1.565127] Testing ftrace regs: PASSED [ 1.641023] Testing tracer irqsoff: PASSED [ 1.950306] Testing tracer branch: PASSED [ 2.060469] xor: measuring software checksum speed [ 2.100021] prefetch64-sse: 5017.000 MB/sec [ 2.140022] generic_sse: 5856.000 MB/sec [ 2.141352] xor: using function: generic_sse (5856.000 MB/sec) [ 2.143519] regulator-dummy: no parameters [ 2.144272] RTC time: 10:13:38, date: 08/28/14 [ 2.146447] NET: Registered protocol family 16 [ 2.149599] ACPI: bus type PCI registered [ 2.152313] PCI: Using configuration type 1 for base access [ 2.170491] bio: create slab at 0 [ 2.240055] raid6: sse2x1 1021 MB/s [ 2.308036] raid6: sse2x2 1238 MB/s [ 2.376023] raid6: sse2x4 1508 MB/s [ 2.378233] raid6: using algorithm sse2x4 (1508 MB/s) [ 2.380012] raid6: using intx1 recovery algorithm [ 2.381990] ACPI: Added _OSI(Module Device) [ 2.383361] ACPI: Added _OSI(Processor Device) [ 2.384014] ACPI: Added _OSI(3.0 _SCP Extensions) [ 2.385548] ACPI: Added _OSI(Processor Aggregator Device) [ 2.395369] ACPI: EC: Look up EC in DSDT [ 2.414853] ACPI: Interpreter enabled [ 2.416022] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [\_S1_] (20130328/hwxface-568) [ 2.419537] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [\_S2_] (20130328/hwxface-568) [ 2.422010] ACPI: (supports S0 S3 S5) [ 2.424012] ACPI: Using IOAPIC for interrupt routing [ 2.425860] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 2.468264] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 2.472528] PCI host bridge to bus 0000:00 [ 2.474221] pci_bus 0000:00: root bus resource [bus 00-ff] [ 2.476015] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7] [ 2.478742] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff] [ 2.480015] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff] [ 2.482109] pci_bus 0000:00: root bus resource [mem 0x80000000-0xfebfffff] [ 2.484141] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 2.490253] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 2.493341] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 2.502079] pci 0000:00:01.1: reg 20: [io 0xc1c0-0xc1cf] [ 2.508945] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 2.511733] pci 0000:00:01.3: quirk: [io 0xb000-0xb03f] claimed by PIIX4 ACPI [ 2.512038] pci 0000:00:01.3: quirk: [io 0xb100-0xb10f] claimed by PIIX4 SMB [ 2.516868] pci 0000:00:02.0: [1013:00b8] type 00 class 0x030000 [ 2.528100] pci 0000:00:02.0: reg 10: [mem 0xfc000000-0xfdffffff pref] [ 2.533373] pci 0000:00:02.0: reg 14: [mem 0xfebf0000-0xfebf0fff] [ 2.549623] pci 0000:00:02.0: reg 30: [mem 0xfebe0000-0xfebeffff pref] [ 2.553456] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000 [ 2.558085] pci 0000:00:03.0: reg 10: [mem 0xfeba0000-0xfebbffff] [ 2.561388] pci 0000:00:03.0: reg 14: [io 0xc000-0xc03f] [ 2.573530] pci 0000:00:03.0: reg 30: [mem 0xfebc0000-0xfebdffff pref] [ 2.577833] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 [ 2.581539] pci 0000:00:04.0: reg 10: [io 0xc040-0xc07f] [ 2.584733] pci 0000:00:04.0: reg 14: [mem 0xfebf1000-0xfebf1fff] [ 2.598893] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 2.601962] pci 0000:00:05.0: reg 10: [io 0xc080-0xc0bf] [ 2.608015] pci 0000:00:05.0: reg 14: [mem 0xfebf2000-0xfebf2fff] [ 2.620583] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 2.624016] pci 0000:00:06.0: reg 10: [io 0xc0c0-0xc0ff] [ 2.628018] pci 0000:00:06.0: reg 14: [mem 0xfebf3000-0xfebf3fff] [ 2.641291] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 [ 2.644733] pci 0000:00:07.0: reg 10: [io 0xc100-0xc13f] [ 2.650354] pci 0000:00:07.0: reg 14: [mem 0xfebf4000-0xfebf4fff] [ 2.662522] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 [ 2.666514] pci 0000:00:08.0: reg 10: [io 0xc140-0xc17f] [ 2.672019] pci 0000:00:08.0: reg 14: [mem 0xfebf5000-0xfebf5fff] [ 2.685307] pci 0000:00:09.0: [1af4:1001] type 00 class 0x010000 [ 2.690529] pci 0000:00:09.0: reg 10: [io 0xc180-0xc1bf] [ 2.693676] pci 0000:00:09.0: reg 14: [mem 0xfebf6000-0xfebf6fff] [ 2.710348] pci 0000:00:0a.0: [8086:25ab] type 00 class 0x088000 [ 2.713063] pci 0000:00:0a.0: reg 10: [mem 0xfebf7000-0xfebf700f] [ 2.722864] pci_bus 0000:00: on NUMA node 0 [ 2.724046] acpi PNP0A03:00: Unable to request _OSC control (_OSC support mask: 0x08) [ 2.734979] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11) [ 2.740209] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11) [ 2.743254] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11) [ 2.745715] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11) [ 2.749209] ACPI: PCI Interrupt Link [LNKS] (IRQs *9) [ 2.753198] ACPI: Enabled 16 GPEs in block 00 to 0F [ 2.755469] acpi root: \_SB_.PCI0 notify handler is installed [ 2.756406] Found 1 acpi root devices [ 2.761476] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none [ 2.764034] vgaarb: loaded [ 2.766016] vgaarb: bridge control possible 0000:00:02.0 [ 2.769182] SCSI subsystem initialized [ 2.772051] ACPI: bus type ATA registered [ 2.774079] libata version 3.00 loaded. [ 2.776271] ACPI: bus type USB registered [ 2.778604] usbcore: registered new interface driver usbfs [ 2.780114] usbcore: registered new interface driver hub [ 2.782537] usbcore: registered new device driver usb [ 2.785576] PCI: Using ACPI for IRQ routing [ 2.788025] PCI: pci_cache_line_size set to 64 bytes [ 2.790944] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] [ 2.792028] e820: reserve RAM buffer [mem 0x13ffe000-0x13ffffff] [ 2.797506] NetLabel: Initializing [ 2.798909] NetLabel: domain hash size = 128 [ 2.800009] NetLabel: protocols = UNLABELED CIPSOv4 [ 2.801710] NetLabel: unlabeled traffic allowed by default [ 2.804613] Switching to clocksource kvm-clock [ 2.807693] Warning: could not register all branches stats [ 2.808570] Warning: could not register annotated branches stats [ 3.049544] pnp: PnP ACPI init [ 3.050937] ACPI: bus type PNP registered [ 3.054103] IOAPIC[0]: Set routing entry (0-8 -> 0x38 -> IRQ 8 Mode:0 Active:0 Dest:1) [ 3.058177] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active) [ 3.060192] IOAPIC[0]: Set routing entry (0-1 -> 0x31 -> IRQ 1 Mode:0 Active:0 Dest:1) [ 3.064452] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active) [ 3.067552] IOAPIC[0]: Set routing entry (0-12 -> 0x3c -> IRQ 12 Mode:0 Active:0 Dest:1) [ 3.071259] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active) [ 3.074193] IOAPIC[0]: Set routing entry (0-6 -> 0x36 -> IRQ 6 Mode:0 Active:0 Dest:1) [ 3.077468] pnp 00:03: [dma 2] [ 3.078606] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active) [ 3.080429] IOAPIC[0]: Set routing entry (0-7 -> 0x37 -> IRQ 7 Mode:0 Active:0 Dest:1) [ 3.083142] pnp 00:04: Plug and Play ACPI device, IDs PNP0400 (active) [ 3.085761] IOAPIC[0]: Set routing entry (0-4 -> 0x34 -> IRQ 4 Mode:0 Active:0 Dest:1) [ 3.088812] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active) [ 3.090536] IOAPIC[0]: Set routing entry (0-3 -> 0x33 -> IRQ 3 Mode:0 Active:0 Dest:1) [ 3.093181] pnp 00:06: Plug and Play ACPI device, IDs PNP0501 (active) [ 3.097450] pnp 00:07: Plug and Play ACPI device, IDs PNP0103 (active) [ 3.099689] pnp: PnP ACPI: found 8 devices [ 3.100927] ACPI: bus type PNP unregistered [ 3.124756] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7] [ 3.126687] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff] [ 3.128292] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff] [ 3.129785] pci_bus 0000:00: resource 7 [mem 0x80000000-0xfebfffff] [ 3.131923] NET: Registered protocol family 2 [ 3.135838] TCP established hash table entries: 4096 (order: 4, 65536 bytes) [ 3.138301] TCP bind hash table entries: 4096 (order: 6, 327680 bytes) [ 3.140474] TCP: Hash tables configured (established 4096 bind 4096) [ 3.142811] TCP: reno registered [ 3.144497] UDP hash table entries: 256 (order: 3, 49152 bytes) [ 3.146847] UDP-Lite hash table entries: 256 (order: 3, 49152 bytes) [ 3.149385] NET: Registered protocol family 1 [ 3.150709] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 3.152458] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 3.155241] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 3.157245] pci 0000:00:02.0: Boot video device [ 3.158591] PCI: CLS 0 bytes, default 64 [ 3.160223] Unpacking initramfs... [ 3.487111] debug: unmapping init [mem 0xffff880013ce6000-0xffff880013feffff] [ 3.490864] microcode: CPU0 sig=0xf61, pf=0x1, revision=0x1 [ 3.492580] microcode: Microcode Update Driver: v2.00 , Peter Oruba [ 3.496894] camellia-x86_64: performance on this CPU would be suboptimal: disabling camellia-x86_64. [ 3.500723] cryptomgr_test (16) used greatest stack depth: 6584 bytes left [ 3.503303] twofish-x86_64-3way: performance on this CPU would be suboptimal: disabling twofish-x86_64-3way. [ 3.517368] sha512_ssse3: Neither AVX nor SSSE3 is available/usable. [ 3.519280] AVX or AES-NI instructions are not detected. [ 3.520989] AVX instructions are not detected. [ 3.522924] AVX instructions are not detected. [ 3.525288] AVX2 or AES-NI instructions are not detected. [ 3.526954] AVX2 instructions are not detected. [ 3.529915] Initialise module verification [ 3.532030] audit: initializing netlink socket (disabled) [ 3.534529] type=2000 audit(1409192018.532:1): initialized [ 3.741765] rcu-torture:--- Start of test: nreaders=2 nfakewriters=4 stat_interval=60 verbose=0 test_no_idle_hz=1 shuffle_interval=3 stutter=5 irqreader=1 fqs_duration=0 fqs_holdoff=0 fqs_stutter=3 test_boost=1/0 test_boost_interval=7 test_boost_duration=4 shutdown_secs=0 stall_cpu=0 stall_cpu_holdoff=10 n_barrier_cbs=0 onoff_interval=0 onoff_holdoff=0 [ 3.879730] bounce pool size: 64 pages [ 3.898595] VFS: Disk quotas dquot_6.5.2 [ 3.900089] Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 3.905349] JFS: nTxBlock = 2071, nTxLock = 16571 [ 3.910352] SGI XFS with security attributes, realtime, large block/inode numbers, no debug enabled [ 3.918126] bio: create slab at 1 [ 3.921554] Btrfs loaded [ 3.922496] msgmni has been set to 517 [ 3.930544] NET: Registered protocol family 38 [ 3.931829] Key type asymmetric registered [ 3.933011] Asymmetric key parser 'x509' registered [ 3.935254] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252) [ 3.938057] io scheduler noop registered (default) [ 3.939353] test_string_helpers: Running tests... [ 3.941581] no IO addresses supplied [ 3.942933] hgafb: HGA card not detected. [ 3.944091] hgafb: probe of hgafb.0 failed with error -22 [ 3.946527] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 3.948548] ACPI: Power Button [PWRF] [ 4.054873] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled [ 4.114906] 00:05: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A [ 4.120519] Non-volatile memory driver v1.3 [ 4.122738] Floppy drive(s): fd0 is 1.44M [ 4.125246] rbd: loaded rbd (rados block device) [ 4.126494] dummy-irq: no IRQ given. Use irq=N [ 4.141084] usbcore: registered new interface driver viperboard [ 4.142962] hp_sw: device handler registered [ 4.144248] st: Version 20101219, fixed bufsize 32768, s/g segs 256 [ 4.146605] FDC 0 is a S82078B [ 4.150230] SSFDC read-only Flash Translation layer [ 4.151484] mtdoops: mtd device (mtddev=name/number) must be supplied [ 4.153161] HSI/SSI char device loaded [ 4.157343] mkiss: AX.25 Multikiss, Hans Albas PE1AYX [ 4.158602] baycom_ser_hdx: (C) 1996-2000 Thomas Sailer, HB9JNX/AE4WA [ 4.158602] baycom_ser_hdx: version 0.10 [ 4.163915] hdlcdrv: (C) 1996-2000 Thomas Sailer HB9JNX/AE4WA [ 4.165322] hdlcdrv: version 0.8 [ 4.167467] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver [ 4.168942] ehci-pci: EHCI PCI platform driver [ 4.183381] ehci-platform: EHCI generic platform driver [ 4.184743] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver [ 4.187289] usbcore: registered new interface driver cdc_wdm [ 4.188829] usbcore: registered new interface driver usbserial [ 4.190293] usbcore: registered new interface driver aircable [ 4.191772] usbserial: USB Serial support registered for aircable [ 4.193490] usbcore: registered new interface driver ark3116 [ 4.194893] usbserial: USB Serial support registered for ark3116 [ 4.210539] usbcore: registered new interface driver cp210x [ 4.211909] usbserial: USB Serial support registered for cp210x [ 4.213386] usbcore: registered new interface driver cypress_m8 [ 4.214801] usbserial: USB Serial support registered for DeLorme Earthmate USB [ 4.216743] usbserial: USB Serial support registered for HID->COM RS232 Adapter [ 4.218746] usbserial: USB Serial support registered for Nokia CA-42 V2 Adapter [ 4.220734] usbcore: registered new interface driver usb_debug [ 4.235534] usbserial: USB Serial support registered for debug [ 4.236986] usbcore: registered new interface driver digi_acceleport [ 4.238523] usbserial: USB Serial support registered for Digi 2 port USB adapter [ 4.240509] usbserial: USB Serial support registered for Digi 4 port USB adapter [ 4.242538] usbcore: registered new interface driver io_ti [ 4.243907] usbserial: USB Serial support registered for Edgeport TI 1 port adapter [ 4.245955] usbserial: USB Serial support registered for Edgeport TI 2 port adapter [ 4.261221] usbcore: registered new interface driver empeg [ 4.262658] usbserial: USB Serial support registered for empeg [ 4.264083] usbcore: registered new interface driver ipw [ 4.265492] usbserial: USB Serial support registered for IPWireless converter [ 4.267163] usbcore: registered new interface driver ir_usb [ 4.268572] usbserial: USB Serial support registered for IR Dongle [ 4.270107] usbcore: registered new interface driver iuu_phoenix [ 4.271593] usbserial: USB Serial support registered for iuu_phoenix [ 4.273136] usbcore: registered new interface driver keyspan [ 4.274642] usbserial: USB Serial support registered for Keyspan - (without firmware) [ 4.276767] usbserial: USB Serial support registered for Keyspan 1 port adapter [ 4.280582] usbserial: USB Serial support registered for Keyspan 2 port adapter [ 4.282629] usbserial: USB Serial support registered for Keyspan 4 port adapter [ 4.284678] usbcore: registered new interface driver keyspan_pda [ 4.286170] usbserial: USB Serial support registered for Keyspan PDA [ 4.287715] usbserial: USB Serial support registered for Keyspan PDA - (prerenumeration) [ 4.289880] usbcore: registered new interface driver kl5kusb105 [ 4.291349] usbserial: USB Serial support registered for KL5KUSB105D / PalmConnect [ 4.293470] usbcore: registered new interface driver metro_usb [ 4.294917] usbserial: USB Serial support registered for Metrologic USB to Serial [ 4.297002] usbcore: registered new interface driver mos7720 [ 4.299181] usbserial: USB Serial support registered for Moschip 2 port adapter [ 4.301266] usbcore: registered new interface driver mos7840 [ 4.302680] usbserial: USB Serial support registered for Moschip 7840/7820 USB Serial Driver [ 4.304858] usbcore: registered new interface driver option [ 4.306280] usbserial: USB Serial support registered for GSM modem (1-port) [ 4.307924] usbcore: registered new interface driver oti6858 [ 4.309350] usbserial: USB Serial support registered for oti6858 [ 4.310812] usbcore: registered new interface driver quatech2 [ 4.312232] usbserial: USB Serial support registered for Quatech 2nd gen USB to Serial Driver [ 4.315482] usbcore: registered new interface driver symbolserial [ 4.316993] usbserial: USB Serial support registered for symbol [ 4.318508] usbcore: registered new interface driver whiteheat [ 4.319986] usbserial: USB Serial support registered for Connect Tech - WhiteHEAT - (prerenumeration) [ 4.322381] usbserial: USB Serial support registered for Connect Tech - WhiteHEAT [ 4.324450] usbcore: registered new interface driver zte_ev [ 4.325886] usbserial: USB Serial support registered for zte_ev [ 4.327701] usbcore: registered new interface driver appledisplay [ 4.329237] usbcore: registered new interface driver cypress_cy7c63 [ 4.330783] usbcore: registered new interface driver cytherm [ 4.332234] usbcore: registered new interface driver emi26 - firmware loader [ 4.334200] usbcore: registered new interface driver idmouse [ 4.335683] usbcore: registered new interface driver iowarrior [ 4.337119] usbcore: registered new interface driver isight_firmware [ 4.338748] usbcore: registered new interface driver legousbtower [ 4.340240] usbcore: registered new interface driver rio500 [ 4.342131] usbcore: registered new interface driver yurex [ 4.343527] usbcore: registered new interface driver sisusb [ 4.345270] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 4.348662] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 4.350243] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 4.352396] mousedev: PS/2 mouse device common for all mice [ 4.354956] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 4.357936] usbcore: registered new interface driver kbtab [ 4.359507] usbcore: registered new interface driver usbtouchscreen [ 4.361435] cm109: Keymap for Komunikate KIP1000 phone loaded [ 4.362895] usbcore: registered new interface driver cm109 [ 4.364236] cm109: CM109 phone driver: 20080805 (C) Alfred E. Heggestad [ 4.365945] usbcore: registered new interface driver ims_pcu [ 4.367408] usbcore: registered new interface driver keyspan_remote [ 4.369342] usbcore: registered new interface driver yealink [ 4.371679] rtc-test rtc-test.0: rtc core: registered test as rtc0 [ 4.373507] rtc-test rtc-test.1: rtc core: registered test as rtc1 [ 4.374977] Driver for 1-wire Dallas network protocol. [ 4.376466] 1-Wire driver for the DS2760 battery monitor chip - (c) 2004-2005, Szabolcs Gyurko [ 4.379092] power_supply test_ac: uevent [ 4.380173] power_supply test_ac: POWER_SUPPLY_NAME=test_ac [ 4.385261] power_supply test_ac: prop ONLINE=1 [ 4.386559] power_supply test_ac: power_supply_changed [ 4.387887] power_supply test_ac: power_supply_changed_work [ 4.389260] power_supply test_ac: power_supply_update_gen_leds 1 [ 4.390715] power_supply test_ac: uevent [ 4.391786] power_supply test_ac: POWER_SUPPLY_NAME=test_ac [ 4.393128] power_supply test_ac: prop ONLINE=1 [ 4.394580] power_supply test_battery: uevent [ 4.395726] power_supply test_battery: POWER_SUPPLY_NAME=test_battery [ 4.397239] power_supply test_battery: prop STATUS=Discharging [ 4.398632] power_supply test_battery: prop CHARGE_TYPE=Fast [ 4.399993] power_supply test_battery: prop HEALTH=Good [ 4.401384] power_supply test_battery: prop PRESENT=1 [ 4.408577] power_supply test_battery: prop TECHNOLOGY=Li-ion [ 4.409947] power_supply test_battery: prop CHARGE_FULL_DESIGN=100 [ 4.411451] power_supply test_battery: prop CHARGE_FULL=100 [ 4.412826] power_supply test_battery: prop CHARGE_NOW=50 [ 4.414140] power_supply test_battery: prop CAPACITY=50 [ 4.415568] power_supply test_battery: prop CAPACITY_LEVEL=Normal [ 4.416956] power_supply test_battery: prop TIME_TO_EMPTY_AVG=3600 [ 4.418457] power_supply test_battery: prop TIME_TO_FULL_NOW=3600 [ 4.420100] power_supply test_battery: prop MODEL_NAME=Test battery [ 4.421561] power_supply test_battery: prop MANUFACTURER=Linux [ 4.423019] power_supply test_battery: prop SERIAL_NUMBER=3.10.0-rc3-00005-g003002e [ 4.425044] power_supply test_battery: prop TEMP=26 [ 4.427536] power_supply test_battery: prop VOLTAGE_NOW=3300 [ 4.429297] power_supply test_battery: power_supply_changed [ 4.430835] power_supply test_battery: power_supply_changed_work [ 4.432237] power_supply test_battery: power_supply_update_bat_leds 2 [ 4.433820] power_supply test_usb: uevent [ 4.434910] power_supply test_usb: POWER_SUPPLY_NAME=test_usb [ 4.436284] power_supply test_usb: prop ONLINE=1 [ 4.438506] power_supply test_battery: uevent [ 4.439645] power_supply test_battery: POWER_SUPPLY_NAME=test_battery [ 4.441179] power_supply test_battery: prop STATUS=Discharging [ 4.443034] power_supply test_battery: prop CHARGE_TYPE=Fast [ 4.444477] power_supply test_battery: prop HEALTH=Good [ 4.445821] power_supply test_battery: prop PRESENT=1 [ 4.447021] power_supply test_battery: prop TECHNOLOGY=Li-ion [ 4.448707] power_supply test_battery: prop CHARGE_FULL_DESIGN=100 [ 4.450343] power_supply test_usb: power_supply_changed [ 4.451873] cpuidle: using governor ladder [ 4.453574] ledtrig-cpu: registered to indicate activity on CPUs [ 4.455091] hidraw: raw HID events driver (C) Jiri Kosina [ 4.457629] power_supply test_battery: prop CHARGE_FULL=100 [ 4.458980] power_supply test_battery: prop CHARGE_NOW=50 [ 4.460299] power_supply test_battery: prop CAPACITY=50 [ 4.462291] usbcore: registered new interface driver usbhid [ 4.463913] usbhid: USB HID core driver [ 4.464930] usbip_core: usbip_core_init:804: USB/IP Core v1.0.0 [ 4.466468] power_supply test_battery: prop CAPACITY_LEVEL=Normal [ 4.467897] power_supply test_battery: prop TIME_TO_EMPTY_AVG=3600 [ 4.469349] power_supply test_battery: prop TIME_TO_FULL_NOW=3600 [ 4.470774] power_supply test_battery: prop MODEL_NAME=Test battery [ 4.472221] power_supply test_battery: prop MANUFACTURER=Linux [ 4.474088] vhci_hcd: vhci_hcd_probe:1000: name vhci_hcd id -1 [ 4.475509] vhci_hcd vhci_hcd: USB/IP Virtual Host Controller [ 4.477358] vhci_hcd vhci_hcd: new USB bus registered, assigned bus number 1 [ 4.478961] vhci_hcd: vhci_start:884: enter vhci_start [ 4.480405] power_supply test_battery: prop SERIAL_NUMBER=3.10.0-rc3-00005-g003002e [ 4.482524] power_supply test_battery: prop TEMP=26 [ 4.483841] power_supply test_battery: prop VOLTAGE_NOW=3300 [ 4.486299] power_supply test_usb: power_supply_changed_work [ 4.487710] power_supply test_usb: power_supply_update_gen_leds 1 [ 4.489074] power_supply test_usb: uevent [ 4.490297] power_supply test_usb: POWER_SUPPLY_NAME=test_usb [ 4.491945] power_supply test_usb: prop ONLINE=1 [ 4.494889] hub 1-0:1.0: USB hub found [ 4.495976] vhci_hcd: vhci_hub_control:247: typeReq a006 wValue 2900 wIndex 0 [ 4.497645] vhci_hcd: vhci_hub_control:305: GetHubDescriptor [ 4.499018] vhci_hcd: vhci_hub_control:398: port -1 [ 4.500245] vhci_hcd: vhci_hub_control:405: bye [ 4.501489] hub 1-0:1.0: 8 ports detected [ 4.502670] vhci_hcd: vhci_hub_control:247: typeReq a000 wValue 0 wIndex 0 [ 4.504222] vhci_hcd: vhci_hub_control:309: GetHubStatus [ 4.505552] vhci_hcd: vhci_hub_control:398: port -1 [ 4.506781] vhci_hcd: vhci_hub_control:405: bye [ 4.508920] vhci_hcd: vhci_hub_control:247: typeReq 2303 wValue 8 wIndex 1 [ 4.510488] vhci_hcd: vhci_hub_control:384: SetPortFeature: default 8 [ 4.512065] vhci_hcd: vhci_hub_control:398: port 0 [ 4.513381] vhci_hcd: dump_port_status_diff:101: status prev -> new: 00000000 -> 00000100 [ 4.515574] vhci_hcd: dump_port_status_diff:115: +POWER [ 4.516948] vhci_hcd: dump_port_status_diff:119: [ 4.518234] vhci_hcd: vhci_hub_control:405: bye [ 4.519775] vhci_hcd: vhci_hub_control:247: typeReq 2303 wValue 8 wIndex 2 [ 4.521304] vhci_hcd: vhci_hub_control:384: SetPortFeature: default 8 [ 4.522835] vhci_hcd: vhci_hub_control:398: port 1 [ 4.524211] vhci_hcd: dump_port_status_diff:101: status prev -> new: 00000000 -> 00000100 [ 4.526382] vhci_hcd: dump_port_status_diff:115: +POWER [ 4.527711] vhci_hcd: dump_port_status_diff:119: [ 4.529025] vhci_hcd: vhci_hub_control:405: bye [ 4.531941] vhci_hcd: vhci_hub_control:247: typeReq 2303 wValue 8 wIndex 3 [ 4.533604] vhci_hcd: vhci_hub_control:384: SetPortFeature: default 8 [ 4.535061] vhci_hcd: vhci_hub_control:398: port 2 [ 4.536469] vhci_hcd: dump_port_status_diff:101: status prev -> new: 00000000 -> 00000100 [ 4.538602] vhci_hcd: dump_port_status_diff:115: +POWER [ 4.539832] vhci_hcd: dump_port_status_diff:119: [ 4.541073] vhci_hcd: vhci_hub_control:405: bye [ 4.543340] vhci_hcd: vhci_hub_control:247: typeReq 2303 wValue 8 wIndex 4 [ 4.545028] vhci_hcd: vhci_hub_control:384: SetPortFeature: default 8 [ 4.546566] vhci_hcd: vhci_hub_control:398: port 3 [ 4.547896] vhci_hcd: dump_port_status_diff:101: status prev -> new: 00000000 -> 00000100 [ 4.550000] vhci_hcd: dump_port_status_diff:115: +POWER [ 4.551273] vhci_hcd: dump_port_status_diff:119: [ 4.552497] vhci_hcd: vhci_hub_control:405: bye [ 4.553829] vhci_hcd: vhci_hub_control:247: typeReq 2303 wValue 8 wIndex 5 [ 4.555374] vhci_hcd: vhci_hub_control:384: SetPortFeature: default 8 [ 4.556914] vhci_hcd: vhci_hub_control:398: port 4 [ 4.558182] vhci_hcd: dump_port_status_diff:101: status prev -> new: 00000000 -> 00000100 [ 4.560490] vhci_hcd: dump_port_status_diff:115: +POWER [ 4.561849] vhci_hcd: dump_port_status_diff:119: [ 4.562984] vhci_hcd: vhci_hub_control:405: bye [ 4.564346] vhci_hcd: vhci_hub_control:247: typeReq 2303 wValue 8 wIndex 6 [ 4.565934] vhci_hcd: vhci_hub_control:384: SetPortFeature: default 8 [ 4.567361] vhci_hcd: vhci_hub_control:398: port 5 [ 4.568891] vhci_hcd: dump_port_status_diff:101: status prev -> new: 00000000 -> 00000100 [ 4.571242] vhci_hcd: dump_port_status_diff:115: +POWER [ 4.572700] vhci_hcd: dump_port_status_diff:119: [ 4.573993] vhci_hcd: vhci_hub_control:405: bye [ 4.575232] vhci_hcd: vhci_hub_control:247: typeReq 2303 wValue 8 wIndex 7 [ 4.576720] vhci_hcd: vhci_hub_control:384: SetPortFeature: default 8 [ 4.578293] vhci_hcd: vhci_hub_control:398: port 6 [ 4.579643] vhci_hcd: dump_port_status_diff:101: status prev -> new: 00000000 -> 00000100 [ 4.581765] vhci_hcd: dump_port_status_diff:115: +POWER [ 4.583023] vhci_hcd: dump_port_status_diff:119: [ 4.584307] vhci_hcd: vhci_hub_control:405: bye [ 4.586015] vhci_hcd: vhci_hub_control:247: typeReq 2303 wValue 8 wIndex 8 [ 4.587616] vhci_hcd: vhci_hub_control:384: SetPortFeature: default 8 [ 4.589176] vhci_hcd: vhci_hub_control:398: port 7 [ 4.590439] vhci_hcd: dump_port_status_diff:101: status prev -> new: 00000000 -> 00000100 [ 4.592584] vhci_hcd: dump_port_status_diff:115: +POWER [ 4.594073] vhci_hcd: dump_port_status_diff:119: [ 4.595330] vhci_hcd: vhci_hub_control:405: bye [ 4.596972] vhci_hcd: vhci_hcd_probe:1034: bye [ 4.598365] vhci_hcd: vhci_hcd_init:1156: USB/IP 'Virtual' Host Controller (VHCI) Driver v1.0.0 [ 4.602279] ashmem: initialized [ 4.603914] ozwpan ozwpan: Ozmo Devices WPAN [ 4.605430] ozwpan ozwpan: new USB bus registered, assigned bus number 2 [ 4.607818] hub 2-0:1.0: USB hub found [ 4.608876] hub 2-0:1.0: 8 ports detected [ 4.612048] GACT probability on [ 4.613106] netem: version 1.3 [ 4.627777] tcp_probe: probe registered (port=0) bufsize=4096 [ 4.629117] TCP: cubic registered [ 4.630258] Initializing XFRM netlink socket [ 4.631439] NET: Registered protocol family 17 [ 4.632931] NET: Registered protocol family 15 [ 4.636807] NET: Registered protocol family 6 [ 4.638147] NET: Registered protocol family 3 [ 4.639434] NET4: DECnet for Linux: V.2.5.68s (C) 1995-2003 Linux DECnet Project Team [ 4.642711] DECnet: Routing cache hash table of 128 buckets, 10Kbytes [ 4.644293] NET: Registered protocol family 12 [ 4.645536] 8021q: 802.1Q VLAN Support v1.8 [ 4.646773] tipc: Activated (version 2.0.0) [ 4.649903] NET: Registered protocol family 30 [ 4.651095] tipc: Started in single node mode [ 4.652329] Key type dns_resolver registered [ 4.653507] Key type ceph registered [ 4.655776] libceph: loaded (mon/osd proto 15/24) [ 4.657144] openvswitch: Open vSwitch switching datapath [ 4.660050] [ 4.660050] printing PIC contents [ 4.661674] ... PIC IMR: ffff [ 4.662562] ... PIC IRR: 1053 [ 4.663715] ... PIC ISR: 0000 [ 4.664812] ... PIC ELCR: 0c00 [ 4.665838] printing local APIC contents on CPU#0/0: [ 4.667161] ... APIC ID: 00000000 (0) [ 4.668233] ... APIC VERSION: 00050014 [ 4.669486] ... APIC TASKPRI: 00000000 (00) [ 4.669710] ... APIC PROCPRI: 00000000 [ 4.669710] ... APIC LDR: 01000000 [ 4.669710] ... APIC DFR: ffffffff [ 4.669710] ... APIC SPIV: 000001ff [ 4.669710] ... APIC ISR field: [ 4.669710] 0000000000000000000000000000000000000000000000000000000000000000 [ 4.669710] ... APIC TMR field: [ 4.669710] 0000000002000000000000000000000000000000000000000000000000000000 [ 4.669710] ... APIC IRR field: [ 4.669710] 0000000000000000000000000000000000000000000000000000000000008000 [ 4.669710] ... APIC ESR: 00000000 [ 4.669710] ... APIC ICR: 00000831 [ 4.669710] ... APIC ICR2: 01000000 [ 4.669710] ... APIC LVTT: 000200ef [ 4.669710] ... APIC LVTPC: 00010000 [ 4.669710] ... APIC LVT0: 00010700 [ 4.669710] ... APIC LVT1: 00000400 [ 4.669710] ... APIC LVTERR: 000000fe [ 4.669710] ... APIC TMICT: 0003d0a7 [ 4.669710] ... APIC TMCCT: 0000139e [ 4.669710] ... APIC TDCR: 00000003 [ 4.669710] [ 4.704033] number of MP IRQ sources: 15. [ 4.705064] number of IO-APIC #0 registers: 24. [ 4.706385] testing the IO APIC....................... [ 4.707816] IO APIC #0...... [ 4.708744] .... register #00: 00000000 [ 4.709849] ....... : physical APIC id: 00 [ 4.711037] ....... : Delivery Type: 0 [ 4.712094] ....... : LTS : 0 [ 4.713305] .... register #01: 00170011 [ 4.714342] ....... : max redirection entries: 17 [ 4.715637] ....... : PRQ implemented: 0 [ 4.716713] ....... : IO APIC version: 11 [ 4.718067] .... register #02: 00000000 [ 4.719134] ....... : arbitration: 00 [ 4.720258] .... IRQ redirection table: [ 4.721544] 1 0 0 0 0 0 0 00 [ 4.722809] 0 0 0 0 0 1 1 31 [ 4.724094] 0 0 0 0 0 1 1 30 [ 4.725368] 0 0 0 0 0 1 1 33 [ 4.726917] 1 0 0 0 0 1 1 34 [ 4.728077] 1 1 0 0 0 1 1 35 [ 4.729328] 0 0 0 0 0 1 1 36 [ 4.730457] 0 0 0 0 0 1 1 37 [ 4.731878] 0 0 0 0 0 1 1 38 [ 4.733044] 0 1 0 0 0 1 1 39 [ 4.734304] 1 1 0 0 0 1 1 3A [ 4.735428] 1 1 0 0 0 1 1 3B [ 4.736828] 0 0 0 0 0 1 1 3C [ 4.738391] 0 0 0 0 0 1 1 3D [ 4.739903] 0 0 0 0 0 1 1 3E [ 4.741060] 0 0 0 0 0 1 1 3F [ 4.742358] 1 0 0 0 0 0 0 00 [ 4.743485] 1 0 0 0 0 0 0 00 [ 4.744864] 1 0 0 0 0 0 0 00 [ 4.746015] 1 0 0 0 0 0 0 00 [ 4.747282] 1 0 0 0 0 0 0 00 [ 4.748437] 1 0 0 0 0 0 0 00 [ 4.749749] 1 0 0 0 0 0 0 00 [ 4.750947] 1 0 0 0 0 0 0 00 [ 4.752138] IRQ to pin mappings: [ 4.753107] IRQ0 -> 0:2 [ 4.754194] IRQ1 -> 0:1 [ 4.755269] IRQ3 -> 0:3 [ 4.756317] IRQ4 -> 0:4 [ 4.757411] IRQ5 -> 0:5 [ 4.758499] IRQ6 -> 0:6 [ 4.759535] IRQ7 -> 0:7 [ 4.760587] IRQ8 -> 0:8 [ 4.761656] IRQ9 -> 0:9 [ 4.762903] IRQ10 -> 0:10 [ 4.764132] IRQ11 -> 0:11 [ 4.765170] IRQ12 -> 0:12 [ 4.766326] IRQ13 -> 0:13 [ 4.767397] IRQ14 -> 0:14 [ 4.768798] IRQ15 -> 0:15 [ 4.769905] .................................... done. [ 4.771288] tsc: Refined TSC clocksource calibration: 2693.399 MHz [ 4.772785] vhci_hcd: vhci_hub_control:247: typeReq a300 wValue 0 wIndex 1 [ 4.774750] vhci_hcd: vhci_hub_control:313: GetPortStatus port 1 [ 4.776213] vhci_hcd: vhci_hub_control:355: GetPortStatus bye 100 0 [ 4.777633] vhci_hcd: vhci_hub_control:398: port 0 [ 4.779202] vhci_hcd: dump_port_status_diff:101: status prev -> new: 00000100 -> 00000100 [ 4.781687] vhci_hcd: dump_port_status_diff:115: POWER [ 4.783030] vhci_hcd: dump_port_status_diff:119: [ 4.784190] vhci_hcd: vhci_hub_control:405: bye [ 4.786350] Loading module verification certificates [ 4.789775] MODSIGN: Loaded cert 'Magrathea: Glacier signing key: 31901a43a4387ad4350cb503b8056eb9c6b86ef6' [ 4.792240] Running tests on trace events: [ 4.793318] Testing event emulate_vsyscall: [ 4.795171] vhci_hcd: vhci_hub_control:247: typeReq a300 wValue 0 wIndex 2 [ 4.797201] vhci_hcd: vhci_hub_control:313: GetPortStatus port 2 [ 4.798778] vhci_hcd: vhci_hub_control:355: GetPortStatus bye 100 0 [ 4.800374] vhci_hcd: vhci_hub_control:398: port 1 [ 4.801656] vhci_hcd: dump_port_status_diff:101: status prev -> new: 00000100 -> 00000100 [ 4.804014] vhci_hcd: dump_port_status_diff:115: POWER [ 4.805976] vhci_hcd: dump_port_status_diff:119: [ 4.807312] vhci_hcd: vhci_hub_control:405: bye [ 4.809266] vhci_hcd: vhci_hub_control:247: typeReq a300 wValue 0 wIndex 3 [ 4.810981] vhci_hcd: vhci_hub_control:313: GetPortStatus port 3 [ 4.812482] vhci_hcd: vhci_hub_control:355: GetPortStatus bye 100 0 [ 4.814126] vhci_hcd: vhci_hub_control:398: port 2 [ 4.815543] vhci_hcd: dump_port_status_diff:101: status prev -> new: 00000100 -> 00000100 [ 4.817788] vhci_hcd: dump_port_status_diff:115: POWER [ 4.819279] vhci_hcd: dump_port_status_diff:119: [ 4.820966] vhci_hcd: vhci_hub_control:405: bye [ 4.822536] vhci_hcd: vhci_hub_control:247: typeReq a300 wValue 0 wIndex 4 [ 4.824215] vhci_hcd: vhci_hub_control:313: GetPortStatus port 4 [ 4.825820] vhci_hcd: vhci_hub_control:355: GetPortStatus bye 100 0 [ 4.827565] vhci_hcd: vhci_hub_control:398: port 3 [ 4.828811] vhci_hcd: dump_port_status_diff:101: status prev -> new: 00000100 -> 00000100 [ 4.831093] vhci_hcd: dump_port_status_diff:115: POWER [ 4.832507] vhci_hcd: dump_port_status_diff:119: [ 4.833896] vhci_hcd: vhci_hub_control:405: bye [ 4.835615] vhci_hcd: vhci_hub_control:247: typeReq a300 wValue 0 wIndex 5 [ 4.837244] vhci_hcd: vhci_hub_control:313: GetPortStatus port 5 [ 4.838811] vhci_hcd: vhci_hub_control:355: GetPortStatus bye 100 0 [ 4.840463] vhci_hcd: vhci_hub_control:398: port 4 [ 4.841781] vhci_hcd: dump_port_status_diff:101: status prev -> new: 00000100 -> 00000100 [ 4.844023] vhci_hcd: dump_port_status_diff:115: POWER [ 4.845428] vhci_hcd: dump_port_status_diff:119: [ 4.846789] vhci_hcd: vhci_hub_control:405: bye [ 4.848083] vhci_hcd: vhci_hub_control:247: typeReq a300 wValue 0 wIndex 6 [ 4.849816] vhci_hcd: vhci_hub_control:313: GetPortStatus port 6 [ 4.851403] vhci_hcd: vhci_hub_control:355: GetPortStatus bye 100 0 [ 4.853059] vhci_hcd: vhci_hub_control:398: port 5 [ 4.854346] vhci_hcd: dump_port_status_diff:101: status prev -> new: 00000100 -> 00000100 [ 4.856622] vhci_hcd: dump_port_status_diff:115: POWER [ 4.858252] vhci_hcd: dump_port_status_diff:119: [ 4.859536] vhci_hcd: vhci_hub_control:405: bye [ 4.860890] vhci_hcd: vhci_hub_control:247: typeReq a300 wValue 0 wIndex 7 [ 4.862583] vhci_hcd: vhci_hub_control:313: GetPortStatus port 7 [ 4.864139] vhci_hcd: vhci_hub_control:355: GetPortStatus bye 100 0 [ 4.865719] vhci_hcd: vhci_hub_control:398: port 6 [ 4.867140] vhci_hcd: dump_port_status_diff:101: status prev -> new: 00000100 -> 00000100 [ 4.869352] vhci_hcd: dump_port_status_diff:115: POWER [ 4.870808] vhci_hcd: dump_port_status_diff:119: [ 4.872036] vhci_hcd: vhci_hub_control:405: bye [ 4.873450] vhci_hcd: vhci_hub_control:247: typeReq a300 wValue 0 wIndex 8 [ 4.875103] vhci_hcd: vhci_hub_control:313: GetPortStatus port 8 [ 4.876660] vhci_hcd: vhci_hub_control:355: GetPortStatus bye 100 0 [ 4.878206] vhci_hcd: vhci_hub_control:398: port 7 [ 4.879553] vhci_hcd: dump_port_status_diff:101: status prev -> new: 00000100 -> 00000100 [ 4.881788] vhci_hcd: dump_port_status_diff:115: POWER [ 4.883344] vhci_hcd: dump_port_status_diff:119: [ 4.884602] vhci_hcd: vhci_hub_control:405: bye [ 4.887017] usb usb1: vhci_bus_suspend [ 4.888238] vhci_hcd: vhci_hub_status:208: changed 0 [ 4.893347] test-events (96) used greatest stack depth: 6232 bytes left OK [ 4.895653] Testing event sys_exit: OK [ 4.951281] Testing event sys_enter: OK [ 4.972819] Testing event task_rename: OK [ 4.997443] Testing event task_newtask: OK [ 5.006782] Testing event console: OK [ 5.024011] Testing event softirq_raise: OK [ 5.034784] Testing event softirq_exit: OK [ 5.054034] Testing event softirq_entry: OK [ 5.067080] Testing event irq_handler_exit: OK [ 5.074198] Testing event irq_handler_entry: OK [ 5.107045] Testing event itimer_expire: OK [ 5.115312] Testing event itimer_state: OK [ 5.139848] Testing event hrtimer_cancel: OK [ 5.147030] Testing event hrtimer_expire_exit: OK [ 5.154356] Testing event hrtimer_expire_entry: OK [ 5.162300] Testing event hrtimer_start: OK [ 5.170109] Testing event hrtimer_init: OK [ 5.203623] Testing event timer_cancel: OK [ 5.210285] Testing event timer_expire_exit: OK [ 5.218881] Testing event timer_expire_entry: OK [ 5.248334] Testing event timer_start: OK [ 5.267739] Testing event timer_init: OK [ 5.273954] Testing event signal_deliver: OK [ 5.297388] Testing event signal_generate: OK [ 5.307144] Testing event workqueue_execute_end: OK [ 5.314388] Testing event workqueue_execute_start: OK [ 5.337637] Testing event workqueue_activate_work: OK [ 5.346525] Testing event workqueue_queue_work: OK [ 5.376873] Testing event rcu_barrier: OK [ 5.386762] Testing event rcu_torture_read: OK [ 5.394554] Testing event rcu_batch_end: OK [ 5.427852] Testing event rcu_invoke_kfree_callback: OK [ 5.439095] Testing event rcu_invoke_callback: OK [ 5.446065] Testing event rcu_batch_start: OK [ 5.485157] Testing event rcu_kfree_callback: OK [ 5.512135] Testing event rcu_callback: OK [ 5.519315] Testing event rcu_prep_idle: OK [ 5.548148] Testing event rcu_dyntick: OK [ 5.634621] Testing event rcu_utilization: OK [ 5.642538] Testing event sched_pi_setprio: OK [ 5.668067] Testing event sched_stat_runtime: OK [ 5.690800] Testing event sched_stat_blocked: OK [ 5.709036] Testing event sched_stat_iowait: OK [ 5.719157] Testing event sched_stat_sleep: OK [ 5.743191] Testing event sched_stat_wait: [ 5.749656] test-events (142) used greatest stack depth: 6208 bytes left OK [ 5.753109] Testing event sched_process_exec: OK [ 5.841728] Testing event sched_process_fork: OK [ 5.851991] Testing event sched_process_wait: OK [ 5.859311] Testing event sched_wait_task: OK [ 5.866878] Testing event sched_process_exit: OK [ 5.876767] Testing event sched_process_free: OK [ 5.911251] Testing event sched_migrate_task: OK [ 5.919183] Testing event sched_switch: OK [ 5.927592] Testing event sched_wakeup_new: OK [ 5.934237] Testing event sched_wakeup: OK [ 5.942482] Testing event sched_kthread_stop_ret: OK [ 5.951420] Testing event sched_kthread_stop: OK [ 5.958982] Testing event lock_acquired: OK [ 5.968103] Testing event lock_contended: OK [ 6.024662] Testing event lock_release: [ 6.055162] test-events (157) used greatest stack depth: 6192 bytes left OK [ 6.058179] Testing event lock_acquire: [ 6.065671] test-events (158) used greatest stack depth: 6176 bytes left OK [ 6.068679] Testing event module_request: OK [ 6.078633] Testing event module_free: OK [ 6.086595] Testing event module_load: OK [ 6.095653] Testing event ftrace_test_filter: OK [ 6.102578] Testing event power_domain_target: OK [ 6.110795] Testing event clock_set_rate: OK [ 6.119394] Testing event clock_disable: OK [ 6.190695] Testing event clock_enable: OK [ 6.198605] Testing event wakeup_source_deactivate: OK [ 6.206998] Testing event wakeup_source_activate: OK [ 6.233321] Testing event machine_suspend: OK [ 6.243175] Testing event cpu_frequency: OK [ 6.250203] Testing event cpu_idle: OK [ 6.293410] Testing event rpm_return_int: OK [ 6.302846] Testing event rpm_idle: OK [ 6.310650] Testing event rpm_resume: OK [ 6.327719] Testing event rpm_suspend: OK [ 6.334231] Testing event mm_filemap_add_to_page_cache: OK [ 6.351993] Testing event mm_filemap_delete_from_page_cache: OK [ 6.362473] Testing event oom_score_adj_update: OK [ 6.387336] Testing event mm_vmscan_lru_shrink_inactive: OK [ 6.405459] Testing event mm_vmscan_writepage: OK [ 6.414246] Testing event mm_vmscan_memcg_isolate: OK [ 6.422336] Testing event mm_vmscan_lru_isolate: OK [ 6.430268] Testing event mm_shrink_slab_end: OK [ 6.438149] Testing event mm_shrink_slab_start: OK [ 6.446404] Testing event mm_vmscan_memcg_softlimit_reclaim_end: OK [ 6.524494] Testing event mm_vmscan_memcg_reclaim_end: OK [ 6.539536] Testing event mm_vmscan_direct_reclaim_end: OK [ 6.546367] Testing event mm_vmscan_memcg_softlimit_reclaim_begin: OK [ 6.554387] Testing event mm_vmscan_memcg_reclaim_begin: OK [ 6.580100] Testing event mm_vmscan_direct_reclaim_begin: OK [ 6.590373] Testing event mm_vmscan_wakeup_kswapd: OK [ 6.599004] Testing event mm_vmscan_kswapd_wake: OK [ 6.637089] Testing event mm_vmscan_kswapd_sleep: OK [ 6.646788] Testing event mm_page_alloc_extfrag: OK [ 6.654324] Testing event mm_page_pcpu_drain: OK [ 6.676167] Testing event mm_page_alloc_zone_locked: OK [ 6.686400] Testing event mm_page_alloc: OK [ 6.704549] Testing event mm_page_free_batched: OK [ 6.714277] Testing event mm_page_free: OK [ 6.722409] Testing event kmem_cache_free: OK [ 6.754204] Testing event kfree: OK [ 6.762327] Testing event kmem_cache_alloc_node: OK [ 6.770388] Testing event kmalloc_node: OK [ 6.803357] Testing event kmem_cache_alloc: OK [ 6.810249] Testing event kmalloc: OK [ 6.818600] Testing event mm_compaction_migratepages: OK [ 6.851416] Testing event mm_compaction_isolate_freepages: OK [ 6.872704] Testing event mm_compaction_isolate_migratepages: OK [ 6.883270] Testing event mm_migrate_pages: OK [ 6.890336] Testing event writeback_single_inode: OK [ 6.899020] Testing event writeback_single_inode_start: OK [ 6.906434] Testing event writeback_wait_iff_congested: OK [ 6.915088] Testing event writeback_congestion_wait: OK [ 6.927581] Testing event writeback_sb_inodes_requeue: OK [ 6.934230] Testing event balance_dirty_pages: OK [ 7.023484] Testing event bdi_dirty_ratelimit: OK [ 7.030278] Testing event global_dirty_state: OK [ 7.038591] Testing event writeback_queue_io: OK [ 7.047342] Testing event wbc_writepage: OK [ 7.078378] Testing event writeback_bdi_unregister: OK [ 7.090397] Testing event writeback_bdi_register: OK [ 7.117414] Testing event writeback_wake_background: OK [ 7.138107] Testing event writeback_nowork: OK [ 7.146958] Testing event writeback_pages_written: OK [ 7.155409] Testing event writeback_wait: OK [ 7.162353] Testing event writeback_written: OK [ 7.196457] Testing event writeback_start: OK [ 7.206929] Testing event writeback_exec: OK [ 7.239110] Testing event writeback_queue: OK [ 7.246673] Testing event writeback_write_inode: OK [ 7.260222] Testing event writeback_write_inode_start: OK [ 7.272125] Testing event writeback_dirty_inode: OK [ 7.278219] Testing event writeback_dirty_inode_start: OK [ 7.286341] Testing event writeback_dirty_page: OK [ 7.322691] Testing event ext3_load_inode: OK [ 7.348722] Testing event ext3_get_blocks_exit: OK [ 7.358386] Testing event ext3_get_blocks_enter: OK [ 7.366615] Testing event ext3_truncate_exit: OK [ 7.386576] Testing event ext3_truncate_enter: OK [ 7.403770] Testing event ext3_unlink_exit: OK [ 7.410277] Testing event ext3_unlink_enter: OK [ 7.428095] Testing event ext3_direct_IO_exit: OK [ 7.434267] Testing event ext3_direct_IO_enter: OK [ 7.442360] Testing event ext3_read_block_bitmap: OK [ 7.524938] Testing event ext3_forget: OK [ 7.534326] Testing event ext3_reserved: OK [ 7.542943] Testing event ext3_alloc_new_reservation: OK [ 7.583435] Testing event ext3_discard_reservation: OK [ 7.590313] Testing event ext3_rsv_window_add: OK [ 7.605092] Testing event ext3_sync_fs: OK [ 7.616396] Testing event ext3_sync_file_exit: OK [ 7.626284] Testing event ext3_sync_file_enter: OK [ 7.647652] Testing event ext3_free_blocks: OK [ 7.654268] Testing event ext3_allocate_blocks: OK [ 7.663101] Testing event ext3_request_blocks: OK [ 7.694756] Testing event ext3_discard_blocks: OK [ 7.702319] Testing event ext3_invalidatepage: OK [ 7.733811] Testing event ext3_releasepage: OK [ 7.742893] Testing event ext3_readpage: OK [ 7.767259] Testing event ext3_journalled_writepage: OK [ 7.774787] Testing event ext3_writeback_writepage: OK [ 7.789035] Testing event ext3_ordered_writepage: OK [ 7.798602] Testing event ext3_journalled_write_end: OK [ 7.832091] Testing event ext3_writeback_write_end: OK [ 7.839485] Testing event ext3_ordered_write_end: OK [ 7.853414] Testing event ext3_write_begin: OK [ 7.862391] Testing event ext3_mark_inode_dirty: OK [ 7.871057] Testing event ext3_drop_inode: OK [ 7.900190] Testing event ext3_evict_inode: OK [ 7.911059] Testing event ext3_allocate_inode: OK [ 7.918350] Testing event ext3_request_inode: OK [ 7.943603] Testing event ext3_free_inode: OK [ 7.950384] Testing event journal_write_superblock: OK [ 7.965267] Testing event jbd_cleanup_journal_tail: OK [ 7.976243] Testing event jbd_do_submit_data: OK [ 7.995063] Testing event jbd_end_commit: OK [ 8.050438] Testing event jbd_drop_transaction: OK [ 8.058375] Testing event jbd_commit_logging: OK [ 8.066409] Testing event jbd_commit_flushing: OK [ 8.074455] Testing event jbd_commit_locking: OK [ 8.162292] Testing event jbd_start_commit: OK [ 8.173319] Testing event jbd_checkpoint: OK [ 8.238050] Testing event xfs_discard_busy: OK [ 8.246667] Testing event xfs_discard_exclude: OK [ 8.254363] Testing event xfs_discard_toosmall: OK [ 8.263249] Testing event xfs_discard_extent: OK [ 8.270387] Testing event xfs_log_recover_inode_skip: OK [ 8.279395] Testing event xfs_log_recover_inode_cancel: OK [ 8.286359] Testing event xfs_log_recover_inode_recover: OK [ 8.295361] Testing event xfs_log_recover_buf_dquot_buf: OK [ 8.302401] Testing event xfs_log_recover_buf_reg_buf: OK [ 8.310396] Testing event xfs_log_recover_buf_inode_buf: OK [ 8.318406] Testing event xfs_log_recover_buf_recover: OK [ 8.326397] Testing event xfs_log_recover_buf_cancel_ref_inc: OK [ 8.419112] Testing event xfs_log_recover_buf_cancel_add: OK [ 8.441244] Testing event xfs_log_recover_buf_cancel: OK [ 8.450448] Testing event xfs_log_recover_buf_not_cancel: OK [ 8.474630] Testing event xfs_log_recover_item_recover: OK [ 8.483361] Testing event xfs_log_recover_item_reorder_tail: OK [ 8.490422] Testing event xfs_log_recover_item_reorder_head: OK [ 8.523028] Testing event xfs_log_recover_item_add_cont: OK [ 8.530843] Testing event xfs_log_recover_item_add: OK [ 8.575353] Testing event xfs_swap_extent_after: OK [ 8.587360] Testing event xfs_swap_extent_before: OK [ 8.594400] Testing event xfs_dir2_leafn_moveents: OK [ 8.602799] Testing event xfs_dir2_shrink_inode: OK [ 8.621768] Testing event xfs_dir2_grow_inode: OK [ 8.638801] Testing event xfs_dir2_leafn_remove: OK [ 8.647426] Testing event xfs_dir2_leafn_add: OK [ 8.680733] Testing event xfs_da_path_shift: OK [ 8.697962] Testing event xfs_da_fixhashpath: OK [ 8.722959] Testing event xfs_da_shrink_inode: OK [ 8.795988] Testing event xfs_da_grow_inode: OK [ 8.802371] Testing event xfs_da_swap_lastblock: OK [ 8.810467] Testing event xfs_da_node_toosmall: OK [ 8.829159] Testing event xfs_da_node_unbalance: OK [ 8.858540] Testing event xfs_da_node_rebalance: OK [ 8.867107] Testing event xfs_da_node_remove: OK [ 8.886454] Testing event xfs_da_node_split: OK [ 8.904477] Testing event xfs_da_node_create: OK [ 9.058571] Testing event xfs_da_node_add: OK [ 9.082541] Testing event xfs_da_root_join: OK [ 9.090371] Testing event xfs_da_root_split: OK [ 9.107893] Testing event xfs_da_unlink_forward: OK [ 9.135379] Testing event xfs_da_unlink_back: OK [ 9.158969] Testing event xfs_da_link_after: OK [ 9.192141] Testing event xfs_da_link_before: OK [ 9.246908] Testing event xfs_da_join: OK [ 9.268031] Testing event xfs_da_split: OK [ 9.288237] Testing event xfs_attr_rmtval_remove: OK [ 9.314553] Testing event xfs_attr_rmtval_set: OK [ 9.398286] Testing event xfs_attr_rmtval_get: OK [ 9.407846] Testing event xfs_attr_refillstate: OK [ 9.429194] Testing event xfs_attr_fillstate: OK [ 9.453063] Testing event xfs_attr_node_removename: OK [ 9.462680] Testing event xfs_attr_node_replace: OK [ 9.548180] Testing event xfs_attr_node_lookup: OK [ 9.578545] Testing event xfs_attr_node_get: OK [ 9.594481] Testing event xfs_attr_node_addname: OK [ 9.602625] Testing event xfs_attr_leaf_toosmall: OK [ 9.665370] Testing event xfs_attr_leaf_unbalance: OK [ 9.675398] Testing event xfs_attr_leaf_rebalance: OK [ 9.791482] Testing event xfs_attr_leaf_to_node: OK [ 9.798701] Testing event xfs_attr_leaf_to_sf: OK [ 9.806641] Testing event xfs_attr_leaf_flipflags: OK [ 9.814623] Testing event xfs_attr_leaf_setflag: OK [ 9.941298] Testing event xfs_attr_leaf_clearflag: OK [ 9.965835] Testing event xfs_attr_leaf_split_after: OK [ 10.018530] Testing event xfs_attr_leaf_split_before: OK [ 10.037311] Testing event xfs_attr_leaf_split: OK [ 10.102983] Testing event xfs_attr_leaf_removename: OK [ 10.128979] Testing event xfs_attr_leaf_remove: OK [ 10.154504] Testing event xfs_attr_leaf_replace: OK [ 10.179379] Testing event xfs_attr_leaf_lookup: OK [ 10.187441] Testing event xfs_attr_leaf_get: OK [ 10.230669] Testing event xfs_attr_leaf_compact: OK [ 10.242947] Testing event xfs_attr_leaf_create: OK [ 10.250671] Testing event xfs_attr_leaf_addname: OK [ 10.289873] Testing event xfs_attr_leaf_add_work: OK [ 10.313132] Testing event xfs_attr_leaf_add_new: OK [ 10.323669] Testing event xfs_attr_leaf_add_old: OK [ 10.358606] Testing event xfs_attr_leaf_add: OK [ 10.376507] Testing event xfs_attr_sf_to_leaf: OK [ 10.382695] Testing event xfs_attr_sf_removename: OK [ 10.432316] Testing event xfs_attr_sf_remove: OK [ 10.438630] Testing event xfs_attr_sf_lookup: OK [ 10.471539] Testing event xfs_attr_sf_create: OK [ 10.482669] Testing event xfs_attr_sf_addname: OK [ 10.514548] Testing event xfs_attr_sf_add: OK [ 10.550652] Testing event xfs_dir2_node_to_leaf: OK [ 10.579053] Testing event xfs_dir2_node_removename: OK [ 10.592922] Testing event xfs_dir2_node_replace: OK [ 10.623277] Testing event xfs_dir2_node_lookup: OK [ 10.666651] Testing event xfs_dir2_node_addname: OK [ 10.694589] Testing event xfs_dir2_leaf_to_node: OK [ 10.722577] Testing event xfs_dir2_leaf_to_block: OK [ 10.751465] Testing event xfs_dir2_leaf_removename: OK [ 10.789423] Testing event xfs_dir2_leaf_replace: OK [ 10.810885] Testing event xfs_dir2_leaf_lookup: OK [ 10.818587] Testing event xfs_dir2_leaf_addname: OK [ 10.895495] Testing event xfs_dir2_block_to_leaf: OK [ 10.935995] Testing event xfs_dir2_block_to_sf: OK [ 10.943440] Testing event xfs_dir2_block_removename: OK [ 10.950743] Testing event xfs_dir2_block_replace: OK [ 10.958746] Testing event xfs_dir2_block_lookup: OK [ 10.966703] Testing event xfs_dir2_block_addname: OK [ 10.974762] Testing event xfs_dir2_sf_to_block: OK [ 11.082625] Testing event xfs_dir2_sf_toino8: OK [ 11.118668] Testing event xfs_dir2_sf_toino4: OK [ 11.148431] Testing event xfs_dir2_sf_removename: OK [ 11.178659] Testing event xfs_dir2_sf_replace: OK [ 11.205107] Testing event xfs_dir2_sf_lookup: OK [ 11.214818] Testing event xfs_dir2_sf_create: OK [ 11.283901] Testing event xfs_dir2_sf_addname: OK [ 11.290740] Testing event xfs_alloc_vextent_allfailed: OK [ 11.320241] Testing event xfs_alloc_vextent_loopfailed: OK [ 11.359005] Testing event xfs_alloc_vextent_noagbp: OK [ 11.370872] Testing event xfs_alloc_vextent_nofix: OK [ 11.378764] Testing event xfs_alloc_vextent_badargs: OK [ 11.432244] Testing event xfs_alloc_small_error: OK [ 11.438700] Testing event xfs_alloc_small_done: OK [ 11.470142] Testing event xfs_alloc_small_notenough: OK [ 11.490522] Testing event xfs_alloc_small_freelist: OK [ 11.506618] Testing event xfs_alloc_size_busy: OK [ 11.547611] Testing event xfs_alloc_size_error: OK [ 11.554754] Testing event xfs_alloc_size_done: OK [ 11.588188] Testing event xfs_alloc_size_nominleft: OK [ 11.621453] Testing event xfs_alloc_size_noentry: OK [ 11.648485] Testing event xfs_alloc_size_neither: OK [ 11.654750] Testing event xfs_alloc_near_busy: OK [ 11.684512] Testing event xfs_alloc_near_noentry: OK [ 11.717909] Testing event xfs_alloc_near_error: OK [ 11.740162] Testing event xfs_alloc_near_lesser: OK [ 11.746718] Testing event xfs_alloc_near_greater: OK [ 11.774520] Testing event xfs_alloc_near_first: OK [ 11.791272] Testing event xfs_alloc_near_nominleft: OK [ 11.798665] Testing event xfs_alloc_exact_error: OK [ 11.854880] Testing event xfs_alloc_exact_notfound: OK [ 11.862831] Testing event xfs_alloc_exact_done: OK [ 11.919835] Testing event xfs_free_extent: OK [ 11.926777] Testing event xfs_agf: OK [ 11.962999] Testing event xfs_trans_commit_lsn: OK [ 11.975516] Testing event xfs_extent_busy_trim: OK [ 11.982791] Testing event xfs_extent_busy_clear: OK [ 12.042329] Testing event xfs_extent_busy_reuse: OK [ 12.066688] Testing event xfs_extent_busy_force: OK [ 12.098669] Testing event xfs_extent_busy_enomem: OK [ 12.130678] Testing event xfs_extent_busy: OK [ 12.150691] Testing event xfs_bunmap: OK [ 12.168957] Testing event xfs_pagecache_inval: OK [ 12.197525] Testing event xfs_itruncate_extents_end: OK [ 12.267351] Testing event xfs_itruncate_extents_start: OK [ 12.276877] Testing event xfs_setfilesize: OK [ 12.372580] Testing event xfs_get_blocks_notfound: OK [ 12.382929] Testing event xfs_unwritten_convert: OK [ 12.394941] Testing event xfs_delalloc_enospc: OK [ 12.498666] Testing event xfs_get_blocks_alloc: OK [ 12.520488] Testing event xfs_get_blocks_found: OK [ 12.554696] Testing event xfs_map_blocks_alloc: OK [ 12.568607] Testing event xfs_map_blocks_found: OK [ 12.598782] Testing event xfs_invalidatepage: OK [ 12.623395] Testing event xfs_releasepage: OK [ 12.635969] Testing event xfs_writepage: OK [ 12.673770] Testing event xfs_file_splice_write: OK [ 12.698751] Testing event xfs_file_splice_read: OK [ 12.723438] Testing event xfs_file_direct_write: OK [ 12.766750] Testing event xfs_file_buffered_write: OK [ 12.777492] Testing event xfs_file_read: OK [ 12.802254] Testing event xfs_ail_flushing: OK [ 12.822743] Testing event xfs_ail_locked: OK [ 12.862724] Testing event xfs_ail_pinned: OK [ 12.896097] Testing event xfs_ail_push: OK [ 12.902828] Testing event xfs_log_force: OK [ 12.935788] Testing event xfs_log_ungrant_sub: OK [ 12.976732] Testing event xfs_log_ungrant_exit: OK [ 13.006913] Testing event xfs_log_ungrant_enter: OK [ 13.014874] Testing event xfs_log_regrant_reserve_sub: OK [ 13.023095] Testing event xfs_log_regrant_reserve_exit: OK [ 13.031461] Testing event xfs_log_regrant_reserve_enter: OK [ 13.039273] Testing event xfs_log_regrant_exit: OK [ 13.048306] Testing event xfs_log_regrant: OK [ 13.055294] Testing event xfs_log_reserve_exit: OK [ 13.062919] Testing event xfs_log_reserve: OK [ 13.071072] Testing event xfs_log_grant_wake_up: OK [ 13.079250] Testing event xfs_log_grant_wake: OK [ 13.087351] Testing event xfs_log_grant_sleep: OK [ 13.095140] Testing event xfs_log_umount_write: OK [ 13.103124] Testing event xfs_log_done_perm: OK [ 13.111406] Testing event xfs_log_done_nonperm: OK [ 13.118904] Testing event xfs_dqflush_done: OK [ 13.127193] Testing event xfs_dqflush_force: OK [ 13.135297] Testing event xfs_dqflush: OK [ 13.144479] Testing event xfs_dqrele: OK [ 13.150973] Testing event xfs_dqput_free: OK [ 13.158961] Testing event xfs_dqput_wait: OK [ 13.167270] Testing event xfs_dqput: OK [ 13.175254] Testing event xfs_dqget_dup: OK [ 13.183325] Testing event xfs_dqget_freeing: OK [ 13.191055] Testing event xfs_dqget_miss: OK [ 13.199446] Testing event xfs_dqget_hit: OK [ 13.207411] Testing event xfs_dqread_fail: OK [ 13.215115] Testing event xfs_dqread: OK [ 13.228822] Testing event xfs_dqtobp_read: OK [ 13.239015] Testing event xfs_dqalloc: OK [ 13.246906] Testing event xfs_dqattach_get: OK [ 13.254880] Testing event xfs_dqattach_found: OK [ 13.262725] Testing event xfs_dqreclaim_done: OK [ 13.270802] Testing event xfs_dqreclaim_busy: OK [ 13.278728] Testing event xfs_dqreclaim_dirty: OK [ 13.286820] Testing event xfs_dqreclaim_want: OK [ 13.294754] Testing event xfs_dqadjust: OK [ 13.302844] Testing event xfs_rename: OK [ 13.310800] Testing event xfs_symlink: OK [ 13.318756] Testing event xfs_create: OK [ 13.326894] Testing event xfs_lookup: OK [ 13.334805] Testing event xfs_link: OK [ 13.342972] Testing event xfs_remove: OK [ 13.350933] Testing event xfs_inode_unpin_nowait: OK [ 13.358846] Testing event xfs_inode_unpin: OK [ 13.366617] Testing event xfs_inode_pin: OK [ 13.374820] Testing event xfs_irele: OK [ 13.383215] Testing event xfs_ihold: OK [ 13.391038] Testing event xfs_iomap_prealloc_size: OK [ 13.398709] Testing event xfs_inode_free_eofblocks_invalid: OK [ 13.406777] Testing event xfs_inode_clear_eofblocks_tag: OK [ 13.414952] Testing event xfs_inode_set_eofblocks_tag: OK [ 13.422712] Testing event xfs_dquot_dqdetach: OK [ 13.430923] Testing event xfs_dquot_dqalloc: OK [ 13.439015] Testing event xfs_update_time: OK [ 13.446908] Testing event xfs_evict_inode: OK [ 13.455010] Testing event xfs_destroy_inode: OK [ 13.463082] Testing event xfs_file_fsync: OK [ 13.470780] Testing event xfs_dir_fsync: OK [ 13.478872] Testing event xfs_ioctl_setattr: OK [ 13.487002] Testing event xfs_file_compat_ioctl: OK [ 13.494858] Testing event xfs_file_ioctl: OK [ 13.503009] Testing event xfs_vm_bmap: OK [ 13.510781] Testing event xfs_readdir: OK [ 13.518989] Testing event xfs_free_file_space: OK [ 13.527050] Testing event xfs_alloc_file_space: OK [ 13.534851] Testing event xfs_readlink: OK [ 13.542966] Testing event xfs_setattr: OK [ 13.551147] Testing event xfs_getattr: OK [ 13.559012] Testing event xfs_iget_miss: OK [ 13.567012] Testing event xfs_iget_hit: OK [ 13.575132] Testing event xfs_iget_reclaim_fail: OK [ 13.583002] Testing event xfs_iget_reclaim: OK [ 13.590892] Testing event xfs_iget_skip: OK [ 13.599111] Testing event xfs_iunlock: OK [ 13.606943] Testing event xfs_ilock_demote: OK [ 13.615042] Testing event xfs_ilock_nowait: OK [ 13.623120] Testing event xfs_ilock: OK [ 13.630992] Testing event xfs_trans_binval: OK [ 13.638978] Testing event xfs_trans_bhold_release: OK [ 13.646985] Testing event xfs_trans_bhold: OK [ 13.655001] Testing event xfs_trans_bjoin: OK [ 13.662975] Testing event xfs_trans_brelse: OK [ 13.671091] Testing event xfs_trans_log_buf: OK [ 13.678901] Testing event xfs_trans_read_buf_recur: OK [ 13.687140] Testing event xfs_trans_read_buf: OK [ 13.695011] Testing event xfs_trans_getsb_recur: OK [ 13.703024] Testing event xfs_trans_getsb: OK [ 13.711125] Testing event xfs_trans_get_buf_recur: OK [ 13.718915] Testing event xfs_trans_get_buf: OK [ 13.727029] Testing event xfs_buf_item_push: OK [ 13.735132] Testing event xfs_buf_item_committed: OK [ 13.743023] Testing event xfs_buf_item_unlock_stale: OK [ 13.751320] Testing event xfs_buf_item_unlock: OK [ 13.758923] Testing event xfs_buf_item_unpin_stale: OK [ 13.767012] Testing event xfs_buf_item_unpin: OK [ 13.775120] Testing event xfs_buf_item_pin: OK [ 13.783039] Testing event xfs_buf_item_format_stale: OK [ 13.791126] Testing event xfs_buf_item_format: OK [ 13.799037] Testing event xfs_buf_item_size_stale: OK [ 13.806872] Testing event xfs_buf_item_size: OK [ 13.814909] Testing event xfs_buf_ioerror: OK [ 13.823022] Testing event xfs_buf_read: OK [ 13.831259] Testing event xfs_buf_get: OK [ 13.838684] Testing event xfs_buf_find: OK [ 13.846964] Testing event xfs_inode_item_push: OK [ 13.854910] Testing event xfs_reset_dqcounts: OK [ 13.862883] Testing event xfs_da_btree_corrupt: OK [ 13.871012] Testing event xfs_btree_corrupt: OK [ 13.879368] Testing event xfs_trans_read_buf_shut: OK [ 13.886906] Testing event xfs_trans_read_buf_io: OK [ 13.895117] Testing event xfs_buf_wait_buftarg: OK [ 13.902876] Testing event xfs_buf_error_relse: OK [ 13.910666] Testing event xfs_buf_item_iodone_async: OK [ 13.918804] Testing event xfs_buf_item_iodone: OK [ 13.926713] Testing event xfs_buf_item_relse: OK [ 13.934808] Testing event xfs_bdstrat_shut: OK [ 13.942669] Testing event xfs_buf_get_uncached: OK [ 13.951071] Testing event xfs_buf_delwri_split: OK [ 13.958728] Testing event xfs_buf_delwri_queued: OK [ 13.966835] Testing event xfs_buf_delwri_queue: OK [ 13.975213] Testing event xfs_buf_iowait_done: OK [ 13.982624] Testing event xfs_buf_iowait: OK [ 13.990970] Testing event xfs_buf_unlock: OK [ 13.998859] Testing event xfs_buf_trylock: OK [ 14.006839] Testing event xfs_buf_lock_done: OK [ 14.015013] Testing event xfs_buf_lock: OK [ 14.023350] Testing event xfs_buf_bawrite: OK [ 14.031036] Testing event xfs_buf_iorequest: OK [ 14.039155] Testing event xfs_buf_iodone: OK [ 14.047157] Testing event xfs_buf_rele: OK [ 14.055355] Testing event xfs_buf_hold: OK [ 14.063001] Testing event xfs_buf_free: OK [ 14.071072] Testing event xfs_buf_init: OK [ 14.079100] Testing event xfs_extlist: OK [ 14.087001] Testing event xfs_bmap_post_update: OK [ 14.095447] Testing event xfs_bmap_pre_update: OK [ 14.107503] Testing event xfs_iext_remove: OK [ 14.115324] Testing event xfs_iext_insert: OK [ 14.122946] Testing event xfs_attr_list_node_descend: OK [ 14.135369] Testing event xfs_perag_clear_eofblocks: OK [ 14.143015] Testing event xfs_perag_set_eofblocks: OK [ 14.155421] Testing event xfs_perag_clear_reclaim: OK [ 14.163255] Testing event xfs_perag_set_reclaim: OK [ 14.175609] Testing event xfs_perag_put: OK [ 14.183072] Testing event xfs_perag_get_tag: OK [ 14.195693] Testing event xfs_perag_get: OK [ 14.207249] Testing event xfs_attr_node_list: OK [ 14.215680] Testing event xfs_attr_leaf_list: OK [ 14.227297] Testing event xfs_attr_list_notfound: OK [ 14.235934] Testing event xfs_attr_list_wrong_blk: OK [ 14.247411] Testing event xfs_attr_list_add: OK [ 14.255384] Testing event xfs_attr_list_full: OK [ 14.263098] Testing event xfs_attr_list_leaf_end: OK [ 14.275441] Testing event xfs_attr_list_leaf: OK [ 14.283069] Testing event xfs_attr_list_sf_all: OK [ 14.295544] Testing event xfs_attr_list_sf: OK [ 14.303053] Testing event free_extent_state: OK [ 14.315355] Testing event alloc_extent_state: OK [ 14.323132] Testing event btrfs_setup_cluster: OK [ 14.330990] Testing event btrfs_failed_cluster_setup: OK [ 14.339010] Testing event btrfs_find_cluster: OK [ 14.346977] Testing event btrfs_reserve_extent_cluster: OK [ 14.354973] Testing event btrfs_reserve_extent: OK [ 14.362992] Testing event find_free_extent: OK [ 14.370882] Testing event btrfs_reserved_extent_free: OK [ 14.378904] Testing event btrfs_reserved_extent_alloc: OK [ 14.387194] Testing event btrfs_space_reservation: OK [ 14.395115] Testing event btrfs_cow_block: OK [ 14.402943] Testing event btrfs_chunk_free: OK [ 14.411138] Testing event btrfs_chunk_alloc: OK [ 14.418895] Testing event btrfs_delayed_ref_head: OK [ 14.426876] Testing event btrfs_delayed_data_ref: OK [ 14.435124] Testing event btrfs_delayed_tree_ref: OK [ 14.442867] Testing event btrfs_sync_fs: OK [ 14.450879] Testing event btrfs_sync_file: OK [ 14.458885] Testing event btrfs_writepage_end_io_hook: OK [ 14.466958] Testing event __extent_writepage: OK [ 14.474867] Testing event btrfs_ordered_extent_put: OK [ 14.483045] Testing event btrfs_ordered_extent_start: OK [ 14.491046] Testing event btrfs_ordered_extent_remove: OK [ 14.499944] Testing event btrfs_ordered_extent_add: OK [ 14.507275] Testing event btrfs_get_extent: OK [ 14.529036] Testing event btrfs_inode_evict: OK [ 14.545618] Testing event btrfs_inode_request: OK [ 14.555904] Testing event btrfs_inode_new: OK [ 14.563838] Testing event btrfs_transaction_commit: OK [ 14.571766] Testing event block_rq_remap: OK [ 14.579334] Testing event block_bio_remap: OK [ 14.587269] Testing event block_split: OK [ 14.596191] Testing event block_unplug: OK [ 14.604314] Testing event block_plug: OK [ 14.611055] Testing event block_sleeprq: OK [ 14.619382] Testing event block_getrq: OK [ 14.628365] Testing event block_bio_queue: OK [ 14.636730] Testing event block_bio_frontmerge: OK [ 14.644584] Testing event block_bio_backmerge: OK [ 14.652254] Testing event block_bio_complete: OK [ 14.659756] Testing event block_bio_bounce: OK [ 14.668192] Testing event block_rq_issue: OK [ 14.676017] Testing event block_rq_insert: OK [ 14.683050] Testing event block_rq_complete: OK [ 14.692095] Testing event block_rq_requeue: OK [ 14.699622] Testing event block_rq_abort: OK [ 14.709505] Testing event block_dirty_buffer: OK [ 14.719112] Testing event block_touch_buffer: OK [ 14.727488] Testing event regulator_set_voltage_complete: OK [ 14.736008] Testing event regulator_set_voltage: OK [ 14.749327] Testing event regulator_disable_complete: OK [ 14.759112] Testing event regulator_disable: OK [ 14.767975] Testing event regulator_enable_complete: OK [ 14.775599] Testing event regulator_enable_delay: OK [ 14.785084] Testing event regulator_enable: OK [ 14.795547] Testing event extract_entropy_user: OK [ 14.803935] Testing event extract_entropy: OK [ 14.812016] Testing event get_random_bytes: OK [ 14.819800] Testing event credit_entropy_bits: OK [ 14.828124] Testing event mix_pool_bytes_nolock: OK [ 14.836437] Testing event mix_pool_bytes: OK [ 14.844993] Testing event regmap_async_complete_done: OK [ 14.856312] Testing event regmap_async_complete_start: OK [ 14.864110] Testing event regmap_async_io_complete: OK [ 14.871540] Testing event regmap_async_write_start: OK [ 14.880174] Testing event regmap_cache_bypass: OK [ 14.888524] Testing event regmap_cache_only: OK [ 14.895833] Testing event regcache_sync: OK [ 14.903120] Testing event regmap_hw_write_done: OK [ 14.911008] Testing event regmap_hw_write_start: OK [ 14.919611] Testing event regmap_hw_read_done: OK [ 14.927504] Testing event regmap_hw_read_start: OK [ 14.935230] Testing event regmap_reg_read_cache: OK [ 14.943276] Testing event regmap_reg_read: OK [ 14.952305] Testing event regmap_reg_write: OK [ 14.959351] Testing event scsi_eh_wakeup: OK [ 14.967147] Testing event scsi_dispatch_cmd_timeout: OK [ 14.976903] Testing event scsi_dispatch_cmd_done: OK [ 14.983473] Testing event scsi_dispatch_cmd_error: OK [ 14.992101] Testing event scsi_dispatch_cmd_start: OK [ 14.999513] Testing event binder_return: OK [ 15.008978] Testing event binder_command: OK [ 15.015559] Testing event binder_update_page_range: OK [ 15.023360] Testing event binder_transaction_failed_buffer_release: OK [ 15.031587] Testing event binder_transaction_buffer_release: OK [ 15.041301] Testing event binder_transaction_alloc_buf: OK [ 15.051913] Testing event binder_transaction_fd: OK [ 15.059241] Testing event binder_transaction_ref_to_ref: OK [ 15.067738] Testing event binder_transaction_ref_to_node: OK [ 15.076205] Testing event binder_transaction_node_to_ref: OK [ 15.083313] Testing event binder_transaction_received: OK [ 15.092454] Testing event binder_transaction: OK [ 15.100192] Testing event binder_wait_for_work: OK [ 15.109736] Testing event binder_read_done: OK [ 15.119564] Testing event binder_write_done: OK [ 15.128317] Testing event binder_ioctl_done: OK [ 15.135117] Testing event binder_unlock: OK [ 15.144587] Testing event binder_locked: OK [ 15.151933] Testing event binder_lock: OK [ 15.160016] Testing event binder_ioctl: OK [ 15.167831] Testing event sync_pt: OK [ 15.175470] Testing event sync_wait: OK [ 15.183286] Testing event sync_timeline: OK [ 15.192489] Testing event udp_fail_queue_rcv_skb: OK [ 15.199723] Testing event sock_exceed_buf_limit: OK [ 15.207544] Testing event sock_rcvqueue_full: OK [ 15.215167] Testing event napi_poll: OK [ 15.223741] Testing event netif_rx: OK [ 15.231752] Testing event netif_receive_skb: OK [ 15.239239] Testing event net_dev_queue: OK [ 15.247915] Testing event net_dev_xmit: OK [ 15.255482] Testing event skb_copy_datagram_iovec: OK [ 15.263117] Testing event consume_skb: OK [ 15.271135] Testing event kfree_skb: OK [ 15.280428] Running tests on trace event systems: [ 15.281784] Testing event system skb: OK [ 15.291550] Testing event system net: OK [ 15.300990] Testing event system napi: OK [ 15.309478] Testing event system sock: OK [ 15.320328] Testing event system udp: OK [ 15.328023] Testing event system sync: OK [ 15.337725] Testing event system binder: OK [ 15.350635] Testing event system scsi: OK [ 15.359912] Testing event system regmap: OK [ 15.369368] Testing event system random: OK [ 15.380035] Testing event system regulator: OK [ 15.389294] Testing event system block: OK [ 15.401733] Testing event system btrfs: OK [ 15.413668] Testing event system xfs: OK [ 15.542398] Testing event system jbd: OK [ 15.552012] Testing event system ext3: OK [ 15.571153] Testing event system writeback: OK [ 15.586695] Testing event system migrate: OK [ 15.595386] Testing event system compaction: OK [ 15.603556] Testing event system kmem: OK [ 15.613337] Testing event system vmscan: OK [ 15.624644] Testing event system oom: OK [ 15.631490] Testing event system filemap: OK [ 15.641270] Testing event system rpm: OK [ 15.652403] Testing event system power: OK [ 15.660056] Testing event system test: OK [ 15.668798] Testing event system module: OK [ 15.676159] Testing event system lock: OK [ 15.684375] Testing event system sched: [ 15.695164] test-events (755) used greatest stack depth: 6088 bytes left OK [ 15.699402] Testing event system rcu: OK [ 15.709232] Testing event system workqueue: OK [ 15.720815] Testing event system signal: OK [ 15.728397] Testing event system timer: OK [ 15.740873] Testing event system irq: OK [ 15.752556] Testing event system printk: OK [ 15.760111] Testing event system task: OK [ 15.769074] Testing event system raw_syscalls: OK [ 15.780265] Testing event system vsyscall: OK [ 15.788032] Testing event system syscalls: OK [ 15.801663] Running tests on all trace events: [ 15.803187] Testing all events: OK [ 16.271020] Running tests again, along with the function tracer [ 16.273079] Running tests on trace events: [ 16.274776] Testing event emulate_vsyscall: [ 16.283006] test-events (767) used greatest stack depth: 5864 bytes left OK [ 16.287320] Testing event sys_exit: OK [ 16.301308] Testing event sys_enter: OK [ 16.313714] Testing event task_rename: OK [ 16.325207] Testing event task_newtask: OK [ 16.337917] Testing event console: OK [ 16.349122] Testing event softirq_raise: [ 16.360773] test-events (773) used greatest stack depth: 5840 bytes left OK [ 16.364904] Testing event softirq_exit: OK [ 16.376963] Testing event softirq_entry: OK [ 16.389551] Testing event irq_handler_exit: OK [ 16.401434] Testing event irq_handler_entry: OK [ 16.415149] Testing event itimer_expire: OK [ 16.424007] Testing event itimer_state: OK [ 16.432304] Testing event hrtimer_cancel: OK [ 16.445230] Testing event hrtimer_expire_exit: OK [ 16.456627] Testing event hrtimer_expire_entry: OK [ 16.468816] Testing event hrtimer_start: OK [ 16.480855] Testing event hrtimer_init: OK [ 16.493738] Testing event timer_cancel: OK [ 16.505990] Testing event timer_expire_exit: OK [ 16.517151] Testing event timer_expire_entry: OK [ 16.529804] Testing event timer_start: OK [ 16.541471] Testing event timer_init: OK [ 16.552610] Testing event signal_deliver: OK [ 16.565914] Testing event signal_generate: OK [ 16.577058] Testing event workqueue_execute_end: OK [ 16.588876] Testing event workqueue_execute_start: OK [ 16.600471] Testing event workqueue_activate_work: OK [ 16.613341] Testing event workqueue_queue_work: OK [ 16.625247] Testing event rcu_barrier: OK [ 16.637266] Testing event rcu_torture_read: OK [ 16.649402] Testing event rcu_batch_end: OK [ 16.661068] Testing event rcu_invoke_kfree_callback: OK [ 16.672449] Testing event rcu_invoke_callback: OK [ 16.684964] Testing event rcu_batch_start: OK [ 16.697008] Testing event rcu_kfree_callback: OK [ 16.709044] Testing event rcu_callback: OK [ 16.720956] Testing event rcu_prep_idle: OK [ 16.732392] Testing event rcu_dyntick: OK [ 16.745522] Testing event rcu_utilization: OK [ 16.758682] Testing event sched_pi_setprio: OK [ 16.769165] Testing event sched_stat_runtime: OK [ 16.780003] Testing event sched_stat_blocked: OK [ 16.790198] Testing event sched_stat_iowait: OK [ 16.801687] Testing event sched_stat_sleep: OK [ 16.813285] Testing event sched_stat_wait: OK [ 16.824853] Testing event sched_process_exec: OK [ 16.836735] Testing event sched_process_fork: OK [ 16.849342] Testing event sched_process_wait: OK [ 16.861172] Testing event sched_wait_task: OK [ 16.872725] Testing event sched_process_exit: OK [ 16.885045] Testing event sched_process_free: OK [ 16.896753] Testing event sched_migrate_task: OK [ 16.910018] Testing event sched_switch: OK [ 16.920392] Testing event sched_wakeup_new: OK [ 16.933674] Testing event sched_wakeup: OK [ 16.945174] Testing event sched_kthread_stop_ret: OK [ 16.956572] Testing event sched_kthread_stop: OK [ 16.969461] Testing event lock_acquired: OK [ 16.980760] Testing event lock_contended: OK [ 16.993246] Testing event lock_release: [ 17.004127] test-events (827) used greatest stack depth: 5776 bytes left OK [ 17.009169] Testing event lock_acquire: OK [ 17.022554] Testing event module_request: OK [ 17.032490] Testing event module_free: OK [ 17.051043] Testing event module_load: OK [ 17.065938] Testing event ftrace_test_filter: OK [ 17.077473] Testing event power_domain_target: OK [ 17.088635] Testing event clock_set_rate: OK [ 17.100968] Testing event clock_disable: OK [ 17.112467] Testing event clock_enable: OK [ 17.120277] Testing event wakeup_source_deactivate: OK [ 17.127570] Testing event wakeup_source_activate: OK [ 17.137560] Testing event machine_suspend: OK [ 17.149784] Testing event cpu_frequency: OK [ 17.159533] Testing event cpu_idle: OK [ 17.168249] Testing event rpm_return_int: OK [ 17.176789] Testing event rpm_idle: OK [ 17.188479] Testing event rpm_resume: OK [ 17.199907] Testing event rpm_suspend: OK [ 17.208652] Testing event mm_filemap_add_to_page_cache: OK [ 17.220276] Testing event mm_filemap_delete_from_page_cache: OK [ 17.233040] Testing event oom_score_adj_update: OK [ 17.245807] Testing event mm_vmscan_lru_shrink_inactive: OK [ 17.256757] Testing event mm_vmscan_writepage: OK [ 17.268658] Testing event mm_vmscan_memcg_isolate: OK [ 17.279900] Testing event mm_vmscan_lru_isolate: OK [ 17.289287] Testing event mm_shrink_slab_end: OK [ 17.300848] Testing event mm_shrink_slab_start: OK [ 17.314689] Testing event mm_vmscan_memcg_softlimit_reclaim_end: OK [ 17.325160] Testing event mm_vmscan_memcg_reclaim_end: OK [ 17.336797] Testing event mm_vmscan_direct_reclaim_end: OK [ 17.348671] Testing event mm_vmscan_memcg_softlimit_reclaim_begin: OK [ 17.360082] Testing event mm_vmscan_memcg_reclaim_begin: OK [ 17.368055] Testing event mm_vmscan_direct_reclaim_begin: OK [ 17.376337] Testing event mm_vmscan_wakeup_kswapd: OK [ 17.388702] Testing event mm_vmscan_kswapd_wake: OK [ 17.400679] Testing event mm_vmscan_kswapd_sleep: OK [ 17.407847] Testing event mm_page_alloc_extfrag: OK [ 17.416260] Testing event mm_page_pcpu_drain: OK [ 17.423911] Testing event mm_page_alloc_zone_locked: OK [ 17.432267] Testing event mm_page_alloc: OK [ 17.444618] Testing event mm_page_free_batched: OK [ 17.456686] Testing event mm_page_free: OK [ 17.468557] Testing event kmem_cache_free: OK [ 17.480025] Testing event kfree: OK [ 17.488054] Testing event kmem_cache_alloc_node: OK [ 17.497247] Testing event kmalloc_node: OK [ 17.509001] Testing event kmem_cache_alloc: OK [ 17.520866] Testing event kmalloc: OK [ 17.529122] Testing event mm_compaction_migratepages: OK [ 17.540740] Testing event mm_compaction_isolate_freepages: OK [ 17.552129] Testing event mm_compaction_isolate_migratepages: OK [ 17.560197] Testing event mm_migrate_pages: OK [ 17.568493] Testing event writeback_single_inode: OK [ 17.580223] Testing event writeback_single_inode_start: OK [ 17.592515] Testing event writeback_wait_iff_congested: OK [ 17.599432] Testing event writeback_congestion_wait: OK [ 17.611026] Testing event writeback_sb_inodes_requeue: OK [ 17.620472] Testing event balance_dirty_pages: OK [ 17.629095] Testing event bdi_dirty_ratelimit: OK [ 17.640873] Testing event global_dirty_state: OK [ 17.652221] Testing event writeback_queue_io: OK [ 17.665291] Testing event wbc_writepage: OK [ 17.675367] Testing event writeback_bdi_unregister: OK [ 17.684839] Testing event writeback_bdi_register: OK [ 17.692356] Testing event writeback_wake_background: OK [ 17.700427] Testing event writeback_nowork: OK [ 17.708939] Testing event writeback_pages_written: OK [ 17.720012] Testing event writeback_wait: OK [ 17.728840] Testing event writeback_written: OK [ 17.740822] Testing event writeback_start: OK [ 17.751613] Testing event writeback_exec: OK [ 17.759878] Testing event writeback_queue: OK [ 17.772694] Testing event writeback_write_inode: OK [ 17.784584] Testing event writeback_write_inode_start: OK [ 17.796393] Testing event writeback_dirty_inode: OK [ 17.808627] Testing event writeback_dirty_inode_start: OK [ 17.821121] Testing event writeback_dirty_page: OK [ 17.832475] Testing event ext3_load_inode: OK [ 17.844499] Testing event ext3_get_blocks_exit: OK [ 17.856838] Testing event ext3_get_blocks_enter: OK [ 17.868001] Testing event ext3_truncate_exit: OK [ 17.876972] Testing event ext3_truncate_enter: OK [ 17.889103] Testing event ext3_unlink_exit: OK [ 17.900137] Testing event ext3_unlink_enter: OK [ 17.908999] Testing event ext3_direct_IO_exit: OK [ 17.920518] Testing event ext3_direct_IO_enter: OK [ 17.932632] Testing event ext3_read_block_bitmap: OK [ 17.944457] Testing event ext3_forget: OK [ 17.957014] Testing event ext3_reserved: OK [ 17.968063] Testing event ext3_alloc_new_reservation: OK [ 17.976219] Testing event ext3_discard_reservation: OK [ 17.984992] Testing event ext3_rsv_window_add: OK [ 17.997082] Testing event ext3_sync_fs: OK [ 18.008113] Testing event ext3_sync_file_exit: OK [ 18.017019] Testing event ext3_sync_file_enter: OK [ 18.028173] Testing event ext3_free_blocks: OK [ 18.037154] Testing event ext3_allocate_blocks: OK [ 18.049093] Testing event ext3_request_blocks: OK [ 18.061262] Testing event ext3_discard_blocks: OK [ 18.073570] Testing event ext3_invalidatepage: OK [ 18.085442] Testing event ext3_releasepage: OK [ 18.096660] Testing event ext3_readpage: OK [ 18.108762] Testing event ext3_journalled_writepage: OK [ 18.121628] Testing event ext3_writeback_writepage: OK [ 18.134774] Testing event ext3_ordered_writepage: OK [ 18.144327] Testing event ext3_journalled_write_end: OK [ 18.152748] Testing event ext3_writeback_write_end: OK [ 18.160519] Testing event ext3_ordered_write_end: OK [ 18.173016] Testing event ext3_write_begin: OK [ 18.185197] Testing event ext3_mark_inode_dirty: OK [ 18.196914] Testing event ext3_drop_inode: OK [ 18.209305] Testing event ext3_evict_inode: OK [ 18.221915] Testing event ext3_allocate_inode: OK [ 18.233628] Testing event ext3_request_inode: OK [ 18.245328] Testing event ext3_free_inode: OK [ 18.257083] Testing event journal_write_superblock: OK [ 18.269278] Testing event jbd_cleanup_journal_tail: OK [ 18.282035] Testing event jbd_do_submit_data: OK [ 18.292347] Testing event jbd_end_commit: OK [ 18.305191] Testing event jbd_drop_transaction: OK [ 18.316384] Testing event jbd_commit_logging: OK [ 18.329834] Testing event jbd_commit_flushing: OK [ 18.341507] Testing event jbd_commit_locking: OK [ 18.352640] Testing event jbd_start_commit: OK [ 18.360158] Testing event jbd_checkpoint: OK [ 18.368822] Testing event xfs_discard_busy: OK [ 18.376125] Testing event xfs_discard_exclude: OK [ 18.384906] Testing event xfs_discard_toosmall: OK [ 18.396303] Testing event xfs_discard_extent: OK [ 18.404651] Testing event xfs_log_recover_inode_skip: OK [ 18.412991] Testing event xfs_log_recover_inode_cancel: OK [ 18.424564] Testing event xfs_log_recover_inode_recover: OK [ 18.433459] Testing event xfs_log_recover_buf_dquot_buf: OK [ 18.444329] Testing event xfs_log_recover_buf_reg_buf: OK [ 18.452319] Testing event xfs_log_recover_buf_inode_buf: OK [ 18.460511] Testing event xfs_log_recover_buf_recover: OK [ 18.467639] Testing event xfs_log_recover_buf_cancel_ref_inc: OK [ 18.476148] Testing event xfs_log_recover_buf_cancel_add: OK [ 18.483785] Testing event xfs_log_recover_buf_cancel: OK [ 18.491750] Testing event xfs_log_recover_buf_not_cancel: OK [ 18.500207] Testing event xfs_log_recover_item_recover: OK [ 18.507295] Testing event xfs_log_recover_item_reorder_tail: OK [ 18.517245] Testing event xfs_log_recover_item_reorder_head: OK [ 18.528727] Testing event xfs_log_recover_item_add_cont: OK [ 18.541021] Testing event xfs_log_recover_item_add: OK [ 18.552525] Testing event xfs_swap_extent_after: OK [ 18.562163] Testing event xfs_swap_extent_before: OK [ 18.571498] Testing event xfs_dir2_leafn_moveents: OK [ 18.579570] Testing event xfs_dir2_shrink_inode: OK [ 18.588088] Testing event xfs_dir2_grow_inode: OK [ 18.595902] Testing event xfs_dir2_leafn_remove: OK [ 18.603591] Testing event xfs_dir2_leafn_add: OK [ 18.612447] Testing event xfs_da_path_shift: OK [ 18.620662] Testing event xfs_da_fixhashpath: OK [ 18.628465] Testing event xfs_da_shrink_inode: OK [ 18.635894] Testing event xfs_da_grow_inode: OK [ 18.644850] Testing event xfs_da_swap_lastblock: OK [ 18.651840] Testing event xfs_da_node_toosmall: OK [ 18.661651] Testing event xfs_da_node_unbalance: OK [ 18.673767] Testing event xfs_da_node_rebalance: OK [ 18.684635] Testing event xfs_da_node_remove: OK [ 18.693745] Testing event xfs_da_node_split: OK [ 18.705309] Testing event xfs_da_node_create: OK [ 18.716179] Testing event xfs_da_node_add: OK [ 18.725296] Testing event xfs_da_root_join: OK [ 18.736602] Testing event xfs_da_root_split: OK [ 18.744823] Testing event xfs_da_unlink_forward: OK [ 18.753721] Testing event xfs_da_unlink_back: OK [ 18.764507] Testing event xfs_da_link_after: OK [ 18.778003] Testing event xfs_da_link_before: OK [ 18.789599] Testing event xfs_da_join: OK [ 18.801892] Testing event xfs_da_split: OK [ 18.813903] Testing event xfs_attr_rmtval_remove: OK [ 18.824868] Testing event xfs_attr_rmtval_set: OK [ 18.837066] Testing event xfs_attr_rmtval_get: OK [ 18.848969] Testing event xfs_attr_refillstate: OK [ 18.860917] Testing event xfs_attr_fillstate: OK [ 18.873765] Testing event xfs_attr_node_removename: OK [ 18.884937] Testing event xfs_attr_node_replace: OK [ 18.896475] Testing event xfs_attr_node_lookup: OK [ 18.908793] Testing event xfs_attr_node_get: OK [ 18.920243] Testing event xfs_attr_node_addname: OK [ 18.933753] Testing event xfs_attr_leaf_toosmall: OK [ 18.947907] Testing event xfs_attr_leaf_unbalance: OK [ 18.955443] Testing event xfs_attr_leaf_rebalance: OK [ 18.963461] Testing event xfs_attr_leaf_to_node: OK [ 18.971899] Testing event xfs_attr_leaf_to_sf: OK [ 18.980482] Testing event xfs_attr_leaf_flipflags: OK [ 18.988191] Testing event xfs_attr_leaf_setflag: OK [ 18.999072] Testing event xfs_attr_leaf_clearflag: OK [ 19.008505] Testing event xfs_attr_leaf_split_after: OK [ 19.017021] Testing event xfs_attr_leaf_split_before: OK [ 19.028043] Testing event xfs_attr_leaf_split: OK [ 19.035467] Testing event xfs_attr_leaf_removename: OK [ 19.043451] Testing event xfs_attr_leaf_remove: OK [ 19.054331] Testing event xfs_attr_leaf_replace: OK [ 19.064011] Testing event xfs_attr_leaf_lookup: OK [ 19.072296] Testing event xfs_attr_leaf_get: OK [ 19.080951] Testing event xfs_attr_leaf_compact: OK [ 19.088160] Testing event xfs_attr_leaf_create: OK [ 19.096573] Testing event xfs_attr_leaf_addname: OK [ 19.104722] Testing event xfs_attr_leaf_add_work: OK [ 19.112853] Testing event xfs_attr_leaf_add_new: OK [ 19.125374] Testing event xfs_attr_leaf_add_old: OK [ 19.136628] Testing event xfs_attr_leaf_add: OK [ 19.144540] Testing event xfs_attr_sf_to_leaf: OK [ 19.153054] Testing event xfs_attr_sf_removename: OK [ 19.163950] Testing event xfs_attr_sf_remove: OK [ 19.172771] Testing event xfs_attr_sf_lookup: OK [ 19.183933] Testing event xfs_attr_sf_create: OK [ 19.197645] Testing event xfs_attr_sf_addname: OK [ 19.209258] Testing event xfs_attr_sf_add: OK [ 19.220411] Testing event xfs_dir2_node_to_leaf: OK [ 19.228465] Testing event xfs_dir2_node_removename: OK [ 19.237280] Testing event xfs_dir2_node_replace: OK [ 19.248851] Testing event xfs_dir2_node_lookup: OK [ 19.257310] Testing event xfs_dir2_node_addname: OK [ 19.268562] Testing event xfs_dir2_leaf_to_node: OK [ 19.280267] Testing event xfs_dir2_leaf_to_block: OK [ 19.288204] Testing event xfs_dir2_leaf_removename: OK [ 19.295939] Testing event xfs_dir2_leaf_replace: OK [ 19.303979] Testing event xfs_dir2_leaf_lookup: OK [ 19.313866] Testing event xfs_dir2_leaf_addname: OK [ 19.325720] Testing event xfs_dir2_block_to_leaf: OK [ 19.336443] Testing event xfs_dir2_block_to_sf: OK [ 19.349537] Testing event xfs_dir2_block_removename: OK [ 19.360136] Testing event xfs_dir2_block_replace: OK [ 19.373850] Testing event xfs_dir2_block_lookup: OK [ 19.387233] Testing event xfs_dir2_block_addname: OK [ 19.396672] Testing event xfs_dir2_sf_to_block: OK [ 19.404965] Testing event xfs_dir2_sf_toino8: OK [ 19.417469] Testing event xfs_dir2_sf_toino4: OK [ 19.430926] Testing event xfs_dir2_sf_removename: OK [ 19.440795] Testing event xfs_dir2_sf_replace: OK [ 19.453315] Testing event xfs_dir2_sf_lookup: OK [ 19.464821] Testing event xfs_dir2_sf_create: OK [ 19.477273] Testing event xfs_dir2_sf_addname: OK [ 19.489554] Testing event xfs_alloc_vextent_allfailed: OK [ 19.500324] Testing event xfs_alloc_vextent_loopfailed: OK [ 19.512432] Testing event xfs_alloc_vextent_noagbp: OK [ 19.520161] Testing event xfs_alloc_vextent_nofix: OK [ 19.533025] Testing event xfs_alloc_vextent_badargs: OK [ 19.544651] Testing event xfs_alloc_small_error: OK [ 19.555743] Testing event xfs_alloc_small_done: OK [ 19.564461] Testing event xfs_alloc_small_notenough: OK [ 19.572472] Testing event xfs_alloc_small_freelist: OK [ 19.584001] Testing event xfs_alloc_size_busy: OK [ 19.593273] Testing event xfs_alloc_size_error: OK [ 19.604827] Testing event xfs_alloc_size_done: OK [ 19.616968] Testing event xfs_alloc_size_nominleft: OK [ 19.628813] Testing event xfs_alloc_size_noentry: OK [ 19.642536] Testing event xfs_alloc_size_neither: OK [ 19.652394] Testing event xfs_alloc_near_busy: OK [ 19.665119] Testing event xfs_alloc_near_noentry: OK [ 19.676441] Testing event xfs_alloc_near_error: OK [ 19.688801] Testing event xfs_alloc_near_lesser: OK [ 19.700990] Testing event xfs_alloc_near_greater: OK [ 19.712987] Testing event xfs_alloc_near_first: OK [ 19.724977] Testing event xfs_alloc_near_nominleft: OK [ 19.736934] Testing event xfs_alloc_exact_error: OK [ 19.748438] Testing event xfs_alloc_exact_notfound: OK [ 19.760508] Testing event xfs_alloc_exact_done: OK [ 19.772991] Testing event xfs_free_extent: OK [ 19.784656] Testing event xfs_agf: OK [ 19.796397] Testing event xfs_trans_commit_lsn: OK [ 19.808971] Testing event xfs_extent_busy_trim: OK [ 19.821316] Testing event xfs_extent_busy_clear: OK [ 19.834953] Testing event xfs_extent_busy_reuse: OK [ 19.849268] Testing event xfs_extent_busy_force: OK [ 19.861226] Testing event xfs_extent_busy_enomem: OK [ 19.875885] Testing event xfs_extent_busy: OK [ 19.888694] Testing event xfs_bunmap: OK [ 19.900629] Testing event xfs_pagecache_inval: OK [ 19.912260] Testing event xfs_itruncate_extents_end: OK [ 19.921406] Testing event xfs_itruncate_extents_start: OK [ 19.932968] Testing event xfs_setfilesize: OK [ 19.945376] Testing event xfs_get_blocks_notfound: OK [ 19.957007] Testing event xfs_unwritten_convert: OK [ 19.968597] Testing event xfs_delalloc_enospc: OK [ 19.980900] Testing event xfs_get_blocks_alloc: OK [ 19.992885] Testing event xfs_get_blocks_found: OK [ 20.004657] Testing event xfs_map_blocks_alloc: OK [ 20.016850] Testing event xfs_map_blocks_found: OK [ 20.028704] Testing event xfs_invalidatepage: OK [ 20.042534] Testing event xfs_releasepage: OK [ 20.052667] Testing event xfs_writepage: OK [ 20.066308] Testing event xfs_file_splice_write: OK [ 20.076853] Testing event xfs_file_splice_read: OK [ 20.088538] Testing event xfs_file_direct_write: OK [ 20.100774] Testing event xfs_file_buffered_write: OK [ 20.112918] Testing event xfs_file_read: OK [ 20.125496] Testing event xfs_ail_flushing: OK [ 20.136818] Testing event xfs_ail_locked: OK [ 20.149093] Testing event xfs_ail_pinned: OK [ 20.161024] Testing event xfs_ail_push: OK [ 20.173160] Testing event xfs_log_force: OK [ 20.186172] Testing event xfs_log_ungrant_sub: OK [ 20.196810] Testing event xfs_log_ungrant_exit: OK [ 20.212900] Testing event xfs_log_ungrant_enter: OK [ 20.225402] Testing event xfs_log_regrant_reserve_sub: OK [ 20.236914] Testing event xfs_log_regrant_reserve_exit: OK [ 20.249078] Testing event xfs_log_regrant_reserve_enter: OK [ 20.261339] Testing event xfs_log_regrant_exit: OK [ 20.272862] Testing event xfs_log_regrant: OK [ 20.287053] Testing event xfs_log_reserve_exit: OK [ 20.296684] Testing event xfs_log_reserve: OK [ 20.309253] Testing event xfs_log_grant_wake_up: OK [ 20.321411] Testing event xfs_log_grant_wake: OK [ 20.336065] Testing event xfs_log_grant_sleep: OK [ 20.344748] Testing event xfs_log_umount_write: OK [ 20.357878] Testing event xfs_log_done_perm: OK [ 20.368501] Testing event xfs_log_done_nonperm: OK [ 20.376680] Testing event xfs_dqflush_done: OK [ 20.384753] Testing event xfs_dqflush_force: OK [ 20.393757] Testing event xfs_dqflush: OK [ 20.413233] Testing event xfs_dqrele: OK [ 20.428377] Testing event xfs_dqput_free: OK [ 20.440875] Testing event xfs_dqput_wait: OK [ 20.452827] Testing event xfs_dqput: OK [ 20.465219] Testing event xfs_dqget_dup: OK [ 20.476901] Testing event xfs_dqget_freeing: OK [ 20.489012] Testing event xfs_dqget_miss: OK [ 20.503553] Testing event xfs_dqget_hit: OK [ 20.528662] Testing event xfs_dqread_fail: OK [ 20.541557] Testing event xfs_dqread: OK [ 20.554489] Testing event xfs_dqtobp_read: OK [ 20.573935] Testing event xfs_dqalloc: OK [ 20.584551] Testing event xfs_dqattach_get: OK [ 20.597343] Testing event xfs_dqattach_found: OK [ 20.609258] Testing event xfs_dqreclaim_done: OK [ 20.622695] Testing event xfs_dqreclaim_busy: OK [ 20.632991] Testing event xfs_dqreclaim_dirty: OK [ 20.647622] Testing event xfs_dqreclaim_want: OK [ 20.665114] Testing event xfs_dqadjust: OK [ 20.685182] Testing event xfs_rename: OK [ 20.697073] Testing event xfs_symlink: OK [ 20.710943] Testing event xfs_create: OK [ 20.727494] Testing event xfs_lookup: OK [ 20.736417] Testing event xfs_link: OK [ 20.749393] Testing event xfs_remove: OK [ 20.761402] Testing event xfs_inode_unpin_nowait: OK [ 20.775763] Testing event xfs_inode_unpin: OK [ 20.786146] Testing event xfs_inode_pin: OK [ 20.796120] Testing event xfs_irele: OK [ 20.807447] Testing event xfs_ihold: OK [ 20.824106] Testing event xfs_iomap_prealloc_size: OK [ 20.832104] Testing event xfs_inode_free_eofblocks_invalid: OK [ 20.840107] Testing event xfs_inode_clear_eofblocks_tag: OK [ 20.849481] Testing event xfs_inode_set_eofblocks_tag: OK [ 20.861161] Testing event xfs_dquot_dqdetach: OK [ 20.873572] Testing event xfs_dquot_dqalloc: OK [ 20.885735] Testing event xfs_update_time: OK [ 20.896829] Testing event xfs_evict_inode: OK [ 20.906006] Testing event xfs_destroy_inode: OK [ 20.920956] Testing event xfs_file_fsync: OK [ 20.936875] Testing event xfs_dir_fsync: OK [ 20.950076] Testing event xfs_ioctl_setattr: OK [ 20.969622] Testing event xfs_file_compat_ioctl: OK [ 20.984808] Testing event xfs_file_ioctl: OK [ 20.992893] Testing event xfs_vm_bmap: OK [ 21.005239] Testing event xfs_readdir: OK [ 21.017118] Testing event xfs_free_file_space: OK [ 21.032803] Testing event xfs_alloc_file_space: OK [ 21.059756] Testing event xfs_readlink: OK [ 21.073247] Testing event xfs_setattr: OK [ 21.090646] Testing event xfs_getattr: OK [ 21.106284] Testing event xfs_iget_miss: OK [ 21.125457] Testing event xfs_iget_hit: OK [ 21.136808] Testing event xfs_iget_reclaim_fail: OK [ 21.148852] Testing event xfs_iget_reclaim: OK [ 21.160846] Testing event xfs_iget_skip: OK [ 21.172692] Testing event xfs_iunlock: OK [ 21.186742] Testing event xfs_ilock_demote: OK [ 21.202466] Testing event xfs_ilock_nowait: OK [ 21.216280] Testing event xfs_ilock: OK [ 21.231542] Testing event xfs_trans_binval: OK [ 21.243952] Testing event xfs_trans_bhold_release: OK [ 21.265118] Testing event xfs_trans_bhold: OK [ 21.284972] Testing event xfs_trans_bjoin: OK [ 21.296530] Testing event xfs_trans_brelse: OK [ 21.308652] Testing event xfs_trans_log_buf: OK [ 21.325505] Testing event xfs_trans_read_buf_recur: OK [ 21.340542] Testing event xfs_trans_read_buf: OK [ 21.355107] Testing event xfs_trans_getsb_recur: OK [ 21.379967] Testing event xfs_trans_getsb: OK [ 21.393951] Testing event xfs_trans_get_buf_recur: OK [ 21.408729] Testing event xfs_trans_get_buf: OK [ 21.425917] Testing event xfs_buf_item_push: OK [ 21.440842] Testing event xfs_buf_item_committed: OK [ 21.460685] Testing event xfs_buf_item_unlock_stale: OK [ 21.479819] Testing event xfs_buf_item_unlock: OK [ 21.495293] Testing event xfs_buf_item_unpin_stale: OK [ 21.516546] Testing event xfs_buf_item_unpin: OK [ 21.543359] Testing event xfs_buf_item_pin: OK [ 21.555018] Testing event xfs_buf_item_format_stale: OK [ 21.599643] Testing event xfs_buf_item_format: OK [ 21.635111] Testing event xfs_buf_item_size_stale: OK [ 21.644406] Testing event xfs_buf_item_size: OK [ 21.652423] Testing event xfs_buf_ioerror: OK [ 21.660387] Testing event xfs_buf_read: OK [ 21.668513] Testing event xfs_buf_get: OK [ 21.676520] Testing event xfs_buf_find: OK [ 21.684314] Testing event xfs_inode_item_push: OK [ 21.692350] Testing event xfs_reset_dqcounts: OK [ 21.704365] Testing event xfs_da_btree_corrupt: OK [ 21.716910] Testing event xfs_btree_corrupt: OK [ 21.732639] Testing event xfs_trans_read_buf_shut: OK [ 21.745894] Testing event xfs_trans_read_buf_io: OK [ 21.759130] Testing event xfs_buf_wait_buftarg: OK [ 21.769064] Testing event xfs_buf_error_relse: OK [ 21.781303] Testing event xfs_buf_item_iodone_async: OK [ 21.793037] Testing event xfs_buf_item_iodone: OK [ 21.804666] Testing event xfs_buf_item_relse: OK [ 21.815428] Testing event xfs_bdstrat_shut: OK [ 21.827770] Testing event xfs_buf_get_uncached: OK [ 21.840823] Testing event xfs_buf_delwri_split: OK [ 21.853317] Testing event xfs_buf_delwri_queued: OK [ 21.864449] Testing event xfs_buf_delwri_queue: OK [ 21.881647] Testing event xfs_buf_iowait_done: OK [ 21.893406] Testing event xfs_buf_iowait: OK [ 21.907897] Testing event xfs_buf_unlock: OK [ 21.925404] Testing event xfs_buf_trylock: OK [ 21.936802] Testing event xfs_buf_lock_done: OK [ 21.948693] Testing event xfs_buf_lock: OK [ 21.960908] Testing event xfs_buf_bawrite: OK [ 21.972675] Testing event xfs_buf_iorequest: OK [ 21.984902] Testing event xfs_buf_iodone: OK [ 21.995974] Testing event xfs_buf_rele: OK [ 22.009286] Testing event xfs_buf_hold: OK [ 22.029698] Testing event xfs_buf_free: OK [ 22.040851] Testing event xfs_buf_init: OK [ 22.052433] Testing event xfs_extlist: OK [ 22.067418] Testing event xfs_bmap_post_update: OK [ 22.083608] Testing event xfs_bmap_pre_update: OK [ 22.101152] Testing event xfs_iext_remove: OK [ 22.112436] Testing event xfs_iext_insert: OK [ 22.121852] Testing event xfs_attr_list_node_descend: OK [ 22.134499] Testing event xfs_perag_clear_eofblocks: OK [ 22.151634] Testing event xfs_perag_set_eofblocks: OK [ 22.165533] Testing event xfs_perag_clear_reclaim: OK [ 22.178018] Testing event xfs_perag_set_reclaim: OK [ 22.193012] Testing event xfs_perag_put: OK [ 22.204660] Testing event xfs_perag_get_tag: OK [ 22.218292] Testing event xfs_perag_get: OK [ 22.232700] Testing event xfs_attr_node_list: OK [ 22.242107] Testing event xfs_attr_leaf_list: OK [ 22.255589] Testing event xfs_attr_list_notfound: OK [ 22.266834] Testing event xfs_attr_list_wrong_blk: OK [ 22.276957] Testing event xfs_attr_list_add: OK [ 22.288820] Testing event xfs_attr_list_full: OK [ 22.304229] Testing event xfs_attr_list_leaf_end: OK [ 22.317757] Testing event xfs_attr_list_leaf: OK [ 22.333225] Testing event xfs_attr_list_sf_all: OK [ 22.344541] Testing event xfs_attr_list_sf: OK [ 22.352717] Testing event free_extent_state: OK [ 22.360575] Testing event alloc_extent_state: OK [ 22.368778] Testing event btrfs_setup_cluster: OK [ 22.381368] Testing event btrfs_failed_cluster_setup: OK [ 22.392480] Testing event btrfs_find_cluster: OK [ 22.400779] Testing event btrfs_reserve_extent_cluster: OK [ 22.412745] Testing event btrfs_reserve_extent: OK [ 22.420472] Testing event find_free_extent: OK [ 22.428694] Testing event btrfs_reserved_extent_free: OK [ 22.458341] Testing event btrfs_reserved_extent_alloc: OK [ 22.468479] Testing event btrfs_space_reservation: OK [ 22.481019] Testing event btrfs_cow_block: OK [ 22.495135] Testing event btrfs_chunk_free: OK [ 22.507593] Testing event btrfs_chunk_alloc: OK [ 22.525995] Testing event btrfs_delayed_ref_head: OK [ 22.537837] Testing event btrfs_delayed_data_ref: OK [ 22.548588] Testing event btrfs_delayed_tree_ref: OK [ 22.557987] Testing event btrfs_sync_fs: OK [ 22.569723] Testing event btrfs_sync_file: OK [ 22.581128] Testing event btrfs_writepage_end_io_hook: OK [ 22.593741] Testing event __extent_writepage: OK [ 22.606787] Testing event btrfs_ordered_extent_put: OK [ 22.619943] Testing event btrfs_ordered_extent_start: OK [ 22.642524] Testing event btrfs_ordered_extent_remove: OK [ 22.659102] Testing event btrfs_ordered_extent_add: OK [ 22.670484] Testing event btrfs_get_extent: OK [ 22.684712] Testing event btrfs_inode_evict: OK [ 22.701328] Testing event btrfs_inode_request: OK [ 22.713060] Testing event btrfs_inode_new: OK [ 22.725217] Testing event btrfs_transaction_commit: OK [ 22.737241] Testing event block_rq_remap: OK [ 22.749225] Testing event block_bio_remap: OK [ 22.761123] Testing event block_split: OK [ 22.773270] Testing event block_unplug: OK [ 22.785003] Testing event block_plug: OK [ 22.797019] Testing event block_sleeprq: OK [ 22.808906] Testing event block_getrq: OK [ 22.821216] Testing event block_bio_queue: OK [ 22.832693] Testing event block_bio_frontmerge: OK [ 22.845013] Testing event block_bio_backmerge: OK [ 22.857090] Testing event block_bio_complete: OK [ 22.870057] Testing event block_bio_bounce: OK [ 22.880738] Testing event block_rq_issue: OK [ 22.892931] Testing event block_rq_insert: OK [ 22.904767] Testing event block_rq_complete: OK [ 22.916839] Testing event block_rq_requeue: OK [ 22.929114] Testing event block_rq_abort: OK [ 22.941160] Testing event block_dirty_buffer: OK [ 22.952886] Testing event block_touch_buffer: OK [ 22.964876] Testing event regulator_set_voltage_complete: OK [ 22.977095] Testing event regulator_set_voltage: OK [ 22.992031] Testing event regulator_disable_complete: OK [ 23.005125] Testing event regulator_disable: OK [ 23.016532] Testing event regulator_enable_complete: OK [ 23.024672] Testing event regulator_enable_delay: OK [ 23.032498] Testing event regulator_enable: OK [ 23.049821] Testing event extract_entropy_user: OK [ 23.060521] Testing event extract_entropy: OK [ 23.068951] Testing event get_random_bytes: OK [ 23.081091] Testing event credit_entropy_bits: OK [ 23.096755] Testing event mix_pool_bytes_nolock: OK [ 23.116745] Testing event mix_pool_bytes: OK [ 23.129489] Testing event regmap_async_complete_done: OK [ 23.142069] Testing event regmap_async_complete_start: OK [ 23.152889] Testing event regmap_async_io_complete: OK [ 23.162350] Testing event regmap_async_write_start: OK [ 23.176558] Testing event regmap_cache_bypass: OK [ 23.188944] Testing event regmap_cache_only: OK [ 23.205221] Testing event regcache_sync: OK [ 23.221883] Testing event regmap_hw_write_done: OK [ 23.236287] Testing event regmap_hw_write_start: OK [ 23.249004] Testing event regmap_hw_read_done: OK [ 23.262182] Testing event regmap_hw_read_start: OK [ 23.273208] Testing event regmap_reg_read_cache: OK [ 23.285935] Testing event regmap_reg_read: OK [ 23.297690] Testing event regmap_reg_write: OK [ 23.310054] Testing event scsi_eh_wakeup: OK [ 23.322073] Testing event scsi_dispatch_cmd_timeout: OK [ 23.334152] Testing event scsi_dispatch_cmd_done: OK [ 23.345937] Testing event scsi_dispatch_cmd_error: OK [ 23.358124] Testing event scsi_dispatch_cmd_start: OK [ 23.370198] Testing event binder_return: OK [ 23.381918] Testing event binder_command: OK [ 23.393646] Testing event binder_update_page_range: OK [ 23.405920] Testing event binder_transaction_failed_buffer_release: OK [ 23.418101] Testing event binder_transaction_buffer_release: OK [ 23.430301] Testing event binder_transaction_alloc_buf: OK [ 23.442019] Testing event binder_transaction_fd: OK [ 23.454012] Testing event binder_transaction_ref_to_ref: OK [ 23.471470] Testing event binder_transaction_ref_to_node: OK [ 23.480929] Testing event binder_transaction_node_to_ref: OK [ 23.494138] Testing event binder_transaction_received: OK [ 23.506068] Testing event binder_transaction: OK [ 23.518008] Testing event binder_wait_for_work: OK [ 23.529981] Testing event binder_read_done: OK [ 23.542003] Testing event binder_write_done: OK [ 23.554000] Testing event binder_ioctl_done: OK [ 23.566008] Testing event binder_unlock: OK [ 23.578039] Testing event binder_locked: OK [ 23.590137] Testing event binder_lock: OK [ 23.602301] Testing event binder_ioctl: OK [ 23.614055] Testing event sync_pt: OK [ 23.625915] Testing event sync_wait: OK [ 23.637946] Testing event sync_timeline: OK [ 23.650041] Testing event udp_fail_queue_rcv_skb: OK [ 23.662094] Testing event sock_exceed_buf_limit: OK [ 23.674144] Testing event sock_rcvqueue_full: OK [ 23.686169] Testing event napi_poll: OK [ 23.698150] Testing event netif_rx: OK [ 23.709926] Testing event netif_receive_skb: OK [ 23.722100] Testing event net_dev_queue: OK [ 23.733961] Testing event net_dev_xmit: OK [ 23.746431] Testing event skb_copy_datagram_iovec: OK [ 23.758199] Testing event consume_skb: OK [ 23.770181] Testing event kfree_skb: OK [ 23.782332] Running tests on trace event systems: [ 23.784315] Testing event system skb: OK [ 23.799269] Testing event system net: OK [ 23.811869] Testing event system napi: OK [ 23.822214] Testing event system sock: OK [ 23.834155] Testing event system udp: OK [ 23.846329] Testing event system sync: OK [ 23.859590] Testing event system binder: OK [ 23.887694] Testing event system scsi: OK [ 23.903942] Testing event system regmap: OK [ 23.928546] Testing event system random: OK [ 23.944434] Testing event system regulator: OK [ 23.960905] Testing event system block: OK [ 23.990197] Testing event system btrfs: OK [ 24.031830] Testing event system xfs: OK [ 24.673550] Testing event system jbd: OK [ 24.712553] Testing event system ext3: OK [ 24.832980] Testing event system writeback: OK [ 24.916634] Testing event system migrate: OK [ 24.933350] Testing event system compaction: OK [ 24.971655] Testing event system kmem: OK [ 25.019258] Testing event system vmscan: OK [ 25.066754] Testing event system oom: OK [ 25.077069] Testing event system filemap: OK [ 25.090101] Testing event system rpm: OK [ 25.123889] Testing event system power: OK [ 25.160994] Testing event system test: OK [ 25.183732] Testing event system module: OK [ 25.205683] Testing event system lock: OK [ 25.227298] Testing event system sched: OK [ 25.254043] Testing event system rcu: OK [ 25.282110] Testing event system workqueue: OK [ 25.301970] Testing event system signal: OK [ 25.314522] Testing event system timer: OK [ 25.334386] Testing event system irq: OK [ 25.352898] Testing event system printk: OK [ 25.362415] Testing event system task: OK [ 25.374296] Testing event system raw_syscalls: OK [ 25.385548] Testing event system vsyscall: OK [ 25.397960] Testing event system syscalls: OK [ 25.424144] Running tests on all trace events: [ 25.425835] Testing all events: OK [ 26.531372] Testing ftrace filter: OK [ 26.534705] Testing kprobe tracing: [ 26.537068] Could not insert probe at kprobe_trace_selftest_target+0: -22 [ 26.540483] ------------[ cut here ]------------ [ 26.541996] WARNING: at kernel/trace/trace_kprobe.c:1393 kprobe_trace_self_tests_init+0x6e/0x84d() [ 26.545093] Modules linked in: [ 26.546418] CPU: 0 PID: 1 Comm: swapper Not tainted 3.10.0-rc3-00005-g003002e #9 [ 26.548765] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 26.550364] 0000000000000009 ffff880013479e68 ffffffff81f16c80 ffff880013479ea0 [ 26.552703] ffffffff810a97e8 ffffffff8322bb14 0000000000000007 0000000000000000 [ 26.555109] 0000000000000000 0000000000000000 ffff880013479eb0 ffffffff810a984a [ 26.558146] Call Trace: [ 26.559125] [] dump_stack+0x27/0x30 [ 26.560708] [] warn_slowpath_common+0xa8/0xe0 [ 26.562520] [] ? init_kprobe_trace+0xe8/0xe8 [ 26.564181] [] warn_slowpath_null+0x2a/0x40 [ 26.565343] [] kprobe_trace_self_tests_init+0x6e/0x84d [ 26.567150] [] ? init_kprobe_trace+0xe8/0xe8 [ 26.568947] [] do_one_initcall+0x1c2/0x2b0 [ 26.570496] [] kernel_init_freeable+0x238/0x36f [ 26.572172] [] ? do_early_param+0x111/0x111 [ 26.573724] [] ? rest_init+0x140/0x140 [ 26.575201] [] kernel_init+0x16/0x2b0 [ 26.576740] [] ret_from_fork+0x7a/0xb0 [ 26.578215] [] ? rest_init+0x140/0x140 [ 26.579717] ---[ end trace c89373f17ce6ce32 ]--- [ 26.581040] error on probing function entry. [ 26.587813] Could not insert probe at kprobe_trace_selftest_target+0: -22 [ 26.589792] ------------[ cut here ]------------ [ 26.591123] WARNING: at kernel/trace/trace_kprobe.c:1414 kprobe_trace_self_tests_init+0xeb/0x84d() [ 26.593986] Modules linked in: [ 26.595166] CPU: 0 PID: 1 Comm: swapper Tainted: G W 3.10.0-rc3-00005-g003002e #9 [ 26.597610] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 26.599140] 0000000000000009 ffff880013479e68 ffffffff81f16c80 ffff880013479ea0 [ 26.601902] ffffffff810a97e8 0000000000000001 0000000000000007 0000000000000000 [ 26.604630] 0000000000000000 0000000000000000 ffff880013479eb0 ffffffff810a984a [ 26.607376] Call Trace: [ 26.608346] [] dump_stack+0x27/0x30 [ 26.609776] [] warn_slowpath_common+0xa8/0xe0 [ 26.611376] [] warn_slowpath_null+0x2a/0x40 [ 26.612928] [] kprobe_trace_self_tests_init+0xeb/0x84d [ 26.614654] [] ? init_kprobe_trace+0xe8/0xe8 [ 26.616283] [] do_one_initcall+0x1c2/0x2b0 [ 26.617806] [] kernel_init_freeable+0x238/0x36f [ 26.619444] [] ? do_early_param+0x111/0x111 [ 26.620986] [] ? rest_init+0x140/0x140 [ 26.622470] [] kernel_init+0x16/0x2b0 [ 26.623962] [] ret_from_fork+0x7a/0xb0 [ 26.625381] [] ? rest_init+0x140/0x140 [ 26.626870] ---[ end trace c89373f17ce6ce33 ]--- [ 26.628221] error on probing function return. [ 26.630657] NG: Some tests are failed. Please check them. [ 26.634611] Key type encrypted registered [ 26.636094] cryptomgr_probe (1441) used greatest stack depth: 5752 bytes left [ 26.642393] Magic number: 10:344:225 [ 26.643709] port2: hash matches [ 26.644803] port2: hash matches [ 26.645943] tty ttyu9: hash matches [ 26.647083] tty ttyrc: hash matches [ 26.649075] hd: no drives specified - use hd=cyl,head,sectors on kernel command line [ 26.652581] debug: unmapping init [mem 0xffffffff831fa000-0xffffffff8335efff] [ 26.670126] mount (1452) used greatest stack depth: 5480 bytes left [ 26.687885] S00fbsetup (1454) used greatest stack depth: 5208 bytes left [ 26.774989] udev[1468]: starting version 164 [ 27.013254] power_supply test_ac: uevent [ 27.014500] power_supply test_ac: POWER_SUPPLY_NAME=test_ac [ 27.026839] power_supply test_ac: prop ONLINE=1 [ 27.028343] power_supply test_battery: uevent [ 27.029567] power_supply test_battery: POWER_SUPPLY_NAME=test_battery [ 27.031219] power_supply test_battery: prop STATUS=Discharging [ 27.035315] power_supply test_battery: prop CHARGE_TYPE=Fast [ 27.036855] power_supply test_battery: prop HEALTH=Good [ 27.038240] power_supply test_battery: prop PRESENT=1 [ 27.043673] power_supply test_battery: prop TECHNOLOGY=Li-ion [ 27.045173] power_supply test_battery: prop CHARGE_FULL_DESIGN=100 [ 27.046764] power_supply test_battery: prop CHARGE_FULL=100 [ 27.057996] power_supply test_battery: prop CHARGE_NOW=50 [ 27.059614] power_supply test_battery: prop CAPACITY=50 [ 27.061047] power_supply test_battery: prop CAPACITY_LEVEL=Normal [ 27.062637] power_supply test_battery: prop TIME_TO_EMPTY_AVG=3600 [ 27.072184] power_supply test_battery: prop TIME_TO_FULL_NOW=3600 [ 27.073810] power_supply test_battery: prop MODEL_NAME=Test battery [ 27.079417] power_supply test_battery: prop MANUFACTURER=Linux [ 27.080993] power_supply test_battery: prop SERIAL_NUMBER=3.10.0-rc3-00005-g003002e [ 27.087459] power_supply test_battery: prop TEMP=26 [ 27.088869] power_supply test_battery: prop VOLTAGE_NOW=3300 [ 27.090544] power_supply test_usb: uevent [ 27.091811] power_supply test_usb: POWER_SUPPLY_NAME=test_usb [ 27.099317] power_supply test_usb: prop ONLINE=1 [ 27.507786] power_supply test_ac: uevent [ 27.509052] power_supply test_ac: POWER_SUPPLY_NAME=test_ac [ 27.511088] power_supply test_ac: prop ONLINE=1 [ 27.560276] power_supply test_ac: uevent [ 27.561532] power_supply test_ac: POWER_SUPPLY_NAME=test_ac [ 27.573952] power_supply test_battery: uevent [ 27.575156] power_supply test_battery: POWER_SUPPLY_NAME=test_battery [ 27.587241] power_supply test_battery: prop STATUS=Discharging [ 27.602348] power_supply test_battery: prop CHARGE_TYPE=Fast [ 27.603809] power_supply test_battery: prop HEALTH=Good [ 27.605817] power_supply test_battery: prop PRESENT=1 [ 27.607110] power_supply test_battery: prop TECHNOLOGY=Li-ion [ 27.632069] power_supply test_ac: prop ONLINE=1 [ 27.654383] power_supply test_battery: prop CHARGE_FULL_DESIGN=100 [ 27.666515] power_supply test_battery: prop CHARGE_FULL=100 [ 27.667937] power_supply test_battery: prop CHARGE_NOW=50 [ 27.669316] power_supply test_battery: prop CAPACITY=50 [ 27.670614] power_supply test_battery: prop CAPACITY_LEVEL=Normal [ 27.696950] power_supply test_battery: prop TIME_TO_EMPTY_AVG=3600 [ 27.698472] power_supply test_battery: prop TIME_TO_FULL_NOW=3600 [ 27.717313] power_supply test_battery: prop MODEL_NAME=Test battery [ 27.718906] power_supply test_battery: prop MANUFACTURER=Linux [ 27.725577] power_supply test_battery: prop SERIAL_NUMBER=3.10.0-rc3-00005-g003002e [ 27.736040] power_supply test_battery: prop TEMP=26 [ 27.737615] power_supply test_battery: prop VOLTAGE_NOW=3300 [ 27.741070] power_supply test_battery: uevent [ 27.742525] power_supply test_battery: POWER_SUPPLY_NAME=test_battery [ 27.744740] power_supply test_battery: prop STATUS=Discharging [ 27.746477] power_supply test_battery: prop CHARGE_TYPE=Fast [ 27.750418] power_supply test_usb: uevent [ 27.751813] power_supply test_usb: POWER_SUPPLY_NAME=test_usb [ 27.753543] power_supply test_usb: prop ONLINE=1 [ 27.755645] power_supply test_usb: uevent [ 27.757039] power_supply test_usb: POWER_SUPPLY_NAME=test_usb [ 27.758760] power_supply test_usb: prop ONLINE=1 [ 27.762750] power_supply test_battery: prop HEALTH=Good [ 27.764433] power_supply test_battery: prop PRESENT=1 [ 27.766012] power_supply test_battery: prop TECHNOLOGY=Li-ion [ 27.795220] power_supply test_battery: prop CHARGE_FULL_DESIGN=100 [ 27.802745] power_supply test_battery: prop CHARGE_FULL=100 [ 27.834691] power_supply test_battery: prop CHARGE_NOW=50 [ 27.854147] power_supply test_battery: prop CAPACITY=50 [ 27.871336] power_supply test_battery: prop CAPACITY_LEVEL=Normal [ 27.873071] power_supply test_battery: prop TIME_TO_EMPTY_AVG=3600 [ 27.874785] power_supply test_battery: prop TIME_TO_FULL_NOW=3600 [ 27.930869] power_supply test_battery: prop MODEL_NAME=Test battery [ 27.957319] power_supply test_battery: prop MANUFACTURER=Linux [ 27.958909] power_supply test_battery: prop SERIAL_NUMBER=3.10.0-rc3-00005-g003002e [ 27.988704] power_supply test_battery: prop TEMP=26 [ 27.990140] power_supply test_battery: prop VOLTAGE_NOW=3300 [ 28.219504] end_request: I/O error, dev fd0, sector 0 [ 28.275450] end_request: I/O error, dev fd0, sector 0 [ 28.315430] end_request: I/O error, dev fd0, sector 0 [ 28.335436] end_request: I/O error, dev fd0, sector 0 [ 28.359462] end_request: I/O error, dev fd0, sector 0 [ 28.379429] end_request: I/O error, dev fd0, sector 0 [ 28.399444] end_request: I/O error, dev fd0, sector 0 [ 28.419436] end_request: I/O error, dev fd0, sector 0 [ 28.439438] end_request: I/O error, dev fd0, sector 0 [ 28.442433] mount (1659) used greatest stack depth: 5096 bytes left Kernel tests: Boot OK! [ 64.843424] rcu-torture: rtc: ffffffff83b8ab70 ver: 4084 tfle: 0 rta: 4084 rtaf: 0 rtf: 4083 rtmbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 9623 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=250) barrier: 0/0:0 [ 64.843424] rcu-torture: Reader Pipe: 2271623 0 0 0 0 0 0 0 0 0 0 [ 64.843424] rcu-torture: Reader Batch: 2271623 0 0 0 0 0 0 0 0 0 0 [ 64.843424] rcu-torture: Free-Block Circulation: 4083 4083 4083 4083 4083 4083 4083 4083 4083 4083 0 [ 98.446026] Unregister pv shared memory for cpu 0 [ 98.449298] Restarting system. [ 98.450025] reboot: machine restart Elapsed time: 105 qemu-system-x86_64 -cpu kvm64 -enable-kvm -kernel /kernel/x86_64-randconfig-ib1-08280643/003002e04ed38618fc37b92ba128f5ca79d39f4f/vmlinuz-3.10.0-rc3-00005-g003002e -append 'hung_task_panic=1 earlyprintk=ttyS0,115200 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 root=/dev/ram0 rw link=/kbuild-tests/run-queue/kvm/x86_64-randconfig-ib1-08280643/next:master:003002e04ed38618fc37b92ba128f5ca79d39f4f:bisect-linux-8/.vmlinuz-003002e04ed38618fc37b92ba128f5ca79d39f4f-20140828101046-11-vp branch=next/master BOOT_IMAGE=/kernel/x86_64-randconfig-ib1-08280643/003002e04ed38618fc37b92ba128f5ca79d39f4f/vmlinuz-3.10.0-rc3-00005-g003002e drbd.minor_count=8' -initrd /kernel-tests/initrd/yocto-minimal-x86_64.cgz -m 320 -smp 1 -net nic,vlan=1,model=e1000 -net user,vlan=1 -boot order=nc -no-reboot -watchdog i6300esb -rtc base=localtime -drive file=/fs/LABEL=KVM/disk0-yocto-vp-24,media=disk,if=virtio -drive file=/fs/LABEL=KVM/disk1-yocto-vp-24,media=disk,if=virtio -drive file=/fs/LABEL=KVM/disk2-yocto-vp-24,media=disk,if=virtio -drive file=/fs/LABEL=KVM/disk3-yocto-vp-24,media=disk,if=virtio -drive file=/fs/LABEL=KVM/disk4-yocto-vp-24,media=disk,if=virtio -drive file=/fs/LABEL=KVM/disk5-yocto-vp-24,media=disk,if=virtio -pidfile /dev/shm/kboot/pid-yocto-vp-24 -serial file:/dev/shm/kboot/serial-yocto-vp-24 -daemonize -display none -monitor null