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

[netatmo] Update time not synchronized with new weather data #16502

Closed
sKinyo opened this issue Mar 8, 2024 · 4 comments · Fixed by #16574
Closed

[netatmo] Update time not synchronized with new weather data #16502

sKinyo opened this issue Mar 8, 2024 · 4 comments · Fixed by #16574
Assignees
@clinique
Labels
bug An unexpected problem or unintended behavior of an add-on

Comments

@sKinyo
Copy link

sKinyo commented Mar 8, 2024

After some hours or days the time when new weather data are requested are no longer shortly after netatmo offer new data.

Compare the update time with the received data timestamp:

2024-02-16 08:00:10.682 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-02-16T07:49:50.000+0100 to 2024-02-16T07:59:55.000+0100
2024-02-16 08:10:15.903 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-02-16T07:59:55.000+0100 to 2024-02-16T08:10:01.000+0100
2024-02-16 08:20:21.239 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-02-16T08:10:01.000+0100 to 2024-02-16T08:20:07.000+0100
2024-02-16 08:30:26.546 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-02-16T08:20:07.000+0100 to 2024-02-16T08:30:13.000+0100
2024-02-16 08:40:31.812 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-02-16T08:30:13.000+0100 to 2024-02-16T08:40:19.000+0100
2024-02-16 08:50:37.052 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-02-16T08:40:19.000+0100 to 2024-02-16T08:50:24.000+0100
2024-02-16 09:00:42.752 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-02-16T08:50:24.000+0100 to 2024-02-16T09:00:31.000+0100
2024-02-16 09:10:48.023 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-02-16T09:00:31.000+0100 to 2024-02-16T09:10:36.000+0100
2024-02-16 09:20:53.358 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-02-16T09:10:36.000+0100 to 2024-02-16T09:20:43.000+0100
2024-02-16 09:30:58.924 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-02-16T09:20:43.000+0100 to 2024-02-16T09:30:49.000+0100
2024-02-16 09:41:05.241 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-02-16T09:30:49.000+0100 to 2024-02-16T09:40:57.000+0100
2024-02-16 09:51:10.475 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-02-16T09:40:57.000+0100 to 2024-02-16T09:51:04.000+0100
2024-02-16 10:01:15.767 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-02-16T09:51:04.000+0100 to 2024-02-16T10:01:09.000+0100
2024-02-16 10:11:21.010 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-02-16T10:01:09.000+0100 to 2024-02-16T10:11:13.000+0100
2024-02-16 10:21:26.225 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-02-16T10:11:13.000+0100 to 2024-02-16T10:21:19.000+0100
2024-02-16 10:31:31.472 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-02-16T10:21:19.000+0100 to 2024-02-16T10:31:24.000+0100
2024-02-16 10:41:36.786 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-02-16T10:31:24.000+0100 to 2024-02-16T10:41:29.000+0100
2024-02-16 10:51:42.501 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-02-16T10:41:29.000+0100 to 2024-02-16T10:51:33.000+0100
2024-02-16 11:01:47.715 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-02-16T10:51:33.000+0100 to 2024-02-16T11:01:38.000+0100
2024-02-16 11:11:53.021 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-02-16T11:01:38.000+0100 to 2024-02-16T11:11:45.000+0100
2024-02-16 11:21:58.248 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-02-16T11:11:45.000+0100 to 2024-02-16T11:21:49.000+0100
2024-02-16 11:42:08.801 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-02-16T11:21:49.000+0100 to 2024-02-16T11:42:02.000+0100
2024-02-16 11:52:14.075 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-02-16T11:42:02.000+0100 to 2024-02-16T11:52:09.000+0100
2024-02-16 12:12:24.536 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-02-16T11:52:09.000+0100 to 2024-02-16T12:12:18.000+0100
2024-02-16 12:32:35.089 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-02-16T12:12:18.000+0100 to 2024-02-16T12:22:26.000+0100
2024-02-16 12:42:40.479 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-02-16T12:22:26.000+0100 to 2024-02-16T12:32:33.000+0100
2024-02-16 12:52:45.676 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-02-16T12:32:33.000+0100 to 2024-02-16T12:42:41.000+0100
2024-02-16 13:02:50.929 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-02-16T12:42:41.000+0100 to 2024-02-16T12:52:46.000+0100
2024-02-16 13:12:56.197 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-02-16T12:52:46.000+0100 to 2024-02-16T13:02:51.000+0100
2024-02-16 13:23:01.400 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-02-16T13:02:51.000+0100 to 2024-02-16T13:12:57.000+0100
2024-02-16 13:33:06.700 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-02-16T13:12:57.000+0100 to 2024-02-16T13:23:04.000+0100
2024-02-16 13:43:11.929 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-02-16T13:23:04.000+0100 to 2024-02-16T13:33:09.000+0100
2024-02-16 13:53:17.329 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-02-16T13:33:09.000+0100 to 2024-02-16T13:43:13.000+0100
2024-02-16 14:03:22.606 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-02-16T13:43:13.000+0100 to 2024-02-16T13:53:19.000+0100

