본문 바로가기
Smart Home/MATTER

MATTER/Log chip-device-ctrl

by 감자최고 2022. 8. 18.

(python_env) gamja@gamja-14Z90P-GALGL:~/connectedhomeip$ chip-device-ctrl 

matter_log.chip-device-ctrl.txt
0.02MB


[1660828884.046983][76806:76806] CHIP:CTL: Generating NOC
[1660828884.047088][76806:76806] CHIP:CTL: Generating ICAC
[1660828884.047124][76806:76806] CHIP:CTL: Generating RCAC
[1660828884.048501][76806:76806] CHIP:DL: AUDIT: ===== RANDOM NUMBER GENERATOR AUDIT START ====
[1660828884.048511][76806:76806] CHIP:DL: AUDIT: * Validate buf1 and buf2 are <<<different every run/boot!>>>
[1660828884.048515][76806:76806] CHIP:DL: AUDIT: * Validate r1 and r2 are <<<different every run/boot!>>>
[1660828884.048518][76806:76806] CHIP:DL: AUDIT: * buf1: 1BF6077521619CA99C4E710CEA3EBDE6
[1660828884.048521][76806:76806] CHIP:DL: AUDIT: * buf2: 97366A8BEDA472CA7E683DB53CE47CB1
[1660828884.048525][76806:76806] CHIP:DL: AUDIT: * r1: 0x9F6EAFDA r2: 0x70C8120B
[1660828884.048528][76806:76806] CHIP:DL: AUDIT: ===== RANDOM NUMBER GENERATOR AUDIT END ====
[1660828884.048584][76806:76806] CHIP:DL: writing settings to file (/tmp/chip_factory.ini-yccuiW)
[1660828884.048613][76806:76806] CHIP:DL: renamed tmp file to file (/tmp/chip_factory.ini)
[1660828884.048638][76806:76806] CHIP:DL: writing settings to file (/tmp/chip_config.ini-zKKDvV)
[1660828884.048652][76806:76806] CHIP:DL: renamed tmp file to file (/tmp/chip_config.ini)
[1660828884.048667][76806:76806] CHIP:DL: writing settings to file (/tmp/chip_counters.ini-zP4cRV)
[1660828884.048679][76806:76806] CHIP:DL: renamed tmp file to file (/tmp/chip_counters.ini)
[1660828884.048713][76806:76806] CHIP:DL: writing settings to file (/tmp/chip_counters.ini-g8Uu3S)
[1660828884.048772][76806:76806] CHIP:DL: renamed tmp file to file (/tmp/chip_counters.ini)
[1660828884.048777][76806:76806] CHIP:DL: NVS set: chip-counters/reboot-count = 1 (0x1)
[1660828884.048800][76806:76806] CHIP:DL: writing settings to file (/tmp/chip_counters.ini-iJSADV)
[1660828884.084939][76806:76806] CHIP:DL: renamed tmp file to file (/tmp/chip_counters.ini)
[1660828884.084973][76806:76806] CHIP:DL: NVS set: chip-counters/total-operational-hours = 0 (0x0)
[1660828884.085049][76806:76806] CHIP:DL: writing settings to file (/tmp/chip_counters.ini-cS4kbT)
[1660828884.085146][76806:76806] CHIP:DL: renamed tmp file to file (/tmp/chip_counters.ini)
[1660828884.085152][76806:76806] CHIP:DL: NVS set: chip-counters/boot-reason = 0 (0x0)
[1660828884.085257][76806:76806] CHIP:DL: Failed to get Ethernet interface
[1660828884.085286][76806:76806] CHIP:DL: Failed to reset Ethernet statistic counts
[1660828884.085306][76806:76806] CHIP:DL: Got WiFi interface: wlp0s20f3
[1660828884.085730][76806:76806] CHIP:DL: Found the primary WiFi interface:wlp0s20f3
[1660828884.085842][76806:76806] CHIP:DL: writing settings to file (/tmp/chip_counters.ini-lOn8lW)
[1660828884.085921][76806:76806] CHIP:DL: renamed tmp file to file (/tmp/chip_counters.ini)
[1660828884.085927][76806:76806] CHIP:DL: NVS set: chip-counters/GlobalMCTR = 1000 (0x3E8)
[1660828884.086980][76806:76806] CHIP:DL: Avahi client registered
[1660828884.087144][76806:76806] CHIP:ZCL: Using ZAP configuration...
[1660828884.087320][76806:76806] CHIP:DIS: Verifying the received credentials
[1660828884.087688][76806:76806] CHIP:DIS: Added new fabric at index: 1, Initialized: 1
[1660828884.087694][76806:76806] CHIP:DIS: Assigned compressed fabric ID: 0xED72ACA7202EA4F8, node ID: 0x000000000001B669
[1660828884.087697][76806:76806] CHIP:CTL: Joined the fabric at index 1. Compressed fabric ID is: 0xED72ACA7202EA4F8
[1660828884.087865][76806:76806] CHIP:DIS: Failed to find a valid admin pairing. Node ID unknown
[1660828884.087869][76806:76806] CHIP:DIS: Start dns-sd server - no current nodeId
[1660828884.087881][76806:76806] CHIP:DL: MAC is not known, using a default.
[1660828884.087902][76806:76806] CHIP:DIS: Advertise commission parameter vendorID=9050 productID=65279 discriminator=3840/00
[1660828884.087911][76806:76806] CHIP:DL: Cannot get device role with Thread api client: 
[1660828884.088043][76806:76806] CHIP:DL: Cannot set hostname on this system, continue anyway...
[1660828884.088061][76806:76806] CHIP:DL: PublishService 0DAFF3CE1C6AC573._matterc._udp5540.-1
[1660828884.088962][76806:76806] CHIP:DL: MAC is not known, using a default.
[1660828884.088984][76806:76806] CHIP:DIS: Advertise commission parameter vendorID=9050 productID=65279 discriminator=3840/00
[1660828884.088993][76806:76806] CHIP:DL: Cannot get device role with Thread api client: 
[1660828884.089062][76806:76806] CHIP:DL: Cannot set hostname on this system, continue anyway...
[1660828884.089069][76806:76806] CHIP:DL: PublishService 0DAFF3CE1C6AC573._matterd._udp5550.-1
[1660828884.089205][76806:76806] CHIP:DL: Avahi publish service failed: ../../src/platform/Linux/DnssdImpl.cpp:478: CHIP Error 0x000000AC: Internal error
[1660828884.089210][76806:76806] CHIP:DIS: Failed to advertise commissioner: ../../src/platform/Linux/DnssdImpl.cpp:478: CHIP Error 0x000000AC: Internal error
[1660828884.102388][76806:76812] CHIP:DL: Platform main loop started.
[1660828884.103077][76806:76812] CHIP:DIS: Failed to find a valid admin pairing. Node ID unknown
[1660828884.103083][76806:76812] CHIP:DIS: Start dns-sd server - no current nodeId
[1660828884.103100][76806:76812] CHIP:DL: MAC is not known, using a default.
[1660828884.103132][76806:76812] CHIP:DIS: Advertise commission parameter vendorID=9050 productID=65279 discriminator=3840/00
[1660828884.103143][76806:76812] CHIP:DL: Cannot get device role with Thread api client: 
[1660828884.103280][76806:76812] CHIP:DL: Cannot set hostname on this system, continue anyway...
[1660828884.103296][76806:76812] CHIP:DL: PublishService 0DAFF3CE1C6AC573._matterc._udp5540.-1
[1660828884.104163][76806:76812] CHIP:DL: MAC is not known, using a default.
[1660828884.104178][76806:76812] CHIP:DIS: Advertise commission parameter vendorID=9050 productID=65279 discriminator=3840/00
[1660828884.104185][76806:76812] CHIP:DL: Cannot get device role with Thread api client: 
[1660828884.104333][76806:76812] CHIP:DL: Cannot set hostname on this system, continue anyway...
[1660828884.104339][76806:76812] CHIP:DL: PublishService 0DAFF3CE1C6AC573._matterd._udp5550.-1
[1660828884.104484][76806:76812] CHIP:DL: Avahi publish service failed: ../../src/platform/Linux/DnssdImpl.cpp:478: CHIP Error 0x000000AC: Internal error
[1660828884.104489][76806:76812] CHIP:DIS: Failed to advertise commissioner: ../../src/platform/Linux/DnssdImpl.cpp:478: CHIP Error 0x000000AC: Internal error
Chip Device Controller Shell

