WARNING - OLD ARCHIVES

This is an archived copy of the Xen.org mailing list, which we have preserved to ensure that existing links to archives are not broken. The live archive, which contains the latest emails, can be found at http://lists.xen.org/
   
 
 
Xen 
 
Home Products Support Community News
 
   
 

xen-bugs

[Xen-bugs] [Bug 645] New: many "Timer ISR/0: Time went backwards" messag

To: xen-bugs@xxxxxxxxxxxxxxxxxxx
Subject: [Xen-bugs] [Bug 645] New: many "Timer ISR/0: Time went backwards" messages and slow system
From: bugzilla-daemon@xxxxxxxxxxxxxxxxxxx
Date: Tue, 16 May 2006 10:00:25 -0700
Delivery-date: Tue, 16 May 2006 10:01:06 -0700
Envelope-to: www-data@xxxxxxxxxxxxxxxxxx
List-help: <mailto:xen-bugs-request@lists.xensource.com?subject=help>
List-id: Xen Bugzilla <xen-bugs.lists.xensource.com>
List-post: <mailto:xen-bugs@lists.xensource.com>
List-subscribe: <http://lists.xensource.com/cgi-bin/mailman/listinfo/xen-bugs>, <mailto:xen-bugs-request@lists.xensource.com?subject=subscribe>
List-unsubscribe: <http://lists.xensource.com/cgi-bin/mailman/listinfo/xen-bugs>, <mailto:xen-bugs-request@lists.xensource.com?subject=unsubscribe>
Reply-to: bugs@xxxxxxxxxxxxxxxxxx
Sender: xen-bugs-bounces@xxxxxxxxxxxxxxxxxxx
http://bugzilla.xensource.com/bugzilla/show_bug.cgi?id=645

           Summary: many "Timer ISR/0: Time went backwards" messages and
                    slow system
           Product: Xen
           Version: 3.0.2
          Platform: x86
        OS/Version: Linux-2.6
            Status: NEW
          Severity: normal
          Priority: P2
         Component: Hypervisor
        AssignedTo: xen-bugs@xxxxxxxxxxxxxxxxxxx
        ReportedBy: mad@xxxxxxxxxxxx


After upgrading from 2.0.7 to 3.0.2 on 2 systems i got more or less of this
messages.
System 1 is a P3 SMP w 1.5Gig Ram running gentoo linux
# cat /proc/cpuinfo
processor       : 0
vendor_id       : GenuineIntel
cpu family      : 6
model           : 8
model name      : Pentium III (Coppermine)
stepping        : 10
cpu MHz         : 1002.270
cache size      : 256 KB
fdiv_bug        : no
hlt_bug         : no
f00f_bug        : no
coma_bug        : no
fpu             : yes
fpu_exception   : yes
cpuid level     : 3
wp              : yes
flags           : fpu tsc msr pae mce cx8 apic mtrr mca cmov pat pse36 mmx fxsr
sse
bogomips        : 2104.66

System 2 is a P4 Xeon SMP w 4.0Gig Ram running the same gentoo
# cat /proc/cpuinfo
processor       : 0
vendor_id       : GenuineIntel
cpu family      : 15
model           : 2
model name      : Intel(R) Xeon(TM) CPU 2.00GHz
stepping        : 9
cpu MHz         : 1994.114
cache size      : 512 KB
fdiv_bug        : no
hlt_bug         : no
f00f_bug        : no
coma_bug        : no
fpu             : yes
fpu_exception   : yes
cpuid level     : 2
wp              : yes
flags           : fpu tsc msr pae mce cx8 apic mtrr mca cmov pat pse36 clflush
dts acpi mmx fxsr sse sse2 ss ht tm pbe cid xtpr
bogomips        : 15455.08

On System 1 i got about 20-30 messages while booting, on System 2 i got 100+,
also while running the System. They are also more painful because this is the
important maschine. 
Here is a dmesg sample:
printk: 90 messages suppressed.
Timer ISR/0: Time went backwards: delta=-51757760 delta_cpu=33242240
shadow=8004605103315 off=601395929 processed=8005258245453
cpu_processed=8005173245453
 0: 8005173245453
 1: 8004539974293
 2: 8005257974293
 3: 8004132974293
printk: 114 messages suppressed.
Timer ISR/0: Time went backwards: delta=-126960768 delta_cpu=32039232
shadow=8009037515296 off=786775017 processed=8009951245453
cpu_processed=8009792245453
 0: 8009792245453
 1: 8009777974293
 2: 8009950974293
 3: 8009131974293

