From: "Ozan Çağlayan" <ozan@pardus.org.tr>
To: linux-kernel <linux-kernel@vger.kernel.org>
Subject: [BUG 2.6.30.9] Soft lockup CPU#X stuck for Y seconds!
Date: Tue, 24 Nov 2009 10:12:40 +0200 [thread overview]
Message-ID: <4B0B9578.90703@pardus.org.tr> (raw)
Hi,
We've hit soft lockups on a 2.6.30.9 KVM guest over an HP DL580-G5 host
running a 2.6.30.9 kernel as well. After the soft lockups, system time
skewed back in time:
~ $ LC_ALL=C date
Mon Feb 1 00:10:58 EET 1954
I'm attaching the dmesg containing the two consecutive soft lockups. One
seems related to cpuidle and the other to the virtio network stuff.
Thanks.
Ozan
------
[ 0.000000] Initializing cgroup subsys cpu
[ 0.000000] Linux version 2.6.30.9-128 (pardus@buildfarm) (gcc
version 4.3.3 (Pardus Linux) ) #1 SMP Thu Nov 5 09:31:27 EET 2009
[ 0.000000] KERNEL supported cpus:
[ 0.000000] Intel GenuineIntel
[ 0.000000] AMD AuthenticAMD
[ 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] BIOS-provided physical RAM map:
[ 0.000000] BIOS-e820: 0000000000000000 - 000000000009f000 (usable)
[ 0.000000] BIOS-e820: 000000000009f000 - 00000000000a0000 (reserved)
[ 0.000000] BIOS-e820: 00000000000e8000 - 0000000000100000 (reserved)
[ 0.000000] BIOS-e820: 0000000000100000 - 000000007fef0000 (usable)
[ 0.000000] BIOS-e820: 000000007fef0000 - 000000007ff00000 (ACPI data)
[ 0.000000] BIOS-e820: 00000000fffbc000 - 0000000100000000 (reserved)
[ 0.000000] DMI 2.4 present.
[ 0.000000] last_pfn = 0x7fef0 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-FFFFF uncachable
[ 0.000000] MTRR variable ranges enabled:
[ 0.000000] 0 base 00E0000000 mask FFFFFFFFE0000000 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] PAT not supported by CPU.
[ 0.000000] e820 update range: 0000000000002000 - 0000000000006000
(usable) ==> (reserved)
[ 0.000000] Scanning 1 areas for low memory corruption
[ 0.000000] modified physical RAM map:
[ 0.000000] modified: 0000000000000000 - 0000000000002000 (usable)
[ 0.000000] modified: 0000000000002000 - 0000000000006000 (reserved)
[ 0.000000] modified: 0000000000006000 - 000000000009f000 (usable)
[ 0.000000] modified: 000000000009f000 - 00000000000a0000 (reserved)
[ 0.000000] modified: 00000000000e8000 - 0000000000100000 (reserved)
[ 0.000000] modified: 0000000000100000 - 000000007fef0000 (usable)
[ 0.000000] modified: 000000007fef0000 - 000000007ff00000 (ACPI data)
[ 0.000000] modified: 00000000fffbc000 - 0000000100000000 (reserved)
[ 0.000000] init_memory_mapping: 0000000000000000-00000000377fe000
[ 0.000000] 0000000000 - 0000400000 page 4k
[ 0.000000] 0000400000 - 0037400000 page 2M
[ 0.000000] 0037400000 - 00377fe000 page 4k
[ 0.000000] kernel direct mapping tables up to 377fe000 @ 7000-c000
[ 0.000000] RAMDISK: 37b98000 - 37fefc72
[ 0.000000] Allocated new RAMDISK: 0070b000 - 00b62c72
[ 0.000000] Move RAMDISK from 0000000037b98000 - 0000000037fefc71 to
0070b000 - 00b62c71
[ 0.000000] ACPI: RSDP 000fbf90 00014 (v00 QEMU )
[ 0.000000] ACPI: RSDT 7fef0000 0002C (v01 QEMU QEMURSDT 00000001
QEMU 00000001)
[ 0.000000] ACPI: FACP 7fef002c 00074 (v01 QEMU QEMUFACP 00000001
QEMU 00000001)
[ 0.000000] ACPI: DSDT 7fef0100 02540 (v01 BXPC BXDSDT 00000001
INTL 20061109)
[ 0.000000] ACPI: FACS 7fef00c0 00040
[ 0.000000] ACPI: APIC 7fef2640 000E0 (v01 QEMU QEMUAPIC 00000001
QEMU 00000001)
[ 0.000000] ACPI: Local APIC address 0xfee00000
[ 0.000000] 1158MB HIGHMEM available.
[ 0.000000] 887MB LOWMEM available.
[ 0.000000] mapped low ram: 0 - 377fe000
[ 0.000000] low ram: 0 - 377fe000
[ 0.000000] node 0 low ram: 00000000 - 377fe000
[ 0.000000] node 0 bootmap 00008000 - 0000ef00
[ 0.000000] (9 early reservations) ==> bootmem [0000000000 - 00377fe000]
[ 0.000000] #0 [0000000000 - 0000001000] BIOS data page ==>
[0000000000 - 0000001000]
[ 0.000000] #1 [0000001000 - 0000002000] EX TRAMPOLINE ==>
[0000001000 - 0000002000]
[ 0.000000] #2 [0000006000 - 0000007000] TRAMPOLINE ==>
[0000006000 - 0000007000]
[ 0.000000] #3 [0000100000 - 0000706fc4] TEXT DATA BSS ==>
[0000100000 - 0000706fc4]
[ 0.000000] #4 [000009fc00 - 0000100000] BIOS reserved ==>
[000009fc00 - 0000100000]
[ 0.000000] #5 [0000707000 - 000070a03d] BRK ==>
[0000707000 - 000070a03d]
[ 0.000000] #6 [0000007000 - 0000008000] PGTABLE ==>
[0000007000 - 0000008000]
[ 0.000000] #7 [000070b000 - 0000b62c72] NEW RAMDISK ==>
[000070b000 - 0000b62c72]
[ 0.000000] #8 [0000008000 - 000000f000] BOOTMAP ==>
[0000008000 - 000000f000]
[ 0.000000] found SMP MP-table at [c00fbd10] fbd10
[ 0.000000] kvm-clock: cpu 0, msr 0:64a3e1, boot clock
[ 0.000000] Zone PFN ranges:
[ 0.000000] DMA 0x00000000 -> 0x00001000
[ 0.000000] Normal 0x00001000 -> 0x000377fe
[ 0.000000] HighMem 0x000377fe -> 0x0007fef0
[ 0.000000] Movable zone start PFN for each node
[ 0.000000] early_node_map[3] active PFN ranges
[ 0.000000] 0: 0x00000000 -> 0x00000002
[ 0.000000] 0: 0x00000006 -> 0x0000009f
[ 0.000000] 0: 0x00000100 -> 0x0007fef0
[ 0.000000] On node 0 totalpages: 523915
[ 0.000000] free_area_init_node: node 0, pgdat c059d6a0, node_mem_map
c1000000
[ 0.000000] DMA zone: 32 pages used for memmap
[ 0.000000] DMA zone: 0 pages reserved
[ 0.000000] DMA zone: 3963 pages, LIFO batch:0
[ 0.000000] Normal zone: 1744 pages used for memmap
[ 0.000000] Normal zone: 221486 pages, LIFO batch:31
[ 0.000000] HighMem zone: 2318 pages used for memmap
[ 0.000000] HighMem zone: 294372 pages, LIFO batch:31
[ 0.000000] Using APIC driver default
[ 0.000000] ACPI: PM-Timer IO Port: 0xb008
[ 0.000000] ACPI: Local APIC address 0xfee00000
[ 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 (acpi_id[0x02] lapic_id[0x02] enabled)
[ 0.000000] ACPI: LAPIC (acpi_id[0x03] lapic_id[0x03] enabled)
[ 0.000000] ACPI: LAPIC (acpi_id[0x04] lapic_id[0x04] enabled)
[ 0.000000] ACPI: LAPIC (acpi_id[0x05] lapic_id[0x05] enabled)
[ 0.000000] ACPI: LAPIC (acpi_id[0x06] lapic_id[0x06] enabled)
[ 0.000000] ACPI: LAPIC (acpi_id[0x07] lapic_id[0x07] enabled)
[ 0.000000] ACPI: LAPIC (acpi_id[0x08] lapic_id[0x08] enabled)
[ 0.000000] ACPI: LAPIC (acpi_id[0x09] lapic_id[0x09] enabled)
[ 0.000000] ACPI: LAPIC (acpi_id[0x0a] lapic_id[0x0a] disabled)
[ 0.000000] ACPI: LAPIC (acpi_id[0x0b] lapic_id[0x0b] disabled)
[ 0.000000] ACPI: LAPIC (acpi_id[0x0c] lapic_id[0x0c] disabled)
[ 0.000000] ACPI: LAPIC (acpi_id[0x0d] lapic_id[0x0d] disabled)
[ 0.000000] ACPI: LAPIC (acpi_id[0x0e] lapic_id[0x0e] disabled)
[ 0.000000] ACPI: LAPIC (acpi_id[0x0f] lapic_id[0x0f] disabled)
[ 0.000000] Overriding APIC driver with bigsmp
[ 0.000000] ACPI: IOAPIC (id[0x0a] address[0xfec00000] gsi_base[0])
[ 0.000000] IOAPIC[0]: apic_id 10, version 17, address 0xfec00000,
GSI 0-23
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
[ 0.000000] ACPI: IRQ5 used by override.
[ 0.000000] ACPI: IRQ9 used by override.
[ 0.000000] ACPI: IRQ10 used by override.
[ 0.000000] ACPI: IRQ11 used by override.
[ 0.000000] Enabling APIC mode: Physflat. Using 1 I/O APICs
[ 0.000000] Using ACPI (MADT) for SMP configuration information
[ 0.000000] SMP: Allowing 16 CPUs, 6 hotplug CPUs
[ 0.000000] nr_irqs_gsi: 24
[ 0.000000] PM: Registered nosave memory: 0000000000002000 -
0000000000006000
[ 0.000000] PM: Registered nosave memory: 000000000009f000 -
00000000000a0000
[ 0.000000] PM: Registered nosave memory: 00000000000a0000 -
00000000000e8000
[ 0.000000] PM: Registered nosave memory: 00000000000e8000 -
0000000000100000
[ 0.000000] Allocating PCI resources starting at 80000000 (gap:
7ff00000:800bc000)
[ 0.000000] NR_CPUS:32 nr_cpumask_bits:32 nr_cpu_ids:16 nr_node_ids:1
[ 0.000000] PERCPU: Embedded 12 pages at c200a000, static data 26972
bytes
[ 0.000000] kvm-clock: cpu 0, msr 0:20103e1, primary cpu clock
[ 0.000000] Built 1 zonelists in Zone order, mobility grouping on.
Total pages: 519821
[ 0.000000] Kernel command line: root=LABEL=PARDUS_ROOT splash=silent
quiet vga=0x314 mudur=virtio
[ 0.000000] bootsplash: silent mode.
[ 0.000000] Enabling fast FPU save and restore... done.
[ 0.000000] Enabling unmasked SIMD FPU exception support... done.
[ 0.000000] Initializing CPU#0
[ 0.000000] NR_IRQS:1280
[ 0.000000] PID hash table entries: 4096 (order: 12, 16384 bytes)
[ 0.000000] Detected 2667.088 MHz processor.
[ 0.000999] Console: colour dummy device 80x25
[ 0.000999] console [tty0] enabled
[ 0.000999] Dentry cache hash table entries: 131072 (order: 7, 524288
bytes)
[ 0.000999] Inode-cache hash table entries: 65536 (order: 6, 262144
bytes)
[ 0.000999] allocated 10480320 bytes of page_cgroup
[ 0.000999] please try cgroup_disable=memory option if you don't want
[ 0.000999] Initializing HighMem for node 0 (000377fe:0007fef0)
[ 0.000999] Memory: 2055624k/2096064k available (3089k kernel code,
38892k reserved, 1849k data, 448k init, 1186760k highmem)
[ 0.000999] virtual kernel memory layout:
[ 0.000999] fixmap : 0xffe16000 - 0xfffff000 (1956 kB)
[ 0.000999] pkmap : 0xff800000 - 0xffc00000 (4096 kB)
[ 0.000999] vmalloc : 0xf7ffe000 - 0xff7fe000 ( 120 MB)
[ 0.000999] lowmem : 0xc0000000 - 0xf77fe000 ( 887 MB)
[ 0.000999] .init : 0xc05db000 - 0xc064b000 ( 448 kB)
[ 0.000999] .data : 0xc04047f3 - 0xc05d2c6c (1849 kB)
[ 0.000999] .text : 0xc0100000 - 0xc04047f3 (3089 kB)
[ 0.000999] Checking if this processor honours the WP bit even in
supervisor mode...Ok.
[ 0.000999] SLUB: Genslabs=13, HWalign=64, Order=0-3, MinObjects=0,
CPUs=16, Nodes=1
[ 0.001019] Calibrating delay loop (skipped) preset value.. 5334.17
BogoMIPS (lpj=2667088)
[ 0.001115] Security Framework initialized
[ 0.001139] Mount-cache hash table entries: 512
[ 0.001622] Initializing cgroup subsys ns
[ 0.001641] Initializing cgroup subsys cpuacct
[ 0.001645] Initializing cgroup subsys memory
[ 0.001660] Initializing cgroup subsys devices
[ 0.001662] Initializing cgroup subsys freezer
[ 0.001725] CPU: L1 I cache: 32K, L1 D cache: 32K
[ 0.001727] CPU: L2 cache: 2048K
[ 0.001736] Intel machine check architecture supported.
[ 0.001742] Intel machine check reporting enabled on CPU#0.
[ 0.009087] ACPI: Core revision 20090320
[ 0.011230] Leaving ESR disabled.
[ 0.011710] ..TIMER: vector=0x30 apic1=0 pin1=0 apic2=-1 pin2=-1
[ 0.021719] CPU0: Intel QEMU Virtual CPU version 0.10.0 stepping 03
[ 0.025234] Booting processor 1 APIC 0x1 ip 0x6000
[ 0.000999] Initializing CPU#1
[ 0.000999] Leaving ESR disabled.
[ 0.000999] Calibrating delay loop (skipped) preset value.. 5334.17
BogoMIPS (lpj=2667088)
[ 0.000999] CPU: L1 I cache: 32K, L1 D cache: 32K
[ 0.000999] CPU: L2 cache: 2048K
[ 0.000999] Intel machine check architecture supported.
[ 0.000999] Intel machine check reporting enabled on CPU#1.
[ 0.036646] CPU1: Intel QEMU Virtual CPU version 0.10.0 stepping 03
[ 0.060916] checking TSC synchronization [CPU#0 -> CPU#1]: passed.
[ 0.000999] kvm-clock: cpu 1, msr 0:20203e1, secondary cpu clock
[ 0.068055] Booting processor 2 APIC 0x2 ip 0x6000
[ 0.000999] Initializing CPU#2
[ 0.000999] Leaving ESR disabled.
[ 0.000999] Calibrating delay loop (skipped) preset value.. 5334.17
BogoMIPS (lpj=2667088)
[ 0.000999] CPU: L1 I cache: 32K, L1 D cache: 32K
[ 0.000999] CPU: L2 cache: 2048K
[ 0.000999] Intel machine check architecture supported.
[ 0.000999] Intel machine check reporting enabled on CPU#2.
[ 0.079512] CPU2: Intel QEMU Virtual CPU version 0.10.0 stepping 03
[ 0.108326] checking TSC synchronization [CPU#0 -> CPU#2]: passed.
[ 0.110071] kvm-clock: cpu 2, msr 0:20303e1, secondary cpu clock
[ 0.117203] Booting processor 3 APIC 0x3 ip 0x6000
[ 0.000999] Initializing CPU#3
[ 0.000999] Leaving ESR disabled.
[ 0.000999] Calibrating delay loop (skipped) preset value.. 5334.17
BogoMIPS (lpj=2667088)
[ 0.000999] CPU: L1 I cache: 32K, L1 D cache: 32K
[ 0.000999] CPU: L2 cache: 2048K
[ 0.000999] Intel machine check architecture supported.
[ 0.000999] Intel machine check reporting enabled on CPU#3.
[ 0.128676] CPU3: Intel QEMU Virtual CPU version 0.10.0 stepping 03
[ 0.156612] checking TSC synchronization [CPU#0 -> CPU#3]: passed.
[ 0.000999] kvm-clock: cpu 3, msr 0:20403e1, secondary cpu clock
[ 0.165913] Booting processor 4 APIC 0x4 ip 0x6000
[ 0.000999] Initializing CPU#4
[ 0.000999] Leaving ESR disabled.
[ 0.000999] Calibrating delay loop (skipped) preset value.. 5334.17
BogoMIPS (lpj=2667088)
[ 0.000999] CPU: L1 I cache: 32K, L1 D cache: 32K
[ 0.000999] CPU: L2 cache: 2048K
[ 0.000999] Intel machine check architecture supported.
[ 0.000999] Intel machine check reporting enabled on CPU#4.
[ 0.177404] CPU4: Intel QEMU Virtual CPU version 0.10.0 stepping 03
[ 0.208195] checking TSC synchronization [CPU#0 -> CPU#4]: passed.
[ 0.209984] kvm-clock: cpu 4, msr 0:20503e1, secondary cpu clock
[ 0.219049] Booting processor 5 APIC 0x5 ip 0x6000
[ 0.000999] Initializing CPU#5
[ 0.000999] Leaving ESR disabled.
[ 0.000999] Calibrating delay loop (skipped) preset value.. 5334.17
BogoMIPS (lpj=2667088)
[ 0.000999] CPU: L1 I cache: 32K, L1 D cache: 32K
[ 0.000999] CPU: L2 cache: 2048K
[ 0.000999] Intel machine check architecture supported.
[ 0.000999] Intel machine check reporting enabled on CPU#5.
[ 0.230481] CPU5: Intel QEMU Virtual CPU version 0.10.0 stepping 03
[ 0.262077] checking TSC synchronization [CPU#0 -> CPU#5]: passed.
[ 0.263978] kvm-clock: cpu 5, msr 0:20603e1, secondary cpu clock
[ 0.273348] Booting processor 6 APIC 0x6 ip 0x6000
[ 0.000999] Initializing CPU#6
[ 0.000999] Leaving ESR disabled.
[ 0.000999] Calibrating delay loop (skipped) preset value.. 5334.17
BogoMIPS (lpj=2667088)
[ 0.000999] CPU: L1 I cache: 32K, L1 D cache: 32K
[ 0.000999] CPU: L2 cache: 2048K
[ 0.000999] Intel machine check architecture supported.
[ 0.000999] Intel machine check reporting enabled on CPU#6.
[ 0.284801] CPU6: Intel QEMU Virtual CPU version 0.10.0 stepping 03
[ 0.317759] checking TSC synchronization [CPU#0 -> CPU#6]: passed.
[ 0.319015] kvm-clock: cpu 6, msr 0:20703e1, secondary cpu clock
[ 0.329370] Booting processor 7 APIC 0x7 ip 0x6000
[ 0.000999] Initializing CPU#7
[ 0.000999] Leaving ESR disabled.
[ 0.000999] Calibrating delay loop (skipped) preset value.. 5334.17
BogoMIPS (lpj=2667088)
[ 0.000999] CPU: L1 I cache: 32K, L1 D cache: 32K
[ 0.000999] CPU: L2 cache: 2048K
[ 0.000999] Intel machine check architecture supported.
[ 0.000999] Intel machine check reporting enabled on CPU#7.
[ 0.340842] CPU7: Intel QEMU Virtual CPU version 0.10.0 stepping 03
[ 0.375024] checking TSC synchronization [CPU#0 -> CPU#7]: passed.
[ 0.377068] kvm-clock: cpu 7, msr 0:20803e1, secondary cpu clock
[ 0.386494] Booting processor 8 APIC 0x8 ip 0x6000
[ 0.000999] Initializing CPU#8
[ 0.000999] Leaving ESR disabled.
[ 0.000999] Calibrating delay loop (skipped) preset value.. 5334.17
BogoMIPS (lpj=2667088)
[ 0.000999] CPU: L1 I cache: 32K, L1 D cache: 32K
[ 0.000999] CPU: L2 cache: 2048K
[ 0.000999] Intel machine check architecture supported.
[ 0.000999] Intel machine check reporting enabled on CPU#8.
[ 0.398150] CPU8: Intel QEMU Virtual CPU version 0.10.0 stepping 03
[ 0.434186] checking TSC synchronization [CPU#0 -> CPU#8]: passed.
[ 0.436016] kvm-clock: cpu 8, msr 0:20903e1, secondary cpu clock
[ 0.445542] Booting processor 9 APIC 0x9 ip 0x6000
[ 0.000999] Initializing CPU#9
[ 0.000999] Leaving ESR disabled.
[ 0.000999] Calibrating delay loop (skipped) preset value.. 5334.17
BogoMIPS (lpj=2667088)
[ 0.000999] CPU: L1 I cache: 32K, L1 D cache: 32K
[ 0.000999] CPU: L2 cache: 2048K
[ 0.000999] Intel machine check architecture supported.
[ 0.000999] Intel machine check reporting enabled on CPU#9.
[ 0.456971] CPU9: Intel QEMU Virtual CPU version 0.10.0 stepping 03
[ 0.487732] checking TSC synchronization [CPU#0 -> CPU#9]: passed.
[ 0.489064] kvm-clock: cpu 9, msr 0:20a03e1, secondary cpu clock
[ 0.489091] Brought up 10 CPUs
[ 0.489094] Total of 10 processors activated (53341.76 BogoMIPS).
[ 0.490403] CPU0 attaching sched-domain:
[ 0.490411] domain 0: span 0-9 level CPU
[ 0.490413] groups: 0 1 2 3 4 5 6 7 8 9
[ 0.490422] CPU1 attaching sched-domain:
[ 0.490423] domain 0: span 0-9 level CPU
[ 0.490425] groups: 1 2 3 4 5 6 7 8 9 0
[ 0.490432] CPU2 attaching sched-domain:
[ 0.490434] domain 0: span 0-9 level CPU
[ 0.490435] groups: 2 3 4 5 6 7 8 9 0 1
[ 0.490442] CPU3 attaching sched-domain:
[ 0.490444] domain 0: span 0-9 level CPU
[ 0.490446] groups: 3 4 5 6 7 8 9 0 1 2
[ 0.490452] CPU4 attaching sched-domain:
[ 0.490454] domain 0: span 0-9 level CPU
[ 0.490456] groups: 4 5 6 7 8 9 0 1 2 3
[ 0.490462] CPU5 attaching sched-domain:
[ 0.490464] domain 0: span 0-9 level CPU
[ 0.490466] groups: 5 6 7 8 9 0 1 2 3 4
[ 0.490472] CPU6 attaching sched-domain:
[ 0.490474] domain 0: span 0-9 level CPU
[ 0.490476] groups: 6 7 8 9 0 1 2 3 4 5
[ 0.490483] CPU7 attaching sched-domain:
[ 0.490484] domain 0: span 0-9 level CPU
[ 0.490486] groups: 7 8 9 0 1 2 3 4 5 6
[ 0.490493] CPU8 attaching sched-domain:
[ 0.490494] domain 0: span 0-9 level CPU
[ 0.490496] groups: 8 9 0 1 2 3 4 5 6 7
[ 0.490503] CPU9 attaching sched-domain:
[ 0.490504] domain 0: span 0-9 level CPU
[ 0.490506] groups: 9 0 1 2 3 4 5 6 7 8
[ 0.492212] net_namespace: 1088 bytes
[ 0.492261] Booting paravirtualized kernel on KVM
[ 0.493088] regulator: core version 0.5
[ 0.493238] NET: Registered protocol family 16
[ 0.493456] EISA bus registered
[ 0.493482] ACPI: bus type pci registered
[ 0.493655] PCI: PCI BIOS revision 2.10 entry at 0xfb510, last bus=0
[ 0.493657] PCI: Using configuration type 1 for base access
[ 0.494379] bio: create slab <bio-0> at 0
[ 0.497407] ACPI: EC: Look up EC in DSDT
[ 0.500021] ACPI: Interpreter enabled
[ 0.500024] ACPI: (supports S0 S3 S4 S5)
[ 0.500080] ACPI: Using IOAPIC for interrupt routing
[ 0.503151] ACPI: No dock devices found.
[ 0.503162] ACPI: PCI Root Bridge [PCI0] (0000:00)
[ 0.504027] pci 0000:00:01.1: reg 20 io port: [0xc000-0xc00f]
[ 0.504451] pci 0000:00:01.3: quirk: region b000-b03f claimed by
PIIX4 ACPI
[ 0.504461] pci 0000:00:01.3: quirk: region b100-b10f claimed by
PIIX4 SMB
[ 0.508188] pci 0000:00:02.0: reg 10 32bit mmio: [0xf0000000-0xf1ffffff]
[ 0.512144] pci 0000:00:02.0: reg 14 32bit mmio: [0xf2000000-0xf2000fff]
[ 0.531391] pci 0000:00:03.0: reg 10 io port: [0xc020-0xc03f]
[ 0.532040] pci 0000:00:04.0: reg 10 io port: [0xc040-0xc07f]
[ 0.532359] pci 0000:00:05.0: reg 10 io port: [0xc080-0xc09f]
[ 0.532783] pci_bus 0000:00: on NUMA node 0
[ 0.532857] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT]
[ 0.535304] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
[ 0.535396] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
[ 0.535479] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
[ 0.535561] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
[ 0.536067] SCSI subsystem initialized
[ 0.536324] usbcore: registered new interface driver usbfs
[ 0.536324] usbcore: registered new interface driver hub
[ 0.536324] usbcore: registered new device driver usb
[ 0.536324] PCI: Using ACPI for IRQ routing
[ 0.541061] Switched to high resolution mode on CPU 0
[ 0.541130] Switched to high resolution mode on CPU 1
[ 0.541206] Switched to high resolution mode on CPU 7
[ 0.541262] Switched to high resolution mode on CPU 5
[ 0.541312] Switched to high resolution mode on CPU 8
[ 0.541416] Switched to high resolution mode on CPU 4
[ 0.541703] Switched to high resolution mode on CPU 2
[ 0.541965] Switched to high resolution mode on CPU 6
[ 0.541985] Switched to high resolution mode on CPU 3
[ 0.542021] Switched to high resolution mode on CPU 9
[ 0.543042] pnp: PnP ACPI init
[ 0.543068] ACPI: bus type pnp registered
[ 0.543822] pnp: PnP ACPI: found 7 devices
[ 0.543824] ACPI: ACPI bus type pnp unregistered
[ 0.543830] PnPBIOS: Disabled
[ 0.580161] pci_bus 0000:00: resource 0 io: [0x00-0xffff]
[ 0.580164] pci_bus 0000:00: resource 1 mem: [0x000000-0xffffffff]
[ 0.580194] NET: Registered protocol family 2
[ 0.589194] IP route cache hash table entries: 32768 (order: 5,
131072 bytes)
[ 0.589686] TCP established hash table entries: 131072 (order: 8,
1048576 bytes)
[ 0.591601] TCP bind hash table entries: 65536 (order: 7, 524288 bytes)
[ 0.592553] TCP: Hash tables configured (established 131072 bind 65536)
[ 0.592556] TCP reno registered
[ 0.595287] NET: Registered protocol family 1
[ 0.595395] Unpacking initramfs...
[ 0.750917] Freeing initrd memory: 4447k freed
[ 0.752634] cpu0(16) debug files 3
[ 0.752649] cpu1(16) debug files 3
[ 0.752693] cpu2(16) debug files 3
[ 0.752706] cpu3(16) debug files 3
[ 0.752718] cpu4(16) debug files 3
[ 0.752738] cpu5(16) debug files 3
[ 0.752751] cpu6(16) debug files 3
[ 0.752763] cpu7(16) debug files 3
[ 0.752805] cpu8(16) debug files 3
[ 0.752825] cpu9(16) debug files 3
[ 0.752830] Machine check exception polling timer started.
[ 0.752849] cpufreq-nforce2: No nForce2 chipset.
[ 0.753197] Scanning for low memory corruption every 60 seconds
[ 0.753363] audit: initializing netlink socket (disabled)
[ 0.753384] type=2000 audit(1257855044.753:1): initialized
[ 0.762053] highmem bounce pool size: 64 pages
[ 0.762059] HugeTLB registered 4 MB page size, pre-allocated 0 pages
[ 0.764836] VFS: Disk quotas dquot_6.5.2
[ 0.764879] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[ 0.765449] fuse init (API version 7.11)
[ 0.766196] aufs 2-29
[ 0.766212] msgmni has been set to 1707
[ 0.769453] alg: No test for stdrng (krng)
[ 0.769547] Block layer SCSI generic (bsg) driver version 0.4 loaded
(major 253)
[ 0.769557] io scheduler noop registered
[ 0.769559] io scheduler anticipatory registered
[ 0.769562] io scheduler deadline registered
[ 0.769598] io scheduler cfq registered (default)
[ 0.769626] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
[ 0.769664] pci 0000:00:01.0: PIIX3: Enabling Passive Release
[ 0.769683] pci 0000:00:01.0: Activating ISA DMA hang workarounds
[ 0.769698] pci 0000:00:02.0: Boot video device
[ 0.769752] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
[ 0.769772] pciehp: PCI Express Hot Plug Controller Driver version: 0.4
[ 0.772248] vesafb: framebuffer at 0xf0000000, mapped to 0xf8080000,
using 3750k, total 4096k
[ 0.772250] vesafb: mode is 800x600x16, linelength=1600, pages=3
[ 0.772252] vesafb: scrolling: redraw
[ 0.772255] vesafb: Truecolor: size=0:5:6:5, shift=0:11:5:0
[ 0.774287] bootsplash 3.1.6-2004/03/31: looking for picture...
[ 0.781093] bootsplash: silentjpeg size 34362 bytes
[ 0.787257] bootsplash: ...found (800x600, 26696 bytes, v3).
[ 0.798984] Console: switching to colour frame buffer device 100x34
[ 0.810922] fb0: VESA VGA frame buffer device
[ 0.811145] input: Power Button as
/devices/LNXSYSTM:00/LNXPWRBN:00/input/input0
[ 0.811147] ACPI: Power Button [PWRF]
[ 0.811635] processor ACPI_CPU:00: registered as cooling_device0
[ 0.811748] processor ACPI_CPU:01: registered as cooling_device1
[ 0.811849] processor ACPI_CPU:02: registered as cooling_device2
[ 0.811986] processor ACPI_CPU:03: registered as cooling_device3
[ 0.812120] processor ACPI_CPU:04: registered as cooling_device4
[ 0.812227] processor ACPI_CPU:05: registered as cooling_device5
[ 0.812331] processor ACPI_CPU:06: registered as cooling_device6
[ 0.812438] processor ACPI_CPU:07: registered as cooling_device7
[ 0.812540] processor ACPI_CPU:08: registered as cooling_device8
[ 0.812642] processor ACPI_CPU:09: registered as cooling_device9
[ 0.814313] isapnp: Scanning for PnP cards...
[ 1.132936] isapnp: No Plug & Play device found
[ 1.133882] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[ 1.134199] serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
[ 1.134632] 00:06: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
[ 1.145399] FDC 0 is a S82078B
[ 1.145884] loop: module loaded
[ 1.145918] input: Macintosh mouse button emulation as
/devices/virtual/input/input1
[ 1.145944] Driver 'sd' needs updating - please use bus_type methods
[ 1.145951] Driver 'sr' needs updating - please use bus_type methods
[ 1.146036] Fixed MDIO Bus: probed
[ 1.146057] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[ 1.146083] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[ 1.146102] uhci_hcd: USB Universal Host Controller Interface driver
[ 1.146151] PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at
0x60,0x64 irq 1,12
[ 1.146853] serio: i8042 KBD port at 0x60,0x64 irq 1
[ 1.146875] serio: i8042 AUX port at 0x60,0x64 irq 12
[ 1.146957] mice: PS/2 mouse device common for all mice
[ 1.147723] rtc_cmos 00:01: rtc core: registered rtc_cmos as rtc0
[ 1.147924] rtc0: alarms up to one day, 114 bytes nvram
[ 1.147951] EISA: Probing bus 0 at eisa.0
[ 1.148150] input: AT Translated Set 2 keyboard as
/devices/platform/i8042/serio0/input/input2
[ 1.148211] EISA: Detected 0 cards.
[ 1.150406] cpuidle: using governor ladder
[ 1.150408] cpuidle: using governor menu
[ 1.151291] usbcore: registered new interface driver hiddev
[ 1.151301] usbcore: registered new interface driver usbhid
[ 1.151302] usbhid: v2.6:USB HID core driver
[ 1.152063] NET: Registered protocol family 17
[ 1.153068] Using IPI No-Shortcut mode
[ 1.153305] TuxOnIce 3.0.1 (http://tuxonice.net)
[ 1.153375] TuxOnIce: Ignoring late initcall, as requested.
[ 1.153385] registered taskstats version 1
[ 1.153558] psmouse serio1: ID: 10 00 64
[ 1.153812] rtc_cmos 00:01: setting system clock to 2009-11-10
12:10:43 UTC (1257855043)
[ 1.154442] Freeing unused kernel memory: 448k freed
[ 1.167651] Write protecting the kernel text: 3092k
[ 1.173187] Write protecting the kernel read-only data: 1444k
[ 1.558224] input: ImExPS/2 Generic Explorer Mouse as
/devices/platform/i8042/serio1/input/input3
[ 2.089215] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 11
[ 2.089258] virtio-pci 0000:00:03.0: PCI INT A -> Link[LNKC] -> GSI
11 (level, high) -> IRQ 11
[ 2.089500] ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 10
[ 2.089521] virtio-pci 0000:00:04.0: PCI INT A -> Link[LNKD] -> GSI
10 (level, high) -> IRQ 10
[ 2.089709] ACPI: PCI Interrupt Link [LNKA] enabled at IRQ 10
[ 2.089712] virtio-pci 0000:00:05.0: PCI INT A -> Link[LNKA] -> GSI
10 (level, high) -> IRQ 10
[ 2.114900] libata version 3.00 loaded.
[ 2.117535] ata_piix 0000:00:01.1: version 2.13
[ 2.117687] ata_piix 0000:00:01.1: setting latency timer to 64
[ 2.118214] scsi0 : ata_piix
[ 2.118514] scsi1 : ata_piix
[ 2.118571] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc000 irq 14
[ 2.118573] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc008 irq 15
[ 2.421476] ata2.01: NODEV after polling detection
[ 2.421787] ata2.00: ATAPI: QEMU DVD-ROM, 0.10.0, max UDMA/100
[ 2.422371] ata2.00: configured for MWDMA2
[ 2.423523] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM
0.10 PQ: 0 ANSI: 5
[ 2.425747] sr0: scsi3-mmc drive: 4x/4x xa/form2 tray
[ 2.425758] Uniform CD-ROM driver Revision: 3.20
[ 2.425860] sr 1:0:0:0: Attached scsi CD-ROM sr0
[ 2.425932] sr 1:0:0:0: Attached scsi generic sg0 type 5
[ 2.475231] vda: vda1
[ 2.519362] brd: module loaded
[ 3.758402] EXT4-fs: barriers enabled
[ 3.763918] kjournald2 starting: pid 229, dev vda1:8, commit interval
5 seconds
[ 3.763948] EXT4-fs: delayed allocation enabled
[ 3.763950] EXT4-fs: file extents enabled
[ 3.773524] EXT4-fs: mballoc enabled
[ 3.773537] EXT4-fs: mounted filesystem vda1 with ordered data mode
[ 6.421525] udev: starting version 146
[ 6.943955] piix4_smbus 0000:00:01.3: SMBus Host Controller at
0xb100, revision 0
[ 6.951640] input: PC Speaker as /devices/platform/pcspkr/input/input4
[ 8.174315] parport_pc 00:05: reported by Plug and Play ACPI
[ 8.174489] parport0: PC-style at 0x378, irq 7 [PCSPP,TRISTATE]
[ 8.261518] lp0: using parport0 (interrupt-driven).
[ 8.339160] ppdev: user-space parallel port driver
[ 9.338879] EXT4 FS on vda1, internal journal on vda1:8
[ 10.075897] Adding 307192k swap on /.swap. Priority:-1 extents:2
across:315384k SS
[ 14.715951] JBD: barrier-based sync failed on vda1:8 - disabling barriers
[ 16.748619] NET: Registered protocol family 10
[ 16.753682] lo: Disabled Privacy Extensions
[ 18.548590] mtrr: no MTRR for f0000000,100000 found
[ 19.134074] bootsplash: status on console 0 changed to on
[ 27.500044] eth0: no IPv6 routers present
[468044.486305] PPP generic driver version 2.4.2
[468044.501532] NET: Registered protocol family 24
[785560.993888] BIOS EDD facility v0.16 2004-Jun-25, 1 devices found
[1267812575.161101] BUG: soft lockup - CPU#2 stuck for 1179833091s!
[swapper:0]
[1267812575.161105] Modules linked in: edd pppoe pppox ppp_generic slhc
ipv6 ppdev parport_pc lp parport pcspkr i2c_piix4 brd virtio_net
virtio_blk virtio_balloon ata_generic pata_acpi ata_piix libata virtio_pci
[1267812575.161125]
[1267812575.161139] Pid: 0, comm: swapper Not tainted (2.6.30.9-128 #1)
[1267812575.161141] EIP: 0060:[<c0135829>] EFLAGS: 00000206 CPU: 2
[1267812575.161151] EIP is at __do_softirq+0x3e/0x133
[1267812575.161153] EAX: 00000002 EBX: 00000046 ECX: 11982cd1 EDX: 00000102
[1267812575.161155] ESI: 00000000 EDI: 00037811 EBP: f7093f20 ESP: f7093f04
[1267812575.161157] DS: 007b ES: 007b FS: 00d8 GS: 0000 SS: 0068
[1267812575.161161] CR0: 8005003b CR2: b7fe4be8 CR3: 3657f000 CR4: 000006d0
[1267812575.161171] DR0: 00000000 DR1: 00000000 DR2: 00000000 DR3: 00000000
[1267812575.161177] DR6: ffff0ff0 DR7: 00000400
[1267812575.161179] Call Trace:
[1267812575.161185] [<c013594f>] do_softirq+0x31/0x3c
[1267812575.161188] [<c0135a3a>] irq_exit+0x29/0x57
[1267812575.161193] [<c01167a9>] smp_apic_timer_interrupt+0x6f/0x7d
[1267812575.161198] [<c0103b26>] apic_timer_interrupt+0x2a/0x30
[1267812575.161209] [<c01400d8>] ? uevent_filter+0xb/0x11
[1267812575.161215] [<c014c711>] ? tick_nohz_restart_sched_tick+0xa7/0xb1
[1267812575.161218] [<c01024c3>] cpu_idle+0x5b/0x64
[1267812575.161224] [<c03fd033>] start_secondary+0xc6/0xc8
[1267812575.162037] BUG: soft lockup - CPU#0 stuck for 1179837187s!
[ata/0:148]
[1267812575.162037] Modules linked in: edd pppoe pppox ppp_generic slhc
ipv6 ppdev parport_pc lp parport pcspkr i2c_piix4 brd virtio_net
virtio_blk virtio_balloon ata_generic pata_acpi ata_piix libata virtio_pci
[1267812575.162037] Pid: 148, comm: ata/0 Not tainted (2.6.30.9-128 #1)
[1267812575.162037] EIP: 0060:[<c0290fff>] EFLAGS: 00000206 CPU: 0
[1267812575.162037] EIP is at ioread8+0x19/0x2f
[1267812575.162037] EAX: 0001c001 EBX: c05a8020 ECX: 019c6000 EDX: 0000c033
[1267812575.162037] ESI: f6afc000 EDI: 00000000 EBP: f690fd1c ESP: f690fd1c
[1267812575.162037] DS: 007b ES: 007b FS: 00d8 GS: 0000 SS: 0068
[1267812575.162037] CR0: 8005003b CR2: 0cd5d000 CR3: 36578000 CR4: 000006d0
[1267812575.162037] DR0: 00000000 DR1: 00000000 DR2: 00000000 DR3: 00000000
[1267812575.162037] DR6: ffff0ff0 DR7: 00000400
[1267812575.162037] Call Trace:
[1267812575.162037] [<f801f3d9>] vp_interrupt+0x1e/0x99 [virtio_pci]
[1267812575.162037] [<c018b400>] ? __alloc_pages_internal+0xa1/0x387
[1267812575.162037] [<c0174c0b>] handle_IRQ_event+0x52/0x108
[1267812575.162037] [<c017600a>] handle_fasteoi_irq+0x69/0x9b
[1267812575.162037] [<c0104cdb>] handle_irq+0x3b/0x48
[1267812575.162037] [<c0104648>] do_IRQ+0x40/0x83
[1267812575.162037] [<c0103889>] common_interrupt+0x29/0x30
[1267812575.162037] [<c01a84cc>] ? __kmalloc_track_caller+0xbc/0x105
[1267812575.162037] [<c038ee74>] ? __netdev_alloc_skb+0x17/0x34
[1267812575.162037] [<c038e489>] __alloc_skb+0x49/0x114
[1267812575.162037] [<c038ee74>] __netdev_alloc_skb+0x17/0x34
[1267812575.162037] [<f848cd69>] try_fill_recv+0x39/0x11b [virtio_net]
[1267812575.162037] [<f848d801>] virtnet_poll+0x7d/0xcc [virtio_net]
[1267812575.162037] [<c0394192>] net_rx_action+0x92/0x16b
[1267812575.162037] [<c0135878>] __do_softirq+0x8d/0x133
[1267812575.162037] [<c013594f>] do_softirq+0x31/0x3c
[1267812575.162037] [<c0135a3a>] irq_exit+0x29/0x57
[1267812575.162037] [<c0104675>] do_IRQ+0x6d/0x83
[1267812575.162037] [<c0103889>] common_interrupt+0x29/0x30
[1267812575.162037] [<c0400af2>] ? _spin_unlock_irqrestore+0x9/0xf
[1267812575.162037] [<f843aabd>] ata_sff_hsm_move+0x237/0x49d [libata]
[1267812575.162037] [<f843aff3>] ata_pio_task+0x8e/0x9e [libata]
[1267812575.162037] [<c013e8ad>] run_workqueue+0x8a/0x107
[1267812575.162037] [<f843af65>] ? ata_pio_task+0x0/0x9e [libata]
[1267812575.162037] [<c013e9e0>] worker_thread+0xb6/0xc2
[1267812575.162037] [<c0141a53>] ? autoremove_wake_function+0x0/0x33
[1267812575.162037] [<c013e92a>] ? worker_thread+0x0/0xc2
[1267812575.162037] [<c014175a>] kthread+0x45/0x6b
[1267812575.162037] [<c0141715>] ? kthread+0x0/0x6b
[1267812575.162037] [<c0103c77>] kernel_thread_helper+0x7/0x10
[1267987394.820065] Clocksource tsc unstable (delta = 237368126 ns)
reply other threads:[~2009-11-24 8:07 UTC|newest]
Thread overview: [no followups] expand[flat|nested] mbox.gz Atom feed
Reply instructions:
You may reply publicly to this message via plain-text email
using any one of the following methods:
* Save the following mbox file, import it into your mail client,
and reply-to-all from there: mbox
Avoid top-posting and favor interleaved quoting:
https://en.wikipedia.org/wiki/Posting_style#Interleaved_style
* Reply using the --to, --cc, and --in-reply-to
switches of git-send-email(1):
git send-email \
--in-reply-to=4B0B9578.90703@pardus.org.tr \
--to=ozan@pardus.org.tr \
--cc=linux-kernel@vger.kernel.org \
/path/to/YOUR_REPLY
https://kernel.org/pub/software/scm/git/docs/git-send-email.html
* If your mail client supports setting the In-Reply-To header
via mailto: links, try the mailto: link
Be sure your reply has a Subject: header at the top and a blank line
before the message body.
This is an external index of several public inboxes,
see mirroring instructions on how to clone and mirror
all data and code used by this external index.