search

xaviml / controllerx

Create controller-based automations with ease to control your home devices and scenes.
https://xaviml.github.io/controllerx/
MIT License
336 stars 70 forks source link

[BUG] Unable to change color_temp or color anymore #338

Closed lkeijser closed 3 years ago

lkeijser commented 3 years ago

Bug report

Description

For some time now, I'm no longer able to change color(_temp) on my IKEA lights that support it, using the E1810 remote.

Additional information

AppDaemon app configuration

tradfri-douche:
  module: controllerx
  class: E1810Controller
  controller: douchelamp_afstandsbediening
  integration: deconz
  light: light.color_temperature_light_6

Logs

2021-07-16 16:23:34.750317 WARNING tradfri-douche: Traceback (most recent call last):
  File "/usr/lib/python3.8/site-packages/appdaemon/threading.py", line 841, in async_worker
    await funcref(args["event"], data, self.AD.events.sanitize_event_kwargs(app, args["kwargs"]))
  File "/config/appdaemon/apps/controllerx/cx_core/integration/deconz.py", line 23, in event_callback
    await Hass.listen_event(
  File "/config/appdaemon/apps/controllerx/cx_core/controller.py", line 319, in handle_action
    self.log("\n".join(to_log), level="INFO", ascii_encode=False)
  File "/config/appdaemon/apps/controllerx/cx_core/controller.py", line 393, in call_action
  File "/config/appdaemon/apps/controllerx/cx_core/controller.py", line 431, in action_timer_callback
    "the default value is `single`.",
  File "/config/appdaemon/apps/controllerx/cx_core/controller.py", line 449, in call_action_types
    action_key: ActionEvent = kwargs["action_key"]
  File "/config/appdaemon/apps/controllerx/cx_core/action_type/predefined_action_type.py", line 56, in run
    attr_msg += f" (value given: {action_args[key]})"
  File "/config/appdaemon/apps/controllerx/cx_core/controller.py", line 61, in _action_impl
    ):
  File "/config/appdaemon/apps/controllerx/cx_core/type/light_controller.py", line 597, in hold
    attribute = await self.get_attribute(attribute)
  File "/config/appdaemon/apps/controllerx/cx_core/type/light_controller.py", line 517, in get_attribute
    )
ValueError: This light does not support xy_color or color_temp
2021-07-16 16:23:34.751010 WARNING tradfri-douche: ------------------------------------------------------------
2021-07-16 16:23:36.409908 INFO tradfri-douche: 🎮 Button event triggered: `5003`
2021-07-16 16:23:36.422812 INFO tradfri-douche: 🏃 Running `Predefined (release)` now
2021-07-16 16:23:37.649140 INFO tradfri-douche: 🎮 Button event triggered: `4001`
2021-07-16 16:23:37.660191 INFO tradfri-douche: 🏃 Running `Predefined (hold_color_down)` now
2021-07-16 16:23:37.668272 WARNING tradfri-douche: ------------------------------------------------------------
2021-07-16 16:23:37.669582 WARNING tradfri-douche: Unexpected error in worker for App tradfri-douche:
2021-07-16 16:23:37.670478 WARNING tradfri-douche: Worker Ags: {'id': '64ee65861994444e87810b90f2fac829', 'name': 'tradfri-douche', 'objectid': '788221f5bc814902a02983f8af9ef900', 'type': 'event', 'event': 'deconz_event', 'function': <bound method DeCONZIntegration.event_callback of <cx_core.integration.deconz.DeCONZIntegration object at 0xb418e5e0>>, 'data': {'id': 'douchelamp_afstandsbediening', 'unique_id': '00:0d:6f:ff:fe:06:72:12', 'event': 4001, 'device_id': '9d0f8d300e4548d19d27ad7ca1ed12d0', 'metadata': {'origin': 'LOCAL', 'time_fired': '2021-07-16T14:23:37.631177+00:00', 'context': {'id': 'ec8e486129eb07877bad061a56fdba6a', 'parent_id': None, 'user_id': None}}}, 'pin_app': True, 'pin_thread': 0, 'kwargs': {'id': 'douchelamp_afstandsbediening', '__thread_id': 'MainThread'}}
2021-07-16 16:23:37.671489 WARNING tradfri-douche: ------------------------------------------------------------
2021-07-16 16:23:37.672773 WARNING tradfri-douche: Traceback (most recent call last):
  File "/usr/lib/python3.8/site-packages/appdaemon/threading.py", line 841, in async_worker
    await funcref(args["event"], data, self.AD.events.sanitize_event_kwargs(app, args["kwargs"]))
  File "/config/appdaemon/apps/controllerx/cx_core/integration/deconz.py", line 23, in event_callback
    await Hass.listen_event(
  File "/config/appdaemon/apps/controllerx/cx_core/controller.py", line 319, in handle_action
    self.log("\n".join(to_log), level="INFO", ascii_encode=False)
  File "/config/appdaemon/apps/controllerx/cx_core/controller.py", line 393, in call_action
  File "/config/appdaemon/apps/controllerx/cx_core/controller.py", line 431, in action_timer_callback
    "the default value is `single`.",
  File "/config/appdaemon/apps/controllerx/cx_core/controller.py", line 449, in call_action_types
    action_key: ActionEvent = kwargs["action_key"]
  File "/config/appdaemon/apps/controllerx/cx_core/action_type/predefined_action_type.py", line 56, in run
    attr_msg += f" (value given: {action_args[key]})"
  File "/config/appdaemon/apps/controllerx/cx_core/controller.py", line 61, in _action_impl
    ):
  File "/config/appdaemon/apps/controllerx/cx_core/type/light_controller.py", line 597, in hold
    attribute = await self.get_attribute(attribute)
  File "/config/appdaemon/apps/controllerx/cx_core/type/light_controller.py", line 517, in get_attribute
    )
