AlarmDecoder reports non-existent restore/fault events

General Discussion

Re: AlarmDecoder reports non-existent restore/fault events

Postby dssinger » Sat Aug 29, 2020 12:05 pm

That fix doesn't solve the timeout problem that I'm seeing. If I have a lot of windows open, it can take more than 30 seconds for the panel to get back to a zone that is skipped when a motion detector fires, and the _zone_expired routine in zonetracking.py wrongly marks such a zone as "restored".

I've made a temporary patch to _zone_expired to always return False and it seems to work - I will try it tonight when we open up and see if all stays good. I can't tell what problem the zone expiration logic is solving, so I don't know if there will be side effects by defeating it.

David
dssinger
newt
newt
 
Posts: 8
Joined: Sat Aug 08, 2020 1:49 pm

Re: AlarmDecoder reports non-existent restore/fault events

Postby dssinger » Mon Aug 31, 2020 2:37 pm

The version of the code with _zone_expired removed works well, but I've accidentally found a way to trigger the false restores - a "double-fault". Here's the sequence of events, followed by the log:

We left a lot of windows open overnight, specifically zones 10, 11, 12, 13, 14, 15, 17, and 19. All was well.

At 13:24:43, I opened the front door (Zone 9), which raised a fault for that zone and added it to the list. A few seconds later, I closed the door. The panel showed Zone 9 and then Zone 10 and would have continued through the zones in turn; it would have removed Zone 9 from the fault list in about 30 seconds except that I opened the door again at 13:24:48, faulting Zone 9 for a second time in quick succession.

This time, when the panel showed Zone 9 as faulted, it was already on the list and so the code declared all zones from 11 to the end as "restored", and then each of them got faulted when they came back on the panel.

