search

r-map / rmap

rete monitoraggio ambientale partecipativo documentation at https://doc.rmap.cc
https://rmap.cc
53 stars 42 forks source link

firmware: restarted by watchdog after mqtterror #335

Closed pat1 closed 3 years ago

pat1 commented 3 years ago

Da investigare:

#Sensors reading...
#Next acquisition scheduled at: 15:30:00
#Sensors reading...
#[ 12 ] data stored in sdcard... [ OK ]
#MQTT publish... [ FAIL ]
#Data pointer... [ 04/02/2021 04:30:01 ] [ UPDATE ]
#[ 1420 ] data published through mqtt... [ ERROR ]

#Configuration received... [ OK ]
#Load configuration... [ OK ]
#--> type: report-gsm
#--> version: 3.2
pat1 commented 3 years ago

ho attivato il log dettagliato lato server una stazione "tidone" pare abbia recuperato l'invio dei dati accodati fino al 16 marzo.

E' però ricorrente il seguente errore:

Socket error on client digiteco/1188483,4471096/fixed, disconnecting.
Socket error on client digiteco/1188483,4471096/fixed, disconnecting.

altre cose evidenti non si notano.

pat1 commented 3 years ago

segnalo questi errori:

mar 24 18:33:53 rmap8.arpaepr.local mosquitto[3434085]: 1616607233: Client tidone/944282,4495427/fixed has exceeded timeout, disconnecting.
mar 24 18:37:47 rmap8.arpaepr.local mosquitto[3434085]: 1616607467: Client tidone/938482,4498058/fixed has exceeded timeout, disconnecting.
mar 24 19:09:30 rmap8.arpaepr.local mosquitto[3434085]: 1616609370: Client tidone/944282,4495427/fixed has exceeded timeout, disconnecting.
mar 24 19:15:30 rmap8.arpaepr.local mosquitto[3434085]: 1616609730: Client tidone/938482,4498058/fixed has exceeded timeout, disconnecting.
mar 24 19:38:31 rmap8.arpaepr.local mosquitto[3434085]: 1616611111: Client tidone/944282,4495427/fixed has exceeded timeout, disconnecting.
mar 24 19:38:31 rmap8.arpaepr.local mosquitto[3434085]: 1616611111: Client tidone/938482,4498058/fixed has exceeded timeout, disconnecting.
mar 24 19:46:58 rmap8.arpaepr.local mosquitto[3434085]: 1616611618: Client tidone/939967,4496087/fixed has exceeded timeout, disconnecting.
mar 24 20:07:30 rmap8.arpaepr.local mosquitto[3434085]: 1616612850: Client tidone/938482,4498058/fixed has exceeded timeout, disconnecting.
mar 24 20:21:30 rmap8.arpaepr.local mosquitto[3434085]: 1616613690: Client tidone/944282,4495427/fixed has exceeded timeout, disconnecting.
mar 24 20:34:00 rmap8.arpaepr.local mosquitto[3434085]: 1616614440: Client tidone/938482,4498058/fixed has exceeded timeout, disconnecting.
mar 24 20:47:18 rmap8.arpaepr.local mosquitto[3434085]: 1616615238: Client tidone/944282,4495427/fixed has exceeded timeout, disconnecting.

ed esaminando una di queste stazioni:

