search

r-map / rmap

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

firmware: NTP sometime do not work #351

Closed pat1 closed 2 years ago

pat1 commented 2 years ago

this is the log:

#Configuration received... [ OK ]
#Load configuration... [ OK ]
#--> type: report-gsm
#--> version: 3.4
#--> sensors: 6
#--> ConstantData: 2
#--> CD 0:  B01019 : test station
#--> CD 1:  B07030 : 20
#--> gsm apn: ibox.tim.it
#--> gsm username: 
#--> gsm password: 
#--> ntp server: it.pool.ntp.org
#--> mqtt server: test.rmap.cc
#--> mqtt port: 1883
#--> mqtt root topic: report/pat1/1165625,4485892/fixed/
#--> mqtt maint topic: maint/pat1/1165625,4485892/fixed/
#--> mqtt rpc topic: rpc/pat1/1165625,4485892/fixed/
#--> mqtt username: pat1

#--> 1: I2C-ITH [ 0x23 ]: 254,0,0/103,2000,-,-/  [ OK ]
#--> 2: I2C-NTH [ 0x23 ]: 3,0,900/103,2000,-,-/  [ OK ]
#--> 3: I2C-MTH [ 0x23 ]: 0,0,900/103,2000,-,-/  [ OK ]
#--> 4: I2C-XTH [ 0x23 ]: 2,0,900/103,2000,-,-/  [ OK ]
#--> 5: I2C-TBR [ 0x21 ]: 1,0,900/1,-,-,-/   [ OK ]
#--> 6: I2C-DEP [ 0x30 ]: 254,0,0/265,1,-,-/     [ OK ]
#
#SIM800 switching ON... [ OK ] [ ON ]
#SIM800 reset to factory default [ OK ]
#SIM800 echo mode off [ OK ]
#SIM800 signal [ OK ] [ rssi 13, ber 5 ]
#SIM800 network registered... [ OK ]
#SIM800 setup... [ OK ]
#SIM800 GPRS attach... [ OK ] [ YES ]
#SIM800 single IP mode... [ OK ]
#SIM800 switch to data mode... [ OK ]
#SIM800 transparent mode... [ OK ]
#SIM800 set APN, username and password... [ OK ]
#SIM800 setting up connection... [ OK ]
#SIM800 IP... [ OK ] [ 10.72.137.73 ]
#SIM800 start connection... [ OK ]
#SIM800 UDP status... [ OK ] [ CONNECT ]
#Current date and time is: 01/01/1970 00:00:35

#Acquisition scheduling...
#--> observations every 1 minutes
#--> report every 3 minutes
#--> starting at: 00:03:00
#--> testing at: 00:01:00

#SIM800 stop connection... [ OK ]
#SIM800 PDP close... [ OK ]
#SIM800 detach GPRS... [ OK ]
#SIM800 stop connection... [ OK ]
#SIM800 switching OFF... [ OK ] [ OFF ]
#Sensors reading...
#Sensors reading...
#Next acquisition scheduled at: 00:06:00
#Sensors reading...
#Restart I2C BUS
#Sensors reading...
#Sensors reading...
#Restart I2C BUS
#Next acquisition scheduled at: 00:09:00
#Sensors reading...
#[ 12 ] data stored in sdcard... [ OK ]
#SIM800 switching ON... [ OK ] [ ON ]
#SIM800 reset to factory default [ OK ]
#SIM800 echo mode off [ OK ]
#SIM800 signal [ OK ] [ rssi 14, ber 0 ]
#SIM800 network registered... [ OK ]
#SIM800 setup... [ OK ]
#SIM800 GPRS attach... [ OK ] [ NO ]
#SIM800 attach GPRS... [ OK ]
#SIM800 single IP mode... [ OK ]
#SIM800 switch to data mode... [ OK ]
#SIM800 transparent mode... [ OK ]
#SIM800 set APN, username and password... [ OK ]
#SIM800 setting up connection... [ OK ]
#SIM800 IP... [ OK ] [ 10.187.111.131 ]
#SIM800 start connection... [ OK ]
#file rpc_ptr.txt do not exists
#Data pointer... [ FIND ]
#1970_01_01.txt... [ FOUND ]
#Data pointer... [ 01/01/1970 00:00:00 ] [ OK ]
#SIM800 TCP status... [ OK ] [ CONNECT ]
#Data pointer... [ 01/01/1970 00:30:01 ] [ UPDATE ]
#[ 12 ] data published through mqtt... [ OK ]
#SIM800 stop connection... [ OK ]
#SIM800 PDP close... [ OK ]
#SIM800 detach GPRS... [ OK ]
#SIM800 stop connection... [ OK ]
#SIM800 switching OFF... [ OK ] [ OFF ]
#Sensors reading...
#Sensors reading...
#Restart I2C BUS
#Next acquisition scheduled at: 00:12:00
#Sensors reading...
#[ 12 ] data stored in sdcard... [ OK ]
#SIM800 switching ON... [ OK ] [ ON ]
#SIM800 reset to factory default [ OK ]
#SIM800 echo mode off [ OK ]
#SIM800 signal [ OK ] [ rssi 13, ber 0 ]
#SIM800 network registered... [ OK ]
#SIM800 setup... [ OK ]
#SIM800 GPRS attach... [ OK ] [ NO ]
#SIM800 attach GPRS... [ OK ]
#SIM800 single IP mode... [ OK ]
#SIM800 switch to data mode... [ OK ]
#SIM800 transparent mode... [ OK ]
#SIM800 set APN, username and password... [ OK ]
#SIM800 setting up connection... [ OK ]
#SIM800 IP... [ OK ] [ 10.187.14.99 ]
#SIM800 start connection... [ OK ]
#file rpc_ptr.txt do not exists
#Data pointer... [ FIND ]
#1970_01_01.txt... [ FOUND ]
#Data pointer... [ 01/01/1970 00:00:00 ] [ OK ]
pat1 commented 2 years ago

other detailed log:

#
#Requested NTP time sync...
#SUPERVISOR_INIT ---> SUPERVISOR_CONNECTION_LEVEL_TASK
#SUPERVISOR_CONNECTION_LEVEL_TASK ---> SUPERVISOR_WAIT_CONNECTION_LEVEL_TASK
#SIM800 switching ON... [ OK ] [ ON ]
#SIM800 reset to factory default [ OK ]
#SIM800 echo mode off [ OK ]
#SIM800 signal [ OK ] [ rssi 10, ber 0 ]
#SIM800 searching network...
#SIM800 network registered... [ OK ]
#SIM800 setup... [ OK ]
#SIM800 GPRS attach... [ OK ] [ YES ]
#SIM800 single IP mode... [ OK ]
#SIM800 switch to data mode... [ OK ]
#SIM800 transparent mode... [ OK ]
#SIM800 set APN, username and password... [ OK ]
#SIM800 setting up connection... [ OK ]
#SIM800 IP... [ OK ] [ 10.187.98.91 ]
#SIM800 start connection... [ OK ]
#SIM800 UDP status... [ OK ] [ CONNECT ]
#SUPERVISOR_WAIT_CONNECTION_LEVEL_TASK ---> SUPERVISOR_TIME_LEVEL_TASK
#TIME_INIT --> TIME_SEND_ONLINE_REQUEST
#TIME_SEND_ONLINE_REQUEST --> TIME_WAIT_ONLINE_RESPONSE
#TIME_WAIT_ONLINE_RESPONSE --> TIME_WAIT_STATE
#TIME_WAIT_ONLINE_RESPONSE --> TIME_WAIT_STATE
#TIME_WAIT_ONLINE_RESPONSE --> TIME_WAIT_STATE
#TIME_WAIT_ONLINE_RESPONSE --> TIME_WAIT_STATE
#TIME_WAIT_ONLINE_RESPONSE --> TIME_SET_SYNC_RTC_PROVIDER
#Current System date and time: 01/01/1970 00:00:40
#TIME_SET_SYNC_RTC_PROVIDER --> TIME_END
#TIME_END --> TIME_INIT
#SUPERVISOR_TIME_LEVEL_TASK ---> SUPERVISOR_MANAGE_LEVEL_TASK
#Current date and time is: 01/01/1970 00:00:40

#Acquisition scheduling...
#--> observations every 1 minutes
#--> report every 3 minutes
#--> starting at: 00:03:00
#--> testing at: 00:01:00

#SUPERVISOR_MANAGE_LEVEL_TASK ---> SUPERVISOR_END

that cause:

