search

postlund / pyatv

A client library for Apple TV and AirPlay devices
https://pyatv.dev
MIT License
839 stars 91 forks source link

Failed to pair using 15.2 (19K53) inside HA latest #1592

Closed tcb678 closed 2 years ago

tcb678 commented 2 years ago

Describe the bug

My hass-atv-beta is installed via HACS; my HA is in a Docker container. Pairing seems to complete normally using atvremote for all 3 protocols (Companion, RAOP, AirPlay). In HA, when the configuration finishes, I get a message that says 'Aborted: Re-authentication was successful' as a popup. The AppleTV component never shows within Home Assistant after configuration.

Error log

tail -f home-assistant.log | grep pyatv
2022-01-09 16:20:20 DEBUG (MainThread) [homeassistant.components.websocket_api.http.connection] [139729098244304] Sending {"id": 118, "type": "result", "success": true, "result": [{"domain": "fan", "name": "Fan", "documentation": "https://www.home-assistant.io/integrations/fan", "codeowners": [], "quality_scale": "internal", "is_built_in": true}, {"domain": "scene", "name": "Scenes", "documentation": "https://www.home-assistant.io/integrations/scene", "codeowners": ["@home-assistant/core"], "quality_scale": "internal", "is_built_in": true}, {"domain": "network", "name": "Network Configuration", "documentation": "https://www.home-assistant.io/integrations/network", "requirements": ["ifaddr==0.1.7"], "codeowners": [], "dependencies": ["websocket_api"], "quality_scale": "internal", "iot_class": "local_push", "is_built_in": true}, {"domain": "nws", "name": "National Weather Service (NWS)", "documentation": "https://www.home-assistant.io/integrations/nws", "codeowners": ["@MatthewFlamm"], "requirements": ["pynws==1.3.2"], "quality_scale": "platinum", "config_flow": true, "iot_class": "cloud_polling", "is_built_in": true}, {"domain": "zeroconf", "name": "Zero-configuration networking (zeroconf)", "documentation": "https://www.home-assistant.io/integrations/zeroconf", "requirements": ["zeroconf==0.38.1"], "dependencies": ["network", "api"], "codeowners": ["@bdraco"], "quality_scale": "internal", "iot_class": "local_push", "is_built_in": true}, {"domain": "google_translate", "name": "Google Translate Text-to-Speech", "documentation": "https://www.home-assistant.io/integrations/google_translate", "requirements": ["gTTS==2.2.3"], "codeowners": [], "iot_class": "cloud_push", "is_built_in": true}, {"domain": "device_automation", "name": "Device Automation", "documentation": "https://www.home-assistant.io/integrations/device_automation", "codeowners": ["@home-assistant/core"], "quality_scale": "internal", "is_built_in": true}, {"domain": "analytics", "name": "Analytics", "documentation": "https://www.home-assistant.io/integrations/analytics", "codeowners": ["@home-assistant/core", "@ludeeus"], "dependencies": ["api", "websocket_api"], "after_dependencies": ["energy"], "quality_scale": "internal", "iot_class": "cloud_push", "is_built_in": true}, {"domain": "trace", "name": "Trace", "documentation": "https://www.home-assistant.io/integrations/automation", "codeowners": ["@home-assistant/core"], "quality_scale": "internal", "is_built_in": true}, {"domain": "sonos", "name": "Sonos", "config_flow": true, "documentation": "https://www.home-assistant.io/integrations/sonos", "requirements": ["soco==0.25.2"], "dependencies": ["ssdp"], "after_dependencies": ["plex", "zeroconf"], "zeroconf": ["_sonos._tcp.local."], "ssdp": [{"st": "urn:schemas-upnp-org:device:ZonePlayer:1"}], "codeowners": ["@cgtobi", "@jjlawren"], "iot_class": "local_push", "is_built_in": true}, {"domain": "system_log", "name": "System Log", "documentation": "https://www.home-assistant.io/integrations/system_log", "dependencies": ["http"], "codeowners": [], "quality_scale": "internal", "is_built_in": true}, {"domain": "persistent_notification", "name": "Persistent Notification", "documentation": "https://www.home-assistant.io/integrations/persistent_notification", "codeowners": ["@home-assistant/core"], "quality_scale": "internal", "iot_class": "local_push", "is_built_in": true}, {"domain": "device_tracker", "name": "Device Tracker", "documentation": "https://www.home-assistant.io/integrations/device_tracker", "dependencies": ["zone"], "after_dependencies": [], "codeowners": [], "quality_scale": "internal", "is_built_in": true}, {"domain": "ffmpeg", "name": "FFmpeg", "documentation": "https://www.home-assistant.io/integrations/ffmpeg", "requirements": ["ha-ffmpeg==3.0.2"], "codeowners": [], "is_built_in": true}, {"domain": "template", "name": "Template", "documentation": "https://www.home-assistant.io/integrations/template", "codeowners": ["@PhracturedBlue", "@tetienne", "@home-assistant/core"], "quality_scale": "internal", "after_dependencies": ["group"], "iot_class": "local_push", "is_built_in": true}, {"domain": "aarlo", "name": "Arlo Camera Support", "documentation": "https://github.com/twrecked/hass-aarlo/blob/master/README.md", "issue_tracker": "https://github.com/twrecked/hass-aarlo/issues", "dependencies": ["ffmpeg"], "codeowners": ["@twrecked"], "requirements": ["unidecode", "cloudscraper>=1.2.58", "paho-mqtt"], "version": "0.7.2b7", "iot_class": "cloud_push", "is_built_in": false}, {"domain": "person", "name": "Person", "documentation": "https://www.home-assistant.io/integrations/person", "dependencies": ["image"], "after_dependencies": ["device_tracker"], "codeowners": [], "quality_scale": "internal", "iot_class": "calculated", "is_built_in": true}, {"domain": "ssdp", "name": "Simple Service Discovery Protocol (SSDP)", "documentation": "https://www.home-assistant.io/integrations/ssdp", "requirements": ["async-upnp-client==0.23.1"], "dependencies": ["network"], "after_dependencies": ["zeroconf"], "codeowners": [], "quality_scale": "internal", "iot_class": "local_push", "is_built_in": true}, {"domain": "input_select", "name": "Input Select", "documentation": "https://www.home-assistant.io/integrations/input_select", "codeowners": ["@home-assistant/core"], "quality_scale": "internal", "is_built_in": true}, {"domain": "zone", "name": "Zone", "config_flow": false, "documentation": "https://www.home-assistant.io/integrations/zone", "codeowners": ["@home-assistant/core"], "quality_scale": "internal", "is_built_in": true}, {"domain": "default_config", "name": "Default Config", "documentation": "https://www.home-assistant.io/integrations/default_config", "dependencies": ["automation", "cloud", "counter", "dhcp", "energy", "frontend", "history", "input_boolean", "input_datetime", "input_number", "input_select", "input_text", "logbook", "map", "media_source", "mobile_app", "my", "network", "person", "scene", "script", "ssdp", "sun", "system_health", "tag", "timer", "usb", "updater", "webhook", "zeroconf", "zone"], "codeowners": [], "quality_scale": "internal", "is_built_in": true}, {"domain": "auth", "name": "Auth", "documentation": "https://www.home-assistant.io/integrations/auth", "dependencies": ["http"], "codeowners": ["@home-assistant/core"], "quality_scale": "internal", "is_built_in": true}, {"domain": "blueprint", "name": "Blueprint", "documentation": "https://www.home-assistant.io/integrations/blueprint", "codeowners": ["@home-assistant/core"], "quality_scale": "internal", "is_built_in": true}, {"domain": "sensor", "name": "Sensor", "documentation": "https://www.home-assistant.io/integrations/sensor", "codeowners": [], "quality_scale": "internal", "after_dependencies": ["recorder"], "is_built_in": true}, {"domain": "sun", "name": "Sun", "documentation": "https://www.home-assistant.io/integrations/sun", "codeowners": ["@Swamp-Ig"], "quality_scale": "internal", "iot_class": "calculated", "is_built_in": true}, {"domain": "blitzortung", "iot_class": "cloud_push", "name": "Blitzortung", "config_flow": true, "version": "1.0.1", "documentation": "https://github.com/mrk-its/homeassistant-blitzortung", "issue_tracker": "https://github.com/mrk-its/homeassistant-blitzortung/issues", "requirements": ["paho-mqtt>=1.5.0"], "after_dependencies": [], "dependencies": ["persistent_notification"], "codeowners": ["@mrk-its"], "is_built_in": false}, {"domain": "system_health", "name": "System Health", "documentation": "https://www.home-assistant.io/integrations/system_health", "dependencies": ["http"], "codeowners": [], "quality_scale": "internal", "is_built_in": true}, {"domain": "recorder", "name": "Recorder", "documentation": "https://www.home-assistant.io/integrations/recorder", "requirements": ["sqlalchemy==1.4.27"], "codeowners": ["@home-assistant/core"], "quality_scale": "internal", "iot_class": "local_push", "is_built_in": true}, {"domain": "cloud", "name": "Home Assistant Cloud", "documentation": "https://www.home-assistant.io/integrations/cloud", "requirements": ["hass-nabucasa==0.50.0"], "dependencies": ["http", "webhook"], "after_dependencies": ["google_assistant", "alexa"], "codeowners": ["@home-assistant/cloud"], "iot_class": "cloud_push", "is_built_in": true}, {"domain": "mobile_app", "name": "Mobile App", "config_flow": true, "documentation": "https://www.home-assistant.io/integrations/mobile_app", "requirements": ["PyNaCl==1.4.0", "emoji==1.5.0"], "dependencies": ["http", "webhook", "person", "tag", "websocket_api"], "after_dependencies": ["cloud", "camera", "notify"], "codeowners": ["@robbiet480"], "quality_scale": "internal", "iot_class": "local_push", "is_built_in": true}, {"domain": "light", "name": "Light", "documentation": "https://www.home-assistant.io/integrations/light", "codeowners": [], "quality_scale": "internal", "is_built_in": true}, {"domain": "energy", "name": "Energy", "documentation": "https://www.home-assistant.io/integrations/energy", "codeowners": ["@home-assistant/core"], "iot_class": "calculated", "dependencies": ["websocket_api", "history", "recorder"], "quality_scale": "internal", "is_built_in": true}, {"domain": "my", "name": "My Home Assistant", "documentation": "https://www.home-assistant.io/integrations/my", "dependencies": ["frontend"], "codeowners": ["@home-assistant/core"], "quality_scale": "internal", "is_built_in": true}, {"domain": "input_datetime", "name": "Input Datetime", "documentation": "https://www.home-assistant.io/integrations/input_datetime", "codeowners": ["@home-assistant/core"], "quality_scale": "internal", "is_built_in": true}, {"domain": "tts", "name": "Text-to-Speech (TTS)", "documentation": "https://www.home-assistant.io/integrations/tts", "requirements": ["mutagen==1.45.1"], "dependencies": ["http"], "after_dependencies": ["media_player"], "codeowners": ["@pvizeli"], "quality_scale": "internal", "is_built_in": true}, {"domain": "script", "name": "Scripts", "documentation": "https://www.home-assistant.io/integrations/script", "dependencies": ["blueprint", "trace"], "codeowners": ["@home-assistant/core"], "quality_scale": "internal", "is_built_in": true}, {"domain": "bond", "name": "Bond", "config_flow": true, "documentation": "https://www.home-assistant.io/integrations/bond", "requirements": ["bond-api==0.1.15"], "zeroconf": ["_bond._tcp.local."], "codeowners": ["@bdraco", "@prystupa", "@joshs85"], "quality_scale": "platinum", "iot_class": "local_push", "is_built_in": true}, {"domain": "input_boolean", "name": "Input Boolean", "documentation": "https://www.home-assistant.io/integrations/input_boolean", "codeowners": ["@home-assistant/core"], "quality_scale": "internal", "is_built_in": true}, {"domain": "apple_tv", "name": "Apple TV", "config_flow": true, "documentation": "https://www.home-assistant.io/integrations/apple_tv", "requirements": ["pyatv==0.9.8"], "zeroconf": ["_mediaremotetv._tcp.local.", "_touch-able._tcp.local.", {"type": "_airplay._tcp.local.", "model": "appletv*"}, {"type": "_airplay._tcp.local.", "model": "audioaccessory*"}, "_appletv-v2._tcp.local.", "_raop._tcp.local.", "_hscp._tcp.local."], "codeowners": ["@postlund"], "version": "2.2.0", "iot_class": "local_push", "is_built_in": false}, {"domain": "frontend", "name": "Home Assistant Frontend", "documentation": "https://www.home-assistant.io/integrations/frontend", "requirements": ["home-assistant-frontend==20211229.0"], "dependencies": ["api", "auth", "config", "device_automation", "http", "lovelace", "onboarding", "search", "system_log", "websocket_api"], "codeowners": ["@home-assistant/frontend"], "quality_scale": "internal", "is_built_in": true}, {"domain": "prometheus", "name": "Prometheus", "documentation": "https://www.home-assistant.io/integrations/prometheus", "requirements": ["prometheus_client==0.7.1"], "dependencies": ["http"], "codeowners": ["@knyar"], "iot_class": "assumed_state", "is_built_in": true}, {"domain": "switch", "name": "Switch", "documentation": "https://www.home-assistant.io/integrations/switch", "codeowners": [], "quality_scale": "internal", "is_built_in": true}, {"domain": "stream", "name": "Stream", "documentation": "https://www.home-assistant.io/integrations/stream", "requirements": ["ha-av==8.0.4-rc.1"], "dependencies": ["http"], "codeowners": ["@hunterjm", "@uvjustin", "@allenporter"], "quality_scale": "internal", "iot_class": "local_push", "is_built_in": true}, {"domain": "map", "name": "Map", "documentation": "https://www.home-assistant.io/integrations/map", "dependencies": ["frontend"], "codeowners": [], "quality_scale": "internal", "is_built_in": true}, {"domain": "input_text", "name": "Input Text", "documentation": "https://www.home-assistant.io/integrations/input_text", "codeowners": ["@home-assistant/core"], "quality_scale": "internal", "is_built_in": true}, {"domain": "camera", "name": "Camera", "documentation": "https://www.home-assistant.io/integrations/camera", "dependencies": ["http"], "requirements": ["PyTurboJPEG==1.6.3"], "after_dependencies": ["media_player"], "codeowners": [], "quality_scale": "internal", "is_built_in": true}, {"domain": "websocket_api", "name": "Home Assistant WebSocket API", "documentation": "https://www.home-assistant.io/integrations/websocket_api", "dependencies": ["http"], "codeowners": ["@home-assistant/core"], "quality_scale": "internal", "is_built_in": true}, {"domain": "media_player", "name": "Media Player", "documentation": "https://www.home-assistant.io/integrations/media_player", "dependencies": ["http"], "codeowners": [], "quality_scale": "internal", "is_built_in": true}, {"domain": "group", "name": "Group", "documentation": "https://www.home-assistant.io/integrations/group", "codeowners": ["@home-assistant/core"], "quality_scale": "internal", "iot_class": "calculated", "is_built_in": true}, {"domain": "binary_sensor", "name": "Binary Sensor", "documentation": "https://www.home-assistant.io/integrations/binary_sensor", "codeowners": [], "quality_scale": "internal", "is_built_in": true}, {"domain": "lovelace", "name": "Lovelace", "documentation": "https://www.home-assistant.io/integrations/lovelace", "codeowners": ["@home-assistant/frontend"], "is_built_in": true}, {"domain": "automation", "name": "Automation", "documentation": "https://www.home-assistant.io/integrations/automation", "dependencies": ["blueprint", "trace"], "after_dependencies": ["device_automation", "webhook"], "codeowners": ["@home-assistant/core"], "quality_scale": "internal", "is_built_in": true}, {"domain": "webhook", "name": "Webhook", "documentation": "https://www.home-assistant.io/integrations/webhook", "dependencies": ["http"], "codeowners": [], "quality_scale": "internal", "is_built_in": true}, {"domain": "search", "name": "Search", "documentation": "https://www.home-assistant.io/integrations/search", "dependencies": ["websocket_api"], "after_dependencies": ["scene", "group", "automation", "script"], "codeowners": ["@home-assistant/core"], "quality_scale": "internal", "is_built_in": true}, {"domain": "http", "name": "HTTP", "documentation": "https://www.home-assistant.io/integrations/http", "requirements": ["aiohttp_cors==0.7.0"], "codeowners": ["@home-assistant/core"], "quality_scale": "internal", "iot_class": "local_push", "is_built_in": true}, {"domain": "climacell", "name": "ClimaCell", "config_flow": true, "documentation": "https://www.home-assistant.io/integrations/climacell", "requirements": ["pyclimacell==0.18.2"], "codeowners": ["@raman325"], "iot_class": "cloud_polling", "is_built_in": true}, {"domain": "dhcp", "name": "DHCP Discovery", "documentation": "https://www.home-assistant.io/integrations/dhcp", "requirements": ["scapy==2.4.5", "aiodiscover==1.4.5"], "codeowners": ["@bdraco"], "quality_scale": "internal", "iot_class": "local_push", "is_built_in": true}, {"domain": "homeassistant", "name": "Home Assistant Core Integration", "documentation": "https://www.home-assistant.io/integrations/homeassistant", "codeowners": ["@home-assistant/core"], "quality_scale": "internal", "is_built_in": true}, {"domain": "logger", "name": "Logger", "documentation": "https://www.home-assistant.io/integrations/logger", "codeowners": ["@home-assistant/core"], "quality_scale": "internal", "is_built_in": true}, {"domain": "gdacs", "name": "Global Disaster Alert and Coordination System (GDACS)", "config_flow": true, "documentation": "https://www.home-assistant.io/integrations/gdacs", "requirements": ["aio_georss_gdacs==0.5"], "codeowners": ["@exxamalte"], "quality_scale": "platinum", "iot_class": "cloud_polling", "is_built_in": true}, {"domain": "met", "name": "Meteorologisk institutt (Met.no)", "config_flow": true, "documentation": "https://www.home-assistant.io/integrations/met", "requirements": ["pyMetno==0.9.0"], "codeowners": ["@danielhiversen", "@thimic"], "iot_class": "cloud_polling", "is_built_in": true}, {"domain": "input_number", "name": "Input Number", "documentation": "https://www.home-assistant.io/integrations/input_number", "codeowners": ["@home-assistant/core"], "quality_scale": "internal", "is_built_in": true}, {"domain": "geo_location", "name": "Geolocation", "documentation": "https://www.home-assistant.io/integrations/geo_location", "codeowners": [], "quality_scale": "internal", "is_built_in": true}, {"domain": "hue", "name": "Philips Hue", "config_flow": true, "documentation": "https://www.home-assistant.io/integrations/hue", "requirements": ["aiohue==3.0.11"], "ssdp": [{"manufacturer": "Royal Philips Electronics", "modelName": "Philips hue bridge 2012"}, {"manufacturer": "Royal Philips Electronics", "modelName": "Philips hue bridge 2015"}, {"manufacturer": "Signify", "modelName": "Philips hue bridge 2015"}], "homekit": {"models": ["BSB002"]}, "zeroconf": ["_hue._tcp.local."], "codeowners": ["@balloob", "@marcelveldt"], "quality_scale": "platinum", "iot_class": "local_push", "is_built_in": true}, {"domain": "history", "name": "History", "documentation": "https://www.home-assistant.io/integrations/history", "dependencies": ["http", "recorder"], "codeowners": ["@home-assistant/core"], "quality_scale": "internal", "is_built_in": true}, {"domain": "faa_delays", "name": "FAA Delays", "config_flow": true, "documentation": "https://www.home-assistant.io/integrations/faa_delays", "requirements": ["faadelays==0.0.7"], "codeowners": ["@ntilley905"], "iot_class": "cloud_polling", "is_built_in": true}, {"domain": "rest_command", "name": "RESTful Command", "documentation": "https://www.home-assistant.io/integrations/rest_command", "codeowners": [], "iot_class": "local_push", "is_built_in": true}, {"domain": "speedtestdotnet", "name": "Speedtest.net", "config_flow": true, "documentation": "https://www.home-assistant.io/integrations/speedtestdotnet", "requirements": ["speedtest-cli==2.1.3"], "codeowners": ["@rohankapoorcom", "@engrbm87"], "iot_class": "cloud_polling", "is_built_in": true}, {"domain": "number", "name": "Number", "documentation": "https://www.home-assistant.io/integrations/number", "codeowners": ["@home-assistant/core", "@Shulyaka"], "quality_scale": "internal", "is_built_in": true}, {"domain": "image", "name": "Image", "config_flow": false, "documentation": "https://www.home-assistant.io/integrations/image", "requirements": ["pillow==8.2.0"], "dependencies": ["http"], "codeowners": ["@home-assistant/core"], "quality_scale": "internal", "is_built_in": true}, {"domain": "updater", "name": "Updater", "documentation": "https://www.home-assistant.io/integrations/updater", "codeowners": ["@home-assistant/core"], "quality_scale": "internal", "iot_class": "cloud_polling", "is_built_in": true}, {"domain": "mqtt", "name": "MQTT", "config_flow": true, "documentation": "https://www.home-assistant.io/integrations/mqtt", "requirements": ["paho-mqtt==1.6.1"], "dependencies": ["http"], "codeowners": ["@emontnemery"], "iot_class": "local_push", "is_built_in": true}, {"codeowners": ["@ludeeus"], "config_flow": true, "dependencies": ["http", "websocket_api", "frontend", "persistent_notification", "lovelace"], "documentation": "https://hacs.xyz/docs/configuration/start", "domain": "hacs", "iot_class": "cloud_polling", "issue_tracker": "https://github.com/hacs/integration/issues", "name": "HACS", "requirements": ["aiogithubapi>=21.11.0"], "version": "1.19.2", "is_built_in": false}, {"domain": "logbook", "name": "Logbook", "documentation": "https://www.home-assistant.io/integrations/logbook", "dependencies": ["frontend", "http", "recorder"], "codeowners": [], "quality_scale": "internal", "is_built_in": true}, {"domain": "counter", "name": "Counter", "documentation": "https://www.home-assistant.io/integrations/counter", "codeowners": ["@fabaff"], "quality_scale": "internal", "is_built_in": true}, {"domain": "timer", "name": "Timer", "documentation": "https://www.home-assistant.io/integrations/timer", "codeowners": [], "quality_scale": "internal", "is_built_in": true}, {"domain": "api", "name": "Home Assistant API", "documentation": "https://www.home-assistant.io/integrations/api", "dependencies": ["http"], "codeowners": ["@home-assistant/core"], "quality_scale": "internal", "is_built_in": true}, {"domain": "tag", "name": "Tags", "documentation": "https://www.home-assistant.io/integrations/tag", "codeowners": ["@balloob", "@dmulcahey"], "quality_scale": "internal", "is_built_in": true}, {"domain": "weather", "name": "Weather", "documentation": "https://www.home-assistant.io/integrations/weather", "codeowners": ["@fabaff"], "quality_scale": "internal", "is_built_in": true}, {"domain": "notify", "name": "Notifications", "documentation": "https://www.home-assistant.io/integrations/notify", "codeowners": ["@home-assistant/core"], "quality_scale": "internal", "is_built_in": true}, {"domain": "onboarding", "name": "Home Assistant Onboarding", "documentation": "https://www.home-assistant.io/integrations/onboarding", "after_dependencies": ["hassio"], "dependencies": ["analytics", "auth", "http", "person"], "codeowners": ["@home-assistant/core"], "quality_scale": "internal", "is_built_in": true}, {"domain": "config", "name": "Configuration", "documentation": "https://www.home-assistant.io/integrations/config", "dependencies": ["http"], "codeowners": ["@home-assistant/core"], "quality_scale": "internal", "is_built_in": true}, {"domain": "dnsip", "name": "DNS IP", "documentation": "https://www.home-assistant.io/integrations/dnsip", "requirements": ["aiodns==3.0.0"], "codeowners": [], "iot_class": "cloud_polling", "is_built_in": true}, {"domain": "media_source", "name": "Media Source", "documentation": "https://www.home-assistant.io/integrations/media_source", "dependencies": ["http"], "codeowners": ["@hunterjm"], "quality_scale": "internal", "is_built_in": true}, {"domain": "usb", "name": "USB Discovery", "documentation": "https://www.home-assistant.io/integrations/usb", "requirements": ["pyudev==0.22.0", "pyserial==3.5"], "codeowners": ["@bdraco"], "dependencies": ["websocket_api"], "quality_scale": "internal", "iot_class": "local_push", "is_built_in": true}, {"domain": "cover", "name": "Cover", "documentation": "https://www.home-assistant.io/integrations/cover", "codeowners": ["@home-assistant/core"], "quality_scale": "internal", "is_built_in": true}]}
2022-01-09 16:20:29 DEBUG (MainThread) [pyatv.support.knock] Knocking at port 3689 on 192.168.1.7
2022-01-09 16:20:29 DEBUG (MainThread) [pyatv.support.knock] Knocking at port 7000 on 192.168.1.7
2022-01-09 16:20:29 DEBUG (MainThread) [pyatv.support.knock] Knocking at port 49152 on 192.168.1.7
2022-01-09 16:20:29 DEBUG (MainThread) [pyatv.support.knock] Knocking at port 32498 on 192.168.1.7
2022-01-09 16:20:29 DEBUG (MainThread) [pyatv.core.scan] Auto-discovered Living Room at 192.168.1.7:49152 via Protocol.Companion ({'rpmac': '1', 'rphn': '1bb4bca13c30', 'rpfl': '0xB6782', 'rpha': '10a2fb7daf28', 'rpmd': 'AppleTV6,2', 'rpvr': '320.2', 'rpad': '14507fcc5f73', 'rphi': '6d40bdf2a1c4', 'rpba': 'EC:6E:58:9D:9F:DD', 'rpmrtid': 'F8CB7428-8D89-4E88-928B-F7E3550A394F'})
2022-01-09 16:20:29 DEBUG (MainThread) [pyatv.core.scan] Auto-discovered Living Room at 192.168.1.7:7000 via Protocol.AirPlay ({'acl': '0', 'btaddr': 'D0:D2:B0:A4:CF:64', 'deviceid': 'D0:D2:B0:A6:D1:83', 'fex': '1d9/St5/FbwI', 'features': '0x4A7FDFD5,0xBC157FDE', 'flags': '0x18644', 'gid': 'CBD79DEB-B12A-4609-8BB2-248B7EDCC295', 'igl': '1', 'gcgl': '1', 'model': 'AppleTV6,2', 'protovers': '1.1', 'pi': '8df77c4d-040d-46ce-94cb-0972bba12e72', 'psi': 'F8CB7428-8D89-4E88-928B-F7E3550A394F', 'pk': 'fb757772e3adeb9bf52750add4d0b5e0b842cb02607ca8f48e2dedcd95e91fc1', 'srcvers': '600.8.41', 'osvers': '15.2', 'vv': '2'})
2022-01-09 16:20:29 DEBUG (MainThread) [pyatv.protocols.mrp] Disabling MRP service since tvOS >= 15
2022-01-09 16:20:29 DEBUG (MainThread) [pyatv.core.scan] Auto-discovered Living Room at 192.168.1.7:49153 via Protocol.MRP ({'modelname': 'Apple TV', 'allowpairing': 'YES', 'bluetoothaddress': "b'\\xd0\\xd2\\xb0\\xa4\\xcfd'", 'macaddress': 'd0:d2:b0:a6:d1:83', 'name': 'Living Room', 'uniqueidentifier': '5E7DCA4D-AB16-469B-99DD-C1D9858B42B9', 'systembuildversion': '19K53', 'localairplayreceiverpairingidentity': 'F8CB7428-8D89-4E88-928B-F7E3550A394F'})
2022-01-09 16:20:29 DEBUG (MainThread) [pyatv.core.scan] Auto-discovered D0D2B0A6D183@Living Room at 192.168.1.7:7000 via Protocol.RAOP ({'cn': '0,1,2,3', 'da': 'true', 'et': '0,3,5', 'ft': '0x4A7FDFD5,0xBC157FDE', 'sf': '0x18644', 'md': '0,1,2', 'am': 'AppleTV6,2', 'pk': 'fb757772e3adeb9bf52750add4d0b5e0b842cb02607ca8f48e2dedcd95e91fc1', 'tp': 'UDP', 'vn': '65537', 'vs': '600.8.41', 'ov': '15.2', 'vv': '2'})
2022-01-09 16:20:31 DEBUG (MainThread) [pyatv.protocols.companion.pairing] Start pairing Companion
2022-01-09 16:20:31 DEBUG (MainThread) [pyatv.protocols.companion.connection] Connected to companion device 192.168.1.7:49152
2022-01-09 16:20:31 DEBUG (MainThread) [pyatv.protocols.companion.protocol] Companion credentials: None
2022-01-09 16:20:31 DEBUG (MainThread) [pyatv.protocols.companion.protocol] Exchange OPACK: {'_pd': b'\x00\x01\x00\x06\x01\x01', '_pwTy': 1}
2022-01-09 16:20:31 DEBUG (MainThread) [pyatv.protocols.companion.protocol] Send OPACK: {'_pd': b'\x00\x01\x00\x06\x01\x01', '_pwTy': 1, '_x': 48236}
2022-01-09 16:20:31 DEBUG (MainThread) [pyatv.protocols.companion.connection] >> Send data (Data=e3435f706476000100060101455f7077547909425f78316cbc, FrameType=03)
2022-01-09 16:20:31 DEBUG (MainThread) [pyatv.protocols.companion.connection] Received data (Data=040001a4e1435f7064929c010601020210207890334740f1ccd4ab4c92583e5f4203ff1c658ef2663007b3d7f9bd2e378a17e2de9ad091e7b47d025edb58926df7ffd58143daa579396f4fbf5e5ec2322fb7219f8ea1608415e99410b920062026c1eee2491e3e7d74f8f00ac4e6c279357d69d91aad17554dbf86bbb64266953f06aec8ac089eba2eec88aadc58386a757bc8973436f72de1d597ac9f4593c9837964df96ae3a4848932df947a64184a953e3b6cb6fe9d6a9842306d3bb2a19131ee6410222d44a2dfaf60257e1cb32dd585725fa36dc96e2e56c168d993055b186e3849413f61e2286398c9c7a4a28cdcc0f4d1542c298f5978f2541f42...)
2022-01-09 16:20:31 DEBUG (MainThread) [pyatv.protocols.companion.protocol] Received frame FrameType.PS_Next: b'\xe1C_pd\x92\x9c\x01\x06\x01\x02\x02\x10 x\x903G@\xf1\xcc\xd4\xabL\x92X>_B\x03\xff\x1ce\x8e\xf2f0\x07\xb3\xd7\xf9\xbd.7\x8a\x17\xe2\xde\x9a\xd0\x91\xe7\xb4}\x02^\xdbX\x92m\xf7\xff\xd5\x81C\xda\xa5y9oO\xbf^^\xc22/\xb7!\x9f\x8e\xa1`\x84\x15\xe9\x94\x10\xb9 \x06 &\xc1\xee\xe2I\x1e>}t\xf8\xf0\n\xc4\xe6\xc2y5}i\xd9\x1a\xad\x17UM\xbf\x86\xbb\xb6Bf\x95?\x06\xae\xc8\xac\x08\x9e\xba.\xec\x88\xaa\xdcX8ju{\xc8\x9746\xf7-\xe1\xd5\x97\xac\x9fE\x93\xc9\x83yd\xdf\x96\xae:HH\x93-\xf9G\xa6A\x84\xa9S\xe3\xb6\xcbo\xe9\xd6\xa9\x84#\x06\xd3\xbb*\x19\x13\x1e\xe6A\x02"\xd4J-\xfa\xf6\x02W\xe1\xcb2\xddXW%\xfa6\xdc\x96\xe2\xe5l\x16\x8d\x990U\xb1\x86\xe3\x84\x94\x13\xf6\x1e"\x869\x8c\x9czJ(\xcd\xcc\x0fM\x15B\xc2\x98\xf5\x97\x8f%A\xf4+Q\x95\x8c\xaf=\x9cm\r\xdf\xd7\xc0\xea\x8eF6\xc8\x83\xe4\xae\x8c\xbf*\xf9\x16j&\x13g`\x86\x9aN#"\x9f\x03\x81\xb9\x80!\xfb\xa7j\x99sU!\xece\xcd\xd93\xee\xb1\x8e\xaa\x97\r\xad\xffx\x11\x10\xac\x92\xc4\xe6\x97\xed\xed\xa5\x00m\x85\x16\xc1\xee\xb6m>\xaeq\xf4\x85\x97t\x97\x8d\x19&g(\xcc?J\xd1\xa2\xef\xc0\x99\xe0\xf4\xc7\xfd\xd5\xa9\xd9\xc4\x81\xda\xc4\x0f\r1H!\xff\xca\xa9\xba\x89\xa1\x88\xda\xc3\xae\xa5 !,l\xdb\x9f\x9b\x859\xdbu\xd9U;\x9a\x15\xbc\xb5\x9a\xa9W\x02\xd5\x94I\xe9\xe3\x0c\x14\xfd\x10\xbf\xaf\xe7_\x02&E\xf0\x1b\x01\x01'
2022-01-09 16:20:31 DEBUG (MainThread) [pyatv.protocols.companion.protocol] Process incoming auth frame (FrameType.PS_Next): {'_pd': b'\x06\x01\x02\x02\x10 x\x903G@\xf1\xcc\xd4\xabL\x92X>_B\x03\xff\x1ce\x8e\xf2f0\x07\xb3\xd7\xf9\xbd.7\x8a\x17\xe2\xde\x9a\xd0\x91\xe7\xb4}\x02^\xdbX\x92m\xf7\xff\xd5\x81C\xda\xa5y9oO\xbf^^\xc22/\xb7!\x9f\x8e\xa1`\x84\x15\xe9\x94\x10\xb9 \x06 &\xc1\xee\xe2I\x1e>}t\xf8\xf0\n\xc4\xe6\xc2y5}i\xd9\x1a\xad\x17UM\xbf\x86\xbb\xb6Bf\x95?\x06\xae\xc8\xac\x08\x9e\xba.\xec\x88\xaa\xdcX8ju{\xc8\x9746\xf7-\xe1\xd5\x97\xac\x9fE\x93\xc9\x83yd\xdf\x96\xae:HH\x93-\xf9G\xa6A\x84\xa9S\xe3\xb6\xcbo\xe9\xd6\xa9\x84#\x06\xd3\xbb*\x19\x13\x1e\xe6A\x02"\xd4J-\xfa\xf6\x02W\xe1\xcb2\xddXW%\xfa6\xdc\x96\xe2\xe5l\x16\x8d\x990U\xb1\x86\xe3\x84\x94\x13\xf6\x1e"\x869\x8c\x9czJ(\xcd\xcc\x0fM\x15B\xc2\x98\xf5\x97\x8f%A\xf4+Q\x95\x8c\xaf=\x9cm\r\xdf\xd7\xc0\xea\x8eF6\xc8\x83\xe4\xae\x8c\xbf*\xf9\x16j&\x13g`\x86\x9aN#"\x9f\x03\x81\xb9\x80!\xfb\xa7j\x99sU!\xece\xcd\xd93\xee\xb1\x8e\xaa\x97\r\xad\xffx\x11\x10\xac\x92\xc4\xe6\x97\xed\xed\xa5\x00m\x85\x16\xc1\xee\xb6m>\xaeq\xf4\x85\x97t\x97\x8d\x19&g(\xcc?J\xd1\xa2\xef\xc0\x99\xe0\xf4\xc7\xfd\xd5\xa9\xd9\xc4\x81\xda\xc4\x0f\r1H!\xff\xca\xa9\xba\x89\xa1\x88\xda\xc3\xae\xa5 !,l\xdb\x9f\x9b\x859\xdbu\xd9U;\x9a\x15\xbc\xb5\x9a\xa9W\x02\xd5\x94I\xe9\xe3\x0c\x14\xfd\x10\xbf\xaf\xe7_\x02&E\xf0\x1b\x01\x01'}
2022-01-09 16:20:31 DEBUG (MainThread) [pyatv.protocols.companion.auth] Got pub key and salt (PubKey=1c658ef2663007b3d7f9bd2e378a17e2de9ad091e7b47d025edb58926df7ffd58143daa579396f4fbf5e5ec2322fb7219f8ea1608415e99410b920062026c1eee2491e3e7d74f8f00ac4e6c279357d69d91aad17554dbf86bbb64266953f06aec8ac089eba2eec88aadc58386a757bc8973436f72de1d597ac9f4593c9837964df96ae3a4848932df947a64184a953e3b6cb6fe9d6a9842306d3bb2a19131ee6410222d44a2dfaf60257e1cb32dd585725fa36dc96e2e56c168d993055b186e3849413f61e2286398c9c7a4a28cdcc0f4d1542c298f5978f2541f42b51958caf3d9c6d0ddfd7c0ea8e4636c883e4ae8cbf2af9166a26136760869a4e23229..., Salt=207890334740f1ccd4ab4c92583e5f42)
2022-01-09 16:20:35 DEBUG (MainThread) [pyatv.protocols.companion.pairing] Companion PIN changed to 0094
2022-01-09 16:20:35 DEBUG (MainThread) [pyatv.protocols.companion.pairing] Finish pairing Companion
2022-01-09 16:20:35 DEBUG (MainThread) [pyatv.auth.hap_srp] Client (Proof=34fe2c3baf2ba5c5e164680105b552472cdabe5794573eb7bf97e487683c8d4b536f7a75a1cb1cbc65e0aa6f7be2a2e77ba623d44630f2be74553008d4fc4c54, Public=be1b9189cbe45ca82a0f4c57326a08ce0294c45af89dd5709802c379778a2724ffe9af91cb09610c1697a610ef366f1668322a8bdb069cdeaf8a05ae3c9b6e6023620d14f42f783f98a134dd2a69a3df3cab5b74256b930265db0226d41802593beaa13bb1a15854331de7c421d12e400674fbddfea0bb06bae01cf21991a391f24858bb531f17807f27b5eea8d41200edb6f3937d516f178840eb79abdd54104be626a3340c49a0a5081a585c6886199106de0211cfde1da492536029fb730984b200ec97eea4ebf1a9893db1488e77f8490d50527517e08dc6678bc78c21ead52e1aadad8f04acfeedffb29c3e8b955af58510bebee1e8e1341032b5829...)
2022-01-09 16:20:35 DEBUG (MainThread) [pyatv.protocols.companion.protocol] Exchange OPACK: {'_pd': b'\x06\x01\x03\x03\xff\xbe\x1b\x91\x89\xcb\xe4\\\xa8*\x0fLW2j\x08\xce\x02\x94\xc4Z\xf8\x9d\xd5p\x98\x02\xc3yw\x8a\'$\xff\xe9\xaf\x91\xcb\ta\x0c\x16\x97\xa6\x10\xef6o\x16h2*\x8b\xdb\x06\x9c\xde\xaf\x8a\x05\xae<\x9bn`#b\r\x14\xf4/x?\x98\xa14\xdd*i\xa3\xdf<\xab[t%k\x93\x02e\xdb\x02&\xd4\x18\x02Y;\xea\xa1;\xb1\xa1XT3\x1d\xe7\xc4!\xd1.@\x06t\xfb\xdd\xfe\xa0\xbb\x06\xba\xe0\x1c\xf2\x19\x91\xa3\x91\xf2HX\xbbS\x1f\x17\x80\x7f\'\xb5\xee\xa8\xd4\x12\x00\xed\xb6\xf3\x93}Qo\x17\x88@\xeby\xab\xddT\x10K\xe6&\xa34\x0cI\xa0\xa5\x08\x1aX\\h\x86\x19\x91\x06\xde\x02\x11\xcf\xde\x1d\xa4\x92S`)\xfbs\t\x84\xb2\x00\xec\x97\xee\xa4\xeb\xf1\xa9\x89=\xb1H\x8ew\xf8I\rPRu\x17\xe0\x8d\xc6g\x8b\xc7\x8c!\xea\xd5.\x1a\xad\xad\x8f\x04\xac\xfe\xed\xff\xb2\x9c>\x8b\x95Z\xf5\x85\x10\xbe\xbe\xe1\xe8\xe14\x102\xb5\x82\x9e\x03\x81oz\x15\x1c\\\xcc\xe7)\xa7Y\xfd\xd7+\xd8VN\xa1J\xd2\x8a-\xbf~\xd1)\xf0\xd1KFjt\x1f\x0f\'\x11\r\xfcWqCF\xb9\x0e\xd9\x17\xd2++j\xb1\x07-\x96\xd1\x85\xba2\x9f\xc3\xbfRp8,\xd1\x920\xb1\x1ex\xb8\x13\xd0\xb5o\xb5\x92\x89\xb2\xa8\x94\x16Z\x0ck\x8b\x8f5\x8d0\xa5m\xe3\xa6\xc3\xa7"\x8d\xd4\xaf\x18\xfe\xf2V\x91\x12\xa2<0\x9bFL\xdf\xe2\xdf\'\xfbK\x08\x99\xcb\x98TD\xd4\xc5\xa6\x8f\n\x04@4\xfe,;\xaf+\xa5\xc5\xe1dh\x01\x05\xb5RG,\xda\xbeW\x94W>\xb7\xbf\x97\xe4\x87h<\x8dKSozu\xa1\xcb\x1c\xbce\xe0\xaao{\xe2\xa2\xe7{\xa6#\xd4F0\xf2\xbetU0\x08\xd4\xfcLT', '_pwTy': 1}
2022-01-09 16:20:35 DEBUG (MainThread) [pyatv.protocols.companion.protocol] Send OPACK: {'_pd': b'\x06\x01\x03\x03\xff\xbe\x1b\x91\x89\xcb\xe4\\\xa8*\x0fLW2j\x08\xce\x02\x94\xc4Z\xf8\x9d\xd5p\x98\x02\xc3yw\x8a\'$\xff\xe9\xaf\x91\xcb\ta\x0c\x16\x97\xa6\x10\xef6o\x16h2*\x8b\xdb\x06\x9c\xde\xaf\x8a\x05\xae<\x9bn`#b\r\x14\xf4/x?\x98\xa14\xdd*i\xa3\xdf<\xab[t%k\x93\x02e\xdb\x02&\xd4\x18\x02Y;\xea\xa1;\xb1\xa1XT3\x1d\xe7\xc4!\xd1.@\x06t\xfb\xdd\xfe\xa0\xbb\x06\xba\xe0\x1c\xf2\x19\x91\xa3\x91\xf2HX\xbbS\x1f\x17\x80\x7f\'\xb5\xee\xa8\xd4\x12\x00\xed\xb6\xf3\x93}Qo\x17\x88@\xeby\xab\xddT\x10K\xe6&\xa34\x0cI\xa0\xa5\x08\x1aX\\h\x86\x19\x91\x06\xde\x02\x11\xcf\xde\x1d\xa4\x92S`)\xfbs\t\x84\xb2\x00\xec\x97\xee\xa4\xeb\xf1\xa9\x89=\xb1H\x8ew\xf8I\rPRu\x17\xe0\x8d\xc6g\x8b\xc7\x8c!\xea\xd5.\x1a\xad\xad\x8f\x04\xac\xfe\xed\xff\xb2\x9c>\x8b\x95Z\xf5\x85\x10\xbe\xbe\xe1\xe8\xe14\x102\xb5\x82\x9e\x03\x81oz\x15\x1c\\\xcc\xe7)\xa7Y\xfd\xd7+\xd8VN\xa1J\xd2\x8a-\xbf~\xd1)\xf0\xd1KFjt\x1f\x0f\'\x11\r\xfcWqCF\xb9\x0e\xd9\x17\xd2++j\xb1\x07-\x96\xd1\x85\xba2\x9f\xc3\xbfRp8,\xd1\x920\xb1\x1ex\xb8\x13\xd0\xb5o\xb5\x92\x89\xb2\xa8\x94\x16Z\x0ck\x8b\x8f5\x8d0\xa5m\xe3\xa6\xc3\xa7"\x8d\xd4\xaf\x18\xfe\xf2V\x91\x12\xa2<0\x9bFL\xdf\xe2\xdf\'\xfbK\x08\x99\xcb\x98TD\xd4\xc5\xa6\x8f\n\x04@4\xfe,;\xaf+\xa5\xc5\xe1dh\x01\x05\xb5RG,\xda\xbeW\x94W>\xb7\xbf\x97\xe4\x87h<\x8dKSozu\xa1\xcb\x1c\xbce\xe0\xaao{\xe2\xa2\xe7{\xa6#\xd4F0\xf2\xbetU0\x08\xd4\xfcLT', '_pwTy': 1, '_x': 48237}
2022-01-09 16:20:35 DEBUG (MainThread) [pyatv.protocols.companion.connection] >> Send data (Data=e3435f706492c90106010303ffbe1b9189cbe45ca82a0f4c57326a08ce0294c45af89dd5709802c379778a2724ffe9af91cb09610c1697a610ef366f1668322a8bdb069cdeaf8a05ae3c9b6e6023620d14f42f783f98a134dd2a69a3df3cab5b74256b930265db0226d41802593beaa13bb1a15854331de7c421d12e400674fbddfea0bb06bae01cf21991a391f24858bb531f17807f27b5eea8d41200edb6f3937d516f178840eb79abdd54104be626a3340c49a0a5081a585c6886199106de0211cfde1da492536029fb730984b200ec97eea4ebf1a9893db1488e77f8490d50527517e08dc6678bc78c21ead52e1aadad8f04acfeedffb29c3e8b955af..., FrameType=04)
2022-01-09 16:20:35 DEBUG (MainThread) [pyatv.protocols.companion.connection] Received data (Data=0400004ce1435f706491450601040440b3f7bc1927aaa96e599288c764487a74234c5b1e07384e76a7dc12467d9cd12098f05d6d9b50ec10e186632e4c6b3acc5af7118726d68d2fdbb0988520f8a9fe)
2022-01-09 16:20:35 DEBUG (MainThread) [pyatv.protocols.companion.protocol] Received frame FrameType.PS_Next: b"\xe1C_pd\x91E\x06\x01\x04\x04@\xb3\xf7\xbc\x19'\xaa\xa9nY\x92\x88\xc7dHzt#L[\x1e\x078Nv\xa7\xdc\x12F}\x9c\xd1 \x98\xf0]m\x9bP\xec\x10\xe1\x86c.Lk:\xccZ\xf7\x11\x87&\xd6\x8d/\xdb\xb0\x98\x85 \xf8\xa9\xfe"
2022-01-09 16:20:35 DEBUG (MainThread) [pyatv.protocols.companion.protocol] Process incoming auth frame (FrameType.PS_Next): {'_pd': b"\x06\x01\x04\x04@\xb3\xf7\xbc\x19'\xaa\xa9nY\x92\x88\xc7dHzt#L[\x1e\x078Nv\xa7\xdc\x12F}\x9c\xd1 \x98\xf0]m\x9bP\xec\x10\xe1\x86c.Lk:\xccZ\xf7\x11\x87&\xd6\x8d/\xdb\xb0\x98\x85 \xf8\xa9\xfe"}
2022-01-09 16:20:35 DEBUG (MainThread) [pyatv.protocols.companion.auth] Device (Proof=b3f7bc1927aaa96e599288c764487a74234c5b1e07384e76a7dc12467d9cd12098f05d6d9b50ec10e186632e4c6b3acc5af7118726d68d2fdbb0988520f8a9fe)
2022-01-09 16:20:35 DEBUG (MainThread) [pyatv.auth.hap_srp] Data (Encrypted=fd901f4dd600c315584030b93d8f1d48595fd927f9b3c1782f271ce6b902a9103e00b332a11029cb01ad67029c296fcef6670d685cf8776647855eab69f4900bc123f84b778e37869f6165916a9f8ecac669af175367174478e33ea79243c96683a4ad11e91672337b272fef928e1e18e246fcce2b962fb2d1e670011920eca55251289e62ee50ec9712ef7217107f47ce648904c9b7b5d45e717a170fb9f797ff6665ae6359c05ffc130b63659d3be8c07e44848c44884bc902f15378d6b6f8f93e409a60b27d55642d128b4f73e1588008abe77876556a4abd7e2ceabedfd32d1c0c8cca54415b0998db68c4f3970d4ffc2abcc58968f302dc4353311e8...)
2022-01-09 16:20:35 DEBUG (MainThread) [pyatv.protocols.companion.protocol] Exchange OPACK: {'_pd': b'\x06\x01\x05\x05\xff\xfd\x90\x1fM\xd6\x00\xc3\x15X@0\xb9=\x8f\x1dHY_\xd9\'\xf9\xb3\xc1x/\'\x1c\xe6\xb9\x02\xa9\x10>\x00\xb32\xa1\x10)\xcb\x01\xadg\x02\x9c)o\xce\xf6g\rh\\\xf8wfG\x85^\xabi\xf4\x90\x0b\xc1#\xf8Kw\x8e7\x86\x9fae\x91j\x9f\x8e\xca\xc6i\xaf\x17Sg\x17Dx\xe3>\xa7\x92C\xc9f\x83\xa4\xad\x11\xe9\x16r3{\'/\xef\x92\x8e\x1e\x18\xe2F\xfc\xce+\x96/\xb2\xd1\xe6p\x01\x19 \xec\xa5RQ(\x9eb\xeeP\xec\x97\x12\xefr\x17\x10\x7fG\xced\x89\x04\xc9\xb7\xb5\xd4^qz\x17\x0f\xb9\xf7\x97\xfffe\xaecY\xc0_\xfc\x13\x0bce\x9d;\xe8\xc0~D\x84\x8cD\x88K\xc9\x02\xf1Sx\xd6\xb6\xf8\xf9>@\x9a`\xb2}Ud-\x12\x8bOs\xe1X\x80\x08\xab\xe7xvUjJ\xbd~,\xea\xbe\xdf\xd3-\x1c\x0c\x8c\xcaTA[\t\x98\xdbh\xc4\xf3\x97\rO\xfc*\xbc\xc5\x89h\xf3\x02\xdcCS1\x1e\x85\x05"\x80\xab}\xa6z\xc6g\x10\x9e)\xc1\x1eF\xfc\r`q%\x89\x94\xb4<]\x0b\x10\xf1\xdb$\xc3\xceC\xda\x988', '_pwTy': 1}
2022-01-09 16:20:35 DEBUG (MainThread) [pyatv.protocols.companion.protocol] Send OPACK: {'_pd': b'\x06\x01\x05\x05\xff\xfd\x90\x1fM\xd6\x00\xc3\x15X@0\xb9=\x8f\x1dHY_\xd9\'\xf9\xb3\xc1x/\'\x1c\xe6\xb9\x02\xa9\x10>\x00\xb32\xa1\x10)\xcb\x01\xadg\x02\x9c)o\xce\xf6g\rh\\\xf8wfG\x85^\xabi\xf4\x90\x0b\xc1#\xf8Kw\x8e7\x86\x9fae\x91j\x9f\x8e\xca\xc6i\xaf\x17Sg\x17Dx\xe3>\xa7\x92C\xc9f\x83\xa4\xad\x11\xe9\x16r3{\'/\xef\x92\x8e\x1e\x18\xe2F\xfc\xce+\x96/\xb2\xd1\xe6p\x01\x19 \xec\xa5RQ(\x9eb\xeeP\xec\x97\x12\xefr\x17\x10\x7fG\xced\x89\x04\xc9\xb7\xb5\xd4^qz\x17\x0f\xb9\xf7\x97\xfffe\xaecY\xc0_\xfc\x13\x0bce\x9d;\xe8\xc0~D\x84\x8cD\x88K\xc9\x02\xf1Sx\xd6\xb6\xf8\xf9>@\x9a`\xb2}Ud-\x12\x8bOs\xe1X\x80\x08\xab\xe7xvUjJ\xbd~,\xea\xbe\xdf\xd3-\x1c\x0c\x8c\xcaTA[\t\x98\xdbh\xc4\xf3\x97\rO\xfc*\xbc\xc5\x89h\xf3\x02\xdcCS1\x1e\x85\x05"\x80\xab}\xa6z\xc6g\x10\x9e)\xc1\x1eF\xfc\r`q%\x89\x94\xb4<]\x0b\x10\xf1\xdb$\xc3\xceC\xda\x988', '_pwTy': 1, '_x': 48238}
2022-01-09 16:20:35 DEBUG (MainThread) [pyatv.protocols.companion.connection] >> Send data (Data=e3435f706492280106010505fffd901f4dd600c315584030b93d8f1d48595fd927f9b3c1782f271ce6b902a9103e00b332a11029cb01ad67029c296fcef6670d685cf8776647855eab69f4900bc123f84b778e37869f6165916a9f8ecac669af175367174478e33ea79243c96683a4ad11e91672337b272fef928e1e18e246fcce2b962fb2d1e670011920eca55251289e62ee50ec9712ef7217107f47ce648904c9b7b5d45e717a170fb9f797ff6665ae6359c05ffc130b63659d3be8c07e44848c44884bc902f15378d6b6f8f93e409a60b27d55642d128b4f73e1588008abe77876556a4abd7e2ceabedfd32d1c0c8cca54415b0998db68c4f3970d4ff..., FrameType=04)
2022-01-09 16:20:35 DEBUG (MainThread) [pyatv.protocols.companion.connection] Received data (Data=04000130e1435f706492280105ff41b62aae418081da1828947617affd128d4485154bdb27a95ce6a9cfcbcb1bfb8c4c4e943a01909ca69d0240060a76d8348c796b92619ffbc23c8964792233ae0875c94f7425a9501dcea5b7219f71f322fda0751d021553ced09349ae230bc3274820ee322b15cf8b41e9eb021e904777c91fb8ef31eaa82e4f64fc6510d6ae1ed78d62b1bc49f54590e9724b76b154843fce4b2d4a2d1d97be4c8412cb6c21a5f044e2c76cc385f07e4f97cc9dda13d250ef33367ae5c28231e0368fc7aa36ae6dc20adf8e58547b161346bd9b2dd29e227cc3481175677477aec5c515e4e8841728d4e7a98bd3bd3e8aaf1ffe3bb2c...)
2022-01-09 16:20:35 DEBUG (MainThread) [pyatv.protocols.companion.protocol] Received frame FrameType.PS_Next: b'\xe1C_pd\x92(\x01\x05\xffA\xb6*\xaeA\x80\x81\xda\x18(\x94v\x17\xaf\xfd\x12\x8dD\x85\x15K\xdb\'\xa9\\\xe6\xa9\xcf\xcb\xcb\x1b\xfb\x8cLN\x94:\x01\x90\x9c\xa6\x9d\x02@\x06\nv\xd84\x8cyk\x92a\x9f\xfb\xc2<\x89dy"3\xae\x08u\xc9Ot%\xa9P\x1d\xce\xa5\xb7!\x9fq\xf3"\xfd\xa0u\x1d\x02\x15S\xce\xd0\x93I\xae#\x0b\xc3\'H \xee2+\x15\xcf\x8bA\xe9\xeb\x02\x1e\x90Gw\xc9\x1f\xb8\xef1\xea\xa8.Od\xfce\x10\xd6\xae\x1e\xd7\x8db\xb1\xbcI\xf5E\x90\xe9rKv\xb1T\x84?\xceK-J-\x1d\x97\xbeL\x84\x12\xcbl!\xa5\xf0D\xe2\xc7l\xc3\x85\xf0~O\x97\xcc\x9d\xda\x13\xd2P\xef36z\xe5\xc2\x821\xe06\x8f\xc7\xaa6\xaem\xc2\n\xdf\x8eXT{\x16\x13F\xbd\x9b-\xd2\x9e"|\xc3H\x11ugtw\xae\xc5\xc5\x15\xe4\xe8\x84\x17(\xd4\xe7\xa9\x8b\xd3\xbd>\x8a\xaf\x1f\xfe;\xb2\xceVD\xc9\xe7\xdc\xad\xd5#\xa8K\x83T7\xaf\x05"7>\xa1O=\xc6\xe7\x07\xb4\xbfQ\xae\xfe\xeb(\xb6\xf6*\xac\x8d\x90\xc6!\xf4\x19R\x83\xb7[jU\rJ}\x06\x01\x06'
2022-01-09 16:20:35 DEBUG (MainThread) [pyatv.protocols.companion.protocol] Process incoming auth frame (FrameType.PS_Next): {'_pd': b'\x05\xffA\xb6*\xaeA\x80\x81\xda\x18(\x94v\x17\xaf\xfd\x12\x8dD\x85\x15K\xdb\'\xa9\\\xe6\xa9\xcf\xcb\xcb\x1b\xfb\x8cLN\x94:\x01\x90\x9c\xa6\x9d\x02@\x06\nv\xd84\x8cyk\x92a\x9f\xfb\xc2<\x89dy"3\xae\x08u\xc9Ot%\xa9P\x1d\xce\xa5\xb7!\x9fq\xf3"\xfd\xa0u\x1d\x02\x15S\xce\xd0\x93I\xae#\x0b\xc3\'H \xee2+\x15\xcf\x8bA\xe9\xeb\x02\x1e\x90Gw\xc9\x1f\xb8\xef1\xea\xa8.Od\xfce\x10\xd6\xae\x1e\xd7\x8db\xb1\xbcI\xf5E\x90\xe9rKv\xb1T\x84?\xceK-J-\x1d\x97\xbeL\x84\x12\xcbl!\xa5\xf0D\xe2\xc7l\xc3\x85\xf0~O\x97\xcc\x9d\xda\x13\xd2P\xef36z\xe5\xc2\x821\xe06\x8f\xc7\xaa6\xaem\xc2\n\xdf\x8eXT{\x16\x13F\xbd\x9b-\xd2\x9e"|\xc3H\x11ugtw\xae\xc5\xc5\x15\xe4\xe8\x84\x17(\xd4\xe7\xa9\x8b\xd3\xbd>\x8a\xaf\x1f\xfe;\xb2\xceVD\xc9\xe7\xdc\xad\xd5#\xa8K\x83T7\xaf\x05"7>\xa1O=\xc6\xe7\x07\xb4\xbfQ\xae\xfe\xeb(\xb6\xf6*\xac\x8d\x90\xc6!\xf4\x19R\x83\xb7[jU\rJ}\x06\x01\x06'}
2022-01-09 16:20:35 DEBUG (MainThread) [pyatv.auth.hap_srp] PS-Msg06: {1: b'F8CB7428-8D89-4E88-928B-F7E3550A394F', 3: b'\xf4_\x06\xc4\xfa\x0b\xec?\xaa+\xc0>~U\x92|\x9d\x8f"\n\xf0\x99[\x0e\x18c4\xa4\x9b\xb8\'Z', 10: b"\xa8\xf4,\x1b\xff\xaaYc\x86\xff\x97\x8c\xc1\x05r\xa6=\xd1|\x15\xb6\x1dH\xe2\xab\x88'mBl\xdd\x13M\xd7=\xb3\xdauX\xe8\x02da|-\xed\x98\xf3\x8cMO\n=y\x03Id\xd9i\x0fL\xcb\x15\x0c", 17: b'\xe6FaltIRK\x80\xe1\x96\x907\x0c\x02\xa3D\x08Z9z-\xa9/\xa5IaccountIDa$F8CB7428-8D89-4E88-928B-F7E3550A394FEmodelJAppleTV6,2GwifiMACv\xd0\xd2\xb0\xa4\x14\xd7DnameKLiving RoomCmacv\xd0\xd2\xb0\xa6\xd1\x83'}
2022-01-09 16:20:35 DEBUG (MainThread) [pyatv.auth.hap_srp] Device (Identifier=46384342373432382d384438392d344538382d393238422d463745333535304133393446, Public=f45f06c4fa0bec3faa2bc03e7e55927c9d8f220af0995b0e186334a49bb8275a, Signature=a8f42c1bffaa596386ff978cc10572a63dd17c15b61d48e2ab88276d426cdd134dd73db3da7558e80264617c2ded98f38c4d4f0a3d79034964d9690f4ccb150c)
2022-01-09 16:20:35 DEBUG (MainThread) [pyatv.protocols.companion.connection] Closing connection
2022-01-09 16:20:35 DEBUG (MainThread) [pyatv.protocols.companion.connection] Connection lost to remote device: None
2022-01-09 16:20:35 DEBUG (MainThread) [pyatv.support.http] Connected to 192.168.1.7
2022-01-09 16:20:35 DEBUG (MainThread) [pyatv.protocols.airplay.auth] Setting up new AirPlay Pair-Setup procedure with type AuthenticationType.HAP
2022-01-09 16:20:35 DEBUG (MainThread) [pyatv.support.http] Sending HTTP/1.1 message: b'POST /pair-pin-start HTTP/1.1\r\nUser-Agent: AirPlay/320.20\r\nConnection: keep-alive\r\nX-Apple-HKP: 3\r\nContent-Type: application/octet-stream\r\n\r\n'
2022-01-09 16:20:35 DEBUG (MainThread) [pyatv.support.http] Received: b'HTTP/1.1 200 OK\r\nDate: Sun, 09 Jan 2022 16:20:35 GMT\r\nContent-Length: 0\r\nServer: AirTunes/600.8.41\r\n\r\n'
2022-01-09 16:20:35 DEBUG (MainThread) [pyatv.support.http] Got HTTP response: HttpResponse(protocol='HTTP', version='1.1', code=200, message='OK', headers={'date': 'Sun, 09 Jan 2022 16:20:35 GMT', 'content-length': '0', 'server': 'AirTunes/600.8.41'}, body=''):
2022-01-09 16:20:35 DEBUG (MainThread) [pyatv.support.http] Sending HTTP/1.1 message: b'POST /pair-setup HTTP/1.1\r\nContent-Length: 6\r\nUser-Agent: AirPlay/320.20\r\nConnection: keep-alive\r\nX-Apple-HKP: 3\r\nContent-Type: application/octet-stream\r\n\r\n\x00\x01\x00\x06\x01\x01'
2022-01-09 16:20:35 DEBUG (MainThread) [pyatv.support.http] Received: b'HTTP/1.1 200 OK\r\nDate: Sun, 09 Jan 2022 16:20:35 GMT\r\nContent-Length: 409\r\nContent-Type: application/x-apple-binary-plist\r\nServer: AirTunes/600.8.41\r\n\r\n\x06\x01\x02\x02\x10!WY\x17I"\x8fA\xdf)\xaa*\xd3\x9cF\xc4\x03\xff\x9c \xe0U\x1b\xb5\xb6\xf8\'\x18\x83\x19\xda\x0bA\xbeB]\x07\nK\x00c\xfc?\x10\x1a\x9e\xcd\xb7\xc0\xa9\x9ari\x91\xc7=\xf2/y\xd2\x8cv\xc5N\x00\'\xa2\xe1[1!vk\x07*\x96B.\xd5\x0f\xcf\x91\xce\xa8L\xda[[\xbb\xa4\x12\x01\x97\xb7\xc5z\x03&\xfc\r)\x8b\rq+\xd6\xc7\xf9\x8ayM\x13\x88\xa7l\xcc\xd3\xa7ya\xa36X\xa0{\x9f\xc32%E\x92\x1cc\xc0g\x9bm\x9em\xde\x94\xae\xa0z\x9c\xcf\xa4WC$\xd3B\x9f\x19\x86\xd8H\xbe\xa8\xc5\xf4\x87\xb8\xc5{a\xbe\x88\xfb X(\xe5\xc1\xc6\x0e\xc9\xdd\xe0\xd6%\xfc(+\xf5\xe5&\x9a@^.\x95~v$\x19\xf5\xdd\x01\xf1\xdc\x88Q\x85H\xd0\x95\x1a/X^\xbf\x1e\xc3\x9b\x81\x8bKhU\xa0\\\xb6T\xb6n\x19\x9eB\x8d\xe5\x9e\x95{U\xf77d\xcc6\r#\xf4\xad.F\xb5\xc3\xdfOq\x0en/8\x8a1\xc2\x97\xbf\xad\x02\x99\xc1\x1c8F\xd4\x07\xa5\xbaYQ\x03\x81>hu\xe7\x02\x01\xcc/i\x8a\x87\xba\xa2\xb9\x92\x1cM\x1c\xc0dHh\x1d)\xa8\x11\x87\xaa-\xe3G\x0e4\xa76z\xab}\xccC\x88\xf6\xb5YZ\x1f\x13\xc8\x8c\x962r\x8b;\xbe2j\x96\xbe\xe0\xe4V:\xcb\x98\x82\xa7\x15\x19\x99\xec\x13\xddF\xacd\xc8\xec\xa7\x1f!\x95\x0eCF\x97-\xc7\xb7c\xab\x81P\xd7\xa0cm\xcb$\xbc\x8b\xa8\xbf,\xbc\xec\x84\xfc#\xd3\xd6\x9dp$K\xcae\'\xdfK\x1df\x05\xe5zD\xf4\xdb\x15'
2022-01-09 16:20:35 DEBUG (MainThread) [pyatv.support.http] Got HTTP response: HttpResponse(protocol='HTTP', version='1.1', code=200, message='OK', headers={'date': 'Sun, 09 Jan 2022 16:20:35 GMT', 'content-length': '409', 'content-type': 'application/x-apple-binary-plist', 'server': 'AirTunes/600.8.41'}, body=b'\x06\x01\x02\x02\x10!WY\x17I"\x8fA\xdf)\xaa*\xd3\x9cF\xc4\x03\xff\x9c \xe0U\x1b\xb5\xb6\xf8\'\x18\x83\x19\xda\x0bA\xbeB]\x07\nK\x00c\xfc?\x10\x1a\x9e\xcd\xb7\xc0\xa9\x9ari\x91\xc7=\xf2/y\xd2\x8cv\xc5N\x00\'\xa2\xe1[1!vk\x07*\x96B.\xd5\x0f\xcf\x91\xce\xa8L\xda[[\xbb\xa4\x12\x01\x97\xb7\xc5z\x03&\xfc\r)\x8b\rq+\xd6\xc7\xf9\x8ayM\x13\x88\xa7l\xcc\xd3\xa7ya\xa36X\xa0{\x9f\xc32%E\x92\x1cc\xc0g\x9bm\x9em\xde\x94\xae\xa0z\x9c\xcf\xa4WC$\xd3B\x9f\x19\x86\xd8H\xbe\xa8\xc5\xf4\x87\xb8\xc5{a\xbe\x88\xfb X(\xe5\xc1\xc6\x0e\xc9\xdd\xe0\xd6%\xfc(+\xf5\xe5&\x9a@^.\x95~v$\x19\xf5\xdd\x01\xf1\xdc\x88Q\x85H\xd0\x95\x1a/X^\xbf\x1e\xc3\x9b\x81\x8bKhU\xa0\\\xb6T\xb6n\x19\x9eB\x8d\xe5\x9e\x95{U\xf77d\xcc6\r#\xf4\xad.F\xb5\xc3\xdfOq\x0en/8\x8a1\xc2\x97\xbf\xad\x02\x99\xc1\x1c8F\xd4\x07\xa5\xbaYQ\x03\x81>hu\xe7\x02\x01\xcc/i\x8a\x87\xba\xa2\xb9\x92\x1cM\x1c\xc0dHh\x1d)\xa8\x11\x87\xaa-\xe3G\x0e4\xa76z\xab}\xccC\x88\xf6\xb5YZ\x1f\x13\xc8\x8c\x962r\x8b;\xbe2j\x96\xbe\xe0\xe4V:\xcb\x98\x82\xa7\x15\x19\x99\xec\x13\xddF\xacd\xc8\xec\xa7\x1f!\x95\x0eCF\x97-\xc7\xb7c\xab\x81P\xd7\xa0cm\xcb$\xbc\x8b\xa8\xbf,\xbc\xec\x84\xfc#\xd3\xd6\x9dp$K\xcae\'\xdfK\x1df\x05\xe5zD\xf4\xdb\x15'):
2022-01-09 16:20:37 DEBUG (MainThread) [pyatv.protocols.airplay.pairing] AirPlay PIN changed to 9415
2022-01-09 16:20:38 DEBUG (MainThread) [pyatv.auth.hap_srp] Client (Proof=44ebfb6df7159319abc0f67b54eb8b8a3be3e1d77b98b548ffcedc8c156eb1859f7b59161078cb0237acb8fb9f827ef67ca2960bfce2283443b39155c49dc26a, Public=466c78cecaf41ed6722b7c30a1ac6d4ab02de324b7087169b364ce8bbf48712a3a8fb22f01ba7122400fbc4653c8a622a5c6c9b82fddaffc18731389e12a22f464d218dd5e98cf57761d5edc187df1195db4a224c5ba3eff399cac46966f6ad3bddef799f92b0c5a135e5dcbfd628500529f21fdd35ae3e25397c0214e666719a1f394ae4f48f0e80abfb8adc1649093d0f6d7ec3d27f57137fd9dc03bfa79336f294407b5fa960b96852d10ed9ef97cabd6466f91b4c400e3ec2905db557ed0b373f0aedc7589c60cb2cc1ab02e5bc13bc9ad883385031b3040ed509a005e62f20770c67d7784d5ca5cbf7045aaf58de50b854a1587d50aa3663e8400e82...)
2022-01-09 16:20:38 DEBUG (MainThread) [pyatv.support.http] Sending HTTP/1.1 message: b'POST /pair-setup HTTP/1.1\r\nContent-Length: 457\r\nUser-Agent: AirPlay/320.20\r\nConnection: keep-alive\r\nX-Apple-HKP: 3\r\nContent-Type: application/octet-stream\r\n\r\n\x06\x01\x03\x03\xffFlx\xce\xca\xf4\x1e\xd6r+|0\xa1\xacmJ\xb0-\xe3$\xb7\x08qi\xb3d\xce\x8b\xbfHq*:\x8f\xb2/\x01\xbaq"@\x0f\xbcFS\xc8\xa6"\xa5\xc6\xc9\xb8/\xdd\xaf\xfc\x18s\x13\x89\xe1*"\xf4d\xd2\x18\xdd^\x98\xcfWv\x1d^\xdc\x18}\xf1\x19]\xb4\xa2$\xc5\xba>\xff9\x9c\xacF\x96oj\xd3\xbd\xde\xf7\x99\xf9+\x0cZ\x13^]\xcb\xfdb\x85\x00R\x9f!\xfd\xd3Z\xe3\xe2S\x97\xc0!Nfg\x19\xa1\xf3\x94\xaeOH\xf0\xe8\n\xbf\xb8\xad\xc1d\x90\x93\xd0\xf6\xd7\xec=\'\xf5q7\xfd\x9d\xc0;\xfay3o)D\x07\xb5\xfa\x96\x0b\x96\x85-\x10\xed\x9e\xf9|\xab\xd6Fo\x91\xb4\xc4\x00\xe3\xec)\x05\xdbU~\xd0\xb3s\xf0\xae\xdcu\x89\xc6\x0c\xb2\xcc\x1a\xb0.[\xc1;\xc9\xad\x883\x85\x03\x1b0@\xedP\x9a\x00^b\xf2\x07p\xc6}w\x84\xd5\xca\\\xbfpE\xaa\xf5\x8d\xe5\x0b\x85J\x15\x87\xd5\n\xa3f>\x84\x00\xe8.\x03\x81\xcewK\xdf\x808.\xab\xd5-\xe9Vwe\x13J\xa3\xaf\x99\xf4\xd4s\xdf\xc8\xc1\xbd\x12\x17N\x06\x0c\x9e\x14\xa6\xe6n\x04\xf3\xf0b\xba+\x07\xfa\xefM\xf7o\x0fx\x10g\xb4\x95f5\x19\xfe\xf5\xca>\xe6\xbb\xbeGz\xea\xd2\x89\xe1R\rV\xdb]\x97\x92\xb7\x06V&"\x92\xb1\x01\x87L\x92\xca\x0f\x84\xa7\xfb<\xf57iV-\xd2\xd1\xf7\xb3\x98\xcf\x8b-zd\x8e\xb0\x10\xe1\xdd\x1c\xcc\x99;\xfe\xf4o\xbf\xbai\xdc\x11Hz`\x04@D\xeb\xfbm\xf7\x15\x93\x19\xab\xc0\xf6{T\xeb\x8b\x8a;\xe3\xe1\xd7{\x98\xb5H\xff\xce\xdc\x8c\x15n\xb1\x85\x9f{Y\x16\x10x\xcb\x027\xac\xb8\xfb\x9f\x82~\xf6|\xa2\x96\x0b\xfc\xe2(4C\xb3\x91U\xc4\x9d\xc2j'
2022-01-09 16:20:38 DEBUG (MainThread) [pyatv.support.http] Received: b'HTTP/1.1 200 OK\r\nDate: Sun, 09 Jan 2022 16:20:38 GMT\r\nContent-Length: 69\r\nContent-Type: application/x-apple-binary-plist\r\nServer: AirTunes/600.8.41\r\n\r\n\x06\x01\x04\x04@\x08\x99\xbd\xd9jUv\xfc\xe3\xb9t@U\x90\x13\xbf9\x9c\xbaN\xac\x1b\x9c\xe2\xfb`\x05\xb2N\x0f\x17Vj\x05\xc9i\xc6\xdc\x8b\xce\xb6c\x1c*\xa7\x99Q\xc53\xe6\x88\xb7~E\x05\xb8\xbb\xe7\xc0:f\x0f\xb74'
2022-01-09 16:20:38 DEBUG (MainThread) [pyatv.support.http] Got HTTP response: HttpResponse(protocol='HTTP', version='1.1', code=200, message='OK', headers={'date': 'Sun, 09 Jan 2022 16:20:38 GMT', 'content-length': '69', 'content-type': 'application/x-apple-binary-plist', 'server': 'AirTunes/600.8.41'}, body=b'\x06\x01\x04\x04@\x08\x99\xbd\xd9jUv\xfc\xe3\xb9t@U\x90\x13\xbf9\x9c\xbaN\xac\x1b\x9c\xe2\xfb`\x05\xb2N\x0f\x17Vj\x05\xc9i\xc6\xdc\x8b\xce\xb6c\x1c*\xa7\x99Q\xc53\xe6\x88\xb7~E\x05\xb8\xbb\xe7\xc0:f\x0f\xb74'):
2022-01-09 16:20:38 DEBUG (MainThread) [pyatv.auth.hap_srp] Data (Encrypted=2398a00d48c57156d291598c16cd793c70a022dd95caf88c5032ac9157508b7b6773b879f94eb9bf86d9f8cf01b62a4b13eefac0deb1835d0f3cb6238f97504c1dc4bb62ef76c5bab67c4de4531ad4ee11a23b73db725180736ea77cf66da9124dca6a7ee2ea0f5ec6005b396902994ee5fe9fd77aa1d374358d697e90fb7774c1c42cef7d17481ff0e130267928736996b0aefe380adca79aef)
2022-01-09 16:20:38 DEBUG (MainThread) [pyatv.support.http] Sending HTTP/1.1 message: b'POST /pair-setup HTTP/1.1\r\nContent-Length: 159\r\nUser-Agent: AirPlay/320.20\r\nConnection: keep-alive\r\nX-Apple-HKP: 3\r\nContent-Type: application/octet-stream\r\n\r\n\x06\x01\x05\x05\x9a#\x98\xa0\rH\xc5qV\xd2\x91Y\x8c\x16\xcdy<p\xa0"\xdd\x95\xca\xf8\x8cP2\xac\x91WP\x8b{gs\xb8y\xf9N\xb9\xbf\x86\xd9\xf8\xcf\x01\xb6*K\x13\xee\xfa\xc0\xde\xb1\x83]\x0f<\xb6#\x8f\x97PL\x1d\xc4\xbbb\xefv\xc5\xba\xb6|M\xe4S\x1a\xd4\xee\x11\xa2;s\xdbrQ\x80sn\xa7|\xf6m\xa9\x12M\xcaj~\xe2\xea\x0f^\xc6\x00[9i\x02\x99N\xe5\xfe\x9f\xd7z\xa1\xd3t5\x8di~\x90\xfbwt\xc1\xc4,\xef}\x17H\x1f\xf0\xe10&y(si\x96\xb0\xae\xfe8\n\xdc\xa7\x9a\xef'
2022-01-09 16:20:38 DEBUG (MainThread) [pyatv.support.http] Received: b'HTTP/1.1 200 OK\r\nDate: Sun, 09 Jan 2022 16:20:38 GMT\r\nContent-Length: 321\r\nContent-Type: application/x-apple-binary-plist\r\nServer: AirTunes/600.8.41\r\n\r\n\x05\xff\\}m\xa7\xd7O\xdf\x9aV\x00R\xc9\xcf\xc1:[/\xd8\xd0\xc5\x06YD\xb2\x17\xc9\x88\xf9\x9csW\xe3\xe4y\xf1:\x08#\xc3\xa1^,Yf\x9f_2j\xc9^3\xad5\xa6\x89\xc50!\x1cJ\xf6\xa6.\xca\x90\xa6\xed\xfe\xd4R\xdd\x8c\x9dB\xaa\xde\x12\x1a6\x01\xb2kq\xea^\xc8\x98W\xaa\x86\xd5\xda\x102\xb6(\xdd\xe9\xe5|X\r\xc3\xf3%\xef\xac\x9f\xa3\xd7\x8e\xe5:z\xafs\xf58\xaf4\xe2S&(}\xff\xe17\xbb8\xc6pg"\xfd\x88\xb8\x1cr\xcb\x8b\xa2\xbb\x1ae\xb6q\\\x05q\x99\xc18P\x1b\x92(\xa8\xf35\x8e\x9d.\xd6\x9cN\x08\xc5G\x9eB#\xaf>\\kA\x8ct\xb9\xdf\xd4\x15\xf8\xc7\x16T\xbc\x86\x86\xe7\x08\x04\xb3\xec\xe1\x9e\xcc=\xdd\xd1\x87\x0fS\x1f\x96\xcf}\x0c\xab\x84\xc2\xa8/F\'cf\xa0Q\x12\xd5\x9e\xf7\xecoB\xc7\xbaa\x16\xa5\x1a&\xcf\xecs\xfe\\\xd3\x1b\x90\x12\xb8\xc0\x95\xbf.\x15}\r\xa3\xaa\x06/\x05;[\xe6\xcfB\xe5j\xafo\xef\xcf(pq\xfai\x1f\xb0\t\xf0\xb7\x95\x04\xa1b\xe2\x15\x1b\x04\x82&EC\xc9\xc2^\xa5}\xaf\x07\xa3\xf3\xe9f\x92\xc5\x07`q\x98\x94\xb0\xba\xad\xed\x92a\x14\x94\x02\x06\x01\x06'
2022-01-09 16:20:38 DEBUG (MainThread) [pyatv.support.http] Got HTTP response: HttpResponse(protocol='HTTP', version='1.1', code=200, message='OK', headers={'date': 'Sun, 09 Jan 2022 16:20:38 GMT', 'content-length': '321', 'content-type': 'application/x-apple-binary-plist', 'server': 'AirTunes/600.8.41'}, body=b'\x05\xff\\}m\xa7\xd7O\xdf\x9aV\x00R\xc9\xcf\xc1:[/\xd8\xd0\xc5\x06YD\xb2\x17\xc9\x88\xf9\x9csW\xe3\xe4y\xf1:\x08#\xc3\xa1^,Yf\x9f_2j\xc9^3\xad5\xa6\x89\xc50!\x1cJ\xf6\xa6.\xca\x90\xa6\xed\xfe\xd4R\xdd\x8c\x9dB\xaa\xde\x12\x1a6\x01\xb2kq\xea^\xc8\x98W\xaa\x86\xd5\xda\x102\xb6(\xdd\xe9\xe5|X\r\xc3\xf3%\xef\xac\x9f\xa3\xd7\x8e\xe5:z\xafs\xf58\xaf4\xe2S&(}\xff\xe17\xbb8\xc6pg"\xfd\x88\xb8\x1cr\xcb\x8b\xa2\xbb\x1ae\xb6q\\\x05q\x99\xc18P\x1b\x92(\xa8\xf35\x8e\x9d.\xd6\x9cN\x08\xc5G\x9eB#\xaf>\\kA\x8ct\xb9\xdf\xd4\x15\xf8\xc7\x16T\xbc\x86\x86\xe7\x08\x04\xb3\xec\xe1\x9e\xcc=\xdd\xd1\x87\x0fS\x1f\x96\xcf}\x0c\xab\x84\xc2\xa8/F\'cf\xa0Q\x12\xd5\x9e\xf7\xecoB\xc7\xbaa\x16\xa5\x1a&\xcf\xecs\xfe\\\xd3\x1b\x90\x12\xb8\xc0\x95\xbf.\x15}\r\xa3\xaa\x06/\x05;[\xe6\xcfB\xe5j\xafo\xef\xcf(pq\xfai\x1f\xb0\t\xf0\xb7\x95\x04\xa1b\xe2\x15\x1b\x04\x82&EC\xc9\xc2^\xa5}\xaf\x07\xa3\xf3\xe9f\x92\xc5\x07`q\x98\x94\xb0\xba\xad\xed\x92a\x14\x94\x02\x06\x01\x06'):
2022-01-09 16:20:38 DEBUG (MainThread) [pyatv.auth.hap_srp] PS-Msg06: {1: b'F8CB7428-8D89-4E88-928B-F7E3550A394F', 3: b'\xf4_\x06\xc4\xfa\x0b\xec?\xaa+\xc0>~U\x92|\x9d\x8f"\n\xf0\x99[\x0e\x18c4\xa4\x9b\xb8\'Z', 10: b'\xfb \x07\x8c\xa6\x91u(r\xc4\xe4\x9a^f3?]:\x19kh\xf9W*\n\x83>I"c\x9f~\xc1\x0b\x94\xa8\xefA/\xea\x90e\xcdv,\x88.\x8f\xbbJ\xe0\x11r\x018\xa9\x8d\xb35\\g\x83\xbf\n', 17: b'\xe7FaltIRK\x80\xe1\x96\x907\x0c\x02\xa3D\x08Z9z-\xa9/\xa5FbtAddrQd0:d2:b0:a4:cf:64Cmacv\xd0\xd2\xb0\xa6\xd1\x83IaccountIDa$F8CB7428-8D89-4E88-928B-F7E3550A394FEmodelJAppleTV6,2GwifiMACv\xd0\xd2\xb0\xa4\x14\xd7DnameKLiving Room'}
2022-01-09 16:20:38 DEBUG (MainThread) [pyatv.auth.hap_srp] Device (Identifier=46384342373432382d384438392d344538382d393238422d463745333535304133393446, Public=f45f06c4fa0bec3faa2bc03e7e55927c9d8f220af0995b0e186334a49bb8275a, Signature=fb20078ca691752872c4e49a5e66333f5d3a196b68f9572a0a833e4922639f7ec10b94a8ef412fea9065cd762c882e8fbb4ae011720138a98db3355c6783bf0a)
2022-01-09 16:20:38 DEBUG (MainThread) [pyatv.support.http] Connection closed
2022-01-09 16:20:38 DEBUG (MainThread) [pyatv.support.http] Connected to 192.168.1.7
2022-01-09 16:20:38 DEBUG (MainThread) [pyatv.protocols.airplay.auth] Setting up new AirPlay Pair-Setup procedure with type AuthenticationType.Legacy
2022-01-09 16:20:38 DEBUG (MainThread) [pyatv.protocols.airplay.srp] Authentication keys (Private=535dca6eb2cbc74c64cb825a22eba060aff0132f76b5f23695cb9052e8f04796, Public=ba68d4056d1f1f3709c09d0683d881b0636e2e5e0644c2534c4386dc256eb7a1)
2022-01-09 16:20:38 DEBUG (MainThread) [pyatv.support.http] Sending HTTP/1.1 message: b'POST /pair-pin-start HTTP/1.1\r\nUser-Agent: AirPlay/320.20\r\nConnection: keep-alive\r\n\r\n'
2022-01-09 16:20:38 DEBUG (MainThread) [pyatv.support.http] Received: b'HTTP/1.1 200 OK\r\nDate: Sun, 09 Jan 2022 16:20:38 GMT\r\nContent-Length: 0\r\nServer: AirTunes/600.8.41\r\n\r\n'
2022-01-09 16:20:38 DEBUG (MainThread) [pyatv.support.http] Got HTTP response: HttpResponse(protocol='HTTP', version='1.1', code=200, message='OK', headers={'date': 'Sun, 09 Jan 2022 16:20:38 GMT', 'content-length': '0', 'server': 'AirTunes/600.8.41'}, body=''):
2022-01-09 16:20:41 DEBUG (MainThread) [pyatv.protocols.airplay.pairing] AirPlay PIN changed to 9143
2022-01-09 16:20:41 DEBUG (MainThread) [pyatv.support.http] Sending HTTP/1.1 message: b'POST /pair-setup-pin HTTP/1.1\r\nUser-Agent: pyatv/0.9.8\r\nContent-Length: 85\r\n\r\nbplist00\xd2\x01\x02\x03\x04VmethodTuserSpin_\x10\x104CA61100E64A6EB4\x08\r\x14\x19\x1d\x00\x00\x00\x00\x00\x00\x01\x01\x00\x00\x00\x00\x00\x00\x00\x05\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x000'
2022-01-09 16:20:41 DEBUG (MainThread) [pyatv.support.http] Received: b"HTTP/1.1 200 OK\r\nDate: Sun, 09 Jan 2022 16:20:41 GMT\r\nContent-Length: 342\r\nContent-Type: application/x-apple-binary-plist\r\nServer: AirTunes/600.8.41\r\n\r\nbplist00\xd2\x01\x02\x03\x04RpkTsaltO\x11\x01\x00 }\x14\xc2\xf6\xf7\xa1\x99a\xee\xb5\x0b\xf0\x83o\x81/\xaf\x88\xbb\x93\x8e\xa8\x12p\xc7U)\xd0\xf9\x98\x17\x93\xe1\x91b\x13\x05\x99\x94\xfc\xbdy\x8bC\x9d\xcbr\xc3Q\xe2j\x8a\x98\xc4\tg X\xa6\xc5\n\x03t\x12\x10\xb7T*\x95z)\x90nL+$s\xe3\x92\x03'\xde\x02\x02\xc3\xa443\x99x\xe8\x00\x06T\x87\xbefjR/\xdf\xfe\xaa\xfc\xa9H\xc8\xd1g\x04\r%\r\x19\xba\xaf\xf6\xb4p\x8b\x1eA\xd2\xb5\r\x07z3\x0e\x16\x0e\x08\xa5\x0b\xf8F\xfc\xc4*\x95\x15B%\xe2\xbd\xf2\xd6\xe1\xe9\xc2`\x9a\x11q\xee\xb0\xb6}\x92E\xe1\xf0\xc1\xecR\x19\xb4\x1d\xe7\xcb\x1b\xb0\xdc]J\xe8\xc5\xe3\x0b~\xd8&\x87@\xbe\x1d9\x92\x8a4\xec\xce\xadS\xc1E<\xf3\xb5z\x0b\th\xbf\xd6\x9cf\xf3\xd6\xb0V\xfb\xb4\xb1$\x84\x9b7*\x01\xa0J\xebK$\xce\xedR\xee\x1c\x06:\xcf\x90\x8fL8F\xdc2b\x89=\xfc\xdf|0\xa2\xf2\xe3\xd5,<\x95aO\x10\x10\xa4n\xd49\xb4/\xe4\xea\x0e\x1a\xc2\xcd0&S\t\x00\x08\x00\r\x00\x10\x00\x15\x01\x19\x00\x00\x00\x00\x00\x00\x02\x01\x00\x00\x00\x00\x00\x00\x00\x05\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x01,"
2022-01-09 16:20:41 DEBUG (MainThread) [pyatv.support.http] Got HTTP response: HttpResponse(protocol='HTTP', version='1.1', code=200, message='OK', headers={'date': 'Sun, 09 Jan 2022 16:20:41 GMT', 'content-length': '342', 'content-type': 'application/x-apple-binary-plist', 'server': 'AirTunes/600.8.41'}, body=b"bplist00\xd2\x01\x02\x03\x04RpkTsaltO\x11\x01\x00 }\x14\xc2\xf6\xf7\xa1\x99a\xee\xb5\x0b\xf0\x83o\x81/\xaf\x88\xbb\x93\x8e\xa8\x12p\xc7U)\xd0\xf9\x98\x17\x93\xe1\x91b\x13\x05\x99\x94\xfc\xbdy\x8bC\x9d\xcbr\xc3Q\xe2j\x8a\x98\xc4\tg X\xa6\xc5\n\x03t\x12\x10\xb7T*\x95z)\x90nL+$s\xe3\x92\x03'\xde\x02\x02\xc3\xa443\x99x\xe8\x00\x06T\x87\xbefjR/\xdf\xfe\xaa\xfc\xa9H\xc8\xd1g\x04\r%\r\x19\xba\xaf\xf6\xb4p\x8b\x1eA\xd2\xb5\r\x07z3\x0e\x16\x0e\x08\xa5\x0b\xf8F\xfc\xc4*\x95\x15B%\xe2\xbd\xf2\xd6\xe1\xe9\xc2`\x9a\x11q\xee\xb0\xb6}\x92E\xe1\xf0\xc1\xecR\x19\xb4\x1d\xe7\xcb\x1b\xb0\xdc]J\xe8\xc5\xe3\x0b~\xd8&\x87@\xbe\x1d9\x92\x8a4\xec\xce\xadS\xc1E<\xf3\xb5z\x0b\th\xbf\xd6\x9cf\xf3\xd6\xb0V\xfb\xb4\xb1$\x84\x9b7*\x01\xa0J\xebK$\xce\xedR\xee\x1c\x06:\xcf\x90\x8fL8F\xdc2b\x89=\xfc\xdf|0\xa2\xf2\xe3\xd5,<\x95aO\x10\x10\xa4n\xd49\xb4/\xe4\xea\x0e\x1a\xc2\xcd0&S\t\x00\x08\x00\r\x00\x10\x00\x15\x01\x19\x00\x00\x00\x00\x00\x00\x02\x01\x00\x00\x00\x00\x00\x00\x00\x05\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x01,"):
2022-01-09 16:20:41 DEBUG (MainThread) [pyatv.protocols.airplay.srp] Client session key: b'698844455de35c1c3d12dc6b012051663dda9287375028d1e21faccdbc6cae615ce9105bbb946fc0'
2022-01-09 16:20:41 DEBUG (MainThread) [pyatv.protocols.airplay.srp] Client public: 0e0e974391541f7aab1cb2bf5f0baa3dfe1adcedba1f14fb4b7933a6e5be1aa19400b8c142163c62f0b214eafd79d631db1ae19b3bf6d3824396f58e883a8223809dd78dd6903929773319ee6c5535b0df8d5e32156e0b7a2ec4fae61d6a8b6ba817403c0d3a888c92b8afb621a2298db6d54497539f48e92788485369506cbafb8ab2fe8ec2f97e64f481929d4428760bcfcb294c2bfc2dad7e17d78a64ef875de4e328a76f0a5ffe2e8a91d96810dd0b8a681cda594e1c1123859b69a65bb95407c40adefe14f78c7a76b88dc9aab90be89ab48a8208ad24ba2846598a55b5ba0730aecaa350d2897f3eca461ee09881530abbc28a6592ee9b9619a857d5ae, proof: b'b0e27c4e8aeac70dd1df60306809b5fb73131ae5'
2022-01-09 16:20:41 DEBUG (MainThread) [pyatv.support.http] Sending HTTP/1.1 message: b"POST /pair-setup-pin HTTP/1.1\r\nUser-Agent: pyatv/0.9.8\r\nContent-Length: 347\r\n\r\nbplist00\xd2\x01\x02\x03\x04RpkUproofO\x11\x01\x00\x0e\x0e\x97C\x91T\x1fz\xab\x1c\xb2\xbf_\x0b\xaa=\xfe\x1a\xdc\xed\xba\x1f\x14\xfbKy3\xa6\xe5\xbe\x1a\xa1\x94\x00\xb8\xc1B\x16<b\xf0\xb2\x14\xea\xfdy\xd61\xdb\x1a\xe1\x9b;\xf6\xd3\x82C\x96\xf5\x8e\x88:\x82#\x80\x9d\xd7\x8d\xd6\x909)w3\x19\xeelU5\xb0\xdf\x8d^2\x15n\x0bz.\xc4\xfa\xe6\x1dj\x8bk\xa8\x17@<\r:\x88\x8c\x92\xb8\xaf\xb6!\xa2)\x8d\xb6\xd5D\x97S\x9fH\xe9'\x88HSiPl\xba\xfb\x8a\xb2\xfe\x8e\xc2\xf9~d\xf4\x81\x92\x9dD(v\x0b\xcf\xcb)L+\xfc-\xad~\x17\xd7\x8ad\xef\x87]\xe4\xe3(\xa7o\n_\xfe.\x8a\x91\xd9h\x10\xdd\x0b\x8ah\x1c\xdaYN\x1c\x11#\x85\x9bi\xa6[\xb9T\x07\xc4\n\xde\xfe\x14\xf7\x8czv\xb8\x8d\xc9\xaa\xb9\x0b\xe8\x9a\xb4\x8a\x82\x08\xad$\xba(FY\x8aU\xb5\xba\x070\xae\xca\xa3P\xd2\x89\x7f>\xcaF\x1e\xe0\x98\x81S\n\xbb\xc2\x8ae\x92\xee\x9b\x96\x19\xa8W\xd5\xaeO\x10\x14\xb0\xe2|N\x8a\xea\xc7\r\xd1\xdf`0h\t\xb5\xfbs\x13\x1a\xe5\x00\x08\x00\r\x00\x10\x00\x16\x01\x1a\x00\x00\x00\x00\x00\x00\x02\x01\x00\x00\x00\x00\x00\x00\x00\x05\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x011"
2022-01-09 16:20:41 DEBUG (MainThread) [pyatv.support.http] Received: b'HTTP/1.1 200 OK\r\nDate: Sun, 09 Jan 2022 16:20:41 GMT\r\nContent-Length: 75\r\nContent-Type: application/x-apple-binary-plist\r\nServer: AirTunes/600.8.41\r\n\r\nbplist00\xd1\x01\x02UproofO\x10\x14m\x84\xc1\xc94^\xb0I\x01\xe2\xc9\x0e|O\x87g\xd0/\x19\x88\x08\x0b\x11\x00\x00\x00\x00\x00\x00\x01\x01\x00\x00\x00\x00\x00\x00\x00\x03\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00('
2022-01-09 16:20:41 DEBUG (MainThread) [pyatv.support.http] Got HTTP response: HttpResponse(protocol='HTTP', version='1.1', code=200, message='OK', headers={'date': 'Sun, 09 Jan 2022 16:20:41 GMT', 'content-length': '75', 'content-type': 'application/x-apple-binary-plist', 'server': 'AirTunes/600.8.41'}, body=b'bplist00\xd1\x01\x02UproofO\x10\x14m\x84\xc1\xc94^\xb0I\x01\xe2\xc9\x0e|O\x87g\xd0/\x19\x88\x08\x0b\x11\x00\x00\x00\x00\x00\x00\x01\x01\x00\x00\x00\x00\x00\x00\x00\x03\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00('):
2022-01-09 16:20:41 DEBUG (MainThread) [pyatv.protocols.airplay.srp] Increase last byte from 43 to 44
2022-01-09 16:20:41 DEBUG (MainThread) [pyatv.protocols.airplay.srp] Pair-Setup-AES (IV=24dfa833a8f22fb6f0316c5652aa4d2c, Key=e0b3ef2d7701c85502294bce25a40173)
2022-01-09 16:20:41 DEBUG (MainThread) [pyatv.protocols.airplay.srp] Pair-Setup EPK+Tag (EPK=814bb945c13acbcad46c17a64a3cc033a77458b772ae11a58444499a66dec19d, Tag=3d3e44e77bc2623f52cea5ddd6c9fc8f)
2022-01-09 16:20:41 DEBUG (MainThread) [pyatv.support.http] Sending HTTP/1.1 message: b'POST /pair-setup-pin HTTP/1.1\r\nUser-Agent: pyatv/0.9.8\r\nContent-Length: 116\r\n\r\nbplist00\xd2\x01\x02\x03\x04WauthTagSepkO\x10\x10=>D\xe7{\xc2b?R\xce\xa5\xdd\xd6\xc9\xfc\x8fO\x10 \x81K\xb9E\xc1:\xcb\xca\xd4l\x17\xa6J<\xc03\xa7tX\xb7r\xae\x11\xa5\x84DI\x9af\xde\xc1\x9d\x08\r\x15\x19,\x00\x00\x00\x00\x00\x00\x01\x01\x00\x00\x00\x00\x00\x00\x00\x05\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00O'
2022-01-09 16:20:41 DEBUG (MainThread) [pyatv.support.http] Received: b'HTTP/1.1 200 OK\r\nDate: Sun, 09 Jan 2022 16:20:41 GMT\r\nContent-Length: 116\r\nContent-Type: application/x-apple-binary-plist\r\nServer: AirTunes/600.8.41\r\n\r\nbplist00\xd2\x01\x02\x03\x04SepkWauthTagO\x10 E&#^\x12\x9c\xe52wX\x80\x9f\x13\xd3`\tk\xfc\xba\xcbP|\x13\x81)\xc4\xeb\xcc\x81|\xfb\xa6O\x10\x10^\xd2\x1c}V7\x8b\xdc\xd7\xa8\xb5\x8e1\x9d\xdf\xf1\x08\r\x11\x19<\x00\x00\x00\x00\x00\x00\x01\x01\x00\x00\x00\x00\x00\x00\x00\x05\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00O'
2022-01-09 16:20:41 DEBUG (MainThread) [pyatv.support.http] Got HTTP response: HttpResponse(protocol='HTTP', version='1.1', code=200, message='OK', headers={'date': 'Sun, 09 Jan 2022 16:20:41 GMT', 'content-length': '116', 'content-type': 'application/x-apple-binary-plist', 'server': 'AirTunes/600.8.41'}, body=b'bplist00\xd2\x01\x02\x03\x04SepkWauthTagO\x10 E&#^\x12\x9c\xe52wX\x80\x9f\x13\xd3`\tk\xfc\xba\xcbP|\x13\x81)\xc4\xeb\xcc\x81|\xfb\xa6O\x10\x10^\xd2\x1c}V7\x8b\xdc\xd7\xa8\xb5\x8e1\x9d\xdf\xf1\x08\r\x11\x19<\x00\x00\x00\x00\x00\x00\x01\x01\x00\x00\x00\x00\x00\x00\x00\x05\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00O'):
2022-01-09 16:20:41 DEBUG (MainThread) [pyatv.support.http] Connection closed
   Model/SW: Apple TV 4K, tvOS 15.2 build 19K53
    Address: 192.168.1.7
        MAC: D0:D2:B0:A6:D1:83
 Deep Sleep: True
