[SOLVED] How do I get Danfoss Ally thermostat exposed in HA from deCONZ?

Nosalismus · November 28, 2020, 12:01am

thx again for your answer. I went with it and bought a Ally device. Managed to set it up through deCONZ and it shows in HA. So far, so good.

But when trying to change the target temperature in HA the thermostat doesn’t respond with the motor adjusting the valve. But when doing in manually on the thermostat, you can hear the motor spinning. So there is something not working properly. Because when I set the target temperature in HA, the thermostat picks it up on the display, but again, the motor is not spinning. Can you adjust the target temperature in HA without any problems?

Robban · November 28, 2020, 7:29am

I’m working on improving climate control right now in preparation for next release so if you can share more details we can make sure everything works as expected

Nosalismus · November 28, 2020, 9:39am

The above mentioned issue is not the only one. Also when clicking on the different options on the climate control card I get errors, eg. turning off the thermostat.

This is from the log reporting the error:

Logger: homeassistant.components.websocket_api.http.connection
Source: components/deconz/climate.py:115
Integration: Home Assistant WebSocket API (documentation, issues)
First occurred: November 27, 2020, 3:13:47 PM (114 occurrences)
Last logged: 10:34:37 AM

[548413826816] /sensors/4/config/mode parameter, mode, not available

[548279578048] /sensors/4/config/mode parameter, mode, not available

[548277327184] /sensors/4/config/mode parameter, mode, not available

[548279555552] /sensors/4/config/mode parameter, mode, not available

