Page 3 of 5

Re: Issue with mencoder.exe of UMS 2.0.0 build

Posted: Tue Nov 20, 2012 8:27 am
by SubJunk
OK that's good, we've now narrowed it down to FFmpeg. Attached another one

Re: Issue with mencoder.exe of UMS 2.0.0 build

Posted: Tue Nov 20, 2012 10:07 am
by SpeedyQ
Movie playback and sound are still ok.

Code: Select all

DEBUG 2012-11-19 22:59:32.493 [WrapperSimpleAppMain] My PID is 3388
INFO  2012-11-19 22:59:33.613 [WrapperSimpleAppMain] An invalid plugin was ignored
INFO  2012-11-19 22:59:33.933 [WrapperSimpleAppMain] Starting Universal Media Server 2.0.0
INFO  2012-11-19 22:59:33.953 [WrapperSimpleAppMain] Based on PS3 Media Server by shagrath, copyright 2008-2012
INFO  2012-11-19 22:59:33.953 [WrapperSimpleAppMain] http://www.universalmediaserver.com
INFO  2012-11-19 22:59:33.953 [WrapperSimpleAppMain] 
INFO  2012-11-19 22:59:33.953 [WrapperSimpleAppMain] Build: 9456e1544 (2012-10-31)
INFO  2012-11-19 22:59:33.953 [WrapperSimpleAppMain] Java: 1.7.0_02-Oracle Corporation
INFO  2012-11-19 22:59:33.953 [WrapperSimpleAppMain] OS: Windows 7 64-bit 6.1
INFO  2012-11-19 22:59:33.953 [WrapperSimpleAppMain] Encoding: Cp1252
INFO  2012-11-19 22:59:33.953 [WrapperSimpleAppMain] Memory: 2730 MB
INFO  2012-11-19 22:59:33.953 [WrapperSimpleAppMain] 
INFO  2012-11-19 22:59:33.953 [WrapperSimpleAppMain] Working directory: C:\Program Files (x86)\Universal Media Server
INFO  2012-11-19 22:59:33.963 [WrapperSimpleAppMain] Temp directory: C:\Windows\TEMP\universalmediaserver
INFO  2012-11-19 22:59:33.963 [WrapperSimpleAppMain] Logging config file: C:\Program Files (x86)\Universal Media Server\logback.xml
INFO  2012-11-19 22:59:33.963 [WrapperSimpleAppMain] debug.log: C:\Program Files (x86)\Universal Media Server\debug.log
INFO  2012-11-19 22:59:33.963 [WrapperSimpleAppMain] 
INFO  2012-11-19 22:59:33.963 [WrapperSimpleAppMain] Profile directory: C:\ProgramData\UMS
INFO  2012-11-19 22:59:33.973 [WrapperSimpleAppMain] Profile path: C:\ProgramData\UMS\UMS.conf
INFO  2012-11-19 22:59:33.973 [WrapperSimpleAppMain] Profile permissions: rw
INFO  2012-11-19 22:59:33.973 [WrapperSimpleAppMain] Profile name: MediaServer2009
INFO  2012-11-19 22:59:33.973 [WrapperSimpleAppMain] 
INFO  2012-11-19 22:59:33.983 [WrapperSimpleAppMain] Loading MediaInfo library
INFO  2012-11-19 22:59:34.103 [WrapperSimpleAppMain] Loaded MediaInfoLib - v0.7.61
INFO  2012-11-19 22:59:34.113 [WrapperSimpleAppMain] Loading renderer configurations from C:\Program Files (x86)\Universal Media Server\renderers
INFO  2012-11-19 22:59:34.113 [WrapperSimpleAppMain] Loading configuration file: AirPlayer.conf
INFO  2012-11-19 22:59:34.123 [WrapperSimpleAppMain] Loading configuration file: Android.conf
INFO  2012-11-19 22:59:34.123 [WrapperSimpleAppMain] Loading configuration file: Bravia4500.conf
INFO  2012-11-19 22:59:34.123 [WrapperSimpleAppMain] Loading configuration file: Bravia5500.conf
INFO  2012-11-19 22:59:34.133 [WrapperSimpleAppMain] Loading configuration file: BraviaEX.conf
INFO  2012-11-19 22:59:34.143 [WrapperSimpleAppMain] Loading configuration file: DirecTVHR.conf
INFO  2012-11-19 22:59:34.143 [WrapperSimpleAppMain] Loading configuration file: DLinkDSM510.conf
INFO  2012-11-19 22:59:34.153 [WrapperSimpleAppMain] Loading configuration file: FreeboxHD.conf
INFO  2012-11-19 22:59:34.153 [WrapperSimpleAppMain] Loading configuration file: FreecomMusicPal.conf
INFO  2012-11-19 22:59:34.163 [WrapperSimpleAppMain] Loading configuration file: iPad-iPhone.conf
INFO  2012-11-19 22:59:34.163 [WrapperSimpleAppMain] Loading configuration file: Kuro.conf
INFO  2012-11-19 22:59:34.173 [WrapperSimpleAppMain] Loading configuration file: LGST600.conf
INFO  2012-11-19 22:59:34.173 [WrapperSimpleAppMain] Loading configuration file: N900.conf
INFO  2012-11-19 22:59:34.183 [WrapperSimpleAppMain] Loading configuration file: OPPOBDP83.conf
INFO  2012-11-19 22:59:34.183 [WrapperSimpleAppMain] Loading configuration file: OPPOBDP93.conf
INFO  2012-11-19 22:59:34.183 [WrapperSimpleAppMain] Loading configuration file: Panasonic.conf
INFO  2012-11-19 22:59:34.193 [WrapperSimpleAppMain] Loading configuration file: Philips.conf
INFO  2012-11-19 22:59:34.193 [WrapperSimpleAppMain] Loading configuration file: PhilipsPFL.conf
INFO  2012-11-19 22:59:34.203 [WrapperSimpleAppMain] Loading configuration file: PopcornHour.conf
INFO  2012-11-19 22:59:34.213 [WrapperSimpleAppMain] Loading configuration file: PS3.conf
INFO  2012-11-19 22:59:34.223 [WrapperSimpleAppMain] Loading configuration file: Realtek.conf
INFO  2012-11-19 22:59:34.223 [WrapperSimpleAppMain] Loading configuration file: Samsung-SMT-G7400.conf
INFO  2012-11-19 22:59:34.233 [WrapperSimpleAppMain] Loading configuration file: SamsungAllShare.conf
INFO  2012-11-19 22:59:34.233 [WrapperSimpleAppMain] Loading configuration file: SamsungWiseLink.conf
INFO  2012-11-19 22:59:34.243 [WrapperSimpleAppMain] Loading configuration file: Showtime3.conf
INFO  2012-11-19 22:59:34.253 [WrapperSimpleAppMain] Loading configuration file: SMP-N100.conf
INFO  2012-11-19 22:59:34.253 [WrapperSimpleAppMain] Loading configuration file: SonyBluray.conf
INFO  2012-11-19 22:59:34.263 [WrapperSimpleAppMain] Loading configuration file: SonyBraviaHX800.conf
INFO  2012-11-19 22:59:34.273 [WrapperSimpleAppMain] Loading configuration file: Streamium.conf
INFO  2012-11-19 22:59:34.273 [WrapperSimpleAppMain] Loading configuration file: WDTVLive.conf
INFO  2012-11-19 22:59:34.273 [WrapperSimpleAppMain] Loading configuration file: WMP.conf
INFO  2012-11-19 22:59:34.273 [WrapperSimpleAppMain] Loading configuration file: XBMC.conf
INFO  2012-11-19 22:59:34.283 [WrapperSimpleAppMain] Loading configuration file: XBOX360.conf
INFO  2012-11-19 22:59:34.283 [WrapperSimpleAppMain] Loading configuration file: YamahaRXA1010.conf
INFO  2012-11-19 22:59:34.283 [WrapperSimpleAppMain] Loading configuration file: YamahaRXV671.conf
INFO  2012-11-19 22:59:34.293 [WrapperSimpleAppMain] Checking MPlayer font cache. It can take a minute or so.
DEBUG 2012-11-19 22:59:34.293 [WrapperSimpleAppMain] launching: win32/mplayer.exe
DEBUG 2012-11-19 22:59:34.791 [WrapperSimpleAppMain] launching: win32/mplayer.exe
INFO  2012-11-19 22:59:34.899 [WrapperSimpleAppMain] Done!
INFO  2012-11-19 22:59:34.899 [WrapperSimpleAppMain] Found VideoLAN version 1.1.5 at: C:\Program Files (x86)\VideoLAN\VLC\vlc.exe
INFO  2012-11-19 22:59:34.899 [WrapperSimpleAppMain] Searching for plugins in C:\Program Files (x86)\Universal Media Server\plugins
INFO  2012-11-19 22:59:34.919 [WrapperSimpleAppMain] Found plugin: net.sharkhunter.gmusic.Gm_plugin
INFO  2012-11-19 22:59:34.919 [WrapperSimpleAppMain] Found plugin: net.pms.movieinfo.MovieInfo
INFO  2012-11-19 22:59:34.919 [WrapperSimpleAppMain] Found plugin: com.chocolatey.pmsencoder.Plugin
INFO  2012-11-19 22:59:34.929 [WrapperSimpleAppMain] Found plugin: com.sharkhunter.channel.CH_plugin
INFO  2012-11-19 22:59:34.939 [WrapperSimpleAppMain] PMSEncoder: initializing PMSEncoder 1.6.2
INFO  2012-11-19 22:59:35.009 [WrapperSimpleAppMain] PMSEncoder: script directory: C:\Program Files (x86)\Universal Media Server\scripts
INFO  2012-11-19 22:59:35.009 [WrapperSimpleAppMain] PMSEncoder: log directory: C:\Program Files (x86)\Universal Media Server
INFO  2012-11-19 22:59:35.009 [WrapperSimpleAppMain] PMSEncoder: loading built-in log4j config file: jar:file:/C:/Program%20Files%20(x86)/Universal%20Media%20Server/plugins/pmsencoder-1.6.2.jar!/log4j_default.xml
INFO  2012-11-19 22:59:37.159 [WrapperSimpleAppMain] Registering transcoding engine: PMSEncoder
INFO  2012-11-19 22:59:37.159 [WrapperSimpleAppMain] PMSEncoder: checking engine list: [pmsencoder, mencoder, ffmpegaudio, mplayeraudio, tsmuxeraudio, ffmpegwebvideo, vlcvideo, mencoderwebvideo, mplayervideodump, mplayerwebaudio, vlcaudio, ffmpegdvrmsremux, rawthumbs]
INFO  2012-11-19 22:59:37.159 [WrapperSimpleAppMain] PMSEncoder: already enabled
INFO  2012-11-19 22:59:37.159 [WrapperSimpleAppMain] Registering transcoding engine: AviSynth/FFmpeg
INFO  2012-11-19 22:59:37.169 [WrapperSimpleAppMain] Registering transcoding engine: FFmpeg Audio
INFO  2012-11-19 22:59:37.169 [WrapperSimpleAppMain] Registering transcoding engine: MEncoder
INFO  2012-11-19 22:59:37.169 [WrapperSimpleAppMain] Registering transcoding engine: AviSynth/MEncoder
INFO  2012-11-19 22:59:37.169 [WrapperSimpleAppMain] Registering transcoding engine: FFmpeg
INFO  2012-11-19 22:59:37.169 [WrapperSimpleAppMain] Registering transcoding engine: MPlayer Audio
INFO  2012-11-19 22:59:37.169 [WrapperSimpleAppMain] Registering transcoding engine: FFmpeg Web Video
INFO  2012-11-19 22:59:37.169 [WrapperSimpleAppMain] Registering transcoding engine: MEncoder Web
INFO  2012-11-19 22:59:37.179 [WrapperSimpleAppMain] Registering transcoding engine: MPlayer Video Dump
INFO  2012-11-19 22:59:37.179 [WrapperSimpleAppMain] Registering transcoding engine: MPlayer Web
INFO  2012-11-19 22:59:37.179 [WrapperSimpleAppMain] Registering transcoding engine: tsMuxeR
INFO  2012-11-19 22:59:37.179 [WrapperSimpleAppMain] Registering transcoding engine: Audio High Fidelity
DEBUG 2012-11-19 22:59:37.179 [WrapperSimpleAppMain] Found VLC version 1.1.5 in Windows Registry: C:\Program Files (x86)\VideoLAN\VLC\vlc.exe
DEBUG 2012-11-19 22:59:37.179 [WrapperSimpleAppMain] Found VLC version 1.1.5 in Windows Registry: C:\Program Files (x86)\VideoLAN\VLC\vlc.exe
DEBUG 2012-11-19 22:59:37.179 [WrapperSimpleAppMain] Found VLC version 1.1.5 in Windows Registry: C:\Program Files (x86)\VideoLAN\VLC\vlc.exe
DEBUG 2012-11-19 22:59:37.179 [WrapperSimpleAppMain] Found VLC version 1.1.5 in Windows Registry: C:\Program Files (x86)\VideoLAN\VLC\vlc.exe
INFO  2012-11-19 22:59:37.179 [WrapperSimpleAppMain] Registering transcoding engine: VLC Audio Streaming
DEBUG 2012-11-19 22:59:37.179 [WrapperSimpleAppMain] Found VLC version 1.1.5 in Windows Registry: C:\Program Files (x86)\VideoLAN\VLC\vlc.exe
DEBUG 2012-11-19 22:59:37.179 [WrapperSimpleAppMain] Found VLC version 1.1.5 in Windows Registry: C:\Program Files (x86)\VideoLAN\VLC\vlc.exe
DEBUG 2012-11-19 22:59:37.179 [WrapperSimpleAppMain] Found VLC version 1.1.5 in Windows Registry: C:\Program Files (x86)\VideoLAN\VLC\vlc.exe
DEBUG 2012-11-19 22:59:37.179 [WrapperSimpleAppMain] Found VLC version 1.1.5 in Windows Registry: C:\Program Files (x86)\VideoLAN\VLC\vlc.exe
INFO  2012-11-19 22:59:37.179 [WrapperSimpleAppMain] Registering transcoding engine: VLC Video Streaming
INFO  2012-11-19 22:59:37.179 [WrapperSimpleAppMain] Registering transcoding engine: FFmpeg DVR-MS Remux
INFO  2012-11-19 22:59:37.179 [WrapperSimpleAppMain] Registering transcoding engine: dcraw Thumbnailer
INFO  2012-11-19 22:59:37.199 [WrapperSimpleAppMain] GoogleMusic plugin missing credentials
INFO  2012-11-19 22:59:37.219 [WrapperSimpleAppMain] Start channel 2.05
INFO  2012-11-19 22:59:37.269 [WrapperSimpleAppMain] Configuration saved to: C:\ProgramData\UMS\UMS.conf
INFO  2012-11-19 22:59:37.439 [WrapperSimpleAppMain] Using address /192.168.31.100 found on network interface: name:eth3 (Realtek RTL8168C(P)/8111C(P) Family PCI-E Gigabit Ethernet NIC (NDIS 6.20))
INFO  2012-11-19 22:59:37.439 [WrapperSimpleAppMain] Created socket: /192.168.31.100:5001
INFO  2012-11-19 22:59:37.539 [WrapperSimpleAppMain] Checking shared folder: D:\Movie-D-drive
INFO  2012-11-19 22:59:37.539 [WrapperSimpleAppMain] Checking shared folder: F:\Movie-F-drive
INFO  2012-11-19 22:59:37.539 [WrapperSimpleAppMain] Checking shared folder: M:\Movie-M-drive
INFO  2012-11-19 22:59:37.539 [WrapperSimpleAppMain] Checking shared folder: F:\Music
ERROR 2012-11-19 22:59:37.599 [WrapperSimpleAppMain] Attempt to add a null child to root
java.lang.NullPointerException: Invalid DLNA resource
	at net.pms.dlna.DLNAResource.addChild(DLNAResource.java:450) [ums.jar:na]
	at net.pms.dlna.RootFolder.discoverChildren(RootFolder.java:148) [ums.jar:na]
	at net.pms.configuration.RendererConfiguration.getRootFolder(RendererConfiguration.java:198) [ums.jar:na]
	at net.pms.PMS.getRootFolder(PMS.java:110) [ums.jar:na]
	at net.pms.PMS.init(PMS.java:510) [ums.jar:na]
	at net.pms.PMS.createInstance(PMS.java:858) [ums.jar:na]
	at net.pms.PMS.main(PMS.java:933) [ums.jar:na]
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.7.0_02]
	at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source) ~[na:1.7.0_02]
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) ~[na:1.7.0_02]
	at java.lang.reflect.Method.invoke(Unknown Source) ~[na:1.7.0_02]
	at org.tanukisoftware.wrapper.WrapperSimpleApp.run(WrapperSimpleApp.java:290) [wrapper.jar:3.5.15]
	at java.lang.Thread.run(Unknown Source) [na:1.7.0_02]