chip-device-ctrl > [1660828886.055648][76806:76812] CHIP:DL: Avahi group established

chip-device-ctrl > ble-scan
2022-08-18 22:22:07,436 ChipBLEMgr   INFO     BLE disconnected
2022-08-18 22:22:12,437 ChipBLEMgr   INFO     BLE disconnect error
2022-08-18 22:22:14,730 ChipBLEMgr   INFO     scanning started
2022-08-18 22:22:19,398 ChipBLEMgr   INFO     Name            = None
2022-08-18 22:22:19,398 ChipBLEMgr   INFO     ID              = 765d8490-6ed6-42c3-9bdc-bfb5dccefc3b
2022-08-18 22:22:19,398 ChipBLEMgr   INFO     RSSI            = -70
2022-08-18 22:22:19,398 ChipBLEMgr   INFO     Address         = 78:21:84:B8:F1:76
2022-08-18 22:22:19,398 ChipBLEMgr   INFO     Pairing State   = 0
2022-08-18 22:22:19,398 ChipBLEMgr   INFO     Discriminator   = 3840
2022-08-18 22:22:19,398 ChipBLEMgr   INFO     Vendor Id       = 9050
2022-08-18 22:22:19,398 ChipBLEMgr   INFO     Product Id      = 17729
2022-08-18 22:22:19,399 ChipBLEMgr   INFO     Adv UUID        = 0000fff6-0000-1000-8000-00805f9b34fb
2022-08-18 22:22:19,399 ChipBLEMgr   INFO     Adv Data        = 00000f5a234145
2022-08-18 22:22:19,399 ChipBLEMgr   INFO     
2022-08-18 22:22:25,656 ChipBLEMgr   INFO     scanning stopped
chip-device-ctrl > connect -ble 3840 20202021 135246
Device is assigned with nodeid = 135246
[1660828976.232507][76806:76812] CHIP:IN: Prepared plaintext message 0x7f01a4eef8e0 to 0x0000000000000000 of type 0x20 and protocolId (0, 0) on exchange 57528i with MessageCounter:108135741.
[1660828976.232529][76806:76812] CHIP:IN: Sending plaintext msg 0x7f01a4eef8e0 with MessageCounter:108135741 to 0x0000000000000000 at monotonic time: 6134801 msec
[1660828976.236187][76806:76810] CHIP:BLE: BLE removing known devices.
[1660828976.237206][76806:76810] CHIP:BLE: BLE initiating scan.
[1660828976.691908][76806:76810] CHIP:BLE: New device scanned: 78:21:84:B8:F1:76
[1660828976.691920][76806:76810] CHIP:BLE: Device discriminator match. Attempting to connect.
[1660828976.754436][76806:76810] CHIP:BLE: Scan complete notification without an active scan.
[1660828979.375330][76806:76812] CHIP:BLE: subscribe complete, ep = 0x7f01a7f5f1c0
[1660828979.375731][76806:76812] CHIP:BLE: peripheral chose BTP version 4; central expected between 4 and 4
[1660828979.375742][76806:76812] CHIP:BLE: using BTP fragment sizes rx 244 / tx 244.
[1660828979.375747][76806:76812] CHIP:BLE: local and remote recv window size = 5
[1660828979.827938][76806:76812] CHIP:EM: Received message of type 0x21 with protocolId (0, 0) and MessageCounter:2979804365 on exchange 57528i
[1660828979.828282][76806:76812] CHIP:IN: Prepared plaintext message 0x7f01a4ef00b0 to 0x0000000000000000 of type 0x22 and protocolId (0, 0) on exchange 57528i with MessageCounter:108135742.
[1660828979.828297][76806:76812] CHIP:IN: Sending plaintext msg 0x7f01a4ef00b0 with MessageCounter:108135742 to 0x0000000000000000 at monotonic time: 6138397 msec
[1660828981.493438][76806:76812] CHIP:EM: Received message of type 0x23 with protocolId (0, 0) and MessageCounter:2979804366 on exchange 57528i
[1660828981.493721][76806:76812] CHIP:IN: Prepared plaintext message 0x7f01a4ef0150 to 0x0000000000000000 of type 0x24 and protocolId (0, 0) on exchange 57528i with MessageCounter:108135743.
[1660828981.493732][76806:76812] CHIP:IN: Sending plaintext msg 0x7f01a4ef0150 with MessageCounter:108135743 to 0x0000000000000000 at monotonic time: 6140062 msec
[1660828981.625809][76806:76812] CHIP:EM: Received message of type 0x40 with protocolId (0, 0) and MessageCounter:2979804367 on exchange 57528i
[1660828981.625922][76806:76812] CHIP:IN: Prepared encrypted message 0x7f01a4eeff10 to 0x000000000002104E of type 0x8 and protocolId (0, 1) on exchange 57529i with MessageCounter:0.
[1660828981.625931][76806:76812] CHIP:IN: Sending encrypted msg 0x7f01a4eeff10 with MessageCounter:0 to 0x000000000002104E at monotonic time: 6140194 msec
[1660828981.988325][76806:76812] CHIP:EM: Received message of type 0x9 with protocolId (0, 1) and MessageCounter:1 on exchange 57529i
[1660828981.988380][76806:76812] CHIP:DMG: Received Command Response Data, Endpoint=0 Cluster=0x0000_003E Command=0x0000_0003
SetCommandIndexStatus commandHandle=1 commandIndex=1
[1660828981.988525][76806:76812] CHIP:ZCL: CertificateChainResponse:
[1660828981.988530][76806:76812] CHIP:ZCL:   Certificate: 451
[1660828981.988542][76806:76812] CHIP:CTL: Received certificate chain from the device
[1660828981.988604][76806:76812] CHIP:IN: Prepared encrypted message 0x7f01a4eef960 to 0x000000000002104E of type 0x8 and protocolId (0, 1) on exchange 57530i with MessageCounter:1.
[1660828981.988613][76806:76812] CHIP:IN: Sending encrypted msg 0x7f01a4eef960 with MessageCounter:1 to 0x000000000002104E at monotonic time: 6140557 msec
[1660828982.218592][76806:76812] CHIP:EM: Received message of type 0x9 with protocolId (0, 1) and MessageCounter:2 on exchange 57530i
[1660828982.218674][76806:76812] CHIP:DMG: Received Command Response Data, Endpoint=0 Cluster=0x0000_003E Command=0x0000_0003
SetCommandIndexStatus commandHandle=1 commandIndex=1
[1660828982.218834][76806:76812] CHIP:ZCL: CertificateChainResponse:
[1660828982.218838][76806:76812] CHIP:ZCL:   Certificate: 494
[1660828982.218842][76806:76812] CHIP:CTL: Received certificate chain from the device
[1660828982.218847][76806:76812] CHIP:CTL: Sending Attestation Request to the device.
[1660828982.218913][76806:76812] CHIP:IN: Prepared encrypted message 0x7f01a4eef960 to 0x000000000002104E of type 0x8 and protocolId (0, 1) on exchange 57531i with MessageCounter:2.
[1660828982.218923][76806:76812] CHIP:IN: Sending encrypted msg 0x7f01a4eef960 with MessageCounter:2 to 0x000000000002104E at monotonic time: 6140787 msec
[1660828982.667976][76806:76812] CHIP:EM: Received message of type 0x9 with protocolId (0, 1) and MessageCounter:3 on exchange 57531i
[1660828982.668033][76806:76812] CHIP:DMG: Received Command Response Data, Endpoint=0 Cluster=0x0000_003E Command=0x0000_0001
SetCommandIndexStatus commandHandle=1 commandIndex=1
[1660828982.668122][76806:76812] CHIP:ZCL: AttestationResponse:
[1660828982.668127][76806:76812] CHIP:ZCL:   AttestationElements: 171
[1660828982.668131][76806:76812] CHIP:ZCL:   Signature: 64
[1660828982.668136][76806:76812] CHIP:CTL: Received Attestation Information from the device
[1660828982.669303][76806:76812] CHIP:CTL: Successfully validated 'Attestation Information' command received from the device.
[1660828982.669312][76806:76812] CHIP:CTL: Sending 'CSR request' command to the device.
[1660828982.669385][76806:76812] CHIP:IN: Prepared encrypted message 0x7f01a4eef960 to 0x000000000002104E of type 0x8 and protocolId (0, 1) on exchange 57532i with MessageCounter:3.
[1660828982.669399][76806:76812] CHIP:IN: Sending encrypted msg 0x7f01a4eef960 with MessageCounter:3 to 0x000000000002104E at monotonic time: 6141238 msec
[1660828983.475215][76806:76812] CHIP:EM: Received message of type 0x9 with protocolId (0, 1) and MessageCounter:4 on exchange 57532i
[1660828983.475273][76806:76812] CHIP:DMG: Received Command Response Data, Endpoint=0 Cluster=0x0000_003E Command=0x0000_0005
SetCommandIndexStatus commandHandle=1 commandIndex=1
[1660828983.475408][76806:76812] CHIP:ZCL: OpCSRResponse:
[1660828983.475412][76806:76812] CHIP:ZCL:   NOCSRElements: 254
[1660828983.475415][76806:76812] CHIP:ZCL:   AttestationSignature: 0
[1660828983.475420][76806:76812] CHIP:CTL: Received certificate signing request from the device
[1660828983.475424][76806:76812] CHIP:CTL: Getting certificate chain for the device from the issuer
[1660828983.475427][76806:76812] CHIP:CTL: Verifying Certificate Signing Request
[1660828983.475622][76806:76812] CHIP:CTL: Generating NOC
[1660828983.475695][76806:76812] CHIP:CTL: Generating ICAC
[1660828983.475744][76806:76812] CHIP:CTL: Providing certificate chain to the commissioner
[1660828983.475748][76806:76812] CHIP:CTL: Received callback from the CA for NOC Chain generation. Status ../../src/controller/ExampleOperationalCredentialsIssuer.cpp:183: Success
[1660828983.475781][76806:76812] CHIP:CTL: Sending root certificate to the device
[1660828983.475835][76806:76812] CHIP:IN: Prepared encrypted message 0x7f01a4eef680 to 0x000000000002104E of type 0x8 and protocolId (0, 1) on exchange 57533i with MessageCounter:4.
[1660828983.475846][76806:76812] CHIP:IN: Sending encrypted msg 0x7f01a4eef680 with MessageCounter:4 to 0x000000000002104E at monotonic time: 6142044 msec
[1660828983.475871][76806:76812] CHIP:CTL: Sent root certificate to the device
[1660828983.741608][76806:76812] CHIP:EM: Received message of type 0x9 with protocolId (0, 1) and MessageCounter:5 on exchange 57533i
[1660828983.741660][76806:76812] CHIP:DMG: Received Command Response Status for Endpoint=0 Cluster=0x0000_003E Command=0x0000_000B Status=0x0
SetCommandIndexStatus commandHandle=1 commandIndex=1
[1660828983.741770][76806:76812] CHIP:ZCL: DefaultResponse:
[1660828983.741773][76806:76812] CHIP:ZCL:   Transaction: 0x7f019000f290
[1660828983.741777][76806:76812] CHIP:ZCL:   status: EMBER_ZCL_STATUS_SUCCESS (0x00)
[1660828983.741783][76806:76812] CHIP:CTL: Device confirmed that it has received the root certificate
[1660828983.741786][76806:76812] CHIP:CTL: Sending operational certificate chain to the device
[1660828983.741844][76806:76812] CHIP:IN: Prepared encrypted message 0x7f01a4eefaf0 to 0x000000000002104E of type 0x8 and protocolId (0, 1) on exchange 57534i with MessageCounter:5.
[1660828983.741853][76806:76812] CHIP:IN: Sending encrypted msg 0x7f01a4eefaf0 with MessageCounter:5 to 0x000000000002104E at monotonic time: 6142310 msec
[1660828983.741878][76806:76812] CHIP:CTL: Sent operational certificate to the device
[1660828985.901332][76806:76812] CHIP:EM: Received message of type 0x9 with protocolId (0, 1) and MessageCounter:6 on exchange 57534i
[1660828985.901399][76806:76812] CHIP:DMG: Received Command Response Data, Endpoint=0 Cluster=0x0000_003E Command=0x0000_0008
SetCommandIndexStatus commandHandle=1 commandIndex=1
[1660828985.901551][76806:76812] CHIP:ZCL: NOCResponse:
[1660828985.901554][76806:76812] CHIP:ZCL:   StatusCode: 0
[1660828985.901557][76806:76812] CHIP:ZCL:   FabricIndex: 1
[1660828985.901561][76806:76812] CHIP:ZCL:   DebugText: 
[1660828985.901567][76806:76812] CHIP:CTL: Device returned status 0 on receiving the NOC
[1660828985.901572][76806:76812] CHIP:CTL: Operational credentials provisioned on device 0x22dc858
Secure Session to Device Established
Device temporary node id (**this does not match spec**): 135246
chip-device-ctrl > 
chip-device-ctrl > zcl NetworkCommissioning AddWiFiNetwork 135246 0 0 ssid=str:<<SSID>> credentials=str:<<passcode>> breadcrumb=0 timeoutMs=1000
[1660829153.438407][76806:76812] CHIP:IN: Prepared encrypted message 0x7f01a4eef670 to 0x000000000002104E of type 0x8 and protocolId (0, 1) on exchange 57535i with MessageCounter:7.
[1660829153.438426][76806:76812] CHIP:IN: Sending encrypted msg 0x7f01a4eef670 with MessageCounter:7 to 0x000000000002104E at monotonic time: 6312007 msec
[1660829153.536411][76806:76812] CHIP:EM: Received message of type 0x9 with protocolId (0, 1) and MessageCounter:7 on exchange 57535i
[1660829153.536479][76806:76812] CHIP:DMG: Received Command Response Status for Endpoint=0 Cluster=0x0000_0031 Command=0x0000_0002 Status=0x0
SetCommandIndexStatus commandHandle=1 commandIndex=1
[1660829153.536623][76806:76812] CHIP:ZCL: DefaultResponse:
[1660829153.536626][76806:76812] CHIP:ZCL:   Transaction: 0x7f0190011f10
[1660829153.536628][76806:76812] CHIP:ZCL:   status: EMBER_ZCL_STATUS_SUCCESS (0x00)
Received command status response:
Container: 
    Status = 0
    ClusterStatus = 255
    EndpointId = 0
    ClusterId = 49
    CommandId = 2
    CommandIndex = 1
