Still happening. This morning I noticed the iCloud Things weren’t updating, and found the same thing in the log: Now running openHAB 3.3.0M3 on a Pi4B with openhabian.
2022-04-15 21:42:22.604 [WARN ] [g.icalendar.internal.handler.PullJob] - Download of calendar failed with ExecutionException: HttpConnectionOverHTTP@96282b::DecryptedEndPoint@5cc2f{l=/192.168.1.89:39720,r=calendar.google.com/142.250.191.238:443,OPEN,fill=-,flush=-,to=911355/0}
2022-04-15 22:37:13.849 [WARN ] [l.handler.ICloudAccountBridgeHandler] - Unable to refresh device data
java.io.IOException: java.util.concurrent.ExecutionException: java.io.EOFException: HttpConnectionOverHTTP@cb36ad::DecryptedEndPoint@349fbf{l=/192.168.1.89:57088,r=fmipmobile.icloud.com/17.248.185.238:443,OPEN,fill=-,flush=-,to=300107/0}
at org.openhab.core.io.net.http.HttpUtil.executeUrlAndGetReponse(HttpUtil.java:260) ~[?:?]
at org.openhab.core.io.net.http.HttpUtil.executeUrl(HttpUtil.java:155) ~[?:?]
at org.openhab.core.io.net.http.HttpUtil.executeUrl(HttpUtil.java:130) ~[?:?]
at org.openhab.core.io.net.http.HttpRequestBuilder.getContentAsString(HttpRequestBuilder.java:135) ~[?:?]
at org.openhab.binding.icloud.internal.ICloudConnection.callApi(ICloudConnection.java:90) ~[?:?]
at org.openhab.binding.icloud.internal.ICloudConnection.requestDeviceStatusJSON(ICloudConnection.java:71) ~[?:?]
at org.openhab.binding.icloud.internal.handler.ICloudAccountBridgeHandler.lambda$0(ICloudAccountBridgeHandler.java:94) ~[?:?]
at org.openhab.core.cache.ExpiringCache.refreshValue(ExpiringCache.java:101) ~[?:?]
at org.openhab.core.cache.ExpiringCache.getValue(ExpiringCache.java:72) ~[?:?]
at org.openhab.binding.icloud.internal.handler.ICloudAccountBridgeHandler.refreshData(ICloudAccountBridgeHandler.java:161) ~[?:?]
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515) [?:?]
at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:305) [?:?]
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:305) [?:?]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) [?:?]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) [?:?]
at java.lang.Thread.run(Thread.java:829) [?:?]
Caused by: java.util.concurrent.ExecutionException: java.io.EOFException: HttpConnectionOverHTTP@cb36ad::DecryptedEndPoint@349fbf{l=/192.168.1.89:57088,r=fmipmobile.icloud.com/17.248.185.238:443,OPEN,fill=-,flush=-,to=300107/0}
at org.eclipse.jetty.client.util.FutureResponseListener.getResult(FutureResponseListener.java:118) ~[?:?]
at org.eclipse.jetty.client.util.FutureResponseListener.get(FutureResponseListener.java:101) ~[?:?]
at org.eclipse.jetty.client.HttpRequest.send(HttpRequest.java:730) ~[?:?]
at org.openhab.core.io.net.http.HttpUtil.executeUrlAndGetReponse(HttpUtil.java:251) ~[?:?]
... 15 more
Caused by: java.io.EOFException: HttpConnectionOverHTTP@cb36ad::DecryptedEndPoint@349fbf{l=/192.168.1.89:57088,r=fmipmobile.icloud.com/17.248.185.238:443,OPEN,fill=-,flush=-,to=300107/0}
at org.eclipse.jetty.client.http.HttpReceiverOverHTTP.earlyEOF(HttpReceiverOverHTTP.java:376) ~[?:?]
at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:1614) ~[?:?]
at org.eclipse.jetty.client.http.HttpReceiverOverHTTP.shutdown(HttpReceiverOverHTTP.java:259) ~[?:?]
at org.eclipse.jetty.client.http.HttpReceiverOverHTTP.process(HttpReceiverOverHTTP.java:181) ~[?:?]
at org.eclipse.jetty.client.http.HttpReceiverOverHTTP.receive(HttpReceiverOverHTTP.java:79) ~[?:?]
at org.eclipse.jetty.client.http.HttpChannelOverHTTP.receive(HttpChannelOverHTTP.java:131) ~[?:?]
at org.eclipse.jetty.client.http.HttpConnectionOverHTTP.onFillable(HttpConnectionOverHTTP.java:172) ~[?:?]
at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311) ~[?:?]
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:105) ~[?:?]
at org.eclipse.jetty.io.ssl.SslConnection$DecryptedEndPoint.onFillable(SslConnection.java:555) ~[?:?]
at org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:410) ~[?:?]
at org.eclipse.jetty.io.ssl.SslConnection$2.succeeded(SslConnection.java:164) ~[?:?]
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:105) ~[?:?]
at org.eclipse.jetty.io.ChannelEndPoint$1.run(ChannelEndPoint.java:104) ~[?:?]
at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.runTask(EatWhatYouKill.java:338) ~[?:?]
at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:315) ~[?:?]
at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:173) ~[?:?]
at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.run(EatWhatYouKill.java:131) ~[?:?]
at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:386) ~[?:?]
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:883) ~[?:?]
at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:1034) ~[?:?]
... 1 more
2022-04-15 22:37:22.431 [ERROR] [.commandclass.ZWaveMeterCommandClass] - NODE 4: Meter Value Error. Error extracting value - length=10, offset=3, size=7.
2022-04-15 22:37:22.437 [ERROR] [.commandclass.ZWaveMeterCommandClass] - NODE 4: Meter Value Error. Error extracting value - length=10, offset=3, size=7.
2022-04-15 22:37:22.444 [ERROR] [.commandclass.ZWaveMeterCommandClass] - NODE 4: Meter Value Error. Error extracting value - length=10, offset=3, size=7.
2022-04-15 22:37:22.517 [ERROR] [.commandclass.ZWaveMeterCommandClass] - NODE 4: Meter Value Error. Error extracting value - length=10, offset=3, size=7.
2022-04-15 22:46:59.702 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: OFFKathleen Presence groupON
2022-04-15 22:47:59.774 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: ONKathleen Presence groupON
2022-04-15 22:49:06.358 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: OFFKathleen Presence groupON
2022-04-15 22:51:44.547 [INFO ] [enhab.core.model.script.PRESENCE.log] - George came home, setting presence to ON
2022-04-15 22:51:44.587 [INFO ] [enhab.core.model.script.PRESENCE.log] - George Presence changed from off to on, run arrival routine
2022-04-15 22:51:44.592 [INFO ] [nhab.core.model.script.Notifications] - Sending notification via email
2022-04-15 22:52:19.975 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: ONKathleen Presence groupON
2022-04-15 22:52:21.678 [INFO ] [penhab.core.model.script.iPhone Home] - George's iPhone is at Spring home.
2022-04-15 22:53:28.390 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: OFFKathleen Presence groupON
2022-04-15 22:57:44.538 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: ONKathleen Presence groupON
2022-04-15 22:58:21.259 [WARN ] [g.icalendar.internal.handler.PullJob] - Download of calendar failed with ExecutionException: HttpConnectionOverHTTP@6ce076::DecryptedEndPoint@456f16{l=/192.168.1.89:39568,r=calendar.google.com/142.251.45.78:443,OPEN,fill=-,flush=-,to=912439/0}
2022-04-15 22:58:50.003 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: OFFKathleen Presence groupON
2022-04-15 23:02:00.278 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: ONKathleen Presence groupON
2022-04-15 23:07:25.794 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: OFFKathleen Presence groupON
2022-04-15 23:08:29.389 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: ONKathleen Presence groupON
2022-04-15 23:09:35.924 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: OFFKathleen Presence groupON
2022-04-15 23:12:46.170 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: ONKathleen Presence groupON
2022-04-15 23:13:52.736 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: OFFKathleen Presence groupON
2022-04-15 23:17:06.280 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: ONKathleen Presence groupON
2022-04-15 23:18:12.402 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: OFFKathleen Presence groupON
2022-04-15 23:20:23.032 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: ONKathleen Presence groupON
2022-04-15 23:21:30.426 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: OFFKathleen Presence groupON
2022-04-15 23:22:32.275 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: ONKathleen Presence groupON
2022-04-15 23:23:40.364 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: OFFKathleen Presence groupON
2022-04-15 23:24:40.693 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: ONKathleen Presence groupON
2022-04-15 23:24:46.329 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: OFFKathleen Presence groupON
2022-04-15 23:25:46.392 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: ONKathleen Presence groupON
2022-04-15 23:26:53.048 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: OFFKathleen Presence groupON
2022-04-15 23:27:53.076 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: ONKathleen Presence groupON
2022-04-15 23:28:58.782 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: OFFKathleen Presence groupON
2022-04-15 23:29:59.245 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: ONKathleen Presence groupON
2022-04-15 23:31:08.908 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: OFFKathleen Presence groupON
2022-04-15 23:32:08.968 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: ONKathleen Presence groupON
2022-04-15 23:34:15.203 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: OFFKathleen Presence groupON
2022-04-15 23:36:21.957 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: ONKathleen Presence groupON
2022-04-15 23:37:30.441 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: OFFKathleen Presence groupON
2022-04-15 23:41:50.776 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: ONKathleen Presence groupON
2022-04-15 23:43:49.535 [WARN ] [g.icalendar.internal.handler.PullJob] - Download of calendar failed with ExecutionException: HttpConnectionOverHTTP@c1777d::DecryptedEndPoint@153242{l=/192.168.1.89:39874,r=calendar.google.com/142.250.191.206:443,OPEN,fill=-,flush=-,to=912487/0}
2022-04-15 23:43:56.806 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: OFFKathleen Presence groupON
2022-04-15 23:49:20.272 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: ONKathleen Presence groupON
2022-04-15 23:51:35.070 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: OFFKathleen Presence groupON
2022-04-15 23:58:01.454 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: ONKathleen Presence groupON
2022-04-16 00:01:19.461 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: OFFKathleen Presence groupON
2022-04-16 00:02:20.117 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: ONKathleen Presence groupON
2022-04-16 00:04:28.337 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: OFFKathleen Presence groupON
2022-04-16 00:07:46.078 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: ONKathleen Presence groupON
2022-04-16 00:10:53.909 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: OFFKathleen Presence groupON
2022-04-16 00:13:00.932 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: ONKathleen Presence groupON
2022-04-16 00:14:07.239 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: OFFKathleen Presence groupON
2022-04-16 00:16:13.654 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: ONKathleen Presence groupON
2022-04-16 00:19:30.191 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: OFFKathleen Presence groupON
2022-04-16 00:21:36.929 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: ONKathleen Presence groupON
2022-04-16 00:22:45.418 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: OFFKathleen Presence groupON
2022-04-16 00:23:48.923 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: ONKathleen Presence groupON
2022-04-16 00:24:56.883 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: OFFKathleen Presence groupON
2022-04-16 00:25:58.302 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: ONKathleen Presence groupON
2022-04-16 00:27:06.990 [INFO ] [e.KathleenPresenceConflictTimerStart] - Kathleen Presence conflict with all devices: OFFKathleen Presence groupON
2022-04-16 00:27:48.417 [WARN ] [l.handler.ICloudAccountBridgeHandler] - Unable to refresh device data
java.io.IOException: java.util.concurrent.ExecutionException: java.io.EOFException: HttpConnectionOverHTTP@1fc69fe::DecryptedEndPoint@320c21{l=/192.168.1.89:46046,r=fmipmobile.icloud.com/17.248.185.228:443,OPEN,fill=-,flush=-,to=300137/0}
at org.openhab.core.io.net.http.HttpUtil.executeUrlAndGetReponse(HttpUtil.java:260) ~[?:?]
at org.openhab.core.io.net.http.HttpUtil.executeUrl(HttpUtil.java:155) ~[?:?]
at org.openhab.core.io.net.http.HttpUtil.executeUrl(HttpUtil.java:130) ~[?:?]
at org.openhab.core.io.net.http.HttpRequestBuilder.getContentAsString(HttpRequestBuilder.java:135) ~[?:?]
at org.openhab.binding.icloud.internal.ICloudConnection.callApi(ICloudConnection.java:90) ~[?:?]
at org.openhab.binding.icloud.internal.ICloudConnection.requestDeviceStatusJSON(ICloudConnection.java:71) ~[?:?]
at org.openhab.binding.icloud.internal.handler.ICloudAccountBridgeHandler.lambda$0(ICloudAccountBridgeHandler.java:94) ~[?:?]
at org.openhab.core.cache.ExpiringCache.refreshValue(ExpiringCache.java:101) ~[?:?]
at org.openhab.core.cache.ExpiringCache.getValue(ExpiringCache.java:72) ~[?:?]
at org.openhab.binding.icloud.internal.handler.ICloudAccountBridgeHandler.refreshData(ICloudAccountBridgeHandler.java:161) ~[?:?]
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515) [?:?]
at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:305) [?:?]
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:305) [?:?]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) [?:?]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) [?:?]
at java.lang.Thread.run(Thread.java:829) [?:?]
Caused by: java.util.concurrent.ExecutionException: java.io.EOFException: HttpConnectionOverHTTP@1fc69fe::DecryptedEndPoint@320c21{l=/192.168.1.89:46046,r=fmipmobile.icloud.com/17.248.185.228:443,OPEN,fill=-,flush=-,to=300137/0}
at org.eclipse.jetty.client.util.FutureResponseListener.getResult(FutureResponseListener.java:118) ~[?:?]
at org.eclipse.jetty.client.util.FutureResponseListener.get(FutureResponseListener.java:101) ~[?:?]
at org.eclipse.jetty.client.HttpRequest.send(HttpRequest.java:730) ~[?:?]
at org.openhab.core.io.net.http.HttpUtil.executeUrlAndGetReponse(HttpUtil.java:251) ~[?:?]
... 15 more
Caused by: java.io.EOFException: HttpConnectionOverHTTP@1fc69fe::DecryptedEndPoint@320c21{l=/192.168.1.89:46046,r=fmipmobile.icloud.com/17.248.185.228:443,OPEN,fill=-,flush=-,to=300137/0}
at org.eclipse.jetty.client.http.HttpReceiverOverHTTP.earlyEOF(HttpReceiverOverHTTP.java:376) ~[?:?]
at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:1614) ~[?:?]
at org.eclipse.jetty.client.http.HttpReceiverOverHTTP.shutdown(HttpReceiverOverHTTP.java:259) ~[?:?]
at org.eclipse.jetty.client.http.HttpReceiverOverHTTP.process(HttpReceiverOverHTTP.java:181) ~[?:?]
at org.eclipse.jetty.client.http.HttpReceiverOverHTTP.receive(HttpReceiverOverHTTP.java:79) ~[?:?]
at org.eclipse.jetty.client.http.HttpChannelOverHTTP.receive(HttpChannelOverHTTP.java:131) ~[?:?]
at org.eclipse.jetty.client.http.HttpConnectionOverHTTP.onFillable(HttpConnectionOverHTTP.java:172) ~[?:?]
at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311) ~[?:?]
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:105) ~[?:?]
at org.eclipse.jetty.io.ssl.SslConnection$DecryptedEndPoint.onFillable(SslConnection.java:555) ~[?:?]
at org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:410) ~[?:?]
at org.eclipse.jetty.io.ssl.SslConnection$2.succeeded(SslConnection.java:164) ~[?:?]
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:105) ~[?:?]
at org.eclipse.jetty.io.ChannelEndPoint$1.run(ChannelEndPoint.java:104) ~[?:?]
at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.runTask(EatWhatYouKill.java:338) ~[?:?]
at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:315) ~[?:?]
at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:173) ~[?:?]
at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.run(EatWhatYouKill.java:131) ~[?:?]
at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:386) ~[?:?]
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:883) ~[?:?]
at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:1034) ~[?:?]
... 1 more
I included the warning from the iCalendar binding because it was HTTP related, and it seems like this has at its root an HTTP problem.