00> *** Booting nRF Connect SDK v3.0.2-89ba1294ac9b ***
00> *** Using Zephyr OS v4.0.99-f791c49f492c ***
00> I: 226 [DL]BLE address: CF:8F:81:D5:2E:CF
00> I: Initializing all sensor services.
00> I: 229 [DL]CHIP task running
00> I: Init CHIP stack
00> I: 230 [DL]OpenThread started: OK
00> I: 230 [DL]Setting OpenThread device type to SLEEPY END DEVICE
00> I: 232 [DL]Found DAC Private Key in factory data set. Copying to secure storage...
00> I: 237 [DL]The device does not support hardware protection against write.
00> D: Registered new test event: 0xffffffff00000000
00> D: Registered new test event: 0xffffffff10000000
00> I: 237 [SVR]Subscription persistence not supported
00> I: 237 [SVR]Server initializing...
00> I: 237 [TS]Last Known Good Time: [unknown]
00> I: 237 [TS]Setting Last Known Good Time to firmware build time 2023-10-14T01:16:48
00> I: 239 [DMG]AccessControl: initializing
00> I: 239 [DMG]Examples::AccessControlDelegate::Init
00> I: 239 [DMG]AccessControl: setting
00> I: 240 [DMG]DefaultAclStorage: initializing
00> I: 240 [DMG]DefaultAclStorage: 0 entries loaded
00> D: 240 [IN]UDP::InI: 21523 [DL]Current number of connections: 1/1
00> I: 21523 [DL]BLE connection established (ConnId: 0x00)
00> I: 21524 [DL]CHIPoBLE advertising stopped
00> D: 22481 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
00> I: 22481 [BLE]local and remote recv window sizes = 5
00> I: 22482 [BLE]selected BTP version 4
00> I: 22482 [BLE]using BTP fragment sizes rx 182 / tx 182.
00> D: 22631 [DL]ConnId: 0x00, New CCCD value: 0x0002
00> D: 22631 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 6)
00> D: 22632 [IN]BLE EndPoint 0x2000d188 Connection Complete
00> I: 22632 [DL]CHIPoBLE connection established (ConnId: 0x00, GATT MTU: 185)
00> D: 22691 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
00> D: 22694 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
00> I: 22695 [EM]>>> [E:4909r S:0 M:75511557] (U) Msg RX from 0:1EE08255A5B3AB7C [0000] to 0000000000000000 --- Type 0000:20 (SecureChannel:PBKDFParamRequest) (B:98)
00> I: 22696 [EM]<<< [E:4909r S:0 M:239902453] (U) Msg TX from 0000000000000000 to 0:1EE08255A5B3AB7C [0000] [BLE] --- Type 0000:21 (SecureChannel:PBKDFParamResponse) (B:154)
00> D: 22696 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 159)
00> I: 22697 [SVR]Commissioning session establishment step started
00> D: 22781 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
00> D: 22784 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
00> I: 22784 [EM]>>> [E:4909r S:0 M:75511558] (U) Msg RX from 0:1EE08255A5B3AB7C [0000] to 0000000000000000 --- Type 0000:22 (SecureChannel:PASE_Pake1) (B:92)
00> I: 22792 [EM]<<< [E:4909r S:0 M:239902454] (U) Msg TX from 0000000000000000 to 0:1EE08255A5B3AB7C [0000] [BLE] --- Type 0000:23 (SecureChannel:PASE_Pake2) (B:127)
00> D: 22792 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 132)
00> D: 22901 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
00> D: 22903 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
00> I: 22904 [EM]>>> [E:4909r S:0 M:75511559] (U) Msg RX from 0:1EE08255A5B3AB7C [0000] to 0000000000000000 --- Type 0000:24 (SecureChannel:PASE_Pake3) (B:59)
00> I: 22904 [EM]<<< [E:4909r S:0 M:239902455] (U) Msg TX from 0000000000000000 to 0:1EE08255A5B3AB7C [0000] [BLE] --- Type 0000:40 (SecureChannel:StatusReport) (B:30)
00> D: 22905 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 35)
00> I: 22906 [SC]SecureSession[0x20004af8, LSID:41248]: State change 'kEstablishing' --> 'kActive'
00> D: 22907 [IN]SecureSession[0x20004af8]: Activated - Type:1 LSID:41248
00> D: 22907 [IN]New secure session activated for device <FFFFFFFB00000000, 0>, LSID:41248 PSID:52579!
00> I: 22907 [SVR]Commissioning completed session establishment step
00> I: 22907 [DIS]Updating services using commissioning mode 0
00> E: 22907 [DIS]Failed to remove advertised services: 3
00> E: 22907 [DIS]Failed to finalize service update: 3
00> D: 22908 [DL]CHIPoBLE advertising set to off
00> I: 22908 [SVR]Device completed Rendezvous process
00> D: 23021 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
00> D: 23023 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
00> I: 23024 [EM]>>> [E:4910r S:41248 M:163080938] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:02 (IM:ReadRequest) (B:51)
00> D: 23024 [IM]Received Read request
00> I: 23026 [EM]<<< [E:4910r S:41248 M:55573852] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:05 (IM:ReportData) (B:68)
00> D: 23026 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 73)
00> D: 23141 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
00> D: 23143 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
00> I: 23144 [EM]>>> [E:4911r S:41248 M:163080939] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:02 (IM:ReadRequest) (B:51)
00> D: 23144 [IM]Received Read request
00> I: 23146 [EM]<<< [E:4911r S:41248 M:55573853] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:05 (IM:ReportData) (B:90)
00> D: 23146 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 95)
00> D: 23261 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
00> D: 23263 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
00> I: 23264 [EM]>>> [E:4912r S:41248 M:163080940] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:02 (IM:ReadRequest) (B:52)
00> D: 23264 [IM]Received Read request
00> I: 23266 [EM]<<< [E:4912r S:41248 M:55573854] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:05 (IM:ReportData) (B:67)
00> D: 23266 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 72)
00> D: 23441 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
00> D: 23443 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
00> I: 23444 [EM]>>> [E:4913r S:41248 M:163080941] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:02 (IM:ReadRequest) (B:51)
00> D: 23444 [IM]Received Read request
00> I: 23446 [EM]<<< [E:4913r S:41248 M:55573855] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:05 (IM:ReportData) (B:66)
00> D: 23446 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71)
00> D: 23561 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
00> D: 23563 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
00> I: 23564 [EM]>>> [E:4914r S:41248 M:163080942] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:59)
00> D: 23566 [DL]OpenThread State Changed (Flags: 0x01009009)
00> D: 23566 [DL]   Network Name: OpenThread
00> D: 23566 [DL]   PAN Id: 0x30E0
00> D: 23566 [DL]   Extended PAN Id: 0xDEAD00BEEF00CAFE
00> D: 23567 [DL]   Channel: 11
00> D: 23567 [DL]   Mesh Prefix: fdde:ad00:beef::/64
00> D: 23567 [DL]   Thread Unicast Addresses:
00> D: 23567 [DL]        fe80::426:bcd3:4e31:b8af/64 valid preferred
00> I: 24922 [DL]Thread Network: ha-thread-5a53 Panid 0x5a53 Channel 15 RSSI -68 LQI 108 Version 4
00> I: 24959 [DL]Thread Network: ha-thread-5a53 Panid 0x5a53 Channel 15 RSSI -38 LQI 236 Version 4
00> D: 26063 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 3)
00> D: 26142 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
00> I: 27871 [DL]Thread Network: MyHome36 Panid 0xbc1c Channel 25 RSSI -82 LQI 60 Version 4
00> D: 28420 [DL]OpenThread State Changed (Flags: 0x00008000)
00> D: 28420 [DL]   Network Name: OpenThread
00> D: 28420 [DL]   PAN Id: 0xFFFF
00> D: 28420 [DL]   Extended PAN Id: 0xDEAD00BEEF00CAFE
00> D: 28420 [DL]   Channel: 11
00> D: 28420 [DL]   Mesh Prefix: fdde:ad00:beef::/64
00> I: 28422 [EM]<<< [E:4914r S:41248 M:55573856] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:09 (IM:InvokeCommandResponse) (B:172)
00> D: 28423 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 176)
00> D: 28423 [DL]OpenThread State Changed (Flags: 0x01002002)
00> D: 28423 [DL]   Thread Unicast Addresses:
00> D: 28542 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
00> D: 28602 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
00> D: 28785 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
00> I: 28785 [EM]>>> [E:4915r S:41248 M:163080943] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:02 (IM:ReadRequest) (B:134)
00> D: 28786 [IM]Received Read request
00> I: 28790 [EM]<<< [E:4915r S:41248 M:55573857] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:05 (IM:ReportData) (B:257)
00> D: 28791 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 182)
00> D: 28902 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
00> D: 28902 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 82)
00> D: 29022 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
00> D: 29025 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
00> I: 29026 [EM]>>> [E:4916r S:41248 M:163080944] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:02 (IM:ReadRequest) (B:103)
00> D: 29026 [IM]Received Read request
00> E: 29028 [DMG]Fail to retrieve data, roll back and encode status on clusterId: 0x0000_0046, attributeId: 0x0000_0002err = 5c3
00> E: 29028 [DMG]Fail to retrieve data, roll back and encode status on clusterId: 0x0000_0046, attributeId: 0x0000_0001err = 5c3
00> E: 29028 [DMG]Fail to retrieve data, roll back and encode status on clusterId: 0x0000_0046, attributeId: 0x0000_0000err = 5c3
00> E: 29028 [DMG]Fail to retrieve data, roll back and encode status on clusterId: 0x0000_0046, attributeId: 0x0000_0007err = 5c3
00> E: 29029 [DMG]Fail to retrieve data, roll back and encode status on clusterId: 0x0000_0046, attributeId: 0x0000_0006err = 5c3
00> I: 29030 [EM]<<< [E:4916r S:41248 M:55573858] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:05 (IM:ReportData) (B:181)
00> D: 29030 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 182)
00> D: 29262 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
00> D: 29262 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 6)
00> D: 29382 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
00> D: 29384 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
00> I: 29385 [EM]>>> [E:4917r S:41248 M:163080945] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:65)
00> I: 29385 [FS]GeneralCommissioning: Received ArmFailSafe (60s)
00> I: 29386 [EM]<<< [E:4917r S:41248 M:55573859] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:09 (IM:InvokeCommandResponse) (B:66)
00> D: 29387 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71)
00> D: 29502 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
00> D: 29504 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
00> I: 29505 [EM]>>> [E:4918r S:41248 M:163080946] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:70)
00> I: 29509 [EM]<<< [E:4918r S:41248 M:55573860] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:09 (IM:InvokeCommandResponse) (B:66)
00> D: 29509 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71)
00> D: 29622 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
00> D: 29625 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
00> I: 29625 [EM]>>> [E:4919r S:41248 M:163080947] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:62)
00> I: 29626 [ZCL]OpCreds: Certificate Chain request received for PAI
00> I: 29627 [EM]<<< [E:4919r S:41248 M:55573861] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:09 (IM:InvokeCommandResponse) (B:527)
00> D: 29627 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 182)
00> D: 29742 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
00> D: 29742 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 182)
00> D: 29862 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
00> D: 29862 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 172)
00> D: 29982 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
00> D: 29984 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
00> I: 29985 [EM]>>> [E:4920r S:41248 M:163080948] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:62)
00> I: 29985 [ZCL]OpCreds: Certificate Chain request received for DAC
00> I: 29987 [EM]<<< [E:4920r S:41248 M:55573862] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:09 (IM:InvokeCommandResponse) (B:555)
00> D: 29987 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 182)
00> D: 30102 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
00> D: 30102 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 182)
00> D: 30222 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
00> D: 30222 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 182)
00> D: 30342 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
00> D: 30342 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 20)
00> D: 30462 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
00> D: 30463 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
00> D: 30584 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
00> I: 30585 [EM]>>> [E:4921r S:41248 M:163080949] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:94)
00> I: 30586 [ZCL]OpCreds: Received an AttestationRequest command
00> I: 30587 [ZCL]OpCreds: AttestationRequest successful.
00> I: 30588 [EM]<<< [E:4921r S:41248 M:55573863] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:09 (IM:InvokeCommandResponse) (B:716)
00> D: 30588 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 182)
00> D: 30702 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
00> D: 30702 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 182)
00> D: 30822 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
00> D: 30822 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 182)
00> D: 30942 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
00> D: 30942 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 181)
00> D: 31062 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
00> D: 31063 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
00> D: 31184 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
00> I: 31184 [EM]>>> [E:4922r S:41248 M:163080950] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:65)
00> I: 31185 [FS]GeneralCommissioning: Received ArmFailSafe (60s)
00> I: 31186 [EM]<<< [E:4922r S:41248 M:55573864] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:09 (IM:InvokeCommandResponse) (B:66)
00> D: 31186 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71)
00> D: 31302 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
00> D: 32324 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
00> I: 32325 [EM]>>> [E:4923r S:41248 M:163080951] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:94)
00> I: 32326 [ZCL]OpCreds: Received a CSRRequest command
00> I: 32334 [ZCL]OpCreds: AllocatePendingOperationalKey succeeded
00> I: 32335 [ZCL]OpCreds: CSRRequest successful.
00> I: 32336 [EM]<<< [E:4923r S:41248 M:55573865] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:09 (IM:InvokeCommandResponse) (B:392)
00> D: 32336 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 182)
00> D: 32442 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
00> D: 32442 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 182)
00> D: 32562 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
00> D: 32562 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 37)
00> D: 32682 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
00> D: 32687 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
00> D: 32806 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
00> I: 32807 [EM]>>> [E:4924r S:41248 M:163080952] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:316)
00> I: 32808 [ZCL]OpCreds: Received an AddTrustedRootCertificate command
00> I: 32810 [ZCL]OpCreds: AddTrustedRootCertificate successful.
00> I: 32810 [EM]<<< [E:4924r S:41248 M:55573866] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:09 (IM:InvokeCommandResponse) (B:63)
00> D: 32811 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 68)
00> D: 32922 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
00> D: 32982 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
00> D: 33106 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
00> I: 33107 [EM]>>> [E:4925r S:41248 M:163080953] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:352)
00> I: 33108 [ZCL]OpCreds: Received an AddNOC command
00> I: 33109 [FP]Validating NOC chain
00> I: 33112 [FP]NOC chain validation successful
00> I: 33112 [FP]Added new fabric at index: 0x1
00> I: 33112 [FP]Assigned compressed fabric ID: 0xEBF1D717072701DF, node ID: 0x00000000F20D7C08
00> I: 33112 [TS]Last Known Good Time: 2023-10-14T01:16:48
00> I: 33113 [TS]New proposed Last Known Good Time: 2025-08-21T01:05:00
00> I: 33113 [TS]Updating pending Last Known Good Time to 2025-08-21T01:05:00
00> I: 33123 [ZCL]OpCreds: ACL entry created for Fabric index 0x1 CASE Admin Subject 0x0000000042461682
00> D: 33123 [DL]Using Thread extended MAC for hostname.
00> I: 33124 [DIS]Advertise operational node EBF1D717072701DF-00000000F20D7C08
00> E: 33124 [SVR]Operational advertising failed: 3
00> I: 33124 [ZCL]OpCreds: successfully created fabric index 0x1 via AddNOC
00> I: 33125 [EM]<<< [E:4925r S:41248 M:55573867] (S) Msg TX from 0000000000000000 to 1:FFFFFFFB00000000 [01DF] [BLE] --- Type 0001:09 (IM:InvokeCommandResponse) (B:66)
00> D: 33125 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71)
00> D: 33282 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
00> D: 33287 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
00> I: 33288 [EM]>>> [E:4926r S:41248 M:163080954] (S) Msg RX from 1:FFFFFFFB00000000 [01DF] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:175)
00> I: 33291 [EM]<<< [E:4926r S:41248 M:55573868] (S) Msg TX from 0000000000000000 to 1:FFFFFFFB00000000 [01DF] [BLE] --- Type 0001:09 (IM:InvokeCommandResponse) (B:66)
00> D: 33291 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71)
00> D: 33402 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
00> D: 33404 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
00> I: 33405 [EM]>>> [E:4927r S:41248 M:163080955] (S) Msg RX from 1:FFFFFFFB00000000 [01DF] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:65)
00> I: 33406 [FS]GeneralCommissioning: Received ArmFailSafe (108s)
00> I: 33407 [EM]<<< [E:4927r S:41248 M:55573869] (S) Msg TX from 0000000000000000 to 1:FFFFFFFB00000000 [01DF] [BLE] --- Type 0001:09 (IM:InvokeCommandResponse) (B:66)
00> D: 33407 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71)
00> D: 33522 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
00> D: 33525 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
00> I: 33526 [EM]>>> [E:4928r S:41248 M:163080956] (S) Msg RX from 1:FFFFFFFB00000000 [01DF] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:73)
00> D: 33556 [DL]OpenThread State Changed (Flags: 0x1017c110)
00> D: 33556 [DL]   Network Name: ha-thread-5a53
00> D: 33556 [DL]   PAN Id: 0x5A53
00> D: 33557 [DL]   Extended PAN Id: 0x8383B9C50F008897
00> D: 33557 [DL]   Channel: 15
00> D: 33557 [DL]   Mesh Prefix: fd66:bf80:8221:1f54::/64
00> D: 33561 [DL]OpenThread State Changed (Flags: 0x1100100d)
00> D: 33561 [DL]   Device Role: DETACHED
00> D: 33561 [DL]   Thread Unicast Addresses:
00> D: 33561 [DL]        fd66:bf80:8221:1f54:f123:c267:7a44:6335/64 valid preferred
00> D: 33561 [DL]        fe80::426:bcd3:4e31:b8af/64 valid preferred
00> I: 35035 [DL]SRP Client was started, detected server: fd66:bf80:8221:1f54:5a91:ed03:c4ba:51ed
00> D: 35035 [DL]OpenThread State Changed (Flags: 0x200002a4)
00> D: 35036 [DL]   Device Role: CHILD
00> D: 35036 [DL]   Partition Id: 0x17A5AE38
00> D: 35039 [DL]OpenThread State Changed (Flags: 0x00000001)
00> D: 35039 [DL]   Thread Unicast Addresses:
00> D: 35040 [DL]        fd0c:5b01:2856:1:4945:3c05:38ba:a58d/64 valid preferred
00> D: 35040 [DL]        fd66:bf80:8221:1f54:0:ff:fe00:2c06/64 valid preferred rloc
00> D: 35040 [DL]        fd66:bf80:8221:1f54:f123:c267:7a44:6335/64 valid preferred
00> D: 35040 [DL]        fe80::426:bcd3:4e31:b8af/64 valid preferred
00> I: 35045 [EM]<<< [E:4928r S:41248 M:55573870] (S) Msg TX from 0000000000000000 to 1:FFFFFFFB00000000 [01DF] [BLE] --- Type 0001:09 (IM:InvokeCommandResponse) (B:65)
00> D: 35045 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 70)
00> D: 35046 [DL]Using Thread extended MAC for hostname.
00> I: 35046 [DIS]Advertise operational node EBF1D717072701DF-00000000F20D7C08
00> E: 35046 [SVR]Operational advertising failed: 3
00> D: 35143 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
00> D: 35713 [DL]SRP update succeeded
00> I: 35713 [SVR]Server initialization complete
00> I: 35713 [DIS]Updating services using commissioning mode 0
00> D: 35714 [DL]Using Thread extended MAC for hostname.
00> I: 35714 [DIS]Advertise operational node EBF1D717072701DF-00000000F20D7C08
00> I: 35714 [DL]advertising srp service: EBF1D717072701DF-00000000F20D7C08._matter._tcp
00> I: 35715 [SWU]Stopping the watchdog timer
00> I: 35715 [SWU]Starting the periodic query timer, timeout: 86400 seconds
00> D: 36859 [DL]SRP update succeeded
00> D: 37603 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
00> I: 37690 [EM]>>> [E:4929r S:0 M:75511560] (U) Msg RX from 0:B166436083384417 [0000] to 0000000000000000 --- Type 0000:30 (SecureChannel:CASE_Sigma1) (B:196)
00> I: 37691 [IN]CASE Server received Sigma1 message . Starting handshake. EC 0x200068a0
00> I: 37691 [EM]<<< [E:4929r S:0 M:239902456 (Ack:75511560)] (U) Msg TX from 0000000000000000 to 0:B166436083384417 [0000] [UDP:[2600:6c5a:597f:6231:8582:8705:14a1:4d5a]:59693] --- Type 0000:10 (SecureChannel:StandaloneAck) (B:26)
00> I: 37692 [SC]Received Sigma1 msg
00> I: 37696 [SC]CASE matched destination ID: fabricIndex 1, NodeID 0x00000000F20D7C08
00> I: 37701 [EM]<<< [E:4929r S:0 M:239902457 (Ack:75511560)] (U) Msg TX from 0000000000000000 to 0:B166436083384417 [0000] [UDP:[2600:6c5a:597f:6231:8582:8705:14a1:4d5a]:59693] --- Type 0000:31 (SecureChannel:CASE_Sigma2) (B:534)
00> I: 37703 [EM]??1 [E:4929r S:0 M:239902457] (U) Msg Retransmission to 0:0000000000000000 in 2041ms [State:Active II:500 AI:300 AT:4000]
00> I: 37703 [SC]Sent Sigma2 msg
00> I: 38350 [EM]>>> [E:4929r S:0 M:75511561 (Ack:239902457)] (U) Msg RX from 0:B166436083384417 [0000] to 0000000000000000 --- Type 0000:32 (SecureChannel:CASE_Sigma3) (B:378)
00> I: 38351 [EM]<<< [E:4929r S:0 M:239902458 (Ack:75511561)] (U) Msg TX from 0000000000000000 to 0:B166436083384417 [0000] [UDP:[2600:6c5a:597f:6231:8582:8705:14a1:4d5a]:59693] --- Type 0000:10 (SecureChannel:StandaloneAck) (B:26)
00> I: 38352 [SC]Received Sigma3 msg
00> E: 38353 [SC]The device does not support GetClock_RealTimeMS() API: 3.  Falling back to Last Known Good UTC Time
00> I: 38365 [EM]<<< [E:4929r S:0 M:239902459 (Ack:75511561)] (U) Msg TX from 0000000000000000 to 0:B166436083384417 [0000] [UDP:[2600:6c5a:597f:6231:8582:8705:14a1:4d5a]:59693] --- Type 0000:40 (SecureChannel:StatusReport) (B:34)
00> I: 38366 [EM]??1 [E:4929r S:0 M:239902459] (U) Msg Retransmission to 0:0000000000000000 in 2053ms [State:Active II:500 AI:300 AT:4000]
00> I: 38368 [SC]SecureSession[0x20004bd0, LSID:41249]: State change 'kEstablishing' --> 'kActive'
00> D: 38368 [IN]SecureSession[0x20004bd0]: Activated - Type:2 LSID:41249
00> D: 38368 [IN]New secure session activated for device <0000000042461682, 1>, LSID:41249 PSID:52580!
00> I: 38368 [IN]CASE Session established to peer: <0000000042461682, 1>
00> D: 38369 [IN]SecureSession[0x20004ca8]: Allocated Type:2 LSID:41250
00> I: 38553 [EM]>>> [E:4930r S:41249 M:59726324] (S) Msg RX from 1:0000000042461682 [01DF] to 00000000F20D7C08 --- Type 0001:08 (IM:InvokeCommandRequest) (B:59)
00> I: 38554 [FS]GeneralCommissioning: Received CommissioningComplete
00> I: 38683 [FP]Metadata for Fabric 0x1 persisted to storage.
00> I: 38691 [TS]Committing Last Known Good Time to storage: 2025-08-21T01:05:00
00> I: 38693 [ZCL]OpCreds: Fabric index 0x1 was committed to storage. Compressed Fabric Id 0xEBF1D717072701DF, FabricId 000000004860FB15, NodeId 00000000F20D7C08, VendorId 0x1384
00> I: 38695 [FS]GeneralCommissioning: Successfully committed pending fabric data
00> I: 38695 [FS]Fail-safe cleanly disarmed
00> I: 38696 [EM]<<< [E:4930r S:41249 M:249334180 (Ack:59726324)] (S) Msg TX from 00000000F20D7C08 to 1:0000000042461682 [01DF] [UDP:[2600:6c5a:597f:6231:8582:8705:14a1:4d5a]:59693] --- Type 0001:09 (IM:InvokeCommandResponse) (B:70)
00> I: 38698 [EM]??1 [E:4930r S:41249 M:249334180] (S) Msg Retransmission to 1:0000000042461682 in 2084ms [State:Active II:500 AI:300 AT:4000]
00> I: 38698 [SWU]Device commissioned, schedule a default provider query
00> I: 38698 [SVR]Commissioning completed successfully
00> I: 38698 [DIS]Updating services using commissioning mode 0
00> D: 38699 [DL]Using Thread extended MAC for hostname.
00> I: 38699 [DIS]Advertise operational node EBF1D717072701DF-00000000F20D7C08
00> D: 38699 [DL]CHIPoBLE advertising set to off
00> D: 38699 [IN]Expiring all PASE sessions
00> D: 38699 [IN]SecureSession[0x20004af8]: MarkForEviction Type:1 LSID:41248
00> I: 38700 [SC]SecureSession[0x20004af8, LSID:41248]: State change 'kActive' --> 'kPendingEviction'
00> D: 38700 [IN]SecureSession[0x20004af8]: Released - Type:1 LSID:41248
00> D: 38700 [IN]Clearing BLE pending packets.
00> I: 38700 [BLE]Releasing end point's BLE connection back to application.
00> I: 38700 [DL]Closing BLE GATT connection (ConnId 00)
00> I: 38707 [EM]>>> [E:4929r S:0 M:75511562 (Ack:239902459)] (U) Msg RX from 0:B166436083384417 [0000] to 0000000000000000 --- Type 0000:10 (SecureChannel:StandaloneAck) (B:26)
00> I: 38803 [DL]Current number of connections: 0/1
00> I: 38803 [DL]BLE GAP connection terminated (reason 0x16)
00> I: 38874 [EM]>>> [E:4930r S:41249 M:59726325 (Ack:249334180)] (S) Msg RX from 1:0000000042461682 [01DF] to 00000000F20D7C08 --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 39002 [EM]>>> [E:4931r S:41249 M:59726326] (S) Msg RX from 1:0000000042461682 [01DF] to 00000000F20D7C08 --- Type 0001:02 (IM:ReadRequest) (B:51)
00> D: 39002 [IM]Received Read request
00> I: 39004 [EM]<<< [E:4931r S:41249 M:249334181 (Ack:59726326)] (S) Msg TX from 00000000F20D7C08 to 1:0000000042461682 [01DF] [UDP:[2600:6c5a:597f:6231:8582:8705:14a1:4d5a]:59693] --- Type 0001:05 (IM:ReportData) (B:72)
00> I: 39005 [EM]??1 [E:4931r S:41249 M:249334181] (S) Msg Retransmission to 1:0000000042461682 in 2034ms [State:Active II:500 AI:300 AT:4000]
00> I: 39014 [EM]>>> [E:4932r S:41249 M:59726327] (S) Msg RX from 1:0000000042461682 [01DF] to 00000000F20D7C08 --- Type 0001:02 (IM:ReadRequest) (B:51)
00> D: 39015 [IM]Received Read request
00> I: 39016 [EM]<<< [E:4932r S:41249 M:249334182 (Ack:59726327)] (S) Msg TX from 00000000F20D7C08 to 1:0000000042461682 [01DF] [UDP:[2600:6c5a:597f:6231:8582:8705:14a1:4d5a]:59693] --- Type 0001:05 (IM:ReportData) (B:90)
00> I: 39017 [EM]??1 [E:4932r S:41249 M:249334182] (S) Msg Retransmission to 1:0000000042461682 in 2109ms [State:Active II:500 AI:300 AT:4000]
00> I: 39113 [EM]>>> [E:4933r S:41249 M:59726328] (S) Msg RX from 1:0000000042461682 [01DF] to 00000000F20D7C08 --- Type 0001:02 (IM:ReadRequest) (B:51)
00> D: 39113 [IM]Received Read request
00> I: 39115 [EM]<<< [E:4933r S:41249 M:249334183 (Ack:59726328)] (S) Msg TX from 00000000F20D7C08 to 1:0000000042461682 [01DF] [UDP:[2600:6c5a:597f:6231:8582:8705:14a1:4d5a]:59693] --- Type 0001:05 (IM:ReportData) (B:162)
00> I: 39116 [EM]??1 [E:4933r S:41249 M:249334183] (S) Msg Retransmission to 1:0000000042461682 in 2088ms [State:Active II:500 AI:300 AT:4000]
00> I: 39326 [EM]>>> [E:4931r S:41249 M:59726329 (Ack:249334181)] (S) Msg RX from 1:0000000042461682 [01DF] to 00000000F20D7C08 --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 39349 [EM]>>> [E:4934r S:41249 M:59726330] (S) Msg RX from 1:0000000042461682 [01DF] to 00000000F20D7C08 --- Type 0001:02 (IM:ReadRequest) (B:51)
00> D: 39350 [IM]Received Read request
00> I: 39351 [EM]<<< [E:4934r S:41249 M:249334184 (Ack:59726330)] (S) Msg TX from 00000000F20D7C08 to 1:0000000042461682 [01DF] [UDP:[2600:6c5a:597f:6231:8582:8705:14a1:4d5a]:59693] --- Type 0001:05 (IM:ReportData) (B:86)
00> I: 39352 [EM]??1 [E:4934r S:41249 M:249334184] (S) Msg Retransmission to 1:0000000042461682 in 2102ms [State:Active II:500 AI:300 AT:4000]
00> I: 39538 [EM]>>> [E:4933r S:41249 M:59726331 (Ack:249334183)] (S) Msg RX from 1:0000000042461682 [01DF] to 00000000F20D7C08 --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 39851 [EM]>>> [E:4934r S:41249 M:59726332 (Ack:249334184)] (S) Msg RX from 1:0000000042461682 [01DF] to 00000000F20D7C08 --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 39862 [EM]>>> [E:4935r S:41249 M:59726333] (S) Msg RX from 1:0000000042461682 [01DF] to 00000000F20D7C08 --- Type 0001:02 (IM:ReadRequest) (B:51)
00> D: 39862 [IM]Received Read request
00> I: 39864 [EM]<<< [E:4935r S:41249 M:249334185 (Ack:59726333)] (S) Msg TX from 00000000F20D7C08 to 1:0000000042461682 [01DF] [UDP:[2600:6c5a:597f:6231:8582:8705:14a1:4d5a]:59693] --- Type 0001:05 (IM:ReportData) (B:79)
00> I: 39865 [EM]??1 [E:4935r S:41249 M:249334185] (S) Msg Retransmission to 1:0000000042461682 in 2073ms [State:Active II:500 AI:300 AT:4000]
00> I: 40061 [EM]>>> [E:4935r S:41249 M:59726334 (Ack:249334185)] (S) Msg RX from 1:0000000042461682 [01DF] to 00000000F20D7C08 --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 41126 [EM]<<1 [E:4932r S:41249 M:249334182] (S) Msg Retransmission to 1:0000000042461682
00> I: 41126 [EM]??2 [E:4932r S:41249 M:249334182] (S) Msg Retransmission to 1:0000000042461682 in 2102ms [State:Active II:500 AI:300 AT:4000]
00> I: 41565 [EM]>>> [E:4932r S:41249 M:59726335 (Ack:249334182)] (S) Msg RX from 1:0000000042461682 [01DF] to 00000000F20D7C08 --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 42565 [EM]>>> [E:4936r S:41249 M:59726336] (S) Msg RX from 1:0000000042461682 [01DF] to 00000000F20D7C08 --- Type 0001:0A (IM:TimedRequest) (B:39)
00> I: 42567 [EM]<<< [E:4936r S:41249 M:249334186 (Ack:59726336)] (S) Msg TX from 00000000F20D7C08 to 1:0000000042461682 [01DF] [UDP:[2600:6c5a:597f:6231:8582:8705:14a1:4d5a]:59693] --- Type 0001:01 (IM:StatusResponse) (B:42)
00> I: 42568 [EM]??1 [E:4936r S:41249 M:249334186] (S) Msg Retransmission to 1:0000000042461682 in 2087ms [State:Active II:500 AI:300 AT:4000]
00> I: 42767 [EM]>>> [E:4936r S:41249 M:59726337 (Ack:249334186)] (S) Msg RX from 1:0000000042461682 [01DF] to 00000000F20D7C08 --- Type 0001:08 (IM:InvokeCommandRequest) (B:63)
00> I: 42768 [ZCL]Received command to close commissioning window
00> E: 42768 [ZCL]Commissioning window is currently not open
00> E: 42768 [DMG]Endpoint=0 Cluster=0x0000_003C Command=0x0000_0002 status 0x01 ClusterSpecificCode=4 (no additional context)
00> I: 42769 [EM]<<< [E:4936r S:41249 M:249334187 (Ack:59726337)] (S) Msg TX from 00000000F20D7C08 to 1:0000000042461682 [01DF] [UDP:[2600:6c5a:597f:6231:8582:8705:14a1:4d5a]:59693] --- Type 0001:09 (IM:InvokeCommandResponse) (B:70)
00> I: 42770 [EM]??1 [E:4936r S:41249 M:249334187] (S) Msg Retransmission to 1:0000000042461682 in 2039ms [State:Active II:500 AI:300 AT:4000]
00> I: 42965 [EM]>>> [E:4936r S:41249 M:59726338 (Ack:249334187)] (S) Msg RX from 1:0000000042461682 [01DF] to 00000000F20D7C08 --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 42976 [EM]>>> [E:4937r S:41249 M:59726339] (S) Msg RX from 1:0000000042461682 [01DF] to 00000000F20D7C08 --- Type 0001:0A (IM:TimedRequest) (B:39)
00> I: 42977 [EM]<<< [E:4937r S:41249 M:249334188 (Ack:59726339)] (S) Msg TX from 00000000F20D7C08 to 1:0000000042461682 [01DF] [UDP:[2600:6c5a:597f:6231:8582:8705:14a1:4d5a]:59693] --- Type 0001:01 (IM:StatusResponse) (B:42)
00> I: 42979 [EM]??1 [E:4937r S:41249 M:249334188] (S) Msg Retransmission to 1:0000000042461682 in 2030ms [State:Active II:500 AI:300 AT:4000]
00> I: 43303 [EM]>>> [E:4937r S:41249 M:59726340 (Ack:249334188)] (S) Msg RX from 1:0000000042461682 [01DF] to 00000000F20D7C08 --- Type 0001:08 (IM:InvokeCommandRequest) (B:210)
00> I: 43304 [ZCL]Received command to open commissioning window
00> D: 43304 [IN]SecureSession[0x20004af8]: Allocated Type:1 LSID:41251
00> I: 43305 [DIS]Updating services using commissioning mode 2
00> D: 43305 [DL]Using Thread extended MAC for hostname.
00> I: 43305 [DIS]Advertise operational node EBF1D717072701DF-00000000F20D7C08
00> D: 43305 [DL]Using Thread extended MAC for hostname.
00> I: 43305 [DIS]Advertise commission parameter vendorID=65521 productID=32781 discriminator=1503/05 cm=2 cp=0
00> I: 43306 [DL]advertising srp service: C52E2F486AD11F01._matterc._udp
00> I: 43306 [ZCL]Commissioning window is now open
00> I: 43307 [EM]<<< [E:4937r S:41249 M:249334189 (Ack:59726340)] (S) Msg TX from 00000000F20D7C08 to 1:0000000042461682 [01DF] [UDP:[2600:6c5a:597f:6231:8582:8705:14a1:4d5a]:59693] --- Type 0001:09 (IM:InvokeCommandResponse) (B:67)
00> I: 43308 [EM]??1 [E:4937r S:41249 M:249334189] (S) Msg Retransmission to 1:0000000042461682 in 2072ms [State:Active II:500 AI:300 AT:4000]
00> I: 43500 [EM]>>> [E:4937r S:41249 M:59726341 (Ack:249334189)] (S) Msg RX from 1:0000000042461682 [01DF] to 00000000F20D7C08 --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> D: 45053 [DL]SRP update succeeded
00> I: 45471 [EM]>>> [E:6544r S:0 M:139133385] (U) Msg RX from 0:7F3FADEFDE4DB8F2 [0000] to 0000000000000000 --- Type 0000:20 (SecureChannel:PBKDFParamRequest) (B:98)
00> I: 45471 [EM]<<< [E:6544r S:0 M:239902460 (Ack:139133385)] (U) Msg TX from 0000000000000000 to 0:7F3FADEFDE4DB8F2 [0000] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0000:10 (SecureChannel:StandaloneAck) (B:26)
00> I: 45473 [EM]<<< [E:6544r S:0 M:239902461 (Ack:139133385)] (U) Msg TX from 0000000000000000 to 0:7F3FADEFDE4DB8F2 [0000] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0000:21 (SecureChannel:PBKDFParamResponse) (B:174)
00> I: 45474 [EM]??1 [E:6544r S:0 M:239902461] (U) Msg Retransmission to 0:0000000000000000 in 2031ms [State:Active II:500 AI:300 AT:4000]
00> I: 45475 [SVR]Commissioning session establishment step started
00> I: 45879 [EM]>>> [E:6544r S:0 M:139133386 (Ack:239902461)] (U) Msg RX from 0:7F3FADEFDE4DB8F2 [0000] to 0000000000000000 --- Type 0000:22 (SecureChannel:PASE_Pake1) (B:96)
00> I: 45879 [EM]<<< [E:6544r S:0 M:239902462 (Ack:139133386)] (U) Msg TX from 0000000000000000 to 0:7F3FADEFDE4DB8F2 [0000] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0000:10 (SecureChannel:StandaloneAck) (B:26)
00> I: 45887 [EM]<<< [E:6544r S:0 M:239902463 (Ack:139133386)] (U) Msg TX from 0000000000000000 to 0:7F3FADEFDE4DB8F2 [0000] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0000:23 (SecureChannel:PASE_Pake2) (B:131)
00> I: 45889 [EM]??1 [E:6544r S:0 M:239902463] (U) Msg Retransmission to 0:0000000000000000 in 2042ms [State:Active II:500 AI:300 AT:4000]
00> I: 46303 [EM]>>> [E:6544r S:0 M:139133387 (Ack:239902463)] (U) Msg RX from 0:7F3FADEFDE4DB8F2 [0000] to 0000000000000000 --- Type 0000:24 (SecureChannel:PASE_Pake3) (B:63)
00> I: 46304 [EM]<<< [E:6544r S:0 M:239902464 (Ack:139133387)] (U) Msg TX from 0000000000000000 to 0:7F3FADEFDE4DB8F2 [0000] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0000:10 (SecureChannel:StandaloneAck) (B:26)
00> I: 46306 [EM]<<< [E:6544r S:0 M:239902465 (Ack:139133387)] (U) Msg TX from 0000000000000000 to 0:7F3FADEFDE4DB8F2 [0000] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0000:40 (SecureChannel:StatusReport) (B:34)
00> I: 46307 [EM]??1 [E:6544r S:0 M:239902465] (U) Msg Retransmission to 0:0000000000000000 in 2087ms [State:Active II:500 AI:300 AT:4000]
00> I: 46308 [SC]SecureSession[0x20004af8, LSID:41251]: State change 'kEstablishing' --> 'kActive'
00> D: 46308 [IN]SecureSession[0x20004af8]: Activated - Type:1 LSID:41251
00> D: 46309 [IN]New secure session activated for device <FFFFFFFB00000000, 0>, LSID:41251 PSID:2986!
00> I: 46310 [SVR]Commissioning completed session establishment step
00> I: 46310 [DIS]Updating services using commissioning mode 0
00> D: 46310 [DL]Using Thread extended MAC for hostname.
00> I: 46310 [DIS]Advertise operational node EBF1D717072701DF-00000000F20D7C08
00> I: 46311 [DL]removing srp service: C52E2F486AD11F01._matterc._udp
00> I: 46311 [SVR]Device completed Rendezvous process
00> I: 46668 [EM]>>> [E:6545r S:41251 M:17238854] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:02 (IM:ReadRequest) (B:134)
00> D: 46668 [IM]Received Read request
00> I: 46676 [EM]<<< [E:6545r S:41251 M:124062886 (Ack:17238854)] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:05 (IM:ReportData) (B:261)
00> I: 46677 [EM]??1 [E:6545r S:41251 M:124062886] (S) Msg Retransmission to 0:FFFFFFFB00000000 in 2093ms [State:Active II:500 AI:300 AT:4000]
00> I: 46849 [EM]>>> [E:6544r S:0 M:139133388 (Ack:239902465)] (U) Msg RX from 0:7F3FADEFDE4DB8F2 [0000] to 0000000000000000 --- Type 0000:10 (SecureChannel:StandaloneAck) (B:26)
00> D: 46986 [DL]SRP update succeeded
00> I: 47187 [EM]>>> [E:6546r S:41251 M:17238855] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:02 (IM:ReadRequest) (B:103)
00> D: 47188 [IM]Received Read request
00> E: 47189 [DMG]Fail to retrieve data, roll back and encode status on clusterId: 0x0000_0046, attributeId: 0x0000_0002err = 5c3
00> E: 47189 [DMG]Fail to retrieve data, roll back and encode status on clusterId: 0x0000_0046, attributeId: 0x0000_0001err = 5c3
00> E: 47190 [DMG]Fail to retrieve data, roll back and encode status on clusterId: 0x0000_0046, attributeId: 0x0000_0000err = 5c3
00> E: 47190 [DMG]Fail to retrieve data, roll back and encode status on clusterId: 0x0000_0046, attributeId: 0x0000_0007err = 5c3
00> E: 47191 [DMG]Fail to retrieve data, roll back and encode status on clusterId: 0x0000_0046, attributeId: 0x0000_0006err = 5c3
00> I: 47192 [EM]<<< [E:6546r S:41251 M:124062887 (Ack:17238855)] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:05 (IM:ReportData) (B:185)
00> I: 47193 [EM]??1 [E:6546r S:41251 M:124062887] (S) Msg Retransmission to 0:FFFFFFFB00000000 in 2055ms [State:Active II:500 AI:300 AT:4000]
00> I: 47199 [EM]>>> [E:6545r S:41251 M:17238856 (Ack:124062886)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 47400 [EM]>>> [E:6547r S:41251 M:17238857] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:65)
00> I: 47400 [FS]GeneralCommissioning: Received ArmFailSafe (60s)
00> I: 47402 [EM]<<< [E:6547r S:41251 M:124062888 (Ack:17238857)] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:09 (IM:InvokeCommandResponse) (B:70)
00> I: 47403 [EM]??1 [E:6547r S:41251 M:124062888] (S) Msg Retransmission to 0:FFFFFFFB00000000 in 2069ms [State:Active II:500 AI:300 AT:4000]
00> I: 47411 [EM]>>> [E:6546r S:41251 M:17238858 (Ack:124062887)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 47611 [EM]>>> [E:6548r S:41251 M:17238859] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:70)
00> I: 47622 [EM]<<< [E:6548r S:41251 M:124062889 (Ack:17238859)] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:09 (IM:InvokeCommandResponse) (B:70)
00> I: 47624 [EM]??1 [E:6548r S:41251 M:124062889] (S) Msg Retransmission to 0:FFFFFFFB00000000 in 2080ms [State:Active II:500 AI:300 AT:4000]
00> I: 47625 [EM]>>> [E:6547r S:41251 M:17238860 (Ack:124062888)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 47824 [EM]>>> [E:6549r S:41251 M:17238861] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:62)
00> I: 47825 [ZCL]OpCreds: Certificate Chain request received for PAI
00> I: 47826 [EM]<<< [E:6549r S:41251 M:124062890 (Ack:17238861)] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:09 (IM:InvokeCommandResponse) (B:531)
00> I: 47827 [EM]??1 [E:6549r S:41251 M:124062890] (S) Msg Retransmission to 0:FFFFFFFB00000000 in 2097ms [State:Active II:500 AI:300 AT:4000]
00> I: 47950 [EM]>>> [E:6548r S:41251 M:17238862 (Ack:124062889)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 48151 [EM]>>> [E:6550r S:41251 M:17238863] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:62)
00> I: 48152 [ZCL]OpCreds: Certificate Chain request received for DAC
00> I: 48153 [EM]<<< [E:6550r S:41251 M:124062891 (Ack:17238863)] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:09 (IM:InvokeCommandResponse) (B:559)
00> I: 48154 [EM]??1 [E:6550r S:41251 M:124062891] (S) Msg Retransmission to 0:FFFFFFFB00000000 in 2077ms [State:Active II:500 AI:300 AT:4000]
00> I: 48163 [EM]>>> [E:6549r S:41251 M:17238864 (Ack:124062890)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 48476 [EM]>>> [E:6551r S:41251 M:17238865] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:94)
00> I: 48477 [ZCL]OpCreds: Received an AttestationRequest command
00> I: 48478 [EM]<<< [E:6551r S:41251 M:124062892 (Ack:17238865)] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 48480 [ZCL]OpCreds: AttestationRequest successful.
00> I: 48481 [EM]<<< [E:6551r S:41251 M:124062893 (Ack:17238865)] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:09 (IM:InvokeCommandResponse) (B:720)
00> I: 48483 [EM]??1 [E:6551r S:41251 M:124062893] (S) Msg Retransmission to 0:FFFFFFFB00000000 in 2062ms [State:Active II:500 AI:300 AT:4000]
00> I: 48487 [EM]>>> [E:6550r S:41251 M:17238866 (Ack:124062891)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 49100 [EM]>>> [E:6552r S:41251 M:17238867] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:94)
00> I: 49101 [ZCL]OpCreds: Received a CSRRequest command
00> I: 49102 [EM]<<< [E:6552r S:41251 M:124062894 (Ack:17238867)] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 49124 [ZCL]OpCreds: AllocatePendingOperationalKey succeeded
00> I: 49125 [ZCL]OpCreds: CSRRequest successful.
00> I: 49127 [EM]<<< [E:6552r S:41251 M:124062895 (Ack:17238867)] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:09 (IM:InvokeCommandResponse) (B:396)
00> I: 49129 [EM]??1 [E:6552r S:41251 M:124062895] (S) Msg Retransmission to 0:FFFFFFFB00000000 in 2066ms [State:Active II:500 AI:300 AT:4000]
00> I: 49130 [EM]>>> [E:6551r S:41251 M:17238868 (Ack:124062893)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 49649 [EM]>>> [E:6553r S:41251 M:17238869] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:293)
00> I: 49650 [ZCL]OpCreds: Received an AddTrustedRootCertificate command
00> I: 49651 [EM]<<< [E:6553r S:41251 M:124062896 (Ack:17238869)] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 49654 [ZCL]OpCreds: AddTrustedRootCertificate successful.
00> I: 49655 [EM]<<< [E:6553r S:41251 M:124062897 (Ack:17238869)] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:09 (IM:InvokeCommandResponse) (B:67)
00> I: 49656 [EM]??1 [E:6553r S:41251 M:124062897] (S) Msg Retransmission to 0:FFFFFFFB00000000 in 2090ms [State:Active II:500 AI:300 AT:4000]
00> I: 49782 [EM]>>> [E:6552r S:41251 M:17238870 (Ack:124062895)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 50352 [EM]>>> [E:6554r S:41251 M:17238871] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:566)
00> I: 50353 [ZCL]OpCreds: Received an AddNOC command
00> I: 50354 [EM]<<< [E:6554r S:41251 M:124062898 (Ack:17238871)] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 50355 [FP]Validating NOC chain
00> I: 50362 [FP]NOC chain validation successful
00> I: 50362 [FP]Added new fabric at index: 0x2
00> I: 50362 [FP]Assigned compressed fabric ID: 0xD12708452B2582B3, node ID: 0x000000000000000A
00> I: 50363 [TS]Last Known Good Time: 2025-08-21T01:05:00
00> I: 50363 [TS]New proposed Last Known Good Time: 2021-01-01T00:00:00
00> I: 50363 [TS]Retaining current Last Known Good Time
00> I: 50373 [ZCL]OpCreds: ACL entry created for Fabric index 0x2 CASE Admin Subject 0x000000000001B669
00> D: 50373 [DL]Using Thread extended MAC for hostname.
00> I: 50373 [DIS]Advertise operational node EBF1D717072701DF-00000000F20D7C08
00> D: 50374 [DL]Using Thread extended MAC for hostname.
00> I: 50374 [DIS]Advertise operational node D12708452B2582B3-000000000000000A
00> I: 50374 [DL]advertising srp service: D12708452B2582B3-000000000000000A._matter._tcp
00> I: 50374 [ZCL]OpCreds: successfully created fabric index 0x2 via AddNOC
00> I: 50375 [EM]<<< [E:6554r S:41251 M:124062899 (Ack:17238871)] (S) Msg TX from 0000000000000000 to 2:FFFFFFFB00000000 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:09 (IM:InvokeCommandResponse) (B:70)
00> I: 50377 [EM]??1 [E:6554r S:41251 M:124062899] (S) Msg Retransmission to 2:FFFFFFFB00000000 in 2046ms [State:Active II:500 AI:300 AT:4000]
00> I: 50378 [EM]>>> [E:6553r S:41251 M:17238872 (Ack:124062897)] (S) Msg RX from 2:FFFFFFFB00000000 [82B3] to 0000000000000000 --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 50563 [EM]>>> [E:6554r S:41251 M:17238873 (Ack:124062899)] (S) Msg RX from 2:FFFFFFFB00000000 [82B3] to 0000000000000000 --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> D: 51688 [DL]SRP update succeeded
00> I: 52119 [EM]>>> [E:6555r S:0 M:139133389] (U) Msg RX from 0:E7FD4D0AD4DA39FF [0000] to 0000000000000000 --- Type 0000:30 (SecureChannel:CASE_Sigma1) (B:196)
00> I: 52119 [IN]CASE Server received Sigma1 message . Starting handshake. EC 0x200068a0
00> I: 52120 [EM]<<< [E:6555r S:0 M:239902466 (Ack:139133389)] (U) Msg TX from 0000000000000000 to 0:E7FD4D0AD4DA39FF [0000] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0000:10 (SecureChannel:StandaloneAck) (B:26)
00> I: 52121 [SC]Received Sigma1 msg
00> I: 52128 [SC]CASE matched destination ID: fabricIndex 2, NodeID 0x000000000000000A
00> I: 52133 [EM]<<< [E:6555r S:0 M:239902467 (Ack:139133389)] (U) Msg TX from 0000000000000000 to 0:E7FD4D0AD4DA39FF [0000] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0000:31 (SecureChannel:CASE_Sigma2) (B:751)
00> I: 52135 [EM]??1 [E:6555r S:0 M:239902467] (U) Msg Retransmission to 0:0000000000000000 in 2063ms [State:Active II:500 AI:300 AT:4000]
00> I: 52135 [SC]Sent Sigma2 msg
00> I: 52710 [EM]>>> [E:6555r S:0 M:139133390 (Ack:239902467)] (U) Msg RX from 0:E7FD4D0AD4DA39FF [0000] to 0000000000000000 --- Type 0000:32 (SecureChannel:CASE_Sigma3) (B:598)
00> I: 52710 [EM]<<< [E:6555r S:0 M:239902468 (Ack:139133390)] (U) Msg TX from 0000000000000000 to 0:E7FD4D0AD4DA39FF [0000] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0000:10 (SecureChannel:StandaloneAck) (B:26)
00> I: 52712 [SC]Received Sigma3 msg
00> E: 52713 [SC]The device does not support GetClock_RealTimeMS() API: 3.  Falling back to Last Known Good UTC Time
00> I: 52726 [EM]<<< [E:6555r S:0 M:239902469 (Ack:139133390)] (U) Msg TX from 0000000000000000 to 0:E7FD4D0AD4DA39FF [0000] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0000:40 (SecureChannel:StatusReport) (B:34)
00> I: 52727 [EM]??1 [E:6555r S:0 M:239902469] (U) Msg Retransmission to 0:0000000000000000 in 2074ms [State:Active II:500 AI:300 AT:4000]
00> I: 52729 [SC]SecureSession[0x20004ca8, LSID:41250]: State change 'kEstablishing' --> 'kActive'
00> D: 52729 [IN]SecureSession[0x20004ca8]: Activated - Type:2 LSID:41250
00> D: 52729 [IN]New secure session activated for device <000000000001B669, 2>, LSID:41250 PSID:2987!
00> I: 52730 [IN]CASE Session established to peer: <000000000001B669, 2>
00> D: 52730 [IN]SecureSession[0x20004d80]: Allocated Type:2 LSID:41252
00> I: 53014 [EM]>>> [E:6556r S:41250 M:179680163] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0001:08 (IM:InvokeCommandRequest) (B:59)
00> I: 53015 [FS]GeneralCommissioning: Received CommissioningComplete
00> I: 53128 [FP]Metadata for Fabric 0x2 persisted to storage.
00> I: 53135 [TS]Committing Last Known Good Time to storage: 2025-08-21T01:05:00
00> I: 53136 [ZCL]OpCreds: Fabric index 0x2 was committed to storage. Compressed Fabric Id 0xD12708452B2582B3, FabricId 0000000000000002, NodeId 000000000000000A, VendorId 0x134B
00> I: 53138 [FS]GeneralCommissioning: Successfully committed pending fabric data
00> I: 53138 [FS]Fail-safe cleanly disarmed
00> I: 53139 [EM]<<< [E:6556r S:41250 M:108035494 (Ack:179680163)] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:09 (IM:InvokeCommandResponse) (B:70)
00> I: 53140 [EM]??1 [E:6556r S:41250 M:108035494] (S) Msg Retransmission to 2:000000000001B669 in 2071ms [State:Active II:500 AI:300 AT:4000]
00> I: 53141 [SVR]Commissioning completed successfully
00> I: 53141 [DIS]Updating services using commissioning mode 0
00> D: 53141 [DL]Using Thread extended MAC for hostname.
00> I: 53141 [DIS]Advertise operational node EBF1D717072701DF-00000000F20D7C08
00> D: 53142 [DL]Using Thread extended MAC for hostname.
00> I: 53142 [DIS]Advertise operational node D12708452B2582B3-000000000000000A
00> D: 53142 [IN]Expiring all PASE sessions
00> D: 53142 [IN]SecureSession[0x20004af8]: MarkForEviction Type:1 LSID:41251
00> I: 53143 [SC]SecureSession[0x20004af8, LSID:41251]: State change 'kActive' --> 'kPendingEviction'
00> D: 53143 [IN]SecureSession[0x20004af8]: Released - Type:1 LSID:41251
00> I: 53143 [SWU]Device commissioned, schedule a default provider query
00> I: 53143 [EM]>>> [E:6555r S:0 M:139133391 (Ack:239902469)] (U) Msg RX from 0:E7FD4D0AD4DA39FF [0000] to 0000000000000000 --- Type 0000:10 (SecureChannel:StandaloneAck) (B:26)
00> I: 53330 [EM]>>> [E:6556r S:41250 M:179680164 (Ack:108035494)] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 53443 [EM]>>> [E:6557r S:41250 M:179680165] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0001:02 (IM:ReadRequest) (B:42)
00> D: 53443 [IM]Received Read request
00> I: 53452 [EM]<<< [E:6557r S:41250 M:108035495 (Ack:179680165)] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:05 (IM:ReportData) (B:1196)
00> I: 53453 [EM]??1 [E:6557r S:41250 M:108035495] (S) Msg Retransmission to 2:000000000001B669 in 2089ms [State:Active II:500 AI:300 AT:4000]
00> I: 54042 [EM]>>> [E:6557r S:41250 M:179680166 (Ack:108035495)] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0001:01 (IM:StatusResponse) (B:42)
00> I: 54043 [IM]Received status response, status is 0x00
00> I: 54050 [EM]<<< [E:6557r S:41250 M:108035496 (Ack:179680166)] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:05 (IM:ReportData) (B:1203)
00> I: 54051 [EM]??1 [E:6557r S:41250 M:108035496] (S) Msg Retransmission to 2:000000000001B669 in 2052ms [State:Active II:500 AI:300 AT:4000]
00> I: 54442 [EM]>>> [E:6557r S:41250 M:179680167 (Ack:108035496)] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0001:01 (IM:StatusResponse) (B:42)
00> I: 54442 [IM]Received status response, status is 0x00
00> I: 54462 [EM]<<< [E:6557r S:41250 M:108035497 (Ack:179680167)] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:05 (IM:ReportData) (B:1207)
00> I: 54463 [EM]??1 [E:6557r S:41250 M:108035497] (S) Msg Retransmission to 2:000000000001B669 in 2066ms [State:Active II:500 AI:300 AT:4000]
00> I: 56529 [EM]<<1 [E:6557r S:41250 M:108035497] (S) Msg Retransmission to 2:000000000001B669
00> I: 56530 [EM]??2 [E:6557r S:41250 M:108035497] (S) Msg Retransmission to 2:000000000001B669 in 2048ms [State:Active II:500 AI:300 AT:4000]
00> D: 56913 [IN]Received a duplicate message with MessageCounter:179680167 on exchange 6557r
00> I: 56913 [EM]>>> [E:6557r S:41250 M:179680167 (Ack:108035496)] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0001:01 (IM:StatusResponse) (B:42)
00> I: 56914 [EM]<<< [E:6557r S:41250 M:108035498 (Ack:179680167)] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 57043 [EM]>>> [E:6557r S:41250 M:179680168 (Ack:108035497)] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0001:01 (IM:StatusResponse) (B:42)
00> I: 57043 [IM]Received status response, status is 0x00
00> I: 57045 [EM]<<< [E:6557r S:41250 M:108035499 (Ack:179680168)] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:05 (IM:ReportData) (B:1177)
00> I: 57047 [EM]??1 [E:6557r S:41250 M:108035499] (S) Msg Retransmission to 2:000000000001B669 in 2041ms [State:Active II:500 AI:300 AT:4000]
00> I: 57646 [EM]>>> [E:6557r S:41250 M:179680169 (Ack:108035499)] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0001:01 (IM:StatusResponse) (B:42)
00> I: 57647 [IM]Received status response, status is 0x00
00> I: 57651 [EM]<<< [E:6557r S:41250 M:108035500 (Ack:179680169)] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:05 (IM:ReportData) (B:1205)
00> I: 57652 [EM]??1 [E:6557r S:41250 M:108035500] (S) Msg Retransmission to 2:000000000001B669 in 2097ms [State:Active II:500 AI:300 AT:4000]
00> I: 58061 [EM]>>> [E:6557r S:41250 M:179680170 (Ack:108035500)] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0001:01 (IM:StatusResponse) (B:42)
00> I: 58062 [IM]Received status response, status is 0x00
00> I: 58064 [EM]<<< [E:6557r S:41250 M:108035501 (Ack:179680170)] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:05 (IM:ReportData) (B:605)
00> I: 58065 [EM]??1 [E:6557r S:41250 M:108035501] (S) Msg Retransmission to 2:000000000001B669 in 2042ms [State:Active II:500 AI:300 AT:4000]
00> I: 58347 [EM]>>> [E:6557r S:41250 M:179680171 (Ack:108035501)] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 59349 [EM]>>> [E:6558r S:41250 M:179680172] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0001:08 (IM:InvokeCommandRequest) (B:66)
00> I: 59350 [ZCL]OpCreds: Received an UpdateFabricLabel command
00> I: 59351 [FP]Metadata for Fabric 0x2 persisted to storage.
00> I: 59352 [EM]<<< [E:6558r S:41250 M:108035502 (Ack:179680172)] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:09 (IM:InvokeCommandResponse) (B:70)
00> I: 59353 [EM]??1 [E:6558r S:41250 M:108035502] (S) Msg Retransmission to 2:000000000001B669 in 2051ms [State:Active II:500 AI:300 AT:4000]
00> I: 59548 [EM]>>> [E:6558r S:41250 M:179680173 (Ack:108035502)] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 59560 [EM]>>> [E:6559r S:41250 M:179680174] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0001:03 (IM:SubscribeRequest) (B:57)
00> D: 59560 [IM]Received Subscribe request
00> I: 59561 [DMG]Final negotiated min/max parameters: Min = 1s, Max = 120s
00> I: 59570 [EM]<<< [E:6559r S:41250 M:108035503 (Ack:179680174)] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:05 (IM:ReportData) (B:1197)
00> I: 59571 [EM]??1 [E:6559r S:41250 M:108035503] (S) Msg Retransmission to 2:000000000001B669 in 2039ms [State:Active II:500 AI:300 AT:4000]
00> I: 60366 [EM]>>> [E:6559r S:41250 M:179680175 (Ack:108035503)] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0001:01 (IM:StatusResponse) (B:42)
00> I: 60366 [IM]Received status response, status is 0x00
00> I: 60373 [EM]<<< [E:6559r S:41250 M:108035504 (Ack:179680175)] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:05 (IM:ReportData) (B:1209)
00> I: 60375 [EM]??1 [E:6559r S:41250 M:108035504] (S) Msg Retransmission to 2:000000000001B669 in 2111ms [State:Active II:500 AI:300 AT:4000]
00> I: 60764 [EM]>>> [E:6559r S:41250 M:179680176 (Ack:108035504)] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0001:01 (IM:StatusResponse) (B:42)
00> I: 60765 [IM]Received status response, status is 0x00
00> I: 60784 [EM]<<< [E:6559r S:41250 M:108035505 (Ack:179680176)] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:05 (IM:ReportData) (B:1186)
00> I: 60786 [EM]??1 [E:6559r S:41250 M:108035505] (S) Msg Retransmission to 2:000000000001B669 in 2090ms [State:Active II:500 AI:300 AT:4000]
00> I: 61165 [EM]>>> [E:6559r S:41250 M:179680177 (Ack:108035505)] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0001:01 (IM:StatusResponse) (B:42)
00> I: 61166 [IM]Received status response, status is 0x00
00> I: 61169 [EM]<<< [E:6559r S:41250 M:108035506 (Ack:179680177)] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:05 (IM:ReportData) (B:1184)
00> I: 61171 [EM]??1 [E:6559r S:41250 M:108035506] (S) Msg Retransmission to 2:000000000001B669 in 2043ms [State:Active II:500 AI:300 AT:4000]
00> I: 61565 [EM]>>> [E:6559r S:41250 M:179680178 (Ack:108035506)] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0001:01 (IM:StatusResponse) (B:42)
00> I: 61565 [IM]Received status response, status is 0x00
00> I: 61570 [EM]<<< [E:6559r S:41250 M:108035507 (Ack:179680178)] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:05 (IM:ReportData) (B:1184)
00> I: 61571 [EM]??1 [E:6559r S:41250 M:108035507] (S) Msg Retransmission to 2:000000000001B669 in 2051ms [State:Active II:500 AI:300 AT:4000]
00> I: 61965 [EM]>>> [E:6559r S:41250 M:179680179 (Ack:108035507)] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0001:01 (IM:StatusResponse) (B:42)
00> I: 61965 [IM]Received status response, status is 0x00
00> I: 61968 [EM]<<< [E:6559r S:41250 M:108035508 (Ack:179680179)] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:05 (IM:ReportData) (B:702)
00> I: 61970 [EM]??1 [E:6559r S:41250 M:108035508] (S) Msg Retransmission to 2:000000000001B669 in 2035ms [State:Active II:500 AI:300 AT:4000]
00> I: 62163 [EM]>>> [E:6559r S:41250 M:179680180 (Ack:108035508)] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0001:01 (IM:StatusResponse) (B:42)
00> I: 62164 [IM]Received status response, status is 0x00
00> I: 62165 [EM]<<< [E:6559r S:41250 M:108035509 (Ack:179680180)] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:04 (IM:SubscribeResponse) (B:48)
00> I: 62166 [EM]??1 [E:6559r S:41250 M:108035509] (S) Msg Retransmission to 2:000000000001B669 in 2043ms [State:Active II:500 AI:300 AT:4000]
00> I: 62167 [DMG]Registered a ReadHandler that will schedule a report between system Timestamp: 0x000000000000F6BF and system Timestamp 0x000000000002C797.
00> I: 62366 [EM]>>> [E:6559r S:41250 M:179680181 (Ack:108035509)] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 63170 [EM]<<< [E:27329i S:41250 M:108035510] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:05 (IM:ReportData) (B:100)
00> I: 63171 [EM]??1 [E:27329i S:41250 M:108035510] (S) Msg Retransmission to 2:000000000001B669 in 2112ms [State:Active II:500 AI:300 AT:4000]
00> I: 63391 [EM]>>> [E:27329i S:41250 M:179680182 (Ack:108035510)] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0001:01 (IM:StatusResponse) (B:42)
00> I: 63392 [IM]Received status response, status is 0x00
00> I: 63392 [EM]<<< [E:27329i S:41250 M:108035511 (Ack:179680182)] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 70241 [EM]<<< [E:27330i S:41250 M:108035512] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:05 (IM:ReportData) (B:100)
00> I: 70242 [EM]??1 [E:27330i S:41250 M:108035512] (S) Msg Retransmission to 2:000000000001B669 in 2337ms [State:Idle II:500 AI:300 AT:4000]
00> I: 70460 [EM]>>> [E:27330i S:41250 M:179680183 (Ack:108035512)] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0001:01 (IM:StatusResponse) (B:42)
00> I: 70461 [IM]Received status response, status is 0x00
00> I: 70461 [EM]<<< [E:27330i S:41250 M:108035513 (Ack:179680183)] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 80240 [EM]<<< [E:27331i S:41250 M:108035514] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:05 (IM:ReportData) (B:72)
00> I: 80242 [EM]??1 [E:27331i S:41250 M:108035514] (S) Msg Retransmission to 2:000000000001B669 in 2298ms [State:Idle II:500 AI:300 AT:4000]
00> I: 80564 [EM]>>> [E:27331i S:41250 M:179680184 (Ack:108035514)] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0001:01 (IM:StatusResponse) (B:42)
00> I: 80564 [IM]Received status response, status is 0x00
00> I: 80565 [EM]<<< [E:27331i S:41250 M:108035515 (Ack:179680184)] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 81873 [EM]>>> [E:6560r S:41250 M:179680185] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0001:02 (IM:ReadRequest) (B:51)
00> D: 81873 [IM]Received Read request
00> I: 81875 [EM]<<< [E:6560r S:41250 M:108035516 (Ack:179680185)] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:05 (IM:ReportData) (B:252)
00> I: 81876 [EM]??1 [E:6560r S:41250 M:108035516] (S) Msg Retransmission to 2:000000000001B669 in 2086ms [State:Active II:500 AI:300 AT:4000]
00> I: 82071 [EM]>>> [E:6560r S:41250 M:179680186 (Ack:108035516)] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 82081 [EM]>>> [E:6561r S:41250 M:179680187] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0001:02 (IM:ReadRequest) (B:51)
00> D: 82081 [IM]Received Read request
00> I: 82082 [EM]<<< [E:6561r S:41250 M:108035517 (Ack:179680187)] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:05 (IM:ReportData) (B:252)
00> I: 82084 [EM]??1 [E:6561r S:41250 M:108035517] (S) Msg Retransmission to 2:000000000001B669 in 2049ms [State:Active II:500 AI:300 AT:4000]
00> I: 82280 [EM]>>> [E:6561r S:41250 M:179680188 (Ack:108035517)] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> E: 83143 [SWU]No suitable OTA Provider candidate found
00> I: 83144 [SWU]No provider available
00> I: 90241 [EM]<<< [E:27332i S:41250 M:108035518] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:05 (IM:ReportData) (B:100)
00> I: 90242 [EM]??1 [E:27332i S:41250 M:108035518] (S) Msg Retransmission to 2:000000000001B669 in 2385ms [State:Idle II:500 AI:300 AT:4000]
00> I: 92627 [EM]<<1 [E:27332i S:41250 M:108035518] (S) Msg Retransmission to 2:000000000001B669
00> I: 92627 [EM]??2 [E:27332i S:41250 M:108035518] (S) Msg Retransmission to 2:000000000001B669 in 2376ms [State:Idle II:500 AI:300 AT:4000]
00> I: 93094 [EM]>>> [E:27332i S:41250 M:179680190 (Ack:108035518)] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 96454 [EM]>>> [E:27332i S:41250 M:179680189 (Ack:108035518)] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0001:01 (IM:StatusResponse) (B:42)
00> I: 96455 [IM]Received status response, status is 0x00
00> I: 96455 [EM]<<< [E:27332i S:41250 M:108035519 (Ack:179680189)] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 100241 [EM]<<< [E:27333i S:41250 M:108035520] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:05 (IM:ReportData) (B:100)
00> I: 100242 [EM]??1 [E:27333i S:41250 M:108035520] (S) Msg Retransmission to 2:000000000001B669 in 2100ms [State:Active II:500 AI:300 AT:4000]
00> I: 100568 [EM]>>> [E:27333i S:41250 M:179680191 (Ack:108035520)] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0001:01 (IM:StatusResponse) (B:42)
00> I: 100568 [IM]Received status response, status is 0x00
00> I: 100569 [EM]<<< [E:27333i S:41250 M:108035521 (Ack:179680191)] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 101768 [EM]>>> [E:6562r S:41250 M:179680192] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0001:02 (IM:ReadRequest) (B:51)
00> D: 101768 [IM]Received Read request
00> I: 101770 [EM]<<< [E:6562r S:41250 M:108035522 (Ack:179680192)] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:05 (IM:ReportData) (B:252)
00> I: 101771 [EM]??1 [E:6562r S:41250 M:108035522] (S) Msg Retransmission to 2:000000000001B669 in 2041ms [State:Active II:500 AI:300 AT:4000]
00> I: 102168 [EM]>>> [E:6562r S:41250 M:179680193 (Ack:108035522)] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 102283 [EM]>>> [E:6563r S:41250 M:179680194] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0001:02 (IM:ReadRequest) (B:51)
00> D: 102283 [IM]Received Read request
00> I: 102285 [EM]<<< [E:6563r S:41250 M:108035523 (Ack:179680194)] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:05 (IM:ReportData) (B:252)
00> I: 102286 [EM]??1 [E:6563r S:41250 M:108035523] (S) Msg Retransmission to 2:000000000001B669 in 2108ms [State:Active II:500 AI:300 AT:4000]
00> I: 102583 [EM]>>> [E:6563r S:41250 M:179680195 (Ack:108035523)] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 110241 [EM]<<< [E:27334i S:41250 M:108035524] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:05 (IM:ReportData) (B:100)
00> I: 110242 [EM]??1 [E:27334i S:41250 M:108035524] (S) Msg Retransmission to 2:000000000001B669 in 2298ms [State:Idle II:500 AI:300 AT:4000]
00> I: 110566 [EM]>>> [E:27334i S:41250 M:179680196 (Ack:108035524)] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0001:01 (IM:StatusResponse) (B:42)
00> I: 110567 [IM]Received status response, status is 0x00
00> I: 110568 [EM]<<< [E:27334i S:41250 M:108035525 (Ack:179680196)] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 120241 [EM]<<< [E:27335i S:41250 M:108035526] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:05 (IM:ReportData) (B:100)
00> I: 120242 [EM]??1 [E:27335i S:41250 M:108035526] (S) Msg Retransmission to 2:000000000001B669 in 2374ms [State:Idle II:500 AI:300 AT:4000]
00> I: 122616 [EM]<<1 [E:27335i S:41250 M:108035526] (S) Msg Retransmission to 2:000000000001B669
00> I: 122616 [EM]??2 [E:27335i S:41250 M:108035526] (S) Msg Retransmission to 2:000000000001B669 in 2273ms [State:Idle II:500 AI:300 AT:4000]
00> I: 123142 [EM]>>> [E:27335i S:41250 M:179680198 (Ack:108035526)] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 123154 [EM]>>> [E:27335i S:41250 M:179680197 (Ack:108035526)] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0001:01 (IM:StatusResponse) (B:42)
00> I: 123154 [IM]Received status response, status is 0x00
00> I: 123155 [EM]<<< [E:27335i S:41250 M:108035527 (Ack:179680197)] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 130241 [EM]<<< [E:27336i S:41250 M:108035528] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:05 (IM:ReportData) (B:100)
00> I: 130242 [EM]??1 [E:27336i S:41250 M:108035528] (S) Msg Retransmission to 2:000000000001B669 in 2330ms [State:Idle II:500 AI:300 AT:4000]
00> I: 130461 [EM]>>> [E:27336i S:41250 M:179680199 (Ack:108035528)] (S) Msg RX from 2:000000000001B669 [82B3] to 000000000000000A --- Type 0001:01 (IM:StatusResponse) (B:42)
00> I: 130461 [IM]Received status response, status is 0x00
00> I: 130462 [EM]<<< [E:27336i S:41250 M:108035529 (Ack:179680199)] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
00> I: 140241 [EM]<<< [E:27337i S:41250 M:108035530] (S) Msg TX from 000000000000000A to 2:000000000001B669 [82B3] [UDP:[fd0c:5b01:2856:1:7c1f:6d7f:f316:fddc]:33196] --- Type 0001:05 (IM:ReportData) (B:100)
00> I: 140242 [EM]??1 [E:27337i S:41250 M:108035530] (S) Msg Retransmission to 2:000000000001B669 in 2317ms [State:Idle II:500 AI:300 AT:4000]