Identifiers:
 - D0:D2:B0:A6:D1:83
 - 5E7DCA4D-AB16-469B-99DD-C1D9858B42B9
 - D0D2B0A6D183
Services:
 - Protocol: Companion, Port: 49152, Credentials: None, Requires Password: False, Password: None, Pairing: Mandatory
 - Protocol: AirPlay, Port: 7000, Credentials: None, Requires Password: False, Password: None, Pairing: Mandatory
 - Protocol: MRP, Port: 49153, Credentials: None, Requires Password: False, Password: None, Pairing: Optional (Disabled)
 - Protocol: RAOP, Port: 7000, Credentials: None, Requires Password: False, Password: None, Pairing: Mandatory


### How to reproduce the bug?

Attempt to configure ATV using HA via hass-atv-beta/hacs

### What is expected behavior?

ATV successfully pairs and is usable using HA remote service.

### Operating System

Linux

### Python

3.9

### pyatv

0.9.8

### Device

ATV 4K A1842, 15.2 19K53

### Additional context

HA 2021.12.8
postlund commented 2 years ago

You likely already have the device added but it is hidden. Try showing hidden devices in the integration page and enable it again from there.

tcb678 commented 2 years ago

Thanks, it works now though I'm still not convinced there wasn't an unusual bug here. Will keep an eye on it.