Проблема с ntp сервисом - лог забит синхронизациями

jlopes · 02.Май.2025 08:10:27

Здравствуйте, заглянул в лог а там такое:

02-05-2025 11:02:38.752 [ntp]	Soliciting pool server 160.119.248.252
02-05-2025 11:02:18.752 [ntp]	Soliciting pool server 102.64.113.152
02-05-2025 11:02:17.756 [ntp]	Soliciting pool server 176.97.192.150
02-05-2025 11:02:17.756 [ntp]	Soliciting pool server 176.97.192.150
02-05-2025 11:01:40.752 [ntp]	Soliciting pool server 196.44.136.165
02-05-2025 11:01:34.752 [ntp]	Soliciting pool server 155.232.19.6
02-05-2025 11:01:13.752 [ntp]	Soliciting pool server 41.175.36.40
02-05-2025 11:01:12.752 [ntp]	Soliciting pool server 196.49.100.58
02-05-2025 11:00:33.752 [ntp]	Soliciting pool server 196.49.100.57
02-05-2025 11:00:32.752 [ntp]	Soliciting pool server 196.10.54.58
02-05-2025 11:00:27.752 [ntp]	Soliciting pool server 41.220.128.73
02-05-2025 11:00:07.752 [ntp]	Soliciting pool server 102.216.37.100
02-05-2025 11:00:06.752 [ntp]	Soliciting pool server 102.64.113.151
02-05-2025 11:00:06.752 [ntp]	Soliciting pool server 102.64.113.151
02-05-2025 10:59:34.752 [ntp]	102.222.156.150 local addr 192.168.1.101 -> <null>
02-05-2025 10:59:30.003 [ntp]	receive: Unexpected origin timestamp 0xebbef9e1.c07a370e does not match aorg 0xebbef9a6.c07d1826 from server@102.222.156.150 xmt 0xebbef9e1.dae8a9a1
02-05-2025 10:59:25.757 [ntp]	Soliciting pool server 41.205.143.146
02-05-2025 10:59:20.756 [ntp]	Soliciting pool server 102.216.37.100
02-05-2025 10:59:02.756 [ntp]	Soliciting pool server 155.232.19.6
02-05-2025 10:59:01.759 [ntp]	Soliciting pool server 102.64.112.165
02-05-2025 10:58:25.005 [ntp]	receive: Unexpected origin timestamp 0xebbef9a0.c0db706b does not match aorg 0xebbef963.c07ce483 from server@102.222.156.150 xmt 0xebbef9a0.db581805
02-05-2025 10:58:21.752 [ntp]	Soliciting pool server 196.44.136.162
02-05-2025 10:58:14.752 [ntp]	Soliciting pool server 102.216.37.100
02-05-2025 10:58:14.752 [ntp]	Soliciting pool server 102.216.37.100
02-05-2025 10:58:06.291 [init.scope]	systemd-timedated.service: Succeeded.

время настраивалось по мануалу на вики
статус:

timedatectl status
               Local time: Fri 2025-05-02 11:07:28 MSK
           Universal time: Fri 2025-05-02 08:07:28 UTC
                 RTC time: Fri 2025-05-02 08:07:28
                Time zone: Europe/Moscow (MSK, +0300)
System clock synchronized: yes
              NTP service: active
          RTC in local TZ: no

нтп показывает вот что:

ntpq -c pe
     remote           refid      st t when poll reach   delay   offset  jitter
==============================================================================
 0.debian.pool.n .POOL.          16 p    -   64    0    0.000   +0.000   0.000
 1.debian.pool.n .POOL.          16 p    -   64    0    0.000   +0.000   0.000
 2.debian.pool.n .POOL.          16 p    -   64    0    0.000   +0.000   0.000
 3.debian.pool.n .POOL.          16 p    -   64    0    0.000   +0.000   0.000
