[SOLVED] Dimmer item jump after command to the given value then to another and then again to the value

Tags: #<Tag:0x00007f6170156188> #<Tag:0x00007f6170156048> #<Tag:0x00007f6170155f58>

If I give a value to a dimmer, then this shows strange behavior:

2018-10-14 22:23:44.620 [ome.event.ItemCommandEvent] - Item 'EG_BAD_HUD_SP' received command 10

2018-10-14 22:23:44.644 [nt.ItemStatePredictedEvent] - EG_BAD_HUD_SP predicted to become 10

2018-10-14 22:23:44.657 [vent.ItemStateChangedEvent] - EG_BAD_HUD_SP changed from 8 to 10

2018-10-14 22:23:46.616 [vent.ItemStateChangedEvent] - EG_BAD_HUD_SP changed from 10 to 8

2018-10-14 22:23:47.645 [vent.ItemStateChangedEvent] - EG_BAD_HUD_SP changed from 8 to 10

2018-10-14 22:26:26.350 [ome.event.ItemCommandEvent] - Item 'EG_BAD_HUD_SP' received command 20

2018-10-14 22:26:26.364 [nt.ItemStatePredictedEvent] - EG_BAD_HUD_SP predicted to become 20

2018-10-14 22:26:26.381 [vent.ItemStateChangedEvent] - EG_BAD_HUD_SP changed from 10 to 20

2018-10-14 22:26:27.848 [vent.ItemStateChangedEvent] - EG_BAD_HUD_SP changed from 20 to 11

2018-10-14 22:26:28.981 [vent.ItemStateChangedEvent] - EG_BAD_HUD_SP changed from 11 to 20

2018-10-14 22:26:46.666 [ome.event.ItemCommandEvent] - Item 'EG_BAD_HUD_SP' received command 21

2018-10-14 22:26:46.681 [nt.ItemStatePredictedEvent] - EG_BAD_HUD_SP predicted to become 21

2018-10-14 22:26:46.697 [vent.ItemStateChangedEvent] - EG_BAD_HUD_SP changed from 20 to 21

2018-10-14 22:26:47.200 [vent.ItemStateChangedEvent] - EG_BAD_HUD_SP changed from 21 to 20

2018-10-14 22:26:48.531 [vent.ItemStateChangedEvent] - EG_BAD_HUD_SP changed from 20 to 21

2018-10-14 22:26:58.525 [ome.event.ItemCommandEvent] - Item 'EG_BAD_HUD_SP' received command 100

2018-10-14 22:26:58.536 [nt.ItemStatePredictedEvent] - EG_BAD_HUD_SP predicted to become 100

2018-10-14 22:26:58.543 [vent.ItemStateChangedEvent] - EG_BAD_HUD_SP changed from 21 to 100

2018-10-14 22:26:58.878 [vent.ItemStateChangedEvent] - EG_BAD_HUD_SP changed from 100 to 29

2018-10-14 22:27:00.033 [vent.ItemStateChangedEvent] - EG_BAD_HUD_SP changed from 29 to 100

In the example I send the value from the console, but also in my scripts, for fane in and fade out, some dimmers or HUE lamps show this behavior. Here is a white hue:

2018-10-14 22:42:27.043 [ome.event.ItemCommandEvent] - Item 'EG_TEST_DIMMER' received command 100

2018-10-14 22:42:27.057 [nt.ItemStatePredictedEvent] - EG_TEST_DIMMER predicted to become 100

2018-10-14 22:42:27.072 [vent.ItemStateChangedEvent] - EG_TEST_DIMMER changed from 10 to 100

2018-10-14 22:42:29.991 [vent.ItemStateChangedEvent] - EG_TEST_DIMMER changed from 100 to 13

2018-10-14 22:42:30.278 [vent.ItemStateChangedEvent] - EG_TEST_DIMMER changed from 13 to 51

2018-10-14 22:42:32.324 [vent.ItemStateChangedEvent] - EG_TEST_DIMMER changed from 51 to 100

2018-10-14 22:42:59.292 [ome.event.ItemCommandEvent] - Item 'EG_TEST_DIMMER' received command 10

2018-10-14 22:42:59.308 [nt.ItemStatePredictedEvent] - EG_TEST_DIMMER predicted to become 10

