Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

Starting the arm countdown and then immediately disarming doesn't work. #140

Open
andredigenova opened this issue Sep 13, 2024 · 3 comments
Open

Starting the arm countdown and then immediately disarming doesn't work. #140

andredigenova opened this issue Sep 13, 2024 · 3 comments

Comments

@andredigenova
Copy link

andredigenova commented Sep 13, 2024 •
edited
Loading

I am using an UNO and when I "ARM HOME" the system and immediately hit "DISARM" to cancel, it doesn't seem to succeed.

I can hear my old DSC keypad doing the countdown and when I try to disarm, the keypad makes a long beep but keeps counting down.

Eventually if I wait 10 seconds or so, the DISARM button starts working and disarms.

Debug log of me starting the arm and then spamming disarm until it finally works and disarms.

2024-09-13 15:57:51.559 WARNING (SyncWorker_0) [homeassistant.loader] We found a custom integration hacs which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant
2024-09-13 15:57:51.559 WARNING (SyncWorker_0) [homeassistant.loader] We found a custom integration envisalink_new which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant
2024-09-13 16:37:04.222 WARNING (MainThread) [homeassistant.helpers.service] Referenced entities alarm_control_panel.home_alarm are missing or not currently available
2024-09-13 16:37:10.222 WARNING (MainThread) [homeassistant.helpers.service] Referenced entities alarm_control_panel.home_alarm are missing or not currently available
2024-09-13 16:37:14.017 WARNING (MainThread) [homeassistant.helpers.service] Referenced entities alarm_control_panel.home_alarm are missing or not currently available
2024-09-13 16:39:36.824 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Waiting for data from EVL
2024-09-13 16:39:39.100 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Queueing command '03' data: '1,*' ; calling_task=Task-2721
2024-09-13 16:39:39.100 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Queueing command '03' data: '1,*' ; calling_task=Task-2721
2024-09-13 16:39:39.100 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Queueing command '03' data: '1,*' ; calling_task=Task-2721
2024-09-13 16:39:39.100 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Queueing command '03' data: '1,*' ; calling_task=Task-2721
2024-09-13 16:39:39.100 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Queueing command '03' data: '1,3' ; calling_task=Task-2721
2024-09-13 16:39:39.100 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Command processor woke up.
2024-09-13 16:39:39.100 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=5
2024-09-13 16:39:39.100 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] TX > b'1,*'
2024-09-13 16:39:39.101 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=5
2024-09-13 16:39:39.103 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] {---------------------------------------
2024-09-13 16:39:39.103 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] RX < ^03,00$

2024-09-13 16:39:39.103 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Data received:^03,00$
2024-09-13 16:39:39.103 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Code:^03 Data:00
2024-09-13 16:39:39.103 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] calling handler: handle_command_response for code: ^03 with data: 00
2024-09-13 16:39:39.103 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Envisalink response: Command Accepted
2024-09-13 16:39:39.103 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Invoking state change callbacks
2024-09-13 16:39:39.103 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] }---------------------------------------
2024-09-13 16:39:39.104 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Waiting for data from EVL
2024-09-13 16:39:39.104 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Command processor woke up.
2024-09-13 16:39:39.104 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=5
2024-09-13 16:39:39.104 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=4
2024-09-13 16:39:39.104 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] TX > b'1,*'
2024-09-13 16:39:39.104 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=4
2024-09-13 16:39:39.106 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] {---------------------------------------
2024-09-13 16:39:39.106 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] RX < ^03,00$

2024-09-13 16:39:39.106 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Data received:^03,00$
2024-09-13 16:39:39.106 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Code:^03 Data:00
2024-09-13 16:39:39.106 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] calling handler: handle_command_response for code: ^03 with data: 00
2024-09-13 16:39:39.106 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Envisalink response: Command Accepted
2024-09-13 16:39:39.106 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Invoking state change callbacks
2024-09-13 16:39:39.106 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] }---------------------------------------
2024-09-13 16:39:39.106 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Waiting for data from EVL
2024-09-13 16:39:39.106 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Command processor woke up.
2024-09-13 16:39:39.106 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=4
2024-09-13 16:39:39.106 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=3
2024-09-13 16:39:39.106 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] TX > b'1,*'
2024-09-13 16:39:39.106 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=3
2024-09-13 16:39:39.108 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] {---------------------------------------
2024-09-13 16:39:39.108 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] RX < ^03,00$

