Roku stucks loading at 33%

[Alefielm 7]

Hi I'm having this trouble on some movies, this is an example, it does a loading pass trought 100% then another that stucks at 33%, it tries some times again and then I get an error.
I thought it could be the PGSUB, that's fine, I select SRT, still failing, I thing it's not remembering the settings for audio and subtitles and sends the previous default to be played.

Any idea?

Have last Roku version (10.5.1) on a 3820X - Streaming Stick 4K, and emby (4.6.7.0), Emby for Roku 4.0 build 31

Thanks!

 

2021-12-28 17:45:09.800 Info Server: http/1.1 Response 500 to 192.168.0.61. Time: 15658ms. http://192.168.0.250:8096/emby/videos/45281/hls1/main/0.ts?DeviceId=c0c3b1db-9390-5507-8626-302d33ef7626&MediaSourceId=3d5e5326e51709224cbebce2235f1873&PlaySessionId=c01405520f0c4a38bf4643a4ea074dc7&VideoCodec=h264,hevc,mpeg2video&AudioCodec=ac3,aac,mp2,mp3,eac3,flac,vorbis,lpcm&VideoBitrate=34616000&AudioBitrate=384000&MaxFramerate=60&MaxWidth=3840&MaxHeight=2160&AudioStreamIndex=1&SubtitleStreamIndex=4&SubtitleMethod=Encode&TranscodingMaxAudioChannels=6&SegmentContainer=ts&SegmentLength=3&MinSegments=1&BreakOnNonKeyFrames=True&ManifestSubtitles=vtt&h264-maxrefframes=16&h264-videobitdepth=8&h264-profile=high,main,baseline,constrainedbaseline&h264-level=51&aac-audiochannels=6&eac3-audiochannels=6&ac3-audiochannels=6&flac-audiochannels=6&lpcm-audiochannels=6&mp3-audiochannels=2&mp2-audiochannels=2&vorbis-audiochannels=6&TranscodeReasons=SubtitleCodecNotSupported,DirectPlayError
2021-12-28 17:45:09.914 Info Server: http/1.1 GET http://192.168.0.250:8096/emby/videos/45281/hls1/main/0.ts?DeviceId=c0c3b1db-9390-5507-8626-302d33ef7626&MediaSourceId=3d5e5326e51709224cbebce2235f1873&PlaySessionId=c01405520f0c4a38bf4643a4ea074dc7&VideoCodec=h264,hevc,mpeg2video&AudioCodec=ac3,aac,mp2,mp3,eac3,flac,vorbis,lpcm&VideoBitrate=34616000&AudioBitrate=384000&MaxFramerate=60&MaxWidth=3840&MaxHeight=2160&AudioStreamIndex=1&SubtitleStreamIndex=4&SubtitleMethod=Encode&TranscodingMaxAudioChannels=6&SegmentContainer=ts&SegmentLength=3&MinSegments=1&BreakOnNonKeyFrames=True&ManifestSubtitles=vtt&h264-maxrefframes=16&h264-videobitdepth=8&h264-profile=high,main,baseline,constrainedbaseline&h264-level=51&aac-audiochannels=6&eac3-audiochannels=6&ac3-audiochannels=6&flac-audiochannels=6&lpcm-audiochannels=6&mp3-audiochannels=2&mp2-audiochannels=2&vorbis-audiochannels=6&TranscodeReasons=SubtitleCodecNotSupported,DirectPlayError. Accept=*/*, Host=192.168.0.250:8096, User-Agent=Roku/DVP-10.5 (10.5.1.4066-CU)
2021-12-28 17:45:10.080 Info App: AppendExtraLogData - Read graph file: /config/logs/ffmpeg-transcode-919a0275-bcfa-4d4c-aca7-c2130c8f1369_1graph.txt
2021-12-28 17:45:10.080 Warn App: AppendExtraLogData: Unable read graph output file: /config/logs/ffmpeg-transcode-919a0275-bcfa-4d4c-aca7-c2130c8f1369_1graph.txt
2021-12-28 17:45:10.086 Info App: ProcessRun 'StreamTranscode 919a02' Process exited with code 137
2021-12-28 17:45:10.264 Info App: ProcessRun 'StreamTranscode a34d48' Execute: /bin/ffmpeg -loglevel +timing -y -print_graphs_file "/config/logs/ffmpeg-transcode-a34d4832-9a93-4746-8a0e-ffdce96fd85b_1graph.txt" -copyts -start_at_zero -f matroska,webm -c:v:0 hevc -canvas_size:s:0 "1920:1080" -i "/Movies5TB/The.Martian.2015.EXTENDED.2160p.BluRay.x265.10bit.HDR.TrueHD.7.1.Atmos-TERMiNAL/The.Martian.2015.EXTENDED.2160p.UHD.BluRay.x265-TERMiNAL.mkv" -filter_complex "[0:0]format@f1=pix_fmts=yuv420p[f1_out0];[0:4]scale@f2=width=3840:height=-2:force_original_aspect_ratio=decrease[f2_out0];[f1_out0][f2_out0]overlay@f3=x=(W-w)/2:y=(H-h):repeatlast=0[f3_out0]" -map [f3_out0] -map 0:1 -sn -c:v:0 libx264 -g:v:0 72 -maxrate:v:0 34616000 -bufsize:v:0 69232000 -sc_threshold:v:0 0 -keyint_min:v:0 72 -r:v:0 23.976024627685547 -pix_fmt:v:0 yuv420p -preset:v:0 veryfast -profile:v:0 high -level:v:0 5.1 -x264opts:v:0 "subme=0:me_range=4:rc_lookahead=10:partitions=none" -crf:v:0 23 -c:a:0 ac3 -ab:a:0 384000 -ar:a:0 48000 -ac:a:0 6 -metadata:s:a:0 language=eng -disposition:a:0 default -max_delay 5000000 -avoid_negative_ts disabled -f segment -map_metadata -1 -map_chapters -1 -segment_format mpegts -segment_list "/config/transcoding-temp/622724.m3u8" -segment_list_type m3u8 -segment_time 3 -segment_start_number 0 -individual_header_trailer 0 -write_header_trailer 0 -segment_write_temp 1 "/config/transcoding-temp/622724_%d.ts"
2021-12-28 17:45:20.417 Error App: Request cancelled during ValidateEncoderOutput
2021-12-28 17:45:20.454 Info Server: http/1.1 GET http://192.168.0.250:8096/emby/videos/45281/hls1/main/0.ts?DeviceId=c0c3b1db-9390-5507-8626-302d33ef7626&MediaSourceId=3d5e5326e51709224cbebce2235f1873&PlaySessionId=c01405520f0c4a38bf4643a4ea074dc7&VideoCodec=h264,hevc,mpeg2video&AudioCodec=ac3,aac,mp2,mp3,eac3,flac,vorbis,lpcm&VideoBitrate=34616000&AudioBitrate=384000&MaxFramerate=60&MaxWidth=3840&MaxHeight=2160&AudioStreamIndex=1&SubtitleStreamIndex=4&SubtitleMethod=Encode&TranscodingMaxAudioChannels=6&SegmentContainer=ts&SegmentLength=3&MinSegments=1&BreakOnNonKeyFrames=True&ManifestSubtitles=vtt&h264-maxrefframes=16&h264-videobitdepth=8&h264-profile=high,main,baseline,constrainedbaseline&h264-level=51&aac-audiochannels=6&eac3-audiochannels=6&ac3-audiochannels=6&flac-audiochannels=6&lpcm-audiochannels=6&mp3-audiochannels=2&mp2-audiochannels=2&vorbis-audiochannels=6&TranscodeReasons=SubtitleCodecNotSupported,DirectPlayError. Accept=*/*, Host=192.168.0.250:8096, User-Agent=Roku/DVP-10.5 (10.5.1.4066-CU)
2021-12-28 17:45:20.535 Error Server: Error processing request
	*** Error Report ***
	Version: 4.6.7.0
	Command line: /system/EmbyServer.dll -programdata /config -ffdetect /bin/ffdetect -ffmpeg /bin/ffmpeg -ffprobe /bin/ffprobe -restartexitcode 3
	Operating system: Linux version 5.10.63-v7l+ (dom@buildbot) (arm-linux-gnueabihf-gcc-8 (Ubuntu/Linaro 8.4.0-3ubuntu1) 8.4.0, GNU ld (GNU Binutils for Ubuntu) 2.34) #145
	Framework: .NET Core 3.1.21
	OS/Process: arm/arm
	Runtime: system/System.Private.CoreLib.dll
	Processor count: 4
	Data path: /config
	Application path: /system
	System.Exception: System.Exception: Error starting ffmpeg
	   at Emby.Server.MediaEncoding.Api.BaseStreamingService.StartFfMpeg(StreamState state, String outputPath, CancellationToken cancellationToken, Boolean acquireResources)
	   at Emby.Server.MediaEncoding.Api.Hls.DynamicHlsService.GetDynamicSegment(StreamRequest request, String playlistId, String segmentId, Int32 subtitleStreamIndex)
	   at Emby.Server.Implementations.Services.ServiceController.GetTaskResult(Task task)
	   at Emby.Server.Implementations.Services.ServiceHandler.ProcessRequestAsync(HttpListenerHost appHost, IRequest httpReq, IResponse httpRes, RestPath restPath, String responseContentType, CancellationToken cancellationToken)
	   at Emby.Server.Implementations.HttpServer.HttpListenerHost.RequestHandler(IRequest httpReq, ReadOnlyMemory`1 urlString, ReadOnlyMemory`1 localPath, CancellationToken cancellationToken)
	Source: Emby.Server.MediaEncoding
	TargetSite: Void MoveNext()

 

Edited December 28, 2021 by Alefielm

[Luke 37230]

Hi there, please attach the complete emby server log, and if an ffmpeg log file was generated, please attach that as well. thanks.

[Alefielm 7]

There they go, thanks!

EDIT: added more versions and models in the first topic

embyserver.txt ffmpeg-transcode-a0ebbd17-da24-45da-9544-0cd9678d5573_1.txt

Edited December 28, 2021 by Alefielm

[Alefielm 7]

Adding, I not sure now that it's a Rolu issue, more data and logs trying to play on Mac, here:

Thanks!

[ebr 14958]

Hi.  No, it isn't a Roku issue.  It looks like your server is not fast enough to transcode these items.  What is the hardware?

[Alefielm 7]

38 minutes ago, ebr said:

Hi.  No, it isn't a Roku issue.  It looks like your server is not fast enough to transcode these items.  What is the hardware?

It's a Raspberry pi4, no problem with other 4k videos, it should do a direct streaming when setting to AC3 and SRT, no transcoding needed here. Am I missing something?

Thanks!

[ebr 14958]

Hi.  You are trying to play PGS subtitles which are not supported by Roku.  if you de-select the subs or find text based ones if you need them then it may work better for you.

[Alefielm 7]

4 minutes ago, ebr said:

Hi.  You are trying to play PGS subtitles which are not supported by Roku.  if you de-select the subs or find text based ones if you need them then it may work better for you.

I am selecting SRT subs and 5.1 audio, apparently it doesn't use my selection and sends PGSSUB. Any idea?

Thanks!

[ebr 14958]

In the above log,  this subtitle track was selected and that is why it transcoded and attempted to burn in:

19:31:42.229     Stream #0:4(eng): Subtitle: hdmv_pgs_subtitle, 1920x1080 (default)
19:31:42.229     Metadata:
19:31:42.229       title           : Forced

Since it is a forced track, it was probably selected automatically.

[Luke 37230]

How are you certain you selected the SRT subtitles?

[Alefielm 7]

Just now, Luke said:

How are you certain you selected the SRT subtitles?

From the movie menu dropdown I selected SRT and then hit play. Am I missing something? Can send a video if it helps

Thanks!

[Luke 37230]

9 minutes ago, Alefielm said:

From the movie menu dropdown I selected SRT and then hit play. Am I missing something? Can send a video if it helps

Thanks!

That would be great, thanks.

[Alefielm 7]

5 minutes ago, Luke said:

That would be great, thanks.

Here it goes, sorry for the low res and video of a screen

[ebr 14958]

Hi.  Can we see the ffmpeg log(s) - there may be more than one - that corresponds with that exact activity?

Thanks.

[Alefielm 7]

1 hour ago, ebr said:

Hi.  Can we see the ffmpeg log(s) - there may be more than one - that corresponds with that exact activity?

Thanks.

Sure! rotated the logs just before selecting movie->config audio and subs, 7 ffmpeg, 1 embyserver.

Thanks!

embyserver.txt ffmpeg-transcode-3b07a5a2-da1d-45be-81e5-a3e6fe75eb9a_1.txt ffmpeg-transcode-3eaa5124-67a3-4822-baaa-ffaeb59e5fa2_1.txt ffmpeg-transcode-5a842ecc-c339-4911-95f8-9e3a2301edec_1.txt ffmpeg-transcode-35b42920-aba7-46b1-92dd-8608f7e2cee7_1.txt ffmpeg-transcode-479498c6-1ab0-4bea-ae89-24288cb0bbc9_1.txt ffmpeg-transcode-bb133e9e-83f0-4f68-bb47-81b10754b9e9_1.txt ffmpeg-transcode-ffb85a78-e825-40d5-9066-8be0fd5197c1_1.txt

Edited December 29, 2021 by Alefielm

[ebr 14958]

They are all showing a direct play error.  It may be that the error fallback is not remembering your manual subtitle selection but I'm not sure why it is having to fall back in the first place.

Can you please play that item until it starts to try and transcode and then follow the instructions to send a log from the app?

 

[Alefielm 7]

4 minutes ago, ebr said:

They are all showing a direct play error.  It may be that the error fallback is not remembering your manual subtitle selection but I'm not sure why it is having to fall back in the first place.

Can you please play that item until it starts to try and transcode and then follow the instructions to send a log from the app?

 

Just to be sure, nothing else on the log folder, so the only log remaining is the roku one, right? Asking to send all in one post.

BTW is also failing when playing on Firefox, so it doesn't seem a Roku issue (so not sure what else to send)

Thanks!

[ebr 14958]

Hi.  The app log is not in a folder.  It is sent right from the app.  Instructions are in the link I provided.

Thanks.

[Alefielm 7]

21 minutes ago, ebr said:

Hi.  The app log is not in a folder.  It is sent right from the app.  Instructions are in the link I provided.

Thanks.

Log sent, 16:53 UTC-3 (14:53 UTC-5)

user alefielm

[pjessup 0]

It's happening to me, too. Stuck at 13 or 33% for a few moments (think it's freezing), and then eventually it starts. Only happens on Roku, I'm not using subtitles at all. On my desktop it's fine. It's happening to a few friends IRL that use Emby, too. They stopped using it on Roku because they thought it was freezing and were getting impatient. It does eventually come up.

On anything else (including phone) it works fine.

[Happy2Play 8351]

7 hours ago, ebr said:

In the above log,  this subtitle track was selected and that is why it transcoded and attempted to burn in:

19:31:42.229     Stream #0:4(eng): Subtitle: hdmv_pgs_subtitle, 1920x1080 (default)
19:31:42.229     Metadata:
19:31:42.229       title           : Forced

Since it is a forced track, it was probably selected automatically.

 

7 hours ago, Luke said:

How are you certain you selected the SRT subtitles?

Is Forced superseding selection?

19:06:29.813 Stream mapping:
19:06:29.813   Stream #0:0 (hevc) -> format (graph 0)
19:06:29.813   Stream #0:4 (pgssub) -> scale (graph 0)
19:06:29.813   overlay (graph 0) -> Stream #0:0 (libx264)
19:06:29.813   Stream #0:1 -> #0:1 (truehd (native) -> ac3 (native))

@AlefielmWhat is the user "Alejandro" subtitle setting?  Server Settings-Subtitles, Subtitle Mode

[Alefielm 7]

27 minutes ago, pjessup said:

It's happening to me, too. Stuck at 13 or 33% for a few moments (think it's freezing), and then eventually it starts. Only happens on Roku, I'm not using subtitles at all. On my desktop it's fine. It's happening to a few friends IRL that use Emby, too. They stopped using it on Roku because they thought it was freezing and were getting impatient. It does eventually come up.

On anything else (including phone) it works fine.

Here it fails a number of times on Roku and then throws an error, never got to play, same on firefox

 

[Alefielm 7]

1 minute ago, Happy2Play said:

@AlefielmWhat is the user "Alejandro" subtitle setting?  Server Settings-Subtitles, Subtitle Mode

"Allways play subtitles", I use subtitles on 99% of the things I watch

[Luke 37230]

4 minutes ago, Alefielm said:

Here it fails a number of times on Roku and then throws an error, never got to play, same on firefox

 

Can you please provide the emby server and ffmpeg log files from when this happened on firefox? Thanks.

[Happy2Play 8351]

Just now, Alefielm said:

"Allways play subtitles", I use subtitles on 99% of the things I watch

Can you test changing to No Subtitles and then test selecting srt at playback.