DEBUG 2012-11-19 22:59:37.629 [WrapperSimpleAppMain] Sending ALIVE...
INFO  2012-11-19 22:59:37.689 [WrapperSimpleAppMain] Using the following UUID configured in UMS.conf: ebbb7981-ccd8-3252-ad23-83e32f84c363
INFO  2012-11-19 22:59:43.794 [WrapperSimpleAppMain] The server should now appear on your renderer
DEBUG 2012-11-19 22:59:53.809 [UPNP-AliveMessageSender] Sending ALIVE...
INFO  2012-11-19 23:00:07.582 [UPNPHelper] No IP filter specified, access granted to /192.168.31.102
INFO  2012-11-19 23:00:07.800 [pool-7-thread-1] Checking IP: 192.168.31.102 for Philips TV
INFO  2012-11-19 23:00:12.777 [pool-7-thread-1] Renderer Philips TV found on this address: 192.168.31.102
DEBUG 2012-11-19 23:00:12.777 [pool-7-thread-1] Starting ping -n 3 -l 64000 192.168.31.102
INFO  2012-11-19 23:00:13.463 [New I/O server worker #1-4] Checking shared folder: D:\Movie-D-drive
INFO  2012-11-19 23:00:13.463 [New I/O server worker #1-4] Checking shared folder: F:\Movie-F-drive
INFO  2012-11-19 23:00:13.463 [New I/O server worker #1-4] Checking shared folder: M:\Movie-M-drive
INFO  2012-11-19 23:00:13.463 [New I/O server worker #1-4] Checking shared folder: F:\Music
ERROR 2012-11-19 23:00:13.463 [New I/O server worker #1-4] Attempt to add a null child to root
java.lang.NullPointerException: Invalid DLNA resource
	at net.pms.dlna.DLNAResource.addChild(DLNAResource.java:450) [ums.jar:na]
	at net.pms.dlna.RootFolder.discoverChildren(RootFolder.java:148) [ums.jar:na]
	at net.pms.configuration.RendererConfiguration.getRootFolder(RendererConfiguration.java:198) [ums.jar:na]
	at net.pms.PMS.getRootFolder(PMS.java:110) [ums.jar:na]
	at net.pms.network.RequestV2.answer(RequestV2.java:628) [ums.jar:na]
	at net.pms.network.RequestHandlerV2.writeResponse(RequestHandlerV2.java:299) [ums.jar:na]
	at net.pms.network.RequestHandlerV2.messageReceived(RequestHandlerV2.java:257) [ums.jar:na]
	at org.jboss.netty.channel.SimpleChannelUpstreamHandler.handleUpstream(SimpleChannelUpstreamHandler.java:80) [ums.jar:na]
	at org.jboss.netty.channel.DefaultChannelPipeline.sendUpstream(DefaultChannelPipeline.java:564) [ums.jar:na]
	at org.jboss.netty.channel.DefaultChannelPipeline$DefaultChannelHandlerContext.sendUpstream(DefaultChannelPipeline.java:783) [ums.jar:na]
	at org.jboss.netty.handler.stream.ChunkedWriteHandler.handleUpstream(ChunkedWriteHandler.java:149) [ums.jar:na]
	at org.jboss.netty.channel.DefaultChannelPipeline.sendUpstream(DefaultChannelPipeline.java:564) [ums.jar:na]
	at org.jboss.netty.channel.DefaultChannelPipeline$DefaultChannelHandlerContext.sendUpstream(DefaultChannelPipeline.java:783) [ums.jar:na]
	at org.jboss.netty.handler.codec.http.HttpChunkAggregator.messageReceived(HttpChunkAggregator.java:116) [ums.jar:na]
	at org.jboss.netty.channel.SimpleChannelUpstreamHandler.handleUpstream(SimpleChannelUpstreamHandler.java:80) [ums.jar:na]
	at org.jboss.netty.channel.DefaultChannelPipeline.sendUpstream(DefaultChannelPipeline.java:564) [ums.jar:na]
	at org.jboss.netty.channel.DefaultChannelPipeline$DefaultChannelHandlerContext.sendUpstream(DefaultChannelPipeline.java:783) [ums.jar:na]
	at org.jboss.netty.channel.Channels.fireMessageReceived(Channels.java:302) [ums.jar:na]
	at org.jboss.netty.handler.codec.replay.ReplayingDecoder.unfoldAndFireMessageReceived(ReplayingDecoder.java:527) [ums.jar:na]
	at org.jboss.netty.handler.codec.replay.ReplayingDecoder.callDecode(ReplayingDecoder.java:506) [ums.jar:na]
	at org.jboss.netty.handler.codec.replay.ReplayingDecoder.messageReceived(ReplayingDecoder.java:443) [ums.jar:na]
	at org.jboss.netty.channel.SimpleChannelUpstreamHandler.handleUpstream(SimpleChannelUpstreamHandler.java:80) [ums.jar:na]
	at org.jboss.netty.channel.DefaultChannelPipeline.sendUpstream(DefaultChannelPipeline.java:564) [ums.jar:na]
	at org.jboss.netty.channel.DefaultChannelPipeline.sendUpstream(DefaultChannelPipeline.java:559) [ums.jar:na]
	at org.jboss.netty.channel.Channels.fireMessageReceived(Channels.java:274) [ums.jar:na]
	at org.jboss.netty.channel.Channels.fireMessageReceived(Channels.java:261) [ums.jar:na]
	at org.jboss.netty.channel.socket.nio.NioWorker.read(NioWorker.java:351) [ums.jar:na]
	at org.jboss.netty.channel.socket.nio.NioWorker.processSelectedKeys(NioWorker.java:282) [ums.jar:na]
	at org.jboss.netty.channel.socket.nio.NioWorker.run(NioWorker.java:202) [ums.jar:na]
	at org.jboss.netty.util.ThreadRenamingRunnable.run(ThreadRenamingRunnable.java:108) [ums.jar:na]
	at org.jboss.netty.util.internal.DeadLockProofWorker$1.run(DeadLockProofWorker.java:44) [ums.jar:na]
	at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source) [na:1.7.0_02]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source) [na:1.7.0_02]
	at java.lang.Thread.run(Unknown Source) [na:1.7.0_02]
INFO  2012-11-19 23:00:13.463 [New I/O server worker #1-4] Node(com.sharkhunter.channel.Channels) already has an ID=0$6, which is overriden now. The previous parent node was:RootFolder[[MapFile [name=Movie-D-drive, id=0$1, format=null, children=[]], MapFile [name=Movie-F-drive, id=0$2, format=null, children=[]], MapFile [name=Movie-M-drive, id=0$3, format=null, children=[]], MapFile [name=Music, id=0$4, format=null, children=[]], VirtualFolder [id=5, name=Web, full path=0$5, ext=null, discovered=false]]]
DEBUG 2012-11-19 23:00:14.789 [SpeedStats Failsafe] Stopping process: ping-0
DEBUG 2012-11-19 23:00:17.630 [New I/O server worker #1-6] Detected encoding for D:\Movie-D-drive\Bad.Ass(2012).srt is WINDOWS-1252.
DEBUG 2012-11-19 23:00:17.708 [New I/O server worker #1-6] Detected encoding for D:\Movie-D-drive\Bad.Ass(2012).srt is WINDOWS-1252.
DEBUG 2012-11-19 23:00:18.395 [New I/O server worker #1-6] Detected encoding for D:\Movie-D-drive\Re-animator(1985).srt is WINDOWS-1252.
DEBUG 2012-11-19 23:00:18.441 [New I/O server worker #1-6] Detected encoding for D:\Movie-D-drive\Re-animator(1985).srt is WINDOWS-1252.
DEBUG 2012-11-19 23:00:19.211 [UPNP-AliveMessageSender] Sending ALIVE...
DEBUG 2012-11-19 23:00:27.046 [New I/O server worker #1-4] Could not parse year "utc 2011-02-25 07:00:00"
DEBUG 2012-11-19 23:00:27.514 [New I/O server worker #1-4] No encoding detected for M:\Movie-M-drive\Action\Kamui-cd1.sub.
DEBUG 2012-11-19 23:00:27.702 [New I/O server worker #1-4] No encoding detected for M:\Movie-M-drive\Action\Kamui-cd2.sub.
DEBUG 2012-11-19 23:00:30.224 [New I/O server worker #1-4] No encoding detected for M:\Movie-M-drive\Action\Thunderbolt(1995)-cd1.sub.
DEBUG 2012-11-19 23:00:30.424 [New I/O server worker #1-4] No encoding detected for M:\Movie-M-drive\Action\Thunderbolt(1995)-cd2.sub.
DEBUG 2012-11-19 23:00:35.461 [pool-19-thread-1] Duplicate A.Dangerous.Man.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.461 [pool-19-thread-3] Duplicate Angel.And.The.Badman.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.461 [pool-19-thread-2] Duplicate Against.The.Dark.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.461 [pool-19-thread-1] Duplicate Armored.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.477 [pool-19-thread-2] Duplicate Bad.Boys.mp4 for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.477 [pool-19-thread-3] Duplicate Bad.Boys.II.mp4 for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.477 [pool-19-thread-3] Duplicate Blade.II(2002).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.477 [pool-19-thread-2] Duplicate Blade.Trinity(2004).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.477 [pool-19-thread-1] Duplicate Born.To.Raise.Hell(2010).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.477 [pool-19-thread-1] Duplicate Bunraku(2010).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.477 [pool-19-thread-2] Duplicate Cash.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.477 [pool-19-thread-3] Duplicate Casino.Royale(2006).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.477 [pool-19-thread-1] Duplicate Chocolate.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.477 [pool-19-thread-2] Duplicate City.Hunter.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.477 [pool-19-thread-1] Duplicate Crank.2.Hi.Voltage(2009).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.492 [pool-19-thread-3] Duplicate Death.Race.cd1.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.492 [pool-19-thread-2] Duplicate Death.Race.cd2.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.492 [pool-19-thread-3] Duplicate Dragon.Eyes(2012).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.492 [pool-19-thread-3] Duplicate Eraser.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.492 [pool-19-thread-2] Duplicate Fast.Five(2011).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.492 [pool-19-thread-3] Duplicate Fire.of.conscience.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.492 [pool-19-thread-3] Duplicate G.I.Joe.The.Rise.Of.Cobra.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.492 [pool-19-thread-2] Duplicate Game.Of.Death(2010).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.492 [pool-19-thread-1] Duplicate Hellbinders.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.492 [pool-19-thread-1] Duplicate Iron.Man(2008).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.492 [pool-19-thread-3] Duplicate Kamui-cd1.avi for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.492 [pool-19-thread-2] Duplicate Kamui-cd2.avi for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.492 [pool-19-thread-3] Duplicate Les.Formidables.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.492 [pool-19-thread-2] Duplicate Limitless(2011).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.492 [pool-19-thread-3] Duplicate Mission.Impossible.1(1996).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.492 [pool-19-thread-2] Duplicate Mission.Impossible.2(2000).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.492 [pool-19-thread-1] Duplicate Mission.Impossible.4.Ghost.Protocol(2011).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.492 [pool-19-thread-1] Duplicate My.Wife.Is.A.Gangster.3.avi for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.492 [pool-19-thread-2] Duplicate Nude.Nuns.with.Big.Guns(2010).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.492 [pool-19-thread-1] Duplicate Ocean's 11.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.492 [pool-19-thread-2] Duplicate Ocean's 12.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.492 [pool-19-thread-1] Duplicate Ocean's.13.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.508 [pool-19-thread-1] Duplicate Operation.Condor.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.508 [pool-19-thread-1] Duplicate Paintball.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.508 [pool-19-thread-1] Duplicate Priest(2011).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.508 [pool-19-thread-2] Duplicate Project.A.2(1987).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.508 [pool-19-thread-1] Duplicate Project.A(1983).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.508 [pool-19-thread-2] Duplicate Quantum.of.Solace(2008).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.508 [pool-19-thread-1] Duplicate Rampage.avi for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.508 [pool-19-thread-3] Duplicate Mission.Impossible.3(2006).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.508 [pool-19-thread-2] Duplicate Real.Steel(2011).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.508 [pool-19-thread-1] Duplicate Recoil(2011).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.508 [pool-19-thread-1] Duplicate Repo.Men.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.508 [pool-19-thread-3] Duplicate Rush.Hour.1.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.508 [pool-19-thread-3] Duplicate Rush.Hour.3.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.508 [pool-19-thread-1] Duplicate Salt.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.508 [pool-19-thread-3] Duplicate Shoot.Em.Up.Wide.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.508 [pool-19-thread-3] Duplicate Snatch.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.508 [pool-19-thread-1] Duplicate Smokin.Aces.2.Assassins.Ball.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.508 [pool-19-thread-2] Duplicate Rush.Hour.2.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.508 [pool-19-thread-3] Duplicate Sniper(2011).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.508 [pool-19-thread-2] Duplicate Special.Forces(2011).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.508 [pool-19-thread-1] Duplicate Steve.McQueen.Bullit.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.508 [pool-19-thread-3] Duplicate Steve.McQueen.The.Cincinnati.Kid.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.508 [pool-19-thread-2] Duplicate Steve.McQueen.The.Getaway.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.508 [pool-19-thread-1] Duplicate The.Bank.Job.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.508 [pool-19-thread-3] Duplicate The.Burma.Conspiracy(2011).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.508 [pool-19-thread-2] Duplicate The.Expendables(2010).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.508 [pool-19-thread-1] Duplicate The.Italian.Job.1969.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.508 [pool-19-thread-3] Duplicate The.Italian.Job.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.508 [pool-19-thread-1] Duplicate The.Keeper.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.508 [pool-19-thread-3] Duplicate The.Mechanic(1972).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.508 [pool-19-thread-2] Duplicate The.Mechanic(2011).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.508 [pool-19-thread-1] Duplicate The.Mechanik.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.508 [pool-19-thread-1] Duplicate The.Outlaw.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.508 [pool-19-thread-3] Duplicate The.Phanton.CD1.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.508 [pool-19-thread-2] Duplicate The.Phanton.CD2.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.508 [pool-19-thread-1] Duplicate The.Shepherd.Border.Patrol.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.524 [pool-19-thread-3] Duplicate The.Spy.Next.Door.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.524 [pool-19-thread-2] Duplicate The.Tournament.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.524 [pool-19-thread-1] Duplicate The.Warriors.Way(2010).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.524 [pool-19-thread-2] Duplicate Thunderbolt(1995)-cd1.avi for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.524 [pool-19-thread-3] Duplicate Thunderbolt(1995)-cd2.avi for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.524 [pool-19-thread-1] Duplicate Tower.Heist(2011).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.524 [pool-19-thread-3] Duplicate Undisputed.III-Redemption.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.524 [pool-19-thread-1] Duplicate Universal.Soldier.Regeneration.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.524 [pool-19-thread-3] Duplicate Unstoppable(2010).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.524 [pool-19-thread-1] Duplicate Wedlock.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.524 [pool-19-thread-3] Duplicate xXx.State.Of.The.Union.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-19 23:00:35.524 [pool-19-thread-2] Duplicate xXx.mkv for direct streaming to renderer: Philips TV
INFO  2012-11-19 23:01:10.741 [New I/O server worker #1-8] Starting transcode/remux of Quantum.of.Solace(2008).mkv
DEBUG 2012-11-19 23:01:10.819 [New I/O server worker #1-8] Creating pipe \\.\pipe\mencoder1353362470819
DEBUG 2012-11-19 23:01:10.850 [Thread-16] Waiting for pipe connection \\.\pipe\mencoder1353362470819
DEBUG 2012-11-19 23:01:10.913 [mencoder.exe-1] Starting "C:\Program Files (x86)\Universal Media Server\win32\mencoder.exe" -ss 0 M:\Movie-M-drive\Action\Quantum.of.Solace(2008).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=448:threads=4:keyint=5:vqscale=1:vqmin=1:vrc_maxrate=36000:vrc_buf_size=7000 -ass -ass-color ffffff00 -ass-border-color 00000000 -ass-font-scale 1.4 -font C:\Windows\Fonts\Arial.ttf -ass-force-style FontName=C:\Windows\Fonts\Arial.ttf,Outline=1,Shadow=1,MarginV=10 -fontconfig -sid 0 -ofps 24000/1001 -lavdopts fast -mc 0 -noskip -af lavcresample=48000 -srate 48000 -o \\.\pipe\mencoder1353362470819
DEBUG 2012-11-19 23:01:11.428 [mencoder.exe-1] Reading pipe: \\.\pipe\mencoder1353362470819
DEBUG 2012-11-19 23:01:11.428 [mencoder.exe-1] Attaching thread: mencoder.exe-1
DEBUG 2012-11-19 23:01:11.521 [Thread-20] MEncoder SB37 (C) 2000-2012 MPlayer Team
DEBUG 2012-11-19 23:01:11.521 [Thread-20] Custom build by SubJunk, http://www.spirton.com
DEBUG 2012-11-19 23:01:11.521 [Thread-20] 
DEBUG 2012-11-19 23:01:11.521 [Thread-20] success: format: 0  data: 0x0 - 0x4997a96f
DEBUG 2012-11-19 23:01:11.521 [Thread-20] libavformat version 54.25.105 (internal)
DEBUG 2012-11-19 23:01:11.521 [Thread-20] libavformat file format detected.
DEBUG 2012-11-19 23:01:11.537 [Thread-20] [lavf] stream 0: video (h264), -vid 0
DEBUG 2012-11-19 23:01:11.537 [Thread-20] [lavf] stream 1: audio (aac), -aid 0, -alang eng
DEBUG 2012-11-19 23:01:11.537 [Thread-20] [lavf] stream 2: subtitle (subrip), -sid 0, -slang nld
DEBUG 2012-11-19 23:01:11.537 [Thread-20] VIDEO:  [H264]  1920x800  0bpp  23.976 fps    0.0 kbps ( 0.0 kbyte/s)
DEBUG 2012-11-19 23:01:11.537 [Thread-20] [V] filefmt:44  fourcc:0x34363248  size:1920x800  fps:23.976  ftime:=0.0417
DEBUG 2012-11-19 23:01:11.537 [Thread-20] ==========================================================================
DEBUG 2012-11-19 23:01:11.537 [Thread-20] Opening audio decoder: [ffmpeg] FFmpeg/libavcodec audio decoders
DEBUG 2012-11-19 23:01:11.537 [Thread-20] libavcodec version 54.55.100 (internal)
DEBUG 2012-11-19 23:01:11.537 [Thread-20] AUDIO: 48000 Hz, 2 ch, s16le, 0.0 kbit/0.00% (ratio: 0->192000)
DEBUG 2012-11-19 23:01:11.537 [Thread-20] Selected audio codec: [ffaac] afm: ffmpeg (FFmpeg AAC (MPEG-2/MPEG-4 Audio))
DEBUG 2012-11-19 23:01:11.552 [Thread-20] ==========================================================================
DEBUG 2012-11-19 23:01:11.552 [Thread-16] Result of \\.\pipe\mencoder1353362470819 : true
DEBUG 2012-11-19 23:01:11.553 [Thread-20] PACKET SIZE: 2048 bytes, deltascr: 884
DEBUG 2012-11-19 23:01:11.554 [Thread-20] Opening video filter: [ass auto=1]
DEBUG 2012-11-19 23:01:11.554 [Thread-20] [ass] auto-open
DEBUG 2012-11-19 23:01:11.570 [Thread-20] ==========================================================================
DEBUG 2012-11-19 23:01:11.572 [Thread-20] Opening video decoder: [ffmpeg] FFmpeg's libavcodec codec family
DEBUG 2012-11-19 23:01:11.574 [Thread-20] Selected video codec: [ffh264] vfm: ffmpeg (FFmpeg H.264)
DEBUG 2012-11-19 23:01:11.575 [Thread-20] ==========================================================================
DEBUG 2012-11-19 23:01:11.575 [Thread-19] [ac3 @ 0113d3c0]channel_layout not specified
DEBUG 2012-11-19 23:01:11.575 [Thread-19] [ac3 @ 0113d3c0]No channel layout specified. The encoder will guess the layout, but it might be incorrect.
DEBUG 2012-11-19 23:01:11.576 [Thread-19] Limiting audio preload to 0.4s.
DEBUG 2012-11-19 23:01:11.576 [Thread-19] Increasing audio density to 4.
DEBUG 2012-11-19 23:01:11.579 [Thread-19] Unsupported PixelFormat 61
DEBUG 2012-11-19 23:01:11.579 [Thread-19] Unsupported PixelFormat 53
DEBUG 2012-11-19 23:01:11.579 [Thread-19] Unsupported PixelFormat 81
DEBUG 2012-11-19 23:01:11.605 [Thread-20] Movie-Aspect is 2.40:1 - prescaling to correct movie aspect.
DEBUG 2012-11-19 23:01:11.605 [Thread-20] videocodec: libavcodec (1920x800 fourcc=3267706d [mpg2])
DEBUG 2012-11-19 23:01:11.605 [Thread-20] [VE_LAVC] Using constant qscale = 1.000000 (VBR).
DEBUG 2012-11-19 23:01:11.647 [Thread-20] Writing header...
DEBUG 2012-11-19 23:01:11.647 [Thread-20] INITV: 0.200, 0.158, fps: 23.976
DEBUG 2012-11-19 23:01:11.647 [Thread-20] 
INFO  2012-11-19 23:01:17.025 [StartPlaying Event] renderer: 192.168.31.102, file: M:\Movie-M-drive\Action\Quantum.of.Solace(2008).mkv
DEBUG 2012-11-19 23:01:44.821 [New I/O server worker #1-2] Setting margin to 2Mb
DEBUG 2012-11-19 23:02:16.552 [Thread-19] [ass] PlayResX undefined, setting to 384
DEBUG 2012-11-19 23:03:24.834 [UPNP-AliveMessageSender] Sending ALIVE...
DEBUG 2012-11-19 23:04:51.824 [Buffered IO End Checker] Stopping process: mencoder.exe-1
INFO  2012-11-19 23:04:53.333 [StopPlaying Event] renderer: 192.168.31.102, file: M:\Movie-M-drive\Action\Quantum.of.Solace(2008).mkv
DEBUG 2012-11-19 23:05:13.010 [UPNP-AliveMessageSender] Error while sending periodic alive message: sleep interrupted
INFO  2012-11-19 23:05:13.010 [PMS Listeners Stopper] Sending BYEBYE...
DEBUG 2012-11-19 23:05:16.685 [PMS Listeners Stopper] Forcing shutdown of all active processes
INFO  2012-11-19 23:05:16.685 [PMS Listeners Stopper] Stopping server on host 192.168.31.100 and port 5001...

Re: Issue with mencoder.exe of UMS 2.0.0 build

Posted: Tue Nov 20, 2012 11:10 am
by SubJunk
Thanks! Next one:

Re: Issue with mencoder.exe of UMS 2.0.0 build

Posted: Tue Nov 20, 2012 11:25 am
by SpeedyQ
Now the problem is back; start of the film only one short dropout in sound but it get worse while the movie progresses. After a minute or so one big dropout, and then short bursts of dropouts, althoug the sound stays in sync with the movie.

Re: Issue with mencoder.exe of UMS 2.0.0 build

Posted: Tue Nov 20, 2012 12:00 pm
by SubJunk
Great! Another one:

Re: Issue with mencoder.exe of UMS 2.0.0 build

Posted: Tue Nov 20, 2012 12:16 pm
by SpeedyQ
Well, this one is ok again... :)

Code: Select all

DEBUG 2012-11-20 01:09:27.191 [WrapperSimpleAppMain] My PID is 4876
INFO  2012-11-20 01:09:28.283 [WrapperSimpleAppMain] An invalid plugin was ignored
INFO  2012-11-20 01:09:28.580 [WrapperSimpleAppMain] Starting Universal Media Server 2.0.0
INFO  2012-11-20 01:09:28.595 [WrapperSimpleAppMain] Based on PS3 Media Server by shagrath, copyright 2008-2012
INFO  2012-11-20 01:09:28.595 [WrapperSimpleAppMain] http://www.universalmediaserver.com
INFO  2012-11-20 01:09:28.595 [WrapperSimpleAppMain] 
INFO  2012-11-20 01:09:28.595 [WrapperSimpleAppMain] Build: 9456e1544 (2012-10-31)
INFO  2012-11-20 01:09:28.595 [WrapperSimpleAppMain] Java: 1.7.0_02-Oracle Corporation
INFO  2012-11-20 01:09:28.595 [WrapperSimpleAppMain] OS: Windows 7 64-bit 6.1
INFO  2012-11-20 01:09:28.595 [WrapperSimpleAppMain] Encoding: Cp1252
INFO  2012-11-20 01:09:28.595 [WrapperSimpleAppMain] Memory: 2730 MB
INFO  2012-11-20 01:09:28.595 [WrapperSimpleAppMain] 
INFO  2012-11-20 01:09:28.595 [WrapperSimpleAppMain] Working directory: C:\Program Files (x86)\Universal Media Server
INFO  2012-11-20 01:09:28.611 [WrapperSimpleAppMain] Temp directory: C:\Windows\TEMP\universalmediaserver
INFO  2012-11-20 01:09:28.611 [WrapperSimpleAppMain] Logging config file: C:\Program Files (x86)\Universal Media Server\logback.xml
INFO  2012-11-20 01:09:28.611 [WrapperSimpleAppMain] debug.log: C:\Program Files (x86)\Universal Media Server\debug.log
INFO  2012-11-20 01:09:28.611 [WrapperSimpleAppMain] 
INFO  2012-11-20 01:09:28.611 [WrapperSimpleAppMain] Profile directory: C:\ProgramData\UMS
INFO  2012-11-20 01:09:28.611 [WrapperSimpleAppMain] Profile path: C:\ProgramData\UMS\UMS.conf
INFO  2012-11-20 01:09:28.611 [WrapperSimpleAppMain] Profile permissions: rw
INFO  2012-11-20 01:09:28.611 [WrapperSimpleAppMain] Profile name: MediaServer2009
INFO  2012-11-20 01:09:28.611 [WrapperSimpleAppMain] 
INFO  2012-11-20 01:09:28.611 [WrapperSimpleAppMain] Loading MediaInfo library
INFO  2012-11-20 01:09:28.704 [WrapperSimpleAppMain] Loaded MediaInfoLib - v0.7.61
INFO  2012-11-20 01:09:28.704 [WrapperSimpleAppMain] Loading renderer configurations from C:\Program Files (x86)\Universal Media Server\renderers
INFO  2012-11-20 01:09:28.704 [WrapperSimpleAppMain] Loading configuration file: AirPlayer.conf
INFO  2012-11-20 01:09:28.720 [WrapperSimpleAppMain] Loading configuration file: Android.conf
INFO  2012-11-20 01:09:28.720 [WrapperSimpleAppMain] Loading configuration file: Bravia4500.conf
INFO  2012-11-20 01:09:28.720 [WrapperSimpleAppMain] Loading configuration file: Bravia5500.conf
INFO  2012-11-20 01:09:28.720 [WrapperSimpleAppMain] Loading configuration file: BraviaEX.conf
INFO  2012-11-20 01:09:28.736 [WrapperSimpleAppMain] Loading configuration file: DirecTVHR.conf
INFO  2012-11-20 01:09:28.736 [WrapperSimpleAppMain] Loading configuration file: DLinkDSM510.conf
INFO  2012-11-20 01:09:28.736 [WrapperSimpleAppMain] Loading configuration file: FreeboxHD.conf
INFO  2012-11-20 01:09:28.751 [WrapperSimpleAppMain] Loading configuration file: FreecomMusicPal.conf
INFO  2012-11-20 01:09:28.751 [WrapperSimpleAppMain] Loading configuration file: iPad-iPhone.conf
INFO  2012-11-20 01:09:28.751 [WrapperSimpleAppMain] Loading configuration file: Kuro.conf
INFO  2012-11-20 01:09:28.751 [WrapperSimpleAppMain] Loading configuration file: LGST600.conf
INFO  2012-11-20 01:09:28.767 [WrapperSimpleAppMain] Loading configuration file: N900.conf
INFO  2012-11-20 01:09:28.767 [WrapperSimpleAppMain] Loading configuration file: OPPOBDP83.conf
INFO  2012-11-20 01:09:28.767 [WrapperSimpleAppMain] Loading configuration file: OPPOBDP93.conf
INFO  2012-11-20 01:09:28.767 [WrapperSimpleAppMain] Loading configuration file: Panasonic.conf
INFO  2012-11-20 01:09:28.782 [WrapperSimpleAppMain] Loading configuration file: Philips.conf
INFO  2012-11-20 01:09:28.782 [WrapperSimpleAppMain] Loading configuration file: PhilipsPFL.conf
INFO  2012-11-20 01:09:28.798 [WrapperSimpleAppMain] Loading configuration file: PopcornHour.conf
INFO  2012-11-20 01:09:28.798 [WrapperSimpleAppMain] Loading configuration file: PS3.conf
INFO  2012-11-20 01:09:28.798 [WrapperSimpleAppMain] Loading configuration file: Realtek.conf
INFO  2012-11-20 01:09:28.798 [WrapperSimpleAppMain] Loading configuration file: Samsung-SMT-G7400.conf
INFO  2012-11-20 01:09:28.814 [WrapperSimpleAppMain] Loading configuration file: SamsungAllShare.conf
INFO  2012-11-20 01:09:28.814 [WrapperSimpleAppMain] Loading configuration file: SamsungWiseLink.conf
INFO  2012-11-20 01:09:28.814 [WrapperSimpleAppMain] Loading configuration file: Showtime3.conf
INFO  2012-11-20 01:09:28.829 [WrapperSimpleAppMain] Loading configuration file: SMP-N100.conf
INFO  2012-11-20 01:09:28.829 [WrapperSimpleAppMain] Loading configuration file: SonyBluray.conf
INFO  2012-11-20 01:09:28.829 [WrapperSimpleAppMain] Loading configuration file: SonyBraviaHX800.conf
INFO  2012-11-20 01:09:28.845 [WrapperSimpleAppMain] Loading configuration file: Streamium.conf
INFO  2012-11-20 01:09:28.845 [WrapperSimpleAppMain] Loading configuration file: WDTVLive.conf
INFO  2012-11-20 01:09:28.845 [WrapperSimpleAppMain] Loading configuration file: WMP.conf
INFO  2012-11-20 01:09:28.845 [WrapperSimpleAppMain] Loading configuration file: XBMC.conf
INFO  2012-11-20 01:09:28.845 [WrapperSimpleAppMain] Loading configuration file: XBOX360.conf
INFO  2012-11-20 01:09:28.860 [WrapperSimpleAppMain] Loading configuration file: YamahaRXA1010.conf
INFO  2012-11-20 01:09:28.860 [WrapperSimpleAppMain] Loading configuration file: YamahaRXV671.conf
INFO  2012-11-20 01:09:28.860 [WrapperSimpleAppMain] Checking MPlayer font cache. It can take a minute or so.
DEBUG 2012-11-20 01:09:28.860 [WrapperSimpleAppMain] launching: win32/mplayer.exe
DEBUG 2012-11-20 01:09:29.002 [WrapperSimpleAppMain] launching: win32/mplayer.exe
INFO  2012-11-20 01:09:29.128 [WrapperSimpleAppMain] Done!
INFO  2012-11-20 01:09:29.128 [WrapperSimpleAppMain] Found VideoLAN version 1.1.5 at: C:\Program Files (x86)\VideoLAN\VLC\vlc.exe
INFO  2012-11-20 01:09:29.128 [WrapperSimpleAppMain] Searching for plugins in C:\Program Files (x86)\Universal Media Server\plugins
INFO  2012-11-20 01:09:29.143 [WrapperSimpleAppMain] Found plugin: net.sharkhunter.gmusic.Gm_plugin
INFO  2012-11-20 01:09:29.143 [WrapperSimpleAppMain] Found plugin: net.pms.movieinfo.MovieInfo
INFO  2012-11-20 01:09:29.143 [WrapperSimpleAppMain] Found plugin: com.chocolatey.pmsencoder.Plugin
INFO  2012-11-20 01:09:29.159 [WrapperSimpleAppMain] Found plugin: com.sharkhunter.channel.CH_plugin
INFO  2012-11-20 01:09:29.174 [WrapperSimpleAppMain] PMSEncoder: initializing PMSEncoder 1.6.2
INFO  2012-11-20 01:09:29.221 [WrapperSimpleAppMain] PMSEncoder: script directory: C:\Program Files (x86)\Universal Media Server\scripts
INFO  2012-11-20 01:09:29.237 [WrapperSimpleAppMain] PMSEncoder: log directory: C:\Program Files (x86)\Universal Media Server
INFO  2012-11-20 01:09:29.237 [WrapperSimpleAppMain] PMSEncoder: loading built-in log4j config file: jar:file:/C:/Program%20Files%20(x86)/Universal%20Media%20Server/plugins/pmsencoder-1.6.2.jar!/log4j_default.xml
INFO  2012-11-20 01:09:31.499 [WrapperSimpleAppMain] Registering transcoding engine: PMSEncoder
INFO  2012-11-20 01:09:31.499 [WrapperSimpleAppMain] PMSEncoder: checking engine list: [pmsencoder, mencoder, ffmpegaudio, mplayeraudio, tsmuxeraudio, ffmpegwebvideo, vlcvideo, mencoderwebvideo, mplayervideodump, mplayerwebaudio, vlcaudio, ffmpegdvrmsremux, rawthumbs]
INFO  2012-11-20 01:09:31.499 [WrapperSimpleAppMain] PMSEncoder: already enabled
INFO  2012-11-20 01:09:31.499 [WrapperSimpleAppMain] Registering transcoding engine: AviSynth/FFmpeg
INFO  2012-11-20 01:09:31.499 [WrapperSimpleAppMain] Registering transcoding engine: FFmpeg Audio
INFO  2012-11-20 01:09:31.514 [WrapperSimpleAppMain] Registering transcoding engine: MEncoder
INFO  2012-11-20 01:09:31.514 [WrapperSimpleAppMain] Registering transcoding engine: AviSynth/MEncoder
INFO  2012-11-20 01:09:31.514 [WrapperSimpleAppMain] Registering transcoding engine: FFmpeg
INFO  2012-11-20 01:09:31.514 [WrapperSimpleAppMain] Registering transcoding engine: MPlayer Audio
INFO  2012-11-20 01:09:31.514 [WrapperSimpleAppMain] Registering transcoding engine: FFmpeg Web Video
INFO  2012-11-20 01:09:31.514 [WrapperSimpleAppMain] Registering transcoding engine: MEncoder Web
INFO  2012-11-20 01:09:31.514 [WrapperSimpleAppMain] Registering transcoding engine: MPlayer Video Dump
INFO  2012-11-20 01:09:31.514 [WrapperSimpleAppMain] Registering transcoding engine: MPlayer Web
INFO  2012-11-20 01:09:31.514 [WrapperSimpleAppMain] Registering transcoding engine: tsMuxeR
INFO  2012-11-20 01:09:31.514 [WrapperSimpleAppMain] Registering transcoding engine: Audio High Fidelity
DEBUG 2012-11-20 01:09:31.514 [WrapperSimpleAppMain] Found VLC version 1.1.5 in Windows Registry: C:\Program Files (x86)\VideoLAN\VLC\vlc.exe
DEBUG 2012-11-20 01:09:31.514 [WrapperSimpleAppMain] Found VLC version 1.1.5 in Windows Registry: C:\Program Files (x86)\VideoLAN\VLC\vlc.exe
DEBUG 2012-11-20 01:09:31.514 [WrapperSimpleAppMain] Found VLC version 1.1.5 in Windows Registry: C:\Program Files (x86)\VideoLAN\VLC\vlc.exe
DEBUG 2012-11-20 01:09:31.514 [WrapperSimpleAppMain] Found VLC version 1.1.5 in Windows Registry: C:\Program Files (x86)\VideoLAN\VLC\vlc.exe
INFO  2012-11-20 01:09:31.514 [WrapperSimpleAppMain] Registering transcoding engine: VLC Audio Streaming
DEBUG 2012-11-20 01:09:31.514 [WrapperSimpleAppMain] Found VLC version 1.1.5 in Windows Registry: C:\Program Files (x86)\VideoLAN\VLC\vlc.exe
DEBUG 2012-11-20 01:09:31.514 [WrapperSimpleAppMain] Found VLC version 1.1.5 in Windows Registry: C:\Program Files (x86)\VideoLAN\VLC\vlc.exe
DEBUG 2012-11-20 01:09:31.514 [WrapperSimpleAppMain] Found VLC version 1.1.5 in Windows Registry: C:\Program Files (x86)\VideoLAN\VLC\vlc.exe
DEBUG 2012-11-20 01:09:31.514 [WrapperSimpleAppMain] Found VLC version 1.1.5 in Windows Registry: C:\Program Files (x86)\VideoLAN\VLC\vlc.exe
INFO  2012-11-20 01:09:31.514 [WrapperSimpleAppMain] Registering transcoding engine: VLC Video Streaming
INFO  2012-11-20 01:09:31.514 [WrapperSimpleAppMain] Registering transcoding engine: FFmpeg DVR-MS Remux
INFO  2012-11-20 01:09:31.514 [WrapperSimpleAppMain] Registering transcoding engine: dcraw Thumbnailer
INFO  2012-11-20 01:09:31.530 [WrapperSimpleAppMain] GoogleMusic plugin missing credentials
INFO  2012-11-20 01:09:31.561 [WrapperSimpleAppMain] Start channel 2.05
INFO  2012-11-20 01:09:31.624 [WrapperSimpleAppMain] Configuration saved to: C:\ProgramData\UMS\UMS.conf
INFO  2012-11-20 01:09:31.780 [WrapperSimpleAppMain] Using address /192.168.31.100 found on network interface: name:eth3 (Realtek RTL8168C(P)/8111C(P) Family PCI-E Gigabit Ethernet NIC (NDIS 6.20))
INFO  2012-11-20 01:09:31.780 [WrapperSimpleAppMain] Created socket: /192.168.31.100:5001
INFO  2012-11-20 01:09:31.873 [WrapperSimpleAppMain] Checking shared folder: D:\Movie-D-drive
INFO  2012-11-20 01:09:31.873 [WrapperSimpleAppMain] Checking shared folder: F:\Movie-F-drive
INFO  2012-11-20 01:09:31.873 [WrapperSimpleAppMain] Checking shared folder: M:\Movie-M-drive
INFO  2012-11-20 01:09:31.873 [WrapperSimpleAppMain] Checking shared folder: F:\Music
ERROR 2012-11-20 01:09:31.936 [WrapperSimpleAppMain] Attempt to add a null child to root
java.lang.NullPointerException: Invalid DLNA resource
	at net.pms.dlna.DLNAResource.addChild(DLNAResource.java:450) [ums.jar:na]
	at net.pms.dlna.RootFolder.discoverChildren(RootFolder.java:148) [ums.jar:na]
	at net.pms.configuration.RendererConfiguration.getRootFolder(RendererConfiguration.java:198) [ums.jar:na]
	at net.pms.PMS.getRootFolder(PMS.java:110) [ums.jar:na]
	at net.pms.PMS.init(PMS.java:510) [ums.jar:na]
	at net.pms.PMS.createInstance(PMS.java:858) [ums.jar:na]
	at net.pms.PMS.main(PMS.java:933) [ums.jar:na]
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.7.0_02]
	at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source) ~[na:1.7.0_02]
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) ~[na:1.7.0_02]
	at java.lang.reflect.Method.invoke(Unknown Source) ~[na:1.7.0_02]
	at org.tanukisoftware.wrapper.WrapperSimpleApp.run(WrapperSimpleApp.java:290) [wrapper.jar:3.5.15]
	at java.lang.Thread.run(Unknown Source) [na:1.7.0_02]
DEBUG 2012-11-20 01:09:31.982 [WrapperSimpleAppMain] Sending ALIVE...
INFO  2012-11-20 01:09:32.045 [WrapperSimpleAppMain] Using the following UUID configured in UMS.conf: ebbb7981-ccd8-3252-ad23-83e32f84c363
INFO  2012-11-20 01:09:39.082 [WrapperSimpleAppMain] The server should now appear on your renderer
DEBUG 2012-11-20 01:09:49.098 [UPNP-AliveMessageSender] Sending ALIVE...
INFO  2012-11-20 01:10:05.528 [UPNPHelper] No IP filter specified, access granted to /192.168.31.102
INFO  2012-11-20 01:10:05.746 [pool-7-thread-1] Checking IP: 192.168.31.102 for Philips TV
INFO  2012-11-20 01:10:10.317 [New I/O server worker #1-4] Checking shared folder: D:\Movie-D-drive
INFO  2012-11-20 01:10:10.317 [New I/O server worker #1-4] Checking shared folder: F:\Movie-F-drive
INFO  2012-11-20 01:10:10.317 [New I/O server worker #1-4] Checking shared folder: M:\Movie-M-drive
INFO  2012-11-20 01:10:10.317 [New I/O server worker #1-4] Checking shared folder: F:\Music
ERROR 2012-11-20 01:10:10.317 [New I/O server worker #1-4] Attempt to add a null child to root
java.lang.NullPointerException: Invalid DLNA resource
	at net.pms.dlna.DLNAResource.addChild(DLNAResource.java:450) [ums.jar:na]
	at net.pms.dlna.RootFolder.discoverChildren(RootFolder.java:148) [ums.jar:na]
	at net.pms.configuration.RendererConfiguration.getRootFolder(RendererConfiguration.java:198) [ums.jar:na]
	at net.pms.PMS.getRootFolder(PMS.java:110) [ums.jar:na]
	at net.pms.network.RequestV2.answer(RequestV2.java:628) [ums.jar:na]
	at net.pms.network.RequestHandlerV2.writeResponse(RequestHandlerV2.java:299) [ums.jar:na]
	at net.pms.network.RequestHandlerV2.messageReceived(RequestHandlerV2.java:257) [ums.jar:na]
	at org.jboss.netty.channel.SimpleChannelUpstreamHandler.handleUpstream(SimpleChannelUpstreamHandler.java:80) [ums.jar:na]
	at org.jboss.netty.channel.DefaultChannelPipeline.sendUpstream(DefaultChannelPipeline.java:564) [ums.jar:na]
	at org.jboss.netty.channel.DefaultChannelPipeline$DefaultChannelHandlerContext.sendUpstream(DefaultChannelPipeline.java:783) [ums.jar:na]
	at org.jboss.netty.handler.stream.ChunkedWriteHandler.handleUpstream(ChunkedWriteHandler.java:149) [ums.jar:na]
	at org.jboss.netty.channel.DefaultChannelPipeline.sendUpstream(DefaultChannelPipeline.java:564) [ums.jar:na]
	at org.jboss.netty.channel.DefaultChannelPipeline$DefaultChannelHandlerContext.sendUpstream(DefaultChannelPipeline.java:783) [ums.jar:na]
	at org.jboss.netty.handler.codec.http.HttpChunkAggregator.messageReceived(HttpChunkAggregator.java:116) [ums.jar:na]
	at org.jboss.netty.channel.SimpleChannelUpstreamHandler.handleUpstream(SimpleChannelUpstreamHandler.java:80) [ums.jar:na]
	at org.jboss.netty.channel.DefaultChannelPipeline.sendUpstream(DefaultChannelPipeline.java:564) [ums.jar:na]
	at org.jboss.netty.channel.DefaultChannelPipeline$DefaultChannelHandlerContext.sendUpstream(DefaultChannelPipeline.java:783) [ums.jar:na]
	at org.jboss.netty.channel.Channels.fireMessageReceived(Channels.java:302) [ums.jar:na]
	at org.jboss.netty.handler.codec.replay.ReplayingDecoder.unfoldAndFireMessageReceived(ReplayingDecoder.java:527) [ums.jar:na]
	at org.jboss.netty.handler.codec.replay.ReplayingDecoder.callDecode(ReplayingDecoder.java:506) [ums.jar:na]
	at org.jboss.netty.handler.codec.replay.ReplayingDecoder.messageReceived(ReplayingDecoder.java:443) [ums.jar:na]
	at org.jboss.netty.channel.SimpleChannelUpstreamHandler.handleUpstream(SimpleChannelUpstreamHandler.java:80) [ums.jar:na]
	at org.jboss.netty.channel.DefaultChannelPipeline.sendUpstream(DefaultChannelPipeline.java:564) [ums.jar:na]
	at org.jboss.netty.channel.DefaultChannelPipeline.sendUpstream(DefaultChannelPipeline.java:559) [ums.jar:na]
	at org.jboss.netty.channel.Channels.fireMessageReceived(Channels.java:274) [ums.jar:na]
	at org.jboss.netty.channel.Channels.fireMessageReceived(Channels.java:261) [ums.jar:na]
	at org.jboss.netty.channel.socket.nio.NioWorker.read(NioWorker.java:351) [ums.jar:na]
	at org.jboss.netty.channel.socket.nio.NioWorker.processSelectedKeys(NioWorker.java:282) [ums.jar:na]
	at org.jboss.netty.channel.socket.nio.NioWorker.run(NioWorker.java:202) [ums.jar:na]
	at org.jboss.netty.util.ThreadRenamingRunnable.run(ThreadRenamingRunnable.java:108) [ums.jar:na]
	at org.jboss.netty.util.internal.DeadLockProofWorker$1.run(DeadLockProofWorker.java:44) [ums.jar:na]
	at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source) [na:1.7.0_02]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source) [na:1.7.0_02]
	at java.lang.Thread.run(Unknown Source) [na:1.7.0_02]
INFO  2012-11-20 01:10:10.332 [New I/O server worker #1-4] Node(com.sharkhunter.channel.Channels) already has an ID=0$6, which is overriden now. The previous parent node was:RootFolder[[MapFile [name=Movie-D-drive, id=0$1, format=null, children=[]], MapFile [name=Movie-F-drive, id=0$2, format=null, children=[]], MapFile [name=Movie-M-drive, id=0$3, format=null, children=[]], MapFile [name=Music, id=0$4, format=null, children=[]], VirtualFolder [id=5, name=Web, full path=0$5, ext=null, discovered=false]]]
INFO  2012-11-20 01:10:10.722 [pool-7-thread-1] Renderer Philips TV found on this address: 192.168.31.102
DEBUG 2012-11-20 01:10:10.722 [pool-7-thread-1] Starting ping -n 3 -l 64000 192.168.31.102
DEBUG 2012-11-20 01:10:12.189 [UPNP-AliveMessageSender] Sending ALIVE...
DEBUG 2012-11-20 01:10:12.723 [SpeedStats Failsafe] Stopping process: ping-0
DEBUG 2012-11-20 01:10:15.098 [New I/O server worker #1-6] Detected encoding for D:\Movie-D-drive\Bad.Ass(2012).srt is WINDOWS-1252.
DEBUG 2012-11-20 01:10:15.179 [New I/O server worker #1-6] Detected encoding for D:\Movie-D-drive\Bad.Ass(2012).srt is WINDOWS-1252.
DEBUG 2012-11-20 01:10:15.870 [New I/O server worker #1-6] Detected encoding for D:\Movie-D-drive\Re-animator(1985).srt is WINDOWS-1252.
DEBUG 2012-11-20 01:10:15.905 [New I/O server worker #1-6] Detected encoding for D:\Movie-D-drive\Re-animator(1985).srt is WINDOWS-1252.
DEBUG 2012-11-20 01:10:23.742 [New I/O server worker #1-4] Could not parse year "utc 2011-02-25 07:00:00"
DEBUG 2012-11-20 01:10:24.210 [New I/O server worker #1-4] No encoding detected for M:\Movie-M-drive\Action\Kamui-cd1.sub.
DEBUG 2012-11-20 01:10:24.397 [New I/O server worker #1-4] No encoding detected for M:\Movie-M-drive\Action\Kamui-cd2.sub.
DEBUG 2012-11-20 01:10:26.924 [New I/O server worker #1-4] No encoding detected for M:\Movie-M-drive\Action\Thunderbolt(1995)-cd1.sub.
DEBUG 2012-11-20 01:10:27.127 [New I/O server worker #1-4] No encoding detected for M:\Movie-M-drive\Action\Thunderbolt(1995)-cd2.sub.
DEBUG 2012-11-20 01:10:31.901 [pool-19-thread-3] Duplicate Angel.And.The.Badman.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.901 [pool-19-thread-2] Duplicate Against.The.Dark.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.901 [pool-19-thread-1] Duplicate A.Dangerous.Man.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.901 [pool-19-thread-2] Duplicate Bad.Boys.mp4 for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.901 [pool-19-thread-1] Duplicate Bad.Boys.II.mp4 for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.901 [pool-19-thread-3] Duplicate Armored.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.916 [pool-19-thread-3] Duplicate Blade.Trinity(2004).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.916 [pool-19-thread-2] Duplicate Blade.II(2002).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.916 [pool-19-thread-1] Duplicate Born.To.Raise.Hell(2010).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.916 [pool-19-thread-1] Duplicate Bunraku(2010).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.916 [pool-19-thread-2] Duplicate Cash.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.916 [pool-19-thread-3] Duplicate Casino.Royale(2006).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.916 [pool-19-thread-2] Duplicate Chocolate.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.916 [pool-19-thread-2] Duplicate City.Hunter.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.916 [pool-19-thread-1] Duplicate Crank.2.Hi.Voltage(2009).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.916 [pool-19-thread-1] Duplicate Death.Race.cd1.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.932 [pool-19-thread-1] Duplicate Death.Race.cd2.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.932 [pool-19-thread-2] Duplicate Dragon.Eyes(2012).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.932 [pool-19-thread-2] Duplicate Fast.Five(2011).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.932 [pool-19-thread-1] Duplicate Eraser.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.932 [pool-19-thread-1] Duplicate Fire.of.conscience.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.932 [pool-19-thread-1] Duplicate G.I.Joe.The.Rise.Of.Cobra.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.932 [pool-19-thread-3] Duplicate Game.Of.Death(2010).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.932 [pool-19-thread-2] Duplicate Hellbinders.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.932 [pool-19-thread-2] Duplicate Iron.Man(2008).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.932 [pool-19-thread-1] Duplicate Kamui-cd1.avi for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.932 [pool-19-thread-3] Duplicate Kamui-cd2.avi for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.932 [pool-19-thread-1] Duplicate Les.Formidables.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.932 [pool-19-thread-3] Duplicate Limitless(2011).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.932 [pool-19-thread-1] Duplicate Mission.Impossible.1(1996).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.932 [pool-19-thread-2] Duplicate Mission.Impossible.2(2000).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.932 [pool-19-thread-1] Duplicate Mission.Impossible.3(2006).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.932 [pool-19-thread-2] Duplicate My.Wife.Is.A.Gangster.3.avi for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.932 [pool-19-thread-3] Duplicate Nude.Nuns.with.Big.Guns(2010).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.932 [pool-19-thread-2] Duplicate Ocean's 11.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.932 [pool-19-thread-1] Duplicate Mission.Impossible.4.Ghost.Protocol(2011).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.932 [pool-19-thread-2] Duplicate Ocean's.13.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.932 [pool-19-thread-2] Duplicate Operation.Condor.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.932 [pool-19-thread-1] Duplicate Paintball.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.932 [pool-19-thread-2] Duplicate Priest(2011).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.932 [pool-19-thread-1] Duplicate Project.A.2(1987).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.932 [pool-19-thread-2] Duplicate Project.A(1983).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.932 [pool-19-thread-1] Duplicate Quantum.of.Solace(2008).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-2] Duplicate Rampage.avi for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-1] Duplicate Real.Steel(2011).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-2] Duplicate Recoil(2011).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-2] Duplicate Repo.Men.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-2] Duplicate Rush.Hour.1.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-1] Duplicate Rush.Hour.2.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-2] Duplicate Rush.Hour.3.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.932 [pool-19-thread-3] Duplicate Ocean's 12.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-2] Duplicate Shoot.Em.Up.Wide.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-1] Duplicate Salt.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-2] Duplicate Smokin.Aces.2.Assassins.Ball.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-2] Duplicate Snatch.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-1] Duplicate Sniper(2011).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-2] Duplicate Special.Forces(2011).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-3] Duplicate Steve.McQueen.Bullit.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-2] Duplicate Steve.McQueen.The.Cincinnati.Kid.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-1] Duplicate Steve.McQueen.The.Getaway.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-3] Duplicate The.Bank.Job.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-2] Duplicate The.Burma.Conspiracy(2011).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-3] Duplicate The.Italian.Job.1969.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-1] Duplicate The.Expendables(2010).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-3] Duplicate The.Italian.Job.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-2] Duplicate The.Keeper.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-3] Duplicate The.Mechanic(1972).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-2] Duplicate The.Mechanic(2011).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-1] Duplicate The.Mechanik.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-3] Duplicate The.Phanton.CD1.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-1] Duplicate The.Outlaw.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-2] Duplicate The.Phanton.CD2.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-3] Duplicate The.Shepherd.Border.Patrol.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-1] Duplicate The.Spy.Next.Door.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-2] Duplicate The.Tournament.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-1] Duplicate The.Warriors.Way(2010).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-3] Duplicate Thunderbolt(1995)-cd1.avi for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-2] Duplicate Thunderbolt(1995)-cd2.avi for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-3] Duplicate Tower.Heist(2011).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-2] Duplicate Undisputed.III-Redemption.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-3] Duplicate Universal.Soldier.Regeneration.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-2] Duplicate Unstoppable(2010).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-3] Duplicate Wedlock.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-3] Duplicate xXx.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 01:10:31.948 [pool-19-thread-1] Duplicate xXx.State.Of.The.Union.mkv for direct streaming to renderer: Philips TV
INFO  2012-11-20 01:11:08.140 [New I/O server worker #1-8] Starting transcode/remux of Quantum.of.Solace(2008).mkv
DEBUG 2012-11-20 01:11:08.218 [New I/O server worker #1-8] Creating pipe \\.\pipe\mencoder1353370268218
DEBUG 2012-11-20 01:11:08.249 [Thread-16] Waiting for pipe connection \\.\pipe\mencoder1353370268218
DEBUG 2012-11-20 01:11:08.311 [mencoder.exe-1] Starting "C:\Program Files (x86)\Universal Media Server\win32\mencoder.exe" -ss 0 M:\Movie-M-drive\Action\Quantum.of.Solace(2008).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=448:threads=4:keyint=5:vqscale=1:vqmin=1:vrc_maxrate=36000:vrc_buf_size=7000 -ass -ass-color ffffff00 -ass-border-color 00000000 -ass-font-scale 1.4 -font C:\Windows\Fonts\Arial.ttf -ass-force-style FontName=C:\Windows\Fonts\Arial.ttf,Outline=1,Shadow=1,MarginV=10 -fontconfig -sid 0 -ofps 24000/1001 -lavdopts fast -mc 0 -noskip -af lavcresample=48000 -srate 48000 -o \\.\pipe\mencoder1353370268218
DEBUG 2012-11-20 01:11:08.623 [mencoder.exe-1] Reading pipe: \\.\pipe\mencoder1353370268218
DEBUG 2012-11-20 01:11:08.623 [mencoder.exe-1] Attaching thread: mencoder.exe-1
DEBUG 2012-11-20 01:11:09.029 [Thread-20] MEncoder SB37 (C) 2000-2012 MPlayer Team
DEBUG 2012-11-20 01:11:09.029 [Thread-20] Custom build by SubJunk, http://www.spirton.com
DEBUG 2012-11-20 01:11:09.029 [Thread-20] 
DEBUG 2012-11-20 01:11:09.044 [Thread-20] success: format: 0  data: 0x0 - 0x4997a96f
DEBUG 2012-11-20 01:11:09.044 [Thread-20] libavformat version 54.26.100 (internal)
DEBUG 2012-11-20 01:11:09.044 [Thread-20] libavformat file format detected.
DEBUG 2012-11-20 01:11:09.062 [Thread-20] [lavf] stream 0: video (h264), -vid 0
DEBUG 2012-11-20 01:11:09.062 [Thread-20] [lavf] stream 1: audio (aac), -aid 0, -alang eng
DEBUG 2012-11-20 01:11:09.062 [Thread-20] [lavf] stream 2: subtitle (subrip), -sid 0, -slang nld
DEBUG 2012-11-20 01:11:09.062 [Thread-20] VIDEO:  [H264]  1920x800  0bpp  23.976 fps    0.0 kbps ( 0.0 kbyte/s)
DEBUG 2012-11-20 01:11:09.062 [Thread-20] [V] filefmt:44  fourcc:0x34363248  size:1920x800  fps:23.976  ftime:=0.0417
DEBUG 2012-11-20 01:11:09.062 [Thread-20] ==========================================================================
DEBUG 2012-11-20 01:11:09.063 [Thread-20] Opening audio decoder: [ffmpeg] FFmpeg/libavcodec audio decoders
DEBUG 2012-11-20 01:11:09.064 [Thread-20] libavcodec version 54.55.100 (internal)
DEBUG 2012-11-20 01:11:09.066 [Thread-20] AUDIO: 48000 Hz, 2 ch, s16le, 0.0 kbit/0.00% (ratio: 0->192000)
DEBUG 2012-11-20 01:11:09.066 [Thread-20] Selected audio codec: [ffaac] afm: ffmpeg (FFmpeg AAC (MPEG-2/MPEG-4 Audio))
DEBUG 2012-11-20 01:11:09.066 [Thread-20] ==========================================================================
DEBUG 2012-11-20 01:11:09.066 [Thread-16] Result of \\.\pipe\mencoder1353370268218 : true
DEBUG 2012-11-20 01:11:09.068 [Thread-20] PACKET SIZE: 2048 bytes, deltascr: 884
DEBUG 2012-11-20 01:11:09.068 [Thread-20] Opening video filter: [ass auto=1]
DEBUG 2012-11-20 01:11:09.068 [Thread-20] [ass] auto-open
DEBUG 2012-11-20 01:11:09.086 [Thread-20] ==========================================================================
DEBUG 2012-11-20 01:11:09.088 [Thread-20] Opening video decoder: [ffmpeg] FFmpeg's libavcodec codec family
DEBUG 2012-11-20 01:11:09.090 [Thread-20] Selected video codec: [ffh264] vfm: ffmpeg (FFmpeg H.264)
DEBUG 2012-11-20 01:11:09.090 [Thread-20] ==========================================================================
DEBUG 2012-11-20 01:11:09.090 [Thread-19] [ac3 @ 011405c0]channel_layout not specified
DEBUG 2012-11-20 01:11:09.090 [Thread-19] [ac3 @ 011405c0]No channel layout specified. The encoder will guess the layout, but it might be incorrect.
DEBUG 2012-11-20 01:11:09.091 [Thread-19] Limiting audio preload to 0.4s.
DEBUG 2012-11-20 01:11:09.091 [Thread-19] Increasing audio density to 4.
DEBUG 2012-11-20 01:11:09.094 [Thread-19] Unsupported PixelFormat 61
DEBUG 2012-11-20 01:11:09.094 [Thread-19] Unsupported PixelFormat 53
DEBUG 2012-11-20 01:11:09.094 [Thread-19] Unsupported PixelFormat 81
DEBUG 2012-11-20 01:11:09.121 [Thread-20] Movie-Aspect is 2.40:1 - prescaling to correct movie aspect.
DEBUG 2012-11-20 01:11:09.121 [Thread-20] videocodec: libavcodec (1920x800 fourcc=3267706d [mpg2])
DEBUG 2012-11-20 01:11:09.122 [Thread-20] [VE_LAVC] Using constant qscale = 1.000000 (VBR).
DEBUG 2012-11-20 01:11:09.161 [Thread-20] Writing header...
DEBUG 2012-11-20 01:11:09.161 [Thread-20] INITV: 0.200, 0.158, fps: 23.976
DEBUG 2012-11-20 01:11:09.161 [Thread-20] 
INFO  2012-11-20 01:11:14.427 [StartPlaying Event] renderer: 192.168.31.102, file: M:\Movie-M-drive\Action\Quantum.of.Solace(2008).mkv
DEBUG 2012-11-20 01:11:43.068 [New I/O server worker #1-2] Setting margin to 2Mb
DEBUG 2012-11-20 01:12:13.290 [Thread-19] [ass] PlayResX undefined, setting to 384
DEBUG 2012-11-20 01:13:16.409 [UPNP-AliveMessageSender] Sending ALIVE...
DEBUG 2012-11-20 01:14:15.536 [Buffered IO End Checker] Stopping process: mencoder.exe-1
INFO  2012-11-20 01:14:17.037 [StopPlaying Event] renderer: 192.168.31.102, file: M:\Movie-M-drive\Action\Quantum.of.Solace(2008).mkv
DEBUG 2012-11-20 01:14:40.313 [UPNP-AliveMessageSender] Error while sending periodic alive message: sleep interrupted
INFO  2012-11-20 01:14:40.313 [PMS Listeners Stopper] Sending BYEBYE...
DEBUG 2012-11-20 01:14:43.701 [PMS Listeners Stopper] Forcing shutdown of all active processes
INFO  2012-11-20 01:14:43.701 [PMS Listeners Stopper] Stopping server on host 192.168.31.100 and port 5001...

Re: Issue with mencoder.exe of UMS 2.0.0 build

Posted: Tue Nov 20, 2012 12:57 pm
by SubJunk
Interesting... Here's another one

Re: Issue with mencoder.exe of UMS 2.0.0 build

Posted: Tue Nov 20, 2012 1:37 pm
by SpeedyQ
And with this one the problem is back again. This was my last test for today as I have got to get some sleep now. Hope you are still narrowing it down :geek: .

Re: Issue with mencoder.exe of UMS 2.0.0 build

Posted: Tue Nov 20, 2012 2:54 pm
by SubJunk
Yup I have an idea of what the cause is now. We'll probably need 3-4 more tests before I've fixed it, then I can release a new version with the fix!

Here's a new version to test when you can:

Re: Issue with mencoder.exe of UMS 2.0.0 build

Posted: Wed Nov 21, 2012 5:58 am
by SpeedyQ
This one runs fine...

Code: Select all

DEBUG 2012-11-20 18:51:57.402 [WrapperSimpleAppMain] My PID is 3128
INFO  2012-11-20 18:51:58.510 [WrapperSimpleAppMain] An invalid plugin was ignored
INFO  2012-11-20 18:51:58.806 [WrapperSimpleAppMain] Starting Universal Media Server 2.0.0
INFO  2012-11-20 18:51:58.822 [WrapperSimpleAppMain] Based on PS3 Media Server by shagrath, copyright 2008-2012
INFO  2012-11-20 18:51:58.822 [WrapperSimpleAppMain] http://www.universalmediaserver.com
INFO  2012-11-20 18:51:58.822 [WrapperSimpleAppMain] 
INFO  2012-11-20 18:51:58.822 [WrapperSimpleAppMain] Build: 9456e1544 (2012-10-31)
INFO  2012-11-20 18:51:58.822 [WrapperSimpleAppMain] Java: 1.7.0_02-Oracle Corporation
INFO  2012-11-20 18:51:58.822 [WrapperSimpleAppMain] OS: Windows 7 64-bit 6.1
INFO  2012-11-20 18:51:58.822 [WrapperSimpleAppMain] Encoding: Cp1252
INFO  2012-11-20 18:51:58.822 [WrapperSimpleAppMain] Memory: 2730 MB
INFO  2012-11-20 18:51:58.822 [WrapperSimpleAppMain] 
INFO  2012-11-20 18:51:58.822 [WrapperSimpleAppMain] Working directory: C:\Program Files (x86)\Universal Media Server
INFO  2012-11-20 18:51:58.837 [WrapperSimpleAppMain] Temp directory: C:\Windows\TEMP\universalmediaserver
INFO  2012-11-20 18:51:58.837 [WrapperSimpleAppMain] Logging config file: C:\Program Files (x86)\Universal Media Server\logback.xml
INFO  2012-11-20 18:51:58.837 [WrapperSimpleAppMain] debug.log: C:\Program Files (x86)\Universal Media Server\debug.log
INFO  2012-11-20 18:51:58.837 [WrapperSimpleAppMain] 
INFO  2012-11-20 18:51:58.837 [WrapperSimpleAppMain] Profile directory: C:\ProgramData\UMS
INFO  2012-11-20 18:51:58.837 [WrapperSimpleAppMain] Profile path: C:\ProgramData\UMS\UMS.conf
INFO  2012-11-20 18:51:58.837 [WrapperSimpleAppMain] Profile permissions: rw
INFO  2012-11-20 18:51:58.837 [WrapperSimpleAppMain] Profile name: MediaServer2009
INFO  2012-11-20 18:51:58.837 [WrapperSimpleAppMain] 
INFO  2012-11-20 18:51:58.837 [WrapperSimpleAppMain] Loading MediaInfo library
INFO  2012-11-20 18:51:58.946 [WrapperSimpleAppMain] Loaded MediaInfoLib - v0.7.61
INFO  2012-11-20 18:51:58.962 [WrapperSimpleAppMain] Loading renderer configurations from C:\Program Files (x86)\Universal Media Server\renderers
INFO  2012-11-20 18:51:58.962 [WrapperSimpleAppMain] Loading configuration file: AirPlayer.conf
INFO  2012-11-20 18:51:58.962 [WrapperSimpleAppMain] Loading configuration file: Android.conf
INFO  2012-11-20 18:51:58.962 [WrapperSimpleAppMain] Loading configuration file: Bravia4500.conf
INFO  2012-11-20 18:51:58.962 [WrapperSimpleAppMain] Loading configuration file: Bravia5500.conf
INFO  2012-11-20 18:51:58.978 [WrapperSimpleAppMain] Loading configuration file: BraviaEX.conf
INFO  2012-11-20 18:51:58.978 [WrapperSimpleAppMain] Loading configuration file: DirecTVHR.conf
INFO  2012-11-20 18:51:58.978 [WrapperSimpleAppMain] Loading configuration file: DLinkDSM510.conf
INFO  2012-11-20 18:51:58.993 [WrapperSimpleAppMain] Loading configuration file: FreeboxHD.conf
INFO  2012-11-20 18:51:58.993 [WrapperSimpleAppMain] Loading configuration file: FreecomMusicPal.conf
INFO  2012-11-20 18:51:58.993 [WrapperSimpleAppMain] Loading configuration file: iPad-iPhone.conf
INFO  2012-11-20 18:51:58.993 [WrapperSimpleAppMain] Loading configuration file: Kuro.conf
INFO  2012-11-20 18:51:59.009 [WrapperSimpleAppMain] Loading configuration file: LGST600.conf
INFO  2012-11-20 18:51:59.009 [WrapperSimpleAppMain] Loading configuration file: N900.conf
INFO  2012-11-20 18:51:59.009 [WrapperSimpleAppMain] Loading configuration file: OPPOBDP83.conf
INFO  2012-11-20 18:51:59.009 [WrapperSimpleAppMain] Loading configuration file: OPPOBDP93.conf
INFO  2012-11-20 18:51:59.009 [WrapperSimpleAppMain] Loading configuration file: Panasonic.conf
INFO  2012-11-20 18:51:59.024 [WrapperSimpleAppMain] Loading configuration file: Philips.conf
INFO  2012-11-20 18:51:59.024 [WrapperSimpleAppMain] Loading configuration file: PhilipsPFL.conf
INFO  2012-11-20 18:51:59.024 [WrapperSimpleAppMain] Loading configuration file: PopcornHour.conf
INFO  2012-11-20 18:51:59.040 [WrapperSimpleAppMain] Loading configuration file: PS3.conf
INFO  2012-11-20 18:51:59.040 [WrapperSimpleAppMain] Loading configuration file: Realtek.conf
INFO  2012-11-20 18:51:59.040 [WrapperSimpleAppMain] Loading configuration file: Samsung-SMT-G7400.conf
INFO  2012-11-20 18:51:59.056 [WrapperSimpleAppMain] Loading configuration file: SamsungAllShare.conf
INFO  2012-11-20 18:51:59.056 [WrapperSimpleAppMain] Loading configuration file: SamsungWiseLink.conf
INFO  2012-11-20 18:51:59.056 [WrapperSimpleAppMain] Loading configuration file: Showtime3.conf
INFO  2012-11-20 18:51:59.056 [WrapperSimpleAppMain] Loading configuration file: SMP-N100.conf
INFO  2012-11-20 18:51:59.056 [WrapperSimpleAppMain] Loading configuration file: SonyBluray.conf
INFO  2012-11-20 18:51:59.071 [WrapperSimpleAppMain] Loading configuration file: SonyBraviaHX800.conf
INFO  2012-11-20 18:51:59.071 [WrapperSimpleAppMain] Loading configuration file: Streamium.conf
INFO  2012-11-20 18:51:59.071 [WrapperSimpleAppMain] Loading configuration file: WDTVLive.conf
INFO  2012-11-20 18:51:59.071 [WrapperSimpleAppMain] Loading configuration file: WMP.conf
INFO  2012-11-20 18:51:59.071 [WrapperSimpleAppMain] Loading configuration file: XBMC.conf
INFO  2012-11-20 18:51:59.087 [WrapperSimpleAppMain] Loading configuration file: XBOX360.conf
INFO  2012-11-20 18:51:59.087 [WrapperSimpleAppMain] Loading configuration file: YamahaRXA1010.conf
INFO  2012-11-20 18:51:59.087 [WrapperSimpleAppMain] Loading configuration file: YamahaRXV671.conf
INFO  2012-11-20 18:51:59.087 [WrapperSimpleAppMain] Checking MPlayer font cache. It can take a minute or so.
DEBUG 2012-11-20 18:51:59.087 [WrapperSimpleAppMain] launching: win32/mplayer.exe
DEBUG 2012-11-20 18:51:59.314 [WrapperSimpleAppMain] launching: win32/mplayer.exe
INFO  2012-11-20 18:51:59.442 [WrapperSimpleAppMain] Done!
INFO  2012-11-20 18:51:59.442 [WrapperSimpleAppMain] Found VideoLAN version 1.1.5 at: C:\Program Files (x86)\VideoLAN\VLC\vlc.exe
INFO  2012-11-20 18:51:59.442 [WrapperSimpleAppMain] Searching for plugins in C:\Program Files (x86)\Universal Media Server\plugins
INFO  2012-11-20 18:51:59.458 [WrapperSimpleAppMain] Found plugin: net.sharkhunter.gmusic.Gm_plugin
INFO  2012-11-20 18:51:59.458 [WrapperSimpleAppMain] Found plugin: net.pms.movieinfo.MovieInfo
INFO  2012-11-20 18:51:59.473 [WrapperSimpleAppMain] Found plugin: com.chocolatey.pmsencoder.Plugin
INFO  2012-11-20 18:51:59.473 [WrapperSimpleAppMain] Found plugin: com.sharkhunter.channel.CH_plugin
INFO  2012-11-20 18:51:59.489 [WrapperSimpleAppMain] PMSEncoder: initializing PMSEncoder 1.6.2
INFO  2012-11-20 18:51:59.551 [WrapperSimpleAppMain] PMSEncoder: script directory: C:\Program Files (x86)\Universal Media Server\scripts
INFO  2012-11-20 18:51:59.551 [WrapperSimpleAppMain] PMSEncoder: log directory: C:\Program Files (x86)\Universal Media Server
INFO  2012-11-20 18:51:59.551 [WrapperSimpleAppMain] PMSEncoder: loading built-in log4j config file: jar:file:/C:/Program%20Files%20(x86)/Universal%20Media%20Server/plugins/pmsencoder-1.6.2.jar!/log4j_default.xml
INFO  2012-11-20 18:52:01.720 [WrapperSimpleAppMain] Registering transcoding engine: PMSEncoder
INFO  2012-11-20 18:52:01.720 [WrapperSimpleAppMain] PMSEncoder: checking engine list: [pmsencoder, mencoder, ffmpegaudio, mplayeraudio, tsmuxeraudio, ffmpegwebvideo, vlcvideo, mencoderwebvideo, mplayervideodump, mplayerwebaudio, vlcaudio, ffmpegdvrmsremux, rawthumbs]
INFO  2012-11-20 18:52:01.720 [WrapperSimpleAppMain] PMSEncoder: already enabled
INFO  2012-11-20 18:52:01.720 [WrapperSimpleAppMain] Registering transcoding engine: AviSynth/FFmpeg
INFO  2012-11-20 18:52:01.720 [WrapperSimpleAppMain] Registering transcoding engine: FFmpeg Audio
INFO  2012-11-20 18:52:01.720 [WrapperSimpleAppMain] Registering transcoding engine: MEncoder
INFO  2012-11-20 18:52:01.720 [WrapperSimpleAppMain] Registering transcoding engine: AviSynth/MEncoder
INFO  2012-11-20 18:52:01.720 [WrapperSimpleAppMain] Registering transcoding engine: FFmpeg
INFO  2012-11-20 18:52:01.720 [WrapperSimpleAppMain] Registering transcoding engine: MPlayer Audio
INFO  2012-11-20 18:52:01.735 [WrapperSimpleAppMain] Registering transcoding engine: FFmpeg Web Video
INFO  2012-11-20 18:52:01.735 [WrapperSimpleAppMain] Registering transcoding engine: MEncoder Web
INFO  2012-11-20 18:52:01.735 [WrapperSimpleAppMain] Registering transcoding engine: MPlayer Video Dump
INFO  2012-11-20 18:52:01.735 [WrapperSimpleAppMain] Registering transcoding engine: MPlayer Web
INFO  2012-11-20 18:52:01.735 [WrapperSimpleAppMain] Registering transcoding engine: tsMuxeR
INFO  2012-11-20 18:52:01.735 [WrapperSimpleAppMain] Registering transcoding engine: Audio High Fidelity
DEBUG 2012-11-20 18:52:01.735 [WrapperSimpleAppMain] Found VLC version 1.1.5 in Windows Registry: C:\Program Files (x86)\VideoLAN\VLC\vlc.exe
DEBUG 2012-11-20 18:52:01.735 [WrapperSimpleAppMain] Found VLC version 1.1.5 in Windows Registry: C:\Program Files (x86)\VideoLAN\VLC\vlc.exe
DEBUG 2012-11-20 18:52:01.735 [WrapperSimpleAppMain] Found VLC version 1.1.5 in Windows Registry: C:\Program Files (x86)\VideoLAN\VLC\vlc.exe
DEBUG 2012-11-20 18:52:01.735 [WrapperSimpleAppMain] Found VLC version 1.1.5 in Windows Registry: C:\Program Files (x86)\VideoLAN\VLC\vlc.exe
INFO  2012-11-20 18:52:01.735 [WrapperSimpleAppMain] Registering transcoding engine: VLC Audio Streaming
DEBUG 2012-11-20 18:52:01.735 [WrapperSimpleAppMain] Found VLC version 1.1.5 in Windows Registry: C:\Program Files (x86)\VideoLAN\VLC\vlc.exe
DEBUG 2012-11-20 18:52:01.735 [WrapperSimpleAppMain] Found VLC version 1.1.5 in Windows Registry: C:\Program Files (x86)\VideoLAN\VLC\vlc.exe
DEBUG 2012-11-20 18:52:01.735 [WrapperSimpleAppMain] Found VLC version 1.1.5 in Windows Registry: C:\Program Files (x86)\VideoLAN\VLC\vlc.exe
DEBUG 2012-11-20 18:52:01.735 [WrapperSimpleAppMain] Found VLC version 1.1.5 in Windows Registry: C:\Program Files (x86)\VideoLAN\VLC\vlc.exe
INFO  2012-11-20 18:52:01.735 [WrapperSimpleAppMain] Registering transcoding engine: VLC Video Streaming
INFO  2012-11-20 18:52:01.735 [WrapperSimpleAppMain] Registering transcoding engine: FFmpeg DVR-MS Remux
INFO  2012-11-20 18:52:01.735 [WrapperSimpleAppMain] Registering transcoding engine: dcraw Thumbnailer
INFO  2012-11-20 18:52:01.751 [WrapperSimpleAppMain] GoogleMusic plugin missing credentials
INFO  2012-11-20 18:52:01.782 [WrapperSimpleAppMain] Start channel 2.05
INFO  2012-11-20 18:52:01.829 [WrapperSimpleAppMain] Configuration saved to: C:\ProgramData\UMS\UMS.conf
INFO  2012-11-20 18:52:01.985 [WrapperSimpleAppMain] Using address /192.168.31.100 found on network interface: name:eth3 (Realtek RTL8168C(P)/8111C(P) Family PCI-E Gigabit Ethernet NIC (NDIS 6.20))
INFO  2012-11-20 18:52:01.985 [WrapperSimpleAppMain] Created socket: /192.168.31.100:5001
INFO  2012-11-20 18:52:02.078 [WrapperSimpleAppMain] Checking shared folder: D:\Movie-D-drive
INFO  2012-11-20 18:52:02.078 [WrapperSimpleAppMain] Checking shared folder: F:\Movie-F-drive
INFO  2012-11-20 18:52:02.078 [WrapperSimpleAppMain] Checking shared folder: M:\Movie-M-drive
INFO  2012-11-20 18:52:02.078 [WrapperSimpleAppMain] Checking shared folder: F:\Music
ERROR 2012-11-20 18:52:02.141 [WrapperSimpleAppMain] Attempt to add a null child to root
java.lang.NullPointerException: Invalid DLNA resource
	at net.pms.dlna.DLNAResource.addChild(DLNAResource.java:450) [ums.jar:na]
	at net.pms.dlna.RootFolder.discoverChildren(RootFolder.java:148) [ums.jar:na]
	at net.pms.configuration.RendererConfiguration.getRootFolder(RendererConfiguration.java:198) [ums.jar:na]
	at net.pms.PMS.getRootFolder(PMS.java:110) [ums.jar:na]
	at net.pms.PMS.init(PMS.java:510) [ums.jar:na]
	at net.pms.PMS.createInstance(PMS.java:858) [ums.jar:na]
	at net.pms.PMS.main(PMS.java:933) [ums.jar:na]
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.7.0_02]
	at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source) ~[na:1.7.0_02]
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) ~[na:1.7.0_02]
	at java.lang.reflect.Method.invoke(Unknown Source) ~[na:1.7.0_02]
	at org.tanukisoftware.wrapper.WrapperSimpleApp.run(WrapperSimpleApp.java:290) [wrapper.jar:3.5.15]
	at java.lang.Thread.run(Unknown Source) [na:1.7.0_02]
DEBUG 2012-11-20 18:52:02.172 [WrapperSimpleAppMain] Sending ALIVE...
INFO  2012-11-20 18:52:02.203 [WrapperSimpleAppMain] Using the following UUID configured in UMS.conf: ebbb7981-ccd8-3252-ad23-83e32f84c363
INFO  2012-11-20 18:52:04.729 [New I/O server worker #1-1] No IP filter specified, access granted to /192.168.31.102
INFO  2012-11-20 18:52:04.738 [pool-7-thread-1] Checking IP: 192.168.31.102 for Philips TV
INFO  2012-11-20 18:52:05.136 [New I/O server worker #1-4] Checking shared folder: D:\Movie-D-drive
INFO  2012-11-20 18:52:05.136 [New I/O server worker #1-4] Checking shared folder: F:\Movie-F-drive
INFO  2012-11-20 18:52:05.136 [New I/O server worker #1-4] Checking shared folder: M:\Movie-M-drive
INFO  2012-11-20 18:52:05.136 [New I/O server worker #1-4] Checking shared folder: F:\Music
ERROR 2012-11-20 18:52:05.136 [New I/O server worker #1-4] Attempt to add a null child to root
java.lang.NullPointerException: Invalid DLNA resource
	at net.pms.dlna.DLNAResource.addChild(DLNAResource.java:450) [ums.jar:na]
	at net.pms.dlna.RootFolder.discoverChildren(RootFolder.java:148) [ums.jar:na]
	at net.pms.configuration.RendererConfiguration.getRootFolder(RendererConfiguration.java:198) [ums.jar:na]
	at net.pms.PMS.getRootFolder(PMS.java:110) [ums.jar:na]
	at net.pms.network.RequestV2.answer(RequestV2.java:628) [ums.jar:na]
	at net.pms.network.RequestHandlerV2.writeResponse(RequestHandlerV2.java:299) [ums.jar:na]
	at net.pms.network.RequestHandlerV2.messageReceived(RequestHandlerV2.java:257) [ums.jar:na]
	at org.jboss.netty.channel.SimpleChannelUpstreamHandler.handleUpstream(SimpleChannelUpstreamHandler.java:80) [ums.jar:na]
	at org.jboss.netty.channel.DefaultChannelPipeline.sendUpstream(DefaultChannelPipeline.java:564) [ums.jar:na]
	at org.jboss.netty.channel.DefaultChannelPipeline$DefaultChannelHandlerContext.sendUpstream(DefaultChannelPipeline.java:783) [ums.jar:na]
	at org.jboss.netty.handler.stream.ChunkedWriteHandler.handleUpstream(ChunkedWriteHandler.java:149) [ums.jar:na]
	at org.jboss.netty.channel.DefaultChannelPipeline.sendUpstream(DefaultChannelPipeline.java:564) [ums.jar:na]
	at org.jboss.netty.channel.DefaultChannelPipeline$DefaultChannelHandlerContext.sendUpstream(DefaultChannelPipeline.java:783) [ums.jar:na]
	at org.jboss.netty.handler.codec.http.HttpChunkAggregator.messageReceived(HttpChunkAggregator.java:116) [ums.jar:na]
	at org.jboss.netty.channel.SimpleChannelUpstreamHandler.handleUpstream(SimpleChannelUpstreamHandler.java:80) [ums.jar:na]
	at org.jboss.netty.channel.DefaultChannelPipeline.sendUpstream(DefaultChannelPipeline.java:564) [ums.jar:na]
	at org.jboss.netty.channel.DefaultChannelPipeline$DefaultChannelHandlerContext.sendUpstream(DefaultChannelPipeline.java:783) [ums.jar:na]
	at org.jboss.netty.channel.Channels.fireMessageReceived(Channels.java:302) [ums.jar:na]
	at org.jboss.netty.handler.codec.replay.ReplayingDecoder.unfoldAndFireMessageReceived(ReplayingDecoder.java:527) [ums.jar:na]
	at org.jboss.netty.handler.codec.replay.ReplayingDecoder.callDecode(ReplayingDecoder.java:506) [ums.jar:na]
	at org.jboss.netty.handler.codec.replay.ReplayingDecoder.messageReceived(ReplayingDecoder.java:443) [ums.jar:na]
	at org.jboss.netty.channel.SimpleChannelUpstreamHandler.handleUpstream(SimpleChannelUpstreamHandler.java:80) [ums.jar:na]
	at org.jboss.netty.channel.DefaultChannelPipeline.sendUpstream(DefaultChannelPipeline.java:564) [ums.jar:na]
	at org.jboss.netty.channel.DefaultChannelPipeline.sendUpstream(DefaultChannelPipeline.java:559) [ums.jar:na]
	at org.jboss.netty.channel.Channels.fireMessageReceived(Channels.java:274) [ums.jar:na]
	at org.jboss.netty.channel.Channels.fireMessageReceived(Channels.java:261) [ums.jar:na]
	at org.jboss.netty.channel.socket.nio.NioWorker.read(NioWorker.java:351) [ums.jar:na]
	at org.jboss.netty.channel.socket.nio.NioWorker.processSelectedKeys(NioWorker.java:282) [ums.jar:na]
	at org.jboss.netty.channel.socket.nio.NioWorker.run(NioWorker.java:202) [ums.jar:na]
	at org.jboss.netty.util.ThreadRenamingRunnable.run(ThreadRenamingRunnable.java:108) [ums.jar:na]
	at org.jboss.netty.util.internal.DeadLockProofWorker$1.run(DeadLockProofWorker.java:44) [ums.jar:na]
	at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source) [na:1.7.0_02]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source) [na:1.7.0_02]
	at java.lang.Thread.run(Unknown Source) [na:1.7.0_02]
INFO  2012-11-20 18:52:05.136 [New I/O server worker #1-4] Node(com.sharkhunter.channel.Channels) already has an ID=0$6, which is overriden now. The previous parent node was:RootFolder[[MapFile [name=Movie-D-drive, id=0$1, format=null, children=[]], MapFile [name=Movie-F-drive, id=0$2, format=null, children=[]], MapFile [name=Movie-M-drive, id=0$3, format=null, children=[]], MapFile [name=Music, id=0$4, format=null, children=[]], VirtualFolder [id=5, name=Web, full path=0$5, ext=null, discovered=false]]]
INFO  2012-11-20 18:52:07.419 [WrapperSimpleAppMain] The server should now appear on your renderer
INFO  2012-11-20 18:52:09.369 [pool-7-thread-1] Renderer Philips TV found on this address: 192.168.31.102
DEBUG 2012-11-20 18:52:09.369 [pool-7-thread-1] Starting ping -n 3 -l 64000 192.168.31.102
DEBUG 2012-11-20 18:52:11.381 [SpeedStats Failsafe] Stopping process: ping-0
DEBUG 2012-11-20 18:52:16.997 [New I/O server worker #1-6] Detected encoding for D:\Movie-D-drive\Bad.Ass(2012).srt is WINDOWS-1252.
DEBUG 2012-11-20 18:52:17.418 [New I/O server worker #1-6] Detected encoding for D:\Movie-D-drive\Bad.Ass(2012).srt is WINDOWS-1252.
DEBUG 2012-11-20 18:52:17.434 [UPNP-AliveMessageSender] Sending ALIVE...
DEBUG 2012-11-20 18:52:19.155 [New I/O server worker #1-6] Detected encoding for D:\Movie-D-drive\Re-animator(1985).srt is WINDOWS-1252.
DEBUG 2012-11-20 18:52:19.324 [New I/O server worker #1-6] Detected encoding for D:\Movie-D-drive\Re-animator(1985).srt is WINDOWS-1252.
DEBUG 2012-11-20 18:52:32.215 [New I/O server worker #1-4] Could not parse year "utc 2011-02-25 07:00:00"
DEBUG 2012-11-20 18:52:33.635 [New I/O server worker #1-4] No encoding detected for M:\Movie-M-drive\Action\Kamui-cd1.sub.
DEBUG 2012-11-20 18:52:33.993 [New I/O server worker #1-4] No encoding detected for M:\Movie-M-drive\Action\Kamui-cd2.sub.
DEBUG 2012-11-20 18:52:41.747 [UPNP-AliveMessageSender] Sending ALIVE...
DEBUG 2012-11-20 18:52:42.016 [New I/O server worker #1-4] No encoding detected for M:\Movie-M-drive\Action\Thunderbolt(1995)-cd1.sub.
DEBUG 2012-11-20 18:52:42.379 [New I/O server worker #1-4] No encoding detected for M:\Movie-M-drive\Action\Thunderbolt(1995)-cd2.sub.
DEBUG 2012-11-20 18:52:48.742 [pool-19-thread-3] Duplicate Angel.And.The.Badman.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.742 [pool-19-thread-1] Duplicate A.Dangerous.Man.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.742 [pool-19-thread-2] Duplicate Against.The.Dark.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.757 [pool-19-thread-2] Duplicate Bad.Boys.mp4 for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.757 [pool-19-thread-3] Duplicate Bad.Boys.II.mp4 for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.757 [pool-19-thread-1] Duplicate Armored.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.757 [pool-19-thread-3] Duplicate Blade.II(2002).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.757 [pool-19-thread-1] Duplicate Blade.Trinity(2004).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.757 [pool-19-thread-2] Duplicate Born.To.Raise.Hell(2010).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.757 [pool-19-thread-1] Duplicate Cash.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.757 [pool-19-thread-2] Duplicate Bunraku(2010).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.757 [pool-19-thread-3] Duplicate Casino.Royale(2006).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.773 [pool-19-thread-1] Duplicate Chocolate.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.773 [pool-19-thread-3] Duplicate Crank.2.Hi.Voltage(2009).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.773 [pool-19-thread-2] Duplicate City.Hunter.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.773 [pool-19-thread-1] Duplicate Death.Race.cd1.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.773 [pool-19-thread-1] Duplicate Death.Race.cd2.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.773 [pool-19-thread-1] Duplicate Dragon.Eyes(2012).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.773 [pool-19-thread-1] Duplicate Eraser.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.773 [pool-19-thread-2] Duplicate Fast.Five(2011).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.773 [pool-19-thread-1] Duplicate Fire.of.conscience.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.773 [pool-19-thread-1] Duplicate G.I.Joe.The.Rise.Of.Cobra.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.773 [pool-19-thread-2] Duplicate Game.Of.Death(2010).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.773 [pool-19-thread-3] Duplicate Hellbinders.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.773 [pool-19-thread-2] Duplicate Iron.Man(2008).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.773 [pool-19-thread-3] Duplicate Kamui-cd1.avi for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.773 [pool-19-thread-1] Duplicate Kamui-cd2.avi for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.773 [pool-19-thread-3] Duplicate Les.Formidables.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.773 [pool-19-thread-2] Duplicate Limitless(2011).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.773 [pool-19-thread-3] Duplicate Mission.Impossible.1(1996).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.773 [pool-19-thread-2] Duplicate Mission.Impossible.2(2000).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.788 [pool-19-thread-1] Duplicate Mission.Impossible.3(2006).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.788 [pool-19-thread-2] Duplicate Mission.Impossible.4.Ghost.Protocol(2011).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.788 [pool-19-thread-1] Duplicate My.Wife.Is.A.Gangster.3.avi for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.788 [pool-19-thread-2] Duplicate Nude.Nuns.with.Big.Guns(2010).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.788 [pool-19-thread-1] Duplicate Ocean's 11.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.788 [pool-19-thread-2] Duplicate Ocean's 12.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.788 [pool-19-thread-1] Duplicate Ocean's.13.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.788 [pool-19-thread-1] Duplicate Operation.Condor.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.788 [pool-19-thread-1] Duplicate Paintball.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.788 [pool-19-thread-1] Duplicate Priest(2011).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.788 [pool-19-thread-2] Duplicate Project.A.2(1987).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.788 [pool-19-thread-1] Duplicate Project.A(1983).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.788 [pool-19-thread-2] Duplicate Quantum.of.Solace(2008).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.788 [pool-19-thread-1] Duplicate Rampage.avi for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.788 [pool-19-thread-1] Duplicate Real.Steel(2011).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.788 [pool-19-thread-2] Duplicate Recoil(2011).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.788 [pool-19-thread-2] Duplicate Repo.Men.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.788 [pool-19-thread-2] Duplicate Rush.Hour.1.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.788 [pool-19-thread-1] Duplicate Rush.Hour.2.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.788 [pool-19-thread-2] Duplicate Rush.Hour.3.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.788 [pool-19-thread-1] Duplicate Salt.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.788 [pool-19-thread-2] Duplicate Shoot.Em.Up.Wide.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.788 [pool-19-thread-2] Duplicate Smokin.Aces.2.Assassins.Ball.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.788 [pool-19-thread-3] Duplicate Snatch.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.788 [pool-19-thread-1] Duplicate Sniper(2011).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.788 [pool-19-thread-3] Duplicate Special.Forces(2011).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.788 [pool-19-thread-2] Duplicate Steve.McQueen.Bullit.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.788 [pool-19-thread-2] Duplicate Steve.McQueen.The.Cincinnati.Kid.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.788 [pool-19-thread-3] Duplicate Steve.McQueen.The.Getaway.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.788 [pool-19-thread-2] Duplicate The.Burma.Conspiracy(2011).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.788 [pool-19-thread-1] Duplicate The.Bank.Job.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.788 [pool-19-thread-3] Duplicate The.Expendables(2010).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.788 [pool-19-thread-1] Duplicate The.Italian.Job.1969.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.788 [pool-19-thread-2] Duplicate The.Italian.Job.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.788 [pool-19-thread-3] Duplicate The.Keeper.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.788 [pool-19-thread-2] Duplicate The.Mechanic(1972).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.804 [pool-19-thread-1] Duplicate The.Mechanic(2011).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.804 [pool-19-thread-3] Duplicate The.Mechanik.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.804 [pool-19-thread-3] Duplicate The.Outlaw.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.804 [pool-19-thread-2] Duplicate The.Phanton.CD1.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.804 [pool-19-thread-1] Duplicate The.Phanton.CD2.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.804 [pool-19-thread-3] Duplicate The.Shepherd.Border.Patrol.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.804 [pool-19-thread-2] Duplicate The.Spy.Next.Door.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.804 [pool-19-thread-1] Duplicate The.Tournament.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.804 [pool-19-thread-3] Duplicate The.Warriors.Way(2010).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.804 [pool-19-thread-2] Duplicate Thunderbolt(1995)-cd1.avi for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.804 [pool-19-thread-1] Duplicate Thunderbolt(1995)-cd2.avi for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.804 [pool-19-thread-2] Duplicate Tower.Heist(2011).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.804 [pool-19-thread-1] Duplicate Undisputed.III-Redemption.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.804 [pool-19-thread-3] Duplicate Universal.Soldier.Regeneration.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.804 [pool-19-thread-1] Duplicate Unstoppable(2010).mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.804 [pool-19-thread-3] Duplicate Wedlock.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.804 [pool-19-thread-3] Duplicate xXx.mkv for direct streaming to renderer: Philips TV
DEBUG 2012-11-20 18:52:48.804 [pool-19-thread-2] Duplicate xXx.State.Of.The.Union.mkv for direct streaming to renderer: Philips TV
INFO  2012-11-20 18:53:31.813 [New I/O server worker #1-8] Starting transcode/remux of Quantum.of.Solace(2008).mkv
DEBUG 2012-11-20 18:53:31.876 [New I/O server worker #1-8] Creating pipe \\.\pipe\mencoder1353434011876
DEBUG 2012-11-20 18:53:31.907 [Thread-16] Waiting for pipe connection \\.\pipe\mencoder1353434011876
DEBUG 2012-11-20 18:53:31.969 [mencoder.exe-1] Starting "C:\Program Files (x86)\Universal Media Server\win32\mencoder.exe" -ss 0 M:\Movie-M-drive\Action\Quantum.of.Solace(2008).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=448:threads=4:keyint=5:vqscale=1:vqmin=1:vrc_maxrate=36000:vrc_buf_size=7000 -ass -ass-color ffffff00 -ass-border-color 00000000 -ass-font-scale 1.4 -font C:\Windows\Fonts\Arial.ttf -ass-force-style FontName=C:\Windows\Fonts\Arial.ttf,Outline=1,Shadow=1,MarginV=10 -fontconfig -sid 0 -ofps 24000/1001 -lavdopts fast -mc 0 -noskip -af lavcresample=48000 -srate 48000 -o \\.\pipe\mencoder1353434011876
DEBUG 2012-11-20 18:53:32.827 [mencoder.exe-1] Reading pipe: \\.\pipe\mencoder1353434011876
DEBUG 2012-11-20 18:53:32.827 [mencoder.exe-1] Attaching thread: mencoder.exe-1
DEBUG 2012-11-20 18:53:33.264 [Thread-20] MEncoder SB37 (C) 2000-2012 MPlayer Team
DEBUG 2012-11-20 18:53:33.280 [Thread-20] Custom build by SubJunk, http://www.spirton.com
DEBUG 2012-11-20 18:53:33.280 [Thread-20] 
DEBUG 2012-11-20 18:53:33.295 [Thread-20] success: format: 0  data: 0x0 - 0x4997a96f
DEBUG 2012-11-20 18:53:33.295 [Thread-20] libavformat version 54.26.101 (internal)
DEBUG 2012-11-20 18:53:33.295 [Thread-20] libavformat file format detected.
DEBUG 2012-11-20 18:53:33.317 [Thread-20] [lavf] stream 0: video (h264), -vid 0
DEBUG 2012-11-20 18:53:33.317 [Thread-20] [lavf] stream 1: audio (aac), -aid 0, -alang eng
DEBUG 2012-11-20 18:53:33.317 [Thread-20] [lavf] stream 2: subtitle (subrip), -sid 0, -slang nld
DEBUG 2012-11-20 18:53:33.317 [Thread-20] VIDEO:  [H264]  1920x800  0bpp  23.976 fps    0.0 kbps ( 0.0 kbyte/s)
DEBUG 2012-11-20 18:53:33.317 [Thread-20] [V] filefmt:44  fourcc:0x34363248  size:1920x800  fps:23.976  ftime:=0.0417
DEBUG 2012-11-20 18:53:33.317 [Thread-20] ==========================================================================
DEBUG 2012-11-20 18:53:33.318 [Thread-20] Opening audio decoder: [ffmpeg] FFmpeg/libavcodec audio decoders
DEBUG 2012-11-20 18:53:33.319 [Thread-20] libavcodec version 54.55.100 (internal)
DEBUG 2012-11-20 18:53:33.321 [Thread-20] AUDIO: 48000 Hz, 2 ch, s16le, 0.0 kbit/0.00% (ratio: 0->192000)
DEBUG 2012-11-20 18:53:33.321 [Thread-20] Selected audio codec: [ffaac] afm: ffmpeg (FFmpeg AAC (MPEG-2/MPEG-4 Audio))
DEBUG 2012-11-20 18:53:33.321 [Thread-20] ==========================================================================
DEBUG 2012-11-20 18:53:33.321 [Thread-16] Result of \\.\pipe\mencoder1353434011876 : true
DEBUG 2012-11-20 18:53:33.322 [Thread-20] PACKET SIZE: 2048 bytes, deltascr: 884
DEBUG 2012-11-20 18:53:33.323 [Thread-20] Opening video filter: [ass auto=1]
DEBUG 2012-11-20 18:53:33.323 [Thread-20] [ass] auto-open
DEBUG 2012-11-20 18:53:33.338 [Thread-20] ==========================================================================
DEBUG 2012-11-20 18:53:33.340 [Thread-20] Opening video decoder: [ffmpeg] FFmpeg's libavcodec codec family
DEBUG 2012-11-20 18:53:33.342 [Thread-20] Selected video codec: [ffh264] vfm: ffmpeg (FFmpeg H.264)
DEBUG 2012-11-20 18:53:33.342 [Thread-20] ==========================================================================
DEBUG 2012-11-20 18:53:33.342 [Thread-19] [ac3 @ 01140820]channel_layout not specified
DEBUG 2012-11-20 18:53:33.342 [Thread-19] [ac3 @ 01140820]No channel layout specified. The encoder will guess the layout, but it might be incorrect.
DEBUG 2012-11-20 18:53:33.343 [Thread-19] Limiting audio preload to 0.4s.
DEBUG 2012-11-20 18:53:33.343 [Thread-19] Increasing audio density to 4.
DEBUG 2012-11-20 18:53:33.346 [Thread-19] Unsupported PixelFormat 61
DEBUG 2012-11-20 18:53:33.346 [Thread-19] Unsupported PixelFormat 53
DEBUG 2012-11-20 18:53:33.346 [Thread-19] Unsupported PixelFormat 81
DEBUG 2012-11-20 18:53:33.372 [Thread-20] Movie-Aspect is 2.40:1 - prescaling to correct movie aspect.
DEBUG 2012-11-20 18:53:33.372 [Thread-20] videocodec: libavcodec (1920x800 fourcc=3267706d [mpg2])
DEBUG 2012-11-20 18:53:33.372 [Thread-20] [VE_LAVC] Using constant qscale = 1.000000 (VBR).
DEBUG 2012-11-20 18:53:33.412 [Thread-20] Writing header...
DEBUG 2012-11-20 18:53:33.412 [Thread-20] INITV: 0.200, 0.158, fps: 23.976
DEBUG 2012-11-20 18:53:33.412 [Thread-20] 
INFO  2012-11-20 18:53:38.087 [StartPlaying Event] renderer: 192.168.31.102, file: M:\Movie-M-drive\Action\Quantum.of.Solace(2008).mkv
DEBUG 2012-11-20 18:54:06.448 [New I/O server worker #1-2] Setting margin to 2Mb
DEBUG 2012-11-20 18:54:38.756 [Thread-19] [ass] PlayResX undefined, setting to 384
DEBUG 2012-11-20 18:55:45.791 [UPNP-AliveMessageSender] Sending ALIVE...
DEBUG 2012-11-20 18:56:36.718 [Buffered IO End Checker] Stopping process: mencoder.exe-1
INFO  2012-11-20 18:56:38.235 [StopPlaying Event] renderer: 192.168.31.102, file: M:\Movie-M-drive\Action\Quantum.of.Solace(2008).mkv
DEBUG 2012-11-20 18:57:03.631 [UPNP-AliveMessageSender] Error while sending periodic alive message: sleep interrupted
INFO  2012-11-20 18:57:03.631 [PMS Listeners Stopper] Sending BYEBYE...
DEBUG 2012-11-20 18:57:08.616 [PMS Listeners Stopper] Forcing shutdown of all active processes
INFO  2012-11-20 18:57:08.616 [PMS Listeners Stopper] Stopping server on host 192.168.31.100 and port 5001...