Traceback (most recent call last): File “/usr/src/homeassistant/homeassistant/components/websocket_api/commands.py”, line 135, in handle_call_service await hass.services.async_call( File “/usr/src/homeassistant/homeassistant/core.py”, line 1451, in async_call task.result() File “/usr/src/homeassistant/homeassistant/core.py”, line 1486, in _execute_service await handler.job.target(service_call) File “/usr/src/homeassistant/homeassistant/helpers/entity_component.py”, line 204, in handle_service await self.hass.helpers.service.entity_service_call( File “/usr/src/homeassistant/homeassistant/helpers/service.py”, line 499, in entity_service_call future.result() # pop exception if have File “/usr/src/homeassistant/homeassistant/helpers/entity.py”, line 664, in async_request_call await coro File “/usr/src/homeassistant/homeassistant/helpers/service.py”, line 536, in _handle_entity_call await result File “/usr/src/homeassistant/homeassistant/components/deconz/climate.py”, line 115, in async_set_hvac_mode await self._device.async_set_config(data) File “/usr/local/lib/python3.8/site-packages/pydeconz/deconzdevice.py”, line 30, in async_set_config await self.async_set(field, data) File “/usr/local/lib/python3.8/site-packages/pydeconz/api.py”, line 112, in async_set await self._request(“put”, field, json=data) File “/usr/local/lib/python3.8/site-packages/pydeconz/gateway.py”, line 106, in request _raise_on_error(response) File “/usr/local/lib/python3.8/site-packages/pydeconz/gateway.py”, line 220, in _raise_on_error raise_error(data[“error”]) File “/usr/local/lib/python3.8/site-packages/pydeconz/errors.py”, line 58, in raise_error raise cls(“{} {}”.format(error[“address”], error[“description”])) pydeconz.errors.RequestError: /sensors/4/config/mode parameter, mode, not available

Robban · November 28, 2020, 10:02am

Can you enable debug logging and share what the device definition looks like?

PerJ · November 28, 2020, 10:03am

Hi,
I have bought my first Danfoss Ally, in order to check it out with deConz and HA.
I have successfully added it as a sensor through the Phoscon web interface.

I can alter the temperature through the webinterface - but the 3 small icons below the orange “circle” result in errors when clicked

If a developer needs help debugging issues, I will help
Regards
Per

Nosalismus · November 28, 2020, 10:42am

What kind of debugging option are you interested in?

dbg_info

dbg_aps

dbg_otau

dbg_zcl

dbg_zdp

Robban · November 28, 2020, 11:59am

Hass debug. Check deconz integration documentation for example

PerJ · November 28, 2020, 12:28pm

@Robban - clicking on the on/off button shown in the screenshot above, the following error is shown in the homeassistant docker log:

2020-11-28 13:24:32 DEBUG (MainThread) [pydeconz.gateway] Sending "put" "{'mode': 'off'}" to "172.30.33.0 /sensors/30/config"
2020-11-28 13:24:32 DEBUG (MainThread) [pydeconz.gateway] HTTP request response: [{'error': {'address': '/sensors/30/config/mode',
            'description': 'parameter, mode, not available',
            'type': 6}}]
2020-11-28 13:24:32 ERROR (MainThread) [homeassistant.components.websocket_api.http.connection] [139702468536832] /sensors/30/config/mode parameter, mode, not available
Traceback (most recent call last):
  File "/usr/src/homeassistant/homeassistant/components/websocket_api/commands.py", line 135, in handle_call_service
    await hass.services.async_call(
  File "/usr/src/homeassistant/homeassistant/core.py", line 1451, in async_call
    task.result()
  File "/usr/src/homeassistant/homeassistant/core.py", line 1486, in _execute_service
    await handler.job.target(service_call)
  File "/usr/src/homeassistant/homeassistant/helpers/entity_component.py", line 204, in handle_service
    await self.hass.helpers.service.entity_service_call(
  File "/usr/src/homeassistant/homeassistant/helpers/service.py", line 499, in entity_service_call
    future.result()  # pop exception if have
  File "/usr/src/homeassistant/homeassistant/helpers/entity.py", line 664, in async_request_call
    await coro
  File "/usr/src/homeassistant/homeassistant/helpers/service.py", line 536, in _handle_entity_call
    await result
  File "/usr/src/homeassistant/homeassistant/components/deconz/climate.py", line 115, in async_set_hvac_mode
    await self._device.async_set_config(data)
  File "/usr/local/lib/python3.8/site-packages/pydeconz/deconzdevice.py", line 30, in async_set_config
    await self.async_set(field, data)
  File "/usr/local/lib/python3.8/site-packages/pydeconz/api.py", line 112, in async_set
    await self._request("put", field, json=data)
  File "/usr/local/lib/python3.8/site-packages/pydeconz/gateway.py", line 106, in request
    _raise_on_error(response)
  File "/usr/local/lib/python3.8/site-packages/pydeconz/gateway.py", line 220, in _raise_on_error
    raise_error(data["error"])
  File "/usr/local/lib/python3.8/site-packages/pydeconz/errors.py", line 58, in raise_error
    raise cls("{} {}".format(error["address"], error["description"]))
pydeconz.errors.RequestError: /sensors/30/config/mode parameter, mode, not available

Robban · November 28, 2020, 5:23pm

OK, I need debug logs for deconz integration to understand more, though I think that error message is actually an issue in deconz itself.

Nosalismus · November 28, 2020, 8:23pm

This is what I get when clicking the buttons on the climate card when debugging in deCONZ. Only filtered ‘ERROR’ and ‘ERROR_L2’. Udklip-deconz-debug-errors

Robban · November 28, 2020, 9:31pm

Talking with deconz deva and it seems you can’t change mode on that device. So I need to figure out how to handle that.

How’d it going with those debug logs?

PerJ · November 29, 2020, 1:13pm

I have enabled all debug settings in the deConz Ha module:
dbg_info: 1
dbg_aps: 1
dbg_otau: 1
dbg_zcl: 1
dbg_zdp: 1

the errors in the deConz container are these:


020-11-29 13:53:04 DEBUG (MainThread) [pydeconz.gateway] Sending "put" "{'mode': 'auto'}" to "172.30.33.0 /sensors/30/config"
2020-11-29 13:53:04 DEBUG (MainThread) [pydeconz.gateway] HTTP request response: [{'error': {'address': '/sensors/30/config/mode',
            'description': 'parameter, mode, not available',
            'type': 6}}]
2020-11-29 13:53:04 ERROR (MainThread) [homeassistant.components.websocket_api.http.connection] [139702328135632] /sensors/30/config/mode parameter, mode, not available
Traceback (most recent call last):
  File "/usr/src/homeassistant/homeassistant/components/websocket_api/commands.py", line 135, in handle_call_service
    await hass.services.async_call(
  File "/usr/src/homeassistant/homeassistant/core.py", line 1451, in async_call
    task.result()
  File "/usr/src/homeassistant/homeassistant/core.py", line 1486, in _execute_service
    await handler.job.target(service_call)
  File "/usr/src/homeassistant/homeassistant/helpers/entity_component.py", line 204, in handle_service
    await self.hass.helpers.service.entity_service_call(
  File "/usr/src/homeassistant/homeassistant/helpers/service.py", line 499, in entity_service_call
    future.result()  # pop exception if have
  File "/usr/src/homeassistant/homeassistant/helpers/entity.py", line 664, in async_request_call
    await coro
  File "/usr/src/homeassistant/homeassistant/helpers/service.py", line 536, in _handle_entity_call
    await result
  File "/usr/src/homeassistant/homeassistant/components/deconz/climate.py", line 115, in async_set_hvac_mode
    await self._device.async_set_config(data)
  File "/usr/local/lib/python3.8/site-packages/pydeconz/deconzdevice.py", line 30, in async_set_config
    await self.async_set(field, data)
  File "/usr/local/lib/python3.8/site-packages/pydeconz/api.py", line 112, in async_set
    await self._request("put", field, json=data)
  File "/usr/local/lib/python3.8/site-packages/pydeconz/gateway.py", line 106, in request
    _raise_on_error(response)
  File "/usr/local/lib/python3.8/site-packages/pydeconz/gateway.py", line 220, in _raise_on_error
    raise_error(data["error"])
  File "/usr/local/lib/python3.8/site-packages/pydeconz/errors.py", line 58, in raise_error
    raise cls("{} {}".format(error["address"], error["description"]))
pydeconz.errors.RequestError: /sensors/30/config/mode parameter, mode, not available
2020-11-29 13:53:05 DEBUG (MainThread) [pydeconz.websocket] {"config":{"battery":94,"on":true,"reachable":true},"e":"changed","id":"21","r":"sensors","t":"event","uniqueid":"00:0d:6f:00:14:f6:cb:f3-01-0500"}
2020-11-29 13:53:05 DEBUG (MainThread) [pydeconz.gateway] Sending "put" "{'mode': 'heat'}" to "172.30.33.0 /sensors/30/config"
2020-11-29 13:53:05 DEBUG (MainThread) [pydeconz.gateway] HTTP request response: [{'error': {'address': '/sensors/30/config/mode',
            'description': 'parameter, mode, not available',
            'type': 6}}]
2020-11-29 13:53:05 ERROR (MainThread) [homeassistant.components.websocket_api.http.connection] [139702328135632] /sensors/30/config/mode parameter, mode, not available
Traceback (most recent call last):
  File "/usr/src/homeassistant/homeassistant/components/websocket_api/commands.py", line 135, in handle_call_service
    await hass.services.async_call(
  File "/usr/src/homeassistant/homeassistant/core.py", line 1451, in async_call
    task.result()
  File "/usr/src/homeassistant/homeassistant/core.py", line 1486, in _execute_service
    await handler.job.target(service_call)
  File "/usr/src/homeassistant/homeassistant/helpers/entity_component.py", line 204, in handle_service
    await self.hass.helpers.service.entity_service_call(
  File "/usr/src/homeassistant/homeassistant/helpers/service.py", line 499, in entity_service_call
    future.result()  # pop exception if have
  File "/usr/src/homeassistant/homeassistant/helpers/entity.py", line 664, in async_request_call
    await coro
  File "/usr/src/homeassistant/homeassistant/helpers/service.py", line 536, in _handle_entity_call
    await result
  File "/usr/src/homeassistant/homeassistant/components/deconz/climate.py", line 115, in async_set_hvac_mode
    await self._device.async_set_config(data)
  File "/usr/local/lib/python3.8/site-packages/pydeconz/deconzdevice.py", line 30, in async_set_config
    await self.async_set(field, data)
  File "/usr/local/lib/python3.8/site-packages/pydeconz/api.py", line 112, in async_set
    await self._request("put", field, json=data)
  File "/usr/local/lib/python3.8/site-packages/pydeconz/gateway.py", line 106, in request
    _raise_on_error(response)
  File "/usr/local/lib/python3.8/site-packages/pydeconz/gateway.py", line 220, in _raise_on_error
    raise_error(data["error"])
  File "/usr/local/lib/python3.8/site-packages/pydeconz/errors.py", line 58, in raise_error
    raise cls("{} {}".format(error["address"], error["description"]))
pydeconz.errors.RequestError: /sensors/30/config/mode parameter, mode, not available
2020-11-29 13:53:06 DEBUG (MainThread) [pydeconz.gateway] Sending "put" "{'mode': 'off'}" to "172.30.33.0 /sensors/30/config"
2020-11-29 13:53:06 DEBUG (MainThread) [pydeconz.gateway] HTTP request response: [{'error': {'address': '/sensors/30/config/mode',
            'description': 'parameter, mode, not available',
            'type': 6}}]
2020-11-29 13:53:06 ERROR (MainThread) [homeassistant.components.websocket_api.http.connection] [139702328135632] /sensors/30/config/mode parameter, mode, not available
Traceback (most recent call last):
  File "/usr/src/homeassistant/homeassistant/components/websocket_api/commands.py", line 135, in handle_call_service
    await hass.services.async_call(
  File "/usr/src/homeassistant/homeassistant/core.py", line 1451, in async_call
    task.result()
  File "/usr/src/homeassistant/homeassistant/core.py", line 1486, in _execute_service
    await handler.job.target(service_call)
  File "/usr/src/homeassistant/homeassistant/helpers/entity_component.py", line 204, in handle_service
    await self.hass.helpers.service.entity_service_call(
  File "/usr/src/homeassistant/homeassistant/helpers/service.py", line 499, in entity_service_call
    future.result()  # pop exception if have
  File "/usr/src/homeassistant/homeassistant/helpers/entity.py", line 664, in async_request_call
    await coro
  File "/usr/src/homeassistant/homeassistant/helpers/service.py", line 536, in _handle_entity_call
    await result
  File "/usr/src/homeassistant/homeassistant/components/deconz/climate.py", line 115, in async_set_hvac_mode
    await self._device.async_set_config(data)
  File "/usr/local/lib/python3.8/site-packages/pydeconz/deconzdevice.py", line 30, in async_set_config
    await self.async_set(field, data)
  File "/usr/local/lib/python3.8/site-packages/pydeconz/api.py", line 112, in async_set
    await self._request("put", field, json=data)
  File "/usr/local/lib/python3.8/site-packages/pydeconz/gateway.py", line 106, in request
    _raise_on_error(response)
  File "/usr/local/lib/python3.8/site-packages/pydeconz/gateway.py", line 220, in _raise_on_error
    raise_error(data["error"])
  File "/usr/local/lib/python3.8/site-packages/pydeconz/errors.py", line 58, in raise_error
    raise cls("{} {}".format(error["address"], error["description"]))
pydeconz.errors.RequestError: /sensors/30/config/mode parameter, mode, not available
2020-11-29 13:53:08 DEBUG (MainThread) [pydeconz.gateway] Sending "put" "{'mode': 'off'}" to "172.30.33.0 /sensors/30/config"
2020-11-29 13:53:08 DEBUG (MainThread) [pydeconz.gateway] HTTP request response: [{'error': {'address': '/sensors/30/config/mode',
            'description': 'parameter, mode, not available',
            'type': 6}}]
2020-11-29 13:53:08 ERROR (MainThread) [homeassistant.components.websocket_api.http.connection] [139702328135632] /sensors/30/config/mode parameter, mode, not available
Traceback (most recent call last):
  File "/usr/src/homeassistant/homeassistant/components/websocket_api/commands.py", line 135, in handle_call_service
    await hass.services.async_call(
  File "/usr/src/homeassistant/homeassistant/core.py", line 1451, in async_call
    task.result()
  File "/usr/src/homeassistant/homeassistant/core.py", line 1486, in _execute_service
    await handler.job.target(service_call)
  File "/usr/src/homeassistant/homeassistant/helpers/entity_component.py", line 204, in handle_service
    await self.hass.helpers.service.entity_service_call(
  File "/usr/src/homeassistant/homeassistant/helpers/service.py", line 499, in entity_service_call
    future.result()  # pop exception if have
  File "/usr/src/homeassistant/homeassistant/helpers/entity.py", line 664, in async_request_call
    await coro
  File "/usr/src/homeassistant/homeassistant/helpers/service.py", line 536, in _handle_entity_call
    await result
  File "/usr/src/homeassistant/homeassistant/components/deconz/climate.py", line 115, in async_set_hvac_mode
    await self._device.async_set_config(data)
  File "/usr/local/lib/python3.8/site-packages/pydeconz/deconzdevice.py", line 30, in async_set_config
    await self.async_set(field, data)
  File "/usr/local/lib/python3.8/site-packages/pydeconz/api.py", line 112, in async_set
    await self._request("put", field, json=data)
  File "/usr/local/lib/python3.8/site-packages/pydeconz/gateway.py", line 106, in request
    _raise_on_error(response)
  File "/usr/local/lib/python3.8/site-packages/pydeconz/gateway.py", line 220, in _raise_on_error
    raise_error(data["error"])
  File "/usr/local/lib/python3.8/site-packages/pydeconz/errors.py", line 58, in raise_error
    raise cls("{} {}".format(error["address"], error["description"]))
pydeconz.errors.RequestError: /sensors/30/config/mode parameter, mode, not available
2020-11-29 13:53:09 DEBUG (MainThread) [pydeconz.gateway] Sending "put" "{'mode': 'off'}" to "172.30.33.0 /sensors/30/config"
2020-11-29 13:53:09 DEBUG (MainThread) [pydeconz.gateway] HTTP request response: [{'error': {'address': '/sensors/30/config/mode',
            'description': 'parameter, mode, not available',
            'type': 6}}]
2020-11-29 13:53:09 ERROR (MainThread) [homeassistant.components.websocket_api.http.connection] [139702328135632] /sensors/30/config/mode parameter, mode, not available
Traceback (most recent call last):
  File "/usr/src/homeassistant/homeassistant/components/websocket_api/commands.py", line 135, in handle_call_service
    await hass.services.async_call(
  File "/usr/src/homeassistant/homeassistant/core.py", line 1451, in async_call
    task.result()
  File "/usr/src/homeassistant/homeassistant/core.py", line 1486, in _execute_service
    await handler.job.target(service_call)
  File "/usr/src/homeassistant/homeassistant/helpers/entity_component.py", line 204, in handle_service
    await self.hass.helpers.service.entity_service_call(
  File "/usr/src/homeassistant/homeassistant/helpers/service.py", line 499, in entity_service_call
    future.result()  # pop exception if have
  File "/usr/src/homeassistant/homeassistant/helpers/entity.py", line 664, in async_request_call
    await coro
  File "/usr/src/homeassistant/homeassistant/helpers/service.py", line 536, in _handle_entity_call
    await result
  File "/usr/src/homeassistant/homeassistant/components/deconz/climate.py", line 115, in async_set_hvac_mode
    await self._device.async_set_config(data)
  File "/usr/local/lib/python3.8/site-packages/pydeconz/deconzdevice.py", line 30, in async_set_config
    await self.async_set(field, data)
  File "/usr/local/lib/python3.8/site-packages/pydeconz/api.py", line 112, in async_set
    await self._request("put", field, json=data)
  File "/usr/local/lib/python3.8/site-packages/pydeconz/gateway.py", line 106, in request
    _raise_on_error(response)
  File "/usr/local/lib/python3.8/site-packages/pydeconz/gateway.py", line 220, in _raise_on_error
    raise_error(data["error"])
  File "/usr/local/lib/python3.8/site-packages/pydeconz/errors.py", line 58, in raise_error
    raise cls("{} {}".format(error["address"], error["description"]))
pydeconz.errors.RequestError: /sensors/30/config/mode parameter, mode, not available
2020-11-29 13:53:10 DEBUG (MainThread) [pydeconz.websocket] {"e":"changed","id":"5","r":"sensors","state":{"dark":true,"daylight":false,"lastupdated":"2020-11-29T12:53:10.735","lightlevel":11140,"lux":13},"t":"event","uniqueid":"00:15:8d:00:02:78:b6:eb-01-0400"}
2020-11-29 13:53:10 DEBUG (MainThread) [pydeconz.websocket] {"e":"changed","id":"6","r":"sensors","state":{"lastupdated":"2020-11-29T12:53:10.739","presence":true},"t":"event","uniqueid":"00:15:8d:00:02:78:b6:eb-01-0406"}

Robban · November 29, 2020, 1:22pm

Thanks but that won’t do. You need to enable debugging in hass for the deconz integration.

logger:
  default: info
  logs:
    pydeconz: debug
    homeassistant.components.deconz: debug

PerJ · November 29, 2020, 1:29pm

I already had those settings in hass, but grepped on the output, so didn’t see anything Here is the output from the hass container:

020-11-29 14:27:19 DEBUG (MainThread) [pydeconz.gateway] Sending "put" "{'mode': 'auto'}" to "172.30.33.0 /sensors/30/config"
2020-11-29 14:27:19 DEBUG (MainThread) [pydeconz.gateway] HTTP request response: [{'error': {'address': '/sensors/30/config/mode',
            'description': 'parameter, mode, not available',
            'type': 6}}]
2020-11-29 14:27:19 ERROR (MainThread) [homeassistant.components.websocket_api.http.connection] [139702328135632] /sensors/30/config/mode parameter, mode, not available
Traceback (most recent call last):
  File "/usr/src/homeassistant/homeassistant/components/websocket_api/commands.py", line 135, in handle_call_service
    await hass.services.async_call(
  File "/usr/src/homeassistant/homeassistant/core.py", line 1451, in async_call
    task.result()
  File "/usr/src/homeassistant/homeassistant/core.py", line 1486, in _execute_service
    await handler.job.target(service_call)
  File "/usr/src/homeassistant/homeassistant/helpers/entity_component.py", line 204, in handle_service
    await self.hass.helpers.service.entity_service_call(
  File "/usr/src/homeassistant/homeassistant/helpers/service.py", line 499, in entity_service_call
    future.result()  # pop exception if have
  File "/usr/src/homeassistant/homeassistant/helpers/entity.py", line 664, in async_request_call
    await coro
  File "/usr/src/homeassistant/homeassistant/helpers/service.py", line 536, in _handle_entity_call
    await result
  File "/usr/src/homeassistant/homeassistant/components/deconz/climate.py", line 115, in async_set_hvac_mode
    await self._device.async_set_config(data)
  File "/usr/local/lib/python3.8/site-packages/pydeconz/deconzdevice.py", line 30, in async_set_config
    await self.async_set(field, data)
  File "/usr/local/lib/python3.8/site-packages/pydeconz/api.py", line 112, in async_set
    await self._request("put", field, json=data)
  File "/usr/local/lib/python3.8/site-packages/pydeconz/gateway.py", line 106, in request
    _raise_on_error(response)
  File "/usr/local/lib/python3.8/site-packages/pydeconz/gateway.py", line 220, in _raise_on_error
    raise_error(data["error"])
  File "/usr/local/lib/python3.8/site-packages/pydeconz/errors.py", line 58, in raise_error
    raise cls("{} {}".format(error["address"], error["description"]))
pydeconz.errors.RequestError: /sensors/30/config/mode parameter, mode, not available
2020-11-29 14:27:20 DEBUG (MainThread) [pydeconz.websocket] {"e":"changed","id":"12","r":"sensors","state":{"dark":false,"daylight":false,"lastupdated":"2020-11-29T13:27:20.223","lightlevel":15798,"lux":38},"t":"event","uniqueid":"00:15:8d:00:02:75:2b:a1-01-0400"}
2020-11-29 14:27:20 DEBUG (MainThread) [pydeconz.websocket] {"attr":{"colorcapabilities":0,"ctmax":65279,"ctmin":0,"id":"8","lastannounced":"2020-10-25T15:26:27Z","lastseen":"2020-11-29T13:27Z","manufacturername":"IKEA of Sweden","modelid":"TRADFRI bulb GU10 WS 400lm","name":"gæsteværelse_seng","swversion":"2.0.022","type":"Color temperature light","uniqueid":"68:0a:e2:ff:fe:13:66:c2-01"},"e":"changed","id":"8","r":"lights","t":"event","uniqueid":"68:0a:e2:ff:fe:13:66:c2-01"}
2020-11-29 14:27:20 DEBUG (MainThread) [pydeconz.websocket] {"e":"changed","id":"13","r":"sensors","state":{"lastupdated":"2020-11-29T13:27:20.283","presence":true},"t":"event","uniqueid":"00:15:8d:00:02:75:2b:a1-01-0406"}
2020-11-29 14:27:20 DEBUG (MainThread) [pydeconz.websocket] {"attr":{"colorcapabilities":0,"ctmax":65279,"ctmin":0,"id":"33","lastannounced":"2020-11-26T16:22:37Z","lastseen":"2020-11-29T13:27Z","manufacturername":"IKEA of Sweden","modelid":"TRADFRI bulb GU10 WS 400lm","name":"Bryggers: yderdør","powerup":7,"swversion":"2.0.029","type":"Color temperature light","uniqueid":"ec:1b:bd:ff:fe:a2:e3:41-01"},"e":"changed","id":"33","r":"lights","t":"event","uniqueid":"ec:1b:bd:ff:fe:a2:e3:41-01"}
^C

Robban · November 29, 2020, 1:41pm

During startup the devices are listed from Deconz rest api. Can you share that data with me?

PerJ · November 29, 2020, 2:30pm

There is quite a lot of data, can I email the file to you ?, apparently I cannot attach the log file to this post ?

The sensor to look for is “Thermostat_stue_sofa”

15:17:16:417 APS-DATA.confirm request id: 57 -> confirmed, timeout 1606659436
15:17:16:451 APS-DATA.indication srcAddr: 0xe3b2, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 255, rssi: -47
15:17:16:452 APS-DATA.indication request id: 57 -> finished
15:17:16:452 APS-DATA.request id: 57 erase from queue
15:17:16:452 ZDP status = 0x00 -> SUCCESS
15:17:16:452 ZDP Mgmt_Lqi_rsp zdpSeq: 5 from 0x000B3CFFFEFCC7A2 total: 18, startIndex: 3, listCount: 3
15:17:16:452     * neighbor: 0x000D6FFFFEF3264E (0x50F7), LQI: 32, relation: 0x02 rxOnWHenIdle: 1
15:17:16:452     * neighbor: 0xEC1BBDFFFEA2E341 (0x6487), LQI: 79, relation: 0x02 rxOnWHenIdle: 1
15:17:16:453     * neighbor: 0x680AE2FFFE1A946F (0x804C), LQI: 107, relation: 0x02 rxOnWHenIdle: 1
15:17:16:966   >>> ZHATime sensor Thermostat_stue_sofa: set READ_TIME from checkSensorNodeReachable()
15:17:16:970 APS-DATA.confirm id: 25, status: 0x00 SUCCESS
15:17:16:970 APS-DATA.confirm request id: 25 -> erase from queue
15:17:17:036 aps request id: 25 finished, erase from queue
15:17:17:432   >>> ZHATime sensor Thermostat_stue_sofa: exec READ_TIME
15:17:17:432   >>> ZHATime sensor Thermostat_stue_sofa: clear READ_TIME
15:17:17:433 APS-DATA.request id: 63, addrmode: 0x03, addr: 0x14b457fffed54e77, profile: 0x0104, cluster: 0x000A, ep: 0x01 -> 0x01 queue: 1 len: 9 tx.options 0x00
15:17:17:476   >>> ZHATime sensor Thermostat_stue_sofa: set READ_TIME from checkSensorNodeReachable()
15:17:17:480 APS-DATA.indication srcAddr: 0x127e, srcEp: 0x01 dstAddrMode: 2, profile: 0x0104, cluster: 0x000A, lqi: 255, rssi: -51
15:17:17:480 ZCL got data for node=0x127E, cl=0x000A, at=0x0000, status=0x00, type=0xE2
15:17:17:481 ZCL got data for node=0x127E, cl=0x000A, at=0x0007, status=0x00, type=0x23
15:17:17:481 ZCL got data for node=0x127E, cl=0x000A, at=0x0008, status=0x00, type=0xE2
15:17:17:482   >>> ZHATime sensor Thermostat_stue_sofa: drift -4
15:17:17:488 Websocket disconnected 172.30.32.1:53190, state: 0, close-code: 1000, reason: 
15:17:17:988 APS-DATA.confirm id: 63, status: 0x00 SUCCESS
15:17:17:988 APS-DATA.confirm request id: 63 -> erase from queue
15:17:17:996 aps request id: 63 finished, erase from queue
15:17:18:490 APS-DATA.indication srcAddr: 0x127e, srcEp: 0x01 dstAddrMode: 2, profile: 0x0104, cluster: 0x000A, lqi: 255, rssi: -51
15:17:18:491 ZCL got data for node=0x127E, cl=0x000A, at=0x0000, status=0x00, type=0xE2
15:17:18:491 ZCL got data for node=0x127E, cl=0x000A, at=0x0007, status=0x00, type=0x23
15:17:18:491 ZCL got data for node=0x127E, cl=0x000A, at=0x0008, status=0x00, type=0xE2
15:17:18:491   >>> ZHATime sensor Thermostat_stue_sofa: drift -4
15:17:18:932   >>> ZHATime sensor Thermostat_stue_sofa: exec READ_TIME
15:17:18:933   >>> ZHATime sensor Thermostat_stue_sofa: clear READ_TIME
15:17:18:933 APS-DATA.request id: 72, addrmode: 0x03, addr: 0x14b457fffed54e77, profile: 0x0104, cluster: 0x000A, ep: 0x01 -> 0x01 queue: 1 len: 9 tx.options 0x00
15:17:19:003 APS-DATA.confirm id: 72, status: 0x00 SUCCESS
15:17:19:003 APS-DATA.confirm request id: 72 -> erase from queue
15:17:19:036 aps request id: 72 finished, erase from queue
15:17:19:500 APS-DATA.indication srcAddr: 0x127e, srcEp: 0x01 dstAddrMode: 2, profile: 0x0104, cluster: 0x000A, lqi: 255, rssi: -51
15:17:19:500 ZCL got data for node=0x127E, cl=0x000A, at=0x0000, status=0x00, type=0xE2
15:17:19:501 ZCL got data for node=0x127E, cl=0x000A, at=0x0007, status=0x00, type=0x23
15:17:19:501 ZCL got data for node=0x127E, cl=0x000A, at=0x0008, status=0x00, type=0xE2
15:17:19:501   >>> ZHATime sensor Thermostat_stue_sofa: drift -4
15:17:19:836 ZDP active ep request to 0xec1bbdfffea2e341
15:17:19:837 APS-DATA.request id: 78, addrmode: 0x02, addr: 0x6487, profile: 0x0000, cluster: 0x0005, ep: 0x00 -> 0x00 queue: 1 len: 3 tx.options 0x00
15:17:19:837 ZDP send request id: 0x07 to 0xec1bbdfffea2e341
15:17:19:857 APS-DATA.confirm id: 78, status: 0x00 SUCCESS
15:17:19:857 APS-DATA.confirm request id: 78 -> confirmed, timeout 1606659439
15:17:19:873 APS-DATA.indication srcAddr: 0x6487, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8005, lqi: 255, rssi: -52
15:17:19:874 APS-DATA.indication request id: 78 -> finished
15:17:19:874 APS-DATA.request id: 78 erase from queue
15:17:19:875 ZDP status = 0x00 -> SUCCESS
15:17:19:875 ZDP active ep response for 0xec1bbdfffea2e341
15:17:19:875 	ep: 0x01
15:17:19:875 	ep: 0xF2
15:17:20:236 Mgmt_Lqi_req zdpSeq: 7 to 0x000B3CFFFEFCC7A2 start index 6
15:17:20:236 APS-DATA.request id: 82, addrmode: 0x03, addr: 0x000b3cfffefcc7a2, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 1 len: 2 tx.options 0x00
15:17:20:257 APS-DATA.confirm id: 82, status: 0x00 SUCCESS

Robban · November 29, 2020, 4:20pm

That’s deconz data and not from hass logs. You need to look at hass logs

PerJ · November 29, 2020, 4:29pm

oh, sorry - here goes:

Haas container stderr output to screen:

2020-11-29 17:24:49 DEBUG (MainThread) [pydeconz.websocket] Websocket starting
2020-11-29 17:24:49 DEBUG (MainThread) [pydeconz.websocket] Reconnecting to deCONZ in 15.
2020-11-29 17:25:04 DEBUG (MainThread) [pydeconz.websocket] Websocket starting
2020-11-29 17:25:04 DEBUG (MainThread) [pydeconz.websocket] Websocket running
2020-11-29 17:25:04 ERROR (MainThread) [homeassistant.util.logging] Exception in async_update_callback when dispatching 'deconz-reachable-00212E051A53': (True,)
Traceback (most recent call last):
  File "/usr/src/homeassistant/homeassistant/components/deconz/sensor.py", line 135, in async_update_callback
    super().async_update_callback(force_update=force_update)
  File "/usr/src/homeassistant/homeassistant/components/deconz/deconz_device.py", line 93, in async_update_callback
    self.async_write_ha_state()
  File "/usr/src/homeassistant/homeassistant/helpers/entity.py", line 296, in async_write_ha_state
    self._async_write_ha_state()
  File "/usr/src/homeassistant/homeassistant/helpers/entity.py", line 320, in _async_write_ha_state
    sstate = self.state
  File "/usr/src/homeassistant/homeassistant/components/deconz/sensor.py", line 140, in state
    return self._device.state
AttributeError: 'DeconzSensor' object has no attribute 'state'

2020-11-29 17:25:04 DEBUG (MainThread) [pydeconz.gateway] Sending "put" "{'on': True, 'xy': (0.565, 0.344), 'bri': 47, 'transitiontime': 0}" to "172.30.33.0 /lights/28/state"
2020-11-29 17:25:04 DEBUG (MainThread) [pydeconz.gateway] Sending "put" "{'mode': 'heat'}" to "172.30.33.0 /sensors/30/config"
2020-11-29 17:25:04 DEBUG (MainThread) [pydeconz.gateway] HTTP request response: [{'error': {'address': '/lights/28',
            'description': 'resource, /lights/28, not available',
            'type': 3}}]
2020-11-29 17:25:04 DEBUG (MainThread) [pydeconz.gateway] HTTP request response: [{'error': {'address': '/sensors/30/config/mode',
            'description': 'parameter, mode, not available',
            'type': 6}}]
2020-11-29 17:25:04 ERROR (MainThread) [homeassistant.components.websocket_api.http.connection] [139702488506080] /lights/28 resource, /lights/28, not available
Traceback (most recent call last):
  File "/usr/src/homeassistant/homeassistant/components/websocket_api/commands.py", line 135, in handle_call_service
    await hass.services.async_call(
  File "/usr/src/homeassistant/homeassistant/core.py", line 1451, in async_call
    task.result()
  File "/usr/src/homeassistant/homeassistant/core.py", line 1486, in _execute_service
    await handler.job.target(service_call)
  File "/usr/src/homeassistant/homeassistant/helpers/entity_component.py", line 204, in handle_service
    await self.hass.helpers.service.entity_service_call(
  File "/usr/src/homeassistant/homeassistant/helpers/service.py", line 499, in entity_service_call
    future.result()  # pop exception if have
  File "/usr/src/homeassistant/homeassistant/helpers/entity.py", line 664, in async_request_call
    await coro
  File "/usr/src/homeassistant/homeassistant/helpers/service.py", line 536, in _handle_entity_call
    await result
  File "/usr/src/homeassistant/homeassistant/components/homeassistant/scene.py", line 311, in async_activate
    await async_reproduce_state(
  File "/usr/src/homeassistant/homeassistant/helpers/state.py", line 106, in async_reproduce_state
    await asyncio.gather(
  File "/usr/src/homeassistant/homeassistant/helpers/state.py", line 100, in worker
    await platform.async_reproduce_states(  # type: ignore
  File "/usr/src/homeassistant/homeassistant/components/light/reproduce_state.py", line 139, in async_reproduce_states
    await asyncio.gather(
  File "/usr/src/homeassistant/homeassistant/components/light/reproduce_state.py", line 126, in _async_reproduce_state
    await hass.services.async_call(
  File "/usr/src/homeassistant/homeassistant/core.py", line 1451, in async_call
    task.result()
  File "/usr/src/homeassistant/homeassistant/core.py", line 1486, in _execute_service
    await handler.job.target(service_call)
  File "/usr/src/homeassistant/homeassistant/helpers/entity_component.py", line 204, in handle_service
    await self.hass.helpers.service.entity_service_call(
  File "/usr/src/homeassistant/homeassistant/helpers/service.py", line 499, in entity_service_call
    future.result()  # pop exception if have
  File "/usr/src/homeassistant/homeassistant/helpers/entity.py", line 664, in async_request_call
    await coro
  File "/usr/src/homeassistant/homeassistant/helpers/service.py", line 536, in _handle_entity_call
    await result
  File "/usr/src/homeassistant/homeassistant/components/light/__init__.py", line 230, in async_handle_light_on_service
    await light.async_turn_on(**params)
  File "/usr/src/homeassistant/homeassistant/components/deconz/light.py", line 186, in async_turn_on
    await self._device.async_set_state(data)
  File "/usr/local/lib/python3.8/site-packages/pydeconz/deconzdevice.py", line 35, in async_set_state
    await self.async_set(field, data)
  File "/usr/local/lib/python3.8/site-packages/pydeconz/api.py", line 112, in async_set
    await self._request("put", field, json=data)
  File "/usr/local/lib/python3.8/site-packages/pydeconz/gateway.py", line 106, in request
    _raise_on_error(response)
  File "/usr/local/lib/python3.8/site-packages/pydeconz/gateway.py", line 220, in _raise_on_error
    raise_error(data["error"])
  File "/usr/local/lib/python3.8/site-packages/pydeconz/errors.py", line 58, in raise_error
    raise cls("{} {}".format(error["address"], error["description"]))
pydeconz.errors.Res

stdout captured in file:

[s6-init] making user provided files available at /var/run/s6/etc...exited 0.
[s6-init] ensuring user provided files have correct perms...exited 0.
[fix-attrs.d] applying ownership & permissions fixes...
[fix-attrs.d] done.
[cont-init.d] executing container initialization scripts...
[cont-init.d] udev.sh: executing... 
[cont-init.d] udev.sh: exited 0.
[cont-init.d] done.
[services.d] starting services
[services.d] done.
[cont-finish.d] executing container finish scripts...
[cont-finish.d] done.
[s6-finish] waiting for services.
[s6-finish] sending all processes the TERM signal.
[s6-init] making user provided files available at /var/run/s6/etc...exited 0.
[s6-init] ensuring user provided files have correct perms...exited 0.
[fix-attrs.d] applying ownership & permissions fixes...
[fix-attrs.d] done.
[cont-init.d] executing container initialization scripts...
[cont-init.d] udev.sh: executing... 
[cont-init.d] udev.sh: exited 0.
[cont-init.d] done.
[services.d] starting services
[services.d] done.
[cont-finish.d] executing container finish scripts...
[cont-finish.d] done.
[s6-finish] waiting for services.
[s6-finish] sending all processes the TERM signal.
[s6-init] making user provided files available at /var/run/s6/etc...exited 0.
[s6-init] ensuring user provided files have correct perms...exited 0.
[fix-attrs.d] applying ownership & permissions fixes...
[fix-attrs.d] done.
[cont-init.d] executing container initialization scripts...
[cont-init.d] udev.sh: executing... 
[cont-init.d] udev.sh: exited 0.
[cont-init.d] done.
[services.d] starting services
[services.d] done.

is the stdout output expected ?

Robban · November 29, 2020, 5:44pm

Can you also share the device definitions? They get printed when deconz integration loads

PerJ · November 29, 2020, 7:22pm

would that be like this:

15:17:11:149 ZDP active ep response for 0x00212effff051a53
15:17:11:150 	ep: 0x01
15:17:11:150 	ep: 0xF2
15:17:11:466   >>> ZHATime sensor qw: exec READ_TIME
15:17:11:467   >>> ZHATime sensor Thermostat_stue_sofa: clear READ_TIME
15:17:11:467 APS-DATA.request id: 25, addrmode: 0x03, addr: 0x14b457fffed54e77, profile: 0x0104, cluster: 0x000A, ep: 0x01 -> 0x01 queue: 0 len: 9 tx.options 0x00
15:17:12:556 Mgmt_Lqi_req zdpSeq: 1 to 0x000B3CFFFEFCC7A2 start index 0
15:17:12:556 APS-DATA.request id: 30, addrmode: 0x03, addr: 0x000b3cfffefcc7a2, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 1 len: 2 tx.options 0x00
15:17:12:575 APS-DATA.confirm id: 30, status: 0x00 SUCCESS
15:17:12:575 APS-DATA.confirm request id: 30 -> confirmed, timeout 1606659432
15:17:12:657 APS-DATA.indication srcAddr: 0xe3b2, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 255, rssi: -47
15:17:12:658 APS-DATA.indication request id: 30 -> finished
15:17:12:658 APS-DATA.request id: 30 erase from queue
15:17:12:658 ZDP status = 0x00 -> SUCCESS
15:17:12:658 ZDP Mgmt_Lqi_rsp zdpSeq: 1 from 0x000B3CFFFEFCC7A2 total: 18, startIndex: 0, listCount: 3
15:17:12:658     * neighbor: 0x00212EFFFF051A53 (0x0000), LQI: 56, relation: 0x02 rxOnWHenIdle: 1
15:17:12:659     * neighbor: 0x14B457FFFE750684 (0x1DDF), LQI: 68, relation: 0x02 rxOnWHenIdle: 1
15:17:12:659     * neighbor: 0x000D6FFFFE1792AF (0x2A9F), LQI: 72, relation: 0x02 rxOnWHenIdle: 1
15:17:13:996 APS-DATA.request id: 38, addrmode: 0x02, addr: 0xfffd, profile: 0x0000, cluster: 0x0000, ep: 0x00 -> 0x00 queue: 1 len: 11 tx.options 0x00
15:17:13:998 send NWK_addr_req to 0x000B3CFFFEF85AD2, last seen 0 s, last seen by neighbors 3 s
15:17:14:036 APS-DATA.confirm id: 38, status: 0x00 SUCCESS
15:17:14:110 APS-DATA.indication srcAddr: 0xec87, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8000, lqi: 255, rssi: -46
15:17:14:111 ZDP status = 0x00 -> SUCCESS
15:17:14:190 APS-DATA.indication srcAddr: 0xe2b9, srcEp: 0x01 dstAddrMode: 2, profile: 0x0104, cluster: 0x0400, lqi: 255, rssi: -47
15:17:14:191 [INFO] - No button handler for: lumi.sensor_motion.aq2 endpoint: 0x01 cluster: 0x0400 command: 0x0A payload[0]: 000
15:17:14:191 ZCL attribute report 0x00158D000278B6EB for cluster: 0x0400, ep: 0x01, frame control: 0x18, mfcode: 0x0000 
15:17:14:194 APS-DATA.indication srcAddr: 0xe2b9, srcEp: 0x01 dstAddrMode: 2, profile: 0x0104, cluster: 0x0406, lqi: 255, rssi: -48
15:17:14:194 [INFO] - No button handler for: lumi.sensor_motion.aq2 endpoint: 0x01 cluster: 0x0406 command: 0x0A payload[0]: 000
15:17:14:195 ZCL attribute report 0x00158D000278B6EB for cluster: 0x0406, ep: 0x01, frame control: 0x18, mfcode: 0x0000 
15:17:14:932 Set sensor check interval to 100 milliseconds
15:17:15:037 ZDP active ep request to 0xec1bbdfffe8ecc02
15:17:15:037 APS-DATA.request id: 46, addrmode: 0x02, addr: 0xf5db, profile: 0x0000, cluster: 0x0005, ep: 0x00 -> 0x00 queue: 2 len: 3 tx.options 0x00
15:17:15:038 ZDP send request id: 0x07 to 0xec1bbdfffe8ecc02
15:17:15:059 APS-DATA.confirm id: 46, status: 0x00 SUCCESS
15:17:15:059 APS-DATA.confirm request id: 46 -> confirmed, timeout 1606659435
15:17:15:072 APS-DATA.indication srcAddr: 0xf5db, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8005, lqi: 255, rssi: -47
15:17:15:072 APS-DATA.indication request id: 46 -> finished
15:17:15:072 APS-DATA.request id: 46 erase from queue
15:17:15:073 ZDP status = 0x00 -> SUCCESS
15:17:15:073 ZDP active ep response for 0xec1bbdfffe8ecc02
15:17:15:073 	ep: 0x01
15:17:15:073 	ep: 0xF2
15:17:15:276 ZDP active ep request to 0xec1bbdfffea9354c
15:17:15:277 APS-DATA.request id: 49, addrmode: 0x02, addr: 0x2789, profile: 0x0000, cluster: 0x0005, ep: 0x00 -> 0x00 queue: 2 len: 3 tx.options 0x00
15:17:15:277 ZDP send request id: 0x07 to 0xec1bbdfffea9354c
15:17:15:298 APS-DATA.confirm id: 49, status: 0x00 SUCCESS
15:17:15:298 APS-DATA.confirm request id: 49 -> confirmed, timeout 1606659435
15:17:15:312 APS-DATA.indication srcAddr: 0x2789, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8005, lqi: 255, rssi: -46
15:17:15:312 APS-DATA.indication request id: 49 -> finished
15:17:15:312 APS-DATA.request id: 49 erase from queue
15:17:15:313 ZDP status = 0x00 -> SUCCESS
15:17:15:313 ZDP active ep response for 0xec1bbdfffea9354c
15:17:15:313 	ep: 0x01
15:17:15:313 	ep: 0xF2
15:17:15:432 reconnect network done
15:17:15:869 APS-DATA.indication srcAddr: 0x6487, srcEp: 0x01 dstAddrMode: 2, profile: 0x0104, cluster: 0x0008, lqi: 255, rssi: -52
15:17:15:869 ZCL attribute report 0xEC1BBDFFFEA2E341 for cluster: 0x0008, ep: 0x01, frame control: 0x08, mfcode: 0x0000 
15:17:15:870 APS-DATA.request id: 54, addrmode: 0x02, addr: 0x6487, profile: 0x0104, cluster: 0x0008, ep: 0x01 -> 0x01 queue: 2 len: 5 tx.options 0x00
15:17:15:891 APS-DATA.confirm id: 54, status: 0x00 SUCCESS
15:17:15:891 APS-DATA.confirm request id: 54 -> erase from queue
15:17:15:915 aps request id: 54 finished, erase from queue
15:17:16:396 Mgmt_Lqi_req zdpSeq: 5 to 0x000B3CFFFEFCC7A2 start index 3
15:17:16:397 APS-DATA.request id: 57, addrmode: 0x03, addr: 0x000b3cfffefcc7a2, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 2 len: 2 tx.options 0x00
15:17:16:417 APS-DATA.confirm id: 57, status: 0x00 SUCCESS
15:17:16:417 APS-DATA.confirm request id: 57 -> confirmed, timeout 1606659436
15:17:16:451 APS-DATA.indication srcAddr: 0xe3b2, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 255, rssi: -47
15:17:16:452 APS-DATA.indication request id: 57 -> finished
15:17:16:452 APS-DATA.request id: 57 erase from queue
15:17:16:452 ZDP status = 0x00 -> SUCCESS
15:17:16:452 ZDP Mgmt_Lqi_rsp zdpSeq: 5 from 0x000B3CFFFEFCC7A2 total: 18, startIndex: 3, listCount: 3
15:17:16:452     * neighbor: 0x000D6FFFFEF3264E (0x50F7), LQI: 32, relation: 0x02 rxOnWHenIdle: 1
15:17:16:452     * neighbor: 0xEC1BBDFFFEA2E341 (0x6487), LQI: 79, relation: 0x02 rxOnWHenIdle: 1
15:17:16:453     * neighbor: 0x680AE2FFFE1A946F (0x804C), LQI: 107, relation: 0x02 rxOnWHenIdle: 1
15:17:16:966   >>> ZHATime sensor Thermostat_stue_sofa: set READ_TIME from checkSensorNodeReachable()
15:17:16:970 APS-DATA.confirm id: 25, status: 0x00 SUCCESS
15:17:16:970 APS-DATA.confirm request id: 25 -> erase from queue
15:17:17:036 aps request id: 25 finished, erase from queue
15:17:17:432   >>> ZHATime sensor Thermostat_stue_sofa: exec READ_TIME
15:17:17:432   >>> ZHATime sensor Thermostat_stue_sofa: clear READ_TIME
15:17:17:433 APS-DATA.request id: 63, addrmode: 0x03, addr: 0x14b457fffed54e77, profile: 0x0104, cluster: 0x000A, ep: 0x01 -> 0x01 queue: 1 len: 9 tx.options 0x00
15:17:17:476   >>> ZHATime sensor Thermostat_stue_sofa: set READ_TIME from checkSensorNodeReachable()
15:17:17:480 APS-DATA.indication srcAddr: 0x127e, srcEp: 0x01 dstAddrMode: 2, profile: 0x0104, cluster: 0x000A, lqi: 255, rssi: -51
15:17:17:480 ZCL got data for node=0x127E, cl=0x000A, at=0x0000, status=0x00, type=0xE2
15:17:17:481 ZCL got data for node=0x127E, cl=0x000A, at=0x0007, status=0x00, type=0x23
15:17:17:481 ZCL got data for node=0x127E, cl=0x000A, at=0x0008, status=0x00, type=0xE2
15:17:17:482   >>> ZHATime sensor Thermostat_stue_sofa: drift -4
15:17:17:488 Websocket disconnected 172.30.32.1:53190, state: 0, close-code: 1000, reason: 
15:17:17:988 APS-DATA.confirm id: 63, status: 0x00 SUCCESS
15:17:17:988 APS-DATA.confirm request id: 63 -> erase from queue
15:17:17:996 aps request id: 63 finished, erase from queue
15:17:18:490 APS-DATA.indication srcAddr: 0x127e, srcEp: 0x01 dstAddrMode: 2, profile: 0x0104, cluster: 0x000A, lqi: 255, rssi: -51
15:17:18:491 ZCL got data for node=0x127E, cl=0x000A, at=0x0000, status=0x00, type=0xE2
15:17:18:491 ZCL got data for node=0x127E, cl=0x000A, at=0x0007, status=0x00, type=0x23
15:17:18:491 ZCL got data for node=0x127E, cl=0x000A, at=0x0008, status=0x00, type=0xE2
15:17:18:491   >>> ZHATime sensor Thermostat_stue_sofa: drift -4
15:17:18:932   >>> ZHATime sensor Thermostat_stue_sofa: exec READ_TIME
15:17:18:933   >>> ZHATime sensor Thermostat_stue_sofa: clear READ_TIME
15:17:18:933 APS-DATA.request id: 72, addrmode: 0x03, addr: 0x14b457fffed54e77, profile: 0x0104, cluster: 0x000A, ep: 0x01 -> 0x01 queue: 1 len: 9 tx.options 0x00
15:17:19:003 APS-DATA.confirm id: 72, status: 0x00 SUCCESS
15:17:19:003 APS-DATA.confirm request id: 72 -> erase from queue
15:17:19:036 aps request id: 72 finished, erase from queue
15:17:19:500 APS-DATA.indication srcAddr: 0x127e, srcEp: 0x01 dstAddrMode: 2, profile: 0x0104, cluster: 0x000A, lqi: 255, rssi: -51
15:17:19:500 ZCL got data for node=0x127E, cl=0x000A, at=0x0000, status=0x00, type=0xE2
15:17:19:501 ZCL got data for node=0x127E, cl=0x000A, at=0x0007, status=0x00, type=0x23
15:17:19:501 ZCL got data for node=0x127E, cl=0x000A, at=0x0008, status=0x00, type=0xE2
15:17:19:501   >>> ZHATime sensor Thermostat_stue_sofa: drift -4
15:17:19:836 ZDP active ep request to 0xec1bbdfffea2e341
15:17:19:837 APS-DATA.request id: 78, addrmode: 0x02, addr: 0x6487, profile: 0x0000, cluster: 0x0005, ep: 0x00 -> 0x00 queue: 1 len: 3 tx.options 0x00
15:17:19:837 ZDP send request id: 0x07 to 0xec1bbdfffea2e341
15:17:19:857 APS-DATA.confirm id: 78, status: 0x00 SUCCESS
15:17:19:857 APS-DATA.confirm request id: 78 -> confirmed, timeout 1606659439
15:17:19:873 APS-DATA.indication srcAddr: 0x6487, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8005, lqi: 255, rssi: -52
15:17:19:874 APS-DATA.indication request id: 78 -> finished
15:17:19:874 APS-DATA.request id: 78 erase from queue
15:17:19:875 ZDP status = 0x00 -> SUCCESS
15:17:19:875 ZDP active ep response for 0xec1bbdfffea2e341
15:17:19:875 	ep: 0x01
15:17:19:875 	ep: 0xF2
15:17:20:236 Mgmt_Lqi_req zdpSeq: 7 to 0x000B3CFFFEFCC7A2 start index 6
15:17:20:236 APS-DATA.request id: 82, addrmode: 0x03, addr: 0x000b3cfffefcc7a2, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 1 len: 2 tx.options 0x00
15:17:20:257 APS-DATA.confirm id: 82, status: 0x00 SUCCESS
15:17:20:257 APS-DATA.confirm request id: 82 -> confirmed, timeout 1606659440
15:17:20:288 APS-DATA.indication srcAddr: 0xe3b2, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 255, rssi: -47
15:17:20:289 APS-DATA.indication request id: 82 -> finished
15:17:20:289 APS-DATA.request id: 82 erase from queue
15:17:20:289 ZDP status = 0x00 -> SUCCESS
15:17:20:289 ZDP Mgmt_Lqi_rsp zdpSeq: 7 from 0x000B3CFFFEFCC7A2 total: 18, startIndex: 6, listCount: 3
15:17:20:289     * neighbor: 0xEC1BBDFFFEA93632 (0x9B4D), LQI: 32, relation: 0x02 rxOnWHenIdle: 1
15:17:20:290     * neighbor: 0x680AE2FFFE12FE2B (0xA4F5), LQI: 115, relation: 0x02 rxOnWHenIdle: 1
15:17:20:290     * neighbor: 0x000D6FFFFE205D2B (0xAFD7), LQI: 25, relation: 0x02 rxOnWHenIdle: 1
15:17:22:556 APS-DATA.request id: 93, addrmode: 0x02, addr: 0x0000, profile: 0x0000, cluster: 0x0004, ep: 0x00 -> 0x00 queue: 1 len: 4 tx.options 0x00
15:17:22:556 ZDP send request id: 0x05 to 0x00212effff051a53
15:17:22:568 APS-DATA.confirm id: 93, status: 0x00 SUCCESS
15:17:22:569 APS-DATA.confirm request id: 93 -> confirmed, timeout 1606659442
15:17:22:573 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8004, lqi: 147, rssi: 23
15:17:22:573 APS-DATA.indication request id: 93 -> finished
15:17:22:573 APS-DATA.request id: 93 erase from queue
15:17:22:573 ZDP status = 0x00 -> SUCCESS
15:17:22:573 ZDP Simple_Descriptor_rsp 0x00212EFFFF051A53 - 0x0000
15:17:22:574 LightNode 5: Configuration tool 5 added
15:17:22:796 ZDP active ep request to 0x000b3cfffefcc7a2
15:17:22:797 APS-DATA.request id: 96, addrmode: 0x02, addr: 0xe3b2, profile: 0x0000, cluster: 0x0005, ep: 0x00 -> 0x00 queue: 1 len: 3 tx.options 0x00
15:17:22:797 ZDP send request id: 0x07 to 0x000b3cfffefcc7a2
15:17:22:816 APS-DATA.confirm id: 96, status: 0x00 SUCCESS
15:17:22:816 APS-DATA.confirm request id: 96 -> confirmed, timeout 1606659442
15:17:22:838 APS-DATA.indication srcAddr: 0xe3b2, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8005, lqi: 255, rssi: -46
15:17:22:838 APS-DATA.indication request id: 96 -> finished
15:17:22:838 APS-DATA.request id: 96 erase from queue
15:17:22:838 ZDP status = 0x00 -> SUCCESS
15:17:22:838 ZDP active ep response for 0x000b3cfffefcc7a2
15:17:22:838 	ep: 0x01
15:17:22:876 ZDP active ep request to 0x000b3cfffef85ad2
15:17:24:076 Mgmt_Lqi_req zdpSeq: 11 to 0x000B3CFFFEFCC7A2 start index 9
15:17:24:077 APS-DATA.request id: 104, addrmode: 0x03, addr: 0x000b3cfffefcc7a2, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 1 len: 2 tx.options 0x00
15:17:24:096 APS-DATA.confirm id: 104, status: 0x00 SUCCESS
15:17:24:097 APS-DATA.confirm request id: 104 -> confirmed, timeout 1606659444
15:17:24:134 APS-DATA.indication srcAddr: 0xe3b2, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 255, rssi: -47
15:17:24:134 APS-DATA.indication request id: 104 -> finished
15:17:24:134 APS-DATA.request id: 104 erase from queue
15:17:24:134 ZDP status = 0x00 -> SUCCESS
15:17:24:135 ZDP Mgmt_Lqi_rsp zdpSeq: 11 from 0x000B3CFFFEFCC7A2 total: 18, startIndex: 9, listCount: 3
15:17:24:135     * neighbor: 0x680AE2FFFE13E417 (0xBB0A), LQI: 28, relation: 0x02 rxOnWHenIdle: 1
15:17:24:135     * neighbor: 0x000D6FFFFE1DFB50 (0xBD07), LQI: 48, relation: 0x02 rxOnWHenIdle: 1
15:17:24:135     * neighbor: 0x00124B001F5DC343 (0xD733), LQI: 34, relation: 0x02 rxOnWHenIdle: 1
15:17:27:676 APS-DATA.request id: 120, addrmode: 0x02, addr: 0x0000, profile: 0x0000, cluster: 0x0004, ep: 0x00 -> 0x00 queue: 1 len: 4 tx.options 0x00
15:17:27:676 ZDP send request id: 0x05 to 0x00212effff051a53
15:17:27:689 APS-DATA.confirm id: 120, status: 0x00 SUCCESS
15:17:27:690 APS-DATA.confirm request id: 120 -> confirmed, timeout 1606659447
15:17:27:694 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8004, lqi: 230, rssi: 32
15:17:27:694 APS-DATA.indication request id: 120 -> finished
15:17:27:694 APS-DATA.request id: 120 erase from queue
15:17:27:694 ZDP status = 0x00 -> SUCCESS
15:17:27:695 ZDP Simple_Descriptor_rsp 0x00212EFFFF051A53 - 0x0000
15:17:27:916 Mgmt_Lqi_req zdpSeq: 13 to 0x000B3CFFFEFCC7A2 start index 12
15:17:27:917 APS-DATA.request id: 123, addrmode: 0x03, addr: 0x000b3cfffefcc7a2, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 1 len: 2 tx.options 0x00
15:17:27:938 APS-DATA.confirm id: 123, status: 0x00 SUCCESS
15:17:27:939 APS-DATA.confirm request id: 123 -> confirmed, timeout 1606659447
15:17:27:973 APS-DATA.indication srcAddr: 0xe3b2, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 255, rssi: -46
15:17:27:974 APS-DATA.indication request id: 123 -> finished
15:17:27:974 APS-DATA.request id: 123 erase from queue
15:17:27:974 ZDP status = 0x00 -> SUCCESS
15:17:27:974 ZDP Mgmt_Lqi_rsp zdpSeq: 13 from 0x000B3CFFFEFCC7A2 total: 18, startIndex: 12, listCount: 3
15:17:27:974     * neighbor: 0x00124B001F5DC343 (0xD733), LQI: 34, relation: 0x02 rxOnWHenIdle: 1
15:17:27:975     * neighbor: 0x90FD9FFFFE2B0876 (0xD802), LQI: 51, relation: 0x02 rxOnWHenIdle: 1
15:17:27:975     * neighbor: 0xCCCCCCFFFEF39275 (0xE2C4), LQI: 52, relation: 0x02 rxOnWHenIdle: 1
15:17:28:156 ZDP active ep request to 0x000b3cfffef85ad2
15:17:31:756 Mgmt_Lqi_req zdpSeq: 17 to 0x000B3CFFFEFCC7A2 start index 15
15:17:31:756 APS-DATA.request id: 144, addrmode: 0x03, addr: 0x000b3cfffefcc7a2, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 1 len: 2 tx.options 0x00
15:17:31:775 APS-DATA.confirm id: 144, status: 0x00 SUCCESS
15:17:31:776 APS-DATA.confirm request id: 144 -> confirmed, timeout 1606659451
15:17:31:808 APS-DATA.indication srcAddr: 0xe3b2, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 255, rssi: -48
15:17:31:808 APS-DATA.indication request id: 144 -> finished
15:17:31:808 APS-DATA.request id: 144 erase from queue
15:17:31:808 ZDP status = 0x00 -> SUCCESS
15:17:31:809 ZDP Mgmt_Lqi_rsp zdpSeq: 17 from 0x000B3CFFFEFCC7A2 total: 18, startIndex: 15, listCount: 3
15:17:31:809     * neighbor: 0x000B3CFFFEF85AD2 (0xEC87), LQI: 80, relation: 0x02 rxOnWHenIdle: 1
15:17:31:809     * neighbor: 0xEC1BBDFFFE1C9981 (0x3FAB), LQI: 255, relation: 0x01 rxOnWHenIdle: 0
15:17:31:809     * neighbor: 0x680AE2FFFEFB1201 (0xA8D8), LQI: 255, relation: 0x01 rxOnWHenIdle: 0
15:17:32:497 New websocket 172.30.32.1:53204 (state: 3) 
15:17:32:617 drop request to zombie (rx = 0)
15:17:32:619 drop request to zombie (rx = 0)
15:17:32:644 drop request to zombie (rx = 0)
15:17:32:661 drop request to zombie (rx = 0)
15:17:32:667 drop request to zombie (rx = 0)
15:17:32:687 drop request to zombie (rx = 0)
15:17:32:694 drop request to zombie (rx = 0)
15:17:32:700 drop request to zombie (rx = 0)
15:17:32:715 drop request to zombie (rx = 0)
15:17:35:596 Mgmt_Lqi_req zdpSeq: 20 to 0x000B3CFFFEF85AD2 start index 0
15:17:35:597 APS-DATA.request id: 181, addrmode: 0x03, addr: 0x000b3cfffef85ad2, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 1 len: 2 tx.options 0x00
15:17:35:620 APS-DATA.confirm id: 181, status: 0x00 SUCCESS
15:17:35:621 APS-DATA.confirm request id: 181 -> confirmed, timeout 1606659455
15:17:35:658 APS-DATA.indication srcAddr: 0xec87, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 255, rssi: -46
15:17:35:658 APS-DATA.indication request id: 181 -> finished
15:17:35:658 APS-DATA.request id: 181 erase from queue
15:17:35:659 ZDP status = 0x00 -> SUCCESS
15:17:35:659 ZDP Mgmt_Lqi_rsp zdpSeq: 20 from 0x000B3CFFFEF85AD2 total: 16, startIndex: 0, listCount: 3
15:17:35:660     * neighbor: 0x680AE2FFFE1214D9 (0x11CF), LQI: 16, relation: 0x02 rxOnWHenIdle: 1
15:17:35:660     * neighbor: 0xEC1BBDFFFEA9354C (0x2789), LQI: 48, relation: 0x02 rxOnWHenIdle: 1
15:17:35:660     * neighbor: 0x000B57FFFEA3B45B (0x354F), LQI: 21, relation: 0x02 rxOnWHenIdle: 1
15:17:35:956 APS-DATA.indication srcAddr: 0x127e, srcEp: 0x01 dstAddrMode: 2, profile: 0x0104, cluster: 0x0019, lqi: 255, rssi: -55
15:17:35:957 APS-DATA.request id: 186, addrmode: 0x03, addr: 0x14b457fffed54e77, profile: 0x0104, cluster: 0x0019, ep: 0x01 -> 0x01 queue: 1 len: 4 tx.options 0x04
15:17:36:465 APS-DATA.confirm id: 186, status: 0x00 SUCCESS

Observe that SensorNode 31 & 30 apparently have the same node# - one reason could of course be, that the thermostat is both a thermometer and thermostat