Skip to content

[Bug]: RAK4630 ETH stops communicating over LoRa after few days (radiolib err -7) #8462

Description

@gdiciocco

Category

Other

Hardware

Rak4631

Is this bug report about any UI component firmware like InkHUD or Meshtatic UI (MUI)?

  • Meshtastic UI aka MUI colorTFT
  • InkHUD ePaper
  • OLED slide UI on any display

Firmware Version

2.7.5 - 2.6.13

Description

Tried two different boards (host - mcu/radio), same ethernet+poe (even without em)

Firmware built locally and uploaded by dfu.

After a few days of correct operation the device stops communicating with the mesh, from the logs the errors are about the radiolib error -7.

RadioLibInterface.cpp:425 (state = -7, see logs)

using target rak4631_eth_gw (but also tried the plain version)

Debugging session snapshot of running and misbehaving unit here (ozone):

https://drive.google.com/file/d/1sKJJGREJZ_NWNPwkb-bBfz614kc8-V9X/view?usp=sharing

Relevant log output

ERROR | 22:14:43 126800 [RadioIf] Ignore received packet due to error=-7
DEBUG | 22:14:43 126800 [RadioIf] Packet RX (noise?) : 184ms
ERROR | 22:14:46 126802 [RadioIf] Ignore received packet due to error=-7
DEBUG | 22:14:46 126802 [RadioIf] Packet RX (noise?) : 184ms
ERROR | 22:14:59 126815 [RadioIf] Ignore received packet due to error=-7
DEBUG | 22:14:59 126815 [RadioIf] Packet RX (noise?) : 184ms
DEBUG | 22:15:03 126819 [Power] Battery: usbPower=1, isCharging=1, batMv=4167, batPct=98
ERROR | 22:15:14 126831 [RadioIf] Ignore received packet due to error=-7
ERROR | 22:16:39 126915 [RadioIf] Ignore received packet due to error=-7
DEBUG | 22:16:39 126915 [RadioIf] Packet RX (noise?) : 184ms
DEBUG | 22:16:43 126919 [Power] Battery: usbPower=1, isCharging=1, batMv=4167, batPct=98
ERROR | 22:16:52 126929 [RadioIf] Ignore received packet due to error=-7
DEBUG | 22:16:52 126929 [RadioIf] Packet RX (noise?) : 184ms
DEBUG | 22:17:03 126939 [Power] Battery: usbPower=1, isCharging=1, batMv=4166, batPct=98
ERROR | 22:17:03 126940 [RadioIf] Ignore received packet due to error=-7
DEBUG | 22:17:03 126940 [RadioIf] Packet RX (noise?) : 184ms
DEBUG | 22:17:23 126959 [Power] Battery: usbPower=1, isCharging=1, batMv=4166, batPct=98
ERROR | 22:17:43 126979 [RadioIf] Ignore received packet due to error=-7
DEBUG | 22:17:43 126979 [RadioIf] Packet RX (noise?) : 184ms
DEBUG | 22:17:43 126979 [Power] Battery: usbPower=1, isCharging=1, batMv=4164, batPct=98
ERROR | 22:18:00 126996 [RadioIf] Ignore received packet due to error=-7
DEBUG | 22:18:00 126996 [RadioIf] Packet RX (noise?) : 184ms
DEBUG | 22:18:03 126999 [Power] Battery: usbPower=1, isCharging=1, batMv=4164, batPct=98
ERROR | 22:18:09 127006 [RadioIf] Ignore received packet due to error=-7
DEBUG | 22:18:09 127006 [RadioIf] Packet RX (noise?) : 184ms
ERROR | 22:18:18 127015 [RadioIf] Ignore received packet due to error=-7
DEBUG | 22:18:18 127015 [RadioIf] Packet RX (noise?) : 184ms
DEBUG | 22:18:23 127019 [Power] Battery: usbPower=1, isCharging=1, batMv=4165, batPct=98
ERROR | 22:18:42 127038 [RadioIf] Ignore received packet due to error=-7
DEBUG | 22:18:42 127038 [RadioIf] Packet RX (noise?) : 184ms
DEBUG | 22:18:43 127039 [Power] Battery: usbPower=1, isCharging=1, batMv=4165, batPct=98
ERROR | 22:18:50 127046 [RadioIf] Ignore received packet due to error=-7
DEBUG | 22:18:50 127046 [RadioIf] Packet RX (noise?) : 184ms
ERROR | 22:18:56 127053 [RadioIf] Ignore received packet due to error=-7
DEBUG | 22:18:56 127053 [RadioIf] Packet RX (noise?) : 184ms
DEBUG | 22:19:03 127059 [Power] Battery: usbPower=1, isCharging=1, batMv=4165, batPct=98
DEBUG | 22:19:23 127079 [Power] Battery: usbPower=1, isCharging=1, batMv=4164, batPct=98
DEBUG | 22:19:43 127099 [Power] Battery: usbPower=1, isCharging=1, batMv=4164, batPct=98
DEBUG | 22:20:03 127119 [Power] Battery: usbPower=1, isCharging=1, batMv=4163, batPct=98
ERROR | 22:20:11 127127 [RadioIf] Ignore received packet due to error=-7
DEBUG | 22:20:11 127127 [RadioIf] Packet RX (noise?) : 184ms
DEBUG | 22:20:23 127139 [Power] Battery: usbPower=1, isCharging=1, batMv=4162, batPct=98
ERROR | 22:20:42 127158 [RadioIf] Ignore received packet due to error=-7
DEBUG | 22:20:42 127158 [RadioIf] Packet RX (noise?) : 184ms
DEBUG | 22:20:43 127159 [Power] Battery: usbPower=1, isCharging=1, batMv=4161, batPct=97
ERROR | 22:20:59 127175 [RadioIf] Ignore received packet due to error=-7
DEBUG | 22:20:59 127175 [RadioIf] Packet RX (noise?) : 184ms
DEBUG | 22:21:03 127179 [Power] Battery: usbPower=1, isCharging=1, batMv=4158, batPct=97
DEBUG | 22:21:23 127199 [Power] Battery: usbPower=1, isCharging=1, batMv=4159, batPct=97
ERROR | 22:21:32 127208 [RadioIf] Ignore received packet due to error=-7
DEBUG | 22:21:32 127208 [RadioIf] Packet RX (noise?) : 184ms
DEBUG | 22:21:43 127219 [Power] Battery: usbPower=1, isCharging=1, batMv=4160, batPct=97
DEBUG | 22:22:03 127239 [Power] Battery: usbPower=1, isCharging=1, batMv=4160, batPct=97
DEBUG | 22:22:23 127259 [Power] Battery: usbPower=1, isCharging=1, batMv=4161, batPct=97
ERROR | 22:22:37 127274 [RadioIf] Ignore received packet due to error=-7
DEBUG | 22:22:37 127274 [RadioIf] Packet RX (noise?) : 184ms
DEBUG | 22:22:43 127279 [Power] Battery: usbPower=1, isCharging=1, batMv=4161, batPct=97
DEBUG | 22:23:03 127299 [Power] Battery: usbPower=1, isCharging=1, batMv=4159, batPct=97
DEBUG | 22:23:23 127319 [Power] Battery: usbPower=1, isCharging=1, batMv=4161, batPct=97
DEBUG | 22:23:43 127339 [Power] Battery: usbPower=1, isCharging=1, batMv=4159, batPct=97
ERROR | 22:23:51 127347 [RadioIf] Ignore received packet due to error=-7
DEBUG | 22:23:51 127347 [RadioIf] Packet RX (noise?) : 184ms
DEBUG | 22:24:03 127359 [Power] Battery: usbPower=1, isCharging=1, batMv=4158, batPct=97
DEBUG | 22:24:23 127379 [Power] Battery: usbPower=1, isCharging=1, batMv=4157, batPct=97
ERROR | 22:24:33 127389 [RadioIf] Ignore received packet due to error=-7
DEBUG | 22:24:33 127389 [RadioIf] Packet RX (noise?) : 184ms
DEBUG | 22:24:43 127399 [Power] Battery: usbPower=1, isCharging=1, batMv=4158, batPct=97
DEBUG | 22:25:03 127419 [Power] Battery: usbPower=1, isCharging=1, batMv=4158, batPct=97
DEBUG | 22:25:23 127439 [Power] Battery: usbPower=1, isCharging=1, batMv=4159, batPct=97
ERROR | 22:25:27 127443 [RadioIf] Ignore received packet due to error=-7
DEBUG | 22:25:27 127443 [RadioIf] Packet RX (noise?) : 184ms
DEBUG | 22:25:43 127459 [Power] Battery: usbPower=1, isCharging=1, batMv=4159, batPct=97
ERROR | 22:25:59 127475 [RadioIf] Ignore received packet due to error=-7     
DEBUG | 22:25:59 127475 [RadioIf] Packet RX (noise?) : 184ms
DEBUG | 22:26:03 127479 [Power] Battery: usbPower=1, isCharging=1, batMv=4158, batPct=97
DEBUG | 22:26:23 127499 [Power] Battery: usbPower=1, isCharging=1, batMv=4159, batPct=97
ERROR | 22:26:41 127517 [RadioIf] Ignore received packet due to error=-7     
DEBUG | 22:26:41 127517 [RadioIf] Packet RX (noise?) : 184ms
DEBUG | 22:26:43 127519 [Power] Battery: usbPower=1, isCharging=1, batMv=4159, batPct=97
ERROR | 22:26:45 127522 [RadioIf] Ignore received packet due to error=-7     
DEBUG | 22:26:45 127522 [RadioIf] Packet RX (noise?) : 184ms
ERROR | 22:26:50 127526 [RadioIf] Ignore received packet due to error=-7     
ERROR | 22:28:12 127608 [RadioIf] Ignore received packet due to error=-7
DEBUG | 22:28:12 127608 [RadioIf] Packet RX (noise?) : 184ms
DEBUG | 22:28:23 127619 [Power] Battery: usbPower=1, isCharging=1, batMv=4157, batPct=97    
DEBUG | 22:28:43 127639 [Power] Battery: usbPower=1, isCharging=1, batMv=4158, batPct=97    
ERROR | 22:45:58 128674 [RadioIf] Ignore received packet due to error=-7
 usbPower=1, isCharging=1, batMv=4157, batPct=97
