Vlc transcoder disconnects client when lights go out
Posted: 13 Oct 2018 22:55
Window 10.
vlc 3.0.3 Vetinari
Vlc is connecting to IP camera's H.264 stream and transcoding to MJpeg over HTTP.
The camera's H.264 stream is set to fps=8, key-interval 12, 200Kbps, 320x240.
My custom client is connecting to vlc output on port 13860.
The Infrared (night-vision) lights on the camera are turned off for this experiment.
This setup usually runs well until I turn off the light in the room.
The camera continues to produce the H.264 stream with the jpeg images changing from about 6KB to about 2.5KB in the dark room.
Vlc continues to consume 0.5% of cpu.
But vlc stops sending the output stream.
My client reacts to the stall by re-sending the HTTP request to port 13860.
Vlc responds with 200 OK and sends a multi-part header indicating Content-Type: image/jpeg and Content-Length: 2452
But it never sends any more video bytes.
The only way to recover is to close the vlc process and start over with a new vlc instance.
My application is a video recorder, so having something temporarily blocking or inhibiting the light is undesirable if it stalls the video feed to the recorder.
Hopefully someone knows how to prevent this behavior.
Other than that it works great!
Here is the log file:
vlc 3.0.3 Vetinari
Code: Select all
vlc -R -Idummy -vvv --network-caching 100 --extraintf=logger --file-logging --logfile=..\VlcLogs\vlc-log.txt "rtsp://me:mypwd@192.168.0.85:554/videoSub" --drop-late-frames --sout "#transcode{vcodec=mjpg,vb=100,venc=ffmpeg{vt=8000000},scale=1,fps=2,acodec=none}:std{access=http{mime=multipart/x-mixed-replace; boundary=Ipcam},mux=mpjpeg,dst=:13860/videostream.cgi}" --sout-keep
The camera's H.264 stream is set to fps=8, key-interval 12, 200Kbps, 320x240.
My custom client is connecting to vlc output on port 13860.
The Infrared (night-vision) lights on the camera are turned off for this experiment.
This setup usually runs well until I turn off the light in the room.
The camera continues to produce the H.264 stream with the jpeg images changing from about 6KB to about 2.5KB in the dark room.
Vlc continues to consume 0.5% of cpu.
But vlc stops sending the output stream.
My client reacts to the stall by re-sending the HTTP request to port 13860.
Vlc responds with 200 OK and sends a multi-part header indicating Content-Type: image/jpeg and Content-Length: 2452
But it never sends any more video bytes.
The only way to recover is to close the vlc process and start over with a new vlc instance.
My application is a video recorder, so having something temporarily blocking or inhibiting the light is undesirable if it stalls the video feed to the recorder.
Hopefully someone knows how to prevent this behavior.
Other than that it works great!
Here is the log file:
Code: Select all
-- logger module started --
main debug: VLC media player - 3.0.4 Vetinari
main debug: Copyright © 1996-2018 the VideoLAN team
main debug: revision 3.0.4-0-gf615db6332
main debug: configured with ../extras/package/win32/../../../configure '--enable-update-check' '--enable-lua' '--enable-faad' '--enable-flac' '--enable-theora' '--enable-avcodec' '--enable-merge-ffmpeg' '--enable-dca' '--enable-mpc' '--enable-libass' '--enable-schroedinger' '--enable-realrtsp' '--enable-live555' '--enable-dvdread' '--enable-shout' '--enable-goom' '--enable-caca' '--enable-qt' '--enable-skins2' '--enable-sse' '--enable-mmx' '--enable-libcddb' '--enable-zvbi' '--disable-telx' '--enable-nls' '--host=x86_64-w64-mingw32' '--with-breakpad=https://win.crashes.videolan.org' 'host_alias=x86_64-w64-mingw32' 'PKG_CONFIG_LIBDIR=/home/jenkins/workspace/vlc-release/windows/vlc-release-win32-x64/contrib/x86_64-w64-mingw32/lib/pkgconfig'
main debug: using multimedia timers as clock source
main debug: min period: 1 ms, max period: 1000000 ms
main debug: searching plug-in modules
main debug: loading plugins cache file C:\xxxx\VLC\plugins\plugins.dat
main debug: recursively browsing `C:\xxxx\VLC\plugins'
main debug: plug-ins loaded: 490 modules
main debug: opening config file (C:\Users\xxxx\AppData\Roaming\vlc\vlcrc)
main debug: looking for logger module matching "any": 2 candidates
file debug: opening logfile `..\VlcLogs\vlc-log.txt'
main debug: using logger module "file"
main debug: translation test: code is "C"
main debug: looking for keystore module matching "memory": 3 candidates
main debug: using keystore module "memory"
main debug: CPU has capabilities MMX MMXEXT SSE SSE2 SSE3 SSSE3 SSE4.1 SSE4.2 FPU
main debug: Creating an input for 'Media Library'
main debug: Input is a meta file: disabling unneeded options
main debug: using timeshift granularity of 50 MiB
main debug: using timeshift path: C:\Users\xxxx\AppData\Local\Temp
main debug: `file/directory:///C:/Users/xxxx/AppData/Roaming/vlc/ml.xspf' gives access `file' demux `directory' path `/C:/Users/xxxx/AppData/Roaming/vlc/ml.xspf'
main debug: creating demux: access='file' demux='directory' location='/C:/Users/xxxx/AppData/Roaming/vlc/ml.xspf' file='C:\Users\xxxx\AppData\Roaming\vlc\ml.xspf'
main debug: looking for access_demux module matching "file": 15 candidates
main debug: no access_demux modules matched
main debug: creating access: file:///C:/Users/xxxx/AppData/Roaming/vlc/ml.xspf
main debug: (path: C:\Users\xxxx\AppData\Roaming\vlc\ml.xspf)
main debug: looking for access module matching "file": 26 candidates
main debug: using access module "filesystem"
main debug: looking for stream_filter module matching "prefetch,cache_read": 24 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 304 bytes in 0s - 296875 KiB/s
main debug: using stream_filter module "cache_read"
main debug: looking for stream_filter module matching "any": 24 candidates
playlist debug: using XSPF playlist reader
main debug: using stream_filter module "playlist"
main debug: stream filter added to 000002181dd38190
main debug: looking for stream_filter module matching "any": 24 candidates
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:///C:/Users/xxxx/AppData/Roaming/vlc/ml.xspf
main debug: looking for stream_filter module matching "record": 24 candidates
main debug: using stream_filter module "record"
main debug: creating demux: access='file' demux='directory' location='/C:/Users/xxxx/AppData/Roaming/vlc/ml.xspf' file='C:\Users\xxxx\AppData\Roaming\vlc\ml.xspf'
main debug: looking for demux module matching "directory": 55 candidates
main debug: using demux module "directory"
main debug: looking for meta reader module matching "any": 2 candidates
lua debug: Trying Lua scripts in C:\Users\xxxx\AppData\Roaming\vlc\lua\meta\reader
lua debug: Trying Lua scripts in C:\xxxx\VLC\lua\meta\reader
lua debug: Trying Lua playlist script C:\xxxx\VLC\lua\meta\reader\filename.luac
main debug: no meta reader modules matched
main debug: `file/directory:///C:/Users/xxxx/AppData/Roaming/vlc/ml.xspf' successfully opened
main debug: looking for xml reader module matching "any": 1 candidates
main debug: using xml reader module "xml"
main debug: EOF reached
main debug: removing module "directory"
main debug: removing module "record"
main debug: removing module "playlist"
main debug: removing module "cache_read"
main debug: removing module "filesystem"
main debug: creating audio output
main debug: looking for audio output module matching "any": 6 candidates
mmdevice debug: using default device
mmdevice debug: display name changed: VLC media player (LibVLC 3.0.4)
mmdevice debug: version 2 session control unavailable
mmdevice debug: volume from -65.250000 dB to +0.000000 dB with 0.031250 dB increments
main debug: using audio output module "mmdevice"
main debug: keeping audio output
main debug: looking for interface module matching "logger,none": 16 candidates
logger error: The logger interface no longer exists.
logger: As of VLC version 0.9.0, use --file-logging to write logs to a file.
main debug: no interface modules matched
main error: no suitable interface module
main error: interface "logger,none" initialization failed
main debug: looking for interface module matching "hotkeys,none": 16 candidates
main debug: using interface module "hotkeys"
main debug: looking for interface module matching "globalhotkeys,none": 16 candidates
main debug: using interface module "win32"
main debug: looking for interface module matching "dummy": 16 candidates
dummy: using the dummy interface module...
main debug: using interface module "dummy"
main debug: processing request item: null, node: Playlist, skip: 0
main debug: rebuilding array of current - root Playlist
main debug: rebuild done - 1 items, index -1
main debug: starting playback of new item
main debug: resyncing on rtsp://192.168.0.85:554/videoSub
main debug: rtsp://192.168.0.85:554/videoSub is at 0
main debug: creating new input thread
main debug: Creating an input for 'rtsp://192.168.0.85:554/videoSub'
main debug: requesting art for new input thread
main debug: using sout chain=`transcode{vcodec=mjpg,vb=100,venc=ffmpeg{vt=8000000},scale=1,fps=2,acodec=copy}:std{access=http{mime=multipart/x-mixed-replace; boundary=Ipcam},mux=mpjpeg,dst=:13860/videostream.cgi}'
main debug: stream=`std'
main debug: looking for sout stream module matching "std": 23 candidates
main debug: looking for meta fetcher module matching "any": 1 candidates
main debug: set config option: sout-standard-access to http{mime=multipart/x-mixed-replace; boundary=Ipcam}
main debug: set config option: sout-standard-mux to mpjpeg
main debug: set config option: sout-standard-dst to :13860/videostream.cgi
main debug: looking for sout access module matching "http": 10 candidates
lua debug: Trying Lua scripts in C:\Users\xxxx\AppData\Roaming\vlc\lua\meta\fetcher
lua debug: Trying Lua scripts in C:\xxx\VLC\lua\meta\fetcher
main debug: no meta fetcher modules matched
main debug: looking for art finder module matching "any": 2 candidates
main debug: set config option: sout-http-mime to multipart/x-mixed-replace; boundary=Ipcam
main debug: net: listening to * port 13860
main debug: using sout access module "http"
lua debug: Trying Lua scripts in C:\Users\xxxx\AppData\Roaming\vlc\lua\meta\art
main debug: looking for sout mux module matching "mpjpeg": 11 candidates
lua debug: Trying Lua scripts in C:\xxxx\\VLC\lua\meta\art
lua debug: Trying Lua playlist script C:\xxxx\\VLC\lua\meta\art\00_musicbrainz.luac
mpjpeg debug: Multipart jpeg muxer opened
main debug: using sout mux module "mpjpeg"
main debug: muxer support adding stream at any time
main debug: muxer prefers to wait for all ES before starting to mux
stream_out_standard debug: using `http{mime=multipart/x-mixed-replace; boundary=Ipcam}/mpjpeg://:13860/videostream.cgi'
main debug: using sout stream module "stream_out_standard"
main debug: stream=`transcode'
main debug: looking for sout stream module matching "transcode": 23 candidates
lua debug: skipping script (unmatched scope) C:\xxxx\\VLC\lua\meta\art\00_musicbrainz.luac
lua debug: Trying Lua playlist script C:\xxxx\\VLC\lua\meta\art\01_googleimage.luac
main debug: set config option: sout-transcode-vcodec to mjpg
main debug: set config option: sout-transcode-vb to 100
main debug: set config option: sout-transcode-venc to ffmpeg{vt=8000000}
main debug: set config option: sout-transcode-scale to 1
main debug: set config option: sout-transcode-fps to 2
main debug: set config option: sout-transcode-acodec to copy
stream_out_transcode debug: Checking codec mapping for copy got copy
stream_out_transcode debug: codec audio=copy 0Hz 0 channels 96Kb/s
stream_out_transcode debug: Checking video codec mapping for mjpg got MJPG
stream_out_transcode debug: codec video=MJPG 0x0 scaling: 1.000000 100kb/s
main debug: using sout stream module "stream_out_transcode"
main debug: using timeshift granularity of 50 MiB
main debug: using timeshift path: C:\Users\xxxx\AppData\Local\Temp
main debug: `rtsp://me:mypwd@192.168.0.85:554/videoSub' gives access `rtsp' demux `any' path `me:mypwd@192.168.0.85:554/videoSub'
main debug: creating demux: access='rtsp' demux='any' location='me:mypwd@192.168.0.85:554/videoSub' file='\\me:mypwd@192.168.0.85:554\videoSub'
main debug: looking for access_demux module matching "rtsp": 15 candidates
lua debug: skipping script (unmatched scope) C:\xxxx\\VLC\lua\meta\art\01_googleimage.luac
lua debug: Trying Lua playlist script C:\xxxx\\VLC\lua\meta\art\02_frenchtv.luac
live555 debug: version 2016.11.28
lua debug: skipping script (unmatched scope) C:\xxxx\\VLC\lua\meta\art\02_frenchtv.luac
lua debug: Trying Lua playlist script C:\xxxx\\VLC\lua\meta\art\03_lastfm.luac
main warning: Password in a URI is DEPRECATED
lua debug: skipping script (unmatched scope) C:\xxxx\\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\xxxx\AppData\Roaming\vlc\lua\meta\fetcher
lua debug: Trying Lua scripts in C:\xxxx\\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\xxxx\AppData\Roaming\vlc\lua\meta\art
lua debug: Trying Lua scripts in C:\xxxx\\VLC\lua\meta\art
lua debug: Trying Lua playlist script C:\xxxx\\VLC\lua\meta\art\00_musicbrainz.luac
lua debug: Trying Lua playlist script C:\xxxx\\VLC\lua\meta\art\01_googleimage.luac
lua debug: Trying Lua playlist script C:\xxxx\\VLC\lua\meta\art\02_frenchtv.luac
lua debug: Trying Lua playlist script C:\xxxx\\VLC\lua\meta\art\03_lastfm.luac
main debug: no art finder modules matched
live555 debug: RTP subsession 'video/H264'
main debug: selecting program id=0
live555 debug: RTP subsession 'audio/PCMU'
live555 debug: setup start: 0.000000 stop:0.000000
live555 debug: We have a timeout of 60 seconds
live555 debug: play start: 0.000000 stop:0.000000
main debug: using access_demux module "live555"
main debug: looking for packetizer module matching "any": 24 candidates
h264 debug: found NAL_SPS (sps_id=0)
h264 debug: found NAL_PPS (pps_id=0 sps_id=0)
main debug: using packetizer module "h264"
main debug: looking for packetizer module matching "any": 24 candidates
main debug: using packetizer module "copy"
main debug: starting in async mode
main debug: looking for meta reader module matching "any": 2 candidates
lua debug: Trying Lua scripts in C:\Users\xxxx\AppData\Roaming\vlc\lua\meta\reader
lua debug: Trying Lua scripts in C:\xxxx\\VLC\lua\meta\reader
lua debug: Trying Lua playlist script C:\xxxx\\VLC\lua\meta\reader\filename.luac
main debug: no meta reader modules matched
main debug: `rtsp://me:mypwd@192.168.0.85:554/videoSub' successfully opened
main debug: switching to sync mode
main debug: Buffering 0%
main debug: adding a new sout input for `mlaw` (sout_input: 000002181dd681c0)
stream_out_transcode debug: creating audio transcoding from fcc=`mlaw' to fcc=`copy'
main debug: looking for audio decoder module matching "any": 23 candidates
g711 debug: samplerate:8000Hz channels:1
main debug: using audio decoder module "g711"
main debug: looking for encoder module matching "any": 23 candidates
avcodec debug: using ffmpeg Lavc58.6.103
avcodec debug: CPU flags: 0x000fd3db
main debug: no encoder modules matched
stream_out_transcode error: cannot find audio encoder (module:any fourcc:copy). Take a look few lines earlier to see possible reason.
main debug: removing module "g711"
stream_out_transcode error: cannot create audio chain
main warning: new sout input failed (sout_input: 000002181dd681c0)
main error: cannot create packetizer output (mlaw)
main debug: Buffering 98%
main debug: Buffering 99%
main debug: Stream buffering done (229 ms in 216 ms)
main error: buffer deadlock prevented
main error: buffer deadlock prevented
main debug: Decoder wait done in 0 ms
main debug: adding a new sout input for `h264` (sout_input: 000002181dd684c0)
stream_out_transcode debug: creating video transcoding from fcc=`h264' to fcc=`MJPG'
main debug: looking for video decoder module matching "any": 17 candidates
avcodec debug: using ffmpeg Lavc58.6.103
avcodec debug: CPU flags: 0x000fd3db
avcodec debug: allowing 5 thread(s) for decoding
avcodec debug: codec (h264) started
avcodec debug: using frame thread mode with 5 threads
main debug: using video decoder module "avcodec"
main debug: looking for encoder module matching "ffmpeg": 23 candidates
avcodec debug: using ffmpeg Lavc58.6.103
avcodec debug: CPU flags: 0x000fd3db
main debug: set config option: sout-avcodec-vt to 8000000
avcodec debug: Time base for probing set to 1000/25000
avcodec debug: Time base set to 1000/25000
avcodec debug: rc buffer size 400000 bits
avcodec error: Unknown option "rc_buffer_aggressivity"
avcodec debug: found encoder Motion JPEG Video
main debug: using encoder module "avcodec"
main debug: removing module "avcodec"
avcodec debug: available hardware decoder output format 119 (cuda)
avcodec debug: available hardware decoder output format 53 (dxva2_vld)
avcodec debug: available hardware decoder output format 118 (d3d11va_vld)
avcodec debug: available hardware decoder output format 174 (d3d11)
avcodec debug: available software decoder output format 0 (yuv420p)
avcodec debug: trying format d3d11va_vld
stream_out_transcode debug: Checking if filter chain DX11 -> J420 is possible
main debug: looking for video converter module matching "any": 24 candidates
chain debug: Trying to use chroma I420 as middle man
main debug: looking for video converter module matching "any": 24 candidates
main debug: using video converter module "d3d11_filters"
main debug: Filter 'd3d11_filters' (000002181de38b20) appended to chain
main debug: looking for video converter module matching "any": 24 candidates
swscale debug: 320x240 (320x240) chroma: I420 -> 320x240 (320x240) chroma: J420 with scaling using Bicubic (good quality)
main debug: using video converter module "swscale"
main debug: Filter 'Swscale' (000002181de387b0) appended to chain
main debug: using video converter module "chain"
main debug: Filter 'chain' (000002181de39200) appended to chain
main debug: removing module "chain"
main debug: removing module "d3d11_filters"
main debug: Filter 000002181de38b20 removed from chain
main debug: removing module "swscale"
main debug: Filter 000002181de387b0 removed from chain
main debug: Filter 000002181de39200 removed from chain
stream_out_transcode debug: Filter chain testing done, input chroma DX11 seems to be possible for transcode
main debug: looking for hw decoder module matching "any": 2 candidates
d3d11va debug: Created the D3D11 device type 1 level b100.
d3d11va debug: Intel WDDM driver 22.20.16.4836
d3d11va debug: CreateDevice succeed
d3d11va debug: - 'MPEG-2 variable-length decoder' is supported
d3d11va debug: - 'MPEG-2 inverse discrete cosine transform' is supported
d3d11va debug: - 'VC-1 variable-length decoder' is supported
d3d11va debug: - 'VC-1 variable-length decoder 2 (Intel)' is supported
d3d11va debug: - 'VC-1 variable-length decoder (Intel)' is supported
d3d11va debug: - 'Windows Media Video 9 IDCT' is supported
d3d11va debug: - 'VC-1 inverse discrete cosine transform' is supported
d3d11va debug: - 'H.264 variable-length decoder, no film grain technology' is supported
d3d11va debug: - 'H.264 stereo high profile, mbs flag set' is supported
d3d11va debug: - 'H.264 stereo high profile' is supported
d3d11va debug: - 'H.264 multiview high profile' is supported
d3d11va debug: - 'Unknown decoder 0x91cd2d6e-0x897b-0x4fa1-0xb0d751dc88010e0a' is supported
d3d11va debug: - 'VP8' is supported
d3d11va debug: - 'Unknown decoder 0x442b942a-0xb4d9-0x4940-0xbc45a882e5f919f3' is supported
d3d11va debug: - 'Unknown decoder 0x97688186-0x56a8-0x4094-0xb543fc9daaa49f4b' is supported
d3d11va debug: - 'Unknown decoder 0x1424d4dc-0x7cf5-0x4bb1-0x9cd7b63717a72a6b' is supported
d3d11va debug: - 'Unknown decoder 0xc346e8a3-0xcbed-0x4d27-0x87cca70eb4dc8c27' is supported
d3d11va debug: - 'Unknown decoder 0xffc79924-0x5eaf-0x4666-0xa73606190f281443' is supported
d3d11va debug: - 'Unknown decoder 0xf416f7bd-0x098a-0x4cf1-0xa11bce54959ca03d' is supported
d3d11va debug: - 'Unknown decoder 0xbf44dacd-0x217f-0x4370-0xa383d573bc56707e' is supported
d3d11va debug: - 'Unknown decoder 0x2364d06a-0xf67f-0x4186-0xaed062b99e1784f1' is supported
d3d11va debug: - 'Unknown decoder 0x464bdb3c-0x91c4-0x4e9b-0x896f225496ac4ed6' is supported
d3d11va debug: - 'Unknown decoder 0x28566328-0xf041-0x4466-0x8b148f5831e78f8b' is supported
d3d11va debug: - 'Unknown decoder 0x6b4a94db-0x54fe-0x4ae1-0x9be47a7dad004600' is supported
d3d11va debug: - 'Unknown decoder 0x8c56eb1e-0x2b47-0x466f-0x8d337dbcd63f3df2' is supported
d3d11va debug: - 'HEVC Main profile' is supported
d3d11va debug: - 'Unknown decoder 0x75fc75f7-0xc589-0x4a07-0xa25b72e03b0383b3' is supported
d3d11va debug: - 'HEVC Main 10 profile' is supported
d3d11va debug: - 'VP9 profile 0' is supported
d3d11va debug: - 'VP9 profile 2' is supported
d3d11va debug: - 'VP9 profile Intel' is supported
d3d11va debug: - 'Unknown decoder 0x80a3a7bd-0x89d8-0x4497-0xa2b82126af7e6eb8' is supported
d3d11va debug: - 'Unknown decoder 0x50925b7b-0xe931-0x4978-0xa12a586630f095f9' is supported
d3d11va debug: - 'Unknown decoder 0x49761bec-0x4b63-0x4349-0xa5ff87ffdf088466' is supported
d3d11va debug: Trying to use 'H.264 variable-length decoder, no film grain technology' as input
d3d11va debug: NV12 output is supported for decoder H.264 variable-length decoder, no film grain technology.
d3d11va debug: Using output format NV12 for decoder H.264 variable-length decoder, no film grain technology
d3d11va debug: va_pool_SetupDecoder id 27 320x240 count: 23
d3d11va debug: ID3D11VideoDecoderOutputView succeed with 23 surfaces (320x240)
d3d11va debug: we got 6 decoder configurations
d3d11va debug: configuration[0] ConfigBitstreamRaw 2
d3d11va debug: configuration[1] ConfigBitstreamRaw 1
d3d11va debug: configuration[2] ConfigBitstreamRaw 2
d3d11va debug: configuration[3] ConfigBitstreamRaw 2
d3d11va debug: configuration[4] ConfigBitstreamRaw 1
d3d11va debug: configuration[5] ConfigBitstreamRaw 1
d3d11va debug: DxCreateDecoderSurfaces succeed
main debug: using hw decoder module "d3d11va"
avcodec: Using D3D11VA (Intel(R) HD Graphics 620, vendor 32902(Intel), device 22806, revision 2) for hardware decoding
stream_out_transcode debug: source fps 0/0, destination 2/1
stream_out_transcode debug: decoder aspect is 1.333333:1
stream_out_transcode debug: source pixel aspect is 1.000000:1
stream_out_transcode debug: scaled pixel aspect is 1.000000:1
stream_out_transcode debug: source 320x240, destination 320x240
stream_out_transcode debug: encoder aspect is 320:240
stream_out_transcode debug: source chroma: DX11, destination J420
main debug: looking for video filter module matching "fps": 46 candidates
fps debug: Converting fps from 0/0 -> 2/1
main debug: using video filter module "fps"
main debug: Filter 'fps' (000002181de39c50) appended to chain
main debug: looking for video converter module matching "any": 24 candidates
chain debug: Trying to use chroma I420 as middle man
main debug: looking for video converter module matching "any": 24 candidates
main debug: using video converter module "d3d11_filters"
main debug: Filter 'd3d11_filters' (000002181de398e0) appended to chain
main debug: looking for video converter module matching "any": 24 candidates
swscale debug: 320x240 (320x240) chroma: I420 -> 320x240 (320x240) chroma: J420 with scaling using Bicubic (good quality)
main debug: using video converter module "swscale"
main debug: Filter 'Swscale' (000002181de38b20) appended to chain
main debug: using video converter module "chain"
main debug: Filter 'chain' (000002181de39200) appended to chain
stream_out_transcode debug: destination (after video filters) 320x240
main debug: looking for encoder module matching "ffmpeg": 23 candidates
avcodec debug: using ffmpeg Lavc58.6.103
avcodec debug: CPU flags: 0x000fd3db
main debug: set config option: sout-avcodec-vt to 8000000
avcodec debug: Time base for probing set to 1/2
avcodec debug: Time base set to 1/2
avcodec debug: rc buffer size 400000 bits
avcodec error: Unknown option "rc_buffer_aggressivity"
avcodec debug: found encoder Motion JPEG Video
main debug: using encoder module "avcodec"
main debug: adding a new input
mpjpeg debug: adding input
fps debug: Resetting timestamps
main error: ES_OUT_SET_(GROUP_)PCR is called too late (pts_delay increased to 100 ms)
main debug: ES_OUT_RESET_PCR called
main debug: Buffering 0%
main debug: Buffering 46%
main debug: Stream buffering done (121 ms in 119 ms)
main error: buffer deadlock prevented
main error: buffer deadlock prevented
main debug: Decoder wait done in 0 ms
main error: ES_OUT_SET_(GROUP_)PCR is called too late (pts_delay increased to 111 ms)
main debug: ES_OUT_RESET_PCR called
main debug: Buffering 0%
main debug: Buffering 50%
main debug: Stream buffering done (152 ms in 159 ms)
main error: buffer deadlock prevented
main error: buffer deadlock prevented
main debug: Decoder wait done in 0 ms
main error: ES_OUT_SET_(GROUP_)PCR is called too late (pts_delay increased to 114 ms)
main debug: ES_OUT_RESET_PCR called
main debug: Buffering 0%
main debug: Buffering 57%
main debug: Stream buffering done (229 ms in 218 ms)
main error: buffer deadlock prevented
main error: buffer deadlock prevented
main debug: Decoder wait done in 0 ms
fps debug: Resetting timestamps
main error: ES_OUT_SET_(GROUP_)PCR is called too late (pts_delay increased to 132 ms)
main debug: ES_OUT_RESET_PCR called
main debug: Buffering 0%
main debug: Buffering 43%
main debug: Buffering 92%
main debug: Buffering 99%
main debug: Stream buffering done (223 ms in 245 ms)
main error: buffer deadlock prevented
main error: buffe