Binding for Apple-TV

[OMR (Ole Morten Rønning)]

@digitaldan

That would be good

Deep sleeping through the night …

But pingable:

omr@rpi4lydhus:~ $ ping 192.168.3.10
PING 192.168.3.10 (192.168.3.10) 56(84) bytes of data.
64 bytes from 192.168.3.10: icmp_seq=1 ttl=64 time=1.57 ms
64 bytes from 192.168.3.10: icmp_seq=2 ttl=64 time=0.397 ms
64 bytes from 192.168.3.10: icmp_seq=3 ttl=64 time=0.404 ms
64 bytes from 192.168.3.10: icmp_seq=4 ttl=64 time=0.383 ms
64 bytes from 192.168.3.10: icmp_seq=5 ttl=64 time=0.330 ms
64 bytes from 192.168.3.10: icmp_seq=6 ttl=64 time=0.257 ms
64 bytes from 192.168.3.10: icmp_seq=7 ttl=64 time=0.306 ms

So I guess ONLINE is a better option.

But, I had to try twice turning the ATV ON using the Power channel.
First time nothing happened and the GUI button went back to OFF.
Second time a few seconds later, it responded:

I can try this once more with TRACE log on, but have to wait 70min+ for that.

[OMR (Ole Morten Rønning)]

@OMR

but have to wait 70min+ for that.

80min later.
FYI, since I didn’t have TRACE log of this latest attempt.
While in deep-sleep: (5min of log)

