Alarm immediately starts arming after disarming

[ondrejmirtes]

Hi, sometimes, infrequently, the alarm starts arming after pressing the Disarm button again.

Here's the log (I added my own "pressing keys" log call, to make sure the master code isn't sent multiple times to the alarm panel, which would explain the behaviour. It is not):

2024-11-29 07:30:51.163 WARNING (MainThread) [custom_components.jablotron80] Pressing keys: xxxx
2024-11-29 07:30:51.462 INFO (MainThread) [custom_components.jablotron80] Keypad Beep: 0xa0, 1 subtle (short) beep triggered
2024-11-29 07:30:51.624 INFO (MainThread) [custom_components.jablotron80] JablotronStatusText(3): message changed from  to Complete entry
2024-11-29 07:30:51.625 INFO (MainThread) [custom_components.jablotron80] Keypad Beep: 0xa0, 1 subtle (short) beep triggered
2024-11-29 07:30:51.665 WARNING (MainThread) [custom_components.jablotron80] Invalid CRC for ed 43 44 00 3f 04 00 6d ff
2024-11-29 07:30:54.024 INFO (ThreadPoolExecutor-1_0) [custom_components.jablotron80] no accepted message for sequence:2 received
2024-11-29 07:30:54.105 INFO (MainThread) [custom_components.jablotron80] Keypad Beep: 0xa0, 1 subtle (short) beep triggered
2024-11-29 07:30:54.252 INFO (MainThread) [custom_components.jablotron80] Keypad Beep: 0xa3, 3 loud (long) beeps triggered
2024-11-29 07:30:54.312 INFO (MainThread) [custom_components.jablotron80] Keypad Beep: 0xb7, no audible beep(1)
2024-11-29 07:30:54.353 INFO (MainThread) [custom_components.jablotron80] JablotronLed(1): active changed from True to False
2024-11-29 07:30:54.354 INFO (MainThread) [custom_components.jablotron80] JablotronLed(2): active changed from True to False
2024-11-29 07:30:54.356 INFO (MainThread) [custom_components.jablotron80] JablotronLed(3): active changed from True to False
2024-11-29 07:30:54.360 INFO (MainThread) [custom_components.jablotron80] JablotronZone(1): status changed from Armed to Disarmed
2024-11-29 07:30:54.361 INFO (MainThread) [custom_components.jablotron80] Zone A status changed from Armed to Disarmed
2024-11-29 07:30:54.363 INFO (MainThread) [custom_components.jablotron80] JablotronZone(2): status changed from Armed to Disarmed
2024-11-29 07:30:54.366 INFO (MainThread) [custom_components.jablotron80] Zone B status changed from Armed to Disarmed
2024-11-29 07:30:54.367 INFO (MainThread) [custom_components.jablotron80] JablotronZone(3): status changed from Armed to Disarmed
2024-11-29 07:30:54.368 INFO (MainThread) [custom_components.jablotron80] Zone C status changed from Armed to Disarmed
2024-11-29 07:30:54.371 INFO (MainThread) [custom_components.jablotron80] JablotronStatusText(3): message changed from Complete entry to 
2024-11-29 07:30:54.473 INFO (MainThread) [custom_components.jablotron80] JablotronControlPanel(0): last_event changed from Setting, 64:Master, 17:40 Sun 23 Jun to Unsetting, 64:Master, 17:43 Sun 23 Jun
2024-11-29 07:30:55.062 INFO (ThreadPoolExecutor-1_0) [custom_components.jablotron80] no accepted message for sequence:1 received
2024-11-29 07:30:55.132 INFO (MainThread) [custom_components.jablotron80] Keypad Beep: 0xa0, 1 subtle (short) beep triggered
2024-11-29 07:30:55.194 INFO (MainThread) [custom_components.jablotron80] Keypad Beep: 0xa0, 1 subtle (short) beep triggered
2024-11-29 07:30:55.313 INFO (MainThread) [custom_components.jablotron80] JablotronStatusText(3): message changed from  to Complete entry
2024-11-29 07:30:55.314 INFO (MainThread) [custom_components.jablotron80] Keypad Beep: 0xa0, 1 subtle (short) beep triggered
2024-11-29 07:30:55.473 INFO (MainThread) [custom_components.jablotron80] Keypad Beep: 0xa1, 1 loud (long) beep triggered
2024-11-29 07:30:55.582 INFO (MainThread) [custom_components.jablotron80] JablotronCode(0): active changed from False to True
2024-11-29 07:30:55.584 INFO (MainThread) [custom_components.jablotron80] JablotronCode(0): active changed from True to False
2024-11-29 07:30:55.586 INFO (MainThread) [custom_components.jablotron80] JablotronZone(1): status changed from Disarmed to Arming
2024-11-29 07:30:55.587 INFO (MainThread) [custom_components.jablotron80] Zone A status changed from Disarmed to Arming
2024-11-29 07:30:55.587 INFO (MainThread) [custom_components.jablotron80] JablotronZone(2): status changed from Disarmed to Arming
2024-11-29 07:30:55.588 INFO (MainThread) [custom_components.jablotron80] Zone B status changed from Disarmed to Arming
2024-11-29 07:30:55.590 INFO (MainThread) [custom_components.jablotron80] JablotronZone(3): status changed from Disarmed to Arming
2024-11-29 07:30:55.591 INFO (MainThread) [custom_components.jablotron80] Zone C status changed from Disarmed to Arming
2024-11-29 07:30:55.592 INFO (MainThread) [custom_components.jablotron80] JablotronControlPanel(0): last_event changed from Unsetting, 64:Master, 17:43 Sun 23 Jun to Setting, 64:Master, 17:43 Sun 23 Jun
2024-11-29 07:30:55.815 INFO (MainThread) [custom_components.jablotron80] JablotronLed(1): active changed from False to True
2024-11-29 07:30:55.816 INFO (MainThread) [custom_components.jablotron80] JablotronLed(2): active changed from False to True
2024-11-29 07:30:55.818 INFO (MainThread) [custom_components.jablotron80] JablotronLed(3): active changed from False to True
2024-11-29 07:30:55.820 INFO (MainThread) [custom_components.jablotron80] JablotronStatusText(3): message changed from Complete entry to Exit delay
2024-11-29 07:30:55.885 WARNING (ThreadPoolExecutor-1_0) [custom_components.jablotron80] no accepted message for sequence:3 received
2024-11-29 07:30:55.890 INFO (MainThread) [custom_components.jablotron80] Keypad Beep: 0xb7, no audible beep(1)
2024-11-29 07:30:56.761 WARNING (MainThread) [homeassistant.bootstrap] Waiting on integrations to complete setup: {('zha', '4d7fdd1059154af5bc6146aebc3d6863'): 3772836.324226828}
2024-11-29 07:31:05.130 WARNING (MainThread) [custom_components.jablotron80] Pressing keys: xxxx
2024-11-29 07:31:05.308 INFO (MainThread) [custom_components.jablotron80] Keypad Beep: 0xa0, 1 subtle (short) beep triggered
2024-11-29 07:31:05.494 INFO (MainThread) [custom_components.jablotron80] JablotronStatusText(3): message changed from Exit delay to Exit delay, Complete entry
2024-11-29 07:31:05.498 INFO (MainThread) [custom_components.jablotron80] Keypad Beep: 0xa0, 1 subtle (short) beep triggered
2024-11-29 07:31:05.643 INFO (MainThread) [custom_components.jablotron80] Keypad Beep: 0xa0, 1 subtle (short) beep triggered
2024-11-29 07:31:05.793 INFO (MainThread) [custom_components.jablotron80] Keypad Beep: 0xa3, 3 loud (long) beeps triggered
2024-11-29 07:31:05.873 INFO (MainThread) [custom_components.jablotron80] JablotronLed(1): active changed from True to False
2024-11-29 07:31:05.874 INFO (MainThread) [custom_components.jablotron80] JablotronLed(2): active changed from True to False
2024-11-29 07:31:05.876 INFO (MainThread) [custom_components.jablotron80] JablotronLed(3): active changed from True to False
2024-11-29 07:31:05.877 INFO (MainThread) [custom_components.jablotron80] JablotronZone(1): status changed from Arming to Disarmed
2024-11-29 07:31:05.878 INFO (MainThread) [custom_components.jablotron80] Zone A status changed from Arming to Disarmed
2024-11-29 07:31:05.879 INFO (MainThread) [custom_components.jablotron80] JablotronZone(2): status changed from Arming to Disarmed
2024-11-29 07:31:05.881 INFO (MainThread) [custom_components.jablotron80] Zone B status changed from Arming to Disarmed
2024-11-29 07:31:05.882 INFO (MainThread) [custom_components.jablotron80] JablotronZone(3): status changed from Arming to Disarmed
2024-11-29 07:31:05.883 INFO (MainThread) [custom_components.jablotron80] Zone C status changed from Arming to Disarmed
2024-11-29 07:31:05.885 INFO (MainThread) [custom_components.jablotron80] JablotronStatusText(3): message changed from Exit delay, Complete entry to 

The highlights:

2024-11-29 07:30:54.360 INFO (MainThread) [custom_components.jablotron80] JablotronZone(1): status changed from Armed to Disarmed
2024-11-29 07:30:55.586 INFO (MainThread) [custom_components.jablotron80] JablotronZone(1): status changed from Disarmed to Arming
2024-11-29 07:31:05.877 INFO (MainThread) [custom_components.jablotron80] JablotronZone(1): status changed from Arming to Disarmed

The 2024-11-29 07:30:55.586 happened by itself, the 2024-11-29 07:31:05.877 happened by me pressing "Disarm" again.

Here's how it looks in the logbook:

The "changed to Arming triggered by action Alarm Control Panel: Disarm " is what doesn't make sense, right.

Any idea what I could do to do about it / debug it? Thank you.

[ondrejmirtes]

For successful disarming I just need to press "Disarm" again after the alarm is in "Arming" state and hope it's going to be successful this time. Sometimes it takes several attempts.