Hi I just recently updated to the latest server build and I started to bump into issues with playing media files on my iPhone. I get the following message “playback was terminated by the server. A required codec could not be found or failed to install”. Below is the server version and logs of the event, thank you.
Server Version#: 1.15.4.919 Unraid Docker
Player Version#: Lastest iOS app
Apr 15, 2019 12:22:28.334 [0x14a180326700] DEBUG - [Now] Device is iOS
Apr 15, 2019 12:22:28.335 [0x14a180326700] DEBUG - [Now] Profile is iOS
Apr 15, 2019 12:22:28.335 [0x14a180326700] DEBUG - [Now] Updated play state for /library/metadata/43548.
Apr 15, 2019 12:22:28.335 [0x14a180326700] DEBUG - HubCache: Expiring ‘1/home.continue/1/hubs/en-US;q=1/count=50&includeCollections=1&includeExternalMedia=1&includeTypeFirst=1’ because of event plex.event.play.session.state.update.
Apr 15, 2019 12:22:28.335 [0x14a180326700] DEBUG - HubCache: Expiring ‘1/home.ondeck/1/hubs/en-US;q=1/count=50&includeCollections=1&includeExternalMedia=1&includeTypeFirst=1’ because of event plex.event.play.session.state.update.
Apr 15, 2019 12:22:28.335 [0x14a180326700] DEBUG - HubCache: Expiring ‘1/home.television.recent/1/hubs/en-US;q=1/count=50&includeCollections=1&includeExternalMedia=1&includeTypeFirst=1’ because event plex.event.play.session.state.update referenced an item the hub contained
Apr 15, 2019 12:22:28.338 [0x14a180326700] DEBUG - Statistics: (C557CD48-2522-4622-9711-4363329C42EA) Reporting active playback in state 2 of type 4 (scrobble: 0) for account 1
Apr 15, 2019 12:22:28.341 [0x14a180527700] DEBUG - Completed: [192.168.1.155:50396] 200 GET /:/timeline?bufferedTime=0&duration=3729732&key=%2Flibrary%2Fmetadata%2F43548&location=lan&playQueueItemID=26821&playbackTime=0&ratingKey=43548&state=buffering&time=0 (20 live) TLS GZIP 12ms 493 bytes (pipelined: 15)
Apr 15, 2019 12:22:28.347 [0x14a180728700] DEBUG - Auth: authenticated user 1 as HavokValor
Apr 15, 2019 12:22:28.347 [0x14a173fff700] DEBUG - Request: [192.168.1.165:51789 (Allowed Network (Subnet))] GET /status/sessions (21 live) TLS GZIP Signed-in Token (HavokValor)
Apr 15, 2019 12:22:28.348 [0x14a173fff700] DEBUG - [Now] Adding 2 sessions.
Apr 15, 2019 12:22:28.349 [0x14a180728700] DEBUG - Completed: [192.168.1.165:51789] 200 GET /status/sessions (21 live) TLS GZIP 2ms 1974 bytes (pipelined: 1)
Apr 15, 2019 12:22:28.352 [0x14a180527700] DEBUG - Auth: authenticated user 1 as HavokValor
Apr 15, 2019 12:22:28.352 [0x14a0f39fc700] DEBUG - Request: [192.168.1.155:50403 (Subnet)] GET /transcode/sessions (21 live) TLS GZIP Signed-in Token (HavokValor)
Apr 15, 2019 12:22:28.354 [0x14a180527700] DEBUG - Completed: [192.168.1.155:50403] 200 GET /transcode/sessions (21 live) TLS GZIP 1ms 397 bytes (pipelined: 7)
Apr 15, 2019 12:22:28.412 [0x14a180527700] DEBUG - Auth: authenticated user 1 as HavokValor
Apr 15, 2019 12:22:28.413 [0x14a171522700] DEBUG - Request: [192.168.1.155:50418 (Subnet)] GET /video/:/transcode/universal/start.m3u8?audioBoost=100&autoAdjustQuality=0&directPlay=1&directStream=1&directStreamAudio=1&fastSeek=1&includeCodecs=1&location=lan&mediaBufferSize=40000&partIndex=0&path=%2Flibrary%2Fmetadata%2F43548&protocol=hls&session=DE7F8C55-61C6-4C47-9D31-FFBBE966672C&subtitleSize=100&videoQuality=100&videoResolution=3840x2160 (22 live) TLS GZIP Signed-in Token (HavokValor)
Apr 15, 2019 12:22:28.413 [0x14a171522700] DEBUG - Found session GUID of DE7F8C55-61C6-4C47-9D31-FFBBE966672C in session start.
Apr 15, 2019 12:22:28.415 [0x14a171522700] DEBUG - TranscodeUniversalRequest: using profile iOS
Apr 15, 2019 12:22:28.415 [0x14a171522700] DEBUG - Downloading document http://127.0.0.1:32400/library/metadata/43548?checkFiles=1&includeBandwidths=1&offset=-1&X-Plex-Incomplete-Segments=1&X-Plex-Session-Identifier=C557CD48-2522-4622-9711-4363329C42EA
Apr 15, 2019 12:22:28.415 [0x14a171522700] DEBUG - Auth: authenticated user 1 as HavokValor
Apr 15, 2019 12:22:28.421 [0x14a171522700] DEBUG - We’re going to try to auto-select an audio stream for account 1.
Apr 15, 2019 12:22:28.421 [0x14a171522700] DEBUG - Selecting best audio stream for part ID 61895 (autoselect: 0 language: en)
Apr 15, 2019 12:22:28.421 [0x14a171522700] DEBUG - Audio Stream: 166456, Subtitle Stream: -1
Apr 15, 2019 12:22:28.422 [0x14a171522700] DEBUG - Found session GUID of DE7F8C55-61C6-4C47-9D31-FFBBE966672C in session start.
Apr 15, 2019 12:22:28.422 [0x14a171522700] DEBUG - Using session GUID DE7F8C55-61C6-4C47-9D31-FFBBE966672C for new transcode session.
Apr 15, 2019 12:22:28.422 [0x14a171522700] DEBUG - Cleaning directory for session DE7F8C55-61C6-4C47-9D31-FFBBE966672C ()
Apr 15, 2019 12:22:28.424 [0x14a180527700] DEBUG - Completed: [192.168.1.155:50418] 200 GET /video/:/transcode/universal/start.m3u8?audioBoost=100&autoAdjustQuality=0&directPlay=1&directStream=1&directStreamAudio=1&fastSeek=1&includeCodecs=1&location=lan&mediaBufferSize=40000&partIndex=0&path=%2Flibrary%2Fmetadata%2F43548&protocol=hls&session=DE7F8C55-61C6-4C47-9D31-FFBBE966672C&subtitleSize=100&videoQuality=100&videoResolution=3840x2160 (22 live) TLS GZIP 11ms 504 bytes (pipelined: 1)
Apr 15, 2019 12:22:28.430 [0x14a180326700] DEBUG - Request: [192.168.1.155:50418 (Subnet)] GET /video/:/transcode/universal/session/DE7F8C55-61C6-4C47-9D31-FFBBE966672C/base/index.m3u8 (22 live) TLS GZIP Signed-in
Apr 15, 2019 12:22:28.431 [0x14a180326700] DEBUG - Found session GUID of DE7F8C55-61C6-4C47-9D31-FFBBE966672C in session start.
Apr 15, 2019 12:22:28.431 [0x14a180326700] DEBUG - Starting a transcode session DE7F8C55-61C6-4C47-9D31-FFBBE966672C at offset -1.0 (state=3)
Apr 15, 2019 12:22:28.431 [0x14a180326700] ERROR - Error creating directory “/transcode”: boost::filesystem::create_directory: Permission denied: “/transcode”
Apr 15, 2019 12:22:28.436 [0x14a180326700] INFO - CodecManager: obtaining EAE
Apr 15, 2019 12:22:28.436 [0x14a180326700] DEBUG - HTTP requesting GET https://plex.tv/api/codecs/easyaudioencoder?build=linux-x86_64-standard&deviceId=23c683c2-ccd2-4fd3-a4f9-d564d4864a5e&oldestPreviousVersion=1.15.1.710-ece95b3a1&version=eae-69c1de6-25
Apr 15, 2019 12:22:28.861 [0x14a180326700] DEBUG - HTTP 200 response from GET https://plex.tv/api/codecs/easyaudioencoder?build=linux-x86_64-standard&deviceId=23c683c2-ccd2-4fd3-a4f9-d564d4864a5e&oldestPreviousVersion=1.15.1.710-ece95b3a1&version=eae-69c1de6-25
Apr 15, 2019 12:22:28.861 [0x14a180326700] DEBUG - HTTP requesting GET https://downloads.plex.tv/codecs/eae-69c1de6-25/linux-x86_64-standard/EasyAudioEncoder-linux-x86_64-standard.zip
Apr 15, 2019 12:22:29.000 [0x14a180326700] DEBUG - HTTP 200 response from GET https://downloads.plex.tv/codecs/eae-69c1de6-25/linux-x86_64-standard/EasyAudioEncoder-linux-x86_64-standard.zip
Apr 15, 2019 12:22:29.063 [0x14a180326700] ERROR - Unzip: could not set executable bit on output file
Apr 15, 2019 12:22:29.064 [0x14a180326700] ERROR - CodecManager: failed to extract zip
Apr 15, 2019 12:22:29.064 [0x14a180326700] ERROR - Error configuring transcoder: Decoder install failed: eac3_eae
Apr 15, 2019 12:22:29.064 [0x14a180326700] DEBUG - Streaming Resource: Terminated session 0x14a104401560:C557CD48-2522-4622-9711-4363329C42EA with reason Conversion failed. A required codec could not be found or failed to install.
Apr 15, 2019 12:22:29.064 [0x14a1735fa700] DEBUG - Killing job.
Apr 15, 2019 12:22:29.064 [0x14a1735fa700] DEBUG - Job was already killed, not killing again.
Apr 15, 2019 12:22:29.064 [0x14a1735fa700] DEBUG - Stopping transcode session DE7F8C55-61C6-4C47-9D31-FFBBE966672C
Apr 15, 2019 12:22:29.064 [0x14a1737fb700] DEBUG - Cleaning directory for session DE7F8C55-61C6-4C47-9D31-FFBBE966672C (/config/transcode/Transcode/Sessions/plex-transcode-DE7F8C55-61C6-4C47-9D31-FFBBE966672C-f055b8a7-1e9e-4bcc-95f4-49355dbccb0c)
Apr 15, 2019 12:22:29.065 [0x14a180728700] DEBUG - Completed: [192.168.1.155:50418] 500 GET /video/:/transcode/universal/session/DE7F8C55-61C6-4C47-9D31-FFBBE966672C/base/index.m3u8 (22 live) TLS GZIP 635ms 405 bytes (pipelined: 2)
Apr 15, 2019 12:22:29.070 [0x14a1735fa700] DEBUG - Transcoder: Cleaning old transcode directories.
Apr 15, 2019 12:22:29.070 [0x14a1735fa700] ERROR - Error creating directory “/transcode”: boost::filesystem::create_directory: Permission denied: “/transcode”
Apr 15, 2019 12:22:29.070 [0x14a1735fa700] DEBUG - Whacked session DE7F8C55-61C6-4C47-9D31-FFBBE966672C, 0 remaining.
Apr 15, 2019 12:22:29.108 [0x14a180728700] DEBUG - Auth: authenticated user 1 as HavokValor
Apr 15, 2019 12:22:29.108 [0x14a0f37fb700] DEBUG - Request: [192.168.1.155:50396 (Subnet)] GET /:/timeline?bufferedTime=0&duration=3729732&key=%2Flibrary%2Fmetadata%2F43548&location=lan&playQueueItemID=26821&playbackTime=0&ratingKey=43548&state=buffering&time=0 (22 live) TLS GZIP Signed-in Token (HavokValor)
Apr 15, 2019 12:22:29.110 [0x14a0f37fb700] DEBUG - Client [C557CD48-2522-4622-9711-4363329C42EA] reporting timeline state buffering, progress of 0/3729732ms for guid=, ratingKey=43548 url=, key=/library/metadata/43548, containerKey=, metadataId=43548, source=

