SDK3.0.2 - Unable to connect to OTBR

[ArunRuchir]

Hi, 
I have upgraded my custom nRF52840 devices from SDK 2.4.1 to SDK 3.0.2. For few days, these devices did connect to existing OpenThread network. But now, all SDK3.0.2 devices are not able to communicate with OTBR. Ping from OTBR to device IP is also not working. No communication on UDP is coming. 

We also tried upgrading RCP but no benefit. 

RCP version
OPENTHREAD/thread-reference-20230119-531-g8ea2031c7; POSIX; Jul 25 2023 20:05:36

We will have mix devices - SDK 2.4.1 and SDK3.0.2 both on the network. If we remove all 2.4.1 devices, then complete network gets crashed. 

Please help get 3.0.2 devices also communicate with OTBR. 

Regards

Arun

[Benjamin]

Hi Arun,

Could you please share the device logs and OTBR logs captured when the issue occurs? Please include journalctl -u otbr-agent starting from when the service was started.

Best regards,
Benjamin

[ArunRuchir]

Dear Benjamin,

I have added journel entry file copies at my drive https://drive.google.com/drive/folders/1pugeX9FLmxm-EcYY2yJXic2NxNopnOcj?usp=sharing

These are 2 days old - 16th Feb when

a) Initially 2.4.1 devices were connected b) Then I could connect 3.0.2 devices c) Then when I merged 2.4.1 and 3.0.2 - everything failed and then 3.0.2 devices were permanently thrown out. 

Added one Note-Pad journel entries of today - 18-Feb. Here I connected only 1 3.0.2 device to OTBR which was earlier running with couple of 2.4.1 devices and tried to form the network. 

Hope you can read these and help me.. 

Regards

Arun

[Benjamin]

Hi Arun,
I don't seem to have access to the files. Could you zip and upload them here?

Thanks,
Benjamin

[ArunRuchir]

[email protected]

Fullscreen Journel-entries-1.txt Download

