core: ZHA unable to set brightness and color temperature in same call

Home Assistant release with the issue: 0.89.1

Last working Home Assistant release (if known): NA

Operating environment (Hass.io/Docker/Windows/etc.): rpi3 IKEA bulbs

Component/platform: https://www.home-assistant.io/components/zha

(eventhough it says “custom_components” in below, it’s from master 0.89.1)

Description of problem: When trying to set both brightness and color temperature in the same call, the brightness just flickers. Color temperature changes ok.

Traceback (if applicable):

2019-03-10 11:51:27 DEBUG (MainThread) [bellows.ezsp] Send command sendUnicast
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.uart] Sending: b'47ce219c54b4abb6589c4a24ab1593499c3851adecb86375f8c6d7d37e'
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.uart] Data frame: b'75cea19c54eafb187e'
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.uart] Sending: b'8070787e'
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.ezsp] Application frame 52 (sendUnicast) received
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.uart] Data frame: b'05ceb1f1ca94ded3696ab572a1556d829cfe037e'
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.uart] Sending: b'8160597e'
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.ezsp] Application frame 89 (incomingRouteRecordHandler) received
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.uart] Data frame: b'15ceb1f1ca94ded3696ab572a1556d829ce0027e'
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.uart] Sending: b'82503a7e'
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.ezsp] Application frame 89 (incomingRouteRecordHandler) received
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.uart] Data frame: b'25ceb1ed542e14ba59954b65ab5592d96385b915123162838bcd678961467e'
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.uart] Sending: b'83401b7e'
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.uart] Data frame: b'35ceb19754b4abb6589c4a24ab1593499c8e51abedad407e'
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.uart] Sending: b'8430fc7e'
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.ezsp] Application frame 63 (messageSentHandler) received
2019-03-10 11:51:27 DEBUG (MainThread) [custom_components.zha.core.channels] 0xbe9e:1:0x0008: executed command: move_to_level_with_on_off with args: (254, 5) with kwargs: {} and result: [4, <Status.SUCCESS: 0>]
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.ezsp] Send command sendUnicast
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.uart] Sending: b'54cf219c54b4abb658924a24ab1593499c3950a8ecb966ace57e'
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.uart] Data frame: b'46cfa19c54eba0047e'
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.uart] Sending: b'8520dd7e'
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.ezsp] Application frame 52 (sendUnicast) received
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.uart] Data frame: b'56cfb1f1ca94ded3696ab572a1556d809c67667e'
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.uart] Sending: b'8610be7e'
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.ezsp] Application frame 89 (incomingRouteRecordHandler) received
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.uart] Data frame: b'66cfb1f1ca94ded3696ab572a1556d839c10367e'
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.uart] Sending: b'87009f7e'
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.ezsp] Application frame 89 (incomingRouteRecordHandler) received
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.uart] Data frame: b'76cfb1ed542e14b459954b65ab5592d86385b915123162838acd62891b957e'
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.uart] Sending: b'8070787e'
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.uart] Data frame: b'06cfb19754b4abb658924a24ab1593499c8f50abed24ac7e'
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.uart] Sending: b'8160597e'
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.ezsp] Application frame 63 (messageSentHandler) received
2019-03-10 11:51:27 DEBUG (MainThread) [custom_components.zha.core.channels] 0xbe9e:1:0x0006: executed command: on with args: () with kwargs: {} and result: [1, <Status.SUCCESS: 0>]
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.ezsp] Send command sendUnicast
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.uart] Sending: b'61cc219c54b4abb658944924ab1593499c365facecb66da0ffc363635b7e'
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.uart] Data frame: b'17cca19c54e84b817e'
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.uart] Sending: b'82503a7e'
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.ezsp] Application frame 52 (sendUnicast) received
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.uart] Data frame: b'27ccb1f1ca94ded3696ab572a1556d809cc5ce7e'
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.uart] Sending: b'83401b7e'
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.ezsp] Application frame 89 (incomingRouteRecordHandler) received
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.uart] Data frame: b'37ccb1f1ca94ded3696ab572a1556d829cbdad7e'
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.uart] Sending: b'8430fc7e'
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.ezsp] Application frame 89 (incomingRouteRecordHandler) received
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.uart] Data frame: b'47ccb1ed542e14b25a954b65ab5592db6385b9151231628385cd6989febf7e'
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.uart] Sending: b'8520dd7e'
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.uart] Data frame: b'57ccb19754b4abb658944924ab1593499c8c5fabedfe1d7e'
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.uart] Sending: b'8610be7e'
2019-03-10 11:51:27 DEBUG (MainThread) [bellows.ezsp] Application frame 63 (messageSentHandler) received
2019-03-10 11:51:27 DEBUG (MainThread) [custom_components.zha.core.channels] 0xbe9e:1:0x0300: executed command: move_to_color_temp with args: (555, 5) with kwargs: {} and result: [10, <Status.SUCCESS: 0>]

Additional information: After the call, hass ui is updated with the changed state, however now incorrect values.

Calling the commands separately works ok:

Successful brightness call:

2019-03-10 11:53:41 DEBUG (MainThread) [bellows.ezsp] Send command sendUnicast
2019-03-10 11:53:41 DEBUG (MainThread) [bellows.uart] Sending: b'72cd219c54b4abb6589c4a24ab1593499c375eadecb76375f8c6a9297e'
2019-03-10 11:53:41 DEBUG (MainThread) [bellows.uart] Data frame: b'20cda19c54e9163c7e'
2019-03-10 11:53:41 DEBUG (MainThread) [bellows.uart] Sending: b'83401b7e'
2019-03-10 11:53:41 DEBUG (MainThread) [bellows.ezsp] Application frame 52 (sendUnicast) received
2019-03-10 11:53:42 DEBUG (MainThread) [bellows.uart] Data frame: b'30cdb1f1ca94ded3696ab572a1556d809c01457e'
2019-03-10 11:53:42 DEBUG (MainThread) [bellows.uart] Sending: b'8430fc7e'
2019-03-10 11:53:42 DEBUG (MainThread) [bellows.ezsp] Application frame 89 (incomingRouteRecordHandler) received
2019-03-10 11:53:42 DEBUG (MainThread) [bellows.uart] Data frame: b'40cdb1f1ca94ded3696ab572a1556d809c5b427e'
2019-03-10 11:53:42 DEBUG (MainThread) [bellows.uart] Sending: b'8520dd7e'
2019-03-10 11:53:42 DEBUG (MainThread) [bellows.ezsp] Application frame 89 (incomingRouteRecordHandler) received
2019-03-10 11:53:42 DEBUG (MainThread) [bellows.uart] Data frame: b'50cdb1ed542e14ba59954b65ab5592da6387b9151231628384cd67895cff7e'
2019-03-10 11:53:42 DEBUG (MainThread) [bellows.uart] Sending: b'8610be7e'
2019-03-10 11:53:42 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received
2019-03-10 11:53:42 DEBUG (MainThread) [bellows.uart] Data frame: b'60cdb19754b4abb6589c4a24ab1593499c8d5eabed638e7e'
2019-03-10 11:53:42 DEBUG (MainThread) [bellows.uart] Sending: b'87009f7e'
2019-03-10 11:53:42 DEBUG (MainThread) [bellows.ezsp] Application frame 63 (messageSentHandler) received
2019-03-10 11:53:42 DEBUG (MainThread) [custom_components.zha.core.channels] 0xbe9e:1:0x0008: executed command: move_to_level_with_on_off with args: (254, 5) with kwargs: {} and result: [4, <Status.SUCCESS: 0>]
2019-03-10 11:53:42 DEBUG (MainThread) [bellows.ezsp] Send command sendUnicast
2019-03-10 11:53:42 DEBUG (MainThread) [bellows.uart] Sending: b'07d2219c54b4abb658924a24ab1593499c345da8ecb466c24f7e'
2019-03-10 11:53:42 DEBUG (MainThread) [bellows.uart] Data frame: b'71d2a19c54ee324c7e'
2019-03-10 11:53:42 DEBUG (MainThread) [bellows.uart] Sending: b'8070787e'
2019-03-10 11:53:42 DEBUG (MainThread) [bellows.ezsp] Application frame 52 (sendUnicast) received
2019-03-10 11:53:42 DEBUG (MainThread) [bellows.uart] Data frame: b'01d2b1f1ca94ded3696ab572a1556d809c69b47e'
2019-03-10 11:53:42 DEBUG (MainThread) [bellows.uart] Sending: b'8160597e'
2019-03-10 11:53:42 DEBUG (MainThread) [bellows.ezsp] Application frame 89 (incomingRouteRecordHandler) received
2019-03-10 11:53:42 DEBUG (MainThread) [bellows.uart] Data frame: b'11d2b1f1ca94ded3696ab572a1556d809c77b57e'
2019-03-10 11:53:42 DEBUG (MainThread) [bellows.uart] Sending: b'82503a7e'
2019-03-10 11:53:42 DEBUG (MainThread) [bellows.ezsp] Application frame 89 (incomingRouteRecordHandler) received
2019-03-10 11:53:42 DEBUG (MainThread) [bellows.uart] Data frame: b'21d2b1ed542e14b459954b65ab5592dd6387b9151231628387cd62894d267e'
2019-03-10 11:53:42 DEBUG (MainThread) [bellows.uart] Sending: b'83401b7e'
2019-03-10 11:53:42 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received
2019-03-10 11:53:42 DEBUG (MainThread) [bellows.uart] Data frame: b'31d2b19754b4abb658924a24ab1593499c8a5dabed65db7e'
2019-03-10 11:53:42 DEBUG (MainThread) [bellows.uart] Sending: b'8430fc7e'
2019-03-10 11:53:42 DEBUG (MainThread) [bellows.ezsp] Application frame 63 (messageSentHandler) received
2019-03-10 11:53:42 DEBUG (MainThread) [custom_components.zha.core.channels] 0xbe9e:1:0x0006: executed command: on with args: () with kwargs: {} and result: [1, <Status.SUCCESS: 0>]