DEBUG | 22:46:18 128694 [Power] Battery: usbPower=1, isChargin usbPower=1, isCharging=1, batMv=4157, batPct=97
DEBUG | 22:46:18 128694 [Power] Battery: usbPower=1, isChargi usbPower=1, isCharging=1, batMv=4157, batPct=97
DEBUG | 22:46:18 128694 [Power] Battery: usbPower=1, isCharging=1, batMv=4154, batPct=97
ERROR | 22:47:45 128782 [RadioIf] Ignore received packet due to error=-7
 usbPower=1, isCharging=1, batMv=4157, batPct=97
 usbPower=1, isCharging=1, batMv=4157, batPct=97
DEBUG | 22:46:18 128694 [Power] Battery: usbPower=1, isCharging=1, batMv=4154, batPct=97
ERROR | 22:47:45 128782 [RadioIf] Ignore received packet due to error=-7
DEBUG | 22:47:45 128782 [RadioIf] Packet RX (noise?) : 184ms
DEBUG | 22:47:45 128782 [Power] Battery: usbPower=1, isCharging=1, batMv=4156, batPct=97
ERROR | 22:48:17 128813 [RadioIf] Ignore received packet due to error=-7
DEBUG | 22:48:17 128813 [RadioIf] Packet RX (noise?) : 184ms
DEBUG | 22:50:17 128933 [Power] Battery: usbPower=1, isCharging=1, batMv=4155, batPct=97
DEBUG | 22:50:37 128953 [Power] Battery: usbPower=1, isCharging=1, batMv=4153, batPct=97
ERROR | 23:03:17 129713 [RadioIf] Ignore received packet due to error=-7
DEBUG | 23:03:17 129713 [RadioIf] Packet RX (noise?) : 184ms
DEBUG | 23:03:17 129713 [Power] Battery: usbPower=1, isCharging=1, batMv=4151, batPct=97
INFO  | 23:03:17 129713 [NodeInfo] Send our nodeinfo to mesh (wantReplies=0)
DEBUG | 23:03:17 129713 [NodeInfo] cancelSending id=0x2a5ef0fc, removed=0
INFO  | 23:03:17 129713 [NodeInfo] Send owner !32560bdb/RAK Diabolique ####/RDSI
DEBUG | 23:03:17 129713 [NodeInfo] Partially randomized packet id 529337597
DEBUG | 23:03:17 129713 [NodeInfo] Update DB node 0x32560bdb, rx_time=1761519797
INFO  | 23:03:17 129713 [NodeInfo] Sort took 0 milliseconds
DEBUG | 23:03:17 129713 [NodeInfo] handleReceived(LOCAL) (id=0x1f8d0cfd fr=0x32560bdb to=0xffffffff, transport = 0, WantAck=0, HopLim=3 Ch=0x0 Portnum=4 rxtime=1761519797 priority=10)
DEBUG | 23:03:17 129713 [NodeInfo] Calling specific module: routing     
DEBUG | 23:03:17 129713 [NodeInfo] No modules interested in portnum=4, src=LOCAL
INFO  | 23:03:17 129713 [NodeInfo] Packet History - insert: Reusing slot aged 70064.168s TRACE OLDEST SLOT  
DEBUG | 23:03:17 129713 [NodeInfo] Expand short PSK #1
DEBUG | 23:03:17 129713 [NodeInfo] Use AES128 key!
DEBUG | 23:03:17 129713 [NodeInfo] Broadcasting packet over UDP (id=529337597)
DEBUG | 23:03:17 129713 [NodeInfo] enqueue for send (id=0x1f8d0cfd fr=0x32560bdb to=0xffffffff, transport = 0, WantAck=0, HopLim=3 Ch=0x1f encrypted len=106 rxtime=1761519797 hopStart=3 relay=0
DEBUG | 23:03:17 129713 [NodeInfo] txGood=1779,txRelay=1750,rxGood=2672,rxBad=671
DEBUG | 23:03:17 129713 [NeighborInfo] Our NodeDB contains 0 neighbors  
DEBUG | 23:03:17 129713 [NeighborInfo] Partially randomized packet id 3524608254
DEBUG | 23:03:17 129713 [NeighborInfo] SENDING NEIGHBORINFO PACKET from Node 0x32560bdb to Node 0x32560bdb (last sent by 0x32560bdb)
DEBUG | 23:03:17 129713 [NeighborInfo] Packet contains 0 neighbors      
DEBUG | 23:03:17 129713 [NeighborInfo] Update DB node 0x32560bdb, rx_time=1761519797
DEBUG | 23:03:17 129713 [NeighborInfo] handleReceived(LOCAL) (id=0xd21540fe fr=0x32560bdb to=0xffffffff, transport = 0, WantAck=0, HopLim=3 Ch=0x0 Portnum=71 rxtime=1761519797 priority=10)
DEBUG | 23:03:17 129713 [NeighborInfo] Calling specific module: routing 
DEBUG | 23:03:17 129713 [NeighborInfo] No modules interested in portnum=71, src=LOCAL
INFO  | 23:03:17 129713 [NeighborInfo] Packet History - insert: Reusing slot aged 70030.651s TRACE OLDEST SLOT
DEBUG | 23:03:17 129713 [NeighborInfo] Expand short PSK #1
DEBUG | 23:03:17 129713 [NeighborInfo] Use AES128 key!
DEBUG | 23:03:17 129713 [NeighborInfo] Broadcasting packet over UDP (id=3524608254)
DEBUG | 23:03:17 129713 [NeighborInfo] enqueue for send (id=0xd21540fe fr=0x32560bdb to=0xffffffff, transport = 0, WantAck=0, HopLim=3 Ch=0x1f encrypted len=37 rxtime=1761519797 hopStart=3 relay=0x
DEBUG | 23:03:17 129713 [NeighborInfo] txGood=1779,txRelay=1750,rxGood=2672,rxBad=671
DEBUG | 23:03:17 129713 [NeighborInfo] Use channel 0 (hash 0x1f)        
art=3 relay=
DEBUG | 23:04:01 129773 [RadioIf] Started Tx (id=0xd21540fe fr=0x32560bdb to=0xffffffff, transport = 0, WantAck=0, HopLim=3 Ch=0x1f encrypted len=37 rxtime=1761519797 hopStart=3 relay=0xdb pri
DEBUG | 23:04:01 129773 [RadioIf] Packet TX: 145ms
DEBUG | 23:04:01 129773 [RadioIf] 0 packets remain in the TX queue
DEBUG | 23:04:01 129773 [RadioIf] Completed sending (id=0xd21540fe fr=0x32560bdb to=0xffffffff, transport = 0, WantAck=0, HopLim=3 Ch=0x1f encrypted len=37 rxtime=1761519797 hopStart=3 relay=0
DEBUG | 23:04:04 129777 [AirTime] Rotate airtimes to a new period = 3
DEBUG | 23:04:19 129791 [Power] Battery: usbPower=1, isCharging=1, batMv=4151, batPct=97

Metadata

Metadata

Assignees

No one assigned

    Labels

    bugSomething isn't working

    Type

    No type
    No fields configured for issues without a type.

    Projects

    No projects

    Milestone

    No milestone

    Relationships

    None yet

    Development

    No branches or pull requests

    Issue actions