ValueError: This light does not support xy_color or color_temp
2021-07-16 16:23:37.674822 WARNING tradfri-douche: ------------------------------------------------------------
2021-07-16 16:23:40.275092 INFO tradfri-douche: 🎮 Button event triggered: `4003`
2021-07-16 16:23:40.283847 INFO tradfri-douche: 🏃 Running `Predefined (release)` now
2021-07-16 16:23:42.617230 INFO tradfri-douche: 🎮 Button event triggered: `5001`
2021-07-16 16:23:42.627784 WARNING tradfri-douche: There is already an action executing for `5001`. If you want a different behaviour change `mode` parameter, the default value is `single`.
2021-07-16 16:23:43.927333 INFO tradfri-douche: 🎮 Button event triggered: `5003`
2021-07-16 16:23:43.939165 INFO tradfri-douche: 🏃 Running `Predefined (release)` now
2021-07-16 16:23:44.672877 INFO tradfri-douche: 🎮 Button event triggered: `2001`
2021-07-16 16:23:44.684659 INFO tradfri-douche: 🏃 Running `Predefined (hold_brightness_up)` now
2021-07-16 16:23:44.708447 INFO tradfri-douche: 
🤖 Service: light.turn_on
  - entity_id: light.color_temperature_light_6
  - brightness: 26.40
  - transition: 0.35
2021-07-16 16:23:45.110129 INFO tradfri-douche: 
🤖 Service: light.turn_on
  - entity_id: light.color_temperature_light_6
  - brightness: 51.80
  - transition: 0.35
2021-07-16 16:23:45.525505 INFO tradfri-douche: 
🤖 Service: light.turn_on
  - entity_id: light.color_temperature_light_6
  - brightness: 77.20
  - transition: 0.35
2021-07-16 16:23:45.798262 INFO tradfri-douche: 🎮 Button event triggered: `2003`
2021-07-16 16:23:45.808353 INFO tradfri-douche: 🏃 Running `Predefined (release)` now
2021-07-16 16:23:46.445905 INFO tradfri-douche: 🎮 Button event triggered: `5001`
2021-07-16 16:23:46.454414 WARNING tradfri-douche: There is already an action executing for `5001`. If you want a different behaviour change `mode` parameter, the default value is `single`.
2021-07-16 16:23:47.460318 INFO tradfri-douche: 🎮 Button event triggered: `5003`
2021-07-16 16:23:47.471881 INFO tradfri-douche: 🏃 Running `Predefined (release)` now
2021-07-16 16:23:48.289554 INFO tradfri-douche: 🎮 Button event triggered: `4001`
2021-07-16 16:23:48.299488 WARNING tradfri-douche: There is already an action executing for `4001`. If you want a different behaviour change `mode` parameter, the default value is `single`.
2021-07-16 16:23:50.445691 INFO tradfri-douche: 🎮 Button event triggered: `4003`
2021-07-16 16:23:50.457188 INFO tradfri-douche: 🏃 Running `Predefined (release)` now
2021-07-16 16:23:51.310117 INFO tradfri-douche: 🎮 Button event triggered: `5001`
2021-07-16 16:23:51.321101 WARNING tradfri-douche: There is already an action executing for `5001`. If you want a different behaviour change `mode` parameter, the default value is `single`.
2021-07-16 16:23:52.140989 INFO tradfri-douche: 🎮 Button event triggered: `5003`
2021-07-16 16:23:52.152081 INFO tradfri-douche: 🏃 Running `Predefined (release)` now
2021-07-16 16:23:52.332537 INFO tradfri-douche: 🎮 Button event triggered: `1002`
2021-07-16 16:23:52.341901 INFO tradfri-douche: 🏃 Running `Predefined (toggle)` now
2021-07-16 16:23:52.355384 INFO tradfri-douche: 
🤖 Service: light.toggle
  - entity_id: light.color_temperature_light_6

Additional Context

N/A

Caine72 commented 3 years ago

Experiencing the same problem as the original poster. As an experiment i tried adding supported_features: 191 while the errors went away ( see below) nothing seem to happen. Also tried supported_features: 51 which i guess would be the supported values for my ikea floalt, but the output is the same as when setting 191.

Manually overrode the value . i.e. 4002: click_color_down, to set min_color_temp and max_color_temp and that works.

Please get back to me if i can help out some more with debugging. :) 

2021-07-19 19:28:52.629123 INFO sauna_controller: 🎮 Button event triggered: `5001`
2021-07-19 19:28:52.639182 INFO sauna_controller: 🏃 Running `Predefined (hold_color_up)` now
2021-07-19 19:28:52.662440 INFO sauna_controller: 
🤖 Service: light.turn_on
  - entity_id: light.sauna_light
  - xy_color: (0.581, 0.245)
  - transition: 0.35
xaviml commented 3 years ago

Hi @lkeijser ,

Is this light light.color_temperature_light_6 a light group? Which lights are attached to it? Do they both support color temp?

xaviml commented 3 years ago

Hi @Caine72,

Is light.sauna_light a group light?

Caine72 commented 3 years ago

Hi @Caine72,

Is light.sauna_light a group light?

