Unstable clock on RB5009UPr+; critical,info ntp change time

Hey there!

I’ve upgraded to the new RB5009 from my old HAP AC, and I’ve noticed a strange behavior of the system clock. Many times a day the clock is being adjusted a second or even two

21:08:36 echo: system,critical,info ntp change time Sep/11/2022 21:08:37 => Sep/11/2022 21:08:36
21:58:52 echo: system,critical,info ntp change time Sep/11/2022 21:58:53 => Sep/11/2022 21:58:52
22:46:02 echo: system,critical,info ntp change time Sep/11/2022 22:46:03 => Sep/11/2022 22:46:02
23:35:15 echo: system,critical,info ntp change time Sep/11/2022 23:35:16 => Sep/11/2022 23:35:15
00:34:09 echo: system,critical,info ntp change time Sep/12/2022 00:34:11 => Sep/12/2022 00:34:09

The ntp client configuration:

 > system ntp client print
         enabled: yes
            mode: unicast
         servers: timeserver.iix.net.il
             vrf: main
      freq-drift: 442.319 PPM
          status: synchronized
   synced-server: timeserver.iix.net.il
  synced-stratum: 2
   system-offset: -251.803 ms

Here is the list of servers:

 > system ntp client servers print
Flags: X - disabled; D - dynamic
 0    address=timeserver.iix.net.il resolved-address=192.114.63.250 min-poll=6 max-poll=10 iburst=yes auth-key=none

I can’t imagine how a clock can be that off. It looks to me more like some competing time updates but I don’t know what alternative source of time could be there.
Any ideas?

So, after writing this yesterday, I’ve decided to disable the NTP client and see if the clock really drifts that much. With the PPM error advertised, I should have seen tens of seconds difference over the 12 hr period, and I’ve checked now that the clock is still perfectly aligned with my computer clock, within a 0.5 seconds error of perception.

So I’m starting to think that maybe I’ve accidentally imported the drift setting from my old router. I’ll reset my frequency drift and see if that changes the picture

If you restored binary backup from hAP ac to RB5009, then you imported quite a few potential problems … binary backups are not meant to transfer config between different device models (even if backup is restored on another device of same model it can cause some surprises). So the erroneous drift value might only be a beginning …

:confused:

well, I did restore binary and then quickly realized it was not a good idea and restored back to the factory settings, then manually imported the relevant config via scripting.

After playing with this for a while I can see that resetting the frequency drift didn’t really help; after starting the ntp client again I have observed the frequency drift get back to ~500 PPM and the constant time update messages returned

 20:35:18 system,info ntp settings changed by leo
 20:35:27 system,info ntp change time Sep/12/2022 20:35:27 => Sep/12/2022 20:35:27
 20:56:49 system,info ntp change time Sep/12/2022 20:56:49 => Sep/12/2022 20:56:49
 20:56:49 ntp,warning WARNING: frequency out of range: -0.000541. MAX: 0.000500
 21:15:03 system,info ntp change time Sep/12/2022 21:15:03 => Sep/12/2022 21:15:03
 21:32:15 system,info ntp change time Sep/12/2022 21:32:14 => Sep/12/2022 21:32:15
 21:53:41 system,info ntp change time Sep/12/2022 21:53:41 => Sep/12/2022 21:53:41
 22:16:08 system,info ntp change time Sep/12/2022 22:16:08 => Sep/12/2022 22:16:08
 22:37:32 system,info ntp change time Sep/12/2022 22:37:31 => Sep/12/2022 22:37:32
 22:53:38 system,info ntp change time Sep/12/2022 22:53:38 => Sep/12/2022 22:53:38
 23:18:13 system,info ntp change time Sep/12/2022 23:18:12 => Sep/12/2022 23:18:13

Changing the ntp server to pool.ntp.org (and resetting drift again) I still have the same issue

 23:36:55 system,info ntp change time Sep/12/2022 23:36:55 => Sep/12/2022 23:36:55
 23:54:06 system,info ntp change time Sep/12/2022 23:54:06 => Sep/12/2022 23:54:06
 00:09:08 system,info ntp change time Sep/13/2022 00:09:07 => Sep/13/2022 00:09:08

I am not that confident factory reset will effectively clear all settings (but it should).

Might be the safer option to netinstall that device and start again from scratch importing from rsc export.
Best to be 100% sure.

You did disable “Update Time” from IP/Cloud, right?

OMG! There was that tickmark, indeed! unchecking it and will report tomorrow.

> ip cloud print
          ddns-enabled: no
  ddns-update-interval: none
           update-time: yes
        public-address:

