search

srcfl / srcful-gateway

Srcful energy gateway to connect your solar inverter and mine src-token
https://srcful.io
MIT License
5 stars 2 forks source link

Dual-mining - Downlink Packet Rejection Due to Timestamp Errors #202

Closed davmoz closed 1 month ago

davmoz commented 3 months ago

Downlink packets are being rejected due to timestamp errors. The packet-forwarder logs indicate that packets are being rejected because the timestamp is "too much in advance." This issue is causing downlink failures and needs to be investigated and resolved.

I am not sure if this is consistent over all downlinks. 

packet-forwarder-1  | INFO: [up] payload (29 bytes): 40C501004881DE000201CB90E875991094C11BA6F8D19483C0408351B4
packet-forwarder-1  | INFO: [up] pkt from mote: 0x480001C5 (netid=0x000024, fcnt=222)
packet-forwarder-1  | 
packet-forwarder-1  | JSON up: {"rxpk":[{"jver":1,"tmst":54934578,"chan":0,"rfch":1,"freq":868.100000,"mid": 8,"stat":1,"modu":"LORA","datr":"SF7BW125","codr":"4/5","rssis":-31,"lsnr":13.5,"foff":2343,"rssi":-30,"size":29,"data":"QMUBAEiB3gACAcuQ6HWZEJTBG6b40ZSDwECDUbQ="}]}
gateway-rs-1        | 2024-06-15T22:38:09.664937Z  INFO run: gateway_rs::gateway: received uplink downlink_mac=D8:3A:DD:FF:FE:4D:FD:D7 uplink=@54934578 us, 868100000 MHz, Sf7bw125, snr: 13.5, rssi: -31, len: 29 region=EU868
packet-forwarder-1  | INFO: [up] PUSH_ACK received in 0 ms
packet-forwarder-1  | INFO: [down] PULL_RESP received  - token[168:176] :)
packet-forwarder-1  | 
gateway-rs-1        | 2024-06-15T22:38:11.846017Z  INFO gateway_rs::gateway: rx1 downlink @55934578 us, 868.10 MHz, DataRate(SF7, BW125), len: 15 downlink_mac=D8:3A:DD:FF:FE:4D:FD:D7
packet-forwarder-1  | JSON down: {"txpk":{"imme":false,"tmst":55934578,"freq":868.1,"rfch":0,"powe":16,"modu":"LORA","datr":"SF7BW125","codr":"4/5","ipol":true,"prea":null,"data":"YMUBAEiD3gACFQE9UKHh","size":15}}
packet-forwarder-1  | src/jitqueue.c:247:jit_enqueue(): ERROR: Packet REJECTED, timestamp seems wrong, too much in advance (current=57119886, packet=55934578, type=0)
packet-forwarder-1  | ERROR: Packet REJECTED (jit error=2)
gateway-rs-1        | 2024-06-15T22:38:11.846492Z  INFO gateway_rs::gateway: rx2 downlink @56934578 us, 869.52 MHz, DataRate(SF12, BW125), len: 15 downlink_mac=D8:3A:DD:FF:FE:4D:FD:D7
packet-forwarder-1  | INFO: [down] PULL_RESP received  - token[1:109] :)
packet-forwarder-1  | 
packet-forwarder-1  | JSON down: {"txpk":{"imme":false,"tmst":56934578,"freq":869.525,"rfch":0,"powe":16,"modu":"LORA","datr":"SF12BW125","codr":"4/5","ipol":true,"prea":null,"data":"YMUBAEiD3gACFQE9UKHh","size":15}}
packet-forwarder-1  | src/jitqueue.c:247:jit_enqueue(): ERROR: Packet REJECTED, timestamp seems wrong, too much in advance (current=57120422, packet=56934578, type=0)
packet-forwarder-1  | ERROR: Packet REJECTED (jit error=2)
gateway-rs-1        | 2024-06-15T22:38:11.847355Z  WARN gateway_rs::gateway: ignoring rx2 downlink error err=Ack Error received from gateway: TxAck::Error::TOO_EARLY
davmoz commented 1 month ago

Seems like this does not occur every time. Closing for now.