Successful color Temperature call:

2019-03-10 11:53:50 DEBUG (MainThread) [bellows.ezsp] Send command sendUnicast
2019-03-10 11:53:50 DEBUG (MainThread) [bellows.uart] Sending: b'14d3219c54b4abb658924a24ab1593499c355ca8ecb566ec3c7e'
2019-03-10 11:53:50 DEBUG (MainThread) [bellows.uart] Data frame: b'42d3a19c54ef69507e'
2019-03-10 11:53:50 DEBUG (MainThread) [bellows.uart] Sending: b'8520dd7e'
2019-03-10 11:53:50 DEBUG (MainThread) [bellows.ezsp] Application frame 52 (sendUnicast) received
2019-03-10 11:53:50 DEBUG (MainThread) [bellows.uart] Data frame: b'52d3b1f1ca94ded3696ab572a1556d809c96b37e'
2019-03-10 11:53:50 DEBUG (MainThread) [bellows.uart] Sending: b'8610be7e'
2019-03-10 11:53:50 DEBUG (MainThread) [bellows.ezsp] Application frame 89 (incomingRouteRecordHandler) received
2019-03-10 11:53:50 DEBUG (MainThread) [bellows.uart] Data frame: b'62d3b1f1ca94ded3696ab572a1556d819c87817e'
2019-03-10 11:53:50 DEBUG (MainThread) [bellows.uart] Sending: b'87009f7e'
2019-03-10 11:53:50 DEBUG (MainThread) [bellows.ezsp] Application frame 89 (incomingRouteRecordHandler) received
2019-03-10 11:53:50 DEBUG (MainThread) [bellows.uart] Data frame: b'72d3b1ed542e14b459954b65ab5592dc6387b9151231628386cd6289db007e'
2019-03-10 11:53:50 DEBUG (MainThread) [bellows.uart] Sending: b'8070787e'
2019-03-10 11:53:50 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received
2019-03-10 11:53:50 DEBUG (MainThread) [bellows.uart] Data frame: b'02d3b19754b4abb658924a24ab1593499c8b5cabedfca17e'
2019-03-10 11:53:50 DEBUG (MainThread) [bellows.uart] Sending: b'8160597e'
2019-03-10 11:53:50 DEBUG (MainThread) [bellows.ezsp] Application frame 63 (messageSentHandler) received
2019-03-10 11:53:50 DEBUG (MainThread) [custom_components.zha.core.channels] 0xbe9e:1:0x0006: executed command: on with args: () with kwargs: {} and result: [1, <Status.SUCCESS: 0>]
2019-03-10 11:53:50 DEBUG (MainThread) [bellows.ezsp] Send command sendUnicast
2019-03-10 11:53:50 DEBUG (MainThread) [bellows.uart] Sending: b'21d0219c54b4abb658944924ab1593499c325bacecb26da0ffc36398347e'
2019-03-10 11:53:50 DEBUG (MainThread) [bellows.uart] Data frame: b'13d0a19c54ec82d57e'
2019-03-10 11:53:50 DEBUG (MainThread) [bellows.uart] Sending: b'82503a7e'
2019-03-10 11:53:50 DEBUG (MainThread) [bellows.ezsp] Application frame 52 (sendUnicast) received
2019-03-10 11:53:50 DEBUG (MainThread) [bellows.uart] Data frame: b'23d0b1f1ca94ded3696ab572a1556d809c341b7e'
2019-03-10 11:53:50 DEBUG (MainThread) [bellows.uart] Sending: b'83401b7e'
2019-03-10 11:53:50 DEBUG (MainThread) [bellows.ezsp] Application frame 89 (incomingRouteRecordHandler) received
2019-03-10 11:53:50 DEBUG (MainThread) [bellows.uart] Data frame: b'33d0b1f1ca94ded3696ab572a1556d809c2a1a7e'
2019-03-10 11:53:50 DEBUG (MainThread) [bellows.uart] Sending: b'8430fc7e'
2019-03-10 11:53:50 DEBUG (MainThread) [bellows.ezsp] Application frame 89 (incomingRouteRecordHandler) received
2019-03-10 11:53:50 DEBUG (MainThread) [bellows.uart] Data frame: b'43d0b1ed542e14b25a954b65ab5592df6387b9151231628381cd6989bbe97e'
2019-03-10 11:53:50 DEBUG (MainThread) [bellows.uart] Sending: b'8520dd7e'
2019-03-10 11:53:50 DEBUG (MainThread) [bellows.ezsp] Application frame 69 (incomingMessageHandler) received
2019-03-10 11:53:50 DEBUG (MainThread) [bellows.uart] Data frame: b'53d0b19754b4abb658944924ab1593499c885babed8fb17e'
2019-03-10 11:53:50 DEBUG (MainThread) [bellows.uart] Sending: b'8610be7e'
2019-03-10 11:53:50 DEBUG (MainThread) [bellows.ezsp] Application frame 63 (messageSentHandler) received
2019-03-10 11:53:50 DEBUG (MainThread) [custom_components.zha.core.channels] 0xbe9e:1:0x0300: executed command: move_to_color_temp with args: (555, 5) with kwargs: {} and result: [10, <Status.SUCCESS: 0>]

