Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

Sensors (wind, light) are recognized as "off" #223

Open
reeeeevls opened this issue Jan 21, 2025 · 20 comments
Open

Sensors (wind, light) are recognized as "off" #223

reeeeevls opened this issue Jan 21, 2025 · 20 comments

Comments

@reeeeevls
Copy link

reeeeevls commented Jan 21, 2025 •
edited
Loading

Hey there,

since 2025.1 the F&B integration does not update the sensor values for wind / light. For every change of the values I have to reload the integration. In the integration itself the sensors are shown as off. In the common B&J app the sensors are working.

free@home configuration:
https://paste.ubuntu.com/p/dZhcC5ZkFr/

free@home status updates
https://paste.ubuntu.com/p/KsXMCmKdTB/

Debugging:
2025-01-21 19:01:20.668 WARNING (MainThread) [custom_components.freeathome.fah.pfreeathome] Connection with SysAP lost
2025-01-21 19:01:24.006 ERROR (Recorder) [homeassistant] Error doing job: Task was destroyed but it is pending! (<Task pending name='Task-3520' coro=<XMLStream.run_filters() running at /usr/local/lib/python3.13/site-packages/slixmpp/xmlstream/xmlstream.py:1262> wait_for=>)
2025-01-21 19:20:13.891 DEBUG (MainThread) [custom_components.freeathome.fah.pfreeathome] received datapoint 7EB100002E14/ch0003/odp0001 = 1
2025-01-21 19:20:14.835 DEBUG (MainThread) [custom_components.freeathome.fah.pfreeathome] received datapoint 7EB100002E14/ch0003/odp0003 = 1.55
2025-01-21 19:20:14.836 DEBUG (MainThread) [custom_components.freeathome.fah.pfreeathome] FahSensor Windsensor (Kind 2)_windstrength: received datapoint 7EB100002E14/ch0003/odp0003 = 1.55
2025-01-21 19:20:14.836 INFO (MainThread) [custom_components.freeathome.fah.devices.fah_sensor] sensor Windsensor (Kind 2)_windstrength (7EB100002E14/ch0003) dp odp0003 state 1.55
2025-01-21 19:20:32.264 DEBUG (MainThread) [custom_components.freeathome.fah.pfreeathome] received datapoint 7EB100002E14/ch0003/odp0001 = 0
2025-01-21 19:20:32.264 DEBUG (MainThread) [custom_components.freeathome.fah.pfreeathome] received datapoint 7EB100002E14/ch0003/odp0003 = 0
2025-01-21 19:20:32.264 DEBUG (MainThread) [custom_components.freeathome.fah.pfreeathome] FahSensor Windsensor (Kind 2)_windstrength: received datapoint 7EB100002E14/ch0003/odp0003 = 0
2025-01-21 19:20:32.265 INFO (MainThread) [custom_components.freeathome.fah.devices.fah_sensor] sensor Windsensor (Kind 2)_windstrength (7EB100002E14/ch0003) dp odp0003 state 0
2025-01-21 19:20:42.719 DEBUG (MainThread) [custom_components.freeathome.fah.pfreeathome] received datapoint 7EB100002E14/ch0003/odp0001 = 1
2025-01-21 19:20:43.763 DEBUG (MainThread) [custom_components.freeathome.fah.pfreeathome] received datapoint 7EB100002E14/ch0003/odp0003 = 1.26
2025-01-21 19:20:43.764 DEBUG (MainThread) [custom_components.freeathome.fah.pfreeathome] FahSensor Windsensor (Kind 2)_windstrength: received datapoint 7EB100002E14/ch0003/odp0003 = 1.26
2025-01-21 19:20:43.764 INFO (MainThread) [custom_components.freeathome.fah.devices.fah_sensor] sensor Windsensor (Kind 2)_windstrength (7EB100002E14/ch0003) dp odp0003 state 1.26
2025-01-21 19:20:54.036 DEBUG (MainThread) [custom_components.freeathome.fah.pfreeathome] received datapoint 7EB100002E14/ch0001/odp0000 = 1
2025-01-21 19:20:54.036 DEBUG (MainThread) [custom_components.freeathome.fah.pfreeathome] FahSensor Regensensor (Kind 2)_rain: received datapoint 7EB100002E14/ch0001/odp0000 = 1
2025-01-21 19:20:54.036 INFO (MainThread) [custom_components.freeathome.fah.devices.fah_sensor] sensor Regensensor (Kind 2)_rain (7EB100002E14/ch0001) dp odp0000 state 1
2025-01-21 19:21:01.777 DEBUG (MainThread) [custom_components.freeathome.fah.pfreeathome] received datapoint 7EB100002E14/ch0003/odp0001 = 2
2025-01-21 19:21:02.784 DEBUG (MainThread) [custom_components.freeathome.fah.pfreeathome] received datapoint 7EB100002E14/ch0003/odp0003 = 1.67
2025-01-21 19:21:02.784 DEBUG (MainThread) [custom_components.freeathome.fah.pfreeathome] FahSensor Windsensor (Kind 2)_windstrength: received datapoint 7EB100002E14/ch0003/odp0003 = 1.67
2025-01-21 19:21:02.785 INFO (MainThread) [custom_components.freeathome.fah.devices.fah_sensor] sensor Windsensor (Kind 2)_windstrength (7EB100002E14/ch0003) dp odp0003 state 1.67
2025-01-21 19:21:17.775 DEBUG (MainThread) [custom_components.freeathome.fah.pfreeathome] received datapoint 7EB100002E14/ch0003/odp0001 = 1
2025-01-21 19:21:17.775 DEBUG (MainThread) [custom_components.freeathome.fah.pfreeathome] received datapoint 7EB100002E14/ch0003/odp0003 = 1.58
2025-01-21 19:21:17.776 DEBUG (MainThread) [custom_components.freeathome.fah.pfreeathome] FahSensor Windsensor (Kind 2)_windstrength: received datapoint 7EB100002E14/ch0003/odp0003 = 1.58
2025-01-21 19:21:17.776 INFO (MainThread) [custom_components.freeathome.fah.devices.fah_sensor] sensor Windsensor (Kind 2)_windstrength (7EB100002E14/ch0003) dp odp0003 state 1.58
2025-01-21 19:21:25.580 DEBUG (MainThread) [custom_components.freeathome.fah.pfreeathome] received datapoint 7EB100002E14/ch0003/odp0001 = 2
2025-01-21 19:21:26.625 DEBUG (MainThread) [custom_components.freeathome.fah.pfreeathome] received datapoint 7EB100002E14/ch0003/odp0003 = 1.62
2025-01-21 19:21:26.626 DEBUG (MainThread) [custom_components.freeathome.fah.pfreeathome] FahSensor Windsensor (Kind 2)_windstrength: received datapoint 7EB100002E14/ch0003/odp0003 = 1.62
2025-01-21 19:21:26.626 INFO (MainThread) [custom_components.freeathome.fah.devices.fah_sensor] sensor Windsensor (Kind 2)_windstrength (7EB100002E14/ch0003) dp odp0003 state 1.62
2025-01-21 19:21:34.428 DEBUG (MainThread) [custom_components.freeathome.fah.pfreeathome] received datapoint 7EB100002E14/ch0003/odp0001 = 1
2025-01-21 19:21:35.374 DEBUG (MainThread) [custom_components.freeathome.fah.pfreeathome] received datapoint 7EB100002E14/ch0003/odp0003 = 1.59
2025-01-21 19:21:35.374 DEBUG (MainThread) [custom_components.freeathome.fah.pfreeathome] FahSensor Windsensor (Kind 2)_windstrength: received datapoint 7EB100002E14/ch0003/odp0003 = 1.59
2025-01-21 19:21:35.374 INFO (MainThread) [custom_components.freeathome.fah.devices.fah_sensor] sensor Windsensor (Kind 2)_windstrength (7EB100002E14/ch0003) dp odp0003 state 1.59
2025-01-21 19:21:38.045 DEBUG (MainThread) [custom_components.freeathome.fah.pfreeathome] received datapoint 7EB100002E14/ch0003/odp0001 = 2
2025-01-21 19:21:39.093 DEBUG (MainThread) [custom_components.freeathome.fah.pfreeathome] received datapoint 7EB100002E14/ch0003/odp0003 = 1.6
2025-01-21 19:21:39.093 DEBUG (MainThread) [custom_components.freeathome.fah.pfreeathome] FahSensor Windsensor (Kind 2)_windstrength: received datapoint 7EB100002E14/ch0003/odp0003 = 1.6
2025-01-21 19:21:39.093 INFO (MainThread) [custom_components.freeathome.fah.devices.fah_sensor] sensor Windsensor (Kind 2)_windstrength (7EB100002E14/ch0003) dp odp0003 state 1.6
2025-01-21 19:21:41.308 DEBUG (MainThread) [custom_components.freeathome.fah.pfreeathome] received datapoint 7EB100002E14/ch0003/odp0001 = 1
2025-01-21 19:21:42.262 DEBUG (MainThread) [custom_components.freeathome.fah.pfreeathome] received datapoint 7EB100002E14/ch0003/odp0003 = 1.59
2025-01-21 19:21:42.262 DEBUG (MainThread) [custom_components.freeathome.fah.pfreeathome] FahSensor Windsensor (Kind 2)_windstrength: received datapoint 7EB100002E14/ch0003/odp0003 = 1.59
2025-01-21 19:21:42.263 INFO (MainThread) [custom_components.freeathome.fah.devices.fah_sensor] sensor Windsensor (Kind 2)_windstrength (7EB100002E14/ch0003) dp odp0003 state 1.59
2025-01-21 19:21:49.405 DEBUG (MainThread) [custom_components.freeathome.fah.pfreeathome] received datapoint 7EB100002E14/ch0003/odp0001 = 2
2025-01-21 19:21:50.355 DEBUG (MainThread) [custom_components.freeathome.fah.pfreeathome] received datapoint 7EB100002E14/ch0003/odp0003 = 1.62
2025-01-21 19:21:50.356 DEBUG (MainThread) [custom_components.freeathome.fah.pfreeathome] FahSensor Windsensor (Kind 2)_windstrength: received datapoint 7EB100002E14/ch0003/odp0003 = 1.62
2025-01-21 19:21:50.356 INFO (MainThread) [custom_components.freeathome.fah.devices.fah_sensor] sensor Windsensor (Kind 2)_windstrength (7EB100002E14/ch0003) dp odp0003 state 1.62
2025-01-21 19:21:53.851 ERROR (MainThread) [homeassistant.helpers.script.websocket_api_script] websocket_api script: Error executing script. Invalid data for call_service at pos 1: must contain at least one of entity_id, device_id, area_id, floor_id, label_id.
2025-01-21 19:21:53.852 ERROR (MainThread) [homeassistant.components.websocket_api.http.connection] [546932142240] Error handling message: must contain at least one of entity_id, device_id, area_id, floor_id, label_id.. Got {'type': 'execute_script', 'sequence': [{'action': 'alarm_control_panel.alarm_arm_away', 'target': {}, 'data': {}}], 'id': 783} (invalid_format) XXX from 192.168.178.20 (Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:134.0) Gecko/20100101 Firefox/134.0)
2025-01-21 19:22:01.549 DEBUG (MainThread) [custom_components.freeathome.fah.pfreeathome] received datapoint 7EB100002E14/ch0003/odp0001 = 0
2025-01-21 19:22:02.025 WARNING (MainThread) [homeassistant.util.loop] Detected blocking call to open with args ('/config/freeathome_dump_192.168.178.32_2025_01_21_19_22_01.xml', 'wt') inside the event loop by custom integration 'freeathome' at custom_components/freeathome/init.py, line 94: with open(hass.config.path(filename), "wt") as f: (offender: /config/custom_components/freeathome/init.py, line 94: with open(hass.config.path(filename), "wt") as f:), please report it to the author of the 'freeathome' custom integration