After reading some stuff i upgraded to 3.0.2-2, same result on System 1, no
upgrade till now on System 2.
Both are installed via gentoo ebuilds, running 2.6.16-xen, are totally
different except SMP feature. I have running it on a single CPU AMD like a
charm.
On both systems the platform timer reports as:
"(XEN) Platform timer is 1.193MHz PIT"

System 1 hw clock:
# hwclock; date; sleep 20; date; hwclock
Tue May 16 17:57:44 2006  -0.028350 seconds
Tue May 16 17:57:43 MEST 2006
Tue May 16 17:58:03 MEST 2006
Tue May 16 17:58:05 2006  -0.973405 seconds

System 2 hw clock:
# hwclock; date; sleep 20; date; hwclock
Tue May 16 16:46:11 2006  -0.881596 seconds
Tue May 16 18:47:12 MEST 2006
Tue May 16 18:47:33 MEST 2006
Tue May 16 16:46:45 2006  -0.149249 seconds

System 1 xm dmesg:
# xm dmesg
 __  __            _____  ___   ____    ____
 \ \/ /___ _ __   |___ / / _ \ |___ \  |___ \
  \  // _ \ '_ \    |_ \| | | |  __) |__ __) |
  /  \  __/ | | |  ___) | |_| | / __/|__/ __/
 /_/\_\___|_| |_| |____(_)___(_)_____| |_____|

 http://www.cl.cam.ac.uk/netos/xen
 University of Cambridge Computer Laboratory

 Xen version 3.0.2-2 (root@xxxxxxxxxxxx) (gcc version 3.4.4 (Gentoo 3.4.4-r1,
ss
p-3.4.4-1.0, pie-8.7.8)) Tue May 16 15:57:03 MEST 2006
 Latest ChangeSet: Thu Apr 13 15:18:37 2006 +0100 9617:5802713c159b

(XEN) Console output is synchronous.
(XEN) Physical RAM map:
(XEN)  0000000000000000 - 00000000000a0000 (usable)
(XEN)  00000000000f0000 - 0000000000100000 (reserved)
(XEN)  0000000000100000 - 000000005fff0000 (usable)
(XEN)  000000005fff0000 - 000000005fff3000 (ACPI NVS)
(XEN)  000000005fff3000 - 0000000060000000 (ACPI data)
(XEN)  00000000fec00000 - 0000000100000000 (reserved)
(XEN) System RAM: 1535MB (1572416kB)
(XEN) Xen heap: 10MB (10584kB)
(XEN) Using scheduler: Simple EDF Scheduler (sedf)
(XEN) PAE disabled.
(XEN) found SMP MP-table at 000f5e70
(XEN) DMI 2.2 present.
(XEN) Using APIC driver default
(XEN) ACPI: RSDP (v000 VIA694                                ) @ 0x000f7760
(XEN) ACPI: RSDT (v001 VIA694 AWRDACPI 0x42302e31 AWRD 0x00000000) @ 0x5fff3000
(XEN) ACPI: FADT (v001 VIA694 AWRDACPI 0x42302e31 AWRD 0x00000000) @ 0x5fff3040
(XEN) ACPI: MADT (v001 VIA694          0x00000000  0x00000000) @ 0x5fff5900
(XEN) ACPI: DSDT (v001 VIA694 AWRDACPI 0x00001000 MSFT 0x0100000c) @ 0x00000000
(XEN) ACPI: Local APIC address 0xfee00000
(XEN) ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled)
(XEN) Processor #0 6:8 APIC version 17
(XEN) ACPI: LAPIC (acpi_id[0x01] lapic_id[0x01] enabled)
(XEN) Processor #1 6:8 APIC version 17
(XEN) ACPI: IOAPIC (id[0x02] address[0xfec00000] gsi_base[0])
(XEN) IOAPIC[0]: apic_id 2, version 17, address 0xfec00000, GSI 0-23
(XEN) ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
(XEN) ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 dfl dfl)
(XEN) ACPI: IRQ0 used by override.
(XEN) ACPI: IRQ2 used by override.
(XEN) ACPI: IRQ9 used by override.
(XEN) Enabling APIC mode:  Flat.  Using 1 I/O APICs
(XEN) Using ACPI (MADT) for SMP configuration information
(XEN) Initializing CPU#0
(XEN) Detected 1002.286 MHz processor.
(XEN) CPU: L1 I cache: 16K, L1 D cache: 16K
(XEN) CPU: L2 cache: 256K
(XEN) Intel machine check architecture supported.
(XEN) Intel machine check reporting enabled on CPU#0.
(XEN) CPU0: Intel Pentium III (Coppermine) stepping 0a
(XEN) Booting processor 1/1 eip 90000
(XEN) Initializing CPU#1
(XEN) CPU: L1 I cache: 16K, L1 D cache: 16K
(XEN) CPU: L2 cache: 256K
(XEN) Intel machine check architecture supported.
(XEN) Intel machine check reporting enabled on CPU#1.
(XEN) CPU1: Intel Pentium III (Coppermine) stepping 0a
(XEN) Total of 2 processors activated.
(XEN) ENABLING IO-APIC IRQs
(XEN) ..TIMER: vector=0x31 apic1=0 pin1=2 apic2=-1 pin2=-1
(XEN) checking TSC synchronization across 2 CPUs: passed.
(XEN) Platform timer is 1.193MHz PIT
(XEN) Brought up 2 CPUs
(XEN) Machine check exception polling timer started.
(XEN) mtrr: your CPUs had inconsistent fixed MTRR settings
(XEN) mtrr: your CPUs had inconsistent variable MTRR settings
(XEN) mtrr: probably your BIOS does not setup all CPUs.
(XEN) mtrr: corrected configuration.
(XEN) Using IPI Shortcut mode
(XEN) *** LOADING DOMAIN 0 ***
(XEN) Domain 0 kernel supports features = { 0000001f }.
(XEN) Domain 0 kernel requires features = { 00000000 }.
(XEN) PHYSICAL MEMORY ARRANGEMENT:
(XEN)  Dom0 alloc.:   5f000000->5f800000 (129024 pages to be allocated)
(XEN) VIRTUAL MEMORY ARRANGEMENT:
(XEN)  Loaded kernel: c0100000->c0506cf8
(XEN)  Init. ramdisk: c0507000->c0507000
(XEN)  Phys-Mach map: c0507000->c0587000
(XEN)  Start info:    c0587000->c0588000
(XEN)  Page tables:   c0588000->c058b000
(XEN)  Boot stack:    c058b000->c058c000
(XEN)  TOTAL:         c0000000->c0800000
(XEN)  ENTRY ADDRESS: c0100000
(XEN) Dom0 has maximum 2 VCPUs
(XEN) Scrubbing Free RAM: ................done.
(XEN) Xen trace buffers: disabled
(XEN) *** Serial input -> DOM0 (type 'CTRL-a' three times to switch input to
Xen
).

