clock too slow - big time offset with ntpdate

Thu May 3 11:27:08 UTC 2007

On Thu, 3 May 2007, Ian Smith wrote:
>
> > > Now I got following while playing sound on the Compaq:
> > >
> > > kernel: calcru: runtime went backwards from 183711700 usec to 183167434 usec for pid 12 (swi4: clock sio)
> > >
> > > here I have a working clock, but also intermittent sound output
>
> To which I suggested, after a bit of hunting:
>
> > http://www.freebsd.org/doc/en/books/faq/book.html#CALCRU-NEGATIVE

this refers to freebsd 4?

> > and
> > http://lists.freebsd.org/pipermail/freebsd-stable/ searching for
> > 'calcru: runtime went backwards' provides many hits, as does google;
> > seems it could be a number of things, perhaps choice of timecounter.

didn't help me

It was always kern.timecounter.hardware: i8254

> Also a bit further down in the FAQ:
> '5.25. Why does the clock on my laptop keep incorrect time?'
>
> Have you had a look at those FAQ entries?  Might they be relevant?
>
> How about showing us /var/run/dmesg.boot for at least one of these two
> machines?  I'm still curious as to what Timecounter & HZ is selected:
> show us 'sysctl kern.timecounter' and 'sysctl -a | grep -i cpu' ?

# sysctl kern.timecounter
kern.timecounter.stepwarnings: 0
kern.timecounter.nbinuptime: 86077047
kern.timecounter.nnanouptime: 0
kern.timecounter.nmicrouptime: 11135
kern.timecounter.nbintime: 16738975
kern.timecounter.nnanotime: 6960807
kern.timecounter.nmicrotime: 9778174
kern.timecounter.ngetbinuptime: 1478970
kern.timecounter.ngetnanouptime: 34251
kern.timecounter.ngetmicrouptime: 6970988
kern.timecounter.ngetbintime: 0
kern.timecounter.ngetnanotime: 1
kern.timecounter.ngetmicrotime: 14171626
kern.timecounter.nsetclock: 5
kern.timecounter.hardware: i8254
kern.timecounter.choice: TSC(-1000) i8254(0) dummy(-1000000)
kern.timecounter.tick: 1

# sysctl -a | grep -i cpu
kern.threads.virtual_cpu: 1
kern.ccpu: 1948
kern.smp.maxcpus: 1
kern.smp.cpus: 1
debug.cpufreq.lowest: 0
debug.cpufreq.verbose: 0
hw.ncpu: 1
machdep.cpu_idle_hlt: 1
dev.cpu.0.%driver: cpu
dev.cpu.0.%parent: legacy0
dev.cpu.0.freq: 1400
dev.cpu.0.freq_levels: 1400/-1 1225/-1 1200/-1 1050/-1 1000/-1 875/-1
800/-1 700/-1 600/-1 525/-1 450/-1 375/-1 300/-1 225/-1 150/-1 75/-1
dev.est.0.%parent: cpu0
dev.cpufreq.0.%driver: cpufreq
dev.cpufreq.0.%parent: cpu0
dev.p4tcc.0.%desc: CPU Frequency Thermal Control
dev.p4tcc.0.%parent: cpu0

dmesg.today is attached

m.
-------------- next part --------------
Copyright (c) 1992-2007 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 6.2-STABLE #4: Fri Mar 23 07:23:44 CET 2007
    martin at thinkpad.dieringer.dyndns.org:/data/obj/usr/src/sys/TP600X
module_register: module isa/cbb already exists!
Module isa/cbb failed to register: 17
module_register: module pci/cbb already exists!
Module pci/cbb failed to register: 17
Timecounter "i8254" frequency 1193182 Hz quality 0
CPU: Intel(R) Pentium(R) M processor 1400MHz (1393.17-MHz 686-class CPU)
  Origin = "GenuineIntel"  Id = 0x695  Stepping = 5
  Features=0xa7e9f9bf<FPU,VME,DE,PSE,TSC,MSR,MCE,CX8,SEP,MTRR,PGE,MCA,CMOV,PAT,CLFLUSH,DTS,ACPI,MMX,FXSR,SSE,SSE2,TM,PBE>
  Features2=0x180<EST,TM2>
