Insteon switchlinc dimmer operates with lovelace but not automation

Greetings,

I have a number of Insteon devices which all work great with Home assistant except one. It is a switchlinc dimmer. It works fine if I switch it from the Lovelace interface but it will not work from and automation. I can see the automation run in the logs but it doesn’t operate the switch.

My automation is copied from a known working automation, I can with authority say it is not the automation, I’ve written a lot of them. I can include it here if required but…

Has anyone else experienced this and is there a way to debug the internal flow via logging?
All suggestion greatly appreciated.

Definitely not normal behavior. Entity ID match in the automation action?

As @Tediore suggests, check and double check your spelling.

Makes sure the automation is on.

Trigger it manually.

Yes the automation is on and when triggered manually it does nothing, however, if I replace the specific Insteon light with a different one in the automation, it all works fine. It’s this one specific light, it works fine with Pytomation ( a different home automation program) and as I say it works from Lovelace, I can toggle the light on or off and change it’s brightness.

Could this be a corrupt database?

Setting the Insteon log level to debug doesn’t show much at the best of times. I suppose the next step would be to rename my .homeassistant folder and start a new instance, create an automation and see if it works.

I know you said you’re confident it’s not the automation, but maybe post it anyway.

Sure I’ll post it. I just added a debug statement to insteon/light.py, in async_turn_on(), it spits out a debug when using lovelace but not when using the automation. I’m wondering if Insteon has got the device confused. When I look it up in the developer tools it shows as the light.switchlinc_dimmer_17_c0_c7 so that’s what I use.

By the way I can see the script run in the log.

- alias: Hallway on from sensor
  trigger:
    platform: event
    event_type: button_pressed
    event_data: {"entity_id": "switch.office_desk_lamp", "state": "On"}
  action:
    service: light.turn_on
    data:
      entity_id: light.switchlinc_dimmer_17_c0_c7

Here is the output of print_im_all_link_database for reference.

2019-11-18 12:19:46 INFO (SyncWorker_8) [homeassistant.components.insteon] ALDB load status is LOADED
2019-11-18 12:19:46 INFO (SyncWorker_8) [homeassistant.components.insteon] RecID In Use Mode HWM Group Address  Data 1 Data 2 Data 3
2019-11-18 12:19:46 INFO (SyncWorker_8) [homeassistant.components.insteon] ----- ------ ---- --- ----- -------- ------ ------ ------
2019-11-18 12:19:46 INFO (SyncWorker_8) [homeassistant.components.insteon]  0012    Y     R   N      1 12.E3.54     2    21    55
2019-11-18 12:19:46 INFO (SyncWorker_8) [homeassistant.components.insteon]  0011    Y     C   N      1 12.E3.54     2    21    55
2019-11-18 12:19:46 INFO (SyncWorker_8) [homeassistant.components.insteon]  0010    Y     R   N      1 12.03.BB     1     0    55
2019-11-18 12:19:46 INFO (SyncWorker_8) [homeassistant.components.insteon]  000f    Y     C   N      1 12.03.BB     1     0    55
2019-11-18 12:19:46 INFO (SyncWorker_8) [homeassistant.components.insteon]  000e    Y     R   N    251 1F.A9.86     2    42    66
2019-11-18 12:19:46 INFO (SyncWorker_8) [homeassistant.components.insteon]  000d    Y     C   N    251 1F.A9.86     2    42    66
2019-11-18 12:19:46 INFO (SyncWorker_8) [homeassistant.components.insteon]  000c    Y     R   N      1 12.07.1F     1     0    55
2019-11-18 12:19:46 INFO (SyncWorker_8) [homeassistant.components.insteon]  000b    Y     R   N    251 17.BE.33     1    25    56
2019-11-18 12:19:46 INFO (SyncWorker_8) [homeassistant.components.insteon]  000a    Y     R   N    251 0E.7C.6C     1     0    51
2019-11-18 12:19:46 INFO (SyncWorker_8) [homeassistant.components.insteon]  0009    Y     R   N    251 17.C0.7C     1    25    56
2019-11-18 12:19:46 INFO (SyncWorker_8) [homeassistant.components.insteon]  0008    Y     C   N      1 12.07.1F     1     0    55
2019-11-18 12:19:46 INFO (SyncWorker_8) [homeassistant.components.insteon]  0007    Y     R   N    251 12.06.58     1     0    55
2019-11-18 12:19:46 INFO (SyncWorker_8) [homeassistant.components.insteon]  0006    Y     R   N    251 12.09.02     0     0     0
2019-11-18 12:19:46 INFO (SyncWorker_8) [homeassistant.components.insteon]  0005    Y     R   N      0 12.20.B0     1     1    55
2019-11-18 12:19:46 INFO (SyncWorker_8) [homeassistant.components.insteon]  0004    Y     R   N    251 1C.F9.A5     0     0     0
2019-11-18 12:19:46 INFO (SyncWorker_8) [homeassistant.components.insteon]  0003    Y     R   N      0 1A.58.E8     1    25    64
2019-11-18 12:19:46 INFO (SyncWorker_8) [homeassistant.components.insteon]  0002    Y     R   N    251 1E.39.5C     2    42    66
2019-11-18 12:19:46 INFO (SyncWorker_8) [homeassistant.components.insteon]  0001    Y     C   N    251 1E.39.5C     2    42    66
2019-11-18 12:19:46 INFO (SyncWorker_8) [homeassistant.components.insteon]  0000    Y     R   N    251 12.20.B0     0     0     0

@horga83 Not sure if you ever got this solved but here is an automation from my HA setup:

- id: Security_Sunset_On
  alias: Security Sunset On
  trigger:
  - event: sunset
    platform: sun
  action:
  - alias: Office Light
    data:
      entity_id: light.keypad_dimmer_46_2f_24_main
    service: light.turn_on

This definitely works. If you trigger your automation manually does it work?