chip-device-ctrl > 
chip-device-ctrl >  - chip-device-ctrl > zcl NetworkCommissioning EnableNetwork 135246 0 0 networkID=str:<<SSID>> breadcrumb=0 timeoutMs=1000
*** Unknown syntax:  chip-device-ctrl > zcl NetworkCommissioning EnableNetwork 135246 0 0 networkID=str:<<SSID>> breadcrumb=0 timeoutMs=1000
chip-device-ctrl > zcl NetworkCommissioning EnableNetwork 135246 0 0 networkID=str:<<SSID>> breadcrumb=0 timeoutMs=1000
[1660829206.459712][76806:76812] CHIP:IN: Prepared encrypted message 0x7f01a4eef700 to 0x000000000002104E of type 0x8 and protocolId (0, 1) on exchange 57536i with MessageCounter:8.
[1660829206.459736][76806:76812] CHIP:IN: Sending encrypted msg 0x7f01a4eef700 with MessageCounter:8 to 0x000000000002104E at monotonic time: 6365028 msec
[1660829206.683273][76806:76812] CHIP:EM: Received message of type 0x9 with protocolId (0, 1) and MessageCounter:8 on exchange 57536i
[1660829206.683316][76806:76812] CHIP:DMG: Received Command Response Status for Endpoint=0 Cluster=0x0000_0031 Command=0x0000_000C Status=0x0
SetCommandIndexStatus commandHandle=1 commandIndex=1
[1660829206.683407][76806:76812] CHIP:ZCL: DefaultResponse:
[1660829206.683410][76806:76812] CHIP:ZCL:   Transaction: 0x7f0190011f10
[1660829206.683413][76806:76812] CHIP:ZCL:   status: EMBER_ZCL_STATUS_SUCCESS (0x00)
Received command status response:
Container: 
    Status = 0
    ClusterStatus = 255
    EndpointId = 0
    ClusterId = 49
    CommandId = 12
    CommandIndex = 1
