Снятие денег за тарифы NoDeny Plus происходит с опозданием

[FlySky11]

Здравствуйте!
Подскажите пожалуйста куда копать

Время запуска скрипта отвечающего за снятие денег за тариф в каждном месяце  с опозданием на +-30 минут, не в 00:00 а в +- 00:20-40 времени, но у всех от начала запуска скрипта  списание проходит за 1-2 минуты.
Из-за этого списание денег происходит по принципу ниже, тоесть считаеться коефициент за неполный месяц.

Код:

Термін дії: 01.08.2020 00:34 .. 01.09.2020 00:00
Зменшено час тарифу, коефіцієнт: 0.999

И долго начисляються бонусы по програме лояльности - тоже около минут +-30-40

[Jovani]

Подскажите, может кто сталкивался с проблемой.
Есть тариф суточный (статус заморожен), клиент пополнил счет, и активация проходит с задержкой в 4-5 часов, иногда и больше.
Перезапуск ядра не дал результата.
At revision 635.
С чем может быть связано?

[Efendy]

Есть ли ошибки в логах:

Код:

cat /usr/local/nodeny/logs/kernel.log
cat /usr/local/nodeny/logs/kernel_services.log

Также узнаем (вдруг файл редактировался) периодичность процедуры восстановления услуг:

Код:

grep service_recovery -A1 /usr/local/nodeny/kernel/services.pm

[Jovani]

В kernel.log

Код:

child process '43027' disappeared. A call to `waitpid` outside of Parallel::ForkManager might have reaped it.
child process '43023' disappeared. A call to `waitpid` outside of Parallel::ForkManager might have reaped it.
child process '43025' disappeared. A call to `waitpid` outside of Parallel::ForkManager might have reaped it.
child process '43024' disappeared. A call to `waitpid` outside of Parallel::ForkManager might have reaped it.
child process '43019' disappeared. A call to `waitpid` outside of Parallel::ForkManager might have reaped it.
child process '43026' disappeared. A call to `waitpid` outside of Parallel::ForkManager might have reaped it.
child process '43020' disappeared. A call to `waitpid` outside of Parallel::ForkManager might have reaped it.
child process '43021' disappeared. A call to `waitpid` outside of Parallel::ForkManager might have reaped it.
child process '43022' disappeared. A call to `waitpid` outside of Parallel::ForkManager might have reaped it.
**  started, pid: 43540
**  started, pid: 43541
**  started, pid: 43542
**  started, pid: 43543
**  started, pid: 43544
**  started, pid: 43545
**  started, pid: 43546
**  started, pid: 43547
**  started, pid: 43548

В kernel_services.log

Код:

05.04.2021 10:08:49 Uid=9436 It's time to finish service id=115358 (Подобовий) and set next one
05.04.2021 10:08:49 Uid=9436 Unsuccessful attempt. The next try will be in 120 sec (service id=115358). Reason: критическая ошибка
05.04.2021 14:01:43 Uid=9436 It's time to finish service id=115358 (Подобовий) and set next one
05.04.2021 14:01:43 Uid=9436 Unsuccessful attempt. The next try will be in 120 sec (service id=115358). Reason: критическая ошибка
05.04.2021 14:01:43 Uid=6410 It's time to finish service id=115360 (Подобовий) and set next one
05.04.2021 14:01:43 Uid=8043 It's time to finish service id=115369 (Безлім40) and set next one
05.04.2021 17:56:45 Uid=9436 It's time to finish service id=115358 (Подобовий) and set next one
05.04.2021 17:56:45 Uid=9436 Unsuccessful attempt. The next try will be in 120 sec (service id=115358). Reason: критическая ошибка
05.04.2021 21:53:57 Uid=9436 It's time to finish service id=115358 (Подобовий) and set next one
05.04.2021 21:53:57 Uid=9436 Unsuccessful attempt. The next try will be in 120 sec (service id=115358). Reason: критическая ошибка
05.04.2021 21:53:57 Uid=6492 It's time to finish service id=115363 (Подобовий) and set next one
06.04.2021 01:51:15 Uid=9436 It's time to finish service id=115358 (Подобовий) and set next one
06.04.2021 01:51:15 Uid=9436 Unsuccessful attempt. The next try will be in 120 sec (service id=115358). Reason: критическая ошибка
06.04.2021 01:51:15 Uid=8893 It's time to finish service id=115364 (Подобовий) and set next one
06.04.2021 05:46:57 Uid=9436 It's time to finish service id=115358 (Подобовий) and set next one
06.04.2021 05:46:57 Uid=9436 Unsuccessful attempt. The next try will be in 120 sec (service id=115358). Reason: критическая ошибка

Код:

root@nodenyplus:~ # grep service_recovery -A1 /usr/local/nodeny/kernel/services.pm
        task         => sub{ service_recovery($_[0], $single, $config) },
        period       => 61,
--
sub service_recovery
{

Поле "Действует раз" пробовал пустое значение и ставил "1", нет результата.

И заметил что в логе изменился формат записи
Было:

Код:

01.05.2020 00:47:05 Переустановка услуги Econom-40 (id=46997, uid=4750)
01.05.2020 00:47:05 Переустановка услуги Econom-40 (id=46998, uid=8894)
01.05.2020 00:47:05 Переустановка услуги Econom-40 (id=47000, uid=894)
01.05.2020 00:47:05 Переустановка услуги Econom-40 (id=47001, uid=8895)
01.05.2020 00:47:05 Переустановка услуги Econom-40 (id=47002, uid=8896)
01.05.2020 00:47:05 Переустановка услуги AirMax AC 15Mbit (id=47008, uid=8897)
01.05.2020 00:47:05 Переустановка услуги Econom-40 (id=47010, uid=8664)
01.05.2020 00:47:05 Переустановка услуги Econom-40 (id=47011, uid=8898)
01.05.2020 00:47:05 Переустановка услуги Econom-40 (id=47012, uid=8899)
01.05.2020 00:47:05 Переустановка услуги Econom-40 (id=47013, uid=5424)
01.05.2020 02:46:26 megogo api: uid=3161 subscription->unsubscribe start
01.05.2020 02:46:26 megogo api: uid=3161 subscription->unsubscribe completed
01.05.2020 02:46:26 megogo api: uid=3161 subscription->subscribe start
01.05.2020 02:46:26 megogo api: uid=3161 subscription->subscribe completed
01.05.2020 02:46:26 Переустановка услуги Megogo Легка (id=46888, uid=3161)
01.05.2020 09:48:54 megogo api: uid=7591 subscription->unsubscribe start
01.05.2020 09:48:54 megogo api: uid=7591 subscription->unsubscribe completed
01.05.2020 09:48:54 megogo api: uid=7591 subscription->subscribe start
01.05.2020 09:48:54 megogo api: uid=7591 subscription->subscribe completed
01.05.2020 09:48:54 Переустановка услуги Megogo Оптимальна (id=46891, uid=7591)

Стало:

Код:

01.06.2020 00:57:19 Uid=6756 It's time to finish service id=47014 (40) and set next one
01.06.2020 00:57:19 Uid=1 It's time to finish service id=47015 (Админ) and set next one
01.06.2020 00:57:19 Uid=6565 It's time to finish service id=47016 (3Mб-150) and set next one
01.06.2020 00:57:19 Uid=12 It's time to finish service id=47017 (8Mб-200) and set next one
01.06.2020 00:57:20 Uid=24 It's time to finish service id=47018 (3Mб-150) and set next one
01.06.2020 00:57:20 Uid=6674 It's time to finish service id=47019 (40) and set next one
01.06.2020 00:57:20 Uid=31 It's time to finish service id=47020 (Админ) and set next one
01.06.2020 00:57:20 Uid=39 It's time to finish service id=47021 (Админ) and set next one
01.06.2020 00:57:20 Uid=7584 It's time to finish service id=47022 (3Mб-150) and set next one
01.06.2020 00:57:20 Uid=41 It's time to finish service id=47023 (Админ) and set next one

[Jovani]

Подскажите где может быть проблема?