#DATA_SAVING_INIT ---> DATA_SAVING_OPEN_SDCARD
#SENSORS_READING_END ---> SENSORS_READING_INIT
#DATA_SAVING_OPEN_SDCARD ---> DATA_SAVING_OPEN_FILE
#DATA_SAVING_OPEN_FILE ---> DATA_SAVING_SENSORS_LOOP
#DATA_SAVING_SENSORS_LOOP ---> DATA_SAVING_DATA_LOOP
#DATA_SAVING_DATA_LOOP ---> DATA_SAVING_WRITE_FILE
#SD <-- 254,0,0/103,2000,-,-/B12101 {"v":null,"t":"1970-01-01T00:06:00"}
#DATA_SAVING_WRITE_FILE ---> DATA_SAVING_DATA_LOOP
#DATA_SAVING_DATA_LOOP ---> DATA_SAVING_WRITE_FILE
#SD <-- 254,0,0/103,2000,-,-/B13003 {"v":null,"t":"1970-01-01T00:06:00"}
#DATA_SAVING_WRITE_FILE ---> DATA_SAVING_DATA_LOOP
#DATA_SAVING_DATA_LOOP ---> DATA_SAVING_SENSORS_LOOP
#DATA_SAVING_SENSORS_LOOP ---> DATA_SAVING_DATA_LOOP
#DATA_SAVING_DATA_LOOP ---> DATA_SAVING_WRITE_FILE
#SD <-- 3,0,900/103,2000,-,-/B12101 {"v":null,"t":"1970-01-01T00:06:00"}
#DATA_SAVING_WRITE_FILE ---> DATA_SAVING_DATA_LOOP
#DATA_SAVING_DATA_LOOP ---> DATA_SAVING_WRITE_FILE
#SD <-- 3,0,900/103,2000,-,-/B13003 {"v":null,"t":"1970-01-01T00:06:00"}
#DATA_SAVING_WRITE_FILE ---> DATA_SAVING_DATA_LOOP
#DATA_SAVING_DATA_LOOP ---> DATA_SAVING_SENSORS_LOOP
#DATA_SAVING_SENSORS_LOOP ---> DATA_SAVING_DATA_LOOP
#DATA_SAVING_DATA_LOOP ---> DATA_SAVING_WRITE_FILE
#SD <-- 0,0,900/103,2000,-,-/B12101 {"v":null,"t":"1970-01-01T00:06:00"}
#DATA_SAVING_WRITE_FILE ---> DATA_SAVING_DATA_LOOP
#DATA_SAVING_DATA_LOOP ---> DATA_SAVING_WRITE_FILE
#SD <-- 0,0,900/103,2000,-,-/B13003 {"v":null,"t":"1970-01-01T00:06:00"}
#DATA_SAVING_WRITE_FILE ---> DATA_SAVING_DATA_LOOP
#DATA_SAVING_DATA_LOOP ---> DATA_SAVING_SENSORS_LOOP
#DATA_SAVING_SENSORS_LOOP ---> DATA_SAVING_DATA_LOOP
#DATA_SAVING_DATA_LOOP ---> DATA_SAVING_WRITE_FILE
#SD <-- 2,0,900/103,2000,-,-/B12101 {"v":null,"t":"1970-01-01T00:06:00"}
#DATA_SAVING_WRITE_FILE ---> DATA_SAVING_DATA_LOOP
#DATA_SAVING_DATA_LOOP ---> DATA_SAVING_WRITE_FILE
#SD <-- 2,0,900/103,2000,-,-/B13003 {"v":null,"t":"1970-01-01T00:06:00"}
#DATA_SAVING_WRITE_FILE ---> DATA_SAVING_DATA_LOOP
#DATA_SAVING_DATA_LOOP ---> DATA_SAVING_SENSORS_LOOP
#DATA_SAVING_SENSORS_LOOP ---> DATA_SAVING_DATA_LOOP
#DATA_SAVING_DATA_LOOP ---> DATA_SAVING_WRITE_FILE
#SD <-- 1,0,900/1,-,-,-/B13011 {"v":0,"t":"1970-01-01T00:06:00"}
#DATA_SAVING_WRITE_FILE ---> DATA_SAVING_DATA_LOOP
#DATA_SAVING_DATA_LOOP ---> DATA_SAVING_SENSORS_LOOP
#DATA_SAVING_SENSORS_LOOP ---> DATA_SAVING_DATA_LOOP
#DATA_SAVING_DATA_LOOP ---> DATA_SAVING_WRITE_FILE
#SD <-- 254,0,0/265,1,-,-/B25192 {"v":null,"t":"1970-01-01T00:06:00"}
#DATA_SAVING_WRITE_FILE ---> DATA_SAVING_DATA_LOOP
#DATA_SAVING_DATA_LOOP ---> DATA_SAVING_WRITE_FILE
#SD <-- 254,0,0/265,1,-,-/B25025 {"v":null,"t":"1970-01-01T00:06:00"}
#DATA_SAVING_WRITE_FILE ---> DATA_SAVING_DATA_LOOP
#DATA_SAVING_DATA_LOOP ---> DATA_SAVING_WRITE_FILE
#SD <-- 254,0,0/265,1,-,-/B25194 {"v":null,"t":"1970-01-01T00:06:00"}
#DATA_SAVING_WRITE_FILE ---> DATA_SAVING_DATA_LOOP
#DATA_SAVING_DATA_LOOP ---> DATA_SAVING_SENSORS_LOOP
#
#DATA_SAVING_SENSORS_LOOP ---> DATA_SAVING_CLOSE_FILE
#DATA_SAVING_CLOSE_FILE ---> DATA_SAVING_END
#[ 12 ] data stored in sdcard... [ OK ]
#DATA_SAVING_END ---> DATA_SAVING_INIT
pat1 commented 2 years ago

Replicate the bug is very simple: Set a fake ntp server and you get the station working with wrong date and time.

