[Solved] WiFi LoRa 32 V2 TTN joining trouble

I have 2 new ESP32 LoRa 32 V2 boards and a new RAKwireless RAK7258 indoor gateway. The gateway has been set up with TTN using the US 915MHz frequency band. On TTN, I created a new application and 2 new devices. After modifying the Arduino library to use the 915MHz frequency band and to have my application EUI and application key, I flashed each device with its device EUI and the example OTAA_OLED.ino from ESP32_LoRaWAN .

For both devices, I have the same problem. They show “JOINING…” on the OLED forever. On the gateway, I see 90% of packets have CRC_ERR. However, a few packets show CRC_OK and the JSON looks correct as far as I can tell: the EUIs look correct, and there is a field “MType”: “Join Request”. A few seconds later, the gateway shows a transmitted packet with the field “MType”: “Join Accept”. On the TTN console, I can see that the devices were seen a few seconds ago.

This is all that I get, with either device. They are on the same desk with the gateway, so the range is about 1m. I am using the antenna that came with the WiFi LoRa 32 V2 boards. I don’t see any packets in the gateway log coming from any other devices in my region, since LoRa is not very common here.

Why do about 90% of the packets have CRC_ERR when the range is only 1m? How can I get these devices to join successfully?

Thanks!

Edit: The problem was the gateway configuration. It has the wrong Frequency Sub-Band selected. After changing it to channels 0~7, 64, the RSSI reported by the gatway improved to -20dBm, and the Heltec WiFi LoRa 32 V2 joined TTN and sent data OK. I hope this post might help another new LoRa user.

I’ve done some further testing by loading the OLED_LoRa_Sender sketch on one board and the OLED_LoRa_Receiver on the other board. This combination works very well. I did not see any missed messages, and the RSSI reported by the receiver about 1m away from the sender is -30dBm.

By comparison, the best RSSI reported by the RAKwireless gateway was around -100dBm. Unfortunately, these two WiFi LoRa 32 V2 boards and the RAKwireless gateway are the only LoRa devices I have access to right now. What else can I try to do further troubleshooting?

Thanks for this post. With your help, I’m sending Joins and the ChirpStack server is sending JoinAccepts. It looks like the RAK is transmitting the Accepts form looking at the Packet Logger the RSSI for those downlinks are “-”, TX power is “20”, and CRC is “CRC”. I’m running the OTAA_DHT11 sketch on the v2 board. Wondering if you ran into this problem as well or if you or anyone had any advice.

Well, downlink packets showing “-” for RSSI makes sense, since the gateway is transmitting those packets it doesn’t measure an RSSI. TX power of 20 dBm sounds correct, also, assuming you are in a region where that is allowed. Is there something else you are seeing that looks like a problem?

Thanks for validating. This now leads me to think the issue is in the radio configuration. I’ve read on other forums (LMIC) that a similar issue with Clock Error but I don’t see a configuration item for that in the Heltec library implementation. I other thought is the devices Rx freq. Where should I be looking to verify those items are configured correctly?

Thanks in advance.

The devices’ Rx freq should be the same band as their Tx freq, so if the gateway is receiving packets from the devices, then they’re on the right band. Not sure what else to look at on the device side of the link.

The problem of CRC bad may be caused by the gateway, or the frequency offset of the signal sent by the node exceeds the maximum value.

According to previous experience, the crystal oscillator’s oscillating capacitor failure, false soldering, and errors will cause the frequency to be inaccurate.

Can you find some capacitors with 0402 package near your hand? the value between 15~20pF should be OK. Can you try to replace this two capacitors?

I suspect it may be the gateway as well. What can you tell log file?