mar 24 20:45:26 rmap8.arpaepr.local mosquitto[3434085]: 1616615126: New client connected from 151.18.2.41 as tidone/944282,4495427/fixed (p1, c0, k60, u'tidone').
mar 24 20:45:26 rmap8.arpaepr.local mosquitto[3434085]: 1616615126:         maint/tidone/944282,4495427/fixed/254,0,0/265,0,-,-/B01213
mar 24 20:45:26 rmap8.arpaepr.local mosquitto[3434085]: 1616615126: Sending CONNACK to tidone/944282,4495427/fixed (0, 0)
mar 24 20:45:27 rmap8.arpaepr.local mosquitto[3434085]: 1616615127: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m1, 'maint/tidone/944282,4495427/fixed/254,0,0/265,0,-,-/B01213', ... (12 bytes))
mar 24 20:45:27 rmap8.arpaepr.local mosquitto[3434085]: 1616615127: Sending PUBACK to tidone/944282,4495427/fixed (m1, rc0)
mar 24 20:45:27 rmap8.arpaepr.local mosquitto[3434085]: 1616615127: Received SUBSCRIBE from tidone/944282,4495427/fixed
mar 24 20:45:27 rmap8.arpaepr.local mosquitto[3434085]: 1616615127:         report/tidone/944282,4495427/fixed/rx (QoS 1)
mar 24 20:45:27 rmap8.arpaepr.local mosquitto[3434085]: 1616615127: Sending SUBACK to tidone/944282,4495427/fixed
mar 24 20:45:29 rmap8.arpaepr.local mosquitto[3434085]: 1616615129: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m3, 'report/tidone/944282,4495427/fixed/254,0,0/103,2000,-,-/B12101', ... (37 bytes))
mar 24 20:45:29 rmap8.arpaepr.local mosquitto[3434085]: 1616615129: Sending PUBACK to tidone/944282,4495427/fixed (m3, rc0)
mar 24 20:45:30 rmap8.arpaepr.local mosquitto[3434085]: 1616615130: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m4, 'report/tidone/944282,4495427/fixed/254,0,0/103,2000,-,-/B13003', ... (34 bytes))
mar 24 20:45:30 rmap8.arpaepr.local mosquitto[3434085]: 1616615130: Sending PUBACK to tidone/944282,4495427/fixed (m4, rc0)
mar 24 20:45:30 rmap8.arpaepr.local mosquitto[3434085]: 1616615130: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m5, 'report/tidone/944282,4495427/fixed/3,0,900/103,2000,-,-/B12101', ... (37 bytes))
mar 24 20:45:30 rmap8.arpaepr.local mosquitto[3434085]: 1616615130: Sending PUBACK to tidone/944282,4495427/fixed (m5, rc0)
mar 24 20:45:31 rmap8.arpaepr.local mosquitto[3434085]: 1616615131: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m6, 'report/tidone/944282,4495427/fixed/3,0,900/103,2000,-,-/B13003', ... (34 bytes))
mar 24 20:45:31 rmap8.arpaepr.local mosquitto[3434085]: 1616615131: Sending PUBACK to tidone/944282,4495427/fixed (m6, rc0)
mar 24 20:45:32 rmap8.arpaepr.local mosquitto[3434085]: 1616615132: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m7, 'report/tidone/944282,4495427/fixed/0,0,900/103,2000,-,-/B12101', ... (37 bytes))
mar 24 20:45:32 rmap8.arpaepr.local mosquitto[3434085]: 1616615132: Sending PUBACK to tidone/944282,4495427/fixed (m7, rc0)
mar 24 20:45:32 rmap8.arpaepr.local mosquitto[3434085]: 1616615132: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m8, 'report/tidone/944282,4495427/fixed/0,0,900/103,2000,-,-/B13003', ... (34 bytes))
mar 24 20:45:32 rmap8.arpaepr.local mosquitto[3434085]: 1616615132: Sending PUBACK to tidone/944282,4495427/fixed (m8, rc0)
mar 24 20:45:33 rmap8.arpaepr.local mosquitto[3434085]: 1616615133: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m9, 'report/tidone/944282,4495427/fixed/2,0,900/103,2000,-,-/B12101', ... (37 bytes))
mar 24 20:45:33 rmap8.arpaepr.local mosquitto[3434085]: 1616615133: Sending PUBACK to tidone/944282,4495427/fixed (m9, rc0)
mar 24 20:45:33 rmap8.arpaepr.local mosquitto[3434085]: 1616615133: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m10, 'report/tidone/944282,4495427/fixed/2,0,900/103,2000,-,-/B13003', ... (34 bytes))
mar 24 20:45:33 rmap8.arpaepr.local mosquitto[3434085]: 1616615133: Sending PUBACK to tidone/944282,4495427/fixed (m10, rc0)
mar 24 20:45:34 rmap8.arpaepr.local mosquitto[3434085]: 1616615134: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m11, 'report/tidone/944282,4495427/fixed/1,0,900/1,-,-,-/B13011', ... (33 bytes))
mar 24 20:45:34 rmap8.arpaepr.local mosquitto[3434085]: 1616615134: Sending PUBACK to tidone/944282,4495427/fixed (m11, rc0)
mar 24 20:45:34 rmap8.arpaepr.local mosquitto[3434085]: 1616615134: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m12, 'report/tidone/944282,4495427/fixed/1,0,900/103,2000,-,-/B13212', ... (33 bytes))
mar 24 20:45:34 rmap8.arpaepr.local mosquitto[3434085]: 1616615134: Sending PUBACK to tidone/944282,4495427/fixed (m12, rc0)
mar 24 20:45:35 rmap8.arpaepr.local mosquitto[3434085]: 1616615135: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m13, 'report/tidone/944282,4495427/fixed/254,0,0/265,1,-,-/B25025', ... (35 bytes))
mar 24 20:45:35 rmap8.arpaepr.local mosquitto[3434085]: 1616615135: Sending PUBACK to tidone/944282,4495427/fixed (m13, rc0)
mar 24 20:45:35 rmap8.arpaepr.local mosquitto[3434085]: 1616615135: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m14, 'report/tidone/944282,4495427/fixed/254,0,0/265,1,-,-/B25194', ... (35 bytes))
mar 24 20:45:35 rmap8.arpaepr.local mosquitto[3434085]: 1616615135: Sending PUBACK to tidone/944282,4495427/fixed (m14, rc0)
mar 24 20:45:36 rmap8.arpaepr.local mosquitto[3434085]: 1616615136: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m15, 'report/tidone/944282,4495427/fixed/254,0,0/265,1,-,-/B25192', ... (35 bytes))
mar 24 20:45:36 rmap8.arpaepr.local mosquitto[3434085]: 1616615136: Sending PUBACK to tidone/944282,4495427/fixed (m15, rc0)
mar 24 20:45:36 rmap8.arpaepr.local mosquitto[3434085]: 1616615136: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m16, 'report/tidone/944282,4495427/fixed/254,0,0/103,2000,-,-/B12101', ... (37 bytes))
mar 24 20:45:36 rmap8.arpaepr.local mosquitto[3434085]: 1616615136: Sending PUBACK to tidone/944282,4495427/fixed (m16, rc0)
mar 24 20:45:37 rmap8.arpaepr.local mosquitto[3434085]: 1616615137: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m17, 'report/tidone/944282,4495427/fixed/254,0,0/103,2000,-,-/B13003', ... (34 bytes))
mar 24 20:45:37 rmap8.arpaepr.local mosquitto[3434085]: 1616615137: Sending PUBACK to tidone/944282,4495427/fixed (m17, rc0)
mar 24 20:45:37 rmap8.arpaepr.local mosquitto[3434085]: 1616615137: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m18, 'report/tidone/944282,4495427/fixed/3,0,900/103,2000,-,-/B12101', ... (37 bytes))
mar 24 20:45:37 rmap8.arpaepr.local mosquitto[3434085]: 1616615137: Sending PUBACK to tidone/944282,4495427/fixed (m18, rc0)
mar 24 20:45:38 rmap8.arpaepr.local mosquitto[3434085]: 1616615138: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m19, 'report/tidone/944282,4495427/fixed/3,0,900/103,2000,-,-/B13003', ... (34 bytes))
mar 24 20:45:38 rmap8.arpaepr.local mosquitto[3434085]: 1616615138: Sending PUBACK to tidone/944282,4495427/fixed (m19, rc0)
mar 24 20:45:38 rmap8.arpaepr.local mosquitto[3434085]: 1616615138: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m20, 'report/tidone/944282,4495427/fixed/0,0,900/103,2000,-,-/B12101', ... (37 bytes))
mar 24 20:45:38 rmap8.arpaepr.local mosquitto[3434085]: 1616615138: Sending PUBACK to tidone/944282,4495427/fixed (m20, rc0)
mar 24 20:45:39 rmap8.arpaepr.local mosquitto[3434085]: 1616615139: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m21, 'report/tidone/944282,4495427/fixed/0,0,900/103,2000,-,-/B13003', ... (34 bytes))
mar 24 20:45:39 rmap8.arpaepr.local mosquitto[3434085]: 1616615139: Sending PUBACK to tidone/944282,4495427/fixed (m21, rc0)
mar 24 20:45:39 rmap8.arpaepr.local mosquitto[3434085]: 1616615139: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m22, 'report/tidone/944282,4495427/fixed/2,0,900/103,2000,-,-/B12101', ... (37 bytes))
mar 24 20:45:39 rmap8.arpaepr.local mosquitto[3434085]: 1616615139: Sending PUBACK to tidone/944282,4495427/fixed (m22, rc0)
mar 24 20:45:40 rmap8.arpaepr.local mosquitto[3434085]: 1616615140: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m23, 'report/tidone/944282,4495427/fixed/2,0,900/103,2000,-,-/B13003', ... (34 bytes))
mar 24 20:45:40 rmap8.arpaepr.local mosquitto[3434085]: 1616615140: Sending PUBACK to tidone/944282,4495427/fixed (m23, rc0)
mar 24 20:45:40 rmap8.arpaepr.local mosquitto[3434085]: 1616615140: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m24, 'report/tidone/944282,4495427/fixed/1,0,900/1,-,-,-/B13011', ... (33 bytes))
mar 24 20:45:40 rmap8.arpaepr.local mosquitto[3434085]: 1616615140: Sending PUBACK to tidone/944282,4495427/fixed (m24, rc0)
mar 24 20:45:41 rmap8.arpaepr.local mosquitto[3434085]: 1616615141: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m25, 'report/tidone/944282,4495427/fixed/1,0,900/103,2000,-,-/B13212', ... (33 bytes))
mar 24 20:45:41 rmap8.arpaepr.local mosquitto[3434085]: 1616615141: Sending PUBACK to tidone/944282,4495427/fixed (m25, rc0)
mar 24 20:45:41 rmap8.arpaepr.local mosquitto[3434085]: 1616615141: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m26, 'report/tidone/944282,4495427/fixed/254,0,0/265,1,-,-/B25025', ... (35 bytes))
mar 24 20:45:41 rmap8.arpaepr.local mosquitto[3434085]: 1616615141: Sending PUBACK to tidone/944282,4495427/fixed (m26, rc0)
mar 24 20:45:42 rmap8.arpaepr.local mosquitto[3434085]: 1616615142: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m27, 'report/tidone/944282,4495427/fixed/254,0,0/265,1,-,-/B25194', ... (35 bytes))
mar 24 20:45:42 rmap8.arpaepr.local mosquitto[3434085]: 1616615142: Sending PUBACK to tidone/944282,4495427/fixed (m27, rc0)
mar 24 20:45:42 rmap8.arpaepr.local mosquitto[3434085]: 1616615142: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m28, 'report/tidone/944282,4495427/fixed/254,0,0/265,1,-,-/B25192', ... (35 bytes))
mar 24 20:45:42 rmap8.arpaepr.local mosquitto[3434085]: 1616615142: Sending PUBACK to tidone/944282,4495427/fixed (m28, rc0)
mar 24 20:45:43 rmap8.arpaepr.local mosquitto[3434085]: 1616615143: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m29, 'report/tidone/944282,4495427/fixed/254,0,0/103,2000,-,-/B12101', ... (37 bytes))
mar 24 20:45:43 rmap8.arpaepr.local mosquitto[3434085]: 1616615143: Sending PUBACK to tidone/944282,4495427/fixed (m29, rc0)
mar 24 20:45:43 rmap8.arpaepr.local mosquitto[3434085]: 1616615143: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m30, 'report/tidone/944282,4495427/fixed/254,0,0/103,2000,-,-/B13003', ... (34 bytes))
mar 24 20:45:43 rmap8.arpaepr.local mosquitto[3434085]: 1616615143: Sending PUBACK to tidone/944282,4495427/fixed (m30, rc0)
mar 24 20:45:44 rmap8.arpaepr.local mosquitto[3434085]: 1616615144: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m31, 'report/tidone/944282,4495427/fixed/3,0,900/103,2000,-,-/B12101', ... (37 bytes))
mar 24 20:45:44 rmap8.arpaepr.local mosquitto[3434085]: 1616615144: Sending PUBACK to tidone/944282,4495427/fixed (m31, rc0)
mar 24 20:45:44 rmap8.arpaepr.local mosquitto[3434085]: 1616615144: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m32, 'report/tidone/944282,4495427/fixed/3,0,900/103,2000,-,-/B13003', ... (34 bytes))
mar 24 20:45:44 rmap8.arpaepr.local mosquitto[3434085]: 1616615144: Sending PUBACK to tidone/944282,4495427/fixed (m32, rc0)
mar 24 20:45:45 rmap8.arpaepr.local mosquitto[3434085]: 1616615145: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m33, 'report/tidone/944282,4495427/fixed/0,0,900/103,2000,-,-/B12101', ... (37 bytes))
mar 24 20:45:45 rmap8.arpaepr.local mosquitto[3434085]: 1616615145: Sending PUBACK to tidone/944282,4495427/fixed (m33, rc0)
mar 24 20:45:45 rmap8.arpaepr.local mosquitto[3434085]: 1616615145: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m34, 'report/tidone/944282,4495427/fixed/0,0,900/103,2000,-,-/B13003', ... (34 bytes))
mar 24 20:45:45 rmap8.arpaepr.local mosquitto[3434085]: 1616615145: Sending PUBACK to tidone/944282,4495427/fixed (m34, rc0)
mar 24 20:45:46 rmap8.arpaepr.local mosquitto[3434085]: 1616615146: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m35, 'report/tidone/944282,4495427/fixed/2,0,900/103,2000,-,-/B12101', ... (37 bytes))
mar 24 20:45:46 rmap8.arpaepr.local mosquitto[3434085]: 1616615146: Sending PUBACK to tidone/944282,4495427/fixed (m35, rc0)
mar 24 20:45:46 rmap8.arpaepr.local mosquitto[3434085]: 1616615146: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m36, 'report/tidone/944282,4495427/fixed/2,0,900/103,2000,-,-/B13003', ... (34 bytes))
mar 24 20:45:46 rmap8.arpaepr.local mosquitto[3434085]: 1616615146: Sending PUBACK to tidone/944282,4495427/fixed (m36, rc0)
mar 24 20:45:47 rmap8.arpaepr.local mosquitto[3434085]: 1616615147: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m37, 'report/tidone/944282,4495427/fixed/1,0,900/1,-,-,-/B13011', ... (33 bytes))
mar 24 20:45:47 rmap8.arpaepr.local mosquitto[3434085]: 1616615147: Sending PUBACK to tidone/944282,4495427/fixed (m37, rc0)
mar 24 20:45:47 rmap8.arpaepr.local mosquitto[3434085]: 1616615147: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m38, 'report/tidone/944282,4495427/fixed/1,0,900/103,2000,-,-/B13212', ... (33 bytes))
mar 24 20:45:47 rmap8.arpaepr.local mosquitto[3434085]: 1616615147: Sending PUBACK to tidone/944282,4495427/fixed (m38, rc0)
mar 24 20:45:48 rmap8.arpaepr.local mosquitto[3434085]: 1616615148: Received PUBLISH from tidone/944282,4495427/fixed (d0, q1, r0, m39, 'report/tidone/944282,4495427/fixed/254,0,0/265,1,-,-/B25025', ... (35 bytes))
mar 24 20:45:48 rmap8.arpaepr.local mosquitto[3434085]: 1616615148: Sending PUBACK to tidone/944282,4495427/fixed (m39, rc0)
mar 24 20:47:18 rmap8.arpaepr.local mosquitto[3434085]: 1616615238: Client tidone/944282,4495427/fixed has exceeded timeout, disconnecting.
pat1 commented 3 years ago

In relazione con: https://github.com/eclipse/paho.mqtt.embedded-c/issues/220

pat1 commented 3 years ago

ho testato l'aggiornamento della libreria e la nuova implementazione del timer. subscribe, publish QOS0, QOS1 e QOS2 funzionano regolarmente. Ho testato anche per un massiccio invio di messaggi con payload di 28 caratteri:

mi pare quindi tutto perfettamente funzionante e il timeout di 6sec può essere al momento un buon compromesso. Certo avere una libreria mqtt non bloccante permetterebbe di allungare il timeout e avere meno errori. Si potrebbe aggiungere un reset del watchdog all'interno della libreria, ma il tutto poi rimarrebbe bloccato per tempi troppo lunghi per un sistema che dovrebbe essere non bloccante.