ubuntu@ubuntu:~/connectedhomeip/examples/all-clusters-app/linux/out/all-clusters-app$ ./chip-all-clusters-app --wifi [1707930953.351922][1223:1223] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_kvs [1707930953.352367][1223:1223] CHIP:DL: writing settings to file (/tmp/chip_kvs-6T0GcF) [1707930953.352599][1223:1223] CHIP:DL: renamed tmp file to file (/tmp/chip_kvs) [1707930953.353393][1223:1223] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_kvs [1707930953.353430][1223:1223] CHIP:DL: ChipLinuxStorage::Init: Attempt to re-initialize with KVS config file: /tmp/chip_kvs [1707930953.358798][1223:1223] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_factory.ini [1707930953.359079][1223:1223] CHIP:DL: writing settings to file (/tmp/chip_factory.ini-hHoKfm) [1707930953.359261][1223:1223] CHIP:DL: renamed tmp file to file (/tmp/chip_factory.ini) [1707930953.359438][1223:1223] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_config.ini [1707930953.359567][1223:1223] CHIP:DL: writing settings to file (/tmp/chip_config.ini-fE22z7) [1707930953.359687][1223:1223] CHIP:DL: renamed tmp file to file (/tmp/chip_config.ini) [1707930953.359765][1223:1223] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_counters.ini [1707930953.359859][1223:1223] CHIP:DL: writing settings to file (/tmp/chip_counters.ini-7pLBNk) [1707930953.359963][1223:1223] CHIP:DL: renamed tmp file to file (/tmp/chip_counters.ini) [1707930953.360190][1223:1223] CHIP:DL: writing settings to file (/tmp/chip_factory.ini-kto9Zg) [1707930953.360725][1223:1223] CHIP:DL: renamed tmp file to file (/tmp/chip_factory.ini) [1707930953.360782][1223:1223] CHIP:DL: NVS set: chip-factory/unique-id = "2D6E84A90F8B8CA2" [1707930953.360928][1223:1223] CHIP:DL: writing settings to file (/tmp/chip_factory.ini-6KdP4U) [1707930953.362143][1223:1223] CHIP:DL: renamed tmp file to file (/tmp/chip_factory.ini) [1707930953.362194][1223:1223] CHIP:DL: NVS set: chip-factory/vendor-id = 65521 (0xFFF1) [1707930953.362318][1223:1223] CHIP:DL: writing settings to file (/tmp/chip_factory.ini-RuFKeO) [1707930953.363422][1223:1223] CHIP:DL: renamed tmp file to file (/tmp/chip_factory.ini) [1707930953.363469][1223:1223] CHIP:DL: NVS set: chip-factory/product-id = 32769 (0x8001) [1707930953.363679][1223:1223] CHIP:DL: writing settings to file (/tmp/chip_counters.ini-QZT2pM) [1707930953.364485][1223:1223] CHIP:DL: renamed tmp file to file (/tmp/chip_counters.ini) [1707930953.364775][1223:1223] CHIP:DL: NVS set: chip-counters/reboot-count = 1 (0x1) [1707930953.365247][1223:1223] CHIP:DL: writing settings to file (/tmp/chip_counters.ini-5dUdyI) [1707930953.366574][1223:1223] CHIP:DL: renamed tmp file to file (/tmp/chip_counters.ini) [1707930953.366694][1223:1223] CHIP:DL: NVS set: chip-counters/total-operational-hours = 0 (0x0) [1707930953.366963][1223:1223] CHIP:DL: writing settings to file (/tmp/chip_counters.ini-KlD1Lb) [1707930953.368263][1223:1223] CHIP:DL: renamed tmp file to file (/tmp/chip_counters.ini) [1707930953.368384][1223:1223] CHIP:DL: NVS set: chip-counters/boot-reason = 0 (0x0) [1707930953.368659][1223:1223] CHIP:DL: writing settings to file (/tmp/chip_config.ini-7N7MFb) [1707930953.369448][1223:1223] CHIP:DL: renamed tmp file to file (/tmp/chip_config.ini) [1707930953.369563][1223:1223] CHIP:DL: NVS set: chip-config/regulatory-location = 0 (0x0) [1707930953.370043][1223:1223] CHIP:DL: writing settings to file (/tmp/chip_config.ini-6WfJRb) [1707930953.371730][1223:1223] CHIP:DL: renamed tmp file to file (/tmp/chip_config.ini) [1707930953.371853][1223:1223] CHIP:DL: NVS set: chip-config/location-capability = 2 (0x2) [1707930953.373090][1223:1223] CHIP:DL: Got Ethernet interface: eth0 [1707930953.374027][1223:1223] CHIP:DL: Found the primary Ethernet interface:eth0 [1707930953.375013][1223:1223] CHIP:DL: Got WiFi interface: wlan0 [1707930953.382096][1223:1223] CHIP:DL: Found the primary WiFi interface:wlan0 [1707930953.382208][1223:1223] CHIP:SPT: *** WARNING: Using temporary passcode 20202021 due to no neither --passcode or --spake2p-verifier-base64 given on command line. This is temporary and will disappear. Please update your scripts to explicitly configure onboarding credentials. *** [1707930953.382270][1223:1223] CHIP:SPT: *** WARNING: Using temporary test discriminator 3840 due to --discriminator not given on command line. This is temporary and will disappear. Please update your scripts to explicitly configure discriminator. *** [1707930953.382323][1223:1223] CHIP:SPT: PASE PBKDF iterations set to 1000 [1707930953.382385][1223:1223] CHIP:SPT: LinuxCommissionableDataProvider didn't get a PASE salt, generating one. [1707930953.400403][1223:1223] CHIP:DL: Device Configuration: [1707930953.400536][1223:1223] CHIP:DL: Serial Number: TEST_SN [1707930953.400616][1223:1223] CHIP:DL: Vendor Id: 65521 (0xFFF1) [1707930953.400698][1223:1223] CHIP:DL: Product Id: 32769 (0x8001) [1707930953.400753][1223:1223] CHIP:DL: Product Name: TEST_PRODUCT [1707930953.400822][1223:1223] CHIP:DL: Hardware Version: 0 [1707930953.400873][1223:1223] CHIP:DL: Setup Pin Code (0 for UNKNOWN/ERROR): 20202021 [1707930953.400919][1223:1223] CHIP:DL: Setup Discriminator (0xFFFF for UNKNOWN/ERROR): 3840 (0xF00) [1707930953.400986][1223:1223] CHIP:DL: Manufacturing Date: (not set) [1707930953.401035][1223:1223] CHIP:DL: Device Type: 65535 (0xFFFF) [1707930953.401081][1223:1223] CHIP:-: ==== Onboarding payload for Standard Commissioning Flow ==== [1707930953.401161][1223:1223] CHIP:SVR: SetupQRCode: [MT:-24J042C00KA0648G00] [1707930953.401224][1223:1223] CHIP:SVR: Copy/paste the below URL in a browser to see the QR Code: [1707930953.401270][1223:1223] CHIP:SVR: https://project-chip.github.io/connectedhomeip/qrcode.html?data=MT%3A-24J042C00KA0648G00 [1707930953.401339][1223:1223] CHIP:SVR: Manual pairing code: [34970112332] [1707930953.401606][1223:1224] CHIP:DL: wpa_supplicant: Start WiFi management [1707930953.422122][1223:1224] CHIP:DL: wpa_supplicant: connected to wpa_supplicant proxy [1707930953.425085][1223:1224] CHIP:DL: wpa_supplicant: WiFi interface: /fi/w1/wpa_supplicant1/Interfaces/0 [1707930953.445036][1223:1224] CHIP:DL: wpa_supplicant: connected to wpa_supplicant interface proxy [1707930953.445753][1223:1224] CHIP:DL: wpa_supplicant: connected to wpa_supplicant bss proxy [1707930953.506093][1223:1223] CHIP:SVR: Initializing subscription resumption storage... [1707930953.506642][1223:1223] CHIP:DL: writing settings to file (/tmp/chip_kvs-7srWpn) [1707930953.507945][1223:1223] CHIP:DL: renamed tmp file to file (/tmp/chip_kvs) [1707930953.508135][1223:1223] CHIP:SVR: Server initializing... [1707930953.508255][1223:1223] CHIP:FP: Initializing FabricTable from persistent storage [1707930953.508405][1223:1223] CHIP:TS: Last Known Good Time: [unknown] [1707930953.508472][1223:1223] CHIP:TS: Setting Last Known Good Time to firmware build time 2023-10-14T01:16:48 [1707930953.508830][1223:1223] CHIP:DL: writing settings to file (/tmp/chip_kvs-wuNrKU) [1707930953.509984][1223:1223] CHIP:DL: renamed tmp file to file (/tmp/chip_kvs) [1707930953.510191][1223:1223] CHIP:DMG: AccessControl: initializing [1707930953.510249][1223:1223] CHIP:DMG: Examples::AccessControlDelegate::Init [1707930953.510324][1223:1223] CHIP:DMG: AccessControl: setting [1707930953.510375][1223:1223] CHIP:DMG: DefaultAclStorage: initializing [1707930953.510421][1223:1223] CHIP:DMG: DefaultAclStorage: 0 entries loaded [1707930953.510490][1223:1223] CHIP:IN: UDP::Init bind&listen port=5540 [1707930953.510754][1223:1223] CHIP:IN: UDP::Init bound to port=5540 [1707930953.510812][1223:1223] CHIP:IN: BLEBase::Init - setting/overriding transport [1707930953.510860][1223:1223] CHIP:IN: TransportMgr initialized [1707930953.511399][1223:1223] CHIP:DL: writing settings to file (/tmp/chip_kvs-B0GHES) [1707930953.512561][1223:1223] CHIP:DL: renamed tmp file to file (/tmp/chip_kvs) [1707930953.512894][1223:1223] CHIP:DL: writing settings to file (/tmp/chip_kvs-H6PMp0) [1707930953.516857][1223:1223] CHIP:DL: renamed tmp file to file (/tmp/chip_kvs) [1707930953.520790][1223:1223] CHIP:DL: writing settings to file (/tmp/chip_kvs-6WwDrB) [1707930953.522033][1223:1223] CHIP:DL: renamed tmp file to file (/tmp/chip_kvs) [1707930953.522175][1223:1223] CHIP:ZCL: Using ZAP configuration... [1707930953.522452][1223:1223] CHIP:DMG: Failed to read stored attribute (0, 0x0000_0028, 0x0000_0005: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.522571][1223:1223] CHIP:DMG: Failed to read stored attribute (0, 0x0000_0028, 0x0000_0010: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.522699][1223:1223] CHIP:DMG: Failed to read stored attribute (0, 0x0000_002B, 0x0000_0000: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.522798][1223:1223] CHIP:DMG: Failed to read stored attribute (0, 0x0000_002C, 0x0000_0000: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.522891][1223:1223] CHIP:DMG: Failed to read stored attribute (0, 0x0000_002C, 0x0000_0001: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.522986][1223:1223] CHIP:DMG: Failed to read stored attribute (0, 0x0000_002D, 0x0000_0000: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.523185][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_0006, 0x0000_0000: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.523279][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_0006, 0x0000_4003: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.523507][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_0008, 0x0000_0000: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.523617][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_0008, 0x0000_4000: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.523764][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_0050, 0x0000_0003: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.523855][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_0050, 0x0000_0004: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.523945][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_0050, 0x0000_0005: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.524076][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_005C, 0x0000_0000: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.524166][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_005C, 0x0000_0001: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.524257][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_005C, 0x0000_0002: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.524347][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_005C, 0x0000_0003: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.524438][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_005C, 0x0000_0004: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.524530][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_005C, 0x0000_0006: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.524620][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_005C, 0x0000_0007: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.524776][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_0080, 0x0000_0005: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.524880][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_0081, 0x0000_0001: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.524983][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_0081, 0x0000_0008: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.525114][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_0102, 0x0000_0003: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.525205][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_0102, 0x0000_0004: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.525297][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_0102, 0x0000_0005: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.525387][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_0102, 0x0000_0006: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.525478][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_0102, 0x0000_0007: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.525569][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_0102, 0x0000_0008: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.525660][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_0102, 0x0000_0009: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.525762][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_0102, 0x0000_000E: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.525854][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_0102, 0x0000_000F: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.525945][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_0102, 0x0000_0010: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.526038][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_0102, 0x0000_0011: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.526130][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_0102, 0x0000_0012: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.526278][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_0102, 0x0000_0013: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.526401][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_0102, 0x0000_0017: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.526729][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_0300, 0x0000_0000: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.526821][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_0300, 0x0000_0001: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.526915][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_0300, 0x0000_0003: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.527006][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_0300, 0x0000_0004: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.527103][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_0300, 0x0000_0007: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.527358][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_0300, 0x0000_4000: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.527455][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_0300, 0x0000_4001: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.527549][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_0300, 0x0000_4002: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.527643][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_0300, 0x0000_4003: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.527736][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_0300, 0x0000_4004: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.527858][1223:1223] CHIP:DMG: Failed to read stored attribute (1, 0x0000_0300, 0x0000_4010: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.528621][1223:1223] CHIP:DMG: AccessControlCluster: initializing [1707930953.528673][1223:1223] CHIP:ZCL: Initiating Admin Commissioning cluster. [1707930953.528745][1223:1223] CHIP:DMG: Endpoint 0, Cluster 0x0000_0030 update version to e0c6e474 [1707930953.528893][1223:1223] CHIP:ZCL: GeneralDiagnostics: OnDeviceReboot [1707930953.528956][1223:1223] CHIP:DMG: Endpoint 0, Cluster 0x0000_0033 update version to d2eaa3d7 [1707930953.529197][1223:1223] CHIP:EVL: LogEvent event number: 0x0000000000000000 priority: 2, endpoint id: 0x0 cluster id: 0x0000_0033 event id: 0x3 Epoch timestamp: 0x0000018DA89E2739 [1707930953.529706][1223:1223] CHIP:DL: writing settings to file (/tmp/chip_kvs-bHHXJg) [1707930953.530963][1223:1223] CHIP:DL: renamed tmp file to file (/tmp/chip_kvs) [1707930953.531247][1223:1223] CHIP:EVL: LogEvent event number: 0x0000000000000001 priority: 1, endpoint id: 0x0 cluster id: 0x0000_0038 event id: 0x0 Epoch timestamp: 0x0000018DA89E273B [1707930953.531351][1223:1223] CHIP:ZCL: Emit DSTTableEmpty event [ep=0] [1707930953.531490][1223:1223] CHIP:DMG: Endpoint 0, Cluster 0x0000_0003 update version to bb72f578 [1707930953.531557][1223:1223] CHIP:DMG: Endpoint 0, Cluster 0x0000_0004 update version to 8b619e8a [1707930953.531620][1223:1223] CHIP:DMG: Endpoint 0, Cluster 0x0000_0004 update version to 8b619e8b [1707930953.531734][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_0003 update version to 327a596 [1707930953.531797][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_0004 update version to 5821e6ee [1707930953.531853][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_0004 update version to 5821e6ef [1707930953.531927][1223:1223] CHIP:ZCL: Endpoint 1 On/off already set to new value [1707930953.532296][1223:1223] CHIP:DL: writing settings to file (/tmp/chip_kvs-XeDvDz) [1707930953.533510][1223:1223] CHIP:DL: renamed tmp file to file (/tmp/chip_kvs) [1707930953.533643][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_0008 update version to d5c22b4b [1707930953.533827][1223:1223] CHIP:ZCL: ModeBase: Unable to load the CurrentMode from the KVS. Assuming 0 [1707930953.533917][1223:1223] CHIP:ZCL: ModeBase: Unable to load the StartUpMode from the KVS. Assuming null [1707930953.533999][1223:1223] CHIP:ZCL: ModeBase: Unable to load the OnMode from the KVS. Assuming null [1707930953.534204][1223:1223] CHIP:ZCL: ModeBase: Unable to load the CurrentMode from the KVS. Assuming 0 [1707930953.534290][1223:1223] CHIP:ZCL: ModeBase: Unable to load the StartUpMode from the KVS. Assuming null [1707930953.534368][1223:1223] CHIP:ZCL: ModeBase: Unable to load the OnMode from the KVS. Assuming null [1707930953.534478][1223:1223] CHIP:ZCL: ModeBase: Unable to load the CurrentMode from the KVS. Assuming 0 [1707930953.534559][1223:1223] CHIP:ZCL: ModeBase: Unable to load the StartUpMode from the KVS. Assuming null [1707930953.534639][1223:1223] CHIP:ZCL: ModeBase: Unable to load the OnMode from the KVS. Assuming null [1707930953.534745][1223:1223] CHIP:ZCL: ModeBase: Unable to load the CurrentMode from the KVS. Assuming 0 [1707930953.534827][1223:1223] CHIP:ZCL: ModeBase: Unable to load the StartUpMode from the KVS. Assuming null [1707930953.534905][1223:1223] CHIP:ZCL: ModeBase: Unable to load the OnMode from the KVS. Assuming null [1707930953.535001][1223:1223] CHIP:ZCL: ModeBase: Unable to load the CurrentMode from the KVS. Assuming 0 [1707930953.535081][1223:1223] CHIP:ZCL: ModeBase: Unable to load the StartUpMode from the KVS. Assuming null [1707930953.535159][1223:1223] CHIP:ZCL: ModeBase: Unable to load the OnMode from the KVS. Assuming null [1707930953.535258][1223:1223] CHIP:ZCL: ModeBase: Unable to load the CurrentMode from the KVS. Assuming 0 [1707930953.535381][1223:1223] CHIP:ZCL: ModeBase: Unable to load the StartUpMode from the KVS. Assuming null [1707930953.535462][1223:1223] CHIP:ZCL: ModeBase: Unable to load the OnMode from the KVS. Assuming null [1707930953.535573][1223:1223] CHIP:ZCL: ModeBase: Unable to load the CurrentMode from the KVS. Assuming 0 [1707930953.535656][1223:1223] CHIP:ZCL: ModeBase: Unable to load the StartUpMode from the KVS. Assuming null [1707930953.535734][1223:1223] CHIP:ZCL: ModeBase: Unable to load the OnMode from the KVS. Assuming null [1707930953.535842][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_0062 update version to b19d367 [1707930953.535915][1223:1223] CHIP:ZCL: ResourceMonitoring: Init [1707930953.536000][1223:1223] CHIP:ZCL: ResourceMonitoring: Unable to load the LastChangedTime from the KVS. Assuming null [1707930953.536058][1223:1223] CHIP:ZCL: ResourceMonitoring: calling mDelegate->Init() [1707930953.536104][1223:1223] CHIP:ZCL: HepaFilterMonitoringDelegate::Init() [1707930953.536154][1223:1223] CHIP:ZCL: ResourceMonitoring: Init [1707930953.536233][1223:1223] CHIP:ZCL: ResourceMonitoring: Unable to load the LastChangedTime from the KVS. Assuming null [1707930953.536288][1223:1223] CHIP:ZCL: ResourceMonitoring: calling mDelegate->Init() [1707930953.536336][1223:1223] CHIP:ZCL: ActivatedCarbonFilterMonitoringDelegate::Init() [1707930953.536507][1223:1223] CHIP:SVR: EVSE: Unable to restore persisted ChargingEnabledUntil value [1707930953.536593][1223:1223] CHIP:SVR: EVSE: Unable to restore persisted DischargingEnabledUntil value [1707930953.536674][1223:1223] CHIP:SVR: EVSE: Unable to restore persisted UserMaximumChargeCurrent value [1707930953.536752][1223:1223] CHIP:SVR: EVSE: Unable to restore persisted RandomizationDelayWindow value [1707930953.536832][1223:1223] CHIP:SVR: EVSE: Unable to restore persisted ApproximateEVEfficiency value [1707930953.536938][1223:1223] CHIP:ZCL: ModeBase: Unable to load the CurrentMode from the KVS. Assuming 0 [1707930953.537019][1223:1223] CHIP:ZCL: ModeBase: Unable to load the StartUpMode from the KVS. Assuming null [1707930953.537098][1223:1223] CHIP:ZCL: ModeBase: Unable to load the OnMode from the KVS. Assuming null [1707930953.537207][1223:1223] CHIP:ZCL: ModeBase: Unable to load the CurrentMode from the KVS. Assuming 0 [1707930953.537289][1223:1223] CHIP:ZCL: ModeBase: Unable to load the StartUpMode from the KVS. Assuming null [1707930953.537367][1223:1223] CHIP:ZCL: ModeBase: Unable to load the OnMode from the KVS. Assuming null [1707930953.537756][1223:1223] CHIP:DL: writing settings to file (/tmp/chip_kvs-Ck15PP) [1707930953.539005][1223:1223] CHIP:DL: renamed tmp file to file (/tmp/chip_kvs) [1707930953.539140][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_0102 update version to 5f58b02f [1707930953.539205][1223:1223] CHIP:ZCL: WC POST ATTRIBUTE=7 [1707930953.539271][1223:1223] CHIP:ZCL: ConfigStatus 0x1B Operational=1 OnlineReserved=1 [1707930953.539360][1223:1223] CHIP:ZCL: Lift(PA=1 Encoder=0 Reversed=0) Tilt(PA=1 Encoder=0) [1707930953.539414][1223:1223] CHIP:ZCL: Initialize PCC Server Cluster [EP:1] [1707930953.539770][1223:1223] CHIP:DL: writing settings to file (/tmp/chip_kvs-mpVSH4) [1707930953.540975][1223:1223] CHIP:DL: renamed tmp file to file (/tmp/chip_kvs) [1707930953.541109][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_0300 update version to 2c13c7c3 [1707930953.541189][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_0300 update version to 2c13c7c4 [1707930953.541474][1223:1223] CHIP:DL: writing settings to file (/tmp/chip_kvs-2J3tEz) [1707930953.542636][1223:1223] CHIP:DL: renamed tmp file to file (/tmp/chip_kvs) [1707930953.542766][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_0300 update version to 2c13c7c5 [1707930953.542863][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_0406 update version to 57e3584d [1707930953.542933][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_0406 update version to 57e3584e [1707930953.543009][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_040C update version to 57466725 [1707930953.543067][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_040C update version to 57466726 [1707930953.543123][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_040C update version to 57466727 [1707930953.543178][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_040C update version to 57466728 [1707930953.543231][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_040C update version to 57466729 [1707930953.543327][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_040C update version to 5746672a [1707930953.543385][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_040C update version to 5746672b [1707930953.543438][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_040C update version to 5746672c [1707930953.543500][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_040D update version to 4f8a548c [1707930953.543555][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_040D update version to 4f8a548d [1707930953.543609][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_040D update version to 4f8a548e [1707930953.543663][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_040D update version to 4f8a548f [1707930953.543715][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_040D update version to 4f8a5490 [1707930953.543769][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_040D update version to 4f8a5491 [1707930953.543821][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_040D update version to 4f8a5492 [1707930953.543873][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_040D update version to 4f8a5493 [1707930953.543932][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_0413 update version to 521a9eef [1707930953.543987][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_0413 update version to 521a9ef0 [1707930953.544041][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_0413 update version to 521a9ef1 [1707930953.544095][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_0413 update version to 521a9ef2 [1707930953.544148][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_0413 update version to 521a9ef3 [1707930953.544201][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_0413 update version to 521a9ef4 [1707930953.544253][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_0413 update version to 521a9ef5 [1707930953.544305][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_0413 update version to 521a9ef6 [1707930953.544365][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_0415 update version to ef98dca [1707930953.544420][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_0415 update version to ef98dcb [1707930953.544474][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_0415 update version to ef98dcc [1707930953.544528][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_0415 update version to ef98dcd [1707930953.544580][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_0415 update version to ef98dce [1707930953.544633][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_0415 update version to ef98dcf [1707930953.544686][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_0415 update version to ef98dd0 [1707930953.544738][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_0415 update version to ef98dd1 [1707930953.544799][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042A update version to 3c5d398f [1707930953.544853][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042A update version to 3c5d3990 [1707930953.544906][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042A update version to 3c5d3991 [1707930953.544960][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042A update version to 3c5d3992 [1707930953.545013][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042A update version to 3c5d3993 [1707930953.545066][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042A update version to 3c5d3994 [1707930953.545119][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042A update version to 3c5d3995 [1707930953.545171][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042A update version to 3c5d3996 [1707930953.545232][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042B update version to 7c2b570f [1707930953.545286][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042B update version to 7c2b5710 [1707930953.545339][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042B update version to 7c2b5711 [1707930953.545393][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042B update version to 7c2b5712 [1707930953.545445][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042B update version to 7c2b5713 [1707930953.545498][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042B update version to 7c2b5714 [1707930953.545550][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042B update version to 7c2b5715 [1707930953.545603][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042B update version to 7c2b5716 [1707930953.545662][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042C update version to a631d965 [1707930953.545716][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042C update version to a631d966 [1707930953.545770][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042C update version to a631d967 [1707930953.545824][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042C update version to a631d968 [1707930953.545876][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042C update version to a631d969 [1707930953.545929][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042C update version to a631d96a [1707930953.545982][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042C update version to a631d96b [1707930953.546034][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042C update version to a631d96c [1707930953.546095][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042D update version to 3f288a36 [1707930953.546149][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042D update version to 3f288a37 [1707930953.546203][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042D update version to 3f288a38 [1707930953.546256][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042D update version to 3f288a39 [1707930953.546309][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042D update version to 3f288a3a [1707930953.546362][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042D update version to 3f288a3b [1707930953.546414][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042D update version to 3f288a3c [1707930953.546466][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042D update version to 3f288a3d [1707930953.546527][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042E update version to 5170d7b8 [1707930953.546582][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042E update version to 5170d7b9 [1707930953.546635][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042E update version to 5170d7ba [1707930953.546689][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042E update version to 5170d7bb [1707930953.546741][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042E update version to 5170d7bc [1707930953.546794][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042E update version to 5170d7bd [1707930953.546847][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042E update version to 5170d7be [1707930953.546899][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042E update version to 5170d7bf [1707930953.546960][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042F update version to 51cb3482 [1707930953.547014][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042F update version to 51cb3483 [1707930953.547068][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042F update version to 51cb3484 [1707930953.547122][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042F update version to 51cb3485 [1707930953.547175][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042F update version to 51cb3486 [1707930953.547229][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042F update version to 51cb3487 [1707930953.547282][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042F update version to 51cb3488 [1707930953.547532][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_042F update version to 51cb3489 [1707930953.547583][1223:1223] CHIP:-: Setting LowPower default delegate to global manager [1707930953.547650][1223:1223] CHIP:DMG: Endpoint 2, Cluster 0x0000_0004 update version to e006420b [1707930953.547707][1223:1223] CHIP:DMG: Endpoint 2, Cluster 0x0000_0004 update version to e006420c [1707930953.547775][1223:1223] CHIP:DMG: Endpoint 2, Cluster 0x0000_0062 update version to 94cfb392 [1707930953.547842][1223:1223] CHIP:DMG: Endpoint 2, Cluster 0x0000_0406 update version to 4a04afc9 [1707930953.547899][1223:1223] CHIP:DMG: Endpoint 2, Cluster 0x0000_0406 update version to 4a04afca [1707930953.548193][1223:1223] CHIP:IN: SecureSession[0xaaaaf44473c0]: Allocated Type:1 LSID:1291 [1707930953.548282][1223:1223] CHIP:SC: Assigned local session key ID 1291 [1707930953.548338][1223:1223] CHIP:SC: Waiting for PBKDF param request [1707930953.548417][1223:1223] CHIP:DIS: Updating services using commissioning mode 1 [1707930953.552042][1223:1223] CHIP:DIS: CHIP minimal mDNS started advertising. [1707930953.557222][1223:1223] CHIP:DL: Using wifi MAC for hostname [1707930953.557441][1223:1223] CHIP:DIS: Advertise commission parameter vendorID=65521 productID=32769 discriminator=3840/15 cm=1 cp=0 [1707930953.557603][1223:1223] CHIP:DIS: Responding with _matterc._udp.local [1707930953.557664][1223:1223] CHIP:DIS: Responding with 2AE6EA690898C6A5._matterc._udp.local [1707930953.557719][1223:1223] CHIP:DIS: Responding with E45F014342150000.local [1707930953.557771][1223:1223] CHIP:DIS: Responding with E45F014342150000.local [1707930953.557833][1223:1223] CHIP:DIS: Responding with _V65521._sub._matterc._udp.local [1707930953.557894][1223:1223] CHIP:DIS: Responding with _T65535._sub._matterc._udp.local [1707930953.557952][1223:1223] CHIP:DIS: Responding with _S15._sub._matterc._udp.local [1707930953.558010][1223:1223] CHIP:DIS: Responding with _L3840._sub._matterc._udp.local [1707930953.558067][1223:1223] CHIP:DIS: Responding with _CM._sub._matterc._udp.local [1707930953.558144][1223:1223] CHIP:DIS: Responding with 2AE6EA690898C6A5._matterc._udp.local [1707930953.558193][1223:1223] CHIP:DIS: CHIP minimal mDNS configured as 'Commissionable node device'; instance name: 2AE6EA690898C6A5. [1707930953.563554][1223:1223] CHIP:DIS: mDNS service published: _matterc._udp [1707930953.563651][1223:1223] CHIP:DIS: Updating services using commissioning mode 1 [1707930953.567000][1223:1223] CHIP:DIS: CHIP minimal mDNS started advertising. [1707930953.578331][1223:1223] CHIP:DL: Using wifi MAC for hostname [1707930953.578549][1223:1223] CHIP:DIS: Advertise commission parameter vendorID=65521 productID=32769 discriminator=3840/15 cm=1 cp=0 [1707930953.578664][1223:1223] CHIP:DIS: Responding with _matterc._udp.local [1707930953.578724][1223:1223] CHIP:DIS: Responding with 2AE6EA690898C6A5._matterc._udp.local [1707930953.578776][1223:1223] CHIP:DIS: Responding with E45F014342150000.local [1707930953.578828][1223:1223] CHIP:DIS: Responding with E45F014342150000.local [1707930953.578889][1223:1223] CHIP:DIS: Responding with _V65521._sub._matterc._udp.local [1707930953.578948][1223:1223] CHIP:DIS: Responding with _T65535._sub._matterc._udp.local [1707930953.579006][1223:1223] CHIP:DIS: Responding with _S15._sub._matterc._udp.local [1707930953.579062][1223:1223] CHIP:DIS: Responding with _L3840._sub._matterc._udp.local [1707930953.579118][1223:1223] CHIP:DIS: Responding with _CM._sub._matterc._udp.local [1707930953.579193][1223:1223] CHIP:DIS: Responding with 2AE6EA690898C6A5._matterc._udp.local [1707930953.579244][1223:1223] CHIP:DIS: CHIP minimal mDNS configured as 'Commissionable node device'; instance name: 2AE6EA690898C6A5. [1707930953.584770][1223:1223] CHIP:DIS: mDNS service published: _matterc._udp [1707930953.584884][1223:1223] CHIP:IN: CASE Server enabling CASE session setups [1707930953.585085][1223:1223] CHIP:IN: SecureSession[0xaaaaf4447950]: Allocated Type:2 LSID:1292 [1707930953.585181][1223:1223] CHIP:SC: Allocated SecureSession (0xaaaaf4447950) - waiting for Sigma1 msg [1707930953.585248][1223:1223] CHIP:SVR: Joining Multicast groups [1707930953.585317][1223:1223] CHIP:ZCL: Emitting StartUp event [1707930953.585467][1223:1223] CHIP:EVL: LogEvent event number: 0x0000000000000002 priority: 2, endpoint id: 0x0 cluster id: 0x0000_0028 event id: 0x0 Epoch timestamp: 0x0000018DA89E2771 [1707930953.585553][1223:1223] CHIP:SVR: Server initialization complete [1707930953.585628][1223:1223] CHIP:SVR: Server Listening... [1707930953.585677][1223:1223] CHIP:DL: Device Configuration: [1707930953.585782][1223:1223] CHIP:DL: Serial Number: TEST_SN [1707930953.585886][1223:1223] CHIP:DL: Vendor Id: 65521 (0xFFF1) [1707930953.585968][1223:1223] CHIP:DL: Product Id: 32769 (0x8001) [1707930953.586020][1223:1223] CHIP:DL: Product Name: TEST_PRODUCT [1707930953.586088][1223:1223] CHIP:DL: Hardware Version: 0 [1707930953.586139][1223:1223] CHIP:DL: Setup Pin Code (0 for UNKNOWN/ERROR): 20202021 [1707930953.586186][1223:1223] CHIP:DL: Setup Discriminator (0xFFFF for UNKNOWN/ERROR): 3840 (0xF00) [1707930953.586254][1223:1223] CHIP:DL: Manufacturing Date: (not set) [1707930953.586304][1223:1223] CHIP:DL: Device Type: 65535 (0xFFFF) [1707930953.586382][1223:1223] CHIP:SVR: SetupQRCode: [MT:-24J042C00KA0648G00] [1707930953.586441][1223:1223] CHIP:SVR: Copy/paste the below URL in a browser to see the QR Code: [1707930953.586488][1223:1223] CHIP:SVR: https://project-chip.github.io/connectedhomeip/qrcode.html?data=MT%3A-24J042C00KA0648G00 [1707930953.586555][1223:1223] CHIP:SVR: Manual pairing code: [34970112332] [1707930953.586633][1223:1223] CHIP:DMG: Endpoint 0, Cluster 0x0000_001D update version to 7d00babc [1707930953.587515][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_005D update version to 951c574f [1707930953.587634][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_005D update version to 951c5750 [1707930953.587723][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_005D update version to 951c5751 [1707930953.587798][1223:1223] CHIP:DMG: Endpoint 1, Cluster 0x0000_005D update version to 951c5752 [1707930953.587940][1223:1223] CHIP:EVL: LogEvent event number: 0x0000000000000003 priority: 1, endpoint id: 0x1 cluster id: 0x0000_005D event id: 0x0 Epoch timestamp: 0x0000018DA89E2773 [1707930953.589389][1223:1224] CHIP:DL: CREATE service object at /chipoble/04c7/service [1707930953.590807][1223:1224] CHIP:DL: Create characteristic object at /chipoble/04c7/service/c1 [1707930953.591567][1223:1224] CHIP:DL: Create characteristic object at /chipoble/04c7/service/c2 [1707930953.591939][1223:1224] CHIP:DL: CHIP BTP C1 /chipoble/04c7/service [1707930953.592005][1223:1224] CHIP:DL: CHIP BTP C2 /chipoble/04c7/service [1707930953.592053][1223:1224] CHIP:DL: CHIP_ENABLE_ADDITIONAL_DATA_ADVERTISING is FALSE [1707930953.609883][1223:1223] CHIP:DL: BlueZ integration init success [1707930953.610702][1223:1223] CHIP:DL: wpa_supplicant: disabling auto scan [1707930953.615199][1223:1223] CHIP:SVR: Cannot load binding table: src/platform/Linux/KeyValueStoreManagerImpl.cpp:53: CHIP Error 0x000000A0: Value not found in the persisted storage [1707930953.615376][1223:1223] CHIP:DL: HandlePlatformSpecificBLEEvent 32785 [1707930953.615543][1223:1223] CHIP:DIS: Updating services using commissioning mode 1 [1707930953.619731][1223:1223] CHIP:DIS: CHIP minimal mDNS started advertising. [1707930953.624752][1223:1224] CHIP:DL: BluezPeripheralRegisterAppDone done [1707930953.631996][1223:1223] CHIP:DL: Using wifi MAC for hostname [1707930953.632245][1223:1223] CHIP:DIS: Advertise commission parameter vendorID=65521 productID=32769 discriminator=3840/15 cm=1 cp=0 [1707930953.632357][1223:1223] CHIP:DIS: Responding with _matterc._udp.local [1707930953.632417][1223:1223] CHIP:DIS: Responding with 2AE6EA690898C6A5._matterc._udp.local [1707930953.632470][1223:1223] CHIP:DIS: Responding with E45F014342150000.local [1707930953.632522][1223:1223] CHIP:DIS: Responding with E45F014342150000.local [1707930953.632582][1223:1223] CHIP:DIS: Responding with _V65521._sub._matterc._udp.local [1707930953.632643][1223:1223] CHIP:DIS: Responding with _T65535._sub._matterc._udp.local [1707930953.632702][1223:1223] CHIP:DIS: Responding with _S15._sub._matterc._udp.local [1707930953.632761][1223:1223] CHIP:DIS: Responding with _L3840._sub._matterc._udp.local [1707930953.632819][1223:1223] CHIP:DIS: Responding with _CM._sub._matterc._udp.local [1707930953.632896][1223:1223] CHIP:DIS: Responding with 2AE6EA690898C6A5._matterc._udp.local [1707930953.633063][1223:1223] CHIP:DIS: CHIP minimal mDNS configured as 'Commissionable node device'; instance name: 2AE6EA690898C6A5. [1707930953.638275][1223:1223] CHIP:DIS: mDNS service published: _matterc._udp [1707930953.638398][1223:1223] CHIP:DL: HandlePlatformSpecificBLEEvent 32789 [1707930953.640354][1223:1223] CHIP:IM: No subscriptions to resume [1707930953.640460][1223:1223] CHIP:DMG: Endpoint 0, Cluster 0x0000_0038 update version to 4c7d3f77 [1707930953.640536][1223:1223] CHIP:DL: HandlePlatformSpecificBLEEvent 16392 [1707930953.640799][1223:1224] CHIP:DL: Create BLE adv object at /chipoble/04c7/advertising [1707930953.642860][1223:1223] CHIP:DL: SET service data to {'0xFFF6': <[byte 0x00, 0x00, 0x0f, 0xf1, 0xff, 0x01, 0x80, 0x00]>} [1707930953.662697][1223:1224] CHIP:DL: RegisterAdvertisement complete [1707930953.662993][1223:1223] CHIP:DL: HandlePlatformSpecificBLEEvent 16393 [1707930963.920687][1223:1224] CHIP:DL: BLE device connected: conn 0xffff84050a50, device E4:5F:01:30:E6:82, path /org/bluez/hci0/dev_E4_5F_01_30_E6_82 [1707930965.827568][1223:1224] CHIP:DL: BluezCharacteristicAcquireWrite is called, conn: 0xffff84050a50 [1707930965.829895][1223:1224] CHIP:DL: C1 WriteHandlerCallback MTU: 517 [1707930965.830154][1223:1224] CHIP:BLE: Write request received debug 0xffff84050a50 [1707930965.830489][1223:1223] CHIP:BLE: local and remote recv window sizes = 6 [1707930965.830563][1223:1223] CHIP:BLE: selected BTP version 4 [1707930965.830608][1223:1223] CHIP:BLE: using BTP fragment sizes rx 244 / tx 244. [1707930966.022946][1223:1224] CHIP:DL: CHIPoBLE subscribe received [1707930966.024131][1223:1223] CHIP:IN: BLE EndPoint 0xaaaae7283220 Connection Complete [1707930966.024262][1223:1223] CHIP:DL: HandlePlatformSpecificBLEEvent 32774 [1707930966.024324][1223:1223] CHIP:DL: Receive kCHIPoBLEConnectionEstablished [1707930966.168524][1223:1224] CHIP:BLE: Indication confirmation, 0xffff84050a50 [1707930966.169306][1223:1224] CHIP:DL: C1 WriteHandlerCallback MTU: 517 [1707930966.170070][1223:1224] CHIP:BLE: Write request received debug 0xffff84050a50 [1707930966.170474][1223:1223] CHIP:EM: >>> [E:41785r S:0 M:210906348] (U) Msg RX from 0:ED31F58593D30AD9 [0000] --- Type 0000:20 (SecureChannel:PBKDFParamRequest) [1707930966.170583][1223:1223] CHIP:EM: Handling via exchange: 41785r, Delegate: 0xaaaae7281d38 [1707930966.170659][1223:1223] CHIP:SC: Received PBKDF param request [1707930966.170749][1223:1223] CHIP:SC: Peer assigned session ID 7071 [1707930966.170814][1223:1223] CHIP:SC: Found MRP parameters in the message [1707930966.171345][1223:1223] CHIP:EM: <<< [E:41785r S:0 M:170926395] (U) Msg TX to 0:0000000000000000 [0000] [BLE] --- Type 0000:21 (SecureChannel:PBKDFParamResponse) [1707930966.171721][1223:1223] CHIP:SC: Sent PBKDF param response [1707930966.171779][1223:1223] CHIP:SVR: Commissioning session establishment step started [1707930966.509184][1223:1224] CHIP:BLE: Indication confirmation, 0xffff84050a50 [1707930966.509900][1223:1224] CHIP:DL: C1 WriteHandlerCallback MTU: 517 [1707930966.510907][1223:1224] CHIP:BLE: Write request received debug 0xffff84050a50 [1707930966.511348][1223:1223] CHIP:EM: >>> [E:41785r S:0 M:210906349] (U) Msg RX from 0:ED31F58593D30AD9 [0000] --- Type 0000:22 (SecureChannel:PASE_Pake1) [1707930966.511466][1223:1223] CHIP:EM: Found matching exchange: 41785r, Delegate: 0xaaaae7281d38 [1707930966.511565][1223:1223] CHIP:SC: Received spake2p msg1 [1707930966.516834][1223:1223] CHIP:EM: <<< [E:41785r S:0 M:170926396] (U) Msg TX to 0:0000000000000000 [0000] [BLE] --- Type 0000:23 (SecureChannel:PASE_Pake2) [1707930966.517518][1223:1223] CHIP:SC: Sent spake2p msg2 [1707930966.655472][1223:1224] CHIP:BLE: Indication confirmation, 0xffff84050a50 [1707930966.655910][1223:1224] CHIP:DL: C1 WriteHandlerCallback MTU: 517 [1707930966.656779][1223:1224] CHIP:BLE: Write request received debug 0xffff84050a50 [1707930966.657164][1223:1223] CHIP:EM: >>> [E:41785r S:0 M:210906350] (U) Msg RX from 0:ED31F58593D30AD9 [0000] --- Type 0000:24 (SecureChannel:PASE_Pake3) [1707930966.657245][1223:1223] CHIP:EM: Found matching exchange: 41785r, Delegate: 0xaaaae7281d38 [1707930966.657339][1223:1223] CHIP:SC: Received spake2p msg3 [1707930966.657556][1223:1223] CHIP:SC: Sending status report. Protocol code 0, exchange 41785 [1707930966.657677][1223:1223] CHIP:EM: <<< [E:41785r S:0 M:170926397] (U) Msg TX to 0:0000000000000000 [0000] [BLE] --- Type 0000:40 (SecureChannel:StatusReport) [1707930966.658624][1223:1223] CHIP:SC: SecureSession[0xaaaaf44473c0, LSID:1291]: State change 'kEstablishing' --> 'kActive' [1707930966.658732][1223:1223] CHIP:IN: SecureSession[0xaaaaf44473c0]: Activated - Type:1 LSID:1291 [1707930966.658788][1223:1223] CHIP:IN: New secure session activated for device , LSID:1291 PSID:7071! [1707930966.658873][1223:1223] CHIP:SVR: Commissioning completed session establishment step [1707930966.658986][1223:1223] CHIP:DIS: Updating services using commissioning mode 0 [1707930966.662563][1223:1223] CHIP:DIS: CHIP minimal mDNS started advertising. [1707930966.669765][1223:1223] CHIP:SVR: Device completed Rendezvous process [1707930966.671977][1223:1224] CHIP:DL: UnregisterAdvertisement complete [1707930966.672159][1223:1223] CHIP:DL: HandlePlatformSpecificBLEEvent 16394 [1707930966.672200][1223:1223] CHIP:DL: CHIPoBLE advertising stopped [1707930967.289448][1223:1224] CHIP:BLE: Indication confirmation, 0xffff84050a50 [1707930967.290665][1223:1224] CHIP:DL: C1 WriteHandlerCallback MTU: 517 [1707930967.291796][1223:1224] CHIP:BLE: Write request received debug 0xffff84050a50 [1707930967.292344][1223:1223] CHIP:EM: >>> [E:41786r S:1291 M:176619639] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest) [1707930967.292466][1223:1223] CHIP:EM: Handling via exchange: 41786r, Delegate: 0xaaaae727a8a8 [1707930967.292538][1223:1223] CHIP:IM: Received Read request [1707930967.292671][1223:1223] CHIP:DMG: ReadRequestMessage = [1707930967.292731][1223:1223] CHIP:DMG: { [1707930967.292781][1223:1223] CHIP:DMG: AttributePathIBs = [1707930967.292841][1223:1223] CHIP:DMG: [ [1707930967.292898][1223:1223] CHIP:DMG: AttributePathIB = [1707930967.292964][1223:1223] CHIP:DMG: { [1707930967.293030][1223:1223] CHIP:DMG: Cluster = 0x31, [1707930967.293113][1223:1223] CHIP:DMG: Attribute = 0x0000_FFFC, [1707930967.293187][1223:1223] CHIP:DMG: } [1707930967.293257][1223:1223] CHIP:DMG: [1707930967.293318][1223:1223] CHIP:DMG: AttributePathIB = [1707930967.293382][1223:1223] CHIP:DMG: { [1707930967.293442][1223:1223] CHIP:DMG: Endpoint = 0x0, [1707930967.293505][1223:1223] CHIP:DMG: Cluster = 0x30, [1707930967.293573][1223:1223] CHIP:DMG: Attribute = 0x0000_0000, [1707930967.293635][1223:1223] CHIP:DMG: } [1707930967.293703][1223:1223] CHIP:DMG: [1707930967.293764][1223:1223] CHIP:DMG: AttributePathIB = [1707930967.293828][1223:1223] CHIP:DMG: { [1707930967.293892][1223:1223] CHIP:DMG: Endpoint = 0x0, [1707930967.293960][1223:1223] CHIP:DMG: Cluster = 0x30, [1707930967.294030][1223:1223] CHIP:DMG: Attribute = 0x0000_0001, [1707930967.294092][1223:1223] CHIP:DMG: } [1707930967.294160][1223:1223] CHIP:DMG: [1707930967.294221][1223:1223] CHIP:DMG: AttributePathIB = [1707930967.294282][1223:1223] CHIP:DMG: { [1707930967.294347][1223:1223] CHIP:DMG: Endpoint = 0x0, [1707930967.294416][1223:1223] CHIP:DMG: Cluster = 0x30, [1707930967.294485][1223:1223] CHIP:DMG: Attribute = 0x0000_0002, [1707930967.294547][1223:1223] CHIP:DMG: } [1707930967.294616][1223:1223] CHIP:DMG: [1707930967.294677][1223:1223] CHIP:DMG: AttributePathIB = [1707930967.294737][1223:1223] CHIP:DMG: { [1707930967.294802][1223:1223] CHIP:DMG: Endpoint = 0x0, [1707930967.294870][1223:1223] CHIP:DMG: Cluster = 0x30, [1707930967.294939][1223:1223] CHIP:DMG: Attribute = 0x0000_0003, [1707930967.295001][1223:1223] CHIP:DMG: } [1707930967.295068][1223:1223] CHIP:DMG: [1707930967.295127][1223:1223] CHIP:DMG: AttributePathIB = [1707930967.295189][1223:1223] CHIP:DMG: { [1707930967.295252][1223:1223] CHIP:DMG: Endpoint = 0x0, [1707930967.295416][1223:1223] CHIP:DMG: Cluster = 0x28, [1707930967.295491][1223:1223] CHIP:DMG: Attribute = 0x0000_0002, [1707930967.295554][1223:1223] CHIP:DMG: } [1707930967.295622][1223:1223] CHIP:DMG: [1707930967.295681][1223:1223] CHIP:DMG: AttributePathIB = [1707930967.295742][1223:1223] CHIP:DMG: { [1707930967.295804][1223:1223] CHIP:DMG: Endpoint = 0x0, [1707930967.295873][1223:1223] CHIP:DMG: Cluster = 0x28, [1707930967.295945][1223:1223] CHIP:DMG: Attribute = 0x0000_0004, [1707930967.296010][1223:1223] CHIP:DMG: } [1707930967.296075][1223:1223] CHIP:DMG: [1707930967.296134][1223:1223] CHIP:DMG: AttributePathIB = [1707930967.296195][1223:1223] CHIP:DMG: { [1707930967.296258][1223:1223] CHIP:DMG: Cluster = 0x31, [1707930967.296326][1223:1223] CHIP:DMG: Attribute = 0x0000_0003, [1707930967.296391][1223:1223] CHIP:DMG: } [1707930967.296458][1223:1223] CHIP:DMG: [1707930967.296518][1223:1223] CHIP:DMG: AttributePathIB = [1707930967.296578][1223:1223] CHIP:DMG: { [1707930967.296641][1223:1223] CHIP:DMG: Endpoint = 0x0, [1707930967.296705][1223:1223] CHIP:DMG: Cluster = 0x38, [1707930967.296767][1223:1223] CHIP:DMG: } [1707930967.296829][1223:1223] CHIP:DMG: [1707930967.296887][1223:1223] CHIP:DMG: ], [1707930967.296985][1223:1223] CHIP:DMG: [1707930967.297046][1223:1223] CHIP:DMG: isFabricFiltered = false, [1707930967.297104][1223:1223] CHIP:DMG: InteractionModelRevision = 11 [1707930967.297158][1223:1223] CHIP:DMG: }, [1707930967.297920][1223:1223] CHIP:DMG: IM RH moving to [CanStartReporting] [1707930967.298193][1223:1223] CHIP:DMG: Building Reports for ReadHandler with LastReportGeneration = 0x0000000000000000 DirtyGeneration = 0x0000000000000000 [1707930967.298276][1223:1223] CHIP:DMG: Cluster 38, Attribute 0 is dirty [1707930967.298327][1223:1223] CHIP:DMG: Reading attribute: Cluster=0x0000_0038 Endpoint=0 AttributeId=0x0000_0000 (expanded=1) [1707930967.298390][1223:1223] CHIP:DMG: AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_0038 e=0 p=v [1707930967.298446][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930967.298557][1223:1223] CHIP:DMG: Cluster 38, Attribute 1 is dirty [1707930967.298610][1223:1223] CHIP:DMG: Reading attribute: Cluster=0x0000_0038 Endpoint=0 AttributeId=0x0000_0001 (expanded=1) [1707930967.298665][1223:1223] CHIP:DMG: AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_0038 e=0 p=v [1707930967.298718][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930967.298795][1223:1223] CHIP:DMG: Cluster 38, Attribute 2 is dirty [1707930967.298847][1223:1223] CHIP:DMG: Reading attribute: Cluster=0x0000_0038 Endpoint=0 AttributeId=0x0000_0002 (expanded=1) [1707930967.298902][1223:1223] CHIP:DMG: AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_0038 e=0 p=v [1707930967.298954][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930967.299039][1223:1223] CHIP:DMG: Cluster 38, Attribute 3 is dirty [1707930967.299091][1223:1223] CHIP:DMG: Reading attribute: Cluster=0x0000_0038 Endpoint=0 AttributeId=0x0000_0003 (expanded=1) [1707930967.299145][1223:1223] CHIP:DMG: AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_0038 e=0 p=v [1707930967.299197][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930967.299271][1223:1223] CHIP:DMG: Cluster 38, Attribute 4 is dirty [1707930967.299354][1223:1223] CHIP:DMG: Reading attribute: Cluster=0x0000_0038 Endpoint=0 AttributeId=0x0000_0004 (expanded=1) [1707930967.299408][1223:1223] CHIP:DMG: AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_0038 e=0 p=v [1707930967.299460][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930967.299638][1223:1223] CHIP:DMG: Cluster 38, Attribute 5 is dirty [1707930967.299701][1223:1223] CHIP:DMG: Reading attribute: Cluster=0x0000_0038 Endpoint=0 AttributeId=0x0000_0005 (expanded=1) [1707930967.299757][1223:1223] CHIP:DMG: AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_0038 e=0 p=v [1707930967.299808][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930967.299907][1223:1223] CHIP:DMG: Cluster 38, Attribute 6 is dirty [1707930967.300035][1223:1223] CHIP:DMG: Reading attribute: Cluster=0x0000_0038 Endpoint=0 AttributeId=0x0000_0006 (expanded=1) [1707930967.300095][1223:1223] CHIP:DMG: AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_0038 e=0 p=v [1707930967.300147][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930967.300232][1223:1223] CHIP:DMG: Cluster 38, Attribute 7 is dirty [1707930967.300285][1223:1223] CHIP:DMG: Reading attribute: Cluster=0x0000_0038 Endpoint=0 AttributeId=0x0000_0007 (expanded=1) [1707930967.300339][1223:1223] CHIP:DMG: AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_0038 e=0 p=v [1707930967.300390][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930967.300466][1223:1223] CHIP:DMG: Cluster 38, Attribute 8 is dirty [1707930967.300518][1223:1223] CHIP:DMG: Reading attribute: Cluster=0x0000_0038 Endpoint=0 AttributeId=0x0000_0008 (expanded=1) [1707930967.300568][1223:1223] CHIP:DMG: AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_0038 e=0 p=v [1707930967.300634][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930967.300716][1223:1223] CHIP:DMG: Cluster 38, Attribute a is dirty [1707930967.300769][1223:1223] CHIP:DMG: Reading attribute: Cluster=0x0000_0038 Endpoint=0 AttributeId=0x0000_000A (expanded=1) [1707930967.300823][1223:1223] CHIP:DMG: AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_0038 e=0 p=v [1707930967.300874][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930967.300948][1223:1223] CHIP:DMG: Cluster 38, Attribute b is dirty [1707930967.300999][1223:1223] CHIP:DMG: Reading attribute: Cluster=0x0000_0038 Endpoint=0 AttributeId=0x0000_000B (expanded=1) [1707930967.301054][1223:1223] CHIP:DMG: AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_0038 e=0 p=v [1707930967.301105][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930967.301177][1223:1223] CHIP:DMG: Cluster 38, Attribute c is dirty [1707930967.301228][1223:1223] CHIP:DMG: Reading attribute: Cluster=0x0000_0038 Endpoint=0 AttributeId=0x0000_000C (expanded=1) [1707930967.301283][1223:1223] CHIP:DMG: AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_0038 e=0 p=v [1707930967.301334][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930967.301412][1223:1223] CHIP:DMG: Cluster 38, Attribute fffc is dirty [1707930967.301464][1223:1223] CHIP:DMG: Reading attribute: Cluster=0x0000_0038 Endpoint=0 AttributeId=0x0000_FFFC (expanded=1) [1707930967.301518][1223:1223] CHIP:DMG: AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_0038 e=0 p=v [1707930967.301569][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930967.301648][1223:1223] CHIP:DMG: Cluster 38, Attribute fffd is dirty [1707930967.301700][1223:1223] CHIP:DMG: Reading attribute: Cluster=0x0000_0038 Endpoint=0 AttributeId=0x0000_FFFD (expanded=1) [1707930967.301754][1223:1223] CHIP:DMG: AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_0038 e=0 p=v [1707930967.301805][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930967.301882][1223:1223] CHIP:DMG: Cluster 38, Attribute fff8 is dirty [1707930967.301934][1223:1223] CHIP:DMG: Reading attribute: Cluster=0x0000_0038 Endpoint=0 AttributeId=0x0000_FFF8 (expanded=1) [1707930967.301986][1223:1223] CHIP:DMG: AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_0038 e=0 p=v [1707930967.302037][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930967.302118][1223:1223] CHIP:DMG: Cluster 38, Attribute fff9 is dirty [1707930967.302170][1223:1223] CHIP:DMG: Reading attribute: Cluster=0x0000_0038 Endpoint=0 AttributeId=0x0000_FFF9 (expanded=1) [1707930967.302222][1223:1223] CHIP:DMG: AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_0038 e=0 p=v [1707930967.302272][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930967.302350][1223:1223] CHIP:DMG: Cluster 38, Attribute fffb is dirty [1707930967.302402][1223:1223] CHIP:DMG: Reading attribute: Cluster=0x0000_0038 Endpoint=0 AttributeId=0x0000_FFFB (expanded=1) [1707930967.302454][1223:1223] CHIP:DMG: AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_0038 e=0 p=v [1707930967.302505][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930967.302605][1223:1223] CHIP:DMG: Cluster 31, Attribute 3 is dirty [1707930967.302659][1223:1223] CHIP:DMG: Reading attribute: Cluster=0x0000_0031 Endpoint=0 AttributeId=0x0000_0003 (expanded=1) [1707930967.302715][1223:1223] CHIP:DMG: AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_0031 e=0 p=v [1707930967.302766][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930967.302846][1223:1223] CHIP:DMG: Cluster 28, Attribute 4 is dirty [1707930967.302898][1223:1223] CHIP:DMG: Reading attribute: Cluster=0x0000_0028 Endpoint=0 AttributeId=0x0000_0004 (expanded=0) [1707930967.302954][1223:1223] CHIP:DMG: AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_0028 e=0 p=v [1707930967.303005][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930967.303187][1223:1223] CHIP:DMG: Cluster 28, Attribute 2 is dirty [1707930967.303247][1223:1223] CHIP:DMG: Reading attribute: Cluster=0x0000_0028 Endpoint=0 AttributeId=0x0000_0002 (expanded=0) [1707930967.303332][1223:1223] CHIP:DMG: AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_0028 e=0 p=v [1707930967.303386][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930967.303517][1223:1223] CHIP:DMG: Cluster 30, Attribute 3 is dirty [1707930967.303582][1223:1223] CHIP:DMG: Reading attribute: Cluster=0x0000_0030 Endpoint=0 AttributeId=0x0000_0003 (expanded=0) [1707930967.303642][1223:1223] CHIP:DMG: AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_0030 e=0 p=v [1707930967.303695][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930967.303833][1223:1223] CHIP:DMG: Cluster 30, Attribute 2 is dirty [1707930967.303894][1223:1223] CHIP:DMG: Reading attribute: Cluster=0x0000_0030 Endpoint=0 AttributeId=0x0000_0002 (expanded=0) [1707930967.303950][1223:1223] CHIP:DMG: AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_0030 e=0 p=v [1707930967.304002][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930967.304118][1223:1223] CHIP:DMG: Cluster 30, Attribute 1 is dirty [1707930967.304174][1223:1223] CHIP:DMG: Reading attribute: Cluster=0x0000_0030 Endpoint=0 AttributeId=0x0000_0001 (expanded=0) [1707930967.304230][1223:1223] CHIP:DMG: AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_0030 e=0 p=v [1707930967.304283][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930967.304365][1223:1223] CHIP:DMG: Cluster 30, Attribute 0 is dirty [1707930967.304417][1223:1223] CHIP:DMG: Reading attribute: Cluster=0x0000_0030 Endpoint=0 AttributeId=0x0000_0000 (expanded=0) [1707930967.304471][1223:1223] CHIP:DMG: AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_0030 e=0 p=v [1707930967.304522][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930967.304619][1223:1223] CHIP:DMG: Cluster 31, Attribute fffc is dirty [1707930967.304673][1223:1223] CHIP:DMG: Reading attribute: Cluster=0x0000_0031 Endpoint=0 AttributeId=0x0000_FFFC (expanded=1) [1707930967.304730][1223:1223] CHIP:DMG: AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_0031 e=0 p=v [1707930967.304782][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930967.304889][1223:1223] CHIP:DMG: Sending report (payload has 737 bytes)... [1707930967.305265][1223:1223] CHIP:EM: <<< [E:41786r S:1291 M:80036317] (S) Msg TX to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:05 (IM:ReportData) [1707930967.305940][1223:1223] CHIP:DMG: OnReportConfirm: NumReports = 0 [1707930967.306044][1223:1223] CHIP:DMG: ReportsInFlight = 0 with readHandler 0, RE has no more messages [1707930967.306102][1223:1223] CHIP:DMG: IM RH moving to [AwaitingDestruction] [1707930967.308170][1223:1223] CHIP:DMG: All ReadHandler-s are clean, clear GlobalDirtySet [1707930967.581904][1223:1224] CHIP:BLE: Indication confirmation, 0xffff84050a50 [1707930967.776813][1223:1224] CHIP:BLE: Indication confirmation, 0xffff84050a50 [1707930968.361175][1223:1224] CHIP:BLE: Indication confirmation, 0xffff84050a50 [1707930968.751197][1223:1224] CHIP:BLE: Indication confirmation, 0xffff84050a50 [1707930968.751739][1223:1224] CHIP:DL: C1 WriteHandlerCallback MTU: 517 [1707930968.752702][1223:1224] CHIP:BLE: Write request received debug 0xffff84050a50 [1707930968.753102][1223:1223] CHIP:EM: >>> [E:41787r S:1291 M:176619640] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest) [1707930968.753196][1223:1223] CHIP:EM: Handling via exchange: 41787r, Delegate: 0xaaaae727a8a8 [1707930968.753250][1223:1223] CHIP:IM: Received Read request [1707930968.753343][1223:1223] CHIP:DMG: ReadRequestMessage = [1707930968.753391][1223:1223] CHIP:DMG: { [1707930968.753433][1223:1223] CHIP:DMG: AttributePathIBs = [1707930968.753546][1223:1223] CHIP:DMG: [ [1707930968.753596][1223:1223] CHIP:DMG: AttributePathIB = [1707930968.753707][1223:1223] CHIP:DMG: { [1707930968.753765][1223:1223] CHIP:DMG: Endpoint = 0x0, [1707930968.753824][1223:1223] CHIP:DMG: Cluster = 0x30, [1707930968.753881][1223:1223] CHIP:DMG: Attribute = 0x0000_0004, [1707930968.754016][1223:1223] CHIP:DMG: } [1707930968.754080][1223:1223] CHIP:DMG: [1707930968.754138][1223:1223] CHIP:DMG: AttributePathIB = [1707930968.754189][1223:1223] CHIP:DMG: { [1707930968.754239][1223:1223] CHIP:DMG: Endpoint = 0x0, [1707930968.754292][1223:1223] CHIP:DMG: Cluster = 0x46, [1707930968.754345][1223:1223] CHIP:DMG: Attribute = 0x0000_FFFC, [1707930968.754393][1223:1223] CHIP:DMG: } [1707930968.754445][1223:1223] CHIP:DMG: [1707930968.754491][1223:1223] CHIP:DMG: AttributePathIB = [1707930968.754538][1223:1223] CHIP:DMG: { [1707930968.754588][1223:1223] CHIP:DMG: Endpoint = 0x0, [1707930968.754652][1223:1223] CHIP:DMG: Cluster = 0x46, [1707930968.754721][1223:1223] CHIP:DMG: Attribute = 0x0000_0006, [1707930968.754785][1223:1223] CHIP:DMG: } [1707930968.754843][1223:1223] CHIP:DMG: [1707930968.754894][1223:1223] CHIP:DMG: AttributePathIB = [1707930968.754946][1223:1223] CHIP:DMG: { [1707930968.754999][1223:1223] CHIP:DMG: Endpoint = 0x0, [1707930968.755066][1223:1223] CHIP:DMG: Cluster = 0x46, [1707930968.755132][1223:1223] CHIP:DMG: Attribute = 0x0000_0007, [1707930968.755192][1223:1223] CHIP:DMG: } [1707930968.755249][1223:1223] CHIP:DMG: [1707930968.755344][1223:1223] CHIP:DMG: ], [1707930968.755417][1223:1223] CHIP:DMG: [1707930968.755468][1223:1223] CHIP:DMG: isFabricFiltered = false, [1707930968.755517][1223:1223] CHIP:DMG: InteractionModelRevision = 11 [1707930968.755562][1223:1223] CHIP:DMG: }, [1707930968.755948][1223:1223] CHIP:DMG: IM RH moving to [CanStartReporting] [1707930968.756157][1223:1223] CHIP:DMG: Building Reports for ReadHandler with LastReportGeneration = 0x0000000000000000 DirtyGeneration = 0x0000000000000000 [1707930968.756218][1223:1223] CHIP:DMG: Cluster 46, Attribute 7 is dirty [1707930968.756260][1223:1223] CHIP:DMG: Reading attribute: Cluster=0x0000_0046 Endpoint=0 AttributeId=0x0000_0007 (expanded=0) [1707930968.756338][1223:1223] CHIP:DMG: Cluster 46, Attribute 6 is dirty [1707930968.756383][1223:1223] CHIP:DMG: Reading attribute: Cluster=0x0000_0046 Endpoint=0 AttributeId=0x0000_0006 (expanded=0) [1707930968.756444][1223:1223] CHIP:DMG: Cluster 46, Attribute fffc is dirty [1707930968.756487][1223:1223] CHIP:DMG: Reading attribute: Cluster=0x0000_0046 Endpoint=0 AttributeId=0x0000_FFFC (expanded=0) [1707930968.756549][1223:1223] CHIP:DMG: Cluster 30, Attribute 4 is dirty [1707930968.756592][1223:1223] CHIP:DMG: Reading attribute: Cluster=0x0000_0030 Endpoint=0 AttributeId=0x0000_0004 (expanded=0) [1707930968.756640][1223:1223] CHIP:DMG: AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_0030 e=0 p=v [1707930968.756686][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930968.756780][1223:1223] CHIP:DMG: Sending report (payload has 105 bytes)... [1707930968.756966][1223:1223] CHIP:EM: <<< [E:41787r S:1291 M:80036318] (S) Msg TX to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:05 (IM:ReportData) [1707930968.757479][1223:1223] CHIP:DMG: OnReportConfirm: NumReports = 0 [1707930968.757535][1223:1223] CHIP:DMG: ReportsInFlight = 0 with readHandler 0, RE has no more messages [1707930968.757578][1223:1223] CHIP:DMG: IM RH moving to [AwaitingDestruction] [1707930968.759074][1223:1223] CHIP:DMG: All ReadHandler-s are clean, clear GlobalDirtySet [1707930968.897942][1223:1224] CHIP:BLE: Indication confirmation, 0xffff84050a50 [1707930968.898445][1223:1224] CHIP:DL: C1 WriteHandlerCallback MTU: 517 [1707930968.899343][1223:1224] CHIP:BLE: Write request received debug 0xffff84050a50 [1707930968.899811][1223:1223] CHIP:EM: >>> [E:41788r S:1291 M:176619641] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest) [1707930968.899914][1223:1223] CHIP:EM: Handling via exchange: 41788r, Delegate: 0xaaaae727a8a8 [1707930968.900044][1223:1223] CHIP:DMG: InvokeRequestMessage = [1707930968.900100][1223:1223] CHIP:DMG: { [1707930968.900150][1223:1223] CHIP:DMG: suppressResponse = false, [1707930968.900211][1223:1223] CHIP:DMG: timedRequest = false, [1707930968.900267][1223:1223] CHIP:DMG: InvokeRequests = [1707930968.900338][1223:1223] CHIP:DMG: [ [1707930968.900394][1223:1223] CHIP:DMG: CommandDataIB = [1707930968.900456][1223:1223] CHIP:DMG: { [1707930968.900530][1223:1223] CHIP:DMG: CommandPathIB = [1707930968.900594][1223:1223] CHIP:DMG: { [1707930968.900657][1223:1223] CHIP:DMG: EndpointId = 0x0, [1707930968.900723][1223:1223] CHIP:DMG: ClusterId = 0x30, [1707930968.900789][1223:1223] CHIP:DMG: CommandId = 0x0, [1707930968.900865][1223:1223] CHIP:DMG: }, [1707930968.900939][1223:1223] CHIP:DMG: [1707930968.901001][1223:1223] CHIP:DMG: CommandFields = [1707930968.901068][1223:1223] CHIP:DMG: { [1707930968.901209][1223:1223] CHIP:DMG: 0x0 = 60, [1707930968.901294][1223:1223] CHIP:DMG: 0x1 = 4, [1707930968.901373][1223:1223] CHIP:DMG: }, [1707930968.901436][1223:1223] CHIP:DMG: }, [1707930968.901506][1223:1223] CHIP:DMG: [1707930968.901560][1223:1223] CHIP:DMG: ], [1707930968.901631][1223:1223] CHIP:DMG: [1707930968.901686][1223:1223] CHIP:DMG: InteractionModelRevision = 11 [1707930968.901739][1223:1223] CHIP:DMG: }, [1707930968.902002][1223:1223] CHIP:DMG: AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_0030 e=0 p=a [1707930968.902066][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930968.902126][1223:1223] CHIP:DMG: Received command for Endpoint=0 Cluster=0x0000_0030 Command=0x0000_0000 [1707930968.902206][1223:1223] CHIP:FS: GeneralCommissioning: Received ArmFailSafe (60s) [1707930968.902324][1223:1223] CHIP:DMG: Endpoint 0, Cluster 0x0000_0030 update version to e0c6e475 [1707930968.902422][1223:1223] CHIP:DMG: Command handler moving to [NewRespons] [1707930968.902479][1223:1223] CHIP:DMG: Command handler moving to [ Preparing] [1707930968.902542][1223:1223] CHIP:DMG: Command handler moving to [AddingComm] [1707930968.902608][1223:1223] CHIP:DMG: Command handler moving to [AddedComma] [1707930968.902703][1223:1223] CHIP:DMG: Decreasing reference count for CommandHandler, remaining 0 [1707930968.902910][1223:1223] CHIP:EM: <<< [E:41788r S:1291 M:80036319] (S) Msg TX to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:09 (IM:InvokeCommandResponse) [1707930968.903428][1223:1223] CHIP:DMG: Command response sender moving to [AllInvokeR] [1707930968.903497][1223:1223] CHIP:DMG: Command handler moving to [AwaitingDe] [1707930969.093053][1223:1224] CHIP:BLE: Indication confirmation, 0xffff84050a50 [1707930969.093453][1223:1224] CHIP:DL: C1 WriteHandlerCallback MTU: 517 [1707930969.094250][1223:1224] CHIP:BLE: Write request received debug 0xffff84050a50 [1707930969.095023][1223:1223] CHIP:EM: >>> [E:41789r S:1291 M:176619642] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest) [1707930969.095130][1223:1223] CHIP:EM: Handling via exchange: 41789r, Delegate: 0xaaaae727a8a8 [1707930969.095262][1223:1223] CHIP:DMG: InvokeRequestMessage = [1707930969.095384][1223:1223] CHIP:DMG: { [1707930969.095436][1223:1223] CHIP:DMG: suppressResponse = false, [1707930969.095500][1223:1223] CHIP:DMG: timedRequest = false, [1707930969.095558][1223:1223] CHIP:DMG: InvokeRequests = [1707930969.095630][1223:1223] CHIP:DMG: [ [1707930969.095683][1223:1223] CHIP:DMG: CommandDataIB = [1707930969.095741][1223:1223] CHIP:DMG: { [1707930969.095796][1223:1223] CHIP:DMG: CommandPathIB = [1707930969.095858][1223:1223] CHIP:DMG: { [1707930969.095923][1223:1223] CHIP:DMG: EndpointId = 0x0, [1707930969.095990][1223:1223] CHIP:DMG: ClusterId = 0x30, [1707930969.096055][1223:1223] CHIP:DMG: CommandId = 0x2, [1707930969.096128][1223:1223] CHIP:DMG: }, [1707930969.096202][1223:1223] CHIP:DMG: [1707930969.096265][1223:1223] CHIP:DMG: CommandFields = [1707930969.096331][1223:1223] CHIP:DMG: { [1707930969.096404][1223:1223] CHIP:DMG: 0x0 = 0, [1707930969.096555][1223:1223] CHIP:DMG: 0x1 = "XX" (2 chars), [1707930969.096644][1223:1223] CHIP:DMG: 0x2 = 5, [1707930969.096726][1223:1223] CHIP:DMG: }, [1707930969.096791][1223:1223] CHIP:DMG: }, [1707930969.096866][1223:1223] CHIP:DMG: [1707930969.096921][1223:1223] CHIP:DMG: ], [1707930969.096993][1223:1223] CHIP:DMG: [1707930969.097048][1223:1223] CHIP:DMG: InteractionModelRevision = 11 [1707930969.097103][1223:1223] CHIP:DMG: }, [1707930969.097379][1223:1223] CHIP:DMG: AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_0030 e=0 p=a [1707930969.097443][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930969.097504][1223:1223] CHIP:DMG: Received command for Endpoint=0 Cluster=0x0000_0030 Command=0x0000_0002 [1707930969.098046][1223:1223] CHIP:DL: writing settings to file (/tmp/chip_config.ini-V2QCt4) [1707930969.099201][1223:1223] CHIP:DL: renamed tmp file to file (/tmp/chip_config.ini) [1707930969.099406][1223:1223] CHIP:DL: NVS set: chip-config/regulatory-location = 0 (0x0) [1707930969.099688][1223:1223] CHIP:DL: writing settings to file (/tmp/chip_config.ini-J7B86t) [1707930969.100654][1223:1223] CHIP:DL: renamed tmp file to file (/tmp/chip_config.ini) [1707930969.100771][1223:1223] CHIP:DL: NVS set: chip-config/country-code = "XX" [1707930969.100851][1223:1223] CHIP:DMG: Endpoint 0, Cluster 0x0000_0030 update version to e0c6e476 [1707930969.100948][1223:1223] CHIP:DMG: Command handler moving to [NewRespons] [1707930969.101007][1223:1223] CHIP:DMG: Command handler moving to [ Preparing] [1707930969.101070][1223:1223] CHIP:DMG: Command handler moving to [AddingComm] [1707930969.101139][1223:1223] CHIP:DMG: Command handler moving to [AddedComma] [1707930969.101256][1223:1223] CHIP:DMG: Decreasing reference count for CommandHandler, remaining 0 [1707930969.101491][1223:1223] CHIP:EM: <<< [E:41789r S:1291 M:80036320] (S) Msg TX to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:09 (IM:InvokeCommandResponse) [1707930969.102031][1223:1223] CHIP:DMG: Command response sender moving to [AllInvokeR] [1707930969.102097][1223:1223] CHIP:DMG: Command handler moving to [AwaitingDe] [1707930969.239885][1223:1224] CHIP:BLE: Indication confirmation, 0xffff84050a50 [1707930969.240303][1223:1224] CHIP:DL: C1 WriteHandlerCallback MTU: 517 [1707930969.241140][1223:1224] CHIP:BLE: Write request received debug 0xffff84050a50 [1707930969.241917][1223:1223] CHIP:EM: >>> [E:41790r S:1291 M:176619643] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest) [1707930969.242025][1223:1223] CHIP:EM: Handling via exchange: 41790r, Delegate: 0xaaaae727a8a8 [1707930969.242155][1223:1223] CHIP:DMG: InvokeRequestMessage = [1707930969.242215][1223:1223] CHIP:DMG: { [1707930969.242267][1223:1223] CHIP:DMG: suppressResponse = false, [1707930969.242328][1223:1223] CHIP:DMG: timedRequest = false, [1707930969.242422][1223:1223] CHIP:DMG: InvokeRequests = [1707930969.242535][1223:1223] CHIP:DMG: [ [1707930969.242598][1223:1223] CHIP:DMG: CommandDataIB = [1707930969.242694][1223:1223] CHIP:DMG: { [1707930969.242754][1223:1223] CHIP:DMG: CommandPathIB = [1707930969.242816][1223:1223] CHIP:DMG: { [1707930969.242879][1223:1223] CHIP:DMG: EndpointId = 0x0, [1707930969.242946][1223:1223] CHIP:DMG: ClusterId = 0x38, [1707930969.243012][1223:1223] CHIP:DMG: CommandId = 0x0, [1707930969.243073][1223:1223] CHIP:DMG: }, [1707930969.243139][1223:1223] CHIP:DMG: [1707930969.243197][1223:1223] CHIP:DMG: CommandFields = [1707930969.243272][1223:1223] CHIP:DMG: { [1707930969.243386][1223:1223] CHIP:DMG: 0x0 = 761246169195259, [1707930969.243472][1223:1223] CHIP:DMG: 0x1 = 2, [1707930969.243577][1223:1223] CHIP:DMG: }, [1707930969.243642][1223:1223] CHIP:DMG: }, [1707930969.243713][1223:1223] CHIP:DMG: [1707930969.243768][1223:1223] CHIP:DMG: ], [1707930969.243829][1223:1223] CHIP:DMG: [1707930969.243867][1223:1223] CHIP:DMG: InteractionModelRevision = 11 [1707930969.243910][1223:1223] CHIP:DMG: }, [1707930969.244103][1223:1223] CHIP:DMG: AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_0038 e=0 p=a [1707930969.244148][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930969.244190][1223:1223] CHIP:DMG: Received command for Endpoint=0 Cluster=0x0000_0038 Command=0x0000_0000 [1707930969.244296][1223:1223] CHIP:DMG: Command handler moving to [NewRespons] [1707930969.244337][1223:1223] CHIP:DMG: Command handler moving to [ Preparing] [1707930969.244381][1223:1223] CHIP:DMG: Command handler moving to [AddingComm] [1707930969.244423][1223:1223] CHIP:DMG: Command handler moving to [AddedComma] [1707930969.244487][1223:1223] CHIP:DMG: Decreasing reference count for CommandHandler, remaining 0 [1707930969.244650][1223:1223] CHIP:EM: <<< [E:41790r S:1291 M:80036321] (S) Msg TX to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:09 (IM:InvokeCommandResponse) [1707930969.245065][1223:1223] CHIP:DMG: Command response sender moving to [AllInvokeR] [1707930969.245112][1223:1223] CHIP:DMG: Command handler moving to [AwaitingDe] [1707930969.386102][1223:1224] CHIP:BLE: Indication confirmation, 0xffff84050a50 [1707930969.386547][1223:1224] CHIP:DL: C1 WriteHandlerCallback MTU: 517 [1707930969.387517][1223:1224] CHIP:BLE: Write request received debug 0xffff84050a50 [1707930969.388087][1223:1223] CHIP:EM: >>> [E:41791r S:1291 M:176619644] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest) [1707930969.388172][1223:1223] CHIP:EM: Handling via exchange: 41791r, Delegate: 0xaaaae727a8a8 [1707930969.388277][1223:1223] CHIP:DMG: InvokeRequestMessage = [1707930969.388324][1223:1223] CHIP:DMG: { [1707930969.388364][1223:1223] CHIP:DMG: suppressResponse = false, [1707930969.388411][1223:1223] CHIP:DMG: timedRequest = false, [1707930969.388456][1223:1223] CHIP:DMG: InvokeRequests = [1707930969.388511][1223:1223] CHIP:DMG: [ [1707930969.388555][1223:1223] CHIP:DMG: CommandDataIB = [1707930969.388602][1223:1223] CHIP:DMG: { [1707930969.388648][1223:1223] CHIP:DMG: CommandPathIB = [1707930969.388700][1223:1223] CHIP:DMG: { [1707930969.388752][1223:1223] CHIP:DMG: EndpointId = 0x0, [1707930969.388823][1223:1223] CHIP:DMG: ClusterId = 0x3e, [1707930969.388881][1223:1223] CHIP:DMG: CommandId = 0x2, [1707930969.388933][1223:1223] CHIP:DMG: }, [1707930969.388986][1223:1223] CHIP:DMG: [1707930969.389034][1223:1223] CHIP:DMG: CommandFields = [1707930969.389083][1223:1223] CHIP:DMG: { [1707930969.389135][1223:1223] CHIP:DMG: 0x0 = 2, [1707930969.389189][1223:1223] CHIP:DMG: }, [1707930969.389236][1223:1223] CHIP:DMG: }, [1707930969.389288][1223:1223] CHIP:DMG: [1707930969.389330][1223:1223] CHIP:DMG: ], [1707930969.389383][1223:1223] CHIP:DMG: [1707930969.389424][1223:1223] CHIP:DMG: InteractionModelRevision = 11 [1707930969.389465][1223:1223] CHIP:DMG: }, [1707930969.389665][1223:1223] CHIP:DMG: AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_003E e=0 p=a [1707930969.389719][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930969.389768][1223:1223] CHIP:DMG: Received command for Endpoint=0 Cluster=0x0000_003E Command=0x0000_0002 [1707930969.389833][1223:1223] CHIP:ZCL: OpCreds: Certificate Chain request received for PAI [1707930969.389906][1223:1223] CHIP:DMG: Command handler moving to [NewRespons] [1707930969.389949][1223:1223] CHIP:DMG: Command handler moving to [ Preparing] [1707930969.389998][1223:1223] CHIP:DMG: Command handler moving to [AddingComm] [1707930969.390048][1223:1223] CHIP:DMG: Command handler moving to [AddedComma] [1707930969.390121][1223:1223] CHIP:DMG: Decreasing reference count for CommandHandler, remaining 0 [1707930969.390332][1223:1223] CHIP:EM: <<< [E:41791r S:1291 M:80036322] (S) Msg TX to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:09 (IM:InvokeCommandResponse) [1707930969.390723][1223:1223] CHIP:DMG: Command response sender moving to [AllInvokeR] [1707930969.390772][1223:1223] CHIP:DMG: Command handler moving to [AwaitingDe] [1707930969.580517][1223:1224] CHIP:BLE: Indication confirmation, 0xffff84050a50 [1707930969.726707][1223:1224] CHIP:BLE: Indication confirmation, 0xffff84050a50 [1707930969.824210][1223:1224] CHIP:BLE: Indication confirmation, 0xffff84050a50 [1707930969.824689][1223:1224] CHIP:DL: C1 WriteHandlerCallback MTU: 517 [1707930969.825441][1223:1224] CHIP:BLE: Write request received debug 0xffff84050a50 [1707930969.825912][1223:1223] CHIP:EM: >>> [E:41792r S:1291 M:176619645] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest) [1707930969.826018][1223:1223] CHIP:EM: Handling via exchange: 41792r, Delegate: 0xaaaae727a8a8 [1707930969.826145][1223:1223] CHIP:DMG: InvokeRequestMessage = [1707930969.826201][1223:1223] CHIP:DMG: { [1707930969.826252][1223:1223] CHIP:DMG: suppressResponse = false, [1707930969.826313][1223:1223] CHIP:DMG: timedRequest = false, [1707930969.826369][1223:1223] CHIP:DMG: InvokeRequests = [1707930969.826439][1223:1223] CHIP:DMG: [ [1707930969.826570][1223:1223] CHIP:DMG: CommandDataIB = [1707930969.826641][1223:1223] CHIP:DMG: { [1707930969.826701][1223:1223] CHIP:DMG: CommandPathIB = [1707930969.826768][1223:1223] CHIP:DMG: { [1707930969.826837][1223:1223] CHIP:DMG: EndpointId = 0x0, [1707930969.826923][1223:1223] CHIP:DMG: ClusterId = 0x3e, [1707930969.827051][1223:1223] CHIP:DMG: CommandId = 0x2, [1707930969.827174][1223:1223] CHIP:DMG: }, [1707930969.827254][1223:1223] CHIP:DMG: [1707930969.827533][1223:1223] CHIP:DMG: CommandFields = [1707930969.827694][1223:1223] CHIP:DMG: { [1707930969.827768][1223:1223] CHIP:DMG: 0x0 = 1, [1707930969.827838][1223:1223] CHIP:DMG: }, [1707930969.827899][1223:1223] CHIP:DMG: }, [1707930969.827969][1223:1223] CHIP:DMG: [1707930969.828024][1223:1223] CHIP:DMG: ], [1707930969.828094][1223:1223] CHIP:DMG: [1707930969.828148][1223:1223] CHIP:DMG: InteractionModelRevision = 11 [1707930969.828202][1223:1223] CHIP:DMG: }, [1707930969.828458][1223:1223] CHIP:DMG: AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_003E e=0 p=a [1707930969.828519][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930969.828578][1223:1223] CHIP:DMG: Received command for Endpoint=0 Cluster=0x0000_003E Command=0x0000_0002 [1707930969.828659][1223:1223] CHIP:ZCL: OpCreds: Certificate Chain request received for DAC [1707930969.828753][1223:1223] CHIP:DMG: Command handler moving to [NewRespons] [1707930969.828809][1223:1223] CHIP:DMG: Command handler moving to [ Preparing] [1707930969.828871][1223:1223] CHIP:DMG: Command handler moving to [AddingComm] [1707930969.828937][1223:1223] CHIP:DMG: Command handler moving to [AddedComma] [1707930969.829028][1223:1223] CHIP:DMG: Decreasing reference count for CommandHandler, remaining 0 [1707930969.829294][1223:1223] CHIP:EM: <<< [E:41792r S:1291 M:80036323] (S) Msg TX to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:09 (IM:InvokeCommandResponse) [1707930969.829812][1223:1223] CHIP:DMG: Command response sender moving to [AllInvokeR] [1707930969.829883][1223:1223] CHIP:DMG: Command handler moving to [AwaitingDe] [1707930970.068029][1223:1224] CHIP:BLE: Indication confirmation, 0xffff84050a50 [1707930970.165472][1223:1224] CHIP:BLE: Indication confirmation, 0xffff84050a50 [1707930970.311825][1223:1224] CHIP:BLE: Indication confirmation, 0xffff84050a50 [1707930970.409031][1223:1224] CHIP:DL: C1 WriteHandlerCallback MTU: 517 [1707930970.409958][1223:1224] CHIP:BLE: Write request received debug 0xffff84050a50 [1707930970.410420][1223:1223] CHIP:EM: >>> [E:41793r S:1291 M:176619646] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest) [1707930970.410530][1223:1223] CHIP:EM: Handling via exchange: 41793r, Delegate: 0xaaaae727a8a8 [1707930970.410660][1223:1223] CHIP:DMG: InvokeRequestMessage = [1707930970.410718][1223:1223] CHIP:DMG: { [1707930970.410769][1223:1223] CHIP:DMG: suppressResponse = false, [1707930970.410830][1223:1223] CHIP:DMG: timedRequest = false, [1707930970.410886][1223:1223] CHIP:DMG: InvokeRequests = [1707930970.410959][1223:1223] CHIP:DMG: [ [1707930970.411017][1223:1223] CHIP:DMG: CommandDataIB = [1707930970.411079][1223:1223] CHIP:DMG: { [1707930970.411140][1223:1223] CHIP:DMG: CommandPathIB = [1707930970.411207][1223:1223] CHIP:DMG: { [1707930970.411410][1223:1223] CHIP:DMG: EndpointId = 0x0, [1707930970.411493][1223:1223] CHIP:DMG: ClusterId = 0x3e, [1707930970.411575][1223:1223] CHIP:DMG: CommandId = 0x0, [1707930970.411644][1223:1223] CHIP:DMG: }, [1707930970.411715][1223:1223] CHIP:DMG: [1707930970.411777][1223:1223] CHIP:DMG: CommandFields = [1707930970.411843][1223:1223] CHIP:DMG: { [1707930970.411914][1223:1223] CHIP:DMG: 0x0 = [ [1707930970.412069][1223:1223] CHIP:DMG: 0x9d, 0xe8, 0xbd, 0xde, 0x40, 0x07, 0xbc, 0x6b, 0xb1, 0xb4, 0xa9, 0xb7, 0x4d, 0xe5, 0x52, 0xf3, 0x84, 0x16, 0x09, 0xaa, 0x2e, 0xa9, 0x0a, 0xce, 0xd9, 0xbe, 0xed, 0x93, 0x21, 0x44, 0x66, 0xb7, [1707930970.412219][1223:1223] CHIP:DMG: ] (32 bytes) [1707930970.412347][1223:1223] CHIP:DMG: }, [1707930970.412415][1223:1223] CHIP:DMG: }, [1707930970.412489][1223:1223] CHIP:DMG: [1707930970.412545][1223:1223] CHIP:DMG: ], [1707930970.412617][1223:1223] CHIP:DMG: [1707930970.412673][1223:1223] CHIP:DMG: InteractionModelRevision = 11 [1707930970.412727][1223:1223] CHIP:DMG: }, [1707930970.412991][1223:1223] CHIP:DMG: AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_003E e=0 p=a [1707930970.413058][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930970.413118][1223:1223] CHIP:DMG: Received command for Endpoint=0 Cluster=0x0000_003E Command=0x0000_0000 [1707930970.413204][1223:1223] CHIP:ZCL: OpCreds: Received an AttestationRequest command [1707930970.414125][1223:1223] CHIP:ZCL: OpCreds: AttestationRequest successful. [1707930970.414240][1223:1223] CHIP:DMG: Command handler moving to [NewRespons] [1707930970.414298][1223:1223] CHIP:DMG: Command handler moving to [ Preparing] [1707930970.414360][1223:1223] CHIP:DMG: Command handler moving to [AddingComm] [1707930970.414426][1223:1223] CHIP:DMG: Command handler moving to [AddedComma] [1707930970.414535][1223:1223] CHIP:DMG: Decreasing reference count for CommandHandler, remaining 0 [1707930970.414817][1223:1223] CHIP:EM: <<< [E:41793r S:1291 M:80036324] (S) Msg TX to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:09 (IM:InvokeCommandResponse) [1707930970.415369][1223:1223] CHIP:DMG: Command response sender moving to [AllInvokeR] [1707930970.415432][1223:1223] CHIP:DMG: Command handler moving to [AwaitingDe] [1707930970.507193][1223:1224] CHIP:BLE: Indication confirmation, 0xffff84050a50 [1707930970.652881][1223:1224] CHIP:BLE: Indication confirmation, 0xffff84050a50 [1707930970.799129][1223:1224] CHIP:BLE: Indication confirmation, 0xffff84050a50 [1707930970.800036][1223:1224] CHIP:DL: C1 WriteHandlerCallback MTU: 517 [1707930970.801144][1223:1224] CHIP:BLE: Write request received debug 0xffff84050a50 [1707930970.801921][1223:1223] CHIP:EM: >>> [E:41794r S:1291 M:176619647] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest) [1707930970.802029][1223:1223] CHIP:EM: Handling via exchange: 41794r, Delegate: 0xaaaae727a8a8 [1707930970.802161][1223:1223] CHIP:DMG: InvokeRequestMessage = [1707930970.802223][1223:1223] CHIP:DMG: { [1707930970.802278][1223:1223] CHIP:DMG: suppressResponse = false, [1707930970.802340][1223:1223] CHIP:DMG: timedRequest = false, [1707930970.802398][1223:1223] CHIP:DMG: InvokeRequests = [1707930970.802863][1223:1223] CHIP:DMG: [ [1707930970.802929][1223:1223] CHIP:DMG: CommandDataIB = [1707930970.802996][1223:1223] CHIP:DMG: { [1707930970.803059][1223:1223] CHIP:DMG: CommandPathIB = [1707930970.803129][1223:1223] CHIP:DMG: { [1707930970.803199][1223:1223] CHIP:DMG: EndpointId = 0x0, [1707930970.803430][1223:1223] CHIP:DMG: ClusterId = 0x3e, [1707930970.803565][1223:1223] CHIP:DMG: CommandId = 0x4, [1707930970.803688][1223:1223] CHIP:DMG: }, [1707930970.803767][1223:1223] CHIP:DMG: [1707930970.803831][1223:1223] CHIP:DMG: CommandFields = [1707930970.803898][1223:1223] CHIP:DMG: { [1707930970.803967][1223:1223] CHIP:DMG: 0x0 = [ [1707930970.804120][1223:1223] CHIP:DMG: 0x83, 0x38, 0x70, 0x2c, 0x64, 0x80, 0xaa, 0xc0, 0x0a, 0xee, 0x4d, 0x5a, 0x61, 0x58, 0x17, 0xaf, 0x60, 0xb4, 0x96, 0x41, 0xae, 0x50, 0x25, 0x9e, 0x0c, 0xa4, 0x82, 0xcd, 0xad, 0x9c, 0x62, 0xa9, [1707930970.804264][1223:1223] CHIP:DMG: ] (32 bytes) [1707930970.804343][1223:1223] CHIP:DMG: }, [1707930970.804406][1223:1223] CHIP:DMG: }, [1707930970.804477][1223:1223] CHIP:DMG: [1707930970.804533][1223:1223] CHIP:DMG: ], [1707930970.804603][1223:1223] CHIP:DMG: [1707930970.804658][1223:1223] CHIP:DMG: InteractionModelRevision = 11 [1707930970.804713][1223:1223] CHIP:DMG: }, [1707930970.804976][1223:1223] CHIP:DMG: AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_003E e=0 p=a [1707930970.805039][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930970.805098][1223:1223] CHIP:DMG: Received command for Endpoint=0 Cluster=0x0000_003E Command=0x0000_0004 [1707930970.805183][1223:1223] CHIP:ZCL: OpCreds: Received a CSRRequest command [1707930970.805242][1223:1223] CHIP:ZCL: OpCreds: Finding fabric with fabricIndex 0x0 [1707930970.808205][1223:1223] CHIP:ZCL: OpCreds: AllocatePendingOperationalKey succeeded [1707930970.808963][1223:1223] CHIP:ZCL: OpCreds: CSRRequest successful. [1707930970.809110][1223:1223] CHIP:DMG: Command handler moving to [NewRespons] [1707930970.809170][1223:1223] CHIP:DMG: Command handler moving to [ Preparing] [1707930970.809234][1223:1223] CHIP:DMG: Command handler moving to [AddingComm] [1707930970.809334][1223:1223] CHIP:DMG: Command handler moving to [AddedComma] [1707930970.809448][1223:1223] CHIP:DMG: Decreasing reference count for CommandHandler, remaining 0 [1707930970.809690][1223:1223] CHIP:EM: <<< [E:41794r S:1291 M:80036325] (S) Msg TX to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:09 (IM:InvokeCommandResponse) [1707930970.810227][1223:1223] CHIP:DMG: Command response sender moving to [AllInvokeR] [1707930970.810295][1223:1223] CHIP:DMG: Command handler moving to [AwaitingDe] [1707930970.945534][1223:1224] CHIP:BLE: Indication confirmation, 0xffff84050a50 [1707930971.091726][1223:1224] CHIP:BLE: Indication confirmation, 0xffff84050a50 [1707930971.094248][1223:1224] CHIP:DL: C1 WriteHandlerCallback MTU: 517 [1707930971.095874][1223:1224] CHIP:BLE: Write request received debug 0xffff84050a50 [1707930971.189019][1223:1224] CHIP:DL: C1 WriteHandlerCallback MTU: 517 [1707930971.190427][1223:1224] CHIP:BLE: Write request received debug 0xffff84050a50 [1707930971.190902][1223:1223] CHIP:EM: >>> [E:41795r S:1291 M:176619648] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest) [1707930971.191014][1223:1223] CHIP:EM: Handling via exchange: 41795r, Delegate: 0xaaaae727a8a8 [1707930971.191145][1223:1223] CHIP:DMG: InvokeRequestMessage = [1707930971.191204][1223:1223] CHIP:DMG: { [1707930971.191257][1223:1223] CHIP:DMG: suppressResponse = false, [1707930971.191366][1223:1223] CHIP:DMG: timedRequest = false, [1707930971.191425][1223:1223] CHIP:DMG: InvokeRequests = [1707930971.191499][1223:1223] CHIP:DMG: [ [1707930971.191556][1223:1223] CHIP:DMG: CommandDataIB = [1707930971.191619][1223:1223] CHIP:DMG: { [1707930971.191679][1223:1223] CHIP:DMG: CommandPathIB = [1707930971.191745][1223:1223] CHIP:DMG: { [1707930971.191814][1223:1223] CHIP:DMG: EndpointId = 0x0, [1707930971.191959][1223:1223] CHIP:DMG: ClusterId = 0x3e, [1707930971.192088][1223:1223] CHIP:DMG: CommandId = 0xb, [1707930971.192211][1223:1223] CHIP:DMG: }, [1707930971.192292][1223:1223] CHIP:DMG: [1707930971.192356][1223:1223] CHIP:DMG: CommandFields = [1707930971.192579][1223:1223] CHIP:DMG: { [1707930971.192653][1223:1223] CHIP:DMG: 0x0 = [ [1707930971.192974][1223:1223] CHIP:DMG: 0x15, 0x30, 0x01, 0x01, 0x01, 0x24, 0x02, 0x01, 0x37, 0x03, 0x24, 0x14, 0x01, 0x18, 0x26, 0x04, 0x80, 0x22, 0x81, 0x27, 0x26, 0x05, 0x80, 0x25, 0x4d, 0x3a, 0x37, 0x06, 0x24, 0x14, 0x01, 0x18, 0x24, 0x07, 0x01, 0x24, 0x08, 0x01, 0x30, 0x09, 0x41, 0x04, 0x17, 0x4b, 0xf7, 0x57, 0xa5, 0xc9, 0x90, 0x37, 0x3c, 0xc1, 0xdf, 0xec, 0x68, 0x23, 0x60, 0xe3, 0xd4, 0x5f, 0xa6, 0x8c, 0x7d, 0x74, 0xcb, 0x21, 0x8f, 0x12, 0x12, 0x53, 0x8d, 0x90, 0x72, 0xea, 0xfd, 0x36, 0xce, 0x44, 0xf3, 0xf3, 0x21, 0xff, 0x47, 0x59, 0x38, 0xa9, 0x70, 0x80, 0xe6, 0x53, 0x97, 0x17, 0x27, 0x6f, 0x08, 0x5d, 0x6c, 0x53, 0xb4, 0x09, 0x7f, 0x8e, 0xdf, 0x88, 0x2c, 0x02, 0x37, 0x0a, 0x35, 0x01, 0x29, 0x01, 0x18, 0x24, 0x02, 0x60, 0x30, 0x04, 0x14, 0xad, 0xb9, 0x6c, 0x76, 0xb9, 0xee, 0xa4, 0x8d, 0xbc, 0x3d, 0x30, 0x93, 0x7f, 0x67, 0x28, 0x0c, 0x00, 0x43, 0x54, 0x87, 0x30, 0x05, 0x14, 0xad, 0xb9, 0x6c, 0x76, 0xb9, 0xee, 0xa4, 0x8d, 0xbc, 0x3d, 0x30, 0x93, 0x7f, 0x67, 0x28, 0x0c, 0x00, 0x43, 0x54, 0x87, 0x18, 0x30, 0x0b, 0x40, 0xfe, 0x4a, 0x69, 0x64, 0x99, 0x06, 0x66, 0x40, 0x7d, 0x4d, 0x4b, 0xe7, 0x9d, 0x44, 0xc8, 0x38, 0x12, 0xd5, 0x9f, 0x81, 0x92, 0x98, 0x33, 0xdd, 0xd9, 0xe6, 0x35, 0x8f, 0x23, 0x68, 0x14, 0x5f, 0x6a, 0xf3, 0x18, 0x1b, 0x34, 0x1a, 0x96, 0xa7, 0x71, 0x5d, 0x87, 0x27, 0x37, 0xbb, 0x94, 0x51, 0x4c, 0x41, 0xb0, 0x2d, 0x9e, 0xd3, 0x41, 0x2c, 0xe2, 0xe3, 0xfb, 0xea, 0xd8, 0x19, 0xaa, 0xa8, 0x18, [1707930971.193139][1223:1223] CHIP:DMG: ] (231 bytes) [1707930971.193271][1223:1223] CHIP:DMG: }, [1707930971.193389][1223:1223] CHIP:DMG: }, [1707930971.193468][1223:1223] CHIP:DMG: [1707930971.193525][1223:1223] CHIP:DMG: ], [1707930971.193597][1223:1223] CHIP:DMG: [1707930971.193654][1223:1223] CHIP:DMG: InteractionModelRevision = 11 [1707930971.193708][1223:1223] CHIP:DMG: }, [1707930971.193971][1223:1223] CHIP:DMG: AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_003E e=0 p=a [1707930971.194035][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930971.194095][1223:1223] CHIP:DMG: Received command for Endpoint=0 Cluster=0x0000_003E Command=0x0000_000B [1707930971.194179][1223:1223] CHIP:ZCL: OpCreds: Received an AddTrustedRootCertificate command [1707930971.196557][1223:1223] CHIP:ZCL: OpCreds: AddTrustedRootCertificate successful. [1707930971.196675][1223:1223] CHIP:DMG: Command handler moving to [NewRespons] [1707930971.196733][1223:1223] CHIP:DMG: Command handler moving to [ Preparing] [1707930971.196796][1223:1223] CHIP:DMG: Command handler moving to [AddingComm] [1707930971.196856][1223:1223] CHIP:DMG: Command handler moving to [AddedComma] [1707930971.196961][1223:1223] CHIP:DMG: Decreasing reference count for CommandHandler, remaining 0 [1707930971.197162][1223:1223] CHIP:EM: <<< [E:41795r S:1291 M:80036326] (S) Msg TX to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:09 (IM:InvokeCommandResponse) [1707930971.197707][1223:1223] CHIP:DMG: Command response sender moving to [AllInvokeR] [1707930971.197771][1223:1223] CHIP:DMG: Command handler moving to [AwaitingDe] [1707930971.336093][1223:1224] CHIP:BLE: Indication confirmation, 0xffff84050a50 [1707930971.382797][1223:1224] CHIP:DL: C1 WriteHandlerCallback MTU: 517 [1707930971.384271][1223:1224] CHIP:BLE: Write request received debug 0xffff84050a50 [1707930971.532549][1223:1224] CHIP:DL: C1 WriteHandlerCallback MTU: 517 [1707930971.534828][1223:1224] CHIP:BLE: Write request received debug 0xffff84050a50 [1707930971.628144][1223:1224] CHIP:DL: C1 WriteHandlerCallback MTU: 517 [1707930971.629713][1223:1224] CHIP:BLE: Write request received debug 0xffff84050a50 [1707930971.630211][1223:1223] CHIP:EM: >>> [E:41796r S:1291 M:176619649] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest) [1707930971.630318][1223:1223] CHIP:EM: Handling via exchange: 41796r, Delegate: 0xaaaae727a8a8 [1707930971.630455][1223:1223] CHIP:DMG: InvokeRequestMessage = [1707930971.630516][1223:1223] CHIP:DMG: { [1707930971.630568][1223:1223] CHIP:DMG: suppressResponse = false, [1707930971.630630][1223:1223] CHIP:DMG: timedRequest = false, [1707930971.630686][1223:1223] CHIP:DMG: InvokeRequests = [1707930971.630835][1223:1223] CHIP:DMG: [ [1707930971.630896][1223:1223] CHIP:DMG: CommandDataIB = [1707930971.630960][1223:1223] CHIP:DMG: { [1707930971.631021][1223:1223] CHIP:DMG: CommandPathIB = [1707930971.631088][1223:1223] CHIP:DMG: { [1707930971.631158][1223:1223] CHIP:DMG: EndpointId = 0x0, [1707930971.631338][1223:1223] CHIP:DMG: ClusterId = 0x3e, [1707930971.631515][1223:1223] CHIP:DMG: CommandId = 0x6, [1707930971.631636][1223:1223] CHIP:DMG: }, [1707930971.631716][1223:1223] CHIP:DMG: [1707930971.631872][1223:1223] CHIP:DMG: CommandFields = [1707930971.631996][1223:1223] CHIP:DMG: { [1707930971.632240][1223:1223] CHIP:DMG: 0x0 = [ [1707930971.632518][1223:1223] CHIP:DMG: 0x15, 0x30, 0x01, 0x01, 0x01, 0x24, 0x02, 0x01, 0x37, 0x03, 0x24, 0x13, 0x02, 0x18, 0x26, 0x04, 0x80, 0x22, 0x81, 0x27, 0x26, 0x05, 0x80, 0x25, 0x4d, 0x3a, 0x37, 0x06, 0x24, 0x15, 0x01, 0x24, 0x11, 0x01, 0x18, 0x24, 0x07, 0x01, 0x24, 0x08, 0x01, 0x30, 0x09, 0x41, 0x04, 0xef, 0x95, 0xf8, 0x56, 0x91, 0x90, 0x4e, 0x2f, 0xb7, 0x68, 0xaa, 0x71, 0xbf, 0x4f, 0x70, 0xd9, 0x05, 0xa0, 0x44, 0x67, 0x31, 0x0e, 0x5d, 0x30, 0xe5, 0x8f, 0x99, 0x4e, 0xcd, 0xcf, 0x37, 0x5a, 0xc0, 0x70, 0x28, 0x1a, 0x90, 0x42, 0x02, 0xd4, 0x04, 0xac, 0xfd, 0x9b, 0x22, 0xe3, 0xa3, 0x6c, 0xf0, 0xad, 0xe2, 0x83, 0xd4, 0xd3, 0x21, 0xd2, 0x3f, 0xd4, 0x6b, 0x1a, 0x4b, 0x0d, 0x5a, 0x2f, 0x37, 0x0a, 0x35, 0x01, 0x28, 0x01, 0x18, 0x24, 0x02, 0x01, 0x36, 0x03, 0x04, 0x02, 0x04, 0x01, 0x18, 0x30, 0x04, 0x14, 0xb4, 0x8e, 0xb0, 0xac, 0x84, 0x3a, 0xb0, 0x08, 0x84, 0x75, 0x5a, 0xfb, 0xbb, 0xff, 0x87, 0x7a, 0xc9, 0x20, 0x44, 0xe3, 0x30, 0x05, 0x14, 0xe6, 0x33, 0x75, 0xf2, 0x1c, 0x18, 0x29, 0xa7, 0xca, 0xb9, 0x90, 0x79, 0xec, 0x83, 0xc2, 0xdf, 0x57, 0xc6, 0xf8, 0x9e, 0x18, 0x30, 0x0b, 0x40, 0x97, 0xb5, 0xff, 0x68, 0xea, 0xb0, 0x53, 0x96, 0x3c, 0x28, 0xcf, 0x4b, 0xae, 0xcf, 0xbe, 0xe9, 0xd0, 0x8b, 0x3c, 0x0b, 0xf5, 0x06, 0xd7, 0x54, 0x7f, 0xda, 0x29, 0x87, 0x71, 0xe4, 0x6e, 0x76, 0xb6, 0x91, 0xe9, 0xf1, 0x26, 0x1e, 0x87, 0x40, 0xe1, 0xb3, 0x5b, 0x97, 0x04, 0xc8, 0x55, 0xf4, 0xb6, 0x6f, 0x21, 0x19, 0x20, 0x2a, 0x76, 0x96, 0x4d, 0x68, 0xe7, 0xd8, 0x97, 0x76, 0x07, 0x61, 0x18, [1707930971.632763][1223:1223] CHIP:DMG: ] (241 bytes) [1707930971.632896][1223:1223] CHIP:DMG: 0x1 = [ [1707930971.633228][1223:1223] CHIP:DMG: 0x15, 0x30, 0x01, 0x01, 0x01, 0x24, 0x02, 0x01, 0x37, 0x03, 0x24, 0x14, 0x01, 0x18, 0x26, 0x04, 0x80, 0x22, 0x81, 0x27, 0x26, 0x05, 0x80, 0x25, 0x4d, 0x3a, 0x37, 0x06, 0x24, 0x13, 0x02, 0x18, 0x24, 0x07, 0x01, 0x24, 0x08, 0x01, 0x30, 0x09, 0x41, 0x04, 0x22, 0x80, 0x2f, 0xc0, 0xc1, 0x9c, 0xea, 0x31, 0x00, 0xd7, 0x97, 0x95, 0xf6, 0xe7, 0x81, 0x2c, 0x6c, 0x1d, 0xba, 0x41, 0x9d, 0x1c, 0x89, 0x84, 0x05, 0xa6, 0x94, 0x3f, 0x21, 0xf4, 0xcf, 0xd8, 0xb7, 0xdd, 0xbf, 0xbf, 0x66, 0xf3, 0x2a, 0x2d, 0xd5, 0x1d, 0xd8, 0xd7, 0x64, 0xc1, 0x34, 0xfb, 0x6f, 0x30, 0x25, 0xfd, 0xab, 0xf0, 0x9c, 0x02, 0x4d, 0x41, 0x82, 0x60, 0xa5, 0x96, 0x6d, 0x6e, 0x37, 0x0a, 0x35, 0x01, 0x29, 0x01, 0x18, 0x24, 0x02, 0x60, 0x30, 0x04, 0x14, 0xe6, 0x33, 0x75, 0xf2, 0x1c, 0x18, 0x29, 0xa7, 0xca, 0xb9, 0x90, 0x79, 0xec, 0x83, 0xc2, 0xdf, 0x57, 0xc6, 0xf8, 0x9e, 0x30, 0x05, 0x14, 0xad, 0xb9, 0x6c, 0x76, 0xb9, 0xee, 0xa4, 0x8d, 0xbc, 0x3d, 0x30, 0x93, 0x7f, 0x67, 0x28, 0x0c, 0x00, 0x43, 0x54, 0x87, 0x18, 0x30, 0x0b, 0x40, 0x22, 0xd6, 0xa4, 0xa9, 0xdd, 0x27, 0x20, 0x55, 0xcb, 0x0c, 0x62, 0xe1, 0x46, 0xc5, 0xa6, 0xfa, 0x0b, 0xb7, 0x38, 0x32, 0xc7, 0x70, 0xd7, 0x6c, 0x30, 0xc8, 0xf7, 0x2f, 0x52, 0x0d, 0x0a, 0x85, 0xd4, 0x9b, 0x15, 0xa8, 0xc6, 0xad, 0xdb, 0x88, 0xa6, 0x3b, 0x18, 0xab, 0xdb, 0x01, 0xa3, 0x84, 0xdb, 0x78, 0x92, 0x41, 0x16, 0xac, 0x0f, 0x77, 0xa7, 0x25, 0x6b, 0x48, 0xc6, 0xe2, 0xef, 0x2b, 0x18, [1707930971.633439][1223:1223] CHIP:DMG: ] (231 bytes) [1707930971.633525][1223:1223] CHIP:DMG: 0x2 = [ [1707930971.633610][1223:1223] CHIP:DMG: 0x74, 0x65, 0x6d, 0x70, 0x6f, 0x72, 0x61, 0x72, 0x79, 0x20, 0x69, 0x70, 0x6b, 0x20, 0x30, 0x31, [1707930971.633699][1223:1223] CHIP:DMG: ] (16 bytes) [1707930971.633779][1223:1223] CHIP:DMG: 0x3 = 112233, [1707930971.633855][1223:1223] CHIP:DMG: 0x4 = 65521, [1707930971.633931][1223:1223] CHIP:DMG: }, [1707930971.633993][1223:1223] CHIP:DMG: }, [1707930971.634069][1223:1223] CHIP:DMG: [1707930971.634125][1223:1223] CHIP:DMG: ], [1707930971.634201][1223:1223] CHIP:DMG: [1707930971.634256][1223:1223] CHIP:DMG: InteractionModelRevision = 11 [1707930971.634310][1223:1223] CHIP:DMG: }, [1707930971.634612][1223:1223] CHIP:DMG: AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_003E e=0 p=a [1707930971.634674][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930971.634735][1223:1223] CHIP:DMG: Received command for Endpoint=0 Cluster=0x0000_003E Command=0x0000_0006 [1707930971.634840][1223:1223] CHIP:ZCL: OpCreds: Received an AddNOC command [1707930971.635279][1223:1223] CHIP:FP: Validating NOC chain [1707930971.637692][1223:1223] CHIP:FP: NOC chain validation successful [1707930971.637749][1223:1223] CHIP:FP: Added new fabric at index: 0x1 [1707930971.637774][1223:1223] CHIP:FP: Assigned compressed fabric ID: 0xEE067FCD7D10156A, node ID: 0x0000000000000001 [1707930971.637805][1223:1223] CHIP:TS: Last Known Good Time: 2023-10-14T01:16:48 [1707930971.637832][1223:1223] CHIP:TS: New proposed Last Known Good Time: 2021-01-01T00:00:00 [1707930971.637857][1223:1223] CHIP:TS: Retaining current Last Known Good Time [1707930971.637893][1223:1223] CHIP:DMG: Endpoint 0, Cluster 0x0000_003E update version to 4d7309d8 [1707930971.637922][1223:1223] CHIP:DMG: Endpoint 0, Cluster 0x0000_003E update version to 4d7309d9 [1707930971.638486][1223:1223] CHIP:DL: writing settings to file (/tmp/chip_kvs-oEYAXB) [1707930971.639398][1223:1223] CHIP:DL: renamed tmp file to file (/tmp/chip_kvs) [1707930971.639676][1223:1223] CHIP:DL: writing settings to file (/tmp/chip_kvs-sObrKK) [1707930971.640351][1223:1223] CHIP:DL: renamed tmp file to file (/tmp/chip_kvs) [1707930971.640556][1223:1223] CHIP:DL: writing settings to file (/tmp/chip_kvs-HkeMNi) [1707930971.641204][1223:1223] CHIP:DL: renamed tmp file to file (/tmp/chip_kvs) [1707930971.641296][1223:1223] CHIP:DMG: AccessControl: validating f=1 p=a a=c s=1 t=0 [1707930971.641328][1223:1223] CHIP:DMG: validating subject 0x000000000001B669 [1707930971.641509][1223:1223] CHIP:DL: writing settings to file (/tmp/chip_kvs-GYfhj0) [1707930971.642163][1223:1223] CHIP:DL: renamed tmp file to file (/tmp/chip_kvs) [1707930971.642313][1223:1223] CHIP:EVL: LogEvent event number: 0x0000000000000004 priority: 1, endpoint id: 0x0 cluster id: 0x0000_001F event id: 0x0 Epoch timestamp: 0x0000018DA89E6DFA [1707930971.642352][1223:1223] CHIP:ZCL: OpCreds: ACL entry created for Fabric index 0x1 CASE Admin Subject 0x000000000001B669 [1707930971.642806][1223:1223] CHIP:DL: Using wifi MAC for hostname [1707930971.642848][1223:1223] CHIP:DIS: Advertise operational node EE067FCD7D10156A-0000000000000001 [1707930971.642915][1223:1223] CHIP:DIS: Responding with _matter._tcp.local [1707930971.642946][1223:1223] CHIP:DIS: Responding with EE067FCD7D10156A-0000000000000001._matter._tcp.local [1707930971.642977][1223:1223] CHIP:DIS: Responding with EE067FCD7D10156A-0000000000000001._matter._tcp.local [1707930971.643004][1223:1223] CHIP:DIS: Responding with E45F014342150000.local [1707930971.643029][1223:1223] CHIP:DIS: Responding with E45F014342150000.local [1707930971.643061][1223:1223] CHIP:DIS: Responding with _IEE067FCD7D10156A._sub._matter._tcp.local [1707930971.643085][1223:1223] CHIP:DIS: CHIP minimal mDNS configured as 'Operational device'; instance name: EE067FCD7D10156A-0000000000000001. [1707930971.645618][1223:1223] CHIP:DIS: mDNS service published: _matter._tcp [1707930971.645675][1223:1223] CHIP:DMG: Endpoint 0, Cluster 0x0000_003E update version to 4d7309da [1707930971.645707][1223:1223] CHIP:DMG: Endpoint 0, Cluster 0x0000_003E update version to 4d7309db [1707930971.645761][1223:1223] CHIP:DMG: Command handler moving to [NewRespons] [1707930971.645841][1223:1223] CHIP:DMG: Command handler moving to [ Preparing] [1707930971.645907][1223:1223] CHIP:DMG: Command handler moving to [AddingComm] [1707930971.645946][1223:1223] CHIP:DMG: Command handler moving to [AddedComma] [1707930971.645973][1223:1223] CHIP:ZCL: OpCreds: successfully created fabric index 0x1 via AddNOC [1707930971.646047][1223:1223] CHIP:DMG: Decreasing reference count for CommandHandler, remaining 0 [1707930971.646191][1223:1223] CHIP:EM: <<< [E:41796r S:1291 M:80036327] (S) Msg TX to 1:FFFFFFFB00000000 [156A] [BLE] --- Type 0001:09 (IM:InvokeCommandResponse) [1707930971.646517][1223:1223] CHIP:DMG: Command response sender moving to [AllInvokeR] [1707930971.646553][1223:1223] CHIP:DMG: Command handler moving to [AwaitingDe] [1707930972.213264][1223:1224] CHIP:BLE: Indication confirmation, 0xffff84050a50 [1707930972.261711][1223:1224] CHIP:DL: C1 WriteHandlerCallback MTU: 517 [1707930972.262738][1223:1224] CHIP:BLE: Write request received debug 0xffff84050a50 [1707930972.263425][1223:1223] CHIP:EM: >>> [E:41797r S:1291 M:176619650] (S) Msg RX from 1:FFFFFFFB00000000 [156A] --- Type 0001:08 (IM:InvokeCommandRequest) [1707930972.263566][1223:1223] CHIP:EM: Handling via exchange: 41797r, Delegate: 0xaaaae727a8a8 [1707930972.263727][1223:1223] CHIP:DMG: InvokeRequestMessage = [1707930972.263788][1223:1223] CHIP:DMG: { [1707930972.263842][1223:1223] CHIP:DMG: suppressResponse = false, [1707930972.263905][1223:1223] CHIP:DMG: timedRequest = false, [1707930972.263963][1223:1223] CHIP:DMG: InvokeRequests = [1707930972.264034][1223:1223] CHIP:DMG: [ [1707930972.264091][1223:1223] CHIP:DMG: CommandDataIB = [1707930972.264155][1223:1223] CHIP:DMG: { [1707930972.264335][1223:1223] CHIP:DMG: CommandPathIB = [1707930972.264412][1223:1223] CHIP:DMG: { [1707930972.264497][1223:1223] CHIP:DMG: EndpointId = 0x0, [1707930972.264565][1223:1223] CHIP:DMG: ClusterId = 0x31, [1707930972.264631][1223:1223] CHIP:DMG: CommandId = 0x2, [1707930972.264692][1223:1223] CHIP:DMG: }, [1707930972.264757][1223:1223] CHIP:DMG: [1707930972.264813][1223:1223] CHIP:DMG: CommandFields = [1707930972.264874][1223:1223] CHIP:DMG: { [1707930972.264938][1223:1223] CHIP:DMG: 0x0 = [ [1707930972.265009][1223:1223] CHIP:DMG: 0x47, 0x52, 0x4c, 0x50, 0x72, 0x69, 0x76, 0x61, 0x74, 0x65, [1707930972.265084][1223:1223] CHIP:DMG: ] (10 bytes) [1707930972.265167][1223:1223] CHIP:DMG: 0x1 = [ [1707930972.265255][1223:1223] CHIP:DMG: 0x67, 0x72, 0x6c, 0x70, 0x72, 0x69, 0x76, 0x61, 0x74, 0x65, 0x77, 0x69, 0x66, 0x69, 0x30, 0x39, 0x32, 0x30, 0x31, 0x30, [1707930972.265359][1223:1223] CHIP:DMG: ] (20 bytes) [1707930972.265444][1223:1223] CHIP:DMG: 0x2 = 23, [1707930972.265525][1223:1223] CHIP:DMG: }, [1707930972.265589][1223:1223] CHIP:DMG: }, [1707930972.265663][1223:1223] CHIP:DMG: [1707930972.265720][1223:1223] CHIP:DMG: ], [1707930972.265794][1223:1223] CHIP:DMG: [1707930972.265850][1223:1223] CHIP:DMG: InteractionModelRevision = 11 [1707930972.265905][1223:1223] CHIP:DMG: }, [1707930972.266199][1223:1223] CHIP:DMG: AccessControl: checking f=1 a=p s=0xFFFFFFFB00000000 t= c=0x0000_0031 e=0 p=a [1707930972.266268][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930972.266330][1223:1223] CHIP:DMG: Received command for Endpoint=0 Cluster=0x0000_0031 Command=0x0000_0002 [1707930972.266492][1223:1223] CHIP:DMG: Command handler moving to [NewRespons] [1707930972.266556][1223:1223] CHIP:DMG: Command handler moving to [ Preparing] [1707930972.266620][1223:1223] CHIP:DMG: Command handler moving to [AddingComm] [1707930972.266693][1223:1223] CHIP:DMG: Command handler moving to [AddedComma] [1707930972.266764][1223:1223] CHIP:DMG: Endpoint 0, Cluster 0x0000_0030 update version to e0c6e477 [1707930972.266876][1223:1223] CHIP:DMG: Decreasing reference count for CommandHandler, remaining 0 [1707930972.267119][1223:1223] CHIP:EM: <<< [E:41797r S:1291 M:80036328] (S) Msg TX to 1:FFFFFFFB00000000 [156A] [BLE] --- Type 0001:09 (IM:InvokeCommandResponse) [1707930972.267745][1223:1223] CHIP:DMG: Command response sender moving to [AllInvokeR] [1707930972.267809][1223:1223] CHIP:DMG: Command handler moving to [AwaitingDe] [1707930972.505253][1223:1224] CHIP:BLE: Indication confirmation, 0xffff84050a50 [1707930972.602478][1223:1224] CHIP:DL: C1 WriteHandlerCallback MTU: 517 [1707930972.603497][1223:1224] CHIP:BLE: Write request received debug 0xffff84050a50 [1707930972.604053][1223:1223] CHIP:EM: >>> [E:41798r S:1291 M:176619651] (S) Msg RX from 1:FFFFFFFB00000000 [156A] --- Type 0001:08 (IM:InvokeCommandRequest) [1707930972.604171][1223:1223] CHIP:EM: Handling via exchange: 41798r, Delegate: 0xaaaae727a8a8 [1707930972.604314][1223:1223] CHIP:DMG: InvokeRequestMessage = [1707930972.604373][1223:1223] CHIP:DMG: { [1707930972.604425][1223:1223] CHIP:DMG: suppressResponse = false, [1707930972.604485][1223:1223] CHIP:DMG: timedRequest = false, [1707930972.604543][1223:1223] CHIP:DMG: InvokeRequests = [1707930972.604614][1223:1223] CHIP:DMG: [ [1707930972.604671][1223:1223] CHIP:DMG: CommandDataIB = [1707930972.604734][1223:1223] CHIP:DMG: { [1707930972.604815][1223:1223] CHIP:DMG: CommandPathIB = [1707930972.604890][1223:1223] CHIP:DMG: { [1707930972.604960][1223:1223] CHIP:DMG: EndpointId = 0x0, [1707930972.605048][1223:1223] CHIP:DMG: ClusterId = 0x30, [1707930972.605134][1223:1223] CHIP:DMG: CommandId = 0x0, [1707930972.605215][1223:1223] CHIP:DMG: }, [1707930972.605300][1223:1223] CHIP:DMG: [1707930972.605366][1223:1223] CHIP:DMG: CommandFields = [1707930972.605441][1223:1223] CHIP:DMG: { [1707930972.605509][1223:1223] CHIP:DMG: 0x0 = 66, [1707930972.605576][1223:1223] CHIP:DMG: 0x1 = 25, [1707930972.605642][1223:1223] CHIP:DMG: }, [1707930972.605698][1223:1223] CHIP:DMG: }, [1707930972.605764][1223:1223] CHIP:DMG: [1707930972.605814][1223:1223] CHIP:DMG: ], [1707930972.605883][1223:1223] CHIP:DMG: [1707930972.605933][1223:1223] CHIP:DMG: InteractionModelRevision = 11 [1707930972.605982][1223:1223] CHIP:DMG: }, [1707930972.606254][1223:1223] CHIP:DMG: AccessControl: checking f=1 a=p s=0xFFFFFFFB00000000 t= c=0x0000_0030 e=0 p=a [1707930972.606323][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930972.606387][1223:1223] CHIP:DMG: Received command for Endpoint=0 Cluster=0x0000_0030 Command=0x0000_0000 [1707930972.606479][1223:1223] CHIP:FS: GeneralCommissioning: Received ArmFailSafe (66s) [1707930972.606610][1223:1223] CHIP:DMG: Endpoint 0, Cluster 0x0000_0030 update version to e0c6e478 [1707930972.606719][1223:1223] CHIP:DMG: Command handler moving to [NewRespons] [1707930972.606777][1223:1223] CHIP:DMG: Command handler moving to [ Preparing] [1707930972.606840][1223:1223] CHIP:DMG: Command handler moving to [AddingComm] [1707930972.606910][1223:1223] CHIP:DMG: Command handler moving to [AddedComma] [1707930972.607014][1223:1223] CHIP:DMG: Decreasing reference count for CommandHandler, remaining 0 [1707930972.607262][1223:1223] CHIP:EM: <<< [E:41798r S:1291 M:80036329] (S) Msg TX to 1:FFFFFFFB00000000 [156A] [BLE] --- Type 0001:09 (IM:InvokeCommandResponse) [1707930972.607900][1223:1223] CHIP:DMG: Command response sender moving to [AllInvokeR] [1707930972.607965][1223:1223] CHIP:DMG: Command handler moving to [AwaitingDe] [1707930972.945179][1223:1224] CHIP:BLE: Indication confirmation, 0xffff84050a50 [1707930972.992596][1223:1224] CHIP:DL: C1 WriteHandlerCallback MTU: 517 [1707930972.993452][1223:1224] CHIP:BLE: Write request received debug 0xffff84050a50 [1707930972.993956][1223:1223] CHIP:EM: >>> [E:41799r S:1291 M:176619652] (S) Msg RX from 1:FFFFFFFB00000000 [156A] --- Type 0001:08 (IM:InvokeCommandRequest) [1707930972.994062][1223:1223] CHIP:EM: Handling via exchange: 41799r, Delegate: 0xaaaae727a8a8 [1707930972.994194][1223:1223] CHIP:DMG: InvokeRequestMessage = [1707930972.994253][1223:1223] CHIP:DMG: { [1707930972.994306][1223:1223] CHIP:DMG: suppressResponse = false, [1707930972.994367][1223:1223] CHIP:DMG: timedRequest = false, [1707930972.994424][1223:1223] CHIP:DMG: InvokeRequests = [1707930972.994498][1223:1223] CHIP:DMG: [ [1707930972.994557][1223:1223] CHIP:DMG: CommandDataIB = [1707930972.994622][1223:1223] CHIP:DMG: { [1707930972.994682][1223:1223] CHIP:DMG: CommandPathIB = [1707930972.994750][1223:1223] CHIP:DMG: { [1707930972.994820][1223:1223] CHIP:DMG: EndpointId = 0x0, [1707930972.994920][1223:1223] CHIP:DMG: ClusterId = 0x31, [1707930972.994995][1223:1223] CHIP:DMG: CommandId = 0x6, [1707930972.995062][1223:1223] CHIP:DMG: }, [1707930972.995136][1223:1223] CHIP:DMG: [1707930972.995199][1223:1223] CHIP:DMG: CommandFields = [1707930972.995268][1223:1223] CHIP:DMG: { [1707930972.995502][1223:1223] CHIP:DMG: 0x0 = [ [1707930972.995635][1223:1223] CHIP:DMG: 0x47, 0x52, 0x4c, 0x50, 0x72, 0x69, 0x76, 0x61, 0x74, 0x65, [1707930972.995750][1223:1223] CHIP:DMG: ] (10 bytes) [1707930972.995835][1223:1223] CHIP:DMG: 0x1 = 27, [1707930972.995917][1223:1223] CHIP:DMG: }, [1707930972.995981][1223:1223] CHIP:DMG: }, [1707930972.996053][1223:1223] CHIP:DMG: [1707930972.996109][1223:1223] CHIP:DMG: ], [1707930972.996180][1223:1223] CHIP:DMG: [1707930972.996235][1223:1223] CHIP:DMG: InteractionModelRevision = 11 [1707930972.996289][1223:1223] CHIP:DMG: }, [1707930972.996554][1223:1223] CHIP:DMG: AccessControl: checking f=1 a=p s=0xFFFFFFFB00000000 t= c=0x0000_0031 e=0 p=a [1707930972.996617][1223:1223] CHIP:DMG: AccessControl: implicit admin (PASE) [1707930972.996678][1223:1223] CHIP:DMG: Received command for Endpoint=0 Cluster=0x0000_0031 Command=0x0000_0006 [1707930972.996776][1223:1223] CHIP:NP: LinuxWiFiDriver: ConnectNetwork 'GRLPrivate' [1707930973.052469][1223:1223] CHIP:DL: wpa_supplicant: added network: /fi/w1/wpa_supplicant1/Interfaces/0/Networks/0 [1707930973.053003][1223:1223] CHIP:DMG: Decreasing reference count for CommandHandler, remaining 1 [1707930973.053743][1223:1224] CHIP:DL: wpa_supplicant:PropertiesChanged:key:DisconnectReason -> -3 [1707930973.054499][1223:1224] CHIP:DL: wpa_supplicant:PropertiesChanged:key:State -> 'disconnected' [1707930973.054600][1223:1224] CHIP:ZCL: WiFiDiagnosticsDelegate: OnDisconnectionDetected [1707930973.054789][1223:1224] CHIP:DL: Chip stack locking error at 'src/app/EventManagement.cpp:416'. Code is unsafe/racy [1707930973.054956][1223:1224] CHIP:-: chipDie chipDie chipDie Aborted (core dumped)