*196.10.52.57 (n 183.3.52.101     2 u  62m 1024   10  223.270   -2.012   3.807
 101.46.64.83 (e 185.125.190.56   3 u  83m 1024   40   99.261   -2.002   0.000

подскажите куда копать.
Диагностику прилагаю

приложен диагностический архив, доступен только сотрудникам поддержки

(343,4 КБ)

Because · 02.Май.2025 09:29:03

Здравствуйте.

Убедитесь, что контроллер имеет стабильное интернет-соединение и может достигать NTP серверов. Вы можете попробовать выполнить команду ping к выбранным NTP серверам, чтобы проверить доступность. Если проверка ping показала недоступность серверов pool.ntp.org, то проверьте подключение к интернету. Например, ping 8.8.8.8.
Если подключение к интернету есть, но сервера pool.ntp.org недоступны, то можете использовать более надёжные и близкие к вашему региону NTP сервера. Например, замените pool.ntp.org на time1.google.com или time.windows.com.
Дополнительные сообщения о ошибках в логах могут дать больше информации. /Выполните ntpq -p для просмотра статуса ваших NTP подключений и проверьте, есть ли какие-либо ошибки.

После изменения конфигурации перезапустите службу NTP:

systemctl restart ntp

jlopes · 02.Май.2025 11:23:25

Как видите пинги идут, потерь нет (0%)
По поводу вашего 3 пункта - ощущение что вы просто скопировали шаблон ответа, не читая мое сообщение, потому что вывод ntpq я приложил. Тем не менее, прикладываю его еще раз.

ping 0.debian.pool.ntp.org
PING 0.debian.pool.ntp.org (101.46.64.83) 56(84) bytes of data.
64 bytes from ecs-101-46-64-83.compute.hwclouds-dns.com (101.46.64.83): icmp_seq=1 ttl=40 time=123 ms
64 bytes from ecs-101-46-64-83.compute.hwclouds-dns.com (101.46.64.83): icmp_seq=2 ttl=40 time=124 ms
64 bytes from ecs-101-46-64-83.compute.hwclouds-dns.com (101.46.64.83): icmp_seq=3 ttl=40 time=123 ms
64 bytes from ecs-101-46-64-83.compute.hwclouds-dns.com (101.46.64.83): icmp_seq=4 ttl=40 time=123 ms
64 bytes from ecs-101-46-64-83.compute.hwclouds-dns.com (101.46.64.83): icmp_seq=5 ttl=40 time=123 ms
64 bytes from ecs-101-46-64-83.compute.hwclouds-dns.com (101.46.64.83): icmp_seq=6 ttl=40 time=123 ms
^C
--- 0.debian.pool.ntp.org ping statistics ---
6 packets transmitted, 6 received, 0% packet loss, time 5008ms
rtt min/avg/max/mdev = 123.157/123.347/123.659/0.170 ms

ping 1.debian.pool.ntp.org
PING 1.debian.pool.ntp.org (196.10.54.58) 56(84) bytes of data.
64 bytes from ntp5.inx.net.za (196.10.54.58): icmp_seq=1 ttl=45 time=212 ms
64 bytes from ntp5.inx.net.za (196.10.54.58): icmp_seq=2 ttl=45 time=212 ms
64 bytes from ntp5.inx.net.za (196.10.54.58): icmp_seq=3 ttl=45 time=212 ms
64 bytes from ntp5.inx.net.za (196.10.54.58): icmp_seq=4 ttl=45 time=212 ms
64 bytes from ntp5.inx.net.za (196.10.54.58): icmp_seq=5 ttl=45 time=212 ms
^C
--- 1.debian.pool.ntp.org ping statistics ---
6 packets transmitted, 5 received, 16.6667% packet loss, time 5007ms
rtt min/avg/max/mdev = 211.674/211.835/211.928/0.087 ms

ping 2.debian.pool.ntp.org
PING 2.debian.pool.ntp.org (102.64.112.164) 56(84) bytes of data.
64 bytes from za-ctn-rs01a.dpogroup.com (102.64.112.164): icmp_seq=1 ttl=50 time=218 ms
64 bytes from za-ctn-rs01a.dpogroup.com (102.64.112.164): icmp_seq=2 ttl=50 time=217 ms
64 bytes from za-ctn-rs01a.dpogroup.com (102.64.112.164): icmp_seq=3 ttl=50 time=217 ms
64 bytes from za-ctn-rs01a.dpogroup.com (102.64.112.164): icmp_seq=4 ttl=50 time=217 ms
^C
--- 2.debian.pool.ntp.org ping statistics ---
4 packets transmitted, 4 received, 0% packet loss, time 3004ms
rtt min/avg/max/mdev = 216.807/217.172/218.073/0.521 ms```

ping 3.debian.pool.ntp.org
PING 3.debian.pool.ntp.org (102.130.49.189) 56(84) bytes of data.
64 bytes from jnb.clearnet.pw (102.130.49.189): icmp_seq=1 ttl=44 time=227 ms
64 bytes from jnb.clearnet.pw (102.130.49.189): icmp_seq=2 ttl=44 time=227 ms
64 bytes from jnb.clearnet.pw (102.130.49.189): icmp_seq=3 ttl=44 time=227 ms
64 bytes from jnb.clearnet.pw (102.130.49.189): icmp_seq=4 ttl=44 time=227 ms
^C
— 3.debian.pool.ntp.org ping statistics —
4 packets transmitted, 4 received, 0% packet loss, time 3001ms
rtt min/avg/max/mdev = 227.259/227.341/227.499/0.092 ms

ntpq -p
remote refid st t when poll reach delay offset jitter

0.debian.pool.n .POOL. 16 p - 64 0 0.000 +0.000 0.000
1.debian.pool.n .POOL. 16 p - 64 0 0.000 +0.000 0.000
2.debian.pool.n .POOL. 16 p - 64 0 0.000 +0.000 0.000
3.debian.pool.n .POOL. 16 p - 64 0 0.000 +0.000 0.000
+101.46.64.83 (e 185.125.190.56 3 u 817 1024 202 124.173 -6.250 3.604
131.111.8.61 (p 128.232.103.138 2 u 65m 1024 10 81.373 -4.907 0.794
*217.155.49.215 .PPS. 1 u 92m 1024 140 63.173 +4.214 1.941
102.64.112.164 210.182.58.253 2 u 2024 1024 160 213.804 +16.278 2.297

Because · 02.Май.2025 16:12:06

Да, прошу прощения. Не дописал: интересен ответ команды ntpq -c rv
Если будет что-то вроде такого:

root@wirenboard-ATY5YNRK:~# ntpq -c pe
     remote           refid      st t when poll reach   delay   offset  jitter
==============================================================================
 0.debian.pool.n .POOL.          16 p    -   64    0    0.000   +0.000   0.001
 1.debian.pool.n .POOL.          16 p    -   64    0    0.000   +0.000   0.001
 2.debian.pool.n .POOL.          16 p    -   64    0    0.000   +0.000   0.001
 185.255.121.15  170.231.250.158  2 u    1   64    1   54.886   +0.494   0.186
+static.179.181. 161.62.157.173   3 u    2   64    1   51.660   +0.177   0.388
+eupenstrasse20. .BBgp.           1 u    1   64    1   61.258   -1.829   0.461
 ntp4.lwlcom.net .GPS.            1 u    1   64    1   55.778   -0.362   1.380
 nbg01.muxx.net  131.188.3.220    2 u    2   64    1   70.596   -1.959   0.415
 ntp.kpprs.de    205.46.178.169   2 u    1   64    1   51.565   +0.162   0.931
root@wirenboard-ATY5YNRK:~# ntpq -c rv
associd=0 status=0615 leap_none, sync_ntp, 1 event, clock_sync,
version="ntpd 4.2.8p15@1.3728-o Wed Sep 23 11:46:38 UTC 2020 (1)",
processor="armv7l", system="Linux/5.10.35-wb175", leap=00, stratum=2,
precision=-20, rootdelay=60.950, rootdisp=191.511, refid=93.241.86.156,
reftime=ebbf6925.f88525a4  Fri, May  2 2025 18:54:13.970,
clock=ebbf6963.7b530877  Fri, May  2 2025 18:55:15.481, peer=13861, tc=6,
mintc=3, offset=-0.221950, frequency=-7.711, sys_jitter=0.143664,
clk_jitter=0.892, clk_wander=0.000, tai=37, leapsec=201701010000,
expire=202512280000

Значит, ntp работает.

Если вас беспокоит постоянный перебор серверов, то нормально это 1-2 синхронизации в день. Если видите ресинхронизацию чаще, то стоит проверить /mnt/data/etc/ntp.conf.
Подробнее здесь.

jlopes · 02.Май.2025 17:35:27

вот такое вижу

ntpq -c rv
associd=0 status=0658 leap_none, sync_ntp, 5 events, no_sys_peer,
version="ntpd 4.2.8p15@1.3728-o Wed Sep 23 11:46:38 UTC 2020 (1)",
processor="aarch64", system="Linux/6.8.0-wb124+wb101", leap=00,
stratum=2, precision=-22, rootdelay=70.890, rootdisp=48.040,
refid=217.155.49.215,
reftime=ebbf7a8d.d2b08677  Fri, May  2 2025 20:08:29.823,
clock=ebbf80a8.df886203  Fri, May  2 2025 20:34:32.873, peer=16776,
tc=10, mintc=3, offset=+2.302340, frequency=+16.270, sys_jitter=6.800024,
clk_jitter=5.637, clk_wander=0.415, tai=37, leapsec=201701010000,
expire=202512280000

но при этом в логах попытки обновления каждые несколько секунд

Spiwell · 02.Май.2025 17:57:16

У вас в конфиге ntp что/как указано в опциях pool и server ?

jlopes · 02.Май.2025 18:47:08

# pool.ntp.org maps to about 1000 low-stratum NTP servers.  Your server will
# pick a different set every time it starts up.  Please consider joining the
# pool: <http://www.pool.ntp.org/join.html>
pool 0.debian.pool.ntp.org iburst
pool 1.debian.pool.ntp.org iburst
pool 2.debian.pool.ntp.org iburst
pool 3.debian.pool.ntp.org iburst

никаких действийс нтп кроме тех что есть в вики по настройке ВБ с нуля не производилось

Spiwell · 04.Май.2025 17:46:24

Закоментарьте все опции pool и добавьте
server 0.pool.ntp.org
server 1.pool.ntp.org
server 2.pool.ntp.org
server 3.pool.ntp.org

Сохраните и перезапустите демона.

Because · 05.Май.2025 07:14:03

Здравствуйте.

Чем приведенное поведение отличается от ожидаемого?

В ответе команды ntpq -c rv вижу:

leap_none, sync_ntp: Это говорит о том, что устройство в синхронизации с сетью NTP, и флаг асинхронного скачка (leap second) не установлен.
stratum: Значение 2 означает, что устройству удается достичь второго уровня от эталонного источника времени, что достаточно точно.
offset: Смещение между локальным временем и эталонным составляет +2.302340 ms.
reftime: Время последней синхронизации на устройстве: Fri, May 2 2025 18:54:13.970

Because · 30.Май.2025 11:36:57

Здравствуйте. Удалось разобраться с NTP?

jlopes · 01.Июнь.2025 11:52:06

По итогу, судя по всему, был виноват роутер заказчика, там OpenWRT с обходчиками блокировок. Вот они, судя по всему, гнали нтп через непонятные туннели

Because · 02.Июнь.2025 06:50:00

Хорошо, рад что удалось найти проблему.

Тема		Ответов	Просм.
Время и Cron в WB6 Программное обеспечение	9	600	17.07.2019
Куда ломится WB6 в интернет?	38	5228	14.01.2020
Неверное время у контроллера Контроллеры Wiren Board	5	67	04.06.2024
Время в системном журнале и истории Web UI Контроллеры Wiren Board	10	232	22.08.2023
Отвалилось mqtt и DNS	13	37	06.05.2025

Проблема с ntp сервисом - лог забит синхронизациями

ntpq -p remote refid st t when poll reach delay offset jitter

Связанные темы

ntpq -p
remote refid st t when poll reach delay offset jitter