[ 0.000000] Initializing cgroup subsys cpuset [ 0.000000] Initializing cgroup subsys cpu [ 0.000000] Linux version 3.6.0-rc1-00022-gd3c6632 (kbuild@bee) (gcc version 4.7.1 (Debian 4.7.1-6) ) #7512 SMP Sat Sep 22 04:42:50 CST 2012 [ 0.000000] Command line: trinity=5m hung_task_panic=1 rcutree.rcu_cpu_stall_timeout=100 branch=pci/pci/taku-acpi-pci-host-bridge-v3 log_buf_len=8M ignore_loglevel debug sched_debug apic=debug dynamic_printk sysrq_always_enabled panic=10 load_ramdisk=2 prompt_ramdisk=0 console=ttyS0,115200 console=tty0 vga=normal ip=::::kvm::dhcp nfsroot=10.239.97.14:/nfsroot/wfg,tcp,v3,nocto,actimeo=600,nolock,rsize=524288,wsize=524288 rw link=vmlinuz-2012-09-22-04-43-21-pci:pci:taku-acpi-pci-host-bridge-v3:e3faec8-d3c6632-x86_64-allyesdebian-1-inn BOOT_IMAGE=kernel-tests/kernels/x86_64-allyesdebian/d3c6632/vmlinuz-3.6.0-rc1-00022-gd3c6632 [ 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-0x000000001fffdfff] usable [ 0.000000] BIOS-e820: [mem 0x000000001fffe000-0x000000001fffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved [ 0.000000] debug: ignoring loglevel setting. [ 0.000000] NX (Execute Disable) protection: active [ 0.000000] DMI 2.4 present. [ 0.000000] DMI: Bochs Bochs, BIOS Bochs 01/01/2007 [ 0.000000] Hypervisor detected: KVM [ 0.000000] e820: update [mem 0x00000000-0x0000ffff] usable ==> reserved [ 0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable [ 0.000000] No AGP bridge found [ 0.000000] e820: last_pfn = 0x1fffe max_arch_pfn = 0x400000000 [ 0.000000] MTRR default type: write-back [ 0.000000] MTRR fixed ranges enabled: [ 0.000000] 00000-9FFFF write-back [ 0.000000] A0000-BFFFF uncachable [ 0.000000] C0000-FFFFF write-protect [ 0.000000] MTRR variable ranges enabled: [ 0.000000] 0 base 00E0000000 mask FFE0000000 uncachable [ 0.000000] 1 disabled [ 0.000000] 2 disabled [ 0.000000] 3 disabled [ 0.000000] 4 disabled [ 0.000000] 5 disabled [ 0.000000] 6 disabled [ 0.000000] 7 disabled [ 0.000000] x86 PAT enabled: cpu 0, old 0x70406, new 0x7010600070106 [ 0.000000] Scan for SMP in [mem 0x00000000-0x000003ff] [ 0.000000] Scan for SMP in [mem 0x0009fc00-0x0009ffff] [ 0.000000] Scan for SMP in [mem 0x000f0000-0x000fffff] [ 0.000000] found SMP MP-table at [mem 0x000fdac0-0x000fdacf] mapped at [ffff8800000fdac0] [ 0.000000] mpc: fdad0-fdbec [ 0.000000] initial memory mapped: [mem 0x00000000-0x1fffffff] [ 0.000000] Base memory trampoline at [ffff88000008d000] 8d000 size 24576 [ 0.000000] init_memory_mapping: [mem 0x00000000-0x1fffdfff] [ 0.000000] [mem 0x00000000-0x1fffdfff] page 4k [ 0.000000] kernel direct mapping tables up to 0x1fffdfff @ [mem 0x1fefc000-0x1fffdfff] [ 0.000000] log_buf_len: 8388608 [ 0.000000] early log buf free: 127832(97%) [ 0.000000] ACPI: RSDP 00000000000fd930 00014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 000000001fffe550 00038 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 000000001fffff80 00074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 000000001fffe590 01121 (v01 BXPC BXDSDT 00000001 INTL 20100528) [ 0.000000] ACPI: FACS 000000001fffff40 00040 [ 0.000000] ACPI: SSDT 000000001ffffe40 000FF (v01 BOCHS BXPCSSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: APIC 000000001ffffd50 00080 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 000000001ffffd10 00038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001) [ 0.000000] ACPI: SSDT 000000001ffff6c0 00644 (v01 BXPC BXSSDTPC 00000001 INTL 20100528) [ 0.000000] ACPI: Local APIC address 0xfee00000 [ 0.000000] mapped APIC to ffffffffff5fb000 ( fee00000) [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x000000001fffdfff] [ 0.000000] Initmem setup node 0 [mem 0x00000000-0x1fffdfff] [ 0.000000] NODE_DATA [mem 0x1f6f7000-0x1f6fbfff] [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000000] kvm-clock: cpu 0, msr 0:389a141, boot clock [ 0.000000] [ffffea0000000000-ffffea00007fffff] PMD -> [ffff88001e600000-ffff88001edfffff] on node 0 [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x00010000-0x00ffffff] [ 0.000000] DMA32 [mem 0x01000000-0xffffffff] [ 0.000000] Normal empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x00010000-0x00092fff] [ 0.000000] node 0: [mem 0x00100000-0x1fffdfff] [ 0.000000] On node 0 totalpages: 130945 [ 0.000000] DMA zone: 64 pages used for memmap [ 0.000000] DMA zone: 6 pages reserved [ 0.000000] DMA zone: 3901 pages, LIFO batch:0 [ 0.000000] DMA32 zone: 1984 pages used for memmap [ 0.000000] DMA32 zone: 124990 pages, LIFO batch:31 [ 0.000000] ACPI: PM-Timer IO Port: 0xb008 [ 0.000000] ACPI: Local APIC address 0xfee00000 [ 0.000000] mapped APIC to ffffffffff5fb000 ( fee00000) [ 0.000000] ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled) [ 0.000000] ACPI: LAPIC (acpi_id[0x01] lapic_id[0x01] enabled) [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] ACPI: IOAPIC (id[0x02] address[0xfec00000] gsi_base[0]) [ 0.000000] IOAPIC[0]: apic_id 2, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 00, APIC ID 2, APIC INT 02 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 05, APIC ID 2, APIC INT 05 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 09, APIC ID 2, APIC INT 09 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 0a, APIC ID 2, APIC INT 0a [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 0b, APIC ID 2, APIC INT 0b [ 0.000000] ACPI: IRQ0 used by override. [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 01, APIC ID 2, APIC INT 01 [ 0.000000] ACPI: IRQ2 used by override. [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 03, APIC ID 2, APIC INT 03 [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 04, APIC ID 2, APIC INT 04 [ 0.000000] ACPI: IRQ5 used by override. [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 06, APIC ID 2, APIC INT 06 [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 07, APIC ID 2, APIC INT 07 [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 08, APIC ID 2, APIC INT 08 [ 0.000000] ACPI: IRQ9 used by override. [ 0.000000] ACPI: IRQ10 used by override. [ 0.000000] ACPI: IRQ11 used by override. [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0c, APIC ID 2, APIC INT 0c [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0d, APIC ID 2, APIC INT 0d [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0e, APIC ID 2, APIC INT 0e [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0f, APIC ID 2, APIC INT 0f [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] smpboot: Allowing 2 CPUs, 0 hotplug CPUs [ 0.000000] mapped IOAPIC to ffffffffff5fa000 (fec00000) [ 0.000000] nr_irqs_gsi: 40 [ 0.000000] PM: Registered nosave memory: 0000000000093000 - 0000000000094000 [ 0.000000] PM: Registered nosave memory: 0000000000094000 - 00000000000a0000 [ 0.000000] PM: Registered nosave memory: 00000000000a0000 - 00000000000f0000 [ 0.000000] PM: Registered nosave memory: 00000000000f0000 - 0000000000100000 [ 0.000000] e820: [mem 0x20000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] setup_percpu: NR_CPUS:512 nr_cpumask_bits:512 nr_cpu_ids:2 nr_node_ids:1 [ 0.000000] PERCPU: Embedded 478 pages/cpu @ffff88001f200000 s1925912 r8192 d23784 u2097152 [ 0.000000] pcpu-alloc: s1925912 r8192 d23784 u2097152 alloc=1*2097152 [ 0.000000] pcpu-alloc: [0] 0 [0] 1 [ 0.000000] kvm-clock: cpu 0, msr 0:1f3d5141, primary cpu clock [ 0.000000] KVM setup async PF for cpu 0 [ 0.000000] kvm-stealtime: cpu 0, msr 1f20e200 [ 0.000000] Built 1 zonelists in Node order, mobility grouping on. Total pages: 128891 [ 0.000000] Policy zone: DMA32 [ 0.000000] Kernel command line: trinity=5m hung_task_panic=1 rcutree.rcu_cpu_stall_timeout=100 branch=pci/pci/taku-acpi-pci-host-bridge-v3 log_buf_len=8M ignore_loglevel debug sched_debug apic=debug dynamic_printk sysrq_always_enabled panic=10 load_ramdisk=2 prompt_ramdisk=0 console=ttyS0,115200 console=tty0 vga=normal ip=::::kvm::dhcp nfsroot=10.239.97.14:/nfsroot/wfg,tcp,v3,nocto,actimeo=600,nolock,rsize=524288,wsize=524288 rw link=vmlinuz-2012-09-22-04-43-21-pci:pci:taku-acpi-pci-host-bridge-v3:e3faec8-d3c6632-x86_64-allyesdebian-1-inn BOOT_IMAGE=kernel-tests/kernels/x86_64-allyesdebian/d3c6632/vmlinuz-3.6.0-rc1-00022-gd3c6632 [ 0.000000] sysrq: sysrq always enabled. [ 0.000000] PID hash table entries: 2048 (order: 2, 16384 bytes) [ 0.000000] __ex_table already sorted, skipping sort [ 0.000000] Checking aperture... [ 0.000000] No AGP bridge found [ 0.000000] Calgary: detecting Calgary via BIOS EBDA area [ 0.000000] Calgary: Unable to locate Rio Grande table in EBDA - bailing! [ 0.000000] Memory: 445560k/524280k available (23661k kernel code, 500k absent, 78220k reserved, 16033k data, 3612k init) [ 0.000000] Hierarchical RCU implementation. [ 0.000000] [ 0.000000] [ 0.000000] [ 0.000000] NR_IRQS:33024 nr_irqs:512 16 [ 0.000000] Console: colour VGA+ 80x25 [ 0.000000] console [tty0] enabled [ 0.000000] console [ttyS0] enabled [ 0.000000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar [ 0.000000] ... MAX_LOCKDEP_SUBCLASSES: 8 [ 0.000000] ... MAX_LOCK_DEPTH: 48 [ 0.000000] ... MAX_LOCKDEP_KEYS: 8191 [ 0.000000] ... CLASSHASH_SIZE: 4096 [ 0.000000] ... MAX_LOCKDEP_ENTRIES: 16384 [ 0.000000] ... MAX_LOCKDEP_CHAINS: 32768 [ 0.000000] ... CHAINHASH_SIZE: 16384 [ 0.000000] memory used by lock dependency info: 6367 kB [ 0.000000] per task-struct memory footprint: 2688 bytes [ 0.000000] ------------------------ [ 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: 0 of 0 active objects replaced [ 0.000000] hpet clockevent registered [ 0.000000] tsc: Detected 2693.550 MHz processor [ 0.008000] Calibrating delay loop (skipped) preset value.. 5387.10 BogoMIPS (lpj=10774200) [ 0.008000] pid_max: default: 32768 minimum: 301 [ 0.008000] Security Framework initialized [ 0.012358] Dentry cache hash table entries: 65536 (order: 7, 524288 bytes) [ 0.014847] Inode-cache hash table entries: 32768 (order: 6, 262144 bytes) [ 0.016402] Mount-cache hash table entries: 256 [ 0.021641] Initializing cgroup subsys devices [ 0.022860] Initializing cgroup subsys freezer [ 0.024018] Initializing cgroup subsys net_cls [ 0.025275] Initializing cgroup subsys blkio [ 0.026924] mce: CPU supports 10 MCE banks [ 0.028089] numa_add_cpu cpu 0 node 0: mask now 0 [ 0.029354] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.029354] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.029354] tlb_flushall_shift is 0x6 [ 0.034089] ACPI: Core revision 20120711 [ 0.041622] ftrace: allocating 90076 entries in 352 pages [ 0.068436] Getting VERSION: 50014 [ 0.069407] Getting VERSION: 50014 [ 0.072021] Getting ID: 0 [ 0.072826] Getting ID: ff000000 [ 0.073758] Getting LVT0: 8700 [ 0.074641] Getting LVT1: 8400 [ 0.075581] enabled ExtINT on CPU#0 [ 0.077208] ENABLING IO-APIC IRQs [ 0.078141] init IO_APIC IRQs [ 0.079004] apic 2 pin 0 not connected [ 0.080050] IOAPIC[0]: Set routing entry (2-1 -> 0x41 -> IRQ 1 Mode:0 Active:0 Dest:1) [ 0.082125] IOAPIC[0]: Set routing entry (2-2 -> 0x51 -> IRQ 0 Mode:0 Active:0 Dest:1) [ 0.084046] IOAPIC[0]: Set routing entry (2-3 -> 0x61 -> IRQ 3 Mode:0 Active:0 Dest:1) [ 0.086194] IOAPIC[0]: Set routing entry (2-4 -> 0x71 -> IRQ 4 Mode:0 Active:0 Dest:1) [ 0.088077] IOAPIC[0]: Set routing entry (2-5 -> 0x81 -> IRQ 5 Mode:1 Active:0 Dest:1) [ 0.090149] IOAPIC[0]: Set routing entry (2-6 -> 0x91 -> IRQ 6 Mode:0 Active:0 Dest:1) [ 0.092042] IOAPIC[0]: Set routing entry (2-7 -> 0xa1 -> IRQ 7 Mode:0 Active:0 Dest:1) [ 0.093995] IOAPIC[0]: Set routing entry (2-8 -> 0xb1 -> IRQ 8 Mode:0 Active:0 Dest:1) [ 0.096042] IOAPIC[0]: Set routing entry (2-9 -> 0xc1 -> IRQ 9 Mode:1 Active:0 Dest:1) [ 0.098006] IOAPIC[0]: Set routing entry (2-10 -> 0xd1 -> IRQ 10 Mode:1 Active:0 Dest:1) [ 0.100041] IOAPIC[0]: Set routing entry (2-11 -> 0xe1 -> IRQ 11 Mode:1 Active:0 Dest:1) [ 0.102120] IOAPIC[0]: Set routing entry (2-12 -> 0x22 -> IRQ 12 Mode:0 Active:0 Dest:1) [ 0.104043] IOAPIC[0]: Set routing entry (2-13 -> 0x42 -> IRQ 13 Mode:0 Active:0 Dest:1) [ 0.108038] IOAPIC[0]: Set routing entry (2-14 -> 0x52 -> IRQ 14 Mode:0 Active:0 Dest:1) [ 0.110176] IOAPIC[0]: Set routing entry (2-15 -> 0x62 -> IRQ 15 Mode:0 Active:0 Dest:1) [ 0.112037] apic 2 pin 16 not connected [ 0.116023] apic 2 pin 17 not connected [ 0.117125] apic 2 pin 18 not connected [ 0.118209] apic 2 pin 19 not connected [ 0.120016] apic 2 pin 20 not connected [ 0.121122] apic 2 pin 21 not connected [ 0.122193] apic 2 pin 22 not connected [ 0.124016] apic 2 pin 23 not connected [ 0.125276] ..TIMER: vector=0x51 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.127186] smpboot: CPU0: Intel Common KVM processor stepping 01 [ 0.129484] Using local APIC timer interrupts. [ 0.129484] calibrating APIC timer ... [ 0.136008] ... lapic delta = 6250083 [ 0.136008] ... PM-Timer delta = 357961 [ 0.136008] ... PM-Timer result ok [ 0.136008] ..... delta 6250083 [ 0.136008] ..... mult: 268422244 [ 0.136008] ..... calibration result: 4000053 [ 0.136008] ..... CPU clock speed is 2693.2232 MHz. [ 0.136008] ..... host bus clock speed is 1000.0053 MHz. [ 0.136094] Performance Events: unsupported Netburst CPU model 6 no PMU driver, software events only. [ 0.141211] Testing tracer nop: PASSED [ 0.145258] SMP alternatives: lockdep: fixing up alternatives [ 0.147105] smpboot: Booting Node 0, Processors #1 OK [ 0.008000] kvm-clock: cpu 1, msr 0:1f5d5141, secondary cpu clock [ 0.008000] masked ExtINT on CPU#1 [ 0.008000] numa_add_cpu cpu 1 node 0: mask now 0-1 [ 0.172343] Brought up 2 CPUs [ 0.173035] smpboot: Total of 2 processors activated (10774.20 BogoMIPS) [ 0.176106] KVM setup async PF for cpu 1 [ 0.177063] kvm-stealtime: cpu 1, msr 1f40e200 [ 0.178861] CPU0 attaching sched-domain: [ 0.180072] domain 0: span 0-1 level CPU [ 0.181287] groups: 0 1 [ 0.182475] CPU1 attaching sched-domain: [ 0.184019] domain 0: span 0-1 level CPU [ 0.185116] groups: 1 0 [ 0.188731] devtmpfs: initialized [ 0.209081] xor: automatically using best checksumming function: [ 0.248035] generic_sse: 168.000 MB/sec [ 0.249054] atomic64 test passed for x86-64 platform with CX8 and with SSE [ 0.251564] dummy: [ 0.253003] NET: Registered protocol family 16 [ 0.259808] ACPI: bus type pci registered [ 0.260346] dca service started, version 1.12.1 [ 0.261731] PCI: Using configuration type 1 for base access [ 0.368041] bio: create slab at 0 [ 0.436049] raid6: sse2x1 5210 MB/s [ 0.504051] raid6: sse2x2 6732 MB/s [ 0.572046] raid6: sse2x4 7884 MB/s [ 0.573112] raid6: using algorithm sse2x4 (7884 MB/s) [ 0.574419] raid6: using intx1 recovery algorithm [ 0.575990] ACPI: Added _OSI(Module Device) [ 0.576047] ACPI: Added _OSI(Processor Device) [ 0.577289] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.578516] ACPI: Added _OSI(Processor Aggregator Device) [ 0.584419] ACPI: EC: Look up EC in DSDT [ 0.597293] ACPI: Interpreter enabled [ 0.598181] ACPI: (supports S0 S3 S4 S5) [ 0.599531] ACPI: Using IOAPIC for interrupt routing [ 0.622677] ACPI: No dock devices found. [ 0.623787] PCI: Ignoring host bridge windows from ACPI; if necessary, use "pci=use_crs" and report a bug [ 0.624206] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.625723] pci_root PNP0A03:00: host bridge window [io 0x0000-0x0cf7] (ignored) [ 0.628048] pci_root PNP0A03:00: host bridge window [io 0x0d00-0xffff] (ignored) [ 0.629831] pci_root PNP0A03:00: host bridge window [mem 0x000a0000-0x000bffff] (ignored) [ 0.632047] pci_root PNP0A03:00: host bridge window [mem 0xe0000000-0xfebfffff] (ignored) [ 0.633890] PCI: root bus 00: using default resources [ 0.636089] pci_root PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.639219] PCI host bridge to bus 0000:00 [ 0.640062] pci_bus 0000:00: busn_res: [bus 00-ff] is inserted under domain [bus 00-ff] [ 0.642177] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.644052] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] [ 0.645558] pci_bus 0000:00: root bus resource [mem 0x00000000-0xffffffffff] [ 0.647401] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.648623] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.650817] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.654220] pci 0000:00:01.1: reg 20: [io 0xc1c0-0xc1cf] [ 0.657263] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.659110] pci 0000:00:01.3: quirk: [io 0xb000-0xb03f] claimed by PIIX4 ACPI [ 0.660063] pci 0000:00:01.3: quirk: [io 0xb100-0xb10f] claimed by PIIX4 SMB [ 0.661747] pci 0000:00:02.0: [1013:00b8] type 00 class 0x030000 [ 0.668210] pci 0000:00:02.0: reg 10: [mem 0xfc000000-0xfdffffff pref] [ 0.672252] pci 0000:00:02.0: reg 14: [mem 0xfebf0000-0xfebf0fff] [ 0.680821] pci 0000:00:02.0: reg 30: [mem 0xfebe0000-0xfebeffff pref] [ 0.683122] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000 [ 0.684507] pci 0000:00:03.0: reg 10: [mem 0xfeba0000-0xfebbffff] [ 0.686675] pci 0000:00:03.0: reg 14: [io 0xc000-0xc03f] [ 0.692474] pci 0000:00:03.0: reg 30: [mem 0xfebc0000-0xfebdffff pref] [ 0.694707] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 [ 0.696565] pci 0000:00:04.0: reg 10: [io 0xc040-0xc07f] [ 0.698704] pci 0000:00:04.0: reg 14: [mem 0xfebf1000-0xfebf1fff] [ 0.704879] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.706770] pci 0000:00:05.0: reg 10: [io 0xc080-0xc0bf] [ 0.708871] pci 0000:00:05.0: reg 14: [mem 0xfebf2000-0xfebf2fff] [ 0.715427] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.716564] pci 0000:00:06.0: reg 10: [io 0xc0c0-0xc0ff] [ 0.718736] pci 0000:00:06.0: reg 14: [mem 0xfebf3000-0xfebf3fff] [ 0.726217] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 [ 0.728098] pci 0000:00:07.0: reg 10: [io 0xc100-0xc13f] [ 0.730070] pci 0000:00:07.0: reg 14: [mem 0xfebf4000-0xfebf4fff] [ 0.736269] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 [ 0.738280] pci 0000:00:08.0: reg 10: [io 0xc140-0xc17f] [ 0.740109] pci 0000:00:08.0: reg 14: [mem 0xfebf5000-0xfebf5fff] [ 0.746575] pci 0000:00:09.0: [1af4:1001] type 00 class 0x010000 [ 0.748534] pci 0000:00:09.0: reg 10: [io 0xc180-0xc1bf] [ 0.750499] pci 0000:00:09.0: reg 14: [mem 0xfebf6000-0xfebf6fff] [ 0.756452] pci 0000:00:0a.0: [8086:25ab] type 00 class 0x088000 [ 0.758095] pci 0000:00:0a.0: reg 10: [mem 0xfebf7000-0xfebf700f] [ 0.763006] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT] [ 0.767536] pci0000:00: Unable to request _OSC control (_OSC support mask: 0x1e) [ 0.803314] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11) [ 0.805217] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11) [ 0.807236] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11) [ 0.809316] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11) [ 0.811808] ACPI: PCI Interrupt Link [LNKS] (IRQs 9) *0 [ 0.814956] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none [ 0.816115] vgaarb: loaded [ 0.816830] vgaarb: bridge control possible 0000:00:02.0 [ 0.824311] tps65010: version 2 May 2005 [ 0.856192] tps65010: no chip? [ 0.858758] SCSI subsystem initialized [ 0.859845] ACPI: bus type scsi registered [ 0.864315] libata version 3.00 loaded. [ 0.866158] pps_core: LinuxPPS API ver. 1 registered [ 0.868061] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.872693] wmi: Mapper loaded [ 0.874176] Advanced Linux Sound Architecture Driver Version 1.0.25. [ 0.876169] PCI: Using ACPI for IRQ routing [ 0.877381] PCI: pci_cache_line_size set to 64 bytes [ 0.880629] e820: reserve RAM buffer [mem 0x00093c00-0x0009ffff] [ 0.884073] e820: reserve RAM buffer [mem 0x1fffe000-0x1fffffff] [ 0.889214] Sangoma WANPIPE Router v1.1 (c) 1995-2000 Sangoma Technologies Inc. [ 0.892357] NET: Registered protocol family 23 [ 0.896423] Bluetooth: Core ver 2.16 [ 0.897664] NET: Registered protocol family 31 [ 0.898861] Bluetooth: HCI device and connection manager initialized [ 0.900091] Bluetooth: HCI socket layer initialized [ 0.904074] Bluetooth: L2CAP socket layer initialized [ 0.905509] Bluetooth: SCO socket layer initialized [ 0.908075] NET: Registered protocol family 8 [ 0.909263] NET: Registered protocol family 20 [ 0.912679] cfg80211: Calling CRDA to update world regulatory domain [ 0.922184] HPET: 3 timers in total, 0 timers will be used for per-cpu timer [ 0.924011] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.924959] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.936351] Switching to clocksource kvm-clock [ 1.412443] FS-Cache: Loaded [ 1.413614] CacheFiles: Loaded [ 1.414575] pnp: PnP ACPI init [ 1.415509] ACPI: bus type pnp registered [ 1.416618] pnp 00:00: [bus 00-ff] [ 1.417586] pnp 00:00: [io 0x0cf8-0x0cff] [ 1.418594] pnp 00:00: [io 0x0000-0x0cf7 window] [ 1.419625] pnp 00:00: [io 0x0d00-0xffff window] [ 1.420677] pnp 00:00: [mem 0x000a0000-0x000bffff window] [ 1.421829] pnp 00:00: [mem 0xe0000000-0xfebfffff window] [ 1.423432] pnp 00:00: Plug and Play ACPI device, IDs PNP0a03 (active) [ 1.424894] pnp 00:01: [io 0x0070-0x0071] [ 1.425903] pnp 00:01: [irq 8] [ 1.426711] pnp 00:01: [io 0x0072-0x0077] [ 1.427866] pnp 00:01: Plug and Play ACPI device, IDs PNP0b00 (active) [ 1.429475] pnp 00:02: [io 0x0060] [ 1.430400] pnp 00:02: [io 0x0064] [ 1.431361] pnp 00:02: [irq 1] [ 1.432386] pnp 00:02: Plug and Play ACPI device, IDs PNP0303 (active) [ 1.434016] pnp 00:03: [irq 12] [ 1.435056] pnp 00:03: Plug and Play ACPI device, IDs PNP0f13 (active) [ 1.436613] pnp 00:04: [io 0x03f2-0x03f5] [ 1.437552] pnp 00:04: [io 0x03f7] [ 1.438421] pnp 00:04: [irq 6] [ 1.450059] pnp 00:04: [dma 2] [ 1.451107] pnp 00:04: Plug and Play ACPI device, IDs PNP0700 (active) [ 1.452772] pnp 00:05: [io 0x0378-0x037f] [ 1.453789] pnp 00:05: [irq 7] [ 1.454829] pnp 00:05: Plug and Play ACPI device, IDs PNP0400 (active) [ 1.456445] pnp 00:06: [io 0x03f8-0x03ff] [ 1.457431] pnp 00:06: [irq 4] [ 1.458400] pnp 00:06: Plug and Play ACPI device, IDs PNP0501 (active) [ 1.460409] pnp 00:07: [mem 0xfed00000-0xfed003ff] [ 1.461669] pnp 00:07: Plug and Play ACPI device, IDs PNP0103 (active) [ 1.463781] pnp: PnP ACPI: found 8 devices [ 1.464887] ACPI: ACPI bus type pnp unregistered [ 1.492354] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] [ 1.493547] pci_bus 0000:00: resource 5 [mem 0x00000000-0xffffffffff] [ 1.495746] NET: Registered protocol family 2 [ 1.499220] TCP established hash table entries: 16384 (order: 6, 262144 bytes) [ 1.501987] TCP bind hash table entries: 16384 (order: 8, 1310720 bytes) [ 1.506457] TCP: Hash tables configured (established 16384 bind 16384) [ 1.507901] TCP: reno registered [ 1.508772] UDP hash table entries: 256 (order: 3, 49152 bytes) [ 1.510106] UDP-Lite hash table entries: 256 (order: 3, 49152 bytes) [ 1.512694] NET: Registered protocol family 1 [ 1.527975] RPC: Registered named UNIX socket transport module. [ 1.529470] RPC: Registered udp transport module. [ 1.530555] RPC: Registered tcp transport module. [ 1.531585] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 1.532921] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 1.534161] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 1.535574] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 1.536911] pci 0000:00:02.0: Boot video device [ 1.538054] PCI: CLS 0 bytes, default 64 [ 1.602278] DMA-API: preallocated 32768 debug entries [ 1.603392] DMA-API: debugging enabled by kernel config [ 1.649454] kvm: no hardware support [ 1.650422] has_svm: not amd [ 1.651188] kvm: no hardware support [ 1.652769] Machine check injector initialized [ 1.655868] microcode: CPU0 sig=0xf61, pf=0x1, revision=0x1 [ 1.657223] microcode: CPU1 sig=0xf61, pf=0x1, revision=0x1 [ 1.658841] microcode: Microcode Update Driver: v2.00 , Peter Oruba [ 1.674801] cryptomgr_test (29) used greatest stack depth: 6504 bytes left [ 1.705605] Initializing RT-Tester: OK [ 1.706926] audit: initializing netlink socket (disabled) [ 1.708229] type=2000 audit(1348260269.704:1): initialized [ 1.772170] Kprobe smoke test started [ 1.827769] Kprobe smoke test passed successfully [ 1.872734] Testing tracer function: PASSED [ 2.329979] Testing dynamic ftrace: [ 2.658169] tsc: Refined TSC clocksource calibration: 2693.500 MHz PASSED [ 3.004641] Testing dynamic ftrace ops #1: (1 0 1 1 0) (1 1 2 1 0) (2 1 3 1 4) (2 2 4 1 184) PASSED [ 3.883605] Testing dynamic ftrace ops #2: (1 0 1 4 0) (1 1 2 170 0) (2 1 3 1 5) (2 2 4 181 185) PASSED [ 4.768534] Testing tracer irqsoff: PASSED [ 5.460119] Testing tracer wakeup: [ 6.484179] ftrace-test (41) used greatest stack depth: 6360 bytes left PASSED [ 6.544156] Testing tracer wakeup_rt: PASSED [ 7.572301] Testing tracer function_graph: PASSED [ 8.370323] HugeTLB registered 2 MB page size, pre-allocated 0 pages [ 8.373704] VFS: Disk quotas dquot_6.5.2 [ 8.374934] Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 8.378971] DLM installed [ 8.382336] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ 8.401137] FS-Cache: Netfs 'nfs' registered for caching [ 8.403763] NFS: Registering the id_resolver key type [ 8.405003] Key type id_resolver registered [ 8.405940] Key type id_legacy registered [ 8.406936] Installing knfsd (copyright (C) 1996 okir@monad.swb.de). [ 8.452683] Key type cifs.spnego registered [ 8.453892] NTFS driver 2.1.30 [Flags: R/W]. [ 8.455586] EFS: 1.0a - http://aeschi.ch.eu.org/efs/ [ 8.456888] jffs2: version 2.2. (NAND) (SUMMARY) [ 8.460175] ROMFS MTD (C) 2007 Red Hat, Inc. [ 8.461449] QNX4 filesystem 0.2.3 registered. [ 8.462963] fuse init (API version 7.19) [ 8.465216] JFS: nTxBlock = 3480, nTxLock = 27847 [ 8.485201] SGI XFS with ACLs, security attributes, realtime, large block/inode numbers, no debug enabled [ 8.489921] 9p: Installing v9fs 9p2000 file system support [ 8.491151] FS-Cache: Netfs '9p' registered for caching [ 8.492658] NILFS version 2 loaded [ 8.493476] BeFS version: 0.9.3 [ 8.494350] OCFS2 1.5.0 [ 8.508677] ocfs2: Registered cluster interface o2cb [ 8.510300] ocfs2: Registered cluster interface user [ 8.511681] OCFS2 DLMFS 1.5.0 [ 8.512887] OCFS2 User DLM kernel interface loaded [ 8.513919] OCFS2 Node Manager 1.5.0 [ 8.515670] OCFS2 DLM 1.5.0 [ 8.517997] Btrfs loaded [ 8.525790] GFS2 installed [ 8.527107] ceph: loaded (mds proto 32) [ 8.528176] msgmni has been set to 870 [ 8.577208] async_tx: api initialized (async) [ 8.578529] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) [ 8.582621] io scheduler noop registered [ 8.583526] io scheduler deadline registered [ 8.590444] io scheduler cfq registered (default) [ 8.591490] start plist test [ 8.593723] end plist test [ 8.600761] pci_hotplug: PCI Hot Plug PCI Core version: 0.5 [ 8.602066] pciehp: PCI Express Hot Plug Controller Driver version: 0.4 [ 8.603394] cpcihp_zt5550: ZT5550 CompactPCI Hot Plug Driver version: 0.2 [ 8.604918] cpcihp_generic: Generic port I/O CompactPCI Hot Plug Driver version: 0.1 [ 8.606656] cpcihp_generic: not configured, disabling. [ 8.607880] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 8.609252] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 8.610859] [ 8.611385] ============================================= [ 8.612505] [ INFO: possible recursive locking detected ] [ 8.613239] 3.6.0-rc1-00022-gd3c6632 #7512 Not tainted [ 8.613239] --------------------------------------------- [ 8.613239] swapper/0/1 is trying to acquire lock: [ 8.613239] (acpi_pci_root_lock){+.+.+.}, at: [] acpi_get_pci_rootbridge_handle+0x22/0x63 [ 8.613239] [ 8.613239] but task is already holding lock: [ 8.613239] (acpi_pci_root_lock){+.+.+.}, at: [] acpi_pci_register_driver+0x21/0x79 [ 8.613239] [ 8.613239] other info that might help us debug this: [ 8.613239] Possible unsafe locking scenario: [ 8.613239] [ 8.613239] CPU0 [ 8.613239] ---- [ 8.613239] lock(acpi_pci_root_lock); [ 8.613239] lock(acpi_pci_root_lock); [ 8.613239] [ 8.613239] *** DEADLOCK *** [ 8.613239] [ 8.613239] May be due to missing lock nesting notation [ 8.613239] [ 8.613239] 1 lock held by swapper/0/1: [ 8.613239] #0: (acpi_pci_root_lock){+.+.+.}, at: [] acpi_pci_register_driver+0x21/0x79 [ 8.613239] [ 8.613239] stack backtrace: [ 8.613239] Pid: 1, comm: swapper/0 Not tainted 3.6.0-rc1-00022-gd3c6632 #7512 [ 8.613239] Call Trace: [ 8.613239] [] __lock_acquire+0xbef/0xd04 [ 8.613239] [] ? kvm_clock_read+0x2e/0x36 [ 8.613239] [] lock_acquire+0xd5/0x119 [ 8.613239] [] ? acpi_get_pci_rootbridge_handle+0x22/0x63 [ 8.613239] [] ? acpi_get_pci_rootbridge_handle+0x22/0x63 [ 8.613239] [] __mutex_lock_common+0x58/0x387 [ 8.613239] [] ? acpi_get_pci_rootbridge_handle+0x22/0x63 [ 8.613239] [] ? kvm_clock_read+0x2e/0x36 [ 8.613239] [] ? irq_trace+0x14/0x21 [ 8.613239] [] mutex_lock_nested+0x40/0x45 [ 8.613239] [] acpi_get_pci_rootbridge_handle+0x22/0x63 [ 8.613239] [] acpi_pci_get_bridge_handle+0x2c/0x2e [ 8.613239] [] acpi_pci_check_ejectable+0x18/0x49 [ 8.613239] [] ? _raw_spin_unlock_irqrestore+0x45/0x61 [ 8.613239] [] register_slot+0x2f/0x460 [ 8.613239] [] ? up+0x39/0x3e [ 8.613239] [] acpi_ns_walk_namespace+0xbe/0x179 [ 8.613239] [] ? acpi_os_wait_semaphore+0x45/0x5a [ 8.613239] [] ? kzalloc.constprop.14+0x10/0x10 [ 8.613239] [] ? kzalloc.constprop.14+0x10/0x10 [ 8.613239] [] acpi_walk_namespace+0x98/0xcb [ 8.613239] [] init_bridge_misc+0x4c/0xd5 [ 8.613239] [] add_bridge+0xe9/0x138 [ 8.613239] [] acpi_pci_register_driver+0x52/0x79 [ 8.613239] [] ? shpcd_init+0xf0/0xf0 [ 8.613239] [] acpiphp_glue_init+0x48/0x51 [ 8.613239] [] acpiphp_init+0x2b/0x50 [ 8.613239] [] do_one_initcall+0x7f/0x13a [ 8.613239] [] kernel_init+0x13c/0x1c0 [ 8.613239] [] ? do_early_param+0x8c/0x8c [ 8.613239] [] kernel_thread_helper+0x4/0x10 [ 8.613239] [] ? retint_restore_args+0x13/0x13 [ 8.613239] [] ? start_kernel+0x3d1/0x3d1 [ 8.613239] [] ? gs_change+0x13/0x13