OTAA failed / Debugging device activation OTAA issues

I don’t think so, in this link https://www.st.com/content/st_com/en/products/embedded-software/mcus-embedded-software/stm32-embedded-software/stm32cube-expansion-packages/i-cube-lrwan.html you can see that from I-CUBE-LWAN_V1.1.0 the lorawan mac version used is V1.0.3.

You can also find a previous link which deals about this topic ==> https://forum.loraserver.io/t/lorawan-mac-version-1-0-3/1914

In my case I’m using I-CUBE-LWAN_V1.0.x (it works with loraserver) and I notified the same behavior with I-CUBE-LWAN_V1.1.0 that is to say join-request/accept loop.

Setting the device-profile to LoRaWAN 1.0.2 or 1.0.3 should not matter for LoRa Server as the only change in behavior of LoRa Server is between 1.0.x vs 1.1.x.

Yes I understand your point of view, normally with lorawan mac V1.0.3 implementation only class B devices could encounter an issue, but something is different from the release of I-CUBE-LRWAN_V1.1, certainly we have to get closer of STMicroelectronics to go deeper.

Julien, is the example code version you are using still available to download? I can’t find it anywhere.

Also, may I PM you about something.

Only the latest version is available from www.st.com but fortunately for you :wink: I have the .zip of I-CUBE-LRWAN_V.1.0.5 which work with lorawan mac version 1.0.2, if you are interested I can send you by email through google drive link.

@Gal @julien please note that there already is a v1.2.0 version of I-CUBE-LRWAN. Maybe that is worth trying?

I did try that version and after setting the connection data in commissioning.h and downloading it to my MCU nothing came through.

In fact, I have the same problem as you, whether the problem is solved now or not.

It is not resolved. I am using ABP whenever I need to test something.

Hello brocaar,
Why have I tried all the LoraWAN MAC versions and still have a join-request join-accept loop?

Hi @brocaar, thanks for your support.

Following the https://forum.loraserver.io/t/unable-to-receive-sensor-data-after-otaa/3428 thread, and after that uplink you see, the subsequent uplinks reach the “live lorawan frames” but they never reach the “live device data” tab.

As you can see here:

Can you help us understand what does this mean?

Thank you,
Best regards.
Miguel

Also having problems to OTAA join (with RN2483 and RHF76-052).

loraserver receives JoinRequest and issues JoinAccept:
loraserver1

gateway looks like this:
gateway/+/rx {“rxInfo”:{“mac”:“xxxxxxxxxxxxxxxxxx”,“timestamp”:1913704108,“frequency”:868299987,“channel”:0,“rfChain”:0,“crcStatus”:1,“codeRate”:“4/5”,“rssi”:-68,“loRaSNR”:9,“size”:23,“dataRate”:{“modulation”:“LORA”,“spreadFactor”:7,“bandwidth”:125},“board”:0,“antenna”:0},“phyPayload”:“ABAxAdB+1bNwQJ27/SrpMiLnbZeG51k=”}
gateway/+/tx {“token”:5804,“txInfo”:{“mac”:“xxxxxxxxxxxxxxxxxx”,“immediately”:false,“timestamp”:1918704108,“frequency”:868299987,“power”:14,“dataRate”:{“modulation”:“LORA”,“spreadFactor”:7,“bandwidth”:125},“codeRate”:“4/5”,“iPol”:true,“board”:0,“antenna”:0},“phyPayload”:“IOmnU702SgGjqNSTpJ+02PI=”}
gateway/+/ack {“mac”:“xxxxxxxxxxxxxxxxxxx”,“token”:0}

Hence, the nodes never receive a join accept.

ABP works fine here. And OTAA works fine with TTN but not here.

Using LoRaWAN 1.0.1 and 1.0.2, respectively, and https://github.com/things4u/ESP-1ch-Gateway-v5.0.

Any hints? Thanks a lot.

Good day!
I have a strange server behavior. We have two devices(1.0.2, OTAA) that, when turned on, send a message to join, you can see that the server responds to their acceptance, then the first messages are transmitted, and everything goes as expected, except for three things: the activation tab does not show activation keys , but there are information of battery and the device margin and third, messages on the mqtt are not transmitted!

