Lots of errors!

Posted on
Sun Sep 24, 2023 1:43 pm
mintzps offline
Posts: 26
Joined: Apr 13, 2010

Lots of errors!

I am glad to see the forum active again.

I run indigo on a Mac Mini running Big Sur. I have a Vista-40 Alarm. The interface is a networked AD2PI with a reserved IP address and port forwarding to 10000.

Everything was going fine until . . . .
I was using an old version of Indigo and the AD2USB plug-in and things were working ok.
Then I updated to Version 2022.2 of Indigo. This required that I upgrade the AD2USB plug-in. So I upgraded to version 3.4.0.
Nothing worked. I couldn't arm or disarm the alarm. My triggers based on the panel didn't work.
I realized the the states on the AD2USB Keypad were not changing. I figured that I might need a update on the firmware for the AD2USB.

I downloaded a fresh image of the Raspberry Pi operating system including the Web app.
I used the web app to update the firmware to V2.2a.8.8.

Now at least the keypad statuses were tracking.

Unfortunately, things are still hit or miss. If I restart the plug-in, things seem to work, but over time (hours) they stop working again.
I am getting all sorts of error messages in the log file.

I have attached today's event log. I have the logging for the plug-in set for Verbose Debugging. Unfortunately, the log file is 10MB and I can't add it as an attachment. How can it get it to you?

I would like to attach screenshots of my plug-in configuration windows, but they are too big too.

Can you help me figure out what to do?
Attachments
2023-09-24 Events.txt
(39.32 KiB) Downloaded 29 times

Posted on
Mon Sep 25, 2023 9:27 am
ab39870 offline
Posts: 40
Joined: Dec 09, 2015

Re: Lots of errors!

Based on just some of your event log entries below, the Plugin is having trouble reading your panel messages. The best path forward is to first look at the messages coming directly from your AlarmDecoder device. You need to enable "Log Panel Messages" in the "Configure" settings. This creates a separate log file - it's not the Indigo Event Log - where all the messages from your panel will be captured. Its grows fast but will be very insightful as to what is going on. The file will be named "panelMessages.log". If you have disk space you can leave it on since it only keeps the last 30 days.

After enabling "Log Panel Messages" restart the plugin and grab the first ~100-500 lines of panel messages after the restart. I don't recommend you post them here - use the forum's Private Message function instead to send them to me.

Code: Select all
2023-09-24 06:52:44.268   AD2USB Alarm Interface Error   Error reading from AlarmPanel:decoding bytes to string - error:'utf-8' codec can't decode byte 0x9f in position 3: invalid start byte
2023-09-24 10:56:06.865   AD2USB Alarm Interface Warning   Unknown message type:e0B57AF05  - skipping
2023-09-24 10:56:06.865   AD2USB Alarm Interface Warning   Unable to parse: - message:e0B57AF05
2

Posted on
Wed Sep 27, 2023 9:06 pm
mintzps offline
Posts: 26
Joined: Apr 13, 2010

Re: Lots of errors!

Help anyone!

I have a Vista-40 alarm panel.
I have a new AD2PI.
I am running Indigo 2022.1
The firmware of the AD2PI is V2.2a.8.8
I am using the AD2USB Plug-in version 3.4.0

I am getting the following errors about every 5 seconds:

AD2USB Alarm Interface Warning Invalid Numeric Code:216 found in KPM message:"****DISARMED**** READY TO ARM ".
AD2USB Alarm Interface Warning Invalid Numeric Code:116 found in KPM message:"****DISARMED**** READY TO ARM ".
AD2USB Alarm Interface Warning Invalid Numeric Code:116 found in KPM message:"****DISARMED**** READY TO ARM ".
AD2USB Alarm Interface Warning Invalid Numeric Code:216 found in KPM message:"****DISARMED**** READY TO ARM ".
AD2USB Alarm Interface Warning Invalid Numeric Code:216 found in KPM message:"****DISARMED**** READY TO ARM ".
AD2USB Alarm Interface Warning Invalid Numeric Code:216 found in KPM message:"****DISARMED**** READY TO ARM ".

Has anyone seen this before? Any help on fixing it?

Posted on
Thu Sep 28, 2023 7:04 am
ab39870 offline
Posts: 40
Joined: Dec 09, 2015

Re: Lots of errors!

After looking at the panelMessage logs provided (the messages coming from AlarmDecoder), the root cause is AlarmDecoder Keypad Messages containing invalid Numeric Codes, in this case 116 and 216.