Expected Behavior

timeline
D: This is when the API provides new data
R: This is when the binding fetches the data

----D------------D------------D------------D---
-----R------------R------------R------------R--

Current Behavior

Current behavior after some hours/days:

----D------------D------------D------------D---
-R------------R------------R------------R------

Most of the time I get old data.

Possible Solution

In RefreshCapability.java, the dataValidity is never re-evaluated as soon as refreshConfigured is set to true.
It loses its validity over time. It should be re-evaluated regularly.

Your Environment

  • Version used: openHAB 4.1.1 and add-on versions 4.1.1
@sKinyo sKinyo added the bug An unexpected problem or unintended behavior of an add-on label Mar 8, 2024
@clinique clinique self-assigned this Mar 9, 2024
@clinique
Copy link
Contributor

clinique commented Mar 9, 2024

Observing your log, on this time window :

2024-02-16 11:11:53.021 [INFO ] [openhab.event.ItemStateChangedEvent ] 
2024-02-16 11:21:58.248 [INFO ] [openhab.event.ItemStateChangedEvent ] 
2024-02-16 11:42:08.801 [INFO ] [openhab.event.ItemStateChangedEvent ] 
2024-02-16 11:52:14.075 [INFO ] [openhab.event.ItemStateChangedEvent ] 
2024-02-16 12:12:24.536 [INFO ] [openhab.event.ItemStateChangedEvent ] 
2024-02-16 12:32:35.089 [INFO ] [openhab.event.ItemStateChangedEvent ] 
2024-02-16 12:42:40.479 [INFO ] [openhab.event.ItemStateChangedEvent ] 
2024-02-16 12:52:45.676 [INFO ] [openhab.event.ItemStateChangedEvent ]

I can observe that there are some missing calls at 11:31, 12:02, 12,22.

The RefreshCapability makes the assumption (shown here as 'could be false') that it is called without interruption, causing this drift.

Two things:
1- Could you identify in your log what could be the cause of these missing calls (interrupted call ?)
2- Reevaluate the dataValidity regularly

I'd like on input on (1) and will see how to address (2).

I have another PR pending affecting RefreshCapability, so likely I will not work on this one until the other one is merged.

@sKinyo
Copy link
Author

sKinyo commented Mar 9, 2024

I don't think that the calls are missing. They are slightly switching before and after new data is available.
Currently, I have no debug log available with this situation.

Newer logs:

