ubuntu@ubuntu:~/master/connectedhomeip/examples/chip-tool/out/debug$ ./chip-tool radonconcentrationmeasurement read cluster-revision 1 1 [1687339426.035713][5060:5060] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_kvs [1687339426.050833][5060:5060] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_factory.ini [1687339426.051335][5060:5060] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_config.ini [1687339426.051632][5060:5060] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_counters.ini [1687339426.052409][5060:5060] CHIP:DL: writing settings to file (/tmp/chip_counters.ini-TvBp77) [1687339426.053762][5060:5060] CHIP:DL: renamed tmp file to file (/tmp/chip_counters.ini) [1687339426.053888][5060:5060] CHIP:DL: NVS set: chip-counters/reboot-count = 52 (0x34) [1687339426.056096][5060:5060] CHIP:DL: Got Ethernet interface: eth0 [1687339426.058125][5060:5060] CHIP:DL: Found the primary Ethernet interface:eth0 [1687339426.059997][5060:5060] CHIP:DL: Got WiFi interface: wlan0 [1687339426.060164][5060:5060] CHIP:DL: Failed to reset WiFi statistic counts [1687339426.060331][5060:5060] CHIP:IN: UDP::Init bind&listen port=0 [1687339426.060585][5060:5060] CHIP:IN: UDP::Init bound to port=36994 [1687339426.060640][5060:5060] CHIP:IN: BLEBase::Init - setting/overriding transport [1687339426.060690][5060:5060] CHIP:IN: TransportMgr initialized [1687339426.060762][5060:5060] CHIP:FP: Initializing FabricTable from persistent storage [1687339426.061074][5060:5060] CHIP:TS: Last Known Good Time: 2023-06-19T05:36:12 [1687339426.065056][5060:5060] CHIP:FP: Fabric index 0x1 was retrieved from storage. Compressed FabricId 0x1B16FB350151CB67, FabricId 0x0000000000000001, NodeId 0x000000000001B669, VendorId 0xFFF1 [1687339426.069800][5060:5060] CHIP:ZCL: Using ZAP configuration... [1687339426.079529][5060:5060] CHIP:DL: Avahi client registered [1687339426.082675][5060:5060] CHIP:CTL: System State Initialized... [1687339426.082884][5060:5060] CHIP:CTL: Stopping commissioning discovery over DNS-SD [1687339426.082978][5060:5060] CHIP:CTL: Setting attestation nonce to random value [1687339426.083067][5060:5060] CHIP:CTL: Setting CSR nonce to random value [1687339426.083198][5060:5060] CHIP:IN: UDP::Init bind&listen port=5550 [1687339426.083478][5060:5060] CHIP:IN: UDP::Init bound to port=5550 [1687339426.083536][5060:5060] CHIP:IN: TransportMgr initialized [1687339426.084098][5060:5062] CHIP:DL: CHIP task running [1687339426.084521][5060:5062] CHIP:DL: HandlePlatformSpecificBLEEvent 32784 [1687339426.085121][5060:5062] CHIP:CTL: Stopping commissioning discovery over DNS-SD [1687339426.085242][5060:5062] CHIP:CTL: Setting attestation nonce to random value [1687339426.085622][5060:5062] CHIP:CTL: Setting CSR nonce to random value [1687339426.087773][5060:5062] CHIP:CTL: Generating NOC [1687339426.089989][5060:5062] CHIP:FP: Validating NOC chain [1687339426.094749][5060:5062] CHIP:FP: NOC chain validation successful [1687339426.095169][5060:5062] CHIP:FP: Updated fabric at index: 0x1, Node ID: 0x000000000001B669 [1687339426.095247][5060:5062] CHIP:TS: Last Known Good Time: 2023-06-19T05:36:12 [1687339426.095302][5060:5062] CHIP:TS: New proposed Last Known Good Time: 2021-01-01T00:00:00 [1687339426.095365][5060:5062] CHIP:TS: Retaining current Last Known Good Time [1687339426.107558][5060:5062] CHIP:FP: Metadata for Fabric 0x1 persisted to storage. [1687339426.112107][5060:5062] CHIP:TS: Committing Last Known Good Time to storage: 2023-06-19T05:36:12 [1687339426.116167][5060:5062] CHIP:CTL: Joined the fabric at index 1. Fabric ID is 0x0000000000000001 (Compressed Fabric ID: 1B16FB350151CB67) [1687339426.116272][5060:5062] CHIP:IN: UDP::Init bind&listen port=5550 [1687339426.116521][5060:5062] CHIP:IN: UDP::Init bound to port=5550 [1687339426.116739][5060:5062] CHIP:IN: TransportMgr initialized [1687339426.150951][5060:5062] CHIP:TOO: Sending command to node 0x1 [1687339426.152223][5060:5062] CHIP:CSM: FindOrEstablishSession: PeerId = [1:0000000000000001] [1687339426.152295][5060:5062] CHIP:CSM: FindOrEstablishSession: No existing OperationalSessionSetup instance found [1687339426.152374][5060:5062] CHIP:DIS: OperationalSessionSetup[1:0000000000000001]: State change 1 --> 2 [1687339426.152447][5060:5062] CHIP:DIS: Resolving 1B16FB350151CB67:0000000000000001 ... [1687339426.156629][5060:5062] CHIP:DL: Avahi resolve found [1687339426.156751][5060:5062] CHIP:DIS: Node ID resolved for 1B16FB350151CB67:0000000000000001 [1687339426.156808][5060:5062] CHIP:DIS: Hostname: E45F010EBE370000 [1687339426.156872][5060:5062] CHIP:DIS: IP Address #1: fe80::e65f:1ff:fe0e:be36 [1687339426.156927][5060:5062] CHIP:DIS: Port: 5540 [1687339426.156980][5060:5062] CHIP:DIS: Mrp Interval idle: not present [1687339426.157032][5060:5062] CHIP:DIS: Mrp Interval active: not present [1687339426.157085][5060:5062] CHIP:DIS: TCP Supported: 1 [1687339426.157341][5060:5062] CHIP:DIS: UDP:[fe80::e65f:1ff:fe0e:be36%eth0]:5540: new best score: 3 [1687339426.157399][5060:5062] CHIP:DIS: Checking node lookup status after 5 ms [1687339426.157447][5060:5062] CHIP:DIS: Keeping DNSSD lookup active [1687339426.352294][5060:5062] CHIP:DIS: Checking node lookup status after 200 ms [1687339426.352597][5060:5062] CHIP:DIS: OperationalSessionSetup[1:0000000000000001]: Updating device address to UDP:[fe80::e65f:1ff:fe0e:be36%eth0]:5540 while in state 2 [1687339426.352658][5060:5062] CHIP:DIS: OperationalSessionSetup[1:0000000000000001]: State change 2 --> 3 [1687339426.352888][5060:5062] CHIP:IN: SecureSession[0xffff7000ae80]: Allocated Type:2 LSID:60279 [1687339426.352980][5060:5062] CHIP:SC: Initiating session on local FabricIndex 1 from 0x000000000001B669 -> 0x0000000000000001 [1687339426.354956][5060:5062] CHIP:EM: <<< [E:30451i S:0 M:75089293] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:30 (SecureChannel:CASE_Sigma1) [1687339426.355261][5060:5062] CHIP:IN: (U) Sending msg 75089293 to IP address 'UDP:[fe80::e65f:1ff:fe0e:be36%eth0]:5540' [1687339426.355578][5060:5062] CHIP:SC: Sent Sigma1 msg [1687339426.355650][5060:5062] CHIP:DIS: OperationalSessionSetup[1:0000000000000001]: State change 3 --> 4 [1687339426.363847][5060:5062] CHIP:EM: >>> [E:30451i S:0 M:106611888 (Ack:75089293)] (U) Msg RX from 0:0000000000000000 [0000] --- Type 0000:31 (SecureChannel:CASE_Sigma2) [1687339426.363942][5060:5062] CHIP:EM: Found matching exchange: 30451i, Delegate: 0xffff7000dd28 [1687339426.364025][5060:5062] CHIP:EM: Rxd Ack; Removing MessageCounter:75089293 from Retrans Table on exchange 30451i [1687339426.364124][5060:5062] CHIP:SC: Received Sigma2 msg [1687339426.364205][5060:5062] CHIP:SC: Peer assigned session session ID 25887 [1687339426.374875][5060:5062] CHIP:SC: Sending Sigma3 [1687339426.376458][5060:5062] CHIP:EM: <<< [E:30451i S:0 M:75089294 (Ack:106611888)] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:32 (SecureChannel:CASE_Sigma3) [1687339426.376767][5060:5062] CHIP:IN: (U) Sending msg 75089294 to IP address 'UDP:[fe80::e65f:1ff:fe0e:be36%eth0]:5540' [1687339426.377083][5060:5062] CHIP:SC: Sent Sigma3 msg [1687339426.394088][5060:5062] CHIP:EM: >>> [E:30451i S:0 M:106611889 (Ack:75089294)] (U) Msg RX from 0:0000000000000000 [0000] --- Type 0000:40 (SecureChannel:StatusReport) [1687339426.394189][5060:5062] CHIP:EM: Found matching exchange: 30451i, Delegate: 0xffff7000dd28 [1687339426.394274][5060:5062] CHIP:EM: Rxd Ack; Removing MessageCounter:75089294 from Retrans Table on exchange 30451i [1687339426.394370][5060:5062] CHIP:SC: Success status report received. Session was established [1687339426.401304][5060:5062] CHIP:SC: SecureSession[0xffff7000ae80, LSID:60279]: State change 'kEstablishing' --> 'kActive' [1687339426.401410][5060:5062] CHIP:IN: SecureSession[0xffff7000ae80]: Activated - Type:2 LSID:60279 [1687339426.401650][5060:5062] CHIP:IN: New secure session activated for device <0000000000000001, 1>, LSID:60279 PSID:25887! [1687339426.401745][5060:5062] CHIP:DIS: OperationalSessionSetup[1:0000000000000001]: State change 4 --> 5 [1687339426.401874][5060:5062] CHIP:TOO: Sending ReadAttribute to: [1687339426.402022][5060:5062] CHIP:TOO: cluster 0x0000_042F, attribute: 0x0000_FFFD, endpoint 1 [1687339426.402112][5060:5062] CHIP:DMG: SendReadRequest ReadClient[0xffff70011370]: Sending Read Request [1687339426.402411][5060:5062] CHIP:EM: <<< [E:30452i S:60279 M:191111641] (S) Msg TX to 1:0000000000000001 [CB67] --- Type 0001:02 (IM:ReadRequest) [1687339426.402510][5060:5062] CHIP:IN: (S) Sending msg 191111641 on secure session with LSID: 60279 [1687339426.402818][5060:5062] CHIP:DMG: MoveToState ReadClient[0xffff70011370]: Moving to [AwaitingIn] [1687339426.402966][5060:5062] CHIP:EM: <<< [E:30451i S:0 M:75089295 (Ack:106611889)] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck) [1687339426.403241][5060:5062] CHIP:IN: (U) Sending msg 75089295 to IP address 'UDP:[fe80::e65f:1ff:fe0e:be36%eth0]:5540' [1687339426.403412][5060:5062] CHIP:EM: Flushed pending ack for MessageCounter:106611889 on exchange 30451i [1687339426.406130][5060:5062] CHIP:EM: >>> [E:30452i S:60279 M:199516211 (Ack:191111641)] (S) Msg RX from 1:0000000000000001 [CB67] --- Type 0001:05 (IM:ReportData) [1687339426.406207][5060:5062] CHIP:EM: Found matching exchange: 30452i, Delegate: 0xffff70011380 [1687339426.406283][5060:5062] CHIP:EM: Rxd Ack; Removing MessageCounter:191111641 from Retrans Table on exchange 30452i [1687339426.406410][5060:5062] CHIP:DMG: ReportDataMessage = [1687339426.406472][5060:5062] CHIP:DMG: { [1687339426.406522][5060:5062] CHIP:DMG: AttributeReportIBs = [1687339426.406596][5060:5062] CHIP:DMG: [ [1687339426.406653][5060:5062] CHIP:DMG: AttributeReportIB = [1687339426.406734][5060:5062] CHIP:DMG: { [1687339426.406795][5060:5062] CHIP:DMG: AttributeDataIB = [1687339426.406865][5060:5062] CHIP:DMG: { [1687339426.406940][5060:5062] CHIP:DMG: DataVersion = 0xbbf19cc3, [1687339426.407011][5060:5062] CHIP:DMG: AttributePathIB = [1687339426.407088][5060:5062] CHIP:DMG: { [1687339426.407164][5060:5062] CHIP:DMG: Endpoint = 0x1, [1687339426.407246][5060:5062] CHIP:DMG: Cluster = 0x42f, [1687339426.407328][5060:5062] CHIP:DMG: Attribute = 0x0000_FFFD, [1687339426.407405][5060:5062] CHIP:DMG: } [1687339426.407485][5060:5062] CHIP:DMG: [1687339426.407562][5060:5062] CHIP:DMG: Data = 1, [1687339426.407633][5060:5062] CHIP:DMG: }, [1687339426.407710][5060:5062] CHIP:DMG: [1687339426.407772][5060:5062] CHIP:DMG: }, [1687339426.407844][5060:5062] CHIP:DMG: [1687339426.407899][5060:5062] CHIP:DMG: ], [1687339426.407985][5060:5062] CHIP:DMG: [1687339426.408053][5060:5062] CHIP:DMG: SuppressResponse = true, [1687339426.408115][5060:5062] CHIP:DMG: InteractionModelRevision = 1 [1687339426.408169][5060:5062] CHIP:DMG: } [1687339426.408472][5060:5062] CHIP:TOO: Endpoint: 1 Cluster: 0x0000_042F Attribute 0x0000_FFFD DataVersion: 3153173699 [1687339426.408613][5060:5062] CHIP:TOO: ClusterRevision: 1 [1687339426.408864][5060:5062] CHIP:EM: <<< [E:30452i S:60279 M:191111642 (Ack:199516211)] (S) Msg TX to 1:0000000000000001 [CB67] --- Type 0000:10 (SecureChannel:StandaloneAck) [1687339426.408949][5060:5062] CHIP:IN: (S) Sending msg 191111642 on secure session with LSID: 60279 [1687339426.409142][5060:5062] CHIP:EM: Flushed pending ack for MessageCounter:199516211 on exchange 30452i [1687339426.409495][5060:5060] CHIP:CTL: Shutting down the commissioner [1687339426.409717][5060:5060] CHIP:CTL: Stopping commissioning discovery over DNS-SD [1687339426.409908][5060:5060] CHIP:CTL: Shutting down the controller [1687339426.410011][5060:5060] CHIP:IN: Expiring all sessions for fabric 0x1!! [1687339426.410065][5060:5060] CHIP:IN: SecureSession[0xffff7000ae80]: MarkForEviction Type:2 LSID:60279 [1687339426.410118][5060:5060] CHIP:SC: SecureSession[0xffff7000ae80, LSID:60279]: State change 'kActive' --> 'kPendingEviction' [1687339426.410169][5060:5060] CHIP:IN: SecureSession[0xffff7000ae80]: Released - Type:2 LSID:60279 [1687339426.410227][5060:5060] CHIP:FP: Forgetting fabric 0x1 [1687339426.410295][5060:5060] CHIP:TS: Pending Last Known Good Time: 2023-06-19T05:36:12 [1687339426.410602][5060:5060] CHIP:TS: Previous Last Known Good Time: 2023-06-19T05:36:12 [1687339426.410659][5060:5060] CHIP:TS: Reverted Last Known Good Time to previous value [1687339426.410746][5060:5060] CHIP:CTL: Shutting down the commissioner [1687339426.410799][5060:5060] CHIP:CTL: Stopping commissioning discovery over DNS-SD [1687339426.410944][5060:5060] CHIP:CTL: Shutting down the controller [1687339426.410997][5060:5060] CHIP:CTL: Shutting down the System State, this will teardown the CHIP Stack [1687339426.412956][5060:5060] CHIP:DMG: All ReadHandler-s are clean, clear GlobalDirtySet [1687339426.413147][5060:5060] CHIP:BLE: BleConnectionDelegate::CancelConnection is not implemented. [1687339426.413382][5060:5060] CHIP:FP: Shutting down FabricTable [1687339426.413473][5060:5060] CHIP:TS: Pending Last Known Good Time: 2023-06-19T05:36:12 [1687339426.413802][5060:5060] CHIP:TS: Previous Last Known Good Time: 2023-06-19T05:36:12 [1687339426.413861][5060:5060] CHIP:TS: Reverted Last Known Good Time to previous value [1687339426.414474][5060:5060] CHIP:DL: writing settings to file (/tmp/chip_counters.ini-1qXWRO) [1687339426.415784][5060:5060] CHIP:DL: renamed tmp file to file (/tmp/chip_counters.ini) [1687339426.415917][5060:5060] CHIP:DL: NVS set: chip-counters/total-operational-hours = 0 (0x0) [1687339426.415971][5060:5060] CHIP:DL: Inet Layer shutdown [1687339426.416019][5060:5060] CHIP:DL: BLE shutdown [1687339426.416069][5060:5060] CHIP:DL: System Layer shutdown ubuntu@ubuntu:~/master/connectedhomeip/examples/chip-tool/out/debug$