ISSUE: zwave commands not being issued

[polski-g]

Describe the bug UI does not push any changes to backend ZwaveJS

Environment (please complete the following information):

• OS: Docker-HASS on centos
• Home Assistant version: 2021.9.0
• Component version: 0.0.63
• Z-Wave integration name: zwave_js
• Lock make and model: [e.g. Schlage BE469ZP

Logs When I enable debug logging for the keymaster integration in HASS, I get logs that keymaster is pulling the codes from zwavejs2mqtt. I never see any keymaster logs about pushing codes

Screenshots n/a

Additional context I am tailing the actual zwavejs2mqtt log file and never see any attempt from keymaster to push codes to the lock.

If I set the code and then toggle the Enabled option, the PIN Status changes to Adding. If I toggle the Enabled (to disabled), the PIN Status changes to Deleting. This persists even after relogging or refreshing.

If I go to the Zwavejs2mqtt control panel, I can set the codes in there just fine. Then the keymaster UI will show PIN Status as Connected (only when the keymaster-defined PIN matches the zwavejs2mqtt-defined PIN exactly).

Basically it seems like keymaster isn't making any effort to actually push changes, only pull them.

I have the zwave_js_homeassistant_shutdown and zwave_js_homeassistant_up automations defined.

[firstof9]

What does your binary_sensor.<door name>_network sensor say?

[firstof9]

Potential dupe of #226

[raman325]

Also what are these automations you are referring to?

[djaesthetic]

Potential dupe of #226

@firstof9 I have the same build (0.0.63), same lock (BE469ZP), also using ZwaveJS2MQTT. Only difference is my version of HA (2021.9.5, running in Docker). Experiencing identical behavior to what @polski-g describes above all the way down to the 'Adding' and 'Deleting' PIN Status changes. I'm not sure how I could set the codes in the ZwaveJS2MQTT Control Panel otherwise I'd attempt to verify that as well.

My binary_sensor.frontdoor_network isn't showing any sort of abnormal status.

[EDIT]: (@firstof9, I noticed you also happen to have engagement with Home-Assistant-Mail-And-Packages as well. I'm ASSUMING it's a mere coincidence, but under the circumstance wanted to note that on my fresh HASS install the only other integration I'm struggling with beyond keymaster happens to be Mail and Packages. I've been assuming I'm experience TWO issues, but on the off-chance they've got a similar root cause I at least wanted to mention it.)

[polski-g]

@raman325 These automations: https://raw.githubusercontent.com/FutureTense/keymaster/main/assets/additional_yaml/zwave_js.yaml

@firstof9 binary_sensor.frontdoor_network is listed as "Connected"

[firstof9]

Those automations are not required.

[firstof9]

In zwavejs2mqtt's control panel see if the User Code command class is showing up, it should look like this:

IF it's missing you may need to re-interview your lock.

[polski-g]

User Code is showing up. Code 1 ([20-99-0-userCode-1] User Code (1)) is defined. I defined it from within the zwavejs2mqtt control panel, not keymaster.

[rsummers618]

I'm having the same issue.

Same setup:

Home Assistant 2021.9.7 on Docker zwavejs2mqtt 5.6.0 on Docker. BE469ZP lock

Pin status stuck in "Adding" binary_sensor.front_door_network listed as "Connected"

"User Code" showing in zwave2mqtt control panel "sensor.front_door_code_slot_1" is showing the correct value of that code (as set from the device, not Keymaster)

It seems to be able to read the codes, but not write.

I Can control the lock directly via Zwave-Js in Homeassistant, so the z-wave integration is also working there.

[firstof9]

I'm having the same issue.

What does your binary_sensor.<door name>_network sensor say?

[rsummers618]

What does your binary_sensor._network sensor say?

As described in the previous post, it is showing as connected

binary_sensor.front_door_network listed as "Connected"

[raman325]

do you see anything in the keymaster or zwave_js logs that could indicate an error of some sort? I haven't added a code in a while but I will try to do so tomorrow EDIT: just tested and everything worked fine on my end, so I'm not sure why it isn't working for you.

[rsummers618]

do you see anything in the keymaster or zwave_js logs that could indicate an error of some sort?

Here's some logs from

keymaster:

2021-09-27 13:33:30 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 1 value: <MANUALLY_REDACTED>
2021-09-27 13:33:30 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 2 value: <MANUALLY_REDACTED>
2021-09-27 13:33:30 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 3 not enabled
2021-09-27 13:33:30 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 4 not enabled
2021-09-27 13:33:30 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 5 not enabled
2021-09-27 13:33:30 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 6 not enabled
2021-09-27 13:33:30 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 7 not enabled
2021-09-27 13:33:30 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 8 not enabled
2021-09-27 13:33:30 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 9 not enabled
2021-09-27 13:33:30 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 10 not enabled
2021-09-27 13:33:30 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 11 not enabled
2021-09-27 13:33:30 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 12 not enabled
2021-09-27 13:33:30 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 13 not enabled
2021-09-27 13:33:30 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 14 not enabled
2021-09-27 13:33:30 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 15 not enabled
2021-09-27 13:33:30 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 16 not enabled
2021-09-27 13:33:30 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 17 not enabled
2021-09-27 13:33:30 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 18 not enabled
2021-09-27 13:33:30 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 19 not enabled
2021-09-27 13:33:30 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 20 not enabled
2021-09-27 13:33:30 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 21 not enabled
2021-09-27 13:33:30 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 22 not enabled
2021-09-27 13:33:30 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 23 not enabled
2021-09-27 13:33:30 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 24 not enabled
2021-09-27 13:33:30 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 25 not enabled
2021-09-27 13:33:30 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 26 not enabled
2021-09-27 13:33:30 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 27 not enabled
2021-09-27 13:33:30 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 28 not enabled
2021-09-27 13:33:30 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 29 not enabled
2021-09-27 13:33:30 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 30 not enabled
2021-09-27 13:33:30 DEBUG (MainThread) [custom_components.keymaster] Finished fetching keymaster data in 0.004 seconds (success: True)
2021-09-27 13:33:35 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 1 value: <MANUALLY_REDACTED>
2021-09-27 13:33:35 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 2 value: <MANUALLY_REDACTED>
2021-09-27 13:33:35 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 3 not enabled
2021-09-27 13:33:35 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 4 not enabled
2021-09-27 13:33:35 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 5 not enabled
2021-09-27 13:33:35 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 6 not enabled
2021-09-27 13:33:35 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 7 not enabled
2021-09-27 13:33:35 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 8 not enabled
2021-09-27 13:33:35 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 9 not enabled
2021-09-27 13:33:35 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 10 not enabled
2021-09-27 13:33:35 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 11 not enabled
2021-09-27 13:33:35 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 12 not enabled
2021-09-27 13:33:35 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 13 not enabled
2021-09-27 13:33:35 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 14 not enabled
2021-09-27 13:33:35 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 15 not enabled
2021-09-27 13:33:35 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 16 not enabled
2021-09-27 13:33:35 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 17 not enabled
2021-09-27 13:33:35 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 18 not enabled
2021-09-27 13:33:35 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 19 not enabled
2021-09-27 13:33:35 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 20 not enabled
2021-09-27 13:33:35 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 21 not enabled
2021-09-27 13:33:35 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 22 not enabled
2021-09-27 13:33:35 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 23 not enabled
2021-09-27 13:33:35 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 24 not enabled
2021-09-27 13:33:35 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 25 not enabled
2021-09-27 13:33:35 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 26 not enabled
2021-09-27 13:33:35 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 27 not enabled
2021-09-27 13:33:35 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 28 not enabled
2021-09-27 13:33:35 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 29 not enabled
2021-09-27 13:33:35 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 30 not enabled
2021-09-27 13:33:35 DEBUG (MainThread) [custom_components.keymaster] Finished fetching keymaster data in 0.004 seconds (success: True)
2021-09-27 13:33:40 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 1 value:<MANUALLY_REDACTED>
2021-09-27 13:33:40 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 2 value: <MANUALLY_REDACTED>
2021-09-27 13:33:40 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 3 not enabled
2021-09-27 13:33:40 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 4 not enabled
2021-09-27 13:33:40 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 5 not enabled
2021-09-27 13:33:40 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 6 not enabled
2021-09-27 13:33:40 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 7 not enabled
2021-09-27 13:33:40 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 8 not enabled
2021-09-27 13:33:40 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 9 not enabled
2021-09-27 13:33:40 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 10 not enabled
2021-09-27 13:33:40 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 11 not enabled
2021-09-27 13:33:40 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 12 not enabled
2021-09-27 13:33:40 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 13 not enabled
2021-09-27 13:33:40 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 14 not enabled
2021-09-27 13:33:40 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 15 not enabled
2021-09-27 13:33:40 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 16 not enabled
2021-09-27 13:33:40 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 17 not enabled
2021-09-27 13:33:40 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 18 not enabled
2021-09-27 13:33:40 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 19 not enabled
2021-09-27 13:33:40 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 20 not enabled
2021-09-27 13:33:40 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 21 not enabled
2021-09-27 13:33:40 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 22 not enabled
2021-09-27 13:33:40 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 23 not enabled
2021-09-27 13:33:40 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 24 not enabled
2021-09-27 13:33:40 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 25 not enabled
2021-09-27 13:33:40 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 26 not enabled
2021-09-27 13:33:40 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 27 not enabled
2021-09-27 13:33:40 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 28 not enabled
2021-09-27 13:33:40 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 29 not enabled
2021-09-27 13:33:40 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 30 not enabled
2021-09-27 13:33:40 DEBUG (MainThread) [custom_components.keymaster] Finished fetching keymaster data in 0.004 seconds (success: True)
2021-09-27 13:33:45 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 1 value: <MANUALLY_REDACTED>
2021-09-27 13:33:45 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 2 value: <MANUALLY_REDACTED>
2021-09-27 13:33:45 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 3 not enabled
2021-09-27 13:33:45 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 4 not enabled
2021-09-27 13:33:45 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 5 not enabled
2021-09-27 13:33:45 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 6 not enabled
2021-09-27 13:33:45 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 7 not enabled
2021-09-27 13:33:45 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 8 not enabled
2021-09-27 13:33:45 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 9 not enabled
2021-09-27 13:33:45 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 10 not enabled
2021-09-27 13:33:45 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 11 not enabled
2021-09-27 13:33:45 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 12 not enabled
2021-09-27 13:33:45 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 13 not enabled
2021-09-27 13:33:45 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 14 not enabled
2021-09-27 13:33:45 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 15 not enabled
2021-09-27 13:33:45 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 16 not enabled
2021-09-27 13:33:45 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 17 not enabled
2021-09-27 13:33:45 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 18 not enabled
2021-09-27 13:33:45 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 19 not enabled
2021-09-27 13:33:45 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 20 not enabled
2021-09-27 13:33:45 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 21 not enabled
2021-09-27 13:33:45 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 22 not enabled
2021-09-27 13:33:45 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 23 not enabled
2021-09-27 13:33:45 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 24 not enabled
2021-09-27 13:33:45 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 25 not enabled
2021-09-27 13:33:45 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 26 not enabled
2021-09-27 13:33:45 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 27 not enabled
2021-09-27 13:33:45 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 28 not enabled
2021-09-27 13:33:45 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 29 not enabled
2021-09-27 13:33:45 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 30 not enabled
2021-09-27 13:33:45 DEBUG (MainThread) [custom_components.keymaster] Finished fetching keymaster data in 0.005 seconds (success: True)

And from the zwavejs2mqtt docker container

2021-09-27 13:33:28.531 INFO MQTT: connect ECONNREFUSED 127.0.0.1:1883
2021-09-27 13:33:28.532 INFO MQTT: MQTT client closed
2021-09-27 13:33:31.532 INFO MQTT: MQTT client reconnecting
2021-09-27 13:33:31.534 INFO MQTT: connect ECONNREFUSED 127.0.0.1:1883
2021-09-27 13:33:31.535 INFO MQTT: MQTT client closed
2021-09-27 13:33:34.534 INFO MQTT: MQTT client reconnecting
2021-09-27 13:33:34.536 INFO MQTT: connect ECONNREFUSED 127.0.0.1:1883
2021-09-27 13:33:34.537 INFO MQTT: MQTT client closed
2021-09-27 13:33:37.538 INFO MQTT: MQTT client reconnecting
2021-09-27 13:33:37.540 INFO MQTT: connect ECONNREFUSED 127.0.0.1:1883
2021-09-27 13:33:37.541 INFO MQTT: MQTT client closed
2021-09-27 13:33:40.541 INFO MQTT: MQTT client reconnecting
2021-09-27 13:33:40.542 INFO MQTT: connect ECONNREFUSED 127.0.0.1:1883
2021-09-27 13:33:40.543 INFO MQTT: MQTT client closed
2021-09-27 13:33:43.543 INFO MQTT: MQTT client reconnecting
2021-09-27 13:33:43.544 INFO MQTT: connect ECONNREFUSED 127.0.0.1:1883
2021-09-27 13:33:43.545 INFO MQTT: MQTT client closed
2021-09-27 13:33:46.544 INFO MQTT: MQTT client reconnecting
2021-09-27 13:33:46.545 INFO MQTT: connect ECONNREFUSED 127.0.0.1:1883
2021-09-27 13:33:46.545 INFO MQTT: MQTT client closed

I'm not sure how to find the logs for the z-wave JS addon in homeassistant, as most documentation I can find for the addon are for hassio and mention the hypervisor.

During the time shown, I tried to enable and disable code slot #2 twice, I saw no logs of that activity.

Based on what I'm seeing here, I'm inferring that keymaster is trying to use MQTT as the communication with Z-waveJS, despite me me not having setup MQTT or anything on my homeassistant installation. Keymaster throws no such errors.

It seems strange that keymaster would try reading via zwave-js WS, but writing via mqtt. So I'm not sure if this is a red herring or not.

[firstof9]

Based on what I'm seeing here, I'm inferring that keymaster is trying to use MQTT as the communication with Z-waveJS

That's an incorrect assumption. Your container logs indicate you've enabled the MQTT configuration. This can be resolved by disabling the MQTT portion like so and making sure to hit that save button:

[rsummers618]

Ok, I've disabled the MQTT Gateway configuration.

My logs are effectively the same (Again toggling Enabled -> Disabled and back 2x with ~ 10 seconds in between). The codes shown in the logs are the values I've set manually in the zwavejs2mqtt control panel, but do not accurately sync with the values for keymaster.

Interestingly if I set the code in zwavejs2mqtt control panel, the keymaster UI will show the Pin Status as "connected". So the UI does indeed work. It just never pushes the data, only pulls.

2021-09-27 21:25:45 DEBUG (MainThread) [custom_components.keymaster] Finished fetching keymaster data in 0.004 seconds (success: True)
2021-09-27 21:25:50 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 1 value: <MANUALLY_REDACTED>
2021-09-27 21:25:50 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 2 value: <MANUALLY_REDACTED>
2021-09-27 21:25:50 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 3 not enabled
2021-09-27 21:25:50 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 4 not enabled
2021-09-27 21:25:50 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 5 not enabled
2021-09-27 21:25:50 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 6 not enabled
2021-09-27 21:25:50 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 7 not enabled
2021-09-27 21:25:50 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 8 not enabled
2021-09-27 21:25:50 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 9 not enabled
2021-09-27 21:25:50 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 10 not enabled
2021-09-27 21:25:50 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 11 not enabled
2021-09-27 21:25:50 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 12 not enabled
2021-09-27 21:25:50 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 13 not enabled
2021-09-27 21:25:50 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 14 not enabled
2021-09-27 21:25:50 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 15 not enabled
2021-09-27 21:25:50 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 16 not enabled
2021-09-27 21:25:50 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 17 not enabled
2021-09-27 21:25:50 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 18 not enabled
2021-09-27 21:25:50 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 19 not enabled
2021-09-27 21:25:50 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 20 not enabled
2021-09-27 21:25:50 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 21 not enabled
2021-09-27 21:25:50 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 22 not enabled
2021-09-27 21:25:50 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 23 not enabled
2021-09-27 21:25:50 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 24 not enabled
2021-09-27 21:25:50 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 25 not enabled
2021-09-27 21:25:50 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 26 not enabled
2021-09-27 21:25:50 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 27 not enabled
2021-09-27 21:25:50 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 28 not enabled
2021-09-27 21:25:50 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 29 not enabled
2021-09-27 21:25:50 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 30 not enabled
2021-09-27 21:25:50 DEBUG (MainThread) [custom_components.keymaster] Finished fetching keymaster data in 0.003 seconds (success: True)
2021-09-27 21:25:55 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 1 value: <MANUALLY_REDACTED>
2021-09-27 21:25:55 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 2 value: <MANUALLY_REDACTED>
2021-09-27 21:25:55 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 3 not enabled
2021-09-27 21:25:55 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 4 not enabled
2021-09-27 21:25:55 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 5 not enabled
2021-09-27 21:25:55 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 6 not enabled
2021-09-27 21:25:55 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 7 not enabled
2021-09-27 21:25:55 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 8 not enabled
2021-09-27 21:25:55 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 9 not enabled
2021-09-27 21:25:55 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 10 not enabled
2021-09-27 21:25:55 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 11 not enabled
2021-09-27 21:25:55 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 12 not enabled
2021-09-27 21:25:55 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 13 not enabled
2021-09-27 21:25:55 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 14 not enabled
2021-09-27 21:25:55 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 15 not enabled
2021-09-27 21:25:55 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 16 not enabled
2021-09-27 21:25:55 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 17 not enabled
2021-09-27 21:25:55 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 18 not enabled
2021-09-27 21:25:55 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 19 not enabled
2021-09-27 21:25:55 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 20 not enabled
2021-09-27 21:25:55 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 21 not enabled
2021-09-27 21:25:55 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 22 not enabled
2021-09-27 21:25:55 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 23 not enabled
2021-09-27 21:25:55 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 24 not enabled
2021-09-27 21:25:55 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 25 not enabled
2021-09-27 21:25:55 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 26 not enabled
2021-09-27 21:25:55 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 27 not enabled
2021-09-27 21:25:55 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 28 not enabled
2021-09-27 21:25:55 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 29 not enabled
2021-09-27 21:25:55 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 30 not enabled
2021-09-27 21:25:55 DEBUG (MainThread) [custom_components.keymaster] Finished fetching keymaster data in 0.004 seconds (success: True)
2021-09-27 21:26:00 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 1 value: <MANUALLY_REDACTED>
2021-09-27 21:26:00 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 2 value: <MANUALLY_REDACTED>
2021-09-27 21:26:00 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 3 not enabled
2021-09-27 21:26:00 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 4 not enabled
2021-09-27 21:26:00 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 5 not enabled
2021-09-27 21:26:00 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 6 not enabled
2021-09-27 21:26:00 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 7 not enabled
2021-09-27 21:26:00 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 8 not enabled
2021-09-27 21:26:00 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 9 not enabled
2021-09-27 21:26:00 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 10 not enabled
2021-09-27 21:26:00 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 11 not enabled
2021-09-27 21:26:00 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 12 not enabled
2021-09-27 21:26:00 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 13 not enabled
2021-09-27 21:26:00 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 14 not enabled
2021-09-27 21:26:00 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 15 not enabled
2021-09-27 21:26:00 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 16 not enabled
2021-09-27 21:26:00 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 17 not enabled
2021-09-27 21:26:00 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 18 not enabled
2021-09-27 21:26:00 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 19 not enabled
2021-09-27 21:26:00 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 20 not enabled
2021-09-27 21:26:00 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 21 not enabled
2021-09-27 21:26:00 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 22 not enabled
2021-09-27 21:26:00 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 23 not enabled
2021-09-27 21:26:00 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 24 not enabled
2021-09-27 21:26:00 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 25 not enabled
2021-09-27 21:26:00 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 26 not enabled
2021-09-27 21:26:00 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 27 not enabled
2021-09-27 21:26:00 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 28 not enabled
2021-09-27 21:26:00 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 29 not enabled
2021-09-27 21:26:00 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 30 not enabled
2021-09-27 21:26:00 DEBUG (MainThread) [custom_components.keymaster] Finished fetching keymaster data in 0.002 seconds (success: True)
2021-09-27 21:26:05 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 1 value: <MANUALLY_REDACTED>
2021-09-27 21:26:05 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 2 value: <MANUALLY_REDACTED>
2021-09-27 21:26:05 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 3 not enabled
2021-09-27 21:26:05 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 4 not enabled
2021-09-27 21:26:05 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 5 not enabled
2021-09-27 21:26:05 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 6 not enabled
2021-09-27 21:26:05 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 7 not enabled
2021-09-27 21:26:05 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 8 not enabled
2021-09-27 21:26:05 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 9 not enabled
2021-09-27 21:26:05 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 10 not enabled
2021-09-27 21:26:05 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 11 not enabled
2021-09-27 21:26:05 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 12 not enabled
2021-09-27 21:26:05 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 13 not enabled
2021-09-27 21:26:05 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 14 not enabled
2021-09-27 21:26:05 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 15 not enabled
2021-09-27 21:26:05 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 16 not enabled
2021-09-27 21:26:05 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 17 not enabled
2021-09-27 21:26:05 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 18 not enabled
2021-09-27 21:26:05 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 19 not enabled
2021-09-27 21:26:05 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 20 not enabled
2021-09-27 21:26:05 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 21 not enabled
2021-09-27 21:26:05 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 22 not enabled
2021-09-27 21:26:05 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 23 not enabled
2021-09-27 21:26:05 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 24 not enabled
2021-09-27 21:26:05 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 25 not enabled
2021-09-27 21:26:05 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 26 not enabled
2021-09-27 21:26:05 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 27 not enabled
2021-09-27 21:26:05 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 28 not enabled
2021-09-27 21:26:05 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 29 not enabled
2021-09-27 21:26:05 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 30 not enabled
2021-09-27 21:26:05 DEBUG (MainThread) [custom_components.keymaster] Finished fetching keymaster data in 0.004 seconds (success: True)
2021-09-27 21:26:10 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 1 value: <MANUALLY_REDACTED>
2021-09-27 21:26:10 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 2 value: <MANUALLY_REDACTED>
2021-09-27 21:26:10 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 3 not enabled
2021-09-27 21:26:10 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 4 not enabled
2021-09-27 21:26:10 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 5 not enabled
2021-09-27 21:26:10 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 6 not enabled
2021-09-27 21:26:10 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 7 not enabled
2021-09-27 21:26:10 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 8 not enabled
2021-09-27 21:26:10 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 9 not enabled
2021-09-27 21:26:10 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 10 not enabled
2021-09-27 21:26:10 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 11 not enabled
2021-09-27 21:26:10 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 12 not enabled
2021-09-27 21:26:10 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 13 not enabled
2021-09-27 21:26:10 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 14 not enabled
2021-09-27 21:26:10 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 15 not enabled
2021-09-27 21:26:10 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 16 not enabled
2021-09-27 21:26:10 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 17 not enabled
2021-09-27 21:26:10 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 18 not enabled
2021-09-27 21:26:10 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 19 not enabled
2021-09-27 21:26:10 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 20 not enabled
2021-09-27 21:26:10 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 21 not enabled
2021-09-27 21:26:10 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 22 not enabled
2021-09-27 21:26:10 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 23 not enabled
2021-09-27 21:26:10 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 24 not enabled
2021-09-27 21:26:10 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 25 not enabled
2021-09-27 21:26:10 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 26 not enabled
2021-09-27 21:26:10 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 27 not enabled
2021-09-27 21:26:10 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 28 not enabled
2021-09-27 21:26:10 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 29 not enabled
2021-09-27 21:26:10 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 30 not enabled
2021-09-27 21:26:10 DEBUG (MainThread) [custom_components.keymaster] Finished fetching keymaster data in 0.003 seconds (success: True)
2021-09-27 21:26:15 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 1 value: <MANUALLY_REDACTED>
2021-09-27 21:26:15 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 2 value: <MANUALLY_REDACTED>
2021-09-27 21:26:15 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 3 not enabled
2021-09-27 21:26:15 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 4 not enabled
2021-09-27 21:26:15 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 5 not enabled
2021-09-27 21:26:15 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 6 not enabled
2021-09-27 21:26:15 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 7 not enabled
2021-09-27 21:26:15 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 8 not enabled
2021-09-27 21:26:15 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 9 not enabled
2021-09-27 21:26:15 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 10 not enabled
2021-09-27 21:26:15 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 11 not enabled
2021-09-27 21:26:15 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 12 not enabled
2021-09-27 21:26:15 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 13 not enabled
2021-09-27 21:26:15 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 14 not enabled
2021-09-27 21:26:15 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 15 not enabled
2021-09-27 21:26:15 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 16 not enabled
2021-09-27 21:26:15 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 17 not enabled
2021-09-27 21:26:15 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 18 not enabled
2021-09-27 21:26:15 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 19 not enabled
2021-09-27 21:26:15 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 20 not enabled
2021-09-27 21:26:15 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 21 not enabled
2021-09-27 21:26:15 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 22 not enabled
2021-09-27 21:26:15 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 23 not enabled
2021-09-27 21:26:15 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 24 not enabled
2021-09-27 21:26:15 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 25 not enabled
2021-09-27 21:26:15 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 26 not enabled
2021-09-27 21:26:15 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 27 not enabled
2021-09-27 21:26:15 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 28 not enabled
2021-09-27 21:26:15 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 29 not enabled
2021-09-27 21:26:15 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 30 not enabled
2021-09-27 21:26:15 DEBUG (MainThread) [custom_components.keymaster] Finished fetching keymaster data in 0.004 seconds (success: True)
2021-09-27 21:26:20 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 1 value: <MANUALLY_REDACTED>
2021-09-27 21:26:20 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 2 value: <MANUALLY_REDACTED>
2021-09-27 21:26:20 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 3 not enabled
2021-09-27 21:26:20 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 4 not enabled
2021-09-27 21:26:20 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 5 not enabled
2021-09-27 21:26:20 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 6 not enabled
2021-09-27 21:26:20 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 7 not enabled
2021-09-27 21:26:20 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 8 not enabled
2021-09-27 21:26:20 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 9 not enabled
2021-09-27 21:26:20 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 10 not enabled
2021-09-27 21:26:20 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 11 not enabled
2021-09-27 21:26:20 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 12 not enabled
2021-09-27 21:26:20 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 13 not enabled
2021-09-27 21:26:20 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 14 not enabled
2021-09-27 21:26:20 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 15 not enabled
2021-09-27 21:26:20 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 16 not enabled
2021-09-27 21:26:20 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 17 not enabled
2021-09-27 21:26:20 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 18 not enabled
2021-09-27 21:26:20 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 19 not enabled
2021-09-27 21:26:20 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 20 not enabled
2021-09-27 21:26:20 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 21 not enabled
2021-09-27 21:26:20 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 22 not enabled
2021-09-27 21:26:20 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 23 not enabled
2021-09-27 21:26:20 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 24 not enabled
2021-09-27 21:26:20 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 25 not enabled
2021-09-27 21:26:20 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 26 not enabled
2021-09-27 21:26:20 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 27 not enabled
2021-09-27 21:26:20 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 28 not enabled
2021-09-27 21:26:20 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 29 not enabled
2021-09-27 21:26:20 DEBUG (MainThread) [custom_components.keymaster] DEBUG: Code slot 30 not enabled
2021-09-27 21:26:20 DEBUG (MainThread) [custom_components.keymaster] Finished fetching keymaster data in 0.004 seconds (success: True)

And I had no zwavejs2mqtt logs during this time

Reference Images:

Are there any other logs I can pull here? Keymaster logs don't even seem to indicate I've done anything, so its difficult to know where to look.

[firstof9]

Based on your log output it doesn't look like the services are being called.

[polski-g]

my log looks identical to @rsummers618

[firstof9]

Likely something wrong with the synchronize_codeslot automation.

[firstof9]

if you guys modify the generated YAML files and insert and ID for the synchronize_codeslot automation you can view the trace in Home Assistant to help narrow down where the fault is.

Should be line: 164

  - alias: keymaster_synchronize_codeslot_<LOCKNAME>_<SLOT NUMBER>

add just below it an ID line like this:

  - alias: keymaster_synchronize_codeslot_<LOCKNAME>_<SLOT NUMBER>
    id: keymaster_synchronize_codeslot_<LOCKNAME>_<SLOT NUMBER>

You should then be able to view the trace to via Configuration -> Automations:

[rsummers618]

if you guys modify the generated YAML files and insert and ID for the synchronize_codeslot automation you can view the trace in Home Assistant to help narrow down where the fault is.

I'm not 100% sure I'm following this.

Where should I expect the generated YAML files to be? (Perhaps this is the true issue?)

~/docker/homeassistant$ grep -r keymaster_synchronize_codeslot .
grep: ./core: Permission denied
Binary file ./home-assistant_v2.db matches
grep: ./.storage/auth_module.totp: Permission denied
grep: ./.storage/onboarding: Permission denied
grep: ./.storage/auth: Permission denied
grep: ./.storage/core.uuid: Permission denied
grep: ./.storage/core.config: Permission denied
grep: ./.storage/auth_provider.homeassistant: Permission denied
./custom_components/keymaster/keymaster_child.yaml:- alias: keymaster_synchronize_codeslot_LOCKNAME_TEMPLATENUM
Binary file ./home-assistant_v2.db-wal matches

[polski-g]

I also only have keymaster_synchronize_codeslot_LOCKNAME_TEMPLATENUM

[firstof9]

Where should I expect the generated YAML files to be?

packages directory.

The directions are in the wiki.

[polski-g]

Automation is synchronize_codeslot_ ... not keymaster_synchronize_codeslot_ ...

I set up id for codeslot 1 (in which the MQTT/live value matches the value set in Keymaster) and the automation was executing.

I set up id for codeslot 2 (which does not match the live code) and the automation does not execute.

[firstof9]

and what does the trace for codeslot 2 show?

[polski-g]

There is no trace, it does not execute at all.

[firstof9]

Does the binary_sensor.pin_synched_<lock_name>_2 show on or off?

[polski-g]

Does the binary_sensor.pin_synched_<lock_name>_2 show on or off?

Off

[firstof9]

and sensor.<lock_name>_code_slot_2 is populated right?

[polski-g]

and sensor.<lock_name>_code_slot_2 is populated right?

Yes, it has a 4 digit number. Control panel PIN Status is currently stuck on "Adding"

[firstof9]

ok and one last one is binary_sensor.active_<lock_name>_2 on or off?