python command: ./out/debug/chip-tool wakeonlan read wake-on-lan-mac-address 1234 1 Mac Chip Tool Log [1643072172125] [18045:5782856] CHIP: [DL] _Init [1643072172126] [18045:5782856] CHIP: [IN] UDP::Init bind&listen port=5542 [1643072172126] [18045:5782856] CHIP: [IN] UDP::Init bound to port=5542 [1643072172126] [18045:5782856] CHIP: [IN] UDP::Init bind&listen port=5542 [1643072172127] [18045:5782856] CHIP: [IN] UDP::Init bound to port=5542 [1643072172127] [18045:5782856] CHIP: [IN] TransportMgr initialized [1643072172127] [18045:5782856] CHIP: [DIS] Init fabric pairing table with server storage [1643072172127] [18045:5782856] CHIP: [ZCL] Using ZAP configuration... [1643072172127] [18045:5782856] CHIP: [CTL] System State Initialized... [1643072172133] [18045:5782856] CHIP: [CTL] Generating NOC [1643072172134] [18045:5782856] CHIP: [CTL] Generating ICAC [1643072172134] [18045:5782856] CHIP: [DIS] Verifying the received credentials [1643072172135] [18045:5782856] CHIP: [IN] Generating compressed fabric ID using uncompressed fabric ID 0x0000000000000001 and root pubkey [1643072172135] [18045:5782856] CHIP: [IN] 0x04, 0xca, 0x41, 0xc3, 0xe1, 0x83, 0x33, 0xc6,  [1643072172135] [18045:5782856] CHIP: [IN] 0xe5, 0x4a, 0xaa, 0x36, 0x98, 0xfe, 0x0d, 0xb3,  [1643072172135] [18045:5782856] CHIP: [IN] 0x43, 0x0b, 0x81, 0xb3, 0xca, 0xc6, 0xc1, 0x1b,  [1643072172135] [18045:5782856] CHIP: [IN] 0x67, 0x0d, 0x71, 0x0b, 0x76, 0xfe, 0xc7, 0x48,  [1643072172135] [18045:5782856] CHIP: [IN] 0x24, 0x38, 0xfe, 0xce, 0x8f, 0xe4, 0xa2, 0xb3,  [1643072172135] [18045:5782856] CHIP: [IN] 0xed, 0xe4, 0x79, 0x06, 0xb2, 0x54, 0xcc, 0xc1,  [1643072172135] [18045:5782856] CHIP: [IN] 0xed, 0x3b, 0x22, 0x01, 0x45, 0x34, 0xd1, 0x04,  [1643072172135] [18045:5782856] CHIP: [IN] 0x9a, 0x34, 0x01, 0x9c, 0xa2, 0x50, 0xab, 0x05,  [1643072172135] [18045:5782856] CHIP: [IN] 0x3b,  [1643072172135] [18045:5782856] CHIP: [IN] Generated compressed fabric ID [1643072172135] [18045:5782856] CHIP: [IN] 0xf3, 0x3b, 0x41, 0xde, 0x52, 0x54, 0x99, 0xdc,  [1643072172135] [18045:5782856] CHIP: [DIS] Added new fabric at index: 1, Initialized: 1 [1643072172135] [18045:5782856] CHIP: [DIS] Assigned compressed fabric ID: 0xF33B41DE525499DC, node ID: 0x000000000001B669 [1643072172135] [18045:5782856] CHIP: [CTL] Joined the fabric at index 1. Compressed fabric ID is: 0xF33B41DE525499DC [1643072172135] [18045:5782856] CHIP: [IN] UDP::Init bind&listen port=5550 [1643072172135] [18045:5782856] CHIP: [IN] UDP::Init bound to port=5550 [1643072172135] [18045:5782856] CHIP: [IN] UDP::Init bind&listen port=5550 [1643072172135] [18045:5782856] CHIP: [IN] UDP::Init bound to port=5550 [1643072172135] [18045:5782856] CHIP: [IN] TransportMgr initialized [1643072172136] [18045:5782856] CHIP: [CTL] Generating NOC [1643072172136] [18045:5782856] CHIP: [CTL] Generating ICAC [1643072172136] [18045:5782856] CHIP: [DIS] Verifying the received credentials [1643072172136] [18045:5782856] CHIP: [IN] Generating compressed fabric ID using uncompressed fabric ID 0x0000000000000002 and root pubkey [1643072172136] [18045:5782856] CHIP: [IN] 0x04, 0xca, 0x41, 0xc3, 0xe1, 0x83, 0x33, 0xc6,  [1643072172136] [18045:5782856] CHIP: [IN] 0xe5, 0x4a, 0xaa, 0x36, 0x98, 0xfe, 0x0d, 0xb3,  [1643072172136] [18045:5782856] CHIP: [IN] 0x43, 0x0b, 0x81, 0xb3, 0xca, 0xc6, 0xc1, 0x1b,  [1643072172136] [18045:5782856] CHIP: [IN] 0x67, 0x0d, 0x71, 0x0b, 0x76, 0xfe, 0xc7, 0x48,  [1643072172136] [18045:5782856] CHIP: [IN] 0x24, 0x38, 0xfe, 0xce, 0x8f, 0xe4, 0xa2, 0xb3,  [1643072172136] [18045:5782856] CHIP: [IN] 0xed, 0xe4, 0x79, 0x06, 0xb2, 0x54, 0xcc, 0xc1,  [1643072172136] [18045:5782856] CHIP: [IN] 0xed, 0x3b, 0x22, 0x01, 0x45, 0x34, 0xd1, 0x04,  [1643072172136] [18045:5782856] CHIP: [IN] 0x9a, 0x34, 0x01, 0x9c, 0xa2, 0x50, 0xab, 0x05,  [1643072172136] [18045:5782856] CHIP: [IN] 0x3b,  [1643072172136] [18045:5782856] CHIP: [IN] Generated compressed fabric ID [1643072172136] [18045:5782856] CHIP: [IN] 0xad, 0x43, 0x6f, 0xf6, 0x51, 0xcc, 0xfd, 0xce,  [1643072172136] [18045:5782856] CHIP: [DIS] Added new fabric at index: 2, Initialized: 1 [1643072172136] [18045:5782856] CHIP: [DIS] Assigned compressed fabric ID: 0xAD436FF651CCFDCE, node ID: 0x000000000001B669 [1643072172136] [18045:5782856] CHIP: [CTL] Joined the fabric at index 2. Compressed fabric ID is: 0xAD436FF651CCFDCE [1643072172136] [18045:5782856] CHIP: [IN] UDP::Init bind&listen port=5550 [1643072172136] [18045:5782856] CHIP: [IN] UDP::Init bound to port=5550 [1643072172136] [18045:5782856] CHIP: [IN] UDP::Init bind&listen port=5550 [1643072172137] [18045:5782856] CHIP: [IN] UDP::Init bound to port=5550 [1643072172137] [18045:5782856] CHIP: [IN] TransportMgr initialized [1643072172137] [18045:5782856] CHIP: [CTL] Generating NOC [1643072172137] [18045:5782856] CHIP: [CTL] Generating ICAC [1643072172138] [18045:5782856] CHIP: [DIS] Verifying the received credentials [1643072172138] [18045:5782856] CHIP: [IN] Generating compressed fabric ID using uncompressed fabric ID 0x0000000000000003 and root pubkey [1643072172138] [18045:5782856] CHIP: [IN] 0x04, 0xca, 0x41, 0xc3, 0xe1, 0x83, 0x33, 0xc6,  [1643072172138] [18045:5782856] CHIP: [IN] 0xe5, 0x4a, 0xaa, 0x36, 0x98, 0xfe, 0x0d, 0xb3,  [1643072172138] [18045:5782856] CHIP: [IN] 0x43, 0x0b, 0x81, 0xb3, 0xca, 0xc6, 0xc1, 0x1b,  [1643072172138] [18045:5782856] CHIP: [IN] 0x67, 0x0d, 0x71, 0x0b, 0x76, 0xfe, 0xc7, 0x48,  [1643072172138] [18045:5782856] CHIP: [IN] 0x24, 0x38, 0xfe, 0xce, 0x8f, 0xe4, 0xa2, 0xb3,  [1643072172138] [18045:5782856] CHIP: [IN] 0xed, 0xe4, 0x79, 0x06, 0xb2, 0x54, 0xcc, 0xc1,  [1643072172138] [18045:5782856] CHIP: [IN] 0xed, 0x3b, 0x22, 0x01, 0x45, 0x34, 0xd1, 0x04,  [1643072172138] [18045:5782856] CHIP: [IN] 0x9a, 0x34, 0x01, 0x9c, 0xa2, 0x50, 0xab, 0x05,  [1643072172138] [18045:5782856] CHIP: [IN] 0x3b,  [1643072172138] [18045:5782856] CHIP: [IN] Generated compressed fabric ID [1643072172138] [18045:5782856] CHIP: [IN] 0x43, 0x2b, 0x62, 0x34, 0x72, 0x74, 0x79, 0x61,  [1643072172138] [18045:5782856] CHIP: [DIS] Added new fabric at index: 3, Initialized: 1 [1643072172138] [18045:5782856] CHIP: [DIS] Assigned compressed fabric ID: 0x432B623472747961, node ID: 0x000000000001B669 [1643072172138] [18045:5782856] CHIP: [CTL] Joined the fabric at index 3. Compressed fabric ID is: 0x432B623472747961 [1643072172138] [18045:5782856] CHIP: [IN] UDP::Init bind&listen port=5550 [1643072172138] [18045:5782856] CHIP: [IN] UDP::Init bound to port=5550 [1643072172138] [18045:5782856] CHIP: [IN] UDP::Init bind&listen port=5550 [1643072172138] [18045:5782856] CHIP: [IN] UDP::Init bound to port=5550 [1643072172138] [18045:5782856] CHIP: [IN] TransportMgr initialized [1643072172138] [18045:5782858] CHIP: [DL] _OnPlatformEvent [1643072172138] [18045:5782858] CHIP: [TOO] Sending command to node 0x4d2 [1643072172253] [18045:5782858] CHIP: [DL] Resolved interface id: 7 [1643072172254] [18045:5782858] CHIP: [DL] Mdns: OnGetAddrInfo hostname:EEAABADABAD0DDCA.local. [1643072172254] [18045:5782858] CHIP: [DIS] Node ID resolved for 0x00000000000004D2 [1643072172254] [18045:5782858] CHIP: [DIS] Addr 0: [fe80::dea6:32ff:fea8:49ea]:5540 [1643072172254] [18045:5782858] CHIP: [CTL] OperationalDiscoveryComplete for device ID 0x00000000000004D2 [1643072172254] [18045:5782858] CHIP: [IN] Generating DestinationID. Fabric ID 0x0000000000000001, Dest node ID 0x00000000000004D2, Random data [1643072172254] [18045:5782858] CHIP: [IN] 0x9b, 0x69, 0x25, 0x7c, 0xa9, 0x77, 0x79, 0x68,  [1643072172254] [18045:5782858] CHIP: [IN] 0x7a, 0xec, 0xeb, 0xc6, 0x9f, 0x62, 0x89, 0xa9,  [1643072172254] [18045:5782858] CHIP: [IN] 0xa0, 0x8e, 0x02, 0x5b, 0xd5, 0x1e, 0x29, 0x36,  [1643072172254] [18045:5782858] CHIP: [IN] 0xa6, 0x1c, 0x55, 0x14, 0x2d, 0x40, 0xdb, 0xcc,  [1643072172254] [18045:5782858] CHIP: [IN] Root pubkey [1643072172254] [18045:5782858] CHIP: [IN] 0x04, 0xca, 0x41, 0xc3, 0xe1, 0x83, 0x33, 0xc6,  [1643072172254] [18045:5782858] CHIP: [IN] 0xe5, 0x4a, 0xaa, 0x36, 0x98, 0xfe, 0x0d, 0xb3,  [1643072172254] [18045:5782858] CHIP: [IN] 0x43, 0x0b, 0x81, 0xb3, 0xca, 0xc6, 0xc1, 0x1b,  [1643072172254] [18045:5782858] CHIP: [IN] 0x67, 0x0d, 0x71, 0x0b, 0x76, 0xfe, 0xc7, 0x48,  [1643072172254] [18045:5782858] CHIP: [IN] 0x24, 0x38, 0xfe, 0xce, 0x8f, 0xe4, 0xa2, 0xb3,  [1643072172254] [18045:5782858] CHIP: [IN] 0xed, 0xe4, 0x79, 0x06, 0xb2, 0x54, 0xcc, 0xc1,  [1643072172254] [18045:5782858] CHIP: [IN] 0xed, 0x3b, 0x22, 0x01, 0x45, 0x34, 0xd1, 0x04,  [1643072172254] [18045:5782858] CHIP: [IN] 0x9a, 0x34, 0x01, 0x9c, 0xa2, 0x50, 0xab, 0x05,  [1643072172254] [18045:5782858] CHIP: [IN] 0x3b,  [1643072172254] [18045:5782858] CHIP: [IN] IPK [1643072172254] [18045:5782858] CHIP: [IN] 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00,  [1643072172254] [18045:5782858] CHIP: [IN] 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00,  [1643072172254] [18045:5782858] CHIP: [IN] Generated DestinationID output [1643072172254] [18045:5782858] CHIP: [IN] 0xa1, 0xd0, 0xe8, 0x75, 0x6a, 0xd1, 0x22, 0xcf,  [1643072172254] [18045:5782858] CHIP: [IN] 0xcd, 0xe6, 0x9f, 0x28, 0xb5, 0x5c, 0x2e, 0x60,  [1643072172254] [18045:5782858] CHIP: [IN] 0xb8, 0xa6, 0xee, 0xc0, 0x0c, 0x71, 0x4b, 0xaa,  [1643072172254] [18045:5782858] CHIP: [IN] 0x05, 0x36, 0xd5, 0x08, 0x0e, 0x60, 0xff, 0x58,  [1643072172254] [18045:5782858] CHIP: [SC] Including MRP parameters [1643072172254] [18045:5782858] CHIP: [IN] Prepared plaintext message 0x7fb2e500d870 to 0x0000000000000000 (0) of type 0x30 and protocolId (0, 0) on exchange 13965i with MessageCounter:2839139666. [1643072172254] [18045:5782858] CHIP: [IN] Sending plaintext msg 0x7fb2e500d870 with MessageCounter:2839139666 to 0x0000000000000000 at monotonic time: 1586618067 msec [1643072172254] [18045:5782858] CHIP: [SC] Sent Sigma1 msg [1643072172254] [18045:5782858] CHIP: [CTL] Address resolved for node: 0x00000000000004D2 [1643072172269] [18045:5782860] CHIP: [EM] Received message of type 0x31 with protocolId (0, 0) and MessageCounter:3044037428 on exchange 13965i [1643072172269] [18045:5782860] CHIP: [EM] Found matching exchange: 13965i, Delegate: 0x7fb2e5900cb8 [1643072172269] [18045:5782860] CHIP: [EM] Rxd Ack; Removing MessageCounter:2839139666 from Retrans Table on exchange 13965i [1643072172269] [18045:5782860] CHIP: [EM] Removed CHIP MessageCounter:2839139666 from RetransTable on exchange 13965i [1643072172269] [18045:5782860] CHIP: [SC] Received Sigma2 msg [1643072172269] [18045:5782860] CHIP: [SC] Peer assigned session session ID 56 [1643072172270] [18045:5782860] CHIP: [IN] Generating compressed fabric ID using uncompressed fabric ID 0x0000000000000001 and root pubkey [1643072172270] [18045:5782860] CHIP: [IN] 0x04, 0xca, 0x41, 0xc3, 0xe1, 0x83, 0x33, 0xc6,  [1643072172270] [18045:5782860] CHIP: [IN] 0xe5, 0x4a, 0xaa, 0x36, 0x98, 0xfe, 0x0d, 0xb3,  [1643072172270] [18045:5782860] CHIP: [IN] 0x43, 0x0b, 0x81, 0xb3, 0xca, 0xc6, 0xc1, 0x1b,  [1643072172270] [18045:5782860] CHIP: [IN] 0x67, 0x0d, 0x71, 0x0b, 0x76, 0xfe, 0xc7, 0x48,  [1643072172270] [18045:5782860] CHIP: [IN] 0x24, 0x38, 0xfe, 0xce, 0x8f, 0xe4, 0xa2, 0xb3,  [1643072172270] [18045:5782860] CHIP: [IN] 0xed, 0xe4, 0x79, 0x06, 0xb2, 0x54, 0xcc, 0xc1,  [1643072172270] [18045:5782860] CHIP: [IN] 0xed, 0x3b, 0x22, 0x01, 0x45, 0x34, 0xd1, 0x04,  [1643072172270] [18045:5782860] CHIP: [IN] 0x9a, 0x34, 0x01, 0x9c, 0xa2, 0x50, 0xab, 0x05,  [1643072172270] [18045:5782860] CHIP: [IN] 0x3b,  [1643072172270] [18045:5782860] CHIP: [IN] Generated compressed fabric ID [1643072172270] [18045:5782860] CHIP: [IN] 0xf3, 0x3b, 0x41, 0xde, 0x52, 0x54, 0x99, 0xdc,  [1643072172271] [18045:5782860] CHIP: [SC] Found MRP parameters in the message [1643072172271] [18045:5782860] CHIP: [SC] Sending Sigma3 [1643072172271] [18045:5782860] CHIP: [EM] Piggybacking Ack for MessageCounter:3044037428 on exchange: 13965i [1643072172271] [18045:5782860] CHIP: [IN] Prepared plaintext message 0x7fb2e500d870 to 0x0000000000000000 (0) of type 0x32 and protocolId (0, 0) on exchange 13965i with MessageCounter:2839139667. [1643072172271] [18045:5782860] CHIP: [IN] Sending plaintext msg 0x7fb2e500d870 with MessageCounter:2839139667 to 0x0000000000000000 at monotonic time: 1586618084 msec [1643072172271] [18045:5782860] CHIP: [SC] Sent Sigma3 msg [1643072172277] [18045:5782860] CHIP: [EM] Received message of type 0x40 with protocolId (0, 0) and MessageCounter:3044037429 on exchange 13965i [1643072172277] [18045:5782860] CHIP: [EM] Found matching exchange: 13965i, Delegate: 0x7fb2e5900cb8 [1643072172277] [18045:5782860] CHIP: [EM] Rxd Ack; Removing MessageCounter:2839139667 from Retrans Table on exchange 13965i [1643072172277] [18045:5782860] CHIP: [EM] Removed CHIP MessageCounter:2839139667 from RetransTable on exchange 13965i [1643072172277] [18045:5782860] CHIP: [SC] Success status report received. Session was established [1643072172277] [18045:5782860] CHIP: [IN] New secure session created for device 0x00000000000004D2, key 56!! [1643072172277] [18045:5782860] CHIP: [TOO] Sending cluster (0x0503) command (0x00) on endpoint 1 [1643072172277] [18045:5782860] CHIP: [DMG] SendReadRequest ReadClient[0x6000026e4620]: Sending Read Request [1643072172277] [18045:5782860] CHIP: [IN] Prepared encrypted message 0x7fb2e500d870 to 0x00000000000004D2 (1) of type 0x2 and protocolId (0, 1) on exchange 13966i with MessageCounter:1314130. [1643072172277] [18045:5782860] CHIP: [IN] Sending encrypted msg 0x7fb2e500d870 with MessageCounter:1314130 to 0x00000000000004D2 (1) at monotonic time: 1586618090 msec [1643072172277] [18045:5782860] CHIP: [DMG] MoveToState ReadClient[0x6000026e4620]: Moving to [AwaitingIn] [1643072172277] [18045:5782860] CHIP: [CTL] Device connected callback with null pairing delegate. Ignoring [1643072172277] [18045:5782860] CHIP: [EM] Sending Standalone Ack for MessageCounter:3044037429 on exchange 13965i [1643072172277] [18045:5782860] CHIP: [IN] Prepared plaintext message 0x7000001cc540 to 0x0000000000000000 (0) of type 0x10 and protocolId (0, 0) on exchange 13965i with MessageCounter:2839139668. [1643072172277] [18045:5782860] CHIP: [IN] Sending plaintext msg 0x7000001cc540 with MessageCounter:2839139668 to 0x0000000000000000 at monotonic time: 1586618090 msec [1643072172277] [18045:5782860] CHIP: [EM] Flushed pending ack for MessageCounter:3044037429 on exchange 13965i [1643072172281] [18045:5782860] CHIP: [EM] Received message of type 0x5 with protocolId (0, 1) and MessageCounter:10332630 on exchange 13966i [1643072172281] [18045:5782860] CHIP: [EM] Found matching exchange: 13966i, Delegate: 0x6000026e4620 [1643072172281] [18045:5782860] CHIP: [EM] Rxd Ack; Removing MessageCounter:1314130 from Retrans Table on exchange 13966i [1643072172281] [18045:5782860] CHIP: [EM] Removed CHIP MessageCounter:1314130 from RetransTable on exchange 13966i [1643072172281] [18045:5782860] CHIP: [DMG] ReportDataMessage = [1643072172281] [18045:5782860] CHIP: [DMG] { [1643072172281] [18045:5782860] CHIP: [DMG] AttributeReportIBs = [1643072172281] [18045:5782860] CHIP: [DMG] [ [1643072172281] [18045:5782860] CHIP: [DMG] AttributeReportIB = [1643072172281] [18045:5782860] CHIP: [DMG] { [1643072172281] [18045:5782860] CHIP: [DMG] AttributeDataIB = [1643072172281] [18045:5782860] CHIP: [DMG] { [1643072172281] [18045:5782860] CHIP: [DMG] DataVersion = 0x0, [1643072172281] [18045:5782860] CHIP: [DMG] AttributePathIB = [1643072172281] [18045:5782860] CHIP: [DMG] { [1643072172281] [18045:5782860] CHIP: [DMG] Endpoint = 0x1, [1643072172281] [18045:5782860] CHIP: [DMG] Cluster = 0x503, [1643072172281] [18045:5782860] CHIP: [DMG] Attribute = 0x0000_0000, [1643072172281] [18045:5782860] CHIP: [DMG] } [1643072172281] [18045:5782860] CHIP: [DMG]  [1643072172281] [18045:5782860] CHIP: [DMG] Data = "00:00:00:00:00",  [1643072172281] [18045:5782860] CHIP: [DMG] }, [1643072172281] [18045:5782860] CHIP: [DMG]  [1643072172281] [18045:5782860] CHIP: [DMG] }, [1643072172281] [18045:5782860] CHIP: [DMG]  [1643072172281] [18045:5782860] CHIP: [DMG] ], [1643072172281] [18045:5782860] CHIP: [DMG]  [1643072172281] [18045:5782860] CHIP: [DMG] SuppressResponse = true,  [1643072172281] [18045:5782860] CHIP: [DMG] } [1643072172281] [18045:5782860] CHIP: [TOO] WakeOnLan.WakeOnLanMacAddress response: 00:00:00:00:00 [1643072172281] [18045:5782860] CHIP: [EM] Sending Standalone Ack for MessageCounter:10332630 on exchange 13966i [1643072172281] [18045:5782860] CHIP: [IN] Prepared encrypted message 0x7000001cc540 to 0x00000000000004D2 (1) of type 0x10 and protocolId (0, 0) on exchange 13966i with MessageCounter:1314131. [1643072172281] [18045:5782860] CHIP: [IN] Sending encrypted msg 0x7000001cc540 with MessageCounter:1314131 to 0x00000000000004D2 (1) at monotonic time: 1586618094 msec [1643072172281] [18045:5782860] CHIP: [EM] Flushed pending ack for MessageCounter:10332630 on exchange 13966i [1643072172281] [18045:5782856] CHIP: [CTL] Shutting down the commissioner [1643072172282] [18045:5782856] CHIP: [CTL] Shutting down the controller [1643072172282] [18045:5782856] CHIP: [CTL] Shutting down the commissioner [1643072172282] [18045:5782856] CHIP: [CTL] Shutting down the controller [1643072172282] [18045:5782856] CHIP: [CTL] Shutting down the commissioner [1643072172282] [18045:5782856] CHIP: [CTL] Shutting down the controller [1643072172282] [18045:5782856] CHIP: [CTL] Shutting down the System State, this will teardown the CHIP Stack [1643072172282] [18045:5782856] CHIP: [BLE] CancelConnection [1643072172282] [18045:5782856] CHIP: [DL] Inet Layer shutdown [1643072172282] [18045:5782856] CHIP: [DL] BLE shutdown [1643072172282] [18045:5782856] CHIP: [DL] System Layer shutdown Accessory Log [1643072144.983723][220296:220296] CHIP:DMG: ICR moving to [CommandSen] [1643072144.983748][220296:220296] CHIP:DMG: ICR moving to [AwaitingDe] [1643072144.983888][220296:220296] CHIP:EM: Received message of type 0x10 with protocolId (0, 0) and MessageCounter:324180994 on exchange 18991r [1643072144.983916][220296:220296] CHIP:EM: Found matching exchange: 18991r, Delegate: (nil) [1643072144.983966][220296:220296] CHIP:EM: Rxd Ack; Removing MessageCounter:3044037427 from Retrans Table on exchange 18991r [1643072144.983989][220296:220296] CHIP:EM: Removed CHIP MessageCounter:3044037427 from RetransTable on exchange 18991r [1643072144.986788][220296:220296] CHIP:EM: Received message of type 0x10 with protocolId (0, 0) and MessageCounter:229793 on exchange 18992r [1643072144.986825][220296:220296] CHIP:EM: Found matching exchange: 18992r, Delegate: (nil) [1643072144.986883][220296:220296] CHIP:EM: Rxd Ack; Removing MessageCounter:8642578 from Retrans Table on exchange 18992r [1643072144.986904][220296:220296] CHIP:EM: Removed CHIP MessageCounter:8642578 from RetransTable on exchange 18992r [1643072172.325619][220296:220296] CHIP:DIS: Directly sending mDns reply to peer 192.168.1.5 on port 5353 [1643072172.328414][220296:220296] CHIP:DIS: Directly sending mDns reply to peer 192.168.1.5 on port 5353 [1643072172.331065][220296:220296] CHIP:DIS: Directly sending mDns reply to peer 192.168.1.5 on port 5353 [1643072172.333671][220296:220296] CHIP:DIS: Directly sending mDns reply to peer 192.168.1.5 on port 5353 [1643072172.336257][220296:220296] CHIP:DIS: Directly sending mDns reply to peer 192.168.1.5 on port 5353 [1643072172.339005][220296:220296] CHIP:DIS: Directly sending mDns reply to peer 192.168.1.5 on port 5353 [1643072172.341625][220296:220296] CHIP:DIS: Directly sending mDns reply to peer fe80::103a:8edd:4b33:46a on port 5353 [1643072172.344339][220296:220296] CHIP:DIS: Directly sending mDns reply to peer fe80::103a:8edd:4b33:46a on port 5353 [1643072172.346978][220296:220296] CHIP:DIS: Directly sending mDns reply to peer fe80::103a:8edd:4b33:46a on port 5353 [1643072172.349657][220296:220296] CHIP:DIS: Directly sending mDns reply to peer fe80::103a:8edd:4b33:46a on port 5353 [1643072172.352325][220296:220296] CHIP:DIS: Directly sending mDns reply to peer fe80::103a:8edd:4b33:46a on port 5353 [1643072172.354976][220296:220296] CHIP:DIS: Directly sending mDns reply to peer fe80::103a:8edd:4b33:46a on port 5353 [1643072172.357593][220296:220296] CHIP:DIS: Directly sending mDns reply to peer fe80::103a:8edd:4b33:46a on port 5353 [1643072172.360224][220296:220296] CHIP:DIS: Directly sending mDns reply to peer 192.168.1.5 on port 5353 [1643072172.362914][220296:220296] CHIP:DIS: Directly sending mDns reply to peer fe80::103a:8edd:4b33:46a on port 5353 [1643072172.366578][220296:220296] CHIP:DIS: Directly sending mDns reply to peer fe80::103a:8edd:4b33:46a on port 5353 [1643072172.369235][220296:220296] CHIP:DIS: Directly sending mDns reply to peer fe80::103a:8edd:4b33:46a on port 5353 [1643072172.371836][220296:220296] CHIP:DIS: Directly sending mDns reply to peer fe80::103a:8edd:4b33:46a on port 5353 [1643072172.372100][220296:220296] CHIP:EM: Received message of type 0x30 with protocolId (0, 0) and MessageCounter:2839139666 on exchange 13965r [1643072172.372144][220296:220296] CHIP:EM: Handling via exchange: 13965r, Delegate: 0xaaaae903f7a8 [1643072172.373369][220296:220296] CHIP:IN: CASE Server received Sigma1 message. Starting handshake. EC 0xaaaae9040de8 [1643072172.373396][220296:220296] CHIP:DIS: CASE handshake initiated, closing all BLE Connections [1643072172.373422][220296:220296] CHIP:SC: Waiting for Sigma1 msg [1643072172.373442][220296:220296] CHIP:IN: CASE Server disabling CASE session setups [1643072172.373470][220296:220296] CHIP:SC: Received Sigma1 msg [1643072172.373521][220296:220296] CHIP:SC: Found MRP parameters in the message [1643072172.373548][220296:220296] CHIP:SC: Peer assigned session key ID 1 [1643072172.373571][220296:220296] CHIP:DIS: Fabric (1) loaded from storage. Calling OnFabricRetrievedFromStorage [1643072172.373591][220296:220296] CHIP:ZCL: OpCreds: Fabric 0x1 was retrieved from storage. FabricId 0x0000000000000001, NodeId 0x00000000000004D2, VendorId 0xFFF1 [1643072172.373613][220296:220296] CHIP:ZCL: OpCreds: Call to fabricListChanged [1643072172.373718][220296:220296] CHIP:IN: Generating DestinationID. Fabric ID 0x0000000000000001, Dest node ID 0x00000000000004D2, Random data [1643072172.373746][220296:220296] CHIP:IN: 0x9b, 0x69, 0x25, 0x7c, 0xa9, 0x77, 0x79, 0x68, [1643072172.373767][220296:220296] CHIP:IN: 0x7a, 0xec, 0xeb, 0xc6, 0x9f, 0x62, 0x89, 0xa9, [1643072172.373789][220296:220296] CHIP:IN: 0xa0, 0x8e, 0x02, 0x5b, 0xd5, 0x1e, 0x29, 0x36, [1643072172.373810][220296:220296] CHIP:IN: 0xa6, 0x1c, 0x55, 0x14, 0x2d, 0x40, 0xdb, 0xcc, [1643072172.373829][220296:220296] CHIP:IN: Root pubkey [1643072172.373850][220296:220296] CHIP:IN: 0x04, 0xca, 0x41, 0xc3, 0xe1, 0x83, 0x33, 0xc6, [1643072172.373872][220296:220296] CHIP:IN: 0xe5, 0x4a, 0xaa, 0x36, 0x98, 0xfe, 0x0d, 0xb3, [1643072172.373892][220296:220296] CHIP:IN: 0x43, 0x0b, 0x81, 0xb3, 0xca, 0xc6, 0xc1, 0x1b, [1643072172.373914][220296:220296] CHIP:IN: 0x67, 0x0d, 0x71, 0x0b, 0x76, 0xfe, 0xc7, 0x48, [1643072172.373935][220296:220296] CHIP:IN: 0x24, 0x38, 0xfe, 0xce, 0x8f, 0xe4, 0xa2, 0xb3, [1643072172.373955][220296:220296] CHIP:IN: 0xed, 0xe4, 0x79, 0x06, 0xb2, 0x54, 0xcc, 0xc1, [1643072172.373976][220296:220296] CHIP:IN: 0xed, 0x3b, 0x22, 0x01, 0x45, 0x34, 0xd1, 0x04, [1643072172.373997][220296:220296] CHIP:IN: 0x9a, 0x34, 0x01, 0x9c, 0xa2, 0x50, 0xab, 0x05, [1643072172.374016][220296:220296] CHIP:IN: 0x3b, [1643072172.374035][220296:220296] CHIP:IN: IPK [1643072172.374056][220296:220296] CHIP:IN: 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, [1643072172.374078][220296:220296] CHIP:IN: 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, [1643072172.374162][220296:220296] CHIP:IN: Generated DestinationID output [1643072172.374186][220296:220296] CHIP:IN: 0xa1, 0xd0, 0xe8, 0x75, 0x6a, 0xd1, 0x22, 0xcf, [1643072172.374207][220296:220296] CHIP:IN: 0xcd, 0xe6, 0x9f, 0x28, 0xb5, 0x5c, 0x2e, 0x60, [1643072172.374228][220296:220296] CHIP:IN: 0xb8, 0xa6, 0xee, 0xc0, 0x0c, 0x71, 0x4b, 0xaa, [1643072172.374249][220296:220296] CHIP:IN: 0x05, 0x36, 0xd5, 0x08, 0x0e, 0x60, 0xff, 0x58, [1643072172.374269][220296:220296] CHIP:DIS: Fabric (1) loaded from storage. Calling OnFabricRetrievedFromStorage [1643072172.374289][220296:220296] CHIP:ZCL: OpCreds: Fabric 0x1 was retrieved from storage. FabricId 0x0000000000000001, NodeId 0x00000000000004D2, VendorId 0xFFF1 [1643072172.374309][220296:220296] CHIP:ZCL: OpCreds: Call to fabricListChanged [1643072172.375415][220296:220296] CHIP:SC: Including MRP parameters [1643072172.375480][220296:220296] CHIP:EM: Piggybacking Ack for MessageCounter:2839139666 on exchange: 13965r [1643072172.375516][220296:220296] CHIP:IN: Prepared plaintext message 0xaaaae9040cb0 to 0x0000000000000000 (0) of type 0x31 and protocolId (0, 0) on exchange 13965r with MessageCounter:3044037428. [1643072172.375552][220296:220296] CHIP:IN: Sending plaintext msg 0xaaaae9040cb0 with MessageCounter:3044037428 to 0x0000000000000000 at monotonic time: 374623199 msec [1643072172.375747][220296:220296] CHIP:SC: Sent Sigma2 msg [1643072172.379916][220296:220296] CHIP:EM: Received message of type 0x32 with protocolId (0, 0) and MessageCounter:2839139667 on exchange 13965r [1643072172.379969][220296:220296] CHIP:EM: Found matching exchange: 13965r, Delegate: 0xaaaae903f7b8 [1643072172.380043][220296:220296] CHIP:EM: Rxd Ack; Removing MessageCounter:3044037428 from Retrans Table on exchange 13965r [1643072172.380066][220296:220296] CHIP:EM: Removed CHIP MessageCounter:3044037428 from RetransTable on exchange 13965r [1643072172.380117][220296:220296] CHIP:SC: Received Sigma3 msg [1643072172.381999][220296:220296] CHIP:IN: Generating compressed fabric ID using uncompressed fabric ID 0x0000000000000001 and root pubkey [1643072172.382045][220296:220296] CHIP:IN: 0x04, 0xca, 0x41, 0xc3, 0xe1, 0x83, 0x33, 0xc6, [1643072172.382067][220296:220296] CHIP:IN: 0xe5, 0x4a, 0xaa, 0x36, 0x98, 0xfe, 0x0d, 0xb3, [1643072172.382088][220296:220296] CHIP:IN: 0x43, 0x0b, 0x81, 0xb3, 0xca, 0xc6, 0xc1, 0x1b, [1643072172.382110][220296:220296] CHIP:IN: 0x67, 0x0d, 0x71, 0x0b, 0x76, 0xfe, 0xc7, 0x48, [1643072172.382131][220296:220296] CHIP:IN: 0x24, 0x38, 0xfe, 0xce, 0x8f, 0xe4, 0xa2, 0xb3, [1643072172.382152][220296:220296] CHIP:IN: 0xed, 0xe4, 0x79, 0x06, 0xb2, 0x54, 0xcc, 0xc1, [1643072172.382173][220296:220296] CHIP:IN: 0xed, 0x3b, 0x22, 0x01, 0x45, 0x34, 0xd1, 0x04, [1643072172.382194][220296:220296] CHIP:IN: 0x9a, 0x34, 0x01, 0x9c, 0xa2, 0x50, 0xab, 0x05, [1643072172.382212][220296:220296] CHIP:IN: 0x3b, [1643072172.382256][220296:220296] CHIP:IN: Generated compressed fabric ID [1643072172.382281][220296:220296] CHIP:IN: 0xf3, 0x3b, 0x41, 0xde, 0x52, 0x54, 0x99, 0xdc, [1643072172.383095][220296:220296] CHIP:SC: Sending status report. Protocol code 0, exchange 13965 [1643072172.383136][220296:220296] CHIP:EM: Piggybacking Ack for MessageCounter:2839139667 on exchange: 13965r [1643072172.383170][220296:220296] CHIP:IN: Prepared plaintext message 0xaaaae9040cb0 to 0x0000000000000000 (0) of type 0x40 and protocolId (0, 0) on exchange 13965r with MessageCounter:3044037429. [1643072172.383204][220296:220296] CHIP:IN: Sending plaintext msg 0xaaaae9040cb0 with MessageCounter:3044037429 to 0x0000000000000000 at monotonic time: 374623207 msec [1643072172.383382][220296:220296] CHIP:IN: CASE Session established. Setting up the secure channel. [1643072172.383411][220296:220296] CHIP:IN: Marking old secure session for device 0x000000000001B669 as expired [1643072172.383443][220296:220296] CHIP:IN: New secure session created for device 0x000000000001B669, key 1!! [1643072172.383540][220296:220296] CHIP:IN: CASE secure channel is available now. [1643072172.383609][220296:220296] CHIP:IN: CASE Server enabling CASE session setups [1643072172.386033][220296:220296] CHIP:EM: Received message of type 0x2 with protocolId (0, 1) and MessageCounter:1314130 on exchange 13966r [1643072172.386107][220296:220296] CHIP:EM: Handling via exchange: 13966r, Delegate: 0xaaaae903b778 [1643072172.386206][220296:220296] CHIP:IM: Received Read request [1643072172.386231][220296:220296] CHIP:DMG: IM RH moving to [Initialized] [1643072172.386272][220296:220296] CHIP:DMG: ReadRequestMessage = [1643072172.386296][220296:220296] CHIP:DMG: { [1643072172.386316][220296:220296] CHIP:DMG: AttributePathIBs = [1643072172.386338][220296:220296] CHIP:DMG: [ [1643072172.386358][220296:220296] CHIP:DMG: AttributePathIB = [1643072172.386380][220296:220296] CHIP:DMG: { [1643072172.386402][220296:220296] CHIP:DMG: Endpoint = 0x1, [1643072172.386424][220296:220296] CHIP:DMG: Cluster = 0x503, [1643072172.386447][220296:220296] CHIP:DMG: Attribute = 0x0000_0000, [1643072172.386467][220296:220296] CHIP:DMG: } [1643072172.386490][220296:220296] CHIP:DMG: [1643072172.386510][220296:220296] CHIP:DMG: ], [1643072172.386533][220296:220296] CHIP:DMG: [1643072172.386554][220296:220296] CHIP:DMG: isFabricFiltered = false, [1643072172.386573][220296:220296] CHIP:DMG: }, [1643072172.386619][220296:220296] CHIP:DMG: IM RH moving to [GeneratingReports] [1643072172.386732][220296:220296] CHIP:DMG: Cluster 503, Attribute 0 is dirty [1643072172.386758][220296:220296] CHIP:DMG: Reading attribute: Cluster=0x0000_0503 Endpoint=1 AttributeId=0x0000_0000 (expanded=0) [1643072172.386812][220296:220296] CHIP:DMG: Sending report (payload has 45 bytes)... [1643072172.386843][220296:220296] CHIP:EM: Piggybacking Ack for MessageCounter:1314130 on exchange: 13966r [1643072172.386895][220296:220296] CHIP:IN: Prepared encrypted message 0xaaaae9040cd0 to 0x000000000001B669 (1) of type 0x5 and protocolId (0, 1) on exchange 13966r with MessageCounter:10332630. [1643072172.386926][220296:220296] CHIP:IN: Sending encrypted msg 0xaaaae9040cd0 with MessageCounter:10332630 to 0x000000000001B669 (1) at monotonic time: 374623210 msec [1643072172.387077][220296:220296] CHIP:DMG: OnReportConfirm: NumReports = 0 [1643072172.387103][220296:220296] CHIP:DMG: ReportsInFlight = 0 with readHandler 0, RE has no more messages [1643072172.387124][220296:220296] CHIP:DMG: IM RH moving to [Uninitialized] [1643072172.387191][220296:220296] CHIP:EM: Received message of type 0x10 with protocolId (0, 0) and MessageCounter:2839139668 on exchange 13965r [1643072172.387216][220296:220296] CHIP:EM: Found matching exchange: 13965r, Delegate: (nil) [1643072172.387267][220296:220296] CHIP:EM: Rxd Ack; Removing MessageCounter:3044037429 from Retrans Table on exchange 13965r [1643072172.387290][220296:220296] CHIP:EM: Removed CHIP MessageCounter:3044037429 from RetransTable on exchange 13965r [1643072172.390807][220296:220296] CHIP:EM: Received message of type 0x10 with protocolId (0, 0) and MessageCounter:1314131 on exchange 13966r [1643072172.390848][220296:220296] CHIP:EM: Found matching exchange: 13966r, Delegate: (nil) [1643072172.390910][220296:220296] CHIP:EM: Rxd Ack; Removing MessageCounter:10332630 from Retrans Table on exchange 13966r [1643072172.390933][220296:220296] CHIP:EM: Removed CHIP MessageCounter:10332630 from RetransTable on exchange 13966r python command: ./out/debug/chip-tool lowpower sleep 1234 1 Mac Chip Tool Log [1643072207610] [18054:5783369] CHIP: [DL] _Init [1643072207611] [18054:5783369] CHIP: [IN] UDP::Init bind&listen port=5542 [1643072207611] [18054:5783369] CHIP: [IN] UDP::Init bound to port=5542 [1643072207611] [18054:5783369] CHIP: [IN] UDP::Init bind&listen port=5542 [1643072207611] [18054:5783369] CHIP: [IN] UDP::Init bound to port=5542 [1643072207611] [18054:5783369] CHIP: [IN] TransportMgr initialized [1643072207611] [18054:5783369] CHIP: [DIS] Init fabric pairing table with server storage [1643072207611] [18054:5783369] CHIP: [ZCL] Using ZAP configuration... [1643072207611] [18054:5783369] CHIP: [CTL] System State Initialized... [1643072207613] [18054:5783369] CHIP: [CTL] Generating NOC [1643072207613] [18054:5783369] CHIP: [CTL] Generating ICAC [1643072207613] [18054:5783369] CHIP: [DIS] Verifying the received credentials [1643072207614] [18054:5783369] CHIP: [IN] Generating compressed fabric ID using uncompressed fabric ID 0x0000000000000001 and root pubkey [1643072207614] [18054:5783369] CHIP: [IN] 0x04, 0xca, 0x41, 0xc3, 0xe1, 0x83, 0x33, 0xc6,  [1643072207614] [18054:5783369] CHIP: [IN] 0xe5, 0x4a, 0xaa, 0x36, 0x98, 0xfe, 0x0d, 0xb3,  [1643072207614] [18054:5783369] CHIP: [IN] 0x43, 0x0b, 0x81, 0xb3, 0xca, 0xc6, 0xc1, 0x1b,  [1643072207614] [18054:5783369] CHIP: [IN] 0x67, 0x0d, 0x71, 0x0b, 0x76, 0xfe, 0xc7, 0x48,  [1643072207614] [18054:5783369] CHIP: [IN] 0x24, 0x38, 0xfe, 0xce, 0x8f, 0xe4, 0xa2, 0xb3,  [1643072207614] [18054:5783369] CHIP: [IN] 0xed, 0xe4, 0x79, 0x06, 0xb2, 0x54, 0xcc, 0xc1,  [1643072207614] [18054:5783369] CHIP: [IN] 0xed, 0x3b, 0x22, 0x01, 0x45, 0x34, 0xd1, 0x04,  [1643072207614] [18054:5783369] CHIP: [IN] 0x9a, 0x34, 0x01, 0x9c, 0xa2, 0x50, 0xab, 0x05,  [1643072207614] [18054:5783369] CHIP: [IN] 0x3b,  [1643072207614] [18054:5783369] CHIP: [IN] Generated compressed fabric ID [1643072207614] [18054:5783369] CHIP: [IN] 0xf3, 0x3b, 0x41, 0xde, 0x52, 0x54, 0x99, 0xdc,  [1643072207614] [18054:5783369] CHIP: [DIS] Added new fabric at index: 1, Initialized: 1 [1643072207614] [18054:5783369] CHIP: [DIS] Assigned compressed fabric ID: 0xF33B41DE525499DC, node ID: 0x000000000001B669 [1643072207614] [18054:5783369] CHIP: [CTL] Joined the fabric at index 1. Compressed fabric ID is: 0xF33B41DE525499DC [1643072207614] [18054:5783369] CHIP: [IN] UDP::Init bind&listen port=5550 [1643072207614] [18054:5783369] CHIP: [IN] UDP::Init bound to port=5550 [1643072207614] [18054:5783369] CHIP: [IN] UDP::Init bind&listen port=5550 [1643072207614] [18054:5783369] CHIP: [IN] UDP::Init bound to port=5550 [1643072207614] [18054:5783369] CHIP: [IN] TransportMgr initialized [1643072207614] [18054:5783369] CHIP: [CTL] Generating NOC [1643072207615] [18054:5783369] CHIP: [CTL] Generating ICAC [1643072207615] [18054:5783369] CHIP: [DIS] Verifying the received credentials [1643072207615] [18054:5783369] CHIP: [IN] Generating compressed fabric ID using uncompressed fabric ID 0x0000000000000002 and root pubkey [1643072207615] [18054:5783369] CHIP: [IN] 0x04, 0xca, 0x41, 0xc3, 0xe1, 0x83, 0x33, 0xc6,  [1643072207615] [18054:5783369] CHIP: [IN] 0xe5, 0x4a, 0xaa, 0x36, 0x98, 0xfe, 0x0d, 0xb3,  [1643072207615] [18054:5783369] CHIP: [IN] 0x43, 0x0b, 0x81, 0xb3, 0xca, 0xc6, 0xc1, 0x1b,  [1643072207615] [18054:5783369] CHIP: [IN] 0x67, 0x0d, 0x71, 0x0b, 0x76, 0xfe, 0xc7, 0x48,  [1643072207615] [18054:5783369] CHIP: [IN] 0x24, 0x38, 0xfe, 0xce, 0x8f, 0xe4, 0xa2, 0xb3,  [1643072207615] [18054:5783369] CHIP: [IN] 0xed, 0xe4, 0x79, 0x06, 0xb2, 0x54, 0xcc, 0xc1,  [1643072207615] [18054:5783369] CHIP: [IN] 0xed, 0x3b, 0x22, 0x01, 0x45, 0x34, 0xd1, 0x04,  [1643072207615] [18054:5783369] CHIP: [IN] 0x9a, 0x34, 0x01, 0x9c, 0xa2, 0x50, 0xab, 0x05,  [1643072207615] [18054:5783369] CHIP: [IN] 0x3b,  [1643072207615] [18054:5783369] CHIP: [IN] Generated compressed fabric ID [1643072207615] [18054:5783369] CHIP: [IN] 0xad, 0x43, 0x6f, 0xf6, 0x51, 0xcc, 0xfd, 0xce,  [1643072207615] [18054:5783369] CHIP: [DIS] Added new fabric at index: 2, Initialized: 1 [1643072207615] [18054:5783369] CHIP: [DIS] Assigned compressed fabric ID: 0xAD436FF651CCFDCE, node ID: 0x000000000001B669 [1643072207615] [18054:5783369] CHIP: [CTL] Joined the fabric at index 2. Compressed fabric ID is: 0xAD436FF651CCFDCE [1643072207615] [18054:5783369] CHIP: [IN] UDP::Init bind&listen port=5550 [1643072207615] [18054:5783369] CHIP: [IN] UDP::Init bound to port=5550 [1643072207615] [18054:5783369] CHIP: [IN] UDP::Init bind&listen port=5550 [1643072207615] [18054:5783369] CHIP: [IN] UDP::Init bound to port=5550 [1643072207615] [18054:5783369] CHIP: [IN] TransportMgr initialized [1643072207616] [18054:5783369] CHIP: [CTL] Generating NOC [1643072207616] [18054:5783369] CHIP: [CTL] Generating ICAC [1643072207616] [18054:5783369] CHIP: [DIS] Verifying the received credentials [1643072207616] [18054:5783369] CHIP: [IN] Generating compressed fabric ID using uncompressed fabric ID 0x0000000000000003 and root pubkey [1643072207616] [18054:5783369] CHIP: [IN] 0x04, 0xca, 0x41, 0xc3, 0xe1, 0x83, 0x33, 0xc6,  [1643072207616] [18054:5783369] CHIP: [IN] 0xe5, 0x4a, 0xaa, 0x36, 0x98, 0xfe, 0x0d, 0xb3,  [1643072207616] [18054:5783369] CHIP: [IN] 0x43, 0x0b, 0x81, 0xb3, 0xca, 0xc6, 0xc1, 0x1b,  [1643072207616] [18054:5783369] CHIP: [IN] 0x67, 0x0d, 0x71, 0x0b, 0x76, 0xfe, 0xc7, 0x48,  [1643072207616] [18054:5783369] CHIP: [IN] 0x24, 0x38, 0xfe, 0xce, 0x8f, 0xe4, 0xa2, 0xb3,  [1643072207616] [18054:5783369] CHIP: [IN] 0xed, 0xe4, 0x79, 0x06, 0xb2, 0x54, 0xcc, 0xc1,  [1643072207616] [18054:5783369] CHIP: [IN] 0xed, 0x3b, 0x22, 0x01, 0x45, 0x34, 0xd1, 0x04,  [1643072207616] [18054:5783369] CHIP: [IN] 0x9a, 0x34, 0x01, 0x9c, 0xa2, 0x50, 0xab, 0x05,  [1643072207616] [18054:5783369] CHIP: [IN] 0x3b,  [1643072207616] [18054:5783369] CHIP: [IN] Generated compressed fabric ID [1643072207616] [18054:5783369] CHIP: [IN] 0x43, 0x2b, 0x62, 0x34, 0x72, 0x74, 0x79, 0x61,  [1643072207616] [18054:5783369] CHIP: [DIS] Added new fabric at index: 3, Initialized: 1 [1643072207616] [18054:5783369] CHIP: [DIS] Assigned compressed fabric ID: 0x432B623472747961, node ID: 0x000000000001B669 [1643072207616] [18054:5783369] CHIP: [CTL] Joined the fabric at index 3. Compressed fabric ID is: 0x432B623472747961 [1643072207616] [18054:5783369] CHIP: [IN] UDP::Init bind&listen port=5550 [1643072207616] [18054:5783369] CHIP: [IN] UDP::Init bound to port=5550 [1643072207616] [18054:5783369] CHIP: [IN] UDP::Init bind&listen port=5550 [1643072207616] [18054:5783369] CHIP: [IN] UDP::Init bound to port=5550 [1643072207616] [18054:5783369] CHIP: [IN] TransportMgr initialized [1643072207617] [18054:5783372] CHIP: [DL] _OnPlatformEvent [1643072207617] [18054:5783372] CHIP: [TOO] Sending command to node 0x4d2 [1643072207617] [18054:5783372] CHIP: [DL] Resolved interface id: 7 [1643072207617] [18054:5783372] CHIP: [DL] Mdns: OnGetAddrInfo hostname:EEAABADABAD0DDCA.local. [1643072207617] [18054:5783372] CHIP: [DIS] Node ID resolved for 0x00000000000004D2 [1643072207617] [18054:5783372] CHIP: [DIS] Addr 0: [fe80::dea6:32ff:fea8:49ea]:5540 [1643072207617] [18054:5783372] CHIP: [CTL] OperationalDiscoveryComplete for device ID 0x00000000000004D2 [1643072207618] [18054:5783372] CHIP: [IN] Generating DestinationID. Fabric ID 0x0000000000000001, Dest node ID 0x00000000000004D2, Random data [1643072207618] [18054:5783372] CHIP: [IN] 0x75, 0x25, 0x34, 0x1f, 0xff, 0x7a, 0x3c, 0xa7,  [1643072207618] [18054:5783372] CHIP: [IN] 0x92, 0xf2, 0xd3, 0xd0, 0x9e, 0x86, 0xca, 0x51,  [1643072207618] [18054:5783372] CHIP: [IN] 0x50, 0xd6, 0x1b, 0x9c, 0x7c, 0x2e, 0x05, 0x08,  [1643072207618] [18054:5783372] CHIP: [IN] 0xb5, 0x8b, 0xae, 0x04, 0x32, 0x18, 0xda, 0xb9,  [1643072207618] [18054:5783372] CHIP: [IN] Root pubkey [1643072207618] [18054:5783372] CHIP: [IN] 0x04, 0xca, 0x41, 0xc3, 0xe1, 0x83, 0x33, 0xc6,  [1643072207618] [18054:5783372] CHIP: [IN] 0xe5, 0x4a, 0xaa, 0x36, 0x98, 0xfe, 0x0d, 0xb3,  [1643072207618] [18054:5783372] CHIP: [IN] 0x43, 0x0b, 0x81, 0xb3, 0xca, 0xc6, 0xc1, 0x1b,  [1643072207618] [18054:5783372] CHIP: [IN] 0x67, 0x0d, 0x71, 0x0b, 0x76, 0xfe, 0xc7, 0x48,  [1643072207618] [18054:5783372] CHIP: [IN] 0x24, 0x38, 0xfe, 0xce, 0x8f, 0xe4, 0xa2, 0xb3,  [1643072207618] [18054:5783372] CHIP: [IN] 0xed, 0xe4, 0x79, 0x06, 0xb2, 0x54, 0xcc, 0xc1,  [1643072207618] [18054:5783372] CHIP: [IN] 0xed, 0x3b, 0x22, 0x01, 0x45, 0x34, 0xd1, 0x04,  [1643072207618] [18054:5783372] CHIP: [IN] 0x9a, 0x34, 0x01, 0x9c, 0xa2, 0x50, 0xab, 0x05,  [1643072207618] [18054:5783372] CHIP: [IN] 0x3b,  [1643072207618] [18054:5783372] CHIP: [IN] IPK [1643072207618] [18054:5783372] CHIP: [IN] 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00,  [1643072207618] [18054:5783372] CHIP: [IN] 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00,  [1643072207618] [18054:5783372] CHIP: [IN] Generated DestinationID output [1643072207618] [18054:5783372] CHIP: [IN] 0xee, 0x34, 0xcb, 0xbb, 0xcf, 0xb8, 0x68, 0xde,  [1643072207618] [18054:5783372] CHIP: [IN] 0x62, 0x7c, 0x6c, 0xed, 0xeb, 0x70, 0x16, 0xb6,  [1643072207618] [18054:5783372] CHIP: [IN] 0xc4, 0x9d, 0x98, 0xc3, 0xa0, 0x0c, 0x73, 0x8c,  [1643072207618] [18054:5783372] CHIP: [IN] 0x51, 0xfd, 0x62, 0x72, 0x77, 0x5e, 0x70, 0xcf,  [1643072207618] [18054:5783372] CHIP: [SC] Including MRP parameters [1643072207618] [18054:5783372] CHIP: [IN] Prepared plaintext message 0x7f8051809870 to 0x0000000000000000 (0) of type 0x30 and protocolId (0, 0) on exchange 57683i with MessageCounter:1295415451. [1643072207618] [18054:5783372] CHIP: [IN] Sending plaintext msg 0x7f8051809870 with MessageCounter:1295415451 to 0x0000000000000000 at monotonic time: 1586653431 msec [1643072207618] [18054:5783372] CHIP: [SC] Sent Sigma1 msg [1643072207618] [18054:5783372] CHIP: [CTL] Address resolved for node: 0x00000000000004D2 [1643072207623] [18054:5783373] CHIP: [EM] Received message of type 0x31 with protocolId (0, 0) and MessageCounter:3044037430 on exchange 57683i [1643072207623] [18054:5783373] CHIP: [EM] Found matching exchange: 57683i, Delegate: 0x7f8052100cb8 [1643072207623] [18054:5783373] CHIP: [EM] Rxd Ack; Removing MessageCounter:1295415451 from Retrans Table on exchange 57683i [1643072207623] [18054:5783373] CHIP: [EM] Removed CHIP MessageCounter:1295415451 from RetransTable on exchange 57683i [1643072207623] [18054:5783373] CHIP: [SC] Received Sigma2 msg [1643072207623] [18054:5783373] CHIP: [SC] Peer assigned session session ID 57 [1643072207624] [18054:5783373] CHIP: [IN] Generating compressed fabric ID using uncompressed fabric ID 0x0000000000000001 and root pubkey [1643072207624] [18054:5783373] CHIP: [IN] 0x04, 0xca, 0x41, 0xc3, 0xe1, 0x83, 0x33, 0xc6,  [1643072207624] [18054:5783373] CHIP: [IN] 0xe5, 0x4a, 0xaa, 0x36, 0x98, 0xfe, 0x0d, 0xb3,  [1643072207624] [18054:5783373] CHIP: [IN] 0x43, 0x0b, 0x81, 0xb3, 0xca, 0xc6, 0xc1, 0x1b,  [1643072207624] [18054:5783373] CHIP: [IN] 0x67, 0x0d, 0x71, 0x0b, 0x76, 0xfe, 0xc7, 0x48,  [1643072207624] [18054:5783373] CHIP: [IN] 0x24, 0x38, 0xfe, 0xce, 0x8f, 0xe4, 0xa2, 0xb3,  [1643072207624] [18054:5783373] CHIP: [IN] 0xed, 0xe4, 0x79, 0x06, 0xb2, 0x54, 0xcc, 0xc1,  [1643072207624] [18054:5783373] CHIP: [IN] 0xed, 0x3b, 0x22, 0x01, 0x45, 0x34, 0xd1, 0x04,  [1643072207624] [18054:5783373] CHIP: [IN] 0x9a, 0x34, 0x01, 0x9c, 0xa2, 0x50, 0xab, 0x05,  [1643072207624] [18054:5783373] CHIP: [IN] 0x3b,  [1643072207624] [18054:5783373] CHIP: [IN] Generated compressed fabric ID [1643072207624] [18054:5783373] CHIP: [IN] 0xf3, 0x3b, 0x41, 0xde, 0x52, 0x54, 0x99, 0xdc,  [1643072207624] [18054:5783373] CHIP: [SC] Found MRP parameters in the message [1643072207624] [18054:5783373] CHIP: [SC] Sending Sigma3 [1643072207624] [18054:5783373] CHIP: [EM] Piggybacking Ack for MessageCounter:3044037430 on exchange: 57683i [1643072207624] [18054:5783373] CHIP: [IN] Prepared plaintext message 0x7f8051809870 to 0x0000000000000000 (0) of type 0x32 and protocolId (0, 0) on exchange 57683i with MessageCounter:1295415452. [1643072207624] [18054:5783373] CHIP: [IN] Sending plaintext msg 0x7f8051809870 with MessageCounter:1295415452 to 0x0000000000000000 at monotonic time: 1586653437 msec [1643072207624] [18054:5783373] CHIP: [SC] Sent Sigma3 msg [1643072207630] [18054:5783373] CHIP: [EM] Received message of type 0x40 with protocolId (0, 0) and MessageCounter:3044037431 on exchange 57683i [1643072207630] [18054:5783373] CHIP: [EM] Found matching exchange: 57683i, Delegate: 0x7f8052100cb8 [1643072207630] [18054:5783373] CHIP: [EM] Rxd Ack; Removing MessageCounter:1295415452 from Retrans Table on exchange 57683i [1643072207630] [18054:5783373] CHIP: [EM] Removed CHIP MessageCounter:1295415452 from RetransTable on exchange 57683i [1643072207630] [18054:5783373] CHIP: [SC] Success status report received. Session was established [1643072207630] [18054:5783373] CHIP: [IN] New secure session created for device 0x00000000000004D2, key 57!! [1643072207630] [18054:5783373] CHIP: [TOO] Sending cluster (0x00000508) command (0x00000000) on endpoint 1 [1643072207630] [18054:5783373] CHIP: [DMG] ICR moving to [AddingComm] [1643072207630] [18054:5783373] CHIP: [DMG] ICR moving to [AddedComma] [1643072207630] [18054:5783373] CHIP: [IN] Prepared encrypted message 0x7f8051809870 to 0x00000000000004D2 (1) of type 0x8 and protocolId (0, 1) on exchange 57684i with MessageCounter:12840264. [1643072207630] [18054:5783373] CHIP: [IN] Sending encrypted msg 0x7f8051809870 with MessageCounter:12840264 to 0x00000000000004D2 (1) at monotonic time: 1586653443 msec [1643072207630] [18054:5783373] CHIP: [DMG] ICR moving to [CommandSen] [1643072207630] [18054:5783373] CHIP: [CTL] Device connected callback with null pairing delegate. Ignoring [1643072207630] [18054:5783373] CHIP: [EM] Sending Standalone Ack for MessageCounter:3044037431 on exchange 57683i [1643072207630] [18054:5783373] CHIP: [IN] Prepared plaintext message 0x7000071c8540 to 0x0000000000000000 (0) of type 0x10 and protocolId (0, 0) on exchange 57683i with MessageCounter:1295415453. [1643072207630] [18054:5783373] CHIP: [IN] Sending plaintext msg 0x7000071c8540 with MessageCounter:1295415453 to 0x0000000000000000 at monotonic time: 1586653443 msec [1643072207630] [18054:5783373] CHIP: [EM] Flushed pending ack for MessageCounter:3044037431 on exchange 57683i [1643072207633] [18054:5783373] CHIP: [EM] Received message of type 0x9 with protocolId (0, 1) and MessageCounter:14244877 on exchange 57684i [1643072207633] [18054:5783373] CHIP: [EM] Found matching exchange: 57684i, Delegate: 0x7f804c7096a0 [1643072207633] [18054:5783373] CHIP: [EM] Rxd Ack; Removing MessageCounter:12840264 from Retrans Table on exchange 57684i [1643072207633] [18054:5783373] CHIP: [EM] Removed CHIP MessageCounter:12840264 from RetransTable on exchange 57684i [1643072207633] [18054:5783373] CHIP: [DMG] ICR moving to [ResponseRe] [1643072207633] [18054:5783373] CHIP: [DMG] InvokeResponseMessage = [1643072207633] [18054:5783373] CHIP: [DMG] { [1643072207633] [18054:5783373] CHIP: [DMG] suppressResponse = false,  [1643072207633] [18054:5783373] CHIP: [DMG] InvokeResponseIBs = [1643072207633] [18054:5783373] CHIP: [DMG] [ [1643072207633] [18054:5783373] CHIP: [DMG] InvokeResponseIB = [1643072207633] [18054:5783373] CHIP: [DMG] { [1643072207633] [18054:5783373] CHIP: [DMG] CommandStatusIB = [1643072207633] [18054:5783373] CHIP: [DMG] { [1643072207633] [18054:5783373] CHIP: [DMG] CommandPathIB = [1643072207633] [18054:5783373] CHIP: [DMG] { [1643072207633] [18054:5783373] CHIP: [DMG] EndpointId = 0x1, [1643072207633] [18054:5783373] CHIP: [DMG] ClusterId = 0x508, [1643072207633] [18054:5783373] CHIP: [DMG] CommandId = 0x0, [1643072207633] [18054:5783373] CHIP: [DMG] }, [1643072207633] [18054:5783373] CHIP: [DMG]  [1643072207633] [18054:5783373] CHIP: [DMG] StatusIB = [1643072207633] [18054:5783373] CHIP: [DMG] { [1643072207633] [18054:5783373] CHIP: [DMG] status = 0x0, [1643072207633] [18054:5783373] CHIP: [DMG] }, [1643072207633] [18054:5783373] CHIP: [DMG]  [1643072207633] [18054:5783373] CHIP: [DMG] }, [1643072207633] [18054:5783373] CHIP: [DMG]  [1643072207633] [18054:5783373] CHIP: [DMG] }, [1643072207633] [18054:5783373] CHIP: [DMG]  [1643072207633] [18054:5783373] CHIP: [DMG] ], [1643072207633] [18054:5783373] CHIP: [DMG]  [1643072207633] [18054:5783373] CHIP: [DMG] }, [1643072207633] [18054:5783373] CHIP: [DMG] Received Command Response Status for Endpoint=1 Cluster=0x0000_0508 Command=0x0000_0000 Status=0x0 [1643072207633] [18054:5783373] CHIP: [TOO] Default Success Response [1643072207633] [18054:5783373] CHIP: [DMG] ICR moving to [AwaitingDe] [1643072207633] [18054:5783373] CHIP: [EM] Sending Standalone Ack for MessageCounter:14244877 on exchange 57684i [1643072207633] [18054:5783373] CHIP: [IN] Prepared encrypted message 0x7000071c8540 to 0x00000000000004D2 (1) of type 0x10 and protocolId (0, 0) on exchange 57684i with MessageCounter:12840265. [1643072207633] [18054:5783373] CHIP: [IN] Sending encrypted msg 0x7000071c8540 with MessageCounter:12840265 to 0x00000000000004D2 (1) at monotonic time: 1586653446 msec [1643072207633] [18054:5783373] CHIP: [EM] Flushed pending ack for MessageCounter:14244877 on exchange 57684i [1643072207633] [18054:5783369] CHIP: [CTL] Shutting down the commissioner [1643072207633] [18054:5783369] CHIP: [CTL] Shutting down the controller [1643072207633] [18054:5783369] CHIP: [CTL] Shutting down the commissioner [1643072207633] [18054:5783369] CHIP: [CTL] Shutting down the controller [1643072207633] [18054:5783369] CHIP: [CTL] Shutting down the commissioner [1643072207633] [18054:5783369] CHIP: [CTL] Shutting down the controller [1643072207633] [18054:5783369] CHIP: [CTL] Shutting down the System State, this will teardown the CHIP Stack [1643072207633] [18054:5783369] CHIP: [BLE] CancelConnection [1643072207633] [18054:5783369] CHIP: [DL] Inet Layer shutdown [1643072207633] [18054:5783369] CHIP: [DL] BLE shutdown [1643072207633] [18054:5783369] CHIP: [DL] System Layer shutdown Accessory Log [1643072172.387103][220296:220296] CHIP:DMG: ReportsInFlight = 0 with readHandler 0, RE has no more messages [1643072172.387124][220296:220296] CHIP:DMG: IM RH moving to [Uninitialized] [1643072172.387191][220296:220296] CHIP:EM: Received message of type 0x10 with protocolId (0, 0) and MessageCounter:2839139668 on exchange 13965r [1643072172.387216][220296:220296] CHIP:EM: Found matching exchange: 13965r, Delegate: (nil) [1643072172.387267][220296:220296] CHIP:EM: Rxd Ack; Removing MessageCounter:3044037429 from Retrans Table on exchange 13965r [1643072172.387290][220296:220296] CHIP:EM: Removed CHIP MessageCounter:3044037429 from RetransTable on exchange 13965r [1643072172.390807][220296:220296] CHIP:EM: Received message of type 0x10 with protocolId (0, 0) and MessageCounter:1314131 on exchange 13966r [1643072172.390848][220296:220296] CHIP:EM: Found matching exchange: 13966r, Delegate: (nil) [1643072172.390910][220296:220296] CHIP:EM: Rxd Ack; Removing MessageCounter:10332630 from Retrans Table on exchange 13966r [1643072172.390933][220296:220296] CHIP:EM: Removed CHIP MessageCounter:10332630 from RetransTable on exchange 13966r [1643072207.727675][220296:220296] CHIP:EM: Received message of type 0x30 with protocolId (0, 0) and MessageCounter:1295415451 on exchange 57683r [1643072207.727775][220296:220296] CHIP:EM: Handling via exchange: 57683r, Delegate: 0xaaaae903f7a8 [1643072207.727816][220296:220296] CHIP:IN: CASE Server received Sigma1 message. Starting handshake. EC 0xaaaae9040de8 [1643072207.727841][220296:220296] CHIP:DIS: CASE handshake initiated, closing all BLE Connections [1643072207.727868][220296:220296] CHIP:SC: Waiting for Sigma1 msg [1643072207.727888][220296:220296] CHIP:IN: CASE Server disabling CASE session setups [1643072207.727915][220296:220296] CHIP:SC: Received Sigma1 msg [1643072207.728012][220296:220296] CHIP:SC: Found MRP parameters in the message [1643072207.728040][220296:220296] CHIP:SC: Peer assigned session key ID 1 [1643072207.728062][220296:220296] CHIP:DIS: Fabric (1) loaded from storage. Calling OnFabricRetrievedFromStorage [1643072207.728082][220296:220296] CHIP:ZCL: OpCreds: Fabric 0x1 was retrieved from storage. FabricId 0x0000000000000001, NodeId 0x00000000000004D2, VendorId 0xFFF1 [1643072207.728104][220296:220296] CHIP:ZCL: OpCreds: Call to fabricListChanged [1643072207.728234][220296:220296] CHIP:IN: Generating DestinationID. Fabric ID 0x0000000000000001, Dest node ID 0x00000000000004D2, Random data [1643072207.728268][220296:220296] CHIP:IN: 0x75, 0x25, 0x34, 0x1f, 0xff, 0x7a, 0x3c, 0xa7, [1643072207.728290][220296:220296] CHIP:IN: 0x92, 0xf2, 0xd3, 0xd0, 0x9e, 0x86, 0xca, 0x51, [1643072207.728312][220296:220296] CHIP:IN: 0x50, 0xd6, 0x1b, 0x9c, 0x7c, 0x2e, 0x05, 0x08, [1643072207.728333][220296:220296] CHIP:IN: 0xb5, 0x8b, 0xae, 0x04, 0x32, 0x18, 0xda, 0xb9, [1643072207.728352][220296:220296] CHIP:IN: Root pubkey [1643072207.728374][220296:220296] CHIP:IN: 0x04, 0xca, 0x41, 0xc3, 0xe1, 0x83, 0x33, 0xc6, [1643072207.728395][220296:220296] CHIP:IN: 0xe5, 0x4a, 0xaa, 0x36, 0x98, 0xfe, 0x0d, 0xb3, [1643072207.728416][220296:220296] CHIP:IN: 0x43, 0x0b, 0x81, 0xb3, 0xca, 0xc6, 0xc1, 0x1b, [1643072207.728437][220296:220296] CHIP:IN: 0x67, 0x0d, 0x71, 0x0b, 0x76, 0xfe, 0xc7, 0x48, [1643072207.728458][220296:220296] CHIP:IN: 0x24, 0x38, 0xfe, 0xce, 0x8f, 0xe4, 0xa2, 0xb3, [1643072207.728479][220296:220296] CHIP:IN: 0xed, 0xe4, 0x79, 0x06, 0xb2, 0x54, 0xcc, 0xc1, [1643072207.728500][220296:220296] CHIP:IN: 0xed, 0x3b, 0x22, 0x01, 0x45, 0x34, 0xd1, 0x04, [1643072207.728521][220296:220296] CHIP:IN: 0x9a, 0x34, 0x01, 0x9c, 0xa2, 0x50, 0xab, 0x05, [1643072207.728539][220296:220296] CHIP:IN: 0x3b, [1643072207.728559][220296:220296] CHIP:IN: IPK [1643072207.728580][220296:220296] CHIP:IN: 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, [1643072207.728602][220296:220296] CHIP:IN: 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, [1643072207.728639][220296:220296] CHIP:IN: Generated DestinationID output [1643072207.728662][220296:220296] CHIP:IN: 0xee, 0x34, 0xcb, 0xbb, 0xcf, 0xb8, 0x68, 0xde, [1643072207.728684][220296:220296] CHIP:IN: 0x62, 0x7c, 0x6c, 0xed, 0xeb, 0x70, 0x16, 0xb6, [1643072207.728705][220296:220296] CHIP:IN: 0xc4, 0x9d, 0x98, 0xc3, 0xa0, 0x0c, 0x73, 0x8c, [1643072207.728726][220296:220296] CHIP:IN: 0x51, 0xfd, 0x62, 0x72, 0x77, 0x5e, 0x70, 0xcf, [1643072207.728746][220296:220296] CHIP:DIS: Fabric (1) loaded from storage. Calling OnFabricRetrievedFromStorage [1643072207.728765][220296:220296] CHIP:ZCL: OpCreds: Fabric 0x1 was retrieved from storage. FabricId 0x0000000000000001, NodeId 0x00000000000004D2, VendorId 0xFFF1 [1643072207.728785][220296:220296] CHIP:ZCL: OpCreds: Call to fabricListChanged [1643072207.729884][220296:220296] CHIP:SC: Including MRP parameters [1643072207.729950][220296:220296] CHIP:EM: Piggybacking Ack for MessageCounter:1295415451 on exchange: 57683r [1643072207.729985][220296:220296] CHIP:IN: Prepared plaintext message 0xaaaae9040cb0 to 0x0000000000000000 (0) of type 0x31 and protocolId (0, 0) on exchange 57683r with MessageCounter:3044037430. [1643072207.730020][220296:220296] CHIP:IN: Sending plaintext msg 0xaaaae9040cb0 with MessageCounter:3044037430 to 0x0000000000000000 at monotonic time: 374658553 msec [1643072207.730219][220296:220296] CHIP:SC: Sent Sigma2 msg [1643072207.733364][220296:220296] CHIP:EM: Received message of type 0x32 with protocolId (0, 0) and MessageCounter:1295415452 on exchange 57683r [1643072207.733405][220296:220296] CHIP:EM: Found matching exchange: 57683r, Delegate: 0xaaaae903f7b8 [1643072207.733467][220296:220296] CHIP:EM: Rxd Ack; Removing MessageCounter:3044037430 from Retrans Table on exchange 57683r [1643072207.733490][220296:220296] CHIP:EM: Removed CHIP MessageCounter:3044037430 from RetransTable on exchange 57683r [1643072207.733540][220296:220296] CHIP:SC: Received Sigma3 msg [1643072207.735439][220296:220296] CHIP:IN: Generating compressed fabric ID using uncompressed fabric ID 0x0000000000000001 and root pubkey [1643072207.735480][220296:220296] CHIP:IN: 0x04, 0xca, 0x41, 0xc3, 0xe1, 0x83, 0x33, 0xc6, [1643072207.735503][220296:220296] CHIP:IN: 0xe5, 0x4a, 0xaa, 0x36, 0x98, 0xfe, 0x0d, 0xb3, [1643072207.735524][220296:220296] CHIP:IN: 0x43, 0x0b, 0x81, 0xb3, 0xca, 0xc6, 0xc1, 0x1b, [1643072207.735546][220296:220296] CHIP:IN: 0x67, 0x0d, 0x71, 0x0b, 0x76, 0xfe, 0xc7, 0x48, [1643072207.735567][220296:220296] CHIP:IN: 0x24, 0x38, 0xfe, 0xce, 0x8f, 0xe4, 0xa2, 0xb3, [1643072207.735587][220296:220296] CHIP:IN: 0xed, 0xe4, 0x79, 0x06, 0xb2, 0x54, 0xcc, 0xc1, [1643072207.735609][220296:220296] CHIP:IN: 0xed, 0x3b, 0x22, 0x01, 0x45, 0x34, 0xd1, 0x04, [1643072207.735629][220296:220296] CHIP:IN: 0x9a, 0x34, 0x01, 0x9c, 0xa2, 0x50, 0xab, 0x05, [1643072207.735648][220296:220296] CHIP:IN: 0x3b, [1643072207.735692][220296:220296] CHIP:IN: Generated compressed fabric ID [1643072207.735717][220296:220296] CHIP:IN: 0xf3, 0x3b, 0x41, 0xde, 0x52, 0x54, 0x99, 0xdc, [1643072207.736572][220296:220296] CHIP:SC: Sending status report. Protocol code 0, exchange 57683 [1643072207.736622][220296:220296] CHIP:EM: Piggybacking Ack for MessageCounter:1295415452 on exchange: 57683r [1643072207.736655][220296:220296] CHIP:IN: Prepared plaintext message 0xaaaae9040cb0 to 0x0000000000000000 (0) of type 0x40 and protocolId (0, 0) on exchange 57683r with MessageCounter:3044037431. [1643072207.736689][220296:220296] CHIP:IN: Sending plaintext msg 0xaaaae9040cb0 with MessageCounter:3044037431 to 0x0000000000000000 at monotonic time: 374658560 msec [1643072207.736867][220296:220296] CHIP:IN: CASE Session established. Setting up the secure channel. [1643072207.736897][220296:220296] CHIP:IN: Marking old secure session for device 0x000000000001B669 as expired [1643072207.736930][220296:220296] CHIP:IN: New secure session created for device 0x000000000001B669, key 1!! [1643072207.737027][220296:220296] CHIP:IN: CASE secure channel is available now. [1643072207.737051][220296:220296] CHIP:IN: CASE Server enabling CASE session setups [1643072207.739160][220296:220296] CHIP:EM: Received message of type 0x8 with protocolId (0, 1) and MessageCounter:12840264 on exchange 57684r [1643072207.739195][220296:220296] CHIP:EM: Handling via exchange: 57684r, Delegate: 0xaaaae903b778 [1643072207.739285][220296:220296] CHIP:DMG: InvokeRequestMessage = [1643072207.739310][220296:220296] CHIP:DMG: { [1643072207.739332][220296:220296] CHIP:DMG: suppressResponse = false, [1643072207.739354][220296:220296] CHIP:DMG: timedRequest = false, [1643072207.739374][220296:220296] CHIP:DMG: InvokeRequests = [1643072207.739400][220296:220296] CHIP:DMG: [ [1643072207.739420][220296:220296] CHIP:DMG: CommandDataIB = [1643072207.739442][220296:220296] CHIP:DMG: { [1643072207.739462][220296:220296] CHIP:DMG: CommandPathIB = [1643072207.739484][220296:220296] CHIP:DMG: { [1643072207.739507][220296:220296] CHIP:DMG: EndpointId = 0x1, [1643072207.739529][220296:220296] CHIP:DMG: ClusterId = 0x508, [1643072207.739550][220296:220296] CHIP:DMG: CommandId = 0x0, [1643072207.739570][220296:220296] CHIP:DMG: }, [1643072207.739593][220296:220296] CHIP:DMG: [1643072207.739614][220296:220296] CHIP:DMG: CommandData = [1643072207.739635][220296:220296] CHIP:DMG: { [1643072207.739656][220296:220296] CHIP:DMG: }, [1643072207.739675][220296:220296] CHIP:DMG: }, [1643072207.739699][220296:220296] CHIP:DMG: [1643072207.739718][220296:220296] CHIP:DMG: ], [1643072207.739742][220296:220296] CHIP:DMG: [1643072207.739761][220296:220296] CHIP:DMG: }, [1643072207.739812][220296:220296] CHIP:DMG: Received command for Endpoint=1 Cluster=0x0000_0508 Command=0x0000_0000 [1643072207.739861][220296:220296] CHIP:DMG: ICR moving to [AddingComm] [1643072207.739889][220296:220296] CHIP:DMG: ICR moving to [AddedComma] [1643072207.739916][220296:220296] CHIP:DMG: Decreasing reference count for CommandHandler, remaining 0 [1643072207.739994][220296:220296] CHIP:EM: Piggybacking Ack for MessageCounter:12840264 on exchange: 57684r [1643072207.740043][220296:220296] CHIP:IN: Prepared encrypted message 0xaaaae9040cd0 to 0x000000000001B669 (1) of type 0x9 and protocolId (0, 1) on exchange 57684r with MessageCounter:14244877. [1643072207.740073][220296:220296] CHIP:IN: Sending encrypted msg 0xaaaae9040cd0 with MessageCounter:14244877 to 0x000000000001B669 (1) at monotonic time: 374658563 msec [1643072207.740231][220296:220296] CHIP:DMG: ICR moving to [CommandSen] [1643072207.740262][220296:220296] CHIP:DMG: ICR moving to [AwaitingDe] [1643072207.740395][220296:220296] CHIP:EM: Received message of type 0x10 with protocolId (0, 0) and MessageCounter:1295415453 on exchange 57683r [1643072207.740424][220296:220296] CHIP:EM: Found matching exchange: 57683r, Delegate: (nil) [1643072207.740476][220296:220296] CHIP:EM: Rxd Ack; Removing MessageCounter:3044037431 from Retrans Table on exchange 57683r [1643072207.740498][220296:220296] CHIP:EM: Removed CHIP MessageCounter:3044037431 from RetransTable on exchange 57683r [1643072207.742301][220296:220296] CHIP:EM: Received message of type 0x10 with protocolId (0, 0) and MessageCounter:12840265 on exchange 57684r [1643072207.742331][220296:220296] CHIP:EM: Found matching exchange: 57684r, Delegate: (nil) [1643072207.742388][220296:220296] CHIP:EM: Rxd Ack; Removing MessageCounter:14244877 from Retrans Table on exchange 57684r [1643072207.742410][220296:220296] CHIP:EM: Removed CHIP MessageCounter:14244877 from RetransTable on exchange 57684r