Skip site navigation (1)Skip section navigation (2)
Date:      Fri, 11 Jun 2010 00:35:05 +0800
From:      Jansen Gotis <jtgotis@gmail.com>
To:        freebsd-stable@FreeBSD.org
Subject:   "calcru: runtime went backwards" messages
Message-ID:  <AANLkTimpKW8-MyWKKo7cylqyb3sND8BGX-woMd2P5YE5@mail.gmail.com>

next in thread | raw e-mail | index | archive | help
Hi, for the past couple of months since moving to RELENG_8 I've been
receiving "calcru: runtime went backwards" messages on the console.

My machine is a dual Pentium III 1.26GHz with an Intel SAI2 board.
Disabling EIST is not an option in my BIOS, and I've tried disabling
the ACPI timer as well as setting kern.timecounter.hardware=i8254.
I've also tried disabling cpufreq in my kernel configuration.

For what it's worth, I'm running base ntpd. I've also tried openntpd,
but no dice.

I did a binary search of the commit with which this started, and
apparently it's svn r204546, a summary of which can be seen here:
http://freshbsd.org/2010/03/02/01/56/55

The calcru messages appear whether vesa is loaded as a module
or compiled into the kernel.

If anyone needs more information, I'll be happy to provide it.


Best regards,
Jansen

===== snippet of /var/log/messages relating to calcru messages =====
Jun 10 22:41:42 hobbes kernel: calcru: runtime went backwards from
3502 usec to 3297 usec for pid 1106 (mksh)
Jun 10 22:41:42 hobbes kernel: calcru: runtime went backwards from
36785 usec to 35858 usec for pid 1114 (csh)
Jun 10 22:41:42 hobbes kernel: calcru: runtime went backwards from
13438 usec to 12652 usec for pid 1113 (su)
Jun 10 22:41:42 hobbes kernel: calcru: runtime went backwards from
14956 usec to 14081 usec for pid 1111 (mksh)
Jun 10 22:41:42 hobbes kernel: calcru: runtime went backwards from
3323 usec to 3128 usec for pid 1111 (mksh)
Jun 10 22:41:42 hobbes kernel: calcru: runtime went backwards from 610
usec to 574 usec for pid 549 (devd)
Jun 10 22:41:42 hobbes kernel: calcru: runtime went backwards from 517
usec to 486 usec for pid 548 (dhclient)
Jun 10 22:41:42 hobbes kernel: calcru: runtime went backwards from
1912 usec to 1800 usec for pid 532 (dhclient)
Jun 10 22:41:42 hobbes kernel: calcru: runtime went backwards from
39738 usec to 37412 usec for pid 532 (dhclient)
Jun 10 22:41:42 hobbes kernel: calcru: runtime went backwards from
3369010 usec to 3334846 usec for pid 1 (init)


===== /var/run/dmesg.boot =====
Copyright (c) 1992-2010 The FreeBSD Project.
Copyright (c) 1979, 1980, 1983, 1986, 1988, 1989, 1991, 1992, 1993, 1994
	The Regents of the University of California. All rights reserved.
FreeBSD is a registered trademark of The FreeBSD Foundation.
FreeBSD 8.0-STABLE #0 r204546: Thu Jun 10 21:05:09 PHT 2010
    jansen@hobbes.jansen.homenet:/usr/obj/usr/src/sys/LOCAL i386
Timecounter "i8254" frequency 1193182 Hz quality 0
CPU: Intel(R) Pentium(R) III CPU family      1266MHz (1263.45-MHz 686-class CPU)
  Origin = "GenuineIntel"  Id = 0x6b1  Stepping = 1
  Features=0x383fbff<FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,MMX,FXSR,SSE>
real memory  = 2148007936 (2048 MB)
avail memory = 2090995712 (1994 MB)
ACPI APIC Table: <Intel  0278    >
FreeBSD/SMP: Multiprocessor System Detected: 2 CPUs
FreeBSD/SMP: 2 package(s) x 1 core(s)
 cpu0 (BSP): APIC ID:  3
 cpu1 (AP): APIC ID:  0
MADT: Forcing active-low polarity and level trigger for SCI
ioapic0 <Version 1.1> irqs 0-15 on motherboard
ioapic1 <Version 1.1> irqs 16-31 on motherboard
kbd1 at kbdmux0
netsmb_dev: loaded
smbios0: <System Management BIOS> at iomem 0xf6e90-0xf6eae on motherboard
smbios0: Version: 2.3, BCD Revision: 2.3
acpi0: <Intel 0278> on motherboard
acpi0: [ITHREAD]
acpi0: Power Button (fixed)
acpi0: Sleep Button (fixed)
Timecounter "ACPI-safe" frequency 3579545 Hz quality 850
acpi_timer0: <32-bit timer at 3.579545MHz> port 0x508-0x50b on acpi0
pcib0: <ACPI Host-PCI bridge> port 0xcf8-0xcff on acpi0
pci0: <ACPI PCI bus> on pcib0
vgapci0: <VGA-compatible display> port 0x2000-0x20ff mem
0xfa000000-0xfaffffff,0xfb000000-0xfb000fff at device 2.0 on pci0
fxp0: <Intel 82559 Pro/100 Ethernet> port 0x2400-0x243f mem
0xfb001000-0xfb001fff,0xfb100000-0xfb1fffff irq 18 at device 3.0 on
pci0
miibus0: <MII bus> on fxp0
inphy0: <i82555 10/100 media interface> PHY 1 on miibus0
inphy0:  10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto
fxp0: Ethernet address: 00:03:47:a6:0d:4a
fxp0: [ITHREAD]
isab0: <PCI-ISA bridge> at device 15.0 on pci0
isa0: <ISA bus> on isab0
atapci0: <ServerWorks CSB5 UDMA100 controller> port
0x1f0-0x1f7,0x3f6,0x170-0x177,0x376,0x2440-0x244f at device 15.1 on
pci0
ata0: <ATA channel 0> on atapci0
ata0: [ITHREAD]
ata1: <ATA channel 1> on atapci0
ata1: [ITHREAD]
ohci0: <OHCI (generic) USB controller> mem 0xfb002000-0xfb002fff irq 9
at device 15.2 on pci0
ohci0: [ITHREAD]
usbus0: <OHCI (generic) USB controller> on ohci0
pcib1: <ACPI Host-PCI bridge> on acpi0
pci1: <ACPI PCI bus> on pcib1
atapci1: <Promise PDC20575 SATA150 controller> port
0x2480-0x24ff,0x2800-0x28ff mem
0xfb420000-0xfb420fff,0xfb400000-0xfb41ffff irq 20 at device 10.0 on
pci1
atapci1: [ITHREAD]
atapci1: [ITHREAD]
ata2: <ATA channel 0> on atapci1
ata2: SIGNATURE: 00000101
ata2: [ITHREAD]
ata3: <ATA channel 1> on atapci1
ata3: [ITHREAD]
ata4: <ATA channel 2> on atapci1
ata4: [ITHREAD]
atrtc0: <AT realtime clock> port 0x70-0x71 irq 8 on acpi0
atkbdc0: <Keyboard controller (i8042)> port 0x60,0x64 irq 1 on acpi0
atkbd0: <AT Keyboard> irq 1 on atkbdc0
kbd0 at atkbd0
atkbd0: [GIANT-LOCKED]
atkbd0: [ITHREAD]
psm0: <PS/2 Mouse> irq 12 on atkbdc0
psm0: [GIANT-LOCKED]
psm0: [ITHREAD]
psm0: model IntelliMouse Explorer, device ID 4
fdc0: <floppy drive controller> port 0x3f0-0x3f5,0x3f7 irq 6 drq 2 on acpi0
fdc0: [FILTER]
uart0: <16550 or compatible> port 0x3f8-0x3ff irq 4 flags 0x10 on acpi0
uart0: [FILTER]
uart1: <16550 or compatible> port 0x2f8-0x2ff irq 3 on acpi0
uart1: [FILTER]
ppc0: <Parallel port> port 0x378-0x37f,0x778-0x77f irq 7 drq 3 on acpi0
ppc0: SMC-like chipset (ECP/EPP/PS2/NIBBLE) in COMPATIBLE mode
ppc0: FIFO with 16/16/8 bytes threshold
ppc0: [ITHREAD]
ppbus0: <Parallel port bus> on ppc0
plip0: <PLIP network interface> on ppbus0
plip0: [ITHREAD]
lpt0: <Printer> on ppbus0
lpt0: [ITHREAD]
lpt0: Interrupt-driven port
ppi0: <Parallel I/O> on ppbus0
cpu0: <ACPI CPU> on acpi0
cpu1: <ACPI CPU> on acpi0
pmtimer0 on isa0
orm0: <ISA Option ROMs> at iomem
0xc0000-0xc7fff,0xc8000-0xc97ff,0xc9800-0xce7ff pnpid ORM0000 on isa0
sc0: <System console> at flags 0x100 on isa0
sc0: VGA <16 virtual consoles, flags=0x300>
vga0: <Generic ISA VGA> at port 0x3c0-0x3df iomem 0xa0000-0xbffff on isa0
Timecounters tick every 1.000 msec
usbus0: 12Mbps Full Speed USB v1.0
ugen0.1: <(0x1166)> at usbus0
uhub0: <(0x1166) OHCI root HUB, class 9/0, rev 1.00/1.00, addr 1> on usbus0
uhub0: 2 ports with 2 removable, self powered
acd0: CDRW <ATAPI DVD C DH52C2P/MP5C> at ata1-master UDMA33
ad4: 953869MB <Seagate ST31000528AS CC38> at ata2-master UDMA100 SATA 1.5Gb/s
ad8: 190781MB <Seagate ST3200820A 3.AAC> at ata4-master UDMA100
SMP: AP CPU #1 Launched!
Trying to mount root from ufs:/dev/ad4s1a



Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?AANLkTimpKW8-MyWKKo7cylqyb3sND8BGX-woMd2P5YE5>