2024-09-13 16:39:39.108 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Data received:^03,00$
2024-09-13 16:39:39.108 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Code:^03 Data:00
2024-09-13 16:39:39.108 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] calling handler: handle_command_response for code: ^03 with data: 00
2024-09-13 16:39:39.108 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Envisalink response: Command Accepted
2024-09-13 16:39:39.108 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Invoking state change callbacks
2024-09-13 16:39:39.108 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] }---------------------------------------
2024-09-13 16:39:39.108 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Waiting for data from EVL
2024-09-13 16:39:39.108 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Command processor woke up.
2024-09-13 16:39:39.108 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=3
2024-09-13 16:39:39.108 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=2
2024-09-13 16:39:39.108 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] TX > b'1,*'
2024-09-13 16:39:39.108 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=2
2024-09-13 16:39:39.110 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] {---------------------------------------
2024-09-13 16:39:39.110 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] RX < ^03,00$

2024-09-13 16:39:39.110 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Data received:^03,00$
2024-09-13 16:39:39.110 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Code:^03 Data:00
2024-09-13 16:39:39.110 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] calling handler: handle_command_response for code: ^03 with data: 00
2024-09-13 16:39:39.110 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Envisalink response: Command Accepted
2024-09-13 16:39:39.110 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Invoking state change callbacks
2024-09-13 16:39:39.110 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] }---------------------------------------
2024-09-13 16:39:39.110 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Waiting for data from EVL
2024-09-13 16:39:39.110 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Command processor woke up.
2024-09-13 16:39:39.110 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=2
2024-09-13 16:39:39.110 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=1
2024-09-13 16:39:39.110 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] TX > b'1,3'
2024-09-13 16:39:39.111 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=1
2024-09-13 16:39:39.115 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] {---------------------------------------
2024-09-13 16:39:39.115 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] RX < %02,0700000000000000$

2024-09-13 16:39:39.115 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Data received:%02,0700000000000000$
2024-09-13 16:39:39.115 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Code:%02 Data:0700000000000000
2024-09-13 16:39:39.115 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] calling handler: handle_partition_state_change for code: %02 with data: 0700000000000000
2024-09-13 16:39:39.115 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.uno_client] Partition 1 is in state EXIT_ENTRY_DELAY
2024-09-13 16:39:39.115 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.uno_client] {"partition_state": "N/A", "alpha": "Entry/Exit Delay", "ac_present": true, "beep": false, "armed_bypass": false, "entry_delay": false, "exit_delay": true, "last_armed_by_user": "", "last_disarmed_by_user": "", "ready": true, "bat_trouble": false, "trouble": false, "fire": false, "panic": false, "alarm": false, "alarm_fire_zone": false, "alarm_in_memory": false, "armed_away": false, "armed_stay": false, "armed_zero_entry_delay": false, "armed": false}
2024-09-13 16:39:39.115 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Invoking state change callbacks
2024-09-13 16:39:39.115 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Triggering state change callback for partition: [1]
2024-09-13 16:39:39.115 DEBUG (MainThread) [custom_components.envisalink_new] The envisalink 'Alarm' sent a partition update event: [1]
2024-09-13 16:39:39.115 DEBUG (MainThread) [custom_components.envisalink_new] state_updated for 'Partition 1'
2024-09-13 16:39:39.115 DEBUG (MainThread) [custom_components.envisalink_new] state_updated for 'Partition 1 Keypad'
2024-09-13 16:39:39.115 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] }---------------------------------------
2024-09-13 16:39:39.115 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Waiting for data from EVL
2024-09-13 16:39:39.157 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] {---------------------------------------
2024-09-13 16:39:39.157 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] RX < ^03,00$

2024-09-13 16:39:39.157 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Data received:^03,00$
2024-09-13 16:39:39.157 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Code:^03 Data:00
2024-09-13 16:39:39.157 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] calling handler: handle_command_response for code: ^03 with data: 00
2024-09-13 16:39:39.157 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Envisalink response: Command Accepted
2024-09-13 16:39:39.157 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Invoking state change callbacks
2024-09-13 16:39:39.157 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] }---------------------------------------
2024-09-13 16:39:39.157 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Waiting for data from EVL
2024-09-13 16:39:39.157 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Command processor woke up.
2024-09-13 16:39:39.157 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=1
2024-09-13 16:39:40.521 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Queueing command '03' data: '1,*' ; calling_task=Task-2722
2024-09-13 16:39:40.521 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Queueing command '03' data: '1,*' ; calling_task=Task-2722
2024-09-13 16:39:40.521 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Queueing command '03' data: '1,*' ; calling_task=Task-2722
2024-09-13 16:39:40.521 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Queueing command '03' data: '1,*' ; calling_task=Task-2722
2024-09-13 16:39:40.521 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Queueing command '03' data: '1,1' ; calling_task=Task-2722
2024-09-13 16:39:40.521 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Command processor woke up.
2024-09-13 16:39:40.521 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=5
2024-09-13 16:39:40.521 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] TX > b'1,*'
2024-09-13 16:39:40.521 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=5
2024-09-13 16:39:40.523 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] {---------------------------------------
2024-09-13 16:39:40.523 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] RX < ^03,00$

2024-09-13 16:39:40.523 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Data received:^03,00$
2024-09-13 16:39:40.523 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Code:^03 Data:00
2024-09-13 16:39:40.523 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] calling handler: handle_command_response for code: ^03 with data: 00
2024-09-13 16:39:40.523 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Envisalink response: Command Accepted
2024-09-13 16:39:40.523 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Invoking state change callbacks
2024-09-13 16:39:40.523 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] }---------------------------------------
2024-09-13 16:39:40.523 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Waiting for data from EVL
2024-09-13 16:39:40.523 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Command processor woke up.
2024-09-13 16:39:40.523 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=5
2024-09-13 16:39:40.523 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=4
2024-09-13 16:39:40.523 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] TX > b'1,*'
2024-09-13 16:39:40.523 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=4
2024-09-13 16:39:40.525 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] {---------------------------------------
2024-09-13 16:39:40.525 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] RX < ^03,00$

2024-09-13 16:39:40.525 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Data received:^03,00$
2024-09-13 16:39:40.525 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Code:^03 Data:00
2024-09-13 16:39:40.525 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] calling handler: handle_command_response for code: ^03 with data: 00
2024-09-13 16:39:40.525 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Envisalink response: Command Accepted
2024-09-13 16:39:40.525 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Invoking state change callbacks
2024-09-13 16:39:40.525 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] }---------------------------------------
2024-09-13 16:39:40.525 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Waiting for data from EVL
2024-09-13 16:39:40.526 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Command processor woke up.
2024-09-13 16:39:40.526 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=4
2024-09-13 16:39:40.526 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=3
2024-09-13 16:39:40.526 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] TX > b'1,*'
2024-09-13 16:39:40.526 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=3
2024-09-13 16:39:40.528 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] {---------------------------------------
2024-09-13 16:39:40.528 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] RX < ^03,00$

2024-09-13 16:39:40.528 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Data received:^03,00$
2024-09-13 16:39:40.528 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Code:^03 Data:00
2024-09-13 16:39:40.528 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] calling handler: handle_command_response for code: ^03 with data: 00
2024-09-13 16:39:40.528 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Envisalink response: Command Accepted
2024-09-13 16:39:40.528 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Invoking state change callbacks
2024-09-13 16:39:40.528 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] }---------------------------------------
2024-09-13 16:39:40.528 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Waiting for data from EVL
2024-09-13 16:39:40.528 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Command processor woke up.
2024-09-13 16:39:40.528 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=3
2024-09-13 16:39:40.528 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=2
2024-09-13 16:39:40.528 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] TX > b'1,*'
2024-09-13 16:39:40.528 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=2
2024-09-13 16:39:40.532 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] {---------------------------------------
2024-09-13 16:39:40.532 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] RX < ^03,00$

