[1659777157.801660][2644:2653] CHIP:-: Received payload: "{"Name":"SwitchLatched","NewPosition":2} {"Name":"MultiPressComplete","PreviousPosition":1,"TotalNumberOfPressesCounted":1}" [1659777157.802160][2644:2644] CHIP:DMG: Endpoint 1, Cluster 0x0000_003B update version to 34b335d1 [1659777157.802248][2644:2644] CHIP:-: The latching switch is moved to a new position:2 [1659777157.802307][2644:2644] CHIP:ZCL: SwitchServer: OnSwitchLatch [1659777157.802425][2644:2644] CHIP:EVL: LogEvent event number: 0x0000000000000008 priority: 1, endpoint id: 0x1 cluster id: 0x0000_003B event id: 0x0 Sys timestamp: 0x0000000000481C4E [1659777222.650797][2644:2644] CHIP:DMG: Refresh subscribe timer sync after 99 seconds [1659777222.650938][2644:2644] CHIP:DMG: Building Reports for ReadHandler with LastReportGeneration = 39 DirtyGeneration = 0 [1659777222.651219][2644:2644] CHIP:DMG: Fetched 0 events [1659777222.651251][2644:2644] CHIP:DMG: Sending report (payload has 11 bytes)... [1659777222.651292][2644:2644] CHIP:DMG: IM RH moving to [AwaitingReportResponse] [1659777222.651394][2644:2644] CHIP:IN: Prepared secure message 0xaaaac0a13e18 to 0x000000000001B669 (1) of type 0x5 and protocolId (0, 1) on exchange 44016i with MessageCounter:14610517. [1659777222.651438][2644:2644] CHIP:IN: Sending encrypted msg 0xaaaac0a13e18 with MessageCounter:14610517 to 0x000000000001B669 (1) at monotonic time: 000000000049199F msec [1659777222.651629][2644:2644] CHIP:DMG: Refresh Subscribe Sync Timer with max 100 seconds [1659777222.651662][2644:2644] CHIP:DMG: ReportsInFlight = 1 with readHandler 0, RE has no more messages [1659777222.651688][2644:2644] CHIP:DMG: All ReadHandler-s are clean, clear GlobalDirtySet [1659777222.653771][2644:2644] CHIP:EM: Received message of type 0x1 with protocolId (0, 1) and MessageCounter:240089705 on exchange 44016i [1659777222.653807][2644:2644] CHIP:EM: Found matching exchange: 44016i, Delegate: 0xffff9803ada8 [1659777222.653839][2644:2644] CHIP:EM: Rxd Ack; Removing MessageCounter:14610517 from Retrans Table on exchange 44016i [1659777222.653863][2644:2644] CHIP:EM: Removed CHIP MessageCounter:14610517 from RetransTable on exchange 44016i [1659777222.653909][2644:2644] CHIP:DMG: StatusResponseMessage = [1659777222.653937][2644:2644] CHIP:DMG: { [1659777222.653961][2644:2644] CHIP:DMG: Status = 0x00 (SUCCESS), [1659777222.653988][2644:2644] CHIP:DMG: InteractionModelRevision = 1 [1659777222.654011][2644:2644] CHIP:DMG: } [1659777222.654036][2644:2644] CHIP:IM: Received status response, status is 0x00 (SUCCESS) [1659777222.654063][2644:2644] CHIP:DMG: OnReportConfirm: NumReports = 0 [1659777222.654087][2644:2644] CHIP:DMG: IM RH moving to [GeneratingReports] [1659777222.654110][2644:2644] CHIP:EM: Sending Standalone Ack for MessageCounter:240089705 on exchange 44016i [1659777222.654157][2644:2644] CHIP:IN: Prepared secure message 0xffffd692e088 to 0x000000000001B669 (1) of type 0x10 and protocolId (0, 0) on exchange 44016i with MessageCounter:14610518. [1659777222.654191][2644:2644] CHIP:IN: Sending encrypted msg 0xffffd692e088 with MessageCounter:14610518 to 0x000000000001B669 (1) at monotonic time: 00000000004919A2 msec [1659777222.654279][2644:2644] CHIP:EM: Flushed pending ack for MessageCounter:240089705 on exchange 44016i [1659777222.654353][2644:2644] CHIP:DMG: All ReadHandler-s are clean, clear GlobalDirtySet [1659777223.652675][2644:2644] CHIP:DMG: Unblock report hold after min 1 seconds [1659777322.654907][2644:2644] CHIP:DMG: Refresh subscribe timer sync after 99 seconds [1659777322.655142][2644:2644] CHIP:DMG: Building Reports for ReadHandler with LastReportGeneration = 40 DirtyGeneration = 0 [1659777322.655838][2644:2644] CHIP:DMG: Fetched 0 events [1659777322.655914][2644:2644] CHIP:DMG: Sending report (payload has 11 bytes)... [1659777322.655997][2644:2644] CHIP:DMG: IM RH moving to [AwaitingReportResponse] [1659777322.656169][2644:2644] CHIP:IN: Prepared secure message 0xaaaac0a510f8 to 0x000000000001B669 (1) of type 0x5 and protocolId (0, 1) on exchange 44017i with MessageCounter:14610519. [1659777322.656265][2644:2644] CHIP:IN: Sending encrypted msg 0xaaaac0a510f8 with MessageCounter:14610519 to 0x000000000001B669 (1) at monotonic time: 00000000004AA044 msec [1659777322.656607][2644:2644] CHIP:DMG: Refresh Subscribe Sync Timer with max 100 seconds [1659777322.656684][2644:2644] CHIP:DMG: ReportsInFlight = 1 with readHandler 0, RE has no more messages [1659777322.656745][2644:2644] CHIP:DMG: All ReadHandler-s are clean, clear GlobalDirtySet [1659777322.658788][2644:2644] CHIP:EM: Received message of type 0x1 with protocolId (0, 1) and MessageCounter:240089706 on exchange 44017i [1659777322.658863][2644:2644] CHIP:EM: Found matching exchange: 44017i, Delegate: 0xffff9803ada8 [1659777322.658938][2644:2644] CHIP:EM: Rxd Ack; Removing MessageCounter:14610519 from Retrans Table on exchange 44017i [1659777322.658999][2644:2644] CHIP:EM: Removed CHIP MessageCounter:14610519 from RetransTable on exchange 44017i [1659777322.659096][2644:2644] CHIP:DMG: StatusResponseMessage = [1659777322.659161][2644:2644] CHIP:DMG: { [1659777322.659221][2644:2644] CHIP:DMG: Status = 0x00 (SUCCESS), [1659777322.659276][2644:2644] CHIP:DMG: InteractionModelRevision = 1 [1659777322.659333][2644:2644] CHIP:DMG: } [1659777322.659391][2644:2644] CHIP:IM: Received status response, status is 0x00 (SUCCESS) [1659777322.659457][2644:2644] CHIP:DMG: OnReportConfirm: NumReports = 0 [1659777322.659518][2644:2644] CHIP:DMG: IM RH moving to [GeneratingReports] [1659777322.659575][2644:2644] CHIP:EM: Sending Standalone Ack for MessageCounter:240089706 on exchange 44017i [1659777322.659683][2644:2644] CHIP:IN: Prepared secure message 0xffffd692e088 to 0x000000000001B669 (1) of type 0x10 and protocolId (0, 0) on exchange 44017i with MessageCounter:14610520. [1659777322.659766][2644:2644] CHIP:IN: Sending encrypted msg 0xffffd692e088 with MessageCounter:14610520 to 0x000000000001B669 (1) at monotonic time: 00000000004AA047 msec [1659777322.660005][2644:2644] CHIP:EM: Flushed pending ack for MessageCounter:240089706 on exchange 44017i [1659777322.660169][2644:2644] CHIP:DMG: All ReadHandler-s are clean, clear GlobalDirtySet [1659777323.657579][2644:2644] CHIP:DMG: Unblock report hold after min 1 seconds [1659777422.665587][2644:2644] CHIP:DMG: Refresh subscribe timer sync after 99 seconds [1659777422.665821][2644:2644] CHIP:DMG: Building Reports for ReadHandler with LastReportGeneration = 40 DirtyGeneration = 0 [1659777422.666464][2644:2644] CHIP:DMG: Fetched 0 events [1659777422.666538][2644:2644] CHIP:DMG: Sending report (payload has 11 bytes)... [1659777422.666619][2644:2644] CHIP:DMG: IM RH moving to [AwaitingReportResponse] [1659777422.666795][2644:2644] CHIP:IN: Prepared secure message 0xaaaac0a11e08 to 0x000000000001B669 (1) of type 0x5 and protocolId (0, 1) on exchange 44018i with MessageCounter:14610521. [1659777422.666891][2644:2644] CHIP:IN: Sending encrypted msg 0xaaaac0a11e08 with MessageCounter:14610521 to 0x000000000001B669 (1) at monotonic time: 00000000004C26EF msec [1659777422.667237][2644:2644] CHIP:DMG: Refresh Subscribe Sync Timer with max 100 seconds [1659777422.667315][2644:2644] CHIP:DMG: ReportsInFlight = 1 with readHandler 0, RE has no more messages [1659777422.667374][2644:2644] CHIP:DMG: All ReadHandler-s are clean, clear GlobalDirtySet [1659777422.668454][2644:2644] CHIP:EM: Received message of type 0x1 with protocolId (0, 1) and MessageCounter:240089707 on exchange 44018i [1659777422.668536][2644:2644] CHIP:EM: Found matching exchange: 44018i, Delegate: 0xffff9803ada8 [1659777422.668614][2644:2644] CHIP:EM: Rxd Ack; Removing MessageCounter:14610521 from Retrans Table on exchange 44018i [1659777422.668674][2644:2644] CHIP:EM: Removed CHIP MessageCounter:14610521 from RetransTable on exchange 44018i [1659777422.668770][2644:2644] CHIP:DMG: StatusResponseMessage = [1659777422.668835][2644:2644] CHIP:DMG: { [1659777422.668895][2644:2644] CHIP:DMG: Status = 0x00 (SUCCESS), [1659777422.668959][2644:2644] CHIP:DMG: InteractionModelRevision = 1 [1659777422.669016][2644:2644] CHIP:DMG: } [1659777422.669073][2644:2644] CHIP:IM: Received status response, status is 0x00 (SUCCESS) [1659777422.669138][2644:2644] CHIP:DMG: OnReportConfirm: NumReports = 0 [1659777422.669196][2644:2644] CHIP:DMG: IM RH moving to [GeneratingReports] [1659777422.669252][2644:2644] CHIP:EM: Sending Standalone Ack for MessageCounter:240089707 on exchange 44018i [1659777422.669352][2644:2644] CHIP:IN: Prepared secure message 0xffffd692e088 to 0x000000000001B669 (1) of type 0x10 and protocolId (0, 0) on exchange 44018i with MessageCounter:14610522. [1659777422.669504][2644:2644] CHIP:IN: Sending encrypted msg 0xffffd692e088 with MessageCounter:14610522 to 0x000000000001B669 (1) at monotonic time: 00000000004C26F1 msec [1659777422.669672][2644:2644] CHIP:EM: Flushed pending ack for MessageCounter:240089707 on exchange 44018i [1659777422.669813][2644:2644] CHIP:DMG: All ReadHandler-s are clean, clear GlobalDirtySet [1659777423.668152][2644:2644] CHIP:DMG: Unblock report hold after min 1 seconds [1659777522.671942][2644:2644] CHIP:DMG: Refresh subscribe timer sync after 99 seconds [1659777522.672081][2644:2644] CHIP:DMG: Building Reports for ReadHandler with LastReportGeneration = 40 DirtyGeneration = 0 [1659777522.672361][2644:2644] CHIP:DMG: Fetched 0 events [1659777522.672394][2644:2644] CHIP:DMG: Sending report (payload has 11 bytes)... [1659777522.672434][2644:2644] CHIP:DMG: IM RH moving to [AwaitingReportResponse] [1659777522.672533][2644:2644] CHIP:IN: Prepared secure message 0xaaaac09fdef8 to 0x000000000001B669 (1) of type 0x5 and protocolId (0, 1) on exchange 44019i with MessageCounter:14610523. [1659777522.672575][2644:2644] CHIP:IN: Sending encrypted msg 0xaaaac09fdef8 with MessageCounter:14610523 to 0x000000000001B669 (1) at monotonic time: 00000000004DAD94 msec [1659777522.672772][2644:2644] CHIP:DMG: Refresh Subscribe Sync Timer with max 100 seconds [1659777522.672805][2644:2644] CHIP:DMG: ReportsInFlight = 1 with readHandler 0, RE has no more messages [1659777522.672831][2644:2644] CHIP:DMG: All ReadHandler-s are clean, clear GlobalDirtySet [1659777522.675017][2644:2644] CHIP:EM: Received message of type 0x1 with protocolId (0, 1) and MessageCounter:240089708 on exchange 44019i [1659777522.675076][2644:2644] CHIP:EM: Found matching exchange: 44019i, Delegate: 0xffff9803ada8 [1659777522.675134][2644:2644] CHIP:EM: Rxd Ack; Removing MessageCounter:14610523 from Retrans Table on exchange 44019i [1659777522.675180][2644:2644] CHIP:EM: Removed CHIP MessageCounter:14610523 from RetransTable on exchange 44019i [1659777522.675257][2644:2644] CHIP:DMG: StatusResponseMessage = [1659777522.675305][2644:2644] CHIP:DMG: { [1659777522.675347][2644:2644] CHIP:DMG: Status = 0x00 (SUCCESS), [1659777522.675395][2644:2644] CHIP:DMG: InteractionModelRevision = 1 [1659777522.675438][2644:2644] CHIP:DMG: } [1659777522.675482][2644:2644] CHIP:IM: Received status response, status is 0x00 (SUCCESS) [1659777522.675533][2644:2644] CHIP:DMG: OnReportConfirm: NumReports = 0 [1659777522.675578][2644:2644] CHIP:DMG: IM RH moving to [GeneratingReports] [1659777522.675622][2644:2644] CHIP:EM: Sending Standalone Ack for MessageCounter:240089708 on exchange 44019i [1659777522.675705][2644:2644] CHIP:IN: Prepared secure message 0xffffd692e088 to 0x000000000001B669 (1) of type 0x10 and protocolId (0, 0) on exchange 44019i with MessageCounter:14610524. [1659777522.675767][2644:2644] CHIP:IN: Sending encrypted msg 0xffffd692e088 with MessageCounter:14610524 to 0x000000000001B669 (1) at monotonic time: 00000000004DAD97 msec [1659777522.675961][2644:2644] CHIP:EM: Flushed pending ack for MessageCounter:240089708 on exchange 44019i [1659777522.676089][2644:2644] CHIP:DMG: All ReadHandler-s are clean, clear GlobalDirtySet [1659777523.674534][2644:2644] CHIP:DMG: Unblock report hold after min 1 seconds [1659777622.686950][2644:2644] CHIP:DMG: Refresh subscribe timer sync after 99 seconds [1659777622.687092][2644:2644] CHIP:DMG: Building Reports for ReadHandler with LastReportGeneration = 40 DirtyGeneration = 0 [1659777622.687371][2644:2644] CHIP:DMG: Fetched 0 events [1659777622.687402][2644:2644] CHIP:DMG: Sending report (payload has 11 bytes)... [1659777622.687443][2644:2644] CHIP:DMG: IM RH moving to [AwaitingReportResponse] [1659777622.687544][2644:2644] CHIP:IN: Prepared secure message 0xaaaac0a13e18 to 0x000000000001B669 (1) of type 0x5 and protocolId (0, 1) on exchange 44020i with MessageCounter:14610525. [1659777622.687588][2644:2644] CHIP:IN: Sending encrypted msg 0xaaaac0a13e18 with MessageCounter:14610525 to 0x000000000001B669 (1) at monotonic time: 00000000004F3443 msec [1659777622.687843][2644:2644] CHIP:DMG: Refresh Subscribe Sync Timer with max 100 seconds [1659777622.687877][2644:2644] CHIP:DMG: ReportsInFlight = 1 with readHandler 0, RE has no more messages [1659777622.687902][2644:2644] CHIP:DMG: All ReadHandler-s are clean, clear GlobalDirtySet [1659777622.690131][2644:2644] CHIP:EM: Received message of type 0x1 with protocolId (0, 1) and MessageCounter:240089709 on exchange 44020i [1659777622.690209][2644:2644] CHIP:EM: Found matching exchange: 44020i, Delegate: 0xffff9803ada8 [1659777622.690285][2644:2644] CHIP:EM: Rxd Ack; Removing MessageCounter:14610525 from Retrans Table on exchange 44020i [1659777622.690345][2644:2644] CHIP:EM: Removed CHIP MessageCounter:14610525 from RetransTable on exchange 44020i [1659777622.690441][2644:2644] CHIP:DMG: StatusResponseMessage = [1659777622.690506][2644:2644] CHIP:DMG: { [1659777622.690566][2644:2644] CHIP:DMG: Status = 0x00 (SUCCESS), [1659777622.690629][2644:2644] CHIP:DMG: InteractionModelRevision = 1 [1659777622.690686][2644:2644] CHIP:DMG: } [1659777622.690741][2644:2644] CHIP:IM: Received status response, status is 0x00 (SUCCESS) [1659777622.690806][2644:2644] CHIP:DMG: OnReportConfirm: NumReports = 0 [1659777622.690864][2644:2644] CHIP:DMG: IM RH moving to [GeneratingReports] [1659777622.690921][2644:2644] CHIP:EM: Sending Standalone Ack for MessageCounter:240089709 on exchange 44020i [1659777622.691027][2644:2644] CHIP:IN: Prepared secure message 0xffffd692e088 to 0x000000000001B669 (1) of type 0x10 and protocolId (0, 0) on exchange 44020i with MessageCounter:14610526. [1659777622.691110][2644:2644] CHIP:IN: Sending encrypted msg 0xffffd692e088 with MessageCounter:14610526 to 0x000000000001B669 (1) at monotonic time: 00000000004F3447 msec [1659777622.691298][2644:2644] CHIP:EM: Flushed pending ack for MessageCounter:240089709 on exchange 44020i [1659777622.691462][2644:2644] CHIP:DMG: All ReadHandler-s are clean, clear GlobalDirtySet [1659777623.688877][2644:2644] CHIP:DMG: Unblock report hold after min 1 seconds [1659777722.700431][2644:2644] CHIP:DMG: Refresh subscribe timer sync after 99 seconds [1659777722.700677][2644:2644] CHIP:DMG: Building Reports for ReadHandler with LastReportGeneration = 40 DirtyGeneration = 0 [1659777722.701329][2644:2644] CHIP:DMG: Fetched 0 events [1659777722.701439][2644:2644] CHIP:DMG: Sending report (payload has 11 bytes)... [1659777722.701526][2644:2644] CHIP:DMG: IM RH moving to [AwaitingReportResponse] [1659777722.701711][2644:2644] CHIP:IN: Prepared secure message 0xaaaac0a510f8 to 0x000000000001B669 (1) of type 0x5 and protocolId (0, 1) on exchange 44021i with MessageCounter:14610527. [1659777722.701813][2644:2644] CHIP:IN: Sending encrypted msg 0xaaaac0a510f8 with MessageCounter:14610527 to 0x000000000001B669 (1) at monotonic time: 000000000050BAF2 msec [1659777722.702170][2644:2644] CHIP:DMG: Refresh Subscribe Sync Timer with max 100 seconds [1659777722.702252][2644:2644] CHIP:DMG: ReportsInFlight = 1 with readHandler 0, RE has no more messages [1659777722.702315][2644:2644] CHIP:DMG: All ReadHandler-s are clean, clear GlobalDirtySet [1659777722.703383][2644:2644] CHIP:EM: Received message of type 0x1 with protocolId (0, 1) and MessageCounter:240089710 on exchange 44021i [1659777722.703467][2644:2644] CHIP:EM: Found matching exchange: 44021i, Delegate: 0xffff9803ada8 [1659777722.703549][2644:2644] CHIP:EM: Rxd Ack; Removing MessageCounter:14610527 from Retrans Table on exchange 44021i [1659777722.703610][2644:2644] CHIP:EM: Removed CHIP MessageCounter:14610527 from RetransTable on exchange 44021i [1659777722.703712][2644:2644] CHIP:DMG: StatusResponseMessage = [1659777722.703778][2644:2644] CHIP:DMG: { [1659777722.703883][2644:2644] CHIP:DMG: Status = 0x00 (SUCCESS), [1659777722.703948][2644:2644] CHIP:DMG: InteractionModelRevision = 1 [1659777722.704006][2644:2644] CHIP:DMG: } [1659777722.704080][2644:2644] CHIP:IM: Received status response, status is 0x00 (SUCCESS) [1659777722.704150][2644:2644] CHIP:DMG: OnReportConfirm: NumReports = 0 [1659777722.704211][2644:2644] CHIP:DMG: IM RH moving to [GeneratingReports] [1659777722.704268][2644:2644] CHIP:EM: Sending Standalone Ack for MessageCounter:240089710 on exchange 44021i [1659777722.704369][2644:2644] CHIP:IN: Prepared secure message 0xffffd692e088 to 0x000000000001B669 (1) of type 0x10 and protocolId (0, 0) on exchange 44021i with MessageCounter:14610528. [1659777722.704524][2644:2644] CHIP:IN: Sending encrypted msg 0xffffd692e088 with MessageCounter:14610528 to 0x000000000001B669 (1) at monotonic time: 000000000050BAF4 msec [1659777722.704702][2644:2644] CHIP:EM: Flushed pending ack for MessageCounter:240089710 on exchange 44021i [1659777722.704845][2644:2644] CHIP:DMG: All ReadHandler-s are clean, clear GlobalDirtySet [1659777723.703220][2644:2644] CHIP:DMG: Unblock report hold after min 1 seconds