мар 11 15:12:47 lws2 lora-app-server[970]: time="2019-03-11T15:12:47+03:00" level=info msg="js: request received" message_type=JoinReq receiver_id=7665676173693131 sender_id=000000 transaction_id=787587301
мар 11 15:12:47 lws2 lora-app-server[970]: time="2019-03-11T15:12:47+03:00" level=info msg="device-keys updated" dev_eui=393337386b375e0c
мар 11 15:12:47 lws2 lora-app-server[970]: time="2019-03-11T15:12:47+03:00" level=info msg="js: sending response" message_type=JoinAns receiver_id=000000 result_code=Success sender_id=7665676173693131 transaction_id=787587301
мар 11 15:13:03 lws2 lora-app-server[970]: time="2019-03-11T15:13:03+03:00" level=info msg="device updated" dev_eui=393337386b375e0c
мар 11 15:13:03 lws2 lora-app-server[970]: time="2019-03-11T15:13:03+03:00" level=info msg="handler/mqtt: publishing message" qos=0 topic=application/1/device/393337386b375e0c/status
мар 11 15:13:09 lws2 lora-app-server[970]: time="2019-03-11T15:13:09+03:00" level=info msg="handler/influxdb: status measurements written" dev_eui=393337386b375e0c

мар 11 15:12:47 lws2 loraserver[971]: time="2019-03-11T15:12:47+03:00" level=info msg="gateway/mqtt: uplink frame received"
мар 11 15:12:47 lws2 loraserver[971]: time="2019-03-11T15:12:47+03:00" level=info msg="packet(s) collected" dev_eui=393337386b375e0c gw_count=1 gw_ids=aad00dba19000013 mtype=JoinRequest
мар 11 15:12:47 lws2 loraserver[971]: time="2019-03-11T15:12:47+03:00" level=info msg="gateway/mqtt: uplink frame received"
мар 11 15:12:47 lws2 loraserver[971]: time="2019-03-11T15:12:47+03:00" level=info msg="device-queue flushed" dev_eui=393337386b375e0c
мар 11 15:12:47 lws2 loraserver[971]: time="2019-03-11T15:12:47+03:00" level=info msg="device-session saved" dev_addr=0186e52a dev_eui=393337386b375e0c
мар 11 15:12:47 lws2 loraserver[971]: time="2019-03-11T15:12:47+03:00" level=info msg="device-activation created" dev_eui=393337386b375e0c id=11764
мар 11 15:12:47 lws2 loraserver[971]: time="2019-03-11T15:12:47+03:00" level=info msg="device updated" dev_eui=393337386b375e0c
мар 11 15:12:47 lws2 loraserver[971]: time="2019-03-11T15:12:47+03:00" level=info msg="gateway/mqtt: publishing downlink frame" qos=0 topic=gateway/aad00dba19000013/tx
мар 11 15:12:47 lws2 loraserver[971]: time="2019-03-11T15:12:47+03:00" level=info msg="downlink-frames saved" dev_eui=393337386b375e0c token=44034
мар 11 15:12:47 lws2 loraserver[971]: time="2019-03-11T15:12:47+03:00" level=info msg="backend/gateway: downlink tx acknowledgement received" gateway_id=aad00dba19000013
мар 11 15:12:53 lws2 loraserver[971]: time="2019-03-11T15:12:53+03:00" level=info msg="gateway/mqtt: gateway stats packet received" gateway_id=21000000080e0e38
мар 11 15:12:53 lws2 loraserver[971]: time="2019-03-11T15:12:53+03:00" level=info msg="gateway updated" gateway_id=21000000080e0e38
мар 11 15:12:53 lws2 loraserver[971]: time="2019-03-11T15:12:53+03:00" level=info msg="gateway/mqtt: publishing gateway configuration" qos=0 topic=gateway/21000000080e0e38/config
мар 11 15:12:53 lws2 loraserver[971]: time="2019-03-11T15:12:53+03:00" level=info msg="metrics saved" aggregation="[MINUTE HOUR DAY MONTH]" name="gw:21000000080e0e38"
мар 11 15:12:57 lws2 loraserver[971]: time="2019-03-11T15:12:57+03:00" level=info msg="gateway/mqtt: uplink frame received"
мар 11 15:12:57 lws2 loraserver[971]: time="2019-03-11T15:12:57+03:00" level=info msg="rx info sent to network-controller" dev_eui=393337386b375e0c
мар 11 15:12:57 lws2 loraserver[971]: time="2019-03-11T15:12:57+03:00" level=info msg="pending mac-command deleted" cid=LinkCheckReq dev_eui=393337386b375e0c
мар 11 15:12:57 lws2 loraserver[971]: time="2019-03-11T15:12:57+03:00" level=info msg="device gateway rx-info meta-data saved" dev_eui=393337386b375e0c
мар 11 15:12:57 lws2 loraserver[971]: time="2019-03-11T15:12:57+03:00" level=info msg="device-session saved" dev_addr=0186e52a dev_eui=393337386b375e0c
мар 11 15:12:57 lws2 loraserver[971]: time="2019-03-11T15:12:57+03:00" level=info msg="gateway/mqtt: uplink frame received"
мар 11 15:12:57 lws2 loraserver[971]: time="2019-03-11T15:12:57+03:00" level=info msg="requesting device-status" dev_eui=393337386b375e0c
мар 11 15:12:57 lws2 loraserver[971]: time="2019-03-11T15:12:57+03:00" level=info msg="pending mac-command block set" cid=LinkCheckReq commands=1 dev_eui=393337386b375e0c
мар 11 15:12:57 lws2 loraserver[971]: time="2019-03-11T15:12:57+03:00" level=info msg="pending mac-command block set" cid=DevStatusReq commands=1 dev_eui=393337386b375e0c
мар 11 15:12:57 lws2 loraserver[971]: time="2019-03-11T15:12:57+03:00" level=info msg="pending mac-command block set" cid=RXTimingSetupReq commands=1 dev_eui=393337386b375e0c
мар 11 15:12:57 lws2 loraserver[971]: time="2019-03-11T15:12:57+03:00" level=info msg="gateway/mqtt: publishing downlink frame" qos=0 topic=gateway/aad00dba19000013/tx
мар 11 15:12:57 lws2 loraserver[971]: time="2019-03-11T15:12:57+03:00" level=info msg="device-session saved" dev_addr=0186e52a dev_eui=393337386b375e0c
мар 11 15:12:57 lws2 loraserver[971]: time="2019-03-11T15:12:57+03:00" level=info msg="downlink-frames saved" dev_eui=393337386b375e0c token=22153
мар 11 15:12:57 lws2 loraserver[971]: time="2019-03-11T15:12:57+03:00" level=info msg="backend/gateway: downlink tx acknowledgement received" gateway_id=aad00dba19000013
мар 11 15:13:03 lws2 loraserver[971]: time="2019-03-11T15:13:03+03:00" level=info msg="gateway/mqtt: uplink frame received"
мар 11 15:13:03 lws2 loraserver[971]: time="2019-03-11T15:13:03+03:00" level=info msg="gateway/mqtt: uplink frame received"
мар 11 15:13:03 lws2 loraserver[971]: time="2019-03-11T15:13:03+03:00" level=info msg="gateway/mqtt: uplink frame received"
мар 11 15:13:03 lws2 loraserver[971]: time="2019-03-11T15:13:03+03:00" level=info msg="gateway/mqtt: uplink frame received"
мар 11 15:13:03 lws2 loraserver[971]: time="2019-03-11T15:13:03+03:00" level=info msg="rx info sent to network-controller" dev_eui=393337386b375e0c
мар 11 15:13:03 lws2 loraserver[971]: time="2019-03-11T15:13:03+03:00" level=info msg="pending mac-command deleted" cid=DevStatusReq dev_eui=393337386b375e0c
мар 11 15:13:03 lws2 loraserver[971]: time="2019-03-11T15:13:03+03:00" level=info msg="dev_status_ans answer received" battery=255 dev_eui=393337386b375e0c margin=31
мар 11 15:13:03 lws2 loraserver[971]: time="2019-03-11T15:13:03+03:00" level=info msg="pending mac-command deleted" cid=RXTimingSetupReq dev_eui=393337386b375e0c
мар 11 15:13:03 lws2 loraserver[971]: time="2019-03-11T15:13:03+03:00" level=info msg="rx_timing_setup request acknowledged" dev_eui=393337386b375e0c rx_delay=1
мар 11 15:13:03 lws2 loraserver[971]: time="2019-03-11T15:13:03+03:00" level=info msg="pending mac-command deleted" cid=LinkCheckReq dev_eui=393337386b375e0c
мар 11 15:13:03 lws2 loraserver[971]: time="2019-03-11T15:13:03+03:00" level=info msg="device gateway rx-info meta-data saved" dev_eui=393337386b375e0c
мар 11 15:13:03 lws2 loraserver[971]: time="2019-03-11T15:13:03+03:00" level=info msg="device-session saved" dev_addr=0186e52a dev_eui=393337386b375e0c
мар 11 15:13:03 lws2 loraserver[971]: time="2019-03-11T15:13:03+03:00" level=info msg="pending mac-command block set" cid=LinkCheckReq commands=1 dev_eui=393337386b375e0c
мар 11 15:13:03 lws2 loraserver[971]: time="2019-03-11T15:13:03+03:00" level=info msg="gateway/mqtt: publishing downlink frame" qos=0 topic=gateway/aad00dba19000013/tx
мар 11 15:13:03 lws2 loraserver[971]: time="2019-03-11T15:13:03+03:00" level=info msg="device-session saved" dev_addr=0186e52a dev_eui=393337386b375e0c
мар 11 15:13:03 lws2 loraserver[971]: time="2019-03-11T15:13:03+03:00" level=info msg="downlink-frames saved" dev_eui=393337386b375e0c token=32355
мар 11 15:13:03 lws2 loraserver[971]: time="2019-03-11T15:13:03+03:00" level=info msg="backend/gateway: downlink tx acknowledgement received" gateway_id=aad00dba19000013
мар 11 15:13:07 lws2 loraserver[971]: time="2019-03-11T15:13:07+03:00" level=info msg="gateway/mqtt: gateway stats packet received" gateway_id=0000985dad86df5b
мар 11 15:13:07 lws2 loraserver[971]: time="2019-03-11T15:13:07+03:00" level=info msg="gateway updated" gateway_id=0000985dad86df5b
мар 11 15:13:07 lws2 loraserver[971]: time="2019-03-11T15:13:07+03:00" level=info msg="gateway/mqtt: publishing gateway configuration" qos=0 topic=gateway/0000985dad86df5b/config