#1970-01-01T00:00:01 N: Configuration received... [ OK ]
#1970-01-01T00:00:01 N: Load configuration... [ OK ]
#1970-01-01T00:00:01 N: --> type: report-gsm
#1970-01-01T00:00:01 N: --> version: 3.5
#1970-01-01T00:00:01 N: --> sensors: 6
#1970-01-01T00:00:01 N: --> ConstantData: 2
#1970-01-01T00:00:01 N: --> CD 0:  B01019 : new station
#1970-01-01T00:00:01 N: --> CD 1:  B07030 : 20
#1970-01-01T00:00:01 N: --> gsm apn: ibox.tim.it
#1970-01-01T00:00:01 N: --> gsm username: 
#1970-01-01T00:00:01 N: --> gsm password: 
#1970-01-01T00:00:01 N: --> ntp server: rmap.cc
#1970-01-01T00:00:01 N: --> mqtt server: test.rmap.cc
#1970-01-01T00:00:01 N: --> mqtt port: 1883
#1970-01-01T00:00:01 N: --> mqtt root topic: report/pat1/1165625,4485892/fixed/
#1970-01-01T00:00:01 N: --> mqtt maint topic: maint/pat1/1165625,4485892/fixed/
#1970-01-01T00:00:01 N: --> mqtt rpc topic: rpc/pat1/1165625,4485892/fixed/
#1970-01-01T00:00:01 N: --> mqtt username: pat1
#1970-01-01T00:00:01 N: --> mqtt password: 1password
#1970-01-01T00:00:01 N: --> 1: I2C-ITH [ 0x23 ]: 254,0,0/103,2000,-,-/   [ OK ]
#1970-01-01T00:00:01 N: --> 2: I2C-NTH [ 0x23 ]: 3,0,900/103,2000,-,-/   [ OK ]
#1970-01-01T00:00:01 N: --> 3: I2C-MTH [ 0x23 ]: 0,0,900/103,2000,-,-/   [ OK ]
#1970-01-01T00:00:01 N: --> 4: I2C-XTH [ 0x23 ]: 2,0,900/103,2000,-,-/   [ OK ]
#1970-01-01T00:00:01 N: --> 5: I2C-TBR [ 0x21 ]: 1,0,900/1,-,-,-/    [ OK ]
#1970-01-01T00:00:01 N: --> 6: I2C-DEP [ 0x30 ]: 254,0,0/265,1,-,-/  [ OK ]
#1970-01-01T00:00:09 N: SIM800 switching ON... [ OK ] [ ON ]
#1970-01-01T00:00:12 N: SIM800 reset to factory default [ OK ]
#1970-01-01T00:00:17 N: SIM800 echo mode off [ OK ]
#1970-01-01T00:00:21 N: SIM800 signal [ OK ] [ rssi 12, ber 0 ]
#1970-01-01T00:00:21 N: SIM800 network registered... [ OK ]
#1970-01-01T00:00:21 N: SIM800 setup... [ OK ]
#1970-01-01T00:00:21 N: SIM800 GPRS attach... [ OK ] [ NO ]
#1970-01-01T00:00:27 N: SIM800 attach GPRS... [ OK ]
#1970-01-01T00:00:27 N: SIM800 single IP mode... [ OK ]
#1970-01-01T00:00:28 N: SIM800 switch to data mode... [ OK ]
#1970-01-01T00:00:28 N: SIM800 transparent mode... [ OK ]
#1970-01-01T00:00:28 N: SIM800 set APN, username and password... [ OK ]
#1970-01-01T00:00:28 N: SIM800 setting up connection... [ OK ]
#1970-01-01T00:00:32 N: SIM800 IP... [ OK ] [ 10.187.88.64 ]
#1970-01-01T00:00:32 N: SIM800 start connection... [ OK ]
#1970-01-01T00:00:35 N: SIM800 UDP status... [ OK ] [ CONNECT ]
#1970-01-01T00:01:05 N: Current date and time is: 1/1/1970 0:1:5
#1970-01-01T00:01:05 N: Acquisition scheduling...
#1970-01-01T00:01:05 N: --> observations every 1 minutes
#1970-01-01T00:01:05 N: --> report every 3 minutes
#1970-01-01T00:01:05 N: --> starting at: 0:3:0
#1970-01-01T00:01:06 N: --> testing at: 0:2:0
#1970-01-01T00:01:06 E: SD Card... [ FAIL ]
#1970-01-01T00:01:06 E: --> is card inserted?
#1970-01-01T00:01:06 E: --> there is a valid FAT32 filesystem?
#1970-01-01T00:01:09 N: SIM800 stop connection... [ OK ]
#1970-01-01T00:01:10 N: SIM800 PDP close... [ OK ]
#1970-01-01T00:01:10 N: SIM800 detach GPRS... [ OK ]
#1970-01-01T00:01:10 N: SIM800 stop connection... [ OK ]
#1970-01-01T00:01:15 N: SIM800 switching OFF... [ OK ] [ OFF ]
#1970-01-01T00:02:00 N: Sensors reading...

The station cannot work without a correct date and time so I suggest at boot time in supervisor_task:

We have to check we do not have problems in time_task too.

pat1 commented 2 years ago

logging with;

define NTP_TIME_FOR_RESYNC_S (900)

in condition where the NTP server works for the first query and d o not work for the second

logging with more logging messages about NTP

I observe that the retry is only for the response and not for the request ...

