search

postlund / pyatv

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

Media player card is not updated in Home Assistant #636

Closed Crocmagnon closed 3 years ago

Crocmagnon commented 4 years ago

Describe the bug Sometimes, the info of a played media "stick" in the home assistant media player view. I reproduced it with Netflix and Molotov.

It sometimes changes, sometimes not.

To Reproduce I don't know to reproduce, but I have debug logs of the last time it happened. See additional context.

Expected behavior The state should match the current state of the apple tv: displaying the currently playing episode OR paused/idle if it's not playing.

System Setup (please complete the following information):

Additional context

In the case described in the logs below, my roommate launched the TV around 21:00 yesterday night (2020-05-01) and was expecting a show. She first watched something else (Candice Renoir [...]) waiting for the other show to begin. Then she switched to the other show and this new show's info (Koh-Lanta [...]) are still on my media player card in HA now after a whole night (it's 07:31 now).

I just tried to launch another video in another app and nothing appeared in the logs + the state didn't change.

Here's the current state of the apple tv according to HA, while it's really off (idle).

media_content_type: video
media_position: 3
media_position_updated_at: '2020-05-01T19:10:40.333247+00:00'
media_title: 'Koh-Lanta, l''île des héros • Episode 10'
app_id: tv.molotov.MolotovAppProd
media_artist: TF1
friendly_name: switch
entity_picture: >-
  /api/media_player_proxy/media_player.switch?token=1a14e68240cbec427bc837d2405893692cf52d75d7cc00208fc7fcc423817d0a&cache=D74F59E3-D732-4609-A8BC-597DCC85F88E
supported_features: 21427