мар 11 15:12:47 lws2 lora-gateway-bridge[976]: time="2019-03-11T15:12:47+03:00" level=info msg="gateway: rxpk packet received" addr="192.168.111.92:52859" data="ADExaXNhZ2V2DF43azg3MzmjkYUpLsc=" mac=aad00dba19000013
мар 11 15:12:47 lws2 lora-gateway-bridge[976]: time="2019-03-11T15:12:47+03:00" level=info msg="backend: publishing packet" qos=0 topic=gateway/aad00dba19000013/rx
мар 11 15:12:47 lws2 lora-gateway-bridge[976]: time="2019-03-11T15:12:47+03:00" level=info msg="gateway: rxpk packet received" addr="192.168.111.159:34685" data="ADExaXNhZ2V2DF43azg3MzmjkYUpLsc=" mac=0000985dad86df5b
мар 11 15:12:47 lws2 lora-gateway-bridge[976]: time="2019-03-11T15:12:47+03:00" level=info msg="backend: publishing packet" qos=0 topic=gateway/0000985dad86df5b/rx
мар 11 15:12:47 lws2 lora-gateway-bridge[976]: time="2019-03-11T15:12:47+03:00" level=info msg="backend: downlink packet received" topic=gateway/aad00dba19000013/tx
мар 11 15:12:47 lws2 lora-gateway-bridge[976]: time="2019-03-11T15:12:47+03:00" level=info msg="backend: publishing packet" qos=0 topic=gateway/aad00dba19000013/ack
мар 11 15:12:53 lws2 lora-gateway-bridge[976]: time="2019-03-11T15:12:53+03:00" level=info msg="gateway: stat packet received" addr="192.168.111.74:42690" mac=21000000080e0e38
мар 11 15:12:53 lws2 lora-gateway-bridge[976]: time="2019-03-11T15:12:53+03:00" level=info msg="backend: publishing packet" qos=0 topic=gateway/21000000080e0e38/stats
мар 11 15:12:53 lws2 lora-gateway-bridge[976]: time="2019-03-11T15:12:53+03:00" level=info msg="backend: config packet received" topic=gateway/21000000080e0e38/config
мар 11 15:12:53 lws2 lora-gateway-bridge[976]: time="2019-03-11T15:12:53+03:00" level=warning msg="gateway: configuration was not applied, gateway is not configured for managed configuration" mac=21000000080e0e38
мар 11 15:12:57 lws2 lora-gateway-bridge[976]: time="2019-03-11T15:12:57+03:00" level=info msg="gateway: rxpk packet received" addr="192.168.111.92:52859" data="QCrlhgEAAAAAu439aQE=" mac=aad00dba19000013
мар 11 15:12:57 lws2 lora-gateway-bridge[976]: time="2019-03-11T15:12:57+03:00" level=info msg="backend: publishing packet" qos=0 topic=gateway/aad00dba19000013/rx
мар 11 15:12:57 lws2 lora-gateway-bridge[976]: time="2019-03-11T15:12:57+03:00" level=info msg="gateway: rxpk packet received" addr="192.168.111.159:34685" data="QCrlhgEAAAAAu439aQE=" mac=0000985dad86df5b
мар 11 15:12:57 lws2 lora-gateway-bridge[976]: time="2019-03-11T15:12:57+03:00" level=info msg="backend: publishing packet" qos=0 topic=gateway/0000985dad86df5b/rx
мар 11 15:12:57 lws2 lora-gateway-bridge[976]: time="2019-03-11T15:12:57+03:00" level=info msg="backend: downlink packet received" topic=gateway/aad00dba19000013/tx
мар 11 15:12:57 lws2 lora-gateway-bridge[976]: time="2019-03-11T15:12:57+03:00" level=info msg="backend: publishing packet" qos=0 topic=gateway/aad00dba19000013/ack
мар 11 15:13:03 lws2 lora-gateway-bridge[976]: time="2019-03-11T15:13:03+03:00" level=info msg="gateway: rxpk packet received" addr="192.168.111.92:52859" data=QCrlhgEAAQAAOoUyumnuJE83 mac=aad00dba19000013
мар 11 15:13:03 lws2 lora-gateway-bridge[976]: time="2019-03-11T15:13:03+03:00" level=info msg="gateway: rxpk packet received" addr="192.168.111.92:52859" data=QCrlhgEAAQAAOoUyumnuJE83 mac=aad00dba19000013
мар 11 15:13:03 lws2 lora-gateway-bridge[976]: time="2019-03-11T15:13:03+03:00" level=info msg="backend: publishing packet" qos=0 topic=gateway/aad00dba19000013/rx
мар 11 15:13:03 lws2 lora-gateway-bridge[976]: time="2019-03-11T15:13:03+03:00" level=info msg="backend: publishing packet" qos=0 topic=gateway/aad00dba19000013/rx
мар 11 15:13:03 lws2 lora-gateway-bridge[976]: time="2019-03-11T15:13:03+03:00" level=info msg="gateway: rxpk packet received" addr="192.168.111.74:42690" data=QCrlhgEAAQAAOoUyumnuJE83 mac=21000000080e0e38
мар 11 15:13:03 lws2 lora-gateway-bridge[976]: time="2019-03-11T15:13:03+03:00" level=info msg="backend: publishing packet" qos=0 topic=gateway/21000000080e0e38/rx
мар 11 15:13:03 lws2 lora-gateway-bridge[976]: time="2019-03-11T15:13:03+03:00" level=info msg="gateway: rxpk packet received" addr="192.168.111.159:34685" data=QCrlhgEAAQAAOoUyumnuJE83 mac=0000985dad86df5b
мар 11 15:13:03 lws2 lora-gateway-bridge[976]: time="2019-03-11T15:13:03+03:00" level=info msg="backend: publishing packet" qos=0 topic=gateway/0000985dad86df5b/rx
мар 11 15:13:03 lws2 lora-gateway-bridge[976]: time="2019-03-11T15:13:03+03:00" level=info msg="backend: downlink packet received" topic=gateway/aad00dba19000013/tx
мар 11 15:13:03 lws2 lora-gateway-bridge[976]: time="2019-03-11T15:13:03+03:00" level=info msg="backend: publishing packet" qos=0 topic=gateway/aad00dba19000013/ack
мар 11 15:13:07 lws2 lora-gateway-bridge[976]: time="2019-03-11T15:13:07+03:00" level=info msg="gateway: stat packet received" addr="192.168.111.159:34685" mac=0000985dad86df5b
мар 11 15:13:07 lws2 lora-gateway-bridge[976]: time="2019-03-11T15:13:07+03:00" level=info msg="backend: publishing packet" qos=0 topic=gateway/0000985dad86df5b/stats
мар 11 15:13:07 lws2 lora-gateway-bridge[976]: time="2019-03-11T15:13:07+03:00" level=info msg="backend: config packet received" topic=gateway/0000985dad86df5b/config
мар 11 15:13:07 lws2 lora-gateway-bridge[976]: time="2019-03-11T15:13:07+03:00" level=warning msg="gateway: configuration was not applied, gateway is not configured for managed configuration" mac=0000985dad86df5b
мар 11 15:13:11 lws2 lora-gateway-bridge[976]: time="2019-03-11T15:13:11+03:00" level=info msg="gateway: stat packet received" addr="192.168.111.92:52859" mac=aad00dba19000013
мар 11 15:13:11 lws2 lora-gateway-bridge[976]: time="2019-03-11T15:13:11+03:00" level=info msg="backend: publishing packet" qos=0 topic=gateway/aad00dba19000013/stats
мар 11 15:13:11 lws2 lora-gateway-bridge[976]: time="2019-03-11T15:13:11+03:00" level=info msg="backend: config packet received" topic=gateway/aad00dba19000013/config
мар 11 15:13:11 lws2 lora-gateway-bridge[976]: time="2019-03-11T15:13:11+03:00" level=warning msg="gateway: configuration was not applied, gateway is not configured for managed configuration" mac=aad00dba19000013