#1970-01-01T00:00:01 N: Configuration received... [ OK ]
#1970-01-01T00:00:01 N: Load configuration... [ OK ]
#1970-01-01T00:00:01 N: --> type: report-gsm
#1970-01-01T00:00:01 N: --> version: 3.5
#1970-01-01T00:00:01 N: --> sensors: 6
#1970-01-01T00:00:01 N: --> ConstantData: 2
#1970-01-01T00:00:01 N: --> CD 0:  B01019 : new station
#1970-01-01T00:00:01 N: --> CD 1:  B07030 : 20
#1970-01-01T00:00:01 N: --> gsm apn: ibox.tim.it
#1970-01-01T00:00:01 N: --> gsm username: 
#1970-01-01T00:00:01 N: --> gsm password: 
#1970-01-01T00:00:01 N: --> ntp server: it.pool.ntp.org
#1970-01-01T00:00:01 N: --> mqtt server: test.rmap.cc
#1970-01-01T00:00:01 N: --> mqtt port: 1883
#1970-01-01T00:00:01 N: --> mqtt root topic: report/pat1/1165625,4485892/fixed/
#1970-01-01T00:00:01 N: --> mqtt maint topic: maint/pat1/1165625,4485892/fixed/
#1970-01-01T00:00:01 N: --> mqtt rpc topic: rpc/pat1/1165625,4485892/fixed/
#1970-01-01T00:00:01 N: --> mqtt username: pat1
#1970-01-01T00:00:01 N: --> mqtt password: 1password
#1970-01-01T00:00:01 N: --> 1: I2C-ITH [ 0x23 ]: 254,0,0/103,2000,-,-/   [ OK ]
#1970-01-01T00:00:01 N: --> 2: I2C-NTH [ 0x23 ]: 3,0,900/103,2000,-,-/   [ OK ]
#1970-01-01T00:00:01 N: --> 3: I2C-MTH [ 0x23 ]: 0,0,900/103,2000,-,-/   [ OK ]
#1970-01-01T00:00:01 N: --> 4: I2C-XTH [ 0x23 ]: 2,0,900/103,2000,-,-/   [ OK ]
#1970-01-01T00:00:01 N: --> 5: I2C-TBR [ 0x21 ]: 1,0,900/1,-,-,-/    [ OK ]
#1970-01-01T00:00:01 N: --> 6: I2C-DEP [ 0x30 ]: 254,0,0/265,1,-,-/  [ OK ]
#1970-01-01T00:00:04 N: SIM800 switching ON... [ OK ] [ ON ]
#1970-01-01T00:00:08 N: SIM800 reset to factory default [ OK ]
#1970-01-01T00:00:13 N: SIM800 echo mode off [ OK ]
#1970-01-01T00:00:16 N: SIM800 signal [ OK ] [ rssi 12, ber 0 ]
#1970-01-01T00:00:16 N: SIM800 network registered... [ OK ]
#1970-01-01T00:00:16 N: SIM800 setup... [ OK ]
#1970-01-01T00:00:16 N: SIM800 GPRS attach... [ OK ] [ NO ]
#1970-01-01T00:00:22 N: SIM800 attach GPRS... [ OK ]
#1970-01-01T00:00:22 N: SIM800 single IP mode... [ OK ]
#1970-01-01T00:00:22 N: SIM800 switch to data mode... [ OK ]
#1970-01-01T00:00:22 N: SIM800 transparent mode... [ OK ]
#1970-01-01T00:00:22 N: SIM800 set APN, username and password... [ OK ]
#1970-01-01T00:00:23 N: SIM800 setting up connection... [ OK ]
#1970-01-01T00:00:26 N: SIM800 IP... [ OK ] [ 10.72.120.131 ]
#1970-01-01T00:00:26 N: SIM800 start connection... [ OK ]
#1970-01-01T00:00:31 N: SIM800 UDP status... [ OK ] [ CONNECT ]
#1970-01-01T00:00:31 N: NTP send request
#1970-01-01T00:00:31 N: NTP send request success
#1970-01-01T00:00:31 N: NTP receive response
#1970-01-01T00:00:31 N: NTP receive response success
#2021-11-16T14:43:57 N: RTC set... [ OK ]
#2021-11-16T14:43:57 N: Current System date and time: 16/11/2021 14:43:57
#2021-11-16T14:43:57 N: Current date and time is: 16/11/2021 14:43:57
#2021-11-16T14:43:57 N: Acquisition scheduling...
#2021-11-16T14:43:57 N: --> observations every 1 minutes
#2021-11-16T14:43:57 N: --> report every 3 minutes
#2021-11-16T14:43:57 N: --> starting at: 14:45:0
#2021-11-16T14:43:57 N: --> testing at: 14:44:0
#2021-11-16T14:43:57 N: sdcard opened
#2021-11-16T14:44:00 N: Sensors reading...
#2021-11-16T14:44:00 N: SIM800 stop connection... [ OK ]
#2021-11-16T14:44:01 N: SIM800 PDP close... [ OK ]
#2021-11-16T14:44:01 N: SIM800 detach GPRS... [ OK ]
#2021-11-16T14:44:01 N: SIM800 stop connection... [ OK ]
#2021-11-16T14:44:06 N: SIM800 switching OFF... [ OK ] [ OFF ]
#2021-11-16T14:45:00 N: Next acquisition scheduled at: 14:48:0
#2021-11-16T14:45:00 N: Sensors reading...
#2021-11-16T14:46:00 N: Sensors reading...
#2021-11-16T14:46:00 E: Restart I2C BUS
#2021-11-16T14:47:00 N: Sensors reading...
#2021-11-16T14:48:00 N: Next acquisition scheduled at: 14:51:0
#2021-11-16T14:48:00 N: Sensors reading...
#2021-11-16T14:48:00 E: Restart I2C BUS
#2021-11-16T14:48:00 N: [ 12 ] data stored in sdcard... [ OK ]
#2021-11-16T14:48:03 N: SIM800 switching ON... [ OK ] [ ON ]
#2021-11-16T14:48:07 N: SIM800 reset to factory default [ OK ]
#2021-11-16T14:48:12 N: SIM800 echo mode off [ OK ]
#2021-11-16T14:48:15 N: SIM800 signal [ OK ] [ rssi 10, ber 5 ]
#2021-11-16T14:48:16 N: SIM800 network registered... [ OK ]
#2021-11-16T14:48:16 N: SIM800 setup... [ OK ]
#2021-11-16T14:48:16 N: SIM800 GPRS attach... [ OK ] [ NO ]
#2021-11-16T14:48:22 N: SIM800 attach GPRS... [ OK ]
#2021-11-16T14:48:22 N: SIM800 single IP mode... [ OK ]
#2021-11-16T14:48:22 N: SIM800 switch to data mode... [ OK ]
#2021-11-16T14:48:22 N: SIM800 transparent mode... [ OK ]
#2021-11-16T14:48:23 N: SIM800 set APN, username and password... [ OK ]
#2021-11-16T14:48:23 N: SIM800 setting up connection... [ OK ]
#2021-11-16T14:48:26 N: SIM800 IP... [ OK ] [ 10.187.141.253 ]
#2021-11-16T14:48:26 N: SIM800 start connection... [ OK ]
#2021-11-16T14:48:26 N: file rpc_ptr.txt do not exists
#2021-11-16T14:48:26 N: Data pointer... [ 16/11/2021 14:24:1 ] [ OK ]
#2021-11-16T14:48:30 N: SIM800 TCP status... [ OK ] [ CONNECT ]
#2021-11-16T14:48:46 N: Data pointer... [ 16/11/2021 14:48:1 ] [ UPDATE ]
#2021-11-16T14:48:46 N: [ 24 ] data published through mqtt... [ OK ]
#2021-11-16T14:48:50 N: SIM800 stop connection... [ OK ]
#2021-11-16T14:48:52 N: SIM800 PDP close... [ OK ]
#2021-11-16T14:48:52 N: SIM800 detach GPRS... [ OK ]
#2021-11-16T14:48:52 N: SIM800 stop connection... [ OK ]
#2021-11-16T14:48:57 N: SIM800 switching OFF... [ OK ] [ OFF ]
#2021-11-16T14:49:00 N: Sensors reading...
#2021-11-16T14:50:00 N: Sensors reading...
#2021-11-16T14:51:00 N: Next acquisition scheduled at: 14:54:0
#2021-11-16T14:51:00 N: Sensors reading...
#2021-11-16T14:51:00 E: Restart I2C BUS
#2021-11-16T14:51:00 N: sdcard opened
#2021-11-16T14:51:00 N: [ 12 ] data stored in sdcard... [ OK ]
#2021-11-16T14:51:03 N: SIM800 switching ON... [ OK ] [ ON ]
#2021-11-16T14:51:07 N: SIM800 reset to factory default [ OK ]
#2021-11-16T14:51:12 N: SIM800 echo mode off [ OK ]
#2021-11-16T14:51:15 N: SIM800 signal [ OK ] [ rssi 12, ber 0 ]
#2021-11-16T14:51:15 N: SIM800 network registered... [ OK ]
#2021-11-16T14:51:15 N: SIM800 setup... [ OK ]
#2021-11-16T14:51:16 N: SIM800 GPRS attach... [ OK ] [ NO ]
#2021-11-16T14:51:21 N: SIM800 attach GPRS... [ OK ]
#2021-11-16T14:51:21 N: SIM800 single IP mode... [ OK ]
#2021-11-16T14:51:21 N: SIM800 switch to data mode... [ OK ]
#2021-11-16T14:51:22 N: SIM800 transparent mode... [ OK ]
#2021-11-16T14:51:22 N: SIM800 set APN, username and password... [ OK ]
#2021-11-16T14:51:22 N: SIM800 setting up connection... [ OK ]
#2021-11-16T14:51:26 N: SIM800 IP... [ OK ] [ 10.187.62.8 ]
#2021-11-16T14:51:26 N: SIM800 start connection... [ OK ]
#2021-11-16T14:51:26 N: file rpc_ptr.txt do not exists
#2021-11-16T14:51:26 N: Data pointer... [ 16/11/2021 14:48:1 ] [ OK ]
#2021-11-16T14:51:29 N: SIM800 TCP status... [ OK ] [ CONNECT ]
#2021-11-16T14:51:42 N: Data pointer... [ 16/11/2021 14:51:1 ] [ UPDATE ]
#2021-11-16T14:51:42 N: [ 12 ] data published through mqtt... [ OK ]
#2021-11-16T14:51:45 N: SIM800 stop connection... [ OK ]
#2021-11-16T14:51:46 N: SIM800 PDP close... [ OK ]
#2021-11-16T14:51:47 N: SIM800 detach GPRS... [ OK ]
#2021-11-16T14:51:47 N: SIM800 stop connection... [ OK ]
#2021-11-16T14:51:51 N: SIM800 switching OFF... [ OK ] [ OFF ]
#2021-11-16T14:52:00 N: Sensors reading...
#2021-11-16T14:53:00 N: Sensors reading...
#2021-11-16T14:53:00 E: Restart I2C BUS
#2021-11-16T14:54:00 N: Next acquisition scheduled at: 14:57:0
#2021-11-16T14:54:00 N: Sensors reading...
#2021-11-16T14:54:00 N: sdcard opened
#2021-11-16T14:54:00 N: [ 12 ] data stored in sdcard... [ OK ]
#2021-11-16T14:54:03 N: SIM800 switching ON... [ OK ] [ ON ]
#2021-11-16T14:54:07 N: SIM800 reset to factory default [ OK ]
#2021-11-16T14:54:12 N: SIM800 echo mode off [ OK ]
#2021-11-16T14:54:15 N: SIM800 signal [ OK ] [ rssi 12, ber 0 ]
#2021-11-16T14:54:15 N: SIM800 network registered... [ OK ]
#2021-11-16T14:54:15 N: SIM800 setup... [ OK ]
#2021-11-16T14:54:16 N: SIM800 GPRS attach... [ OK ] [ NO ]
#2021-11-16T14:54:22 N: SIM800 attach GPRS... [ OK ]
#2021-11-16T14:54:22 N: SIM800 single IP mode... [ OK ]
#2021-11-16T14:54:22 N: SIM800 switch to data mode... [ OK ]
#2021-11-16T14:54:22 N: SIM800 transparent mode... [ OK ]
#2021-11-16T14:54:23 N: SIM800 set APN, username and password... [ OK ]
#2021-11-16T14:54:23 N: SIM800 setting up connection... [ OK ]
#2021-11-16T14:54:26 N: SIM800 IP... [ OK ] [ 10.72.136.166 ]
#2021-11-16T14:54:26 N: SIM800 start connection... [ OK ]
#2021-11-16T14:54:26 N: file rpc_ptr.txt do not exists
#2021-11-16T14:54:26 N: Data pointer... [ 16/11/2021 14:51:1 ] [ OK ]
#2021-11-16T14:54:30 N: SIM800 TCP status... [ OK ] [ CONNECT ]
#2021-11-16T14:54:40 N: Data pointer... [ 16/11/2021 14:54:1 ] [ UPDATE ]
#2021-11-16T14:54:40 N: [ 12 ] data published through mqtt... [ OK ]
#2021-11-16T14:54:44 N: SIM800 stop connection... [ OK ]
#2021-11-16T14:54:45 N: SIM800 PDP close... [ OK ]
#2021-11-16T14:54:46 N: SIM800 detach GPRS... [ OK ]
#2021-11-16T14:54:46 N: SIM800 stop connection... [ OK ]
#2021-11-16T14:54:50 N: SIM800 switching OFF... [ OK ] [ OFF ]
#2021-11-16T14:55:00 N: Sensors reading...
#2021-11-16T14:56:00 N: Sensors reading...
#2021-11-16T14:56:00 E: Restart I2C BUS
#2021-11-16T14:57:00 N: Next acquisition scheduled at: 15:0:0
#2021-11-16T14:57:00 N: Sensors reading...
#2021-11-16T14:57:00 N: sdcard opened
#2021-11-16T14:57:00 N: [ 12 ] data stored in sdcard... [ OK ]
#2021-11-16T14:57:03 N: SIM800 switching ON... [ OK ] [ ON ]
#2021-11-16T14:57:07 N: SIM800 reset to factory default [ OK ]
#2021-11-16T14:57:12 N: SIM800 echo mode off [ OK ]
#2021-11-16T14:57:15 N: SIM800 signal [ OK ] [ rssi 12, ber 3 ]
#2021-11-16T14:57:15 N: SIM800 network registered... [ OK ]
#2021-11-16T14:57:15 N: SIM800 setup... [ OK ]
#2021-11-16T14:57:16 N: SIM800 GPRS attach... [ OK ] [ YES ]
#2021-11-16T14:57:16 N: SIM800 single IP mode... [ OK ]
#2021-11-16T14:57:16 N: SIM800 switch to data mode... [ OK ]
#2021-11-16T14:57:16 N: SIM800 transparent mode... [ OK ]
#2021-11-16T14:57:17 N: SIM800 set APN, username and password... [ OK ]
#2021-11-16T14:57:17 N: SIM800 setting up connection... [ OK ]
#2021-11-16T14:57:21 N: SIM800 IP... [ OK ] [ 10.72.58.201 ]
#2021-11-16T14:57:21 N: SIM800 start connection... [ OK ]
#2021-11-16T14:57:21 N: file rpc_ptr.txt do not exists
#2021-11-16T14:57:21 N: Data pointer... [ 16/11/2021 14:54:1 ] [ OK ]
#2021-11-16T14:57:24 N: SIM800 TCP status... [ OK ] [ CONNECT ]
#2021-11-16T14:57:34 N: Data pointer... [ 16/11/2021 14:57:1 ] [ UPDATE ]
#2021-11-16T14:57:34 N: [ 12 ] data published through mqtt... [ OK ]
#2021-11-16T14:57:38 N: SIM800 stop connection... [ OK ]
#2021-11-16T14:57:39 N: SIM800 PDP close... [ OK ]
#2021-11-16T14:57:39 N: SIM800 detach GPRS... [ OK ]
#2021-11-16T14:57:39 N: SIM800 stop connection... [ OK ]
#2021-11-16T14:57:43 N: SIM800 switching OFF... [ OK ] [ OFF ]
#2021-11-16T14:58:00 N: Sensors reading...
#2021-11-16T14:58:00 E: Restart I2C BUS
#2021-11-16T14:59:00 N: Sensors reading...
#2021-11-16T15:00:00 N: Next acquisition scheduled at: 15:3:0
#2021-11-16T15:00:00 N: Sensors reading...
#2021-11-16T15:00:00 E: Restart I2C BUS
#2021-11-16T15:00:00 N: sdcard opened
#2021-11-16T15:00:00 N: [ 12 ] data stored in sdcard... [ OK ]
#2021-11-16T15:00:03 N: SIM800 switching ON... [ OK ] [ ON ]
#2021-11-16T15:00:07 N: SIM800 reset to factory default [ OK ]
#2021-11-16T15:00:12 N: SIM800 echo mode off [ OK ]
#2021-11-16T15:00:15 N: SIM800 signal [ OK ] [ rssi 11, ber 0 ]
#2021-11-16T15:00:16 N: SIM800 network registered... [ OK ]
#2021-11-16T15:00:16 N: SIM800 setup... [ OK ]
#2021-11-16T15:00:16 N: SIM800 GPRS attach... [ OK ] [ NO ]
#2021-11-16T15:00:21 N: SIM800 attach GPRS... [ OK ]
#2021-11-16T15:00:21 N: SIM800 single IP mode... [ OK ]
#2021-11-16T15:00:21 N: SIM800 switch to data mode... [ OK ]
#2021-11-16T15:00:22 N: SIM800 transparent mode... [ OK ]
#2021-11-16T15:00:22 N: SIM800 set APN, username and password... [ OK ]
#2021-11-16T15:00:22 N: SIM800 setting up connection... [ OK ]
#2021-11-16T15:00:26 N: SIM800 IP... [ OK ] [ 10.72.134.185 ]
#2021-11-16T15:00:26 N: SIM800 start connection... [ OK ]
#2021-11-16T15:00:29 N: SIM800 UDP status... [ OK ] [ CONNECT ]
#2021-11-16T15:00:29 N: NTP send request
#2021-11-16T15:00:29 N: NTP send request success
#2021-11-16T15:00:29 N: NTP receive response
#2021-11-16T15:00:35 N: NTP receive response
#2021-11-16T15:00:40 N: NTP receive response
#2021-11-16T15:00:46 N: NTP receive response
#2021-11-16T15:00:51 N: NTP receive response
#2021-11-16T15:00:57 E: NTP response... [ FAIL ]
#2021-11-16T15:00:57 N: Current System date and time: 16/11/2021 15:0:57
#2021-11-16T15:00:57 N: Current date and time is: 16/11/2021 15:0:57
#2021-11-16T15:01:00 N: Sensors reading...
#2021-11-16T15:01:00 N: SIM800 stop connection... [ OK ]
#2021-11-16T15:01:01 N: SIM800 PDP close... [ OK ]
#2021-11-16T15:01:01 N: SIM800 detach GPRS... [ OK ]
#2021-11-16T15:01:01 N: SIM800 stop connection... [ OK ]
#2021-11-16T15:01:06 N: SIM800 switching OFF... [ OK ] [ OFF ]
#2021-11-16T15:02:00 N: Sensors reading...
#2021-11-16T15:03:00 N: Next acquisition scheduled at: 15:6:0
#2021-11-16T15:03:00 N: Sensors reading...
#2021-11-16T15:03:00 E: Restart I2C BUS
pat1 commented 2 years ago

I suggest this solution: