MrCatters
commented
2 years ago I am having the same issue. Instant error on version 10.8.1 with no FFMPEG logs. A longer "attempt" at playback on 10.8.0 with an FFMPEG log.
10.8.0 Log:
[2022-07-03 21:02:54.057 -04:00] [INF] [29] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "redacted". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True [2022-07-03 21:02:54.057 -04:00] [INF] [29] Jellyfin.Api.Helpers.MediaInfoHelper: RemoteClientBitrateLimit: 8000000, RemoteIp: "192.168.68.110", IsInLocalNetwork: True [2022-07-03 21:02:54.114 -04:00] [INF] [29] Jellyfin.Api.Helpers.MediaInfoHelper: StreamBuilder.BuildVideoItem( Profile="Anonymous Profile", Path="/storage/tv_shows/Defending Jacob (2020)/Season 01/Defending Jacob (2020) - S01E05 - Visitors [WEBDL-2160p][HDR][10bit][h265][EAC3 Atmos 5.1]-GHOSTS.mkv", AudioStreamIndex=1, SubtitleStreamIndex=-1 ) => ( PlayMethod=Transcode, TranscodeReason=AudioCodecNotSupported ) "media:/videos/47fd7ebd-c525-1b1b-59c9-17cd7ca07f2c/master.m3u8?MediaSourceId=47fd7ebdc5251b1b59c917cd7ca07f2c&VideoCodec=h264,mpeg2video,h265,hevc,hevc&AudioCodec=aac,ac3&AudioStreamIndex=1&VideoBitrate=139360000&AudioBitrate=640000&MaxFramerate=23.976025&api_key=<token>&SubtitleMethod=Encode&TranscodingMaxAudioChannels=6&RequireAvc=false&Tag=24b05976e5ae54997cbe24eca26f190c&SegmentContainer=ts&MinSegments=1&BreakOnNonKeyFrames=True&hevc-level=150&hevc-videobitdepth=10&hevc-profile=main10&h264-profile=high,main,baseline,constrainedbaseline&h264-level=51&aac-audiochannels=6&TranscodeReasons=AudioCodecNotSupported" [2022-07-03 21:02:54.760 -04:00] [INF] [29] MediaBrowser.MediaEncoding.Subtitles.SubtitleEncoder: "/usr/lib/jellyfin-ffmpeg/ffmpeg" "-i file:\"/storage/tv_shows/Defending Jacob (2020)/Season 01/Defending Jacob (2020) - S01E05 - Visitors [WEBDL-2160p][HDR][10bit][h265][EAC3 Atmos 5.1]-GHOSTS.mkv\" -map 0:2 -an -vn -c:s copy \"/config/data/data/subtitles/b/b88a2a7e-22ce-7256-0d80-26209227e314.srt\"" [2022-07-03 21:02:55.348 -04:00] [INF] [54] Jellyfin.Api.Controllers.DynamicHlsController: Current HLS implementation doesn't support non-keyframe breaks but one is requested, ignoring that request [2022-07-03 21:02:55.371 -04:00] [INF] [54] Jellyfin.Api.Helpers.TranscodingJobHelper: "/usr/lib/jellyfin-ffmpeg/ffmpeg" "-analyzeduration 200M -init_hw_device cuda=cu:0 -filter_hw_device cu -hwaccel cuda -hwaccel_output_format cuda -c:v hevc_cuvid -autorotate 0 -i file:\"/storage/tv_shows/Defending Jacob (2020)/Season 01/Defending Jacob (2020) - S01E05 - Visitors [WEBDL-2160p][HDR][10bit][h265][EAC3 Atmos 5.1]-GHOSTS.mkv\" -map_metadata -1 -map_chapters -1 -threads 0 -map 0:0 -map 0:1 -map -0:s -codec:v:0 h264_nvenc -preset p4 -b:v 41250653 -maxrate 41250653 -bufsize 82501306 -profile:v:0 high -g:v:0 72 -keyint_min:v:0 72 -vf \"setparams=color_primaries=bt2020:color_trc=smpte2084:colorspace=bt2020nc,tonemap_cuda=format=yuv420p:p=bt709:t=bt709:m=bt709:tonemap=none:peak=100:desat=0\" -codec:a:0 libfdk_aac -ac 6 -ab 640000 -copyts -avoid_negative_ts disabled -max_muxing_queue_size 2048 -f hls -max_delay 5000000 -hls_time 3 -hls_segment_type mpegts -start_number 0 -hls_segment_filename \"/config/data/transcodes/d6bed90a8ab0620defbb91d2a95d04e6%d.ts\" -hls_playlist_type vod -hls_list_size 0 -y \"/config/data/transcodes/d6bed90a8ab0620defbb91d2a95d04e6.m3u8\"" [2022-07-03 21:03:15.091 -04:00] [ERR] [22] Jellyfin.Server.Middleware.ExceptionMiddleware: Error processing request: "A task was canceled". URL "GET" "/videos/47fd7ebd-c525-1b1b-59c9-17cd7ca07f2c/hls1/main/0.ts". [2022-07-03 21:03:15.091 -04:00] [WRN] [22] Jellyfin.Server.Middleware.ResponseTimeMiddleware: Slow HTTP Response from "http://192.168.68.136:8096/jellyfin/videos/47fd7ebd-c525-1b1b-59c9-17cd7ca07f2c/hls1/main/0.ts?DeviceId=e3567495-d8d9-5dfd-87dc-ac5ab9389dc1&MediaSourceId=47fd7ebdc5251b1b59c917cd7ca07f2c&VideoCodec=h264,mpeg2video,h265,hevc,hevc&AudioCodec=aac,ac3&AudioStreamIndex=1&VideoBitrate=139360000&AudioBitrate=640000&MaxFramerate=23.976025&PlaySessionId=910fd9dff78a46a49822399f26dbabc4&api_key=207d96970eb642d78f3a9a008afa9f33&SubtitleMethod=Encode&TranscodingMaxAudioChannels=6&RequireAvc=false&Tag=24b05976e5ae54997cbe24eca26f190c&SegmentContainer=ts&MinSegments=1&BreakOnNonKeyFrames=True&hevc-level=150&hevc-videobitdepth=10&hevc-profile=main&h264-profile=high,main,baseline,constrainedbaseline&h264-level=51&aac-audiochannels=6&TranscodeReasons=AudioCodecNotSupported&AllowVideoStreamCopy=false&runtimeTicks=0&actualSegmentLengthTicks=44210000" to "192.168.68.110" in 0:00:19.7632589 with Status Code 500 [2022-07-03 21:03:15.092 -04:00] [INF] [22] Jellyfin.Api.Helpers.TranscodingJobHelper: Stopping ffmpeg process with q command for "/config/data/transcodes/d6bed90a8ab0620defbb91d2a95d04e6.m3u8" [2022-07-03 21:03:20.092 -04:00] [INF] [22] Jellyfin.Api.Helpers.TranscodingJobHelper: Killing FFmpeg process for "/config/data/transcodes/d6bed90a8ab0620defbb91d2a95d04e6.m3u8" [2022-07-03 21:03:20.094 -04:00] [INF] [22] Jellyfin.Api.Helpers.TranscodingJobHelper: Deleting partial stream file(s) "/config/data/transcodes/d6bed90a8ab0620defbb91d2a95d04e6.m3u8" [2022-07-03 21:03:21.171 -04:00] [ERR] [29] Jellyfin.Api.Helpers.TranscodingJobHelper: FFmpeg exited with code 137 [2022-07-03 21:03:21.603 -04:00] [INF] [29] Emby.Server.Implementations.Session.SessionManager: Playback stopped reported by app "Jellyfin Roku" "1.4.12" playing "Visitors". Stopped at "0" ms [2022-07-03 21:03:21.629 -04:00] [WRN] [29] Jellyfin.Server.Middleware.ResponseTimeMiddleware: Slow HTTP Response from "http://192.168.68.136:8096/jellyfin/Sessions/Playing/Stopped" to "192.168.68.110" in 0:00:06.5659957 with Status Code 204 [2022-07-03 21:05:53.892 -04:00] [INF] [15] MediaBrowser.MediaEncoding.Subtitles.SubtitleEncoder: ffmpeg subtitle extraction completed for "file:\"/storage/tv_shows/Defending Jacob (2020)/Season 01/Defending Jacob (2020) - S01E05 - Visitors [WEBDL-2160p][HDR][10bit][h265][EAC3 Atmos 5.1]-GHOSTS.mkv\"" to "/config/data/data/subtitles/b/b88a2a7e-22ce-7256-0d80-26209227e314.srt" [2022-07-03 21:05:53.930 -04:00] [WRN] [15] Jellyfin.Server.Middleware.ResponseTimeMiddleware: Slow HTTP Response from "http://192.168.68.136:8096/jellyfin/Videos/47fd7ebd-c525-1b1b-59c9-17cd7ca07f2c/47fd7ebdc5251b1b59c917cd7ca07f2c/Subtitles/2/0/Stream.vtt?api_key=207d96970eb642d78f3a9a008afa9f33" to "192.168.68.110" in 0:02:59.1892703 with Status Code 200 [2022-07-03 21:14:01.441 -04:00] [INF] [84] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "::ffff:192.168.68.117" closed [2022-07-03 21:33:58.792 -04:00] [INF] [64] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "::ffff:192.168.68.117" request [2022-07-03 21:47:05.283 -04:00] [INF] [41] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "::ffff:192.168.68.117" request [2022-07-03 21:47:58.821 -04:00] [INF] [47] Emby.Server.Implementations.Session.SessionWebSocketListener: Sending ForceKeepAlive message to 1 inactive WebSockets. [2022-07-03 21:48:10.821 -04:00] [INF] [28] Emby.Server.Implementations.Session.SessionWebSocketListener: Lost 1 WebSockets. [2022-07-03 22:11:52.093 -04:00] [INF] [44] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "::ffff:192.168.68.117" request [2022-07-03 22:11:52.110 -04:00] [INF] [36] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "::ffff:192.168.68.117" closed
I am having the same issue. Instant error on version 10.8.1 with no FFMPEG logs. A longer "attempt" at playback on 10.8.0 with an FFMPEG log.
10.8.0 Log:
[2022-07-03 21:02:54.057 -04:00] [INF] [29] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "redacted". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True [2022-07-03 21:02:54.057 -04:00] [INF] [29] Jellyfin.Api.Helpers.MediaInfoHelper: RemoteClientBitrateLimit: 8000000, RemoteIp: "192.168.68.110", IsInLocalNetwork: True [2022-07-03 21:02:54.114 -04:00] [INF] [29] Jellyfin.Api.Helpers.MediaInfoHelper: StreamBuilder.BuildVideoItem( Profile="Anonymous Profile", Path="/storage/tv_shows/Defending Jacob (2020)/Season 01/Defending Jacob (2020) - S01E05 - Visitors [WEBDL-2160p][HDR][10bit][h265][EAC3 Atmos 5.1]-GHOSTS.mkv", AudioStreamIndex=1, SubtitleStreamIndex=-1 ) => ( PlayMethod=Transcode, TranscodeReason=AudioCodecNotSupported ) "media:/videos/47fd7ebd-c525-1b1b-59c9-17cd7ca07f2c/master.m3u8?MediaSourceId=47fd7ebdc5251b1b59c917cd7ca07f2c&VideoCodec=h264,mpeg2video,h265,hevc,hevc&AudioCodec=aac,ac3&AudioStreamIndex=1&VideoBitrate=139360000&AudioBitrate=640000&MaxFramerate=23.976025&api_key=<token>&SubtitleMethod=Encode&TranscodingMaxAudioChannels=6&RequireAvc=false&Tag=24b05976e5ae54997cbe24eca26f190c&SegmentContainer=ts&MinSegments=1&BreakOnNonKeyFrames=True&hevc-level=150&hevc-videobitdepth=10&hevc-profile=main10&h264-profile=high,main,baseline,constrainedbaseline&h264-level=51&aac-audiochannels=6&TranscodeReasons=AudioCodecNotSupported" [2022-07-03 21:02:54.760 -04:00] [INF] [29] MediaBrowser.MediaEncoding.Subtitles.SubtitleEncoder: "/usr/lib/jellyfin-ffmpeg/ffmpeg" "-i file:\"/storage/tv_shows/Defending Jacob (2020)/Season 01/Defending Jacob (2020) - S01E05 - Visitors [WEBDL-2160p][HDR][10bit][h265][EAC3 Atmos 5.1]-GHOSTS.mkv\" -map 0:2 -an -vn -c:s copy \"/config/data/data/subtitles/b/b88a2a7e-22ce-7256-0d80-26209227e314.srt\"" [2022-07-03 21:02:55.348 -04:00] [INF] [54] Jellyfin.Api.Controllers.DynamicHlsController: Current HLS implementation doesn't support non-keyframe breaks but one is requested, ignoring that request [2022-07-03 21:02:55.371 -04:00] [INF] [54] Jellyfin.Api.Helpers.TranscodingJobHelper: "/usr/lib/jellyfin-ffmpeg/ffmpeg" "-analyzeduration 200M -init_hw_device cuda=cu:0 -filter_hw_device cu -hwaccel cuda -hwaccel_output_format cuda -c:v hevc_cuvid -autorotate 0 -i file:\"/storage/tv_shows/Defending Jacob (2020)/Season 01/Defending Jacob (2020) - S01E05 - Visitors [WEBDL-2160p][HDR][10bit][h265][EAC3 Atmos 5.1]-GHOSTS.mkv\" -map_metadata -1 -map_chapters -1 -threads 0 -map 0:0 -map 0:1 -map -0:s -codec:v:0 h264_nvenc -preset p4 -b:v 41250653 -maxrate 41250653 -bufsize 82501306 -profile:v:0 high -g:v:0 72 -keyint_min:v:0 72 -vf \"setparams=color_primaries=bt2020:color_trc=smpte2084:colorspace=bt2020nc,tonemap_cuda=format=yuv420p:p=bt709:t=bt709:m=bt709:tonemap=none:peak=100:desat=0\" -codec:a:0 libfdk_aac -ac 6 -ab 640000 -copyts -avoid_negative_ts disabled -max_muxing_queue_size 2048 -f hls -max_delay 5000000 -hls_time 3 -hls_segment_type mpegts -start_number 0 -hls_segment_filename \"/config/data/transcodes/d6bed90a8ab0620defbb91d2a95d04e6%d.ts\" -hls_playlist_type vod -hls_list_size 0 -y \"/config/data/transcodes/d6bed90a8ab0620defbb91d2a95d04e6.m3u8\"" [2022-07-03 21:03:15.091 -04:00] [ERR] [22] Jellyfin.Server.Middleware.ExceptionMiddleware: Error processing request: "A task was canceled". URL "GET" "/videos/47fd7ebd-c525-1b1b-59c9-17cd7ca07f2c/hls1/main/0.ts". [2022-07-03 21:03:15.091 -04:00] [WRN] [22] Jellyfin.Server.Middleware.ResponseTimeMiddleware: Slow HTTP Response from "http://192.168.68.136:8096/jellyfin/videos/47fd7ebd-c525-1b1b-59c9-17cd7ca07f2c/hls1/main/0.ts?DeviceId=e3567495-d8d9-5dfd-87dc-ac5ab9389dc1&MediaSourceId=47fd7ebdc5251b1b59c917cd7ca07f2c&VideoCodec=h264,mpeg2video,h265,hevc,hevc&AudioCodec=aac,ac3&AudioStreamIndex=1&VideoBitrate=139360000&AudioBitrate=640000&MaxFramerate=23.976025&PlaySessionId=910fd9dff78a46a49822399f26dbabc4&api_key=207d96970eb642d78f3a9a008afa9f33&SubtitleMethod=Encode&TranscodingMaxAudioChannels=6&RequireAvc=false&Tag=24b05976e5ae54997cbe24eca26f190c&SegmentContainer=ts&MinSegments=1&BreakOnNonKeyFrames=True&hevc-level=150&hevc-videobitdepth=10&hevc-profile=main&h264-profile=high,main,baseline,constrainedbaseline&h264-level=51&aac-audiochannels=6&TranscodeReasons=AudioCodecNotSupported&AllowVideoStreamCopy=false&runtimeTicks=0&actualSegmentLengthTicks=44210000" to "192.168.68.110" in 0:00:19.7632589 with Status Code 500 [2022-07-03 21:03:15.092 -04:00] [INF] [22] Jellyfin.Api.Helpers.TranscodingJobHelper: Stopping ffmpeg process with q command for "/config/data/transcodes/d6bed90a8ab0620defbb91d2a95d04e6.m3u8" [2022-07-03 21:03:20.092 -04:00] [INF] [22] Jellyfin.Api.Helpers.TranscodingJobHelper: Killing FFmpeg process for "/config/data/transcodes/d6bed90a8ab0620defbb91d2a95d04e6.m3u8" [2022-07-03 21:03:20.094 -04:00] [INF] [22] Jellyfin.Api.Helpers.TranscodingJobHelper: Deleting partial stream file(s) "/config/data/transcodes/d6bed90a8ab0620defbb91d2a95d04e6.m3u8" [2022-07-03 21:03:21.171 -04:00] [ERR] [29] Jellyfin.Api.Helpers.TranscodingJobHelper: FFmpeg exited with code 137 [2022-07-03 21:03:21.603 -04:00] [INF] [29] Emby.Server.Implementations.Session.SessionManager: Playback stopped reported by app "Jellyfin Roku" "1.4.12" playing "Visitors". Stopped at "0" ms [2022-07-03 21:03:21.629 -04:00] [WRN] [29] Jellyfin.Server.Middleware.ResponseTimeMiddleware: Slow HTTP Response from "http://192.168.68.136:8096/jellyfin/Sessions/Playing/Stopped" to "192.168.68.110" in 0:00:06.5659957 with Status Code 204 [2022-07-03 21:05:53.892 -04:00] [INF] [15] MediaBrowser.MediaEncoding.Subtitles.SubtitleEncoder: ffmpeg subtitle extraction completed for "file:\"/storage/tv_shows/Defending Jacob (2020)/Season 01/Defending Jacob (2020) - S01E05 - Visitors [WEBDL-2160p][HDR][10bit][h265][EAC3 Atmos 5.1]-GHOSTS.mkv\"" to "/config/data/data/subtitles/b/b88a2a7e-22ce-7256-0d80-26209227e314.srt" [2022-07-03 21:05:53.930 -04:00] [WRN] [15] Jellyfin.Server.Middleware.ResponseTimeMiddleware: Slow HTTP Response from "http://192.168.68.136:8096/jellyfin/Videos/47fd7ebd-c525-1b1b-59c9-17cd7ca07f2c/47fd7ebdc5251b1b59c917cd7ca07f2c/Subtitles/2/0/Stream.vtt?api_key=207d96970eb642d78f3a9a008afa9f33" to "192.168.68.110" in 0:02:59.1892703 with Status Code 200 [2022-07-03 21:14:01.441 -04:00] [INF] [84] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "::ffff:192.168.68.117" closed [2022-07-03 21:33:58.792 -04:00] [INF] [64] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "::ffff:192.168.68.117" request [2022-07-03 21:47:05.283 -04:00] [INF] [41] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "::ffff:192.168.68.117" request [2022-07-03 21:47:58.821 -04:00] [INF] [47] Emby.Server.Implementations.Session.SessionWebSocketListener: Sending ForceKeepAlive message to 1 inactive WebSockets. [2022-07-03 21:48:10.821 -04:00] [INF] [28] Emby.Server.Implementations.Session.SessionWebSocketListener: Lost 1 WebSockets. [2022-07-03 22:11:52.093 -04:00] [INF] [44] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "::ffff:192.168.68.117" request [2022-07-03 22:11:52.110 -04:00] [INF] [36] Emby.Server.Implementations.HttpServer.WebSocketManager: WS "::ffff:192.168.68.117" closed