UnknownDevEUI error

almaz · November 19, 2018, 6:11pm

Hi!
Here what I see in lora-app-server logs:

INFO[0606] js: request received                          message_type=JoinReq receiver_id=70b3d57ed000f706 sender_id=000000 transaction_id=347210067
INFO[0606] js: sending response                          message_type=JoinAns receiver_id=000000 result_code=UnknownDevEUI sender_id=70b3d57ed000f706 transaction_id=347210067
INFO[1806] finished streaming call with code Canceled    error="rpc error: code = Canceled desc = context canceled" grpc.code=Canceled grpc.method=StreamFrameLogs grpc.service=api.GatewayService grpc.start_time="2018-11-19T18:00:02Z" grpc.time_ms=519378.2 peer.address="127.0.0.1:50210" span.kind=server system=grpc

And here what I see in loraserver logs:

INFO[3004] gateway updated                               gateway_id=aa555a0000000005
INFO[3034] gateway/mqtt: gateway stats packet received   gateway_id=aa555a0000000005
INFO[3034] gateway updated                               gateway_id=aa555a0000000005
INFO[3064] gateway/mqtt: gateway stats packet received   gateway_id=aa555a0000000005
INFO[3064] gateway updated                               gateway_id=aa555a0000000005
INFO[3068] gateway/mqtt: uplink frame received
INFO[3068] packet(s) collected                           dev_eui=343934354c377516 gw_count=1 gw_ids=aa555a0000000005 mtype=JoinRequest
INFO[3068] finished streaming call with code OK          grpc.code=OK grpc.method=StreamFrameLogsForDevice grpc.service=ns.NetworkServerService grpc.start_time="2018-11-19T17:13:55Z" grpc.time_ms=275441.7 peer.address="172.17.0.1:56162" span.kind=server system=grpc
ERRO[3068] processing uplink frame error                 data_base64="AAb3ANB+1bNwFnU3TDU0OTQeTRspqDo=" error="join-request to join-server error: response error, code: UnknownDevEUI, description: get device-keys error: object does not exist"
INFO[3094] gateway/mqtt: gateway stats packet received   gateway_id=aa555a0000000005
INFO[3094] gateway updated                               gateway_id=aa555a0000000005
INFO[3124] gateway/mqtt: gateway stats packet received   gateway_id=aa555a0000000005
INFO[3124] gateway updated                               gateway_id=aa555a0000000005

But I have 343934354c377516 in list of devices:

What else did I miss? Can someone point me?

brocaar · November 20, 2018, 2:19am

It seems you have not yet added the keys for this device (in LoRa App Server).

almaz · November 20, 2018, 5:33pm

Do you mean Application key?
Can’t find this field in Lora-App-Server v2.0.
I remember such field existed in prev version of lora-app-server:

But now I can’t find this field. Looked through all the web interface without luck.
No any setting in lora-app-server.toml as well.

almaz · November 21, 2018, 1:11pm

Anyone can help me please?
I found just one way to add DevEui while adding device to application in web interface.
And I use exactly that DevEui that lora-app-server returns me us UnknownDevEui.
I use loraserver-docker built by single command docker-compose up -d.

iegomez · November 21, 2018, 1:15pm

In the newest version the Application Key is in the exact same place, just under the Keys (OTAA) tab for device (given its device profile is indeed OTAA and not ABP activated).

almaz · November 21, 2018, 1:59pm

Magic!
I can’t see this field:

KEYS (OTAA) field is empty!

almaz · November 21, 2018, 4:46pm

Finally I saw it just from Tor browser.
Here are lora-app-server logs from Opera (can’t see KEYS(OTAA) ):

