early console in setup code early console in decompress_kernel KASLR using RDTSC... Decompressing Linux... Parsing ELF... Performing relocations... done. Booting the kernel. [ 0.000000] Initializing cgroup subsys cpuset [ 0.000000] Initializing cgroup subsys cpu [ 0.000000] Linux version 3.16.0-g6aaca9b (kbuild@snb) (gcc version 4.9.1 (Debian 4.9.1-19) ) #80 SMP Fri Jan 23 20:31:23 CST 2015 [ 0.000000] Command line: user=lkp job=/lkp/scheduled/vm-kbuild-yocto-x86_64-22/bisect_boot-1-yocto-minimal-x86_64.cgz-x86_64-randconfig-s1-01211233-6aaca9bab6116a2b392e7a07b5ff209741bc248f-3.yaml ARCH=x86_64 BOOT_IMAGE=/kernel/x86_64-randconfig-s1-01211233/6aaca9bab6116a2b392e7a07b5ff209741bc248f/vmlinuz-3.16.0-g6aaca9b kconfig=x86_64-randconfig-s1-01211233 commit=6aaca9bab6116a2b392e7a07b5ff209741bc248f branch=next/master root=/dev/ram0 max_uptime=3600 RESULT_ROOT=/result/vm-kbuild-yocto-x86_64/boot/1/yocto-minimal-x86_64.cgz/x86_64-randconfig-s1-01211233/6aaca9bab6116a2b392e7a07b5ff209741bc248f/1 ip=::::vm-kbuild-yocto-x86_64-22::dhcp 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 rw 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] 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] Scan for SMP in [mem 0x00000000-0x000003ff] [ 0.000000] Scan for SMP in [mem 0x0009fc00-0x0009ffff] [ 0.000000] Scan for SMP in [mem 0x000f0000-0x000fffff] [ 0.000000] found SMP MP-table at [mem 0x000fdaf0-0x000fdaff] mapped at [ffff8800000fdaf0] [ 0.000000] mpc: fdb00-fdbe8 [ 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 [0x0a982000, 0x0a982fff] PGTABLE [ 0.000000] BRK [0x0a983000, 0x0a983fff] PGTABLE [ 0.000000] BRK [0x0a984000, 0x0a984fff] PGTABLE [ 0.000000] init_memory_mapping: [mem 0x13a00000-0x13bfffff] [ 0.000000] [mem 0x13a00000-0x13bfffff] page 2M [ 0.000000] init_memory_mapping: [mem 0x10000000-0x139fffff] [ 0.000000] [mem 0x10000000-0x139fffff] page 2M [ 0.000000] init_memory_mapping: [mem 0x00100000-0x0fffffff] [ 0.000000] [mem 0x00100000-0x001fffff] page 4k [ 0.000000] [mem 0x00200000-0x0fffffff] page 2M [ 0.000000] init_memory_mapping: [mem 0x13c00000-0x13ffdfff] [ 0.000000] [mem 0x13c00000-0x13dfffff] page 2M [ 0.000000] [mem 0x13e00000-0x13ffdfff] page 4k [ 0.000000] BRK [0x0a985000, 0x0a985fff] PGTABLE [ 0.000000] RAMDISK: [mem 0x13c20000-0x13feffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000FD990 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x0000000013FFE4B0 000034 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x0000000013FFFF80 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x0000000013FFE4F0 0011A9 (v01 BXPC BXDSDT 00000001 INTL 20100528) [ 0.000000] ACPI: FACS 0x0000000013FFFF40 000040 [ 0.000000] ACPI: SSDT 0x0000000013FFF800 000735 (v01 BOCHS BXPCSSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: APIC 0x0000000013FFF6E0 000078 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x0000000013FFF6A0 000038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001) [ 0.000000] ACPI: Local APIC address 0xfee00000 [ 0.000000] mapped APIC to ffffffffff57d000 ( fee00000) [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000013ffdfff] [ 0.000000] Initmem setup node 0 [mem 0x00000000-0x13ffdfff] [ 0.000000] NODE_DATA [mem 0x13bfa000-0x13c1ffff] [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000000] kvm-clock: cpu 0, msr 0:13b7a001, primary cpu clock [ 0.000000] [ffffea0000000000-ffffea00005fffff] PMD -> [ffff880012c00000-ffff8800131fffff] on node 0 [ 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 ffffffffff57d000 ( 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] smpboot: Allowing 1 CPUs, 0 hotplug CPUs [ 0.000000] mapped IOAPIC to ffffffffff57c000 (fec00000) [ 0.000000] nr_irqs_gsi: 40 [ 0.000000] e820: [mem 0x14000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 [ 0.000000] PERCPU: Embedded 26 pages/cpu @ffff880013800000 s82496 r0 d24000 u2097152 [ 0.000000] pcpu-alloc: s82496 r0 d24000 u2097152 alloc=1*2097152 [ 0.000000] pcpu-alloc: [0] 0 [ 0.000000] KVM setup async PF for cpu 0 [ 0.000000] kvm-stealtime: cpu 0, msr 1380cb40 [ 0.000000] Built 1 zonelists in Node order, mobility grouping on. Total pages: 80519 [ 0.000000] Policy zone: DMA32 [ 0.000000] Kernel command line: user=lkp job=/lkp/scheduled/vm-kbuild-yocto-x86_64-22/bisect_boot-1-yocto-minimal-x86_64.cgz-x86_64-randconfig-s1-01211233-6aaca9bab6116a2b392e7a07b5ff209741bc248f-3.yaml ARCH=x86_64 BOOT_IMAGE=/kernel/x86_64-randconfig-s1-01211233/6aaca9bab6116a2b392e7a07b5ff209741bc248f/vmlinuz-3.16.0-g6aaca9b kconfig=x86_64-randconfig-s1-01211233 commit=6aaca9bab6116a2b392e7a07b5ff209741bc248f branch=next/master root=/dev/ram0 max_uptime=3600 RESULT_ROOT=/result/vm-kbuild-yocto-x86_64/boot/1/yocto-minimal-x86_64.cgz/x86_64-randconfig-s1-01211233/6aaca9bab6116a2b392e7a07b5ff209741bc248f/1 ip=::::vm-kbuild-yocto-x86_64-22::dhcp 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 rw drbd.minor_count=8 [ 0.000000] sysrq: sysrq always enabled. [ 0.000000] PID hash table entries: 2048 (order: 2, 16384 bytes) [ 0.000000] xsave: enabled xstate_bv 0x7, cntxt size 0x340 [ 0.000000] Memory: 263528K/327280K available (16799K kernel code, 11283K rwdata, 11052K rodata, 1660K init, 11904K bss, 63752K reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 [ 0.000000] Hierarchical RCU implementation. [ 0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 [ 0.000000] NR_IRQS:524544 nr_irqs:256 16 [ 0.000000] Console: colour VGA+ 80x25 [ 0.000000] console [tty0] enabled [ 0.000000] bootconsole [earlyser0] disabled [ 0.000000] Initializing cgroup subsys cpuset [ 0.000000] Initializing cgroup subsys cpu [ 0.000000] Linux version 3.16.0-g6aaca9b (kbuild@snb) (gcc version 4.9.1 (Debian 4.9.1-19) ) #80 SMP Fri Jan 23 20:31:23 CST 2015 [ 0.000000] Command line: user=lkp job=/lkp/scheduled/vm-kbuild-yocto-x86_64-22/bisect_boot-1-yocto-minimal-x86_64.cgz-x86_64-randconfig-s1-01211233-6aaca9bab6116a2b392e7a07b5ff209741bc248f-3.yaml ARCH=x86_64 BOOT_IMAGE=/kernel/x86_64-randconfig-s1-01211233/6aaca9bab6116a2b392e7a07b5ff209741bc248f/vmlinuz-3.16.0-g6aaca9b kconfig=x86_64-randconfig-s1-01211233 commit=6aaca9bab6116a2b392e7a07b5ff209741bc248f branch=next/master root=/dev/ram0 max_uptime=3600 RESULT_ROOT=/result/vm-kbuild-yocto-x86_64/boot/1/yocto-minimal-x86_64.cgz/x86_64-randconfig-s1-01211233/6aaca9bab6116a2b392e7a07b5ff209741bc248f/1 ip=::::vm-kbuild-yocto-x86_64-22::dhcp 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 rw 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] 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] Scan for SMP in [mem 0x00000000-0x000003ff] [ 0.000000] Scan for SMP in [mem 0x0009fc00-0x0009ffff] [ 0.000000] Scan for SMP in [mem 0x000f0000-0x000fffff] [ 0.000000] found SMP MP-table at [mem 0x000fdaf0-0x000fdaff] mapped at [ffff8800000fdaf0] [ 0.000000] mpc: fdb00-fdbe8 [ 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 [0x0a982000, 0x0a982fff] PGTABLE [ 0.000000] BRK [0x0a983000, 0x0a983fff] PGTABLE [ 0.000000] BRK [0x0a984000, 0x0a984fff] PGTABLE [ 0.000000] init_memory_mapping: [mem 0x13a00000-0x13bfffff] [ 0.000000] [mem 0x13a00000-0x13bfffff] page 2M [ 0.000000] init_memory_mapping: [mem 0x10000000-0x139fffff] [ 0.000000] [mem 0x10000000-0x139fffff] page 2M [ 0.000000] init_memory_mapping: [mem 0x00100000-0x0fffffff] [ 0.000000] [mem 0x00100000-0x001fffff] page 4k [ 0.000000] [mem 0x00200000-0x0fffffff] page 2M [ 0.000000] init_memory_mapping: [mem 0x13c00000-0x13ffdfff] [ 0.000000] [mem 0x13c00000-0x13dfffff] page 2M [ 0.000000] [mem 0x13e00000-0x13ffdfff] page 4k [ 0.000000] BRK [0x0a985000, 0x0a985fff] PGTABLE [ 0.000000] RAMDISK: [mem 0x13c20000-0x13feffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000FD990 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x0000000013FFE4B0 000034 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x0000000013FFFF80 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x0000000013FFE4F0 0011A9 (v01 BXPC BXDSDT 00000001 INTL 20100528) [ 0.000000] ACPI: FACS 0x0000000013FFFF40 000040 [ 0.000000] ACPI: SSDT 0x0000000013FFF800 000735 (v01 BOCHS BXPCSSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: APIC 0x0000000013FFF6E0 000078 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x0000000013FFF6A0 000038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001) [ 0.000000] ACPI: Local APIC address 0xfee00000 [ 0.000000] mapped APIC to ffffffffff57d000 ( fee00000) [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000013ffdfff] [ 0.000000] Initmem setup node 0 [mem 0x00000000-0x13ffdfff] [ 0.000000] NODE_DATA [mem 0x13bfa000-0x13c1ffff] [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000000] kvm-clock: cpu 0, msr 0:13b7a001, primary cpu clock [ 0.000000] [ffffea0000000000-ffffea00005fffff] PMD -> [ffff880012c00000-ffff8800131fffff] on node 0 [ 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 ffffffffff57d000 ( 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] smpboot: Allowing 1 CPUs, 0 hotplug CPUs [ 0.000000] mapped IOAPIC to ffffffffff57c000 (fec00000) [ 0.000000] nr_irqs_gsi: 40 [ 0.000000] e820: [mem 0x14000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 [ 0.000000] PERCPU: Embedded 26 pages/cpu @ffff880013800000 s82496 r0 d24000 u2097152 [ 0.000000] pcpu-alloc: s82496 r0 d24000 u2097152 alloc=1*2097152 [ 0.000000] pcpu-alloc: [0] 0 [ 0.000000] KVM setup async PF for cpu 0 [ 0.000000] kvm-stealtime: cpu 0, msr 1380cb40 [ 0.000000] Built 1 zonelists in Node order, mobility grouping on. Total pages: 80519 [ 0.000000] Policy zone: DMA32 [ 0.000000] Kernel command line: user=lkp job=/lkp/scheduled/vm-kbuild-yocto-x86_64-22/bisect_boot-1-yocto-minimal-x86_64.cgz-x86_64-randconfig-s1-01211233-6aaca9bab6116a2b392e7a07b5ff209741bc248f-3.yaml ARCH=x86_64 BOOT_IMAGE=/kernel/x86_64-randconfig-s1-01211233/6aaca9bab6116a2b392e7a07b5ff209741bc248f/vmlinuz-3.16.0-g6aaca9b kconfig=x86_64-randconfig-s1-01211233 commit=6aaca9bab6116a2b392e7a07b5ff209741bc248f branch=next/master root=/dev/ram0 max_uptime=3600 RESULT_ROOT=/result/vm-kbuild-yocto-x86_64/boot/1/yocto-minimal-x86_64.cgz/x86_64-randconfig-s1-01211233/6aaca9bab6116a2b392e7a07b5ff209741bc248f/1 ip=::::vm-kbuild-yocto-x86_64-22::dhcp 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 rw drbd.minor_count=8 [ 0.000000] sysrq: sysrq always enabled. [ 0.000000] PID hash table entries: 2048 (order: 2, 16384 bytes) [ 0.000000] xsave: enabled xstate_bv 0x7, cntxt size 0x340 [ 0.000000] Memory: 263528K/327280K available (16799K kernel code, 11283K rwdata, 11052K rodata, 1660K init, 11904K bss, 63752K reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 [ 0.000000] Hierarchical RCU implementation. [ 0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 [ 0.000000] NR_IRQS:524544 nr_irqs:256 16 [ 0.000000] Console: colour VGA+ 80x25 [ 0.000000] console [tty0] enabled [ 0.000000] bootconsole [earlyser0] 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: 32768 [ 0.000000] ... MAX_LOCKDEP_CHAINS: 65536 [ 0.000000] ... CHAINHASH_SIZE: 32768 [ 0.000000] memory used by lock dependency info: 8127 kB [ 0.000000] per task-struct memory footprint: 1920 bytes [ 0.000000] hpet clockevent registered [ 0.000000] tsc: Detected 2693.400 MHz processor [ 0.020000] Calibrating delay loop (skipped) preset value.. 5386.80 BogoMIPS (lpj=26934000) [ 0.020000] pid_max: default: 32768 minimum: 301 [ 0.020000] ACPI: Core revision 20140424 [ 0.058911] ACPI: All ACPI Tables successfully acquired [ 0.060292] Dentry cache hash table entries: 65536 (order: 7, 524288 bytes) [ 0.061473] Inode-cache hash table entries: 32768 (order: 6, 262144 bytes) [ 0.062573] Mount-cache hash table entries: 1024 (order: 1, 8192 bytes) [ 0.063566] Mountpoint-cache hash table entries: 1024 (order: 1, 8192 bytes) [ 0.066351] Initializing cgroup subsys freezer [ 0.067111] Initializing cgroup subsys net_cls [ 0.067877] Initializing cgroup subsys blkio [ 0.068618] Initializing cgroup subsys debug [ 0.069636] numa_add_cpu cpu 0 node 0: mask now 0 [ 0.070012] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.070012] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.070012] tlb_flushall_shift: 6 [ 0.085849] Freeing SMP alternatives memory: 24K (ffffffff89ddb000 - ffffffff89de1000) [ 0.088566] Getting VERSION: 1050014 [ 0.089195] Getting VERSION: 1050014 [ 0.089809] Getting ID: 0 [ 0.090023] Getting ID: ff000000 [ 0.090604] Getting LVT0: 8700 [ 0.091167] Getting LVT1: 8400 [ 0.091784] enabled ExtINT on CPU#0 [ 0.093099] ENABLING IO-APIC IRQs [ 0.093691] init IO_APIC IRQs [ 0.094234] apic 0 pin 0 not connected [ 0.094919] IOAPIC[0]: Set routing entry (0-1 -> 0x31 -> IRQ 1 Mode:0 Active:0 Dest:1) [ 0.096195] IOAPIC[0]: Set routing entry (0-2 -> 0x30 -> IRQ 0 Mode:0 Active:0 Dest:1) [ 0.097474] IOAPIC[0]: Set routing entry (0-3 -> 0x33 -> IRQ 3 Mode:0 Active:0 Dest:1) [ 0.098758] IOAPIC[0]: Set routing entry (0-4 -> 0x34 -> IRQ 4 Mode:0 Active:0 Dest:1) [ 0.100037] IOAPIC[0]: Set routing entry (0-5 -> 0x35 -> IRQ 5 Mode:1 Active:0 Dest:1) [ 0.101296] IOAPIC[0]: Set routing entry (0-6 -> 0x36 -> IRQ 6 Mode:0 Active:0 Dest:1) [ 0.102567] IOAPIC[0]: Set routing entry (0-7 -> 0x37 -> IRQ 7 Mode:0 Active:0 Dest:1) [ 0.103839] IOAPIC[0]: Set routing entry (0-8 -> 0x38 -> IRQ 8 Mode:0 Active:0 Dest:1) [ 0.105106] IOAPIC[0]: Set routing entry (0-9 -> 0x39 -> IRQ 9 Mode:1 Active:0 Dest:1) [ 0.106377] IOAPIC[0]: Set routing entry (0-10 -> 0x3a -> IRQ 10 Mode:1 Active:0 Dest:1) [ 0.107662] IOAPIC[0]: Set routing entry (0-11 -> 0x3b -> IRQ 11 Mode:1 Active:0 Dest:1) [ 0.108976] IOAPIC[0]: Set routing entry (0-12 -> 0x3c -> IRQ 12 Mode:0 Active:0 Dest:1) [ 0.110039] IOAPIC[0]: Set routing entry (0-13 -> 0x3d -> IRQ 13 Mode:0 Active:0 Dest:1) [ 0.111330] IOAPIC[0]: Set routing entry (0-14 -> 0x3e -> IRQ 14 Mode:0 Active:0 Dest:1) [ 0.112605] IOAPIC[0]: Set routing entry (0-15 -> 0x3f -> IRQ 15 Mode:0 Active:0 Dest:1) [ 0.113869] apic 0 pin 16 not connected [ 0.114516] apic 0 pin 17 not connected [ 0.115154] apic 0 pin 18 not connected [ 0.115801] apic 0 pin 19 not connected [ 0.116439] apic 0 pin 20 not connected [ 0.117080] apic 0 pin 21 not connected [ 0.117724] apic 0 pin 22 not connected [ 0.118367] apic 0 pin 23 not connected [ 0.119161] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.120011] smpboot: CPU0: Intel Xeon E312xx (Sandy Bridge) (fam: 06, model: 2a, stepping: 01) [ 0.121529] TSC deadline timer enabled [ 0.122275] Performance Events: unsupported p6 CPU model 42 no PMU driver, software events only. [ 0.125207] [ 0.125207] ********************************************************** [ 0.126465] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.127413] ** ** [ 0.128332] ** trace_printk() being used. Allocating extra memory. ** [ 0.129247] ** ** [ 0.130000] ** This means that this is a DEBUG kernel and it is ** [ 0.130000] ** unsafe for produciton use. ** [ 0.130000] ** ** [ 0.130007] ** If you see this message and you are not debugging ** [ 0.130921] ** the kernel, report this immediately to your vendor! ** [ 0.131835] ** ** [ 0.132744] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.133657] ********************************************************** [ 0.136688] Testing tracer nop: PASSED [ 0.137537] x86: Booted up 1 node, 1 CPUs [ 0.138183] smpboot: Total of 1 processors activated (5386.80 BogoMIPS) [ 0.141311] devtmpfs: initialized [ 0.146430] Testing tracer function: PASSED [ 0.270967] Testing ftrace regs(no arch support): PASSED [ 0.275590] Testing tracer wakeup: ret = 0 [ 0.381623] PASSED [ 0.384193] Testing tracer wakeup_rt: ret = 0 [ 0.491623] PASSED [ 0.493786] Testing tracer wakeup_dl: ret = 0 [ 0.601636] PASSED [ 0.602119] Testing tracer branch: PASSED [ 0.717851] xor: automatically using best checksumming function: [ 0.810008] avx : 20160.800 MB/sec [ 0.810684] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 0.812698] regulator-dummy: no parameters [ 0.814091] NET: Registered protocol family 16 [ 0.817207] cpuidle: using governor menu [ 0.818593] ACPI: bus type PCI registered [ 0.819941] PCI: Using configuration type 1 for base access [ 1.070018] raid6: sse2x1 7774 MB/s [ 1.240013] raid6: sse2x2 9759 MB/s [ 1.410014] raid6: sse2x4 11492 MB/s [ 1.410661] raid6: using algorithm sse2x4 (11492 MB/s) [ 1.411420] raid6: using ssse3x2 recovery algorithm [ 1.412588] ACPI: Added _OSI(Module Device) [ 1.413282] ACPI: Added _OSI(Processor Device) [ 1.413981] ACPI: Added _OSI(3.0 _SCP Extensions) [ 1.414735] ACPI: Added _OSI(Processor Aggregator Device) [ 1.467853] ACPI: Interpreter enabled [ 1.468526] ACPI: (supports S0 S5) [ 1.469143] ACPI: Using IOAPIC for interrupt routing [ 1.470156] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 1.541983] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 1.542910] acpi PNP0A03:00: _OSC: OS supports [Segments] [ 1.543857] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM [ 1.550112] PCI host bridge to bus 0000:00 [ 1.550787] pci_bus 0000:00: root bus resource [bus 00-ff] [ 1.551604] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7] [ 1.552490] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff] [ 1.553387] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff] [ 1.554348] pci_bus 0000:00: root bus resource [mem 0x80000000-0xfebfffff] [ 1.555364] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 1.558704] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 1.562244] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 1.565321] pci 0000:00:01.1: reg 0x20: [io 0xc080-0xc08f] [ 1.567008] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 1.567992] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 1.568916] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 1.569893] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 1.572287] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 1.573485] pci 0000:00:01.3: quirk: [io 0xb000-0xb03f] claimed by PIIX4 ACPI [ 1.574621] pci 0000:00:01.3: quirk: [io 0xb100-0xb10f] claimed by PIIX4 SMB [ 1.577970] pci 0000:00:02.0: [1013:00b8] type 00 class 0x030000 [ 1.580610] pci 0000:00:02.0: reg 0x10: [mem 0xfc000000-0xfdffffff pref] [ 1.582764] pci 0000:00:02.0: reg 0x14: [mem 0xfebf0000-0xfebf0fff] [ 1.588968] pci 0000:00:02.0: reg 0x30: [mem 0xfebe0000-0xfebeffff pref] [ 1.592630] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000 [ 1.594224] pci 0000:00:03.0: reg 0x10: [mem 0xfeba0000-0xfebbffff] [ 1.595865] pci 0000:00:03.0: reg 0x14: [io 0xc000-0xc03f] [ 1.600430] pci 0000:00:03.0: reg 0x30: [mem 0xfebc0000-0xfebdffff pref] [ 1.603584] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 [ 1.605203] pci 0000:00:04.0: reg 0x10: [io 0xc040-0xc07f] [ 1.606769] pci 0000:00:04.0: reg 0x14: [mem 0xfebf1000-0xfebf1fff] [ 1.613499] pci 0000:00:05.0: [8086:25ab] type 00 class 0x088000 [ 1.614745] pci 0000:00:05.0: reg 0x10: [mem 0xfebf2000-0xfebf200f] [ 1.627821] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11) [ 1.630807] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11) [ 1.633769] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11) [ 1.636768] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11) [ 1.638681] ACPI: PCI Interrupt Link [LNKS] (IRQs *9) [ 1.642648] ACPI: Enabled 16 GPEs in block 00 to 0F [ 1.646866] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none [ 1.648057] vgaarb: loaded [ 1.648560] vgaarb: bridge control possible 0000:00:02.0 [ 1.652846] SCSI subsystem initialized [ 1.653581] ACPI: bus type USB registered [ 1.654571] usbcore: registered new interface driver usbfs [ 1.655510] usbcore: registered new interface driver hub [ 1.656618] usbcore: registered new device driver usb [ 1.658211] pps_core: LinuxPPS API ver. 1 registered [ 1.658924] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it> [ 1.660102] PTP clock support registered [ 1.667532] PCI: Using ACPI for IRQ routing [ 1.668170] PCI: pci_cache_line_size set to 64 bytes [ 1.668982] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] [ 1.669799] e820: reserve RAM buffer [mem 0x13ffe000-0x13ffffff] [ 1.672182] Bluetooth: Core ver 2.19 [ 1.672851] NET: Registered protocol family 31 [ 1.673515] Bluetooth: HCI device and connection manager initialized [ 1.674421] Bluetooth: HCI socket layer initialized [ 1.675134] Bluetooth: L2CAP socket layer initialized [ 1.675995] Bluetooth: SCO socket layer initialized [ 1.676746] NET: Registered protocol family 8 [ 1.677394] NET: Registered protocol family 20 [ 1.678835] cfg80211: Calling CRDA to update world regulatory domain [ 1.680063] nfc: nfc_init: NFC Core ver 0.1 [ 1.680852] NET: Registered protocol family 39 [ 1.682389] Switched to clocksource kvm-clock [ 1.684107] Warning: could not register all branches stats [ 1.684958] Warning: could not register annotated branches stats [ 1.834812] FS-Cache: Loaded [ 1.835636] pnp: PnP ACPI init [ 1.836230] ACPI: bus type PNP registered [ 1.837168] IOAPIC[0]: Set routing entry (0-8 -> 0x38 -> IRQ 8 Mode:0 Active:0 Dest:1) [ 1.838657] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active) [ 1.839848] IOAPIC[0]: Set routing entry (0-1 -> 0x31 -> IRQ 1 Mode:0 Active:0 Dest:1) [ 1.841345] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active) [ 1.842499] IOAPIC[0]: Set routing entry (0-12 -> 0x3c -> IRQ 12 Mode:0 Active:0 Dest:1) [ 1.844027] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active) [ 1.845448] IOAPIC[0]: Set routing entry (0-6 -> 0x36 -> IRQ 6 Mode:0 Active:0 Dest:1) [ 1.846623] pnp 00:03: [dma 2] [ 1.847432] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active) [ 1.848846] IOAPIC[0]: Set routing entry (0-7 -> 0x37 -> IRQ 7 Mode:0 Active:0 Dest:1) [ 1.850327] pnp 00:04: Plug and Play ACPI device, IDs PNP0400 (active) [ 1.851749] IOAPIC[0]: Set routing entry (0-4 -> 0x34 -> IRQ 4 Mode:0 Active:0 Dest:1) [ 1.853241] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active) [ 1.854683] IOAPIC[0]: Set routing entry (0-3 -> 0x33 -> IRQ 3 Mode:0 Active:0 Dest:1) [ 1.856263] pnp 00:06: Plug and Play ACPI device, IDs PNP0501 (active) [ 1.861027] pnp: PnP ACPI: found 7 devices [ 1.861656] ACPI: bus type PNP unregistered [ 1.889379] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7] [ 1.890184] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff] [ 1.890947] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff] [ 1.891785] pci_bus 0000:00: resource 7 [mem 0x80000000-0xfebfffff] [ 1.892864] NET: Registered protocol family 2 [ 1.894642] TCP established hash table entries: 4096 (order: 3, 32768 bytes) [ 1.895709] TCP bind hash table entries: 4096 (order: 6, 262144 bytes) [ 1.896846] TCP: Hash tables configured (established 4096 bind 4096) [ 1.897800] TCP: reno registered [ 1.898360] UDP hash table entries: 256 (order: 3, 40960 bytes) [ 1.899240] UDP-Lite hash table entries: 256 (order: 3, 40960 bytes) [ 1.900639] NET: Registered protocol family 1 [ 1.902445] RPC: Registered named UNIX socket transport module. [ 1.903290] RPC: Registered udp transport module. [ 1.903959] RPC: Registered tcp transport module. [ 1.904685] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 1.905605] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 1.906465] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 1.907343] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 1.908275] pci 0000:00:02.0: Boot video device [ 1.909003] PCI: CLS 0 bytes, default 64 [ 1.910248] Unpacking initramfs... [ 2.263127] Freeing initrd memory: 3904K (ffff880013c20000 - ffff880013ff0000) [ 2.264944] kvm: no hardware support [ 2.265578] has_svm: not amd [ 2.266110] kvm: no hardware support [ 2.278262] AVX version of gcm_enc/dec engaged. [ 2.316090] sha1_ssse3: Using AVX optimized SHA-1 implementation [ 2.317240] sha256_ssse3: Using AVX optimized SHA-256 implementation [ 2.318398] sha512_ssse3: Using AVX optimized SHA-512 implementation [ 2.323331] AVX2 or AES-NI instructions are not detected. [ 2.324154] AVX2 instructions are not detected. [ 2.325158] rcu-torture:--- Start of test: nreaders=1 nfakewriters=4 stat_interval=60 verbose=1 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 [ 2.329327] rcu-torture: Creating rcu_torture_writer task [ 2.330814] rcu-torture: Creating rcu_torture_fakewriter task [ 2.331739] rcu-torture: rcu_torture_writer task started [ 2.332561] rcu-torture: Creating rcu_torture_fakewriter task [ 2.333462] rcu-torture: rcu_torture_fakewriter task started [ 2.334323] rcu-torture: Creating rcu_torture_fakewriter task [ 2.335227] rcu-torture: rcu_torture_fakewriter task started [ 2.336086] rcu-torture: Creating rcu_torture_fakewriter task [ 2.336987] rcu-torture: rcu_torture_fakewriter task started [ 2.337847] rcu-torture: Creating rcu_torture_reader task [ 2.338713] rcu-torture: rcu_torture_fakewriter task started [ 2.339571] rcu-torture: Creating rcu_torture_stats task [ 2.341188] rcu-torture: rcu_torture_reader task started [ 2.350698] rcu-torture: Creating torture_shuffle task [ 2.351579] rcu-torture: rcu_torture_stats task started [ 2.352390] rcu-torture: Creating torture_stutter task [ 2.353237] rcu-torture: torture_shuffle task started [ 2.355616] futex hash table entries: 256 (order: 3, 32768 bytes) [ 2.356569] Initialise system trusted keyring [ 2.357436] audit: initializing netlink subsys (disabled) [ 2.358343] audit: type=2000 audit(1422016397.982:1): initialized [ 2.362000] rcu-torture: torture_stutter task started [ 2.385277] HugeTLB registered 2 MB page size, pre-allocated 0 pages [ 2.526735] VFS: Disk quotas dquot_6.5.2 [ 2.528697] Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 2.583890] Key type cifs.spnego registered [ 2.588561] efs: 1.0a - http://aeschi.ch.eu.org/efs/ [ 2.591988] ROMFS MTD (C) 2007 Red Hat, Inc. [ 2.595307] QNX4 filesystem 0.2.3 registered. [ 2.597298] QNX6 filesystem 1.0.0 registered. [ 2.599299] fuse init (API version 7.23) [ 2.604491] SGI XFS with ACLs, security attributes, realtime, large block/inode numbers, debug enabled [ 2.630841] NILFS version 2 loaded [ 2.636635] ocfs2: Registered cluster interface o2cb [ 2.638769] OCFS2 User DLM kernel interface loaded [ 2.659454] FS-Cache: Netfs 'ceph' registered for caching [ 2.660291] ceph: loaded (mds proto 32) [ 2.671559] NET: Registered protocol family 38 [ 2.672351] Key type asymmetric registered [ 2.673032] Asymmetric key parser 'x509' registered [ 2.675268] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) [ 2.676808] io scheduler noop registered [ 2.677501] io scheduler deadline registered (default) [ 2.678313] start plist test [ 2.684264] end plist test [ 2.684792] list_sort_test: start testing list_sort() [ 2.691332] crc32: CRC_LE_BITS = 64, CRC_BE BITS = 64 [ 2.692090] crc32: self tests passed, processed 225944 bytes in 140644 nsec [ 2.693194] crc32c: CRC_LE_BITS = 64 [ 2.693788] crc32c: self tests passed, processed 225944 bytes in 70651 nsec [ 2.914462] crc32_combine: 8373 self tests passed [ 3.148221] crc32c_combine: 8373 self tests passed [ 3.149303] rbtree testing -> 16399 cycles [ 3.820142] augmented rbtree testing -> 23855 cycles [ 4.789964] hgafb: HGA card not detected. [ 4.790711] hgafb: probe of hgafb.0 failed with error -22 [ 4.792247] usbcore: registered new interface driver smscufx [ 4.796816] tsc: Refined TSC clocksource calibration: 2693.510 MHz [ 4.798286] uvesafb: failed to execute /sbin/v86d [ 4.799010] uvesafb: make sure that the v86d helper is installed and executable [ 4.800193] uvesafb: Getting VBE info block failed (eax=0x4f00, err=-2) [ 4.801126] uvesafb: vbe_init() failed with -22 [ 4.801872] uvesafb: probe of uvesafb.0 failed with error -22 [ 4.803972] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 4.805183] ACPI: Power Button [PWRF] [ 4.951505] r3964: Philips r3964 Driver $Revision: 1.10 $ [ 4.952361] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled [ 4.977788] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 4.985852] serial: Freescale lpuart driver [ 4.988129] telclk_interrupt = 0xf non-mcpbl0010 hw. [ 4.988980] smapi::smapi_init, ERROR invalid usSmapiID [ 4.989777] mwave: tp3780i::tp3780I_InitializeBoardData: Error: SMAPI is not available on this machine [ 4.991215] mwave: mwavedd::mwave_init: Error: Failed to initialize board data [ 4.992393] mwave: mwavedd::mwave_init: Error: Failed to initialize [ 4.993516] SyncLink PC Card driver $Revision: 4.34 $, tty major#246 [ 4.995426] [drm] Initialized drm 1.1.0 20060810 [ 4.996362] usbcore: registered new interface driver udl [ 4.998423] parport_pc 00:04: reported by Plug and Play ACPI [ 4.999383] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] [ 5.003154] dummy-irq: no IRQ given. Use irq=N [ 5.004675] Silicon Labs C2 port support v. 0.51.0 - (C) 2007 Rodolfo Giometti [ 5.006456] c2port c2port0: C2 port uc added [ 5.007154] c2port c2port0: uc flash has 30 blocks x 512 bytes (15360 bytes total) [ 5.009530] usbcore: registered new interface driver rtsx_usb [ 5.011813] usbcore: registered new interface driver viperboard [ 5.012848] usbcore: registered new interface driver pn533 [ 5.014760] Loading iSCSI transport class v2.0-870. [ 5.017090] iscsi: registered transport (tcp) [ 5.023498] ppa: Version 2.07 (for Linux 2.4.x) [ 5.028349] osst :I: Tape driver with OnStream support version 0.99.4 [ 5.028349] osst :I: $Id: osst.c,v 1.73 2005/01/01 21:13:34 wriede Exp $ [ 5.041262] scsi_debug: host protection [ 5.041909] scsi0 : scsi_debug, version 1.82 [20100324], dev_size_mb=8, opts=0x0 [ 5.060114] Rounding down aligned max_sectors from 4294967295 to 4294967288 [ 5.061977] scsi 0:0:0:0: Direct-Access Linux scsi_debug 0004 PQ: 0 ANSI: 5 [ 5.066902] sd 0:0:0:0: Attached scsi generic sg0 type 0 [ 5.077224] mtdoops: mtd device (mtddev=name/number) must be supplied [ 5.078204] L440GX flash mapping: failed to find PIIX4 ISA bridge, cannot continue [ 5.079576] platform physmap-flash.0: failed to claim resource 0 [ 5.080924] slram: not enough parameters. [ 5.082664] sd 0:0:0:0: [sda] 16384 512-byte logical blocks: (8.38 MB/8.00 MiB) [ 5.089900] HSI/SSI char device loaded [ 5.090602] ipddp.c:v0.01 8/28/97 Bradford W. Johnson <johns393@maroon.tc.umn.edu> [ 5.093389] ipddp0: Appletalk-IP Decap. mode by Jay Schulist <jschlst@samba.org> [ 5.094591] YAM driver version 0.8 by F1OAT/F6FBB [ 5.101518] baycom_ser_fdx: (C) 1996-2000 Thomas Sailer, HB9JNX/AE4WA [ 5.101518] baycom_ser_fdx: version 0.10 [ 5.109349] hdlcdrv: (C) 1996-2000 Thomas Sailer HB9JNX/AE4WA [ 5.110218] hdlcdrv: version 0.8 [ 5.110782] baycom_ser_hdx: (C) 1996-2000 Thomas Sailer, HB9JNX/AE4WA [ 5.110782] baycom_ser_hdx: version 0.10 [ 5.118625] baycom_par: (C) 1996-2000 Thomas Sailer, HB9JNX/AE4WA [ 5.118625] baycom_par: version 0.9 [ 5.126785] usbcore: registered new interface driver hwa-rc [ 5.127775] usbcore: registered new interface driver i1480-dfu-usb [ 5.129092] sd 0:0:0:0: [sda] Write Protect is off [ 5.129833] sd 0:0:0:0: [sda] Mode Sense: 73 00 10 08 [ 5.131072] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver [ 5.132112] ohci-pci: OHCI PCI platform driver [ 5.133012] ohci-platform: OHCI generic platform driver [ 5.138356] usbcore: registered new interface driver hwa-hc [ 5.139396] fusbh200_hcd: FUSBH200 Host Controller (EHCI) Driver [ 5.140274] Warning! fusbh200_hcd should always be loaded before uhci_hcd and ohci_hcd, not after [ 5.141774] fotg210_hcd: FOTG210 Host Controller (EHCI) Driver [ 5.144423] usbcore: registered new interface driver cdc_acm [ 5.145245] cdc_acm: USB Abstract Control Model driver for USB modems and ISDN adapters [ 5.146661] usbcore: registered new interface driver cdc_wdm [ 5.147645] usbcore: registered new interface driver usbtmc [ 5.148630] usbcore: registered new interface driver uas [ 5.149600] usbcore: registered new interface driver usb-storage [ 5.150641] usbcore: registered new interface driver ums-cypress [ 5.151635] usbcore: registered new interface driver ums-datafab [ 5.152624] usbcore: registered new interface driver ums-isd200 [ 5.153593] usbcore: registered new interface driver ums-jumpshot [ 5.154586] usbcore: registered new interface driver ums-onetouch [ 5.155603] usbcore: registered new interface driver ums-realtek [ 5.156589] usbcore: registered new interface driver ums-sddr09 [ 5.157553] usbcore: registered new interface driver ums-sddr55 [ 5.158527] usbcore: registered new interface driver ums-usbat [ 5.159557] usbcore: registered new interface driver microtekX6 [ 5.160858] usbcore: registered new interface driver usbserial [ 5.161852] usbcore: registered new interface driver belkin_sa [ 5.162850] usbserial: USB Serial support registered for Belkin / Peracom / GoHubs USB Serial Adapter [ 5.164321] usbcore: registered new interface driver ch341 [ 5.165251] usbserial: USB Serial support registered for ch341-uart [ 5.166357] usbcore: registered new interface driver cyberjack [ 5.167350] usbserial: USB Serial support registered for Reiner SCT Cyberjack USB card reader [ 5.168771] usbcore: registered new interface driver cypress_m8 [ 5.169774] usbserial: USB Serial support registered for DeLorme Earthmate USB [ 5.171050] usbserial: USB Serial support registered for HID->COM RS232 Adapter [ 5.172365] usbserial: USB Serial support registered for Nokia CA-42 V2 Adapter [ 5.173634] usbcore: registered new interface driver usb_debug [ 5.174603] usbserial: USB Serial support registered for debug [ 5.175589] usbcore: registered new interface driver digi_acceleport [ 5.176640] usbserial: USB Serial support registered for Digi 2 port USB adapter [ 5.177906] usbserial: USB Serial support registered for Digi 4 port USB adapter [ 5.179207] usbcore: registered new interface driver io_edgeport [ 5.180216] usbserial: USB Serial support registered for Edgeport 2 port adapter [ 5.181498] usbserial: USB Serial support registered for Edgeport 4 port adapter [ 5.182809] usbserial: USB Serial support registered for Edgeport 8 port adapter [ 5.184083] usbserial: USB Serial support registered for EPiC device [ 5.185108] usbcore: registered new interface driver io_ti [ 5.186076] usbserial: USB Serial support registered for Edgeport TI 1 port adapter [ 5.187374] usbserial: USB Serial support registered for Edgeport TI 2 port adapter [ 5.188688] usbcore: registered new interface driver empeg [ 5.189660] usbserial: USB Serial support registered for empeg [ 5.190652] usbcore: registered new interface driver f81232 [ 5.191610] usbserial: USB Serial support registered for f81232 [ 5.192596] usbcore: registered new interface driver garmin_gps [ 5.193586] usbserial: USB Serial support registered for Garmin GPS usb/tty [ 5.194672] usbcore: registered new interface driver ipaq [ 5.195668] usbserial: USB Serial support registered for PocketPC PDA [ 5.196721] usbcore: registered new interface driver ipw [ 5.197646] usbserial: USB Serial support registered for IPWireless converter [ 5.198741] usbcore: registered new interface driver iuu_phoenix [ 5.199767] usbserial: USB Serial support registered for iuu_phoenix [ 5.200827] usbcore: registered new interface driver keyspan [ 5.201789] usbserial: USB Serial support registered for Keyspan - (without firmware) [ 5.203144] usbserial: USB Serial support registered for Keyspan 1 port adapter [ 5.204394] usbserial: USB Serial support registered for Keyspan 2 port adapter [ 5.205701] usbserial: USB Serial support registered for Keyspan 4 port adapter [ 5.206969] usbcore: registered new interface driver keyspan_pda [ 5.207998] usbserial: USB Serial support registered for Keyspan PDA [ 5.209055] usbserial: USB Serial support registered for Keyspan PDA - (prerenumeration) [ 5.210428] usbserial: USB Serial support registered for Xircom / Entregra PGS - (prerenumeration) [ 5.211875] usbcore: registered new interface driver kobil_sct [ 5.212882] usbserial: USB Serial support registered for KOBIL USB smart card terminal [ 5.214213] usbcore: registered new interface driver mct_u232 [ 5.215181] usbserial: USB Serial support registered for MCT U232 [ 5.216232] usbcore: registered new interface driver mos7840 [ 5.217188] usbserial: USB Serial support registered for Moschip 7840/7820 USB Serial Driver [ 5.218577] usbcore: registered new interface driver mxuport [ 5.219568] usbserial: USB Serial support registered for MOXA UPort [ 5.220605] usbcore: registered new interface driver omninet [ 5.221566] usbserial: USB Serial support registered for ZyXEL - omni.net lcd plus usb [ 5.222922] usbcore: registered new interface driver pl2303 [ 5.223870] usbserial: USB Serial support registered for pl2303 [ 5.224853] usbcore: registered new interface driver qcaux [ 5.225840] usbserial: USB Serial support registered for qcaux [ 5.226815] usbcore: registered new interface driver qcserial [ 5.227773] usbserial: USB Serial support registered for Qualcomm USB modem [ 5.228873] usbcore: registered new interface driver quatech2 [ 5.229872] usbserial: USB Serial support registered for Quatech 2nd gen USB to Serial Driver [ 5.231320] usbcore: registered new interface driver sierra [ 5.232287] usbserial: USB Serial support registered for Sierra USB modem [ 5.233372] usbcore: registered new interface driver usb_serial_simple [ 5.234423] usbserial: USB Serial support registered for zio [ 5.235393] usbserial: USB Serial support registered for funsoft [ 5.236412] usbserial: USB Serial support registered for flashloader [ 5.237444] usbserial: USB Serial support registered for vivopay [ 5.238441] usbserial: USB Serial support registered for moto_modem [ 5.239525] usbserial: USB Serial support registered for hp4x [ 5.240518] usbserial: USB Serial support registered for suunto [ 5.241508] usbserial: USB Serial support registered for siemens_mpi [ 5.242539] usbcore: registered new interface driver ssu100 [ 5.243475] usbserial: USB Serial support registered for Quatech SSU-100 USB to Serial Driver [ 5.244865] usbcore: registered new interface driver symbolserial [ 5.245921] usbserial: USB Serial support registered for symbol [ 5.246909] usbcore: registered new interface driver ti_usb_3410_5052 [ 5.247953] usbserial: USB Serial support registered for TI USB 3410 1 port adapter [ 5.249280] usbserial: USB Serial support registered for TI USB 5052 2 port adapter [ 5.250599] usbcore: registered new interface driver visor [ 5.251529] usbserial: USB Serial support registered for Handspring Visor / Palm OS [ 5.252845] usbserial: USB Serial support registered for Sony Clie 5.0 [ 5.253910] usbserial: USB Serial support registered for Sony Clie 3.5 [ 5.254971] usbcore: registered new interface driver wishbone_serial [ 5.256036] usbserial: USB Serial support registered for wishbone_serial [ 5.257096] usbcore: registered new interface driver xsens_mt [ 5.258056] usbserial: USB Serial support registered for xsens_mt [ 5.259117] usbcore: registered new interface driver adutux [ 5.260393] usbcore: registered new interface driver appledisplay [ 5.261435] usbcore: registered new interface driver cypress_cy7c63 [ 5.268169] usbcore: registered new interface driver cytherm [ 5.269192] usbcore: registered new interface driver emi26 - firmware loader [ 5.270342] usbcore: registered new interface driver idmouse [ 5.271345] usbcore: registered new interface driver iowarrior [ 5.272356] usbcore: registered new interface driver usblcd [ 5.273325] usbcore: registered new interface driver ldusb [ 5.274293] usbcore: registered new interface driver legousbtower [ 5.275337] usbcore: registered new interface driver rio500 [ 5.276333] usbcore: registered new interface driver usbtest [ 5.277314] usbcore: registered new interface driver usb_ehset_test [ 5.278354] usbcore: registered new interface driver trancevibrator [ 5.279437] usbcore: registered new interface driver usbsevseg [ 5.280492] usbcore: registered new interface driver yurex [ 5.281842] usbcore: registered new interface driver cxacru [ 5.282865] usbcore: registered new interface driver speedtch [ 5.283869] usbcore: registered new interface driver ueagle-atm [ 5.287048] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 5.289485] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 5.290291] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 5.291127] parport0: no more devices allowed [ 5.292465] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, supports DPO and FUA [ 5.295626] mousedev: PS/2 mouse device common for all mice [ 5.296475] evbug: Connected device: input0 (Power Button at LNXPWRBN/button/input0) [ 5.299504] usbcore: registered new interface driver appletouch [ 5.300530] usbcore: registered new interface driver bcm5974 [ 5.301818] usbcore: registered new interface driver synaptics_usb [ 5.306786] rtc_cmos 00:00: RTC can wake from S4 [ 5.307770] rtc (null): alarm rollover: day [ 5.308940] rtc_cmos 00:00: rtc core: registered rtc_cmos as rtc0 [ 5.310076] rtc_cmos 00:00: alarms up to one day, 114 bytes nvram, hpet irqs [ 5.314746] i2c /dev entries driver [ 5.315905] i2c-parport-light: adapter type unspecified [ 5.316833] usbcore: registered new interface driver RobotFuzz Open Source InterFace, OSIF [ 5.318233] usbcore: registered new interface driver i2c-tiny-usb [ 5.319147] pps_parport: parallel port PPS client [ 5.319875] parport0: no more devices allowed [ 5.320565] pps_parport: couldn't register with parport0 [ 5.321361] Driver for 1-wire Dallas network protocol. [ 5.322752] usbcore: registered new interface driver DS9490R [ 5.327631] applesmc: supported laptop not found! [ 5.328379] applesmc: driver init failed (ret=-19)! [ 5.334860] pc87360: PC8736x not detected, module not inserted [ 5.337644] Bluetooth: HCI UART driver ver 2.2 [ 5.338368] Bluetooth: HCI BCSP protocol initialized [ 5.339167] Bluetooth: HCILL protocol initialized [ 5.339872] Bluetooth: HCIATH3K protocol initialized [ 5.340797] usbcore: registered new interface driver bcm203x [ 5.341811] usbcore: registered new interface driver bpa10x [ 5.342943] usbcore: registered new interface driver btusb [ 5.343758] Bluetooth: Generic Bluetooth SDIO driver ver 0.1 [ 5.344846] usbcore: registered new interface driver ath3k [ 5.346134] sdhci: Secure Digital Host Controller Interface driver [ 5.346998] sdhci: Copyright(c) Pierre Ossman [ 5.347682] VUB300 Driver rom wait states = 1C irqpoll timeout = 0400 [ 5.349786] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 5.351387] evbug: Connected device: input1 (AT Translated Set 2 keyboard at isa0060/serio0/input0) [ 5.355041] usbcore: registered new interface driver vub300 [ 5.356052] usbcore: registered new interface driver ushc [ 5.359212] ledtrig-cpu: registered to indicate activity on CPUs [ 5.362319] hidraw: raw HID events driver (C) Jiri Kosina [ 5.371277] usbcore: registered new interface driver usbhid [ 5.372081] usbhid: USB HID core driver [ 5.378709] fake-fmc-carrier: mezzanine 0 [ 5.379411] Manufacturer: fake-vendor [ 5.380088] Product name: fake-design-for-testing [ 5.381084] fmc fake-design-for-testing-f001: Driver has no ID: matches all [ 5.382103] fmc_write_eeprom fake-design-for-testing-f001: fmc_write_eeprom: no busid passed, refusing all cards [ 5.383721] fmc fake-design-for-testing-f001: Driver has no ID: matches all [ 5.385159] fmc_chardev fake-design-for-testing-f001: Created misc device "fake-design-for-testing-f001" [ 5.387148] pktgen: Packet Generator for packet performance testing. Version: 2.74 [ 5.388545] drop_monitor: Initializing network drop monitor service [ 5.389873] NET: Registered protocol family 26 [ 5.390778] ipip: IPv4 over IPv4 tunneling driver [ 5.393286] gre: GRE over IPv4 demultiplexor driver [ 5.394038] ip_gre: GRE over IPv4 tunneling driver [ 5.398221] IPv4 over IPSec tunneling driver [ 5.400847] TCP: bic registered [ 5.401416] TCP: westwood registered [ 5.402011] TCP: highspeed registered [ 5.402628] TCP: hybla registered [ 5.403209] TCP: htcp registered [ 5.403766] TCP: vegas registered [ 5.404343] TCP: veno registered [ 5.404906] TCP: yeah registered [ 5.405517] TCP: illinois registered [ 5.406134] Initializing XFRM netlink socket [ 5.406880] NET: Registered protocol family 17 [ 5.410149] NET: Registered protocol family 4 [ 5.410996] NET: Registered protocol family 5 [ 5.418033] NET: Registered protocol family 6 [ 5.418878] NET: Registered protocol family 3 [ 5.420756] Bluetooth: RFCOMM socket layer initialized [ 5.421542] Bluetooth: RFCOMM ver 1.11 [ 5.422183] Bluetooth: HIDP (Human Interface Emulation) ver 1.2 [ 5.423040] Bluetooth: HIDP socket layer initialized [ 5.426277] NET: Registered protocol family 33 [ 5.426961] Key type rxrpc registered [ 5.427589] Key type rxrpc_s registered [ 5.428477] l2tp_core: L2TP core driver, V2.0 [ 5.429223] l2tp_netlink: L2TP netlink interface [ 5.430062] l2tp_debugfs: L2TP debugfs support [ 5.430790] NET4: DECnet for Linux: V.2.5.68s (C) 1995-2003 Linux DECnet Project Team [ 5.434751] DECnet: Routing cache hash table of 256 buckets, 16Kbytes [ 5.437025] NET: Registered protocol family 12 [ 5.437817] NET: Registered protocol family 35 [ 5.441060] 8021q: 802.1Q VLAN Support v1.8 [ 5.448223] DCCP: Activated CCID 2 (TCP-like) [ 5.455122] sctp: Hash tables configured (established 1024 bind 1024) [ 5.457499] tipc: Activated (version 2.0.0) [ 5.460053] NET: Registered protocol family 30 [ 5.462335] tipc: Started in single node mode [ 5.463032] 9pnet: Installing 9P2000 support [ 5.466319] NET: Registered protocol family 36 [ 5.467064] Key type dns_resolver registered [ 5.467777] Key type ceph registered [ 5.472051] libceph: loaded (mon/osd proto 15/24) [ 5.473623] batman_adv: B.A.T.M.A.N. advanced 2014.3.0 (compatibility version 15) loaded [ 5.474868] mpls_gso: MPLS GSO support [ 5.476147] [ 5.476147] printing PIC contents [ 5.476999] ... PIC IMR: ffff [ 5.477534] ... PIC IRR: 1113 [ 5.478066] ... PIC ISR: 0000 [ 5.478602] ... PIC ELCR: 0c00 [ 5.479170] printing local APIC contents on CPU#0/0: [ 5.479905] ... APIC ID: 00000000 (0) [ 5.480013] ... APIC VERSION: 01050014 [ 5.480013] ... APIC TASKPRI: 00000000 (00) [ 5.480013] ... APIC PROCPRI: 00000000 [ 5.480013] ... APIC LDR: 01000000 [ 5.480013] ... APIC DFR: ffffffff [ 5.480013] ... APIC SPIV: 000001ff [ 5.480013] ... APIC ISR field: [ 5.480013] 0000000000000000000000000000000000000000000000000000000000000000 [ 5.480013] ... APIC TMR field: [ 5.480013] 0000000002000000000000000000000000000000000000000000000000000000 [ 5.480013] ... APIC IRR field: [ 5.480013] 0000000000000000000000000000000000000000000000000000000000008000 [ 5.480013] ... APIC ESR: 00000000 [ 5.480013] ... APIC ICR: 00000831 [ 5.480013] ... APIC ICR2: 01000000 [ 5.480013] ... APIC LVTT: 000400ef [ 5.480013] ... APIC LVTPC: 00010000 [ 5.480013] ... APIC LVT0: 00010700 [ 5.480013] ... APIC LVT1: 00000400 [ 5.480013] ... APIC LVTERR: 000000fe [ 5.480013] ... APIC TMICT: 00000000 [ 5.480013] ... APIC TMCCT: 00000000 [ 5.480013] ... APIC TDCR: 00000000 [ 5.480013] [ 5.497570] number of MP IRQ sources: 15. [ 5.498212] number of IO-APIC #0 registers: 24. [ 5.498894] testing the IO APIC....................... [ 5.499688] IO APIC #0...... [ 5.500258] .... register #00: 00000000 [ 5.500877] ....... : physical APIC id: 00 [ 5.501553] ....... : Delivery Type: 0 [ 5.502218] ....... : LTS : 0 [ 5.502848] .... register #01: 00170011 [ 5.503461] ....... : max redirection entries: 17 [ 5.504203] ....... : PRQ implemented: 0 [ 5.504855] ....... : IO APIC version: 11 [ 5.505556] .... register #02: 00000000 [ 5.506170] ....... : arbitration: 00 [ 5.506791] .... IRQ redirection table: [ 5.507419] 1 0 0 0 0 0 0 00 [ 5.508155] 0 0 0 0 0 1 1 31 [ 5.508870] 0 0 0 0 0 1 1 30 [ 5.509603] 0 0 0 0 0 1 1 33 [ 5.516270] 1 0 0 0 0 1 1 34 [ 5.516962] 1 1 0 0 0 1 1 35 [ 5.517684] 0 0 0 0 0 1 1 36 [ 5.518409] 0 0 0 0 0 1 1 37 [ 5.519130] 0 0 0 0 0 1 1 38 [ 5.519838] 0 1 0 0 0 1 1 39 [ 5.520557] 1 1 0 0 0 1 1 3A [ 5.521266] 1 1 0 0 0 1 1 3B [ 5.521977] 0 0 0 0 0 1 1 3C [ 5.522696] 0 0 0 0 0 1 1 3D [ 5.523390] 0 0 0 0 0 1 1 3E [ 5.524121] 0 0 0 0 0 1 1 3F [ 5.524838] 1 0 0 0 0 0 0 00 [ 5.525584] 1 0 0 0 0 0 0 00 [ 5.526344] 1 0 0 0 0 0 0 00 [ 5.527058] 1 0 0 0 0 0 0 00 [ 5.527816] 1 0 0 0 0 0 0 00 [ 5.528563] 1 0 0 0 0 0 0 00 [ 5.529302] 1 0 0 0 0 0 0 00 [ 5.530055] 1 0 0 0 0 0 0 00 [ 5.530794] IRQ to pin mappings: [ 5.531391] IRQ0 -> 0:2 [ 5.532033] IRQ1 -> 0:1 [ 5.532678] IRQ3 -> 0:3 [ 5.533326] IRQ4 -> 0:4 [ 5.533967] IRQ5 -> 0:5 [ 5.534640] IRQ6 -> 0:6 [ 5.535316] IRQ7 -> 0:7 [ 5.535961] IRQ8 -> 0:8 [ 5.536643] IRQ9 -> 0:9 [ 5.537322] IRQ10 -> 0:10 [ 5.537985] IRQ11 -> 0:11 [ 5.538690] IRQ12 -> 0:12 [ 5.539382] IRQ13 -> 0:13 [ 5.540060] IRQ14 -> 0:14 [ 5.540764] IRQ15 -> 0:15 [ 5.541484] .................................... done. [ 5.543509] Loading compiled-in X.509 certificates [ 5.544377] registered taskstats version 1 [ 5.545123] Running tests on trace events: [ 5.545827] Testing event kvm_async_pf_completed: [ 5.561723] sda: unknown partition table [ 5.563957] OK [ 5.564399] Testing event kvm_async_pf_ready: OK [ 5.590494] Testing event kvm_async_pf_not_present: [ 5.600725] sd 0:0:0:0: [sda] Attached SCSI disk [ 5.630032] OK [ 5.630453] Testing event kvm_async_pf_doublefault: OK [ 5.650367] Testing event kvm_try_async_get_page: OK [ 5.670669] Testing event kvm_age_page: OK [ 5.691178] Testing event kvm_fpu: OK [ 5.731959] Testing event kvm_mmio: OK [ 5.750806] Testing event kvm_ack_irq: OK [ 5.780347] Testing event kvm_msi_set_irq: OK [ 5.810888] Testing event kvm_ioapic_set_irq: OK [ 5.840836] Testing event kvm_set_irq: OK [ 5.903144] Testing event kvm_userspace_exit: OK [ 5.930988] Testing event kvm_track_tsc: OK [ 5.960501] Testing event kvm_update_master_clock: OK [ 5.993253] Testing event kvm_write_tsc_offset: OK [ 6.025832] Testing event vcpu_match_mmio: OK [ 6.040393] Testing event kvm_emulate_insn: OK [ 6.070574] Testing event kvm_skinit: OK [ 6.100353] Testing event kvm_invlpga: OK [ 6.126258] Testing event kvm_nested_intr_vmexit: OK [ 6.140384] Testing event kvm_nested_vmexit_inject: OK [ 6.170461] Testing event kvm_nested_vmexit: OK [ 6.210300] Testing event kvm_nested_intercepts: OK [ 6.236629] Testing event kvm_nested_vmrun: OK [ 6.294251] Testing event kvm_pv_eoi: OK [ 6.313944] Testing event kvm_eoi: OK [ 6.340342] Testing event kvm_apic_accept_irq: OK [ 6.370482] Testing event kvm_apic_ipi: OK [ 6.400634] Testing event kvm_pic_set_irq: OK [ 6.430379] Testing event kvm_cr: OK [ 6.465601] Testing event kvm_msr: OK [ 6.480340] Testing event kvm_page_fault: OK [ 6.510474] Testing event kvm_inj_exception: OK [ 6.550370] Testing event kvm_inj_virq: OK [ 6.581987] Testing event kvm_exit: OK [ 6.620347] Testing event kvm_apic: OK [ 6.640492] Testing event kvm_cpuid: OK [ 6.670402] Testing event kvm_pio: OK [ 6.701228] Testing event kvm_hv_hypercall: OK [ 6.730389] Testing event kvm_hypercall: OK [ 6.760949] Testing event kvm_entry: OK [ 6.786270] Testing event check_mmio_spte: OK [ 6.800809] Testing event kvm_mmu_invalidate_zap_all_pages: OK [ 6.830410] Testing event fast_page_fault: OK [ 6.861425] Testing event handle_mmio_page_fault: OK [ 6.880431] Testing event mark_mmio_spte: OK [ 6.910398] Testing event kvm_mmu_prepare_zap_page: OK [ 6.950872] Testing event kvm_mmu_unsync_page: OK [ 6.970374] Testing event kvm_mmu_sync_page: OK [ 6.990537] Testing event kvm_mmu_get_page: OK [ 7.036216] Testing event kvm_mmu_walker_error: OK [ 7.051441] Testing event kvm_mmu_set_dirty_bit: OK [ 7.081501] Testing event kvm_mmu_set_accessed_bit: OK [ 7.101356] Testing event kvm_mmu_paging_element: OK [ 7.120404] Testing event kvm_mmu_pagetable_walk: OK [ 7.192222] Testing event thermal_apic_exit: OK [ 7.237528] Testing event thermal_apic_entry: OK [ 7.251546] Testing event threshold_apic_exit: OK [ 7.280482] Testing event threshold_apic_entry: OK [ 7.319147] Testing event call_function_single_exit: OK [ 7.370378] Testing event call_function_single_entry: OK [ 7.420448] Testing event call_function_exit: OK [ 7.450446] Testing event call_function_entry: OK [ 7.480431] Testing event irq_work_exit: OK [ 7.510576] Testing event irq_work_entry: OK [ 7.540504] Testing event x86_platform_ipi_exit: OK [ 7.570498] Testing event x86_platform_ipi_entry: OK [ 7.600502] Testing event error_apic_exit: OK [ 7.630646] Testing event error_apic_entry: OK [ 7.660471] Testing event spurious_apic_exit: OK [ 7.690514] Testing event spurious_apic_entry: OK [ 7.720458] Testing event reschedule_exit: OK [ 7.750614] Testing event reschedule_entry: OK [ 7.780578] Testing event local_timer_exit: OK [ 7.810518] Testing event local_timer_entry: OK [ 7.840562] Testing event nmi_handler: OK [ 7.870448] Testing event emulate_vsyscall: OK [ 7.900568] Testing event sys_exit: OK [ 7.930663] Testing event sys_enter: OK [ 7.960507] Testing event page_fault_kernel: OK [ 7.990448] Testing event page_fault_user: OK [ 8.020494] Testing event task_rename: OK [ 8.050503] Testing event task_newtask: OK [ 8.080478] Testing event softirq_raise: OK [ 8.110468] Testing event softirq_exit: OK [ 8.140420] Testing event softirq_entry: OK [ 8.170506] Testing event irq_handler_exit: OK [ 8.200421] Testing event irq_handler_entry: OK [ 8.230476] Testing event itimer_expire: OK [ 8.260470] Testing event itimer_state: OK [ 8.290445] Testing event hrtimer_cancel: OK [ 8.320417] Testing event hrtimer_expire_exit: OK [ 8.350461] Testing event hrtimer_expire_entry: OK [ 8.380425] Testing event hrtimer_start: OK [ 8.410451] Testing event hrtimer_init: OK [ 8.440447] Testing event timer_cancel: OK [ 8.470450] Testing event timer_expire_exit: OK [ 8.500430] Testing event timer_expire_entry: OK [ 8.530450] Testing event timer_start: OK [ 8.580415] Testing event timer_init: OK [ 8.600460] Testing event signal_deliver: OK [ 8.630444] Testing event signal_generate: OK [ 8.660444] Testing event workqueue_execute_end: OK [ 8.690458] Testing event workqueue_execute_start: OK [ 8.720444] Testing event workqueue_activate_work: OK [ 8.750451] Testing event workqueue_queue_work: OK [ 8.780474] Testing event sched_wake_idle_without_ipi: OK [ 8.810414] Testing event sched_swap_numa: OK [ 8.840441] Testing event sched_stick_numa: OK [ 8.870497] Testing event sched_move_numa: OK [ 8.900422] Testing event sched_pi_setprio: OK [ 8.930399] Testing event sched_stat_runtime: OK [ 8.960433] Testing event sched_stat_blocked: OK [ 8.990443] Testing event sched_stat_iowait: OK [ 9.020417] Testing event sched_stat_sleep: OK [ 9.050397] Testing event sched_stat_wait: OK [ 9.080423] Testing event sched_process_exec: OK [ 9.110397] Testing event sched_process_fork: OK [ 9.140427] Testing event sched_process_wait: OK [ 9.170399] Testing event sched_wait_task: OK [ 9.200430] Testing event sched_process_exit: OK [ 9.230404] Testing event sched_process_free: OK [ 9.260483] Testing event sched_migrate_task: OK [ 9.290409] Testing event sched_switch: OK [ 9.320507] Testing event sched_wakeup_new: OK [ 9.370442] Testing event sched_wakeup: OK [ 9.400443] Testing event sched_kthread_stop_ret: OK [ 9.430541] Testing event sched_kthread_stop: OK [ 9.460459] Testing event lock_release: OK [ 9.490445] Testing event lock_acquire: OK [ 9.520482] Testing event console: OK [ 9.550398] Testing event rcu_utilization: OK [ 9.580438] Testing event ftrace_test_filter: OK [ 9.610400] Testing event dev_pm_qos_remove_request: OK [ 9.650468] Testing event dev_pm_qos_update_request: OK [ 9.688487] Testing event dev_pm_qos_add_request: OK [ 9.720465] Testing event pm_qos_update_flags: OK [ 9.750427] Testing event pm_qos_update_target: OK [ 9.780431] Testing event pm_qos_update_request_timeout: OK [ 9.810420] Testing event pm_qos_remove_request: OK [ 9.840422] Testing event pm_qos_update_request: OK [ 9.870421] Testing event pm_qos_add_request: OK [ 9.900415] Testing event power_domain_target: OK [ 9.930434] Testing event clock_set_rate: OK [ 9.960423] Testing event clock_disable: OK [ 9.990429] Testing event clock_enable: OK [ 10.040396] Testing event wakeup_source_deactivate: OK [ 10.060461] Testing event wakeup_source_activate: OK [ 10.090447] Testing event suspend_resume: OK [ 10.120432] Testing event device_pm_callback_end: OK [ 10.150409] Testing event device_pm_callback_start: OK [ 10.180441] Testing event cpu_frequency: OK [ 10.210399] Testing event pstate_sample: OK [ 10.240428] Testing event cpu_idle: OK [ 10.270407] Testing event user_exit: OK [ 10.310408] Testing event user_enter: OK [ 10.340432] Testing event mm_filemap_add_to_page_cache: OK [ 10.370402] Testing event mm_filemap_delete_from_page_cache: OK [ 10.400431] Testing event oom_score_adj_update: OK [ 10.430406] Testing event mm_lru_activate: OK [ 10.460423] Testing event mm_lru_insertion: OK [ 10.490404] Testing event mm_vmscan_lru_shrink_inactive: OK [ 10.520425] Testing event mm_vmscan_writepage: OK [ 10.550435] Testing event mm_vmscan_memcg_isolate: OK [ 10.580427] Testing event mm_vmscan_lru_isolate: OK [ 10.610403] Testing event mm_shrink_slab_end: OK [ 10.640443] Testing event mm_shrink_slab_start: OK [ 10.670408] Testing event mm_vmscan_memcg_softlimit_reclaim_end: OK [ 10.700339] Testing event mm_vmscan_memcg_reclaim_end: OK [ 10.730348] Testing event mm_vmscan_direct_reclaim_end: OK [ 10.760348] Testing event mm_vmscan_memcg_softlimit_reclaim_begin: OK [ 10.800309] Testing event mm_vmscan_memcg_reclaim_begin: OK [ 10.820362] Testing event mm_vmscan_direct_reclaim_begin: OK [ 10.850347] Testing event mm_vmscan_wakeup_kswapd: OK [ 10.880439] Testing event mm_vmscan_kswapd_wake: OK [ 10.910343] Testing event mm_vmscan_kswapd_sleep: OK [ 10.940344] Testing event mm_page_alloc_extfrag: OK [ 10.970348] Testing event mm_page_pcpu_drain: OK [ 11.000393] Testing event mm_page_alloc_zone_locked: OK [ 11.030341] Testing event mm_page_alloc: OK [ 11.060477] Testing event mm_page_free_batched: OK [ 11.090342] Testing event mm_page_free: OK [ 11.120368] Testing event kmem_cache_free: OK [ 11.150320] Testing event kfree: OK [ 11.180350] Testing event kmem_cache_alloc_node: OK [ 11.210353] Testing event kmalloc_node: OK [ 11.240339] Testing event kmem_cache_alloc: OK [ 11.270525] Testing event kmalloc: OK [ 11.300396] Testing event mm_compaction_end: OK [ 11.330326] Testing event mm_compaction_begin: OK [ 11.360333] Testing event mm_compaction_migratepages: OK [ 11.390408] Testing event mm_compaction_isolate_freepages: OK [ 11.420357] Testing event mm_compaction_isolate_migratepages: OK [ 11.440359] Testing event mm_numa_migrate_ratelimit: OK [ 11.470317] Testing event mm_migrate_pages: OK [ 11.500414] Testing event writeback_single_inode: OK [ 11.530343] Testing event writeback_single_inode_start: OK [ 11.560351] Testing event writeback_wait_iff_congested: OK [ 11.590309] Testing event writeback_congestion_wait: OK [ 11.620328] Testing event writeback_sb_inodes_requeue: OK [ 11.650314] Testing event balance_dirty_pages: OK [ 11.680362] Testing event bdi_dirty_ratelimit: OK [ 11.710373] Testing event global_dirty_state: OK [ 11.740399] Testing event writeback_queue_io: OK [ 11.770351] Testing event wbc_writepage: OK [ 11.800373] Testing event writeback_bdi_unregister: OK [ 11.830385] Testing event writeback_bdi_register: OK [ 11.860393] Testing event writeback_wake_background: OK [ 11.890379] Testing event writeback_nowork: OK [ 11.920399] Testing event writeback_pages_written: OK [ 11.950428] Testing event writeback_wait: OK [ 11.980400] Testing event writeback_written: OK [ 12.010362] Testing event writeback_start: OK [ 12.040399] Testing event writeback_exec: OK [ 12.070374] Testing event writeback_queue: OK [ 12.100374] Testing event writeback_write_inode: OK [ 12.130350] Testing event writeback_write_inode_start: OK [ 12.160368] Testing event writeback_dirty_inode: OK [ 12.190368] Testing event writeback_dirty_inode_start: OK [ 12.220379] Testing event writeback_dirty_page: OK [ 12.250405] Testing event time_out_leases: OK [ 12.280413] Testing event generic_delete_lease: OK [ 12.310358] Testing event generic_add_lease: OK [ 12.340372] Testing event break_lease_unblock: OK [ 12.370348] Testing event break_lease_block: OK [ 12.410401] Testing event break_lease_noblock: OK [ 12.431212] Testing event jbd2_lock_buffer_stall: OK [ 12.461029] Testing event jbd2_write_superblock: OK [ 12.529236] Testing event jbd2_update_log_tail: OK [ 12.551358] Testing event jbd2_checkpoint_stats: OK [ 12.618446] Testing event jbd2_run_stats: OK [ 12.640739] Testing event jbd2_handle_stats: OK [ 12.670373] Testing event jbd2_handle_extend: OK [ 12.700944] Testing event jbd2_handle_start: OK [ 12.731611] Testing event jbd2_submit_inode_data: OK [ 12.801865] Testing event jbd2_end_commit: OK [ 12.830422] Testing event jbd2_drop_transaction: OK [ 12.861382] Testing event jbd2_commit_logging: OK [ 12.927694] Testing event jbd2_commit_flushing: OK [ 12.951951] Testing event jbd2_commit_locking: OK [ 13.031306] Testing event jbd2_start_commit: OK [ 13.100981] Testing event jbd2_checkpoint: OK [ 13.120387] Testing event nfs_sillyrename_unlink: OK [ 13.151517] Testing event nfs_sillyrename_rename: OK [ 13.217544] Testing event nfs_rename_exit: OK [ 13.241502] Testing event nfs_rename_enter: OK [ 13.270374] Testing event nfs_link_exit: OK [ 13.301394] Testing event nfs_link_enter: OK [ 13.330759] Testing event nfs_symlink_exit: OK [ 13.361411] Testing event nfs_symlink_enter: OK [ 13.391310] Testing event nfs_unlink_exit: OK [ 13.410367] Testing event nfs_unlink_enter: OK [ 13.440767] Testing event nfs_remove_exit: OK [ 13.470347] Testing event nfs_remove_enter: OK [ 13.491310] Testing event nfs_rmdir_exit: OK [ 13.546045] Testing event nfs_rmdir_enter: OK [ 13.572103] Testing event nfs_mkdir_exit: OK [ 13.590604] Testing event nfs_mkdir_enter: OK [ 13.660774] Testing event nfs_mknod_exit: OK [ 13.690725] Testing event nfs_mknod_enter: OK [ 13.721896] Testing event nfs_create_exit: OK [ 13.750474] Testing event nfs_create_enter: OK [ 13.770671] Testing event nfs_atomic_open_exit: OK [ 13.800766] Testing event nfs_atomic_open_enter: OK [ 13.871068] Testing event nfs_lookup_revalidate_exit: OK [ 13.892338] Testing event nfs_lookup_revalidate_enter: OK [ 13.953597] Testing event nfs_lookup_exit: OK [ 13.982009] Testing event nfs_lookup_enter: OK [ 14.011163] Testing event nfs_access_exit: OK [ 14.040346] Testing event nfs_access_enter: OK [ 14.071069] Testing event nfs_fsync_exit: OK [ 14.091045] Testing event nfs_fsync_enter: OK [ 14.180462] Testing event nfs_writeback_inode_exit: OK [ 14.200495] Testing event nfs_writeback_inode_enter: OK [ 14.230375] Testing event nfs_writeback_page_exit: OK [ 14.262437] Testing event nfs_writeback_page_enter: OK [ 14.280360] Testing event nfs_setattr_exit: OK [ 14.350346] Testing event nfs_setattr_enter: OK [ 14.370833] Testing event nfs_getattr_exit: OK [ 14.392048] Testing event nfs_getattr_enter: OK [ 14.420777] Testing event nfs_invalidate_mapping_exit: OK [ 14.450392] Testing event nfs_invalidate_mapping_enter: OK [ 14.471691] Testing event nfs_revalidate_inode_exit: OK [ 14.500408] Testing event nfs_revalidate_inode_enter: OK [ 14.521039] Testing event nfs_refresh_inode_exit: OK [ 14.583662] Testing event nfs_refresh_inode_enter: OK [ 14.611848] Testing event xfs_discard_busy: OK [ 14.680493] Testing event xfs_discard_exclude: OK [ 14.710539] Testing event xfs_discard_toosmall: OK [ 14.768802] Testing event xfs_discard_extent: OK [ 14.791464] Testing event xfs_log_recover_inode_skip: OK [ 14.822064] Testing event xfs_log_recover_inode_cancel: OK [ 14.850594] Testing event xfs_log_recover_inode_recover: OK [ 14.870439] Testing event xfs_log_recover_buf_dquot_buf: OK [ 14.938893] Testing event xfs_log_recover_buf_reg_buf: OK [ 14.961225] Testing event xfs_log_recover_buf_inode_buf: OK [ 15.090916] Testing event xfs_log_recover_buf_recover: OK [ 15.159603] Testing event xfs_log_recover_buf_cancel_ref_inc: OK [ 15.228385] Testing event xfs_log_recover_buf_cancel_add: OK [ 15.283465] Testing event xfs_log_recover_buf_cancel: OK [ 15.350618] Testing event xfs_log_recover_buf_not_cancel: OK [ 15.371161] Testing event xfs_log_recover_item_recover: OK [ 15.461168] Testing event xfs_log_recover_item_reorder_tail: OK [ 15.481718] Testing event xfs_log_recover_item_reorder_head: OK [ 15.502135] Testing event xfs_log_recover_item_add_cont: OK [ 15.568841] Testing event xfs_log_recover_item_add: OK [ 15.591257] Testing event xfs_swap_extent_after: OK [ 15.622738] Testing event xfs_swap_extent_before: OK [ 15.700582] Testing event xfs_dir2_leafn_moveents: OK [ 15.721327] Testing event xfs_dir2_shrink_inode: OK [ 15.750485] Testing event xfs_dir2_grow_inode: OK [ 15.781197] Testing event xfs_dir2_leafn_remove: OK [ 15.810553] Testing event xfs_dir2_leafn_add: OK [ 15.873797] Testing event xfs_da_path_shift: OK [ 15.901163] Testing event xfs_da_fixhashpath: OK [ 15.937512] Testing event xfs_da_shrink_inode: OK [ 15.994474] Testing event xfs_da_grow_inode: OK [ 16.021036] Testing event xfs_da_swap_lastblock: OK [ 16.090505] Testing event xfs_da_node_toosmall: OK [ 16.121359] Testing event xfs_da_node_unbalance: OK [ 16.150798] Testing event xfs_da_node_rebalance: OK [ 16.180691] Testing event xfs_da_node_remove: OK [ 16.212370] Testing event xfs_da_node_split: OK [ 16.241412] Testing event xfs_da_node_create: OK [ 16.270547] Testing event xfs_da_node_add: OK [ 16.300503] Testing event xfs_da_root_join: OK [ 16.330524] Testing event xfs_da_root_split: OK [ 16.360793] Testing event xfs_da_unlink_forward: OK [ 16.380420] Testing event xfs_da_unlink_back: OK [ 16.412229] Testing event xfs_da_link_after: OK [ 16.441352] Testing event xfs_da_link_before: OK [ 16.470757] Testing event xfs_da_join: OK [ 16.501318] Testing event xfs_da_split: OK [ 16.522302] Testing event xfs_attr_rmtval_remove: OK [ 16.550482] Testing event xfs_attr_rmtval_set: OK [ 16.621108] Testing event xfs_attr_rmtval_get: OK [ 16.694041] Testing event xfs_attr_refillstate: OK [ 16.710444] Testing event xfs_attr_fillstate: OK [ 16.730548] Testing event xfs_attr_node_removename: OK [ 16.760514] Testing event xfs_attr_node_replace: OK [ 16.790752] Testing event xfs_attr_node_lookup: OK [ 16.860782] Testing event xfs_attr_node_get: OK [ 16.940987] Testing event xfs_attr_node_addname: OK [ 16.961211] Testing event xfs_attr_leaf_toosmall: OK [ 16.990494] Testing event xfs_attr_leaf_unbalance: OK [ 17.010485] Testing event xfs_attr_leaf_rebalance: OK [ 17.030439] Testing event xfs_attr_leaf_to_node: OK [ 17.050982] Testing event xfs_attr_leaf_to_sf: OK [ 17.080817] Testing event xfs_attr_leaf_flipflags: OK [ 17.151261] Testing event xfs_attr_leaf_setflag: OK [ 17.180553] Testing event xfs_attr_leaf_clearflag: OK [ 17.200444] Testing event xfs_attr_leaf_split_after: OK [ 17.230715] Testing event xfs_attr_leaf_split_before: OK [ 17.260743] Testing event xfs_attr_leaf_split: OK [ 17.290587] Testing event xfs_attr_leaf_removename: OK [ 17.311196] Testing event xfs_attr_leaf_remove: OK [ 17.374143] Testing event xfs_attr_leaf_replace: OK [ 17.411081] Testing event xfs_attr_leaf_lookup: OK [ 17.430511] Testing event xfs_attr_leaf_get: OK [ 17.460402] Testing event xfs_attr_leaf_compact: OK [ 17.490429] Testing event xfs_attr_leaf_create: OK [ 17.520397] Testing event xfs_attr_leaf_addname: OK [ 17.550431] Testing event xfs_attr_leaf_add_work: OK [ 17.580397] Testing event xfs_attr_leaf_add_new: OK [ 17.610427] Testing event xfs_attr_leaf_add_old: OK [ 17.640395] Testing event xfs_attr_leaf_add: OK [ 17.670424] Testing event xfs_attr_sf_to_leaf: OK [ 17.700408] Testing event xfs_attr_sf_removename: OK [ 17.730418] Testing event xfs_attr_sf_remove: OK [ 17.760429] Testing event xfs_attr_sf_lookup: OK [ 17.790435] Testing event xfs_attr_sf_create: OK [ 17.820399] Testing event xfs_attr_sf_addname: OK [ 17.850417] Testing event xfs_attr_sf_add: OK [ 17.880396] Testing event xfs_dir2_node_to_leaf: OK [ 17.910419] Testing event xfs_dir2_node_removename: OK [ 17.940396] Testing event xfs_dir2_node_replace: OK [ 17.970437] Testing event xfs_dir2_node_lookup: OK [ 18.000397] Testing event xfs_dir2_node_addname: OK [ 18.030419] Testing event xfs_dir2_leaf_to_node: OK [ 18.060401] Testing event xfs_dir2_leaf_to_block: OK [ 18.090430] Testing event xfs_dir2_leaf_removename: OK [ 18.120406] Testing event xfs_dir2_leaf_replace: OK [ 18.150418] Testing event xfs_dir2_leaf_lookup: OK [ 18.180400] Testing event xfs_dir2_leaf_addname: OK [ 18.210421] Testing event xfs_dir2_block_to_leaf: OK [ 18.240398] Testing event xfs_dir2_block_to_sf: OK [ 18.270423] Testing event xfs_dir2_block_removename: OK [ 18.300399] Testing event xfs_dir2_block_replace: OK [ 18.330420] Testing event xfs_dir2_block_lookup: OK [ 18.360398] Testing event xfs_dir2_block_addname: OK [ 18.390419] Testing event xfs_dir2_sf_to_block: OK [ 18.420398] Testing event xfs_dir2_sf_toino8: OK [ 18.450439] Testing event xfs_dir2_sf_toino4: OK [ 18.480397] Testing event xfs_dir2_sf_removename: OK [ 18.510424] Testing event xfs_dir2_sf_replace: OK [ 18.540395] Testing event xfs_dir2_sf_lookup: OK [ 18.570427] Testing event xfs_dir2_sf_create: OK [ 18.600494] Testing event xfs_dir2_sf_addname: OK [ 18.630456] Testing event xfs_alloc_vextent_allfailed: OK [ 18.660442] Testing event xfs_alloc_vextent_loopfailed: OK [ 18.690419] Testing event xfs_alloc_vextent_noagbp: OK [ 18.720396] Testing event xfs_alloc_vextent_nofix: OK [ 18.750421] Testing event xfs_alloc_vextent_badargs: OK [ 18.780407] Testing event xfs_alloc_small_error: OK [ 18.810427] Testing event xfs_alloc_small_done: OK [ 18.840471] Testing event xfs_alloc_small_notenough: OK [ 18.870483] Testing event xfs_alloc_small_freelist: OK [ 18.900441] Testing event xfs_alloc_size_busy: OK [ 18.930423] Testing event xfs_alloc_size_error: OK [ 18.960405] Testing event xfs_alloc_size_done: OK [ 18.990445] Testing event xfs_alloc_size_nominleft: OK [ 19.020406] Testing event xfs_alloc_size_noentry: OK [ 19.050422] Testing event xfs_alloc_size_neither: OK [ 19.080397] Testing event xfs_alloc_near_busy: OK [ 19.110416] Testing event xfs_alloc_near_noentry: OK [ 19.140399] Testing event xfs_alloc_near_error: OK [ 19.170419] Testing event xfs_alloc_near_lesser: OK [ 19.200397] Testing event xfs_alloc_near_greater: OK [ 19.230420] Testing event xfs_alloc_near_first: OK [ 19.260397] Testing event xfs_alloc_near_nominleft: OK [ 19.290430] Testing event xfs_alloc_exact_error: OK [ 19.320398] Testing event xfs_alloc_exact_notfound: OK [ 19.350436] Testing event xfs_alloc_exact_done: OK [ 19.380407] Testing event xfs_free_extent: OK [ 19.410424] Testing event xfs_agf: OK [ 19.440455] Testing event xfs_trans_commit_lsn: OK [ 19.470445] Testing event xfs_extent_busy_trim: OK [ 19.500409] Testing event xfs_extent_busy_clear: OK [ 19.530424] Testing event xfs_extent_busy_reuse: OK [ 19.560403] Testing event xfs_extent_busy_force: OK [ 19.590427] Testing event xfs_extent_busy_enomem: OK [ 19.620399] Testing event xfs_extent_busy: OK [ 19.650455] Testing event xfs_bunmap: OK [ 19.680411] Testing event xfs_pagecache_inval: OK [ 19.710425] Testing event xfs_itruncate_extents_end: OK [ 19.740426] Testing event xfs_itruncate_extents_start: OK [ 19.770432] Testing event xfs_setfilesize: OK [ 19.800402] Testing event xfs_get_blocks_notfound: OK [ 19.830426] Testing event xfs_unwritten_convert: OK [ 19.860403] Testing event xfs_delalloc_enospc: OK [ 19.890421] Testing event xfs_get_blocks_alloc: OK [ 19.920428] Testing event xfs_get_blocks_found: OK [ 19.950451] Testing event xfs_map_blocks_alloc: OK [ 19.980430] Testing event xfs_map_blocks_found: OK [ 20.010490] Testing event xfs_invalidatepage: OK [ 20.040446] Testing event xfs_releasepage: OK [ 20.070454] Testing event xfs_writepage: OK [ 20.100413] Testing event xfs_file_splice_read: OK [ 20.130443] Testing event xfs_file_direct_write: OK [ 20.160410] Testing event xfs_file_buffered_write: OK [ 20.190430] Testing event xfs_file_read: OK [ 20.220415] Testing event xfs_log_assign_tail_lsn: OK [ 20.250433] Testing event xfs_ail_delete: OK [ 20.280405] Testing event xfs_ail_move: OK [ 20.310446] Testing event xfs_ail_insert: OK [ 20.340441] Testing event xfs_ail_flushing: OK [ 20.370455] Testing event xfs_ail_locked: OK [ 20.400408] Testing event xfs_ail_pinned: OK [ 20.430430] Testing event xfs_ail_push: OK [ 20.460408] Testing event xfs_log_force: OK [ 20.490432] Testing event xfs_log_ungrant_sub: OK [ 20.520416] Testing event xfs_log_ungrant_exit: OK [ 20.550445] Testing event xfs_log_ungrant_enter: OK [ 20.580413] Testing event xfs_log_regrant_reserve_sub: OK [ 20.610460] Testing event xfs_log_regrant_reserve_exit: OK [ 20.650428] Testing event xfs_log_regrant_reserve_enter: OK [ 20.680474] Testing event xfs_log_regrant_exit: OK [ 20.710419] Testing event xfs_log_regrant: OK [ 20.740434] Testing event xfs_log_reserve_exit: OK [ 20.770419] Testing event xfs_log_reserve: OK [ 20.800433] Testing event xfs_log_grant_wake_up: OK [ 20.830407] Testing event xfs_log_grant_wake: OK [ 20.860427] Testing event xfs_log_grant_sleep: OK [ 20.890422] Testing event xfs_log_umount_write: OK [ 20.920466] Testing event xfs_log_done_perm: OK [ 20.950420] Testing event xfs_log_done_nonperm: OK [ 20.980457] Testing event xfs_dqflush_done: OK [ 21.010462] Testing event xfs_dqflush_force: OK [ 21.040465] Testing event xfs_dqflush: OK [ 21.070447] Testing event xfs_dqrele: OK [ 21.100440] Testing event xfs_dqput_free: OK [ 21.130417] Testing event xfs_dqput_wait: OK [ 21.160430] Testing event xfs_dqput: OK [ 21.190413] Testing event xfs_dqget_dup: OK [ 21.220451] Testing event xfs_dqget_freeing: OK [ 21.250413] Testing event xfs_dqget_miss: OK [ 21.280427] Testing event xfs_dqget_hit: OK [ 21.310401] Testing event xfs_dqread_fail: OK [ 21.340419] Testing event xfs_dqread: OK [ 21.370407] Testing event xfs_dqtobp_read: OK [ 21.400429] Testing event xfs_dqalloc: OK [ 21.430456] Testing event xfs_dqattach_get: OK [ 21.460421] Testing event xfs_dqattach_found: OK [ 21.490411] Testing event xfs_dqreclaim_done: OK [ 21.520420] Testing event xfs_dqreclaim_busy: OK [ 21.557495] Testing event xfs_dqreclaim_dirty: OK [ 21.580430] Testing event xfs_dqreclaim_want: OK [ 21.610401] Testing event xfs_dqadjust: OK [ 21.640432] Testing event xfs_rename: OK [ 21.670410] Testing event xfs_symlink: OK [ 21.700431] Testing event xfs_create: OK [ 21.730402] Testing event xfs_lookup: OK [ 21.761575] Testing event xfs_link: OK [ 21.780426] Testing event xfs_remove: OK [ 21.811557] Testing event xfs_inode_unpin_nowait: OK [ 21.840421] Testing event xfs_inode_unpin: OK [ 21.870402] Testing event xfs_inode_pin: OK [ 21.900421] Testing event xfs_irele: OK [ 21.941539] Testing event xfs_ihold: OK [ 21.960360] Testing event xfs_iomap_prealloc_size: OK [ 21.990344] Testing event xfs_inode_free_eofblocks_invalid: OK [ 22.020359] Testing event xfs_inode_clear_eofblocks_tag: OK [ 22.050319] Testing event xfs_inode_set_eofblocks_tag: OK [ 22.080369] Testing event xfs_dquot_dqdetach: OK [ 22.110337] Testing event xfs_dquot_dqalloc: OK [ 22.140337] Testing event xfs_update_time: OK [ 22.170324] Testing event xfs_evict_inode: OK [ 22.200336] Testing event xfs_destroy_inode: OK [ 22.230337] Testing event xfs_file_fsync: OK [ 22.260359] Testing event xfs_dir_fsync: OK [ 22.290369] Testing event xfs_ioctl_setattr: OK [ 22.320373] Testing event xfs_file_compat_ioctl: OK [ 22.350343] Testing event xfs_file_ioctl: OK [ 22.380335] Testing event xfs_vm_bmap: OK [ 22.420315] Testing event xfs_get_acl: OK [ 22.440710] Testing event xfs_readdir: OK [ 22.471631] Testing event xfs_collapse_file_space: OK [ 22.491655] Testing event xfs_zero_file_space: OK [ 22.520399] Testing event xfs_free_file_space: OK [ 22.589740] Testing event xfs_alloc_file_space: OK [ 22.622131] Testing event xfs_inactive_symlink: OK [ 22.682946] Testing event xfs_readlink: OK [ 22.710425] Testing event xfs_setattr: OK [ 22.742361] Testing event xfs_getattr: OK [ 22.761561] Testing event xfs_iget_miss: OK [ 22.792301] Testing event xfs_iget_hit: OK [ 22.811427] Testing event xfs_iget_reclaim_fail: OK [ 22.831382] Testing event xfs_iget_reclaim: OK [ 22.852666] Testing event xfs_iget_skip: OK [ 22.870439] Testing event xfs_iunlock: OK [ 22.902031] Testing event xfs_ilock_demote: OK [ 22.922131] Testing event xfs_ilock_nowait: OK [ 22.941414] Testing event xfs_ilock: OK [ 22.961392] Testing event xfs_filestream_pick: OK [ 23.019606] Testing event xfs_filestream_scan: OK [ 23.051440] Testing event xfs_filestream_lookup: OK [ 23.071410] Testing event xfs_filestream_free: OK [ 23.091070] Testing event xfs_trans_buf_ordered: OK [ 23.121995] Testing event xfs_trans_binval: OK [ 23.140526] Testing event xfs_trans_bhold_release: OK [ 23.161034] Testing event xfs_trans_bhold: OK [ 23.191528] Testing event xfs_trans_bjoin: OK [ 23.211439] Testing event xfs_trans_brelse: OK [ 23.301082] Testing event xfs_trans_log_buf: OK [ 23.321090] Testing event xfs_trans_read_buf_recur: OK [ 23.352685] Testing event xfs_trans_read_buf: OK [ 23.371943] Testing event xfs_trans_getsb_recur: OK [ 23.392311] Testing event xfs_trans_getsb: OK [ 23.412093] Testing event xfs_trans_get_buf_recur: OK [ 23.465928] Testing event xfs_trans_get_buf: OK [ 23.542226] Testing event xfs_buf_item_push: OK [ 23.563206] Testing event xfs_buf_item_committed: OK [ 23.581151] Testing event xfs_buf_item_unlock_stale: OK [ 23.612261] Testing event xfs_buf_item_unlock: OK [ 23.666651] Testing event xfs_buf_item_unpin_stale: OK [ 23.683349] Testing event xfs_buf_item_unpin: OK [ 23.701555] Testing event xfs_buf_item_pin: OK [ 23.779698] Testing event xfs_buf_item_ordered: OK [ 23.811343] Testing event xfs_buf_item_format_stale: OK [ 23.840883] Testing event xfs_buf_item_format_ordered: OK [ 23.862345] Testing event xfs_buf_item_format: OK [ 23.883136] Testing event xfs_buf_item_size_stale: OK [ 23.901831] Testing event xfs_buf_item_size_ordered: OK [ 23.920909] Testing event xfs_buf_item_size: OK [ 23.951327] Testing event xfs_buf_ioerror: OK [ 24.018236] Testing event xfs_buf_read: OK [ 24.041020] Testing event xfs_buf_get: OK [ 24.111958] Testing event xfs_buf_find: OK [ 24.131594] Testing event xfs_inode_item_push: OK [ 24.152994] Testing event xfs_reset_dqcounts: OK [ 24.172135] Testing event xfs_da_btree_corrupt: OK [ 24.200769] Testing event xfs_btree_corrupt: OK [ 24.232496] Testing event xfs_trans_read_buf_shut: OK [ 24.250564] Testing event xfs_trans_read_buf_io: OK [ 24.281436] Testing event xfs_buf_wait_buftarg: OK [ 24.312086] Testing event xfs_buf_error_relse: OK [ 24.373862] Testing event xfs_buf_item_iodone_async: OK [ 24.401688] Testing event xfs_buf_item_iodone: OK [ 24.421736] Testing event xfs_buf_item_relse: OK [ 24.440625] Testing event xfs_bdstrat_shut: OK [ 24.472521] Testing event xfs_buf_get_uncached: OK [ 24.501439] Testing event xfs_buf_delwri_split: OK [ 24.533067] Testing event xfs_buf_delwri_queued: OK [ 24.552329] Testing event xfs_buf_delwri_queue: OK [ 24.615071] Testing event xfs_buf_iowait_done: OK [ 24.640641] Testing event xfs_buf_iowait: OK [ 24.671673] Testing event xfs_buf_unlock: OK [ 24.691613] Testing event xfs_buf_trylock: OK [ 24.711584] Testing event xfs_buf_lock_done: OK [ 24.742381] Testing event xfs_buf_lock: OK [ 24.762591] Testing event xfs_buf_bawrite: OK [ 24.781593] Testing event xfs_buf_iorequest: OK [ 24.801568] Testing event xfs_buf_iodone: OK [ 24.821720] Testing event xfs_buf_rele: OK [ 24.851789] Testing event xfs_buf_hold: OK [ 24.871877] Testing event xfs_buf_free: OK [ 24.892742] Testing event xfs_buf_init: OK [ 24.911561] Testing event xfs_extlist: OK [ 24.932221] Testing event xfs_bmap_post_update: OK [ 24.950812] Testing event xfs_bmap_pre_update: OK [ 25.016302] Testing event xfs_iext_remove: OK [ 25.041536] Testing event xfs_iext_insert: OK [ 25.071563] Testing event xfs_attr_list_node_descend: OK [ 25.092298] Testing event xfs_ialloc_read_agi: OK [ 25.110561] Testing event xfs_read_agi: OK [ 25.140818] Testing event xfs_alloc_read_agf: OK [ 25.172350] Testing event xfs_read_agf: OK [ 25.190438] Testing event xfs_perag_clear_eofblocks: OK [ 25.212447] Testing event xfs_perag_set_eofblocks: OK [ 25.232064] Testing event xfs_perag_clear_reclaim: OK [ 25.260452] Testing event xfs_perag_set_reclaim: OK [ 25.281898] Testing event xfs_perag_put: OK [ 25.302323] Testing event xfs_perag_get_tag: OK [ 25.356759] Testing event xfs_perag_get: OK [ 25.424528] Testing event xfs_attr_node_list: OK [ 25.485954] Testing event xfs_attr_leaf_list: OK [ 25.512861] Testing event xfs_attr_list_notfound: OK [ 25.541666] Testing event xfs_attr_list_wrong_blk: OK [ 25.562834] Testing event xfs_attr_list_add: OK [ 25.582397] Testing event xfs_attr_list_full: OK [ 25.635752] Testing event xfs_attr_list_leaf_end: OK [ 25.653125] Testing event xfs_attr_list_leaf: OK [ 25.671212] Testing event xfs_attr_list_sf_all: OK [ 25.701538] Testing event xfs_attr_list_sf: OK [ 25.722745] Testing event ocfs2_remove_block_from_cache: OK [ 25.741981] Testing event ocfs2_remove_metadata_tree: OK [ 25.762643] Testing event ocfs2_remove_metadata_array: OK [ 25.781670] Testing event ocfs2_set_buffer_uptodate_begin: OK [ 25.811458] Testing event ocfs2_set_buffer_uptodate: OK [ 25.842147] Testing event ocfs2_expand_cache: OK [ 25.861035] Testing event ocfs2_insert_cache_tree: OK [ 25.882892] Testing event ocfs2_append_cache_array: OK [ 25.943612] Testing event ocfs2_buffer_cached_end: OK [ 25.972390] Testing event ocfs2_buffer_cached_begin: OK [ 26.002244] Testing event ocfs2_metadata_cache_purge: OK [ 26.021557] Testing event ocfs2_purge_copied_metadata_tree: OK [ 26.041567] Testing event ocfs2_read_blocks_begin: OK [ 26.071927] Testing event ocfs2_write_block: OK [ 26.102181] Testing event ocfs2_read_blocks_end: OK [ 26.122514] Testing event ocfs2_read_blocks_bh: OK [ 26.140548] Testing event ocfs2_read_blocks_from_disk: OK [ 26.211240] Testing event ocfs2_read_blocks_sync_jbd: OK [ 26.242263] Testing event ocfs2_read_blocks_sync: OK [ 26.262749] Testing event ocfs2_wait_on_mount: OK [ 26.281560] Testing event ocfs2_recover_orphans_iput: OK [ 26.300416] Testing event ocfs2_recover_orphans: OK [ 26.331115] Testing event ocfs2_orphan_filldir: OK [ 26.350995] Testing event ocfs2_queue_orphan_scan_end: OK [ 26.382322] Testing event ocfs2_queue_orphan_scan_begin: OK [ 26.401387] Testing event ocfs2_mark_dead_nodes: OK [ 26.430440] Testing event ocfs2_recover_node_skip: OK [ 26.462814] Testing event ocfs2_recover_node: OK [ 26.480591] Testing event ocfs2_replay_journal_skip: OK [ 26.511694] Testing event ocfs2_replay_journal_lock_err: OK [ 26.541597] Testing event ocfs2_replay_journal_recovered: OK [ 26.603658] Testing event ocfs2_recovery_thread: OK [ 26.630930] Testing event ocfs2_recovery_thread_end: OK [ 26.662973] Testing event ocfs2_recovery_thread_node: OK [ 26.716436] Testing event ocfs2_complete_recovery_slot: OK [ 26.742698] Testing event ocfs2_complete_recovery_end: OK [ 26.762384] Testing event ocfs2_complete_recovery: OK [ 26.780514] Testing event ocfs2_journal_shutdown_wait: OK [ 26.811613] Testing event ocfs2_journal_shutdown: OK [ 26.833098] Testing event ocfs2_journal_init_maxlen: OK [ 26.892513] Testing event ocfs2_journal_init: OK [ 26.928697] Testing event ocfs2_journal_dirty: OK [ 26.940865] Testing event ocfs2_journal_access: OK [ 26.971585] Testing event ocfs2_allocate_extend_trans: OK [ 26.993276] Testing event ocfs2_extend_trans_restart: OK [ 27.011749] Testing event ocfs2_extend_trans: OK [ 27.030520] Testing event ocfs2_commit_cache_end: OK [ 27.061869] Testing event ocfs2_commit_cache_begin: OK [ 27.083258] Testing event ocfs2_encode_fh_type: OK [ 27.137963] Testing event ocfs2_encode_fh_parent: OK [ 27.161960] Testing event ocfs2_encode_fh_self: OK [ 27.183375] Testing event ocfs2_encode_fh_begin: OK [ 27.202381] Testing event ocfs2_get_parent_end: OK [ 27.222733] Testing event ocfs2_get_parent: OK [ 27.251609] Testing event ocfs2_get_dentry_end: OK [ 27.271576] Testing event ocfs2_get_dentry_generation: OK [ 27.292619] Testing event ocfs2_get_dentry_stale: OK [ 27.351624] Testing event ocfs2_get_dentry_test_bit: OK [ 27.381651] Testing event ocfs2_get_dentry_begin: OK [ 27.411580] Testing event ocfs2_dentry_attach_lock_found: OK [ 27.431645] Testing event ocfs2_dentry_attach_lock: OK [ 27.451940] Testing event ocfs2_find_local_alias: OK [ 27.471604] Testing event ocfs2_dentry_revalidate_ret: OK [ 27.491607] Testing event ocfs2_dentry_revalidate_nofsdata: OK [ 27.511596] Testing event ocfs2_dentry_revalidate_orphaned: OK [ 27.531599] Testing event ocfs2_dentry_revalidate_delete: OK [ 27.551608] Testing event ocfs2_dentry_revalidate_negative: OK [ 27.571608] Testing event ocfs2_dentry_revalidate: OK [ 27.591635] Testing event ocfs2_orphan_del: OK [ 27.611622] Testing event ocfs2_orphan_add_end: OK [ 27.631594] Testing event ocfs2_orphan_add_begin: OK [ 27.651607] Testing event ocfs2_blkno_stringify: OK [ 27.671623] Testing event ocfs2_symlink_begin: OK [ 27.691612] Testing event ocfs2_create_symlink_data: OK [ 27.711594] Testing event ocfs2_rename_over_existing: OK [ 27.731647] Testing event ocfs2_rename_disagree: OK [ 27.751612] Testing event ocfs2_rename_target_exists: OK [ 27.771652] Testing event ocfs2_rename_not_permitted: OK [ 27.791660] Testing event ocfs2_rename: OK [ 27.811668] Testing event ocfs2_double_lock_end: OK [ 27.831611] Testing event ocfs2_double_lock: OK [ 27.851617] Testing event ocfs2_unlink_noent: OK [ 27.871607] Testing event ocfs2_link: OK [ 27.891638] Testing event ocfs2_mknod: OK [ 27.911599] Testing event ocfs2_lookup_ret: OK [ 27.931619] Testing event ocfs2_mv_orphaned_inode_to_new: OK [ 27.951619] Testing event ocfs2_symlink_create: OK [ 27.971612] Testing event ocfs2_unlink: OK [ 27.991607] Testing event ocfs2_create: OK [ 28.011614] Testing event ocfs2_mkdir: OK [ 28.031602] Testing event ocfs2_lookup: OK [ 28.051610] Testing event ocfs2_prepare_dir_for_insert: OK [ 28.071608] Testing event ocfs2_dx_dir_rebalance_split: OK [ 28.091610] Testing event ocfs2_dx_dir_rebalance: OK [ 28.111616] Testing event ocfs2_extend_dir: OK [ 28.131637] Testing event ocfs2_dx_dir_index_root_block: OK [ 28.151627] Testing event ocfs2_dx_dir_format_cluster: OK [ 28.171606] Testing event ocfs2_dx_dir_attach_index: OK [ 28.191597] Testing event ocfs2_check_dir_for_entry: OK [ 28.211604] Testing event ocfs2_find_files_on_disk: OK [ 28.231600] Testing event ocfs2_readdir: OK [ 28.251601] Testing event ocfs2_delete_entry_dx: OK [ 28.271607] Testing event ocfs2_dx_dir_search_leaf_info: OK [ 28.291620] Testing event ocfs2_dx_dir_search: OK [ 28.311599] Testing event ocfs2_find_entry_el: OK [ 28.331616] Testing event ocfs2_validate_dir_block: OK [ 28.351633] Testing event ocfs2_search_dirblock: OK [ 28.371602] Testing event ocfs2_mark_dquot_dirty: OK [ 28.391607] Testing event ocfs2_acquire_dquot: OK [ 28.411592] Testing event ocfs2_release_dquot: OK [ 28.431603] Testing event ocfs2_write_dquot: OK [ 28.451615] Testing event ocfs2_sync_dquot_helper: OK [ 28.471608] Testing event ocfs2_sync_dquot: OK [ 28.491598] Testing event ocfs2_validate_quota_block: OK [ 28.511605] Testing event olq_set_dquot: OK [ 28.531598] Testing event ocfs2_finish_quota_recovery: OK [ 28.551607] Testing event ocfs2_recover_local_quota_file: OK [ 28.571601] Testing event ocfs2_resmap_claimed_bits_end: OK [ 28.591605] Testing event ocfs2_resmap_claimed_bits_begin: OK [ 28.611659] Testing event ocfs2_resmap_resv_bits: OK [ 28.631610] Testing event ocfs2_cannibalize_resv_end: OK [ 28.651638] Testing event ocfs2_cannibalize_resv_begin: OK [ 28.671597] Testing event ocfs2_resv_find_window_next: OK [ 28.691612] Testing event ocfs2_resv_find_window_prev: OK [ 28.711592] Testing event ocfs2_resv_find_window_begin: OK [ 28.731612] Testing event ocfs2_resmap_find_free_bits_end: OK [ 28.751649] Testing event ocfs2_resmap_find_free_bits_begin: OK [ 28.771621] Testing event ocfs2_resv_insert: OK [ 28.791677] Testing event ocfs2_reflink_xattr_rec: OK [ 28.811606] Testing event ocfs2_reflink_xattr_buckets: OK [ 28.831601] Testing event ocfs2_xattr_bucket_value_refcount: OK [ 28.851606] Testing event ocfs2_xattr_set_entry_index_block: OK [ 28.871611] Testing event ocfs2_xattr_set_entry_bucket: OK [ 28.891615] Testing event ocfs2_create_empty_xattr_block: OK [ 28.911606] Testing event ocfs2_reflink_xattr_header: OK [ 28.931633] Testing event ocfs2_rm_xattr_cluster: OK [ 28.951596] Testing event ocfs2_xattr_bucket_value_truncate: OK [ 28.971590] Testing event ocfs2_add_new_xattr_bucket: OK [ 28.991587] Testing event ocfs2_extend_xattr_bucket: OK [ 29.011579] Testing event ocfs2_add_new_xattr_cluster_insert: OK [ 29.031596] Testing event ocfs2_add_new_xattr_cluster: OK [ 29.051591] Testing event ocfs2_add_new_xattr_cluster_begin: OK [ 29.071585] Testing event ocfs2_adjust_xattr_cross_cluster: OK [ 29.091591] Testing event ocfs2_mv_xattr_buckets: OK [ 29.111582] Testing event ocfs2_cp_xattr_bucket: OK [ 29.131580] Testing event ocfs2_divide_xattr_bucket_move: OK [ 29.151580] Testing event ocfs2_divide_xattr_bucket_begin: OK [ 29.171587] Testing event ocfs2_mv_xattr_bucket_cross_cluster: OK [ 29.191588] Testing event ocfs2_defrag_xattr_bucket: OK [ 29.211582] Testing event ocfs2_xattr_create_index_block: OK [ 29.231582] Testing event ocfs2_xattr_create_index_block_begin: OK [ 29.251599] Testing event ocfs2_cp_xattr_block_to_bucket_end: OK [ 29.271581] Testing event ocfs2_cp_xattr_block_to_bucket_begin: OK [ 29.291590] Testing event ocfs2_iterate_xattr_bucket: OK [ 29.311605] Testing event ocfs2_iterate_xattr_buckets: OK [ 29.331590] Testing event ocfs2_xattr_index_block_find_rec: OK [ 29.351589] Testing event ocfs2_xattr_index_block_find: OK [ 29.371606] Testing event ocfs2_xattr_bucket_find: OK [ 29.391594] Testing event ocfs2_init_xattr_set_ctxt: OK [ 29.411589] Testing event ocfs2_xattr_extend_allocation: OK [ 29.431640] Testing event ocfs2_validate_xattr_block: OK [ 29.451591] Testing event ocfs2_initialize_super: OK [ 29.471598] Testing event ocfs2_dismount_volume: OK [ 29.491595] Testing event ocfs2_statfs: OK [ 29.511584] Testing event ocfs2_put_super: OK [ 29.531582] Testing event ocfs2_parse_options: OK [ 29.551595] Testing event ocfs2_fill_super: OK [ 29.571584] Testing event ocfs2_remount: OK [ 29.591586] Testing event ocfs2_do_node_down: OK [ 29.611589] Testing event ocfs2_find_slot: OK [ 29.631587] Testing event ocfs2_map_slot_buffers_block: OK [ 29.651592] Testing event ocfs2_map_slot_buffers: OK [ 29.671593] Testing event ocfs2_refresh_slot_info: OK [ 29.691605] Testing event ocfs2_read_virt_blocks: OK [ 29.711581] Testing event ocfs2_mark_inode_dirty: OK [ 29.731583] Testing event ocfs2_inode_revalidate: OK [ 29.751599] Testing event ocfs2_drop_inode: OK [ 29.771593] Testing event ocfs2_clear_inode: OK [ 29.791590] Testing event ocfs2_delete_inode: OK [ 29.811579] Testing event ocfs2_cleanup_delete_inode: OK [ 29.831587] Testing event ocfs2_query_inode_wipe_end: OK [ 29.851589] Testing event ocfs2_query_inode_wipe_succ: OK [ 29.871588] Testing event ocfs2_query_inode_wipe_begin: OK [ 29.891595] Testing event ocfs2_inode_is_valid_to_delete: OK [ 29.911583] Testing event ocfs2_validate_inode_block: OK [ 29.931586] Testing event ocfs2_check_orphan_recovery_state: OK [ 29.951602] Testing event ocfs2_read_locked_inode: OK [ 29.971585] Testing event ocfs2_populate_inode: OK [ 29.991583] Testing event ocfs2_find_actor: OK [ 30.011604] Testing event ocfs2_iget_end: OK [ 30.031594] Testing event ocfs2_iget5_locked: OK [ 30.051592] Testing event ocfs2_iget_begin: OK [ 30.071589] Testing event generic_file_aio_read_ret: OK [ 30.091585] Testing event ocfs2_prepare_inode_for_write: OK [ 30.111586] Testing event ocfs2_remove_inode_range: OK [ 30.131586] Testing event ocfs2_zero_partial_clusters_range2: OK [ 30.151607] Testing event ocfs2_zero_partial_clusters_range1: OK [ 30.171582] Testing event ocfs2_zero_partial_clusters: OK [ 30.191586] Testing event ocfs2_write_remove_suid: OK [ 30.211587] Testing event ocfs2_setattr: OK [ 30.231581] Testing event ocfs2_zero_extend: OK [ 30.251584] Testing event ocfs2_zero_extend_range: OK [ 30.271586] Testing event ocfs2_write_zero_page: OK [ 30.291594] Testing event ocfs2_extend_allocation_end: OK [ 30.311587] Testing event ocfs2_extend_allocation: OK [ 30.331581] Testing event ocfs2_truncate_file_error: OK [ 30.351588] Testing event ocfs2_truncate_file: OK [ 30.371588] Testing event ocfs2_file_aio_read: OK [ 30.391575] Testing event ocfs2_file_splice_read: OK [ 30.411590] Testing event ocfs2_file_splice_write: OK [ 30.431585] Testing event ocfs2_file_aio_write: OK [ 30.451590] Testing event ocfs2_sync_file: OK [ 30.471588] Testing event ocfs2_file_release: OK [ 30.491596] Testing event ocfs2_file_open: OK [ 30.511585] Testing event ocfs2_fault: OK [ 30.531584] Testing event ocfs2_write_end_inline: OK [ 30.551601] Testing event ocfs2_write_begin_nolock: OK [ 30.571589] Testing event ocfs2_try_to_write_inline_data: OK [ 30.591584] Testing event ocfs2_bmap: OK [ 30.611224] Testing event ocfs2_writepage: OK [ 30.631410] Testing event ocfs2_readpage: OK [ 30.657532] Testing event ocfs2_get_block_end: OK [ 30.671265] Testing event ocfs2_get_block: OK [ 30.691228] Testing event ocfs2_symlink_get_block: OK [ 30.711228] Testing event ocfs2_refcount_cow_hunk: OK [ 30.731275] Testing event ocfs2_make_clusters_writable: OK [ 30.751231] Testing event ocfs2_replace_clusters: OK [ 30.771227] Testing event ocfs2_clear_ext_refcount: OK [ 30.791300] Testing event ocfs2_duplicate_clusters_by_jbd: OK [ 30.811225] Testing event ocfs2_duplicate_clusters_by_page: OK [ 30.831224] Testing event ocfs2_lock_refcount_allocators: OK [ 30.851270] Testing event ocfs2_prepare_refcount_change_for_del: OK [ 30.871262] Testing event ocfs2_add_refcount_flag: OK [ 30.891283] Testing event ocfs2_calc_refcount_meta_credits_iterate: OK [ 30.911251] Testing event ocfs2_calc_refcount_meta_credits: OK [ 30.931393] Testing event ocfs2_mark_extent_refcounted: OK [ 30.951342] Testing event ocfs2_decrease_refcount: OK [ 30.971261] Testing event ocfs2_decrease_refcount_rec: OK [ 30.991234] Testing event ocfs2_restore_refcount_block: OK [ 31.011282] Testing event ocfs2_remove_refcount_extent: OK [ 31.031278] Testing event ocfs2_increase_refcount_split: OK [ 31.051404] Testing event ocfs2_increase_refcount_insert: OK [ 31.071391] Testing event ocfs2_increase_refcount_change: OK [ 31.091344] Testing event ocfs2_increase_refcount_begin: OK [ 31.111226] Testing event ocfs2_split_refcount_rec_insert: OK [ 31.131280] Testing event ocfs2_split_refcount_rec: OK [ 31.151257] Testing event ocfs2_insert_refcount_rec: OK [ 31.171224] Testing event ocfs2_new_leaf_refcount_block: OK [ 31.191393] Testing event ocfs2_divide_leaf_refcount_block: OK [ 31.211295] Testing event ocfs2_expand_inline_ref_root: OK [ 31.231224] Testing event ocfs2_change_refcount_rec: OK [ 31.251230] Testing event ocfs2_create_refcount_tree_blkno: OK [ 31.271224] Testing event ocfs2_create_refcount_tree: OK [ 31.291322] Testing event ocfs2_purge_refcount_trees: OK [ 31.311270] Testing event ocfs2_validate_refcount_block: OK [ 31.331252] Testing event ocfs2_test_inode_bit: OK [ 31.351229] Testing event ocfs2_test_suballoc_bit: OK [ 31.370376] Testing event ocfs2_get_suballoc_slot_bit: OK [ 31.390436] Testing event ocfs2_free_clusters: OK [ 31.410430] Testing event ocfs2_free_suballoc_bits: OK [ 31.430713] Testing event ocfs2_block_group_clear_bits: OK [ 31.450423] Testing event ocfs2_claim_new_inode_at_loc: OK [ 31.470388] Testing event ocfs2_claim_suballoc_bits: OK [ 31.490471] Testing event ocfs2_search_chain_end: OK [ 31.510384] Testing event ocfs2_search_chain_succ: OK [ 31.530369] Testing event ocfs2_search_chain_begin: OK [ 31.550389] Testing event ocfs2_block_group_search_max_block: OK [ 31.570451] Testing event ocfs2_cluster_group_search_max_block: OK [ 31.590410] Testing event ocfs2_cluster_group_search_wrong_max_bits: OK [ 31.610371] Testing event ocfs2_relink_block_group: OK [ 31.630402] Testing event ocfs2_block_group_set_bits: OK [ 31.650392] Testing event ocfs2_reserve_new_inode_new_group: OK [ 31.670373] Testing event ocfs2_reserve_suballoc_bits_no_new_group: OK [ 31.690423] Testing event ocfs2_reserve_suballoc_bits_nospc: OK [ 31.710373] Testing event ocfs2_block_group_alloc: OK [ 31.730409] Testing event ocfs2_block_group_alloc_discontig: OK [ 31.750411] Testing event ocfs2_block_group_alloc_contig: OK [ 31.770374] Testing event ocfs2_validate_group_descriptor: OK [ 31.790376] Testing event ocfs2_group_add: OK [ 31.810440] Testing event ocfs2_group_extend: OK [ 31.830385] Testing event ocfs2_update_last_group_and_inode: OK [ 31.850376] Testing event ocfs2_local_alloc_new_window_result: OK [ 31.870372] Testing event ocfs2_local_alloc_new_window: OK [ 31.890375] Testing event ocfs2_sync_local_to_main_free: OK [ 31.910396] Testing event ocfs2_sync_local_to_main: OK [ 31.930372] Testing event ocfs2_local_alloc_find_clear_bits: OK [ 31.950377] Testing event ocfs2_local_alloc_find_clear_bits_search_bitmap: OK [ 31.970372] Testing event ocfs2_local_alloc_count_bits: OK [ 31.990372] Testing event ocfs2_reserve_local_alloc_bits: OK [ 32.010441] Testing event ocfs2_begin_local_alloc_recovery: OK [ 32.030406] Testing event ocfs2_load_local_alloc: OK [ 32.050380] Testing event ocfs2_alloc_should_use_local: OK [ 32.070371] Testing event ocfs2_la_set_sizes: OK [ 32.090372] Testing event ocfs2_trim_fs: OK [ 32.110371] Testing event ocfs2_trim_group: OK [ 32.130373] Testing event ocfs2_trim_extent: OK [ 32.150392] Testing event ocfs2_cache_block_dealloc: OK [ 32.170372] Testing event ocfs2_run_deallocs: OK [ 32.190365] Testing event ocfs2_cache_cluster_dealloc: OK [ 32.210373] Testing event ocfs2_free_cached_blocks: OK [ 32.230406] Testing event ocfs2_complete_truncate_log_recovery: OK [ 32.250365] Testing event ocfs2_truncate_log_recovery_num: OK [ 32.270373] Testing event ocfs2_begin_truncate_log_recovery: OK [ 32.290442] Testing event ocfs2_flush_truncate_log: OK [ 32.310418] Testing event ocfs2_replay_truncate_records: OK [ 32.330418] Testing event ocfs2_truncate_log_append: OK [ 32.350414] Testing event ocfs2_mark_extent_written: OK [ 32.370384] Testing event ocfs2_add_clusters_in_btree_ret: OK [ 32.390373] Testing event ocfs2_rotate_leaf: OK [ 32.420919] Testing event ocfs2_validate_extent_block: OK [ 32.441300] Testing event ocfs2_commit_truncate: OK [ 32.470996] Testing event ocfs2_remove_extent: OK [ 32.500321] Testing event ocfs2_split_extent: OK [ 32.563472] Testing event ocfs2_insert_extent: OK [ 32.630371] Testing event ocfs2_rotate_subtree: OK [ 32.698863] Testing event ocfs2_grow_tree: OK [ 32.721584] Testing event ocfs2_complete_edge_insert: OK [ 32.775445] Testing event ocfs2_num_free_extents: OK [ 32.800484] Testing event ocfs2_add_clusters_in_btree: OK [ 32.871320] Testing event ocfs2_insert_extent_start: OK [ 32.901671] Testing event ocfs2_append_rec_to_path: OK [ 32.973875] Testing event ocfs2_rotate_tree_right: OK [ 32.990497] Testing event ocfs2_adjust_rightmost_branch: OK [ 33.020316] Testing event btrfs_workqueue_destroy: OK [ 33.052030] Testing event btrfs_workqueue_alloc: OK [ 33.071104] Testing event btrfs_ordered_sched: OK [ 33.141681] Testing event btrfs_all_work_done: OK [ 33.170608] Testing event btrfs_normal_work_done: OK [ 33.250431] Testing event btrfs_work_sched: OK [ 33.280320] Testing event btrfs_work_queued: OK [ 33.311232] Testing event free_extent_state: OK [ 33.380369] Testing event alloc_extent_state: OK [ 33.443509] Testing event btrfs_setup_cluster: OK [ 33.471050] Testing event btrfs_failed_cluster_setup: OK [ 33.492384] Testing event btrfs_find_cluster: OK [ 33.511407] Testing event btrfs_reserve_extent_cluster: OK [ 33.575872] Testing event btrfs_reserve_extent: OK [ 33.700607] Testing event find_free_extent: OK [ 33.721030] Testing event btrfs_reserved_extent_free: OK [ 33.750510] Testing event btrfs_reserved_extent_alloc: OK [ 33.830334] Testing event btrfs_space_reservation: OK [ 33.885034] Testing event btrfs_cow_block: OK [ 33.911368] Testing event btrfs_chunk_free: OK [ 33.980783] Testing event btrfs_chunk_alloc: OK [ 34.050959] Testing event run_delayed_ref_head: OK [ 34.080488] Testing event add_delayed_ref_head: OK [ 34.100721] Testing event run_delayed_data_ref: OK [ 34.167862] Testing event add_delayed_data_ref: OK [ 34.191870] Testing event run_delayed_tree_ref: OK [ 34.221821] Testing event add_delayed_tree_ref: OK [ 34.250998] Testing event btrfs_sync_fs: OK [ 34.318363] Testing event btrfs_sync_file: OK [ 34.341486] Testing event btrfs_writepage_end_io_hook: OK [ 34.370715] Testing event __extent_writepage: OK [ 34.424217] Testing event btrfs_ordered_extent_put: OK [ 34.500521] Testing event btrfs_ordered_extent_start: OK [ 34.520950] Testing event btrfs_ordered_extent_remove: OK [ 34.540389] Testing event btrfs_ordered_extent_add: OK [ 34.595111] Testing event btrfs_get_extent: OK [ 34.622307] Testing event btrfs_inode_evict: OK [ 34.641387] Testing event btrfs_inode_request: OK [ 34.670421] Testing event btrfs_inode_new: OK [ 34.690456] Testing event btrfs_transaction_commit: OK [ 34.720886] Testing event f2fs_issue_discard: OK [ 34.751350] Testing event f2fs_write_checkpoint: OK [ 34.876424] Testing event f2fs_submit_page_mbio: OK [ 34.928537] Testing event f2fs_writepages: OK [ 34.984328] Testing event f2fs_vm_page_mkwrite: OK [ 35.012429] Testing event f2fs_set_page_dirty: OK [ 35.041431] Testing event f2fs_readpage: OK [ 35.071478] Testing event f2fs_writepage: OK [ 35.100359] Testing event f2fs_write_end: OK [ 35.130372] Testing event f2fs_write_begin: OK [ 35.151182] Testing event f2fs_submit_read_bio: OK [ 35.171330] Testing event f2fs_submit_write_bio: OK [ 35.200986] Testing event f2fs_reserve_new_block: OK [ 35.230371] Testing event f2fs_fallocate: OK [ 35.307978] Testing event f2fs_get_victim: OK [ 35.330947] Testing event f2fs_get_data_block: OK [ 35.456088] Testing event f2fs_submit_page_bio: OK [ 35.470559] Testing event f2fs_truncate_partial_nodes: OK [ 35.490370] Testing event f2fs_truncate_node: OK [ 35.521156] Testing event f2fs_truncate_nodes_exit: OK [ 35.540849] Testing event f2fs_truncate_nodes_enter: OK [ 35.571044] Testing event f2fs_truncate_inode_blocks_exit: OK [ 35.629259] Testing event f2fs_truncate_inode_blocks_enter: OK [ 35.661152] Testing event f2fs_truncate_blocks_exit: OK [ 35.691507] Testing event f2fs_truncate_blocks_enter: OK [ 35.759076] Testing event f2fs_truncate_data_blocks_range: OK [ 35.831230] Testing event f2fs_truncate: OK [ 35.850977] Testing event f2fs_unlink_exit: OK [ 35.921991] Testing event f2fs_unlink_enter: OK [ 35.991722] Testing event f2fs_new_inode: OK [ 36.021012] Testing event f2fs_evict_inode: OK [ 36.040988] Testing event f2fs_iget_exit: OK [ 36.060773] Testing event f2fs_iget: OK [ 36.124008] Testing event f2fs_sync_fs: OK [ 36.150393] Testing event f2fs_sync_file_exit: OK [ 36.180365] Testing event f2fs_sync_file_enter: OK [ 36.211339] Testing event block_rq_remap: OK [ 36.280193] Testing event block_bio_remap: OK [ 36.317358] Testing event block_split: OK [ 36.340443] Testing event block_unplug: OK [ 36.373628] Testing event block_plug: OK [ 36.401566] Testing event block_sleeprq: OK [ 36.430684] Testing event block_getrq: OK [ 36.460469] Testing event block_bio_queue: OK [ 36.529825] Testing event block_bio_frontmerge: OK [ 36.561502] Testing event block_bio_backmerge: OK [ 36.630317] Testing event block_bio_complete: OK [ 36.661014] Testing event block_bio_bounce: OK [ 36.690485] Testing event block_rq_issue: OK [ 36.720457] Testing event block_rq_insert: OK [ 36.740405] Testing event block_rq_complete: OK [ 36.771052] Testing event block_rq_requeue: OK [ 36.822940] Testing event block_rq_abort: OK [ 36.887552] Testing event block_dirty_buffer: OK [ 36.910456] Testing event block_touch_buffer: OK [ 36.941265] Testing event swiotlb_bounced: OK [ 36.970473] Testing event regulator_set_voltage_complete: OK [ 37.043207] Testing event regulator_set_voltage: OK [ 37.070498] Testing event regulator_disable_complete: OK [ 37.140929] Testing event regulator_disable: OK [ 37.260317] Testing event regulator_enable_complete: OK [ 37.330321] Testing event regulator_enable_delay: OK [ 37.350831] Testing event regulator_enable: OK [ 37.381045] Testing event urandom_read: OK [ 37.411131] Testing event random_read: OK [ 37.430385] Testing event extract_entropy_user: OK [ 37.460392] Testing event extract_entropy: OK [ 37.490354] Testing event get_random_bytes_arch: OK [ 37.520362] Testing event get_random_bytes: OK [ 37.550345] Testing event xfer_secondary_pool: OK [ 37.580364] Testing event add_disk_randomness: OK [ 37.610367] Testing event add_input_randomness: OK [ 37.640359] Testing event debit_entropy: OK [ 37.670339] Testing event push_to_pool: OK [ 37.700369] Testing event credit_entropy_bits: OK [ 37.730337] Testing event mix_pool_bytes_nolock: OK [ 37.760390] Testing event mix_pool_bytes: OK [ 37.790346] Testing event add_device_randomness: OK [ 37.820407] Testing event drm_vblank_event_delivered: OK [ 37.850364] Testing event drm_vblank_event_queued: OK [ 37.880379] Testing event drm_vblank_event: OK [ 37.910340] Testing event regcache_drop_region: OK [ 37.940381] Testing event regmap_async_complete_done: OK [ 37.970345] Testing event regmap_async_complete_start: OK [ 38.000360] Testing event regmap_async_io_complete: OK [ 38.030320] Testing event regmap_async_write_start: OK [ 38.060340] Testing event regmap_cache_bypass: OK [ 38.090321] Testing event regmap_cache_only: OK [ 38.120359] Testing event regcache_sync: OK [ 38.150495] Testing event regmap_hw_write_done: OK [ 38.180376] Testing event regmap_hw_write_start: OK [ 38.210320] Testing event regmap_hw_read_done: OK [ 38.240338] Testing event regmap_hw_read_start: OK [ 38.270347] Testing event regmap_reg_read_cache: OK [ 38.300357] Testing event regmap_reg_read: OK [ 38.330341] Testing event regmap_reg_write: OK [ 38.360362] Testing event scsi_eh_wakeup: OK [ 38.390321] Testing event scsi_dispatch_cmd_timeout: OK [ 38.420337] Testing event scsi_dispatch_cmd_done: OK [ 38.450344] Testing event scsi_dispatch_cmd_error: OK [ 38.480358] Testing event scsi_dispatch_cmd_start: OK [ 38.510320] Testing event target_cmd_complete: OK [ 38.540362] Testing event target_sequencer_start: OK [ 38.570340] Testing event docg3_io: OK [ 38.600363] Testing event smbus_result: OK [ 38.630346] Testing event smbus_reply: OK [ 38.660372] Testing event smbus_read: OK [ 38.690338] Testing event smbus_write: OK [ 38.720364] Testing event i2c_result: OK [ 38.750340] Testing event i2c_reply: OK [ 38.780361] Testing event i2c_read: OK [ 38.810347] Testing event i2c_write: OK [ 38.840361] Testing event udp_fail_queue_rcv_skb: OK [ 38.870338] Testing event sock_exceed_buf_limit: OK [ 38.900359] Testing event sock_rcvqueue_full: OK [ 38.930335] Testing event napi_poll: OK [ 38.960366] Testing event netif_rx_ni_entry: OK [ 38.990337] Testing event netif_rx_entry: OK [ 39.020360] Testing event netif_receive_skb_entry: OK [ 39.050345] Testing event napi_gro_receive_entry: OK [ 39.080360] Testing event napi_gro_frags_entry: OK [ 39.110343] Testing event netif_rx: OK [ 39.140362] Testing event netif_receive_skb: OK [ 39.170341] Testing event net_dev_queue: OK [ 39.200360] Testing event net_dev_xmit: OK [ 39.230337] Testing event net_dev_start_xmit: OK [ 39.260361] Testing event skb_copy_datagram_iovec: OK [ 39.290343] Testing event consume_skb: OK [ 39.320358] Testing event kfree_skb: OK [ 39.350343] Testing event rpc_socket_shutdown: OK [ 39.380358] Testing event rpc_socket_close: OK [ 39.410339] Testing event rpc_socket_reset_connection: OK [ 39.440360] Testing event rpc_socket_error: OK [ 39.470341] Testing event rpc_socket_connect: OK [ 39.500362] Testing event rpc_socket_state_change: OK [ 39.530340] Testing event rpc_task_wakeup: OK [ 39.560361] Testing event rpc_task_sleep: OK [ 39.590345] Testing event rpc_task_complete: OK [ 39.620359] Testing event rpc_task_run_action: OK [ 39.650343] Testing event rpc_task_begin: OK [ 39.680361] Testing event rpc_connect_status: OK [ 39.710353] Testing event rpc_bind_status: OK [ 39.740359] Testing event rpc_call_status: OK [ 39.770338] Testing event cfg80211_stop_iface: OK [ 39.800361] Testing event cfg80211_ft_event: OK [ 39.830338] Testing event cfg80211_report_wowlan_wakeup: OK [ 39.860359] Testing event cfg80211_return_u32: OK [ 39.890339] Testing event cfg80211_return_uint: OK [ 39.920357] Testing event cfg80211_return_bss: OK [ 39.950344] Testing event cfg80211_inform_bss_width_frame: OK [ 39.980365] Testing event cfg80211_get_bss: OK [ 40.010341] Testing event cfg80211_sched_scan_stopped: OK [ 40.040373] Testing event cfg80211_sched_scan_results: OK [ 40.070360] Testing event cfg80211_scan_done: OK [ 40.100371] Testing event cfg80211_tdls_oper_request: OK [ 40.130339] Testing event cfg80211_report_obss_beacon: OK [ 40.160357] Testing event cfg80211_pmksa_candidate_notify: OK [ 40.190338] Testing event cfg80211_gtk_rekey_notify: OK [ 40.220359] Testing event cfg80211_cqm_pktloss_notify: OK [ 40.250345] Testing event cfg80211_probe_status: OK [ 40.280370] Testing event cfg80211_ibss_joined: OK [ 40.310336] Testing event cfg80211_rx_unexpected_4addr_frame: OK [ 40.340356] Testing event cfg80211_rx_spurious_frame: OK [ 40.370343] Testing event cfg80211_cac_event: OK [ 40.400358] Testing event cfg80211_radar_event: OK [ 40.430333] Testing event cfg80211_ch_switch_notify: OK [ 40.460357] Testing event cfg80211_chandef_dfs_required: OK [ 40.490339] Testing event cfg80211_reg_can_beacon: OK [ 40.520358] Testing event cfg80211_cqm_rssi_notify: OK [ 40.550340] Testing event cfg80211_mgmt_tx_status: OK [ 40.580337] Testing event cfg80211_rx_mgmt: OK [ 40.610317] Testing event cfg80211_del_sta: OK [ 40.640338] Testing event cfg80211_new_sta: OK [ 40.670353] Testing event cfg80211_ready_on_channel_expired: OK [ 40.700338] Testing event cfg80211_ready_on_channel: OK [ 40.730319] Testing event cfg80211_michael_mic_failure: OK [ 40.760340] Testing event cfg80211_send_assoc_timeout: OK [ 40.790495] Testing event cfg80211_send_auth_timeout: OK [ 40.820339] Testing event cfg80211_tx_mlme_mgmt: OK [ 40.850328] Testing event cfg80211_rx_mlme_mgmt: OK [ 40.880337] Testing event cfg80211_rx_unprot_mlme_mgmt: OK [ 40.910318] Testing event cfg80211_send_rx_assoc: OK [ 40.940342] Testing event cfg80211_send_rx_auth: OK [ 40.970323] Testing event cfg80211_notify_new_peer_candidate: OK [ 41.000338] Testing event cfg80211_return_bool: OK [ 41.030324] Testing event rdev_set_ap_chanwidth: OK [ 41.060338] Testing event rdev_set_qos_map: OK [ 41.090343] Testing event rdev_channel_switch: OK [ 41.120368] Testing event rdev_crit_proto_stop: OK [ 41.150361] Testing event rdev_crit_proto_start: OK [ 41.180369] Testing event rdev_update_ft_ies: OK [ 41.210364] Testing event rdev_set_mac_acl: OK [ 41.240379] Testing event rdev_stop_p2p_device: OK [ 41.270353] Testing event rdev_start_p2p_device: OK [ 41.300360] Testing event rdev_return_chandef: OK [ 41.330352] Testing event rdev_get_channel: OK [ 41.360421] Testing event rdev_get_et_strings: OK [ 41.410387] Testing event rdev_get_et_sset_count: OK [ 41.455159] Testing event rdev_set_noack_map: OK [ 41.470424] Testing event rdev_mgmt_tx: OK [ 41.500358] Testing event rdev_cancel_remain_on_channel: OK [ 41.530382] Testing event rdev_return_int_cookie: OK [ 41.570327] Testing event rdev_remain_on_channel: OK [ 41.590401] Testing event rdev_del_pmksa: OK [ 41.620365] Testing event rdev_set_pmksa: OK [ 41.655176] Testing event rdev_probe_client: OK [ 41.680350] Testing event rdev_tdls_oper: OK [ 41.710378] Testing event rdev_return_int_survey_info: OK [ 41.740368] Testing event rdev_dump_survey: OK [ 41.770376] Testing event rdev_tdls_mgmt: OK [ 41.810319] Testing event rdev_sched_scan_start: OK [ 41.830400] Testing event rdev_set_antenna: OK [ 41.860356] Testing event rdev_set_ringparam: OK [ 41.900381] Testing event rdev_return_void_tx_rx: OK [ 41.930366] Testing event rdev_return_int_tx_rx: OK [ 41.970322] Testing event rdev_mgmt_frame_register: OK [ 41.992409] Testing event rdev_set_bitrate_mask: OK [ 42.020379] Testing event rdev_return_int_int: OK [ 42.071282] Testing event rdev_set_tx_power: OK [ 42.090379] Testing event rdev_get_tx_power: OK [ 42.120355] Testing event rdev_set_wiphy_params: OK [ 42.150401] Testing event rdev_join_ibss: OK [ 42.190324] Testing event rdev_disconnect: OK [ 42.210370] Testing event rdev_set_cqm_txe_config: OK [ 42.240361] Testing event rdev_set_cqm_rssi_config: OK [ 42.280322] Testing event rdev_connect: OK [ 42.300368] Testing event rdev_set_power_mgmt: OK [ 42.330375] Testing event rdev_mgmt_tx_cancel_wait: OK [ 42.360398] Testing event rdev_disassoc: OK [ 42.390355] Testing event rdev_deauth: OK [ 42.421166] Testing event rdev_assoc: OK [ 42.451391] Testing event rdev_auth: OK [ 42.520464] Testing event rdev_set_monitor_channel: OK [ 42.590387] Testing event rdev_libertas_set_mesh_channel: OK [ 42.676402] Testing event rdev_set_txq_params: OK [ 42.700422] Testing event rdev_change_bss: OK [ 42.730343] Testing event rdev_join_mesh: OK [ 42.750627] Testing event rdev_update_mesh_config: OK [ 42.780368] Testing event rdev_return_int_mesh_config: OK [ 42.845161] Testing event rdev_return_int_mpath_info: OK [ 42.885122] Testing event rdev_dump_mpath: OK [ 42.901638] Testing event rdev_get_mpath: OK [ 42.931172] Testing event rdev_change_mpath: OK [ 42.961913] Testing event rdev_add_mpath: OK [ 42.996495] Testing event rdev_return_int_station_info: OK [ 43.021696] Testing event rdev_dump_station: OK [ 43.066476] Testing event rdev_set_wds_peer: OK [ 43.091122] Testing event rdev_del_mpath: OK [ 43.120371] Testing event rdev_get_station: OK [ 43.144779] Testing event rdev_del_station: OK [ 43.161117] Testing event rdev_change_station: OK [ 43.181078] Testing event rdev_add_station: OK [ 43.216003] Testing event rdev_flush_pmksa: OK [ 43.280904] Testing event rdev_leave_ibss: OK [ 43.307199] Testing event rdev_leave_mesh: OK [ 43.320377] Testing event rdev_get_mesh_config: OK [ 43.350366] Testing event rdev_set_rekey_data: OK [ 43.381235] Testing event rdev_sched_scan_stop: OK [ 43.400359] Testing event rdev_get_et_stats: OK [ 43.420362] Testing event rdev_stop_ap: OK [ 43.440374] Testing event rdev_change_beacon: OK [ 43.470435] Testing event rdev_start_ap: OK [ 43.491791] Testing event rdev_set_default_mgmt_key: OK [ 43.521801] Testing event rdev_set_default_key: OK [ 43.550539] Testing event rdev_del_key: OK [ 43.620600] Testing event rdev_get_key: OK [ 43.650347] Testing event rdev_add_key: OK [ 43.680919] Testing event rdev_change_virtual_intf: OK [ 43.705421] Testing event rdev_del_virtual_intf: OK [ 43.731305] Testing event rdev_return_wdev: OK [ 43.760486] Testing event rdev_add_virtual_intf: OK [ 43.802011] Testing event rdev_set_wakeup: OK [ 43.820947] Testing event rdev_rfkill_poll: OK [ 43.851191] Testing event rdev_get_antenna: OK [ 43.924473] Testing event rdev_get_ringparam: OK [ 43.942731] Testing event rdev_return_void: OK [ 43.970367] Testing event rdev_resume: OK [ 44.000821] Testing event rdev_scan: OK [ 44.031605] Testing event rdev_return_int: OK [ 44.071053] Testing event rdev_suspend: OK [ 44.100339] Testing event drv_channel_switch_beacon: OK [ 44.120569] Testing event api_radar_detected: OK [ 44.201859] Testing event drv_set_default_unicast_key: OK [ 44.221219] Testing event stop_queue: OK [ 44.250352] Testing event wake_queue: OK [ 44.286070] Testing event api_sta_set_buffered: OK [ 44.300802] Testing event api_eosp: OK [ 44.321417] Testing event api_enable_rssi_reports: OK [ 44.359526] Testing event api_gtk_rekey_notify: OK [ 44.415237] Testing event api_remain_on_channel_expired: OK [ 44.441018] Testing event api_ready_on_channel: OK [ 44.470336] Testing event api_chswitch_done: OK [ 44.532395] Testing event api_sta_block_awake: OK [ 44.560841] Testing event api_sched_scan_stopped: OK [ 44.591382] Testing event api_sched_scan_results: OK [ 44.630588] Testing event api_scan_completed: OK [ 44.690801] Testing event api_cqm_rssi_notify: OK [ 44.721170] Testing event api_connection_loss: OK [ 44.750513] Testing event api_beacon_loss: OK [ 44.780875] Testing event api_restart_hw: OK [ 44.811110] Testing event api_stop_tx_ba_cb: OK [ 44.840334] Testing event api_stop_tx_ba_session: OK [ 44.871240] Testing event api_start_tx_ba_cb: OK [ 44.904909] Testing event api_start_tx_ba_session: OK [ 44.930355] Testing event drv_get_expected_throughput: OK [ 44.962502] Testing event drv_leave_ibss: OK [ 45.001210] Testing event drv_join_ibss: OK [ 45.021150] Testing event drv_restart_complete: OK [ 45.050402] Testing event drv_stop_ap: OK [ 45.080400] Testing event drv_start_ap: OK [ 45.118431] Testing event drv_unassign_vif_chanctx: OK [ 45.141073] Testing event drv_assign_vif_chanctx: OK [ 45.160921] Testing event drv_switch_vif_chanctx: OK [ 45.195185] Testing event drv_change_chanctx: OK [ 45.220351] Testing event drv_remove_chanctx: OK [ 45.252076] Testing event drv_add_chanctx: OK [ 45.280634] Testing event drv_mgd_prepare_tx: OK [ 45.310356] Testing event drv_get_rssi: OK [ 45.340533] Testing event drv_allow_buffered_frames: OK [ 45.370356] Testing event drv_release_buffered_frames: OK [ 45.400767] Testing event drv_rssi_callback: OK [ 45.460640] Testing event drv_set_rekey_data: OK [ 45.540633] Testing event drv_set_bitrate_mask: OK [ 45.566658] Testing event drv_offchannel_tx_cancel_wait: OK [ 45.591245] Testing event drv_tx_frames_pending: OK [ 45.611984] Testing event drv_get_ringparam: OK [ 45.630473] Testing event drv_set_ringparam: OK [ 45.707411] Testing event drv_cancel_remain_on_channel: OK [ 45.731281] Testing event drv_remain_on_channel: OK [ 45.770316] Testing event drv_get_antenna: OK [ 45.793130] Testing event drv_set_antenna: OK [ 45.863006] Testing event drv_channel_switch: OK [ 45.891356] Testing event drv_flush: OK [ 45.920652] Testing event drv_get_survey: OK [ 46.008288] Testing event drv_ampdu_action: OK [ 46.020855] Testing event drv_tx_last_beacon: OK [ 46.050523] Testing event drv_reset_tsf: OK [ 46.080638] Testing event drv_set_tsf: OK [ 46.101146] Testing event drv_get_tsf: OK [ 46.130417] Testing event drv_conf_tx: OK [ 46.160504] Testing event drv_sta_pre_rcu_remove: OK [ 46.185128] Testing event drv_sta_remove: OK [ 46.211060] Testing event drv_sta_add: OK [ 46.240762] Testing event drv_sta_rc_update: OK [ 46.271398] Testing event drv_sta_state: OK [ 46.297312] Testing event drv_sta_notify: OK [ 46.351913] Testing event drv_set_coverage_class: OK [ 46.386069] Testing event drv_set_rts_threshold: OK [ 46.400506] Testing event drv_set_frag_threshold: OK [ 46.430882] Testing event drv_get_tkip_seq: OK [ 46.460376] Testing event drv_get_stats: OK [ 46.481462] Testing event drv_sw_scan_complete: OK [ 46.501645] Testing event drv_sw_scan_start: OK [ 46.579054] Testing event drv_sched_scan_stop: OK [ 46.607350] Testing event drv_sched_scan_start: OK [ 46.635999] Testing event drv_cancel_hw_scan: OK [ 46.651167] Testing event drv_hw_scan: OK [ 46.684841] Testing event drv_update_tkip_key: OK [ 46.774264] Testing event drv_set_key: OK [ 46.793803] Testing event drv_set_tim: OK [ 46.810514] Testing event drv_configure_filter: OK [ 46.840550] Testing event drv_prepare_multicast: OK [ 46.862464] Testing event drv_bss_info_changed: OK [ 46.892031] Testing event drv_config: OK [ 46.920816] Testing event drv_remove_interface: OK [ 46.950515] Testing event drv_change_interface: OK [ 46.990430] Testing event drv_add_interface: OK [ 47.020626] Testing event drv_stop: OK [ 47.106429] Testing event drv_set_wakeup: OK [ 47.120822] Testing event drv_resume: OK [ 47.152453] Testing event drv_suspend: OK [ 47.180433] Testing event drv_get_et_stats: OK [ 47.210681] Testing event drv_get_et_sset_count: OK [ 47.245670] Testing event drv_get_et_strings: OK [ 47.261621] Testing event drv_start: OK [ 47.290361] Testing event drv_return_u64: OK [ 47.365985] Testing event drv_return_u32: OK [ 47.381077] Testing event drv_return_bool: OK [ 47.430365] Testing event drv_return_int: OK [ 47.470356] Testing event drv_return_void: OK [ 47.500334] Testing event 9p_protocol_dump: OK [ 47.530350] Testing event 9p_client_res: OK [ 47.560333] Testing event 9p_client_req: OK [ 47.590352] Running tests on trace event systems: [ 47.591112] Testing event system 9p: OK [ 47.620366] Testing event system mac80211: OK [ 47.650498] Testing event system cfg80211: OK [ 47.680448] Testing event system sunrpc: OK [ 47.710382] Testing event system skb: OK [ 47.740358] Testing event system net: OK [ 47.770384] Testing event system napi: OK [ 47.800386] Testing event system sock: OK [ 47.830388] Testing event system udp: OK [ 47.860431] Testing event system i2c: OK [ 47.890394] Testing event system docg3: OK [ 47.920359] Testing event system target: OK [ 47.950389] Testing event system scsi: OK [ 47.980371] Testing event system regmap: OK [ 48.016456] Testing event system drm: OK [ 48.050361] Testing event system random: OK [ 48.080398] Testing event system regulator: OK [ 48.110370] Testing event system swiotlb: OK [ 48.140384] Testing event system block: OK [ 48.170378] Testing event system f2fs: OK [ 48.200450] Testing event system btrfs: OK [ 48.230390] Testing event system ocfs2: OK [ 48.260566] Testing event system xfs: OK [ 48.290559] Testing event system nfs: OK [ 48.320407] Testing event system jbd2: OK [ 48.350384] Testing event system filelock: OK [ 48.380383] Testing event system writeback: OK [ 48.410379] Testing event system migrate: OK [ 48.450339] Testing event system compaction: OK [ 48.470393] Testing event system kmem: OK [ 48.500374] Testing event system vmscan: OK [ 48.530397] Testing event system pagemap: OK [ 48.560364] Testing event system oom: OK [ 48.590385] Testing event system filemap: OK [ 48.620388] Testing event system context_tracking: OK [ 48.650443] Testing event system power: OK [ 48.680421] Testing event system test: OK [ 48.710409] Testing event system rcu: OK [ 48.740388] Testing event system printk: OK [ 48.770408] Testing event system lock: OK [ 48.800457] Testing event system sched: OK [ 48.830494] Testing event system workqueue: OK [ 48.860480] Testing event system signal: OK [ 48.900454] Testing event system timer: OK [ 48.930432] Testing event system irq: OK [ 48.960410] Testing event system task: OK [ 49.000497] Testing event system exceptions: OK [ 49.030426] Testing event system raw_syscalls: OK [ 49.060444] Testing event system vsyscall: OK [ 49.090533] Testing event system nmi: OK [ 49.120399] Testing event system irq_vectors: OK [ 49.150444] Testing event system kvmmmu: OK [ 49.180399] Testing event system kvm: OK [ 49.210453] Running tests on all trace events: [ 49.211202] Testing all events: OK [ 49.261464] Running tests again, along with the function tracer [ 49.262562] Running tests on trace events: [ 49.263411] Testing event kvm_async_pf_completed: OK [ 49.355077] Testing event kvm_async_pf_ready: OK [ 49.381039] Testing event kvm_async_pf_not_present: OK [ 49.410562] Testing event kvm_async_pf_doublefault: OK [ 49.440719] Testing event kvm_try_async_get_page: OK [ 49.470552] Testing event kvm_age_page: OK [ 49.500667] Testing event kvm_fpu: OK [ 49.530617] Testing event kvm_mmio: OK [ 49.560695] Testing event kvm_ack_irq: OK [ 49.590572] Testing event kvm_msi_set_irq: OK [ 49.620711] Testing event kvm_ioapic_set_irq: OK [ 49.650576] Testing event kvm_set_irq: OK [ 49.680720] Testing event kvm_userspace_exit: OK [ 49.710572] Testing event kvm_track_tsc: OK [ 49.740714] Testing event kvm_update_master_clock: OK [ 49.770590] Testing event kvm_write_tsc_offset: OK [ 49.800682] Testing event vcpu_match_mmio: OK [ 49.830605] Testing event kvm_emulate_insn: OK [ 49.860686] Testing event kvm_skinit: OK [ 49.890569] Testing event kvm_invlpga: OK [ 49.920691] Testing event kvm_nested_intr_vmexit: OK [ 49.950603] Testing event kvm_nested_vmexit_inject: OK [ 49.980691] Testing event kvm_nested_vmexit: OK [ 50.010565] Testing event kvm_nested_intercepts: OK [ 50.040741] Testing event kvm_nested_vmrun: OK [ 50.070620] Testing event kvm_pv_eoi: OK [ 50.150678] Testing event kvm_eoi: OK [ 50.180663] Testing event kvm_apic_accept_irq: OK [ 50.210555] Testing event kvm_apic_ipi: OK [ 50.240661] Testing event kvm_pic_set_irq: OK [ 50.270539] Testing event kvm_cr: OK [ 50.300647] Testing event kvm_msr: OK [ 50.330537] Testing event kvm_page_fault: OK [ 50.360671] Testing event kvm_inj_exception: OK [ 50.390573] Testing event kvm_inj_virq: OK [ 50.420651] Testing event kvm_exit: OK [ 50.450561] Testing event kvm_apic: OK [ 50.480651] Testing event kvm_cpuid: OK [ 50.510558] Testing event kvm_pio: OK [ 50.540705] Testing event kvm_hv_hypercall: OK [ 50.580566] Testing event kvm_hypercall: OK [ 50.610664] Testing event kvm_entry: OK [ 50.640592] Testing event check_mmio_spte: OK [ 50.670748] Testing event kvm_mmu_invalidate_zap_all_pages: OK [ 50.700646] Testing event fast_page_fault: OK [ 50.730695] Testing event handle_mmio_page_fault: OK [ 50.760563] Testing event mark_mmio_spte: OK [ 50.790658] Testing event kvm_mmu_prepare_zap_page: OK [ 50.820565] Testing event kvm_mmu_unsync_page: OK [ 50.850647] Testing event kvm_mmu_sync_page: OK [ 50.880497] Testing event kvm_mmu_get_page: OK [ 50.910647] Testing event kvm_mmu_walker_error: OK [ 50.940533] Testing event kvm_mmu_set_dirty_bit: OK [ 50.970609] Testing event kvm_mmu_set_accessed_bit: OK [ 51.000550] Testing event kvm_mmu_paging_element: OK [ 51.030610] Testing event kvm_mmu_pagetable_walk: OK [ 51.060526] Testing event thermal_apic_exit: OK [ 51.090608] Testing event thermal_apic_entry: OK [ 51.120570] Testing event threshold_apic_exit: OK [ 51.150607] Testing event threshold_apic_entry: OK [ 51.180528] Testing event call_function_single_exit: OK [ 51.210640] Testing event call_function_single_entry: OK [ 51.250539] Testing event call_function_exit: OK [ 51.280640] Testing event call_function_entry: OK [ 51.310566] Testing event irq_work_exit: OK [ 51.340604] Testing event irq_work_entry: OK [ 51.370510] Testing event x86_platform_ipi_exit: OK [ 51.400635] Testing event x86_platform_ipi_entry: OK [ 51.430590] Testing event error_apic_exit: OK [ 51.460639] Testing event error_apic_entry: OK [ 51.490536] Testing event spurious_apic_exit: OK [ 51.520672] Testing event spurious_apic_entry: OK [ 51.550548] Testing event reschedule_exit: OK [ 51.580646] Testing event reschedule_entry: OK [ 51.610500] Testing event local_timer_exit: OK [ 51.640682] Testing event local_timer_entry: OK [ 51.670535] Testing event nmi_handler: OK [ 51.700601] Testing event emulate_vsyscall: OK [ 51.730500] Testing event sys_exit: OK [ 51.760609] Testing event sys_enter: OK [ 51.790514] Testing event page_fault_kernel: OK [ 51.820601] Testing event page_fault_user: OK [ 51.860506] Testing event task_rename: OK [ 51.890634] Testing event task_newtask: OK [ 51.920506] Testing event softirq_raise: OK [ 51.950603] Testing event softirq_exit: OK [ 51.980526] Testing event softirq_entry: OK [ 52.010602] Testing event irq_handler_exit: OK [ 52.050513] Testing event irq_handler_entry: OK [ 52.080651] Testing event itimer_expire: OK [ 52.110511] Testing event itimer_state: OK [ 52.140601] Testing event hrtimer_cancel: OK [ 52.170532] Testing event hrtimer_expire_exit: OK [ 52.200637] Testing event hrtimer_expire_entry: OK [ 52.230504] Testing event hrtimer_start: OK [ 52.260598] Testing event hrtimer_init: OK [ 52.290499] Testing event timer_cancel: OK [ 52.320600] Testing event timer_expire_exit: OK [ 52.350545] Testing event timer_expire_entry: OK [ 52.380673] Testing event timer_start: OK [ 52.410534] Testing event timer_init: OK [ 52.440657] Testing event signal_deliver: OK [ 52.470837] Testing event signal_generate: OK [ 52.502868] Testing event workqueue_execute_end: OK [ 52.531655] Testing event workqueue_execute_start: OK [ 52.561070] Testing event workqueue_activate_work: OK [ 52.590601] Testing event workqueue_queue_work: OK [ 52.610734] Testing event sched_wake_idle_without_ipi: OK [ 52.641605] Testing event sched_swap_numa: OK [ 52.671032] Testing event sched_stick_numa: OK [ 52.691507] Testing event sched_move_numa: OK [ 52.711395] Testing event sched_pi_setprio: OK [ 52.731656] Testing event sched_stat_runtime: OK [ 52.761480] Testing event sched_stat_blocked: OK [ 52.791661] Testing event sched_stat_iowait: OK [ 52.810737] Testing event sched_stat_sleep: OK [ 52.841249] Testing event sched_stat_wait: OK [ 52.872791] Testing event sched_process_exec: OK [ 52.900691] Testing event sched_process_fork: OK [ 52.931680] Testing event sched_process_wait: OK [ 52.960573] Testing event sched_wait_task: OK [ 53.040701] Testing event sched_process_exit: OK [ 53.061204] Testing event sched_process_free: OK [ 53.091277] Testing event sched_migrate_task: OK [ 53.111996] Testing event sched_switch: OK [ 53.140843] Testing event sched_wakeup_new: OK [ 53.161556] Testing event sched_wakeup: OK [ 53.191248] Testing event sched_kthread_stop_ret: OK [ 53.220736] Testing event sched_kthread_stop: OK [ 53.240729] Testing event lock_release: OK [ 53.262664] Testing event lock_acquire: OK [ 53.291830] Testing event console: OK [ 53.321484] Testing event rcu_utilization: OK [ 53.351878] Testing event ftrace_test_filter: OK [ 53.428624] Testing event dev_pm_qos_remove_request: OK [ 53.451477] Testing event dev_pm_qos_update_request: OK [ 53.471679] Testing event dev_pm_qos_add_request: OK [ 53.506969] Testing event pm_qos_update_flags: OK [ 53.531704] Testing event pm_qos_update_target: OK [ 53.553203] Testing event pm_qos_update_request_timeout: OK [ 53.581651] Testing event pm_qos_remove_request: OK [ 53.611441] Testing event pm_qos_update_request: OK [ 53.631769] Testing event pm_qos_add_request: OK [ 53.651094] Testing event power_domain_target: OK [ 53.717574] Testing event clock_set_rate: OK [ 53.774233] Testing event clock_disable: OK [ 53.850469] Testing event clock_enable: OK [ 53.872235] Testing event wakeup_source_deactivate: OK [ 53.900554] Testing event wakeup_source_activate: OK [ 53.931076] Testing event suspend_resume: OK [ 53.961006] Testing event device_pm_callback_end: OK [ 53.981666] Testing event device_pm_callback_start: OK [ 54.010932] Testing event cpu_frequency: OK [ 54.031570] Testing event pstate_sample: OK [ 54.061219] Testing event cpu_idle: OK [ 54.080969] Testing event user_exit: OK [ 54.100746] Testing event user_enter: OK [ 54.131934] Testing event mm_filemap_add_to_page_cache: OK [ 54.161459] Testing event mm_filemap_delete_from_page_cache: OK [ 54.190548] Testing event oom_score_adj_update: OK [ 54.213490] Testing event mm_lru_activate: OK [ 54.241700] Testing event mm_lru_insertion: OK [ 54.271879] Testing event mm_vmscan_lru_shrink_inactive: OK [ 54.349184] Testing event mm_vmscan_writepage: OK [ 54.371270] Testing event mm_vmscan_memcg_isolate: OK [ 54.401527] Testing event mm_vmscan_lru_isolate: OK [ 54.420741] Testing event mm_shrink_slab_end: OK [ 54.451620] Testing event mm_shrink_slab_start: OK [ 54.483251] Testing event mm_vmscan_memcg_softlimit_reclaim_end: OK [ 54.510702] Testing event mm_vmscan_memcg_reclaim_end: OK [ 54.531840] Testing event mm_vmscan_direct_reclaim_end: OK [ 54.561471] Testing event mm_vmscan_memcg_softlimit_reclaim_begin: OK [ 54.591152] Testing event mm_vmscan_memcg_reclaim_begin: OK [ 54.610682] Testing event mm_vmscan_direct_reclaim_begin: OK [ 54.641533] Testing event mm_vmscan_wakeup_kswapd: OK [ 54.671504] Testing event mm_vmscan_kswapd_wake: OK [ 54.691804] Testing event mm_vmscan_kswapd_sleep: OK [ 54.720700] Testing event mm_page_alloc_extfrag: OK [ 54.750802] Testing event mm_page_pcpu_drain: OK [ 54.771933] Testing event mm_page_alloc_zone_locked: OK [ 54.801230] Testing event mm_page_alloc: OK [ 54.830967] Testing event mm_page_free_batched: OK [ 54.861998] Testing event mm_page_free: OK [ 54.891592] Testing event kmem_cache_free: OK [ 54.921038] Testing event kfree: OK [ 54.986378] Testing event kmem_cache_alloc_node: OK [ 55.011232] Testing event kmalloc_node: OK [ 55.031553] Testing event kmem_cache_alloc: OK [ 55.061448] Testing event kmalloc: OK [ 55.090718] Testing event mm_compaction_end: OK [ 55.110803] Testing event mm_compaction_begin: OK [ 55.140580] Testing event mm_compaction_migratepages: OK [ 55.170669] Testing event mm_compaction_isolate_freepages: OK [ 55.201064] Testing event mm_compaction_isolate_migratepages: OK [ 55.231187] Testing event mm_numa_migrate_ratelimit: OK [ 55.261331] Testing event mm_migrate_pages: OK [ 55.291710] Testing event writeback_single_inode: OK [ 55.321106] Testing event writeback_single_inode_start: OK [ 55.350961] Testing event writeback_wait_iff_congested: OK [ 55.381049] Testing event writeback_congestion_wait: OK [ 55.451519] Testing event writeback_sb_inodes_requeue: OK [ 55.471068] Testing event balance_dirty_pages: OK [ 55.500788] Testing event bdi_dirty_ratelimit: OK [ 55.521834] Testing event global_dirty_state: OK [ 55.541005] Testing event writeback_queue_io: OK [ 55.570955] Testing event wbc_writepage: OK [ 55.590965] Testing event writeback_bdi_unregister: OK [ 55.621635] Testing event writeback_bdi_register: OK [ 55.651750] Testing event writeback_wake_background: OK [ 55.681166] Testing event writeback_nowork: OK [ 55.712103] Testing event writeback_pages_written: OK [ 55.742075] Testing event writeback_wait: OK [ 55.760755] Testing event writeback_written: OK [ 55.780727] Testing event writeback_start: OK [ 55.811374] Testing event writeback_exec: OK [ 55.840837] Testing event writeback_queue: OK [ 55.904023] Testing event writeback_write_inode: OK [ 55.931935] Testing event writeback_write_inode_start: OK [ 55.960805] Testing event writeback_dirty_inode: OK [ 55.991193] Testing event writeback_dirty_inode_start: OK [ 56.011858] Testing event writeback_dirty_page: OK [ 56.040620] Testing event time_out_leases: OK [ 56.070612] Testing event generic_delete_lease: OK [ 56.091365] Testing event generic_add_lease: OK [ 56.110750] Testing event break_lease_unblock: OK [ 56.140674] Testing event break_lease_block: OK [ 56.170729] Testing event break_lease_noblock: OK [ 56.236144] Testing event jbd2_lock_buffer_stall: OK [ 56.301431] Testing event jbd2_write_superblock: OK [ 56.330626] Testing event jbd2_update_log_tail: OK [ 56.361030] Testing event jbd2_checkpoint_stats: OK [ 56.431577] Testing event jbd2_run_stats: OK [ 56.461882] Testing event jbd2_handle_stats: OK [ 56.481991] Testing event jbd2_handle_extend: OK [ 56.511403] Testing event jbd2_handle_start: OK [ 56.531696] Testing event jbd2_submit_inode_data: OK [ 56.562934] Testing event jbd2_end_commit: OK [ 56.590668] Testing event jbd2_drop_transaction: OK [ 56.621201] Testing event jbd2_commit_logging: OK [ 56.650716] Testing event jbd2_commit_flushing: OK [ 56.680782] Testing event jbd2_commit_locking: OK [ 56.711219] Testing event jbd2_start_commit: OK [ 56.742018] Testing event jbd2_checkpoint: OK [ 56.771145] Testing event nfs_sillyrename_unlink: OK [ 56.792657] Testing event nfs_sillyrename_rename: OK [ 56.820648] Testing event nfs_rename_exit: OK [ 56.850616] Testing event nfs_rename_enter: OK [ 56.904450] Testing event nfs_link_exit: OK [ 56.931266] Testing event nfs_link_enter: OK [ 56.950892] Testing event nfs_symlink_exit: OK [ 56.981090] Testing event nfs_symlink_enter: OK [ 57.011039] Testing event nfs_unlink_exit: OK [ 57.031728] Testing event nfs_unlink_enter: OK [ 57.061561] Testing event nfs_remove_exit: OK [ 57.080935] Testing event nfs_remove_enter: OK [ 57.111432] Testing event nfs_rmdir_exit: OK [ 57.142395] Testing event nfs_rmdir_enter: OK [ 57.171036] Testing event nfs_mkdir_exit: OK [ 57.201021] Testing event nfs_mkdir_enter: OK [ 57.231364] Testing event nfs_mknod_exit: OK [ 57.261255] Testing event nfs_mknod_enter: OK [ 57.290603] Testing event nfs_create_exit: OK [ 57.311073] Testing event nfs_create_enter: OK [ 57.340538] Testing event nfs_atomic_open_exit: OK [ 57.370646] Testing event nfs_atomic_open_enter: OK [ 57.400574] Testing event nfs_lookup_revalidate_exit: OK [ 57.422710] Testing event nfs_lookup_revalidate_enter: OK [ 57.460694] Testing event nfs_lookup_exit: OK [ 57.481712] Testing event nfs_lookup_enter: OK [ 57.511212] Testing event nfs_access_exit: OK [ 57.540626] Testing event nfs_access_enter: OK [ 57.560706] Testing event nfs_fsync_exit: OK [ 57.580720] Testing event nfs_fsync_enter: OK [ 57.600731] Testing event nfs_writeback_inode_exit: OK [ 57.630594] Testing event nfs_writeback_inode_enter: OK [ 57.660697] Testing event nfs_writeback_page_exit: OK [ 57.690609] Testing event nfs_writeback_page_enter: OK [ 57.720685] Testing event nfs_setattr_exit: OK [ 57.750572] Testing event nfs_setattr_enter: OK [ 57.780724] Testing event nfs_getattr_exit: OK [ 57.810586] Testing event nfs_getattr_enter: OK [ 57.840682] Testing event nfs_invalidate_mapping_exit: OK [ 57.870603] Testing event nfs_invalidate_mapping_enter: OK [ 57.900720] Testing event nfs_revalidate_inode_exit: OK [ 57.930596] Testing event nfs_revalidate_inode_enter: OK [ 57.960700] Testing event nfs_refresh_inode_exit: OK [ 57.990567] Testing event nfs_refresh_inode_enter: OK [ 58.020672] Testing event xfs_discard_busy: OK [ 58.050571] Testing event xfs_discard_exclude: OK [ 58.080725] Testing event xfs_discard_toosmall: OK [ 58.110579] Testing event xfs_discard_extent: OK [ 58.140683] Testing event xfs_log_recover_inode_skip: OK [ 58.170613] Testing event xfs_log_recover_inode_cancel: OK [ 58.200673] Testing event xfs_log_recover_inode_recover: OK [ 58.230626] Testing event xfs_log_recover_buf_dquot_buf: OK [ 58.260682] Testing event xfs_log_recover_buf_reg_buf: OK [ 58.290577] Testing event xfs_log_recover_buf_inode_buf: OK [ 58.320728] Testing event xfs_log_recover_buf_recover: OK [ 58.350569] Testing event xfs_log_recover_buf_cancel_ref_inc: OK [ 58.380677] Testing event xfs_log_recover_buf_cancel_add: OK [ 58.410568] Testing event xfs_log_recover_buf_cancel: OK [ 58.440729] Testing event xfs_log_recover_buf_not_cancel: OK [ 58.470612] Testing event xfs_log_recover_item_recover: OK [ 58.500680] Testing event xfs_log_recover_item_reorder_tail: OK [ 58.530639] Testing event xfs_log_recover_item_reorder_head: OK [ 58.560682] Testing event xfs_log_recover_item_add_cont: OK [ 58.590571] Testing event xfs_log_recover_item_add: OK [ 58.620734] Testing event xfs_swap_extent_after: OK [ 58.650568] Testing event xfs_swap_extent_before: OK [ 58.680705] Testing event xfs_dir2_leafn_moveents: OK [ 58.710565] Testing event xfs_dir2_shrink_inode: OK [ 58.740682] Testing event xfs_dir2_grow_inode: OK [ 58.770571] Testing event xfs_dir2_leafn_remove: OK [ 58.800718] Testing event xfs_dir2_leafn_add: OK [ 58.830611] Testing event xfs_da_path_shift: OK [ 58.860693] Testing event xfs_da_fixhashpath: OK [ 58.890629] Testing event xfs_da_shrink_inode: OK [ 58.926651] Testing event xfs_da_grow_inode: OK [ 58.970625] Testing event xfs_da_swap_lastblock: OK [ 59.000703] Testing event xfs_da_node_toosmall: OK [ 59.030638] Testing event xfs_da_node_unbalance: OK [ 59.060672] Testing event xfs_da_node_rebalance: OK [ 59.090573] Testing event xfs_da_node_remove: OK [ 59.120689] Testing event xfs_da_node_split: OK [ 59.150616] Testing event xfs_da_node_create: OK [ 59.180678] Testing event xfs_da_node_add: OK [ 59.210571] Testing event xfs_da_root_join: OK [ 59.240728] Testing event xfs_da_root_split: OK [ 59.270572] Testing event xfs_da_unlink_forward: OK [ 59.300729] Testing event xfs_da_unlink_back: OK [ 59.330621] Testing event xfs_da_link_after: OK [ 59.360714] Testing event xfs_da_link_before: OK [ 59.390617] Testing event xfs_da_join: OK [ 59.420757] Testing event xfs_da_split: OK [ 59.450633] Testing event xfs_attr_rmtval_remove: OK [ 59.480744] Testing event xfs_attr_rmtval_set: OK [ 59.510615] Testing event xfs_attr_rmtval_get: OK [ 59.540731] Testing event xfs_attr_refillstate: OK [ 59.570747] Testing event xfs_attr_fillstate: OK [ 59.600760] Testing event xfs_attr_node_removename: OK [ 59.630675] Testing event xfs_attr_node_replace: OK [ 59.660729] Testing event xfs_attr_node_lookup: OK [ 59.690629] Testing event xfs_attr_node_get: OK [ 59.720715] Testing event xfs_attr_node_addname: OK [ 59.750643] Testing event xfs_attr_leaf_toosmall: OK [ 59.780740] Testing event xfs_attr_leaf_unbalance: OK [ 59.810617] Testing event xfs_attr_leaf_rebalance: OK [ 59.840783] Testing event xfs_attr_leaf_to_node: OK [ 59.870618] Testing event xfs_attr_leaf_to_sf: OK [ 59.900718] Testing event xfs_attr_leaf_flipflags: OK [ 59.930642] Testing event xfs_attr_leaf_setflag: OK [ 59.960756] Testing event xfs_attr_leaf_clearflag: OK [ 59.990630] Testing event xfs_attr_leaf_split_after: OK [ 60.020718] Testing event xfs_attr_leaf_split_before: OK [ 60.050624] Testing event xfs_attr_leaf_split: OK [ 60.080727] Testing event xfs_attr_leaf_removename: OK [ 60.110700] Testing event xfs_attr_leaf_remove: OK [ 60.140775] Testing event xfs_attr_leaf_replace: OK [ 60.170609] Testing event xfs_attr_leaf_lookup: OK [ 60.200734] Testing event xfs_attr_leaf_get: OK [ 60.230625] Testing event xfs_attr_leaf_compact: OK [ 60.260725] Testing event xfs_attr_leaf_create: OK [ 60.290602] Testing event xfs_attr_leaf_addname: OK [ 60.320737] Testing event xfs_attr_leaf_add_work: OK [ 60.350647] Testing event xfs_attr_leaf_add_new: OK [ 60.380718] Testing event xfs_attr_leaf_add_old: OK [ 60.410600] Testing event xfs_attr_leaf_add: OK [ 60.440729] Testing event xfs_attr_sf_to_leaf: OK [ 60.470624] Testing event xfs_attr_sf_removename: OK [ 60.500731] Testing event xfs_attr_sf_remove: OK [ 60.530694] Testing event xfs_attr_sf_lookup: OK [ 60.560778] Testing event xfs_attr_sf_create: OK [ 60.590628] Testing event xfs_attr_sf_addname: OK [ 60.620751] Testing event xfs_attr_sf_add: OK [ 60.650619] Testing event xfs_dir2_node_to_leaf: OK [ 60.680734] Testing event xfs_dir2_node_removename: OK [ 60.710623] Testing event xfs_dir2_node_replace: OK [ 60.740777] Testing event xfs_dir2_node_lookup: OK [ 60.770605] Testing event xfs_dir2_node_addname: OK [ 60.800757] Testing event xfs_dir2_leaf_to_node: OK [ 60.830624] Testing event xfs_dir2_leaf_to_block: OK [ 60.860695] Testing event xfs_dir2_leaf_removename: OK [ 60.890691] Testing event xfs_dir2_leaf_replace: OK [ 60.920713] Testing event xfs_dir2_leaf_lookup: OK [ 60.950628] Testing event xfs_dir2_leaf_addname: OK [ 60.980718] Testing event xfs_dir2_block_to_leaf: OK [ 61.010659] Testing event xfs_dir2_block_to_sf: OK [ 61.040745] Testing event xfs_dir2_block_removename: OK [ 61.070586] Testing event xfs_dir2_block_replace: OK [ 61.100701] Testing event xfs_dir2_block_lookup: OK [ 61.130712] Testing event xfs_dir2_block_addname: OK [ 61.160781] Testing event xfs_dir2_sf_to_block: OK [ 61.200596] Testing event xfs_dir2_sf_toino8: OK [ 61.230716] Testing event xfs_dir2_sf_toino4: OK [ 61.260638] Testing event xfs_dir2_sf_removename: OK [ 61.290713] Testing event xfs_dir2_sf_replace: OK [ 61.320609] Testing event xfs_dir2_sf_lookup: OK [ 61.350780] Testing event xfs_dir2_sf_create: OK [ 61.380608] Testing event xfs_dir2_sf_addname: OK [ 61.410758] Testing event xfs_alloc_vextent_allfailed: OK [ 61.440632] Testing event xfs_alloc_vextent_loopfailed: OK [ 61.470733] Testing event xfs_alloc_vextent_noagbp: OK [ 61.500582] Testing event xfs_alloc_vextent_nofix: OK [ 61.530813] Testing event xfs_alloc_vextent_badargs: OK [ 61.560612] Testing event xfs_alloc_small_error: OK [ 61.590711] Testing event xfs_alloc_small_done: OK [ 61.620597] Testing event xfs_alloc_small_notenough: OK [ 61.650808] Testing event xfs_alloc_small_freelist: OK [ 61.680605] Testing event xfs_alloc_size_busy: OK [ 61.710720] Testing event xfs_alloc_size_error: OK [ 61.740630] Testing event xfs_alloc_size_done: OK [ 61.770720] Testing event xfs_alloc_size_nominleft: OK [ 61.800610] Testing event xfs_alloc_size_noentry: OK [ 61.830750] Testing event xfs_alloc_size_neither: OK [ 61.860609] Testing event xfs_alloc_near_busy: OK [ 61.890707] Testing event xfs_alloc_near_noentry: OK [ 61.920616] Testing event xfs_alloc_near_error: OK [ 61.950771] Testing event xfs_alloc_near_lesser: OK [ 61.980591] Testing event xfs_alloc_near_greater: OK [ 62.010684] Testing event xfs_alloc_near_first: OK [ 62.040587] Testing event xfs_alloc_near_nominleft: OK [ 62.070635] Testing event xfs_alloc_exact_error: OK [ 62.100594] Testing event xfs_alloc_exact_notfound: OK [ 62.130693] Testing event xfs_alloc_exact_done: OK [ 62.160584] Testing event xfs_free_extent: OK [ 62.190694] Testing event xfs_agf: OK [ 62.220535] Testing event xfs_trans_commit_lsn: OK [ 62.250680] Testing event xfs_extent_busy_trim: OK [ 62.290615] Testing event xfs_extent_busy_clear: OK [ 62.320634] Testing event xfs_extent_busy_reuse: [ 62.350087] rcu-torture: rtc: ffffffff8a8772c0 ver: 847 tfle: 0 rta: 847 rtaf: 0 rtf: 838 rtmbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 1533 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=100) barrier: 0/0:0 [ 62.350087] rcu-torture: Reader Pipe: 13439263 0 0 0 0 0 0 0 0 0 0 [ 62.350087] rcu-torture: Reader Batch: 13439263 0 0 0 0 0 0 0 0 0 0 [ 62.350087] rcu-torture: Free-Block Circulation: 846 846 845 844 843 842 841 840 839 838 0 [ 62.356590] OK [ 62.357035] Testing event xfs_extent_busy_force: OK [ 62.390702] Testing event xfs_extent_busy_enomem: OK [ 62.420602] Testing event xfs_extent_busy: OK [ 62.450637] Testing event xfs_bunmap: OK [ 62.491375] Testing event xfs_pagecache_inval: OK [ 62.522557] Testing event xfs_itruncate_extents_end: OK [ 62.540964] Testing event xfs_itruncate_extents_start: OK [ 62.573051] Testing event xfs_setfilesize: OK [ 62.593267] Testing event xfs_get_blocks_notfound: OK [ 62.611531] Testing event xfs_unwritten_convert: OK [ 62.641136] Testing event xfs_delalloc_enospc: OK [ 62.672630] Testing event xfs_get_blocks_alloc: OK [ 62.691458] Testing event xfs_get_blocks_found: OK [ 62.722387] Testing event xfs_map_blocks_alloc: OK [ 62.743363] Testing event xfs_map_blocks_found: OK [ 62.760647] Testing event xfs_invalidatepage: OK [ 62.793658] Testing event xfs_releasepage: OK [ 62.813726] Testing event xfs_writepage: OK [ 62.833221] Testing event xfs_file_splice_read: OK [ 62.860765] Testing event xfs_file_direct_write: OK [ 62.894061] Testing event xfs_file_buffered_write: OK [ 62.911173] Testing event xfs_file_read: OK [ 62.943246] Testing event xfs_log_assign_tail_lsn: OK [ 62.963439] Testing event xfs_ail_delete: OK [ 62.980831] Testing event xfs_ail_move: OK [ 63.012695] Testing event xfs_ail_insert: OK [ 63.032676] Testing event xfs_ail_flushing: OK [ 63.051360] Testing event xfs_ail_locked: OK [ 63.072128] Testing event xfs_ail_pinned: OK [ 63.101812] Testing event xfs_ail_push: OK [ 63.133425] Testing event xfs_log_force: OK [ 63.151796] Testing event xfs_log_ungrant_sub: OK [ 63.182525] Testing event xfs_log_ungrant_exit: OK [ 63.202888] Testing event xfs_log_ungrant_enter: OK [ 63.222519] Testing event xfs_log_regrant_reserve_sub: OK [ 63.250645] Testing event xfs_log_regrant_reserve_exit: OK [ 63.285546] Testing event xfs_log_regrant_reserve_enter: OK [ 63.347206] Testing event xfs_log_regrant_exit: OK [ 63.370784] Testing event xfs_log_regrant: OK [ 63.402327] Testing event xfs_log_reserve_exit: OK [ 63.433766] Testing event xfs_log_reserve: OK [ 63.452471] Testing event xfs_log_grant_wake_up: OK [ 63.472436] Testing event xfs_log_grant_wake: OK [ 63.500825] Testing event xfs_log_grant_sleep: OK [ 63.533464] Testing event xfs_log_umount_write: OK [ 63.550990] Testing event xfs_log_done_perm: OK [ 63.581203] Testing event xfs_log_done_nonperm: OK [ 63.613041] Testing event xfs_dqflush_done: OK [ 63.642444] Testing event xfs_dqflush_force: OK [ 63.663208] Testing event xfs_dqflush: OK [ 63.680899] Testing event xfs_dqrele: OK [ 63.711647] Testing event xfs_dqput_free: OK [ 63.742483] Testing event xfs_dqput_wait: OK [ 63.806919] Testing event xfs_dqput: OK [ 63.830499] Testing event xfs_dqget_dup: OK [ 63.862541] Testing event xfs_dqget_freeing: OK [ 63.883539] Testing event xfs_dqget_miss: OK [ 63.943546] Testing event xfs_dqget_hit: OK [ 63.970870] Testing event xfs_dqread_fail: OK [ 64.009158] Testing event xfs_dqread: OK [ 64.032610] Testing event xfs_dqtobp_read: OK [ 64.099973] Testing event xfs_dqalloc: OK [ 64.133264] Testing event xfs_dqattach_get: OK [ 64.152486] Testing event xfs_dqattach_found: OK [ 64.170675] Testing event xfs_dqreclaim_done: OK [ 64.203339] Testing event xfs_dqreclaim_busy: OK [ 64.222700] Testing event xfs_dqreclaim_dirty: OK [ 64.240727] Testing event xfs_dqreclaim_want: OK [ 64.272648] Testing event xfs_dqadjust: OK [ 64.293266] Testing event xfs_rename: OK [ 64.311561] Testing event xfs_symlink: OK [ 64.342713] Testing event xfs_create: OK [ 64.372534] Testing event xfs_lookup: OK [ 64.392923] Testing event xfs_link: OK [ 64.422598] Testing event xfs_remove: OK [ 64.444006] Testing event xfs_inode_unpin_nowait: OK [ 64.460729] Testing event xfs_inode_unpin: OK [ 64.482645] Testing event xfs_inode_pin: OK [ 64.501730] Testing event xfs_irele: OK [ 64.532483] Testing event xfs_ihold: OK [ 64.564230] Testing event xfs_iomap_prealloc_size: OK [ 64.581878] Testing event xfs_inode_free_eofblocks_invalid: OK [ 64.611264] Testing event xfs_inode_clear_eofblocks_tag: OK [ 64.642622] Testing event xfs_inode_set_eofblocks_tag: OK [ 64.673138] Testing event xfs_dquot_dqdetach: OK [ 64.693452] Testing event xfs_dquot_dqalloc: OK [ 64.713486] Testing event xfs_update_time: OK [ 64.730733] Testing event xfs_evict_inode: OK [ 64.811090] Testing event xfs_destroy_inode: OK [ 64.834113] Testing event xfs_file_fsync: OK [ 64.851840] Testing event xfs_dir_fsync: OK [ 64.880904] Testing event xfs_ioctl_setattr: OK [ 64.901191] Testing event xfs_file_compat_ioctl: OK [ 64.930620] Testing event xfs_file_ioctl: OK [ 64.961080] Testing event xfs_vm_bmap: OK [ 64.993496] Testing event xfs_get_acl: OK [ 65.011028] Testing event xfs_readdir: OK [ 65.031031] Testing event xfs_collapse_file_space: OK [ 65.062541] Testing event xfs_zero_file_space: OK [ 65.083124] Testing event xfs_free_file_space: OK [ 65.101441] Testing event xfs_alloc_file_space: OK [ 65.120832] Testing event xfs_inactive_symlink: OK [ 65.152588] Testing event xfs_readlink: OK [ 65.173821] Testing event xfs_setattr: OK [ 65.191325] Testing event xfs_getattr: OK [ 65.211380] Testing event xfs_iget_miss: OK [ 65.243347] Testing event xfs_iget_hit: OK [ 65.260758] Testing event xfs_iget_reclaim_fail: OK [ 65.282912] Testing event xfs_iget_reclaim: OK [ 65.313396] Testing event xfs_iget_skip: OK [ 65.332598] Testing event xfs_iunlock: OK [ 65.352642] Testing event xfs_ilock_demote: OK [ 65.413580] Testing event xfs_ilock_nowait: OK [ 65.442699] Testing event xfs_ilock: OK [ 65.471146] Testing event xfs_filestream_pick: OK [ 65.503008] Testing event xfs_filestream_scan: OK [ 65.520891] Testing event xfs_filestream_lookup: OK [ 65.551395] Testing event xfs_filestream_free: OK [ 65.570920] Testing event xfs_trans_buf_ordered: OK [ 65.602863] Testing event xfs_trans_binval: OK [ 65.621973] Testing event xfs_trans_bhold_release: OK [ 65.650826] Testing event xfs_trans_bhold: OK [ 65.683453] Testing event xfs_trans_bjoin: OK [ 65.701929] Testing event xfs_trans_brelse: OK [ 65.732847] Testing event xfs_trans_log_buf: OK [ 65.753875] Testing event xfs_trans_read_buf_recur: OK [ 65.770736] Testing event xfs_trans_read_buf: OK [ 65.802913] Testing event xfs_trans_getsb_recur: OK [ 65.823457] Testing event xfs_trans_getsb: OK [ 65.840762] Testing event xfs_trans_get_buf_recur: OK [ 65.861779] Testing event xfs_trans_get_buf: OK [ 65.893422] Testing event xfs_buf_item_push: OK [ 65.914532] Testing event xfs_buf_item_committed: OK [ 65.931187] Testing event xfs_buf_item_unlock_stale: OK [ 65.963189] Testing event xfs_buf_item_unlock: OK [ 65.982808] Testing event xfs_buf_item_unpin_stale: OK [ 66.013246] Testing event xfs_buf_item_unpin: OK [ 66.033759] Testing event xfs_buf_item_pin: OK [ 66.051324] Testing event xfs_buf_item_ordered: OK [ 66.071609] Testing event xfs_buf_item_format_stale: OK [ 66.103678] Testing event xfs_buf_item_format_ordered: OK [ 66.123216] Testing event xfs_buf_item_format: OK [ 66.150693] Testing event xfs_buf_item_size_stale: OK [ 66.182527] Testing event xfs_buf_item_size_ordered: OK [ 66.201895] Testing event xfs_buf_item_size: OK [ 66.231571] Testing event xfs_buf_ioerror: OK [ 66.263026] Testing event xfs_buf_read: OK [ 66.285001] Testing event xfs_buf_get: OK [ 66.300909] Testing event xfs_buf_find: OK [ 66.333623] Testing event xfs_inode_item_push: OK [ 66.350889] Testing event xfs_reset_dqcounts: OK [ 66.382784] Testing event xfs_da_btree_corrupt: OK [ 66.402965] Testing event xfs_btree_corrupt: OK [ 66.420755] Testing event xfs_trans_read_buf_shut: OK [ 66.452223] Testing event xfs_trans_read_buf_io: OK [ 66.483511] Testing event xfs_buf_wait_buftarg: OK [ 66.501542] Testing event xfs_buf_error_relse: OK [ 66.533388] Testing event xfs_buf_item_iodone_async: OK [ 66.553078] Testing event xfs_buf_item_iodone: OK [ 66.571150] Testing event xfs_buf_item_relse: OK [ 66.603323] Testing event xfs_bdstrat_shut: OK [ 66.622730] Testing event xfs_buf_get_uncached: OK [ 66.643758] Testing event xfs_buf_delwri_split: OK [ 66.661688] Testing event xfs_buf_delwri_queued: OK [ 66.693532] Testing event xfs_buf_delwri_queue: OK [ 66.713062] Testing event xfs_buf_iowait_done: OK [ 66.730696] Testing event xfs_buf_iowait: OK [ 66.762518] Testing event xfs_buf_unlock: OK [ 66.782971] Testing event xfs_buf_trylock: OK [ 66.802418] Testing event xfs_buf_lock_done: OK [ 66.823213] Testing event xfs_buf_lock: OK [ 66.840696] Testing event xfs_buf_bawrite: OK [ 66.870536] Testing event xfs_buf_iorequest: OK [ 66.902983] Testing event xfs_buf_iodone: OK [ 66.933023] Testing event xfs_buf_rele: OK [ 66.953665] Testing event xfs_buf_hold: OK [ 66.970710] Testing event xfs_buf_free: OK [ 67.003453] Testing event xfs_buf_init: OK [ 67.021967] Testing event xfs_extlist: OK [ 67.050524] Testing event xfs_bmap_post_update: OK [ 67.082490] Testing event xfs_bmap_pre_update: OK [ 67.100838] Testing event xfs_iext_remove: OK [ 67.132012] Testing event xfs_iext_insert: OK [ 67.162494] Testing event xfs_attr_list_node_descend: OK [ 67.180723] Testing event xfs_ialloc_read_agi: OK [ 67.211746] Testing event xfs_read_agi: OK [ 67.243117] Testing event xfs_alloc_read_agf: OK [ 67.261895] Testing event xfs_read_agf: OK [ 67.282583] Testing event xfs_perag_clear_eofblocks: OK [ 67.300725] Testing event xfs_perag_set_eofblocks: OK [ 67.331731] Testing event xfs_perag_clear_reclaim: OK [ 67.362549] Testing event xfs_perag_set_reclaim: OK [ 67.381353] Testing event xfs_perag_put: OK [ 67.412425] Testing event xfs_perag_get_tag: OK [ 67.433751] Testing event xfs_perag_get: OK [ 67.450886] Testing event xfs_attr_node_list: OK [ 67.490610] Testing event xfs_attr_leaf_list: OK [ 67.520592] Testing event xfs_attr_list_notfound: OK [ 67.550711] Testing event xfs_attr_list_wrong_blk: OK [ 67.570728] Testing event xfs_attr_list_add: OK [ 67.600562] Testing event xfs_attr_list_full: OK [ 67.630676] Testing event xfs_attr_list_leaf_end: OK [ 67.660563] Testing event xfs_attr_list_leaf: OK [ 67.690711] Testing event xfs_attr_list_sf_all: OK [ 67.720618] Testing event xfs_attr_list_sf: OK [ 67.750679] Testing event ocfs2_remove_block_from_cache: OK [ 67.780568] Testing event ocfs2_remove_metadata_tree: OK [ 67.810690] Testing event ocfs2_remove_metadata_array: OK [ 67.840668] Testing event ocfs2_set_buffer_uptodate_begin: OK [ 67.870751] Testing event ocfs2_set_buffer_uptodate: OK [ 67.900695] Testing event ocfs2_expand_cache: OK [ 67.930768] Testing event ocfs2_insert_cache_tree: OK [ 67.960635] Testing event ocfs2_append_cache_array: OK [ 67.990733] Testing event ocfs2_buffer_cached_end: OK [ 68.020666] Testing event ocfs2_buffer_cached_begin: OK [ 68.050726] Testing event ocfs2_metadata_cache_purge: OK [ 68.080635] Testing event ocfs2_purge_copied_metadata_tree: OK [ 68.110749] Testing event ocfs2_read_blocks_begin: OK [ 68.140648] Testing event ocfs2_write_block: OK [ 68.170729] Testing event ocfs2_read_blocks_end: OK [ 68.200616] Testing event ocfs2_read_blocks_bh: OK [ 68.230733] Testing event ocfs2_read_blocks_from_disk: OK [ 68.260734] Testing event ocfs2_read_blocks_sync_jbd: OK [ 68.290762] Testing event ocfs2_read_blocks_sync: OK [ 68.320590] Testing event ocfs2_wait_on_mount: OK [ 68.350734] Testing event ocfs2_recover_orphans_iput: OK [ 68.380615] Testing event ocfs2_recover_orphans: OK [ 68.410728] Testing event ocfs2_orphan_filldir: OK [ 68.440638] Testing event ocfs2_queue_orphan_scan_end: OK [ 68.470726] Testing event ocfs2_queue_orphan_scan_begin: OK [ 68.500609] Testing event ocfs2_mark_dead_nodes: OK [ 68.530750] Testing event ocfs2_recover_node_skip: OK [ 68.560633] Testing event ocfs2_recover_node: OK [ 68.590787] Testing event ocfs2_replay_journal_skip: OK [ 68.620666] Testing event ocfs2_replay_journal_lock_err: OK [ 68.650732] Testing event ocfs2_replay_journal_recovered: OK [ 68.680613] Testing event ocfs2_recovery_thread: OK [ 68.710788] Testing event ocfs2_recovery_thread_end: OK [ 68.740654] Testing event ocfs2_recovery_thread_node: OK [ 68.776914] Testing event ocfs2_complete_recovery_slot: OK [ 68.810679] Testing event ocfs2_complete_recovery_end: OK [ 68.840738] Testing event ocfs2_complete_recovery: OK [ 68.870678] Testing event ocfs2_journal_shutdown_wait: OK [ 68.900812] Testing event ocfs2_journal_shutdown: OK [ 68.930645] Testing event ocfs2_journal_init_maxlen: OK [ 68.960756] Testing event ocfs2_journal_init: OK [ 68.990668] Testing event ocfs2_journal_dirty: OK [ 69.020734] Testing event ocfs2_journal_access: OK [ 69.050655] Testing event ocfs2_allocate_extend_trans: OK [ 69.080746] Testing event ocfs2_extend_trans_restart: OK [ 69.110600] Testing event ocfs2_extend_trans: OK [ 69.140797] Testing event ocfs2_commit_cache_end: OK [ 69.170610] Testing event ocfs2_commit_cache_begin: OK [ 69.200785] Testing event ocfs2_encode_fh_type: OK [ 69.230620] Testing event ocfs2_encode_fh_parent: OK [ 69.260733] Testing event ocfs2_encode_fh_self: OK [ 69.290658] Testing event ocfs2_encode_fh_begin: OK [ 69.320728] Testing event ocfs2_get_parent_end: OK [ 69.350680] Testing event ocfs2_get_parent: OK [ 69.380746] Testing event ocfs2_get_dentry_end: OK [ 69.410615] Testing event ocfs2_get_dentry_generation: OK [ 69.440807] Testing event ocfs2_get_dentry_stale: OK [ 69.470676] Testing event ocfs2_get_dentry_test_bit: OK [ 69.500756] Testing event ocfs2_get_dentry_begin: OK [ 69.530615] Testing event ocfs2_dentry_attach_lock_found: OK [ 69.560790] Testing event ocfs2_dentry_attach_lock: OK [ 69.590694] Testing event ocfs2_find_local_alias: OK [ 69.620785] Testing event ocfs2_dentry_revalidate_ret: OK [ 69.650616] Testing event ocfs2_dentry_revalidate_nofsdata: OK [ 69.680755] Testing event ocfs2_dentry_revalidate_orphaned: OK [ 69.710615] Testing event ocfs2_dentry_revalidate_delete: OK [ 69.740770] Testing event ocfs2_dentry_revalidate_negative: OK [ 69.770615] Testing event ocfs2_dentry_revalidate: OK [ 69.800783] Testing event ocfs2_orphan_del: OK [ 69.830617] Testing event ocfs2_orphan_add_end: OK [ 69.860715] Testing event ocfs2_orphan_add_begin: OK [ 69.890641] Testing event ocfs2_blkno_stringify: OK [ 69.920732] Testing event ocfs2_symlink_begin: OK [ 69.950636] Testing event ocfs2_create_symlink_data: OK [ 69.980760] Testing event ocfs2_rename_over_existing: OK [ 70.010611] Testing event ocfs2_rename_disagree: OK [ 70.040809] Testing event ocfs2_rename_target_exists: OK [ 70.070576] Testing event ocfs2_rename_not_permitted: OK [ 70.100690] Testing event ocfs2_rename: OK [ 70.130591] Testing event ocfs2_double_lock_end: OK [ 70.160758] Testing event ocfs2_double_lock: OK [ 70.190579] Testing event ocfs2_unlink_noent: OK [ 70.220748] Testing event ocfs2_link: OK [ 70.252538] Testing event ocfs2_mknod: OK [ 70.280679] Testing event ocfs2_lookup_ret: OK [ 70.310572] Testing event ocfs2_mv_orphaned_inode_to_new: OK [ 70.340749] Testing event ocfs2_symlink_create: OK [ 70.370572] Testing event ocfs2_unlink: OK [ 70.400678] Testing event ocfs2_create: OK [ 70.430619] Testing event ocfs2_mkdir: OK [ 70.460681] Testing event ocfs2_lookup: OK [ 70.490579] Testing event ocfs2_prepare_dir_for_insert: OK [ 70.520687] Testing event ocfs2_dx_dir_rebalance_split: OK [ 70.550575] Testing event ocfs2_dx_dir_rebalance: OK [ 70.580659] Testing event ocfs2_extend_dir: OK [ 70.610548] Testing event ocfs2_dx_dir_index_root_block: OK [ 70.640646] Testing event ocfs2_dx_dir_format_cluster: OK [ 70.670551] Testing event ocfs2_dx_dir_attach_index: OK [ 70.700644] Testing event ocfs2_check_dir_for_entry: OK [ 70.730539] Testing event ocfs2_find_files_on_disk: OK [ 70.760738] Testing event ocfs2_readdir: OK [ 70.790577] Testing event ocfs2_delete_entry_dx: OK [ 70.820719] Testing event ocfs2_dx_dir_search_leaf_info: OK [ 70.850540] Testing event ocfs2_dx_dir_search: OK [ 70.880642] Testing event ocfs2_find_entry_el: OK [ 70.910541] Testing event ocfs2_validate_dir_block: OK [ 70.940640] Testing event ocfs2_search_dirblock: OK [ 70.970543] Testing event ocfs2_mark_dquot_dirty: OK [ 71.000641] Testing event ocfs2_acquire_dquot: OK [ 71.030541] Testing event ocfs2_release_dquot: OK [ 71.060698] Testing event ocfs2_write_dquot: OK [ 71.090573] Testing event ocfs2_sync_dquot_helper: OK [ 71.120653] Testing event ocfs2_sync_dquot: OK [ 71.150549] Testing event ocfs2_validate_quota_block: OK [ 71.180686] Testing event olq_set_dquot: OK [ 71.210580] Testing event ocfs2_finish_quota_recovery: OK [ 71.240763] Testing event ocfs2_recover_local_quota_file: OK [ 71.270541] Testing event ocfs2_resmap_claimed_bits_end: OK [ 71.300693] Testing event ocfs2_resmap_claimed_bits_begin: OK [ 71.330543] Testing event ocfs2_resmap_resv_bits: OK [ 71.360694] Testing event ocfs2_cannibalize_resv_end: OK [ 71.390539] Testing event ocfs2_cannibalize_resv_begin: OK [ 71.420708] Testing event ocfs2_resv_find_window_next: OK [ 71.450539] Testing event ocfs2_resv_find_window_prev: OK [ 71.480693] Testing event ocfs2_resv_find_window_begin: OK [ 71.510542] Testing event ocfs2_resmap_find_free_bits_end: OK [ 71.540685] Testing event ocfs2_resmap_find_free_bits_begin: OK [ 71.570575] Testing event ocfs2_resv_insert: OK [ 71.600646] Testing event ocfs2_reflink_xattr_rec: OK [ 71.630545] Testing event ocfs2_reflink_xattr_buckets: OK [ 71.660641] Testing event ocfs2_xattr_bucket_value_refcount: OK [ 71.690596] Testing event ocfs2_xattr_set_entry_index_block: OK [ 71.720683] Testing event ocfs2_xattr_set_entry_bucket: OK [ 71.750572] Testing event ocfs2_create_empty_xattr_block: OK [ 71.780681] Testing event ocfs2_reflink_xattr_header: OK [ 71.810539] Testing event ocfs2_rm_xattr_cluster: OK [ 71.840704] Testing event ocfs2_xattr_bucket_value_truncate: OK [ 71.870586] Testing event ocfs2_add_new_xattr_bucket: OK [ 71.900646] Testing event ocfs2_extend_xattr_bucket: OK [ 71.930548] Testing event ocfs2_add_new_xattr_cluster_insert: OK [ 71.960642] Testing event ocfs2_add_new_xattr_cluster: OK [ 71.990537] Testing event ocfs2_add_new_xattr_cluster_begin: OK [ 72.020644] Testing event ocfs2_adjust_xattr_cross_cluster: OK [ 72.050551] Testing event ocfs2_mv_xattr_buckets: OK [ 72.080644] Testing event ocfs2_cp_xattr_bucket: OK [ 72.110575] Testing event ocfs2_divide_xattr_bucket_move: OK [ 72.140692] Testing event ocfs2_divide_xattr_bucket_begin: OK [ 72.170572] Testing event ocfs2_mv_xattr_bucket_cross_cluster: OK [ 72.200693] Testing event ocfs2_defrag_xattr_bucket: OK [ 72.230587] Testing event ocfs2_xattr_create_index_block: OK [ 72.260744] Testing event ocfs2_xattr_create_index_block_begin: OK [ 72.290545] Testing event ocfs2_cp_xattr_block_to_bucket_end: OK [ 72.320641] Testing event ocfs2_cp_xattr_block_to_bucket_begin: OK [ 72.350560] Testing event ocfs2_iterate_xattr_bucket: OK [ 72.380641] Testing event ocfs2_iterate_xattr_buckets: OK [ 72.410548] Testing event ocfs2_xattr_index_block_find_rec: OK [ 72.440695] Testing event ocfs2_xattr_index_block_find: OK [ 72.480489] Testing event ocfs2_xattr_bucket_find: OK [ 72.501135] Testing event ocfs2_init_xattr_set_ctxt: OK [ 72.531271] Testing event ocfs2_xattr_extend_allocation: OK [ 72.611259] Testing event ocfs2_validate_xattr_block: OK [ 72.630675] Testing event ocfs2_initialize_super: OK [ 72.650808] Testing event ocfs2_dismount_volume: OK [ 72.682624] Testing event ocfs2_statfs: OK [ 72.712234] Testing event ocfs2_put_super: OK [ 72.740719] Testing event ocfs2_parse_options: OK [ 72.770544] Testing event ocfs2_fill_super: OK [ 72.801279] Testing event ocfs2_remount: OK [ 72.830592] Testing event ocfs2_do_node_down: OK [ 72.861459] Testing event ocfs2_find_slot: OK [ 72.891177] Testing event ocfs2_map_slot_buffers_block: OK [ 72.911139] Testing event ocfs2_map_slot_buffers: OK [ 72.940816] Testing event ocfs2_refresh_slot_info: OK [ 72.970819] Testing event ocfs2_read_virt_blocks: OK [ 73.000666] Testing event ocfs2_mark_inode_dirty: OK [ 73.031430] Testing event ocfs2_inode_revalidate: OK [ 73.061759] Testing event ocfs2_drop_inode: OK [ 73.092349] Testing event ocfs2_clear_inode: OK [ 73.121197] Testing event ocfs2_delete_inode: OK [ 73.191623] Testing event ocfs2_cleanup_delete_inode: OK [ 73.221580] Testing event ocfs2_query_inode_wipe_end: OK [ 73.242028] Testing event ocfs2_query_inode_wipe_succ: OK [ 73.270927] Testing event ocfs2_query_inode_wipe_begin: OK [ 73.290956] Testing event ocfs2_inode_is_valid_to_delete: OK [ 73.320585] Testing event ocfs2_validate_inode_block: OK [ 73.351538] Testing event ocfs2_check_orphan_recovery_state: OK [ 73.381374] Testing event ocfs2_read_locked_inode: OK [ 73.451535] Testing event ocfs2_populate_inode: OK [ 73.480665] Testing event ocfs2_find_actor: OK [ 73.510547] Testing event ocfs2_iget_end: OK [ 73.530950] Testing event ocfs2_iget5_locked: OK [ 73.560724] Testing event ocfs2_iget_begin: OK [ 73.582069] Testing event generic_file_aio_read_ret: OK [ 73.660477] Testing event ocfs2_prepare_inode_for_write: OK [ 73.681319] Testing event ocfs2_remove_inode_range: OK [ 73.710631] Testing event ocfs2_zero_partial_clusters_range2: OK [ 73.740758] Testing event ocfs2_zero_partial_clusters_range1: OK [ 73.760733] Testing event ocfs2_zero_partial_clusters: OK [ 73.790546] Testing event ocfs2_write_remove_suid: OK [ 73.812120] Testing event ocfs2_setattr: OK [ 73.874222] Testing event ocfs2_zero_extend: OK [ 73.900945] Testing event ocfs2_zero_extend_range: OK [ 73.981827] Testing event ocfs2_write_zero_page: OK [ 74.046198] Testing event ocfs2_extend_allocation_end: OK [ 74.061233] Testing event ocfs2_extend_allocation: OK [ 74.090616] Testing event ocfs2_truncate_file_error: OK [ 74.111307] Testing event ocfs2_truncate_file: OK [ 74.140679] Testing event ocfs2_file_aio_read: OK [ 74.171779] Testing event ocfs2_file_splice_read: OK [ 74.191614] Testing event ocfs2_file_splice_write: OK [ 74.220895] Testing event ocfs2_file_aio_write: OK [ 74.251167] Testing event ocfs2_sync_file: OK [ 74.281630] Testing event ocfs2_file_release: OK [ 74.310999] Testing event ocfs2_file_open: OK [ 74.347039] Testing event ocfs2_fault: OK [ 74.371209] Testing event ocfs2_write_end_inline: OK [ 74.400545] Testing event ocfs2_write_begin_nolock: OK [ 74.421002] Testing event ocfs2_try_to_write_inline_data: OK [ 74.491298] Testing event ocfs2_bmap: OK [ 74.522335] Testing event ocfs2_writepage: OK [ 74.550838] Testing event ocfs2_readpage: OK [ 74.573366] Testing event ocfs2_get_block_end: OK [ 74.639781] Testing event ocfs2_get_block: OK [ 74.670690] Testing event ocfs2_symlink_get_block: OK [ 74.690714] Testing event ocfs2_refcount_cow_hunk: OK [ 74.721723] Testing event ocfs2_make_clusters_writable: OK [ 74.752497] Testing event ocfs2_replace_clusters: OK [ 74.809636] Testing event ocfs2_clear_ext_refcount: OK [ 74.842318] Testing event ocfs2_duplicate_clusters_by_jbd: OK [ 74.870775] Testing event ocfs2_duplicate_clusters_by_page: OK [ 74.901558] Testing event ocfs2_lock_refcount_allocators: OK [ 74.980594] Testing event ocfs2_prepare_refcount_change_for_del: OK [ 75.000776] Testing event ocfs2_add_refcount_flag: OK [ 75.070560] Testing event ocfs2_calc_refcount_meta_credits_iterate: OK [ 75.101311] Testing event ocfs2_calc_refcount_meta_credits: OK [ 75.130865] Testing event ocfs2_mark_extent_refcounted: OK [ 75.161908] Testing event ocfs2_decrease_refcount: OK [ 75.181564] Testing event ocfs2_decrease_refcount_rec: OK [ 75.210602] Testing event ocfs2_restore_refcount_block: OK [ 75.242077] Testing event ocfs2_remove_refcount_extent: OK [ 75.270748] Testing event ocfs2_increase_refcount_split: OK [ 75.301601] Testing event ocfs2_increase_refcount_insert: OK [ 75.330613] Testing event ocfs2_increase_refcount_change: OK [ 75.389020] Testing event ocfs2_increase_refcount_begin: OK [ 75.421026] Testing event ocfs2_split_refcount_rec_insert: OK [ 75.451392] Testing event ocfs2_split_refcount_rec: OK [ 75.481353] Testing event ocfs2_insert_refcount_rec: OK [ 75.501709] Testing event ocfs2_new_leaf_refcount_block: OK [ 75.531448] Testing event ocfs2_divide_leaf_refcount_block: OK [ 75.560874] Testing event ocfs2_expand_inline_ref_root: OK [ 75.640923] Testing event ocfs2_change_refcount_rec: OK [ 75.670853] Testing event ocfs2_create_refcount_tree_blkno: OK [ 75.700603] Testing event ocfs2_create_refcount_tree: OK [ 75.722038] Testing event ocfs2_purge_refcount_trees: OK [ 75.751126] Testing event ocfs2_validate_refcount_block: OK [ 75.770944] Testing event ocfs2_test_inode_bit: OK [ 75.800601] Testing event ocfs2_test_suballoc_bit: OK [ 75.832067] Testing event ocfs2_get_suballoc_slot_bit: OK [ 75.860590] Testing event ocfs2_free_clusters: OK [ 75.881572] Testing event ocfs2_free_suballoc_bits: OK [ 75.901329] Testing event ocfs2_block_group_clear_bits: OK [ 75.930549] Testing event ocfs2_claim_new_inode_at_loc: OK [ 75.951560] Testing event ocfs2_claim_suballoc_bits: OK [ 75.971499] Testing event ocfs2_search_chain_end: OK [ 76.001314] Testing event ocfs2_search_chain_succ: OK [ 76.031400] Testing event ocfs2_search_chain_begin: OK [ 76.052009] Testing event ocfs2_block_group_search_max_block: OK [ 76.080537] Testing event ocfs2_cluster_group_search_max_block: OK [ 76.101783] Testing event ocfs2_cluster_group_search_wrong_max_bits: OK [ 76.131333] Testing event ocfs2_relink_block_group: OK [ 76.161847] Testing event ocfs2_block_group_set_bits: OK [ 76.180754] Testing event ocfs2_reserve_new_inode_new_group: OK [ 76.212122] Testing event ocfs2_reserve_suballoc_bits_no_new_group: OK [ 76.240679] Testing event ocfs2_reserve_suballoc_bits_nospc: OK [ 76.262237] Testing event ocfs2_block_group_alloc: OK [ 76.290799] Testing event ocfs2_block_group_alloc_discontig: OK [ 76.321334] Testing event ocfs2_block_group_alloc_contig: OK [ 76.351079] Testing event ocfs2_validate_group_descriptor: OK [ 76.420609] Testing event ocfs2_group_add: OK [ 76.484748] Testing event ocfs2_group_extend: OK [ 76.511986] Testing event ocfs2_update_last_group_and_inode: OK [ 76.541225] Testing event ocfs2_local_alloc_new_window_result: OK [ 76.570611] Testing event ocfs2_local_alloc_new_window: OK [ 76.601905] Testing event ocfs2_sync_local_to_main_free: OK [ 76.620979] Testing event ocfs2_sync_local_to_main: OK [ 76.651012] Testing event ocfs2_local_alloc_find_clear_bits: OK [ 76.672861] Testing event ocfs2_local_alloc_find_clear_bits_search_bitmap: OK [ 76.700674] Testing event ocfs2_local_alloc_count_bits: OK [ 76.720877] Testing event ocfs2_reserve_local_alloc_bits: OK [ 76.752231] Testing event ocfs2_begin_local_alloc_recovery: OK [ 76.780564] Testing event ocfs2_load_local_alloc: OK [ 76.800913] Testing event ocfs2_alloc_should_use_local: OK [ 76.821180] Testing event ocfs2_la_set_sizes: OK [ 76.851922] Testing event ocfs2_trim_fs: OK [ 76.881272] Testing event ocfs2_trim_group: OK [ 76.911631] Testing event ocfs2_trim_extent: OK [ 76.941476] Testing event ocfs2_cache_block_dealloc: OK [ 76.961255] Testing event ocfs2_run_deallocs: OK [ 76.990578] Testing event ocfs2_cache_cluster_dealloc: OK [ 77.020581] Testing event ocfs2_free_cached_blocks: OK [ 77.050518] Testing event ocfs2_complete_truncate_log_recovery: OK [ 77.070916] Testing event ocfs2_truncate_log_recovery_num: OK [ 77.151259] Testing event ocfs2_begin_truncate_log_recovery: OK [ 77.172059] Testing event ocfs2_flush_truncate_log: OK [ 77.201676] Testing event ocfs2_replay_truncate_records: OK [ 77.230627] Testing event ocfs2_truncate_log_append: OK [ 77.261660] Testing event ocfs2_mark_extent_written: OK [ 77.281171] Testing event ocfs2_add_clusters_in_btree_ret: OK [ 77.312549] Testing event ocfs2_rotate_leaf: OK [ 77.340764] Testing event ocfs2_validate_extent_block: OK [ 77.360711] Testing event ocfs2_commit_truncate: OK [ 77.390549] Testing event ocfs2_remove_extent: OK [ 77.421320] Testing event ocfs2_split_extent: OK [ 77.450526] Testing event ocfs2_insert_extent: OK [ 77.520651] Testing event ocfs2_rotate_subtree: OK [ 77.550534] Testing event ocfs2_grow_tree: OK [ 77.570951] Testing event ocfs2_complete_edge_insert: OK [ 77.600550] Testing event ocfs2_num_free_extents: OK [ 77.630640] Testing event ocfs2_add_clusters_in_btree: OK [ 77.660553] Testing event ocfs2_insert_extent_start: OK [ 77.690638] Testing event ocfs2_append_rec_to_path: OK [ 77.720551] Testing event ocfs2_rotate_tree_right: OK [ 77.750637] Testing event ocfs2_adjust_rightmost_branch: OK [ 77.780530] Testing event btrfs_workqueue_destroy: OK [ 77.810683] Testing event btrfs_workqueue_alloc: OK [ 77.840543] Testing event btrfs_ordered_sched: OK [ 77.870661] Testing event btrfs_all_work_done: OK [ 77.900589] Testing event btrfs_normal_work_done: OK [ 77.930675] Testing event btrfs_work_sched: OK [ 77.960558] Testing event btrfs_work_queued: OK [ 77.990641] Testing event free_extent_state: OK [ 78.020560] Testing event alloc_extent_state: OK [ 78.050643] Testing event btrfs_setup_cluster: OK [ 78.080535] Testing event btrfs_failed_cluster_setup: OK [ 78.110710] Testing event btrfs_find_cluster: OK [ 78.130724] Testing event btrfs_reserve_extent_cluster: OK [ 78.160545] Testing event btrfs_reserve_extent: OK [ 78.190648] Testing event find_free_extent: OK [ 78.220546] Testing event btrfs_reserved_extent_free: OK [ 78.250654] Testing event btrfs_reserved_extent_alloc: OK [ 78.300597] Testing event btrfs_space_reservation: OK [ 78.330671] Testing event btrfs_cow_block: OK [ 78.360570] Testing event btrfs_chunk_free: OK [ 78.390684] Testing event btrfs_chunk_alloc: OK [ 78.420563] Testing event run_delayed_ref_head: OK [ 78.450656] Testing event add_delayed_ref_head: OK [ 78.480601] Testing event run_delayed_data_ref: OK [ 78.510657] Testing event add_delayed_data_ref: OK [ 78.540565] Testing event run_delayed_tree_ref: OK [ 78.570682] Testing event add_delayed_tree_ref: OK [ 78.600571] Testing event btrfs_sync_fs: OK [ 78.630707] Testing event btrfs_sync_file: OK [ 78.660604] Testing event btrfs_writepage_end_io_hook: OK [ 78.690707] Testing event __extent_writepage: OK [ 78.720637] Testing event btrfs_ordered_extent_put: OK [ 78.750766] Testing event btrfs_ordered_extent_start: OK [ 78.780591] Testing event btrfs_ordered_extent_remove: OK [ 78.810702] Testing event btrfs_ordered_extent_add: OK [ 78.840614] Testing event btrfs_get_extent: OK [ 78.870711] Testing event btrfs_inode_evict: OK [ 78.900702] Testing event btrfs_inode_request: OK [ 78.930810] Testing event btrfs_inode_new: OK [ 78.970631] Testing event btrfs_transaction_commit: OK [ 79.000730] Testing event f2fs_issue_discard: OK [ 79.030609] Testing event f2fs_write_checkpoint: OK [ 79.060790] Testing event f2fs_submit_page_mbio: OK [ 79.090632] Testing event f2fs_writepages: OK [ 79.120721] Testing event f2fs_vm_page_mkwrite: OK [ 79.150624] Testing event f2fs_set_page_dirty: OK [ 79.180737] Testing event f2fs_readpage: OK [ 79.210610] Testing event f2fs_writepage: OK [ 79.240715] Testing event f2fs_write_end: OK [ 79.270611] Testing event f2fs_write_begin: OK [ 79.300725] Testing event f2fs_submit_read_bio: OK [ 79.330634] Testing event f2fs_submit_write_bio: OK [ 79.360736] Testing event f2fs_reserve_new_block: OK [ 79.390645] Testing event f2fs_fallocate: OK [ 79.420727] Testing event f2fs_get_victim: OK [ 79.450620] Testing event f2fs_get_data_block: OK [ 79.480743] Testing event f2fs_submit_page_bio: OK [ 79.510797] Testing event f2fs_truncate_partial_nodes: OK [ 79.540839] Testing event f2fs_truncate_node: OK [ 79.570689] Testing event f2fs_truncate_nodes_exit: OK [ 79.600914] Testing event f2fs_truncate_nodes_enter: OK [ 79.630759] Testing event f2fs_truncate_inode_blocks_exit: OK [ 79.660829] Testing event f2fs_truncate_inode_blocks_enter: OK [ 79.690691] Testing event f2fs_truncate_blocks_exit: OK [ 79.720827] Testing event f2fs_truncate_blocks_enter: OK [ 79.750749] Testing event f2fs_truncate_data_blocks_range: OK [ 79.790736] Testing event f2fs_truncate: OK [ 79.820856] Testing event f2fs_unlink_exit: OK [ 79.850725] Testing event f2fs_unlink_enter: OK [ 79.880833] Testing event f2fs_new_inode: OK [ 79.910792] Testing event f2fs_evict_inode: OK [ 79.947972] Testing event f2fs_iget_exit: OK [ 79.980720] Testing event f2fs_iget: OK [ 80.010866] Testing event f2fs_sync_fs: OK [ 80.040734] Testing event f2fs_sync_file_exit: OK [ 80.070817] Testing event f2fs_sync_file_enter: OK [ 80.100720] Testing event block_rq_remap: OK [ 80.130841] Testing event block_bio_remap: OK [ 80.160743] Testing event block_split: OK [ 80.190903] Testing event block_unplug: OK [ 80.220712] Testing event block_plug: OK [ 80.250846] Testing event block_sleeprq: OK [ 80.280711] Testing event block_getrq: OK [ 80.320754] Testing event block_bio_queue: OK [ 80.350818] Testing event block_bio_frontmerge: OK [ 80.380693] Testing event block_bio_backmerge: OK [ 80.410872] Testing event block_bio_complete: OK [ 80.440715] Testing event block_bio_bounce: OK [ 80.470818] Testing event block_rq_issue: OK [ 80.500695] Testing event block_rq_insert: OK [ 80.530847] Testing event block_rq_complete: OK [ 80.560695] Testing event block_rq_requeue: OK [ 80.590830] Testing event block_rq_abort: OK [ 80.620713] Testing event block_dirty_buffer: OK [ 80.650827] Testing event block_touch_buffer: OK [ 80.680731] Testing event swiotlb_bounced: OK [ 80.710862] Testing event regulator_set_voltage_complete: OK [ 80.740762] Testing event regulator_set_voltage: OK [ 80.770829] Testing event regulator_disable_complete: OK [ 80.800748] Testing event regulator_disable: OK [ 80.830839] Testing event regulator_enable_complete: OK [ 80.860692] Testing event regulator_enable_delay: OK [ 80.890830] Testing event regulator_enable: OK [ 80.920691] Testing event urandom_read: OK [ 80.950819] Testing event random_read: OK [ 80.980789] Testing event extract_entropy_user: OK [ 81.060118] Testing event extract_entropy: OK [ 81.090793] Testing event get_random_bytes_arch: OK [ 81.120648] Testing event get_random_bytes: OK [ 81.150758] Testing event xfer_secondary_pool: OK [ 81.180689] Testing event add_disk_randomness: OK [ 81.210782] Testing event add_input_randomness: OK [ 81.240636] Testing event debit_entropy: OK [ 81.270760] Testing event push_to_pool: OK [ 81.300642] Testing event credit_entropy_bits: OK [ 81.330764] Testing event mix_pool_bytes_nolock: OK [ 81.360645] Testing event mix_pool_bytes: OK [ 81.390761] Testing event add_device_randomness: OK [ 81.430719] Testing event drm_vblank_event_delivered: OK [ 81.460767] Testing event drm_vblank_event_queued: OK [ 81.490636] Testing event drm_vblank_event: OK [ 81.520802] Testing event regcache_drop_region: OK [ 81.550655] Testing event regmap_async_complete_done: OK [ 81.580806] Testing event regmap_async_complete_start: OK [ 81.610634] Testing event regmap_async_io_complete: OK [ 81.640763] Testing event regmap_async_write_start: OK [ 81.670632] Testing event regmap_cache_bypass: OK [ 81.700768] Testing event regmap_cache_only: OK [ 81.730672] Testing event regcache_sync: OK [ 81.760810] Testing event regmap_hw_write_done: OK [ 81.790642] Testing event regmap_hw_write_start: OK [ 81.820769] Testing event regmap_hw_read_done: OK [ 81.850661] Testing event regmap_hw_read_start: OK [ 81.980544] Testing event regmap_reg_read_cache: OK [ 82.000489] Testing event regmap_reg_read: OK [ 82.030593] Testing event regmap_reg_write: OK [ 82.060491] Testing event scsi_eh_wakeup: OK [ 82.090591] Testing event scsi_dispatch_cmd_timeout: OK [ 82.120517] Testing event scsi_dispatch_cmd_done: OK [ 82.150753] Testing event scsi_dispatch_cmd_error: OK [ 82.180533] Testing event scsi_dispatch_cmd_start: OK [ 82.210626] Testing event target_cmd_complete: OK [ 82.240564] Testing event target_sequencer_start: OK [ 82.270596] Testing event docg3_io: OK [ 82.300490] Testing event smbus_result: OK [ 82.330589] Testing event smbus_reply: OK [ 82.360491] Testing event smbus_read: OK [ 82.390625] Testing event smbus_write: OK [ 82.420561] Testing event i2c_result: OK [ 82.460625] Testing event i2c_reply: OK [ 82.490649] Testing event i2c_read: OK [ 82.557449] Testing event i2c_write: OK [ 82.572807] Testing event udp_fail_queue_rcv_skb: OK [ 82.640893] Testing event sock_exceed_buf_limit: OK [ 82.700413] Testing event sock_rcvqueue_full: OK [ 82.722013] Testing event napi_poll: OK [ 82.791740] Testing event netif_rx_ni_entry: OK [ 82.840369] Testing event netif_rx_entry: OK [ 82.912027] Testing event netif_receive_skb_entry: OK [ 82.931610] Testing event napi_gro_receive_entry: OK [ 83.046086] Testing event napi_gro_frags_entry: OK [ 83.081738] Testing event netif_rx: OK [ 83.110615] Testing event netif_receive_skb: OK [ 83.180656] Testing event net_dev_queue: OK [ 83.241111] Testing event net_dev_xmit: OK [ 83.311993] Testing event net_dev_start_xmit: OK [ 83.331557] Testing event skb_copy_datagram_iovec: OK [ 83.391366] Testing event consume_skb: OK [ 83.445998] Testing event kfree_skb: OK [ 83.470779] Testing event rpc_socket_shutdown: OK [ 83.542433] Testing event rpc_socket_close: OK [ 83.630682] Testing event rpc_socket_reset_connection: OK [ 83.711006] Testing event rpc_socket_error: OK [ 83.731933] Testing event rpc_socket_connect: OK [ 83.824150] Testing event rpc_socket_state_change: OK [ 83.850706] Testing event rpc_task_wakeup: OK [ 83.921530] Testing event rpc_task_sleep: OK [ 83.983943] Testing event rpc_task_complete: OK [ 84.053619] Testing event rpc_task_run_action: OK [ 84.080664] Testing event rpc_task_begin: OK [ 84.151058] Testing event rpc_connect_status: OK [ 84.231024] Testing event rpc_bind_status: OK [ 84.251800] Testing event rpc_call_status: OK [ 84.320573] Testing event cfg80211_stop_iface: OK [ 84.341659] Testing event cfg80211_ft_event: OK [ 84.411484] Testing event cfg80211_report_wowlan_wakeup: OK [ 84.481679] Testing event cfg80211_return_u32: OK [ 84.561729] Testing event cfg80211_return_uint: OK [ 84.630768] Testing event cfg80211_return_bss: OK [ 84.695739] Testing event cfg80211_inform_bss_width_frame: OK [ 84.731452] Testing event cfg80211_get_bss: OK [ 84.760818] Testing event cfg80211_sched_scan_stopped: OK [ 84.845618] Testing event cfg80211_sched_scan_results: OK [ 84.871495] Testing event cfg80211_scan_done: OK [ 84.940825] Testing event cfg80211_tdls_oper_request: OK [ 85.003895] Testing event cfg80211_report_obss_beacon: OK [ 85.054772] Testing event cfg80211_pmksa_candidate_notify: OK [ 85.081400] Testing event cfg80211_gtk_rekey_notify: OK [ 85.150862] Testing event cfg80211_cqm_pktloss_notify: OK [ 85.214521] Testing event cfg80211_probe_status: OK [ 85.231358] Testing event cfg80211_ibss_joined: OK [ 85.271523] Testing event cfg80211_rx_unexpected_4addr_frame: OK [ 85.341974] Testing event cfg80211_rx_spurious_frame: OK [ 85.405965] Testing event cfg80211_cac_event: OK [ 85.432534] Testing event cfg80211_radar_event: OK [ 85.487018] Testing event cfg80211_ch_switch_notify: OK [ 85.512563] Testing event cfg80211_chandef_dfs_required: OK [ 85.541208] Testing event cfg80211_reg_can_beacon: OK [ 85.631691] Testing event cfg80211_cqm_rssi_notify: OK [ 85.651510] Testing event cfg80211_mgmt_tx_status: OK [ 85.721338] Testing event cfg80211_rx_mgmt: OK [ 85.790831] Testing event cfg80211_del_sta: OK [ 85.854470] Testing event cfg80211_new_sta: OK [ 85.931207] Testing event cfg80211_ready_on_channel_expired: OK [ 86.000933] Testing event cfg80211_ready_on_channel: OK [ 86.020994] Testing event cfg80211_michael_mic_failure: OK [ 86.128506] Testing event cfg80211_send_assoc_timeout: OK [ 86.151618] Testing event cfg80211_send_auth_timeout: OK [ 86.220643] Testing event cfg80211_tx_mlme_mgmt: OK [ 86.272923] Testing event cfg80211_rx_mlme_mgmt: OK [ 86.300810] Testing event cfg80211_rx_unprot_mlme_mgmt: OK [ 86.421465] Testing event cfg80211_send_rx_assoc: OK [ 86.481438] Testing event cfg80211_send_rx_auth: OK [ 86.511422] Testing event cfg80211_notify_new_peer_candidate: OK [ 86.581455] Testing event cfg80211_return_bool: OK [ 86.660745] Testing event rdev_set_ap_chanwidth: OK [ 86.692219] Testing event rdev_set_qos_map: OK [ 86.711516] Testing event rdev_channel_switch: OK [ 86.740692] Testing event rdev_crit_proto_stop: OK [ 86.796337] Testing event rdev_crit_proto_start: OK [ 86.821074] Testing event rdev_update_ft_ies: OK [ 86.891602] Testing event rdev_set_mac_acl: OK [ 86.941334] Testing event rdev_stop_p2p_device: OK [ 87.003265] Testing event rdev_start_p2p_device: OK [ 87.031548] Testing event rdev_return_chandef: OK [ 87.101566] Testing event rdev_get_channel: OK [ 87.210420] Testing event rdev_get_et_strings: OK [ 87.230734] Testing event rdev_get_et_sset_count: OK [ 87.301217] Testing event rdev_set_noack_map: OK [ 87.371011] Testing event rdev_mgmt_tx: OK [ 87.451555] Testing event rdev_cancel_remain_on_channel: OK [ 87.520684] Testing event rdev_return_int_cookie: OK [ 87.590464] Testing event rdev_remain_on_channel: OK [ 87.670755] Testing event rdev_del_pmksa: OK [ 87.722269] Testing event rdev_set_pmksa: OK [ 87.792306] Testing event rdev_probe_client: OK [ 87.820572] Testing event rdev_tdls_oper: OK [ 87.931818] Testing event rdev_return_int_survey_info: OK [ 87.960709] Testing event rdev_dump_survey: OK [ 88.066891] Testing event rdev_tdls_mgmt: OK [ 88.090564] Testing event rdev_sched_scan_start: OK [ 88.166789] Testing event rdev_set_antenna: OK [ 88.219659] Testing event rdev_set_ringparam: OK [ 88.290708] Testing event rdev_return_void_tx_rx: OK [ 88.311102] Testing event rdev_return_int_tx_rx: OK [ 88.380752] Testing event rdev_mgmt_frame_register: OK [ 88.460851] Testing event rdev_set_bitrate_mask: OK [ 88.490649] Testing event rdev_return_int_int: OK [ 88.520754] Testing event rdev_set_tx_power: OK [ 88.550647] Testing event rdev_get_tx_power: OK [ 88.660509] Testing event rdev_set_wiphy_params: OK [ 88.680897] Testing event rdev_join_ibss: OK [ 88.742852] Testing event rdev_disconnect: OK [ 88.810469] Testing event rdev_set_cqm_txe_config: OK [ 88.880538] Testing event rdev_set_cqm_rssi_config: OK [ 88.900878] Testing event rdev_connect: OK [ 89.022080] Testing event rdev_set_power_mgmt: OK [ 89.041072] Testing event rdev_mgmt_tx_cancel_wait: OK [ 89.070724] Testing event rdev_disassoc: OK [ 89.100892] Testing event rdev_deauth: OK [ 89.130715] Testing event rdev_assoc: OK [ 89.200797] Testing event rdev_auth: OK [ 89.280750] Testing event rdev_set_monitor_channel: OK [ 89.410491] Testing event rdev_libertas_set_mesh_channel: OK [ 89.431067] Testing event rdev_set_txq_params: OK [ 89.552089] Testing event rdev_change_bss: OK [ 89.571087] Testing event rdev_join_mesh: OK [ 89.600673] Testing event rdev_update_mesh_config: OK [ 89.630823] Testing event rdev_return_int_mesh_config: OK [ 89.660774] Testing event rdev_return_int_mpath_info: OK [ 89.730795] Testing event rdev_dump_mpath: OK [ 89.790699] Testing event rdev_get_mpath: OK [ 89.852865] Testing event rdev_change_mpath: OK [ 89.930514] Testing event rdev_add_mpath: OK [ 90.000479] Testing event rdev_return_int_station_info: OK [ 90.020814] Testing event rdev_dump_station: OK [ 90.090691] Testing event rdev_set_wds_peer: OK [ 90.150860] Testing event rdev_del_mpath: OK [ 90.220702] Testing event rdev_get_station: OK [ 90.300808] Testing event rdev_del_station: OK [ 90.330724] Testing event rdev_change_station: OK [ 90.360762] Testing event rdev_add_station: OK [ 90.380797] Testing event rdev_flush_pmksa: OK [ 90.400831] Testing event rdev_leave_ibss: OK [ 90.430645] Testing event rdev_leave_mesh: OK [ 90.460812] Testing event rdev_get_mesh_config: OK [ 90.490637] Testing event rdev_set_rekey_data: OK [ 90.520750] Testing event rdev_sched_scan_stop: OK [ 90.550665] Testing event rdev_get_et_stats: OK [ 90.580800] Testing event rdev_stop_ap: OK [ 90.610637] Testing event rdev_change_beacon: OK [ 90.640750] Testing event rdev_start_ap: OK [ 90.670618] Testing event rdev_set_default_mgmt_key: OK [ 90.700698] Testing event rdev_set_default_key: OK [ 90.730530] Testing event rdev_del_key: OK [ 90.760669] Testing event rdev_get_key: OK [ 90.790570] Testing event rdev_add_key: OK [ 90.820683] Testing event rdev_change_virtual_intf: OK [ 90.850661] Testing event rdev_del_virtual_intf: OK [ 90.880703] Testing event rdev_return_wdev: OK [ 90.910546] Testing event rdev_add_virtual_intf: OK [ 90.940629] Testing event rdev_set_wakeup: OK [ 90.970534] Testing event rdev_rfkill_poll: OK [ 91.000633] Testing event rdev_get_antenna: OK [ 91.030532] Testing event rdev_get_ringparam: OK [ 91.060627] Testing event rdev_return_void: OK [ 91.090610] Testing event rdev_resume: OK [ 91.120745] Testing event rdev_scan: OK [ 91.150615] Testing event rdev_return_int: OK [ 91.180671] Testing event rdev_suspend: OK [ 91.210631] Testing event drv_channel_switch_beacon: OK [ 91.240747] Testing event api_radar_detected: OK [ 91.270543] Testing event drv_set_default_unicast_key: OK [ 91.300679] Testing event stop_queue: OK [ 91.330543] Testing event wake_queue: OK [ 91.360648] Testing event api_sta_set_buffered: OK [ 91.390544] Testing event api_eosp: OK [ 91.420689] Testing event api_enable_rssi_reports: OK [ 91.450633] Testing event api_gtk_rekey_notify: OK [ 91.480767] Testing event api_remain_on_channel_expired: OK [ 91.510571] Testing event api_ready_on_channel: OK [ 91.540648] Testing event api_chswitch_done: OK [ 91.570558] Testing event api_sta_block_awake: OK [ 91.600741] Testing event api_sched_scan_stopped: OK [ 91.630561] Testing event api_sched_scan_results: OK [ 91.660702] Testing event api_scan_completed: OK [ 91.690540] Testing event api_cqm_rssi_notify: OK [ 91.720730] Testing event api_connection_loss: OK [ 91.750622] Testing event api_beacon_loss: OK [ 91.780691] Testing event api_restart_hw: OK [ 91.810579] Testing event api_stop_tx_ba_cb: OK [ 91.840695] Testing event api_stop_tx_ba_session: OK [ 91.870564] Testing event api_start_tx_ba_cb: OK [ 91.900771] Testing event api_start_tx_ba_session: OK [ 91.930582] Testing event drv_get_expected_throughput: OK [ 91.960651] Testing event drv_leave_ibss: OK [ 91.990537] Testing event drv_join_ibss: OK [ 92.020645] Testing event drv_restart_complete: OK [ 92.050538] Testing event drv_stop_ap: OK [ 92.080741] Testing event drv_start_ap: OK [ 92.110554] Testing event drv_unassign_vif_chanctx: OK [ 92.140694] Testing event drv_assign_vif_chanctx: OK [ 92.170682] Testing event drv_switch_vif_chanctx: OK [ 92.200747] Testing event drv_change_chanctx: OK [ 92.230583] Testing event drv_remove_chanctx: OK [ 92.260675] Testing event drv_add_chanctx: OK [ 92.290541] Testing event drv_mgd_prepare_tx: OK [ 92.320648] Testing event drv_get_rssi: OK [ 92.350543] Testing event drv_allow_buffered_frames: OK [ 92.380718] Testing event drv_release_buffered_frames: OK [ 92.410572] Testing event drv_rssi_callback: OK [ 92.440700] Testing event drv_set_rekey_data: OK [ 92.470550] Testing event drv_set_bitrate_mask: OK [ 92.500704] Testing event drv_offchannel_tx_cancel_wait: OK [ 92.574393] Testing event drv_tx_frames_pending: OK [ 92.601111] Testing event drv_get_ringparam: OK [ 92.630495] Testing event drv_set_ringparam: OK [ 92.650917] Testing event drv_cancel_remain_on_channel: OK [ 92.682175] Testing event drv_remain_on_channel: OK [ 92.711180] Testing event drv_get_antenna: OK [ 92.780861] Testing event drv_set_antenna: OK [ 92.801752] Testing event drv_channel_switch: OK [ 92.831457] Testing event drv_flush: OK [ 92.852122] Testing event drv_get_survey: OK [ 92.880761] Testing event drv_ampdu_action: OK [ 92.900721] Testing event drv_tx_last_beacon: OK [ 92.930599] Testing event drv_reset_tsf: OK [ 92.950801] Testing event drv_set_tsf: OK [ 92.981507] Testing event drv_get_tsf: OK [ 93.001133] Testing event drv_conf_tx: OK [ 93.030495] Testing event drv_sta_pre_rcu_remove: OK [ 93.052576] Testing event drv_sta_remove: OK [ 93.080553] Testing event drv_sta_add: OK [ 93.110624] Testing event drv_sta_rc_update: OK [ 93.131197] Testing event drv_sta_state: OK [ 93.160722] Testing event drv_sta_notify: OK [ 93.191494] Testing event drv_set_coverage_class: OK [ 93.221363] Testing event drv_set_rts_threshold: OK [ 93.251366] Testing event drv_set_frag_threshold: OK [ 93.281566] Testing event drv_get_tkip_seq: OK [ 93.310644] Testing event drv_get_stats: OK [ 93.330699] Testing event drv_sw_scan_complete: OK [ 93.351566] Testing event drv_sw_scan_start: OK [ 93.380539] Testing event drv_sched_scan_stop: OK [ 93.410608] Testing event drv_sched_scan_start: OK [ 93.441010] Testing event drv_cancel_hw_scan: OK [ 93.472516] Testing event drv_hw_scan: OK [ 93.500903] Testing event drv_update_tkip_key: OK [ 93.568499] Testing event drv_set_key: OK [ 93.593152] Testing event drv_set_tim: OK [ 93.620537] Testing event drv_configure_filter: OK [ 93.650579] Testing event drv_prepare_multicast: OK [ 93.682582] Testing event drv_bss_info_changed: OK [ 93.711118] Testing event drv_config: OK [ 93.740531] Testing event drv_remove_interface: OK [ 93.771287] Testing event drv_change_interface: OK [ 93.801062] Testing event drv_add_interface: OK [ 93.820646] Testing event drv_stop: OK [ 93.850478] Testing event drv_set_wakeup: OK [ 93.880663] Testing event drv_resume: OK [ 93.901103] Testing event drv_suspend: OK [ 93.930690] Testing event drv_get_et_stats: OK [ 93.950902] Testing event drv_get_et_sset_count: OK [ 93.981605] Testing event drv_get_et_strings: OK [ 94.043997] Testing event drv_start: OK [ 94.070670] Testing event drv_return_u64: OK [ 94.090673] Testing event drv_return_u32: OK [ 94.120742] Testing event drv_return_bool: OK [ 94.150634] Testing event drv_return_int: OK [ 94.170697] Testing event drv_return_void: OK [ 94.191827] Testing event 9p_protocol_dump: OK [ 94.210990] Testing event 9p_client_res: OK [ 94.280537] Testing event 9p_client_req: OK [ 94.301130] Running tests on trace event systems: [ 94.301970] Testing event system 9p: OK [ 94.331637] Testing event system mac80211: OK [ 94.360848] Testing event system cfg80211: OK [ 94.400968] Testing event system sunrpc: OK [ 94.431353] Testing event system skb: OK [ 94.462087] Testing event system net: OK [ 94.490601] Testing event system napi: OK [ 94.526571] Testing event system sock: OK [ 94.600190] Testing event system udp: OK [ 94.620754] Testing event system i2c: OK [ 94.651382] Testing event system docg3: OK [ 94.671507] Testing event system target: OK [ 94.700547] Testing event system scsi: OK [ 94.720977] Testing event system regmap: OK [ 94.751419] Testing event system drm: OK [ 94.772544] Testing event system random: OK [ 94.792343] Testing event system regulator: OK [ 94.820533] Testing event system swiotlb: OK [ 94.851437] Testing event system block: OK [ 94.882092] Testing event system f2fs: OK [ 94.970823] Testing event system btrfs: OK [ 94.991181] Testing event system ocfs2: OK [ 95.041915] Testing event system xfs: OK [ 95.099085] Testing event system nfs: OK [ 95.138775] Testing event system jbd2: OK [ 95.170699] Testing event system filelock: OK [ 95.193852] Testing event system writeback: OK [ 95.221753] Testing event system migrate: OK [ 95.243781] Testing event system compaction: OK [ 95.261439] Testing event system kmem: OK [ 95.292164] Testing event system vmscan: OK [ 95.320896] Testing event system pagemap: OK [ 95.350575] Testing event system oom: OK [ 95.421398] Testing event system filemap: OK [ 95.450586] Testing event system context_tracking: OK [ 95.470734] Testing event system power: OK [ 95.501232] Testing event system test: OK [ 95.522331] Testing event system rcu: OK [ 95.542468] Testing event system printk: OK [ 95.572321] Testing event system lock: OK [ 95.600765] Testing event system sched: OK [ 95.632160] Testing event system workqueue: OK [ 95.661104] Testing event system signal: OK [ 95.690760] Testing event system timer: OK [ 95.748309] Testing event system irq: OK [ 95.771655] Testing event system task: OK [ 95.792443] Testing event system exceptions: OK [ 95.821691] Testing event system raw_syscalls: OK [ 95.852447] Testing event system vsyscall: OK [ 95.881595] Testing event system nmi: OK [ 95.910586] Testing event system irq_vectors: OK [ 95.941310] Testing event system kvmmmu: OK [ 95.970646] Testing event system kvm: OK [ 96.001651] Running tests on all trace events: [ 96.002499] Testing all events: OK [ 96.125650] Testing ftrace filter: OK [ 96.144584] kAFS: Red Hat AFS client v0.1 registering. [ 96.145535] FS-Cache: Netfs 'afs' registered for caching [ 96.179165] Btrfs loaded, debug=on, assert=on, integrity-checker=on [ 96.180295] BTRFS: selftest: Running btrfs free space cache tests [ 96.181230] BTRFS: selftest: Running extent only tests [ 96.182117] BTRFS: selftest: Running bitmap only tests [ 96.182994] BTRFS: selftest: Running bitmap and extent tests [ 96.184022] BTRFS: selftest: Free space cache tests finished [ 96.184893] BTRFS: selftest: Running extent buffer operation tests [ 96.185652] BTRFS: selftest: Running btrfs_split_item tests [ 96.186929] BTRFS: selftest: Running find delalloc tests [ 100.380235] rb_consumer: page allocation failure: order:0, mode:0x10d0 [ 100.381231] CPU: 0 PID: 104 Comm: rb_consumer Not tainted 3.16.0-g6aaca9b #80 [ 100.382248] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 100.383104] 0000000000000001 ffff880010cbbc20 ffffffff88650896 0000000000000001 [ 100.384580] ffff880010cbbcb8 ffffffff877e016c ffff880010cbbcc8 0000000000000000 [ 100.386057] 0000000000000000 0000000000000000 0000000000000001 00000000000010d0 [ 100.387526] Call Trace: [ 100.388045] [<ffffffff88650896>] dump_stack+0x80/0xa8 [ 100.388807] [<ffffffff877e016c>] warn_alloc_failed+0x190/0x1cc [ 100.389650] [<ffffffff877e5856>] __alloc_pages_nodemask+0xda5/0xf21 [ 100.390575] [<ffffffff877abea1>] alloc_pages_node+0x42/0x44 [ 100.391525] [<ffffffff877aed83>] ring_buffer_alloc_read_page+0x17/0x4d [ 100.392443] [<ffffffff877af7a0>] ring_buffer_consumer_thread+0x1bc/0x422 [ 100.393380] [<ffffffff877af5e4>] ? ring_buffer_producer_thread+0x4fb/0x4fb [ 100.394346] [<ffffffff8772d01e>] kthread+0xf9/0x101 [ 100.395108] [<ffffffff8772cf25>] ? __kthread_parkme+0x86/0x86 [ 100.395945] [<ffffffff88661ffc>] ret_from_fork+0x7c/0xb0 [ 100.396732] [<ffffffff8772cf25>] ? __kthread_parkme+0x86/0x86 [ 100.397570] Mem-Info: [ 100.398026] Node 0 DMA per-cpu: [ 100.398642] CPU 0: hi: 0, btch: 1 usd: 0 [ 100.399376] Node 0 DMA32 per-cpu: [ 100.399972] CPU 0: hi: 90, btch: 15 usd: 14 [ 100.400684] active_anon:0 inactive_anon:0 isolated_anon:0 [ 100.400684] active_file:52 inactive_file:50097 isolated_file:0 [ 100.400684] unevictable:363 dirty:0 writeback:0 unstable:0 [ 100.400684] free:750 slab_reclaimable:4250 slab_unreclaimable:6589 [ 100.400684] mapped:0 shmem:0 pagetables:0 bounce:0 [ 100.400684] free_cma:0 [ 100.404531] Node 0 DMA free:1100kB min:120kB low:148kB high:180kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:12476kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:15992kB managed:15908kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:32kB slab_unreclaimable:1276kB kernel_stack:80kB pagetables:0kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:20993 all_unreclaimable? yes [ 100.409482] lowmem_reserve[]: 0 245 245 245 [ 100.410422] Node 0 DMA32 free:1900kB min:1944kB low:2428kB high:2916kB active_anon:0kB inactive_anon:0kB active_file:208kB inactive_file:187912kB unevictable:1452kB isolated(anon):0kB isolated(file):0kB present:311288kB managed:251548kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:16968kB slab_unreclaimable:25080kB kernel_stack:1184kB pagetables:0kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:520259 all_unreclaimable? yes [ 100.415813] lowmem_reserve[]: 0 0 0 0 [ 100.416710] Node 0 DMA: 1*4kB (R) 1*8kB (R) 0*16kB 0*32kB 1*64kB (R) 0*128kB 0*256kB 0*512kB 1*1024kB (R) 0*2048kB 0*4096kB = 1100kB [ 100.419400] Node 0 DMA32: 1*4kB (R) 1*8kB (R) 0*16kB 1*32kB (R) 1*64kB (R) 0*128kB 1*256kB (R) 1*512kB (R) 1*1024kB (R) 0*2048kB 0*4096kB = 1900kB [ 100.422439] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB [ 100.423611] 50513 total pagecache pages [ 100.424201] 81820 pages RAM [ 100.424664] 0 pages HighMem/MovableOnly [ 100.425269] 14935 pages reserved [ 101.910162] rb_consumer: page allocation failure: order:0, mode:0x10d0 [ 101.911126] CPU: 0 PID: 104 Comm: rb_consumer Not tainted 3.16.0-g6aaca9b #80 [ 101.912084] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 101.912861] 0000000000000001 ffff880010cbbc20 ffffffff88650896 0000000000000001 [ 101.914264] ffff880010cbbcb8 ffffffff877e016c ffff880010cbbcc8 0000000000000000 [ 101.915678] 0000000000000000 0000000000000000 0000000000000001 00000000000010d0 [ 101.917088] Call Trace: [ 101.917533] [<ffffffff88650896>] dump_stack+0x80/0xa8 [ 101.918286] [<ffffffff877e016c>] warn_alloc_failed+0x190/0x1cc [ 101.919119] [<ffffffff877e5856>] __alloc_pages_nodemask+0xda5/0xf21 [ 101.920032] [<ffffffff877abea1>] alloc_pages_node+0x42/0x44 [ 101.920975] [<ffffffff877aed83>] ring_buffer_alloc_read_page+0x17/0x4d [ 101.921898] [<ffffffff877af7a0>] ring_buffer_consumer_thread+0x1bc/0x422 [ 101.922808] [<ffffffff877af5e4>] ? ring_buffer_producer_thread+0x4fb/0x4fb [ 101.923740] [<ffffffff8772d01e>] kthread+0xf9/0x101 [ 101.924471] [<ffffffff8772cf25>] ? __kthread_parkme+0x86/0x86 [ 101.925308] [<ffffffff88661ffc>] ret_from_fork+0x7c/0xb0 [ 101.926115] [<ffffffff8772cf25>] ? __kthread_parkme+0x86/0x86 [ 101.926900] Mem-Info: [ 101.927357] Node 0 DMA per-cpu: [ 101.927955] CPU 0: hi: 0, btch: 1 usd: 0 [ 101.928646] Node 0 DMA32 per-cpu: [ 101.929297] CPU 0: hi: 90, btch: 15 usd: 14 [ 101.930024] active_anon:0 inactive_anon:0 isolated_anon:0 [ 101.930024] active_file:52 inactive_file:50095 isolated_file:0 [ 101.930024] unevictable:363 dirty:0 writeback:0 unstable:0 [ 101.930024] free:750 slab_reclaimable:4250 slab_unreclaimable:6589 [ 101.930024] mapped:0 shmem:0 pagetables:0 bounce:0 [ 101.930024] free_cma:0 [ 101.934093] Node 0 DMA free:1100kB min:120kB low:148kB high:180kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:12468kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:15992kB managed:15908kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:32kB slab_unreclaimable:1276kB kernel_stack:80kB pagetables:0kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:21057 all_unreclaimable? yes [ 101.939293] lowmem_reserve[]: 0 245 245 245 [ 101.940260] Node 0 DMA32 free:1900kB min:1944kB low:2428kB high:2916kB active_anon:0kB inactive_anon:0kB active_file:208kB inactive_file:187912kB unevictable:1452kB isolated(anon):0kB isolated(file):0kB present:311288kB managed:251548kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:16968kB slab_unreclaimable:25080kB kernel_stack:1184kB pagetables:0kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:612219 all_unreclaimable? yes [ 101.945616] lowmem_reserve[]: 0 0 0 0 [ 101.946528] Node 0 DMA: 1*4kB (R) 1*8kB (R) 0*16kB 0*32kB 1*64kB (R) 0*128kB 0*256kB 0*512kB 1*1024kB (R) 0*2048kB 0*4096kB = 1100kB [ 101.949224] Node 0 DMA32: 1*4kB (R) 1*8kB (R) 0*16kB 1*32kB (R) 1*64kB (R) 0*128kB 1*256kB (R) 1*512kB (R) 1*1024kB (R) 0*2048kB 0*4096kB = 1900kB [ 101.952285] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB [ 101.953469] 50513 total pagecache pages [ 101.954055] 81820 pages RAM [ 101.954529] 0 pages HighMem/MovableOnly [ 101.955123] 14935 pages reserved [ 102.960196] rb_consumer: page allocation failure: order:0, mode:0x10d0 [ 102.961214] CPU: 0 PID: 104 Comm: rb_consumer Not tainted 3.16.0-g6aaca9b #80 [ 102.962236] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 102.963098] 0000000000000001 ffff880010cbbc20 ffffffff88650896 0000000000000001 [ 102.964585] ffff880010cbbcb8 ffffffff877e016c ffff880010cbbcc8 0000000000000000 [ 102.972004] 0000000000000000 0000000000000000 0000000000000001 00000000000010d0 [ 102.973479] Call Trace: [ 102.973972] [<ffffffff88650896>] dump_stack+0x80/0xa8 [ 102.974758] [<ffffffff877e016c>] warn_alloc_failed+0x190/0x1cc [ 102.975644] [<ffffffff877e5856>] __alloc_pages_nodemask+0xda5/0xf21 [ 102.976569] [<ffffffff877abea1>] alloc_pages_node+0x42/0x44 [ 102.977537] [<ffffffff877aed83>] ring_buffer_alloc_read_page+0x17/0x4d [ 102.978491] [<ffffffff877af7a0>] ring_buffer_consumer_thread+0x1bc/0x422 [ 102.979467] [<ffffffff877af5e4>] ? ring_buffer_producer_thread+0x4fb/0x4fb [ 102.980480] [<ffffffff8772d01e>] kthread+0xf9/0x101 [ 102.981252] [<ffffffff8772cf25>] ? __kthread_parkme+0x86/0x86 [ 102.982120] [<ffffffff88661ffc>] ret_from_fork+0x7c/0xb0 [ 102.982931] [<ffffffff8772cf25>] ? __kthread_parkme+0x86/0x86 [ 102.983799] Mem-Info: [ 102.984274] Node 0 DMA per-cpu: [ 102.984913] CPU 0: hi: 0, btch: 1 usd: 0 [ 102.985667] Node 0 DMA32 per-cpu: [ 102.986329] CPU 0: hi: 90, btch: 15 usd: 14 [ 102.987087] active_anon:0 inactive_anon:0 isolated_anon:0 [ 102.987087] active_file:52 inactive_file:50095 isolated_file:0 [ 102.987087] unevictable:363 dirty:0 writeback:0 unstable:0 [ 102.987087] free:750 slab_reclaimable:4250 slab_unreclaimable:6589 [ 102.987087] mapped:0 shmem:0 pagetables:0 bounce:0 [ 102.987087] free_cma:0 [ 102.991429] Node 0 DMA free:1100kB min:120kB low:148kB high:180kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:12468kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:15992kB managed:15908kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:32kB slab_unreclaimable:1276kB kernel_stack:80kB pagetables:0kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:21089 all_unreclaimable? yes [ 102.996912] lowmem_reserve[]: 0 245 245 245 [ 102.997956] Node 0 DMA32 free:1900kB min:1944kB low:2428kB high:2916kB active_anon:0kB inactive_anon:0kB active_file:208kB inactive_file:187912kB unevictable:1452kB isolated(anon):0kB isolated(file):0kB present:311288kB managed:251548kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:16968kB slab_unreclaimable:25080kB kernel_stack:1184kB pagetables:0kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:697590 all_unreclaimable? yes [ 103.003828] lowmem_reserve[]: 0 0 0 0 [ 103.004817] Node 0 DMA: 1*4kB (R) 1*8kB (R) 0*16kB 0*32kB 1*64kB (R) 0*128kB 0*256kB 0*512kB 1*1024kB (R) 0*2048kB 0*4096kB = 1100kB [ 103.007746] Node 0 DMA32: 1*4kB (R) 1*8kB (R) 0*16kB 1*32kB (R) 1*64kB (R) 0*128kB 1*256kB (R) 1*512kB (R) 1*1024kB (R) 0*2048kB 0*4096kB = 1900kB [ 103.011049] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB [ 103.012360] 50513 total pagecache pages [ 103.013002] 81820 pages RAM [ 103.013526] 0 pages HighMem/MovableOnly [ 103.014173] 14935 pages reserved [ 103.870176] rb_consumer: page allocation failure: order:0, mode:0x10d0 [ 103.871161] CPU: 0 PID: 104 Comm: rb_consumer Not tainted 3.16.0-g6aaca9b #80 [ 103.872165] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 103.873010] 0000000000000001 ffff880010cbbc20 ffffffff88650896 0000000000000001 [ 103.874492] ffff880010cbbcb8 ffffffff877e016c ffff880010cbbcc8 0000000000000000 [ 103.875986] 0000000000000000 0000000000000000 0000000000000001 00000000000010d0 [ 103.877469] Call Trace: [ 103.877963] [<ffffffff88650896>] dump_stack+0x80/0xa8 [ 103.878754] [<ffffffff877e016c>] warn_alloc_failed+0x190/0x1cc [ 103.879632] [<ffffffff877e5856>] __alloc_pages_nodemask+0xda5/0xf21 [ 103.880578] [<ffffffff877abea1>] alloc_pages_node+0x42/0x44 [ 103.881554] [<ffffffff877aed83>] ring_buffer_alloc_read_page+0x17/0x4d [ 103.882514] [<ffffffff877af7a0>] ring_buffer_consumer_thread+0x1bc/0x422 [ 103.883484] [<ffffffff877af5e4>] ? ring_buffer_producer_thread+0x4fb/0x4fb [ 103.884469] [<ffffffff8772d01e>] kthread+0xf9/0x101 [ 103.885250] [<ffffffff8772cf25>] ? __kthread_parkme+0x86/0x86 [ 103.886118] [<ffffffff88661ffc>] ret_from_fork+0x7c/0xb0 [ 103.886931] [<ffffffff8772cf25>] ? __kthread_parkme+0x86/0x86 [ 103.887791] Mem-Info: [ 103.888259] Node 0 DMA per-cpu: [ 103.888890] CPU 0: hi: 0, btch: 1 usd: 0 [ 103.889639] Node 0 DMA32 per-cpu: [ 103.890321] CPU 0: hi: 90, btch: 15 usd: 14 [ 103.891080] active_anon:0 inactive_anon:0 isolated_anon:0 [ 103.891080] active_file:52 inactive_file:50095 isolated_file:0 [ 103.891080] unevictable:363 dirty:0 writeback:0 unstable:0 [ 103.891080] free:750 slab_reclaimable:4250 slab_unreclaimable:6589 [ 103.891080] mapped:0 shmem:0 pagetables:0 bounce:0 [ 103.891080] free_cma:0 [ 103.895383] Node 0 DMA free:1100kB min:120kB low:148kB high:180kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:12468kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:15992kB managed:15908kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:32kB slab_unreclaimable:1276kB kernel_stack:80kB pagetables:0kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:21121 all_unreclaimable? yes [ 103.901299] lowmem_reserve[]: 0 245 245 245 [ 103.902349] Node 0 DMA32 free:1900kB min:1944kB low:2428kB high:2916kB active_anon:0kB inactive_anon:0kB active_file:208kB inactive_file:187912kB unevictable:1452kB isolated(anon):0kB isolated(file):0kB present:311288kB managed:251548kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:16968kB slab_unreclaimable:25080kB kernel_stack:1184kB pagetables:0kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:793422 all_unreclaimable? yes [ 103.908174] lowmem_reserve[]: 0 0 0 0 [ 103.909158] Node 0 DMA: 1*4kB (R) 1*8kB (R) 0*16kB 0*32kB 1*64kB (R) 0*128kB 0*256kB 0*512kB 1*1024kB (R) 0*2048kB 0*4096kB = 1100kB [ 103.912105] Node 0 DMA32: 1*4kB (R) 1*8kB (R) 0*16kB 1*32kB (R) 1*64kB (R) 0*128kB 1*256kB (R) 1*512kB (R) 1*1024kB (R) 0*2048kB 0*4096kB = 1900kB [ 103.915381] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB [ 103.916677] 50513 total pagecache pages [ 103.917328] 81820 pages RAM [ 103.917852] 0 pages HighMem/MovableOnly [ 103.918496] 14935 pages reserved [ 105.380178] rb_consumer: page allocation failure: order:0, mode:0x10d0 [ 105.381100] CPU: 0 PID: 104 Comm: rb_consumer Not tainted 3.16.0-g6aaca9b #80 [ 105.382012] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 105.382796] 0000000000000001 ffff880010cbbc20 ffffffff88650896 0000000000000001 [ 105.384111] ffff880010cbbcb8 ffffffff877e016c ffff880010cbbcc8 0000000000000000 [ 105.385456] 0000000000000000 0000000000000000 0000000000000001 00000000000010d0 [ 105.386988] Call Trace: [ 105.387483] [<ffffffff88650896>] dump_stack+0x80/0xa8 [ 105.388296] [<ffffffff877e016c>] warn_alloc_failed+0x190/0x1cc [ 105.389196] [<ffffffff877e5856>] __alloc_pages_nodemask+0xda5/0xf21 [ 105.390103] [<ffffffff877abea1>] alloc_pages_node+0x42/0x44 [ 105.391082] [<ffffffff877aed83>] ring_buffer_alloc_read_page+0x17/0x4d [ 105.392047] [<ffffffff877af7a0>] ring_buffer_consumer_thread+0x1bc/0x422 [ 105.393030] [<ffffffff877af5e4>] ? ring_buffer_producer_thread+0x4fb/0x4fb [ 105.394087] [<ffffffff8772d01e>] kthread+0xf9/0x101 [ 105.394864] [<ffffffff8772cf25>] ? __kthread_parkme+0x86/0x86 [ 105.395724] [<ffffffff88661ffc>] ret_from_fork+0x7c/0xb0 [ 105.396626] [<ffffffff8772cf25>] ? __kthread_parkme+0x86/0x86 [ 105.397540] Mem-Info: [ 105.397994] Node 0 DMA per-cpu: [ 105.398641] CPU 0: hi: 0, btch: 1 usd: 0 [ 105.399424] Node 0 DMA32 per-cpu: [ 105.400148] CPU 0: hi: 90, btch: 15 usd: 14 [ 105.400918] active_anon:0 inactive_anon:0 isolated_anon:0 [ 105.400918] active_file:52 inactive_file:50095 isolated_file:0 [ 105.400918] unevictable:363 dirty:0 writeback:0 unstable:0 [ 105.400918] free:750 slab_reclaimable:4250 slab_unreclaimable:6589 [ 105.400918] mapped:0 shmem:0 pagetables:0 bounce:0 [ 105.400918] free_cma:0 [ 105.405430] Node 0 DMA free:1100kB min:120kB low:148kB high:180kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:12468kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:15992kB managed:15908kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:32kB slab_unreclaimable:1276kB kernel_stack:80kB pagetables:0kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:21153 all_unreclaimable? yes [ 105.410988] lowmem_reserve[]: 0 245 245 245 [ 105.412032] Node 0 DMA32 free:1900kB min:1944kB low:2428kB high:2916kB active_anon:0kB inactive_anon:0kB active_file:208kB inactive_file:187912kB unevictable:1452kB isolated(anon):0kB isolated(file):0kB present:311288kB managed:251548kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:16968kB slab_unreclaimable:25080kB kernel_stack:1184kB pagetables:0kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:960094 all_unreclaimable? yes [ 105.417871] lowmem_reserve[]: 0 0 0 0 [ 105.418856] Node 0 DMA: 1*4kB (R) 1*8kB (R) 0*16kB 0*32kB 1*64kB (R) 0*128kB 0*256kB 0*512kB 1*1024kB (R) 0*2048kB 0*4096kB = 1100kB [ 105.421808] Node 0 DMA32: 1*4kB (R) 1*8kB (R) 0*16kB 1*32kB (R) 1*64kB (R) 0*128kB 1*256kB (R) 1*512kB (R) 1*1024kB (R) 0*2048kB 0*4096kB = 1900kB [ 105.425090] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB [ 105.426396] 50513 total pagecache pages [ 105.427033] 81820 pages RAM [ 105.427563] 0 pages HighMem/MovableOnly [ 105.428198] 14935 pages reserved [ 108.960170] rb_consumer: page allocation failure: order:0, mode:0x10d0 [ 108.961077] CPU: 0 PID: 104 Comm: rb_consumer Not tainted 3.16.0-g6aaca9b #80 [ 108.962004] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 108.962865] 0000000000000001 ffff880010cbbc20 ffffffff88650896 0000000000000001 [ 108.964355] ffff880010cbbcb8 ffffffff877e016c ffff880010cbbcc8 0000000000000000 [ 108.965842] 0000000000000000 0000000000000000 0000000000000001 00000000000010d0 [ 108.967322] Call Trace: [ 108.967830] [<ffffffff88650896>] dump_stack+0x80/0xa8 [ 108.968607] [<ffffffff877e016c>] warn_alloc_failed+0x190/0x1cc [ 108.969468] [<ffffffff877e5856>] __alloc_pages_nodemask+0xda5/0xf21 [ 108.970449] [<ffffffff877abea1>] alloc_pages_node+0x42/0x44 [ 108.971435] [<ffffffff877aed83>] ring_buffer_alloc_read_page+0x17/0x4d [ 108.978147] [<ffffffff877af7a0>] ring_buffer_consumer_thread+0x1bc/0x422 [ 108.979113] [<ffffffff877af5e4>] ? ring_buffer_producer_thread+0x4fb/0x4fb [ 108.980117] [<ffffffff8772d01e>] kthread+0xf9/0x101 [ 108.980893] [<ffffffff8772cf25>] ? __kthread_parkme+0x86/0x86 [ 108.981757] [<ffffffff88661ffc>] ret_from_fork+0x7c/0xb0 [ 108.982582] [<ffffffff8772cf25>] ? __kthread_parkme+0x86/0x86 [ 108.983446] Mem-Info: [ 108.983895] Node 0 DMA per-cpu: [ 108.984549] CPU 0: hi: 0, btch: 1 usd: 0 [ 108.985309] Node 0 DMA32 per-cpu: [ 108.985943] CPU 0: hi: 90, btch: 15 usd: 14 [ 108.986696] active_anon:0 inactive_anon:0 isolated_anon:0 [ 108.986696] active_file:52 inactive_file:50095 isolated_file:0 [ 108.986696] unevictable:363 dirty:0 writeback:0 unstable:0 [ 108.986696] free:750 slab_reclaimable:4250 slab_unreclaimable:6589 [ 108.986696] mapped:0 shmem:0 pagetables:0 bounce:0 [ 108.986696] free_cma:0 [ 108.991013] Node 0 DMA free:1100kB min:120kB low:148kB high:180kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:12468kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:15992kB managed:15908kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:32kB slab_unreclaimable:1276kB kernel_stack:80kB pagetables:0kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:21185 all_unreclaimable? yes [ 108.996433] lowmem_reserve[]: 0 245 245 245 [ 108.997538] Node 0 DMA32 free:1900kB min:1944kB low:2428kB high:2916kB active_anon:0kB inactive_anon:0kB active_file:208kB inactive_file:187912kB unevictable:1452kB isolated(anon):0kB isolated(file):0kB present:311288kB managed:251548kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:16968kB slab_unreclaimable:25080kB kernel_stack:1184kB pagetables:0kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:1364982 all_unreclaimable? yes [ 109.003371] lowmem_reserve[]: 0 0 0 0 [ 109.004361] Node 0 DMA: 1*4kB (R) 1*8kB (R) 0*16kB 0*32kB 1*64kB (R) 0*128kB 0*256kB 0*512kB 1*1024kB (R) 0*2048kB 0*4096kB = 1100kB [ 109.007287] Node 0 DMA32: 1*4kB (R) 1*8kB (R) 0*16kB 1*32kB (R) 1*64kB (R) 0*128kB 1*256kB (R) 1*512kB (R) 1*1024kB (R) 0*2048kB 0*4096kB = 1900kB [ 109.010553] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB [ 109.011840] 50513 total pagecache pages [ 109.012493] 81820 pages RAM [ 109.012999] 0 pages HighMem/MovableOnly [ 109.013662] 14935 pages reserved [ 109.740192] rb_consumer: page allocation failure: order:0, mode:0x10d0 [ 109.741188] CPU: 0 PID: 104 Comm: rb_consumer Not tainted 3.16.0-g6aaca9b #80 [ 109.742197] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 109.743057] 0000000000000001 ffff880010cbbc20 ffffffff88650896 0000000000000001 [ 109.744536] ffff880010cbbcb8 ffffffff877e016c ffff880010cbbcc8 0000000000000000 [ 109.746011] 0000000000000000 0000000000000000 0000000000000001 00000000000010d0 [ 109.747485] Call Trace: [ 109.747980] [<ffffffff88650896>] dump_stack+0x80/0xa8 [ 109.748770] [<ffffffff877e016c>] warn_alloc_failed+0x190/0x1cc [ 109.749643] [<ffffffff877e5856>] __alloc_pages_nodemask+0xda5/0xf21 [ 109.750596] [<ffffffff877abea1>] alloc_pages_node+0x42/0x44 [ 109.751568] [<ffffffff877aed83>] ring_buffer_alloc_read_page+0x17/0x4d [ 109.752522] [<ffffffff877af7a0>] ring_buffer_consumer_thread+0x1bc/0x422 [ 109.753494] [<ffffffff877af5e4>] ? ring_buffer_producer_thread+0x4fb/0x4fb [ 109.754484] [<ffffffff8772d01e>] kthread+0xf9/0x101 [ 109.755242] [<ffffffff8772cf25>] ? __kthread_parkme+0x86/0x86 [ 109.756108] [<ffffffff88661ffc>] ret_from_fork+0x7c/0xb0 [ 109.756925] [<ffffffff8772cf25>] ? __kthread_parkme+0x86/0x86 [ 109.757789] Mem-Info: [ 109.758259] Node 0 DMA per-cpu: [ 109.758893] CPU 0: hi: 0, btch: 1 usd: 0 [ 109.759640] Node 0 DMA32 per-cpu: [ 109.760318] CPU 0: hi: 90, btch: 15 usd: 14 [ 109.761063] active_anon:0 inactive_anon:0 isolated_anon:0 [ 109.761063] active_file:52 inactive_file:50095 isolated_file:0 [ 109.761063] unevictable:363 dirty:0 writeback:0 unstable:0 [ 109.761063] free:750 slab_reclaimable:4250 slab_unreclaimable:6589 [ 109.761063] mapped:0 shmem:0 pagetables:0 bounce:0 [ 109.761063] free_cma:0 [ 109.765368] Node 0 DMA free:1100kB min:120kB low:148kB high:180kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:12468kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:15992kB managed:15908kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:32kB slab_unreclaimable:1276kB kernel_stack:80kB pagetables:0kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:21217 all_unreclaimable? yes [ 109.770884] lowmem_reserve[]: 0 245 245 245 [ 109.771934] Node 0 DMA32 free:1900kB min:1944kB low:2428kB high:2916kB active_anon:0kB inactive_anon:0kB active_file:208kB inactive_file:187912kB unevictable:1452kB isolated(anon):0kB isolated(file):0kB present:311288kB managed:251548kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:16968kB slab_unreclaimable:25080kB kernel_stack:1184kB pagetables:0kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:1449495 all_unreclaimable? yes [ 109.777757] lowmem_reserve[]: 0 0 0 0 [ 109.778739] Node 0 DMA: 1*4kB (R) 1*8kB (R) 0*16kB 0*32kB 1*64kB (R) 0*128kB 0*256kB 0*512kB 1*1024kB (R) 0*2048kB 0*4096kB = 1100kB [ 109.781681] Node 0 DMA32: 1*4kB (R) 1*8kB (R) 0*16kB 1*32kB (R) 1*64kB (R) 0*128kB 1*256kB (R) 1*512kB (R) 1*1024kB (R) 0*2048kB 0*4096kB = 1900kB [ 109.784956] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB [ 109.786265] 50513 total pagecache pages [ 109.786900] 81820 pages RAM [ 109.787430] 0 pages HighMem/MovableOnly [ 109.788070] 14935 pages reserved [ 110.530188] rb_consumer: page allocation failure: order:0, mode:0x10d0 [ 110.531174] CPU: 0 PID: 104 Comm: rb_consumer Not tainted 3.16.0-g6aaca9b #80 [ 110.532183] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 110.533040] 0000000000000001 ffff880010cbbc20 ffffffff88650896 0000000000000001 [ 110.534518] ffff880010cbbcb8 ffffffff877e016c ffff880010cbbcc8 0000000000000000 [ 110.535995] 0000000000000000 0000000000000000 0000000000000001 00000000000010d0 [ 110.537470] Call Trace: [ 110.537962] [<ffffffff88650896>] dump_stack+0x80/0xa8 [ 110.538754] [<ffffffff877e016c>] warn_alloc_failed+0x190/0x1cc [ 110.539627] [<ffffffff877e5856>] __alloc_pages_nodemask+0xda5/0xf21 [ 110.540579] [<ffffffff877abea1>] alloc_pages_node+0x42/0x44 [ 110.541560] [<ffffffff877aed83>] ring_buffer_alloc_read_page+0x17/0x4d [ 110.542516] [<ffffffff877af7a0>] ring_buffer_consumer_thread+0x1bc/0x422 [ 110.543488] [<ffffffff877af5e4>] ? ring_buffer_producer_thread+0x4fb/0x4fb [ 110.544481] [<ffffffff8772d01e>] kthread+0xf9/0x101 [ 110.545247] [<ffffffff8772cf25>] ? __kthread_parkme+0x86/0x86 [ 110.546125] [<ffffffff88661ffc>] ret_from_fork+0x7c/0xb0 [ 110.546942] [<ffffffff8772cf25>] ? __kthread_parkme+0x86/0x86 [ 110.547802] Mem-Info: [ 110.548265] Node 0 DMA per-cpu: [ 110.548905] CPU 0: hi: 0, btch: 1 usd: 0 [ 110.549651] Node 0 DMA32 per-cpu: [ 110.550328] CPU 0: hi: 90, btch: 15 usd: 14 [ 110.551078] active_anon:0 inactive_anon:0 isolated_anon:0 [ 110.551078] active_file:52 inactive_file:50095 isolated_file:0 [ 110.551078] unevictable:363 dirty:0 writeback:0 unstable:0 [ 110.551078] free:750 slab_reclaimable:4250 slab_unreclaimable:6589 [ 110.551078] mapped:0 shmem:0 pagetables:0 bounce:0 [ 110.551078] free_cma:0 [ 110.555390] Node 0 DMA free:1100kB min:120kB low:148kB high:180kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:12468kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:15992kB managed:15908kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:32kB slab_unreclaimable:1276kB kernel_stack:80kB pagetables:0kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:21249 all_unreclaimable? yes [ 110.560878] lowmem_reserve[]: 0 245 245 245 [ 110.561929] Node 0 DMA32 free:1900kB min:1944kB low:2428kB high:2916kB active_anon:0kB inactive_anon:0kB active_file:208kB inactive_file:187912kB unevictable:1452kB isolated(anon):0kB isolated(file):0kB present:311288kB managed:251548kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:16968kB slab_unreclaimable:25080kB kernel_stack:1184kB pagetables:0kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:1535999 all_unreclaimable? yes [ 110.567775] lowmem_reserve[]: 0 0 0 0 [ 110.568758] Node 0 DMA: 1*4kB (R) 1*8kB (R) 0*16kB 0*32kB 1*64kB (R) 0*128kB 0*256kB 0*512kB 1*1024kB (R) 0*2048kB 0*4096kB = 1100kB [ 110.571704] Node 0 DMA32: 1*4kB (R) 1*8kB (R) 0*16kB 1*32kB (R) 1*64kB (R) 0*128kB 1*256kB (R) 1*512kB (R) 1*1024kB (R) 0*2048kB 0*4096kB = 1900kB [ 110.574971] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB [ 110.576268] 50513 total pagecache pages [ 110.576911] 81820 pages RAM [ 110.577436] 0 pages HighMem/MovableOnly [ 110.578070] 14935 pages reserved [ 122.450102] rcu_torture_sta invoked oom-killer: gfp_mask=0x40d0, order=2, oom_score_adj=0 [ 122.451284] rcu_torture_sta cpuset=/ mems_allowed=0 [ 122.452113] CPU: 0 PID: 101 Comm: rcu_torture_sta Not tainted 3.16.0-g6aaca9b #80 [ 122.453187] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 122.453942] 0000000000000001 ffff880010d87b30 ffffffff88650896 0000000000000000 [ 122.455259] ffff880010d87b98 ffffffff886493fa ffff880010d87b50 0000000000000246 [ 122.456697] ffff880010d87b88 ffffffff8775737a 0000000000000000 0000000000000000 [ 122.458102] Call Trace: [ 122.458535] [<ffffffff88650896>] dump_stack+0x80/0xa8 [ 122.459268] [<ffffffff886493fa>] dump_header+0x9c/0x249 [ 122.460089] [<ffffffff8775737a>] ? lock_release+0x18c/0x1dc [ 122.460872] [<ffffffff877de444>] out_of_memory+0x559/0x5ed [ 122.461616] [<ffffffff877e563d>] __alloc_pages_nodemask+0xb8c/0xf21 [ 122.462464] [<ffffffff8782eb9f>] alloc_pages_current+0x104/0x173 [ 122.463283] [<ffffffff877e0289>] alloc_kmem_pages+0x15/0x17 [ 122.464067] [<ffffffff877ff284>] kmalloc_order+0x18/0x46 [ 122.464804] [<ffffffff877ff2d6>] kmalloc_order_trace+0x24/0xe2 [ 122.465589] [<ffffffff87837f10>] __kmalloc+0x64/0x2b1 [ 122.466324] [<ffffffff8776b4cf>] rcu_torture_stats_print+0x2b/0x83 [ 122.472374] [<ffffffff8776b527>] ? rcu_torture_stats_print+0x83/0x83 [ 122.473209] [<ffffffff8776b573>] rcu_torture_stats+0x4c/0x71 [ 122.473962] [<ffffffff8772d01e>] kthread+0xf9/0x101 [ 122.474739] [<ffffffff8772cf25>] ? __kthread_parkme+0x86/0x86 [ 122.475546] [<ffffffff88661ffc>] ret_from_fork+0x7c/0xb0 [ 122.476331] [<ffffffff8772cf25>] ? __kthread_parkme+0x86/0x86 [ 122.477125] Mem-Info: [ 122.477539] Node 0 DMA per-cpu: [ 122.478136] CPU 0: hi: 0, btch: 1 usd: 0 [ 122.478829] Node 0 DMA32 per-cpu: [ 122.479405] CPU 0: hi: 90, btch: 15 usd: 0 [ 122.480110] active_anon:0 inactive_anon:0 isolated_anon:0 [ 122.480110] active_file:52 inactive_file:50062 isolated_file:32 [ 122.480110] unevictable:363 dirty:0 writeback:0 unstable:0 [ 122.480110] free:760 slab_reclaimable:4250 slab_unreclaimable:6589 [ 122.480110] mapped:0 shmem:0 pagetables:0 bounce:0 [ 122.480110] free_cma:0 [ 122.484047] Node 0 DMA free:1100kB min:120kB low:148kB high:180kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:12468kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:15992kB managed:15908kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:32kB slab_unreclaimable:1276kB kernel_stack:80kB pagetables:0kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:21345 all_unreclaimable? yes [ 122.489129] lowmem_reserve[]: 0 245 245 245 [ 122.490123] Node 0 DMA32 free:1940kB min:1944kB low:2428kB high:2916kB active_anon:0kB inactive_anon:0kB active_file:208kB inactive_file:187780kB unevictable:1452kB isolated(anon):0kB isolated(file):128kB present:311288kB managed:251548kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:16968kB slab_unreclaimable:25080kB kernel_stack:1184kB pagetables:0kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:284293 all_unreclaimable? yes [ 122.495424] lowmem_reserve[]: 0 0 0 0 [ 122.496351] Node 0 DMA: 1*4kB (R) 1*8kB (R) 0*16kB 0*32kB 1*64kB (R) 0*128kB 0*256kB 0*512kB 1*1024kB (R) 0*2048kB 0*4096kB = 1100kB [ 122.499021] Node 0 DMA32: 3*4kB (E) 1*8kB (R) 1*16kB (R) 0*32kB 0*64kB 1*128kB (R) 1*256kB (R) 1*512kB (R) 1*1024kB (R) 0*2048kB 0*4096kB = 1956kB [ 122.502017] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB [ 122.503191] 50513 total pagecache pages [ 122.503773] 81820 pages RAM [ 122.504250] 0 pages HighMem/MovableOnly [ 122.504829] 14935 pages reserved [ 122.505345] [ pid ] uid tgid total_vm rss nr_ptes swapents oom_score_adj name [ 122.506496] Kernel panic - not syncing: Out of memory and no killable processes... [ 122.506496] [ 122.507899] CPU: 0 PID: 101 Comm: rcu_torture_sta Not tainted 3.16.0-g6aaca9b #80 [ 122.508983] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 122.509757] 0000000000000001 ffff880010d87b18 ffffffff88650896 ffffffff88fd4035 [ 122.510083] ffff880010d87b98 ffffffff88648ec2 ffffffff00000008 ffff880010d87ba8 [ 122.510083] ffff880010d87b40 ffff880010d87b50 0000000000000001 0000000000000000 [ 122.510083] Call Trace: [ 122.510083] [<ffffffff88650896>] dump_stack+0x80/0xa8 [ 122.510083] [<ffffffff88648ec2>] panic+0x10f/0x2ba [ 122.510083] [<ffffffff877de452>] out_of_memory+0x567/0x5ed [ 122.510083] [<ffffffff877e563d>] __alloc_pages_nodemask+0xb8c/0xf21 [ 122.510083] [<ffffffff8782eb9f>] alloc_pages_current+0x104/0x173 [ 122.510083] [<ffffffff877e0289>] alloc_kmem_pages+0x15/0x17 [ 122.510083] [<ffffffff877ff284>] kmalloc_order+0x18/0x46 [ 122.510083] [<ffffffff877ff2d6>] kmalloc_order_trace+0x24/0xe2 [ 122.510083] [<ffffffff87837f10>] __kmalloc+0x64/0x2b1 [ 122.510083] [<ffffffff8776b4cf>] rcu_torture_stats_print+0x2b/0x83 [ 122.510083] [<ffffffff8776b527>] ? rcu_torture_stats_print+0x83/0x83 [ 122.510083] [<ffffffff8776b573>] rcu_torture_stats+0x4c/0x71 [ 122.510083] [<ffffffff8772d01e>] kthread+0xf9/0x101 [ 122.510083] [<ffffffff8772cf25>] ? __kthread_parkme+0x86/0x86 [ 122.510083] [<ffffffff88661ffc>] ret_from_fork+0x7c/0xb0 [ 122.510083] [<ffffffff8772cf25>] ? __kthread_parkme+0x86/0x86 [ 122.510083] Kernel Offset: 0x6600000 from 0xffffffff81000000 (relocation range: 0xffffffff80000000-0xffffffffbfffffff) Elapsed time: 125 qemu-system-x86_64 -enable-kvm -cpu SandyBridge -kernel /kernel/x86_64-randconfig-s1-01211233/6aaca9bab6116a2b392e7a07b5ff209741bc248f/vmlinuz-3.16.0-g6aaca9b -append 'user=lkp job=/lkp/scheduled/vm-kbuild-yocto-x86_64-22/bisect_boot-1-yocto-minimal-x86_64.cgz-x86_64-randconfig-s1-01211233-6aaca9bab6116a2b392e7a07b5ff209741bc248f-3.yaml ARCH=x86_64 BOOT_IMAGE=/kernel/x86_64-randconfig-s1-01211233/6aaca9bab6116a2b392e7a07b5ff209741bc248f/vmlinuz-3.16.0-g6aaca9b kconfig=x86_64-randconfig-s1-01211233 commit=6aaca9bab6116a2b392e7a07b5ff209741bc248f branch=next/master root=/dev/ram0 max_uptime=3600 RESULT_ROOT=/result/vm-kbuild-yocto-x86_64/boot/1/yocto-minimal-x86_64.cgz/x86_64-randconfig-s1-01211233/6aaca9bab6116a2b392e7a07b5ff209741bc248f/1 ip=::::vm-kbuild-yocto-x86_64-22::dhcp 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 rw drbd.minor_count=8' -initrd /fs/sde1/initrd-vm-kbuild-yocto-x86_64-22 -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/sde1/disk0-vm-kbuild-yocto-x86_64-22,media=disk,if=virtio -pidfile /dev/shm/kboot/pid-vm-kbuild-yocto-x86_64-22 -serial file:/dev/shm/kboot/serial-vm-kbuild-yocto-x86_64-22 -daemonize -display none -monitor null