2024-09-13 16:39:40.532 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Data received:^03,00$
2024-09-13 16:39:40.532 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Code:^03 Data:00
2024-09-13 16:39:40.532 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] calling handler: handle_command_response for code: ^03 with data: 00
2024-09-13 16:39:40.532 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Envisalink response: Command Accepted
2024-09-13 16:39:40.532 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Invoking state change callbacks
2024-09-13 16:39:40.532 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] }---------------------------------------
2024-09-13 16:39:40.532 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Waiting for data from EVL
2024-09-13 16:39:40.532 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Command processor woke up.
2024-09-13 16:39:40.532 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=2
2024-09-13 16:39:40.532 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=1
2024-09-13 16:39:40.533 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] TX > b'1,1'
2024-09-13 16:39:40.533 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=1
2024-09-13 16:39:40.535 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] {---------------------------------------
2024-09-13 16:39:40.535 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] RX < ^03,00$

2024-09-13 16:39:40.535 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Data received:^03,00$
2024-09-13 16:39:40.535 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Code:^03 Data:00
2024-09-13 16:39:40.535 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] calling handler: handle_command_response for code: ^03 with data: 00
2024-09-13 16:39:40.535 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Envisalink response: Command Accepted
2024-09-13 16:39:40.535 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Invoking state change callbacks
2024-09-13 16:39:40.535 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] }---------------------------------------
2024-09-13 16:39:40.535 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Waiting for data from EVL
2024-09-13 16:39:40.535 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Command processor woke up.
2024-09-13 16:39:40.535 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=1
2024-09-13 16:39:42.581 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Queueing command '03' data: '1,*' ; calling_task=Task-2723
2024-09-13 16:39:42.581 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Queueing command '03' data: '1,*' ; calling_task=Task-2723
2024-09-13 16:39:42.581 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Queueing command '03' data: '1,*' ; calling_task=Task-2723
2024-09-13 16:39:42.581 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Queueing command '03' data: '1,*' ; calling_task=Task-2723
2024-09-13 16:39:42.581 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Queueing command '03' data: '1,1' ; calling_task=Task-2723
2024-09-13 16:39:42.581 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Command processor woke up.
2024-09-13 16:39:42.581 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=5
2024-09-13 16:39:42.581 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] TX > b'1,*'
2024-09-13 16:39:42.581 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=5
2024-09-13 16:39:42.583 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] {---------------------------------------
2024-09-13 16:39:42.583 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] RX < ^03,00$

2024-09-13 16:39:42.583 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Data received:^03,00$
2024-09-13 16:39:42.583 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Code:^03 Data:00
2024-09-13 16:39:42.583 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] calling handler: handle_command_response for code: ^03 with data: 00
2024-09-13 16:39:42.583 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Envisalink response: Command Accepted
2024-09-13 16:39:42.583 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Invoking state change callbacks
2024-09-13 16:39:42.583 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] }---------------------------------------
2024-09-13 16:39:42.583 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Waiting for data from EVL
2024-09-13 16:39:42.583 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Command processor woke up.
2024-09-13 16:39:42.583 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=5
2024-09-13 16:39:42.583 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=4
2024-09-13 16:39:42.583 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] TX > b'1,*'
2024-09-13 16:39:42.583 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=4
2024-09-13 16:39:42.586 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] {---------------------------------------
2024-09-13 16:39:42.586 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] RX < ^03,00$

2024-09-13 16:39:42.586 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Data received:^03,00$
2024-09-13 16:39:42.586 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Code:^03 Data:00
2024-09-13 16:39:42.586 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] calling handler: handle_command_response for code: ^03 with data: 00
2024-09-13 16:39:42.586 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Envisalink response: Command Accepted
2024-09-13 16:39:42.586 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Invoking state change callbacks
2024-09-13 16:39:42.586 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] }---------------------------------------
2024-09-13 16:39:42.586 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Waiting for data from EVL
2024-09-13 16:39:42.586 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Command processor woke up.
2024-09-13 16:39:42.586 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=4
2024-09-13 16:39:42.586 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=3
2024-09-13 16:39:42.586 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] TX > b'1,*'
2024-09-13 16:39:42.586 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=3
2024-09-13 16:39:42.590 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] {---------------------------------------
2024-09-13 16:39:42.590 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] RX < ^03,00$