time="2018-11-21T16:41:42Z" level=info msg="finished unary call with code OK" grpc.code=OK grpc.method=Profile grpc.service=api.InternalService grpc.start_time="2018-11-21T16:41:42Z" grpc.time_ms=6.214 peer.address="127.0.0.1:52982" span.kind=server system=grpc
time="2018-11-21T16:41:42Z" level=info msg="finished unary call with code OK" grpc.code=OK grpc.method=Get grpc.service=api.ApplicationService grpc.start_time="2018-11-21T16:41:42Z" grpc.time_ms=8.26 peer.address="127.0.0.1:52974" span.kind=server system=grpc
time="2018-11-21T16:41:42Z" level=info msg="finished client unary call" grpc.code=OK grpc.method=GetDevice grpc.service=ns.NetworkServerService grpc.time_ms=1.9 span.kind=client system=grpc
time="2018-11-21T16:41:42Z" level=info msg="finished unary call with code OK" grpc.code=OK grpc.method=Get grpc.service=api.DeviceService grpc.start_time="2018-11-21T16:41:42Z" grpc.time_ms=14 peer.address="127.0.0.1:52978" span.kind=server system=grpc
time="2018-11-21T16:41:42Z" level=info msg="finished unary call with code OK" grpc.code=OK grpc.method=List grpc.service=api.OrganizationService grpc.start_time="2018-11-21T16:41:42Z" grpc.time_ms=16.465 peer.address="127.0.0.1:52988" span.kind=server system=grpc
time="2018-11-21T16:41:42Z" level=info msg="finished unary call with code OK" grpc.code=OK grpc.method=Get grpc.service=api.OrganizationService grpc.start_time="2018-11-21T16:41:42Z" grpc.time_ms=18.887 peer.address="127.0.0.1:52988" span.kind=server system=grpc
time="2018-11-21T16:41:42Z" level=info msg="finished client unary call" grpc.code=OK grpc.method=GetDeviceProfile grpc.service=ns.NetworkServerService grpc.time_ms=1.984 span.kind=client system=grpc
time="2018-11-21T16:41:42Z" level=info msg="finished unary call with code OK" grpc.code=OK grpc.method=Get grpc.service=api.DeviceProfileService grpc.start_time="2018-11-21T16:41:42Z" grpc.time_ms=31.951 peer.address="127.0.0.1:52994" span.kind=server system=grpc
time="2018-11-21T16:41:43Z" level=info msg="finished unary call with code OK" grpc.code=OK grpc.method=List grpc.service=api.OrganizationService grpc.start_time="2018-11-21T16:41:43Z" grpc.time_ms=7.348 peer.address="127.0.0.1:52988" span.kind=server system=grpc
time="2018-11-21T16:41:43Z" level=info msg="finished unary call with code OK" grpc.code=OK grpc.method=Get grpc.service=api.OrganizationService grpc.start_time="2018-11-21T16:41:43Z" grpc.time_ms=6.795 peer.address="127.0.0.1:52988" span.kind=server system=grpc
time="2018-11-21T16:41:43Z" level=info msg="finished unary call with code NotFound" error="rpc error: code = NotFound desc = object does not exist" grpc.code=NotFound grpc.method=GetKeys grpc.service=api.DeviceService grpc.start_time="2018-11-21T16:41:43Z" grpc.time_ms=6.457 peer.address="127.0.0.1:52978" span.kind=server system=grpc
time="2018-11-21T16:41:43Z" level=info msg="finished unary call with code OK" grpc.code=OK grpc.method=List grpc.service=api.OrganizationService grpc.start_time="2018-11-21T16:41:43Z" grpc.time_ms=7.323 peer.address="127.0.0.1:52988" span.kind=server system=grpc
time="2018-11-21T16:41:43Z" level=info msg="finished unary call with code OK" grpc.code=OK grpc.method=Get grpc.service=api.OrganizationService grpc.start_time="2018-11-21T16:41:43Z" grpc.time_ms=5.981 peer.address="127.0.0.1:52988" span.kind=server system=grpc
time="2018-11-21T16:41:43Z" level=info msg="finished unary call with code OK" grpc.code=OK grpc.method=Get grpc.service=api.OrganizationService grpc.start_time="2018-11-21T16:41:43Z" grpc.time_ms=6.252 peer.address="127.0.0.1:52988" span.kind=server system=grpc

There are lora-app-server logs while browsing from Tor (can see KEYS(OTAA):

time="2018-11-21T16:42:35Z" level=info msg="finished unary call with code OK" grpc.code=OK grpc.method=Get grpc.service=api.ApplicationService grpc.start_time="2018-11-21T16:42:35Z" grpc.time_ms=4.28 peer.address="127.0.0.1:52974" span.kind=server system=grpc
time="2018-11-21T16:42:35Z" level=info msg="finished unary call with code OK" grpc.code=OK grpc.method=Branding grpc.service=api.InternalService grpc.start_time="2018-11-21T16:42:35Z" grpc.time_ms=0.027 peer.address="127.0.0.1:52982" span.kind=server system=grpc
time="2018-11-21T16:42:35Z" level=info msg="finished unary call with code OK" grpc.code=OK grpc.method=Profile grpc.service=api.InternalService grpc.start_time="2018-11-21T16:42:35Z" grpc.time_ms=11.579 peer.address="127.0.0.1:52982" span.kind=server system=grpc
time="2018-11-21T16:42:35Z" level=info msg="finished client unary call" grpc.code=OK grpc.method=GetDevice grpc.service=ns.NetworkServerService grpc.time_ms=2.254 span.kind=client system=grpc
time="2018-11-21T16:42:35Z" level=info msg="finished unary call with code OK" grpc.code=OK grpc.method=Get grpc.service=api.DeviceService grpc.start_time="2018-11-21T16:42:35Z" grpc.time_ms=12.938 peer.address="127.0.0.1:52978" span.kind=server system=grpc
time="2018-11-21T16:42:35Z" level=info msg="finished client unary call" grpc.code=OK grpc.method=GetDeviceProfile grpc.service=ns.NetworkServerService grpc.time_ms=1.841 span.kind=client system=grpc
time="2018-11-21T16:42:35Z" level=info msg="finished unary call with code OK" grpc.code=OK grpc.method=Get grpc.service=api.DeviceProfileService grpc.start_time="2018-11-21T16:42:35Z" grpc.time_ms=8.02 peer.address="127.0.0.1:52994" span.kind=server system=grpc
time="2018-11-21T16:42:35Z" level=info msg="finished unary call with code OK" grpc.code=OK grpc.method=Get grpc.service=api.OrganizationService grpc.start_time="2018-11-21T16:42:35Z" grpc.time_ms=7.383 peer.address="127.0.0.1:52988" span.kind=server system=grpc
time="2018-11-21T16:42:35Z" level=info msg="finished unary call with code OK" grpc.code=OK grpc.method=List grpc.service=api.OrganizationService grpc.start_time="2018-11-21T16:42:35Z" grpc.time_ms=9.655 peer.address="127.0.0.1:52988" span.kind=server system=grpc
time="2018-11-21T16:42:36Z" level=info msg="finished unary call with code OK" grpc.code=OK grpc.method=Get grpc.service=api.OrganizationService grpc.start_time="2018-11-21T16:42:36Z" grpc.time_ms=6.226 peer.address="127.0.0.1:52988" span.kind=server system=grpc
time="2018-11-21T16:42:36Z" level=info msg="finished unary call with code OK" grpc.code=OK grpc.method=List grpc.service=api.OrganizationService grpc.start_time="2018-11-21T16:42:36Z" grpc.time_ms=5.54 peer.address="127.0.0.1:52988" span.kind=server system=grpc
time="2018-11-21T16:42:36Z" level=info msg="finished unary call with code NotFound" error="rpc error: code = NotFound desc = object does not exist" grpc.code=NotFound grpc.method=GetKeys grpc.service=api.DeviceService grpc.start_time="2018-11-21T16:42:36Z" grpc.time_ms=3.793 peer.address="127.0.0.1:52978" span.kind=server system=grpc
time="2018-11-21T16:42:36Z" level=info msg="finished unary call with code OK" grpc.code=OK grpc.method=List grpc.service=api.OrganizationService grpc.start_time="2018-11-21T16:42:36Z" grpc.time_ms=7.686 peer.address="127.0.0.1:52988" span.kind=server system=grpc
time="2018-11-21T16:42:36Z" level=info msg="finished unary call with code OK" grpc.code=OK grpc.method=Get grpc.service=api.OrganizationService grpc.start_time="2018-11-21T16:42:36Z" grpc.time_ms=4.643 peer.address="127.0.0.1:52988" span.kind=server system=grpc
time="2018-11-21T16:42:37Z" level=info msg="finished unary call with code OK" grpc.code=OK grpc.method=Get grpc.service=api.OrganizationService grpc.start_time="2018-11-21T16:42:37Z" grpc.time_ms=5.177 peer.address="127.0.0.1:52988" span.kind=server system=grpc

almaz · November 21, 2018, 4:51pm

No, the issue in Opera.
Google Chrome shows me KEYS(OTAA) field too.

brocaar · December 1, 2018, 11:53am

Could you great a GitHub issue if you think this is a bug?