I believe this is a Network, not USB, AlarmDecoder, so this could be happening in the AlarmDecoder or the ser2sock process that reads from the AlarmDecoder serial port messages and makes the messages available via the IP port. If this was the panel, then I'd expect weird messages on the actual physical keypads too. Regardless, it's odd behavior.

To reduce the noise of these warnings, make sure you enable AlarmDecoder Configure option "Remove duplicate messages (DEDUPLICATE)". That won't make the warnings go away, but may reduce the frequency.

Other than writing the WARNING message, the Plugin ignores these Keypad messages when it sees an invalid numeric code (> 99 or if it contains non-digits). Is the Plugin working otherwise? Are other Keypad Messages for other zones working properly? If so, I could make a patch release that gives users the options of disabling/silencing invalid Keypad Zone number messages. This would stop those WARNING messages and would be a relatively easy feature to add.

Posted on
Thu Sep 28, 2023 11:30 am
mintzps offline
Posts: 26
Joined: Apr 13, 2010

Re: Lots of errors!

I have enabled the DEDUPLICATE. I am not sure I have seen any errors that don't relate to 116 or 216. The patch would allow me to keep a better handle on plug-in problems.

Regarding plug-in functioning, sometimes , it does seem that arming and disarming actions don't work. This seems better with the new Raspberry Pi bundle.

I will continue to follow.

Posted on
Fri Sep 29, 2023 8:44 am
mintzps offline
Posts: 26
Joined: Apr 13, 2010

Re: Lots of errors!

Well I thought things were going well until tried to disarm the alarm this morning.

When I executed the action nothing happened.
I went to turn off DEDUPLICATE to try to see any errors. When I went to read the configuration I got a spinning wheel for a while and then a "Timeout" window.

I unchecked the box for DEDUPLCATE . Then, at 1025, my disarm action worked.

Here are lines from the plug-in log:

2023-09-29 03:47:26.046 WARNING 123145353113600 Plugin.__processMessage: Unknown message type:    - skipping
2023-09-29 03:47:26.046 WARNING 123145353113600 Plugin.panelMsgRead: Unable to parse: - message:   
2023-09-29 03:47:43.278 WARNING 123145353113600 Plugin.__processMessage: Unknown message type:  - skipping
2023-09-29 03:47:43.278 WARNING 123145353113600 Plugin.panelMsgRead: Unable to parse: - message: 
2023-09-29 03:48:31.210 WARNING 123145353113600 Plugin.__processMessage: Unknown message type:Ceae - skipping
2023-09-29 03:48:31.210 WARNING 123145353113600 Plugin.panelMsgRead: Unable to parse: - message:Ceae
2023-09-29 03:48:31.844 WARNING 123145353113600 Plugin.parseMessage_KPM: Invalid Numeric Code:257 found in KPM message:"ALL SECURE **/Y ** ALL S # ".
2023-09-29 03:48:33.099 WARNING 123145353113600 Plugin.parseMessage_KPM: Invalid Numeric Code:257 found in KPM message:"ALL SECURE **/Y ** ALL S # ".
2023-09-29 03:48:34.946 WARNING 123145353113600 Plugin.parseMessage_KPM: Invalid Numeric Code:116 found in KPM message:" AR # ARMED AW".
2023-09-29 03:48:35.454 WARNING 123145353113600 Plugin.parseMessage_KPM: Invalid Numeric Code:120 found in KPM message:" AR # ARMED AW".
2023-09-29 03:48:35.459 INFO 123145353113600 Plugin.panelMsgRead: Alarm tripped by zone:120
2023-09-29 03:48:36.097 WARNING 123145353113600 Plugin.parseMessage_KPM: Invalid Numeric Code:120 found in KPM message:" ARMED AWAY ** ALL SECURE **".
2023-09-29 03:48:36.103 INFO 123145353113600 Plugin.panelMsgRead: Alarm tripped by zone:120
2023-09-29 03:48:36.677 WARNING 123145353113600 Plugin.parseMessage_KPM: Invalid Numeric Code:116 found in KPM message:" ARMED AWAY ** ALL SECURE **".
2023-09-29 03:48:49.519 WARNING 123145353113600 Plugin.parseMessage_KPM: Invalid Numeric Code:116 found in KPM message:" ARMED AWAY ** ALL SECURE **".
2023-09-29 03:49:25.626 WARNING 123145353113600 Plugin.__processMessage: Unknown message type:B42Fe205  - skipping
2023-09-29 03:49:25.627 WARNING 123145353113600 Plugin.panelMsgRead: Unable to parse: - message:B42Fe205 
2023-09-29 03:49:26.236 WARNING 123145353113600 Plugin.parseMessage_KPM: Invalid Numeric Code:216 found in KPM message:" ARMED AWAY ** ALL SECURE **".
2023-09-29 03:49:26.809 WARNING 123145353113600 Plugin.parseMessage_KPM: Invalid Numeric Code:216 found in KPM message:" ARMED AWAY ** ALL SECURE **".
2023-09-29 03:49:27.420 WARNING 123145353113600 Plugin.parseMessage_KPM: Invalid Numeric Code:216 found in KPM message:" ARMED AWAY ** ALL SECURE **".
2023-09-29 09:44:32.858 INFO 4729142784 Plugin.panelMsgWrite: Panel message:CODE+1 sent to AlarmDecoder
2023-09-29 09:44:36.217 INFO 4729142784 Plugin.panelMsgWrite: Panel message:CODE+1 sent to AlarmDecoder
2023-09-29 09:44:39.289 INFO 4729142784 Plugin.panelMsgWrite: Panel message:#2 sent to AlarmDecoder
2023-09-29 09:44:42.332 INFO 4729142784 Plugin.panelMsgWrite: Panel message:CODE+1 sent to AlarmDecoder
2023-09-29 09:44:45.505 INFO 4729142784 Plugin.panelMsgWrite: Panel message:CODE+1 sent to AlarmDecoder
2023-09-29 09:44:50.653 WARNING 123145353113600 Plugin.__processMessage: Unknown message type:1286731128673112212867311286731 - skipping
2023-09-29 09:44:50.653 WARNING 123145353113600 Plugin.panelMsgRead: Unable to parse: - message:1286731128673112212867311286731
2023-09-29 10:24:18.479 WARNING 123145353113600 Plugin.__processMessage: Unknown message type:C - skipping
2023-09-29 10:24:18.479 WARNING 123145353113600 Plugin.panelMsgRead: Unable to parse: - message:C
2023-09-29 10:24:28.074 WARNING 123145353113600 Plugin.parseMessage_KPM: Invalid Numeric Code:257 found in KPM message:"ALL SECURE **/Y ** ALL S # ".
2023-09-29 10:24:29.387 WARNING 4729142784 Plugin.NewConfigButtonPressed: Unable to read the config from the AlarmDecoder or possible timeout while waiting. Try again.
2023-09-29 10:24:30.329 WARNING 123145353113600 Plugin.parseMessage_KPM: Invalid Numeric Code:116 found in KPM message:" AR # ARMED AW".
2023-09-29 10:24:31.587 WARNING 123145353113600 Plugin.parseMessage_KPM: Invalid Numeric Code:120 found in KPM message:" AR # ARMED AW".
2023-09-29 10:24:31.591 INFO 123145353113600 Plugin.panelMsgRead: Alarm tripped by zone:120
2023-09-29 10:24:33.442 WARNING 123145353113600 Plugin.parseMessage_KPM: Invalid Numeric Code:120 found in KPM message:" ARMED AWAY ** ALL SECURE **".
2023-09-29 10:24:33.446 INFO 123145353113600 Plugin.panelMsgRead: Alarm tripped by zone:120
2023-09-29 10:24:34.682 WARNING 123145353113600 Plugin.parseMessage_KPM: Invalid Numeric Code:116 found in KPM message:" ARMED AWAY ** ALL SECURE **".
2023-09-29 10:24:47.141 INFO 123145353113600 Plugin.processAlarmDecoderConfigMessage: AlarmDecoder CONFIG message read: MODE=A&CONFIGBITS=ff04&ADDRESS=10&LRR=N&COM=N&EXP=NNNNN&REL=NNNN&MASK=ffffffff&DEDUPLICATE=Y
2023-09-29 10:24:47.142 INFO 123145353113600 Plugin.processAlarmDecoderConfigMessage: AlarmDecoder CONFIG setting are now: ADDRESS=10&LRR=N&EXP=NNNNN&REL=NNNN&DEDUPLICATE=Y
2023-09-29 10:24:56.347 INFO 4729142784 Plugin.updateAlarmDecoderConfig: AlarmDecoder CONFIG message:CADDRESS=10&LRR=N&EXP=NNNNN&REL=NNNN&DEDUPLICATE=N
has been sent. Check the Event Log to verify it was successful.
2023-09-29 10:24:56.347 INFO 4729142784 Plugin.updateAlarmDecoderConfig: Plugin preferences have been updated
2023-09-29 10:24:57.322 INFO 123145353113600 Plugin.processAlarmDecoderConfigMessage: AlarmDecoder CONFIG message read: MODE=A&CONFIGBITS=ff04&ADDRESS=10&LRR=N&COM=N&EXP=NNNNN&REL=NNNN&MASK=ffffffff&DEDUPLICATE=N
2023-09-29 10:24:57.322 INFO 123145353113600 Plugin.processAlarmDecoderConfigMessage: AlarmDecoder CONFIG setting are now: ADDRESS=10&LRR=N&EXP=NNNNN&REL=NNNN&DEDUPLICATE=N
2023-09-29 10:25:27.594 WARNING 123145353113600 Plugin.parseMessage_KPM: Invalid Numeric Code:216 found in KPM message:" ARMED AWAY ** ALL SECURE **".
2023-09-29 10:25:32.771 WARNING 123145353113600 Plugin.parseMessage_KPM: Invalid Numeric Code:216 found in KPM message:" ARMED AWAY ** ALL SECURE **".
2023-09-29 10:25:37.952 WARNING 123145353113600 Plugin.parseMessage_KPM: Invalid Numeric Code:216 found in KPM message:" ARMED AWAY ** ALL SECURE **".
2023-09-29 10:25:41.548 INFO 4729142784 Plugin.panelMsgWrite: Panel message:CODE+1 sent to AlarmDecoder