Image

Any ideas?
@jheling
Copy link
Owner

jheling commented Jan 23, 2025

Hi @reeeeevls. So after a restart the wind sensor seems to be working for about 10 minutes and after that it shows a constant wind speed of 4.32? Are there any errors in the log at the time the constant speed starts?

@reeeeevls
Copy link
Author

reeeeevls commented Jan 23, 2025 •
edited
Loading

No, there are no errors in the system log during this time.

Image

That is the data from today. Most of the time the sensor does not show live data.

@jheling
Copy link
Owner

jheling commented Jan 27, 2025

The official free@home app has also a monitor function for the different messages. Do you see the same behavior of the wind speed in this app?

@reeeeevls
Copy link
Author

reeeeevls commented Jan 27, 2025 •
edited
Loading

F&H App:

Image

Home Assistant:

Image

Timeframe 18:10 - 19:10

So the values do not match.

Iam doing a recording right now; takes 5 minutes.

@reeeeevls
Copy link
Author

Okay, I have a lot of files:

Image

What do you need? :|

@domi8671
Copy link

I have the same problem, but it's not new; it's been there for me from the beginning. So I didn't think about it any further. So it's not because of 2025.1, at least not for me.

@domi8671
Copy link

I noticed a phenomenon. If the wind sensor has not been updated in HA for a long time and I open the F@H app, the wind sensor is immediately updated in HA. This then lasts for a few minutes before it gets stuck again.