System 1 dmesg:
Linux version 2.6.16-xen (root@defiant) (gcc version 3.4.4 (Gentoo 3.4.4-r1,
ssp-3.4.4-1.0, pie-8.7.8)) #11 SMP Tue M
ay 16 17:59:03 MEST 2006
BIOS-provided physical RAM map:
 Xen: 0000000000000000 - 0000000020000000 (usable)
0MB HIGHMEM available.
520MB LOWMEM available.
On node 0 totalpages: 133120
  DMA zone: 133120 pages, LIFO batch:31
  DMA32 zone: 0 pages, LIFO batch:0
  Normal zone: 0 pages, LIFO batch:0
  HighMem zone: 0 pages, LIFO batch:0
found SMP MP-table at 000f5e70
DMI 2.2 present.
ACPI: RSDP (v000 VIA694                                ) @ 0x000f7760
ACPI: RSDT (v001 VIA694 AWRDACPI 0x42302e31 AWRD 0x00000000) @ 0x5fff3000
ACPI: FADT (v001 VIA694 AWRDACPI 0x42302e31 AWRD 0x00000000) @ 0x5fff3040
ACPI: MADT (v001 VIA694          0x00000000  0x00000000) @ 0x5fff5900
ACPI: DSDT (v001 VIA694 AWRDACPI 0x00001000 MSFT 0x0100000c) @ 0x00000000
ACPI: Local APIC address 0xfee00000
ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled)
ACPI: LAPIC (acpi_id[0x01] lapic_id[0x01] enabled)
ACPI: IOAPIC (id[0x02] address[0xfec00000] gsi_base[0])
IOAPIC[0]: apic_id 2, version 17, address 0xfec00000, GSI 0-23
ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 dfl dfl)
ACPI: IRQ0 used by override.
ACPI: IRQ2 used by override.
ACPI: IRQ9 used by override.
Enabling APIC mode:  Flat.  Using 1 I/O APICs
Using ACPI (MADT) for SMP configuration information
IRQ lockup detection disabled
Allocating PCI resources starting at 60000000 (gap: 60000000:9ec00000)
Built 1 zonelists
Kernel command line: root=/dev/md0 max_loop=64 panic=20 5
Enabling fast FPU save and restore... done.
Enabling unmasked SIMD FPU exception support... done.
Initializing CPU#0
PID hash table entries: 4096 (order: 12, 65536 bytes)
Xen reported: 1002.270 MHz processor.
Console: colour VGA+ 80x25
Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
Software IO TLB enabled:
 Aperture:     2 megabytes
 Bus range:    0x000000001e000000 - 0x000000001e200000
 Kernel range: 0x00000000c0613000 - 0x00000000c0813000