chip-device-ctrl > close-ble
[1660829214.076293][76806:76812] CHIP:BLE: Auto-closing end point's BLE connection.
[1660829214.076301][76806:76812] CHIP:DL: Closing BLE GATT connection (con 0x7f019c02d140)
chip-device-ctrl > [1660829216.448925][76806:76812] CHIP:BLE: no endpoint for unsub complete
[1660829216.448960][76806:76810] CHIP:DL: Bluez notify CHIPoBluez connection disconnected

chip-device-ctrl > resolve 135246
[1660829230.996871][76806:76812] CHIP:DL: Avahi resolve found
[1660829230.996902][76806:76812] CHIP:DIS: Node ID resolved for 0x000000000002104E to [192.168.0.18]:5540
Node address has been updated
[1660829230.997301][76806:76812] CHIP:CTL: OperationalDiscoveryComplete for device ID 135246
[1660829230.997497][76806:76812] CHIP:IN: Prepared plaintext message 0x231a020 to 0x0000000000000000 of type 0x30 and protocolId (0, 0) on exchange 57537i with MessageCounter:3305705472.
[1660829230.997510][76806:76812] CHIP:IN: Sending plaintext msg 0x231a020 with MessageCounter:3305705472 to 0x0000000000000000 at monotonic time: 6389566 msec
[1660829232.556777][76806:76812] CHIP:EM: Received message of type 0x31 with protocolId (0, 0) and MessageCounter:2510115655 on exchange 57537i
[1660829232.558175][76806:76812] CHIP:IN: Prepared plaintext message 0x231a020 to 0x0000000000000000 of type 0x32 and protocolId (0, 0) on exchange 57537i with MessageCounter:3305705473.
[1660829232.558202][76806:76812] CHIP:IN: Sending plaintext msg 0x231a020 with MessageCounter:3305705473 to 0x0000000000000000 at monotonic time: 6391126 msec
[1660829234.607098][76806:76812] CHIP:EM: Received message of type 0x40 with protocolId (0, 0) and MessageCounter:2510115656 on exchange 57537i
[1660829234.607160][76806:76812] CHIP:SC: Success status report received. Session was established
Commissioning complete
[1660829234.607302][76806:76812] CHIP:IN: Prepared plaintext message 0x7f01a4ef00f0 to 0x0000000000000000 of type 0x10 and protocolId (0, 0) on exchange 57537i with MessageCounter:3305705474.
[1660829234.607317][76806:76812] CHIP:IN: Sending plaintext msg 0x7f01a4ef00f0 with MessageCounter:3305705474 to 0x0000000000000000 at monotonic time: 6393176 msec
Current address: 192.168.0.18:5540
chip-device-ctrl > 
chip-device-ctrl > 
chip-device-ctrl > zcl OnOff Off 135246 1 1
[1660829259.123474][76806:76812] CHIP:IN: Prepared encrypted message 0x231a020 to 0x000000000002104E of type 0x8 and protocolId (0, 1) on exchange 57538i with MessageCounter:0.
[1660829259.123494][76806:76812] CHIP:IN: Sending encrypted msg 0x231a020 with MessageCounter:0 to 0x000000000002104E at monotonic time: 6417692 msec
[1660829259.384796][76806:76812] CHIP:EM: Received message of type 0x9 with protocolId (0, 1) and MessageCounter:1 on exchange 57538i
[1660829259.384875][76806:76812] CHIP:DMG: Received Command Response Status for Endpoint=1 Cluster=0x0000_0006 Command=0x0000_0000 Status=0x0
SetCommandIndexStatus commandHandle=1 commandIndex=1
[1660829259.385010][76806:76812] CHIP:ZCL: DefaultResponse:
[1660829259.385014][76806:76812] CHIP:ZCL:   Transaction: 0x7f0190011f10
[1660829259.385018][76806:76812] CHIP:ZCL:   status: EMBER_ZCL_STATUS_SUCCESS (0x00)
[1660829259.385073][76806:76812] CHIP:IN: Prepared encrypted message 0x7f01a4ef00c0 to 0x000000000002104E of type 0x10 and protocolId (0, 0) on exchange 57538i with MessageCounter:1.
Received command status response:
[1660829259.385085][76806:76812] CHIP:IN: Sending encrypted msg 0x7f01a4ef00c0 with MessageCounter:1 to 0x000000000002104E at monotonic time: 6417953 msec
Container: 
    Status = 0
    ClusterStatus = 255
    EndpointId = 1
    ClusterId = 6
    CommandId = 0
    CommandIndex = 1
