SPA112 NTP Issue

SidWise · ‎02-12-2020

We have setup NTP on two SPA112's and they start syncing correctly as per the settings (Time Server=Auto,Resync=3600) and then they start updating every minute which fills the log up until we update something on the webpage and the cycle starts again. Has anybody had the same issue/solution.

Simon

Dan Lukes · ‎02-13-2020

then they start updating every minute

They starts updating what ? The time via NTP ? The configuration via provisioning ? Can you disclose exact message filling the log (and what log is filled) ?

SidWise · ‎02-13-2020

The time starts updating via NTP every minute and fills the system log as seen below:

27>Feb 12 15:33:30 SPA112 sendmail: SSL Helper exited (0)

<45>Feb 12 15:34:52 SPA112 syslog-ng[126]: STATS: dropped 0

<45>Feb 12 15:44:52 SPA112 syslog-ng[126]: STATS: dropped 0

<29>Feb 12 15:53:23 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:15,Min:53,Sec:23

<45>Feb 12 15:54:52 SPA112 syslog-ng[126]: STATS: dropped 0

<45>Feb 12 16:04:52 SPA112 syslog-ng[126]: STATS: dropped 0

<45>Feb 12 16:14:52 SPA112 syslog-ng[126]: STATS: dropped 0

<45>Feb 12 16:24:52 SPA112 syslog-ng[126]: STATS: dropped 0

<45>Feb 12 16:34:52 SPA112 syslog-ng[126]: STATS: dropped 0

<45>Feb 12 16:44:52 SPA112 syslog-ng[126]: STATS: dropped 0

<29>Feb 12 16:53:26 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:16,Min:53,Sec:26

<45>Feb 12 16:54:52 SPA112 syslog-ng[126]: STATS: dropped 0

<45>Feb 12 17:04:52 SPA112 syslog-ng[126]: STATS: dropped 0

<45>Feb 12 17:14:52 SPA112 syslog-ng[126]: STATS: dropped 0

<45>Feb 12 17:24:53 SPA112 syslog-ng[126]: STATS: dropped 0

<45>Feb 12 17:34:53 SPA112 syslog-ng[126]: STATS: dropped 0

<45>Feb 12 17:44:53 SPA112 syslog-ng[126]: STATS: dropped 0

<29>Feb 12 17:53:28 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:17,Min:53,Sec:28

<45>Feb 12 17:54:54 SPA112 syslog-ng[126]: STATS: dropped 0

<45>Feb 12 18:04:55 SPA112 syslog-ng[126]: STATS: dropped 0

<45>Feb 12 18:14:55 SPA112 syslog-ng[126]: STATS: dropped 0

<45>Feb 12 18:24:55 SPA112 syslog-ng[126]: STATS: dropped 0

<45>Feb 12 18:34:55 SPA112 syslog-ng[126]: STATS: dropped 0

<45>Feb 12 18:44:55 SPA112 syslog-ng[126]: STATS: dropped 0

<29>Feb 12 18:53:34 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:18,Min:53,Sec:34

<45>Feb 12 18:54:55 SPA112 syslog-ng[126]: STATS: dropped 0

<45>Feb 12 19:04:55 SPA112 syslog-ng[126]: STATS: dropped 0

<45>Feb 12 19:14:56 SPA112 syslog-ng[126]: STATS: dropped 0

<45>Feb 12 19:24:56 SPA112 syslog-ng[126]: STATS: dropped 0

<45>Feb 12 19:34:56 SPA112 syslog-ng[126]: STATS: dropped 0

<45>Feb 12 19:44:56 SPA112 syslog-ng[126]: STATS: dropped 0

<29>Feb 12 19:53:36 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:19,Min:53,Sec:36

<45>Feb 12 19:54:56 SPA112 syslog-ng[126]: STATS: dropped 0

<45>Feb 12 20:04:56 SPA112 syslog-ng[126]: STATS: dropped 0

<45>Feb 12 20:14:56 SPA112 syslog-ng[126]: STATS: dropped 0

<45>Feb 12 20:24:56 SPA112 syslog-ng[126]: STATS: dropped 0

<45>Feb 12 20:34:56 SPA112 syslog-ng[126]: STATS: dropped 0

<45>Feb 12 20:44:56 SPA112 syslog-ng[126]: STATS: dropped 0

<29>Feb 12 20:53:44 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:20,Min:53,Sec:44

<45>Feb 12 20:54:56 SPA112 syslog-ng[126]: STATS: dropped 0

<45>Feb 12 21:04:57 SPA112 syslog-ng[126]: STATS: dropped 0

<45>Feb 12 21:14:57 SPA112 syslog-ng[126]: STATS: dropped 0

