Need help troubleshooting - DVD ISO won't play

For help and support with Universal Media Server
Forum rules
Please make sure you follow the Problem Reporting Guidelines before posting if you want a reply
Post Reply
thrakazog
Posts: 9
Joined: Sun Jul 27, 2014 4:55 pm

Need help troubleshooting - DVD ISO won't play

Post by thrakazog »

I have an intermittent problem with playing DVD ISO files on a CPU that is on the same physical network as another machine (older) that does not have problems playing the same ISO files. I do not no how to troubleshoot by looking into the debug.log file because I have little experience in what the output is indicating. (Sorry).

I am curious if someone can see anything useful in this one section of debug output that happened when I tried to play a DVD ISO file and it started to cache and then stopped.

by the way, this video will play if I keep trying for a couple dozen times. It is hit or miss. When movies do play, there is no problem, but just a pain trying to get them to start and stay started...

The code follows:

Code: Select all

DEBUG 2014-07-28 14:25:51.085 [New I/O worker #4] Starting transcode/remux of Title 1 with media info: container: iso, bitrate: 0, size: 0, video codec: mpeg2video, duration: 01:48:03.50, width: 720, height: 480, frame rate: 29.970, muxing mode: null, mime type: null
	Audio track id: 128, lang: en, flavor: null, audio codec: AC3, sample frequency:null, number of channels: 6, bits per sample: 16
	Audio track id: 129, lang: fr, flavor: null, audio codec: AC3, sample frequency:null, number of channels: 6, bits per sample: 16
	Subtitle track id: 0, type: UNKNOWN, flavor: null, lang: en, externalFileCharacterSet: null
	Subtitle track id: 1, type: UNKNOWN, flavor: null, lang: es, externalFileCharacterSet: null
	Subtitle track id: 2, type: UNKNOWN, flavor: null, lang: fr, externalFileCharacterSet: null
DEBUG 2014-07-28 14:25:51.095 [New I/O worker #4] Creating pipe \\.\pipe\mencoder1406575551095
DEBUG 2014-07-28 14:25:51.115 [Thread-167] Waiting for pipe connection \\.\pipe\mencoder1406575551095
DEBUG 2014-07-28 14:25:51.115 [mencoder.exe-52] Starting C:\Program Files (x86)\Universal Media Server\win32\mencoder.exe -ss 0 -dvd-device E:\[DVD_ISO]\[BAD_COMPANY_(1995)].ISO dvd://1 -msglevel statusline=2 -oac copy -of mpeg -mpegopts format=mpeg2:muxrate=500000:vbuf_size=1194:abuf_size=64:vaspect=16/9 -ovc lavc -channels 6 -lavdopts debug=0:threads=1 -lavcopts autoaspect=1:vcodec=mpeg2video:acodec=ac3:abitrate=448:threads=2:keyint=5:vqscale=1:vqmin=2:vqmax=3:vrc_maxrate=499000:vrc_buf_size=1835 -aid 128 -nosub -noautosub -ofps 30000/1001 -o \\.\pipe\mencoder1406575551095
DEBUG 2014-07-28 14:25:51.125 [mencoder.exe-52] Reading pipe: \\.\pipe\mencoder1406575551095
DEBUG 2014-07-28 14:25:51.125 [mencoder.exe-52] Attaching thread: mencoder.exe-52
DEBUG 2014-07-28 14:25:51.155 [Thread-171] MEncoder SB58-UMS (C) 2000-2014 MPlayer Team
DEBUG 2014-07-28 14:25:51.155 [Thread-171] Custom build by SubJunk, http://www.spirton.com
DEBUG 2014-07-28 14:25:51.155 [Thread-171] 
DEBUG 2014-07-28 14:25:51.172 [Thread-171] There are 6 titles on this DVD.
DEBUG 2014-07-28 14:25:51.172 [Thread-171] There are 1 angles in this DVD title.
DEBUG 2014-07-28 14:25:51.175 [Thread-171] audio stream: 0 format: ac3 (5.1) language: en aid: 128.
DEBUG 2014-07-28 14:25:51.175 [Thread-171] audio stream: 1 format: ac3 (5.1) language: fr aid: 129.
DEBUG 2014-07-28 14:25:51.175 [Thread-171] number of audio channels on disk: 2.
DEBUG 2014-07-28 14:25:51.175 [Thread-171] subtitle ( sid ): 0 language: en
DEBUG 2014-07-28 14:25:51.175 [Thread-171] subtitle ( sid ): 1 language: es
DEBUG 2014-07-28 14:25:51.175 [Thread-171] subtitle ( sid ): 2 language: fr
DEBUG 2014-07-28 14:25:51.175 [Thread-171] number of subtitles on disk: 3
DEBUG 2014-07-28 14:25:51.175 [Thread-171] 
DEBUG 2014-07-28 14:25:51.175 [Thread-171] success: format: 2  data: 0xC5A2000 - 0x3800
DEBUG 2014-07-28 14:25:51.175 [Thread-171] MPEG-PS file format detected.
DEBUG 2014-07-28 14:25:51.175 [Thread-171] VIDEO:  MPEG2  720x480  (aspect 3)  29.970 fps  9801.6 kbps (1225.2 kbyte/s)
DEBUG 2014-07-28 14:25:51.175 [Thread-171] [V] filefmt:2  fourcc:0x10000002  size:720x480  fps:29.970  ftime:=0.0334
DEBUG 2014-07-28 14:25:51.175 [Thread-171] ==========================================================================
DEBUG 2014-07-28 14:25:51.175 [Thread-171] Opening audio decoder: [ffmpeg] FFmpeg/libavcodec audio decoders
DEBUG 2014-07-28 14:25:51.177 [Thread-171] libavcodec version 55.67.100 (internal)
DEBUG 2014-07-28 14:25:51.179 [Thread-171] AUDIO: 48000 Hz, 6 ch, floatle, 448.0 kbit/4.86% (ratio: 56000->1152000)
DEBUG 2014-07-28 14:25:51.179 [Thread-171] Selected audio codec: [ffac3] afm: ffmpeg (FFmpeg AC-3)
DEBUG 2014-07-28 14:25:51.179 [Thread-171] ==========================================================================
DEBUG 2014-07-28 14:25:51.179 [Thread-167] Result of \\.\pipe\mencoder1406575551095 : true
DEBUG 2014-07-28 14:25:51.181 [Thread-171] PACKET SIZE: 2048 bytes, deltascr: 884
DEBUG 2014-07-28 14:25:51.182 [Thread-171] MPEG MUXER, patching aspect ratio to 16/9
DEBUG 2014-07-28 14:25:51.182 [Thread-171] Opening video filter: [expand osd=1]
DEBUG 2014-07-28 14:25:51.182 [Thread-171] Expand: -1 x -1, -1 ; -1, osd: 1, aspect: 0.000000, round: 1
DEBUG 2014-07-28 14:25:51.182 [Thread-171] ==========================================================================
DEBUG 2014-07-28 14:25:51.182 [Thread-171] Opening video decoder: [ffmpeg] FFmpeg's libavcodec codec family
DEBUG 2014-07-28 14:25:51.183 [Thread-171] Selected video codec: [ffmpeg2] vfm: ffmpeg (FFmpeg MPEG-2)
DEBUG 2014-07-28 14:25:51.183 [Thread-171] ==========================================================================
DEBUG 2014-07-28 14:25:51.183 [Thread-171] audiocodec: framecopy (format=2000 chans=6 rate=48000 bits=16 B/s=56000 sample-1)
DEBUG 2014-07-28 14:25:51.183 [mencoder.exe-52-2] 
DEBUG 2014-07-28 14:25:51.183 [mencoder.exe-52-2] libdvdread: Attempting to retrieve all CSS keys
DEBUG 2014-07-28 14:25:51.183 [mencoder.exe-52-2] libdvdread: This can take a _long_ time, please be patient
DEBUG 2014-07-28 14:25:51.183 [mencoder.exe-52-2] 
DEBUG 2014-07-28 14:25:51.183 [mencoder.exe-52-2] libdvdread: Found 4 VTS's
DEBUG 2014-07-28 14:25:51.183 [mencoder.exe-52-2] libdvdread: Elapsed time 0
DEBUG 2014-07-28 14:25:51.183 [mencoder.exe-52-2] Limiting audio preload to 0.4s.
DEBUG 2014-07-28 14:25:51.183 [mencoder.exe-52-2] Increasing audio density to 4.
DEBUG 2014-07-28 14:25:51.184 [Thread-171] Movie-Aspect is 1.78:1 - prescaling to correct movie aspect.
DEBUG 2014-07-28 14:25:51.184 [Thread-171] videocodec: libavcodec (720x480 fourcc=3267706d [mpg2])
DEBUG 2014-07-28 14:25:51.184 [Thread-171] [VE_LAVC] Using constant qscale = 1.000000 (VBR).
DEBUG 2014-07-28 14:25:51.225 [mencoder.exe-52-2] [mpeg2video @ 01f7daa0]ac-tex damaged at 19 14
DEBUG 2014-07-28 14:25:51.225 [mencoder.exe-52-2] [mpeg2video @ 01f7daa0]Warning MVs not available
DEBUG 2014-07-28 14:25:51.225 [Thread-171] [mpeg2video @ 01f7daa0]concealing 720 DC, 720 AC, 720 MV errors in I frame
DEBUG 2014-07-28 14:25:51.231 [mencoder.exe-52-2] [VD_FFMPEG] DRI failure.
DEBUG 2014-07-28 14:25:51.236 [Thread-171] Writing header...
DEBUG 2014-07-28 14:25:51.236 [Thread-171] INITV: 0.200, 0.167, fps: 29.970
DEBUG 2014-07-28 14:25:51.236 [Thread-171] 
DEBUG 2014-07-28 14:25:51.236 [mencoder.exe-52-2] 
DEBUG 2014-07-28 14:25:51.236 [mencoder.exe-52-2] 1 duplicate frame(s)!
DEBUG 2014-07-28 14:25:51.248 [mencoder.exe-52-2] 
DEBUG 2014-07-28 14:25:51.248 [mencoder.exe-52-2] 1 duplicate frame(s)!
DEBUG 2014-07-28 14:25:51.262 [mencoder.exe-52-2] 
DEBUG 2014-07-28 14:25:51.262 [mencoder.exe-52-2] 1 duplicate frame(s)!
DEBUG 2014-07-28 14:25:51.276 [Thread-171] 
DEBUG 2014-07-28 14:25:51.277 [Thread-171] demux_mpg: 24000/1001fps progressive NTSC content detected, switching framerate.
DEBUG 2014-07-28 14:25:51.282 [mencoder.exe-52-2] 
DEBUG 2014-07-28 14:25:51.282 [mencoder.exe-52-2] 1 duplicate frame(s)!
DEBUG 2014-07-28 14:25:51.296 [mencoder.exe-52-2] 
DEBUG 2014-07-28 14:25:51.297 [mencoder.exe-52-2] 1 duplicate frame(s)!
DEBUG 2014-07-28 14:25:51.330 [mencoder.exe-52-2] 
DEBUG 2014-07-28 14:25:51.330 [mencoder.exe-52-2] 1 duplicate frame(s)!
DEBUG 2014-07-28 14:25:51.382 [mencoder.exe-52-2] 
DEBUG 2014-07-28 14:25:51.382 [mencoder.exe-52-2] 1 duplicate frame(s)!
DEBUG 2014-07-28 14:25:51.434 [mencoder.exe-52-2] 
DEBUG 2014-07-28 14:25:51.434 [mencoder.exe-52-2] 1 duplicate frame(s)!
DEBUG 2014-07-28 14:25:51.459 [mencoder.exe-52-2] 
DEBUG 2014-07-28 14:25:51.460 [mencoder.exe-52-2] 1 duplicate frame(s)!
DEBUG 2014-07-28 14:25:51.483 [mencoder.exe-52-2] 


.
.
.
100s of the "1 duplicate frame(s)!" message deleted because it would exceed the character limit for the post
.
.
.


DEBUG 2014-07-28 14:25:57.150 [mencoder.exe-52-2] 
DEBUG 2014-07-28 14:25:57.150 [mencoder.exe-52-2] 1 duplicate frame(s)!
DEBUG 2014-07-28 14:25:57.178 [mencoder.exe-52-2] 
DEBUG 2014-07-28 14:25:57.178 [mencoder.exe-52-2] 1 duplicate frame(s)!
DEBUG 2014-07-28 14:25:57.208 [mencoder.exe-52-2] 
DEBUG 2014-07-28 14:25:57.208 [mencoder.exe-52-2] 1 duplicate frame(s)!
INFO  2014-07-28 14:25:57.215 [StartPlaying Event] Started playing Title 1 on your Vizio Smart TV
DEBUG 2014-07-28 14:25:57.216 [StartPlaying Event] The full filename of which is: E:\[DVD_ISO]\[BAD_COMPANY_(1995)].ISO and the address of the renderer is: 192.168.1.90
DEBUG 2014-07-28 14:25:57.261 [mencoder.exe-52-2] 
DEBUG 2014-07-28 14:25:57.261 [mencoder.exe-52-2] 1 duplicate frame(s)!
DEBUG 2014-07-28 14:25:57.309 [mencoder.exe-52-2] 
DEBUG 2014-07-28 14:25:57.309 [mencoder.exe-52-2] 1 duplicate frame(s)!
DEBUG 2014-07-28 14:25:57.338 [mencoder.exe-52-2] 
DEBUG 2014-07-28 14:25:57.338 [mencoder.exe-52-2] 1 duplicate frame(s)!
DEBUG 2014-07-28 14:25:57.365 [mencoder.exe-52-2] 


.
.
.
100s of the "1 duplicate frame(s)!" message deleted because it would exceed the character limit for the post
.
.
.

DEBUG 2014-07-28 14:26:03.361 [mencoder.exe-52-2] 1 duplicate frame(s)!
DEBUG 2014-07-28 14:26:03.390 [mencoder.exe-52-2] 
DEBUG 2014-07-28 14:26:03.390 [mencoder.exe-52-2] 1 duplicate frame(s)!
DEBUG 2014-07-28 14:26:03.624 [mencoder.exe-52-2] 
DEBUG 2014-07-28 14:26:03.624 [mencoder.exe-52-2] 1 duplicate frame(s)!
DEBUG 2014-07-28 14:26:03.624 [mencoder.exe-52-2] 
DEBUG 2014-07-28 14:26:03.624 [mencoder.exe-52-2] 1 duplicate frame(s)!
DEBUG 2014-07-28 14:26:03.628 [mencoder.exe-52-Cleanup] Stopping process: mencoder.exe-52
DEBUG 2014-07-28 14:26:04.566 [pool-30-thread-1] Starting C:\Program Files (x86)\Universal Media Server\win32\mplayer.exe -identify -endpos 0 -v -ao null -vc null -vo null -dvd-device E:\[DVD_ISO]\[BAD_COMPANY_(1995)].ISO dvd://1
DEBUG 2014-07-28 14:26:04.620 [mplayer.exe-53-1] MPlayer SB58-UMS (C) 2000-2014 MPlayer Team
DEBUG 2014-07-28 14:26:04.620 [mplayer.exe-53-1] Custom build by SubJunk, http://www.spirton.com
DEBUG 2014-07-28 14:26:04.620 [mplayer.exe-53-1] 
DEBUG 2014-07-28 14:26:04.620 [mplayer.exe-53-1] CPU vendor name: GenuineIntel  max cpuid level: 10
DEBUG 2014-07-28 14:26:04.620 [mplayer.exe-53-1] CPU: Intel(R) Core(TM)2 CPU          4400  @ 2.00GHz (Family: 6, Model: 15, Stepping: 2)
DEBUG 2014-07-28 14:26:04.620 [mplayer.exe-53-1] extended cpuid-level: 8
DEBUG 2014-07-28 14:26:04.620 [mplayer.exe-53-1] extended cache-info: 134242368
DEBUG 2014-07-28 14:26:04.620 [mplayer.exe-53-1] Detected cache-line size is 64 bytes
DEBUG 2014-07-28 14:26:04.622 [mplayer.exe-53-1] Testing OS support for SSE... yes.
DEBUG 2014-07-28 14:26:04.622 [mplayer.exe-53-1] CPUflags:  MMX: 1 MMX2: 1 3DNow: 0 3DNowExt: 0 SSE: 1 SSE2: 1 SSE3: 1 SSSE3: 1 SSE4: 0 SSE4.2: 0 AVX: 0
DEBUG 2014-07-28 14:26:04.622 [mplayer.exe-53-1] Compiled with runtime CPU detection.
DEBUG 2014-07-28 14:26:04.622 [mplayer.exe-53-1] Setting PATH to C:\Program Files (x86)\Universal Media Server\win32\codecs
DEBUG 2014-07-28 14:26:04.622 [mplayer.exe-53-1] get_path('codecs.conf') -> 'C:/Program Files (x86)/Universal Media Server/win32/mplayer/codecs.conf'
DEBUG 2014-07-28 14:26:04.622 [mplayer.exe-53-1] Reading optional codecs config file C:/Program Files (x86)/Universal Media Server/win32/mplayer/codecs.conf: No such file or directory
DEBUG 2014-07-28 14:26:04.622 [mplayer.exe-53-1] Reading optional codecs config file /usr/local/etc/mplayer/codecs.conf: No such file or directory
DEBUG 2014-07-28 14:26:04.622 [mplayer.exe-53-1] Using built-in default codecs.conf.
DEBUG 2014-07-28 14:26:04.622 [mplayer.exe-53-1] init_freetype
DEBUG 2014-07-28 14:26:04.622 [mplayer.exe-53-1] Using MMX (with tiny bit MMX2) Optimized OnScreenDisplay
DEBUG 2014-07-28 14:26:04.622 [mplayer.exe-53-1] get_path('fonts') -> 'C:/Program Files (x86)/Universal Media Server/win32/mplayer/fonts'
DEBUG 2014-07-28 14:26:04.623 [mplayer.exe-53-1] Configuration: --enable-static --enable-runtime-cpudetection --disable-vidix --disable-sse3 --disable-sse4 --disable-sse42 --disable-avx --disable-xvid --disable-libcdio --disable-libvorbis --disable-theora --disable-mp3lame --disable-liba52 --disable-faad --disable-libopus
DEBUG 2014-07-28 14:26:04.623 [mplayer.exe-53-1] CommandLine: '-identify' '-endpos' '0' '-v' '-ao' 'null' '-vc' 'null' '-vo' 'null' '-dvd-device' 'E:\[DVD_ISO]\[BAD_COMPANY_(1995)].ISO' 'dvd://1'
DEBUG 2014-07-28 14:26:04.623 [mplayer.exe-53-1] Using Windows native timing
DEBUG 2014-07-28 14:26:04.623 [mplayer.exe-53-1] get_path('input.conf') -> 'C:/Program Files (x86)/Universal Media Server/win32/mplayer/input.conf'
DEBUG 2014-07-28 14:26:04.623 [mplayer.exe-53-1] Parsing input config file C:/Program Files (x86)/Universal Media Server/win32/mplayer/input.conf
DEBUG 2014-07-28 14:26:04.624 [mplayer.exe-53-1] Input config file C:/Program Files (x86)/Universal Media Server/win32/mplayer/input.conf parsed: 92 binds
DEBUG 2014-07-28 14:26:04.648 [mplayer.exe-53-1] get_path('1.conf') -> 'C:/Program Files (x86)/Universal Media Server/win32/mplayer/1.conf'
DEBUG 2014-07-28 14:26:04.648 [mplayer.exe-53-1] getch2: 6 can't get number of input events  [disabling console input]
DEBUG 2014-07-28 14:26:04.648 [mplayer.exe-53-1] 
DEBUG 2014-07-28 14:26:04.648 [mplayer.exe-53-1] Playing dvd://1.
DEBUG 2014-07-28 14:26:04.648 [mplayer.exe-53-1] get_path('sub/') -> 'C:/Program Files (x86)/Universal Media Server/win32/mplayer/sub/'
DEBUG 2014-07-28 14:26:04.651 [mplayer.exe-53-1] WINSOCK2 init: 0
DEBUG 2014-07-28 14:26:04.651 [mplayer.exe-53-1] URL: dvd://1
DEBUG 2014-07-28 14:26:04.654 [mplayer.exe-53-1] Reading disc structure, please wait...
DEBUG 2014-07-28 14:26:04.654 [mplayer.exe-53-1] ID_DVD_TITLES=6
DEBUG 2014-07-28 14:26:04.654 [mplayer.exe-53-1] ID_DVD_TITLE_1_CHAPTERS=11
DEBUG 2014-07-28 14:26:04.655 [mplayer.exe-53-1] ID_DVD_TITLE_1_ANGLES=1
DEBUG 2014-07-28 14:26:04.655 [mplayer.exe-53-1] ID_DVD_TITLE_2_CHAPTERS=1
DEBUG 2014-07-28 14:26:04.655 [mplayer.exe-53-1] ID_DVD_TITLE_2_ANGLES=1
DEBUG 2014-07-28 14:26:04.655 [mplayer.exe-53-1] ID_DVD_TITLE_3_CHAPTERS=3
DEBUG 2014-07-28 14:26:04.655 [mplayer.exe-53-1] ID_DVD_TITLE_3_ANGLES=1
DEBUG 2014-07-28 14:26:04.655 [mplayer.exe-53-1] ID_DVD_TITLE_4_CHAPTERS=3
DEBUG 2014-07-28 14:26:04.655 [mplayer.exe-53-1] ID_DVD_TITLE_4_ANGLES=1
DEBUG 2014-07-28 14:26:04.655 [mplayer.exe-53-1] ID_DVD_TITLE_5_CHAPTERS=2
DEBUG 2014-07-28 14:26:04.655 [mplayer.exe-53-1] ID_DVD_TITLE_5_ANGLES=1
DEBUG 2014-07-28 14:26:04.655 [mplayer.exe-53-1] ID_DVD_TITLE_6_CHAPTERS=2
DEBUG 2014-07-28 14:26:04.655 [mplayer.exe-53-1] ID_DVD_TITLE_6_ANGLES=1
DEBUG 2014-07-28 14:26:04.655 [mplayer.exe-53-1] ID_DVD_TITLE_1_LENGTH=6483.500
DEBUG 2014-07-28 14:26:04.656 [mplayer.exe-53-1] ID_DVD_TITLE_2_LENGTH=0.834
DEBUG 2014-07-28 14:26:04.656 [mplayer.exe-53-1] ID_DVD_TITLE_3_LENGTH=11.000
DEBUG 2014-07-28 14:26:04.656 [mplayer.exe-53-1] ID_DVD_TITLE_4_LENGTH=11.000
DEBUG 2014-07-28 14:26:04.656 [mplayer.exe-53-1] ID_DVD_TITLE_5_LENGTH=11.000
DEBUG 2014-07-28 14:26:04.657 [mplayer.exe-53-1] ID_DVD_TITLE_6_LENGTH=80.533
DEBUG 2014-07-28 14:26:04.658 [mplayer.exe-53-1] ID_DVD_DISC_ID=AB2CC66C001EF8EEF1D40BD62AB16DFD
DEBUG 2014-07-28 14:26:04.658 [mplayer.exe-53-1] ID_DVD_VOLUME_ID=BAD_COMPANY_US
DEBUG 2014-07-28 14:26:04.658 [mplayer.exe-53-1] There are 6 titles on this DVD.
DEBUG 2014-07-28 14:26:04.658 [mplayer.exe-53-1] 
DEBUG 2014-07-28 14:26:04.658 [mplayer.exe-53-1] ID_DVD_CURRENT_TITLE=1
DEBUG 2014-07-28 14:26:04.658 [mplayer.exe-53-1] There are 1 angles in this DVD title.
DEBUG 2014-07-28 14:26:04.661 [mplayer.exe-53-1] 
DEBUG 2014-07-28 14:26:04.661 [mplayer.exe-53-1] DVD successfully opened.
DEBUG 2014-07-28 14:26:04.661 [mplayer.exe-53-1] audio stream: 0 format: ac3 (5.1) language: en aid: 128.
DEBUG 2014-07-28 14:26:04.661 [mplayer.exe-53-1] 
DEBUG 2014-07-28 14:26:04.661 [mplayer.exe-53-1] ID_AUDIO_ID=128
DEBUG 2014-07-28 14:26:04.661 [mplayer.exe-53-1] ID_AID_128_LANG=en
DEBUG 2014-07-28 14:26:04.661 [mplayer.exe-53-1] audio stream: 1 format: ac3 (5.1) language: fr aid: 129.
DEBUG 2014-07-28 14:26:04.661 [mplayer.exe-53-1] 
DEBUG 2014-07-28 14:26:04.661 [mplayer.exe-53-1] ID_AUDIO_ID=129
DEBUG 2014-07-28 14:26:04.661 [mplayer.exe-53-1] ID_AID_129_LANG=fr
DEBUG 2014-07-28 14:26:04.661 [mplayer.exe-53-1] number of audio channels on disk: 2.
DEBUG 2014-07-28 14:26:04.661 [mplayer.exe-53-1] subtitle ( sid ): 0 language: en
DEBUG 2014-07-28 14:26:04.661 [mplayer.exe-53-1] 
DEBUG 2014-07-28 14:26:04.661 [mplayer.exe-53-1] ID_SUBTITLE_ID=0
DEBUG 2014-07-28 14:26:04.661 [mplayer.exe-53-1] ID_SID_0_LANG=en
DEBUG 2014-07-28 14:26:04.661 [mplayer.exe-53-1] subtitle ( sid ): 1 language: es
DEBUG 2014-07-28 14:26:04.661 [mplayer.exe-53-1] 
DEBUG 2014-07-28 14:26:04.661 [mplayer.exe-53-1] ID_SUBTITLE_ID=1
DEBUG 2014-07-28 14:26:04.661 [mplayer.exe-53-1] ID_SID_1_LANG=es
DEBUG 2014-07-28 14:26:04.661 [mplayer.exe-53-1] subtitle ( sid ): 2 language: fr
DEBUG 2014-07-28 14:26:04.661 [mplayer.exe-53-1] 
DEBUG 2014-07-28 14:26:04.661 [mplayer.exe-53-1] ID_SUBTITLE_ID=2
DEBUG 2014-07-28 14:26:04.661 [mplayer.exe-53-1] ID_SID_2_LANG=fr
DEBUG 2014-07-28 14:26:04.661 [mplayer.exe-53-1] number of subtitles on disk: 3
DEBUG 2014-07-28 14:26:04.662 [mplayer.exe-53-1] 
DEBUG 2014-07-28 14:26:04.662 [mplayer.exe-53-1] DVD start cell: 0  pack: 0x18B44-0x60E6E  
DEBUG 2014-07-28 14:26:04.662 [mplayer.exe-53-1] CHAPTERS: 00:00:00.000,00:09:18.700,00:16:23.033,00:25:40.033,00:31:15.867,00:44:26.367,00:54:36.000,01:07:30.667,01:16:08.501,01:31:59.534,01:48:02.667,
DEBUG 2014-07-28 14:26:04.662 [mplayer.exe-53-1] DVD start=101188 end=7  
DEBUG 2014-07-28 14:26:04.662 [mplayer.exe-53-1] STREAM: [null] dvd://1
DEBUG 2014-07-28 14:26:04.662 [mplayer.exe-53-1] STREAM: Description: DVD stream
DEBUG 2014-07-28 14:26:04.662 [mplayer.exe-53-1] STREAM: Author: 
DEBUG 2014-07-28 14:26:04.662 [mplayer.exe-53-1] STREAM: Comment: 
DEBUG 2014-07-28 14:26:04.662 [mplayer.exe-53-1] DVD Seek! lba=0x18B44  cell=0  packs: 0x18B44-0x60E6E  
DEBUG 2014-07-28 14:26:04.662 [mplayer.exe-53-1] Angle-seek synced by cell/vob IDN search!  
DEBUG 2014-07-28 14:26:04.662 [mplayer.exe-53-1] system stream synced at 0xC5A200D (207233037)!
DEBUG 2014-07-28 14:26:04.662 [mplayer.exe-53-1] ==> Found video stream: 0
DEBUG 2014-07-28 14:26:04.662 [mplayer.exe-53-1] ID_VIDEO_ID=0
DEBUG 2014-07-28 14:26:04.662 [mplayer.exe-53-1] DVD Seek! lba=0x18B44  cell=0  packs: 0x18B44-0x60E6E  
DEBUG 2014-07-28 14:26:04.662 [mplayer.exe-53-1] Angle-seek synced by cell/vob IDN search!  
DEBUG 2014-07-28 14:26:04.662 [mplayer.exe-53-1] MPEG-PS file format detected.
DEBUG 2014-07-28 14:26:04.662 [mplayer.exe-53-1] ==> Found audio stream: 128
DEBUG 2014-07-28 14:26:04.663 [mplayer.exe-53-1] ID_AUDIO_ID=128
DEBUG 2014-07-28 14:26:04.663 [mplayer.exe-53-1] Searching for sequence header... OK!
DEBUG 2014-07-28 14:26:04.663 [mplayer.exe-53-1] VIDEO:  MPEG2  720x480  (aspect 3)  29.970 fps  9801.6 kbps (1225.2 kbyte/s)
DEBUG 2014-07-28 14:26:04.663 [mplayer.exe-53-1] [V] filefmt:2  fourcc:0x10000002  size:720x480  fps:29.970  ftime:=0.0334
DEBUG 2014-07-28 14:26:04.663 [mplayer.exe-53-1] get_path('sub/') -> 'C:/Program Files (x86)/Universal Media Server/win32/mplayer/sub/'
DEBUG 2014-07-28 14:26:04.663 [mplayer.exe-53-1] ID_FILENAME=dvd://1
DEBUG 2014-07-28 14:26:04.663 [mplayer.exe-53-1] ID_DEMUXER=mpegps
DEBUG 2014-07-28 14:26:04.663 [mplayer.exe-53-1] ID_VIDEO_FORMAT=0x10000002
DEBUG 2014-07-28 14:26:04.663 [mplayer.exe-53-1] ID_VIDEO_BITRATE=9801600
DEBUG 2014-07-28 14:26:04.663 [mplayer.exe-53-1] ID_VIDEO_WIDTH=720
DEBUG 2014-07-28 14:26:04.663 [mplayer.exe-53-1] ID_VIDEO_HEIGHT=480
DEBUG 2014-07-28 14:26:04.663 [mplayer.exe-53-1] ID_VIDEO_FPS=29.970
DEBUG 2014-07-28 14:26:04.663 [mplayer.exe-53-1] ID_VIDEO_ASPECT=0.0000
DEBUG 2014-07-28 14:26:04.663 [mplayer.exe-53-1] ID_AUDIO_FORMAT=8192
DEBUG 2014-07-28 14:26:04.663 [mplayer.exe-53-1] ID_AUDIO_BITRATE=0
DEBUG 2014-07-28 14:26:04.663 [mplayer.exe-53-1] ID_AUDIO_RATE=0
DEBUG 2014-07-28 14:26:04.664 [mplayer.exe-53-1] ID_AUDIO_NCH=0
DEBUG 2014-07-28 14:26:04.664 [mplayer.exe-53-1] ID_START_TIME=0.28
DEBUG 2014-07-28 14:26:04.664 [mplayer.exe-53-1] ID_LENGTH=6483.50
DEBUG 2014-07-28 14:26:04.664 [mplayer.exe-53-1] ID_SEEKABLE=1
DEBUG 2014-07-28 14:26:04.664 [mplayer.exe-53-1] ID_CHAPTERS=11
DEBUG 2014-07-28 14:26:04.664 [mplayer.exe-53-1] ==========================================================================
DEBUG 2014-07-28 14:26:04.664 [mplayer.exe-53-1] Forced video codec: null
DEBUG 2014-07-28 14:26:04.664 [mplayer.exe-53-1] Opening video decoder: [null] Null video decoder
DEBUG 2014-07-28 14:26:04.664 [mplayer.exe-53-1] VDec: vo config request - 720 x 480 (preferred colorspace: BGR 24-bit)
DEBUG 2014-07-28 14:26:04.664 [mplayer.exe-53-1] Trying filter chain: vo
DEBUG 2014-07-28 14:26:04.664 [mplayer.exe-53-1] VDec: using BGR 24-bit as output csp (no 6)
DEBUG 2014-07-28 14:26:04.664 [mplayer.exe-53-1] Movie-Aspect is 1.78:1 - prescaling to correct movie aspect.
DEBUG 2014-07-28 14:26:04.664 [mplayer.exe-53-1] ID_VIDEO_ASPECT=1.7778
DEBUG 2014-07-28 14:26:04.664 [mplayer.exe-53-1] VO Config (720x480->854x480,flags=0,'MPlayer',0x42475218)
DEBUG 2014-07-28 14:26:04.664 [mplayer.exe-53-1] VO: [null] 720x480 => 854x480 BGR 24-bit 
DEBUG 2014-07-28 14:26:04.664 [mplayer.exe-53-1] VO: Description: Null video output
DEBUG 2014-07-28 14:26:04.664 [mplayer.exe-53-1] VO: Author: Aaron Holtzman <[email protected]>
DEBUG 2014-07-28 14:26:04.665 [mplayer.exe-53-1] Selected video codec: [null] vfm: null (NULL codec (no decoding!))
DEBUG 2014-07-28 14:26:04.665 [mplayer.exe-53-1] ==========================================================================
DEBUG 2014-07-28 14:26:04.665 [mplayer.exe-53-1] ID_VIDEO_CODEC=null
DEBUG 2014-07-28 14:26:04.665 [mplayer.exe-53-1] ==========================================================================
DEBUG 2014-07-28 14:26:04.665 [mplayer.exe-53-1] Opening audio decoder: [ffmpeg] FFmpeg/libavcodec audio decoders
DEBUG 2014-07-28 14:26:04.665 [mplayer.exe-53-1] dec_audio: Allocating 1536000 + 131072 = 1667072 bytes for output buffer.
DEBUG 2014-07-28 14:26:04.666 [mplayer.exe-53-1] FFmpeg's libavcodec audio codec
DEBUG 2014-07-28 14:26:04.666 [mplayer.exe-53-1] libavcodec version 55.67.100 (internal)
DEBUG 2014-07-28 14:26:04.667 [mplayer.exe-53-1] Configuration: --enable-gpl --enable-postproc
DEBUG 2014-07-28 14:26:04.668 [mplayer.exe-53-1] INFO: libavcodec "ac3" init OK!
DEBUG 2014-07-28 14:26:04.668 [mplayer.exe-53-1] AUDIO: 48000 Hz, 2 ch, floatle, 448.0 kbit/14.58% (ratio: 56000->384000)
DEBUG 2014-07-28 14:26:04.668 [mplayer.exe-53-1] ID_AUDIO_BITRATE=448000
DEBUG 2014-07-28 14:26:04.668 [mplayer.exe-53-1] ID_AUDIO_RATE=48000
DEBUG 2014-07-28 14:26:04.668 [mplayer.exe-53-1] ID_AUDIO_NCH=2
DEBUG 2014-07-28 14:26:04.668 [mplayer.exe-53-1] Selected audio codec: [ffac3] afm: ffmpeg (FFmpeg AC-3)
DEBUG 2014-07-28 14:26:04.668 [mplayer.exe-53-1] ==========================================================================
DEBUG 2014-07-28 14:26:04.668 [mplayer.exe-53-1] Building audio filter chain for 48000Hz/2ch/floatle -> 0Hz/0ch/??...
DEBUG 2014-07-28 14:26:04.669 [mplayer.exe-53-1] [libaf] Adding filter dummy 
DEBUG 2014-07-28 14:26:04.669 [mplayer.exe-53-1] [dummy] Was reinitialized: 48000Hz/2ch/floatle
DEBUG 2014-07-28 14:26:04.669 [mplayer.exe-53-1] [dummy] Was reinitialized: 48000Hz/2ch/floatle
DEBUG 2014-07-28 14:26:04.669 [mplayer.exe-53-1] Trying preferred audio driver 'null', options '[none]'
DEBUG 2014-07-28 14:26:04.669 [mplayer.exe-53-1] AO: [null] 48000Hz 2ch floatle (4 bytes per sample)
DEBUG 2014-07-28 14:26:04.669 [mplayer.exe-53-1] AO: Description: Null audio output
DEBUG 2014-07-28 14:26:04.669 [mplayer.exe-53-1] AO: Author: Tobias Diedrich <[email protected]>
DEBUG 2014-07-28 14:26:04.669 [mplayer.exe-53-1] Building audio filter chain for 48000Hz/2ch/floatle -> 48000Hz/2ch/floatle...
DEBUG 2014-07-28 14:26:04.669 [mplayer.exe-53-1] [dummy] Was reinitialized: 48000Hz/2ch/floatle
DEBUG 2014-07-28 14:26:04.669 [mplayer.exe-53-1] [dummy] Was reinitialized: 48000Hz/2ch/floatle
DEBUG 2014-07-28 14:26:04.669 [mplayer.exe-53-1] ID_AUDIO_CODEC=ffac3
DEBUG 2014-07-28 14:26:04.669 [mplayer.exe-53-1] Starting playback...
DEBUG 2014-07-28 14:26:04.669 [mplayer.exe-53-1] ==> Found audio stream: 129
DEBUG 2014-07-28 14:26:04.669 [mplayer.exe-53-1] ID_AUDIO_ID=129
DEBUG 2014-07-28 14:26:04.670 [mplayer.exe-53-1] Increasing filtered audio buffer size from 0 to 81920
DEBUG 2014-07-28 14:26:04.670 [mplayer.exe-53-1] EOF code: 1  
DEBUG 2014-07-28 14:26:04.670 [mplayer.exe-53-1] 
DEBUG 2014-07-28 14:26:04.670 [mplayer.exe-53-1] Uninit audio filters...
DEBUG 2014-07-28 14:26:04.670 [mplayer.exe-53-1] [libaf] Removing filter dummy 
DEBUG 2014-07-28 14:26:04.670 [mplayer.exe-53-1] Uninit audio: ffmpeg
DEBUG 2014-07-28 14:26:04.671 [mplayer.exe-53-1] Uninit video: null
DEBUG 2014-07-28 14:26:04.671 [mplayer.exe-53-1] WINSOCK2 uninit
DEBUG 2014-07-28 14:26:04.671 [mplayer.exe-53-1] 
DEBUG 2014-07-28 14:26:04.671 [mplayer.exe-53-1] Exiting... (End of file)
DEBUG 2014-07-28 14:26:04.671 [mplayer.exe-53-1] ID_EXIT=EOF
DEBUG 2014-07-28 14:26:04.723 [mplayer.exe-53-2] libdvdnav:DVDOpenFileUDF:UDFFindFile /VIDEO_TS/VTS_05_0.IFO failed
DEBUG 2014-07-28 14:26:04.723 [mplayer.exe-53-2] libdvdnav:DVDOpenFileUDF:UDFFindFile /VIDEO_TS/VTS_06_0.IFO failed
DEBUG 2014-07-28 14:26:04.723 [mplayer.exe-53-2] libdvdnav:DVDOpenFileUDF:UDFFindFile /VIDEO_TS/VTS_07_0.IFO failed
DEBUG 2014-07-28 14:26:04.723 [mplayer.exe-53-2] libdvdnav:DVDOpenFileUDF:UDFFindFile /VIDEO_TS/VTS_08_0.IFO failed
DEBUG 2014-07-28 14:26:04.723 [mplayer.exe-53-2] libdvdnav:DVDOpenFileUDF:UDFFindFile /VIDEO_TS/VTS_09_0.IFO failed
DEBUG 2014-07-28 14:26:04.723 [mplayer.exe-53-2] 
DEBUG 2014-07-28 14:26:04.723 [mplayer.exe-53-2] libdvdread: Attempting to retrieve all CSS keys
DEBUG 2014-07-28 14:26:04.723 [mplayer.exe-53-2] libdvdread: This can take a _long_ time, please be patient
DEBUG 2014-07-28 14:26:04.723 [mplayer.exe-53-2] 
DEBUG 2014-07-28 14:26:04.723 [mplayer.exe-53-2] libdvdread: Found 4 VTS's
DEBUG 2014-07-28 14:26:04.723 [mplayer.exe-53-2] libdvdread: Elapsed time 0
INFO  2014-07-28 14:26:04.723 [pool-30-thread-1] Exception in thread "pool-30-thread-1" java.lang.NullPointerException
INFO  2014-07-28 14:26:04.723 [pool-30-thread-1] 	at net.pms.dlna.DVDISOTitle.resolveOnce(DVDISOTitle.java:214)
INFO  2014-07-28 14:26:04.723 [pool-30-thread-1] 	at net.pms.dlna.DLNAResource.resolve(DLNAResource.java:1183)
INFO  2014-07-28 14:26:04.723 [pool-30-thread-1] 	at net.pms.dlna.DLNAResource.run(DLNAResource.java:1027)
INFO  2014-07-28 14:26:04.723 [pool-30-thread-1] 	at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source)
INFO  2014-07-28 14:26:04.723 [pool-30-thread-1] 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
INFO  2014-07-28 14:26:04.723 [pool-30-thread-1] 	at java.lang.Thread.run(Unknown Source)
INFO  2014-07-28 14:26:06.653 [StopPlaying Event] Stopped playing Title 1 on your Vizio Smart TV
DEBUG 2014-07-28 14:26:06.653 [StopPlaying Event] The full filename of which is: E:\[DVD_ISO]\[BAD_COMPANY_(1995)].ISO and the address of the renderer is: 192.168.1.90
DEBUG 2014-07-28 14:26:06.653 [StopPlaying Event] add DVDISOTitle [id=null, name=Title 1, full path=null, ext=ISO, discovered=false] to last played DVDISOFile [id=3, name=[DVD ISO] [BAD_COMPANY_(1995)].ISO, full path=0$2$3, ext=null, discovered=true] RecentlyPlayed [id=1, name=Recently Played, full path=0$1, ext=null, discovered=false]
DEBUG 2014-07-28 14:26:14.573 [DVD ISO Title Failsafe] Stopping process: mplayer.exe-53
Post Reply