[YouTube] Freeze on Second Playback Attempt

hiya · August 7, 2024 at 8:56 PM

Installed LE 11.0.6 on a RPI3B and moving around menus work fine. However I'm having problems on playback.

When first playing back, it plays fine. However, if I try to watch a second item, Kodi looks to start the playback with the skin stating "Please wait Loading" and then it freezes. No response to plugged in keyboard.

I can log in via SSH after the freeze.

In the kodi.log it repeats two lines every 10 seconds:

2024-08-07 20:16:59.701 T:22498 warning <general>: OutputPicture - timeout waiting for buffer
2024-08-07 20:17:09.737 T:22498 info <general>: Skipped 195 duplicate messages..

On last attempt when I was trying to watch a trailer on youtube resulted in log below

Code

2024-08-07 20:16:13.518 T:791      info <general>: VideoPlayer::OpenFile: plugin://plugin.video.youtube/play/?video_id=5e8apSFDXsQ
2024-08-07 20:16:13.520 T:22487    info <general>: Creating InputStream
2024-08-07 20:16:13.528 T:22487    info <general>: AddOnLog: inputstream.adaptive: [Repr. chooser] Resolution set: 1920x1080, max allowed: 2048x1080, Adjust refresh rate: 1
2024-08-07 20:16:13.539 T:22487    info <general>: AddOnLog: inputstream.adaptive: Successfully parsed manifest file (Periods: 1, Streams in first period: 8, Type: VOD)
2024-08-07 20:16:13.540 T:22487    info <general>: Creating Demuxer
2024-08-07 20:16:13.541 T:22487    info <general>: Opening stream: 1001 source: 256
2024-08-07 20:16:14.090 T:22487    info <general>: Creating video codec with codec id: 167
2024-08-07 20:16:14.124 T:22487    info <general>: CDVDVideoCodecDRMPRIME::Open - using decoder V4L2 mem2mem VP9 decoder wrapper
2024-08-07 20:16:14.126 T:22487    info <general>: CDVDVideoCodecDRMPRIME::Open - unable to open codec
2024-08-07 20:16:14.126 T:22487    info <general>: CDVDVideoCodecDRMPRIME::Open - using decoder Google VP9
2024-08-07 20:16:14.220 T:22487    info <general>: Creating video thread
2024-08-07 20:16:14.221 T:22498    info <general>: running thread: video_thread
2024-08-07 20:16:14.221 T:22487    info <general>: Opening stream: 1008 source: 256
2024-08-07 20:16:14.463 T:22487    info <general>: Finding audio codec for: 86018
2024-08-07 20:16:14.464 T:22487    info <general>: CDVDAudioCodecFFmpeg::Open() Successful opened audio decoder aac
2024-08-07 20:16:14.464 T:22487    info <general>: OpenStream: Allowing max Out-Of-Sync Value of 10 ms
2024-08-07 20:16:14.464 T:22487    info <general>: Creating audio thread
2024-08-07 20:16:14.465 T:22500    info <general>: running thread: CVideoPlayerAudio::Process()
2024-08-07 20:16:15.208 T:22500    info <general>: CDVDAudioCodecFFmpeg::Open() Successful opened audio decoder aac
2024-08-07 20:16:15.208 T:22500    info <general>: Creating audio stream (codec id: 86018, channels: 2, sample rate: 44100, no pass-through)
2024-08-07 20:16:15.258 T:798      info <general>: CActiveAESink::OpenSink - initialize sink
2024-08-07 20:16:15.459 T:798      info <general>: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=vc4hdmi,DEV=0"
2024-08-07 20:16:15.476 T:798      info <general>: CAESinkALSA::Initialize - Opened device "hdmi:CARD=vc4hdmi,DEV=0,AES0=0x04,AES1=0x82,AES2=0x00,AES3=0x00"
2024-08-07 20:16:15.477 T:798      info <general>: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats
2024-08-07 20:16:15.477 T:798      info <general>: CAESinkALSA::InitializeHW - Using data format AE_FMT_S24NE3
2024-08-07 20:16:16.256 T:22498 warning <general>: OutputPicture - timeout waiting for buffer
2024-08-07 20:16:23.746 T:22500    info <general>: Skipped 141 duplicate messages..
2024-08-07 20:16:23.746 T:22500    info <general>: CVideoPlayerAudio::Process - stream stalled
2024-08-07 20:16:23.784 T:22498 warning <general>: OutputPicture - timeout waiting for buffer
2024-08-07 20:16:23.787 T:22487    info <general>: AddOnLog: inputstream.adaptive: PosTime (8022)
2024-08-07 20:16:23.818 T:22487    info <general>: AddOnLog: inputstream.adaptive: Seek time 8.0 for stream: 1001 (physical index 393217) continues at 13.3 (PTS: 13305000)
2024-08-07 20:16:23.913 T:22487    info <general>: AddOnLog: inputstream.adaptive: Seek time 13.3 for stream: 1008 (physical index 131080) continues at 13.3 (PTS: 13281814)
2024-08-07 20:16:29.591 T:22498 warning <general>: OutputPicture - timeout waiting for buffer
2024-08-07 20:16:39.626 T:22498    info <general>: Skipped 106 duplicate messages..
2024-08-07 20:16:39.625 T:22498 warning <general>: OutputPicture - timeout waiting for buffer
2024-08-07 20:16:49.664 T:22498    info <general>: Skipped 195 duplicate messages..
2024-08-07 20:16:49.664 T:22498 warning <general>: OutputPicture - timeout waiting for buffer
2024-08-07 20:16:59.701 T:22498    info <general>: Skipped 195 duplicate messages..
2024-08-07 20:16:59.701 T:22498 warning <general>: OutputPicture - timeout waiting for buffer
2024-08-07 20:17:09.737 T:22498    info <general>: Skipped 195 duplicate messages..
2024-08-07 20:17:09.737 T:22498 warning <general>: OutputPicture - timeout waiting for buffer
2024-08-07 20:17:19.773 T:22498    info <general>: Skipped 195 duplicate messages..

Display More

I have to turn the power off and on again to get back control.

Any suggestions to what might be wrong?

Thanks

**Da Flex** · August 7, 2024 at 11:11 PM

Update to LE 12.

**chewitt** · August 8, 2024 at 3:51 PM

No RPi board has hardware support for VP9 media and RPi3 doesn't have the CPU grunt for software decoding. You need to use H264 content (which can be decoded) or use different hardware. RPi4 can handle 1080p and RPi5 has the oomph to handle most 4K30 VP9 media (but not 4K60).

Updating to LE12 won't solve anything.

hiya · August 8, 2024 at 7:55 PM

Sorry I didn't see the VP9 in the logs... that is probably a bad example as I'm seeing the same issue on h.264 content as well. I can play a file first time fine but if I stop and then playback the same file it will result in the issue with the "OutputPicture - timeout waiting for buffer" repeating ad-infinitum until I power off.

**Da Flex** · August 8, 2024 at 8:16 PM

Quote from hiya

Sorry I didn't see the VP9 in the logs...

Line 8 of your log snippet. YouTube often plays ads before the actual content, so maybe the ad is VP9. VP9 was developed by Google, so it would make sense.

**chewitt** · August 10, 2024 at 11:54 AM

Share a full debug log file .. it will contain more info on your setup.

[YouTube] Freeze on Second Playback Attempt

Similar Threads

[RPi4] Steam Link Launcher