@jheling
Copy link
Owner

jheling commented Jan 28, 2025

So it looks like the wind sensor, and maybe the other sensors put out some data, get into a sleep mode and are waked by the free@home app. If you use the status updates of the freeathome integration and monitor the messages while activating the free@home app, maybe we can find the wake message.

@domi8671
Copy link

@jheling
I have attached the messages of the status updates of the freeathome integration while activating the free@home app. I hope it helps. The weatherstation is 7EB1000043B0.

freeathome_monitor.txt

@fuzerjir
Copy link

The same problem

@reeeeevls
Copy link
Author

Is the Log from domi8671 enough? Or do you need more data?

@jheling
Copy link
Owner

jheling commented Feb 8, 2025

I think it is enough. I have found two messages that look interesting. They seem to be targeted at two different SysAP communication interfaces. Maybe you can check if you get the same messages while waking up the sensors.

<device serialNumber="ABB7F6322701" domainAddress="0D39" state="modified" commissioningState="waitingForNeighborhoodTable"/>   
<device serialNumber="ABB7F6322700" domainAddress="0D39" state="modified" commissioningState="waitingForHealthInformation"/>

@reeeeevls
Copy link
Author

Where do you fetch these messages? In the debug protocoll?

@domi8671
Copy link

you can record the updates as described here:
https://github.com/jheling/freeathome?tab=readme-ov-file#2-monitoring-freehome-status-updates