Fri Jan 10 07:31:52 2020 user.info lora_pkt_fwd[4491]: INFO: [down] PULL_RESP received - token[166:241] :slight_smile:
Fri Jan 10 07:31:52 2020 user.info lora_pkt_fwd[4491]:
JSON down: {“txpk”:{“imme”:false,“tmst”:768858532,“freq”:926.900000,“rfch”:0,“powe”:20,“ncrc”:false,“modu”:“LORA”,“codr”:“4/5”,“datr”:“SF10BW500”,“ipol”:true,“size”:17,“data”:“IOl5W6QPqPnih2UCjACaJbw=”}}
Fri Jan 10 07:31:52 2020 user.info lora_pkt_fwd[4491]: INFO: Packet ENQUENUE SUCCESS on sx1301 0
Fri Jan 10 07:31:52 2020 daemon.info gwBridge[4531]: [TxAck] - Protobuf size 32
Fri Jan 10 07:31:55 2020 user.info lora_pkt_fwd[4491]: INFO: [down] PULL_ACK received in 0 ms
Fri Jan 10 07:31:56 2020 user.info lora_pkt_fwd[4491]: src/lora_pkt_fwd.c:4077:thread_jit(): lgw_send done: count_us=768858532
Fri Jan 10 07:32:00 2020 user.info lora_pkt_fwd[4491]: INFO: [down] PULL_ACK received in 0 ms
Fri Jan 10 07:32:05 2020 user.info lora_pkt_fwd[4491]: INFO: [down] PULL_ACK received in 0 ms
Fri Jan 10 07:32:11 2020 user.info lora_pkt_fwd[4491]: INFO: [down] PULL_ACK received in 0 ms
Fri Jan 10 07:32:12 2020 user.info lora_pkt_fwd[4491]:
INFO: Disabling GPS mode for concentrator’s counter…
Fri Jan 10 07:32:12 2020 user.info lora_pkt_fwd[4491]: INFO: host/sx1301 time offset=(1578658747s:899661µs) - drift=-523µs
Fri Jan 10 07:32:12 2020 user.info lora_pkt_fwd[4491]: INFO: Enabling GPS mode for concentrator’s counter.

Fri Jan 10 07:32:12 2020 user.debug lora_pkt_fwd[4491]:

2020-01-10 12:32:12 UTC

