Real Media Playback Issues with RM demuxer
The new version of VLC seems to have some problems with Real Media video files. The Video codec for the .rm file in question is RealVideo G2 (2.0) (RV20) with Audio listed as Cook Audio (cook).
This is on a Late 2013 Mac Pro with 3.5GHz 6-Core Intel Xeon E5 processor, 12GB RAM, 500GB Flash Storage & an AMD FirePro D300 204MB GPU, running macOS Sierra 10.12.6 (16G1212).
Playback is fine on VLC 2.2.8, but on 3.0.0, 3.0.1, 3.0.2-20180326-0644 & VLC 4.0.0-20180326-0403 the audio starts immediately, but the video is frozen for a few seconds & then, once it does kick in, it's a bit garbled at first before playback clears up completely. This occurs even after I "Reset All" on VLC Preferences.
Sample here: https://streams.videolan.org/issues/20179/
Here's the debug log info up until the point things clear up:
main debug: VLC media player - 3.0.1 Vetinari
main debug: Copyright © 1996-2018 the VideoLAN team
main debug: revision 3.0.1-0-gec0f700fcc
main debug: configured with /Users/d-fu/vlc-3.0/extras/package/macosx/../../../configure '--prefix=/Users/d-fu/vlc-3.0/release-3.0.1/vlc_install_dir' '--enable-macosx' '--enable-merge-ffmpeg' '--enable-osx-notifications' '--enable-faad' '--enable-flac' '--enable-theora' '--enable-shout' '--enable-ncurses' '--enable-twolame' '--enable-realrtsp' '--enable-libass' '--enable-macosx-qtkit' '--enable-macosx-avfoundation' '--disable-skins2' '--disable-xcb' '--disable-caca' '--disable-pulse' '--disable-sdl-image' '--disable-vnc' '--build=x86_64-apple-darwin17' '--host=x86_64-apple-darwin17' '--with-macosx-version-min=10.7' '--with-macosx-sdk=/Applications/Xcode.app/Contents/Developer/Platforms/MacOSX.platform/Developer/SDKs/MacOSX10.13.sdk' '--with-breakpad=https://mac.crashes.videolan.org' 'build_alias=x86_64-apple-darwin17' 'host_alias=x86_64-apple-darwin17' 'CC=/Applications/Xcode.app/Contents/Developer/Toolchains/XcodeDefault.xctoolchain/usr/bin/clang' 'CFLAGS=-g' 'LDFLAGS=' 'CXX=/Applications/Xcode.app/Contents/Developer/Toolchains/XcodeDefault.xctoolchain/usr/bin/clang++' 'CXXFLAGS=-g' 'OBJC=/Applications/Xcode.app/Contents/Developer/Toolchains/XcodeDefault.xctoolchain/usr/bin/clang' 'OBJCFLAGS=-g'
main debug: Creating an input for preparsing 'Life Of Larry.rm'
main debug: processing request item: Life Of Larry.rm, 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 Life Of Larry.rm
main debug: Life Of Larry.rm is at 0
main debug: creating new input thread
macosx debug: Enable media key support
main debug: Creating an input for 'Life Of Larry.rm'
main debug: looking for meta fetcher module matching "any": 1 candidates
lua debug: Trying Lua scripts in /Users/steve/Library/Application Support/org.videolan.vlc/lua/meta/fetcher
lua debug: Trying Lua scripts in /Applications/VLC.app/Contents/MacOS/lua/meta/fetcher
lua debug: Trying Lua scripts in /Applications/VLC.app/Contents/MacOS/share/lua/meta/fetcher
main debug: no meta fetcher modules matched
main debug: looking for art finder module matching "any": 2 candidates
main debug: requesting art for new input thread
main debug: using timeshift granularity of 50 MiB
main debug: using default timeshift path
main debug: `file:///Users/steve/Desktop/Life%20Of%20Larry.rm' gives access `file' demux `any' path `/Users/steve/Desktop/Life%20Of%20Larry.rm'
main debug: creating demux: access='file' demux='any' location='/Users/steve/Desktop/Life%20Of%20Larry.rm' file='/Users/steve/Desktop/Life Of Larry.rm'
main debug: looking for access_demux module matching "file": 13 candidates
main debug: no access_demux modules matched
main debug: creating access: file:///Users/steve/Desktop/Life%20Of%20Larry.rm
main debug: (path: /Users/steve/Desktop/Life Of Larry.rm)
main debug: looking for access module matching "file": 23 candidates
main debug: using access module "filesystem"
main debug: looking for stream_filter module matching "prefetch,cache_read": 26 candidates
cache_read debug: Using stream method for AStream*
cache_read debug: starting pre-buffering
cache_read debug: received first data after 0 ms
cache_read debug: pre-buffering done 1024 bytes in 0s - 15873 KiB/s
main debug: using stream_filter module "cache_read"
main debug: looking for stream_filter module matching "any": 26 candidates
lua debug: Trying Lua scripts in /Users/steve/Library/Application Support/org.videolan.vlc/lua/playlist
lua debug: Trying Lua scripts in /Applications/VLC.app/Contents/MacOS/lua/playlist
lua debug: Trying Lua scripts in /Applications/VLC.app/Contents/MacOS/share/lua/playlist
lua debug: Trying Lua scripts in /Users/steve/Library/Application Support/org.videolan.vlc/lua/meta/art
lua debug: Trying Lua scripts in /Applications/VLC.app/Contents/MacOS/lua/meta/art
lua debug: Trying Lua scripts in /Applications/VLC.app/Contents/MacOS/share/lua/meta/art
lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/playlist/anevia_streams.luac
lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/meta/art/00_musicbrainz.luac
lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/playlist/anevia_xml.luac
lua debug: skipping script (unmatched scope) /Applications/VLC.app/Contents/MacOS/share/lua/meta/art/00_musicbrainz.luac
lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/meta/art/01_googleimage.luac
lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/playlist/appletrailers.luac
lua debug: skipping script (unmatched scope) /Applications/VLC.app/Contents/MacOS/share/lua/meta/art/01_googleimage.luac
lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/meta/art/02_frenchtv.luac
lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/playlist/bbc_co_uk.luac
lua debug: skipping script (unmatched scope) /Applications/VLC.app/Contents/MacOS/share/lua/meta/art/02_frenchtv.luac
lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/meta/art/03_lastfm.luac
lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/playlist/cue.luac
lua debug: skipping script (unmatched scope) /Applications/VLC.app/Contents/MacOS/share/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 playlist script /Applications/VLC.app/Contents/MacOS/share/lua/playlist/dailymotion.luac
lua debug: Trying Lua scripts in /Users/steve/Library/Application Support/org.videolan.vlc/lua/meta/fetcher
lua debug: Trying Lua scripts in /Applications/VLC.app/Contents/MacOS/lua/meta/fetcher
lua debug: Trying Lua scripts in /Applications/VLC.app/Contents/MacOS/share/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 /Users/steve/Library/Application Support/org.videolan.vlc/lua/meta/art
lua debug: Trying Lua scripts in /Applications/VLC.app/Contents/MacOS/lua/meta/art
lua debug: Trying Lua scripts in /Applications/VLC.app/Contents/MacOS/share/lua/meta/art
lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/meta/art/00_musicbrainz.luac
lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/playlist/jamendo.luac
lua debug: skipping script (unmatched scope) /Applications/VLC.app/Contents/MacOS/share/lua/meta/art/00_musicbrainz.luac
lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/meta/art/01_googleimage.luac
lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/playlist/koreus.luac
lua debug: skipping script (unmatched scope) /Applications/VLC.app/Contents/MacOS/share/lua/meta/art/01_googleimage.luac
lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/meta/art/02_frenchtv.luac
lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/playlist/liveleak.luac
lua debug: skipping script (unmatched scope) /Applications/VLC.app/Contents/MacOS/share/lua/meta/art/02_frenchtv.luac
lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/meta/art/03_lastfm.luac
lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/playlist/newgrounds.luac
lua debug: skipping script (unmatched scope) /Applications/VLC.app/Contents/MacOS/share/lua/meta/art/03_lastfm.luac
lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/playlist/rockbox_fm_presets.luac
main debug: no art finder modules matched
lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/playlist/soundcloud.luac
lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/playlist/twitch.luac
lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/playlist/vimeo.luac
lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/playlist/vocaroo.luac
lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/playlist/youtube.luac
main debug: no stream_filter modules matched
main debug: looking for stream_directory module matching "any": 1 candidates
main debug: no stream_directory modules matched
main debug: attachment of directory-extractor failed for file:///Users/steve/Desktop/Life%20Of%20Larry.rm
main debug: looking for stream_filter module matching "record": 26 candidates
main debug: using stream_filter module "record"
main debug: creating demux: access='file' demux='any' location='/Users/steve/Desktop/Life%20Of%20Larry.rm' file='/Users/steve/Desktop/Life Of Larry.rm'
main debug: looking for demux module matching "avformatrmi": 55 candidates
main debug: looking for xml reader module matching "any": 1 candidates
main debug: using xml reader module "xml"
ts debug: TS module discarded (lost sync)
mod debug: MOD validation failed (ext=rm)
webvtt debug: subtitle demux discarded
avcodec debug: trying url: /Users/steve/Desktop/Life Of Larry.rm
avcodec debug: CPU flags: 0x000853db
avcodec debug: detected format: rm
main debug: selecting program id=0
avcodec debug: adding es: audio codec = cook (86036)
avcodec debug: adding es: video codec = RV20 (6)
avcodec debug: AVFormat(ffmpeg Lavf58.3.100) supported stream
avcodec debug: - format = rm (RealMedia)
avcodec debug: - start time = 0
avcodec debug: - duration = 620107000
main debug: using demux module "avcodec"
main debug: looking for a subtitle file in /Users/steve/Desktop/
main debug: looking for audio decoder module matching "any": 21 candidates
avcodec debug: using ffmpeg Lavc58.6.103
avcodec debug: CPU flags: 0x000853db
avcodec debug: codec (cook) started
main debug: using audio decoder module "avcodec"
main debug: looking for video decoder module matching "any": 14 candidates
avcodec debug: using ffmpeg Lavc58.6.103
avcodec debug: CPU flags: 0x000853db
avcodec debug: allowing 6 thread(s) for decoding
avcodec debug: codec (rv20) started
main debug: using video decoder module "avcodec"
main debug: looking for meta reader module matching "any": 2 candidates
lua debug: Trying Lua scripts in /Users/steve/Library/Application Support/org.videolan.vlc/lua/meta/reader
lua debug: Trying Lua scripts in /Applications/VLC.app/Contents/MacOS/lua/meta/reader
lua debug: Trying Lua scripts in /Applications/VLC.app/Contents/MacOS/share/lua/meta/reader
lua debug: Trying Lua playlist script /Applications/VLC.app/Contents/MacOS/share/lua/meta/reader/filename.luac
main debug: no meta reader modules matched
main debug: `file:///Users/steve/Desktop/Life%20Of%20Larry.rm' successfully opened
main debug: Buffering 0%
main debug: Buffering 2%
main debug: Buffering 4%
main debug: Buffering 6%
main debug: reusing audio output
main debug: Buffering 9%
main debug: VLC is looking for: 'f32l' 22050 Hz Mono frame=1 samples/4 bytes
auhal debug: attempting to use device 0
main debug: Buffering 11%
main debug: Buffering 13%
main debug: Buffering 16%
auhal debug: using default audio device 40
main debug: Buffering 18%
main debug: Buffering 20%
main debug: Buffering 23%
main debug: Buffering 25%
main debug: Buffering 27%
main debug: Buffering 29%
main debug: Buffering 32%
main debug: Buffering 34%
main debug: Buffering 36%
main debug: Buffering 39%
main debug: Buffering 41%
main debug: Buffering 43%
main debug: Buffering 46%
main debug: Buffering 48%
main debug: Buffering 50%
main debug: Buffering 52%
main debug: Buffering 55%
main debug: Buffering 57%
main debug: Buffering 59%
main debug: Buffering 62%
main debug: Buffering 64%
main debug: Buffering 66%
main debug: Buffering 69%
main debug: Buffering 71%
main debug: Buffering 73%
main debug: Buffering 75%
main debug: Buffering 78%
main debug: Buffering 80%
main debug: Buffering 82%
main debug: Buffering 85%
main debug: Buffering 87%
main debug: Buffering 89%
main debug: Buffering 92%
main debug: Buffering 94%
main debug: Buffering 96%
main debug: Buffering 98%
main debug: Stream buffering done (1012 ms in 1 ms)
auhal debug: output layout of AUHAL is Stereo
auhal debug: selected 2 physical channels for device output
auhal debug: VLC will output: Stereo
auhal debug: Current AU format: [22050.000000][mcpl][9][8][1][8][2][32]
auhal debug: Current device has a latency of 634 us
auhal debug: analog output successfully opened
main debug: output 'f32l' 22050 Hz Stereo frame=1 samples/8 bytes
main debug: looking for audio volume module matching "any": 2 candidates
main debug: using audio volume module "float_mixer"
main debug: input 'f32l' 22050 Hz Mono frame=1 samples/4 bytes
main debug: looking for audio filter module matching "scaletempo": 16 candidates
scaletempo debug: format: 22050 rate, 1 nch, 4 bps, fl32
scaletempo debug: params: 30 stride, 0.200 overlap, 14 search
scaletempo debug: 1.000 scale, 661.000 stride_in, 661 stride_out, 529 standing, 132 overlap, 308 search, 1101 queue, fl32 mode
main debug: using audio filter module "scaletempo"
main debug: conversion: 'f32l'->'f32l' 22050 Hz->22050 Hz Mono->Mono
main debug: conversion pipeline complete
main debug: conversion: 'f32l'->'f32l' 22050 Hz->22050 Hz Mono->Stereo
main debug: looking for audio converter module matching "any": 8 candidates
main debug: using audio converter module "trivial"
main debug: conversion pipeline complete
main debug: looking for audio resampler module matching "any": 3 candidates
main debug: using audio resampler module "samplerate"
main error: buffer deadlock prevented
main debug: Decoder wait done in 21 ms
main debug: inserting 1218 zeroes
macosx debug: Activated assertion NoIdleSleepAssertion through IOKit (35624)
main debug: looking for text renderer module matching "any": 3 candidates
main warning: playback way too early (-413048): playing silence
main debug: inserting 9107 zeroes
main debug: using text renderer module "freetype"
main debug: looking for video converter module matching "any": 22 candidates
swscale debug: 32x32 (32x32) chroma: YUVA -> 16x16 (16x16) chroma: RGBA with scaling using Bicubic (good quality)
main debug: using video converter module "swscale"
main debug: looking for video converter module matching "any": 22 candidates
yuvp debug: YUVP to YUVA converter
main debug: using video converter module "yuvp"
main debug: Deinterlacing available
main debug: deinterlace -1, mode auto, is_needed 0
main debug: looking for vout window module matching "any": 1 candidates
macosx debug: Opening video window
macosx debug: Releasing old IOKit other assertion (35624)
macosx debug: Activated assertion NoDisplaySleepAssertion through IOKit (35626)
macosx debug: toggle playlist from state: removed splitview 0, minimized view 0. Event 2
macosx debug: toggle playlist to state: removed splitview 0, minimized view 0
macosx debug: returning videoview with proposed position x=0, y=0, width=176, height=120
main debug: using vout window module "macosx"
main debug: Opening vout display wrapper
main debug: looking for vout display module matching "any": 7 candidates
main debug: VoutDisplayEvent 'resize' 176x120
macosx debug: PBO support enabled
main debug: VoutDisplayEvent 'resize' 176x120
main debug: using vout display module "macosx"
main debug: original format sz 176x128, of (0,0), vsz 176x120, 4cc I420, sar 1:1, msk r0x0 g0x0 b0x0
main debug: removing module "freetype"
main debug: looking for text renderer module matching "any": 3 candidates
main debug: VoutDisplayEvent 'resize' 716x297
main debug: using text renderer module "freetype"
main debug: picture might be displayed late (missing 694 ms)
main debug: VoutDisplayEvent 'resize' 716x297
main debug: VoutDisplayEvent 'resize' 716x297
main debug: VoutDisplayEvent 'resize' 701x274
main debug: VoutDisplayEvent 'resize' 701x274
main debug: picture might be displayed late (missing 612 ms)
main debug: VoutDisplayEvent 'resize' 701x274
main debug: picture might be displayed late (missing 555 ms)
main debug: picture might be displayed late (missing 488 ms)
main debug: VoutDisplayEvent 'resize' 701x274
main debug: VoutDisplayEvent 'resize' 701x274
main debug: VoutDisplayEvent 'resize' 632x164
main debug: VoutDisplayEvent 'resize' 632x164
main debug: VoutDisplayEvent 'resize' 632x164
main debug: VoutDisplayEvent 'resize' 632x164
main debug: VoutDisplayEvent 'resize' 632x164
main debug: VoutDisplayEvent 'resize' 618x142
main debug: VoutDisplayEvent 'resize' 618x142
main debug: VoutDisplayEvent 'resize' 618x142
main debug: VoutDisplayEvent 'resize' 618x142
main debug: VoutDisplayEvent 'resize' 618x142
main debug: VoutDisplayEvent 'resize' 610x129
main debug: VoutDisplayEvent 'resize' 610x129
main debug: VoutDisplayEvent 'resize' 610x129
main debug: VoutDisplayEvent 'resize' 610x129
main debug: VoutDisplayEvent 'resize' 610x129
main debug: VoutDisplayEvent 'resize' 608x125
main debug: VoutDisplayEvent 'resize' 608x125
main debug: VoutDisplayEvent 'resize' 608x125
main debug: VoutDisplayEvent 'resize' 608x125
main debug: VoutDisplayEvent 'resize' 608x125
main debug: VoutDisplayEvent 'resize' 605x121
main debug: VoutDisplayEvent 'resize' 605x121
main debug: VoutDisplayEvent 'resize' 605x121
main debug: VoutDisplayEvent 'resize' 605x121
main debug: VoutDisplayEvent 'resize' 605x121
main debug: VoutDisplayEvent 'resize' 604x120
main debug: VoutDisplayEvent 'resize' 604x120
main debug: VoutDisplayEvent 'resize' 604x120
main debug: VoutDisplayEvent 'resize' 604x120
main debug: auto hiding mouse cursor
avcodec error: more than 5 seconds of late video -> dropping frame (computer too slow ?)
avcodec error: more than 5 seconds of late video -> dropping frame (computer too slow ?)
avcodec error: more than 5 seconds of late video -> dropping frame (computer too slow ?)
avcodec error: more than 5 seconds of late video -> dropping frame (computer too slow ?)
avcodec error: more than 5 seconds of late video -> dropping frame (computer too slow ?)
main debug: picture might be displayed late (missing 4 ms)