Here are event log lines:

Sep 29, 2023 at 9:44:31 AM
Web Server Indigo Touch client connected from 73.230.130.7
Action Group Disarm alarm
Action Group Disarm alarm
Action Group Arm alarm away
Action Group Disarm alarm
Action Group Disarm alarm

Sep 29, 2023 at 9:58:01 AM
Indigo Cocoa client disconnected (73.230.130.7)

Sep 29, 2023 at 10:23:32 AM
Indigo Cocoa client authenticated (73.230.130.7)

Sep 29, 2023 at 10:24:28 AM
Trigger Alarm is disarmed
Email+ sending email 'Wyo Alarm is disarmed' to '6102238287@vtext.com' using Email+ SMTP Server
Error (client) timeout waiting for plugin response from com.berkinet.ad2usb for request UiAction
Trigger alarm is armed
Email+ sending email 'Wyo alarm is armed' to '6102238287@vtext.com' using Email+ SMTP Server

Sep 29, 2023 at 10:25:41 AM
Action Group Disarm alarm
Z-Wave received "018 - Alarm Off is disarmed" status update is off
Trigger Alarm is disarmed
Email+ sending email 'Wyo Alarm is disarmed' to '6102238287@vtext.com' using Email+ SMTP Server



Here are panel message log ines:

