3.0.0-a6 Video never gets encoded when using DTS

Developers forum for Univeral Media Server-related development (only for programmers)
Locked
Fenzor
Posts: 20
Joined: Fri Apr 12, 2013 5:03 am
Location: Trondheim, Norway

3.0.0-a6 Video never gets encoded when using DTS

Post by Fenzor »

Hi!

My problem doesn't happen in Windows build, but only in Linux build from my experience.
I have an issue that when enabling encoding of videos with DTS-audio embedded they don't create encoded data in the "/tmp/universalmediaserver"-folder.
The files are created correctly with full rwx-permissions as specified in the call using mkfifo.
But when encoding the video, the buffer-files are never filled. They stay the same with size 0. (As observed in "real-time" while playing the video, and after)
Such that when reading data this is shown: "External input stream instance is null... sounds not good, waiting 500ms" in the debug.log file.

Have scourged through some of the source code, in hope of finding the problem, but have so far not found any problems.

When making a manual call (in command line) to MEncoder, using the same parameters used in the code with the same files. The result is that the files gets filled correctly. With audio and video separated.
I am using the latest version of UMS.(as of 4. Oct. 2013)
Fenzor
Posts: 20
Joined: Fri Apr 12, 2013 5:03 am
Location: Trondheim, Norway

Re: 3.0.0-a6 Video never gets encoded when using DTS

Post by Fenzor »

Since there has been quiet for a little while now, I think I should at least add some debug logs. :)

With DTS enabled:

Code: Select all