Thanks Znevna :folded_hands:t3:

While I do hope that will help, there’s also this in the docs (https://help.mikrotik.com/docs/display/ROS/Cloud#Cloud-Properties):

update-time (yes | no; Default: yes) If set to yes then router clock will be set to time, provided by cloud server IF there is no NTP or SNTP client enabled. If set to no, then IP/Cloud service will never update the device’s clock. If update-time is set to yes, Clock will be updated even when ddns-enabled is set to no.

so, technically, since I had the NTP client enabled, that setting should have been ignored. We’ll see about that soon.

I didn’t check the docs sadly, sorry, hopefully you’ve found a bug.

First netinstall before jumping to conclusions, please.
I’m still not convinced all the rubbish from previous digital import was cleared with factory reset.

Sadly,

 22:58:11 system,info ntp change time Sep/13/2022 22:58:11 => Sep/13/2022 22:58:11
 23:23:50 system,info ntp change time Sep/13/2022 23:23:50 => Sep/13/2022 23:23:50

I’m starting to wonder if this is a WAD. Cause, otherwise, I’d have to follow holvoetn’s advice but that’s painful :see_no_evil_monkey:

What needs to be done, needs to be done.
At least you can be 100% sure then that mishap with previous restore is not the root cause.

Hi, did you fix it?

i have the same issue after, power outage, until mikrotik sync with NTP servers, it sends many warning emails with same warning “ntp change time” :frowning:

I’m actually having the same issue too on several different mikrotiks. Any update on this?

I started to notice this in the logs after upgrading from 6 to 7. I turned off /ip/cloud/update-time and it fixed it for me. I am using a local NTP server.

I’m seeing the same issue on a CHR instance in a KVM VM (on Proxmox VE). Cloud time sync is off, 4 ntp servers are configured, all work. The offset is weirdly high. Can it be caused by something like CPU frequency scaling?

 13:56:55 system,info ntp change time Jul/14/2023 13:56:55 => Jul/14/2023 13:56:55
 14:13:59 system,critical,info ntp change time Jul/14/2023 14:14:00 => Jul/14/2023 14:13:59
 14:30:00 system,info ntp change time Jul/14/2023 14:30:00 => Jul/14/2023 14:30:00
 14:47:00 system,info ntp change time Jul/14/2023 14:47:00 => Jul/14/2023 14:47:00
 15:03:03 system,info ntp change time Jul/14/2023 15:03:03 => Jul/14/2023 15:03:03
 15:21:11 system,critical,info ntp change time Jul/14/2023 15:21:12 => Jul/14/2023 15:21:11
 15:38:17 system,info ntp change time Jul/14/2023 15:38:17 => Jul/14/2023 15:38:17
 15:54:23 system,info ntp change time Jul/14/2023 15:54:23 => Jul/14/2023 15:54:23
 16:13:37 system,critical,info ntp change time Jul/14/2023 16:13:39 => Jul/14/2023 16:13:37
 16:34:02 system,info ntp change time Jul/14/2023 16:34:02 => Jul/14/2023 16:34:02
 16:51:00 system,info ntp change time Jul/14/2023 16:51:00 => Jul/14/2023 16:51:00
 17:06:52 system,critical,info ntp change time Jul/14/2023 17:06:53 => Jul/14/2023 17:06:52
 17:29:16 system,info ntp change time Jul/14/2023 17:29:16 => Jul/14/2023 17:29:16

> /system/ntp/client/print 
         enabled: yes
            mode: unicast
         servers: 0.hu.pool.ntp.org,1.hu.pool.ntp.org,2.hu.pool.ntp.org,3.hu.pool.ntp.org
             vrf: main
      freq-drift: 487.389 PPM
          status: synchronized
   synced-server: 3.hu.pool.ntp.org
  synced-stratum: 2
   system-offset: -787.488 ms

Hi all!

I apologize for not responding earlier, somehow the notifications from the forum got lost.

As was suggested above, I have restored to factory settings and re-configured the router from scratch. It was painful, but I was able to salvage some blocks of config from the config exports lying around. It looks like my original attempt to restore from a binary backup has misconfigured the hardware or something like that. In any case, after the reset I stopped seeing this issue

Thanks for the feedback !

Yes, it is a really nasty problem.
I think RouterOS should post a big warning when restoring a backup from a different device.
When same hardware → warning and pointing to some info page on how to reset MAC addresses etc
When different hardware model → plainly refuse to restore.

And then offer a service in the mikrotik account to convert a .backup file to a .rsc file that the user can use to recover their config manually.