events.log
2024-03-07 10:05:56.460 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T09:48:29.000+0100 to 2024-03-07T09:58:34.000+0100
2024-03-07 10:16:01.734 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T09:58:34.000+0100 to 2024-03-07T10:08:40.000+0100
2024-03-07 10:26:07.382 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T10:08:40.000+0100 to 2024-03-07T10:18:46.000+0100
2024-03-07 10:36:12.636 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T10:18:46.000+0100 to 2024-03-07T10:28:51.000+0100
2024-03-07 10:46:17.911 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T10:28:51.000+0100 to 2024-03-07T10:38:57.000+0100
2024-03-07 10:56:23.189 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T10:38:57.000+0100 to 2024-03-07T10:49:03.000+0100
2024-03-07 11:06:28.543 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T10:49:03.000+0100 to 2024-03-07T10:59:09.000+0100
2024-03-07 11:16:33.783 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T10:59:09.000+0100 to 2024-03-07T11:09:15.000+0100
2024-03-07 11:26:39.126 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T11:09:15.000+0100 to 2024-03-07T11:19:20.000+0100
2024-03-07 11:36:44.401 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T11:19:20.000+0100 to 2024-03-07T11:29:25.000+0100
2024-03-07 11:46:49.654 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T11:29:25.000+0100 to 2024-03-07T11:39:30.000+0100
2024-03-07 11:56:54.887 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T11:39:30.000+0100 to 2024-03-07T11:49:36.000+0100
2024-03-07 12:07:00.219 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T11:49:36.000+0100 to 2024-03-07T11:59:41.000+0100
2024-03-07 12:17:05.589 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T11:59:41.000+0100 to 2024-03-07T12:09:47.000+0100
2024-03-07 12:27:11.114 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T12:09:47.000+0100 to 2024-03-07T12:19:52.000+0100
2024-03-07 12:37:16.428 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T12:19:52.000+0100 to 2024-03-07T12:29:58.000+0100
2024-03-07 12:47:21.726 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T12:29:58.000+0100 to 2024-03-07T12:40:03.000+0100
2024-03-07 12:57:26.994 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T12:40:03.000+0100 to 2024-03-07T12:50:09.000+0100
2024-03-07 13:07:32.305 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T12:50:09.000+0100 to 2024-03-07T13:00:15.000+0100
2024-03-07 13:17:37.501 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T13:00:15.000+0100 to 2024-03-07T13:10:20.000+0100
2024-03-07 13:27:42.813 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T13:10:20.000+0100 to 2024-03-07T13:20:26.000+0100
2024-03-07 13:37:48.066 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T13:20:26.000+0100 to 2024-03-07T13:30:31.000+0100
2024-03-07 13:47:53.326 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T13:30:31.000+0100 to 2024-03-07T13:40:37.000+0100
2024-03-07 13:57:58.630 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T13:40:37.000+0100 to 2024-03-07T13:50:43.000+0100
2024-03-07 14:08:03.896 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T13:50:43.000+0100 to 2024-03-07T14:00:48.000+0100
2024-03-07 14:18:09.170 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T14:00:48.000+0100 to 2024-03-07T14:10:54.000+0100
2024-03-07 14:28:14.479 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T14:10:54.000+0100 to 2024-03-07T14:21:00.000+0100
2024-03-07 14:38:19.808 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T14:21:00.000+0100 to 2024-03-07T14:31:05.000+0100
2024-03-07 14:48:25.180 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T14:31:05.000+0100 to 2024-03-07T14:41:11.000+0100
2024-03-07 14:58:30.474 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T14:41:11.000+0100 to 2024-03-07T14:51:17.000+0100
2024-03-07 15:08:35.716 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T14:51:17.000+0100 to 2024-03-07T15:01:22.000+0100
2024-03-07 15:18:41.143 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T15:01:22.000+0100 to 2024-03-07T15:11:29.000+0100
2024-03-07 15:28:46.352 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T15:11:29.000+0100 to 2024-03-07T15:21:35.000+0100
2024-03-07 15:38:51.675 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T15:21:35.000+0100 to 2024-03-07T15:31:40.000+0100
2024-03-07 15:48:56.975 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T15:31:40.000+0100 to 2024-03-07T15:41:46.000+0100
2024-03-07 15:59:02.338 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T15:41:46.000+0100 to 2024-03-07T15:51:51.000+0100
2024-03-07 16:09:07.772 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-07T15:51:51.000+0100 to 2024-03-07T16:01:57.000+0100

