ubuntu@ubuntu:~/connectedhomeip_n/out_6.1$ sudo ./chip-tool generalcommissioning read feature-map 2 0 [1654500190.720080][52059:52059] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_kvs [1654500190.720605][52059:52059] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_factory.ini [1654500190.720845][52059:52059] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_config.ini [1654500190.721019][52059:52059] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_counters.ini [1654500190.721412][52059:52059] CHIP:DL: writing settings to file (/tmp/chip_counters.ini-tsldxR) [1654500190.722005][52059:52059] CHIP:DL: renamed tmp file to file (/tmp/chip_counters.ini) [1654500190.722055][52059:52059] CHIP:DL: NVS set: chip-counters/reboot-count = 146 (0x92) [1654500190.722994][52059:52059] CHIP:DL: Got Ethernet interface: eth0 [1654500190.723509][52059:52059] CHIP:DL: Found the primary Ethernet interface:eth0 [1654500190.724027][52059:52059] CHIP:DL: Got WiFi interface: wlan0 [1654500190.724102][52059:52059] CHIP:DL: Failed to reset WiFi statistic counts [1654500190.724233][52059:52059] CHIP:IN: UDP::Init bind&listen port=0 [1654500190.724373][52059:52059] CHIP:IN: UDP::Init bound to port=51816 [1654500190.724402][52059:52059] CHIP:IN: UDP::Init bind&listen port=0 [1654500190.724501][52059:52059] CHIP:IN: UDP::Init bound to port=42995 [1654500190.724526][52059:52059] CHIP:IN: BLEBase::Init - setting/overriding transport [1654500190.724548][52059:52059] CHIP:IN: TransportMgr initialized [1654500190.724614][52059:52059] CHIP:DIS: Init fabric pairing table with server storage [1654500190.724933][52059:52059] CHIP:IN: Loading from storage for fabric index 0x1 [1654500190.728241][52059:52059] CHIP:IN: Loading from storage for fabric index 0x2 [1654500190.729446][52059:52059] CHIP:IN: Loading from storage for fabric index 0x3 [1654500190.737871][52059:52059] CHIP:ZCL: Using ZAP configuration... [1654500190.743868][52059:52059] CHIP:DL: MDNS failed to join multicast group on wpan0 for address type IPv4: ../examples/chip-tool/third_party/connectedhomeip/src/inet/UDPEndPointImplSockets.cpp:772: Inet Error 0x00000110: Address not found [1654500190.744213][52059:52059] CHIP:CTL: System State Initialized... [1654500190.744305][52059:52059] CHIP:CTL: Setting attestation nonce to random value [1654500190.744370][52059:52059] CHIP:CTL: Setting CSR nonce to random value [1654500190.744446][52059:52059] CHIP:IN: UDP::Init bind&listen port=5550 [1654500190.744540][52059:52059] CHIP:IN: UDP::Init bound to port=5550 [1654500190.744566][52059:52059] CHIP:IN: UDP::Init bind&listen port=5550 [1654500190.744650][52059:52059] CHIP:IN: UDP::Init bound to port=5550 [1654500190.744751][52059:52059] CHIP:IN: TransportMgr initialized [1654500190.744813][52059:52059] CHIP:CTL: Setting attestation nonce to random value [1654500190.744866][52059:52059] CHIP:CTL: Setting CSR nonce to random value [1654500190.745859][52059:52059] CHIP:CTL: Generating NOC [1654500190.746755][52059:52059] CHIP:DIS: Verifying the received credentials [1654500190.748655][52059:52059] CHIP:DIS: Added new fabric at index: 0x1, Initialized: 1 [1654500190.748693][52059:52059] CHIP:DIS: Assigned compressed fabric ID: 0x8739F9DA28568034, node ID: 0x000000000001B669 [1654500190.765090][52059:52059] CHIP:DIS: Fabric (0x1) persisted to storage. Calling OnFabricPersistedToStorage [1654500190.765140][52059:52059] CHIP:CTL: Joined the fabric at index 1. Compressed fabric ID is: 0x8739F9DA28568034 [1654500190.765196][52059:52059] CHIP:IN: UDP::Init bind&listen port=5550 [1654500190.765327][52059:52059] CHIP:IN: UDP::Init bound to port=5550 [1654500190.765354][52059:52059] CHIP:IN: UDP::Init bind&listen port=5550 [1654500190.765441][52059:52059] CHIP:IN: UDP::Init bound to port=5550 [1654500190.765466][52059:52059] CHIP:IN: TransportMgr initialized [1654500190.765566][52059:52059] CHIP:CTL: Setting attestation nonce to random value [1654500190.765632][52059:52059] CHIP:CTL: Setting CSR nonce to random value [1654500190.766543][52059:52059] CHIP:CTL: Generating NOC [1654500190.767600][52059:52059] CHIP:DIS: Verifying the received credentials [1654500190.769434][52059:52059] CHIP:DIS: Added new fabric at index: 0x2, Initialized: 1 [1654500190.769471][52059:52059] CHIP:DIS: Assigned compressed fabric ID: 0xF8A84CFD5F7A399A, node ID: 0x000000000001B669 [1654500190.785443][52059:52059] CHIP:DIS: Fabric (0x2) persisted to storage. Calling OnFabricPersistedToStorage [1654500190.785493][52059:52059] CHIP:CTL: Joined the fabric at index 2. Compressed fabric ID is: 0xF8A84CFD5F7A399A [1654500190.785549][52059:52059] CHIP:IN: UDP::Init bind&listen port=5550 [1654500190.785677][52059:52059] CHIP:IN: UDP::Init bound to port=5550 [1654500190.785703][52059:52059] CHIP:IN: UDP::Init bind&listen port=5550 [1654500190.785795][52059:52059] CHIP:IN: UDP::Init bound to port=5550 [1654500190.785818][52059:52059] CHIP:IN: TransportMgr initialized [1654500190.785944][52059:52059] CHIP:CTL: Setting attestation nonce to random value [1654500190.786007][52059:52059] CHIP:CTL: Setting CSR nonce to random value [1654500190.787030][52059:52059] CHIP:CTL: Generating NOC [1654500190.787850][52059:52059] CHIP:DIS: Verifying the received credentials [1654500190.789728][52059:52059] CHIP:DIS: Added new fabric at index: 0x3, Initialized: 1 [1654500190.789768][52059:52059] CHIP:DIS: Assigned compressed fabric ID: 0xAD4355F0FD56BBCD, node ID: 0x000000000001B669 [1654500190.805494][52059:52059] CHIP:DIS: Fabric (0x3) persisted to storage. Calling OnFabricPersistedToStorage [1654500190.805541][52059:52059] CHIP:CTL: Joined the fabric at index 3. Compressed fabric ID is: 0xAD4355F0FD56BBCD [1654500190.805596][52059:52059] CHIP:IN: UDP::Init bind&listen port=5550 [1654500190.805724][52059:52059] CHIP:IN: UDP::Init bound to port=5550 [1654500190.805750][52059:52059] CHIP:IN: UDP::Init bind&listen port=5550 [1654500190.805841][52059:52059] CHIP:IN: UDP::Init bound to port=5550 [1654500190.805864][52059:52059] CHIP:IN: TransportMgr initialized [1654500190.886983][52059:52064] CHIP:DL: CHIP task running [1654500190.887127][52059:52064] CHIP:TOO: Sending command to node 0x2 [1654500190.887166][52059:52064] CHIP:CSM: FindOrEstablishSession: PeerId = 8739F9DA28568034:0000000000000002 [1654500190.887192][52059:52064] CHIP:CSM: FindOrEstablishSession: No existing OperationalDeviceProxy instance found [1654500190.887306][52059:52064] CHIP:CTL: OperationalDeviceProxy[8739F9DA28568034:0000000000000002]: State change 1 --> 2 [1654500190.887378][52059:52064] CHIP:DIS: MINMDNS: Sending query ANY/UNICAST for 8739F9DA28568034-0000000000000002._matter._tcp.local [1654500190.888646][52059:52064] CHIP:DIS: MINMDNS: received SRV record for 8739F9DA28568034-0000000000000002._matter._tcp.local [1654500190.888721][52059:52064] CHIP:DIS: MINMDNS: Operational SRV for 8739F9DA28568034-0000000000000002: DEA31B98844CD240.local [1654500190.888749][52059:52064] CHIP:DIS: MINMDNS: received TXT record for 8739F9DA28568034-0000000000000002._matter._tcp.local [1654500190.888784][52059:52064] CHIP:DIS: MINMDNS: received AAAA record for DEA31B98844CD240.local [1654500190.888812][52059:52064] CHIP:DIS: MINMDNS: IP address fd11:22::5d8c:69ab:1e8:b279 found for DEA31B98844CD240.local [1654500190.889501][52059:52064] CHIP:DIS: Lookup clearing interface for non LL address [1654500190.889545][52059:52064] CHIP:DIS: UDP:[fd11:22::5d8c:69ab:1e8:b279%eth0]:5540: new best score: 6 [1654500190.889571][52059:52064] CHIP:DIS: Checking node lookup status after 2 ms [1654500190.889593][52059:52064] CHIP:DIS: Keeping DNSSD lookup active [1654500190.889779][52059:52064] CHIP:DIS: MINMDNS: received SRV record for 8739F9DA28568034-0000000000000002._matter._tcp.local [1654500190.889830][52059:52064] CHIP:DIS: MINMDNS: Operational SRV for 8739F9DA28568034-0000000000000002: DEA31B98844CD240.local [1654500190.889862][52059:52064] CHIP:DIS: MINMDNS: received TXT record for 8739F9DA28568034-0000000000000002._matter._tcp.local [1654500190.889900][52059:52064] CHIP:DIS: MINMDNS: received AAAA record for DEA31B98844CD240.local [1654500190.889932][52059:52064] CHIP:DIS: MINMDNS: IP address fd11:22::5d8c:69ab:1e8:b279 found for DEA31B98844CD240.local [1654500190.889960][52059:52064] CHIP:DIS: Discovered node without a pending query [1654500190.890469][52059:52064] CHIP:DIS: UDP:[fd11:22::5d8c:69ab:1e8:b279%docker0]:5540: score has not improved: 6 [1654500190.890502][52059:52064] CHIP:DIS: Checking node lookup status after 3 ms [1654500190.890523][52059:52064] CHIP:DIS: Keeping DNSSD lookup active [1654500190.891152][52059:52064] CHIP:DIS: MINMDNS: received SRV record for 8739F9DA28568034-0000000000000002._matter._tcp.local [1654500190.891201][52059:52064] CHIP:DIS: MINMDNS: Operational SRV for 8739F9DA28568034-0000000000000002: DEA31B98844CD240.local [1654500190.891232][52059:52064] CHIP:DIS: MINMDNS: received TXT record for 8739F9DA28568034-0000000000000002._matter._tcp.local [1654500190.891269][52059:52064] CHIP:DIS: MINMDNS: received AAAA record for DEA31B98844CD240.local [1654500190.891301][52059:52064] CHIP:DIS: MINMDNS: IP address fd11:22::5d8c:69ab:1e8:b279 found for DEA31B98844CD240.local [1654500190.891328][52059:52064] CHIP:DIS: Discovered node without a pending query [1654500190.891823][52059:52064] CHIP:DIS: UDP:[fd11:22::5d8c:69ab:1e8:b279%br-1b2587eb2d56]:5540: score has not improved: 6 [1654500190.891855][52059:52064] CHIP:DIS: Checking node lookup status after 5 ms [1654500190.891875][52059:52064] CHIP:DIS: Keeping DNSSD lookup active [1654500190.892027][52059:52064] CHIP:DIS: MINMDNS: received SRV record for 8739F9DA28568034-0000000000000002._matter._tcp.local [1654500190.892070][52059:52064] CHIP:DIS: MINMDNS: Operational SRV for 8739F9DA28568034-0000000000000002: DEA31B98844CD240.local [1654500190.892099][52059:52064] CHIP:DIS: MINMDNS: received TXT record for 8739F9DA28568034-0000000000000002._matter._tcp.local [1654500190.892131][52059:52064] CHIP:DIS: MINMDNS: received AAAA record for DEA31B98844CD240.local [1654500190.892160][52059:52064] CHIP:DIS: MINMDNS: IP address fd11:22::5d8c:69ab:1e8:b279 found for DEA31B98844CD240.local [1654500190.892185][52059:52064] CHIP:DIS: Discovered node without a pending query [1654500190.892609][52059:52064] CHIP:DIS: UDP:[fd11:22::5d8c:69ab:1e8:b279%br-db1df168c909]:5540: score has not improved: 6 [1654500190.892713][52059:52064] CHIP:DIS: Checking node lookup status after 6 ms [1654500190.892737][52059:52064] CHIP:DIS: Keeping DNSSD lookup active [1654500190.893029][52059:52064] CHIP:DIS: MINMDNS: received SRV record for 8739F9DA28568034-0000000000000002._matter._tcp.local [1654500190.893073][52059:52064] CHIP:DIS: MINMDNS: Operational SRV for 8739F9DA28568034-0000000000000002: DEA31B98844CD240.local [1654500190.893103][52059:52064] CHIP:DIS: MINMDNS: received TXT record for 8739F9DA28568034-0000000000000002._matter._tcp.local [1654500190.893141][52059:52064] CHIP:DIS: MINMDNS: received (47) record for 8739F9DA28568034-0000000000000002._matter._tcp.local [1654500190.893255][52059:52064] CHIP:DIS: MINMDNS: received SRV record for 8739F9DA28568034-0000000000000002._matter._tcp.local [1654500190.893283][52059:52064] CHIP:DIS: SRV record already actively processed. [1654500190.893308][52059:52064] CHIP:DIS: MINMDNS: received TXT record for 8739F9DA28568034-0000000000000002._matter._tcp.local [1654500190.893339][52059:52064] CHIP:DIS: MINMDNS: received (47) record for 8739F9DA28568034-0000000000000002._matter._tcp.local [1654500190.893443][52059:52064] CHIP:DIS: MINMDNS: received SRV record for 8739F9DA28568034-0000000000000002._matter._tcp.local [1654500190.893470][52059:52064] CHIP:DIS: SRV record already actively processed. [1654500190.893495][52059:52064] CHIP:DIS: MINMDNS: received TXT record for 8739F9DA28568034-0000000000000002._matter._tcp.local [1654500190.893526][52059:52064] CHIP:DIS: MINMDNS: received (47) record for 8739F9DA28568034-0000000000000002._matter._tcp.local [1654500190.893629][52059:52064] CHIP:DIS: MINMDNS: received SRV record for 8739F9DA28568034-0000000000000002._matter._tcp.local [1654500190.893656][52059:52064] CHIP:DIS: SRV record already actively processed. [1654500190.893681][52059:52064] CHIP:DIS: MINMDNS: received TXT record for 8739F9DA28568034-0000000000000002._matter._tcp.local [1654500190.893712][52059:52064] CHIP:DIS: MINMDNS: received (47) record for 8739F9DA28568034-0000000000000002._matter._tcp.local [1654500190.893814][52059:52064] CHIP:DIS: MINMDNS: received SRV record for 8739F9DA28568034-0000000000000002._matter._tcp.local [1654500190.893840][52059:52064] CHIP:DIS: SRV record already actively processed. [1654500190.893865][52059:52064] CHIP:DIS: MINMDNS: received TXT record for 8739F9DA28568034-0000000000000002._matter._tcp.local [1654500190.893896][52059:52064] CHIP:DIS: MINMDNS: received (47) record for 8739F9DA28568034-0000000000000002._matter._tcp.local [1654500190.894057][52059:52064] CHIP:DIS: MINMDNS: Sending query AAAA/UNICAST for DEA31B98844CD240.local [1654500190.896190][52059:52064] CHIP:DIS: MINMDNS: received AAAA record for DEA31B98844CD240.local [1654500190.896263][52059:52064] CHIP:DIS: MINMDNS: IP address fd11:22::5d8c:69ab:1e8:b279 found for DEA31B98844CD240.local [1654500190.896311][52059:52064] CHIP:DIS: Discovered node without a pending query [1654500190.896996][52059:52064] CHIP:DIS: UDP:[fd11:22::5d8c:69ab:1e8:b279%eth0]:5540: score has not improved: 6 [1654500190.897049][52059:52064] CHIP:DIS: Checking node lookup status after 10 ms [1654500190.897077][52059:52064] CHIP:DIS: Keeping DNSSD lookup active [1654500190.897283][52059:52064] CHIP:DIS: MINMDNS: received AAAA record for DEA31B98844CD240.local [1654500190.897449][52059:52064] CHIP:DIS: MINMDNS: received AAAA record for DEA31B98844CD240.local [1654500190.897609][52059:52064] CHIP:DIS: MINMDNS: received AAAA record for DEA31B98844CD240.local [1654500190.989129][52059:52064] CHIP:DIS: MINMDNS: received AAAA record for DEA31B98844CD240.local [1654500190.989230][52059:52064] CHIP:DIS: MINMDNS: received (47) record for DEA31B98844CD240.local [1654500190.989371][52059:52064] CHIP:DIS: MINMDNS: received AAAA record for DEA31B98844CD240.local [1654500190.989427][52059:52064] CHIP:DIS: MINMDNS: received (47) record for DEA31B98844CD240.local [1654500190.989558][52059:52064] CHIP:DIS: MINMDNS: received AAAA record for DEA31B98844CD240.local [1654500190.989614][52059:52064] CHIP:DIS: MINMDNS: received (47) record for DEA31B98844CD240.local [1654500190.989745][52059:52064] CHIP:DIS: MINMDNS: received AAAA record for DEA31B98844CD240.local [1654500190.989798][52059:52064] CHIP:DIS: MINMDNS: received (47) record for DEA31B98844CD240.local [1654500190.990044][52059:52064] CHIP:DIS: MINMDNS: received AAAA record for DEA31B98844CD240.local [1654500190.990102][52059:52064] CHIP:DIS: MINMDNS: received (47) record for DEA31B98844CD240.local [1654500190.990234][52059:52064] CHIP:DIS: MINMDNS: received AAAA record for DEA31B98844CD240.local [1654500190.990288][52059:52064] CHIP:DIS: MINMDNS: received (47) record for DEA31B98844CD240.local [1654500190.990442][52059:52064] CHIP:DIS: MINMDNS: received AAAA record for DEA31B98844CD240.local [1654500190.990515][52059:52064] CHIP:DIS: MINMDNS: received (47) record for DEA31B98844CD240.local [1654500190.990707][52059:52064] CHIP:DIS: MINMDNS: received AAAA record for DEA31B98844CD240.local [1654500190.990781][52059:52064] CHIP:DIS: MINMDNS: received (47) record for DEA31B98844CD240.local [1654500190.990931][52059:52064] CHIP:DIS: MINMDNS: received AAAA record for DEA31B98844CD240.local [1654500190.991002][52059:52064] CHIP:DIS: MINMDNS: received (47) record for DEA31B98844CD240.local [1654500190.991260][52059:52064] CHIP:DIS: MINMDNS: received AAAA record for DEA31B98844CD240.local [1654500190.991330][52059:52064] CHIP:DIS: MINMDNS: received (47) record for DEA31B98844CD240.local [1654500190.991471][52059:52064] CHIP:DIS: MINMDNS: received AAAA record for DEA31B98844CD240.local [1654500190.991535][52059:52064] CHIP:DIS: MINMDNS: received (47) record for DEA31B98844CD240.local [1654500190.991674][52059:52064] CHIP:DIS: MINMDNS: received AAAA record for DEA31B98844CD240.local [1654500190.991739][52059:52064] CHIP:DIS: MINMDNS: received (47) record for DEA31B98844CD240.local [1654500190.991878][52059:52064] CHIP:DIS: MINMDNS: received AAAA record for DEA31B98844CD240.local [1654500190.991942][52059:52064] CHIP:DIS: MINMDNS: received (47) record for DEA31B98844CD240.local [1654500190.992082][52059:52064] CHIP:DIS: MINMDNS: received AAAA record for DEA31B98844CD240.local [1654500190.992147][52059:52064] CHIP:DIS: MINMDNS: received (47) record for DEA31B98844CD240.local [1654500190.992392][52059:52064] CHIP:DIS: MINMDNS: received AAAA record for DEA31B98844CD240.local [1654500190.992459][52059:52064] CHIP:DIS: MINMDNS: received (47) record for DEA31B98844CD240.local [1654500190.992599][52059:52064] CHIP:DIS: MINMDNS: received AAAA record for DEA31B98844CD240.local [1654500190.992662][52059:52064] CHIP:DIS: MINMDNS: received (47) record for DEA31B98844CD240.local [1654500190.992799][52059:52064] CHIP:DIS: MINMDNS: received AAAA record for DEA31B98844CD240.local [1654500190.992863][52059:52064] CHIP:DIS: MINMDNS: received (47) record for DEA31B98844CD240.local [1654500190.993005][52059:52064] CHIP:DIS: MINMDNS: received AAAA record for DEA31B98844CD240.local [1654500190.993070][52059:52064] CHIP:DIS: MINMDNS: received (47) record for DEA31B98844CD240.local [1654500190.993208][52059:52064] CHIP:DIS: MINMDNS: received AAAA record for DEA31B98844CD240.local [1654500190.993272][52059:52064] CHIP:DIS: MINMDNS: received (47) record for DEA31B98844CD240.local [1654500190.993571][52059:52064] CHIP:DIS: MINMDNS: received AAAA record for DEA31B98844CD240.local [1654500190.993639][52059:52064] CHIP:DIS: MINMDNS: received (47) record for DEA31B98844CD240.local [1654500191.086981][52059:52064] CHIP:DIS: Checking node lookup status after 200 ms [1654500191.087085][52059:52064] CHIP:CTL: Updating device address to UDP:[fd11:22::5d8c:69ab:1e8:b279]:5540 while in state 2 [1654500191.087140][52059:52064] CHIP:CTL: OperationalDeviceProxy[8739F9DA28568034:0000000000000002]: State change 2 --> 3 [1654500191.087508][52059:52064] CHIP:IN: SecureSession Allocated 0xaaaae50a1a90 Type:2 LSID:26517 [1654500191.087590][52059:52064] CHIP:SC: Initiating session on local FabricIndex 1 from 0x000000000001B669 -> 0x0000000000000002 [1654500191.089626][52059:52064] CHIP:SC: Including MRP parameters [1654500191.090329][52059:52064] CHIP:IN: Prepared unauthenticated message 0xaaaae50a2df8 to 0x0000000000000000 (0) of type 0x30 and protocolId (0, 0) on exchange 31539i with MessageCounter:3194463925. [1654500191.090436][52059:52064] CHIP:IN: Sending unauthenticated msg 0xaaaae50a2df8 with MessageCounter:3194463925 to 0x0000000000000000 at monotonic time: 0000000019076F8F msec [1654500191.090836][52059:52064] CHIP:SC: Sent Sigma1 msg [1654500191.090912][52059:52064] CHIP:CTL: OperationalDeviceProxy[8739F9DA28568034:0000000000000002]: State change 3 --> 4 [1654500191.090977][52059:52064] CHIP:DIS: Discovery does not require any more timeouts [1654500192.701328][52059:52064] CHIP:EM: Received message of type 0x31 with protocolId (0, 0) and MessageCounter:3860072770 on exchange 31539i [1654500192.701435][52059:52064] CHIP:EM: Found matching exchange: 31539i, Delegate: 0xffff700015a0 [1654500192.701530][52059:52064] CHIP:EM: Rxd Ack; Removing MessageCounter:3194463925 from Retrans Table on exchange 31539i [1654500192.701591][52059:52064] CHIP:EM: Removed CHIP MessageCounter:3194463925 from RetransTable on exchange 31539i [1654500192.701671][52059:52064] CHIP:SC: Received Sigma2 msg [1654500192.701749][52059:52064] CHIP:SC: Peer assigned session session ID 29073 [1654500192.709405][52059:52064] CHIP:SC: Found MRP parameters in the message [1654500192.709506][52059:52064] CHIP:SC: Sending Sigma3 [1654500192.710168][52059:52064] CHIP:EM: Piggybacking Ack for MessageCounter:3860072770 on exchange: 31539i [1654500192.710360][52059:52064] CHIP:IN: Prepared unauthenticated message 0xaaaae50a2df8 to 0x0000000000000000 (0) of type 0x32 and protocolId (0, 0) on exchange 31539i with MessageCounter:3194463926. [1654500192.710460][52059:52064] CHIP:IN: Sending unauthenticated msg 0xaaaae50a2df8 with MessageCounter:3194463926 to 0x0000000000000000 at monotonic time: 00000000190775E3 msec [1654500192.710850][52059:52064] CHIP:SC: Sent Sigma3 msg [1654500193.062548][52059:52064] CHIP:EM: Retransmitting MessageCounter:3194463926 on exchange 31539i Send Cnt 1 [1654500193.062781][52059:52064] CHIP:IN: Sending unauthenticated msg 0xaaaae50a2df8 with MessageCounter:3194463926 to 0x0000000000000000 at monotonic time: 0000000019077744 msec [1654500193.399697][52059:52064] CHIP:EM: Retransmitting MessageCounter:3194463926 on exchange 31539i Send Cnt 2 [1654500193.399901][52059:52064] CHIP:IN: Sending unauthenticated msg 0xaaaae50a2df8 with MessageCounter:3194463926 to 0x0000000000000000 at monotonic time: 0000000019077895 msec [1654500193.921983][52059:52064] CHIP:EM: Retransmitting MessageCounter:3194463926 on exchange 31539i Send Cnt 3 [1654500193.922177][52059:52064] CHIP:IN: Sending unauthenticated msg 0xaaaae50a2df8 with MessageCounter:3194463926 to 0x0000000000000000 at monotonic time: 0000000019077A9F msec [1654500194.845659][52059:52064] CHIP:EM: Retransmitting MessageCounter:3194463926 on exchange 31539i Send Cnt 4 [1654500194.845864][52059:52064] CHIP:IN: Sending unauthenticated msg 0xaaaae50a2df8 with MessageCounter:3194463926 to 0x0000000000000000 at monotonic time: 0000000019077E3B msec [1654500195.164935][52059:52064] CHIP:EM: Received message of type 0x40 with protocolId (0, 0) and MessageCounter:3860072771 on exchange 31539i [1654500195.165042][52059:52064] CHIP:EM: Found matching exchange: 31539i, Delegate: 0xffff700015a0 [1654500195.165135][52059:52064] CHIP:EM: Rxd Ack; Removing MessageCounter:3194463926 from Retrans Table on exchange 31539i [1654500195.165195][52059:52064] CHIP:EM: Removed CHIP MessageCounter:3194463926 from RetransTable on exchange 31539i [1654500195.165277][52059:52064] CHIP:SC: Success status report received. Session was established [1654500195.168079][52059:52064] CHIP:SC: Unable to delete session resumption link for node 0000000000000002: ../examples/chip-tool/config/PersistentStorage.cpp:140: CHIP Error 0x000000A0: Value not found in the persisted storage [1654500195.191396][52059:52064] CHIP:IN: SecureSession Active 0xaaaae50a1a90 Type:2 LSID:26517 [1654500195.191444][52059:52064] CHIP:IN: New secure session created for device <0000000000000002, 1>, LSID:26517 PSID:29073! [1654500195.191473][52059:52064] CHIP:CTL: OperationalDeviceProxy[8739F9DA28568034:0000000000000002]: State change 4 --> 5 [1654500195.191534][52059:52064] CHIP:TOO: Sending ReadAttribute to: [1654500195.191560][52059:52064] CHIP:TOO: cluster 0x0000_0030, attribute: 0x0000_FFFC, endpoint 0 [1654500195.191598][52059:52064] CHIP:DMG: SendReadRequest ReadClient[0xffff70009450]: Sending Read Request [1654500195.191732][52059:52064] CHIP:IN: Prepared secure message 0xaaaae50a2df8 to 0x0000000000000002 (1) of type 0x2 and protocolId (0, 1) on exchange 31540i with MessageCounter:37232. [1654500195.191774][52059:52064] CHIP:IN: Sending encrypted msg 0xaaaae50a2df8 with MessageCounter:37232 to 0x0000000000000002 (1) at monotonic time: 0000000019077F95 msec [1654500195.191979][52059:52064] CHIP:DMG: MoveToState ReadClient[0xffff70009450]: Moving to [AwaitingIn] [1654500195.192032][52059:52064] CHIP:EM: Sending Standalone Ack for MessageCounter:3860072771 on exchange 31539i [1654500195.192074][52059:52064] CHIP:IN: Prepared unauthenticated message 0xffff837ed9c8 to 0x0000000000000000 (0) of type 0x10 and protocolId (0, 0) on exchange 31539i with MessageCounter:3194463927. [1654500195.192109][52059:52064] CHIP:IN: Sending unauthenticated msg 0xffff837ed9c8 with MessageCounter:3194463927 to 0x0000000000000000 at monotonic time: 0000000019077F95 msec [1654500195.192194][52059:52064] CHIP:EM: Flushed pending ack for MessageCounter:3860072771 on exchange 31539i [1654500195.213017][52059:52064] CHIP:EM: Received message of type 0x10 with protocolId (0, 0) and MessageCounter:3860072772 on exchange 31539i [1654500195.213116][52059:52064] CHIP:EM: OnMessageReceived failed, err = ../examples/chip-tool/third_party/connectedhomeip/src/messaging/ExchangeMgr.cpp:265: CHIP Error 0x00000070: Unsolicited msg with originator bit clear [1654500195.273771][52059:52064] CHIP:EM: Received message of type 0x10 with protocolId (0, 0) and MessageCounter:3860072773 on exchange 31539i [1654500195.273869][52059:52064] CHIP:EM: OnMessageReceived failed, err = ../examples/chip-tool/third_party/connectedhomeip/src/messaging/ExchangeMgr.cpp:265: CHIP Error 0x00000070: Unsolicited msg with originator bit clear [1654500195.331333][52059:52064] CHIP:EM: Received message of type 0x10 with protocolId (0, 0) and MessageCounter:3860072774 on exchange 31539i [1654500195.331447][52059:52064] CHIP:EM: OnMessageReceived failed, err = ../examples/chip-tool/third_party/connectedhomeip/src/messaging/ExchangeMgr.cpp:265: CHIP Error 0x00000070: Unsolicited msg with originator bit clear [1654500195.387569][52059:52064] CHIP:EM: Received message of type 0x10 with protocolId (0, 0) and MessageCounter:3860072775 on exchange 31539i [1654500195.387646][52059:52064] CHIP:EM: OnMessageReceived failed, err = ../examples/chip-tool/third_party/connectedhomeip/src/messaging/ExchangeMgr.cpp:265: CHIP Error 0x00000070: Unsolicited msg with originator bit clear [1654500195.444553][52059:52064] CHIP:EM: Received message of type 0x5 with protocolId (0, 1) and MessageCounter:8540140 on exchange 31540i [1654500195.444654][52059:52064] CHIP:EM: Found matching exchange: 31540i, Delegate: 0xffff70009450 [1654500195.444749][52059:52064] CHIP:EM: Rxd Ack; Removing MessageCounter:37232 from Retrans Table on exchange 31540i [1654500195.444799][52059:52064] CHIP:EM: Removed CHIP MessageCounter:37232 from RetransTable on exchange 31540i [1654500195.444910][52059:52064] CHIP:DMG: ReportDataMessage = [1654500195.444977][52059:52064] CHIP:DMG: { [1654500195.445030][52059:52064] CHIP:DMG: AttributeReportIBs = [1654500195.445105][52059:52064] CHIP:DMG: [ [1654500195.445196][52059:52064] CHIP:DMG: AttributeReportIB = [1654500195.445289][52059:52064] CHIP:DMG: { [1654500195.445377][52059:52064] CHIP:DMG: AttributeDataIB = [1654500195.445457][52059:52064] CHIP:DMG: { [1654500195.445556][52059:52064] CHIP:DMG: DataVersion = 0x83b91302, [1654500195.445636][52059:52064] CHIP:DMG: AttributePathIB = [1654500195.445744][52059:52064] CHIP:DMG: { [1654500195.445850][52059:52064] CHIP:DMG: Endpoint = 0x0, [1654500195.445938][52059:52064] CHIP:DMG: Cluster = 0x30, [1654500195.446055][52059:52064] CHIP:DMG: Attribute = 0x0000_FFFC, [1654500195.446137][52059:52064] CHIP:DMG: } [1654500195.446248][52059:52064] CHIP:DMG: [1654500195.446335][52059:52064] CHIP:DMG: Data = 6, [1654500195.446442][52059:52064] CHIP:DMG: }, [1654500195.446535][52059:52064] CHIP:DMG: [1654500195.446644][52059:52064] CHIP:DMG: }, [1654500195.446723][52059:52064] CHIP:DMG: [1654500195.446783][52059:52064] CHIP:DMG: ], [1654500195.446877][52059:52064] CHIP:DMG: [1654500195.446940][52059:52064] CHIP:DMG: SuppressResponse = true, [1654500195.447023][52059:52064] CHIP:DMG: InteractionModelRevision = 1 [1654500195.447080][52059:52064] CHIP:DMG: } [1654500195.447398][52059:52064] CHIP:TOO: Endpoint: 0 Cluster: 0x0000_0030 Attribute 0x0000_FFFC DataVersion: 2209944322 [1654500195.447542][52059:52064] CHIP:TOO: FeatureMap: 6 [1654500195.447729][52059:52064] CHIP:EM: Sending Standalone Ack for MessageCounter:8540140 on exchange 31540i [1654500195.447890][52059:52064] CHIP:IN: Prepared secure message 0xffff837ed9d8 to 0x0000000000000002 (1) of type 0x10 and protocolId (0, 0) on exchange 31540i with MessageCounter:37233. [1654500195.447980][52059:52064] CHIP:IN: Sending encrypted msg 0xffff837ed9d8 with MessageCounter:37233 to 0x0000000000000002 (1) at monotonic time: 0000000019078095 msec [1654500195.448258][52059:52064] CHIP:EM: Flushed pending ack for MessageCounter:8540140 on exchange 31540i [1654500195.448680][52059:52059] CHIP:CTL: Shutting down the commissioner [1654500195.448945][52059:52059] CHIP:CTL: Shutting down the controller [1654500195.449020][52059:52059] CHIP:CTL: Shutting down the commissioner [1654500195.449207][52059:52059] CHIP:CTL: Shutting down the controller [1654500195.449278][52059:52059] CHIP:IN: Expiring all connections for fabric 1!! [1654500195.449335][52059:52059] CHIP:IN: SecureSession MarkForRemoval 0xaaaae50a1a90 Type:2 LSID:26517 [1654500195.449390][52059:52059] CHIP:IN: SecureSession Released 0xaaaae50a1a90 Type:2 LSID:26517 [1654500195.449485][52059:52059] CHIP:CTL: Shutting down the commissioner [1654500195.449673][52059:52059] CHIP:CTL: Shutting down the controller [1654500195.449731][52059:52059] CHIP:IN: Expiring all connections for fabric 2!! [1654500195.449810][52059:52059] CHIP:CTL: Shutting down the commissioner [1654500195.449995][52059:52059] CHIP:CTL: Shutting down the controller [1654500195.450051][52059:52059] CHIP:IN: Expiring all connections for fabric 3!! [1654500195.450121][52059:52059] CHIP:CTL: Shutting down the System State, this will teardown the CHIP Stack [1654500195.451676][52059:52059] CHIP:DMG: IM WH moving to [Uninitialized] [1654500195.451743][52059:52059] CHIP:DMG: IM WH moving to [Uninitialized] [1654500195.451792][52059:52059] CHIP:DMG: IM WH moving to [Uninitialized] [1654500195.451841][52059:52059] CHIP:DMG: IM WH moving to [Uninitialized] [1654500195.451893][52059:52059] CHIP:DMG: All ReadHandler-s are clean, clear GlobalDirtySet [1654500195.452073][52059:52059] CHIP:BLE: BleConnectionDelegate::CancelConnection is not implemented. [1654500195.452506][52059:52059] CHIP:DL: writing settings to file (/tmp/chip_counters.ini-XAAOxt) [1654500195.453836][52059:52059] CHIP:DL: renamed tmp file to file (/tmp/chip_counters.ini) [1654500195.453953][52059:52059] CHIP:DL: NVS set: chip-counters/total-operational-hours = 0 (0x0) [1654500195.454016][52059:52059] CHIP:DL: Inet Layer shutdown [1654500195.454067][52059:52059] CHIP:DL: BLE shutdown [1654500195.454118][52059:52059] CHIP:DL: System Layer shutdown