<45>Feb 12 21:24:57 SPA112 syslog-ng[126]: STATS: dropped 0

<45>Feb 12 21:34:57 SPA112 syslog-ng[126]: STATS: dropped 0

<45>Feb 12 21:44:58 SPA112 syslog-ng[126]: STATS: dropped 0

<45>Feb 12 21:54:58 SPA112 syslog-ng[126]: STATS: dropped 0

<29>Feb 12 21:54:59 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:21,Min:54,Sec:59

<29>Feb 12 21:56:02 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:21,Min:56,Sec:2

<29>Feb 12 21:57:03 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:21,Min:57,Sec:3

<29>Feb 12 21:58:04 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:21,Min:58,Sec:4

<29>Feb 12 21:59:05 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:21,Min:59,Sec:5

<29>Feb 12 22:00:07 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:0,Sec:7

<29>Feb 12 22:01:09 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:1,Sec:9

<29>Feb 12 22:02:10 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:2,Sec:10

<29>Feb 12 22:03:11 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:3,Sec:11

<29>Feb 12 22:04:11 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:4,Sec:11

<45>Feb 12 22:04:59 SPA112 syslog-ng[126]: STATS: dropped 0

<29>Feb 12 22:05:13 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:5,Sec:13

<29>Feb 12 22:06:15 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:6,Sec:15

<29>Feb 12 22:07:15 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:7,Sec:15

<29>Feb 12 22:08:17 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:8,Sec:17

<29>Feb 12 22:09:18 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:9,Sec:18

<29>Feb 12 22:10:23 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:10,Sec:23

<29>Feb 12 22:11:25 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:11,Sec:25

<29>Feb 12 22:12:26 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:12,Sec:26

<29>Feb 12 22:13:28 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:13,Sec:28

<29>Feb 12 22:14:29 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:14,Sec:29

<45>Feb 12 22:14:59 SPA112 syslog-ng[126]: STATS: dropped 0

<29>Feb 12 22:15:29 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:15,Sec:29

<29>Feb 12 22:16:32 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:16,Sec:32

<29>Feb 12 22:17:33 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:17,Sec:33

<29>Feb 12 22:18:35 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:18,Sec:35

<29>Feb 12 22:19:36 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:19,Sec:36

<29>Feb 12 22:20:36 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:20,Sec:36

<29>Feb 12 22:21:39 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:21,Sec:39

<29>Feb 12 22:22:40 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:22,Sec:40

<29>Feb 12 22:23:41 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:23,Sec:41

<29>Feb 12 22:24:42 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:24,Sec:42

<45>Feb 12 22:24:59 SPA112 syslog-ng[126]: STATS: dropped 0

<29>Feb 12 22:25:43 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:25,Sec:43

<29>Feb 12 22:26:46 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:26,Sec:46

<29>Feb 12 22:27:47 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:27,Sec:47

<29>Feb 12 22:28:48 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:28,Sec:48

<29>Feb 12 22:29:49 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:29,Sec:49

<29>Feb 12 22:30:49 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:30,Sec:49

<29>Feb 12 22:31:52 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:31,Sec:52

<29>Feb 12 22:32:53 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:32,Sec:53

<29>Feb 12 22:33:53 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:33,Sec:53

<29>Feb 12 22:34:55 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:34,Sec:55

<45>Feb 12 22:34:59 SPA112 syslog-ng[126]: STATS: dropped 0

<29>Feb 12 22:36:08 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:36,Sec:8

<29>Feb 12 22:37:10 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:37,Sec:10

<29>Feb 12 22:38:12 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:38,Sec:12

<29>Feb 12 22:39:19 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:39,Sec:19

<29>Feb 12 22:40:19 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:40,Sec:19

<29>Feb 12 22:41:21 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:41,Sec:21

<29>Feb 12 22:42:23 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:42,Sec:23

<29>Feb 12 22:43:24 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:43,Sec:24

<29>Feb 12 22:44:25 SPA112 system[116]: NTP update successfully, Year:2020,Month:2,Day:12,Hour:22,Min:44,Sec:25

<45>Feb 12 22:44:59 SPA112 syslog-ng[126]: STATS: dropped 0

Dan Lukes · ‎02-13-2020

NTP is complex protocol, the update period depends on the stability of the internal clock and some other parameters. Based on the information available, I'm unable to judge you are facing software bug or expected behavior. All at all, you can do nothing. Just upgrade to the latest firmware available (unless you have it already).

Hopefully, filled log is not severe issue. The log in question is system kernel log. It contain no information related to the calls and other voice operations, thus it have little or no value for most issues you may have. To analyze issues, the log of Voice Application needs to be captured. But it require external syslog server. See Debug and syslog Messages from SPA1x2 and SPA232D ATA for details.