openhab.log
2024-03-07 10:05:56.169 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 10:05:56.170 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 10:05:56.416 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-07 10:16:01.417 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 10:16:01.418 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 10:16:01.643 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-07 10:26:06.645 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 10:26:06.646 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 10:26:07.209 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 10:26:07.211 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 10:26:07.213 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 10:26:07.320 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-07 10:36:12.328 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 10:36:12.329 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 10:36:12.556 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-07 10:46:17.557 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 10:46:17.559 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 10:46:17.845 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-07 10:56:22.847 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 10:56:22.849 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 10:56:23.072 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 10:56:23.073 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 10:56:23.075 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 10:56:23.166 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-07 11:06:28.168 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 11:06:28.169 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 11:06:28.487 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-07 11:16:33.488 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 11:16:33.489 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 11:16:33.728 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-07 11:26:38.729 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 11:26:38.732 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 11:26:38.988 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 11:26:38.990 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 11:26:38.991 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 11:26:39.051 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-07 11:36:44.054 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 11:36:44.055 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 11:36:44.319 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-07 11:46:49.322 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 11:46:49.324 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 11:46:49.623 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-07 11:56:54.624 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 11:56:54.626 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 11:56:54.802 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 11:56:54.803 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 11:56:54.804 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 11:56:54.856 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-07 12:06:59.857 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 12:06:59.859 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 12:07:00.187 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-07 12:17:05.188 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 12:17:05.190 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 12:17:05.533 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-07 12:27:10.540 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 12:27:10.542 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 12:27:10.971 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 12:27:10.973 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 12:27:10.974 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 12:27:11.064 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-07 12:37:16.065 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 12:37:16.067 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 12:37:16.358 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-07 12:47:21.360 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 12:47:21.362 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 12:47:21.668 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-07 12:57:26.672 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 12:57:26.674 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 12:57:26.882 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 12:57:26.883 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 12:57:26.884 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 12:57:26.955 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-07 13:07:31.959 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 13:07:31.961 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 13:07:32.231 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-07 13:17:37.232 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 13:17:37.233 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 13:17:37.437 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-07 13:27:42.439 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 13:27:42.441 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 13:27:42.667 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 13:27:42.668 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 13:27:42.670 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 13:27:42.739 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-07 13:37:47.741 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 13:37:47.743 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 13:37:48.010 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-07 13:47:53.013 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 13:47:53.015 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 13:47:53.270 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-07 13:57:58.271 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 13:57:58.273 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 13:57:58.495 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 13:57:58.497 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 13:57:58.498 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 13:57:58.594 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-07 14:08:03.595 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 14:08:03.596 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 14:08:03.826 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-07 14:18:08.828 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 14:18:08.830 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 14:18:09.107 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-07 14:28:14.109 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 14:28:14.112 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 14:28:14.330 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 14:28:14.332 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 14:28:14.333 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 14:28:14.445 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-07 14:38:19.448 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 14:38:19.450 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 14:38:19.784 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-07 14:48:24.786 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 14:48:24.789 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 14:48:25.145 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-07 14:58:30.146 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 14:58:30.149 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 14:58:30.358 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 14:58:30.359 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 14:58:30.360 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 14:58:30.422 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-07 15:08:35.424 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 15:08:35.425 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 15:08:35.687 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-07 15:18:40.688 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 15:18:40.691 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 15:18:41.087 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-07 15:28:46.089 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 15:28:46.090 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 15:28:46.255 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 15:28:46.256 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 15:28:46.257 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 15:28:46.293 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-07 15:38:51.296 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 15:38:51.298 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 15:38:51.638 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-07 15:48:56.639 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 15:48:56.640 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 15:48:56.939 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-07 15:59:01.946 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 15:59:01.948 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 15:59:02.245 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 15:59:02.246 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 15:59:02.246 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 15:59:02.281 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-07 16:09:07.282 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-07 16:09:07.285 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-07 16:09:07.705 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s

I let the debug log on and trying to catch the situation like 2024-02-16

@sKinyo
Copy link
Author

sKinyo commented Mar 15, 2024

I have new logs. Shortly after restarting the thing (~2h) the update gets from a 5s data delay to > 10min data delay.
It has not left out an update, but there was no new data at 13:11

events.log
2024-03-15 12:01:02.311 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-15T11:50:50.000+0100 to 2024-03-15T12:00:56.000+0100
2024-03-15 12:11:07.789 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-15T12:00:56.000+0100 to 2024-03-15T12:11:01.000+0100
2024-03-15 12:21:13.040 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-15T12:11:01.000+0100 to 2024-03-15T12:21:07.000+0100
2024-03-15 12:41:23.759 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-15T12:21:07.000+0100 to 2024-03-15T12:41:21.000+0100
2024-03-15 12:51:29.071 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-15T12:41:21.000+0100 to 2024-03-15T12:51:26.000+0100
2024-03-15 13:01:34.363 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-15T12:51:26.000+0100 to 2024-03-15T13:01:32.000+0100
2024-03-15 13:21:45.265 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-15T13:01:32.000+0100 to 2024-03-15T13:11:40.000+0100
2024-03-15 13:31:50.633 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-15T13:11:40.000+0100 to 2024-03-15T13:21:46.000+0100
2024-03-15 13:41:55.984 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-15T13:21:46.000+0100 to 2024-03-15T13:31:52.000+0100
2024-03-15 13:52:01.304 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-15T13:31:52.000+0100 to 2024-03-15T13:41:57.000+0100
2024-03-15 14:02:06.655 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-15T13:41:57.000+0100 to 2024-03-15T13:52:03.000+0100
2024-03-15 14:12:12.092 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-15T13:52:03.000+0100 to 2024-03-15T14:02:09.000+0100
2024-03-15 14:22:17.919 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-15T14:02:09.000+0100 to 2024-03-15T14:12:15.000+0100
2024-03-15 14:32:23.200 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-15T14:12:15.000+0100 to 2024-03-15T14:22:22.000+0100
2024-03-15 14:42:28.507 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-15T14:22:22.000+0100 to 2024-03-15T14:32:26.000+0100
2024-03-15 14:52:33.820 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-15T14:32:26.000+0100 to 2024-03-15T14:42:32.000+0100
2024-03-15 15:02:39.216 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-15T14:42:32.000+0100 to 2024-03-15T14:52:39.000+0100
2024-03-15 15:12:44.558 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-15T14:52:39.000+0100 to 2024-03-15T15:02:43.000+0100
2024-03-15 15:22:49.876 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-15T15:02:43.000+0100 to 2024-03-15T15:12:49.000+0100
2024-03-15 15:32:55.243 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-15T15:12:49.000+0100 to 2024-03-15T15:22:55.000+0100
2024-03-15 15:43:00.615 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-15T15:22:55.000+0100 to 2024-03-15T15:32:59.000+0100
2024-03-15 15:53:06.026 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Indoor_TimeStamp' changed from 2024-03-15T15:32:59.000+0100 to 2024-03-15T15:43:06.000+0100

openhab.log
2024-03-15 12:01:02.021 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-15 12:01:02.022 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-15 12:01:02.241 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-15 12:11:07.242 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-15 12:11:07.249 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-15 12:11:07.636 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-15 12:11:07.638 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-15 12:11:07.640 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-15 12:11:07.702 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-15 12:21:12.703 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-15 12:21:12.705 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-15 12:21:12.987 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-15 12:31:17.993 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-15 12:31:17.994 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-15 12:31:18.311 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-15 12:41:23.313 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-15 12:41:23.315 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-15 12:41:23.593 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-15 12:41:23.595 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-15 12:41:23.596 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-15 12:41:23.711 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-15 12:51:28.714 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-15 12:51:28.716 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-15 12:51:29.007 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-15 13:01:34.009 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-15 13:01:34.011 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-15 13:01:34.295 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-15 13:11:39.297 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-15 13:11:39.300 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-15 13:11:39.554 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-15 13:11:39.557 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-15 13:11:39.559 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-15 13:11:39.636 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-15 13:21:44.638 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-15 13:21:44.640 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-15 13:21:45.250 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-15 13:31:50.252 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-15 13:31:50.257 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-15 13:31:50.575 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-15 13:41:55.580 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-15 13:41:55.582 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-15 13:41:55.833 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-15 13:41:55.834 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-15 13:41:55.835 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-15 13:41:55.922 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-15 13:52:00.924 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-15 13:52:00.925 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-15 13:52:01.242 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-15 14:02:06.246 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-15 14:02:06.247 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-15 14:02:06.613 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-15 14:12:11.614 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-15 14:12:11.617 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-15 14:12:11.941 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-15 14:12:11.942 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-15 14:12:11.944 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-15 14:12:12.081 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-15 14:22:17.082 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-15 14:22:17.084 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-15 14:22:17.884 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-15 14:32:22.885 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-15 14:32:22.886 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-15 14:32:23.161 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-15 14:42:28.163 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-15 14:42:28.165 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-15 14:42:28.354 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-15 14:42:28.355 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-15 14:42:28.357 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-15 14:42:28.449 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-15 14:52:33.451 [DEBUG] [er.capability.CacheWeatherCapability] - Requesting fresh data
2024-03-15 14:52:33.453 [DEBUG] [mo.internal.handler.ApiBridgeHandler] - executeUri GET  https://api.netatmo.com/api/getstationsdata?device_id=MAC&get_favorites=false 
2024-03-15 14:52:33.783 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s

@jlaur
Copy link
Contributor

jlaur commented Mar 23, 2024

During testing of #16489 I noticed that apparently the refresh interval is "locked in" once calculated. Recent example with two weather stations:

2024-03-23 15:32:35.092 [DEBUG] [handler.capability.RefreshCapability] - Data validity period identified to be PT5M3S
2024-03-23 15:32:35.145 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 303s
2024-03-23 15:32:36.374 [DEBUG] [handler.capability.RefreshCapability] - Data validity period identified to be PT10M5S
2024-03-23 15:32:36.425 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-23 15:37:38.628 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 303s
2024-03-23 15:42:41.861 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-23 15:42:42.005 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 303s
2024-03-23 15:47:45.489 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 303s
2024-03-23 15:52:47.235 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-23 15:52:51.269 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 303s
2024-03-23 15:57:54.867 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 303s
2024-03-23 16:02:52.831 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-23 16:02:58.107 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 303s
2024-03-23 16:08:01.786 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 303s
2024-03-23 16:12:58.195 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 605s
2024-03-23 16:13:04.932 [DEBUG] [handler.capability.RefreshCapability] - Module refreshed, next one in 303s

@clinique clinique mentioned this issue Mar 24, 2024
Merged
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees

@clinique clinique

Labels
bug An unexpected problem or unintended behavior of an add-on
Projects
None yet
Milestone
No milestone
Development

Successfully merging a pull request may close this issue.

[netatmo] Enhance RefreshCapability clinique/openhab-addons
3 participants
@clinique @jlaur @sKinyo