pi@ubuntu:~$ ./chip-tool binding write binding '[{"node" : 2 , "cluster" : "0x0006" , "endpoint" : 1 }, { "node" : 3 , "cluster" : "0x0006" , "endpoint" : 1 }, { "node" : 4 , "cluster" : "0x0006" , "endpoint" : 1 }, { "node" : 5 , "cluster" : "0x0006" , "endpoint" : 1 }, { "node" : 6 , "cluster" : "0x0006" , "endpoint" : 1 }, { "node" : 7 , "cluster" : "0x0006" , "endpoint" : 1 }, { "node" : 8 , "cluster" : "0x0006" , "endpoint" : 1 }, { "node" : 9 , "cluster" : "0x0006" , "endpoint" : 1 }, { "node" : 10 , "cluster" : "0x0006" , "endpoint" : 1 }, { "node" : 11 , "cluster" : "0x0006" , "endpoint" : 1 }, { "node" : 12 , "cluster" : "0x0006" , "endpoint" : 1 }, { "node" : 13 , "cluster" : "0x0006" , "endpoint" : 1 }]' 1 1 [1666833842.983876][1930:1930] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_kvs [1666833842.989298][1930:1930] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_factory.ini [1666833842.989600][1930:1930] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_config.ini [1666833842.989736][1930:1930] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_counters.ini [1666833842.990293][1930:1930] CHIP:DL: writing settings to file (/tmp/chip_counters.ini-vm8Fac) [1666833842.990927][1930:1930] CHIP:DL: renamed tmp file to file (/tmp/chip_counters.ini) [1666833842.990981][1930:1930] CHIP:DL: NVS set: chip-counters/reboot-count = 12 (0xC) [1666833842.991655][1930:1930] CHIP:DL: Got Ethernet interface: eth0 [1666833842.992261][1930:1930] CHIP:DL: Found the primary Ethernet interface:eth0 [1666833842.992842][1930:1930] CHIP:DL: Got WiFi interface: wlan0 [1666833842.992928][1930:1930] CHIP:DL: Failed to reset WiFi statistic counts [1666833842.993033][1930:1930] CHIP:IN: UDP::Init bind&listen port=0 [1666833842.993167][1930:1930] CHIP:IN: UDP::Init bound to port=46710 [1666833842.993212][1930:1930] CHIP:IN: BLEBase::Init - setting/overriding transport [1666833842.993235][1930:1930] CHIP:IN: TransportMgr initialized [1666833842.993273][1930:1930] CHIP:FP: Initializing FabricTable from persistent storage [1666833842.993527][1930:1930] CHIP:TS: Last Known Good Time: 2023-02-02T22:46:27 [1666833842.995614][1930:1930] CHIP:FP: Fabric index 0x1 was retrieved from storage. Compressed FabricId 0xAC8528230FB2F420, FabricId 0x0000000000000001, NodeId 0x000000000001B669, VendorId 0xFFF1 [1666833842.998544][1930:1930] CHIP:ZCL: Using ZAP configuration... [1666833842.999679][1930:1930] CHIP:CTL: System State Initialized... [1666833842.999791][1930:1930] CHIP:CTL: Stopping commissioning discovery over DNS-SD [1666833842.999852][1930:1930] CHIP:CTL: Setting attestation nonce to random value [1666833842.999911][1930:1930] CHIP:CTL: Setting CSR nonce to random value [1666833842.999988][1930:1930] CHIP:IN: UDP::Init bind&listen port=5550 [1666833843.000093][1930:1930] CHIP:IN: UDP::Init bound to port=5550 [1666833843.000121][1930:1930] CHIP:IN: TransportMgr initialized [1666833843.000451][1930:1935] CHIP:DL: CHIP task running [1666833843.001172][1930:1935] CHIP:CTL: Stopping commissioning discovery over DNS-SD [1666833843.001229][1930:1935] CHIP:CTL: Setting attestation nonce to random value [1666833843.001444][1930:1935] CHIP:CTL: Setting CSR nonce to random value [1666833843.002786][1930:1935] CHIP:CTL: Generating NOC [1666833843.003940][1930:1935] CHIP:FP: Validating NOC chain [1666833843.005555][1930:1935] CHIP:FP: NOC chain validation successful [1666833843.005705][1930:1935] CHIP:FP: Updated fabric at index: 0x1, Node ID: 0x000000000001B669 [1666833843.005735][1930:1935] CHIP:TS: Last Known Good Time: 2023-02-02T22:46:27 [1666833843.005755][1930:1935] CHIP:TS: New proposed Last Known Good Time: 2021-01-01T00:00:00 [1666833843.005789][1930:1935] CHIP:TS: Retaining current Last Known Good Time [1666833843.011380][1930:1935] CHIP:FP: Metadata for Fabric 0x1 persisted to storage. [1666833843.013594][1930:1935] CHIP:TS: Committing Last Known Good Time to storage: 2023-02-02T22:46:27 [1666833843.015610][1930:1935] CHIP:CTL: Joined the fabric at index 1. Compressed fabric ID is: 0x0000000000000000 [1666833843.015664][1930:1935] CHIP:IN: UDP::Init bind&listen port=5550 [1666833843.015781][1930:1935] CHIP:IN: UDP::Init bound to port=5550 [1666833843.015805][1930:1935] CHIP:IN: TransportMgr initialized [1666833843.042819][1930:1935] CHIP:TOO: Sending command to node 0x1 [1666833843.045410][1930:1935] CHIP:CSM: FindOrEstablishSession: PeerId = [1:0000000000000001] [1666833843.045594][1930:1935] CHIP:CSM: FindOrEstablishSession: No existing OperationalSessionSetup instance found [1666833843.045658][1930:1935] CHIP:CTL: OperationalSessionSetup[1:0000000000000001]: State change 1 --> 2 [1666833843.048214][1930:1935] CHIP:DIS: Lookup clearing interface for non LL address [1666833843.048255][1930:1935] CHIP:DIS: UDP:[fd11:22::588a:7bbe:ad63:48e2%eth0]:5540: new best score: 6 [1666833843.048284][1930:1935] CHIP:DIS: Checking node lookup status after 3 ms [1666833843.048303][1930:1935] CHIP:DIS: Keeping DNSSD lookup active [1666833843.048815][1930:1935] CHIP:DIS: SRV record already actively processed. [1666833843.048898][1930:1935] CHIP:DIS: SRV record already actively processed. [1666833843.050033][1930:1935] CHIP:DIS: UDP:[fd11:22::588a:7bbe:ad63:48e2%eth0]:5540: score has not improved: 6 [1666833843.050070][1930:1935] CHIP:DIS: Checking node lookup status after 5 ms [1666833843.050089][1930:1935] CHIP:DIS: Keeping DNSSD lookup active [1666833843.246220][1930:1935] CHIP:DIS: Checking node lookup status after 201 ms [1666833843.246331][1930:1935] CHIP:DIS: OperationalSessionSetup[1:0000000000000001]: Updating device address to UDP:[fd11:22::588a:7bbe:ad63:48e2]:5540 while in state 2 [1666833843.246392][1930:1935] CHIP:CTL: OperationalSessionSetup[1:0000000000000001]: State change 2 --> 3 [1666833843.246629][1930:1935] CHIP:IN: SecureSession[0xffffac00b040]: Allocated Type:2 LSID:27785 [1666833843.246721][1930:1935] CHIP:SC: Initiating session on local FabricIndex 1 from 0x000000000001B669 -> 0x0000000000000001 [1666833843.248754][1930:1935] CHIP:SC: Including MRP parameters [1666833843.249226][1930:1935] CHIP:EM: <<< [E:19230i M:84165299] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:30 (SecureChannel:CASE_Sigma1) [1666833843.249346][1930:1935] CHIP:IN: (U) Sending msg 84165299 to IP address 'UDP:[fd11:22::588a:7bbe:ad63:48e2]:5540' [1666833843.249666][1930:1935] CHIP:SC: Sent Sigma1 msg [1666833843.249745][1930:1935] CHIP:CTL: OperationalSessionSetup[1:0000000000000001]: State change 3 --> 4 [1666833843.363373][1930:1935] CHIP:EM: >>> [E:19230i M:151222295 (Ack:84165299)] (U) Msg RX from 0:0000000000000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck) [1666833843.363449][1930:1935] CHIP:EM: Found matching exchange: 19230i, Delegate: 0xffffac00ec88 [1666833843.363514][1930:1935] CHIP:EM: Rxd Ack; Removing MessageCounter:84165299 from Retrans Table on exchange 19230i [1666833843.508297][1930:1935] CHIP:EM: >>> [E:19230i M:151222296 (Ack:84165299)] (U) Msg RX from 0:0000000000000000 [0000] --- Type 0000:31 (SecureChannel:CASE_Sigma2) [1666833843.508393][1930:1935] CHIP:EM: Found matching exchange: 19230i, Delegate: 0xffffac00ec88 [1666833843.508449][1930:1935] CHIP:EM: CHIP MessageCounter:84165299 not in RetransTable on exchange 19230i [1666833843.508534][1930:1935] CHIP:SC: Received Sigma2 msg [1666833843.508605][1930:1935] CHIP:SC: Peer assigned session session ID 34164 [1666833843.519137][1930:1935] CHIP:SC: Found MRP parameters in the message [1666833843.519263][1930:1935] CHIP:SC: Sending Sigma3 [1666833843.520787][1930:1935] CHIP:EM: <<< [E:19230i M:84165300 (Ack:151222296)] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:32 (SecureChannel:CASE_Sigma3) [1666833843.520959][1930:1935] CHIP:IN: (U) Sending msg 84165300 to IP address 'UDP:[fd11:22::588a:7bbe:ad63:48e2%wpan0]:5540' [1666833843.521139][1930:1935] CHIP:SC: Sent Sigma3 msg [1666833843.783291][1930:1935] CHIP:EM: >>> [E:19230i M:151222297 (Ack:84165300)] (U) Msg RX from 0:0000000000000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck) [1666833843.783375][1930:1935] CHIP:EM: Found matching exchange: 19230i, Delegate: 0xffffac00ec88 [1666833843.783443][1930:1935] CHIP:EM: Rxd Ack; Removing MessageCounter:84165300 from Retrans Table on exchange 19230i [1666833843.813770][1930:1935] CHIP:EM: >>> [E:19230i M:151222298 (Ack:84165300)] (U) Msg RX from 0:0000000000000000 [0000] --- Type 0000:40 (SecureChannel:StatusReport) [1666833843.813870][1930:1935] CHIP:EM: Found matching exchange: 19230i, Delegate: 0xffffac00ec88 [1666833843.813938][1930:1935] CHIP:EM: CHIP MessageCounter:84165300 not in RetransTable on exchange 19230i [1666833843.814088][1930:1935] CHIP:SC: Success status report received. Session was established [1666833843.821110][1930:1935] CHIP:SC: SecureSession[0xffffac00b040]: Moving from state 'kEstablishing' --> 'kActive' [1666833843.821178][1930:1935] CHIP:IN: SecureSession[0xffffac00b040]: Activated - Type:2 LSID:27785 [1666833843.821206][1930:1935] CHIP:IN: New secure session activated for device <0000000000000001, 1>, LSID:27785 PSID:34164! [1666833843.821245][1930:1935] CHIP:CTL: OperationalSessionSetup[1:0000000000000001]: State change 4 --> 5 [1666833843.821348][1930:1935] CHIP:TOO: cluster 0x0000_001E, attribute: 0x0000_0000, endpoint 1 [1666833843.821434][1930:1935] CHIP:DMG: WriteClient moving to [AddAttribu] [1666833843.821483][1930:1935] CHIP:DMG: WriteClient moving to [AddAttribu] [1666833843.821520][1930:1935] CHIP:DMG: WriteClient moving to [AddAttribu] [1666833843.821556][1930:1935] CHIP:DMG: WriteClient moving to [AddAttribu] [1666833843.821592][1930:1935] CHIP:DMG: WriteClient moving to [AddAttribu] [1666833843.821628][1930:1935] CHIP:DMG: WriteClient moving to [AddAttribu] [1666833843.821665][1930:1935] CHIP:DMG: WriteClient moving to [AddAttribu] [1666833843.821700][1930:1935] CHIP:DMG: WriteClient moving to [AddAttribu] [1666833843.821867][1930:1935] CHIP:DMG: WriteClient moving to [AddAttribu] [1666833843.821908][1930:1935] CHIP:DMG: WriteClient moving to [AddAttribu] [1666833843.821943][1930:1935] CHIP:DMG: WriteClient moving to [AddAttribu] [1666833843.821978][1930:1935] CHIP:DMG: WriteClient moving to [AddAttribu] [1666833843.822048][1930:1935] CHIP:DMG: WriteClient moving to [AddAttribu] [1666833843.822237][1930:1935] CHIP:EM: <<< [E:19231i M:1140760] (S) Msg TX to 1:0000000000000001 [F420] --- Type 0001:06 (IM:WriteRequest) [1666833843.822297][1930:1935] CHIP:IN: (S) Sending msg 1140760 on secure session with LSID: 27785 [1666833843.822519][1930:1935] CHIP:DMG: WriteClient moving to [AwaitingRe] [1666833843.822624][1930:1935] CHIP:EM: <<< [E:19230i M:84165301 (Ack:151222298)] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck) [1666833843.822808][1930:1935] CHIP:IN: (U) Sending msg 84165301 to IP address 'UDP:[fd11:22::588a:7bbe:ad63:48e2%wpan0]:5540' [1666833843.822940][1930:1935] CHIP:EM: Flushed pending ack for MessageCounter:151222298 on exchange 19230i [1666833844.198411][1930:1935] CHIP:EM: >>> [E:19231i M:208506925 (Ack:1140760)] (S) Msg RX from 1:0000000000000001 [F420] --- Type 0001:07 (IM:WriteResponse) [1666833844.198509][1930:1935] CHIP:EM: Found matching exchange: 19231i, Delegate: 0xaaaaf4948590 [1666833844.198586][1930:1935] CHIP:EM: Rxd Ack; Removing MessageCounter:1140760 from Retrans Table on exchange 19231i [1666833844.198663][1930:1935] CHIP:DMG: WriteClient moving to [ResponseRe] [1666833844.198889][1930:1935] CHIP:DMG: WriteResponseMessage = [1666833844.198956][1930:1935] CHIP:DMG: { [1666833844.198997][1930:1935] CHIP:DMG: AttributeStatusIBs = [1666833844.199067][1930:1935] CHIP:DMG: [ [1666833844.199122][1930:1935] CHIP:DMG: AttributeStatusIB = [1666833844.199193][1930:1935] CHIP:DMG: { [1666833844.199253][1930:1935] CHIP:DMG: AttributePathIB = [1666833844.199319][1930:1935] CHIP:DMG: { [1666833844.199385][1930:1935] CHIP:DMG: Endpoint = 0x1, [1666833844.199454][1930:1935] CHIP:DMG: Cluster = 0x1e, [1666833844.199523][1930:1935] CHIP:DMG: Attribute = 0x0000_0000, [1666833844.199588][1930:1935] CHIP:DMG: } [1666833844.199663][1930:1935] CHIP:DMG: [1666833844.199726][1930:1935] CHIP:DMG: StatusIB = [1666833844.199793][1930:1935] CHIP:DMG: { [1666833844.199851][1930:1935] CHIP:DMG: status = 0x00 (SUCCESS), [1666833844.199906][1930:1935] CHIP:DMG: }, [1666833844.199962][1930:1935] CHIP:DMG: [1666833844.200011][1930:1935] CHIP:DMG: }, [1666833844.200084][1930:1935] CHIP:DMG: [1666833844.200131][1930:1935] CHIP:DMG: AttributeStatusIB = [1666833844.200182][1930:1935] CHIP:DMG: { [1666833844.200235][1930:1935] CHIP:DMG: AttributePathIB = [1666833844.200301][1930:1935] CHIP:DMG: { [1666833844.200372][1930:1935] CHIP:DMG: Endpoint = 0x1, [1666833844.200447][1930:1935] CHIP:DMG: Cluster = 0x1e, [1666833844.200523][1930:1935] CHIP:DMG: Attribute = 0x0000_0000, [1666833844.200601][1930:1935] CHIP:DMG: ListIndex = Null, [1666833844.200676][1930:1935] CHIP:DMG: } [1666833844.200761][1930:1935] CHIP:DMG: [1666833844.200824][1930:1935] CHIP:DMG: StatusIB = [1666833844.200890][1930:1935] CHIP:DMG: { [1666833844.200960][1930:1935] CHIP:DMG: status = 0x00 (SUCCESS), [1666833844.201029][1930:1935] CHIP:DMG: }, [1666833844.201103][1930:1935] CHIP:DMG: [1666833844.201162][1930:1935] CHIP:DMG: }, [1666833844.201246][1930:1935] CHIP:DMG: [1666833844.201299][1930:1935] CHIP:DMG: AttributeStatusIB = [1666833844.201361][1930:1935] CHIP:DMG: { [1666833844.201420][1930:1935] CHIP:DMG: AttributePathIB = [1666833844.201486][1930:1935] CHIP:DMG: { [1666833844.201562][1930:1935] CHIP:DMG: Endpoint = 0x1, [1666833844.201641][1930:1935] CHIP:DMG: Cluster = 0x1e, [1666833844.201719][1930:1935] CHIP:DMG: Attribute = 0x0000_0000, [1666833844.201790][1930:1935] CHIP:DMG: ListIndex = Null, [1666833844.201857][1930:1935] CHIP:DMG: } [1666833844.201934][1930:1935] CHIP:DMG: [1666833844.202028][1930:1935] CHIP:DMG: StatusIB = [1666833844.202096][1930:1935] CHIP:DMG: { [1666833844.202171][1930:1935] CHIP:DMG: status = 0x00 (SUCCESS), [1666833844.202238][1930:1935] CHIP:DMG: }, [1666833844.202314][1930:1935] CHIP:DMG: [1666833844.202373][1930:1935] CHIP:DMG: }, [1666833844.202459][1930:1935] CHIP:DMG: [1666833844.202512][1930:1935] CHIP:DMG: AttributeStatusIB = [1666833844.202575][1930:1935] CHIP:DMG: { [1666833844.202630][1930:1935] CHIP:DMG: AttributePathIB = [1666833844.202684][1930:1935] CHIP:DMG: { [1666833844.202751][1930:1935] CHIP:DMG: Endpoint = 0x1, [1666833844.202822][1930:1935] CHIP:DMG: Cluster = 0x1e, [1666833844.202901][1930:1935] CHIP:DMG: Attribute = 0x0000_0000, [1666833844.203105][1930:1935] CHIP:DMG: ListIndex = Null, [1666833844.203177][1930:1935] CHIP:DMG: } [1666833844.203258][1930:1935] CHIP:DMG: [1666833844.203329][1930:1935] CHIP:DMG: StatusIB = [1666833844.203402][1930:1935] CHIP:DMG: { [1666833844.203479][1930:1935] CHIP:DMG: status = 0x00 (SUCCESS), [1666833844.203547][1930:1935] CHIP:DMG: }, [1666833844.203616][1930:1935] CHIP:DMG: [1666833844.203675][1930:1935] CHIP:DMG: }, [1666833844.203759][1930:1935] CHIP:DMG: [1666833844.203812][1930:1935] CHIP:DMG: AttributeStatusIB = [1666833844.203874][1930:1935] CHIP:DMG: { [1666833844.203934][1930:1935] CHIP:DMG: AttributePathIB = [1666833844.204007][1930:1935] CHIP:DMG: { [1666833844.204076][1930:1935] CHIP:DMG: Endpoint = 0x1, [1666833844.204153][1930:1935] CHIP:DMG: Cluster = 0x1e, [1666833844.204226][1930:1935] CHIP:DMG: Attribute = 0x0000_0000, [1666833844.204296][1930:1935] CHIP:DMG: ListIndex = Null, [1666833844.204363][1930:1935] CHIP:DMG: } [1666833844.204437][1930:1935] CHIP:DMG: [1666833844.204475][1930:1935] CHIP:DMG: StatusIB = [1666833844.204518][1930:1935] CHIP:DMG: { [1666833844.204625][1930:1935] CHIP:DMG: status = 0x00 (SUCCESS), [1666833844.204671][1930:1935] CHIP:DMG: }, [1666833844.204713][1930:1935] CHIP:DMG: [1666833844.204748][1930:1935] CHIP:DMG: }, [1666833844.204799][1930:1935] CHIP:DMG: [1666833844.204830][1930:1935] CHIP:DMG: AttributeStatusIB = [1666833844.204867][1930:1935] CHIP:DMG: { [1666833844.204902][1930:1935] CHIP:DMG: AttributePathIB = [1666833844.204942][1930:1935] CHIP:DMG: { [1666833844.204985][1930:1935] CHIP:DMG: Endpoint = 0x1, [1666833844.205032][1930:1935] CHIP:DMG: Cluster = 0x1e, [1666833844.205075][1930:1935] CHIP:DMG: Attribute = 0x0000_0000, [1666833844.205115][1930:1935] CHIP:DMG: ListIndex = Null, [1666833844.205158][1930:1935] CHIP:DMG: } [1666833844.205204][1930:1935] CHIP:DMG: [1666833844.205242][1930:1935] CHIP:DMG: StatusIB = [1666833844.205281][1930:1935] CHIP:DMG: { [1666833844.205325][1930:1935] CHIP:DMG: status = 0x00 (SUCCESS), [1666833844.205365][1930:1935] CHIP:DMG: }, [1666833844.205405][1930:1935] CHIP:DMG: [1666833844.205440][1930:1935] CHIP:DMG: }, [1666833844.205490][1930:1935] CHIP:DMG: [1666833844.205521][1930:1935] CHIP:DMG: AttributeStatusIB = [1666833844.205557][1930:1935] CHIP:DMG: { [1666833844.205591][1930:1935] CHIP:DMG: AttributePathIB = [1666833844.205634][1930:1935] CHIP:DMG: { [1666833844.205678][1930:1935] CHIP:DMG: Endpoint = 0x1, [1666833844.205723][1930:1935] CHIP:DMG: Cluster = 0x1e, [1666833844.205765][1930:1935] CHIP:DMG: Attribute = 0x0000_0000, [1666833844.205806][1930:1935] CHIP:DMG: ListIndex = Null, [1666833844.205845][1930:1935] CHIP:DMG: } [1666833844.205890][1930:1935] CHIP:DMG: [1666833844.205929][1930:1935] CHIP:DMG: StatusIB = [1666833844.205969][1930:1935] CHIP:DMG: { [1666833844.206026][1930:1935] CHIP:DMG: status = 0x00 (SUCCESS), [1666833844.206068][1930:1935] CHIP:DMG: }, [1666833844.206109][1930:1935] CHIP:DMG: [1666833844.206143][1930:1935] CHIP:DMG: }, [1666833844.206193][1930:1935] CHIP:DMG: [1666833844.206224][1930:1935] CHIP:DMG: AttributeStatusIB = [1666833844.206261][1930:1935] CHIP:DMG: { [1666833844.206296][1930:1935] CHIP:DMG: AttributePathIB = [1666833844.206335][1930:1935] CHIP:DMG: { [1666833844.206379][1930:1935] CHIP:DMG: Endpoint = 0x1, [1666833844.206421][1930:1935] CHIP:DMG: Cluster = 0x1e, [1666833844.206464][1930:1935] CHIP:DMG: Attribute = 0x0000_0000, [1666833844.206505][1930:1935] CHIP:DMG: ListIndex = Null, [1666833844.206544][1930:1935] CHIP:DMG: } [1666833844.206593][1930:1935] CHIP:DMG: [1666833844.206632][1930:1935] CHIP:DMG: StatusIB = [1666833844.206675][1930:1935] CHIP:DMG: { [1666833844.206713][1930:1935] CHIP:DMG: status = 0x00 (SUCCESS), [1666833844.206753][1930:1935] CHIP:DMG: }, [1666833844.206794][1930:1935] CHIP:DMG: [1666833844.206828][1930:1935] CHIP:DMG: }, [1666833844.206877][1930:1935] CHIP:DMG: [1666833844.206909][1930:1935] CHIP:DMG: AttributeStatusIB = [1666833844.206945][1930:1935] CHIP:DMG: { [1666833844.206980][1930:1935] CHIP:DMG: AttributePathIB = [1666833844.207019][1930:1935] CHIP:DMG: { [1666833844.207058][1930:1935] CHIP:DMG: Endpoint = 0x1, [1666833844.207100][1930:1935] CHIP:DMG: Cluster = 0x1e, [1666833844.207142][1930:1935] CHIP:DMG: Attribute = 0x0000_0000, [1666833844.207187][1930:1935] CHIP:DMG: ListIndex = Null, [1666833844.207226][1930:1935] CHIP:DMG: } [1666833844.207274][1930:1935] CHIP:DMG: [1666833844.207313][1930:1935] CHIP:DMG: StatusIB = [1666833844.207352][1930:1935] CHIP:DMG: { [1666833844.207393][1930:1935] CHIP:DMG: status = 0x00 (SUCCESS), [1666833844.207433][1930:1935] CHIP:DMG: }, [1666833844.207473][1930:1935] CHIP:DMG: [1666833844.207507][1930:1935] CHIP:DMG: }, [1666833844.207557][1930:1935] CHIP:DMG: [1666833844.207588][1930:1935] CHIP:DMG: AttributeStatusIB = [1666833844.207624][1930:1935] CHIP:DMG: { [1666833844.207659][1930:1935] CHIP:DMG: AttributePathIB = [1666833844.207699][1930:1935] CHIP:DMG: { [1666833844.207742][1930:1935] CHIP:DMG: Endpoint = 0x1, [1666833844.207784][1930:1935] CHIP:DMG: Cluster = 0x1e, [1666833844.207826][1930:1935] CHIP:DMG: Attribute = 0x0000_0000, [1666833844.207871][1930:1935] CHIP:DMG: ListIndex = Null, [1666833844.207910][1930:1935] CHIP:DMG: } [1666833844.207955][1930:1935] CHIP:DMG: [1666833844.207994][1930:1935] CHIP:DMG: StatusIB = [1666833844.208037][1930:1935] CHIP:DMG: { [1666833844.208077][1930:1935] CHIP:DMG: status = 0x00 (SUCCESS), [1666833844.208117][1930:1935] CHIP:DMG: }, [1666833844.208157][1930:1935] CHIP:DMG: [1666833844.208192][1930:1935] CHIP:DMG: }, [1666833844.208242][1930:1935] CHIP:DMG: [1666833844.208273][1930:1935] CHIP:DMG: AttributeStatusIB = [1666833844.208309][1930:1935] CHIP:DMG: { [1666833844.208344][1930:1935] CHIP:DMG: AttributePathIB = [1666833844.208383][1930:1935] CHIP:DMG: { [1666833844.208422][1930:1935] CHIP:DMG: Endpoint = 0x1, [1666833844.208464][1930:1935] CHIP:DMG: Cluster = 0x1e, [1666833844.208506][1930:1935] CHIP:DMG: Attribute = 0x0000_0000, [1666833844.208547][1930:1935] CHIP:DMG: ListIndex = Null, [1666833844.208586][1930:1935] CHIP:DMG: } [1666833844.208635][1930:1935] CHIP:DMG: [1666833844.208673][1930:1935] CHIP:DMG: StatusIB = [1666833844.208713][1930:1935] CHIP:DMG: { [1666833844.208757][1930:1935] CHIP:DMG: status = 0x00 (SUCCESS), [1666833844.208801][1930:1935] CHIP:DMG: }, [1666833844.208844][1930:1935] CHIP:DMG: [1666833844.208878][1930:1935] CHIP:DMG: }, [1666833844.208927][1930:1935] CHIP:DMG: [1666833844.208959][1930:1935] CHIP:DMG: AttributeStatusIB = [1666833844.208995][1930:1935] CHIP:DMG: { [1666833844.209029][1930:1935] CHIP:DMG: AttributePathIB = [1666833844.209072][1930:1935] CHIP:DMG: { [1666833844.209112][1930:1935] CHIP:DMG: Endpoint = 0x1, [1666833844.209154][1930:1935] CHIP:DMG: Cluster = 0x1e, [1666833844.209200][1930:1935] CHIP:DMG: Attribute = 0x0000_0000, [1666833844.209241][1930:1935] CHIP:DMG: ListIndex = Null, [1666833844.209280][1930:1935] CHIP:DMG: } [1666833844.209325][1930:1935] CHIP:DMG: [1666833844.209367][1930:1935] CHIP:DMG: StatusIB = [1666833844.209406][1930:1935] CHIP:DMG: { [1666833844.209450][1930:1935] CHIP:DMG: status = 0x00 (SUCCESS), [1666833844.209490][1930:1935] CHIP:DMG: }, [1666833844.209534][1930:1935] CHIP:DMG: [1666833844.209568][1930:1935] CHIP:DMG: }, [1666833844.209617][1930:1935] CHIP:DMG: [1666833844.209648][1930:1935] CHIP:DMG: AttributeStatusIB = [1666833844.209684][1930:1935] CHIP:DMG: { [1666833844.209719][1930:1935] CHIP:DMG: AttributePathIB = [1666833844.209758][1930:1935] CHIP:DMG: { [1666833844.209798][1930:1935] CHIP:DMG: Endpoint = 0x1, [1666833844.209844][1930:1935] CHIP:DMG: Cluster = 0x1e, [1666833844.209886][1930:1935] CHIP:DMG: Attribute = 0x0000_0000, [1666833844.209930][1930:1935] CHIP:DMG: ListIndex = Null, [1666833844.209969][1930:1935] CHIP:DMG: } [1666833844.210029][1930:1935] CHIP:DMG: [1666833844.210073][1930:1935] CHIP:DMG: StatusIB = [1666833844.210115][1930:1935] CHIP:DMG: { [1666833844.210160][1930:1935] CHIP:DMG: status = 0x00 (SUCCESS), [1666833844.210200][1930:1935] CHIP:DMG: }, [1666833844.210244][1930:1935] CHIP:DMG: [1666833844.210278][1930:1935] CHIP:DMG: }, [1666833844.210320][1930:1935] CHIP:DMG: [1666833844.210351][1930:1935] CHIP:DMG: ], [1666833844.210459][1930:1935] CHIP:DMG: [1666833844.210490][1930:1935] CHIP:DMG: InteractionModelRevision = 1 [1666833844.210520][1930:1935] CHIP:DMG: } [1666833844.211126][1930:1935] CHIP:DMG: WriteClient moving to [AwaitingDe] [1666833844.211289][1930:1935] CHIP:EM: <<< [E:19231i M:1140761 (Ack:208506925)] (S) Msg TX to 1:0000000000000001 [F420] --- Type 0000:10 (SecureChannel:StandaloneAck) [1666833844.211343][1930:1935] CHIP:IN: (S) Sending msg 1140761 on secure session with LSID: 27785 [1666833844.211498][1930:1935] CHIP:EM: Flushed pending ack for MessageCounter:208506925 on exchange 19231i [1666833844.211778][1930:1930] CHIP:CTL: Shutting down the commissioner [1666833844.211831][1930:1930] CHIP:CTL: Stopping commissioning discovery over DNS-SD [1666833844.211947][1930:1930] CHIP:CTL: Shutting down the controller [1666833844.211978][1930:1930] CHIP:IN: Expiring all sessions for fabric 0x1!! [1666833844.212002][1930:1930] CHIP:IN: SecureSession[0xffffac00b040]: MarkForEviction Type:2 LSID:27785 [1666833844.212028][1930:1930] CHIP:SC: SecureSession[0xffffac00b040]: Moving from state 'kActive' --> 'kPendingEviction' [1666833844.212054][1930:1930] CHIP:IN: SecureSession[0xffffac00b040]: Released - Type:2 LSID:27785 [1666833844.212081][1930:1930] CHIP:FP: Forgetting fabric 0x1 [1666833844.212208][1930:1930] CHIP:TS: Pending Last Known Good Time: 2023-02-02T22:46:27 [1666833844.212508][1930:1930] CHIP:TS: Previous Last Known Good Time: 2023-02-02T22:46:27 [1666833844.212536][1930:1930] CHIP:TS: Reverted Last Known Good Time to previous value [1666833844.212592][1930:1930] CHIP:CTL: Shutting down the commissioner [1666833844.212616][1930:1930] CHIP:CTL: Stopping commissioning discovery over DNS-SD [1666833844.212724][1930:1930] CHIP:CTL: Shutting down the controller [1666833844.212790][1930:1930] CHIP:CTL: Shutting down the System State, this will teardown the CHIP Stack [1666833844.213108][1930:1930] CHIP:DMG: IM WH moving to [Uninitialized] [1666833844.213243][1930:1930] CHIP:DMG: IM WH moving to [Uninitialized] [1666833844.213272][1930:1930] CHIP:DMG: IM WH moving to [Uninitialized] [1666833844.213296][1930:1930] CHIP:DMG: IM WH moving to [Uninitialized] [1666833844.213323][1930:1930] CHIP:DMG: All ReadHandler-s are clean, clear GlobalDirtySet [1666833844.213405][1930:1930] CHIP:BLE: BleConnectionDelegate::CancelConnection is not implemented. [1666833844.213751][1930:1930] CHIP:DL: writing settings to file (/tmp/chip_counters.ini-Ibrjwi) [1666833844.214576][1930:1930] CHIP:DL: renamed tmp file to file (/tmp/chip_counters.ini) [1666833844.214649][1930:1930] CHIP:DL: NVS set: chip-counters/total-operational-hours = 0 (0x0) [1666833844.214691][1930:1930] CHIP:DL: Inet Layer shutdown [1666833844.214718][1930:1930] CHIP:DL: BLE shutdown [1666833844.214744][1930:1930] CHIP:DL: System Layer shutdown pi@ubuntu:~$