I set the duration to 20.
Make sure the wind sensor is stuck again. / hasn't been updated for quite some time.
Hit the button 'call service' and open the f@h app on your mobile.
The file will be stored in your config folder.

@reeeeevls
Copy link
Author

xml version.docx

@jheling
Copy link
Owner

jheling commented Feb 15, 2025 •
edited
Loading

Thank you @reeeeevls . Your dump show the same messages.

I almost had a solution when I realized that the messages we have captured now are a result of a command that is send on the free@home bus. Unfortunately this command is not captured by the Monitoring of the status updates. So I had to think about something new for finding this specific command.

My proposal is turning on the debugging level of the slixmpp library which handles the communication with free@home.
That looks like this in the configuration.yaml:

logger:
  default: info
  logs:
    custom_components.freeathome: info
    slixmpp: debug

This will mean that the home-assistant.log will grow much bigger. If have also made a change to the Monitoring of the status updates. Now it is also showing a timestamp in the file, see pr #224. This makes finding the right message in the home assistant log much easier.

So the test would now be

  • Change the debug level of slixmpp (keep monitoring the free disk space on your system )
  • restart home assistant
  • Wait for the wind sensor to be stuck again
  • Turn on the 'Monitoring of the status updates'
  • Use your phone to wake up the wind sensor
  • Make a copy of the home-assistant.log
  • change the log level of slixmpp back to info.
  • restart home assistant.

@reeeeevls
Copy link
Author

So I have to add "logger: default: info logs: custom_components.freeathome: info slixmpp: debug" to the configuration.yaml, correct?

@jheling
Copy link
Owner

jheling commented Feb 16, 2025

I see I have mangled the layout for the configuration.yaml. I have updated the previous message with the right layout. The indents in the configuration.yaml are each 2 spaces. The line with the 'custom_components.freeathome' is not necessary.

@reeeeevls
Copy link
Author

Okay, I have the logfile. It is about 2 mb. Is it safe to post the complete file here?

@jheling
Copy link
Owner

jheling commented Feb 17, 2025

You can send it to helingj at Google Mail.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
None yet
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
4 participants
@jheling @fuzerjir @reeeeevls @domi8671