real memory  = 503119872 (479 MB)
avail memory = 482918400 (460 MB)
cpu0 on motherboard
est0: <Enhanced SpeedStep Frequency Control> on cpu0
p4tcc0: <CPU Frequency Thermal Control> on cpu0
apm0: <APM BIOS> on motherboard
apm0: found APM BIOS v1.2, connected at v1.2
pcib0: <Host to PCI bridge> pcibus 0 on motherboard
pci0: <PCI bus> on pcib0
agp0: <ATI RS200M AGP bridge> mem 0x9c000000-0x9fffffff,0x98480000-0x98480fff at device 0.0 on pci0
pcib1: <PCI-PCI bridge> at device 1.0 on pci0
pci1: <PCI bus> on pcib1
pci1: <display, VGA> at device 5.0 (no driver attached)
pcm0: <Acer Labs M5451> port 0x3000-0x30ff mem 0x98080000-0x98080fff irq 11 at device 6.0 on pci0
pcm0: <Analog Devices AD1981B AC97 Codec>
pcm0: [GIANT-LOCKED]
isab0: <PCI-ISA bridge> at device 7.0 on pci0
isa0: <ISA bus> on isab0
pci0: <simple comms, generic modem> at device 8.0 (no driver attached)
cbb0: <O2Micro OZ711M1 PCI-CardBus Bridge> mem 0x98180000-0x98180fff irq 11 at device 11.0 on pci0
cardbus0: <CardBus bus> on cbb0
pccard0: <16-bit PCCard bus> on cbb0
cbb1: <O2Micro OZ711M1 PCI-CardBus Bridge> mem 0x98200000-0x98200fff irq 11 at device 11.1 on pci0
cardbus1: <CardBus bus> on cbb1
pccard1: <16-bit PCCard bus> on cbb1
pci0: <base peripheral> at device 11.2 (no driver attached)
atapci0: <AcerLabs M5229 UDMA100 controller> port 0x1f0-0x1f7,0x3f6,0x170-0x177,0x376,0x3800-0x380f irq 11 at device 16.0 on pci0
atapci0: using PIO transfers above 137GB as workaround for 48bit DMA access bug, expect reduced performance
ata0: <ATA channel 0> on atapci0
ata1: <ATA channel 1> on atapci0
pci0: <bridge> at device 17.0 (no driver attached)
ohci0: <NEC uPD 9210 USB controller> mem 0x98300000-0x98300fff irq 10 at device 18.0 on pci0
ohci0: [GIANT-LOCKED]
usb0: OHCI version 1.0
usb0: SMM does not respond, resetting
usb0: <NEC uPD 9210 USB controller> on ohci0
usb0: USB revision 1.0
uhub0: NEC OHCI root hub, class 9/0, rev 1.00/1.00, addr 1
uhub0: 3 ports with 3 removable, self powered
ohci1: <NEC uPD 9210 USB controller> mem 0x98380000-0x98380fff irq 10 at device 18.1 on pci0
ohci1: [GIANT-LOCKED]
usb1: OHCI version 1.0
usb1: <NEC uPD 9210 USB controller> on ohci1
usb1: USB revision 1.0
uhub1: NEC OHCI root hub, class 9/0, rev 1.00/1.00, addr 1
uhub1: 2 ports with 2 removable, self powered
ehci0: <NEC uPD 720100 USB 2.0 controller> mem 0x98400000-0x984000ff irq 10 at device 18.2 on pci0
ehci0: [GIANT-LOCKED]
usb2: EHCI version 1.0
usb2: companion controllers, 3 ports each: usb0 usb1
usb2: <NEC uPD 720100 USB 2.0 controller> on ehci0
usb2: USB revision 2.0
uhub2: NEC EHCI root hub, class 9/0, rev 2.00/1.00, addr 1
uhub2: 5 ports with 5 removable, self powered
umass0: Prolific Technology Inc. Mass Storage Device, rev 2.00/1.00, addr 2
bge0: <Broadcom BCM5705 A1, ASIC rev. 0x3001> mem 0x98000000-0x9800ffff irq 10 at device 19.0 on pci0
miibus0: <MII bus> on bge0
brgphy0: <BCM5705 10/100/1000baseTX PHY> on miibus0
brgphy0:  10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, 1000baseTX, 1000baseTX-FDX, auto
bge0: Ethernet address: 00:08:02:d4:06:f1
pmtimer0 on isa0
orm0: <ISA Option ROM> at iomem 0xc0000-0xcefff on isa0
atkbdc0: <Keyboard controller (i8042)> at port 0x60,0x64 on isa0
atkbd0: <AT Keyboard> irq 1 on atkbdc0
kbd0 at atkbd0
atkbd0: [GIANT-LOCKED]
psm0: <PS/2 Mouse> irq 12 on atkbdc0
psm0: [GIANT-LOCKED]
psm0: model Generic PS/2 mouse, device ID 0
ppc0: <Parallel port> at port 0x378-0x37f irq 7 on isa0
ppc0: SMC-like chipset (ECP/EPP/PS2/NIBBLE) in COMPATIBLE mode
ppc0: FIFO with 16/16/1 bytes threshold
ppbus0: <Parallel port bus> on ppc0
plip0: <PLIP network interface> on ppbus0
lpt0: <Printer> on ppbus0
lpt0: Interrupt-driven port
ppi0: <Parallel I/O> on ppbus0
sc0: <System console> at flags 0x100 on isa0
sc0: VGA <16 virtual consoles, flags=0x300>
sio0 at port 0x3f8-0x3ff irq 4 flags 0x10 on isa0
sio0: type 16550A
sio1: configured irq 3 not in bitmap of probed irqs 0
sio1: port may not be enabled
vga0: <Generic ISA VGA> at port 0x3c0-0x3df iomem 0xa0000-0xbffff on isa0
unknown: <PNP0303> can't assign resources (port)
unknown: <PNP0f13> can't assign resources (irq)
unknown: <PNP0401> can't assign resources (port)
unknown: <PNP0501> can't assign resources (port)
sio4: <NSC6001> at port 0x3e8-0x3ef irq 3 drq 3 on isa0
sio4: type 16550A
unknown: <PNP0c02> can't assign resources (memory)
Timecounters tick every 1.000 msec
WARNING: apm_saver module requires apm enabled
cardbus0: Expecting link target, got 0xff
cardbus0: Resource not specified in CIS: id=10, size=1000
cardbus0: Resource not specified in CIS: id=14, size=100
cardbus0: Resource not specified in CIS: id=18, size=100
fwohci0: <NEC uPD72873> mem 0x88000000-0x88000fff,0x88001000-0x880010ff,0x88002000-0x880020ff irq 11 at device 0.0 on cardbus0
fwohci0: OHCI version 1.10 (ROM=1)
fwohci0: No. of Isochronous channels is 4.
fwohci0: EUI64 ff:ff:ff:ff:ff:ff:ff:ff
fwohci0: Phy 1394a available S400, 2 ports.
fwohci0: Link S400, max_rec 65536 bytes.
fwohci0: max_rec 65536 -> 2048
firewire0: <IEEE1394(FireWire) bus> on fwohci0
fwe0: <Ethernet over FireWire> on firewire0
if_fwe0: Fake Ethernet address: fe:ff:ff:ff:ff:ff
fwe0: Ethernet address: fe:ff:ff:ff:ff:ff
fwe0: if_start running deferred for Giant
sbp0: <SBP-2/SCSI over FireWire> on firewire0
fwohci0: Initiate bus reset
fwohci0: node_id=0x8000ffc0, gen=1, non CYCLEMASTER mode
firewire0: 2 nodes, maxhop <= 1, cable IRM = 0 (me)
firewire0: root node is not cycle master capable
firewire0: bus manager 0 (me)
firewire0: New S400 device ID:0001a30000063511
da0 at umass-sim0 bus 0 target 0 lun 0
da0: <SAMSUNG SP2514N VF10> Fixed Direct Access SCSI-0 device 
da0: 40.000MB/s transfers
da0: 238475MB (488397169 512 byte sectors: 255H 63S/T 30401C)
Trying to mount root from ufs:/dev/da0s1a
WARNING: / was not properly dismounted
da1 at sbp0 bus 0 target 0 lun 0
da1: <Genesys  > Fixed Direct Access SCSI-0 device 
da1: 50.000MB/s transfers
da1: 152627MB (312581808 512 byte sectors: 255H 63S/T 19457C)
WARNING: /var was not properly dismounted
WARNING: /usr was not properly dismounted
WARNING: /data was not properly dismounted
WARNING: /BIG was not properly dismounted
ipfw2 (+ipv6) initialized, divert loadable, rule-based forwarding disabled, default to deny, logging disabled
bge0: link state changed to UP
fuse4bsd: version 0.3.0, FUSE ABI 7.8
uhub3: vendor 0x03eb Standard USB Hub, class 9/0, rev 1.10/3.00, addr 2
uhub3: 4 ports with 4 removable, self powered
ugen0: M-Audio Transit USB, rev 1.10/1.00, addr 3
All threads purged from ugen0
ugen0: detached
ugen0: M-Audio Transit USB, rev 1.10/1.00, addr 3
ugen0: at uhub3 port 1 (addr 3) disconnected
All threads purged from ugen0
ugen0: detached
ugen0: Unknown Unknown, rev 1.00/1.00, addr 3
uhub3: at uhub0 port 2 (addr 2) disconnected
ugen0: at uhub3 port 1 (addr 3) disconnected
All threads purged from ugen0
ugen0: detached
uhub3: detached
uhub3: vendor 0x03eb Standard USB Hub, class 9/0, rev 1.10/3.00, addr 2
uhub3: 4 ports with 4 removable, self powered
uaudio0: M-Audio Transit USB, rev 1.10/1.00, addr 3
uaudio0: non sync-pipe endpoint but multiple endpoints
uaudio0: ignored setting with type 8193 format
uaudio0: ignored setting with type 8193 format
uaudio0: audio rev 1.00
pcm1: <USB Audio> on uaudio0
uhub3: at uhub0 port 2 (addr 2) disconnected
uaudio0: at uhub3 port 1 (addr 3) disconnected
pcm1: unregister: operation in progress
pcm1: unregister: operation in progress
uhub3: detached
pcm1: unregister: operation in progress
uhub3: vendor 0x03eb Standard USB Hub, class 9/0, rev 1.10/3.00, addr 2
uhub3: 4 ports with 4 removable, self powered
uaudio1: M-Audio Transit USB, rev 1.10/1.00, addr 3
uaudio1: non sync-pipe endpoint but multiple endpoints
uaudio1: ignored setting with type 8193 format
uaudio1: ignored setting with type 8193 format
uaudio1: audio rev 1.00
pcm2: <USB Audio> on uaudio1
uhub3: at uhub0 port 2 (addr 2) disconnected
uaudio1: at uhub3 port 1 (addr 3) disconnected
pcm2: unregister: operation in progress
pcm2: unregister: operation in progress
uhub3: detached
pcm2: unregister: operation in progress
uhub3: vendor 0x03eb Standard USB Hub, class 9/0, rev 1.10/3.00, addr 2
uhub3: 4 ports with 4 removable, self powered
uaudio2: M-Audio Transit USB, rev 1.10/1.00, addr 3
uaudio2: non sync-pipe endpoint but multiple endpoints
uaudio2: ignored setting with type 8193 format
uaudio2: ignored setting with type 8193 format
uaudio2: audio rev 1.00
pcm3: <USB Audio> on uaudio2
uaudio2: at uhub3 port 1 (addr 3) disconnected
pcm3: detached
uaudio2: detached
uhub3: at uhub0 port 2 (addr 2) disconnected
uhub3: detached
calcru: runtime went backwards from 183711700 usec to 183167434 usec for pid 12 (swi4: clock sio)
calcru: runtime went backwards from 183711700 usec to 183167434 usec for pid 12 (swi4: clock sio)
calcru: runtime went backwards from 183711700 usec to 183214330 usec for pid 12 (swi4: clock sio)
calcru: runtime went backwards from 183711700 usec to 183214357 usec for pid 12 (swi4: clock sio)