Hello folks.
I am trying to connect LoRa device using RAK7268CV2 gateway as forwarder but get 95 error code (Time out reached while waiting for a packet in the LoRa RX1 window: https://docs.rakwireless.com/product-categories/wisduo/rak4270-module/at-command-manual/#error-code-table ) using chirpstack v4. However, this device connects successfully with chirpstack v3.
Here is the logs:
Chirpstack:
Dec 11 09:51:20 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:20.691818Z INFO chirpstack::gateway::backend::mqtt: Message received from gateway region_id="eu868" topic=eu868/gateway/ac1f09fffe18503d/event/up qos=AtMostOnce json=false
Dec 11 09:51:20 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:20.893807Z INFO up{deduplication_id=7701524b-6637-42fc-b348-229294c51901}: chirpstack::uplink: Uplink received f_type=JoinRequest
Dec 11 09:51:20 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:20.893860Z DEBUG up{deduplication_id=7701524b-6637-42fc-b348-229294c51901}: chirpstack::uplink: Updating gateway meta-data for uplink frame-set
Dec 11 09:51:20 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:20.894437Z DEBUG up{deduplication_id=7701524b-6637-42fc-b348-229294c51901}: chirpstack::uplink: Logging uplink frame to Redis Stream
Dec 11 09:51:20 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:20.902187Z INFO up{deduplication_id=7701524b-6637-42fc-b348-229294c51901}:join_request{dev_eui="bcfcc644f909e65c"}: chirpstack::storage::device_keys: Device-nonce validated, join-nonce incremented and stored dev_eui=bcfcc644f909e65c dev_nonce=60908
Dec 11 09:51:20 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:20.902744Z INFO up{deduplication_id=7701524b-6637-42fc-b348-229294c51901}:join_request{dev_eui="bcfcc644f909e65c"}: chirpstack::storage::device_queue: Device queue flushed dev_eui=bcfcc644f909e65c count=0
Dec 11 09:51:20 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:20.908433Z INFO up{deduplication_id=7701524b-6637-42fc-b348-229294c51901}:join_request{dev_eui="bcfcc644f909e65c"}: chirpstack::storage::device: Device partially updated dev_eui=bcfcc644f909e65c
Dec 11 09:51:20 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:20.908775Z INFO up{deduplication_id=7701524b-6637-42fc-b348-229294c51901}:join_request{dev_eui="bcfcc644f909e65c"}:join_accept{downlink_id=2055986882}: chirpstack::storage::downlink_frame: Downlink-frame saved downlink_id=2055986882
Dec 11 09:51:20 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:20.908982Z INFO up{deduplication_id=7701524b-6637-42fc-b348-229294c51901}:join_request{dev_eui="bcfcc644f909e65c"}:join_accept{downlink_id=2055986882}: chirpstack::gateway::backend::mqtt: Sending downlink frame region_id=eu868 gateway_id=ac1f09fffe18503d topic=eu868/gateway/ac1f09fffe18503d/command/down json=false
Dec 11 09:51:20 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:20.909707Z INFO chirpstack::integration::mqtt: Publishing event topic=application/00000000-0000-0000-0000-000000000001/device/bcfcc644f909e65c/event/join
Dec 11 09:51:20 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:20.953472Z INFO chirpstack::gateway::backend::mqtt: Message received from gateway region_id="eu868" topic=eu868/gateway/ac1f09fffe18503d/event/ack qos=AtMostOnce json=false
Dec 11 09:51:20 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:20.953943Z INFO tx_ack{downlink_id=2055986882}: chirpstack::downlink::tx_ack: Log downlink-frame for gateway gateway_id=ac1f09fffe18503d
Dec 11 09:51:20 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:20.954432Z INFO tx_ack{downlink_id=2055986882}: chirpstack::downlink::tx_ack: Log downlink-frame for device device_eui=bcfcc644f909e65c
Dec 11 09:51:20 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:20.970579Z INFO chirpstack::gateway::backend::mqtt: Message received from gateway region_id="eu868" topic=eu868/gateway/ac1f09fffe18503d/event/ack qos=AtMostOnce json=false
Dec 11 09:51:20 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:20.970848Z ERROR chirpstack::downlink::tx_ack: Handling tx ack error error=Object does not exist (id: 2055986882)
Dec 11 09:51:25 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:25.927762Z INFO chirpstack::gateway::backend::mqtt: Message received from gateway region_id="eu868" topic=eu868/gateway/ac1f09fffe18503d/event/up qos=AtMostOnce json=false
Dec 11 09:51:26 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:26.130162Z INFO up{deduplication_id=b7a2d230-38a1-438a-b8d1-4898e33b6311}: chirpstack::uplink: Uplink received f_type=ConfirmedDataUp
Dec 11 09:51:26 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:26.130207Z DEBUG up{deduplication_id=b7a2d230-38a1-438a-b8d1-4898e33b6311}: chirpstack::uplink: Updating gateway meta-data for uplink frame-set
Dec 11 09:51:26 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:26.130643Z DEBUG up{deduplication_id=b7a2d230-38a1-438a-b8d1-4898e33b6311}: chirpstack::uplink: Logging uplink frame to Redis Stream
Dec 11 09:51:26 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:26.141232Z INFO up{deduplication_id=b7a2d230-38a1-438a-b8d1-4898e33b6311}:data_up{dev_eui="bcfcc644f909e65c"}: chirpstack::storage::device_gateway: Gateway rx-info saved dev_eui=bcfcc644f909e65c
Dec 11 09:51:26 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:26.166295Z INFO chirpstack::integration::mqtt: Publishing event topic=application/00000000-0000-0000-0000-000000000001/device/bcfcc644f909e65c/event/up
Dec 11 09:51:26 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:26.175966Z INFO up{deduplication_id=b7a2d230-38a1-438a-b8d1-4898e33b6311}:data_up{dev_eui="bcfcc644f909e65c"}: chirpstack::storage::device: Device partially updated dev_eui=bcfcc644f909e65c
Dec 11 09:51:26 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:26.176089Z INFO up{deduplication_id=b7a2d230-38a1-438a-b8d1-4898e33b6311}:data_up{dev_eui="bcfcc644f909e65c"}: chirpstack::storage::metrics: Metrics saved name=device:bcfcc644f909e65c aggregation=HOUR
Dec 11 09:51:26 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:26.176143Z INFO up{deduplication_id=b7a2d230-38a1-438a-b8d1-4898e33b6311}:data_up{dev_eui="bcfcc644f909e65c"}: chirpstack::storage::metrics: Metrics saved name=device:bcfcc644f909e65c aggregation=DAY
Dec 11 09:51:26 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:26.176192Z INFO up{deduplication_id=b7a2d230-38a1-438a-b8d1-4898e33b6311}:data_up{dev_eui="bcfcc644f909e65c"}: chirpstack::storage::metrics: Metrics saved name=device:bcfcc644f909e65c aggregation=MONTH
Dec 11 09:51:26 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:26.278299Z INFO up{deduplication_id=b7a2d230-38a1-438a-b8d1-4898e33b6311}:data_up{dev_eui="bcfcc644f909e65c"}:data_down{downlink_id=1664739085}: chirpstack::storage::mac_command: Pending mac-command block set cid=DevStatusReq
Dec 11 09:51:26 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:26.278318Z INFO up{deduplication_id=b7a2d230-38a1-438a-b8d1-4898e33b6311}:data_up{dev_eui="bcfcc644f909e65c"}:data_down{downlink_id=1664739085}: chirpstack::storage::mac_command: Pending mac-command block set cid=PingSlotChannelReq
Dec 11 09:51:26 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:26.278336Z INFO up{deduplication_id=b7a2d230-38a1-438a-b8d1-4898e33b6311}:data_up{dev_eui="bcfcc644f909e65c"}:data_down{downlink_id=1664739085}: chirpstack::storage::mac_command: Pending mac-command block set cid=DevStatusReq
Dec 11 09:51:26 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:26.278342Z INFO up{deduplication_id=b7a2d230-38a1-438a-b8d1-4898e33b6311}:data_up{dev_eui="bcfcc644f909e65c"}:data_down{downlink_id=1664739085}: chirpstack::storage::mac_command: Pending mac-command block set cid=PingSlotChannelReq
Dec 11 09:51:26 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:26.278544Z INFO up{deduplication_id=b7a2d230-38a1-438a-b8d1-4898e33b6311}:data_up{dev_eui="bcfcc644f909e65c"}:data_down{downlink_id=1664739085}: chirpstack::storage::downlink_frame: Downlink-frame saved downlink_id=1664739085
Dec 11 09:51:26 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:26.286709Z INFO up{deduplication_id=b7a2d230-38a1-438a-b8d1-4898e33b6311}:data_up{dev_eui="bcfcc644f909e65c"}:data_down{downlink_id=1664739085}: chirpstack::storage::device: Device partially updated dev_eui=bcfcc644f909e65c
Dec 11 09:51:26 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:26.286887Z INFO up{deduplication_id=b7a2d230-38a1-438a-b8d1-4898e33b6311}:data_up{dev_eui="bcfcc644f909e65c"}:data_down{downlink_id=1664739085}: chirpstack::gateway::backend::mqtt: Sending downlink frame region_id=eu868 gateway_id=ac1f09fffe18503d topic=eu868/gateway/ac1f09fffe18503d/command/down json=false
Dec 11 09:51:26 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:26.328328Z INFO chirpstack::gateway::backend::mqtt: Message received from gateway region_id="eu868" topic=eu868/gateway/ac1f09fffe18503d/event/ack qos=AtMostOnce json=false
Dec 11 09:51:26 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:26.330361Z INFO chirpstack::integration::mqtt: Publishing event topic=application/00000000-0000-0000-0000-000000000001/device/bcfcc644f909e65c/event/log
Dec 11 09:51:26 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:26.345809Z INFO chirpstack::gateway::backend::mqtt: Message received from gateway region_id="eu868" topic=eu868/gateway/ac1f09fffe18503d/event/ack qos=AtMostOnce json=false
Dec 11 09:51:26 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:26.346067Z ERROR chirpstack::downlink::tx_ack: Handling tx ack error error=Object does not exist (id: 1664739085)
Dec 11 09:51:33 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:33.847968Z INFO chirpstack::gateway::backend::mqtt: Message received from gateway region_id="eu868" topic=eu868/gateway/ac1f09fffe18503d/event/stats qos=AtMostOnce json=false
Dec 11 09:51:33 devtankhq-trixie chirpstack[1302]: 2025-12-11T09:51:33.854111Z INFO stats{gateway_id=ac1f09fffe18503d}: chirpstack::storage::gateway: Gateway partially updated gateway_id=ac1f09fffe18503d
Gateway:
Thu Dec 11 09:51:19 2025 daemon.info gwBridge[8423]: Uplink Packet from Gateway ac1f09fffe18503d
Thu Dec 11 09:51:19 2025 user.info lora_pkt_fwd[8546]: INFO: [down] PULL_ACK received in 2 ms
Thu Dec 11 09:51:20 2025 user.info lora_pkt_fwd[8546]: src/lora_pkt_fwd.c:2788:fetch_packets(): Current time: 2025-12-11 09:51:20 UTC
Thu Dec 11 09:51:20 2025 user.debug lora_pkt_fwd[8546]: rrd_statistic_up 376 uplinkTqByAirtime : dr = 4, timeonair = 102, tm = 1765446680
Thu Dec 11 09:51:20 2025 user.debug lora_pkt_fwd[8546]: rrd_statistic_up 378 uplinkTqByPkt : dr = 4, tm = 1765446680
Thu Dec 11 09:51:20 2025 user.debug lora_pkt_fwd[8546]: rrd_statistic_up 380 ChanBusyByAirtime chan 4, timeonair = 102, tm = 1765446680
Thu Dec 11 09:51:20 2025 user.info lora_pkt_fwd[8546]: INFO: Received pkt CRC BAD
Thu Dec 11 09:51:20 2025 user.debug lora_pkt_fwd[8546]: rrd_statistic_up 376 uplinkTqByAirtime : dr = 4, timeonair = 102, tm = 1765446680
Thu Dec 11 09:51:20 2025 user.debug lora_pkt_fwd[8546]: rrd_statistic_up 378 uplinkTqByPkt : dr = 4, tm = 1765446680
Thu Dec 11 09:51:20 2025 user.debug lora_pkt_fwd[8546]: rrd_statistic_up 380 ChanBusyByAirtime chan 6, timeonair = 102, tm = 1765446680
Thu Dec 11 09:51:20 2025 user.debug lora_pkt_fwd[8546]: INFO: [filter] white list join filter is not enable
Thu Dec 11 09:51:20 2025 user.info lora_pkt_fwd[8546]: INFO: Received pkt from mote: F909E65C (fcnt=64710)
Thu Dec 11 09:51:20 2025 user.debug lora_pkt_fwd[8546]: Uplink Frame :
Thu Dec 11 09:51:20 2025 user.debug lora_pkt_fwd[8546]: 00 5C E6 09 F9 44 C6 FC
Thu Dec 11 09:51:20 2025 user.debug lora_pkt_fwd[8546]: BC 5C E6 09 F9 44 C6 FC
Thu Dec 11 09:51:20 2025 user.debug lora_pkt_fwd[8546]: BC EC ED CD 18 D8 04
Thu Dec 11 09:51:20 2025 user.info lora_pkt_fwd[8546]: src/lora_pkt_fwd.c:3369:thread_up(): nb_pkt 1 send_report 0
Thu Dec 11 09:51:20 2025 user.info lora_pkt_fwd[8546]: src/lora_pkt_fwd.c:3243:dgram_push_pkt(): buff_index 225 buff_size 8169
Thu Dec 11 09:51:20 2025 user.info lora_pkt_fwd[8546]: JSON up: {"rxpk":[{"jver":1,"tmst":3664778052,"chan":6,"rfch":1,"freq":868.300000,"mid": 8,"stat":1,"modu":"LORA","datr":"SF8BW125","codr":"4/5","rssis":-30
,"lsnr":15.0,"foff":-61,"rssi":-29,"size":23,"data":"AFzmCflExvy8XOYJ+UTG/Lzs7c0Y2AQ="}]}
Thu Dec 11 09:51:20 2025 daemon.info gwBridge[8423]: gwBridgeReadCB: Frame size 248
Thu Dec 11 09:51:20 2025 daemon.info gwBridge[8423]: Enter gwBridgeFrameRcv, mdCreateEvent 0 Frame Len 248
Thu Dec 11 09:51:20 2025 daemon.info gwBridge[8423]: Uplink Packet from Gateway ac1f09fffe18503d
Thu Dec 11 09:51:20 2025 daemon.info gwBridge[8423]: Uplink - {"rxpk":[{"jver":1,"tmst":3664778052,"chan":6,"rfch":1,"freq":868.300000,"mid": 8,"stat":1,"modu":"LORA","datr":"SF8BW125","codr":"4/5","rssis":-30,"l
snr":15.0,"foff":-61,"rssi":-29,"size":23,"data":"AFzmCflExvy8XOYJ+UTG/Lzs7c0Y2AQ="}]}
Thu Dec 11 09:51:20 2025 daemon.info gwBridge[8423]: [Uplink] - Protobuf size 130
Thu Dec 11 09:51:20 2025 daemon.info mqttEv[8423]: mqttEvPublish : [[gwBridgeS Mqtt Client]] publish - [130][ W]
Thu Dec 11 09:51:20 2025 user.info lora_pkt_fwd[8546]: INFO: [up] PUSH_ACK received in 4 ms
Thu Dec 11 09:51:20 2025 daemon.info gwBridge[8423]: mosqMsgCB topic : eu868/gateway/ac1f09fffe18503d/command/down
Thu Dec 11 09:51:20 2025 daemon.info gwBridge[8423]: gwBridgeParseMosqDownlink mqtt downlink packet - size 174
Thu Dec 11 09:51:20 2025 user.info lora_pkt_fwd[8546]: INFO: [down] PULL_RESP received - token[194:222] :)
Thu Dec 11 09:51:20 2025 user.info lora_pkt_fwd[8546]: JSON down: {"txpk":{"imme":false,"tmst":3669778052,"freq":868.300000,"rfch":0,"powe":16,"ncrc":false,"modu":"LORA","codr":"4/5","datr":"SF8BW125","ipol":tru
e,"size":33,"data":"IMBr+hb2VS72gRnVB1X2XJvYtqCYfzKkrNdPRDDgh29x"}}
Thu Dec 11 09:51:20 2025 user.debug lora_pkt_fwd[8546]: DownLink Frame :
Thu Dec 11 09:51:20 2025 user.debug lora_pkt_fwd[8546]: 20 C0 6B FA 16 F6 55 2E
Thu Dec 11 09:51:20 2025 user.debug lora_pkt_fwd[8546]: F6 81 19 D5 07 55 F6 5C
Thu Dec 11 09:51:20 2025 user.debug lora_pkt_fwd[8546]: 9B D8 B6 A0 98 7F 32 A4
Thu Dec 11 09:51:20 2025 user.debug lora_pkt_fwd[8546]: AC D7 4F 44 30 E0 87 6F
Thu Dec 11 09:51:20 2025 user.debug lora_pkt_fwd[8546]: 71
Thu Dec 11 09:51:20 2025 user.info lora_pkt_fwd[8546]: INFO: Packet ENQUENUE SUCCESS on SX1301/SX1302: 0
Thu Dec 11 09:51:20 2025 daemon.info gwBridge[8423]: gwBridgeReadCB: Frame size 12
Thu Dec 11 09:51:20 2025 user.info lora_pkt_fwd[8546]: INFO: [down] PULL_RESP received - token[194:222] :)
Thu Dec 11 09:51:20 2025 user.info lora_pkt_fwd[8546]: JSON down: {"txpk":{"imme":false,"tmst":3670778052,"freq":869.525000,"rfch":0,"powe":29,"ncrc":false,"modu":"LORA","codr":"4/5","datr":"SF12BW125","ipol":tr
ue,"size":33,"data":"IMBr+hb2VS72gRnVB1X2XJvYtqCYfzKkrNdPRDDgh29x"}}
Thu Dec 11 09:51:20 2025 daemon.info gwBridge[8423]: Enter gwBridgeFrameRcv, mdCreateEvent 0 Frame Len 12
Thu Dec 11 09:51:20 2025 daemon.info gwBridge[8423]: Uplink Packet from Gateway ac1f09fffe18503d
Thu Dec 11 09:51:20 2025 user.debug lora_pkt_fwd[8546]: DownLink Frame :
Thu Dec 11 09:51:20 2025 user.debug lora_pkt_fwd[8546]: 20 C0 6B FA 16 F6 55 2E
Thu Dec 11 09:51:20 2025 user.debug lora_pkt_fwd[8546]: F6 81 19 D5 07 55 F6 5C
Thu Dec 11 09:51:20 2025 daemon.info gwBridge[8423]: [TxAck] - Protobuf size 28
Thu Dec 11 09:51:20 2025 user.debug lora_pkt_fwd[8546]: 9B D8 B6 A0 98 7F 32 A4
Thu Dec 11 09:51:20 2025 user.debug lora_pkt_fwd[8546]: AC D7 4F 44 30 E0 87 6F
Thu Dec 11 09:51:20 2025 daemon.info mqttEv[8423]: mqttEvPublish : [[gwBridgeS Mqtt Client]] publish - [28][P½¯ÔG*A2Pac1f09fffe18503d0àoq]
Thu Dec 11 09:51:20 2025 user.debug lora_pkt_fwd[8546]: 71
Thu Dec 11 09:51:20 2025 user.warn lora_pkt_fwd[8546]: WARNING: Requested TX power is not supported (29dBm), actual power used: 27dBm
Thu Dec 11 09:51:20 2025 user.info lora_pkt_fwd[8546]: INFO: Packet ENQUENUE SUCCESS on SX1301/SX1302: 0
Thu Dec 11 09:51:20 2025 daemon.info gwBridge[8423]: gwBridgeReadCB: Frame size 12
Thu Dec 11 09:51:20 2025 daemon.info gwBridge[8423]: Enter gwBridgeFrameRcv, mdCreateEvent 0 Frame Len 12
Thu Dec 11 09:51:20 2025 daemon.info gwBridge[8423]: Uplink Packet from Gateway ac1f09fffe18503d
Thu Dec 11 09:51:20 2025 daemon.info gwBridge[8423]: [TxAck] - Protobuf size 28
Thu Dec 11 09:51:20 2025 daemon.info mqttEv[8423]: mqttEvPublish : [[gwBridgeS Mqtt Client]] publish - [28][P½¯ÔG*A2Pac1f09fffe18503d]
Thu Dec 11 09:51:21 2025 user.debug lora_pkt_fwd[8546]: PPS check: pps_xticks=0, last_pps_xticks=0, pps_nochange_count=59481, local_pps_ok=0
Thu Dec 11 09:51:24 2025 daemon.info gwBridge[8423]: gwBridgeReadCB: Frame size 12
Thu Dec 11 09:51:24 2025 daemon.info gwBridge[8423]: Enter gwBridgeFrameRcv, mdCreateEvent 0 Frame Len 12
Thu Dec 11 09:51:24 2025 daemon.info gwBridge[8423]: Uplink Packet from Gateway ac1f09fffe18503d
Thu Dec 11 09:51:24 2025 user.info lora_pkt_fwd[8546]: INFO: [down] PULL_ACK received in 2 ms
Thu Dec 11 09:51:25 2025 user.debug lora_pkt_fwd[8546]: DEBUG: peek packet with count_us=3669778052 at index 0
Thu Dec 11 09:51:25 2025 user.info lora_pkt_fwd[8546]: src/lora_pkt_fwd.c:4535:thread_jit(): lgw_send done on rf_chain 0: count_us=3669778052
Thu Dec 11 09:51:25 2025 user.info lora_pkt_fwd[8546]: src/lora_pkt_fwd.c:2788:fetch_packets(): Current time: 2025-12-11 09:51:25 UTC
Thu Dec 11 09:51:25 2025 user.debug lora_pkt_fwd[8546]: rrd_statistic_up 376 uplinkTqByAirtime : dr = 4, timeonair = 72, tm = 1765446685
Thu Dec 11 09:51:25 2025 user.debug lora_pkt_fwd[8546]: rrd_statistic_up 378 uplinkTqByPkt : dr = 4, tm = 1765446685
Thu Dec 11 09:51:25 2025 user.debug lora_pkt_fwd[8546]: rrd_statistic_up 380 ChanBusyByAirtime chan 6, timeonair = 72, tm = 1765446685
Thu Dec 11 09:51:25 2025 user.info lora_pkt_fwd[8546]: INFO: Received pkt from mote: 00E09535 (fcnt=0)
Thu Dec 11 09:51:25 2025 user.debug lora_pkt_fwd[8546]: Uplink Frame :
Thu Dec 11 09:51:25 2025 user.debug lora_pkt_fwd[8546]: 80 35 95 E0 00 00 00 00
Thu Dec 11 09:51:25 2025 user.debug lora_pkt_fwd[8546]: 7F 9F CA AF
Thu Dec 11 09:51:25 2025 user.info lora_pkt_fwd[8546]: src/lora_pkt_fwd.c:3369:thread_up(): nb_pkt 1 send_report 0
Thu Dec 11 09:51:25 2025 user.info lora_pkt_fwd[8546]: src/lora_pkt_fwd.c:3243:dgram_push_pkt(): buff_index 209 buff_size 8169
Thu Dec 11 09:51:25 2025 user.info lora_pkt_fwd[8546]: JSON up: {"rxpk":[{"jver":1,"tmst":3670030023,"chan":6,"rfch":1,"freq":868.300000,"mid": 8,"stat":1,"modu":"LORA","datr":"SF8BW125","codr":"4/5","rssis":-30
,"lsnr":14.0,"foff":-61,"rssi":-29,"size":12,"data":"gDWV4AAAAAB/n8qv"}]}
Thu Dec 11 09:51:25 2025 daemon.info gwBridge[8423]: gwBridgeReadCB: Frame size 232
Thu Dec 11 09:51:25 2025 daemon.info gwBridge[8423]: Enter gwBridgeFrameRcv, mdCreateEvent 0 Frame Len 232
Thu Dec 11 09:51:25 2025 daemon.info gwBridge[8423]: Uplink Packet from Gateway ac1f09fffe18503d
Thu Dec 11 09:51:25 2025 daemon.info gwBridge[8423]: Uplink - {"rxpk":[{"jver":1,"tmst":3670030023,"chan":6,"rfch":1,"freq":868.300000,"mid": 8,"stat":1,"modu":"LORA","datr":"SF8BW125","codr":"4/5","rssis":-30,"l
snr":14.0,"foff":-61,"rssi":-29,"size":12,"data":"gDWV4AAAAAB/n8qv"}]}
Thu Dec 11 09:51:25 2025 daemon.info gwBridge[8423]: [Uplink] - Protobuf size 119
Thu Dec 11 09:51:25 2025 daemon.info mqttEv[8423]: mqttEvPublish : [[gwBridgeS Mqtt Client]] publish - [119][ L5à]
Thu Dec 11 09:51:25 2025 user.info lora_pkt_fwd[8546]: INFO: [up] PUSH_ACK received in 0 ms
Thu Dec 11 09:51:26 2025 daemon.info gwBridge[8423]: mosqMsgCB topic : eu868/gateway/ac1f09fffe18503d/command/down
Thu Dec 11 09:51:26 2025 daemon.info gwBridge[8423]: gwBridgeParseMosqDownlink mqtt downlink packet - size 144
Thu Dec 11 09:51:26 2025 user.info lora_pkt_fwd[8546]: INFO: [down] PULL_RESP received - token[13:231] :)
Thu Dec 11 09:51:26 2025 user.info lora_pkt_fwd[8546]: JSON down: {"txpk":{"imme":false,"tmst":3671030023,"freq":868.300000,"rfch":0,"powe":16,"ncrc":false,"modu":"LORA","codr":"4/5","datr":"SF8BW125","ipol":tru
e,"size":18,"data":"YDWV4ACmAAAGEQAAAAOTeNlS"}}
Thu Dec 11 09:51:26 2025 user.debug lora_pkt_fwd[8546]: DownLink Frame :
Thu Dec 11 09:51:26 2025 user.debug lora_pkt_fwd[8546]: 60 35 95 E0 00 A6 00 00
Thu Dec 11 09:51:26 2025 user.debug lora_pkt_fwd[8546]: 06 11 00 00 00 03 93 78
Thu Dec 11 09:51:26 2025 user.debug lora_pkt_fwd[8546]: D9 52
Thu Dec 11 09:51:26 2025 user.info lora_pkt_fwd[8546]: src/jitqueue.c:282:jit_enqueue(): ERROR: Packet (type=0) REJECTED, collision with packet already programmed at 3670778052 (3671030023)
Thu Dec 11 09:51:26 2025 user.debug lora_pkt_fwd[8546]: [logger]: pkt type = COLLISION_PACKET, count_us = 3671030023
Thu Dec 11 09:51:26 2025 user.debug lora_pkt_fwd[8546]: JSON tx_ack: {"txpk_ack":{"error":"COLLISION_PACKET"}}
Thu Dec 11 09:51:26 2025 user.info lora_pkt_fwd[8546]: INFO: [down] PULL_RESP received - token[13:231] :)
Thu Dec 11 09:51:26 2025 user.info lora_pkt_fwd[8546]: JSON down: {"txpk":{"imme":false,"tmst":3672030023,"freq":869.525000,"rfch":0,"powe":29,"ncrc":false,"modu":"LORA","codr":"4/5","datr":"SF12BW125","ipol":tr
ue,"size":18,"data":"YDWV4ACmAAAGEQAAAAOTeNlS"}}
Thu Dec 11 09:51:26 2025 user.debug lora_pkt_fwd[8546]: DownLink Frame :
Thu Dec 11 09:51:26 2025 user.debug lora_pkt_fwd[8546]: 60 35 95 E0 00 A6 00 00
Thu Dec 11 09:51:26 2025 user.debug lora_pkt_fwd[8546]: 06 11 00 00 00 03 93 78
Thu Dec 11 09:51:26 2025 user.debug lora_pkt_fwd[8546]: D9 52
Thu Dec 11 09:51:26 2025 user.warn lora_pkt_fwd[8546]: WARNING: Requested TX power is not supported (29dBm), actual power used: 27dBm
Thu Dec 11 09:51:26 2025 daemon.info gwBridge[8423]: gwBridgeReadCB: Frame size 53
Thu Dec 11 09:51:26 2025 daemon.info gwBridge[8423]: Enter gwBridgeFrameRcv, mdCreateEvent 0 Frame Len 53
Thu Dec 11 09:51:26 2025 daemon.info gwBridge[8423]: Uplink Packet from Gateway ac1f09fffe18503d
Thu Dec 11 09:51:26 2025 daemon.info gwBridge[8423]: [TxAck] - Protobuf size 28
Thu Dec 11 09:51:26 2025 user.info lora_pkt_fwd[8546]: src/jitqueue.c:282:jit_enqueue(): ERROR: Packet (type=0) REJECTED, collision with packet already programmed at 3670778052 (3672030023)
Thu Dec 11 09:51:26 2025 daemon.info mqttEv[8423]: mqttEvPublish : [[gwBridgeS Mqtt Client]] publish - [28][PÎçF*D2Pac1f09fffe18503d3d/event/up]
Thu Dec 11 09:51:26 2025 user.debug lora_pkt_fwd[8546]: [logger]: pkt type = COLLISION_PACKET, count_us = 3672030023
Thu Dec 11 09:51:26 2025 user.debug lora_pkt_fwd[8546]: JSON tx_ack: {"txpk_ack":{"error":"COLLISION_PACKET"}}
Thu Dec 11 09:51:26 2025 daemon.info gwBridge[8423]: gwBridgeReadCB: Frame size 53
Thu Dec 11 09:51:26 2025 daemon.info gwBridge[8423]: Enter gwBridgeFrameRcv, mdCreateEvent 0 Frame Len 53
Thu Dec 11 09:51:26 2025 daemon.info gwBridge[8423]: Uplink Packet from Gateway ac1f09fffe18503d
Thu Dec 11 09:51:26 2025 daemon.info gwBridge[8423]: [TxAck] - Protobuf size 28
Thu Dec 11 09:51:26 2025 daemon.info mqttEv[8423]: mqttEvPublish : [[gwBridgeS Mqtt Client]] publish - [28][PÎçF*D2Pac1f09fffe18503d3d/event/up]
Thu Dec 11 09:51:26 2025 user.debug lora_pkt_fwd[8546]: DEBUG: peek packet with count_us=3670778052 at index 0
Thu Dec 11 09:51:26 2025 user.info lora_pkt_fwd[8546]: src/lora_pkt_fwd.c:4535:thread_jit(): lgw_send done on rf_chain 0: count_us=3670778052
Thu Dec 11 09:51:27 2025 user.debug lora_pkt_fwd[8546]: DEBUG: timersync wait result 145
Thu Dec 11 09:51:27 2025 user.info lora_pkt_fwd[8546]: INFO: host/radio[0] time offset=(1765443015 s:867021 us) - drift=1 us
Thu Dec 11 09:51:29 2025 daemon.info gwBridge[8423]: gwBridgeReadCB: Frame size 12
Thu Dec 11 09:51:29 2025 daemon.info gwBridge[8423]: Enter gwBridgeFrameRcv, mdCreateEvent 0 Frame Len 12
Thu Dec 11 09:51:29 2025 daemon.info gwBridge[8423]: Uplink Packet from Gateway ac1f09fffe18503d
Thu Dec 11 09:51:29 2025 user.info lora_pkt_fwd[8546]: INFO: [down] PULL_ACK received in 2 ms
Thu Dec 11 09:51:31 2025 user.debug lora_pkt_fwd[8546]: PPS check: pps_xticks=0, last_pps_xticks=0, pps_nochange_count=59491, local_pps_ok=0
Thu Dec 11 09:51:33 2025 user.notice lora_pkt_fwd[8546]: ##### 2025-12-11 09:51:33 UTC #####
Thu Dec 11 09:51:33 2025 user.notice lora_pkt_fwd[8546]: ### [UPSTREAM] ###
Thu Dec 11 09:51:33 2025 user.notice lora_pkt_fwd[8546]: # RF packets received by concentrator: 3
Thu Dec 11 09:51:33 2025 user.notice lora_pkt_fwd[8546]: # CRC_OK: 66.67%, CRC_FAIL: 33.33%, NO_CRC: 0.00%
Thu Dec 11 09:51:33 2025 user.notice lora_pkt_fwd[8546]: # RF packets forwarded: 2 (35 bytes)
Thu Dec 11 09:51:33 2025 user.notice lora_pkt_fwd[8546]: # PUSH_DATA datagrams sent: 3 (605 bytes)
Thu Dec 11 09:51:33 2025 user.notice lora_pkt_fwd[8546]: # PUSH_DATA acknowledged: 100.00%
Thu Dec 11 09:51:33 2025 user.notice lora_pkt_fwd[8546]: ### [DOWNSTREAM] ###
Thu Dec 11 09:51:33 2025 user.notice lora_pkt_fwd[8546]: # PULL_DATA sent: 6 (100.00% acknowledged)
Thu Dec 11 09:51:33 2025 user.notice lora_pkt_fwd[8546]: # PULL_RESP(onse) datagrams received: 4 (826 bytes)
Thu Dec 11 09:51:33 2025 user.notice lora_pkt_fwd[8546]: # RF packets sent to concentrator: 2 (102 bytes)
Thu Dec 11 09:51:33 2025 user.notice lora_pkt_fwd[8546]: # TX errors: 0
Thu Dec 11 09:51:33 2025 user.notice lora_pkt_fwd[8546]: # TX rejected (collision packet): 100.00% (req:142, rej:142)
Thu Dec 11 09:51:33 2025 user.notice lora_pkt_fwd[8546]: # TX rejected (collision beacon): 0.00% (req:142, rej:0)
Thu Dec 11 09:51:33 2025 user.notice lora_pkt_fwd[8546]: # TX rejected (too late): 0.00% (req:142, rej:0)
Thu Dec 11 09:51:33 2025 user.notice lora_pkt_fwd[8546]: # TX rejected (too early): 0.00% (req:142, rej:0)
Thu Dec 11 09:51:33 2025 user.notice lora_pkt_fwd[8546]: ### SX1302 Status ###
Thu Dec 11 09:51:33 2025 user.notice lora_pkt_fwd[8546]: # SX130X counter (INST): 3677929659
Thu Dec 11 09:51:33 2025 user.notice lora_pkt_fwd[8546]: # SX130X time (PPS): 0, offset us 0
Thu Dec 11 09:51:33 2025 user.notice lora_pkt_fwd[8546]: # BEACON queued: 0
Thu Dec 11 09:51:33 2025 user.notice lora_pkt_fwd[8546]: # BEACON sent so far: 0
Thu Dec 11 09:51:33 2025 user.notice lora_pkt_fwd[8546]: # BEACON rejected: 0
Thu Dec 11 09:51:33 2025 user.notice lora_pkt_fwd[8546]: ### [JIT] ###
Thu Dec 11 09:51:33 2025 user.info lora_pkt_fwd[8546]: src/jitqueue.c:453:jit_print_queue(): INFO: [jit] queue is empty
Thu Dec 11 09:51:33 2025 user.notice lora_pkt_fwd[8546]: #--------
Thu Dec 11 09:51:33 2025 user.notice lora_pkt_fwd[8546]: ### [GPS] ###
Thu Dec 11 09:51:33 2025 user.notice lora_pkt_fwd[8546]: # GPS sync is disabled
Thu Dec 11 09:51:33 2025 user.notice lora_pkt_fwd[8546]: ### Concentrator[0] temperature: 30 C ###
Thu Dec 11 09:51:33 2025 user.notice lora_pkt_fwd[8546]: ##### END #####
Thu Dec 11 09:51:33 2025 user.debug lora_pkt_fwd[8546]: watchdog wait result 0
Thu Dec 11 09:51:33 2025 user.debug lora_pkt_fwd[8546]: watchdog check past/last tstamp[0]: 3647907941 3677929659
Thu Dec 11 09:51:33 2025 user.info lora_pkt_fwd[8546]: src/lora_pkt_fwd.c:3369:thread_up(): nb_pkt 0 send_report 1
Thu Dec 11 09:51:33 2025 user.info lora_pkt_fwd[8546]: JSON up: {"stat":{"time":"2025-12-11 09:51:33 UTC","rxnb":3,"rxok":2,"rxfw":2,"ackr":100.0,"dwnb":4,"txnb":2,"temp":30.0}}
Thu Dec 11 09:51:33 2025 daemon.info gwBridge[8423]: gwBridgeReadCB: Frame size 125
Thu Dec 11 09:51:33 2025 daemon.info gwBridge[8423]: Enter gwBridgeFrameRcv, mdCreateEvent 0 Frame Len 125
Thu Dec 11 09:51:33 2025 daemon.info gwBridge[8423]: Uplink Packet from Gateway ac1f09fffe18503d
Thu Dec 11 09:51:33 2025 daemon.info gwBridge[8423]: Uplink - {"stat":{"time":"2025-12-11 09:51:33 UTC","rxnb":3,"rxok":2,"rxfw":2,"ackr":100.0,"dwnb":4,"txnb":2,"temp":30.0}}
Thu Dec 11 09:51:33 2025 daemon.info gwBridge[8423]: Stats : Protobuf size 46
Thu Dec 11 09:51:33 2025 daemon.info mqttEv[8423]: mqttEvPublish : [[gwBridgeS Mqtt Client]] publish - [46]¥¨êÉFP]
Thu Dec 11 09:51:33 2025 user.info lora_pkt_fwd[8546]: INFO: [up] PUSH_ACK received in 21 ms
Thu Dec 11 09:51:35 2025 daemon.info gwBridge[8423]: gwBridgeReadCB: Frame size 12
Thu Dec 11 09:51:35 2025 daemon.info gwBridge[8423]: Enter gwBridgeFrameRcv, mdCreateEvent 0 Frame Len 12
Thu Dec 11 09:51:35 2025 daemon.info gwBridge[8423]: Uplink Packet from Gateway ac1f09fffe18503d
Thu Dec 11 09:51:35 2025 user.info lora_pkt_fwd[8546]: INFO: [down] PULL_ACK received in 2 ms
Thu Dec 11 09:51:37 2025 user.debug lora_pkt_fwd[8546]: DEBUG: timersync wait result 145
Thu Dec 11 09:51:37 2025 user.info lora_pkt_fwd[8546]: INFO: host/radio[0] time offset=(1765443015 s:867022 us) - drift=1 us
Thu Dec 11 09:51:40 2025 daemon.info gwBridge[8423]: gwBridgeReadCB: Frame size 12
Thu Dec 11 09:51:40 2025 daemon.info gwBridge[8423]: Enter gwBridgeFrameRcv, mdCreateEvent 0 Frame Len 12
Thu Dec 11 09:51:40 2025 daemon.info gwBridge[8423]: Uplink Packet from Gateway ac1f09fffe18503d
Thu Dec 11 09:51:40 2025 user.info lora_pkt_fwd[8546]: INFO: [down] PULL_ACK received in 2 ms
Thu Dec 11 09:51:41 2025 user.debug lora_pkt_fwd[8546]: PPS check: pps_xticks=0, last_pps_xticks=0, pps_nochange_count=59501, local_pps_ok=0
Thu Dec 11 09:51:42 2025 user.debug lora_pkt_fwd[8546]: INFO: [MQTT] mqttLogger: Client mqtt-logger-1765387182 sending PINGREQ
Thu Dec 11 09:51:42 2025 user.debug lora_pkt_fwd[8546]: INFO: [MQTT] mqttLogger: Client mqtt-logger-1765387182 received PINGRESP
Thu Dec 11 09:51:45 2025 daemon.info gwBridge[8423]: gwBridgeReadCB: Frame size 12
Thu Dec 11 09:51:45 2025 daemon.info gwBridge[8423]: Enter gwBridgeFrameRcv, mdCreateEvent 0 Frame Len 12
Thu Dec 11 09:51:45 2025 daemon.info gwBridge[8423]: Uplink Packet from Gateway ac1f09fffe18503d
Thu Dec 11 09:51:45 2025 user.info lora_pkt_fwd[8546]: INFO: [down] PULL_ACK received in 2 ms
Thu Dec 11 09:51:47 2025 user.debug lora_pkt_fwd[8546]: DEBUG: timersync wait result 145
Thu Dec 11 09:51:47 2025 user.info lora_pkt_fwd[8546]: INFO: host/radio[0] time offset=(1765443015 s:867022 us) - drift=0 us
Thu Dec 11 09:51:50 2025 daemon.info gwBridge[8423]: gwBridgeReadCB: Frame size 12
Thu Dec 11 09:51:50 2025 daemon.info gwBridge[8423]: Enter gwBridgeFrameRcv, mdCreateEvent 0 Frame Len 12
Thu Dec 11 09:51:50 2025 daemon.info gwBridge[8423]: Uplink Packet from Gateway ac1f09fffe18503d
Thu Dec 11 09:51:50 2025 user.info lora_pkt_fwd[8546]: INFO: [down] PULL_ACK received in 2 ms
Thu Dec 11 09:51:51 2025 user.debug lora_pkt_fwd[8546]: PPS check: pps_xticks=0, last_pps_xticks=0, pps_nochange_count=59511, local_pps_ok=0
Thu Dec 11 09:51:55 2025 daemon.info gwBridge[8423]: gwBridgeReadCB: Frame size 12
Thu Dec 11 09:51:55 2025 daemon.info gwBridge[8423]: Enter gwBridgeFrameRcv, mdCreateEvent 0 Frame Len 12
Device log:
DEBUG:0000089023:COMMS: >> RAK4270 version:3.3.0.17
DEBUG:0000089175:COMMS: >> UART1 work mode: RUI_UART_NORMAL, 115200, N81
DEBUG:0000089180:COMMS: >> UART2 work mode: RUI_UART_NORMAL, 115200, N81
DEBUG:0000089188:COMMS: >> Current work_mode:LoRaWAN, join_mode:OTAA, Multicast
DEBUG:0000089190:COMMS: >> Initialization OK
DEBUG:0000089190:COMMS: << at+set_config=lora:default_parameters
DEBUG:0000089416:COMMS: >> OK
DEBUG:0000089418:COMMS: << at+set_config=lora:join_mode:0
DEBUG:0000089421:COMMS: >> OK
DEBUG:0000089423:COMMS: << at+set_config=lora:class:2
DEBUG:0000089436:COMMS: >> OK
DEBUG:0000089438:COMMS: << at+set_config=lora:region:EU868
DEBUG:0000089442:COMMS: >> OK
DEBUG:0000089444:COMMS: << at+set_config=lora:confirm:1
DEBUG:0000089447:COMMS: >> OK
DEBUG:0000089449:COMMS: << at+set_config=lora:adr:0
DEBUG:0000089452:COMMS: >> OK
DEBUG:0000089454:COMMS: << at+set_config=lora:dr:4
DEBUG:0000089462:COMMS: >> OK
DEBUG:0000089464:COMMS: << at+set_config=lora:dutycycle_enable:0
DEBUG:0000089468:COMMS: >> OK
DEBUG:0000089470:COMMS: << at+set_config=lora:dev_eui:bcfcc644f909e65c
DEBUG:0000089703:COMMS: >> OK
DEBUG:0000089705:COMMS: << at+set_config=lora:app_eui:bcfcc644f909e65c
DEBUG:0000089931:COMMS: >> OK
DEBUG:0000089933:COMMS: << at+set_config=lora:app_key:f3fe43d0920ceb7df3d9a3e081
DEBUG:0000090168:COMMS: >> OK
DEBUG:0000090170:COMMS: << at+set_config=device:restart
DEBUG:0000090204:COMMS: >> LoRa (R) is a registered trademark or service mark o
DEBUG:0000090207:COMMS: >> RAK4270 version:3.3.0.17
DEBUG:0000090359:COMMS: >> UART1 work mode: RUI_UART_NORMAL, 115200, N81
DEBUG:0000090364:COMMS: >> UART2 work mode: RUI_UART_NORMAL, 115200, N81
DEBUG:0000090372:COMMS: >> Current work_mode:LoRaWAN, join_mode:OTAA, Multicast
DEBUG:0000090374:COMMS: >> Initialization OK
DEBUG:0000090376:COMMS: << at+join
DEBUG:0000095738:COMMS: >> OK Join Success
DEBUG:0000095740:COMMS: Sending an 'is alive' packet.
DEBUG:0000095740:COMMS: << at+send=lora:3:
DEBUG:0000100766:COMMS: >> ERROR: 95
DEBUG:0000100766:COMMS: Timed out waiting for packet in window RX1.
DEBUG:0000100766:COMMS: Resending 3/5
DEBUG:0000100766:COMMS: Broken backup, cant resend
DEBUG:0000131335:COMMS: LoRa chip timed out, resetting.
Any thoughts?