2026-07-30 12:35:59.673 [DEBUG] [tocols.companion.CompanionConnection] - Closing connection
2026-07-30 12:36:00.611 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 32498 on /192.168.3.10 failed: java.net.ConnectException: Connection refused
2026-07-30 12:36:19.110 [TRACE] [al.discovery.AtvDiscoveryParticipant] - Discovered AirPlay device Camping (1E:57:C6:CD:EC:F7) at 192.168.3.10
2026-07-30 12:36:23.030 [TRACE] [al.discovery.AtvDiscoveryParticipant] - Discovered AirPlay device Camping (1E:57:C6:CD:EC:F7) at 192.168.3.10
2026-07-30 12:36:41.883 [TRACE] [al.discovery.AtvDiscoveryParticipant] - Discovered AirPlay device Camping (1E:57:C6:CD:EC:F7) at 192.168.3.10
2026-07-30 12:36:45.925 [TRACE] [al.discovery.AtvDiscoveryParticipant] - Discovered AirPlay device Camping (1E:57:C6:CD:EC:F7) at 192.168.3.10
2026-07-30 12:36:59.676 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 3689 on /192.168.3.10
2026-07-30 12:36:59.677 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 7000 on /192.168.3.10
2026-07-30 12:36:59.677 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 49152 on /192.168.3.10
2026-07-30 12:36:59.678 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 32498 on /192.168.3.10
2026-07-30 12:36:59.680 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 3689 on /192.168.3.10 failed: java.net.ConnectException: Connection refused
2026-07-30 12:36:59.680 [DEBUG] [nternal.client.scan.ScanOrchestrator] - Auto-discovered Camping at 192.168.3.10:61975 via Companion ({rpmac=0, rphn=47cbe60b2da0, rpfl=0x36782, rpmd=AppleTV14,1, rpvr=715.2, rpmrtid=1D57C6CD-ECF7-4863-BCAB-5E3EEE5B2CED, rpad=62ff28a09b06, rpba=35:64:F3:61:A3:B3})
2026-07-30 12:36:59.681 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 32498 on /192.168.3.10 failed: java.net.ConnectException: Connection refused
2026-07-30 12:36:59.682 [DEBUG] [nternal.client.scan.ScanOrchestrator] - Auto-discovered Camping at 192.168.3.10:7000 via AirPlay ({acl=0, btaddr=54:6F:CB:00:A2:EB, deviceid=1E:57:C6:CD:EC:F7, fex=1d9/St5/Fzw4oY58, features=0x4A7FDFD5,0x3C177FDE, flags=0x244, gid=CCD412F8-DAA3-4F82-A1DA-31419C605261, igl=1, gcgl=1, model=AppleTV14,1, protovers=1.1, pi=33425b35-f9e8-4a44-97a2-1ac464c74e8a, psi=1D57C6CD-ECF7-4863-BCAB-5E3EEE5B2CED, pk=753d82c17da41aad50ef782a2bbd5f2a8adfe42fd18e054f3d641f4d9000f265, srcvers=950.7.1, osvers=26.5, vv=1})
2026-07-30 12:36:59.683 [DEBUG] [nternal.client.scan.ScanOrchestrator] - Auto-discovered 1E57C6CDECF7@Camping at 192.168.3.10:7000 via RAOP ({cn=0,1,2,3, da=true, et=0,3,5, ft=0x4A7FDFD5,0x3C177FDE, sf=0x244, md=0,1,2, am=AppleTV14,1, pk=753d82c17da41aad50ef782a2bbd5f2a8adfe42fd18e054f3d641f4d9000f265, tp=UDP, vn=65537, vs=950.7.1, ov=26.5, vv=1})
2026-07-30 12:36:59.684 [DEBUG] [nhab.binding.atv.internal.client.Atv] - Loading settings from MemoryStorage
2026-07-30 12:36:59.686 [DEBUG] [tv.internal.client.core.AppleTVRelay] - Adding handler for protocol Companion
2026-07-30 12:36:59.687 [DEBUG] [tv.internal.client.core.AppleTVRelay] - Connecting to protocol: Companion
2026-07-30 12:36:59.688 [DEBUG] [ent.protocols.companion.CompanionApi] - Connect to Companion from API
2026-07-30 12:36:59.690 [DEBUG] [tocols.companion.CompanionConnection] - Connected to companion device 192.168.3.10:61975
2026-07-30 12:36:59.691 [DEBUG] [rotocols.companion.CompanionProtocol] - Companion credentials: 800669aae62f0d79a12f252dd48dae53d7f361e7e22ea39a1f1e46b3fe7ac8d8:61e987a0149b3b8f9ae4f9ce22713d011c30f8967d9a6f1da33948d78f31b0a6:31443537433643442d454346372d343836332d424341422d354533454545354232434544:39636263386265652d336136372d343332642d396563642d353436356566383339633362
2026-07-30 12:36:59.693 [DEBUG] [rotocols.companion.CompanionProtocol] - Exchange OPACK: {_pd=[B@5d02a892, _auTy=4}
2026-07-30 12:36:59.694 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_pd=[B@5d02a892, _auTy=4, _x=34912}
2026-07-30 12:36:59.705 [DEBUG] [rotocols.companion.CompanionProtocol] - Received frame PV_Next (166 bytes)
2026-07-30 12:36:59.706 [DEBUG] [rotocols.companion.CompanionProtocol] - Process incoming auth frame (PV_Next): {_pd=[B@18e1ba76}
2026-07-30 12:36:59.711 [DEBUG] [rotocols.companion.CompanionProtocol] - Exchange OPACK: {_pd=[B@dde51ca}
2026-07-30 12:36:59.711 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_pd=[B@dde51ca, _x=34913}
2026-07-30 12:36:59.716 [DEBUG] [rotocols.companion.CompanionProtocol] - Received frame PV_Next (9 bytes)
2026-07-30 12:36:59.717 [DEBUG] [rotocols.companion.CompanionProtocol] - Process incoming auth frame (PV_Next): {_pd=[B@439f5232}
2026-07-30 12:36:59.718 [DEBUG] [ent.protocols.companion.CompanionApi] - Sending system information
2026-07-30 12:36:59.719 [DEBUG] [rotocols.companion.CompanionProtocol] - Exchange OPACK: {_i=_systemInfo, _t=2, _c={_bf=0, _cf=512, _clFl=128, _i=38ae83df4ff0, _idsID=[B@6c159032, _pubID=FF:70:79:61:74:76, _sf=256, _sv=170.18, model=iPhone10,6, name=openHAB}, _x=34914}
2026-07-30 12:36:59.720 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_systemInfo, _t=2, _c={_bf=0, _cf=512, _clFl=128, _i=38ae83df4ff0, _idsID=[B@6c159032, _pubID=FF:70:79:61:74:76, _sf=256, _sv=170.18, model=iPhone10,6, name=openHAB}, _x=34914}
2026-07-30 12:36:59.724 [DEBUG] [tocols.companion.CompanionConnection] - Require 5399 bytes but only 2896 in buffer
2026-07-30 12:36:59.725 [DEBUG] [rotocols.companion.CompanionProtocol] - Received frame E_OPACK (5379 bytes)
2026-07-30 12:36:59.726 [DEBUG] [rotocols.companion.CompanionProtocol] - Process incoming OPACK frame (E_OPACK): {_c={_lP=SizedLong[value=61975, size=4], _cf=SizedLong[value=512, size=2], _pubID=35:64:F3:61:A3:B3, _accAltDSID=001415-10-4ada4300-ad73-4809-b7dd-beebe7e14137, _stA=[com.apple.bluetooth.remote, SymptomNetworkDiagnostics, com.apple.devicediscoveryui.rapportwake, com.apple.tvremoteservices, com.apple.ApplicationService.chrono, com.apple.accessibility.axremoted.rapportWake, com.apple.dropin.setup, com.apple.wifivelocityd.rapportWake, com.apple.siri.wakeup, com.apple.workflow.remotewidgets, com.apple.networkrelay.on-demand-setup, com.apple.biomesyncd.rapport, com.apple.DDUI-Picker, com.apple.Seymour, com.apple.home.messaging, com.apple.siri.wakeup, com.apple.announce, com.apple.biomesyncd.cascade.rapport, com.apple.SeymourSession, com.apple.messagecenter.coordinatorlink], _sv=715.2, _spID=1829D260-A484-461E-9297-A30181339BB9, _mrID=1D57C6CD-ECF7-4863-BCAB-5E3EEE5B2CED, name=Camping, _aaltDSID=001415-10-4ada4300-ad73-4809-b7dd-beebe7e14137, _dCapF=1, _siriInfo={collectorElectionVersion=0.0, deviceCapabilitiesV2=[[B@752337d3, [B@3d2d57dd, [B@428211b3, [B@2568dd1, [B@6e27bfe7], peerData={myriadTrialTreatment=, productType=AppleTV14,1, buildVersion=23L471, isLocationSharingDevice=false, aceVersion=13.0-20A, userInterfaceIdiom=ZEUS, isSiriCloudSyncEnabled=true, userAssignedDeviceName=Camping}}, _idsCID=31fa3445-b152-401a-9aef-b82e0cd36c3e, _i=1dba2efb02f6, _accID=olemr@olemr.com, _clFl=SizedLong[value=128, size=2], _bf=SizedLong[value=1920, size=2], _osV=26.5.0, model=productType, _mRtID=1D57C6CD-ECF7-4863-BCAB-5E3EEE5B2CED, _idsID=C0BA895E-8247-4406-B125-5438C5A9CBC7, _sf=SizedLong[value=65536, size=4], _dC=unknown}, _t=3, _x=SizedLong[value=34914, size=2]}
2026-07-30 12:36:59.727 [DEBUG] [rotocols.companion.CompanionProtocol] - Exchange OPACK: {_i=_touchStart, _t=2, _c={_height=1000.0, _tFl=0, _width=1000.0}, _x=34915}
2026-07-30 12:36:59.729 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_touchStart, _t=2, _c={_height=1000.0, _tFl=0, _width=1000.0}, _x=34915}
2026-07-30 12:36:59.731 [DEBUG] [rotocols.companion.CompanionProtocol] - Received frame E_OPACK (24 bytes)
2026-07-30 12:36:59.732 [DEBUG] [rotocols.companion.CompanionProtocol] - Process incoming OPACK frame (E_OPACK): {_x=SizedLong[value=34915, size=2], _rT=0, _c={_i=1}, _t=3}
2026-07-30 12:36:59.733 [DEBUG] [rotocols.companion.CompanionProtocol] - Exchange OPACK: {_i=_sessionStart, _t=2, _c={_srvT=com.apple.tvremoteservices, _sid=141205285}, _x=34916}
2026-07-30 12:36:59.734 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_sessionStart, _t=2, _c={_srvT=com.apple.tvremoteservices, _sid=141205285}, _x=34916}
2026-07-30 12:36:59.736 [DEBUG] [rotocols.companion.CompanionProtocol] - Received frame E_OPACK (34 bytes)
2026-07-30 12:36:59.737 [DEBUG] [rotocols.companion.CompanionProtocol] - Process incoming OPACK frame (E_OPACK): {_x=SizedLong[value=34916, size=2], _rT=0, _c={_sid=SizedLong[value=3903167589, size=8]}, _t=3}
2026-07-30 12:36:59.738 [DEBUG] [ent.protocols.companion.CompanionApi] - Started session with SID 0xe8a59c65086a9f25
2026-07-30 12:36:59.738 [DEBUG] [rotocols.companion.CompanionProtocol] - Exchange OPACK: {_i=TVRCSessionStart, _t=2, _c={ProtocolVersionKey=1.2}, _x=34917}
2026-07-30 12:36:59.739 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=TVRCSessionStart, _t=2, _c={ProtocolVersionKey=1.2}, _x=34917}
2026-07-30 12:36:59.743 [DEBUG] [rotocols.companion.CompanionProtocol] - Received frame E_OPACK (43 bytes)
2026-07-30 12:36:59.744 [DEBUG] [rotocols.companion.CompanionProtocol] - Process incoming OPACK frame (E_OPACK): {_x=SizedLong[value=34917, size=2], _rT=1, _c={ProtocolVersionKey=1.2}, _t=3}
2026-07-30 12:36:59.745 [DEBUG] [ent.protocols.companion.CompanionApi] - Started TV RC session: {ProtocolVersionKey=1.2}
2026-07-30 12:36:59.746 [DEBUG] [rotocols.companion.CompanionProtocol] - Exchange OPACK: {_i=_tiStart, _t=2, _c={}, _x=34918}
2026-07-30 12:36:59.747 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_tiStart, _t=2, _c={}, _x=34918}
2026-07-30 12:36:59.749 [DEBUG] [rotocols.companion.CompanionProtocol] - Received frame E_OPACK (20 bytes)
2026-07-30 12:36:59.749 [DEBUG] [rotocols.companion.CompanionProtocol] - Process incoming OPACK frame (E_OPACK): {_x=SizedLong[value=34918, size=2], _rT=0, _c={}, _t=3}
2026-07-30 12:36:59.750 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_interest, _t=1, _c={_regEvents=[_iMC]}, _x=34919}
2026-07-30 12:36:59.751 [DEBUG] [rotocols.companion.CompanionProtocol] - Exchange OPACK: {_i=FetchAttentionState, _t=2, _c={}, _x=34920}
2026-07-30 12:36:59.751 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=FetchAttentionState, _t=2, _c={}, _x=34920}
2026-07-30 12:36:59.753 [DEBUG] [rotocols.companion.CompanionProtocol] - Received frame E_OPACK (33 bytes)
2026-07-30 12:36:59.754 [DEBUG] [rotocols.companion.CompanionProtocol] - Process incoming OPACK frame (E_OPACK): {_i=_iMC, _x=SizedLong[value=1835361257, size=4], _c={_mcF=SizedLong[value=256, size=2]}, _t=1}
2026-07-30 12:36:59.754 [DEBUG] [rotocols.companion.CompanionProtocol] - Received event: {_i=_iMC, _x=SizedLong[value=1835361257, size=4], _c={_mcF=SizedLong[value=256, size=2]}, _t=1}
2026-07-30 12:36:59.755 [DEBUG] [ent.protocols.companion.CompanionApi] - Got event _iMC from device: {_mcF=SizedLong[value=256, size=2]}
2026-07-30 12:36:59.755 [DEBUG] [rotocols.companion.CompanionProtocol] - Received frame E_OPACK (27 bytes)
2026-07-30 12:36:59.755 [DEBUG] [rotocols.companion.CompanionFeatures] - Updated media control flags to 256
2026-07-30 12:36:59.756 [DEBUG] [rotocols.companion.CompanionProtocol] - Process incoming OPACK frame (E_OPACK): {_x=SizedLong[value=34920, size=2], _rT=0, _c={state=1}, _t=3}
2026-07-30 12:36:59.756 [DEBUG] [t.protocols.companion.CompanionAudio] - Volume control changed, updating volume
2026-07-30 12:36:59.756 [DEBUG] [t.protocols.companion.CompanionPower] - Initial power state is Off
2026-07-30 12:36:59.756 [DEBUG] [rotocols.companion.CompanionProtocol] - Exchange OPACK: {_i=_mcc, _t=2, _c={_mcc=5}, _x=34921}
2026-07-30 12:36:59.757 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_interest, _t=1, _c={_regEvents=[SystemStatus]}, _x=34922}
2026-07-30 12:36:59.757 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_mcc, _t=2, _c={_mcc=5}, _x=34921}
2026-07-30 12:36:59.758 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_interest, _t=1, _c={_regEvents=[TVSystemStatus]}, _x=34923}
2026-07-30 12:36:59.759 [DEBUG] [tv.internal.client.core.AppleTVRelay] - Connected to protocol: Companion
2026-07-30 12:36:59.760 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_interest, _t=1, _c={_deregEvents=[_iMC]}, _x=34924}
2026-07-30 12:36:59.760 [DEBUG] [rotocols.companion.CompanionProtocol] - Received frame E_OPACK (30 bytes)
2026-07-30 12:36:59.761 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_interest, _t=1, _c={_deregEvents=[SystemStatus]}, _x=34925}
2026-07-30 12:36:59.761 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_interest, _t=1, _c={_deregEvents=[TVSystemStatus]}, _x=34926}
2026-07-30 12:36:59.761 [DEBUG] [rotocols.companion.CompanionProtocol] - Process incoming OPACK frame (E_OPACK): {_x=SizedLong[value=34921, size=2], _rT=1, _c={_vol=0.5}, _t=3}
2026-07-30 12:36:59.762 [DEBUG] [rotocols.companion.CompanionProtocol] - Exchange OPACK: {_i=_sessionStop, _t=2, _c={_srvT=com.apple.tvremoteservices, _sid=-1682766928006176987}, _x=34927}
2026-07-30 12:36:59.762 [DEBUG] [t.protocols.companion.CompanionAudio] - Volume changed to 50.0
2026-07-30 12:36:59.762 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_sessionStop, _t=2, _c={_srvT=com.apple.tvremoteservices, _sid=-1682766928006176987}, _x=34927}
2026-07-30 12:36:59.763 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type VOLUME to org.openhab.binding.atv.internal.client.core.AudioRelay$$Lambda/0x00000001011ed748@6b3e0f57
2026-07-30 12:36:59.763 [DEBUG] [ent.protocols.companion.CompanionApi] - Ignoring error during disconnect: org.openhab.binding.atv.internal.client.exceptions.ProtocolError: Command _sessionStop failed
2026-07-30 12:36:59.764 [DEBUG] [tocols.companion.CompanionConnection] - Closing connection
2026-07-30 12:37:30.146 [TRACE] [al.discovery.AtvDiscoveryParticipant] - Discovered AirPlay device Camping (1E:57:C6:CD:EC:F7) at 192.168.3.10
2026-07-30 12:37:34.090 [TRACE] [al.discovery.AtvDiscoveryParticipant] - Discovered AirPlay device Camping (1E:57:C6:CD:EC:F7) at 192.168.3.10
2026-07-30 12:37:59.766 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 3689 on /192.168.3.10
2026-07-30 12:37:59.766 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 49152 on /192.168.3.10
2026-07-30 12:37:59.767 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 32498 on /192.168.3.10
2026-07-30 12:37:59.768 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 7000 on /192.168.3.10
2026-07-30 12:38:01.567 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 49152 on /192.168.3.10 failed: java.net.SocketTimeoutException: Connect timed out
2026-07-30 12:38:01.568 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 3689 on /192.168.3.10 failed: java.net.SocketTimeoutException: Connect timed out
2026-07-30 12:38:01.569 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 32498 on /192.168.3.10 failed: java.net.SocketTimeoutException: Connect timed out
2026-07-30 12:38:01.570 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 7000 on /192.168.3.10 failed: java.net.SocketTimeoutException: Connect timed out
2026-07-30 12:38:01.766 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 7000 on /192.168.3.10
2026-07-30 12:38:01.766 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 49152 on /192.168.3.10
2026-07-30 12:38:01.766 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 32498 on /192.168.3.10
2026-07-30 12:38:01.766 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 3689 on /192.168.3.10
2026-07-30 12:38:03.568 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 49152 on /192.168.3.10 failed: java.net.SocketTimeoutException: Connect timed out
2026-07-30 12:38:03.568 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 32498 on /192.168.3.10 failed: java.net.SocketTimeoutException: Connect timed out
2026-07-30 12:38:03.569 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 7000 on /192.168.3.10 failed: java.net.SocketTimeoutException: Connect timed out
2026-07-30 12:38:03.569 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 3689 on /192.168.3.10 failed: java.net.SocketTimeoutException: Connect timed out
2026-07-30 12:38:03.766 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 3689 on /192.168.3.10
2026-07-30 12:38:03.766 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 49152 on /192.168.3.10
2026-07-30 12:38:03.766 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 7000 on /192.168.3.10
2026-07-30 12:38:03.766 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 32498 on /192.168.3.10
2026-07-30 12:38:05.567 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 49152 on /192.168.3.10 failed: java.net.SocketTimeoutException: Connect timed out
2026-07-30 12:38:05.567 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 3689 on /192.168.3.10 failed: java.net.SocketTimeoutException: Connect timed out
2026-07-30 12:38:05.568 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 32498 on /192.168.3.10 failed: java.net.SocketTimeoutException: Connect timed out
2026-07-30 12:38:05.568 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 7000 on /192.168.3.10 failed: java.net.SocketTimeoutException: Connect timed out
2026-07-30 12:38:05.766 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 3689 on /192.168.3.10
2026-07-30 12:38:05.766 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 49152 on /192.168.3.10
2026-07-30 12:38:05.766 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 32498 on /192.168.3.10
2026-07-30 12:38:05.766 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 7000 on /192.168.3.10
2026-07-30 12:38:07.566 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 49152 on /192.168.3.10 failed: java.net.SocketTimeoutException: Connect timed out
2026-07-30 12:38:07.566 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 7000 on /192.168.3.10 failed: java.net.SocketTimeoutException: Connect timed out
2026-07-30 12:38:07.566 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 32498 on /192.168.3.10 failed: java.net.SocketTimeoutException: Connect timed out
2026-07-30 12:38:07.566 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 3689 on /192.168.3.10 failed: java.net.SocketTimeoutException: Connect timed out
2026-07-30 12:38:12.680 [TRACE] [al.discovery.AtvDiscoveryParticipant] - Discovered AirPlay device Camping (1E:57:C6:CD:EC:F7) at 192.168.3.10
2026-07-30 12:38:16.557 [TRACE] [al.discovery.AtvDiscoveryParticipant] - Discovered AirPlay device Camping (1E:57:C6:CD:EC:F7) at 192.168.3.10
2026-07-30 12:38:34.813 [TRACE] [al.discovery.AtvDiscoveryParticipant] - Discovered AirPlay device Camping (1E:57:C6:CD:EC:F7) at 192.168.3.10
2026-07-30 12:38:37.771 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 3689 on /192.168.3.10
2026-07-30 12:38:37.772 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 49152 on /192.168.3.10
2026-07-30 12:38:37.772 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 7000 on /192.168.3.10
2026-07-30 12:38:37.772 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 32498 on /192.168.3.10
2026-07-30 12:38:37.773 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 3689 on /192.168.3.10 failed: java.net.ConnectException: Connection refused
2026-07-30 12:38:37.774 [DEBUG] [nternal.client.scan.ScanOrchestrator] - Auto-discovered Camping at 192.168.3.10:61975 via Companion ({rpmac=0, rphn=47cbe60b2da0, rpfl=0x36782, rpmd=AppleTV14,1, rpvr=715.2, rpmrtid=1D57C6CD-ECF7-4863-BCAB-5E3EEE5B2CED, rpad=62ff28a09b06, rpba=35:64:F3:61:A3:B3})
2026-07-30 12:38:37.774 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 32498 on /192.168.3.10 failed: java.net.ConnectException: Connection refused
2026-07-30 12:38:37.775 [DEBUG] [nternal.client.scan.ScanOrchestrator] - Auto-discovered Camping at 192.168.3.10:7000 via AirPlay ({acl=0, btaddr=54:6F:CB:00:A2:EB, deviceid=1E:57:C6:CD:EC:F7, fex=1d9/St5/Fzw4oY58, features=0x4A7FDFD5,0x3C177FDE, flags=0x204, gid=CCD412F8-DAA3-4F82-A1DA-31419C605261, igl=1, gcgl=1, model=AppleTV14,1, protovers=1.1, pi=33425b35-f9e8-4a44-97a2-1ac464c74e8a, psi=1D57C6CD-ECF7-4863-BCAB-5E3EEE5B2CED, pk=753d82c17da41aad50ef782a2bbd5f2a8adfe42fd18e054f3d641f4d9000f265, srcvers=950.7.1, osvers=26.5, vv=1})
2026-07-30 12:38:37.775 [DEBUG] [nternal.client.scan.ScanOrchestrator] - Auto-discovered 1E57C6CDECF7@Camping at 192.168.3.10:7000 via RAOP ({cn=0,1,2,3, da=true, et=0,3,5, ft=0x4A7FDFD5,0x3C177FDE, sf=0x204, md=0,1,2, am=AppleTV14,1, pk=753d82c17da41aad50ef782a2bbd5f2a8adfe42fd18e054f3d641f4d9000f265, tp=UDP, vn=65537, vs=950.7.1, ov=26.5, vv=1})
2026-07-30 12:38:37.776 [DEBUG] [nhab.binding.atv.internal.client.Atv] - Loading settings from MemoryStorage
2026-07-30 12:38:37.777 [DEBUG] [tv.internal.client.core.AppleTVRelay] - Adding handler for protocol Companion
2026-07-30 12:38:37.777 [DEBUG] [tv.internal.client.core.AppleTVRelay] - Connecting to protocol: Companion
2026-07-30 12:38:37.778 [DEBUG] [ent.protocols.companion.CompanionApi] - Connect to Companion from API
2026-07-30 12:38:37.779 [DEBUG] [tocols.companion.CompanionConnection] - Connected to companion device 192.168.3.10:61975
2026-07-30 12:38:37.779 [DEBUG] [rotocols.companion.CompanionProtocol] - Companion credentials: 800669aae62f0d79a12f252dd48dae53d7f361e7e22ea39a1f1e46b3fe7ac8d8:61e987a0149b3b8f9ae4f9ce22713d011c30f8967d9a6f1da33948d78f31b0a6:31443537433643442d454346372d343836332d424341422d354533454545354232434544:39636263386265652d336136372d343332642d396563642d353436356566383339633362
2026-07-30 12:38:37.780 [DEBUG] [rotocols.companion.CompanionProtocol] - Exchange OPACK: {_pd=[B@7c28d45a, _auTy=4}
2026-07-30 12:38:37.781 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_pd=[B@7c28d45a, _auTy=4, _x=23307}
2026-07-30 12:38:37.790 [DEBUG] [rotocols.companion.CompanionProtocol] - Received frame PV_Next (166 bytes)
2026-07-30 12:38:37.791 [DEBUG] [rotocols.companion.CompanionProtocol] - Process incoming auth frame (PV_Next): {_pd=[B@4fe65d69}
2026-07-30 12:38:37.793 [DEBUG] [rotocols.companion.CompanionProtocol] - Exchange OPACK: {_pd=[B@570800}
2026-07-30 12:38:37.793 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_pd=[B@570800, _x=23308}
2026-07-30 12:38:37.797 [DEBUG] [rotocols.companion.CompanionProtocol] - Received frame PV_Next (9 bytes)
2026-07-30 12:38:37.798 [DEBUG] [rotocols.companion.CompanionProtocol] - Process incoming auth frame (PV_Next): {_pd=[B@424988f2}
2026-07-30 12:38:37.798 [DEBUG] [ent.protocols.companion.CompanionApi] - Sending system information
2026-07-30 12:38:37.799 [DEBUG] [rotocols.companion.CompanionProtocol] - Exchange OPACK: {_i=_systemInfo, _t=2, _c={_bf=0, _cf=512, _clFl=128, _i=c7d42256f443, _idsID=[B@3a3fadfb, _pubID=FF:70:79:61:74:76, _sf=256, _sv=170.18, model=iPhone10,6, name=openHAB}, _x=23309}
2026-07-30 12:38:37.799 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_systemInfo, _t=2, _c={_bf=0, _cf=512, _clFl=128, _i=c7d42256f443, _idsID=[B@3a3fadfb, _pubID=FF:70:79:61:74:76, _sf=256, _sv=170.18, model=iPhone10,6, name=openHAB}, _x=23309}
2026-07-30 12:38:37.803 [DEBUG] [tocols.companion.CompanionConnection] - Require 5399 bytes but only 1448 in buffer
2026-07-30 12:38:37.803 [DEBUG] [rotocols.companion.CompanionProtocol] - Received frame E_OPACK (5379 bytes)
2026-07-30 12:38:37.804 [DEBUG] [rotocols.companion.CompanionProtocol] - Process incoming OPACK frame (E_OPACK): {_c={_lP=SizedLong[value=61975, size=4], _cf=SizedLong[value=512, size=2], _pubID=35:64:F3:61:A3:B3, _accAltDSID=001415-10-4ada4300-ad73-4809-b7dd-beebe7e14137, _stA=[com.apple.bluetooth.remote, SymptomNetworkDiagnostics, com.apple.devicediscoveryui.rapportwake, com.apple.tvremoteservices, com.apple.ApplicationService.chrono, com.apple.accessibility.axremoted.rapportWake, com.apple.dropin.setup, com.apple.wifivelocityd.rapportWake, com.apple.siri.wakeup, com.apple.workflow.remotewidgets, com.apple.networkrelay.on-demand-setup, com.apple.biomesyncd.rapport, com.apple.DDUI-Picker, com.apple.Seymour, com.apple.home.messaging, com.apple.siri.wakeup, com.apple.announce, com.apple.biomesyncd.cascade.rapport, com.apple.SeymourSession, com.apple.messagecenter.coordinatorlink], _sv=715.2, _spID=1829D260-A484-461E-9297-A30181339BB9, _mrID=1D57C6CD-ECF7-4863-BCAB-5E3EEE5B2CED, name=Camping, _aaltDSID=001415-10-4ada4300-ad73-4809-b7dd-beebe7e14137, _dCapF=1, _siriInfo={collectorElectionVersion=0.0, deviceCapabilitiesV2=[[B@7ff7bb1d, [B@45c72abd, [B@7d683d0d, [B@3a7f072e, [B@78126c2f], peerData={myriadTrialTreatment=, productType=AppleTV14,1, buildVersion=23L471, isLocationSharingDevice=false, aceVersion=13.0-20A, userInterfaceIdiom=ZEUS, isSiriCloudSyncEnabled=true, userAssignedDeviceName=Camping}}, _idsCID=31fa3445-b152-401a-9aef-b82e0cd36c3e, _i=1dba2efb02f6, _accID=olemr@olemr.com, _clFl=SizedLong[value=128, size=2], _bf=SizedLong[value=1920, size=2], _osV=26.5.0, model=productType, _mRtID=1D57C6CD-ECF7-4863-BCAB-5E3EEE5B2CED, _idsID=C0BA895E-8247-4406-B125-5438C5A9CBC7, _sf=SizedLong[value=65536, size=4], _dC=unknown}, _t=3, _x=SizedLong[value=23309, size=2]}
2026-07-30 12:38:37.805 [DEBUG] [rotocols.companion.CompanionProtocol] - Exchange OPACK: {_i=_touchStart, _t=2, _c={_height=1000.0, _tFl=0, _width=1000.0}, _x=23310}
2026-07-30 12:38:37.806 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_touchStart, _t=2, _c={_height=1000.0, _tFl=0, _width=1000.0}, _x=23310}
2026-07-30 12:38:37.807 [DEBUG] [rotocols.companion.CompanionProtocol] - Received frame E_OPACK (24 bytes)
2026-07-30 12:38:37.808 [DEBUG] [rotocols.companion.CompanionProtocol] - Process incoming OPACK frame (E_OPACK): {_x=SizedLong[value=23310, size=2], _rT=0, _c={_i=1}, _t=3}
2026-07-30 12:38:37.808 [DEBUG] [rotocols.companion.CompanionProtocol] - Exchange OPACK: {_i=_sessionStart, _t=2, _c={_srvT=com.apple.tvremoteservices, _sid=3445785907}, _x=23311}
2026-07-30 12:38:37.809 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_sessionStart, _t=2, _c={_srvT=com.apple.tvremoteservices, _sid=3445785907}, _x=23311}
2026-07-30 12:38:37.811 [DEBUG] [rotocols.companion.CompanionProtocol] - Received frame E_OPACK (34 bytes)
2026-07-30 12:38:37.812 [DEBUG] [rotocols.companion.CompanionProtocol] - Process incoming OPACK frame (E_OPACK): {_x=SizedLong[value=23311, size=2], _rT=0, _c={_sid=SizedLong[value=3903167590, size=8]}, _t=3}
2026-07-30 12:38:37.812 [DEBUG] [ent.protocols.companion.CompanionApi] - Started session with SID 0xe8a59c66cd628533
2026-07-30 12:38:37.813 [DEBUG] [rotocols.companion.CompanionProtocol] - Exchange OPACK: {_i=TVRCSessionStart, _t=2, _c={ProtocolVersionKey=1.2}, _x=23312}
2026-07-30 12:38:37.813 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=TVRCSessionStart, _t=2, _c={ProtocolVersionKey=1.2}, _x=23312}
2026-07-30 12:38:37.816 [DEBUG] [rotocols.companion.CompanionProtocol] - Received frame E_OPACK (43 bytes)
2026-07-30 12:38:37.817 [DEBUG] [rotocols.companion.CompanionProtocol] - Process incoming OPACK frame (E_OPACK): {_x=SizedLong[value=23312, size=2], _rT=1, _c={ProtocolVersionKey=1.2}, _t=3}
2026-07-30 12:38:37.817 [DEBUG] [ent.protocols.companion.CompanionApi] - Started TV RC session: {ProtocolVersionKey=1.2}
2026-07-30 12:38:37.818 [DEBUG] [rotocols.companion.CompanionProtocol] - Exchange OPACK: {_i=_tiStart, _t=2, _c={}, _x=23313}
2026-07-30 12:38:37.818 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_tiStart, _t=2, _c={}, _x=23313}
2026-07-30 12:38:37.820 [DEBUG] [rotocols.companion.CompanionProtocol] - Received frame E_OPACK (20 bytes)
2026-07-30 12:38:37.821 [DEBUG] [rotocols.companion.CompanionProtocol] - Process incoming OPACK frame (E_OPACK): {_x=SizedLong[value=23313, size=2], _rT=0, _c={}, _t=3}
2026-07-30 12:38:37.822 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_interest, _t=1, _c={_regEvents=[_iMC]}, _x=23314}
2026-07-30 12:38:37.822 [DEBUG] [rotocols.companion.CompanionProtocol] - Exchange OPACK: {_i=FetchAttentionState, _t=2, _c={}, _x=23315}
2026-07-30 12:38:37.823 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=FetchAttentionState, _t=2, _c={}, _x=23315}
2026-07-30 12:38:37.825 [DEBUG] [rotocols.companion.CompanionProtocol] - Received frame E_OPACK (33 bytes)
2026-07-30 12:38:37.825 [DEBUG] [rotocols.companion.CompanionProtocol] - Process incoming OPACK frame (E_OPACK): {_i=_iMC, _x=SizedLong[value=1835361258, size=4], _c={_mcF=SizedLong[value=256, size=2]}, _t=1}
2026-07-30 12:38:37.826 [DEBUG] [rotocols.companion.CompanionProtocol] - Received event: {_i=_iMC, _x=SizedLong[value=1835361258, size=4], _c={_mcF=SizedLong[value=256, size=2]}, _t=1}
2026-07-30 12:38:37.826 [DEBUG] [ent.protocols.companion.CompanionApi] - Got event _iMC from device: {_mcF=SizedLong[value=256, size=2]}
2026-07-30 12:38:37.826 [DEBUG] [rotocols.companion.CompanionFeatures] - Updated media control flags to 256
2026-07-30 12:38:37.826 [DEBUG] [rotocols.companion.CompanionProtocol] - Received frame E_OPACK (27 bytes)
2026-07-30 12:38:37.827 [DEBUG] [t.protocols.companion.CompanionAudio] - Volume control changed, updating volume
2026-07-30 12:38:37.827 [DEBUG] [rotocols.companion.CompanionProtocol] - Process incoming OPACK frame (E_OPACK): {_x=SizedLong[value=23315, size=2], _rT=0, _c={state=1}, _t=3}
2026-07-30 12:38:37.827 [DEBUG] [t.protocols.companion.CompanionPower] - Initial power state is Off
2026-07-30 12:38:37.827 [DEBUG] [rotocols.companion.CompanionProtocol] - Exchange OPACK: {_i=_mcc, _t=2, _c={_mcc=5}, _x=23316}
2026-07-30 12:38:37.828 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_interest, _t=1, _c={_regEvents=[SystemStatus]}, _x=23317}
2026-07-30 12:38:37.829 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_mcc, _t=2, _c={_mcc=5}, _x=23316}
2026-07-30 12:38:37.829 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_interest, _t=1, _c={_regEvents=[TVSystemStatus]}, _x=23318}
2026-07-30 12:38:37.830 [DEBUG] [tv.internal.client.core.AppleTVRelay] - Connected to protocol: Companion
2026-07-30 12:38:37.830 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_interest, _t=1, _c={_deregEvents=[_iMC]}, _x=23319}
2026-07-30 12:38:37.831 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_interest, _t=1, _c={_deregEvents=[SystemStatus]}, _x=23320}
2026-07-30 12:38:37.831 [DEBUG] [rotocols.companion.CompanionProtocol] - Received frame E_OPACK (30 bytes)
2026-07-30 12:38:37.832 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_interest, _t=1, _c={_deregEvents=[TVSystemStatus]}, _x=23321}
2026-07-30 12:38:37.833 [DEBUG] [rotocols.companion.CompanionProtocol] - Process incoming OPACK frame (E_OPACK): {_x=SizedLong[value=23316, size=2], _rT=0, _c={_vol=0.5}, _t=3}
2026-07-30 12:38:37.833 [DEBUG] [rotocols.companion.CompanionProtocol] - Exchange OPACK: {_i=_sessionStop, _t=2, _c={_srvT=com.apple.tvremoteservices, _sid=-1682766920406629069}, _x=23322}
2026-07-30 12:38:37.834 [DEBUG] [t.protocols.companion.CompanionAudio] - Volume changed to 50.0
2026-07-30 12:38:37.834 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_sessionStop, _t=2, _c={_srvT=com.apple.tvremoteservices, _sid=-1682766920406629069}, _x=23322}
2026-07-30 12:38:37.834 [DEBUG] [ent.protocols.companion.CompanionApi] - Ignoring error during disconnect: org.openhab.binding.atv.internal.client.exceptions.ProtocolError: Command _sessionStop failed
2026-07-30 12:38:37.835 [DEBUG] [tocols.companion.CompanionConnection] - Closing connection
2026-07-30 12:38:37.834 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type VOLUME to org.openhab.binding.atv.internal.client.core.AudioRelay$$Lambda/0x00000001011ed748@41c4e3fc
2026-07-30 12:38:38.731 [TRACE] [al.discovery.AtvDiscoveryParticipant] - Discovered AirPlay device Camping (1E:57:C6:CD:EC:F7) at 192.168.3.10
2026-07-30 12:39:26.112 [TRACE] [al.discovery.AtvDiscoveryParticipant] - Discovered AirPlay device Camping (1E:57:C6:CD:EC:F7) at 192.168.3.10
2026-07-30 12:39:29.950 [TRACE] [al.discovery.AtvDiscoveryParticipant] - Discovered AirPlay device Camping (1E:57:C6:CD:EC:F7) at 192.168.3.10
2026-07-30 12:39:37.836 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 3689 on /192.168.3.10
2026-07-30 12:39:37.836 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 49152 on /192.168.3.10
2026-07-30 12:39:37.837 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 7000 on /192.168.3.10
2026-07-30 12:39:37.837 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 32498 on /192.168.3.10
2026-07-30 12:39:37.839 [DEBUG] [nternal.client.scan.ScanOrchestrator] - Auto-discovered Camping at 192.168.3.10:61975 via Companion ({rpmac=0, rphn=47cbe60b2da0, rpfl=0x36782, rpmd=AppleTV14,1, rpvr=715.2, rpmrtid=1D57C6CD-ECF7-4863-BCAB-5E3EEE5B2CED, rpad=62ff28a09b06, rpba=35:64:F3:61:A3:B3})
2026-07-30 12:39:37.840 [DEBUG] [nternal.client.scan.ScanOrchestrator] - Auto-discovered Camping at 192.168.3.10:7000 via AirPlay ({acl=0, btaddr=54:6F:CB:00:A2:EB, deviceid=1E:57:C6:CD:EC:F7, fex=1d9/St5/Fzw4oY58, features=0x4A7FDFD5,0x3C177FDE, flags=0x244, gid=CCD412F8-DAA3-4F82-A1DA-31419C605261, igl=1, gcgl=1, model=AppleTV14,1, protovers=1.1, pi=33425b35-f9e8-4a44-97a2-1ac464c74e8a, psi=1D57C6CD-ECF7-4863-BCAB-5E3EEE5B2CED, pk=753d82c17da41aad50ef782a2bbd5f2a8adfe42fd18e054f3d641f4d9000f265, srcvers=950.7.1, osvers=26.5, vv=1})
2026-07-30 12:39:37.840 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 32498 on /192.168.3.10 failed: java.net.ConnectException: Connection refused
2026-07-30 12:39:37.841 [DEBUG] [nternal.client.scan.ScanOrchestrator] - Auto-discovered 1E57C6CDECF7@Camping at 192.168.3.10:7000 via RAOP ({cn=0,1,2,3, da=true, et=0,3,5, ft=0x4A7FDFD5,0x3C177FDE, sf=0x244, md=0,1,2, am=AppleTV14,1, pk=753d82c17da41aad50ef782a2bbd5f2a8adfe42fd18e054f3d641f4d9000f265, tp=UDP, vn=65537, vs=950.7.1, ov=26.5, vv=1})
2026-07-30 12:39:37.842 [DEBUG] [nhab.binding.atv.internal.client.Atv] - Loading settings from MemoryStorage
2026-07-30 12:39:37.843 [DEBUG] [tv.internal.client.core.AppleTVRelay] - Adding handler for protocol Companion
2026-07-30 12:39:37.843 [DEBUG] [tv.internal.client.core.AppleTVRelay] - Connecting to protocol: Companion
2026-07-30 12:39:37.844 [DEBUG] [ent.protocols.companion.CompanionApi] - Connect to Companion from API
2026-07-30 12:39:37.845 [DEBUG] [tocols.companion.CompanionConnection] - Connected to companion device 192.168.3.10:61975
2026-07-30 12:39:37.846 [DEBUG] [rotocols.companion.CompanionProtocol] - Companion credentials: 800669aae62f0d79a12f252dd48dae53d7f361e7e22ea39a1f1e46b3fe7ac8d8:61e987a0149b3b8f9ae4f9ce22713d011c30f8967d9a6f1da33948d78f31b0a6:31443537433643442d454346372d343836332d424341422d354533454545354232434544:39636263386265652d336136372d343332642d396563642d353436356566383339633362
2026-07-30 12:39:37.847 [DEBUG] [rotocols.companion.CompanionProtocol] - Exchange OPACK: {_pd=[B@7eb3b949, _auTy=4}
2026-07-30 12:39:37.848 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_pd=[B@7eb3b949, _auTy=4, _x=1557}
2026-07-30 12:39:37.859 [DEBUG] [rotocols.companion.CompanionProtocol] - Received frame PV_Next (166 bytes)
2026-07-30 12:39:37.860 [DEBUG] [rotocols.companion.CompanionProtocol] - Process incoming auth frame (PV_Next): {_pd=[B@11dcb8b7}
2026-07-30 12:39:37.862 [DEBUG] [rotocols.companion.CompanionProtocol] - Exchange OPACK: {_pd=[B@14ef078a}
2026-07-30 12:39:37.863 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_pd=[B@14ef078a, _x=1558}
2026-07-30 12:39:37.866 [DEBUG] [rotocols.companion.CompanionProtocol] - Received frame PV_Next (9 bytes)
2026-07-30 12:39:37.867 [DEBUG] [rotocols.companion.CompanionProtocol] - Process incoming auth frame (PV_Next): {_pd=[B@745fef6d}
2026-07-30 12:39:37.867 [DEBUG] [ent.protocols.companion.CompanionApi] - Sending system information
2026-07-30 12:39:37.868 [DEBUG] [rotocols.companion.CompanionProtocol] - Exchange OPACK: {_i=_systemInfo, _t=2, _c={_bf=0, _cf=512, _clFl=128, _i=8dd98f8f7807, _idsID=[B@3fdd2b4d, _pubID=FF:70:79:61:74:76, _sf=256, _sv=170.18, model=iPhone10,6, name=openHAB}, _x=1559}
2026-07-30 12:39:37.868 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_systemInfo, _t=2, _c={_bf=0, _cf=512, _clFl=128, _i=8dd98f8f7807, _idsID=[B@3fdd2b4d, _pubID=FF:70:79:61:74:76, _sf=256, _sv=170.18, model=iPhone10,6, name=openHAB}, _x=1559}
2026-07-30 12:39:37.872 [DEBUG] [tocols.companion.CompanionConnection] - Require 5399 bytes but only 1448 in buffer
2026-07-30 12:39:37.872 [DEBUG] [rotocols.companion.CompanionProtocol] - Received frame E_OPACK (5379 bytes)
2026-07-30 12:39:37.873 [DEBUG] [rotocols.companion.CompanionProtocol] - Process incoming OPACK frame (E_OPACK): {_c={_lP=SizedLong[value=61975, size=4], _cf=SizedLong[value=512, size=2], _pubID=35:64:F3:61:A3:B3, _accAltDSID=001415-10-4ada4300-ad73-4809-b7dd-beebe7e14137, _stA=[com.apple.bluetooth.remote, SymptomNetworkDiagnostics, com.apple.devicediscoveryui.rapportwake, com.apple.tvremoteservices, com.apple.ApplicationService.chrono, com.apple.accessibility.axremoted.rapportWake, com.apple.dropin.setup, com.apple.wifivelocityd.rapportWake, com.apple.siri.wakeup, com.apple.workflow.remotewidgets, com.apple.networkrelay.on-demand-setup, com.apple.biomesyncd.rapport, com.apple.DDUI-Picker, com.apple.Seymour, com.apple.home.messaging, com.apple.siri.wakeup, com.apple.announce, com.apple.biomesyncd.cascade.rapport, com.apple.SeymourSession, com.apple.messagecenter.coordinatorlink], _sv=715.2, _spID=1829D260-A484-461E-9297-A30181339BB9, _mrID=1D57C6CD-ECF7-4863-BCAB-5E3EEE5B2CED, name=Camping, _aaltDSID=001415-10-4ada4300-ad73-4809-b7dd-beebe7e14137, _dCapF=1, _siriInfo={collectorElectionVersion=0.0, deviceCapabilitiesV2=[[B@2e5a4529, [B@4d40d85a, [B@217f452f, [B@77ae850e, [B@ba1f5df], peerData={myriadTrialTreatment=, productType=AppleTV14,1, buildVersion=23L471, isLocationSharingDevice=false, aceVersion=13.0-20A, userInterfaceIdiom=ZEUS, isSiriCloudSyncEnabled=true, userAssignedDeviceName=Camping}}, _idsCID=31fa3445-b152-401a-9aef-b82e0cd36c3e, _i=1dba2efb02f6, _accID=olemr@olemr.com, _clFl=SizedLong[value=128, size=2], _bf=SizedLong[value=1920, size=2], _osV=26.5.0, model=productType, _mRtID=1D57C6CD-ECF7-4863-BCAB-5E3EEE5B2CED, _idsID=C0BA895E-8247-4406-B125-5438C5A9CBC7, _sf=SizedLong[value=65536, size=4], _dC=unknown}, _t=3, _x=SizedLong[value=1559, size=2]}
2026-07-30 12:39:37.874 [DEBUG] [rotocols.companion.CompanionProtocol] - Exchange OPACK: {_i=_touchStart, _t=2, _c={_height=1000.0, _tFl=0, _width=1000.0}, _x=1560}
2026-07-30 12:39:37.875 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_touchStart, _t=2, _c={_height=1000.0, _tFl=0, _width=1000.0}, _x=1560}
2026-07-30 12:39:37.877 [DEBUG] [rotocols.companion.CompanionProtocol] - Received frame E_OPACK (24 bytes)
2026-07-30 12:39:37.877 [DEBUG] [rotocols.companion.CompanionProtocol] - Process incoming OPACK frame (E_OPACK): {_x=SizedLong[value=1560, size=2], _rT=0, _c={_i=1}, _t=3}
2026-07-30 12:39:37.878 [DEBUG] [rotocols.companion.CompanionProtocol] - Exchange OPACK: {_i=_sessionStart, _t=2, _c={_srvT=com.apple.tvremoteservices, _sid=1454835831}, _x=1561}
2026-07-30 12:39:37.878 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_sessionStart, _t=2, _c={_srvT=com.apple.tvremoteservices, _sid=1454835831}, _x=1561}
2026-07-30 12:39:37.880 [DEBUG] [rotocols.companion.CompanionProtocol] - Received frame E_OPACK (34 bytes)
2026-07-30 12:39:37.881 [DEBUG] [rotocols.companion.CompanionProtocol] - Process incoming OPACK frame (E_OPACK): {_x=SizedLong[value=1561, size=2], _rT=0, _c={_sid=SizedLong[value=3903167591, size=8]}, _t=3}
2026-07-30 12:39:37.881 [DEBUG] [ent.protocols.companion.CompanionApi] - Started session with SID 0xe8a59c6756b70877
2026-07-30 12:39:37.882 [DEBUG] [rotocols.companion.CompanionProtocol] - Exchange OPACK: {_i=TVRCSessionStart, _t=2, _c={ProtocolVersionKey=1.2}, _x=1562}
2026-07-30 12:39:37.883 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=TVRCSessionStart, _t=2, _c={ProtocolVersionKey=1.2}, _x=1562}
2026-07-30 12:39:37.886 [DEBUG] [rotocols.companion.CompanionProtocol] - Received frame E_OPACK (43 bytes)
2026-07-30 12:39:37.886 [DEBUG] [rotocols.companion.CompanionProtocol] - Process incoming OPACK frame (E_OPACK): {_x=SizedLong[value=1562, size=2], _rT=1, _c={ProtocolVersionKey=1.2}, _t=3}
2026-07-30 12:39:37.887 [DEBUG] [ent.protocols.companion.CompanionApi] - Started TV RC session: {ProtocolVersionKey=1.2}
2026-07-30 12:39:37.887 [DEBUG] [rotocols.companion.CompanionProtocol] - Exchange OPACK: {_i=_tiStart, _t=2, _c={}, _x=1563}
2026-07-30 12:39:37.888 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_tiStart, _t=2, _c={}, _x=1563}
2026-07-30 12:39:37.890 [DEBUG] [rotocols.companion.CompanionProtocol] - Received frame E_OPACK (20 bytes)
2026-07-30 12:39:37.890 [DEBUG] [rotocols.companion.CompanionProtocol] - Process incoming OPACK frame (E_OPACK): {_x=SizedLong[value=1563, size=2], _rT=0, _c={}, _t=3}
2026-07-30 12:39:37.891 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_interest, _t=1, _c={_regEvents=[_iMC]}, _x=1564}
2026-07-30 12:39:37.892 [DEBUG] [rotocols.companion.CompanionProtocol] - Exchange OPACK: {_i=FetchAttentionState, _t=2, _c={}, _x=1565}
2026-07-30 12:39:37.893 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=FetchAttentionState, _t=2, _c={}, _x=1565}
2026-07-30 12:39:37.893 [DEBUG] [rotocols.companion.CompanionProtocol] - Received frame E_OPACK (33 bytes)
2026-07-30 12:39:37.894 [DEBUG] [rotocols.companion.CompanionProtocol] - Process incoming OPACK frame (E_OPACK): {_i=_iMC, _x=SizedLong[value=1835361259, size=4], _c={_mcF=SizedLong[value=256, size=2]}, _t=1}
2026-07-30 12:39:37.894 [DEBUG] [rotocols.companion.CompanionProtocol] - Received event: {_i=_iMC, _x=SizedLong[value=1835361259, size=4], _c={_mcF=SizedLong[value=256, size=2]}, _t=1}
2026-07-30 12:39:37.895 [DEBUG] [ent.protocols.companion.CompanionApi] - Got event _iMC from device: {_mcF=SizedLong[value=256, size=2]}
2026-07-30 12:39:37.895 [DEBUG] [rotocols.companion.CompanionFeatures] - Updated media control flags to 256
2026-07-30 12:39:37.895 [DEBUG] [rotocols.companion.CompanionProtocol] - Received frame E_OPACK (27 bytes)
2026-07-30 12:39:37.896 [DEBUG] [t.protocols.companion.CompanionAudio] - Volume control changed, updating volume
2026-07-30 12:39:37.896 [DEBUG] [rotocols.companion.CompanionProtocol] - Process incoming OPACK frame (E_OPACK): {_x=SizedLong[value=1565, size=2], _rT=0, _c={state=1}, _t=3}
2026-07-30 12:39:37.897 [DEBUG] [rotocols.companion.CompanionProtocol] - Exchange OPACK: {_i=_mcc, _t=2, _c={_mcc=5}, _x=1566}
2026-07-30 12:39:37.897 [DEBUG] [t.protocols.companion.CompanionPower] - Initial power state is Off
2026-07-30 12:39:37.897 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_interest, _t=1, _c={_regEvents=[SystemStatus]}, _x=1567}
2026-07-30 12:39:37.898 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_mcc, _t=2, _c={_mcc=5}, _x=1566}
2026-07-30 12:39:37.898 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_interest, _t=1, _c={_regEvents=[TVSystemStatus]}, _x=1568}
2026-07-30 12:39:37.899 [DEBUG] [tv.internal.client.core.AppleTVRelay] - Connected to protocol: Companion
2026-07-30 12:39:37.899 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_interest, _t=1, _c={_deregEvents=[_iMC]}, _x=1569}
2026-07-30 12:39:37.900 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_interest, _t=1, _c={_deregEvents=[SystemStatus]}, _x=1570}
2026-07-30 12:39:37.900 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_interest, _t=1, _c={_deregEvents=[TVSystemStatus]}, _x=1571}
2026-07-30 12:39:37.901 [DEBUG] [rotocols.companion.CompanionProtocol] - Exchange OPACK: {_i=_sessionStop, _t=2, _c={_srvT=com.apple.tvremoteservices, _sid=-1682766918102611849}, _x=1572}
2026-07-30 12:39:37.901 [DEBUG] [rotocols.companion.CompanionProtocol] - Received frame E_OPACK (30 bytes)
2026-07-30 12:39:37.901 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_sessionStop, _t=2, _c={_srvT=com.apple.tvremoteservices, _sid=-1682766918102611849}, _x=1572}
2026-07-30 12:39:37.902 [DEBUG] [ent.protocols.companion.CompanionApi] - Ignoring error during disconnect: org.openhab.binding.atv.internal.client.exceptions.ProtocolError: Command _sessionStop failed
2026-07-30 12:39:37.902 [DEBUG] [tocols.companion.CompanionConnection] - Closing connection
2026-07-30 12:39:37.902 [DEBUG] [rotocols.companion.CompanionProtocol] - Process incoming OPACK frame (E_OPACK): {_x=SizedLong[value=1566, size=2], _rT=1, _c={_vol=0.5}, _t=3}
2026-07-30 12:39:37.903 [DEBUG] [rotocols.companion.CompanionProtocol] - No receiver for XID 1566
2026-07-30 12:39:38.850 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 3689 on /192.168.3.10 failed: java.net.ConnectException: Connection refused
2026-07-30 12:39:42.900 [DEBUG] [t.protocols.companion.CompanionAudio] - Failed to fetch volume: java.util.concurrent.CompletionException: org.openhab.binding.atv.internal.client.exceptions.ProtocolError: Command _mcc failed
2026-07-30 12:40:37.905 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 3689 on /192.168.3.10
2026-07-30 12:40:37.905 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 49152 on /192.168.3.10
2026-07-30 12:40:37.906 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 32498 on /192.168.3.10
2026-07-30 12:40:37.905 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 7000 on /192.168.3.10
2026-07-30 12:40:39.706 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 49152 on /192.168.3.10 failed: java.net.SocketTimeoutException: Connect timed out
2026-07-30 12:40:39.706 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 32498 on /192.168.3.10 failed: java.net.SocketTimeoutException: Connect timed out
2026-07-30 12:40:39.706 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 3689 on /192.168.3.10 failed: java.net.SocketTimeoutException: Connect timed out
2026-07-30 12:40:39.707 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 7000 on /192.168.3.10 failed: java.net.SocketTimeoutException: Connect timed out
2026-07-30 12:40:39.905 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 49152 on /192.168.3.10
2026-07-30 12:40:39.905 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 32498 on /192.168.3.10
2026-07-30 12:40:39.905 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 3689 on /192.168.3.10
2026-07-30 12:40:39.905 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 7000 on /192.168.3.10
2026-07-30 12:40:41.706 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 3689 on /192.168.3.10 failed: java.net.SocketTimeoutException: Connect timed out
2026-07-30 12:40:41.706 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 32498 on /192.168.3.10 failed: java.net.SocketTimeoutException: Connect timed out
2026-07-30 12:40:41.706 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 7000 on /192.168.3.10 failed: java.net.SocketTimeoutException: Connect timed out
2026-07-30 12:40:41.706 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 49152 on /192.168.3.10 failed: java.net.SocketTimeoutException: Connect timed out
2026-07-30 12:40:41.905 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 7000 on /192.168.3.10
2026-07-30 12:40:41.905 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 3689 on /192.168.3.10
2026-07-30 12:40:41.905 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 32498 on /192.168.3.10
2026-07-30 12:40:41.905 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 49152 on /192.168.3.10
2026-07-30 12:40:43.706 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 7000 on /192.168.3.10 failed: java.net.SocketTimeoutException: Connect timed out
2026-07-30 12:40:43.706 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 32498 on /192.168.3.10 failed: java.net.SocketTimeoutException: Connect timed out
2026-07-30 12:40:43.707 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 49152 on /192.168.3.10 failed: java.net.SocketTimeoutException: Connect timed out
2026-07-30 12:40:43.707 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 3689 on /192.168.3.10 failed: java.net.SocketTimeoutException: Connect timed out
2026-07-30 12:40:43.906 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 7000 on /192.168.3.10
2026-07-30 12:40:43.906 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 49152 on /192.168.3.10
2026-07-30 12:40:43.906 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 3689 on /192.168.3.10
2026-07-30 12:40:43.906 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 32498 on /192.168.3.10
2026-07-30 12:40:45.706 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 3689 on /192.168.3.10 failed: java.net.SocketTimeoutException: Connect timed out
2026-07-30 12:40:45.706 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 49152 on /192.168.3.10 failed: java.net.SocketTimeoutException: Connect timed out
2026-07-30 12:40:45.707 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 32498 on /192.168.3.10 failed: java.net.SocketTimeoutException: Connect timed out
2026-07-30 12:40:45.707 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 7000 on /192.168.3.10 failed: java.net.SocketTimeoutException: Connect timed out
2026-07-30 12:40:53.101 [TRACE] [al.discovery.AtvDiscoveryParticipant] - Discovered AirPlay device Camping (1E:57:C6:CD:EC:F7) at 192.168.3.10
2026-07-30 12:40:56.945 [TRACE] [al.discovery.AtvDiscoveryParticipant] - Discovered AirPlay device Camping (1E:57:C6:CD:EC:F7) at 192.168.3.10

