[5.99.41] clock skew
BERTRAND Joel
I have installed NetBSD 5.99.41 on one of my SS20 (with only one RT626
processor).
NetBSD riemann 5.99.41 NetBSD 5.99.41 (GENERIC.MP) #0: Fri Dec 17
22:07:08 UTC 2010
bui...@b8.netbsd.org:/home/builds/ab/HEAD/sparc/201012172000Z-obj/home/builds/ab/HEAD/src/sys/arch/sparc/compile/GENERIC.MP
sparc
Root riemann:[/home/pkgupgrade] > uptime
10:21AM up 3 days, 15:56, 3 users, load averages: 0.00, 0.00, 0.22
System is up for more than 3 days and I see a strange clock skew. ntpd
cannot synchronize clock (I have a local ntp server on a linux/sparc
box). I have tried to write some different values in /var/db/ntp.drift
without any result.
Is it a known bug ?
Regards,
JKB
PS: ntpd output:
Root riemann:[/etc] > ntpd -d -ntart
ntpd 4.2.6-o Sun Dec 13 14:48:32 UTC 2009 (import)
addto_syslog: proto: precision = 8.036 usec
event at 0 0.0.0.0 c01d 0d kern kernel time sync enabled
status=0x1<PLL,MODE=0x0=PLL,CLK=0x0=A>
Finished Parsing!!
addto_syslog: ntp_io: estimated max descriptors: 128, initial socket
boundary: 20
addto_syslog: Listen and drop on 0 v4wildcard 0.0.0.0 UDP 123
addto_syslog: Listen and drop on 1 v6wildcard :: UDP 123
addto_syslog: Listen normally on 2 le0 192.168.0.85 UDP 123
restrict: addr c0a80055 mask ffffffff mflags 00003000 flags 00000001
addto_syslog: Listen normally on 3 le0 fe80::a00:20ff:fe78:6e83 UDP 123
addto_syslog: Listen normally on 4 lo0 127.0.0.1 UDP 123
restrict: addr 7f000001 mask ffffffff mflags 00003000 flags 00000001
addto_syslog: Listen normally on 5 lo0 ::1 UDP 123
addto_syslog: Listen normally on 6 lo0 fe80::1 UDP 123
addto_syslog: Listening on routing socket on fd #27 for interface updates
key_expire: at 0 associd 3654
peer_clear: at 0 next 1 associd 3654 refid INIT
event at 0 192.168.0.128 8011 81 mobilize assoc 3654
newpeer: 192.168.0.85->192.168.0.128 mode 3 vers 4 poll 6 10 flags 0x1
0x1 ttl 0 key 00000000
event at 0 0.0.0.0 c016 06 restart
event at 0 0.0.0.0 c012 02 freq_set kernel -100.000 PPM
transmit: at 1 192.168.0.85->192.168.0.128 mode 3 len 48
auth_agekeys: at 1 keys 1 expired 0
receive: at 1 192.168.0.85<-192.168.0.128 mode 4 len 48
event at 1 192.168.0.128 8024 84 reachable
clock_filter: n 1 off -0.019208 del 0.000928 dsp 7.937505 jit 0.000008
transmit: at 65 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 65 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 2 off -0.353226 del 0.000795 dsp 3.937747 jit 0.334018
transmit: at 131 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 131 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 3 off -0.690626 del 0.000831 dsp 1.938000 jit 0.531338
transmit: at 196 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 196 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 4 off -1.034167 del 0.000832 dsp 0.938181 jit 0.732994
transmit: at 263 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 263 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 5 off -1.366905 del 0.000764 dsp 0.438316 jit 0.923566
select: combine offset -1.366905129 jitter 0.923566321
event at 263 192.168.0.128 963a 8a sys_peer
clock_update: at 263 sample 263 associd 3654
event at 263 0.0.0.0 c61c 0c clock_step -1.366905 s
step_systime: step -1.366905 residual 0.000000
In ntp_set_tod
ntp_set_tod: clock_settime: 0: Undefined error: 0
ntp_set_tod: Final result: clock_settime: 0: Undefined error: 0
event at 263 0.0.0.0 c614 04 freq_mode
key_expire: at 263 associd 3654
peer_clear: at 263 next 263 associd 3654 refid STEP
clear_all: at 263
transmit: at 264 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 264 192.168.0.85<-192.168.0.128 mode 4 len 48
event at 264 192.168.0.128 8044 84 reachable
clock_filter: n 1 off -0.003665 del 0.000797 dsp 7.937505 jit 0.000008
event at 264 0.0.0.0 c618 08 no_sys_peer
transmit: at 332 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 332 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 2 off -0.350588 del 0.000866 dsp 3.937762 jit 0.346923
transmit: at 401 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 401 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 3 off -0.694305 del 0.000799 dsp 1.938024 jit 0.545493
transmit: at 470 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 470 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 4 off -1.036756 del 0.000850 dsp 0.938220 jit 0.742827
transmit: at 539 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 539 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 5 off -1.385335 del 0.000770 dsp 0.438350 jit 0.945878
select: combine offset -1.385335216 jitter 0.945878421
event at 539 192.168.0.128 965a 8a sys_peer
clock_update: at 539 sample 539 associd 3654
transmit: at 606 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 606 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 6 off -1.735069 del 0.000830 dsp 0.188416 jit 1.149582
select: combine offset -1.735069059 jitter 1.149581813
clock_update: at 606 sample 606 associd 3654
transmit: at 675 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 675 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 7 off -2.086852 del 0.000773 dsp 0.063472 jit 1.354748
select: combine offset -2.086851977 jitter 1.354747533
clock_update: at 675 sample 675 associd 3654
transmit: at 742 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 742 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 8 off -2.419615 del 0.000833 dsp 0.000990 jit 1.542528
event at 742 0.0.0.0 c628 08 no_sys_peer
transmit: at 808 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 808 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 8 off -2.761397 del 0.000829 dsp 0.000977 jit 1.538923
transmit: at 874 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 874 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 8 off -3.115970 del 0.000783 dsp 0.000970 jit 1.547315
transmit: at 941 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 941 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 8 off -3.454656 del 0.000812 dsp 0.000975 jit 1.541002
transmit: at 1008 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 1008 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 8 off -3.782565 del 0.000874 dsp 0.000977 jit 1.524405
transmit: at 1073 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 1073 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 8 off -4.129596 del 0.000772 dsp 0.000963 jit 1.526246
transmit: at 1139 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 1139 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 8 off -4.474546 del 0.000842 dsp 0.000964 jit 1.527951
transmit: at 1204 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 1204 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 8 off -4.816187 del 0.000865 dsp 0.000957 jit 1.529086
transmit: at 1270 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 1270 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 8 off -5.150281 del 0.000791 dsp 0.000961 jit 1.521326
transmit: at 1336 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 1336 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 8 off -5.488886 del 0.000826 dsp 0.000963 jit 1.517709
transmit: at 1400 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 1400 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 8 off -5.828900 del 0.000837 dsp 0.000949 jit 1.518841
transmit: at 1466 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 1466 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 8 off -6.151891 del 0.000802 dsp 0.000957 jit 1.504664
transmit: at 1531 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 1531 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 8 off -6.496869 del 0.000889 dsp 0.000953 jit 1.507741
...
transmit: at 60016 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 60016 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 8 off -308.457330 del 0.000845 dsp 0.000953 jit 1.478485
transmit: at 60083 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 60083 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 8 off -308.794748 del 0.000787 dsp 0.000967 jit 1.485310
transmit: at 60147 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 60147 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 8 off -309.112881 del 0.000664 dsp 0.000951 jit 1.475267
transmit: at 60212 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 60212 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 8 off -309.437339 del 0.000652 dsp 0.000951 jit 1.469266
transmit: at 60279 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 60279 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 8 off -309.771347 del 0.000684 dsp 0.000965 jit 1.471392
transmit: at 60346 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 60346 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 8 off -310.108806 del 0.000700 dsp 0.000973 jit 1.477145
transmit: at 60412 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 60412 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 8 off -310.442923 del 0.000739 dsp 0.000969 jit 1.481047
transmit: at 60476 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 60476 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 8 off -310.772225 del 0.000737 dsp 0.000952 jit 1.481063
^Caddto_syslog: ntpd exiting on signal 2
--
Posted automagically by a mail2news gateway at muc.de e.V.
Please direct questions, flames, donations, etc. to news-...@muc.de
Sujit K M
> ntp_set_tod: Final result: clock_settime: 0: Undefined error: 0
Could not find any documentation. But is this that you are looking for.
Sujit K M
-x, --slew
Slew up to 600 seconds.
Normally, the time is slewed if the offset is less than the step
threshold, which is 128 ms by default, and stepped if above the
threshold. This option sets the threshold to 600 s, which is
well within the accuracy window to set the clock manually.
Note: Since the slew rate of typical Unix kernels is limited to
0.5 ms/s, each second of adjustment requires an amortization
interval of 2000 s. Thus, an adjustment as much as 600 s will
take almost 14 days to complete. This option can be used with
the -g and -q options. See the tinker configuration file direc-
tive for other options. Note: The kernel time discipline is
disabled with this option.
On Fri, Dec 24, 2010 at 4:39 PM, Sujit K M <sjt...@gmail.com> wrote:
>> ntp_set_tod: clock_settime: 0: Undefined error: 0
>> ntp_set_tod: Final result: clock_settime: 0: Undefined error: 0
>
>
> Could not find any documentation. But is this that you are looking for.
>
--
-- Sujit K M
blog(http://kmsujit.blogspot.com/)
BERTRAND Joel
> I quote from http://www.daemon-systems.org/man/ntpd.8.html)
>
> -x, --slew
> Slew up to 600 seconds.
>
> Normally, the time is slewed if the offset is less than the step
> threshold, which is 128 ms by default, and stepped if above the
> threshold. This option sets the threshold to 600 s, which is
> well within the accuracy window to set the clock manually.
> Note: Since the slew rate of typical Unix kernels is limited to
> 0.5 ms/s, each second of adjustment requires an amortization
> interval of 2000 s. Thus, an adjustment as much as 600 s will
> take almost 14 days to complete. This option can be used with
> the -g and -q options. See the tinker configuration file direc-
> tive for other options. Note: The kernel time discipline is
> disabled with this option.
I have tried without any success :
riemann# ntpd -n -d -x
ntpd 4.2.6-o Sun Dec 13 14:48:32 UTC 2009 (import)
addto_syslog: proto: precision = 8.000 usec
event at 0 0.0.0.0 c01d 0d kern kernel time sync enabled
status=0x1<PLL,MODE=0x0=PLL,CLK=0x0=A>
Finished Parsing!!
addto_syslog: ntp_io: estimated max descriptors: 128, initial socket
boundary: 20
addto_syslog: Listen and drop on 0 v4wildcard 0.0.0.0 UDP 123
addto_syslog: Listen and drop on 1 v6wildcard :: UDP 123
addto_syslog: Listen normally on 2 le0 192.168.0.85 UDP 123
restrict: addr c0a80055 mask ffffffff mflags 00003000 flags 00000001
addto_syslog: Listen normally on 3 le0 fe80::a00:20ff:fe78:6e83 UDP 123
addto_syslog: Listen normally on 4 lo0 127.0.0.1 UDP 123
restrict: addr 7f000001 mask ffffffff mflags 00003000 flags 00000001
addto_syslog: Listen normally on 5 lo0 ::1 UDP 123
addto_syslog: Listen normally on 6 lo0 fe80::1 UDP 123
addto_syslog: Listening on routing socket on fd #27 for interface updates
key_expire: at 0 associd 13230
peer_clear: at 0 next 1 associd 13230 refid INIT
event at 0 192.168.0.128 8011 81 mobilize assoc 13230
newpeer: 192.168.0.85->192.168.0.128 mode 3 vers 4 poll 6 10 flags 0x1
0x1 ttl 0 key 00000000
event at 0 0.0.0.0 c016 06 restart
event at 0 0.0.0.0 c012 02 freq_set ntpd 0.000 PPM
event at 0 0.0.0.0 c011 01 freq_not_set
transmit: at 1 192.168.0.85->192.168.0.128 mode 3 len 48
auth_agekeys: at 1 keys 1 expired 0
receive: at 1 192.168.0.85<-192.168.0.128 mode 4 len 48
event at 1 192.168.0.128 8024 84 reachable
clock_filter: n 1 off 0.001928 del 0.000848 dsp 7.937505 jit 0.000008
transmit: at 67 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 67 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 2 off 0.005789 del 0.000887 dsp 3.937755 jit 0.003861
transmit: at 134 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 134 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 3 off -0.957518 del 0.000754 dsp 1.938009 jit 0.961378
transmit: at 200 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 200 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 4 off -1.921037 del 0.000860 dsp 0.938192 jit 1.667215
transmit: at 267 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 267 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 5 off -1.917218 del 0.001017 dsp 0.438322 jit 1.440670
transmit: at 334 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 334 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 6 off -2.396893 del 0.000786 dsp 0.188403 jit 1.676637
transmit: at 398 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 398 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 7 off -2.393055 del 0.000862 dsp 0.063429 jit 1.527547
transmit: at 462 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 462 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 8 off -2.873037 del 0.000778 dsp 0.000945 jit 1.792814
transmit: at 529 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 529 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 8 off -3.352658 del 0.000777 dsp 0.000962 jit 1.820136
transmit: at 593 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 593 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 8 off -4.316154 del 0.000802 dsp 0.000949 jit 2.176653
transmit: at 660 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 660 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 8 off -5.279447 del 0.000928 dsp 0.000964 jit 2.663379
transmit: at 725 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 725 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 8 off -6.242732 del 0.000733 dsp 0.000957 jit 3.221968
transmit: at 791 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 791 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 8 off -6.722613 del 0.000861 dsp 0.000961 jit 3.201268
transmit: at 858 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 858 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 8 off -7.202363 del 0.000859 dsp 0.000970 jit 3.159376
Regards,
JKB
BERTRAND Joel
transmit: at 3663 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 3663 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: n 8 off -23.499113 del 0.000693 dsp 0.001302 jit 1.037349
select: combine offset -23.499113340 jitter 1.037348506
clock_update: at 3663 sample 3663 associd 13230
addto_syslog: frequency error -590 PPM exceeds tolerance 500 PPM
local_clock: offset -23.499113340 jit 9.782995348 freq -500.000 stab
31.693 poll 6
transmit: at 3730 192.168.0.85->192.168.0.128 mode 3 len 48
receive: at 3730 192.168.0.85<-192.168.0.128 mode 4 len 48
clock_filter: old sample 67
frequency error -590 PPM ! If I reboot the same workstation with NetBSD
4.0.1, ntpd can synchronize system clock.
Regards,
JKB
Hauke Fath
> frequency error -590 PPM ! If I reboot the same workstation with
>NetBSD
>4.0.1, ntpd can synchronize system clock.
From my experience, sparc time-keeping quality has gone downhill ever since
the introduction of SMP support in netbsd-2.
From my ss20's message (netbsd-4, 2x SM71):
<snip>
Dec 24 13:47:08 pizza ntpd[15329]: synchronized to 85.25.120.47, stratum 2
Dec 24 13:50:31 pizza ntpd[15329]: synchronized to 192.53.103.108, stratum 1
Dec 24 13:52:31 pizza ntpd[15329]: time reset -0.183353 s
Dec 24 13:56:59 pizza ntpd[15329]: synchronized to 213.198.55.2, stratum 2
Dec 24 13:58:29 pizza ntpd[15329]: synchronized to 192.53.103.108, stratum 1
Dec 24 14:00:01 pizza syslogd: restart
Dec 24 14:13:16 pizza ntpd[15329]: time reset -0.395868 s
Dec 24 14:18:32 pizza ntpd[15329]: synchronized to 192.53.103.108, stratum 1
Dec 24 14:35:31 pizza ntpd[15329]: time reset -0.373273 s
Dec 24 14:39:55 pizza ntpd[15329]: synchronized to 217.157.154.78, stratum 2
Dec 24 14:42:59 pizza ntpd[15329]: synchronized to 192.53.103.108, stratum 1
</snip>
hauke
--
"It's never straight up and down" (DEVO)
BERTRAND Joel
> At 14:08 Uhr +0100 24.12.2010, BERTRAND Joel wrote:
>> frequency error -590 PPM ! If I reboot the same workstation with
>> NetBSD
>> 4.0.1, ntpd can synchronize system clock.
>
> From my experience, sparc time-keeping quality has gone downhill ever since
> the introduction of SMP support in netbsd-2.
I don't agree. I've never seen this mistake with NetBSD 4.0.1. It's a
-current regression.
Regards,
JKB