image

Hi, does anyone found a solution for this yet?

…disconnect (power off) the node for 24 hrs and then reconnect it.

Hi, we experienced a similar issue. Redis was out of memory (>1G) so we had to reinitialize Redis and allocate more memory. Some nodes are not able to rejoin. Is there a way to remove ‘old’ node sessions from redis? When we remove the node data from Lora app server and re-enter the node doesn’t rejoin, only after a manual reset.

1 Like

I’m having the issue where a device is stuck in a Join Request-Join Accept loop with a sensor made by Netvox.

Oddly, other Netvox sensors work OK and this sensor in particular works OK with ThingsNetwork and Loriot.io.

I have tried it with all versions of Lorawan supported by LoraServer, 1.0.0-1.1.0.

Apr 05 10:06:27 loraserver-1 loraserver[945]: time="2019-04-05T10:06:27Z" level=info 
msg="gateway/mqtt: uplink frame received"
Apr 05 10:06:27 loraserver-1 loraserver[945]: time="2019-04-05T10:06:27Z" level=info 
msg="gateway/mqtt: uplink frame received"
Apr 05 10:06:28 loraserver-1 loraserver[945]: time="2019-04-05T10:06:28Z" level=info 
msg="packet(s) collected" dev_eui=00137a1000000976 gw_count=2 
gw_ids="647fdafffe00744f, fcc23dfffe0f0d35" mtype=JoinRequest
Apr 05 10:06:28 loraserver-1 loraserver[945]: time="2019-04-05T10:06:28Z" level=info 
msg="device-queue flushed" dev_eui=00137a1000000976
Apr 05 10:06:28 loraserver-1 loraserver[945]: time="2019-04-05T10:06:28Z" level=info 
msg="device-session saved" dev_addr=0179f6df dev_eui=00137a1000000976
Apr 05 10:06:28 loraserver-1 loraserver[945]: time="2019-04-05T10:06:28Z" level=info 
msg="device-activation created" dev_eui=00137a1000000976 id=570
Apr 05 10:06:28 loraserver-1 loraserver[945]: time="2019-04-05T10:06:28Z" level=info 
msg="gateway/mqtt: publishing downlink frame" qos=0 
topic=gateway/647fdafffe00744f/tx
Apr 05 10:06:28 loraserver-1 loraserver[945]: time="2019-04-05T10:06:28Z" level=info 
msg="downlink-frames saved" dev_eui=00137a1000000976 token=24467

Please can you send it to me.
Thanks a lot.

Please does anyone found a solution to the joinRequest joinAccept loop without the activation of the device. I really need help.
Thanks a lot.