Stuttering playback when trying to cast a blu ray disk

[Mwilliams89]

I'm attempting to use VLC to stream a Blu Ray Disk from my Home PC to a Chromecast. The setup works, but the playback is extremely laggy and stutters. I've tried playing with the muxer cache options (which was the suggested solution via a quick Google) but can't seem to make playback any smoother.

I understand its a pretty intensive operation but thought there would probably be a way to optimise. My PC is decent (can post specs if needed) and plays back Blu rays locally perfectly fine. I also think that my wifi network is suitable too - I can stream HD movies across it from my plex media server (on a raspberry pi) no problem.

I guess I'm not exactly looking for a fix, but a way to diagnose the cause of the stutter. It could be my PC transcoding, my router, or the chromecast. I've checked the VLC logs and don't get much more info than the player moving from a playing state to a buffering state constantly.

Any pointers in any direction would be great.

Thanks

[Mwilliams89]

I can get improved performance by streaming the disk via HTTP, picking up the stream on my Android Device and then chromecasting from the VLC app. I'm guessing this is because I have more control over things like the bitrate and codec. Is there a slightly more elegant solution?

[unidan]

Hi, you can try to provide some logs with the following method:

To help you, we need messages, to completely understand what your problems is.
To fix this, please be sure before you start the playback to:

1. Open: Tools -> Messages.
2. Set Verbosity to 2
3. Start playback to reproduce your issue
4. Save text in a file or copy into clipboard
5. Then paste the full resulting log here between [​code]and[​/code] (or use Pastebin.com if it's too long)

Also don't forget to name your Operating System and provide the VLC media player version.

I would say transcoding, but it's hard to accept if your other setup works, as we don't do hardware encoding on android yet.

[Mwilliams89]

Sure thing. OS is Windows 10 and vlc version is 3.0.4

Code: Select all

main debug: processing request item: bluray:///H:/, node: Playlist, skip: 0 main debug: rebuilding array of current - root Playlist main debug: rebuild done - 1 items, index 0 main debug: starting playback of new item main debug: resyncing on bluray:///H:/ main debug: bluray:///H:/ is at 0 main debug: creating new input thread main debug: Creating an input for 'bluray:///H:/' main debug: requesting art for new input thread main debug: looking for meta fetcher module matching "any": 1 candidates main debug: using sout chain=`chromecast{ip=192.168.1.84,port=8009}' main debug: stream=`chromecast' main debug: looking for sout stream module matching "chromecast": 23 candidates lua debug: Trying Lua scripts in C:\Users\MattW\AppData\Roaming\vlc\lua\meta\fetcher lua debug: Trying Lua scripts in C:\Program Files (x86)\VideoLAN\VLC\lua\meta\fetcher main debug: no meta fetcher modules matched main debug: looking for art finder module matching "any": 2 candidates lua debug: Trying Lua scripts in C:\Users\MattW\AppData\Roaming\vlc\lua\meta\art lua debug: Trying Lua scripts in C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art\00_musicbrainz.luac main debug: set config option: sout-chromecast-ip to 192.168.1.84 main debug: set config option: sout-chromecast-port to 8009 main debug: net: listening to * port 8010 main debug: looking for tls client module matching "any": 1 candidates lua debug: skipping script (unmatched scope) C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art\00_musicbrainz.luac lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art\01_googleimage.luac qt debug: IM: Setting an input lua debug: skipping script (unmatched scope) C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art\01_googleimage.luac lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art\02_frenchtv.luac lua debug: skipping script (unmatched scope) C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art\02_frenchtv.luac lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art\03_lastfm.luac gnutls debug: using GnuTLS version 3.5.18 lua debug: skipping script (unmatched scope) C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art\03_lastfm.luac main debug: no art finder modules matched main debug: looking for meta fetcher module matching "any": 1 candidates lua debug: Trying Lua scripts in C:\Users\MattW\AppData\Roaming\vlc\lua\meta\fetcher lua debug: Trying Lua scripts in C:\Program Files (x86)\VideoLAN\VLC\lua\meta\fetcher main debug: no meta fetcher modules matched main debug: looking for art finder module matching "any": 2 candidates lua debug: Trying Lua scripts in C:\Users\MattW\AppData\Roaming\vlc\lua\meta\art lua debug: Trying Lua scripts in C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art\00_musicbrainz.luac lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art\01_googleimage.luac lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art\02_frenchtv.luac lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art\03_lastfm.luac main debug: no art finder modules matched gnutls debug: loaded 48 trusted CAs from system main debug: using tls client module "gnutls" main debug: resolving 192.168.1.84 ... gnutls debug: TLS handshake: Resource temporarily unavailable, try again. gnutls debug: TLS handshake: Success. gnutls debug: - safe renegotiation (RFC5746) enabled gnutls debug: - extended master secret (RFC7627) enabled gnutls debug: - false start (RFC7918) enabled gnutls error: Certificate verification failure: The certificate is NOT trusted. The certificate issuer is unknown. The name in the certificate does not match the expected. gnutls info: Accepting self-signed/untrusted CA certificate. main debug: using sout stream module "stream_out_chromecast" main debug: using timeshift granularity of 50 MiB main debug: using timeshift path: C:\Users\MattW\AppData\Local\Temp main debug: `bluray:///H:/' gives access `bluray' demux `any' path `/H:/' main debug: creating demux: access='bluray' demux='any' location='/H:/' file='H:\' main debug: looking for access_demux module matching "bluray": 15 candidates libbluray info: First play: 0, Top menu: 0 HDMV Titles: 3, BD-J Titles: 86, Other: 86 libbluray debug: Disc is using AACS libbluray debug: Selecting Title 10 main debug: using access_demux module "libbluray" main debug: looking for demux_filter module matching "cc_demux": 2 candidates main debug: creating demux: access='' demux='ts' location='' file='(null)' main debug: looking for demux module matching "ts": 55 candidates main debug: ES_OUT_RESET_PCR called main debug: using demux_filter module "demux_chromecast" main debug: attempt to destroy nonexistent variable "title 0" main debug: attempt to destroy nonexistent variable "title 1" main debug: attempt to destroy nonexistent variable "title 2" main debug: attempt to destroy nonexistent variable "title 3" main debug: attempt to destroy nonexistent variable "title 4" main debug: attempt to destroy nonexistent variable "title 5" main debug: attempt to destroy nonexistent variable "title 6" main debug: attempt to destroy nonexistent variable "title 7" main debug: attempt to destroy nonexistent variable "title 8" main debug: attempt to destroy nonexistent variable "title 9" main debug: attempt to destroy nonexistent variable "title 10" main debug: attempt to destroy nonexistent variable "next-chapter" main debug: attempt to destroy nonexistent variable "prev-chapter" main debug: starting in sync mode main debug: looking for meta reader module matching "any": 2 candidates lua debug: Trying Lua scripts in C:\Users\MattW\AppData\Roaming\vlc\lua\meta\reader lua debug: Trying Lua scripts in C:\Program Files (x86)\VideoLAN\VLC\lua\meta\reader lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\meta\reader\filename.luac main debug: no meta reader modules matched main debug: `bluray:///H:/' successfully opened main debug: no demux modules matched main debug: creating demux: access='' demux='ts' location='' file='(null)' main debug: looking for demux module matching "ts": 55 candidates ts debug: Standard set to Auto main debug: using demux module "ts" ts debug: DEMUX_SET_GROUP -1 00000000 ts debug: PATCallBack called ts debug: new PAT ts_id=0 version=0 current_next=1 ts debug: * number=0 pid=31 ts debug: * number=1 pid=256 ts debug: temporary receiving program 1 ts debug: PMTCallBack called for program 1 ts debug: new PMT program number=1 version=0 pid_pcr=4097 ts debug: * PMT descriptor: Registration (0x5) ts debug: : HDMV registration ts debug: * PMT descriptor: Unknown Private (0x88) ts debug: * pid=4113 type=0x1b AVC video stream as defined in ITU-T Rec. H.264 ts debug: - ES descriptor tag 0x5 ts debug: => pid 4113 has now es fcc=h264 main debug: selecting program id=1 main debug: looking for packetizer module matching "any": 24 candidates main debug: using packetizer module "h264" libbluray info: Adding ES 4113 ts debug: Default program is 1 ts debug: * pid=4352 type=0x86 User Private ts debug: + HDMV registration applied to pid 4352 type 0x86 ts debug: => pid 4352 has now es fcc=dts libbluray info: Adding ES 4352 ts debug: * pid=4353 type=0x81 User Private ts debug: - ES descriptor tag 0x5 ts debug: - ES descriptor tag 0x81 ts debug: + HDMV registration applied to pid 4353 type 0x81 ts debug: => pid 4353 has now es fcc=a52 libbluray info: Adding ES 4353 ts debug: * pid=4354 type=0x85 User Private ts debug: + HDMV registration applied to pid 4354 type 0x85 ts debug: => pid 4354 has now es fcc=dts libbluray info: Adding ES 4354 ts debug: * pid=4608 type=0x90 User Private ts debug: + HDMV registration applied to pid 4608 type 0x90 ts debug: => pid 4608 has now es fcc=bdpg libbluray info: Adding ES 4608 main debug: looking for packetizer module matching "any": 24 candidates ts debug: * pid=4609 type=0x90 User Private ts debug: + HDMV registration applied to pid 4609 type 0x90 ts debug: => pid 4609 has now es fcc=bdpg main debug: using packetizer module "dts" main debug: ES_OUT_RESET_PCR called libbluray info: Adding ES 4609 ts debug: * pid=4610 type=0x90 User Private main debug: ES_OUT_RESET_PCR called ts debug: + HDMV registration applied to pid 4610 type 0x90 libbluray warning: event: 24 param: 0 ts debug: => pid 4610 has now es fcc=bdpg libbluray info: Adding ES 4610 ts debug: * pid=4611 type=0x90 User Private ts debug: + HDMV registration applied to pid 4611 type 0x90 ts debug: => pid 4611 has now es fcc=bdpg libbluray info: Adding ES 4611 ts debug: * pid=4612 type=0x90 User Private ts debug: + HDMV registration applied to pid 4612 type 0x90 ts debug: => pid 4612 has now es fcc=bdpg libbluray info: Adding ES 4612 ts debug: * pid=4613 type=0x90 User Private ts debug: + HDMV registration applied to pid 4613 type 0x90 ts debug: => pid 4613 has now es fcc=bdpg libbluray info: Adding ES 4613 ts debug: * pid=4614 type=0x90 User Private ts debug: + HDMV registration applied to pid 4614 type 0x90 ts debug: => pid 4614 has now es fcc=bdpg libbluray info: Adding ES 4614 ts debug: * pid=4615 type=0x90 User Private ts debug: + HDMV registration applied to pid 4615 type 0x90 ts debug: => pid 4615 has now es fcc=bdpg libbluray info: Adding ES 4615 ts debug: * pid=4616 type=0x90 User Private ts debug: + HDMV registration applied to pid 4616 type 0x90 ts debug: => pid 4616 has now es fcc=bdpg libbluray info: Adding ES 4616 ts debug: enabling pid 4113 from program 1 ts debug: enabling pid 4352 from program 1 ts debug: enabling pid 4353 from program 1 ts debug: enabling pid 4354 from program 1 ts debug: enabling pid 4608 from program 1 ts debug: enabling pid 4609 from program 1 ts debug: enabling pid 4610 from program 1 ts debug: enabling pid 4611 from program 1 ts debug: enabling pid 4612 from program 1 ts debug: enabling pid 4613 from program 1 ts debug: enabling pid 4614 from program 1 ts debug: enabling pid 4615 from program 1 ts debug: enabling pid 4616 from program 1 ts debug: enabling pcr pid 4097 from program 1 ts debug: pid[31] unknown ts debug: pid[4097] unknown main debug: Buffering 0% ts warning: discontinuity indicator (pid=4352) ts warning: discontinuity indicator (pid=4353) ts warning: discontinuity indicator (pid=4354) ts warning: discontinuity indicator (pid=4113) main debug: switching to async mode ts warning: discontinuity indicator (pid=4608) ts warning: discontinuity indicator (pid=4609) ts warning: discontinuity indicator (pid=4610) h264 debug: found NAL_SPS (sps_id=0) ts warning: discontinuity indicator (pid=4611) ts warning: discontinuity indicator (pid=4612) ts warning: discontinuity indicator (pid=4613) ts warning: discontinuity indicator (pid=4614) ts warning: discontinuity indicator (pid=4615) ts warning: discontinuity indicator (pid=4616) ts error: libdvbpsi error (PSI decoder): TS duplicate (received 0, expected 1) for PID 0 ts error: libdvbpsi error (PSI decoder): TS duplicate (received 0, expected 1) for PID 256 h264 debug: found NAL_PPS (pps_id=0 sps_id=0) dts debug: DTS samplerate:48000 bitrate:1536000 main debug: adding a new sout input for `dts ` (sout_input: 05f2bee8) main debug: adding a new sout input for `h264` (sout_input: 05e85bb8) main debug: Buffering 1% main debug: Buffering 2% main debug: Buffering 3% main debug: Buffering 4% main debug: Buffering 5% main debug: Buffering 6% main debug: Buffering 7% main debug: Buffering 8% main debug: Buffering 9% main debug: Buffering 10% main debug: Buffering 11% main debug: Buffering 12% main debug: Buffering 13% main debug: Buffering 14% main debug: Buffering 15% main debug: Buffering 16% main debug: Buffering 17% main debug: Buffering 18% main debug: Buffering 19% main debug: Buffering 20% main debug: Buffering 21% main debug: Buffering 22% main debug: Buffering 23% main debug: Buffering 24% main debug: Buffering 25% main debug: Buffering 26% main debug: Buffering 27% main debug: Buffering 28% main debug: Buffering 29% main debug: Buffering 30% main debug: Buffering 31% main debug: Buffering 32% main debug: Buffering 33% main debug: Buffering 34% main debug: Buffering 35% main debug: Buffering 36% main debug: Buffering 37% main debug: Buffering 38% main debug: Buffering 39% main debug: Buffering 40% main debug: Buffering 41% main debug: Buffering 42% main debug: Buffering 43% main debug: Buffering 44% main debug: Buffering 45% main debug: Buffering 46% main debug: Buffering 47% main debug: Buffering 48% main debug: Buffering 49% main debug: Buffering 50% main debug: Buffering 51% main debug: Buffering 52% main debug: Buffering 53% main debug: Buffering 54% main debug: Buffering 55% main debug: Buffering 56% main debug: Buffering 57% main debug: Buffering 58% main debug: Buffering 59% main debug: removing module "microdns" main debug: Buffering 60% main debug: Buffering 61% main debug: Buffering 62% main debug: Buffering 63% main debug: Buffering 64% main debug: Buffering 65% main debug: Buffering 66% main debug: Buffering 67% main debug: Buffering 68% main debug: Buffering 69% main debug: Buffering 70% main debug: Buffering 71% main debug: Buffering 72% main debug: Buffering 73% main debug: Buffering 74% main debug: Buffering 75% main debug: Buffering 76% main debug: Buffering 77% main debug: Buffering 78% main debug: Buffering 79% main debug: Buffering 80% main debug: Buffering 81% main debug: Buffering 82% main debug: Buffering 83% main debug: Buffering 84% main debug: Buffering 85% main debug: Buffering 86% main debug: Buffering 87% main debug: Buffering 88% main debug: Buffering 89% main debug: Buffering 90% main debug: Buffering 91% main debug: Buffering 92% main debug: Buffering 93% main debug: Buffering 94% main debug: Buffering 95% main debug: Buffering 96% main debug: Buffering 97% main debug: Buffering 98% main debug: Buffering 99% main debug: Stream buffering done (10079 ms in 4016 ms) main debug: Decoder wait done in 0 ms stream_out_chromecast debug: can't remux audio track 4352 codec dts stream_out_chromecast debug: Converting audio to vorb stream_out_chromecast debug: Creating chain transcode{acodec=vorb,aenc=vorbis{quality=4},}:chromecast-proxy:std{mux=avformat{mux=matroska,options={live=1}},access=chromecast-http} main debug: stream=`std' main debug: looking for sout stream module matching "std": 23 candidates main debug: set config option: sout-standard-mux to avformat{mux=matroska,options={live=1}} main debug: set config option: sout-standard-access to chromecast-http main debug: looking for sout access module matching "chromecast-http": 10 candidates main debug: using sout access module "stream_out_chromecast" main debug: looking for sout mux module matching "avformat": 11 candidates avcodec debug: using ffmpeg Lavf58.3.100 avcodec debug: CPU flags: 0x0007d3db main debug: set config option: sout-avformat-mux to matroska main debug: set config option: sout-avformat-options to live=1 main debug: using sout mux module "avcodec" stream_out_standard debug: using `chromecast-http/avformat{mux=matroska,options={live=1}}://(null)' main debug: using sout stream module "stream_out_standard" main debug: stream=`chromecast-proxy' main debug: looking for sout stream module matching "chromecast-proxy": 23 candidates main debug: using sout stream module "stream_out_chromecast" main debug: stream=`transcode' main debug: looking for sout stream module matching "transcode": 23 candidates stream_out_chromecast debug: PONG received from the Chromecast main debug: set config option: sout-transcode-acodec to vorb main debug: set config option: sout-transcode-aenc to vorbis{quality=4} stream_out_transcode debug: Checking codec mapping for vorb got vorb stream_out_transcode debug: codec audio=vorb 0Hz 0 channels 96Kb/s main debug: using sout stream module "stream_out_transcode" stream_out_transcode debug: creating audio transcoding from fcc=`dts ' to fcc=`vorb' main debug: looking for audio decoder module matching "any": 23 candidates avcodec debug: using ffmpeg Lavc58.6.103 avcodec debug: CPU flags: 0x0007d3db avcodec debug: codec (dca) started main debug: using audio decoder module "avcodec" main debug: looking for encoder module matching "vorbis": 23 candidates main debug: set config option: sout-vorbis-quality to 4 main debug: using encoder module "vorbis" main debug: input 's16l' 48000 Hz 3F2R/LFE frame=1 samples/12 bytes main debug: conversion: 's16l'->'f32l' 48000 Hz->48000 Hz 3F2R/LFE->3F2R/LFE main debug: looking for audio converter module matching "any": 8 candidates audio_format debug: s16l->f32l, bits per sample: 16->32 main debug: using audio converter module "audio_format" main debug: conversion pipeline complete main debug: looking for audio resampler module matching "any": 3 candidates main debug: using audio resampler module "samplerate" main debug: removing module "vorbis" main debug: removing module "samplerate" main debug: removing module "audio_format" stream_out_transcode debug: not transcoding a stream (fcc=`h264') main debug: adding a new input avcodec debug: adding input avcodec debug: Muxing framerate will be 24000/1001 = 23.98 fps avcodec debug: Muxing aspect ratio will be 1/1 avcodec warning: Missing video bitrate, assuming 512k main debug: looking for encoder module matching "vorbis": 23 candidates main debug: set config option: sout-vorbis-quality to 4 main debug: using encoder module "vorbis" main debug: input 's32l' 48000 Hz 3F2M2R/LFE frame=1 samples/32 bytes main debug: conversion: 's32l'->'f32l' 48000 Hz->48000 Hz 3F2M2R/LFE->3F2M2R/LFE main debug: looking for audio converter module matching "any": 8 candidates audio_format debug: s32l->f32l, bits per sample: 32->32 main debug: using audio converter module "audio_format" main debug: conversion pipeline complete main debug: looking for audio resampler module matching "any": 3 candidates main debug: using audio resampler module "samplerate" main debug: adding a new input avcodec debug: adding input avcodec debug: writing header stream_out_chromecast debug: Loading content stream_out_chromecast debug: Starting the media receiver application stream_out_chromecast debug: Media receiver application has been started. stream_out_chromecast debug: s_chromecast_url: http://192.168.1.105:8010/chromecast/84222000/18446744071823998995/stream stream_out_chromecast debug: PING received from the Chromecast stream_out_chromecast debug: Player state: BUFFERING sessionId: 1 stream_out_chromecast debug: New mediaSessionId: 1 stream_out_chromecast debug: Player state: PLAYING sessionId: 1 stream_out_chromecast debug: Player state: PLAYING sessionId: 1 stream_out_chromecast debug: Player state: BUFFERING sessionId: 1 stream_out_chromecast debug: Player state: PLAYING sessionId: 1 stream_out_chromecast debug: Player state: PLAYING sessionId: 1 stream_out_chromecast debug: Player state: PLAYING sessionId: 1 stream_out_chromecast debug: Player state: BUFFERING sessionId: 1 stream_out_chromecast debug: Player state: PLAYING sessionId: 1 stream_out_chromecast debug: Player state: PLAYING sessionId: 1 stream_out_chromecast debug: Player state: BUFFERING sessionId: 1 stream_out_chromecast debug: Player state: PLAYING sessionId: 1 stream_out_chromecast debug: Player state: PLAYING sessionId: 1 stream_out_chromecast debug: Player state: PLAYING sessionId: 1 stream_out_chromecast debug: Player state: BUFFERING sessionId: 1 stream_out_chromecast debug: Player state: PLAYING sessionId: 1 stream_out_chromecast debug: Player state: PLAYING sessionId: 1 stream_out_chromecast debug: Player state: PLAYING sessionId: 1 stream_out_chromecast debug: Player state: PLAYING sessionId: 1 stream_out_chromecast debug: Player state: PLAYING sessionId: 1 stream_out_chromecast debug: Player state: PLAYING sessionId: 1 stream_out_chromecast debug: Player state: BUFFERING sessionId: 1 stream_out_chromecast debug: Player state: PLAYING sessionId: 1 stream_out_chromecast debug: Player state: BUFFERING sessionId: 1 stream_out_chromecast debug: Player state: BUFFERING sessionId: 1 main debug: incoming request - stopping current input main debug: killing decoder fourcc `h264' main debug: removing module "h264" main debug: removing a sout input (sout_input: 05e85bb8) avcodec debug: removing input main debug: killing decoder fourcc `dts ' main debug: removing module "dts" main debug: removing a sout input (sout_input: 05f2bee8) main debug: removing module "avcodec" main debug: removing module "vorbis" main debug: removing module "samplerate" main debug: removing module "audio_format" avcodec debug: removing input main warning: no more input streams for this mux main debug: destroying chain... (name=transcode) main debug: removing module "stream_out_transcode" main debug: destroying chain done main debug: destroying chain... (name=chromecast-proxy) main debug: removing module "stream_out_chromecast" main debug: destroying chain done main debug: destroying chain... (name=std) main debug: removing module "stream_out_standard" main debug: removing module "avcodec" main debug: removing module "stream_out_chromecast" main debug: destroying chain done main debug: removing module "demux_chromecast" main debug: removing module "libbluray" libbluray info: Closing overlays. ts debug: Can't read TS packet at 75765696 main debug: removing module "ts" main debug: Program doesn't contain anymore ES main debug: dead input main debug: nothing to play qt debug: IM: Deleting the input stream_out_chromecast warning: Unexpected RECEIVER_STATUS with state Stopping. Checking media status stream_out_chromecast debug: Player state: IDLE sessionId: 1 stream_out_chromecast debug: PING received from the Chromecast stream_out_chromecast debug: PING received from the Chromecast

[robUx4]

Strange, there is no transcoding of the video. So it's basically sending the data from the disc (the audio is transcoded but it's less CPU intensive).