Now, setting Power channel to ON: (this time it worked on first attempt, but Power state toggled between ON/OFF/ON at least one time that I could see. Perhaps I didn’t wait long enough on my previous attempt?)

2026-07-30 12:43:41.832 [DEBUG] [ding.atv.internal.handler.AtvHandler] - Power ON requested while offline; reconnecting to wake 1E:57:C6:CD:EC:F7
2026-07-30 12:43:43.332 [TRACE] [al.discovery.AtvDiscoveryParticipant] - Discovered AirPlay device Camping (1E:57:C6:CD:EC:F7) at 192.168.3.10
2026-07-30 12:43:44.834 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 3689 on /192.168.3.10
2026-07-30 12:43:44.834 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 49152 on /192.168.3.10
2026-07-30 12:43:44.835 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 32498 on /192.168.3.10
2026-07-30 12:43:44.834 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knocking at port 7000 on /192.168.3.10
2026-07-30 12:43:44.838 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 32498 on /192.168.3.10 failed: java.net.ConnectException: Connection refused
2026-07-30 12:43:44.839 [DEBUG] [nternal.client.scan.ScanOrchestrator] - Auto-discovered Camping at 192.168.3.10:61975 via Companion ({rpmac=0, rphn=47cbe60b2da0, rpfl=0x36782, rpmd=AppleTV14,1, rpvr=715.2, rpmrtid=1D57C6CD-ECF7-4863-BCAB-5E3EEE5B2CED, rpad=62ff28a09b06, rpba=35:64:F3:61:A3:B3})
2026-07-30 12:43:44.840 [DEBUG] [nternal.client.scan.ScanOrchestrator] - Auto-discovered Camping at 192.168.3.10:7000 via AirPlay ({acl=0, btaddr=54:6F:CB:00:A2:EB, deviceid=1E:57:C6:CD:EC:F7, fex=1d9/St5/Fzw4oY58, features=0x4A7FDFD5,0x3C177FDE, flags=0x204, gid=CCD412F8-DAA3-4F82-A1DA-31419C605261, igl=1, gcgl=1, model=AppleTV14,1, protovers=1.1, pi=33425b35-f9e8-4a44-97a2-1ac464c74e8a, psi=1D57C6CD-ECF7-4863-BCAB-5E3EEE5B2CED, pk=753d82c17da41aad50ef782a2bbd5f2a8adfe42fd18e054f3d641f4d9000f265, srcvers=950.7.1, osvers=26.5, vv=1})
2026-07-30 12:43:44.841 [DEBUG] [nternal.client.scan.ScanOrchestrator] - Auto-discovered 1E57C6CDECF7@Camping at 192.168.3.10:7000 via RAOP ({cn=0,1,2,3, da=true, et=0,3,5, ft=0x4A7FDFD5,0x3C177FDE, sf=0x204, md=0,1,2, am=AppleTV14,1, pk=753d82c17da41aad50ef782a2bbd5f2a8adfe42fd18e054f3d641f4d9000f265, tp=UDP, vn=65537, vs=950.7.1, ov=26.5, vv=1})
2026-07-30 12:43:44.843 [DEBUG] [nhab.binding.atv.internal.client.Atv] - Loading settings from MemoryStorage
2026-07-30 12:43:44.844 [DEBUG] [nal.client.protocols.airplay.AirPlay] - Remote control channel is supported
2026-07-30 12:43:44.847 [DEBUG] [tv.internal.client.core.AppleTVRelay] - Adding handler for protocol AirPlay
2026-07-30 12:43:44.848 [DEBUG] [tv.internal.client.core.AppleTVRelay] - Adding handler for protocol MRP
2026-07-30 12:43:44.849 [DEBUG] [tv.internal.client.core.AppleTVRelay] - Adding handler for protocol Companion
2026-07-30 12:43:44.852 [DEBUG] [tv.internal.client.core.AppleTVRelay] - Adding handler for protocol MRP
2026-07-30 12:43:44.853 [DEBUG] [tv.internal.client.core.AppleTVRelay] - Adding handler for protocol RAOP
2026-07-30 12:43:44.854 [DEBUG] [tv.internal.client.core.AppleTVRelay] - Connecting to protocol: AirPlay
2026-07-30 12:43:44.854 [DEBUG] [tv.internal.client.core.AppleTVRelay] - Connected to protocol: AirPlay
2026-07-30 12:43:44.855 [DEBUG] [tv.internal.client.core.AppleTVRelay] - Connecting to protocol: MRP
2026-07-30 12:43:44.856 [DEBUG] [.client.protocols.airplay.Ap2Session] - Setting up remote connection to 192.168.3.10:7000
2026-07-30 12:43:44.858 [DEBUG] [l.client.support.http.HttpConnection] - Connected to 192.168.3.10
2026-07-30 12:43:44.859 [DEBUG] [client.protocols.airplay.AirPlayAuth] - Setting up new AirPlay Pair-Verify procedure with type HAP
2026-07-30 12:43:44.862 [TRACE] [l.client.support.http.HttpConnection] - Sending HTTP/1.1 message: POST /pair-verify
2026-07-30 12:43:44.878 [TRACE] [l.client.support.http.HttpConnection] - Got HTTP response: 200 OK
2026-07-30 12:43:44.882 [TRACE] [l.client.support.http.HttpConnection] - Sending HTTP/1.1 message: POST /pair-verify
2026-07-30 12:43:44.889 [TRACE] [l.client.support.http.HttpConnection] - Got HTTP response: 200 OK
2026-07-30 12:43:44.892 [TRACE] [l.client.support.http.HttpConnection] - Sending RTSP/1.0 message: SETUP rtsp://192.168.3.6/1969593195
2026-07-30 12:43:44.895 [TRACE] [l.client.support.http.HttpConnection] - Got RTSP response: 200 OK
2026-07-30 12:43:44.898 [DEBUG] [.atv.internal.client.auth.HapChannel] - Connected to 192.168.3.10:62800
2026-07-30 12:43:44.899 [TRACE] [l.client.support.http.HttpConnection] - Sending RTSP/1.0 message: RECORD rtsp://192.168.3.6/1969593195
2026-07-30 12:43:44.905 [TRACE] [l.client.support.http.HttpConnection] - Got RTSP response: 200 OK
2026-07-30 12:43:44.905 [DEBUG] [lient.protocols.airplay.EventChannel] - Got message on event channel: POST /command
2026-07-30 12:43:44.908 [TRACE] [l.client.support.http.HttpConnection] - Sending RTSP/1.0 message: SETUP rtsp://192.168.3.6/1969593195
2026-07-30 12:43:44.912 [TRACE] [l.client.support.http.HttpConnection] - Got RTSP response: 200 OK
2026-07-30 12:43:44.914 [DEBUG] [.atv.internal.client.auth.HapChannel] - Connected to 192.168.3.10:62801
2026-07-30 12:43:44.916 [DEBUG] [atv.internal.client.core.Heartbeater] - Starting heartbeat loop (AirPlay:192.168.3.10)
2026-07-30 12:43:44.918 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - >> Send: Protobuf type=DEVICE_INFO_MESSAGE
2026-07-30 12:43:44.920 [DEBUG] [.protocols.airplay.DataStreamChannel] - Got message with unsupported format: {}
2026-07-30 12:43:44.924 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=DEVICE_INFO_MESSAGE
2026-07-30 12:43:44.925 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type DEVICE_INFO_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.MrpPower$$Lambda/0x000000010120b990@3287b3ae
2026-07-30 12:43:44.926 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type DEVICE_INFO_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.MrpAudio$$Lambda/0x000000010122afb0@24f1c2f6
2026-07-30 12:43:44.928 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type OUTPUT_DEVICES to org.openhab.binding.atv.internal.client.core.AudioRelay$$Lambda/0x00000001011ee3e8@5591e6ea
2026-07-30 12:43:44.929 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - >> Send: Protobuf type=SET_CONNECTION_STATE_MESSAGE
2026-07-30 12:43:44.931 [DEBUG] [.protocols.airplay.DataStreamChannel] - Got message with unsupported format: {}
2026-07-30 12:43:44.931 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - >> Send: Protobuf type=CLIENT_UPDATES_CONFIG_MESSAGE
2026-07-30 12:43:44.933 [DEBUG] [.protocols.airplay.DataStreamChannel] - Got message with unsupported format: {}
2026-07-30 12:43:44.953 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=UPDATE_OUTPUT_DEVICE_MESSAGE
2026-07-30 12:43:44.955 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=VOLUME_CONTROL_AVAILABILITY_MESSAGE
2026-07-30 12:43:44.955 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type VOLUME_CONTROL_AVAILABILITY_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.MrpAudio$$Lambda/0x000000010122a938@10730fbd
2026-07-30 12:43:44.956 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=SET_DEFAULT_SUPPORTED_COMMANDS_MESSAGE
2026-07-30 12:43:44.956 [DEBUG] [ternal.client.protocols.mrp.MrpAudio] - Volume control availability changed to true
2026-07-30 12:43:44.957 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type SET_DEFAULT_SUPPORTED_COMMANDS_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.PlayerStateManager$$Lambda/0x000000010120aa90@1fe6c4de
2026-07-30 12:43:44.958 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=SET_DEFAULT_SUPPORTED_COMMANDS_MESSAGE
2026-07-30 12:43:44.959 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type SET_DEFAULT_SUPPORTED_COMMANDS_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.PlayerStateManager$$Lambda/0x000000010120aa90@1fe6c4de
2026-07-30 12:43:44.960 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=ORIGIN_CLIENT_PROPERTIES_MESSAGE
2026-07-30 12:43:44.960 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=SET_NOW_PLAYING_CLIENT_MESSAGE
2026-07-30 12:43:44.961 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type SET_NOW_PLAYING_CLIENT_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.PlayerStateManager$$Lambda/0x0000000101209fc8@158a52a3
2026-07-30 12:43:44.961 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=UPDATE_CLIENT_MESSAGE
2026-07-30 12:43:44.961 [DEBUG] [ent.protocols.mrp.PlayerStateManager] - Active client is now com.google.ios.youtube
2026-07-30 12:43:44.962 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type UPDATE_CLIENT_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.PlayerStateManager$$Lambda/0x000000010120a418@3f46c496
2026-07-30 12:43:44.963 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=SET_STATE_MESSAGE
2026-07-30 12:43:44.964 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type SET_STATE_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.PlayerStateManager$$Lambda/0x0000000101209b78@37402a24
2026-07-30 12:43:44.964 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=PLAYER_CLIENT_PROPERTIES_MESSAGE
2026-07-30 12:43:44.965 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=UPDATE_CLIENT_MESSAGE
2026-07-30 12:43:44.965 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type UPDATE_CLIENT_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.PlayerStateManager$$Lambda/0x000000010120a418@3f46c496
2026-07-30 12:43:44.966 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=SET_STATE_MESSAGE
2026-07-30 12:43:44.967 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type SET_STATE_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.PlayerStateManager$$Lambda/0x0000000101209b78@37402a24
2026-07-30 12:43:44.968 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=PLAYER_CLIENT_PROPERTIES_MESSAGE
2026-07-30 12:43:44.969 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=UPDATE_CLIENT_MESSAGE
2026-07-30 12:43:44.970 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type UPDATE_CLIENT_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.PlayerStateManager$$Lambda/0x000000010120a418@3f46c496
2026-07-30 12:43:44.970 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=SET_STATE_MESSAGE
2026-07-30 12:43:44.971 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type SET_STATE_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.PlayerStateManager$$Lambda/0x0000000101209b78@37402a24
2026-07-30 12:43:44.972 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=PLAYER_CLIENT_PROPERTIES_MESSAGE
2026-07-30 12:43:44.973 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=SET_STATE_MESSAGE
2026-07-30 12:43:44.973 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type SET_STATE_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.PlayerStateManager$$Lambda/0x0000000101209b78@37402a24
2026-07-30 12:43:44.974 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=PLAYER_CLIENT_PROPERTIES_MESSAGE
2026-07-30 12:43:44.975 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=UPDATE_PLAYER_MESSAGE
2026-07-30 12:43:44.975 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=SET_STATE_MESSAGE
2026-07-30 12:43:44.976 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type SET_STATE_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.PlayerStateManager$$Lambda/0x0000000101209b78@37402a24
2026-07-30 12:43:44.977 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=PLAYER_CLIENT_PROPERTIES_MESSAGE
2026-07-30 12:43:44.977 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=UPDATE_PLAYER_MESSAGE
2026-07-30 12:43:44.978 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=SET_STATE_MESSAGE
2026-07-30 12:43:44.978 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type SET_STATE_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.PlayerStateManager$$Lambda/0x0000000101209b78@37402a24
2026-07-30 12:43:44.979 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=PLAYER_CLIENT_PROPERTIES_MESSAGE
2026-07-30 12:43:44.979 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=UPDATE_PLAYER_MESSAGE
2026-07-30 12:43:44.979 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=SET_STATE_MESSAGE
2026-07-30 12:43:44.980 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type SET_STATE_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.PlayerStateManager$$Lambda/0x0000000101209b78@37402a24
2026-07-30 12:43:44.980 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=PLAYER_CLIENT_PROPERTIES_MESSAGE
2026-07-30 12:43:44.981 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=UPDATE_PLAYER_MESSAGE
2026-07-30 12:43:44.981 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=SET_STATE_MESSAGE
2026-07-30 12:43:44.981 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type SET_STATE_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.PlayerStateManager$$Lambda/0x0000000101209b78@37402a24
2026-07-30 12:43:44.982 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=PLAYER_CLIENT_PROPERTIES_MESSAGE
2026-07-30 12:43:44.982 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=UPDATE_PLAYER_MESSAGE
2026-07-30 12:43:44.983 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=SET_STATE_MESSAGE
2026-07-30 12:43:44.983 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type SET_STATE_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.PlayerStateManager$$Lambda/0x0000000101209b78@37402a24
2026-07-30 12:43:44.983 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=PLAYER_CLIENT_PROPERTIES_MESSAGE
2026-07-30 12:43:44.984 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=UPDATE_PLAYER_MESSAGE
2026-07-30 12:43:44.984 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=SET_STATE_MESSAGE
2026-07-30 12:43:44.984 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type SET_STATE_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.PlayerStateManager$$Lambda/0x0000000101209b78@37402a24
2026-07-30 12:43:44.985 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=PLAYER_CLIENT_PROPERTIES_MESSAGE
2026-07-30 12:43:44.985 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=UPDATE_PLAYER_MESSAGE
2026-07-30 12:43:44.986 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=SET_STATE_MESSAGE
2026-07-30 12:43:44.986 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type SET_STATE_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.PlayerStateManager$$Lambda/0x0000000101209b78@37402a24
2026-07-30 12:43:44.986 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=PLAYER_CLIENT_PROPERTIES_MESSAGE
2026-07-30 12:43:44.987 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=UPDATE_PLAYER_MESSAGE
2026-07-30 12:43:44.987 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=SET_STATE_MESSAGE
2026-07-30 12:43:44.987 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type SET_STATE_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.PlayerStateManager$$Lambda/0x0000000101209b78@37402a24
2026-07-30 12:43:44.988 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=PLAYER_CLIENT_PROPERTIES_MESSAGE
2026-07-30 12:43:44.988 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=UPDATE_PLAYER_MESSAGE
2026-07-30 12:43:44.989 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=SET_STATE_MESSAGE
2026-07-30 12:43:44.989 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type SET_STATE_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.PlayerStateManager$$Lambda/0x0000000101209b78@37402a24
2026-07-30 12:43:44.990 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=PLAYER_CLIENT_PROPERTIES_MESSAGE
2026-07-30 12:43:44.990 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=UPDATE_PLAYER_MESSAGE
2026-07-30 12:43:44.991 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=SET_STATE_MESSAGE
2026-07-30 12:43:44.991 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type SET_STATE_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.PlayerStateManager$$Lambda/0x0000000101209b78@37402a24
2026-07-30 12:43:44.991 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=PLAYER_CLIENT_PROPERTIES_MESSAGE
2026-07-30 12:43:44.992 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=UPDATE_PLAYER_MESSAGE
2026-07-30 12:43:44.992 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=SET_STATE_MESSAGE
2026-07-30 12:43:44.993 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type SET_STATE_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.PlayerStateManager$$Lambda/0x0000000101209b78@37402a24
2026-07-30 12:43:44.993 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=PLAYER_CLIENT_PROPERTIES_MESSAGE
2026-07-30 12:43:44.993 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=UPDATE_PLAYER_MESSAGE
2026-07-30 12:43:44.994 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=SET_STATE_MESSAGE
2026-07-30 12:43:44.994 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type SET_STATE_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.PlayerStateManager$$Lambda/0x0000000101209b78@37402a24
2026-07-30 12:43:44.995 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=PLAYER_CLIENT_PROPERTIES_MESSAGE
2026-07-30 12:43:44.995 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=UPDATE_PLAYER_MESSAGE
2026-07-30 12:43:44.996 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=SET_STATE_MESSAGE
2026-07-30 12:43:44.997 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type SET_STATE_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.PlayerStateManager$$Lambda/0x0000000101209b78@37402a24
2026-07-30 12:43:44.997 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=PLAYER_CLIENT_PROPERTIES_MESSAGE
2026-07-30 12:43:44.998 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=UPDATE_PLAYER_MESSAGE
2026-07-30 12:43:44.998 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=SET_STATE_MESSAGE
2026-07-30 12:43:44.999 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type SET_STATE_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.PlayerStateManager$$Lambda/0x0000000101209b78@37402a24
2026-07-30 12:43:44.999 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=PLAYER_CLIENT_PROPERTIES_MESSAGE
2026-07-30 12:43:44.999 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=UPDATE_PLAYER_MESSAGE
2026-07-30 12:43:45.000 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=SET_STATE_MESSAGE
2026-07-30 12:43:45.000 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type SET_STATE_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.PlayerStateManager$$Lambda/0x0000000101209b78@37402a24
2026-07-30 12:43:45.000 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=PLAYER_CLIENT_PROPERTIES_MESSAGE
2026-07-30 12:43:45.001 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=UPDATE_PLAYER_MESSAGE
2026-07-30 12:43:45.001 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=UPDATE_CLIENT_MESSAGE
2026-07-30 12:43:45.001 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type UPDATE_CLIENT_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.PlayerStateManager$$Lambda/0x000000010120a418@3f46c496
2026-07-30 12:43:45.003 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=SET_STATE_MESSAGE
2026-07-30 12:43:45.003 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type SET_STATE_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.PlayerStateManager$$Lambda/0x0000000101209b78@37402a24
2026-07-30 12:43:45.004 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=PLAYER_CLIENT_PROPERTIES_MESSAGE
2026-07-30 12:43:45.005 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=UPDATE_CLIENT_MESSAGE
2026-07-30 12:43:45.006 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type UPDATE_CLIENT_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.PlayerStateManager$$Lambda/0x000000010120a418@3f46c496
2026-07-30 12:43:45.007 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=SET_STATE_MESSAGE
2026-07-30 12:43:45.008 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type SET_STATE_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.PlayerStateManager$$Lambda/0x0000000101209b78@37402a24
2026-07-30 12:43:45.008 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=PLAYER_CLIENT_PROPERTIES_MESSAGE
2026-07-30 12:43:45.009 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=UPDATE_CLIENT_MESSAGE
2026-07-30 12:43:45.010 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type UPDATE_CLIENT_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.PlayerStateManager$$Lambda/0x000000010120a418@3f46c496
2026-07-30 12:43:45.010 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=SET_STATE_MESSAGE
2026-07-30 12:43:45.011 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type SET_STATE_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.PlayerStateManager$$Lambda/0x0000000101209b78@37402a24
2026-07-30 12:43:45.011 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=PLAYER_CLIENT_PROPERTIES_MESSAGE
2026-07-30 12:43:45.012 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=UNKNOWN_MESSAGE
2026-07-30 12:43:45.014 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - >> Send: Protobuf type=GET_KEYBOARD_SESSION_MESSAGE
2026-07-30 12:43:45.014 [DEBUG] [.protocols.airplay.DataStreamChannel] - Got message with unsupported format: {}
2026-07-30 12:43:45.016 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=KEYBOARD_MESSAGE
2026-07-30 12:43:45.016 [DEBUG] [tv.internal.client.core.AppleTVRelay] - Connected to protocol: MRP
2026-07-30 12:43:45.017 [DEBUG] [tv.internal.client.core.AppleTVRelay] - Connecting to protocol: Companion
2026-07-30 12:43:45.018 [DEBUG] [ent.protocols.companion.CompanionApi] - Connect to Companion from API
2026-07-30 12:43:45.019 [DEBUG] [tocols.companion.CompanionConnection] - Connected to companion device 192.168.3.10:61975
2026-07-30 12:43:45.020 [DEBUG] [rotocols.companion.CompanionProtocol] - Companion credentials: 800669aae62f0d79a12f252dd48dae53d7f361e7e22ea39a1f1e46b3fe7ac8d8:61e987a0149b3b8f9ae4f9ce22713d011c30f8967d9a6f1da33948d78f31b0a6:31443537433643442d454346372d343836332d424341422d354533454545354232434544:39636263386265652d336136372d343332642d396563642d353436356566383339633362
2026-07-30 12:43:45.021 [DEBUG] [rotocols.companion.CompanionProtocol] - Exchange OPACK: {_pd=[B@effabe, _auTy=4}
2026-07-30 12:43:45.021 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_pd=[B@effabe, _auTy=4, _x=65449}
2026-07-30 12:43:45.031 [DEBUG] [rotocols.companion.CompanionProtocol] - Received frame PV_Next (166 bytes)
2026-07-30 12:43:45.032 [DEBUG] [rotocols.companion.CompanionProtocol] - Process incoming auth frame (PV_Next): {_pd=[B@5605cbe5}
2026-07-30 12:43:45.034 [DEBUG] [rotocols.companion.CompanionProtocol] - Exchange OPACK: {_pd=[B@1665346b}
2026-07-30 12:43:45.035 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_pd=[B@1665346b, _x=65450}
2026-07-30 12:43:45.040 [DEBUG] [rotocols.companion.CompanionProtocol] - Received frame PV_Next (9 bytes)
2026-07-30 12:43:45.040 [DEBUG] [rotocols.companion.CompanionProtocol] - Process incoming auth frame (PV_Next): {_pd=[B@3e917fc9}
2026-07-30 12:43:45.041 [DEBUG] [ent.protocols.companion.CompanionApi] - Sending system information
2026-07-30 12:43:45.041 [DEBUG] [rotocols.companion.CompanionProtocol] - Exchange OPACK: {_i=_systemInfo, _t=2, _c={_bf=0, _cf=512, _clFl=128, _i=cf6fabfdfde9, _idsID=[B@75b062c4, _pubID=FF:70:79:61:74:76, _sf=256, _sv=170.18, model=iPhone10,6, name=openHAB}, _x=65451}
2026-07-30 12:43:45.042 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_systemInfo, _t=2, _c={_bf=0, _cf=512, _clFl=128, _i=cf6fabfdfde9, _idsID=[B@75b062c4, _pubID=FF:70:79:61:74:76, _sf=256, _sv=170.18, model=iPhone10,6, name=openHAB}, _x=65451}
2026-07-30 12:43:45.046 [DEBUG] [tocols.companion.CompanionConnection] - Require 5398 bytes but only 1448 in buffer
2026-07-30 12:43:45.046 [DEBUG] [rotocols.companion.CompanionProtocol] - Received frame E_OPACK (5378 bytes)
2026-07-30 12:43:45.047 [DEBUG] [rotocols.companion.CompanionProtocol] - Process incoming OPACK frame (E_OPACK): {_c={_lP=SizedLong[value=61975, size=4], _cf=SizedLong[value=512, size=2], _pubID=35:64:F3:61:A3:B3, _accAltDSID=001415-10-4ada4300-ad73-4809-b7dd-beebe7e14137, _stA=[com.apple.bluetooth.remote, SymptomNetworkDiagnostics, com.apple.devicediscoveryui.rapportwake, com.apple.tvremoteservices, com.apple.ApplicationService.chrono, com.apple.accessibility.axremoted.rapportWake, com.apple.dropin.setup, com.apple.wifivelocityd.rapportWake, com.apple.siri.wakeup, com.apple.workflow.remotewidgets, com.apple.networkrelay.on-demand-setup, com.apple.biomesyncd.rapport, com.apple.DDUI-Picker, com.apple.Seymour, com.apple.home.messaging, com.apple.siri.wakeup, com.apple.announce, com.apple.biomesyncd.cascade.rapport, com.apple.SeymourSession, com.apple.messagecenter.coordinatorlink], _sv=715.2, _spID=1829D260-A484-461E-9297-A30181339BB9, _mrID=1D57C6CD-ECF7-4863-BCAB-5E3EEE5B2CED, name=Camping, _aaltDSID=001415-10-4ada4300-ad73-4809-b7dd-beebe7e14137, _dCapF=1, _siriInfo={collectorElectionVersion=0.0, deviceCapabilitiesV2=[[B@4235e4bf, [B@3d70dc4d, [B@20971e4, [B@74d98523, [B@1924971b], peerData={myriadTrialTreatment=, productType=AppleTV14,1, buildVersion=23L471, isLocationSharingDevice=false, aceVersion=13.0-20A, userInterfaceIdiom=ZEUS, isSiriCloudSyncEnabled=true, userAssignedDeviceName=Camping}}, _idsCID=31fa3445-b152-401a-9aef-b82e0cd36c3e, _i=1dba2efb02f6, _accID=olemr@olemr.com, _clFl=SizedLong[value=128, size=2], _bf=SizedLong[value=1920, size=2], _osV=26.5.0, model=productType, _mRtID=1D57C6CD-ECF7-4863-BCAB-5E3EEE5B2CED, _idsID=C0BA895E-8247-4406-B125-5438C5A9CBC7, _sf=SizedLong[value=65536, size=4], _dC=unknown}, _t=3, _x=SizedLong[value=171, size=1]}
2026-07-30 12:43:45.048 [DEBUG] [rotocols.companion.CompanionProtocol] - No receiver for XID 171
2026-07-30 12:43:45.858 [DEBUG] [nding.atv.internal.client.scan.Knock] - Knock at port 3689 on /192.168.3.10 failed: java.net.ConnectException: Connection refused
2026-07-30 12:43:46.917 [TRACE] [atv.internal.client.core.Heartbeater] - Sending periodic heartbeat 0 (AirPlay:192.168.3.10)
2026-07-30 12:43:46.918 [TRACE] [l.client.support.http.HttpConnection] - Sending RTSP/1.0 message: POST /feedback
2026-07-30 12:43:46.924 [TRACE] [l.client.support.http.HttpConnection] - Got RTSP response: 200 OK
2026-07-30 12:43:46.925 [TRACE] [atv.internal.client.core.Heartbeater] - Got heartbeat 0 (AirPlay:192.168.3.10)
2026-07-30 12:43:47.052 [DEBUG] [lient.protocols.airplay.EventChannel] - Not enough data to parse request on event channel
2026-07-30 12:43:47.053 [DEBUG] [lient.protocols.airplay.EventChannel] - Got message on event channel: POST /command
2026-07-30 12:43:47.254 [TRACE] [al.discovery.AtvDiscoveryParticipant] - Discovered AirPlay device Camping (1E:57:C6:CD:EC:F7) at 192.168.3.10
2026-07-30 12:43:48.925 [TRACE] [atv.internal.client.core.Heartbeater] - Sending periodic heartbeat 1 (AirPlay:192.168.3.10)
2026-07-30 12:43:48.926 [TRACE] [l.client.support.http.HttpConnection] - Sending RTSP/1.0 message: POST /feedback
2026-07-30 12:43:48.929 [TRACE] [l.client.support.http.HttpConnection] - Got RTSP response: 200 OK
2026-07-30 12:43:48.929 [TRACE] [atv.internal.client.core.Heartbeater] - Got heartbeat 1 (AirPlay:192.168.3.10)
2026-07-30 12:43:50.043 [DEBUG] [tocols.companion.CompanionConnection] - Closing connection
2026-07-30 12:43:50.044 [DEBUG] [tv.internal.client.core.AppleTVRelay] - Protocol Companion failed to connect: Command _systemInfo failed
2026-07-30 12:43:50.045 [DEBUG] [tv.internal.client.core.AppleTVRelay] - Protocol MRP already set up, ignoring
2026-07-30 12:43:50.046 [DEBUG] [tv.internal.client.core.AppleTVRelay] - Connecting to protocol: RAOP
2026-07-30 12:43:50.047 [DEBUG] [tv.internal.client.core.AppleTVRelay] - Connected to protocol: RAOP
2026-07-30 12:43:50.056 [DEBUG] [.protocols.airplay.DataStreamChannel] - Got message with unsupported format: {}
2026-07-30 12:43:50.056 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - >> Send: Protobuf type=WAKE_DEVICE_MESSAGE
2026-07-30 12:43:50.502 [DEBUG] [lient.protocols.airplay.EventChannel] - Got message on event channel: POST /command
2026-07-30 12:43:50.546 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=UPDATE_OUTPUT_DEVICE_MESSAGE
2026-07-30 12:43:50.547 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=VOLUME_CONTROL_CAPABILITIES_DID_CHANGE_MESSAGE
2026-07-30 12:43:50.548 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type VOLUME_CONTROL_CAPABILITIES_DID_CHANGE_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.MrpAudio$$Lambda/0x000000010122ab60@1ea9d826
2026-07-30 12:43:50.549 [DEBUG] [ternal.client.protocols.mrp.MrpAudio] - Volume control availability changed to true
2026-07-30 12:43:50.612 [DEBUG] [lient.protocols.airplay.EventChannel] - Not enough data to parse request on event channel
2026-07-30 12:43:50.613 [DEBUG] [lient.protocols.airplay.EventChannel] - Got message on event channel: POST /command
2026-07-30 12:43:50.618 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=DEVICE_INFO_UPDATE_MESSAGE
2026-07-30 12:43:50.619 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type DEVICE_INFO_UPDATE_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.MrpPower$$Lambda/0x000000010120bbb8@220db2c6
2026-07-30 12:43:50.620 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type DEVICE_INFO_UPDATE_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.MrpAudio$$Lambda/0x000000010122b1d8@6b427132
2026-07-30 12:43:50.620 [DEBUG] [ternal.client.protocols.mrp.MrpPower] - Power state changed from Off to On
2026-07-30 12:43:50.622 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type OUTPUT_DEVICES to org.openhab.binding.atv.internal.client.core.AudioRelay$$Lambda/0x00000001011ee3e8@5591e6ea
2026-07-30 12:43:50.930 [TRACE] [atv.internal.client.core.Heartbeater] - Sending periodic heartbeat 2 (AirPlay:192.168.3.10)
2026-07-30 12:43:50.930 [TRACE] [l.client.support.http.HttpConnection] - Sending RTSP/1.0 message: POST /feedback
2026-07-30 12:43:50.932 [TRACE] [l.client.support.http.HttpConnection] - Got RTSP response: 200 OK
2026-07-30 12:43:50.933 [TRACE] [atv.internal.client.core.Heartbeater] - Got heartbeat 2 (AirPlay:192.168.3.10)
2026-07-30 12:43:51.807 [DEBUG] [lient.protocols.airplay.EventChannel] - Not enough data to parse request on event channel
2026-07-30 12:43:51.808 [DEBUG] [lient.protocols.airplay.EventChannel] - Got message on event channel: POST /command
2026-07-30 12:43:52.933 [TRACE] [atv.internal.client.core.Heartbeater] - Sending periodic heartbeat 3 (AirPlay:192.168.3.10)
2026-07-30 12:43:52.934 [TRACE] [l.client.support.http.HttpConnection] - Sending RTSP/1.0 message: POST /feedback
2026-07-30 12:43:52.936 [TRACE] [l.client.support.http.HttpConnection] - Got RTSP response: 200 OK
2026-07-30 12:43:52.937 [TRACE] [atv.internal.client.core.Heartbeater] - Got heartbeat 3 (AirPlay:192.168.3.10)
2026-07-30 12:43:53.391 [DEBUG] [lient.protocols.airplay.EventChannel] - Not enough data to parse request on event channel
2026-07-30 12:43:53.392 [DEBUG] [lient.protocols.airplay.EventChannel] - Got message on event channel: POST /command
2026-07-30 12:43:53.404 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=REMOVE_OUTPUT_DEVICES_MESSAGE
2026-07-30 12:43:53.500 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=DEVICE_INFO_UPDATE_MESSAGE
2026-07-30 12:43:53.501 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type DEVICE_INFO_UPDATE_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.MrpPower$$Lambda/0x000000010120bbb8@220db2c6
2026-07-30 12:43:53.502 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type DEVICE_INFO_UPDATE_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.MrpAudio$$Lambda/0x000000010122b1d8@6b427132
2026-07-30 12:43:53.502 [DEBUG] [ternal.client.protocols.mrp.MrpPower] - Power state changed from On to Off
2026-07-30 12:43:53.503 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type OUTPUT_DEVICES to org.openhab.binding.atv.internal.client.core.AudioRelay$$Lambda/0x00000001011ee3e8@5591e6ea
2026-07-30 12:43:54.938 [TRACE] [atv.internal.client.core.Heartbeater] - Sending periodic heartbeat 4 (AirPlay:192.168.3.10)
2026-07-30 12:43:54.938 [TRACE] [l.client.support.http.HttpConnection] - Sending RTSP/1.0 message: POST /feedback
2026-07-30 12:43:54.941 [TRACE] [l.client.support.http.HttpConnection] - Got RTSP response: 200 OK
2026-07-30 12:43:54.942 [TRACE] [atv.internal.client.core.Heartbeater] - Got heartbeat 4 (AirPlay:192.168.3.10)
2026-07-30 12:43:55.730 [DEBUG] [lient.protocols.airplay.EventChannel] - Got message on event channel: POST /command
2026-07-30 12:43:55.764 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=UPDATE_OUTPUT_DEVICE_MESSAGE
2026-07-30 12:43:55.765 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=VOLUME_CONTROL_CAPABILITIES_DID_CHANGE_MESSAGE
2026-07-30 12:43:55.766 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type VOLUME_CONTROL_CAPABILITIES_DID_CHANGE_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.MrpAudio$$Lambda/0x000000010122ab60@1ea9d826
2026-07-30 12:43:55.767 [DEBUG] [ternal.client.protocols.mrp.MrpAudio] - Volume control availability changed to true
2026-07-30 12:43:55.847 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=DEVICE_INFO_UPDATE_MESSAGE
2026-07-30 12:43:55.848 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type DEVICE_INFO_UPDATE_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.MrpPower$$Lambda/0x000000010120bbb8@220db2c6
2026-07-30 12:43:55.849 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type DEVICE_INFO_UPDATE_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.MrpAudio$$Lambda/0x000000010122b1d8@6b427132
2026-07-30 12:43:55.849 [DEBUG] [ternal.client.protocols.mrp.MrpPower] - Power state changed from Off to On
2026-07-30 12:43:55.850 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type OUTPUT_DEVICES to org.openhab.binding.atv.internal.client.core.AudioRelay$$Lambda/0x00000001011ee3e8@5591e6ea
2026-07-30 12:43:55.864 [DEBUG] [lient.protocols.airplay.EventChannel] - Not enough data to parse request on event channel
2026-07-30 12:43:55.865 [DEBUG] [lient.protocols.airplay.EventChannel] - Got message on event channel: POST /command
2026-07-30 12:43:56.858 [DEBUG] [lient.protocols.airplay.EventChannel] - Not enough data to parse request on event channel
2026-07-30 12:43:56.859 [DEBUG] [lient.protocols.airplay.EventChannel] - Got message on event channel: POST /command
2026-07-30 12:43:56.942 [TRACE] [atv.internal.client.core.Heartbeater] - Sending periodic heartbeat 5 (AirPlay:192.168.3.10)
2026-07-30 12:43:56.943 [TRACE] [l.client.support.http.HttpConnection] - Sending RTSP/1.0 message: POST /feedback
2026-07-30 12:43:56.945 [TRACE] [l.client.support.http.HttpConnection] - Got RTSP response: 200 OK
2026-07-30 12:43:56.946 [TRACE] [atv.internal.client.core.Heartbeater] - Got heartbeat 5 (AirPlay:192.168.3.10)
2026-07-30 12:43:58.301 [DEBUG] [lient.protocols.airplay.EventChannel] - Got message on event channel: POST /command
2026-07-30 12:43:58.329 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=REMOVE_OUTPUT_DEVICES_MESSAGE
2026-07-30 12:43:58.418 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=DEVICE_INFO_UPDATE_MESSAGE
2026-07-30 12:43:58.419 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type DEVICE_INFO_UPDATE_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.MrpPower$$Lambda/0x000000010120bbb8@220db2c6
2026-07-30 12:43:58.420 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type DEVICE_INFO_UPDATE_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.MrpAudio$$Lambda/0x000000010122b1d8@6b427132
2026-07-30 12:43:58.420 [DEBUG] [ternal.client.protocols.mrp.MrpPower] - Power state changed from On to Off
2026-07-30 12:43:58.421 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type OUTPUT_DEVICES to org.openhab.binding.atv.internal.client.core.AudioRelay$$Lambda/0x00000001011ee3e8@5591e6ea
2026-07-30 12:43:58.947 [TRACE] [atv.internal.client.core.Heartbeater] - Sending periodic heartbeat 6 (AirPlay:192.168.3.10)
2026-07-30 12:43:58.947 [TRACE] [l.client.support.http.HttpConnection] - Sending RTSP/1.0 message: POST /feedback
2026-07-30 12:43:58.949 [TRACE] [l.client.support.http.HttpConnection] - Got RTSP response: 200 OK
2026-07-30 12:43:58.950 [TRACE] [atv.internal.client.core.Heartbeater] - Got heartbeat 6 (AirPlay:192.168.3.10)
2026-07-30 12:44:00.781 [DEBUG] [lient.protocols.airplay.EventChannel] - Got message on event channel: POST /command
2026-07-30 12:44:00.811 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=UPDATE_OUTPUT_DEVICE_MESSAGE
2026-07-30 12:44:00.811 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=VOLUME_CONTROL_CAPABILITIES_DID_CHANGE_MESSAGE
2026-07-30 12:44:00.812 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type VOLUME_CONTROL_CAPABILITIES_DID_CHANGE_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.MrpAudio$$Lambda/0x000000010122ab60@1ea9d826
2026-07-30 12:44:00.812 [DEBUG] [ternal.client.protocols.mrp.MrpAudio] - Volume control availability changed to true
2026-07-30 12:44:00.906 [DEBUG] [otocols.airplay.AirPlayMrpConnection] - << Receive: Protobuf type=DEVICE_INFO_UPDATE_MESSAGE
2026-07-30 12:44:00.906 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type DEVICE_INFO_UPDATE_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.MrpPower$$Lambda/0x000000010120bbb8@220db2c6
2026-07-30 12:44:00.907 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type DEVICE_INFO_UPDATE_MESSAGE to org.openhab.binding.atv.internal.client.protocols.mrp.MrpAudio$$Lambda/0x000000010122b1d8@6b427132
2026-07-30 12:44:00.907 [DEBUG] [ternal.client.protocols.mrp.MrpPower] - Power state changed from Off to On
2026-07-30 12:44:00.908 [DEBUG] [ternal.client.core.MessageDispatcher] - Dispatching message with type OUTPUT_DEVICES to org.openhab.binding.atv.internal.client.core.AudioRelay$$Lambda/0x00000001011ee3e8@5591e6ea
2026-07-30 12:44:00.950 [TRACE] [atv.internal.client.core.Heartbeater] - Sending periodic heartbeat 7 (AirPlay:192.168.3.10)
2026-07-30 12:44:00.951 [TRACE] [l.client.support.http.HttpConnection] - Sending RTSP/1.0 message: POST /feedback
2026-07-30 12:44:00.953 [TRACE] [l.client.support.http.HttpConnection] - Got RTSP response: 200 OK
2026-07-30 12:44:00.954 [TRACE] [atv.internal.client.core.Heartbeater] - Got heartbeat 7 (AirPlay:192.168.3.10)
2026-07-30 12:44:02.956 [TRACE] [atv.internal.client.core.Heartbeater] - Sending periodic heartbeat 8 (AirPlay:192.168.3.10)
2026-07-30 12:44:02.957 [TRACE] [l.client.support.http.HttpConnection] - Sending RTSP/1.0 message: POST /feedback
2026-07-30 12:44:02.960 [TRACE] [l.client.support.http.HttpConnection] - Got RTSP response: 200 OK
2026-07-30 12:44:02.961 [TRACE] [atv.internal.client.core.Heartbeater] - Got heartbeat 8 (AirPlay:192.168.3.10)
2026-07-30 12:44:04.962 [TRACE] [atv.internal.client.core.Heartbeater] - Sending periodic heartbeat 9 (AirPlay:192.168.3.10)
2026-07-30 12:44:04.963 [TRACE] [l.client.support.http.HttpConnection] - Sending RTSP/1.0 message: POST /feedback
2026-07-30 12:44:04.966 [TRACE] [l.client.support.http.HttpConnection] - Got RTSP response: 200 OK
2026-07-30 12:44:04.967 [TRACE] [atv.internal.client.core.Heartbeater] - Got heartbeat 9 (AirPlay:192.168.3.10)

This is not a big issue for me since I always turn my ATVs ON using the remote, but tell me if I should test waking up using the Power channel some more.

[digitaldan (Dan Cunningham)]

@OMR

omr@rpi4lydhus:~ $ ping 192.168.3.10

Thats interesting, that seems to provide evidence the device is not actually sleeping in the traditional sense, like how a Mac might (which uses a Bonjour Sleep Proxy as a way for other devices to find and wake it up). So it would seem this is a protocol level issue.

[OMR (Ole Morten Rønning)]

Indeed…

[digitaldan (Dan Cunningham)]

I have a new Jar up based on your recent logs (thanks again!), i want to try something since we know the device is not really sleeping at the network level. This will try and use the companion connection to see if we can still talk with it and know its up, if that does not work, it falls back to how it was working previously. If you could post logs once it sleeps that would be great i’m hoping to see lines like " poll → power=Off ". This jar also keeps the Thing online while in sleep mode.

[OMR (Ole Morten Rønning)]

@digitaldan

If you could post logs once it sleeps that would be great

On it.
But I will have to amend my previous statement regarding pingability.
I just now wanted to ping 2 of my deep sleeping ATVs, and unlike last time, one did not reply. Right away that is. Turns out, they both have periods of deafness when no replies are sent.

ATV1:

[1785525693.369477] 64 bytes from 192.168.3.10: icmp_seq=184 ttl=64 time=727 ms
[1785525693.644568] 64 bytes from 192.168.3.10: icmp_seq=185 ttl=64 time=1.58 ms
[1785525694.645655] 64 bytes from 192.168.3.10: icmp_seq=186 ttl=64 time=1.53 ms
[1785525695.646276] 64 bytes from 192.168.3.10: icmp_seq=187 ttl=64 time=0.380 ms
[1785525696.674733] 64 bytes from 192.168.3.10: icmp_seq=188 ttl=64 time=0.386 ms
[1785525697.698486] 64 bytes from 192.168.3.10: icmp_seq=189 ttl=64 time=0.306 ms
[1785525698.722527] 64 bytes from 192.168.3.10: icmp_seq=190 ttl=64 time=0.342 ms
[1785525699.746532] 64 bytes from 192.168.3.10: icmp_seq=191 ttl=64 time=0.337 ms
[1785525700.770577] 64 bytes from 192.168.3.10: icmp_seq=192 ttl=64 time=0.371 ms
[1785525701.794579] 64 bytes from 192.168.3.10: icmp_seq=193 ttl=64 time=0.355 ms
[1785525702.818771] 64 bytes from 192.168.3.10: icmp_seq=194 ttl=32 time=0.571 ms
[1785525752.994548] From 192.168.3.6 icmp_seq=240 Destination Host Unreachable
ping: sendmsg: No route to host
[1785525752.994654] From 192.168.3.6 icmp_seq=241 Destination Host Unreachable
[1785525752.994680] From 192.168.3.6 icmp_seq=242 Destination Host Unreachable
[1785525756.515395] From 192.168.3.6 icmp_seq=244 Destination Host Unreachable
[1785525756.515517] From 192.168.3.6 icmp_seq=245 Destination Host Unreachable
[1785525756.515580] From 192.168.3.6 icmp_seq=246 Destination Host Unreachable
[1785525760.130641] From 192.168.3.6 icmp_seq=247 Destination Host Unreachable
[1785525760.130733] From 192.168.3.6 icmp_seq=248 Destination Host Unreachable
[1785525760.130788] From 192.168.3.6 icmp_seq=249 Destination Host Unreachable
[1785525763.202552] From 192.168.3.6 icmp_seq=250 Destination Host Unreachable
[1785525763.202662] From 192.168.3.6 icmp_seq=251 Destination Host Unreachable
[1785525763.202727] From 192.168.3.6 icmp_seq=252 Destination Host Unreachable
[1785525766.274576] From 192.168.3.6 icmp_seq=253 Destination Host Unreachable
[1785525766.274680] From 192.168.3.6 icmp_seq=254 Destination Host Unreachable
[1785525766.274745] From 192.168.3.6 icmp_seq=255 Destination Host Unreachable
[1785525769.346582] From 192.168.3.6 icmp_seq=256 Destination Host Unreachable
[1785525769.346687] From 192.168.3.6 icmp_seq=257 Destination Host Unreachable
[1785525769.346753] From 192.168.3.6 icmp_seq=258 Destination Host Unreachable
[1785525772.418411] From 192.168.3.6 icmp_seq=259 Destination Host Unreachable
[1785525772.418493] From 192.168.3.6 icmp_seq=260 Destination Host Unreachable
[1785525772.418537] From 192.168.3.6 icmp_seq=261 Destination Host Unreachable
[1785525775.490607] From 192.168.3.6 icmp_seq=262 Destination Host Unreachable
[1785525775.490712] From 192.168.3.6 icmp_seq=263 Destination Host Unreachable
[1785525775.490776] From 192.168.3.6 icmp_seq=264 Destination Host Unreachable
[1785525778.562578] From 192.168.3.6 icmp_seq=265 Destination Host Unreachable
[1785525778.562692] From 192.168.3.6 icmp_seq=266 Destination Host Unreachable
[1785525778.562751] From 192.168.3.6 icmp_seq=267 Destination Host Unreachable
[1785525781.634604] From 192.168.3.6 icmp_seq=268 Destination Host Unreachable
[1785525781.634718] From 192.168.3.6 icmp_seq=269 Destination Host Unreachable
[1785525781.634778] From 192.168.3.6 icmp_seq=270 Destination Host Unreachable
[1785525784.706541] From 192.168.3.6 icmp_seq=271 Destination Host Unreachable
[1785525784.706652] From 192.168.3.6 icmp_seq=272 Destination Host Unreachable
[1785525784.706710] From 192.168.3.6 icmp_seq=273 Destination Host Unreachable
[1785525787.778564] From 192.168.3.6 icmp_seq=274 Destination Host Unreachable
[1785525787.778674] From 192.168.3.6 icmp_seq=275 Destination Host Unreachable
[1785525787.778740] From 192.168.3.6 icmp_seq=276 Destination Host Unreachable
[1785525790.851252] From 192.168.3.6 icmp_seq=277 Destination Host Unreachable
ping: sendmsg: No route to host
[1785525790.851477] From 192.168.3.6 icmp_seq=278 Destination Host Unreachable
[1785525790.851543] From 192.168.3.6 icmp_seq=279 Destination Host Unreachable
[1785525794.530496] From 192.168.3.6 icmp_seq=281 Destination Host Unreachable
[1785525794.530560] From 192.168.3.6 icmp_seq=282 Destination Host Unreachable
[1785525794.530586] From 192.168.3.6 icmp_seq=283 Destination Host Unreachable
[1785525797.986659] From 192.168.3.6 icmp_seq=284 Destination Host Unreachable
[1785525797.986770] From 192.168.3.6 icmp_seq=285 Destination Host Unreachable
[1785525797.986835] From 192.168.3.6 icmp_seq=286 Destination Host Unreachable
[1785525801.058579] From 192.168.3.6 icmp_seq=287 Destination Host Unreachable
[1785525801.058690] From 192.168.3.6 icmp_seq=288 Destination Host Unreachable
[1785525801.058754] From 192.168.3.6 icmp_seq=289 Destination Host Unreachable
[1785525804.130564] From 192.168.3.6 icmp_seq=290 Destination Host Unreachable
[1785525804.130677] From 192.168.3.6 icmp_seq=291 Destination Host Unreachable
[1785525804.130742] From 192.168.3.6 icmp_seq=292 Destination Host Unreachable
[1785525807.202560] From 192.168.3.6 icmp_seq=293 Destination Host Unreachable
[1785525807.202671] From 192.168.3.6 icmp_seq=294 Destination Host Unreachable
[1785525807.202737] From 192.168.3.6 icmp_seq=295 Destination Host Unreachable
[1785525810.274550] From 192.168.3.6 icmp_seq=296 Destination Host Unreachable
[1785525810.274656] From 192.168.3.6 icmp_seq=297 Destination Host Unreachable
[1785525810.274720] From 192.168.3.6 icmp_seq=298 Destination Host Unreachable
[1785525813.346286] From 192.168.3.6 icmp_seq=299 Destination Host Unreachable
[1785525813.346342] From 192.168.3.6 icmp_seq=300 Destination Host Unreachable
[1785525813.346368] From 192.168.3.6 icmp_seq=301 Destination Host Unreachable
[1785525816.418562] From 192.168.3.6 icmp_seq=302 Destination Host Unreachable
[1785525816.418670] From 192.168.3.6 icmp_seq=303 Destination Host Unreachable
[1785525816.418735] From 192.168.3.6 icmp_seq=304 Destination Host Unreachable
[1785525819.490305] From 192.168.3.6 icmp_seq=305 Destination Host Unreachable
[1785525819.490362] From 192.168.3.6 icmp_seq=306 Destination Host Unreachable
[1785525819.490388] From 192.168.3.6 icmp_seq=307 Destination Host Unreachable
[1785525822.562331] From 192.168.3.6 icmp_seq=308 Destination Host Unreachable
[1785525822.562391] From 192.168.3.6 icmp_seq=309 Destination Host Unreachable
[1785525822.562417] From 192.168.3.6 icmp_seq=310 Destination Host Unreachable
[1785525825.634577] From 192.168.3.6 icmp_seq=311 Destination Host Unreachable
[1785525825.634687] From 192.168.3.6 icmp_seq=312 Destination Host Unreachable
[1785525825.634752] From 192.168.3.6 icmp_seq=313 Destination Host Unreachable
[1785525828.707173] From 192.168.3.6 icmp_seq=314 Destination Host Unreachable
ping: sendmsg: No route to host
[1785525828.707398] From 192.168.3.6 icmp_seq=315 Destination Host Unreachable
[1785525828.707457] From 192.168.3.6 icmp_seq=316 Destination Host Unreachable
[1785525832.547394] From 192.168.3.6 icmp_seq=318 Destination Host Unreachable
[1785525832.547514] From 192.168.3.6 icmp_seq=319 Destination Host Unreachable
[1785525832.547604] From 192.168.3.6 icmp_seq=320 Destination Host Unreachable
[1785525835.842352] From 192.168.3.6 icmp_seq=321 Destination Host Unreachable
[1785525835.842405] From 192.168.3.6 icmp_seq=322 Destination Host Unreachable
[1785525835.842430] From 192.168.3.6 icmp_seq=323 Destination Host Unreachable
[1785525838.914518] From 192.168.3.6 icmp_seq=324 Destination Host Unreachable
[1785525838.914619] From 192.168.3.6 icmp_seq=325 Destination Host Unreachable
[1785525838.914675] From 192.168.3.6 icmp_seq=326 Destination Host Unreachable
[1785525841.986287] From 192.168.3.6 icmp_seq=327 Destination Host Unreachable
[1785525841.986342] From 192.168.3.6 icmp_seq=328 Destination Host Unreachable
[1785525841.986368] From 192.168.3.6 icmp_seq=329 Destination Host Unreachable
[1785525845.058334] From 192.168.3.6 icmp_seq=330 Destination Host Unreachable
[1785525845.058393] From 192.168.3.6 icmp_seq=331 Destination Host Unreachable
[1785525845.058417] From 192.168.3.6 icmp_seq=332 Destination Host Unreachable
[1785525848.130570] From 192.168.3.6 icmp_seq=333 Destination Host Unreachable
[1785525848.130679] From 192.168.3.6 icmp_seq=334 Destination Host Unreachable
[1785525848.130751] From 192.168.3.6 icmp_seq=335 Destination Host Unreachable
[1785525851.202505] From 192.168.3.6 icmp_seq=336 Destination Host Unreachable
[1785525851.202597] From 192.168.3.6 icmp_seq=337 Destination Host Unreachable
[1785525851.202653] From 192.168.3.6 icmp_seq=338 Destination Host Unreachable
[1785525854.274571] From 192.168.3.6 icmp_seq=339 Destination Host Unreachable
[1785525854.274684] From 192.168.3.6 icmp_seq=340 Destination Host Unreachable
[1785525854.274748] From 192.168.3.6 icmp_seq=341 Destination Host Unreachable
[1785525857.346562] From 192.168.3.6 icmp_seq=342 Destination Host Unreachable
[1785525857.346670] From 192.168.3.6 icmp_seq=343 Destination Host Unreachable
[1785525857.346736] From 192.168.3.6 icmp_seq=344 Destination Host Unreachable
[1785525860.418501] From 192.168.3.6 icmp_seq=345 Destination Host Unreachable
[1785525860.418596] From 192.168.3.6 icmp_seq=346 Destination Host Unreachable
[1785525860.418659] From 192.168.3.6 icmp_seq=347 Destination Host Unreachable
[1785525863.490289] From 192.168.3.6 icmp_seq=348 Destination Host Unreachable
[1785525863.490347] From 192.168.3.6 icmp_seq=349 Destination Host Unreachable
[1785525863.490373] From 192.168.3.6 icmp_seq=350 Destination Host Unreachable
[1785525866.562545] From 192.168.3.6 icmp_seq=351 Destination Host Unreachable
ping: sendmsg: No route to host
[1785525866.562655] From 192.168.3.6 icmp_seq=352 Destination Host Unreachable
[1785525866.562682] From 192.168.3.6 icmp_seq=353 Destination Host Unreachable
[1785525870.531152] From 192.168.3.6 icmp_seq=355 Destination Host Unreachable
[1785525870.531270] From 192.168.3.6 icmp_seq=356 Destination Host Unreachable
[1785525870.531355] From 192.168.3.6 icmp_seq=357 Destination Host Unreachable
[1785525873.698674] From 192.168.3.6 icmp_seq=358 Destination Host Unreachable
[1785525873.698780] From 192.168.3.6 icmp_seq=359 Destination Host Unreachable
[1785525873.698844] From 192.168.3.6 icmp_seq=360 Destination Host Unreachable
[1785525876.770572] From 192.168.3.6 icmp_seq=361 Destination Host Unreachable
[1785525876.770724] From 192.168.3.6 icmp_seq=362 Destination Host Unreachable
[1785525876.770790] From 192.168.3.6 icmp_seq=363 Destination Host Unreachable
[1785525877.367198] 64 bytes from 192.168.3.10: icmp_seq=364 ttl=64 time=597 ms
[1785525877.773358] 64 bytes from 192.168.3.10: icmp_seq=365 ttl=64 time=1.51 ms
[1785525878.775124] 64 bytes from 192.168.3.10: icmp_seq=366 ttl=64 time=1.54 ms
[1785525879.774930] 64 bytes from 192.168.3.10: icmp_seq=367 ttl=64 time=0.354 ms
[1785525880.802610] 64 bytes from 192.168.3.10: icmp_seq=368 ttl=64 time=0.363 ms
[1785525881.826570] 64 bytes from 192.168.3.10: icmp_seq=369 ttl=64 time=0.349 ms
[1785525882.850469] 64 bytes from 192.168.3.10: icmp_seq=370 ttl=64 time=0.333 ms
[1785525883.874417] 64 bytes from 192.168.3.10: icmp_seq=371 ttl=64 time=0.293 ms
[1785525884.898518] 64 bytes from 192.168.3.10: icmp_seq=372 ttl=64 time=0.396 ms
[1785525885.922488] 64 bytes from 192.168.3.10: icmp_seq=373 ttl=64 time=0.337 ms
[1785525886.946413] 64 bytes from 192.168.3.10: icmp_seq=374 ttl=64 time=0.279 ms
[1785525887.970574] 64 bytes from 192.168.3.10: icmp_seq=375 ttl=64 time=0.382 ms
[1785525888.994670] 64 bytes from 192.168.3.10: icmp_seq=376 ttl=64 time=0.445 ms
[1785525890.018563] 64 bytes from 192.168.3.10: icmp_seq=377 ttl=64 time=0.365 ms
[1785525891.042615] 64 bytes from 192.168.3.10: icmp_seq=378 ttl=64 time=0.391 ms
[1785525892.066642] 64 bytes from 192.168.3.10: icmp_seq=379 ttl=64 time=0.398 ms
[1785525893.090568] 64 bytes from 192.168.3.10: icmp_seq=380 ttl=64 time=0.371 ms
[1785525894.114603] 64 bytes from 192.168.3.10: icmp_seq=381 ttl=64 time=0.398 ms
[1785525895.138629] 64 bytes from 192.168.3.10: icmp_seq=382 ttl=64 time=0.399 ms
[1785525896.162621] 64 bytes from 192.168.3.10: icmp_seq=383 ttl=64 time=0.427 ms
[1785525898.210764] 64 bytes from 192.168.3.10: icmp_seq=385 ttl=32 time=0.564 ms
[1785525934.050634] From 192.168.3.6 icmp_seq=417 Destination Host Unreachable
[1785525934.050743] From 192.168.3.6 icmp_seq=418 Destination Host Unreachable
[1785525934.050808] From 192.168.3.6 icmp_seq=419 Destination Host Unreachable
[1785525937.122682] From 192.168.3.6 icmp_seq=420 Destination Host Unreachable
[1785525937.122795] From 192.168.3.6 icmp_seq=421 Destination Host Unreachable
[1785525937.122860] From 192.168.3.6 icmp_seq=422 Destination Host Unreachable
[1785525940.194624] From 192.168.3.6 icmp_seq=423 Destination Host Unreachable
[1785525940.194736] From 192.168.3.6 icmp_seq=424 Destination Host Unreachable
[1785525940.194802] From 192.168.3.6 icmp_seq=425 Destination Host Unreachable
[1785525943.267043] From 192.168.3.6 icmp_seq=426 Destination Host Unreachable
ping: sendmsg: No route to host
[1785525943.267247] From 192.168.3.6 icmp_seq=427 Destination Host Unreachable
[1785525943.267299] From 192.168.3.6 icmp_seq=428 Destination Host Unreachable
[1785525946.562921] From 192.168.3.6 icmp_seq=430 Destination Host Unreachable
[1785525946.563030] From 192.168.3.6 icmp_seq=431 Destination Host Unreachable
[1785525946.563085] From 192.168.3.6 icmp_seq=432 Destination Host Unreachable
[1785525950.402805] From 192.168.3.6 icmp_seq=433 Destination Host Unreachable
[1785525950.402913] From 192.168.3.6 icmp_seq=434 Destination Host Unreachable
[1785525950.402978] From 192.168.3.6 icmp_seq=435 Destination Host Unreachable
[1785525953.474322] From 192.168.3.6 icmp_seq=436 Destination Host Unreachable
[1785525953.474414] From 192.168.3.6 icmp_seq=437 Destination Host Unreachable
[1785525953.474470] From 192.168.3.6 icmp_seq=438 Destination Host Unreachable
[1785525956.546396] From 192.168.3.6 icmp_seq=440 Destination Host Unreachable
[1785525956.546508] From 192.168.3.6 icmp_seq=441 Destination Host Unreachable
[1785525959.618586] From 192.168.3.6 icmp_seq=443 Destination Host Unreachable
[1785525959.618699] From 192.168.3.6 icmp_seq=444 Destination Host Unreachable
[1785525962.690225] From 192.168.3.6 icmp_seq=446 Destination Host Unreachable
[1785525965.762276] From 192.168.3.6 icmp_seq=449 Destination Host Unreachable
[1785525965.762333] From 192.168.3.6 icmp_seq=450 Destination Host Unreachable
[1785525968.834598] From 192.168.3.6 icmp_seq=451 Destination Host Unreachable
[1785525968.834706] From 192.168.3.6 icmp_seq=452 Destination Host Unreachable
[1785525968.834771] From 192.168.3.6 icmp_seq=453 Destination Host Unreachable
[1785525971.906636] From 192.168.3.6 icmp_seq=454 Destination Host Unreachable
[1785525971.906748] From 192.168.3.6 icmp_seq=455 Destination Host Unreachable
[1785525971.906812] From 192.168.3.6 icmp_seq=456 Destination Host Unreachable
[1785525974.978618] From 192.168.3.6 icmp_seq=457 Destination Host Unreachable
[1785525974.978724] From 192.168.3.6 icmp_seq=458 Destination Host Unreachable
[1785525974.978787] From 192.168.3.6 icmp_seq=459 Destination Host Unreachable

ATV2:

omr@shs3:~$ ping -D 192.168.1.101
PING 192.168.1.101 (192.168.1.101) 56(84) bytes of data.
[1785525482.677128] From 192.168.1.7 icmp_seq=1 Destination Host Unreachable
[1785525482.677234] From 192.168.1.7 icmp_seq=2 Destination Host Unreachable
[1785525482.677255] From 192.168.1.7 icmp_seq=3 Destination Host Unreachable
[1785525485.749087] From 192.168.1.7 icmp_seq=4 Destination Host Unreachable
[1785525485.749178] From 192.168.1.7 icmp_seq=5 Destination Host Unreachable
[1785525485.749197] From 192.168.1.7 icmp_seq=6 Destination Host Unreachable
[1785525488.821160] From 192.168.1.7 icmp_seq=7 Destination Host Unreachable
[1785525488.821289] From 192.168.1.7 icmp_seq=8 Destination Host Unreachable
[1785525488.821308] From 192.168.1.7 icmp_seq=9 Destination Host Unreachable
[1785525491.893207] From 192.168.1.7 icmp_seq=10 Destination Host Unreachable
[1785525491.893316] From 192.168.1.7 icmp_seq=11 Destination Host Unreachable
[1785525491.893329] From 192.168.1.7 icmp_seq=12 Destination Host Unreachable
[1785525494.965127] From 192.168.1.7 icmp_seq=13 Destination Host Unreachable
[1785525494.965173] From 192.168.1.7 icmp_seq=14 Destination Host Unreachable
[1785525494.965185] From 192.168.1.7 icmp_seq=15 Destination Host Unreachable
[1785525498.037064] From 192.168.1.7 icmp_seq=16 Destination Host Unreachable
[1785525498.037114] From 192.168.1.7 icmp_seq=17 Destination Host Unreachable
[1785525498.037127] From 192.168.1.7 icmp_seq=18 Destination Host Unreachable
[1785525501.109473] From 192.168.1.7 icmp_seq=19 Destination Host Unreachable
[1785525501.109526] From 192.168.1.7 icmp_seq=20 Destination Host Unreachable
[1785525501.109561] From 192.168.1.7 icmp_seq=21 Destination Host Unreachable
[1785525504.181354] From 192.168.1.7 icmp_seq=22 Destination Host Unreachable
[1785525504.181412] From 192.168.1.7 icmp_seq=23 Destination Host Unreachable
[1785525504.181431] From 192.168.1.7 icmp_seq=24 Destination Host Unreachable
[1785525507.253142] From 192.168.1.7 icmp_seq=25 Destination Host Unreachable
[1785525510.325312] From 192.168.1.7 icmp_seq=29 Destination Host Unreachable
[1785525510.325369] From 192.168.1.7 icmp_seq=30 Destination Host Unreachable
[1785525513.396962] From 192.168.1.7 icmp_seq=31 Destination Host Unreachable
[1785525513.397004] From 192.168.1.7 icmp_seq=32 Destination Host Unreachable
[1785525513.397017] From 192.168.1.7 icmp_seq=33 Destination Host Unreachable
[1785525516.469108] From 192.168.1.7 icmp_seq=34 Destination Host Unreachable
[1785525516.469188] From 192.168.1.7 icmp_seq=35 Destination Host Unreachable
[1785525516.469215] From 192.168.1.7 icmp_seq=36 Destination Host Unreachable
[1785525519.541163] From 192.168.1.7 icmp_seq=37 Destination Host Unreachable
[1785525519.541224] From 192.168.1.7 icmp_seq=38 Destination Host Unreachable
[1785525519.541247] From 192.168.1.7 icmp_seq=39 Destination Host Unreachable
[1785525522.613338] From 192.168.1.7 icmp_seq=40 Destination Host Unreachable
[1785525522.613401] From 192.168.1.7 icmp_seq=41 Destination Host Unreachable
[1785525522.613421] From 192.168.1.7 icmp_seq=42 Destination Host Unreachable
[1785525525.685160] From 192.168.1.7 icmp_seq=43 Destination Host Unreachable
[1785525525.685215] From 192.168.1.7 icmp_seq=44 Destination Host Unreachable
[1785525525.685234] From 192.168.1.7 icmp_seq=45 Destination Host Unreachable
[1785525528.757345] From 192.168.1.7 icmp_seq=46 Destination Host Unreachable
[1785525528.757405] From 192.168.1.7 icmp_seq=47 Destination Host Unreachable
[1785525528.757423] From 192.168.1.7 icmp_seq=48 Destination Host Unreachable
[1785525531.829344] From 192.168.1.7 icmp_seq=49 Destination Host Unreachable
[1785525531.829411] From 192.168.1.7 icmp_seq=50 Destination Host Unreachable
[1785525531.829430] From 192.168.1.7 icmp_seq=51 Destination Host Unreachable
[1785525534.901273] From 192.168.1.7 icmp_seq=52 Destination Host Unreachable
[1785525534.901337] From 192.168.1.7 icmp_seq=53 Destination Host Unreachable
[1785525534.901359] From 192.168.1.7 icmp_seq=54 Destination Host Unreachable
[1785525537.973303] From 192.168.1.7 icmp_seq=55 Destination Host Unreachable
[1785525537.973375] From 192.168.1.7 icmp_seq=56 Destination Host Unreachable
[1785525537.973404] From 192.168.1.7 icmp_seq=57 Destination Host Unreachable
[1785525541.045537] From 192.168.1.7 icmp_seq=58 Destination Host Unreachable
[1785525541.045604] From 192.168.1.7 icmp_seq=59 Destination Host Unreachable
[1785525541.045625] From 192.168.1.7 icmp_seq=60 Destination Host Unreachable
[1785525544.117403] From 192.168.1.7 icmp_seq=61 Destination Host Unreachable
[1785525544.117463] From 192.168.1.7 icmp_seq=62 Destination Host Unreachable
[1785525544.117485] From 192.168.1.7 icmp_seq=63 Destination Host Unreachable
[1785525547.189074] From 192.168.1.7 icmp_seq=64 Destination Host Unreachable
[1785525547.189133] From 192.168.1.7 icmp_seq=65 Destination Host Unreachable
[1785525547.189152] From 192.168.1.7 icmp_seq=66 Destination Host Unreachable
[1785525550.261064] From 192.168.1.7 icmp_seq=67 Destination Host Unreachable
[1785525550.261126] From 192.168.1.7 icmp_seq=68 Destination Host Unreachable
[1785525550.261159] From 192.168.1.7 icmp_seq=69 Destination Host Unreachable
[1785525553.333211] From 192.168.1.7 icmp_seq=70 Destination Host Unreachable
[1785525553.333271] From 192.168.1.7 icmp_seq=71 Destination Host Unreachable
[1785525553.333289] From 192.168.1.7 icmp_seq=72 Destination Host Unreachable
[1785525556.405225] From 192.168.1.7 icmp_seq=73 Destination Host Unreachable
[1785525556.405288] From 192.168.1.7 icmp_seq=74 Destination Host Unreachable
[1785525556.405310] From 192.168.1.7 icmp_seq=75 Destination Host Unreachable
[1785525559.478186] From 192.168.1.7 icmp_seq=76 Destination Host Unreachable
[1785525559.478248] From 192.168.1.7 icmp_seq=77 Destination Host Unreachable
[1785525559.478270] From 192.168.1.7 icmp_seq=78 Destination Host Unreachable
[1785525562.549159] From 192.168.1.7 icmp_seq=79 Destination Host Unreachable
[1785525562.549216] From 192.168.1.7 icmp_seq=80 Destination Host Unreachable
[1785525562.549235] From 192.168.1.7 icmp_seq=81 Destination Host Unreachable
[1785525565.621431] From 192.168.1.7 icmp_seq=82 Destination Host Unreachable
[1785525565.621509] From 192.168.1.7 icmp_seq=83 Destination Host Unreachable
[1785525565.621540] From 192.168.1.7 icmp_seq=84 Destination Host Unreachable
[1785525568.693116] From 192.168.1.7 icmp_seq=85 Destination Host Unreachable
[1785525568.693175] From 192.168.1.7 icmp_seq=86 Destination Host Unreachable
[1785525568.693194] From 192.168.1.7 icmp_seq=87 Destination Host Unreachable
[1785525571.765353] From 192.168.1.7 icmp_seq=88 Destination Host Unreachable
[1785525571.765412] From 192.168.1.7 icmp_seq=89 Destination Host Unreachable
[1785525571.765430] From 192.168.1.7 icmp_seq=90 Destination Host Unreachable
[1785525574.837446] From 192.168.1.7 icmp_seq=91 Destination Host Unreachable
[1785525574.837508] From 192.168.1.7 icmp_seq=92 Destination Host Unreachable
[1785525574.837536] From 192.168.1.7 icmp_seq=93 Destination Host Unreachable
[1785525577.909281] From 192.168.1.7 icmp_seq=95 Destination Host Unreachable
[1785525580.981387] From 192.168.1.7 icmp_seq=98 Destination Host Unreachable
[1785525585.141172] 64 bytes from 192.168.1.101: icmp_seq=104 ttl=64 time=63.9 ms
[1785525586.080564] 64 bytes from 192.168.1.101: icmp_seq=105 ttl=64 time=2.45 ms
[1785525587.080201] 64 bytes from 192.168.1.101: icmp_seq=106 ttl=64 time=1.10 ms
[1785525588.083106] 64 bytes from 192.168.1.101: icmp_seq=107 ttl=64 time=2.52 ms
[1785525589.083575] 64 bytes from 192.168.1.101: icmp_seq=108 ttl=64 time=1.07 ms
[1785525590.085303] 64 bytes from 192.168.1.101: icmp_seq=109 ttl=64 time=1.18 ms
[1785525591.086965] 64 bytes from 192.168.1.101: icmp_seq=110 ttl=64 time=1.23 ms
[1785525592.087929] 64 bytes from 192.168.1.101: icmp_seq=111 ttl=64 time=1.11 ms
[1785525593.089296] 64 bytes from 192.168.1.101: icmp_seq=112 ttl=64 time=1.21 ms
[1785525598.199437] 64 bytes from 192.168.1.101: icmp_seq=117 ttl=32 time=1.34 ms
[1785525607.416819] 64 bytes from 192.168.1.101: icmp_seq=126 ttl=64 time=1.93 ms
[1785525622.775743] 64 bytes from 192.168.1.101: icmp_seq=141 ttl=64 time=2.43 ms
[1785525623.776488] 64 bytes from 192.168.1.101: icmp_seq=142 ttl=64 time=1.26 ms
[1785525624.777170] 64 bytes from 192.168.1.101: icmp_seq=143 ttl=64 time=1.05 ms
[1785525625.780122] 64 bytes from 192.168.1.101: icmp_seq=144 ttl=64 time=2.44 ms
[1785525626.780511] 64 bytes from 192.168.1.101: icmp_seq=145 ttl=64 time=1.25 ms
[1785525627.782395] 64 bytes from 192.168.1.101: icmp_seq=146 ttl=64 time=1.47 ms
[1785525628.784130] 64 bytes from 192.168.1.101: icmp_seq=147 ttl=64 time=1.28 ms
[1785525629.785777] 64 bytes from 192.168.1.101: icmp_seq=148 ttl=64 time=1.17 ms
[1785525634.870479] 64 bytes from 192.168.1.101: icmp_seq=153 ttl=32 time=1.27 ms
[1785525635.872347] 64 bytes from 192.168.1.101: icmp_seq=154 ttl=32 time=1.48 ms
[1785525636.873345] 64 bytes from 192.168.1.101: icmp_seq=155 ttl=32 time=1.20 ms
[1785525637.874516] 64 bytes from 192.168.1.101: icmp_seq=156 ttl=32 time=1.29 ms
[1785525638.876477] 64 bytes from 192.168.1.101: icmp_seq=157 ttl=32 time=1.53 ms
[1785525639.878402] 64 bytes from 192.168.1.101: icmp_seq=158 ttl=32 time=1.44 ms
[1785525640.880032] 64 bytes from 192.168.1.101: icmp_seq=159 ttl=32 time=1.32 ms
[1785525641.882370] 64 bytes from 192.168.1.101: icmp_seq=160 ttl=32 time=1.87 ms
[1785525642.882585] 64 bytes from 192.168.1.101: icmp_seq=161 ttl=32 time=1.17 ms
[1785525643.884519] 64 bytes from 192.168.1.101: icmp_seq=162 ttl=32 time=1.46 ms
[1785525644.886226] 64 bytes from 192.168.1.101: icmp_seq=163 ttl=32 time=1.43 ms
[1785525645.887715] 64 bytes from 192.168.1.101: icmp_seq=164 ttl=32 time=1.48 ms
[1785525646.889511] 64 bytes from 192.168.1.101: icmp_seq=165 ttl=32 time=1.31 ms
[1785525647.890144] 64 bytes from 192.168.1.101: icmp_seq=166 ttl=32 time=1.21 ms
[1785525648.892053] 64 bytes from 192.168.1.101: icmp_seq=167 ttl=32 time=2.35 ms
[1785525649.892924] 64 bytes from 192.168.1.101: icmp_seq=168 ttl=32 time=1.83 ms
[1785525659.108136] 64 bytes from 192.168.1.101: icmp_seq=177 ttl=64 time=46.8 ms
[1785525670.325122] From 192.168.1.7 icmp_seq=185 Destination Host Unreachable
[1785525670.325188] From 192.168.1.7 icmp_seq=186 Destination Host Unreachable
[1785525670.325209] From 192.168.1.7 icmp_seq=187 Destination Host Unreachable
[1785525673.397166] From 192.168.1.7 icmp_seq=188 Destination Host Unreachable
[1785525673.397224] From 192.168.1.7 icmp_seq=189 Destination Host Unreachable
[1785525673.397242] From 192.168.1.7 icmp_seq=190 Destination Host Unreachable
[1785525673.449586] 64 bytes from 192.168.1.101: icmp_seq=191 ttl=64 time=52.4 ms
[1785525674.401160] 64 bytes from 192.168.1.101: icmp_seq=192 ttl=64 time=2.27 ms
[1785525675.401938] 64 bytes from 192.168.1.101: icmp_seq=193 ttl=64 time=1.15 ms
[1785525676.404808] 64 bytes from 192.168.1.101: icmp_seq=194 ttl=64 time=2.37 ms
[1785525677.405387] 64 bytes from 192.168.1.101: icmp_seq=195 ttl=64 time=1.05 ms
[1785525678.406901] 64 bytes from 192.168.1.101: icmp_seq=196 ttl=64 time=1.09 ms
[1785525679.408711] 64 bytes from 192.168.1.101: icmp_seq=197 ttl=64 time=1.22 ms
[1785525680.410332] 64 bytes from 192.168.1.101: icmp_seq=198 ttl=64 time=1.14 ms
[1785525681.411585] 64 bytes from 192.168.1.101: icmp_seq=199 ttl=64 time=1.17 ms
[1785525692.663802] 64 bytes from 192.168.1.101: icmp_seq=210 ttl=64 time=1.72 ms
[1785525697.783166] 64 bytes from 192.168.1.101: icmp_seq=215 ttl=32 time=1.14 ms
[1785525698.784922] 64 bytes from 192.168.1.101: icmp_seq=216 ttl=32 time=1.30 ms
[1785525699.786662] 64 bytes from 192.168.1.101: icmp_seq=217 ttl=32 time=1.32 ms
[1785525700.789829] 64 bytes from 192.168.1.101: icmp_seq=218 ttl=32 time=2.68 ms
[1785525701.790705] 64 bytes from 192.168.1.101: icmp_seq=219 ttl=32 time=1.44 ms
[1785525702.792069] 64 bytes from 192.168.1.101: icmp_seq=220 ttl=32 time=1.41 ms
[1785525703.793414] 64 bytes from 192.168.1.101: icmp_seq=221 ttl=32 time=1.30 ms
[1785525704.795326] 64 bytes from 192.168.1.101: icmp_seq=222 ttl=32 time=1.44 ms
[1785525705.796943] 64 bytes from 192.168.1.101: icmp_seq=223 ttl=32 time=1.45 ms
[1785525706.797817] 64 bytes from 192.168.1.101: icmp_seq=224 ttl=32 time=1.42 ms
[1785525707.800079] 64 bytes from 192.168.1.101: icmp_seq=225 ttl=32 time=1.54 ms
[1785525708.800958] 64 bytes from 192.168.1.101: icmp_seq=226 ttl=32 time=1.32 ms
[1785525709.802760] 64 bytes from 192.168.1.101: icmp_seq=227 ttl=32 time=1.50 ms
[1785525710.803525] 64 bytes from 192.168.1.101: icmp_seq=228 ttl=32 time=1.39 ms
[1785525711.804719] 64 bytes from 192.168.1.101: icmp_seq=229 ttl=32 time=1.35 ms
[1785525712.806321] 64 bytes from 192.168.1.101: icmp_seq=230 ttl=32 time=1.29 ms
[1785525713.807952] 64 bytes from 192.168.1.101: icmp_seq=231 ttl=32 time=1.34 ms
[1785525714.809543] 64 bytes from 192.168.1.101: icmp_seq=232 ttl=32 time=1.25 ms
[1785525728.119502] 64 bytes from 192.168.1.101: icmp_seq=245 ttl=64 time=2.30 ms
[1785525729.119937] 64 bytes from 192.168.1.101: icmp_seq=246 ttl=64 time=1.14 ms
[1785525730.121085] 64 bytes from 192.168.1.101: icmp_seq=247 ttl=64 time=1.03 ms
[1785525731.123344] 64 bytes from 192.168.1.101: icmp_seq=248 ttl=64 time=2.26 ms
[1785525732.123073] 64 bytes from 192.168.1.101: icmp_seq=249 ttl=64 time=1.05 ms
[1785525733.124655] 64 bytes from 192.168.1.101: icmp_seq=250 ttl=64 time=1.22 ms
[1785525734.126450] 64 bytes from 192.168.1.101: icmp_seq=251 ttl=64 time=1.29 ms
[1785525735.128167] 64 bytes from 192.168.1.101: icmp_seq=252 ttl=64 time=1.24 ms
[1785525740.214397] 64 bytes from 192.168.1.101: icmp_seq=257 ttl=32 time=1.29 ms
[1785525741.215556] 64 bytes from 192.168.1.101: icmp_seq=258 ttl=32 time=1.31 ms
[1785525742.217509] 64 bytes from 192.168.1.101: icmp_seq=259 ttl=32 time=1.45 ms
[1785525743.218612] 64 bytes from 192.168.1.101: icmp_seq=260 ttl=32 time=1.40 ms
[1785525744.220341] 64 bytes from 192.168.1.101: icmp_seq=261 ttl=32 time=1.34 ms
[1785525745.223531] 64 bytes from 192.168.1.101: icmp_seq=262 ttl=32 time=2.82 ms
[1785525754.521524] 64 bytes from 192.168.1.101: icmp_seq=271 ttl=64 time=100 ms
[1785525766.709235] From 192.168.1.7 icmp_seq=280 Destination Host Unreachable
[1785525766.709309] From 192.168.1.7 icmp_seq=281 Destination Host Unreachable
[1785525766.709331] From 192.168.1.7 icmp_seq=282 Destination Host Unreachable
[1785525769.598596] 64 bytes from 192.168.1.101: icmp_seq=283 ttl=64 time=2889 ms
[1785525769.598648] 64 bytes from 192.168.1.101: icmp_seq=284 ttl=64 time=1866 ms
[1785525769.598664] 64 bytes from 192.168.1.101: icmp_seq=285 ttl=64 time=842 ms
[1785525769.759929] 64 bytes from 192.168.1.101: icmp_seq=286 ttl=64 time=2.75 ms
[1785525770.760349] 64 bytes from 192.168.1.101: icmp_seq=287 ttl=64 time=1.11 ms
[1785525771.761998] 64 bytes from 192.168.1.101: icmp_seq=288 ttl=64 time=1.25 ms
[1785525772.763949] 64 bytes from 192.168.1.101: icmp_seq=289 ttl=64 time=1.92 ms
[1785525773.764140] 64 bytes from 192.168.1.101: icmp_seq=290 ttl=64 time=0.997 ms
[1785525774.765692] 64 bytes from 192.168.1.101: icmp_seq=291 ttl=64 time=1.17 ms
[1785525775.766230] 64 bytes from 192.168.1.101: icmp_seq=292 ttl=64 time=0.968 ms
[1785525776.767741] 64 bytes from 192.168.1.101: icmp_seq=293 ttl=64 time=1.14 ms
[1785525777.769026] 64 bytes from 192.168.1.101: icmp_seq=294 ttl=64 time=1.05 ms
[1785525789.047962] 64 bytes from 192.168.1.101: icmp_seq=305 ttl=64 time=2.59 ms
[1785525809.527078] 64 bytes from 192.168.1.101: icmp_seq=325 ttl=64 time=2.02 ms
[1785525810.527624] 64 bytes from 192.168.1.101: icmp_seq=326 ttl=64 time=1.36 ms
[1785525811.530086] 64 bytes from 192.168.1.101: icmp_seq=327 ttl=64 time=2.18 ms
[1785525812.530296] 64 bytes from 192.168.1.101: icmp_seq=328 ttl=64 time=1.21 ms
[1785525813.531985] 64 bytes from 192.168.1.101: icmp_seq=329 ttl=64 time=1.24 ms
[1785525814.533649] 64 bytes from 192.168.1.101: icmp_seq=330 ttl=64 time=1.32 ms
[1785525815.535350] 64 bytes from 192.168.1.101: icmp_seq=331 ttl=64 time=1.11 ms
[1785525816.536062] 64 bytes from 192.168.1.101: icmp_seq=332 ttl=64 time=1.23 ms
[1785525828.790310] 64 bytes from 192.168.1.101: icmp_seq=344 ttl=64 time=1.10 ms
[1785525832.887680] 64 bytes from 192.168.1.101: icmp_seq=348 ttl=32 time=2.50 ms
[1785525852.343278] 64 bytes from 192.168.1.101: icmp_seq=367 ttl=64 time=2.17 ms
[1785525853.343925] 64 bytes from 192.168.1.101: icmp_seq=368 ttl=64 time=1.20 ms
[1785525854.345605] 64 bytes from 192.168.1.101: icmp_seq=369 ttl=64 time=1.19 ms
[1785525855.348402] 64 bytes from 192.168.1.101: icmp_seq=370 ttl=64 time=2.35 ms
[1785525856.348236] 64 bytes from 192.168.1.101: icmp_seq=371 ttl=64 time=1.11 ms
[1785525857.349883] 64 bytes from 192.168.1.101: icmp_seq=372 ttl=64 time=1.20 ms
[1785525858.352890] 64 bytes from 192.168.1.101: icmp_seq=373 ttl=64 time=1.00 ms
[1785525859.353539] 64 bytes from 192.168.1.101: icmp_seq=374 ttl=64 time=1.21 ms
[1785525860.355353] 64 bytes from 192.168.1.101: icmp_seq=375 ttl=64 time=1.21 ms
[1785525870.582300] 64 bytes from 192.168.1.101: icmp_seq=385 ttl=64 time=1.17 ms
[1785525898.229333] From 192.168.1.7 icmp_seq=409 Destination Host Unreachable
[1785525898.229403] From 192.168.1.7 icmp_seq=410 Destination Host Unreachable
[1785525898.229439] From 192.168.1.7 icmp_seq=411 Destination Host Unreachable
[1785525901.302310] From 192.168.1.7 icmp_seq=412 Destination Host Unreachable
[1785525901.302370] From 192.168.1.7 icmp_seq=413 Destination Host Unreachable
[1785525901.302398] From 192.168.1.7 icmp_seq=414 Destination Host Unreachable
[1785525901.302419] From 192.168.1.7 icmp_seq=415 Destination Host Unreachable
[1785525905.397494] From 192.168.1.7 icmp_seq=416 Destination Host Unreachable
[1785525905.397618] From 192.168.1.7 icmp_seq=417 Destination Host Unreachable
[1785525905.397637] From 192.168.1.7 icmp_seq=418 Destination Host Unreachable
[1785525908.469241] From 192.168.1.7 icmp_seq=419 Destination Host Unreachable
[1785525908.469295] From 192.168.1.7 icmp_seq=420 Destination Host Unreachable
[1785525912.925863] 64 bytes from 192.168.1.101: icmp_seq=426 ttl=64 time=361 ms
[1785525913.569584] 64 bytes from 192.168.1.101: icmp_seq=427 ttl=64 time=2.66 ms
[1785525914.569784] 64 bytes from 192.168.1.101: icmp_seq=428 ttl=64 time=1.20 ms
[1785525915.572644] 64 bytes from 192.168.1.101: icmp_seq=429 ttl=64 time=2.51 ms
[1785525916.572111] 64 bytes from 192.168.1.101: icmp_seq=430 ttl=64 time=0.931 ms
[1785525917.573539] 64 bytes from 192.168.1.101: icmp_seq=431 ttl=64 time=1.08 ms
[1785525918.575049] 64 bytes from 192.168.1.101: icmp_seq=432 ttl=64 time=1.15 ms
[1785525919.576101] 64 bytes from 192.168.1.101: icmp_seq=433 ttl=64 time=1.01 ms
[1785525920.577727] 64 bytes from 192.168.1.101: icmp_seq=434 ttl=64 time=1.18 ms
[1785525930.807614] 64 bytes from 192.168.1.101: icmp_seq=444 ttl=64 time=2.38 ms
[1785525935.926698] 64 bytes from 192.168.1.101: icmp_seq=449 ttl=32 time=1.40 ms
[1785525936.928392] 64 bytes from 192.168.1.101: icmp_seq=450 ttl=32 time=1.31 ms
[1785525937.931363] 64 bytes from 192.168.1.101: icmp_seq=451 ttl=32 time=2.56 ms
[1785525938.931624] 64 bytes from 192.168.1.101: icmp_seq=452 ttl=32 time=1.38 ms
[1785525939.934567] 64 bytes from 192.168.1.101: icmp_seq=453 ttl=32 time=2.50 ms
[1785525940.934646] 64 bytes from 192.168.1.101: icmp_seq=454 ttl=32 time=1.47 ms
[1785525971.637232] From 192.168.1.7 icmp_seq=481 Destination Host Unreachable
[1785525971.637320] From 192.168.1.7 icmp_seq=482 Destination Host Unreachable
[1785525971.637349] From 192.168.1.7 icmp_seq=483 Destination Host Unreachable
[1785525974.709261] From 192.168.1.7 icmp_seq=484 Destination Host Unreachable
[1785525974.709321] From 192.168.1.7 icmp_seq=485 Destination Host Unreachable
[1785525974.709341] From 192.168.1.7 icmp_seq=486 Destination Host Unreachable
[1785525977.782156] From 192.168.1.7 icmp_seq=487 Destination Host Unreachable
[1785525977.782213] From 192.168.1.7 icmp_seq=488 Destination Host Unreachable
[1785525977.782234] From 192.168.1.7 icmp_seq=489 Destination Host Unreachable
[1785525980.853491] From 192.168.1.7 icmp_seq=490 Destination Host Unreachable
[1785525980.853736] From 192.168.1.7 icmp_seq=491 Destination Host Unreachable
[1785525980.853792] From 192.168.1.7 icmp_seq=492 Destination Host Unreachable
[1785525983.925522] From 192.168.1.7 icmp_seq=493 Destination Host Unreachable
[1785525983.925576] From 192.168.1.7 icmp_seq=494 Destination Host Unreachable
[1785525983.925589] From 192.168.1.7 icmp_seq=495 Destination Host Unreachable
[1785525986.997332] From 192.168.1.7 icmp_seq=496 Destination Host Unreachable
[1785525986.997393] From 192.168.1.7 icmp_seq=497 Destination Host Unreachable
[1785525986.997406] From 192.168.1.7 icmp_seq=498 Destination Host Unreachable
[1785525990.069233] From 192.168.1.7 icmp_seq=499 Destination Host Unreachable
[1785525990.069285] From 192.168.1.7 icmp_seq=500 Destination Host Unreachable
[1785525990.069297] From 192.168.1.7 icmp_seq=501 Destination Host Unreachable
[1785525993.141302] From 192.168.1.7 icmp_seq=502 Destination Host Unreachable
[1785525993.141362] From 192.168.1.7 icmp_seq=503 Destination Host Unreachable
[1785525993.141374] From 192.168.1.7 icmp_seq=504 Destination Host Unreachable
[1785525996.213262] From 192.168.1.7 icmp_seq=505 Destination Host Unreachable
[1785525996.213324] From 192.168.1.7 icmp_seq=506 Destination Host Unreachable
[1785525996.213343] From 192.168.1.7 icmp_seq=507 Destination Host Unreachable
[1785525999.285429] From 192.168.1.7 icmp_seq=508 Destination Host Unreachable
[1785525999.285516] From 192.168.1.7 icmp_seq=509 Destination Host Unreachable
[1785525999.285560] From 192.168.1.7 icmp_seq=510 Destination Host Unreachable
[1785526002.357159] From 192.168.1.7 icmp_seq=511 Destination Host Unreachable
[1785526002.357217] From 192.168.1.7 icmp_seq=512 Destination Host Unreachable
[1785526002.357235] From 192.168.1.7 icmp_seq=513 Destination Host Unreachable

Does this fact impact out next test?

I had to turn the Power channel ON 3 times now to wake it. GUI button goes down to OFF after some time, but did not wait the full minute to see if it woke up.
Nit: When the Power channel do come on in this menu, the Thing status remains OFFLINE until I refresh the WEB browser:

I have move location and now have 2 ATV on my LAN, so keep that in mind when reading logs.

[OMR (Ole Morten Rønning)]

@digitaldan

i’m hoping to see lines like " poll → power=Off ".

My log is much more talkative now with 2 ATVs and an Airplay Receiver, but was this what you were looking for? Only grep hit on ‘poll’ after more than 70min OFF.

omr@shs3:~$ grep -i -C 15 poll /var/log/openhab/openhab.log
2026-07-31 21:41:22.592 [TRACE] [atv.internal.client.core.Heartbeater] - Got heartbeat 300 (AirPlay:192.168.1.107)
2026-07-31 21:41:23.666 [DEBUG] [rotocols.companion.CompanionProtocol] - Exchange OPACK: {_i=FetchAttentionState, _t=2, _c={}, _x=34886}
2026-07-31 21:41:23.666 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=FetchAttentionState, _t=2, _c={}, _x=34886}
2026-07-31 21:41:24.592 [TRACE] [atv.internal.client.core.Heartbeater] - Sending periodic heartbeat 301 (AirPlay:192.168.1.107)
2026-07-31 21:41:24.593 [TRACE] [l.client.support.http.HttpConnection] - Sending RTSP/1.0 message: POST /feedback
2026-07-31 21:41:24.595 [TRACE] [l.client.support.http.HttpConnection] - Got RTSP response: 200 OK
2026-07-31 21:41:24.596 [TRACE] [atv.internal.client.core.Heartbeater] - Got heartbeat 301 (AirPlay:192.168.1.107)
2026-07-31 21:41:26.596 [TRACE] [atv.internal.client.core.Heartbeater] - Sending periodic heartbeat 302 (AirPlay:192.168.1.107)
2026-07-31 21:41:26.597 [TRACE] [l.client.support.http.HttpConnection] - Sending RTSP/1.0 message: POST /feedback
2026-07-31 21:41:26.599 [TRACE] [l.client.support.http.HttpConnection] - Got RTSP response: 200 OK
2026-07-31 21:41:26.600 [TRACE] [atv.internal.client.core.Heartbeater] - Got heartbeat 302 (AirPlay:192.168.1.107)
2026-07-31 21:41:28.600 [TRACE] [atv.internal.client.core.Heartbeater] - Sending periodic heartbeat 303 (AirPlay:192.168.1.107)
2026-07-31 21:41:28.601 [TRACE] [l.client.support.http.HttpConnection] - Sending RTSP/1.0 message: POST /feedback
2026-07-31 21:41:28.604 [TRACE] [l.client.support.http.HttpConnection] - Got RTSP response: 200 OK
2026-07-31 21:41:28.604 [TRACE] [atv.internal.client.core.Heartbeater] - Got heartbeat 303 (AirPlay:192.168.1.107)
2026-07-31 21:41:28.668 [DEBUG] [ding.atv.internal.handler.AtvHandler] - Sleep monitor: poll failed after 1 min; falling back to reconnect probe
2026-07-31 21:41:28.668 [DEBUG] [ding.atv.internal.handler.AtvHandler] - Sleep monitor: Companion connection dropped after 65 s; falling back to reconnect probe
2026-07-31 21:41:28.669 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_interest, _t=1, _c={_deregEvents=[_iMC]}, _x=34887}
2026-07-31 21:41:28.669 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_interest, _t=1, _c={_deregEvents=[SystemStatus]}, _x=34888}
2026-07-31 21:41:28.670 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_interest, _t=1, _c={_deregEvents=[TVSystemStatus]}, _x=34889}
2026-07-31 21:41:28.670 [DEBUG] [rotocols.companion.CompanionProtocol] - Exchange OPACK: {_i=_sessionStop, _t=2, _c={_srvT=com.apple.tvremoteservices, _sid=1201032004866154370}, _x=34890}
2026-07-31 21:41:28.670 [DEBUG] [rotocols.companion.CompanionProtocol] - Send OPACK: {_i=_sessionStop, _t=2, _c={_srvT=com.apple.tvremoteservices, _sid=1201032004866154370}, _x=34890}
2026-07-31 21:41:30.605 [TRACE] [atv.internal.client.core.Heartbeater] - Sending periodic heartbeat 304 (AirPlay:192.168.1.107)
2026-07-31 21:41:30.606 [TRACE] [l.client.support.http.HttpConnection] - Sending RTSP/1.0 message: POST /feedback
2026-07-31 21:41:30.608 [TRACE] [l.client.support.http.HttpConnection] - Got RTSP response: 200 OK
2026-07-31 21:41:30.609 [TRACE] [atv.internal.client.core.Heartbeater] - Got heartbeat 304 (AirPlay:192.168.1.107)
2026-07-31 21:41:32.610 [TRACE] [atv.internal.client.core.Heartbeater] - Sending periodic heartbeat 305 (AirPlay:192.168.1.107)
2026-07-31 21:41:32.610 [TRACE] [l.client.support.http.HttpConnection] - Sending RTSP/1.0 message: POST /feedback
2026-07-31 21:41:32.613 [TRACE] [l.client.support.http.HttpConnection] - Got RTSP response: 200 OK
2026-07-31 21:41:32.613 [TRACE] [atv.internal.client.core.Heartbeater] - Got heartbeat 305 (AirPlay:192.168.1.107)
2026-07-31 21:41:34.614 [TRACE] [atv.internal.client.core.Heartbeater] - Sending periodic heartbeat 306 (AirPlay:192.168.1.107)
omr@shs3:~$

[digitaldan (Dan Cunningham)]

New binding is up (few days old). Worth giving a shot.

[OMR (Ole Morten Rønning)]

Previous one has been stable.
Only nit is it can take up to a minute to detect power on from the remote and automations are triggered.

BTW, i will try 26.6 soon, on my second ATV.
Will report back when done.

[digitaldan (Dan Cunningham)]

@OMR

Only nit is it can take up to a minute to detect power on from the remote and automations are triggered.

I’ll see about making that shorter if possible.

[OMR (Ole Morten Rønning)]

openhab> list | grep -i atv
251 │ Active │ 80 │ 5.3.0.202608052301 │ openHAB Add-ons :: Bundles :: atv Binding
Verified OK.
Now stays ONLINE when OFF.
Also works fine on ATV 26.6.

Thanks!

[digitaldan (Dan Cunningham)]

@OMR

Only nit is it can take up to a minute to detect power on from the remote and automations are triggered.

new jar is up, this should react immediately to a sleeping device waking up, it uses MDNS to listen for an announcement which should happening in a few seconds. This jar also has a ton of clean up in it.

[TAKeanice (Tassilo Karge)]

I did not test all of the features and reaction times yet, but so far I am amazed at how far this binding has come from when I first tried it out. I just want to say thanks for the great work!

[OMR (Ole Morten Rønning)]

@digitaldan

new jar is up, this should react immediately to a sleeping device waking up, it uses MDNS to listen for an announcement which should happening in a few seconds. This jar also has a ton of clean up in it.

Snappy now!
Thanks again!

[digitaldan (Dan Cunningham)]

There’s a new Jar up, this fixes an issue where i was starving the general openHAB thread pool. I would highly recommend to restart openHAB after upgrading the jar to clear the stuck threads, unfortunately there is not another way to clear those, and a starved thread pool can cause all sorts of issues on a system if not addressed.

[OMR (Ole Morten Rønning)]

@digitaldan

i was starving the general openHAB thread pool

Did that show up on top?
Could it be what I experienced here: openHAB 5.2 Release discussion - #262 by OMR ?

[digitaldan (Dan Cunningham)]

@OMR

Did that show up on top?

No, this is the internal thread pool in Java land, its not spawning anything, just eating up the pool of available ones.

@OMR

Could it be what I experienced here:

Yes this could very well be related, if the thread pool is dead locked, then stuff just stops working.

[OMR (Ole Morten Rønning)]

ICYMI: 26.6 seems fine …

And new Thing status:

[OMR (Ole Morten Rønning)]

@digitaldan any plans to release?

[digitaldan (Dan Cunningham)]

Thanks for the reminder, yeah, its probably a good to time to submit this. I’ll see if i can do a couple of final cleanups tomorrow and submit it to the add-ons repo.