Code: Select all
13:24:09|Zone OFFICE MOTION DETECTOR (23) has been restored.
13:24:13 [00000001000000000A--],010,[f702000d1010000008020000000000],"FAULT 10 LIVING ROOM WINDOW     "
13:24:17 [00000001000000000A--],011,[f702000d1011000008020000000000],"FAULT 11 LIVING ROOM WINDOW     "
13:24:21 [00000001000000000A--],012,[f702000d1012000008020000000000],"FAULT 12 MASTER BATHROOM WINDOW "
13:24:25 [00000001000000000A--],013,[f702000d1013000008020000000000],"FAULT 13 MASTER BEDROOM WINDOW  "
13:24:29 [00000001000000000A--],014,[f702000d1014000008020000000000],"FAULT 14 OFFICE WINDOW          "
13:24:33 [00000001000000000A--],015,[f702000d1015000008020000000000],"FAULT 15 JEFF'S BEDROOM WINDOW  "
13:24:37 [00000001000000000A--],017,[f702000d1017000008020000000000],"FAULT 17 KITCHENDESK WINDOW     "
13:24:41 [00000001000000000A--],019,[f702000d1019000008020000000000],"FAULT 19 SIDE   BATHROOM WINDOW "
13:24:42 !RFX:0012978,04
13:24:42|0012978:0:1:0:0:0:0
13:24:43 !AUI:120600000000666c02456cf5ec0101010000
13:24:43 !AUI:1606000000006763024543f531fb456cf5ec01020106
13:24:43 !RFX:zone09,a0
13:24:43 [00000001000000000A--],009,[f702000d1009000008020000000000],"FAULT 09 FRONT  ENTRY DOOR      "
13:24:43|120600000000666c02456cf5ec0101010000
13:24:43|Zone FRONT ENTRY DOOR (9) has been faulted.
13:24:43|zone09:0:0:1:1:0:0
13:24:44|1606000000006763024543f531fb456cf5ec01020106
13:24:47 !AUI:120600000000606c02456cf5ec0101010000
13:24:47 !AUI:1606000000006163024543f531fb456cf5ec01020106
13:24:47 !RFX:zone09,80
13:24:47 [00000001000000000A--],010,[f702000d1010000008020000000000],"FAULT 10 LIVING ROOM WINDOW     "
13:24:47|120600000000606c02456cf5ec0101010000
13:24:47|1606000000006163024543f531fb456cf5ec01020106
13:24:47|zone09:0:0:1:0:0:0
13:24:48 !AUI:120600000000626c02456cf5ec0101010000
13:24:48 !AUI:1606000000006363024543f531fb456cf5ec01020106
13:24:48 !RFX:zone09,a0
13:24:48 [00000001000000000A--],009,[f702000d1009000008020000000000],"FAULT 09 FRONT  ENTRY DOOR      "
13:24:48|120600000000626c02456cf5ec0101010000
13:24:48|1606000000006363024543f531fb456cf5ec01020106
13:24:48|Zone LIVING ROOM WINDOW (11) has been restored.
13:24:48|Zone MASTER BATHROOM WINDOW (12) has been restored.
13:24:48|Zone MASTER BEDROOM WINDOW (13) has been restored.
13:24:48|Zone OFFICE WINDOW (14) has been restored.
13:24:48|zone09:0:0:1:1:0:0
13:24:49|Zone Jeff's Bedroom Window (15) has been restored.
13:24:49|Zone KITCHEN (31) has been restored.
13:24:49|Zone KITCHEN DESK WINDOW (17) has been restored.
13:24:49|Zone SIDE BATHROOM WINDOW (19) has been restored.
13:24:51 !AUI:120600000000646c02456cf5ec0101010000
13:24:51 !AUI:1606000000006563024543f531fb456cf5ec01020106
13:24:51 !RFX:zone09,80
13:24:51|120600000000646c02456cf5ec0101010000
13:24:51|zone09:0:0:1:0:0:0
13:24:52|1606000000006563024543f531fb456cf5ec01020106
13:24:53 !AUI:120600000000666c02456cf5ec0101010000
13:24:53 !RFX:zone09,a0
13:24:53|zone09:0:0:1:1:0:0
13:24:54 !AUI:1606000000006763024543f531fb456cf5ec01020106
13:24:54 [00000001000000000A--],009,[f702000d1009000008020000000000],"FAULT 09 FRONT  ENTRY DOOR      "
13:24:54|120600000000666c02456cf5ec0101010000
13:24:54|1606000000006763024543f531fb456cf5ec01020106
13:24:54|Zone LIVING ROOM WINDOW (10) has been restored.
13:24:56 !AUI:120600000000606c02456cf5ec0101010000
13:24:56 !AUI:1606000000006163024543f531fb456cf5ec01020106
13:24:56 !RFX:zone09,80
13:24:56 [00000001000000000A--],010,[f702000d1010000008020000000000],"FAULT 10 LIVING ROOM WINDOW     "
13:24:56|120600000000606c02456cf5ec0101010000
13:24:56|1606000000006163024543f531fb456cf5ec01020106
13:24:56|Zone LIVING ROOM WINDOW (10) has been faulted.
13:24:56|zone09:0:0:1:0:0:0
13:25:00 [00000001000000000A--],011,[f702000d1011000008020000000000],"FAULT 11 LIVING ROOM WINDOW     "
13:25:00|Zone LIVING ROOM WINDOW (11) has been faulted.
13:25:04 [00000001000000000A--],012,[f702000d1012000008020000000000],"FAULT 12 MASTER BATHROOM WINDOW "
13:25:04|Zone MASTER BATHROOM WINDOW (12) has been faulted.
13:25:08 [00000001000000000A--],013,[f702000d1013000008020000000000],"FAULT 13 MASTER BEDROOM WINDOW  "
13:25:08|Zone MASTER BEDROOM WINDOW (13) has been faulted.
13:25:12 [00000001000000000A--],014,[f702000d1014000008020000000000],"FAULT 14 OFFICE WINDOW          "
13:25:12|Zone OFFICE WINDOW (14) has been faulted.
13:25:16 [00000001000000000A--],015,[f702000d1015000008020000000000],"FAULT 15 JEFF'S BEDROOM WINDOW  "
13:25:16|Zone Jeff's Bedroom Window (15) has been faulted.
13:25:20 [00000001000000000A--],017,[f702000d1017000008020000000000],"FAULT 17 KITCHENDESK WINDOW     "
13:25:20|Zone KITCHEN DESK WINDOW (17) has been faulted.
13:25:21 !RFX:0042883,84
13:25:21|0042883:0:1:1:0:0:0
13:25:23 [00000001000000000A--],019,[f702000d1019000008020000000000],"FAULT 19 SIDE   BATHROOM WINDOW "
13:25:24|Zone SIDE BATHROOM WINDOW (19) has been faulted.
13:25:27 [00000001000000000A--],031,[f702000d1031000008020000000000],"FAULT 31 KITCHEN                "
13:25:28|Zone KITCHEN (31) has been faulted.
13:25:31 [00000001000000000A--],010,[f702000d1010000008020000000000],"FAULT 10 LIVING ROOM WINDOW     "
13:25:35 !AUI:120600000000626c02456cf5ec0101010000
13:25:35 !AUI:1606000000006363024543f531fb456cf5ec01020106
13:25:35 !RFX:zone09,a0
13:25:35 [00000001000000000A--],009,[f702000d1009000008020000000000],"FAULT 09 FRONT  ENTRY DOOR      "
13:25:35|120600000000626c02456cf5ec0101010000
13:25:35|Zone LIVING ROOM WINDOW (11) has been restored.
13:25:35|zone09:0:0:1:1:0:0
13:25:36|Zone Jeff's Bedroom Window (15) has been restored.
13:25:36|Zone KITCHEN (31) has been restored.
13:25:36|Zone KITCHEN DESK WINDOW (17) has been restored.
13:25:36|Zone MASTER BATHROOM WINDOW (12) has been restored.
13:25:36|Zone MASTER BEDROOM WINDOW (13) has been restored.
13:25:36|Zone OFFICE WINDOW (14) has been restored.
13:25:36|Zone SIDE BATHROOM WINDOW (19) has been restored.
13:25:37|1606000000006363024543f531fb456cf5ec01020106
13:25:38 !AUI:120600000000646c02456cf5ec0101010000
13:25:38 !AUI:1606000000006563024543f531fb456cf5ec01020106
13:25:38 !RFX:zone09,80
13:25:38 [00000001000000000A--],010,[f702000d1010000008020000000000],"FAULT 10 LIVING ROOM WINDOW     "
13:25:38|120600000000646c02456cf5ec0101010000
13:25:38|zone09:0:0:1:0:0:0
13:25:39|1606000000006563024543f531fb456cf5ec01020106
13:25:42 [00000001000000000A--],011,[f702000d1011000008020000000000],"FAULT 11 LIVING ROOM WINDOW     "
13:25:42|Zone LIVING ROOM WINDOW (11) has been faulted.
13:25:46 [00000001000000000A--],012,[f702000d1012000008020000000000],"FAULT 12 MASTER BATHROOM WINDOW "
13:25:46|Zone MASTER BATHROOM WINDOW (12) has been faulted.