Fri Jan 10 07:32:12 2020 user.debug lora_pkt_fwd[4491]: ### [UPSTREAM] ###
Fri Jan 10 07:32:12 2020 user.debug lora_pkt_fwd[4491]: # RF packets received by concentrator: 1
Fri Jan 10 07:32:12 2020 user.debug lora_pkt_fwd[4491]: [truncated] , CRC_FAIL: 0.00%, NO_CRC: 0.00%
Fri Jan 10 07:32:12 2020 user.debug lora_pkt_fwd[4491]: # RF packets forwarded: 1 (23 bytes)
Fri Jan 10 07:32:12 2020 user.debug lora_pkt_fwd[4491]: # PUSH_DATA datagrams sent: 2 (385 bytes)
Fri Jan 10 07:32:12 2020 user.debug lora_pkt_fwd[4491]: [truncated]
Fri Jan 10 07:32:12 2020 user.debug lora_pkt_fwd[4491]: ### [DOWNSTREAM] ###
Fri Jan 10 07:32:12 2020 user.debug lora_pkt_fwd[4491]: # PULL_DATA sent: 6 (100.00 0x0.0000000000005p-992cknowledged)
Fri Jan 10 07:32:12 2020 user.debug lora_pkt_fwd[4491]: # PULL_RESP(onse) datagrams received: 1 (196 bytes)
Fri Jan 10 07:32:12 2020 user.debug lora_pkt_fwd[4491]: # RF packets sent to concentrator: 1 (17 bytes)
Fri Jan 10 07:32:12 2020 user.debug lora_pkt_fwd[4491]: # SX1301 time (PPS): 784595471, offset us 0
Fri Jan 10 07:32:12 2020 user.info lora_pkt_fwd[4491]: src/jitqueue.c:452:jit_print_queue(): INFO: [jit] queue is empty
Fri Jan 10 07:32:12 2020 user.debug lora_pkt_fwd[4491]: ### [GPS] ###
Fri Jan 10 07:32:12 2020 user.debug lora_pkt_fwd[4491]: # Invalid time reference (age: 1578659532 sec)
Fri Jan 10 07:32:12 2020 user.debug lora_pkt_fwd[4491]: # no valid GPS coordinates available yet
Fri Jan 10 07:32:12 2020 user.debug lora_pkt_fwd[4491]: ##### END #####
Fri Jan 10 07:32:12 2020 user.info lora_pkt_fwd[4491]:
JSON up: {“stat”:{“time”:“2020-01-10 12:32:12 UTC”,“lati”:##.87253,“long”:-##.27245,“alti”:40,“rxnb”:1,“rxok”:1,“rxfw”:1,“ackr”:100.0,“dwnb”:1,“txnb”:1,“cpur”:0.0,“memr”:0.0}}
Fri Jan 10 07:32:12 2020 daemon.info gwBridge[4531]: Stats : Protobuf size 98
Fri Jan 10 07:32:12 2020 user.info lora_pkt_fwd[4491]: INFO: [up] PUSH_ACK received in 0 ms
Fri Jan 10 07:32:16 2020 user.info lora_pkt_fwd[4491]: INFO: [down] PULL_ACK received in 0 ms
Fri Jan 10 07:32:21 2020 user.info lora_pkt_fwd[4491]: INFO: [down] PULL_ACK received in 0 ms
Fri Jan 10 07:32:26 2020 user.info lora_pkt_fwd[4491]: INFO: [down] PULL_ACK received in 0 ms
Fri Jan 10 07:32:31 2020 user.info lora_pkt_fwd[4491]: INFO: [down] PULL_ACK received in 0 ms
Fri Jan 10 07:32:37 2020 user.info lora_pkt_fwd[4491]: INFO: [down] PULL_ACK received in 0 ms
Fri Jan 10 07:32:42 2020 user.info lora_pkt_fwd[4491]: INFO: [down] PULL_ACK received in 0 ms
Fri Jan 10 07:32:42 2020 user.debug lora_pkt_fwd[4491]:

2020-01-10 12:32:42 UTC

Fri Jan 10 07:32:42 2020 user.debug lora_pkt_fwd[4491]: ### [UPSTREAM] ###
Fri Jan 10 07:32:42 2020 user.debug lora_pkt_fwd[4491]: # RF packets received by concentrator: 0
Fri Jan 10 07:32:42 2020 user.debug lora_pkt_fwd[4491]: [truncated] , CRC_FAIL: 0.00%, NO_CRC: 0.00%
Fri Jan 10 07:32:42 2020 user.debug lora_pkt_fwd[4491]: # RF packets forwarded: 0 (0 bytes)
Fri Jan 10 07:32:42 2020 user.debug lora_pkt_fwd[4491]: # PUSH_DATA datagrams sent: 1 (178 bytes)
Fri Jan 10 07:32:42 2020 user.debug lora_pkt_fwd[4491]: [truncated]
Fri Jan 10 07:32:42 2020 user.debug lora_pkt_fwd[4491]: ### [DOWNSTREAM] ###
Fri Jan 10 07:32:42 2020 user.debug lora_pkt_fwd[4491]: # PULL_DATA sent: 6 (100.00 0x0.0000000000005p-992cknowledged)
Fri Jan 10 07:32:42 2020 user.debug lora_pkt_fwd[4491]: # PULL_RESP(onse) datagrams received: 0 (0 bytes)
Fri Jan 10 07:32:42 2020 user.debug lora_pkt_fwd[4491]: # RF packets sent to concentrator: 0 (0 bytes)
Fri Jan 10 07:32:42 2020 user.debug lora_pkt_fwd[4491]: # TX errors: 0
Fri Jan 10 07:32:42 2020 user.debug lora_pkt_fwd[4491]: [truncated] (req:9, rej:0)
Fri Jan 10 07:32:42 2020 user.debug lora_pkt_fwd[4491]: [truncated] (req:9, rej:0)
Fri Jan 10 07:32:42 2020 user.debug lora_pkt_fwd[4491]: [truncated] (req:9, rej:0)
Fri Jan 10 07:32:42 2020 user.debug lora_pkt_fwd[4491]: [truncated] (req:9, rej:0)
Fri Jan 10 07:32:42 2020 user.debug lora_pkt_fwd[4491]: # BEACON queued: 0
Fri Jan 10 07:32:42 2020 user.debug lora_pkt_fwd[4491]: # BEACON sent so far: 0
Fri Jan 10 07:32:42 2020 user.debug lora_pkt_fwd[4491]: # BEACON rejected: 0
Fri Jan 10 07:32:42 2020 user.debug lora_pkt_fwd[4491]: ### [JIT] ###
Fri Jan 10 07:32:42 2020 user.debug lora_pkt_fwd[4491]: # SX1301 time (PPS): 784595471, offset us 0
Fri Jan 10 07:32:42 2020 user.info lora_pkt_fwd[4491]: src/jitqueue.c:452:jit_print_queue(): INFO: [jit] queue is empty
Fri Jan 10 07:32:42 2020 user.debug lora_pkt_fwd[4491]: ### [GPS] ###
Fri Jan 10 07:32:42 2020 user.debug lora_pkt_fwd[4491]: # Invalid time reference (age: 1578659562 sec)
Fri Jan 10 07:32:42 2020 user.debug lora_pkt_fwd[4491]: # no valid GPS coordinates available yet
Fri Jan 10 07:32:42 2020 user.debug lora_pkt_fwd[4491]: ##### END #####
Fri Jan 10 07:32:42 2020 user.info lora_pkt_fwd[4491]:
JSON up: {“stat”:{“time”:“2020-01-10 12:32:42 UTC”,“lati”:##.87253,“long”:-##.27245,“alti”:40,“rxnb”:0,“rxok”:0,“rxfw”:0,“ackr”:100.0,“dwnb”:0,“txnb”:0,“cpur”:0.0,“memr”:0.0}}
Fri Jan 10 07:32:42 2020 daemon.info gwBridge[4531]: Stats : Protobuf size 90
Fri Jan 10 07:32:42 2020 user.info lora_pkt_fwd[4491]: INFO: [up] PUSH_ACK received in 6 ms
Fri Jan 10 07:32:47 2020 user.info lora_pkt_fwd[4491]: INFO: [down] PULL_ACK received in 0 ms
Fri Jan 10 07:32:52 2020 user.info lora_pkt_fwd[4491]: INFO: [down] PULL_ACK received in 0 ms
Fri Jan 10 07:32:57 2020 user.info lora_pkt_fwd[4491]: INFO: [down] PULL_ACK received in 0 ms
Fri Jan 10 07:33:03 2020 user.info lora_pkt_fwd[4491]: INFO: [down] PULL_ACK received in 0 ms
Fri Jan 10 07:33:08 2020 user.info lora_pkt_fwd[4491]: INFO: [down] PULL_ACK received in 0 ms
Fri Jan 10 07:33:12 2020 user.info lora_pkt_fwd[4491]:
INFO: Disabling GPS mode for concentrator’s counter…
Fri Jan 10 07:33:12 2020 user.info lora_pkt_fwd[4491]: INFO: host/sx1301 time offset=(1578658747s:899172µs) - drift=-489µs
Fri Jan 10 07:33:12 2020 user.info lora_pkt_fwd[4491]: INFO: Enabling GPS mode for concentrator’s counter.

Fri Jan 10 07:33:12 2020 user.debug lora_pkt_fwd[4491]:

2020-01-10 12:33:12 UTC

Fri Jan 10 07:33:12 2020 user.debug lora_pkt_fwd[4491]: ### [UPSTREAM] ###
Fri Jan 10 07:33:12 2020 user.debug lora_pkt_fwd[4491]: # RF packets received by concentrator: 0
Fri Jan 10 07:33:12 2020 user.debug lora_pkt_fwd[4491]: [truncated] , CRC_FAIL: 0.00%, NO_CRC: 0.00%
Fri Jan 10 07:33:12 2020 user.debug lora_pkt_fwd[4491]: # RF packets forwarded: 0 (0 bytes)
Fri Jan 10 07:33:12 2020 user.debug lora_pkt_fwd[4491]: # PUSH_DATA datagrams sent: 1 (178 bytes)
Fri Jan 10 07:33:12 2020 user.debug lora_pkt_fwd[4491]: [truncated]
Fri Jan 10 07:33:12 2020 user.debug lora_pkt_fwd[4491]: ### [DOWNSTREAM] ###
Fri Jan 10 07:33:12 2020 user.debug lora_pkt_fwd[4491]: # PULL_DATA sent: 5 (100.00 0x0.0000000000005p-992cknowledged)
Fri Jan 10 07:33:12 2020 user.debug lora_pkt_fwd[4491]: # PULL_RESP(onse) datagrams received: 0 (0 bytes)
Fri Jan 10 07:33:12 2020 user.debug lora_pkt_fwd[4491]: # RF packets sent to concentrator: 0 (0 bytes)
Fri Jan 10 07:33:12 2020 user.debug lora_pkt_fwd[4491]: [truncated] (req:9, rej:0)
Fri Jan 10 07:33:12 2020 user.debug lora_pkt_fwd[4491]: [truncated] (req:9, rej:0)
Fri Jan 10 07:33:12 2020 user.debug lora_pkt_fwd[4491]: [truncated] (req:9, rej:0)
Fri Jan 10 07:33:12 2020 user.debug lora_pkt_fwd[4491]: # BEACON queued: 0
Fri Jan 10 07:33:12 2020 user.debug lora_pkt_fwd[4491]: # BEACON sent so far: 0
Fri Jan 10 07:33:12 2020 user.debug lora_pkt_fwd[4491]: # BEACON rejected: 0
Fri Jan 10 07:33:12 2020 user.debug lora_pkt_fwd[4491]: ### [JIT] ###
Fri Jan 10 07:33:12 2020 user.debug lora_pkt_fwd[4491]: # SX1301 time (PPS): 844598358, offset us 0
Fri Jan 10 07:33:12 2020 user.info lora_pkt_fwd[4491]: src/jitqueue.c:452:jit_print_queue(): INFO: [jit] queue is empty
Fri Jan 10 07:33:12 2020 user.debug lora_pkt_fwd[4491]: ### [GPS] ###
Fri Jan 10 07:33:12 2020 user.debug lora_pkt_fwd[4491]: # Invalid time reference (age: 1578659592 sec)
Fri Jan 10 07:33:12 2020 user.debug lora_pkt_fwd[4491]: # no valid GPS coordinates available yet
Fri Jan 10 07:33:12 2020 user.debug lora_pkt_fwd[4491]: ##### END #####
Fri Jan 10 07:33:12 2020 user.info lora_pkt_fwd[4491]:
JSON up: {“stat”:{“time”:“2020-01-10 12:33:12 UTC”,“lati”:##.87253,“long”:-##.27245,“alti”:40,“rxnb”:0,“rxok”:0,“rxfw”:0,“ackr”:100.0,“dwnb”:0,“txnb”:0,“cpur”:0.0,“memr”:0.0}}
Fri Jan 10 07:33:12 2020 daemon.info gwBridge[4531]: Stats : Protobuf size 90
Fri Jan 10 07:33:12 2020 user.info lora_pkt_fwd[4491]: INFO: [up] PUSH_ACK received in 5 ms
Fri Jan 10 07:33:13 2020 user.info lora_pkt_fwd[4491]: INFO: [down] PULL_ACK received in 0 ms
Fri Jan 10 07:33:18 2020 user.info lora_pkt_fwd[4491]: INFO: [down] PULL_ACK received in 0 ms
Fri Jan 10 07:33:23 2020 user.info lora_pkt_fwd[4491]: INFO: [down] PULL_ACK received in 0 ms
Fri Jan 10 07:33:29 2020 user.info lora_pkt_fwd[4491]: INFO: [down] PULL_ACK received in 0 ms
Fri Jan 10 07:33:34 2020 user.info lora_pkt_fwd[4491]: INFO: [down] PULL_ACK received in 0 ms
Fri Jan 10 07:33:39 2020 user.info lora_pkt_fwd[4491]: INFO: [down] PULL_ACK received in 0 ms
Fri Jan 10 07:33:42 2020 user.debug lora_pkt_fwd[4491]:

2020-01-10 12:33:42 UTC

Fri Jan 10 07:33:42 2020 user.debug lora_pkt_fwd[4491]: ### [UPSTREAM] ###
Fri Jan 10 07:33:42 2020 user.debug lora_pkt_fwd[4491]: # RF packets received by concentrator: 0
Fri Jan 10 07:33:42 2020 user.debug lora_pkt_fwd[4491]: [truncated] , CRC_FAIL: 0.00%, NO_CRC: 0.00%
Fri Jan 10 07:33:42 2020 user.debug lora_pkt_fwd[4491]: # RF packets forwarded: 0 (0 bytes)
Fri Jan 10 07:33:42 2020 user.debug lora_pkt_fwd[4491]: # PUSH_DATA datagrams sent: 1 (178 bytes)
Fri Jan 10 07:33:42 2020 user.debug lora_pkt_fwd[4491]: [truncated]
Fri Jan 10 07:33:42 2020 user.debug lora_pkt_fwd[4491]: ### [DOWNSTREAM] ###
Fri Jan 10 07:33:42 2020 user.debug lora_pkt_fwd[4491]: # PULL_DATA sent: 6 (100.00 0x0.0000000000005p-992cknowledged)
Fri Jan 10 07:33:42 2020 user.debug lora_pkt_fwd[4491]: # PULL_RESP(onse) datagrams received: 0 (0 bytes)
Fri Jan 10 07:33:42 2020 user.debug lora_pkt_fwd[4491]: # RF packets sent to concentrator: 0 (0 bytes)
Fri Jan 10 07:33:42 2020 user.debug lora_pkt_fwd[4491]: # SX1301 time (PPS): 844598358, offset us 0
Fri Jan 10 07:33:42 2020 user.info lora_pkt_fwd[4491]: src/jitqueue.c:452:jit_print_queue(): INFO: [jit] queue is empty
Fri Jan 10 07:33:42 2020 user.debug lora_pkt_fwd[4491]: ### [GPS] ###
Fri Jan 10 07:33:42 2020 user.debug lora_pkt_fwd[4491]: # Invalid time reference (age: 1578659622 sec)
Fri Jan 10 07:33:42 2020 user.debug lora_pkt_fwd[4491]: # no valid GPS coordinates available yet
Fri Jan 10 07:33:42 2020 user.debug lora_pkt_fwd[4491]: ##### END #####
Fri Jan 10 07:33:42 2020 user.info lora_pkt_fwd[4491]:
JSON up: {“stat”:{“time”:“2020-01-10 12:33:42 UTC”,“lati”:##.87253,“long”:-##.27245,“alti”:40,“rxnb”:0,“rxok”:0,“rxfw”:0,“ackr”:100.0,“dwnb”:0,“txnb”:0,“cpur”:0.0,“memr”:0.0}}
Fri Jan 10 07:33:42 2020 daemon.info gwBridge[4531]: Stats : Protobuf size 90
Fri Jan 10 07:33:42 2020 user.info lora_pkt_fwd[4491]: INFO: [up] PUSH_ACK received in 6 ms
Fri Jan 10 07:33:44 2020 user.debug lora_pkt_fwd[4491]: INFO: [filter] white list join filter is not enable
Fri Jan 10 07:33:44 2020 user.debug lora_pkt_fwd[4491]: Uplink Frame :
Fri Jan 10 07:33:44 2020 user.debug lora_pkt_fwd[4491]: 00 00 00 00 00 00 00 00
Fri Jan 10 07:33:44 2020 user.debug lora_pkt_fwd[4491]: 00 FA 85 B1 CB 85 EC 79
Fri Jan 10 07:33:44 2020 user.debug lora_pkt_fwd[4491]: 75 DC 07 E9 DF AE 2B
Fri Jan 10 07:33:44 2020 user.info lora_pkt_fwd[4491]:
JSON up: {“rxpk”:[{“tmst”:876586868,“chan”:5,“rfch”:1,“freq”:903.300000,“stat”:1,“modu”:“LORA”,“datr”:“SF10BW125”,“codr”:“4/5”,“lsnr”:10.3,“rssi”:-42,“size”:23,“data”:“AAAAAAAAAAAA+oWxy4XseXXcB+nfris=”}]}
Fri Jan 10 07:33:44 2020 daemon.info gwBridge[4531]: [Uplink] - Protobuf size 136
Fri Jan 10 07:33:44 2020 user.info lora_pkt_fwd[4491]: INFO: [up] PUSH_ACK received in 4 ms
Fri Jan 10 07:33:44 2020 user.info lora_pkt_fwd[4491]: INFO: [down] PULL_ACK received in 0 ms
Fri Jan 10 07:33:44 2020 user.info lora_pkt_fwd[4491]: INFO: [down] PULL_RESP received - token[112:214] :slight_smile:
Fri Jan 10 07:33:44 2020 user.info lora_pkt_fwd[4491]:
JSON down: {“txpk”:{“imme”:false,“tmst”:881586868,“freq”:926.300000,“rfch”:0,“powe”:20,“ncrc”:false,“modu”:“LORA”,“codr”:“4/5”,“datr”:“SF10BW500”,“ipol”:true,“size”:17,“data”:“IMceqVFl4F+Fs6Y0y3JRP+4=”}}
Fri Jan 10 07:33:44 2020 user.info lora_pkt_fwd[4491]: INFO: Packet ENQUENUE SUCCESS on sx1301 0
Fri Jan 10 07:33:44 2020 daemon.info gwBridge[4531]: [TxAck] - Protobuf size 32
Fri Jan 10 07:33:49 2020 user.info lora_pkt_fwd[4491]: src/lora_pkt_fwd.c:4077:thread_jit(): lgw_send done: count_us=881586868
Fri Jan 10 07:33:49 2020 user.info lora_pkt_fwd[4491]: INFO: [down] PULL_ACK received in 0 ms
Fri Jan 10 07:33:54 2020 user.info lora_pkt_fwd[4491]: INFO: [down] PULL_ACK received in 0 ms
Fri Jan 10 07:34:00 2020 user.info lora_pkt_fwd[4491]: INFO: [down] PULL_ACK received in 0 ms
Fri Jan 10 07:34:05 2020 user.info lora_pkt_fwd[4491]: INFO: [down] PULL_ACK received in 0 ms
Fri Jan 10 07:34:10 2020 user.info lora_pkt_fwd[4491]: INFO: [down] PULL_ACK received in 0 ms
Fri Jan 10 07:34:12 2020 user.info lora_pkt_fwd[4491]:
INFO: Disabling GPS mode for concentrator’s counter…
Fri Jan 10 07:34:12 2020 user.info lora_pkt_fwd[4491]: INFO: host/sx1301 time offset=(1578658747s:899039µs) - drift=-133µs
Fri Jan 10 07:34:12 2020 user.info lora_pkt_fwd[4491]: INFO: Enabling GPS mode for concentrator’s counter.

Fri Jan 10 07:34:12 2020 user.debug lora_pkt_fwd[4491]:

2020-01-10 12:34:12 UTC

Fri Jan 10 07:34:12 2020 user.debug lora_pkt_fwd[4491]: ### [UPSTREAM] ###
Fri Jan 10 07:34:12 2020 user.debug lora_pkt_fwd[4491]: # RF packets received by concentrator: 1
Fri Jan 10 07:34:12 2020 user.debug lora_pkt_fwd[4491]: [truncated] , CRC_FAIL: 0.00%, NO_CRC: 0.00%
Fri Jan 10 07:34:12 2020 user.debug lora_pkt_fwd[4491]: # RF packets forwarded: 1 (23 bytes)
Fri Jan 10 07:34:12 2020 user.debug lora_pkt_fwd[4491]: # PUSH_DATA datagrams sent: 2 (385 bytes)
Fri Jan 10 07:34:12 2020 user.debug lora_pkt_fwd[4491]: [truncated]
Fri Jan 10 07:34:12 2020 user.debug lora_pkt_fwd[4491]: ### [DOWNSTREAM] ###
Fri Jan 10 07:34:12 2020 user.debug lora_pkt_fwd[4491]: # PULL_DATA sent: 6 (100.00 0x0.0000000000005p-992cknowledged)
Fri Jan 10 07:34:12 2020 user.debug lora_pkt_fwd[4491]: # PULL_RESP(onse) datagrams received: 1 (196 bytes)
Fri Jan 10 07:34:12 2020 user.debug lora_pkt_fwd[4491]: # RF packets sent to concentrator: 1 (17 bytes)
Fri Jan 10 07:34:12 2020 user.debug lora_pkt_fwd[4491]: # TX errors: 0
Fri Jan 10 07:34:12 2020 user.debug lora_pkt_fwd[4491]: [truncated] (req:10, rej:0)
Fri Jan 10 07:34:12 2020 user.debug lora_pkt_fwd[4491]: [truncated] (req:10, rej:0)
Fri Jan 10 07:34:12 2020 user.debug lora_pkt_fwd[4491]: [truncated] (req:10, rej:0)
Fri Jan 10 07:34:12 2020 user.debug lora_pkt_fwd[4491]: [truncated] (req:10, rej:0)
Fri Jan 10 07:34:12 2020 user.debug lora_pkt_fwd[4491]: # BEACON queued: 0
Fri Jan 10 07:34:12 2020 user.debug lora_pkt_fwd[4491]: # BEACON sent so far: 0
Fri Jan 10 07:34:12 2020 user.debug lora_pkt_fwd[4491]: # BEACON rejected: 0
Fri Jan 10 07:34:12 2020 user.debug lora_pkt_fwd[4491]: ### [JIT] ###
Fri Jan 10 07:34:12 2020 user.debug lora_pkt_fwd[4491]: # SX1301 time (PPS): 904600830, offset us 0
Fri Jan 10 07:34:12 2020 user.info lora_pkt_fwd[4491]: src/jitqueue.c:452:jit_print_queue(): INFO: [jit] queue is empty
Fri Jan 10 07:34:12 2020 user.debug lora_pkt_fwd[4491]: ### [GPS] ###
Fri Jan 10 07:34:12 2020 user.debug lora_pkt_fwd[4491]: # Invalid time reference (age: 1578659652 sec)
Fri Jan 10 07:34:12 2020 user.debug lora_pkt_fwd[4491]: # no valid GPS coordinates available yet
Fri Jan 10 07:34:12 2020 user.debug lora_pkt_fwd[4491]: ##### END #####
Fri Jan 10 07:34:12 2020 user.info lora_pkt_fwd[4491]:
JSON up: {“stat”:{“time”:“2020-01-10 12:34:12 UTC”,“lati”:##.87253,“long”:-##.27245,“alti”:40,“rxnb”:1,“rxok”:1,“rxfw”:1,“ackr”:100.0,“dwnb”:1,“txnb”:1,“cpur”:0.0,“memr”:0.0}}
Fri Jan 10 07:34:12 2020 daemon.info gwBridge[4531]: Stats : Protobuf size 98
Fri Jan 10 07:34:12 2020 user.info lora_pkt_fwd[4491]: INFO: [up] PUSH_ACK received in 5 ms
Fri Jan 10 07:34:15 2020 user.info lora_pkt_fwd[4491]: INFO: [down] PULL_ACK received in 0 ms
Fri Jan 10 07:34:20 2020 user.info lora_pkt_fwd[4491]: INFO: [down] PULL_ACK received in 0 ms
Fri Jan 10 07:34:26 2020 user.info lora_pkt_fwd[4491]: INFO: [down] PULL_ACK received in 0 ms