Netatmo shedule state is very slow to change (webhook seems ok)

Hi All

I’m using Netatmo thermostats and here is what I experience:

  1. I change the schedule using the built in service, on the device itself.
  2. The schedule changes correctly in the (phone)APP and on web immediately
  3. The state changes correctly in HA . also immediately
  4. After about 30 seconds, the state in HA changes back to the previous one.
  5. In netatmo app, the schedule remains correct.
  6. (If I leave HA alone, the state updates to the correct one after a some hours.)

Here’s the info…

  • I’m using reverse proxy via Cloudflare. I can see in my firewall events that Netatmo messages are allowed through.
  • I can see in the HA log that the webhook registers correctly.
  • Webhooks are not banned in Netatmo

I have un-registered and registered the webhook. Logs below. I have anonymized the logs - let me know if it’s too much.(or too little :wink: )

Also, I can see that the state of mit_hjem changed at 02.15.09 AM - there are no HA log entries at that time.

Hope someone can help here :slight_smile:

2022-12-22 23:18:50.883 INFO (MainThread) [homeassistant.helpers.script.websocket_api_script] websocket_api script: Running websocket_api script
2022-12-22 23:18:50.885 INFO (MainThread) [homeassistant.helpers.script.websocket_api_script] websocket_api script: Executing step call service
2022-12-22 23:18:50.887 DEBUG (MainThread) [homeassistant.components.netatmo] Unregister Netatmo webhook ([WEBHOOK ID])
2022-12-22 23:18:50.895 INFO (MainThread) [homeassistant.components.netatmo.data_handler] Netatmo webhook unregistered
2022-12-22 23:19:11.751 INFO (MainThread) [homeassistant.helpers.script.websocket_api_script] websocket_api script: Running websocket_api script
2022-12-22 23:19:11.752 INFO (MainThread) [homeassistant.helpers.script.websocket_api_script] websocket_api script: Executing step call service
2022-12-22 23:19:11.931 INFO (MainThread) [homeassistant.components.netatmo] Register Netatmo webhook: https://xxxx.yyy.dk/api/webhook/[WEBHOOK ID]
2022-12-22 23:19:12.068 DEBUG (MainThread) [homeassistant.components.netatmo.webhook] Got webhook data: {'user_id': '[MY ID]', 'user': {'id': '[MY ID]', 'email': '[MY EMAIL]'}, 'push_type': 'webhook_activation'}
2022-12-22 23:19:12.069 DEBUG (MainThread) [homeassistant.components.netatmo.webhook] None: {'user_id': '[MY USER]', 'user': {'id': '[MY ID]', 'email': '[MY EMAIL]'}, 'push_type': 'webhook_activation'}
2022-12-22 23:19:12.077 INFO (MainThread) [homeassistant.components.netatmo.data_handler] Netatmo webhook successfully registered
2022-12-22 23:20:48.590 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [547659167440] Initialized trigger
2022-12-22 23:21:54.160 INFO (MainThread) [homeassistant.components.automation.test2_set_value_from_helper4] test2_set_value_from_helper4: Running automation actions
2022-12-22 23:21:54.161 INFO (MainThread) [homeassistant.components.automation.test2_set_value_from_helper4] test2_set_value_from_helper4: Executing step call service
2022-12-22 23:21:54.174 DEBUG (MainThread) [homeassistant.components.netatmo.select] Setting [ENTITY ID] schedule to Standard ([ENTITY ID])
2022-12-22 23:21:54.502 DEBUG (MainThread) [homeassistant.components.netatmo.webhook] Got webhook data: {'user_id': '[MY ID]', 'user': {'id': '[MY ID]', 'email': '[MY EMAIL]'}, 'home_id': '[HOME ID]', 'event_type': 'schedule', 'schedule_id': '5dea735a4aa11372751890c6', 'previous_schedule_id': '5e4d7f224aa113fa7726c2f4', 'push_type': 'home_event_changed'}
2022-12-22 23:21:54.503 DEBUG (MainThread) [homeassistant.components.netatmo.webhook] schedule: {'user_id': '[MY USER]', 'user': {'id': '[MY ID]', 'email': '[MY EMAIL]'}, 'home_id': '[HOME ID]', 'event_type': 'schedule', 'schedule_id': '5dea735a4aa11372751890c6', 'previous_schedule_id': '5e4d7f224aa113fa7726c2f4', 'push_type': 'home_event_changed'}
2022-12-22 23:25:50.392 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [547659363472] Connection closed by client
2022-12-22 23:33:03.867 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [547631324928] Connection closed by client
2022-12-22 23:33:03.873 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [547636643776] Connection closed by client
2022-12-22 23:33:25.347 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [547630637760] Connection closed by client
2022-12-22 23:38:27.546 DEBUG (MainThread) [homeassistant.components.netatmo.select] Setting 5c03af40ea00a01a388baf1e schedule to Arbejder hjemme (61f2b0372066e413021525f5)
2022-12-22 23:38:27.847 DEBUG (MainThread) [homeassistant.components.netatmo.webhook] Got webhook data: {'user_id': '[MY ID]', 'user': {'id': '[MY ID]', 'email': '[MY EMAIL]'}, 'home_id': '[HOME ID]', 'event_type': 'schedule', 'schedule_id': '61f2b0372b66e413021525f4', 'previous_schedule_id': '5dea735a41a11372751890c6', 'push_type': 'home_event_changed'}
2022-12-22 23:38:27.851 DEBUG (MainThread) [homeassistant.components.netatmo.webhook] schedule: {'user_id': '[MY ID]', 'user': {'id': '[MY ID]', 'email': '[MY EMAIL]'}, 'home_id': '[HOME ID]', 'event_type': 'schedule', 'schedule_id': '61f2b0372b66e413021525f5', 'previous_schedule_id': '5dea735a41a11372751890c6', 'push_type': 'home_event_changed'}
2022-12-22 23:41:43.110 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [547633724960] Connection closed by client
2022-12-22 23:43:40.004 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [547630641360] Connection closed by client
2022-12-22 23:45:04.414 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [547635915808] Connection closed by client
2022-12-22 23:53:37.494 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [547658760256] Connection closed by client
2022-12-22 23:55:01.412 INFO (MainThread) [homeassistant.components.websocket_api.http.connection] [547896889248] Connection closed by client

Bumping this once :grinning: