Время и Cron в WB6

Добрый день.
Было желание отказаться от ввода времени в UTC, и скорректировать системное время для своего часового пояса. Через утилиту Dpkg-reconfigure tzdata поставил свой часовой пояс(UTC+5), правила с cron срабатывали по нужному времени. Но, в логах контроллер постоянно пытается синхронизировать время, при этом скидывая его на UTC и обратно, NTP сервера изменил, проблема не исчезла, вернул UTC, теперь в логах до два времени, UTC и UTC-5.
Jul 16 06:30:01 wirenboard-ASZ4DBMC authpriv.info CRON[32347]: pam_unix(cron:session): session opened for user root by (uid=0)

Jul 16 06:30:01 wirenboard-ASZ4DBMC authpriv.info CRON[32346]: pam_unix(cron:session): session opened for user root by (uid=0)

Jul 16 06:30:01 wirenboard-ASZ4DBMC cron.info CRON[32354]: (root) CMD (/usr/share/wb-daemon-watchdogs/check_wbrules.sh 2>&1 | logger -t wb-daemon-watchdogs)

Jul 16 06:30:01 wirenboard-ASZ4DBMC cron.info CRON[32355]: (root) CMD (/usr/share/wb-daemon-watchdogs/check_confed.sh 2>&1 | logger -t wb-daemon-watchdogs)

Jul 16 06:30:02 wirenboard-ASZ4DBMC authpriv.info CRON[32347]: pam_unix(cron:session): session closed for user root

Jul 16 06:30:05 wirenboard-ASZ4DBMC authpriv.info CRON[32346]: pam_unix(cron:session): session closed for user root

Jul 16 01:30:10 wirenboard-ASZ4DBMC daemon.info ntpd[18899]: Soliciting pool server 2001:470:784d:fffd::3

Jul 16 01:30:32 wirenboard-ASZ4DBMC daemon.info ntpd[18899]: Soliciting pool server 2001:470:784d:fffd::4

Jul 16 06:31:01 wirenboard-ASZ4DBMC authpriv.info CRON[32431]: pam_unix(cron:session): session opened for user root by (uid=0)

Jul 16 06:31:01 wirenboard-ASZ4DBMC cron.info CRON[32435]: (root) CMD (/usr/share/wb-daemon-watchdogs/check_confed.sh 2>&1 | logger -t wb-daemon-watchdogs)

Jul 16 06:31:06 wirenboard-ASZ4DBMC authpriv.info CRON[32431]: pam_unix(cron:session): session closed for user root

Jul 16 01:31:15 wirenboard-ASZ4DBMC daemon.info ntpd[18899]: Soliciting pool server 2001:470:784d:fffd::3

Jul 16 01:31:36 wirenboard-ASZ4DBMC daemon.info ntpd[18899]: Soliciting pool server 2001:470:784d:fffd::4

Дмитрий, добрый день! Скажите, а вы контроллер перезагружали после изменения time-зоны?

1 Like

Перезагрузил, время в логах пришло в норму, но каждые 30 секунд следующее:
Jul 16 14:30:01 wirenboard-ASZ4DBMC authpriv.info CRON[7529]: pam_unix(cron:session): session opened for user root by (uid=0)

Jul 16 14:30:01 wirenboard-ASZ4DBMC authpriv.info CRON[7530]: pam_unix(cron:session): session opened for user root by (uid=0)

Jul 16 14:30:01 wirenboard-ASZ4DBMC cron.info CRON[7537]: (root) CMD (/usr/share/wb-daemon-watchdogs/check_wbrules.sh 2>&1 | logger -t wb-daemon-watchdogs)

Jul 16 14:30:01 wirenboard-ASZ4DBMC cron.info CRON[7538]: (root) CMD (/usr/share/wb-daemon-watchdogs/check_confed.sh 2>&1 | logger -t wb-daemon-watchdogs)

Jul 16 14:30:02 wirenboard-ASZ4DBMC authpriv.info CRON[7530]: pam_unix(cron:session): session closed for user root

Jul 16 14:30:05 wirenboard-ASZ4DBMC authpriv.info CRON[7529]: pam_unix(cron:session): session closed for user root

Jul 16 14:30:51 wirenboard-ASZ4DBMC daemon.info ntpd[3322]: Soliciting pool server 2001:470:784d:fffd::4

Jul 16 14:30:55 wirenboard-ASZ4DBMC daemon.info ntpd[3322]: Soliciting pool server 2001:470:784d:fffd::3

Отлично! А в чем вы видите проблему в log-сообщениях?

Проблема, конечная глубже, и связанна с тем, что после эксперементов с часовыми поясами возникали проблемы с передачей данных через mqtt. После возврата контроллера к формату utc проблема решилась, но, как я понимаю, синхронизация времени проходит раз в 30 секунд. По аналогии с другими устройствами это слишком часто, есть подозрение, что в момент синхронизации часть данных через mqtt не проходит, но так как отследить этот факт пока не получается, задаю вопрос только относительно этих логов. Если все в порядке, буду смотреть дальше. Спасибо.

Вот этот момент настораживает:
Soliciting pool server
Соединение/синхронизация ntpd с другими серверами (ntpq -pn) в порядке?

Сейчас время отображает МСК,

root@wirenboard-ASZ4DBMC:~# date
Tue Jul 16 19:46:22 MSK 2019

Синхронизация

 ntp3.stratum2.r .POOL.          16 p    -   64    0    0.000    0.000   0.002
 ntp2.stratum2.r .POOL.          16 p    -   64    0    0.000    0.000   0.002
 ntp1.stratum1.r .POOL.          16 p    -   64    0    0.000    0.000   0.002
 ntp2.stratum1.r .POOL.          16 p    -   64    0    0.000    0.000   0.002
+88.147.254.235  88.147.254.229   2 u  692 1024  377   36.496    0.853   0.603
+88.147.254.232  88.147.254.229   2 u    3 1024  377   37.502   -0.240   0.382
-109.195.19.73   89.109.251.21    2 u  512 1024  377   52.143    2.974   0.385
*88.147.254.227  89.109.251.24    2 u  826 1024  377   37.414   -0.592   0.427

Да, тут все в порядке.
Синхронизация времени не проходит раз в 30 секунд, ntpd достаточно корректно и аккуратно подправляет системное время. “Soliciting pool server”, как я понимаю, появляется, когда ntpd хочет получить из пула адрес еще одного сервера ntp.
Попробуйте сменить пулы на дебиановские, например.

А в каком направлении не проходит часть данных, локально, на контроллере, или вы передает их в брокер, и они туда не поступают?

Пока прошу не рассматривать это, как проблему. Возможно некорректно работает БД Influx, или выборка данных из нее. Вопрос с временем можно считать решенным, спасибо.

Успехов вам, обращайтесь!

1 Like