NRF 52840 matter window covering accessory is displaying no response on Apple Home app with Home pop mini

Hi

 I use a HomePod mini as a border router,commissioning six window covering samples.They are working normally.But after two days,I found two samples displaying no response on the Apple    HOME app.Must be added again.And then I found when I power off the samples for a while,they are displaying no response after power on.I've been waiting for a long time, and the app still shows the same thing.

 NCS Version: v2.3.0

 Home pop mini version:16.4

How should I debug this issue,

Regards

Danny

  • Hi,

    Have you checked the device logs from the nRF52840 to see if it gives any indications to what happened? Logging can be enabled/increased as described in Thread and Matter.

    If you could also do a sniffer trace, that could indicate what is not working. Ideally a sniffer trace when the issue occurs as well would be useful, but might not be easy to capture if the issue happens after a long time.

    If you can provide the device logs and sniffer logs to us, we might be able to help determine what is going on.

    Best regards,
    Jørgen

  • Hi,

    Matter accessory power on log:

    00> I: nRF5 802154 radio initialized
    00> I: 4 Sectors of 4096 bytes
    00> I: alloc wra: 0, d70
    00> I: data wra: 0, ad0
    00> *** Booting Zephyr OS build v3.2.99-ncs2 ***
    00> I: Init CHIP stack
    00> I: 212 [DL]BLE address: E7:0C:FD:D7:77:1F
    00> I: 216 [DL]OpenThread SED interval is 500ms
    00> I: 255 [DL]OpenThread ifconfig up and thread start
    00> I: 259 [DL]OpenThread started: OK
    00> I: 259 [DL]Setting OpenThread device type to SLEEPY END DEVICE
    00> I: uart_init...
    00> I: StartUartTimer
    00> I: 259 [SVR]Server initializing...
    00> I: 262 [TS]Last Known Good Time: 2023-04-22T09:54:01
    00> I: 266 [FP]Fabric index 0x1 was retrieved from storage. Compressed FabricId 0xCCA458A73881E3D2, FabricId 0x0000000000000001, NodeId 0x00000000B6F4B9B5, VendorId 0x1349
    00> I: 269 [FP]Fabric index 0x2 was retrieved from storage. Compressed FabricId 0xF64035E83E412165, FabricId 0x0000000000000002, NodeId 0x000000008F248371, VendorId 0x1384
    00> I: 270 [DMG]AccessControl: initializing
    00> I: 271 [DMG]Examples::AccessControlDelegate::Init
    00> I: 271 [DMG]AccessControl: setting
    00> I: 271 [DMG]DefaultAclStorage: initializiI: UartSleep set pin gpio@50000000 2
    00> 
    00> I: CancelUartTimer
    00> I: UartSleep set end
    00> 
    00> I: 6264 [DL]SRP Client was started, detected server: fdce:29ef:5e97:0000:0000:00ff:fe00:fc11
    00> I: 7074 [DIS]Setting operational delegate post init
    00> I: 7080 [SWU]Stopping the watchdog timer
    00> I: 7080 [SWU]Starting the periodic query timer, timeout: 86400 seconds
    00> I: 7080 [DIS]Updating services using commissioning mode 0
    00> I: 7081 [DIS]Advertise operational node CCA458A73881E3D2-00000000B6F4B9B5
    00> I: 7081 [DL]advertising srp service: CCA458A73881E3D2-00000000B6F4B9B5._matter._tcp
    00> I: 7082 [DIS]Advertise operational node F64035E83E412165-000000008F248371
    00> I: 7083 [DL]advertising srp service: F64035E83E412165-000000008F248371._matter._tcp
    00> I: 7084 [DIS]Advertise commission parameter vendorID=65521 productID=32784 discriminator=3856/15 cm=0
    00> I: 7085 [DL]advertising srp service: EDB25A5FD92083FC._matterc._udp
    00> I: 210271 [EM]>>> [E:18025r M:60692867] (U) Msg RX from 0:679B940419506FF1 [0000] --- Type 0000:30 (SecureChannel:CASE_Sigma1)
    00> I: 210271 [IN]CASE Server received Sigma1 message. Starting handshake. EC 0x20004ea8
    00> I: 210272 [IN]CASE Server disabling CASE session setups
    00> I: 210272 [EM]<<< [E:18025r M:75202900 (Ack:60692867)] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 210273 [IN](U) Sending msg 75202900 to IP address 'UDP:[fd85:4025:13b2:0:ef0e:d145:69fc:5121]:61284'
    00> I: 210274 [SC]Received Sigma1 msg
    00> I: 210280 [EM]<<< [E:18025r M:75202901 (Ack:60692867)] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:33 (SecureChannel:CASE_Sigma2Resume)
    00> I: 210280 [IN](U) Sending msg 75202901 to IP address 'UDP:[fd85:4025:13b2:0:ef0e:d145:69fc:5121]:61284'
    00> I: 210282 [DL]OpenThread SED interval is 500ms
    00> I: 210766 [EM]>>> [E:18025r M:60692868 (Ack:75202901)] (U) Msg RX from 0:679B940419506FF1 [0000] --- Type 0000:40 (SecureChannel:StatusReport)
    00> I: 210767 [SC]Success status report received. Session was established
    00> I: 210864 [SC]SecureSession[0x20003578]: Moving from state 'kEstablishing' --> 'kActive'
    00> D: 210864 [IN]SecureSession[0x20003578]: Activated - Type:2 LSID:40053
    00> D: 210865 [IN]New secure session activated for device <5ABECE966C84D61C, 1>, LSID:40053 PSID:57320!
    00> I: 210865 [IN]CASE Session established to peer: <5ABECE966C84D61C, 1>
    00> I: 210866 [IN]CASE Server enabling CASE session setups
    00> D: 210866 [IN]SecureSession[0x20003630]: Allocated Type:2 LSID:40054
    00> I: 210867 [DL]OpenThread SED interval is 500ms
    00> I: 210867 [EM]<<< [E:18025r M:75202902 (Ack:60692868)] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 210868 [IN](U) Sending msg 75202902 to IP address 'UDP:[fd85:4025:13b2:0:ef0e:d145:69fc:5121]:61284'
    00> I: 210935 [EM]>>> [E:18026r M:262239121] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:03 (IM:SubscribeRequest)
    00> D: 210936 [IM]Received Subscribe request
    00> I: 210941 [DMG]Final negotiated min/max parameters: Min = 0s, Max = 2s
    00> I: 210942 [DL]OpenThread SED interval is 500ms
    00> E: 210945 [DMG]Error retrieving data from clusterId: 0x0000_001F, err = b
    00> I: 210951 [EM]<<< [E:18026r M:124338494 (Ack:262239121)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 210951 [IN](S) Sending msg 124338494 on secure session with LSID: 40053
    00> I: 211433 [EM]>>> [E:18026r M:262239122 (Ack:124338494)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 211434 [IM]Received status response, status is 0x00
    00> E: 211443 [DMG]Error retrieving data from clusterId: 0x0000_0028, err = b
    00> I: 211449 [EM]<<< [E:18026r M:124338495 (Ack:262239122)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 211449 [IN](S) Sending msg 124338495 on secure session with LSID: 40053
    00> I: 211934 [EM]>>> [E:18026r M:262239123 (Ack:124338495)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 211935 [IM]Received status response, status is 0x00
    00> E: 211941 [DMG]Error retrieving data from clusterId: 0x0000_002A, err = b
    00> I: 211947 [EM]<<< [E:18026r M:124338496 (Ack:262239123)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 211947 [IN](S) Sending msg 124338496 on secure session with LSID: 40053
    00> I: 212437 [EM]>>> [E:18026r M:262239124 (Ack:124338496)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 212438 [IM]Received status response, status is 0x00
    00> E: 212442 [DMG]Error retrieving data from clusterId: 0x0000_0030, err = b
    00> I: 212447 [EM]<<< [E:18026r M:124338497 (Ack:262239124)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 212448 [IN](S) Sending msg 124338497 on secure session with LSID: 40053
    00> I: 212937 [EM]>>> [E:18026r M:262239125 (Ack:124338497)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 212938 [IM]Received status response, status is 0x00
    00> E: 212942 [DMG]Error retrieving data from clusterId: 0x0000_0031, err = b
    00> I: 212948 [EM]<<< [E:18026r M:124338498 (Ack:262239125)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 212949 [IN](S) Sending msg 124338498 on secure session with LSID: 40053
    00> I: 213436 [EM]>>> [E:18026r M:262239126 (Ack:124338498)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 213437 [IM]Received status response, status is 0x00
    00> E: 213441 [DMG]Error retrieving data from clusterId: 0x0000_0033, err = b
    00> I: 213447 [EM]<<< [E:18026r M:124338499 (Ack:262239126)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 213447 [IN](S) Sending msg 124338499 on secure session with LSID: 40053
    00> I: 213937 [EM]>>> [E:18026r M:262239127 (Ack:124338499)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 213937 [IM]Received status response, status is 0x00
    00> E: 213941 [DL]_WriteThreadNetworkDiagnosticAttributeToTlv failed: Error CHIP:0x0000000B
    00> E: 213941 [DMG]Error retrieving data from clusterId: 0x0000_0035, err = b
    00> I: 213947 [EM]<<< [E:18026r M:124338500 (Ack:262239127)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 213948 [IN](S) Sending msg 124338500 on secure session with LSID: 40053
    00> I: 214437 [EM]>>> [E:18026r M:262239128 (Ack:124338500)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 214437 [IM]Received status response, status is 0x00
    00> E: 214443 [DL]_WriteThreadNetworkDiagnosticAttributeToTlv failed: Error CHIP:0x0000000B
    00> E: 214443 [DMG]Error retrieving data from clusterId: 0x0000_0035, err = b
    00> I: 214449 [EM]<<< [E:18026r M:124338501 (Ack:262239128)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 214450 [IN](S) Sending msg 124338501 on secure session with LSID: 40053
    00> I: 214937 [EM]>>> [E:18026r M:262239129 (Ack:124338501)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 214937 [IM]Received status response, status is 0x00
    00> E: 214952 [DMG]Error retrieving data from clusterId: 0x0000_0035, err = b
    00> I: 214957 [EM]<<< [E:18026r M:124338502 (Ack:262239129)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 214958 [IN](S) Sending msg 124338502 on secure session with LSID: 40053
    00> I: 215435 [EM]>>> [E:18026r M:262239130 (Ack:124338502)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 215436 [IM]Received status response, status is 0x00
    00> E: 215438 [DMG]Error retrieving data from clusterId: 0x0000_0035, err = b
    00> I: 215444 [EM]<<< [E:18026r M:124338503 (Ack:262239130)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 215444 [IN](S) Sending msg 124338503 on secure session with LSID: 40053
    00> I: 215937 [EM]>>> [E:18026r M:262239131 (Ack:124338503)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 215938 [IM]Received status response, status is 0x00
    00> E: 215941 [DMG]Error retrieving data from clusterId: 0x0000_003C, err = b
    00> I: 215946 [EM]<<< [E:18026r M:124338504 (Ack:262239131)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 215947 [IN](S) Sending msg 124338504 on secure session with LSID: 40053
    00> I: 216438 [EM]>>> [E:18026r M:262239132 (Ack:124338504)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 216438 [IM]Received status response, status is 0x00
    00> E: 216443 [DMG]Error retrieving data from clusterId: 0x0000_003E, err = b
    00> I: 216449 [EM]<<< [E:18026r M:124338505 (Ack:262239132)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 216449 [IN](S) Sending msg 124338505 on secure session with LSID: 40053
    00> I: 216936 [EM]>>> [E:18026r M:262239133 (Ack:124338505)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 216937 [IM]Received status response, status is 0x00
    00> E: 216939 [DMG]Error retrieving data from clusterId: 0x0000_003E, err = b
    00> I: 216945 [EM]<<< [E:18026r M:124338506 (Ack:262239133)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 216945 [IN](S) Sending msg 124338506 on secure session with LSID: 40053
    00> I: 217437 [EM]>>> [E:18026r M:262239134 (Ack:124338506)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 217438 [IM]Received status response, status is 0x00
    00> E: 217443 [DMG]Error retrieving data from clusterId: 0x0000_003F, err = b
    00> I: 217448 [EM]<<< [E:18026r M:124338507 (Ack:262239134)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 217449 [IN](S) Sending msg 124338507 on secure session with LSID: 40053
    00> I: 217936 [EM]>>> [E:18026r M:262239135 (Ack:124338507)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 217936 [IM]Received status response, status is 0x00
    00> E: 217939 [DMG]Error retrieving data from clusterId: 0x0000_001D, err = b
    00> I: 217945 [EM]<<< [E:18026r M:124338508 (Ack:262239135)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 217946 [IN](S) Sending msg 124338508 on secure session with LSID: 40053
    00> I: 218438 [EM]>>> [E:18026r M:262239136 (Ack:124338508)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 218438 [IM]Received status response, status is 0x00
    00> E: 218442 [DMG]Error retrieving data from clusterId: 0x0000_0102, err = b
    00> I: 218448 [EM]<<< [E:18026r M:124338509 (Ack:262239136)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 218449 [IN](S) Sending msg 124338509 on secure session with LSID: 40053
    00> I: 218938 [EM]>>> [E:18026r M:262239137 (Ack:124338509)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 218938 [IM]Received status response, status is 0x00
    00> E: 218940 [DMG]Error retrieving data from clusterId: 0x0000_0102, err = b
    00> I: 218946 [EM]<<< [E:18026r M:124338510 (Ack:262239137)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 218946 [IN](S) Sending msg 124338510 on secure session with LSID: 40053
    00> I: 219436 [EM]>>> [E:18026r M:262239138 (Ack:124338510)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 219436 [IM]Received status response, status is 0x00
    00> I: 219439 [EM]<<< [E:18026r M:124338511 (Ack:262239138)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 219440 [IN](S) Sending msg 124338511 on secure session with LSID: 40053
    00> I: 219936 [EM]>>> [E:18026r M:262239139 (Ack:124338511)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 219937 [IM]Received status response, status is 0x00
    00> I: 219937 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 219938 [EM]<<< [E:18026r M:124338512 (Ack:262239139)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:04 (IM:SubscribeResponse)
    00> I: 219939 [IN](S) Sending msg 124338512 on secure session with LSID: 40053
    00> I: 220436 [EM]>>> [E:18026r M:262239140 (Ack:124338512)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 220437 [DL]OpenThread SED interval is 500ms
    00> I: 220448 [EM]>>> [E:18027r M:262239141] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:02 (IM:ReadRequest)
    00> D: 220449 [IM]Received Read request
    00> I: 220450 [DL]OpenThread SED interval is 500ms
    00> I: 220451 [EM]<<< [E:18027r M:124338513 (Ack:262239141)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 220452 [IN](S) Sending msg 124338513 on secure session with LSID: 40053
    00> I: 220949 [EM]>>> [E:18027r M:262239142 (Ack:124338513)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 220950 [DL]OpenThread SED interval is 500ms
    00> I: 221940 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 221946 [EM]<<< [E:39924i M:124338514] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 221946 [IN](S) Sending msg 124338514 on secure session with LSID: 40053
    00> I: 221948 [DL]OpenThread SED interval is 500ms
    00> I: 221949 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 222450 [EM]>>> [E:39924i M:262239143 (Ack:124338514)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 222451 [IM]Received status response, status is 0x00
    00> I: 222451 [DL]OpenThread SED interval is 500ms
    00> I: 222452 [EM]<<< [E:39924i M:124338515 (Ack:262239143)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 222453 [IN](S) Sending msg 124338515 on secure session with LSID: 40053
    00> I: 223950 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 223955 [EM]<<< [E:39925i M:124338516] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 223956 [IN](S) Sending msg 124338516 on secure session with LSID: 40053
    00> I: 223957 [DL]OpenThread SED interval is 500ms
    00> I: 223958 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 224453 [EM]>>> [E:39925i M:262239144 (Ack:124338516)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 224454 [IM]Received status response, status is 0x00
    00> I: 224454 [DL]OpenThread SED interval is 500ms
    00> I: 224455 [EM]<<< [E:39925i M:124338517 (Ack:262239144)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 224456 [IN](S) Sending msg 124338517 on secure session with LSID: 40053
    00> I: 225958 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 225963 [EM]<<< [E:39926i M:124338518] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 225964 [IN](S) Sending msg 124338518 on secure session with LSID: 40053
    00> I: 225965 [DL]OpenThread SED interval is 500ms
    00> I: 225966 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 226450 [EM]>>> [E:39926i M:262239145 (Ack:124338518)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 226451 [IM]Received status response, status is 0x00
    00> I: 226451 [DL]OpenThread SED interval is 500ms
    00> I: 226452 [EM]<<< [E:39926i M:124338519 (Ack:262239145)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 226453 [IN](S) Sending msg 124338519 on secure session with LSID: 40053
    00> I: 227967 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 227973 [EM]<<< [E:39927i M:124338520] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 227974 [IN](S) Sending msg 124338520 on secure session with LSID: 40053
    00> I: 227975 [DL]OpenThread SED interval is 500ms
    00> I: 227975 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 228451 [EM]>>> [E:39927i M:262239146 (Ack:124338520)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 228452 [IM]Received status response, status is 0x00
    00> I: 228452 [DL]OpenThread SED interval is 500ms
    00> I: 228453 [EM]<<< [E:39927i M:124338521 (Ack:262239146)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 228454 [IN](S) Sending msg 124338521 on secure session with LSID: 40053
    00> I: 229977 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 229982 [EM]<<< [E:39928i M:124338522] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 229983 [IN](S) Sending msg 124338522 on secure session with LSID: 40053
    00> I: 229984 [DL]OpenThread SED interval is 500ms
    00> I: 229985 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 230451 [EM]>>> [E:39928i M:262239147 (Ack:124338522)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 230451 [IM]Received status response, status is 0x00
    00> I: 230452 [DL]OpenThread SED interval is 500ms
    00> I: 230453 [EM]<<< [E:39928i M:124338523 (Ack:262239147)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 230453 [IN](S) Sending msg 124338523 on secure session with LSID: 40053
    00> I: 231986 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 231992 [EM]<<< [E:39929i M:124338524] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 231992 [IN](S) Sending msg 124338524 on secure session with LSID: 40053
    00> I: 231994 [DL]OpenThread SED interval is 500ms
    00> I: 231995 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 232452 [EM]>>> [E:39929i M:262239148 (Ack:124338524)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 232452 [IM]Received status response, status is 0x00
    00> I: 232453 [DL]OpenThread SED interval is 500ms
    00> I: 232454 [EM]<<< [E:39929i M:124338525 (Ack:262239148)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 232454 [IN](S) Sending msg 124338525 on secure session with LSID: 40053
    00> I: 233995 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 234001 [EM]<<< [E:39930i M:124338526] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 234001 [IN](S) Sending msg 124338526 on secure session with LSID: 40053
    00> I: 234003 [DL]OpenThread SED interval is 500ms
    00> I: 234003 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 234451 [EM]>>> [E:39930i M:262239149 (Ack:124338526)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 234451 [IM]Received status response, status is 0x00
    00> I: 234452 [DL]OpenThread SED interval is 500ms
    00> I: 234453 [EM]<<< [E:39930i M:124338527 (Ack:262239149)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 234453 [IN](S) Sending msg 124338527 on secure session with LSID: 40053
    00> I: 236004 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 236010 [EM]<<< [E:39931i M:124338528] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 236010 [IN](S) Sending msg 124338528 on secure session with LSID: 40053
    00> I: 236012 [DL]OpenThread SED interval is 500ms
    00> I: 236012 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 236451 [EM]>>> [E:39931i M:262239150 (Ack:124338528)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 236451 [IM]Received status response, status is 0x00
    00> I: 236452 [DL]OpenThread SED interval is 500ms
    00> I: 236453 [EM]<<< [E:39931i M:124338529 (Ack:262239150)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 236453 [IN](S) Sending msg 124338529 on secure session with LSID: 40053
    00> I: 238013 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 238019 [EM]<<< [E:39932i M:124338530] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 238019 [IN](S) Sending msg 124338530 on secure session with LSID: 40053
    00> I: 238021 [DL]OpenThread SED interval is 500ms
    00> I: 238022 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 238452 [EM]>>> [E:39932i M:262239151 (Ack:124338530)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 238453 [IM]Received status response, status is 0x00
    00> I: 238453 [DL]OpenThread SED interval is 500ms
    00> I: 238454 [EM]<<< [E:39932i M:124338531 (Ack:262239151)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 238455 [IN](S) Sending msg 124338531 on secure session with LSID: 40053
    00> I: 240023 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 240028 [EM]<<< [E:39933i M:124338532] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 240029 [IN](S) Sending msg 124338532 on secure session with LSID: 40053
    00> I: 240031 [DL]OpenThread SED interval is 500ms
    00> I: 240031 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 240454 [EM]>>> [E:39933i M:262239152 (Ack:124338532)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 240454 [IM]Received status response, status is 0x00
    00> I: 240455 [DL]OpenThread SED interval is 500ms
    00> I: 240455 [EM]<<< [E:39933i M:124338533 (Ack:262239152)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 240456 [IN](S) Sending msg 124338533 on secure session with LSID: 40053
    00> I: 242032 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 242038 [EM]<<< [E:39934i M:124338534] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 242038 [IN](S) Sending msg 124338534 on secure session with LSID: 40053
    00> I: 242040 [DL]OpenThread SED interval is 500ms
    00> I: 242040 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 242454 [EM]>>> [E:39934i M:262239153 (Ack:124338534)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 242454 [IM]Received status response, status is 0x00
    00> I: 242455 [DL]OpenThread SED interval is 500ms
    00> I: 242456 [EM]<<< [E:39934i M:124338535 (Ack:262239153)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 242456 [IN](S) Sending msg 124338535 on secure session with LSID: 40053
    00> I: 244040 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 244046 [EM]<<< [E:39935i M:124338536] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 244046 [IN](S) Sending msg 124338536 on secure session with LSID: 40053
    00> I: 244048 [DL]OpenThread SED interval is 500ms
    00> I: 244048 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 244452 [EM]>>> [E:39935i M:262239154 (Ack:124338536)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 244453 [IM]Received status response, status is 0x00
    00> I: 244453 [DL]OpenThread SED interval is 500ms
    00> I: 244454 [EM]<<< [E:39935i M:124338537 (Ack:262239154)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 244455 [IN](S) Sending msg 124338537 on secure session with LSID: 40053
    00> I: 246049 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 246055 [EM]<<< [E:39936i M:124338538] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 246055 [IN](S) Sending msg 124338538 on secure session with LSID: 40053
    00> I: 246057 [DL]OpenThread SED interval is 500ms
    00> I: 246057 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 246453 [EM]>>> [E:39936i M:262239155 (Ack:124338538)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 246453 [IM]Received status response, status is 0x00
    00> I: 246454 [DL]OpenThread SED interval is 500ms
    00> I: 246455 [EM]<<< [E:39936i M:124338539 (Ack:262239155)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 246455 [IN](S) Sending msg 124338539 on secure session with LSID: 40053
    00> I: 248058 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 248064 [EM]<<< [E:39937i M:124338540] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 248064 [IN](S) Sending msg 124338540 on secure session with LSID: 40053
    00> I: 248066 [DL]OpenThread SED interval is 500ms
    00> I: 248066 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 248453 [EM]>>> [E:39937i M:262239156 (Ack:124338540)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 248454 [IM]Received status response, status is 0x00
    00> I: 248454 [DL]OpenThread SED interval is 500ms
    00> I: 248455 [EM]<<< [E:39937i M:124338541 (Ack:262239156)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 248456 [IN](S) Sending msg 124338541 on secure session with LSID: 40053
    00> I: 250067 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 250072 [EM]<<< [E:39938i M:124338542] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 250073 [IN](S) Sending msg 124338542 on secure session with LSID: 40053
    00> I: 250075 [DL]OpenThread SED interval is 500ms
    00> I: 250075 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 250456 [EM]>>> [E:39938i M:262239157 (Ack:124338542)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 250457 [IM]Received status response, status is 0x00
    00> I: 250457 [DL]OpenThread SED interval is 500ms
    00> I: 250458 [EM]<<< [E:39938i M:124338543 (Ack:262239157)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 250458 [IN](S) Sending msg 124338543 on secure session with LSID: 40053
    00> I: 252076 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 252082 [EM]<<< [E:39939i M:124338544] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 252082 [IN](S) Sending msg 124338544 on secure session with LSID: 40053
    00> I: 252084 [DL]OpenThread SED interval is 500ms
    00> I: 252084 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 252558 [EM]>>> [E:39939i M:262239158 (Ack:124338544)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 252559 [IM]Received status response, status is 0x00
    00> I: 252559 [DL]OpenThread SED interval is 500ms
    00> I: 252560 [EM]<<< [E:39939i M:124338545 (Ack:262239158)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 252561 [IN](S) Sending msg 124338545 on secure session with LSID: 40053
    00> I: 254086 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 254091 [EM]<<< [E:39940i M:124338546] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 254092 [IN](S) Sending msg 124338546 on secure session with LSID: 40053
    00> I: 254093 [DL]OpenThread SED interval is 500ms
    00> I: 254094 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 254560 [EM]>>> [E:39940i M:262239159 (Ack:124338546)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 254561 [IM]Received status response, status is 0x00
    00> I: 254561 [DL]OpenThread SED interval is 500ms
    00> I: 254562 [EM]<<< [E:39940i M:124338547 (Ack:262239159)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 254563 [IN](S) Sending msg 124338547 on secure session with LSID: 40053
    00> I: 256096 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 256101 [EM]<<< [E:39941i M:124338548] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 256102 [IN](S) Sending msg 124338548 on secure session with LSID: 40053
    00> I: 256103 [DL]OpenThread SED interval is 500ms
    00> I: 256104 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 256559 [EM]>>> [E:39941i M:262239160 (Ack:124338548)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 256560 [IM]Received status response, status is 0x00
    00> I: 256560 [DL]OpenThread SED interval is 500ms
    00> I: 256561 [EM]<<< [E:39941i M:124338549 (Ack:262239160)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 256562 [IN](S) Sending msg 124338549 on secure session with LSID: 40053
    00> I: 258105 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 258110 [EM]<<< [E:39942i M:124338550] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 258111 [IN](S) Sending msg 124338550 on secure session with LSID: 40053
    00> I: 258112 [DL]OpenThread SED interval is 500ms
    00> I: 258113 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 258559 [EM]>>> [E:39942i M:262239161 (Ack:124338550)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 258560 [IM]Received status response, status is 0x00
    00> I: 258560 [DL]OpenThread SED interval is 500ms
    00> I: 258561 [EM]<<< [E:39942i M:124338551 (Ack:262239161)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 258562 [IN](S) Sending msg 124338551 on secure session with LSID: 40053
    00> I: 260114 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 260120 [EM]<<< [E:39943i M:124338552] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 260121 [IN](S) Sending msg 124338552 on secure session with LSID: 40053
    00> I: 260122 [DL]OpenThread SED interval is 500ms
    00> I: 260123 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 260560 [EM]>>> [E:39943i M:262239162 (Ack:124338552)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 260561 [IM]Received status response, status is 0x00
    00> I: 260561 [DL]OpenThread SED interval is 500ms
    00> I: 260562 [EM]<<< [E:39943i M:124338553 (Ack:262239162)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 260563 [IN](S) Sending msg 124338553 on secure session with LSID: 40053
    00> I: 262124 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 262129 [EM]<<< [E:39944i M:124338554] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 262130 [IN](S) Sending msg 124338554 on secure session with LSID: 40053
    00> I: 262131 [DL]OpenThread SED interval is 500ms
    00> I: 262132 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 262561 [EM]>>> [E:39944i M:262239163 (Ack:124338554)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 262562 [IM]Received status response, status is 0x00
    00> I: 262562 [DL]OpenThread SED interval is 500ms
    00> I: 262563 [EM]<<< [E:39944i M:124338555 (Ack:262239163)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 262564 [IN](S) Sending msg 124338555 on secure session with LSID: 40053
    00> I: 264132 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 264138 [EM]<<< [E:39945i M:124338556] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 264138 [IN](S) Sending msg 124338556 on secure session with LSID: 40053
    00> I: 264140 [DL]OpenThread SED interval is 500ms
    00> I: 264140 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 264562 [EM]>>> [E:39945i M:262239164 (Ack:124338556)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 264563 [IM]Received status response, status is 0x00
    00> I: 264563 [DL]OpenThread SED interval is 500ms
    00> I: 264564 [EM]<<< [E:39945i M:124338557 (Ack:262239164)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 264565 [IN](S) Sending msg 124338557 on secure session with LSID: 40053
    00> I: 266142 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 266147 [EM]<<< [E:39946i M:124338558] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 266148 [IN](S) Sending msg 124338558 on secure session with LSID: 40053
    00> I: 266150 [DL]OpenThread SED interval is 500ms
    00> I: 266150 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 266562 [EM]>>> [E:39946i M:262239165 (Ack:124338558)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 266563 [IM]Received status response, status is 0x00
    00> I: 266563 [DL]OpenThread SED interval is 500ms
    00> I: 266564 [EM]<<< [E:39946i M:124338559 (Ack:262239165)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 266565 [IN](S) Sending msg 124338559 on secure session with LSID: 40053
    00> I: 268151 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 268156 [EM]<<< [E:39947i M:124338560] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 268157 [IN](S) Sending msg 124338560 on secure session with LSID: 40053
    00> I: 268158 [DL]OpenThread SED interval is 500ms
    00> I: 268159 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 268562 [EM]>>> [E:39947i M:262239166 (Ack:124338560)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 268563 [IM]Received status response, status is 0x00
    00> I: 268563 [DL]OpenThread SED interval is 500ms
    00> I: 268564 [EM]<<< [E:39947i M:124338561 (Ack:262239166)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 268565 [IN](S) Sending msg 124338561 on secure session with LSID: 40053
    00> I: 270159 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 270164 [EM]<<< [E:39948i M:124338562] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 270165 [IN](S) Sending msg 124338562 on secure session with LSID: 40053
    00> I: 270167 [DL]OpenThread SED interval is 500ms
    00> I: 270167 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 270564 [EM]>>> [E:39948i M:262239167 (Ack:124338562)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 270564 [IM]Received status response, status is 0x00
    00> I: 270565 [DL]OpenThread SED interval is 500ms
    00> I: 270566 [EM]<<< [E:39948i M:124338563 (Ack:262239167)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 270566 [IN](S) Sending msg 124338563 on secure session with LSID: 40053
    00> I: 272168 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 272174 [EM]<<< [E:39949i M:124338564] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 272174 [IN](S) Sending msg 124338564 on secure session with LSID: 40053
    00> I: 272176 [DL]OpenThread SED interval is 500ms
    00> I: 272176 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 272564 [EM]>>> [E:39949i M:262239168 (Ack:124338564)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 272565 [IM]Received status response, status is 0x00
    00> I: 272565 [DL]OpenThread SED interval is 500ms
    00> I: 272566 [EM]<<< [E:39949i M:124338565 (Ack:262239168)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 272567 [IN](S) Sending msg 124338565 on secure session with LSID: 40053
    00> I: 274178 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 274183 [EM]<<< [E:39950i M:124338566] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 274184 [IN](S) Sending msg 124338566 on secure session with LSID: 40053
    00> I: 274185 [DL]OpenThread SED interval is 500ms
    00> I: 274186 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 274563 [EM]>>> [E:39950i M:262239169 (Ack:124338566)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 274563 [IM]Received status response, status is 0x00
    00> I: 274564 [DL]OpenThread SED interval is 500ms
    00> I: 274565 [EM]<<< [E:39950i M:124338567 (Ack:262239169)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 274565 [IN](S) Sending msg 124338567 on secure session with LSID: 40053
    00> I: 276186 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 276192 [EM]<<< [E:39951i M:124338568] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 276192 [IN](S) Sending msg 124338568 on secure session with LSID: 40053
    00> I: 276194 [DL]OpenThread SED interval is 500ms
    00> I: 276194 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds

    Install the latest version of sniffer according to the link, but received very little data. 

    Best regards,
    Danny

  • Are you sure the sniffer is started on the correct channel? Looks like there is very few packets if your image shows the entire sniffer log.

    Can you try enabling DEBUG log level in your application build according to my previous links, to see if this provides more details in the device logs?

  • Hi,

       The public version of the windowcovering sample I tested also has this phenomenon. Can you reproduce it?

       Following the process:Commission the sample,and Power off the sample for a while,and then turn on the power,the home app show no repond all the time.But The light_bulb  sample is working normally following the same process.

       WireShake configuration:(Use Nrf52840 Doggle),Are there any issues with the configuration?

        NRF52840 window covering log:

    00> I: nRF5 802154 radio initialized
    00> I: 4 Sectors of 4096 bytes
    00> I: alloc wra: 1, e70
    00> I: data wra: 1, 63c
    00> *** Booting Zephyr OS build v3.2.99-ncs2 ***
    00> I: Init CHIP stack
    00> I: 214 [DL]BLE address: E5:B2:6F:10:63:30
    00> I: 218 [DL]OpenThread SED interval is 500ms
    00> I: 257 [DL]OpenThread ifconfig up and thread start
    00> I: 261 [DL]OpenThread started: OK
    00> I: 261 [DL]Setting OpenThread device type to SYNCHRONIZED SLEEPY END DEVICE
    00> I: uart_init...
    00> I: StartUartTimer
    00> I: 262 [SVR]Server initializing...
    00> I: 263 [TS]Last Known Good Time: 2023-04-25T17:20:00
    00> I: 267 [FP]Fabric index 0x1 was retrieved from storage. Compressed FabricId 0xCCA458A73881E3D2, FabricId 0x0000000000000001, NodeId 0x00000000E0B83703, VendorId 0x1349
    00> I: 270 [FP]Fabric index 0x2 was retrieved from storage. Compressed FabricId 0xF64035E83E412165, FabricId 0x0000000000000002, NodeId 0x000000001F8A003D, VendorId 0x1384
    00> I: 272 [DMG]AccessControl: initializing
    00> I: 272 [DMG]Examples::AccessControlDelegate::Init
    00> I: 273 [DMG]AccessControl: setting
    00> I: 273 [DMG]DefaultAclStoragE: 4866 [DL]SRP update error: timed out waiting on server response
    00> I: UartSleep set pin gpio@50000000 2
    00> 
    00> I: CancelUartTimer
    00> I: UartSleep set end
    00> 
    00> I: 22909 [EM]>>> [E:21114r M:60693269] (U) Msg RX from 0:2A93603EA476CBA2 [0000] --- Type 0000:30 (SecureChannel:CASE_Sigma1)
    00> I: 22910 [EM]<<< [E:21114r M:235396625 (Ack:60693269)] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 22911 [IN](U) Sending msg 235396625 to IP address 'UDP:[fd85:4025:13b2:0:ef0e:d145:69fc:5121]:61284'
    00> E: 40037 [SC]CASESession timed out while waiting for a response from the peer. Current state was 5
    00> E: 40037 [IN]CASE Session establishment failed: 32
    00> I: 40037 [IN]CASE Server enabling CASE session setups
    00> D: 40038 [IN]SecureSession[0x20003578]: Released - Type:2 LSID:64331
    00> D: 40038 [IN]SecureSession[0x20003578]: Allocated Type:2 LSID:64332
    00> I: 40039 [DL]OpenThread SED interval is 500ms
    00> I: 117410 [EM]>>> [E:21115r M:60693270] (U) Msg RX from 0:5BECF2A9E3B6E5F2 [0000] --- Type 0000:30 (SecureChannel:CASE_Sigma1)
    00> I: 117411 [IN]CASE Server received Sigma1 message. Starting handshake. EC 0x20004ea8
    00> I: 117411 [IN]CASE Server disabling CASE session setups
    00> I: 117412 [EM]<<< [E:21115r M:235396626 (Ack:60693270)] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 117413 [IN](U) Sending msg 235396626 to IP address 'UDP:[fd85:4025:13b2:0:ef0e:d145:69fc:5121]:61284'
    00> I: 117414 [SC]Received Sigma1 msg
    00> I: 117418 [EM]<<< [E:21115r M:235396627 (Ack:60693270)] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:33 (SecureChannel:CASE_Sigma2Resume)
    00> I: 117420 [IN](U) Sending msg 235396627 to IP address 'UDP:[fd85:4025:13b2:0:ef0e:d145:69fc:5121]:61284'
    00> I: 117422 [DL]OpenThread SED interval is 500ms
    00> I: 118817 [IN](U) Sending msg 235396627 to IP address 'UDP:[fd85:4025:13b2:0:ef0e:d145:69fc:5121]:61284'
    00> I: 118839 [EM]>>> [E:21115r M:60693271 (Ack:235396627)] (U) Msg RX from 0:5BECF2A9E3B6E5F2 [0000] --- Type 0000:40 (SecureChannel:StatusReport)
    00> I: 118840 [SC]Success status report received. Session was established
    00> I: 118881 [SC]SecureSession[0x20003578]: Moving from state 'kEstablishing' --> 'kActive'
    00> D: 118881 [IN]SecureSession[0x20003578]: Activated - Type:2 LSID:64332
    00> D: 118882 [IN]New secure session activated for device <5ABECE966C84D61C, 1>, LSID:64332 PSID:57552!
    00> I: 118882 [IN]CASE Session established to peer: <5ABECE966C84D61C, 1>
    00> I: 118883 [IN]CASE Server enabling CASE session setups
    00> D: 118883 [IN]SecureSession[0x20003630]: Allocated Type:2 LSID:64333
    00> I: 118884 [DL]OpenThread SED interval is 500ms
    00> I: 118884 [EM]<<< [E:21115r M:235396628 (Ack:60693271)] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 118885 [IN](U) Sending msg 235396628 to IP address 'UDP:[fd85:4025:13b2:0:ef0e:d145:69fc:5121]:61284'
    00> I: 119023 [EM]>>> [E:21116r M:134862488] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:03 (IM:SubscribeRequest)
    00> D: 119024 [IM]Received Subscribe request
    00> I: 119030 [DMG]Final negotiated min/max parameters: Min = 0s, Max = 2s
    00> I: 119031 [DL]OpenThread SED interval is 500ms
    00> E: 119034 [DMG]Error retrieving data from clusterId: 0x0000_001F, err = b
    00> I: 119041 [EM]<<< [E:21116r M:30572577 (Ack:134862488)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 119042 [IN](S) Sending msg 30572577 on secure session with LSID: 64332
    00> I: 119045 [EM]>>> [E:21115r M:60693272 (Ack:235396627)] (U) Msg RX from 0:5BECF2A9E3B6E5F2 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> D: 119191 [IN]Received a duplicate message with MessageCounter:134862488 on exchange 21116r
    00> I: 119192 [EM]>>> [E:21116r M:134862488] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:03 (IM:SubscribeRequest)
    00> I: 119193 [EM]<<< [E:21116r M:30572578 (Ack:134862488)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 119194 [IN](S) Sending msg 30572578 on secure session with LSID: 64332
    00> I: 120435 [IN](S) Sending msg 30572577 on secure session with LSID: 64332
    00> I: 121782 [IN](S) Sending msg 30572577 on secure session with LSID: 64332
    00> I: 121807 [EM]>>> [E:21116r M:134862490 (Ack:30572577)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 121831 [EM]>>> [E:21116r M:134862489 (Ack:30572577)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 121832 [IM]Received status response, status is 0x00
    00> E: 121843 [DMG]Error retrieving data from clusterId: 0x0000_0028, err = b
    00> I: 121850 [EM]<<< [E:21116r M:30572579 (Ack:134862489)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 121852 [IN](S) Sending msg 30572579 on secure session with LSID: 64332
    00> I: 121957 [EM]>>> [E:21116r M:134862491 (Ack:30572577)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 123199 [IN](S) Sending msg 30572579 on secure session with LSID: 64332
    00> I: 123879 [EM]>>> [E:21116r M:134862493 (Ack:30572579)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 124880 [EM]>>> [E:21116r M:134862492 (Ack:30572579)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 124880 [IM]Received status response, status is 0x00
    00> E: 124886 [DMG]Error retrieving data from clusterId: 0x0000_002A, err = b
    00> I: 124892 [EM]<<< [E:21116r M:30572580 (Ack:134862492)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 124893 [IN](S) Sending msg 30572580 on secure session with LSID: 64332
    00> I: 126301 [IN](S) Sending msg 30572580 on secure session with LSID: 64332
    00> I: 126325 [EM]>>> [E:21116r M:134862494 (Ack:30572580)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 126326 [IM]Received status response, status is 0x00
    00> E: 126330 [DMG]Error retrieving data from clusterId: 0x0000_0030, err = b
    00> I: 126338 [EM]<<< [E:21116r M:30572581 (Ack:134862494)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 126338 [IN](S) Sending msg 30572581 on secure session with LSID: 64332
    00> I: 126451 [EM]>>> [E:21116r M:134862495 (Ack:30572580)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 127677 [IN](S) Sending msg 30572581 on secure session with LSID: 64332
    00> I: 128379 [EM]>>> [E:21116r M:134862497 (Ack:30572581)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 129380 [EM]>>> [E:21116r M:134862496 (Ack:30572581)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 129380 [IM]Received status response, status is 0x00
    00> E: 129385 [DMG]Error retrieving data from clusterId: 0x0000_0031, err = b
    00> I: 129391 [EM]<<< [E:21116r M:30572582 (Ack:134862496)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 129391 [IN](S) Sending msg 30572582 on secure session with LSID: 64332
    00> I: 130380 [EM]>>> [E:21116r M:134862498 (Ack:30572582)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 130380 [IM]Received status response, status is 0x00
    00> E: 130385 [DMG]Error retrieving data from clusterId: 0x0000_0033, err = b
    00> I: 130391 [EM]<<< [E:21116r M:30572583 (Ack:134862498)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 130392 [IN](S) Sending msg 30572583 on secure session with LSID: 64332
    00> I: 131787 [IN](S) Sending msg 30572583 on secure session with LSID: 64332
    00> I: 131813 [EM]>>> [E:21116r M:134862499 (Ack:30572583)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 131814 [IM]Received status response, status is 0x00
    00> E: 131818 [DL]_WriteThreadNetworkDiagnosticAttributeToTlv failed: Error CHIP:0x0000000B
    00> E: 131818 [DMG]Error retrieving data from clusterId: 0x0000_0035, err = b
    00> I: 131828 [EM]<<< [E:21116r M:30572584 (Ack:134862499)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 131828 [IN](S) Sending msg 30572584 on secure session with LSID: 64332
    00> I: 131934 [EM]>>> [E:21116r M:134862500 (Ack:30572583)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> D: 132002 [IN]Received a duplicate message with MessageCounter:134862499 on exchange 21116r
    00> I: 132002 [EM]>>> [E:21116r M:134862499 (Ack:30572583)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 132004 [EM]<<< [E:21116r M:30572585 (Ack:134862499)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 132005 [IN](S) Sending msg 30572585 on secure session with LSID: 64332
    00> I: 133163 [IN](S) Sending msg 30572584 on secure session with LSID: 64332
    00> I: 133879 [EM]>>> [E:21116r M:134862502 (Ack:30572584)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 134880 [EM]>>> [E:21116r M:134862501 (Ack:30572584)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 134880 [IM]Received status response, status is 0x00
    00> E: 134886 [DL]_WriteThreadNetworkDiagnosticAttributeToTlv failed: Error CHIP:0x0000000B
    00> E: 134886 [DMG]Error retrieving data from clusterId: 0x0000_0035, err = b
    00> I: 134892 [EM]<<< [E:21116r M:30572586 (Ack:134862501)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 134893 [IN](S) Sending msg 30572586 on secure session with LSID: 64332
    00> I: 136297 [IN](S) Sending msg 30572586 on secure session with LSID: 64332
    00> I: 136322 [EM]>>> [E:21116r M:134862503 (Ack:30572586)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 136322 [IM]Received status response, status is 0x00
    00> E: 136341 [DMG]Error retrieving data from clusterId: 0x0000_0035, err = b
    00> I: 136348 [EM]<<< [E:21116r M:30572587 (Ack:134862503)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 136349 [IN](S) Sending msg 30572587 on secure session with LSID: 64332
    00> I: 136446 [EM]>>> [E:21116r M:134862504 (Ack:30572586)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 137727 [IN](S) Sending msg 30572587 on secure session with LSID: 64332
    00> I: 137752 [EM]>>> [E:21116r M:134862505 (Ack:30572587)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 137753 [IM]Received status response, status is 0x00
    00> E: 137755 [DMG]Error retrieving data from clusterId: 0x0000_0035, err = b
    00> I: 137763 [EM]<<< [E:21116r M:30572588 (Ack:134862505)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 137764 [IN](S) Sending msg 30572588 on secure session with LSID: 64332
    00> I: 137866 [EM]>>> [E:21116r M:134862506 (Ack:30572587)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 139142 [IN](S) Sending msg 30572588 on secure session with LSID: 64332
    00> I: 139165 [EM]>>> [E:21116r M:134862507 (Ack:30572588)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 139166 [IM]Received status response, status is 0x00
    00> E: 139169 [DMG]Error retrieving data from clusterId: 0x0000_003C, err = b
    00> I: 139177 [EM]<<< [E:21116r M:30572589 (Ack:134862507)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 139178 [IN](S) Sending msg 30572589 on secure session with LSID: 64332
    00> I: 139282 [EM]>>> [E:21116r M:134862508 (Ack:30572588)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 140587 [IN](S) Sending msg 30572589 on secure session with LSID: 64332
    00> I: 140613 [EM]>>> [E:21116r M:134862509 (Ack:30572589)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 140613 [IM]Received status response, status is 0x00
    00> E: 140619 [DMG]Error retrieving data from clusterId: 0x0000_003E, err = b
    00> I: 140627 [EM]<<< [E:21116r M:30572590 (Ack:134862509)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 140628 [IN](S) Sending msg 30572590 on secure session with LSID: 64332
    00> I: 140719 [EM]>>> [E:21116r M:134862510 (Ack:30572589)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 141380 [EM]>>> [E:21116r M:134862511 (Ack:30572590)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 141380 [IM]Received status response, status is 0x00
    00> E: 141383 [DMG]Error retrieving data from clusterId: 0x0000_003E, err = b
    00> I: 141388 [EM]<<< [E:21116r M:30572591 (Ack:134862511)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 141389 [IN](S) Sending msg 30572591 on secure session with LSID: 64332
    00> I: 141880 [EM]>>> [E:21116r M:134862512 (Ack:30572591)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 141880 [IM]Received status response, status is 0x00
    00> E: 141885 [DMG]Error retrieving data from clusterId: 0x0000_003F, err = b
    00> I: 141891 [EM]<<< [E:21116r M:30572592 (Ack:134862512)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 141891 [IN](S) Sending msg 30572592 on secure session with LSID: 64332
    00> I: 142880 [EM]>>> [E:21116r M:134862513 (Ack:30572592)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 142880 [IM]Received status response, status is 0x00
    00> E: 142883 [DMG]Error retrieving data from clusterId: 0x0000_001D, err = b
    00> I: 142889 [EM]<<< [E:21116r M:30572593 (Ack:134862513)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 142889 [IN](S) Sending msg 30572593 on secure session with LSID: 64332
    00> I: 143880 [EM]>>> [E:21116r M:134862514 (Ack:30572593)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 143880 [IM]Received status response, status is 0x00
    00> E: 143884 [DMG]Error retrieving data from clusterId: 0x0000_0102, err = b
    00> I: 143890 [EM]<<< [E:21116r M:30572594 (Ack:134862514)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 143891 [IN](S) Sending msg 30572594 on secure session with LSID: 64332
    00> I: 145271 [IN](S) Sending msg 30572594 on secure session with LSID: 64332
    00> I: 145296 [EM]>>> [E:21116r M:134862515 (Ack:30572594)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 145297 [IM]Received status response, status is 0x00
    00> E: 145299 [DMG]Error retrieving data from clusterId: 0x0000_0102, err = b
    00> I: 145307 [EM]<<< [E:21116r M:30572595 (Ack:134862515)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 145308 [IN](S) Sending msg 30572595 on secure session with LSID: 64332
    00> I: 145417 [EM]>>> [E:21116r M:134862516 (Ack:30572594)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 146701 [IN](S) Sending msg 30572595 on secure session with LSID: 64332
    00> I: 148087 [IN](S) Sending msg 30572595 on secure session with LSID: 64332
    00> I: 148380 [EM]>>> [E:21116r M:134862518 (Ack:30572595)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 148399 [EM]>>> [E:21116r M:134862517 (Ack:30572595)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 148399 [IM]Received status response, status is 0x00
    00> I: 148402 [EM]<<< [E:21116r M:30572596 (Ack:134862517)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 148404 [IN](S) Sending msg 30572596 on secure session with LSID: 64332
    00> I: 148492 [EM]>>> [E:21116r M:134862519 (Ack:30572595)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 149786 [IN](S) Sending msg 30572596 on secure session with LSID: 64332
    00> I: 149810 [EM]>>> [E:21116r M:134862520 (Ack:30572596)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 149810 [IM]Received status response, status is 0x00
    00> I: 149811 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 149812 [EM]<<< [E:21116r M:30572597 (Ack:134862520)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:04 (IM:SubscribeResponse)
    00> I: 149813 [IN](S) Sending msg 30572597 on secure session with LSID: 64332
    00> I: 151190 [IN](S) Sending msg 30572597 on secure session with LSID: 64332
    00> I: 151380 [EM]>>> [E:21116r M:134862522 (Ack:30572597)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 151380 [DL]OpenThread SED interval is 500ms
    00> I: 151393 [EM]>>> [E:21117r M:134862523] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:02 (IM:ReadRequest)
    00> D: 151394 [IM]Received Read request
    00> I: 151395 [DL]OpenThread SED interval is 500ms
    00> I: 151397 [EM]<<< [E:21117r M:30572598 (Ack:134862523)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 151397 [IN](S) Sending msg 30572598 on secure session with LSID: 64332
    00> I: 151405 [EM]>>> [E:21116r M:134862524 (Ack:30572597)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 151814 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 151820 [EM]<<< [E:48703i M:30572599] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 151820 [IN](S) Sending msg 30572599 on secure session with LSID: 64332
    00> I: 151822 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 151842 [EM]>>> [E:21117r M:134862525 (Ack:30572598)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 153223 [IN](S) Sending msg 30572599 on secure session with LSID: 64332
    00> I: 153380 [EM]>>> [E:48703i M:134862526 (Ack:30572599)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 153380 [IM]Received status response, status is 0x00
    00> I: 153381 [DL]OpenThread SED interval is 500ms
    00> I: 153382 [EM]<<< [E:48703i M:30572600 (Ack:134862526)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 153382 [IN](S) Sending msg 30572600 on secure session with LSID: 64332
    00> I: 153410 [EM]>>> [E:48703i M:134862527 (Ack:30572599)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> E: 153411 [EM]OnMessageReceived failed, err = 70
    00> D: 153424 [IN]Received a duplicate message with MessageCounter:134862526 on exchange 48703i
    00> I: 153425 [EM]>>> [E:48703i M:134862526 (Ack:30572599)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 153426 [EM]<<< [E:48703i M:30572601 (Ack:134862526)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 153427 [IN](S) Sending msg 30572601 on secure session with LSID: 64332
    00> I: 153824 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 153829 [EM]<<< [E:48704i M:30572602] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 153830 [IN](S) Sending msg 30572602 on secure session with LSID: 64332
    00> I: 153831 [DL]OpenThread SED interval is 500ms
    00> I: 153832 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 155178 [IN](S) Sending msg 30572602 on secure session with LSID: 64332
    00> I: 155380 [EM]>>> [E:48704i M:134862528 (Ack:30572602)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 155380 [IM]Received status response, status is 0x00
    00> I: 155381 [DL]OpenThread SED interval is 500ms
    00> I: 155382 [EM]<<< [E:48704i M:30572603 (Ack:134862528)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 155382 [IN](S) Sending msg 30572603 on secure session with LSID: 64332
    00> I: 155413 [EM]>>> [E:48704i M:134862529 (Ack:30572602)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> E: 155414 [EM]OnMessageReceived failed, err = 70
    00> D: 155427 [IN]Received a duplicate message with MessageCounter:134862528 on exchange 48704i
    00> I: 155428 [EM]>>> [E:48704i M:134862528 (Ack:30572602)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 155429 [EM]<<< [E:48704i M:30572604 (Ack:134862528)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 155429 [IN](S) Sending msg 30572604 on secure session with LSID: 64332
    00> I: 155832 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 155838 [EM]<<< [E:48705i M:30572605] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 155838 [IN](S) Sending msg 30572605 on secure session with LSID: 64332
    00> I: 155840 [DL]OpenThread SED interval is 500ms
    00> I: 155840 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 157216 [IN](S) Sending msg 30572605 on secure session with LSID: 64332
    00> I: 157380 [EM]>>> [E:48705i M:134862530 (Ack:30572605)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 157380 [IM]Received status response, status is 0x00
    00> I: 157381 [DL]OpenThread SED interval is 500ms
    00> I: 157382 [EM]<<< [E:48705i M:30572606 (Ack:134862530)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 157382 [IN](S) Sending msg 30572606 on secure session with LSID: 64332
    00> I: 157398 [EM]>>> [E:48705i M:134862531 (Ack:30572605)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> E: 157398 [EM]OnMessageReceived failed, err = 70
    00> D: 157419 [IN]Received a duplicate message with MessageCounter:134862530 on exchange 48705i
    00> I: 157419 [EM]>>> [E:48705i M:134862530 (Ack:30572605)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 157421 [EM]<<< [E:48705i M:30572607 (Ack:134862530)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 157421 [IN](S) Sending msg 30572607 on secure session with LSID: 64332
    00> I: 157841 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 157846 [EM]<<< [E:48706i M:30572608] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 157847 [IN](S) Sending msg 30572608 on secure session with LSID: 64332
    00> I: 157849 [DL]OpenThread SED interval is 500ms
    00> I: 157849 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 159247 [IN](S) Sending msg 30572608 on secure session with LSID: 64332
    00> I: 159380 [EM]>>> [E:48706i M:134862532 (Ack:30572608)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 159380 [IM]Received status response, status is 0x00
    00> I: 159381 [DL]OpenThread SED interval is 500ms
    00> I: 159382 [EM]<<< [E:48706i M:30572609 (Ack:134862532)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 159382 [IN](S) Sending msg 30572609 on secure session with LSID: 64332
    00> I: 159404 [EM]>>> [E:48706i M:134862533 (Ack:30572608)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> E: 159404 [EM]OnMessageReceived failed, err = 70
    00> I: 159850 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 159856 [EM]<<< [E:48707i M:30572610] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 159856 [IN](S) Sending msg 30572610 on secure session with LSID: 64332
    00> I: 159858 [DL]OpenThread SED interval is 500ms
    00> I: 159858 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 161209 [IN](S) Sending msg 30572610 on secure session with LSID: 64332
    00> I: 161233 [EM]>>> [E:48707i M:134862534 (Ack:30572610)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 161233 [IM]Received status response, status is 0x00
    00> I: 161234 [DL]OpenThread SED interval is 500ms
    00> I: 161235 [EM]<<< [E:48707i M:30572611 (Ack:134862534)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 161235 [IN](S) Sending msg 30572611 on secure session with LSID: 64332
    00> I: 161259 [EM]>>> [E:48707i M:134862535 (Ack:30572610)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> E: 161260 [EM]OnMessageReceived failed, err = 70
    00> I: 161859 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 161865 [EM]<<< [E:48708i M:30572612] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 161865 [IN](S) Sending msg 30572612 on secure session with LSID: 64332
    00> I: 161867 [DL]OpenThread SED interval is 500ms
    00> I: 161867 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 161899 [EM]>>> [E:48708i M:134862536 (Ack:30572612)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 161900 [IM]Received status response, status is 0x00
    00> I: 161900 [DL]OpenThread SED interval is 500ms
    00> I: 161901 [EM]<<< [E:48708i M:30572613 (Ack:134862536)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 161902 [IN](S) Sending msg 30572613 on secure session with LSID: 64332
    00> I: 163869 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 163875 [EM]<<< [E:48709i M:30572614] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 163875 [IN](S) Sending msg 30572614 on secure session with LSID: 64332
    00> I: 163877 [DL]OpenThread SED interval is 500ms
    00> I: 163877 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 165284 [IN](S) Sending msg 30572614 on secure session with LSID: 64332
    00> I: 165309 [EM]>>> [E:48709i M:134862537 (Ack:30572614)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 165310 [IM]Received status response, status is 0x00
    00> I: 165310 [DL]OpenThread SED interval is 500ms
    00> I: 165311 [EM]<<< [E:48709i M:30572615 (Ack:134862537)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 165313 [IN](S) Sending msg 30572615 on secure session with LSID: 64332
    00> I: 165326 [EM]>>> [E:48709i M:134862538 (Ack:30572614)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> E: 165326 [EM]OnMessageReceived failed, err = 70
    00> I: 165878 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 165884 [EM]<<< [E:48710i M:30572616] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 165884 [IN](S) Sending msg 30572616 on secure session with LSID: 64332
    00> I: 165886 [DL]OpenThread SED interval is 500ms
    00> I: 165886 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 167232 [IN](S) Sending msg 30572616 on secure session with LSID: 64332
    00> I: 167255 [EM]>>> [E:48710i M:134862539 (Ack:30572616)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 167256 [IM]Received status response, status is 0x00
    00> I: 167256 [DL]OpenThread SED interval is 500ms
    00> I: 167257 [EM]<<< [E:48710i M:30572617 (Ack:134862539)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 167257 [IN](S) Sending msg 30572617 on secure session with LSID: 64332
    00> I: 167280 [EM]>>> [E:48710i M:134862540 (Ack:30572616)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> E: 167281 [EM]OnMessageReceived failed, err = 70
    00> I: 167886 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 167892 [EM]<<< [E:48711i M:30572618] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 167892 [IN](S) Sending msg 30572618 on secure session with LSID: 64332
    00> I: 167894 [DL]OpenThread SED interval is 500ms
    00> I: 167894 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 169232 [IN](S) Sending msg 30572618 on secure session with LSID: 64332
    00> I: 169895 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 170581 [IN](S) Sending msg 30572618 on secure session with LSID: 64332
    00> I: 170880 [EM]>>> [E:48711i M:134862542 (Ack:30572618)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 170892 [EM]>>> [E:48711i M:134862541 (Ack:30572618)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 170893 [IM]Received status response, status is 0x00
    00> I: 170893 [DL]OpenThread SED interval is 500ms
    00> I: 170895 [EM]<<< [E:48711i M:30572619 (Ack:134862541)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 170896 [IN](S) Sending msg 30572619 on secure session with LSID: 64332
    00> I: 170904 [EM]<<< [E:48712i M:30572620] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 170905 [IN](S) Sending msg 30572620 on secure session with LSID: 64332
    00> I: 170906 [DL]OpenThread SED interval is 500ms
    00> I: 170906 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 170909 [EM]>>> [E:48711i M:134862543 (Ack:30572618)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> E: 170910 [EM]OnMessageReceived failed, err = 70
    00> I: 171880 [EM]>>> [E:48712i M:134862544 (Ack:30572620)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 171880 [IM]Received status response, status is 0x00
    00> I: 171881 [DL]OpenThread SED interval is 500ms
    00> I: 171882 [EM]<<< [E:48712i M:30572621 (Ack:134862544)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 171882 [IN](S) Sending msg 30572621 on secure session with LSID: 64332
    00> I: 172907 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 172913 [EM]<<< [E:48713i M:30572622] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 172913 [IN](S) Sending msg 30572622 on secure session with LSID: 64332
    00> I: 172915 [DL]OpenThread SED interval is 500ms
    00> I: 172915 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 173880 [EM]>>> [E:48713i M:134862545 (Ack:30572622)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 173880 [IM]Received status response, status is 0x00
    00> I: 173881 [DL]OpenThread SED interval is 500ms
    00> I: 173882 [EM]<<< [E:48713i M:30572623 (Ack:134862545)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 173882 [IN](S) Sending msg 30572623 on secure session with LSID: 64332
    00> I: 174916 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 174922 [EM]<<< [E:48714i M:30572624] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 174922 [IN](S) Sending msg 30572624 on secure session with LSID: 64332
    00> I: 174924 [DL]OpenThread SED interval is 500ms
    00> I: 174925 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 176311 [IN](S) Sending msg 30572624 on secure session with LSID: 64332
    00> I: 176336 [EM]>>> [E:48714i M:134862546 (Ack:30572624)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 176337 [IM]Received status response, status is 0x00
    00> I: 176337 [DL]OpenThread SED interval is 500ms
    00> I: 176338 [EM]<<< [E:48714i M:30572625 (Ack:134862546)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 176339 [IN](S) Sending msg 30572625 on secure session with LSID: 64332
    00> I: 176364 [EM]>>> [E:48714i M:134862547 (Ack:30572624)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> E: 176364 [EM]OnMessageReceived failed, err = 70
    00> I: 176925 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 176930 [EM]<<< [E:48715i M:30572626] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 176931 [IN](S) Sending msg 30572626 on secure session with LSID: 64332
    00> I: 176933 [DL]OpenThread SED interval is 500ms
    00> I: 176933 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 178262 [IN](S) Sending msg 30572626 on secure session with LSID: 64332
    00> I: 178935 [DMG]Refresh subscribe timer sync after 2 seconds
    00> I: 179629 [IN](S) Sending msg 30572626 on secure session with LSID: 64332
    00> I: 179880 [EM]>>> [E:48715i M:134862549 (Ack:30572626)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 179893 [EM]>>> [E:48715i M:134862548 (Ack:30572626)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0001:01 (IM:StatusResponse)
    00> I: 179894 [IM]Received status response, status is 0x00
    00> I: 179894 [DL]OpenThread SED interval is 500ms
    00> I: 179895 [EM]<<< [E:48715i M:30572627 (Ack:134862548)] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> I: 179896 [IN](S) Sending msg 30572627 on secure session with LSID: 64332
    00> I: 179902 [EM]<<< [E:48716i M:30572628] (S) Msg TX to 1:5ABECE966C84D61C [E3D2] --- Type 0001:05 (IM:ReportData)
    00> I: 179903 [IN](S) Sending msg 30572628 on secure session with LSID: 64332
    00> I: 179904 [DL]OpenThread SED interval is 500ms
    00> I: 179905 [DMG]Refresh Subscribe Sync Timer with min 0 seconds and max 2 seconds
    00> I: 179910 [EM]>>> [E:48715i M:134862550 (Ack:30572626)] (S) Msg RX from 1:5ABECE966C84D61C [E3D2] --- Type 0000:10 (SecureChannel:StandaloneAck)
    00> E: 179911 [EM]OnMessageReceived failed, err = 70

    Best regards,
    Danny

  • Hi,

      Can you help me test it?

    Best regards,
    Danny

Related