I tried to connect a Eve Energy matter device to Home Assistant using SkyConnect but the commissioning failed.
I used the HA compainion app and also tried smartthings app on Android. The OTBR connection succeed, I was able to see the child in OTBR topology.
The Matter Server log showed an error “network is unreachable”
2024-07-22 21:46:37.420 (Dummy-2) CHIP_PROGRESS [chip.native.DIS] CHIP minimal mDNS configured as 'Operational device'; instance name: D6AAB6F0C0B04E9D-000000000001B669.
2024-07-22 21:46:37.422 (Dummy-2) CHIP_DETAIL [chip.native.DIS] Warning: Attempt to mDNS broadcast failed on end0: src/inet/UDPEndPointImplSockets.cpp:416: OS Error 0x02000065: Network is unreachable
2024-07-22 21:46:37.422 (Dummy-2) CHIP_PROGRESS [chip.native.DIS] mDNS broadcast full failed in 1 separate send attempts.
2024-07-22 21:46:37.423 (Dummy-2) CHIP_ERROR [chip.native.DIS] Failed to advertise records: src/inet/UDPEndPointImplSockets.cpp:416: OS Error 0x02000065: Network is unreachable
It tried several eve devices, always the same issue.
IPv6 is enabled. I was able to move a thread device from Apple HomePod to Home Assistant but was never able to pair a Thread/Matter device with Home Assistant von RPi4 with SkyConnect.
Matter Server log
2024-07-22 21:46:37.121 (Dummy-2) CHIP_DETAIL [chip.native.CTL] StorageAdapter::GetKeyValue: Key = ExampleOpCredsICAKey1, Value = 0x7febffdc40 (97)
2024-07-22 21:46:37.121 (Dummy-2) CHIP_DETAIL [chip.native.CTL] Key Found 97
2024-07-22 21:46:37.124 (MainThread) INFO [chip.CertificateAuthority] Loading fabric admins from storage...
2024-07-22 21:46:37.125 (MainThread) INFO [chip.FabricAdmin] New FabricAdmin: FabricId: 0x0000000000000002, VendorId = 0x134B
2024-07-22 21:46:37.125 (MainThread) DEBUG [chip.storage] SetReplKey: caList = {'1': [{'fabricId': 2, 'vendorId': 4939}]}
2024-07-22 21:46:37.126 (MainThread) INFO [matter_server.server.stack] CHIP Controller Stack initialized.
2024-07-22 21:46:37.126 (MainThread) DEBUG [aiorun] Entering run()
2024-07-22 21:46:37.127 (MainThread) DEBUG [asyncio] Using selector: EpollSelector
2024-07-22 21:46:37.128 (MainThread) DEBUG [aiorun] Creating default executor
2024-07-22 21:46:37.129 (MainThread) INFO [matter_server.server.server] Starting the Matter Server...
[New Thread 0x7feb7fe1e0 (LWP 254)]
2024-07-22 21:46:37.140 (MainThread) INFO [matter_server.server.helpers.paa_certificates] Skip fetching certificates (already fetched within the last 24h).
2024-07-22 21:46:37.141 (MainThread) INFO [chip.FabricAdmin] Allocating new controller with CaIndex: 1, FabricId: 0x0000000000000002, NodeId: 0x000000000001B669, CatTags: []
2024-07-22 21:46:37.144 (Dummy-2) CHIP_DETAIL [chip.native.CTL] Creating New Device Controller
2024-07-22 21:46:37.144 (Dummy-2) CHIP_PROGRESS [chip.native.CTL] Setting attestation nonce to random value
2024-07-22 21:46:37.145 (Dummy-2) CHIP_PROGRESS [chip.native.CTL] Setting CSR nonce to random value
2024-07-22 21:46:37.146 (Dummy-2) CHIP_PROGRESS [chip.native.SPT] Using device attestation PAA trust store path /data/credentials.
2024-07-22 21:46:37.355 (Dummy-2) CHIP_DETAIL [chip.native.CTL] StorageAdapter::GetKeyValue: Key = ExampleCARootCert1, Value = 0x7fe000dca0 (600)
2024-07-22 21:46:37.356 (Dummy-2) CHIP_DETAIL [chip.native.CTL] Key Found 411
2024-07-22 21:46:37.356 (Dummy-2) CHIP_DETAIL [chip.native.CTL] StorageAdapter::GetKeyValue: Key = ExampleCAIntermediateCert1, Value = 0x7fe000da40 (600)
2024-07-22 21:46:37.357 (Dummy-2) CHIP_DETAIL [chip.native.CTL] Key Found 410
2024-07-22 21:46:37.357 (Dummy-2) CHIP_PROGRESS [chip.native.CTL] Generating NOC
2024-07-22 21:46:37.364 (Dummy-2) CHIP_DETAIL [chip.native.CTL] StorageAdapter::GetKeyValue: Key = f/1/r, Value = 0x7febffcef8 (400)
2024-07-22 21:46:37.365 (Dummy-2) CHIP_DETAIL [chip.native.CTL] Key Found 231
2024-07-22 21:46:37.365 (Dummy-2) CHIP_DETAIL [chip.native.CTL] StorageAdapter::GetKeyValue: Key = f/1/n, Value = 0x7febffcef8 (400)
2024-07-22 21:46:37.366 (Dummy-2) CHIP_DETAIL [chip.native.CTL] Key Found 244
2024-07-22 21:46:37.366 (Dummy-2) CHIP_DETAIL [chip.native.CTL] StorageAdapter::GetKeyValue: Key = f/1/r, Value = 0x7fe0005360 (400)
2024-07-22 21:46:37.367 (Dummy-2) CHIP_DETAIL [chip.native.CTL] Key Found 231
2024-07-22 21:46:37.367 (Dummy-2) CHIP_PROGRESS [chip.native.FP] Validating NOC chain
2024-07-22 21:46:37.394 (Dummy-2) CHIP_PROGRESS [chip.native.FP] NOC chain validation successful
2024-07-22 21:46:37.395 (Dummy-2) CHIP_PROGRESS [chip.native.FP] Updated fabric at index: 0x1, Node ID: 0x000000000001B669
2024-07-22 21:46:37.395 (Dummy-2) CHIP_PROGRESS [chip.native.TS] Last Known Good Time: 2023-10-14T01:16:48
2024-07-22 21:46:37.395 (Dummy-2) CHIP_PROGRESS [chip.native.TS] New proposed Last Known Good Time: 2021-01-01T00:00:00
2024-07-22 21:46:37.396 (Dummy-2) CHIP_PROGRESS [chip.native.TS] Retaining current Last Known Good Time
2024-07-22 21:46:37.396 (Dummy-2) CHIP_DETAIL [chip.native.CTL] StorageAdapter::GetKeyValue: Key = g/sri, Value = 0x7febffc840 (966)
2024-07-22 21:46:37.396 (Dummy-2) CHIP_DETAIL [chip.native.CTL] Key Not Found
2024-07-22 21:46:37.396 (Dummy-2) CHIP_DETAIL [chip.native.CTL] StorageAdapter::SetKeyValue: Key = g/fs/c, Value = 0x7febffd0d0 (7)
2024-07-22 21:46:37.396 (Dummy-2) DEBUG [chip.storage] SetSdkKey: g/fs/c = b'\x15$\x00\x01(\x01\x18'
2024-07-22 21:46:37.397 (Dummy-2) CHIP_DETAIL [chip.native.CTL] StorageAdapter::SetKeyValue: Key = f/1/m, Value = 0x7febffd048 (9)
2024-07-22 21:46:37.399 (Dummy-2) DEBUG [chip.storage] SetSdkKey: f/1/m = b'\x15%\x00K\x13,\x01\x00\x18'
2024-07-22 21:46:37.400 (Dummy-2) CHIP_PROGRESS [chip.native.FP] Metadata for Fabric 0x1 persisted to storage.
2024-07-22 21:46:37.401 (Dummy-2) CHIP_DETAIL [chip.native.CTL] StorageAdapter::SetKeyValue: Key = f/1/n, Value = 0x7fe000e7f0 (244)
2024-07-22 21:46:37.402 (Dummy-2) DEBUG [chip.storage] SetSdkKey: f/1/n = b'\x150\x01\x01\x01$\x02\x017\x03$\x13\x02\x18&\x04\x80"\x81\'&\x05\x80%M:7\x06$\x15\x02&\x11i\xb6\x01\x00\x18$\x07\x01$\x08\x010\tA\x0488\x9e*\x976\x0f\xfe\xc3$\xef\x9b\xa32\xdf\x87\xd3\xee\xae|8\xbc\x92\xfb\xe1\xbb\xc3\xd5\xb2\xb3\x1a\x88\xee\xc9\x94\xa0\x1a\xa5{\xffn\xdeK\xb3_j\xc3{r\xa9\xd2\xa3\x1a\xa9\xe0\x13\x19\x9a\xa3\xb5\xe14\xe3{7\n5\x01(\x01\x18$\x02\x016\x03\x04\x02\x04\x01\x180\x04\x14.\x8e\xb0\x98\xee\xf5\x9c\xd3{l\xb1\xf4\x04T\xf7\xf4\xe16\xa1\xa70\x05\x14;\xe9\x0e=1Y+-\xbaE\xa6t\x18J\x9e\x94\xe0?\xed\xe8\x180\x0b@\xcd\x97\x903B\xadY\xcdE9d=qI{\xd8\xef\x13\xa5<\xc2\xbc\x8f\xa4Uc\xa4\xd9#\xd4\xea\xb3\xec\xed\x83\x04O1\xef\x17\xa1\xc0\xeem\xe8y\xd2}\xb6&\xe5\xec+\xb8 d(\x05Qz\x96\x14\x85\x89\x18'
2024-07-22 21:46:37.403 (Dummy-2) CHIP_DETAIL [chip.native.CTL] StorageAdapter::SetKeyValue: Key = f/1/i, Value = 0x7fe0010ae0 (231)
2024-07-22 21:46:37.404 (Dummy-2) DEBUG [chip.storage] SetSdkKey: f/1/i = b'\x150\x01\x01\x01$\x02\x017\x03$\x14\x01\x18&\x04\x80"\x81\'&\x05\x80%M:7\x06$\x13\x02\x18$\x07\x01$\x08\x010\tA\x04\xacz\xb8|\xdf\x88\ro\xf2~!\xa3\xb85\xe5\xff\x1c\r\x80\xd2`\xfcY\xa0Z\xabpc\xc9\xef\xd1R\xbc\xc1Y\xac\x98 W\x96\xe9Rs\xcf\xcf}y\xfa\x9b1[<(\xcd\xfe\xdd\xe3\xa8wE\x17W\x9d\xa87\n5\x01)\x01\x18$\x02`0\x04\x14;\xe9\x0e=1Y+-\xbaE\xa6t\x18J\x9e\x94\xe0?\xed\xe80\x05\x14\xa6=|\xc2\xe2\x04\xbc\xdeo\xc2\xf09\x13(l"\xca\x1f\xb9A\x180\x0b@\xef\xbc(\xde\xf6\x92\x8e\xb21\x10\xa5{<\xe0};\x08~\x16S\x18b\x8fl\xe2[\n9.\xc3\xd1\xa2!5\nf\xdf*\xe6JDwY\n\tw>*BW\x92\xe9\xc2?\x90\xbb\xd4\x8al\x07d\x91\xb1\xe3\x18'
2024-07-22 21:46:37.405 (Dummy-2) CHIP_PROGRESS [chip.native.TS] Committing Last Known Good Time to storage: 2023-10-14T01:16:48
2024-07-22 21:46:37.405 (Dummy-2) CHIP_DETAIL [chip.native.CTL] StorageAdapter::SetKeyValue: Key = g/lkgt, Value = 0x7febffd070 (8)
2024-07-22 21:46:37.406 (Dummy-2) DEBUG [chip.storage] SetSdkKey: g/lkgt = b'\x15&\x00\x80\xa8\xbc,\x18'
2024-07-22 21:46:37.406 (Dummy-2) CHIP_DETAIL [chip.native.CTL] StorageAdapter::GetKeyValue: Key = g/fs/c, Value = 0x7febffd070 (0)
2024-07-22 21:46:37.407 (Dummy-2) CHIP_DETAIL [chip.native.CTL] Buf not big enough
2024-07-22 21:46:37.407 (Dummy-2) CHIP_DETAIL [chip.native.CTL] StorageAdapter::DeleteKeyValue: Key = g/fs/c
2024-07-22 21:46:37.408 (Dummy-2) DEBUG [chip.storage] DeleteSdkKey: g/fs/c
2024-07-22 21:46:37.409 (Dummy-2) CHIP_PROGRESS [chip.native.CTL] Joined the fabric at index 1. Fabric ID is 0x0000000000000002 (Compressed Fabric ID: D6AAB6F0C0B04E9D)
2024-07-22 21:46:37.409 (Dummy-2) CHIP_PROGRESS [chip.native.CTL] *** Missing DeviceAttestationVerifier configuration at DeviceCommissioner init: using global default, consider passing one in CommissionerInitParams.
2024-07-22 21:46:37.409 (Dummy-2) CHIP_PROGRESS [chip.native.DIS] Updating services using commissioning mode 0
2024-07-22 21:46:37.415 (Dummy-2) CHIP_PROGRESS [chip.native.DIS] CHIP minimal mDNS started advertising.
2024-07-22 21:46:37.418 (Dummy-2) CHIP_DETAIL [chip.native.DL] Using WiFi MAC for hostname
2024-07-22 21:46:37.418 (Dummy-2) CHIP_PROGRESS [chip.native.DIS] Advertise operational node D6AAB6F0C0B04E9D-000000000001B669
2024-07-22 21:46:37.419 (Dummy-2) CHIP_DETAIL [chip.native.DIS] Responding with _matter._tcp.local
2024-07-22 21:46:37.419 (Dummy-2) CHIP_DETAIL [chip.native.DIS] Responding with D6AAB6F0C0B04E9D-000000000001B669._matter._tcp.local
2024-07-22 21:46:37.419 (Dummy-2) CHIP_DETAIL [chip.native.DIS] Responding with D6AAB6F0C0B04E9D-000000000001B669._matter._tcp.local
2024-07-22 21:46:37.419 (Dummy-2) CHIP_DETAIL [chip.native.DIS] Responding with E45F018E7FE20000.local
2024-07-22 21:46:37.419 (Dummy-2) CHIP_DETAIL [chip.native.DIS] Responding with E45F018E7FE20000.local
2024-07-22 21:46:37.420 (Dummy-2) CHIP_DETAIL [chip.native.DIS] Responding with _ID6AAB6F0C0B04E9D._sub._matter._tcp.local
2024-07-22 21:46:37.420 (Dummy-2) CHIP_PROGRESS [chip.native.DIS] CHIP minimal mDNS configured as 'Operational device'; instance name: D6AAB6F0C0B04E9D-000000000001B669.
2024-07-22 21:46:37.422 (Dummy-2) CHIP_DETAIL [chip.native.DIS] Warning: Attempt to mDNS broadcast failed on end0: src/inet/UDPEndPointImplSockets.cpp:416: OS Error 0x02000065: Network is unreachable
2024-07-22 21:46:37.422 (Dummy-2) CHIP_PROGRESS [chip.native.DIS] mDNS broadcast full failed in 1 separate send attempts.
2024-07-22 21:46:37.423 (Dummy-2) CHIP_ERROR [chip.native.DIS] Failed to advertise records: src/inet/UDPEndPointImplSockets.cpp:416: OS Error 0x02000065: Network is unreachable
2024-07-22 21:46:37.440 (Dummy-2) CHIP_PROGRESS [chip.native.DIS] mDNS service published: _matter._tcp
2024-07-22 21:46:37.440 (Dummy-2) CHIP_PROGRESS [chip.native.SPT] Setting up group data for Fabric Index 1 with Compressed Fabric ID:
2024-07-22 21:46:37.440 (Dummy-2) CHIP_DETAIL [chip.native.SPT] 0xd6, 0xaa, 0xb6, 0xf0, 0xc0, 0xb0, 0x4e, 0x9d,
2024-07-22 21:46:37.441 (Dummy-2) CHIP_DETAIL [chip.native.CTL] StorageAdapter::GetKeyValue: Key = f/1/g, Value = 0x7febffd488 (128)
2024-07-22 21:46:37.441 (Dummy-2) CHIP_DETAIL [chip.native.CTL] Key Found 23
2024-07-22 21:46:37.441 (Dummy-2) CHIP_DETAIL [chip.native.CTL] StorageAdapter::GetKeyValue: Key = f/1/k/0, Value = 0x7febffd528 (128)
2024-07-22 21:46:37.442 (Dummy-2) CHIP_DETAIL [chip.native.CTL] Key Found 97
2024-07-22 21:46:37.442 (Dummy-2) CHIP_DETAIL [chip.native.CTL] StorageAdapter::SetKeyValue: Key = f/1/k/0, Value = 0x7febffd528 (97)
2024-07-22 21:46:37.443 (Dummy-2) DEBUG [chip.storage] SetSdkKey: f/1/k/0 = b'\x15$\x01\x00$\x02\x016\x03\x15$\x04\x00%\x05\xcc\xee0\x06\x10\xae"a\xcf@\x02\xc0xu\xed\x1a\x1e`o\xc1\x16\x18\x15$\x04\x00$\x05\x000\x06\x10\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x18\x15$\x04\x00$\x05\x000\x06\x10\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x18\x18%\x07\xff\xff\x18'
2024-07-22 21:46:37.444 (Dummy-2) CHIP_ERROR [chip.native.DL] Long dispatch time: 301 ms, for event type 2
2024-07-22 21:46:37.448 (MainThread) DEBUG [matter_server.server.sdk] CHIP Device Controller Initialized
2024-07-22 21:46:37.460 (ThreadPoolExecutor-0_0) DEBUG [matter_server.server.storage] Loading persistent settings from /data/15468377015298576029.json
2024-07-22 21:46:37.465 (MainThread) DEBUG [matter_server.server.storage] Started.
2024-07-22 21:46:37.465 (MainThread) INFO [matter_server.server.device_controller] Loaded 0 nodes from stored configuration
2024-07-22 21:46:37.518 (MainThread) INFO [matter_server.server.vendor_info] Loading vendor info from storage.
2024-07-22 21:46:37.539 (MainThread) INFO [matter_server.server.vendor_info] Loaded 226 vendors from storage.
2024-07-22 21:46:37.539 (MainThread) INFO [matter_server.server.vendor_info] Fetching the latest vendor info from DCL.
2024-07-22 21:46:38.350 (MainThread) INFO [matter_server.server.vendor_info] Fetched 224 vendors from DCL.
2024-07-22 21:46:38.351 (MainThread) INFO [matter_server.server.vendor_info] Saving vendor info to storage.
2024-07-22 21:46:38.379 (MainThread) DEBUG [matter_server.server.server] Detected dashboard files on /usr/local/lib/python3.11/site-packages/matter_server/dashboard
2024-07-22 21:46:38.383 (MainThread) DEBUG [matter_server.server.server] Webserver initialized.
2024-07-22 21:47:14.397 (MainThread) DEBUG [matter_server.server.client_handler] [549488302800] Connected from 192.168.10.51
2024-07-22 21:48:38.384 (ThreadPoolExecutor-0_0) DEBUG [matter_server.server.storage] Saved data to persistent storage
Silicon labs multiprotocol log
otbr-agent[312]: 00:28:44.499 [I] MeshForwarder-: src:[fe80:0:0:0:bc9d:9242:bf32:9178]:19788
otbr-agent[312]: 00:28:44.499 [I] MeshForwarder-: dst:[ff02:0:0:0:0:0:0:1]:19788
otbr-agent[312]: 00:29:25.855 [I] Mle-----------: Send Advertisement (ff02:0:0:0:0:0:0:1)
otbr-agent[312]: 00:29:25.866 [I] MeshForwarder-: Sent IPv6 UDP msg, len:90, chksum:8295, ecn:no, to:0xffff, sec:no, prio:net
otbr-agent[312]: 00:29:25.866 [I] MeshForwarder-: src:[fe80:0:0:0:bc9d:9242:bf32:9178]:19788
otbr-agent[312]: 00:29:25.866 [I] MeshForwarder-: dst:[ff02:0:0:0:0:0:0:1]:19788
otbr-agent[312]: 00:29:27.580 [I] RoutingManager: Sent Neighbor Solicitation to fe80:0:0:0:cece:1eff:fe51:8326 - attempt:1/5
otbr-agent[312]: 00:29:27.584 [I] RoutingManager: Received NA from router fe80:0:0:0:cece:1eff:fe51:8326
otbr-agent[312]: 00:29:55.890 [I] Mle-----------: Send Advertisement (ff02:0:0:0:0:0:0:1)
otbr-agent[312]: 00:29:55.900 [I] MeshForwarder-: Sent IPv6 UDP msg, len:90, chksum:f0cf, ecn:no, to:0xffff, sec:no, prio:net
otbr-agent[312]: 00:29:55.900 [I] MeshForwarder-: src:[fe80:0:0:0:bc9d:9242:bf32:9178]:19788
otbr-agent[312]: 00:29:55.901 [I] MeshForwarder-: dst:[ff02:0:0:0:0:0:0:1]:19788
otbr-agent[312]: 00:30:15.004 [I] AnnounceSender: Schedule tx for one cycle
otbr-agent[312]: 00:30:15.288 [I] Mle-----------: Send Announce on channel 15
otbr-agent[312]: 00:30:15.300 [I] MeshForwarder-: Sent IPv6 UDP msg, len:83, chksum:62c8, ecn:no, to:0xffff, sec:yes, prio:net
otbr-agent[312]: 00:30:15.300 [I] MeshForwarder-: src:[fe80:0:0:0:bc9d:9242:bf32:9178]:19788
otbr-agent[312]: 00:30:15.301 [I] MeshForwarder-: dst:[ff02:0:0:0:0:0:0:1]:19788
otbr-agent[312]: 00:30:18.131 [I] Mle-----------: Send Advertisement (ff02:0:0:0:0:0:0:1)
otbr-agent[312]: 00:30:18.143 [I] MeshForwarder-: Sent IPv6 UDP msg, len:90, chksum:2142, ecn:no, to:0xffff, sec:no, prio:net
otbr-agent[312]: 00:30:18.143 [I] MeshForwarder-: src:[fe80:0:0:0:bc9d:9242:bf32:9178]:19788
otbr-agent[312]: 00:30:18.143 [I] MeshForwarder-: dst:[ff02:0:0:0:0:0:0:1]:19788
otbr-agent[312]: 00:30:27.407 [I] RoutingManager: Sent Neighbor Solicitation to fe80:0:0:0:cece:1eff:fe51:8326 - attempt:1/5
otbr-agent[312]: 00:30:27.411 [I] RoutingManager: Received NA from router fe80:0:0:0:cece:1eff:fe51:8326
otbr-agent[312]: 00:30:37.169 [I] Mle-----------: Send Announce on channel 16
otbr-agent[312]: 00:30:37.181 [I] MeshForwarder-: Sent IPv6 UDP msg, len:83, chksum:36f8, ecn:no, to:0xffff, sec:yes, prio:net
otbr-agent[312]: 00:30:37.181 [I] MeshForwarder-: src:[fe80:0:0:0:bc9d:9242:bf32:9178]:19788
otbr-agent[312]: 00:30:37.181 [I] MeshForwarder-: dst:[ff02:0:0:0:0:0:0:1]:19788
otbr-agent[312]: 00:30:58.625 [I] Mle-----------: Send Announce on channel 17
otbr-agent[312]: 00:30:58.638 [I] MeshForwarder-: Sent IPv6 UDP msg, len:83, chksum:9406, ecn:no, to:0xffff, sec:yes, prio:net
otbr-agent[312]: 00:30:58.639 [I] MeshForwarder-: src:[fe80:0:0:0:bc9d:9242:bf32:9178]:19788
otbr-agent[312]: 00:30:58.639 [I] MeshForwarder-: dst:[ff02:0:0:0:0:0:0:1]:19788
otbr-agent[312]: 00:31:02.677 [I] Mle-----------: Send Advertisement (ff02:0:0:0:0:0:0:1)
otbr-agent[312]: 00:31:02.688 [I] MeshForwarder-: Sent IPv6 UDP msg, len:90, chksum:8766, ecn:no, to:0xffff, sec:no, prio:net
otbr-agent[312]: 00:31:02.688 [I] MeshForwarder-: src:[fe80:0:0:0:bc9d:9242:bf32:9178]:19788
otbr-agent[312]: 00:31:02.688 [I] MeshForwarder-: dst:[ff02:0:0:0:0:0:0:1]:19788
otbr-agent[312]: 00:31:20.497 [I] Mle-----------: Send Announce on channel 18
otbr-agent[312]: 00:31:20.508 [I] MeshForwarder-: Sent IPv6 UDP msg, len:83, chksum:7113, ecn:no, to:0xffff, sec:yes, prio:net
otbr-agent[312]: 00:31:20.509 [I] MeshForwarder-: src:[fe80:0:0:0:bc9d:9242:bf32:9178]:19788
otbr-agent[312]: 00:31:20.509 [I] MeshForwarder-: dst:[ff02:0:0:0:0:0:0:1]:19788
otbr-agent[312]: 00:31:27.344 [I] RoutingManager: Sent Neighbor Solicitation to fe80:0:0:0:cece:1eff:fe51:8326 - attempt:1/5
otbr-agent[312]: 00:31:27.349 [I] RoutingManager: Received NA from router fe80:0:0:0:cece:1eff:fe51:8326
otbr-agent[312]: 00:31:29.766 [I] Mle-----------: Send Advertisement (ff02:0:0:0:0:0:0:1)
otbr-agent[312]: 00:31:29.778 [I] MeshForwarder-: Sent IPv6 UDP msg, len:90, chksum:18cb, ecn:no, to:0xffff, sec:no, prio:net
otbr-agent[312]: 00:31:29.778 [I] MeshForwarder-: src:[fe80:0:0:0:bc9d:9242:bf32:9178]:19788
otbr-agent[312]: 00:31:29.778 [I] MeshForwarder-: dst:[ff02:0:0:0:0:0:0:1]:19788
otbr-agent[312]: 00:31:42.063 [I] Mle-----------: Send Announce on channel 19
otbr-agent[312]: 00:31:42.075 [I] MeshForwarder-: Sent IPv6 UDP msg, len:83, chksum:b5f4, ecn:no, to:0xffff, sec:yes, prio:net
otbr-agent[312]: 00:31:42.075 [I] MeshForwarder-: src:[fe80:0:0:0:bc9d:9242:bf32:9178]:19788
otbr-agent[312]: 00:31:42.075 [I] MeshForwarder-: dst:[ff02:0:0:0:0:0:0:1]:19788
otbr-agent[312]: 00:31:54.911 [I] Mle-----------: Send Advertisement (ff02:0:0:0:0:0:0:1)
otbr-agent[312]: 00:31:54.923 [I] MeshForwarder-: Sent IPv6 UDP msg, len:90, chksum:4fba, ecn:no, to:0xffff, sec:no, prio:net
otbr-agent[312]: 00:31:54.923 [I] MeshForwarder-: src:[fe80:0:0:0:bc9d:9242:bf32:9178]:19788
otbr-agent[312]: 00:31:54.923 [I] MeshForwarder-: dst:[ff02:0:0:0:0:0:0:1]:19788
otbr-agent[312]: 00:32:03.848 [I] Mle-----------: Send Announce on channel 20
otbr-agent[312]: 00:32:03.860 [I] MeshForwarder-: Sent IPv6 UDP msg, len:83, chksum:9905, ecn:no, to:0xffff, sec:yes, prio:net
otbr-agent[312]: 00:32:03.861 [I] MeshForwarder-: src:[fe80:0:0:0:bc9d:9242:bf32:9178]:19788
otbr-agent[312]: 00:32:03.861 [I] MeshForwarder-: dst:[ff02:0:0:0:0:0:0:1]:19788
otbr-agent[312]: 00:32:24.888 [I] Mle-----------: Send Announce on channel 21
otbr-agent[312]: 00:32:24.901 [I] MeshForwarder-: Sent IPv6 UDP msg, len:83, chksum:22f4, ecn:no, to:0xffff, sec:yes, prio:net
otbr-agent[312]: 00:32:24.902 [I] MeshForwarder-: src:[fe80:0:0:0:bc9d:9242:bf32:9178]:19788
otbr-agent[312]: 00:32:24.902 [I] MeshForwarder-: dst:[ff02:0:0:0:0:0:0:1]:19788
otbr-agent[312]: 00:32:27.126 [I] RoutingManager: Sent Neighbor Solicitation to fe80:0:0:0:cece:1eff:fe51:8326 - attempt:1/5
otbr-agent[312]: 00:32:27.138 [I] RoutingManager: Received NA from router fe80:0:0:0:cece:1eff:fe51:8326
otbr-agent[312]: 00:32:32.751 [I] Mle-----------: Send Advertisement (ff02:0:0:0:0:0:0:1)
otbr-agent[312]: 00:32:32.762 [I] MeshForwarder-: Sent IPv6 UDP msg, len:90, chksum:7687, ecn:no, to:0xffff, sec:no, prio:net
otbr-agent[312]: 00:32:32.762 [I] MeshForwarder-: src:[fe80:0:0:0:bc9d:9242:bf32:9178]:19788
otbr-agent[312]: 00:32:32.762 [I] MeshForwarder-: dst:[ff02:0:0:0:0:0:0:1]:19788
otbr-agent[312]: 00:32:44.440 [I] MlrManager----: MLR Reregister!
otbr-agent[312]: 00:32:46.618 [I] Mle-----------: Send Announce on channel 22
otbr-agent[312]: 00:32:46.631 [I] MeshForwarder-: Sent IPv6 UDP msg, len:83, chksum:6a80, ecn:no, to:0xffff, sec:yes, prio:net
otbr-agent[312]: 00:32:46.632 [I] MeshForwarder-: src:[fe80:0:0:0:bc9d:9242:bf32:9178]:19788
otbr-agent[312]: 00:32:46.632 [I] MeshForwarder-: dst:[ff02:0:0:0:0:0:0:1]:19788
otbr-agent[312]: 00:33:00.785 [I] Mle-----------: Send Advertisement (ff02:0:0:0:0:0:0:1)
otbr-agent[312]: 00:33:00.795 [I] MeshForwarder-: Sent IPv6 UDP msg, len:90, chksum:74eb, ecn:no, to:0xffff, sec:no, prio:net
otbr-agent[312]: 00:33:00.796 [I] MeshForwarder-: src:[fe80:0:0:0:bc9d:9242:bf32:9178]:19788
otbr-agent[312]: 00:33:00.796 [I] MeshForwarder-: dst:[ff02:0:0:0:0:0:0:1]:19788
otbr-agent[312]: 00:33:08.084 [I] Mle-----------: Send Announce on channel 23
otbr-agent[312]: 00:33:08.097 [I] MeshForwarder-: Sent IPv6 UDP msg, len:83, chksum:7bc7, ecn:no, to:0xffff, sec:yes, prio:net
otbr-agent[312]: 00:33:08.098 [I] MeshForwarder-: src:[fe80:0:0:0:bc9d:9242:bf32:9178]:19788
otbr-agent[312]: 00:33:08.098 [I] MeshForwarder-: dst:[ff02:0:0:0:0:0:0:1]:19788
otbr-agent[312]: 00:33:26.048 [I] RoutingManager: Sent Neighbor Solicitation to fe80:0:0:0:cece:1eff:fe51:8326 - attempt:1/5
otbr-agent[312]: 00:33:26.054 [I] RoutingManager: Received NA from router fe80:0:0:0:cece:1eff:fe51:8326
otbr-agent[312]: 00:33:28.539 [I] RoutingManager: Evaluating routing policy
otbr-agent[312]: 00:33:28.539 [I] RoutingManager: Preparing RA
otbr-agent[312]: 00:33:28.539 [I] RoutingManager: - RIO fd7d:f502:c86a:1::/64 (lifetime:1800, prf:medium)
otbr-agent[312]: 00:33:28.540 [I] RoutingManager: Sent RA on infra netif 3
otbr-agent[312]: 00:33:28.540 [I] RoutingManager: Will evaluate routing policy in 05:42.711 (342711 msec)
otbr-agent[312]: 00:33:28.540 [I] RoutingManager: Received RA from fe80:0:0:0:5d43:233e:4a65:ef6b on infra netif 3
otbr-agent[312]: 00:33:28.540 [I] RoutingManager: - RA Header - default route - lifetime:0
otbr-agent[312]: 00:33:29.324 [I] Mle-----------: Send Announce on channel 24
otbr-agent[312]: 00:33:29.336 [I] MeshForwarder-: Sent IPv6 UDP msg, len:83, chksum:d970, ecn:no, to:0xffff, sec:yes, prio:net
otbr-agent[312]: 00:33:29.336 [I] MeshForwarder-: src:[fe80:0:0:0:bc9d:9242:bf32:9178]:19788
otbr-agent[312]: 00:33:29.336 [I] MeshForwarder-: dst:[ff02:0:0:0:0:0:0:1]:19788
otbr-agent[312]: 00:33:43.162 [I] Mle-----------: Send Advertisement (ff02:0:0:0:0:0:0:1)
otbr-agent[312]: 00:33:43.172 [I] MeshForwarder-: Sent IPv6 UDP msg, len:90, chksum:ec50, ecn:no, to:0xffff, sec:no, prio:net
otbr-agent[312]: 00:33:43.173 [I] MeshForwarder-: src:[fe80:0:0:0:bc9d:9242:bf32:9178]:19788
otbr-agent[312]: 00:33:43.173 [I] MeshForwarder-: dst:[ff02:0:0:0:0:0:0:1]:19788
otbr-agent[312]: 00:33:51.120 [I] Mle-----------: Send Announce on channel 25
otbr-agent[312]: 00:33:51.132 [I] MeshForwarder-: Sent IPv6 UDP msg, len:83, chksum:d966, ecn:no, to:0xffff, sec:yes, prio:net
otbr-agent[312]: 00:33:51.132 [I] MeshForwarder-: src:[fe80:0:0:0:bc9d:9242:bf32:9178]:19788
otbr-agent[312]: 00:33:51.132 [I] MeshForwarder-: dst:[ff02:0:0:0:0:0:0:1]:19788