2024-09-13 16:39:42.590 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Data received:^03,00$
2024-09-13 16:39:42.590 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Code:^03 Data:00
2024-09-13 16:39:42.590 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] calling handler: handle_command_response for code: ^03 with data: 00
2024-09-13 16:39:42.590 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Envisalink response: Command Accepted
2024-09-13 16:39:42.590 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Invoking state change callbacks
2024-09-13 16:39:42.590 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] }---------------------------------------
2024-09-13 16:39:42.590 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Waiting for data from EVL
2024-09-13 16:39:42.590 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Command processor woke up.
2024-09-13 16:39:42.590 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=3
2024-09-13 16:39:42.590 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=2
2024-09-13 16:39:42.590 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] TX > b'1,*'
2024-09-13 16:39:42.590 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=2
2024-09-13 16:39:42.592 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] {---------------------------------------
2024-09-13 16:39:42.592 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] RX < ^03,00$

2024-09-13 16:39:42.592 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Data received:^03,00$
2024-09-13 16:39:42.592 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Code:^03 Data:00
2024-09-13 16:39:42.592 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] calling handler: handle_command_response for code: ^03 with data: 00
2024-09-13 16:39:42.592 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Envisalink response: Command Accepted
2024-09-13 16:39:42.592 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Invoking state change callbacks
2024-09-13 16:39:42.592 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] }---------------------------------------
2024-09-13 16:39:42.592 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Waiting for data from EVL
2024-09-13 16:39:42.592 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Command processor woke up.
2024-09-13 16:39:42.592 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=2
2024-09-13 16:39:42.592 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=1
2024-09-13 16:39:42.592 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] TX > b'1,1'
2024-09-13 16:39:42.593 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=1
2024-09-13 16:39:42.594 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] {---------------------------------------
2024-09-13 16:39:42.594 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] RX < ^03,00$

2024-09-13 16:39:42.594 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Data received:^03,00$
2024-09-13 16:39:42.594 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Code:^03 Data:00
2024-09-13 16:39:42.594 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] calling handler: handle_command_response for code: ^03 with data: 00
2024-09-13 16:39:42.594 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Envisalink response: Command Accepted
2024-09-13 16:39:42.594 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Invoking state change callbacks
2024-09-13 16:39:42.594 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] }---------------------------------------
2024-09-13 16:39:42.594 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Waiting for data from EVL
2024-09-13 16:39:42.594 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Command processor woke up.
2024-09-13 16:39:42.594 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=1
2024-09-13 16:39:44.392 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Queueing command '03' data: '1,*' ; calling_task=Task-2724
2024-09-13 16:39:44.392 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Queueing command '03' data: '1,*' ; calling_task=Task-2724
2024-09-13 16:39:44.392 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Queueing command '03' data: '1,*' ; calling_task=Task-2724
2024-09-13 16:39:44.392 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Queueing command '03' data: '1,*' ; calling_task=Task-2724
2024-09-13 16:39:44.392 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Queueing command '03' data: '1,1' ; calling_task=Task-2724
2024-09-13 16:39:44.392 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Command processor woke up.
2024-09-13 16:39:44.392 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=5
2024-09-13 16:39:44.392 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] TX > b'1,*'
2024-09-13 16:39:44.392 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=5
2024-09-13 16:39:44.395 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] {---------------------------------------
2024-09-13 16:39:44.395 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] RX < ^03,00$

