[ 0.000000] Linux version 3.6.0-rc1-00241-gd57c5d5 (kbuild@snb) (gcc version 4.7.1 (Debian 4.7.1-6) ) #709 SMP Fri Aug 24 05:46:29 CST 2012 [ 0.000000] Command line: trinity=2m hung_task_panic=1 branch=trace/tip/perf/core log_buf_len=8M ignore_loglevel debug sched_debug apic=debug dynamic_printk sysrq_always_enabled panic=10 prompt_ramdisk=0 console=ttyS0,115200 console=tty0 vga=normal root=/dev/ram0 rw link=vmlinuz-2012-08-24-05-47-39-trace:tip:perf:core:d57c5d5-d57c5d5-x86_64-randconfig-s158-7-waimea BOOT_IMAGE=kernel-tests/kernels/x86_64-randconfig-s158/d57c5d5/vmlinuz-3.6.0-rc1-00241-gd57c5d5 [ 0.000000] e820: BIOS-provided physical RAM map: [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x0000000000093bff] usable [ 0.000000] BIOS-e820: [mem 0x0000000000093c00-0x000000000009ffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000000fffdfff] usable [ 0.000000] BIOS-e820: [mem 0x000000000fffe000-0x000000000fffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved [ 0.000000] debug: ignoring loglevel setting. [ 0.000000] NX (Execute Disable) protection: active [ 0.000000] DMI 2.4 present. [ 0.000000] DMI: Bochs Bochs, BIOS Bochs 01/01/2007 [ 0.000000] Hypervisor detected: KVM [ 0.000000] e820: update [mem 0x00000000-0x0000ffff] usable ==> reserved [ 0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable [ 0.000000] No AGP bridge found [ 0.000000] e820: last_pfn = 0xfffe 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 00E0000000 mask FFE0000000 uncachable [ 0.000000] 1 disabled [ 0.000000] 2 disabled [ 0.000000] 3 disabled [ 0.000000] 4 disabled [ 0.000000] 5 disabled [ 0.000000] 6 disabled [ 0.000000] 7 disabled [ 0.000000] x86 PAT enabled: cpu 0, old 0x70406, new 0x7010600070106 [ 0.000000] Scan for SMP in [mem 0x00000000-0x000003ff] [ 0.000000] Scan for SMP in [mem 0x0009fc00-0x0009ffff] [ 0.000000] Scan for SMP in [mem 0x000f0000-0x000fffff] [ 0.000000] found SMP MP-table at [mem 0x000fdab0-0x000fdabf] mapped at [ffff8800000fdab0] [ 0.000000] mpc: fdac0-fdbe4 [ 0.000000] initial memory mapped: [mem 0x00000000-0x1fffffff] [ 0.000000] Base memory trampoline at [ffff88000008d000] 8d000 size 24576 [ 0.000000] init_memory_mapping: [mem 0x00000000-0x0fffdfff] [ 0.000000] [mem 0x00000000-0x0fdfffff] page 2M [ 0.000000] [mem 0x0fe00000-0x0fffdfff] page 4k [ 0.000000] kernel direct mapping tables up to 0xfffdfff @ [mem 0x0e854000-0x0e8d5fff] [ 0.000000] log_buf_len: 8388608 [ 0.000000] early log buf free: 128044(97%) [ 0.000000] RAMDISK: [mem 0x0e8d6000-0x0ffeffff] [ 0.000000] ACPI: RSDP 00000000000fd920 00014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 000000000fffe550 00038 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 000000000fffff80 00074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 000000000fffe590 01121 (v01 BXPC BXDSDT 00000001 INTL 20100528) [ 0.000000] ACPI: FACS 000000000fffff40 00040 [ 0.000000] ACPI: SSDT 000000000ffffe40 000FF (v01 BOCHS BXPCSSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: APIC 000000000ffffd50 00080 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 000000000ffffd10 00038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001) [ 0.000000] ACPI: SSDT 000000000ffff6c0 00644 (v01 BXPC BXSSDTPC 00000001 INTL 20100528) [ 0.000000] ACPI: Local APIC address 0xfee00000 [ 0.000000] mapped APIC to ffffffffff5fb000 ( fee00000) [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x000000000fffdfff] [ 0.000000] Initmem setup node 0 [mem 0x00000000-0x0fffdfff] [ 0.000000] NODE_DATA [mem 0x0fff9000-0x0fffdfff] [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000000] kvm-clock: cpu 0, msr 0:1bae841, boot clock [ 0.000000] [ffffea0000000000-ffffea00003fffff] PMD -> [ffff88000d400000-ffff88000d7fffff] on node 0 [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x00010000-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 0x00010000-0x00092fff] [ 0.000000] node 0: [mem 0x00100000-0x0fffdfff] [ 0.000000] On node 0 totalpages: 65409 [ 0.000000] DMA zone: 64 pages used for memmap [ 0.000000] DMA zone: 6 pages reserved [ 0.000000] DMA zone: 3901 pages, LIFO batch:0 [ 0.000000] DMA32 zone: 960 pages used for memmap [ 0.000000] DMA32 zone: 60478 pages, LIFO batch:15 [ 0.000000] ACPI: PM-Timer IO Port: 0xb008 [ 0.000000] ACPI: Local APIC address 0xfee00000 [ 0.000000] mapped APIC to ffffffffff5fb000 ( 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[0x02] address[0xfec00000] gsi_base[0]) [ 0.000000] IOAPIC[0]: apic_id 2, 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 2, 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 2, 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 2, 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 2, 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 2, 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 2, APIC INT 01 [ 0.000000] ACPI: IRQ2 used by override. [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 03, APIC ID 2, APIC INT 03 [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 04, APIC ID 2, 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 2, APIC INT 06 [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 07, APIC ID 2, APIC INT 07 [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 08, APIC ID 2, 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 2, APIC INT 0c [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0d, APIC ID 2, APIC INT 0d [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0e, APIC ID 2, APIC INT 0e [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0f, APIC ID 2, 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 ffffffffff5fa000 (fec00000) [ 0.000000] nr_irqs_gsi: 40 [ 0.000000] e820: [mem 0x10000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] setup_percpu: NR_CPUS:8 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1 [ 0.000000] PERCPU: Embedded 475 pages/cpu @ffff88000da00000 s1914112 r8192 d23296 u2097152 [ 0.000000] pcpu-alloc: s1914112 r8192 d23296 u2097152 alloc=1*2097152 [ 0.000000] pcpu-alloc: [0] 0 [0] 1 [ 0.000000] kvm-clock: cpu 0, msr 0:dbd2841, primary cpu clock [ 0.000000] KVM setup async PF for cpu 0 [ 0.000000] kvm-stealtime: cpu 0, msr da0cec0 [ 0.000000] Built 1 zonelists in Node order, mobility grouping on. Total pages: 64379 [ 0.000000] Policy zone: DMA32 [ 0.000000] Kernel command line: trinity=2m hung_task_panic=1 branch=trace/tip/perf/core log_buf_len=8M ignore_loglevel debug sched_debug apic=debug dynamic_printk sysrq_always_enabled panic=10 prompt_ramdisk=0 console=ttyS0,115200 console=tty0 vga=normal root=/dev/ram0 rw link=vmlinuz-2012-08-24-05-47-39-trace:tip:perf:core:d57c5d5-d57c5d5-x86_64-randconfig-s158-7-waimea BOOT_IMAGE=kernel-tests/kernels/x86_64-randconfig-s158/d57c5d5/vmlinuz-3.6.0-rc1-00241-gd57c5d5 [ 0.000000] sysrq: sysrq always enabled. [ 0.000000] PID hash table entries: 1024 (order: 1, 8192 bytes) [ 0.000000] __ex_table already sorted, skipping sort [ 0.000000] Checking aperture... [ 0.000000] No AGP bridge found [ 0.000000] Memory: 195436k/262136k available (5278k kernel code, 500k absent, 66200k reserved, 4803k data, 2656k init) [ 0.000000] SLUB: Genslabs=15, HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 [ 0.000000] Hierarchical RCU implementation. [ 0.000000] [ 0.000000] [ 0.000000] [ 0.000000] [ 0.000000] [ 0.000000] NR_IRQS:4352 nr_irqs:512 16 [ 0.000000] Console: colour VGA+ 80x25 [ 0.000000] console [tty0] enabled [ 0.000000] console [ttyS0] enabled [ 0.000000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar [ 0.000000] ... MAX_LOCKDEP_SUBCLASSES: 8 [ 0.000000] ... MAX_LOCK_DEPTH: 48 [ 0.000000] ... MAX_LOCKDEP_KEYS: 8191 [ 0.000000] ... CLASSHASH_SIZE: 4096 [ 0.000000] ... MAX_LOCKDEP_ENTRIES: 16384 [ 0.000000] ... MAX_LOCKDEP_CHAINS: 32768 [ 0.000000] ... CHAINHASH_SIZE: 16384 [ 0.000000] memory used by lock dependency info: 6367 kB [ 0.000000] per task-struct memory footprint: 2688 bytes [ 0.000000] ODEBUG: 0 of 0 active objects replaced [ 0.000000] hpet clockevent registered [ 0.000000] tsc: Detected 3300.196 MHz processor [ 0.003333] Calibrating delay loop (skipped) preset value.. 6603.40 BogoMIPS (lpj=11000653) [ 0.003376] pid_max: default: 32768 minimum: 301 [ 0.007448] Dentry cache hash table entries: 32768 (order: 6, 262144 bytes) [ 0.010164] Inode-cache hash table entries: 16384 (order: 5, 131072 bytes) [ 0.012430] Mount-cache hash table entries: 256 [ 0.019694] mce: CPU supports 10 MCE banks [ 0.020077] numa_add_cpu cpu 0 node 0: mask now 0 [ 0.021567] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.021567] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.021567] tlb_flushall_shift is 0x6 [ 0.040075] Freeing SMP alternatives: 12k freed [ 0.043386] ACPI: Core revision 20120711 [ 0.117865] ftrace: allocating 12215 entries in 48 pages [ 0.124087] Getting VERSION: 50014 [ 0.126680] Getting VERSION: 50014 [ 0.127810] Getting ID: 0 [ 0.128766] Getting ID: ff000000 [ 0.130096] Getting LVT0: 8700 [ 0.131478] Getting LVT1: 8400 [ 0.132557] enabled ExtINT on CPU#0 [ 0.134611] ENABLING IO-APIC IRQs [ 0.136675] init IO_APIC IRQs [ 0.137803] apic 2 pin 0 not connected [ 0.139142] IOAPIC[0]: Set routing entry (2-1 -> 0x41 -> IRQ 1 Mode:0 Active:0 Dest:1) [ 0.140103] IOAPIC[0]: Set routing entry (2-2 -> 0x51 -> IRQ 0 Mode:0 Active:0 Dest:1) [ 0.143398] IOAPIC[0]: Set routing entry (2-3 -> 0x61 -> IRQ 3 Mode:0 Active:0 Dest:1) [ 0.146768] IOAPIC[0]: Set routing entry (2-4 -> 0x71 -> IRQ 4 Mode:0 Active:0 Dest:1) [ 0.150059] IOAPIC[0]: Set routing entry (2-5 -> 0x81 -> IRQ 5 Mode:1 Active:0 Dest:1) [ 0.153426] IOAPIC[0]: Set routing entry (2-6 -> 0x91 -> IRQ 6 Mode:0 Active:0 Dest:1) [ 0.155808] IOAPIC[0]: Set routing entry (2-7 -> 0xa1 -> IRQ 7 Mode:0 Active:0 Dest:1) [ 0.156741] IOAPIC[0]: Set routing entry (2-8 -> 0xb1 -> IRQ 8 Mode:0 Active:0 Dest:1) [ 0.160051] IOAPIC[0]: Set routing entry (2-9 -> 0xc1 -> IRQ 9 Mode:1 Active:0 Dest:1) [ 0.163383] IOAPIC[0]: Set routing entry (2-10 -> 0xd1 -> IRQ 10 Mode:1 Active:0 Dest:1) [ 0.165608] IOAPIC[0]: Set routing entry (2-11 -> 0xe1 -> IRQ 11 Mode:1 Active:0 Dest:1) [ 0.166724] IOAPIC[0]: Set routing entry (2-12 -> 0x22 -> IRQ 12 Mode:0 Active:0 Dest:1) [ 0.170057] IOAPIC[0]: Set routing entry (2-13 -> 0x42 -> IRQ 13 Mode:0 Active:0 Dest:1) [ 0.172333] IOAPIC[0]: Set routing entry (2-14 -> 0x52 -> IRQ 14 Mode:0 Active:0 Dest:1) [ 0.173451] IOAPIC[0]: Set routing entry (2-15 -> 0x62 -> IRQ 15 Mode:0 Active:0 Dest:1) [ 0.176691] apic 2 pin 16 not connected [ 0.177886] apic 2 pin 17 not connected [ 0.180000] apic 2 pin 18 not connected [ 0.181252] apic 2 pin 19 not connected [ 0.182329] apic 2 pin 20 not connected [ 0.183331] apic 2 pin 21 not connected [ 0.184352] apic 2 pin 22 not connected [ 0.185377] apic 2 pin 23 not connected [ 0.186859] ..TIMER: vector=0x51 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.188431] smpboot: CPU0: Intel Common KVM processor stepping 01 [ 0.193332] Using local APIC timer interrupts. [ 0.193332] calibrating APIC timer ... [ 0.199987] ... lapic delta = 10498206 [ 0.199987] ... PM-Timer delta = 601252 [ 0.199987] APIC calibration not consistent with PM-Timer: 167ms instead of 100ms [ 0.199987] APIC delta adjusted to PM-Timer: 6250082 (10498206) [ 0.199987] TSC delta adjusted to PM-Timer: 330018564 (554329109) [ 0.199987] ..... delta 6250082 [ 0.199987] ..... mult: 268456481 [ 0.199987] ..... calibration result: 3333377 [ 0.199987] ..... CPU clock speed is 3300.1718 MHz. [ 0.199987] ..... host bus clock speed is 1000.0377 MHz. [ 0.200081] Performance Events: unsupported Netburst CPU model 6 no PMU driver, software events only. [ 0.208055] Testing tracer nop: PASSED [ 0.211223] NMI watchdog: disabled (cpu0): hardware events not enabled [ 0.214986] SMP alternatives: lockdep: fixing up alternatives [ 0.223331] smpboot: Booting Node 0, Processors #1 OK [ 0.003333] kvm-clock: cpu 1, msr 0:ddd2841, secondary cpu clock [ 0.003333] masked ExtINT on CPU#1 [ 0.003333] numa_add_cpu cpu 1 node 0: mask now 0-1 [ 0.267357] Brought up 2 CPUs [ 0.268323] ---------------- [ 0.269990] | NMI testsuite: [ 0.270912] -------------------- [ 0.271881] remote IPI:[ 0.269983] KVM setup async PF for cpu 1 [ 0.269983] kvm-stealtime: cpu 1, msr dc0cec0 ok | [ 0.290709] local IPI: ok | [ 0.310007] -------------------- [ 0.311045] Good, all 2 testcases passed! | [ 0.312249] --------------------------------- [ 0.313324] smpboot: Total of 2 processors activated (13206.81 BogoMIPS) [ 0.320797] CPU0 attaching sched-domain: [ 0.322038] domain 0: span 0-1 level CPU [ 0.323330] groups: 0 (cpu_power = 1023) 1 (cpu_power = 1023) [ 0.327039] CPU1 attaching sched-domain: [ 0.328158] domain 0: span 0-1 level CPU [ 0.330702] groups: 1 (cpu_power = 1023) 0 (cpu_power = 1023) [ 0.366761] device: 'platform': device_add [ 0.368335] bus: 'platform': registered [ 0.369767] bus: 'cpu': registered [ 0.370047] device: 'cpu': device_add [ 0.371458] bus: 'memory': registered [ 0.373383] device: 'memory': device_add [ 0.374650] device: 'memory0': device_add [ 0.375897] bus: 'memory': add device memory0 [ 0.376971] device: 'memory1': device_add [ 0.378164] bus: 'memory': add device memory1 [ 0.390912] device class 'regulator': registering [ 0.392765] Registering platform device 'reg-dummy'. Parent at platform [ 0.393329] device: 'reg-dummy': device_add [ 0.400046] bus: 'platform': add device reg-dummy [ 0.403424] bus: 'platform': add driver reg-dummy [ 0.404794] bus: 'platform': driver_probe_device: matched device reg-dummy with driver reg-dummy [ 0.406650] bus: 'platform': really_probe: probing driver reg-dummy with device reg-dummy [ 0.410182] device: 'regulator.0': device_add [ 0.411957] dummy: [ 0.416885] driver: 'reg-dummy': driver_bound: bound to device 'reg-dummy' [ 0.420029] bus: 'platform': really_probe: bound device reg-dummy to driver reg-dummy [ 0.424548] NET: Registered protocol family 16 [ 0.425961] device class 'bdi': registering [ 0.426888] device class 'pci_bus': registering [ 0.428419] bus: 'pci': registered [ 0.429990] device class 'tty': registering [ 0.436773] device class 'vtconsole': registering [ 0.438205] device: 'vtcon0': device_add [ 0.440054] bus: 'node': registered [ 0.441143] device: 'node': device_add [ 0.442655] bus: 'spi': registered [ 0.443313] device class 'spi_master': registering [ 0.450583] ACPI: bus type pci registered [ 0.451784] PCI: Using configuration type 1 for base access [ 0.456733] device: 'node0': device_add [ 0.458107] bus: 'node': add device node0 [ 0.460204] device: 'cpu0': device_add [ 0.461566] bus: 'cpu': add device cpu0 [ 0.463056] device: 'cpu1': device_add [ 0.466716] bus: 'cpu': add device cpu1 [ 0.480767] device: 'default': device_add [ 0.484455] bio: create slab at 0 [ 0.493556] device class 'block': registering [ 0.497568] ACPI: Added _OSI(Module Device) [ 0.499995] ACPI: Added _OSI(Processor Device) [ 0.501238] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.503341] ACPI: Added _OSI(Processor Aggregator Device) [ 0.527105] ACPI: EC: Look up EC in DSDT [ 0.687942] ACPI: Interpreter enabled [ 0.689183] ACPI: (supports S0 S5) [ 0.690859] ACPI: Using IOAPIC for interrupt routing [ 0.692754] bus: 'acpi': registered [ 0.693299] bus: 'acpi': add driver power [ 0.700443] device: 'LNXSYSTM:00': device_add [ 0.701649] bus: 'acpi': add device LNXSYSTM:00 [ 0.704134] device: 'device:00': device_add [ 0.705496] bus: 'acpi': add device device:00 [ 0.708212] device: 'PNP0A03:00': device_add [ 0.709410] bus: 'acpi': add device PNP0A03:00 [ 0.718709] device: 'device:01': device_add [ 0.720028] bus: 'acpi': add device device:01 [ 0.723412] device: 'device:02': device_add [ 0.724538] bus: 'acpi': add device device:02 [ 0.727366] device: 'PNP0B00:00': device_add [ 0.728614] bus: 'acpi': add device PNP0B00:00 [ 0.731488] device: 'PNP0303:00': device_add [ 0.732655] bus: 'acpi': add device PNP0303:00 [ 0.735386] device: 'PNP0F13:00': device_add [ 0.740028] bus: 'acpi': add device PNP0F13:00 [ 0.744797] device: 'PNP0700:00': device_add [ 0.745979] bus: 'acpi': add device PNP0700:00 [ 0.754076] device: 'PNP0400:00': device_add [ 0.755288] bus: 'acpi': add device PNP0400:00 [ 0.759769] device: 'PNP0501:00': device_add [ 0.763355] bus: 'acpi': add device PNP0501:00 [ 0.767418] device: 'device:03': device_add [ 0.769029] bus: 'acpi': add device device:03 [ 0.771334] device: 'device:04': device_add [ 0.772568] bus: 'acpi': add device device:04 [ 0.777487] device: 'device:05': device_add [ 0.778636] bus: 'acpi': add device device:05 [ 0.783673] device: 'device:06': device_add [ 0.784883] bus: 'acpi': add device device:06 [ 0.796638] device: 'device:07': device_add [ 0.797956] bus: 'acpi': add device device:07 [ 0.801407] device: 'device:08': device_add [ 0.803392] bus: 'acpi': add device device:08 [ 0.807040] device: 'device:09': device_add [ 0.810004] bus: 'acpi': add device device:09 [ 0.820226] device: 'device:0a': device_add [ 0.821550] bus: 'acpi': add device device:0a [ 0.824405] device: 'device:0b': device_add [ 0.825702] bus: 'acpi': add device device:0b [ 0.827909] device: 'device:0c': device_add [ 0.830025] bus: 'acpi': add device device:0c [ 0.833869] device: 'device:0d': device_add [ 0.835201] bus: 'acpi': add device device:0d [ 0.837684] device: 'device:0e': device_add [ 0.838822] bus: 'acpi': add device device:0e [ 0.844092] device: 'device:0f': device_add [ 0.846671] bus: 'acpi': add device device:0f [ 0.854213] device: 'device:10': device_add [ 0.855381] bus: 'acpi': add device device:10 [ 0.857830] device: 'device:11': device_add [ 0.858965] bus: 'acpi': add device device:11 [ 0.861236] device: 'device:12': device_add [ 0.866668] bus: 'acpi': add device device:12 [ 0.869114] device: 'device:13': device_add [ 0.869998] bus: 'acpi': add device device:13 [ 0.872587] device: 'device:14': device_add [ 0.873332] bus: 'acpi': add device device:14 [ 0.883712] device: 'device:15': device_add [ 0.885063] bus: 'acpi': add device device:15 [ 0.887953] device: 'device:16': device_add [ 0.889078] bus: 'acpi': add device device:16 [ 0.891234] device: 'device:17': device_add [ 0.893352] bus: 'acpi': add device device:17 [ 0.897220] device: 'device:18': device_add [ 0.898384] bus: 'acpi': add device device:18 [ 0.900862] device: 'device:19': device_add [ 0.901994] bus: 'acpi': add device device:19 [ 0.906671] device: 'device:1a': device_add [ 0.907877] bus: 'acpi': add device device:1a [ 0.911253] device: 'device:1b': device_add [ 0.913344] bus: 'acpi': add device device:1b [ 0.917956] device: 'device:1c': device_add [ 0.920048] bus: 'acpi': add device device:1c [ 0.924350] device: 'device:1d': device_add [ 0.925500] bus: 'acpi': add device device:1d [ 0.927933] device: 'device:1e': device_add [ 0.929062] bus: 'acpi': add device device:1e [ 0.933843] device: 'device:1f': device_add [ 0.935026] bus: 'acpi': add device device:1f [ 0.937887] device: 'device:20': device_add [ 0.939078] bus: 'acpi': add device device:20 [ 0.941217] device: 'device:21': device_add [ 0.943326] bus: 'acpi': add device device:21 [ 0.947957] device: 'device:22': device_add [ 0.949993] bus: 'acpi': add device device:22 [ 0.957342] device: 'PNP0103:00': device_add [ 0.960010] bus: 'acpi': add device PNP0103:00 [ 0.966641] device: 'PNP0C0F:00': device_add [ 0.967875] bus: 'acpi': add device PNP0C0F:00 [ 0.974956] device: 'PNP0C0F:01': device_add [ 0.976683] bus: 'acpi': add device PNP0C0F:01 [ 0.981560] device: 'PNP0C0F:02': device_add [ 0.982696] bus: 'acpi': add device PNP0C0F:02 [ 0.990738] device: 'PNP0C0F:03': device_add [ 0.992222] bus: 'acpi': add device PNP0C0F:03 [ 0.996747] device: 'PNP0C0F:04': device_add [ 1.000051] bus: 'acpi': add device PNP0C0F:04 [ 1.005035] device: 'LNXCPU:00': device_add [ 1.006325] bus: 'acpi': add device LNXCPU:00 [ 1.008870] device: 'LNXCPU:01': device_add [ 1.013337] bus: 'acpi': add device LNXCPU:01 [ 1.017046] device: 'device:23': device_add [ 1.018199] bus: 'acpi': add device device:23 [ 1.019648] device: 'LNXPWRBN:00': device_add [ 1.020014] bus: 'acpi': add device LNXPWRBN:00 [ 1.021728] bus: 'acpi': add driver ec [ 1.023543] PCI: Ignoring host bridge windows from ACPI; if necessary, use "pci=use_crs" and report a bug [ 1.026619] bus: 'acpi': add driver pci_root [ 1.027794] bus: 'acpi': driver_probe_device: matched device PNP0A03:00 with driver pci_root [ 1.029941] bus: 'acpi': really_probe: probing driver pci_root with device PNP0A03:00 [ 1.033559] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 1.036967] pci_root PNP0A03:00: host bridge window [io 0x0000-0x0cf7] (ignored) [ 1.039942] pci_root PNP0A03:00: host bridge window [io 0x0d00-0xffff] (ignored) [ 1.041829] pci_root PNP0A03:00: host bridge window [mem 0x000a0000-0x000bffff] (ignored) [ 1.046613] pci_root PNP0A03:00: host bridge window [mem 0xe0000000-0xfebfffff] (ignored) [ 1.049976] PCI: root bus 00: using default resources [ 1.051294] device: 'pci0000:00': device_add [ 1.052615] device: '0000:00': device_add [ 1.053629] PCI host bridge to bus 0000:00 [ 1.056641] pci_bus 0000:00: busn_res: [bus 00-ff] is inserted under domain [bus 00-ff] [ 1.059940] pci_bus 0000:00: root bus resource [bus 00-ff] [ 1.061252] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] [ 1.063297] pci_bus 0000:00: root bus resource [mem 0x00000000-0xffffffffff] [ 1.066795] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 1.070510] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 1.076613] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 1.084108] pci 0000:00:01.1: reg 20: [io 0xc1c0-0xc1cf] [ 1.087829] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 1.090573] pci 0000:00:01.3: quirk: [io 0xb000-0xb03f] claimed by PIIX4 ACPI [ 1.092427] pci 0000:00:01.3: quirk: [io 0xb100-0xb10f] claimed by PIIX4 SMB [ 1.093547] pci 0000:00:02.0: [1013:00b8] type 00 class 0x030000 [ 1.100101] pci 0000:00:02.0: reg 10: [mem 0xfc000000-0xfdffffff pref] [ 1.107307] pci 0000:00:02.0: reg 14: [mem 0xfebf4000-0xfebf4fff] [ 1.118440] pci 0000:00:02.0: reg 30: [mem 0xfebe0000-0xfebeffff pref] [ 1.120732] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000 [ 1.123339] pci 0000:00:03.0: reg 10: [mem 0xfeba0000-0xfebbffff] [ 1.133861] pci 0000:00:03.0: reg 14: [io 0xc000-0xc03f] [ 1.139236] pci 0000:00:03.0: reg 30: [mem 0xfebc0000-0xfebdffff pref] [ 1.143846] pci 0000:00:04.0: [8086:2668] type 00 class 0x040300 [ 1.145607] pci 0000:00:04.0: reg 10: [mem 0xfebf0000-0xfebf3fff] [ 1.157401] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 1.159333] pci 0000:00:05.0: reg 10: [io 0xc040-0xc07f] [ 1.166631] pci 0000:00:05.0: reg 14: [mem 0xfebf5000-0xfebf5fff] [ 1.177740] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 1.179960] pci 0000:00:06.0: reg 10: [io 0xc080-0xc0bf] [ 1.184033] pci 0000:00:06.0: reg 14: [mem 0xfebf6000-0xfebf6fff] [ 1.193672] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 [ 1.200454] pci 0000:00:07.0: reg 10: [io 0xc0c0-0xc0ff] [ 1.204077] pci 0000:00:07.0: reg 14: [mem 0xfebf7000-0xfebf7fff] [ 1.213065] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 [ 1.217160] pci 0000:00:08.0: reg 10: [io 0xc100-0xc13f] [ 1.219983] pci 0000:00:08.0: reg 14: [mem 0xfebf8000-0xfebf8fff] [ 1.236867] pci 0000:00:09.0: [1af4:1001] type 00 class 0x010000 [ 1.240401] pci 0000:00:09.0: reg 10: [io 0xc140-0xc17f] [ 1.242439] pci 0000:00:09.0: reg 14: [mem 0xfebf9000-0xfebf9fff] [ 1.257480] pci 0000:00:0a.0: [1af4:1001] type 00 class 0x010000 [ 1.260419] pci 0000:00:0a.0: reg 10: [io 0xc180-0xc1bf] [ 1.262666] pci 0000:00:0a.0: reg 14: [mem 0xfebfa000-0xfebfafff] [ 1.271985] pci 0000:00:0b.0: [8086:25ab] type 00 class 0x088000 [ 1.276861] pci 0000:00:0b.0: reg 10: [mem 0xfebfb000-0xfebfb00f] [ 1.284310] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT] [ 1.343431] pci0000:00: Unable to request _OSC control (_OSC support mask: 0x08) [ 1.346717] device: '0000:00:00.0': device_add [ 1.396141] bus: 'pci': add device 0000:00:00.0 [ 1.400481] device: '0000:00:01.0': device_add [ 1.440719] bus: 'pci': add device 0000:00:01.0 [ 1.442501] device: '0000:00:01.1': device_add [ 1.479611] bus: 'pci': add device 0000:00:01.1 [ 1.480408] device: '0000:00:01.3': device_add [ 1.516745] bus: 'pci': add device 0000:00:01.3 [ 1.520439] device: '0000:00:02.0': device_add [ 1.562692] bus: 'pci': add device 0000:00:02.0 [ 1.563716] device: '0000:00:03.0': device_add [ 1.598595] bus: 'pci': add device 0000:00:03.0 [ 1.606893] device: '0000:00:04.0': device_add [ 1.644332] bus: 'pci': add device 0000:00:04.0 [ 1.646894] device: '0000:00:05.0': device_add [ 1.689054] bus: 'pci': add device 0000:00:05.0 [ 1.693723] device: '0000:00:06.0': device_add [ 1.736883] bus: 'pci': add device 0000:00:06.0 [ 1.738506] device: '0000:00:07.0': device_add [ 1.781412] bus: 'pci': add device 0000:00:07.0 [ 1.782996] device: '0000:00:08.0': device_add [ 1.826399] bus: 'pci': add device 0000:00:08.0 [ 1.830327] device: '0000:00:09.0': device_add [ 1.872861] bus: 'pci': add device 0000:00:09.0 [ 1.874016] device: '0000:00:0a.0': device_add [ 1.914902] bus: 'pci': add device 0000:00:0a.0 [ 1.916613] device: '0000:00:0b.0': device_add [ 1.962807] bus: 'pci': add device 0000:00:0b.0 [ 1.963648] driver: 'PNP0A03:00': driver_bound: bound to device 'pci_root' [ 1.965469] bus: 'acpi': really_probe: bound device PNP0A03:00 to driver pci_root [ 1.966816] bus: 'acpi': add driver pci_link [ 1.969991] bus: 'acpi': driver_probe_device: matched device PNP0C0F:00 with driver pci_link [ 1.976552] bus: 'acpi': really_probe: probing driver pci_link with device PNP0C0F:00 [ 1.981479] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11) [ 1.984150] driver: 'PNP0C0F:00': driver_bound: bound to device 'pci_link' [ 1.985968] bus: 'acpi': really_probe: bound device PNP0C0F:00 to driver pci_link [ 1.989900] bus: 'acpi': driver_probe_device: matched device PNP0C0F:01 with driver pci_link [ 1.993212] bus: 'acpi': really_probe: probing driver pci_link with device PNP0C0F:01 [ 1.998383] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11) [ 2.001651] driver: 'PNP0C0F:01': driver_bound: bound to device 'pci_link' [ 2.003218] bus: 'acpi': really_probe: bound device PNP0C0F:01 to driver pci_link [ 2.009901] bus: 'acpi': driver_probe_device: matched device PNP0C0F:02 with driver pci_link [ 2.012187] bus: 'acpi': really_probe: probing driver pci_link with device PNP0C0F:02 [ 2.016677] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11) [ 2.021580] driver: 'PNP0C0F:02': driver_bound: bound to device 'pci_link' [ 2.023219] bus: 'acpi': really_probe: bound device PNP0C0F:02 to driver pci_link [ 2.025311] bus: 'acpi': driver_probe_device: matched device PNP0C0F:03 with driver pci_link [ 2.029886] bus: 'acpi': really_probe: probing driver pci_link with device PNP0C0F:03 [ 2.034931] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11) [ 2.037607] driver: 'PNP0C0F:03': driver_bound: bound to device 'pci_link' [ 2.039361] bus: 'acpi': really_probe: bound device PNP0C0F:03 to driver pci_link [ 2.043227] bus: 'acpi': driver_probe_device: matched device PNP0C0F:04 with driver pci_link [ 2.046543] bus: 'acpi': really_probe: probing driver pci_link with device PNP0C0F:04 [ 2.051659] ACPI: PCI Interrupt Link [LNKS] (IRQs 9) *0 [ 2.054629] driver: 'PNP0C0F:04': driver_bound: bound to device 'pci_link' [ 2.056549] bus: 'acpi': really_probe: bound device PNP0C0F:04 to driver pci_link [ 2.060272] bus: 'pnp': registered [ 2.061392] device class 'misc': registering [ 2.063453] device: 'vga_arbiter': device_add [ 2.065222] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none [ 2.066748] vgaarb: loaded [ 2.067672] vgaarb: bridge control possible 0000:00:02.0 [ 2.069893] bus: 'spi': add driver wm831x [ 2.071209] bus: 'spi': add driver ezx-pcap [ 2.076697] bus: 'spi': add driver da9052 [ 2.078326] bus: 'serio': registered [ 2.079881] device class 'input': registering [ 2.081452] device class 'rtc': registering [ 2.082768] device class 'power_supply': registering [ 2.083295] PCI: Using ACPI for IRQ routing [ 2.084542] PCI: pci_cache_line_size set to 64 bytes [ 2.087709] e820: reserve RAM buffer [mem 0x00093c00-0x0009ffff] [ 2.089924] e820: reserve RAM buffer [mem 0x0fffe000-0x0fffffff] [ 2.093467] device class 'net': registering [ 2.095057] device: 'lo': device_add [ 2.103968] Switching to clocksource kvm-clock [ 2.106523] Warning: could not register annotated branches stats [ 2.666768] bus: 'pnp': add driver system [ 2.668178] pnp: PnP ACPI init [ 2.669204] device: 'pnp0': device_add [ 2.670385] ACPI: bus type pnp registered [ 2.671849] pnp 00:00: [bus 00-ff] [ 2.672932] pnp 00:00: [io 0x0cf8-0x0cff] [ 2.674184] pnp 00:00: [io 0x0000-0x0cf7 window] [ 2.675544] pnp 00:00: [io 0x0d00-0xffff window] [ 2.676778] pnp 00:00: [mem 0x000a0000-0x000bffff window] [ 2.698044] pnp 00:00: [mem 0xe0000000-0xfebfffff window] [ 2.699581] device: '00:00': device_add [ 2.701008] bus: 'pnp': add device 00:00 [ 2.702393] pnp 00:00: Plug and Play ACPI device, IDs PNP0a03 (active) [ 2.704479] pnp 00:01: [io 0x0070-0x0071] [ 2.705700] pnp 00:01: [irq 8] [ 2.723958] pnp 00:01: [io 0x0072-0x0077] [ 2.725225] device: '00:01': device_add [ 2.726527] bus: 'pnp': add device 00:01 [ 2.727837] pnp 00:01: Plug and Play ACPI device, IDs PNP0b00 (active) [ 2.730441] pnp 00:02: [io 0x0060] [ 2.731585] pnp 00:02: [io 0x0064] [ 2.732681] pnp 00:02: [irq 1] [ 2.744828] device: '00:02': device_add [ 2.746194] bus: 'pnp': add device 00:02 [ 2.747520] pnp 00:02: Plug and Play ACPI device, IDs PNP0303 (active) [ 2.750298] pnp 00:03: [irq 12] [ 2.751398] device: '00:03': device_add [ 2.752641] bus: 'pnp': add device 00:03 [ 2.753946] pnp 00:03: Plug and Play ACPI device, IDs PNP0f13 (active) [ 2.773723] pnp 00:04: [io 0x03f2-0x03f5] [ 2.774963] pnp 00:04: [io 0x03f7] [ 2.776039] pnp 00:04: [irq 6] [ 2.776999] pnp 00:04: [dma 2] [ 2.778029] device: '00:04': device_add [ 2.779406] bus: 'pnp': add device 00:04 [ 2.780717] pnp 00:04: Plug and Play ACPI device, IDs PNP0700 (active) [ 2.798079] pnp 00:05: [io 0x0378-0x037f] [ 2.799333] pnp 00:05: [irq 7] [ 2.800348] device: '00:05': device_add [ 2.801693] bus: 'pnp': add device 00:05 [ 2.803081] pnp 00:05: Plug and Play ACPI device, IDs PNP0400 (active) [ 2.815914] pnp 00:06: [io 0x03f8-0x03ff] [ 2.817188] pnp 00:06: [irq 4] [ 2.818225] device: '00:06': device_add [ 2.819531] bus: 'pnp': add device 00:06 [ 2.820852] pnp 00:06: Plug and Play ACPI device, IDs PNP0501 (active) [ 2.850858] pnp 00:07: [mem 0xfed00000-0xfed003ff] [ 2.852370] device: '00:07': device_add [ 2.853802] bus: 'pnp': add device 00:07 [ 2.855171] pnp 00:07: Plug and Play ACPI device, IDs PNP0103 (active) [ 2.884494] pnp: PnP ACPI: found 8 devices [ 2.885729] ACPI: ACPI bus type pnp unregistered [ 2.887143] device class 'mem': registering [ 2.888517] device: 'mem': device_add [ 2.889958] device: 'kmem': device_add [ 2.891389] device: 'null': device_add [ 2.892698] device: 'port': device_add [ 2.905720] device: 'zero': device_add [ 2.907031] device: 'full': device_add [ 2.908444] device: 'random': device_add [ 2.909885] device: 'urandom': device_add [ 2.911335] device: 'kmsg': device_add [ 2.912642] device: 'oldmem': device_add [ 2.914028] device: 'tty': device_add [ 2.930491] device: 'console': device_add [ 2.931972] device: 'tty0': device_add [ 2.933447] device class 'vc': registering [ 2.934760] device: 'vcs': device_add [ 2.936184] device: 'vcsa': device_add [ 2.937526] device: 'vcs1': device_add [ 2.938980] device: 'vcsa1': device_add [ 2.957048] device: 'tty1': device_add [ 2.958597] device: 'tty2': device_add [ 2.959940] device: 'tty3': device_add [ 2.961334] device: 'tty4': device_add [ 2.962726] device: 'tty5': device_add [ 2.964062] device: 'tty6': device_add [ 2.965461] device: 'tty7': device_add [ 2.966789] device: 'tty8': device_add [ 2.984135] device: 'tty9': device_add [ 2.985503] device: 'tty10': device_add [ 2.986861] device: 'tty11': device_add [ 2.988335] device: 'tty12': device_add [ 2.989692] device: 'tty13': device_add [ 2.991155] device: 'tty14': device_add [ 2.992534] device: 'tty15': device_add [ 3.007587] device: 'tty16': device_add [ 3.009017] device: 'tty17': device_add [ 3.010408] device: 'tty18': device_add [ 3.011811] device: 'tty19': device_add [ 3.013216] device: 'tty20': device_add [ 3.025277] device: 'tty21': device_add [ 3.026673] device: 'tty22': device_add [ 3.028171] device: 'tty23': device_add [ 3.029515] device: 'tty24': device_add [ 3.030903] device: 'tty25': device_add [ 3.032304] device: 'tty26': device_add [ 3.033622] device: 'tty27': device_add [ 3.035041] device: 'tty28': device_add [ 3.053589] device: 'tty29': device_add [ 3.054968] device: 'tty30': device_add [ 3.056329] device: 'tty31': device_add [ 3.057701] device: 'tty32': device_add [ 3.059008] device: 'tty33': device_add [ 3.060362] device: 'tty34': device_add [ 3.061751] device: 'tty35': device_add [ 3.076285] device: 'tty36': device_add [ 3.077593] device: 'tty37': device_add [ 3.083720] device: 'tty38': device_add [ 3.105313] device: 'tty39': device_add [ 3.106702] device: 'tty40': device_add [ 3.108162] device: 'tty41': device_add [ 3.109528] device: 'tty42': device_add [ 3.110951] device: 'tty43': device_add [ 3.112341] device: 'tty44': device_add [ 3.113678] device: 'tty45': device_add [ 3.115037] device: 'tty46': device_add [ 3.129635] device: 'tty47': device_add [ 3.131006] device: 'tty48': device_add [ 3.132381] device: 'tty49': device_add [ 3.133748] device: 'tty50': device_add [ 3.150341] device: 'tty51': device_add [ 3.151774] device: 'tty52': device_add [ 3.153164] device: 'tty53': device_add [ 3.154539] device: 'tty54': device_add [ 3.155925] device: 'tty55': device_add [ 3.157327] device: 'tty56': device_add [ 3.158781] device: 'tty57': device_add [ 3.160193] device: 'tty58': device_add [ 3.161549] device: 'tty59': device_add [ 3.174246] device: 'tty60': device_add [ 3.175604] device: 'tty61': device_add [ 3.176968] device: 'tty62': device_add [ 3.178399] device: 'tty63': device_add [ 3.191031] device class 'firmware': registering [ 3.192514] device class 'thermal': registering [ 3.212495] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] [ 3.213980] pci_bus 0000:00: resource 5 [mem 0x00000000-0xffffffffff] [ 3.215961] NET: Registered protocol family 1 [ 3.217362] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 3.219022] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 3.220695] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 3.238560] pci 0000:00:02.0: Boot video device [ 3.240269] PCI: CLS 0 bytes, default 64 [ 3.242621] Unpacking initramfs... [ 8.250867] Freeing initrd memory: 23656k freed [ 8.804065] DMA-API: preallocated 32768 debug entries [ 8.805462] DMA-API: debugging enabled by kernel config [ 8.808397] Registering platform device 'pcspkr'. Parent at platform [ 8.810066] device: 'pcspkr': device_add [ 8.811166] bus: 'platform': add device pcspkr [ 8.812997] bus: 'clocksource': registered [ 8.814080] device: 'clocksource': device_add [ 8.825537] device: 'clocksource0': device_add [ 8.826810] bus: 'clocksource': add device clocksource0 [ 8.828583] bus: 'platform': add driver alarmtimer [ 8.830029] Registering platform device 'alarmtimer'. Parent at platform [ 8.831607] device: 'alarmtimer': device_add [ 8.832774] bus: 'platform': add device alarmtimer [ 8.834051] bus: 'platform': driver_probe_device: matched device alarmtimer with driver alarmtimer [ 8.848573] bus: 'platform': really_probe: probing driver alarmtimer with device alarmtimer [ 8.850775] driver: 'alarmtimer': driver_bound: bound to device 'alarmtimer' [ 8.852459] bus: 'platform': really_probe: bound device alarmtimer to driver alarmtimer [ 8.854768] bus: 'rttest': registered [ 8.855819] device: 'rttest': device_add [ 8.896313] device: 'rttest0': device_add [ 8.897418] bus: 'rttest': add device rttest0 [ 8.898926] device: 'rttest1': device_add [ 8.900024] bus: 'rttest': add device rttest1 [ 8.901743] device: 'rttest2': device_add [ 8.902904] bus: 'rttest': add device rttest2 [ 8.924319] device: 'rttest3': device_add [ 8.925505] bus: 'rttest': add device rttest3 [ 8.927138] device: 'rttest4': device_add [ 8.928344] bus: 'rttest': add device rttest4 [ 8.930133] device: 'rttest5': device_add [ 8.931255] bus: 'rttest': add device rttest5 [ 8.978270] device: 'rttest6': device_add [ 8.979391] bus: 'rttest': add device rttest6 [ 8.980959] device: 'rttest7': device_add [ 8.982236] bus: 'rttest': add device rttest7 [ 8.983626] Initializing RT-Tester: OK [ 8.984818] audit: initializing netlink socket (disabled) [ 8.986448] type=2000 audit(1345761198.983:1): initialized [ 9.049363] Kprobe smoke test started [ 9.084881] Kprobe smoke test failed: register_jprobe returned -22 [ 9.086786] Kprobe smoke test failed: register_jprobes returned -22 [ 9.121281] BUG: Kprobe smoke test: 2 out of 6 tests failed [ 9.171132] Testing tracer function: PASSED [ 9.408938] Testing dynamic ftrace: PASSED [ 9.781718] Testing dynamic ftrace ops #1: (1 0 1 1 0) (1 1 2 1 0) (2 1 3 1 9) (2 2 4 1 341) PASSED [ 10.210541] Testing dynamic ftrace ops #2: [ 10.314710] tsc: Refined TSC clocksource calibration: 3300.196 MHz (1 0 1 3 0) (1 1 2 268 0) (2 1 3 1 3) (2 2 4 379 381) PASSED [ 10.655904] Testing ftrace recursion: PASSED [ 10.678444] Testing ftrace recursion safe: PASSED [ 10.698913] Testing ftrace regs: PASSED [ 10.797812] Testing tracer irqsoff: [ 10.959633] [ 10.960459] =============================== [ 10.961689] [ INFO: suspicious RCU usage. ] [ 10.961689] 3.6.0-rc1-00241-gd57c5d5 #709 Not tainted [ 10.961689] ------------------------------- [ 10.961689] /c/kernel-tests/src/tip/include/linux/rcupdate.h:725 rcu_read_lock() used illegally while idle! [ 10.961689] [ 10.961689] other info that might help us debug this: [ 10.961689] [ 10.961689] [ 10.961689] RCU used illegally from idle CPU! [ 10.961689] rcu_scheduler_active = 1, debug_locks = 1 [ 10.961689] RCU used illegally from extended quiescent state! [ 10.961689] 2 locks held by swapper/1/0: [ 10.961689] #0: (max_trace_lock){......}, at: [] check_critical_timing+0xae/0x205 [ 10.961689] #1: (rcu_read_lock){.+.+..}, at: [] __update_max_tr+0x0/0x2f0 [ 10.961689] [ 10.961689] stack backtrace: [ 10.961689] Pid: 0, comm: swapper/1 Not tainted 3.6.0-rc1-00241-gd57c5d5 #709 [ 10.961689] Call Trace: [ 10.961689] [] lockdep_rcu_suspicious+0x16b/0x180 [ 10.961689] [] __update_max_tr+0x11e/0x2f0 [ 10.961689] [] ? tracing_record_cmdline+0x190/0x190 [ 10.961689] [] update_max_tr_single+0x1de/0x250 [ 10.961689] [] check_critical_timing+0x190/0x205 [ 10.961689] [] ? default_idle+0x361/0x900 [ 10.961689] [] ? default_idle+0x361/0x900 [ 10.961689] [] ? default_idle+0x361/0x900 [ 10.961689] [] ? trace_hardirqs_on+0x1d/0x30 [ 10.961689] [] time_hardirqs_on+0x109/0x1a0 [ 10.961689] [] ? default_idle+0x361/0x900 [ 10.961689] [] trace_hardirqs_on_caller+0x26/0x390 [ 10.961689] [] trace_hardirqs_on+0x1d/0x30 [ 10.961689] [] default_idle+0x361/0x900 [ 10.961689] [] cpu_idle+0x1d4/0x300 [ 10.961689] [] start_secondary+0x717/0x72d [ 10.961689] [ 10.961689] =============================== [ 10.961689] [ INFO: suspicious RCU usage. ] [ 10.961689] 3.6.0-rc1-00241-gd57c5d5 #709 Not tainted [ 10.961689] ------------------------------- [ 10.961689] /c/kernel-tests/src/tip/kernel/trace/trace.c:675 suspicious rcu_dereference_check() usage! [ 10.961689] [ 10.961689] other info that might help us debug this: [ 10.961689] [ 10.961689] [ 10.961689] RCU used illegally from idle CPU! [ 10.961689] rcu_scheduler_active = 1, debug_locks = 1 [ 10.961689] RCU used illegally from extended quiescent state! [ 10.961689] 2 locks held by swapper/1/0: [ 10.961689] #0: (max_trace_lock){......}, at: [] check_critical_timing+0xae/0x205 [ 10.961689] #1: (rcu_read_lock){.+.+..}, at: [] __update_max_tr+0x0/0x2f0 [ 10.961689] [ 10.961689] stack backtrace: [ 10.961689] Pid: 0, comm: swapper/1 Not tainted 3.6.0-rc1-00241-gd57c5d5 #709 [ 10.961689] Call Trace: [ 10.961689] [] lockdep_rcu_suspicious+0x16b/0x180 [ 10.961689] [] __update_max_tr+0x1e0/0x2f0 [ 10.961689] [] ? tracing_record_cmdline+0x190/0x190 [ 10.961689] [] update_max_tr_single+0x1de/0x250 [ 10.961689] [] check_critical_timing+0x190/0x205 [ 10.961689] [] ? default_idle+0x361/0x900 [ 10.961689] [] ? default_idle+0x361/0x900 [ 10.961689] [] ? default_idle+0x361/0x900 [ 10.961689] [] ? trace_hardirqs_on+0x1d/0x30 [ 10.961689] [] time_hardirqs_on+0x109/0x1a0 [ 10.961689] [] ? default_idle+0x361/0x900 [ 10.961689] [] trace_hardirqs_on_caller+0x26/0x390 [ 10.961689] [] trace_hardirqs_on+0x1d/0x30 [ 10.961689] [] default_idle+0x361/0x900 [ 10.961689] [] cpu_idle+0x1d4/0x300 [ 10.961689] [] start_secondary+0x717/0x72d [ 10.961689] [ 10.961689] =============================== [ 10.961689] [ INFO: suspicious RCU usage. ] [ 10.961689] 3.6.0-rc1-00241-gd57c5d5 #709 Not tainted [ 10.961689] ------------------------------- [ 10.961689] /c/kernel-tests/src/tip/include/linux/rcupdate.h:746 rcu_read_unlock() used illegally while idle! [ 10.961689] [ 10.961689] other info that might help us debug this: [ 10.961689] [ 10.961689] [ 10.961689] RCU used illegally from idle CPU! [ 10.961689] rcu_scheduler_active = 1, debug_locks = 1 [ 10.961689] RCU used illegally from extended quiescent state! [ 10.961689] 2 locks held by swapper/1/0: [ 10.961689] #0: (max_trace_lock){......}, at: [] check_critical_timing+0xae/0x205 [ 10.961689] #1: (rcu_read_lock){.+.+..}, at: [] __update_max_tr+0x0/0x2f0 [ 10.961689] [ 10.961689] stack backtrace: [ 10.961689] Pid: 0, comm: swapper/1 Not tainted 3.6.0-rc1-00241-gd57c5d5 #709 [ 10.961689] Call Trace: [ 10.961689] [] lockdep_rcu_suspicious+0x16b/0x180 [ 10.961689] [] __update_max_tr+0x256/0x2f0 [ 10.961689] [] ? tracing_record_cmdline+0x190/0x190 [ 10.961689] [] update_max_tr_single+0x1de/0x250 [ 10.961689] [] check_critical_timing+0x190/0x205 [ 10.961689] [] ? default_idle+0x361/0x900 [ 10.961689] [] ? default_idle+0x361/0x900 [ 10.961689] [] ? default_idle+0x361/0x900 [ 10.961689] [] ? trace_hardirqs_on+0x1d/0x30 [ 10.961689] [] time_hardirqs_on+0x109/0x1a0 [ 10.961689] [] ? default_idle+0x361/0x900 [ 10.961689] [] trace_hardirqs_on_caller+0x26/0x390 [ 10.961689] [] trace_hardirqs_on+0x1d/0x30 [ 10.961689] [] default_idle+0x361/0x900 [ 10.961689] [] cpu_idle+0x1d4/0x300 [ 10.961689] [] start_secondary+0x717/0x72d [ 11.861159] PASSED [ 11.891155] Testing tracer wakeup: PASSED [ 12.298405] Testing tracer wakeup_rt: PASSED [ 12.778406] Testing tracer function_graph: PASSED [ 13.191749] Testing tracer branch: PASSED [ 13.369297] bus: 'event_source': registered [ 13.370505] device: 'breakpoint': device_add [ 13.371813] bus: 'event_source': add device breakpoint [ 13.373406] device: 'tracepoint': device_add [ 13.374659] bus: 'event_source': add device tracepoint [ 13.376264] device: 'software': device_add [ 13.377552] bus: 'event_source': add device software [ 13.379925] HugeTLB registered 2 MB page size, pre-allocated 0 pages [ 13.721535] msgmni has been set to 427 [ 13.735281] device class 'bsg': registering [ 13.736608] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 254) [ 13.738682] io scheduler noop registered (default) [ 13.739956] start plist test [ 13.761036] end plist test [ 13.761933] list_sort_test: start testing list_sort() [ 13.778011] bus: 'acpi': add driver ac [ 13.794862] bus: 'acpi': add driver button [ 13.796159] bus: 'acpi': driver_probe_device: matched device LNXPWRBN:00 with driver button [ 13.800359] bus: 'acpi': really_probe: probing driver button with device LNXPWRBN:00 [ 13.802550] device: 'input0': device_add [ 13.804346] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 13.806448] ACPI: Power Button [PWRF] [ 13.807521] driver: 'LNXPWRBN:00': driver_bound: bound to device 'button' [ 13.824819] bus: 'acpi': really_probe: bound device LNXPWRBN:00 to driver button [ 13.826990] bus: 'acpi': add driver fan [ 13.828331] bus: 'acpi': add driver processor [ 13.829643] bus: 'acpi': driver_probe_device: matched device LNXCPU:00 with driver processor [ 13.843926] bus: 'acpi': really_probe: probing driver processor with device LNXCPU:00 [ 13.849784] device: 'cooling_device0': device_add [ 13.851497] driver: 'LNXCPU:00': driver_bound: bound to device 'processor' [ 13.853249] bus: 'acpi': really_probe: bound device LNXCPU:00 to driver processor [ 13.875341] bus: 'acpi': driver_probe_device: matched device LNXCPU:01 with driver processor [ 13.877440] bus: 'acpi': really_probe: probing driver processor with device LNXCPU:01 [ 13.894812] device: 'cooling_device1': device_add [ 13.896404] driver: 'LNXCPU:01': driver_bound: bound to device 'processor' [ 13.898145] bus: 'acpi': really_probe: bound device LNXCPU:01 to driver processor [ 13.900292] bus: 'acpi': add driver thermal [ 13.923254] device: 'ptmx': device_add [ 13.924679] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled [ 13.926439] Registering platform device 'serial8250'. Parent at platform [ 13.928307] device: 'serial8250': device_add [ 13.929639] bus: 'platform': add device serial8250 [ 13.932512] bus: 'acpi': add driver battery [ 14.011068] serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A [ 14.011176] device: 'ttyS0': device_add [ 14.011767] device: 'ttyS1': device_add [ 14.012169] device: 'ttyS2': device_add [ 14.012499] device: 'ttyS3': device_add [ 14.012714] bus: 'platform': add driver serial8250 [ 14.012769] bus: 'platform': driver_probe_device: matched device serial8250 with driver serial8250 [ 14.012771] bus: 'platform': really_probe: probing driver serial8250 with device serial8250 [ 14.012822] driver: 'serial8250': driver_bound: bound to device 'serial8250' [ 14.012829] bus: 'platform': really_probe: bound device serial8250 to driver serial8250 [ 14.012916] bus: 'pnp': add driver serial [ 14.013021] bus: 'pnp': driver_probe_device: matched device 00:06 with driver serial [ 14.013023] bus: 'pnp': really_probe: probing driver serial with device 00:06 [ 14.013287] device: 'ttyS0': device_unregister [ 14.013802] device: 'ttyS0': device_create_release [ 14.110519] 00:06: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A [ 14.110596] device: 'ttyS0': device_add [ 14.111044] driver: '00:06': driver_bound: bound to device 'serial' [ 14.111051] bus: 'pnp': really_probe: bound device 00:06 to driver serial [ 14.111198] bus: 'pci': add driver serial [ 14.111781] bus: 'pnp': add driver i8042 kbd [ 14.111845] bus: 'pnp': driver_probe_device: matched device 00:02 with driver i8042 kbd [ 14.111848] bus: 'pnp': really_probe: probing driver i8042 kbd with device 00:02 [ 14.111911] driver: '00:02': driver_bound: bound to device 'i8042 kbd' [ 14.111917] bus: 'pnp': really_probe: bound device 00:02 to driver i8042 kbd [ 14.112043] bus: 'pnp': add driver i8042 aux [ 14.112141] bus: 'pnp': driver_probe_device: matched device 00:03 with driver i8042 aux [ 14.112143] bus: 'pnp': really_probe: probing driver i8042 aux with device 00:03 [ 14.112202] driver: '00:03': driver_bound: bound to device 'i8042 aux' [ 14.112207] bus: 'pnp': really_probe: bound device 00:03 to driver i8042 aux [ 14.112300] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 14.112369] Registering platform device 'i8042'. Parent at platform [ 14.112380] device: 'i8042': device_add [ 14.112437] bus: 'platform': add device i8042 [ 14.112556] bus: 'platform': add driver i8042 [ 14.112613] bus: 'platform': driver_probe_device: matched device i8042 with driver i8042 [ 14.112615] bus: 'platform': really_probe: probing driver i8042 with device i8042 [ 14.390294] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 14.391707] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 14.393272] device: 'serio0': device_add [ 14.394598] bus: 'serio': add device serio0 [ 14.409254] driver: 'i8042': driver_bound: bound to device 'i8042' [ 14.410837] device: 'serio1': device_add [ 14.412177] bus: 'serio': add device serio1 [ 14.413584] bus: 'platform': really_probe: bound device i8042 to driver i8042 [ 14.415632] device: 'mice': device_add [ 14.417381] mousedev: PS/2 mouse device common for all mice [ 14.418874] bus: 'serio': add driver atkbd [ 14.420245] bus: 'serio': driver_probe_device: matched device serio0 with driver atkbd [ 14.440053] bus: 'serio': really_probe: probing driver atkbd with device serio0 [ 14.442225] cpuidle: using governor ladder [ 14.443404] device class 'extcon': registering [ 14.450995] bus: 'machinecheck': registered [ 14.452432] device: 'machinecheck': device_add [ 14.457367] device: 'machinecheck0': device_add [ 14.458713] bus: 'machinecheck': add device machinecheck0 [ 14.460495] device: 'machinecheck1': device_add [ 14.461858] bus: 'machinecheck': add device machinecheck1 [ 14.463633] device: 'mcelog': device_add [ 14.516067] device: 'input1': device_add [ 14.518088] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 14.520597] driver: 'serio0': driver_bound: bound to device 'atkbd' [ 14.538589] [ 14.538589] printing PIC contents [ 14.538599] ... PIC IMR: ffff [ 14.538605] ... PIC IRR: 1013 [ 14.538615] ... PIC ISR: 0000 [ 14.538621] ... PIC ELCR: 0c00 [ 14.538632] printing local APIC contents on CPU#0/0: [ 14.538639] ... APIC ID: 00000000 (0) [ 14.538643] ... APIC VERSION: 00050014 [ 14.538650] ... APIC TASKPRI: 00000000 (00) [ 14.538654] ... APIC PROCPRI: 00000000 [ 14.538658] ... APIC LDR: 01000000 [ 14.538662] ... APIC DFR: ffffffff [ 14.538666] ... APIC SPIV: 000001ff [ 14.538667] ... APIC ISR field: [ 14.538696] 0000000000000000000000000000000000000000000000000000000000000000 [ 14.538697] ... APIC TMR field: [ 14.538723] 0000000000000000000000000000000000000000000000000000000000000000 [ 14.538724] ... APIC IRR field: [ 14.538753] 0000000000000000000000000000000000000000000000000000000000000000 [ 14.538759] ... APIC ESR: 00000000 [ 14.538765] ... APIC ICR: 000008fd [ 14.538766] ... APIC ICR2: 02000000 [ 14.538769] ... APIC LVTT: 000200ef [ 14.538772] ... APIC LVTPC: 00010000 [ 14.538776] ... APIC LVT0: 00010700 [ 14.538780] ... APIC LVT1: 00000400 [ 14.538784] ... APIC LVTERR: 000000fe [ 14.538788] ... APIC TMICT: 00032dd0 [ 14.538792] ... APIC TMCCT: 000235dd [ 14.538795] ... APIC TDCR: 00000003 [ 14.538796] [ 14.538797] number of MP IRQ sources: 15. [ 14.538798] number of IO-APIC #2 registers: 24. [ 14.538799] testing the IO APIC....................... [ 14.538814] IO APIC #2...... [ 14.538815] .... register #00: 00000000 [ 14.538816] ....... : physical APIC id: 00 [ 14.538817] ....... : Delivery Type: 0 [ 14.538818] ....... : LTS : 0 [ 14.538819] .... register #01: 00170011 [ 14.538820] ....... : max redirection entries: 17 [ 14.538821] ....... : PRQ implemented: 0 [ 14.538822] ....... : IO APIC version: 11 [ 14.538823] .... register #02: 00000000 [ 14.538824] ....... : arbitration: 00 [ 14.538825] .... IRQ redirection table: [ 14.538825] NR Dst Mask Trig IRR Pol Stat Dmod Deli Vect: [ 14.538838] 00 00 1 0 0 0 0 0 0 00 [ 14.538850] 01 03 0 0 0 0 0 1 1 41 [ 14.538862] 02 03 0 0 0 0 0 1 1 51 [ 14.538873] 03 01 0 0 0 0 0 1 1 61 [ 14.538885] 04 01 1 0 0 0 0 1 1 71 [ 14.538899] 05 01 1 1 0 0 0 1 1 81 [ 14.538915] 06 01 0 0 0 0 0 1 1 91 [ 14.538931] 07 01 0 0 0 0 0 1 1 A1 [ 14.538947] 08 01 0 0 0 0 0 1 1 B1 [ 14.538967] 09 01 0 1 0 0 0 1 1 C1 [ 14.538982] 0a 01 1 1 0 0 0 1 1 D1 [ 14.538998] 0b 01 1 1 0 0 0 1 1 E1 [ 14.539016] 0c 03 0 0 0 0 0 1 1 22 [ 14.539033] 0d 01 0 0 0 0 0 1 1 42 [ 14.539048] 0e 01 0 0 0 0 0 1 1 52 [ 14.539064] 0f 01 0 0 0 0 0 1 1 62 [ 14.539080] 10 00 1 0 0 0 0 0 0 00 [ 14.539126] 11 00 1 0 0 0 0 0 0 00 [ 14.539142] 12 00 1 0 0 0 0 0 0 00 [ 14.539156] 13 00 1 0 0 0 0 0 0 00 [ 14.539172] 14 00 1 0 0 0 0 0 0 00 [ 14.539188] 15 00 1 0 0 0 0 0 0 00 [ 14.539204] 16 00 1 0 0 0 0 0 0 00 [ 14.539221] 17 00 1 0 0 0 0 0 0 00 [ 14.539222] IRQ to pin mappings: [ 14.539226] IRQ0 -> 0:2 [ 14.539229] IRQ1 -> 0:1 [ 14.539233] IRQ3 -> 0:3 [ 14.539236] IRQ4 -> 0:4 [ 14.539239] IRQ5 -> 0:5 [ 14.539243] IRQ6 -> 0:6 [ 14.539246] IRQ7 -> 0:7 [ 14.539249] IRQ8 -> 0:8 [ 14.539252] IRQ9 -> 0:9 [ 14.539256] IRQ10 -> 0:10 [ 14.539259] IRQ11 -> 0:11 [ 14.539262] IRQ12 -> 0:12 [ 14.539265] IRQ13 -> 0:13 [ 14.539273] IRQ14 -> 0:14 [ 14.539279] IRQ15 -> 0:15 [ 14.539280] .................................... done. [ 14.539426] device: 'cpu_dma_latency': device_add [ 14.539661] device: 'network_latency': device_add [ 14.539893] device: 'network_throughput': device_add [ 14.540303] registered taskstats version 1 [ 14.540305] Running tests on trace events: [ 14.795455] bus: 'serio': really_probe: bound device serio0 to driver atkbd [ 14.797286] bus: 'serio': driver_probe_device: matched device serio1 with driver atkbd [ 14.799543] bus: 'serio': really_probe: probing driver atkbd with device serio1 [ 14.802124] atkbd: probe of serio1 rejects match -19 [ 14.844364] Testing event kfree_skb: OK [ 14.845546] Testing event consume_skb: OK [ 14.858631] Testing event skb_copy_datagram_iovec: OK [ 14.894873] Testing event net_dev_xmit: OK [ 14.915247] Testing event net_dev_queue: OK [ 14.934900] Testing event netif_receive_skb: OK [ 14.948606] Testing event netif_rx: OK [ 14.961848] Testing event napi_poll: OK [ 14.975254] Testing event sock_rcvqueue_full: OK [ 14.994832] Testing event sock_exceed_buf_limit: OK [ 15.008519] Testing event udp_fail_queue_rcv_skb: OK [ 15.021896] Testing event regmap_reg_write: OK [ 15.041796] Testing event regmap_reg_read: OK [ 15.055226] Testing event regmap_reg_read_cache: OK [ 15.068526] Testing event regmap_hw_read_start: OK [ 15.081925] Testing event regmap_hw_read_done: OK [ 15.131015] Testing event regmap_hw_write_start: OK [ 15.181882] Testing event regmap_hw_write_done: OK [ 15.195194] Testing event regcache_sync: OK [ 15.208510] Testing event regmap_cache_only: OK [ 15.221921] Testing event regmap_cache_bypass: OK [ 15.235227] Testing event mix_pool_bytes: OK [ 15.273811] Testing event mix_pool_bytes_nolock: OK [ 15.288561] Testing event credit_entropy_bits: OK [ 15.308886] Testing event get_random_bytes: OK [ 15.321924] Testing event extract_entropy: OK [ 15.338591] Testing event extract_entropy_user: OK [ 15.351812] Testing event regulator_enable: OK [ 15.365206] Testing event regulator_enable_delay: OK [ 15.378472] Testing event regulator_enable_complete: OK [ 15.391852] Testing event regulator_disable: OK [ 15.405068] Testing event regulator_disable_complete: OK [ 15.418498] Testing event regulator_set_voltage: OK [ 15.431799] Testing event regulator_set_voltage_complete: OK [ 15.445217] Testing event block_rq_abort: OK [ 15.458473] Testing event block_rq_requeue: OK [ 15.471847] Testing event block_rq_complete: OK [ 15.485138] Testing event block_rq_insert: OK [ 15.498519] Testing event block_rq_issue: OK [ 15.511766] Testing event block_bio_bounce: OK [ 15.525168] Testing event block_bio_complete: OK [ 15.538487] Testing event block_bio_backmerge: OK [ 15.555132] Testing event block_bio_frontmerge: OK [ 15.568548] Testing event block_bio_queue: OK [ 15.581804] Testing event block_getrq: OK [ 15.595209] Testing event block_sleeprq: OK [ 15.608481] Testing event block_plug: OK [ 15.621877] Testing event block_unplug: OK [ 15.635144] Testing event block_split: OK [ 15.648541] Testing event block_bio_remap: OK [ 15.661748] Testing event block_rq_remap: OK [ 15.675202] Testing event writeback_nothread: OK [ 15.688489] Testing event writeback_queue: OK [ 15.701856] Testing event writeback_exec: OK [ 15.715134] Testing event writeback_start: OK [ 15.728498] Testing event writeback_written: OK [ 15.741897] Testing event writeback_wait: OK [ 15.755275] Testing event writeback_pages_written: OK [ 15.773799] Testing event writeback_nowork: OK [ 15.788557] Testing event writeback_wake_background: OK [ 15.801842] Testing event writeback_wake_thread: OK [ 15.818797] Testing event writeback_wake_forker_thread: OK [ 15.831831] Testing event writeback_bdi_register: OK [ 15.845176] Testing event writeback_bdi_unregister: OK [ 15.858532] Testing event writeback_thread_start: OK [ 15.871821] Testing event writeback_thread_stop: OK [ 15.885265] Testing event wbc_writepage: OK [ 15.898558] Testing event writeback_queue_io: OK [ 15.911915] Testing event global_dirty_state: OK [ 15.925184] Testing event bdi_dirty_ratelimit: OK [ 15.938620] Testing event balance_dirty_pages: OK [ 15.951791] Testing event writeback_sb_inodes_requeue: OK [ 15.965281] Testing event writeback_congestion_wait: OK [ 15.978565] Testing event writeback_wait_iff_congested: OK [ 15.991797] Testing event writeback_single_inode: OK [ 16.005256] Testing event mm_compaction_isolate_migratepages: OK [ 16.021927] Testing event mm_compaction_isolate_freepages: OK [ 16.035174] Testing event mm_compaction_migratepages: OK [ 16.048638] Testing event kmalloc: OK [ 16.061808] Testing event kmem_cache_alloc: OK [ 16.075243] Testing event kmalloc_node: OK [ 16.088468] Testing event kmem_cache_alloc_node: OK [ 16.101838] Testing event kfree: OK [ 16.115143] Testing event kmem_cache_free: OK [ 16.128554] Testing event mm_page_free: OK [ 16.141766] Testing event mm_page_free_batched: OK [ 16.155749] Testing event mm_page_alloc: OK [ 16.168463] Testing event mm_page_alloc_zone_locked: OK [ 16.181841] Testing event mm_page_pcpu_drain: OK [ 16.195259] Testing event mm_page_alloc_extfrag: OK [ 16.208571] Testing event mm_vmscan_kswapd_sleep: OK [ 16.221800] Testing event mm_vmscan_kswapd_wake: OK [ 16.235226] Testing event mm_vmscan_wakeup_kswapd: OK [ 16.248550] Testing event mm_vmscan_direct_reclaim_begin: OK [ 16.266393] Testing event mm_vmscan_memcg_reclaim_begin: OK [ 16.281879] Testing event mm_vmscan_memcg_softlimit_reclaim_begin: OK [ 16.295176] Testing event mm_vmscan_direct_reclaim_end: OK [ 16.308666] Testing event mm_vmscan_memcg_reclaim_end: OK [ 16.321865] Testing event mm_vmscan_memcg_softlimit_reclaim_end: OK [ 16.360862] Testing event mm_shrink_slab_start: OK [ 16.382520] Testing event mm_shrink_slab_end: OK [ 16.405217] Testing event mm_vmscan_lru_isolate: OK [ 16.418593] Testing event mm_vmscan_memcg_isolate: OK [ 16.439836] Testing event mm_vmscan_writepage: OK [ 16.455253] Testing event mm_vmscan_lru_shrink_inactive: OK [ 16.468607] Testing event oom_score_adj_update: OK [ 16.514829] Testing event cpu_idle: OK [ 16.528598] Testing event cpu_frequency: OK [ 16.541866] Testing event machine_suspend: