openhab / openhab-addons

Add-ons for openHAB
https://www.openhab.org/
Eclipse Public License 2.0
1.88k stars 3.59k forks source link

[iCloud] Binding Communications Error. Drops offline, comes back online some of the time #13231

Open BigGeorgeTx opened 2 years ago

BigGeorgeTx commented 2 years ago

Expected Behavior

Binding stays online and if it drops offline, it reconnects automatically. Currently a number of users are reporting that sometimes they have to restart the binding or openHAB to get it to reconnect.

Current Behavior

Communication Error appears occasionally (a few times day) and doesn't come back on line (~ 1 a week). Reported by several users at https://community.openhab.org/t/icloud-binding-communication-error/122131/308?u=biggeorgetx

Possible Solution

No idea

Steps to Reproduce (for Bugs)

Your Environment

2022-08-07 18:51:13.229 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'icloud:device:iCloudAccountBridgeThing:ca18beb9' changed from OFFLINE (COMMUNICATION_ERROR): Reported offline by iCloud webservice to OFFLINE (BRIDGE_OFFLINE)
2022-08-07 18:51:13.230 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'icloud:device:iCloudAccountBridgeThing:23366cfe' changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)
2022-08-07 18:56:14.055 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'icloud:account:iCloudAccountBridgeThing' changed from OFFLINE (COMMUNICATION_ERROR): java.util.concurrent.TimeoutException: Total timeout 15000 ms elapsed to ONLINE
2022-08-07 18:56:14.061 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'icloud:device:iCloudAccountBridgeThing:71c63b69' changed from OFFLINE (BRIDGE_OFFLINE) to ONLINE
2022-08-07 18:56:14.073 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'icloud:device:iCloudAccountBridgeThing:KAirPods' changed from OFFLINE (BRIDGE_OFFLINE) to ONLINE
2022-08-07 18:56:14.084 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'icloud:device:iCloudAccountBridgeThing:KathleeniPhone13' changed from OFFLINE (BRIDGE_OFFLINE) to ONLINE
2022-08-07 18:56:14.094 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'icloud:device:iCloudAccount:5eff41d2' changed from OFFLINE (BRIDGE_OFFLINE) to ONLINE
2022-08-07 18:56:14.103 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'icloud:device:iCloudAccountBridgeThing:GeorgeAppleWallet' changed from OFFLINE (BRIDGE_OFFLINE) to ONLINE
2022-08-07 18:56:14.113 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'icloud:device:iCloudAccountBridgeThing:23366cfe' changed from OFFLINE (BRIDGE_OFFLINE) to ONLINE
2022-08-07 18:56:14.123 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'icloud:device:iCloudAccountBridgeThing:d8e940e9' changed from OFFLINE (BRIDGE_OFFLINE) to ONLINE
2022-08-07 18:56:14.131 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'icloud:device:iCloudAccount:65be325e' changed from OFFLINE (BRIDGE_OFFLINE) to ONLINE
2022-08-07 18:56:14.191 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'icloud:device:iCloudAccountBridgeThing:GeorgeiPhone13Pro' changed from OFFLINE (BRIDGE_OFFLINE) to ONLINE
2022-08-07 18:56:14.200 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'icloud:device:iCloudAccountBridgeThing:ca18beb9' changed from OFFLINE (BRIDGE_OFFLINE) to ONLINE
2022-08-07 18:56:14.209 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'icloud:device:iCloudAccount:b9132fe5' changed from OFFLINE (BRIDGE_OFFLINE) to ONLINE
2022-08-07 18:56:14.239 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'icloud:device:iCloudAccountBridgeThing:GeorgeAppleWallet' changed from ONLINE to OFFLINE (COMMUNICATION_ERROR): Reported offline by iCloud webservice
2022-08-07 18:56:14.242 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'icloud:device:iCloudAccountBridgeThing:KAirPods' changed from ONLINE to OFFLINE (COMMUNICATION_ERROR): Reported offline by iCloud webservice
2022-08-07 18:56:14.266 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'icloud:device:iCloudAccountBridgeThing:ca18beb9' changed from ONLINE to OFFLINE (COMMUNICATION_ERROR): Reported offline by iCloud webservice
2022-08-07 18:56:14.320 [INFO ] [openhab.event.ItemCommandEvent      ] - Item 'KathleeniCloudConnectedSwitch' received command ON
2022-08-07 18:56:14.331 [INFO ] [openhab.event.ItemCommandEvent      ] - Item 'GeorgeiCloudConnectedSwitch' received command ON
2022-08-07 19:01:14.808 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'icloud:device:iCloudAccountBridgeThing:GeorgeAppleWallet' changed from OFFLINE (COMMUNICATION_ERROR): Reported offline by iCloud webservice to ONLINE
2022-08-07 19:01:14.844 [INFO ] [openhab.event.ItemCommandEvent      ] - Item 'KathleeniCloudConnectedSwitch' received command ON
2022-08-07 19:01:14.900 [INFO ] [openhab.event.ItemCommandEvent      ] - Item 'GeorgeiCloudConnectedSwitch' received command ON
openhab-bot commented 2 years ago

This issue has been mentioned on openHAB Community. There might be relevant details there:

https://community.openhab.org/t/icloud-binding-communication-error/122131/318

maihacke commented 1 year ago

With https://github.com/openhab/openhab-addons/issues/13282 we changed a lot on the logic the binding handles communication to iCloud and how devices are initialized. Is this error still existing in 3.4.x?

lsiepel commented 3 months ago

Ping @BigGeorgeTx please confirm this issue is resolved. If not please update to 4.2.0 and report a new log file as the binding has changed so did the log.