2023-09-29 03:49:26.236 | [01010001000000003A--],216,[f723d4001016800c0c020000020000]," ARMED AWAY ** ALL SECURE **"
2023-09-29 03:49:26.809 | [01010001000000003A--],216,[f723d4001016800c0c020000020000]," ARMED AWAY ** ALL SECURE **"
2023-09-29 03:49:27.420 | [01010001000000003A--],216,[f723d4001016800c0c020000020000]," ARMED AWAY ** ALL SECURE **"
2023-09-29 03:49:33.131 | !>E9
2023-09-29 09:44:50.653 | 1286731128673112212867311286731
2023-09-29 10:24:18.479 | C
2023-09-29 10:24:27.439 | !Sending.....done
2023-09-29 10:24:28.073 | [10000100100100002A--],257,[4d45442041574159202a2a20020000],"ALL SECURE **/Y ** ALL S # "
2023-09-29 10:24:28.664 | !RFX:0713735,84
2023-09-29 10:24:29.169 | [10000100100100002A--],057,[4d45442041574159202a2a20000000],"ALL SECURE **/Y ** ALL SECURE **"
2023-09-29 10:24:29.676 | !RFX:0939584,84
2023-09-29 10:24:30.329 | [01000001000000003A--],116,[f723d4001016800c0c02000059202a]," AR # ARMED AW"
2023-09-29 10:24:30.945 | !RFX:0060681,04
2023-09-29 10:24:31.587 | [01000201111001102A--],120,[4543555245202a2a2f02000059202a]," AR # ARMED AW"
2023-09-29 10:24:32.234 | !RFX:0311880,04
2023-09-29 10:24:32.853 | !RFX:0494047,84
2023-09-29 10:24:33.442 | [01000201111001102A--],120,[4543555245202a2a2f02000059202a]," ARMED AWAY ** ALL SECURE **"
2023-09-29 10:24:34.072 | !RFX:0477773,84
2023-09-29 10:24:34.682 | [01000001000000003A--],116,[f723d4001016800c0c02000059202a]," ARMED AWAY ** ALL SECURE **"
2023-09-29 10:24:35.317 | !RFX:0982134,04
2023-09-29 10:24:35.821 | !RFX:0068856,84
2023-09-29 10:24:36.472 | !RFX:0068856,84
2023-09-29 10:24:37.110 | !RFX:0278459,84
2023-09-29 10:24:37.673 | !RFX:0674564,04
2023-09-29 10:24:38.283 | !RFX:0083310,84
2023-09-29 10:24:38.858 | !RFX:0349290,84
2023-09-29 10:24:39.395 | !RFX:0298716,04
2023-09-29 10:24:39.993 | !RFX:0331768,04
2023-09-29 10:24:40.570 | !RFX:0768950,80
2023-09-29 10:24:41.201 | !RFX:0768950,00
2023-09-29 10:24:41.823 | !RFX:0484893,80
2023-09-29 10:24:42.448 | !RFX:0006849,80
2023-09-29 10:24:43.072 | !RFX:0484893,00
2023-09-29 10:24:43.718 | !RFX:0006849,00
2023-09-29 10:24:44.331 | !RFX:0398053,84
2023-09-29 10:24:44.975 | !RFX:0513604,a4
2023-09-29 10:24:45.482 | !RFX:0071096,80
2023-09-29 10:24:45.989 | !RFX:0071096,00
2023-09-29 10:24:46.635 | !>
2023-09-29 10:24:47.140 | !CONFIG>MODE=A&CONFIGBITS=ff04&ADDRESS=10&LRR=N&COM=N&EXP=NNNNN&REL=NNNN&MASK=ffffffff&DEDUPLICATE=Y
2023-09-29 10:24:47.677 | !Reading configuration.
2023-09-29 10:24:48.312 | !UART init.
2023-09-29 10:24:48.902 | [01000001000000003A--],016,[f723d4001016800c0c020000000000]," ARMED AWAY ** ALL SECURE **"
2023-09-29 10:24:49.412 | !RFX:0938312,80
2023-09-29 10:24:49.982 | !RFX:0938312,00
2023-09-29 10:24:50.595 | !RFX:0213849,04
2023-09-29 10:24:56.749 | !>ADDRESS=10&LRR=N&EXP=NNNNN&REL=NNNN&DEDUPLICATE=N
2023-09-29 10:24:57.321 | !CONFIG>MODE=A&CONFIGBITS=ff04&ADDRESS=10&LRR=N&COM=N&EXP=NNNNN&REL=NNNN&MASK=ffffffff&DEDUPLICATE=N
2023-09-29 10:24:57.971 | !Reading configuration.
2023-09-29 10:24:58.607 | !UART init.
2023-09-29 10:25:01.525 | [01000001000000003A--],016,[f723d4001016800c0c020000000000]," ARMED AWAY ** ALL SECURE **"
2023-09-29 10:25:06.724 | [01000001000000003A--],016,[f723d4001016800c0c020000000000]," ARMED AWAY ** ALL SECURE **"
2023-09-29 10:25:11.979 | [01000001000000003A--],016,[f723d4001016800c0c020000000000]," ARMED AWAY ** ALL SECURE **"
2023-09-29 10:25:17.167 | [01000001000000003A--],016,[f723d4001016800c0c020000000000]," ARMED AWAY ** ALL SECURE **"
2023-09-29 10:25:22.417 | [01000001000000003A--],016,[f723d4001016800c0c020000000000]," ARMED AWAY ** ALL SECURE **"
2023-09-29 10:25:27.594 | [01000001000000003A--],216,[f723d4001016800c0c020000020000]," ARMED AWAY ** ALL SECURE **"
2023-09-29 10:25:32.771 | [01000001000000003A--],216,[f723d4001016800c0c020000020000]," ARMED AWAY ** ALL SECURE **"
2023-09-29 10:25:37.952 | [01000001000000003A--],216,[f723d4001016800c0c020000020000]," ARMED AWAY ** ALL SECURE **"
2023-09-29 10:25:41.996 | !Sending.done
2023-09-29 10:25:42.642 | [10010101000000003A--],216,[f723d4001016011c08020000020000],"****DISARMED**** READY TO ARM "
2023-0

Page 1 of 1

Who is online

Users browsing this forum: No registered users and 1 guest