About this issue

Original URL
State: closed
Created 5 years ago
Reactions: 1
Comments: 45 (25 by maintainers)

Most upvoted comments

Even if doing transition, that’s 1 message per sec.

Adminiuga on Nov 19, 2020

Seems like I have the same issue as described here. My lighting setup consists of Ikea lights both rgb and color temperature bulbs. They are connected through deconz using the raspberry pi shield.

My observation after reading this thread and testing it myself after having trouble with a scene, is that as soon as I set the transition to 0 the bulb changes brightness and color at the same time. Just tested this a few times but it seems reliable. But as @lwis said, in the phoscon app the scenes do work as expected.

Edit: running latest 0.96.2 version of HA

Torrenator on Jul 21, 2019

My latest experience is positive.
I am using Hassio with HA 0.94.2 and ZHA seems to be working a lot better. I did a fresh install in my Dev environment, but I only have Philips Hue globes to test with there. Everything is working as expected and stable, at least for now. Hopefully it will remain stable.

My DEV environment is using Home Assistant via HASSIO on a Raspberry Pi 3B+ with a Digi XSTICK2 (XBEE) USB Stick for ZHA and AEOTEK Z-Stick 5 for Z-Wave. Not sure if there is a difference for this using different sticks, but it seems fine with Xbee.

ghost on Jun 13, 2019

Try the current beta. The UI is still a bit jumpy but it’s all functional now.

dmulcahey on Mar 30, 2019