journalctl -u otbr-agent -f
-- Journal begins at Sun 2025-08-10 18:22:11 IST. --
Feb 18 13:17:04 OpenThread otbr-agent[746]: 00:01:31.119 [I] Mle-----------: AttachState ParentReq -> ChildIdReq
Feb 18 13:17:04 OpenThread otbr-agent[746]: 00:01:31.124 [I] MeshForwarder-: Sent IPv6 UDP msg, len:108, chksum:602a, ecn:no, to:3efee9o:net
Feb 18 13:17:04 OpenThread otbr-agent[746]: 00:01:31.125 [I] MeshForwarder-:     src:[fe80:0:0:0:c04e:bd37:a9a5:5f6f]:19788
Feb 18 13:17:04 OpenThread otbr-agent[746]: 00:01:31.125 [I] MeshForwarder-:     dst:[fe80:0:0:0:3cfe:e990:e37b:3449]:19788
Feb 18 13:17:04 OpenThread otbr-agent[746]: 00:01:31.319 [I] Mac-----------: Frame rx failed, error:Security, len:126, seqnum:139, type3449, dst:c24ebd37a9a55f6f, sec:yes, ackreq:yes
Feb 18 13:17:05 OpenThread otbr-agent[746]: 00:01:31.326 [I] Mac-----------: Frame rx failed, error:Security, len:124, seqnum:140, type3449, dst:c24ebd37a9a55f6f, sec:yes, ackreq:yes
Feb 18 13:17:06 OpenThread otbr-agent[746]: 00:01:32.369 [I] Mle-----------: AttachState ChildIdReq -> Idle
Feb 18 13:17:06 OpenThread otbr-agent[746]: 00:01:32.369 [I] BbrLocal------: Remove BBR Service: seqno (96), delay (5s), timeout (3600s
Feb 18 13:17:06 OpenThread otbr-agent[746]: 00:01:32.369 [I] Mle-----------: AttachState Idle -> Start
Feb 18 13:17:06 OpenThread otbr-agent[746]: 00:01:32.369 [N] Mle-----------: Attach attempt 9 unsuccessful, will try again in 64.289 se
Feb 18 13:17:07 OpenThread otbr-agent[746]: 00:01:33.770 [I] MeshForwarder-: Received IPv6 UDP msg, len:90, chksum:b883, ecn:no, from:3, prio:net, rss:-48.0
Feb 18 13:17:07 OpenThread otbr-agent[746]: 00:01:33.770 [I] MeshForwarder-:     src:[fe80:0:0:0:3cfe:e990:e37b:3449]:19788
Feb 18 13:17:07 OpenThread otbr-agent[746]: 00:01:33.770 [I] MeshForwarder-:     dst:[ff02:0:0:0:0:0:0:1]:19788
Feb 18 13:17:07 OpenThread otbr-agent[746]: [WARN]-REST----: Failed to get diagnostic data: ResponseTimeout
Feb 18 13:17:20 OpenThread otbr-agent[746]: 00:01:46.933 [I] NetDiag-------: Sent DiagGetRequest to fdde:ad00:beef:0:0:ff:fe00:0
Feb 18 13:17:20 OpenThread otbr-agent[746]: 00:01:46.933 [I] NetDiag-------: Sent DiagGetQuery to ff03:0:0:0:0:0:0:2
Feb 18 13:17:20 OpenThread otbr-agent[746]: 00:01:46.933 [N] MeshForwarder-: Dropping IPv6 UDP msg, len:77, chksum:664b, ecn:no, sec:yemal
Feb 18 13:17:20 OpenThread otbr-agent[746]: 00:01:46.933 [N] MeshForwarder-:     src:[fdde:ad00:beef:0:0:ff:fe00:0]:61631
Feb 18 13:17:20 OpenThread otbr-agent[746]: 00:01:46.933 [N] MeshForwarder-:     dst:[fdde:ad00:beef:0:0:ff:fe00:0]:61631
Feb 18 13:17:20 OpenThread otbr-agent[746]: 00:01:46.933 [N] MeshForwarder-: Dropping IPv6 HopOpts msg, len:89, chksum:0000, ecn:no, se:normal
Feb 18 13:17:20 OpenThread otbr-agent[746]: 00:01:46.933 [N] MeshForwarder-:     src:[fdde:ad00:beef:0:0:ff:fe00:0]
Feb 18 13:17:20 OpenThread otbr-agent[746]: 00:01:46.933 [N] MeshForwarder-:     dst:[ff03:0:0:0:0:0:0:2]
Feb 18 13:17:22 OpenThread otbr-agent[746]: 00:01:49.163 [I] MeshForwarder-: Received IPv6 UDP msg, len:90, chksum:0654, ecn:no, from:3, prio:net, rss:-48.0
Feb 18 13:17:22 OpenThread otbr-agent[746]: 00:01:49.163 [I] MeshForwarder-:     src:[fe80:0:0:0:3cfe:e990:e37b:3449]:19788
Feb 18 13:17:22 OpenThread otbr-agent[746]: 00:01:49.163 [I] MeshForwarder-:     dst:[ff02:0:0:0:0:0:0:1]:19788
Feb 18 13:17:23 OpenThread otbr-agent[746]: 00:01:49.746 [N] MeshForwarder-: Dropping IPv6 UDP msg, len:77, chksum:664b, ecn:no, sec:yemal
Feb 18 13:17:23 OpenThread otbr-agent[746]: 00:01:49.746 [N] MeshForwarder-:     src:[fdde:ad00:beef:0:0:ff:fe00:0]:61631
Feb 18 13:17:23 OpenThread otbr-agent[746]: 00:01:49.746 [N] MeshForwarder-:     dst:[fdde:ad00:beef:0:0:ff:fe00:0]:61631
Feb 18 13:17:25 OpenThread otbr-agent[746]: 00:01:51.434 [I] Platform------: Session socket is ready
Feb 18 13:17:26 OpenThread otbr-agent[746]: 00:01:52.763 [I] Platform------: Session socket is ready
Feb 18 13:17:26 OpenThread otbr-agent[746]: 00:01:52.764 [I] Mac-----------: Sending Beacon Request
Feb 18 13:17:26 OpenThread otbr-agent[746]: 00:01:52.768 [I] Mac-----------: Received Beacon
Feb 18 13:17:26 OpenThread otbr-agent[746]: 00:01:53.066 [I] Mac-----------: Sending Beacon Request
Feb 18 13:17:27 OpenThread otbr-agent[746]: 00:01:53.370 [I] Mac-----------: Sending Beacon Request
Feb 18 13:17:27 OpenThread otbr-agent[746]: 00:01:53.674 [I] Mac-----------: Sending Beacon Request
Feb 18 13:17:27 OpenThread otbr-agent[746]: 00:01:53.976 [I] Mac-----------: Sending Beacon Request
Feb 18 13:17:27 OpenThread otbr-agent[746]: 00:01:54.279 [I] Mac-----------: Sending Beacon Request
Feb 18 13:17:28 OpenThread otbr-agent[746]: 00:01:54.584 [I] Mac-----------: Sending Beacon Request
Feb 18 13:17:28 OpenThread otbr-agent[746]: 00:01:54.887 [I] Mac-----------: Sending Beacon Request
Feb 18 13:17:28 OpenThread otbr-agent[746]: 00:01:55.190 [I] Mac-----------: Sending Beacon Request
Feb 18 13:17:29 OpenThread otbr-agent[746]: 00:01:55.372 [N] MeshForwarder-: Dropping IPv6 UDP msg, len:77, chksum:664b, ecn:no, sec:yemal
Feb 18 13:17:29 OpenThread otbr-agent[746]: 00:01:55.372 [N] MeshForwarder-:     src:[fdde:ad00:beef:0:0:ff:fe00:0]:61631
Feb 18 13:17:29 OpenThread otbr-agent[746]: 00:01:55.372 [N] MeshForwarder-:     dst:[fdde:ad00:beef:0:0:ff:fe00:0]:61631
Feb 18 13:17:29 OpenThread otbr-agent[746]: 00:01:55.494 [I] Mac-----------: Sending Beacon Request
Feb 18 13:17:29 OpenThread otbr-agent[746]: 00:01:55.798 [I] Mac-----------: Sending Beacon Request
Feb 18 13:17:29 OpenThread otbr-agent[746]: 00:01:56.101 [I] Mac-----------: Sending Beacon Request
Feb 18 13:17:30 OpenThread otbr-agent[746]: 00:01:56.403 [I] Mac-----------: Sending Beacon Request
Feb 18 13:17:30 OpenThread otbr-agent[746]: 00:01:56.707 [I] Mac-----------: Sending Beacon Request
Feb 18 13:17:30 OpenThread otbr-agent[746]: 00:01:57.010 [I] Mac-----------: Sending Beacon Request
Feb 18 13:17:30 OpenThread otbr-agent[746]: 00:01:57.313 [I] Mac-----------: Sending Beacon Request
Feb 18 13:17:34 OpenThread otbr-agent[746]: 00:02:00.418 [I] MeshForwarder-: Received IPv6 UDP msg, len:90, chksum:b6b4, ecn:no, from:3, prio:net, rss:-48.0
Feb 18 13:17:34 OpenThread otbr-agent[746]: 00:02:00.418 [I] MeshForwarder-:     src:[fe80:0:0:0:3cfe:e990:e37b:3449]:19788
Feb 18 13:17:34 OpenThread otbr-agent[746]: 00:02:00.418 [I] MeshForwarder-:     dst:[ff02:0:0:0:0:0:0:1]:19788
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:02:02.746 [I] Platform------: Session socket is ready
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:02:02.746 [I] Settings------: Wiped all info
Feb 18 13:17:36 OpenThread otbr-agent[746]: [INFO]-BA------: Stop Thread Border Agent
Feb 18 13:17:36 OpenThread otbr-agent[746]: [INFO]-ADPROXY-: Stopped
Feb 18 13:17:36 OpenThread otbr-agent[746]: [INFO]-DPROXY--: Stopped
Feb 18 13:17:36 OpenThread otbr-agent[746]: [INFO]-BA------: Unpublish meshcop service OpenThread BorderRouter #5F6F._meshcop._udp.loca
Feb 18 13:17:36 OpenThread otbr-agent[746]: [INFO]-MDNS----: Removing service OpenThread BorderRouter #5F6F._meshcop._udp
Feb 18 13:17:36 OpenThread otbr-agent[746]: [INFO]-BA------: Result of unpublish meshcop service OpenThread BorderRouter #5F6F._meshcop
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:02:02.747 [I] BbrLocal------: Remove BBR Service: seqno (96), delay (5s), timeout (3600s
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:02:02.747 [I] Mle-----------: AttachState Start -> Idle
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:02:02.747 [I] Platform------: [netif] Removed multicast address ff33:40:fdde:ad00:beef::
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:02:02.747 [I] Platform------: [netif] Removed multicast address ff32:40:fdde:ad00:beef::
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:02:02.747 [I] Platform------: [netif] Sent request#4 to remove fdde:ad00:beef:0:c343:25d
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:02:02.747 [N] Mle-----------: Role detached -> disabled
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:02:02.747 [I] DnssdServer---: stopped
Feb 18 13:17:36 OpenThread otbr-agent[746]: [WARN]-REST----: Failed to get diagnostic data: Abort
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:02:02.747 [I] Platform------: [netif] Sent request#5 to remove fe80::c04e:bd37:a9a5:5f6f
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:02:02.747 [I] Platform------: [netif] Removed multicast address ff02::1
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:02:02.747 [I] Platform------: [netif] Removed multicast address ff03::1
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:02:02.747 [I] Platform------: [netif] Removed multicast address ff03::fc
Feb 18 13:17:36 OpenThread otbr-agent[746]: [NOTE]-AGENT---: Backbone interface: wlan0
Feb 18 13:17:36 OpenThread otbr-agent[746]: [NOTE]-AGENT---: Running 0.3.0-thread-reference-20230119-255-g5f53b03335
Feb 18 13:17:36 OpenThread otbr-agent[746]: [NOTE]-AGENT---: Thread version: 1.3.0
Feb 18 13:17:36 OpenThread otbr-agent[746]: [NOTE]-AGENT---: Thread interface: wpan0
Feb 18 13:17:36 OpenThread otbr-agent[746]: [NOTE]-AGENT---: Radio URL: spinel+hdlc+uart:///dev/ttyACM0
Feb 18 13:17:36 OpenThread otbr-agent[746]: [NOTE]-AGENT---: Radio URL: trel://wlan0
Feb 18 13:17:36 OpenThread otbr-agent[746]: [NOTE]-ILS-----: Infra link selected: wlan0
Feb 18 13:17:36 OpenThread otbr-agent[746]: [INFO]-NCP-----: OpenThread log level changed to 4
Feb 18 13:17:36 OpenThread otbr-agent[746]: 51d.14:43:26.340 [I] Platform------: RCP reset: RESET_POWER_ON
Feb 18 13:17:36 OpenThread otbr-agent[746]: 51d.14:43:26.340 [I] Platform------: Software reset RCP successfully
Feb 18 13:17:36 OpenThread otbr-agent[746]: 51d.14:43:26.345 [I] Platform------: Backbone interface is configured to wlan0 (3)
Feb 18 13:17:36 OpenThread otbr-agent[746]: 51d.14:43:26.347 [I] Platform------: [netif] Sent request#1 to set addr_gen_mode to 1
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:00:00.008 [I] ChildSupervsn-: Timeout: 0 -> 190
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:00:00.009 [I] RoutingManager: Initializing - InfraIfIndex:3
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:00:00.009 [I] InfraIf-------: Init infra netif 3
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:00:00.009 [N] RoutingManager: No valid /48 BR ULA prefix found in settings, generating n
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:00:00.021 [I] Settings------: Saved BrUlaPrefix fd04:239b:bd30::/48
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:00:00.021 [N] RoutingManager: BR ULA prefix: fd04:239b:bd30::/48 (generated)
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:00:00.021 [I] RoutingManager: Generated local OMR prefix: fd04:239b:bd30:1::/64
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:00:00.021 [N] RoutingManager: Local on-link prefix: fdde:ad00:beef:cafe::/64
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:00:00.021 [I] RoutingManager: Enabling
Feb 18 13:17:36 OpenThread otbr-agent[746]: [INFO]-UTILS---: Set state callback: OK
Feb 18 13:17:36 OpenThread otbr-agent[746]: [INFO]-BA------: Publish meshcop service OpenThread BorderRouter #FDBC._meshcop._udp.local.
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:00:00.031 [I] Settings------: Saved BorderAgentId {id:7a9591eb89ada86777b2440fe9e7a71b}
Feb 18 13:17:36 OpenThread otbr-agent[746]: [INFO]-MDNS----: Registering new service OpenThread BorderRouter #FDBC._meshcop._udp.local,
Feb 18 13:17:36 OpenThread otbr-agent[746]: [INFO]-ADPROXY-: Publish all hosts and services
Feb 18 13:17:36 OpenThread otbr-agent[746]: [INFO]-ADPROXY-: Started
Feb 18 13:17:36 OpenThread otbr-agent[746]: [INFO]-DPROXY--: Started
Feb 18 13:17:36 OpenThread otbr-agent[746]: [INFO]-BA------: Start Thread Border Agent: OK
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:00:00.033 [I] BbrLocal------: Add Domain Prefix: ::/0, NotFound
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:00:00.033 [I] BbrLocal------: Add BBR Service: seqno (113), delay (5s), timeout (3600s),
Feb 18 13:17:36 OpenThread otbr-agent[746]: [INFO]-APP-----: Thread Border Router started on AIL wlan0.
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:00:00.043 [I] Notifier------: StateChanged (0x02038200) [NetData PanId NetName ExtPanId
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:00:00.043 [I] Bbr-----------: Start listening on port 61631
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:00:00.043 [I] Bbr-----------: Backbone TMF subscribes ff32:40:fdde:ad00:beef:0:0:3: OK
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:00:00.043 [I] BbrManager----: Start Backbone TMF agent: OK
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:00:00.055 [I] Platform------: Execute command `ipset flush otbr-ingress-allow-dst-swap`
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:00:00.070 [I] Platform------: Execute command `ipset flush otbr-ingress-deny-src-swap` =
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:00:00.076 [I] Platform------: Execute command `ipset add otbr-ingress-deny-src-swap fddet` = 0
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:00:00.082 [I] Platform------: Execute command `ipset swap otbr-ingress-deny-src-swap otb
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:00:00.087 [I] Platform------: Execute command `ipset swap otbr-ingress-allow-dst-swap ot 0
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:00:00.087 [I] Platform------: MulticastRoutingManager: Disable: OK
Feb 18 13:17:36 OpenThread otbr-agent[746]: [INFO]-BA------: Publish meshcop service OpenThread BorderRouter #FDBC._meshcop._udp.local.
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:00:00.087 [I] RouterTable---: Route table
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:00:00.088 [I] Platform------: [netif] Host netif is down
Feb 18 13:17:36 OpenThread otbr-agent[746]: 00:00:00.089 [I] Platform------: [netif] Succeeded to process request#1
Feb 18 13:17:37 OpenThread otbr-agent[746]: [INFO]-MDNS----: Received reply for service OpenThread BorderRouter #FDBC._meshcop._udp., s0
Feb 18 13:17:37 OpenThread otbr-agent[746]: [INFO]-MDNS----: Successfully registered service OpenThread BorderRouter #FDBC._meshcop._ud
Feb 18 13:17:37 OpenThread otbr-agent[746]: [INFO]-BA------: Result of publish meshcop service OpenThread BorderRouter #FDBC._meshcop._
Feb 18 13:17:37 OpenThread otbr-agent[746]: [INFO]-BA------: Result of publish meshcop service OpenThread BorderRouter #FDBC._meshcop._
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.925 [I] Platform------: Session socket is ready
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.932 [I] Settings------: Saved ActiveDataset
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.933 [I] DatasetLocal--: Active dataset set
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.934 [I] Notifier------: StateChanged (0x1004c100) [KeySeqCntr Channel PanId Networ
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.934 [I] AnnounceSender: StartingChannel:11
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.936 [I] Platform------: [netif] Added multicast address ff02::1
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.936 [I] Platform------: [netif] Added multicast address ff03::1
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.936 [I] Platform------: [netif] Added multicast address ff03::fc
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.936 [I] Platform------: [netif] Sent request#2 to add fe80::14b1:253b:955f:fdbc/64
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.936 [I] DnssdServer---: started: OK
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.937 [I] Notifier------: StateChanged (0x01001009) [Ip6+ LLAddr Ip6Mult+ NetifState
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.937 [N] Platform------: [netif] Changing interface state to up.
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.938 [I] Platform------: [netif] Succeeded to process request#2
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.938 [I] BbrLocal------: Remove BBR Service: seqno (113), delay (5s), timeout (3600
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.938 [N] Mle-----------: Role disabled -> detached
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.939 [I] Platform------: [netif] Sent request#3 to add fdde:ad00:beef:0:1801:740f:6
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.939 [I] Platform------: [netif] Added multicast address ff32:40:fdde:ad00:beef::1
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.940 [I] Platform------: [netif] Added multicast address ff33:40:fdde:ad00:beef::1
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.940 [I] Bbr-----------: Backbone TMF unsubscribes ff32:40:fdde:ad00:beef:0:0:3: OK
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.940 [I] Bbr-----------: Backbone TMF subscribes ff32:40:fdde:ad00:beef:0:0:3: OK
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.940 [I] Mle-----------: AttachState Idle -> Start
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.940 [I] Platform------: [netif] Message dropped by Thread
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.940 [I] Platform------: [netif] Host netif is up
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.941 [I] Platform------: [netif] ADD [M] ff03:0:0:0:0:0:0:fc (already subscribed, i
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.941 [I] Platform------: [netif] ADD [M] ff03:0:0:0:0:0:0:1 (already subscribed, ig
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.941 [I] Platform------: [netif] ADD [M] ff02:0:0:0:0:0:0:16
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.941 [I] Platform------: [netif] ADD [M] ff02:0:0:0:0:0:0:2 (rejected)
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.941 [I] Notifier------: StateChanged (0x10001015) [Ip6+ Role MLAddr Ip6Mult+ ActDs
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.941 [I] AnnounceSender: Stopped
Feb 18 13:17:40 OpenThread otbr-agent[746]: [INFO]-BA------: Thread is down
Feb 18 13:17:40 OpenThread otbr-agent[746]: [INFO]-BA------: Publish meshcop service OpenThread BorderRouter #FDBC._meshcop._udp.local.
Feb 18 13:17:40 OpenThread otbr-agent[746]: [INFO]-MDNS----: Removing existing service OpenThread BorderRouter #FDBC._meshcop._udp: out
Feb 18 13:17:40 OpenThread otbr-agent[746]: [INFO]-MDNS----: Removing service OpenThread BorderRouter #FDBC._meshcop._udp
Feb 18 13:17:40 OpenThread otbr-agent[746]: [INFO]-MDNS----: Registering new service OpenThread BorderRouter #FDBC._meshcop._udp.local,
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.943 [I] Platform------: [netif] ADD [U] fe80:0:0:0:14b1:253b:955f:fdbc (already su
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.943 [I] Platform------: [netif] Succeeded to process request#3
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.943 [I] Platform------: [netif] ADD [U] fdde:ad00:beef:0:1801:740f:6e8f:b94c (alre)
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.950 [I] Platform------: [netif] Message dropped by Thread
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.951 [I] Platform------: [netif] ADD [M] ff33:40:fdde:ad00:beef:0:0:1 (already subs
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.951 [I] Platform------: [netif] ADD [M] ff32:40:fdde:ad00:beef:0:0:1 (already subs
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.951 [I] Platform------: [netif] ADD [M] ff03:0:0:0:0:0:0:fc (already subscribed, i
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.951 [I] Platform------: [netif] ADD [M] ff03:0:0:0:0:0:0:1 (already subscribed, ig
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.951 [I] Platform------: [netif] ADD [M] ff02:0:0:0:0:0:0:16 (already subscribed, i
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:03.951 [I] Platform------: [netif] ADD [M] ff02:0:0:0:0:0:0:2 (rejected)
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:04.218 [I] Platform------: [netif] Message dropped by Thread
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:04.219 [I] Platform------: [netif] ADD [M] ff33:40:fdde:ad00:beef:0:0:1 (already subs
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:04.219 [I] Platform------: [netif] ADD [M] ff32:40:fdde:ad00:beef:0:0:1 (already subs
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:04.219 [I] Platform------: [netif] ADD [M] ff03:0:0:0:0:0:0:fc (already subscribed, i
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:04.219 [I] Platform------: [netif] ADD [M] ff03:0:0:0:0:0:0:1 (already subscribed, ig
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:04.219 [I] Platform------: [netif] ADD [M] ff02:0:0:0:0:0:0:16 (already subscribed, i
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:04.219 [I] Platform------: [netif] ADD [M] ff02:0:0:0:0:0:0:2 (rejected)
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:04.346 [I] Platform------: [netif] Message dropped by Thread
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:04.347 [I] Platform------: [netif] ADD [M] ff33:40:fdde:ad00:beef:0:0:1 (already subs
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:04.347 [I] Platform------: [netif] ADD [M] ff32:40:fdde:ad00:beef:0:0:1 (already subs
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:04.347 [I] Platform------: [netif] ADD [M] ff03:0:0:0:0:0:0:fc (already subscribed, i
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:04.347 [I] Platform------: [netif] ADD [M] ff03:0:0:0:0:0:0:1 (already subscribed, ig
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:04.347 [I] Platform------: [netif] ADD [M] ff02:0:0:0:0:0:0:16 (already subscribed, i
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:04.347 [I] Platform------: [netif] ADD [M] ff02:0:0:0:0:0:0:2 (rejected)
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:04.433 [N] Mle-----------: Attach attempt 1, AnyPartition reattaching with Active Dat
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:04.433 [I] Mle-----------: AttachState Start -> ParentReq
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:04.433 [I] Mle-----------: Send Parent Request to routers (ff02:0:0:0:0:0:0:2)
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:04.437 [I] MeshForwarder-: Sent IPv6 UDP msg, len:84, chksum:176f, ecn:no, to:0xffff,
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:04.437 [I] MeshForwarder-:     src:[fe80:0:0:0:14b1:253b:955f:fdbc]:19788
Feb 18 13:17:40 OpenThread otbr-agent[746]: 00:00:04.437 [I] MeshForwarder-:     dst:[ff02:0:0:0:0:0:0:2]:19788
Feb 18 13:17:41 OpenThread otbr-agent[746]: 00:00:04.531 [I] MeshForwarder-: Received IPv6 UDP msg, len:129, chksum:a0e5, ecn:no, from:o, prio:net, rss:-48.0
Feb 18 13:17:41 OpenThread otbr-agent[746]: 00:00:04.531 [I] MeshForwarder-:     src:[fe80:0:0:0:3cfe:e990:e37b:3449]:19788
Feb 18 13:17:41 OpenThread otbr-agent[746]: 00:00:04.531 [I] MeshForwarder-:     dst:[fe80:0:0:0:14b1:253b:955f:fdbc]:19788
Feb 18 13:17:41 OpenThread otbr-agent[746]: 00:00:04.532 [I] Mle-----------: Receive Parent Response (fe80:0:0:0:3cfe:e990:e37b:3449,0x
Feb 18 13:17:41 OpenThread otbr-agent[746]: 00:00:04.533 [I] Notifier------: StateChanged (0x00000100) [KeySeqCntr]
Feb 18 13:17:41 OpenThread otbr-agent[746]: [INFO]-MDNS----: Received reply for service OpenThread BorderRouter #FDBC._meshcop._udp., s0
Feb 18 13:17:41 OpenThread otbr-agent[746]: [INFO]-MDNS----: Successfully registered service OpenThread BorderRouter #FDBC._meshcop._ud
Feb 18 13:17:41 OpenThread otbr-agent[746]: [INFO]-BA------: Result of publish meshcop service OpenThread BorderRouter #FDBC._meshcop._
Feb 18 13:17:41 OpenThread otbr-agent[746]: 00:00:05.183 [I] Mle-----------: Send Child ID Request (fe80:0:0:0:3cfe:e990:e37b:3449)
Feb 18 13:17:41 OpenThread otbr-agent[746]: 00:00:05.183 [I] Mle-----------: AttachState ParentReq -> ChildIdReq
Feb 18 13:17:41 OpenThread otbr-agent[746]: 00:00:05.191 [I] MeshForwarder-: Sent IPv6 UDP msg, len:108, chksum:f063, ecn:no, to:3efee9o:net
Feb 18 13:17:41 OpenThread otbr-agent[746]: 00:00:05.191 [I] MeshForwarder-:     src:[fe80:0:0:0:14b1:253b:955f:fdbc]:19788
Feb 18 13:17:41 OpenThread otbr-agent[746]: 00:00:05.191 [I] MeshForwarder-:     dst:[fe80:0:0:0:3cfe:e990:e37b:3449]:19788
Feb 18 13:17:41 OpenThread otbr-agent[746]: 00:00:05.337 [I] Mac-----------: Frame rx failed, error:Security, len:126, seqnum:145, type3449, dst:16b1253b955ffdbc, sec:yes, ackreq:yes
Feb 18 13:17:41 OpenThread otbr-agent[746]: 00:00:05.343 [I] Mac-----------: Frame rx failed, error:Security, len:124, seqnum:146, type3449, dst:16b1253b955ffdbc, sec:yes, ackreq:yes
Feb 18 13:17:42 OpenThread otbr-agent[746]: 00:00:06.433 [I] Mle-----------: AttachState ChildIdReq -> Idle
Feb 18 13:17:42 OpenThread otbr-agent[746]: 00:00:06.433 [I] BbrLocal------: Remove BBR Service: seqno (113), delay (5s), timeout (3600
Feb 18 13:17:42 OpenThread otbr-agent[746]: 00:00:06.433 [I] Mle-----------: AttachState Idle -> Start
Feb 18 13:17:42 OpenThread otbr-agent[746]: 00:00:06.433 [N] Mle-----------: Attach attempt 1 unsuccessful, will try again in 0.295 sec
Feb 18 13:17:43 OpenThread otbr-agent[746]: 00:00:06.728 [N] Mle-----------: Attach attempt 2, AnyPartition
Feb 18 13:17:43 OpenThread otbr-agent[746]: 00:00:06.728 [I] Mle-----------: AttachState Start -> ParentReq
Feb 18 13:17:43 OpenThread otbr-agent[746]: 00:00:06.728 [I] Mle-----------: Send Parent Request to routers (ff02:0:0:0:0:0:0:2)
Feb 18 13:17:43 OpenThread otbr-agent[746]: 00:00:06.732 [I] MeshForwarder-: Sent IPv6 UDP msg, len:84, chksum:e0be, ecn:no, to:0xffff,
Feb 18 13:17:43 OpenThread otbr-agent[746]: 00:00:06.732 [I] MeshForwarder-:     src:[fe80:0:0:0:14b1:253b:955f:fdbc]:19788
Feb 18 13:17:43 OpenThread otbr-agent[746]: 00:00:06.732 [I] MeshForwarder-:     dst:[ff02:0:0:0:0:0:0:2]:19788
Feb 18 13:17:43 OpenThread otbr-agent[746]: 00:00:06.944 [I] MeshForwarder-: Received IPv6 UDP msg, len:129, chksum:e630, ecn:no, from:o, prio:net, rss:-48.0
Feb 18 13:17:43 OpenThread otbr-agent[746]: 00:00:06.944 [I] MeshForwarder-:     src:[fe80:0:0:0:3cfe:e990:e37b:3449]:19788
Feb 18 13:17:43 OpenThread otbr-agent[746]: 00:00:06.944 [I] MeshForwarder-:     dst:[fe80:0:0:0:14b1:253b:955f:fdbc]:19788
Feb 18 13:17:43 OpenThread otbr-agent[746]: 00:00:06.944 [I] Mle-----------: Receive Parent Response (fe80:0:0:0:3cfe:e990:e37b:3449,0x
Feb 18 13:17:43 OpenThread otbr-agent[746]: 00:00:07.478 [I] Mle-----------: Send Child ID Request (fe80:0:0:0:3cfe:e990:e37b:3449)
Feb 18 13:17:43 OpenThread otbr-agent[746]: 00:00:07.478 [I] Mle-----------: AttachState ParentReq -> ChildIdReq
Feb 18 13:17:43 OpenThread otbr-agent[746]: 00:00:07.486 [I] MeshForwarder-: Sent IPv6 UDP msg, len:108, chksum:bcd5, ecn:no, to:3efee9o:net
Feb 18 13:17:43 OpenThread otbr-agent[746]: 00:00:07.486 [I] MeshForwarder-:     src:[fe80:0:0:0:14b1:253b:955f:fdbc]:19788
Feb 18 13:17:43 OpenThread otbr-agent[746]: 00:00:07.486 [I] MeshForwarder-:     dst:[fe80:0:0:0:3cfe:e990:e37b:3449]:19788
Feb 18 13:17:44 OpenThread otbr-agent[746]: 00:00:07.683 [I] Mac-----------: Frame rx failed, error:Security, len:126, seqnum:148, type3449, dst:16b1253b955ffdbc, sec:yes, ackreq:yes
Feb 18 13:17:44 OpenThread otbr-agent[746]: 00:00:07.689 [I] Mac-----------: Frame rx failed, error:Security, len:124, seqnum:149, type3449, dst:16b1253b955ffdbc, sec:yes, ackreq:yes
Feb 18 13:17:44 OpenThread otbr-agent[746]: 00:00:07.865 [I] MeshForwarder-: Received IPv6 UDP msg, len:90, chksum:4a3d, ecn:no, from:3, prio:net, rss:-48.0
Feb 18 13:17:44 OpenThread otbr-agent[746]: 00:00:07.865 [I] MeshForwarder-:     src:[fe80:0:0:0:3cfe:e990:e37b:3449]:19788
Feb 18 13:17:44 OpenThread otbr-agent[746]: 00:00:07.865 [I] MeshForwarder-:     dst:[ff02:0:0:0:0:0:0:1]:19788
Feb 18 13:17:45 OpenThread otbr-agent[746]: 00:00:08.728 [I] Mle-----------: AttachState ChildIdReq -> Idle
Feb 18 13:17:45 OpenThread otbr-agent[746]: 00:00:08.729 [I] BbrLocal------: Remove BBR Service: seqno (113), delay (5s), timeout (3600
Feb 18 13:17:45 OpenThread otbr-agent[746]: 00:00:08.729 [I] Mle-----------: AttachState Idle -> Start
Feb 18 13:17:45 OpenThread otbr-agent[746]: 00:00:08.729 [N] Mle-----------: Attach attempt 2 unsuccessful, will try again in 0.521 sec
Feb 18 13:17:45 OpenThread otbr-agent[746]: 00:00:09.250 [N] Mle-----------: Attach attempt 3, AnyPartition
Feb 18 13:17:45 OpenThread otbr-agent[746]: 00:00:09.250 [I] Mle-----------: AttachState Start -> ParentReq
Feb 18 13:17:45 OpenThread otbr-agent[746]: 00:00:09.250 [I] Mle-----------: Send Parent Request to routers (ff02:0:0:0:0:0:0:2)
Feb 18 13:17:45 OpenThread otbr-agent[746]: 00:00:09.256 [I] MeshForwarder-: Sent IPv6 UDP msg, len:84, chksum:e471, ecn:no, to:0xffff,
Feb 18 13:17:45 OpenThread otbr-agent[746]: 00:00:09.256 [I] MeshForwarder-:     src:[fe80:0:0:0:14b1:253b:955f:fdbc]:19788
Feb 18 13:17:45 OpenThread otbr-agent[746]: 00:00:09.256 [I] MeshForwarder-:     dst:[ff02:0:0:0:0:0:0:2]:19788
Feb 18 13:17:45 OpenThread otbr-agent[746]: 00:00:09.312 [I] MeshForwarder-: Received IPv6 UDP msg, len:129, chksum:7f5a, ecn:no, from:o, prio:net, rss:-48.0
Feb 18 13:17:45 OpenThread otbr-agent[746]: 00:00:09.312 [I] MeshForwarder-:     src:[fe80:0:0:0:3cfe:e990:e37b:3449]:19788
Feb 18 13:17:45 OpenThread otbr-agent[746]: 00:00:09.312 [I] MeshForwarder-:     dst:[fe80:0:0:0:14b1:253b:955f:fdbc]:19788
Feb 18 13:17:45 OpenThread otbr-agent[746]: 00:00:09.312 [I] Mle-----------: Receive Parent Response (fe80:0:0:0:3cfe:e990:e37b:3449,0x
Feb 18 13:17:46 OpenThread otbr-agent[746]: 00:00:10.000 [I] Mle-----------: Send Child ID Request (fe80:0:0:0:3cfe:e990:e37b:3449)
Feb 18 13:17:46 OpenThread otbr-agent[746]: 00:00:10.000 [I] Mle-----------: AttachState ParentReq -> ChildIdReq
Feb 18 13:17:46 OpenThread otbr-agent[746]: 00:00:10.013 [I] MeshForwarder-: Sent IPv6 UDP msg, len:108, chksum:2a3d, ecn:no, to:3efee9o:net
Feb 18 13:17:46 OpenThread otbr-agent[746]: 00:00:10.013 [I] MeshForwarder-:     src:[fe80:0:0:0:14b1:253b:955f:fdbc]:19788
Feb 18 13:17:46 OpenThread otbr-agent[746]: 00:00:10.013 [I] MeshForwarder-:     dst:[fe80:0:0:0:3cfe:e990:e37b:3449]:19788
Feb 18 13:17:46 OpenThread otbr-agent[746]: 00:00:10.215 [I] Mac-----------: Frame rx failed, error:Security, len:126, seqnum:152, type3449, dst:16b1253b955ffdbc, sec:yes, ackreq:yes
Feb 18 13:17:46 OpenThread otbr-agent[746]: 00:00:10.223 [I] Mac-----------: Frame rx failed, error:Security, len:124, seqnum:153, type3449, dst:16b1253b955ffdbc, sec:yes, ackreq:yes
Feb 18 13:17:47 OpenThread otbr-agent[746]: 00:00:11.250 [I] Mle-----------: AttachState ChildIdReq -> Idle
Feb 18 13:17:47 OpenThread otbr-agent[746]: 00:00:11.250 [I] BbrLocal------: Remove BBR Service: seqno (113), delay (5s), timeout (3600
Feb 18 13:17:47 OpenThread otbr-agent[746]: 00:00:11.250 [I] Mle-----------: AttachState Idle -> Start
Feb 18 13:17:47 OpenThread otbr-agent[746]: 00:00:11.250 [N] Mle-----------: Attach attempt 3 unsuccessful, will try again in 1.047 sec
Feb 18 13:17:48 OpenThread otbr-agent[746]: 00:00:12.297 [N] Mle-----------: Attach attempt 4, AnyPartition
Feb 18 13:17:48 OpenThread otbr-agent[746]: 00:00:12.297 [I] Mle-----------: AttachState Start -> ParentReq
Feb 18 13:17:48 OpenThread otbr-agent[746]: 00:00:12.297 [I] Mle-----------: Send Parent Request to routers (ff02:0:0:0:0:0:0:2)
Feb 18 13:17:48 OpenThread otbr-agent[746]: 00:00:12.302 [I] MeshForwarder-: Sent IPv6 UDP msg, len:84, chksum:c42c, ecn:no, to:0xffff,
Feb 18 13:17:48 OpenThread otbr-agent[746]: 00:00:12.302 [I] MeshForwarder-:     src:[fe80:0:0:0:14b1:253b:955f:fdbc]:19788
Feb 18 13:17:48 OpenThread otbr-agent[746]: 00:00:12.302 [I] MeshForwarder-:     dst:[ff02:0:0:0:0:0:0:2]:19788
Feb 18 13:17:49 OpenThread otbr-agent[746]: 00:00:12.631 [I] MeshForwarder-: Received IPv6 UDP msg, len:129, chksum:3a01, ecn:no, from:o, prio:net, rss:-48.0
Feb 18 13:17:49 OpenThread otbr-agent[746]: 00:00:12.631 [I] MeshForwarder-:     src:[fe80:0:0:0:3cfe:e990:e37b:3449]:19788
Feb 18 13:17:49 OpenThread otbr-agent[746]: 00:00:12.631 [I] MeshForwarder-:     dst:[fe80:0:0:0:14b1:253b:955f:fdbc]:19788
Feb 18 13:17:49 OpenThread otbr-agent[746]: 00:00:12.631 [I] Mle-----------: Receive Parent Response (fe80:0:0:0:3cfe:e990:e37b:3449,0x
Feb 18 13:17:49 OpenThread otbr-agent[746]: 00:00:13.047 [I] Mle-----------: Send Child ID Request (fe80:0:0:0:3cfe:e990:e37b:3449)
Feb 18 13:17:49 OpenThread otbr-agent[746]: 00:00:13.047 [I] Mle-----------: AttachState ParentReq -> ChildIdReq
Feb 18 13:17:49 OpenThread otbr-agent[746]: 00:00:13.054 [I] MeshForwarder-: Sent IPv6 UDP msg, len:108, chksum:fdd9, ecn:no, to:3efee9o:net
Feb 18 13:17:49 OpenThread otbr-agent[746]: 00:00:13.054 [I] MeshForwarder-:     src:[fe80:0:0:0:14b1:253b:955f:fdbc]:19788
Feb 18 13:17:49 OpenThread otbr-agent[746]: 00:00:13.054 [I] MeshForwarder-:     dst:[fe80:0:0:0:3cfe:e990:e37b:3449]:19788
Feb 18 13:17:49 OpenThread otbr-agent[746]: 00:00:13.251 [I] Mac-----------: Frame rx failed, error:Security, len:126, seqnum:155, type3449, dst:16b1253b955ffdbc, sec:yes, ackreq:yes
Feb 18 13:17:49 OpenThread otbr-agent[746]: 00:00:13.258 [I] Mac-----------: Frame rx failed, error:Security, len:124, seqnum:156, type3449, dst:16b1253b955ffdbc, sec:yes, ackreq:yes
Feb 18 13:17:50 OpenThread otbr-agent[746]: 00:00:14.297 [I] Mle-----------: AttachState ChildIdReq -> Idle
Feb 18 13:17:50 OpenThread otbr-agent[746]: 00:00:14.297 [I] BbrLocal------: Remove BBR Service: seqno (113), delay (5s), timeout (3600
Feb 18 13:17:50 OpenThread otbr-agent[746]: 00:00:14.297 [I] Mle-----------: AttachState Idle -> Start
Feb 18 13:17:50 OpenThread otbr-agent[746]: 00:00:14.297 [N] Mle-----------: Attach attempt 4 unsuccessful, will try again in 2.045 sec
Feb 18 13:17:52 OpenThread otbr-agent[746]: 00:00:16.342 [N] Mle-----------: Attach attempt 5, AnyPartition
Feb 18 13:17:52 OpenThread otbr-agent[746]: 00:00:16.342 [I] Mle-----------: AttachState Start -> ParentReq
Feb 18 13:17:52 OpenThread otbr-agent[746]: 00:00:16.342 [I] Mle-----------: Send Parent Request to routers (ff02:0:0:0:0:0:0:2)
Feb 18 13:17:52 OpenThread otbr-agent[746]: 00:00:16.347 [I] MeshForwarder-: Sent IPv6 UDP msg, len:84, chksum:c62d, ecn:no, to:0xffff,
Feb 18 13:17:52 OpenThread otbr-agent[746]: 00:00:16.347 [I] MeshForwarder-:     src:[fe80:0:0:0:14b1:253b:955f:fdbc]:19788
Feb 18 13:17:52 OpenThread otbr-agent[746]: 00:00:16.347 [I] MeshForwarder-:     dst:[ff02:0:0:0:0:0:0:2]:19788
Feb 18 13:17:53 OpenThread otbr-agent[746]: 00:00:16.754 [I] MeshForwarder-: Received IPv6 UDP msg, len:129, chksum:2502, ecn:no, from:o, prio:net, rss:-48.0
Feb 18 13:17:53 OpenThread otbr-agent[746]: 00:00:16.754 [I] MeshForwarder-:     src:[fe80:0:0:0:3cfe:e990:e37b:3449]:19788
Feb 18 13:17:53 OpenThread otbr-agent[746]: 00:00:16.754 [I] MeshForwarder-:     dst:[fe80:0:0:0:14b1:253b:955f:fdbc]:19788
Feb 18 13:17:53 OpenThread otbr-agent[746]: 00:00:16.754 [I] Mle-----------: Receive Parent Response (fe80:0:0:0:3cfe:e990:e37b:3449,0x
Feb 18 13:17:53 OpenThread otbr-agent[746]: 00:00:17.092 [I] Mle-----------: Send Child ID Request (fe80:0:0:0:3cfe:e990:e37b:3449)
Feb 18 13:17:53 OpenThread otbr-agent[746]: 00:00:17.092 [I] Mle-----------: AttachState ParentReq -> ChildIdReq
Feb 18 13:17:53 OpenThread otbr-agent[746]: 00:00:17.099 [I] MeshForwarder-: Sent IPv6 UDP msg, len:108, chksum:2c6b, ecn:no, to:3efee9o:net
Feb 18 13:17:53 OpenThread otbr-agent[746]: 00:00:17.100 [I] MeshForwarder-:     src:[fe80:0:0:0:14b1:253b:955f:fdbc]:19788
Feb 18 13:17:53 OpenThread otbr-agent[746]: 00:00:17.100 [I] MeshForwarder-:     dst:[fe80:0:0:0:3cfe:e990:e37b:3449]:19788
Feb 18 13:17:53 OpenThread otbr-agent[746]: 00:00:17.306 [I] Mac-----------: Frame rx failed, error:Security, len:126, seqnum:158, type3449, dst:16b1253b955ffdbc, sec:yes, ackreq:yes
Feb 18 13:17:53 OpenThread otbr-agent[746]: 00:00:17.313 [I] Mac-----------: Frame rx failed, error:Security, len:124, seqnum:159, type3449, dst:16b1253b955ffdbc, sec:yes, ackreq:yes
Feb 18 13:17:54 OpenThread otbr-agent[746]: 00:00:18.342 [I] Mle-----------: AttachState ChildIdReq -> Idle
Feb 18 13:17:54 OpenThread otbr-agent[746]: 00:00:18.342 [I] BbrLocal------: Remove BBR Service: seqno (113), delay (5s), timeout (3600
Feb 18 13:17:54 OpenThread otbr-agent[746]: 00:00:18.342 [I] Mle-----------: AttachState Idle -> Start
Feb 18 13:17:54 OpenThread otbr-agent[746]: 00:00:18.342 [N] Mle-----------: Attach attempt 5 unsuccessful, will try again in 4.021 sec
Feb 18 13:17:56 OpenThread otbr-agent[746]: 00:00:20.330 [I] MeshForwarder-: Received IPv6 UDP msg, len:90, chksum:4f2d, ecn:no, from:3, prio:net, rss:-48.0
Feb 18 13:17:56 OpenThread otbr-agent[746]: 00:00:20.330 [I] MeshForwarder-:     src:[fe80:0:0:0:3cfe:e990:e37b:3449]:19788
Feb 18 13:17:56 OpenThread otbr-agent[746]: 00:00:20.330 [I] MeshForwarder-:     dst:[ff02:0:0:0:0:0:0:1]:19788
Feb 18 13:17:58 OpenThread otbr-agent[746]: 00:00:22.363 [N] Mle-----------: Attach attempt 6, AnyPartition
Feb 18 13:17:58 OpenThread otbr-agent[746]: 00:00:22.363 [I] Mle-----------: AttachState Start -> ParentReq
Feb 18 13:17:58 OpenThread otbr-agent[746]: 00:00:22.363 [I] Mle-----------: Send Parent Request to routers (ff02:0:0:0:0:0:0:2)
Feb 18 13:17:58 OpenThread otbr-agent[746]: 00:00:22.369 [I] MeshForwarder-: Sent IPv6 UDP msg, len:84, chksum:73b0, ecn:no, to:0xffff,
Feb 18 13:17:58 OpenThread otbr-agent[746]: 00:00:22.369 [I] MeshForwarder-:     src:[fe80:0:0:0:14b1:253b:955f:fdbc]:19788
Feb 18 13:17:58 OpenThread otbr-agent[746]: 00:00:22.369 [I] MeshForwarder-:     dst:[ff02:0:0:0:0:0:0:2]:19788
Feb 18 13:17:58 OpenThread otbr-agent[746]: 00:00:22.479 [I] MeshForwarder-: Received IPv6 UDP msg, len:129, chksum:a0b4, ecn:no, from:o, prio:net, rss:-48.0

[Sigurd Hellesvik]

Hi,

I will also help with this ticket. 

1. Is this the first time you have updated the devices, or have you upgraded version before?
2. How do you upgrade the devices? OTA or a Programmer? If you use OTA, which protocol do you OTA over?
3. Do the 2.4.1 devices still work?
4. Can you read out (and not share) channel, panid and networkkey for both v2.4.1 and v3.0.2 devices and compare these? 

Regards,
Sigurd Hellesvik

[ArunRuchir]

Thanks. I could make my devices communicate with OTBR while using SDK3.0.2. 
But still mixing of devices from SDK2.4.1 and SDK3.0.2 may cause problem. So, I am not mixing and simply upgrading devices to 3.0.2 only. 

We can close this ticket for now. Once I have some more progress, will update. 

Regards

Arun