[Bug 242137] [NTP] "Unexpected origin timestamp 0xe180e455.d15bf3fb does not match aorg 0000000000.00000000 from server" (kernel reports TIME_ERROR: 0x41: Clock Unsynchronized)
bugzilla-noreply at freebsd.org
bugzilla-noreply at freebsd.org
Thu Nov 21 11:54:47 UTC 2019
https://bugs.freebsd.org/bugzilla/show_bug.cgi?id=242137
Bug ID: 242137
Summary: [NTP] "Unexpected origin timestamp 0xe180e455.d15bf3fb
does not match aorg 0000000000.00000000 from server"
(kernel reports TIME_ERROR: 0x41: Clock
Unsynchronized)
Product: Base System
Version: 12.0-STABLE
Hardware: amd64
OS: Any
Status: New
Severity: Affects Some People
Priority: ---
Component: bin
Assignee: bugs at FreeBSD.org
Reporter: egypcio at FreeBSD.org
*** this issue was first noticed on FreeBSD stable/12 at r354367; amd64. after
updating the machine to stable/12 at r354893 it still persists. bare metal, no VM.
OSVERSION and KERNVERSION are both 1201502.
*** it was tested in 2 different machines (same hardware with same BIOS
version, drivers and so on; all up to date. dell poweredge r440).
% grep -i ntp /etc/rc.conf
ntpdate_enable="YES"
ntpd_enable="YES"
ntpd_flags="${ntpd_flags} -4 --logfile=/var/log/ntpd.log
--statsdir=/etc/ntp/stats -g -g -g -G"
% grep -v ^# /etc/ntp.conf
restrict default limited kod nomodify notrap noquery nopeer
restrict 127.0.0.1 mask 255.255.255.255
restrict 10.64.35.0 mask 255.255.255.248 nomodify notrap
server ntp1 iburst prefer
server ntp2 iburst prefer
server ntp3 iburst
server ntp4 iburst
tos orphan 3
statistics clockstats cryptostats loopstats peerstats rawstats sysstats
% uptime
12:39PM up 19:28, 4 users, load averages: 0.33, 0.26, 0.21
% date ; ntpq -4 -n -c peers localhost
Thu Nov 21 12:39:57 CET 2019
remote refid st t when poll reach delay offset jitter
==============================================================================
10.0.5.3 134.130.4.17 2 u 14 64 1 0.172 1295.19 145.506
10.0.5.4 192.87.106.2 2 u 12 64 1 0.199 1151.60 163.782
10.0.32.248 134.130.4.17 2 u 15 64 1 1.039 1093.62 252.553
10.0.32.249 192.87.106.2 2 u 14 64 1 1.064 1084.35 263.641
% tail -n5 /var/log/ntpd.log
21 Nov 11:54:19 ntpd[62796]: kernel reports TIME_ERROR: 0x2041: Clock
Unsynchronized
21 Nov 11:54:19 ntpd[62796]: kernel reports TIME_ERROR: 0x2041: Clock
Unsynchronized
21 Nov 11:54:27 ntpd[62796]: Doing intital time step
21 Nov 12:07:40 ntpd[62796]: receive: Unexpected origin timestamp
0xe180ee7b.1b07155c does not match aorg 0000000000.00000000 from
server at 10.0.32.249 xmt 0xe180ee7c.0e6de70f
21 Nov 12:12:48 ntpd[62796]: receive: Unexpected origin timestamp
0xe180efb0.0f7b03f3 does not match aorg 0000000000.00000000 from
server at 10.0.32.249 xmt 0xe180efb0.c5f625d7
*** the server reported above by ntpd.log is NOT always the same; also used
servers from the public pool offered by ntp.org, and others.
*** stratum 1 and 2 were used to try synchonizing the clock. the machine ran
with a slightly nodified 'ntp.conf' with +4 servers for a couple minutes. same
behavior.
*** a reboot was conducted just in case.
# tail /etc/ntp/stats/*.20191121
==> /etc/ntp/stats/loopstats.20191121 <==
58808 39269.319 0.000000000 41.447 0.000000238 0.000000 6
58808 39276.266 0.016292991 41.447 0.005760442 0.000000 6
58808 39280.272 0.024378028 41.447 0.006099659 0.000000 6
58808 39283.292 0.028349141 41.447 0.005875910 0.000000 6
58808 39284.325 0.031962872 41.447 0.005642953 0.000000 6
58808 39648.103 0.000000000 41.447 0.000000238 0.000000 6
58808 40060.057 0.000000000 41.447 0.000000238 0.000000 6
58808 40368.773 0.000000000 41.447 0.000000238 0.000003 6
58808 41071.263 0.000000000 41.447 0.000000238 0.000003 6
58808 41831.078 0.000000000 41.447 0.000000238 0.000003 6
==> /etc/ntp/stats/peerstats.20191121 <==
58808 41832.116 10.0.5.4 9014 1.084662017 0.000208704 7.937500151 0.000000238
58808 41832.116 10.0.5.3 9014 1.084808389 0.000198845 7.937500151 0.000000238
58808 41832.117 10.0.32.249 9074 1.084358544 0.001063677 7.937500157
0.000000238
58808 41836.090 10.0.32.248 9064 1.093624959 0.001039041 7.937500157
0.000000238
58808 41861.061 10.0.5.4 9014 1.151605000 0.000199260 3.937608976 0.066942983
58808 41921.087 10.0.5.3 9014 1.290578800 0.000184648 3.937833976 0.205770411
58808 41923.097 10.0.5.3 9014 1.295191429 0.000171885 1.937678388 0.148799025
58808 42044.123 10.0.32.248 9064 1.574754317 0.000975819 0.438625303
0.321708459
58808 42045.071 10.0.5.3 961a 1.577294399 0.000142329 0.438419041 0.325921391
58808 42107.065 10.0.32.249 9374 1.720286304 0.000934281 0.188952496
0.417919861
==> /etc/ntp/stats/rawstats.20191121 <==
58808 42045.071 10.0.5.3 10.0.5.7 3783325245.070321137 3783325246.647686701
3783325246.647714587 3783325245.070491352 0 4 4 2 6 -24 0.002029 0.038559
134.130.4.17
58808 42045.071 10.0.32.249 10.0.248.26 3783325245.070242874
3783325246.647650840 3783325246.647691908 3783325245.071362245 0 4 4 2 6 -24
0.006226 0.043961 192.87.106.2
58808 42047.107 10.0.5.7 10.0.5.4 49709281.717738837 32932065.437737468
1073119457.879780001 0.000000000 3 4 3 3 6 -22 2382364672.000000
1449198080.000000 10.0.5.3
58808 42047.107 10.0.5.4 10.0.5.7 3783325247.106494539 3783325248.688494213
3783325248.688520585 3783325247.106853646 0 4 4 2 6 -24 0.005630 0.042023
192.87.106.2
58808 42106.109 10.0.248.26 10.0.32.248 1039565025.590554219
1022787809.035393484 2062975201.462277836 0.000000000 3 4 3 3 6 -22
2382364672.000000 2422276608.000000 10.0.5.3
58808 42106.110 10.0.32.248 10.0.248.26 3783325306.108754603
3783325307.827359874 3783325307.827429942 3783325306.109918638 0 4 4 2 6 -24
0.002396 0.036011 134.130.4.17
58808 42107.064 10.0.248.26 10.0.32.249 1056342241.047421434
1039565025.799976591 2079752417.367572907 0.000000000 3 4 3 3 6 -22
2382364672.000000 2439053824.000000 10.0.5.3
58808 42107.064 10.0.5.7 10.0.5.3 1056342241.541501084 1039565025.647339527
2079752417.948276881 0.000000000 3 4 3 3 6 -22 2382364672.000000
2439053824.000000 10.0.5.3
58808 42107.064 10.0.5.3 10.0.5.7 3783325307.063579735 3783325308.784316616
3783325308.784336750 3783325307.063787127 0 4 4 2 6 -24 0.002029 0.039490
134.130.4.17
58808 42107.065 10.0.32.249 10.0.248.26 3783325307.063508592
3783325308.784262036 3783325308.784329157 3783325307.064509994 0 4 4 2 6 -24
0.006226 0.044891 192.87.106.2
==> /etc/ntp/stats/sysstats.20191121 <==
58808 1051.535 3600 288 236 288 0 0 0 0 0 0 0
58808 4660.020 3600 287 231 287 0 0 0 0 0 0 0
58808 8266.163 3600 281 227 281 0 0 0 0 0 0 0
58808 11875.331 3600 284 231 284 0 0 0 0 0 0 0
58808 15484.618 3600 288 235 288 0 0 0 0 0 0 0
58808 19091.952 3600 284 227 284 0 0 0 0 0 0 0
58808 22701.535 3600 284 238 284 0 0 0 0 0 0 0
58808 26308.724 3600 282 228 282 0 0 0 0 0 0 0
58808 29917.975 3600 286 233 286 0 0 0 0 0 0 0
58808 33526.016 3600 272 227 272 0 0 0 0 0 0 0
% date ; ntpq -4 -n -c peers localhost
Thu Nov 21 12:53:22 CET 2019
remote refid st t when poll reach delay offset jitter
==============================================================================
*10.0.5.3 134.130.4.17 2 u 11 64 1 0.168 973.772 232.305
+10.0.5.4 192.87.106.2 2 u 9 64 1 0.195 978.173 278.795
+10.0.32.248 134.130.4.17 2 u 12 64 1 1.071 684.348 162.969
+10.0.32.249 192.87.106.2 2 u 11 64 1 1.061 624.044 207.852
*** other machines running either older revisions of stable/12 or releng/12.0
and releng/12.1 are not affected.
--
You are receiving this mail because:
You are the assignee for the bug.
More information about the freebsd-bugs
mailing list