ubuntu@ubuntu:~/May3_cntr/connectedhomeip/examples/chip-tool/out/debug$ ./chip-tool generalcommissioning read feature-map 1 0 [1651640662.350417][2914:2914] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_kvs [1651640662.350995][2914:2914] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_factory.ini [1651640662.351172][2914:2914] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_config.ini [1651640662.351292][2914:2914] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_counters.ini [1651640662.351612][2914:2914] CHIP:DL: writing settings to file (/tmp/chip_counters.ini-stW2C1) [1651640662.352236][2914:2914] CHIP:DL: renamed tmp file to file (/tmp/chip_counters.ini) [1651640662.352287][2914:2914] CHIP:DL: NVS set: chip-counters/reboot-count = 2 (0x2) [1651640662.353163][2914:2914] CHIP:DL: Got Ethernet interface: eth0 [1651640662.353789][2914:2914] CHIP:DL: Found the primary Ethernet interface:eth0 [1651640662.354442][2914:2914] CHIP:DL: Got WiFi interface: wlan0 [1651640662.354518][2914:2914] CHIP:DL: Failed to reset WiFi statistic counts [1651640662.354610][2914:2914] CHIP:IN: UDP::Init bind&listen port=0 [1651640662.354743][2914:2914] CHIP:IN: UDP::Init bound to port=36224 [1651640662.354768][2914:2914] CHIP:IN: BLEBase::Init - setting/overriding transport [1651640662.354790][2914:2914] CHIP:IN: TransportMgr initialized [1651640662.354826][2914:2914] CHIP:DIS: Init fabric pairing table with server storage [1651640662.354965][2914:2914] CHIP:IN: Loading from storage for fabric index 0x1 [1651640662.358047][2914:2914] CHIP:IN: Loading from storage for fabric index 0x2 [1651640662.358830][2914:2914] CHIP:IN: Loading from storage for fabric index 0x3 [1651640662.359601][2914:2914] CHIP:DIS: Add fabric pairing table delegate [1651640662.363243][2914:2914] CHIP:ZCL: Using ZAP configuration... [1651640662.368120][2914:2914] CHIP:DL: Avahi client registered [1651640662.369411][2914:2914] CHIP:CTL: System State Initialized... [1651640662.369538][2914:2914] CHIP:CTL: Setting attestation nonce to random value [1651640662.369593][2914:2914] CHIP:CTL: Setting CSR nonce to random value [1651640662.369672][2914:2914] CHIP:IN: UDP::Init bind&listen port=5550 [1651640662.369827][2914:2914] CHIP:IN: UDP::Init bound to port=5550 [1651640662.369852][2914:2914] CHIP:IN: TransportMgr initialized [1651640662.369927][2914:2914] CHIP:CTL: Setting attestation nonce to random value [1651640662.369979][2914:2914] CHIP:CTL: Setting CSR nonce to random value [1651640662.371034][2914:2914] CHIP:CTL: Generating NOC [1651640662.371981][2914:2914] CHIP:DIS: Verifying the received credentials [1651640662.373837][2914:2914] CHIP:DIS: Added new fabric at index: 0x1, Initialized: 1 [1651640662.373874][2914:2914] CHIP:DIS: Assigned compressed fabric ID: 0x9C5F092678988D71, node ID: 0x000000000001B669 [1651640662.373900][2914:2914] CHIP:CTL: Joined the fabric at index 1. Compressed fabric ID is: 0x9C5F092678988D71 [1651640662.373945][2914:2914] CHIP:IN: UDP::Init bind&listen port=5550 [1651640662.374118][2914:2914] CHIP:IN: UDP::Init bound to port=5550 [1651640662.374146][2914:2914] CHIP:IN: TransportMgr initialized [1651640662.374243][2914:2914] CHIP:CTL: Setting attestation nonce to random value [1651640662.374305][2914:2914] CHIP:CTL: Setting CSR nonce to random value [1651640662.375192][2914:2914] CHIP:CTL: Generating NOC [1651640662.376219][2914:2914] CHIP:DIS: Verifying the received credentials [1651640662.378376][2914:2914] CHIP:DIS: Added new fabric at index: 0x2, Initialized: 1 [1651640662.378422][2914:2914] CHIP:DIS: Assigned compressed fabric ID: 0x49A03E044BF8278F, node ID: 0x000000000001B669 [1651640662.378452][2914:2914] CHIP:CTL: Joined the fabric at index 2. Compressed fabric ID is: 0x49A03E044BF8278F [1651640662.378505][2914:2914] CHIP:IN: UDP::Init bind&listen port=5550 [1651640662.378655][2914:2914] CHIP:IN: UDP::Init bound to port=5550 [1651640662.378685][2914:2914] CHIP:IN: TransportMgr initialized [1651640662.378799][2914:2914] CHIP:CTL: Setting attestation nonce to random value [1651640662.378872][2914:2914] CHIP:CTL: Setting CSR nonce to random value [1651640662.379882][2914:2914] CHIP:CTL: Generating NOC [1651640662.380965][2914:2914] CHIP:DIS: Verifying the received credentials [1651640662.383110][2914:2914] CHIP:DIS: Added new fabric at index: 0x3, Initialized: 1 [1651640662.383153][2914:2914] CHIP:DIS: Assigned compressed fabric ID: 0x5DD8E09E8A24A0D9, node ID: 0x000000000001B669 [1651640662.383182][2914:2914] CHIP:CTL: Joined the fabric at index 3. Compressed fabric ID is: 0x5DD8E09E8A24A0D9 [1651640662.383230][2914:2914] CHIP:IN: UDP::Init bind&listen port=5550 [1651640662.383375][2914:2914] CHIP:IN: UDP::Init bound to port=5550 [1651640662.383405][2914:2914] CHIP:IN: TransportMgr initialized [1651640662.426846][2914:2920] CHIP:DL: CHIP task running [1651640662.427094][2914:2920] CHIP:DL: HandlePlatformSpecificBLEEvent 32787 [1651640662.427129][2914:2920] CHIP:TOO: Sending command to node 0x1 [1651640662.427166][2914:2920] CHIP:CSM: FindOrEstablishSession: PeerId = 9C5F092678988D71:0000000000000001 [1651640662.427194][2914:2920] CHIP:CSM: FindOrEstablishSession: No existing OperationalDeviceProxy instance found [1651640662.427241][2914:2920] CHIP:DIS: Resolving 9C5F092678988D71:0000000000000001 ... [1651640662.538107][2914:2920] CHIP:DL: Avahi resolve found [1651640662.538215][2914:2920] CHIP:DIS: Node ID resolved for 9C5F092678988D71:0000000000000001 [1651640662.538260][2914:2920] CHIP:DIS: Addr 0: [fe80::e65f:1ff:fe0f:2877]:5540 [1651640662.538589][2914:2920] CHIP:DIS: UDP:[fe80::e65f:1ff:fe0f:2877%eth0]:5540: new best score: 3 [1651640662.538633][2914:2920] CHIP:DIS: Checking node lookup status after 111 ms [1651640662.538665][2914:2920] CHIP:DIS: Keeping DNSSD lookup active [1651640662.627868][2914:2920] CHIP:DIS: Checking node lookup status after 200 ms [1651640662.628045][2914:2920] CHIP:CTL: Updating device address to UDP:[fe80::e65f:1ff:fe0f:2877%eth0]:5540 while in state 1 [1651640662.628074][2914:2920] CHIP:CTL: OperationalDeviceProxy[9C5F092678988D71:0000000000000001]: State change 1 --> 2 [1651640662.628284][2914:2920] CHIP:SC: Initiating session on local FabricIndex 1 from 0x000000000001B669 -> 0x0000000000000001 [1651640662.629077][2914:2920] CHIP:SC: Including MRP parameters [1651640662.629326][2914:2920] CHIP:IN: Prepared unauthenticated message 0xaaaadd073698 to 0x0000000000000000 (0) of type 0x30 and protocolId (0, 0) on exchange 39508i with MessageCounter:2990102374. [1651640662.629385][2914:2920] CHIP:IN: Sending unauthenticated msg 0xaaaadd073698 with MessageCounter:2990102374 to 0x0000000000000000 at monotonic time: 0000000000176D07 msec [1651640662.629572][2914:2920] CHIP:SC: Sent Sigma1 msg [1651640662.629606][2914:2920] CHIP:CTL: OperationalDeviceProxy[9C5F092678988D71:0000000000000001]: State change 2 --> 3 [1651640662.629635][2914:2920] CHIP:DIS: Discovery does not require any more timeouts [1651640662.632058][2914:2920] CHIP:EM: Received message of type 0x33 with protocolId (0, 0) and MessageCounter:3085356089 on exchange 39508i [1651640662.632114][2914:2920] CHIP:EM: Found matching exchange: 39508i, Delegate: 0xffff8c001180 [1651640662.632158][2914:2920] CHIP:EM: Rxd Ack; Removing MessageCounter:2990102374 from Retrans Table on exchange 39508i [1651640662.632182][2914:2920] CHIP:EM: Removed CHIP MessageCounter:2990102374 from RetransTable on exchange 39508i [1651640662.632217][2914:2920] CHIP:SC: Received Sigma2Resume msg [1651640662.632321][2914:2920] CHIP:SC: Found MRP parameters in the message [1651640662.632351][2914:2920] CHIP:SC: Peer assigned session session ID 17370 [1651640662.636692][2914:2920] CHIP:SC: Sending status report. Protocol code 0, exchange 39508 [1651640662.636764][2914:2920] CHIP:EM: Piggybacking Ack for MessageCounter:3085356089 on exchange: 39508i [1651640662.636813][2914:2920] CHIP:IN: Prepared unauthenticated message 0xaaaadd073698 to 0x0000000000000000 (0) of type 0x40 and protocolId (0, 0) on exchange 39508i with MessageCounter:2990102375. [1651640662.636859][2914:2920] CHIP:IN: Sending unauthenticated msg 0xaaaadd073698 with MessageCounter:2990102375 to 0x0000000000000000 at monotonic time: 0000000000176D0E msec [1651640662.637114][2914:2920] CHIP:IN: New secure session created for device <0000000000000001, 1>, LSID:51376 PSID:17370! [1651640662.637151][2914:2920] CHIP:CTL: OperationalDeviceProxy[9C5F092678988D71:0000000000000001]: State change 3 --> 4 [1651640662.637208][2914:2920] CHIP:TOO: Sending ReadAttribute to: [1651640662.637233][2914:2920] CHIP:TOO: cluster 0x0000_0030, attribute: 0x0000_FFFC, endpoint 0 [1651640662.637268][2914:2920] CHIP:DMG: SendReadRequest ReadClient[0xffff8c004080]: Sending Read Request [1651640662.637375][2914:2920] CHIP:IN: Prepared secure message 0xaaaadd0736b8 to 0x0000000000000001 (1) of type 0x2 and protocolId (0, 1) on exchange 39509i with MessageCounter:6609279. [1651640662.637413][2914:2920] CHIP:IN: Sending encrypted msg 0xaaaadd0736b8 with MessageCounter:6609279 to 0x0000000000000001 (1) at monotonic time: 0000000000176D0F msec [1651640662.637533][2914:2920] CHIP:DMG: MoveToState ReadClient[0xffff8c004080]: Moving to [AwaitingIn] [1651640662.643705][2914:2920] CHIP:EM: Received message of type 0x10 with protocolId (0, 0) and MessageCounter:3085356090 on exchange 39508i [1651640662.643751][2914:2920] CHIP:EM: Found matching exchange: 39508i, Delegate: (nil) [1651640662.643800][2914:2920] CHIP:EM: Rxd Ack; Removing MessageCounter:2990102375 from Retrans Table on exchange 39508i [1651640662.643831][2914:2920] CHIP:EM: Removed CHIP MessageCounter:2990102375 from RetransTable on exchange 39508i [1651640662.645530][2914:2920] CHIP:EM: Received message of type 0x5 with protocolId (0, 1) and MessageCounter:713637 on exchange 39509i [1651640662.645567][2914:2920] CHIP:EM: Found matching exchange: 39509i, Delegate: 0xffff8c004080 [1651640662.645603][2914:2920] CHIP:EM: Rxd Ack; Removing MessageCounter:6609279 from Retrans Table on exchange 39509i [1651640662.645632][2914:2920] CHIP:EM: Removed CHIP MessageCounter:6609279 from RetransTable on exchange 39509i [1651640662.645698][2914:2920] CHIP:DMG: ReportDataMessage = [1651640662.645730][2914:2920] CHIP:DMG: { [1651640662.645757][2914:2920] CHIP:DMG: AttributeReportIBs = [1651640662.645794][2914:2920] CHIP:DMG: [ [1651640662.645824][2914:2920] CHIP:DMG: AttributeReportIB = [1651640662.645867][2914:2920] CHIP:DMG: { [1651640662.645899][2914:2920] CHIP:DMG: AttributeDataIB = [1651640662.645934][2914:2920] CHIP:DMG: { [1651640662.645972][2914:2920] CHIP:DMG: DataVersion = 0x8910cdf8, [1651640662.646011][2914:2920] CHIP:DMG: AttributePathIB = [1651640662.646074][2914:2920] CHIP:DMG: { [1651640662.646129][2914:2920] CHIP:DMG: Endpoint = 0x0, [1651640662.646176][2914:2920] CHIP:DMG: Cluster = 0x30, [1651640662.646220][2914:2920] CHIP:DMG: Attribute = 0x0000_FFFC, [1651640662.646265][2914:2920] CHIP:DMG: } [1651640662.646308][2914:2920] CHIP:DMG: [1651640662.646349][2914:2920] CHIP:DMG: Data = 6, [1651640662.646393][2914:2920] CHIP:DMG: }, [1651640662.646433][2914:2920] CHIP:DMG: [1651640662.646467][2914:2920] CHIP:DMG: }, [1651640662.646506][2914:2920] CHIP:DMG: [1651640662.646536][2914:2920] CHIP:DMG: ], [1651640662.646573][2914:2920] CHIP:DMG: [1651640662.646604][2914:2920] CHIP:DMG: SuppressResponse = true, [1651640662.646635][2914:2920] CHIP:DMG: InteractionModelRevision = 1 [1651640662.646719][2914:2920] CHIP:DMG: } [1651640662.646912][2914:2920] CHIP:TOO: Endpoint: 0 Cluster: 0x0000_0030 Attribute 0x0000_FFFC DataVersion: 2299579896 [1651640662.647031][2914:2920] CHIP:TOO: FeatureMap: 6 [1651640662.649910][2914:2920] CHIP:EM: Sending Standalone Ack for MessageCounter:713637 on exchange 39509i [1651640662.650029][2914:2920] CHIP:IN: Prepared secure message 0xffff9efdd968 to 0x0000000000000001 (1) of type 0x10 and protocolId (0, 0) on exchange 39509i with MessageCounter:6609280. [1651640662.650140][2914:2920] CHIP:IN: Sending encrypted msg 0xffff9efdd968 with MessageCounter:6609280 to 0x0000000000000001 (1) at monotonic time: 0000000000176D1C msec [1651640662.650309][2914:2920] CHIP:EM: Flushed pending ack for MessageCounter:713637 on exchange 39509i [1651640662.650600][2914:2914] CHIP:CTL: Shutting down the commissioner [1651640662.650734][2914:2914] CHIP:CTL: Shutting down the controller [1651640662.650783][2914:2914] CHIP:CTL: Shutting down the commissioner [1651640662.650868][2914:2914] CHIP:CTL: Shutting down the controller [1651640662.650917][2914:2914] CHIP:IN: Expiring all connections for fabric 1!! [1651640662.650989][2914:2914] CHIP:CTL: Shutting down the commissioner [1651640662.651075][2914:2914] CHIP:CTL: Shutting down the controller [1651640662.651113][2914:2914] CHIP:IN: Expiring all connections for fabric 2!! [1651640662.651168][2914:2914] CHIP:CTL: Shutting down the commissioner [1651640662.651252][2914:2914] CHIP:CTL: Shutting down the controller [1651640662.651289][2914:2914] CHIP:IN: Expiring all connections for fabric 3!! [1651640662.651336][2914:2914] CHIP:CTL: Shutting down the System State, this will teardown the CHIP Stack [1651640662.652675][2914:2914] CHIP:DMG: IM WH moving to [Uninitialized] [1651640662.652734][2914:2914] CHIP:DMG: IM WH moving to [Uninitialized] [1651640662.652766][2914:2914] CHIP:DMG: IM WH moving to [Uninitialized] [1651640662.652798][2914:2914] CHIP:DMG: IM WH moving to [Uninitialized] [1651640662.652833][2914:2914] CHIP:DMG: All ReadHandler-s are clean, clear GlobalDirtySet [1651640662.652932][2914:2914] CHIP:BLE: BleConnectionDelegate::CancelConnection is not implemented. [1651640662.653300][2914:2914] CHIP:DL: writing settings to file (/tmp/chip_counters.ini-4wu2MF) [1651640662.654384][2914:2914] CHIP:DL: renamed tmp file to file (/tmp/chip_counters.ini) [1651640662.654482][2914:2914] CHIP:DL: NVS set: chip-counters/total-operational-hours = 0 (0x0) [1651640662.654519][2914:2914] CHIP:DL: Inet Layer shutdown [1651640662.654548][2914:2914] CHIP:DL: BLE shutdown [1651640662.654607][2914:2914] CHIP:DL: System Layer shutdown