* Re: System time drifts when processor idle. [not found] <AANLkTi=ivkOHRYwLy5FDg3RnK18+opjGd9XsxC7yZqi7@mail.gmail.com> @ 2010-08-21 3:58 ` Lin Ming 2010-08-23 8:46 ` jean-philippe francois 0 siblings, 1 reply; 16+ messages in thread From: Lin Ming @ 2010-08-21 3:58 UTC (permalink / raw) To: jean-philippe francois, H. Peter Anvin; +Cc: linux-acpi, LKML On Fri, Aug 20, 2010 at 8:55 AM, jean-philippe francois <jp.francois@cynove.com> wrote: > Hi, > > Please correct me if I am sending this to the wrong list. LKML is better for this issue. Added. Lin Ming > > I would like to debug the following issue, which I suspect is related > to cpu losing track of time when going idle. > > When I run the following script : > > #!/bin/bash > # set hwclock to system clock to start > # the log file with the same time > hwclock -w > #start with a fresh logfile > touch clocktest.log > echo START > clocktest.log > while [[ true ]] > do > systime=$(date) > hwtime=$(hwclock -r) > echo "$systime | $hwtime" >> clocktest.log > sleep 20 > done > > Expected output : > On each line, the system time (left) and hardware time (right) > should be roughly the same. Time delta between each line should be > around 20 seconds > > Observed output : > This is an edited version of the real logfile so that it fits on one > line. the date was removed. > START > 15:09:43 (UTC+0200) | 15:09:44 CEST -0.500555 secondes > 15:10:04 (UTC+0200) | 15:10:05 CEST -1.001562 secondes > 15:10:25 (UTC+0200) | 15:10:26 CEST -0.985944 secondes > 15:10:46 (UTC+0200) | 15:15:46 CEST -0.032792 secondes <-- 5 minute lag ! > 15:11:06 (UTC+0200) | 15:16:07 CEST -0.985926 secondes > 15:11:27 (UTC+0200) | 15:16:28 CEST -1.001539 secondes > 15:11:48 (UTC+0200) | 15:16:49 CEST -0.985969 secondes > 15:12:09 (UTC+0200) | 15:17:10 CEST -0.985977 secondes > 15:12:30 (UTC+0200) | 15:17:31 CEST -1.001544 secondes > 15:12:51 (UTC+0200) | 15:17:52 CEST -0.985920 secondes > 15:13:12 (UTC+0200) | 15:18:13 CEST -0.985939 secondes > 15:13:33 (UTC+0200) | 15:18:34 CEST -1.001581 secondes > 15:13:54 (UTC+0200) | 15:18:55 CEST -0.985917 secondes > 15:14:15 (UTC+0200) | 15:29:15 CEST -0.079685 secondes <-- add > another 10 minute > 15:14:35 (UTC+0200) | 15:29:36 CEST -1.001568 secondes > 15:14:56 (UTC+0200) | 15:29:57 CEST -0.985952 secondes > > As you can see, after 20 minutes without touching the computer, the > system time is late by 15 minutes. > This was tested on ubuntu 10.04 with a 2.6.32 "vanilla" kernel where > "vanilla" means ubuntu packaged > upstream kernel closest to the distribution shipped kernel. > > How can I debug and possibly fix this issue ? > -- > To unsubscribe from this list: send the line "unsubscribe linux-acpi" in > the body of a message to majordomo@vger.kernel.org > More majordomo info at http://vger.kernel.org/majordomo-info.html > ^ permalink raw reply [flat|nested] 16+ messages in thread
* Re: System time drifts when processor idle. 2010-08-21 3:58 ` System time drifts when processor idle Lin Ming @ 2010-08-23 8:46 ` jean-philippe francois 2010-08-23 22:17 ` john stultz 0 siblings, 1 reply; 16+ messages in thread From: jean-philippe francois @ 2010-08-23 8:46 UTC (permalink / raw) To: Lin Ming; +Cc: H. Peter Anvin, linux-acpi, LKML 2010/8/21 Lin Ming <lin@ming.vg>: > On Fri, Aug 20, 2010 at 8:55 AM, jean-philippe francois > <jp.francois@cynove.com> wrote: >> Hi, >> >> Please correct me if I am sending this to the wrong list. > > LKML is better for this issue. Added. > Thank you. I have been looking at the ML archives, and it seems there has been issue related to timekeeping lately. So I tested my script with a decently recent kernel : 2.6.36-rc1. The timekeeping bug described below still exists. >> >> I would like to debug the following issue, which I suspect is related >> to cpu losing track of time when going idle. >> >> When I run the following script : >> >> #!/bin/bash >> # set hwclock to system clock to start >> # the log file with the same time >> hwclock -w >> #start with a fresh logfile >> touch clocktest.log >> echo START > clocktest.log >> while [[ true ]] >> do >> systime=$(date) >> hwtime=$(hwclock -r) >> echo "$systime | $hwtime" >> clocktest.log >> sleep 20 >> done >> >> Expected output : >> On each line, the system time (left) and hardware time (right) >> should be roughly the same. Time delta between each line should be >> around 20 seconds >> >> Observed output : >> This is an edited version of the real logfile so that it fits on one >> line. the date was removed. >> START >> 15:09:43 (UTC+0200) | 15:09:44 CEST -0.500555 secondes >> 15:10:04 (UTC+0200) | 15:10:05 CEST -1.001562 secondes >> 15:10:25 (UTC+0200) | 15:10:26 CEST -0.985944 secondes >> 15:10:46 (UTC+0200) | 15:15:46 CEST -0.032792 secondes <-- 5 minute lag ! >> 15:11:06 (UTC+0200) | 15:16:07 CEST -0.985926 secondes >> 15:11:27 (UTC+0200) | 15:16:28 CEST -1.001539 secondes >> 15:11:48 (UTC+0200) | 15:16:49 CEST -0.985969 secondes >> 15:12:09 (UTC+0200) | 15:17:10 CEST -0.985977 secondes >> 15:12:30 (UTC+0200) | 15:17:31 CEST -1.001544 secondes >> 15:12:51 (UTC+0200) | 15:17:52 CEST -0.985920 secondes >> 15:13:12 (UTC+0200) | 15:18:13 CEST -0.985939 secondes >> 15:13:33 (UTC+0200) | 15:18:34 CEST -1.001581 secondes >> 15:13:54 (UTC+0200) | 15:18:55 CEST -0.985917 secondes >> 15:14:15 (UTC+0200) | 15:29:15 CEST -0.079685 secondes <-- add >> another 10 minute >> 15:14:35 (UTC+0200) | 15:29:36 CEST -1.001568 secondes >> 15:14:56 (UTC+0200) | 15:29:57 CEST -0.985952 secondes >> >> As you can see, after 20 minutes without touching the computer, the >> system time is late by 15 minutes. >> This was tested on ubuntu 10.04 with a 2.6.32 "vanilla" kernel where >> "vanilla" means ubuntu packaged >> upstream kernel closest to the distribution shipped kernel. >> ^ permalink raw reply [flat|nested] 16+ messages in thread
* Re: System time drifts when processor idle. 2010-08-23 8:46 ` jean-philippe francois @ 2010-08-23 22:17 ` john stultz 2010-08-24 7:08 ` jean-philippe francois 0 siblings, 1 reply; 16+ messages in thread From: john stultz @ 2010-08-23 22:17 UTC (permalink / raw) To: jean-philippe francois; +Cc: Lin Ming, H. Peter Anvin, linux-acpi, LKML On Mon, Aug 23, 2010 at 1:46 AM, jean-philippe francois <jp.francois@cynove.com> wrote: > 2010/8/21 Lin Ming <lin@ming.vg>: >> On Fri, Aug 20, 2010 at 8:55 AM, jean-philippe francois >> <jp.francois@cynove.com> wrote: >>> Hi, >>> >>> Please correct me if I am sending this to the wrong list. >> >> LKML is better for this issue. Added. >> > > Thank you. I have been looking at the ML archives, and it seems there > has been issue related to timekeeping lately. So I tested my script > with a decently recent kernel : 2.6.36-rc1. > > The timekeeping bug described below still exists. >>> >>> I would like to debug the following issue, which I suspect is related >>> to cpu losing track of time when going idle. >>> >>> When I run the following script : >>> >>> #!/bin/bash >>> # set hwclock to system clock to start >>> # the log file with the same time >>> hwclock -w >>> #start with a fresh logfile >>> touch clocktest.log >>> echo START > clocktest.log >>> while [[ true ]] >>> do >>> systime=$(date) >>> hwtime=$(hwclock -r) >>> echo "$systime | $hwtime" >> clocktest.log >>> sleep 20 >>> done >>> >>> Expected output : >>> On each line, the system time (left) and hardware time (right) >>> should be roughly the same. Time delta between each line should be >>> around 20 seconds >>> >>> Observed output : >>> This is an edited version of the real logfile so that it fits on one >>> line. the date was removed. >>> START >>> 15:09:43 (UTC+0200) | 15:09:44 CEST -0.500555 secondes >>> 15:10:04 (UTC+0200) | 15:10:05 CEST -1.001562 secondes >>> 15:10:25 (UTC+0200) | 15:10:26 CEST -0.985944 secondes >>> 15:10:46 (UTC+0200) | 15:15:46 CEST -0.032792 secondes <-- 5 minute lag ! >>> 15:11:06 (UTC+0200) | 15:16:07 CEST -0.985926 secondes >>> 15:11:27 (UTC+0200) | 15:16:28 CEST -1.001539 secondes >>> 15:11:48 (UTC+0200) | 15:16:49 CEST -0.985969 secondes >>> 15:12:09 (UTC+0200) | 15:17:10 CEST -0.985977 secondes >>> 15:12:30 (UTC+0200) | 15:17:31 CEST -1.001544 secondes >>> 15:12:51 (UTC+0200) | 15:17:52 CEST -0.985920 secondes >>> 15:13:12 (UTC+0200) | 15:18:13 CEST -0.985939 secondes >>> 15:13:33 (UTC+0200) | 15:18:34 CEST -1.001581 secondes >>> 15:13:54 (UTC+0200) | 15:18:55 CEST -0.985917 secondes >>> 15:14:15 (UTC+0200) | 15:29:15 CEST -0.079685 secondes <-- add >>> another 10 minute >>> 15:14:35 (UTC+0200) | 15:29:36 CEST -1.001568 secondes >>> 15:14:56 (UTC+0200) | 15:29:57 CEST -0.985952 secondes >>> >>> As you can see, after 20 minutes without touching the computer, the >>> system time is late by 15 minutes. >>> This was tested on ubuntu 10.04 with a 2.6.32 "vanilla" kernel where >>> "vanilla" means ubuntu packaged >>> upstream kernel closest to the distribution shipped kernel. Could you provide the output of: cat /sys/devices/system/clocksource/clocksource0/available_clocksource cat /sys/devices/system/clocksource/clocksource0/current_clocksource I assume you're using the TSC, and hitting the halt-in-c3 issue, but I'm curious why the clocksource watchdog isn't catching this and dropping you back to a more stable clocksource. thanks -john ^ permalink raw reply [flat|nested] 16+ messages in thread
* Re: System time drifts when processor idle. 2010-08-23 22:17 ` john stultz @ 2010-08-24 7:08 ` jean-philippe francois 2010-08-27 14:12 ` jean-philippe francois 0 siblings, 1 reply; 16+ messages in thread From: jean-philippe francois @ 2010-08-24 7:08 UTC (permalink / raw) To: john stultz; +Cc: Lin Ming, H. Peter Anvin, linux-acpi, LKML [-- Attachment #1: Type: text/plain, Size: 501 bytes --] > > Could you provide the output of: > cat /sys/devices/system/clocksource/clocksource0/available_clocksource hpet acpi_pm > cat /sys/devices/system/clocksource/clocksource0/current_clocksource > hpet > I assume you're using the TSC, and hitting the halt-in-c3 issue, but > I'm curious why the clocksource watchdog isn't catching this and > dropping you back to a more stable clocksource. > I also attached the dmesg output. Thank you for your help. Jean-Philippe François [-- Attachment #2: dmesg.log --] [-- Type: text/x-log, Size: 57176 bytes --] [ 0.000000] Initializing cgroup subsys cpuset [ 0.000000] Initializing cgroup subsys cpu [ 0.000000] Linux version 2.6.32-24-generic (buildd@vernadsky) (gcc version 4.4.3 (Ubuntu 4.4.3-4ubuntu5) ) #41-Ubuntu SMP Thu Aug 19 01:12:52 UTC 2010 (Ubuntu 2.6.32-24.41-generic 2.6.32.15+drm33.5) [ 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 - 000000000009b400 (usable) [ 0.000000] BIOS-e820: 000000000009b400 - 00000000000a0000 (reserved) [ 0.000000] BIOS-e820: 00000000000d6000 - 00000000000d8000 (reserved) [ 0.000000] BIOS-e820: 00000000000e0000 - 0000000000100000 (reserved) [ 0.000000] BIOS-e820: 0000000000100000 - 00000000bfed0000 (usable) [ 0.000000] BIOS-e820: 00000000bfed0000 - 00000000bfedc000 (ACPI NVS) [ 0.000000] BIOS-e820: 00000000bfedc000 - 00000000c0000000 (reserved) [ 0.000000] BIOS-e820: 00000000e0000000 - 00000000f0000000 (reserved) [ 0.000000] BIOS-e820: 00000000fec00000 - 00000000fec10000 (reserved) [ 0.000000] BIOS-e820: 00000000fed00000 - 00000000fed00400 (reserved) [ 0.000000] BIOS-e820: 00000000fed14000 - 00000000fed1a000 (reserved) [ 0.000000] BIOS-e820: 00000000fed1c000 - 00000000fed90000 (reserved) [ 0.000000] BIOS-e820: 00000000fee00000 - 00000000fee01000 (reserved) [ 0.000000] BIOS-e820: 00000000ff000000 - 0000000100000000 (reserved) [ 0.000000] DMI present. [ 0.000000] last_pfn = 0xbfed0 max_arch_pfn = 0x100000 [ 0.000000] MTRR default type: uncachable [ 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 000000000 mask F80000000 write-back [ 0.000000] 1 base 080000000 mask FC0000000 write-back [ 0.000000] 2 base 0BFF00000 mask FFFF00000 uncachable [ 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 0x7040600070406, new 0x7010600070106 [ 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 - 000000000009b400 (usable) [ 0.000000] modified: 000000000009b400 - 00000000000a0000 (reserved) [ 0.000000] modified: 00000000000d6000 - 00000000000d8000 (reserved) [ 0.000000] modified: 00000000000e0000 - 0000000000100000 (reserved) [ 0.000000] modified: 0000000000100000 - 00000000bfed0000 (usable) [ 0.000000] modified: 00000000bfed0000 - 00000000bfedc000 (ACPI NVS) [ 0.000000] modified: 00000000bfedc000 - 00000000c0000000 (reserved) [ 0.000000] modified: 00000000e0000000 - 00000000f0000000 (reserved) [ 0.000000] modified: 00000000fec00000 - 00000000fec10000 (reserved) [ 0.000000] modified: 00000000fed00000 - 00000000fed00400 (reserved) [ 0.000000] modified: 00000000fed14000 - 00000000fed1a000 (reserved) [ 0.000000] modified: 00000000fed1c000 - 00000000fed90000 (reserved) [ 0.000000] modified: 00000000fee00000 - 00000000fee01000 (reserved) [ 0.000000] modified: 00000000ff000000 - 0000000100000000 (reserved) [ 0.000000] initial memory mapped : 0 - 00c00000 [ 0.000000] init_memory_mapping: 0000000000000000-00000000377fe000 [ 0.000000] Using x86 segment limits to approximate NX protection [ 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: 7f810000 - 7ffef157 [ 0.000000] Allocated new RAMDISK: 008e2000 - 010c1157 [ 0.000000] Move RAMDISK from 000000007f810000 - 000000007ffef156 to 008e2000 - 010c1156 [ 0.000000] ACPI: RSDP 000f8000 00024 (v02 PTLTD ) [ 0.000000] ACPI: XSDT bfed24d6 0007C (v01 FSC PC 06040000 LTP 00000000) [ 0.000000] ACPI: FACP bfed8c6c 000F4 (v03 INTEL CRESTLNE 06040000 ALAN 00000001) [ 0.000000] ACPI: DSDT bfed3ae1 05117 (v02 ECS F44 06040000 INTL 20050624) [ 0.000000] ACPI: FACS bfedbfc0 00040 [ 0.000000] ACPI: HPET bfed8d60 00038 (v01 INTEL CRESTLNE 06040000 LOHR 0000005A) [ 0.000000] ACPI: MCFG bfed8d98 0003C (v01 INTEL CRESTLNE 06040000 LOHR 0000005A) [ 0.000000] ACPI: TMOR bfed8dd4 00026 (v01 PTLTD 06040000 PTL 00000003) [ 0.000000] ACPI: APIC bfed8dfa 00068 (v01 PTLTD ? APIC 06040000 LTP 00000000) [ 0.000000] ACPI: BOOT bfed8e62 00028 (v01 PTLTD $SBFTBL$ 06040000 LTP 00000001) [ 0.000000] ACPI: SLIC bfed8e8a 00176 (v01 FSC PC 06040000 LTP 00000000) [ 0.000000] ACPI: SSDT bfed3804 002DD (v01 SataRe SataAhci 00001000 INTL 20050624) [ 0.000000] ACPI: SSDT bfed2b0e 0025F (v01 PmRef Cpu0Tst 00003000 INTL 20050624) [ 0.000000] ACPI: SSDT bfed2a68 000A6 (v01 PmRef Cpu1Tst 00003000 INTL 20050624) [ 0.000000] ACPI: SSDT bfed2552 00516 (v01 PmRef CpuPm 00003000 INTL 20050624) [ 0.000000] ACPI: Local APIC address 0xfee00000 [ 0.000000] 2182MB 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 - 00008ddeb8] TEXT DATA BSS ==> [0000100000 - 00008ddeb8] [ 0.000000] #4 [000009b400 - 0000100000] BIOS reserved ==> [000009b400 - 0000100000] [ 0.000000] #5 [00008de000 - 00008e1140] BRK ==> [00008de000 - 00008e1140] [ 0.000000] #6 [0000007000 - 0000008000] PGTABLE ==> [0000007000 - 0000008000] [ 0.000000] #7 [00008e2000 - 00010c1157] NEW RAMDISK ==> [00008e2000 - 00010c1157] [ 0.000000] #8 [0000008000 - 000000f000] BOOTMAP ==> [0000008000 - 000000f000] [ 0.000000] found SMP MP-table at [c00f8030] f8030 [ 0.000000] Zone PFN ranges: [ 0.000000] DMA 0x00000000 -> 0x00001000 [ 0.000000] Normal 0x00001000 -> 0x000377fe [ 0.000000] HighMem 0x000377fe -> 0x000bfed0 [ 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 -> 0x0000009b [ 0.000000] 0: 0x00000100 -> 0x000bfed0 [ 0.000000] On node 0 totalpages: 786023 [ 0.000000] free_area_init_node: node 0, pgdat c079a780, node_mem_map c10c3000 [ 0.000000] DMA zone: 32 pages used for memmap [ 0.000000] DMA zone: 0 pages reserved [ 0.000000] DMA zone: 3959 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: 4366 pages used for memmap [ 0.000000] HighMem zone: 554436 pages, LIFO batch:31 [ 0.000000] Using APIC driver default [ 0.000000] ACPI: PM-Timer IO Port: 0x1008 [ 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_NMI (acpi_id[0x00] high edge lint[0x1]) [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0x01] high edge lint[0x1]) [ 0.000000] ACPI: IOAPIC (id[0x02] address[0xfec00000] gsi_base[0]) [ 0.000000] IOAPIC[0]: apic_id 2, version 32, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 high edge) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: IRQ0 used by override. [ 0.000000] ACPI: IRQ2 used by override. [ 0.000000] ACPI: IRQ9 used by override. [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] SMP: Allowing 2 CPUs, 0 hotplug CPUs [ 0.000000] nr_irqs_gsi: 24 [ 0.000000] PM: Registered nosave memory: 0000000000002000 - 0000000000006000 [ 0.000000] PM: Registered nosave memory: 000000000009b000 - 000000000009c000 [ 0.000000] PM: Registered nosave memory: 000000000009c000 - 00000000000a0000 [ 0.000000] PM: Registered nosave memory: 00000000000a0000 - 00000000000d6000 [ 0.000000] PM: Registered nosave memory: 00000000000d6000 - 00000000000d8000 [ 0.000000] PM: Registered nosave memory: 00000000000d8000 - 00000000000e0000 [ 0.000000] PM: Registered nosave memory: 00000000000e0000 - 0000000000100000 [ 0.000000] Allocating PCI resources starting at c0000000 (gap: c0000000:20000000) [ 0.000000] Booting paravirtualized kernel on bare hardware [ 0.000000] NR_CPUS:8 nr_cpumask_bits:8 nr_cpu_ids:2 nr_node_ids:1 [ 0.000000] PERCPU: Embedded 14 pages/cpu @c2c00000 s36056 r0 d21288 u2097152 [ 0.000000] pcpu-alloc: s36056 r0 d21288 u2097152 alloc=1*4194304 [ 0.000000] pcpu-alloc: [0] 0 1 [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 779881 [ 0.000000] Kernel command line: root=UUID=d6f01bdd-8503-4992-bc4e-a511f74318fb ro quiet splash [ 0.000000] PID hash table entries: 4096 (order: 2, 16384 bytes) [ 0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes) [ 0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes) [ 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] allocated 15722560 bytes of page_cgroup [ 0.000000] please try 'cgroup_disable=memory' option if you don't want memory cgroups [ 0.000000] Initializing HighMem for node 0 (000377fe:000bfed0) [ 0.000000] Memory: 3085996k/3144512k available (4679k kernel code, 57072k reserved, 2124k data, 660k init, 2235208k highmem) [ 0.000000] virtual kernel memory layout: [ 0.000000] fixmap : 0xfff1d000 - 0xfffff000 ( 904 kB) [ 0.000000] pkmap : 0xff800000 - 0xffc00000 (4096 kB) [ 0.000000] vmalloc : 0xf7ffe000 - 0xff7fe000 ( 120 MB) [ 0.000000] lowmem : 0xc0000000 - 0xf77fe000 ( 887 MB) [ 0.000000] .init : 0xc07a5000 - 0xc084a000 ( 660 kB) [ 0.000000] .data : 0xc0591e33 - 0xc07a4e88 (2124 kB) [ 0.000000] .text : 0xc0100000 - 0xc0591e33 (4679 kB) [ 0.000000] Checking if this processor honours the WP bit even in supervisor mode...Ok. [ 0.000000] SLUB: Genslabs=13, HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 [ 0.000000] Hierarchical RCU implementation. [ 0.000000] NR_IRQS:2304 nr_irqs:424 [ 0.000000] Extended CMOS year: 2000 [ 0.000000] Console: colour VGA+ 80x25 [ 0.000000] console [tty0] enabled [ 0.000000] hpet clockevent registered [ 0.000000] HPET: 3 timers in total, 0 timers will be used for per-cpu timer [ 0.000000] Fast TSC calibration using PIT [ 0.000000] Detected 2493.552 MHz processor. [ 0.004005] Calibrating delay loop (skipped), value calculated using timer frequency.. 4987.10 BogoMIPS (lpj=9974208) [ 0.004020] Security Framework initialized [ 0.004036] AppArmor: AppArmor initialized [ 0.004041] Mount-cache hash table entries: 512 [ 0.004147] Initializing cgroup subsys ns [ 0.004151] Initializing cgroup subsys cpuacct [ 0.004154] Initializing cgroup subsys memory [ 0.004160] Initializing cgroup subsys devices [ 0.004162] Initializing cgroup subsys freezer [ 0.004164] Initializing cgroup subsys net_cls [ 0.004181] CPU: L1 I cache: 32K, L1 D cache: 32K [ 0.004183] CPU: L2 cache: 6144K [ 0.004186] CPU: Physical Processor ID: 0 [ 0.004187] CPU: Processor Core ID: 0 [ 0.004190] mce: CPU supports 6 MCE banks [ 0.004197] CPU0: Thermal monitoring enabled (TM2) [ 0.004200] using mwait in idle threads. [ 0.004206] Performance Events: Core2 events, Intel PMU driver. [ 0.004213] ... version: 2 [ 0.004214] ... bit width: 40 [ 0.004216] ... generic registers: 2 [ 0.004217] ... value mask: 000000ffffffffff [ 0.004219] ... max period: 000000007fffffff [ 0.004220] ... fixed-purpose events: 3 [ 0.004221] ... event mask: 0000000700000003 [ 0.004225] Checking 'hlt' instruction... OK. [ 0.022257] ACPI: Core revision 20090903 [ 0.031066] ftrace: converting mcount calls to 0f 1f 44 00 00 [ 0.031073] ftrace: allocating 21780 entries in 43 pages [ 0.032040] Enabling APIC mode: Flat. Using 1 I/O APICs [ 0.032385] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.074641] CPU0: Intel(R) Core(TM)2 Duo CPU T9300 @ 2.50GHz stepping 06 [ 0.076001] Booting processor 1 APIC 0x1 ip 0x6000 [ 0.008000] Initializing CPU#1 [ 0.008000] CPU: L1 I cache: 32K, L1 D cache: 32K [ 0.008000] CPU: L2 cache: 6144K [ 0.008000] CPU: Physical Processor ID: 0 [ 0.008000] CPU: Processor Core ID: 1 [ 0.008000] CPU1: Thermal monitoring enabled (TM2) [ 0.160078] CPU1: Intel(R) Core(TM)2 Duo CPU T9300 @ 2.50GHz stepping 06 [ 0.160089] checking TSC synchronization [CPU#0 -> CPU#1]: passed. [ 0.164015] Brought up 2 CPUs [ 0.164018] Total of 2 processors activated (9974.55 BogoMIPS). [ 0.164896] CPU0 attaching sched-domain: [ 0.164899] domain 0: span 0-1 level MC [ 0.164901] groups: 0 1 [ 0.164906] CPU1 attaching sched-domain: [ 0.164908] domain 0: span 0-1 level MC [ 0.164910] groups: 1 0 [ 0.164992] devtmpfs: initialized [ 0.164992] regulator: core version 0.5 [ 0.164992] Time: 8:48:21 Date: 08/24/10 [ 0.164992] NET: Registered protocol family 16 [ 0.164992] Trying to unpack rootfs image as initramfs... [ 0.164992] EISA bus registered [ 0.164992] ACPI: bus type pci registered [ 0.164992] PCI: MCFG configuration 0: base e0000000 segment 0 buses 0 - 255 [ 0.164992] PCI: MCFG area at e0000000 reserved in E820 [ 0.164992] PCI: Using MMCONFIG for extended config space [ 0.164992] PCI: Using configuration type 1 for base access [ 0.168079] bio: create slab <bio-0> at 0 [ 0.168793] ACPI: EC: Look up EC in DSDT [ 0.170758] ACPI: BIOS _OSI(Linux) query ignored [ 0.248048] ACPI: Interpreter enabled [ 0.248062] ACPI: (supports S0 S3 S4 S5) [ 0.248085] ACPI: Using IOAPIC for interrupt routing [ 0.292125] ACPI: EC: GPE = 0x11, I/O: command/status = 0x66, data = 0x62 [ 0.292434] ACPI: No dock devices found. [ 0.292958] ACPI: PCI Root Bridge [PCI0] (0000:00) [ 0.293065] pci 0000:00:01.0: PME# supported from D0 D3hot D3cold [ 0.293068] pci 0000:00:01.0: PME# disabled [ 0.293154] pci 0000:00:1a.0: reg 20 io port: [0x1800-0x181f] [ 0.293221] pci 0000:00:1a.1: reg 20 io port: [0x1820-0x183f] [ 0.293292] pci 0000:00:1a.7: reg 10 32bit mmio: [0xf0804800-0xf0804bff] [ 0.293356] pci 0000:00:1a.7: PME# supported from D0 D3hot D3cold [ 0.293361] pci 0000:00:1a.7: PME# disabled [ 0.293415] pci 0000:00:1b.0: reg 10 64bit mmio: [0xf0800000-0xf0803fff] [ 0.293477] pci 0000:00:1b.0: PME# supported from D0 D3hot D3cold [ 0.293481] pci 0000:00:1b.0: PME# disabled [ 0.293576] pci 0000:00:1c.0: PME# supported from D0 D3hot D3cold [ 0.293581] pci 0000:00:1c.0: PME# disabled [ 0.293678] pci 0000:00:1c.1: PME# supported from D0 D3hot D3cold [ 0.293682] pci 0000:00:1c.1: PME# disabled [ 0.293781] pci 0000:00:1c.2: PME# supported from D0 D3hot D3cold [ 0.293786] pci 0000:00:1c.2: PME# disabled [ 0.293882] pci 0000:00:1c.3: PME# supported from D0 D3hot D3cold [ 0.293887] pci 0000:00:1c.3: PME# disabled [ 0.293984] pci 0000:00:1c.4: PME# supported from D0 D3hot D3cold [ 0.293988] pci 0000:00:1c.4: PME# disabled [ 0.294085] pci 0000:00:1c.5: PME# supported from D0 D3hot D3cold [ 0.294090] pci 0000:00:1c.5: PME# disabled [ 0.294153] pci 0000:00:1d.0: reg 20 io port: [0x1840-0x185f] [ 0.294219] pci 0000:00:1d.1: reg 20 io port: [0x1860-0x187f] [ 0.294285] pci 0000:00:1d.2: reg 20 io port: [0x1880-0x189f] [ 0.294355] pci 0000:00:1d.7: reg 10 32bit mmio: [0xf0804c00-0xf0804fff] [ 0.294418] pci 0000:00:1d.7: PME# supported from D0 D3hot D3cold [ 0.294424] pci 0000:00:1d.7: PME# disabled [ 0.294598] pci 0000:00:1f.0: quirk: region 1000-107f claimed by ICH6 ACPI/GPIO/TCO [ 0.294602] pci 0000:00:1f.0: quirk: region 1180-11bf claimed by ICH6 GPIO [ 0.294606] pci 0000:00:1f.0: ICH7 LPC Generic IO decode 1 PIO at 0068 (mask 0007) [ 0.294610] pci 0000:00:1f.0: ICH7 LPC Generic IO decode 2 PIO at 0260 (mask 0003) [ 0.294667] pci 0000:00:1f.1: reg 10 io port: [0x00-0x07] [ 0.294674] pci 0000:00:1f.1: reg 14 io port: [0x00-0x03] [ 0.294682] pci 0000:00:1f.1: reg 18 io port: [0x00-0x07] [ 0.294689] pci 0000:00:1f.1: reg 1c io port: [0x00-0x03] [ 0.294697] pci 0000:00:1f.1: reg 20 io port: [0x18a0-0x18af] [ 0.294770] pci 0000:00:1f.2: reg 10 io port: [0x18d8-0x18df] [ 0.294777] pci 0000:00:1f.2: reg 14 io port: [0x18cc-0x18cf] [ 0.294785] pci 0000:00:1f.2: reg 18 io port: [0x18d0-0x18d7] [ 0.294793] pci 0000:00:1f.2: reg 1c io port: [0x18c8-0x18cb] [ 0.294800] pci 0000:00:1f.2: reg 20 io port: [0x18e0-0x18ff] [ 0.294808] pci 0000:00:1f.2: reg 24 32bit mmio: [0xf0804000-0xf08047ff] [ 0.294852] pci 0000:00:1f.2: PME# supported from D3hot [ 0.294857] pci 0000:00:1f.2: PME# disabled [ 0.294889] pci 0000:00:1f.3: reg 10 32bit mmio: [0x000000-0x0000ff] [ 0.294914] pci 0000:00:1f.3: reg 20 io port: [0x1c00-0x1c1f] [ 0.294985] pci 0000:01:00.0: reg 10 64bit mmio pref: [0xd0000000-0xdfffffff] [ 0.294999] pci 0000:01:00.0: reg 18 64bit mmio: [0xcfef0000-0xcfefffff] [ 0.295006] pci 0000:01:00.0: reg 20 io port: [0x2000-0x20ff] [ 0.295019] pci 0000:01:00.0: reg 30 32bit mmio pref: [0x000000-0x01ffff] [ 0.295049] pci 0000:01:00.0: supports D1 D2 [ 0.295100] pci 0000:01:00.1: reg 10 64bit mmio: [0xcfeec000-0xcfeeffff] [ 0.295159] pci 0000:01:00.1: supports D1 D2 [ 0.295229] pci 0000:00:01.0: bridge io port: [0x2000-0x2fff] [ 0.295232] pci 0000:00:01.0: bridge 32bit mmio: [0xcfe00000-0xcfefffff] [ 0.295237] pci 0000:00:01.0: bridge 64bit mmio pref: [0xd0000000-0xdfffffff] [ 0.295296] pci 0000:00:1c.0: bridge io port: [0xf000-0xffff] [ 0.295301] pci 0000:00:1c.0: bridge 32bit mmio: [0xfb000000-0xfcffffff] [ 0.295370] pci 0000:04:00.0: reg 10 32bit mmio: [0xf0300000-0xf03003ff] [ 0.295389] pci 0000:04:00.0: reg 18 io port: [0x3000-0x307f] [ 0.295425] pci 0000:04:00.0: reg 30 32bit mmio pref: [0x000000-0x00ffff] [ 0.295543] pci 0000:00:1c.1: bridge io port: [0x3000-0x3fff] [ 0.295548] pci 0000:00:1c.1: bridge 32bit mmio: [0xf0300000-0xf03fffff] [ 0.295646] pci 0000:05:00.0: reg 10 64bit mmio: [0xf0200000-0xf0201fff] [ 0.295764] pci 0000:05:00.0: PME# supported from D0 D3hot D3cold [ 0.295772] pci 0000:05:00.0: PME# disabled [ 0.295858] pci 0000:00:1c.2: bridge 32bit mmio: [0xf0200000-0xf02fffff] [ 0.295940] pci 0000:06:00.0: reg 10 io port: [0x4000-0x40ff] [ 0.295969] pci 0000:06:00.0: reg 18 64bit mmio: [0xf0500000-0xf0500fff] [ 0.296008] pci 0000:06:00.0: reg 30 32bit mmio pref: [0x000000-0x01ffff] [ 0.296071] pci 0000:06:00.0: supports D1 D2 [ 0.296073] pci 0000:06:00.0: PME# supported from D1 D2 D3hot D3cold [ 0.296078] pci 0000:06:00.0: PME# disabled [ 0.296157] pci 0000:00:1c.3: bridge io port: [0x4000-0x4fff] [ 0.296162] pci 0000:00:1c.3: bridge 32bit mmio: [0xf0500000-0xf05fffff] [ 0.296252] pci 0000:07:00.0: reg 10 64bit mmio: [0xf0402000-0xf040207f] [ 0.296273] pci 0000:07:00.0: reg 18 64bit mmio: [0xf0400000-0xf0401fff] [ 0.296285] pci 0000:07:00.0: reg 20 io port: [0x5000-0x507f] [ 0.296357] pci 0000:07:00.0: supports D1 D2 [ 0.296432] pci 0000:00:1c.4: bridge io port: [0x5000-0x5fff] [ 0.296437] pci 0000:00:1c.4: bridge 32bit mmio: [0xf0400000-0xf04fffff] [ 0.296564] pci 0000:08:00.0: reg 24 32bit mmio: [0xf0600000-0xf0601fff] [ 0.296616] pci 0000:08:00.0: PME# supported from D3hot [ 0.296622] pci 0000:08:00.0: PME# disabled [ 0.296692] pci 0000:08:00.1: reg 10 io port: [0x6020-0x6027] [ 0.296704] pci 0000:08:00.1: reg 14 io port: [0x6014-0x6017] [ 0.296715] pci 0000:08:00.1: reg 18 io port: [0x6018-0x601f] [ 0.296726] pci 0000:08:00.1: reg 1c io port: [0x6010-0x6013] [ 0.296737] pci 0000:08:00.1: reg 20 io port: [0x6000-0x600f] [ 0.296866] pci 0000:00:1c.5: bridge io port: [0x6000-0x6fff] [ 0.296871] pci 0000:00:1c.5: bridge 32bit mmio: [0xf0600000-0xf06fffff] [ 0.296927] pci 0000:09:04.0: reg 10 32bit mmio: [0xf0701000-0xf0701fff] [ 0.296935] pci 0000:09:04.0: reg 14 32bit mmio: [0xf0700000-0xf07007ff] [ 0.296987] pci 0000:09:04.0: supports D1 D2 [ 0.296989] pci 0000:09:04.0: PME# supported from D0 D1 D2 D3hot D3cold [ 0.296993] pci 0000:09:04.0: PME# disabled [ 0.297063] pci 0000:00:1e.0: transparent bridge [ 0.297070] pci 0000:00:1e.0: bridge 32bit mmio: [0xf0700000-0xf07fffff] [ 0.297122] pci_bus 0000:00: on NUMA node 0 [ 0.297126] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT] [ 0.297300] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PEGP._PRT] [ 0.297366] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.RP01._PRT] [ 0.297427] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.RP02._PRT] [ 0.297488] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.RP03._PRT] [ 0.297549] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.RP04._PRT] [ 0.297611] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.RP05._PRT] [ 0.297672] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.RP06._PRT] [ 0.297753] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PCIB._PRT] [ 0.306795] ACPI: PCI Interrupt Link [LNKA] (IRQs 1 3 4 *5 6 7 10 12 14 15) [ 0.306878] ACPI: PCI Interrupt Link [LNKB] (IRQs 1 3 4 5 6 7 11 12 14 15) *10 [ 0.306960] ACPI: PCI Interrupt Link [LNKC] (IRQs 1 3 4 5 6 *7 10 12 14 15) [ 0.307041] ACPI: PCI Interrupt Link [LNKD] (IRQs 1 3 4 5 6 7 11 12 14 15) *10 [ 0.307122] ACPI: PCI Interrupt Link [LNKE] (IRQs 1 3 4 5 6 7 10 12 14 15) *11 [ 0.307203] ACPI: PCI Interrupt Link [LNKF] (IRQs 1 3 4 5 6 7 *11 12 14 15) [ 0.307286] ACPI: PCI Interrupt Link [LNKG] (IRQs 1 3 4 5 6 7 10 12 14 15) *11 [ 0.307366] ACPI: PCI Interrupt Link [LNKH] (IRQs 1 3 4 5 6 7 11 12 14 15) *10 [ 0.307466] vgaarb: device added: PCI:0000:01:00.0,decodes=io+mem,owns=io+mem,locks=none [ 0.307472] vgaarb: loaded [ 0.307578] SCSI subsystem initialized [ 0.307655] libata version 3.00 loaded. [ 0.307716] usbcore: registered new interface driver usbfs [ 0.307726] usbcore: registered new interface driver hub [ 0.307748] usbcore: registered new device driver usb [ 0.307867] ACPI: WMI: Mapper loaded [ 0.307869] PCI: Using ACPI for IRQ routing [ 0.308086] NetLabel: Initializing [ 0.308088] NetLabel: domain hash size = 128 [ 0.308089] NetLabel: protocols = UNLABELED CIPSOv4 [ 0.308100] NetLabel: unlabeled traffic allowed by default [ 0.308128] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.308132] hpet0: 3 comparators, 64-bit 14.318180 MHz counter [ 0.312051] Switching to clocksource tsc [ 0.313741] AppArmor: AppArmor Filesystem Enabled [ 0.313748] pnp: PnP ACPI init [ 0.313756] ACPI: bus type pnp registered [ 0.330388] Freeing initrd memory: 8060k freed [ 0.333440] pnp 00:07: io resource (0xfe00-0xfe00) overlaps 0000:00:1c.0 BAR 13 (0xf000-0xffff), disabling [ 0.333780] pnp: PnP ACPI: found 11 devices [ 0.333782] ACPI: ACPI bus type pnp unregistered [ 0.333789] PnPBIOS: Disabled by ACPI PNP [ 0.333807] system 00:01: iomem range 0xfed1c000-0xfed1ffff has been reserved [ 0.333809] system 00:01: iomem range 0xfed14000-0xfed17fff has been reserved [ 0.333811] system 00:01: iomem range 0xfed18000-0xfed18fff has been reserved [ 0.333814] system 00:01: iomem range 0xfed19000-0xfed19fff has been reserved [ 0.333816] system 00:01: iomem range 0xe0000000-0xefffffff has been reserved [ 0.333819] system 00:01: iomem range 0xfed20000-0xfed3ffff has been reserved [ 0.333821] system 00:01: iomem range 0xfed40000-0xfed44fff has been reserved [ 0.333823] system 00:01: iomem range 0xfed45000-0xfed8ffff has been reserved [ 0.333829] system 00:05: iomem range 0xfed00000-0xfed003ff has been reserved [ 0.333837] system 00:07: ioport range 0x680-0x69f has been reserved [ 0.333840] system 00:07: ioport range 0x800-0x80f has been reserved [ 0.333842] system 00:07: ioport range 0x1000-0x107f has been reserved [ 0.333844] system 00:07: ioport range 0x1180-0x11bf has been reserved [ 0.333846] system 00:07: ioport range 0x1640-0x164f has been reserved [ 0.368692] pci 0000:00:01.0: PCI bridge, secondary bus 0000:01 [ 0.368694] pci 0000:00:01.0: IO window: 0x2000-0x2fff [ 0.368698] pci 0000:00:01.0: MEM window: 0xcfe00000-0xcfefffff [ 0.368702] pci 0000:00:01.0: PREFETCH window: 0x000000d0000000-0x000000dfffffff [ 0.368706] pci 0000:00:1c.0: PCI bridge, secondary bus 0000:02 [ 0.368709] pci 0000:00:1c.0: IO window: 0xf000-0xffff [ 0.368715] pci 0000:00:1c.0: MEM window: 0xfb000000-0xfcffffff [ 0.368720] pci 0000:00:1c.0: PREFETCH window: 0x000000c0000000-0x000000c01fffff [ 0.368728] pci 0000:00:1c.1: PCI bridge, secondary bus 0000:04 [ 0.368731] pci 0000:00:1c.1: IO window: 0x3000-0x3fff [ 0.368737] pci 0000:00:1c.1: MEM window: 0xf0300000-0xf03fffff [ 0.368742] pci 0000:00:1c.1: PREFETCH window: 0xc0200000-0xc03fffff [ 0.368749] pci 0000:00:1c.2: PCI bridge, secondary bus 0000:05 [ 0.368753] pci 0000:00:1c.2: IO window: 0x7000-0x7fff [ 0.368759] pci 0000:00:1c.2: MEM window: 0xf0200000-0xf02fffff [ 0.368763] pci 0000:00:1c.2: PREFETCH window: 0x000000c0400000-0x000000c05fffff [ 0.368771] pci 0000:00:1c.3: PCI bridge, secondary bus 0000:06 [ 0.368774] pci 0000:00:1c.3: IO window: 0x4000-0x4fff [ 0.368780] pci 0000:00:1c.3: MEM window: 0xf0500000-0xf05fffff [ 0.368785] pci 0000:00:1c.3: PREFETCH window: 0xc0600000-0xc07fffff [ 0.368793] pci 0000:00:1c.4: PCI bridge, secondary bus 0000:07 [ 0.368796] pci 0000:00:1c.4: IO window: 0x5000-0x5fff [ 0.368802] pci 0000:00:1c.4: MEM window: 0xf0400000-0xf04fffff [ 0.368807] pci 0000:00:1c.4: PREFETCH window: 0x000000c0800000-0x000000c09fffff [ 0.368814] pci 0000:00:1c.5: PCI bridge, secondary bus 0000:08 [ 0.368817] pci 0000:00:1c.5: IO window: 0x6000-0x6fff [ 0.368823] pci 0000:00:1c.5: MEM window: 0xf0600000-0xf06fffff [ 0.368828] pci 0000:00:1c.5: PREFETCH window: 0x000000c0a00000-0x000000c0bfffff [ 0.368836] pci 0000:00:1e.0: PCI bridge, secondary bus 0000:09 [ 0.368837] pci 0000:00:1e.0: IO window: disabled [ 0.368843] pci 0000:00:1e.0: MEM window: 0xf0700000-0xf07fffff [ 0.368848] pci 0000:00:1e.0: PREFETCH window: disabled [ 0.368862] alloc irq_desc for 16 on node -1 [ 0.368864] alloc kstat_irqs on node -1 [ 0.368869] pci 0000:00:01.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [ 0.368873] pci 0000:00:01.0: setting latency timer to 64 [ 0.368882] alloc irq_desc for 17 on node -1 [ 0.368883] alloc kstat_irqs on node -1 [ 0.368886] pci 0000:00:1c.0: PCI INT A -> GSI 17 (level, low) -> IRQ 17 [ 0.368891] pci 0000:00:1c.0: setting latency timer to 64 [ 0.368901] pci 0000:00:1c.1: PCI INT B -> GSI 16 (level, low) -> IRQ 16 [ 0.368905] pci 0000:00:1c.1: setting latency timer to 64 [ 0.368915] alloc irq_desc for 18 on node -1 [ 0.368916] alloc kstat_irqs on node -1 [ 0.368919] pci 0000:00:1c.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [ 0.368924] pci 0000:00:1c.2: setting latency timer to 64 [ 0.368933] alloc irq_desc for 19 on node -1 [ 0.368934] alloc kstat_irqs on node -1 [ 0.368937] pci 0000:00:1c.3: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [ 0.368942] pci 0000:00:1c.3: setting latency timer to 64 [ 0.368952] pci 0000:00:1c.4: PCI INT A -> GSI 17 (level, low) -> IRQ 17 [ 0.368957] pci 0000:00:1c.4: setting latency timer to 64 [ 0.368966] pci 0000:00:1c.5: PCI INT B -> GSI 16 (level, low) -> IRQ 16 [ 0.368971] pci 0000:00:1c.5: setting latency timer to 64 [ 0.368979] pci 0000:00:1e.0: setting latency timer to 64 [ 0.368983] pci_bus 0000:00: resource 0 io: [0x00-0xffff] [ 0.368985] pci_bus 0000:00: resource 1 mem: [0x000000-0xffffffff] [ 0.368987] pci_bus 0000:01: resource 0 io: [0x2000-0x2fff] [ 0.368989] pci_bus 0000:01: resource 1 mem: [0xcfe00000-0xcfefffff] [ 0.368991] pci_bus 0000:01: resource 2 pref mem [0xd0000000-0xdfffffff] [ 0.368994] pci_bus 0000:02: resource 0 io: [0xf000-0xffff] [ 0.368996] pci_bus 0000:02: resource 1 mem: [0xfb000000-0xfcffffff] [ 0.368998] pci_bus 0000:02: resource 2 pref mem [0xc0000000-0xc01fffff] [ 0.369000] pci_bus 0000:04: resource 0 io: [0x3000-0x3fff] [ 0.369002] pci_bus 0000:04: resource 1 mem: [0xf0300000-0xf03fffff] [ 0.369004] pci_bus 0000:04: resource 2 pref mem [0xc0200000-0xc03fffff] [ 0.369006] pci_bus 0000:05: resource 0 io: [0x7000-0x7fff] [ 0.369008] pci_bus 0000:05: resource 1 mem: [0xf0200000-0xf02fffff] [ 0.369010] pci_bus 0000:05: resource 2 pref mem [0xc0400000-0xc05fffff] [ 0.369012] pci_bus 0000:06: resource 0 io: [0x4000-0x4fff] [ 0.369014] pci_bus 0000:06: resource 1 mem: [0xf0500000-0xf05fffff] [ 0.369016] pci_bus 0000:06: resource 2 pref mem [0xc0600000-0xc07fffff] [ 0.369018] pci_bus 0000:07: resource 0 io: [0x5000-0x5fff] [ 0.369020] pci_bus 0000:07: resource 1 mem: [0xf0400000-0xf04fffff] [ 0.369022] pci_bus 0000:07: resource 2 pref mem [0xc0800000-0xc09fffff] [ 0.369024] pci_bus 0000:08: resource 0 io: [0x6000-0x6fff] [ 0.369026] pci_bus 0000:08: resource 1 mem: [0xf0600000-0xf06fffff] [ 0.369028] pci_bus 0000:08: resource 2 pref mem [0xc0a00000-0xc0bfffff] [ 0.369031] pci_bus 0000:09: resource 1 mem: [0xf0700000-0xf07fffff] [ 0.369033] pci_bus 0000:09: resource 3 io: [0x00-0xffff] [ 0.369035] pci_bus 0000:09: resource 4 mem: [0x000000-0xffffffff] [ 0.369070] NET: Registered protocol family 2 [ 0.369158] IP route cache hash table entries: 32768 (order: 5, 131072 bytes) [ 0.369450] TCP established hash table entries: 131072 (order: 8, 1048576 bytes) [ 0.369984] TCP bind hash table entries: 65536 (order: 7, 524288 bytes) [ 0.370249] TCP: Hash tables configured (established 131072 bind 65536) [ 0.370251] TCP reno registered [ 0.370306] NET: Registered protocol family 1 [ 0.370442] pci 0000:01:00.0: Boot video device [ 0.370467] Simple Boot Flag at 0x36 set to 0x1 [ 0.370599] cpufreq-nforce2: No nForce2 chipset. [ 0.370620] Scanning for low memory corruption every 60 seconds [ 0.370714] audit: initializing netlink socket (disabled) [ 0.370722] type=2000 audit(1282639701.367:1): initialized [ 0.378805] highmem bounce pool size: 64 pages [ 0.378809] HugeTLB registered 4 MB page size, pre-allocated 0 pages [ 0.380048] VFS: Disk quotas dquot_6.5.2 [ 0.380095] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) [ 0.380564] fuse init (API version 7.13) [ 0.380634] msgmni has been set to 1679 [ 0.380812] alg: No test for stdrng (krng) [ 0.380852] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 253) [ 0.380855] io scheduler noop registered [ 0.380857] io scheduler anticipatory registered [ 0.380858] io scheduler deadline registered [ 0.380890] io scheduler cfq registered (default) [ 0.381020] alloc irq_desc for 24 on node -1 [ 0.381021] alloc kstat_irqs on node -1 [ 0.381028] pcieport 0000:00:01.0: irq 24 for MSI/MSI-X [ 0.381033] pcieport 0000:00:01.0: setting latency timer to 64 [ 0.381150] alloc irq_desc for 25 on node -1 [ 0.381152] alloc kstat_irqs on node -1 [ 0.381160] pcieport 0000:00:1c.0: irq 25 for MSI/MSI-X [ 0.381170] pcieport 0000:00:1c.0: setting latency timer to 64 [ 0.381312] alloc irq_desc for 26 on node -1 [ 0.381314] alloc kstat_irqs on node -1 [ 0.381322] pcieport 0000:00:1c.1: irq 26 for MSI/MSI-X [ 0.381332] pcieport 0000:00:1c.1: setting latency timer to 64 [ 0.381478] alloc irq_desc for 27 on node -1 [ 0.381480] alloc kstat_irqs on node -1 [ 0.381488] pcieport 0000:00:1c.2: irq 27 for MSI/MSI-X [ 0.381498] pcieport 0000:00:1c.2: setting latency timer to 64 [ 0.381641] alloc irq_desc for 28 on node -1 [ 0.381643] alloc kstat_irqs on node -1 [ 0.381651] pcieport 0000:00:1c.3: irq 28 for MSI/MSI-X [ 0.381661] pcieport 0000:00:1c.3: setting latency timer to 64 [ 0.381807] alloc irq_desc for 29 on node -1 [ 0.381809] alloc kstat_irqs on node -1 [ 0.381817] pcieport 0000:00:1c.4: irq 29 for MSI/MSI-X [ 0.381827] pcieport 0000:00:1c.4: setting latency timer to 64 [ 0.381970] alloc irq_desc for 30 on node -1 [ 0.381971] alloc kstat_irqs on node -1 [ 0.381979] pcieport 0000:00:1c.5: irq 30 for MSI/MSI-X [ 0.381989] pcieport 0000:00:1c.5: setting latency timer to 64 [ 0.382087] pci_hotplug: PCI Hot Plug PCI Core version: 0.5 [ 0.382235] pciehp: PCI Express Hot Plug Controller Driver version: 0.4 [ 0.382540] ACPI: AC Adapter [AC0] (on-line) [ 0.382616] input: Lid Switch as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0D:00/input/input0 [ 0.382647] ACPI: Lid Switch [LID0] [ 0.382681] input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input1 [ 0.382684] ACPI: Power Button [PWRB] [ 0.382720] input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input2 [ 0.382722] ACPI: Sleep Button [SLPB] [ 0.382770] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 [ 0.382772] ACPI: Power Button [PWRF] [ 0.383377] ACPI: SSDT bfed33fe 0033E (v01 PmRef Cpu0Ist 00003000 INTL 20050624) [ 0.383803] ACPI: SSDT bfed2d6d 0060C (v01 PmRef Cpu0Cst 00003001 INTL 20050624) [ 0.385557] Monitor-Mwait will be used to enter C-1 state [ 0.385579] Monitor-Mwait will be used to enter C-3 state [ 0.385586] Marking TSC unstable due to TSC halts in idle [ 0.385624] Switching to clocksource hpet [ 0.385677] processor LNXCPU:00: registered as cooling_device0 [ 0.385978] ACPI: SSDT bfed373c 000C8 (v01 PmRef Cpu1Ist 00003000 INTL 20050624) [ 0.386234] ACPI: SSDT bfed3379 00085 (v01 PmRef Cpu1Cst 00003000 INTL 20050624) [ 0.386971] processor LNXCPU:01: registered as cooling_device1 [ 0.410261] thermal LNXTHERM:01: registered as thermal_zone0 [ 0.410267] ACPI: Thermal Zone [THRM] (39 C) [ 0.410374] isapnp: Scanning for PnP cards... [ 0.411525] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 0.412670] brd: module loaded [ 0.413050] loop: module loaded [ 0.413112] input: Macintosh mouse button emulation as /devices/virtual/input/input4 [ 0.413175] ata_piix 0000:00:1f.1: version 2.13 [ 0.413184] ata_piix 0000:00:1f.1: PCI INT A -> GSI 19 (level, low) -> IRQ 19 [ 0.413225] ata_piix 0000:00:1f.1: setting latency timer to 64 [ 0.413293] scsi0 : ata_piix [ 0.413349] scsi1 : ata_piix [ 0.413826] ata1: PATA max UDMA/100 cmd 0x1f0 ctl 0x3f6 bmdma 0x18a0 irq 14 [ 0.413828] ata2: PATA max UDMA/100 cmd 0x170 ctl 0x376 bmdma 0x18a8 irq 15 [ 0.413884] pata_acpi 0000:08:00.1: enabling device (0000 -> 0001) [ 0.413890] pata_acpi 0000:08:00.1: PCI INT B -> GSI 18 (level, low) -> IRQ 18 [ 0.413924] pata_acpi 0000:08:00.1: setting latency timer to 64 [ 0.413937] pata_acpi 0000:08:00.1: PCI INT B disabled [ 0.414177] Fixed MDIO Bus: probed [ 0.414204] PPP generic driver version 2.4.2 [ 0.414233] tun: Universal TUN/TAP device driver, 1.6 [ 0.414234] tun: (C) 1999-2004 Max Krasnyansky <maxk@qualcomm.com> [ 0.414299] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver [ 0.414315] ehci_hcd 0000:00:1a.7: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [ 0.414324] ehci_hcd 0000:00:1a.7: setting latency timer to 64 [ 0.414327] ehci_hcd 0000:00:1a.7: EHCI Host Controller [ 0.414352] ehci_hcd 0000:00:1a.7: new USB bus registered, assigned bus number 1 [ 0.414378] ehci_hcd 0000:00:1a.7: debug port 1 [ 0.418270] ehci_hcd 0000:00:1a.7: cache line size of 32 is not supported [ 0.418281] ehci_hcd 0000:00:1a.7: irq 18, io mem 0xf0804800 [ 0.432015] ehci_hcd 0000:00:1a.7: USB 2.0 started, EHCI 1.00 [ 0.432085] usb usb1: configuration #1 chosen from 1 choice [ 0.432108] hub 1-0:1.0: USB hub found [ 0.432114] hub 1-0:1.0: 4 ports detected [ 0.432163] alloc irq_desc for 23 on node -1 [ 0.432164] alloc kstat_irqs on node -1 [ 0.432168] ehci_hcd 0000:00:1d.7: PCI INT A -> GSI 23 (level, low) -> IRQ 23 [ 0.432177] ehci_hcd 0000:00:1d.7: setting latency timer to 64 [ 0.432180] ehci_hcd 0000:00:1d.7: EHCI Host Controller [ 0.432204] ehci_hcd 0000:00:1d.7: new USB bus registered, assigned bus number 2 [ 0.432233] ehci_hcd 0000:00:1d.7: debug port 1 [ 0.436126] ehci_hcd 0000:00:1d.7: cache line size of 32 is not supported [ 0.436137] ehci_hcd 0000:00:1d.7: irq 23, io mem 0xf0804c00 [ 0.446595] ACPI: Battery Slot [BAT0] (battery present) [ 0.452014] ehci_hcd 0000:00:1d.7: USB 2.0 started, EHCI 1.00 [ 0.452080] usb usb2: configuration #1 chosen from 1 choice [ 0.452102] hub 2-0:1.0: USB hub found [ 0.452109] hub 2-0:1.0: 6 ports detected [ 0.452159] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver [ 0.452171] uhci_hcd: USB Universal Host Controller Interface driver [ 0.452186] uhci_hcd 0000:00:1a.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [ 0.452192] uhci_hcd 0000:00:1a.0: setting latency timer to 64 [ 0.452195] uhci_hcd 0000:00:1a.0: UHCI Host Controller [ 0.452219] uhci_hcd 0000:00:1a.0: new USB bus registered, assigned bus number 3 [ 0.452251] uhci_hcd 0000:00:1a.0: irq 16, io base 0x00001800 [ 0.452325] usb usb3: configuration #1 chosen from 1 choice [ 0.452348] hub 3-0:1.0: USB hub found [ 0.452354] hub 3-0:1.0: 2 ports detected [ 0.452393] alloc irq_desc for 21 on node -1 [ 0.452395] alloc kstat_irqs on node -1 [ 0.452398] uhci_hcd 0000:00:1a.1: PCI INT B -> GSI 21 (level, low) -> IRQ 21 [ 0.452404] uhci_hcd 0000:00:1a.1: setting latency timer to 64 [ 0.452407] uhci_hcd 0000:00:1a.1: UHCI Host Controller [ 0.452431] uhci_hcd 0000:00:1a.1: new USB bus registered, assigned bus number 4 [ 0.452465] uhci_hcd 0000:00:1a.1: irq 21, io base 0x00001820 [ 0.452543] usb usb4: configuration #1 chosen from 1 choice [ 0.452563] hub 4-0:1.0: USB hub found [ 0.452569] hub 4-0:1.0: 2 ports detected [ 0.452610] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 23 (level, low) -> IRQ 23 [ 0.452615] uhci_hcd 0000:00:1d.0: setting latency timer to 64 [ 0.452619] uhci_hcd 0000:00:1d.0: UHCI Host Controller [ 0.452643] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 5 [ 0.452669] uhci_hcd 0000:00:1d.0: irq 23, io base 0x00001840 [ 0.452747] usb usb5: configuration #1 chosen from 1 choice [ 0.452767] hub 5-0:1.0: USB hub found [ 0.452773] hub 5-0:1.0: 2 ports detected [ 0.452810] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 19 (level, low) -> IRQ 19 [ 0.452815] uhci_hcd 0000:00:1d.1: setting latency timer to 64 [ 0.452818] uhci_hcd 0000:00:1d.1: UHCI Host Controller [ 0.452844] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 6 [ 0.452876] uhci_hcd 0000:00:1d.1: irq 19, io base 0x00001860 [ 0.452948] usb usb6: configuration #1 chosen from 1 choice [ 0.452968] hub 6-0:1.0: USB hub found [ 0.452973] hub 6-0:1.0: 2 ports detected [ 0.453014] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [ 0.453020] uhci_hcd 0000:00:1d.2: setting latency timer to 64 [ 0.453023] uhci_hcd 0000:00:1d.2: UHCI Host Controller [ 0.453054] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 7 [ 0.453080] uhci_hcd 0000:00:1d.2: irq 18, io base 0x00001880 [ 0.453151] usb usb7: configuration #1 chosen from 1 choice [ 0.453171] hub 7-0:1.0: USB hub found [ 0.453177] hub 7-0:1.0: 2 ports detected [ 0.453255] PNP: PS/2 Controller [PNP0303:PS2K,PNP0f13:PS2M] at 0x60,0x64 irq 1,12 [ 0.455458] i8042.c: Detected active multiplexing controller, rev 1.1. [ 0.457635] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 0.457640] serio: i8042 AUX0 port at 0x60,0x64 irq 12 [ 0.457661] serio: i8042 AUX1 port at 0x60,0x64 irq 12 [ 0.457678] serio: i8042 AUX2 port at 0x60,0x64 irq 12 [ 0.457695] serio: i8042 AUX3 port at 0x60,0x64 irq 12 [ 0.457782] mice: PS/2 mouse device common for all mice [ 0.457939] rtc_cmos 00:08: rtc core: registered rtc_cmos as rtc0 [ 0.457968] rtc0: alarms up to one month, y3k, 242 bytes nvram, hpet irqs [ 0.458042] device-mapper: uevent: version 1.0.3 [ 0.458110] device-mapper: ioctl: 4.15.0-ioctl (2009-04-01) initialised: dm-devel@redhat.com [ 0.458159] device-mapper: multipath: version 1.1.0 loaded [ 0.458161] device-mapper: multipath round-robin: version 1.0.0 loaded [ 0.458247] EISA: Probing bus 0 at eisa.0 [ 0.458252] Cannot allocate resource for EISA slot 1 [ 0.458254] Cannot allocate resource for EISA slot 2 [ 0.458255] Cannot allocate resource for EISA slot 3 [ 0.458257] Cannot allocate resource for EISA slot 4 [ 0.458258] Cannot allocate resource for EISA slot 5 [ 0.458260] Cannot allocate resource for EISA slot 6 [ 0.458261] Cannot allocate resource for EISA slot 7 [ 0.458266] EISA: Detected 0 cards. [ 0.458376] cpuidle: using governor ladder [ 0.458466] cpuidle: using governor menu [ 0.458810] TCP cubic registered [ 0.458933] NET: Registered protocol family 10 [ 0.459310] lo: Disabled Privacy Extensions [ 0.459582] NET: Registered protocol family 17 [ 0.460036] Using IPI No-Shortcut mode [ 0.460089] PM: Resume from disk failed. [ 0.460097] registered taskstats version 1 [ 0.460783] Magic number: 6:450:827 [ 0.460841] rtc_cmos 00:08: setting system clock to 2010-08-24 08:48:21 UTC (1282639701) [ 0.460844] BIOS EDD facility v0.16 2004-Jun-25, 0 devices found [ 0.460845] EDD information not available. [ 0.494820] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input5 [ 0.587664] ata1.00: ATAPI: Optiarc BD ROM BC-5500A, 1.41, max UDMA/33 [ 0.600302] ata1.00: configured for UDMA/33 [ 0.764493] isapnp: No Plug & Play device found [ 0.765066] usb 2-1: new high speed USB device using ehci_hcd and address 2 [ 0.765618] scsi 0:0:0:0: CD-ROM Optiarc BD ROM BC-5500A 1.41 PQ: 0 ANSI: 5 [ 0.768793] sr0: scsi3-mmc drive: 24x/24x writer dvd-ram cd/rw xa/form2 cdda tray [ 0.768795] Uniform CD-ROM driver Revision: 3.20 [ 0.768852] sr 0:0:0:0: Attached scsi CD-ROM sr0 [ 0.768890] sr 0:0:0:0: Attached scsi generic sg0 type 5 [ 0.768954] Freeing unused kernel memory: 660k freed [ 0.769346] Write protecting the kernel text: 4680k [ 0.769395] Write protecting the kernel read-only data: 1844k [ 0.782592] udev: starting version 151 [ 0.824286] r8169 Gigabit Ethernet driver 2.3LK-NAPI loaded [ 0.824309] r8169 0000:06:00.0: PCI INT A -> GSI 19 (level, low) -> IRQ 19 [ 0.824360] r8169 0000:06:00.0: setting latency timer to 64 [ 0.824436] alloc irq_desc for 31 on node -1 [ 0.824437] alloc kstat_irqs on node -1 [ 0.824454] r8169 0000:06:00.0: irq 31 for MSI/MSI-X [ 0.824993] eth0: RTL8168b/8111b at 0xf805e000, 00:03:0d:8c:20:33, XID 18000000 IRQ 31 [ 0.855181] pata_jmicron 0000:08:00.1: PCI INT B -> GSI 18 (level, low) -> IRQ 18 [ 0.855220] pata_jmicron 0000:08:00.1: setting latency timer to 64 [ 0.855458] sata_sil24 0000:07:00.0: version 1.1 [ 0.855475] sata_sil24 0000:07:00.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [ 0.855535] sata_sil24 0000:07:00.0: setting latency timer to 64 [ 0.863633] ahci 0000:00:1f.2: version 3.0 [ 0.863644] ahci 0000:00:1f.2: PCI INT B -> GSI 19 (level, low) -> IRQ 19 [ 0.863677] alloc irq_desc for 32 on node -1 [ 0.863678] alloc kstat_irqs on node -1 [ 0.863689] ahci 0000:00:1f.2: irq 32 for MSI/MSI-X [ 0.863751] ahci 0000:00:1f.2: AHCI 0001.0100 32 slots 3 ports 3 Gbps 0x7 impl SATA mode [ 0.863754] ahci 0000:00:1f.2: flags: 64bit ncq sntf pm led clo pio slum part ccc [ 0.863759] ahci 0000:00:1f.2: setting latency timer to 64 [ 0.872740] scsi2 : pata_jmicron [ 0.872853] scsi3 : sata_sil24 [ 0.872892] ata5: SATA max UDMA/100 host m128@0xf0402000 port 0xf0400000 irq 16 [ 0.877140] scsi4 : ahci [ 0.890690] scsi5 : pata_jmicron [ 0.890737] ata3: PATA max UDMA/100 cmd 0x6020 ctl 0x6014 bmdma 0x6000 irq 18 [ 0.890739] ata4: PATA max UDMA/100 cmd 0x6018 ctl 0x6010 bmdma 0x6008 irq 18 [ 0.891884] scsi6 : ahci [ 0.900129] usb 2-1: configuration #1 chosen from 1 choice [ 0.905151] scsi7 : ahci [ 0.905273] ata6: SATA max UDMA/133 abar m2048@0xf0804000 port 0xf0804100 irq 32 [ 0.905277] ata7: SATA max UDMA/133 abar m2048@0xf0804000 port 0xf0804180 irq 32 [ 0.905280] ata8: SATA max UDMA/133 abar m2048@0xf0804000 port 0xf0804200 irq 32 [ 0.905318] ahci 0000:08:00.0: PCI INT A -> GSI 17 (level, low) -> IRQ 17 [ 0.920079] ahci 0000:08:00.0: AHCI 0001.0000 32 slots 2 ports 3 Gbps 0x3 impl SATA mode [ 0.920082] ahci 0000:08:00.0: flags: 64bit ncq pm led clo pmp pio slum part [ 0.920089] ahci 0000:08:00.0: setting latency timer to 64 [ 0.920287] scsi8 : ahci [ 0.920386] scsi9 : ahci [ 0.920427] ata9: SATA max UDMA/133 abar m8192@0xf0600000 port 0xf0600100 irq 17 [ 0.920431] ata10: SATA max UDMA/133 abar m8192@0xf0600000 port 0xf0600180 irq 17 [ 1.224085] ata7: SATA link down (SStatus 0 SControl 300) [ 1.224103] ata6: SATA link down (SStatus 0 SControl 300) [ 1.224120] ata8: SATA link down (SStatus 0 SControl 300) [ 1.404085] ata10: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [ 1.404111] ata9: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [ 1.443319] ata9.00: ATA-8: WDC WD3200BEVT-22ZCT0, 11.01A11, max UDMA/133 [ 1.443321] ata9.00: 625142448 sectors, multi 0: LBA48 NCQ (depth 31/32), AA [ 1.444433] ata9.00: configured for UDMA/133 [ 1.449793] ata10.00: ATA-8: WDC WD3200BEVT-22ZCT0, 11.01A11, max UDMA/133 [ 1.449796] ata10.00: 625142448 sectors, multi 0: LBA48 NCQ (depth 31/32), AA [ 1.450932] ata10.00: configured for UDMA/133 [ 2.952085] ata5: SATA link down (SStatus 0 SControl 0) [ 3.120195] scsi 8:0:0:0: Direct-Access ATA WDC WD3200BEVT-2 11.0 PQ: 0 ANSI: 5 [ 3.120301] sd 8:0:0:0: [sda] 625142448 512-byte logical blocks: (320 GB/298 GiB) [ 3.120340] sd 8:0:0:0: [sda] Write Protect is off [ 3.120342] sd 8:0:0:0: [sda] Mode Sense: 00 3a 00 00 [ 3.120363] sd 8:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 3.120482] sda: [ 3.120553] sd 8:0:0:0: Attached scsi generic sg1 type 0 [ 3.120644] scsi 9:0:0:0: Direct-Access ATA WDC WD3200BEVT-2 11.0 PQ: 0 ANSI: 5 [ 3.120730] sd 9:0:0:0: [sdb] 625142448 512-byte logical blocks: (320 GB/298 GiB) [ 3.120767] sd 9:0:0:0: [sdb] Write Protect is off [ 3.120769] sd 9:0:0:0: [sdb] Mode Sense: 00 3a 00 00 [ 3.120789] sd 9:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 3.120888] sdb: [ 3.120943] sd 9:0:0:0: Attached scsi generic sg2 type 0 [ 3.162201] sdb1 sdb2 sdb3 sdb4 [ 3.166820] sda1 sda2 sda4 [ 3.167055] sd 8:0:0:0: [sda] Attached SCSI disk [ 3.182203] sd 9:0:0:0: [sdb] Attached SCSI disk [ 3.184471] ohci1394 0000:09:04.0: enabling device (0195 -> 0197) [ 3.184477] alloc irq_desc for 20 on node -1 [ 3.184478] alloc kstat_irqs on node -1 [ 3.184483] ohci1394 0000:09:04.0: PCI INT A -> GSI 20 (level, low) -> IRQ 20 [ 3.241089] ohci1394: fw-host0: OHCI-1394 1.1 (PCI): IRQ=[20] MMIO=[f0701000-f07017ff] Max Packet=[2048] IR/IT contexts=[8/8] [ 3.712758] kjournald starting. Commit interval 5 seconds [ 3.712766] EXT3-fs: mounted filesystem with ordered data mode. [ 4.512154] ieee1394: Host added: ID:BUS[0-00:1023] GUID[00030d0055014b3c] [ 19.377346] udev: starting version 151 [ 19.515266] Adding 3903784k swap on /dev/sdb3. Priority:-1 extents:1 across:3903784k [ 19.555849] Linux agpgart interface v0.103 [ 19.616708] cfg80211: Calling CRDA to update world regulatory domain [ 19.622138] lp: driver loaded but no devices found [ 19.653706] type=1505 audit(1282632520.692:2): operation="profile_load" pid=627 name="/sbin/dhclient3" [ 19.654251] type=1505 audit(1282632520.692:3): operation="profile_load" pid=627 name="/usr/lib/NetworkManager/nm-dhcp-client.action" [ 19.654474] cfg80211: World regulatory domain updated: [ 19.654476] (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [ 19.654478] (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [ 19.654480] (2457000 KHz - 2482000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [ 19.654482] (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [ 19.654484] (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [ 19.654486] (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [ 19.654543] type=1505 audit(1282632520.692:4): operation="profile_load" pid=627 name="/usr/lib/connman/scripts/dhclient-script" [ 19.658635] type=1505 audit(1282632520.695:5): operation="profile_load" pid=710 name="/usr/sbin/ntpd" [ 19.661739] [drm] Initialized drm 1.1.0 20060810 [ 19.679586] lirc_dev: IR Remote Control driver registered, major 61 [ 19.698624] lirc_dev: lirc_register_driver: sample_rate: 0 [ 19.700282] lirc_ite8709: device found : irq=10 io=0x260 [ 19.704428] acpi device:03: registered as cooling_device2 [ 19.704460] ACPI: Cant attach device [ 19.704527] input: Video Bus as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A08:00/device:01/LNXVIDEO:00/input/input6 [ 19.704558] ACPI: Video Device [VGA] (multi-head: yes rom: no post: no) [ 19.750754] iwlagn: Intel(R) Wireless WiFi Link AGN driver for Linux, 1.3.27k [ 19.750758] iwlagn: Copyright(c) 2003-2009 Intel Corporation [ 19.750842] iwlagn 0000:05:00.0: PCI INT A -> GSI 18 (level, low) -> IRQ 18 [ 19.750851] iwlagn 0000:05:00.0: setting latency timer to 64 [ 19.750882] iwlagn 0000:05:00.0: Detected Intel Wireless WiFi Link 4965AGN REV=0x4 [ 19.778375] Linux video capture interface: v2.00 [ 19.780345] [drm] radeon defaulting to kernel modesetting. [ 19.780347] [drm] radeon kernel modesetting enabled. [ 19.780393] radeon 0000:01:00.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [ 19.780408] radeon 0000:01:00.0: setting latency timer to 64 [ 19.782098] [drm] radeon: Initializing kernel modesetting. [ 19.782667] [drm] register mmio base: 0xCFEF0000 [ 19.782669] [drm] register mmio size: 65536 [ 19.782745] ATOM BIOS: ECS_P75IM0_M76XT [ 19.782763] [drm] Clocks initialized ! [ 19.784442] [drm] Detected VRAM RAM=256M, BAR=256M [ 19.784445] [drm] RAM width 128bits DDR [ 19.785245] [TTM] Zone kernel: Available graphics memory: 430266 kiB. [ 19.785248] [TTM] Zone highmem: Available graphics memory: 1547870 kiB. [ 19.785261] [drm] radeon: 256M of VRAM memory ready [ 19.785263] [drm] radeon: 512M of GTT memory ready. [ 19.785369] alloc irq_desc for 33 on node -1 [ 19.785371] alloc kstat_irqs on node -1 [ 19.785393] radeon 0000:01:00.0: irq 33 for MSI/MSI-X [ 19.785411] [drm] radeon: using MSI. [ 19.785475] [drm] radeon: irq initialized. [ 19.785477] [drm] GART: num cpu pages 131072, num gpu pages 131072 [ 19.785709] [drm] Loading RV630 Microcode [ 19.785713] platform radeon_cp.0: firmware: requesting radeon/RV630_pfp.bin [ 19.788591] platform radeon_cp.0: firmware: requesting radeon/RV630_me.bin [ 19.793117] platform radeon_cp.0: firmware: requesting radeon/R600_rlc.bin [ 19.838861] iwlagn 0000:05:00.0: Tunable channels: 13 802.11bg, 19 802.11a channels [ 19.839151] alloc irq_desc for 34 on node -1 [ 19.839153] alloc kstat_irqs on node -1 [ 19.839172] iwlagn 0000:05:00.0: irq 34 for MSI/MSI-X [ 19.852045] [drm] ring test succeeded in 1 usecs [ 19.852189] [drm] radeon: ib pool ready. [ 19.852258] [drm] ib test succeeded in 0 usecs [ 19.852260] [drm] Enabling audio support [ 19.852331] [drm] Default TV standard: NTSC [ 19.852422] [drm] Radeon Display Connectors [ 19.852423] [drm] Connector 0: [ 19.852424] [drm] LVDS [ 19.852426] [drm] DDC: 0xac0 0xac0 0xac4 0xac4 0xac8 0xac8 0xacc 0xacc [ 19.852428] [drm] Encoders: [ 19.852429] [drm] LCD1: INTERNAL_LVTM1 [ 19.852430] [drm] Connector 1: [ 19.852431] [drm] DIN [ 19.852432] [drm] Encoders: [ 19.852434] [drm] TV1: INTERNAL_KLDSCP_DAC2 [ 19.852435] [drm] Connector 2: [ 19.852436] [drm] HDMI-A [ 19.852437] [drm] HPD1 [ 19.852439] [drm] DDC: 0x7e50 0x7e50 0x7e54 0x7e54 0x7e58 0x7e58 0x7e5c 0x7e5c [ 19.852440] [drm] Encoders: [ 19.852442] [drm] DFP1: INTERNAL_KLDSCP_TMDS1 [ 19.852443] [drm] Connector 3: [ 19.852444] [drm] VGA [ 19.852446] [drm] DDC: 0x7e40 0x7e40 0x7e44 0x7e44 0x7e48 0x7e48 0x7e4c 0x7e4c [ 19.852447] [drm] Encoders: [ 19.852448] [drm] CRT1: INTERNAL_KLDSCP_DAC1 [ 19.865441] alloc irq_desc for 22 on node -1 [ 19.865443] alloc kstat_irqs on node -1 [ 19.865449] HDA Intel 0000:00:1b.0: PCI INT A -> GSI 22 (level, low) -> IRQ 22 [ 19.865479] HDA Intel 0000:00:1b.0: setting latency timer to 64 [ 19.871772] phy0: Selected rate control algorithm 'iwl-agn-rs' [ 19.981695] input: HDA Digital PCBeep as /devices/pci0000:00/0000:00:1b.0/input/input7 [ 20.311798] EXT3 FS on sdb1, internal journal [ 20.409616] [drm] fb mappable at 0xD0141000 [ 20.409618] [drm] vram apper at 0xD0000000 [ 20.409619] [drm] size 9216000 [ 20.409620] [drm] fb depth is 24 [ 20.409621] [drm] pitch is 7680 [ 20.409735] fb0: radeondrmfb frame buffer device [ 20.409736] registered panic notifier [ 20.409740] [drm] Initialized radeon 2.0.0 20080528 for 0000:01:00.0 on minor 0 [ 20.409781] HDA Intel 0000:01:00.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [ 20.409798] HDA Intel 0000:01:00.1: setting latency timer to 64 [ 20.411517] vga16fb: initializing [ 20.411520] vga16fb: mapped to 0xc00a0000 [ 20.411522] vga16fb: not registering due to another framebuffer present [ 20.427113] Synaptics Touchpad, model: 1, fw: 6.2, id: 0xa0b1, caps: 0xa04713/0x20040a [ 20.470037] input: SynPS/2 Synaptics TouchPad as /devices/platform/i8042/serio4/input/input8 [ 20.830778] Console: switching to colour frame buffer device 240x75 [ 20.935953] Cynove 2 Mpix micron camera at usb-0000:00:1d.7-1 registered to minor 0 (high speed) [ 20.935973] usbcore: registered new interface driver ovfx2 [ 20.935975] version 158M : ovfx2 USB Camera Driver [ 21.347688] kjournald starting. Commit interval 5 seconds [ 21.348039] EXT3 FS on sdb2, internal journal [ 21.348043] EXT3-fs: mounted filesystem with ordered data mode. [ 22.895210] r8169: eth0: link up [ 22.895213] r8169: eth0: link up [ 23.236798] type=1505 audit(1282632524.272:6): operation="profile_load" pid=1073 name="/usr/share/gdm/guest-session/Xsession" [ 23.238159] type=1505 audit(1282632524.276:7): operation="profile_replace" pid=1074 name="/sbin/dhclient3" [ 23.238702] type=1505 audit(1282632524.276:8): operation="profile_replace" pid=1074 name="/usr/lib/NetworkManager/nm-dhcp-client.action" [ 23.238998] type=1505 audit(1282632524.276:9): operation="profile_replace" pid=1074 name="/usr/lib/connman/scripts/dhclient-script" [ 23.241624] type=1505 audit(1282632524.280:10): operation="profile_load" pid=1075 name="/usr/bin/evince" [ 23.248852] type=1505 audit(1282632524.284:11): operation="profile_load" pid=1075 name="/usr/bin/evince-previewer" [ 23.391165] apm: BIOS not found. [ 23.630460] ppdev: user-space parallel port driver [ 25.695146] hda-intel: IRQ timing workaround is activated for card #1. Suggest a bigger bdl_pos_adj. [ 33.232092] eth0: no IPv6 routers present ^ permalink raw reply [flat|nested] 16+ messages in thread
* Re: System time drifts when processor idle. 2010-08-24 7:08 ` jean-philippe francois @ 2010-08-27 14:12 ` jean-philippe francois 2010-08-27 18:11 ` john stultz 0 siblings, 1 reply; 16+ messages in thread From: jean-philippe francois @ 2010-08-27 14:12 UTC (permalink / raw) To: john stultz; +Cc: Lin Ming, H. Peter Anvin, linux-acpi, LKML [-- Attachment #1: Type: text/plain, Size: 266 bytes --] Hi, My Timekeeping bug is still present, here is an updated script and log. I am willing to make test, but I don't know what kind of debugging info is needed. I am all eyes to any advice that could help solve this BUG. Thank you, Jean-Philippe François [-- Attachment #2: clocktest.sh --] [-- Type: application/x-sh, Size: 605 bytes --] [-- Attachment #3: clocktest.log --] [-- Type: text/x-log, Size: 2097 bytes --] Linux jp 2.6.36-020636rc1-generic #201008171306 SMP Tue Aug 17 14:16:28 UTC 2010 i686 GNU/Linux cat /sys/devices/system/clocksource/clocksource0/available_clocksource hpet acpi_pm cat /sys/devices/system/clocksource/clocksource0/current_clocksource hpet ________________________ system | hardware(RTC) 15:46:37 | ven. 27 août 2010 15:46:38 CEST -0.500550 secondes 15:46:58 | ven. 27 août 2010 15:46:59 CEST -0.985953 secondes 15:47:19 | ven. 27 août 2010 15:47:20 CEST -1.001591 secondes 15:47:40 | ven. 27 août 2010 15:47:41 CEST -0.985932 secondes 15:48:01 | ven. 27 août 2010 15:48:02 CEST -0.985961 secondes 15:48:22 | ven. 27 août 2010 15:48:23 CEST -1.001558 secondes 15:48:43 | ven. 27 août 2010 15:48:44 CEST -0.985908 secondes 15:49:04 | ven. 27 août 2010 15:54:04 CEST -0.032800 secondes 15:49:24 | ven. 27 août 2010 15:54:25 CEST -0.985920 secondes 15:49:45 | ven. 27 août 2010 15:54:46 CEST -1.001574 secondes 15:50:06 | ven. 27 août 2010 15:55:07 CEST -0.985939 secondes 15:50:27 | ven. 27 août 2010 15:55:28 CEST -0.985923 secondes 15:50:48 | ven. 27 août 2010 15:55:49 CEST -1.001554 secondes 15:51:09 | ven. 27 août 2010 15:56:10 CEST -0.985936 secondes 15:51:30 | ven. 27 août 2010 15:56:31 CEST -0.985928 secondes 15:51:51 | ven. 27 août 2010 15:56:52 CEST -0.985952 secondes 15:52:12 | ven. 27 août 2010 15:57:13 CEST -1.001538 secondes 15:52:33 | ven. 27 août 2010 15:57:34 CEST -0.985936 secondes 15:52:54 | ven. 27 août 2010 15:57:55 CEST -1.005861 secondes 15:53:15 | ven. 27 août 2010 15:58:16 CEST -0.990192 secondes 15:53:36 | ven. 27 août 2010 15:58:37 CEST -0.990185 secondes 15:53:57 | ven. 27 août 2010 15:58:58 CEST -0.985933 secondes 15:54:18 | ven. 27 août 2010 15:59:19 CEST -0.985931 secondes 15:54:39 | ven. 27 août 2010 15:59:40 CEST -0.985938 secondes 15:55:00 | ven. 27 août 2010 16:00:01 CEST -1.005813 secondes 15:55:21 | ven. 27 août 2010 16:00:22 CEST -0.990182 secondes 15:55:42 | ven. 27 août 2010 16:00:43 CEST -0.985932 secondes 15:56:03 | ven. 27 août 2010 16:01:04 CEST -0.985925 secondes ^ permalink raw reply [flat|nested] 16+ messages in thread
* Re: System time drifts when processor idle. 2010-08-27 14:12 ` jean-philippe francois @ 2010-08-27 18:11 ` john stultz 2010-08-28 0:10 ` Venkatesh Pallipadi 2010-09-03 12:23 ` jean-philippe francois 0 siblings, 2 replies; 16+ messages in thread From: john stultz @ 2010-08-27 18:11 UTC (permalink / raw) To: jean-philippe francois Cc: Lin Ming, venki, H. Peter Anvin, linux-acpi, LKML, jslaby On Fri, 2010-08-27 at 16:12 +0200, jean-philippe francois wrote: > My Timekeeping bug is still present, here is an updated script and log. > I am willing to make test, but I don't know what kind of debugging > info is needed. > > cat /sys/devices/system/clocksource/clocksource0/available_clocksource > hpet acpi_pm > cat /sys/devices/system/clocksource/clocksource0/current_clocksource > hpet Huh. hpet was not what I would have expected. So first, two experiments: 1) Does booting with "clock=acpi_pm" cause the issue to disappear? 2) Does booting with "nohz=off" cause the issue to disappear? Venkatesh: You have any experience with HPETs that halt in idle? thanks -john ^ permalink raw reply [flat|nested] 16+ messages in thread
* Re: System time drifts when processor idle. 2010-08-27 18:11 ` john stultz @ 2010-08-28 0:10 ` Venkatesh Pallipadi 2010-08-28 1:09 ` john stultz 2010-09-03 12:23 ` jean-philippe francois 1 sibling, 1 reply; 16+ messages in thread From: Venkatesh Pallipadi @ 2010-08-28 0:10 UTC (permalink / raw) To: john stultz Cc: jean-philippe francois, Lin Ming, H. Peter Anvin, linux-acpi, LKML, jslaby On Fri, Aug 27, 2010 at 11:11 AM, john stultz <johnstul@us.ibm.com> wrote: > On Fri, 2010-08-27 at 16:12 +0200, jean-philippe francois wrote: >> My Timekeeping bug is still present, here is an updated script and log. >> I am willing to make test, but I don't know what kind of debugging >> info is needed. >> >> cat /sys/devices/system/clocksource/clocksource0/available_clocksource >> hpet acpi_pm >> cat /sys/devices/system/clocksource/clocksource0/current_clocksource >> hpet > > Huh. hpet was not what I would have expected. > > > So first, two experiments: > > 1) Does booting with "clock=acpi_pm" cause the issue to disappear? > > 2) Does booting with "nohz=off" cause the issue to disappear? > > > Venkatesh: You have any experience with HPETs that halt in idle? > No. Haven't seen anything like this before with HPET. The jump was system | hardware(RTC) 15:48:43 | ven. 27 août 2010 15:48:44 CEST -0.985908 secondes 15:49:04 | ven. 27 août 2010 15:54:04 CEST -0.032800 secondes We lost ~300 seconds and from dmesg hpet0: 3 comparators, 64-bit 14.318180 MHz counter Which is close to 2^32 HPET ticks. So, looks like we have some 32 bit wraparound somewhere.. Thanks, Venki ^ permalink raw reply [flat|nested] 16+ messages in thread
* Re: System time drifts when processor idle. 2010-08-28 0:10 ` Venkatesh Pallipadi @ 2010-08-28 1:09 ` john stultz 2010-08-28 12:45 ` jean-philippe francois 2010-08-30 8:03 ` jean-philippe francois 0 siblings, 2 replies; 16+ messages in thread From: john stultz @ 2010-08-28 1:09 UTC (permalink / raw) To: Venkatesh Pallipadi Cc: jean-philippe francois, Lin Ming, H. Peter Anvin, linux-acpi, LKML, jslaby On Fri, 2010-08-27 at 17:10 -0700, Venkatesh Pallipadi wrote: > On Fri, Aug 27, 2010 at 11:11 AM, john stultz <johnstul@us.ibm.com> wrote: > > On Fri, 2010-08-27 at 16:12 +0200, jean-philippe francois wrote: > >> My Timekeeping bug is still present, here is an updated script and log. > >> I am willing to make test, but I don't know what kind of debugging > >> info is needed. > >> > >> cat /sys/devices/system/clocksource/clocksource0/available_clocksource > >> hpet acpi_pm > >> cat /sys/devices/system/clocksource/clocksource0/current_clocksource > >> hpet > > > > Huh. hpet was not what I would have expected. > > > > > > So first, two experiments: > > > > 1) Does booting with "clock=acpi_pm" cause the issue to disappear? > > > > 2) Does booting with "nohz=off" cause the issue to disappear? > > > > > > Venkatesh: You have any experience with HPETs that halt in idle? > > > > No. Haven't seen anything like this before with HPET. > > The jump was > > system | hardware(RTC) > 15:48:43 | ven. 27 août 2010 15:48:44 CEST -0.985908 secondes > 15:49:04 | ven. 27 août 2010 15:54:04 CEST -0.032800 secondes > > We lost ~300 seconds and from dmesg > hpet0: 3 comparators, 64-bit 14.318180 MHz counter > > Which is close to 2^32 HPET ticks. So, looks like we have some 32 bit > wraparound somewhere.. Huh. So you're thinking the timer tick scheduler is pushing way past the HPET wrap length, and then we're missing an accumulation point and things wrap under us? We have some code to try to limit the nohz length to avoid hardware wrapping, but honestly I'd be surprised if the system is actually that idle for that long (no timers firing for 5 minutes? that'd be really impressive!). jean-philippe: Is the drift always in 5 minute increments? Can you leave it idle for 3 minutes and see a similar 3 minute delay, or is it always in units of 5 ? thanks -john ^ permalink raw reply [flat|nested] 16+ messages in thread
* Re: System time drifts when processor idle. 2010-08-28 1:09 ` john stultz @ 2010-08-28 12:45 ` jean-philippe francois 2010-08-28 15:19 ` Venkatesh Pallipadi 2010-08-30 8:03 ` jean-philippe francois 1 sibling, 1 reply; 16+ messages in thread From: jean-philippe francois @ 2010-08-28 12:45 UTC (permalink / raw) To: john stultz Cc: Venkatesh Pallipadi, Lin Ming, H. Peter Anvin, linux-acpi, LKML, jslaby 2010/8/28 john stultz <johnstul@us.ibm.com>: >> > Huh. hpet was not what I would have expected. >> > >> > >> > So first, two experiments: >> > >> > 1) Does booting with "clock=acpi_pm" cause the issue to disappear? >> > Yes, the problem usually show up quite quickly, and I think I have let my script run for a long enough time to say it does not occur with clock=acpi_pm >> > 2) Does booting with "nohz=off" cause the issue to disappear? >> > Not tested yet. > > jean-philippe: Is the drift always in 5 minute increments? Can you leave > it idle for 3 minutes and see a similar 3 minute delay, or is it always > in units of 5 ? > That is interesting ! I think I have always seen 5 minutes or multiples of this delay. I will try to leave it running for a longer period of time and come back to you with more results. If you look at the first message of this thread (on linux-acpi) the delay is first 5, then 10 minutes. Thank you for your interest. Jean-Philippe ^ permalink raw reply [flat|nested] 16+ messages in thread
* Re: System time drifts when processor idle. 2010-08-28 12:45 ` jean-philippe francois @ 2010-08-28 15:19 ` Venkatesh Pallipadi 2010-09-02 11:45 ` jean-philippe francois 0 siblings, 1 reply; 16+ messages in thread From: Venkatesh Pallipadi @ 2010-08-28 15:19 UTC (permalink / raw) To: jean-philippe francois Cc: john stultz, Lin Ming, H. Peter Anvin, linux-acpi, LKML, jslaby On Sat, Aug 28, 2010 at 5:45 AM, jean-philippe francois <jp.francois@cynove.com> wrote: > 2010/8/28 john stultz <johnstul@us.ibm.com>: > >>> > Huh. hpet was not what I would have expected. >>> > >>> > >>> > So first, two experiments: >>> > >>> > 1) Does booting with "clock=acpi_pm" cause the issue to disappear? >>> > > > Yes, the problem usually show up quite quickly, and I think I have let > my script run > for a long enough time to say it does not occur with clock=acpi_pm > >>> > 2) Does booting with "nohz=off" cause the issue to disappear? >>> > > Not tested yet. > >> >> jean-philippe: Is the drift always in 5 minute increments? Can you leave >> it idle for 3 minutes and see a similar 3 minute delay, or is it always >> in units of 5 ? >> > That is interesting ! > I think I have always seen 5 minutes or multiples of this delay. I > will try to leave it running for a longer > period of time and come back to you with more results. If you look at > the first message of this thread > (on linux-acpi) the delay is first 5, then 10 minutes. > OK. So, the problem seems to be limited to HPET and 5 min multiples. > john stultz <johnstul@us.ibm.com>: > Huh. So you're thinking the timer tick scheduler is pushing way past the > HPET wrap length, and then we're missing an accumulation point and > things wrap under us? John: I don't think it is that we are going tickless beyond HPET wrap length. HPET max delta should be preventing that. We probably need to read out HPET hardware counter to see whether things are OK there. Even if we miss the interrupt, time update should notice that. One potential problem may be that HPET hardware can only do 32 bit mode, but advertising 64 bit mode and we are getting confused when we update time? jean-philippe: What does hpet section of "cat /proc/timer_list" look like? Also, can you boot with "hpet=verbose" option and send the dmesg. Thanks, Venki ^ permalink raw reply [flat|nested] 16+ messages in thread
* Re: System time drifts when processor idle. 2010-08-28 15:19 ` Venkatesh Pallipadi @ 2010-09-02 11:45 ` jean-philippe francois 0 siblings, 0 replies; 16+ messages in thread From: jean-philippe francois @ 2010-09-02 11:45 UTC (permalink / raw) To: Venkatesh Pallipadi Cc: john stultz, Lin Ming, H. Peter Anvin, linux-acpi, LKML, jslaby [-- Attachment #1: Type: text/plain, Size: 5527 bytes --] 2010/8/28 Venkatesh Pallipadi <venki@google.com>: > > OK. So, the problem seems to be limited to HPET and 5 min multiples. > >> john stultz <johnstul@us.ibm.com>: >> Huh. So you're thinking the timer tick scheduler is pushing way past the >> HPET wrap length, and then we're missing an accumulation point and >> things wrap under us? > > John: I don't think it is that we are going tickless beyond HPET wrap > length. HPET max delta should be preventing that. > We probably need to read out HPET hardware counter to see whether > things are OK there. Even if we miss the interrupt, time update should > notice that. One potential problem may be that HPET hardware can only > do 32 bit mode, but advertising 64 bit mode and we are getting > confused when we update time? > > jean-philippe: What does hpet section of "cat /proc/timer_list" look > like? Tick Device: mode: 1 Broadcast device Clock Event Device: hpet max_delta_ns: 2147483647 min_delta_ns: 7500 mult: 61496114 shift: 32 mode: 3 next_event: 11289189000000 nsecs set_next_event: hpet_legacy_next_event set_mode: hpet_legacy_set_mode event_handler: tick_handle_oneshot_broadcast tick_broadcast_mask: 00000003 tick_broadcast_oneshot_mask: 00000002 > Also, can you boot with "hpet=verbose" option and send the > dmesg. > Please find attached, and quoted below with the hpet section only : [ 0.000000] Kernel command line: root=UUID=d6f01bdd-8503-4992-bc4e-a511f74318fb ro quiet splash hpet=verbose [ 0.000000] hpet: hpet_enable(895): [ 0.000000] hpet: ID: 0x8086a201, PERIOD: 0x429b17f [ 0.000000] hpet: CFG: 0x0, STATUS: 0x0 [ 0.000000] hpet: COUNTER_l: 0x0, COUNTER_h: 0x0 [ 0.000000] hpet: T0: CFG_l: 0x30, CFG_h: 0xf00000 [ 0.000000] hpet: T0: CMP_l: 0xffffffff, CMP_h: 0xffffffff [ 0.000000] hpet: T0 ROUTE_l: 0x0, ROUTE_h: 0x0 [ 0.000000] hpet: T1: CFG_l: 0x0, CFG_h: 0xf00000 [ 0.000000] hpet: T1: CMP_l: 0xffffffff, CMP_h: 0x0 [ 0.000000] hpet: T1 ROUTE_l: 0x0, ROUTE_h: 0x0 [ 0.000000] hpet: T2: CFG_l: 0x0, CFG_h: 0xf00800 [ 0.000000] hpet: T2: CMP_l: 0xffffffff, CMP_h: 0x0 [ 0.000000] hpet: T2 ROUTE_l: 0x0, ROUTE_h: 0x0 [ 0.000000] hpet: hpet_set_mode(348): [ 0.000000] hpet: ID: 0x8086a201, PERIOD: 0x429b17f [ 0.000000] hpet: CFG: 0x3, STATUS: 0x0 [ 0.000000] hpet: COUNTER_l: 0x577, COUNTER_h: 0x0 [ 0.000000] hpet: T0: CFG_l: 0x13c, CFG_h: 0xf00000 [ 0.000000] hpet: T0: CMP_l: 0xe4c0, CMP_h: 0x0 [ 0.000000] hpet: T0 ROUTE_l: 0x0, ROUTE_h: 0x0 [ 0.000000] hpet: T1: CFG_l: 0x0, CFG_h: 0xf00000 [ 0.000000] hpet: T1: CMP_l: 0xffffffff, CMP_h: 0x0 [ 0.000000] hpet: T1 ROUTE_l: 0x0, ROUTE_h: 0x0 [ 0.000000] hpet: T2: CFG_l: 0x0, CFG_h: 0xf00800 [ 0.000000] hpet: T2: CMP_l: 0xffffffff, CMP_h: 0x0 [ 0.000000] hpet: T2 ROUTE_l: 0x0, ROUTE_h: 0x0 [ 0.000000] hpet clockevent registered [ 0.320995] hpet: hpet_msi_capability_lookup(621): [ 0.320995] hpet: ID: 0x8086a201, PERIOD: 0x429b17f [ 0.320995] hpet: CFG: 0x3, STATUS: 0x0 [ 0.320995] hpet: COUNTER_l: 0x63fff5, COUNTER_h: 0x0 [ 0.320995] hpet: T0: CFG_l: 0x138, CFG_h: 0xf00000 [ 0.320995] hpet: T0: CMP_l: 0x6484b0, CMP_h: 0x0 [ 0.320995] hpet: T0 ROUTE_l: 0x0, ROUTE_h: 0x0 [ 0.320995] hpet: T1: CFG_l: 0x0, CFG_h: 0xf00000 [ 0.320995] hpet: T1: CMP_l: 0xffffffff, CMP_h: 0x0 [ 0.320995] hpet: T1 ROUTE_l: 0x0, ROUTE_h: 0x0 [ 0.320995] hpet: T2: CFG_l: 0x0, CFG_h: 0xf00800 [ 0.320995] hpet: T2: CMP_l: 0xffffffff, CMP_h: 0x0 [ 0.320995] hpet: T2 ROUTE_l: 0x0, ROUTE_h: 0x0 [ 0.320995] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.320995] hpet0: 3 comparators, 64-bit 14.318180 MHz counter [ 0.322438] hpet: hpet_late_init(951): [ 0.322441] hpet: ID: 0x8086a201, PERIOD: 0x429b17f [ 0.322444] hpet: CFG: 0x3, STATUS: 0x0 [ 0.322447] hpet: COUNTER_l: 0x647301, COUNTER_h: 0x0 [ 0.322450] hpet: T0: CFG_l: 0x138, CFG_h: 0xf00000 [ 0.322454] hpet: T0: CMP_l: 0x6484b0, CMP_h: 0x0 [ 0.322457] hpet: T0 ROUTE_l: 0x0, ROUTE_h: 0x0 [ 0.322460] hpet: T1: CFG_l: 0x0, CFG_h: 0xf00000 [ 0.322463] hpet: T1: CMP_l: 0xffffffff, CMP_h: 0x0 [ 0.322466] hpet: T1 ROUTE_l: 0x0, ROUTE_h: 0x0 [ 0.322470] hpet: T2: CFG_l: 0x0, CFG_h: 0xf00800 [ 0.322473] hpet: T2: CMP_l: 0xc8ad01, CMP_h: 0x0 [ 0.322476] hpet: T2 ROUTE_l: 0x0, ROUTE_h: 0x0 [ 0.610087] hpet: hpet_set_mode(348): [ 0.610090] hpet: ID: 0x8086a201, PERIOD: 0x429b17f [ 0.610093] hpet: CFG: 0x3, STATUS: 0x0 [ 0.610097] hpet: COUNTER_l: 0xa30ae4, COUNTER_h: 0x0 [ 0.610100] hpet: T0: CFG_l: 0x13c, CFG_h: 0xf00000 [ 0.610104] hpet: T0: CMP_l: 0xa3ea17, CMP_h: 0x0 [ 0.610107] hpet: T0 ROUTE_l: 0x0, ROUTE_h: 0x0 [ 0.610110] hpet: T1: CFG_l: 0x0, CFG_h: 0xf00000 [ 0.610114] hpet: T1: CMP_l: 0xffffffff, CMP_h: 0x0 [ 0.610117] hpet: T1 ROUTE_l: 0x0, ROUTE_h: 0x0 [ 0.610120] hpet: T2: CFG_l: 0x0, CFG_h: 0xf00800 [ 0.610124] hpet: T2: CMP_l: 0xc8ad01, CMP_h: 0x0 [ 0.610127] hpet: T2 ROUTE_l: 0x0, ROUTE_h: 0x0 [ 0.610154] Switching to clocksource hpet [ 1.034733] rtc0: alarms up to one month, y3k, 242 bytes nvram, hpet irqs > Thanks, > Venki > -- > To unsubscribe from this list: send the line "unsubscribe linux-acpi" in > the body of a message to majordomo@vger.kernel.org > More majordomo info at http://vger.kernel.org/majordomo-info.html > [-- Attachment #2: dmesg_hpet.log --] [-- Type: text/x-log, Size: 67722 bytes --] [ 0.000000] Initializing cgroup subsys cpuset [ 0.000000] Initializing cgroup subsys cpu [ 0.000000] Linux version 2.6.36-020636rc1-generic (root@zinc) (gcc version 4.2.3 (Ubuntu 4.2.3-2ubuntu7)) #201008171306 SMP Tue Aug 17 14:16:28 UTC 2010 [ 0.000000] BIOS-provided physical RAM map: [ 0.000000] BIOS-e820: 0000000000000000 - 000000000009b400 (usable) [ 0.000000] BIOS-e820: 000000000009b400 - 00000000000a0000 (reserved) [ 0.000000] BIOS-e820: 00000000000d6000 - 00000000000d8000 (reserved) [ 0.000000] BIOS-e820: 00000000000e0000 - 0000000000100000 (reserved) [ 0.000000] BIOS-e820: 0000000000100000 - 00000000bfed0000 (usable) [ 0.000000] BIOS-e820: 00000000bfed0000 - 00000000bfedc000 (ACPI NVS) [ 0.000000] BIOS-e820: 00000000bfedc000 - 00000000c0000000 (reserved) [ 0.000000] BIOS-e820: 00000000e0000000 - 00000000f0000000 (reserved) [ 0.000000] BIOS-e820: 00000000fec00000 - 00000000fec10000 (reserved) [ 0.000000] BIOS-e820: 00000000fed00000 - 00000000fed00400 (reserved) [ 0.000000] BIOS-e820: 00000000fed14000 - 00000000fed1a000 (reserved) [ 0.000000] BIOS-e820: 00000000fed1c000 - 00000000fed90000 (reserved) [ 0.000000] BIOS-e820: 00000000fee00000 - 00000000fee01000 (reserved) [ 0.000000] BIOS-e820: 00000000ff000000 - 0000000100000000 (reserved) [ 0.000000] Notice: NX (Execute Disable) protection cannot be enabled: non-PAE kernel! [ 0.000000] DMI present. [ 0.000000] e820 update range: 0000000000000000 - 0000000000001000 (usable) ==> (reserved) [ 0.000000] e820 remove range: 00000000000a0000 - 0000000000100000 (usable) [ 0.000000] last_pfn = 0xbfed0 max_arch_pfn = 0x100000 [ 0.000000] MTRR default type: uncachable [ 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 000000000 mask F80000000 write-back [ 0.000000] 1 base 080000000 mask FC0000000 write-back [ 0.000000] 2 base 0BFF00000 mask FFFF00000 uncachable [ 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 0x7040600070406, new 0x7010600070106 [ 0.000000] e820 update range: 0000000000002000 - 0000000000010000 (usable) ==> (reserved) [ 0.000000] Scanning 1 areas for low memory corruption [ 0.000000] modified physical RAM map: [ 0.000000] modified: 0000000000000000 - 0000000000001000 (reserved) [ 0.000000] modified: 0000000000001000 - 0000000000002000 (usable) [ 0.000000] modified: 0000000000002000 - 0000000000010000 (reserved) [ 0.000000] modified: 0000000000010000 - 000000000009b400 (usable) [ 0.000000] modified: 000000000009b400 - 00000000000a0000 (reserved) [ 0.000000] modified: 00000000000d6000 - 00000000000d8000 (reserved) [ 0.000000] modified: 00000000000e0000 - 0000000000100000 (reserved) [ 0.000000] modified: 0000000000100000 - 00000000bfed0000 (usable) [ 0.000000] modified: 00000000bfed0000 - 00000000bfedc000 (ACPI NVS) [ 0.000000] modified: 00000000bfedc000 - 00000000c0000000 (reserved) [ 0.000000] modified: 00000000e0000000 - 00000000f0000000 (reserved) [ 0.000000] modified: 00000000fec00000 - 00000000fec10000 (reserved) [ 0.000000] modified: 00000000fed00000 - 00000000fed00400 (reserved) [ 0.000000] modified: 00000000fed14000 - 00000000fed1a000 (reserved) [ 0.000000] modified: 00000000fed1c000 - 00000000fed90000 (reserved) [ 0.000000] modified: 00000000fee00000 - 00000000fee01000 (reserved) [ 0.000000] modified: 00000000ff000000 - 0000000100000000 (reserved) [ 0.000000] initial memory mapped : 0 - 00c00000 [ 0.000000] found SMP MP-table at [c00f8030] f8030 [ 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 @ 15000-1a000 [ 0.000000] RAMDISK: 7f76a000 - 7fff0000 [ 0.000000] Allocated new RAMDISK: 009d1000 - 01256eff [ 0.000000] Move RAMDISK from 000000007f76a000 - 000000007ffefefe to 009d1000 - 01256efe [ 0.000000] ACPI: RSDP 000f8000 00024 (v02 PTLTD ) [ 0.000000] ACPI: XSDT bfed24d6 0007C (v01 FSC PC 06040000 LTP 00000000) [ 0.000000] ACPI: FACP bfed8c6c 000F4 (v03 INTEL CRESTLNE 06040000 ALAN 00000001) [ 0.000000] ACPI: DSDT bfed3ae1 05117 (v02 ECS F44 06040000 INTL 20050624) [ 0.000000] ACPI: FACS bfedbfc0 00040 [ 0.000000] ACPI: HPET bfed8d60 00038 (v01 INTEL CRESTLNE 06040000 LOHR 0000005A) [ 0.000000] ACPI: MCFG bfed8d98 0003C (v01 INTEL CRESTLNE 06040000 LOHR 0000005A) [ 0.000000] ACPI: TMOR bfed8dd4 00026 (v01 PTLTD 06040000 PTL 00000003) [ 0.000000] ACPI: APIC bfed8dfa 00068 (v01 PTLTD ? APIC 06040000 LTP 00000000) [ 0.000000] ACPI: BOOT bfed8e62 00028 (v01 PTLTD $SBFTBL$ 06040000 LTP 00000001) [ 0.000000] ACPI: SLIC bfed8e8a 00176 (v01 FSC PC 06040000 LTP 00000000) [ 0.000000] ACPI: SSDT bfed3804 002DD (v01 SataRe SataAhci 00001000 INTL 20050624) [ 0.000000] ACPI: SSDT bfed2b0e 0025F (v01 PmRef Cpu0Tst 00003000 INTL 20050624) [ 0.000000] ACPI: SSDT bfed2a68 000A6 (v01 PmRef Cpu1Tst 00003000 INTL 20050624) [ 0.000000] ACPI: SSDT bfed2552 00516 (v01 PmRef CpuPm 00003000 INTL 20050624) [ 0.000000] ACPI: Local APIC address 0xfee00000 [ 0.000000] 2182MB HIGHMEM available. [ 0.000000] 887MB LOWMEM available. [ 0.000000] mapped low ram: 0 - 377fe000 [ 0.000000] low ram: 0 - 377fe000 [ 0.000000] Zone PFN ranges: [ 0.000000] DMA 0x00000001 -> 0x00001000 [ 0.000000] Normal 0x00001000 -> 0x000377fe [ 0.000000] HighMem 0x000377fe -> 0x000bfed0 [ 0.000000] Movable zone start PFN for each node [ 0.000000] early_node_map[3] active PFN ranges [ 0.000000] 0: 0x00000001 -> 0x00000002 [ 0.000000] 0: 0x00000010 -> 0x0000009b [ 0.000000] 0: 0x00000100 -> 0x000bfed0 [ 0.000000] On node 0 totalpages: 786012 [ 0.000000] free_area_init_node: node 0, pgdat c081c580, node_mem_map c1258020 [ 0.000000] DMA zone: 32 pages used for memmap [ 0.000000] DMA zone: 0 pages reserved [ 0.000000] DMA zone: 3948 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: 4366 pages used for memmap [ 0.000000] HighMem zone: 554436 pages, LIFO batch:31 [ 0.000000] Using APIC driver default [ 0.000000] ACPI: PM-Timer IO Port: 0x1008 [ 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_NMI (acpi_id[0x00] high edge lint[0x1]) [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0x01] high edge lint[0x1]) [ 0.000000] ACPI: IOAPIC (id[0x02] address[0xfec00000] gsi_base[0]) [ 0.000000] IOAPIC[0]: apic_id 2, version 32, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 high edge) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: IRQ0 used by override. [ 0.000000] ACPI: IRQ2 used by override. [ 0.000000] ACPI: IRQ9 used by override. [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] SMP: Allowing 2 CPUs, 0 hotplug CPUs [ 0.000000] nr_irqs_gsi: 40 [ 0.000000] early_res array is doubled to 64 at [16000 - 167ff] [ 0.000000] PM: Registered nosave memory: 0000000000002000 - 0000000000010000 [ 0.000000] PM: Registered nosave memory: 000000000009b000 - 000000000009c000 [ 0.000000] PM: Registered nosave memory: 000000000009c000 - 00000000000a0000 [ 0.000000] PM: Registered nosave memory: 00000000000a0000 - 00000000000d6000 [ 0.000000] PM: Registered nosave memory: 00000000000d6000 - 00000000000d8000 [ 0.000000] PM: Registered nosave memory: 00000000000d8000 - 00000000000e0000 [ 0.000000] PM: Registered nosave memory: 00000000000e0000 - 0000000000100000 [ 0.000000] Allocating PCI resources starting at c0000000 (gap: c0000000:20000000) [ 0.000000] Booting paravirtualized kernel on bare hardware [ 0.000000] setup_percpu: NR_CPUS:8 nr_cpumask_bits:8 nr_cpu_ids:2 nr_node_ids:1 [ 0.000000] PERCPU: Embedded 14 pages/cpu @c2c00000 s32832 r0 d24512 u2097152 [ 0.000000] pcpu-alloc: s32832 r0 d24512 u2097152 alloc=1*4194304 [ 0.000000] pcpu-alloc: [0] 0 1 [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 779870 [ 0.000000] Kernel command line: root=UUID=d6f01bdd-8503-4992-bc4e-a511f74318fb ro quiet splash hpet=verbose [ 0.000000] PID hash table entries: 4096 (order: 2, 16384 bytes) [ 0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes) [ 0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes) [ 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] allocated 15722540 bytes of page_cgroup [ 0.000000] please try 'cgroup_disable=memory' option if you don't want memory cgroups [ 0.000000] Subtract (54 early reservations) [ 0.000000] #1 [0000001000 - 0000002000] EX TRAMPOLINE [ 0.000000] #2 [0000100000 - 00009cc864] TEXT DATA BSS [ 0.000000] #3 [00009cd000 - 00009d0140] BRK [ 0.000000] #4 [00000f8040 - 0000100000] BIOS reserved [ 0.000000] #5 [00000f8030 - 00000f8040] MP-table mpf [ 0.000000] #6 [000009b400 - 000009b971] BIOS reserved [ 0.000000] #7 [000009bb65 - 00000f8030] BIOS reserved [ 0.000000] #8 [000009b971 - 000009bb65] MP-table mpc [ 0.000000] #9 [0000010000 - 0000011000] TRAMPOLINE [ 0.000000] #10 [0000011000 - 0000015000] ACPI WAKEUP [ 0.000000] #11 [0000015000 - 0000016000] PGTABLE [ 0.000000] #12 [00009d1000 - 0001257000] NEW RAMDISK [ 0.000000] #13 [0001257000 - 0001258000] BOOTMEM [ 0.000000] #14 [0001258000 - 0002a58000] BOOTMEM [ 0.000000] #15 [0002a58000 - 0002a58004] BOOTMEM [ 0.000000] #16 [0002a58040 - 0002a58100] BOOTMEM [ 0.000000] #17 [0002a58100 - 0002a58154] BOOTMEM [ 0.000000] #18 [0002a58180 - 0002a5b180] BOOTMEM [ 0.000000] #19 [0002a5b180 - 0002a5b250] BOOTMEM [ 0.000000] #20 [0002a5b280 - 0002a67280] BOOTMEM [ 0.000000] #21 [0002a67280 - 0002a672a5] BOOTMEM [ 0.000000] #22 [0002a672c0 - 0002a672e7] BOOTMEM [ 0.000000] #23 [0002a67300 - 0002a674dc] BOOTMEM [ 0.000000] #24 [0002a67500 - 0002a67540] BOOTMEM [ 0.000000] #25 [0002a67540 - 0002a67580] BOOTMEM [ 0.000000] #26 [0002a67580 - 0002a675c0] BOOTMEM [ 0.000000] #27 [0002a675c0 - 0002a67600] BOOTMEM [ 0.000000] #28 [0002a67600 - 0002a67640] BOOTMEM [ 0.000000] #29 [0002a67640 - 0002a67680] BOOTMEM [ 0.000000] #30 [0002a67680 - 0002a676c0] BOOTMEM [ 0.000000] #31 [0002a676c0 - 0002a67700] BOOTMEM [ 0.000000] #32 [0002a67700 - 0002a67740] BOOTMEM [ 0.000000] #33 [0002a67740 - 0002a67780] BOOTMEM [ 0.000000] #34 [0002a67780 - 0002a677c0] BOOTMEM [ 0.000000] #35 [0002a677c0 - 0002a67800] BOOTMEM [ 0.000000] #36 [0002a67800 - 0002a67840] BOOTMEM [ 0.000000] #37 [0002a67840 - 0002a67880] BOOTMEM [ 0.000000] #38 [0002a67880 - 0002a67890] BOOTMEM [ 0.000000] #39 [0002a678c0 - 0002a678d0] BOOTMEM [ 0.000000] #40 [0002a67900 - 0002a6794c] BOOTMEM [ 0.000000] #41 [0002a67980 - 0002a679cc] BOOTMEM [ 0.000000] #42 [0002c00000 - 0002c0e000] BOOTMEM [ 0.000000] #43 [0002e00000 - 0002e0e000] BOOTMEM [ 0.000000] #44 [0002a69a00 - 0002a69a04] BOOTMEM [ 0.000000] #45 [0002a69a40 - 0002a69a44] BOOTMEM [ 0.000000] #46 [0002a69a80 - 0002a69a88] BOOTMEM [ 0.000000] #47 [0002a69ac0 - 0002a69ac8] BOOTMEM [ 0.000000] #48 [0002a69b00 - 0002a69ba8] BOOTMEM [ 0.000000] #49 [0002a69bc0 - 0002a69c28] BOOTMEM [ 0.000000] #50 [0002a69c40 - 0002a6dc40] BOOTMEM [ 0.000000] #51 [0002a6dc40 - 0002aedc40] BOOTMEM [ 0.000000] #52 [0002aedc40 - 0002b2dc40] BOOTMEM [ 0.000000] #53 [0002e0e000 - 0003d0c82c] BOOTMEM [ 0.000000] Initializing HighMem for node 0 (000377fe:000bfed0) [ 0.000000] Memory: 3085364k/3144512k available (4980k kernel code, 58684k reserved, 2400k data, 732k init, 2235208k highmem) [ 0.000000] virtual kernel memory layout: [ 0.000000] fixmap : 0xfff16000 - 0xfffff000 ( 932 kB) [ 0.000000] pkmap : 0xff800000 - 0xffc00000 (4096 kB) [ 0.000000] vmalloc : 0xf7ffe000 - 0xff7fe000 ( 120 MB) [ 0.000000] lowmem : 0xc0000000 - 0xf77fe000 ( 887 MB) [ 0.000000] .init : 0xc0836000 - 0xc08ed000 ( 732 kB) [ 0.000000] .data : 0xc05dd1af - 0xc0835568 (2400 kB) [ 0.000000] .text : 0xc0100000 - 0xc05dd1af (4980 kB) [ 0.000000] Checking if this processor honours the WP bit even in supervisor mode...Ok. [ 0.000000] SLUB: Genslabs=13, HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 [ 0.000000] Hierarchical RCU implementation. [ 0.000000] RCU dyntick-idle grace-period acceleration is enabled. [ 0.000000] RCU-based detection of stalled CPUs is disabled. [ 0.000000] Verbose stalled-CPUs detection is disabled. [ 0.000000] NR_IRQS:2304 nr_irqs:512 [ 0.000000] Extended CMOS year: 2000 [ 0.000000] Console: colour VGA+ 80x25 [ 0.000000] console [tty0] enabled [ 0.000000] hpet: hpet_enable(895): [ 0.000000] hpet: ID: 0x8086a201, PERIOD: 0x429b17f [ 0.000000] hpet: CFG: 0x0, STATUS: 0x0 [ 0.000000] hpet: COUNTER_l: 0x0, COUNTER_h: 0x0 [ 0.000000] hpet: T0: CFG_l: 0x30, CFG_h: 0xf00000 [ 0.000000] hpet: T0: CMP_l: 0xffffffff, CMP_h: 0xffffffff [ 0.000000] hpet: T0 ROUTE_l: 0x0, ROUTE_h: 0x0 [ 0.000000] hpet: T1: CFG_l: 0x0, CFG_h: 0xf00000 [ 0.000000] hpet: T1: CMP_l: 0xffffffff, CMP_h: 0x0 [ 0.000000] hpet: T1 ROUTE_l: 0x0, ROUTE_h: 0x0 [ 0.000000] hpet: T2: CFG_l: 0x0, CFG_h: 0xf00800 [ 0.000000] hpet: T2: CMP_l: 0xffffffff, CMP_h: 0x0 [ 0.000000] hpet: T2 ROUTE_l: 0x0, ROUTE_h: 0x0 [ 0.000000] hpet: hpet_set_mode(348): [ 0.000000] hpet: ID: 0x8086a201, PERIOD: 0x429b17f [ 0.000000] hpet: CFG: 0x3, STATUS: 0x0 [ 0.000000] hpet: COUNTER_l: 0x577, COUNTER_h: 0x0 [ 0.000000] hpet: T0: CFG_l: 0x13c, CFG_h: 0xf00000 [ 0.000000] hpet: T0: CMP_l: 0xe4c0, CMP_h: 0x0 [ 0.000000] hpet: T0 ROUTE_l: 0x0, ROUTE_h: 0x0 [ 0.000000] hpet: T1: CFG_l: 0x0, CFG_h: 0xf00000 [ 0.000000] hpet: T1: CMP_l: 0xffffffff, CMP_h: 0x0 [ 0.000000] hpet: T1 ROUTE_l: 0x0, ROUTE_h: 0x0 [ 0.000000] hpet: T2: CFG_l: 0x0, CFG_h: 0xf00800 [ 0.000000] hpet: T2: CMP_l: 0xffffffff, CMP_h: 0x0 [ 0.000000] hpet: T2 ROUTE_l: 0x0, ROUTE_h: 0x0 [ 0.000000] hpet clockevent registered [ 0.000000] Fast TSC calibration using PIT [ 0.000000] Detected 2493.418 MHz processor. [ 0.004005] Calibrating delay loop (skipped), value calculated using timer frequency.. 4986.83 BogoMIPS (lpj=9973672) [ 0.004010] pid_max: default: 32768 minimum: 301 [ 0.004026] Security Framework initialized [ 0.004044] AppArmor: AppArmor initialized [ 0.004084] Mount-cache hash table entries: 512 [ 0.004202] Initializing cgroup subsys ns [ 0.004206] Initializing cgroup subsys cpuacct [ 0.004210] Initializing cgroup subsys memory [ 0.004219] Initializing cgroup subsys devices [ 0.004220] Initializing cgroup subsys freezer [ 0.004222] Initializing cgroup subsys net_cls [ 0.004252] CPU: Physical Processor ID: 0 [ 0.004253] CPU: Processor Core ID: 0 [ 0.004256] mce: CPU supports 6 MCE banks [ 0.004264] CPU0: Thermal monitoring enabled (TM2) [ 0.004267] using mwait in idle threads. [ 0.004274] Performance Events: PEBS fmt0+, Core2 events, Intel PMU driver. [ 0.004284] ... version: 2 [ 0.004285] ... bit width: 40 [ 0.004286] ... generic registers: 2 [ 0.004288] ... value mask: 000000ffffffffff [ 0.004289] ... max period: 000000007fffffff [ 0.004290] ... fixed-purpose events: 3 [ 0.004292] ... event mask: 0000000700000003 [ 0.007259] ACPI: Core revision 20100702 [ 0.015645] ftrace: converting mcount calls to 0f 1f 44 00 00 [ 0.015651] ftrace: allocating 25958 entries in 51 pages [ 0.020037] Enabling APIC mode: Flat. Using 1 I/O APICs [ 0.020382] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.061582] CPU0: Intel(R) Core(TM)2 Duo CPU T9300 @ 2.50GHz stepping 06 [ 0.064000] Booting Node 0, Processors #1 Ok. [ 0.008000] Initializing CPU#1 [ 0.152016] Brought up 2 CPUs [ 0.152018] Total of 2 processors activated (9974.27 BogoMIPS). [ 0.153032] devtmpfs: initialized [ 0.153032] regulator: core version 0.5 [ 0.153032] Time: 16:38:09 Date: 09/01/10 [ 0.153032] NET: Registered protocol family 16 [ 0.153032] EISA bus registered [ 0.153032] ACPI: bus type pci registered [ 0.153068] PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xe0000000-0xefffffff] (base 0xe0000000) [ 0.153072] PCI: MMCONFIG at [mem 0xe0000000-0xefffffff] reserved in E820 [ 0.153073] PCI: Using MMCONFIG for extended config space [ 0.153075] PCI: Using configuration type 1 for base access [ 0.153818] bio: create slab <bio-0> at 0 [ 0.156443] ACPI: EC: Look up EC in DSDT [ 0.158751] ACPI: BIOS _OSI(Linux) query ignored [ 0.159823] ACPI: SSDT bfed33fe 0033E (v01 PmRef Cpu0Ist 00003000 INTL 20050624) [ 0.160105] ACPI: Dynamic OEM Table Load: [ 0.160108] ACPI: SSDT (null) 0033E (v01 PmRef Cpu0Ist 00003000 INTL 20050624) [ 0.160401] ACPI: SSDT bfed2d6d 0060C (v01 PmRef Cpu0Cst 00003001 INTL 20050624) [ 0.160655] ACPI: Dynamic OEM Table Load: [ 0.160658] ACPI: SSDT (null) 0060C (v01 PmRef Cpu0Cst 00003001 INTL 20050624) [ 0.161010] ACPI: SSDT bfed373c 000C8 (v01 PmRef Cpu1Ist 00003000 INTL 20050624) [ 0.161273] ACPI: Dynamic OEM Table Load: [ 0.161276] ACPI: SSDT (null) 000C8 (v01 PmRef Cpu1Ist 00003000 INTL 20050624) [ 0.161407] ACPI: SSDT bfed3379 00085 (v01 PmRef Cpu1Cst 00003000 INTL 20050624) [ 0.161661] ACPI: Dynamic OEM Table Load: [ 0.161664] ACPI: SSDT (null) 00085 (v01 PmRef Cpu1Cst 00003000 INTL 20050624) [ 0.240031] ACPI: Interpreter enabled [ 0.240035] ACPI: (supports S0 S3 S4 S5) [ 0.240054] ACPI: Using IOAPIC for interrupt routing [ 0.284859] ACPI: EC: GPE = 0x11, I/O: command/status = 0x66, data = 0x62 [ 0.285140] ACPI: No dock devices found. [ 0.285144] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.285712] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.286827] pci_root PNP0A08:00: host bridge window [io 0x0000-0x0cf7] [ 0.286830] pci_root PNP0A08:00: host bridge window [io 0x0d00-0xffff] [ 0.286832] pci_root PNP0A08:00: host bridge window [mem 0x000a0000-0x000bffff] [ 0.286835] pci_root PNP0A08:00: host bridge window [mem 0x000d8000-0x000dbfff] [ 0.286838] pci_root PNP0A08:00: host bridge window [mem 0x000dc000-0x000dffff] [ 0.286841] pci_root PNP0A08:00: host bridge window [mem 0xc0000000-0xdfffffff] [ 0.286843] pci_root PNP0A08:00: host bridge window [mem 0xf0000000-0xfebfffff] [ 0.286926] pci 0000:00:01.0: PME# supported from D0 D3hot D3cold [ 0.286929] pci 0000:00:01.0: PME# disabled [ 0.287038] pci 0000:00:1a.0: reg 20: [io 0x1800-0x181f] [ 0.287132] pci 0000:00:1a.1: reg 20: [io 0x1820-0x183f] [ 0.287210] pci 0000:00:1a.7: reg 10: [mem 0xf0804800-0xf0804bff] [ 0.287304] pci 0000:00:1a.7: PME# supported from D0 D3hot D3cold [ 0.287309] pci 0000:00:1a.7: PME# disabled [ 0.287358] pci 0000:00:1b.0: reg 10: [mem 0xf0800000-0xf0803fff 64bit] [ 0.287443] pci 0000:00:1b.0: PME# supported from D0 D3hot D3cold [ 0.287448] pci 0000:00:1b.0: PME# disabled [ 0.287561] pci 0000:00:1c.0: PME# supported from D0 D3hot D3cold [ 0.287566] pci 0000:00:1c.0: PME# disabled [ 0.287682] pci 0000:00:1c.1: PME# supported from D0 D3hot D3cold [ 0.287686] pci 0000:00:1c.1: PME# disabled [ 0.287803] pci 0000:00:1c.2: PME# supported from D0 D3hot D3cold [ 0.287808] pci 0000:00:1c.2: PME# disabled [ 0.287924] pci 0000:00:1c.3: PME# supported from D0 D3hot D3cold [ 0.287928] pci 0000:00:1c.3: PME# disabled [ 0.288053] pci 0000:00:1c.4: PME# supported from D0 D3hot D3cold [ 0.288058] pci 0000:00:1c.4: PME# disabled [ 0.288172] pci 0000:00:1c.5: PME# supported from D0 D3hot D3cold [ 0.288176] pci 0000:00:1c.5: PME# disabled [ 0.288263] pci 0000:00:1d.0: reg 20: [io 0x1840-0x185f] [ 0.288358] pci 0000:00:1d.1: reg 20: [io 0x1860-0x187f] [ 0.288453] pci 0000:00:1d.2: reg 20: [io 0x1880-0x189f] [ 0.288531] pci 0000:00:1d.7: reg 10: [mem 0xf0804c00-0xf0804fff] [ 0.288625] pci 0000:00:1d.7: PME# supported from D0 D3hot D3cold [ 0.288631] pci 0000:00:1d.7: PME# disabled [ 0.288842] pci 0000:00:1f.0: quirk: [io 0x1000-0x107f] claimed by ICH6 ACPI/GPIO/TCO [ 0.288846] pci 0000:00:1f.0: quirk: [io 0x1180-0x11bf] claimed by ICH6 GPIO [ 0.288851] pci 0000:00:1f.0: ICH7 LPC Generic IO decode 1 PIO at 0068 (mask 0007) [ 0.288855] pci 0000:00:1f.0: ICH7 LPC Generic IO decode 2 PIO at 0260 (mask 0003) [ 0.288913] pci 0000:00:1f.1: reg 10: [io 0x0000-0x0007] [ 0.288925] pci 0000:00:1f.1: reg 14: [io 0x0000-0x0003] [ 0.288938] pci 0000:00:1f.1: reg 18: [io 0x0000-0x0007] [ 0.288950] pci 0000:00:1f.1: reg 1c: [io 0x0000-0x0003] [ 0.288963] pci 0000:00:1f.1: reg 20: [io 0x18a0-0x18af] [ 0.289040] pci 0000:00:1f.2: reg 10: [io 0x18d8-0x18df] [ 0.289052] pci 0000:00:1f.2: reg 14: [io 0x18cc-0x18cf] [ 0.289065] pci 0000:00:1f.2: reg 18: [io 0x18d0-0x18d7] [ 0.289077] pci 0000:00:1f.2: reg 1c: [io 0x18c8-0x18cb] [ 0.289089] pci 0000:00:1f.2: reg 20: [io 0x18e0-0x18ff] [ 0.289101] pci 0000:00:1f.2: reg 24: [mem 0xf0804000-0xf08047ff] [ 0.289148] pci 0000:00:1f.2: PME# supported from D3hot [ 0.289153] pci 0000:00:1f.2: PME# disabled [ 0.289188] pci 0000:00:1f.3: reg 10: [mem 0x00000000-0x000000ff] [ 0.289231] pci 0000:00:1f.3: reg 20: [io 0x1c00-0x1c1f] [ 0.289331] pci 0000:01:00.0: reg 10: [mem 0xd0000000-0xdfffffff 64bit pref] [ 0.289349] pci 0000:01:00.0: reg 18: [mem 0xcfef0000-0xcfefffff 64bit] [ 0.289360] pci 0000:01:00.0: reg 20: [io 0x2000-0x20ff] [ 0.289382] pci 0000:01:00.0: reg 30: [mem 0x00000000-0x0001ffff pref] [ 0.289412] pci 0000:01:00.0: supports D1 D2 [ 0.289462] pci 0000:01:00.1: reg 10: [mem 0xcfeec000-0xcfeeffff 64bit] [ 0.289543] pci 0000:01:00.1: supports D1 D2 [ 0.289592] pci 0000:00:01.0: PCI bridge to [bus 01-01] [ 0.289595] pci 0000:00:01.0: bridge window [io 0x2000-0x2fff] [ 0.289599] pci 0000:00:01.0: bridge window [mem 0xcfe00000-0xcfefffff] [ 0.289603] pci 0000:00:01.0: bridge window [mem 0xd0000000-0xdfffffff 64bit pref] [ 0.289665] pci 0000:00:1c.0: PCI bridge to [bus 02-03] [ 0.289670] pci 0000:00:1c.0: bridge window [io 0xf000-0xffff] [ 0.289675] pci 0000:00:1c.0: bridge window [mem 0xfb000000-0xfcffffff] [ 0.289683] pci 0000:00:1c.0: bridge window [mem 0xfff00000-0x000fffff pref] (disabled) [ 0.289791] pci 0000:04:00.0: reg 10: [mem 0xf0300000-0xf03003ff] [ 0.289823] pci 0000:04:00.0: reg 18: [io 0x3000-0x307f] [ 0.289885] pci 0000:04:00.0: reg 30: [mem 0x00000000-0x0000ffff pref] [ 0.296017] pci 0000:00:1c.1: PCI bridge to [bus 04-04] [ 0.296022] pci 0000:00:1c.1: bridge window [io 0x3000-0x3fff] [ 0.296027] pci 0000:00:1c.1: bridge window [mem 0xf0300000-0xf03fffff] [ 0.296035] pci 0000:00:1c.1: bridge window [mem 0xfff00000-0x000fffff pref] (disabled) [ 0.296169] pci 0000:05:00.0: reg 10: [mem 0xf0200000-0xf0201fff 64bit] [ 0.296333] pci 0000:05:00.0: PME# supported from D0 D3hot D3cold [ 0.296340] pci 0000:05:00.0: PME# disabled [ 0.304022] pci 0000:00:1c.2: PCI bridge to [bus 05-05] [ 0.304028] pci 0000:00:1c.2: bridge window [io 0xf000-0x0000] (disabled) [ 0.304032] pci 0000:00:1c.2: bridge window [mem 0xf0200000-0xf02fffff] [ 0.304040] pci 0000:00:1c.2: bridge window [mem 0xfff00000-0x000fffff pref] (disabled) [ 0.304154] pci 0000:06:00.0: reg 10: [io 0x4000-0x40ff] [ 0.304196] pci 0000:06:00.0: reg 18: [mem 0xf0500000-0xf0500fff 64bit] [ 0.304243] pci 0000:06:00.0: reg 30: [mem 0x00000000-0x0001ffff pref] [ 0.304304] pci 0000:06:00.0: supports D1 D2 [ 0.304306] pci 0000:06:00.0: PME# supported from D1 D2 D3hot D3cold [ 0.304312] pci 0000:06:00.0: PME# disabled [ 0.304341] pci 0000:06:00.0: disabling ASPM on pre-1.1 PCIe device. You can enable it with 'pcie_aspm=force' [ 0.304354] pci 0000:00:1c.3: PCI bridge to [bus 06-06] [ 0.304359] pci 0000:00:1c.3: bridge window [io 0x4000-0x4fff] [ 0.304363] pci 0000:00:1c.3: bridge window [mem 0xf0500000-0xf05fffff] [ 0.304371] pci 0000:00:1c.3: bridge window [mem 0xfff00000-0x000fffff pref] (disabled) [ 0.304490] pci 0000:07:00.0: reg 10: [mem 0xf0402000-0xf040207f 64bit] [ 0.304517] pci 0000:07:00.0: reg 18: [mem 0xf0400000-0xf0401fff 64bit] [ 0.304534] pci 0000:07:00.0: reg 20: [io 0x5000-0x507f] [ 0.304614] pci 0000:07:00.0: supports D1 D2 [ 0.312017] pci 0000:00:1c.4: PCI bridge to [bus 07-07] [ 0.312022] pci 0000:00:1c.4: bridge window [io 0x5000-0x5fff] [ 0.312027] pci 0000:00:1c.4: bridge window [mem 0xf0400000-0xf04fffff] [ 0.312034] pci 0000:00:1c.4: bridge window [mem 0xfff00000-0x000fffff pref] (disabled) [ 0.312234] pci 0000:08:00.0: reg 24: [mem 0xf0600000-0xf0601fff] [ 0.312290] pci 0000:08:00.0: PME# supported from D3hot [ 0.312296] pci 0000:08:00.0: PME# disabled [ 0.312361] pci 0000:08:00.1: reg 10: [io 0x6020-0x6027] [ 0.312378] pci 0000:08:00.1: reg 14: [io 0x6014-0x6017] [ 0.312396] pci 0000:08:00.1: reg 18: [io 0x6018-0x601f] [ 0.312413] pci 0000:08:00.1: reg 1c: [io 0x6010-0x6013] [ 0.312431] pci 0000:08:00.1: reg 20: [io 0x6000-0x600f] [ 0.312522] pci 0000:08:00.0: disabling ASPM on pre-1.1 PCIe device. You can enable it with 'pcie_aspm=force' [ 0.312539] pci 0000:00:1c.5: PCI bridge to [bus 08-08] [ 0.312544] pci 0000:00:1c.5: bridge window [io 0x6000-0x6fff] [ 0.312549] pci 0000:00:1c.5: bridge window [mem 0xf0600000-0xf06fffff] [ 0.312557] pci 0000:00:1c.5: bridge window [mem 0xfff00000-0x000fffff pref] (disabled) [ 0.312628] pci 0000:09:04.0: reg 10: [mem 0xf0701000-0xf0701fff] [ 0.312641] pci 0000:09:04.0: reg 14: [mem 0xf0700000-0xf07007ff] [ 0.312718] pci 0000:09:04.0: supports D1 D2 [ 0.312720] pci 0000:09:04.0: PME# supported from D0 D1 D2 D3hot D3cold [ 0.312725] pci 0000:09:04.0: PME# disabled [ 0.312790] pci 0000:00:1e.0: PCI bridge to [bus 09-09] (subtractive decode) [ 0.312795] pci 0000:00:1e.0: bridge window [io 0xf000-0x0000] (disabled) [ 0.312799] pci 0000:00:1e.0: bridge window [mem 0xf0700000-0xf07fffff] [ 0.312807] pci 0000:00:1e.0: bridge window [mem 0xfff00000-0x000fffff pref] (disabled) [ 0.312809] pci 0000:00:1e.0: bridge window [io 0x0000-0x0cf7] (subtractive decode) [ 0.312812] pci 0000:00:1e.0: bridge window [io 0x0d00-0xffff] (subtractive decode) [ 0.312814] pci 0000:00:1e.0: bridge window [mem 0x000a0000-0x000bffff] (subtractive decode) [ 0.312817] pci 0000:00:1e.0: bridge window [mem 0x000d8000-0x000dbfff] (subtractive decode) [ 0.312819] pci 0000:00:1e.0: bridge window [mem 0x000dc000-0x000dffff] (subtractive decode) [ 0.312821] pci 0000:00:1e.0: bridge window [mem 0xc0000000-0xdfffffff] (subtractive decode) [ 0.312824] pci 0000:00:1e.0: bridge window [mem 0xf0000000-0xfebfffff] (subtractive decode) [ 0.312871] pci_bus 0000:00: on NUMA node 0 [ 0.312874] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT] [ 0.313097] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PEGP._PRT] [ 0.313162] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.RP01._PRT] [ 0.313222] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.RP02._PRT] [ 0.313283] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.RP03._PRT] [ 0.313344] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.RP04._PRT] [ 0.313404] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.RP05._PRT] [ 0.313465] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.RP06._PRT] [ 0.313549] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PCIB._PRT] [ 0.313594] Unable to assume PCIe control: Disabling ASPM [ 0.320310] ACPI: PCI Interrupt Link [LNKA] (IRQs 1 3 4 *5 6 7 10 12 14 15) [ 0.320374] ACPI: PCI Interrupt Link [LNKB] (IRQs 1 3 4 5 6 7 11 12 14 15) *10 [ 0.320437] ACPI: PCI Interrupt Link [LNKC] (IRQs 1 3 4 5 6 *7 10 12 14 15) [ 0.320499] ACPI: PCI Interrupt Link [LNKD] (IRQs 1 3 4 5 6 7 11 12 14 15) *10 [ 0.320562] ACPI: PCI Interrupt Link [LNKE] (IRQs 1 3 4 5 6 7 10 12 14 15) *11 [ 0.320625] ACPI: PCI Interrupt Link [LNKF] (IRQs 1 3 4 5 6 7 *11 12 14 15) [ 0.320687] ACPI: PCI Interrupt Link [LNKG] (IRQs 1 3 4 5 6 7 10 12 14 15) *11 [ 0.320750] ACPI: PCI Interrupt Link [LNKH] (IRQs 1 3 4 5 6 7 11 12 14 15) *10 [ 0.320778] HEST: Table is not found! [ 0.320847] vgaarb: device added: PCI:0000:01:00.0,decodes=io+mem,owns=io+mem,locks=none [ 0.320853] vgaarb: loaded [ 0.320988] SCSI subsystem initialized [ 0.320995] libata version 3.00 loaded. [ 0.320995] usbcore: registered new interface driver usbfs [ 0.320995] usbcore: registered new interface driver hub [ 0.320995] usbcore: registered new device driver usb [ 0.320995] ACPI: WMI: Mapper loaded [ 0.320995] PCI: Using ACPI for IRQ routing [ 0.320995] PCI: pci_cache_line_size set to 64 bytes [ 0.320995] reserve RAM buffer: 0000000000002000 - 000000000000ffff [ 0.320995] reserve RAM buffer: 000000000009b400 - 000000000009ffff [ 0.320995] reserve RAM buffer: 00000000bfed0000 - 00000000bfffffff [ 0.320995] NetLabel: Initializing [ 0.320995] NetLabel: domain hash size = 128 [ 0.320995] NetLabel: protocols = UNLABELED CIPSOv4 [ 0.320995] NetLabel: unlabeled traffic allowed by default [ 0.320995] hpet: hpet_msi_capability_lookup(621): [ 0.320995] hpet: ID: 0x8086a201, PERIOD: 0x429b17f [ 0.320995] hpet: CFG: 0x3, STATUS: 0x0 [ 0.320995] hpet: COUNTER_l: 0x63fff5, COUNTER_h: 0x0 [ 0.320995] hpet: T0: CFG_l: 0x138, CFG_h: 0xf00000 [ 0.320995] hpet: T0: CMP_l: 0x6484b0, CMP_h: 0x0 [ 0.320995] hpet: T0 ROUTE_l: 0x0, ROUTE_h: 0x0 [ 0.320995] hpet: T1: CFG_l: 0x0, CFG_h: 0xf00000 [ 0.320995] hpet: T1: CMP_l: 0xffffffff, CMP_h: 0x0 [ 0.320995] hpet: T1 ROUTE_l: 0x0, ROUTE_h: 0x0 [ 0.320995] hpet: T2: CFG_l: 0x0, CFG_h: 0xf00800 [ 0.320995] hpet: T2: CMP_l: 0xffffffff, CMP_h: 0x0 [ 0.320995] hpet: T2 ROUTE_l: 0x0, ROUTE_h: 0x0 [ 0.320995] HPET: 3 timers in total, 0 timers will be used for per-cpu timer [ 0.320995] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.320995] hpet0: 3 comparators, 64-bit 14.318180 MHz counter [ 0.322438] hpet: hpet_late_init(951): [ 0.322441] hpet: ID: 0x8086a201, PERIOD: 0x429b17f [ 0.322444] hpet: CFG: 0x3, STATUS: 0x0 [ 0.322447] hpet: COUNTER_l: 0x647301, COUNTER_h: 0x0 [ 0.322450] hpet: T0: CFG_l: 0x138, CFG_h: 0xf00000 [ 0.322454] hpet: T0: CMP_l: 0x6484b0, CMP_h: 0x0 [ 0.322457] hpet: T0 ROUTE_l: 0x0, ROUTE_h: 0x0 [ 0.322460] hpet: T1: CFG_l: 0x0, CFG_h: 0xf00000 [ 0.322463] hpet: T1: CMP_l: 0xffffffff, CMP_h: 0x0 [ 0.322466] hpet: T1 ROUTE_l: 0x0, ROUTE_h: 0x0 [ 0.322470] hpet: T2: CFG_l: 0x0, CFG_h: 0xf00800 [ 0.322473] hpet: T2: CMP_l: 0xc8ad01, CMP_h: 0x0 [ 0.322476] hpet: T2 ROUTE_l: 0x0, ROUTE_h: 0x0 [ 0.324020] Switching to clocksource tsc [ 0.330612] AppArmor: AppArmor Filesystem Enabled [ 0.330619] pnp: PnP ACPI init [ 0.330628] ACPI: bus type pnp registered [ 0.349362] pnp 00:07: disabling [io 0xfe00] because it overlaps 0000:00:1c.0 BAR 13 [io 0xf000-0xffff] [ 0.349667] pnp: PnP ACPI: found 11 devices [ 0.349669] ACPI: ACPI bus type pnp unregistered [ 0.349672] PnPBIOS: Disabled by ACPI PNP [ 0.349680] system 00:01: [mem 0xfed1c000-0xfed1ffff] has been reserved [ 0.349683] system 00:01: [mem 0xfed14000-0xfed17fff] has been reserved [ 0.349685] system 00:01: [mem 0xfed18000-0xfed18fff] has been reserved [ 0.349688] system 00:01: [mem 0xfed19000-0xfed19fff] has been reserved [ 0.349690] system 00:01: [mem 0xe0000000-0xefffffff] has been reserved [ 0.349693] system 00:01: [mem 0xfed20000-0xfed3ffff] has been reserved [ 0.349695] system 00:01: [mem 0xfed40000-0xfed44fff] has been reserved [ 0.349698] system 00:01: [mem 0xfed45000-0xfed8ffff] has been reserved [ 0.349704] system 00:05: [mem 0xfed00000-0xfed003ff] has been reserved [ 0.349710] system 00:07: [io 0x0680-0x069f] has been reserved [ 0.349712] system 00:07: [io 0x0800-0x080f] has been reserved [ 0.349715] system 00:07: [io 0x1000-0x107f] has been reserved [ 0.349717] system 00:07: [io 0x1180-0x11bf] has been reserved [ 0.349720] system 00:07: [io 0x1640-0x164f] has been reserved [ 0.385608] pci 0000:00:1c.0: BAR 15: assigned [mem 0xc0000000-0xc01fffff 64bit pref] [ 0.385612] pci 0000:00:1c.1: BAR 15: assigned [mem 0xc0200000-0xc03fffff pref] [ 0.385615] pci 0000:00:1c.2: BAR 15: assigned [mem 0xc0400000-0xc05fffff 64bit pref] [ 0.385618] pci 0000:00:1c.3: BAR 15: assigned [mem 0xc0600000-0xc07fffff pref] [ 0.385622] pci 0000:00:1c.4: BAR 15: assigned [mem 0xc0800000-0xc09fffff 64bit pref] [ 0.385625] pci 0000:00:1c.5: BAR 15: assigned [mem 0xc0a00000-0xc0bfffff 64bit pref] [ 0.385628] pci 0000:00:1c.2: BAR 13: assigned [io 0x7000-0x7fff] [ 0.385631] pci 0000:00:1f.3: BAR 0: assigned [mem 0xc0c00000-0xc0c000ff] [ 0.385637] pci 0000:00:1f.3: BAR 0: set to [mem 0xc0c00000-0xc0c000ff] (PCI address [0xc0c00000-0xc0c000ff] [ 0.385640] pci 0000:01:00.0: BAR 6: assigned [mem 0xcfe00000-0xcfe1ffff pref] [ 0.385643] pci 0000:00:01.0: PCI bridge to [bus 01-01] [ 0.385646] pci 0000:00:01.0: bridge window [io 0x2000-0x2fff] [ 0.385650] pci 0000:00:01.0: bridge window [mem 0xcfe00000-0xcfefffff] [ 0.385653] pci 0000:00:01.0: bridge window [mem 0xd0000000-0xdfffffff 64bit pref] [ 0.385658] pci 0000:00:1c.0: PCI bridge to [bus 02-03] [ 0.385661] pci 0000:00:1c.0: bridge window [io 0xf000-0xffff] [ 0.385668] pci 0000:00:1c.0: bridge window [mem 0xfb000000-0xfcffffff] [ 0.385672] pci 0000:00:1c.0: bridge window [mem 0xc0000000-0xc01fffff 64bit pref] [ 0.385681] pci 0000:04:00.0: BAR 6: assigned [mem 0xc0200000-0xc020ffff pref] [ 0.385683] pci 0000:00:1c.1: PCI bridge to [bus 04-04] [ 0.385686] pci 0000:00:1c.1: bridge window [io 0x3000-0x3fff] [ 0.385693] pci 0000:00:1c.1: bridge window [mem 0xf0300000-0xf03fffff] [ 0.385697] pci 0000:00:1c.1: bridge window [mem 0xc0200000-0xc03fffff pref] [ 0.385705] pci 0000:00:1c.2: PCI bridge to [bus 05-05] [ 0.385708] pci 0000:00:1c.2: bridge window [io 0x7000-0x7fff] [ 0.385715] pci 0000:00:1c.2: bridge window [mem 0xf0200000-0xf02fffff] [ 0.385720] pci 0000:00:1c.2: bridge window [mem 0xc0400000-0xc05fffff 64bit pref] [ 0.385728] pci 0000:06:00.0: BAR 6: assigned [mem 0xc0600000-0xc061ffff pref] [ 0.385730] pci 0000:00:1c.3: PCI bridge to [bus 06-06] [ 0.385733] pci 0000:00:1c.3: bridge window [io 0x4000-0x4fff] [ 0.385740] pci 0000:00:1c.3: bridge window [mem 0xf0500000-0xf05fffff] [ 0.385745] pci 0000:00:1c.3: bridge window [mem 0xc0600000-0xc07fffff pref] [ 0.385752] pci 0000:00:1c.4: PCI bridge to [bus 07-07] [ 0.385756] pci 0000:00:1c.4: bridge window [io 0x5000-0x5fff] [ 0.385762] pci 0000:00:1c.4: bridge window [mem 0xf0400000-0xf04fffff] [ 0.385767] pci 0000:00:1c.4: bridge window [mem 0xc0800000-0xc09fffff 64bit pref] [ 0.385775] pci 0000:00:1c.5: PCI bridge to [bus 08-08] [ 0.385778] pci 0000:00:1c.5: bridge window [io 0x6000-0x6fff] [ 0.385784] pci 0000:00:1c.5: bridge window [mem 0xf0600000-0xf06fffff] [ 0.385789] pci 0000:00:1c.5: bridge window [mem 0xc0a00000-0xc0bfffff 64bit pref] [ 0.385797] pci 0000:00:1e.0: PCI bridge to [bus 09-09] [ 0.385799] pci 0000:00:1e.0: bridge window [io disabled] [ 0.385805] pci 0000:00:1e.0: bridge window [mem 0xf0700000-0xf07fffff] [ 0.385809] pci 0000:00:1e.0: bridge window [mem pref disabled] [ 0.385824] alloc irq_desc for 16 on node -1 [ 0.385826] alloc kstat_irqs on node -1 [ 0.385831] pci 0000:00:01.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [ 0.385835] pci 0000:00:01.0: setting latency timer to 64 [ 0.385844] alloc irq_desc for 17 on node -1 [ 0.385845] alloc kstat_irqs on node -1 [ 0.385849] pci 0000:00:1c.0: PCI INT A -> GSI 17 (level, low) -> IRQ 17 [ 0.385854] pci 0000:00:1c.0: setting latency timer to 64 [ 0.385864] pci 0000:00:1c.1: PCI INT B -> GSI 16 (level, low) -> IRQ 16 [ 0.385869] pci 0000:00:1c.1: setting latency timer to 64 [ 0.385879] alloc irq_desc for 18 on node -1 [ 0.385880] alloc kstat_irqs on node -1 [ 0.385884] pci 0000:00:1c.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [ 0.385889] pci 0000:00:1c.2: setting latency timer to 64 [ 0.385898] alloc irq_desc for 19 on node -1 [ 0.385900] alloc kstat_irqs on node -1 [ 0.385903] pci 0000:00:1c.3: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [ 0.385908] pci 0000:00:1c.3: setting latency timer to 64 [ 0.385919] pci 0000:00:1c.4: PCI INT A -> GSI 17 (level, low) -> IRQ 17 [ 0.385924] pci 0000:00:1c.4: setting latency timer to 64 [ 0.385933] pci 0000:00:1c.5: PCI INT B -> GSI 16 (level, low) -> IRQ 16 [ 0.385938] pci 0000:00:1c.5: setting latency timer to 64 [ 0.385946] pci 0000:00:1e.0: setting latency timer to 64 [ 0.385950] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7] [ 0.385952] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff] [ 0.385955] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff] [ 0.385957] pci_bus 0000:00: resource 7 [mem 0x000d8000-0x000dbfff] [ 0.385959] pci_bus 0000:00: resource 8 [mem 0x000dc000-0x000dffff] [ 0.385962] pci_bus 0000:00: resource 9 [mem 0xc0000000-0xdfffffff] [ 0.385964] pci_bus 0000:00: resource 10 [mem 0xf0000000-0xfebfffff] [ 0.385966] pci_bus 0000:01: resource 0 [io 0x2000-0x2fff] [ 0.385968] pci_bus 0000:01: resource 1 [mem 0xcfe00000-0xcfefffff] [ 0.385971] pci_bus 0000:01: resource 2 [mem 0xd0000000-0xdfffffff 64bit pref] [ 0.385973] pci_bus 0000:02: resource 0 [io 0xf000-0xffff] [ 0.385976] pci_bus 0000:02: resource 1 [mem 0xfb000000-0xfcffffff] [ 0.385978] pci_bus 0000:02: resource 2 [mem 0xc0000000-0xc01fffff 64bit pref] [ 0.385980] pci_bus 0000:04: resource 0 [io 0x3000-0x3fff] [ 0.385983] pci_bus 0000:04: resource 1 [mem 0xf0300000-0xf03fffff] [ 0.385985] pci_bus 0000:04: resource 2 [mem 0xc0200000-0xc03fffff pref] [ 0.385987] pci_bus 0000:05: resource 0 [io 0x7000-0x7fff] [ 0.385990] pci_bus 0000:05: resource 1 [mem 0xf0200000-0xf02fffff] [ 0.385992] pci_bus 0000:05: resource 2 [mem 0xc0400000-0xc05fffff 64bit pref] [ 0.385994] pci_bus 0000:06: resource 0 [io 0x4000-0x4fff] [ 0.385997] pci_bus 0000:06: resource 1 [mem 0xf0500000-0xf05fffff] [ 0.385999] pci_bus 0000:06: resource 2 [mem 0xc0600000-0xc07fffff pref] [ 0.386001] pci_bus 0000:07: resource 0 [io 0x5000-0x5fff] [ 0.386003] pci_bus 0000:07: resource 1 [mem 0xf0400000-0xf04fffff] [ 0.386006] pci_bus 0000:07: resource 2 [mem 0xc0800000-0xc09fffff 64bit pref] [ 0.386008] pci_bus 0000:08: resource 0 [io 0x6000-0x6fff] [ 0.386010] pci_bus 0000:08: resource 1 [mem 0xf0600000-0xf06fffff] [ 0.386013] pci_bus 0000:08: resource 2 [mem 0xc0a00000-0xc0bfffff 64bit pref] [ 0.386015] pci_bus 0000:09: resource 1 [mem 0xf0700000-0xf07fffff] [ 0.386018] pci_bus 0000:09: resource 4 [io 0x0000-0x0cf7] [ 0.386020] pci_bus 0000:09: resource 5 [io 0x0d00-0xffff] [ 0.386022] pci_bus 0000:09: resource 6 [mem 0x000a0000-0x000bffff] [ 0.386024] pci_bus 0000:09: resource 7 [mem 0x000d8000-0x000dbfff] [ 0.386027] pci_bus 0000:09: resource 8 [mem 0x000dc000-0x000dffff] [ 0.386029] pci_bus 0000:09: resource 9 [mem 0xc0000000-0xdfffffff] [ 0.386031] pci_bus 0000:09: resource 10 [mem 0xf0000000-0xfebfffff] [ 0.386058] NET: Registered protocol family 2 [ 0.386106] IP route cache hash table entries: 32768 (order: 5, 131072 bytes) [ 0.386302] TCP established hash table entries: 131072 (order: 8, 1048576 bytes) [ 0.386614] TCP bind hash table entries: 65536 (order: 7, 524288 bytes) [ 0.386773] TCP: Hash tables configured (established 131072 bind 65536) [ 0.386775] TCP reno registered [ 0.386777] UDP hash table entries: 512 (order: 2, 16384 bytes) [ 0.386784] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes) [ 0.386841] NET: Registered protocol family 1 [ 0.387004] pci 0000:01:00.0: Boot video device [ 0.387031] PCI: CLS 64 bytes, default 64 [ 0.387067] Trying to unpack rootfs image as initramfs... [ 0.587671] Freeing initrd memory: 8728k freed [ 0.592011] Simple Boot Flag at 0x36 set to 0x1 [ 0.592200] cpufreq-nforce2: No nForce2 chipset. [ 0.592228] Scanning for low memory corruption every 60 seconds [ 0.592384] audit: initializing netlink socket (disabled) [ 0.592398] type=2000 audit(1283359089.588:1): initialized [ 0.601120] highmem bounce pool size: 64 pages [ 0.601126] HugeTLB registered 4 MB page size, pre-allocated 0 pages [ 0.602428] VFS: Disk quotas dquot_6.5.2 [ 0.602482] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) [ 0.602996] fuse init (API version 7.15) [ 0.603076] msgmni has been set to 1677 [ 0.605480] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 253) [ 0.605483] io scheduler noop registered [ 0.605485] io scheduler deadline registered [ 0.605496] io scheduler cfq registered (default) [ 0.605629] pcieport 0000:00:01.0: setting latency timer to 64 [ 0.605655] alloc irq_desc for 40 on node -1 [ 0.605658] alloc kstat_irqs on node -1 [ 0.605666] pcieport 0000:00:01.0: irq 40 for MSI/MSI-X [ 0.605736] pcieport 0000:00:1c.0: setting latency timer to 64 [ 0.605781] alloc irq_desc for 41 on node -1 [ 0.605783] alloc kstat_irqs on node -1 [ 0.605791] pcieport 0000:00:1c.0: irq 41 for MSI/MSI-X [ 0.605891] pcieport 0000:00:1c.1: setting latency timer to 64 [ 0.605936] alloc irq_desc for 42 on node -1 [ 0.605938] alloc kstat_irqs on node -1 [ 0.605946] pcieport 0000:00:1c.1: irq 42 for MSI/MSI-X [ 0.606046] pcieport 0000:00:1c.2: setting latency timer to 64 [ 0.606091] alloc irq_desc for 43 on node -1 [ 0.606092] alloc kstat_irqs on node -1 [ 0.606101] pcieport 0000:00:1c.2: irq 43 for MSI/MSI-X [ 0.606203] pcieport 0000:00:1c.3: setting latency timer to 64 [ 0.606249] alloc irq_desc for 44 on node -1 [ 0.606250] alloc kstat_irqs on node -1 [ 0.606259] pcieport 0000:00:1c.3: irq 44 for MSI/MSI-X [ 0.606361] pcieport 0000:00:1c.4: setting latency timer to 64 [ 0.606406] alloc irq_desc for 45 on node -1 [ 0.606407] alloc kstat_irqs on node -1 [ 0.606416] pcieport 0000:00:1c.4: irq 45 for MSI/MSI-X [ 0.606513] pcieport 0000:00:1c.5: setting latency timer to 64 [ 0.606559] alloc irq_desc for 46 on node -1 [ 0.606560] alloc kstat_irqs on node -1 [ 0.606568] pcieport 0000:00:1c.5: irq 46 for MSI/MSI-X [ 0.606684] pci_hotplug: PCI Hot Plug PCI Core version: 0.5 [ 0.606796] pciehp: PCI Express Hot Plug Controller Driver version: 0.4 [ 0.607192] ACPI: AC Adapter [AC0] (on-line) [ 0.607266] input: Lid Switch as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0D:00/input/input0 [ 0.607286] ACPI: Lid Switch [LID0] [ 0.607323] input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input1 [ 0.607328] ACPI: Power Button [PWRB] [ 0.607366] input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input2 [ 0.607370] ACPI: Sleep Button [SLPB] [ 0.607420] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 [ 0.607423] ACPI: Power Button [PWRF] [ 0.607612] ACPI: acpi_idle registered with cpuidle [ 0.610043] Monitor-Mwait will be used to enter C-1 state [ 0.610063] Monitor-Mwait will be used to enter C-3 state [ 0.610067] Marking TSC unstable due to TSC halts in idle [ 0.610087] hpet: hpet_set_mode(348): [ 0.610090] hpet: ID: 0x8086a201, PERIOD: 0x429b17f [ 0.610093] hpet: CFG: 0x3, STATUS: 0x0 [ 0.610097] hpet: COUNTER_l: 0xa30ae4, COUNTER_h: 0x0 [ 0.610100] hpet: T0: CFG_l: 0x13c, CFG_h: 0xf00000 [ 0.610104] hpet: T0: CMP_l: 0xa3ea17, CMP_h: 0x0 [ 0.610107] hpet: T0 ROUTE_l: 0x0, ROUTE_h: 0x0 [ 0.610110] hpet: T1: CFG_l: 0x0, CFG_h: 0xf00000 [ 0.610114] hpet: T1: CMP_l: 0xffffffff, CMP_h: 0x0 [ 0.610117] hpet: T1 ROUTE_l: 0x0, ROUTE_h: 0x0 [ 0.610120] hpet: T2: CFG_l: 0x0, CFG_h: 0xf00800 [ 0.610124] hpet: T2: CMP_l: 0xc8ad01, CMP_h: 0x0 [ 0.610127] hpet: T2 ROUTE_l: 0x0, ROUTE_h: 0x0 [ 0.610154] Switching to clocksource hpet [ 0.634087] thermal LNXTHERM:01: registered as thermal_zone0 [ 0.634094] ACPI: Thermal Zone [THRM] (72 C) [ 0.634144] ERST: Table is not found! [ 0.634154] isapnp: Scanning for PnP cards... [ 0.679376] ACPI: Battery Slot [BAT0] (battery present) [ 0.988159] isapnp: No Plug & Play device found [ 0.988345] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 0.989681] brd: module loaded [ 0.990170] loop: module loaded [ 0.990315] ata_piix 0000:00:1f.1: version 2.13 [ 0.990327] ata_piix 0000:00:1f.1: PCI INT A -> GSI 19 (level, low) -> IRQ 19 [ 0.990367] ata_piix 0000:00:1f.1: setting latency timer to 64 [ 0.990449] scsi0 : ata_piix [ 0.990523] scsi1 : ata_piix [ 0.991008] ata1: PATA max UDMA/100 cmd 0x1f0 ctl 0x3f6 bmdma 0x18a0 irq 14 [ 0.991011] ata2: PATA max UDMA/100 cmd 0x170 ctl 0x376 bmdma 0x18a8 irq 15 [ 0.991091] pata_acpi 0000:08:00.1: enabling device (0000 -> 0001) [ 0.991099] pata_acpi 0000:08:00.1: PCI INT B -> GSI 18 (level, low) -> IRQ 18 [ 0.991133] pata_acpi 0000:08:00.1: setting latency timer to 64 [ 0.991148] pata_acpi 0000:08:00.1: PCI INT B disabled [ 0.991435] Fixed MDIO Bus: probed [ 0.991465] PPP generic driver version 2.4.2 [ 0.991495] tun: Universal TUN/TAP device driver, 1.6 [ 0.991497] tun: (C) 1999-2004 Max Krasnyansky <maxk@qualcomm.com> [ 0.991567] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver [ 0.991584] ehci_hcd 0000:00:1a.7: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [ 0.991596] ehci_hcd 0000:00:1a.7: setting latency timer to 64 [ 0.991600] ehci_hcd 0000:00:1a.7: EHCI Host Controller [ 0.991628] ehci_hcd 0000:00:1a.7: new USB bus registered, assigned bus number 1 [ 0.991658] ehci_hcd 0000:00:1a.7: debug port 1 [ 0.995541] ehci_hcd 0000:00:1a.7: cache line size of 64 is not supported [ 0.995556] ehci_hcd 0000:00:1a.7: irq 18, io mem 0xf0804800 [ 1.008017] ehci_hcd 0000:00:1a.7: USB 2.0 started, EHCI 1.00 [ 1.008118] hub 1-0:1.0: USB hub found [ 1.008124] hub 1-0:1.0: 4 ports detected [ 1.008196] alloc irq_desc for 23 on node -1 [ 1.008198] alloc kstat_irqs on node -1 [ 1.008202] ehci_hcd 0000:00:1d.7: PCI INT A -> GSI 23 (level, low) -> IRQ 23 [ 1.008213] ehci_hcd 0000:00:1d.7: setting latency timer to 64 [ 1.008216] ehci_hcd 0000:00:1d.7: EHCI Host Controller [ 1.008244] ehci_hcd 0000:00:1d.7: new USB bus registered, assigned bus number 2 [ 1.008272] ehci_hcd 0000:00:1d.7: debug port 1 [ 1.012148] ehci_hcd 0000:00:1d.7: cache line size of 64 is not supported [ 1.012164] ehci_hcd 0000:00:1d.7: irq 23, io mem 0xf0804c00 [ 1.028017] ehci_hcd 0000:00:1d.7: USB 2.0 started, EHCI 1.00 [ 1.028123] hub 2-0:1.0: USB hub found [ 1.028128] hub 2-0:1.0: 6 ports detected [ 1.028200] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver [ 1.028214] uhci_hcd: USB Universal Host Controller Interface driver [ 1.028231] uhci_hcd 0000:00:1a.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [ 1.028237] uhci_hcd 0000:00:1a.0: setting latency timer to 64 [ 1.028240] uhci_hcd 0000:00:1a.0: UHCI Host Controller [ 1.028271] uhci_hcd 0000:00:1a.0: new USB bus registered, assigned bus number 3 [ 1.028307] uhci_hcd 0000:00:1a.0: irq 16, io base 0x00001800 [ 1.028421] hub 3-0:1.0: USB hub found [ 1.028425] hub 3-0:1.0: 2 ports detected [ 1.028489] alloc irq_desc for 21 on node -1 [ 1.028491] alloc kstat_irqs on node -1 [ 1.028496] uhci_hcd 0000:00:1a.1: PCI INT B -> GSI 21 (level, low) -> IRQ 21 [ 1.028502] uhci_hcd 0000:00:1a.1: setting latency timer to 64 [ 1.028506] uhci_hcd 0000:00:1a.1: UHCI Host Controller [ 1.028533] uhci_hcd 0000:00:1a.1: new USB bus registered, assigned bus number 4 [ 1.028569] uhci_hcd 0000:00:1a.1: irq 21, io base 0x00001820 [ 1.028677] hub 4-0:1.0: USB hub found [ 1.028680] hub 4-0:1.0: 2 ports detected [ 1.028743] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 23 (level, low) -> IRQ 23 [ 1.028749] uhci_hcd 0000:00:1d.0: setting latency timer to 64 [ 1.028753] uhci_hcd 0000:00:1d.0: UHCI Host Controller [ 1.028781] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 5 [ 1.028807] uhci_hcd 0000:00:1d.0: irq 23, io base 0x00001840 [ 1.028916] hub 5-0:1.0: USB hub found [ 1.028920] hub 5-0:1.0: 2 ports detected [ 1.028980] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 19 (level, low) -> IRQ 19 [ 1.028987] uhci_hcd 0000:00:1d.1: setting latency timer to 64 [ 1.028990] uhci_hcd 0000:00:1d.1: UHCI Host Controller [ 1.029019] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 6 [ 1.029055] uhci_hcd 0000:00:1d.1: irq 19, io base 0x00001860 [ 1.029159] hub 6-0:1.0: USB hub found [ 1.029162] hub 6-0:1.0: 2 ports detected [ 1.029225] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [ 1.029232] uhci_hcd 0000:00:1d.2: setting latency timer to 64 [ 1.029235] uhci_hcd 0000:00:1d.2: UHCI Host Controller [ 1.029266] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 7 [ 1.029291] uhci_hcd 0000:00:1d.2: irq 18, io base 0x00001880 [ 1.029397] hub 7-0:1.0: USB hub found [ 1.029401] hub 7-0:1.0: 2 ports detected [ 1.029520] PNP: PS/2 Controller [PNP0303:PS2K,PNP0f13:PS2M] at 0x60,0x64 irq 1,12 [ 1.033044] i8042.c: Detected active multiplexing controller, rev 1.1. [ 1.034481] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 1.034487] serio: i8042 AUX0 port at 0x60,0x64 irq 12 [ 1.034489] serio: i8042 AUX1 port at 0x60,0x64 irq 12 [ 1.034492] serio: i8042 AUX2 port at 0x60,0x64 irq 12 [ 1.034494] serio: i8042 AUX3 port at 0x60,0x64 irq 12 [ 1.034544] mice: PS/2 mouse device common for all mice [ 1.034703] rtc_cmos 00:08: rtc core: registered rtc_cmos as rtc0 [ 1.034733] rtc0: alarms up to one month, y3k, 242 bytes nvram, hpet irqs [ 1.034816] device-mapper: uevent: version 1.0.3 [ 1.034914] device-mapper: ioctl: 4.18.0-ioctl (2010-06-29) initialised: dm-devel@redhat.com [ 1.034968] device-mapper: multipath: version 1.1.1 loaded [ 1.034971] device-mapper: multipath round-robin: version 1.0.0 loaded [ 1.035074] EISA: Probing bus 0 at eisa.0 [ 1.035076] EISA: Cannot allocate resource for mainboard [ 1.035078] Cannot allocate resource for EISA slot 1 [ 1.035080] Cannot allocate resource for EISA slot 2 [ 1.035081] Cannot allocate resource for EISA slot 3 [ 1.035083] Cannot allocate resource for EISA slot 4 [ 1.035084] Cannot allocate resource for EISA slot 5 [ 1.035086] Cannot allocate resource for EISA slot 6 [ 1.035088] Cannot allocate resource for EISA slot 7 [ 1.035089] Cannot allocate resource for EISA slot 8 [ 1.035091] EISA: Detected 0 cards. [ 1.035202] cpuidle: using governor ladder [ 1.035296] cpuidle: using governor menu [ 1.035566] TCP cubic registered [ 1.035677] NET: Registered protocol family 10 [ 1.035997] lo: Disabled Privacy Extensions [ 1.036229] NET: Registered protocol family 17 [ 1.036243] Registering the dns_resolver key type [ 1.071719] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input4 [ 1.076117] Using IPI No-Shortcut mode [ 1.076184] PM: Resume from disk failed. [ 1.076192] registered taskstats version 1 [ 1.076679] Magic number: 10:370:640 [ 1.076769] rtc_cmos 00:08: setting system clock to 2010-09-01 16:38:10 UTC (1283359090) [ 1.076772] BIOS EDD facility v0.16 2004-Jun-25, 0 devices found [ 1.076774] EDD information not available. [ 1.155734] ata1.00: ATAPI: Optiarc BD ROM BC-5500A, 1.41, max UDMA/33 [ 1.168312] ata1.00: configured for UDMA/33 [ 1.169650] scsi 0:0:0:0: CD-ROM Optiarc BD ROM BC-5500A 1.41 PQ: 0 ANSI: 5 [ 1.172862] sr0: scsi3-mmc drive: 24x/24x writer dvd-ram cd/rw xa/form2 cdda tray [ 1.172864] cdrom: Uniform CD-ROM driver Revision: 3.20 [ 1.172934] sr 0:0:0:0: Attached scsi CD-ROM sr0 [ 1.172977] sr 0:0:0:0: Attached scsi generic sg0 type 5 [ 1.173088] Freeing unused kernel memory: 732k freed [ 1.173495] Write protecting the kernel text: 4984k [ 1.173548] Write protecting the kernel read-only data: 2044k [ 1.186605] udev: starting version 151 [ 1.186637] udevd (74): /proc/74/oom_adj is deprecated, please use /proc/74/oom_score_adj instead. [ 1.238069] pata_jmicron 0000:08:00.1: PCI INT B -> GSI 18 (level, low) -> IRQ 18 [ 1.238111] pata_jmicron 0000:08:00.1: setting latency timer to 64 [ 1.259219] r8169 Gigabit Ethernet driver 2.3LK-NAPI loaded [ 1.259246] r8169 0000:06:00.0: PCI INT A -> GSI 19 (level, low) -> IRQ 19 [ 1.259301] r8169 0000:06:00.0: setting latency timer to 64 [ 1.259379] alloc irq_desc for 47 on node -1 [ 1.259381] alloc kstat_irqs on node -1 [ 1.259398] r8169 0000:06:00.0: irq 47 for MSI/MSI-X [ 1.259992] r8169 0000:06:00.0: eth0: RTL8168b/8111b at 0xf80bc000, 00:03:0d:8c:20:33, XID 18000000 IRQ 47 [ 1.273477] scsi2 : pata_jmicron [ 1.273726] sata_sil24 0000:07:00.0: version 1.1 [ 1.273748] sata_sil24 0000:07:00.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [ 1.273802] sata_sil24 0000:07:00.0: setting latency timer to 64 [ 1.276574] ahci 0000:00:1f.2: version 3.0 [ 1.276589] ahci 0000:00:1f.2: PCI INT B -> GSI 19 (level, low) -> IRQ 19 [ 1.276628] alloc irq_desc for 48 on node -1 [ 1.276630] alloc kstat_irqs on node -1 [ 1.276642] ahci 0000:00:1f.2: irq 48 for MSI/MSI-X [ 1.276714] ahci 0000:00:1f.2: AHCI 0001.0100 32 slots 3 ports 3 Gbps 0x7 impl SATA mode [ 1.276717] ahci 0000:00:1f.2: flags: 64bit ncq sntf pm led clo pio slum part ccc [ 1.276722] ahci 0000:00:1f.2: setting latency timer to 64 [ 1.292790] scsi3 : pata_jmicron [ 1.292849] ata3: PATA max UDMA/100 cmd 0x6020 ctl 0x6014 bmdma 0x6000 irq 18 [ 1.292852] ata4: PATA max UDMA/100 cmd 0x6018 ctl 0x6010 bmdma 0x6008 irq 18 [ 1.294043] scsi4 : sata_sil24 [ 1.294089] ata5: SATA max UDMA/100 host m128@0xf0402000 port 0xf0400000 irq 16 [ 1.295569] scsi5 : ahci [ 1.312405] scsi6 : ahci [ 1.323488] scsi7 : ahci [ 1.323631] ata6: SATA max UDMA/133 abar m2048@0xf0804000 port 0xf0804100 irq 48 [ 1.323635] ata7: SATA max UDMA/133 abar m2048@0xf0804000 port 0xf0804180 irq 48 [ 1.323639] ata8: SATA max UDMA/133 abar m2048@0xf0804000 port 0xf0804200 irq 48 [ 1.323677] ahci 0000:08:00.0: PCI INT A -> GSI 17 (level, low) -> IRQ 17 [ 1.336094] ahci 0000:08:00.0: AHCI 0001.0000 32 slots 2 ports 3 Gbps 0x3 impl SATA mode [ 1.336098] ahci 0000:08:00.0: flags: 64bit ncq pm led clo pmp pio slum part [ 1.336105] ahci 0000:08:00.0: setting latency timer to 64 [ 1.336322] scsi8 : ahci [ 1.336403] scsi9 : ahci [ 1.336447] ata9: SATA max UDMA/133 abar m8192@0xf0600000 port 0xf0600100 irq 17 [ 1.336452] ata10: SATA max UDMA/133 abar m8192@0xf0600000 port 0xf0600180 irq 17 [ 1.396055] usb 2-5: new high speed USB device using ehci_hcd and address 3 [ 1.640085] ata6: SATA link down (SStatus 0 SControl 300) [ 1.644047] ata7: SATA link down (SStatus 0 SControl 300) [ 1.644074] ata8: SATA link down (SStatus 0 SControl 300) [ 1.772049] usb 5-1: new low speed USB device using uhci_hcd and address 2 [ 1.820074] ata9: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [ 1.828068] ata10: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [ 1.854339] ata9.00: ATA-8: WDC WD3200BEVT-22ZCT0, 11.01A11, max UDMA/133 [ 1.854342] ata9.00: 625142448 sectors, multi 0: LBA48 NCQ (depth 31/32), AA [ 1.855428] ata9.00: configured for UDMA/133 [ 1.869165] ata10.00: ATA-8: WDC WD3200BEVT-22ZCT0, 11.01A11, max UDMA/133 [ 1.869168] ata10.00: 625142448 sectors, multi 0: LBA48 NCQ (depth 31/32), AA [ 1.870202] ata10.00: configured for UDMA/133 [ 1.967431] usbcore: registered new interface driver hiddev [ 1.982258] input: USB-compliant keyboard as /devices/pci0000:00/0000:00:1d.0/usb5/5-1/5-1:1.0/input/input5 [ 1.982327] generic-usb 0003:062A:0201.0001: input,hidraw0: USB HID v1.10 Keyboard [USB-compliant keyboard] on usb-0000:00:1d.0-1/input0 [ 2.010666] input: USB-compliant keyboard as /devices/pci0000:00/0000:00:1d.0/usb5/5-1/5-1:1.1/input/input6 [ 2.010781] generic-usb 0003:062A:0201.0002: input,hiddev0,hidraw1: USB HID v1.10 Mouse [USB-compliant keyboard] on usb-0000:00:1d.0-1/input1 [ 2.010794] usbcore: registered new interface driver usbhid [ 2.010795] usbhid: USB HID core driver [ 3.372098] ata5: SATA link down (SStatus 0 SControl 0) [ 3.372308] scsi 8:0:0:0: Direct-Access ATA WDC WD3200BEVT-2 11.0 PQ: 0 ANSI: 5 [ 3.372423] sd 8:0:0:0: Attached scsi generic sg1 type 0 [ 3.372560] scsi 9:0:0:0: Direct-Access ATA WDC WD3200BEVT-2 11.0 PQ: 0 ANSI: 5 [ 3.372679] sd 9:0:0:0: Attached scsi generic sg2 type 0 [ 3.372739] sd 8:0:0:0: [sda] 625142448 512-byte logical blocks: (320 GB/298 GiB) [ 3.372748] sd 9:0:0:0: [sdb] 625142448 512-byte logical blocks: (320 GB/298 GiB) [ 3.372798] sd 8:0:0:0: [sda] Write Protect is off [ 3.372800] sd 8:0:0:0: [sda] Mode Sense: 00 3a 00 00 [ 3.372804] sd 9:0:0:0: [sdb] Write Protect is off [ 3.372807] sd 9:0:0:0: [sdb] Mode Sense: 00 3a 00 00 [ 3.372823] sd 8:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 3.372829] sd 9:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 3.411102] sda: sda1 sda2 sda4 [ 3.411364] sd 8:0:0:0: [sda] Attached SCSI disk [ 3.434554] sdb: sdb1 sdb2 sdb3 sdb4 [ 3.434835] sd 9:0:0:0: [sdb] Attached SCSI disk [ 3.438378] ohci1394 0000:09:04.0: enabling device (0195 -> 0197) [ 3.438385] alloc irq_desc for 20 on node -1 [ 3.438387] alloc kstat_irqs on node -1 [ 3.438394] ohci1394 0000:09:04.0: PCI INT A -> GSI 20 (level, low) -> IRQ 20 [ 3.493092] ohci1394: fw-host0: OHCI-1394 1.1 (PCI): IRQ=[20] MMIO=[f0701000-f07017ff] Max Packet=[2048] IR/IT contexts=[8/8] [ 3.926518] EXT3-fs: barriers not enabled [ 3.931983] kjournald starting. Commit interval 5 seconds [ 3.932066] EXT3-fs (sdb1): mounted filesystem with ordered data mode [ 4.764515] ieee1394: Host added: ID:BUS[0-00:1023] GUID[00030d0055014b3c] [ 16.286419] udev: starting version 151 [ 16.450374] apparmor_parser[596]: segfault at 0 ip b775e24b sp bfa912bc error 4 in libc-2.11.1.so[b7646000+153000] [ 16.451312] apparmor_parser[597]: segfault at 0 ip b76c324b sp bfbde61c error 4 in libc-2.11.1.so[b75ab000+153000] [ 16.470988] Adding 3903788k swap on /dev/sdb3. Priority:-1 extents:1 across:3903788k [ 16.575521] Linux agpgart interface v0.103 [ 16.590161] lp: driver loaded but no devices found [ 16.714476] [drm] Initialized drm 1.1.0 20060810 [ 16.738957] acpi device:03: registered as cooling_device2 [ 16.739002] ACPI: Cant attach device [ 16.739059] input: Video Bus as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A08:00/device:01/LNXVIDEO:00/input/input7 [ 16.739105] ACPI: Video Device [VGA] (multi-head: yes rom: no post: no) [ 16.770613] cfg80211: Calling CRDA to update world regulatory domain [ 16.812934] cfg80211: World regulatory domain updated: [ 16.812936] (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [ 16.812939] (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [ 16.812941] (2457000 KHz - 2482000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [ 16.812943] (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [ 16.812945] (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [ 16.812947] (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [ 17.093835] alloc irq_desc for 22 on node -1 [ 17.093838] alloc kstat_irqs on node -1 [ 17.093846] HDA Intel 0000:00:1b.0: PCI INT A -> GSI 22 (level, low) -> IRQ 22 [ 17.093898] alloc irq_desc for 49 on node -1 [ 17.093899] alloc kstat_irqs on node -1 [ 17.093911] HDA Intel 0000:00:1b.0: irq 49 for MSI/MSI-X [ 17.093941] HDA Intel 0000:00:1b.0: setting latency timer to 64 [ 17.104710] [drm] radeon defaulting to kernel modesetting. [ 17.104712] [drm] radeon kernel modesetting enabled. [ 17.104759] radeon 0000:01:00.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [ 17.104764] radeon 0000:01:00.0: setting latency timer to 64 [ 17.105611] [drm] initializing kernel modesetting (RV630 0x1002:0x9583). [ 17.105712] [drm] register mmio base: 0xCFEF0000 [ 17.105714] [drm] register mmio size: 65536 [ 17.105847] ATOM BIOS: ECS_P75IM0_M76XT [ 17.105857] [drm] Clocks initialized ! [ 17.105869] radeon 0000:01:00.0: VRAM: 256M 0x00000000 - 0x0FFFFFFF (256M used) [ 17.105871] radeon 0000:01:00.0: GTT: 512M 0x10000000 - 0x2FFFFFFF [ 17.107631] [drm] Detected VRAM RAM=256M, BAR=256M [ 17.107634] [drm] RAM width 128bits DDR [ 17.107729] [TTM] Zone kernel: Available graphics memory: 429808 kiB. [ 17.107731] [TTM] Zone highmem: Available graphics memory: 1547412 kiB. [ 17.107733] [TTM] Initializing pool allocator. [ 17.107751] [drm] radeon: 256M of VRAM memory ready [ 17.107753] [drm] radeon: 512M of GTT memory ready. [ 17.107813] alloc irq_desc for 50 on node -1 [ 17.107815] alloc kstat_irqs on node -1 [ 17.107828] radeon 0000:01:00.0: irq 50 for MSI/MSI-X [ 17.107835] [drm] radeon: using MSI. [ 17.107868] [drm] radeon: irq initialized. [ 17.107871] [drm] GART: num cpu pages 131072, num gpu pages 131072 [ 17.108405] [drm] Loading RV630 Microcode [ 17.341955] hda_codec: ALC883: SKU not ready 0x598301f0 [ 17.477051] [drm] ring test succeeded in 1 usecs [ 17.477197] [drm] radeon: ib pool ready. [ 17.477264] [drm] ib test succeeded in 0 usecs [ 17.477266] [drm] Enabling audio support [ 17.478556] [drm] Default TV standard: NTSC [ 17.478559] [drm] Default TV standard: NTSC [ 17.478753] [drm] Default TV standard: NTSC [ 17.478827] [drm] Radeon Display Connectors [ 17.478829] [drm] Connector 0: [ 17.478830] [drm] LVDS [ 17.478832] [drm] DDC: 0xac0 0xac0 0xac4 0xac4 0xac8 0xac8 0xacc 0xacc [ 17.478833] [drm] Encoders: [ 17.478835] [drm] LCD1: INTERNAL_LVTM1 [ 17.478836] [drm] Connector 1: [ 17.478838] [drm] DIN [ 17.478839] [drm] Encoders: [ 17.478840] [drm] TV1: INTERNAL_KLDSCP_DAC2 [ 17.478841] [drm] Connector 2: [ 17.478842] [drm] HDMI-A [ 17.478844] [drm] HPD1 [ 17.478846] [drm] DDC: 0x7e50 0x7e50 0x7e54 0x7e54 0x7e58 0x7e58 0x7e5c 0x7e5c [ 17.478847] [drm] Encoders: [ 17.478848] [drm] DFP1: INTERNAL_KLDSCP_TMDS1 [ 17.478850] [drm] Connector 3: [ 17.478851] [drm] VGA [ 17.478853] [drm] DDC: 0x7e40 0x7e40 0x7e44 0x7e44 0x7e48 0x7e48 0x7e4c 0x7e4c [ 17.478854] [drm] Encoders: [ 17.478856] [drm] CRT1: INTERNAL_KLDSCP_DAC1 [ 17.521103] iwlagn: Intel(R) Wireless WiFi Link AGN driver for Linux, in-tree: [ 17.521105] iwlagn: Copyright(c) 2003-2010 Intel Corporation [ 17.521171] iwlagn 0000:05:00.0: PCI INT A -> GSI 18 (level, low) -> IRQ 18 [ 17.521179] iwlagn 0000:05:00.0: setting latency timer to 64 [ 17.521203] iwlagn 0000:05:00.0: Detected Intel(R) Wireless WiFi Link 4965AGN, REV=0x4 [ 17.538872] [drm] Internal thermal controller without fan control [ 17.538948] [drm] radeon: power management initialized [ 17.559969] iwlagn 0000:05:00.0: device EEPROM VER=0x36, CALIB=0x5 [ 17.559984] iwlagn 0000:05:00.0: Tunable channels: 13 802.11bg, 19 802.11a channels [ 17.560071] alloc irq_desc for 51 on node -1 [ 17.560074] alloc kstat_irqs on node -1 [ 17.560093] iwlagn 0000:05:00.0: irq 51 for MSI/MSI-X [ 17.659492] Synaptics Touchpad, model: 1, fw: 6.2, id: 0xa0b1, caps: 0xa04713/0x20040a/0x0 [ 17.698267] input: SynPS/2 Synaptics TouchPad as /devices/platform/i8042/serio4/input/input8 [ 17.734157] iwlagn 0000:05:00.0: loaded firmware version 228.61.2.24 [ 17.852761] phy0: Selected rate control algorithm 'iwl-agn-rs' [ 18.048272] EXT3-fs (sdb1): using internal journal [ 18.264369] EXT3-fs: barriers not enabled [ 18.264760] kjournald starting. Commit interval 5 seconds [ 18.265142] EXT3-fs (sdb2): using internal journal [ 18.265146] EXT3-fs (sdb2): mounted filesystem with ordered data mode [ 18.425028] [drm] fb mappable at 0xD0141000 [ 18.425030] [drm] vram apper at 0xD0000000 [ 18.425031] [drm] size 9216000 [ 18.425033] [drm] fb depth is 24 [ 18.425034] [drm] pitch is 7680 [ 19.649707] Console: switching to colour frame buffer device 240x75 [ 19.658424] fb0: radeondrmfb frame buffer device [ 19.658426] drm: registered panic notifier [ 19.658438] [drm] Initialized radeon 2.6.0 20080528 for 0000:01:00.0 on minor 0 [ 19.658707] HDA Intel 0000:01:00.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [ 19.658769] alloc irq_desc for 52 on node -1 [ 19.658771] alloc kstat_irqs on node -1 [ 19.658783] HDA Intel 0000:01:00.1: irq 52 for MSI/MSI-X [ 19.658814] HDA Intel 0000:01:00.1: setting latency timer to 64 [ 19.693382] apparmor_parser[955]: segfault at 0 ip b784e24b sp bfbfd69c error 4 in libc-2.11.1.so[b7736000+153000] [ 19.718601] r8169 0000:06:00.0: eth0: link up [ 19.718608] r8169 0000:06:00.0: eth0: link up [ 19.813142] apparmor_parser[1066]: segfault at 0 ip 08050ce1 sp bfbb7a40 error 4 in apparmor_parser[8048000+bd000] [ 20.111769] apm: BIOS not found. [ 20.482485] ppdev: user-space parallel port driver [ 21.597738] hda-intel: IRQ timing workaround is activated for card #1. Suggest a bigger bdl_pos_adj. [ 29.968064] eth0: no IPv6 routers present ^ permalink raw reply [flat|nested] 16+ messages in thread
* Re: System time drifts when processor idle. 2010-08-28 1:09 ` john stultz 2010-08-28 12:45 ` jean-philippe francois @ 2010-08-30 8:03 ` jean-philippe francois 1 sibling, 0 replies; 16+ messages in thread From: jean-philippe francois @ 2010-08-30 8:03 UTC (permalink / raw) To: john stultz Cc: Venkatesh Pallipadi, Lin Ming, H. Peter Anvin, linux-acpi, LKML, jslaby [-- Attachment #1: Type: text/plain, Size: 355 bytes --] > > jean-philippe: Is the drift always in 5 minute increments? Can you leave > it idle for 3 minutes and see a similar 3 minute delay, or is it always > in units of 5 ? > It looks like it is always a 5 minute delay, or sometimes 10. Attached is an edited version with the interesting bits of a test running for 8 hours Jean-Philippe François [-- Attachment #2: longrun_edited.log --] [-- Type: text/x-log, Size: 4579 bytes --] Linux jp 2.6.36-020636rc1-generic #201008171306 SMP Tue Aug 17 14:16:28 UTC 2010 i686 GNU/Linux cat /sys/devices/system/clocksource/clocksource0/available_clocksource hpet acpi_pm cat /sys/devices/system/clocksource/clocksource0/current_clocksource hpet ________________________ system | hardware(RTC) 14:47:45 | sam. 28 août 2010 14:47:46 CEST -0.500555 secondes 14:48:06 | sam. 28 août 2010 14:48:07 CEST -0.970362 secondes ... 14:59:18 | sam. 28 août 2010 14:59:19 CEST -1.001551 secondes 14:59:39 | sam. 28 août 2010 15:09:39 CEST -0.064061 secondes 14:59:59 | sam. 28 août 2010 15:10:00 CEST -1.001577 secondes ... 15:07:41 | sam. 28 août 2010 15:17:42 CEST -0.985940 secondes 15:08:02 | sam. 28 août 2010 15:23:02 CEST -0.032802 secondes 15:08:22 | sam. 28 août 2010 15:23:23 CEST -1.005817 secondes ... 15:10:07 | sam. 28 août 2010 15:25:08 CEST -0.985960 secondes 15:10:28 | sam. 28 août 2010 15:30:28 CEST -0.052756 secondes 15:10:48 | sam. 28 août 2010 15:30:49 CEST -0.990236 secondes ... 15:18:30 | sam. 28 août 2010 15:38:31 CEST -0.985951 secondes 15:18:51 | sam. 28 août 2010 15:43:51 CEST -0.032807 secondes 15:19:11 | sam. 28 août 2010 15:44:12 CEST -0.985941 secondes ... 15:34:56 | sam. 28 août 2010 15:59:57 CEST -0.990177 secondes 15:35:17 | sam. 28 août 2010 16:05:17 CEST -0.032806 secondes 15:35:37 | sam. 28 août 2010 16:05:38 CEST -0.990294 secondes ... 15:37:43 | sam. 28 août 2010 16:07:44 CEST -0.985947 secondes 15:38:04 | sam. 28 août 2010 16:13:04 CEST -0.032832 secondes 15:38:24 | sam. 28 août 2010 16:13:25 CEST -0.985923 secondes ... 16:12:21 | sam. 28 août 2010 16:47:22 CEST -0.985922 secondes 16:12:42 | sam. 28 août 2010 16:52:42 CEST -0.032823 secondes 16:13:02 | sam. 28 août 2010 16:53:03 CEST -1.001559 secondes ... 16:34:23 | sam. 28 août 2010 17:14:24 CEST -0.985973 secondes 16:34:44 | sam. 28 août 2010 17:19:44 CEST -0.032830 secondes 16:35:04 | sam. 28 août 2010 17:20:05 CEST -0.985937 secondes ... 17:01:40 | sam. 28 août 2010 17:46:41 CEST -0.985929 secondes 17:02:01 | sam. 28 août 2010 17:52:01 CEST -0.032804 secondes 17:02:21 | sam. 28 août 2010 17:52:22 CEST -1.005806 secondes ... 17:30:42 | sam. 28 août 2010 18:20:43 CEST -0.985931 secondes 17:31:03 | sam. 28 août 2010 18:26:03 CEST -0.032813 secondes 17:31:23 | sam. 28 août 2010 18:26:24 CEST -0.985933 secondes ... 17:39:47 | sam. 28 août 2010 18:34:48 CEST -0.990211 secondes 17:40:08 | sam. 28 août 2010 18:40:08 CEST -0.032826 secondes 17:40:28 | sam. 28 août 2010 18:40:29 CEST -0.990231 secondes 17:40:49 | sam. 28 août 2010 18:40:50 CEST -0.984926 secondes 17:41:10 | sam. 28 août 2010 18:41:11 CEST -0.985949 secondes 17:41:31 | sam. 28 août 2010 18:41:32 CEST -0.985977 secondes 17:41:52 | sam. 28 août 2010 18:46:52 CEST -0.032827 secondes 17:42:12 | sam. 28 août 2010 18:47:13 CEST -1.001567 secondes 17:42:33 | sam. 28 août 2010 18:47:34 CEST -0.985927 secondes ... 18:05:18 | sam. 28 août 2010 19:10:19 CEST -0.985952 secondes 18:05:39 | sam. 28 août 2010 19:15:39 CEST -0.032854 secondes 18:05:59 | sam. 28 août 2010 19:16:00 CEST -0.985934 secondes ... 18:19:38 | sam. 28 août 2010 19:29:39 CEST -0.990163 secondes 18:19:59 | sam. 28 août 2010 19:34:59 CEST -0.031814 secondes 18:20:19 | sam. 28 août 2010 19:35:20 CEST -0.985953 secondes ... 18:37:28 | sam. 28 août 2010 19:52:29 CEST -0.990183 secondes 18:37:49 | sam. 28 août 2010 19:57:49 CEST -0.032844 secondes 18:38:10 | sam. 28 août 2010 19:58:10 CEST -0.990349 secondes ... 18:48:19 | sam. 28 août 2010 20:08:19 CEST -0.985910 secondes 18:48:40 | sam. 28 août 2010 20:13:39 CEST -0.032822 secondes 18:49:00 | sam. 28 août 2010 20:14:00 CEST -1.001557 secondes ... 19:06:09 | sam. 28 août 2010 20:31:09 CEST -0.990204 secondes 19:06:30 | sam. 28 août 2010 20:36:29 CEST -0.032840 secondes 19:06:50 | sam. 28 août 2010 20:36:50 CEST -0.990175 secondes ... 19:31:20 | sam. 28 août 2010 21:01:20 CEST -0.990135 secondes 19:31:41 | sam. 28 août 2010 21:06:40 CEST -0.032806 secondes 19:32:01 | sam. 28 août 2010 21:07:01 CEST -0.985929 secondes ... 20:07:01 | sam. 28 août 2010 21:42:01 CEST -0.985931 secondes 20:07:22 | sam. 28 août 2010 21:47:21 CEST -0.032800 secondes 20:07:42 | sam. 28 août 2010 21:47:42 CEST -1.005799 secondes ... 20:12:56 | sam. 28 août 2010 21:57:56 CEST -0.985941 secondes 20:13:17 | sam. 28 août 2010 22:03:16 CEST -0.032838 secondes 20:13:37 | sam. 28 août 2010 22:08:36 CEST -0.032806 secondes ^ permalink raw reply [flat|nested] 16+ messages in thread
* Re: System time drifts when processor idle. 2010-08-27 18:11 ` john stultz 2010-08-28 0:10 ` Venkatesh Pallipadi @ 2010-09-03 12:23 ` jean-philippe francois 2010-09-09 17:42 ` john stultz 1 sibling, 1 reply; 16+ messages in thread From: jean-philippe francois @ 2010-09-03 12:23 UTC (permalink / raw) To: john stultz; +Cc: Lin Ming, venki, H. Peter Anvin, linux-acpi, LKML, jslaby 2010/8/27 john stultz <johnstul@us.ibm.com>: > On Fri, 2010-08-27 at 16:12 +0200, jean-philippe francois wrote: >> My Timekeeping bug is still present, here is an updated script and log. >> I am willing to make test, but I don't know what kind of debugging >> info is needed. >> >> cat /sys/devices/system/clocksource/clocksource0/available_clocksource >> hpet acpi_pm >> cat /sys/devices/system/clocksource/clocksource0/current_clocksource >> hpet > > Huh. hpet was not what I would have expected. > > > So first, two experiments: > > 1) Does booting with "clock=acpi_pm" cause the issue to disappear? > Hi, The same bug happens with clock=acpi_pm. My apologies for a previous mail where I said it was not hapenning with acpi_pm. With both clock, the timekeeping gap augments by amount of 5 minutes. Jean-Philippe François ^ permalink raw reply [flat|nested] 16+ messages in thread
* Re: System time drifts when processor idle. 2010-09-03 12:23 ` jean-philippe francois @ 2010-09-09 17:42 ` john stultz 2010-09-13 13:04 ` jean-philippe francois 0 siblings, 1 reply; 16+ messages in thread From: john stultz @ 2010-09-09 17:42 UTC (permalink / raw) To: jean-philippe francois Cc: Lin Ming, venki, H. Peter Anvin, linux-acpi, LKML, jslaby On Fri, 2010-09-03 at 14:23 +0200, jean-philippe francois wrote: > 2010/8/27 john stultz <johnstul@us.ibm.com>: > > On Fri, 2010-08-27 at 16:12 +0200, jean-philippe francois wrote: > >> My Timekeeping bug is still present, here is an updated script and log. > >> I am willing to make test, but I don't know what kind of debugging > >> info is needed. > >> > >> cat /sys/devices/system/clocksource/clocksource0/available_clocksource > >> hpet acpi_pm > >> cat /sys/devices/system/clocksource/clocksource0/current_clocksource > >> hpet > > > > Huh. hpet was not what I would have expected. > > > > > > So first, two experiments: > > > > 1) Does booting with "clock=acpi_pm" cause the issue to disappear? > > > > Hi, > > The same bug happens with clock=acpi_pm. > My apologies for a previous mail where I said it was not hapenning with acpi_pm. > > With both clock, the timekeeping gap augments by amount of 5 minutes. Huh. So this still seems strange, but assuming we're still using the hpet for irqs, its possible the event somehow gets pushed back 5 minutes and we miss an timekeeping interval accumulation (with acpi_pm, the counter wraps ever 5 seconds or so, so we could miss many accumulation intervals and still be 5 minutes off if the tick timer was late). Again, seeing if the issue goes away with nohz=off would be helpful. thanks -john ^ permalink raw reply [flat|nested] 16+ messages in thread
* Re: System time drifts when processor idle. 2010-09-09 17:42 ` john stultz @ 2010-09-13 13:04 ` jean-philippe francois 2010-12-06 12:55 ` jean-philippe francois 0 siblings, 1 reply; 16+ messages in thread From: jean-philippe francois @ 2010-09-13 13:04 UTC (permalink / raw) To: john stultz; +Cc: Lin Ming, venki, H. Peter Anvin, linux-acpi, LKML, jslaby 2010/9/9 john stultz <johnstul@us.ibm.com>: > On Fri, 2010-09-03 at 14:23 +0200, jean-philippe francois wrote: >> 2010/8/27 john stultz <johnstul@us.ibm.com>: >> > On Fri, 2010-08-27 at 16:12 +0200, jean-philippe francois wrote: >> >> My Timekeeping bug is still present, here is an updated script and log. >> >> I am willing to make test, but I don't know what kind of debugging >> >> info is needed. >> >> >> >> cat /sys/devices/system/clocksource/clocksource0/available_clocksource >> >> hpet acpi_pm >> >> cat /sys/devices/system/clocksource/clocksource0/current_clocksource >> >> hpet >> > >> > Huh. hpet was not what I would have expected. >> > >> > >> > So first, two experiments: >> > >> > 1) Does booting with "clock=acpi_pm" cause the issue to disappear? >> > >> >> Hi, >> >> The same bug happens with clock=acpi_pm. >> My apologies for a previous mail where I said it was not hapenning with acpi_pm. >> >> With both clock, the timekeeping gap augments by amount of 5 minutes. > > Huh. So this still seems strange, but assuming we're still using the > hpet for irqs, its possible the event somehow gets pushed back 5 minutes > and we miss an timekeeping interval accumulation (with acpi_pm, the > counter wraps ever 5 seconds or so, so we could miss many accumulation > intervals and still be 5 minutes off if the tick timer was late). > > Again, seeing if the issue goes away with nohz=off would be helpful. > It goes away witj nohz=off Thank you for your interest. Jean-Philippe François ^ permalink raw reply [flat|nested] 16+ messages in thread
* Re: System time drifts when processor idle. 2010-09-13 13:04 ` jean-philippe francois @ 2010-12-06 12:55 ` jean-philippe francois 0 siblings, 0 replies; 16+ messages in thread From: jean-philippe francois @ 2010-12-06 12:55 UTC (permalink / raw) To: john stultz; +Cc: Lin Ming, venki, H. Peter Anvin, linux-acpi, LKML, jslaby 2010/9/13 jean-philippe francois <jp.francois@cynove.com>: > 2010/9/9 john stultz <johnstul@us.ibm.com>: >> On Fri, 2010-09-03 at 14:23 +0200, jean-philippe francois wrote: >>> 2010/8/27 john stultz <johnstul@us.ibm.com>: >>> > On Fri, 2010-08-27 at 16:12 +0200, jean-philippe francois wrote: >>> >> My Timekeeping bug is still present, here is an updated script and log. >>> >> I am willing to make test, but I don't know what kind of debugging >>> >> info is needed. >>> >> >>> >> cat /sys/devices/system/clocksource/clocksource0/available_clocksource >>> >> hpet acpi_pm >>> >> cat /sys/devices/system/clocksource/clocksource0/current_clocksource >>> >> hpet >>> > >>> > Huh. hpet was not what I would have expected. >>> > >>> > >>> > So first, two experiments: >>> > >>> > 1) Does booting with "clock=acpi_pm" cause the issue to disappear? >>> > >>> >>> Hi, >>> >>> The same bug happens with clock=acpi_pm. >>> My apologies for a previous mail where I said it was not hapenning with acpi_pm. >>> >>> With both clock, the timekeeping gap augments by amount of 5 minutes. >> >> Huh. So this still seems strange, but assuming we're still using the >> hpet for irqs, its possible the event somehow gets pushed back 5 minutes >> and we miss an timekeeping interval accumulation (with acpi_pm, the >> counter wraps ever 5 seconds or so, so we could miss many accumulation >> intervals and still be 5 minutes off if the tick timer was late). >> >> Again, seeing if the issue goes away with nohz=off would be helpful. >> > > It goes away witj nohz=off > A little update on this time keeping bug : - the system time drifts by amount of 5 minutes - it happens with both hpet and acpi_pm as clock source - it goes away when booting with nohz=off - it goes away when booting with processor.max_cstate=1 Jean-Philippe François ^ permalink raw reply [flat|nested] 16+ messages in thread
end of thread, other threads:[~2010-12-06 12:55 UTC | newest]
Thread overview: 16+ messages (download: mbox.gz follow: Atom feed
-- links below jump to the message on this page --
[not found] <AANLkTi=ivkOHRYwLy5FDg3RnK18+opjGd9XsxC7yZqi7@mail.gmail.com>
2010-08-21 3:58 ` System time drifts when processor idle Lin Ming
2010-08-23 8:46 ` jean-philippe francois
2010-08-23 22:17 ` john stultz
2010-08-24 7:08 ` jean-philippe francois
2010-08-27 14:12 ` jean-philippe francois
2010-08-27 18:11 ` john stultz
2010-08-28 0:10 ` Venkatesh Pallipadi
2010-08-28 1:09 ` john stultz
2010-08-28 12:45 ` jean-philippe francois
2010-08-28 15:19 ` Venkatesh Pallipadi
2010-09-02 11:45 ` jean-philippe francois
2010-08-30 8:03 ` jean-philippe francois
2010-09-03 12:23 ` jean-philippe francois
2010-09-09 17:42 ` john stultz
2010-09-13 13:04 ` jean-philippe francois
2010-12-06 12:55 ` jean-philippe francois
This is a public inbox, see mirroring instructions for how to clone and mirror all data and code used for this inbox