2024-09-13 16:39:44.395 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Data received:^03,00$
2024-09-13 16:39:44.395 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Code:^03 Data:00
2024-09-13 16:39:44.395 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] calling handler: handle_command_response for code: ^03 with data: 00
2024-09-13 16:39:44.395 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Envisalink response: Command Accepted
2024-09-13 16:39:44.395 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Invoking state change callbacks
2024-09-13 16:39:44.395 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] }---------------------------------------
2024-09-13 16:39:44.395 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Waiting for data from EVL
2024-09-13 16:39:44.395 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Command processor woke up.
2024-09-13 16:39:44.395 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=5
2024-09-13 16:39:44.395 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=4
2024-09-13 16:39:44.395 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] TX > b'1,*'
2024-09-13 16:39:44.395 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=4
2024-09-13 16:39:44.400 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] {---------------------------------------
2024-09-13 16:39:44.400 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] RX < ^03,00$

2024-09-13 16:39:44.400 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Data received:^03,00$
2024-09-13 16:39:44.400 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Code:^03 Data:00
2024-09-13 16:39:44.400 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] calling handler: handle_command_response for code: ^03 with data: 00
2024-09-13 16:39:44.400 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Envisalink response: Command Accepted
2024-09-13 16:39:44.400 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Invoking state change callbacks
2024-09-13 16:39:44.400 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] }---------------------------------------
2024-09-13 16:39:44.400 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Waiting for data from EVL
2024-09-13 16:39:44.400 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Command processor woke up.
2024-09-13 16:39:44.400 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=4
2024-09-13 16:39:44.400 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=3
2024-09-13 16:39:44.400 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] TX > b'1,*'
2024-09-13 16:39:44.400 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=3
2024-09-13 16:39:44.402 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] {---------------------------------------
2024-09-13 16:39:44.402 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] RX < ^03,00$

2024-09-13 16:39:44.402 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Data received:^03,00$
2024-09-13 16:39:44.402 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Code:^03 Data:00
2024-09-13 16:39:44.402 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] calling handler: handle_command_response for code: ^03 with data: 00
2024-09-13 16:39:44.402 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Envisalink response: Command Accepted
2024-09-13 16:39:44.402 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Invoking state change callbacks
2024-09-13 16:39:44.402 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] }---------------------------------------
2024-09-13 16:39:44.402 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Waiting for data from EVL
2024-09-13 16:39:44.402 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Command processor woke up.
2024-09-13 16:39:44.402 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=3
2024-09-13 16:39:44.402 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=2
2024-09-13 16:39:44.402 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] TX > b'1,*'
2024-09-13 16:39:44.402 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=2
2024-09-13 16:39:44.404 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] {---------------------------------------
2024-09-13 16:39:44.404 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] RX < ^03,00$

2024-09-13 16:39:44.404 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Data received:^03,00$
2024-09-13 16:39:44.404 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Code:^03 Data:00
2024-09-13 16:39:44.404 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] calling handler: handle_command_response for code: ^03 with data: 00
2024-09-13 16:39:44.404 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Envisalink response: Command Accepted
2024-09-13 16:39:44.404 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Invoking state change callbacks
2024-09-13 16:39:44.404 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] }---------------------------------------
2024-09-13 16:39:44.404 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Waiting for data from EVL
2024-09-13 16:39:44.404 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Command processor woke up.
2024-09-13 16:39:44.404 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=2
2024-09-13 16:39:44.404 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=1
2024-09-13 16:39:44.404 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] TX > b'1,1'
2024-09-13 16:39:44.404 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=1
2024-09-13 16:39:44.406 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] {---------------------------------------
2024-09-13 16:39:44.406 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] RX < ^03,00$

2024-09-13 16:39:44.406 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Data received:^03,00$
2024-09-13 16:39:44.406 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Code:^03 Data:00
2024-09-13 16:39:44.406 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] calling handler: handle_command_response for code: ^03 with data: 00
2024-09-13 16:39:44.406 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Envisalink response: Command Accepted
2024-09-13 16:39:44.406 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Invoking state change callbacks
2024-09-13 16:39:44.406 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] }---------------------------------------
2024-09-13 16:39:44.406 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Waiting for data from EVL
2024-09-13 16:39:44.406 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Command processor woke up.
2024-09-13 16:39:44.406 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=1
2024-09-13 16:39:46.060 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Queueing command '03' data: '1,*' ; calling_task=Task-2725
2024-09-13 16:39:46.060 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Queueing command '03' data: '1,*' ; calling_task=Task-2725
2024-09-13 16:39:46.060 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Queueing command '03' data: '1,*' ; calling_task=Task-2725
2024-09-13 16:39:46.060 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Queueing command '03' data: '1,*' ; calling_task=Task-2725
2024-09-13 16:39:46.060 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Queueing command '03' data: '1,1' ; calling_task=Task-2725
2024-09-13 16:39:46.060 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Command processor woke up.
2024-09-13 16:39:46.060 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=5
2024-09-13 16:39:46.060 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] TX > b'1,*'
2024-09-13 16:39:46.060 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=5
2024-09-13 16:39:46.062 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] {---------------------------------------
2024-09-13 16:39:46.062 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] RX < ^03,00$

2024-09-13 16:39:46.062 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Data received:^03,00$
2024-09-13 16:39:46.062 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Code:^03 Data:00
2024-09-13 16:39:46.062 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] calling handler: handle_command_response for code: ^03 with data: 00
2024-09-13 16:39:46.062 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Envisalink response: Command Accepted
2024-09-13 16:39:46.062 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Invoking state change callbacks
2024-09-13 16:39:46.062 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] }---------------------------------------
2024-09-13 16:39:46.062 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Waiting for data from EVL
2024-09-13 16:39:46.062 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Command processor woke up.
2024-09-13 16:39:46.062 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=5
2024-09-13 16:39:46.062 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=4
2024-09-13 16:39:46.062 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] TX > b'1,*'
2024-09-13 16:39:46.062 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=4
2024-09-13 16:39:46.064 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] {---------------------------------------
2024-09-13 16:39:46.064 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] RX < ^03,00$

2024-09-13 16:39:46.064 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Data received:^03,00$
2024-09-13 16:39:46.064 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Code:^03 Data:00
2024-09-13 16:39:46.064 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] calling handler: handle_command_response for code: ^03 with data: 00
2024-09-13 16:39:46.064 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Envisalink response: Command Accepted
2024-09-13 16:39:46.064 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Invoking state change callbacks
2024-09-13 16:39:46.064 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] }---------------------------------------
2024-09-13 16:39:46.064 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Waiting for data from EVL
2024-09-13 16:39:46.064 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Command processor woke up.
2024-09-13 16:39:46.064 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=4
2024-09-13 16:39:46.064 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=3
2024-09-13 16:39:46.064 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] TX > b'1,*'
2024-09-13 16:39:46.065 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=3
2024-09-13 16:39:46.067 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] {---------------------------------------
2024-09-13 16:39:46.067 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] RX < ^03,00$

2024-09-13 16:39:46.067 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Data received:^03,00$
2024-09-13 16:39:46.067 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Code:^03 Data:00
2024-09-13 16:39:46.067 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] calling handler: handle_command_response for code: ^03 with data: 00
2024-09-13 16:39:46.067 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Envisalink response: Command Accepted
2024-09-13 16:39:46.067 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Invoking state change callbacks
2024-09-13 16:39:46.067 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] }---------------------------------------
2024-09-13 16:39:46.067 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Waiting for data from EVL
2024-09-13 16:39:46.067 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Command processor woke up.
2024-09-13 16:39:46.067 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=3
2024-09-13 16:39:46.067 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=2
2024-09-13 16:39:46.067 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] TX > b'1,*'
2024-09-13 16:39:46.067 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=2
2024-09-13 16:39:46.069 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] {---------------------------------------
2024-09-13 16:39:46.069 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] RX < ^03,00$

2024-09-13 16:39:46.069 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Data received:^03,00$
2024-09-13 16:39:46.069 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Code:^03 Data:00
2024-09-13 16:39:46.069 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] calling handler: handle_command_response for code: ^03 with data: 00
2024-09-13 16:39:46.069 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Envisalink response: Command Accepted
2024-09-13 16:39:46.069 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Invoking state change callbacks
2024-09-13 16:39:46.069 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] }---------------------------------------
2024-09-13 16:39:46.069 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Waiting for data from EVL
2024-09-13 16:39:46.069 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Command processor woke up.
2024-09-13 16:39:46.069 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=2
2024-09-13 16:39:46.069 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=1
2024-09-13 16:39:46.069 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] TX > b'1,1'
2024-09-13 16:39:46.069 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=1
2024-09-13 16:39:46.071 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] {---------------------------------------
2024-09-13 16:39:46.071 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] RX < %02,0100000000000000$

2024-09-13 16:39:46.071 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Data received:%02,0100000000000000$
2024-09-13 16:39:46.071 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Code:%02 Data:0100000000000000
2024-09-13 16:39:46.071 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] calling handler: handle_partition_state_change for code: %02 with data: 0100000000000000
2024-09-13 16:39:46.071 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.uno_client] Partition 1 is in state READY
2024-09-13 16:39:46.071 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.uno_client] {"partition_state": "N/A", "alpha": "Ready", "ac_present": true, "beep": false, "armed_bypass": false, "entry_delay": false, "exit_delay": false, "last_armed_by_user": "", "last_disarmed_by_user": "", "ready": true, "bat_trouble": false, "trouble": false, "fire": false, "panic": false, "alarm": false, "alarm_fire_zone": false, "alarm_in_memory": false, "armed_away": false, "armed_stay": false, "armed_zero_entry_delay": false, "armed": false}
2024-09-13 16:39:46.071 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Invoking state change callbacks
2024-09-13 16:39:46.071 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Triggering state change callback for partition: [1]
2024-09-13 16:39:46.071 DEBUG (MainThread) [custom_components.envisalink_new] The envisalink 'Alarm' sent a partition update event: [1]
2024-09-13 16:39:46.071 DEBUG (MainThread) [custom_components.envisalink_new] state_updated for 'Partition 1'
2024-09-13 16:39:46.071 DEBUG (MainThread) [custom_components.envisalink_new] state_updated for 'Partition 1 Keypad'
2024-09-13 16:39:46.071 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] }---------------------------------------
2024-09-13 16:39:46.071 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Waiting for data from EVL
2024-09-13 16:39:46.113 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] {---------------------------------------
2024-09-13 16:39:46.113 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] RX < ^03,00$

2024-09-13 16:39:46.113 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Data received:^03,00$
2024-09-13 16:39:46.113 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Code:^03 Data:00
2024-09-13 16:39:46.113 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] calling handler: handle_command_response for code: ^03 with data: 00
2024-09-13 16:39:46.113 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.honeywell_client] Envisalink response: Command Accepted
2024-09-13 16:39:46.113 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Invoking state change callbacks
2024-09-13 16:39:46.113 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] }---------------------------------------
2024-09-13 16:39:46.113 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Waiting for data from EVL
2024-09-13 16:39:46.114 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Command processor woke up.
2024-09-13 16:39:46.114 DEBUG (MainThread) [custom_components.envisalink_new.pyenvisalink.envisalink_base_client] Checking command queue: len=1
`
```
@ufodone
Copy link
Owner

ufodone commented Sep 14, 2024

Everything looks "fine" in the logs with respect to what the integration is sending/receiving and match the behaviour you're seeing. The disarm commands are being send and accepted but the panel itself isn't actually disarming (but provides no indication of a failure). The long beeps you are hearing on the physical panel presumably indicate the panel rejecting the keystrokes to disarm the panel but there's no indication why that might be.

What version of the firmware are you running? I know people have had success with 1.0.77.

FYI, Uno support is pretty limited at the moment due to a lack of capability in the firmware. Additions were planned but I've not heard whether they have been rolled out yet. But it is my understanding that people have been able to get basic arm/disarm functioning (I don't have an Uno myself to test).

@andredigenova
Copy link
Author

Thanks for the reply and the integration!

Arm/disarm does work, just need to wait 10 seconds or so between operations.

I'm running latest firmware 98.

@deliverer33
Copy link

I can confirm I have the same behavior. I just thought it was intentional. I’m on the latest build running the Uno.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
None yet
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
3 participants
@andredigenova @deliverer33 @ufodone