[ 0.000000] Linux version 3.6.0-rc3-00182-gc2865bb (kbuild@bee) (gcc version 4.7.1 (Debian 4.7.1-6) ) #50 SMP Mon Sep 10 08:40:58 CST 2012 [ 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] 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] Hypervisor detected: KVM [ 0.000000] e820: update [mem 0x00000000-0x0000ffff] usable ==> reserved [ 0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable [ 0.000000] e820: last_pfn = 0xfffe 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 0x70406, new 0x7010600070106 [ 0.000000] initial memory mapped: [mem 0x00000000-0x01ffffff] [ 0.000000] Base memory trampoline at [c008f000] 8f000 size 16384 [ 0.000000] init_memory_mapping: [mem 0x00000000-0x0fffdfff] [ 0.000000] [mem 0x00000000-0x003fffff] page 4k [ 0.000000] [mem 0x00400000-0x0fbfffff] page 2M [ 0.000000] [mem 0x0fc00000-0x0fffdfff] page 4k [ 0.000000] kernel direct mapping tables up to 0xfffdfff @ [mem 0x01ff9000-0x01ffffff] [ 0.000000] log_buf_len: 8388608 [ 0.000000] early log buf free: 128788(98%) [ 0.000000] RAMDISK: [mem 0x0e73f000-0x0ffeffff] [ 0.000000] ACPI: RSDP 000fd920 00014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0fffe550 00038 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0fffff80 00074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0fffe590 01121 (v01 BXPC BXDSDT 00000001 INTL 20100528) [ 0.000000] ACPI: FACS 0fffff40 00040 [ 0.000000] ACPI: SSDT 0ffffe40 000FF (v01 BOCHS BXPCSSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: APIC 0ffffd50 00080 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0ffffd10 00038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001) [ 0.000000] ACPI: SSDT 0ffff6c0 00644 (v01 BXPC BXSSDTPC 00000001 INTL 20100528) [ 0.000000] ACPI: Local APIC address 0xfee00000 [ 0.000000] mapped APIC to ffffa000 ( fee00000) [ 0.000000] 0MB HIGHMEM available. [ 0.000000] 255MB LOWMEM available. [ 0.000000] mapped low ram: 0 - 0fffe000 [ 0.000000] low ram: 0 - 0fffe000 [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000000] kvm-clock: cpu 0, msr 0:16bd041, boot clock [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x00010000-0x00ffffff] [ 0.000000] Normal [mem 0x01000000-0x0fffdfff] [ 0.000000] HighMem 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] free_area_init_node: node 0, pgdat c14e3840, node_mem_map cdd3f200 [ 0.000000] DMA zone: 32 pages used for memmap [ 0.000000] DMA zone: 0 pages reserved [ 0.000000] DMA zone: 3939 pages, LIFO batch:0 [ 0.000000] Normal zone: 480 pages used for memmap [ 0.000000] Normal zone: 60958 pages, LIFO batch:15 [ 0.000000] Using APIC driver default [ 0.000000] ACPI: PM-Timer IO Port: 0xb008 [ 0.000000] ACPI: Local APIC address 0xfee00000 [ 0.000000] mapped APIC to ffffa000 ( 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 ffff9000 (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:32 nr_cpumask_bits:32 nr_cpu_ids:2 nr_node_ids:1 [ 0.000000] PERCPU: Embedded 333 pages/cpu @cdaa5000 s1341280 r0 d22688 u1363968 [ 0.000000] pcpu-alloc: s1341280 r0 d22688 u1363968 alloc=333*4096 [ 0.000000] pcpu-alloc: [0] 0 [0] 1 [ 0.000000] kvm-clock: cpu 0, msr 0:dbec041, primary cpu clock [ 0.000000] KVM setup async PF for cpu 0 [ 0.000000] kvm-stealtime: cpu 0, msr daa78c0 [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 64897 [ 0.000000] Kernel command line: trinity=2m hung_task_panic=1 rcutree.rcu_cpu_stall_timeout=100 branch=signal/experimental-kernel_thread 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-09-10-08-41-44-signal:experimental-kernel_thread:a392720-c2865bb-i386-randconfig-b006-1-fat BOOT_IMAGE=kernel-tests/kernels/i386-randconfig-b006/c2865bb/vmlinuz-3.6.0-rc3-00182-gc2865bb [ 0.000000] sysrq: sysrq always enabled. [ 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: 210572k/262136k available (3227k kernel code, 51064k reserved, 1939k data, 1736k init, 0k highmem) [ 0.000000] virtual kernel memory layout: [ 0.000000] fixmap : 0xffa94000 - 0xfffff000 (5548 kB) [ 0.000000] pkmap : 0xff400000 - 0xff800000 (4096 kB) [ 0.000000] vmalloc : 0xd07fe000 - 0xff3fe000 ( 748 MB) [ 0.000000] lowmem : 0xc0000000 - 0xcfffe000 ( 255 MB) [ 0.000000] .init : 0xc150c000 - 0xc16be000 (1736 kB) [ 0.000000] .data : 0xc1326f26 - 0xc150bd60 (1939 kB) [ 0.000000] .text : 0xc1000000 - 0xc1326f26 (3227 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] [ 0.000000] [ 0.000000] [ 0.000000] NR_IRQS:2304 nr_irqs:512 16 [ 0.000000] CPU 0 irqstacks, hard=cd40a000 soft=cd40c000 [ 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: 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] hpet clockevent registered [ 0.000000] tsc: Detected 3200.098 MHz processor [ 0.010000] Calibrating delay loop (skipped) preset value.. 6400.19 BogoMIPS (lpj=32000980) [ 0.010000] pid_max: default: 32768 minimum: 301 [ 0.010000] Mount-cache hash table entries: 512 [ 0.010000] mce: CPU supports 10 MCE banks [ 0.010000] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.010000] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.010000] tlb_flushall_shift is 0x6 [ 0.010430] ACPI: Core revision 20120711 [ 0.014445] ftrace: allocating 12564 entries in 25 pages [ 0.020176] Getting VERSION: 50014 [ 0.020759] Getting VERSION: 50014 [ 0.021303] Getting ID: 0 [ 0.021773] Getting ID: f000000 [ 0.022287] Getting LVT0: 8700 [ 0.022833] Getting LVT1: 8400 [ 0.030007] Enabling APIC mode: Flat. Using 1 I/O APICs [ 0.030806] enabled ExtINT on CPU#0 [ 0.032166] ENABLING IO-APIC IRQs [ 0.032705] init IO_APIC IRQs [ 0.033245] apic 2 pin 0 not connected [ 0.033844] IOAPIC[0]: Set routing entry (2-1 -> 0x31 -> IRQ 1 Mode:0 Active:0 Dest:1) [ 0.035014] IOAPIC[0]: Set routing entry (2-2 -> 0x30 -> IRQ 0 Mode:0 Active:0 Dest:1) [ 0.036201] IOAPIC[0]: Set routing entry (2-3 -> 0x33 -> IRQ 3 Mode:0 Active:0 Dest:1) [ 0.037389] IOAPIC[0]: Set routing entry (2-4 -> 0x34 -> IRQ 4 Mode:0 Active:0 Dest:1) [ 0.038548] IOAPIC[0]: Set routing entry (2-5 -> 0x35 -> IRQ 5 Mode:1 Active:0 Dest:1) [ 0.039742] IOAPIC[0]: Set routing entry (2-6 -> 0x36 -> IRQ 6 Mode:0 Active:0 Dest:1) [ 0.040021] IOAPIC[0]: Set routing entry (2-7 -> 0x37 -> IRQ 7 Mode:0 Active:0 Dest:1) [ 0.041194] IOAPIC[0]: Set routing entry (2-8 -> 0x38 -> IRQ 8 Mode:0 Active:0 Dest:1) [ 0.042376] IOAPIC[0]: Set routing entry (2-9 -> 0x39 -> IRQ 9 Mode:1 Active:0 Dest:1) [ 0.043516] IOAPIC[0]: Set routing entry (2-10 -> 0x3a -> IRQ 10 Mode:1 Active:0 Dest:1) [ 0.044703] IOAPIC[0]: Set routing entry (2-11 -> 0x3b -> IRQ 11 Mode:1 Active:0 Dest:1) [ 0.045861] IOAPIC[0]: Set routing entry (2-12 -> 0x3c -> IRQ 12 Mode:0 Active:0 Dest:1) [ 0.047053] IOAPIC[0]: Set routing entry (2-13 -> 0x3d -> IRQ 13 Mode:0 Active:0 Dest:1) [ 0.048210] IOAPIC[0]: Set routing entry (2-14 -> 0x3e -> IRQ 14 Mode:0 Active:0 Dest:1) [ 0.050022] IOAPIC[0]: Set routing entry (2-15 -> 0x3f -> IRQ 15 Mode:0 Active:0 Dest:1) [ 0.051210] apic 2 pin 16 not connected [ 0.051799] apic 2 pin 17 not connected [ 0.052386] apic 2 pin 18 not connected [ 0.053007] apic 2 pin 19 not connected [ 0.053592] apic 2 pin 20 not connected [ 0.054182] apic 2 pin 21 not connected [ 0.054766] apic 2 pin 22 not connected [ 0.055384] apic 2 pin 23 not connected [ 0.056121] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.057051] smpboot: CPU0: Intel Common KVM processor stepping 01 [ 0.058186] Using local APIC timer interrupts. [ 0.058186] calibrating APIC timer ... [ 0.060000] ... lapic delta = 6254196 [ 0.060000] ... PM-Timer delta = 358195 [ 0.060000] ... PM-Timer result ok [ 0.060000] ..... delta 6254196 [ 0.060000] ..... mult: 268615672 [ 0.060000] ..... calibration result: 10006713 [ 0.060000] ..... CPU clock speed is 3202.2566 MHz. [ 0.060000] ..... host bus clock speed is 1000.6713 MHz. [ 0.060000] Performance Events: unsupported Netburst CPU model 6 no PMU driver, software events only. [ 0.060000] Testing tracer nop: PASSED [ 0.060000] SMP alternatives: lockdep: fixing up alternatives [ 0.060000] CPU 1 irqstacks, hard=cd49c000 soft=cd49e000 [ 0.060000] smpboot: Booting Node 0, Processors #1 OK [ 0.010000] Initializing CPU#1 [ 0.010000] kvm-clock: cpu 1, msr 0:dd39041, secondary cpu clock [ 0.010000] masked ExtINT on CPU#1 [ 0.080439] Brought up 2 CPUs [ 0.080429] KVM setup async PF for cpu 1 [ 0.080429] kvm-stealtime: cpu 1, msr dbf48c0 [ 0.082164] smpboot: Total of 2 processors activated (12800.39 BogoMIPS) [ 0.090391] CPU0 attaching sched-domain: [ 0.090951] domain 0: span 0-1 level CPU [ 0.091661] groups: 0 1 [ 0.092281] CPU1 attaching sched-domain: [ 0.092834] domain 0: span 0-1 level CPU [ 0.093537] groups: 1 0 [ 0.095747] dummy: [ 0.096400] NET: Registered protocol family 16 [ 0.097612] ACPI: bus type pci registered [ 0.098350] PCI: PCI BIOS revision 2.10 entry at 0xfc78c, last bus=0 [ 0.099226] PCI: Using configuration type 1 for base access [ 0.101617] bio: create slab at 0 [ 0.102610] ACPI: Added _OSI(Module Device) [ 0.103287] ACPI: Added _OSI(Processor Device) [ 0.103889] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.104518] ACPI: Added _OSI(Processor Aggregator Device) [ 0.107803] ACPI: EC: Look up EC in DSDT [ 0.115532] ACPI: Interpreter enabled [ 0.116158] ACPI: (supports S0 S3 S5) [ 0.116914] ACPI: Using IOAPIC for interrupt routing [ 0.128563] ACPI: No dock devices found. [ 0.129137] PCI: Ignoring host bridge windows from ACPI; if necessary, use "pci=use_crs" and report a bug [ 0.130054] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.130877] pci_root PNP0A03:00: host bridge window [io 0x0000-0x0cf7] (ignored) [ 0.131982] pci_root PNP0A03:00: host bridge window [io 0x0d00-0xffff] (ignored) [ 0.133005] pci_root PNP0A03:00: host bridge window [mem 0x000a0000-0x000bffff] (ignored) [ 0.134170] pci_root PNP0A03:00: host bridge window [mem 0xe0000000-0xfebfffff] (ignored) [ 0.135335] PCI: root bus 00: using default resources [ 0.136024] pci_root PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.137714] PCI host bridge to bus 0000:00 [ 0.138305] pci_bus 0000:00: busn_res: [bus 00-ff] is inserted under domain [bus 00-ff] [ 0.139461] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.140005] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] [ 0.140780] pci_bus 0000:00: root bus resource [mem 0x00000000-0xffffffff] [ 0.141763] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.142794] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.144025] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.146384] pci 0000:00:01.1: reg 20: [io 0xc1c0-0xc1cf] [ 0.148057] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.149210] pci 0000:00:01.3: quirk: [io 0xb000-0xb03f] claimed by PIIX4 ACPI [ 0.150014] pci 0000:00:01.3: quirk: [io 0xb100-0xb10f] claimed by PIIX4 SMB [ 0.151067] pci 0000:00:02.0: [1013:00b8] type 00 class 0x030000 [ 0.152736] pci 0000:00:02.0: reg 10: [mem 0xfc000000-0xfdffffff pref] [ 0.154452] pci 0000:00:02.0: reg 14: [mem 0xfebf4000-0xfebf4fff] [ 0.160091] pci 0000:00:02.0: reg 30: [mem 0xfebe0000-0xfebeffff pref] [ 0.161374] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000 [ 0.162543] pci 0000:00:03.0: reg 10: [mem 0xfeba0000-0xfebbffff] [ 0.163989] pci 0000:00:03.0: reg 14: [io 0xc000-0xc03f] [ 0.167852] pci 0000:00:03.0: reg 30: [mem 0xfebc0000-0xfebdffff pref] [ 0.169049] pci 0000:00:04.0: [8086:2668] type 00 class 0x040300 [ 0.170224] pci 0000:00:04.0: reg 10: [mem 0xfebf0000-0xfebf3fff] [ 0.173334] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.174522] pci 0000:00:05.0: reg 10: [io 0xc040-0xc07f] [ 0.175908] pci 0000:00:05.0: reg 14: [mem 0xfebf5000-0xfebf5fff] [ 0.180180] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.181296] pci 0000:00:06.0: reg 10: [io 0xc080-0xc0bf] [ 0.182683] pci 0000:00:06.0: reg 14: [mem 0xfebf6000-0xfebf6fff] [ 0.187091] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 [ 0.188283] pci 0000:00:07.0: reg 10: [io 0xc0c0-0xc0ff] [ 0.189664] pci 0000:00:07.0: reg 14: [mem 0xfebf7000-0xfebf7fff] [ 0.193654] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 [ 0.194776] pci 0000:00:08.0: reg 10: [io 0xc100-0xc13f] [ 0.196169] pci 0000:00:08.0: reg 14: [mem 0xfebf8000-0xfebf8fff] [ 0.201097] pci 0000:00:09.0: [1af4:1001] type 00 class 0x010000 [ 0.202297] pci 0000:00:09.0: reg 10: [io 0xc140-0xc17f] [ 0.203685] pci 0000:00:09.0: reg 14: [mem 0xfebf9000-0xfebf9fff] [ 0.208092] pci 0000:00:0a.0: [1af4:1001] type 00 class 0x010000 [ 0.209209] pci 0000:00:0a.0: reg 10: [io 0xc180-0xc1bf] [ 0.210617] pci 0000:00:0a.0: reg 14: [mem 0xfebfa000-0xfebfafff] [ 0.215002] pci 0000:00:0b.0: [8086:25ab] type 00 class 0x088000 [ 0.216026] pci 0000:00:0b.0: reg 10: [mem 0xfebfb000-0xfebfb00f] [ 0.219132] pci_bus 0000:00: on NUMA node 0 [ 0.219829] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT] [ 0.221620] pci0000:00: Unable to request _OSC control (_OSC support mask: 0x08) [ 0.243301] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11) [ 0.244563] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11) [ 0.245820] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11) [ 0.247078] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11) [ 0.248322] ACPI: PCI Interrupt Link [LNKS] (IRQs 9) *0 [ 0.249687] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none [ 0.250024] vgaarb: loaded [ 0.250469] vgaarb: bridge control possible 0000:00:02.0 [ 0.251536] PCI: Using ACPI for IRQ routing [ 0.252126] PCI: pci_cache_line_size set to 64 bytes [ 0.253161] e820: reserve RAM buffer [mem 0x00093c00-0x0009ffff] [ 0.253927] e820: reserve RAM buffer [mem 0x0fffe000-0x0fffffff] [ 0.255308] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.256199] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.259104] Switching to clocksource kvm-clock [ 0.260717] Warning: could not register annotated branches stats [ 0.270660] pnp: PnP ACPI init [ 0.271262] ACPI: bus type pnp registered [ 0.271869] pnp 00:00: [bus 00-ff] [ 0.272384] pnp 00:00: [io 0x0cf8-0x0cff] [ 0.273024] pnp 00:00: [io 0x0000-0x0cf7 window] [ 0.273674] pnp 00:00: [io 0x0d00-0xffff window] [ 0.274311] pnp 00:00: [mem 0x000a0000-0x000bffff window] [ 0.275082] pnp 00:00: [mem 0xe0000000-0xfebfffff window] [ 0.275930] pnp 00:00: Plug and Play ACPI device, IDs PNP0a03 (active) [ 0.276780] pnp 00:01: [io 0x0070-0x0071] [ 0.277455] IOAPIC[0]: Set routing entry (2-8 -> 0x38 -> IRQ 8 Mode:0 Active:0 Dest:3) [ 0.278538] pnp 00:01: [irq 8] [ 0.279098] pnp 00:01: [io 0x0072-0x0077] [ 0.279742] pnp 00:01: Plug and Play ACPI device, IDs PNP0b00 (active) [ 0.280622] pnp 00:02: [io 0x0060] [ 0.281228] pnp 00:02: [io 0x0064] [ 0.281746] IOAPIC[0]: Set routing entry (2-1 -> 0x31 -> IRQ 1 Mode:0 Active:0 Dest:3) [ 0.282828] pnp 00:02: [irq 1] [ 0.283444] pnp 00:02: Plug and Play ACPI device, IDs PNP0303 (active) [ 0.284316] IOAPIC[0]: Set routing entry (2-12 -> 0x3c -> IRQ 12 Mode:0 Active:0 Dest:3) [ 0.285504] pnp 00:03: [irq 12] [ 0.286060] pnp 00:03: Plug and Play ACPI device, IDs PNP0f13 (active) [ 0.286927] pnp 00:04: [io 0x03f2-0x03f5] [ 0.287596] pnp 00:04: [io 0x03f7] [ 0.288120] IOAPIC[0]: Set routing entry (2-6 -> 0x36 -> IRQ 6 Mode:0 Active:0 Dest:3) [ 0.289274] pnp 00:04: [irq 6] [ 0.289765] pnp 00:04: [dma 2] [ 0.290307] pnp 00:04: Plug and Play ACPI device, IDs PNP0700 (active) [ 0.291316] pnp 00:05: [io 0x0378-0x037f] [ 0.291896] IOAPIC[0]: Set routing entry (2-7 -> 0x37 -> IRQ 7 Mode:0 Active:0 Dest:3) [ 0.293061] pnp 00:05: [irq 7] [ 0.293604] pnp 00:05: Plug and Play ACPI device, IDs PNP0400 (active) [ 0.294521] pnp 00:06: [io 0x03f8-0x03ff] [ 0.295188] IOAPIC[0]: Set routing entry (2-4 -> 0x34 -> IRQ 4 Mode:0 Active:0 Dest:3) [ 0.296269] pnp 00:06: [irq 4] [ 0.296821] pnp 00:06: Plug and Play ACPI device, IDs PNP0501 (active) [ 0.298142] pnp 00:07: [mem 0xfed00000-0xfed003ff] [ 0.298896] pnp 00:07: Plug and Play ACPI device, IDs PNP0103 (active) [ 0.300097] pnp: PnP ACPI: found 8 devices [ 0.300673] ACPI: ACPI bus type pnp unregistered [ 0.338949] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] [ 0.339754] pci_bus 0000:00: resource 5 [mem 0x00000000-0xffffffff] [ 0.340564] NET: Registered protocol family 1 [ 0.341259] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.342023] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.342771] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.343651] pci 0000:00:02.0: Boot video device [ 0.344365] PCI: CLS 0 bytes, default 64 [ 0.345248] Unpacking initramfs... [ 1.182320] Freeing initrd memory: 25284k freed [ 1.195901] DMA-API: preallocated 32768 debug entries [ 1.196601] DMA-API: debugging enabled by kernel config [ 1.290129] Testing tracer function: PASSED [ 1.520950] Testing dynamic ftrace: PASSED [ 1.840771] Testing dynamic ftrace ops #1: (1 0 1 1 0) (1 1 2 1 0) (2 1 3 1 19) (2 2 4 1 262) PASSED [ 1.916596] Testing dynamic ftrace ops #2: (1 0 1 19 0) (1 1 2 294 0) (2 1 3 1 32) (2 2 4 244 275) PASSED [ 2.190876] tsc: Refined TSC clocksource calibration: 3200.115 MHz [ 2.210747] Testing tracer wakeup: [ 2.739067] ftrace-test (20) used greatest stack depth: 7232 bytes left PASSED [ 2.919025] Testing tracer wakeup_rt: PASSED [ 3.629487] Testing tracer branch: PASSED [ 3.920818] HugeTLB registered 4 MB page size, pre-allocated 0 pages [ 3.928225] VFS: Disk quotas dquot_6.5.2 [ 3.928945] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) [ 3.930589] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252) [ 3.931604] io scheduler noop registered (default) [ 3.932539] crc32: CRC_LE_BITS = 64, CRC_BE BITS = 64 [ 3.933203] crc32: self tests passed, processed 225944 bytes in 127976 nsec [ 3.934249] crc32c: CRC_LE_BITS = 64 [ 3.934771] crc32c: self tests passed, processed 225944 bytes in 64127 nsec [ 3.935824] GHES: HEST is not enabled! [ 3.936511] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 3.958557] serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A [ 3.981788] 00:06: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A [ 3.983102] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.985006] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.985709] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.986845] mousedev: PS/2 mouse device common for all mice [ 3.988212] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 [ 3.989633] cpuidle: using governor ladder [ 3.990625] [ 3.990625] printing PIC contents [ 3.991402] ... PIC IMR: ffff [ 3.991873] ... PIC IRR: 1013 [ 3.992367] ... PIC ISR: 0000 [ 3.992839] ... PIC ELCR: 0c00 [ 3.993390] printing local APIC contents on CPU#0/0: [ 3.994127] ... APIC ID: 00000000 (0) [ 3.994724] ... APIC VERSION: 00050014 [ 3.995294] ... APIC TASKPRI: 00000000 (00) [ 3.995899] ... APIC PROCPRI: 00000000 [ 3.996466] ... APIC LDR: 01000000 [ 3.997000] ... APIC DFR: ffffffff [ 3.997527] ... APIC SPIV: 000001ff [ 3.998063] ... APIC ISR field: [ 3.998566] 0000000000000000000000000000000000000000000000000000000000000000 [ 3.999935] ... APIC TMR field: [ 4.000439] 0000000000000000000000000000000000000000000000000000000000000000 [ 4.001807] ... APIC IRR field: [ 4.001956] 0000000000000000000000000000000000000000000000000000000000008000 [ 4.001956] ... APIC ESR: 00000000 [ 4.001956] ... APIC ICR: 000008fd [ 4.001956] ... APIC ICR2: 02000000 [ 4.001956] ... APIC LVTT: 000200ef [ 4.001956] ... APIC LVTPC: 00010000 [ 4.001956] ... APIC LVT0: 00010700 [ 4.001956] ... APIC LVT1: 00000400 [ 4.001956] ... APIC LVTERR: 000000fe [ 4.001956] ... APIC TMICT: 00098b0b [ 4.001956] ... APIC TMCCT: 0003256c [ 4.001956] ... APIC TDCR: 00000003 [ 4.001956] [ 4.010047] number of MP IRQ sources: 15. [ 4.010636] number of IO-APIC #2 registers: 24. [ 4.011275] testing the IO APIC....................... [ 4.012006] IO APIC #2...... [ 4.012465] .... register #00: 00000000 [ 4.013016] ....... : physical APIC id: 00 [ 4.013607] ....... : Delivery Type: 0 [ 4.014243] ....... : LTS : 0 [ 4.014804] .... register #01: 00170011 [ 4.015356] ....... : max redirection entries: 17 [ 4.016087] ....... : PRQ implemented: 0 [ 4.016673] ....... : IO APIC version: 11 [ 4.017271] .... register #02: 00000000 [ 4.017817] ....... : arbitration: 00 [ 4.018458] .... IRQ redirection table: [ 4.019008] NR Dst Mask Trig IRR Pol Stat Dmod Deli Vect: [ 4.019730] 00 00 1 0 0 0 0 0 0 00 [ 4.020556] 01 03 0 0 0 0 0 1 1 31 [ 4.021300] 02 03 0 0 0 0 0 1 1 30 [ 4.022093] 03 03 0 0 0 0 0 1 1 33 [ 4.022829] 04 03 1 0 0 0 0 1 1 34 [ 4.023571] 05 03 1 1 0 0 0 1 1 35 [ 4.024401] 06 03 0 0 0 0 0 1 1 36 [ 4.025138] 07 03 0 0 0 0 0 1 1 37 [ 4.025873] 08 03 0 0 0 0 0 1 1 38 [ 4.026700] 09 03 0 1 0 0 0 1 1 39 [ 4.027448] 0a 03 1 1 0 0 0 1 1 3A [ 4.028271] 0b 03 1 1 0 0 0 1 1 3B [ 4.029016] 0c 03 0 0 0 0 0 1 1 3C [ 4.029773] 0d 03 0 0 0 0 0 1 1 3D [ 4.030598] 0e 03 0 0 0 0 0 1 1 3E [ 4.031335] 0f 03 0 0 0 0 0 1 1 3F [ 4.032103] 10 00 1 0 0 0 0 0 0 00 [ 4.032845] 11 00 1 0 0 0 0 0 0 00 [ 4.033594] 12 00 1 0 0 0 0 0 0 00 [ 4.034417] 13 00 1 0 0 0 0 0 0 00 [ 4.035165] 14 00 1 0 0 0 0 0 0 00 [ 4.035906] 15 00 1 0 0 0 0 0 0 00 [ 4.036726] 16 00 1 0 0 0 0 0 0 00 [ 4.037471] 17 00 1 0 0 0 0 0 0 00 [ 4.038284] IRQ to pin mappings: [ 4.038772] IRQ0 -> 0:2 [ 4.039306] IRQ1 -> 0:1 [ 4.039845] IRQ3 -> 0:3 [ 4.040458] IRQ4 -> 0:4 [ 4.040989] IRQ5 -> 0:5 [ 4.041515] IRQ6 -> 0:6 [ 4.042054] IRQ7 -> 0:7 [ 4.042586] IRQ8 -> 0:8 [ 4.043197] IRQ9 -> 0:9 [ 4.043722] IRQ10 -> 0:10 [ 4.044351] IRQ11 -> 0:11 [ 4.044895] IRQ12 -> 0:12 [ 4.045524] IRQ13 -> 0:13 [ 4.046073] IRQ14 -> 0:14 [ 4.046615] IRQ15 -> 0:15 [ 4.047233] .................................... done. [ 4.047897] Using IPI No-Shortcut mode [ 4.048707] registered taskstats version 1 [ 4.049358] Running tests on trace events: [ 4.049936] Testing event kfree_skb: [ 4.089781] test-events (25) used greatest stack depth: 7060 bytes left OK [ 4.091079] Testing event consume_skb: OK [ 4.122461] Testing event skb_copy_datagram_iovec: OK [ 4.162485] Testing event net_dev_xmit: OK [ 4.202547] Testing event net_dev_queue: OK [ 4.242539] Testing event netif_receive_skb: OK [ 4.282570] Testing event netif_rx: OK [ 4.322620] Testing event napi_poll: OK [ 4.362644] Testing event sock_rcvqueue_full: OK [ 4.402653] Testing event sock_exceed_buf_limit: OK [ 4.442679] Testing event udp_fail_queue_rcv_skb: OK [ 4.482700] Testing event regmap_reg_write: OK [ 4.522725] Testing event regmap_reg_read: OK [ 4.562755] Testing event regmap_reg_read_cache: OK [ 4.602782] Testing event regmap_hw_read_start: OK [ 4.642831] Testing event regmap_hw_read_done: OK [ 4.682840] Testing event regmap_hw_write_start: OK [ 4.722866] Testing event regmap_hw_write_done: OK [ 4.762886] Testing event regcache_sync: OK [ 4.802914] Testing event regmap_cache_only: OK [ 4.842946] Testing event regmap_cache_bypass: OK [ 4.883120] Testing event mix_pool_bytes: OK [ 4.923146] Testing event mix_pool_bytes_nolock: OK [ 4.963127] Testing event credit_entropy_bits: OK [ 5.003186] Testing event get_random_bytes: OK [ 5.043293] Testing event extract_entropy: OK [ 5.083252] Testing event extract_entropy_user: OK [ 5.123294] Testing event regulator_enable: OK [ 5.163298] Testing event regulator_enable_delay: OK [ 5.203332] Testing event regulator_enable_complete: OK [ 5.243306] Testing event regulator_disable: OK [ 5.283366] Testing event regulator_disable_complete: OK [ 5.323363] Testing event regulator_set_voltage: OK [ 5.363391] Testing event regulator_set_voltage_complete: OK [ 5.403363] Testing event gpio_direction: OK [ 5.443432] Testing event gpio_value: OK [ 5.483378] Testing event block_rq_abort: OK [ 5.523497] Testing event block_rq_requeue: OK [ 5.563478] Testing event block_rq_complete: OK [ 5.603558] Testing event block_rq_insert: OK [ 5.643578] Testing event block_rq_issue: OK [ 5.683529] Testing event block_bio_bounce: OK [ 5.723535] Testing event block_bio_complete: OK [ 5.763574] Testing event block_bio_backmerge: OK [ 5.803604] Testing event block_bio_frontmerge: OK [ 5.843635] Testing event block_bio_queue: OK [ 5.883637] Testing event block_getrq: OK [ 5.923677] Testing event block_sleeprq: OK [ 5.963699] Testing event block_plug: OK [ 6.003815] Testing event block_unplug: OK [ 6.043858] Testing event block_split: OK [ 6.083796] Testing event block_bio_remap: OK [ 6.123901] Testing event block_rq_remap: OK [ 6.163937] Testing event writeback_nothread: OK [ 6.203864] Testing event writeback_queue: OK [ 6.243978] Testing event writeback_exec: OK [ 6.284108] Testing event writeback_start: OK [ 6.324145] Testing event writeback_written: OK [ 6.364100] Testing event writeback_wait: OK [ 6.404214] Testing event writeback_pages_written: OK [ 6.446173] Testing event writeback_nowork: OK [ 6.484252] Testing event writeback_wake_background: OK [ 6.524217] Testing event writeback_wake_thread: OK [ 6.564298] Testing event writeback_wake_forker_thread: OK [ 6.604256] Testing event writeback_bdi_register: OK [ 6.644281] Testing event writeback_bdi_unregister: OK [ 6.684311] Testing event writeback_thread_start: OK [ 6.724320] Testing event writeback_thread_stop: OK [ 6.764359] Testing event wbc_writepage: OK [ 6.804364] Testing event writeback_queue_io: OK [ 6.844371] Testing event global_dirty_state: OK [ 6.884406] Testing event bdi_dirty_ratelimit: OK [ 6.924400] Testing event balance_dirty_pages: OK [ 6.964413] Testing event writeback_sb_inodes_requeue: OK [ 7.004443] Testing event writeback_congestion_wait: OK [ 7.044479] Testing event writeback_wait_iff_congested: OK [ 7.084497] Testing event writeback_single_inode: OK [ 7.124511] Testing event mm_compaction_isolate_migratepages: OK [ 7.164543] Testing event mm_compaction_isolate_freepages: OK [ 7.204582] Testing event mm_compaction_migratepages: OK [ 7.244588] Testing event kmalloc: OK [ 7.284624] Testing event kmem_cache_alloc: OK [ 7.324650] Testing event kmalloc_node: OK [ 7.364675] Testing event kmem_cache_alloc_node: OK [ 7.404702] Testing event kfree: OK [ 7.444731] Testing event kmem_cache_free: OK [ 7.484774] Testing event mm_page_free: OK [ 7.524795] Testing event mm_page_free_batched: OK [ 7.564806] Testing event mm_page_alloc: OK [ 7.604831] Testing event mm_page_alloc_zone_locked: OK [ 7.644857] Testing event mm_page_pcpu_drain: OK [ 7.684883] Testing event mm_page_alloc_extfrag: OK [ 7.724919] Testing event mm_vmscan_kswapd_sleep: OK [ 7.764959] Testing event mm_vmscan_kswapd_wake: OK [ 7.804968] Testing event mm_vmscan_wakeup_kswapd: OK [ 7.845050] Testing event mm_vmscan_direct_reclaim_begin: OK [ 7.885104] Testing event mm_vmscan_memcg_reclaim_begin: OK [ 7.925130] Testing event mm_vmscan_memcg_softlimit_reclaim_begin: OK [ 7.965155] Testing event mm_vmscan_direct_reclaim_end: OK [ 8.005186] Testing event mm_vmscan_memcg_reclaim_end: OK [ 8.045234] Testing event mm_vmscan_memcg_softlimit_reclaim_end: OK [ 8.085239] Testing event mm_shrink_slab_start: OK [ 8.125269] Testing event mm_shrink_slab_end: OK [ 8.165300] Testing event mm_vmscan_lru_isolate: OK [ 8.205325] Testing event mm_vmscan_memcg_isolate: OK [ 8.245306] Testing event mm_vmscan_writepage: OK [ 8.285322] Testing event mm_vmscan_lru_shrink_inactive: OK [ 8.325350] Testing event oom_score_adj_update: OK [ 8.365364] Testing event rpm_suspend: OK [ 8.405370] Testing event rpm_resume: OK [ 8.445396] Testing event rpm_idle: OK [ 8.485432] Testing event rpm_return_int: OK [ 8.525483] Testing event cpu_idle: OK [ 8.565485] Testing event cpu_frequency: OK [ 8.605507] Testing event machine_suspend: OK [ 8.645546] Testing event wakeup_source_activate: OK [ 8.685578] Testing event wakeup_source_deactivate: OK [ 8.725591] Testing event clock_enable: OK [ 8.765630] Testing event clock_disable: OK [ 8.805650] Testing event clock_set_rate: OK [ 8.845650] Testing event power_domain_target: OK [ 8.885715] Testing event ftrace_test_filter: OK [ 8.925723] Testing event module_load: OK [ 8.965754] Testing event module_free: OK [ 9.005804] Testing event module_get: OK [ 9.045817] Testing event module_put: OK [ 9.085828] Testing event module_request: OK [ 9.125852] Testing event lock_acquire: OK [ 9.165908] Testing event lock_release: OK [ 9.205957] Testing event lock_contended: OK [ 9.245945] Testing event lock_acquired: OK [ 9.285995] Testing event sched_kthread_stop: OK [ 9.326087] Testing event sched_kthread_stop_ret: OK [ 9.366135] Testing event sched_wakeup: OK [ 9.405970] Testing event sched_wakeup_new: OK [ 9.445966] Testing event sched_switch: OK [ 9.485990] Testing event sched_migrate_task: OK [ 9.526089] Testing event sched_process_free: OK [ 9.566114] Testing event sched_process_exit: OK [ 9.606146] Testing event sched_wait_task: OK [ 9.646174] Testing event sched_process_wait: OK [ 9.686199] Testing event sched_process_fork: OK [ 9.726224] Testing event sched_process_exec: OK [ 9.766267] Testing event sched_stat_wait: OK [ 9.806291] Testing event sched_stat_sleep: OK [ 9.846289] Testing event sched_stat_iowait: OK [ 9.886277] Testing event sched_stat_blocked: OK [ 9.926289] Testing event sched_stat_runtime: OK [ 9.966319] Testing event sched_pi_setprio: OK [ 10.006370] Testing event rcu_utilization: OK [ 10.046416] Testing event workqueue_queue_work: OK [ 10.086383] Testing event workqueue_activate_work: OK [ 10.126450] Testing event workqueue_execute_start: OK [ 10.166481] Testing event workqueue_execute_end: OK [ 10.206477] Testing event signal_generate: OK [ 10.246451] Testing event signal_deliver: OK [ 10.286526] Testing event timer_init: OK [ 10.326552] Testing event timer_start: OK [ 10.366587] Testing event timer_expire_entry: OK [ 10.406587] Testing event timer_expire_exit: OK [ 10.446639] Testing event timer_cancel: OK [ 10.486665] Testing event hrtimer_init: OK [ 10.526789] Testing event hrtimer_start: OK [ 10.566789] Testing event hrtimer_expire_entry: OK [ 10.606851] Testing event hrtimer_expire_exit: OK [ 10.646867] Testing event hrtimer_cancel: OK [ 10.687116] Testing event itimer_state: OK [ 10.726987] Testing event itimer_expire: OK [ 10.767110] Testing event irq_handler_entry: OK [ 10.806998] Testing event irq_handler_exit: OK [ 10.847100] Testing event softirq_entry: OK [ 10.887126] Testing event softirq_exit: OK [ 10.927165] Testing event softirq_raise: OK [ 10.967203] Testing event console: OK [ 11.007210] Testing event task_newtask: OK [ 11.047268] Testing event task_rename: OK [ 11.087275] Testing event mce_record: OK [ 11.127306] Testing event sys_enter: OK [ 11.167346] Testing event sys_exit: OK [ 11.207371] Running tests on trace event systems: [ 11.207995] Testing event system skb: OK [ 11.247349] Testing event system net: OK [ 11.287388] Testing event system napi: OK [ 11.327373] Testing event system sock: OK [ 11.367395] Testing event system udp: OK [ 11.407405] Testing event system regmap: OK [ 11.447513] Testing event system random: OK [ 11.487574] Testing event system regulator: OK [ 11.527569] Testing event system gpio: OK [ 11.567520] Testing event system block: OK [ 11.607742] Testing event system writeback: OK [ 11.647861] Testing event system compaction: OK [ 11.687610] Testing event system kmem: OK [ 11.727761] Testing event system vmscan: OK [ 11.767817] Testing event system oom: OK [ 11.807687] Testing event system rpm: OK [ 11.847747] Testing event system power: OK [ 11.887830] Testing event system test: OK [ 11.927752] Testing event system module: OK [ 11.967825] Testing event system lock: OK [ 12.007937] Testing event system sched: OK [ 12.048151] Testing event system rcu: OK [ 12.087894] Testing event system workqueue: OK [ 12.127932] Testing event system signal: OK [ 12.167927] Testing event system timer: OK [ 12.208160] Testing event system irq: OK [ 12.248100] Testing event system printk: OK [ 12.288008] Testing event system task: OK [ 12.328121] Testing event system mce: OK [ 12.368132] Testing event system raw_syscalls: OK [ 12.408194] Running tests on all trace events: [ 12.408790] Testing all events: OK [ 12.464068] Running tests again, along with the function tracer [ 12.465111] Running tests on trace events: [ 12.465937] Testing event kfree_skb: [ 12.505589] test-events (236) used greatest stack depth: 6736 bytes left OK [ 12.507877] Testing event consume_skb: OK [ 12.548977] Testing event skb_copy_datagram_iovec: OK [ 12.588981] Testing event net_dev_xmit: OK [ 12.628986] Testing event net_dev_queue: OK [ 12.669012] Testing event netif_receive_skb: OK [ 12.709014] Testing event netif_rx: OK [ 12.749144] Testing event napi_poll: OK [ 12.789080] Testing event sock_rcvqueue_full: OK [ 12.829116] Testing event sock_exceed_buf_limit: OK [ 12.869193] Testing event udp_fail_queue_rcv_skb: OK [ 12.909127] Testing event regmap_reg_write: OK [ 12.949200] Testing event regmap_reg_read: OK [ 12.989237] Testing event regmap_reg_read_cache: OK [ 13.029233] Testing event regmap_hw_read_start: OK [ 13.069421] Testing event regmap_hw_read_done: OK [ 13.109392] Testing event regmap_hw_write_start: OK [ 13.149425] Testing event regmap_hw_write_done: OK [ 13.189435] Testing event regcache_sync: OK [ 13.229474] Testing event regmap_cache_only: OK [ 13.269472] Testing event regmap_cache_bypass: OK [ 13.309541] Testing event mix_pool_bytes: OK [ 13.349553] Testing event mix_pool_bytes_nolock: OK [ 13.389587] Testing event credit_entropy_bits: OK [ 13.431563] Testing event get_random_bytes: OK [ 13.469645] Testing event extract_entropy: OK [ 13.509645] Testing event extract_entropy_user: OK [ 13.549687] Testing event regulator_enable: OK [ 13.589712] Testing event regulator_enable_delay: OK [ 13.629727] Testing event regulator_enable_complete: OK [ 13.669759] Testing event regulator_disable: OK [ 13.709816] Testing event regulator_disable_complete: OK [ 13.749811] Testing event regulator_set_voltage: OK [ 13.789839] Testing event regulator_set_voltage_complete: OK [ 13.829879] Testing event gpio_direction: OK [ 13.869891] Testing event gpio_value: OK [ 13.909928] Testing event block_rq_abort: OK [ 13.949943] Testing event block_rq_requeue: OK [ 13.989978] Testing event block_rq_complete: OK [ 14.030025] Testing event block_rq_insert: OK [ 14.069972] Testing event block_rq_issue: OK [ 14.110006] Testing event block_bio_bounce: OK [ 14.150015] Testing event block_bio_complete: OK [ 14.190006] Testing event block_bio_backmerge: OK [ 14.230095] Testing event block_bio_frontmerge: OK [ 14.270094] Testing event block_bio_queue: OK [ 14.310127] Testing event block_getrq: OK [ 14.350209] Testing event block_sleeprq: OK [ 14.390379] Testing event block_plug: OK [ 14.430281] Testing event block_unplug: OK [ 14.470291] Testing event block_split: OK [ 14.510284] Testing event block_bio_remap: OK [ 14.550315] Testing event block_rq_remap: OK [ 14.590392] Testing event writeback_nothread: OK [ 14.630422] Testing event writeback_queue: OK [ 14.670529] Testing event writeback_exec: OK [ 14.710488] Testing event writeback_start: OK [ 14.750519] Testing event writeback_written: OK [ 14.790554] Testing event writeback_wait: OK [ 14.830572] Testing event writeback_pages_written: OK [ 14.870608] Testing event writeback_nowork: OK [ 14.910628] Testing event writeback_wake_background: OK [ 14.950677] Testing event writeback_wake_thread: OK [ 14.990633] Testing event writeback_wake_forker_thread: OK [ 15.030598] Testing event writeback_bdi_register: OK [ 15.070672] Testing event writeback_bdi_unregister: OK [ 15.110694] Testing event writeback_thread_start: OK [ 15.150743] Testing event writeback_thread_stop: OK [ 15.190756] Testing event wbc_writepage: OK [ 15.230780] Testing event writeback_queue_io: [ 15.269836] test-events (306) used greatest stack depth: 6724 bytes left OK [ 15.272233] Testing event global_dirty_state: OK [ 15.310810] Testing event bdi_dirty_ratelimit: OK [ 15.350834] Testing event balance_dirty_pages: OK [ 15.390865] Testing event writeback_sb_inodes_requeue: OK [ 15.430896] Testing event writeback_congestion_wait: OK [ 15.470908] Testing event writeback_wait_iff_congested: OK [ 15.510988] Testing event writeback_single_inode: OK [ 15.550971] Testing event mm_compaction_isolate_migratepages: OK [ 15.590983] Testing event mm_compaction_isolate_freepages: OK [ 15.630989] Testing event mm_compaction_migratepages: OK [ 15.671094] Testing event kmalloc: OK [ 15.711002] Testing event kmem_cache_alloc: OK [ 15.751027] Testing event kmalloc_node: OK [ 15.791047] Testing event kmem_cache_alloc_node: OK [ 15.831195] Testing event kfree: OK [ 15.871136] Testing event kmem_cache_free: OK [ 15.911179] Testing event mm_page_free: OK [ 15.951136] Testing event mm_page_free_batched: OK [ 15.991216] Testing event mm_page_alloc: OK [ 16.031281] Testing event mm_page_alloc_zone_locked: OK [ 16.071347] Testing event mm_page_pcpu_drain: OK [ 16.111356] Testing event mm_page_alloc_extfrag: OK [ 16.151367] Testing event mm_vmscan_kswapd_sleep: OK [ 16.191396] Testing event mm_vmscan_kswapd_wake: OK [ 16.231369] Testing event mm_vmscan_wakeup_kswapd: OK [ 16.271468] Testing event mm_vmscan_direct_reclaim_begin: OK [ 16.311487] Testing event mm_vmscan_memcg_reclaim_begin: OK [ 16.351516] Testing event mm_vmscan_memcg_softlimit_reclaim_begin: OK [ 16.391553] Testing event mm_vmscan_direct_reclaim_end: OK [ 16.431567] Testing event mm_vmscan_memcg_reclaim_end: OK [ 16.471592] Testing event mm_vmscan_memcg_softlimit_reclaim_end: OK [ 16.511628] Testing event mm_shrink_slab_start: OK [ 16.551640] Testing event mm_shrink_slab_end: OK [ 16.591680] Testing event mm_vmscan_lru_isolate: OK [ 16.631722] Testing event mm_vmscan_memcg_isolate: OK [ 16.671716] Testing event mm_vmscan_writepage: OK [ 16.711759] Testing event mm_vmscan_lru_shrink_inactive: OK [ 16.751776] Testing event oom_score_adj_update: OK [ 16.791795] Testing event rpm_suspend: OK [ 16.831841] Testing event rpm_resume: OK [ 16.871866] Testing event rpm_idle: OK [ 16.911888] Testing event rpm_return_int: OK [ 16.951948] Testing event cpu_idle: OK [ 16.991948] Testing event cpu_frequency: OK [ 17.031933] Testing event machine_suspend: OK [ 17.071983] Testing event wakeup_source_activate: OK [ 17.111958] Testing event wakeup_source_deactivate: OK [ 17.151964] Testing event clock_enable: OK [ 17.191986] Testing event clock_disable: OK [ 17.231973] Testing event clock_set_rate: OK [ 17.272054] Testing event power_domain_target: OK [ 17.312077] Testing event ftrace_test_filter: OK [ 17.352159] Testing event module_load: OK [ 17.392123] Testing event module_free: OK [ 17.432130] Testing event module_get: OK [ 17.472175] Testing event module_put: OK [ 17.512197] Testing event module_request: OK [ 17.552336] Testing event lock_acquire: OK [ 17.592402] Testing event lock_release: OK [ 17.632445] Testing event lock_contended: OK [ 17.672398] Testing event lock_acquired: OK [ 17.712469] Testing event sched_kthread_stop: OK [ 17.752474] Testing event sched_kthread_stop_ret: OK [ 17.792482] Testing event sched_wakeup: OK [ 17.832516] Testing event sched_wakeup_new: OK [ 17.872536] Testing event sched_switch: OK [ 17.912566] Testing event sched_migrate_task: OK [ 17.952581] Testing event sched_process_free: OK [ 17.992607] Testing event sched_process_exit: OK [ 18.032568] Testing event sched_wait_task: OK [ 18.072677] Testing event sched_process_wait: OK [ 18.112696] Testing event sched_process_fork: OK [ 18.152720] Testing event sched_process_exec: OK [ 18.192770] Testing event sched_stat_wait: OK [ 18.232814] Testing event sched_stat_sleep: OK [ 18.272809] Testing event sched_stat_iowait: OK [ 18.312848] Testing event sched_stat_blocked: OK [ 18.352867] Testing event sched_stat_runtime: OK [ 18.392891] Testing event sched_pi_setprio: OK [ 18.432922] Testing event rcu_utilization: OK [ 18.472965] Testing event workqueue_queue_work: OK [ 18.512977] Testing event workqueue_activate_work: OK [ 18.552987] Testing event workqueue_execute_start: OK [ 18.592960] Testing event workqueue_execute_end: OK [ 18.632956] Testing event signal_generate: OK [ 18.672967] Testing event signal_deliver: OK [ 18.713053] Testing event timer_init: OK [ 18.753122] Testing event timer_start: OK [ 18.793237] Testing event timer_expire_entry: OK [ 18.833238] Testing event timer_expire_exit: OK [ 18.873195] Testing event timer_cancel: OK [ 18.913226] Testing event hrtimer_init: OK [ 18.953252] Testing event hrtimer_start: OK [ 18.993342] Testing event hrtimer_expire_entry: OK [ 19.040885] Testing event hrtimer_expire_exit: OK [ 19.083228] Testing event hrtimer_cancel: OK [ 19.123240] Testing event itimer_state: OK [ 19.163271] Testing event itimer_expire: OK [ 19.203297] Testing event irq_handler_entry: OK [ 19.243306] Testing event irq_handler_exit: OK [ 19.283347] Testing event softirq_entry: OK [ 19.323379] Testing event softirq_exit: OK [ 19.363398] Testing event softirq_raise: OK [ 19.403633] Testing event console: OK [ 19.443666] Testing event task_newtask: OK [ 19.483689] Testing event task_rename: OK [ 19.523714] Testing event mce_record: OK [ 19.563756] Testing event sys_enter: OK [ 19.603844] Testing event sys_exit: OK [ 19.643885] Running tests on trace event systems: [ 19.644724] Testing event system skb: OK [ 19.684169] Testing event system net: OK [ 19.724349] Testing event system napi: OK [ 19.763904] Testing event system sock: OK [ 19.804082] Testing event system udp: OK [ 19.843973] Testing event system regmap: OK [ 19.885539] Testing event system random: OK [ 19.924790] Testing event system regulator: OK [ 19.965048] Testing event system gpio: OK [ 20.004175] Testing event system block: OK [ 20.046719] Testing event system writeback: OK [ 20.098175] Testing event system compaction: OK [ 20.134364] Testing event system kmem: OK [ 20.175911] Testing event system vmscan: OK [ 20.224320] Testing event system oom: OK [ 20.264167] Testing event system rpm: OK [ 20.304708] Testing event system power: OK [ 20.345651] Testing event system test: OK [ 20.384250] Testing event system module: OK [ 20.424891] Testing event system lock: OK [ 20.464826] Testing event system sched: OK [ 20.507294] Testing event system rcu: OK [ 20.546378] Testing event system workqueue: OK [ 20.584901] Testing event system signal: OK [ 20.624617] Testing event system timer: OK [ 20.666394] Testing event system irq: OK [ 20.705247] Testing event system printk: OK [ 20.744521] Testing event system task: OK [ 20.784693] Testing event system mce: OK [ 20.824590] Testing event system raw_syscalls: OK [ 20.864843] Running tests on all trace events: [ 20.865727] Testing all events: OK [ 21.043172] Testing ftrace filter: OK [ 21.045198] /c/kernel-tests/src/linux/drivers/rtc/hctosys.c: unable to open rtc device (rtc0) [ 21.047179] Freeing unused kernel memory: 1736k freed [ 21.073242] plymouthd (459) used greatest stack depth: 6652 bytes left [ 21.074143] plymouthd (453) used greatest stack depth: 6644 bytes left [ 21.076021] hwclock (454) used greatest stack depth: 6468 bytes left [ 21.121238] ------------[ cut here ]------------ [ 21.121919] WARNING: at /c/kernel-tests/src/linux/kernel/lockdep.c:2623 trace_hardirqs_off_caller+0x56/0x90() [ 21.123259] Hardware name: Bochs [ 21.123784] Modules linked in: [ 21.124344] Pid: 477, comm: modprobe Not tainted 3.6.0-rc3-00182-gc2865bb #50 [ 21.125262] Call Trace: [ 21.125695] [] warn_slowpath_common+0x87/0xb0 [ 21.126411] [] ? trace_hardirqs_off_caller+0x56/0x90 [ 21.127217] [] ? trace_hardirqs_off_caller+0x56/0x90 [ 21.127984] [] ? error_code+0x5b/0x64 [ 21.128633] [] ? smp_threshold_interrupt+0x10/0x10 [ 21.129421] [] warn_slowpath_null+0x22/0x30 [ 21.130118] [] trace_hardirqs_off_caller+0x56/0x90 [ 21.130870] [] trace_hardirqs_off_thunk+0xc/0x14 [ 21.131627] [] ? error_code+0x5b/0x64 [ 21.132247] [] ? do_trap+0x2b/0xd0 [ 21.132846] [] ? int3+0x4/0x34 [ 21.133503] [] ? smp_threshold_interrupt+0x10/0x10 [ 21.134231] ---[ end trace aae500c76998a1c7 ]--- [ 21.134847] iret exception: 0000 [#1] SMP [ 21.135608] Modules linked in: [ 21.136138] Pid: 477, comm: modprobe Tainted: G W 3.6.0-rc3-00182-gc2865bb #50 Bochs Bochs [ 21.137396] EIP: 0000:[] EFLAGS: 00000000 CPU: 0 [ 21.138098] EIP is at 0xb77cb1d0 [ 21.138588] EAX: 00000000 EBX: 00000000 ECX: 00000000 EDX: 00000000 [ 21.139439] ESI: 00000000 EDI: 00000000 EBP: 00000000 ESP: cf83dff0 [ 21.140211] DS: 007b ES: 007b FS: 0000 GS: 0000 SS: 0068 [ 21.140900] CR0: 8005003b CR2: bfd3e59b CR3: 0f88d000 CR4: 000006d0 [ 21.141772] DR0: 00000000 DR1: 00000000 DR2: 00000000 DR3: 00000000 [ 21.142545] DR6: ffff0ff0 DR7: 00000400 [ 21.143166] Process modprobe (pid: 477, ti=cf83c000 task=cf8764f0 task.ti=cf83c000) [ 21.143498] Stack: [ 21.143498] 00000000 00000000 00000000 00000000 [ 21.143498] Call Trace: [ 21.143498] Code: Bad EIP value. [ 21.143498] EIP: [] 0xb77cb1d0 SS:ESP 0068:cf83dff0 [ 21.147466] ---[ end trace aae500c76998a1c8 ]--- [ 21.270231] mountall (466) used greatest stack depth: 6308 bytes left