Skip to content

openthred ot_rcp stops working after few moments (IDFGH-17076) (TZ-2352) #171

@mmlody

Description

@mmlody

Answers checklist.

  • I have read the documentation ESP-IDF Programming Guide and the issue is not addressed there.
  • I have updated my IDF branch (master or release) to the latest version and checked that the issue is present there.
  • I have searched the issue tracker for a similar issue and not found a similar issue.

General issue report

hello

latest IDF, example code from openthread\ot_rcp
esp-idf-v5.5.2
device: mstack nanoc6 (ESP32-C6)

compilation without errors, flashed without erros
configured in homeassistant as router to thread netowrk, after few minutes errors like below (log from OpenThread Border Router):
how to correct this error ?

====
00:08:20.288 [I] MeshForwarder-: Sent IPv6 UDP msg, len:73, chksum:0a38, ecn:no, to:0xffff, sec:yes, prio:low, radio:all
00:08:20.288 [I] MeshForwarder-: src:[fe80:0:0:0:a821:5e77:acc5:5207]:5355
00:08:20.288 [I] MeshForwarder-: dst:[ff02:0:0:0:0:0:1:3]:5355
00:08:20.317 [D] P-SpinelDrive-: Sent spinel frame, flg:0x2, iid:0, tid:14, cmd:PROP_VALUE_SET, key:STREAM_RAW, len:124, channel:15, maxbackoffs:4, maxretries:15 ...
00:08:20.317 [D] P-SpinelDrive-: ... csmaCaEnabled:1, isHeaderUpdated:0, isARetx:0, skipAes:0, txDelay:0, txDelayBase:0
00:08:20.326 [D] P-SpinelDrive-: Received spinel frame, flg:0x2, iid:0, tid:14, cmd:PROP_VALUE_IS, key:LAST_STATUS, status:OK
00:08:20.327 [D] P-SpinelDrive-: Sent spinel frame, flg:0x2, iid:0, tid:15, cmd:PROP_VALUE_SET, key:STREAM_RAW, len:120, channel:15, maxbackoffs:4, maxretries:15 ...
00:08:20.327 [D] P-SpinelDrive-: ... csmaCaEnabled:1, isHeaderUpdated:0, isARetx:0, skipAes:0, txDelay:0, txDelayBase:0
00:08:20.336 [D] P-SpinelDrive-: Received spinel frame, flg:0x2, iid:0, tid:15, cmd:PROP_VALUE_IS, key:LAST_STATUS, status:OK
00:08:20.336 [D] P-SpinelDrive-: Sent spinel frame, flg:0x2, iid:0, tid:1, cmd:PROP_VALUE_SET, key:STREAM_RAW, len:66, channel:15, maxbackoffs:4, maxretries:15 ...
00:08:20.336 [D] P-SpinelDrive-: ... csmaCaEnabled:1, isHeaderUpdated:0, isARetx:0, skipAes:0, txDelay:0, txDelayBase:0
00:08:20.343 [D] P-SpinelDrive-: Received spinel frame, flg:0x2, iid:0, tid:1, cmd:PROP_VALUE_IS, key:LAST_STATUS, status:OK
00:08:20.343 [I] MeshForwarder-: Sent IPv6 UDP msg, len:250, chksum:b7c7, ecn:no, to:0xffff, sec:yes, prio:low, radio:all
00:08:20.343 [I] MeshForwarder-: src:[fe80:0:0:0:a821:5e77:acc5:5207]:5353
00:08:20.343 [I] MeshForwarder-: dst:[ff02:0:0:0:0:0:0:fb]:5353
00:08:20.499 [D] P-SpinelDrive-: Sent spinel frame, flg:0x2, iid:0, tid:2, cmd:PROP_VALUE_SET, key:STREAM_RAW, len:72, channel:15, maxbackoffs:4, maxretries:15 ...
00:08:20.499 [D] P-SpinelDrive-: ... csmaCaEnabled:1, isHeaderUpdated:0, isARetx:0, skipAes:0, txDelay:0, txDelayBase:0
00:08:20.505 [D] P-SpinelDrive-: Received spinel frame, flg:0x2, iid:0, tid:2, cmd:PROP_VALUE_IS, key:LAST_STATUS, status:OK
00:08:20.506 [I] MeshForwarder-: Sent IPv6 UDP msg, len:73, chksum:31fd, ecn:no, to:0xffff, sec:yes, prio:low, radio:all
00:08:20.506 [I] MeshForwarder-: src:[fe80:0:0:0:a821:5e77:acc5:5207]:5355
00:08:20.506 [I] MeshForwarder-: dst:[ff02:0:0:0:0:0:1:3]:5355
00:08:20.517 [D] P-SpinelDrive-: Sent spinel frame, flg:0x2, iid:0, tid:3, cmd:PROP_VALUE_SET, key:STREAM_RAW, len:124, channel:15, maxbackoffs:4, maxretries:15 ...
00:08:20.517 [D] P-SpinelDrive-: ... csmaCaEnabled:1, isHeaderUpdated:0, isARetx:0, skipAes:0, txDelay:0, txDelayBase:0
00:08:22.329 [I] Mle-----------: Send Advertisement (ff02:0:0:0:0:0:0:1)
00:08:25.518 [W] P-RadioSpinel-: radio tx timeout
00:08:25.518 [W] P-RadioSpinel-: RCP failure detected
00:08:25.518 [W] P-RadioSpinel-: Trying to recover (1/2)
00:08:25.518 [D] P-SpinelDrive-: Sent spinel frame, flg:0x2, iid:0, tid:1, cmd:PROP_VALUE_SET, key:PHY_ENABLED, enabled:1
00:08:25.518 [D] P-RadioSpinel-: Wait response: tid=1 key=32
00:08:27.520 [W] P-RadioSpinel-: Wait for response timeout
00:08:27.520 [W] P-RadioSpinel-: RCP failure detected
00:08:27.520 [W] P-RadioSpinel-: Trying to recover (2/2)
00:08:27.520 [D] P-SpinelDrive-: Sent spinel frame, flg:0x2, iid:0, tid:1, cmd:PROP_VALUE_SET, key:PHY_ENABLED, enabled:1
00:08:27.520 [D] P-RadioSpinel-: Wait response: tid=1 key=32
00:08:29.522 [W] P-RadioSpinel-: Wait for response timeout
00:08:29.522 [W] P-RadioSpinel-: RCP failure detected
00:08:29.522 [C] P-RadioSpinel-: Too many rcp failures, exiting
00:08:29.522 [C] Platform------: RecoverFromRcpFailure() at radio_spinel.cpp:2063: Failure
[17:09:59] WARNING: otbr-agent exited with code 1 (by signal 0).
Chain OTBR_FORWARD_INGRESS (0 references)
target prot opt source destination
DROP all -- anywhere anywhere PKTTYPE = unicast
DROP all -- anywhere anywhere match-set otbr-ingress-deny-src src
ACCEPT all -- anywhere anywhere match-set otbr-ingress-allow-dst dst
DROP all -- anywhere anywhere PKTTYPE = unicast
ACCEPT all -- anywhere anywhere
otbr-ingress-deny-src
otbr-ingress-deny-src-swap
otbr-ingress-allow-dst
otbr-ingress-allow-dst-swap
Chain OTBR_FORWARD_EGRESS (0 references)
target prot opt source destination
ACCEPT all -- anywhere anywhere
[17:09:59] INFO: OTBR firewall teardown completed.u

Metadata

Metadata

Assignees

Labels

No labels
No labels

Type

No type

Projects

No projects

Milestone

No milestone

Relationships

None yet

Development

No branches or pull requests

Issue actions