2018-10-14 22:42:59.334 [vent.ItemStateChangedEvent] - EG_TEST_DIMMER changed from 100 to 10

2018-10-14 22:42:59.621 [vent.ItemStateChangedEvent] - EG_TEST_DIMMER changed from 10 to 96

2018-10-14 22:43:02.272 [vent.ItemStateChangedEvent] - EG_TEST_DIMMER changed from 96 to 10

In practice, this has the effect of flickering when dimming brighter or darker.
Do not know where to look, I’m grateful for any idea.

Which binding are you using?

What happens is that the binding sends a command. The binding receives the actual states, updates to the actual state and then updates to the wanted state.

You could try adding autoupdate=false to your binding definitions.

1 Like

If you’re on the latest binding, try adjusting the command polling interval in the Thing settings. If you set the zwave binding to debug, you could see the command polling in the log.

Edit: I wrongly assumed this is a zwave device… I see you mention Hue.

1 Like

I use the Zigbee Binding 2.4 snapshot.

But I can not find anything where I could set autoupdate or “command polling interval”.

You add autoupdate like this:

ItemType itemName "Item Label" { binding1, binding1, autoupdate="false" }
1 Like

You can’t adjust the polling.

It’s hard to tell what is happening without seeing a debug log. Please enable debug logging as per the binding docs and we and see what’s happening hopefully.

Hi Chris, Here is the timing:

2018-10-14 23:12:03.294 [ome.event.ItemCommandEvent] - Item 'EG_TEST_DIMMER' received command 10
2018-10-14 23:12:11.341 [ome.event.ItemCommandEvent] - Item 'EG_TEST_DIMMER' received command 100
2018-10-14 23:12:11.971 [vent.ItemStateChangedEvent] - EG_TEST_DIMMER changed from 10 to 13
2018-10-14 23:12:12.629 [vent.ItemStateChangedEvent] - EG_TEST_DIMMER changed from 13 to 83
2018-10-14 23:12:14.636 [vent.ItemStateChangedEvent] - EG_TEST_DIMMER changed from 83 to 100

And here’s the debug log: https://www.dropbox.com/s/9jbykf57gwudbfj/ZigBee_LOG.txt?dl=0

I hope you find something, It’s a lot of text for 11 seconds.

What are you expecting to happen?

To me, this looks reasonably ok - you sent the level to 10%, then to 100%, and it goes to 100% over a 3 second period. I don’t see anything out of the ordinary, but presumably this is not what you’re expecting?

1 Like

You’re right, I’ve missed, but in the first post, you’ll see what happens when the error occurs (EG_BAD_HUD_SP). Where the HUE in the first post also already worked properly, what they did not an hour ago. Unfortunately, I can not reproduce the error at the moment, the Dimmer is working well at the moment, although the problem has already occupied me for a couple of days.
Thanks in any case, I will post a log when it occurs again.

That part is autoupdate at work, in line 3; then that gets overridden by update from actual device.
Disable autoupdate where you get reliable feedback from device.

1 Like

@rossko57 thats it: @vzorglub was right in the first answere, but i did not realize it.
This ist with autoupdate:

2018-10-15 00:14:28.967 [ome.event.ItemCommandEvent] - Item 'EG_BAD_HUD_SP' received command 10
2018-10-15 00:14:28.978 [nt.ItemStatePredictedEvent] - EG_BAD_HUD_SP predicted to become 10
2018-10-15 00:14:28.988 [vent.ItemStateChangedEvent] - EG_BAD_HUD_SP changed from 90 to 10
2018-10-15 00:14:29.337 [vent.ItemStateChangedEvent] - EG_BAD_HUD_SP changed from 10 to 82
2018-10-15 00:14:30.493 [vent.ItemStateChangedEvent] - EG_BAD_HUD_SP changed from 82 to 10

and this with {autoupdate=“false”}:

2018-10-15 00:15:57.051 [ome.event.ItemCommandEvent] - Item 'EG_BAD_HUD_SP' received command 10
2018-10-15 00:15:57.395 [vent.ItemStateChangedEvent] - EG_BAD_HUD_SP changed from 90 to 82
2018-10-15 00:15:58.642 [vent.ItemStateChangedEvent] - EG_BAD_HUD_SP changed from 82 to 10

Thank you all!