TRACE 2013-10-09 14:47:19.086 [New I/O worker #4] Asked stream chunk : TimeRange [start=0.0, end=null] of video_withDTS.mkv and player MEncoder
DEBUG 2013-10-09 14:47:19.087 [New I/O worker #4] Starting transcode/remux of video_withDTS.mkv with media info: container: mkv, bitrate: 6861472, size: 2342964620, video codec: h264, duration: 00:45:31.00, width: 976, height: 720, frame rate: 23.976, thumb size : 1524, muxing mode: null, mime type: video/x-matroska
	Audio track id: 0, lang: en, flavor: dts, audio codec: DTS, sample frequency:48000, number of channels: 6, bits per sample: 24
	Subtitle track id: 0, type: SUBRIP, flavor: english, lang: en, externalFileCharacterSet: null
TRACE 2013-10-09 14:47:19.087 [New I/O worker #4] Don't want subtitles!
TRACE 2013-10-09 14:47:19.088 [New I/O worker #4] Audio codec "dts" failed to match support line f:mpegps|mpegts   v:mpeg1|mpeg2|mp4|h264   a:ac3|lpcm|mpa       m:video/mpeg
TRACE 2013-10-09 14:47:19.088 [New I/O worker #4] Format "mpegps" failed to match support line f:avi|divx        v:mp4|divx|mjpeg         a:mp3|lpcm|mpa|ac3   m:video/x-divx     gmc:0
TRACE 2013-10-09 14:47:19.088 [New I/O worker #4] Format "mpegps" failed to match support line f:mp4             v:mp4|h264               a:ac3                m:video/mp4
TRACE 2013-10-09 14:47:19.088 [New I/O worker #4] Format "mpegps" failed to match support line f:mp4             v:mp4|h264               a:aac                m:video/mp4                n:2
TRACE 2013-10-09 14:47:19.088 [New I/O worker #4] Format "mpegps" failed to match support line f:wmv             v:wmv|vc1                a:wma                m:video/x-ms-wmv           n:2
TRACE 2013-10-09 14:47:19.088 [New I/O worker #4] Format "mpegps" failed to match support line f:wav     a:dts          n:6   s:48000   m:audio/wav
TRACE 2013-10-09 14:47:19.088 [New I/O worker #4] Format "mpegps" failed to match support line f:wav     a:lpcm         n:6   s:48000   m:audio/l16
TRACE 2013-10-09 14:47:19.088 [New I/O worker #4] Format "mpegps" failed to match support line f:wav                    n:2   s:48000   m:audio/wav
TRACE 2013-10-09 14:47:19.088 [New I/O worker #4] Format "mpegps" failed to match support line f:mp3                    n:2             m:audio/mpeg
TRACE 2013-10-09 14:47:19.088 [New I/O worker #4] Format "mpegps" failed to match support line f:aac     a:(?!alac).+   n:2             m:audio/x-m4a
TRACE 2013-10-09 14:47:19.088 [New I/O worker #4] Format "mpegps" failed to match support line f:wma                    n:2             m:audio/x-ms-wma
TRACE 2013-10-09 14:47:19.088 [New I/O worker #4] Format "mpegps" failed to match support line f:atrac                  n:2             m:audio/x-oma
TRACE 2013-10-09 14:47:19.089 [New I/O worker #4] Format "mpegps" failed to match support line f:lpcm    a:lpcm         n:6   s:48000   m:audio/l16
TRACE 2013-10-09 14:47:19.089 [New I/O worker #4] Format "mpegps" failed to match support line f:jpg    m:image/jpeg
TRACE 2013-10-09 14:47:19.089 [New I/O worker #4] Format "mpegps" failed to match support line f:png    m:image/png
TRACE 2013-10-09 14:47:19.089 [New I/O worker #4] Format "mpegps" failed to match support line f:gif    m:image/gif
TRACE 2013-10-09 14:47:19.089 [New I/O worker #4] Format "mpegps" failed to match support line f:tiff   m:image/tiff
TRACE 2013-10-09 14:47:19.089 [New I/O worker #4] Audio codec "dts" failed to match support line f:mpegps|mpegts   v:mpeg1|mpeg2|mp4|h264   a:ac3|lpcm|mpa       m:video/mpeg
TRACE 2013-10-09 14:47:19.089 [New I/O worker #4] Format "mpegts" failed to match support line f:avi|divx        v:mp4|divx|mjpeg         a:mp3|lpcm|mpa|ac3   m:video/x-divx     gmc:0
TRACE 2013-10-09 14:47:19.089 [New I/O worker #4] Format "mpegts" failed to match support line f:mp4             v:mp4|h264               a:ac3                m:video/mp4
TRACE 2013-10-09 14:47:19.089 [New I/O worker #4] Format "mpegts" failed to match support line f:mp4             v:mp4|h264               a:aac                m:video/mp4                n:2
TRACE 2013-10-09 14:47:19.089 [New I/O worker #4] Format "mpegts" failed to match support line f:wmv             v:wmv|vc1                a:wma                m:video/x-ms-wmv           n:2
TRACE 2013-10-09 14:47:19.089 [New I/O worker #4] Format "mpegts" failed to match support line f:wav     a:dts          n:6   s:48000   m:audio/wav
TRACE 2013-10-09 14:47:19.089 [New I/O worker #4] Format "mpegts" failed to match support line f:wav     a:lpcm         n:6   s:48000   m:audio/l16
TRACE 2013-10-09 14:47:19.089 [New I/O worker #4] Format "mpegts" failed to match support line f:wav                    n:2   s:48000   m:audio/wav
TRACE 2013-10-09 14:47:19.089 [New I/O worker #4] Format "mpegts" failed to match support line f:mp3                    n:2             m:audio/mpeg
TRACE 2013-10-09 14:47:19.089 [New I/O worker #4] Format "mpegts" failed to match support line f:aac     a:(?!alac).+   n:2             m:audio/x-m4a
TRACE 2013-10-09 14:47:19.090 [New I/O worker #4] Format "mpegts" failed to match support line f:wma                    n:2             m:audio/x-ms-wma
TRACE 2013-10-09 14:47:19.090 [New I/O worker #4] Format "mpegts" failed to match support line f:atrac                  n:2             m:audio/x-oma
TRACE 2013-10-09 14:47:19.090 [New I/O worker #4] Format "mpegts" failed to match support line f:lpcm    a:lpcm         n:6   s:48000   m:audio/l16
TRACE 2013-10-09 14:47:19.090 [New I/O worker #4] Format "mpegts" failed to match support line f:jpg    m:image/jpeg
TRACE 2013-10-09 14:47:19.090 [New I/O worker #4] Format "mpegts" failed to match support line f:png    m:image/png
TRACE 2013-10-09 14:47:19.090 [New I/O worker #4] Format "mpegts" failed to match support line f:gif    m:image/gif
TRACE 2013-10-09 14:47:19.090 [New I/O worker #4] Format "mpegts" failed to match support line f:tiff   m:image/tiff
TRACE 2013-10-09 14:47:19.090 [New I/O worker #4] Matched support line f:mpegps|mpegts   v:mpeg1|mpeg2|mp4|h264   a:ac3|lpcm|mpa       m:video/mpeg
TRACE 2013-10-09 14:47:19.090 [New I/O worker #4] Matched support line f:mpegps|mpegts   v:mpeg1|mpeg2|mp4|h264   a:ac3|lpcm|mpa       m:video/mpeg
TRACE 2013-10-09 14:47:19.090 [New I/O worker #4] channels=2
DEBUG 2013-10-09 14:47:19.106 [mkfifo-18] Starting mkfifo --mode=777 /tmp/universalmediaserver/1381322839105ffmpegvideo
DEBUG 2013-10-09 14:47:19.106 [mkfifo-19] Starting mkfifo --mode=777 /tmp/universalmediaserver/1381322839105videoout
DEBUG 2013-10-09 14:47:19.108 [mkfifo-18] Unix process ID (mkfifo): 6995
DEBUG 2013-10-09 14:47:19.109 [mkfifo-19] Unix process ID (mkfifo): 6996
TRACE 2013-10-09 14:47:19.256 [New I/O worker #4] Audio codec "dts" failed to match support line f:mpegps|mpegts   v:mpeg1|mpeg2|mp4|h264   a:ac3|lpcm|mpa       m:video/mpeg
DEBUG 2013-10-09 14:47:19.256 [mencoder-17] Starting /home/larsat/ums-3.0.0-a6/mencoder -ss 0 /media/disk2/Filmer/video_withDTS.mkv -msglevel statusline=2 -nosound -of rawvideo -mpegopts format=mpeg2:muxrate=500000:vbuf_size=1194:abuf_size=64 -ovc lavc -channels 2 -lavdopts debug=0:threads=4 -lavcopts autoaspect=1:vcodec=mpeg2video:acodec=ac3:abitrate=640:threads=8:keyint=25:vqscale=1:vqmin=2:vqmax=3:vrc_maxrate=53000:vrc_buf_size=7000 -nosub -noautosub -ofps 24000/1001 -lavdopts fast -mc 0 -noskip -o /tmp/universalmediaserver/1381322839105ffmpegvideo
TRACE 2013-10-09 14:47:19.257 [New I/O worker #4] Format "mpegps" failed to match support line f:avi|divx        v:mp4|divx|mjpeg         a:mp3|lpcm|mpa|ac3   m:video/x-divx     gmc:0
TRACE 2013-10-09 14:47:19.257 [New I/O worker #4] Format "mpegps" failed to match support line f:mp4             v:mp4|h264               a:ac3                m:video/mp4
TRACE 2013-10-09 14:47:19.257 [Thread-49] Opening file /tmp/universalmediaserver/1381322839105ffmpegvideo for reading...
TRACE 2013-10-09 14:47:19.257 [New I/O worker #4] Format "mpegps" failed to match support line f:mp4             v:mp4|h264               a:aac                m:video/mp4                n:2
TRACE 2013-10-09 14:47:19.257 [New I/O worker #4] Format "mpegps" failed to match support line f:wmv             v:wmv|vc1                a:wma                m:video/x-ms-wmv           n:2
TRACE 2013-10-09 14:47:19.257 [New I/O worker #4] Format "mpegps" failed to match support line f:wav     a:dts          n:6   s:48000   m:audio/wav
TRACE 2013-10-09 14:47:19.257 [New I/O worker #4] Format "mpegps" failed to match support line f:wav     a:lpcm         n:6   s:48000   m:audio/l16
TRACE 2013-10-09 14:47:19.257 [New I/O worker #4] Format "mpegps" failed to match support line f:wav                    n:2   s:48000   m:audio/wav
TRACE 2013-10-09 14:47:19.258 [New I/O worker #4] Format "mpegps" failed to match support line f:mp3                    n:2             m:audio/mpeg
TRACE 2013-10-09 14:47:19.258 [New I/O worker #4] Format "mpegps" failed to match support line f:aac     a:(?!alac).+   n:2             m:audio/x-m4a
TRACE 2013-10-09 14:47:19.258 [New I/O worker #4] Format "mpegps" failed to match support line f:wma                    n:2             m:audio/x-ms-wma
TRACE 2013-10-09 14:47:19.258 [New I/O worker #4] Format "mpegps" failed to match support line f:atrac                  n:2             m:audio/x-oma
TRACE 2013-10-09 14:47:19.258 [New I/O worker #4] Format "mpegps" failed to match support line f:lpcm    a:lpcm         n:6   s:48000   m:audio/l16
TRACE 2013-10-09 14:47:19.258 [New I/O worker #4] Format "mpegps" failed to match support line f:jpg    m:image/jpeg
TRACE 2013-10-09 14:47:19.258 [New I/O worker #4] Format "mpegps" failed to match support line f:png    m:image/png
TRACE 2013-10-09 14:47:19.258 [New I/O worker #4] Format "mpegps" failed to match support line f:gif    m:image/gif
TRACE 2013-10-09 14:47:19.258 [New I/O worker #4] Format "mpegps" failed to match support line f:tiff   m:image/tiff
TRACE 2013-10-09 14:47:19.259 [New I/O worker #4] Audio codec "dts" failed to match support line f:mpegps|mpegts   v:mpeg1|mpeg2|mp4|h264   a:ac3|lpcm|mpa       m:video/mpeg
TRACE 2013-10-09 14:47:19.259 [New I/O worker #4] Format "mpegts" failed to match support line f:avi|divx        v:mp4|divx|mjpeg         a:mp3|lpcm|mpa|ac3   m:video/x-divx     gmc:0
TRACE 2013-10-09 14:47:19.259 [New I/O worker #4] Format "mpegts" failed to match support line f:mp4             v:mp4|h264               a:ac3                m:video/mp4
TRACE 2013-10-09 14:47:19.259 [New I/O worker #4] Format "mpegts" failed to match support line f:mp4             v:mp4|h264               a:aac                m:video/mp4                n:2
TRACE 2013-10-09 14:47:19.259 [New I/O worker #4] Format "mpegts" failed to match support line f:wmv             v:wmv|vc1                a:wma                m:video/x-ms-wmv           n:2
TRACE 2013-10-09 14:47:19.259 [New I/O worker #4] Format "mpegts" failed to match support line f:wav     a:dts          n:6   s:48000   m:audio/wav
TRACE 2013-10-09 14:47:19.259 [New I/O worker #4] Format "mpegts" failed to match support line f:wav     a:lpcm         n:6   s:48000   m:audio/l16
TRACE 2013-10-09 14:47:19.260 [New I/O worker #4] Format "mpegts" failed to match support line f:wav                    n:2   s:48000   m:audio/wav
TRACE 2013-10-09 14:47:19.260 [New I/O worker #4] Format "mpegts" failed to match support line f:mp3                    n:2             m:audio/mpeg
TRACE 2013-10-09 14:47:19.260 [New I/O worker #4] Format "mpegts" failed to match support line f:aac     a:(?!alac).+   n:2             m:audio/x-m4a
TRACE 2013-10-09 14:47:19.260 [mencoder-17] Successfully initialized buffer to 1,048,576 bytes.
TRACE 2013-10-09 14:47:19.260 [New I/O worker #4] Format "mpegts" failed to match support line f:wma                    n:2             m:audio/x-ms-wma
TRACE 2013-10-09 14:47:19.260 [New I/O worker #4] Format "mpegts" failed to match support line f:atrac                  n:2             m:audio/x-oma
DEBUG 2013-10-09 14:47:19.261 [mencoder-17] Attaching thread: mencoder-17
TRACE 2013-10-09 14:47:19.261 [New I/O worker #4] Format "mpegts" failed to match support line f:lpcm    a:lpcm         n:6   s:48000   m:audio/l16
TRACE 2013-10-09 14:47:19.261 [New I/O worker #4] Format "mpegts" failed to match support line f:jpg    m:image/jpeg
DEBUG 2013-10-09 14:47:19.261 [mencoder-17] Unix process ID (/home/larsat/ums-3.0.0-a6/mencoder): 7004
TRACE 2013-10-09 14:47:19.261 [New I/O worker #4] Format "mpegts" failed to match support line f:png    m:image/png
TRACE 2013-10-09 14:47:19.262 [New I/O worker #4] Format "mpegts" failed to match support line f:gif    m:image/gif
TRACE 2013-10-09 14:47:19.262 [New I/O worker #4] Format "mpegts" failed to match support line f:tiff   m:image/tiff
TRACE 2013-10-09 14:47:19.263 [New I/O worker #4] Audio codec "dts" failed to match support line f:mpegps|mpegts   v:mpeg1|mpeg2|mp4|h264   a:ac3|lpcm|mpa       m:video/mpeg
TRACE 2013-10-09 14:47:19.263 [New I/O worker #4] Format "mpegps" failed to match support line f:avi|divx        v:mp4|divx|mjpeg         a:mp3|lpcm|mpa|ac3   m:video/x-divx     gmc:0
TRACE 2013-10-09 14:47:19.263 [New I/O worker #4] Format "mpegps" failed to match support line f:mp4             v:mp4|h264               a:ac3                m:video/mp4
TRACE 2013-10-09 14:47:19.264 [New I/O worker #4] Format "mpegps" failed to match support line f:mp4             v:mp4|h264               a:aac                m:video/mp4                n:2
TRACE 2013-10-09 14:47:19.264 [New I/O worker #4] Format "mpegps" failed to match support line f:wmv             v:wmv|vc1                a:wma                m:video/x-ms-wmv           n:2
TRACE 2013-10-09 14:47:19.264 [New I/O worker #4] Format "mpegps" failed to match support line f:wav     a:dts          n:6   s:48000   m:audio/wav
TRACE 2013-10-09 14:47:19.264 [New I/O worker #4] Format "mpegps" failed to match support line f:wav     a:lpcm         n:6   s:48000   m:audio/l16
TRACE 2013-10-09 14:47:19.265 [New I/O worker #4] Format "mpegps" failed to match support line f:wav                    n:2   s:48000   m:audio/wav
TRACE 2013-10-09 14:47:19.265 [New I/O worker #4] Format "mpegps" failed to match support line f:mp3                    n:2             m:audio/mpeg
TRACE 2013-10-09 14:47:19.265 [New I/O worker #4] Format "mpegps" failed to match support line f:aac     a:(?!alac).+   n:2             m:audio/x-m4a
TRACE 2013-10-09 14:47:19.265 [New I/O worker #4] Format "mpegps" failed to match support line f:wma                    n:2             m:audio/x-ms-wma
TRACE 2013-10-09 14:47:19.265 [New I/O worker #4] Format "mpegps" failed to match support line f:atrac                  n:2             m:audio/x-oma
TRACE 2013-10-09 14:47:19.266 [New I/O worker #4] Format "mpegps" failed to match support line f:lpcm    a:lpcm         n:6   s:48000   m:audio/l16
TRACE 2013-10-09 14:47:19.266 [New I/O worker #4] Format "mpegps" failed to match support line f:jpg    m:image/jpeg
TRACE 2013-10-09 14:47:19.266 [New I/O worker #4] Format "mpegps" failed to match support line f:png    m:image/png
TRACE 2013-10-09 14:47:19.266 [New I/O worker #4] Format "mpegps" failed to match support line f:gif    m:image/gif
TRACE 2013-10-09 14:47:19.266 [New I/O worker #4] Format "mpegps" failed to match support line f:tiff   m:image/tiff
TRACE 2013-10-09 14:47:19.267 [New I/O worker #4] Audio codec "dts" failed to match support line f:mpegps|mpegts   v:mpeg1|mpeg2|mp4|h264   a:ac3|lpcm|mpa       m:video/mpeg
TRACE 2013-10-09 14:47:19.267 [New I/O worker #4] Format "mpegts" failed to match support line f:avi|divx        v:mp4|divx|mjpeg         a:mp3|lpcm|mpa|ac3   m:video/x-divx     gmc:0
TRACE 2013-10-09 14:47:19.267 [New I/O worker #4] Format "mpegts" failed to match support line f:mp4             v:mp4|h264               a:ac3                m:video/mp4
TRACE 2013-10-09 14:47:19.267 [New I/O worker #4] Format "mpegts" failed to match support line f:mp4             v:mp4|h264               a:aac                m:video/mp4                n:2
TRACE 2013-10-09 14:47:19.267 [New I/O worker #4] Format "mpegts" failed to match support line f:wmv             v:wmv|vc1                a:wma                m:video/x-ms-wmv           n:2
TRACE 2013-10-09 14:47:19.267 [New I/O worker #4] Format "mpegts" failed to match support line f:wav     a:dts          n:6   s:48000   m:audio/wav
TRACE 2013-10-09 14:47:19.268 [New I/O worker #4] Format "mpegts" failed to match support line f:wav     a:lpcm         n:6   s:48000   m:audio/l16
TRACE 2013-10-09 14:47:19.268 [New I/O worker #4] Format "mpegts" failed to match support line f:wav                    n:2   s:48000   m:audio/wav
TRACE 2013-10-09 14:47:19.268 [New I/O worker #4] Format "mpegts" failed to match support line f:mp3                    n:2             m:audio/mpeg
TRACE 2013-10-09 14:47:19.268 [New I/O worker #4] Format "mpegts" failed to match support line f:aac     a:(?!alac).+   n:2             m:audio/x-m4a
TRACE 2013-10-09 14:47:19.268 [New I/O worker #4] Format "mpegts" failed to match support line f:wma                    n:2             m:audio/x-ms-wma
TRACE 2013-10-09 14:47:19.268 [New I/O worker #4] Format "mpegts" failed to match support line f:atrac                  n:2             m:audio/x-oma
TRACE 2013-10-09 14:47:19.268 [New I/O worker #4] Format "mpegts" failed to match support line f:lpcm    a:lpcm         n:6   s:48000   m:audio/l16
TRACE 2013-10-09 14:47:19.268 [New I/O worker #4] Format "mpegts" failed to match support line f:jpg    m:image/jpeg
TRACE 2013-10-09 14:47:19.268 [New I/O worker #4] Format "mpegts" failed to match support line f:png    m:image/png
TRACE 2013-10-09 14:47:19.268 [New I/O worker #4] Format "mpegts" failed to match support line f:gif    m:image/gif
TRACE 2013-10-09 14:47:19.268 [New I/O worker #4] Format "mpegts" failed to match support line f:tiff   m:image/tiff
DEBUG 2013-10-09 14:47:19.269 [mkfifo-21] Starting mkfifo --mode=777 /tmp/universalmediaserver/1381322839105tsmuxerout.ts
DEBUG 2013-10-09 14:47:19.271 [mkfifo-21] Unix process ID (mkfifo): 7009
TRACE 2013-10-09 14:47:19.276 [Thread-49] Opening file /tmp/universalmediaserver/1381322839105videoout for writing...
DEBUG 2013-10-09 14:47:19.320 [mkfifo-22] Starting mkfifo --mode=777 /tmp/universalmediaserver/1381322839256ffmpegaudio01
DEBUG 2013-10-09 14:47:19.321 [mkfifo-23] Starting mkfifo --mode=777 /tmp/universalmediaserver/1381322839256audioout
DEBUG 2013-10-09 14:47:19.323 [mkfifo-22] Unix process ID (mkfifo): 7026
DEBUG 2013-10-09 14:47:19.323 [mkfifo-23] Unix process ID (mkfifo): 7027
TRACE 2013-10-09 14:47:19.472 [Thread-57] Opening file /tmp/universalmediaserver/1381322839256ffmpegaudio01 for reading...
DEBUG 2013-10-09 14:47:19.521 [tsMuxeR-16] Starting /home/larsat/ums-3.0.0-a6/tsMuxeR /tmp/universalmediaserver/pms-tsmuxer.meta /tmp/universalmediaserver/1381322839105tsmuxerout.ts
DEBUG 2013-10-09 14:47:19.522 [mencoder-20] Starting /home/larsat/ums-3.0.0-a6/mencoder -ss 0 /media/disk2/Filmer/video_withDTS.mkv -really-quiet -msglevel statusline=2 -channels 2 -ovc copy -of rawaudio -mc 0.1 -noskip -quiet -quiet -oac copy -quiet -quiet -srate 48000 -o /tmp/universalmediaserver/1381322839256ffmpegaudio01
DEBUG 2013-10-09 14:47:19.523 [tsMuxeR-16] Reading pipe: /tmp/universalmediaserver/1381322839105tsmuxerout.ts
TRACE 2013-10-09 14:47:19.523 [tsMuxeR-16] Opening file /tmp/universalmediaserver/1381322839105tsmuxerout.ts for reading...
TRACE 2013-10-09 14:47:19.526 [mencoder-20] Successfully initialized buffer to 1,048,576 bytes.
DEBUG 2013-10-09 14:47:19.527 [mencoder-20] Attaching thread: mencoder-20
DEBUG 2013-10-09 14:47:19.527 [mencoder-20] Unix process ID (/home/larsat/ums-3.0.0-a6/mencoder): 7038
TRACE 2013-10-09 14:47:19.549 [Thread-57] Opening file /tmp/universalmediaserver/1381322839256audioout for writing...
TRACE 2013-10-09 14:47:19.551 [Thread-57] DTS bits per sample: 24
TRACE 2013-10-09 14:47:19.551 [Thread-57] DTS framesize: 2012
DEBUG 2013-10-09 14:47:19.621 [New I/O worker #4] External input stream instance is null... sounds not good, waiting 500ms
TRACE 2013-10-09 14:47:20.084 [UPNPHelper] Receiving a NOTIFY from [192.168.1.165:24234]
TRACE 2013-10-09 14:47:20.104 [UPNPHelper] Receiving a NOTIFY from [192.168.1.165:24234]
DEBUG 2013-10-09 14:47:20.122 [New I/O worker #4] External input stream instance is null... sounds not good, waiting 500ms
TRACE 2013-10-09 14:47:20.125 [UPNPHelper] Receiving a NOTIFY from [192.168.1.165:24234]
TRACE 2013-10-09 14:47:20.158 [UPNPHelper] Receiving a NOTIFY from [192.168.1.165:24234]
TRACE 2013-10-09 14:47:20.166 [UPNPHelper] Receiving a NOTIFY from [192.168.1.165:24234]
TRACE 2013-10-09 14:47:20.190 [UPNPHelper] Receiving a NOTIFY from [192.168.1.165:24234]
DEBUG 2013-10-09 14:47:20.622 [New I/O worker #4] External input stream instance is null... sounds not good, waiting 500ms
DEBUG 2013-10-09 14:47:20.811 [UPNP-AliveMessageSender] Sending ALIVE...
TRACE 2013-10-09 14:47:20.812 [UPNP-AliveMessageSender] Sending message from multicast socket on network interface: name:null
TRACE 2013-10-09 14:47:20.812 [UPNP-AliveMessageSender] Multicast socket is on interface: /0.0.0.0
TRACE 2013-10-09 14:47:20.812 [UPNP-AliveMessageSender] Socket Timeout: 0
TRACE 2013-10-09 14:47:20.813 [UPNP-AliveMessageSender] Socket TTL: 32
TRACE 2013-10-09 14:47:20.813 [UPNPHelper] Receiving a NOTIFY from [192.168.1.100:33443]
TRACE 2013-10-09 14:47:20.814 [UPNPHelper] Receiving a NOTIFY from [192.168.1.100:33443]
TRACE 2013-10-09 14:47:20.814 [UPNPHelper] Receiving a NOTIFY from [192.168.1.100:33443]
TRACE 2013-10-09 14:47:20.814 [UPNPHelper] Receiving a NOTIFY from [192.168.1.100:33443]
TRACE 2013-10-09 14:47:20.814 [UPNPHelper] Receiving a NOTIFY from [192.168.1.100:33443]
DEBUG 2013-10-09 14:47:21.123 [New I/O worker #4] External input stream instance is null... sounds not good, waiting 500ms
TRACE 2013-10-09 14:47:21.190 [New I/O server boss #17] Creating new pipeline
TRACE 2013-10-09 14:47:21.192 [New I/O worker #5] Opened request handler on socket /192.168.1.169:55389
TRACE 2013-10-09 14:47:21.192 [New I/O worker #5] Request: HTTP/1.1 : GET : description/fetch
TRACE 2013-10-09 14:47:21.193 [New I/O worker #5] Matched media renderer "PlayStation 3" based on address /192.168.1.169
TRACE 2013-10-09 14:47:21.193 [New I/O worker #5] Received on socket: Date: Wed, 09 Oct 2013 12:47:19 GMT
TRACE 2013-10-09 14:47:21.193 [New I/O worker #5] Received on socket: Host: 192.168.1.100:5001
TRACE 2013-10-09 14:47:21.193 [New I/O worker #5] Received on socket: User-Agent: UPnP/1.0
TRACE 2013-10-09 14:47:21.193 [New I/O worker #5] Received on socket: X-AV-Client-Info: av=5.0; cn="Sony Computer Entertainment Inc."; mn="PLAYSTATION 3"; mv="1.0";
TRACE 2013-10-09 14:47:21.194 [New I/O worker #5] Recognized media renderer: PlayStation 3
TRACE 2013-10-09 14:47:21.194 [New I/O worker #5] HTTP: description/fetch / 0-0
TRACE 2013-10-09 14:47:21.197 [New I/O worker #5] Sent to socket: Accept-Ranges: bytes
TRACE 2013-10-09 14:47:21.198 [New I/O worker #5] Sent to socket: Cache-Control: no-cache
TRACE 2013-10-09 14:47:21.198 [New I/O worker #5] Sent to socket: Connection: keep-alive
TRACE 2013-10-09 14:47:21.198 [New I/O worker #5] Sent to socket: Content-Length: 2002
TRACE 2013-10-09 14:47:21.198 [New I/O worker #5] Sent to socket: Content-Type: text/xml; charset="utf-8"
TRACE 2013-10-09 14:47:21.198 [New I/O worker #5] Sent to socket: Expires: 0
TRACE 2013-10-09 14:47:21.199 [New I/O worker #5] Sent to socket: Server: Linux-amd64-3.8.0-19-generic, UPnP/1.0, UMS/3.0.0-a6
TRACE 2013-10-09 14:47:21.564 [UPNPHelper] Receiving a NOTIFY from [192.168.1.165:24234]
TRACE 2013-10-09 14:47:21.585 [UPNPHelper] Receiving a NOTIFY from [192.168.1.165:24234]
TRACE 2013-10-09 14:47:21.604 [UPNPHelper] Receiving a NOTIFY from [192.168.1.165:24234]
DEBUG 2013-10-09 14:47:21.623 [New I/O worker #4] External input stream instance is null... sounds not good, waiting 500ms
TRACE 2013-10-09 14:47:21.624 [UPNPHelper] Receiving a NOTIFY from [192.168.1.165:24234]
DEBUG 2013-10-09 14:47:22.124 [New I/O worker #4] External input stream instance is null... sounds not good, waiting 500ms
DEBUG 2013-10-09 14:47:22.624 [New I/O worker #4] External input stream instance is null... sounds not good, waiting 500ms
DEBUG 2013-10-09 14:47:23.125 [New I/O worker #4] External input stream instance is null... sounds not good, waiting 500ms
DEBUG 2013-10-09 14:47:23.625 [New I/O worker #4] External input stream instance is null... sounds not good, waiting 500ms
DEBUG 2013-10-09 14:47:24.126 [New I/O worker #4] External input stream instance is null... sounds not good, waiting 500ms
ERROR 2013-10-09 14:47:24.627 [Hanging External Process Stopper] External input stream instance is null... stopping process
ERROR 2013-10-09 14:47:24.627 [New I/O worker #4] There is no inputstream to return for video_withDTS.mkv [MEncoder] {Audio: DTS/English (dts)}
DEBUG 2013-10-09 14:47:24.628 [Hanging External Process Stopper] Stopping Unix process 7036: tsMuxeR-16
TRACE 2013-10-09 14:47:24.628 [Hanging External Process Stopper] Killing the Unix process: 7036
TRACE 2013-10-09 14:47:24.628 [New I/O worker #4] Sent to socket: Content-Length: 0
TRACE 2013-10-09 14:47:24.629 [New I/O worker #4] Sent to socket: Server: Linux-amd64-3.8.0-19-generic, UPnP/1.0, UMS/3.0.0-a6
TRACE 2013-10-09 14:47:24.629 [New I/O worker #4] Sent to socket: TransferMode.DLNA.ORG: Streaming
DEBUG 2013-10-09 14:47:24.630 [Hanging External Process Stopper] Stopping Unix process 7004: mencoder-17
TRACE 2013-10-09 14:47:24.630 [Hanging External Process Stopper] Killing the Unix process: 7004
TRACE 2013-10-09 14:47:24.631 [Hanging External Process Stopper] Destroying buffer
DEBUG 2013-10-09 14:47:24.631 [Hanging External Process Stopper] Stopping Unix process 7009: mkfifo-21
TRACE 2013-10-09 14:47:24.631 [Hanging External Process Stopper] Killing the Unix process: 7009
DEBUG 2013-10-09 14:47:24.633 [Hanging External Process Stopper] Stopping Unix process 7038: mencoder-20
TRACE 2013-10-09 14:47:24.634 [Hanging External Process Stopper] Killing the Unix process: 7038
TRACE 2013-10-09 14:47:24.634 [Hanging External Process Stopper] Destroying buffer
With DTS disabled:

Code: Select all

TRACE 2013-10-09 14:45:26.038 [New I/O worker #2] Asked stream chunk : TimeRange [start=null, end=null] of video_withDTS.mkv and player MEncoder
DEBUG 2013-10-09 14:45:26.041 [New I/O worker #2] Starting transcode/remux of video_withDTS.mkv with media info: container: mkv, bitrate: 6861472, size: 2342964620, video codec: h264, duration: 00:45:31.00, width: 976, height: 720, frame rate: 23.976, thumb size : 1524, muxing mode: null, mime type: video/x-matroska
	Audio track id: 0, lang: en, flavor: dts, audio codec: DTS, sample frequency:48000, number of channels: 6, bits per sample: 24
	Subtitle track id: 0, type: SUBRIP, flavor: english, lang: en, externalFileCharacterSet: null
TRACE 2013-10-09 14:45:26.041 [New I/O worker #2] Don't want subtitles!
TRACE 2013-10-09 14:45:26.042 [New I/O worker #2] channels=6
DEBUG 2013-10-09 14:45:26.104 [New I/O worker #2] Starting mkfifo --mode=777 /tmp/universalmediaserver/mencoder1381322726104
DEBUG 2013-10-09 14:45:26.106 [New I/O worker #2] Unix process ID (mkfifo): 6773
DEBUG 2013-10-09 14:45:26.108 [mencoder-4] Starting /home/larsat/ums-3.0.0-a6/mencoder -ss 0 /media/disk2/Filmer/video_withDTS.mkv -msglevel statusline=2 -oac lavc -of mpeg -mpegopts format=mpeg2:muxrate=500000:vbuf_size=1194:abuf_size=64 -ovc lavc -channels 6 -lavdopts debug=0:threads=4 -lavcopts autoaspect=1:vcodec=mpeg2video:acodec=ac3:abitrate=640:threads=8:keyint=25:vqscale=1:vqmin=2:vqmax=3:vrc_maxrate=54000:vrc_buf_size=7000 -nosub -noautosub -ofps 24000/1001 -lavdopts fast -mc 0 -noskip -af lavcresample=48000 -srate 48000 -o /tmp/universalmediaserver/mencoder1381322726104
DEBUG 2013-10-09 14:45:26.109 [mencoder-4] Reading pipe: /tmp/universalmediaserver/mencoder1381322726104
TRACE 2013-10-09 14:45:26.109 [mencoder-4] Opening file /tmp/universalmediaserver/mencoder1381322726104 for reading...
DEBUG 2013-10-09 14:45:26.130 [Thread-21] [ac3 @ 0x8f80b40]Channel layout not specified
DEBUG 2013-10-09 14:45:26.130 [Thread-21] [ac3 @ 0x8f80b40]No channel layout specified. The encoder will guess the layout, but it might be incorrect.
DEBUG 2013-10-09 14:45:26.131 [Thread-21] Limiting audio preload to 0.4s.
DEBUG 2013-10-09 14:45:26.131 [Thread-21] Increasing audio density to 4.
TRACE 2013-10-09 14:45:26.158 [mencoder-4] Successfully initialized buffer to 52,428,800 bytes.
DEBUG 2013-10-09 14:45:26.158 [mencoder-4] Attaching thread: mencoder-4
DEBUG 2013-10-09 14:45:26.159 [mencoder-4] Unix process ID (/home/larsat/ums-3.0.0-a6/mencoder): 6777
TRACE 2013-10-09 14:45:26.159 [Timer-2] buffered: 0 bytes / inputs: 0
DEBUG 2013-10-09 14:45:26.159 [Thread-24] MEncoder SB50 (C) 2000-2013 MPlayer Team
DEBUG 2013-10-09 14:45:26.159 [Thread-24] Custom build by SubJunk, http://www.spirton.com
DEBUG 2013-10-09 14:45:26.159 [Thread-24] 
DEBUG 2013-10-09 14:45:26.159 [Thread-24] success: format: 0  data: 0x0 - 0x8ba6cd8c
DEBUG 2013-10-09 14:45:26.159 [Thread-24] libavformat version 54.61.101 (internal)
DEBUG 2013-10-09 14:45:26.159 [Thread-24] libavformat file format detected.
DEBUG 2013-10-09 14:45:26.159 [Thread-24] [lavf] stream 0: video (h264), -vid 0, X264
DEBUG 2013-10-09 14:45:26.160 [Thread-24] [lavf] stream 1: audio (dca), -aid 0, -alang eng, DTS
DEBUG 2013-10-09 14:45:26.160 [Thread-24] [lavf] stream 2: subtitle (subrip), -sid 0, -slang eng, English
DEBUG 2013-10-09 14:45:26.160 [Thread-24] VIDEO:  [H264]  976x720  0bpp  23.976 fps    0.0 kbps ( 0.0 kbyte/s)
DEBUG 2013-10-09 14:45:26.160 [Thread-24] [V] filefmt:44  fourcc:0x34363248  size:976x720  fps:23.976  ftime:=0.0417
DEBUG 2013-10-09 14:45:26.160 [Thread-24] ==========================================================================
DEBUG 2013-10-09 14:45:26.160 [Thread-24] Opening audio decoder: [ffmpeg] FFmpeg/libavcodec audio decoders
DEBUG 2013-10-09 14:45:26.160 [Thread-24] libavcodec version 54.89.100 (internal)
DEBUG 2013-10-09 14:45:26.160 [Thread-24] AUDIO: 48000 Hz, 6 ch, floatle, 1536.0 kbit/16.67% (ratio: 192000->1152000)
DEBUG 2013-10-09 14:45:26.160 [Thread-24] Selected audio codec: [ffdca] afm: ffmpeg (FFmpeg DTS)
DEBUG 2013-10-09 14:45:26.160 [Thread-24] ==========================================================================
DEBUG 2013-10-09 14:45:26.160 [Thread-24] PACKET SIZE: 2048 bytes, deltascr: 884
DEBUG 2013-10-09 14:45:26.160 [Thread-24] Opening video filter: [expand osd=1]
DEBUG 2013-10-09 14:45:26.160 [Thread-24] Expand: -1 x -1, -1 ; -1, osd: 1, aspect: 0.000000, round: 1
DEBUG 2013-10-09 14:45:26.160 [Thread-24] ==========================================================================
DEBUG 2013-10-09 14:45:26.160 [Thread-24] Opening video decoder: [ffmpeg] FFmpeg's libavcodec codec family
DEBUG 2013-10-09 14:45:26.160 [Thread-24] Selected video codec: [ffh264] vfm: ffmpeg (FFmpeg H.264)
DEBUG 2013-10-09 14:45:26.161 [Thread-24] ==========================================================================
DEBUG 2013-10-09 14:45:26.161 [Thread-24] Movie-Aspect is 1.36:1 - prescaling to correct movie aspect.
DEBUG 2013-10-09 14:45:26.161 [Thread-24] videocodec: libavcodec (976x720 fourcc=3267706d [mpg2])
DEBUG 2013-10-09 14:45:26.161 [Thread-24] [VE_LAVC] Using constant qscale = 1.000000 (VBR).
DEBUG 2013-10-09 14:45:26.190 [Thread-24] Writing header...
DEBUG 2013-10-09 14:45:26.190 [Thread-24] INITV: 0.200, 0.158, fps: 23.976
TRACE 2013-10-09 14:45:26.212 [New I/O worker #2] Matched support line f:mpegps|mpegts   v:mpeg1|mpeg2|mp4|h264   a:ac3|lpcm|mpa       m:video/mpeg
INFO  2013-10-09 14:45:26.212 [StartPlaying Event] Started playing video_withDTS.mkv on your PlayStation 3
DEBUG 2013-10-09 14:45:26.213 [StartPlaying Event] The full filename of which is: /media/disk2/Filmer/video_withDTS.mkv and the address of the renderer is: 192.168.1.169
TRACE 2013-10-09 14:45:26.213 [New I/O worker #2] Ready to Stop: true
TRACE 2013-10-09 14:45:26.216 [New I/O worker #2] Sent to socket: Accept-Ranges: bytes
TRACE 2013-10-09 14:45:26.216 [New I/O worker #2] Sent to socket: Connection: keep-alive
TRACE 2013-10-09 14:45:26.216 [New I/O worker #2] Sent to socket: Content-Type: video/mpeg
TRACE 2013-10-09 14:45:26.216 [New I/O worker #2] Sent to socket: Server: Linux-amd64-3.8.0-19-generic, UPnP/1.0, UMS/3.0.0-a6
TRACE 2013-10-09 14:45:26.217 [New I/O server boss #17] Creating new pipeline
Locked