chip-device-ctrl > [1660829264.299102][76806:76812] CHIP:EM: Received message of type 0x9 with protocolId (0, 1) and MessageCounter:1 on exchange 57538i
[1660829264.299148][76806:76812] CHIP:IN: Prepared encrypted message 0x7f01a4ef01e0 to 0x000000000002104E of type 0x10 and protocolId (0, 0) on exchange 57538i with MessageCounter:2.
[1660829264.299159][76806:76812] CHIP:IN: Sending encrypted msg 0x7f01a4ef01e0 with MessageCounter:2 to 0x000000000002104E at monotonic time: 6422867 msec

chip-device-ctrl > zcl LevelControl MoveToLevel 135246 1 1 level=10 transitionTime=0 optionMask=0 optionOverride=0
[1660829291.308721][76806:76812] CHIP:IN: Prepared encrypted message 0x231a020 to 0x000000000002104E of type 0x8 and protocolId (0, 1) on exchange 57539i with MessageCounter:3.
[1660829291.308771][76806:76812] CHIP:IN: Sending encrypted msg 0x231a020 with MessageCounter:3 to 0x000000000002104E at monotonic time: 6449877 msec
[1660829291.641036][76806:76812] CHIP:EM: Received message of type 0x9 with protocolId (0, 1) and MessageCounter:2 on exchange 57539i
[1660829291.641104][76806:76812] CHIP:DMG: Received Command Response Status for Endpoint=1 Cluster=0x0000_0008 Command=0x0000_0000 Status=0x0
SetCommandIndexStatus commandHandle=1 commandIndex=1
[1660829291.641202][76806:76812] CHIP:ZCL: DefaultResponse:
[1660829291.641205][76806:76812] CHIP:ZCL:   Transaction: 0x7f0190011f10
[1660829291.641209][76806:76812] CHIP:ZCL:   status: EMBER_ZCL_STATUS_SUCCESS (0x00)
Received command status response:
[1660829291.641254][76806:76812] CHIP:IN: Prepared encrypted message 0x7f01a4ef00c0 to 0x000000000002104E of type 0x10 and protocolId (0, 0) on exchange 57539i with MessageCounter:4.
[1660829291.641265][76806:76812] CHIP:IN: Sending encrypted msg 0x7f01a4ef00c0 with MessageCounter:4 to 0x000000000002104E at monotonic time: 6450209 msec
Container: 
    Status = 0
    ClusterStatus = 255
    EndpointId = 1
    ClusterId = 8
    CommandId = 0
    CommandIndex = 1
chip-device-ctrl > [1660829296.446613][76806:76812] CHIP:EM: Received message of type 0x9 with protocolId (0, 1) and MessageCounter:2 on exchange 57539i
[1660829296.446655][76806:76812] CHIP:IN: Prepared encrypted message 0x7f01a4ef01e0 to 0x000000000002104E of type 0x10 and protocolId (0, 0) on exchange 57539i with MessageCounter:5.
[1660829296.446665][76806:76812] CHIP:IN: Sending encrypted msg 0x7f01a4ef01e0 with MessageCounter:5 to 0x000000000002104E at monotonic time: 6455015 msec

댓글