I don't know if it's possible to do better than this without using the actual RFX events directly instead of relying on the panel to interpret the state.

I'll send a pull request for my change removing the timed expiration.

Thanks!

David
dssinger
newt
newt
 
Posts: 8
Joined: Sat Aug 08, 2020 1:49 pm

Re: AlarmDecoder reports non-existent restore/fault events

Postby mathewss » Tue Sep 01, 2020 8:05 am

I see it but I have never seen that happen. Zone 9 tripped twice? It is an RFX zone so maybe its a bug in the panel firmware. Please report back your panel info including revision of firmware on the sticker on the panel.

Best
Sean M.
mathewss
Moderator
Moderator
 
Posts: 135
Joined: Fri Dec 06, 2013 11:14 am

Re: AlarmDecoder reports non-existent restore/fault events

Postby dssinger » Tue Sep 01, 2020 2:01 pm

It's not a bug in the firmware or panel. Here's the short form of what happened:

1. Open front door (zone 9) - RFX event is logged.
2. Panel shows zone 9 as faulted. Add zone 9 to the list of faulted zones; set "last seen faulted" to 0 since it's a new zone.
3. Close front door. RFX event is logged. No change to the panel, of course.
4. Panel shows zone 10 as faulted. Set "last seen faulted" to 10.
5. Open front door again (any time before the panel loops back to zone 10) - RFX event is logged.
6. Panel shows zone 9 as faulted; it's already on the list of faulted zones, so the code restores all zones from 11 to the end of the list because they were skipped.

If I'd only opened the front door once, or if I had waited long enough for the panel to get through the whole list before opening it the second time, there wouldn't have been any false restores.

I think this is a sufficiently unusual case that it's OK to accept false restores (and they get fixed on the next cycle of panel messages anyway).

David
dssinger
newt
newt
 
Posts: 8
Joined: Sat Aug 08, 2020 1:49 pm

Re: AlarmDecoder reports non-existent restore/fault events

Postby mathewss » Mon Sep 07, 2020 11:17 am

As I start porting this code to the new C++ api I will make a note to watch for this issue of intermixing RFX or EXP zones with actual alarm "FAULT XXX" message zones in the tracking code.

Best
SM
mathewss
Moderator
Moderator
 
Posts: 135
Joined: Fri Dec 06, 2013 11:14 am

Re: AlarmDecoder reports non-existent restore/fault events

Postby cw76 » Sat Nov 14, 2020 4:55 pm

Hello,

I'm also experiencing this problem. I've opened more than 8 windows and I keep getting notifications that the zones are faulting and restoring.

When I call the status API, I've noticed that it only reports 8 faulted zones and it somehow cycles the zones that it faults. Is this the source of the status issue? I.e., if a zone falls out of the currently-reported 8 zones, it thinks it is restored and then when it cycles back in, it registers as faulted?

Thanks!
cw76
newt
newt
 
Posts: 14
Joined: Thu Oct 29, 2015 2:32 pm

Re: AlarmDecoder reports non-existent restore/fault events

Postby mathewss » Sat Nov 14, 2020 5:34 pm

Send logs of panel messages via ser2sock or some other method. This will help find the issue in the zone tracker code.

Best
Sean M.
mathewss
Moderator
Moderator
 
Posts: 135
Joined: Fri Dec 06, 2013 11:14 am

Previous

Return to General

Who is online

Users browsing this forum: No registered users and 4 guests

cron