Nope. It's a single light.

Basing this on that I have scripts for changing the brightness (was not completely satisfied with how controllerx was doing it. I'm using transitions instead of steps) and needed to write two different ones depending on if the light was a group or single light. But as a matter of fact, tried changing the color of a group of lights as well. Was not working there either. =(

Caine72 commented 3 years ago

@xaviml just to be sure. Is there some 100% way I can verify this for you, so that I'm not sending you on a wild goose chase?

xaviml commented 3 years ago

Hi @Caine72 ,

I am trying to understand what is your issue and how to reproduce it. If I did understand correctly, you have a controller integrated with deCONZ that it does not change the color of your light when holding, is that correct?

Can you please share the AppDaemon logs when you are pressing the controller until you release the button?

Regards, Xavi M.

xaviml commented 3 years ago

Could you also add log_level: DEBUG to your configuration? 

example_app:
  log_level: DEBUG
  module: controllerx
  class: ...
...
xaviml commented 3 years ago

Hi @Caine72 again,

I just realised that Home Assistanthas deprecated the way to show the supported features for lights. I have a color light and it is not working for me either. This is due to a change from Home Assistant. However, if I put supported_features: 191, the color works as always.

I have created the following bug to follow this issue: https://github.com/xaviml/controllerx/issues/342

Regards,

Caine72 commented 3 years ago

Hi @Caine72 again,

I just realised that Home Assistanthas deprecated the way to show the supported features for lights. I have a color light and it is not working for me either. This is due to a change from Home Assistant. However, if I put supported_features: 191, the color works as always.

I have created the following bug to follow this issue: #342

Regards,

As i wrote earlier 191 did not work for me sadly. It just made the error go away. But the color does not change. Nothing happens. =/

Just to be clear. To be clear, I'm trying to change the color temperature. I.e. not RGB but Yellow to Blue.

Ran with the debug command. Lots of "is not recognized as a template". Can do a version with 191 enabled as well if you want it?

From apps.yaml

sauna_controller:
  log_level: DEBUG
  module: controllerx
  class: E1810Controller
  controller: sauna_control
  integration: deconz
  light: light.sauna_light
  merge_mapping:
    2001:
      - service: script.increase_brightness_light
        data:
          entity: light.sauna_light
    2003:
      - service: script.stop_brightness_light
        data:
          entity: light.sauna_light
    3001:
      - service: script.decrease_brightness_light
        data:
          entity: light.sauna_light
    3003:
      - service: script.stop_brightness_light
        data:
          entity: light.sauna_light

Log from appdeamon.

2021-08-05 20:54:24.832877 INFO sauna_controller: 🎮 ControllerX v4.14.0
2021-08-05 20:54:24.838014 DEBUG sauna_controller: `light.sauna_light` is not recognized as a template
2021-08-05 20:54:24.843555 DEBUG sauna_controller: Entities from `light.sauna_light` (entity_id attribute): `light.sauna_light`
2021-08-05 20:54:24.847680 DEBUG sauna_controller: `light.sauna_light` is not recognized as a template
2021-08-05 20:54:24.854905 DEBUG sauna_controller: `toggle` is not recognized as a template
2021-08-05 20:54:24.860416 DEBUG sauna_controller: `sync` is not recognized as a template
2021-08-05 20:54:24.865904 DEBUG sauna_controller: `click_brightness_up` is not recognized as a template
2021-08-05 20:54:24.871322 DEBUG sauna_controller: `click_brightness_down` is not recognized as a template
2021-08-05 20:54:24.876877 DEBUG sauna_controller: `click_color_down` is not recognized as a template
2021-08-05 20:54:24.882879 DEBUG sauna_controller: `click_color_up` is not recognized as a template
2021-08-05 20:54:24.888554 DEBUG sauna_controller: `hold_brightness_up` is not recognized as a template
2021-08-05 20:54:24.894745 DEBUG sauna_controller: `release` is not recognized as a template
2021-08-05 20:54:24.900336 DEBUG sauna_controller: `hold_brightness_down` is not recognized as a template
2021-08-05 20:54:24.906148 DEBUG sauna_controller: `release` is not recognized as a template
2021-08-05 20:54:24.911660 DEBUG sauna_controller: `hold_color_down` is not recognized as a template
2021-08-05 20:54:24.917189 DEBUG sauna_controller: `release` is not recognized as a template
2021-08-05 20:54:24.922829 DEBUG sauna_controller: `hold_color_up` is not recognized as a template
2021-08-05 20:54:24.928295 DEBUG sauna_controller: `release` is not recognized as a template
2021-08-05 20:54:24.930244 DEBUG sauna_controller: Calling listen_event for sauna_controller
2021-08-05 20:54:47.612952 INFO sauna_controller: 🎮 Button event triggered: `1002`
2021-08-05 20:54:47.617782 DEBUG sauna_controller: Extra:
{'id': 'sauna_control', 'unique_id': '90:fd:9f:ff:fe:4c:71:65', 'event': 1002, 'device_id': 'f28de507c69b9c08b0667c277eb1503d', 'metadata': {'origin': 'LOCAL', 'time_fired': '2021-08-05T18:54:47.587304+00:00', 'context': {'id': '7d01296a41a309988c83e654d672b50a', 'parent_id': None, 'user_id': None}}}
2021-08-05 20:54:47.624719 INFO sauna_controller: 🏃 Running `Predefined (toggle)` now
2021-08-05 20:54:47.628663 DEBUG sauna_controller: `toggle` is not recognized as a template
2021-08-05 20:54:47.633893 DEBUG sauna_controller: `light.sauna_light` is not recognized as a template
2021-08-05 20:54:47.638477 INFO sauna_controller: 
🤖 Service: light.toggle
  - entity_id: light.sauna_light
2021-08-05 20:54:47.640707 DEBUG sauna_controller: call_service: light/toggle, {'entity_id': 'light.sauna_light'}
2021-08-05 20:54:49.802014 INFO sauna_controller: 🎮 Button event triggered: `5001`
2021-08-05 20:54:49.807115 DEBUG sauna_controller: Extra:
{'id': 'sauna_control', 'unique_id': '90:fd:9f:ff:fe:4c:71:65', 'event': 5001, 'device_id': 'f28de507c69b9c08b0667c277eb1503d', 'metadata': {'origin': 'LOCAL', 'time_fired': '2021-08-05T18:54:49.785093+00:00', 'context': {'id': '74e726765f689338c30fb2f3adb44fd3', 'parent_id': None, 'user_id': None}}}
2021-08-05 20:54:49.813152 INFO sauna_controller: 🏃 Running `Predefined (hold_color_up)` now
2021-08-05 20:54:49.817091 DEBUG sauna_controller: `hold_color_up` is not recognized as a template
2021-08-05 20:54:49.822202 DEBUG sauna_controller: `light.sauna_light` is not recognized as a template
2021-08-05 20:54:49.828087 WARNING sauna_controller: ------------------------------------------------------------
2021-08-05 20:54:49.829189 WARNING sauna_controller: Unexpected error in worker for App sauna_controller:
2021-08-05 20:54:49.830322 WARNING sauna_controller: Worker Ags: {'id': 'e9837bbb09d74b35bc1a3a78fe0137f2', 'name': 'sauna_controller', 'objectid': '85543c6a1c4d40089ac5e2a232b240ec', 'type': 'event', 'event': 'deconz_event', 'function': <bound method DeCONZIntegration.event_callback of <cx_core.integration.deconz.DeCONZIntegration object at 0xb48dc868>>, 'data': {'id': 'sauna_control', 'unique_id': '90:fd:9f:ff:fe:4c:71:65', 'event': 5001, 'device_id': 'f28de507c69b9c08b0667c277eb1503d', 'metadata': {'origin': 'LOCAL', 'time_fired': '2021-08-05T18:54:49.785093+00:00', 'context': {'id': '74e726765f689338c30fb2f3adb44fd3', 'parent_id': None, 'user_id': None}}}, 'pin_app': True, 'pin_thread': 0, 'kwargs': {'id': 'sauna_control', '__thread_id': 'MainThread'}}
2021-08-05 20:54:49.831152 WARNING sauna_controller: ------------------------------------------------------------
2021-08-05 20:54:49.832681 WARNING sauna_controller: Traceback (most recent call last):
  File "/usr/lib/python3.8/site-packages/appdaemon/threading.py", line 841, in async_worker
    await funcref(args["event"], data, self.AD.events.sanitize_event_kwargs(app, args["kwargs"]))
  File "/config/appdaemon/apps/controllerx/cx_core/integration/deconz.py", line 34, in event_callback
    await self.controller.handle_action(data[type_], extra=data)
  File "/config/appdaemon/apps/controllerx/cx_core/controller.py", line 347, in handle_action
    await self.call_action(action_key, extra=extra)
  File "/config/appdaemon/apps/controllerx/cx_core/controller.py", line 421, in call_action
    await self.action_timer_callback({"action_key": action_key, "extra": extra})
  File "/config/appdaemon/apps/controllerx/cx_core/controller.py", line 459, in action_timer_callback
    await task
  File "/config/appdaemon/apps/controllerx/cx_core/controller.py", line 477, in call_action_types
    await action_type.run(extra=extra)
  File "/config/appdaemon/apps/controllerx/cx_core/action_type/predefined_action_type.py", line 115, in run
    await action(*positional, **action_args)
  File "/config/appdaemon/apps/controllerx/cx_core/controller.py", line 64, in _action_impl
    await method(controller, *args, **kwargs)
  File "/config/appdaemon/apps/controllerx/cx_core/type/light_controller.py", line 609, in hold
    attribute = await self.get_attribute(attribute)
  File "/config/appdaemon/apps/controllerx/cx_core/type/light_controller.py", line 529, in get_attribute
    raise ValueError(
ValueError: This light does not support xy_color or color_temp
2021-08-05 20:54:49.833407 WARNING sauna_controller: ------------------------------------------------------------
2021-08-05 20:54:52.475699 INFO sauna_controller: Previous message repeated 1 times
2021-08-05 20:54:52.476968 INFO sauna_controller: 🎮 Button event triggered: `5003`
2021-08-05 20:54:52.482466 DEBUG sauna_controller: Extra:
{'id': 'sauna_control', 'unique_id': '90:fd:9f:ff:fe:4c:71:65', 'event': 5003, 'device_id': 'f28de507c69b9c08b0667c277eb1503d', 'metadata': {'origin': 'LOCAL', 'time_fired': '2021-08-05T18:54:52.456558+00:00', 'context': {'id': '1fb9825843c3a060031c05ecbc486a58', 'parent_id': None, 'user_id': None}}}
2021-08-05 20:54:52.487243 INFO sauna_controller: 🏃 Running `Predefined (release)` now
2021-08-05 20:54:52.490711 DEBUG sauna_controller: `release` is not recognized as a template
2021-08-05 20:54:53.933014 INFO sauna_controller: 🎮 Button event triggered: `1002`
2021-08-05 20:54:53.940160 DEBUG sauna_controller: Extra:
{'id': 'sauna_control', 'unique_id': '90:fd:9f:ff:fe:4c:71:65', 'event': 1002, 'device_id': 'f28de507c69b9c08b0667c277eb1503d', 'metadata': {'origin': 'LOCAL', 'time_fired': '2021-08-05T18:54:53.917131+00:00', 'context': {'id': '4a54e9e2e24966b63a29eb02bc21b363', 'parent_id': None, 'user_id': None}}}
2021-08-05 20:54:53.949273 INFO sauna_controller: 🏃 Running `Predefined (toggle)` now
2021-08-05 20:54:53.952736 DEBUG sauna_controller: `toggle` is not recognized as a template
2021-08-05 20:54:53.957331 DEBUG sauna_controller: `light.sauna_light` is not recognized as a template
2021-08-05 20:54:53.961208 INFO sauna_controller: 
🤖 Service: light.toggle
  - entity_id: light.sauna_light
2021-08-05 20:54:53.963022 DEBUG sauna_controller: call_service: light/toggle, {'entity_id': 'light.sauna_light'}
xaviml commented 3 years ago

Hi @Caine72,

Yes, could you do the same with supported_features attribute? You can do 175, instead of 191. It will remove the xy_color feature.

Caine72 commented 3 years ago

It's ALIVE! =D I.e 175 works.

Here is the log. ( sadly it seems like i cannot fetch the complete scenario,but i hope it's enough,as Appdeamon will not allow me to see the complete log via the GUI) 

{'id': 'sauna_control', 'unique_id': '90:fd:9f:ff:fe:4c:71:65', 'event': 5003, 'device_id': 'f28de507c69b9c08b0667c277eb1503d', 'metadata': {'origin': 'LOCAL', 'time_fired': '2021-08-05T19:05:01.533172+00:00', 'context': {'id': '1029eb7924030a0e6ab273ef5d02c210', 'parent_id': None, 'user_id': None}}}
2021-08-05 21:05:01.559925 INFO sauna_controller: 🏃 Running `Predefined (release)` now
2021-08-05 21:05:01.564941 DEBUG sauna_controller: `release` is not recognized as a template
2021-08-05 21:05:03.380629 INFO sauna_controller: 🎮 Button event triggered: `4001`
2021-08-05 21:05:03.386655 DEBUG sauna_controller: Extra:
{'id': 'sauna_control', 'unique_id': '90:fd:9f:ff:fe:4c:71:65', 'event': 4001, 'device_id': 'f28de507c69b9c08b0667c277eb1503d', 'metadata': {'origin': 'LOCAL', 'time_fired': '2021-08-05T19:05:03.361068+00:00', 'context': {'id': 'a4a393752eb729105a7dc4ff582dd52d', 'parent_id': None, 'user_id': None}}}
2021-08-05 21:05:03.392333 INFO sauna_controller: 🏃 Running `Predefined (hold_color_down)` now
2021-08-05 21:05:03.396556 DEBUG sauna_controller: `hold_color_down` is not recognized as a template
2021-08-05 21:05:03.401667 DEBUG sauna_controller: `light.sauna_light` is not recognized as a template
2021-08-05 21:05:03.411044 INFO sauna_controller: Previous message repeated 1 times
2021-08-05 21:05:03.411855 DEBUG sauna_controller: Attribute value before running the hold action: 454.0
2021-08-05 21:05:03.415048 DEBUG sauna_controller: Going direction: down
2021-08-05 21:05:03.420138 DEBUG sauna_controller: `light.sauna_light` is not recognized as a template
2021-08-05 21:05:03.424543 INFO sauna_controller: 
🤖 Service: light.turn_on
  - entity_id: light.sauna_light
  - color_temp: 419.30
  - transition: 0.35
2021-08-05 21:05:03.426069 DEBUG sauna_controller: call_service: light/turn_on, {'entity_id': 'light.sauna_light', 'color_temp': 419.3, 'transition': 0.35}
2021-08-05 21:05:03.817108 DEBUG sauna_controller: `light.sauna_light` is not recognized as a template
2021-08-05 21:05:03.824625 INFO sauna_controller: 
🤖 Service: light.turn_on
  - entity_id: light.sauna_light
  - color_temp: 384.60
  - transition: 0.35
2021-08-05 21:05:03.826461 DEBUG sauna_controller: call_service: light/turn_on, {'entity_id': 'light.sauna_light', 'color_temp': 384.6, 'transition': 0.35}
2021-08-05 21:05:04.222709 DEBUG sauna_controller: `light.sauna_light` is not recognized as a template
2021-08-05 21:05:04.227878 INFO sauna_controller: 
🤖 Service: light.turn_on
  - entity_id: light.sauna_light
  - color_temp: 349.90
  - transition: 0.35
2021-08-05 21:05:04.229852 DEBUG sauna_controller: call_service: light/turn_on, {'entity_id': 'light.sauna_light', 'color_temp': 349.9, 'transition': 0.35}
2021-08-05 21:05:04.633278 DEBUG sauna_controller: `light.sauna_light` is not recognized as a template
2021-08-05 21:05:04.641120 INFO sauna_controller: 
🤖 Service: light.turn_on
  - entity_id: light.sauna_light
  - color_temp: 315.20
  - transition: 0.35
2021-08-05 21:05:04.643647 DEBUG sauna_controller: call_service: light/turn_on, {'entity_id': 'light.sauna_light', 'color_temp': 315.2, 'transition': 0.35}
2021-08-05 21:05:05.031749 DEBUG sauna_controller: `light.sauna_light` is not recognized as a template
2021-08-05 21:05:05.040333 INFO sauna_controller: 
🤖 Service: light.turn_on
  - entity_id: light.sauna_light
  - color_temp: 280.50
  - transition: 0.35
2021-08-05 21:05:05.043754 DEBUG sauna_controller: call_service: light/turn_on, {'entity_id': 'light.sauna_light', 'color_temp': 280.5, 'transition': 0.35}
2021-08-05 21:05:05.436016 DEBUG sauna_controller: `light.sauna_light` is not recognized as a template
2021-08-05 21:05:05.443100 INFO sauna_controller: 
🤖 Service: light.turn_on
  - entity_id: light.sauna_light
  - color_temp: 245.80
  - transition: 0.35
2021-08-05 21:05:05.445440 DEBUG sauna_controller: call_service: light/turn_on, {'entity_id': 'light.sauna_light', 'color_temp': 245.8, 'transition': 0.35}
2021-08-05 21:05:05.845444 DEBUG sauna_controller: `light.sauna_light` is not recognized as a template
2021-08-05 21:05:05.855754 INFO sauna_controller: 
🤖 Service: light.turn_on
  - entity_id: light.sauna_light
  - color_temp: 211.10
  - transition: 0.35
2021-08-05 21:05:05.858418 DEBUG sauna_controller: call_service: light/turn_on, {'entity_id': 'light.sauna_light', 'color_temp': 211.1, 'transition': 0.35}
2021-08-05 21:05:06.251953 DEBUG sauna_controller: `light.sauna_light` is not recognized as a template
2021-08-05 21:05:06.260384 INFO sauna_controller: 
🤖 Service: light.turn_on
  - entity_id: light.sauna_light
  - color_temp: 176.40
  - transition: 0.35
2021-08-05 21:05:06.263221 DEBUG sauna_controller: call_service: light/turn_on, {'entity_id': 'light.sauna_light', 'color_temp': 176.4, 'transition': 0.35}
2021-08-05 21:05:06.657112 DEBUG sauna_controller: `light.sauna_light` is not recognized as a template
2021-08-05 21:05:06.665826 INFO sauna_controller: 
🤖 Service: light.turn_on
  - entity_id: light.sauna_light
  - color_temp: 153
  - transition: 0.35
2021-08-05 21:05:06.667223 DEBUG sauna_controller: call_service: light/turn_on, {'entity_id': 'light.sauna_light', 'color_temp': 153, 'transition': 0.35}
2021-08-05 21:05:07.574410 INFO sauna_controller: 🎮 Button event triggered: `4003`
2021-08-05 21:05:07.579394 DEBUG sauna_controller: Extra:
{'id': 'sauna_control', 'unique_id': '90:fd:9f:ff:fe:4c:71:65', 'event': 4003, 'device_id': 'f28de507c69b9c08b0667c277eb1503d', 'metadata': {'origin': 'LOCAL', 'time_fired': '2021-08-05T19:05:07.558123+00:00', 'context': {'id': 'dab86c06b96cc9d45eea921d95885d0a', 'parent_id': None, 'user_id': None}}}
2021-08-05 21:05:07.584915 INFO sauna_controller: 🏃 Running `Predefined (release)` now
2021-08-05 21:05:07.588763 DEBUG sauna_controller: `release` is not recognized as a template
2021-08-05 21:05:08.786233 INFO sauna_controller: 🎮 Button event triggered: `1002`
2021-08-05 21:05:08.791519 DEBUG sauna_controller: Extra:
{'id': 'sauna_control', 'unique_id': '90:fd:9f:ff:fe:4c:71:65', 'event': 1002, 'device_id': 'f28de507c69b9c08b0667c277eb1503d', 'metadata': {'origin': 'LOCAL', 'time_fired': '2021-08-05T19:05:08.771389+00:00', 'context': {'id': 'e243a9aaf7f6af6f5fa66cf75f23ccb5', 'parent_id': None, 'user_id': None}}}
2021-08-05 21:05:08.798129 INFO sauna_controller: 🏃 Running `Predefined (toggle)` now
2021-08-05 21:05:08.803559 DEBUG sauna_controller: `toggle` is not recognized as a template
2021-08-05 21:05:08.809813 DEBUG sauna_controller: `light.sauna_light` is not recognized as a template
2021-08-05 21:05:08.813787 INFO sauna_controller: 
🤖 Service: light.toggle
  - entity_id: light.sauna_light
2021-08-05 21:05:08.816225 DEBUG sauna_controller: call_service: light/toggle, {'entity_id': 'light.sauna_light'}
xaviml commented 3 years ago

Perfect! Sorry for the inconvenience, I was not aware of this change from Home Assistant.. to be honest, not sure why they changed this.

Out of curiosity, could you try 191 as well and share the logs?

Thanks!

Caine72 commented 3 years ago

Sure no problem. :)

Seem to remember them mentioning changing stuff around in 2021.5 release. So probably around there i would guess.. But as you can see on the report date, it's not a feature we use daily. ;D

2021-08-05 21:14:34.687396 INFO sauna_controller: 🎮 ControllerX v4.14.0
2021-08-05 21:14:34.692205 DEBUG sauna_controller: `light.sauna_light` is not recognized as a template
2021-08-05 21:14:34.697635 DEBUG sauna_controller: Entities from `light.sauna_light` (entity_id attribute): `light.sauna_light`
2021-08-05 21:14:34.701850 DEBUG sauna_controller: `light.sauna_light` is not recognized as a template
2021-08-05 21:14:34.709486 DEBUG sauna_controller: `toggle` is not recognized as a template
2021-08-05 21:14:34.714886 DEBUG sauna_controller: `sync` is not recognized as a template
2021-08-05 21:14:34.720370 DEBUG sauna_controller: `click_brightness_up` is not recognized as a template
2021-08-05 21:14:34.726143 DEBUG sauna_controller: `click_brightness_down` is not recognized as a template
2021-08-05 21:14:34.731651 DEBUG sauna_controller: `click_color_down` is not recognized as a template
2021-08-05 21:14:34.737766 DEBUG sauna_controller: `click_color_up` is not recognized as a template
2021-08-05 21:14:34.743352 DEBUG sauna_controller: `hold_brightness_up` is not recognized as a template
2021-08-05 21:14:34.748840 DEBUG sauna_controller: `release` is not recognized as a template
2021-08-05 21:14:34.754481 DEBUG sauna_controller: `hold_brightness_down` is not recognized as a template
2021-08-05 21:14:34.759976 DEBUG sauna_controller: `release` is not recognized as a template
2021-08-05 21:14:34.767021 DEBUG sauna_controller: `hold_color_down` is not recognized as a template
2021-08-05 21:14:34.772562 DEBUG sauna_controller: `release` is not recognized as a template
2021-08-05 21:14:34.778120 DEBUG sauna_controller: `hold_color_up` is not recognized as a template
2021-08-05 21:14:34.783633 DEBUG sauna_controller: `release` is not recognized as a template
2021-08-05 21:14:34.785249 DEBUG sauna_controller: Calling listen_event for sauna_controller
2021-08-05 21:15:01.970847 INFO sauna_controller: 🎮 Button event triggered: `1002`
2021-08-05 21:15:01.976574 DEBUG sauna_controller: Extra:
{'id': 'sauna_control', 'unique_id': '90:fd:9f:ff:fe:4c:71:65', 'event': 1002, 'device_id': 'f28de507c69b9c08b0667c277eb1503d', 'metadata': {'origin': 'LOCAL', 'time_fired': '2021-08-05T19:15:01.953895+00:00', 'context': {'id': 'c03c9e0777e875e248ad048bdf203a44', 'parent_id': None, 'user_id': None}}}
2021-08-05 21:15:01.983902 INFO sauna_controller: 🏃 Running `Predefined (toggle)` now
2021-08-05 21:15:01.988074 DEBUG sauna_controller: `toggle` is not recognized as a template
2021-08-05 21:15:01.992943 DEBUG sauna_controller: `light.sauna_light` is not recognized as a template
2021-08-05 21:15:01.997037 INFO sauna_controller: 
🤖 Service: light.toggle
  - entity_id: light.sauna_light
2021-08-05 21:15:01.999009 DEBUG sauna_controller: call_service: light/toggle, {'entity_id': 'light.sauna_light'}
2021-08-05 21:15:03.664503 INFO sauna_controller: 🎮 Button event triggered: `5001`
2021-08-05 21:15:03.669999 DEBUG sauna_controller: Extra:
{'id': 'sauna_control', 'unique_id': '90:fd:9f:ff:fe:4c:71:65', 'event': 5001, 'device_id': 'f28de507c69b9c08b0667c277eb1503d', 'metadata': {'origin': 'LOCAL', 'time_fired': '2021-08-05T19:15:03.647865+00:00', 'context': {'id': 'f1a3f1176a838568ecbe146034b45491', 'parent_id': None, 'user_id': None}}}
2021-08-05 21:15:03.675491 INFO sauna_controller: 🏃 Running `Predefined (hold_color_up)` now
2021-08-05 21:15:03.679804 DEBUG sauna_controller: `hold_color_up` is not recognized as a template
2021-08-05 21:15:03.684923 DEBUG sauna_controller: `light.sauna_light` is not recognized as a template
2021-08-05 21:15:03.690496 DEBUG sauna_controller: Attribute value before running the hold action: 0
2021-08-05 21:15:03.694435 DEBUG sauna_controller: Going direction: up
2021-08-05 21:15:03.699508 DEBUG sauna_controller: `light.sauna_light` is not recognized as a template
2021-08-05 21:15:03.704022 INFO sauna_controller: 
🤖 Service: light.turn_on
  - entity_id: light.sauna_light
  - xy_color: (0.667, 0.284)
  - transition: 0.35
2021-08-05 21:15:03.705751 DEBUG sauna_controller: call_service: light/turn_on, {'entity_id': 'light.sauna_light', 'xy_color': (0.667, 0.284), 'transition': 0.35}
2021-08-05 21:15:04.101212 DEBUG sauna_controller: `light.sauna_light` is not recognized as a template
2021-08-05 21:15:04.108406 INFO sauna_controller: 
🤖 Service: light.turn_on
  - entity_id: light.sauna_light
  - xy_color: (0.581, 0.245)
  - transition: 0.35
2021-08-05 21:15:04.110469 DEBUG sauna_controller: call_service: light/turn_on, {'entity_id': 'light.sauna_light', 'xy_color': (0.581, 0.245), 'transition': 0.35}
2021-08-05 21:15:04.503437 DEBUG sauna_controller: `light.sauna_light` is not recognized as a template
2021-08-05 21:15:04.512518 INFO sauna_controller: 
🤖 Service: light.turn_on
  - entity_id: light.sauna_light
  - xy_color: (0.477, 0.196)
  - transition: 0.35
2021-08-05 21:15:04.517360 DEBUG sauna_controller: call_service: light/turn_on, {'entity_id': 'light.sauna_light', 'xy_color': (0.477, 0.196), 'transition': 0.35}
2021-08-05 21:15:04.910291 DEBUG sauna_controller: `light.sauna_light` is not recognized as a template
2021-08-05 21:15:04.919118 INFO sauna_controller: 
🤖 Service: light.turn_on
  - entity_id: light.sauna_light
  - xy_color: (0.385, 0.155)
  - transition: 0.35
2021-08-05 21:15:04.920712 DEBUG sauna_controller: call_service: light/turn_on, {'entity_id': 'light.sauna_light', 'xy_color': (0.385, 0.155), 'transition': 0.35}
2021-08-05 21:15:05.312858 DEBUG sauna_controller: `light.sauna_light` is not recognized as a template
2021-08-05 21:15:05.320872 INFO sauna_controller: 
🤖 Service: light.turn_on
  - entity_id: light.sauna_light
  - xy_color: (0.301, 0.116)
  - transition: 0.35
2021-08-05 21:15:05.323029 DEBUG sauna_controller: call_service: light/turn_on, {'entity_id': 'light.sauna_light', 'xy_color': (0.301, 0.116), 'transition': 0.35}
2021-08-05 21:15:05.467887 INFO sauna_controller: 🎮 Button event triggered: `5003`
2021-08-05 21:15:05.473209 DEBUG sauna_controller: Extra:
{'id': 'sauna_control', 'unique_id': '90:fd:9f:ff:fe:4c:71:65', 'event': 5003, 'device_id': 'f28de507c69b9c08b0667c277eb1503d', 'metadata': {'origin': 'LOCAL', 'time_fired': '2021-08-05T19:15:05.449269+00:00', 'context': {'id': '1e277f76c3271644a28401208b9d5119', 'parent_id': None, 'user_id': None}}}
2021-08-05 21:15:05.478714 INFO sauna_controller: 🏃 Running `Predefined (release)` now
2021-08-05 21:15:05.482314 DEBUG sauna_controller: `release` is not recognized as a template
2021-08-05 21:15:06.375422 INFO sauna_controller: 🎮 Button event triggered: `1002`
2021-08-05 21:15:06.381481 DEBUG sauna_controller: Extra:
{'id': 'sauna_control', 'unique_id': '90:fd:9f:ff:fe:4c:71:65', 'event': 1002, 'device_id': 'f28de507c69b9c08b0667c277eb1503d', 'metadata': {'origin': 'LOCAL', 'time_fired': '2021-08-05T19:15:06.359700+00:00', 'context': {'id': 'edde7fcd754ca8960e1d7241ba539db9', 'parent_id': None, 'user_id': None}}}
2021-08-05 21:15:06.388026 INFO sauna_controller: 🏃 Running `Predefined (toggle)` now
2021-08-05 21:15:06.392689 DEBUG sauna_controller: `toggle` is not recognized as a template
2021-08-05 21:15:06.398869 DEBUG sauna_controller: `light.sauna_light` is not recognized as a template
2021-08-05 21:15:06.403707 INFO sauna_controller: 
🤖 Service: light.toggle
  - entity_id: light.sauna_light
2021-08-05 21:15:06.406210 DEBUG sauna_controller: call_service: light/toggle, {'entity_id': 'light.sauna_light'}
xaviml commented 3 years ago

Hi @lkeijser and @Caine72,

Thank you both for reporting this. As you might know, I created #342, which tackles this problem. I just released a beta v4.15.0b1 with this fix. Now everything should work as it used to be without placing any supported_features in your configuration.

Please, let me know if you try it out and you have some problems with it.

Regards, Xavi M.

xaviml commented 3 years ago

This problem has been fixed in ControllerX v4.15.0.

Caine72 commented 3 years ago

@xaviml Sorry to comment so late. I have had much to do and was planning to test it this weekend.

You where right in your decision to close it.

Did try the new version But sorry to say, the i0ssue seem to persist. Should I open a new bug?

xaviml commented 3 years ago

Hi @Caine72,

Could you please show me all the attributes of your light? You can see that in the Developer Tools.

Could you also:

Finally, paste in here the controller configuration.

Regards, Xavi M.

Caine72 commented 3 years ago

Yes. Will fix that first thing tomorrow morning! =)

xaviml commented 3 years ago

Hi @Caine72,

No worries. Do when you have time for it, I closed the ticket because I added the fix. However, I opened it again so we can make sure it works in your side. Maybe I forgot something that I didn't take into account.

My light that was not working for this same reason is now working as before. That is why I thought it was now fixed.

Regards, Xavi M.

Caine72 commented 3 years ago

Prepared today's testing session to pull the logs for you by:

Restarting

Little embarrassing to say this. Seems like everything is working as it should now... and the fault was somewhere locally. And manually rebooting one of the 3 above solved the issue.

I.e. My bad. You fixed it. Great work! :)

xaviml commented 3 years ago

Hi @Caine72,

I am glad it is now working all fine :) Sometimes a good restart is the best solution..

I will close now this ticket.

Regards, Xavi M.