[sched] WARNING: CPU: 0 PID: 11 at kernel/sched/core.c:1188 do_set_cpus_allowed()

From: Fengguang Wu
Date: Sun Jun 14 2015 - 04:54:45 EST


Hi Peter,

0day kernel testing robot got the below dmesg and the first bad commit is

git://git.kernel.org/pub/scm/linux/kernel/git/peterz/queue.git sched/core

commit 2ea0fdfb65e03094bba3a705b6e00c9a500d5101
Author: Peter Zijlstra <peterz@xxxxxxxxxxxxx>
AuthorDate: Fri May 15 17:43:34 2015 +0200
Commit: Peter Zijlstra <peterz@xxxxxxxxxxxxx>
CommitDate: Tue Jun 2 15:46:15 2015 +0200

sched: Fix a race between __kthread_bind() and sched_setaffinity()

Because sched_setscheduler() checks p->flags & PF_NO_SETAFFINITY
without locks, a caller might observe an old value and race with the
set_cpus_allowed_ptr() call from __kthread_bind() and effectively undo
it.

__kthread_bind()
do_set_cpus_allowed()
<SYSCALL>
sched_setaffinity()
if (p->flags & PF_NO_SETAFFINITIY)
set_cpus_allowed_ptr()
p->flags |= PF_NO_SETAFFINITY

Fix the issue by putting everything under the regular scheduler locks.

This also closes a hole in the serialization of
task_struct::{nr_,}cpus_allowed.

Cc: Oleg Nesterov <oleg@xxxxxxxxxx>
Cc: mingo@xxxxxxxxxx
Cc: riel@xxxxxxxxxx
Cc: dedekind1@xxxxxxxxx
Cc: mgorman@xxxxxxx
Cc: rostedt@xxxxxxxxxxx
Cc: juri.lelli@xxxxxxx
Acked-by: Tejun Heo <tj@xxxxxxxxxx>
Signed-off-by: Peter Zijlstra (Intel) <peterz@xxxxxxxxxxxxx>
Link: http://lkml.kernel.org/r/20150515154833.545640346@xxxxxxxxxxxxx

+-------------------------------------------------------+------------+------------+------------+
| | 94309ae387 | 2ea0fdfb65 | a28f5721ea |
+-------------------------------------------------------+------------+------------+------------+
| boot_successes | 900 | 289 | 209 |
| boot_failures | 0 | 11 | 3 |
| WARNING:at_kernel/sched/core.c:#do_set_cpus_allowed() | 0 | 11 | 3 |
| backtrace:smpboot_thread_fn | 0 | 11 | 3 |
+-------------------------------------------------------+------------+------------+------------+

[ 25.671242] EDD information not available.
[ 25.672183] Unregister pv shared memory for cpu 0
[ 25.986014] ------------[ cut here ]------------
[ 25.986014] WARNING: CPU: 0 PID: 11 at kernel/sched/core.c:1188 do_set_cpus_allowed+0x8e/0xf0()
[ 25.986014] CPU: 0 PID: 11 Comm: migration/0 Not tainted 4.1.0-rc6-00115-g2ea0fdf #1
[ 25.986014] 00000000 00000000 50a4bd48 41a09dc0 00000000 50a4bd7c 4105710c 41ce1bec
[ 25.986014] 00000000 0000000b 41ce30cc 000004a4 4108324e 000004a4 4108324e 4af38190
[ 25.986014] 00000002 4af382d8 50a4bd8c 41057200 00000009 00000000 50a4bda4 4108324e
[ 25.986014] Call Trace:
[ 25.986014] [<41a09dc0>] dump_stack+0x48/0x60
[ 25.986014] [<4105710c>] warn_slowpath_common+0x8c/0xc0
[ 25.986014] [<4108324e>] ? do_set_cpus_allowed+0x8e/0xf0
[ 25.986014] [<4108324e>] ? do_set_cpus_allowed+0x8e/0xf0
[ 25.986014] [<41057200>] warn_slowpath_null+0x20/0x30
[ 25.986014] [<4108324e>] do_set_cpus_allowed+0x8e/0xf0
[ 25.986014] [<4108359b>] select_fallback_rq+0x2eb/0x300
[ 25.986014] [<41084d1c>] migration_call+0xec/0x290
[ 25.986014] [<41562ece>] ? __delay+0xe/0x10
[ 25.986014] [<41079c89>] notifier_call_chain+0x59/0x70
[ 25.986014] [<4107a19e>] __raw_notifier_call_chain+0x1e/0x30
[ 25.986014] [<41057256>] cpu_notify+0x26/0x50
[ 25.986014] [<41a01462>] take_cpu_down+0x22/0x40
[ 25.986014] [<410f152d>] multi_cpu_stop+0xcd/0x140
[ 25.986014] [<410f1460>] ? cpu_stop_park+0x60/0x60
[ 25.986014] [<410f17d5>] cpu_stopper_thread+0x85/0x120
[ 25.986014] [<410a3fec>] ? trace_hardirqs_on_caller+0x13c/0x1e0
[ 25.986014] [<410a409b>] ? trace_hardirqs_on+0xb/0x10
[ 25.986014] [<410aa65e>] ? do_raw_spin_lock+0xe/0x1c0
[ 25.986014] [<410a3fec>] ? trace_hardirqs_on_caller+0x13c/0x1e0
[ 25.986014] [<410a409b>] ? trace_hardirqs_on+0xb/0x10
[ 25.986014] [<4107c5f4>] smpboot_thread_fn+0x144/0x250
[ 25.986014] [<4107c4b0>] ? sort_range+0x30/0x30
[ 25.986014] [<410789aa>] kthread+0xba/0xd0
[ 25.986014] [<41080000>] ? ftrace_raw_output_sched_wake_idle_without_ipi+0x20/0x70
[ 25.986014] [<41a13461>] ret_from_kernel_thread+0x21/0x30
[ 25.986014] [<410788f0>] ? insert_kthread_work+0x90/0x90
[ 25.986014] ---[ end trace 39f17a9725435b83 ]---
[ 26.079472] CPU 0 is now offline

git bisect start a28f5721ea3e387cabb9bdd69a56fa0519b827bf c65b99f046843d2455aa231747b5a07a999a9f3d --
git bisect bad 9d7edaa508475a065be5db19af006a06e999c64f # 17:53 0- 6 Merge 'bluetooth/master' into devel-spot-201506030813
git bisect bad 2ec19bfaf5097b0d51f637127ec322b8a07aad53 # 17:53 0- 19 Merge 'x86-mpx/mpx-v24' into devel-spot-201506030813
git bisect bad 75b43e7865e3d49fe5d26439295affa5c7dbfa13 # 17:53 0- 18 Merge 'dledford/k.o/for-4.2' into devel-spot-201506030813
git bisect good f6ed40e1cf411383f199b0c5444296b3ac19f547 # 17:53 300+ 0 Merge 'peterz-queue/perf/core' into devel-spot-201506030813
git bisect bad 2a8e405a6d774f98ca0a74b0c4a8e6e177c4a79c # 17:53 0- 17 Merge 'amirv/for-upstream' into devel-spot-201506030813
git bisect bad 4dda3866e84d40a66817a61a4cd34939aa5fd691 # 17:53 0- 20 Merge 'peterz-queue/master' into devel-spot-201506030813
git bisect good 2689c71810a6c5de51b8745921d242daf3f71005 # 18:01 300+ 224 kvm tools: Stop init if check_extensions failed
git bisect good 6ec97151b4c1f95bb7ca383d6b91b3e990471259 # 18:01 300+ 0 Merge branch 'x86/fpu'
git bisect good 915111910c2ffcefe5fa876d64727fdb647286fc # 18:13 300+ 376 kvm tools: use iovec functions in uip_rx
git bisect good 43fad805ca8dd7c7f46b7e52e819c4e0752de7dc # 18:13 300+ 0 Merge branch 'tools/kvm'
git bisect good 0868aa22167d93dd974c253d259c3e6fd47a16c8 # 18:23 300+ 3 Merge branches 'array.2015.05.27a', 'doc.2015.05.27a', 'fixes.2015.05.27a', 'hotplug.2015.05.27a', 'init.2015.05.27a', 'tiny.2015.05.27a' and 'torture.2015.05.27a' into HEAD
git bisect bad 59a906d08da336582829285caeb654d48677dab3 # 18:23 0- 20 sched: Change sched_class::set_cpus_allowed calling context
git bisect bad e22b8a5970d1a2c544a319105e715e7f266a62b8 # 18:24 0- 17 sched: Make sched_class::set_cpus_allowed() unconditional
git bisect good 30f9ab57b5415c7a92d870f800e14c6c4ad46252 # 18:26 300+ 0 sched,rt: Convert switched_{from,to}_rt() / prio_changed_rt() to balance callbacks
git bisect good dbd10e5378726f2e3e17b7e932d63133da4fba55 # 07:09 300+ 0 Merge branch 'sched/urgent'
git bisect bad 2ea0fdfb65e03094bba3a705b6e00c9a500d5101 # 07:13 14- 1 sched: Fix a race between __kthread_bind() and sched_setaffinity()
git bisect good 94309ae3871464d3e4105234ba66cb92fa63c1f8 # 19:09 300+ 0 sched: Move code around
# first bad commit: [2ea0fdfb65e03094bba3a705b6e00c9a500d5101] sched: Fix a race between __kthread_bind() and sched_setaffinity()
git bisect good 94309ae3871464d3e4105234ba66cb92fa63c1f8 # 19:26 900+ 0 sched: Move code around
# extra tests with DEBUG_INFO
git bisect bad 2ea0fdfb65e03094bba3a705b6e00c9a500d5101 # 19:36 11- 1 sched: Fix a race between __kthread_bind() and sched_setaffinity()
# extra tests on HEAD of linux-devel/devel-spot-201506030813
git bisect bad a28f5721ea3e387cabb9bdd69a56fa0519b827bf # 19:36 0- 3 0day head guard for 'devel-spot-201506030813'
# extra tests on tree/branch peterz-queue/sched/core
git bisect bad d4374648628fdefd467393b3bf797f348ecad42d # 19:49 68- 2 sched: prevent throttle in early pick_next_task_fair
# extra tests on tree/branch linus/master
git bisect good df5f4158415b6fc4a2d683c6fdc806be6da176bc # 09:09 900+ 1 Merge branch 'drm-fixes' of git://people.freedesktop.org/~airlied/linux
# extra tests on tree/branch next/master
git bisect good d9b5ec5b1b4d4055e256674de4a5337f6a66d284 # 22:12 900+ 591 Add linux-next specific files for 20150612


This script may reproduce the error.

----------------------------------------------------------------------------
#!/bin/bash

kernel=$1
initrd=quantal-core-i386.cgz

wget --no-clobber https://github.com/fengguang/reproduce-kernel-bug/raw/master/initrd/$initrd

kvm=(
qemu-system-x86_64
-enable-kvm
-cpu kvm64
-kernel $kernel
-initrd $initrd
-m 300
-smp 2
-device e1000,netdev=net0
-netdev user,id=net0
-boot order=nc
-no-reboot
-watchdog i6300esb
-rtc base=localtime
-serial stdio
-display none
-monitor null
)

append=(
hung_task_panic=1
earlyprintk=ttyS0,115200
systemd.log_level=err
debug
apic=debug
sysrq_always_enabled
rcupdate.rcu_cpu_stall_timeout=100
panic=-1
softlockup_panic=1
nmi_watchdog=panic
oops=panic
load_ramdisk=2
prompt_ramdisk=0
console=ttyS0,115200
console=tty0
vga=normal
root=/dev/ram0
rw
drbd.minor_count=8
)

"${kvm[@]}" --append "${append[*]}"
----------------------------------------------------------------------------

Thanks,
Fengguang
early console in setup code
early console in decompress_kernel

Decompressing Linux... Parsing ELF... done.
Booting the kernel.
[ 0.000000] Linux version 4.1.0-rc6-00115-g2ea0fdf (kbuild@ivytown2) (gcc version 4.9.2 (Debian 4.9.2-10) ) #1 SMP Fri Jun 12 07:10:54 CST 2015
[ 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-0x0000000012bdffff] usable
[ 0.000000] BIOS-e820: [mem 0x0000000012be0000-0x0000000012bfffff] 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] 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 = 0x12be0 max_arch_pfn = 0x1000000
[ 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] Scanning 1 areas for low memory corruption
[ 0.000000] initial memory mapped: [mem 0x00000000-0x035fffff]
[ 0.000000] Base memory trampoline at [4009b000] 9b000 size 16384
[ 0.000000] init_memory_mapping: [mem 0x00000000-0x000fffff]
[ 0.000000] [mem 0x00000000-0x000fffff] page 4k
[ 0.000000] init_memory_mapping: [mem 0x11000000-0x111fffff]
[ 0.000000] [mem 0x11000000-0x111fffff] page 2M
[ 0.000000] init_memory_mapping: [mem 0x00100000-0x10ffffff]
[ 0.000000] [mem 0x00100000-0x001fffff] page 4k
[ 0.000000] [mem 0x00200000-0x10ffffff] page 2M
[ 0.000000] init_memory_mapping: [mem 0x11200000-0x12bdffff]
[ 0.000000] [mem 0x11200000-0x129fffff] page 2M
[ 0.000000] [mem 0x12a00000-0x12bdffff] page 4k
[ 0.000000] BRK [0x02829000, 0x02829fff] PGTABLE
[ 0.000000] BRK [0x0282a000, 0x0282afff] PGTABLE
[ 0.000000] RAMDISK: [mem 0x11393000-0x12bd7fff]
[ 0.000000] ACPI: Early table checksum verification disabled
[ 0.000000] ACPI: RSDP 0x00000000000F0C60 000014 (v00 BOCHS )
[ 0.000000] ACPI: RSDT 0x0000000012BE18BD 000034 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001)
[ 0.000000] ACPI: FACP 0x0000000012BE0B37 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001)
[ 0.000000] ACPI: DSDT 0x0000000012BE0040 000AF7 (v01 BOCHS BXPCDSDT 00000001 BXPC 00000001)
[ 0.000000] ACPI: FACS 0x0000000012BE0000 000040
[ 0.000000] ACPI: SSDT 0x0000000012BE0BAB 000C5A (v01 BOCHS BXPCSSDT 00000001 BXPC 00000001)
[ 0.000000] ACPI: APIC 0x0000000012BE1805 000080 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001)
[ 0.000000] ACPI: HPET 0x0000000012BE1885 000038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001)
[ 0.000000] ACPI: Local APIC address 0xfee00000
[ 0.000000] mapped APIC to ffffc000 ( fee00000)
[ 0.000000] 0MB HIGHMEM available.
[ 0.000000] 299MB LOWMEM available.
[ 0.000000] mapped low ram: 0 - 12be0000
[ 0.000000] low ram: 0 - 12be0000
[ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
[ 0.000000] kvm-clock: cpu 0, msr 0:12bdf001, primary cpu clock
[ 0.000000] clocksource kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
[ 0.000000] Zone ranges:
[ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff]
[ 0.000000] Normal [mem 0x0000000001000000-0x0000000012bdffff]
[ 0.000000] HighMem empty
[ 0.000000] Movable zone start for each node
[ 0.000000] Early memory node ranges
[ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff]
[ 0.000000] node 0: [mem 0x0000000000100000-0x0000000012bdffff]
[ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000012bdffff]
[ 0.000000] On node 0 totalpages: 76670
[ 0.000000] DMA zone: 32 pages used for memmap
[ 0.000000] DMA zone: 0 pages reserved
[ 0.000000] DMA zone: 3998 pages, LIFO batch:0
[ 0.000000] Normal zone: 568 pages used for memmap
[ 0.000000] Normal zone: 72672 pages, LIFO batch:15
[ 0.000000] Using APIC driver default
[ 0.000000] ACPI: PM-Timer IO Port: 0x608
[ 0.000000] ACPI: Local APIC address 0xfee00000
[ 0.000000] mapped APIC to ffffc000 ( fee00000)
[ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
[ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
[ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 00, APIC ID 0, APIC INT 02
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
[ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 05, APIC ID 0, APIC INT 05
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 09, APIC ID 0, APIC INT 09
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
[ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 0a, APIC ID 0, APIC INT 0a
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
[ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 0b, APIC ID 0, APIC INT 0b
[ 0.000000] ACPI: IRQ0 used by override.
[ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 01, APIC ID 0, APIC INT 01
[ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 03, APIC ID 0, APIC INT 03
[ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 04, APIC ID 0, APIC INT 04
[ 0.000000] ACPI: IRQ5 used by override.
[ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 06, APIC ID 0, APIC INT 06
[ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 07, APIC ID 0, APIC INT 07
[ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 08, APIC ID 0, APIC INT 08
[ 0.000000] ACPI: IRQ9 used by override.
[ 0.000000] ACPI: IRQ10 used by override.
[ 0.000000] ACPI: IRQ11 used by override.
[ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0c, APIC ID 0, APIC INT 0c
[ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0d, APIC ID 0, APIC INT 0d
[ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0e, APIC ID 0, APIC INT 0e
[ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0f, APIC ID 0, APIC INT 0f
[ 0.000000] Using ACPI (MADT) for SMP configuration information
[ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000
[ 0.000000] smpboot: Allowing 2 CPUs, 0 hotplug CPUs
[ 0.000000] mapped IOAPIC to ffffb000 (fec00000)
[ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff]
[ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff]
[ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff]
[ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff]
[ 0.000000] e820: [mem 0x12c00000-0xfeffbfff] available for PCI devices
[ 0.000000] Booting paravirtualized kernel on KVM
[ 0.000000] clocksource refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
[ 0.000000] setup_percpu: NR_CPUS:8 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1
[ 0.000000] PERCPU: Embedded 17 pages/cpu @50f21000 s45504 r0 d24128 u69632
[ 0.000000] pcpu-alloc: s45504 r0 d24128 u69632 alloc=17*4096
[ 0.000000] pcpu-alloc: [0] 0 [0] 1
[ 0.000000] KVM setup async PF for cpu 0
[ 0.000000] kvm-stealtime: cpu 0, msr 10f24ac0
[ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 76070
[ 0.000000] Kernel command line: hung_task_panic=1 earlyprintk=ttyS0,115200 systemd.log_level=err debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 console=ttyS0,115200 console=tty0 vga=normal root=/dev/ram0 rw link=/kbuild-tests/run-queue/kvm/i386-randconfig-b0-06030907/linux-devel:devel-spot-201506030813:2ea0fdfb65e03094bba3a705b6e00c9a500d5101:bisect-linux-3/.vmlinuz-2ea0fdfb65e03094bba3a705b6e00c9a500d5101-20150612071114-111-vp branch=linux-devel/devel-spot-201506030813 BOOT_IMAGE=/pkg/linux/i386-randconfig-b0-06030907/gcc-4.9/2ea0fdfb65e03094bba3a705b6e00c9a500d5101/vmlinuz-4.1.0-rc6-00115-g2ea0fdf drbd.minor_count=8
[ 0.000000] PID hash table entries: 2048 (order: 1, 8192 bytes)
[ 0.000000] Dentry cache hash table entries: 65536 (order: 6, 262144 bytes)
[ 0.000000] Inode-cache hash table entries: 32768 (order: 5, 131072 bytes)
[ 0.000000] Initializing CPU#0
[ 0.000000] Initializing HighMem for node 0 (00000000:00000000)
[ 0.000000] Memory: 252032K/306680K available (10324K kernel code, 1148K rwdata, 3940K rodata, 600K init, 8576K bss, 54648K reserved, 0K cma-reserved, 0K highmem)
[ 0.000000] virtual kernel memory layout:
[ 0.000000] fixmap : 0xfff16000 - 0xfffff000 ( 932 kB)
[ 0.000000] pkmap : 0xffc00000 - 0xffe00000 (2048 kB)
[ 0.000000] vmalloc : 0x533e0000 - 0xffbfe000 (2760 MB)
[ 0.000000] lowmem : 0x40000000 - 0x52be0000 ( 299 MB)
[ 0.000000] .init : 0x41f11000 - 0x41fa7000 ( 600 kB)
[ 0.000000] .data : 0x41a156db - 0x41f0f300 (5095 kB)
[ 0.000000] .text : 0x41000000 - 0x41a156db (10325 kB)
[ 0.000000] Checking if this processor honours the WP bit even in supervisor mode...Ok.
[ 0.000000] Running RCU self tests
[ 0.000000] Hierarchical RCU implementation.
[ 0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
[ 0.000000]
[ 0.000000] **********************************************************
[ 0.000000] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE **
[ 0.000000] ** **
[ 0.000000] ** trace_printk() being used. Allocating extra memory. **
[ 0.000000] ** **
[ 0.000000] ** This means that this is a DEBUG kernel and it is **
[ 0.000000] ** unsafe for production use. **
[ 0.000000] ** **
[ 0.000000] ** If you see this message and you are not debugging **
[ 0.000000] ** the kernel, report this immediately to your vendor! **
[ 0.000000] ** **
[ 0.000000] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE **
[ 0.000000] **********************************************************
[ 0.000000] Testing tracer nop: PASSED
[ 0.000000] NR_IRQS:2304 nr_irqs:440 16
[ 0.000000] CPU 0 irqstacks, hard=509d4000 soft=509d6000
[ 0.000000] Linux version 4.1.0-rc6-00115-g2ea0fdf (kbuild@ivytown2) (gcc version 4.9.2 (Debian 4.9.2-10) ) #1 SMP Fri Jun 12 07:10:54 CST 2015
[ 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-0x0000000012bdffff] usable
[ 0.000000] BIOS-e820: [mem 0x0000000012be0000-0x0000000012bfffff] 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] 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 = 0x12be0 max_arch_pfn = 0x1000000
[ 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] Scanning 1 areas for low memory corruption
[ 0.000000] initial memory mapped: [mem 0x00000000-0x035fffff]
[ 0.000000] Base memory trampoline at [4009b000] 9b000 size 16384
[ 0.000000] init_memory_mapping: [mem 0x00000000-0x000fffff]
[ 0.000000] [mem 0x00000000-0x000fffff] page 4k
[ 0.000000] init_memory_mapping: [mem 0x11000000-0x111fffff]
[ 0.000000] [mem 0x11000000-0x111fffff] page 2M
[ 0.000000] init_memory_mapping: [mem 0x00100000-0x10ffffff]
[ 0.000000] [mem 0x00100000-0x001fffff] page 4k
[ 0.000000] [mem 0x00200000-0x10ffffff] page 2M
[ 0.000000] init_memory_mapping: [mem 0x11200000-0x12bdffff]
[ 0.000000] [mem 0x11200000-0x129fffff] page 2M
[ 0.000000] [mem 0x12a00000-0x12bdffff] page 4k
[ 0.000000] BRK [0x02829000, 0x02829fff] PGTABLE
[ 0.000000] BRK [0x0282a000, 0x0282afff] PGTABLE
[ 0.000000] RAMDISK: [mem 0x11393000-0x12bd7fff]
[ 0.000000] ACPI: Early table checksum verification disabled
[ 0.000000] ACPI: RSDP 0x00000000000F0C60 000014 (v00 BOCHS )
[ 0.000000] ACPI: RSDT 0x0000000012BE18BD 000034 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001)
[ 0.000000] ACPI: FACP 0x0000000012BE0B37 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001)
[ 0.000000] ACPI: DSDT 0x0000000012BE0040 000AF7 (v01 BOCHS BXPCDSDT 00000001 BXPC 00000001)
[ 0.000000] ACPI: FACS 0x0000000012BE0000 000040
[ 0.000000] ACPI: SSDT 0x0000000012BE0BAB 000C5A (v01 BOCHS BXPCSSDT 00000001 BXPC 00000001)
[ 0.000000] ACPI: APIC 0x0000000012BE1805 000080 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001)
[ 0.000000] ACPI: HPET 0x0000000012BE1885 000038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001)
[ 0.000000] ACPI: Local APIC address 0xfee00000
[ 0.000000] mapped APIC to ffffc000 ( fee00000)
[ 0.000000] 0MB HIGHMEM available.
[ 0.000000] 299MB LOWMEM available.
[ 0.000000] mapped low ram: 0 - 12be0000
[ 0.000000] low ram: 0 - 12be0000
[ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
[ 0.000000] kvm-clock: cpu 0, msr 0:12bdf001, primary cpu clock
[ 0.000000] clocksource kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
[ 0.000000] Zone ranges:
[ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff]
[ 0.000000] Normal [mem 0x0000000001000000-0x0000000012bdffff]
[ 0.000000] HighMem empty
[ 0.000000] Movable zone start for each node
[ 0.000000] Early memory node ranges
[ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff]
[ 0.000000] node 0: [mem 0x0000000000100000-0x0000000012bdffff]
[ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000012bdffff]
[ 0.000000] On node 0 totalpages: 76670
[ 0.000000] DMA zone: 32 pages used for memmap
[ 0.000000] DMA zone: 0 pages reserved
[ 0.000000] DMA zone: 3998 pages, LIFO batch:0
[ 0.000000] Normal zone: 568 pages used for memmap
[ 0.000000] Normal zone: 72672 pages, LIFO batch:15
[ 0.000000] Using APIC driver default
[ 0.000000] ACPI: PM-Timer IO Port: 0x608
[ 0.000000] ACPI: Local APIC address 0xfee00000
[ 0.000000] mapped APIC to ffffc000 ( fee00000)
[ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
[ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
[ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 00, APIC ID 0, APIC INT 02
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
[ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 05, APIC ID 0, APIC INT 05
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 09, APIC ID 0, APIC INT 09
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
[ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 0a, APIC ID 0, APIC INT 0a
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
[ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 0b, APIC ID 0, APIC INT 0b
[ 0.000000] ACPI: IRQ0 used by override.
[ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 01, APIC ID 0, APIC INT 01
[ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 03, APIC ID 0, APIC INT 03
[ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 04, APIC ID 0, APIC INT 04
[ 0.000000] ACPI: IRQ5 used by override.
[ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 06, APIC ID 0, APIC INT 06
[ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 07, APIC ID 0, APIC INT 07
[ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 08, APIC ID 0, APIC INT 08
[ 0.000000] ACPI: IRQ9 used by override.
[ 0.000000] ACPI: IRQ10 used by override.
[ 0.000000] ACPI: IRQ11 used by override.
[ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0c, APIC ID 0, APIC INT 0c
[ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0d, APIC ID 0, APIC INT 0d
[ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0e, APIC ID 0, APIC INT 0e
[ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0f, APIC ID 0, APIC INT 0f
[ 0.000000] Using ACPI (MADT) for SMP configuration information
[ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000
[ 0.000000] smpboot: Allowing 2 CPUs, 0 hotplug CPUs
[ 0.000000] mapped IOAPIC to ffffb000 (fec00000)
[ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff]
[ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff]
[ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff]
[ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff]
[ 0.000000] e820: [mem 0x12c00000-0xfeffbfff] available for PCI devices
[ 0.000000] Booting paravirtualized kernel on KVM
[ 0.000000] clocksource refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
[ 0.000000] setup_percpu: NR_CPUS:8 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1
[ 0.000000] PERCPU: Embedded 17 pages/cpu @50f21000 s45504 r0 d24128 u69632
[ 0.000000] pcpu-alloc: s45504 r0 d24128 u69632 alloc=17*4096
[ 0.000000] pcpu-alloc: [0] 0 [0] 1
[ 0.000000] KVM setup async PF for cpu 0
[ 0.000000] kvm-stealtime: cpu 0, msr 10f24ac0
[ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 76070
[ 0.000000] Kernel command line: hung_task_panic=1 earlyprintk=ttyS0,115200 systemd.log_level=err debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 console=ttyS0,115200 console=tty0 vga=normal root=/dev/ram0 rw link=/kbuild-tests/run-queue/kvm/i386-randconfig-b0-06030907/linux-devel:devel-spot-201506030813:2ea0fdfb65e03094bba3a705b6e00c9a500d5101:bisect-linux-3/.vmlinuz-2ea0fdfb65e03094bba3a705b6e00c9a500d5101-20150612071114-111-vp branch=linux-devel/devel-spot-201506030813 BOOT_IMAGE=/pkg/linux/i386-randconfig-b0-06030907/gcc-4.9/2ea0fdfb65e03094bba3a705b6e00c9a500d5101/vmlinuz-4.1.0-rc6-00115-g2ea0fdf drbd.minor_count=8
[ 0.000000] PID hash table entries: 2048 (order: 1, 8192 bytes)
[ 0.000000] Dentry cache hash table entries: 65536 (order: 6, 262144 bytes)
[ 0.000000] Inode-cache hash table entries: 32768 (order: 5, 131072 bytes)
[ 0.000000] Initializing CPU#0
[ 0.000000] Initializing HighMem for node 0 (00000000:00000000)
[ 0.000000] Memory: 252032K/306680K available (10324K kernel code, 1148K rwdata, 3940K rodata, 600K init, 8576K bss, 54648K reserved, 0K cma-reserved, 0K highmem)
[ 0.000000] virtual kernel memory layout:
[ 0.000000] fixmap : 0xfff16000 - 0xfffff000 ( 932 kB)
[ 0.000000] pkmap : 0xffc00000 - 0xffe00000 (2048 kB)
[ 0.000000] vmalloc : 0x533e0000 - 0xffbfe000 (2760 MB)
[ 0.000000] lowmem : 0x40000000 - 0x52be0000 ( 299 MB)
[ 0.000000] .init : 0x41f11000 - 0x41fa7000 ( 600 kB)
[ 0.000000] .data : 0x41a156db - 0x41f0f300 (5095 kB)
[ 0.000000] .text : 0x41000000 - 0x41a156db (10325 kB)
[ 0.000000] Checking if this processor honours the WP bit even in supervisor mode...Ok.
[ 0.000000] Running RCU self tests
[ 0.000000] Hierarchical RCU implementation.
[ 0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
[ 0.000000]
[ 0.000000] **********************************************************
[ 0.000000] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE **
[ 0.000000] ** **
[ 0.000000] ** trace_printk() being used. Allocating extra memory. **
[ 0.000000] ** **
[ 0.000000] ** This means that this is a DEBUG kernel and it is **
[ 0.000000] ** unsafe for production use. **
[ 0.000000] ** **
[ 0.000000] ** If you see this message and you are not debugging **
[ 0.000000] ** the kernel, report this immediately to your vendor! **
[ 0.000000] ** **
[ 0.000000] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE **
[ 0.000000] **********************************************************
[ 0.000000] Testing tracer nop: PASSED
[ 0.000000] NR_IRQS:2304 nr_irqs:440 16
[ 0.000000] CPU 0 irqstacks, hard=509d4000 soft=509d6000
[ 0.000000] console [ttyS0] enabled
[ 0.000000] console [ttyS0] enabled
[ 0.000000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
[ 0.000000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
[ 0.000000] ... MAX_LOCKDEP_SUBCLASSES: 8
[ 0.000000] ... MAX_LOCKDEP_SUBCLASSES: 8
[ 0.000000] ... MAX_LOCK_DEPTH: 48
[ 0.000000] ... MAX_LOCK_DEPTH: 48
[ 0.000000] ... MAX_LOCKDEP_KEYS: 8191
[ 0.000000] ... MAX_LOCKDEP_KEYS: 8191
[ 0.000000] ... CLASSHASH_SIZE: 4096
[ 0.000000] ... CLASSHASH_SIZE: 4096
[ 0.000000] ... MAX_LOCKDEP_ENTRIES: 32768
[ 0.000000] ... MAX_LOCKDEP_ENTRIES: 32768
[ 0.000000] ... MAX_LOCKDEP_CHAINS: 65536
[ 0.000000] ... MAX_LOCKDEP_CHAINS: 65536
[ 0.000000] ... CHAINHASH_SIZE: 32768
[ 0.000000] ... CHAINHASH_SIZE: 32768
[ 0.000000] memory used by lock dependency info: 4911 kB
[ 0.000000] memory used by lock dependency info: 4911 kB
[ 0.000000] per task-struct memory footprint: 1152 bytes
[ 0.000000] per task-struct memory footprint: 1152 bytes
[ 0.000000] ------------------------
[ 0.000000] ------------------------
[ 0.000000] | Locking API testsuite:
[ 0.000000] | Locking API testsuite:
[ 0.000000] ----------------------------------------------------------------------------
[ 0.000000] ----------------------------------------------------------------------------
[ 0.000000] | spin |wlock |rlock |mutex | wsem | rsem |
[ 0.000000] | spin |wlock |rlock |mutex | wsem | rsem |
[ 0.000000] --------------------------------------------------------------------------
[ 0.000000] --------------------------------------------------------------------------
[ 0.000000] A-A deadlock:
[ 0.000000] A-A deadlock: ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | ok |

[ 0.000000] A-B-B-A deadlock:
[ 0.000000] A-B-B-A deadlock: ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | ok |

[ 0.000000] A-B-B-C-C-A deadlock:
[ 0.000000] A-B-B-C-C-A deadlock: ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | ok |

[ 0.000000] A-B-C-A-B-C deadlock:
[ 0.000000] A-B-C-A-B-C deadlock: ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | ok |

[ 0.000000] A-B-B-C-C-D-D-A deadlock:
[ 0.000000] A-B-B-C-C-D-D-A deadlock: ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | ok |

[ 0.000000] A-B-C-D-B-D-D-A deadlock:
[ 0.000000] A-B-C-D-B-D-D-A deadlock: ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | ok |

[ 0.000000] A-B-C-D-B-C-D-A deadlock:
[ 0.000000] A-B-C-D-B-C-D-A deadlock: ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | ok |

[ 0.000000] double unlock:
[ 0.000000] double unlock: ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | ok |

[ 0.000000] initialize held:
[ 0.000000] initialize held: ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | ok |

[ 0.000000] bad unlock order:
[ 0.000000] bad unlock order: ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | ok |

[ 0.000000] --------------------------------------------------------------------------
[ 0.000000] --------------------------------------------------------------------------
[ 0.000000] recursive read-lock:
[ 0.000000] recursive read-lock: | | ok | ok | | | ok | ok |

[ 0.000000] recursive read-lock #2:
[ 0.000000] recursive read-lock #2: | | ok | ok | | | ok | ok |

[ 0.000000] mixed read-write-lock:
[ 0.000000] mixed read-write-lock: | | ok | ok | | | ok | ok |

[ 0.000000] mixed write-read-lock:
[ 0.000000] mixed write-read-lock: | | ok | ok | | | ok | ok |

[ 0.000000] --------------------------------------------------------------------------
[ 0.000000] --------------------------------------------------------------------------
[ 0.000000] hard-irqs-on + irq-safe-A/12:
[ 0.000000] hard-irqs-on + irq-safe-A/12: ok | ok | ok | ok | ok | ok |

[ 0.000000] soft-irqs-on + irq-safe-A/12:
[ 0.000000] soft-irqs-on + irq-safe-A/12: ok | ok | ok | ok | ok | ok |

[ 0.000000] hard-irqs-on + irq-safe-A/21:
[ 0.000000] hard-irqs-on + irq-safe-A/21: ok | ok | ok | ok | ok | ok |

[ 0.000000] soft-irqs-on + irq-safe-A/21:
[ 0.000000] soft-irqs-on + irq-safe-A/21: ok | ok | ok | ok | ok | ok |

[ 0.000000] sirq-safe-A => hirqs-on/12:
[ 0.000000] sirq-safe-A => hirqs-on/12: ok | ok | ok | ok | ok | ok |

[ 0.000000] sirq-safe-A => hirqs-on/21:
[ 0.000000] sirq-safe-A => hirqs-on/21: ok | ok | ok | ok | ok | ok |

[ 0.000000] hard-safe-A + irqs-on/12:
[ 0.000000] hard-safe-A + irqs-on/12: ok | ok | ok | ok | ok | ok |

[ 0.000000] soft-safe-A + irqs-on/12:
[ 0.000000] soft-safe-A + irqs-on/12: ok | ok | ok | ok | ok | ok |

[ 0.000000] hard-safe-A + irqs-on/21:
[ 0.000000] hard-safe-A + irqs-on/21: ok | ok | ok | ok | ok | ok |

[ 0.000000] soft-safe-A + irqs-on/21:
[ 0.000000] soft-safe-A + irqs-on/21: ok | ok | ok | ok | ok | ok |

[ 0.000000] hard-safe-A + unsafe-B #1/123:
[ 0.000000] hard-safe-A + unsafe-B #1/123: ok | ok | ok | ok | ok | ok |

[ 0.000000] soft-safe-A + unsafe-B #1/123:
[ 0.000000] soft-safe-A + unsafe-B #1/123: ok | ok | ok | ok | ok | ok |

[ 0.000000] hard-safe-A + unsafe-B #1/132:
[ 0.000000] hard-safe-A + unsafe-B #1/132: ok | ok | ok | ok | ok | ok |

[ 0.000000] soft-safe-A + unsafe-B #1/132:
[ 0.000000] soft-safe-A + unsafe-B #1/132: ok | ok | ok | ok | ok | ok |

[ 0.000000] hard-safe-A + unsafe-B #1/213:
[ 0.000000] hard-safe-A + unsafe-B #1/213: ok | ok | ok | ok | ok | ok |

[ 0.000000] soft-safe-A + unsafe-B #1/213:
[ 0.000000] soft-safe-A + unsafe-B #1/213: ok | ok | ok | ok | ok | ok |

[ 0.000000] hard-safe-A + unsafe-B #1/231:
[ 0.000000] hard-safe-A + unsafe-B #1/231: ok | ok | ok | ok | ok | ok |

[ 0.000000] soft-safe-A + unsafe-B #1/231:
[ 0.000000] soft-safe-A + unsafe-B #1/231: ok | ok | ok | ok | ok | ok |

[ 0.000000] hard-safe-A + unsafe-B #1/312:
[ 0.000000] hard-safe-A + unsafe-B #1/312: ok | ok | ok | ok | ok | ok |

[ 0.000000] soft-safe-A + unsafe-B #1/312:
[ 0.000000] soft-safe-A + unsafe-B #1/312: ok | ok | ok | ok | ok | ok |

[ 0.000000] hard-safe-A + unsafe-B #1/321:
[ 0.000000] hard-safe-A + unsafe-B #1/321: ok | ok | ok | ok | ok | ok |

[ 0.000000] soft-safe-A + unsafe-B #1/321:
[ 0.000000] soft-safe-A + unsafe-B #1/321: ok | ok | ok | ok | ok | ok |

[ 0.000000] hard-safe-A + unsafe-B #2/123:
[ 0.000000] hard-safe-A + unsafe-B #2/123: ok | ok | ok | ok | ok | ok |

[ 0.000000] soft-safe-A + unsafe-B #2/123:
[ 0.000000] soft-safe-A + unsafe-B #2/123: ok | ok | ok | ok | ok | ok |

[ 0.000000] hard-safe-A + unsafe-B #2/132:
[ 0.000000] hard-safe-A + unsafe-B #2/132: ok | ok | ok | ok | ok | ok |

[ 0.000000] soft-safe-A + unsafe-B #2/132:
[ 0.000000] soft-safe-A + unsafe-B #2/132: ok | ok | ok | ok | ok | ok |

[ 0.000000] hard-safe-A + unsafe-B #2/213:
[ 0.000000] hard-safe-A + unsafe-B #2/213: ok | ok | ok | ok | ok | ok |

[ 0.000000] soft-safe-A + unsafe-B #2/213:
[ 0.000000] soft-safe-A + unsafe-B #2/213: ok | ok | ok | ok | ok | ok |

[ 0.000000] hard-safe-A + unsafe-B #2/231:
[ 0.000000] hard-safe-A + unsafe-B #2/231: ok | ok | ok | ok | ok | ok |

[ 0.000000] soft-safe-A + unsafe-B #2/231:
[ 0.000000] soft-safe-A + unsafe-B #2/231: ok | ok | ok | ok | ok | ok |

[ 0.000000] hard-safe-A + unsafe-B #2/312:
[ 0.000000] hard-safe-A + unsafe-B #2/312: ok | ok | ok | ok | ok | ok |

[ 0.000000] soft-safe-A + unsafe-B #2/312:
[ 0.000000] soft-safe-A + unsafe-B #2/312: ok | ok | ok | ok | ok | ok |

[ 0.000000] hard-safe-A + unsafe-B #2/321:
[ 0.000000] hard-safe-A + unsafe-B #2/321: ok | ok | ok | ok | ok | ok |

[ 0.000000] soft-safe-A + unsafe-B #2/321:
[ 0.000000] soft-safe-A + unsafe-B #2/321: ok | ok | ok | ok | ok | ok |

[ 0.000000] hard-irq lock-inversion/123:
[ 0.000000] hard-irq lock-inversion/123: ok | ok | ok | ok | ok | ok |

[ 0.000000] soft-irq lock-inversion/123:
[ 0.000000] soft-irq lock-inversion/123: ok | ok | ok | ok | ok | ok |

[ 0.000000] hard-irq lock-inversion/132:
[ 0.000000] hard-irq lock-inversion/132: ok | ok | ok | ok | ok | ok |

[ 0.000000] soft-irq lock-inversion/132:
[ 0.000000] soft-irq lock-inversion/132: ok | ok | ok | ok | ok | ok |

[ 0.000000] hard-irq lock-inversion/213:
[ 0.000000] hard-irq lock-inversion/213: ok | ok | ok | ok | ok | ok |

[ 0.000000] soft-irq lock-inversion/213:
[ 0.000000] soft-irq lock-inversion/213: ok | ok | ok | ok | ok | ok |

[ 0.000000] hard-irq lock-inversion/231:
[ 0.000000] hard-irq lock-inversion/231: ok | ok | ok | ok | ok | ok |

[ 0.000000] soft-irq lock-inversion/231:
[ 0.000000] soft-irq lock-inversion/231: ok | ok | ok | ok | ok | ok |

[ 0.000000] hard-irq lock-inversion/312:
[ 0.000000] hard-irq lock-inversion/312: ok | ok | ok | ok | ok | ok |

[ 0.000000] soft-irq lock-inversion/312:
[ 0.000000] soft-irq lock-inversion/312: ok | ok | ok | ok | ok | ok |

[ 0.000000] hard-irq lock-inversion/321:
[ 0.000000] hard-irq lock-inversion/321: ok | ok | ok | ok | ok | ok |

[ 0.000000] soft-irq lock-inversion/321:
[ 0.000000] soft-irq lock-inversion/321: ok | ok | ok | ok | ok | ok |

[ 0.000000] hard-irq read-recursion/123:
[ 0.000000] hard-irq read-recursion/123: ok | ok |

[ 0.000000] soft-irq read-recursion/123:
[ 0.000000] soft-irq read-recursion/123: ok | ok |

[ 0.000000] hard-irq read-recursion/132:
[ 0.000000] hard-irq read-recursion/132: ok | ok |

[ 0.000000] soft-irq read-recursion/132:
[ 0.000000] soft-irq read-recursion/132: ok | ok |

[ 0.000000] hard-irq read-recursion/213:
[ 0.000000] hard-irq read-recursion/213: ok | ok |

[ 0.000000] soft-irq read-recursion/213:
[ 0.000000] soft-irq read-recursion/213: ok | ok |

[ 0.000000] hard-irq read-recursion/231:
[ 0.000000] hard-irq read-recursion/231: ok | ok |

[ 0.000000] soft-irq read-recursion/231:
[ 0.000000] soft-irq read-recursion/231: ok | ok |

[ 0.000000] hard-irq read-recursion/312:
[ 0.000000] hard-irq read-recursion/312: ok | ok |

[ 0.000000] soft-irq read-recursion/312:
[ 0.000000] soft-irq read-recursion/312: ok | ok |

[ 0.000000] hard-irq read-recursion/321:
[ 0.000000] hard-irq read-recursion/321: ok | ok |

[ 0.000000] soft-irq read-recursion/321:
[ 0.000000] soft-irq read-recursion/321: ok | ok |

[ 0.000000] --------------------------------------------------------------------------
[ 0.000000] --------------------------------------------------------------------------
[ 0.000000] | Wound/wait tests |
[ 0.000000] | Wound/wait tests |
[ 0.000000] ---------------------
[ 0.000000] ---------------------
[ 0.000000] ww api failures:
[ 0.000000] ww api failures: ok | ok | ok | ok | ok | ok |

[ 0.000000] ww contexts mixing:
[ 0.000000] ww contexts mixing: ok | ok | ok | ok |

[ 0.000000] finishing ww context:
[ 0.000000] finishing ww context: ok | ok | ok | ok | ok | ok | ok | ok |

[ 0.000000] locking mismatches:
[ 0.000000] locking mismatches: ok | ok | ok | ok | ok | ok |

[ 0.000000] EDEADLK handling:
[ 0.000000] EDEADLK handling: ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | ok |

[ 0.000000] spinlock nest unlocked:
[ 0.000000] spinlock nest unlocked: ok | ok |

[ 0.000000] -----------------------------------------------------
[ 0.000000] -----------------------------------------------------
[ 0.000000] |block | try |context|
[ 0.000000] |block | try |context|
[ 0.000000] -----------------------------------------------------
[ 0.000000] -----------------------------------------------------
[ 0.000000] context:
[ 0.000000] context: ok | ok | ok | ok | ok | ok |

[ 0.000000] try:
[ 0.000000] try: ok | ok | ok | ok | ok | ok |

[ 0.000000] block:
[ 0.000000] block: ok | ok | ok | ok | ok | ok |

[ 0.000000] spinlock:
[ 0.000000] spinlock: ok | ok | ok | ok | ok | ok |

[ 0.000000] -------------------------------------------------------
[ 0.000000] -------------------------------------------------------
[ 0.000000] Good, all 253 testcases passed! |
[ 0.000000] Good, all 253 testcases passed! |
[ 0.000000] ---------------------------------
[ 0.000000] ---------------------------------
[ 0.000000] clocksource hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
[ 0.000000] clocksource hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
[ 0.000000] hpet clockevent registered
[ 0.000000] hpet clockevent registered
[ 0.000000] tsc: Detected 2693.508 MHz processor
[ 0.000000] tsc: Detected 2693.508 MHz processor
[ 0.003000] Calibrating delay loop (skipped) preset value..
[ 0.003000] Calibrating delay loop (skipped) preset value.. 5387.01 BogoMIPS (lpj=2693508)
5387.01 BogoMIPS (lpj=2693508)
[ 0.004008] pid_max: default: 32768 minimum: 301
[ 0.004008] pid_max: default: 32768 minimum: 301
[ 0.005082] ACPI: Core revision 20150410
[ 0.005082] ACPI: Core revision 20150410
[ 0.028313] ACPI:
[ 0.028313] ACPI: All ACPI Tables successfully acquiredAll ACPI Tables successfully acquired

[ 0.029413] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
[ 0.029413] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
[ 0.030019] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
[ 0.030019] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
[ 0.034254] mce: CPU supports 10 MCE banks
[ 0.034254] mce: CPU supports 10 MCE banks
[ 0.035090] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
[ 0.035090] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
[ 0.037008] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
[ 0.037008] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
[ 0.040250] Freeing SMP alternatives memory: 28K (41fa7000 - 41fae000)
[ 0.040250] Freeing SMP alternatives memory: 28K (41fa7000 - 41fae000)
[ 0.061233] Enabling APIC mode: Flat. Using 1 I/O APICs
[ 0.061233] Enabling APIC mode: Flat. Using 1 I/O APICs
[ 0.063039] enabled ExtINT on CPU#0
[ 0.063039] enabled ExtINT on CPU#0
[ 0.066171] ENABLING IO-APIC IRQs
[ 0.066171] ENABLING IO-APIC IRQs
[ 0.067045] init IO_APIC IRQs
[ 0.067045] init IO_APIC IRQs
[ 0.068007] apic 0 pin 0 not connected
[ 0.068007] apic 0 pin 0 not connected
[ 0.069082] IOAPIC[0]: Set routing entry (0-1 -> 0x31 -> IRQ 1 Mode:0 Active:0 Dest:1)
[ 0.069082] IOAPIC[0]: Set routing entry (0-1 -> 0x31 -> IRQ 1 Mode:0 Active:0 Dest:1)
[ 0.070073] IOAPIC[0]: Set routing entry (0-2 -> 0x30 -> IRQ 0 Mode:0 Active:0 Dest:1)
[ 0.070073] IOAPIC[0]: Set routing entry (0-2 -> 0x30 -> IRQ 0 Mode:0 Active:0 Dest:1)
[ 0.071044] IOAPIC[0]: Set routing entry (0-2 -> 0x30 -> IRQ 0 Mode:0 Active:0 Dest:1)
[ 0.071044] IOAPIC[0]: Set routing entry (0-2 -> 0x30 -> IRQ 0 Mode:0 Active:0 Dest:1)
[ 0.072062] IOAPIC[0]: Set routing entry (0-3 -> 0x33 -> IRQ 3 Mode:0 Active:0 Dest:1)
[ 0.072062] IOAPIC[0]: Set routing entry (0-3 -> 0x33 -> IRQ 3 Mode:0 Active:0 Dest:1)
[ 0.073076] IOAPIC[0]: Set routing entry (0-4 -> 0x34 -> IRQ 4 Mode:0 Active:0 Dest:1)
[ 0.073076] IOAPIC[0]: Set routing entry (0-4 -> 0x34 -> IRQ 4 Mode:0 Active:0 Dest:1)
[ 0.074058] IOAPIC[0]: Set routing entry (0-5 -> 0x35 -> IRQ 5 Mode:1 Active:0 Dest:1)
[ 0.074058] IOAPIC[0]: Set routing entry (0-5 -> 0x35 -> IRQ 5 Mode:1 Active:0 Dest:1)
[ 0.075056] IOAPIC[0]: Set routing entry (0-6 -> 0x36 -> IRQ 6 Mode:0 Active:0 Dest:1)
[ 0.075056] IOAPIC[0]: Set routing entry (0-6 -> 0x36 -> IRQ 6 Mode:0 Active:0 Dest:1)
[ 0.076060] IOAPIC[0]: Set routing entry (0-7 -> 0x37 -> IRQ 7 Mode:0 Active:0 Dest:1)
[ 0.076060] IOAPIC[0]: Set routing entry (0-7 -> 0x37 -> IRQ 7 Mode:0 Active:0 Dest:1)
[ 0.078058] IOAPIC[0]: Set routing entry (0-8 -> 0x38 -> IRQ 8 Mode:0 Active:0 Dest:1)
[ 0.078058] IOAPIC[0]: Set routing entry (0-8 -> 0x38 -> IRQ 8 Mode:0 Active:0 Dest:1)
[ 0.080066] IOAPIC[0]: Set routing entry (0-9 -> 0x39 -> IRQ 9 Mode:1 Active:0 Dest:1)
[ 0.080066] IOAPIC[0]: Set routing entry (0-9 -> 0x39 -> IRQ 9 Mode:1 Active:0 Dest:1)
[ 0.081056] IOAPIC[0]: Set routing entry (0-10 -> 0x3a -> IRQ 10 Mode:1 Active:0 Dest:1)
[ 0.081056] IOAPIC[0]: Set routing entry (0-10 -> 0x3a -> IRQ 10 Mode:1 Active:0 Dest:1)
[ 0.082056] IOAPIC[0]: Set routing entry (0-11 -> 0x3b -> IRQ 11 Mode:1 Active:0 Dest:1)
[ 0.082056] IOAPIC[0]: Set routing entry (0-11 -> 0x3b -> IRQ 11 Mode:1 Active:0 Dest:1)
[ 0.083075] IOAPIC[0]: Set routing entry (0-12 -> 0x3c -> IRQ 12 Mode:0 Active:0 Dest:1)
[ 0.083075] IOAPIC[0]: Set routing entry (0-12 -> 0x3c -> IRQ 12 Mode:0 Active:0 Dest:1)
[ 0.084062] IOAPIC[0]: Set routing entry (0-13 -> 0x3d -> IRQ 13 Mode:0 Active:0 Dest:1)
[ 0.084062] IOAPIC[0]: Set routing entry (0-13 -> 0x3d -> IRQ 13 Mode:0 Active:0 Dest:1)
[ 0.085065] IOAPIC[0]: Set routing entry (0-14 -> 0x3e -> IRQ 14 Mode:0 Active:0 Dest:1)
[ 0.085065] IOAPIC[0]: Set routing entry (0-14 -> 0x3e -> IRQ 14 Mode:0 Active:0 Dest:1)
[ 0.086060] IOAPIC[0]: Set routing entry (0-15 -> 0x3f -> IRQ 15 Mode:0 Active:0 Dest:1)
[ 0.086060] IOAPIC[0]: Set routing entry (0-15 -> 0x3f -> IRQ 15 Mode:0 Active:0 Dest:1)
[ 0.087043] apic 0 pin 16 not connected
[ 0.087043] apic 0 pin 16 not connected
[ 0.088010] apic 0 pin 17 not connected
[ 0.088010] apic 0 pin 17 not connected
[ 0.089008] apic 0 pin 18 not connected
[ 0.089008] apic 0 pin 18 not connected
[ 0.090007] apic 0 pin 19 not connected
[ 0.090007] apic 0 pin 19 not connected
[ 0.091009] apic 0 pin 20 not connected
[ 0.091009] apic 0 pin 20 not connected
[ 0.092008] apic 0 pin 21 not connected
[ 0.092008] apic 0 pin 21 not connected
[ 0.093011] apic 0 pin 22 not connected
[ 0.093011] apic 0 pin 22 not connected
[ 0.095006] apic 0 pin 23 not connected
[ 0.095006] apic 0 pin 23 not connected
[ 0.096186] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[ 0.096186] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[ 0.097012] Using local APIC timer interrupts.
[ 0.097012] calibrating APIC timer ...
[ 0.097012] Using local APIC timer interrupts.
[ 0.097012] calibrating APIC timer ...
[ 0.099000] ... lapic delta = 9562057
[ 0.099000] ... lapic delta = 9562057
[ 0.099000] ... PM-Timer delta = 547642
[ 0.099000] ... PM-Timer delta = 547642
[ 0.099000] APIC calibration not consistent with PM-Timer: 152ms instead of 100ms
[ 0.099000] APIC calibration not consistent with PM-Timer: 152ms instead of 100ms
[ 0.099000] APIC delta adjusted to PM-Timer: 6250025 (9562057)
[ 0.099000] APIC delta adjusted to PM-Timer: 6250025 (9562057)
[ 0.099000] TSC delta adjusted to PM-Timer: 269350485 (412085460)
[ 0.099000] TSC delta adjusted to PM-Timer: 269350485 (412085460)
[ 0.099000] ..... delta 6250025
[ 0.099000] ..... delta 6250025
[ 0.099000] ..... mult: 268436529
[ 0.099000] ..... mult: 268436529
[ 0.099000] ..... calibration result: 1000004
[ 0.099000] ..... calibration result: 1000004
[ 0.099000] ..... CPU clock speed is 2693.0504 MHz.
[ 0.099000] ..... CPU clock speed is 2693.0504 MHz.
[ 0.099000] ..... host bus clock speed is 1000.0004 MHz.
[ 0.099000] ..... host bus clock speed is 1000.0004 MHz.
[ 0.099082] smpboot: CPU0:
[ 0.099082] smpboot: CPU0: Intel Intel Common KVM processorCommon KVM processor (fam: 0f, model: 06 (fam: 0f, model: 06, stepping: 01)
, stepping: 01)
[ 0.103136] Performance Events:
[ 0.103136] Performance Events: unsupported Netburst CPU model 6 unsupported Netburst CPU model 6 no PMU driver, software events only.
no PMU driver, software events only.
[ 0.115639] CPU 1 irqstacks, hard=50bec000 soft=50bee000
[ 0.115639] CPU 1 irqstacks, hard=50bec000 soft=50bee000
[ 0.116015] x86: Booting SMP configuration:
[ 0.116015] x86: Booting SMP configuration:
[ 0.117091] .... node #0, CPUs:
[ 0.117091] .... node #0, CPUs: #1 #1
[ 0.002000] Initializing CPU#1
[ 0.003000] kvm-clock: cpu 1, msr 0:12bdf021, secondary cpu clock
[ 0.003000] masked ExtINT on CPU#1
[ 0.142186] x86: Booted up 1 node, 2 CPUs
[ 0.142186] x86: Booted up 1 node, 2 CPUs
[ 0.142146] KVM setup async PF for cpu 1
[ 0.142146] KVM setup async PF for cpu 1
[ 0.142146] kvm-stealtime: cpu 1, msr 10f35ac0
[ 0.142146] kvm-stealtime: cpu 1, msr 10f35ac0
[ 0.145014] ----------------
[ 0.145014] ----------------
[ 0.146004] | NMI testsuite:
[ 0.146004] | NMI testsuite:
[ 0.147004] --------------------
[ 0.147004] --------------------
[ 0.148004] remote IPI:
[ 0.148004] remote IPI: ok | ok |

[ 0.153397] local IPI:
[ 0.153397] local IPI: ok | ok |

[ 0.160030] --------------------
[ 0.160030] --------------------
[ 0.161005] Good, all 2 testcases passed! |
[ 0.161005] Good, all 2 testcases passed! |
[ 0.162004] ---------------------------------
[ 0.162004] ---------------------------------
[ 0.163007] smpboot: Total of 2 processors activated (10774.03 BogoMIPS)
[ 0.163007] smpboot: Total of 2 processors activated (10774.03 BogoMIPS)
[ 0.168390] devtmpfs: initialized
[ 0.168390] devtmpfs: initialized
[ 0.175547] clocksource jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
[ 0.175547] clocksource jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
[ 0.186053] Testing tracer function:
[ 0.186053] Testing tracer function: PASSED
PASSED
[ 0.302543] Testing ftrace regs(no arch support):
[ 0.302543] Testing ftrace regs(no arch support): PASSED
PASSED
[ 0.322057] Testing tracer function_graph:
[ 0.322057] Testing tracer function_graph: PASSED
PASSED
[ 0.445697] xor: measuring software checksum speed
[ 0.445697] xor: measuring software checksum speed
[ 0.456010] pIII_sse : 9164.000 MB/sec
[ 0.456010] pIII_sse : 9164.000 MB/sec
[ 0.467010] prefetch64-sse: 10132.000 MB/sec
[ 0.467010] prefetch64-sse: 10132.000 MB/sec
[ 0.468012] xor: using function: prefetch64-sse (10132.000 MB/sec)
[ 0.468012] xor: using function: prefetch64-sse (10132.000 MB/sec)
[ 0.469028] prandom: seed boundary self test passed
[ 0.469028] prandom: seed boundary self test passed
[ 0.472283] prandom: 100 self tests passed
[ 0.472283] prandom: 100 self tests passed
[ 0.476471] NET: Registered protocol family 16
[ 0.476471] NET: Registered protocol family 16
[ 0.482055] cpuidle: using governor ladder
[ 0.482055] cpuidle: using governor ladder
[ 0.486055] cpuidle: using governor menu
[ 0.486055] cpuidle: using governor menu
[ 0.488618] ACPI: bus type PCI registered
[ 0.488618] ACPI: bus type PCI registered
[ 0.490107] PCI : PCI BIOS area is rw and x. Use pci=nobios if you want it NX.
[ 0.490107] PCI : PCI BIOS area is rw and x. Use pci=nobios if you want it NX.
[ 0.491015] PCI: PCI BIOS revision 2.10 entry at 0xfd456, last bus=0
[ 0.491015] PCI: PCI BIOS revision 2.10 entry at 0xfd456, last bus=0
[ 0.492009] PCI: Using configuration type 1 for base access
[ 0.492009] PCI: Using configuration type 1 for base access
[ 0.559020] raid6: mmxx1 gen() 1367 MB/s
[ 0.559020] raid6: mmxx1 gen() 1367 MB/s
[ 0.577010] raid6: mmxx2 gen() 1394 MB/s
[ 0.577010] raid6: mmxx2 gen() 1394 MB/s
[ 0.595010] raid6: sse1x1 gen() 1742 MB/s
[ 0.595010] raid6: sse1x1 gen() 1742 MB/s
[ 0.613018] raid6: sse1x2 gen() 3128 MB/s
[ 0.613018] raid6: sse1x2 gen() 3128 MB/s
[ 0.631017] raid6: sse2x1 gen() 4312 MB/s
[ 0.631017] raid6: sse2x1 gen() 4312 MB/s
[ 0.649009] raid6: sse2x1 xor() 2792 MB/s
[ 0.649009] raid6: sse2x1 xor() 2792 MB/s
[ 0.667017] raid6: sse2x2 gen() 5773 MB/s
[ 0.667017] raid6: sse2x2 gen() 5773 MB/s
[ 0.685015] raid6: sse2x2 xor() 3873 MB/s
[ 0.685015] raid6: sse2x2 xor() 3873 MB/s
[ 0.686006] raid6: using algorithm sse2x2 gen() 5773 MB/s
[ 0.686006] raid6: using algorithm sse2x2 gen() 5773 MB/s
[ 0.687010] raid6: .... xor() 3873 MB/s, rmw enabled
[ 0.687010] raid6: .... xor() 3873 MB/s, rmw enabled
[ 0.688005] raid6: using intx1 recovery algorithm
[ 0.688005] raid6: using intx1 recovery algorithm
[ 0.689681] ACPI: Added _OSI(Module Device)
[ 0.689681] ACPI: Added _OSI(Module Device)
[ 0.690006] ACPI: Added _OSI(Processor Device)
[ 0.690006] ACPI: Added _OSI(Processor Device)
[ 0.692006] ACPI: Added _OSI(3.0 _SCP Extensions)
[ 0.692006] ACPI: Added _OSI(3.0 _SCP Extensions)
[ 0.693006] ACPI: Added _OSI(Processor Aggregator Device)
[ 0.693006] ACPI: Added _OSI(Processor Aggregator Device)
[ 0.696488] IOAPIC[0]: Set routing entry (0-9 -> 0x39 -> IRQ 9 Mode:1 Active:0 Dest:3)
[ 0.696488] IOAPIC[0]: Set routing entry (0-9 -> 0x39 -> IRQ 9 Mode:1 Active:0 Dest:3)
[ 0.705253] ACPI: Interpreter enabled
[ 0.705253] ACPI: Interpreter enabled
[ 0.706066] ACPI: (supports S0 S4 S5)
[ 0.706066] ACPI: (supports S0 S4 S5)
[ 0.707006] ACPI: Using IOAPIC for interrupt routing
[ 0.707006] ACPI: Using IOAPIC for interrupt routing
[ 0.709056] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[ 0.709056] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[ 0.751186] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[ 0.751186] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[ 0.752022] acpi PNP0A03:00: _OSC: OS supports [Segments]
[ 0.752022] acpi PNP0A03:00: _OSC: OS supports [Segments]
[ 0.754090] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
[ 0.754090] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
[ 0.756164] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
[ 0.756164] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
[ 0.757429] PCI host bridge to bus 0000:00
[ 0.757429] PCI host bridge to bus 0000:00
[ 0.758011] pci_bus 0000:00: root bus resource [bus 00-ff]
[ 0.758011] pci_bus 0000:00: root bus resource [bus 00-ff]
[ 0.759014] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]
[ 0.759014] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]
[ 0.760011] pci_bus 0000:00: root bus resource [io 0x0d00-0xadff window]
[ 0.760011] pci_bus 0000:00: root bus resource [io 0x0d00-0xadff window]
[ 0.761012] pci_bus 0000:00: root bus resource [io 0xae0f-0xaeff window]
[ 0.761012] pci_bus 0000:00: root bus resource [io 0xae0f-0xaeff window]
[ 0.762014] pci_bus 0000:00: root bus resource [io 0xaf20-0xafdf window]
[ 0.762014] pci_bus 0000:00: root bus resource [io 0xaf20-0xafdf window]
[ 0.763017] pci_bus 0000:00: root bus resource [io 0xafe4-0xffff window]
[ 0.763017] pci_bus 0000:00: root bus resource [io 0xafe4-0xffff window]
[ 0.765016] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
[ 0.765016] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
[ 0.766012] pci_bus 0000:00: root bus resource [mem 0x12c00000-0xfebfffff window]
[ 0.766012] pci_bus 0000:00: root bus resource [mem 0x12c00000-0xfebfffff window]
[ 0.767120] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
[ 0.767120] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
[ 0.770265] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
[ 0.770265] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
[ 0.774182] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180
[ 0.774182] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180
[ 0.787014] pci 0000:00:01.1: reg 0x20: [io 0xc200-0xc20f]
[ 0.787014] pci 0000:00:01.1: reg 0x20: [io 0xc200-0xc20f]
[ 0.792051] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7]
[ 0.792051] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7]
[ 0.793013] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6]
[ 0.793013] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6]
[ 0.794012] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177]
[ 0.794012] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177]
[ 0.795011] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376]
[ 0.795011] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376]
[ 0.797560] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000
[ 0.797560] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000
[ 0.799014] pci 0000:00:01.3: can't claim BAR 7 [io 0x0600-0x063f]: address conflict with ACPI PM1a_EVT_BLK [io 0x0600-0x0603]
[ 0.799014] pci 0000:00:01.3: can't claim BAR 7 [io 0x0600-0x063f]: address conflict with ACPI PM1a_EVT_BLK [io 0x0600-0x0603]
[ 0.800033] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB
[ 0.800033] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB
[ 0.802638] pci 0000:00:02.0: [1013:00b8] type 00 class 0x030000
[ 0.802638] pci 0000:00:02.0: [1013:00b8] type 00 class 0x030000
[ 0.805022] pci 0000:00:02.0: reg 0x10: [mem 0xfc000000-0xfdffffff pref]
[ 0.805022] pci 0000:00:02.0: reg 0x10: [mem 0xfc000000-0xfdffffff pref]
[ 0.808030] pci 0000:00:02.0: reg 0x14: [mem 0xfebf0000-0xfebf0fff]
[ 0.808030] pci 0000:00:02.0: reg 0x14: [mem 0xfebf0000-0xfebf0fff]
[ 0.819025] pci 0000:00:02.0: reg 0x30: [mem 0xfebe0000-0xfebeffff pref]
[ 0.819025] pci 0000:00:02.0: reg 0x30: [mem 0xfebe0000-0xfebeffff pref]
[ 0.821522] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000
[ 0.821522] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000
[ 0.824017] pci 0000:00:03.0: reg 0x10: [mem 0xfebc0000-0xfebdffff]
[ 0.824017] pci 0000:00:03.0: reg 0x10: [mem 0xfebc0000-0xfebdffff]
[ 0.828015] pci 0000:00:03.0: reg 0x14: [io 0xc000-0xc03f]
[ 0.828015] pci 0000:00:03.0: reg 0x14: [io 0xc000-0xc03f]
[ 0.841020] pci 0000:00:03.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref]
[ 0.841020] pci 0000:00:03.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref]
[ 0.844598] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000
[ 0.844598] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000
[ 0.847015] pci 0000:00:04.0: reg 0x10: [io 0xc040-0xc07f]
[ 0.847015] pci 0000:00:04.0: reg 0x10: [io 0xc040-0xc07f]
[ 0.850016] pci 0000:00:04.0: reg 0x14: [mem 0xfebf1000-0xfebf1fff]
[ 0.850016] pci 0000:00:04.0: reg 0x14: [mem 0xfebf1000-0xfebf1fff]
[ 0.863064] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000
[ 0.863064] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000
[ 0.866016] pci 0000:00:05.0: reg 0x10: [io 0xc080-0xc0bf]
[ 0.866016] pci 0000:00:05.0: reg 0x10: [io 0xc080-0xc0bf]
[ 0.869015] pci 0000:00:05.0: reg 0x14: [mem 0xfebf2000-0xfebf2fff]
[ 0.869015] pci 0000:00:05.0: reg 0x14: [mem 0xfebf2000-0xfebf2fff]
[ 0.882647] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000
[ 0.882647] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000
[ 0.885018] pci 0000:00:06.0: reg 0x10: [io 0xc0c0-0xc0ff]
[ 0.885018] pci 0000:00:06.0: reg 0x10: [io 0xc0c0-0xc0ff]
[ 0.888016] pci 0000:00:06.0: reg 0x14: [mem 0xfebf3000-0xfebf3fff]
[ 0.888016] pci 0000:00:06.0: reg 0x14: [mem 0xfebf3000-0xfebf3fff]
[ 0.903265] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000
[ 0.903265] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000
[ 0.908013] pci 0000:00:07.0: reg 0x10: [io 0xc100-0xc13f]
[ 0.908013] pci 0000:00:07.0: reg 0x10: [io 0xc100-0xc13f]
[ 0.911033] pci 0000:00:07.0: reg 0x14: [mem 0xfebf4000-0xfebf4fff]
[ 0.911033] pci 0000:00:07.0: reg 0x14: [mem 0xfebf4000-0xfebf4fff]
[ 0.924226] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000
[ 0.924226] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000
[ 0.927016] pci 0000:00:08.0: reg 0x10: [io 0xc140-0xc17f]
[ 0.927016] pci 0000:00:08.0: reg 0x10: [io 0xc140-0xc17f]
[ 0.931015] pci 0000:00:08.0: reg 0x14: [mem 0xfebf5000-0xfebf5fff]
[ 0.931015] pci 0000:00:08.0: reg 0x14: [mem 0xfebf5000-0xfebf5fff]
[ 0.944610] pci 0000:00:09.0: [1af4:1001] type 00 class 0x010000
[ 0.944610] pci 0000:00:09.0: [1af4:1001] type 00 class 0x010000
[ 0.947016] pci 0000:00:09.0: reg 0x10: [io 0xc180-0xc1bf]
[ 0.947016] pci 0000:00:09.0: reg 0x10: [io 0xc180-0xc1bf]
[ 0.950018] pci 0000:00:09.0: reg 0x14: [mem 0xfebf6000-0xfebf6fff]
[ 0.950018] pci 0000:00:09.0: reg 0x14: [mem 0xfebf6000-0xfebf6fff]
[ 0.965295] pci 0000:00:0a.0: [1af4:1001] type 00 class 0x010000
[ 0.965295] pci 0000:00:0a.0: [1af4:1001] type 00 class 0x010000
[ 0.969015] pci 0000:00:0a.0: reg 0x10: [io 0xc1c0-0xc1ff]
[ 0.969015] pci 0000:00:0a.0: reg 0x10: [io 0xc1c0-0xc1ff]
[ 0.972018] pci 0000:00:0a.0: reg 0x14: [mem 0xfebf7000-0xfebf7fff]
[ 0.972018] pci 0000:00:0a.0: reg 0x14: [mem 0xfebf7000-0xfebf7fff]
[ 0.986045] pci 0000:00:0b.0: [8086:25ab] type 00 class 0x088000
[ 0.986045] pci 0000:00:0b.0: [8086:25ab] type 00 class 0x088000
[ 0.989016] pci 0000:00:0b.0: reg 0x10: [mem 0xfebf8000-0xfebf800f]
[ 0.989016] pci 0000:00:0b.0: reg 0x10: [mem 0xfebf8000-0xfebf800f]
[ 1.005521] pci_bus 0000:00: on NUMA node 0
[ 1.005521] pci_bus 0000:00: on NUMA node 0
[ 1.010332] ACPI: PCI Interrupt Link [LNKA] (IRQs
[ 1.010332] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 5 *10 *10 11 11))

[ 1.013406] ACPI: PCI Interrupt Link [LNKB] (IRQs
[ 1.013406] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 5 *10 *10 11 11))

[ 1.016688] ACPI: PCI Interrupt Link [LNKC] (IRQs
[ 1.016688] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 5 10 10 *11 *11))

[ 1.019570] ACPI: PCI Interrupt Link [LNKD] (IRQs
[ 1.019570] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 5 10 10 *11 *11))

[ 1.021686] ACPI: PCI Interrupt Link [LNKS] (IRQs
[ 1.021686] ACPI: PCI Interrupt Link [LNKS] (IRQs *9 *9))

[ 1.027366] ACPI:
[ 1.027366] ACPI: Enabled 16 GPEs in block 00 to 0FEnabled 16 GPEs in block 00 to 0F

[ 1.034470] vgaarb: setting as boot device: PCI:0000:00:02.0
[ 1.034470] vgaarb: setting as boot device: PCI:0000:00:02.0
[ 1.035000] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none
[ 1.035000] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none
[ 1.037015] vgaarb: loaded
[ 1.037015] vgaarb: loaded
[ 1.038004] vgaarb: bridge control possible 0000:00:02.0
[ 1.038004] vgaarb: bridge control possible 0000:00:02.0
[ 1.046283] SCSI subsystem initialized
[ 1.046283] SCSI subsystem initialized
[ 1.057193] libata version 3.00 loaded.
[ 1.057193] libata version 3.00 loaded.
[ 1.059338] Linux video capture interface: v2.00
[ 1.059338] Linux video capture interface: v2.00
[ 1.066079] Advanced Linux Sound Architecture Driver Initialized.
[ 1.066079] Advanced Linux Sound Architecture Driver Initialized.
[ 1.067157] PCI: Using ACPI for IRQ routing
[ 1.067157] PCI: Using ACPI for IRQ routing
[ 1.069006] PCI: pci_cache_line_size set to 64 bytes
[ 1.069006] PCI: pci_cache_line_size set to 64 bytes
[ 1.070281] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
[ 1.070281] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
[ 1.072030] e820: reserve RAM buffer [mem 0x12be0000-0x13ffffff]
[ 1.072030] e820: reserve RAM buffer [mem 0x12be0000-0x13ffffff]
[ 1.093655] Switched to clocksource kvm-clock
[ 1.093655] Switched to clocksource kvm-clock
[ 1.265332] FS-Cache: Loaded
[ 1.265332] FS-Cache: Loaded
[ 1.267296] CacheFiles: Loaded
[ 1.267296] CacheFiles: Loaded
[ 1.268365] pnp: PnP ACPI init
[ 1.268365] pnp: PnP ACPI init
[ 1.269692] IOAPIC[0]: Set routing entry (0-8 -> 0x38 -> IRQ 8 Mode:0 Active:0 Dest:3)
[ 1.269692] IOAPIC[0]: Set routing entry (0-8 -> 0x38 -> IRQ 8 Mode:0 Active:0 Dest:3)
[ 1.272832] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active)
[ 1.272832] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active)
[ 1.278315] IOAPIC[0]: Set routing entry (0-1 -> 0x31 -> IRQ 1 Mode:0 Active:0 Dest:3)
[ 1.278315] IOAPIC[0]: Set routing entry (0-1 -> 0x31 -> IRQ 1 Mode:0 Active:0 Dest:3)
[ 1.285371] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active)
[ 1.285371] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active)
[ 1.290294] IOAPIC[0]: Set routing entry (0-12 -> 0x3c -> IRQ 12 Mode:0 Active:0 Dest:3)
[ 1.290294] IOAPIC[0]: Set routing entry (0-12 -> 0x3c -> IRQ 12 Mode:0 Active:0 Dest:3)
[ 1.294512] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active)
[ 1.294512] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active)
[ 1.298470] IOAPIC[0]: Set routing entry (0-6 -> 0x36 -> IRQ 6 Mode:0 Active:0 Dest:3)
[ 1.298470] IOAPIC[0]: Set routing entry (0-6 -> 0x36 -> IRQ 6 Mode:0 Active:0 Dest:3)
[ 1.302886] pnp 00:03: [dma 2]
[ 1.302886] pnp 00:03: [dma 2]
[ 1.306324] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active)
[ 1.306324] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active)
[ 1.309406] IOAPIC[0]: Set routing entry (0-7 -> 0x37 -> IRQ 7 Mode:0 Active:0 Dest:3)
[ 1.309406] IOAPIC[0]: Set routing entry (0-7 -> 0x37 -> IRQ 7 Mode:0 Active:0 Dest:3)
[ 1.313593] pnp 00:04: Plug and Play ACPI device, IDs PNP0400 (active)
[ 1.313593] pnp 00:04: Plug and Play ACPI device, IDs PNP0400 (active)
[ 1.317501] IOAPIC[0]: Set routing entry (0-4 -> 0x34 -> IRQ 4 Mode:0 Active:0 Dest:3)
[ 1.317501] IOAPIC[0]: Set routing entry (0-4 -> 0x34 -> IRQ 4 Mode:0 Active:0 Dest:3)
[ 1.323329] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active)
[ 1.323329] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active)
[ 1.329532] pnp: PnP ACPI: found 6 devices
[ 1.329532] pnp: PnP ACPI: found 6 devices
[ 1.376083] clocksource acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
[ 1.376083] clocksource acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
[ 1.382829] pci 0000:00:01.3: BAR 7: [io size 0x0040] has bogus alignment
[ 1.382829] pci 0000:00:01.3: BAR 7: [io size 0x0040] has bogus alignment
[ 1.387656] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]
[ 1.387656] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]
[ 1.392363] pci_bus 0000:00: resource 5 [io 0x0d00-0xadff window]
[ 1.392363] pci_bus 0000:00: resource 5 [io 0x0d00-0xadff window]
[ 1.396483] pci_bus 0000:00: resource 6 [io 0xae0f-0xaeff window]
[ 1.396483] pci_bus 0000:00: resource 6 [io 0xae0f-0xaeff window]
[ 1.399765] pci_bus 0000:00: resource 7 [io 0xaf20-0xafdf window]
[ 1.399765] pci_bus 0000:00: resource 7 [io 0xaf20-0xafdf window]
[ 1.404081] pci_bus 0000:00: resource 8 [io 0xafe4-0xffff window]
[ 1.404081] pci_bus 0000:00: resource 8 [io 0xafe4-0xffff window]
[ 1.408461] pci_bus 0000:00: resource 9 [mem 0x000a0000-0x000bffff window]
[ 1.408461] pci_bus 0000:00: resource 9 [mem 0x000a0000-0x000bffff window]
[ 1.412351] pci_bus 0000:00: resource 10 [mem 0x12c00000-0xfebfffff window]
[ 1.412351] pci_bus 0000:00: resource 10 [mem 0x12c00000-0xfebfffff window]
[ 1.414666] NET: Registered protocol family 1
[ 1.414666] NET: Registered protocol family 1
[ 1.416416] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
[ 1.416416] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
[ 1.418135] pci 0000:00:01.0: PIIX3: Enabling Passive Release
[ 1.418135] pci 0000:00:01.0: PIIX3: Enabling Passive Release
[ 1.420526] pci 0000:00:01.0: Activating ISA DMA hang workarounds
[ 1.420526] pci 0000:00:01.0: Activating ISA DMA hang workarounds
[ 1.423464] pci 0000:00:02.0: Video device with shadowed ROM
[ 1.423464] pci 0000:00:02.0: Video device with shadowed ROM
[ 1.425268] PCI: CLS 0 bytes, default 64
[ 1.425268] PCI: CLS 0 bytes, default 64
[ 1.442613] Trying to unpack rootfs image as initramfs...
[ 1.442613] Trying to unpack rootfs image as initramfs...
[ 3.651547] Freeing initrd memory: 24852K (51393000 - 52bd8000)
[ 3.651547] Freeing initrd memory: 24852K (51393000 - 52bd8000)
[ 3.660804] Machine check injector initialized
[ 3.660804] Machine check injector initialized
[ 3.663195] Scanning for low memory corruption every 60 seconds
[ 3.663195] Scanning for low memory corruption every 60 seconds
[ 3.711914] PCLMULQDQ-NI instructions are not detected.
[ 3.711914] PCLMULQDQ-NI instructions are not detected.
[ 3.713291] The force parameter has not been set to 1. The Iris poweroff handler will not be installed.
[ 3.713291] The force parameter has not been set to 1. The Iris poweroff handler will not be installed.
[ 3.715768] spin_lock-torture:--- Start of test [debug]: nwriters_stress=4 nreaders_stress=0 stat_interval=60 verbose=1 shuffle_interval=3 stutter=5 shutdown_secs=0 onoff_interval=0 onoff_holdoff=0
[ 3.715768] spin_lock-torture:--- Start of test [debug]: nwriters_stress=4 nreaders_stress=0 stat_interval=60 verbose=1 shuffle_interval=3 stutter=5 shutdown_secs=0 onoff_interval=0 onoff_holdoff=0
[ 3.725261] spin_lock-torture: Creating torture_shuffle task
[ 3.725261] spin_lock-torture: Creating torture_shuffle task
[ 3.744389] spin_lock-torture: Creating torture_stutter task
[ 3.744389] spin_lock-torture: Creating torture_stutter task
[ 3.746042] spin_lock-torture: torture_shuffle task started
[ 3.746042] spin_lock-torture: torture_shuffle task started
[ 3.747591] spin_lock-torture: Creating lock_torture_writer task
[ 3.747591] spin_lock-torture: Creating lock_torture_writer task
[ 3.749337] spin_lock-torture: torture_stutter task started
[ 3.749337] spin_lock-torture: torture_stutter task started
[ 3.750879] spin_lock-torture: Creating lock_torture_writer task
[ 3.750879] spin_lock-torture: Creating lock_torture_writer task
[ 3.752684] spin_lock-torture: lock_torture_writer task started
[ 3.752684] spin_lock-torture: lock_torture_writer task started
[ 3.759150] spin_lock-torture: lock_torture_writer task started
[ 3.759150] spin_lock-torture: lock_torture_writer task started
[ 3.760745] spin_lock-torture: Creating lock_torture_writer task
[ 3.760745] spin_lock-torture: Creating lock_torture_writer task
[ 3.762446] spin_lock-torture: Creating lock_torture_writer task
[ 3.762446] spin_lock-torture: Creating lock_torture_writer task
[ 3.763983] spin_lock-torture: lock_torture_writer task started
[ 3.763983] spin_lock-torture: lock_torture_writer task started
[ 3.779153] spin_lock-torture: lock_torture_writer task started
[ 3.779153] spin_lock-torture: lock_torture_writer task started
[ 3.792156] spin_lock-torture: Creating lock_torture_stats task
[ 3.792156] spin_lock-torture: Creating lock_torture_stats task
[ 3.802572] torture_init_begin: refusing rcu init: spin_lock running
[ 3.802572] torture_init_begin: refusing rcu init: spin_lock running

[ 3.808288] futex hash table entries: 512 (order: 3, 32768 bytes)
[ 3.808288] futex hash table entries: 512 (order: 3, 32768 bytes)
[ 3.810002] Initialise system trusted keyring
[ 3.810002] Initialise system trusted keyring
[ 3.812307] spin_lock-torture: lock_torture_stats task started
[ 3.812307] spin_lock-torture: lock_torture_stats task started
[ 3.831259] HugeTLB registered 2 MB page size, pre-allocated 0 pages
[ 3.831259] HugeTLB registered 2 MB page size, pre-allocated 0 pages
[ 3.833044] page_owner is disabled
[ 3.833044] page_owner is disabled
[ 3.833995] zpool: loaded
[ 3.833995] zpool: loaded
[ 3.882901] ntfs: driver 2.1.32 [Flags: R/W].
[ 3.882901] ntfs: driver 2.1.32 [Flags: R/W].
[ 3.885936] fuse init (API version 7.23)
[ 3.885936] fuse init (API version 7.23)
[ 3.887586] JFS: nTxBlock = 2163, nTxLock = 17307
[ 3.887586] JFS: nTxBlock = 2163, nTxLock = 17307
[ 4.140171] SGI XFS with ACLs, security attributes, realtime, debug enabled
[ 4.140171] SGI XFS with ACLs, security attributes, realtime, debug enabled
[ 4.275449] NILFS version 2 loaded
[ 4.275449] NILFS version 2 loaded
[ 7.910374] Key type asymmetric registered
[ 7.910374] Key type asymmetric registered
[ 7.913124] io scheduler noop registered (default)
[ 7.913124] io scheduler noop registered (default)
[ 7.916655] io scheduler deadline registered
[ 7.916655] io scheduler deadline registered
[ 7.918885] test_string_helpers: Running tests...
[ 7.918885] test_string_helpers: Running tests...
[ 7.924480] test_hexdump: Running tests...
[ 7.924480] test_hexdump: Running tests...
[ 7.925872] Running resizable hashtable tests...
[ 7.925872] Running resizable hashtable tests...
[ 7.929157] Adding 2048 keys
[ 7.929157] Adding 2048 keys
[ 7.951413] Traversal complete: counted=2048, nelems=2048, entries=2048
[ 7.951413] Traversal complete: counted=2048, nelems=2048, entries=2048
[ 7.960112] Traversal complete: counted=2048, nelems=2048, entries=2048
[ 7.960112] Traversal complete: counted=2048, nelems=2048, entries=2048
[ 7.964022] Deleting 2048 keys
[ 7.964022] Deleting 2048 keys
[ 7.969246] clocksource tsc: mask: 0xffffffffffffffff max_cycles: 0x26d349e8249, max_idle_ns: 440795288087 ns
[ 7.969246] clocksource tsc: mask: 0xffffffffffffffff max_cycles: 0x26d349e8249, max_idle_ns: 440795288087 ns
[ 7.975890] xz_dec_test: module loaded
[ 7.975890] xz_dec_test: module loaded
[ 7.977935] xz_dec_test: Create a device node with 'mknod xz_dec_test c 252 0' and write .xz files to it.
[ 7.977935] xz_dec_test: Create a device node with 'mknod xz_dec_test c 252 0' and write .xz files to it.
[ 7.983803] glob: 64 self-tests passed, 0 failed
[ 7.983803] glob: 64 self-tests passed, 0 failed
[ 7.989294] no IO addresses supplied
[ 7.989294] no IO addresses supplied
[ 7.991662] hgafb: HGA card not detected.
[ 7.991662] hgafb: HGA card not detected.
[ 7.993886] hgafb: probe of hgafb.0 failed with error -22
[ 7.993886] hgafb: probe of hgafb.0 failed with error -22
[ 7.999388] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0
[ 7.999388] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0
[ 8.003532] ACPI: Power Button [PWRF]
[ 8.003532] ACPI: Power Button [PWRF]
[ 8.314129] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled
[ 8.314129] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled
[ 8.389638] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
[ 8.389638] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
[ 8.396095] lp: driver loaded but no devices found
[ 8.396095] lp: driver loaded but no devices found
[ 8.397673] Non-volatile memory driver v1.3
[ 8.397673] Non-volatile memory driver v1.3
[ 8.398792] toshiba: not a supported Toshiba laptop
[ 8.398792] toshiba: not a supported Toshiba laptop
[ 8.408347] ppdev: user-space parallel port driver
[ 8.408347] ppdev: user-space parallel port driver
[ 8.409587] nsc_gpio initializing
[ 8.409587] nsc_gpio initializing
[ 8.410467] telclk_interrupt = 0xf non-mcpbl0010 hw.
[ 8.410467] telclk_interrupt = 0xf non-mcpbl0010 hw.
[ 8.411902] Hangcheck: starting hangcheck timer 0.9.1 (tick is 180 seconds, margin is 60 seconds).
[ 8.411902] Hangcheck: starting hangcheck timer 0.9.1 (tick is 180 seconds, margin is 60 seconds).
[ 8.441657] brd: module loaded
[ 8.441657] brd: module loaded
[ 8.465926] loop: module loaded
[ 8.465926] loop: module loaded
[ 8.467417] lkdtm: No crash points registered, enable through debugfs
[ 8.467417] lkdtm: No crash points registered, enable through debugfs
[ 8.484527] Silicon Labs C2 port support v. 0.51.0 - (C) 2007 Rodolfo Giometti
[ 8.484527] Silicon Labs C2 port support v. 0.51.0 - (C) 2007 Rodolfo Giometti
[ 8.486729] c2port c2port0: C2 port uc added
[ 8.486729] c2port c2port0: C2 port uc added
[ 8.487836] c2port c2port0: uc flash has 30 blocks x 512 bytes (15360 bytes total)
[ 8.487836] c2port c2port0: uc flash has 30 blocks x 512 bytes (15360 bytes total)
[ 8.490844] Uniform Multi-Platform E-IDE driver
[ 8.490844] Uniform Multi-Platform E-IDE driver
[ 8.492146] ide_generic: please use "probe_mask=0x3f" module parameter for probing all legacy ISA IDE ports
[ 8.492146] ide_generic: please use "probe_mask=0x3f" module parameter for probing all legacy ISA IDE ports
[ 8.494588] ide-cd driver 5.00
[ 8.494588] ide-cd driver 5.00
[ 8.495713] rdac: device handler registered
[ 8.495713] rdac: device handler registered
[ 8.496945] hp_sw: device handler registered
[ 8.496945] hp_sw: device handler registered
[ 8.498052] emc: device handler registered
[ 8.498052] emc: device handler registered
[ 8.499110] alua: device handler registered
[ 8.499110] alua: device handler registered
[ 8.500155] st: Version 20101219, fixed bufsize 32768, s/g segs 256
[ 8.500155] st: Version 20101219, fixed bufsize 32768, s/g segs 256
[ 8.511842] osst :I: Tape driver with OnStream support version 0.99.4
[ 8.511842] osst :I: $Id: osst.c,v 1.73 2005/01/01 21:13:34 wriede Exp $
[ 8.511842] osst :I: Tape driver with OnStream support version 0.99.4
[ 8.511842] osst :I: $Id: osst.c,v 1.73 2005/01/01 21:13:34 wriede Exp $
[ 8.516589] SCSI Media Changer driver v0.25
[ 8.516589] SCSI Media Changer driver v0.25
[ 8.517839] osd: LOADED open-osd 0.2.1
[ 8.517839] osd: LOADED open-osd 0.2.1
[ 8.519887] Rounding down aligned max_sectors from 4294967295 to 4294967288
[ 8.519887] Rounding down aligned max_sectors from 4294967295 to 4294967288
[ 8.541647] SSFDC read-only Flash Translation layer
[ 8.541647] SSFDC read-only Flash Translation layer
[ 8.543060] platform physmap-flash.0: failed to claim resource 0
[ 8.543060] platform physmap-flash.0: failed to claim resource 0
[ 8.544671] SBC-GXx flash: IO:0x258-0x259 MEM:0xdc000-0xdffff
[ 8.544671] SBC-GXx flash: IO:0x258-0x259 MEM:0xdc000-0xdffff
[ 8.547884] ftl_cs: FTL header not found.
[ 8.547884] ftl_cs: FTL header not found.
[ 8.615177] No valid DiskOnChip devices found
[ 8.615177] No valid DiskOnChip devices found
[ 8.616461] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0
[ 8.616461] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0
[ 8.618811] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0
[ 8.618811] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0
[ 8.621175] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0
[ 8.621175] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0
[ 8.623529] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0
[ 8.623529] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0
[ 8.625859] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0
[ 8.625859] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0
[ 8.640274] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0
[ 8.640274] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0
[ 8.642624] nand: device found, Manufacturer ID: 0x98, Chip ID: 0x39
[ 8.642624] nand: device found, Manufacturer ID: 0x98, Chip ID: 0x39
[ 8.644213] nand: Toshiba NAND 128MiB 1,8V 8-bit
[ 8.644213] nand: Toshiba NAND 128MiB 1,8V 8-bit
[ 8.645401] nand: 128 MiB, SLC, erase size: 16 KiB, page size: 512, OOB size: 16
[ 8.645401] nand: 128 MiB, SLC, erase size: 16 KiB, page size: 512, OOB size: 16
[ 8.647408] flash size: 128 MiB
[ 8.647408] flash size: 128 MiB
[ 8.648200] page size: 512 bytes
[ 8.648200] page size: 512 bytes
[ 8.649030] OOB area size: 16 bytes
[ 8.649030] OOB area size: 16 bytes
[ 8.649902] sector size: 16 KiB
[ 8.649902] sector size: 16 KiB
[ 8.650713] pages number: 262144
[ 8.650713] pages number: 262144
[ 8.664596] pages per sector: 32
[ 8.664596] pages per sector: 32
[ 8.665455] bus width: 8
[ 8.665455] bus width: 8
[ 8.666092] bits in sector size: 14
[ 8.666092] bits in sector size: 14
[ 8.666985] bits in page size: 9
[ 8.666985] bits in page size: 9
[ 8.667822] bits in OOB size: 4
[ 8.667822] bits in OOB size: 4
[ 8.668635] flash size with OOB: 135168 KiB
[ 8.668635] flash size with OOB: 135168 KiB
[ 8.669751] page address bytes: 4
[ 8.669751] page address bytes: 4
[ 8.670601] sector address bytes: 3
[ 8.670601] sector address bytes: 3
[ 8.671512] options: 0x42
[ 8.671512] options: 0x42
[ 8.672796] Scanning device for bad blocks
[ 8.672796] Scanning device for bad blocks
[ 8.739798] Creating 1 MTD partitions on "NAND 128MiB 1,8V 8-bit":
[ 8.739798] Creating 1 MTD partitions on "NAND 128MiB 1,8V 8-bit":
[ 8.743896] 0x000000000000-0x000008000000 : "NAND simulator partition 0"
[ 8.743896] 0x000000000000-0x000008000000 : "NAND simulator partition 0"
[ 8.750819] ftl_cs: FTL header not found.
[ 8.750819] ftl_cs: FTL header not found.
[ 8.756830] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
[ 8.756830] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
[ 8.880279] serio: i8042 KBD port at 0x60,0x64 irq 1
[ 8.880279] serio: i8042 KBD port at 0x60,0x64 irq 1
[ 8.886075] serio: i8042 AUX port at 0x60,0x64 irq 12
[ 8.886075] serio: i8042 AUX port at 0x60,0x64 irq 12
[ 8.897880] parkbd: no such parport
[ 8.897880] parkbd: no such parport
[ 9.134141] evbug: Connected device: input0 (Power Button at LNXPWRBN/button/input0)
[ 9.134141] evbug: Connected device: input0 (Power Button at LNXPWRBN/button/input0)
[ 9.154193] i2c /dev entries driver
[ 9.154193] i2c /dev entries driver
[ 9.155297] i2c-parport: adapter type unspecified
[ 9.155297] i2c-parport: adapter type unspecified
[ 9.156480] i2c-parport-light: adapter type unspecified
[ 9.156480] i2c-parport-light: adapter type unspecified
[ 9.159901] Driver for 1-wire Dallas network protocol.
[ 9.159901] Driver for 1-wire Dallas network protocol.
[ 9.161420] DS1WM w1 busmaster driver - (c) 2004 Szabolcs Gyurko
[ 9.161420] DS1WM w1 busmaster driver - (c) 2004 Szabolcs Gyurko
[ 9.163478] power_supply test_ac: uevent
[ 9.163478] power_supply test_ac: uevent
[ 9.164483] power_supply test_ac: POWER_SUPPLY_NAME=test_ac
[ 9.164483] power_supply test_ac: POWER_SUPPLY_NAME=test_ac
[ 9.184028] power_supply test_ac: prop ONLINE=1
[ 9.184028] power_supply test_ac: prop ONLINE=1
[ 9.185235] power_supply test_ac: power_supply_changed
[ 9.185235] power_supply test_ac: power_supply_changed
[ 9.186609] power_supply test_ac: power_supply_changed_work
[ 9.186609] power_supply test_ac: power_supply_changed_work
[ 9.188028] power_supply test_ac: uevent
[ 9.188028] power_supply test_ac: uevent
[ 9.189043] power_supply test_ac: POWER_SUPPLY_NAME=test_ac
[ 9.189043] power_supply test_ac: POWER_SUPPLY_NAME=test_ac
[ 9.190465] power_supply test_ac: prop ONLINE=1
[ 9.190465] power_supply test_ac: prop ONLINE=1
[ 9.191953] power_supply test_battery: uevent
[ 9.191953] power_supply test_battery: uevent
[ 9.193053] power_supply test_battery: POWER_SUPPLY_NAME=test_battery
[ 9.193053] power_supply test_battery: POWER_SUPPLY_NAME=test_battery
[ 9.194687] power_supply test_battery: prop STATUS=Discharging
[ 9.194687] power_supply test_battery: prop STATUS=Discharging
[ 9.196134] power_supply test_battery: prop CHARGE_TYPE=Fast
[ 9.196134] power_supply test_battery: prop CHARGE_TYPE=Fast
[ 9.197590] power_supply test_battery: prop HEALTH=Good
[ 9.197590] power_supply test_battery: prop HEALTH=Good
[ 9.198891] power_supply test_battery: prop PRESENT=1
[ 9.198891] power_supply test_battery: prop PRESENT=1
[ 9.200169] power_supply test_battery: prop TECHNOLOGY=Li-ion
[ 9.200169] power_supply test_battery: prop TECHNOLOGY=Li-ion
[ 9.215783] power_supply test_battery: prop CHARGE_FULL_DESIGN=100
[ 9.215783] power_supply test_battery: prop CHARGE_FULL_DESIGN=100
[ 9.217345] power_supply test_battery: prop CHARGE_FULL=100
[ 9.217345] power_supply test_battery: prop CHARGE_FULL=100
[ 9.218741] power_supply test_battery: prop CHARGE_NOW=50
[ 9.218741] power_supply test_battery: prop CHARGE_NOW=50
[ 9.220088] power_supply test_battery: prop CAPACITY=50
[ 9.220088] power_supply test_battery: prop CAPACITY=50
[ 9.221423] power_supply test_battery: prop CAPACITY_LEVEL=Normal
[ 9.221423] power_supply test_battery: prop CAPACITY_LEVEL=Normal
[ 9.222925] power_supply test_battery: prop TIME_TO_EMPTY_AVG=3600
[ 9.222925] power_supply test_battery: prop TIME_TO_EMPTY_AVG=3600
[ 9.224497] power_supply test_battery: prop TIME_TO_FULL_NOW=3600
[ 9.224497] power_supply test_battery: prop TIME_TO_FULL_NOW=3600
[ 9.226022] power_supply test_battery: prop MODEL_NAME=Test battery
[ 9.226022] power_supply test_battery: prop MODEL_NAME=Test battery
[ 9.227605] power_supply test_battery: prop MANUFACTURER=Linux
[ 9.227605] power_supply test_battery: prop MANUFACTURER=Linux
[ 9.242191] power_supply test_battery: prop SERIAL_NUMBER=4.1.0-rc6-00115-g2ea0fdf
[ 9.242191] power_supply test_battery: prop SERIAL_NUMBER=4.1.0-rc6-00115-g2ea0fdf
[ 9.244072] power_supply test_battery: prop TEMP=26
[ 9.244072] power_supply test_battery: prop TEMP=26
[ 9.245307] power_supply test_battery: prop VOLTAGE_NOW=3300
[ 9.245307] power_supply test_battery: prop VOLTAGE_NOW=3300
[ 9.246949] power_supply test_battery: power_supply_changed
[ 9.246949] power_supply test_battery: power_supply_changed
[ 9.248395] power_supply test_battery: power_supply_changed_work
[ 9.248395] power_supply test_battery: power_supply_changed_work
[ 9.249905] power_supply test_battery: uevent
[ 9.249905] power_supply test_battery: uevent
[ 9.250998] power_supply test_battery: POWER_SUPPLY_NAME=test_battery
[ 9.250998] power_supply test_battery: POWER_SUPPLY_NAME=test_battery
[ 9.252631] power_supply test_battery: prop STATUS=Discharging
[ 9.252631] power_supply test_battery: prop STATUS=Discharging
[ 9.272277] power_supply test_battery: prop CHARGE_TYPE=Fast
[ 9.272277] power_supply test_battery: prop CHARGE_TYPE=Fast
[ 9.273706] power_supply test_battery: prop HEALTH=Good
[ 9.273706] power_supply test_battery: prop HEALTH=Good
[ 9.275001] power_supply test_battery: prop PRESENT=1
[ 9.275001] power_supply test_battery: prop PRESENT=1
[ 9.276312] power_supply test_battery: prop TECHNOLOGY=Li-ion
[ 9.276312] power_supply test_battery: prop TECHNOLOGY=Li-ion
[ 9.277735] power_supply test_battery: prop CHARGE_FULL_DESIGN=100
[ 9.277735] power_supply test_battery: prop CHARGE_FULL_DESIGN=100
[ 9.279338] power_supply test_battery: prop CHARGE_FULL=100
[ 9.279338] power_supply test_battery: prop CHARGE_FULL=100
[ 9.280708] power_supply test_battery: prop CHARGE_NOW=50
[ 9.280708] power_supply test_battery: prop CHARGE_NOW=50
[ 9.282049] power_supply test_battery: prop CAPACITY=50
[ 9.282049] power_supply test_battery: prop CAPACITY=50
[ 9.283369] power_supply test_battery: prop CAPACITY_LEVEL=Normal
[ 9.283369] power_supply test_battery: prop CAPACITY_LEVEL=Normal
[ 9.284876] power_supply test_battery: prop TIME_TO_EMPTY_AVG=3600
[ 9.284876] power_supply test_battery: prop TIME_TO_EMPTY_AVG=3600
[ 9.300934] power_supply test_usb: uevent
[ 9.300934] power_supply test_usb: uevent
[ 9.301973] power_supply test_usb: POWER_SUPPLY_NAME=test_usb
[ 9.301973] power_supply test_usb: POWER_SUPPLY_NAME=test_usb
[ 9.303449] power_supply test_usb: prop ONLINE=1
[ 9.303449] power_supply test_usb: prop ONLINE=1
[ 9.304609] power_supply test_usb: power_supply_changed
[ 9.304609] power_supply test_usb: power_supply_changed
[ 9.307407] applesmc: supported laptop not found!
[ 9.307407] applesmc: supported laptop not found!
[ 9.308587] applesmc: driver init failed (ret=-19)!
[ 9.308587] applesmc: driver init failed (ret=-19)!
[ 9.312207] pc87360: PC8736x not detected, module not inserted
[ 9.312207] pc87360: PC8736x not detected, module not inserted
[ 9.314964] intel_powerclamp: Intel powerclamp does not run on family 15 model 6
[ 9.314964] intel_powerclamp: Intel powerclamp does not run on family 15 model 6
[ 9.316950] acquirewdt: WDT driver for Acquire single board computer initialising
[ 9.316950] acquirewdt: WDT driver for Acquire single board computer initialising
[ 9.332351] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1
[ 9.332351] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1
[ 9.334914] evbug: Connected device: input1 (AT Translated Set 2 keyboard at isa0060/serio0/input0)
[ 9.334914] evbug: Connected device: input1 (AT Translated Set 2 keyboard at isa0060/serio0/input0)
[ 9.337336] power_supply test_battery: prop TIME_TO_FULL_NOW=3600
[ 9.337336] power_supply test_battery: prop TIME_TO_FULL_NOW=3600
[ 9.349387] power_supply test_battery: prop MODEL_NAME=Test battery
[ 9.349387] power_supply test_battery: prop MODEL_NAME=Test battery
[ 9.350935] power_supply test_battery: prop MANUFACTURER=Linux
[ 9.350935] power_supply test_battery: prop MANUFACTURER=Linux
[ 9.352416] power_supply test_battery: prop SERIAL_NUMBER=4.1.0-rc6-00115-g2ea0fdf
[ 9.352416] power_supply test_battery: prop SERIAL_NUMBER=4.1.0-rc6-00115-g2ea0fdf
[ 9.354294] power_supply test_battery: prop TEMP=26
[ 9.354294] power_supply test_battery: prop TEMP=26
[ 9.355511] power_supply test_battery: prop VOLTAGE_NOW=3300
[ 9.355511] power_supply test_battery: prop VOLTAGE_NOW=3300
[ 9.356962] power_supply test_usb: power_supply_changed_work
[ 9.356962] power_supply test_usb: power_supply_changed_work
[ 9.358393] power_supply test_usb: uevent
[ 9.358393] power_supply test_usb: uevent
[ 9.359398] power_supply test_usb: POWER_SUPPLY_NAME=test_usb
[ 9.359398] power_supply test_usb: POWER_SUPPLY_NAME=test_usb
[ 9.360821] power_supply test_usb: prop ONLINE=1
[ 9.360821] power_supply test_usb: prop ONLINE=1
[ 9.371313] acquirewdt: I/O address 0x0043 already in use
[ 9.371313] acquirewdt: I/O address 0x0043 already in use
[ 9.372685] acquirewdt: probe of acquirewdt failed with error -5
[ 9.372685] acquirewdt: probe of acquirewdt failed with error -5
[ 9.374570] advantechwdt: WDT driver for Advantech single board computer initialising
[ 9.374570] advantechwdt: WDT driver for Advantech single board computer initialising
[ 9.392284] advantechwdt: initialized. timeout=60 sec (nowayout=0)
[ 9.392284] advantechwdt: initialized. timeout=60 sec (nowayout=0)
[ 9.393905] ib700wdt: WDT driver for IB700 single board computer initialising
[ 9.393905] ib700wdt: WDT driver for IB700 single board computer initialising
[ 9.395929] ib700wdt: START method I/O 443 is not available
[ 9.395929] ib700wdt: START method I/O 443 is not available
[ 9.397346] ib700wdt: probe of ib700wdt failed with error -5
[ 9.397346] ib700wdt: probe of ib700wdt failed with error -5
[ 9.398905] wafer5823wdt: WDT driver for Wafer 5823 single board computer initialising
[ 9.398905] wafer5823wdt: WDT driver for Wafer 5823 single board computer initialising
[ 9.405957] wafer5823wdt: I/O address 0x0443 already in use
[ 9.405957] wafer5823wdt: I/O address 0x0443 already in use
[ 9.407493] sc1200wdt: build 20020303
[ 9.407493] sc1200wdt: build 20020303
[ 9.408477] sc1200wdt: io parameter must be specified
[ 9.408477] sc1200wdt: io parameter must be specified
[ 9.409785] pc87413_wdt: Version 1.1 at io 0x2E
[ 9.409785] pc87413_wdt: Version 1.1 at io 0x2E
[ 9.410917] pc87413_wdt: cannot register miscdev on minor=130 (err=-16)
[ 9.410917] pc87413_wdt: cannot register miscdev on minor=130 (err=-16)
[ 9.412588] sbc60xxwdt: I/O address 0x0443 already in use
[ 9.412588] sbc60xxwdt: I/O address 0x0443 already in use
[ 9.413943] cpu5wdt: misc_register failed
[ 9.413943] cpu5wdt: misc_register failed
[ 9.415002] smsc37b787_wdt: SMsC 37B787 watchdog component driver 1.1 initialising...
[ 9.415002] smsc37b787_wdt: SMsC 37B787 watchdog component driver 1.1 initialising...
[ 9.440145] smsc37b787_wdt: Unable to register miscdev on minor 130
[ 9.440145] smsc37b787_wdt: Unable to register miscdev on minor 130
[ 9.441745] w83877f_wdt: I/O address 0x0443 already in use
[ 9.441745] w83877f_wdt: I/O address 0x0443 already in use
[ 9.443106] w83977f_wdt: driver v1.00
[ 9.443106] w83977f_wdt: driver v1.00
[ 9.444038] w83977f_wdt: cannot register miscdev on minor=130 (err=-16)
[ 9.444038] w83977f_wdt: cannot register miscdev on minor=130 (err=-16)
[ 9.445679] sbc_epx_c3: cannot register miscdev on minor=130 (err=-16)
[ 9.445679] sbc_epx_c3: cannot register miscdev on minor=130 (err=-16)
[ 9.448787] dcdbas dcdbas: Dell Systems Management Base Driver (version 5.6.0-3.2)
[ 9.448787] dcdbas dcdbas: Dell Systems Management Base Driver (version 5.6.0-3.2)
[ 9.453928] fake-fmc-carrier: mezzanine 0
[ 9.453928] fake-fmc-carrier: mezzanine 0
[ 9.454981] Manufacturer: fake-vendor
[ 9.454981] Manufacturer: fake-vendor
[ 9.468084] Product name: fake-design-for-testing
[ 9.468084] Product name: fake-design-for-testing
[ 9.469629] fmc fake-design-for-testing-f001: Driver has no ID: matches all
[ 9.469629] fmc fake-design-for-testing-f001: Driver has no ID: matches all
[ 9.471383] fmc_trivial: probe of fake-design-for-testing-f001 failed with error -95
[ 9.471383] fmc_trivial: probe of fake-design-for-testing-f001 failed with error -95
[ 9.473363] fmc fake-design-for-testing-f001: Driver has no ID: matches all
[ 9.473363] fmc fake-design-for-testing-f001: Driver has no ID: matches all
[ 9.475092] fmc_write_eeprom fake-design-for-testing-f001: fmc_write_eeprom: no busid passed, refusing all cards
[ 9.475092] fmc_write_eeprom fake-design-for-testing-f001: fmc_write_eeprom: no busid passed, refusing all cards
[ 9.477685] fmc fake-design-for-testing-f001: Driver has no ID: matches all
[ 9.477685] fmc fake-design-for-testing-f001: Driver has no ID: matches all
[ 9.479697] fmc_chardev fake-design-for-testing-f001: Created misc device "fake-design-for-testing-f001"
[ 9.479697] fmc_chardev fake-design-for-testing-f001: Created misc device "fake-design-for-testing-f001"
[ 9.482856] Audio Excel DSP 16 init driver Copyright (C) Riccardo Facchetti 1995-98
[ 9.482856] Audio Excel DSP 16 init driver Copyright (C) Riccardo Facchetti 1995-98
[ 9.484741] aedsp16: I/O, IRQ and DMA are mandatory
[ 9.484741] aedsp16: I/O, IRQ and DMA are mandatory
[ 9.485963] MediaTrix audio driver Copyright (C) by Hannu Savolainen 1993-1996
[ 9.485963] MediaTrix audio driver Copyright (C) by Hannu Savolainen 1993-1996
[ 9.487745] I/O, IRQ, DMA and type are mandatory
[ 9.487745] I/O, IRQ, DMA and type are mandatory
[ 9.501027] ad1848/cs4248 codec driver Copyright (C) by Hannu Savolainen 1993-1996
[ 9.501027] ad1848/cs4248 codec driver Copyright (C) by Hannu Savolainen 1993-1996
[ 9.502902] ad1848: No ISAPnP cards found, trying standard ones...
[ 9.502902] ad1848: No ISAPnP cards found, trying standard ones...
[ 9.504491] sb: Init: Starting Probe...
[ 9.504491] sb: Init: Starting Probe...
[ 9.505534] sb: Init: Done
[ 9.505534] sb: Init: Done
[ 9.506269] uart6850: irq and io must be set.
[ 9.506269] uart6850: irq and io must be set.
[ 9.507424] YM3812 and OPL-3 driver Copyright (C) by Hannu Savolainen, Rob Hooft 1993-1996
[ 9.507424] YM3812 and OPL-3 driver Copyright (C) by Hannu Savolainen, Rob Hooft 1993-1996
[ 9.509474] MIDI Loopback device driver
[ 9.509474] MIDI Loopback device driver
[ 9.537469] ... APIC ID: 00000000 (0)
[ 9.537469] ... APIC ID: 00000000 (0)
[ 9.538018] ... APIC VERSION: 01050014
[ 9.538018] ... APIC VERSION: 01050014
[ 9.538018] 00000000
[ 9.538018] 000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000

[ 9.538018] 00000000
[ 9.538018] 000000000e2000000e200000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000

[ 9.538018] 00000000
[ 9.538018] 000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000800000008000

[ 9.545201]
[ 9.545201]
[ 9.557588] number of MP IRQ sources: 15.
[ 9.557588] number of MP IRQ sources: 15.
[ 9.558587] number of IO-APIC #0 registers: 24.
[ 9.558587] number of IO-APIC #0 registers: 24.
[ 9.559709] testing the IO APIC.......................
[ 9.559709] testing the IO APIC.......................
[ 9.561007] IO APIC #0......
[ 9.561007] IO APIC #0......
[ 9.561744] .... register #00: 00000000
[ 9.561744] .... register #00: 00000000
[ 9.562719] ....... : physical APIC id: 00
[ 9.562719] ....... : physical APIC id: 00
[ 9.563803] ....... : Delivery Type: 0
[ 9.563803] ....... : Delivery Type: 0
[ 9.564806] ....... : LTS : 0
[ 9.564806] ....... : LTS : 0
[ 9.565800] .... register #01: 00170011
[ 9.565800] .... register #01: 00170011
[ 9.566763] ....... : max redirection entries: 17
[ 9.566763] ....... : max redirection entries: 17
[ 9.568003] ....... : PRQ implemented: 0
[ 9.568003] ....... : PRQ implemented: 0
[ 9.569076] ....... : IO APIC version: 11
[ 9.569076] ....... : IO APIC version: 11
[ 9.587242] .... register #02: 00000000
[ 9.587242] .... register #02: 00000000
[ 9.588200] ....... : arbitration: 00
[ 9.588200] ....... : arbitration: 00
[ 9.589206] .... IRQ redirection table:
[ 9.589206] .... IRQ redirection table:
[ 9.590175] 1 0 0 0 0 0 0 00
[ 9.590175] 1 0 0 0 0 0 0 00
[ 9.591326] 0 0 0 0 0 1 1 31
[ 9.591326] 0 0 0 0 0 1 1 31
[ 9.592470] 0 0 0 0 0 1 1 30
[ 9.592470] 0 0 0 0 0 1 1 30
[ 9.593604] 0 0 0 0 0 1 1 33
[ 9.593604] 0 0 0 0 0 1 1 33
[ 9.594756] 1 0 0 0 0 1 1 34
[ 9.594756] 1 0 0 0 0 1 1 34
[ 9.595889] 1 1 0 0 0 1 1 35
[ 9.595889] 1 1 0 0 0 1 1 35
[ 9.597047] 0 0 0 0 0 1 1 36
[ 9.597047] 0 0 0 0 0 1 1 36
[ 9.598173] 0 0 0 0 0 1 1 37
[ 9.598173] 0 0 0 0 0 1 1 37
[ 9.599329] 0 0 0 0 0 1 1 38
[ 9.599329] 0 0 0 0 0 1 1 38
[ 9.614533] 0 1 0 0 0 1 1 39
[ 9.614533] 0 1 0 0 0 1 1 39
[ 9.615679] 1 1 0 0 0 1 1 3A
[ 9.615679] 1 1 0 0 0 1 1 3A
[ 9.616820] 1 1 0 0 0 1 1 3B
[ 9.616820] 1 1 0 0 0 1 1 3B
[ 9.617955] 0 0 0 0 0 1 1 3C
[ 9.617955] 0 0 0 0 0 1 1 3C
[ 9.619100] 0 0 0 0 0 1 1 3D
[ 9.619100] 0 0 0 0 0 1 1 3D
[ 9.620237] 0 0 0 0 0 1 1 3E
[ 9.620237] 0 0 0 0 0 1 1 3E
[ 9.621381] 0 0 0 0 0 1 1 3F
[ 9.621381] 0 0 0 0 0 1 1 3F
[ 9.622525] 1 0 0 0 0 0 0 00
[ 9.622525] 1 0 0 0 0 0 0 00
[ 9.623662] 1 0 0 0 0 0 0 00
[ 9.623662] 1 0 0 0 0 0 0 00
[ 9.624805] 1 0 0 0 0 0 0 00
[ 9.624805] 1 0 0 0 0 0 0 00
[ 9.625933] 1 0 0 0 0 0 0 00
[ 9.625933] 1 0 0 0 0 0 0 00
[ 9.639158] 1 0 0 0 0 0 0 00
[ 9.639158] 1 0 0 0 0 0 0 00
[ 9.640302] 1 0 0 0 0 0 0 00
[ 9.640302] 1 0 0 0 0 0 0 00
[ 9.641436] 1 0 0 0 0 0 0 00
[ 9.641436] 1 0 0 0 0 0 0 00
[ 9.642579] 1 0 0 0 0 0 0 00
[ 9.642579] 1 0 0 0 0 0 0 00
[ 9.643704] IRQ to pin mappings:
[ 9.643704] IRQ to pin mappings:
[ 9.644519] IRQ0
[ 9.644519] IRQ0 -> 0:2-> 0:2

[ 9.645173] IRQ1
[ 9.645173] IRQ1 -> 0:1-> 0:1

[ 9.645821] IRQ3
[ 9.645821] IRQ3 -> 0:3-> 0:3

[ 9.646486] IRQ4
[ 9.646486] IRQ4 -> 0:4-> 0:4

[ 9.647131] IRQ5
[ 9.647131] IRQ5 -> 0:5-> 0:5

[ 9.647775] IRQ6
[ 9.647775] IRQ6 -> 0:6-> 0:6

[ 9.648441] IRQ7
[ 9.648441] IRQ7 -> 0:7-> 0:7

[ 9.649093] IRQ8
[ 9.649093] IRQ8 -> 0:8-> 0:8

[ 9.649739] IRQ9
[ 9.649739] IRQ9 -> 0:9-> 0:9

[ 9.650405] IRQ10
[ 9.650405] IRQ10 -> 0:10-> 0:10

[ 9.653148] IRQ11
[ 9.653148] IRQ11 -> 0:11-> 0:11

[ 9.653840] IRQ12
[ 9.653840] IRQ12 -> 0:12-> 0:12

[ 9.654554] IRQ13
[ 9.654554] IRQ13 -> 0:13-> 0:13

[ 9.655261] IRQ14
[ 9.655261] IRQ14 -> 0:14-> 0:14

[ 9.655930] IRQ15
[ 9.655930] IRQ15 -> 0:15-> 0:15

[ 9.656641] .................................... done.
[ 9.656641] .................................... done.
[ 9.657957] Using IPI No-Shortcut mode
[ 9.657957] Using IPI No-Shortcut mode
[ 9.659745] bootconsole [earlyser0] disabled
[ 9.659745] bootconsole [earlyser0] disabled
[ 9.661140] Loading compiled-in X.509 certificates
[ 9.661756] Running tests on trace events:
[ 9.662307] Testing event thermal_apic_exit: OK
[ 13.978811] Testing event thermal_apic_entry: OK
[ 13.984416] Testing event threshold_apic_exit: OK
[ 13.989215] Testing event threshold_apic_entry: OK
[ 13.993221] Testing event call_function_single_exit: OK
[ 13.997255] Testing event call_function_single_entry: OK
[ 14.001195] Testing event call_function_exit: OK
[ 14.005190] Testing event call_function_entry: OK
[ 14.009368] Testing event irq_work_exit: OK
[ 14.013229] Testing event irq_work_entry: OK
[ 14.017254] Testing event x86_platform_ipi_exit: OK
[ 14.022246] Testing event x86_platform_ipi_entry: OK
[ 14.044387] Testing event error_apic_exit: OK
[ 14.079342] Testing event error_apic_entry: OK
[ 14.101369] Testing event spurious_apic_exit: OK
[ 14.136292] Testing event spurious_apic_entry: OK
[ 14.158352] Testing event reschedule_exit: OK
[ 14.193313] Testing event reschedule_entry: OK
[ 14.219434] Testing event local_timer_exit: OK
[ 14.224301] Testing event local_timer_entry: OK
[ 14.228261] Testing event nmi_handler: OK
[ 14.232231] Testing event sys_exit: OK
[ 14.236275] Testing event sys_enter: OK
[ 14.240248] Testing event mce_record: OK
[ 14.244262] Testing event tlb_flush: OK
[ 14.249363] Testing event page_fault_kernel: OK
[ 14.254292] Testing event page_fault_user: OK
[ 14.277461] Testing event task_rename: OK
[ 14.283330] Testing event task_newtask: OK
[ 14.288384] Testing event softirq_raise: OK
[ 14.293311] Testing event softirq_exit: OK
[ 14.298328] Testing event softirq_entry: OK
[ 14.303308] Testing event irq_handler_exit: OK
[ 14.308275] Testing event irq_handler_entry: OK
[ 14.313261] Testing event signal_deliver: OK
[ 14.317217] Testing event signal_generate: OK
[ 14.321263] Testing event workqueue_execute_end: OK
[ 14.326320] Testing event workqueue_execute_start: OK
[ 14.332299] Testing event workqueue_activate_work: OK
[ 14.337275] Testing event workqueue_queue_work: OK
[ 14.342294] Testing event sched_wake_idle_without_ipi: OK
[ 14.347263] Testing event sched_swap_numa: OK
[ 14.351295] Testing event sched_stick_numa: OK
[ 14.355260] Testing event sched_move_numa: OK
[ 14.359239] Testing event sched_process_hang: OK
[ 14.363252] Testing event sched_pi_setprio: OK
[ 14.367286] Testing event sched_stat_runtime: OK
[ 14.372262] Testing event sched_stat_blocked: OK
[ 14.376387] Testing event sched_stat_iowait: OK
[ 14.382250] Testing event sched_stat_sleep: OK
[ 14.386328] Testing event sched_stat_wait: OK
[ 14.391328] Testing event sched_process_exec: OK
[ 14.396302] Testing event sched_process_fork: OK
[ 14.402313] Testing event sched_process_wait: OK
[ 14.420353] Testing event sched_wait_task: OK
[ 14.425336] Testing event sched_process_exit: OK
[ 14.430288] Testing event sched_process_free: OK
[ 14.436256] Testing event sched_migrate_task: OK
[ 14.442205] Testing event sched_switch: OK
[ 14.447279] Testing event sched_wakeup_new: OK
[ 14.451209] Testing event sched_wakeup: OK
[ 14.456304] Testing event sched_kthread_stop_ret: OK
[ 14.462319] Testing event sched_kthread_stop: OK
[ 14.468217] Testing event lock_release: OK
[ 14.473376] Testing event lock_acquire: OK
[ 14.478295] Testing event console: OK
[ 14.484236] Testing event rcu_utilization: OK
[ 14.488274] Testing event itimer_expire: OK
[ 14.493327] Testing event itimer_state: OK
[ 14.499219] Testing event hrtimer_cancel: OK
[ 14.503201] Testing event hrtimer_expire_exit: OK
[ 14.507300] Testing event hrtimer_expire_entry: OK
[ 14.513291] Testing event hrtimer_start: OK
[ 14.518265] Testing event hrtimer_init: OK
[ 14.523270] Testing event timer_cancel: OK
[ 14.527197] Testing event timer_expire_exit: OK
[ 14.531198] Testing event timer_expire_entry: OK
[ 14.535210] Testing event timer_start: OK
[ 14.539314] Testing event timer_init: OK
[ 14.544325] Testing event ftrace_test_filter: OK
[ 14.549246] Testing event dev_pm_qos_remove_request: OK
[ 14.554242] Testing event dev_pm_qos_update_request: OK
[ 14.559250] Testing event dev_pm_qos_add_request: OK
[ 14.564289] Testing event pm_qos_update_flags: OK
[ 14.570269] Testing event pm_qos_update_target: OK
[ 14.575365] Testing event pm_qos_update_request_timeout: OK
[ 14.581286] Testing event pm_qos_remove_request: OK
[ 14.586258] Testing event pm_qos_update_request: OK
[ 14.592255] Testing event pm_qos_add_request: OK
[ 14.598279] Testing event power_domain_target: OK
[ 14.603284] Testing event clock_set_rate: OK
[ 14.607247] Testing event clock_disable: OK
[ 14.611262] Testing event clock_enable: OK
[ 14.615280] Testing event wakeup_source_deactivate: OK
[ 14.620211] Testing event wakeup_source_activate: OK
[ 14.624287] Testing event suspend_resume: OK
[ 14.628293] Testing event device_pm_callback_end: OK
[ 14.634393] Testing event device_pm_callback_start: OK
[ 14.640283] Testing event cpu_frequency: OK
[ 14.645314] Testing event pstate_sample: OK
[ 14.651251] Testing event cpu_idle: OK
[ 14.655254] Testing event rpm_return_int: OK
[ 14.659211] Testing event rpm_idle: OK
[ 14.663284] Testing event rpm_resume: OK
[ 14.667258] Testing event rpm_suspend: OK
[ 14.671229] Testing event mm_filemap_add_to_page_cache: OK
[ 14.676284] Testing event mm_filemap_delete_from_page_cache: OK
[ 14.681232] Testing event oom_score_adj_update: OK
[ 14.685283] Testing event mm_lru_activate: OK
[ 14.689222] Testing event mm_lru_insertion: OK
[ 14.693255] Testing event mm_vmscan_lru_shrink_inactive: OK
[ 14.698370] Testing event mm_vmscan_writepage: OK
[ 14.703353] Testing event mm_vmscan_memcg_isolate: OK
[ 14.708311] Testing event mm_vmscan_lru_isolate: OK
[ 14.713345] Testing event mm_shrink_slab_end: OK
[ 14.719317] Testing event mm_shrink_slab_start: OK
[ 14.724313] Testing event mm_vmscan_memcg_softlimit_reclaim_end: OK
[ 14.730257] Testing event mm_vmscan_memcg_reclaim_end: OK
[ 14.736239] Testing event mm_vmscan_direct_reclaim_end: OK
[ 14.741265] Testing event mm_vmscan_memcg_softlimit_reclaim_begin: OK
[ 14.746244] Testing event mm_vmscan_memcg_reclaim_begin: OK
[ 14.751303] Testing event mm_vmscan_direct_reclaim_begin: OK
[ 14.757373] Testing event mm_vmscan_wakeup_kswapd: OK
[ 14.763254] Testing event mm_vmscan_kswapd_wake: OK
[ 14.769241] Testing event mm_vmscan_kswapd_sleep: OK
[ 14.774344] Testing event mm_page_alloc_extfrag: OK
[ 14.779312] Testing event mm_page_pcpu_drain: OK
[ 14.784262] Testing event mm_page_alloc_zone_locked: OK
[ 14.790236] Testing event mm_page_alloc: OK
[ 14.794243] Testing event mm_page_free_batched: OK
[ 14.798251] Testing event mm_page_free: OK
[ 14.802221] Testing event kmem_cache_free: OK
[ 14.806254] Testing event kfree: OK
[ 14.810252] Testing event kmem_cache_alloc_node: OK
[ 14.816240] Testing event kmalloc_node: OK
[ 14.820206] Testing event kmem_cache_alloc: OK
[ 14.824255] Testing event kmalloc: OK
[ 14.828290] Testing event mm_compaction_suitable: OK
[ 14.833279] Testing event mm_compaction_finished: OK
[ 14.838282] Testing event mm_compaction_try_to_compact_pages: OK
[ 14.843230] Testing event mm_compaction_end: OK
[ 14.847289] Testing event mm_compaction_begin: OK
[ 14.852242] Testing event mm_compaction_migratepages: OK
[ 14.857315] Testing event mm_compaction_isolate_freepages: OK
[ 14.862232] Testing event mm_compaction_isolate_migratepages: OK
[ 14.868258] Testing event mm_numa_migrate_ratelimit: OK
[ 14.872274] Testing event mm_migrate_pages: OK
[ 14.876281] Testing event cma_release: OK
[ 14.880222] Testing event cma_alloc: OK
[ 14.884272] Testing event writeback_dirty_inode_enqueue: OK
[ 14.889253] Testing event writeback_lazytime_iput: OK
[ 14.895306] Testing event writeback_lazytime: OK
[ 14.900262] Testing event writeback_single_inode: OK
[ 14.906259] Testing event writeback_single_inode_start: OK
[ 14.911298] Testing event writeback_wait_iff_congested: OK
[ 14.917233] Testing event writeback_congestion_wait: OK
[ 14.923264] Testing event writeback_sb_inodes_requeue: OK
[ 14.928241] Testing event balance_dirty_pages: OK
[ 14.932338] Testing event bdi_dirty_ratelimit: OK
[ 14.938341] Testing event global_dirty_state: OK
[ 14.944279] Testing event writeback_queue_io: OK
[ 14.949253] Testing event wbc_writepage: OK
[ 14.953233] Testing event writeback_bdi_unregister: OK
[ 14.958250] Testing event writeback_bdi_register: OK
[ 14.962285] Testing event writeback_wake_background: OK
[ 14.967237] Testing event writeback_nowork: OK
[ 14.971252] Testing event writeback_pages_written: OK
[ 14.975366] Testing event writeback_wait: OK
[ 14.980455] Testing event writeback_written: OK
[ 14.986269] Testing event writeback_start: OK
[ 14.990260] Testing event writeback_exec: OK
[ 14.994308] Testing event writeback_queue: OK
[ 14.998301] Testing event writeback_write_inode: OK
[ 15.003261] Testing event writeback_write_inode_start: OK
[ 15.008364] Testing event writeback_dirty_inode: OK
[ 15.014290] Testing event writeback_dirty_inode_start: OK
[ 15.019252] Testing event writeback_mark_inode_dirty: OK
[ 15.024234] Testing event writeback_dirty_page: OK
[ 15.028229] Testing event time_out_leases: OK
[ 15.032265] Testing event generic_delete_lease: OK
[ 15.036246] Testing event generic_add_lease: OK
[ 15.040214] Testing event break_lease_unblock: OK
[ 15.045310] Testing event break_lease_block: OK
[ 15.049222] Testing event break_lease_noblock: OK
[ 15.053234] Testing event ext4_es_shrink: OK
[ 15.057216] Testing event ext4_collapse_range: OK
[ 15.061305] Testing event ext4_es_shrink_scan_exit: OK
[ 15.066265] Testing event ext4_es_shrink_scan_enter: OK
[ 15.071262] Testing event ext4_es_shrink_count: OK
[ 15.075287] Testing event ext4_es_lookup_extent_exit: OK
[ 15.080228] Testing event ext4_es_lookup_extent_enter: OK
[ 15.085279] Testing event ext4_es_find_delayed_extent_range_exit: OK
[ 15.090261] Testing event ext4_es_find_delayed_extent_range_enter: OK
[ 15.095266] Testing event ext4_es_remove_extent: OK
[ 15.099329] Testing event ext4_es_cache_extent: OK
[ 15.105260] Testing event ext4_es_insert_extent: OK
[ 15.110327] Testing event ext4_ext_remove_space_done: OK
[ 15.116259] Testing event ext4_ext_remove_space: OK
[ 15.122288] Testing event ext4_ext_rm_idx: OK
[ 15.126261] Testing event ext4_ext_rm_leaf: OK
[ 15.130338] Testing event ext4_remove_blocks: OK
[ 15.135306] Testing event ext4_ext_show_extent: OK
[ 15.141307] Testing event ext4_get_reserved_cluster_alloc: OK
[ 15.147280] Testing event ext4_find_delalloc_range: OK
[ 15.153239] Testing event ext4_ext_in_cache: OK
[ 15.159279] Testing event ext4_ext_put_in_cache: OK
[ 15.164280] Testing event ext4_get_implied_cluster_alloc_exit: OK
[ 15.169250] Testing event ext4_ext_handle_unwritten_extents: OK
[ 15.175301] Testing event ext4_trim_all_free: OK
[ 15.181221] Testing event ext4_trim_extent: OK
[ 15.185263] Testing event ext4_journal_start_reserved: OK
[ 15.191239] Testing event ext4_journal_start: OK
[ 15.195280] Testing event ext4_load_inode: OK
[ 15.199258] Testing event ext4_ext_load_extent: OK
[ 15.205290] Testing event ext4_ind_map_blocks_exit: OK
[ 15.210263] Testing event ext4_ext_map_blocks_exit: OK
[ 15.216245] Testing event ext4_ind_map_blocks_enter: OK
[ 15.221295] Testing event ext4_ext_map_blocks_enter: OK
[ 15.226223] Testing event ext4_ext_convert_to_initialized_fastpath: OK
[ 15.232282] Testing event ext4_ext_convert_to_initialized_enter: OK
[ 15.237358] Testing event ext4_truncate_exit: OK
[ 15.243281] Testing event ext4_truncate_enter: OK
[ 15.248260] Testing event ext4_unlink_exit: OK
[ 15.252329] Testing event ext4_unlink_enter: OK
[ 15.257222] Testing event ext4_fallocate_exit: OK
[ 15.261264] Testing event ext4_zero_range: OK
[ 15.265268] Testing event ext4_punch_hole: OK
[ 15.269233] Testing event ext4_fallocate_enter: OK
[ 15.273235] Testing event ext4_direct_IO_exit: OK
[ 15.277226] Testing event ext4_direct_IO_enter: OK
[ 15.281279] Testing event ext4_load_inode_bitmap: OK
[ 15.286269] Testing event ext4_read_block_bitmap_load: OK
[ 15.291240] Testing event ext4_mb_buddy_bitmap_load: OK
[ 15.295284] Testing event ext4_mb_bitmap_load: OK
[ 15.300254] Testing event ext4_da_release_space: OK
[ 15.306245] Testing event ext4_da_reserve_space: OK
[ 15.310219] Testing event ext4_da_update_reserve_space: OK
[ 15.316238] Testing event ext4_forget: OK
[ 15.321353] Testing event ext4_mballoc_free: OK
[ 15.326279] Testing event ext4_mballoc_discard: OK
[ 15.331367] Testing event ext4_mballoc_prealloc: OK
[ 15.337354] Testing event ext4_mballoc_alloc: OK
[ 15.342279] Testing event ext4_alloc_da_blocks: OK
[ 15.348295] Testing event ext4_sync_fs: OK
[ 15.359337] Testing event ext4_sync_file_exit: OK
[ 15.363320] Testing event ext4_sync_file_enter: OK
[ 15.368285] Testing event ext4_free_blocks: OK
[ 15.373430] Testing event ext4_allocate_blocks: OK
[ 15.379288] Testing event ext4_request_blocks: OK
[ 15.383307] Testing event ext4_mb_discard_preallocations: OK
[ 15.389311] Testing event ext4_discard_preallocations: OK
[ 15.394340] Testing event ext4_mb_release_group_pa: OK
[ 15.400333] Testing event ext4_mb_release_inode_pa: OK
[ 15.406231] Testing event ext4_mb_new_group_pa: OK
[ 15.410264] Testing event ext4_mb_new_inode_pa: OK
[ 15.415303] Testing event ext4_discard_blocks: OK
[ 15.421298] Testing event ext4_journalled_invalidatepage: OK
[ 15.427323] Testing event ext4_invalidatepage: OK
[ 15.432242] Testing event ext4_releasepage: OK
[ 15.436288] Testing event ext4_readpage: OK
[ 15.440273] Testing event ext4_writepage: OK
[ 15.444212] Testing event ext4_writepages_result: OK
[ 15.448218] Testing event ext4_da_write_pages_extent: OK
[ 15.452219] Testing event ext4_da_write_pages: OK
[ 15.456282] Testing event ext4_writepages: OK
[ 15.460263] Testing event ext4_da_write_end: OK
[ 15.464207] Testing event ext4_journalled_write_end: OK
[ 15.468204] Testing event ext4_write_end: OK
[ 15.472216] Testing event ext4_da_write_begin: OK
[ 15.476287] Testing event ext4_write_begin: OK
[ 15.480314] Testing event ext4_begin_ordered_truncate: OK
[ 15.485262] Testing event ext4_mark_inode_dirty: OK
[ 15.490368] Testing event ext4_drop_inode: OK
[ 15.495270] Testing event ext4_evict_inode: OK
[ 15.501299] Testing event ext4_allocate_inode: OK
[ 15.507257] Testing event ext4_request_inode: OK
[ 15.513299] Testing event ext4_free_inode: OK
[ 15.519321] Testing event ext4_other_inode_update_time: OK
[ 15.524315] Testing event jbd2_lock_buffer_stall: OK
[ 15.529231] Testing event jbd2_write_superblock: OK
[ 15.535257] Testing event jbd2_update_log_tail: OK
[ 15.539300] Testing event jbd2_checkpoint_stats: OK
[ 15.545210] Testing event jbd2_run_stats: OK
[ 15.549226] Testing event jbd2_handle_stats: OK
[ 15.553317] Testing event jbd2_handle_extend: OK
[ 15.559278] Testing event jbd2_handle_start: OK
[ 15.563285] Testing event jbd2_submit_inode_data: OK
[ 15.568240] Testing event jbd2_end_commit: OK
[ 15.572362] Testing event jbd2_drop_transaction: OK
[ 15.577279] Testing event jbd2_commit_logging: OK
[ 15.582329] Testing event jbd2_commit_flushing: OK
[ 15.587254] Testing event jbd2_commit_locking: OK
[ 15.591204] Testing event jbd2_start_commit: OK
[ 15.595215] Testing event jbd2_checkpoint: OK
[ 15.599202] Testing event xfs_discard_busy: OK
[ 15.603273] Testing event xfs_discard_exclude: OK
[ 15.607220] Testing event xfs_discard_toosmall: OK
[ 15.611216] Testing event xfs_discard_extent: OK
[ 15.615182] Testing event xfs_log_recover_inode_skip: OK
[ 15.619232] Testing event xfs_log_recover_inode_cancel: OK
[ 15.623225] Testing event xfs_log_recover_inode_recover: OK
[ 15.628246] Testing event xfs_log_recover_buf_dquot_buf: OK
[ 15.633276] Testing event xfs_log_recover_buf_reg_buf: OK
[ 15.639235] Testing event xfs_log_recover_buf_inode_buf: OK
[ 15.645270] Testing event xfs_log_recover_buf_recover: OK
[ 15.651335] Testing event xfs_log_recover_buf_cancel_ref_inc: OK
[ 15.656252] Testing event xfs_log_recover_buf_cancel_add: OK
[ 15.662225] Testing event xfs_log_recover_buf_cancel: OK
[ 15.668254] Testing event xfs_log_recover_buf_not_cancel: OK
[ 15.673290] Testing event xfs_log_recover_item_recover: OK
[ 15.679262] Testing event xfs_log_recover_item_reorder_tail: OK
[ 15.685288] Testing event xfs_log_recover_item_reorder_head: OK
[ 15.690253] Testing event xfs_log_recover_item_add_cont: OK
[ 15.695262] Testing event xfs_log_recover_item_add: OK
[ 15.701334] Testing event xfs_swap_extent_after: OK
[ 15.706298] Testing event xfs_swap_extent_before: OK
[ 15.712305] Testing event xfs_dir2_leafn_moveents: OK
[ 15.718324] Testing event xfs_dir2_shrink_inode: OK
[ 15.724248] Testing event xfs_dir2_grow_inode: OK
[ 15.729320] Testing event xfs_dir2_leafn_remove: OK
[ 15.734299] Testing event xfs_dir2_leafn_add: OK
[ 15.739266] Testing event xfs_da_path_shift: OK
[ 15.743323] Testing event xfs_da_fixhashpath: OK
[ 15.748274] Testing event xfs_da_shrink_inode: OK
[ 15.753333] Testing event xfs_da_grow_inode: OK
[ 15.758262] Testing event xfs_da_swap_lastblock: OK
[ 15.764345] Testing event xfs_da_node_toosmall: OK
[ 15.770252] Testing event xfs_da_node_unbalance: OK
[ 15.776254] Testing event xfs_da_node_rebalance: OK
[ 15.781311] Testing event xfs_da_node_remove: OK
[ 15.787360] Testing event xfs_da_node_split: OK
[ 15.792331] Testing event xfs_da_node_create: OK
[ 15.798267] Testing event xfs_da_node_add: OK
[ 15.803294] Testing event xfs_da_root_join: OK
[ 15.808249] Testing event xfs_da_root_split: OK
[ 15.813210] Testing event xfs_da_unlink_forward: OK
[ 15.817211] Testing event xfs_da_unlink_back: OK
[ 15.821215] Testing event xfs_da_link_after: OK
[ 15.826213] Testing event xfs_da_link_before: OK
[ 15.830242] Testing event xfs_da_join: OK
[ 15.834231] Testing event xfs_da_split: OK
[ 15.838224] Testing event xfs_attr_rmtval_remove: OK
[ 15.843223] Testing event xfs_attr_rmtval_set: OK
[ 15.847229] Testing event xfs_attr_rmtval_get: OK
[ 15.852212] Testing event xfs_attr_refillstate: OK
[ 15.856213] Testing event xfs_attr_fillstate: OK
[ 15.860265] Testing event xfs_attr_node_removename: OK
[ 15.865184] Testing event xfs_attr_node_replace: OK
[ 15.870246] Testing event xfs_attr_node_lookup: OK
[ 15.876247] Testing event xfs_attr_node_get: OK
[ 15.881311] Testing event xfs_attr_node_addname: OK
[ 15.886253] Testing event xfs_attr_leaf_toosmall: OK
[ 15.891311] Testing event xfs_attr_leaf_unbalance: OK
[ 15.897292] Testing event xfs_attr_leaf_rebalance: OK
[ 15.902295] Testing event xfs_attr_leaf_to_node: OK
[ 15.907299] Testing event xfs_attr_leaf_to_sf: OK
[ 15.913236] Testing event xfs_attr_leaf_flipflags: OK
[ 15.919315] Testing event xfs_attr_leaf_setflag: OK
[ 15.924215] Testing event xfs_attr_leaf_clearflag: OK
[ 15.928254] Testing event xfs_attr_leaf_split_after: OK
[ 15.933191] Testing event xfs_attr_leaf_split_before: OK
[ 15.938231] Testing event xfs_attr_leaf_split: OK
[ 15.943328] Testing event xfs_attr_leaf_removename: OK
[ 15.948261] Testing event xfs_attr_leaf_remove: OK
[ 15.953244] Testing event xfs_attr_leaf_replace: OK
[ 15.957205] Testing event xfs_attr_leaf_lookup: OK
[ 15.961318] Testing event xfs_attr_leaf_get: OK
[ 15.965340] Testing event xfs_attr_leaf_compact: OK
[ 15.971425] Testing event xfs_attr_leaf_create: OK
[ 15.976255] Testing event xfs_attr_leaf_addname: OK
[ 15.982264] Testing event xfs_attr_leaf_add_work: OK
[ 15.987307] Testing event xfs_attr_leaf_add_new: OK
[ 15.993333] Testing event xfs_attr_leaf_add_old: OK
[ 15.999343] Testing event xfs_attr_leaf_add: OK
[ 16.004326] Testing event xfs_attr_sf_to_leaf: OK
[ 16.009236] Testing event xfs_attr_sf_removename: OK
[ 16.014275] Testing event xfs_attr_sf_remove: OK
[ 16.018346] Testing event xfs_attr_sf_lookup: OK
[ 16.024287] Testing event xfs_attr_sf_create: OK
[ 16.029252] Testing event xfs_attr_sf_addname: OK
[ 16.035269] Testing event xfs_attr_sf_add: OK
[ 16.039238] Testing event xfs_dir2_node_to_leaf: OK
[ 16.043317] Testing event xfs_dir2_node_removename: OK
[ 16.049297] Testing event xfs_dir2_node_replace: OK
[ 16.054242] Testing event xfs_dir2_node_lookup: OK
[ 16.058292] Testing event xfs_dir2_node_addname: OK
[ 16.063194] Testing event xfs_dir2_leaf_to_node: OK
[ 16.067313] Testing event xfs_dir2_leaf_to_block: OK
[ 16.073289] Testing event xfs_dir2_leaf_removename: OK
[ 16.079317] Testing event xfs_dir2_leaf_replace: OK
[ 16.084270] Testing event xfs_dir2_leaf_lookup: OK
[ 16.089232] Testing event xfs_dir2_leaf_addname: OK
[ 16.093302] Testing event xfs_dir2_block_to_leaf: OK
[ 16.098233] Testing event xfs_dir2_block_to_sf: OK
[ 16.102288] Testing event xfs_dir2_block_removename: OK
[ 16.108244] Testing event xfs_dir2_block_replace: OK
[ 16.112317] Testing event xfs_dir2_block_lookup: OK
[ 16.117241] Testing event xfs_dir2_block_addname: OK
[ 16.123217] Testing event xfs_dir2_sf_to_block: OK
[ 16.127259] Testing event xfs_dir2_sf_toino8: OK
[ 16.131254] Testing event xfs_dir2_sf_toino4: OK
[ 16.135264] Testing event xfs_dir2_sf_removename: OK
[ 16.140229] Testing event xfs_dir2_sf_replace: OK
[ 16.144285] Testing event xfs_dir2_sf_lookup: OK
[ 16.149219] Testing event xfs_dir2_sf_create: OK
[ 16.153265] Testing event xfs_dir2_sf_addname: OK
[ 16.157268] Testing event xfs_alloc_vextent_allfailed: OK
[ 16.163336] Testing event xfs_alloc_vextent_loopfailed: OK
[ 16.169336] Testing event xfs_alloc_vextent_noagbp: OK
[ 16.175311] Testing event xfs_alloc_vextent_nofix: OK
[ 16.181805] Testing event xfs_alloc_vextent_badargs: OK
[ 16.187335] Testing event xfs_alloc_small_error: OK
[ 16.192272] Testing event xfs_alloc_small_done: OK
[ 16.196263] Testing event xfs_alloc_small_notenough: OK
[ 16.202324] Testing event xfs_alloc_small_freelist: OK
[ 16.208355] Testing event xfs_alloc_size_busy: OK
[ 16.214321] Testing event xfs_alloc_size_error: OK
[ 16.219268] Testing event xfs_alloc_size_done: OK
[ 16.225231] Testing event xfs_alloc_size_nominleft: OK
[ 16.229233] Testing event xfs_alloc_size_noentry: OK
[ 16.233197] Testing event xfs_alloc_size_neither: OK
[ 16.237197] Testing event xfs_alloc_near_busy: OK
[ 16.241213] Testing event xfs_alloc_near_noentry: OK
[ 16.245223] Testing event xfs_alloc_near_error: OK
[ 16.249191] Testing event xfs_alloc_near_lesser: OK
[ 16.253217] Testing event xfs_alloc_near_greater: OK
[ 16.257247] Testing event xfs_alloc_near_first: OK
[ 16.261218] Testing event xfs_alloc_near_nominleft: OK
[ 16.265229] Testing event xfs_alloc_exact_error: OK
[ 16.270242] Testing event xfs_alloc_exact_notfound: OK
[ 16.275275] Testing event xfs_alloc_exact_done: OK
[ 16.280290] Testing event xfs_free_extent: OK
[ 16.285313] Testing event xfs_agf: OK
[ 16.289296] Testing event xfs_trans_commit_lsn: OK
[ 16.294275] Testing event xfs_extent_busy_trim: OK
[ 16.300329] Testing event xfs_extent_busy_clear: OK
[ 16.306247] Testing event xfs_extent_busy_reuse: OK
[ 16.310340] Testing event xfs_extent_busy_force: OK
[ 16.316284] Testing event xfs_extent_busy_enomem: OK
[ 16.322296] Testing event xfs_extent_busy: OK
[ 16.327223] Testing event xfs_bunmap: OK
[ 16.331273] Testing event xfs_pagecache_inval: OK
[ 16.335255] Testing event xfs_itruncate_extents_end: OK
[ 16.340271] Testing event xfs_itruncate_extents_start: OK
[ 16.346282] Testing event xfs_setfilesize: OK
[ 16.350276] Testing event xfs_get_blocks_notfound: OK
[ 16.355290] Testing event xfs_unwritten_convert: OK
[ 16.360298] Testing event xfs_delalloc_enospc: OK
[ 16.365234] Testing event xfs_gbmap_direct_endio: OK
[ 16.369258] Testing event xfs_gbmap_direct_none: OK
[ 16.373274] Testing event xfs_gbmap_direct_update: OK
[ 16.378286] Testing event xfs_gbmap_direct_new: OK
[ 16.383245] Testing event xfs_gbmap_direct: OK
[ 16.387274] Testing event xfs_get_blocks_alloc: OK
[ 16.393309] Testing event xfs_get_blocks_found: OK
[ 16.398288] Testing event xfs_map_blocks_alloc: OK
[ 16.402292] Testing event xfs_map_blocks_found: OK
[ 16.408244] Testing event xfs_invalidatepage: OK
[ 16.412341] Testing event xfs_releasepage: OK
[ 16.418294] Testing event xfs_writepage: OK
[ 16.422310] Testing event xfs_file_splice_read: OK
[ 16.427294] Testing event xfs_file_direct_write: OK
[ 16.432229] Testing event xfs_file_buffered_write: OK
[ 16.436262] Testing event xfs_file_read: OK
[ 16.440279] Testing event xfs_log_assign_tail_lsn: OK
[ 16.444262] Testing event xfs_ail_delete: OK
[ 16.448273] Testing event xfs_ail_move: OK
[ 16.452212] Testing event xfs_ail_insert: OK
[ 16.456227] Testing event xfs_ail_flushing: OK
[ 16.460323] Testing event xfs_ail_locked: OK
[ 16.465219] Testing event xfs_ail_pinned: OK
[ 16.469339] Testing event xfs_ail_push: OK
[ 16.473274] Testing event xfs_log_force: OK
[ 16.477217] Testing event xfs_log_ungrant_sub: OK
[ 16.481265] Testing event xfs_log_ungrant_exit: OK
[ 16.487279] Testing event xfs_log_ungrant_enter: OK
[ 16.493278] Testing event xfs_log_regrant_reserve_sub: OK
[ 16.499271] Testing event xfs_log_regrant_reserve_exit: OK
[ 16.505284] Testing event xfs_log_regrant_reserve_enter: OK
[ 16.511376] Testing event xfs_log_regrant_exit: OK
[ 16.517352] Testing event xfs_log_regrant: OK
[ 16.523304] Testing event xfs_log_reserve_exit: OK
[ 16.529287] Testing event xfs_log_reserve: OK
[ 16.534217] Testing event xfs_log_grant_wake_up: OK
[ 16.540289] Testing event xfs_log_grant_wake: OK
[ 16.545244] Testing event xfs_log_grant_sleep: OK
[ 16.550221] Testing event xfs_log_umount_write: OK
[ 16.554184] Testing event xfs_log_done_perm: OK
[ 16.561293] Testing event xfs_log_done_nonperm: OK
[ 16.567303] Testing event xfs_dqflush_done: OK
[ 16.572225] Testing event xfs_dqflush_force: OK
[ 16.576260] Testing event xfs_dqflush: OK
[ 16.580268] Testing event xfs_dqrele: OK
[ 16.584223] Testing event xfs_dqput_free: OK
[ 16.588226] Testing event xfs_dqput_wait: OK
[ 16.592307] Testing event xfs_dqput: OK
[ 16.596250] Testing event xfs_dqget_dup: OK
[ 16.600214] Testing event xfs_dqget_freeing: OK
[ 16.604282] Testing event xfs_dqget_miss: OK
[ 16.608226] Testing event xfs_dqget_hit: OK
[ 16.613271] Testing event xfs_dqread_fail: OK
[ 16.618227] Testing event xfs_dqread: OK
[ 16.622307] Testing event xfs_dqtobp_read: OK
[ 16.627240] Testing event xfs_dqalloc: OK
[ 16.631334] Testing event xfs_dqattach_get: OK
[ 16.637264] Testing event xfs_dqattach_found: OK
[ 16.641270] Testing event xfs_dqreclaim_done: OK
[ 16.645289] Testing event xfs_dqreclaim_busy: OK
[ 16.657331] Testing event xfs_dqreclaim_dirty: OK
[ 16.663289] Testing event xfs_dqreclaim_want: OK
[ 16.668327] Testing event xfs_dqadjust: OK
[ 16.673227] Testing event xfs_rename: OK
[ 16.683322] Testing event xfs_symlink: OK
[ 16.688312] Testing event xfs_create: OK
[ 16.694310] Testing event xfs_lookup: OK
[ 16.699237] Testing event xfs_link: OK
[ 16.703306] Testing event xfs_remove: OK
[ 16.707311] Testing event xfs_inode_unpin_nowait: OK
[ 16.712833] Testing event xfs_inode_unpin: OK
[ 16.718306] Testing event xfs_inode_pin: OK
[ 16.723237] Testing event xfs_irele: OK
[ 16.727316] Testing event xfs_ihold: OK
[ 16.732221] Testing event xfs_iomap_prealloc_size: OK
[ 16.737288] Testing event xfs_filemap_page_mkwrite: OK
[ 16.743294] Testing event xfs_filemap_fault: OK
[ 16.749242] Testing event xfs_inode_free_eofblocks_invalid: OK
[ 16.755229] Testing event xfs_inode_clear_eofblocks_tag: OK
[ 16.760317] Testing event xfs_inode_set_eofblocks_tag: OK
[ 16.765237] Testing event xfs_dquot_dqdetach: OK
[ 16.770214] Testing event xfs_dquot_dqalloc: OK
[ 16.774200] Testing event xfs_update_time: OK
[ 16.778215] Testing event xfs_evict_inode: OK
[ 16.782196] Testing event xfs_destroy_inode: OK
[ 16.786198] Testing event xfs_file_fsync: OK
[ 16.790250] Testing event xfs_dir_fsync: OK
[ 16.794196] Testing event xfs_ioctl_setattr: OK
[ 16.798211] Testing event xfs_file_compat_ioctl: OK
[ 16.803175] Testing event xfs_file_ioctl: OK
[ 16.807196] Testing event xfs_vm_bmap: OK
[ 16.811230] Testing event xfs_get_acl: OK
[ 16.815214] Testing event xfs_readdir: OK
[ 16.819192] Testing event xfs_insert_file_space: OK
[ 16.823233] Testing event xfs_collapse_file_space: OK
[ 16.827191] Testing event xfs_zero_file_space: OK
[ 16.832228] Testing event xfs_free_file_space: OK
[ 16.836194] Testing event xfs_alloc_file_space: OK
[ 16.840207] Testing event xfs_inactive_symlink: OK
[ 16.844258] Testing event xfs_readlink: OK
[ 16.848195] Testing event xfs_setattr: OK
[ 16.852188] Testing event xfs_getattr: OK
[ 16.856224] Testing event xfs_iget_miss: OK
[ 16.860213] Testing event xfs_iget_hit: OK
[ 16.864212] Testing event xfs_iget_reclaim_fail: OK
[ 16.869193] Testing event xfs_iget_reclaim: OK
[ 16.873202] Testing event xfs_iget_skip: OK
[ 16.877236] Testing event xfs_iunlock: OK
[ 16.881193] Testing event xfs_ilock_demote: OK
[ 16.885203] Testing event xfs_ilock_nowait: OK
[ 16.889242] Testing event xfs_ilock: OK
[ 16.893193] Testing event xfs_filestream_pick: OK
[ 16.897225] Testing event xfs_filestream_scan: OK
[ 16.901214] Testing event xfs_filestream_lookup: OK
[ 16.905183] Testing event xfs_filestream_free: OK
[ 16.909204] Testing event xfs_trans_buf_ordered: OK
[ 16.914194] Testing event xfs_trans_binval: OK
[ 16.918205] Testing event xfs_trans_bhold_release: OK
[ 16.922222] Testing event xfs_trans_bhold: OK
[ 16.926193] Testing event xfs_trans_bjoin: OK
[ 16.930195] Testing event xfs_trans_brelse: OK
[ 16.934252] Testing event xfs_trans_log_buf: OK
[ 16.938190] Testing event xfs_trans_read_buf_recur: OK
[ 16.942195] Testing event xfs_trans_read_buf: OK
[ 16.946206] Testing event xfs_trans_getsb_recur: OK
[ 16.950219] Testing event xfs_trans_getsb: OK
[ 16.954195] Testing event xfs_trans_get_buf_recur: OK
[ 16.958260] Testing event xfs_trans_get_buf: OK
[ 16.968214] Testing event xfs_buf_item_push: OK
[ 16.972219] Testing event xfs_buf_item_committed: OK
[ 16.976221] Testing event xfs_buf_item_unlock_stale: OK
[ 16.981199] Testing event xfs_buf_item_unlock: OK
[ 16.985216] Testing event xfs_buf_item_unpin_stale: OK
[ 16.990203] Testing event xfs_buf_item_unpin: OK
[ 16.994201] Testing event xfs_buf_item_pin: OK
[ 16.998206] Testing event xfs_buf_item_ordered: OK
[ 17.003209] Testing event xfs_buf_item_format_stale: OK
[ 17.007193] Testing event xfs_buf_item_format_ordered: OK
[ 17.012217] Testing event xfs_buf_item_format: OK
[ 17.016206] Testing event xfs_buf_item_size_stale: OK
[ 17.021205] Testing event xfs_buf_item_size_ordered: OK
[ 17.025193] Testing event xfs_buf_item_size: OK
[ 17.029224] Testing event xfs_buf_ioerror: OK
[ 17.033204] Testing event xfs_buf_read: OK
[ 17.037210] Testing event xfs_buf_get: OK
[ 17.041228] Testing event xfs_buf_find: OK
[ 17.045203] Testing event xfs_inode_item_push: OK
[ 17.049199] Testing event xfs_reset_dqcounts: OK
[ 17.053196] Testing event xfs_da_btree_corrupt: OK
[ 17.057224] Testing event xfs_btree_corrupt: OK
[ 17.061191] Testing event xfs_trans_read_buf_shut: OK
[ 17.065225] Testing event xfs_trans_read_buf_io: OK
[ 17.070197] Testing event xfs_buf_wait_buftarg: OK
[ 17.074209] Testing event xfs_buf_error_relse: OK
[ 17.078219] Testing event xfs_buf_item_iodone_async: OK
[ 17.083199] Testing event xfs_buf_item_iodone: OK
[ 17.088238] Testing event xfs_buf_item_relse: OK
[ 17.093304] Testing event xfs_bdstrat_shut: OK
[ 17.104223] Testing event xfs_buf_get_uncached: OK
[ 17.108310] Testing event xfs_buf_delwri_split: OK
[ 17.113231] Testing event xfs_buf_delwri_queued: OK
[ 17.119307] Testing event xfs_buf_delwri_queue: OK
[ 17.124251] Testing event xfs_buf_iowait_done: OK
[ 17.129299] Testing event xfs_buf_iowait: OK
[ 17.134259] Testing event xfs_buf_unlock: OK
[ 17.139249] Testing event xfs_buf_trylock: OK
[ 17.143196] Testing event xfs_buf_lock_done: OK
[ 17.147241] Testing event xfs_buf_lock: OK
[ 17.151205] Testing event xfs_buf_bawrite: OK
[ 17.155274] Testing event xfs_buf_submit_wait: OK
[ 17.159285] Testing event xfs_buf_submit: OK
[ 17.163202] Testing event xfs_buf_iodone: OK
[ 17.167192] Testing event xfs_buf_rele: OK
[ 17.176286] Testing event xfs_buf_hold: OK
[ 17.181380] Testing event xfs_buf_free: OK
[ 17.187328] Testing event xfs_buf_init: OK
[ 17.191270] Testing event xfs_extlist: OK
[ 17.195198] Testing event xfs_bmap_post_update: OK
[ 17.199249] Testing event xfs_bmap_pre_update: OK
[ 17.203239] Testing event xfs_iext_remove: OK
[ 17.207311] Testing event xfs_iext_insert: OK
[ 17.213216] Testing event xfs_attr_list_node_descend: OK
[ 17.217237] Testing event xfs_ialloc_read_agi: OK
[ 17.221195] Testing event xfs_read_agi: OK
[ 17.225189] Testing event xfs_alloc_read_agf: OK
[ 17.229233] Testing event xfs_read_agf: OK
[ 17.233205] Testing event xfs_perag_clear_eofblocks: OK
[ 17.237192] Testing event xfs_perag_set_eofblocks: OK
[ 17.241216] Testing event xfs_perag_clear_reclaim: OK
[ 17.245202] Testing event xfs_perag_set_reclaim: OK
[ 17.249205] Testing event xfs_perag_put: OK
[ 17.253258] Testing event xfs_perag_get_tag: OK
[ 17.257189] Testing event xfs_perag_get: OK
[ 17.261206] Testing event xfs_attr_node_list: OK
[ 17.265212] Testing event xfs_attr_leaf_list: OK
[ 17.269208] Testing event xfs_attr_list_notfound: OK
[ 17.273200] Testing event xfs_attr_list_wrong_blk: OK
[ 17.277229] Testing event xfs_attr_list_add: OK
[ 17.281205] Testing event xfs_attr_list_full: OK
[ 17.285202] Testing event xfs_attr_list_leaf_end: OK
[ 17.289256] Testing event xfs_attr_list_leaf: OK
[ 17.293197] Testing event xfs_attr_list_sf_all: OK
[ 17.297194] Testing event xfs_attr_list_sf: OK
[ 17.301219] Testing event btrfs_qgroup_record_ref: OK
[ 17.305197] Testing event btrfs_qgroup_account: OK
[ 17.309223] Testing event btrfs_workqueue_destroy: OK
[ 17.313228] Testing event btrfs_workqueue_alloc: OK
[ 17.317198] Testing event btrfs_ordered_sched: OK
[ 17.321207] Testing event btrfs_all_work_done: OK
[ 17.325253] Testing event btrfs_work_sched: OK
[ 17.329210] Testing event btrfs_work_queued: OK
[ 17.333204] Testing event free_extent_state: OK
[ 17.337219] Testing event alloc_extent_state: OK
[ 17.341206] Testing event btrfs_setup_cluster: OK
[ 17.345191] Testing event btrfs_failed_cluster_setup: OK
[ 17.349244] Testing event btrfs_find_cluster: OK
[ 17.353209] Testing event btrfs_reserve_extent_cluster: OK
[ 17.358235] Testing event btrfs_reserve_extent: OK
[ 17.362199] Testing event find_free_extent: OK
[ 17.366198] Testing event btrfs_reserved_extent_free: OK
[ 17.370251] Testing event btrfs_reserved_extent_alloc: OK
[ 17.375193] Testing event btrfs_space_reservation: OK
[ 17.379255] Testing event btrfs_cow_block: OK
[ 17.383397] Testing event btrfs_chunk_free: OK
[ 17.388262] Testing event btrfs_chunk_alloc: OK
[ 17.392197] Testing event run_delayed_ref_head: OK
[ 17.396205] Testing event add_delayed_ref_head: OK
[ 17.400213] Testing event run_delayed_data_ref: OK
[ 17.404194] Testing event add_delayed_data_ref: OK
[ 17.408203] Testing event run_delayed_tree_ref: OK
[ 17.412231] Testing event add_delayed_tree_ref: OK
[ 17.416194] Testing event btrfs_sync_fs: OK
[ 17.420204] Testing event btrfs_sync_file: OK
[ 17.424255] Testing event btrfs_writepage_end_io_hook: OK
[ 17.429211] Testing event __extent_writepage: OK
[ 17.433277] Testing event btrfs_ordered_extent_put: OK
[ 17.438206] Testing event btrfs_ordered_extent_start: OK
[ 17.442244] Testing event btrfs_ordered_extent_remove: OK
[ 17.447197] Testing event btrfs_ordered_extent_add: OK
[ 17.451257] Testing event btrfs_get_extent: OK
[ 17.455195] Testing event btrfs_inode_evict: OK
[ 17.459215] Testing event btrfs_inode_request: OK
[ 17.463237] Testing event btrfs_inode_new: OK
[ 17.467194] Testing event btrfs_transaction_commit: OK
[ 17.471204] Testing event f2fs_destroy_extent_tree: OK
[ 17.475222] Testing event f2fs_shrink_extent_tree: OK
[ 17.479213] Testing event f2fs_update_extent_tree: OK
[ 17.483219] Testing event f2fs_lookup_extent_tree_end: OK
[ 17.488186] Testing event f2fs_lookup_extent_tree_start: OK
[ 17.492202] Testing event f2fs_issue_flush: OK
[ 17.496255] Testing event f2fs_issue_discard: OK
[ 17.500189] Testing event f2fs_write_checkpoint: OK
[ 17.504205] Testing event f2fs_writepages: OK
[ 17.508215] Testing event f2fs_commit_inmem_page: OK
[ 17.512186] Testing event f2fs_register_inmem_page: OK
[ 17.517304] Testing event f2fs_vm_page_mkwrite: OK
[ 17.523305] Testing event f2fs_set_page_dirty: OK
[ 17.529277] Testing event f2fs_readpage: OK
[ 17.533276] Testing event f2fs_do_write_data_page: OK
[ 17.539228] Testing event f2fs_writepage: OK
[ 17.543272] Testing event f2fs_write_end: OK
[ 17.547297] Testing event f2fs_write_begin: OK
[ 17.552226] Testing event f2fs_submit_read_bio: OK
[ 17.556335] Testing event f2fs_submit_write_bio: OK
[ 17.562320] Testing event f2fs_submit_page_mbio: OK
[ 17.568274] Testing event f2fs_submit_page_bio: OK
[ 17.573211] Testing event f2fs_reserve_new_block: OK
[ 17.577272] Testing event f2fs_direct_IO_exit: OK
[ 17.583267] Testing event f2fs_direct_IO_enter: OK
[ 17.588223] Testing event f2fs_fallocate: OK
[ 17.592294] Testing event f2fs_get_victim: OK
[ 17.598284] Testing event f2fs_get_data_block: OK
[ 17.603268] Testing event f2fs_truncate_partial_nodes: OK
[ 17.609290] Testing event f2fs_truncate_node: OK
[ 17.615241] Testing event f2fs_truncate_nodes_exit: OK
[ 17.620221] Testing event f2fs_truncate_nodes_enter: OK
[ 17.624200] Testing event f2fs_truncate_inode_blocks_exit: OK
[ 17.629219] Testing event f2fs_truncate_inode_blocks_enter: OK
[ 17.635189] Testing event f2fs_truncate_blocks_exit: OK
[ 17.639192] Testing event f2fs_truncate_blocks_enter: OK
[ 17.643208] Testing event f2fs_truncate_data_blocks_range: OK
[ 17.648179] Testing event f2fs_truncate: OK
[ 17.652207] Testing event f2fs_unlink_exit: OK
[ 17.656200] Testing event f2fs_unlink_enter: OK
[ 17.660191] Testing event f2fs_new_inode: OK
[ 17.664233] Testing event f2fs_evict_inode: OK
[ 17.668181] Testing event f2fs_iget_exit: OK
[ 17.672177] Testing event f2fs_iget: OK
[ 17.676221] Testing event f2fs_sync_fs: OK
[ 17.680187] Testing event f2fs_sync_file_exit: OK
[ 17.684189] Testing event f2fs_sync_file_enter: OK
[ 17.688205] Testing event block_rq_remap: OK
[ 17.692178] Testing event block_bio_remap: OK
[ 17.696189] Testing event block_split: OK
[ 17.700243] Testing event block_unplug: OK
[ 17.707196] Testing event block_plug: OK
[ 17.712215] Testing event block_sleeprq: OK
[ 17.716182] Testing event block_getrq: OK
[ 17.720200] Testing event block_bio_queue: OK
[ 17.724197] Testing event block_bio_frontmerge: OK
[ 17.728178] Testing event block_bio_backmerge: OK
[ 17.732219] Testing event block_bio_complete: OK
[ 17.736182] Testing event block_bio_bounce: OK
[ 17.740192] Testing event block_rq_issue: OK
[ 17.744180] Testing event block_rq_insert: OK
[ 17.748192] Testing event block_rq_complete: OK
[ 17.752182] Testing event block_rq_requeue: OK
[ 17.756193] Testing event block_rq_abort: OK
[ 17.760199] Testing event block_dirty_buffer: OK
[ 17.764178] Testing event block_touch_buffer: OK
[ 17.768224] Testing event gpio_value: OK
[ 17.772190] Testing event gpio_direction: OK
[ 17.776179] Testing event regulator_set_voltage_complete: OK
[ 17.781211] Testing event regulator_set_voltage: OK
[ 17.785188] Testing event regulator_disable_complete: OK
[ 17.789179] Testing event regulator_disable: OK
[ 17.793189] Testing event regulator_enable_complete: OK
[ 17.797177] Testing event regulator_enable_delay: OK
[ 17.801189] Testing event regulator_enable: OK
[ 17.805194] Testing event urandom_read: OK
[ 17.809182] Testing event random_read: OK
[ 17.813231] Testing event extract_entropy_user: OK
[ 17.817185] Testing event extract_entropy: OK
[ 17.821175] Testing event get_random_bytes_arch: OK
[ 17.825169] Testing event get_random_bytes: OK
[ 17.829188] Testing event xfer_secondary_pool: OK
[ 17.833178] Testing event add_disk_randomness: OK
[ 17.837195] Testing event add_input_randomness: OK
[ 17.841189] Testing event debit_entropy: OK
[ 17.845193] Testing event push_to_pool: OK
[ 17.849223] Testing event credit_entropy_bits: OK
[ 17.853192] Testing event mix_pool_bytes_nolock: OK
[ 17.857182] Testing event mix_pool_bytes: OK
[ 17.861183] Testing event add_device_randomness: OK
[ 17.865219] Testing event regcache_drop_region: OK
[ 17.869182] Testing event regmap_async_complete_done: OK
[ 17.873204] Testing event regmap_async_complete_start: OK
[ 17.877200] Testing event regmap_async_io_complete: OK
[ 17.881178] Testing event regmap_async_write_start: OK
[ 17.885227] Testing event regmap_cache_bypass: OK
[ 17.889195] Testing event regmap_cache_only: OK
[ 17.893189] Testing event regcache_sync: OK
[ 17.897177] Testing event regmap_hw_write_done: OK
[ 17.901195] Testing event regmap_hw_write_start: OK
[ 17.905176] Testing event regmap_hw_read_done: OK
[ 17.909200] Testing event regmap_hw_read_start: OK
[ 17.913206] Testing event regmap_reg_read_cache: OK
[ 17.917192] Testing event regmap_reg_read: OK
[ 17.921224] Testing event regmap_reg_write: OK
[ 17.925199] Testing event scsi_eh_wakeup: OK
[ 17.929188] Testing event scsi_dispatch_cmd_timeout: OK
[ 17.933181] Testing event scsi_dispatch_cmd_done: OK
[ 17.937199] Testing event scsi_dispatch_cmd_error: OK
[ 17.941193] Testing event scsi_dispatch_cmd_start: OK
[ 17.945208] Testing event ata_eh_link_autopsy_qc: OK
[ 17.949196] Testing event ata_eh_link_autopsy: OK
[ 17.953181] Testing event ata_qc_complete_done: OK
[ 17.957233] Testing event ata_qc_complete_failed: OK
[ 17.961194] Testing event ata_qc_complete_internal: OK
[ 17.965190] Testing event ata_qc_issue: OK
[ 17.969189] Testing event target_cmd_complete: OK
[ 17.973194] Testing event target_sequencer_start: OK
[ 17.977186] Testing event docg3_io: OK
[ 17.981203] Testing event spi_transfer_stop: OK
[ 17.985203] Testing event spi_transfer_start: OK
[ 17.989180] Testing event spi_message_done: OK
[ 17.993188] Testing event spi_message_start: OK
[ 17.997197] Testing event spi_message_submit: OK
[ 18.001181] Testing event spi_master_busy: OK
[ 18.005183] Testing event spi_master_idle: OK
[ 18.009202] Testing event smbus_result: OK
[ 18.013184] Testing event smbus_reply: OK
[ 18.017196] Testing event smbus_read: OK
[ 18.021197] Testing event smbus_write: OK
[ 18.025181] Testing event i2c_result: OK
[ 18.029187] Testing event i2c_reply: OK
[ 18.033194] Testing event i2c_read: OK
[ 18.037178] Testing event i2c_write: OK
[ 18.041180] Testing event v4l2_qbuf: OK
[ 18.045208] Testing event v4l2_dqbuf: OK
[ 18.049188] Testing event thermal_zone_trip: OK
[ 18.053202] Testing event cdev_update: OK
[ 18.057216] Testing event thermal_temperature: OK
[ 18.061189] Testing event snd_soc_jack_notify: OK
[ 18.065199] Testing event snd_soc_jack_report: OK
[ 18.069196] Testing event snd_soc_jack_irq: OK
[ 18.073187] Testing event snd_soc_dapm_connected: OK
[ 18.077184] Testing event snd_soc_dapm_input_path: OK
[ 18.081195] Testing event snd_soc_dapm_output_path: OK
[ 18.085179] Testing event snd_soc_dapm_walk_done: OK
[ 18.089203] Testing event snd_soc_dapm_widget_event_done: OK
[ 18.094193] Testing event snd_soc_dapm_widget_event_start: OK
[ 18.099235] Testing event snd_soc_dapm_widget_power: OK
[ 18.103192] Testing event snd_soc_dapm_done: OK
[ 18.107203] Testing event snd_soc_dapm_start: OK
[ 18.111209] Testing event snd_soc_bias_level_done: OK
[ 18.115186] Testing event snd_soc_bias_level_start: OK
[ 18.119197] Testing event udp_fail_queue_rcv_skb: OK
[ 18.123200] Testing event sock_exceed_buf_limit: OK
[ 18.127185] Testing event sock_rcvqueue_full: OK
[ 18.131177] Testing event napi_poll: OK
[ 18.135240] Testing event netif_rx_ni_entry: OK
[ 18.139186] Testing event netif_rx_entry: OK
[ 18.143208] Testing event netif_receive_skb_entry: OK
[ 18.148170] Testing event napi_gro_receive_entry: OK
[ 18.152209] Testing event napi_gro_frags_entry: OK
[ 18.156206] Testing event netif_rx: OK
[ 18.160186] Testing event netif_receive_skb: OK
[ 18.164211] Testing event net_dev_queue: OK
[ 18.168199] Testing event net_dev_xmit: OK
[ 18.172197] Testing event net_dev_start_xmit: OK
[ 18.176183] Testing event skb_copy_datagram_iovec: OK
[ 18.180201] Testing event consume_skb: OK
[ 18.184187] Testing event kfree_skb: OK
[ 18.188197] Running tests on trace event systems:
[ 18.188770] Testing event system skb: OK
[ 18.193244] Testing event system net: OK
[ 18.197244] Testing event system napi: OK
[ 18.201212] Testing event system sock: OK
[ 18.205212] Testing event system udp: OK
[ 18.209261] Testing event system asoc: OK
[ 18.213247] Testing event system thermal: OK
[ 18.217217] Testing event system v4l2: OK
[ 18.221209] Testing event system i2c: OK
[ 18.225247] Testing event system spi: OK
[ 18.229216] Testing event system docg3: OK
[ 18.233222] Testing event system target: OK
[ 18.237215] Testing event system libata: OK
[ 18.241208] Testing event system scsi: OK
[ 18.245260] Testing event system regmap: OK
[ 18.249239] Testing event system random: OK
[ 18.253223] Testing event system regulator: OK
[ 18.257206] Testing event system gpio: OK
[ 18.261236] Testing event system block: OK
[ 18.265224] Testing event system f2fs: OK
[ 18.269274] Testing event system btrfs: OK
[ 18.273306] Testing event system xfs: OK
[ 18.278678] Testing event system jbd2: OK
[ 18.283233] Testing event system ext4: OK
[ 18.288341] Testing event system filelock: OK
[ 18.293224] Testing event system writeback: OK
[ 18.297293] Testing event system cma: OK
[ 18.301217] Testing event system migrate: OK
[ 18.305226] Testing event system compaction: OK
[ 18.309225] Testing event system kmem: OK
[ 18.313230] Testing event system vmscan: OK
[ 18.317251] Testing event system pagemap: OK
[ 18.321233] Testing event system oom: OK
[ 18.325222] Testing event system filemap: OK
[ 18.329197] Testing event system rpm: OK
[ 18.333222] Testing event system power: OK
[ 18.337235] Testing event system test: OK
[ 18.341229] Testing event system timer: OK
[ 18.345244] Testing event system rcu: OK
[ 18.349190] Testing event system printk: OK
[ 18.353240] Testing event system lock: OK
[ 18.357298] Testing event system sched: OK
[ 18.361235] Testing event system workqueue: OK
[ 18.365205] Testing event system signal: OK
[ 18.369211] Testing event system irq: OK
[ 18.373209] Testing event system task: OK
[ 18.377222] Testing event system exceptions: OK
[ 18.381237] Testing event system tlb: OK
[ 18.385206] Testing event system mce: OK
[ 18.389244] Testing event system raw_syscalls: OK
[ 18.393235] Testing event system nmi: OK
[ 18.397241] Testing event system irq_vectors: OK
[ 18.402270] Running tests on all trace events:
[ 18.402804] Testing all events: OK
[ 18.411582] Running tests again, along with the function tracer
[ 18.412513] Running tests on trace events:
[ 18.413197] Testing event thermal_apic_exit: OK
[ 18.449899] Testing event thermal_apic_entry: OK
[ 18.498379] Testing event threshold_apic_exit: OK
[ 18.503358] Testing event threshold_apic_entry: OK
[ 18.508555] Testing event call_function_single_exit: OK
[ 18.513338] Testing event call_function_single_entry: OK
[ 18.518417] Testing event call_function_exit: OK
[ 18.523514] Testing event call_function_entry: OK
[ 18.528394] Testing event irq_work_exit: OK
[ 18.533406] Testing event irq_work_entry: OK
[ 18.538464] Testing event x86_platform_ipi_exit: OK
[ 18.543402] Testing event x86_platform_ipi_entry: OK
[ 18.548449] Testing event error_apic_exit: OK
[ 18.553569] Testing event error_apic_entry: OK
[ 18.558337] Testing event spurious_apic_exit: OK
[ 18.563356] Testing event spurious_apic_entry: OK
[ 18.568560] Testing event reschedule_exit: OK
[ 18.573404] Testing event reschedule_entry: OK
[ 18.578368] Testing event local_timer_exit: OK
[ 18.583521] Testing event local_timer_entry: OK
[ 18.588420] Testing event nmi_handler: OK
[ 18.593362] Testing event sys_exit: OK
[ 18.598573] Testing event sys_enter: OK
[ 18.603369] Testing event mce_record: OK
[ 18.608384] Testing event tlb_flush: OK
[ 18.613493] Testing event page_fault_kernel: OK
[ 18.618401] Testing event page_fault_user: OK
[ 18.623405] Testing event task_rename: OK
[ 18.628407] Testing event task_newtask: OK
[ 18.633386] Testing event softirq_raise: OK
[ 18.638363] Testing event softirq_exit: OK
[ 18.643533] Testing event softirq_entry: OK
[ 18.648349] Testing event irq_handler_exit: OK
[ 18.653387] Testing event irq_handler_entry: OK
[ 18.658526] Testing event signal_deliver: OK
[ 18.663377] Testing event signal_generate: OK
[ 18.668347] Testing event workqueue_execute_end: OK
[ 18.673414] Testing event workqueue_execute_start: OK
[ 18.678388] Testing event workqueue_activate_work: OK
[ 18.683332] Testing event workqueue_queue_work: OK
[ 18.688559] Testing event sched_wake_idle_without_ipi: OK
[ 18.693344] Testing event sched_swap_numa: OK
[ 18.698369] Testing event sched_stick_numa: OK
[ 18.703496] Testing event sched_move_numa: OK
[ 18.708339] Testing event sched_process_hang: OK
[ 18.713392] Testing event sched_pi_setprio: OK
[ 18.718471] Testing event sched_stat_runtime: OK
[ 18.723345] Testing event sched_stat_blocked: OK
[ 18.728369] Testing event sched_stat_iowait: OK
[ 18.733298] Testing event sched_stat_sleep: OK
[ 18.738348] Testing event sched_stat_wait: OK
[ 18.743331] Testing event sched_process_exec: OK
[ 18.748307] Testing event sched_process_fork: OK
[ 18.753332] Testing event sched_process_wait: OK
[ 18.758349] Testing event sched_wait_task: OK
[ 18.763438] Testing event sched_process_exit: OK
[ 18.768324] Testing event sched_process_free: OK
[ 18.773377] Testing event sched_migrate_task: OK
[ 18.778528] Testing event sched_switch: OK
[ 18.783398] Testing event sched_wakeup_new: OK
[ 18.788385] Testing event sched_wakeup: OK
[ 18.793446] Testing event sched_kthread_stop_ret: OK
[ 18.798343] Testing event sched_kthread_stop: OK
[ 18.803370] Testing event lock_release: OK
[ 18.808544] Testing event lock_acquire: OK
[ 18.813418] Testing event console: OK
[ 18.818348] Testing event rcu_utilization: OK
[ 18.823489] Testing event itimer_expire: OK
[ 18.828327] Testing event itimer_state: OK
[ 18.833368] Testing event hrtimer_cancel: OK
[ 18.838410] Testing event hrtimer_expire_exit: OK
[ 18.843371] Testing event hrtimer_expire_entry: OK
[ 18.848336] Testing event hrtimer_start: OK
[ 18.853474] Testing event hrtimer_init: OK
[ 18.858341] Testing event timer_cancel: OK
[ 18.863346] Testing event timer_expire_exit: OK
[ 18.868460] Testing event timer_expire_entry: OK
[ 18.886734] Testing event timer_start: OK
[ 18.891493] Testing event timer_init: OK
[ 18.897564] Testing event ftrace_test_filter: OK
[ 18.903533] Testing event dev_pm_qos_remove_request: OK
[ 18.908526] Testing event dev_pm_qos_update_request: OK
[ 18.913652] Testing event dev_pm_qos_add_request: OK
[ 18.919621] Testing event pm_qos_update_flags: OK
[ 18.924505] Testing event pm_qos_update_target: OK
[ 18.936644] Testing event pm_qos_update_request_timeout: OK
[ 18.941463] Testing event pm_qos_remove_request: OK
[ 18.946788] Testing event pm_qos_update_request: OK
[ 18.952354] Testing event pm_qos_add_request: OK
[ 18.957335] Testing event power_domain_target: OK
[ 18.962338] Testing event clock_set_rate: OK
[ 18.967337] Testing event clock_disable: OK
[ 18.972458] Testing event clock_enable: OK
[ 18.978529] Testing event wakeup_source_deactivate: OK
[ 18.988352] Testing event wakeup_source_activate: OK
[ 18.993322] Testing event suspend_resume: OK
[ 18.998376] Testing event device_pm_callback_end: OK
[ 19.003429] Testing event device_pm_callback_start: OK
[ 19.008328] Testing event cpu_frequency: OK
[ 19.018431] Testing event pstate_sample: OK
[ 19.023331] Testing event cpu_idle: OK
[ 19.028373] Testing event rpm_return_int: OK
[ 19.033321] Testing event rpm_idle: OK
[ 19.038318] Testing event rpm_resume: OK
[ 19.043431] Testing event rpm_suspend: OK
[ 19.052541] Testing event mm_filemap_add_to_page_cache: OK
[ 19.057334] Testing event mm_filemap_delete_from_page_cache: OK
[ 19.062321] Testing event oom_score_adj_update: OK
[ 19.067366] Testing event mm_lru_activate: OK
[ 19.076411] Testing event mm_lru_insertion: OK
[ 19.081339] Testing event mm_vmscan_lru_shrink_inactive: OK
[ 19.086331] Testing event mm_vmscan_writepage: OK
[ 19.091440] Testing event mm_vmscan_memcg_isolate: OK
[ 19.101332] Testing event mm_vmscan_lru_isolate: OK
[ 19.106328] Testing event mm_shrink_slab_end: OK
[ 19.133430] Testing event mm_shrink_slab_start: OK
[ 19.153495] Testing event mm_vmscan_memcg_softlimit_reclaim_end: OK
[ 19.159475] Testing event mm_vmscan_memcg_reclaim_end: OK
[ 19.165497] Testing event mm_vmscan_direct_reclaim_end: OK
[ 19.171517] Testing event mm_vmscan_memcg_softlimit_reclaim_begin: OK
[ 19.203422] Testing event mm_vmscan_memcg_reclaim_begin: OK
[ 19.211709] Testing event mm_vmscan_direct_reclaim_begin: OK
[ 19.224735] Testing event mm_vmscan_wakeup_kswapd: OK
[ 19.245422] Testing event mm_vmscan_kswapd_wake: OK
[ 19.250311] Testing event mm_vmscan_kswapd_sleep: OK
[ 19.255395] Testing event mm_page_alloc_extfrag: OK
[ 19.260345] Testing event mm_page_pcpu_drain: OK
[ 19.265352] Testing event mm_page_alloc_zone_locked: OK
[ 19.270365] Testing event mm_page_alloc: OK
[ 19.279415] Testing event mm_page_free_batched: OK
[ 19.284326] Testing event mm_page_free: OK
[ 19.289328] Testing event kmem_cache_free: OK
[ 19.294511] Testing event kfree: OK
[ 19.299323] Testing event kmem_cache_alloc_node: OK
[ 19.304332] Testing event kmalloc_node: OK
[ 19.310283] Testing event kmem_cache_alloc: OK
[ 19.315438] Testing event kmalloc: OK
[ 19.324519] Testing event mm_compaction_suitable: OK
[ 19.329331] Testing event mm_compaction_finished: OK
[ 19.334353] Testing event mm_compaction_try_to_compact_pages: OK
[ 19.344336] Testing event mm_compaction_end: OK
[ 19.349339] Testing event mm_compaction_begin: OK
[ 19.354336] Testing event mm_compaction_migratepages: OK
[ 19.359452] Testing event mm_compaction_isolate_freepages: OK
[ 19.364352] Testing event mm_compaction_isolate_migratepages: OK
[ 19.379362] Testing event mm_numa_migrate_ratelimit: OK
[ 19.384323] Testing event mm_migrate_pages: OK
[ 19.389366] Testing event cma_release: OK
[ 19.394342] Testing event cma_alloc: OK
[ 19.399343] Testing event writeback_dirty_inode_enqueue: OK
[ 19.404435] Testing event writeback_lazytime_iput: OK
[ 19.409329] Testing event writeback_lazytime: OK
[ 19.414339] Testing event writeback_single_inode: OK
[ 19.423526] Testing event writeback_single_inode_start: OK
[ 19.428331] Testing event writeback_wait_iff_congested: OK
[ 19.469490] Testing event writeback_congestion_wait: OK
[ 19.491529] Testing event writeback_sb_inodes_requeue: OK
[ 19.497449] Testing event balance_dirty_pages: OK
[ 19.503523] Testing event bdi_dirty_ratelimit: OK
[ 19.509558] Testing event global_dirty_state: OK
[ 19.522631] Testing event writeback_queue_io: OK
[ 19.528518] Testing event wbc_writepage: OK
[ 19.533561] Testing event writeback_bdi_unregister: OK
[ 19.538835] Testing event writeback_bdi_register: OK
[ 19.544876] Testing event writeback_wake_background: OK
[ 19.549529] Testing event writeback_nowork: OK
[ 19.554542] Testing event writeback_pages_written: OK
[ 19.559673] Testing event writeback_wait: OK
[ 19.564545] Testing event writeback_written: OK
[ 19.569680] Testing event writeback_start: OK
[ 19.574664] Testing event writeback_exec: OK
[ 19.579519] Testing event writeback_queue: OK
[ 19.584544] Testing event writeback_write_inode: OK
[ 19.589695] Testing event writeback_write_inode_start: OK
[ 19.595648] Testing event writeback_dirty_inode: OK
[ 19.600534] Testing event writeback_dirty_inode_start: OK
[ 19.605652] Testing event writeback_mark_inode_dirty: OK
[ 19.611667] Testing event writeback_dirty_page: OK
[ 19.616648] Testing event time_out_leases: OK
[ 19.621505] Testing event generic_delete_lease: OK
[ 19.626528] Testing event generic_add_lease: OK
[ 19.631612] Testing event break_lease_unblock: OK
[ 19.636535] Testing event break_lease_block: OK
[ 19.641488] Testing event break_lease_noblock: OK
[ 19.646653] Testing event ext4_es_shrink: OK
[ 19.651492] Testing event ext4_collapse_range: OK
[ 19.656536] Testing event ext4_es_shrink_scan_exit: OK
[ 19.661636] Testing event ext4_es_shrink_scan_enter: OK
[ 19.666631] Testing event ext4_es_shrink_count: OK
[ 19.678648] Testing event ext4_es_lookup_extent_exit: OK
[ 19.683654] Testing event ext4_es_lookup_extent_enter: OK
[ 19.688676] Testing event ext4_es_find_delayed_extent_range_exit: OK
[ 19.694687] Testing event ext4_es_find_delayed_extent_range_enter: OK
[ 19.701748] Testing event ext4_es_remove_extent: OK
[ 19.766351] Testing event ext4_es_cache_extent: OK
[ 19.820395] Testing event ext4_es_insert_extent: OK
[ 19.843448] Testing event ext4_ext_remove_space_done: OK
[ 19.848345] Testing event ext4_ext_remove_space: OK
[ 19.853412] Testing event ext4_ext_rm_idx: OK
[ 19.858394] Testing event ext4_ext_rm_leaf: OK
[ 19.863451] Testing event ext4_remove_blocks: OK
[ 19.868340] Testing event ext4_ext_show_extent: OK
[ 19.873386] Testing event ext4_get_reserved_cluster_alloc: OK
[ 19.887348] Testing event ext4_find_delalloc_range: OK
[ 19.892381] Testing event ext4_ext_in_cache: OK
[ 19.897410] Testing event ext4_ext_put_in_cache: OK
[ 19.902326] Testing event ext4_get_implied_cluster_alloc_exit: OK
[ 19.907335] Testing event ext4_ext_handle_unwritten_extents: OK
[ 19.912349] Testing event ext4_trim_all_free: OK
[ 19.922341] Testing event ext4_trim_extent: OK
[ 19.927401] Testing event ext4_journal_start_reserved: OK
[ 19.932329] Testing event ext4_journal_start: OK
[ 19.937353] Testing event ext4_load_inode: OK
[ 19.942492] Testing event ext4_ext_load_extent: OK
[ 19.952392] Testing event ext4_ind_map_blocks_exit: OK
[ 19.957445] Testing event ext4_ext_map_blocks_exit: OK
[ 19.962400] Testing event ext4_ind_map_blocks_enter: OK
[ 19.985624] Testing event ext4_ext_map_blocks_enter: OK
[ 19.992721] Testing event ext4_ext_convert_to_initialized_fastpath: OK
[ 19.998595] Testing event ext4_ext_convert_to_initialized_enter: OK
[ 20.004574] Testing event ext4_truncate_exit: OK
[ 20.009381] Testing event ext4_truncate_enter: OK
[ 20.015568] Testing event ext4_unlink_exit: OK
[ 20.020480] Testing event ext4_unlink_enter: OK
[ 20.025767] Testing event ext4_fallocate_exit: OK
[ 20.031905] Testing event ext4_zero_range: OK
[ 20.037604] Testing event ext4_punch_hole: OK
[ 20.042456] Testing event ext4_fallocate_enter: OK
[ 20.048570] Testing event ext4_direct_IO_exit: OK
[ 20.054595] Testing event ext4_direct_IO_enter: OK
[ 20.060638] Testing event ext4_load_inode_bitmap: OK
[ 20.067695] Testing event ext4_read_block_bitmap_load: OK
[ 20.074445] Testing event ext4_mb_buddy_bitmap_load: OK
[ 20.079587] Testing event ext4_mb_bitmap_load: OK
[ 20.084438] Testing event ext4_da_release_space: OK
[ 20.089473] Testing event ext4_da_reserve_space: OK
[ 20.094563] Testing event ext4_da_update_reserve_space: OK
[ 20.099374] Testing event ext4_forget: OK
[ 20.104383] Testing event ext4_mballoc_free: OK
[ 20.112399] Testing event ext4_mballoc_discard: OK
[ 20.117657] Testing event ext4_mballoc_prealloc: OK
[ 20.122609] Testing event ext4_mballoc_alloc: OK
[ 20.133790] Testing event ext4_alloc_da_blocks: OK
[ 20.139641] Testing event ext4_sync_fs: OK
[ 20.144435] Testing event ext4_sync_file_exit: OK
[ 20.149492] Testing event ext4_sync_file_enter: OK
[ 20.154618] Testing event ext4_free_blocks: OK
[ 20.159465] Testing event ext4_allocate_blocks: OK
[ 20.170793] Testing event ext4_request_blocks: OK
[ 20.175464] Testing event ext4_mb_discard_preallocations: OK
[ 20.182787] Testing event ext4_discard_preallocations: OK
[ 20.188802] Testing event ext4_mb_release_group_pa: OK
[ 20.194706] Testing event ext4_mb_release_inode_pa: OK
[ 20.209386] Testing event ext4_mb_new_group_pa: OK
[ 20.214408] Testing event ext4_mb_new_inode_pa: OK
[ 20.219480] Testing event ext4_discard_blocks: OK
[ 20.233417] Testing event ext4_journalled_invalidatepage: OK
[ 20.239424] Testing event ext4_invalidatepage: OK
[ 20.244623] Testing event ext4_releasepage: OK
[ 20.249730] Testing event ext4_readpage: OK
[ 20.255653] Testing event ext4_writepage: OK
[ 20.267651] Testing event ext4_writepages_result: OK
[ 20.272716] Testing event ext4_da_write_pages_extent: OK
[ 20.278696] Testing event ext4_da_write_pages: OK
[ 20.284581] Testing event ext4_writepages: OK
[ 20.306526] Testing event ext4_da_write_end: OK
[ 20.312492] Testing event ext4_journalled_write_end: OK
[ 20.319691] Testing event ext4_write_end: OK
[ 20.325649] Testing event ext4_da_write_begin: OK
[ 20.344450] Testing event ext4_write_begin: OK
[ 20.349454] Testing event ext4_begin_ordered_truncate: OK
[ 20.355616] Testing event ext4_mark_inode_dirty: OK
[ 20.368779] Testing event ext4_drop_inode: OK
[ 20.380812] Testing event ext4_evict_inode: OK
[ 20.386820] Testing event ext4_allocate_inode: OK
[ 20.393498] Testing event ext4_request_inode: OK
[ 20.399552] Testing event ext4_free_inode: OK
[ 20.427370] Testing event ext4_other_inode_update_time: OK
[ 20.432402] Testing event jbd2_lock_buffer_stall: OK
[ 20.437380] Testing event jbd2_write_superblock: OK
[ 20.442444] Testing event jbd2_update_log_tail: OK
[ 20.447546] Testing event jbd2_checkpoint_stats: OK
[ 20.452405] Testing event jbd2_run_stats: OK
[ 20.457353] Testing event jbd2_handle_stats: OK
[ 20.462378] Testing event jbd2_handle_extend: OK
[ 20.467452] Testing event jbd2_handle_start: OK
[ 20.481334] Testing event jbd2_submit_inode_data: OK
[ 20.486342] Testing event jbd2_end_commit: OK
[ 20.491490] Testing event jbd2_drop_transaction: OK
[ 20.496355] Testing event jbd2_commit_logging: OK
[ 20.506582] Testing event jbd2_commit_flushing: OK
[ 20.511500] Testing event jbd2_commit_locking: OK
[ 20.516322] Testing event jbd2_start_commit: OK
[ 20.521355] Testing event jbd2_checkpoint: OK
[ 20.526513] Testing event xfs_discard_busy: OK
[ 20.531366] Testing event xfs_discard_exclude: OK
[ 20.540392] Testing event xfs_discard_toosmall: OK
[ 20.545396] Testing event xfs_discard_extent: OK
[ 20.550336] Testing event xfs_log_recover_inode_skip: OK
[ 20.555363] Testing event xfs_log_recover_inode_cancel: OK
[ 20.564445] Testing event xfs_log_recover_inode_recover: OK
[ 20.569411] Testing event xfs_log_recover_buf_dquot_buf: OK
[ 20.574341] Testing event xfs_log_recover_buf_reg_buf: OK
[ 20.584446] Testing event xfs_log_recover_buf_inode_buf: OK
[ 20.589333] Testing event xfs_log_recover_buf_recover: OK
[ 20.594482] Testing event xfs_log_recover_buf_cancel_ref_inc: OK
[ 20.604381] Testing event xfs_log_recover_buf_cancel_add: OK
[ 20.609344] Testing event xfs_log_recover_buf_cancel: OK
[ 20.614419] Testing event xfs_log_recover_buf_not_cancel: OK
[ 20.619315] Testing event xfs_log_recover_item_recover: OK
[ 20.628360] Testing event xfs_log_recover_item_reorder_tail: OK
[ 20.633440] Testing event xfs_log_recover_item_reorder_head: OK
[ 20.638322] Testing event xfs_log_recover_item_add_cont: OK
[ 20.648433] Testing event xfs_log_recover_item_add: OK
[ 20.653409] Testing event xfs_swap_extent_after: OK
[ 20.658429] Testing event xfs_swap_extent_before: OK
[ 20.663326] Testing event xfs_dir2_leafn_moveents: OK
[ 20.672377] Testing event xfs_dir2_shrink_inode: OK
[ 20.677365] Testing event xfs_dir2_grow_inode: OK
[ 20.682407] Testing event xfs_dir2_leafn_remove: OK
[ 20.687318] Testing event xfs_dir2_leafn_add: OK
[ 20.695392] Testing event xfs_da_path_shift: OK
[ 20.700427] Testing event xfs_da_fixhashpath: OK
[ 20.705367] Testing event xfs_da_shrink_inode: OK
[ 20.720778] Testing event xfs_da_grow_inode: OK
[ 20.726554] Testing event xfs_da_swap_lastblock: OK
[ 20.732554] Testing event xfs_da_node_toosmall: OK
[ 20.753575] Testing event xfs_da_node_unbalance: OK
[ 20.759508] Testing event xfs_da_node_rebalance: OK
[ 20.764645] Testing event xfs_da_node_remove: OK
[ 20.770724] Testing event xfs_da_node_split: OK
[ 20.777485] Testing event xfs_da_node_create: OK
[ 20.782420] Testing event xfs_da_node_add: OK
[ 20.787363] Testing event xfs_da_root_join: OK
[ 20.792338] Testing event xfs_da_root_split: OK
[ 20.797370] Testing event xfs_da_unlink_forward: OK
[ 20.802356] Testing event xfs_da_unlink_back: OK
[ 20.807437] Testing event xfs_da_link_after: OK
[ 20.812413] Testing event xfs_da_link_before: OK
[ 20.817341] Testing event xfs_da_join: OK
[ 20.822361] Testing event xfs_da_split: OK
[ 20.827412] Testing event xfs_attr_rmtval_remove: OK
[ 20.832365] Testing event xfs_attr_rmtval_set: OK
[ 20.841385] Testing event xfs_attr_rmtval_get: OK
[ 20.846352] Testing event xfs_attr_refillstate: OK
[ 20.851436] Testing event xfs_attr_fillstate: OK
[ 20.856332] Testing event xfs_attr_node_removename: OK
[ 20.865398] Testing event xfs_attr_node_replace: OK
[ 20.870412] Testing event xfs_attr_node_lookup: OK
[ 20.875340] Testing event xfs_attr_node_get: OK
[ 20.880349] Testing event xfs_attr_node_addname: OK
[ 20.889412] Testing event xfs_attr_leaf_toosmall: OK
[ 20.894411] Testing event xfs_attr_leaf_unbalance: OK
[ 20.899344] Testing event xfs_attr_leaf_rebalance: OK
[ 20.904409] Testing event xfs_attr_leaf_to_node: OK
[ 20.909324] Testing event xfs_attr_leaf_to_sf: OK
[ 20.915371] Testing event xfs_attr_leaf_flipflags: OK
[ 20.920413] Testing event xfs_attr_leaf_setflag: OK
[ 20.929443] Testing event xfs_attr_leaf_clearflag: OK
[ 20.934449] Testing event xfs_attr_leaf_split_after: OK
[ 20.939334] Testing event xfs_attr_leaf_split_before: OK
[ 20.948461] Testing event xfs_attr_leaf_split: OK
[ 20.953398] Testing event xfs_attr_leaf_removename: OK
[ 20.958323] Testing event xfs_attr_leaf_remove: OK
[ 20.963371] Testing event xfs_attr_leaf_replace: OK
[ 20.972434] Testing event xfs_attr_leaf_lookup: OK
[ 20.977430] Testing event xfs_attr_leaf_get: OK
[ 20.982349] Testing event xfs_attr_leaf_compact: OK
[ 20.987348] Testing event xfs_attr_leaf_create: OK
[ 20.992422] Testing event xfs_attr_leaf_addname: OK
[ 21.001370] Testing event xfs_attr_leaf_add_work: OK
[ 21.006441] Testing event xfs_attr_leaf_add_new: OK
[ 21.011326] Testing event xfs_attr_leaf_add_old: OK
[ 21.016329] Testing event xfs_attr_leaf_add: OK
[ 21.025357] Testing event xfs_attr_sf_to_leaf: OK
[ 21.030323] Testing event xfs_attr_sf_removename: OK
[ 21.035404] Testing event xfs_attr_sf_remove: OK
[ 21.040325] Testing event xfs_attr_sf_lookup: OK
[ 21.045326] Testing event xfs_attr_sf_create: OK
[ 21.054367] Testing event xfs_attr_sf_addname: OK
[ 21.068646] Testing event xfs_attr_sf_add: OK
[ 21.073491] Testing event xfs_dir2_node_to_leaf: OK
[ 21.079539] Testing event xfs_dir2_node_removename: OK
[ 21.085595] Testing event xfs_dir2_node_replace: OK
[ 21.090595] Testing event xfs_dir2_node_lookup: OK
[ 21.096661] Testing event xfs_dir2_node_addname: OK
[ 21.102567] Testing event xfs_dir2_leaf_to_node: OK
[ 21.115821] Testing event xfs_dir2_leaf_to_block: OK
[ 21.120507] Testing event xfs_dir2_leaf_removename: OK
[ 21.126541] Testing event xfs_dir2_leaf_replace: OK
[ 21.131635] Testing event xfs_dir2_leaf_lookup: OK
[ 21.136531] Testing event xfs_dir2_leaf_addname: OK
[ 21.142543] Testing event xfs_dir2_block_to_leaf: OK
[ 21.147618] Testing event xfs_dir2_block_to_sf: OK
[ 21.152630] Testing event xfs_dir2_block_removename: OK
[ 21.158677] Testing event xfs_dir2_block_replace: OK
[ 21.164535] Testing event xfs_dir2_block_lookup: OK
[ 21.170507] Testing event xfs_dir2_block_addname: OK
[ 21.176520] Testing event xfs_dir2_sf_to_block: OK
[ 21.181534] Testing event xfs_dir2_sf_toino8: OK
[ 21.186326] Testing event xfs_dir2_sf_toino4: OK
[ 21.191360] Testing event xfs_dir2_sf_removename: OK
[ 21.196444] Testing event xfs_dir2_sf_replace: OK
[ 21.201324] Testing event xfs_dir2_sf_lookup: OK
[ 21.206378] Testing event xfs_dir2_sf_create: OK
[ 21.211384] Testing event xfs_dir2_sf_addname: OK
[ 21.216374] Testing event xfs_alloc_vextent_allfailed: OK
[ 21.221398] Testing event xfs_alloc_vextent_loopfailed: OK
[ 21.226359] Testing event xfs_alloc_vextent_noagbp: OK
[ 21.231385] Testing event xfs_alloc_vextent_nofix: OK
[ 21.236365] Testing event xfs_alloc_vextent_badargs: OK
[ 21.241406] Testing event xfs_alloc_small_error: OK
[ 21.246382] Testing event xfs_alloc_small_done: OK
[ 21.251341] Testing event xfs_alloc_small_notenough: OK
[ 21.256549] Testing event xfs_alloc_small_freelist: OK
[ 21.261374] Testing event xfs_alloc_size_busy: OK
[ 21.266342] Testing event xfs_alloc_size_error: OK
[ 21.271437] Testing event xfs_alloc_size_done: OK
[ 21.285551] Testing event xfs_alloc_size_nominleft: OK
[ 21.291578] Testing event xfs_alloc_size_noentry: OK
[ 21.297493] Testing event xfs_alloc_size_neither: OK
[ 21.303503] Testing event xfs_alloc_near_busy: OK
[ 21.309519] Testing event xfs_alloc_near_noentry: OK
[ 21.325679] Testing event xfs_alloc_near_error: OK
[ 21.334516] Testing event xfs_alloc_near_lesser: OK
[ 21.339620] Testing event xfs_alloc_near_greater: OK
[ 21.347492] Testing event xfs_alloc_near_first: OK
[ 21.352597] Testing event xfs_alloc_near_nominleft: OK
[ 21.357514] Testing event xfs_alloc_exact_error: OK
[ 21.363522] Testing event xfs_alloc_exact_notfound: OK
[ 21.369523] Testing event xfs_alloc_exact_done: OK
[ 21.381783] Testing event xfs_free_extent: OK
[ 21.387638] Testing event xfs_agf: OK
[ 21.392666] Testing event xfs_trans_commit_lsn: OK
[ 21.397524] Testing event xfs_extent_busy_trim: OK
[ 21.402660] Testing event xfs_extent_busy_clear: OK
[ 21.407522] Testing event xfs_extent_busy_reuse: OK
[ 21.415477] Testing event xfs_extent_busy_force: OK
[ 21.420348] Testing event xfs_extent_busy_enomem: OK
[ 21.430369] Testing event xfs_extent_busy: OK
[ 21.435341] Testing event xfs_bunmap: OK
[ 21.449520] Testing event xfs_pagecache_inval: OK
[ 21.454611] Testing event xfs_itruncate_extents_end: OK
[ 21.459491] Testing event xfs_itruncate_extents_start: OK
[ 21.465503] Testing event xfs_setfilesize: OK
[ 21.470588] Testing event xfs_get_blocks_notfound: OK
[ 21.475620] Testing event xfs_unwritten_convert: OK
[ 21.481653] Testing event xfs_delalloc_enospc: OK
[ 21.487505] Testing event xfs_gbmap_direct_endio: OK
[ 21.492611] Testing event xfs_gbmap_direct_none: OK
[ 21.500699] Testing event xfs_gbmap_direct_update: OK
[ 21.506734] Testing event xfs_gbmap_direct_new: OK
[ 21.512629] Testing event xfs_gbmap_direct: OK
[ 21.517625] Testing event xfs_get_blocks_alloc: OK
[ 21.529866] Testing event xfs_get_blocks_found: OK
[ 21.534528] Testing event xfs_map_blocks_alloc: OK
[ 21.539766] Testing event xfs_map_blocks_found: OK
[ 21.544493] Testing event xfs_invalidatepage: OK
[ 21.550527] Testing event xfs_releasepage: OK
[ 21.555638] Testing event xfs_writepage: OK
[ 21.560539] Testing event xfs_file_splice_read: OK
[ 21.572829] Testing event xfs_file_direct_write: OK
[ 21.577514] Testing event xfs_file_buffered_write: OK
[ 21.583588] Testing event xfs_file_read: OK
[ 21.589550] Testing event xfs_log_assign_tail_lsn: OK
[ 21.595556] Testing event xfs_ail_delete: OK
[ 21.601550] Testing event xfs_ail_move: OK
[ 21.607487] Testing event xfs_ail_insert: OK
[ 21.675283] Testing event xfs_ail_flushing: OK
[ 21.681525] Testing event xfs_ail_locked: OK
[ 21.686717] Testing event xfs_ail_pinned: OK
[ 21.691517] Testing event xfs_ail_push: OK
[ 21.697597] Testing event xfs_log_force: OK
[ 21.702583] Testing event xfs_log_ungrant_sub: OK
[ 21.708686] Testing event xfs_log_ungrant_exit: OK
[ 21.713476] Testing event xfs_log_ungrant_enter: OK
[ 21.719566] Testing event xfs_log_regrant_reserve_sub: OK
[ 21.726512] Testing event xfs_log_regrant_reserve_exit: OK
[ 21.742586] Testing event xfs_log_regrant_reserve_enter: OK
[ 21.752467] Testing event xfs_log_regrant_exit: OK
[ 21.757305] Testing event xfs_log_regrant: OK
[ 21.768815] Testing event xfs_log_reserve_exit: OK
[ 21.773516] Testing event xfs_log_reserve: OK
[ 21.781504] Testing event xfs_log_grant_wake_up: OK
[ 21.787544] Testing event xfs_log_grant_wake: OK
[ 21.792666] Testing event xfs_log_grant_sleep: OK
[ 21.802533] Testing event xfs_log_umount_write: OK
[ 21.807361] Testing event xfs_log_done_perm: OK
[ 21.812494] Testing event xfs_log_done_nonperm: OK
[ 21.817473] Testing event xfs_dqflush_done: OK
[ 21.822436] Testing event xfs_dqflush_force: OK
[ 21.827342] Testing event xfs_dqflush: OK
[ 21.832372] Testing event xfs_dqrele: OK
[ 21.837424] Testing event xfs_dqput_free: OK
[ 21.842465] Testing event xfs_dqput_wait: OK
[ 21.847436] Testing event xfs_dqput: OK
[ 21.852366] Testing event xfs_dqget_dup: OK
[ 21.857376] Testing event xfs_dqget_freeing: OK
[ 21.862398] Testing event xfs_dqget_miss: OK
[ 21.867363] Testing event xfs_dqget_hit: OK
[ 21.875371] Testing event xfs_dqread_fail: OK
[ 21.880337] Testing event xfs_dqread: OK
[ 21.885390] Testing event xfs_dqtobp_read: OK
[ 21.890331] Testing event xfs_dqalloc: OK
[ 21.895328] Testing event xfs_dqattach_get: OK
[ 21.900487] Testing event xfs_dqattach_found: OK
[ 21.909431] Testing event xfs_dqreclaim_done: OK
[ 21.914427] Testing event xfs_dqreclaim_busy: OK
[ 21.919330] Testing event xfs_dqreclaim_dirty: OK
[ 21.928361] Testing event xfs_dqreclaim_want: OK
[ 21.933331] Testing event xfs_dqadjust: OK
[ 21.938430] Testing event xfs_rename: OK
[ 21.943342] Testing event xfs_symlink: OK
[ 21.948327] Testing event xfs_create: OK
[ 21.953537] Testing event xfs_lookup: OK
[ 21.958356] Testing event xfs_link: OK
[ 21.967379] Testing event xfs_remove: OK
[ 21.972346] Testing event xfs_inode_unpin_nowait: OK
[ 21.977395] Testing event xfs_inode_unpin: OK
[ 21.982359] Testing event xfs_inode_pin: OK
[ 21.987349] Testing event xfs_irele: OK
[ 21.992597] Testing event xfs_ihold: OK
[ 21.997321] Testing event xfs_iomap_prealloc_size: OK
[ 22.006367] Testing event xfs_filemap_page_mkwrite: OK
[ 22.011388] Testing event xfs_filemap_fault: OK
[ 22.023742] Testing event xfs_inode_free_eofblocks_invalid: OK
[ 22.029488] Testing event xfs_inode_clear_eofblocks_tag: OK
[ 22.034605] Testing event xfs_inode_set_eofblocks_tag: OK
[ 22.040531] Testing event xfs_dquot_dqdetach: OK
[ 22.045786] Testing event xfs_dquot_dqalloc: OK
[ 22.051636] Testing event xfs_update_time: OK
[ 22.056610] Testing event xfs_evict_inode: OK
[ 22.061550] Testing event xfs_destroy_inode: OK
[ 22.066658] Testing event xfs_file_fsync: OK
[ 22.071505] Testing event xfs_dir_fsync: OK
[ 22.076619] Testing event xfs_ioctl_setattr: OK
[ 22.081480] Testing event xfs_file_compat_ioctl: OK
[ 22.086640] Testing event xfs_file_ioctl: OK
[ 22.091489] Testing event xfs_vm_bmap: OK
[ 22.096632] Testing event xfs_get_acl: OK
[ 22.101492] Testing event xfs_readdir: OK
[ 22.106660] Testing event xfs_insert_file_space: OK
[ 22.112532] Testing event xfs_collapse_file_space: OK
[ 22.117639] Testing event xfs_zero_file_space: OK
[ 22.123647] Testing event xfs_free_file_space: OK
[ 22.129697] Testing event xfs_alloc_file_space: OK
[ 22.135556] Testing event xfs_inactive_symlink: OK
[ 22.140657] Testing event xfs_readlink: OK
[ 22.145554] Testing event xfs_setattr: OK
[ 22.150647] Testing event xfs_getattr: OK
[ 22.155545] Testing event xfs_iget_miss: OK
[ 22.160628] Testing event xfs_iget_hit: OK
[ 22.165518] Testing event xfs_iget_reclaim_fail: OK
[ 22.171517] Testing event xfs_iget_reclaim: OK
[ 22.176649] Testing event xfs_iget_skip: OK
[ 22.181672] Testing event xfs_iunlock: OK
[ 22.186637] Testing event xfs_ilock_demote: OK
[ 22.193224] Testing event xfs_ilock_nowait: OK
[ 22.199661] Testing event xfs_ilock: OK
[ 22.204638] Testing event xfs_filestream_pick: OK
[ 22.209589] Testing event xfs_filestream_scan: OK
[ 22.215650] Testing event xfs_filestream_lookup: OK
[ 22.221537] Testing event xfs_filestream_free: OK
[ 22.226652] Testing event xfs_trans_buf_ordered: OK
[ 22.231530] Testing event xfs_trans_binval: OK
[ 22.236642] Testing event xfs_trans_bhold_release: OK
[ 22.241555] Testing event xfs_trans_bhold: OK
[ 22.246656] Testing event xfs_trans_bjoin: OK
[ 22.251540] Testing event xfs_trans_brelse: OK
[ 22.256627] Testing event xfs_trans_log_buf: OK
[ 22.261543] Testing event xfs_trans_read_buf_recur: OK
[ 22.267481] Testing event xfs_trans_read_buf: OK
[ 22.272638] Testing event xfs_trans_getsb_recur: OK
[ 22.277641] Testing event xfs_trans_getsb: OK
[ 22.283653] Testing event xfs_trans_get_buf_recur: OK
[ 22.288616] Testing event xfs_trans_get_buf: OK
[ 22.293549] Testing event xfs_buf_item_push: OK
[ 22.305629] Testing event xfs_buf_item_committed: OK
[ 22.310619] Testing event xfs_buf_item_unlock_stale: OK
[ 22.316640] Testing event xfs_buf_item_unlock: OK
[ 22.321624] Testing event xfs_buf_item_unpin_stale: OK
[ 22.327526] Testing event xfs_buf_item_unpin: OK
[ 22.332568] Testing event xfs_buf_item_pin: OK
[ 22.338705] Testing event xfs_buf_item_ordered: OK
[ 22.351770] Testing event xfs_buf_item_format_stale: OK
[ 22.357553] Testing event xfs_buf_item_format_ordered: OK
[ 22.362635] Testing event xfs_buf_item_format: OK
[ 22.367553] Testing event xfs_buf_item_size_stale: OK
[ 22.373576] Testing event xfs_buf_item_size_ordered: OK
[ 22.380117] Testing event xfs_buf_item_size: OK
[ 22.385819] Testing event xfs_buf_ioerror: OK
[ 22.397845] Testing event xfs_buf_read: OK
[ 22.407846] Testing event xfs_buf_get: OK
[ 22.413687] Testing event xfs_buf_find: OK
[ 22.419700] Testing event xfs_inode_item_push: OK
[ 22.424644] Testing event xfs_reset_dqcounts: OK
[ 22.430512] Testing event xfs_da_btree_corrupt: OK
[ 22.436523] Testing event xfs_btree_corrupt: OK
[ 22.496414] Testing event xfs_trans_read_buf_shut: OK
[ 22.514504] Testing event xfs_trans_read_buf_io: OK
[ 22.520525] Testing event xfs_buf_wait_buftarg: OK
[ 22.526446] Testing event xfs_buf_error_relse: OK
[ 22.532536] Testing event xfs_buf_item_iodone_async: OK
[ 22.538561] Testing event xfs_buf_item_iodone: OK
[ 22.544551] Testing event xfs_buf_item_relse: OK
[ 22.549651] Testing event xfs_bdstrat_shut: OK
[ 22.554573] Testing event xfs_buf_get_uncached: OK
[ 22.567514] Testing event xfs_buf_delwri_split: OK
[ 22.573540] Testing event xfs_buf_delwri_queued: OK
[ 22.579560] Testing event xfs_buf_delwri_queue: OK
[ 22.584757] Testing event xfs_buf_iowait_done: OK
[ 22.590628] Testing event xfs_buf_iowait: OK
[ 22.596500] Testing event xfs_buf_unlock: OK
[ 22.602694] Testing event xfs_buf_trylock: OK
[ 22.615837] Testing event xfs_buf_lock_done: OK
[ 22.636480] Testing event xfs_buf_lock: OK
[ 22.641319] Testing event xfs_buf_bawrite: OK
[ 22.646354] Testing event xfs_buf_submit_wait: OK
[ 22.651395] Testing event xfs_buf_submit: OK
[ 22.656377] Testing event xfs_buf_iodone: OK
[ 22.661357] Testing event xfs_buf_rele: OK
[ 22.666535] Testing event xfs_buf_hold: OK
[ 22.671374] Testing event xfs_buf_free: OK
[ 22.676351] Testing event xfs_buf_init: OK
[ 22.681467] Testing event xfs_extlist: OK
[ 22.686336] Testing event xfs_bmap_post_update: OK
[ 22.695363] Testing event xfs_bmap_pre_update: OK
[ 22.700342] Testing event xfs_iext_remove: OK
[ 22.705363] Testing event xfs_iext_insert: OK
[ 22.710326] Testing event xfs_attr_list_node_descend: OK
[ 22.719355] Testing event xfs_ialloc_read_agi: OK
[ 22.724335] Testing event xfs_read_agi: OK
[ 22.729423] Testing event xfs_alloc_read_agf: OK
[ 22.734346] Testing event xfs_read_agf: OK
[ 22.739330] Testing event xfs_perag_clear_eofblocks: OK
[ 22.744495] Testing event xfs_perag_set_eofblocks: OK
[ 22.753447] Testing event xfs_perag_clear_reclaim: OK
[ 22.758398] Testing event xfs_perag_set_reclaim: OK
[ 22.763324] Testing event xfs_perag_put: OK
[ 22.768332] Testing event xfs_perag_get_tag: OK
[ 22.773408] Testing event xfs_perag_get: OK
[ 22.782470] Testing event xfs_attr_node_list: OK
[ 22.787386] Testing event xfs_attr_leaf_list: OK
[ 22.792325] Testing event xfs_attr_list_notfound: OK
[ 22.797315] Testing event xfs_attr_list_wrong_blk: OK
[ 22.802349] Testing event xfs_attr_list_add: OK
[ 22.811462] Testing event xfs_attr_list_full: OK
[ 22.816394] Testing event xfs_attr_list_leaf_end: OK
[ 22.821325] Testing event xfs_attr_list_leaf: OK
[ 22.827567] Testing event xfs_attr_list_sf_all: OK
[ 22.832494] Testing event xfs_attr_list_sf: OK
[ 22.837610] Testing event btrfs_qgroup_record_ref: OK
[ 22.842676] Testing event btrfs_qgroup_account: OK
[ 22.847643] Testing event btrfs_workqueue_destroy: OK
[ 22.852677] Testing event btrfs_workqueue_alloc: OK
[ 22.857636] Testing event btrfs_ordered_sched: OK
[ 22.863560] Testing event btrfs_all_work_done: OK
[ 22.874784] Testing event btrfs_work_sched: OK
[ 22.880563] Testing event btrfs_work_queued: OK
[ 22.886520] Testing event free_extent_state: OK
[ 22.891613] Testing event alloc_extent_state: OK
[ 22.896626] Testing event btrfs_setup_cluster: OK
[ 22.901725] Testing event btrfs_failed_cluster_setup: OK
[ 22.907565] Testing event btrfs_find_cluster: OK
[ 22.918769] Testing event btrfs_reserve_extent_cluster: OK
[ 22.928790] Testing event btrfs_reserve_extent: OK
[ 22.933509] Testing event find_free_extent: OK
[ 22.940525] Testing event btrfs_reserved_extent_free: OK
[ 22.946459] Testing event btrfs_reserved_extent_alloc: OK
[ 22.952516] Testing event btrfs_space_reservation: OK
[ 22.957636] Testing event btrfs_cow_block: OK
[ 22.966858] Testing event btrfs_chunk_free: OK
[ 22.975981] Testing event btrfs_chunk_alloc: OK
[ 22.991224] Testing event run_delayed_ref_head: OK
[ 22.999392] Testing event add_delayed_ref_head: OK
[ 23.006744] Testing event run_delayed_data_ref: OK
[ 23.019910] Testing event add_delayed_data_ref: OK
[ 23.060790] Testing event run_delayed_tree_ref: OK
[ 23.078529] Testing event add_delayed_tree_ref: OK
[ 23.083594] Testing event btrfs_sync_fs: OK
[ 23.088508] Testing event btrfs_sync_file: OK
[ 23.093687] Testing event btrfs_writepage_end_io_hook: OK
[ 23.099638] Testing event __extent_writepage: OK
[ 23.115376] Testing event btrfs_ordered_extent_put: OK
[ 23.120425] Testing event btrfs_ordered_extent_start: OK
[ 23.125341] Testing event btrfs_ordered_extent_remove: OK
[ 23.130453] Testing event btrfs_ordered_extent_add: OK
[ 23.135308] Testing event btrfs_get_extent: OK
[ 23.140365] Testing event btrfs_inode_evict: OK
[ 23.145404] Testing event btrfs_inode_request: OK
[ 23.150468] Testing event btrfs_inode_new: OK
[ 23.155437] Testing event btrfs_transaction_commit: OK
[ 23.160334] Testing event f2fs_destroy_extent_tree: OK
[ 23.170430] Testing event f2fs_shrink_extent_tree: OK
[ 23.175316] Testing event f2fs_update_extent_tree: OK
[ 23.180329] Testing event f2fs_lookup_extent_tree_end: OK
[ 23.185384] Testing event f2fs_lookup_extent_tree_start: OK
[ 23.195393] Testing event f2fs_issue_flush: OK
[ 23.200383] Testing event f2fs_issue_discard: OK
[ 23.205335] Testing event f2fs_write_checkpoint: OK
[ 23.210422] Testing event f2fs_writepages: OK
[ 23.215288] Testing event f2fs_commit_inmem_page: OK
[ 23.220364] Testing event f2fs_register_inmem_page: OK
[ 23.225400] Testing event f2fs_vm_page_mkwrite: OK
[ 23.230335] Testing event f2fs_set_page_dirty: OK
[ 23.240390] Testing event f2fs_readpage: OK
[ 23.245435] Testing event f2fs_do_write_data_page: OK
[ 23.250424] Testing event f2fs_writepage: OK
[ 23.255332] Testing event f2fs_write_end: OK
[ 23.260363] Testing event f2fs_write_begin: OK
[ 23.265407] Testing event f2fs_submit_read_bio: OK
[ 23.270320] Testing event f2fs_submit_write_bio: OK
[ 23.279372] Testing event f2fs_submit_page_mbio: OK
[ 23.284339] Testing event f2fs_submit_page_bio: OK
[ 23.289398] Testing event f2fs_reserve_new_block: OK
[ 23.294324] Testing event f2fs_direct_IO_exit: OK
[ 23.300513] Testing event f2fs_direct_IO_enter: OK
[ 23.339495] Testing event f2fs_fallocate: OK
[ 23.359555] Testing event f2fs_get_victim: OK
[ 23.365507] Testing event f2fs_get_data_block: OK
[ 23.370551] Testing event f2fs_truncate_partial_nodes: OK
[ 23.376658] Testing event f2fs_truncate_node: OK
[ 23.381619] Testing event f2fs_truncate_nodes_exit: OK
[ 23.387635] Testing event f2fs_truncate_nodes_enter: OK
[ 23.393674] Testing event f2fs_truncate_inode_blocks_exit: OK
[ 23.399660] Testing event f2fs_truncate_inode_blocks_enter: OK
[ 23.405715] Testing event f2fs_truncate_blocks_exit: OK
[ 23.411648] Testing event f2fs_truncate_blocks_enter: OK
[ 23.416643] Testing event f2fs_truncate_data_blocks_range: OK
[ 23.422604] Testing event f2fs_truncate: OK
[ 23.427537] Testing event f2fs_unlink_exit: OK
[ 23.438775] Testing event f2fs_unlink_enter: OK
[ 23.443521] Testing event f2fs_new_inode: OK
[ 23.448478] Testing event f2fs_evict_inode: OK
[ 23.453647] Testing event f2fs_iget_exit: OK
[ 23.458483] Testing event f2fs_iget: OK
[ 23.463520] Testing event f2fs_sync_fs: OK
[ 23.469559] Testing event f2fs_sync_file_exit: OK
[ 23.482746] Testing event f2fs_sync_file_enter: OK
[ 23.491819] Testing event block_rq_remap: OK
[ 23.497827] Testing event block_bio_remap: OK
[ 23.503760] Testing event block_split: OK
[ 23.508524] Testing event block_unplug: OK
[ 23.513531] Testing event block_plug: OK
[ 23.518705] Testing event block_sleeprq: OK
[ 23.523505] Testing event block_getrq: OK
[ 23.528523] Testing event block_bio_queue: OK
[ 23.533628] Testing event block_bio_frontmerge: OK
[ 23.538524] Testing event block_bio_backmerge: OK
[ 23.543524] Testing event block_bio_complete: OK
[ 23.548641] Testing event block_bio_bounce: OK
[ 23.553506] Testing event block_rq_issue: OK
[ 23.558546] Testing event block_rq_insert: OK
[ 23.563659] Testing event block_rq_complete: OK
[ 23.568527] Testing event block_rq_requeue: OK
[ 23.573530] Testing event block_rq_abort: OK
[ 23.579628] Testing event block_dirty_buffer: OK
[ 23.584654] Testing event block_touch_buffer: OK
[ 23.589492] Testing event gpio_value: OK
[ 23.594650] Testing event gpio_direction: OK
[ 23.599604] Testing event regulator_set_voltage_complete: OK
[ 23.605646] Testing event regulator_set_voltage: OK
[ 23.610521] Testing event regulator_disable_complete: OK
[ 23.616605] Testing event regulator_disable: OK
[ 23.646566] Testing event regulator_enable_complete: OK
[ 23.652393] Testing event regulator_enable_delay: OK
[ 23.665805] Testing event regulator_enable: OK
[ 23.678366] Testing event urandom_read: OK
[ 23.683362] Testing event random_read: OK
[ 23.688484] Testing event extract_entropy_user: OK
[ 23.693328] Testing event extract_entropy: OK
[ 23.703358] Testing event get_random_bytes_arch: OK
[ 23.708522] Testing event get_random_bytes: OK
[ 23.713327] Testing event xfer_secondary_pool: OK
[ 23.725428] Testing event add_disk_randomness: OK
[ 23.730341] Testing event add_input_randomness: OK
[ 23.735350] Testing event debit_entropy: OK
[ 23.740315] Testing event push_to_pool: OK
[ 23.746588] Testing event credit_entropy_bits: OK
[ 23.760689] Testing event mix_pool_bytes_nolock: OK
[ 23.765596] Testing event mix_pool_bytes: OK
[ 23.770697] Testing event add_device_randomness: OK
[ 23.775559] Testing event regcache_drop_region: OK
[ 23.780815] Testing event regmap_async_complete_done: OK
[ 23.785473] Testing event regmap_async_complete_start: OK
[ 23.790662] Testing event regmap_async_io_complete: OK
[ 23.795592] Testing event regmap_async_write_start: OK
[ 23.801681] Testing event regmap_cache_bypass: OK
[ 23.806358] Testing event regmap_cache_only: OK
[ 23.811335] Testing event regcache_sync: OK
[ 23.816358] Testing event regmap_hw_write_done: OK
[ 23.821319] Testing event regmap_hw_write_start: OK
[ 23.826510] Testing event regmap_hw_read_done: OK
[ 23.831348] Testing event regmap_hw_read_start: OK
[ 23.836341] Testing event regmap_reg_read_cache: OK
[ 23.841361] Testing event regmap_reg_read: OK
[ 23.846365] Testing event regmap_reg_write: OK
[ 23.851366] Testing event scsi_eh_wakeup: OK
[ 23.860431] Testing event scsi_dispatch_cmd_timeout: OK
[ 23.865328] Testing event scsi_dispatch_cmd_done: OK
[ 23.870338] Testing event scsi_dispatch_cmd_error: OK
[ 23.884645] Testing event scsi_dispatch_cmd_start: OK
[ 23.889593] Testing event ata_eh_link_autopsy_qc: OK
[ 23.895707] Testing event ata_eh_link_autopsy: OK
[ 23.900498] Testing event ata_qc_complete_done: OK
[ 23.905543] Testing event ata_qc_complete_failed: OK
[ 23.910646] Testing event ata_qc_complete_internal: OK
[ 23.924548] Testing event ata_qc_issue: OK
[ 23.930697] Testing event target_cmd_complete: OK
[ 23.936557] Testing event target_sequencer_start: OK
[ 23.941803] Testing event docg3_io: OK
[ 23.946627] Testing event spi_transfer_stop: OK
[ 23.952513] Testing event spi_transfer_start: OK
[ 23.958522] Testing event spi_message_done: OK
[ 23.964493] Testing event spi_message_start: OK
[ 23.970529] Testing event spi_message_submit: OK
[ 23.975534] Testing event spi_master_busy: OK
[ 23.980747] Testing event spi_master_idle: OK
[ 23.985499] Testing event smbus_result: OK
[ 23.991543] Testing event smbus_reply: OK
[ 24.052370] Testing event smbus_read: OK
[ 24.072335] Testing event smbus_write: OK
[ 24.082364] Testing event i2c_result: OK
[ 24.099327] Testing event i2c_reply: OK
[ 24.104380] Testing event i2c_read: OK
[ 24.126317] Testing event i2c_write: OK
[ 24.131297] Testing event v4l2_qbuf: OK
[ 24.152418] Testing event v4l2_dqbuf: OK
[ 24.161174] Testing event thermal_zone_trip: OK
[ 24.167201] Testing event cdev_update: OK
[ 24.173157] Testing event thermal_temperature: OK
[ 24.188873] Testing event snd_soc_jack_notify: OK
[ 24.194368] Testing event snd_soc_jack_report: OK
[ 24.212364] Testing event snd_soc_jack_irq: OK
[ 24.218148] Testing event snd_soc_dapm_connected: OK
[ 24.236954] Testing event snd_soc_dapm_input_path: OK
[ 24.249119] Testing event snd_soc_dapm_output_path: OK
[ 24.261399] Testing event snd_soc_dapm_walk_done: OK
[ 24.278151] Testing event snd_soc_dapm_widget_event_done: OK
[ 24.301373] Testing event snd_soc_dapm_widget_event_start: OK
[ 24.322583] Testing event snd_soc_dapm_widget_power: OK
[ 24.337316] Testing event snd_soc_dapm_done: OK
[ 24.349331] Testing event snd_soc_dapm_start: OK
[ 24.378521] Testing event snd_soc_bias_level_done: OK
[ 24.394000] Testing event snd_soc_bias_level_start: OK
[ 24.414571] Testing event udp_fail_queue_rcv_skb: OK
[ 24.428302] Testing event sock_exceed_buf_limit: OK
[ 24.449230] Testing event sock_rcvqueue_full: OK
[ 24.470975] Testing event napi_poll: OK
[ 24.483145] Testing event netif_rx_ni_entry: OK
[ 24.500526] Testing event netif_rx_entry: OK
[ 24.507374] Testing event netif_receive_skb_entry: OK
[ 24.521970] Testing event napi_gro_receive_entry: OK
[ 24.535094] Testing event napi_gro_frags_entry: OK
[ 24.552408] Testing event netif_rx: OK
[ 24.563408] Testing event netif_receive_skb: OK
[ 24.583771] Testing event net_dev_queue: OK
[ 24.597190] Testing event net_dev_xmit: OK
[ 24.615130] Testing event net_dev_start_xmit: OK
[ 24.631210] Testing event skb_copy_datagram_iovec: OK
[ 24.653110] Testing event consume_skb: OK
[ 24.664971] Testing event kfree_skb: OK
[ 24.671517] Running tests on trace event systems:
[ 24.673514] Testing event system skb: OK
[ 24.700547] Testing event system net: OK
[ 24.730691] Testing event system napi: OK
[ 24.741511] Testing event system sock: OK
[ 24.758157] Testing event system udp: OK
[ 24.773375] Testing event system asoc: OK
[ 24.785355] Testing event system thermal: OK
[ 24.797554] Testing event system v4l2: OK
[ 24.810969] Testing event system i2c: OK
[ 24.818843] Testing event system spi: OK
[ 24.829838] Testing event system docg3: OK
[ 24.838465] Testing event system target: OK
[ 24.844372] Testing event system libata: OK
[ 24.850246] Testing event system scsi: OK
[ 24.861541] Testing event system regmap: OK
[ 24.868417] Testing event system random: OK
[ 24.877945] Testing event system regulator: OK
[ 24.892527] Testing event system gpio: OK
[ 24.901339] Testing event system block: OK
[ 24.920966] Testing event system f2fs: OK
[ 24.946993] Testing event system btrfs: OK
[ 24.964832] Testing event system xfs: OK
[ 24.995586] Testing event system jbd2: OK
[ 25.024429] Testing event system ext4: OK
[ 25.073327] Testing event system filelock: OK
[ 25.109762] Testing event system writeback: OK
[ 25.138815] Testing event system cma: OK
[ 25.169780] Testing event system migrate: OK
[ 25.200856] Testing event system compaction: OK
[ 25.219816] Testing event system kmem: OK
[ 25.225704] Testing event system vmscan: OK
[ 25.244066] Testing event system pagemap: OK
[ 25.283010] Testing event system oom: OK
[ 25.295261] Testing event system filemap: OK
[ 25.315417] Testing event system rpm: OK
[ 25.325305] Testing event system power: OK
[ 25.339126] Testing event system test: OK
[ 25.352428] Testing event system timer: OK
[ 25.365466] Testing event system rcu: OK
[ 25.389272] Testing event system printk: OK
[ 25.419187] Testing event system lock: OK
[ 25.439769] Testing event system sched: OK
[ 25.455717] Testing event system workqueue: OK
[ 25.463819] Testing event system signal: OK
[ 25.471409] Testing event system irq: OK
[ 25.484387] Testing event system task: OK
[ 25.490353] Testing event system exceptions: OK
[ 25.497511] Testing event system tlb: OK
[ 25.504383] Testing event system mce: OK
[ 25.518639] Testing event system raw_syscalls: OK
[ 25.524695] Testing event system nmi: OK
[ 25.531869] Testing event system irq_vectors: OK
[ 25.540404] Running tests on all trace events:
[ 25.541158] Testing all events: OK
[ 25.640283] Testing ftrace filter: OK
[ 25.662611] Btrfs loaded, debug=on, integrity-checker=on
[ 25.664426] Key type trusted registered
[ 25.666343] Key type encrypted registered
[ 25.670359] BIOS EDD facility v0.16 2004-Jun-25, 0 devices found
[ 25.671242] EDD information not available.
[ 25.672183] Unregister pv shared memory for cpu 0
[ 25.986014] ------------[ cut here ]------------
[ 25.986014] WARNING: CPU: 0 PID: 11 at kernel/sched/core.c:1188 do_set_cpus_allowed+0x8e/0xf0()
[ 25.986014] CPU: 0 PID: 11 Comm: migration/0 Not tainted 4.1.0-rc6-00115-g2ea0fdf #1
[ 25.986014] 00000000 00000000 50a4bd48 41a09dc0 00000000 50a4bd7c 4105710c 41ce1bec
[ 25.986014] 00000000 0000000b 41ce30cc 000004a4 4108324e 000004a4 4108324e 4af38190
[ 25.986014] 00000002 4af382d8 50a4bd8c 41057200 00000009 00000000 50a4bda4 4108324e
[ 25.986014] Call Trace:
[ 25.986014] [<41a09dc0>] dump_stack+0x48/0x60
[ 25.986014] [<4105710c>] warn_slowpath_common+0x8c/0xc0
[ 25.986014] [<4108324e>] ? do_set_cpus_allowed+0x8e/0xf0
[ 25.986014] [<4108324e>] ? do_set_cpus_allowed+0x8e/0xf0
[ 25.986014] [<41057200>] warn_slowpath_null+0x20/0x30
[ 25.986014] [<4108324e>] do_set_cpus_allowed+0x8e/0xf0
[ 25.986014] [<4108359b>] select_fallback_rq+0x2eb/0x300
[ 25.986014] [<41084d1c>] migration_call+0xec/0x290
[ 25.986014] [<41562ece>] ? __delay+0xe/0x10
[ 25.986014] [<41079c89>] notifier_call_chain+0x59/0x70
[ 25.986014] [<4107a19e>] __raw_notifier_call_chain+0x1e/0x30
[ 25.986014] [<41057256>] cpu_notify+0x26/0x50
[ 25.986014] [<41a01462>] take_cpu_down+0x22/0x40
[ 25.986014] [<410f152d>] multi_cpu_stop+0xcd/0x140
[ 25.986014] [<410f1460>] ? cpu_stop_park+0x60/0x60
[ 25.986014] [<410f17d5>] cpu_stopper_thread+0x85/0x120
[ 25.986014] [<410a3fec>] ? trace_hardirqs_on_caller+0x13c/0x1e0
[ 25.986014] [<410a409b>] ? trace_hardirqs_on+0xb/0x10
[ 25.986014] [<410aa65e>] ? do_raw_spin_lock+0xe/0x1c0
[ 25.986014] [<410a3fec>] ? trace_hardirqs_on_caller+0x13c/0x1e0
[ 25.986014] [<410a409b>] ? trace_hardirqs_on+0xb/0x10
[ 25.986014] [<4107c5f4>] smpboot_thread_fn+0x144/0x250
[ 25.986014] [<4107c4b0>] ? sort_range+0x30/0x30
[ 25.986014] [<410789aa>] kthread+0xba/0xd0
[ 25.986014] [<41080000>] ? ftrace_raw_output_sched_wake_idle_without_ipi+0x20/0x70
[ 25.986014] [<41a13461>] ret_from_kernel_thread+0x21/0x30
[ 25.986014] [<410788f0>] ? insert_kthread_work+0x90/0x90
[ 25.986014] ---[ end trace 39f17a9725435b83 ]---
[ 26.079472] CPU 0 is now offline
[ 26.080312] PM: Hibernation image not present or could not be loaded