vmalloc area: e1000000-fb7fe000, maxmem 33ffe000
Memory: 511488k/532480k available (2933k kernel code, 12464k reserved, 752k
data, 192k init, 0k highmem)
Checking if this processor honours the WP bit even in supervisor mode... Ok.
Calibrating delay using timer specific routine.. 2104.66 BogoMIPS (lpj=1052332)
Mount-cache hash table entries: 512
CPU: After generic identify, caps: 0387d3f1 00000000 00000000 00000000 00000000
00000000 00000000
CPU: After vendor identify, caps: 0387d3f1 00000000 00000000 00000000 00000000
00000000 00000000
CPU: L1 I cache: 16K, L1 D cache: 16K
CPU: L2 cache: 256K
CPU serial number disabled.
CPU: After all inits, caps: 0383d3f1 00000000 00000000 00000040 00000000
00000000 00000000
Checking 'hlt' instruction... OK.
ENABLING IO-APIC IRQs
Brought up 2 CPUs
Initializing CPU#1
migration_cost=580
Grant table initialized
NET: Registered protocol family 16
ACPI: bus type pci registered
PCI: Using configuration type 1
ACPI: Subsystem revision 20060127
Timer ISR/0: Time went backwards: delta=-46021931 delta_cpu=978069
shadow=5207074370 off=905208816 processed=61583039
59 cpu_processed=6111303959
 0: 6111303959
 1: 6158074370
ACPI: Interpreter enabled
ACPI: Using IOAPIC for interrupt routing
ACPI: PCI Root Bridge [PCI0] (0000:00)
PCI: Probing PCI hardware (bus 00)
ACPI: Assume root bridge [\_SB_.PCI0] bus is 0
PCI quirk: region 4000-40ff claimed by vt82c586 ACPI
PCI quirk: region 6000-607f claimed by vt82c686 HW-mon
PCI quirk: region 5000-500f claimed by vt82c686 SMB
Boot video device is 0000:01:00.0
ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT]
ACPI: PCI Interrupt Link [LNKA] (IRQs 1 3 4 5 6 7 *10 11 12 14 15)
ACPI: PCI Interrupt Link [LNKB] (IRQs 1 3 4 5 6 7 10 *11 12 14 15)
ACPI: PCI Interrupt Link [LNKC] (IRQs 1 3 4 5 6 7 10 11 12 14 *15)
ACPI: PCI Interrupt Link [LNKD] (IRQs 1 3 4 5 6 7 10 11 *12 14 15)
xen_mem: Initialising balloon driver.
SCSI subsystem initialized
usbcore: registered new driver usbfs
usbcore: registered new driver hub
PCI: Using ACPI for IRQ routing
PCI: If a device doesn't work, try "pci=routeirq".  If it helps, post a report
PCI: Bridge: 0000:00:01.0
  IO window: disabled.
  MEM window: d0000000-d2ffffff
  PREFETCH window: d3000000-d3ffffff
PCI: Setting latency timer of device 0000:00:01.0 to 64
Timer ISR/1: Time went backwards: delta=-14037730 delta_cpu=220191859
shadow=7157981472 off=214286754 processed=73863
03959 cpu_processed=7152074370
 0: 7385303959
 1: 7152074370

and so on ... about 20-30 messages .... System 1, System 2 has lot more.

Any help is appreciated

regards Martin


-- 
Configure bugmail: 
http://bugzilla.xensource.com/bugzilla/userprefs.cgi?tab=email
------- You are receiving this mail because: -------
You are the assignee for the bug, or are watching the assignee.

_______________________________________________
Xen-bugs mailing list
Xen-bugs@xxxxxxxxxxxxxxxxxxx
http://lists.xensource.com/xen-bugs

<Prev in Thread] Current Thread [Next in Thread>