[ 0.000000] Linux version 3.5.0+ (wfg@bee) (gcc version 4.7.1 (Debian 4.7.1-5) ) #1289 SMP Mon Jul 23 04:15:02 CST 2012 [ 0.000000] KERNEL supported cpus: [ 0.000000] Intel GenuineIntel [ 0.000000] NSC Geode by NSC [ 0.000000] Cyrix CyrixInstead [ 0.000000] Centaur CentaurHauls [ 0.000000] Transmeta GenuineTMx86 [ 0.000000] Transmeta TransmetaCPU [ 0.000000] UMC UMC UMC UMC [ 0.000000] Disabled fast string operations [ 0.000000] e820: BIOS-provided physical RAM map: [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009f3ff] usable [ 0.000000] BIOS-e820: [mem 0x000000000009f400-0x000000000009ffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000000fffcfff] usable [ 0.000000] BIOS-e820: [mem 0x000000000fffd000-0x000000000fffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000fffbc000-0x00000000ffffffff] reserved [ 0.000000] debug: ignoring loglevel setting. [ 0.000000] Notice: NX (Execute Disable) protection cannot be enabled: non-PAE kernel! [ 0.000000] DMI 2.4 present. [ 0.000000] DMI: Bochs Bochs, BIOS Bochs 01/01/2007 [ 0.000000] e820: update [mem 0x00000000-0x0000ffff] usable ==> reserved [ 0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable [ 0.000000] e820: last_pfn = 0xfffd max_arch_pfn = 0x100000 [ 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 0x70106, 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 0x000f8860-0x000f886f] mapped at [400f8860] [ 0.000000] mpc: f8870-f898c [ 0.000000] initial memory mapped: [mem 0x00000000-0x023fffff] [ 0.000000] Base memory trampoline at [4009b000] 9b000 size 16384 [ 0.000000] init_memory_mapping: [mem 0x00000000-0x0fffcfff] [ 0.000000] [mem 0x00000000-0x0fffcfff] page 4k [ 0.000000] kernel direct mapping tables up to 0xfffcfff @ [mem 0x023bd000-0x023fffff] [ 0.000000] log_buf_len: 8388608 [ 0.000000] early log buf free: 128376(97%) [ 0.000000] RAMDISK: [mem 0x0fce4000-0x0ffeffff] [ 0.000000] 0MB HIGHMEM available. [ 0.000000] 255MB LOWMEM available. [ 0.000000] mapped low ram: 0 - 0fffd000 [ 0.000000] low ram: 0 - 0fffd000 [ 0.000000] kvm-clock: Using msrs 12 and 11 [ 0.000000] kvm-clock: cpu 0, msr 0:15b61c1, boot clock [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x00010000-0x00ffffff] [ 0.000000] Normal [mem 0x01000000-0x0fffcfff] [ 0.000000] HighMem empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x00010000-0x0009efff] [ 0.000000] node 0: [mem 0x00100000-0x0fffcfff] [ 0.000000] On node 0 totalpages: 65420 [ 0.000000] free_area_init_node: node 0, pgdat 413f7b00, node_mem_map 4f264280 [ 0.000000] DMA zone: 40 pages used for memmap [ 0.000000] DMA zone: 0 pages reserved [ 0.000000] DMA zone: 3943 pages, LIFO batch:0 [ 0.000000] Normal zone: 600 pages used for memmap [ 0.000000] Normal zone: 60837 pages, LIFO batch:15 [ 0.000000] Using APIC driver default [ 0.000000] Intel MultiProcessor Specification v1.4 [ 0.000000] Virtual Wire compatibility mode. [ 0.000000] mpc: f8870-f898c [ 0.000000] MPTABLE: OEM ID: BOCHSCPU [ 0.000000] MPTABLE: Product ID: 0.1 [ 0.000000] MPTABLE: APIC at: 0xFEE00000 [ 0.000000] mapped APIC to ffffb000 ( fee00000) [ 0.000000] Processor #0 (Bootup-CPU) [ 0.000000] Processor #1 [ 0.000000] Bus #0 is PCI [ 0.000000] Bus #1 is ISA [ 0.000000] IOAPIC[0]: Assigned apic_id 2 [ 0.000000] IOAPIC[0]: apic_id 2, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] Int: type 0, pol 1, trig 0, bus 00, IRQ 04, APIC ID 2, APIC INT 09 [ 0.000000] Int: type 0, pol 1, trig 0, bus 00, IRQ 0c, APIC ID 2, APIC INT 0b [ 0.000000] Int: type 0, pol 1, trig 0, bus 00, IRQ 10, APIC ID 2, APIC INT 0b [ 0.000000] Int: type 0, pol 1, trig 0, bus 00, IRQ 14, APIC ID 2, APIC INT 0a [ 0.000000] Int: type 0, pol 1, trig 0, bus 00, IRQ 18, APIC ID 2, APIC INT 0a [ 0.000000] Int: type 0, pol 1, trig 0, bus 00, IRQ 1c, APIC ID 2, APIC INT 0b [ 0.000000] Int: type 0, pol 1, trig 0, bus 00, IRQ 20, APIC ID 2, APIC INT 0b [ 0.000000] Int: type 0, pol 1, trig 0, bus 00, IRQ 24, APIC ID 2, APIC INT 0a [ 0.000000] Int: type 0, pol 0, trig 0, bus 01, IRQ 00, APIC ID 2, APIC INT 02 [ 0.000000] Int: type 0, pol 0, trig 0, bus 01, IRQ 01, APIC ID 2, APIC INT 01 [ 0.000000] Int: type 0, pol 0, trig 0, bus 01, IRQ 03, APIC ID 2, APIC INT 03 [ 0.000000] Int: type 0, pol 0, trig 0, bus 01, IRQ 04, APIC ID 2, APIC INT 04 [ 0.000000] Int: type 0, pol 0, trig 0, bus 01, IRQ 05, APIC ID 2, APIC INT 05 [ 0.000000] Int: type 0, pol 0, trig 0, bus 01, IRQ 06, APIC ID 2, APIC INT 06 [ 0.000000] Int: type 0, pol 0, trig 0, bus 01, IRQ 07, APIC ID 2, APIC INT 07 [ 0.000000] Int: type 0, pol 0, trig 0, bus 01, IRQ 08, APIC ID 2, APIC INT 08 [ 0.000000] Int: type 0, pol 0, trig 0, bus 01, IRQ 0c, APIC ID 2, APIC INT 0c [ 0.000000] Int: type 0, pol 0, trig 0, bus 01, IRQ 0d, APIC ID 2, APIC INT 0d [ 0.000000] Int: type 0, pol 0, trig 0, bus 01, IRQ 0e, APIC ID 2, APIC INT 0e [ 0.000000] Int: type 0, pol 0, trig 0, bus 01, IRQ 0f, APIC ID 2, APIC INT 0f [ 0.000000] Lint: type 3, pol 0, trig 0, bus 01, IRQ 00, APIC ID 0, APIC LINT 00 [ 0.000000] Lint: type 1, pol 0, trig 0, bus 01, IRQ 00, APIC ID 0, APIC LINT 01 [ 0.000000] Processors: 2 [ 0.000000] SMP: Allowing 2 CPUs, 0 hotplug CPUs [ 0.000000] mapped IOAPIC to ffffa000 (fec00000) [ 0.000000] nr_irqs_gsi: 40 [ 0.000000] e820: [mem 0x10000000-0xfffbbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] setup_percpu: NR_CPUS:32 nr_cpumask_bits:32 nr_cpu_ids:2 nr_node_ids:1 [ 0.000000] PERCPU: Embedded 333 pages/cpu @4efca000 s1341952 r0 d22016 u1363968 [ 0.000000] pcpu-alloc: s1341952 r0 d22016 u1363968 alloc=333*4096 [ 0.000000] pcpu-alloc: [0] 0 [0] 1 [ 0.000000] kvm-clock: cpu 0, msr 0:f1111c1, primary cpu clock [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 64780 [ 0.000000] Kernel command line: trinity=1m hung_task_panic=1 tree=linus:master log_buf_len=8M ignore_loglevel debug sched_debug apic=debug dynamic_printk sysrq_always_enabled panic=10 softlockup_panic=1 unknown_nmi_panic=1 nmi_watchdog=panic,lapic prompt_ramdisk=0 console=ttyS0,115200 console=tty0 vga=normal root=/dev/ram0 rw link=vmlinuz-2012-07-23-04-16-10-linus:master:e2b34e3-ceee0e9-i386-randconfig-b003-1-waimea BOOT_IMAGE=kernel-tests/kernels/i386-randconfig-b003/ceee0e9/vmlinuz-3.5.0+ [ 0.000000] PID hash table entries: 1024 (order: 0, 4096 bytes) [ 0.000000] Dentry cache hash table entries: 32768 (order: 5, 131072 bytes) [ 0.000000] Inode-cache hash table entries: 16384 (order: 4, 65536 bytes) [ 0.000000] __ex_table already sorted, skipping sort [ 0.000000] Initializing CPU#0 [ 0.000000] Initializing HighMem for node 0 (00000000:00000000) [ 0.000000] Memory: 232184k/262132k available (2749k kernel code, 29496k reserved, 1454k data, 1648k init, 0k highmem) [ 0.000000] virtual kernel memory layout: [ 0.000000] fixmap : 0xffd36000 - 0xfffff000 (2852 kB) [ 0.000000] pkmap : 0xff800000 - 0xffc00000 (4096 kB) [ 0.000000] vmalloc : 0x507fd000 - 0xff7fe000 (2800 MB) [ 0.000000] lowmem : 0x40000000 - 0x4fffd000 ( 255 MB) [ 0.000000] .init : 0x4141b000 - 0x415b7000 (1648 kB) [ 0.000000] .data : 0x412af4e5 - 0x4141ae00 (1454 kB) [ 0.000000] .text : 0x41000000 - 0x412af4e5 (2749 kB) [ 0.000000] Checking if this processor honours the WP bit even in supervisor mode...Ok. [ 0.000000] SLUB: Genslabs=15, HWalign=128, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 [ 0.000000] Hierarchical RCU implementation. [ 0.000000] RCU debugfs-based tracing is enabled. [ 0.000000] Hierarchical RCU autobalancing is disabled. [ 0.000000] RCU dyntick-idle grace-period acceleration is enabled. [ 0.000000] RCU lockdep checking is enabled. [ 0.000000] Additional per-CPU info printed with stalls. [ 0.000000] NR_IRQS:2304 nr_irqs:56 16 [ 0.000000] CPU 0 irqstacks, hard=4e812000 soft=4e814000 [ 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: 3823 kB [ 0.000000] per task-struct memory footprint: 1920 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: ok | ok | ok | ok | ok | ok | [ 0.000000] A-B-B-A deadlock: ok | ok | ok | ok | ok | ok | [ 0.000000] A-B-B-C-C-A deadlock: ok | ok | ok | ok | ok | ok | [ 0.000000] A-B-C-A-B-C deadlock: ok | ok | ok | ok | ok | ok | [ 0.000000] A-B-B-C-C-D-D-A deadlock: ok | ok | ok | ok | ok | ok | [ 0.000000] A-B-C-D-B-D-D-A deadlock: ok | ok | ok | ok | ok | ok | [ 0.000000] A-B-C-D-B-C-D-A deadlock: ok | ok | ok | ok | ok | ok | [ 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 | | ok | [ 0.000000] recursive read-lock #2: | ok | | ok | [ 0.000000] mixed read-write-lock: | ok | | ok | [ 0.000000] mixed write-read-lock: | ok | | ok | [ 0.000000] -------------------------------------------------------------------------- [ 0.000000] hard-irqs-on + irq-safe-A/12: ok | ok | ok | [ 0.000000] soft-irqs-on + irq-safe-A/12: ok | ok | ok | [ 0.000000] hard-irqs-on + irq-safe-A/21: ok | ok | ok | [ 0.000000] soft-irqs-on + irq-safe-A/21: ok | ok | ok | [ 0.000000] sirq-safe-A => hirqs-on/12: ok | ok | ok | [ 0.000000] sirq-safe-A => hirqs-on/21: ok | ok | ok | [ 0.000000] hard-safe-A + irqs-on/12: ok | ok | ok | [ 0.000000] soft-safe-A + irqs-on/12: ok | ok | ok | [ 0.000000] hard-safe-A + irqs-on/21: ok | ok | ok | [ 0.000000] soft-safe-A + irqs-on/21: ok | ok | ok | [ 0.000000] hard-safe-A + unsafe-B #1/123: ok | ok | ok | [ 0.000000] soft-safe-A + unsafe-B #1/123: ok | ok | ok | [ 0.000000] hard-safe-A + unsafe-B #1/132: ok | ok | ok | [ 0.000000] soft-safe-A + unsafe-B #1/132: ok | ok | ok | [ 0.000000] hard-safe-A + unsafe-B #1/213: ok | ok | ok | [ 0.000000] soft-safe-A + unsafe-B #1/213: ok | ok | ok | [ 0.000000] hard-safe-A + unsafe-B #1/231: ok | ok | ok | [ 0.000000] soft-safe-A + unsafe-B #1/231: ok | ok | ok | [ 0.000000] hard-safe-A + unsafe-B #1/312: ok | ok | ok | [ 0.000000] soft-safe-A + unsafe-B #1/312: ok | ok | ok | [ 0.000000] hard-safe-A + unsafe-B #1/321: ok | ok | ok | [ 0.000000] soft-safe-A + unsafe-B #1/321: ok | ok | ok | [ 0.000000] hard-safe-A + unsafe-B #2/123: ok | ok | ok | [ 0.000000] soft-safe-A + unsafe-B #2/123: ok | ok | ok | [ 0.000000] hard-safe-A + unsafe-B #2/132: ok | ok | ok | [ 0.000000] soft-safe-A + unsafe-B #2/132: ok | ok | ok | [ 0.000000] hard-safe-A + unsafe-B #2/213: ok | ok | ok | [ 0.000000] soft-safe-A + unsafe-B #2/213: ok | ok | ok | [ 0.000000] hard-safe-A + unsafe-B #2/231: ok | ok | ok | [ 0.000000] soft-safe-A + unsafe-B #2/231: ok | ok | ok | [ 0.000000] hard-safe-A + unsafe-B #2/312: ok | ok | ok | [ 0.000000] soft-safe-A + unsafe-B #2/312: ok | ok | ok | [ 0.000000] hard-safe-A + unsafe-B #2/321: ok | ok | ok | [ 0.000000] soft-safe-A + unsafe-B #2/321: ok | ok | ok | [ 0.000000] hard-irq lock-inversion/123: ok | ok | ok | [ 0.000000] soft-irq lock-inversion/123: ok | ok | ok | [ 0.000000] hard-irq lock-inversion/132: ok | ok | ok | [ 0.000000] soft-irq lock-inversion/132: ok | ok | ok | [ 0.000000] hard-irq lock-inversion/213: ok | ok | ok | [ 0.000000] soft-irq lock-inversion/213: ok | ok | ok | [ 0.000000] hard-irq lock-inversion/231: ok | ok | ok | [ 0.000000] soft-irq lock-inversion/231: ok | ok | ok | [ 0.000000] hard-irq lock-inversion/312: ok | ok | ok | [ 0.000000] soft-irq lock-inversion/312: ok | ok | ok | [ 0.000000] hard-irq lock-inversion/321: ok | ok | ok | [ 0.000000] soft-irq lock-inversion/321: ok | ok | 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] Good, all 218 testcases passed! | [ 0.000000] --------------------------------- [ 0.000000] ODEBUG: 2 of 2 active objects replaced [ 0.000000] Detected 3300.286 MHz processor. [ 0.010000] Calibrating delay loop (skipped) preset value.. 6600.57 BogoMIPS (lpj=33002860) [ 0.010000] pid_max: default: 4096 minimum: 301 [ 0.010000] Security Framework initialized [ 0.010000] AppArmor: AppArmor initialized [ 0.010000] Mount-cache hash table entries: 512 [ 0.010000] Disabled fast string operations [ 0.010000] mce: CPU supports 10 MCE banks [ 0.010257] ftrace: allocating 9767 entries in 20 pages [ 0.019698] Getting VERSION: 50014 [ 0.020010] Getting VERSION: 50014 [ 0.020564] Getting ID: 0 [ 0.020960] Getting ID: f000000 [ 0.021428] Getting LVT0: 8700 [ 0.021900] Getting LVT1: 8400 [ 0.022357] Enabling APIC mode: Flat. Using 1 I/O APICs [ 0.023205] enabled ExtINT on CPU#0 [ 0.024469] ENABLING IO-APIC IRQs [ 0.024990] Setting 2 in the phys_id_present_map [ 0.025690] init IO_APIC IRQs [ 0.026136] apic 2 pin 0 not connected [ 0.026739] IOAPIC[0]: Set routing entry (2-1 -> 0x31 -> IRQ 1 Mode:0 Active:0 Dest:1) [ 0.027955] IOAPIC[0]: Set routing entry (2-2 -> 0x30 -> IRQ 0 Mode:0 Active:0 Dest:1) [ 0.029188] IOAPIC[0]: Set routing entry (2-3 -> 0x33 -> IRQ 3 Mode:0 Active:0 Dest:1) [ 0.030023] IOAPIC[0]: Set routing entry (2-4 -> 0x34 -> IRQ 4 Mode:0 Active:0 Dest:1) [ 0.031233] IOAPIC[0]: Set routing entry (2-5 -> 0x35 -> IRQ 5 Mode:0 Active:0 Dest:1) [ 0.032465] IOAPIC[0]: Set routing entry (2-6 -> 0x36 -> IRQ 6 Mode:0 Active:0 Dest:1) [ 0.033655] IOAPIC[0]: Set routing entry (2-7 -> 0x37 -> IRQ 7 Mode:0 Active:0 Dest:1) [ 0.034924] IOAPIC[0]: Set routing entry (2-8 -> 0x38 -> IRQ 8 Mode:0 Active:0 Dest:1) [ 0.036154] IOAPIC[0]: Set routing entry (2-9 -> 0x29 -> IRQ 33 Mode:1 Active:0 Dest:1) [ 0.037454] IOAPIC[0]: Set routing entry (2-10 -> 0x41 -> IRQ 34 Mode:1 Active:0 Dest:1) [ 0.038688] IOAPIC[0]: Set routing entry (2-11 -> 0x49 -> IRQ 35 Mode:1 Active:0 Dest:1) [ 0.040021] IOAPIC[0]: Set routing entry (2-12 -> 0x3c -> IRQ 12 Mode:0 Active:0 Dest:1) [ 0.041318] IOAPIC[0]: Set routing entry (2-13 -> 0x3d -> IRQ 13 Mode:0 Active:0 Dest:1) [ 0.042563] IOAPIC[0]: Set routing entry (2-14 -> 0x3e -> IRQ 14 Mode:0 Active:0 Dest:1) [ 0.043773] IOAPIC[0]: Set routing entry (2-15 -> 0x3f -> IRQ 15 Mode:0 Active:0 Dest:1) [ 0.045128] apic 2 pin 16 not connected [ 0.045726] apic 2 pin 17 not connected [ 0.046319] apic 2 pin 18 not connected [ 0.046895] apic 2 pin 19 not connected [ 0.047492] apic 2 pin 20 not connected [ 0.048106] apic 2 pin 21 not connected [ 0.048803] apic 2 pin 22 not connected [ 0.050003] apic 2 pin 23 not connected [ 0.050736] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.051739] CPU0: Intel Common KVM processor stepping 01 [ 0.052805] Using local APIC timer interrupts. [ 0.052805] calibrating APIC timer ... [ 0.060000] ... lapic delta = 6250062 [ 0.060000] ..... delta 6250062 [ 0.060000] ..... mult: 268438118 [ 0.060000] ..... calibration result: 10000099 [ 0.060000] ..... CPU clock speed is 3300.3160 MHz. [ 0.060000] ..... host bus clock speed is 1000.0099 MHz. [ 0.060000] ... verify APIC timer [ 0.174981] ... jiffies delta = 10 [ 0.175641] ... jiffies result ok [ 0.176308] Performance Events: unsupported Netburst CPU model 6 no PMU driver, software events only. [ 0.178796] Testing tracer nop: PASSED [ 0.180000] lockdep: fixing up alternatives. [ 0.180000] CPU 1 irqstacks, hard=4e8c0000 soft=4e8c2000 [ 0.180000] Booting Node 0, Processors #1 Ok. [ 0.010000] Initializing CPU#1 [ 0.010000] kvm-clock: cpu 1, msr 0:f25e1c1, secondary cpu clock [ 0.010000] masked ExtINT on CPU#1 [ 0.010000] Disabled fast string operations [ 0.190000] TSC synchronization [CPU#0 -> CPU#1]: [ 0.190000] Measured 30 cycles TSC warp between CPUs, turning off TSC clock. [ 0.190000] Marking TSC unstable due to check_tsc_sync_source failed [ 0.200065] Brought up 2 CPUs [ 0.200576] ---------------- [ 0.201086] | NMI testsuite: [ 0.201539] -------------------- [ 0.202074] remote IPI: ok | [ 0.202548] local IPI: ok | [ 0.210031] -------------------- [ 0.210516] Good, all 2 testcases passed! | [ 0.211152] --------------------------------- [ 0.211857] Total of 2 processors activated (13201.14 BogoMIPS). [ 0.213344] CPU0 attaching sched-domain: [ 0.213963] domain 0: span 0-1 level CPU [ 0.214595] groups: 0 1 [ 0.215127] CPU1 attaching sched-domain: [ 0.215944] domain 0: span 0-1 level CPU [ 0.216675] groups: 1 0 [ 0.217545] device: 'platform': device_add [ 0.217545] bus: 'platform': registered [ 0.217545] bus: 'cpu': registered [ 0.220016] device: 'cpu': device_add [ 0.222666] device class 'regulator': registering [ 0.222666] Registering platform device 'reg-dummy'. Parent at platform [ 0.222666] device: 'reg-dummy': device_add [ 0.223302] bus: 'platform': add device reg-dummy [ 0.224360] bus: 'platform': add driver reg-dummy [ 0.225092] bus: 'platform': driver_probe_device: matched device reg-dummy with driver reg-dummy [ 0.226487] bus: 'platform': really_probe: probing driver reg-dummy with device reg-dummy [ 0.230076] device: 'regulator.0': device_add [ 0.231002] dummy: [ 0.231412] driver: 'reg-dummy': driver_bound: bound to device 'reg-dummy' [ 0.232521] bus: 'platform': really_probe: bound device reg-dummy to driver reg-dummy [ 0.234153] NET: Registered protocol family 16 [ 0.234910] device class 'bdi': registering [ 0.235620] device class 'gpio': registering [ 0.236328] device class 'tty': registering [ 0.237376] device class 'dma': registering [ 0.238078] device class 'dmi': registering [ 0.238751] device: 'id': device_add [ 0.240321] device: 'cpu0': device_add [ 0.240913] bus: 'cpu': add device cpu0 [ 0.241745] device: 'cpu1': device_add [ 0.242338] bus: 'cpu': add device cpu1 [ 0.243041] mtrr: your CPUs had inconsistent variable MTRR settings [ 0.243965] mtrr: your CPUs had inconsistent MTRRdefType settings [ 0.244891] mtrr: probably your BIOS does not setup all CPUs. [ 0.245864] mtrr: corrected configuration. [ 0.248521] device: 'default': device_add [ 0.248521] device class 'misc': registering [ 0.250132] bus: 'serio': registered [ 0.250672] device class 'input': registering [ 0.251407] device class 'rtc': registering [ 0.252113] device class 'power_supply': registering [ 0.253017] device class 'devfreq': registering [ 0.253821] device class 'net': registering [ 0.254554] device: 'lo': device_add [ 0.255885] Switching to clocksource kvm-clock [ 0.256578] Warning: could not register annotated branches stats [ 0.325770] AppArmor: AppArmor Filesystem Enabled [ 0.326582] device class 'mem': registering [ 0.327287] device: 'mem': device_add [ 0.328001] device: 'null': device_add [ 0.328745] device: 'port': device_add [ 0.329454] device: 'zero': device_add [ 0.330216] device: 'full': device_add [ 0.330911] device: 'random': device_add [ 0.331660] device: 'urandom': device_add [ 0.332405] device: 'kmsg': device_add [ 0.333120] device: 'tty': device_add [ 0.333868] device: 'console': device_add [ 0.334709] NET: Registered protocol family 1 [ 0.335905] Unpacking initramfs... [ 0.490703] debug: unmapping init [mem 0x4fce4000-0x4ffeffff] [ 0.590508] DMA-API: preallocated 32768 debug entries [ 0.591296] DMA-API: debugging enabled by kernel config [ 0.592139] Registering platform device 'rtc_cmos'. Parent at platform [ 0.593145] device: 'rtc_cmos': device_add [ 0.593806] bus: 'platform': add device rtc_cmos [ 0.594631] platform rtc_cmos: registered platform RTC device (no PNP device found) [ 0.596336] bus: 'machinecheck': registered [ 0.596993] device: 'machinecheck': device_add [ 0.597740] device: 'machinecheck0': device_add [ 0.598462] bus: 'machinecheck': add device machinecheck0 [ 0.599469] device: 'machinecheck1': device_add [ 0.600220] bus: 'machinecheck': add device machinecheck1 [ 0.601255] device: 'mcelog': device_add [ 0.602056] Registering platform device 'pcspkr'. Parent at platform [ 0.603042] device: 'pcspkr': device_add [ 0.603702] bus: 'platform': add device pcspkr [ 0.604665] bus: 'clocksource': registered [ 0.605348] device: 'clocksource': device_add [ 0.606068] device: 'clocksource0': device_add [ 0.606781] bus: 'clocksource': add device clocksource0 [ 0.607703] bus: 'platform': add driver alarmtimer [ 0.608510] Registering platform device 'alarmtimer'. Parent at platform [ 0.609543] device: 'alarmtimer': device_add [ 0.610252] bus: 'platform': add device alarmtimer [ 0.611073] bus: 'platform': driver_probe_device: matched device alarmtimer with driver alarmtimer [ 0.612452] bus: 'platform': really_probe: probing driver alarmtimer with device alarmtimer [ 0.613859] driver: 'alarmtimer': driver_bound: bound to device 'alarmtimer' [ 0.614934] bus: 'platform': really_probe: bound device alarmtimer to driver alarmtimer [ 0.616324] bus: 'rttest': registered [ 0.616905] device: 'rttest': device_add [ 0.617733] device: 'rttest0': device_add [ 0.618499] bus: 'rttest': add device rttest0 [ 0.619713] device: 'rttest1': device_add [ 0.620528] bus: 'rttest': add device rttest1 [ 0.621756] device: 'rttest2': device_add [ 0.622435] bus: 'rttest': add device rttest2 [ 0.623433] device: 'rttest3': device_add [ 0.624067] bus: 'rttest': add device rttest3 [ 0.624966] device: 'rttest4': device_add [ 0.625642] bus: 'rttest': add device rttest4 [ 0.626627] device: 'rttest5': device_add [ 0.627295] bus: 'rttest': add device rttest5 [ 0.628239] device: 'rttest6': device_add [ 0.628890] bus: 'rttest': add device rttest6 [ 0.629822] device: 'rttest7': device_add [ 0.630523] bus: 'rttest': add device rttest7 [ 0.631325] Initializing RT-Tester: OK [ 0.631981] audit: initializing netlink socket (disabled) [ 0.632932] type=2000 audit(1342988216.630:1): initialized [ 0.690117] Testing tracer function: PASSED [ 0.900891] Testing dynamic ftrace: PASSED [ 1.140582] Testing dynamic ftrace ops #1: (1 0 1 1 0) (1 1 2 1 0) (2 1 3 1 7) (2 2 4 1 109) PASSED [ 1.202855] Testing dynamic ftrace ops #2: (1 0 1 6 0) (1 1 2 109 0) (2 1 3 2 6) (2 2 4 105 110) PASSED [ 1.380369] Testing tracer irqsoff: [ 1.524917] [ 1.525217] =============================== [ 1.525868] [ INFO: suspicious RCU usage. ] [ 1.526556] 3.5.0+ #1289 Not tainted [ 1.527124] ------------------------------- [ 1.527799] /c/kernel-tests/src/linux/include/linux/rcupdate.h:730 rcu_read_lock() used illegally while idle! [ 1.529375] [ 1.529375] other info that might help us debug this: [ 1.529375] [ 1.530667] [ 1.530667] RCU used illegally from idle CPU! [ 1.530667] rcu_scheduler_active = 1, debug_locks = 1 [ 1.532383] RCU used illegally from extended quiescent state! [ 1.533297] 2 locks held by swapper/0/0: [ 1.533924] #0: [ 1.534271] (max_trace_lock){......}, at: [<410e9d67>] check_critical_timing+0x67/0x1b0 [ 1.534883] #1: (rcu_read_lock){.+.+..}, at: [<410e1ea0>] __update_max_tr+0x0/0x200 [ 1.534883] stack backtrace: [ 1.534883] Pid: 0, comm: swapper/0 Not tainted 3.5.0+ #1289 [ 1.534883] Call Trace: [ 1.534883] [<41093a76>] lockdep_rcu_suspicious+0xc6/0x100 [ 1.534883] [<410e2071>] __update_max_tr+0x1d1/0x200 [ 1.534883] [<410e1ea0>] ? tracing_record_cmdline+0x130/0x130 [ 1.534883] [<410e30f5>] update_max_tr_single+0x1f5/0x240 [ 1.534883] [<410e294c>] ? __trace_stack+0x1c/0x30 [ 1.534883] [<410e9e96>] check_critical_timing+0x196/0x1b0 [ 1.534883] [<4100b858>] ? default_idle+0x468/0x4c0 [ 1.534883] [<4100b858>] ? default_idle+0x468/0x4c0 [ 1.534883] [<410ea47f>] time_hardirqs_on+0xff/0x110 [ 1.534883] [<410961eb>] ? trace_hardirqs_on+0xb/0x10 [ 1.534883] [<4100b858>] ? default_idle+0x468/0x4c0 [ 1.534883] [<41096031>] trace_hardirqs_on_caller+0x11/0x1c0 [ 1.534883] [<410961eb>] trace_hardirqs_on+0xb/0x10 [ 1.534883] [<4100b858>] default_idle+0x468/0x4c0 [ 1.534883] [<4100c4e6>] cpu_idle+0x186/0x190 [ 1.534883] [<412953c3>] rest_init+0x127/0x134 [ 1.534883] [<4129529c>] ? __read_lock_failed+0x14/0x14 [ 1.534883] [<4141b9e0>] start_kernel+0x36f/0x375 [ 1.534883] [<4141b4a6>] ? repair_env_string+0x51/0x51 [ 1.534883] [<4141b2d4>] i386_start_kernel+0x8a/0x8f [ 1.534883] [ 1.534883] =============================== [ 1.534883] [ INFO: suspicious RCU usage. ] [ 1.534883] 3.5.0+ #1289 Not tainted [ 1.534883] ------------------------------- [ 1.534883] /c/kernel-tests/src/linux/kernel/trace/trace.c:675 suspicious rcu_dereference_check() usage! [ 1.534883] [ 1.534883] other info that might help us debug this: [ 1.534883] [ 1.534883] [ 1.534883] RCU used illegally from idle CPU! [ 1.534883] rcu_scheduler_active = 1, debug_locks = 1 [ 1.534883] RCU used illegally from extended quiescent state! [ 1.534883] 2 locks held by swapper/0/0: [ 1.534883] #0: (max_trace_lock){......}, at: [<410e9d67>] check_critical_timing+0x67/0x1b0 [ 1.534883] #1: (rcu_read_lock){.+.+..}, at: [<410e1ea0>] __update_max_tr+0x0/0x200 [ 1.534883] [ 1.534883] stack backtrace: [ 1.534883] Pid: 0, comm: swapper/0 Not tainted 3.5.0+ #1289 [ 1.534883] Call Trace: [ 1.534883] [<41093a76>] lockdep_rcu_suspicious+0xc6/0x100 [ 1.534883] [<410e203d>] __update_max_tr+0x19d/0x200 [ 1.534883] [<410e1ea0>] ? tracing_record_cmdline+0x130/0x130 [ 1.534883] [<410e30f5>] update_max_tr_single+0x1f5/0x240 [ 1.534883] [<410e294c>] ? __trace_stack+0x1c/0x30 [ 1.534883] [<410e9e96>] check_critical_timing+0x196/0x1b0 [ 1.534883] [<4100b858>] ? default_idle+0x468/0x4c0 [ 1.534883] [<4100b858>] ? default_idle+0x468/0x4c0 [ 1.534883] [<410ea47f>] time_hardirqs_on+0xff/0x110 [ 1.534883] [<410961eb>] ? trace_hardirqs_on+0xb/0x10 [ 1.534883] [<4100b858>] ? default_idle+0x468/0x4c0 [ 1.534883] [<41096031>] trace_hardirqs_on_caller+0x11/0x1c0 [ 1.534883] [<410961eb>] trace_hardirqs_on+0xb/0x10 [ 1.534883] [<4100b858>] default_idle+0x468/0x4c0 [ 1.534883] [<4100c4e6>] cpu_idle+0x186/0x190 [ 1.534883] [<412953c3>] rest_init+0x127/0x134 [ 1.534883] [<4129529c>] ? __read_lock_failed+0x14/0x14 [ 1.534883] [<4141b9e0>] start_kernel+0x36f/0x375 [ 1.534883] [<4141b4a6>] ? repair_env_string+0x51/0x51 [ 1.534883] [<4141b2d4>] i386_start_kernel+0x8a/0x8f [ 1.534883] [ 1.534883] =============================== [ 1.534883] [ INFO: suspicious RCU usage. ] [ 1.534883] 3.5.0+ #1289 Not tainted [ 1.534883] ------------------------------- [ 1.534883] /c/kernel-tests/src/linux/include/linux/rcupdate.h:751 rcu_read_unlock() used illegally while idle! [ 1.534883] [ 1.534883] other info that might help us debug this: [ 1.534883] [ 1.534883] [ 1.534883] RCU used illegally from idle CPU! [ 1.534883] rcu_scheduler_active = 1, debug_locks = 1 [ 1.534883] RCU used illegally from extended quiescent state! [ 1.534883] 2 locks held by swapper/0/0: [ 1.534883] #0: (max_trace_lock){......}, at: [<410e9d67>] check_critical_timing+0x67/0x1b0 [ 1.534883] #1: (rcu_read_lock){.+.+..}, at: [<410e1ea0>] __update_max_tr+0x0/0x200 [ 1.534883] [ 1.534883] stack backtrace: [ 1.534883] Pid: 0, comm: swapper/0 Not tainted 3.5.0+ #1289 [ 1.534883] Call Trace: [ 1.534883] [<41093a76>] lockdep_rcu_suspicious+0xc6/0x100 [ 1.534883] [<410e2004>] __update_max_tr+0x164/0x200 [ 1.534883] [<410e1ea0>] ? tracing_record_cmdline+0x130/0x130 [ 1.534883] [<410e30f5>] update_max_tr_single+0x1f5/0x240 [ 1.534883] [<410e294c>] ? __trace_stack+0x1c/0x30 [ 1.534883] [<410e9e96>] check_critical_timing+0x196/0x1b0 [ 1.534883] [<4100b858>] ? default_idle+0x468/0x4c0 [ 1.534883] [<4100b858>] ? default_idle+0x468/0x4c0 [ 1.534883] [<410ea47f>] time_hardirqs_on+0xff/0x110 [ 1.534883] [<410961eb>] ? trace_hardirqs_on+0xb/0x10 [ 1.534883] [<4100b858>] ? default_idle+0x468/0x4c0 [ 1.534883] [<41096031>] trace_hardirqs_on_caller+0x11/0x1c0 [ 1.534883] [<410961eb>] trace_hardirqs_on+0xb/0x10 [ 1.534883] [<4100b858>] default_idle+0x468/0x4c0 [ 1.534883] [<4100c4e6>] cpu_idle+0x186/0x190 [ 1.534883] [<412953c3>] rest_init+0x127/0x134 [ 1.534883] [<4129529c>] ? __read_lock_failed+0x14/0x14 [ 1.534883] [<4141b9e0>] start_kernel+0x36f/0x375 [ 1.534883] [<4141b4a6>] ? repair_env_string+0x51/0x51 [ 1.534883] [<4141b2d4>] i386_start_kernel+0x8a/0x8f [ 1.630101] PASSED [ 1.690213] Testing tracer wakeup: PASSED [ 2.170561] Testing tracer wakeup_rt: PASSED [ 2.650475] Testing tracer function_graph: PASSED [ 2.850412] bus: 'event_source': registered [ 2.851080] device: 'breakpoint': device_add [ 2.851785] bus: 'event_source': add device breakpoint [ 2.852690] device: 'tracepoint': device_add [ 2.853350] bus: 'event_source': add device tracepoint [ 2.854250] device: 'software': device_add [ 2.854910] bus: 'event_source': add device software [ 2.856338] HugeTLB registered 4 MB page size, pre-allocated 0 pages [ 2.875283] msgmni has been set to 453 [ 2.876007] device: 'ptyp0': device_add [ 2.876826] device: 'ptyp1': device_add [ 2.877628] device: 'ptyp2': device_add [ 2.878452] device: 'ptyp3': device_add [ 2.879227] device: 'ptyp4': device_add [ 2.879956] device: 'ptyp5': device_add [ 2.880804] device: 'ptyp6': device_add [ 2.881582] device: 'ptyp7': device_add [ 2.882389] device: 'ptyp8': device_add [ 2.883107] device: 'ptyp9': device_add [ 2.883867] device: 'ptypa': device_add [ 2.884648] device: 'ptypb': device_add [ 2.885433] device: 'ptypc': device_add [ 2.886172] device: 'ptypd': device_add [ 2.886960] device: 'ptype': device_add [ 2.887739] device: 'ptypf': device_add [ 2.888502] device: 'ptyq0': device_add [ 2.889260] device: 'ptyq1': device_add [ 2.889996] device: 'ptyq2': device_add [ 2.890787] device: 'ptyq3': device_add [ 2.891547] device: 'ptyq4': device_add [ 2.892313] device: 'ptyq5': device_add [ 2.893060] device: 'ptyq6': device_add [ 2.893816] device: 'ptyq7': device_add [ 2.894593] device: 'ptyq8': device_add [ 2.895364] device: 'ptyq9': device_add [ 2.896099] device: 'ptyqa': device_add [ 2.896869] device: 'ptyqb': device_add [ 2.897719] device: 'ptyqc': device_add [ 2.898489] device: 'ptyqd': device_add [ 2.899237] device: 'ptyqe': device_add [ 2.899972] device: 'ptyqf': device_add [ 2.900750] device: 'ptyr0': device_add [ 2.901512] device: 'ptyr1': device_add [ 2.902266] device: 'ptyr2': device_add [ 2.902990] device: 'ptyr3': device_add [ 2.903739] device: 'ptyr4': device_add [ 2.904499] device: 'ptyr5': device_add [ 2.905288] device: 'ptyr6': device_add [ 2.906027] device: 'ptyr7': device_add [ 2.906765] device: 'ptyr8': device_add [ 2.907530] device: 'ptyr9': device_add [ 2.908293] device: 'ptyra': device_add [ 2.909042] device: 'ptyrb': device_add [ 2.909790] device: 'ptyrc': device_add [ 2.910551] device: 'ptyrd': device_add [ 2.911313] device: 'ptyre': device_add [ 2.912051] device: 'ptyrf': device_add [ 2.912799] device: 'ptys0': device_add [ 2.913553] device: 'ptys1': device_add [ 2.914302] device: 'ptys2': device_add [ 2.915073] device: 'ptys3': device_add [ 2.915837] device: 'ptys4': device_add [ 2.916585] device: 'ptys5': device_add [ 2.917342] device: 'ptys6': device_add [ 2.918080] device: 'ptys7': device_add [ 2.918840] device: 'ptys8': device_add [ 2.919573] device: 'ptys9': device_add [ 2.920326] device: 'ptysa': device_add [ 2.921164] device: 'ptysb': device_add [ 2.921916] device: 'ptysc': device_add [ 2.922670] device: 'ptysd': device_add [ 2.923404] device: 'ptyse': device_add [ 2.924126] device: 'ptysf': device_add [ 2.924911] device: 'ptyt0': device_add [ 2.925644] device: 'ptyt1': device_add [ 2.926447] device: 'ptyt2': device_add [ 2.927251] device: 'ptyt3': device_add [ 2.927983] device: 'ptyt4': device_add [ 2.928718] device: 'ptyt5': device_add [ 2.929437] device: 'ptyt6': device_add [ 2.930221] device: 'ptyt7': device_add [ 2.930968] device: 'ptyt8': device_add [ 2.931705] device: 'ptyt9': device_add [ 2.932440] device: 'ptyta': device_add [ 2.933148] device: 'ptytb': device_add [ 2.933878] device: 'ptytc': device_add [ 2.934676] device: 'ptytd': device_add [ 2.935423] device: 'ptyte': device_add [ 2.936155] device: 'ptytf': device_add [ 2.936871] device: 'ptyu0': device_add [ 2.937616] device: 'ptyu1': device_add [ 2.938403] device: 'ptyu2': device_add [ 2.939127] device: 'ptyu3': device_add [ 2.939859] device: 'ptyu4': device_add [ 2.940615] device: 'ptyu5': device_add [ 2.941360] device: 'ptyu6': device_add [ 2.942097] device: 'ptyu7': device_add [ 2.942847] device: 'ptyu8': device_add [ 2.943611] device: 'ptyu9': device_add [ 2.944375] device: 'ptyua': device_add [ 2.945096] device: 'ptyub': device_add [ 2.945856] device: 'ptyuc': device_add [ 2.946622] device: 'ptyud': device_add [ 2.947365] device: 'ptyue': device_add [ 2.948075] device: 'ptyuf': device_add [ 2.948810] device: 'ptyv0': device_add [ 2.949544] device: 'ptyv1': device_add [ 2.950354] device: 'ptyv2': device_add [ 2.951088] device: 'ptyv3': device_add [ 2.951810] device: 'ptyv4': device_add [ 2.952543] device: 'ptyv5': device_add [ 2.953277] device: 'ptyv6': device_add [ 2.954055] device: 'ptyv7': device_add [ 2.954804] device: 'ptyv8': device_add [ 2.955552] device: 'ptyv9': device_add [ 2.956294] device: 'ptyva': device_add [ 2.957218] device: 'ptyvb': device_add [ 2.957971] device: 'ptyvc': device_add [ 2.958726] device: 'ptyvd': device_add [ 2.959451] device: 'ptyve': device_add [ 2.960220] device: 'ptyvf': device_add [ 2.960978] device: 'ptyw0': device_add [ 2.961684] device: 'ptyw1': device_add [ 2.962424] device: 'ptyw2': device_add [ 2.963122] device: 'ptyw3': device_add [ 2.963859] device: 'ptyw4': device_add [ 2.964565] device: 'ptyw5': device_add [ 2.965325] device: 'ptyw6': device_add [ 2.966043] device: 'ptyw7': device_add [ 2.966769] device: 'ptyw8': device_add [ 2.967482] device: 'ptyw9': device_add [ 2.968176] device: 'ptywa': device_add [ 2.968908] device: 'ptywb': device_add [ 2.969614] device: 'ptywc': device_add [ 2.970374] device: 'ptywd': device_add [ 2.971088] device: 'ptywe': device_add [ 2.971807] device: 'ptywf': device_add [ 2.972511] device: 'ptyx0': device_add [ 2.973265] device: 'ptyx1': device_add [ 2.973978] device: 'ptyx2': device_add [ 2.974729] device: 'ptyx3': device_add [ 2.975443] device: 'ptyx4': device_add [ 2.976135] device: 'ptyx5': device_add [ 2.976864] device: 'ptyx6': device_add [ 2.977583] device: 'ptyx7': device_add [ 2.978335] device: 'ptyx8': device_add [ 2.979048] device: 'ptyx9': device_add [ 2.979762] device: 'ptyxa': device_add [ 2.980487] device: 'ptyxb': device_add [ 2.981210] device: 'ptyxc': device_add [ 2.981989] device: 'ptyxd': device_add [ 2.982799] device: 'ptyxe': device_add [ 2.983523] device: 'ptyxf': device_add [ 2.984227] device: 'ptyy0': device_add [ 2.984934] device: 'ptyy1': device_add [ 2.985647] device: 'ptyy2': device_add [ 2.986404] device: 'ptyy3': device_add [ 2.987152] device: 'ptyy4': device_add [ 2.987924] device: 'ptyy5': device_add [ 2.988618] device: 'ptyy6': device_add [ 2.989346] device: 'ptyy7': device_add [ 2.990093] device: 'ptyy8': device_add [ 2.990829] device: 'ptyy9': device_add [ 2.991533] device: 'ptyya': device_add [ 2.992249] device: 'ptyyb': device_add [ 2.992996] device: 'ptyyc': device_add [ 2.993701] device: 'ptyyd': device_add [ 2.994443] device: 'ptyye': device_add [ 2.995152] device: 'ptyyf': device_add [ 2.995870] device: 'ptyz0': device_add [ 2.996575] device: 'ptyz1': device_add [ 2.997305] device: 'ptyz2': device_add [ 2.998017] device: 'ptyz3': device_add [ 2.998761] device: 'ptyz4': device_add [ 2.999466] device: 'ptyz5': device_add [ 3.000193] device: 'ptyz6': device_add [ 3.000913] device: 'ptyz7': device_add [ 3.001643] device: 'ptyz8': device_add [ 3.002415] device: 'ptyz9': device_add [ 3.003124] device: 'ptyza': device_add [ 3.003855] device: 'ptyzb': device_add [ 3.004615] device: 'ptyzc': device_add [ 3.005361] device: 'ptyzd': device_add [ 3.006088] device: 'ptyze': device_add [ 3.006821] device: 'ptyzf': device_add [ 3.007525] device: 'ptya0': device_add [ 3.008281] device: 'ptya1': device_add [ 3.009016] device: 'ptya2': device_add [ 3.009720] device: 'ptya3': device_add [ 3.010475] device: 'ptya4': device_add [ 3.011216] device: 'ptya5': device_add [ 3.011930] device: 'ptya6': device_add [ 3.012633] device: 'ptya7': device_add [ 3.013365] device: 'ptya8': device_add [ 3.014068] device: 'ptya9': device_add [ 3.014800] device: 'ptyaa': device_add [ 3.015529] device: 'ptyab': device_add [ 3.016234] device: 'ptyac': device_add [ 3.017171] device: 'ptyad': device_add [ 3.017901] device: 'ptyae': device_add [ 3.018654] device: 'ptyaf': device_add [ 3.019378] device: 'ptyb0': device_add [ 3.020095] device: 'ptyb1': device_add [ 3.020840] device: 'ptyb2': device_add [ 3.021560] device: 'ptyb3': device_add [ 3.022356] device: 'ptyb4': device_add [ 3.023105] device: 'ptyb5': device_add [ 3.023883] device: 'ptyb6': device_add [ 3.024640] device: 'ptyb7': device_add [ 3.025428] device: 'ptyb8': device_add [ 3.026241] device: 'ptyb9': device_add [ 3.026968] device: 'ptyba': device_add [ 3.027706] device: 'ptybb': device_add [ 3.028450] device: 'ptybc': device_add [ 3.029194] device: 'ptybd': device_add [ 3.029940] device: 'ptybe': device_add [ 3.030756] device: 'ptybf': device_add [ 3.031504] device: 'ptyc0': device_add [ 3.032260] device: 'ptyc1': device_add [ 3.032972] device: 'ptyc2': device_add [ 3.033720] device: 'ptyc3': device_add [ 3.034486] device: 'ptyc4': device_add [ 3.035242] device: 'ptyc5': device_add [ 3.035967] device: 'ptyc6': device_add [ 3.036690] device: 'ptyc7': device_add [ 3.037425] device: 'ptyc8': device_add [ 3.038163] device: 'ptyc9': device_add [ 3.038931] device: 'ptyca': device_add [ 3.039672] device: 'ptycb': device_add [ 3.040442] device: 'ptycc': device_add [ 3.041194] device: 'ptycd': device_add [ 3.041924] device: 'ptyce': device_add [ 3.042668] device: 'ptycf': device_add [ 3.043498] device: 'ptyd0': device_add [ 3.044257] device: 'ptyd1': device_add [ 3.044990] device: 'ptyd2': device_add [ 3.045735] device: 'ptyd3': device_add [ 3.046476] device: 'ptyd4': device_add [ 3.047311] device: 'ptyd5': device_add [ 3.048020] device: 'ptyd6': device_add [ 3.048761] device: 'ptyd7': device_add [ 3.049510] device: 'ptyd8': device_add [ 3.050303] device: 'ptyd9': device_add [ 3.051029] device: 'ptyda': device_add [ 3.051766] device: 'ptydb': device_add [ 3.052500] device: 'ptydc': device_add [ 3.053238] device: 'ptydd': device_add [ 3.053959] device: 'ptyde': device_add [ 3.054692] device: 'ptydf': device_add [ 3.055442] device: 'ptye0': device_add [ 3.056165] device: 'ptye1': device_add [ 3.056898] device: 'ptye2': device_add [ 3.057637] device: 'ptye3': device_add [ 3.058393] device: 'ptye4': device_add [ 3.059106] device: 'ptye5': device_add [ 3.059883] device: 'ptye6': device_add [ 3.060644] device: 'ptye7': device_add [ 3.061392] device: 'ptye8': device_add [ 3.062119] device: 'ptye9': device_add [ 3.062843] device: 'ptyea': device_add [ 3.063579] device: 'ptyeb': device_add [ 3.064317] device: 'ptyec': device_add [ 3.065068] device: 'ptyed': device_add [ 3.065821] device: 'ptyee': device_add [ 3.066551] device: 'ptyef': device_add [ 3.067300] device: 'ttyp0': device_add [ 3.068047] device: 'ttyp1': device_add [ 3.068806] device: 'ttyp2': device_add [ 3.069597] device: 'ttyp3': device_add [ 3.070333] device: 'ttyp4': device_add [ 3.071059] device: 'ttyp5': device_add [ 3.071810] device: 'ttyp6': device_add [ 3.072550] device: 'ttyp7': device_add [ 3.073290] device: 'ttyp8': device_add [ 3.074001] device: 'ttyp9': device_add [ 3.074749] device: 'ttypa': device_add [ 3.075502] device: 'ttypb': device_add [ 3.076243] device: 'ttypc': device_add [ 3.076981] device: 'ttypd': device_add [ 3.077814] device: 'ttype': device_add [ 3.078555] device: 'ttypf': device_add [ 3.079335] device: 'ttyq0': device_add [ 3.080083] device: 'ttyq1': device_add [ 3.080836] device: 'ttyq2': device_add [ 3.081580] device: 'ttyq3': device_add [ 3.082324] device: 'ttyq4': device_add [ 3.083051] device: 'ttyq5': device_add [ 3.083789] device: 'ttyq6': device_add [ 3.084540] device: 'ttyq7': device_add [ 3.085283] device: 'ttyq8': device_add [ 3.086009] device: 'ttyq9': device_add [ 3.086751] device: 'ttyqa': device_add [ 3.087493] device: 'ttyqb': device_add [ 3.088249] device: 'ttyqc': device_add [ 3.089000] device: 'ttyqd': device_add [ 3.089736] device: 'ttyqe': device_add [ 3.090494] device: 'ttyqf': device_add [ 3.091245] device: 'ttyr0': device_add [ 3.091975] device: 'ttyr1': device_add [ 3.092698] device: 'ttyr2': device_add [ 3.093435] device: 'ttyr3': device_add [ 3.094173] device: 'ttyr4': device_add [ 3.094915] device: 'ttyr5': device_add [ 3.095672] device: 'ttyr6': device_add [ 3.096415] device: 'ttyr7': device_add [ 3.097142] device: 'ttyr8': device_add [ 3.097894] device: 'ttyr9': device_add [ 3.098670] device: 'ttyra': device_add [ 3.099443] device: 'ttyrb': device_add [ 3.100180] device: 'ttyrc': device_add [ 3.100931] device: 'ttyrd': device_add [ 3.101672] device: 'ttyre': device_add [ 3.102414] device: 'ttyrf': device_add [ 3.103137] device: 'ttys0': device_add [ 3.103861] device: 'ttys1': device_add [ 3.104613] device: 'ttys2': device_add [ 3.105468] device: 'ttys3': device_add [ 3.106227] device: 'ttys4': device_add [ 3.107100] device: 'ttys5': device_add [ 3.107851] device: 'ttys6': device_add [ 3.108619] device: 'ttys7': device_add [ 3.109358] device: 'ttys8': device_add [ 3.110107] device: 'ttys9': device_add [ 3.110864] device: 'ttysa': device_add [ 3.111589] device: 'ttysb': device_add [ 3.112337] device: 'ttysc': device_add [ 3.113062] device: 'ttysd': device_add [ 3.113799] device: 'ttyse': device_add [ 3.114545] device: 'ttysf': device_add [ 3.115282] device: 'ttyt0': device_add [ 3.116007] device: 'ttyt1': device_add [ 3.116746] device: 'ttyt2': device_add [ 3.117507] device: 'ttyt3': device_add [ 3.118276] device: 'ttyt4': device_add [ 3.118988] device: 'ttyt5': device_add [ 3.119725] device: 'ttyt6': device_add [ 3.120486] device: 'ttyt7': device_add [ 3.121235] device: 'ttyt8': device_add [ 3.121961] device: 'ttyt9': device_add [ 3.122689] device: 'ttyta': device_add [ 3.123426] device: 'ttytb': device_add [ 3.124163] device: 'ttytc': device_add [ 3.124903] device: 'ttytd': device_add [ 3.125657] device: 'ttyte': device_add [ 3.126384] device: 'ttytf': device_add [ 3.127158] device: 'ttyu0': device_add [ 3.127957] device: 'ttyu1': device_add [ 3.128701] device: 'ttyu2': device_add [ 3.129519] device: 'ttyu3': device_add [ 3.130299] device: 'ttyu4': device_add [ 3.131040] device: 'ttyu5': device_add [ 3.131780] device: 'ttyu6': device_add [ 3.132522] device: 'ttyu7': device_add [ 3.133264] device: 'ttyu8': device_add [ 3.133993] device: 'ttyu9': device_add [ 3.134731] device: 'ttyua': device_add [ 3.135486] device: 'ttyub': device_add [ 3.136227] device: 'ttyuc': device_add [ 3.137091] device: 'ttyud': device_add [ 3.137875] device: 'ttyue': device_add [ 3.138617] device: 'ttyuf': device_add [ 3.139357] device: 'ttyv0': device_add [ 3.140105] device: 'ttyv1': device_add [ 3.140855] device: 'ttyv2': device_add [ 3.141581] device: 'ttyv3': device_add [ 3.142317] device: 'ttyv4': device_add [ 3.143048] device: 'ttyv5': device_add [ 3.143810] device: 'ttyv6': device_add [ 3.144552] device: 'ttyv7': device_add [ 3.145291] device: 'ttyv8': device_add [ 3.146045] device: 'ttyv9': device_add [ 3.146797] device: 'ttyva': device_add [ 3.147573] device: 'ttyvb': device_add [ 3.148313] device: 'ttyvc': device_add [ 3.149029] device: 'ttyvd': device_add [ 3.149768] device: 'ttyve': device_add [ 3.150583] device: 'ttyvf': device_add [ 3.151345] device: 'ttyw0': device_add [ 3.152111] device: 'ttyw1': device_add [ 3.152836] device: 'ttyw2': device_add [ 3.153616] device: 'ttyw3': device_add [ 3.154384] device: 'ttyw4': device_add [ 3.155116] device: 'ttyw5': device_add [ 3.155868] device: 'ttyw6': device_add [ 3.156606] device: 'ttyw7': device_add [ 3.157384] device: 'ttyw8': device_add [ 3.158131] device: 'ttyw9': device_add [ 3.158896] device: 'ttywa': device_add [ 3.159649] device: 'ttywb': device_add [ 3.160406] device: 'ttywc': device_add [ 3.161135] device: 'ttywd': device_add [ 3.161874] device: 'ttywe': device_add [ 3.162614] device: 'ttywf': device_add [ 3.163352] device: 'ttyx0': device_add [ 3.164079] device: 'ttyx1': device_add [ 3.164820] device: 'ttyx2': device_add [ 3.165579] device: 'ttyx3': device_add [ 3.166333] device: 'ttyx4': device_add [ 3.167168] device: 'ttyx5': device_add [ 3.167978] device: 'ttyx6': device_add [ 3.168717] device: 'ttyx7': device_add [ 3.169478] device: 'ttyx8': device_add [ 3.170242] device: 'ttyx9': device_add [ 3.170980] device: 'ttyxa': device_add [ 3.171705] device: 'ttyxb': device_add [ 3.172438] device: 'ttyxc': device_add [ 3.173178] device: 'ttyxd': device_add [ 3.173927] device: 'ttyxe': device_add [ 3.174671] device: 'ttyxf': device_add [ 3.175433] device: 'ttyy0': device_add [ 3.176162] device: 'ttyy1': device_add [ 3.176932] device: 'ttyy2': device_add [ 3.177673] device: 'ttyy3': device_add [ 3.178416] device: 'ttyy4': device_add [ 3.179131] device: 'ttyy5': device_add [ 3.179867] device: 'ttyy6': device_add [ 3.180636] device: 'ttyy7': device_add [ 3.181374] device: 'ttyy8': device_add [ 3.182101] device: 'ttyy9': device_add [ 3.182823] device: 'ttyya': device_add [ 3.183571] device: 'ttyyb': device_add [ 3.184311] device: 'ttyyc': device_add [ 3.185051] device: 'ttyyd': device_add [ 3.185805] device: 'ttyye': device_add [ 3.186561] device: 'ttyyf': device_add [ 3.187309] device: 'ttyz0': device_add [ 3.188048] device: 'ttyz1': device_add [ 3.188788] device: 'ttyz2': device_add [ 3.189529] device: 'ttyz3': device_add [ 3.190288] device: 'ttyz4': device_add [ 3.191029] device: 'ttyz5': device_add [ 3.191769] device: 'ttyz6': device_add [ 3.192507] device: 'ttyz7': device_add [ 3.193260] device: 'ttyz8': device_add [ 3.193974] device: 'ttyz9': device_add [ 3.194726] device: 'ttyza': device_add [ 3.195478] device: 'ttyzb': device_add [ 3.196243] device: 'ttyzc': device_add [ 3.197116] device: 'ttyzd': device_add [ 3.197841] device: 'ttyze': device_add [ 3.198581] device: 'ttyzf': device_add [ 3.199323] device: 'ttya0': device_add [ 3.200082] device: 'ttya1': device_add [ 3.200829] device: 'ttya2': device_add [ 3.201560] device: 'ttya3': device_add [ 3.202300] device: 'ttya4': device_add [ 3.203036] device: 'ttya5': device_add [ 3.203789] device: 'ttya6': device_add [ 3.204540] device: 'ttya7': device_add [ 3.205280] device: 'ttya8': device_add [ 3.206036] device: 'ttya9': device_add [ 3.206802] device: 'ttyaa': device_add [ 3.207551] device: 'ttyab': device_add [ 3.208289] device: 'ttyac': device_add [ 3.209004] device: 'ttyad': device_add [ 3.209752] device: 'ttyae': device_add [ 3.210512] device: 'ttyaf': device_add [ 3.211253] device: 'ttyb0': device_add [ 3.211982] device: 'ttyb1': device_add [ 3.212708] device: 'ttyb2': device_add [ 3.213457] device: 'ttyb3': device_add [ 3.214208] device: 'ttyb4': device_add [ 3.214937] device: 'ttyb5': device_add [ 3.215718] device: 'ttyb6': device_add [ 3.216460] device: 'ttyb7': device_add [ 3.217196] device: 'ttyb8': device_add [ 3.217934] device: 'ttyb9': device_add [ 3.218674] device: 'ttyba': device_add [ 3.219463] device: 'ttybb': device_add [ 3.220224] device: 'ttybc': device_add [ 3.220954] device: 'ttybd': device_add [ 3.221695] device: 'ttybe': device_add [ 3.222447] device: 'ttybf': device_add [ 3.223196] device: 'ttyc0': device_add [ 3.223925] device: 'ttyc1': device_add [ 3.224666] device: 'ttyc2': device_add [ 3.225444] device: 'ttyc3': device_add [ 3.226195] device: 'ttyc4': device_add [ 3.226974] device: 'ttyc5': device_add [ 3.227734] device: 'ttyc6': device_add [ 3.228474] device: 'ttyc7': device_add [ 3.229302] device: 'ttyc8': device_add [ 3.230098] device: 'ttyc9': device_add [ 3.230838] device: 'ttyca': device_add [ 3.231560] device: 'ttycb': device_add [ 3.232297] device: 'ttycc': device_add [ 3.233054] device: 'ttycd': device_add [ 3.233796] device: 'ttyce': device_add [ 3.234537] device: 'ttycf': device_add [ 3.235304] device: 'ttyd0': device_add [ 3.236034] device: 'ttyd1': device_add [ 3.236785] device: 'ttyd2': device_add [ 3.237524] device: 'ttyd3': device_add [ 3.238274] device: 'ttyd4': device_add [ 3.238990] device: 'ttyd5': device_add [ 3.239740] device: 'ttyd6': device_add [ 3.240502] device: 'ttyd7': device_add [ 3.241244] device: 'ttyd8': device_add [ 3.241972] device: 'ttyd9': device_add [ 3.242721] device: 'ttyda': device_add [ 3.243460] device: 'ttydb': device_add [ 3.244199] device: 'ttydc': device_add [ 3.244952] device: 'ttydd': device_add [ 3.245704] device: 'ttyde': device_add [ 3.246445] device: 'ttydf': device_add [ 3.247174] device: 'ttye0': device_add [ 3.247923] device: 'ttye1': device_add [ 3.248666] device: 'ttye2': device_add [ 3.249415] device: 'ttye3': device_add [ 3.250148] device: 'ttye4': device_add [ 3.250892] device: 'ttye5': device_add [ 3.251634] device: 'ttye6': device_add [ 3.252385] device: 'ttye7': device_add [ 3.253124] device: 'ttye8': device_add [ 3.253863] device: 'ttye9': device_add [ 3.254634] device: 'ttyea': device_add [ 3.255388] device: 'ttyeb': device_add [ 3.256126] device: 'ttyec': device_add [ 3.256866] device: 'ttyed': device_add [ 3.257682] device: 'ttyee': device_add [ 3.258421] device: 'ttyef': device_add [ 3.259134] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled [ 3.260180] Registering platform device 'serial8250'. Parent at platform [ 3.261218] device: 'serial8250': device_add [ 3.261888] bus: 'platform': add device serial8250 [ 3.286675] serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A [ 3.287718] device: 'ttyS0': device_add [ 3.288593] device: 'ttyS1': device_add [ 3.289423] device: 'ttyS2': device_add [ 3.290259] device: 'ttyS3': device_add [ 3.291001] bus: 'platform': add driver serial8250 [ 3.291767] bus: 'platform': driver_probe_device: matched device serial8250 with driver serial8250 [ 3.293132] bus: 'platform': really_probe: probing driver serial8250 with device serial8250 [ 3.294424] driver: 'serial8250': driver_bound: bound to device 'serial8250' [ 3.295518] bus: 'platform': really_probe: bound device serial8250 to driver serial8250 [ 3.296865] device: 'ttyprintk': device_add [ 3.297802] bus: 'isa': registered [ 3.298357] device: 'isa': device_add [ 3.299091] Registering platform device 'i8042'. Parent at platform [ 3.300076] device: 'i8042': device_add [ 3.300696] bus: 'platform': add device i8042 [ 3.301467] bus: 'platform': add driver i8042 [ 3.302171] bus: 'platform': driver_probe_device: matched device i8042 with driver i8042 [ 3.303410] bus: 'platform': really_probe: probing driver i8042 with device i8042 [ 3.305469] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.306306] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.307090] driver: 'i8042': driver_bound: bound to device 'i8042' [ 3.308041] bus: 'platform': really_probe: bound device i8042 to driver i8042 [ 3.309164] bus: 'serio': add driver atkbd [ 3.309884] cpuidle: using governor ladder [ 3.310565] cpuidle: using governor menu [ 3.311173] device class 'extcon': registering [ 3.312239] [ 3.312239] printing PIC contents [ 3.312982] ... PIC IMR: fffb [ 3.313469] ... PIC IRR: 1013 [ 3.313948] ... PIC ISR: 0000 [ 3.314438] ... PIC ELCR: 0c00 [ 3.314968] printing local APIC contents on CPU#0/0: [ 3.315795] ... APIC ID: 00000000 (0) [ 3.316456] ... APIC VERSION: 00050014 [ 3.317076] ... APIC TASKPRI: 00000000 (00) [ 3.317765] ... APIC PROCPRI: 00000000 [ 3.318585] ... APIC LDR: 01000000 [ 3.319126] ... APIC DFR: ffffffff [ 3.319678] ... APIC SPIV: 000001ff [ 3.320242] ... APIC ISR field: [ 3.320746] 0000000000000000000000000000000000000000000000000000000000000000 [ 3.322024] ... APIC TMR field: [ 3.322537] 0000000000000000000000000000000000000000000000000000000000000000 [ 3.323810] ... APIC IRR field: [ 3.324322] 0000000000000000000000000000000000000000000000000000000020000000 [ 3.324957] ... APIC ESR: 00000000 [ 3.324957] ... APIC ICR: 000008fd [ 3.324957] ... APIC ICR2: 02000000 [ 3.324957] ... APIC LVTT: 000000ef [ 3.324957] ... APIC LVTPC: 00010000 [ 3.324957] ... APIC LVT0: 00010700 [ 3.324957] ... APIC LVT1: 00000400 [ 3.324957] ... APIC LVTERR: 000000fe [ 3.324957] ... APIC TMICT: 0b8c489b [ 3.324957] ... APIC TMCCT: 0a2ae032 [ 3.324957] ... APIC TDCR: 00000003 [ 3.324957] [ 3.332104] number of MP IRQ sources: 20. [ 3.332733] number of IO-APIC #2 registers: 24. [ 3.333433] testing the IO APIC....................... [ 3.334232] [ 3.334470] IO APIC #2...... [ 3.334912] .... register #00: 02000000 [ 3.335521] ....... : physical APIC id: 02 [ 3.336193] ....... : Delivery Type: 0 [ 3.336805] ....... : LTS : 0 [ 3.337427] .... register #01: 00170011 [ 3.338011] ....... : max redirection entries: 17 [ 3.338810] ....... : PRQ implemented: 0 [ 3.339493] ....... : IO APIC version: 11 [ 3.340214] .... register #02: 02000000 [ 3.340857] ....... : arbitration: 02 [ 3.341563] .... IRQ redirection table: [ 3.342223] NR Dst Mask Trig IRR Pol Stat Dmod Deli Vect: [ 3.343104] 00 00 1 0 0 0 0 0 0 00 [ 3.343974] 01 03 0 0 0 0 0 1 1 31 [ 3.344836] 02 03 0 0 0 0 0 1 1 30 [ 3.345726] 03 03 0 0 0 0 0 1 1 33 [ 3.346614] 04 03 1 0 0 0 0 1 1 34 [ 3.347489] 05 03 0 0 0 0 0 1 1 35 [ 3.348496] 06 03 0 0 0 0 0 1 1 36 [ 3.349404] 07 03 0 0 0 0 0 1 1 37 [ 3.350352] 08 03 0 0 0 0 0 1 1 38 [ 3.351267] 09 03 1 1 0 0 0 1 1 29 [ 3.352090] 0a 03 1 1 0 0 0 1 1 41 [ 3.352965] 0b 03 1 1 0 0 0 1 1 49 [ 3.353842] 0c 03 0 0 0 0 0 1 1 3C [ 3.354710] 0d 03 0 0 0 0 0 1 1 3D [ 3.355582] 0e 03 0 0 0 0 0 1 1 3E [ 3.356468] 0f 03 0 0 0 0 0 1 1 3F [ 3.357343] 10 00 1 0 0 0 0 0 0 00 [ 3.358163] 11 00 1 0 0 0 0 0 0 00 [ 3.359041] 12 00 1 0 0 0 0 0 0 00 [ 3.359922] 13 00 1 0 0 0 0 0 0 00 [ 3.360847] 14 00 1 0 0 0 0 0 0 00 [ 3.361748] 15 00 1 0 0 0 0 0 0 00 [ 3.362624] 16 00 1 0 0 0 0 0 0 00 [ 3.363515] 17 00 1 0 0 0 0 0 0 00 [ 3.364379] IRQ to pin mappings: [ 3.364888] IRQ0 -> 0:2 [ 3.365372] IRQ1 -> 0:1 [ 3.365798] IRQ3 -> 0:3 [ 3.366299] IRQ4 -> 0:4 [ 3.366727] IRQ5 -> 0:5 [ 3.367155] IRQ6 -> 0:6 [ 3.367612] IRQ7 -> 0:7 [ 3.368049] IRQ8 -> 0:8 [ 3.368522] IRQ12 -> 0:12 [ 3.368971] IRQ13 -> 0:13 [ 3.369452] IRQ14 -> 0:14 [ 3.369903] IRQ15 -> 0:15 [ 3.370413] IRQ33 -> 0:9 [ 3.370855] IRQ34 -> 0:10 [ 3.371337] IRQ35 -> 0:11 [ 3.371792] .................................... done. [ 3.372623] Using IPI No-Shortcut mode [ 3.373320] device: 'cpu_dma_latency': device_add [ 3.374241] device: 'network_latency': device_add [ 3.375106] device: 'network_throughput': device_add [ 3.376073] registered taskstats version 1 [ 3.376761] Running tests on trace events: [ 3.377425] Testing event kfree_skb: [ 3.378106] device: 'serio0': device_add [ 3.378945] bus: 'serio': add device serio0 [ 3.379774] bus: 'serio': driver_probe_device: matched device serio0 with driver atkbd [ 3.381075] bus: 'serio': really_probe: probing driver atkbd with device serio0 [ 3.382798] device: 'input0': device_add [ 3.383837] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 [ 3.385306] driver: 'serio0': driver_bound: bound to device 'atkbd' [ 3.386339] bus: 'serio': really_probe: bound device serio0 to driver atkbd [ 3.387509] device: 'serio1': device_add [ 3.388236] bus: 'serio': add device serio1 [ 3.389036] bus: 'serio': driver_probe_device: matched device serio1 with driver atkbd [ 3.390351] bus: 'serio': really_probe: probing driver atkbd with device serio1 [ 3.391818] atkbd: probe of serio1 rejects match -19 [ 3.392646] bus: 'serio': driver_probe_device: matched device serio1 with driver atkbd [ 3.393913] bus: 'serio': really_probe: probing driver atkbd with device serio1 [ 3.395363] atkbd: probe of serio1 rejects match -19 OK [ 3.431876] Testing event consume_skb: OK [ 3.471761] Testing event skb_copy_datagram_iovec: OK [ 3.511651] Testing event net_dev_xmit: OK [ 3.551920] Testing event net_dev_queue: OK [ 3.591763] Testing event netif_receive_skb: OK [ 3.631582] Testing event netif_rx: OK [ 3.671780] Testing event napi_poll: OK [ 3.711907] Testing event sock_rcvqueue_full: OK [ 3.751792] Testing event sock_exceed_buf_limit: OK [ 3.791563] Testing event udp_fail_queue_rcv_skb: OK [ 3.831382] Testing event regmap_reg_write: OK [ 3.871585] Testing event regmap_reg_read: OK [ 3.911458] Testing event regmap_reg_read_cache: OK [ 3.951465] Testing event regmap_hw_read_start: OK [ 3.991635] Testing event regmap_hw_read_done: OK [ 4.031521] Testing event regmap_hw_write_start: OK [ 4.071697] Testing event regmap_hw_write_done: OK [ 4.111632] Testing event regcache_sync: OK [ 4.151643] Testing event regmap_cache_only: OK [ 4.191448] Testing event regmap_cache_bypass: OK [ 4.231316] Testing event regulator_enable: OK [ 4.271377] Testing event regulator_enable_delay: OK [ 4.311446] Testing event regulator_enable_complete: OK [ 4.351389] Testing event regulator_disable: OK [ 4.391483] Testing event regulator_disable_complete: OK [ 4.431518] Testing event regulator_set_voltage: OK [ 4.471811] Testing event regulator_set_voltage_complete: OK [ 4.511782] Testing event gpio_direction: OK [ 4.552166] Testing event gpio_value: OK [ 4.592177] Testing event writeback_nothread: OK [ 4.631784] Testing event writeback_queue: OK [ 4.671797] Testing event writeback_exec: OK [ 4.711780] Testing event writeback_start: OK [ 4.751787] Testing event writeback_written: OK [ 4.791791] Testing event writeback_wait: OK [ 4.831792] Testing event writeback_pages_written: OK [ 4.871800] Testing event writeback_nowork: OK [ 4.911696] Testing event writeback_wake_background: OK [ 4.951789] Testing event writeback_wake_thread: OK [ 4.991627] Testing event writeback_wake_forker_thread: OK [ 5.031815] Testing event writeback_bdi_register: OK [ 5.071029] Testing event writeback_bdi_unregister: OK [ 5.111744] Testing event writeback_thread_start: OK [ 5.151785] Testing event writeback_thread_stop: OK [ 5.191791] Testing event wbc_writepage: OK [ 5.231779] Testing event writeback_queue_io: OK [ 5.271797] Testing event global_dirty_state: OK [ 5.311555] Testing event bdi_dirty_ratelimit: OK [ 5.351786] Testing event balance_dirty_pages: OK [ 5.391777] Testing event writeback_sb_inodes_requeue: OK [ 5.431536] Testing event writeback_congestion_wait: OK [ 5.471794] Testing event writeback_wait_iff_congested: OK [ 5.510828] Testing event writeback_single_inode: OK [ 5.551785] Testing event mm_compaction_isolate_migratepages: OK [ 5.591702] Testing event mm_compaction_isolate_freepages: OK [ 5.631678] Testing event mm_compaction_migratepages: OK [ 5.671661] Testing event kmalloc: OK [ 5.712108] Testing event kmem_cache_alloc: OK [ 5.751806] Testing event kmalloc_node: OK [ 5.791585] Testing event kmem_cache_alloc_node: OK [ 5.831422] Testing event kfree: OK [ 5.871451] Testing event kmem_cache_free: OK [ 5.911816] Testing event mm_page_free: OK [ 5.951776] Testing event mm_page_free_batched: OK [ 5.991793] Testing event mm_page_alloc: OK [ 6.031773] Testing event mm_page_alloc_zone_locked: OK [ 6.071630] Testing event mm_page_pcpu_drain: OK [ 6.111784] Testing event mm_page_alloc_extfrag: OK [ 6.151687] Testing event mm_vmscan_kswapd_sleep: OK [ 6.191546] Testing event mm_vmscan_kswapd_wake: OK [ 6.231525] Testing event mm_vmscan_wakeup_kswapd: OK [ 6.271768] Testing event mm_vmscan_direct_reclaim_begin: OK [ 6.311793] Testing event mm_vmscan_memcg_reclaim_begin: OK [ 6.350943] Testing event mm_vmscan_memcg_softlimit_reclaim_begin: OK [ 6.391602] Testing event mm_vmscan_direct_reclaim_end: OK [ 6.431407] Testing event mm_vmscan_memcg_reclaim_end: OK [ 6.471598] Testing event mm_vmscan_memcg_softlimit_reclaim_end: OK [ 6.510862] Testing event mm_shrink_slab_start: OK [ 6.551791] Testing event mm_shrink_slab_end: OK [ 6.591792] Testing event mm_vmscan_lru_isolate: OK [ 6.631782] Testing event mm_vmscan_memcg_isolate: OK [ 6.670849] Testing event mm_vmscan_writepage: OK [ 6.711799] Testing event mm_vmscan_lru_shrink_inactive: OK [ 6.751810] Testing event oom_score_adj_update: OK [ 6.792022] Testing event rpm_suspend: OK [ 6.831709] Testing event rpm_resume: OK [ 6.871735] Testing event rpm_idle: OK [ 6.911726] Testing event rpm_return_int: OK [ 6.952032] Testing event cpu_idle: OK [ 6.992785] Testing event cpu_frequency: OK [ 7.030773] Testing event machine_suspend: OK [ 7.071588] Testing event wakeup_source_activate: OK [ 7.111586] Testing event wakeup_source_deactivate: OK [ 7.151600] Testing event power_start: OK [ 7.192151] Testing event power_frequency: OK [ 7.230959] Testing event power_end: OK [ 7.272156] Testing event clock_enable: OK [ 7.311606] Testing event clock_disable: OK [ 7.351699] Testing event clock_set_rate: OK [ 7.391597] Testing event power_domain_target: OK [ 7.431545] Testing event ftrace_test_filter: OK [ 7.471449] Testing event module_load: OK [ 7.511695] Testing event module_free: OK [ 7.551482] Testing event module_get: OK [ 7.591654] Testing event module_put: OK [ 7.631441] Testing event module_request: OK [ 7.671542] Testing event lock_acquire: OK [ 7.711681] Testing event lock_release: OK [ 7.751766] Testing event lock_contended: OK [ 7.791646] Testing event lock_acquired: OK [ 7.831988] Testing event sched_kthread_stop: OK [ 7.871664] Testing event sched_kthread_stop_ret: OK [ 7.910747] Testing event sched_wakeup: OK [ 7.951269] Testing event sched_wakeup_new: OK [ 7.990539] Testing event sched_switch: OK [ 8.030609] Testing event sched_migrate_task: OK [ 8.070567] Testing event sched_process_free: OK [ 8.110526] Testing event sched_process_exit: OK [ 8.150518] Testing event sched_wait_task: OK [ 8.190492] Testing event sched_process_wait: OK [ 8.231363] Testing event sched_process_fork: OK [ 8.271759] Testing event sched_process_exec: OK [ 8.311803] Testing event sched_stat_wait: OK [ 8.351467] Testing event sched_stat_sleep: OK [ 8.391780] Testing event sched_stat_iowait: OK [ 8.431806] Testing event sched_stat_blocked: OK [ 8.471442] Testing event sched_stat_runtime: OK [ 8.511641] Testing event sched_pi_setprio: OK [ 8.551776] Testing event rcu_utilization: OK [ 8.593302] Testing event rcu_grace_period: OK [ 8.632772] Testing event rcu_grace_period_init: OK [ 8.671046] Testing event rcu_preempt_task: OK [ 8.711436] Testing event rcu_unlock_preempted_task: OK [ 8.751537] Testing event rcu_quiescent_state_report: OK [ 8.791770] Testing event rcu_fqs: OK [ 8.831918] Testing event rcu_dyntick: OK [ 8.872474] Testing event rcu_prep_idle: OK [ 8.911511] Testing event rcu_callback: OK [ 8.951767] Testing event rcu_kfree_callback: OK [ 8.991732] Testing event rcu_batch_start: OK [ 9.030675] Testing event rcu_invoke_callback: OK [ 9.071782] Testing event rcu_invoke_kfree_callback: OK [ 9.111774] Testing event rcu_batch_end: OK [ 9.151897] Testing event rcu_torture_read: OK [ 9.191782] Testing event workqueue_queue_work: OK [ 9.231631] Testing event workqueue_activate_work: OK [ 9.271888] Testing event workqueue_execute_start: OK [ 9.310918] Testing event workqueue_execute_end: OK [ 9.351716] Testing event signal_generate: OK [ 9.391676] Testing event signal_deliver: OK [ 9.431764] Testing event timer_init: OK [ 9.471456] Testing event timer_start: OK [ 9.512293] Testing event timer_expire_entry: OK [ 9.550813] Testing event timer_expire_exit: OK [ 9.591791] Testing event timer_cancel: OK [ 9.632646] Testing event hrtimer_init: OK [ 9.670670] Testing event hrtimer_start: OK [ 9.711662] Testing event hrtimer_expire_entry: OK [ 9.751506] Testing event hrtimer_expire_exit: OK [ 9.791894] Testing event hrtimer_cancel: OK [ 9.832118] Testing event itimer_state: OK [ 9.870842] Testing event itimer_expire: OK [ 9.910706] Testing event irq_handler_entry: OK [ 9.951688] Testing event irq_handler_exit: OK [ 9.991836] Testing event softirq_entry: OK [ 10.031598] Testing event softirq_exit: OK [ 10.071794] Testing event softirq_raise: OK [ 10.111807] Testing event console: OK [ 10.151790] Testing event task_newtask: OK [ 10.191262] Testing event task_rename: OK [ 10.230746] Testing event mce_record: OK [ 10.271786] Testing event sys_enter: OK [ 10.310978] Testing event sys_exit: OK [ 10.351799] Running tests on trace event systems: [ 10.353684] Testing event system skb: OK [ 10.392556] Testing event system net: OK [ 10.431619] Testing event system napi: OK [ 10.471495] Testing event system sock: OK [ 10.510726] Testing event system udp: OK [ 10.550778] Testing event system regmap: OK [ 10.594713] Testing event system regulator: OK [ 10.632619] Testing event system gpio: OK [ 10.672759] Testing event system writeback: OK [ 10.715080] Testing event system compaction: OK [ 10.752371] Testing event system kmem: OK [ 10.793099] Testing event system vmscan: OK [ 10.832350] Testing event system oom: OK [ 10.871853] Testing event system rpm: OK [ 10.912279] Testing event system power: OK [ 10.954311] Testing event system test: OK [ 10.991611] Testing event system module: OK [ 11.032600] Testing event system lock: OK [ 11.071034] Testing event system sched: OK [ 11.114732] Testing event system rcu: OK [ 11.155882] Testing event system workqueue: OK [ 11.191386] Testing event system signal: OK [ 11.231930] Testing event system timer: OK [ 11.274305] Testing event system irq: OK [ 11.311019] Testing event system printk: OK [ 11.351213] Testing event system task: OK [ 11.391466] Testing event system syscalls: OK [ 11.431956] Testing event system mce: OK [ 11.470979] Testing event system raw_syscalls: OK [ 11.511836] Running tests on all trace events: [ 11.513672] Testing all events: OK [ 11.606880] Running tests again, along with the function tracer [ 11.608085] Running tests on trace events: [ 11.608836] Testing event kfree_skb: OK [ 11.654052] Testing event consume_skb: OK [ 11.703257] Testing event skb_copy_datagram_iovec: OK [ 11.743618] Testing event net_dev_xmit: OK [ 11.783239] Testing event net_dev_queue: OK [ 11.823790] Testing event netif_receive_skb: OK [ 11.877597] Testing event netif_rx: OK [ 11.926489] Testing event napi_poll: OK [ 11.977781] Testing event sock_rcvqueue_full: OK [ 12.023817] Testing event sock_exceed_buf_limit: OK [ 12.076584] Testing event udp_fail_queue_rcv_skb: OK [ 12.125847] Testing event regmap_reg_write: OK [ 12.177428] Testing event regmap_reg_read: OK [ 12.223357] Testing event regmap_reg_read_cache: OK [ 12.267325] Testing event regmap_hw_read_start: OK [ 12.317389] Testing event regmap_hw_read_done: OK [ 12.366674] Testing event regmap_hw_write_start: OK [ 12.416248] Testing event regmap_hw_write_done: OK [ 12.467423] Testing event regcache_sync: OK [ 12.523051] Testing event regmap_cache_only: OK [ 12.581560] Testing event regmap_cache_bypass: OK [ 12.637454] Testing event regulator_enable: OK [ 12.686602] Testing event regulator_enable_delay: OK [ 12.737419] Testing event regulator_enable_complete: OK [ 12.791178] Testing event regulator_disable: OK [ 12.850352] Testing event regulator_disable_complete: OK [ 12.907557] Testing event regulator_set_voltage: OK [ 12.960380] Testing event regulator_set_voltage_complete: OK [ 13.018342] Testing event gpio_direction: OK [ 13.077261] Testing event gpio_value: OK [ 13.132397] Testing event writeback_nothread: OK [ 13.190015] Testing event writeback_queue: OK [ 13.250485] Testing event writeback_exec: OK [ 13.306613] Testing event writeback_start: OK [ 13.360425] Testing event writeback_written: OK [ 13.417507] Testing event writeback_wait: OK [ 13.466615] Testing event writeback_pages_written: OK [ 13.516518] Testing event writeback_nowork: