early console in setup code Probing EDD (edd=off to disable)... ok [ 0.000000] Linux version 3.17.0-rc2-00062-gb52938b (kbuild@lkp-hsx01) (gcc version 4.8.2 (Debian 4.8.2-18) ) #8 SMP Thu Aug 28 19:35:47 CST 2014 [ 0.000000] Command line: hung_task_panic=1 earlyprintk=ttyS0,115200 debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 console=ttyS0,115200 console=tty0 vga=normal root=/dev/ram0 rw link=/kbuild-tests/run-queue/kvm/x86_64-randconfig-s1-08281038/linux-devel:devel-hourly-2014082810:b52938be99a099b452979ed805b480337ee2df0f:bisect-linux-8/.vmlinuz-b52938be99a099b452979ed805b480337ee2df0f-20140828193620-58-kbuild branch=linux-devel/devel-hourly-2014082810 BOOT_IMAGE=/kernel/x86_64-randconfig-s1-08281038/b52938be99a099b452979ed805b480337ee2df0f/vmlinuz-3.17.0-rc2-00062-gb52938b drbd.minor_count=8 [ 0.000000] e820: BIOS-provided physical RAM map: [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x0000000013ffdfff] usable [ 0.000000] BIOS-e820: [mem 0x0000000013ffe000-0x0000000013ffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved [ 0.000000] NX (Execute Disable) protection: active [ 0.000000] SMBIOS 2.4 present. [ 0.000000] DMI: Bochs Bochs, BIOS Bochs 01/01/2011 [ 0.000000] Hypervisor detected: KVM [ 0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved [ 0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable [ 0.000000] e820: last_pfn = 0x13ffe max_arch_pfn = 0x400000000 [ 0.000000] MTRR default type: write-back [ 0.000000] MTRR fixed ranges enabled: [ 0.000000] 00000-9FFFF write-back [ 0.000000] A0000-BFFFF uncachable [ 0.000000] C0000-FFFFF write-protect [ 0.000000] MTRR variable ranges enabled: [ 0.000000] 0 base 0080000000 mask FF80000000 uncachable [ 0.000000] 1 disabled [ 0.000000] 2 disabled [ 0.000000] 3 disabled [ 0.000000] 4 disabled [ 0.000000] 5 disabled [ 0.000000] 6 disabled [ 0.000000] 7 disabled [ 0.000000] x86 PAT enabled: cpu 0, old 0x70406, new 0x7010600070106 [ 0.000000] Base memory trampoline at [ffff880000099000] 99000 size 24576 [ 0.000000] init_memory_mapping: [mem 0x00000000-0x000fffff] [ 0.000000] [mem 0x00000000-0x000fffff] page 4k [ 0.000000] BRK [0x04dc6000, 0x04dc6fff] PGTABLE [ 0.000000] BRK [0x04dc7000, 0x04dc7fff] PGTABLE [ 0.000000] BRK [0x04dc8000, 0x04dc8fff] PGTABLE [ 0.000000] init_memory_mapping: [mem 0x12600000-0x127fffff] [ 0.000000] [mem 0x12600000-0x127fffff] page 4k [ 0.000000] BRK [0x04dc9000, 0x04dc9fff] PGTABLE [ 0.000000] init_memory_mapping: [mem 0x10000000-0x125fffff] [ 0.000000] [mem 0x10000000-0x125fffff] page 4k [ 0.000000] BRK [0x04dca000, 0x04dcafff] PGTABLE [ 0.000000] BRK [0x04dcb000, 0x04dcbfff] PGTABLE [ 0.000000] init_memory_mapping: [mem 0x00100000-0x0fffffff] [ 0.000000] [mem 0x00100000-0x0fffffff] page 4k [ 0.000000] init_memory_mapping: [mem 0x12800000-0x13ffdfff] [ 0.000000] [mem 0x12800000-0x13ffdfff] page 4k [ 0.000000] RAMDISK: [mem 0x1293d000-0x13feffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000FD950 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x0000000013FFE450 000034 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x0000000013FFFF80 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x0000000013FFE490 0011A9 (v01 BXPC BXDSDT 00000001 INTL 20100528) [ 0.000000] ACPI: FACS 0x0000000013FFFF40 000040 [ 0.000000] ACPI: SSDT 0x0000000013FFF7A0 000796 (v01 BOCHS BXPCSSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: APIC 0x0000000013FFF680 000080 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x0000000013FFF640 000038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001) [ 0.000000] ACPI: Local APIC address 0xfee00000 [ 0.000000] mapped APIC to ffffffffff5fc000 ( fee00000) [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000013ffdfff] [ 0.000000] Initmem setup node 0 [mem 0x00000000-0x13ffdfff] [ 0.000000] NODE_DATA [mem 0x13ff9000-0x13ffdfff] [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000000] kvm-clock: cpu 0, msr 0:13ff8001, primary cpu clock [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x00001000-0x00ffffff] [ 0.000000] DMA32 [mem 0x01000000-0xffffffff] [ 0.000000] Normal empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x00001000-0x0009efff] [ 0.000000] node 0: [mem 0x00100000-0x13ffdfff] [ 0.000000] On node 0 totalpages: 81820 [ 0.000000] DMA zone: 64 pages used for memmap [ 0.000000] DMA zone: 21 pages reserved [ 0.000000] DMA zone: 3998 pages, LIFO batch:0 [ 0.000000] DMA32 zone: 1216 pages used for memmap [ 0.000000] DMA32 zone: 77822 pages, LIFO batch:15 [ 0.000000] ACPI: PM-Timer IO Port: 0xb008 [ 0.000000] ACPI: Local APIC address 0xfee00000 [ 0.000000] mapped APIC to ffffffffff5fc000 ( fee00000) [ 0.000000] ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled) [ 0.000000] ACPI: LAPIC (acpi_id[0x01] lapic_id[0x01] enabled) [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] ACPI: IOAPIC (id[0x00] address[0xfec00000] gsi_base[0]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 00, APIC ID 0, APIC INT 02 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 05, APIC ID 0, APIC INT 05 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 09, APIC ID 0, APIC INT 09 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 0a, APIC ID 0, APIC INT 0a [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 0b, APIC ID 0, APIC INT 0b [ 0.000000] ACPI: IRQ0 used by override. [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 01, APIC ID 0, APIC INT 01 [ 0.000000] 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 ffffffffff5fb000 (fec00000) [ 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 0x14000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] setup_percpu: NR_CPUS:8 nr_cpumask_bits:8 nr_cpu_ids:2 nr_node_ids:1 [ 0.000000] PERCPU: Embedded 474 pages/cpu @ffff880012200000 s1918912 r0 d22592 u2097152 [ 0.000000] pcpu-alloc: s1918912 r0 d22592 u2097152 alloc=1*2097152 [ 0.000000] pcpu-alloc: [0] 0 [0] 1 [ 0.000000] KVM setup async PF for cpu 0 [ 0.000000] kvm-stealtime: cpu 0, msr 1220ce00 [ 0.000000] Built 1 zonelists in Node order, mobility grouping on. Total pages: 80519 [ 0.000000] Policy zone: DMA32 [ 0.000000] Kernel command line: hung_task_panic=1 earlyprintk=ttyS0,115200 debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 console=ttyS0,115200 console=tty0 vga=normal root=/dev/ram0 rw link=/kbuild-tests/run-queue/kvm/x86_64-randconfig-s1-08281038/linux-devel:devel-hourly-2014082810:b52938be99a099b452979ed805b480337ee2df0f:bisect-linux-8/.vmlinuz-b52938be99a099b452979ed805b480337ee2df0f-20140828193620-58-kbuild branch=linux-devel/devel-hourly-2014082810 BOOT_IMAGE=/kernel/x86_64-randconfig-s1-08281038/b52938be99a099b452979ed805b480337ee2df0f/vmlinuz-3.17.0-rc2-00062-gb52938b drbd.minor_count=8 [ 0.000000] sysrq: sysrq always enabled. [ 0.000000] PID hash table entries: 2048 (order: 2, 16384 bytes) [ 0.000000] xsave: enabled xstate_bv 0x7, cntxt size 0x340 using standard form [ 0.000000] Memory: 230008K/327280K available (20532K kernel code, 7361K rwdata, 9716K rodata, 3632K init, 19440K bss, 97272K reserved) [ 0.000000] Hierarchical RCU implementation. [ 0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 [ 0.000000] NR_IRQS:4352 nr_irqs:440 0 [ 0.000000] console [ttyS0] enabled [ 0.000000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar [ 0.000000] ... MAX_LOCKDEP_SUBCLASSES: 8 [ 0.000000] ... MAX_LOCK_DEPTH: 48 [ 0.000000] ... MAX_LOCKDEP_KEYS: 8191 [ 0.000000] ... CLASSHASH_SIZE: 4096 [ 0.000000] ... MAX_LOCKDEP_ENTRIES: 32768 [ 0.000000] ... MAX_LOCKDEP_CHAINS: 65536 [ 0.000000] ... CHAINHASH_SIZE: 32768 [ 0.000000] memory used by lock dependency info: 8639 kB [ 0.000000] per task-struct memory footprint: 2688 bytes [ 0.000000] ------------------------ [ 0.000000] | Locking API testsuite: [ 0.000000] ---------------------------------------------------------------------------- [ 0.000000] | spin |wlock |rlock |mutex | wsem | rsem | [ 0.000000] -------------------------------------------------------------------------- [ 0.000000] A-A deadlock:failed|failed| ok |failed|failed|failed| [ 0.000000] A-B-B-A deadlock:failed|failed| ok |failed|failed|failed| [ 0.000000] A-B-B-C-C-A deadlock:failed|failed| ok |failed|failed|failed| [ 0.000000] A-B-C-A-B-C deadlock:failed|failed| ok |failed|failed|failed| [ 0.000000] A-B-B-C-C-D-D-A deadlock:failed|failed| ok |failed|failed|failed| [ 0.000000] A-B-C-D-B-D-D-A deadlock:failed|failed| ok |failed|failed|failed| [ 0.000000] A-B-C-D-B-C-D-A deadlock:failed|failed| ok |failed|failed|failed| [ 0.000000] double unlock: ok | ok | ok | ok | ok | ok | [ 0.000000] initialize held: ok | ok | ok | ok | ok | ok | [ 0.000000] bad unlock order: ok | ok | ok | ok | ok | ok | [ 0.000000] -------------------------------------------------------------------------- [ 0.000000] recursive read-lock: | ok | |failed| [ 0.000000] recursive read-lock #2: | ok | |failed| [ 0.000000] mixed read-write-lock: |failed| |failed| [ 0.000000] mixed write-read-lock: |failed| |failed| [ 0.000000] -------------------------------------------------------------------------- [ 0.000000] hard-irqs-on + irq-safe-A/12:failed|failed| ok | [ 0.000000] soft-irqs-on + irq-safe-A/12:failed|failed| ok | [ 0.000000] hard-irqs-on + irq-safe-A/21:failed|failed| ok | [ 0.000000] soft-irqs-on + irq-safe-A/21:failed|failed| ok | [ 0.000000] sirq-safe-A => hirqs-on/12:failed|failed| ok | [ 0.000000] sirq-safe-A => hirqs-on/21:failed|failed| ok | [ 0.000000] hard-safe-A + irqs-on/12:failed|failed| ok | [ 0.000000] soft-safe-A + irqs-on/12:failed|failed| ok | [ 0.000000] hard-safe-A + irqs-on/21:failed|failed| ok | [ 0.000000] soft-safe-A + irqs-on/21:failed|failed| ok | [ 0.000000] hard-safe-A + unsafe-B #1/123:failed|failed| ok | [ 0.000000] soft-safe-A + unsafe-B #1/123:failed|failed| ok | [ 0.000000] hard-safe-A + unsafe-B #1/132:failed|failed| ok | [ 0.000000] soft-safe-A + unsafe-B #1/132:failed|failed| ok | [ 0.000000] hard-safe-A + unsafe-B #1/213:failed|failed| ok | [ 0.000000] soft-safe-A + unsafe-B #1/213:failed|failed| ok | [ 0.000000] hard-safe-A + unsafe-B #1/231:failed|failed| ok | [ 0.000000] soft-safe-A + unsafe-B #1/231:failed|failed| ok | [ 0.000000] hard-safe-A + unsafe-B #1/312:failed|failed| ok | [ 0.000000] soft-safe-A + unsafe-B #1/312:failed|failed| ok | [ 0.000000] hard-safe-A + unsafe-B #1/321:failed|failed| ok | [ 0.000000] soft-safe-A + unsafe-B #1/321:failed|failed| ok | [ 0.000000] hard-safe-A + unsafe-B #2/123:failed|failed| ok | [ 0.000000] soft-safe-A + unsafe-B #2/123:failed|failed| ok | [ 0.000000] hard-safe-A + unsafe-B #2/132:failed|failed| ok | [ 0.000000] soft-safe-A + unsafe-B #2/132:failed|failed| ok | [ 0.000000] hard-safe-A + unsafe-B #2/213:failed|failed| ok | [ 0.000000] soft-safe-A + unsafe-B #2/213:failed|failed| ok | [ 0.000000] hard-safe-A + unsafe-B #2/231:failed|failed| ok | [ 0.000000] soft-safe-A + unsafe-B #2/231:failed|failed| ok | [ 0.000000] hard-safe-A + unsafe-B #2/312:failed|failed| ok | [ 0.000000] soft-safe-A + unsafe-B #2/312:failed|failed| ok | [ 0.000000] hard-safe-A + unsafe-B #2/321:failed|failed| ok | [ 0.000000] soft-safe-A + unsafe-B #2/321:failed|failed| ok | [ 0.000000] hard-irq lock-inversion/123:failed|failed| ok | [ 0.000000] soft-irq lock-inversion/123:failed|failed| ok | [ 0.000000] hard-irq lock-inversion/132:failed|failed| ok | [ 0.000000] soft-irq lock-inversion/132:failed|failed| ok | [ 0.000000] hard-irq lock-inversion/213:failed|failed| ok | [ 0.000000] soft-irq lock-inversion/213:failed|failed| ok | [ 0.000000] hard-irq lock-inversion/231:failed|failed| ok | [ 0.000000] soft-irq lock-inversion/231:failed|failed| ok | [ 0.000000] hard-irq lock-inversion/312:failed|failed| ok | [ 0.000000] soft-irq lock-inversion/312:failed|failed| ok | [ 0.000000] hard-irq lock-inversion/321:failed|failed| ok | [ 0.000000] soft-irq lock-inversion/321:failed|failed| ok | [ 0.000000] hard-irq read-recursion/123: ok | [ 0.000000] soft-irq read-recursion/123: ok | [ 0.000000] hard-irq read-recursion/132: ok | [ 0.000000] soft-irq read-recursion/132: ok | [ 0.000000] hard-irq read-recursion/213: ok | [ 0.000000] soft-irq read-recursion/213: ok | [ 0.000000] hard-irq read-recursion/231: ok | [ 0.000000] soft-irq read-recursion/231: ok | [ 0.000000] hard-irq read-recursion/312: ok | [ 0.000000] soft-irq read-recursion/312: ok | [ 0.000000] hard-irq read-recursion/321: ok | [ 0.000000] soft-irq read-recursion/321: ok | [ 0.000000] -------------------------------------------------------------------------- [ 0.000000] | Wound/wait tests | [ 0.000000] --------------------- [ 0.000000] ww api failures: ok | ok | ok | [ 0.000000] ww contexts mixing:failed| ok | [ 0.000000] finishing ww context: ok | ok | ok | ok | [ 0.000000] locking mismatches: ok | ok | ok | [ 0.000000] EDEADLK handling: ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | [ 0.000000] spinlock nest unlocked: ok | [ 0.000000] ----------------------------------------------------- [ 0.000000] |block | try |context| [ 0.000000] ----------------------------------------------------- [ 0.000000] context:failed| ok | ok | [ 0.000000] try:failed| ok |failed| [ 0.000000] block:failed| ok |failed| [ 0.000000] spinlock:failed| ok |failed| [ 0.000000] -------------------------------------------------------- [ 0.000000] 141 out of 253 testcases failed, as expected. | [ 0.000000] ---------------------------------------------------- [ 0.000000] hpet clockevent registered [ 0.000000] tsc: Detected 2693.452 MHz processor [ 0.006666] Calibrating delay loop (skipped) preset value.. 5389.35 BogoMIPS (lpj=8978173) [ 0.006676] pid_max: default: 32768 minimum: 301 [ 0.007524] ACPI: Core revision 20140724 [ 0.012514] ACPI: All ACPI Tables successfully acquired [ 0.013690] Security Framework initialized [ 0.014870] AppArmor: AppArmor initialized [ 0.016678] Yama: becoming mindful. [ 0.017830] Dentry cache hash table entries: 65536 (order: 7, 524288 bytes) [ 0.020862] Inode-cache hash table entries: 32768 (order: 6, 262144 bytes) [ 0.022510] Mount-cache hash table entries: 1024 (order: 1, 8192 bytes) [ 0.023355] Mountpoint-cache hash table entries: 1024 (order: 1, 8192 bytes) [ 0.026735] mce: CPU supports 10 MCE banks [ 0.027474] numa_add_cpu cpu 0 node 0: mask now 0 [ 0.028326] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.028326] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.030594] debug: unmapping init [mem 0xffffffff83abe000-0xffffffff83ac7fff] [ 0.041198] ftrace: allocating 48604 entries in 190 pages [ 0.060444] Getting VERSION: 1050014 [ 0.061089] Getting VERSION: 1050014 [ 0.061596] Getting ID: 0 [ 0.063350] Getting ID: ff000000 [ 0.063811] Getting LVT0: 8700 [ 0.064264] Getting LVT1: 8400 [ 0.064771] enabled ExtINT on CPU#0 [ 0.066710] ENABLING IO-APIC IRQs [ 0.067238] init IO_APIC IRQs [ 0.067734] apic 0 pin 0 not connected [ 0.068436] IOAPIC[0]: Set routing entry (0-1 -> 0x31 -> IRQ 1 Mode:0 Active:0 Dest:1) [ 0.069674] IOAPIC[0]: Set routing entry (0-2 -> 0x30 -> IRQ 0 Mode:0 Active:0 Dest:1) [ 0.073368] IOAPIC[0]: Set routing entry (0-3 -> 0x33 -> IRQ 3 Mode:0 Active:0 Dest:1) [ 0.074505] IOAPIC[0]: Set routing entry (0-4 -> 0x34 -> IRQ 4 Mode:0 Active:0 Dest:1) [ 0.075733] IOAPIC[0]: Set routing entry (0-5 -> 0x35 -> IRQ 5 Mode:1 Active:0 Dest:1) [ 0.076701] IOAPIC[0]: Set routing entry (0-6 -> 0x36 -> IRQ 6 Mode:0 Active:0 Dest:1) [ 0.077841] IOAPIC[0]: Set routing entry (0-7 -> 0x37 -> IRQ 7 Mode:0 Active:0 Dest:1) [ 0.080035] IOAPIC[0]: Set routing entry (0-8 -> 0x38 -> IRQ 8 Mode:0 Active:0 Dest:1) [ 0.083369] IOAPIC[0]: Set routing entry (0-9 -> 0x39 -> IRQ 9 Mode:1 Active:0 Dest:1) [ 0.086031] IOAPIC[0]: Set routing entry (0-10 -> 0x3a -> IRQ 10 Mode:1 Active:0 Dest:1) [ 0.086698] IOAPIC[0]: Set routing entry (0-11 -> 0x3b -> IRQ 11 Mode:1 Active:0 Dest:1) [ 0.090032] IOAPIC[0]: Set routing entry (0-12 -> 0x3c -> IRQ 12 Mode:0 Active:0 Dest:1) [ 0.091143] IOAPIC[0]: Set routing entry (0-13 -> 0x3d -> IRQ 13 Mode:0 Active:0 Dest:1) [ 0.093367] IOAPIC[0]: Set routing entry (0-14 -> 0x3e -> IRQ 14 Mode:0 Active:0 Dest:1) [ 0.096724] IOAPIC[0]: Set routing entry (0-15 -> 0x3f -> IRQ 15 Mode:0 Active:0 Dest:1) [ 0.100028] apic 0 pin 16 not connected [ 0.100578] apic 0 pin 17 not connected [ 0.101367] apic 0 pin 18 not connected [ 0.101912] apic 0 pin 19 not connected [ 0.103340] apic 0 pin 20 not connected [ 0.103892] apic 0 pin 21 not connected [ 0.106672] apic 0 pin 22 not connected [ 0.107239] apic 0 pin 23 not connected [ 0.107962] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.110007] smpboot: CPU0: Intel Core Processor (Haswell) (fam: 06, model: 3c, stepping: 01) [ 0.111478] TSC deadline timer enabled [ 0.113378] Performance Events: unsupported p6 CPU model 60 no PMU driver, software events only. [ 0.116425] Testing tracer nop: PASSED [ 0.119805] NMI watchdog: disabled (cpu0): hardware events not enabled [ 0.120900] x86: Booting SMP configuration: [ 0.121801] .... node #0, CPUs: #1 [ 0.006666] kvm-clock: cpu 1, msr 0:13ff8041, secondary cpu clock [ 0.006666] masked ExtINT on CPU#1 [ 0.006666] numa_add_cpu cpu 1 node 0: mask now 0-1 [ 0.136831] x86: Booted up 1 node, 2 CPUs [ 0.137412] smpboot: Total of 2 processors activated (10778.71 BogoMIPS) [ 0.136736] KVM setup async PF for cpu 1 [ 0.136736] kvm-stealtime: cpu 1, msr 1240ce00 [ 0.167193] devtmpfs: initialized [ 0.168414] gcov: version magic: 0x3430382a [ 0.190980] Testing tracer function: PASSED [ 0.368343] Testing dynamic ftrace: PASSED [ 0.690204] Testing dynamic ftrace ops #1: (1 0 1 0 0) (1 1 2 0 0) (2 1 3 0 279) (2 2 4 0 381) PASSED [ 0.938171] Testing dynamic ftrace ops #2: (1 0 1 223 0) (1 1 2 338 0) (2 1 3 2 402) (2 2 4 112 512) PASSED [ 1.211119] Testing ftrace recursion: PASSED [ 1.253716] Testing ftrace recursion safe: PASSED [ 1.295205] Testing ftrace regs: PASSED [ 1.413369] Testing tracer wakeup: ret = 0 [ 1.683370] PASSED [ 1.723371] Testing tracer wakeup_rt: ret = 0 [ 1.986706] PASSED [ 2.026707] Testing tracer wakeup_dl: ret = 0 [ 2.290045] PASSED [ 2.330062] Testing tracer function_graph: PASSED [ 2.934559] xor: automatically using best checksumming function: [ 2.967490] avx : 134.400 MB/sec [ 2.968158] prandom: seed boundary self test passed [ 2.969574] prandom: 100 self tests passed [ 2.970552] regulator-dummy: no parameters [ 2.971841] NET: Registered protocol family 16 [ 2.973545] cpuidle: using governor ladder [ 2.974162] cpuidle: using governor menu [ 2.975286] ACPI: bus type PCI registered [ 2.976045] PCI: Using configuration type 1 for base access [ 3.064148] raid6: sse2x1 1510 MB/s [ 3.120646] raid6: sse2x2 1856 MB/s [ 3.177486] raid6: sse2x4 1838 MB/s [ 3.178107] raid6: using algorithm sse2x2 (1856 MB/s) [ 3.178887] raid6: using ssse3x2 recovery algorithm [ 3.183068] ACPI: Added _OSI(Module Device) [ 3.183068] ACPI: Added _OSI(Processor Device) [ 3.183068] ACPI: Added _OSI(3.0 _SCP Extensions) [ 3.183068] ACPI: Added _OSI(Processor Aggregator Device) [ 3.193653] ACPI: Interpreter enabled [ 3.194230] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [\_S1_] (20140724/hwxface-580) [ 3.195613] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [\_S2_] (20140724/hwxface-580) [ 3.197059] ACPI: (supports S0 S3 S4 S5) [ 3.197664] ACPI: Using IOAPIC for interrupt routing [ 3.198485] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 3.212813] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 3.213353] acpi PNP0A03:00: _OSC: OS supports [Segments] [ 3.214207] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM [ 3.222027] PCI host bridge to bus 0000:00 [ 3.222673] pci_bus 0000:00: root bus resource [bus 00-ff] [ 3.223347] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7] [ 3.224225] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff] [ 3.225133] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff] [ 3.226105] pci_bus 0000:00: root bus resource [mem 0x80000000-0xfebfffff] [ 3.233453] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 3.235272] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 3.237205] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 3.241172] pci 0000:00:01.1: reg 0x20: [io 0xc040-0xc04f] [ 3.243267] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 3.243346] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 3.244287] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 3.245320] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 3.246854] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 3.248268] pci 0000:00:01.3: quirk: [io 0xb000-0xb03f] claimed by PIIX4 ACPI [ 3.249371] pci 0000:00:01.3: quirk: [io 0xb100-0xb10f] claimed by PIIX4 SMB [ 3.250692] pci 0000:00:02.0: [1013:00b8] type 00 class 0x030000 [ 3.257507] pci 0000:00:02.0: reg 0x10: [mem 0xfc000000-0xfdffffff pref] [ 3.260100] pci 0000:00:02.0: reg 0x14: [mem 0xfebf0000-0xfebf0fff] [ 3.268372] pci 0000:00:02.0: reg 0x30: [mem 0xfebe0000-0xfebeffff pref] [ 3.270573] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000 [ 3.272499] pci 0000:00:03.0: reg 0x10: [mem 0xfeba0000-0xfebbffff] [ 3.273876] pci 0000:00:03.0: reg 0x14: [io 0xc000-0xc03f] [ 3.280018] pci 0000:00:03.0: reg 0x30: [mem 0xfebc0000-0xfebdffff pref] [ 3.281707] pci 0000:00:04.0: [8086:25ab] type 00 class 0x088000 [ 3.283276] pci 0000:00:04.0: reg 0x10: [mem 0xfebf1000-0xfebf100f] [ 3.289474] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11) [ 3.290502] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11) [ 3.291591] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11) [ 3.292692] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11) [ 3.293646] ACPI: PCI Interrupt Link [LNKS] (IRQs *9) [ 3.295391] ACPI: Enabled 16 GPEs in block 00 to 0F [ 3.297906] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none [ 3.299152] vgaarb: loaded [ 3.299546] vgaarb: bridge control possible 0000:00:02.0 [ 3.301843] SCSI subsystem initialized [ 3.302767] media: Linux media interface: v0.10 [ 3.303392] Linux video capture interface: v2.00 [ 3.304235] pps_core: LinuxPPS API ver. 1 registered [ 3.304988] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 3.306376] PTP clock support registered [ 3.307482] Advanced Linux Sound Architecture Driver Initialized. [ 3.308483] PCI: Using ACPI for IRQ routing [ 3.309115] PCI: pci_cache_line_size set to 64 bytes [ 3.310082] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] [ 3.311021] e820: reserve RAM buffer [mem 0x13ffe000-0x13ffffff] [ 3.312877] irda_init() [ 3.313365] NET: Registered protocol family 23 [ 3.314033] Bluetooth: Core ver 2.19 [ 3.314583] NET: Registered protocol family 31 [ 3.315201] Bluetooth: HCI device and connection manager initialized [ 3.316030] Bluetooth: HCI socket layer initialized [ 3.316692] Bluetooth: L2CAP socket layer initialized [ 3.317496] Bluetooth: SCO socket layer initialized [ 3.318217] NET: Registered protocol family 8 [ 3.318776] NET: Registered protocol family 20 [ 3.319434] NetLabel: Initializing [ 3.319873] NetLabel: domain hash size = 128 [ 3.320008] NetLabel: protocols = UNLABELED CIPSOv4 [ 3.320850] NetLabel: unlabeled traffic allowed by default [ 3.323344] Switched to clocksource kvm-clock [ 3.480935] FS-Cache: Loaded [ 3.481680] CacheFiles: Loaded [ 3.490936] AppArmor: AppArmor Filesystem Enabled [ 3.491830] pnp: PnP ACPI init [ 3.492857] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active) [ 3.494245] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active) [ 3.495454] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active) [ 3.497015] pnp 00:03: [dma 2] [ 3.497741] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active) [ 3.499573] pnp 00:04: Plug and Play ACPI device, IDs PNP0400 (active) [ 3.500858] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active) [ 3.502062] pnp 00:06: Plug and Play ACPI device, IDs PNP0501 (active) [ 3.510396] pnp: PnP ACPI: found 7 devices [ 3.518489] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7] [ 3.519594] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff] [ 3.520447] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff] [ 3.521548] pci_bus 0000:00: resource 7 [mem 0x80000000-0xfebfffff] [ 3.522876] NET: Registered protocol family 2 [ 3.525169] TCP established hash table entries: 4096 (order: 3, 32768 bytes) [ 3.526464] TCP bind hash table entries: 4096 (order: 6, 327680 bytes) [ 3.527877] TCP: Hash tables configured (established 4096 bind 4096) [ 3.529049] TCP: reno registered [ 3.529588] UDP hash table entries: 256 (order: 3, 49152 bytes) [ 3.530791] UDP-Lite hash table entries: 256 (order: 3, 49152 bytes) [ 3.532610] NET: Registered protocol family 1 [ 3.533627] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 3.534628] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 3.535613] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 3.536625] pci 0000:00:02.0: Boot video device [ 3.537459] PCI: CLS 0 bytes, default 64 [ 3.538466] Unpacking initramfs... [ 4.699045] debug: unmapping init [mem 0xffff88001293d000-0xffff880013feffff] [ 4.708058] Machine check injector initialized [ 4.708990] microcode: CPU0 sig=0x306c1, pf=0x1, revision=0x1 [ 4.709838] microcode: CPU1 sig=0x306c1, pf=0x1, revision=0x1 [ 4.711022] microcode: Microcode Update Driver: v2.00 , Peter Oruba [ 4.732106] AVX version of gcm_enc/dec engaged. [ 4.732804] AES CTR mode by8 optimization enabled [ 4.737398] sha256_ssse3: Using AVX optimized SHA-256 implementation [ 4.745539] sha512_ssse3: Using AVX optimized SHA-512 implementation [ 4.754281] AVX2 or AES-NI instructions are not detected. [ 4.755453] rcu-torture:--- Start of test: nreaders=1 nfakewriters=4 stat_interval=60 verbose=1 test_no_idle_hz=1 shuffle_interval=3 stutter=5 irqreader=1 fqs_duration=0 fqs_holdoff=0 fqs_stutter=3 test_boost=1/0 test_boost_interval=7 test_boost_duration=4 shutdown_secs=0 stall_cpu=0 stall_cpu_holdoff=10 n_barrier_cbs=0 onoff_interval=0 onoff_holdoff=0 [ 4.759803] rcu-torture: Creating rcu_torture_writer task [ 4.760761] rcu-torture: rcu_torture_writer task started [ 4.761546] rcu-torture: Creating rcu_torture_fakewriter task [ 4.784562] rcu-torture: Creating rcu_torture_fakewriter task [ 4.785494] rcu-torture: Creating rcu_torture_fakewriter task [ 4.785651] rcu-torture: rcu_torture_fakewriter task started [ 4.787230] rcu-torture: rcu_torture_fakewriter task started [ 4.788083] rcu-torture: Creating rcu_torture_fakewriter task [ 4.788626] rcu-torture: rcu_torture_fakewriter task started [ 4.789839] rcu-torture: Creating rcu_torture_reader task [ 4.791100] rcu-torture: rcu_torture_fakewriter task started [ 4.792001] rcu-torture: Creating rcu_torture_stats task [ 4.799338] rcu-torture: rcu_torture_reader task started [ 4.804331] rcu-torture: Creating torture_shuffle task [ 4.805260] rcu-torture: rcu_torture_stats task started [ 4.806160] rcu-torture: Creating torture_stutter task [ 4.806167] rcu-torture: torture_shuffle task started [ 4.807898] rcu-torture: Creating rcu_torture_cbflood task [ 4.807900] rcu-torture: torture_stutter task started [ 4.811300] rcu-torture: rcu_torture_cbflood task started [ 4.811388] futex hash table entries: 512 (order: 4, 65536 bytes) [ 4.811493] audit: initializing netlink subsys (disabled) [ 4.811677] audit: type=2000 audit(1409197062.426:1): initialized [ 5.703738] tsc: Refined TSC clocksource calibration: 2693.501 MHz [ 6.294975] zpool: loaded [ 6.295425] zbud: loaded [ 6.296462] VFS: Disk quotas dquot_6.5.2 [ 6.297149] Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 6.299157] DLM installed [ 6.302386] FS-Cache: Netfs 'cifs' registered for caching [ 6.303483] Key type cifs.spnego registered [ 6.304190] Key type cifs.idmap registered [ 6.304815] ntfs: driver 2.1.30 [Flags: R/W DEBUG]. [ 6.305823] efs: 1.0a - http://aeschi.ch.eu.org/efs/ [ 6.308485] fuse init (API version 7.23) [ 6.309641] NILFS version 2 loaded [ 6.310194] befs: version: 0.9.3 [ 6.311291] ocfs2: Registered cluster interface user [ 6.312295] OCFS2 User DLM kernel interface loaded [ 6.314889] gfs2: GFS2 installed [ 6.315676] ceph: loaded (mds proto 32) [ 6.316301] msgmni has been set to 449 [ 6.338935] NET: Registered protocol family 38 [ 6.339649] Key type asymmetric registered [ 6.340370] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) [ 6.346570] io scheduler noop registered (default) [ 6.347357] io scheduler deadline registered [ 6.348447] io scheduler cfq registered [ 6.349565] test_string_helpers: Running tests... [ 6.355035] test_firmware: interface ready [ 6.359155] crc32: CRC_LE_BITS = 8, CRC_BE BITS = 8 [ 6.359880] crc32: self tests passed, processed 225944 bytes in 982795 nsec [ 6.365820] crc32c: CRC_LE_BITS = 8 [ 6.366340] crc32c: self tests passed, processed 225944 bytes in 4278473 nsec [ 6.452547] crc32_combine: 8373 self tests passed [ 6.573201] crc32c_combine: 8373 self tests passed [ 6.580595] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 6.582841] ACPI: Power Button [PWRF] [ 6.701420] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled [ 6.759185] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 6.762935] ppdev: user-space parallel port driver [ 6.763668] telclk_interrupt = 0xf non-mcpbl0010 hw. [ 6.764497] Hangcheck: starting hangcheck timer 0.9.1 (tick is 180 seconds, margin is 60 seconds). [ 6.766276] [drm] Initialized drm 1.1.0 20060810 [ 6.768247] dummy-irq: no IRQ given. Use irq=N [ 6.771756] lkdtm: No crash points registered, enable through debugfs [ 6.772989] Silicon Labs C2 port support v. 0.51.0 - (C) 2007 Rodolfo Giometti [ 6.774293] c2port c2port0: C2 port uc added [ 6.775248] c2port c2port0: uc flash has 30 blocks x 512 bytes (15360 bytes total) [ 6.777973] Loading iSCSI transport class v2.0-870. [ 6.820902] iscsi: registered transport (tcp) [ 6.827591] st: Version 20101219, fixed bufsize 32768, s/g segs 256 [ 6.839295] osst :I: Tape driver with OnStream support version 0.99.4 [ 6.839295] osst :I: $Id: osst.c,v 1.73 2005/01/01 21:13:34 wriede Exp $ [ 6.843089] SCSI Media Changer driver v0.25 [ 6.886388] scsi_debug: host protection [ 6.887009] scsi host0: scsi_debug, version 1.84 [20140706], dev_size_mb=8, opts=0x0 [ 6.889250] scsi 0:0:0:0: Direct-Access Linux scsi_debug 0184 PQ: 0 ANSI: 5 [ 6.893900] Rounding down aligned max_sectors from 4294967295 to 4294967288 [ 6.900455] mtdoops: mtd device (mtddev=name/number) must be supplied [ 6.901661] L440GX flash mapping: failed to find PIIX4 ISA bridge, cannot continue [ 6.903243] vcan: Virtual CAN interface driver [ 6.904195] YAM driver version 0.8 by F1OAT/F6FBB [ 6.910640] AX.25: bpqether driver version 004 [ 6.911438] baycom_ser_fdx: (C) 1996-2000 Thomas Sailer, HB9JNX/AE4WA [ 6.911438] baycom_ser_fdx: version 0.10 [ 6.913496] sd 0:0:0:0: [sda] 16384 512-byte logical blocks: (8.38 MB/8.00 MiB) [ 6.916821] sd 0:0:0:0: [sda] Write Protect is off [ 6.916982] hdlcdrv: (C) 1996-2000 Thomas Sailer HB9JNX/AE4WA [ 6.916984] hdlcdrv: version 0.8 [ 6.916986] baycom_ser_hdx: (C) 1996-2000 Thomas Sailer, HB9JNX/AE4WA [ 6.916986] baycom_ser_hdx: version 0.10 [ 6.918596] baycom_par: (C) 1996-2000 Thomas Sailer, HB9JNX/AE4WA [ 6.918596] baycom_par: version 0.9 [ 6.923187] sd 0:0:0:0: [sda] Mode Sense: 73 00 10 08 [ 6.923498] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 6.928803] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 6.929609] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 6.933070] parkbd: no such parport [ 6.933391] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, supports DPO and FUA [ 6.940605] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 6.960201] sda: unknown partition table [ 6.990471] sd 0:0:0:0: [sda] Attached SCSI disk [ 7.009357] apanel: Fujitsu BIOS signature 'FJKEYINF' not found... [ 7.012763] input: PC Speaker as /devices/platform/pcspkr/input/input4 [ 7.030628] i2c /dev entries driver [ 7.036323] i2c-parport: adapter type unspecified [ 7.037145] i2c-parport-light: adapter type unspecified [ 7.044328] pps pps0: new PPS source ktimer [ 7.044972] pps pps0: ktimer PPS source registered [ 7.045724] pps_parport: parallel port PPS client [ 7.046640] Driver for 1-wire Dallas network protocol. [ 7.047603] DS1WM w1 busmaster driver - (c) 2004 Szabolcs Gyurko [ 7.049068] 1-Wire driver for the DS2760 battery monitor chip - (c) 2004-2005, Szabolcs Gyurko [ 7.055548] applesmc: supported laptop not found! [ 7.056261] applesmc: driver init failed (ret=-19)! [ 7.067267] advantechwdt: WDT driver for Advantech single board computer initialising [ 7.069402] advantechwdt: initialized. timeout=60 sec (nowayout=1) [ 7.070391] ib700wdt: WDT driver for IB700 single board computer initialising [ 7.071646] ib700wdt: START method I/O 443 is not available [ 7.072476] ib700wdt: probe of ib700wdt failed with error -5 [ 7.073743] wafer5823wdt: WDT driver for Wafer 5823 single board computer initialising [ 7.074936] wafer5823wdt: I/O address 0x0443 already in use [ 7.075905] it87_wdt: no device [ 7.076379] sc1200wdt: build 20020303 [ 7.077034] sc1200wdt: io parameter must be specified [ 7.077811] sbc60xxwdt: I/O address 0x0443 already in use [ 7.078658] smsc37b787_wdt: SMsC 37B787 watchdog component driver 1.1 initialising... [ 7.080820] smsc37b787_wdt: Unable to register miscdev on minor 130 [ 7.081879] w83877f_wdt: I/O address 0x0443 already in use [ 7.082690] machzwd: MachZ ZF-Logic Watchdog driver initializing [ 7.083603] machzwd: no ZF-Logic found [ 7.084363] Bluetooth: Virtual HCI driver ver 1.5 [ 7.086908] Bluetooth: Generic Bluetooth SDIO driver ver 0.1 [ 7.088288] sdhci: Secure Digital Host Controller Interface driver [ 7.089206] sdhci: Copyright(c) Pierre Ossman [ 7.089866] wbsd: Winbond W83L51xD SD/MMC card interface driver [ 7.090767] wbsd: Copyright(c) Pierre Ossman [ 7.091570] sdhci-pltfm: SDHCI platform and OF driver helper [ 7.094837] ledtrig-cpu: registered to indicate activity on CPUs [ 7.097457] dcdbas dcdbas: Dell Systems Management Base Driver (version 5.6.0-3.2) [ 7.098953] hidraw: raw HID events driver (C) Jiri Kosina [ 7.101311] panel: driver version 0.9.5 not yet registered [ 7.105335] logger: created 256K log 'log_main' [ 7.106322] logger: created 256K log 'log_events' [ 7.107351] logger: created 256K log 'log_radio' [ 7.108644] logger: created 256K log 'log_system' [ 7.115963] fake-fmc-carrier: mezzanine 0 [ 7.116627] Manufacturer: fake-vendor [ 7.117323] Product name: fake-design-for-testing [ 7.118357] fmc fake-design-for-testing-f001: Driver has no ID: matches all [ 7.119489] fmc_trivial: probe of fake-design-for-testing-f001 failed with error -95 [ 7.120928] fmc fake-design-for-testing-f001: Driver has no ID: matches all [ 7.122004] fmc_write_eeprom fake-design-for-testing-f001: fmc_write_eeprom: no busid passed, refusing all cards [ 7.123545] fmc fake-design-for-testing-f001: Driver has no ID: matches all [ 7.124900] fmc_chardev fake-design-for-testing-f001: Created misc device "fake-design-for-testing-f001" [ 7.130153] oprofile: using timer interrupt. [ 7.130802] pktgen: Packet Generator for packet performance testing. Version: 2.74 [ 7.176914] NET: Registered protocol family 26 [ 7.177734] Netfilter messages via NETLINK v0.30. [ 7.178543] nf_conntrack version 0.5.0 (1796 buckets, 7184 max) [ 7.181813] ctnetlink v0.93: registering with nfnetlink. [ 7.182904] nf_tables: (c) 2007-2009 Patrick McHardy [ 7.184163] ip_set: protocol 6 [ 7.184748] IPVS: Registered protocols (TCP, UDP, ESP) [ 7.185664] IPVS: Connection hash table configured (size=4096, memory=64Kbytes) [ 7.186784] IPVS: Each connection entry needs 408 bytes at least [ 7.187974] IPVS: Creating netns size=2568 id=0 [ 7.190636] IPVS: ipvs loaded. [ 7.191150] IPVS: [rr] scheduler registered. [ 7.191805] IPVS: [lc] scheduler registered. [ 7.192479] IPVS: [wlc] scheduler registered. [ 7.193262] IPVS: [lblc] scheduler registered. [ 7.194038] IPVS: [lblcr] scheduler registered. [ 7.194732] IPVS: [dh] scheduler registered. [ 7.195403] IPVS: [sed] scheduler registered. [ 7.196066] IPVS: [nq] scheduler registered. [ 7.197605] TCP: bic registered [ 7.198101] TCP: westwood registered [ 7.198655] TCP: highspeed registered [ 7.199171] TCP: hybla registered [ 7.199682] TCP: htcp registered [ 7.200244] TCP: vegas registered [ 7.200768] TCP: veno registered [ 7.201255] TCP: scalable registered [ 7.201819] TCP: lp registered [ 7.202310] TCP: yeah registered [ 7.202874] Initializing XFRM netlink socket [ 7.204150] NET: Registered protocol family 10 [ 7.206540] mip6: Mobile IPv6 [ 7.207318] ip6_tables: (C) 2000-2006 Netfilter Core Team [ 7.209361] sit: IPv6 over IPv4 tunneling driver [ 7.211360] ip6_gre: GRE over IPv6 tunneling driver [ 7.212764] NET: Registered protocol family 15 [ 7.213719] NET: Registered protocol family 5 [ 7.214589] NET: Registered protocol family 9 [ 7.215283] X25: Linux Version 0.2 [ 7.227874] NET: Registered protocol family 11 [ 7.228821] NET: Registered protocol family 3 [ 7.229507] can: controller area network core (rev 20120528 abi 9) [ 7.232444] NET: Registered protocol family 29 [ 7.233240] can: raw protocol (rev 20120528) [ 7.234044] can: broadcast manager protocol (rev 20120528 t) [ 7.234893] can: netlink gateway (rev 20130117) max_hops=1 [ 7.237809] Bluetooth: HIDP (Human Interface Emulation) ver 1.2 [ 7.238737] Bluetooth: HIDP socket layer initialized [ 7.239619] NET: Registered protocol family 33 [ 7.240393] Key type rxrpc registered [ 7.240933] Key type rxrpc_s registered [ 7.243556] RxRPC: Registered security type 2 'rxkad' [ 7.244403] lec:lane_module_init: lec.c: initialized [ 7.245160] mpoa:atm_mpoa_init: mpc.c: initialized [ 7.250827] NET4: DECnet for Linux: V.2.5.68s (C) 1995-2003 Linux DECnet Project Team [ 7.252916] DECnet: Routing cache hash table of 128 buckets, 10Kbytes [ 7.253976] NET: Registered protocol family 12 [ 7.254796] NET: Registered protocol family 35 [ 7.256442] 8021q: 802.1Q VLAN Support v1.8 [ 7.257827] sctp: Hash tables configured (established 819 bind 819) [ 7.259518] Key type dns_resolver registered [ 7.260498] Key type ceph registered [ 7.263046] libceph: loaded (mon/osd proto 15/24) [ 7.264282] openvswitch: Open vSwitch switching datapath [ 7.267973] mpls_gso: MPLS GSO support [ 7.271509] [ 7.271509] printing PIC contents [ 7.272215] ... PIC IMR: ffff [ 7.272666] ... PIC IRR: 1013 [ 7.273106] ... PIC ISR: 0000 [ 7.282678] ... PIC ELCR: 0c00 [ 7.283163] printing local APIC contents on CPU#0/0: [ 7.283344] ... APIC ID: 00000000 (0) [ 7.283344] ... APIC VERSION: 01050014 [ 7.283344] ... APIC TASKPRI: 00000000 (00) [ 7.283344] ... APIC PROCPRI: 00000000 [ 7.283344] ... APIC LDR: 01000000 [ 7.283344] ... APIC DFR: ffffffff [ 7.283344] ... APIC SPIV: 000001ff [ 7.283344] ... APIC ISR field: [ 7.283344] 0000000000000000000000000000000000000000000000000000000000000000 [ 7.283344] ... APIC TMR field: [ 7.283344] 0000000002000000000000000000000000000000000000000000000000000000 [ 7.283344] ... APIC IRR field: [ 7.283344] 0000000000000000000000000000000000000000000000000000000000008000 [ 7.283344] ... APIC ESR: 00000000 [ 7.283344] ... APIC ICR: 000008fd [ 7.283344] ... APIC ICR2: 02000000 [ 7.283344] ... APIC LVTT: 000400ef [ 7.283344] ... APIC LVTPC: 00010000 [ 7.283344] ... APIC LVT0: 00010700 [ 7.283344] ... APIC LVT1: 00000400 [ 7.283344] ... APIC LVTERR: 000000fe [ 7.283344] ... APIC TMICT: 00000000 [ 7.283344] ... APIC TMCCT: 00000000 [ 7.283344] ... APIC TDCR: 00000000 [ 7.283344] [ 7.300256] number of MP IRQ sources: 15. [ 7.300914] number of IO-APIC #0 registers: 24. [ 7.301630] testing the IO APIC....................... [ 7.302468] IO APIC #0...... [ 7.302878] .... register #00: 00000000 [ 7.305503] ....... : physical APIC id: 00 [ 7.306124] ....... : Delivery Type: 0 [ 7.306774] ....... : LTS : 0 [ 7.307616] .... register #01: 00170011 [ 7.308169] ....... : max redirection entries: 17 [ 7.308894] ....... : PRQ implemented: 0 [ 7.315516] ....... : IO APIC version: 11 [ 7.316147] .... register #02: 00000000 [ 7.316751] ....... : arbitration: 00 [ 7.317351] .... IRQ redirection table: [ 7.317944] 1 0 0 0 0 0 0 00 [ 7.318644] 0 0 0 0 0 1 1 31 [ 7.319336] 0 0 0 0 0 1 1 30 [ 7.320045] 0 0 0 0 0 1 1 33 [ 7.320742] 1 0 0 0 0 1 1 34 [ 7.321446] 1 1 0 0 0 1 1 35 [ 7.322128] 0 0 0 0 0 1 1 36 [ 7.322827] 0 0 0 0 0 1 1 37 [ 7.323542] 0 0 0 0 0 1 1 38 [ 7.324221] 0 1 0 0 0 1 1 39 [ 7.324909] 1 1 0 0 0 1 1 3A [ 7.335677] 1 1 0 0 0 1 1 3B [ 7.336411] 0 0 0 0 0 1 1 3C [ 7.337131] 0 0 0 0 0 1 1 3D [ 7.337851] 0 0 0 0 0 1 1 3E [ 7.338570] 0 0 0 0 0 1 1 3F [ 7.339270] 1 0 0 0 0 0 0 00 [ 7.339983] 1 0 0 0 0 0 0 00 [ 7.340723] 1 0 0 0 0 0 0 00 [ 7.341442] 1 0 0 0 0 0 0 00 [ 7.342132] 1 0 0 0 0 0 0 00 [ 7.342837] 1 0 0 0 0 0 0 00 [ 7.343555] 1 0 0 0 0 0 0 00 [ 7.344254] 1 0 0 0 0 0 0 00 [ 7.344947] IRQ to pin mappings: [ 7.347607] IRQ0 -> 0:2 [ 7.348035] IRQ1 -> 0:1 [ 7.348499] IRQ3 -> 0:3 [ 7.348922] IRQ4 -> 0:4 [ 7.349362] IRQ5 -> 0:5 [ 7.349779] IRQ6 -> 0:6 [ 7.350223] IRQ7 -> 0:7 [ 7.350664] IRQ8 -> 0:8 [ 7.351086] IRQ9 -> 0:9 [ 7.351531] IRQ10 -> 0:10 [ 7.351971] IRQ11 -> 0:11 [ 7.352438] IRQ12 -> 0:12 [ 7.352886] IRQ13 -> 0:13 [ 7.353365] IRQ14 -> 0:14 [ 7.353814] IRQ15 -> 0:15 [ 7.354266] .................................... done. [ 7.364178] Running tests on trace events: [ 7.364819] Testing event thermal_apic_exit: OK [ 7.394931] Testing event thermal_apic_entry: OK [ 7.502622] Testing event threshold_apic_exit: OK [ 7.517217] Testing event threshold_apic_entry: OK [ 7.582642] Testing event call_function_single_exit: [ 7.590808] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input3 [ 7.597215] OK [ 7.597481] Testing event call_function_single_entry: OK [ 7.614108] Testing event call_function_exit: OK [ 7.627823] Testing event call_function_entry: OK [ 7.666724] Testing event irq_work_exit: OK [ 7.701334] Testing event irq_work_entry: OK [ 7.714346] Testing event x86_platform_ipi_exit: OK [ 7.730833] Testing event x86_platform_ipi_entry: OK [ 7.748485] Testing event error_apic_exit: OK [ 7.771220] Testing event error_apic_entry: OK [ 7.805366] Testing event spurious_apic_exit: OK [ 7.845383] Testing event spurious_apic_entry: OK [ 7.881187] Testing event reschedule_exit: OK [ 7.893843] Testing event reschedule_entry: OK [ 7.907165] Testing event local_timer_exit: OK [ 7.936192] Testing event local_timer_entry: OK [ 7.962287] Testing event nmi_handler: OK [ 7.993722] Testing event emulate_vsyscall: OK [ 8.022935] Testing event sys_exit: OK [ 8.062644] Testing event sys_enter: OK [ 8.081121] Testing event mce_record: OK [ 8.095210] Testing event tlb_flush: OK [ 8.108785] Testing event page_fault_kernel: OK [ 8.121371] Testing event page_fault_user: OK [ 8.145952] Testing event task_rename: OK [ 8.210487] Testing event task_newtask: OK [ 8.263448] Testing event softirq_raise: OK [ 8.277231] Testing event softirq_exit: OK [ 8.294655] Testing event softirq_entry: OK [ 8.312424] Testing event irq_handler_exit: OK [ 8.327570] Testing event irq_handler_entry: OK [ 8.341163] Testing event signal_deliver: OK [ 8.358341] Testing event signal_generate: OK [ 8.376184] Testing event workqueue_execute_end: OK [ 8.483983] Testing event workqueue_execute_start: OK [ 8.591196] Testing event workqueue_activate_work: OK [ 8.607589] Testing event workqueue_queue_work: OK [ 8.621176] Testing event sched_wake_idle_without_ipi: OK [ 8.641190] Testing event sched_swap_numa: OK [ 8.714785] Testing event sched_stick_numa: OK [ 8.727148] Testing event sched_move_numa: OK [ 8.740926] Testing event sched_process_hang: OK [ 8.754819] Testing event sched_pi_setprio: OK [ 8.767180] Testing event sched_stat_runtime: OK [ 8.782202] Testing event sched_stat_blocked: OK [ 8.798630] Testing event sched_stat_iowait: OK [ 8.810715] Testing event sched_stat_sleep: OK [ 8.824889] Testing event sched_stat_wait: OK [ 8.837455] Testing event sched_process_exec: OK [ 8.854180] Testing event sched_process_fork: OK [ 8.868322] Testing event sched_process_wait: OK [ 8.881040] Testing event sched_wait_task: OK [ 8.895894] Testing event sched_process_exit: OK [ 8.911690] Testing event sched_process_free: OK [ 8.927813] Testing event sched_migrate_task: OK [ 9.052747] Testing event sched_switch: OK [ 9.087726] Testing event sched_wakeup_new: OK [ 9.138673] Testing event sched_wakeup: OK [ 9.187688] Testing event sched_kthread_stop_ret: OK [ 9.225607] Testing event sched_kthread_stop: OK [ 9.255691] Testing event lock_acquired: OK [ 9.287086] Testing event lock_contended: OK [ 9.328846] Testing event lock_release: OK [ 9.350485] Testing event lock_acquire: OK [ 9.367256] Testing event console: OK [ 9.380453] Testing event rcu_utilization: OK [ 9.394130] Testing event itimer_expire: OK [ 9.407224] Testing event itimer_state: OK [ 9.420499] Testing event hrtimer_cancel: OK [ 9.480613] Testing event hrtimer_expire_exit: OK [ 9.493796] Testing event hrtimer_expire_entry: OK [ 9.526418] Testing event hrtimer_start: OK [ 9.559585] Testing event hrtimer_init: OK [ 9.593010] Testing event timer_cancel: OK [ 9.616618] Testing event timer_expire_exit: OK [ 9.643574] Testing event timer_expire_entry: OK [ 9.665264] Testing event timer_start: OK [ 9.680910] Testing event timer_init: OK [ 9.695078] Testing event ftrace_test_filter: OK [ 9.708591] Testing event dev_pm_qos_remove_request: OK [ 9.728052] Testing event dev_pm_qos_update_request: OK [ 9.744744] Testing event dev_pm_qos_add_request: OK [ 9.758256] Testing event pm_qos_update_flags: OK [ 9.770425] Testing event pm_qos_update_target: OK [ 9.794150] Testing event pm_qos_update_request_timeout: OK [ 9.805856] Testing event pm_qos_remove_request: OK [ 9.823784] Testing event pm_qos_update_request: OK [ 9.843774] Testing event pm_qos_add_request: OK [ 9.857105] Testing event power_domain_target: OK [ 9.873748] Testing event clock_set_rate: OK [ 10.005576] Testing event clock_disable: OK [ 10.215650] Testing event clock_enable: OK [ 10.435568] Testing event wakeup_source_deactivate: OK [ 10.638423] Testing event wakeup_source_activate: OK [ 10.653162] Testing event suspend_resume: OK [ 10.682723] Testing event device_pm_callback_end: OK [ 10.709001] Testing event device_pm_callback_start: OK [ 10.723995] Testing event cpu_frequency: OK [ 10.737168] Testing event pstate_sample: OK [ 10.752163] Testing event cpu_idle: OK [ 10.764394] Testing event mm_filemap_add_to_page_cache: OK [ 10.778935] Testing event mm_filemap_delete_from_page_cache: OK [ 10.794177] Testing event oom_score_adj_update: OK [ 10.807163] Testing event mm_lru_activate: OK [ 10.823899] Testing event mm_lru_insertion: OK [ 10.882986] Testing event mm_vmscan_lru_shrink_inactive: OK [ 10.903879] Testing event mm_vmscan_writepage: OK [ 10.921127] Testing event mm_vmscan_memcg_isolate: OK [ 10.937025] Testing event mm_vmscan_lru_isolate: OK [ 10.953772] Testing event mm_shrink_slab_end: OK [ 10.971157] Testing event mm_shrink_slab_start: OK [ 10.983727] Testing event mm_vmscan_memcg_softlimit_reclaim_end: OK [ 10.997069] Testing event mm_vmscan_memcg_reclaim_end: OK [ 11.013769] Testing event mm_vmscan_direct_reclaim_end: OK [ 11.027096] Testing event mm_vmscan_memcg_softlimit_reclaim_begin: OK [ 11.040387] Testing event mm_vmscan_memcg_reclaim_begin: OK [ 11.057075] Testing event mm_vmscan_direct_reclaim_begin: OK [ 11.070447] Testing event mm_vmscan_wakeup_kswapd: OK [ 11.083950] Testing event mm_vmscan_kswapd_wake: OK [ 11.107153] Testing event mm_vmscan_kswapd_sleep: OK [ 11.152283] Testing event mm_page_alloc_extfrag: OK [ 11.179108] Testing event mm_page_pcpu_drain: OK [ 11.213802] Testing event mm_page_alloc_zone_locked: OK [ 11.233820] Testing event mm_page_alloc: OK [ 11.247123] Testing event mm_page_free_batched: OK [ 11.263913] Testing event mm_page_free: OK [ 11.277136] Testing event kmem_cache_free: OK [ 11.295871] Testing event kfree: OK [ 11.315908] Testing event kmem_cache_alloc_node: OK [ 11.343104] Testing event kmalloc_node: OK [ 11.363844] Testing event kmem_cache_alloc: OK [ 11.377208] Testing event kmalloc: OK [ 11.393996] Testing event mm_compaction_end: OK [ 11.407116] Testing event mm_compaction_begin: OK [ 11.420507] Testing event mm_compaction_migratepages: OK [ 11.437166] Testing event mm_compaction_isolate_freepages: OK [ 11.457164] Testing event mm_compaction_isolate_migratepages: OK [ 11.473809] Testing event mm_numa_migrate_ratelimit: OK [ 11.487083] Testing event mm_migrate_pages: OK [ 11.501716] Testing event writeback_single_inode: OK [ 11.513796] Testing event writeback_single_inode_start: OK [ 11.530407] Testing event writeback_wait_iff_congested: OK [ 11.547107] Testing event writeback_congestion_wait: OK [ 11.567133] Testing event writeback_sb_inodes_requeue: OK [ 11.583787] Testing event balance_dirty_pages: OK [ 11.597178] Testing event bdi_dirty_ratelimit: OK [ 11.610473] Testing event global_dirty_state: OK [ 11.623798] Testing event writeback_queue_io: OK [ 11.637867] Testing event wbc_writepage: OK [ 11.650532] Testing event writeback_bdi_unregister: OK [ 11.731029] Testing event writeback_bdi_register: OK [ 11.743746] Testing event writeback_wake_background: OK [ 11.757037] Testing event writeback_nowork: OK [ 11.770408] Testing event writeback_pages_written: OK [ 11.783779] Testing event writeback_wait: OK [ 11.797089] Testing event writeback_written: OK [ 11.813298] Testing event writeback_start: OK [ 11.830423] Testing event writeback_exec: OK [ 11.847088] Testing event writeback_queue: OK [ 11.860385] Testing event writeback_write_inode: OK [ 11.873957] Testing event writeback_write_inode_start: OK [ 11.890483] Testing event writeback_dirty_inode: OK [ 11.907510] Testing event writeback_dirty_inode_start: OK [ 11.927091] Testing event writeback_dirty_page: OK [ 11.943748] Testing event ext3_load_inode: OK [ 11.960417] Testing event ext3_get_blocks_exit: OK [ 11.975857] Testing event ext3_get_blocks_enter: OK [ 12.100929] Testing event ext3_truncate_exit: OK [ 12.314309] Testing event ext3_truncate_enter: OK [ 12.534281] Testing event ext3_unlink_exit: OK [ 12.774275] Testing event ext3_unlink_enter: OK [ 12.837072] Testing event ext3_direct_IO_exit: OK [ 12.850427] Testing event ext3_direct_IO_enter: OK [ 12.863712] Testing event ext3_read_block_bitmap: OK [ 12.877086] Testing event ext3_forget: OK [ 12.890417] Testing event ext3_reserved: OK [ 13.014247] Testing event ext3_alloc_new_reservation: OK [ 13.170917] Testing event ext3_discard_reservation: OK [ 13.282409] Testing event ext3_rsv_window_add: OK [ 13.417614] Testing event ext3_sync_fs: OK [ 13.594244] Testing event ext3_sync_file_exit: OK [ 13.834274] Testing event ext3_sync_file_enter: OK [ 13.860444] Testing event ext3_free_blocks: OK [ 13.873726] Testing event ext3_allocate_blocks: OK [ 13.887059] Testing event ext3_request_blocks: OK [ 13.900395] Testing event ext3_discard_blocks: OK [ 13.913759] Testing event ext3_invalidatepage: OK [ 13.927110] Testing event ext3_releasepage: OK [ 13.940401] Testing event ext3_readpage: OK [ 13.953728] Testing event ext3_journalled_writepage: OK [ 13.967058] Testing event ext3_writeback_writepage: OK [ 13.983046] Testing event ext3_ordered_writepage: OK [ 14.000450] Testing event ext3_journalled_write_end: OK [ 14.017919] Testing event ext3_writeback_write_end: OK [ 14.034732] Testing event ext3_ordered_write_end: OK [ 14.050558] Testing event ext3_write_begin: OK [ 14.063843] Testing event ext3_mark_inode_dirty: OK [ 14.078287] Testing event ext3_drop_inode: OK [ 14.091706] Testing event ext3_evict_inode: OK [ 14.103796] Testing event ext3_allocate_inode: OK [ 14.121894] Testing event ext3_request_inode: OK [ 14.135585] Testing event ext3_free_inode: OK [ 14.148711] Testing event journal_write_superblock: OK [ 14.163789] Testing event jbd_cleanup_journal_tail: OK [ 14.182250] Testing event jbd_do_submit_data: OK [ 14.195813] Testing event jbd_end_commit: OK [ 14.215845] Testing event jbd_drop_transaction: OK [ 14.230490] Testing event jbd_commit_logging: OK [ 14.243786] Testing event jbd_commit_flushing: OK [ 14.262724] Testing event jbd_commit_locking: OK [ 14.277103] Testing event jbd_start_commit: OK [ 14.290473] Testing event jbd_checkpoint: OK [ 14.304906] Testing event jbd2_lock_buffer_stall: OK [ 14.319837] Testing event jbd2_write_superblock: OK [ 14.339921] Testing event jbd2_update_log_tail: OK [ 14.359929] Testing event jbd2_checkpoint_stats: OK [ 14.379967] Testing event jbd2_run_stats: OK [ 14.396053] Testing event jbd2_handle_stats: OK [ 14.413262] Testing event jbd2_handle_extend: OK [ 14.430280] Testing event jbd2_handle_start: OK [ 14.445950] Testing event jbd2_submit_inode_data: OK [ 14.463218] Testing event jbd2_end_commit: OK [ 14.477257] Testing event jbd2_drop_transaction: OK [ 14.490464] Testing event jbd2_commit_logging: OK [ 14.504259] Testing event jbd2_commit_flushing: OK [ 14.520538] Testing event jbd2_commit_locking: OK [ 14.537804] Testing event jbd2_start_commit: OK [ 14.550470] Testing event jbd2_checkpoint: OK [ 14.568331] Testing event ocfs2_remove_block_from_cache: OK [ 14.584695] Testing event ocfs2_remove_metadata_tree: OK [ 14.599852] Testing event ocfs2_remove_metadata_array: OK [ 14.614910] Testing event ocfs2_set_buffer_uptodate_begin: OK [ 14.628293] Testing event ocfs2_set_buffer_uptodate: OK [ 14.641693] Testing event ocfs2_expand_cache: OK [ 14.658471] Testing event ocfs2_insert_cache_tree: OK [ 14.671889] Testing event ocfs2_append_cache_array: OK [ 14.685286] Testing event ocfs2_buffer_cached_end: OK [ 14.698672] Testing event ocfs2_buffer_cached_begin: OK [ 14.712080] Testing event ocfs2_metadata_cache_purge: OK [ 14.725527] Testing event ocfs2_purge_copied_metadata_tree: OK [ 14.745626] Testing event ocfs2_read_blocks_begin: OK [ 14.759033] Testing event ocfs2_write_block: OK [ 14.772453] Testing event ocfs2_read_blocks_end: OK [ 14.823656] Testing event ocfs2_read_blocks_bh: OK [ 14.843902] Testing event ocfs2_read_blocks_from_disk: OK [ 14.857379] Testing event ocfs2_read_blocks_sync_jbd: OK [ 14.954422] Testing event ocfs2_read_blocks_sync: OK [ 14.967308] Testing event ocfs2_wait_on_mount: OK [ 14.980505] Testing event ocfs2_recover_orphans_iput: OK [ 15.005459] Testing event ocfs2_recover_orphans: OK [ 15.021269] Testing event ocfs2_orphan_filldir: OK [ 15.037961] Testing event ocfs2_queue_orphan_scan_end: OK [ 15.061483] Testing event ocfs2_queue_orphan_scan_begin: OK [ 15.091673] Testing event ocfs2_mark_dead_nodes: OK [ 15.126481] Testing event ocfs2_recover_node_skip: OK [ 15.152670] Testing event ocfs2_recover_node: OK [ 15.187514] Testing event ocfs2_replay_journal_skip: OK [ 15.217047] Testing event ocfs2_replay_journal_lock_err: OK [ 15.258115] Testing event ocfs2_replay_journal_recovered: OK [ 15.295984] Testing event ocfs2_recovery_thread: OK [ 15.339301] Testing event ocfs2_recovery_thread_end: OK [ 15.359394] Testing event ocfs2_recovery_thread_node: OK [ 15.397865] Testing event ocfs2_complete_recovery_slot: OK [ 15.420341] Testing event ocfs2_complete_recovery_end: OK [ 15.445837] Testing event ocfs2_complete_recovery: OK [ 15.489459] Testing event ocfs2_journal_shutdown_wait: OK [ 15.529548] Testing event ocfs2_journal_shutdown: OK [ 15.585320] Testing event ocfs2_journal_init_maxlen: OK [ 15.608200] Testing event ocfs2_journal_init: OK [ 15.620800] Testing event ocfs2_journal_dirty: OK [ 15.647302] Testing event ocfs2_journal_access: OK [ 15.661257] Testing event ocfs2_allocate_extend_trans: OK [ 15.677160] Testing event ocfs2_extend_trans_restart: OK [ 15.691252] Testing event ocfs2_extend_trans: OK [ 15.708209] Testing event ocfs2_commit_cache_end: OK [ 15.721022] Testing event ocfs2_commit_cache_begin: OK [ 15.734409] Testing event ocfs2_encode_fh_type: OK [ 15.747954] Testing event ocfs2_encode_fh_parent: OK [ 15.763911] Testing event ocfs2_encode_fh_self: OK [ 15.779173] Testing event ocfs2_encode_fh_begin: OK [ 15.797836] Testing event ocfs2_get_parent_end: OK [ 15.814059] Testing event ocfs2_get_parent: OK [ 15.844580] Testing event ocfs2_get_dentry_end: OK [ 15.934050] Testing event ocfs2_get_dentry_generation: OK [ 16.014403] Testing event ocfs2_get_dentry_stale: OK [ 16.034376] Testing event ocfs2_get_dentry_test_bit: OK [ 16.054444] Testing event ocfs2_get_dentry_begin: OK [ 16.071041] Testing event ocfs2_dentry_attach_lock_found: OK [ 16.095364] Testing event ocfs2_dentry_attach_lock: OK [ 16.118658] Testing event ocfs2_find_local_alias: OK [ 16.225250] Testing event ocfs2_dentry_revalidate_ret: OK [ 16.267181] Testing event ocfs2_dentry_revalidate_nofsdata: OK [ 16.291070] Testing event ocfs2_dentry_revalidate_orphaned: OK [ 16.310835] Testing event ocfs2_dentry_revalidate_delete: OK [ 16.334223] Testing event ocfs2_dentry_revalidate_negative: OK [ 16.357664] Testing event ocfs2_dentry_revalidate: OK [ 16.373593] Testing event ocfs2_orphan_del: OK [ 16.393526] Testing event ocfs2_orphan_add_end: OK [ 16.420971] Testing event ocfs2_orphan_add_begin: OK [ 16.433911] Testing event ocfs2_blkno_stringify: OK [ 16.447768] Testing event ocfs2_symlink_begin: OK [ 16.470785] Testing event ocfs2_create_symlink_data: OK [ 16.579529] Testing event ocfs2_rename_over_existing: OK [ 16.611229] Testing event ocfs2_rename_disagree: OK [ 16.626210] Testing event ocfs2_rename_target_exists: OK [ 16.646948] Testing event ocfs2_rename_not_permitted: OK [ 16.662183] Testing event ocfs2_rename: OK [ 16.677279] Testing event ocfs2_double_lock_end: OK [ 16.694657] Testing event ocfs2_double_lock: OK [ 16.713266] Testing event ocfs2_unlink_noent: OK [ 16.734295] Testing event ocfs2_link: OK [ 16.748206] Testing event ocfs2_mknod: OK [ 16.768162] Testing event ocfs2_lookup_ret: OK [ 16.788180] Testing event ocfs2_mv_orphaned_inode_to_new: OK [ 16.826217] Testing event ocfs2_symlink_create: OK [ 16.857214] Testing event ocfs2_unlink: OK [ 16.882684] Testing event ocfs2_create: OK [ 16.906073] Testing event ocfs2_mkdir: OK [ 16.920489] Testing event ocfs2_lookup: OK [ 16.940535] Testing event ocfs2_prepare_dir_for_insert: OK [ 16.960477] Testing event ocfs2_dx_dir_rebalance_split: OK [ 16.983898] Testing event ocfs2_dx_dir_rebalance: OK [ 17.000459] Testing event ocfs2_extend_dir: OK [ 17.022370] Testing event ocfs2_dx_dir_index_root_block: OK [ 17.038710] Testing event ocfs2_dx_dir_format_cluster: OK [ 17.090444] Testing event ocfs2_dx_dir_attach_index: OK [ 17.129873] Testing event ocfs2_check_dir_for_entry: OK [ 17.157263] Testing event ocfs2_find_files_on_disk: OK [ 17.192057] Testing event ocfs2_readdir: OK [ 17.236248] Testing event ocfs2_delete_entry_dx: OK [ 17.266741] Testing event ocfs2_dx_dir_search_leaf_info: OK [ 17.299957] Testing event ocfs2_dx_dir_search: OK [ 17.380800] Testing event ocfs2_find_entry_el: OK [ 17.482237] Testing event ocfs2_validate_dir_block: OK [ 17.515524] Testing event ocfs2_search_dirblock: OK [ 17.564073] Testing event ocfs2_mark_dquot_dirty: OK [ 17.583814] Testing event ocfs2_acquire_dquot: OK [ 17.603787] Testing event ocfs2_release_dquot: OK [ 17.620465] Testing event ocfs2_write_dquot: OK [ 17.640431] Testing event ocfs2_sync_dquot_helper: OK [ 17.660424] Testing event ocfs2_sync_dquot: OK [ 17.677094] Testing event ocfs2_validate_quota_block: OK [ 17.694420] Testing event olq_set_dquot: OK [ 17.710571] Testing event ocfs2_finish_quota_recovery: OK [ 17.735962] Testing event ocfs2_recover_local_quota_file: OK [ 17.756003] Testing event ocfs2_resmap_claimed_bits_end: OK [ 17.770395] Testing event ocfs2_resmap_claimed_bits_begin: OK [ 17.791008] Testing event ocfs2_resmap_resv_bits: OK [ 17.810407] Testing event ocfs2_cannibalize_resv_end: OK [ 17.830498] Testing event ocfs2_cannibalize_resv_begin: OK [ 17.850434] Testing event ocfs2_resv_find_window_next: OK [ 17.870624] Testing event ocfs2_resv_find_window_prev: OK [ 17.890624] Testing event ocfs2_resv_find_window_begin: OK [ 17.910640] Testing event ocfs2_resmap_find_free_bits_end: OK [ 18.017149] Testing event ocfs2_resmap_find_free_bits_begin: OK [ 18.041953] Testing event ocfs2_resv_insert: OK [ 18.060616] Testing event ocfs2_reflink_xattr_rec: OK [ 18.099789] Testing event ocfs2_reflink_xattr_buckets: OK [ 18.129455] Testing event ocfs2_xattr_bucket_value_refcount: OK [ 18.177523] Testing event ocfs2_xattr_set_entry_index_block: OK [ 18.255498] Testing event ocfs2_xattr_set_entry_bucket: OK [ 18.292962] Testing event ocfs2_create_empty_xattr_block: OK [ 18.318878] Testing event ocfs2_reflink_xattr_header: OK [ 18.341131] Testing event ocfs2_rm_xattr_cluster: OK [ 18.361472] Testing event ocfs2_xattr_bucket_value_truncate: OK [ 18.480493] Testing event ocfs2_add_new_xattr_bucket: OK [ 18.493893] Testing event ocfs2_extend_xattr_bucket: OK [ 18.527591] Testing event ocfs2_add_new_xattr_cluster_insert: OK [ 18.576341] Testing event ocfs2_add_new_xattr_cluster: OK [ 18.611313] Testing event ocfs2_add_new_xattr_cluster_begin: OK [ 18.636051] Testing event ocfs2_adjust_xattr_cross_cluster: OK [ 18.661041] Testing event ocfs2_mv_xattr_buckets: OK [ 18.677191] Testing event ocfs2_cp_xattr_bucket: OK [ 18.693512] Testing event ocfs2_divide_xattr_bucket_move: OK [ 18.732219] Testing event ocfs2_divide_xattr_bucket_begin: OK [ 18.768305] Testing event ocfs2_mv_xattr_bucket_cross_cluster: OK [ 18.788487] Testing event ocfs2_defrag_xattr_bucket: OK [ 18.810825] Testing event ocfs2_xattr_create_index_block: OK [ 18.887039] Testing event ocfs2_xattr_create_index_block_begin: OK [ 18.907254] Testing event ocfs2_cp_xattr_block_to_bucket_end: OK [ 18.921108] Testing event ocfs2_cp_xattr_block_to_bucket_begin: OK [ 18.934977] Testing event ocfs2_iterate_xattr_bucket: OK [ 18.960609] Testing event ocfs2_iterate_xattr_buckets: OK [ 18.984920] Testing event ocfs2_xattr_index_block_find_rec: OK [ 18.998712] Testing event ocfs2_xattr_index_block_find: OK [ 19.013900] Testing event ocfs2_xattr_bucket_find: OK [ 19.028323] Testing event ocfs2_init_xattr_set_ctxt: OK [ 19.043918] Testing event ocfs2_xattr_extend_allocation: OK [ 19.087336] Testing event ocfs2_validate_xattr_block: OK [ 19.123372] Testing event ocfs2_initialize_super: OK [ 19.153978] Testing event ocfs2_dismount_volume: OK [ 19.182650] Testing event ocfs2_statfs: OK [ 19.227508] Testing event ocfs2_put_super: OK [ 19.268167] Testing event ocfs2_parse_options: OK [ 19.355863] Testing event ocfs2_fill_super: OK [ 19.431088] Testing event ocfs2_remount: OK [ 19.489884] Testing event ocfs2_do_node_down: OK [ 19.514548] Testing event ocfs2_find_slot: OK [ 19.546009] Testing event ocfs2_map_slot_buffers_block: OK [ 19.560373] Testing event ocfs2_map_slot_buffers: OK [ 19.573776] Testing event ocfs2_refresh_slot_info: OK [ 19.606964] Testing event ocfs2_read_virt_blocks: OK [ 19.649211] Testing event ocfs2_mark_inode_dirty: OK [ 19.688354] Testing event ocfs2_inode_revalidate: OK [ 19.716983] Testing event ocfs2_drop_inode: OK [ 19.747258] Testing event ocfs2_clear_inode: OK [ 19.816721] Testing event ocfs2_delete_inode: OK [ 19.850582] Testing event ocfs2_cleanup_delete_inode: OK [ 19.935908] Testing event ocfs2_query_inode_wipe_end: OK [ 20.073768] Testing event ocfs2_query_inode_wipe_succ: OK [ 20.087041] Testing event ocfs2_query_inode_wipe_begin: OK [ 20.100372] Testing event ocfs2_inode_is_valid_to_delete: OK [ 20.113705] Testing event ocfs2_validate_inode_block: OK [ 20.127059] Testing event ocfs2_check_orphan_recovery_state: OK [ 20.140359] Testing event ocfs2_read_locked_inode: OK [ 20.153710] Testing event ocfs2_populate_inode: OK [ 20.170385] Testing event ocfs2_find_actor: OK [ 20.183706] Testing event ocfs2_iget_end: OK [ 20.197045] Testing event ocfs2_iget5_locked: OK [ 20.289869] Testing event ocfs2_iget_begin: OK [ 20.341080] Testing event generic_file_aio_read_ret: OK [ 20.363722] Testing event ocfs2_prepare_inode_for_write: OK [ 20.380353] Testing event ocfs2_remove_inode_range: OK [ 20.403736] Testing event ocfs2_zero_partial_clusters_range2: OK [ 20.420395] Testing event ocfs2_zero_partial_clusters_range1: OK [ 20.492438] Testing event ocfs2_zero_partial_clusters: OK [ 20.530449] Testing event ocfs2_write_remove_suid: OK [ 20.543724] Testing event ocfs2_setattr: OK [ 20.567662] Testing event ocfs2_zero_extend: OK [ 20.580439] Testing event ocfs2_zero_extend_range: OK [ 20.598454] Testing event ocfs2_write_zero_page: OK [ 20.613799] Testing event ocfs2_extend_allocation_end: OK [ 20.630496] Testing event ocfs2_extend_allocation: OK [ 20.694001] Testing event ocfs2_truncate_file_error: OK [ 20.707138] Testing event ocfs2_truncate_file: OK [ 20.723784] Testing event ocfs2_file_aio_read: OK [ 20.785909] Testing event ocfs2_file_splice_read: OK [ 20.889157] Testing event ocfs2_file_splice_write: OK [ 20.910676] Testing event ocfs2_file_aio_write: OK [ 20.927258] Testing event ocfs2_sync_file: OK [ 20.943909] Testing event ocfs2_file_release: OK [ 20.957281] Testing event ocfs2_file_open: OK [ 20.973725] Testing event ocfs2_fault: OK [ 20.987828] Testing event ocfs2_write_end_inline: OK [ 21.004453] Testing event ocfs2_write_begin_nolock: OK [ 21.021578] Testing event ocfs2_try_to_write_inline_data: OK [ 21.037836] Testing event ocfs2_bmap: OK [ 21.054646] Testing event ocfs2_writepage: OK [ 21.070440] Testing event ocfs2_readpage: OK [ 21.087096] Testing event ocfs2_get_block_end: OK [ 21.155754] Testing event ocfs2_get_block: OK [ 21.211824] Testing event ocfs2_symlink_get_block: OK [ 21.231004] Testing event ocfs2_refcount_cow_hunk: OK [ 21.247904] Testing event ocfs2_make_clusters_writable: OK [ 21.264824] Testing event ocfs2_replace_clusters: OK [ 21.281991] Testing event ocfs2_clear_ext_refcount: OK [ 21.301639] Testing event ocfs2_duplicate_clusters_by_jbd: OK [ 21.313856] Testing event ocfs2_duplicate_clusters_by_page: OK [ 21.330737] Testing event ocfs2_lock_refcount_allocators: OK [ 21.347266] Testing event ocfs2_prepare_refcount_change_for_del: OK [ 21.365239] Testing event ocfs2_add_refcount_flag: OK [ 21.383938] Testing event ocfs2_calc_refcount_meta_credits_iterate: OK [ 21.400660] Testing event ocfs2_calc_refcount_meta_credits: OK [ 21.417111] Testing event ocfs2_mark_extent_refcounted: OK [ 21.431203] Testing event ocfs2_decrease_refcount: OK [ 21.443763] Testing event ocfs2_decrease_refcount_rec: OK [ 21.457120] Testing event ocfs2_restore_refcount_block: OK [ 21.473824] Testing event ocfs2_remove_refcount_extent: OK [ 21.487119] Testing event ocfs2_increase_refcount_split: OK [ 21.515044] Testing event ocfs2_increase_refcount_insert: OK [ 21.530458] Testing event ocfs2_increase_refcount_change: OK [ 21.543764] Testing event ocfs2_increase_refcount_begin: OK [ 21.563807] Testing event ocfs2_split_refcount_rec_insert: OK [ 21.577801] Testing event ocfs2_split_refcount_rec: OK [ 21.590720] Testing event ocfs2_insert_refcount_rec: OK [ 21.607113] Testing event ocfs2_new_leaf_refcount_block: OK [ 21.620434] Testing event ocfs2_divide_leaf_refcount_block: OK [ 21.634147] Testing event ocfs2_expand_inline_ref_root: OK [ 21.647101] Testing event ocfs2_change_refcount_rec: OK [ 21.660435] Testing event ocfs2_create_refcount_tree_blkno: OK [ 21.673794] Testing event ocfs2_create_refcount_tree: OK [ 21.690456] Testing event ocfs2_purge_refcount_trees: OK [ 21.712358] Testing event ocfs2_validate_refcount_block: OK [ 21.727111] Testing event ocfs2_test_inode_bit: OK [ 21.740433] Testing event ocfs2_test_suballoc_bit: OK [ 21.753783] Testing event ocfs2_get_suballoc_slot_bit: OK [ 21.767092] Testing event ocfs2_free_clusters: OK [ 21.780435] Testing event ocfs2_free_suballoc_bits: OK [ 21.793801] Testing event ocfs2_block_group_clear_bits: OK [ 21.807088] Testing event ocfs2_claim_new_inode_at_loc: OK [ 21.820437] Testing event ocfs2_claim_suballoc_bits: OK [ 21.833911] Testing event ocfs2_search_chain_end: OK [ 21.847130] Testing event ocfs2_search_chain_succ: OK [ 21.860920] Testing event ocfs2_search_chain_begin: OK [ 21.873830] Testing event ocfs2_block_group_search_max_block: OK [ 21.888774] Testing event ocfs2_cluster_group_search_max_block: OK [ 21.903792] Testing event ocfs2_cluster_group_search_wrong_max_bits: OK [ 21.917136] Testing event ocfs2_relink_block_group: OK [ 21.930462] Testing event ocfs2_block_group_set_bits: OK [ 21.943847] Testing event ocfs2_reserve_new_inode_new_group: OK [ 21.957120] Testing event ocfs2_reserve_suballoc_bits_no_new_group: OK [ 21.970425] Testing event ocfs2_reserve_suballoc_bits_nospc: OK [ 21.983813] Testing event ocfs2_block_group_alloc: OK [ 21.997101] Testing event ocfs2_block_group_alloc_discontig: OK [ 22.010425] Testing event ocfs2_block_group_alloc_contig: OK [ 22.023852] Testing event ocfs2_validate_group_descriptor: OK [ 22.037106] Testing event ocfs2_group_add: OK [ 22.050449] Testing event ocfs2_group_extend: OK [ 22.073787] Testing event ocfs2_update_last_group_and_inode: OK [ 22.092323] Testing event ocfs2_local_alloc_new_window_result: OK [ 22.110435] Testing event ocfs2_local_alloc_new_window: OK [ 22.123800] Testing event ocfs2_sync_local_to_main_free: OK [ 22.140425] Testing event ocfs2_sync_local_to_main: OK [ 22.153774] Testing event ocfs2_local_alloc_find_clear_bits: OK [ 22.167112] Testing event ocfs2_local_alloc_find_clear_bits_search_bitmap: OK [ 22.180417] Testing event ocfs2_local_alloc_count_bits: OK [ 22.193805] Testing event ocfs2_reserve_local_alloc_bits: OK [ 22.207113] Testing event ocfs2_begin_local_alloc_recovery: OK [ 22.220419] Testing event ocfs2_load_local_alloc: OK [ 22.233786] Testing event ocfs2_alloc_should_use_local: OK [ 22.267201] Testing event ocfs2_la_set_sizes: OK [ 22.287122] Testing event ocfs2_trim_fs: OK [ 22.300458] Testing event ocfs2_trim_group: OK [ 22.313813] Testing event ocfs2_trim_extent: OK [ 22.327125] Testing event ocfs2_cache_block_dealloc: OK [ 22.340457] Testing event ocfs2_run_deallocs: OK [ 22.353886] Testing event ocfs2_cache_cluster_dealloc: OK [ 22.367130] Testing event ocfs2_free_cached_blocks: OK [ 22.380430] Testing event ocfs2_complete_truncate_log_recovery: OK [ 22.393793] Testing event ocfs2_truncate_log_recovery_num: OK [ 22.407120] Testing event ocfs2_begin_truncate_log_recovery: OK [ 22.420454] Testing event ocfs2_flush_truncate_log: OK [ 22.433723] Testing event ocfs2_replay_truncate_records: OK [ 22.447072] Testing event ocfs2_truncate_log_append: OK [ 22.460443] Testing event ocfs2_mark_extent_written: OK [ 22.473789] Testing event ocfs2_add_clusters_in_btree_ret: OK [ 22.487050] Testing event ocfs2_rotate_leaf: OK [ 22.500414] Testing event ocfs2_validate_extent_block: OK [ 22.513758] Testing event ocfs2_commit_truncate: OK [ 22.527060] Testing event ocfs2_remove_extent: OK [ 22.540400] Testing event ocfs2_split_extent: OK [ 22.553760] Testing event ocfs2_insert_extent: OK [ 22.567112] Testing event ocfs2_rotate_subtree: OK [ 22.580462] Testing event ocfs2_grow_tree: OK [ 22.593760] Testing event ocfs2_complete_edge_insert: OK [ 22.607085] Testing event ocfs2_num_free_extents: OK [ 22.627103] Testing event ocfs2_add_clusters_in_btree: OK [ 22.647103] Testing event ocfs2_insert_extent_start: OK [ 22.660418] Testing event ocfs2_append_rec_to_path: OK [ 22.673770] Testing event ocfs2_rotate_tree_right: OK [ 22.687164] Testing event ocfs2_adjust_rightmost_branch: OK [ 22.700430] Testing event btrfs_workqueue_destroy: OK [ 22.713867] Testing event btrfs_workqueue_alloc: OK [ 22.727166] Testing event btrfs_ordered_sched: OK [ 22.865790] Testing event btrfs_all_work_done: OK [ 22.920428] Testing event btrfs_normal_work_done: OK [ 23.035794] Testing event btrfs_work_sched: OK [ 23.050377] Testing event btrfs_work_queued: OK [ 23.063722] Testing event free_extent_state: OK [ 23.077091] Testing event alloc_extent_state: OK [ 23.100413] Testing event btrfs_setup_cluster: OK [ 23.120460] Testing event btrfs_failed_cluster_setup: OK [ 23.225925] Testing event btrfs_find_cluster: OK [ 23.246034] Testing event btrfs_reserve_extent_cluster: OK [ 23.280489] Testing event btrfs_reserve_extent: OK [ 23.300482] Testing event find_free_extent: OK [ 23.320422] Testing event btrfs_reserved_extent_free: OK [ 23.340664] Testing event btrfs_reserved_extent_alloc: OK [ 23.363837] Testing event btrfs_space_reservation: OK [ 23.398289] Testing event btrfs_cow_block: OK [ 23.423806] Testing event btrfs_chunk_free: OK [ 23.456206] Testing event btrfs_chunk_alloc: OK [ 23.480448] Testing event run_delayed_ref_head: OK [ 23.500432] Testing event add_delayed_ref_head: OK [ 23.546006] Testing event run_delayed_data_ref: OK [ 23.580463] Testing event add_delayed_data_ref: OK [ 23.606153] Testing event run_delayed_tree_ref: OK [ 23.630523] Testing event add_delayed_tree_ref: OK [ 23.785842] Testing event btrfs_sync_fs: OK [ 23.826115] Testing event btrfs_sync_file: OK [ 23.853778] Testing event btrfs_writepage_end_io_hook: OK [ 23.900470] Testing event __extent_writepage: OK [ 23.920436] Testing event btrfs_ordered_extent_put: OK [ 23.966219] Testing event btrfs_ordered_extent_start: OK [ 23.990433] Testing event btrfs_ordered_extent_remove: OK [ 24.013791] Testing event btrfs_ordered_extent_add: OK [ 24.125952] Testing event btrfs_get_extent: OK [ 24.146196] Testing event btrfs_inode_evict: OK [ 24.170448] Testing event btrfs_inode_request: OK [ 24.187084] Testing event btrfs_inode_new: OK [ 24.203726] Testing event btrfs_transaction_commit: OK [ 24.220500] Testing event gfs2_rs: OK [ 24.237179] Testing event gfs2_block_alloc: OK [ 24.253894] Testing event gfs2_bmap: OK [ 24.270470] Testing event gfs2_ail_flush: OK [ 24.287162] Testing event gfs2_log_blocks: OK [ 24.304044] Testing event gfs2_log_flush: OK [ 24.320475] Testing event gfs2_pin: OK [ 24.337189] Testing event gfs2_glock_lock_time: OK [ 24.353693] Testing event gfs2_glock_queue: OK [ 24.370741] Testing event gfs2_promote: OK [ 24.387125] Testing event gfs2_demote_rq: OK [ 24.403771] Testing event gfs2_glock_put: OK [ 24.420411] Testing event gfs2_glock_state_change: OK [ 24.437085] Testing event block_rq_remap: OK [ 24.453694] Testing event block_bio_remap: OK [ 24.470412] Testing event block_split: OK [ 24.487070] Testing event block_unplug: OK [ 24.503825] Testing event block_plug: OK [ 24.520550] Testing event block_sleeprq: OK [ 24.541510] Testing event block_getrq: OK [ 24.557541] Testing event block_bio_queue: OK [ 24.579966] Testing event block_bio_frontmerge: OK [ 24.597125] Testing event block_bio_backmerge: OK [ 24.612821] Testing event block_bio_complete: OK [ 24.628215] Testing event block_bio_bounce: OK [ 24.643743] Testing event block_rq_issue: OK [ 24.663850] Testing event block_rq_insert: OK [ 24.677205] Testing event block_rq_complete: OK [ 24.697072] Testing event block_rq_requeue: OK [ 24.713834] Testing event block_rq_abort: OK [ 24.734802] Testing event block_dirty_buffer: OK [ 24.754904] Testing event block_touch_buffer: OK [ 24.776000] Testing event swiotlb_bounced: OK [ 24.800876] Testing event gpio_value: OK [ 24.814983] Testing event gpio_direction: OK [ 24.833881] Testing event regulator_set_voltage_complete: OK [ 24.847281] Testing event regulator_set_voltage: OK [ 24.863945] Testing event regulator_disable_complete: OK [ 24.877345] Testing event regulator_disable: OK [ 24.946393] Testing event regulator_enable_complete: OK [ 24.966269] Testing event regulator_enable_delay: OK [ 24.984068] Testing event regulator_enable: OK [ 25.000606] Testing event urandom_read: OK [ 25.058148] Testing event random_read: OK [ 25.073823] Testing event extract_entropy_user: OK [ 25.130797] Testing event extract_entropy: OK [ 25.154447] Testing event get_random_bytes_arch: OK [ 25.178146] Testing event get_random_bytes: OK [ 25.194745] Testing event xfer_secondary_pool: OK [ 25.208945] Testing event add_disk_randomness: OK [ 25.236218] Testing event add_input_randomness: OK [ 25.253749] Testing event debit_entropy: OK [ 25.356935] Testing event push_to_pool: OK [ 25.370585] Testing event credit_entropy_bits: OK [ 25.390555] Testing event mix_pool_bytes_nolock: OK [ 25.404775] Testing event mix_pool_bytes: OK [ 25.420834] Testing event add_device_randomness: OK [ 25.434772] Testing event drm_vblank_event_delivered: OK [ 25.447605] Testing event drm_vblank_event_queued: OK [ 25.470853] Testing event drm_vblank_event: OK [ 25.484577] Testing event regcache_drop_region: OK [ 25.514660] Testing event regmap_async_complete_done: OK [ 25.556894] Testing event regmap_async_complete_start: OK [ 25.580497] Testing event regmap_async_io_complete: OK [ 25.597110] Testing event regmap_async_write_start: OK [ 25.613847] Testing event regmap_cache_bypass: OK [ 25.630929] Testing event regmap_cache_only: OK [ 25.733261] Testing event regcache_sync: OK [ 25.748291] Testing event regmap_hw_write_done: OK [ 25.760595] Testing event regmap_hw_write_start: OK [ 25.774469] Testing event regmap_hw_read_done: OK [ 25.833987] Testing event regmap_hw_read_start: OK [ 25.847532] Testing event regmap_reg_read_cache: OK [ 25.876232] Testing event regmap_reg_read: OK [ 25.937631] Testing event regmap_reg_write: OK [ 25.957416] Testing event fence_wait_end: OK [ 26.040416] Testing event fence_wait_start: OK [ 26.078387] Testing event fence_signaled: OK [ 26.144215] Testing event fence_enable_signal: OK [ 26.214931] Testing event fence_destroy: OK [ 26.252567] Testing event fence_init: OK [ 26.323881] Testing event fence_emit: OK [ 26.337209] Testing event fence_annotate_wait_on: OK [ 26.350429] Testing event scsi_eh_wakeup: OK [ 26.392115] Testing event scsi_dispatch_cmd_timeout: OK [ 26.452277] Testing event scsi_dispatch_cmd_done: OK [ 26.606529] Testing event scsi_dispatch_cmd_error: OK [ 26.682674] Testing event scsi_dispatch_cmd_start: OK [ 26.742285] Testing event target_cmd_complete: OK [ 26.781126] Testing event target_sequencer_start: OK [ 26.816374] Testing event spi_transfer_stop: OK [ 26.846622] Testing event spi_transfer_start: OK [ 26.881717] Testing event spi_message_done: OK [ 26.911086] Testing event spi_message_start: OK [ 26.949762] Testing event spi_message_submit: OK [ 26.994839] Testing event spi_master_busy: OK [ 27.035020] Testing event spi_master_idle: OK [ 27.133880] Testing event smbus_result: OK [ 27.170332] Testing event smbus_reply: OK [ 27.207174] Testing event smbus_read: OK [ 27.240494] Testing event smbus_write: OK [ 27.276376] Testing event i2c_result: OK [ 27.319832] Testing event i2c_reply: OK [ 27.337232] Testing event i2c_read: OK [ 27.350640] Testing event i2c_write: OK [ 27.393316] Testing event v4l2_qbuf: OK [ 27.427966] Testing event v4l2_dqbuf: OK [ 27.470345] Testing event snd_soc_cache_sync: OK [ 27.517059] Testing event snd_soc_jack_notify: OK [ 27.546151] Testing event snd_soc_jack_report: OK [ 27.560389] Testing event snd_soc_jack_irq: OK [ 27.573827] Testing event snd_soc_dapm_connected: OK [ 27.636812] Testing event snd_soc_dapm_input_path: OK [ 27.650455] Testing event snd_soc_dapm_output_path: OK [ 27.664420] Testing event snd_soc_dapm_walk_done: OK [ 27.677578] Testing event snd_soc_dapm_widget_event_done: OK [ 27.690414] Testing event snd_soc_dapm_widget_event_start: OK [ 27.703935] Testing event snd_soc_dapm_widget_power: OK [ 27.717067] Testing event snd_soc_dapm_done: OK [ 27.767144] Testing event snd_soc_dapm_start: OK [ 27.780477] Testing event snd_soc_bias_level_done: OK [ 27.793722] Testing event snd_soc_bias_level_start: OK [ 27.808733] Testing event udp_fail_queue_rcv_skb: OK [ 27.820384] Testing event sock_exceed_buf_limit: OK [ 27.833748] Testing event sock_rcvqueue_full: OK [ 27.847123] Testing event napi_poll: OK [ 27.926248] Testing event netif_rx_ni_entry: OK [ 27.940383] Testing event netif_rx_entry: OK [ 27.953732] Testing event netif_receive_skb_entry: OK [ 27.967173] Testing event napi_gro_receive_entry: OK [ 27.980440] Testing event napi_gro_frags_entry: OK [ 27.993776] Testing event netif_rx: OK [ 28.007058] Testing event netif_receive_skb: OK [ 28.020529] Testing event net_dev_queue: OK [ 28.033781] Testing event net_dev_xmit: OK [ 28.047174] Testing event net_dev_start_xmit: OK [ 28.060489] Testing event skb_copy_datagram_iovec: OK [ 28.084973] Testing event consume_skb: OK [ 28.101599] Testing event kfree_skb: OK [ 28.207296] Running tests on trace event systems: [ 28.207926] Testing event system skb: OK [ 28.253032] Testing event system net: OK [ 28.286121] Testing event system napi: OK [ 28.301547] Testing event system sock: OK [ 28.313841] Testing event system udp: OK [ 28.347020] Testing event system asoc: OK [ 28.385329] Testing event system v4l2: OK [ 28.401565] Testing event system i2c: OK [ 28.414243] Testing event system spi: OK [ 28.493089] Testing event system target: OK [ 28.517114] Testing event system scsi: OK [ 28.541061] Testing event system fence: OK [ 28.574044] Testing event system regmap: OK [ 28.605292] Testing event system drm: OK [ 28.634975] Testing event system random: OK [ 28.724176] Testing event system regulator: OK [ 28.756485] Testing event system gpio: OK [ 28.777215] Testing event system swiotlb: OK [ 28.804696] Testing event system block: OK [ 28.833849] Testing event system gfs2: OK [ 28.875198] Testing event system btrfs: OK [ 28.925536] Testing event system ocfs2: OK [ 29.038475] Testing event system jbd2: OK [ 29.094457] Testing event system jbd: OK [ 29.116469] Testing event system ext3: OK [ 29.185327] Testing event system writeback: OK [ 29.261222] Testing event system migrate: OK [ 29.285149] Testing event system compaction: OK [ 29.348726] Testing event system kmem: OK [ 29.372623] Testing event system vmscan: OK [ 29.395739] Testing event system pagemap: OK [ 29.417980] Testing event system oom: OK [ 29.440670] Testing event system filemap: OK [ 29.463557] Testing event system power: OK [ 29.508635] Testing event system test: OK [ 29.529586] Testing event system timer: OK [ 29.559193] Testing event system rcu: OK [ 29.596009] Testing event system printk: OK [ 29.628977] Testing event system lock: OK [ 29.656569] Testing event system sched: OK [ 29.729773] Testing event system workqueue: OK [ 29.811834] Testing event system signal: OK [ 29.905918] Testing event system irq: OK [ 30.014081] Testing event system task: OK [ 30.117125] Testing event system exceptions: OK [ 30.218071] Testing event system tlb: OK [ 30.473091] Testing event system mce: OK [ 30.577122] Testing event system raw_syscalls: OK [ 30.684110] Testing event system vsyscall: OK [ 30.760099] Testing event system nmi: OK [ 30.844068] Testing event system irq_vectors: OK [ 31.193089] Running tests on all trace events: [ 31.193741] Testing all events: OK [ 32.437891] Running tests again, along with the function tracer [ 32.438962] Running tests on trace events: [ 32.439686] Testing event thermal_apic_exit: OK [ 32.464067] Testing event thermal_apic_entry: OK [ 32.491676] Testing event threshold_apic_exit: OK [ 32.514233] Testing event threshold_apic_entry: OK [ 32.541789] Testing event call_function_single_exit: OK [ 32.573924] Testing event call_function_single_entry: OK [ 32.603964] Testing event call_function_exit: OK [ 32.641785] Testing event call_function_entry: OK [ 32.667674] Testing event irq_work_exit: OK [ 32.697613] Testing event irq_work_entry: OK [ 32.729605] Testing event x86_platform_ipi_exit: OK [ 32.750988] Testing event x86_platform_ipi_entry: OK [ 32.791711] Testing event error_apic_exit: OK [ 32.812964] Testing event error_apic_entry: OK [ 32.832903] Testing event spurious_apic_exit: OK [ 32.852906] Testing event spurious_apic_entry: OK [ 32.879515] Testing event reschedule_exit: OK [ 32.899344] Testing event reschedule_entry: OK [ 32.914283] Testing event local_timer_exit: OK [ 32.953180] Testing event local_timer_entry: OK [ 32.975028] Testing event nmi_handler: OK [ 32.990936] Testing event emulate_vsyscall: OK [ 33.016300] Testing event sys_exit: OK [ 33.126041] Testing event sys_enter: OK [ 33.456031] Testing event mce_record: OK [ 33.766061] Testing event tlb_flush: OK [ 33.962140] Testing event page_fault_kernel: OK [ 33.982835] Testing event page_fault_user: OK [ 33.997589] Testing event task_rename: OK [ 34.014247] Testing event task_newtask: OK [ 34.032849] Testing event softirq_raise: OK [ 34.049626] Testing event softirq_exit: OK [ 34.203101] Testing event softirq_entry: OK [ 34.217666] Testing event irq_handler_exit: OK [ 34.247739] Testing event irq_handler_entry: OK [ 34.271085] Testing event signal_deliver: OK [ 34.296839] Testing event signal_generate: OK [ 34.486133] Testing event workqueue_execute_end: OK [ 34.806080] Testing event workqueue_execute_start: OK [ 34.986123] Testing event workqueue_activate_work: OK [ 35.065610] Testing event workqueue_queue_work: OK [ 35.141304] Testing event sched_wake_idle_without_ipi: OK [ 35.270181] Testing event sched_swap_numa: OK [ 35.324490] Testing event sched_stick_numa: OK [ 35.391012] Testing event sched_move_numa: OK [ 35.443996] Testing event sched_process_hang: OK [ 35.580379] Testing event sched_pi_setprio: OK [ 35.653785] Testing event sched_stat_runtime: OK [ 35.690941] Testing event sched_stat_blocked: OK [ 35.704145] Testing event sched_stat_iowait: OK [ 35.724160] Testing event sched_stat_sleep: OK [ 35.740980] Testing event sched_stat_wait: OK [ 35.764257] Testing event sched_process_exec: OK [ 35.797001] Testing event sched_process_fork: OK [ 35.817038] Testing event sched_process_wait: OK [ 35.837468] Testing event sched_wait_task: OK [ 35.857848] Testing event sched_process_exit: OK [ 35.907441] Testing event sched_process_free: OK [ 35.976107] Testing event sched_migrate_task: OK [ 36.127428] Testing event sched_switch: OK [ 36.176999] Testing event sched_wakeup_new: OK [ 36.207267] Testing event sched_wakeup: OK [ 36.264739] Testing event sched_kthread_stop_ret: OK [ 36.308787] Testing event sched_kthread_stop: OK [ 36.360314] Testing event lock_acquired: OK [ 36.407469] Testing event lock_contended: OK [ 36.454629] Testing event lock_release: OK [ 36.487931] Testing event lock_acquire: OK [ 36.540892] Testing event console: OK [ 36.585381] Testing event rcu_utilization: OK [ 36.670590] Testing event itimer_expire: OK [ 36.717665] Testing event itimer_state: OK [ 36.771940] Testing event hrtimer_cancel: OK [ 36.811477] Testing event hrtimer_expire_exit: OK [ 36.850774] Testing event hrtimer_expire_entry: OK [ 36.907769] Testing event hrtimer_start: OK [ 36.942419] Testing event hrtimer_init: OK [ 36.977276] Testing event timer_cancel: OK [ 37.019701] Testing event timer_expire_exit: OK [ 37.037602] Testing event timer_expire_entry: OK [ 37.050830] Testing event timer_start: OK [ 37.104412] Testing event timer_init: OK [ 37.147768] Testing event ftrace_test_filter: OK [ 37.206312] Testing event dev_pm_qos_remove_request: OK [ 37.220929] Testing event dev_pm_qos_update_request: OK [ 37.235281] Testing event dev_pm_qos_add_request: OK [ 37.251221] Testing event pm_qos_update_flags: OK [ 37.264183] Testing event pm_qos_update_target: OK [ 37.278853] Testing event pm_qos_update_request_timeout: OK [ 37.294196] Testing event pm_qos_remove_request: OK [ 37.307523] Testing event pm_qos_update_request: OK [ 37.346484] Testing event pm_qos_add_request: OK [ 37.386973] Testing event power_domain_target: OK [ 37.404096] Testing event clock_set_rate: OK [ 37.417494] Testing event clock_disable: OK [ 37.447099] Testing event clock_enable: OK [ 37.474022] Testing event wakeup_source_deactivate: OK [ 37.506393] Testing event wakeup_source_activate: OK [ 37.554900] Testing event suspend_resume: OK [ 37.777861] Testing event device_pm_callback_end: OK [ 37.830594] Testing event device_pm_callback_start: OK [ 37.878208] Testing event cpu_frequency: OK [ 37.932287] Testing event pstate_sample: OK [ 37.965323] Testing event cpu_idle: OK [ 38.023865] Testing event mm_filemap_add_to_page_cache: OK [ 38.060477] Testing event mm_filemap_delete_from_page_cache: OK [ 38.108263] Testing event oom_score_adj_update: OK [ 38.140902] Testing event mm_lru_activate: OK [ 38.197285] Testing event mm_lru_insertion: OK [ 38.306168] Testing event mm_vmscan_lru_shrink_inactive: OK [ 38.463610] Testing event mm_vmscan_writepage: OK [ 38.484292] Testing event mm_vmscan_memcg_isolate: OK [ 38.507365] Testing event mm_vmscan_lru_isolate: OK [ 38.520765] Testing event mm_shrink_slab_end: OK [ 38.534165] Testing event mm_shrink_slab_start: OK [ 38.547508] Testing event mm_vmscan_memcg_softlimit_reclaim_end: OK [ 38.560750] Testing event mm_vmscan_memcg_reclaim_end: OK [ 38.574261] Testing event mm_vmscan_direct_reclaim_end: OK [ 38.587492] Testing event mm_vmscan_memcg_softlimit_reclaim_begin: OK [ 38.600854] Testing event mm_vmscan_memcg_reclaim_begin: OK [ 38.614101] Testing event mm_vmscan_direct_reclaim_begin: OK [ 38.654443] Testing event mm_vmscan_wakeup_kswapd: OK [ 38.714215] Testing event mm_vmscan_kswapd_wake: OK [ 38.782899] Testing event mm_vmscan_kswapd_sleep: OK [ 38.833465] Testing event mm_page_alloc_extfrag: OK [ 38.867355] Testing event mm_page_pcpu_drain: OK [ 38.888677] Testing event mm_page_alloc_zone_locked: OK [ 38.913892] Testing event mm_page_alloc: OK [ 38.953831] Testing event mm_page_free_batched: OK [ 38.997629] Testing event mm_page_free: OK [ 39.057554] Testing event kmem_cache_free: OK [ 39.100277] Testing event kfree: OK [ 39.153271] Testing event kmem_cache_alloc_node: OK [ 39.217231] Testing event kmalloc_node: OK [ 39.230907] Testing event kmem_cache_alloc: OK [ 39.276817] Testing event kmalloc: OK [ 39.291172] Testing event mm_compaction_end: OK [ 39.304199] Testing event mm_compaction_begin: OK [ 39.317594] Testing event mm_compaction_migratepages: OK [ 39.330864] Testing event mm_compaction_isolate_freepages: OK [ 39.344171] Testing event mm_compaction_isolate_migratepages: OK [ 39.360789] Testing event mm_numa_migrate_ratelimit: OK [ 39.374059] Testing event mm_migrate_pages: OK [ 39.387634] Testing event writeback_single_inode: OK [ 39.400977] Testing event writeback_single_inode_start: OK [ 39.414221] Testing event writeback_wait_iff_congested: OK [ 39.427522] Testing event writeback_congestion_wait: OK [ 39.440832] Testing event writeback_sb_inodes_requeue: OK [ 39.454206] Testing event balance_dirty_pages: OK [ 39.467755] Testing event bdi_dirty_ratelimit: OK [ 39.480839] Testing event global_dirty_state: OK [ 39.517656] Testing event writeback_queue_io: OK [ 39.575590] Testing event wbc_writepage: OK [ 39.627139] Testing event writeback_bdi_unregister: OK [ 39.737204] Testing event writeback_bdi_register: OK [ 39.790868] Testing event writeback_wake_background: OK [ 39.804375] Testing event writeback_nowork: OK [ 39.817635] Testing event writeback_pages_written: OK [ 39.831056] Testing event writeback_wait: OK [ 39.844278] Testing event writeback_written: OK [ 39.860947] Testing event writeback_start: OK [ 39.874309] Testing event writeback_exec: OK [ 39.887686] Testing event writeback_queue: OK [ 39.900970] Testing event writeback_write_inode: OK [ 39.917573] Testing event writeback_write_inode_start: OK [ 40.016752] Testing event writeback_dirty_inode: OK [ 40.030860] Testing event writeback_dirty_inode_start: OK [ 40.044262] Testing event writeback_dirty_page: OK [ 40.060920] Testing event ext3_load_inode: OK [ 40.074299] Testing event ext3_get_blocks_exit: OK [ 40.090959] Testing event ext3_get_blocks_enter: OK [ 40.146734] Testing event ext3_truncate_exit: OK [ 40.160995] Testing event ext3_truncate_enter: OK [ 40.174237] Testing event ext3_unlink_exit: OK [ 40.187550] Testing event ext3_unlink_enter: OK [ 40.200877] Testing event ext3_direct_IO_exit: OK [ 40.214214] Testing event ext3_direct_IO_enter: OK [ 40.227546] Testing event ext3_read_block_bitmap: OK [ 40.240993] Testing event ext3_forget: OK [ 40.254277] Testing event ext3_reserved: OK [ 40.267591] Testing event ext3_alloc_new_reservation: OK [ 40.280924] Testing event ext3_discard_reservation: OK [ 40.294268] Testing event ext3_rsv_window_add: OK [ 40.307605] Testing event ext3_sync_fs: OK [ 40.320926] Testing event ext3_sync_file_exit: OK [ 40.334279] Testing event ext3_sync_file_enter: OK [ 40.347556] Testing event ext3_free_blocks: OK [ 40.360997] Testing event ext3_allocate_blocks: OK [ 40.380931] Testing event ext3_request_blocks: OK [ 40.394225] Testing event ext3_discard_blocks: OK [ 40.407578] Testing event ext3_invalidatepage: OK [ 40.420875] Testing event ext3_releasepage: OK [ 40.434215] Testing event ext3_readpage: OK [ 40.447547] Testing event ext3_journalled_writepage: OK [ 40.460910] Testing event ext3_writeback_writepage: OK [ 40.474199] Testing event ext3_ordered_writepage: OK [ 40.487586] Testing event ext3_journalled_write_end: OK [ 40.500866] Testing event ext3_writeback_write_end: OK [ 40.514261] Testing event ext3_ordered_write_end: OK [ 40.527601] Testing event ext3_write_begin: OK [ 40.540863] Testing event ext3_mark_inode_dirty: OK [ 40.554236] Testing event ext3_drop_inode: OK [ 40.567537] Testing event ext3_evict_inode: OK [ 40.580965] Testing event ext3_allocate_inode: OK [ 40.594243] Testing event ext3_request_inode: OK [ 40.607584] Testing event ext3_free_inode: OK [ 40.620914] Testing event journal_write_superblock: OK [ 40.634261] Testing event jbd_cleanup_journal_tail: OK [ 40.647579] Testing event jbd_do_submit_data: OK [ 40.661160] Testing event jbd_end_commit: OK [ 40.674290] Testing event jbd_drop_transaction: OK [ 40.690978] Testing event jbd_commit_logging: OK [ 40.704317] Testing event jbd_commit_flushing: OK [ 40.717601] Testing event jbd_commit_locking: OK [ 40.754298] Testing event jbd_start_commit: OK [ 40.810392] Testing event jbd_checkpoint: OK [ 40.935051] Testing event jbd2_lock_buffer_stall: OK [ 40.950883] Testing event jbd2_write_superblock: OK [ 40.964197] Testing event jbd2_update_log_tail: OK [ 40.980955] Testing event jbd2_checkpoint_stats: OK [ 40.994272] Testing event jbd2_run_stats: OK [ 41.008238] Testing event jbd2_handle_stats: OK [ 41.024221] Testing event jbd2_handle_extend: OK [ 41.038219] Testing event jbd2_handle_start: OK [ 41.054341] Testing event jbd2_submit_inode_data: OK [ 41.067638] Testing event jbd2_end_commit: OK [ 41.080929] Testing event jbd2_drop_transaction: OK [ 41.095234] Testing event jbd2_commit_logging: OK [ 41.114631] Testing event jbd2_commit_flushing: OK [ 41.141627] Testing event jbd2_commit_locking: OK [ 41.165234] Testing event jbd2_start_commit: OK [ 41.186744] Testing event jbd2_checkpoint: OK [ 41.205138] Testing event ocfs2_remove_block_from_cache: OK [ 41.221959] Testing event ocfs2_remove_metadata_tree: OK [ 41.248719] Testing event ocfs2_remove_metadata_array: OK [ 41.282341] Testing event ocfs2_set_buffer_uptodate_begin: OK [ 41.306939] Testing event ocfs2_set_buffer_uptodate: OK [ 41.335802] Testing event ocfs2_expand_cache: OK [ 41.356049] Testing event ocfs2_insert_cache_tree: OK [ 41.375584] Testing event ocfs2_append_cache_array: OK [ 41.395385] Testing event ocfs2_buffer_cached_end: OK [ 41.415362] Testing event ocfs2_buffer_cached_begin: OK [ 41.435583] Testing event ocfs2_metadata_cache_purge: OK [ 41.455378] Testing event ocfs2_purge_copied_metadata_tree: OK [ 41.479241] Testing event ocfs2_read_blocks_begin: OK [ 41.503733] Testing event ocfs2_write_block: OK [ 41.528320] Testing event ocfs2_read_blocks_end: OK [ 41.563982] Testing event ocfs2_read_blocks_bh: OK [ 41.582387] Testing event ocfs2_read_blocks_from_disk: OK [ 41.604478] Testing event ocfs2_read_blocks_sync_jbd: OK [ 41.626281] Testing event ocfs2_read_blocks_sync: OK [ 41.667315] Testing event ocfs2_wait_on_mount: OK [ 41.699090] Testing event ocfs2_recover_orphans_iput: OK [ 41.726637] Testing event ocfs2_recover_orphans: OK [ 41.751760] Testing event ocfs2_orphan_filldir: OK [ 41.808514] Testing event ocfs2_queue_orphan_scan_end: OK [ 41.835793] Testing event ocfs2_queue_orphan_scan_begin: OK [ 41.872536] Testing event ocfs2_mark_dead_nodes: OK [ 41.898379] Testing event ocfs2_recover_node_skip: OK [ 41.937677] Testing event ocfs2_recover_node: OK [ 41.975289] Testing event ocfs2_replay_journal_skip: OK [ 42.003138] Testing event ocfs2_replay_journal_lock_err: OK [ 42.098993] Testing event ocfs2_replay_journal_recovered: OK [ 42.122822] Testing event ocfs2_recovery_thread: OK [ 42.159405] Testing event ocfs2_recovery_thread_end: OK [ 42.203902] Testing event ocfs2_recovery_thread_node: OK [ 42.237471] Testing event ocfs2_complete_recovery_slot: OK [ 42.267909] Testing event ocfs2_complete_recovery_end: OK [ 42.294334] Testing event ocfs2_complete_recovery: OK [ 42.330366] Testing event ocfs2_journal_shutdown_wait: OK [ 42.373089] Testing event ocfs2_journal_shutdown: OK [ 42.439817] Testing event ocfs2_journal_init_maxlen: OK [ 42.462119] Testing event ocfs2_journal_init: OK [ 42.497138] Testing event ocfs2_journal_dirty: OK [ 42.532671] Testing event ocfs2_journal_access: OK [ 42.555786] Testing event ocfs2_allocate_extend_trans: OK [ 42.578609] Testing event ocfs2_extend_trans_restart: OK [ 42.605397] Testing event ocfs2_extend_trans: OK [ 42.645804] Testing event ocfs2_commit_cache_end: OK [ 42.673597] Testing event ocfs2_commit_cache_begin: OK [ 42.705910] Testing event ocfs2_encode_fh_type: OK [ 42.735490] Testing event ocfs2_encode_fh_parent: OK [ 42.772144] Testing event ocfs2_encode_fh_self: OK [ 42.811977] Testing event ocfs2_encode_fh_begin: OK [ 42.840742] Testing event ocfs2_get_parent_end: OK [ 42.899386] Testing event ocfs2_get_parent: OK [ 42.951166] Testing event ocfs2_get_dentry_end: OK [ 42.993657] Testing event ocfs2_get_dentry_generation: OK [ 43.052484] Testing event ocfs2_get_dentry_stale: OK [ 43.094711] Testing event ocfs2_get_dentry_test_bit: OK [ 43.129339] Testing event ocfs2_get_dentry_begin: OK [ 43.172379] Testing event ocfs2_dentry_attach_lock_found: OK [ 43.208410] Testing event ocfs2_dentry_attach_lock: OK [ 43.254419] Testing event ocfs2_find_local_alias: OK [ 43.311414] Testing event ocfs2_dentry_revalidate_ret: OK [ 43.358823] Testing event ocfs2_dentry_revalidate_nofsdata: OK [ 43.391077] Testing event ocfs2_dentry_revalidate_orphaned: OK [ 43.428195] Testing event ocfs2_dentry_revalidate_delete: OK [ 43.474175] Testing event ocfs2_dentry_revalidate_negative: OK [ 43.519889] Testing event ocfs2_dentry_revalidate: OK [ 43.563768] Testing event ocfs2_orphan_del: OK [ 43.614626] Testing event ocfs2_orphan_add_end: OK [ 43.673455] Testing event ocfs2_orphan_add_begin: OK [ 43.722223] Testing event ocfs2_blkno_stringify: OK [ 43.768499] Testing event ocfs2_symlink_begin: OK [ 43.814816] Testing event ocfs2_create_symlink_data: OK [ 43.857854] Testing event ocfs2_rename_over_existing: OK [ 43.908970] Testing event ocfs2_rename_disagree: OK [ 43.954216] Testing event ocfs2_rename_target_exists: OK [ 44.007041] Testing event ocfs2_rename_not_permitted: OK [ 44.036196] Testing event ocfs2_rename: OK [ 44.078799] Testing event ocfs2_double_lock_end: OK [ 44.118616] Testing event ocfs2_double_lock: OK [ 44.146982] Testing event ocfs2_unlink_noent: OK [ 44.194185] Testing event ocfs2_link: OK [ 44.219150] Testing event ocfs2_mknod: OK [ 44.297596] Testing event ocfs2_lookup_ret: OK [ 44.315631] Testing event ocfs2_mv_orphaned_inode_to_new: OK [ 44.344622] Testing event ocfs2_symlink_create: OK [ 44.369978] Testing event ocfs2_unlink: OK [ 44.395312] Testing event ocfs2_create: OK [ 44.421408] Testing event ocfs2_mkdir: OK [ 44.445370] Testing event ocfs2_lookup: OK [ 44.502041] Testing event ocfs2_prepare_dir_for_insert: OK [ 44.557577] Testing event ocfs2_dx_dir_rebalance_split: OK [ 44.587628] Testing event ocfs2_dx_dir_rebalance: OK [ 44.608283] Testing event ocfs2_extend_dir: OK [ 44.630606] Testing event ocfs2_dx_dir_index_root_block: OK [ 44.661314] Testing event ocfs2_dx_dir_format_cluster: OK [ 44.695733] Testing event ocfs2_dx_dir_attach_index: OK [ 44.721343] Testing event ocfs2_check_dir_for_entry: OK [ 44.747833] Testing event ocfs2_find_files_on_disk: OK [ 44.765572] Testing event ocfs2_readdir: OK [ 44.781801] Testing event ocfs2_delete_entry_dx: OK [ 44.806372] Testing event ocfs2_dx_dir_search_leaf_info: OK [ 44.825488] Testing event ocfs2_dx_dir_search: OK [ 44.926916] Testing event ocfs2_find_entry_el: OK [ 44.955441] Testing event ocfs2_validate_dir_block: OK [ 44.974177] Testing event ocfs2_search_dirblock: OK [ 44.991258] Testing event ocfs2_mark_dquot_dirty: OK [ 45.017930] Testing event ocfs2_acquire_dquot: OK [ 45.035708] Testing event ocfs2_release_dquot: OK [ 45.051838] Testing event ocfs2_write_dquot: OK [ 45.076470] Testing event ocfs2_sync_dquot_helper: OK [ 45.103711] Testing event ocfs2_sync_dquot: OK [ 45.125315] Testing event ocfs2_validate_quota_block: OK [ 45.146967] Testing event olq_set_dquot: OK [ 45.165992] Testing event ocfs2_finish_quota_recovery: OK [ 45.185593] Testing event ocfs2_recover_local_quota_file: OK [ 45.208014] Testing event ocfs2_resmap_claimed_bits_end: OK [ 45.225402] Testing event ocfs2_resmap_claimed_bits_begin: OK [ 45.257809] Testing event ocfs2_resmap_resv_bits: OK [ 45.320632] Testing event ocfs2_cannibalize_resv_end: OK [ 45.347499] Testing event ocfs2_cannibalize_resv_begin: OK [ 45.404011] Testing event ocfs2_resv_find_window_next: OK [ 45.438987] Testing event ocfs2_resv_find_window_prev: OK [ 45.520892] Testing event ocfs2_resv_find_window_begin: OK [ 45.623691] Testing event ocfs2_resmap_find_free_bits_end: OK [ 45.664806] Testing event ocfs2_resmap_find_free_bits_begin: OK [ 45.720953] Testing event ocfs2_resv_insert: OK [ 45.771788] Testing event ocfs2_reflink_xattr_rec: OK [ 45.810656] Testing event ocfs2_reflink_xattr_buckets: OK [ 45.857522] Testing event ocfs2_xattr_bucket_value_refcount: OK [ 45.907478] Testing event ocfs2_xattr_set_entry_index_block: OK [ 45.989098] Testing event ocfs2_xattr_set_entry_bucket: OK [ 46.112973] Testing event ocfs2_create_empty_xattr_block: OK [ 46.148082] Testing event ocfs2_reflink_xattr_header: OK [ 46.168501] Testing event ocfs2_rm_xattr_cluster: OK [ 46.204931] Testing event ocfs2_xattr_bucket_value_truncate: OK [ 46.227049] Testing event ocfs2_add_new_xattr_bucket: OK [ 46.306337] Testing event ocfs2_extend_xattr_bucket: OK [ 46.334143] Testing event ocfs2_add_new_xattr_cluster_insert: OK [ 46.370355] Testing event ocfs2_add_new_xattr_cluster: OK [ 46.407471] Testing event ocfs2_add_new_xattr_cluster_begin: OK [ 46.428804] Testing event ocfs2_adjust_xattr_cross_cluster: OK [ 46.449329] Testing event ocfs2_mv_xattr_buckets: OK [ 46.478240] Testing event ocfs2_cp_xattr_bucket: OK [ 46.498818] Testing event ocfs2_divide_xattr_bucket_move: OK [ 46.514954] Testing event ocfs2_divide_xattr_bucket_begin: OK [ 46.547664] Testing event ocfs2_mv_xattr_bucket_cross_cluster: OK [ 46.565224] Testing event ocfs2_defrag_xattr_bucket: OK [ 46.584231] Testing event ocfs2_xattr_create_index_block: OK [ 46.605555] Testing event ocfs2_xattr_create_index_block_begin: OK [ 46.624857] Testing event ocfs2_cp_xattr_block_to_bucket_end: OK [ 46.645150] Testing event ocfs2_cp_xattr_block_to_bucket_begin: OK [ 46.664664] Testing event ocfs2_iterate_xattr_bucket: OK [ 46.684829] Testing event ocfs2_iterate_xattr_buckets: OK [ 46.701974] Testing event ocfs2_xattr_index_block_find_rec: OK [ 46.722548] Testing event ocfs2_xattr_index_block_find: OK [ 46.741354] Testing event ocfs2_xattr_bucket_find: OK [ 46.760759] Testing event ocfs2_init_xattr_set_ctxt: OK [ 46.781154] Testing event ocfs2_xattr_extend_allocation: OK [ 46.807528] Testing event ocfs2_validate_xattr_block: OK [ 46.828505] Testing event ocfs2_initialize_super: OK [ 46.848776] Testing event ocfs2_dismount_volume: OK [ 46.867835] Testing event ocfs2_statfs: OK [ 46.884988] Testing event ocfs2_put_super: OK [ 46.905051] Testing event ocfs2_parse_options: OK [ 46.953847] Testing event ocfs2_fill_super: OK [ 47.022522] Testing event ocfs2_remount: OK [ 47.037963] Testing event ocfs2_do_node_down: OK [ 47.054188] Testing event ocfs2_find_slot: OK [ 47.072407] Testing event ocfs2_map_slot_buffers_block: OK [ 47.088214] Testing event ocfs2_map_slot_buffers: OK [ 47.104855] Testing event ocfs2_refresh_slot_info: OK [ 47.135160] Testing event ocfs2_read_virt_blocks: OK [ 47.214059] Testing event ocfs2_mark_inode_dirty: OK [ 47.259034] Testing event ocfs2_inode_revalidate: OK [ 47.329974] Testing event ocfs2_drop_inode: OK [ 47.457560] Testing event ocfs2_clear_inode: OK [ 47.488289] Testing event ocfs2_delete_inode: OK [ 47.522652] Testing event ocfs2_cleanup_delete_inode: OK [ 47.614289] Testing event ocfs2_query_inode_wipe_end: OK [ 47.668991] Testing event ocfs2_query_inode_wipe_succ: OK [ 47.713567] Testing event ocfs2_query_inode_wipe_begin: OK [ 47.763983] Testing event ocfs2_inode_is_valid_to_delete: OK [ 47.856923] Testing event ocfs2_validate_inode_block: OK [ 47.956287] Testing event ocfs2_check_orphan_recovery_state: OK [ 48.009845] Testing event ocfs2_read_locked_inode: OK [ 48.052430] Testing event ocfs2_populate_inode: OK [ 48.070950] Testing event ocfs2_find_actor: OK [ 48.084259] Testing event ocfs2_iget_end: OK [ 48.097508] Testing event ocfs2_iget5_locked: OK [ 48.111008] Testing event ocfs2_iget_begin: OK [ 48.124258] Testing event generic_file_aio_read_ret: OK [ 48.137746] Testing event ocfs2_prepare_inode_for_write: OK [ 48.150955] Testing event ocfs2_remove_inode_range: OK [ 48.164325] Testing event ocfs2_zero_partial_clusters_range2: OK [ 48.180904] Testing event ocfs2_zero_partial_clusters_range1: OK [ 48.195126] Testing event ocfs2_zero_partial_clusters: OK [ 48.210843] Testing event ocfs2_write_remove_suid: OK [ 48.224199] Testing event ocfs2_setattr: OK [ 48.237595] Testing event ocfs2_zero_extend: OK [ 48.250939] Testing event ocfs2_zero_extend_range: OK [ 48.300339] Testing event ocfs2_write_zero_page: OK [ 48.471130] Testing event ocfs2_extend_allocation_end: OK [ 48.577695] Testing event ocfs2_extend_allocation: OK [ 48.644357] Testing event ocfs2_truncate_file_error: OK [ 48.692096] Testing event ocfs2_truncate_file: OK [ 48.735838] Testing event ocfs2_file_aio_read: OK [ 48.788704] Testing event ocfs2_file_splice_read: OK [ 48.846031] Testing event ocfs2_file_splice_write: OK [ 48.864189] Testing event ocfs2_file_aio_write: OK [ 48.877599] Testing event ocfs2_sync_file: OK [ 48.907576] Testing event ocfs2_file_release: OK [ 48.924217] Testing event ocfs2_file_open: OK [ 48.968231] Testing event ocfs2_fault: OK [ 48.980854] Testing event ocfs2_write_end_inline: OK [ 49.000930] Testing event ocfs2_write_begin_nolock: OK [ 49.020862] Testing event ocfs2_try_to_write_inline_data: OK [ 49.040846] Testing event ocfs2_bmap: OK [ 49.098308] Testing event ocfs2_writepage: OK [ 49.160551] Testing event ocfs2_readpage: OK [ 49.203851] Testing event ocfs2_get_block_end: OK [ 49.257007] Testing event ocfs2_get_block: OK [ 49.277511] Testing event ocfs2_symlink_get_block: OK [ 49.294259] Testing event ocfs2_refcount_cow_hunk: OK [ 49.320680] Testing event ocfs2_make_clusters_writable: OK [ 49.334256] Testing event ocfs2_replace_clusters: OK [ 49.350950] Testing event ocfs2_clear_ext_refcount: OK [ 49.367487] Testing event ocfs2_duplicate_clusters_by_jbd: OK [ 49.418086] Testing event ocfs2_duplicate_clusters_by_page: OK [ 49.454451] Testing event ocfs2_lock_refcount_allocators: OK [ 49.553593] Testing event ocfs2_prepare_refcount_change_for_del: OK [ 49.672224] Testing event ocfs2_add_refcount_flag: OK [ 49.754431] Testing event ocfs2_calc_refcount_meta_credits_iterate: OK [ 49.860626] Testing event ocfs2_calc_refcount_meta_credits: OK [ 49.897897] Testing event ocfs2_mark_extent_refcounted: OK [ 49.937553] Testing event ocfs2_decrease_refcount: OK [ 49.971371] Testing event ocfs2_decrease_refcount_rec: OK [ 50.019802] Testing event ocfs2_restore_refcount_block: OK [ 50.034272] Testing event ocfs2_remove_refcount_extent: OK [ 50.047640] Testing event ocfs2_increase_refcount_split: OK [ 50.060990] Testing event ocfs2_increase_refcount_insert: OK [ 50.074307] Testing event ocfs2_increase_refcount_change: OK [ 50.087775] Testing event ocfs2_increase_refcount_begin: OK [ 50.100943] Testing event ocfs2_split_refcount_rec_insert: OK [ 50.114277] Testing event ocfs2_split_refcount_rec: OK [ 50.127563] Testing event ocfs2_insert_refcount_rec: OK [ 50.140876] Testing event ocfs2_new_leaf_refcount_block: OK [ 50.154196] Testing event ocfs2_divide_leaf_refcount_block: OK [ 50.167563] Testing event ocfs2_expand_inline_ref_root: OK [ 50.180862] Testing event ocfs2_change_refcount_rec: OK [ 50.194184] Testing event ocfs2_create_refcount_tree_blkno: OK [ 50.207564] Testing event ocfs2_create_refcount_tree: OK [ 50.220962] Testing event ocfs2_purge_refcount_trees: OK [ 50.234332] Testing event ocfs2_validate_refcount_block: OK [ 50.247629] Testing event ocfs2_test_inode_bit: OK [ 50.260963] Testing event ocfs2_test_suballoc_bit: OK [ 50.274293] Testing event ocfs2_get_suballoc_slot_bit: OK [ 50.287651] Testing event ocfs2_free_clusters: OK [ 50.300977] Testing event ocfs2_free_suballoc_bits: OK [ 50.314309] Testing event ocfs2_block_group_clear_bits: OK [ 50.327672] Testing event ocfs2_claim_new_inode_at_loc: OK [ 50.347645] Testing event ocfs2_claim_suballoc_bits: OK [ 50.377625] Testing event ocfs2_search_chain_end: OK [ 50.410685] Testing event ocfs2_search_chain_succ: OK [ 50.457742] Testing event ocfs2_search_chain_begin: OK [ 50.478656] Testing event ocfs2_block_group_search_max_block: OK [ 50.517237] Testing event ocfs2_cluster_group_search_max_block: OK [ 50.536411] Testing event ocfs2_cluster_group_search_wrong_max_bits: OK [ 50.554789] Testing event ocfs2_relink_block_group: OK [ 50.572088] Testing event ocfs2_block_group_set_bits: OK [ 50.591751] Testing event ocfs2_reserve_new_inode_new_group: OK [ 50.611848] Testing event ocfs2_reserve_suballoc_bits_no_new_group: OK [ 50.631805] Testing event ocfs2_reserve_suballoc_bits_nospc: OK [ 50.648124] Testing event ocfs2_block_group_alloc: OK [ 50.665200] Testing event ocfs2_block_group_alloc_discontig: OK [ 50.681537] Testing event ocfs2_block_group_alloc_contig: OK [ 50.698208] Testing event ocfs2_validate_group_descriptor: OK [ 50.727597] Testing event ocfs2_group_add: OK [ 50.797774] Testing event ocfs2_group_extend: OK [ 50.996392] Testing event ocfs2_update_last_group_and_inode: OK [ 51.182949] Testing event ocfs2_local_alloc_new_window_result: OK [ 51.218850] Testing event ocfs2_local_alloc_new_window: OK [ 51.238435] Testing event ocfs2_sync_local_to_main_free: OK [ 51.265320] Testing event ocfs2_sync_local_to_main: OK [ 51.285242] Testing event ocfs2_local_alloc_find_clear_bits: OK [ 51.302798] Testing event ocfs2_local_alloc_find_clear_bits_search_bitmap: OK [ 51.321873] Testing event ocfs2_local_alloc_count_bits: OK [ 51.347510] Testing event ocfs2_reserve_local_alloc_bits: OK [ 51.422277] Testing event ocfs2_begin_local_alloc_recovery: OK [ 51.437819] Testing event ocfs2_load_local_alloc: OK [ 51.457287] Testing event ocfs2_alloc_should_use_local: OK [ 51.471118] Testing event ocfs2_la_set_sizes: OK [ 51.484425] Testing event ocfs2_trim_fs: OK [ 51.548793] Testing event ocfs2_trim_group: OK [ 51.575315] Testing event ocfs2_trim_extent: OK [ 51.601401] Testing event ocfs2_cache_block_dealloc: OK [ 51.620426] Testing event ocfs2_run_deallocs: OK [ 51.635250] Testing event ocfs2_cache_cluster_dealloc: OK [ 51.651614] Testing event ocfs2_free_cached_blocks: OK [ 51.668519] Testing event ocfs2_complete_truncate_log_recovery: OK [ 51.684989] Testing event ocfs2_truncate_log_recovery_num: OK [ 51.701730] Testing event ocfs2_begin_truncate_log_recovery: OK [ 51.718670] Testing event ocfs2_flush_truncate_log: OK [ 51.735214] Testing event ocfs2_replay_truncate_records: OK [ 51.751684] Testing event ocfs2_truncate_log_append: OK [ 51.768499] Testing event ocfs2_mark_extent_written: OK [ 51.785478] Testing event ocfs2_add_clusters_in_btree_ret: OK [ 51.801725] Testing event ocfs2_rotate_leaf: OK [ 51.818535] Testing event ocfs2_validate_extent_block: OK [ 51.835147] Testing event ocfs2_commit_truncate: OK [ 51.851741] Testing event ocfs2_remove_extent: OK [ 51.868443] Testing event ocfs2_split_extent: OK [ 51.885048] Testing event ocfs2_insert_extent: OK [ 51.901860] Testing event ocfs2_rotate_subtree: OK [ 51.918671] Testing event ocfs2_grow_tree: OK [ 51.935162] Testing event ocfs2_complete_edge_insert: OK [ 51.951747] Testing event ocfs2_num_free_extents: OK [ 51.968631] Testing event ocfs2_add_clusters_in_btree: OK [ 51.985087] Testing event ocfs2_insert_extent_start: OK [ 52.001754] Testing event ocfs2_append_rec_to_path: OK [ 52.018299] Testing event ocfs2_rotate_tree_right: OK [ 52.038865] Testing event ocfs2_adjust_rightmost_branch: OK [ 52.055038] Testing event btrfs_workqueue_destroy: OK [ 52.072177] Testing event btrfs_workqueue_alloc: OK [ 52.088673] Testing event btrfs_ordered_sched: OK [ 52.105072] Testing event btrfs_all_work_done: OK [ 52.121954] Testing event btrfs_normal_work_done: OK [ 52.138220] Testing event btrfs_work_sched: OK [ 52.155055] Testing event btrfs_work_queued: OK [ 52.171911] Testing event free_extent_state: OK [ 52.188676] Testing event alloc_extent_state: OK [ 52.205089] Testing event btrfs_setup_cluster: OK [ 52.221971] Testing event btrfs_failed_cluster_setup: OK [ 52.238542] Testing event btrfs_find_cluster: OK [ 52.255197] Testing event btrfs_reserve_extent_cluster: OK [ 52.272084] Testing event btrfs_reserve_extent: OK [ 52.288478] Testing event find_free_extent: OK [ 52.312086] Testing event btrfs_reserved_extent_free: OK [ 52.328852] Testing event btrfs_reserved_extent_alloc: OK [ 52.368969] Testing event btrfs_space_reservation: OK [ 52.397033] Testing event btrfs_cow_block: OK [ 52.418524] Testing event btrfs_chunk_free: OK [ 52.435422] Testing event btrfs_chunk_alloc: OK [ 52.458525] Testing event run_delayed_ref_head: OK [ 52.478568] Testing event add_delayed_ref_head: OK [ 52.502163] Testing event run_delayed_data_ref: OK [ 52.518354] Testing event add_delayed_data_ref: OK [ 52.535565] Testing event run_delayed_tree_ref: OK [ 52.557741] Testing event add_delayed_tree_ref: OK [ 52.585382] Testing event btrfs_sync_fs: OK [ 52.608585] Testing event btrfs_sync_file: OK [ 52.625176] Testing event btrfs_writepage_end_io_hook: OK [ 52.641799] Testing event __extent_writepage: OK [ 52.658421] Testing event btrfs_ordered_extent_put: OK [ 52.678415] Testing event btrfs_ordered_extent_start: OK [ 52.695404] Testing event btrfs_ordered_extent_remove: OK [ 52.721779] Testing event btrfs_ordered_extent_add: OK [ 52.738626] Testing event btrfs_get_extent: OK [ 52.755176] Testing event btrfs_inode_evict: OK [ 52.772126] Testing event btrfs_inode_request: OK [ 52.788572] Testing event btrfs_inode_new: OK [ 52.805237] Testing event btrfs_transaction_commit: OK [ 52.835184] Testing event gfs2_rs: OK [ 52.855478] Testing event gfs2_block_alloc: OK [ 52.872766] Testing event gfs2_bmap: OK [ 52.888784] Testing event gfs2_ail_flush: OK [ 52.905456] Testing event gfs2_log_blocks: OK [ 52.922982] Testing event gfs2_log_flush: OK [ 52.938650] Testing event gfs2_pin: OK [ 52.962007] Testing event gfs2_glock_lock_time: OK [ 52.978545] Testing event gfs2_glock_queue: OK [ 52.999846] Testing event gfs2_promote: OK [ 53.015397] Testing event gfs2_demote_rq: OK [ 53.035337] Testing event gfs2_glock_put: OK [ 53.051858] Testing event gfs2_glock_state_change: OK [ 53.068513] Testing event block_rq_remap: OK [ 53.088477] Testing event block_bio_remap: OK [ 53.107430] Testing event block_split: OK [ 53.135166] Testing event block_unplug: OK [ 53.152186] Testing event block_plug: OK [ 53.177436] Testing event block_sleeprq: OK [ 53.191951] Testing event block_getrq: OK [ 53.217402] Testing event block_bio_queue: OK [ 53.231520] Testing event block_bio_frontmerge: OK [ 53.251547] Testing event block_bio_backmerge: OK [ 53.268423] Testing event block_bio_complete: OK [ 53.291074] Testing event block_bio_bounce: OK [ 53.339950] Testing event block_rq_issue: OK [ 53.397801] Testing event block_rq_insert: OK [ 53.454580] Testing event block_rq_complete: OK [ 53.511085] Testing event block_rq_requeue: OK [ 53.548987] Testing event block_rq_abort: OK [ 53.567603] Testing event block_dirty_buffer: OK [ 53.585089] Testing event block_touch_buffer: OK [ 53.605067] Testing event swiotlb_bounced: OK [ 53.625521] Testing event gpio_value: OK [ 53.657721] Testing event gpio_direction: OK [ 53.701047] Testing event regulator_set_voltage_complete: OK [ 53.747482] Testing event regulator_set_voltage: OK [ 53.801837] Testing event regulator_disable_complete: OK [ 53.818731] Testing event regulator_disable: OK [ 53.834963] Testing event regulator_enable_complete: OK [ 53.851865] Testing event regulator_enable_delay: OK [ 53.868331] Testing event regulator_enable: OK [ 53.885813] Testing event urandom_read: OK [ 53.901967] Testing event random_read: OK [ 53.918431] Testing event extract_entropy_user: OK [ 53.934947] Testing event extract_entropy: OK [ 53.951980] Testing event get_random_bytes_arch: OK [ 53.968408] Testing event get_random_bytes: OK [ 54.006493] Testing event xfer_secondary_pool: OK [ 54.137212] Testing event add_disk_randomness: OK [ 54.223920] Testing event add_input_randomness: OK [ 54.271006] Testing event debit_entropy: OK [ 54.284359] Testing event push_to_pool: OK [ 54.297877] Testing event credit_entropy_bits: OK [ 54.310966] Testing event mix_pool_bytes_nolock: OK [ 54.324389] Testing event mix_pool_bytes: OK [ 54.337669] Testing event add_device_randomness: OK [ 54.351137] Testing event drm_vblank_event_delivered: OK [ 54.364491] Testing event drm_vblank_event_queued: OK [ 54.377744] Testing event drm_vblank_event: OK [ 54.391146] Testing event regcache_drop_region: OK [ 54.404402] Testing event regmap_async_complete_done: OK [ 54.417706] Testing event regmap_async_complete_start: OK [ 54.430966] Testing event regmap_async_io_complete: OK [ 54.444496] Testing event regmap_async_write_start: OK [ 54.457783] Testing event regmap_cache_bypass: OK [ 54.471033] Testing event regmap_cache_only: OK [ 54.484410] Testing event regcache_sync: OK [ 54.498034] Testing event regmap_hw_write_done: OK [ 54.514621] Testing event regmap_hw_write_start: OK [ 54.538038] Testing event regmap_hw_read_done: OK [ 54.586523] Testing event regmap_hw_read_start: OK [ 54.601866] Testing event regmap_reg_read_cache: OK [ 54.618296] Testing event regmap_reg_read: OK [ 54.635526] Testing event regmap_reg_write: OK [ 54.651593] Testing event fence_wait_end: OK [ 54.671744] Testing event fence_wait_start: OK [ 54.692508] Testing event fence_signaled: OK [ 54.708492] Testing event fence_enable_signal: OK [ 54.739649] Testing event fence_destroy: OK [ 54.755059] Testing event fence_init: OK [ 54.771873] Testing event fence_emit: OK [ 54.788242] Testing event fence_annotate_wait_on: OK [ 54.804938] Testing event scsi_eh_wakeup: OK [ 54.821646] Testing event scsi_dispatch_cmd_timeout: OK [ 54.845974] Testing event scsi_dispatch_cmd_done: OK [ 54.877694] Testing event scsi_dispatch_cmd_error: OK [ 54.911507] Testing event scsi_dispatch_cmd_start: OK [ 54.958124] Testing event target_cmd_complete: OK [ 55.028108] Testing event target_sequencer_start: OK [ 55.111055] Testing event spi_transfer_stop: OK [ 55.148346] Testing event spi_transfer_start: OK [ 55.165477] Testing event spi_message_done: OK [ 55.208568] Testing event spi_message_start: OK [ 55.235022] Testing event spi_message_submit: OK [ 55.264961] Testing event spi_master_busy: OK [ 55.292006] Testing event spi_master_idle: OK [ 55.321610] Testing event smbus_result: OK [ 55.348760] Testing event smbus_reply: OK [ 55.371773] Testing event smbus_read: OK [ 55.395169] Testing event smbus_write: OK [ 55.428492] Testing event i2c_result: OK [ 55.455689] Testing event i2c_reply: OK [ 55.488649] Testing event i2c_read: OK [ 55.557276] Testing event i2c_write: OK [ 55.667806] Testing event v4l2_qbuf: OK [ 55.692222] Testing event v4l2_dqbuf: OK [ 55.714250] Testing event snd_soc_cache_sync: OK [ 55.734277] Testing event snd_soc_jack_notify: OK [ 55.754196] Testing event snd_soc_jack_report: OK [ 55.770870] Testing event snd_soc_jack_irq: OK [ 55.791083] Testing event snd_soc_dapm_connected: OK [ 55.810929] Testing event snd_soc_dapm_input_path: OK [ 55.824177] Testing event snd_soc_dapm_output_path: OK [ 55.897435] Testing event snd_soc_dapm_walk_done: OK [ 55.970255] Testing event snd_soc_dapm_widget_event_done: OK [ 56.118276] Testing event snd_soc_dapm_widget_event_start: OK [ 56.179574] Testing event snd_soc_dapm_widget_power: OK [ 56.211207] Testing event snd_soc_dapm_done: OK [ 56.259536] Testing event snd_soc_dapm_start: OK [ 56.297701] Testing event snd_soc_bias_level_done: OK [ 56.337443] Testing event snd_soc_bias_level_start: OK [ 56.367582] Testing event udp_fail_queue_rcv_skb: OK [ 56.407330] Testing event sock_exceed_buf_limit: OK [ 56.507135] Testing event sock_rcvqueue_full: OK [ 56.601837] Testing event napi_poll: OK [ 56.690849] Testing event netif_rx_ni_entry: OK [ 56.737741] Testing event netif_rx_entry: OK [ 56.790129] Testing event netif_receive_skb_entry: OK [ 56.847334] Testing event napi_gro_receive_entry: OK [ 56.892039] Testing event napi_gro_frags_entry: OK [ 56.939736] Testing event netif_rx: OK [ 56.980478] Testing event netif_receive_skb: OK [ 57.029338] Testing event net_dev_queue: OK [ 57.077019] Testing event net_dev_xmit: OK [ 57.130656] Testing event net_dev_start_xmit: OK [ 57.406563] Testing event skb_copy_datagram_iovec: OK [ 57.473984] Testing event consume_skb: OK [ 57.504732] Testing event kfree_skb: OK [ 57.538093] Running tests on trace event systems: [ 57.538958] Testing event system skb: OK [ 57.575098] Testing event system net: OK [ 57.615700] Testing event system napi: OK [ 57.647695] Testing event system sock: OK [ 57.667860] Testing event system udp: OK [ 57.748010] Testing event system asoc: OK [ 57.809554] Testing event system v4l2: OK [ 57.831148] Testing event system i2c: OK [ 57.879753] Testing event system spi: OK [ 57.984085] Testing event system target: OK [ 58.011941] Testing event system scsi: OK [ 58.058054] Testing event system fence: OK [ 58.102495] Testing event system regmap: OK [ 58.168539] Testing event system drm: OK [ 58.196258] Testing event system random: OK [ 58.229975] Testing event system regulator: OK [ 58.286647] Testing event system gpio: OK [ 58.334379] Testing event system swiotlb: OK [ 58.388100] Testing event system block: OK [ 58.675244] Testing event system gfs2: OK [ 58.811612] Testing event system btrfs: OK [ 59.350133] Testing event system ocfs2: OK [ 59.710977] Testing event system jbd2: OK [ 59.729693] Testing event system jbd: OK [ 59.958898] Testing event system ext3: OK [ 60.169340] Testing event system writeback: OK [ 60.232480] Testing event system migrate: OK [ 60.270798] Testing event system compaction: OK [ 60.289633] Testing event system kmem: OK [ 60.322111] Testing event system vmscan: OK [ 60.361835] Testing event system pagemap: OK [ 60.385822] Testing event system oom: OK [ 60.422896] Testing event system filemap: OK [ 60.462333] Testing event system power: OK [ 60.536030] Testing event system test: OK [ 60.551920] Testing event system timer: OK [ 60.595498] Testing event system rcu: OK [ 60.627951] Testing event system printk: OK [ 60.645261] Testing event system lock: OK [ 60.678049] Testing event system sched: OK [ 60.715474] Testing event system workqueue: OK [ 60.740309] Testing event system signal: OK [ 60.763805] Testing event system irq: OK [ 60.793794] Testing event system task: OK [ 60.822176] Testing event system exceptions: OK [ 60.840868] Testing event system tlb: OK [ 60.887500] Testing event system mce: OK [ 60.981304] Testing event system raw_syscalls: OK [ 61.005892] Testing event system vsyscall: OK [ 61.074927] Testing event system nmi: OK [ 61.095070] Testing event system irq_vectors: OK [ 61.152128] Running tests on all trace events: [ 61.152995] Testing all events: OK [ 62.590097] Testing ftrace filter: OK [ 62.597049] kAFS: Red Hat AFS client v0.1 registering. [ 62.598086] FS-Cache: Netfs 'afs' registered for caching [ 62.610295] Btrfs loaded, debug=on [ 62.612448] drivers/rtc/hctosys.c: unable to open rtc device (rtc0) [ 62.614844] BIOS EDD facility v0.16 2004-Jun-25, 0 devices found [ 62.616202] EDD information not available. [ 62.617013] ALSA device list: [ 62.617459] No soundcards found. [ 62.618835] debug: unmapping init [mem 0xffffffff83732000-0xffffffff83abdfff] [ 62.625277] Write protecting the kernel read-only data: 32768k [ 62.627475] debug: unmapping init [mem 0xffff88000242c000-0xffff8800025fffff] [ 62.629036] debug: unmapping init [mem 0xffff880002f7d000-0xffff880002ffffff] [ 62.643630] random: init urandom read with 17 bits of entropy available mountall: ply-event-loop.c:497: ply_event_loop_new: Assertion `loop->epoll_fd >= 0' failed. [ 62.811344] Unregister pv shared memory for cpu 1 General error mounting filesystems. A maintenance shell will now be started. CONTROL-D will terminate this shell and reboot the system. wfg: rebooting [ 62.816088] Unregister pv shared memory for cpu 0 [ 62.816806] rcu-torture: Unscheduled system shutdown detected [ 62.817787] torture thread rcu_torture_writer parking due to system shutdown [ 62.818834] torture thread rcu_torture_cbflood parking due to system shutdown [ 62.819940] torture thread rcu_torture_fakewriter parking due to system shutdown [ 62.821624] torture thread rcu_torture_fakewriter parking due to system shutdown [ 62.822808] torture thread rcu_torture_fakewriter parking due to system shutdown [ 62.827228] torture thread rcu_torture_fakewriter parking due to system shutdown BUG: kernel boot crashed Elapsed time: 75 qemu-system-x86_64 -enable-kvm -cpu Haswell,+smep,+smap -kernel /kernel/x86_64-randconfig-s1-08281038/b52938be99a099b452979ed805b480337ee2df0f/vmlinuz-3.17.0-rc2-00062-gb52938b -append 'hung_task_panic=1 earlyprintk=ttyS0,115200 debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 console=ttyS0,115200 console=tty0 vga=normal root=/dev/ram0 rw link=/kbuild-tests/run-queue/kvm/x86_64-randconfig-s1-08281038/linux-devel:devel-hourly-2014082810:b52938be99a099b452979ed805b480337ee2df0f:bisect-linux-8/.vmlinuz-b52938be99a099b452979ed805b480337ee2df0f-20140828193620-58-kbuild branch=linux-devel/devel-hourly-2014082810 BOOT_IMAGE=/kernel/x86_64-randconfig-s1-08281038/b52938be99a099b452979ed805b480337ee2df0f/vmlinuz-3.17.0-rc2-00062-gb52938b drbd.minor_count=8' -initrd /kernel-tests/initrd/quantal-core-x86_64.cgz -m 320 -smp 2 -net nic,vlan=1,model=e1000 -net user,vlan=1 -boot order=nc -no-reboot -watchdog i6300esb -rtc base=localtime -pidfile /dev/shm/kboot/pid-quantal-kbuild-10 -serial file:/dev/shm/kboot/serial-quantal-kbuild-10 -daemonize -display none -monitor null