Invalid chain?
Posted: 07 Jul 2010 20:11
Hello, I'm using MediaTomb to stream things to my DirecTV receiver. So far it's worked pretty well, aside from the rampant bugs of variable bitrate.
However, when I try to stream .flv files, MediaTomb uses VLC to transcode instead of ffmpeg like it ordinarily does. I'm not sure if there's a big difference, but if it uses that, it must know what it's doing.
Here's exactly what it executes:
I added the -vvv parameter to try and figure out what's wrong. It keeps complaining of an invalid chain, and as far as I've researched that means the parameters are wrong. Here's the -vvv output:
However, when I try to stream .flv files, MediaTomb uses VLC to transcode instead of ffmpeg like it ordinarily does. I'm not sure if there's a big difference, but if it uses that, it must know what it's doing.
Here's exactly what it executes:
Code: Select all
vlc -vvv -I dummy %in
--sout #transcode{vcodec=mp2v,vb=4096,canvas-width=448,canvas-height=252,
acodec=mpga,ab=64,samplerate=44100,channels=1}:standard{access=file,
mux=ts,dst=%out} vlc://quitCode: Select all
2010-07-07 14:02:36 INFO: Arguments: -vvv -I dummy %in --sout #transcode{vcodec=mp2v,vb=4096,canvas-width=448,canvas-height=252, acodec=mpga,ab=64,samplerate=44100,channels=1}:standard{access=file, mux=ts,dst=%out} vlc://quit
VLC media player 1.0.6 Goldeneye
[0x1b6c4b8] main libvlc debug: VLC media player - version 1.0.6 Goldeneye - (c) 1996-2010 the VideoLAN team
[0x1b6c4b8] main libvlc debug: libvlc was configured with ./configure '--build=x86_64-linux-gnu' '--config-cache' '--disable-maintainer-mode' '--disable-update-check' '--enable-fast-install' '--enable-release' '--prefix=/usr' '--with-binary-version=1ubuntu1.1' '--disable-atmo' '--disable-fluidsynth' '--disable-gnomevfs' '--disable-kate' '--disable-mtp' '--enable-x264' '--disable-zvbi' '--enable-a52' '--enable-aa' '--enable-bonjour' '--enable-caca' '--enable-dca' '--enable-dvb' '--enable-dvbpsi' '--enable-dvdnav' '--enable-faad' '--enable-flac' '--enable-freetype' '--enable-fribidi' '--enable-ggi' '--enable-gnutls' '--enable-jack' '--enable-libass' '--enable-libmpeg2' '--enable-lirc' '--enable-live555' '--enable-mad' '--enable-mkv' '--enable-mod' '--enable-mozilla' '--enable-mpc' '--enable-ncurses' '--enable-notify' '--enable-ogg' '--enable-pulse' '--enable-qt4' '--enable-realrtsp' '--enable-sdl' '--enable-shout' '--enable-skins2' '--enable-smb' '--enable-speex' '--enable-svg' '--enable-taglib' '--enable-telx' '--enable-theora' '--enable-twolame' '--enable-vcd' '--enable-vcdx' '--enable-vorbis' '--with-mozilla-pkg=libxul' '--enable-alsa' '--enable-dv' '--enable-pvr' '--enable-v4l' '--enable-v4l2' '--enable-svgalib' 'build_alias=x86_64-linux-gnu' 'CFLAGS=-g -O2' 'LDFLAGS=-Wl,--as-needed' 'CPPFLAGS=' 'CXXFLAGS=-g -O2'
[0x1b6c4b8] main libvlc debug: translation test: code is "C"
[0x1b6c4b8] main libvlc debug: checking plugin modules
[0x1b6c4b8] main libvlc debug: loading plugins cache file /home/trev/.cache/vlc/plugins-04081e.dat
[0x1b6c4b8] main libvlc debug: recursively browsing `/usr/lib/vlc'
[0x1b6c4b8] main libvlc debug: module bank initialized (383 modules)
[0x1b6c4b8] main libvlc debug: opening config file (/home/trev/.config/vlc/vlcrc)
[0x1b6c4b8] main libvlc debug: CPU has capabilities 486 586 MMX MMXEXT SSE SSE2 FPU
[0x1b6c4b8] main libvlc debug: looking for memcpy module: 3 candidates
[0x1b6c4b8] main libvlc debug: using memcpy module "memcpymmxext"
[0x1c620f8] main input debug: Creating an input for 'Media Library'
[0x1c620f8] main input debug: Input is a meta file: disabling unneeded options
[0x1c620f8] main input debug: using timeshift granularity of 50 MBytes
[0x1c620f8] main input debug: using timeshift path '/tmp'
[0x1c620f8] main input debug: `file/xspf-open:///home/trev/.local/share/vlc/ml.xspf' gives access `file' demux `xspf-open' path `/home/trev/.local/share/vlc/ml.xspf'
[0x1c620f8] main input debug: creating demux: access='file' demux='xspf-open' path='/home/trev/.local/share/vlc/ml.xspf'
[0x1c6bf78] main demux debug: looking for access_demux module: 1 candidate
[0x1c6bf78] main demux warning: no access_demux module matching "file" could be loaded
[0x1c6bf78] main demux debug: TIMER module_need() : 0.780 ms - Total 0.780 ms / 1 intvls (Avg 0.780 ms)
[0x1c620f8] main input debug: creating access 'file' path='/home/trev/.local/share/vlc/ml.xspf'
[0x1c7c368] main access debug: looking for access module: 3 candidates
[0x1c7c368] access_file access debug: opening file `/home/trev/.local/share/vlc/ml.xspf'
[0x1c7c368] main access debug: using access module "access_file"
[0x1c7c368] main access debug: TIMER module_need() : 0.904 ms - Total 0.904 ms / 1 intvls (Avg 0.904 ms)
[0x1c7bf08] main stream debug: Using AStream*Stream
[0x1c7bf08] main stream debug: pre buffering
[0x1c7bf08] main stream debug: received first data after 0 ms
[0x1c7bf08] main stream debug: pre-buffering done 296 bytes in 0s - 16059 kbytes/s
[0x1c7b338] main stream debug: looking for stream_filter module: 5 candidates
[0x1c7b338] main stream debug: TIMER module_need() : 0.549 ms - Total 0.549 ms / 1 intvls (Avg 0.549 ms)
[0x1c80618] main stream debug: looking for stream_filter module: 1 candidate
[0x1c80618] main stream debug: using stream_filter module "stream_filter_record"
[0x1c80618] main stream debug: TIMER module_need() : 0.173 ms - Total 0.173 ms / 1 intvls (Avg 0.173 ms)
[0x1c620f8] main input debug: creating demux: access='file' demux='xspf-open' path='/home/trev/.local/share/vlc/ml.xspf'
[0x1c7f018] main demux debug: looking for demux module: 1 candidate
[0x1c7f018] playlist demux debug: using XSPF playlist reader
[0x1c7f018] main demux debug: using demux module "playlist"
[0x1c7f018] main demux debug: TIMER module_need() : 0.271 ms - Total 0.271 ms / 1 intvls (Avg 0.271 ms)
[0x1c620f8] main input debug: `file/xspf-open:///home/trev/.local/share/vlc/ml.xspf' successfully opened
[0x1c7ee18] main xml debug: looking for xml module: 2 candidates
[0x1c7ee18] main xml debug: using xml module "xml"
[0x1c7ee18] main xml debug: TIMER module_need() : 0.594 ms - Total 0.594 ms / 1 intvls (Avg 0.594 ms)
[0x1c7f018] playlist demux debug: parsed 0 tracks successfully
[0x1c7ee18] main xml debug: removing module "xml"
[0x1c620f8] main input debug: EOF reached
[0x1c7f018] main demux debug: removing module "playlist"
[0x1c80618] main stream debug: removing module "stream_filter_record"
[0x1c7c368] main access debug: removing module "access_file"
[0x1c620f8] main input debug: TIMER input launching for 'Media Library' : 6.607 ms - Total 6.607 ms / 1 intvls (Avg 6.607 ms)
[0x1c63478] main playlist debug: Activated
[0x1c7bf08] main interface debug: looking for interface module: 1 candidate
[0x1c7bf08] main interface debug: using interface module "hotkeys"
[0x1c7bf08] main interface debug: TIMER module_need() : 0.375 ms - Total 0.375 ms / 1 intvls (Avg 0.375 ms)
[0x1c7bf08] main interface debug: thread (interface) created at priority 0 (interface/interface.c:151)
[0x1c7c038] main interface debug: looking for interface module: 1 candidate
[0x1c7c038] main interface debug: using interface module "inhibit"
[0x1c7c038] main interface debug: TIMER module_need() : 3.183 ms - Total 3.183 ms / 1 intvls (Avg 3.183 ms)
[0x1c7c038] main interface debug: thread (interface) created at priority 0 (interface/interface.c:151)
[0x1c89f88] main interface debug: looking for interface module: 1 candidate
[0x1c89f88] main interface debug: using interface module "screensaver"
[0x1c89f88] main interface debug: TIMER module_need() : 0.289 ms - Total 0.289 ms / 1 intvls (Avg 0.289 ms)
[0x1c89f88] main interface debug: thread (interface) created at priority 0 (interface/interface.c:151)
[0x1c63478] main playlist debug: adding item `quit' ( vlc://quit )
[0x1c63478] main playlist debug: adding item `mt_transcode_MFLUFV}' ( mux=ts,dst=/tmp/mt_transcode_MFLUFV} )
[0x1c63478] main playlist debug: adding item `acodec=mpga,ab=64,samplerate=44100,channels=1}' ( acodec=mpga,ab=64,samplerate=44100,channels=1}:standard{access=file, )
[0x1c63478] main playlist debug: adding item `Moreaway - Dawn Original' ( /home/trev/Videos/Music/Moreaway - Dawn Original )
[0x1c81ce8] main interface debug: looking for interface module: 1 candidate
[0x1c81ce8] main interface debug: using interface module "signals"
[0x1c81ce8] main interface debug: TIMER module_need() : 0.330 ms - Total 0.330 ms / 1 intvls (Avg 0.330 ms)
[0x1c81ce8] main interface debug: thread (interface) created at priority 0 (interface/interface.c:151)
[0x1c83488] main interface debug: looking for interface module: 1 candidate
[0x1c63478] main playlist debug: rebuilding array of current - root Playlist
[0x1c63478] main playlist debug: rebuild done - 4 items, index -1
[0x1c7bf08] main interface debug: thread started
[0x1c81ce8] main interface debug: thread started
[0x1c81ce8] main interface debug: thread ended
[0x1c89f88] main interface debug: thread started
[0x1c7c038] main interface debug: thread started
[0x1c83488] main interface debug: using interface module "globalhotkeys"
[0x1c83488] main interface debug: TIMER module_need() : 46.875 ms - Total 46.875 ms / 1 intvls (Avg 46.875 ms)
[0x1c83488] main interface debug: thread (interface) created at priority 0 (interface/interface.c:151)
[0x1c88a88] main interface debug: looking for interface module: 1 candidate
[0x1c88a88] dummy interface: using the dummy interface module...
[0x1c88a88] main interface debug: using interface module "dummy"
[0x1c88a88] main interface debug: TIMER module_need() : 0.369 ms - Total 0.369 ms / 1 intvls (Avg 0.369 ms)
[0x1c88a88] main interface debug: thread (interface) created at priority 0 (interface/interface.c:151)
[0x1c88a88] main interface debug: thread started
[0x1c88a88] main interface debug: thread ended
[0x1c63478] main playlist debug: processing request item null node Playlist skip 0
[0x1c63478] main playlist debug: starting new item
[0x1c63478] main playlist debug: creating new input thread
[0x1c85aa8] main input debug: Creating an input for 'Moreaway - Dawn Original'
[0x1c83488] main interface debug: thread started
[0x1c83488] main interface debug: thread ended
[0x1c85aa8] main input debug: thread (input) created at priority 10 (input/input.c:230)
[0x1c85aa8] main input debug: thread started
[0x1c942d8] main stream output debug: stream=`transcode'
[0x1c94f38] main stream out debug: looking for sout stream module: 1 candidate
[0x1c942d8] main stream output error: invalid chain
[0x1c94f38] stream_out_transcode stream out error: cannot create chain
[0x1c94f38] main stream out warning: no sout stream module matching "transcode" could be loaded
[0x1c94f38] main stream out debug: TIMER module_need() : 0.532 ms - Total 0.532 ms / 1 intvls (Avg 0.532 ms)
[0x1c94f38] main stream out debug: destroying chain... (name=transcode)
[0x1c94f38] main stream out debug: destroying chain done
[0x1c942d8] main stream output error: stream chain failed for `transcode{vcodec=mp2v,vb=4096,canvas-width=448,canvas-height=252,'
[0x1c63478] main playlist debug: finished input
[0x1c85aa8] main input error: cannot start stream output instance, aborting
[0x1c63478] main playlist debug: dead input
[0x1c85aa8] main input debug: thread ended
[0x1c85aa8] main input debug: TIMER input launching for 'Moreaway - Dawn Original' : 10.963 ms - Total 10.963 ms / 1 intvls (Avg 10.963 ms)
[0x1c63478] main playlist debug: changing item without a request (current 0/4)
[0x1c63478] main playlist debug: using item 1
[0x1c63478] main playlist debug: starting new item
[0x1c63478] main playlist debug: creating new input thread
[0x1c85aa8] main input debug: Creating an input for 'acodec=mpga,ab=64,samplerate=44100,channels=1}'
[0x1c85aa8] main input debug: thread (input) created at priority 10 (input/input.c:230)
[0x1c85aa8] main input debug: thread started
[0x1c86238] main stream output debug: stream=`transcode'
[0x1c86388] main stream out debug: looking for sout stream module: 1 candidate
[0x1c86238] main stream output error: invalid chain
[0x1c86388] stream_out_transcode stream out error: cannot create chain
[0x1c86388] main stream out warning: no sout stream module matching "transcode" could be loaded
[0x1c86388] main stream out debug: TIMER module_need() : 0.148 ms - Total 0.148 ms / 1 intvls (Avg 0.148 ms)
[0x1c86388] main stream out debug: destroying chain... (name=transcode)
[0x1c86388] main stream out debug: destroying chain done
[0x1c86238] main stream output error: stream chain failed for `transcode{vcodec=mp2v,vb=4096,canvas-width=448,canvas-height=252,'
[0x1c63478] main playlist debug: finished input
[0x1c85aa8] main input error: cannot start stream output instance, aborting
[0x1c63478] main playlist debug: dead input
[0x1c85aa8] main input debug: thread ended
[0x1c85aa8] main input debug: TIMER input launching for 'acodec=mpga,ab=64,samplerate=44100,channels=1}' : 10.651 ms - Total 10.651 ms / 1 intvls (Avg 10.651 ms)
[0x1c63478] main playlist debug: changing item without a request (current 1/4)
[0x1c63478] main playlist debug: using item 2
[0x1c63478] main playlist debug: starting new item
[0x1c63478] main playlist debug: creating new input thread
[0x1c95118] main input debug: Creating an input for 'mt_transcode_MFLUFV}'
[0x1c95118] main input debug: thread (input) created at priority 10 (input/input.c:230)
[0x1c95118] main input debug: thread started
[0x1c94b78] main stream output debug: stream=`transcode'
[0x1c94cc8] main stream out debug: looking for sout stream module: 1 candidate
[0x1c94b78] main stream output error: invalid chain
[0x1c94cc8] stream_out_transcode stream out error: cannot create chain
[0x1c94cc8] main stream out warning: no sout stream module matching "transcode" could be loaded
[0x1c94cc8] main stream out debug: TIMER module_need() : 0.132 ms - Total 0.132 ms / 1 intvls (Avg 0.132 ms)
[0x1c94cc8] main stream out debug: destroying chain... (name=transcode)
[0x1c94cc8] main stream out debug: destroying chain done
[0x1c94b78] main stream output error: stream chain failed for `transcode{vcodec=mp2v,vb=4096,canvas-width=448,canvas-height=252,'
[0x1c63478] main playlist debug: finished input
[0x1c95118] main input error: cannot start stream output instance, aborting
[0x1c63478] main playlist debug: dead input
[0x1c95118] main input debug: thread ended
[0x1c95118] main input debug: TIMER input launching for 'mt_transcode_MFLUFV}' : 6.086 ms - Total 6.086 ms / 1 intvls (Avg 6.086 ms)
[0x1c63478] main playlist debug: changing item without a request (current 2/4)
[0x1c63478] main playlist debug: using item 3
[0x1c63478] main playlist debug: starting new item
[0x1c63478] main playlist debug: creating new input thread
[0x1c85a78] main input debug: Creating an input for 'quit'
[0x1c85a78] main input debug: thread (input) created at priority 10 (input/input.c:230)
[0x1c85a78] main input debug: thread started
[0x1c85a78] main input debug: using timeshift granularity of 50 MBytes
[0x1c85a78] main input debug: using timeshift path '/tmp'
[0x1c85a78] main input debug: `vlc://quit' gives access `vlc' demux `' path `quit'
[0x1c85a78] main input debug: creating demux: access='vlc' demux='' path='quit'
[0x1c95988] main demux debug: looking for access_demux module: 0 candidates
[0x1c95988] main demux debug: no access_demux module matched "vlc"
[0x1c95988] main demux debug: TIMER module_need() : 0.128 ms - Total 0.128 ms / 1 intvls (Avg 0.128 ms)
[0x1c85a78] main input debug: creating access 'vlc' path='quit'
[0x1c948a8] main access debug: looking for access module: 1 candidate
[0x1c948a8] main access debug: using access module "dummy"
[0x1c948a8] main access debug: TIMER module_need() : 0.098 ms - Total 0.098 ms / 1 intvls (Avg 0.098 ms)
[0x1c95a18] main stream debug: Using AStream*Stream
[0x1c95a18] main stream debug: pre buffering
[0x1c95a18] main stream debug: received first data after 0 ms
[0x1c95a18] main stream debug: pre-buffering done 1024 bytes in 0s - 55555 kbytes/s
[0x1c94ca8] main stream debug: looking for stream_filter module: 5 candidates
[0x1c94ca8] main stream debug: TIMER module_need() : 0.176 ms - Total 0.176 ms / 1 intvls (Avg 0.176 ms)
[0x1c94b68] main stream debug: looking for stream_filter module: 1 candidate
[0x1c94b68] main stream debug: using stream_filter module "stream_filter_record"
[0x1c94b68] main stream debug: TIMER module_need() : 0.090 ms - Total 0.090 ms / 1 intvls (Avg 0.090 ms)
[0x1c85a78] main input debug: creating demux: access='vlc' demux='vlc' path='quit'
[0x1c94ff8] main demux debug: looking for demux module: 1 candidate
[0x1c94ff8] dummy demux: command `quit'
[0x1c94ff8] main demux debug: using demux module "dummy"
[0x1c94ff8] main demux debug: TIMER module_need() : 0.129 ms - Total 0.129 ms / 1 intvls (Avg 0.129 ms)
[0x1c85a78] main input debug: `vlc://quit' successfully opened
[0x1b6c4b8] main libvlc debug: deactivating the playlist
[0x1c63478] main playlist debug: Deactivate
[0x1c63478] main playlist debug: incoming request - stopping current input
[0x1c63478] main playlist debug: dying input
[0x1c85a78] main input debug: EOF reached
[0x1c85a78] main input debug: control type=0
[0x1c85a78] main input debug: control: stopping input
[0x1c63478] main playlist debug: dying input
[0x1c94ff8] main demux debug: removing module "dummy"
[0x1c94b68] main stream debug: removing module "stream_filter_record"
[0x1c948a8] main access debug: removing module "dummy"
[0x1c63478] main playlist debug: dead input
[0x1c85a78] main input debug: thread ended
[0x1c85a78] main input debug: TIMER input launching for 'quit' : 21.517 ms - Total 21.517 ms / 1 intvls (Avg 21.517 ms)
[0x1c63478] main playlist debug: saving Media Library to file /home/trev/.local/share/vlc/ml.xspf
[0x1c63478] main playlist debug: looking for playlist export module: 1 candidate
[0x1c63478] main playlist debug: using playlist export module "export"
[0x1c63478] main playlist debug: TIMER module_need() : 0.308 ms - Total 0.308 ms / 1 intvls (Avg 0.308 ms)
[0x1c63478] main playlist debug: removing module "export"
[0x1c63478] main playlist debug: Deactivated
[0x1b6c4b8] main libvlc debug: removing all services discovery tasks
[0x1b6c4b8] main libvlc debug: removing all interfaces
[0x1c88a88] main interface debug: removing module "dummy"
[0x1c83488] main interface debug: removing module "globalhotkeys"
[0x1c81ce8] main interface debug: removing module "signals"
[0x1c89f88] main interface debug: removing module "screensaver"
[0x1c7c038] main interface debug: removing module "inhibit"
[0x1c7bf08] main interface debug: removing module "hotkeys"
[0x1b6c4b8] main libvlc debug: removing playlist
[0x1c63478] main playlist debug: Destroyed
[0x1b6c4b8] main libvlc debug: TIMER ML Load : Total 10.430 ms / 1 intvls (Avg 10.430 ms)
[0x1b6c4b8] main libvlc debug: TIMER Items array build : Total 0.049 ms / 1 intvls (Avg 0.049 ms)
[0x1b6c4b8] main libvlc debug: TIMER ML Dump : Total 0.549 ms / 1 intvls (Avg 0.549 ms)
[0x1b6c4b8] main libvlc debug: removing stats
[0x1b6c4b8] main libvlc debug: removing module "memcpymmxext"
[0x1b6c4b8] main libvlc debug: opening config file (/home/trev/.config/vlc/vlcrc)
[0x1b6c4b8] main libvlc debug: writing plugins cache /home/trev/.cache/vlc/plugins-04081e.dat