It also happened yesterday morning, I was watching a Netflix show episode (let's call it A), when I switched to a completely other show (B), I still had infos from A in the media player card. Even after putting the Apple TV to sleep.

Here's my logging config (from the pyatv/HA integration repo):

logger:
  default: info
  logs:
    pyatv: debug
    custom_components.apple_tv: debug

And here are the logs:

Logs from 2020-01-05 21:00:00 to 2020-01-05 23:30:00 
-- Logs begin at Fri 2020-05-01 13:14:56 CEST, end at Sat 2020-05-02 07:42:29 CEST. --
May 01 21:01:51 architect hass[24888]: 2020-05-01 21:01:51 INFO (Thread-3) [pyhap.hap_server] Got connection with ('192.168.1.59', 49954).
May 01 21:01:51 architect hass[24888]: 2020-05-01 21:01:51 INFO (Thread-258) [pyhap.hap_server] 192.168.1.59 - "POST /pair-verify HTTP/1.1" 200 -
May 01 21:01:51 architect hass[24888]: 2020-05-01 21:01:51 INFO (Thread-258) [pyhap.hap_server] 192.168.1.59 - "POST /pair-verify HTTP/1.1" 200 -
May 01 21:01:51 architect hass[24888]: 2020-05-01 21:01:51 INFO (Thread-258) [pyhap.hap_server] 192.168.1.59 - "GET /accessories HTTP/1.1" 200 -
May 01 21:03:04 architect hass[24888]: 2020-05-01 21:03:04 INFO (Thread-3) [pyhap.hap_server] Got connection with ('192.168.1.59', 49956).
May 01 21:03:04 architect hass[24888]: 2020-05-01 21:03:04 INFO (Thread-259) [pyhap.hap_server] 192.168.1.59 - "POST /pair-verify HTTP/1.1" 200 -
May 01 21:03:04 architect hass[24888]: 2020-05-01 21:03:04 INFO (Thread-259) [pyhap.hap_server] 192.168.1.59 - "POST /pair-verify HTTP/1.1" 200 -
May 01 21:03:04 architect hass[24888]: 2020-05-01 21:03:04 INFO (Thread-259) [pyhap.hap_server] 192.168.1.59 - "GET /accessories HTTP/1.1" 200 -
May 01 21:05:07 architect hass[24888]: 2020-05-01 21:05:07 INFO (Thread-3) [pyhap.hap_server] Got connection with ('192.168.1.59', 49960).
May 01 21:05:07 architect hass[24888]: 2020-05-01 21:05:07 INFO (Thread-260) [pyhap.hap_server] 192.168.1.59 - "POST /pair-verify HTTP/1.1" 200 -
May 01 21:05:07 architect hass[24888]: 2020-05-01 21:05:07 INFO (Thread-260) [pyhap.hap_server] 192.168.1.59 - "POST /pair-verify HTTP/1.1" 200 -
May 01 21:05:07 architect hass[24888]: 2020-05-01 21:05:07 INFO (Thread-260) [pyhap.hap_server] 192.168.1.59 - "GET /accessories HTTP/1.1" 200 -
May 01 21:07:52 architect hass[24888]: 2020-05-01 21:07:52 INFO (Thread-6) [pyhap.hap_server] 192.168.1.77 - "PUT /characteristics HTTP/1.1" 204 -
May 01 21:07:56 architect hass[24888]: 2020-05-01 21:07:56 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=1901727537aa519d42a94943c5ba82b43c2f54b75c1e30fb6ffc)
May 01 21:07:56 architect hass[24888]: 2020-05-01 21:07:56 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08162000da01020806)
May 01 21:07:56 architect hass[24888]: 2020-05-01 21:07:56 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: type: REGISTER_FOR_GAME_CONTROLLER_EVENTS_MESSAGE
May 01 21:07:56 architect hass[24888]: errorCode: NoError
May 01 21:07:56 architect hass[24888]: [registerForGameControllerEventsMessage] {
May 01 21:07:56 architect hass[24888]: }
May 01 21:07:58 architect hass[24888]: 2020-05-01 21:07:58 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=d3077cc90b6818da16fdda5c74bdc071f9304af772a56eb2dee8941c0f413f92ed7c2d9b19a1a306f57d82f4b972677a79ad105854513ad89234ec2d3a0144e7b1a553fa8fae9ac9e93bcc92c9378023f0fe80f022ebe04a6f71d8a0ef41306f9bf842b3e1780e97f5f55bf52576bd6ea9e3743d7fd22846e9a1ba3c317153e02abc51e44ed129b5eac2cfe78fdffeba04da0bf71670ed5ba886a4a3be4aad1f42d737c9971c430dfb5d212a6b1034cbf4038e325548e10f5f24b2fe8353c989a0b4e4077e7e34661e1d452024d1065795fc9fac64136469dd4192852c30a1b2fc2e2f845f0cecb2eff219acd4bf36c54b2fd4a257e1f312ef1671f91d54f...)
May 01 21:07:58 architect hass[24888]: 2020-05-01 21:07:58 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=080420004abc071ad806080012d3060a12657069736f64652d323631353031312d313912b6060a3e43616e646963652052656e6f697220e280a22053303845303420e280a220436520717569206e6520747565207061732072656e6420706c757320666f72742d000000003a084672616e63652032980101fa010a696d6167652f6a706567a80201bd0200000000e20212657069736f64652d323631353031312d31398004028804009a049b0362706c6973743030d4010203040506070a582476657273696f6e592461726368697665725424746f7058246f626a6563747312000186a05f100f4e534b657965644172636869766572d1080954726f6f748...)
May 01 21:07:58 architect hass[24888]: 2020-05-01 21:07:58 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: type: SET_STATE_MESSAGE
May 01 21:07:58 architect hass[24888]: errorCode: NoError
May 01 21:07:58 architect hass[24888]: [setStateMessage] {
May 01 21:07:58 architect hass[24888]:   playbackQueue {
May 01 21:07:58 architect hass[24888]:     location: 0
May 01 21:07:58 architect hass[24888]:     contentItems {
May 01 21:07:58 architect hass[24888]:       identifier: "episode-2615011-19"
May 01 21:07:58 architect hass[24888]:       metadata {
May 01 21:07:58 architect hass[24888]:         title: "Candice Renoir \342\200\242 S08E04 \342\200\242 Ce qui ne tue pas rend plus fort"
May 01 21:07:58 architect hass[24888]:         playbackProgress: 0.0
May 01 21:07:58 architect hass[24888]:         trackArtistName: "France 2"
May 01 21:07:58 architect hass[24888]:         artworkAvailable: true
May 01 21:07:58 architect hass[24888]:         artworkMIMEType: "image/jpeg"
May 01 21:07:58 architect hass[24888]:         isAlwaysLive: true
May 01 21:07:58 architect hass[24888]:         playbackRate: 0.0
May 01 21:07:58 architect hass[24888]:         contentIdentifier: "episode-2615011-19"
May 01 21:07:58 architect hass[24888]:         mediaType: Video
May 01 21:07:58 architect hass[24888]:         mediaSubType: UnknownMediaSubType
May 01 21:07:58 architect hass[24888]:         nowPlayingInfoData: "bplist00\324\001\002\003\004\005\006\007\nX$versionY$archiverT$topX$objects\022\000\001\206\240_\020\017NSKeyedArchive...
May 01 21:07:58 architect hass[24888]:         elapsedTimeTimestamp: 610052878.192498
May 01 21:07:58 architect hass[24888]:         currentPlaybackDateData: "bplist00\324\001\002\003\004\005\006\007\nX$versionY$archiverT$topX$objects\022\000\001\206\240_\020\017NSKeyedAr...
May 01 21:07:58 architect hass[24888]:         artworkIdentifier: "04371781-A102-4FB4-971C-E725B473C203"
May 01 21:07:58 architect hass[24888]:       }
May 01 21:07:58 architect hass[24888]:       artworkDataWidth: 768
May 01 21:07:58 architect hass[24888]:       artworkDataHeight: 768
May 01 21:07:58 architect hass[24888]:     }
May 01 21:07:58 architect hass[24888]:   }
May 01 21:07:58 architect hass[24888]:   playerPath {
May 01 21:07:58 architect hass[24888]:     origin {
May 01 21:07:58 architect hass[24888]:       type: Local
May 01 21:07:58 architect hass[24888]:       displayName: "switch"
May 01 21:07:58 architect hass[24888]:       identifier: 1280262988
May 01 21:07:58 architect hass[24888]:     }
May 01 21:07:58 architect hass[24888]:     client {
May 01 21:07:58 architect hass[24888]:       processIdentifier: 1737
May 01 21:07:58 architect hass[24888]:       bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:07:58 architect hass[24888]:     }
May 01 21:07:58 architect hass[24888]:     player {
May 01 21:07:58 architect hass[24888]:       identifier: "MediaRemote-DefaultPlayer"
May 01 21:07:58 architect hass[24888]:       displayName: "Default Player"
May 01 21:07:58 architect hass[24888]:     }
May 01 21:07:58 architect hass[24888]:   }
May 01 21:07:58 architect hass[24888]: }
May 01 21:07:58 architect hass[24888]: 2020-05-01 21:07:58 DEBUG (MainThread) [pyatv.mrp.protocol] Dispatching message with type 4 (SetStateMessage) to Listener(func=>, data=None)
May 01 21:07:58 architect hass[24888]: 2020-05-01 21:07:58 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=c9075f914601f3244091272545101edc43c1fbd4a73a63c42e846062c6610c3765caf48da9091462eccafbf52ea60c122f10ac40044fb3132b39304ac210c1a2e01329bef670adfc0d804cf74de108e7199e76bd331988e8be224c1930af99ea5ee59aacb0e98063839ffbc3bc61ddef72b28971bcc0610b2a9604e3668ae6e2cf9a0b6ba48fb9d722a7d748522303484c5ee63c6907bda0e064bf860d57ff0c8d04378680df58ce15276dcb82a5907c5b853d252f92e18066e8884d93668041de01c7c9111258a6595c427af757cffaee4cb3d2994a19a17e52cff725b64d1fec2185e84b68a3bf8d7461016e173072398d2c80f090d726fafa5eae031e8...)
May 01 21:07:58 architect hass[24888]: 2020-05-01 21:07:58 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08382000e203b1070acd060a12657069736f64652d323631353031312d313912b6060a3e43616e646963652052656e6f697220e280a22053303845303420e280a220436520717569206e6520747565207061732072656e6420706c757320666f72742d000000003a084672616e63652032980101fa010a696d6167652f6a706567a80201bd0200000000e20212657069736f64652d323631353031312d31398004028804009a049b0362706c6973743030d4010203040506070a582476657273696f6e592461726368697665725424746f7058246f626a6563747312000186a05f100f4e534b657965644172636869766572d1080954726f6f748001a70b0...)
May 01 21:07:58 architect hass[24888]: 2020-05-01 21:07:58 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: type: UPDATE_CONTENT_ITEM_MESSAGE
May 01 21:07:58 architect hass[24888]: errorCode: NoError
May 01 21:07:58 architect hass[24888]: [updateContentItemMessage] {
May 01 21:07:58 architect hass[24888]:   contentItems {
May 01 21:07:58 architect hass[24888]:     identifier: "episode-2615011-19"
May 01 21:07:58 architect hass[24888]:     metadata {
May 01 21:07:58 architect hass[24888]:       title: "Candice Renoir \342\200\242 S08E04 \342\200\242 Ce qui ne tue pas rend plus fort"
May 01 21:07:58 architect hass[24888]:       playbackProgress: 0.0
May 01 21:07:58 architect hass[24888]:       trackArtistName: "France 2"
May 01 21:07:58 architect hass[24888]:       artworkAvailable: true
May 01 21:07:58 architect hass[24888]:       artworkMIMEType: "image/jpeg"
May 01 21:07:58 architect hass[24888]:       isAlwaysLive: true
May 01 21:07:58 architect hass[24888]:       playbackRate: 0.0
May 01 21:07:58 architect hass[24888]:       contentIdentifier: "episode-2615011-19"
May 01 21:07:58 architect hass[24888]:       mediaType: Video
May 01 21:07:58 architect hass[24888]:       mediaSubType: UnknownMediaSubType
May 01 21:07:58 architect hass[24888]:       nowPlayingInfoData: "bplist00\324\001\002\003\004\005\006\007\nX$versionY$archiverT$topX$objects\022\000\001\206\240_\020\017NSKeyedArchiver\...
May 01 21:07:58 architect hass[24888]:       elapsedTimeTimestamp: 610052878.723234
May 01 21:07:58 architect hass[24888]:       currentPlaybackDateData: "bplist00\324\001\002\003\004\005\006\007\nX$versionY$archiverT$topX$objects\022\000\001\206\240_\020\017NSKeyedArch...
May 01 21:07:58 architect hass[24888]:       artworkIdentifier: "01036DC0-AB35-4DE9-939A-EC140FEBDE56"
May 01 21:07:58 architect hass[24888]:     }
May 01 21:07:58 architect hass[24888]:   }
May 01 21:07:58 architect hass[24888]:   playerPath {
May 01 21:07:58 architect hass[24888]:     origin {
May 01 21:07:58 architect hass[24888]:       type: Local
May 01 21:07:58 architect hass[24888]:       displayName: "switch"
May 01 21:07:58 architect hass[24888]:       identifier: 1280262988
May 01 21:07:58 architect hass[24888]:     }
May 01 21:07:58 architect hass[24888]:     client {
May 01 21:07:58 architect hass[24888]:       processIdentifier: 1737
May 01 21:07:58 architect hass[24888]:       bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:07:58 architect hass[24888]:     }
May 01 21:07:58 architect hass[24888]:     player {
May 01 21:07:58 architect hass[24888]:       identifier: "MediaRemote-DefaultPlayer"
May 01 21:07:58 architect hass[24888]:       displayName: "Default Player"
May 01 21:07:58 architect hass[24888]:     }
May 01 21:07:58 architect hass[24888]:   }
May 01 21:07:58 architect hass[24888]: }
May 01 21:07:58 architect hass[24888]: 2020-05-01 21:07:58 DEBUG (MainThread) [pyatv.mrp.protocol] Dispatching message with type 56 (UpdateContentItemMessage) to Listener(func=>, data=None)
May 01 21:07:59 architect hass[24888]: 2020-05-01 21:07:59 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=37b7d0c5fafe444added8d37504da95b93abd3a95eb57d405812dd519cc92aa4437440b4e73fe73d0ebfec5a45fbd3fa27f9dfeaf2c94e70)
May 01 21:07:59 architect hass[24888]: 2020-05-01 21:07:59 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=082e20009203200a1e08c90d121974762e6d6f6c6f746f762e4d6f6c6f746f7641707050726f64)
May 01 21:07:59 architect hass[24888]: 2020-05-01 21:07:59 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: type: SET_NOW_PLAYING_CLIENT_MESSAGE
May 01 21:07:59 architect hass[24888]: errorCode: NoError
May 01 21:07:59 architect hass[24888]: [setNowPlayingClientMessage] {
May 01 21:07:59 architect hass[24888]:   client {
May 01 21:07:59 architect hass[24888]:     processIdentifier: 1737
May 01 21:07:59 architect hass[24888]:     bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:07:59 architect hass[24888]:   }
May 01 21:07:59 architect hass[24888]: }
May 01 21:07:59 architect hass[24888]: 2020-05-01 21:07:59 DEBUG (MainThread) [pyatv.mrp.protocol] Dispatching message with type 46 (SetNowPlayingClientMessage) to Listener(func=>, data=None)
May 01 21:07:59 architect hass[24888]: 2020-05-01 21:07:59 DEBUG (MainThread) [pyatv.mrp.player_state] Active player is now tv.molotov.MolotovAppProd
May 01 21:08:00 architect hass[24888]: 2020-05-01 21:08:00 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=82017a4a580ad8f28440677b26225e4cfdddf46944e34beee1ba6156dd136684460ab2f572d5ef3361d367bbf9a011a4d48e35c045aa52f91341cd5c6541138a21a619744c3e900a36b99a083f6f9eabc8ca77ee0d3dbe159d2c8ce6ea956435426d077658606ab31a9806d0c820fa5f715f10c53988703628e329b21d5977044340d480cd07b7c396a7796924a8d2572f3755772bf9787c9abd25f0119f54f9950aee1213b83d17c58a35b3d12f99e49f3ca58026d51e5fc55d864a8e4fc1e68a79b36c4a6001f604e2c1cd8e14a4b120e7ff6973ac439cfc19f4f6840849196c841d9a61a28b5b3fe5dad65bfdb33f8026d8f549a78f16cac6299c71d01...)
May 01 21:08:00 architect hass[24888]: 2020-05-01 21:08:00 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=080420004a6c30014a5f0a100801120673776974636818cc86bde204121e08c90d121974762e6d6f6c6f746f762e4d6f6c6f746f7641707050726f641a2b0a194d6564696152656d6f74652d44656661756c74506c61796572120e44656661756c7420506c6179657259573da287552ec241)
May 01 21:08:00 architect hass[24888]: 2020-05-01 21:08:00 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: type: SET_STATE_MESSAGE
May 01 21:08:00 architect hass[24888]: errorCode: NoError
May 01 21:08:00 architect hass[24888]: [setStateMessage] {
May 01 21:08:00 architect hass[24888]:   playbackState: Playing
May 01 21:08:00 architect hass[24888]:   playerPath {
May 01 21:08:00 architect hass[24888]:     origin {
May 01 21:08:00 architect hass[24888]:       type: Local
May 01 21:08:00 architect hass[24888]:       displayName: "switch"
May 01 21:08:00 architect hass[24888]:       identifier: 1280262988
May 01 21:08:00 architect hass[24888]:     }
May 01 21:08:00 architect hass[24888]:     client {
May 01 21:08:00 architect hass[24888]:       processIdentifier: 1737
May 01 21:08:00 architect hass[24888]:       bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:08:00 architect hass[24888]:     }
May 01 21:08:00 architect hass[24888]:     player {
May 01 21:08:00 architect hass[24888]:       identifier: "MediaRemote-DefaultPlayer"
May 01 21:08:00 architect hass[24888]:       displayName: "Default Player"
May 01 21:08:00 architect hass[24888]:     }
May 01 21:08:00 architect hass[24888]:   }
May 01 21:08:00 architect hass[24888]:   playbackStateTimestamp: 610052879.267497
May 01 21:08:00 architect hass[24888]: }
May 01 21:08:00 architect hass[24888]: 2020-05-01 21:08:00 DEBUG (MainThread) [pyatv.mrp.protocol] Dispatching message with type 4 (SetStateMessage) to Listener(func=>, data=None)
May 01 21:08:00 architect hass[24888]: 2020-05-01 21:08:00 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08382000e203b5070ad1060a12657069736f64652d323631353031312d313912ba060a3e43616e646963652052656e6f697220e280a22053303845303420e280a220436520717569206e6520747565207061732072656e6420706c757320666f72742d000000003a084672616e63652032980101fa010a696d6167652f6a706567a80201bd020000803fe20212657069736f64652d323631353031312d31398004028804009a049b0362706c6973743030d4010203040506070a582476657273696f6e592461726368697665725424746f7058246f626a6563747312000186a05f100f4e534b657965644172636869766572d1080954726f6f748001a70b0...)
May 01 21:08:00 architect hass[24888]: 2020-05-01 21:08:00 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: type: UPDATE_CONTENT_ITEM_MESSAGE
May 01 21:08:00 architect hass[24888]: errorCode: NoError
May 01 21:08:00 architect hass[24888]: [updateContentItemMessage] {
May 01 21:08:00 architect hass[24888]:   contentItems {
May 01 21:08:00 architect hass[24888]:     identifier: "episode-2615011-19"
May 01 21:08:00 architect hass[24888]:     metadata {
May 01 21:08:00 architect hass[24888]:       title: "Candice Renoir \342\200\242 S08E04 \342\200\242 Ce qui ne tue pas rend plus fort"
May 01 21:08:00 architect hass[24888]:       playbackProgress: 0.0
May 01 21:08:00 architect hass[24888]:       trackArtistName: "France 2"
May 01 21:08:00 architect hass[24888]:       artworkAvailable: true
May 01 21:08:00 architect hass[24888]:       artworkMIMEType: "image/jpeg"
May 01 21:08:00 architect hass[24888]:       isAlwaysLive: true
May 01 21:08:00 architect hass[24888]:       playbackRate: 1.0
May 01 21:08:00 architect hass[24888]:       contentIdentifier: "episode-2615011-19"
May 01 21:08:00 architect hass[24888]:       mediaType: Video
May 01 21:08:00 architect hass[24888]:       mediaSubType: UnknownMediaSubType
May 01 21:08:00 architect hass[24888]:       nowPlayingInfoData: "bplist00\324\001\002\003\004\005\006\007\nX$versionY$archiverT$topX$objects\022\000\001\206\240_\020\017NSKeyedArchiver\...
May 01 21:08:00 architect hass[24888]:       elapsedTimeTimestamp: 610052879.476763
May 01 21:08:00 architect hass[24888]:       currentPlaybackDateData: "bplist00\324\001\002\003\004\005\006\007\nX$versionY$archiverT$topX$objects\022\000\001\206\240_\020\017NSKeyedArch...
May 01 21:08:00 architect hass[24888]:       artworkIdentifier: "715bc6d217957b35b806fad7ee3392aa4a0439c6"
May 01 21:08:00 architect hass[24888]:     }
May 01 21:08:00 architect hass[24888]:   }
May 01 21:08:00 architect hass[24888]:   playerPath {
May 01 21:08:00 architect hass[24888]:     origin {
May 01 21:08:00 architect hass[24888]:       type: Local
May 01 21:08:00 architect hass[24888]:       displayName: "switch"
May 01 21:08:00 architect hass[24888]:       identifier: 1280262988
May 01 21:08:00 architect hass[24888]:     }
May 01 21:08:00 architect hass[24888]:     client {
May 01 21:08:00 architect hass[24888]:       processIdentifier: 1737
May 01 21:08:00 architect hass[24888]:       bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:08:00 architect hass[24888]:     }
May 01 21:08:00 architect hass[24888]:     player {
May 01 21:08:00 architect hass[24888]:       identifier: "MediaRemote-DefaultPlayer"
May 01 21:08:00 architect hass[24888]:       displayName: "Default Player"
May 01 21:08:00 architect hass[24888]:     }
May 01 21:08:00 architect hass[24888]:   }
May 01 21:08:00 architect hass[24888]: }
May 01 21:08:00 architect hass[24888]: 2020-05-01 21:08:00 DEBUG (MainThread) [pyatv.mrp.protocol] Dispatching message with type 56 (UpdateContentItemMessage) to Listener(func=>, data=None)
May 01 21:08:00 architect hass[24888]: 2020-05-01 21:08:00 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08382000e203bc070ad8060a12657069736f64652d323631353031312d313912c1060a3e43616e646963652052656e6f697220e280a22053303845303420e280a220436520717569206e6520747565207061732072656e6420706c757320666f72742d000000003a084672616e63652032980101fa010a696d6167652f6a706567a80201bd020000803fe20212657069736f64652d323631353031312d31398004028804009a04a20362706c6973743030d4010203040506070a582476657273696f6e592461726368697665725424746f7058246f626a6563747312000186a05f100f4e534b657965644172636869766572d1080954726f6f748001a70b0...)
May 01 21:08:00 architect hass[24888]: 2020-05-01 21:08:00 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: type: UPDATE_CONTENT_ITEM_MESSAGE
May 01 21:08:00 architect hass[24888]: errorCode: NoError
May 01 21:08:00 architect hass[24888]: [updateContentItemMessage] {
May 01 21:08:00 architect hass[24888]:   contentItems {
May 01 21:08:00 architect hass[24888]:     identifier: "episode-2615011-19"
May 01 21:08:00 architect hass[24888]:     metadata {
May 01 21:08:00 architect hass[24888]:       title: "Candice Renoir \342\200\242 S08E04 \342\200\242 Ce qui ne tue pas rend plus fort"
May 01 21:08:00 architect hass[24888]:       playbackProgress: 0.0
May 01 21:08:00 architect hass[24888]:       trackArtistName: "France 2"
May 01 21:08:00 architect hass[24888]:       artworkAvailable: true
May 01 21:08:00 architect hass[24888]:       artworkMIMEType: "image/jpeg"
May 01 21:08:00 architect hass[24888]:       isAlwaysLive: true
May 01 21:08:00 architect hass[24888]:       playbackRate: 1.0
May 01 21:08:00 architect hass[24888]:       contentIdentifier: "episode-2615011-19"
May 01 21:08:00 architect hass[24888]:       mediaType: Video
May 01 21:08:00 architect hass[24888]:       mediaSubType: UnknownMediaSubType
May 01 21:08:00 architect hass[24888]:       nowPlayingInfoData: "bplist00\324\001\002\003\004\005\006\007\nX$versionY$archiverT$topX$objects\022\000\001\206\240_\020\017NSKeyedArchiver\...
May 01 21:08:00 architect hass[24888]:       elapsedTimeTimestamp: 610052880.243022
May 01 21:08:00 architect hass[24888]:       currentPlaybackDateData: "bplist00\324\001\002\003\004\005\006\007\nX$versionY$archiverT$topX$objects\022\000\001\206\240_\020\017NSKeyedArch...
May 01 21:08:00 architect hass[24888]:       artworkIdentifier: "715bc6d217957b35b806fad7ee3392aa4a0439c6"
May 01 21:08:00 architect hass[24888]:     }
May 01 21:08:00 architect hass[24888]:   }
May 01 21:08:00 architect hass[24888]:   playerPath {
May 01 21:08:00 architect hass[24888]:     origin {
May 01 21:08:00 architect hass[24888]:       type: Local
May 01 21:08:00 architect hass[24888]:       displayName: "switch"
May 01 21:08:00 architect hass[24888]:       identifier: 1280262988
May 01 21:08:00 architect hass[24888]:     }
May 01 21:08:00 architect hass[24888]:     client {
May 01 21:08:00 architect hass[24888]:       processIdentifier: 1737
May 01 21:08:00 architect hass[24888]:       bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:08:00 architect hass[24888]:     }
May 01 21:08:00 architect hass[24888]:     player {
May 01 21:08:00 architect hass[24888]:       identifier: "MediaRemote-DefaultPlayer"
May 01 21:08:00 architect hass[24888]:       displayName: "Default Player"
May 01 21:08:00 architect hass[24888]:     }
May 01 21:08:00 architect hass[24888]:   }
May 01 21:08:00 architect hass[24888]: }
May 01 21:08:00 architect hass[24888]: 2020-05-01 21:08:00 DEBUG (MainThread) [pyatv.mrp.protocol] Dispatching message with type 56 (UpdateContentItemMessage) to Listener(func=>, data=None)
May 01 21:08:02 architect hass[24888]: 2020-05-01 21:08:02 INFO (MainThread) [homeassistant.components.automation] Executing Mode film quand l'Apple TV joue le soir
May 01 21:08:02 architect hass[24888]: 2020-05-01 21:08:02 INFO (MainThread) [homeassistant.components.automation] Mode film quand l'Apple TV joue le soir: Running script
May 01 21:08:02 architect hass[24888]: 2020-05-01 21:08:02 INFO (MainThread) [homeassistant.components.automation] Mode film quand l'Apple TV joue le soir: Executing step call service
May 01 21:08:02 architect hass[24888]: 2020-05-01 21:08:02 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 >> Send (Data=0820122434656162386565332d613630662d343339622d396265302d6435623239363336383330342000aa02160800100121000000000000804029000000000000f0bf)
May 01 21:08:02 architect hass[24888]: 2020-05-01 21:08:02 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 >> Send (Encrypted=a5712e47fc9d19e3b69a491026c27dbf2674c49f24d91d24f4c378eb774821d649d50a9a66a8aad656f985e7abf80b5703dc123405d21fc0c986be58454161a178d866b76bc5d24991948a43dee2aa6c9ebe57)
May 01 21:08:02 architect hass[24888]: 2020-05-01 21:08:02 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 >> Send: Protobuf: type: PLAYBACK_QUEUE_REQUEST_MESSAGE
May 01 21:08:02 architect hass[24888]: identifier: "4eab8ee3-a60f-439b-9be0-d5b296368304"
May 01 21:08:02 architect hass[24888]: errorCode: NoError
May 01 21:08:02 architect hass[24888]: [playbackQueueRequestMessage] {
May 01 21:08:02 architect hass[24888]:   location: 0
May 01 21:08:02 architect hass[24888]:   length: 1
May 01 21:08:02 architect hass[24888]:   artworkWidth: 512
May 01 21:08:02 architect hass[24888]:   artworkHeight: -1
May 01 21:08:02 architect hass[24888]: }
May 01 21:08:02 architect hass[24888]: 2020-05-01 21:08:02 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 >> Send (Data=0820122432356432313833342d326636392d343664652d613765392d3032623362626662653066652000aa02160800100121000000000000804029000000000000f0bf)
May 01 21:08:02 architect hass[24888]: 2020-05-01 21:08:02 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 >> Send (Encrypted=4da5da9a3cce92d9dff8c835ec479f1867e0d805e024a21069d44539269e138fe1495eea8802b55f71c1b3d9006f86e1f6d7c66a251924fa5cdd717826c371d4668802a80175d7ec74be8f6c98895a29c9d486)
May 01 21:08:02 architect hass[24888]: 2020-05-01 21:08:02 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 >> Send: Protobuf: type: PLAYBACK_QUEUE_REQUEST_MESSAGE
May 01 21:08:02 architect hass[24888]: identifier: "25d21834-2f69-46de-a7e9-02b3bbfbe0fe"
May 01 21:08:02 architect hass[24888]: errorCode: NoError
May 01 21:08:02 architect hass[24888]: [playbackQueueRequestMessage] {
May 01 21:08:02 architect hass[24888]:   location: 0
May 01 21:08:02 architect hass[24888]:   length: 1
May 01 21:08:02 architect hass[24888]:   artworkWidth: 512
May 01 21:08:02 architect hass[24888]:   artworkHeight: -1
May 01 21:08:02 architect hass[24888]: }
May 01 21:08:02 architect hass[24888]: 2020-05-01 21:08:02 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=eca503c7785698a8b5d0520a47f02323deb2c409f6c8a8914e7641fa384c2452fb7f2ffbe74958c8477bb1f8110b89708a50ebe29f3e625c700aa3cbfcef17518de47a6a52a5e4375abeeed654c4067729ed671cea0603274bb2d535dc98a2b721dc55d3e62fda0db5fc7bc03202bccc0e966360c64fda326bd62ccc27305fde1fef8419d04618bb3071283df2920118cc18ce0f25df5c24e6ef7e23a542b354b6e93320f706d61b9b7b70d5319ea9fbca37d5dffda37535e7f6a151eafae16cc66588c855371c36e593816d19247422fc96791d74e2b036f0a723d6984af59cde4443a529b3bf72dee0f6867d8a3c1bd6d9c21e1fd64ad785a6f9ef54d31...)
May 01 21:08:02 architect hass[24888]: 2020-05-01 21:08:02 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 Require 53996 bytes but only 4341 in buffer
May 01 21:08:02 architect hass[24888]: 2020-05-01 21:08:02 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=b5d7bb910d96549667bd7db2193e22e56f41da10074f8eca3cef64031e087a24d86c4974a181cb505253de65a43f11385096597513222fc449457ac70b3f1f995c441e3133bd3012f743774b5c724286d9118e8daa39bef47dd1d112b9a957027df84e3eaf60fcbcb42ce15cdfa8282822e034a8f30b23a8628faed7a1af4386c07620ca25797fcb832e577d45b325dfdbfed34b38114acfcf2b55f484398f6d64e2da1ce260ac72714cb040790b74ee789f4aade5426bf5566b8ca304403c62ab27449cd1bd85db50a44e93a306c4d0a97259963a5ae189618132d89761fb632e5b6aa9edaa70044406d0eb1e5ca5b8882729a59152e86a5863d865e2cd0...)
May 01 21:08:02 architect hass[24888]: 2020-05-01 21:08:02 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 Require 53996 bytes but only 14477 in buffer
May 01 21:08:02 architect hass[24888]: 2020-05-01 21:08:02 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=85a9e4d40d74b236cc6b38d4a6520370a3077399c5bd14c407cfef712efcc2837db7e49e0c0ef568d47d7a7a87d291ff846a29bfafb9c1d38bcf325da6496f4e5c8fa981687674c66bce28373a0c3060fcf6113e4f04f3bdd79d61c945d3824ff33da650481712c2b86dd311222ecf2b59c106ab3aa20b43e4d2c51a76b441c6857c22f97469e70321af07733555a30d7a55aa2f0b3a0394117b5faf132071aa167c23d042622f86b90133eefea3de22d192745799cb22111dd8b231a0739cdf672a01187903145a2ee66ceae62d83db5c3e1655064735d7dc9c3d12bf69c1401fa9448b4d3564a70f4d90d53b2de9165f18ed5d495220f7c04fcd74d7339...)
May 01 21:08:02 architect hass[24888]: 2020-05-01 21:08:02 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 Require 53996 bytes but only 41989 in buffer
May 01 21:08:02 architect hass[24888]: 2020-05-01 21:08:02 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=e069e9b5c877e9f3a8c1bc7106d34fbfa44c036fb35f39223ff1e7adb01571115d84239b04d861a9d3995364362ffe9fb429c98dc957d977b7ad57d9af948cebffdc4193044c65f8e3e2bce212d49b634e3955982269b2d80d130a2844d8422c93418e047771638ab6764394f091d0ebfac4c7d63f1c2fb3427f6721f3dc577ff3294f4433a777e4a8b8b3e8800543185d5dd3a4fa015b5a21378bc5c2a9c237d7ad99b6317b27fe781c13fcfb100dac0b9498b8ef329add10ba0d315f660a925a8887378959763878dabd7471136aa895fe042c15d97f8f3f89fe95a81e11a85d11a33d9042cad0c492082eb3b74e0ac94f652944106903c7e247f26ff07...)
May 01 21:08:02 architect hass[24888]: 2020-05-01 21:08:02 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 Require 53996 bytes but only 43437 in buffer
May 01 21:08:02 architect hass[24888]: 2020-05-01 21:08:02 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=b230a24d83facc4e2c6a32d65985b1eed6c6ced5c8a8e5eeaee45dad32f3adc09b95b20b2f257f860f9fc9d4a40b64fdada83d03f4affc0ec8c955bac0900c28491f98b5e8dcee3e9e4f0e48e283081ed89248d26d4f8b47c7c5db9df17c99420a4805c4e831728288dca4916a280095145145dda6d8e140fe1b244f786ca1a4605b3a5d8136c868f3fa6d810fe3a2507e9dc1b66b44b19b559f1e8c832682ac0a3df50b4dc07fd23eabcd3603597d754c4381f62c080267af498c796838ee0b8a74611e550e31bf362a5b8125f16fbe5a8cb29211246ad505caf260e04ef4be3257d4c5f86d6d1a6ef44e40fa79ec8d19d825be451c44a16d9eac748c5ba...)
May 01 21:08:02 architect hass[24888]: 2020-05-01 21:08:02 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=0804122434656162386565332d613630662d343339622d396265302d64356232393633363833303420004aaea5031a8ba403080012f2a2030a12657069736f64652d323631353031312d31391ad4a203ffd8ffe10ffe4578696600004d4d002a000000080005011a0005000000010000004a011b0005000000010000005201280003000000010002000002130003000000010001000087690004000000010000005a00000000000000480000000100000048000000010007900000070000000430323231910100070000000401020300a00000070000000430313030a00100030000000100010000a00200040000000100000200a00300040000000100000...)
May 01 21:08:03 architect hass[24888]: 2020-05-01 21:08:03 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: type: SET_STATE_MESSAGE
May 01 21:08:03 architect hass[24888]: identifier: "4eab8ee3-a60f-439b-9be0-d5b296368304"
May 01 21:08:03 architect hass[24888]: errorCode: NoError
May 01 21:08:03 architect hass[24888]: [setStateMessage] {
May 01 21:08:03 architect hass[24888]:   playbackQueue {
May 01 21:08:03 architect hass[24888]:     location: 0
May 01 21:08:03 architect hass[24888]:     contentItems {
May 01 21:08:03 architect hass[24888]:       identifier: "episode-2615011-19"
May 01 21:08:03 architect hass[24888]:       artworkData: "\377\330\377\341\017\376Exif\000\000MM\000*\000\000\000\010\000\005\001\032\000\005\000\000\000\001\000\000\000J\001\033\000\00...
May 01 21:08:03 architect hass[24888]:       artworkDataWidth: 512
May 01 21:08:03 architect hass[24888]:       artworkDataHeight: 512
May 01 21:08:03 architect hass[24888]:     }
May 01 21:08:03 architect hass[24888]:     requestId: "641EE4A0-B61A-4A91-8B15-7858726AAE44"
May 01 21:08:03 architect hass[24888]:     resolvedPlayerPath {
May 01 21:08:03 architect hass[24888]:       origin {
May 01 21:08:03 architect hass[24888]:         type: Local
May 01 21:08:03 architect hass[24888]:         displayName: "switch"
May 01 21:08:03 architect hass[24888]:         identifier: 1280262988
May 01 21:08:03 architect hass[24888]:       }
May 01 21:08:03 architect hass[24888]:       client {
May 01 21:08:03 architect hass[24888]:         processIdentifier: 1737
May 01 21:08:03 architect hass[24888]:         bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:08:03 architect hass[24888]:         processUserIdentifier: 501
May 01 21:08:03 architect hass[24888]:         displayName: "Molotov"
May 01 21:08:03 architect hass[24888]:       }
May 01 21:08:03 architect hass[24888]:       player {
May 01 21:08:03 architect hass[24888]:         identifier: "MediaRemote-DefaultPlayer"
May 01 21:08:03 architect hass[24888]:         displayName: "Default Player"
May 01 21:08:03 architect hass[24888]:       }
May 01 21:08:03 architect hass[24888]:     }
May 01 21:08:03 architect hass[24888]:   }
May 01 21:08:03 architect hass[24888]:   playerPath {
May 01 21:08:03 architect hass[24888]:     origin {
May 01 21:08:03 architect hass[24888]:       type: Local
May 01 21:08:03 architect hass[24888]:       displayName: "switch"
May 01 21:08:03 architect hass[24888]:       identifier: 1280262988
May 01 21:08:03 architect hass[24888]:     }
May 01 21:08:03 architect hass[24888]:     client {
May 01 21:08:03 architect hass[24888]:       processIdentifier: 1737
May 01 21:08:03 architect hass[24888]:       bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:08:03 architect hass[24888]:     }
May 01 21:08:03 architect hass[24888]:     player {
May 01 21:08:03 architect hass[24888]:       identifier: "MediaRemote-DefaultPlayer"
May 01 21:08:03 architect hass[24888]:       displayName: "Default Player"
May 01 21:08:03 architect hass[24888]:     }
May 01 21:08:03 architect hass[24888]:   }
May 01 21:08:03 architect hass[24888]:   request {
May 01 21:08:03 architect hass[24888]:     location: 0
May 01 21:08:03 architect hass[24888]:     length: 1
May 01 21:08:03 architect hass[24888]:     artworkWidth: 512.0
May 01 21:08:03 architect hass[24888]:     artworkHeight: -1.0
May 01 21:08:03 architect hass[24888]:     requestID: "641EE4A0-B61A-4A91-8B15-7858726AAE44"
May 01 21:08:03 architect hass[24888]:   }
May 01 21:08:03 architect hass[24888]: }
May 01 21:08:03 architect hass[24888]: 2020-05-01 21:08:03 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 Require 53832 bytes but only 19846 in buffer
May 01 21:08:03 architect hass[24888]: 2020-05-01 21:08:03 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=78d09567dbfafe41a114049476b96967c92bc8d8cc7517b384ae0582edd3924ec3970c8f1cdd459ad65a4b8c0d90b893691f81a680b22ec610bb8ad3f218678f5593558c3d3182404adc6a67d0988eba9fd5e2d4f61a0a410242c469a343c6e48c54deb63c54cb03a49a74801260b5654df6398a93e35bdd75589905ae56dfe09e20a23875eef5a157c9c8018be7b7cb7890100808230569df13f207364e062ae35efce810b355816a11642ec810650359d3d1d1dc65be5ddee3d58dfc67cd811053955b6f401fbb0392b39db97214521159d3d5665072f8a1783097538743b948ed30026940728f8537a2d5acbc06dd6c52a634fbdbb4ab153a1df36cdb8...)
May 01 21:08:03 architect hass[24888]: 2020-05-01 21:08:03 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08212000b202afa403080212bca3030ab8a3030a140a12657069736f64652d323631353031312d313912f2a2030a12657069736f64652d323631353031312d31391ad4a203ffd8ffe10ffe4578696600004d4d002a000000080005011a0005000000010000004a011b0005000000010000005201280003000000010002000002130003000000010001000087690004000000010000005a00000000000000480000000100000048000000010007900000070000000430323231910100070000000401020300a00000070000000430313030a00100030000000100010000a00200040000000100000200a00300040000000100000200a406000300000001000...)
May 01 21:08:03 architect hass[24888]: 2020-05-01 21:08:03 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: type: TRANSACTION_MESSAGE
May 01 21:08:03 architect hass[24888]: errorCode: NoError
May 01 21:08:03 architect hass[24888]: [transactionMessage] {
May 01 21:08:03 architect hass[24888]:   name: 2
May 01 21:08:03 architect hass[24888]:   packets {
May 01 21:08:03 architect hass[24888]:     packets {
May 01 21:08:03 architect hass[24888]:       key {
May 01 21:08:03 architect hass[24888]:         identifier: "episode-2615011-19"
May 01 21:08:03 architect hass[24888]:       }
May 01 21:08:03 architect hass[24888]:       packetData: "\n\022episode-2615011-19\032\324\242\003\377\330\377\341\017\376Exif\000\000MM\000*\000\000\000\010\000\005\001\032\000\005\000\...
May 01 21:08:03 architect hass[24888]:       identifier: "7E59BC41-80B6-4E01-9122-42824EDE5081"
May 01 21:08:03 architect hass[24888]:       totalLength: 53618
May 01 21:08:03 architect hass[24888]:       totalWritePosition: 0
May 01 21:08:03 architect hass[24888]:     }
May 01 21:08:03 architect hass[24888]:   }
May 01 21:08:03 architect hass[24888]:   playerPath {
May 01 21:08:03 architect hass[24888]:     origin {
May 01 21:08:03 architect hass[24888]:       type: Local
May 01 21:08:03 architect hass[24888]:       displayName: "switch"
May 01 21:08:03 architect hass[24888]:       identifier: 1280262988
May 01 21:08:03 architect hass[24888]:     }
May 01 21:08:03 architect hass[24888]:     client {
May 01 21:08:03 architect hass[24888]:       processIdentifier: 1737
May 01 21:08:03 architect hass[24888]:       bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:08:03 architect hass[24888]:       processUserIdentifier: 501
May 01 21:08:03 architect hass[24888]:       displayName: "Molotov"
May 01 21:08:03 architect hass[24888]:     }
May 01 21:08:03 architect hass[24888]:     player {
May 01 21:08:03 architect hass[24888]:       identifier: "MediaRemote-DefaultPlayer"
May 01 21:08:03 architect hass[24888]:       displayName: "Default Player"
May 01 21:08:03 architect hass[24888]:     }
May 01 21:08:03 architect hass[24888]:   }
May 01 21:08:03 architect hass[24888]: }
May 01 21:08:03 architect hass[24888]: 2020-05-01 21:08:03 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 Require 53996 bytes but only 9451 in buffer
May 01 21:08:03 architect hass[24888]: 2020-05-01 21:08:03 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=3a0215bf8aaad54bf029907fec051a6f5860a2d48b57d4abbc6aef7cc2076cc6f4214a7b91c41d0bcca181cea45e632b6ae7ac3fda32bb1746c6ad479523715b9f1e861ffb188350345079f05d11d6afd715eaa5e51aef57173d7f73cfda4c69cf9bcdf5bfbba3caeeb040fc70c82321ae5557adf12fcfb2dc93fe2c4af48c86e68401a5cf8ab461058c62046ba876efa72ba0a0fdb74475f37b1ffd0ecb784033c0fe9c516e27932e35cbc69b1277d44ef157119ffbabea0684a5ff49e655d3cc25185a7266d6eb1c2a00c980d6b0da88746fdf161ddbde30a9066fa80e3fcb698d4121d92d06297d4314aebc1933184c972b3c5eb7b6ce0b9b7cb7fc749...)
May 01 21:08:03 architect hass[24888]: 2020-05-01 21:08:03 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=0804122432356432313833342d326636392d343664652d613765392d30326233626266626530666520004aaea5031a8ba403080012f2a2030a12657069736f64652d323631353031312d31391ad4a203ffd8ffe10ffe4578696600004d4d002a000000080005011a0005000000010000004a011b0005000000010000005201280003000000010002000002130003000000010001000087690004000000010000005a00000000000000480000000100000048000000010007900000070000000430323231910100070000000401020300a00000070000000430313030a00100030000000100010000a00200040000000100000200a00300040000000100000...)
May 01 21:08:03 architect hass[24888]: 2020-05-01 21:08:03 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: type: SET_STATE_MESSAGE
May 01 21:08:03 architect hass[24888]: identifier: "25d21834-2f69-46de-a7e9-02b3bbfbe0fe"
May 01 21:08:03 architect hass[24888]: errorCode: NoError
May 01 21:08:03 architect hass[24888]: [setStateMessage] {
May 01 21:08:03 architect hass[24888]:   playbackQueue {
May 01 21:08:03 architect hass[24888]:     location: 0
May 01 21:08:03 architect hass[24888]:     contentItems {
May 01 21:08:03 architect hass[24888]:       identifier: "episode-2615011-19"
May 01 21:08:03 architect hass[24888]:       artworkData: "\377\330\377\341\017\376Exif\000\000MM\000*\000\000\000\010\000\005\001\032\000\005\000\000\000\001\000\000\000J\001\033\000\00...
May 01 21:08:03 architect hass[24888]:       artworkDataWidth: 512
May 01 21:08:03 architect hass[24888]:       artworkDataHeight: 512
May 01 21:08:03 architect hass[24888]:     }
May 01 21:08:03 architect hass[24888]:     requestId: "9E3B5A5E-901F-4546-BE27-8CA9209F12F2"
May 01 21:08:03 architect hass[24888]:     resolvedPlayerPath {
May 01 21:08:03 architect hass[24888]:       origin {
May 01 21:08:03 architect hass[24888]:         type: Local
May 01 21:08:03 architect hass[24888]:         displayName: "switch"
May 01 21:08:03 architect hass[24888]:         identifier: 1280262988
May 01 21:08:03 architect hass[24888]:       }
May 01 21:08:03 architect hass[24888]:       client {
May 01 21:08:03 architect hass[24888]:         processIdentifier: 1737
May 01 21:08:03 architect hass[24888]:         bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:08:03 architect hass[24888]:         processUserIdentifier: 501
May 01 21:08:03 architect hass[24888]:         displayName: "Molotov"
May 01 21:08:03 architect hass[24888]:       }
May 01 21:08:03 architect hass[24888]:       player {
May 01 21:08:03 architect hass[24888]:         identifier: "MediaRemote-DefaultPlayer"
May 01 21:08:03 architect hass[24888]:         displayName: "Default Player"
May 01 21:08:03 architect hass[24888]:       }
May 01 21:08:03 architect hass[24888]:     }
May 01 21:08:03 architect hass[24888]:   }
May 01 21:08:03 architect hass[24888]:   playerPath {
May 01 21:08:03 architect hass[24888]:     origin {
May 01 21:08:03 architect hass[24888]:       type: Local
May 01 21:08:03 architect hass[24888]:       displayName: "switch"
May 01 21:08:03 architect hass[24888]:       identifier: 1280262988
May 01 21:08:03 architect hass[24888]:     }
May 01 21:08:03 architect hass[24888]:     client {
May 01 21:08:03 architect hass[24888]:       processIdentifier: 1737
May 01 21:08:03 architect hass[24888]:       bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:08:03 architect hass[24888]:     }
May 01 21:08:03 architect hass[24888]:     player {
May 01 21:08:03 architect hass[24888]:       identifier: "MediaRemote-DefaultPlayer"
May 01 21:08:03 architect hass[24888]:       displayName: "Default Player"
May 01 21:08:03 architect hass[24888]:     }
May 01 21:08:03 architect hass[24888]:   }
May 01 21:08:03 architect hass[24888]:   request {
May 01 21:08:03 architect hass[24888]:     location: 0
May 01 21:08:03 architect hass[24888]:     length: 1
May 01 21:08:03 architect hass[24888]:     artworkWidth: 512.0
May 01 21:08:03 architect hass[24888]:     artworkHeight: -1.0
May 01 21:08:03 architect hass[24888]:     requestID: "9E3B5A5E-901F-4546-BE27-8CA9209F12F2"
May 01 21:08:03 architect hass[24888]:   }
May 01 21:08:03 architect hass[24888]: }
May 01 21:08:03 architect hass[24888]: 2020-05-01 21:08:03 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08212000b202afa403080212bca3030ab8a3030a140a12657069736f64652d323631353031312d313912f2a2030a12657069736f64652d323631353031312d31391ad4a203ffd8ffe10ffe4578696600004d4d002a000000080005011a0005000000010000004a011b0005000000010000005201280003000000010002000002130003000000010001000087690004000000010000005a00000000000000480000000100000048000000010007900000070000000430323231910100070000000401020300a00000070000000430313030a00100030000000100010000a00200040000000100000200a00300040000000100000200a406000300000001000...)
May 01 21:08:03 architect hass[24888]: 2020-05-01 21:08:03 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: type: TRANSACTION_MESSAGE
May 01 21:08:03 architect hass[24888]: errorCode: NoError
May 01 21:08:03 architect hass[24888]: [transactionMessage] {
May 01 21:08:03 architect hass[24888]:   name: 2
May 01 21:08:03 architect hass[24888]:   packets {
May 01 21:08:03 architect hass[24888]:     packets {
May 01 21:08:03 architect hass[24888]:       key {
May 01 21:08:03 architect hass[24888]:         identifier: "episode-2615011-19"
May 01 21:08:03 architect hass[24888]:       }
May 01 21:08:03 architect hass[24888]:       packetData: "\n\022episode-2615011-19\032\324\242\003\377\330\377\341\017\376Exif\000\000MM\000*\000\000\000\010\000\005\001\032\000\005\000\...
May 01 21:08:03 architect hass[24888]:       identifier: "DDD9A775-8882-4FDD-BED6-471611B35926"
May 01 21:08:03 architect hass[24888]:       totalLength: 53618
May 01 21:08:03 architect hass[24888]:       totalWritePosition: 0
May 01 21:08:03 architect hass[24888]:     }
May 01 21:08:03 architect hass[24888]:   }
May 01 21:08:03 architect hass[24888]:   playerPath {
May 01 21:08:03 architect hass[24888]:     origin {
May 01 21:08:03 architect hass[24888]:       type: Local
May 01 21:08:03 architect hass[24888]:       displayName: "switch"
May 01 21:08:03 architect hass[24888]:       identifier: 1280262988
May 01 21:08:03 architect hass[24888]:     }
May 01 21:08:03 architect hass[24888]:     client {
May 01 21:08:03 architect hass[24888]:       processIdentifier: 1737
May 01 21:08:03 architect hass[24888]:       bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:08:03 architect hass[24888]:       processUserIdentifier: 501
May 01 21:08:03 architect hass[24888]:       displayName: "Molotov"
May 01 21:08:03 architect hass[24888]:     }
May 01 21:08:03 architect hass[24888]:     player {
May 01 21:08:03 architect hass[24888]:       identifier: "MediaRemote-DefaultPlayer"
May 01 21:08:03 architect hass[24888]:       displayName: "Default Player"
May 01 21:08:03 architect hass[24888]:     }
May 01 21:08:03 architect hass[24888]:   }
May 01 21:08:03 architect hass[24888]: }
May 01 21:08:03 architect hass[24888]: 2020-05-01 21:08:03 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08342000c203510d0000803e122432334337363542352d353230442d343136332d394230362d3844334342453430373237301a2443393334463538352d423942382d343533352d384646392d413244353543353334423544)
May 01 21:08:03 architect hass[24888]: 2020-05-01 21:08:03 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: errorCode: NoError
May 01 21:08:03 architect hass[24888]: 2020-05-01 21:08:03 INFO (MainThread) [homeassistant.components.automation] Mode film quand l'Apple TV joue le soir: Test condition sun: True
May 01 21:08:03 architect hass[24888]: 2020-05-01 21:08:03 INFO (MainThread) [homeassistant.components.automation] Mode film quand l'Apple TV joue le soir: Executing step call service
May 01 21:08:03 architect hass[24888]: 2020-05-01 21:08:03 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=68a201aba3130bc4bbfd5b68cedfe1a1d812e3bfa70511ef168ef8ec8941bf186c9c0db0ad29ffeaf16b1ed8f44efe4b31e4f5cbf53c0d717b1283a35b6f4da2f29a6ae2fa5ceedffdf9b0e72ecd7f0d8199493ba49cfae6bf5f10837c70a1d2423bc908e4ca010514)
May 01 21:08:03 architect hass[24888]: 2020-05-01 21:08:03 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08342000c203510d0000403e122432334337363542352d353230442d343136332d394230362d3844334342453430373237301a2443393334463538352d423942382d343533352d384646392d413244353543353334423544)
May 01 21:08:03 architect hass[24888]: 2020-05-01 21:08:03 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: errorCode: NoError
May 01 21:08:04 architect hass[24888]: 2020-05-01 21:08:04 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=68f69d3d637cffd5137070cb4483d862384ea00c893a326cb44de074091cdcd8d0b6e4e107a8798a0d608fe4354ff5b064a6e9e30b80a0d18425fc4006742b78801d92daa92c332eb2d16d42fc4ce1695b6af884e3a5e6c254f47b47cbab74d1847df31aaa92d64249)
May 01 21:08:05 architect hass[24888]: 2020-05-01 21:08:04 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08342000c203510d0000803e122432334337363542352d353230442d343136332d394230362d3844334342453430373237301a2443393334463538352d423942382d343533352d384646392d413244353543353334423544)
May 01 21:08:05 architect hass[24888]: 2020-05-01 21:08:05 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: errorCode: NoError
May 01 21:08:05 architect hass[24888]: 2020-05-01 21:08:05 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=686c74a82d79afc28dc56fbc33626d6d6a8b133c9f24ab5d7d5064aaa70cee65bfe5c6ba35f5d86a169a2e55c442bdb6e24694a1f3ab838045aa23ee239a4e7d5b8b3398fc54ad98aa4e015a60a5c6b309afd8f6c2fac89e5b882593c8fcb4169691326f3b0e207468)
May 01 21:08:05 architect hass[24888]: 2020-05-01 21:08:05 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08342000c203510d0000a03e122432334337363542352d353230442d343136332d394230362d3844334342453430373237301a2443393334463538352d423942382d343533352d384646392d413244353543353334423544)
May 01 21:08:05 architect hass[24888]: 2020-05-01 21:08:05 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: errorCode: NoError
May 01 21:08:05 architect hass[24888]: 2020-05-01 21:08:05 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=68663aa8220ccf5dfbd5214f7155378e751ee4c244d9dff3cbc1fa9f73ce9f1c746f46b852868df1be93006d31552044a4eb61d39eed7cb35e73ad7a6a7d13843b0617c22cc059ca2a777357ccea2e30b8d00cb26f55dd72cfbdfdf07d4c2423ef5e3608a3bd8fb360)
May 01 21:08:05 architect hass[24888]: 2020-05-01 21:08:05 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08342000c203510d0000c03e122432334337363542352d353230442d343136332d394230362d3844334342453430373237301a2443393334463538352d423942382d343533352d384646392d413244353543353334423544)
May 01 21:08:05 architect hass[24888]: 2020-05-01 21:08:05 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: errorCode: NoError
May 01 21:08:05 architect hass[24888]: 2020-05-01 21:08:05 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=68b8246139e7199040692852c19ee7093150e9d68f2a0b6f7b1cea5086c0315a27816f3271e8defc85a8a036739837b2b3a3bc3168254383b670a62c18770e9920c4159ec3ac95e0134c0886bf8bd49ef1143401ca1e8f362f719e577c395d0a78e966f3a4df19c7aa)
May 01 21:08:05 architect hass[24888]: 2020-05-01 21:08:05 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08342000c203510d0000e03e122432334337363542352d353230442d343136332d394230362d3844334342453430373237301a2443393334463538352d423942382d343533352d384646392d413244353543353334423544)
May 01 21:08:05 architect hass[24888]: 2020-05-01 21:08:05 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: errorCode: NoError
May 01 21:08:05 architect hass[24888]: 2020-05-01 21:08:05 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=6852272ee3b9a9fc9ebe424031496ea9eec0e653e636d6afdd851aac6137a6c592dab8bea139582715dce628819f3d11b26a10efb00ad52c35f312d4f497694f958db80d0b5b63acf77640103d581a490310aec99b4909cedc7b0413969dc563c429d72e815657a36f)
May 01 21:08:05 architect hass[24888]: 2020-05-01 21:08:05 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08342000c203510d0000003f122432334337363542352d353230442d343136332d394230362d3844334342453430373237301a2443393334463538352d423942382d343533352d384646392d413244353543353334423544)
May 01 21:08:05 architect hass[24888]: 2020-05-01 21:08:05 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: errorCode: NoError
May 01 21:08:06 architect hass[24888]: 2020-05-01 21:08:06 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=688ce6a100af4ef1c4f53a1fef7c29c2e3049532aaae5ccbad19e3a0cc4f0a4b3670a0e54fd37585e8d60e8b82faaaa46242c9172b11e65782b9bc6416b2e3903b1f2ffae64a98a5b651d96d4a17ef7118b30a03209dffcc5bf8925f8fc643759ace0d58b4d18a6e1b)
May 01 21:08:06 architect hass[24888]: 2020-05-01 21:08:06 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08342000c203510d0000103f122432334337363542352d353230442d343136332d394230362d3844334342453430373237301a2443393334463538352d423942382d343533352d384646392d413244353543353334423544)
May 01 21:08:06 architect hass[24888]: 2020-05-01 21:08:06 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: errorCode: NoError
May 01 21:08:06 architect hass[24888]: 2020-05-01 21:08:06 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=6825cc1b2f25f55ff18bf6b43f1f3239c15cf90835306d98e45404ccabe7acce27ae6b2beb67e8ad02f218f1d1025a0a25551b87367a8cfb6d0481225a608fbe717fa4cccb4afce795d765ba2043b5447fbdde3abd4be279f3bbdaba9d81d0027c64ed3f3c8ad3d735)
May 01 21:08:06 architect hass[24888]: 2020-05-01 21:08:06 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08342000c203510d0000203f122432334337363542352d353230442d343136332d394230362d3844334342453430373237301a2443393334463538352d423942382d343533352d384646392d413244353543353334423544)
May 01 21:08:06 architect hass[24888]: 2020-05-01 21:08:06 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: errorCode: NoError
May 01 21:08:06 architect hass[24888]: 2020-05-01 21:08:06 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=68bfaee23d3014bc3a30305e753bbd5a8b0844faf6dbf86df9a16ae2181246a669a34e40a7b06b09ed85feaa7ce61b63c5de88accf018a92d62525b5a6cc728865733ca1a049b6150259d0b9dd38dfe6bba6accab4b119795d7c40aed2291a07ae0ec7c901a8a2906f)
May 01 21:08:06 architect hass[24888]: 2020-05-01 21:08:06 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08342000c203510d0000103f122432334337363542352d353230442d343136332d394230362d3844334342453430373237301a2443393334463538352d423942382d343533352d384646392d413244353543353334423544)
May 01 21:08:06 architect hass[24888]: 2020-05-01 21:08:06 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: errorCode: NoError
May 01 21:08:06 architect hass[24888]: 2020-05-01 21:08:06 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=68dfc3a8895749e746dce68a8b49d43cbfc1abc81183772a4686e2fcdedbc05a25b9ed2ff1501d700d6c66c6efebc9833f1dfb6f90d3ed36ddde1f2b33b2bb964ffc2e9b8b8f381c1678082a669def43bd66bd7d298135291f787c153ac16b34ed87ff6119342862cd)
May 01 21:08:06 architect hass[24888]: 2020-05-01 21:08:06 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08342000c203510d0000003f122432334337363542352d353230442d343136332d394230362d3844334342453430373237301a2443393334463538352d423942382d343533352d384646392d413244353543353334423544)
May 01 21:08:06 architect hass[24888]: 2020-05-01 21:08:06 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: errorCode: NoError
May 01 21:08:07 architect hass[24888]: 2020-05-01 21:08:07 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=6870b64bb70d088b6a20ba3ba804f41fe70394d3e6e796b338ce6c8b0318343760a99576666aeae534127d4881ec28f4438442040c4e0eb1c16f128faf072e3549e9ad02f825636089036079e570f9fdcba8c13c28a56727c8b5e062bdacc398b2a3d9ed099f0d1790)
May 01 21:08:07 architect hass[24888]: 2020-05-01 21:08:07 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08342000c203510d0000e03e122432334337363542352d353230442d343136332d394230362d3844334342453430373237301a2443393334463538352d423942382d343533352d384646392d413244353543353334423544)
May 01 21:08:07 architect hass[24888]: 2020-05-01 21:08:07 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: errorCode: NoError
May 01 21:08:07 architect hass[24888]: 2020-05-01 21:08:07 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=6839650645b0aec13d68f419de287ffdf0985d807d73bdce67b1760b49765f553be84ee0fb849a4b757b87ccb6fdae818cc3561aab8b374735fd3fc3ee8e5444670aba5a8191d459d1457d9dde63ff16241f55238fcaa0f392ec020f4e8c0c63bf7b48def05409d57a)
May 01 21:08:07 architect hass[24888]: 2020-05-01 21:08:07 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08342000c203510d0000c03e122432334337363542352d353230442d343136332d394230362d3844334342453430373237301a2443393334463538352d423942382d343533352d384646392d413244353543353334423544)
May 01 21:08:07 architect hass[24888]: 2020-05-01 21:08:07 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: errorCode: NoError
May 01 21:08:07 architect hass[24888]: 2020-05-01 21:08:07 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=68d3e11f57e06388e8ad804d4acba2299ac7880f87d30a610fa9df979e7d0e01003496c10595fba1d2fef3093c3fc0b70e8c020909349f686fb3788217db11b684dd4ed5942296137ff06f27bcc9b01dde3c2ee7fe9581b4b75b45902a067776923293add60742f4a1)
May 01 21:08:07 architect hass[24888]: 2020-05-01 21:08:07 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08342000c203510d0000a03e122432334337363542352d353230442d343136332d394230362d3844334342453430373237301a2443393334463538352d423942382d343533352d384646392d413244353543353334423544)
May 01 21:08:07 architect hass[24888]: 2020-05-01 21:08:07 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: errorCode: NoError
May 01 21:08:07 architect hass[24888]: 2020-05-01 21:08:07 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=681aba8635c0386e5dc6e258099ff7fe293a79c47d564ae36e3959057459e94e89cdd23d3ec836cfb8f1ada21f60c62d21355cbcd4dde010560116bc60691b1bad494abdf0bbd3dfd091d645d94d0a371f18ba8b8acb5338ee823fc56c278cad0b5b08b3a8988c4407)
May 01 21:08:07 architect hass[24888]: 2020-05-01 21:08:07 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08342000c203510d0000803e122432334337363542352d353230442d343136332d394230362d3844334342453430373237301a2443393334463538352d423942382d343533352d384646392d413244353543353334423544)
May 01 21:08:07 architect hass[24888]: 2020-05-01 21:08:07 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: errorCode: NoError
May 01 21:08:07 architect hass[24888]: 2020-05-01 21:08:07 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=68830a8e539000ac7fcc24b36149fe64e41fc4b52f984c0999543533eacf08aa52f552cf1b46adccc0333b9c0298904a87dabff221c2be7dbdaf90fa8477872ce05adb6fb20d234042d3393ba505ae9be155262257a55bf17c9f9b7995df97bea695e6a0d81ded8045)
May 01 21:08:07 architect hass[24888]: 2020-05-01 21:08:07 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08342000c203510d0000403e122432334337363542352d353230442d343136332d394230362d3844334342453430373237301a2443393334463538352d423942382d343533352d384646392d413244353543353334423544)
May 01 21:08:07 architect hass[24888]: 2020-05-01 21:08:07 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: errorCode: NoError
May 01 21:08:13 architect hass[24888]: 2020-05-01 21:08:13 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=820180977d2e6f365a503ab1cbe060774264b3ec15fdf7a44d4b805ea66d384541f885a830d980aaba34ba06bf9df2984afeebfd6ba9a5d7dc4ae849c7f85679bf02dcd459faf774b69096b6d19cfee03bdb5a84f4e03d1375990084c360ab3ca26ab9b69c53ad2a105429d279f71b23581692b7683451ce5056b16111c1ecfdaa0022d5)
May 01 21:08:13 architect hass[24888]: 2020-05-01 21:08:13 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=080420004a6c30024a5f0a100801120673776974636818cc86bde204121e08c90d121974762e6d6f6c6f746f762e4d6f6c6f746f7641707050726f641a2b0a194d6564696152656d6f74652d44656661756c74506c61796572120e44656661756c7420506c617965725980d6b28e552ec241)
May 01 21:08:13 architect hass[24888]: 2020-05-01 21:08:13 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: type: SET_STATE_MESSAGE
May 01 21:08:13 architect hass[24888]: errorCode: NoError
May 01 21:08:13 architect hass[24888]: [setStateMessage] {
May 01 21:08:13 architect hass[24888]:   playbackState: Paused
May 01 21:08:13 architect hass[24888]:   playerPath {
May 01 21:08:13 architect hass[24888]:     origin {
May 01 21:08:13 architect hass[24888]:       type: Local
May 01 21:08:13 architect hass[24888]:       displayName: "switch"
May 01 21:08:13 architect hass[24888]:       identifier: 1280262988
May 01 21:08:13 architect hass[24888]:     }
May 01 21:08:13 architect hass[24888]:     client {
May 01 21:08:13 architect hass[24888]:       processIdentifier: 1737
May 01 21:08:13 architect hass[24888]:       bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:08:13 architect hass[24888]:     }
May 01 21:08:13 architect hass[24888]:     player {
May 01 21:08:13 architect hass[24888]:       identifier: "MediaRemote-DefaultPlayer"
May 01 21:08:13 architect hass[24888]:       displayName: "Default Player"
May 01 21:08:13 architect hass[24888]:     }
May 01 21:08:13 architect hass[24888]:   }
May 01 21:08:13 architect hass[24888]:   playbackStateTimestamp: 610052893.397171
May 01 21:08:13 architect hass[24888]: }
May 01 21:08:13 architect hass[24888]: 2020-05-01 21:08:13 DEBUG (MainThread) [pyatv.mrp.protocol] Dispatching message with type 4 (SetStateMessage) to Listener(func=>, data=None)
May 01 21:08:14 architect hass[24888]: 2020-05-01 21:08:14 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=bb0757b21c6a4a3059d24e8281f4a4e3fe8b2b4dd09c95038a8e61bdf3810a7bb8574b59eeddd1d040122e4f86315ef7e4476ec018d2d25dfd90912d28be2408389c4b5e2266ab8d081e38877b3d3e53393df127cec17fc58252fe88c5e2d092b267c67a641b260db04cfec744895d5748897a0948e5c648c11e77f7399106a9f5ae1880ef2798f3be71b535adcf136f5dfcc895324c10a70a0d2249f32399d71bfbdb5f0f8184e8ed9694884e595b556c5d64274bbad6df99bb563b4ca51885830ede83349cda612d3140ed427d4075b9d31ec3acf47949362ed0d64a4548f64e45b353dca2008ef5f835b425924ff9e0361474271a7ab7b4601cd83ef8e...)
May 01 21:08:14 architect hass[24888]: 2020-05-01 21:08:14 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=080420004aa4071ac006080012bb060a12657069736f64652d323631343836312d3436129e060a2b4b6f682d4c616e74612c206c27c3ae6c65206465732068c3a9726f7320e280a220457069736f64652031302d000000003a03544631980101fa010a696d6167652f6a706567a80201bd0200000000e20212657069736f64652d323631343836312d34368004028804009a049b0362706c6973743030d4010203040506070a582476657273696f6e592461726368697665725424746f7058246f626a6563747312000186a05f100f4e534b657965644172636869766572d1080954726f6f748001a70b0c1718191a1b55246e756c6cd30d0e0f101316574...)
May 01 21:08:14 architect hass[24888]: 2020-05-01 21:08:14 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: type: SET_STATE_MESSAGE
May 01 21:08:14 architect hass[24888]: errorCode: NoError
May 01 21:08:14 architect hass[24888]: [setStateMessage] {
May 01 21:08:14 architect hass[24888]:   playbackQueue {
May 01 21:08:14 architect hass[24888]:     location: 0
May 01 21:08:14 architect hass[24888]:     contentItems {
May 01 21:08:14 architect hass[24888]:       identifier: "episode-2614861-46"
May 01 21:08:14 architect hass[24888]:       metadata {
May 01 21:08:14 architect hass[24888]:         title: "Koh-Lanta, l\'\303\256le des h\303\251ros \342\200\242 Episode 10"
May 01 21:08:14 architect hass[24888]:         playbackProgress: 0.0
May 01 21:08:14 architect hass[24888]:         trackArtistName: "TF1"
May 01 21:08:14 architect hass[24888]:         artworkAvailable: true
May 01 21:08:14 architect hass[24888]:         artworkMIMEType: "image/jpeg"
May 01 21:08:14 architect hass[24888]:         isAlwaysLive: true
May 01 21:08:14 architect hass[24888]:         playbackRate: 0.0
May 01 21:08:14 architect hass[24888]:         contentIdentifier: "episode-2614861-46"
May 01 21:08:14 architect hass[24888]:         mediaType: Video
May 01 21:08:14 architect hass[24888]:         mediaSubType: UnknownMediaSubType
May 01 21:08:14 architect hass[24888]:         nowPlayingInfoData: "bplist00\324\001\002\003\004\005\006\007\nX$versionY$archiverT$topX$objects\022\000\001\206\240_\020\017NSKeyedArchive...
May 01 21:08:14 architect hass[24888]:         elapsedTimeTimestamp: 610052893.536444
May 01 21:08:14 architect hass[24888]:         currentPlaybackDateData: "bplist00\324\001\002\003\004\005\006\007\nX$versionY$archiverT$topX$objects\022\000\001\206\240_\020\017NSKeyedAr...
May 01 21:08:14 architect hass[24888]:         artworkIdentifier: "21281952-3E24-4534-9B0C-6C5A3DF1DF6C"
May 01 21:08:14 architect hass[24888]:       }
May 01 21:08:14 architect hass[24888]:       artworkDataWidth: 768
May 01 21:08:14 architect hass[24888]:       artworkDataHeight: 768
May 01 21:08:14 architect hass[24888]:     }
May 01 21:08:14 architect hass[24888]:   }
May 01 21:08:14 architect hass[24888]:   playerPath {
May 01 21:08:14 architect hass[24888]:     origin {
May 01 21:08:14 architect hass[24888]:       type: Local
May 01 21:08:14 architect hass[24888]:       displayName: "switch"
May 01 21:08:14 architect hass[24888]:       identifier: 1280262988
May 01 21:08:14 architect hass[24888]:     }
May 01 21:08:14 architect hass[24888]:     client {
May 01 21:08:14 architect hass[24888]:       processIdentifier: 1737
May 01 21:08:14 architect hass[24888]:       bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:08:14 architect hass[24888]:     }
May 01 21:08:14 architect hass[24888]:     player {
May 01 21:08:14 architect hass[24888]:       identifier: "MediaRemote-DefaultPlayer"
May 01 21:08:14 architect hass[24888]:       displayName: "Default Player"
May 01 21:08:14 architect hass[24888]:     }
May 01 21:08:14 architect hass[24888]:   }
May 01 21:08:14 architect hass[24888]: }
May 01 21:08:14 architect hass[24888]: 2020-05-01 21:08:14 DEBUG (MainThread) [pyatv.mrp.protocol] Dispatching message with type 4 (SetStateMessage) to Listener(func=>, data=None)
May 01 21:08:14 architect hass[24888]: 2020-05-01 21:08:14 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08382000e20399070ab5060a12657069736f64652d323631343836312d3436129e060a2b4b6f682d4c616e74612c206c27c3ae6c65206465732068c3a9726f7320e280a220457069736f64652031302d000000003a03544631980101fa010a696d6167652f6a706567a80201bd0200000000e20212657069736f64652d323631343836312d34368004028804009a049b0362706c6973743030d4010203040506070a582476657273696f6e592461726368697665725424746f7058246f626a6563747312000186a05f100f4e534b657965644172636869766572d1080954726f6f748001a70b0c1718191a1b55246e756c6cd30d0e0f101316574e532e6b6...)
May 01 21:08:14 architect hass[24888]: 2020-05-01 21:08:14 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: type: UPDATE_CONTENT_ITEM_MESSAGE
May 01 21:08:14 architect hass[24888]: errorCode: NoError
May 01 21:08:14 architect hass[24888]: [updateContentItemMessage] {
May 01 21:08:14 architect hass[24888]:   contentItems {
May 01 21:08:14 architect hass[24888]:     identifier: "episode-2614861-46"
May 01 21:08:14 architect hass[24888]:     metadata {
May 01 21:08:14 architect hass[24888]:       title: "Koh-Lanta, l\'\303\256le des h\303\251ros \342\200\242 Episode 10"
May 01 21:08:14 architect hass[24888]:       playbackProgress: 0.0
May 01 21:08:14 architect hass[24888]:       trackArtistName: "TF1"
May 01 21:08:14 architect hass[24888]:       artworkAvailable: true
May 01 21:08:14 architect hass[24888]:       artworkMIMEType: "image/jpeg"
May 01 21:08:14 architect hass[24888]:       isAlwaysLive: true
May 01 21:08:14 architect hass[24888]:       playbackRate: 0.0
May 01 21:08:14 architect hass[24888]:       contentIdentifier: "episode-2614861-46"
May 01 21:08:14 architect hass[24888]:       mediaType: Video
May 01 21:08:14 architect hass[24888]:       mediaSubType: UnknownMediaSubType
May 01 21:08:14 architect hass[24888]:       nowPlayingInfoData: "bplist00\324\001\002\003\004\005\006\007\nX$versionY$archiverT$topX$objects\022\000\001\206\240_\020\017NSKeyedArchiver\...
May 01 21:08:14 architect hass[24888]:       elapsedTimeTimestamp: 610052894.082717
May 01 21:08:14 architect hass[24888]:       currentPlaybackDateData: "bplist00\324\001\002\003\004\005\006\007\nX$versionY$archiverT$topX$objects\022\000\001\206\240_\020\017NSKeyedArch...
May 01 21:08:14 architect hass[24888]:       artworkIdentifier: "6A9D5EC2-F194-4FA1-8C65-FBE4AC3A22FA"
May 01 21:08:14 architect hass[24888]:     }
May 01 21:08:14 architect hass[24888]:   }
May 01 21:08:14 architect hass[24888]:   playerPath {
May 01 21:08:14 architect hass[24888]:     origin {
May 01 21:08:14 architect hass[24888]:       type: Local
May 01 21:08:14 architect hass[24888]:       displayName: "switch"
May 01 21:08:14 architect hass[24888]:       identifier: 1280262988
May 01 21:08:14 architect hass[24888]:     }
May 01 21:08:14 architect hass[24888]:     client {
May 01 21:08:14 architect hass[24888]:       processIdentifier: 1737
May 01 21:08:14 architect hass[24888]:       bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:08:14 architect hass[24888]:     }
May 01 21:08:14 architect hass[24888]:     player {
May 01 21:08:14 architect hass[24888]:       identifier: "MediaRemote-DefaultPlayer"
May 01 21:08:14 architect hass[24888]:       displayName: "Default Player"
May 01 21:08:14 architect hass[24888]:     }
May 01 21:08:14 architect hass[24888]:   }
May 01 21:08:14 architect hass[24888]: }
May 01 21:08:14 architect hass[24888]: 2020-05-01 21:08:14 DEBUG (MainThread) [pyatv.mrp.protocol] Dispatching message with type 56 (UpdateContentItemMessage) to Listener(func=>, data=None)
May 01 21:08:15 architect hass[24888]: 2020-05-01 21:08:15 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=820173b123a3c19ecf6ce96a84e43a5eaef449b550f968d7184bc7ce5a68cfc626e84124aa6e548db417693a0e219e3e98cb9af0f96a0390c65cf8a948c751b4e9286f80130549e8f819b84dfef1b417d3f0e8b2d18e2807d7b79ab8f21f186dcf648bdc1210cdae53435eb81e203d2d97c7fa96577e80350da35b85fd67dc7eae2f48b0b507b82986bcd3e25a89401ad3c817ac6442eb6ba76d0e376839b048541cfa29ac959957a868b3ca6a7226b799da5184623aa410757b8771b47fe30738a73f5e8d044d93681a6a682f907c9a1f7fba56f9e588db4184e749b250ee375d097e350c800a20a380ccae3cb853e3677783f4b36edb9765f64c4c74d1b...)
May 01 21:08:15 architect hass[24888]: 2020-05-01 21:08:15 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=080420004a6c30014a5f0a100801120673776974636818cc86bde204121e08c90d121974762e6d6f6c6f746f762e4d6f6c6f746f7641707050726f641a2b0a194d6564696152656d6f74652d44656661756c74506c61796572120e44656661756c7420506c61796572593c9f2b8f552ec241)
May 01 21:08:15 architect hass[24888]: 2020-05-01 21:08:15 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: type: SET_STATE_MESSAGE
May 01 21:08:15 architect hass[24888]: errorCode: NoError
May 01 21:08:15 architect hass[24888]: [setStateMessage] {
May 01 21:08:15 architect hass[24888]:   playbackState: Playing
May 01 21:08:15 architect hass[24888]:   playerPath {
May 01 21:08:15 architect hass[24888]:     origin {
May 01 21:08:15 architect hass[24888]:       type: Local
May 01 21:08:15 architect hass[24888]:       displayName: "switch"
May 01 21:08:15 architect hass[24888]:       identifier: 1280262988
May 01 21:08:15 architect hass[24888]:     }
May 01 21:08:15 architect hass[24888]:     client {
May 01 21:08:15 architect hass[24888]:       processIdentifier: 1737
May 01 21:08:15 architect hass[24888]:       bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:08:15 architect hass[24888]:     }
May 01 21:08:15 architect hass[24888]:     player {
May 01 21:08:15 architect hass[24888]:       identifier: "MediaRemote-DefaultPlayer"
May 01 21:08:15 architect hass[24888]:       displayName: "Default Player"
May 01 21:08:15 architect hass[24888]:     }
May 01 21:08:15 architect hass[24888]:   }
May 01 21:08:15 architect hass[24888]:   playbackStateTimestamp: 610052894.340797
May 01 21:08:15 architect hass[24888]: }
May 01 21:08:15 architect hass[24888]: 2020-05-01 21:08:15 DEBUG (MainThread) [pyatv.mrp.protocol] Dispatching message with type 4 (SetStateMessage) to Listener(func=>, data=None)
May 01 21:08:15 architect hass[24888]: 2020-05-01 21:08:15 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08382000e2039d070ab9060a12657069736f64652d323631343836312d343612a2060a2b4b6f682d4c616e74612c206c27c3ae6c65206465732068c3a9726f7320e280a220457069736f64652031302d000000003a03544631980101fa010a696d6167652f6a706567a80201bd020000803fe20212657069736f64652d323631343836312d34368004028804009a049b0362706c6973743030d4010203040506070a582476657273696f6e592461726368697665725424746f7058246f626a6563747312000186a05f100f4e534b657965644172636869766572d1080954726f6f748001a70b0c1718191a1b55246e756c6cd30d0e0f101316574e532e6b6...)
May 01 21:08:15 architect hass[24888]: 2020-05-01 21:08:15 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: type: UPDATE_CONTENT_ITEM_MESSAGE
May 01 21:08:15 architect hass[24888]: errorCode: NoError
May 01 21:08:15 architect hass[24888]: [updateContentItemMessage] {
May 01 21:08:15 architect hass[24888]:   contentItems {
May 01 21:08:15 architect hass[24888]:     identifier: "episode-2614861-46"
May 01 21:08:15 architect hass[24888]:     metadata {
May 01 21:08:15 architect hass[24888]:       title: "Koh-Lanta, l\'\303\256le des h\303\251ros \342\200\242 Episode 10"
May 01 21:08:15 architect hass[24888]:       playbackProgress: 0.0
May 01 21:08:15 architect hass[24888]:       trackArtistName: "TF1"
May 01 21:08:15 architect hass[24888]:       artworkAvailable: true
May 01 21:08:15 architect hass[24888]:       artworkMIMEType: "image/jpeg"
May 01 21:08:15 architect hass[24888]:       isAlwaysLive: true
May 01 21:08:15 architect hass[24888]:       playbackRate: 1.0
May 01 21:08:15 architect hass[24888]:       contentIdentifier: "episode-2614861-46"
May 01 21:08:15 architect hass[24888]:       mediaType: Video
May 01 21:08:15 architect hass[24888]:       mediaSubType: UnknownMediaSubType
May 01 21:08:15 architect hass[24888]:       nowPlayingInfoData: "bplist00\324\001\002\003\004\005\006\007\nX$versionY$archiverT$topX$objects\022\000\001\206\240_\020\017NSKeyedArchiver\...
May 01 21:08:15 architect hass[24888]:       elapsedTimeTimestamp: 610052894.776711
May 01 21:08:15 architect hass[24888]:       currentPlaybackDateData: "bplist00\324\001\002\003\004\005\006\007\nX$versionY$archiverT$topX$objects\022\000\001\206\240_\020\017NSKeyedArch...
May 01 21:08:15 architect hass[24888]:       artworkIdentifier: "9c5b2bc4411e6d82c3c1796301ab3cf9d5caf49a"
May 01 21:08:15 architect hass[24888]:     }
May 01 21:08:15 architect hass[24888]:   }
May 01 21:08:15 architect hass[24888]:   playerPath {
May 01 21:08:15 architect hass[24888]:     origin {
May 01 21:08:15 architect hass[24888]:       type: Local
May 01 21:08:15 architect hass[24888]:       displayName: "switch"
May 01 21:08:15 architect hass[24888]:       identifier: 1280262988
May 01 21:08:15 architect hass[24888]:     }
May 01 21:08:15 architect hass[24888]:     client {
May 01 21:08:15 architect hass[24888]:       processIdentifier: 1737
May 01 21:08:15 architect hass[24888]:       bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:08:15 architect hass[24888]:     }
May 01 21:08:15 architect hass[24888]:     player {
May 01 21:08:15 architect hass[24888]:       identifier: "MediaRemote-DefaultPlayer"
May 01 21:08:15 architect hass[24888]:       displayName: "Default Player"
May 01 21:08:15 architect hass[24888]:     }
May 01 21:08:15 architect hass[24888]:   }
May 01 21:08:15 architect hass[24888]: }
May 01 21:08:15 architect hass[24888]: 2020-05-01 21:08:15 DEBUG (MainThread) [pyatv.mrp.protocol] Dispatching message with type 56 (UpdateContentItemMessage) to Listener(func=>, data=None)
May 01 21:08:18 architect hass[24888]: 2020-05-01 21:08:18 INFO (MainThread) [homeassistant.components.automation] Executing Mode film quand l'Apple TV joue le soir
May 01 21:08:18 architect hass[24888]: 2020-05-01 21:08:18 INFO (MainThread) [homeassistant.components.automation] Mode film quand l'Apple TV joue le soir: Running script
May 01 21:08:18 architect hass[24888]: 2020-05-01 21:08:18 INFO (MainThread) [homeassistant.components.automation] Mode film quand l'Apple TV joue le soir: Executing step call service
May 01 21:08:18 architect hass[24888]: 2020-05-01 21:08:18 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 >> Send (Data=0820122431383033646531342d376635382d343531662d623861612d6633383263366231353261302000aa02160800100121000000000000804029000000000000f0bf)
May 01 21:08:18 architect hass[24888]: 2020-05-01 21:08:18 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 >> Send (Encrypted=d80b527f90294f74064498ac21b3962c185dd8ecfcd9a2ae305cf6a6836887c0d40c12d422bc50e46527e0dcebd18362b6bf488e96ef30ef44175fb4f739f3fc45fc28d7fd44f8a2103b79a9ec7afe80a008a6)
May 01 21:08:18 architect hass[24888]: 2020-05-01 21:08:18 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 >> Send: Protobuf: type: PLAYBACK_QUEUE_REQUEST_MESSAGE
May 01 21:08:18 architect hass[24888]: identifier: "1803de14-7f58-451f-b8aa-f382c6b152a0"
May 01 21:08:18 architect hass[24888]: errorCode: NoError
May 01 21:08:18 architect hass[24888]: [playbackQueueRequestMessage] {
May 01 21:08:18 architect hass[24888]:   location: 0
May 01 21:08:18 architect hass[24888]:   length: 1
May 01 21:08:18 architect hass[24888]:   artworkWidth: 512
May 01 21:08:18 architect hass[24888]:   artworkHeight: -1
May 01 21:08:18 architect hass[24888]: }
May 01 21:08:18 architect hass[24888]: 2020-05-01 21:08:18 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 >> Send (Data=0820122466646266303837312d646435312d346561622d623534612d6439353134333930393533332000aa02160800100121000000000000804029000000000000f0bf)
May 01 21:08:18 architect hass[24888]: 2020-05-01 21:08:18 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 >> Send (Encrypted=eee346cfea2ea8caa0db7d6b146f967f9c7fbb42e3f588662db41c2326954d38ed9927b136b60b7694bd392b49371b925684b9d26110710a81ebe61f3cb051a7ad859316c657fd41f1df2c9c70ddb372211034)
May 01 21:08:18 architect hass[24888]: 2020-05-01 21:08:18 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 >> Send: Protobuf: type: PLAYBACK_QUEUE_REQUEST_MESSAGE
May 01 21:08:18 architect hass[24888]: identifier: "fdbf0871-dd51-4eab-b54a-d95143909533"
May 01 21:08:18 architect hass[24888]: errorCode: NoError
May 01 21:08:18 architect hass[24888]: [playbackQueueRequestMessage] {
May 01 21:08:18 architect hass[24888]:   location: 0
May 01 21:08:18 architect hass[24888]:   length: 1
May 01 21:08:18 architect hass[24888]:   artworkWidth: 512
May 01 21:08:18 architect hass[24888]:   artworkHeight: -1
May 01 21:08:18 architect hass[24888]: }
May 01 21:08:18 architect hass[24888]: 2020-05-01 21:08:18 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=8cc2032f11ac13645be76cc064292625c94174748ec6917c296d84a5cfde4f3731c2adafeb70b7df782b9aa5f4eb304f75039462e24445f737003e3a18c21ea06366bd99e1a23b2ff4afca7c26d4a12268541b61b3a495feee3d36a5952a47c3f1d4e0b053f29e6dda3315e99c29b0b381f7e40e17052caa13785266a3420cf668c1eb77096aa5c29ffc3dbd568ed21f4fd8c84214ae74796b39ba6b2bbd583cf589f57a589d8be041a7685c43b8128f03f82a5d46e8479e3443d4eba1d062bfcf34606cbc0b10483f19c036fc3bff5b91d7a1bcadc1803a38a867c2d06b7614e0505306d1160bd93bcfc6f7ff8dd5b66b0a3eade27100f80411343aeaaed...)
May 01 21:08:18 architect hass[24888]: 2020-05-01 21:08:18 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 Require 57612 bytes but only 28957 in buffer
May 01 21:08:18 architect hass[24888]: 2020-05-01 21:08:18 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=e9971d76eb5f18163cc9ee86d3ee7e22df6f41c4829e99d850909aa922b9e1f1ae0839b92905486486e40e189c56a8bf43e3bd927271ddcd156032a783febc3f26ed4b7746c5a51ce283b1b0a3d67c9acdb47999d5b9ba3977f3b801b71ddae1171870dbe416d1dde52b2bdbf03b702a24ea3fe1b2688da3469729eb66bf878585c2cd255d4521a3a82883631197609b01e49dc7c9d53048a3bf9e5709e927f8c47a133483f5569980452748abf82d71a74b07e455cc4526a461dde2b1b711ee1a2fe950a748292f4ab8b756a79fb988bbad4cef919e948972444e007652cae56aa269704083e99d8d1bca7930873152cdb9dd89eed190b46e9c170160122...)
May 01 21:08:18 architect hass[24888]: 2020-05-01 21:08:18 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 Require 57612 bytes but only 30405 in buffer
May 01 21:08:18 architect hass[24888]: 2020-05-01 21:08:18 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=dacf0511a362777bb0fe85883b5ee99360ce3fbe2e14e3abb55bdf7449591c3c92dbdf7f6445fee8254dabf04a861963d0584db9049cb8a4052ea3ffc394a42a41599ebb462fbec1777c6d2688d2e1bb45e2f89db6dfeb8f259529e72ac143cdeb0584fc11f3fdd5e76f435a565e27e255a15a1ddc2b24ecf924c56697c53aa1f1c156c0a16db5a6b89ff9c4ac1055ea2c7f7ddde20062939cbf9ff37a077a972e59a747694f842e1ee428f4f1fcb8f939b599716ad727a6484b6e7fc4200b6cd4a2fdeca46e214faa3da84fc025c328a5e075ca0b798905e482cbf076fd2a8dd5162a8921225c811336df1fec658a3e8f9e3d718cc96e7cc1b0031abbb4d...)
May 01 21:08:18 architect hass[24888]: 2020-05-01 21:08:18 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=0804122431383033646531342d376635382d343531662d623861612d66333832633662313532613020004acec1031aabc00308001292bf030a12657069736f64652d323631343836312d34361af4be03ffd8ffe10ffe4578696600004d4d002a000000080005011a0005000000010000004a011b0005000000010000005201280003000000010002000002130003000000010001000087690004000000010000005a00000000000000480000000100000048000000010007900000070000000430323231910100070000000401020300a00000070000000430313030a00100030000000100010000a00200040000000100000200a00300040000000100000...)
May 01 21:08:18 architect hass[24888]: 2020-05-01 21:08:18 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: type: SET_STATE_MESSAGE
May 01 21:08:18 architect hass[24888]: identifier: "1803de14-7f58-451f-b8aa-f382c6b152a0"
May 01 21:08:18 architect hass[24888]: errorCode: NoError
May 01 21:08:18 architect hass[24888]: [setStateMessage] {
May 01 21:08:18 architect hass[24888]:   playbackQueue {
May 01 21:08:18 architect hass[24888]:     location: 0
May 01 21:08:18 architect hass[24888]:     contentItems {
May 01 21:08:18 architect hass[24888]:       identifier: "episode-2614861-46"
May 01 21:08:18 architect hass[24888]:       artworkData: "\377\330\377\341\017\376Exif\000\000MM\000*\000\000\000\010\000\005\001\032\000\005\000\000\000\001\000\000\000J\001\033\000\00...
May 01 21:08:18 architect hass[24888]:       artworkDataWidth: 512
May 01 21:08:18 architect hass[24888]:       artworkDataHeight: 512
May 01 21:08:18 architect hass[24888]:     }
May 01 21:08:18 architect hass[24888]:     requestId: "EA221183-FA31-44B0-9658-CAD5A1C723FC"
May 01 21:08:18 architect hass[24888]:     resolvedPlayerPath {
May 01 21:08:18 architect hass[24888]:       origin {
May 01 21:08:18 architect hass[24888]:         type: Local
May 01 21:08:18 architect hass[24888]:         displayName: "switch"
May 01 21:08:18 architect hass[24888]:         identifier: 1280262988
May 01 21:08:18 architect hass[24888]:       }
May 01 21:08:18 architect hass[24888]:       client {
May 01 21:08:18 architect hass[24888]:         processIdentifier: 1737
May 01 21:08:18 architect hass[24888]:         bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:08:18 architect hass[24888]:         processUserIdentifier: 501
May 01 21:08:18 architect hass[24888]:         displayName: "Molotov"
May 01 21:08:18 architect hass[24888]:       }
May 01 21:08:18 architect hass[24888]:       player {
May 01 21:08:18 architect hass[24888]:         identifier: "MediaRemote-DefaultPlayer"
May 01 21:08:18 architect hass[24888]:         displayName: "Default Player"
May 01 21:08:18 architect hass[24888]:       }
May 01 21:08:18 architect hass[24888]:     }
May 01 21:08:18 architect hass[24888]:   }
May 01 21:08:18 architect hass[24888]:   playerPath {
May 01 21:08:18 architect hass[24888]:     origin {
May 01 21:08:18 architect hass[24888]:       type: Local
May 01 21:08:18 architect hass[24888]:       displayName: "switch"
May 01 21:08:18 architect hass[24888]:       identifier: 1280262988
May 01 21:08:18 architect hass[24888]:     }
May 01 21:08:18 architect hass[24888]:     client {
May 01 21:08:18 architect hass[24888]:       processIdentifier: 1737
May 01 21:08:18 architect hass[24888]:       bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:08:18 architect hass[24888]:     }
May 01 21:08:18 architect hass[24888]:     player {
May 01 21:08:18 architect hass[24888]:       identifier: "MediaRemote-DefaultPlayer"
May 01 21:08:18 architect hass[24888]:       displayName: "Default Player"
May 01 21:08:18 architect hass[24888]:     }
May 01 21:08:18 architect hass[24888]:   }
May 01 21:08:18 architect hass[24888]:   request {
May 01 21:08:18 architect hass[24888]:     location: 0
May 01 21:08:18 architect hass[24888]:     length: 1
May 01 21:08:18 architect hass[24888]:     artworkWidth: 512.0
May 01 21:08:18 architect hass[24888]:     artworkHeight: -1.0
May 01 21:08:18 architect hass[24888]:     requestID: "EA221183-FA31-44B0-9658-CAD5A1C723FC"
May 01 21:08:18 architect hass[24888]:   }
May 01 21:08:18 architect hass[24888]: }
May 01 21:08:18 architect hass[24888]: 2020-05-01 21:08:18 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08212000b202cfc003080212dcbf030ad8bf030a140a12657069736f64652d323631343836312d34361292bf030a12657069736f64652d323631343836312d34361af4be03ffd8ffe10ffe4578696600004d4d002a000000080005011a0005000000010000004a011b0005000000010000005201280003000000010002000002130003000000010001000087690004000000010000005a00000000000000480000000100000048000000010007900000070000000430323231910100070000000401020300a00000070000000430313030a00100030000000100010000a00200040000000100000200a00300040000000100000200a406000300000001000...)
May 01 21:08:18 architect hass[24888]: 2020-05-01 21:08:18 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: type: TRANSACTION_MESSAGE
May 01 21:08:18 architect hass[24888]: errorCode: NoError
May 01 21:08:18 architect hass[24888]: [transactionMessage] {
May 01 21:08:18 architect hass[24888]:   name: 2
May 01 21:08:18 architect hass[24888]:   packets {
May 01 21:08:18 architect hass[24888]:     packets {
May 01 21:08:18 architect hass[24888]:       key {
May 01 21:08:18 architect hass[24888]:         identifier: "episode-2614861-46"
May 01 21:08:18 architect hass[24888]:       }
May 01 21:08:18 architect hass[24888]:       packetData: "\n\022episode-2614861-46\032\364\276\003\377\330\377\341\017\376Exif\000\000MM\000*\000\000\000\010\000\005\001\032\000\005\000\...
May 01 21:08:18 architect hass[24888]:       identifier: "1CE4F1AF-9EEF-418B-A802-227267F78F4D"
May 01 21:08:18 architect hass[24888]:       totalLength: 57234
May 01 21:08:18 architect hass[24888]:       totalWritePosition: 0
May 01 21:08:18 architect hass[24888]:     }
May 01 21:08:18 architect hass[24888]:   }
May 01 21:08:18 architect hass[24888]:   playerPath {
May 01 21:08:18 architect hass[24888]:     origin {
May 01 21:08:18 architect hass[24888]:       type: Local
May 01 21:08:18 architect hass[24888]:       displayName: "switch"
May 01 21:08:18 architect hass[24888]:       identifier: 1280262988
May 01 21:08:18 architect hass[24888]:     }
May 01 21:08:18 architect hass[24888]:     client {
May 01 21:08:18 architect hass[24888]:       processIdentifier: 1737
May 01 21:08:18 architect hass[24888]:       bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:08:18 architect hass[24888]:       processUserIdentifier: 501
May 01 21:08:18 architect hass[24888]:       displayName: "Molotov"
May 01 21:08:18 architect hass[24888]:     }
May 01 21:08:18 architect hass[24888]:     player {
May 01 21:08:18 architect hass[24888]:       identifier: "MediaRemote-DefaultPlayer"
May 01 21:08:18 architect hass[24888]:       displayName: "Default Player"
May 01 21:08:18 architect hass[24888]:     }
May 01 21:08:18 architect hass[24888]:   }
May 01 21:08:18 architect hass[24888]: }
May 01 21:08:18 architect hass[24888]: 2020-05-01 21:08:18 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=8cc203044737befa733cf3cb019ed5d3c0ff524cc9e43a7b34db7382f98eab7ec9046f474fa045efb3556ae8d4e632ae6b3e6758676953ccdd0aae37eaa0eb53e0ac1fe9a0220665f8ec28abd229e152b33aee7c7b2e923de1fa121b3e4d84fcc9ef4082d84f4ad3239bc88c31bc0c53204ef4d9603cc78932a569ebd4c04d5b92f3d6837410f32d640bf1d4d8bb8a0b9c3a21d1ee1041b932b0aa0a38fd5cab5a2b7143109a947d50d2f6fbf8004949f7fe48f1b59299cb3e076d81432d9b7d84be7647b0974faf0ff9a20c542431d1c0830a8a564505102b476075356cccd0f49106c3c14c4e77910a6a39eb1b96f0e850c070f138c79fe140f054ef880...)
May 01 21:08:18 architect hass[24888]: 2020-05-01 21:08:18 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=0804122466646266303837312d646435312d346561622d623534612d64393531343339303935333320004acec1031aabc00308001292bf030a12657069736f64652d323631343836312d34361af4be03ffd8ffe10ffe4578696600004d4d002a000000080005011a0005000000010000004a011b0005000000010000005201280003000000010002000002130003000000010001000087690004000000010000005a00000000000000480000000100000048000000010007900000070000000430323231910100070000000401020300a00000070000000430313030a00100030000000100010000a00200040000000100000200a00300040000000100000...)
May 01 21:08:18 architect hass[24888]: 2020-05-01 21:08:18 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: type: SET_STATE_MESSAGE
May 01 21:08:18 architect hass[24888]: identifier: "fdbf0871-dd51-4eab-b54a-d95143909533"
May 01 21:08:18 architect hass[24888]: errorCode: NoError
May 01 21:08:18 architect hass[24888]: [setStateMessage] {
May 01 21:08:18 architect hass[24888]:   playbackQueue {
May 01 21:08:18 architect hass[24888]:     location: 0
May 01 21:08:18 architect hass[24888]:     contentItems {
May 01 21:08:18 architect hass[24888]:       identifier: "episode-2614861-46"
May 01 21:08:18 architect hass[24888]:       artworkData: "\377\330\377\341\017\376Exif\000\000MM\000*\000\000\000\010\000\005\001\032\000\005\000\000\000\001\000\000\000J\001\033\000\00...
May 01 21:08:18 architect hass[24888]:       artworkDataWidth: 512
May 01 21:08:18 architect hass[24888]:       artworkDataHeight: 512
May 01 21:08:18 architect hass[24888]:     }
May 01 21:08:18 architect hass[24888]:     requestId: "3D01C0B1-9FC9-4A2A-BC8A-8B23A71CC30A"
May 01 21:08:18 architect hass[24888]:     resolvedPlayerPath {
May 01 21:08:18 architect hass[24888]:       origin {
May 01 21:08:18 architect hass[24888]:         type: Local
May 01 21:08:18 architect hass[24888]:         displayName: "switch"
May 01 21:08:18 architect hass[24888]:         identifier: 1280262988
May 01 21:08:18 architect hass[24888]:       }
May 01 21:08:18 architect hass[24888]:       client {
May 01 21:08:18 architect hass[24888]:         processIdentifier: 1737
May 01 21:08:18 architect hass[24888]:         bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:08:18 architect hass[24888]:         processUserIdentifier: 501
May 01 21:08:18 architect hass[24888]:         displayName: "Molotov"
May 01 21:08:18 architect hass[24888]:       }
May 01 21:08:18 architect hass[24888]:       player {
May 01 21:08:18 architect hass[24888]:         identifier: "MediaRemote-DefaultPlayer"
May 01 21:08:18 architect hass[24888]:         displayName: "Default Player"
May 01 21:08:18 architect hass[24888]:       }
May 01 21:08:18 architect hass[24888]:     }
May 01 21:08:18 architect hass[24888]:   }
May 01 21:08:18 architect hass[24888]:   playerPath {
May 01 21:08:18 architect hass[24888]:     origin {
May 01 21:08:18 architect hass[24888]:       type: Local
May 01 21:08:18 architect hass[24888]:       displayName: "switch"
May 01 21:08:18 architect hass[24888]:       identifier: 1280262988
May 01 21:08:18 architect hass[24888]:     }
May 01 21:08:18 architect hass[24888]:     client {
May 01 21:08:18 architect hass[24888]:       processIdentifier: 1737
May 01 21:08:18 architect hass[24888]:       bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:08:18 architect hass[24888]:     }
May 01 21:08:18 architect hass[24888]:     player {
May 01 21:08:18 architect hass[24888]:       identifier: "MediaRemote-DefaultPlayer"
May 01 21:08:18 architect hass[24888]:       displayName: "Default Player"
May 01 21:08:18 architect hass[24888]:     }
May 01 21:08:18 architect hass[24888]:   }
May 01 21:08:18 architect hass[24888]:   request {
May 01 21:08:18 architect hass[24888]:     location: 0
May 01 21:08:18 architect hass[24888]:     length: 1
May 01 21:08:18 architect hass[24888]:     artworkWidth: 512.0
May 01 21:08:18 architect hass[24888]:     artworkHeight: -1.0
May 01 21:08:18 architect hass[24888]:     requestID: "3D01C0B1-9FC9-4A2A-BC8A-8B23A71CC30A"
May 01 21:08:18 architect hass[24888]:   }
May 01 21:08:18 architect hass[24888]: }
May 01 21:08:18 architect hass[24888]: 2020-05-01 21:08:18 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08212000b202cfc003080212dcbf030ad8bf030a140a12657069736f64652d323631343836312d34361292bf030a12657069736f64652d323631343836312d34361af4be03ffd8ffe10ffe4578696600004d4d002a000000080005011a0005000000010000004a011b0005000000010000005201280003000000010002000002130003000000010001000087690004000000010000005a00000000000000480000000100000048000000010007900000070000000430323231910100070000000401020300a00000070000000430313030a00100030000000100010000a00200040000000100000200a00300040000000100000200a406000300000001000...)
May 01 21:08:18 architect hass[24888]: 2020-05-01 21:08:18 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: type: TRANSACTION_MESSAGE
May 01 21:08:18 architect hass[24888]: errorCode: NoError
May 01 21:08:18 architect hass[24888]: [transactionMessage] {
May 01 21:08:18 architect hass[24888]:   name: 2
May 01 21:08:18 architect hass[24888]:   packets {
May 01 21:08:18 architect hass[24888]:     packets {
May 01 21:08:18 architect hass[24888]:       key {
May 01 21:08:18 architect hass[24888]:         identifier: "episode-2614861-46"
May 01 21:08:18 architect hass[24888]:       }
May 01 21:08:18 architect hass[24888]:       packetData: "\n\022episode-2614861-46\032\364\276\003\377\330\377\341\017\376Exif\000\000MM\000*\000\000\000\010\000\005\001\032\000\005\000\...
May 01 21:08:18 architect hass[24888]:       identifier: "483DF6B5-41BD-497C-A0B0-EFA4495603D4"
May 01 21:08:18 architect hass[24888]:       totalLength: 57234
May 01 21:08:18 architect hass[24888]:       totalWritePosition: 0
May 01 21:08:18 architect hass[24888]:     }
May 01 21:08:18 architect hass[24888]:   }
May 01 21:08:18 architect hass[24888]:   playerPath {
May 01 21:08:18 architect hass[24888]:     origin {
May 01 21:08:18 architect hass[24888]:       type: Local
May 01 21:08:18 architect hass[24888]:       displayName: "switch"
May 01 21:08:18 architect hass[24888]:       identifier: 1280262988
May 01 21:08:18 architect hass[24888]:     }
May 01 21:08:18 architect hass[24888]:     client {
May 01 21:08:18 architect hass[24888]:       processIdentifier: 1737
May 01 21:08:18 architect hass[24888]:       bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:08:18 architect hass[24888]:       processUserIdentifier: 501
May 01 21:08:18 architect hass[24888]:       displayName: "Molotov"
May 01 21:08:18 architect hass[24888]:     }
May 01 21:08:18 architect hass[24888]:     player {
May 01 21:08:18 architect hass[24888]:       identifier: "MediaRemote-DefaultPlayer"
May 01 21:08:18 architect hass[24888]:       displayName: "Default Player"
May 01 21:08:18 architect hass[24888]:     }
May 01 21:08:18 architect hass[24888]:   }
May 01 21:08:18 architect hass[24888]: }
May 01 21:08:18 architect hass[24888]: 2020-05-01 21:08:18 INFO (MainThread) [homeassistant.components.automation] Mode film quand l'Apple TV joue le soir: Test condition sun: True
May 01 21:08:18 architect hass[24888]: 2020-05-01 21:08:18 INFO (MainThread) [homeassistant.components.automation] Mode film quand l'Apple TV joue le soir: Executing step call service
May 01 21:08:20 architect hass[24888]: 2020-05-01 21:08:20 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=68f5bd7c0484a4a47eec1fabb93ad42202a3421b8522379e5f7acada6850251e5b0cb1ca61732d269628a1232eae221907dfb52853df6db65485f7a548714f4f8b7da99c4d1a1ca0be0c427b5924b6a280bd131526bc9701bc23f05f448faa043162b40e5c497b579e)
May 01 21:08:20 architect hass[24888]: 2020-05-01 21:08:20 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08342000c203510d0000003e122432334337363542352d353230442d343136332d394230362d3844334342453430373237301a2443393334463538352d423942382d343533352d384646392d413244353543353334423544)
May 01 21:08:20 architect hass[24888]: 2020-05-01 21:08:20 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: errorCode: NoError
May 01 21:08:21 architect hass[24888]: 2020-05-01 21:08:21 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=68dae434bb3753facbd0a9dc7b4f590f40076f0b9a59d4381018954d29dc362843dd8b4bcf02692848d4a4bc26ab653431043642107ed3a32bc69ce694031dde690ab477abe66b31ac7eba7a3981ce6dd5188aacf6bbf968626062c0f9dec8ec912e9b4ceb87866f10)
May 01 21:08:21 architect hass[24888]: 2020-05-01 21:08:21 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08342000c203510d0000403e122432334337363542352d353230442d343136332d394230362d3844334342453430373237301a2443393334463538352d423942382d343533352d384646392d413244353543353334423544)
May 01 21:08:21 architect hass[24888]: 2020-05-01 21:08:21 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: errorCode: NoError
May 01 21:08:24 architect hass[24888]: 2020-05-01 21:08:24 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=68c880473451d297eecd815970f6e5cc181bbb0c7fc6a62aaae7f27c823a54c8a97eaa60e0dbb82033970c6e339b1c678a7d3e800e941841fb559c4bb4e8de51e39296facc8d216d6323d89f98924bcb49285d97c4e54fa83d8965404cd782e8bea6f8b11818389859)
May 01 21:08:24 architect hass[24888]: 2020-05-01 21:08:24 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08342000c203510d0000003e122432334337363542352d353230442d343136332d394230362d3844334342453430373237301a2443393334463538352d423942382d343533352d384646392d413244353543353334423544)
May 01 21:08:24 architect hass[24888]: 2020-05-01 21:08:24 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: errorCode: NoError
May 01 21:08:34 architect hass[24888]: 2020-05-01 21:08:34 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=685569cec4761da0e22df313b2fa10541bd68726fdd35af42167ecc75160da845067ab9707e15af233ab6a3b8c2500cfa9d36c01adadd3aa4c35c4ffd258a667d1c839889513fa9eafca41cd5e9e9aee1d4047c0bed50c3670dbec32012b7ecd2538580220d5ca38b9)
May 01 21:08:34 architect hass[24888]: 2020-05-01 21:08:34 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08342000c203510d0000803d122432334337363542352d353230442d343136332d394230362d3844334342453430373237301a2443393334463538352d423942382d343533352d384646392d413244353543353334423544)
May 01 21:08:34 architect hass[24888]: 2020-05-01 21:08:34 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: errorCode: NoError
May 01 21:08:35 architect hass[24888]: 2020-05-01 21:08:35 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=6802b4784e29842ec5672d12bb72055fd8ae30d5a861960a995811e62cc194f752dbec35060285b7a4be7b6c8060bc2ebca5df7b4b207eb8709b9df4dfd48d488d53b7f4e00e16309c0801c4781293bbe66b7de3a5599f349e645ac9d1cd75d5a4151bd49e99cdeca0)
May 01 21:08:35 architect hass[24888]: 2020-05-01 21:08:35 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08342000c203510d00000000122432334337363542352d353230442d343136332d394230362d3844334342453430373237301a2443393334463538352d423942382d343533352d384646392d413244353543353334423544)
May 01 21:08:35 architect hass[24888]: 2020-05-01 21:08:35 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: errorCode: NoError
May 01 21:09:00 architect hass[24888]: 2020-05-01 21:09:00 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=68f6674cc883bb55686a4ad40ad296be485b9c4dd32a83f28d75bf3d5f9fb797d9e05631278a464d041714082054da1b650a56fa703f894639b7371ce65756c56dcea7ec96e9316f9e63e0672445ac70316b0abc7b9f84f5a9b6e44a2872460e03a6c0561a241f1ea4)
May 01 21:09:00 architect hass[24888]: 2020-05-01 21:09:00 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08342000c203510d0000803d122432334337363542352d353230442d343136332d394230362d3844334342453430373237301a2443393334463538352d423942382d343533352d384646392d413244353543353334423544)
May 01 21:09:00 architect hass[24888]: 2020-05-01 21:09:00 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: errorCode: NoError
May 01 21:09:00 architect hass[24888]: 2020-05-01 21:09:00 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=6806fb99238a3bad5526029ed415e620420aa8394575dac72b5e5d8940976b620b4def0b7f655d8ef37bf0d3bc6a55651a9135ec446e06b89c48cdb8119c0f7fdd867af122301d1588d38cba964fb928686e856c594409364c392ac4a3cc2f99b414d3b5edbd07de9f)
May 01 21:09:00 architect hass[24888]: 2020-05-01 21:09:00 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08342000c203510d0000003e122432334337363542352d353230442d343136332d394230362d3844334342453430373237301a2443393334463538352d423942382d343533352d384646392d413244353543353334423544)
May 01 21:09:00 architect hass[24888]: 2020-05-01 21:09:00 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: errorCode: NoError
May 01 21:09:15 architect hass[24888]: 2020-05-01 21:09:15 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=9e0198ffb59e65cefad1617021b362fbd0882d4600fceaec7bf623ef4f9de97ca2d96380228de5b0ebc2a506ffa2a2d7b0ee27a67521816dc3c9b539d45982aa1cad147846a53b1a1c1965c9b7ac88da7cde19c4c3a83cf57476a1a5987847e2d02c723b792570dde16dfcc5eaa329717e5fd4a83c8d49ef899f669eec64c61853d299021fb5124a17e9cfa3fc1d86cd7fff7aa4e136f822085ebd6852de53f78201303363f946b27c1e23999fed41c97c5756c58326eb512f2de2fde499e93feaf66a90d6753e6618d910324fbd08ea3eb68585aed929437f5544b2b0b25dce3e605ff99701315aac0a4e7322b6ded5ebb9350463385271e32907af5598a...)
May 01 21:09:15 architect hass[24888]: 2020-05-01 21:09:15 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=080420004a870112240a04080310010a0d081210012100000000000024400a0d081310012100000000000024404a5f0a100801120673776974636818cc86bde204121e08c90d121974762e6d6f6c6f746f762e4d6f6c6f746f7641707050726f641a2b0a194d6564696152656d6f74652d44656661756c74506c61796572120e44656661756c7420506c61796572)
May 01 21:09:15 architect hass[24888]: 2020-05-01 21:09:15 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: type: SET_STATE_MESSAGE
May 01 21:09:15 architect hass[24888]: errorCode: NoError
May 01 21:09:15 architect hass[24888]: [setStateMessage] {
May 01 21:09:15 architect hass[24888]:   supportedCommands {
May 01 21:09:15 architect hass[24888]:     supportedCommands {
May 01 21:09:15 architect hass[24888]:       command: TogglePlayPause
May 01 21:09:15 architect hass[24888]:       enabled: true
May 01 21:09:15 architect hass[24888]:     }
May 01 21:09:15 architect hass[24888]:     supportedCommands {
May 01 21:09:15 architect hass[24888]:       command: SkipForward
May 01 21:09:15 architect hass[24888]:       enabled: true
May 01 21:09:15 architect hass[24888]:       preferredIntervals: 10.0
May 01 21:09:15 architect hass[24888]:     }
May 01 21:09:15 architect hass[24888]:     supportedCommands {
May 01 21:09:15 architect hass[24888]:       command: SkipBackward
May 01 21:09:15 architect hass[24888]:       enabled: true
May 01 21:09:15 architect hass[24888]:       preferredIntervals: 10.0
May 01 21:09:15 architect hass[24888]:     }
May 01 21:09:15 architect hass[24888]:   }
May 01 21:09:15 architect hass[24888]:   playerPath {
May 01 21:09:15 architect hass[24888]:     origin {
May 01 21:09:15 architect hass[24888]:       type: Local
May 01 21:09:15 architect hass[24888]:       displayName: "switch"
May 01 21:09:15 architect hass[24888]:       identifier: 1280262988
May 01 21:09:15 architect hass[24888]:     }
May 01 21:09:15 architect hass[24888]:     client {
May 01 21:09:15 architect hass[24888]:       processIdentifier: 1737
May 01 21:09:15 architect hass[24888]:       bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:09:15 architect hass[24888]:     }
May 01 21:09:15 architect hass[24888]:     player {
May 01 21:09:15 architect hass[24888]:       identifier: "MediaRemote-DefaultPlayer"
May 01 21:09:15 architect hass[24888]:       displayName: "Default Player"
May 01 21:09:15 architect hass[24888]:     }
May 01 21:09:15 architect hass[24888]:   }
May 01 21:09:15 architect hass[24888]: }
May 01 21:09:15 architect hass[24888]: 2020-05-01 21:09:15 DEBUG (MainThread) [pyatv.mrp.protocol] Dispatching message with type 4 (SetStateMessage) to Listener(func=>, data=None)
May 01 21:09:15 architect hass[24888]: 2020-05-01 21:09:15 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=080420004a6c30014a5f0a100801120673776974636818cc86bde204121e08c90d121974762e6d6f6c6f746f762e4d6f6c6f746f7641707050726f641a2b0a194d6564696152656d6f74652d44656661756c74506c61796572120e44656661756c7420506c61796572593c9f2b8f552ec241)
May 01 21:09:15 architect hass[24888]: 2020-05-01 21:09:15 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: type: SET_STATE_MESSAGE
May 01 21:09:15 architect hass[24888]: errorCode: NoError
May 01 21:09:15 architect hass[24888]: [setStateMessage] {
May 01 21:09:15 architect hass[24888]:   playbackState: Playing
May 01 21:09:15 architect hass[24888]:   playerPath {
May 01 21:09:15 architect hass[24888]:     origin {
May 01 21:09:15 architect hass[24888]:       type: Local
May 01 21:09:15 architect hass[24888]:       displayName: "switch"
May 01 21:09:15 architect hass[24888]:       identifier: 1280262988
May 01 21:09:15 architect hass[24888]:     }
May 01 21:09:15 architect hass[24888]:     client {
May 01 21:09:15 architect hass[24888]:       processIdentifier: 1737
May 01 21:09:15 architect hass[24888]:       bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:09:15 architect hass[24888]:     }
May 01 21:09:15 architect hass[24888]:     player {
May 01 21:09:15 architect hass[24888]:       identifier: "MediaRemote-DefaultPlayer"
May 01 21:09:15 architect hass[24888]:       displayName: "Default Player"
May 01 21:09:15 architect hass[24888]:     }
May 01 21:09:15 architect hass[24888]:   }
May 01 21:09:15 architect hass[24888]:   playbackStateTimestamp: 610052894.340797
May 01 21:09:15 architect hass[24888]: }
May 01 21:09:15 architect hass[24888]: 2020-05-01 21:09:15 DEBUG (MainThread) [pyatv.mrp.protocol] Dispatching message with type 4 (SetStateMessage) to Listener(func=>, data=None)
May 01 21:09:17 architect hass[24888]: 2020-05-01 21:09:17 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=82019bd26af58d949eb44264f9bd401567ce022361262edcab2f9a4b0f82cb175fb04344b0df8403c7e49ba375b93f091be58c5afb9440024ef06e29d39f9cfd6876817d7ec86326d1ad056f4423b04a5eee315fe616d245ea06ea789acf3bc73ddeed141c59566ad6c8bf9b188a02a762f3ff47023ffb8196d48e4ef92f9792db4d6b30)
May 01 21:09:17 architect hass[24888]: 2020-05-01 21:09:17 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=080420004a6c30024a5f0a100801120673776974636818cc86bde204121e08c90d121974762e6d6f6c6f746f762e4d6f6c6f746f7641707050726f641a2b0a194d6564696152656d6f74652d44656661756c74506c61796572120e44656661756c7420506c6179657259d23410ae552ec241)
May 01 21:09:17 architect hass[24888]: 2020-05-01 21:09:17 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: type: SET_STATE_MESSAGE
May 01 21:09:17 architect hass[24888]: errorCode: NoError
May 01 21:09:17 architect hass[24888]: [setStateMessage] {
May 01 21:09:17 architect hass[24888]:   playbackState: Paused
May 01 21:09:17 architect hass[24888]:   playerPath {
May 01 21:09:17 architect hass[24888]:     origin {
May 01 21:09:17 architect hass[24888]:       type: Local
May 01 21:09:17 architect hass[24888]:       displayName: "switch"
May 01 21:09:17 architect hass[24888]:       identifier: 1280262988
May 01 21:09:17 architect hass[24888]:     }
May 01 21:09:17 architect hass[24888]:     client {
May 01 21:09:17 architect hass[24888]:       processIdentifier: 1737
May 01 21:09:17 architect hass[24888]:       bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:09:17 architect hass[24888]:     }
May 01 21:09:17 architect hass[24888]:     player {
May 01 21:09:17 architect hass[24888]:       identifier: "MediaRemote-DefaultPlayer"
May 01 21:09:17 architect hass[24888]:       displayName: "Default Player"
May 01 21:09:17 architect hass[24888]:     }
May 01 21:09:17 architect hass[24888]:   }
May 01 21:09:17 architect hass[24888]:   playbackStateTimestamp: 610052956.126612
May 01 21:09:17 architect hass[24888]: }
May 01 21:09:17 architect hass[24888]: 2020-05-01 21:09:17 DEBUG (MainThread) [pyatv.mrp.protocol] Dispatching message with type 4 (SetStateMessage) to Listener(func=>, data=None)
May 01 21:10:33 architect hass[24888]: 2020-05-01 21:10:33 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=a4016bb9f65a07d964d71e9595f7bbaf65d60429a6241b717c030b96cd778ff0d768efdae9fc637002fd4ec1ed0637f78a85cb53131ae0280122de8d695fe854a11f6d957b0ac842648c8e6a75816e96e5f92a01db0cbe14f48cf4c92a4b0470920706b27e18ac6b48302b562f1e457a6d8e877c6874ab5eb9764f40eaaef2df44c46432737771fe2eca524487d4e54ffda0cc2e35ffa33d8aa2a1a4bfb6e455098a28356e2e)
May 01 21:10:33 architect hass[24888]: 2020-05-01 21:10:33 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=080420004a8d01122a0a04080210010a04080310010a0d081210012100000000000024400a0d081310012100000000000024404a5f0a100801120673776974636818cc86bde204121e08c90d121974762e6d6f6c6f746f762e4d6f6c6f746f7641707050726f641a2b0a194d6564696152656d6f74652d44656661756c74506c61796572120e44656661756c7420506c61796572)
May 01 21:10:33 architect hass[24888]: 2020-05-01 21:10:33 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: type: SET_STATE_MESSAGE
May 01 21:10:33 architect hass[24888]: errorCode: NoError
May 01 21:10:33 architect hass[24888]: [setStateMessage] {
May 01 21:10:33 architect hass[24888]:   supportedCommands {
May 01 21:10:33 architect hass[24888]:     supportedCommands {
May 01 21:10:33 architect hass[24888]:       command: Pause
May 01 21:10:33 architect hass[24888]:       enabled: true
May 01 21:10:33 architect hass[24888]:     }
May 01 21:10:33 architect hass[24888]:     supportedCommands {
May 01 21:10:33 architect hass[24888]:       command: TogglePlayPause
May 01 21:10:33 architect hass[24888]:       enabled: true
May 01 21:10:33 architect hass[24888]:     }
May 01 21:10:33 architect hass[24888]:     supportedCommands {
May 01 21:10:33 architect hass[24888]:       command: SkipForward
May 01 21:10:33 architect hass[24888]:       enabled: true
May 01 21:10:33 architect hass[24888]:       preferredIntervals: 10.0
May 01 21:10:33 architect hass[24888]:     }
May 01 21:10:33 architect hass[24888]:     supportedCommands {
May 01 21:10:33 architect hass[24888]:       command: SkipBackward
May 01 21:10:33 architect hass[24888]:       enabled: true
May 01 21:10:33 architect hass[24888]:       preferredIntervals: 10.0
May 01 21:10:33 architect hass[24888]:     }
May 01 21:10:33 architect hass[24888]:   }
May 01 21:10:33 architect hass[24888]:   playerPath {
May 01 21:10:33 architect hass[24888]:     origin {
May 01 21:10:33 architect hass[24888]:       type: Local
May 01 21:10:33 architect hass[24888]:       displayName: "switch"
May 01 21:10:33 architect hass[24888]:       identifier: 1280262988
May 01 21:10:33 architect hass[24888]:     }
May 01 21:10:33 architect hass[24888]:     client {
May 01 21:10:33 architect hass[24888]:       processIdentifier: 1737
May 01 21:10:33 architect hass[24888]:       bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:10:33 architect hass[24888]:     }
May 01 21:10:33 architect hass[24888]:     player {
May 01 21:10:33 architect hass[24888]:       identifier: "MediaRemote-DefaultPlayer"
May 01 21:10:33 architect hass[24888]:       displayName: "Default Player"
May 01 21:10:33 architect hass[24888]:     }
May 01 21:10:33 architect hass[24888]:   }
May 01 21:10:33 architect hass[24888]: }
May 01 21:10:33 architect hass[24888]: 2020-05-01 21:10:33 DEBUG (MainThread) [pyatv.mrp.protocol] Dispatching message with type 4 (SetStateMessage) to Listener(func=>, data=None)
May 01 21:10:34 architect hass[24888]: 2020-05-01 21:10:34 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=820154d654dcc60184cea3b19d4394217d422450b2c8bee531f3b1ceb25cc58d878cb2f1cb3a879e1881e137dd5da33ca254d0318362612ad2c15d8aed9b561bd2480d82e2d9b660ab45688f9efdf37fc54ae611ce301afed24bbe3a0a9c442058f123d3a2b68ef19e74752f10bff1ceded3dd970184773166635e4a13542838f6a48dcdb7079ed6f88ff26c3fd04183cea827e045c7019dec22143a2da846984f1220e7f0d97894ff1edd7f3df941ebe58e0d63b61802ca0a15406733184897da5ff5d40c22c5cbcf075d6b169fbf1bb83ac397e3aed982a2876d8bc585e43a6eb6e2ee42d82e0338d274026fe6878a7c937609b4c9814b08199c48c2614...)
May 01 21:10:34 architect hass[24888]: 2020-05-01 21:10:34 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=080420004a6c30024a5f0a100801120673776974636818cc86bde204121e08c90d121974762e6d6f6c6f746f762e4d6f6c6f746f7641707050726f641a2b0a194d6564696152656d6f74652d44656661756c74506c61796572120e44656661756c7420506c6179657259d23410ae552ec241)
May 01 21:10:34 architect hass[24888]: 2020-05-01 21:10:34 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: type: SET_STATE_MESSAGE
May 01 21:10:34 architect hass[24888]: errorCode: NoError
May 01 21:10:34 architect hass[24888]: [setStateMessage] {
May 01 21:10:34 architect hass[24888]:   playbackState: Paused
May 01 21:10:34 architect hass[24888]:   playerPath {
May 01 21:10:34 architect hass[24888]:     origin {
May 01 21:10:34 architect hass[24888]:       type: Local
May 01 21:10:34 architect hass[24888]:       displayName: "switch"
May 01 21:10:34 architect hass[24888]:       identifier: 1280262988
May 01 21:10:34 architect hass[24888]:     }
May 01 21:10:34 architect hass[24888]:     client {
May 01 21:10:34 architect hass[24888]:       processIdentifier: 1737
May 01 21:10:34 architect hass[24888]:       bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:10:34 architect hass[24888]:     }
May 01 21:10:34 architect hass[24888]:     player {
May 01 21:10:34 architect hass[24888]:       identifier: "MediaRemote-DefaultPlayer"
May 01 21:10:34 architect hass[24888]:       displayName: "Default Player"
May 01 21:10:34 architect hass[24888]:     }
May 01 21:10:34 architect hass[24888]:   }
May 01 21:10:34 architect hass[24888]:   playbackStateTimestamp: 610052956.126612
May 01 21:10:34 architect hass[24888]: }
May 01 21:10:34 architect hass[24888]: 2020-05-01 21:10:34 DEBUG (MainThread) [pyatv.mrp.protocol] Dispatching message with type 4 (SetStateMessage) to Listener(func=>, data=None)
May 01 21:10:34 architect hass[24888]: 2020-05-01 21:10:34 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08382000e2039f070abb060a12657069736f64652d323631343836312d3436129e060a2b4b6f682d4c616e74612c206c27c3ae6c65206465732068c3a9726f7320e280a220457069736f64652031302d000000003a03544631980101fa010a696d6167652f6a706567a80201bd0200000000e20212657069736f64652d323631343836312d34368004028804009a049b0362706c6973743030d4010203040506070a582476657273696f6e592461726368697665725424746f7058246f626a6563747312000186a05f100f4e534b657965644172636869766572d1080954726f6f748001a70b0c1718191a1b55246e756c6cd30d0e0f101316574e532e6b6...)
May 01 21:10:34 architect hass[24888]: 2020-05-01 21:10:34 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: type: UPDATE_CONTENT_ITEM_MESSAGE
May 01 21:10:34 architect hass[24888]: errorCode: NoError
May 01 21:10:34 architect hass[24888]: [updateContentItemMessage] {
May 01 21:10:34 architect hass[24888]:   contentItems {
May 01 21:10:34 architect hass[24888]:     identifier: "episode-2614861-46"
May 01 21:10:34 architect hass[24888]:     metadata {
May 01 21:10:34 architect hass[24888]:       title: "Koh-Lanta, l\'\303\256le des h\303\251ros \342\200\242 Episode 10"
May 01 21:10:34 architect hass[24888]:       playbackProgress: 0.0
May 01 21:10:34 architect hass[24888]:       trackArtistName: "TF1"
May 01 21:10:34 architect hass[24888]:       artworkAvailable: true
May 01 21:10:34 architect hass[24888]:       artworkMIMEType: "image/jpeg"
May 01 21:10:34 architect hass[24888]:       isAlwaysLive: true
May 01 21:10:34 architect hass[24888]:       playbackRate: 0.0
May 01 21:10:34 architect hass[24888]:       contentIdentifier: "episode-2614861-46"
May 01 21:10:34 architect hass[24888]:       mediaType: Video
May 01 21:10:34 architect hass[24888]:       mediaSubType: UnknownMediaSubType
May 01 21:10:34 architect hass[24888]:       nowPlayingInfoData: "bplist00\324\001\002\003\004\005\006\007\nX$versionY$archiverT$topX$objects\022\000\001\206\240_\020\017NSKeyedArchiver\...
May 01 21:10:34 architect hass[24888]:       elapsedTimeTimestamp: 610053034.208642
May 01 21:10:34 architect hass[24888]:       currentPlaybackDateData: "bplist00\324\001\002\003\004\005\006\007\nX$versionY$archiverT$topX$objects\022\000\001\206\240_\020\017NSKeyedArch...
May 01 21:10:34 architect hass[24888]:       artworkIdentifier: "2757AD21-BD73-459A-B2BD-47F4BEDBF81A"
May 01 21:10:34 architect hass[24888]:     }
May 01 21:10:34 architect hass[24888]:     artworkDataWidth: 768
May 01 21:10:34 architect hass[24888]:     artworkDataHeight: 768
May 01 21:10:34 architect hass[24888]:   }
May 01 21:10:34 architect hass[24888]:   playerPath {
May 01 21:10:34 architect hass[24888]:     origin {
May 01 21:10:34 architect hass[24888]:       type: Local
May 01 21:10:34 architect hass[24888]:       displayName: "switch"
May 01 21:10:34 architect hass[24888]:       identifier: 1280262988
May 01 21:10:34 architect hass[24888]:     }
May 01 21:10:34 architect hass[24888]:     client {
May 01 21:10:34 architect hass[24888]:       processIdentifier: 1737
May 01 21:10:34 architect hass[24888]:       bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:10:34 architect hass[24888]:     }
May 01 21:10:34 architect hass[24888]:     player {
May 01 21:10:34 architect hass[24888]:       identifier: "MediaRemote-DefaultPlayer"
May 01 21:10:34 architect hass[24888]:       displayName: "Default Player"
May 01 21:10:34 architect hass[24888]:     }
May 01 21:10:34 architect hass[24888]:   }
May 01 21:10:34 architect hass[24888]: }
May 01 21:10:34 architect hass[24888]: 2020-05-01 21:10:34 DEBUG (MainThread) [pyatv.mrp.protocol] Dispatching message with type 56 (UpdateContentItemMessage) to Listener(func=>, data=None)
May 01 21:10:36 architect hass[24888]: 2020-05-01 21:10:36 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=b7072c4674ebccffe48a1c27b17f29515d9d141d85876ee12100ea0f90d868ca775e2ad90e5f6915e3bfd5b1d5fe9852090ff1af9b8f87adda901466cdb7656010236698880de20a774cc6e1c8a6cb278bb364178e30a470b1396bcef23370958f881a6dd1505b9e53f1aab2bd65b562b3e4c626061f3f745fd2112e5e7cbdb492fd42b360e4c89ac492fe68da711669e80183b2c3c8880bd8cdecb7a59abf1f47a65e95e587a622b52a39a48a44d8e6ce70e162f5f6aca6967d66f706fc87cefb13d42312bdbd974fc0089be9029f32ea134613a4a8b8c73ee07579909b7b13356167c891bb769f7c7a58ecc667872caab0a1127f1055f1e57495681059b...)
May 01 21:10:36 architect hass[24888]: 2020-05-01 21:10:36 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08382000e2039f070abb060a12657069736f64652d323631343836312d3436129e060a2b4b6f682d4c616e74612c206c27c3ae6c65206465732068c3a9726f7320e280a220457069736f64652031302d000000003a03544631980101fa010a696d6167652f6a706567a80201bd0200000000e20212657069736f64652d323631343836312d34368004028804009a049b0362706c6973743030d4010203040506070a582476657273696f6e592461726368697665725424746f7058246f626a6563747312000186a05f100f4e534b657965644172636869766572d1080954726f6f748001a70b0c1718191a1b55246e756c6cd30d0e0f101316574e532e6b6...)
May 01 21:10:36 architect hass[24888]: 2020-05-01 21:10:36 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: type: UPDATE_CONTENT_ITEM_MESSAGE
May 01 21:10:36 architect hass[24888]: errorCode: NoError
May 01 21:10:36 architect hass[24888]: [updateContentItemMessage] {
May 01 21:10:36 architect hass[24888]:   contentItems {
May 01 21:10:36 architect hass[24888]:     identifier: "episode-2614861-46"
May 01 21:10:36 architect hass[24888]:     metadata {
May 01 21:10:36 architect hass[24888]:       title: "Koh-Lanta, l\'\303\256le des h\303\251ros \342\200\242 Episode 10"
May 01 21:10:36 architect hass[24888]:       playbackProgress: 0.0
May 01 21:10:36 architect hass[24888]:       trackArtistName: "TF1"
May 01 21:10:36 architect hass[24888]:       artworkAvailable: true
May 01 21:10:36 architect hass[24888]:       artworkMIMEType: "image/jpeg"
May 01 21:10:36 architect hass[24888]:       isAlwaysLive: true
May 01 21:10:36 architect hass[24888]:       playbackRate: 0.0
May 01 21:10:36 architect hass[24888]:       contentIdentifier: "episode-2614861-46"
May 01 21:10:36 architect hass[24888]:       mediaType: Video
May 01 21:10:36 architect hass[24888]:       mediaSubType: UnknownMediaSubType
May 01 21:10:36 architect hass[24888]:       nowPlayingInfoData: "bplist00\324\001\002\003\004\005\006\007\nX$versionY$archiverT$topX$objects\022\000\001\206\240_\020\017NSKeyedArchiver\...
May 01 21:10:36 architect hass[24888]:       elapsedTimeTimestamp: 610053034.77066
May 01 21:10:36 architect hass[24888]:       currentPlaybackDateData: "bplist00\324\001\002\003\004\005\006\007\nX$versionY$archiverT$topX$objects\022\000\001\206\240_\020\017NSKeyedArch...
May 01 21:10:36 architect hass[24888]:       artworkIdentifier: "3FFA69A0-4D11-41D4-A371-EBFE96DED7A2"
May 01 21:10:36 architect hass[24888]:     }
May 01 21:10:36 architect hass[24888]:     artworkDataWidth: 768
May 01 21:10:36 architect hass[24888]:     artworkDataHeight: 768
May 01 21:10:36 architect hass[24888]:   }
May 01 21:10:36 architect hass[24888]:   playerPath {
May 01 21:10:36 architect hass[24888]:     origin {
May 01 21:10:36 architect hass[24888]:       type: Local
May 01 21:10:36 architect hass[24888]:       displayName: "switch"
May 01 21:10:36 architect hass[24888]:       identifier: 1280262988
May 01 21:10:36 architect hass[24888]:     }
May 01 21:10:36 architect hass[24888]:     client {
May 01 21:10:36 architect hass[24888]:       processIdentifier: 1737
May 01 21:10:36 architect hass[24888]:       bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:10:36 architect hass[24888]:     }
May 01 21:10:36 architect hass[24888]:     player {
May 01 21:10:36 architect hass[24888]:       identifier: "MediaRemote-DefaultPlayer"
May 01 21:10:36 architect hass[24888]:       displayName: "Default Player"
May 01 21:10:36 architect hass[24888]:     }
May 01 21:10:36 architect hass[24888]:   }
May 01 21:10:36 architect hass[24888]: }
May 01 21:10:36 architect hass[24888]: 2020-05-01 21:10:36 DEBUG (MainThread) [pyatv.mrp.protocol] Dispatching message with type 56 (UpdateContentItemMessage) to Listener(func=>, data=None)
May 01 21:10:36 architect hass[24888]: 2020-05-01 21:10:36 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08382000e2039f070abb060a12657069736f64652d323631343836312d3436129e060a2b4b6f682d4c616e74612c206c27c3ae6c65206465732068c3a9726f7320e280a220457069736f64652031302d000000003a03544631980101fa010a696d6167652f6a706567a80201bd0200000000e20212657069736f64652d323631343836312d34368004028804009a049b0362706c6973743030d4010203040506070a582476657273696f6e592461726368697665725424746f7058246f626a6563747312000186a05f100f4e534b657965644172636869766572d1080954726f6f748001a70b0c1718191a1b55246e756c6cd30d0e0f101316574e532e6b6...)
May 01 21:10:36 architect hass[24888]: 2020-05-01 21:10:36 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: type: UPDATE_CONTENT_ITEM_MESSAGE
May 01 21:10:36 architect hass[24888]: errorCode: NoError
May 01 21:10:36 architect hass[24888]: [updateContentItemMessage] {
May 01 21:10:36 architect hass[24888]:   contentItems {
May 01 21:10:36 architect hass[24888]:     identifier: "episode-2614861-46"
May 01 21:10:36 architect hass[24888]:     metadata {
May 01 21:10:36 architect hass[24888]:       title: "Koh-Lanta, l\'\303\256le des h\303\251ros \342\200\242 Episode 10"
May 01 21:10:36 architect hass[24888]:       playbackProgress: 0.0
May 01 21:10:36 architect hass[24888]:       trackArtistName: "TF1"
May 01 21:10:36 architect hass[24888]:       artworkAvailable: true
May 01 21:10:36 architect hass[24888]:       artworkMIMEType: "image/jpeg"
May 01 21:10:36 architect hass[24888]:       isAlwaysLive: true
May 01 21:10:36 architect hass[24888]:       playbackRate: 0.0
May 01 21:10:36 architect hass[24888]:       contentIdentifier: "episode-2614861-46"
May 01 21:10:36 architect hass[24888]:       mediaType: Video
May 01 21:10:36 architect hass[24888]:       mediaSubType: UnknownMediaSubType
May 01 21:10:36 architect hass[24888]:       nowPlayingInfoData: "bplist00\324\001\002\003\004\005\006\007\nX$versionY$archiverT$topX$objects\022\000\001\206\240_\020\017NSKeyedArchiver\...
May 01 21:10:36 architect hass[24888]:       elapsedTimeTimestamp: 610053035.295772
May 01 21:10:36 architect hass[24888]:       currentPlaybackDateData: "bplist00\324\001\002\003\004\005\006\007\nX$versionY$archiverT$topX$objects\022\000\001\206\240_\020\017NSKeyedArch...
May 01 21:10:36 architect hass[24888]:       artworkIdentifier: "8E9029C0-FD0D-4EE3-92F4-6FE304126E5E"
May 01 21:10:36 architect hass[24888]:     }
May 01 21:10:36 architect hass[24888]:     artworkDataWidth: 768
May 01 21:10:36 architect hass[24888]:     artworkDataHeight: 768
May 01 21:10:36 architect hass[24888]:   }
May 01 21:10:36 architect hass[24888]:   playerPath {
May 01 21:10:36 architect hass[24888]:     origin {
May 01 21:10:36 architect hass[24888]:       type: Local
May 01 21:10:36 architect hass[24888]:       displayName: "switch"
May 01 21:10:36 architect hass[24888]:       identifier: 1280262988
May 01 21:10:36 architect hass[24888]:     }
May 01 21:10:36 architect hass[24888]:     client {
May 01 21:10:36 architect hass[24888]:       processIdentifier: 1737
May 01 21:10:36 architect hass[24888]:       bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:10:36 architect hass[24888]:     }
May 01 21:10:36 architect hass[24888]:     player {
May 01 21:10:36 architect hass[24888]:       identifier: "MediaRemote-DefaultPlayer"
May 01 21:10:36 architect hass[24888]:       displayName: "Default Player"
May 01 21:10:36 architect hass[24888]:     }
May 01 21:10:36 architect hass[24888]:   }
May 01 21:10:36 architect hass[24888]: }
May 01 21:10:36 architect hass[24888]: 2020-05-01 21:10:36 DEBUG (MainThread) [pyatv.mrp.protocol] Dispatching message with type 56 (UpdateContentItemMessage) to Listener(func=>, data=None)
May 01 21:10:36 architect hass[24888]: 2020-05-01 21:10:36 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08382000e2039d070ab9060a12657069736f64652d323631343836312d343612a2060a2b4b6f682d4c616e74612c206c27c3ae6c65206465732068c3a9726f7320e280a220457069736f64652031302d000000003a03544631980101fa010a696d6167652f6a706567a80201bd020000803fe20212657069736f64652d323631343836312d34368004028804009a049b0362706c6973743030d4010203040506070a582476657273696f6e592461726368697665725424746f7058246f626a6563747312000186a05f100f4e534b657965644172636869766572d1080954726f6f748001a70b0c1718191a1b55246e756c6cd30d0e0f101316574e532e6b6...)
May 01 21:10:36 architect hass[24888]: 2020-05-01 21:10:36 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: type: UPDATE_CONTENT_ITEM_MESSAGE
May 01 21:10:36 architect hass[24888]: errorCode: NoError
May 01 21:10:36 architect hass[24888]: [updateContentItemMessage] {
May 01 21:10:36 architect hass[24888]:   contentItems {
May 01 21:10:36 architect hass[24888]:     identifier: "episode-2614861-46"
May 01 21:10:36 architect hass[24888]:     metadata {
May 01 21:10:36 architect hass[24888]:       title: "Koh-Lanta, l\'\303\256le des h\303\251ros \342\200\242 Episode 10"
May 01 21:10:36 architect hass[24888]:       playbackProgress: 0.0
May 01 21:10:36 architect hass[24888]:       trackArtistName: "TF1"
May 01 21:10:36 architect hass[24888]:       artworkAvailable: true
May 01 21:10:36 architect hass[24888]:       artworkMIMEType: "image/jpeg"
May 01 21:10:36 architect hass[24888]:       isAlwaysLive: true
May 01 21:10:36 architect hass[24888]:       playbackRate: 1.0
May 01 21:10:36 architect hass[24888]:       contentIdentifier: "episode-2614861-46"
May 01 21:10:36 architect hass[24888]:       mediaType: Video
May 01 21:10:36 architect hass[24888]:       mediaSubType: UnknownMediaSubType
May 01 21:10:36 architect hass[24888]:       nowPlayingInfoData: "bplist00\324\001\002\003\004\005\006\007\nX$versionY$archiverT$topX$objects\022\000\001\206\240_\020\017NSKeyedArchiver\...
May 01 21:10:36 architect hass[24888]:       elapsedTimeTimestamp: 610053035.991571
May 01 21:10:36 architect hass[24888]:       currentPlaybackDateData: "bplist00\324\001\002\003\004\005\006\007\nX$versionY$archiverT$topX$objects\022\000\001\206\240_\020\017NSKeyedArch...
May 01 21:10:36 architect hass[24888]:       artworkIdentifier: "c867329cd3c1756aeaa51a685cc5d89470de87e4"
May 01 21:10:36 architect hass[24888]:     }
May 01 21:10:36 architect hass[24888]:   }
May 01 21:10:36 architect hass[24888]:   playerPath {
May 01 21:10:36 architect hass[24888]:     origin {
May 01 21:10:36 architect hass[24888]:       type: Local
May 01 21:10:36 architect hass[24888]:       displayName: "switch"
May 01 21:10:36 architect hass[24888]:       identifier: 1280262988
May 01 21:10:36 architect hass[24888]:     }
May 01 21:10:36 architect hass[24888]:     client {
May 01 21:10:36 architect hass[24888]:       processIdentifier: 1737
May 01 21:10:36 architect hass[24888]:       bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:10:36 architect hass[24888]:     }
May 01 21:10:36 architect hass[24888]:     player {
May 01 21:10:36 architect hass[24888]:       identifier: "MediaRemote-DefaultPlayer"
May 01 21:10:36 architect hass[24888]:       displayName: "Default Player"
May 01 21:10:36 architect hass[24888]:     }
May 01 21:10:36 architect hass[24888]:   }
May 01 21:10:36 architect hass[24888]: }
May 01 21:10:36 architect hass[24888]: 2020-05-01 21:10:36 DEBUG (MainThread) [pyatv.mrp.protocol] Dispatching message with type 56 (UpdateContentItemMessage) to Listener(func=>, data=None)
May 01 21:10:38 architect hass[24888]: 2020-05-01 21:10:38 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=820171140ccf70ddb3ec7e734d499c68dfed5eb651c452e538b90b6e8e0f554a54e8b7f32d02d9ff45a83167875d8189714c578f58ab334a30c7326eda4590bb3a37a820969e1e80687388eb22f8cdd9fea99bf23b85820a9ac65944c36274872c00c7435f74afd56646722b6ffffb48231f8704e25884d4543d33b415f09c064f9d8a6bb7077c8d349005a78cc42c4cb7139b6d4feee5ab2eab720d638512c4dc0b8f3c3484d5a8b3e5e59a294f20a195f7cd85989af28681104a238cb8b8a962a5bae47140f35f749c1c334d06cf9a5141fb9e45ab8382de50d1ce6e58673f3d74de1c44343f54745b8abbc71ba4842e035193e5c61bdb76d3aaba22701...)
May 01 21:10:38 architect hass[24888]: 2020-05-01 21:10:38 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=080420004a6c30014a5f0a100801120673776974636818cc86bde204121e08c90d121974762e6d6f6c6f746f762e4d6f6c6f746f7641707050726f641a2b0a194d6564696152656d6f74652d44656661756c74506c61796572120e44656661756c7420506c6179657259c28906d6552ec241)
May 01 21:10:38 architect hass[24888]: 2020-05-01 21:10:38 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: type: SET_STATE_MESSAGE
May 01 21:10:38 architect hass[24888]: errorCode: NoError
May 01 21:10:38 architect hass[24888]: [setStateMessage] {
May 01 21:10:38 architect hass[24888]:   playbackState: Playing
May 01 21:10:38 architect hass[24888]:   playerPath {
May 01 21:10:38 architect hass[24888]:     origin {
May 01 21:10:38 architect hass[24888]:       type: Local
May 01 21:10:38 architect hass[24888]:       displayName: "switch"
May 01 21:10:38 architect hass[24888]:       identifier: 1280262988
May 01 21:10:38 architect hass[24888]:     }
May 01 21:10:38 architect hass[24888]:     client {
May 01 21:10:38 architect hass[24888]:       processIdentifier: 1737
May 01 21:10:38 architect hass[24888]:       bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:10:38 architect hass[24888]:     }
May 01 21:10:38 architect hass[24888]:     player {
May 01 21:10:38 architect hass[24888]:       identifier: "MediaRemote-DefaultPlayer"
May 01 21:10:38 architect hass[24888]:       displayName: "Default Player"
May 01 21:10:38 architect hass[24888]:     }
May 01 21:10:38 architect hass[24888]:   }
May 01 21:10:38 architect hass[24888]:   playbackStateTimestamp: 610053036.051079
May 01 21:10:38 architect hass[24888]: }
May 01 21:10:38 architect hass[24888]: 2020-05-01 21:10:38 DEBUG (MainThread) [pyatv.mrp.protocol] Dispatching message with type 4 (SetStateMessage) to Listener(func=>, data=None)
May 01 21:10:38 architect hass[24888]: 2020-05-01 21:10:38 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08382000e2039f070abb060a12657069736f64652d323631343836312d3436129e060a2b4b6f682d4c616e74612c206c27c3ae6c65206465732068c3a9726f7320e280a220457069736f64652031302d000000003a03544631980101fa010a696d6167652f6a706567a80201bd020000803fe20212657069736f64652d323631343836312d34368004028804009a049b0362706c6973743030d4010203040506070a582476657273696f6e592461726368697665725424746f7058246f626a6563747312000186a05f100f4e534b657965644172636869766572d1080954726f6f748001a70b0c1718191a1b55246e756c6cd30d0e0f101316574e532e6b6...)
May 01 21:10:38 architect hass[24888]: 2020-05-01 21:10:38 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: type: UPDATE_CONTENT_ITEM_MESSAGE
May 01 21:10:38 architect hass[24888]: errorCode: NoError
May 01 21:10:38 architect hass[24888]: [updateContentItemMessage] {
May 01 21:10:38 architect hass[24888]:   contentItems {
May 01 21:10:38 architect hass[24888]:     identifier: "episode-2614861-46"
May 01 21:10:38 architect hass[24888]:     metadata {
May 01 21:10:38 architect hass[24888]:       title: "Koh-Lanta, l\'\303\256le des h\303\251ros \342\200\242 Episode 10"
May 01 21:10:38 architect hass[24888]:       playbackProgress: 0.0
May 01 21:10:38 architect hass[24888]:       trackArtistName: "TF1"
May 01 21:10:38 architect hass[24888]:       artworkAvailable: true
May 01 21:10:38 architect hass[24888]:       artworkMIMEType: "image/jpeg"
May 01 21:10:38 architect hass[24888]:       isAlwaysLive: true
May 01 21:10:38 architect hass[24888]:       playbackRate: 1.0
May 01 21:10:38 architect hass[24888]:       contentIdentifier: "episode-2614861-46"
May 01 21:10:38 architect hass[24888]:       mediaType: Video
May 01 21:10:38 architect hass[24888]:       mediaSubType: UnknownMediaSubType
May 01 21:10:38 architect hass[24888]:       nowPlayingInfoData: "bplist00\324\001\002\003\004\005\006\007\nX$versionY$archiverT$topX$objects\022\000\001\206\240_\020\017NSKeyedArchiver\...
May 01 21:10:38 architect hass[24888]:       elapsedTimeTimestamp: 610053036.528033
May 01 21:10:38 architect hass[24888]:       currentPlaybackDateData: "bplist00\324\001\002\003\004\005\006\007\nX$versionY$archiverT$topX$objects\022\000\001\206\240_\020\017NSKeyedArch...
May 01 21:10:38 architect hass[24888]:       artworkIdentifier: "D74F59E3-D732-4609-A8BC-597DCC85F88E"
May 01 21:10:38 architect hass[24888]:     }
May 01 21:10:38 architect hass[24888]:     artworkDataWidth: 768
May 01 21:10:38 architect hass[24888]:     artworkDataHeight: 768
May 01 21:10:38 architect hass[24888]:   }
May 01 21:10:38 architect hass[24888]:   playerPath {
May 01 21:10:38 architect hass[24888]:     origin {
May 01 21:10:38 architect hass[24888]:       type: Local
May 01 21:10:38 architect hass[24888]:       displayName: "switch"
May 01 21:10:38 architect hass[24888]:       identifier: 1280262988
May 01 21:10:38 architect hass[24888]:     }
May 01 21:10:38 architect hass[24888]:     client {
May 01 21:10:38 architect hass[24888]:       processIdentifier: 1737
May 01 21:10:38 architect hass[24888]:       bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:10:38 architect hass[24888]:     }
May 01 21:10:38 architect hass[24888]:     player {
May 01 21:10:38 architect hass[24888]:       identifier: "MediaRemote-DefaultPlayer"
May 01 21:10:38 architect hass[24888]:       displayName: "Default Player"
May 01 21:10:38 architect hass[24888]:     }
May 01 21:10:38 architect hass[24888]:   }
May 01 21:10:38 architect hass[24888]: }
May 01 21:10:39 architect hass[24888]: 2020-05-01 21:10:38 DEBUG (MainThread) [pyatv.mrp.protocol] Dispatching message with type 56 (UpdateContentItemMessage) to Listener(func=>, data=None)
May 01 21:10:40 architect hass[24888]: 2020-05-01 21:10:40 INFO (MainThread) [homeassistant.components.automation] Executing Mode film quand l'Apple TV joue le soir
May 01 21:10:40 architect hass[24888]: 2020-05-01 21:10:40 INFO (MainThread) [homeassistant.components.automation] Mode film quand l'Apple TV joue le soir: Running script
May 01 21:10:40 architect hass[24888]: 2020-05-01 21:10:40 INFO (MainThread) [homeassistant.components.automation] Mode film quand l'Apple TV joue le soir: Executing step call service
May 01 21:10:43 architect hass[24888]: 2020-05-01 21:10:43 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 >> Send (Data=0820122430633062626233622d383935332d346437662d623366362d3566643336363563613834322000aa02160800100121000000000000804029000000000000f0bf)
May 01 21:10:43 architect hass[24888]: 2020-05-01 21:10:43 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 >> Send (Encrypted=ab0d0311994b83d6cac0c614c46391602f115a13953ef88e5c55d0ea0f4749a9dcf1170c5dfedc477381789e66cc71412d6276fa3f57dbf5c933cbd9319bf680f3a17239ce5ef6be1ee13cad4455d7cc009b6c)
May 01 21:10:43 architect hass[24888]: 2020-05-01 21:10:43 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 >> Send: Protobuf: type: PLAYBACK_QUEUE_REQUEST_MESSAGE
May 01 21:10:43 architect hass[24888]: identifier: "0c0bbb3b-8953-4d7f-b3f6-5fd3665ca842"
May 01 21:10:43 architect hass[24888]: errorCode: NoError
May 01 21:10:43 architect hass[24888]: [playbackQueueRequestMessage] {
May 01 21:10:43 architect hass[24888]:   location: 0
May 01 21:10:43 architect hass[24888]:   length: 1
May 01 21:10:43 architect hass[24888]:   artworkWidth: 512
May 01 21:10:43 architect hass[24888]:   artworkHeight: -1
May 01 21:10:43 architect hass[24888]: }
May 01 21:10:43 architect hass[24888]: 2020-05-01 21:10:43 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 >> Send (Data=0820122433616337353065362d306266302d343534392d393438372d3465653961376664663535652000aa02160800100121000000000000804029000000000000f0bf)
May 01 21:10:43 architect hass[24888]: 2020-05-01 21:10:43 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 >> Send (Encrypted=a1977c53c8bb4ecc1554df059d9d8443a5f338e49cd75dd75b12604c4ecdf429eca92fef6b2a395dabd386a1a77c2dd064783b60d50b3a2001aa7af06e6a72d575981b1a6f218f375b77b83155259982fe3a30)
May 01 21:10:43 architect hass[24888]: 2020-05-01 21:10:43 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 >> Send: Protobuf: type: PLAYBACK_QUEUE_REQUEST_MESSAGE
May 01 21:10:43 architect hass[24888]: identifier: "3ac750e6-0bf0-4549-9487-4ee9a7fdf55e"
May 01 21:10:43 architect hass[24888]: errorCode: NoError
May 01 21:10:43 architect hass[24888]: [playbackQueueRequestMessage] {
May 01 21:10:43 architect hass[24888]:   location: 0
May 01 21:10:43 architect hass[24888]:   length: 1
May 01 21:10:43 architect hass[24888]:   artworkWidth: 512
May 01 21:10:43 architect hass[24888]:   artworkHeight: -1
May 01 21:10:43 architect hass[24888]: }
May 01 21:10:43 architect hass[24888]: 2020-05-01 21:10:43 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 >> Send (Data=0820122464373733313036382d393832362d343638622d386665352d3237383263333731623938632000aa02160800100121000000000000804029000000000000f0bf)
May 01 21:10:43 architect hass[24888]: 2020-05-01 21:10:43 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 >> Send (Encrypted=ab4077186f8ab85faa156147a482951e0833fc1971a0cd943f71d610991a9fa723a8001414b9b11eff23adf87102c91bbcf4521706d45b32360e1c6051e502ed4a8aabfa90d15e44b554634277bc65598d99c7)
May 01 21:10:43 architect hass[24888]: 2020-05-01 21:10:43 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 >> Send: Protobuf: type: PLAYBACK_QUEUE_REQUEST_MESSAGE
May 01 21:10:43 architect hass[24888]: identifier: "d7731068-9826-468b-8fe5-2782c371b98c"
May 01 21:10:43 architect hass[24888]: errorCode: NoError
May 01 21:10:43 architect hass[24888]: [playbackQueueRequestMessage] {
May 01 21:10:43 architect hass[24888]:   location: 0
May 01 21:10:43 architect hass[24888]:   length: 1
May 01 21:10:43 architect hass[24888]:   artworkWidth: 512
May 01 21:10:43 architect hass[24888]:   artworkHeight: -1
May 01 21:10:43 architect hass[24888]: }
May 01 21:10:43 architect hass[24888]: 2020-05-01 21:10:43 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=8cc2034c05559c292ce57a9cdfa1896653d785dd6cb59be05db960744c6fb581094db16a64d49e4856c945d60fce7ed49be048a6befaec978d4ab5c6f74163c4f2a3f9443d4fe169615a76a4dd02f46b37d2337a5f823f134cc5ba84ef0a45d3fb19b0de51e76895e9e4356aa16e73545fc5a14ce1cf9cc9c7187062ac0696117adc3e673728a24485fbfc48a5483818841baabfdcb643fefbf181ce06e75b27643fb89caede571ac7eb06a9b2aabe8a523dea5b5c1c382df9d25a32a129fec5931177bb89c67e05c4fdfe8010d14c0f07e5abd132a208c3fc1e374937999e5ffe4ad5a0abeaca1e60906f71ebf9b528ce40bb973699aa614c4bb99cfbbed...)
May 01 21:10:43 architect hass[24888]: 2020-05-01 21:10:43 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=0804122430633062626233622d383935332d346437662d623366362d35666433363635636138343220004acec1031aabc00308001292bf030a12657069736f64652d323631343836312d34361af4be03ffd8ffe10ffe4578696600004d4d002a000000080005011a0005000000010000004a011b0005000000010000005201280003000000010002000002130003000000010001000087690004000000010000005a00000000000000480000000100000048000000010007900000070000000430323231910100070000000401020300a00000070000000430313030a00100030000000100010000a00200040000000100000200a00300040000000100000...)
May 01 21:10:43 architect hass[24888]: 2020-05-01 21:10:43 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: type: SET_STATE_MESSAGE
May 01 21:10:43 architect hass[24888]: identifier: "0c0bbb3b-8953-4d7f-b3f6-5fd3665ca842"
May 01 21:10:43 architect hass[24888]: errorCode: NoError
May 01 21:10:43 architect hass[24888]: [setStateMessage] {
May 01 21:10:43 architect hass[24888]:   playbackQueue {
May 01 21:10:43 architect hass[24888]:     location: 0
May 01 21:10:43 architect hass[24888]:     contentItems {
May 01 21:10:43 architect hass[24888]:       identifier: "episode-2614861-46"
May 01 21:10:43 architect hass[24888]:       artworkData: "\377\330\377\341\017\376Exif\000\000MM\000*\000\000\000\010\000\005\001\032\000\005\000\000\000\001\000\000\000J\001\033\000\00...
May 01 21:10:43 architect hass[24888]:       artworkDataWidth: 512
May 01 21:10:43 architect hass[24888]:       artworkDataHeight: 512
May 01 21:10:43 architect hass[24888]:     }
May 01 21:10:43 architect hass[24888]:     requestId: "4F135E15-2D66-4C15-A450-3952C1DB6BDD"
May 01 21:10:43 architect hass[24888]:     resolvedPlayerPath {
May 01 21:10:43 architect hass[24888]:       origin {
May 01 21:10:43 architect hass[24888]:         type: Local
May 01 21:10:43 architect hass[24888]:         displayName: "switch"
May 01 21:10:43 architect hass[24888]:         identifier: 1280262988
May 01 21:10:43 architect hass[24888]:       }
May 01 21:10:43 architect hass[24888]:       client {
May 01 21:10:43 architect hass[24888]:         processIdentifier: 1737
May 01 21:10:43 architect hass[24888]:         bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:10:43 architect hass[24888]:         processUserIdentifier: 501
May 01 21:10:43 architect hass[24888]:         displayName: "Molotov"
May 01 21:10:43 architect hass[24888]:       }
May 01 21:10:43 architect hass[24888]:       player {
May 01 21:10:43 architect hass[24888]:         identifier: "MediaRemote-DefaultPlayer"
May 01 21:10:43 architect hass[24888]:         displayName: "Default Player"
May 01 21:10:43 architect hass[24888]:       }
May 01 21:10:43 architect hass[24888]:     }
May 01 21:10:43 architect hass[24888]:   }
May 01 21:10:43 architect hass[24888]:   playerPath {
May 01 21:10:43 architect hass[24888]:     origin {
May 01 21:10:43 architect hass[24888]:       type: Local
May 01 21:10:43 architect hass[24888]:       displayName: "switch"
May 01 21:10:43 architect hass[24888]:       identifier: 1280262988
May 01 21:10:43 architect hass[24888]:     }
May 01 21:10:43 architect hass[24888]:     client {
May 01 21:10:43 architect hass[24888]:       processIdentifier: 1737
May 01 21:10:43 architect hass[24888]:       bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:10:43 architect hass[24888]:     }
May 01 21:10:43 architect hass[24888]:     player {
May 01 21:10:43 architect hass[24888]:       identifier: "MediaRemote-DefaultPlayer"
May 01 21:10:43 architect hass[24888]:       displayName: "Default Player"
May 01 21:10:43 architect hass[24888]:     }
May 01 21:10:43 architect hass[24888]:   }
May 01 21:10:43 architect hass[24888]:   request {
May 01 21:10:43 architect hass[24888]:     location: 0
May 01 21:10:43 architect hass[24888]:     length: 1
May 01 21:10:43 architect hass[24888]:     artworkWidth: 512.0
May 01 21:10:43 architect hass[24888]:     artworkHeight: -1.0
May 01 21:10:43 architect hass[24888]:     requestID: "4F135E15-2D66-4C15-A450-3952C1DB6BDD"
May 01 21:10:43 architect hass[24888]:   }
May 01 21:10:43 architect hass[24888]: }
May 01 21:10:43 architect hass[24888]: 2020-05-01 21:10:43 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 Require 57448 bytes but only 31853 in buffer
May 01 21:10:43 architect hass[24888]: 2020-05-01 21:10:43 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Data=164bafb24c09475b3cc46ca255b293f356b80e614b94952060b827ab9f023cd4d3e432d600579dd4204046801c12b4d6cbd4c65bdc6b4a546cc82fd788790291155a53825a7c2b255835a2af0d75b715aad60ac0d747a5da696a6bb73fe4f26f709d3bc58528ba0d1733cb6e6d44bc6eb0a23f0f7d2a838ba04484b6b63a5a06fc73d6f5a60aae0dee5aa8cab082e7ec6f4ab921fa373095156752d11f36c44a4a59367e6322a26d52d838eea57fa43e05f6350751acfe7f86d54eb677f7614e954685cf30e0de95a68363c207b0f5a41deceaa400e3f46dc7bf420744d72c7973c5514e9d88a840841e4a04674617eb75d332d677a690426c4cc9f0f5f00...)
May 01 21:10:43 architect hass[24888]: 2020-05-01 21:10:43 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08212000b202cfc003080212dcbf030ad8bf030a140a12657069736f64652d323631343836312d34361292bf030a12657069736f64652d323631343836312d34361af4be03ffd8ffe10ffe4578696600004d4d002a000000080005011a0005000000010000004a011b0005000000010000005201280003000000010002000002130003000000010001000087690004000000010000005a00000000000000480000000100000048000000010007900000070000000430323231910100070000000401020300a00000070000000430313030a00100030000000100010000a00200040000000100000200a00300040000000100000200a406000300000001000...)
May 01 21:10:43 architect hass[24888]: 2020-05-01 21:10:43 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: type: TRANSACTION_MESSAGE
May 01 21:10:43 architect hass[24888]: errorCode: NoError
May 01 21:10:43 architect hass[24888]: [transactionMessage] {
May 01 21:10:43 architect hass[24888]:   name: 2
May 01 21:10:43 architect hass[24888]:   packets {
May 01 21:10:43 architect hass[24888]:     packets {
May 01 21:10:43 architect hass[24888]:       key {
May 01 21:10:43 architect hass[24888]:         identifier: "episode-2614861-46"
May 01 21:10:43 architect hass[24888]:       }
May 01 21:10:43 architect hass[24888]:       packetData: "\n\022episode-2614861-46\032\364\276\003\377\330\377\341\017\376Exif\000\000MM\000*\000\000\000\010\000\005\001\032\000\005\000\...
May 01 21:10:43 architect hass[24888]:       identifier: "059ED5E7-05A9-4BDE-9C7B-BDFEED351815"
May 01 21:10:43 architect hass[24888]:       totalLength: 57234
May 01 21:10:43 architect hass[24888]:       totalWritePosition: 0
May 01 21:10:43 architect hass[24888]:     }
May 01 21:10:43 architect hass[24888]:   }
May 01 21:10:43 architect hass[24888]:   playerPath {
May 01 21:10:43 architect hass[24888]:     origin {
May 01 21:10:43 architect hass[24888]:       type: Local
May 01 21:10:43 architect hass[24888]:       displayName: "switch"
May 01 21:10:43 architect hass[24888]:       identifier: 1280262988
May 01 21:10:43 architect hass[24888]:     }
May 01 21:10:43 architect hass[24888]:     client {
May 01 21:10:43 architect hass[24888]:       processIdentifier: 1737
May 01 21:10:43 architect hass[24888]:       bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:10:43 architect hass[24888]:       processUserIdentifier: 501
May 01 21:10:43 architect hass[24888]:       displayName: "Molotov"
May 01 21:10:43 architect hass[24888]:     }
May 01 21:10:43 architect hass[24888]:     player {
May 01 21:10:43 architect hass[24888]:       identifier: "MediaRemote-DefaultPlayer"
May 01 21:10:43 architect hass[24888]:       displayName: "Default Player"
May 01 21:10:43 architect hass[24888]:     }
May 01 21:10:43 architect hass[24888]:   }
May 01 21:10:43 architect hass[24888]: }
May 01 21:10:43 architect hass[24888]: 2020-05-01 21:10:43 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=0804122433616337353065362d306266302d343534392d393438372d34656539613766646635356520004acec1031aabc00308001292bf030a12657069736f64652d323631343836312d34361af4be03ffd8ffe10ffe4578696600004d4d002a000000080005011a0005000000010000004a011b0005000000010000005201280003000000010002000002130003000000010001000087690004000000010000005a00000000000000480000000100000048000000010007900000070000000430323231910100070000000401020300a00000070000000430313030a00100030000000100010000a00200040000000100000200a00300040000000100000...)
May 01 21:10:43 architect hass[24888]: 2020-05-01 21:10:43 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: type: SET_STATE_MESSAGE
May 01 21:10:43 architect hass[24888]: identifier: "3ac750e6-0bf0-4549-9487-4ee9a7fdf55e"
May 01 21:10:43 architect hass[24888]: errorCode: NoError
May 01 21:10:43 architect hass[24888]: [setStateMessage] {
May 01 21:10:43 architect hass[24888]:   playbackQueue {
May 01 21:10:43 architect hass[24888]:     location: 0
May 01 21:10:43 architect hass[24888]:     contentItems {
May 01 21:10:43 architect hass[24888]:       identifier: "episode-2614861-46"
May 01 21:10:43 architect hass[24888]:       artworkData: "\377\330\377\341\017\376Exif\000\000MM\000*\000\000\000\010\000\005\001\032\000\005\000\000\000\001\000\000\000J\001\033\000\00...
May 01 21:10:43 architect hass[24888]:       artworkDataWidth: 512
May 01 21:10:43 architect hass[24888]:       artworkDataHeight: 512
May 01 21:10:43 architect hass[24888]:     }
May 01 21:10:43 architect hass[24888]:     requestId: "91563391-2BC8-4267-8113-C4F51FB2FF2F"
May 01 21:10:43 architect hass[24888]:     resolvedPlayerPath {
May 01 21:10:43 architect hass[24888]:       origin {
May 01 21:10:43 architect hass[24888]:         type: Local
May 01 21:10:43 architect hass[24888]:         displayName: "switch"
May 01 21:10:43 architect hass[24888]:         identifier: 1280262988
May 01 21:10:43 architect hass[24888]:       }
May 01 21:10:43 architect hass[24888]:       client {
May 01 21:10:43 architect hass[24888]:         processIdentifier: 1737
May 01 21:10:43 architect hass[24888]:         bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:10:43 architect hass[24888]:         processUserIdentifier: 501
May 01 21:10:43 architect hass[24888]:         displayName: "Molotov"
May 01 21:10:43 architect hass[24888]:       }
May 01 21:10:43 architect hass[24888]:       player {
May 01 21:10:43 architect hass[24888]:         identifier: "MediaRemote-DefaultPlayer"
May 01 21:10:43 architect hass[24888]:         displayName: "Default Player"
May 01 21:10:43 architect hass[24888]:       }
May 01 21:10:43 architect hass[24888]:     }
May 01 21:10:43 architect hass[24888]:   }
May 01 21:10:43 architect hass[24888]:   playerPath {
May 01 21:10:43 architect hass[24888]:     origin {
May 01 21:10:43 architect hass[24888]:       type: Local
May 01 21:10:43 architect hass[24888]:       displayName: "switch"
May 01 21:10:43 architect hass[24888]:       identifier: 1280262988
May 01 21:10:43 architect hass[24888]:     }
May 01 21:10:43 architect hass[24888]:     client {
May 01 21:10:43 architect hass[24888]:       processIdentifier: 1737
May 01 21:10:43 architect hass[24888]:       bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:10:43 architect hass[24888]:     }
May 01 21:10:43 architect hass[24888]:     player {
May 01 21:10:43 architect hass[24888]:       identifier: "MediaRemote-DefaultPlayer"
May 01 21:10:43 architect hass[24888]:       displayName: "Default Player"
May 01 21:10:43 architect hass[24888]:     }
May 01 21:10:43 architect hass[24888]:   }
May 01 21:10:43 architect hass[24888]:   request {
May 01 21:10:43 architect hass[24888]:     location: 0
May 01 21:10:43 architect hass[24888]:     length: 1
May 01 21:10:43 architect hass[24888]:     artworkWidth: 512.0
May 01 21:10:43 architect hass[24888]:     artworkHeight: -1.0
May 01 21:10:43 architect hass[24888]:     requestID: "91563391-2BC8-4267-8113-C4F51FB2FF2F"
May 01 21:10:43 architect hass[24888]:   }
May 01 21:10:43 architect hass[24888]: }
May 01 21:10:43 architect hass[24888]: 2020-05-01 21:10:43 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=08212000b202cfc003080212dcbf030ad8bf030a140a12657069736f64652d323631343836312d34361292bf030a12657069736f64652d323631343836312d34361af4be03ffd8ffe10ffe4578696600004d4d002a000000080005011a0005000000010000004a011b0005000000010000005201280003000000010002000002130003000000010001000087690004000000010000005a00000000000000480000000100000048000000010007900000070000000430323231910100070000000401020300a00000070000000430313030a00100030000000100010000a00200040000000100000200a00300040000000100000200a406000300000001000...)
May 01 21:10:43 architect hass[24888]: 2020-05-01 21:10:43 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: type: TRANSACTION_MESSAGE
May 01 21:10:43 architect hass[24888]: errorCode: NoError
May 01 21:10:43 architect hass[24888]: [transactionMessage] {
May 01 21:10:43 architect hass[24888]:   name: 2
May 01 21:10:43 architect hass[24888]:   packets {
May 01 21:10:43 architect hass[24888]:     packets {
May 01 21:10:43 architect hass[24888]:       key {
May 01 21:10:43 architect hass[24888]:         identifier: "episode-2614861-46"
May 01 21:10:43 architect hass[24888]:       }
May 01 21:10:43 architect hass[24888]:       packetData: "\n\022episode-2614861-46\032\364\276\003\377\330\377\341\017\376Exif\000\000MM\000*\000\000\000\010\000\005\001\032\000\005\000\...
May 01 21:10:43 architect hass[24888]:       identifier: "62A13712-D39D-4435-91A0-6E8E80E7217B"
May 01 21:10:43 architect hass[24888]:       totalLength: 57234
May 01 21:10:43 architect hass[24888]:       totalWritePosition: 0
May 01 21:10:43 architect hass[24888]:     }
May 01 21:10:43 architect hass[24888]:   }
May 01 21:10:43 architect hass[24888]:   playerPath {
May 01 21:10:43 architect hass[24888]:     origin {
May 01 21:10:43 architect hass[24888]:       type: Local
May 01 21:10:43 architect hass[24888]:       displayName: "switch"
May 01 21:10:43 architect hass[24888]:       identifier: 1280262988
May 01 21:10:43 architect hass[24888]:     }
May 01 21:10:43 architect hass[24888]:     client {
May 01 21:10:43 architect hass[24888]:       processIdentifier: 1737
May 01 21:10:43 architect hass[24888]:       bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:10:43 architect hass[24888]:       processUserIdentifier: 501
May 01 21:10:43 architect hass[24888]:       displayName: "Molotov"
May 01 21:10:43 architect hass[24888]:     }
May 01 21:10:43 architect hass[24888]:     player {
May 01 21:10:43 architect hass[24888]:       identifier: "MediaRemote-DefaultPlayer"
May 01 21:10:43 architect hass[24888]:       displayName: "Default Player"
May 01 21:10:43 architect hass[24888]:     }
May 01 21:10:43 architect hass[24888]:   }
May 01 21:10:43 architect hass[24888]: }
May 01 21:10:43 architect hass[24888]: 2020-05-01 21:10:43 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive (Decrypted=0804122464373733313036382d393832362d343638622d386665352d32373832633337316239386320004acec1031aabc00308001292bf030a12657069736f64652d323631343836312d34361af4be03ffd8ffe10ffe4578696600004d4d002a000000080005011a0005000000010000004a011b0005000000010000005201280003000000010002000002130003000000010001000087690004000000010000005a00000000000000480000000100000048000000010007900000070000000430323231910100070000000401020300a00000070000000430313030a00100030000000100010000a00200040000000100000200a00300040000000100000...)
May 01 21:10:44 architect hass[24888]: 2020-05-01 21:10:44 DEBUG (MainThread) [pyatv.mrp.connection] 192.168.1.8:57166<->192.168.1.72:49152 << Receive: Protobuf: type: SET_STATE_MESSAGE
May 01 21:10:44 architect hass[24888]: identifier: "d7731068-9826-468b-8fe5-2782c371b98c"
May 01 21:10:44 architect hass[24888]: errorCode: NoError
May 01 21:10:44 architect hass[24888]: [setStateMessage] {
May 01 21:10:44 architect hass[24888]:   playbackQueue {
May 01 21:10:44 architect hass[24888]:     location: 0
May 01 21:10:44 architect hass[24888]:     contentItems {
May 01 21:10:44 architect hass[24888]:       identifier: "episode-2614861-46"
May 01 21:10:44 architect hass[24888]:       artworkData: "\377\330\377\341\017\376Exif\000\000MM\000*\000\000\000\010\000\005\001\032\000\005\000\000\000\001\000\000\000J\001\033\000\00...
May 01 21:10:44 architect hass[24888]:       artworkDataWidth: 512
May 01 21:10:44 architect hass[24888]:       artworkDataHeight: 512
May 01 21:10:44 architect hass[24888]:     }
May 01 21:10:44 architect hass[24888]:     requestId: "B351636D-BE10-47AC-820F-8DADB526C67F"
May 01 21:10:44 architect hass[24888]:     resolvedPlayerPath {
May 01 21:10:44 architect hass[24888]:       origin {
May 01 21:10:44 architect hass[24888]:         type: Local
May 01 21:10:44 architect hass[24888]:         displayName: "switch"
May 01 21:10:44 architect hass[24888]:         identifier: 1280262988
May 01 21:10:44 architect hass[24888]:       }
May 01 21:10:44 architect hass[24888]:       client {
May 01 21:10:44 architect hass[24888]:         processIdentifier: 1737
May 01 21:10:44 architect hass[24888]:         bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:10:44 architect hass[24888]:         processUserIdentifier: 501
May 01 21:10:44 architect hass[24888]:         displayName: "Molotov"
May 01 21:10:44 architect hass[24888]:       }
May 01 21:10:44 architect hass[24888]:       player {
May 01 21:10:44 architect hass[24888]:         identifier: "MediaRemote-DefaultPlayer"
May 01 21:10:44 architect hass[24888]:         displayName: "Default Player"
May 01 21:10:44 architect hass[24888]:       }
May 01 21:10:44 architect hass[24888]:     }
May 01 21:10:44 architect hass[24888]:   }
May 01 21:10:44 architect hass[24888]:   playerPath {
May 01 21:10:44 architect hass[24888]:     origin {
May 01 21:10:44 architect hass[24888]:       type: Local
May 01 21:10:44 architect hass[24888]:       displayName: "switch"
May 01 21:10:44 architect hass[24888]:       identifier: 1280262988
May 01 21:10:44 architect hass[24888]:     }
May 01 21:10:44 architect hass[24888]:     client {
May 01 21:10:44 architect hass[24888]:       processIdentifier: 1737
May 01 21:10:44 architect hass[24888]:       bundleIdentifier: "tv.molotov.MolotovAppProd"
May 01 21:10:44 architect hass[24888]:     }
May 01 21:10:44 architect hass[24888]:     player {
May 01 21:10:44 architect hass[24888]:       identifier: "MediaRemote-DefaultPlayer"
May 01 21:10:44 architect hass[24888]:       displayName: "Default Player"
May 01 21:10:44 architect hass[24888]:     }
May 01 21:10:44 architect hass[24888]:   }
May 01 21:10:44 architect hass[24888]:   request {
May 01 21:10:44 architect hass[24888]:     location: 0
May 01 21:10:44 architect hass[24888]:     length: 1
May 01 21:10:44 architect hass[24888]:     artworkWidth: 512.0
May 01 21:10:44 architect hass[24888]:     artworkHeight: -1.0
May 01 21:10:44 architect hass[24888]:     requestID: "B351636D-BE10-47AC-820F-8DADB526C67F"
May 01 21:10:44 architect hass[24888]:   }
May 01 21:10:44 architect hass[24888]: }
May 01 21:10:49 architect hass[24888]: 2020-05-01 21:10:49 INFO (MainThread) [homeassistant.components.automation] Mode film quand l'Apple TV joue le soir: Test condition sun: True
May 01 21:10:49 architect hass[24888]: 2020-05-01 21:10:49 INFO (MainThread) [homeassistant.components.automation] Mode film quand l'Apple TV joue le soir: Executing step call service
May 01 21:14:49 architect hass[24888]: 2020-05-01 21:14:49 INFO (Thread-3) [pyhap.hap_server] Got connection with ('192.168.1.59', 49970).
May 01 21:14:49 architect hass[24888]: 2020-05-01 21:14:49 INFO (Thread-356) [pyhap.hap_server] 192.168.1.59 - "POST /pair-verify HTTP/1.1" 200 -
May 01 21:14:49 architect hass[24888]: 2020-05-01 21:14:49 INFO (Thread-356) [pyhap.hap_server] 192.168.1.59 - "POST /pair-verify HTTP/1.1" 200 -
May 01 21:14:49 architect hass[24888]: 2020-05-01 21:14:49 INFO (Thread-356) [pyhap.hap_server] 192.168.1.59 - "GET /accessories HTTP/1.1" 200 -
May 01 21:16:55 architect hass[24888]: 2020-05-01 21:16:55 INFO (MainThread) [aiofreepybox.access] Session opened
May 01 21:16:55 architect hass[24888]: 2020-05-01 21:16:55 INFO (MainThread) [aiofreepybox.access] Permissions: {'parental': True, 'explorer': True, 'contacts': True, 'tv': True, 'downloader': True, 'settings': True, 'calls': True, 'player': True, 'pvr': True, 'home': True, 'camera': True}
May 01 21:16:55 architect hass[24888]: 2020-05-01 21:16:55 INFO (MainThread) [aiofreepybox.access] Session opened
May 01 21:16:55 architect hass[24888]: 2020-05-01 21:16:55 INFO (MainThread) [aiofreepybox.access] Permissions: {'parental': True, 'explorer': True, 'contacts': True, 'tv': True, 'downloader': True, 'settings': True, 'calls': True, 'player': True, 'pvr': True, 'home': True, 'camera': True}
May 01 21:19:33 architect hass[24888]: 2020-05-01 21:19:33 INFO (Thread-3) [pyhap.hap_server] Got connection with ('192.168.1.59', 49976).
May 01 21:19:33 architect hass[24888]: 2020-05-01 21:19:33 INFO (Thread-357) [pyhap.hap_server] 192.168.1.59 - "POST /pair-verify HTTP/1.1" 200 -
May 01 21:19:33 architect hass[24888]: 2020-05-01 21:19:33 INFO (Thread-357) [pyhap.hap_server] 192.168.1.59 - "POST /pair-verify HTTP/1.1" 200 -
May 01 21:19:33 architect hass[24888]: 2020-05-01 21:19:33 INFO (Thread-357) [pyhap.hap_server] 192.168.1.59 - "GET /accessories HTTP/1.1" 200 -
May 01 21:20:56 architect hass[24888]: 2020-05-01 21:20:56 INFO (Thread-3) [pyhap.hap_server] Got connection with ('192.168.1.59', 49978).
May 01 21:20:56 architect hass[24888]: 2020-05-01 21:20:56 INFO (Thread-358) [pyhap.hap_server] 192.168.1.59 - "POST /pair-verify HTTP/1.1" 200 -
May 01 21:20:56 architect hass[24888]: 2020-05-01 21:20:56 INFO (Thread-358) [pyhap.hap_server] 192.168.1.59 - "POST /pair-verify HTTP/1.1" 200 -
May 01 21:20:56 architect hass[24888]: 2020-05-01 21:20:56 INFO (Thread-358) [pyhap.hap_server] 192.168.1.59 - "GET /accessories HTTP/1.1" 200 -
May 01 21:27:51 architect hass[24888]: 2020-05-01 21:27:51 INFO (Thread-3) [pyhap.hap_server] Got connection with ('192.168.1.59', 49984).
May 01 21:27:51 architect hass[24888]: 2020-05-01 21:27:51 INFO (Thread-359) [pyhap.hap_server] 192.168.1.59 - "POST /pair-verify HTTP/1.1" 200 -
May 01 21:27:51 architect hass[24888]: 2020-05-01 21:27:51 INFO (Thread-359) [pyhap.hap_server] 192.168.1.59 - "POST /pair-verify HTTP/1.1" 200 -
May 01 21:27:51 architect hass[24888]: 2020-05-01 21:27:51 INFO (Thread-359) [pyhap.hap_server] 192.168.1.59 - "GET /accessories HTTP/1.1" 200 -
May 01 21:29:50 architect hass[24888]: 2020-05-01 21:29:50 INFO (Thread-3) [pyhap.hap_server] Got connection with ('192.168.1.59', 49986).
May 01 21:29:50 architect hass[24888]: 2020-05-01 21:29:50 INFO (Thread-360) [pyhap.hap_server] 192.168.1.59 - "POST /pair-verify HTTP/1.1" 200 -
May 01 21:29:51 architect hass[24888]: 2020-05-01 21:29:51 INFO (Thread-360) [pyhap.hap_server] 192.168.1.59 - "POST /pair-verify HTTP/1.1" 200 -
May 01 21:29:51 architect hass[24888]: 2020-05-01 21:29:51 INFO (Thread-360) [pyhap.hap_server] 192.168.1.59 - "GET /accessories HTTP/1.1" 200 -
May 01 21:34:43 architect hass[24888]: 2020-05-01 21:34:43 INFO (Thread-3) [pyhap.hap_server] Got connection with ('192.168.1.59', 49991).
May 01 21:34:43 architect hass[24888]: 2020-05-01 21:34:43 INFO (Thread-361) [pyhap.hap_server] 192.168.1.59 - "POST /pair-verify HTTP/1.1" 200 -
May 01 21:34:43 architect hass[24888]: 2020-05-01 21:34:43 INFO (Thread-361) [pyhap.hap_server] 192.168.1.59 - "POST /pair-verify HTTP/1.1" 200 -
May 01 21:34:43 architect hass[24888]: 2020-05-01 21:34:43 INFO (Thread-361) [pyhap.hap_server] 192.168.1.59 - "GET /accessories HTTP/1.1" 200 -
May 01 21:36:35 architect hass[24888]: 2020-05-01 21:36:35 INFO (Thread-3) [pyhap.hap_server] Got connection with ('192.168.1.59', 49994).
May 01 21:36:35 architect hass[24888]: 2020-05-01 21:36:35 INFO (Thread-362) [pyhap.hap_server] 192.168.1.59 - "POST /pair-verify HTTP/1.1" 200 -
May 01 21:36:35 architect hass[24888]: 2020-05-01 21:36:35 INFO (Thread-362) [pyhap.hap_server] 192.168.1.59 - "POST /pair-verify HTTP/1.1" 200 -
May 01 21:36:35 architect hass[24888]: 2020-05-01 21:36:35 INFO (Thread-362) [pyhap.hap_server] 192.168.1.59 - "GET /accessories HTTP/1.1" 200 -
May 01 21:40:29 architect hass[24888]: 2020-05-01 21:40:29 INFO (Thread-3) [pyhap.hap_server] Got connection with ('192.168.1.59', 49996).
May 01 21:40:29 architect hass[24888]: 2020-05-01 21:40:29 INFO (Thread-363) [pyhap.hap_server] 192.168.1.59 - "POST /pair-verify HTTP/1.1" 200 -
May 01 21:40:29 architect hass[24888]: 2020-05-01 21:40:29 INFO (Thread-363) [pyhap.hap_server] 192.168.1.59 - "POST /pair-verify HTTP/1.1" 200 -
May 01 21:40:29 architect hass[24888]: 2020-05-01 21:40:29 INFO (Thread-363) [pyhap.hap_server] 192.168.1.59 - "GET /accessories HTTP/1.1" 200 -
May 01 21:49:31 architect hass[24888]: 2020-05-01 21:49:31 INFO (Thread-3) [pyhap.hap_server] Got connection with ('192.168.1.59', 50000).
May 01 21:49:31 architect hass[24888]: 2020-05-01 21:49:31 INFO (Thread-364) [pyhap.hap_server] 192.168.1.59 - "POST /pair-verify HTTP/1.1" 200 -
May 01 21:49:31 architect hass[24888]: 2020-05-01 21:49:31 INFO (Thread-364) [pyhap.hap_server] 192.168.1.59 - "POST /pair-verify HTTP/1.1" 200 -
May 01 21:49:31 architect hass[24888]: 2020-05-01 21:49:31 INFO (Thread-364) [pyhap.hap_server] 192.168.1.59 - "GET /accessories HTTP/1.1" 200 -
May 01 21:58:48 architect hass[24888]: 2020-05-01 21:58:48 INFO (Thread-3) [pyhap.hap_server] Got connection with ('192.168.1.59', 50011).
May 01 21:58:48 architect hass[24888]: 2020-05-01 21:58:48 INFO (Thread-365) [pyhap.hap_server] 192.168.1.59 - "POST /pair-verify HTTP/1.1" 200 -
May 01 21:58:48 architect hass[24888]: 2020-05-01 21:58:48 INFO (Thread-365) [pyhap.hap_server] 192.168.1.59 - "POST /pair-verify HTTP/1.1" 200 -
May 01 21:58:48 architect hass[24888]: 2020-05-01 21:58:48 INFO (Thread-365) [pyhap.hap_server] 192.168.1.59 - "GET /accessories HTTP/1.1" 200 -
May 01 22:06:08 architect hass[24888]: 2020-05-01 22:06:08 INFO (MainThread) [zigpy_deconz.zigbee.application] New device joined: 0x32eb, 14:b4:57:ff:fe:70:b5:f9
May 01 22:06:08 architect hass[24888]: 2020-05-01 22:06:08 INFO (MainThread) [zigpy.application] Device 0x32eb (14:b4:57:ff:fe:70:b5:f9) joined the network
May 01 22:06:26 architect hass[24888]: 2020-05-01 22:06:26 ERROR (MainThread) [zigpy.zcl] [0x32eb:1:0x0020] Traceback (most recent call last):
May 01 22:06:26 architect hass[24888]:   File "/srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/zha/core/channels/general.py", line 373, in check_in_response
May 01 22:06:26 architect hass[24888]:     await self.checkin_response(True, self.CHECKIN_FAST_POLL_TIMEOUT, tsn=tsn)
May 01 22:06:26 architect hass[24888]:   File "/srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/zha/core/channels/base.py", line 49, in wrapper
May 01 22:06:26 architect hass[24888]:     result = await command(*args, **kwds)
May 01 22:06:26 architect hass[24888]:   File "/srv/homeassistant/lib/python3.7/site-packages/zigpy/device.py", line 178, in request
May 01 22:06:26 architect hass[24888]:     with self._pending.new(sequence) as req:
May 01 22:06:26 architect hass[24888]:   File "/srv/homeassistant/lib/python3.7/site-packages/zigpy/util.py", line 247, in new
May 01 22:06:26 architect hass[24888]:     return Request(self, sequence)
May 01 22:06:26 architect hass[24888]:   File "/srv/homeassistant/lib/python3.7/site-packages/zigpy/util.py", line 216, in __init__
May 01 22:06:26 architect hass[24888]:     assert sequence not in pending
May 01 22:06:26 architect hass[24888]: AssertionError
May 01 22:06:26 architect hass[24888]: 
May 01 22:06:36 architect hass[24888]: 2020-05-01 22:06:36 ERROR (MainThread) [zigpy.zcl] [0x32eb:1:0x0020] Traceback (most recent call last):
May 01 22:06:36 architect hass[24888]:   File "/srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/zha/core/channels/general.py", line 373, in check_in_response
May 01 22:06:36 architect hass[24888]:     await self.checkin_response(True, self.CHECKIN_FAST_POLL_TIMEOUT, tsn=tsn)
May 01 22:06:36 architect hass[24888]:   File "/srv/homeassistant/lib/python3.7/site-packages/homeassistant/components/zha/core/channels/base.py", line 49, in wrapper
May 01 22:06:36 architect hass[24888]:     result = await command(*args, **kwds)
May 01 22:06:36 architect hass[24888]:   File "/srv/homeassistant/lib/python3.7/site-packages/zigpy/device.py", line 178, in request
May 01 22:06:36 architect hass[24888]:     with self._pending.new(sequence) as req:
May 01 22:06:36 architect hass[24888]:   File "/srv/homeassistant/lib/python3.7/site-packages/zigpy/util.py", line 247, in new
May 01 22:06:36 architect hass[24888]:     return Request(self, sequence)
May 01 22:06:36 architect hass[24888]:   File "/srv/homeassistant/lib/python3.7/site-packages/zigpy/util.py", line 216, in __init__
May 01 22:06:36 architect hass[24888]:     assert sequence not in pending
May 01 22:06:36 architect hass[24888]: AssertionError
May 01 22:06:36 architect hass[24888]: 
May 01 22:14:27 architect hass[24888]: 2020-05-01 22:14:27 INFO (Thread-3) [pyhap.hap_server] Got connection with ('192.168.1.59', 50023).
May 01 22:14:27 architect hass[24888]: 2020-05-01 22:14:27 INFO (Thread-461) [pyhap.hap_server] 192.168.1.59 - "POST /pair-verify HTTP/1.1" 200 -
May 01 22:14:27 architect hass[24888]: 2020-05-01 22:14:27 INFO (Thread-461) [pyhap.hap_server] 192.168.1.59 - "POST /pair-verify HTTP/1.1" 200 -
May 01 22:14:27 architect hass[24888]: 2020-05-01 22:14:27 INFO (Thread-461) [pyhap.hap_server] 192.168.1.59 - "GET /accessories HTTP/1.1" 200 -
May 01 22:16:02 architect hass[24888]: 2020-05-01 22:16:02 INFO (Thread-3) [pyhap.hap_server] Got connection with ('192.168.1.59', 50025).
May 01 22:16:02 architect hass[24888]: 2020-05-01 22:16:02 INFO (Thread-462) [pyhap.hap_server] 192.168.1.59 - "POST /pair-verify HTTP/1.1" 200 -
May 01 22:16:02 architect hass[24888]: 2020-05-01 22:16:02 INFO (Thread-462) [pyhap.hap_server] 192.168.1.59 - "POST /pair-verify HTTP/1.1" 200 -
May 01 22:16:02 architect hass[24888]: 2020-05-01 22:16:02 INFO (Thread-462) [pyhap.hap_server] 192.168.1.59 - "GET /accessories HTTP/1.1" 200 -
May 01 22:18:55 architect hass[24888]: 2020-05-01 22:18:55 INFO (MainThread) [aiofreepybox.access] Session opened
May 01 22:18:55 architect hass[24888]: 2020-05-01 22:18:55 INFO (MainThread) [aiofreepybox.access] Permissions: {'parental': True, 'explorer': True, 'contacts': True, 'tv': True, 'downloader': True, 'settings': True, 'calls': True, 'player': True, 'pvr': True, 'home': True, 'camera': True}
May 01 22:18:55 architect hass[24888]: 2020-05-01 22:18:55 INFO (MainThread) [aiofreepybox.access] Session opened
May 01 22:18:55 architect hass[24888]: 2020-05-01 22:18:55 INFO (MainThread) [aiofreepybox.access] Permissions: {'parental': True, 'explorer': True, 'contacts': True, 'tv': True, 'downloader': True, 'settings': True, 'calls': True, 'player': True, 'pvr': True, 'home': True, 'camera': True}
May 01 22:27:48 architect hass[24888]: 2020-05-01 22:27:48 ERROR (MainThread) [homeassistant.components.websocket_api.http.connection.1413244400] Client unable to keep up with pending messages. Stayed over 512 for 5 seconds
May 01 22:27:48 architect hass[24888]: 2020-05-01 22:27:48 INFO (MainThread) [homeassistant.components.websocket_api.http.connection.1413244400] Connection closed by client
May 01 22:32:51 architect hass[24888]: 2020-05-01 22:32:51 ERROR (MainThread) [homeassistant.core] Error doing job: Fatal read error on socket transport
May 01 22:32:51 architect hass[24888]: Traceback (most recent call last):
May 01 22:32:51 architect hass[24888]:   File "/usr/lib/python3.7/asyncio/selector_events.py", line 801, in _read_ready__data_received
May 01 22:32:51 architect hass[24888]:     data = self._sock.recv(self.max_size)
May 01 22:32:51 architect hass[24888]: TimeoutError: [Errno 110] Connection timed out
postlund commented 4 years ago

Hmm, since the last message is artwork, perhaps this is related to #609 somehow. Will have to check a bit more.

Crocmagnon commented 4 years ago

FYI I reproduced it today with how I met your mother on Netflix.

Don’t have a log though.

After quickly reading #609, yeah it seems related.

I didn’t notice it with older (but recent, like 1-2 weeks ago) releases of pyatv.

Crocmagnon commented 4 years ago

Would there be something I could do to help resolve this issue? 😊 It breaks a non-null amount of workflows for me 😛

postlund commented 4 years ago

It would kinda be interesting to narrow it down to see if artwork is the problem. If you could remove artwork support and try again, that would be great input. You just need to remove the media_image_hash and async_get_media_image methods from media_player.py.

Crocmagnon commented 4 years ago

I tried the following:

  1. Comment out the methods
  2. Restart HA
  3. Try to play a media that caused the issue before a. State changes are reflected flawlessly (although with a very slight delay)
  4. Remove comments (restore methods)
  5. Restart HA
  6. Try to play a media that caused the issue before a. After having displayed the artwork, the state does not change anymore.

Here are the logs of the second attempt (the failed one): https://gist.github.com/Crocmagnon/39bfcb056bcf3f84eff23f818d817074

So I'd be tempted to say that the issue is indeed linked to the artwork :)

Crocmagnon commented 4 years ago

As a workaround, I'm keeping the methods commented for the moment.

postlund commented 4 years ago

Ah, that is excellent work! 😊 This at least gives me something to work with. I will have to dig a bit into the code to figure out what is happening.

If you want to help out some more, there's one thing to try out. I would like to know if we get stuck inside pyatv when requesting the artwork. So, if we add some log points before and after the artwork is fetched, then we can see if we get "stuck" by matching those log points. I'm thinking something along the lines of:


    async def async_get_media_image(self):
        """Fetch media image of current playing image."""
        state = self.state
        if self._playing and state not in [STATE_OFF, STATE_IDLE]:
            _LOGGER.warning("fetching artwork")
            artwork = await self.atv.metadata.artwork()
            _LOGGER.warning("artwork fetched")
            if artwork:
                return artwork.bytes, artwork.mimetype

        return None, None

Using warning to make it easier to spot in the log.

Crocmagnon commented 4 years ago

I can't reproduce the issue this morning after having upgraded HACS from 0.24.3 to 0.24.4.

Crocmagnon commented 4 years ago

No luck reproducing after re-downgrading to 0.24.3 either. I'll re-upgrade and check later in the day.

Crocmagnon commented 4 years ago

Got it again tonight: https://gist.github.com/Crocmagnon/bca786061b941a0e954688953484d943

Didn't do anything special this time, but it's frozen to the second to last episode we watched ("Petits sabotages entre amis")

postlund commented 4 years ago

Hmm, based on the logs I don't see anything "strange", but state changes doesn't seem to come. I assume you watched mentioned episode and continued with the next? Based on that at least... you started to watch around 21:02:07 and the duration is 1316s=22min, so we should see some updates around 21:24. But there are none. Not really sure why or what is blocking here.

Crocmagnon commented 4 years ago

I assume you watched mentioned episode and continued with the next?

You are correct.

postlund commented 4 years ago

I noticed these were present both in you first and last log:

May 09 21:31:55 architect hass[18673]: 2020-05-09 21:31:55 ERROR (MainThread) [homeassistant.core] Error doing job: Fatal read error on socket transport
May 09 21:31:55 architect hass[18673]: Traceback (most recent call last):
May 09 21:31:55 architect hass[18673]:   File "/usr/lib/python3.7/asyncio/selector_events.py", line 801, in _read_ready__data_received
May 09 21:31:55 architect hass[18673]:     data = self._sock.recv(self.max_size)
May 09 21:31:55 architect hass[18673]: TimeoutError: [Errno 110] Connection timed out

Since no information is available that allows us to trace back to its source, we can't really draw any conclusions. But perhaps it's related to pyatv? Strange thing is that it's not signaled back to pyatv in that case. Any why does it even happen? Would it be possible for you to take a traffic dump with tcpdump (e.g. tcpdump -w traffic.pcap "host <ATV ip>)? It could help me find if the connection is closed.

Crocmagnon commented 4 years ago

I just tried your suggestion but couldn't reproduce the bug. Sorry 😕

postlund commented 4 years ago

@Crocmagnon Just wanted to see if you are still running with my integration and if you still see these issues with latest update?

Crocmagnon commented 4 years ago

I’ve upgraded recently and haven’t had yet the time to test. I’ll be able to tell you more on Monday ! 🙂

Crocmagnon commented 4 years ago

I couldn't reproduce the bug on 31c334e today 👍 I'm closing this issue, I'll comment here later if I happen to reproduce it!

Crocmagnon commented 4 years ago

Running on integration commit 6e8190c, Home Assistant 0.115.0, tvOS 14 I reproduced the issue this morning. Unfortunately I don't have any logs to share.

It happened with the Music app.

I'll upgrade HA to 0.115.2 and will keep you updated if I encounter it again.

postlund commented 3 years ago

@Crocmagnon Can you please retry with latest version of Home Assistant (beta component not needed, but works as well)?

Crocmagnon commented 3 years ago

I haven't noticed any issue with the latest HA version (using the new stable integration). Again, I'll close the issue and I'll reopen it if I notice it again 🙂