Sun 2/17 10:32:22.590 [AWT-EventQueue-0@4794d88c] processUserEvent-UserEvent[select] evtTime=Sun 2/17 10:32:22.599
Sun 2/17 10:32:22.609 [AWT-EventQueue-0@4794d88c] processOptionsMenu optionsMenu=default:BASE-49221|OptionsMenu:Show Options for an Airing, Recording, File, etc.
Sun 2/17 10:32:22.618 [AWT-EventQueue-0@4794d88c] BEGIN: Sort video playlists.
Sun 2/17 10:32:22.625 [AWT-EventQueue-0@4794d88c] END: Sort video playlists. Sorted 13 playlists. Total Time = '0'
Sun 2/17 10:32:22.661 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Loading RawImage of size 50x50 for C:\Program Files\SageTV\SageTV\.\STVs\SageTV7\Themes\Gemstone\DialogBG.png fileSize=2196
Sun 2/17 10:32:22.667 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Loading 0x0 image from file C:\Program Files\SageTV\SageTV\.\STVs\SageTV7\Themes\Gemstone\DialogBG.png
Sun 2/17 10:32:22.668 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Creating DirectX9 Texture from nio buffer w=50 h=50
Sun 2/17 10:32:22.668 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Loading RawImage of size 756x160 for C:\Program Files\SageTV\SageTV\.\STVs\SageTV7\Themes\Gemstone\Highlights\Original\ButtonHighlight.png fileSize=4815
Sun 2/17 10:32:22.674 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Loading 0x0 image from file C:\Program Files\SageTV\SageTV\.\STVs\SageTV7\Themes\Gemstone\Highlights\Original\ButtonHighlight.png
Sun 2/17 10:32:22.679 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Creating DirectX9 Texture from nio buffer w=756 h=160
Sun 2/17 10:32:22.680 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Loading RawImage of size 940x2 for C:\Program Files\SageTV\SageTV\.\STVs\SageTV7\Themes\Gemstone\ButtonDivider.png fileSize=1813
Sun 2/17 10:32:22.685 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Loading 0x0 image from file C:\Program Files\SageTV\SageTV\.\STVs\SageTV7\Themes\Gemstone\ButtonDivider.png
Sun 2/17 10:32:22.685 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Creating DirectX9 Texture from nio buffer w=940 h=2
Sun 2/17 10:32:22.686 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Creating new RawImage for font rendering w=128 h=128
Sun 2/17 10:32:22.686 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Rendered new font to raw cache index=5 font=MetaFont[fonts\DejaVuSans, size=40, style=0, height=47.0, ascent=38.0, descent=10.0, leading=-1.0, class=class sage.FreetypeFont]
Sun 2/17 10:32:22.691 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Creating DirectX9 Texture from nio buffer w=128 h=128
Sun 2/17 10:32:22.692 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Loading RawImage of size 100x100 for C:\Program Files\SageTV\SageTV\.\STVs\SageTV7\Themes\Gemstone\OSDPlay.png fileSize=4033
Sun 2/17 10:32:22.697 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Loading 0x0 image from file C:\Program Files\SageTV\SageTV\.\STVs\SageTV7\Themes\Gemstone\OSDPlay.png
Sun 2/17 10:32:22.697 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Creating DirectX9 Texture from nio buffer w=100 h=100
Sun 2/17 10:32:22.698 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Loading RawImage of size 100x100 for C:\Program Files\SageTV\SageTV\.\STVs\SageTV7\Themes\Gemstone\MarkerInfo.png fileSize=1786
Sun 2/17 10:32:22.703 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Loading 0x0 image from file C:\Program Files\SageTV\SageTV\.\STVs\SageTV7\Themes\Gemstone\MarkerInfo.png
Sun 2/17 10:32:22.704 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Creating DirectX9 Texture from nio buffer w=100 h=100
Sun 2/17 10:32:22.705 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Loading RawImage of size 96x96 for C:\Program Files\SageTV\SageTV\.\STVs\SageTV7\Themes\Gemstone\MarkerDelete.png fileSize=2070
Sun 2/17 10:32:22.711 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Loading 0x0 image from file C:\Program Files\SageTV\SageTV\.\STVs\SageTV7\Themes\Gemstone\MarkerDelete.png
Sun 2/17 10:32:22.711 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Creating DirectX9 Texture from nio buffer w=96 h=96
Sun 2/17 10:32:22.712 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Loading RawImage of size 100x100 for C:\Program Files\SageTV\SageTV\.\STVs\SageTV7\Themes\Gemstone\MarkerChecked.png fileSize=7976
Sun 2/17 10:32:22.716 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Loading 0x0 image from file C:\Program Files\SageTV\SageTV\.\STVs\SageTV7\Themes\Gemstone\MarkerChecked.png
Sun 2/17 10:32:22.717 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Creating DirectX9 Texture from nio buffer w=100 h=100
Sun 2/17 10:32:23.811 [AWT-EventQueue-0@4794d88c] processUserEvent-UserEvent[select] evtTime=Sun 2/17 10:32:23.820
Sun 2/17 10:32:23.818 [AWT-EventQueue-0@4794d88c] VF.submitJob(VFJob[CloseMF r=0.0 t=0 file=null ifn=null])
Sun 2/17 10:32:23.826 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@393eacd7] VF processing job VFJob[CloseMF r=0.0 t=0 file=null ifn=null] nPlayin=false
Sun 2/17 10:32:23.831 [AWT-EventQueue-0@4794d88c] CloseAndWait is executing the close job synchronously now
Sun 2/17 10:32:23.835 [AWT-EventQueue-0@4794d88c] VF processing on UI Thread VFJob[CloseMF r=0.0 t=0 file=null ifn=null]
Sun 2/17 10:32:23.840 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@393eacd7] VF processing job null nPlayin=false
Sun 2/17 10:32:23.844 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@393eacd7] VF thread is now waiting for 0:00:00.000
Sun 2/17 10:32:23.849 [AsyncWatch@6f1de026] VideoFrame.watch(A[21712516,21712515,"101 Dalmatians (1996)",0@1227.23:22,79,V])
Sun 2/17 10:32:23.853 [AsyncWatch@6f1de026] watchThisFile=MediaFile[id=21712514 A[21712516,21712515,"101 Dalmatians (1996)",0@1227.23:22,79,V] mask=V host=MOL-HTPC encodedBy= format=AVI 1:19:45 2900 kbps [#0 Video[MPEG4-Video 23.98 fps 720x544 45:34 progressive]#1 Audio[AC3 48000 Hz 6 channels 448 kbps idx=1]{SeriesInfoID=1697220}] M:\Movies\Family\101 Dalmatians (1996).avi, Seg0[Sat 12/27 23:22:46.695-Sun 12/28 0:42:32.515]]
Sun 2/17 10:32:23.858 [AsyncWatch@6f1de026] Watch airing is a file & over, do that instead dvd=false
Sun 2/17 10:32:23.867 [AsyncWatch@6f1de026] VF.submitJob(VFJob[WatchMF r=0.0 t=0 file=MediaFile[id=21712514 A[21712516,21712515,"101 Dalmatians (1996)",0@1227.23:22,79,V] mask=V host=MOL-HTPC encodedBy= format=AVI 1:19:45 2900 kbps [#0 Video[MPEG4-Video 23.98 fps 720x544 45:34 progressive]#1 Audio[AC3 48000 Hz 6 channels 448 kbps idx=1]{SeriesInfoID=1697220}] M:\Movies\Family\101 Dalmatians (1996).avi, Seg0[Sat 12/27 23:22:46.695-Sun 12/28 0:42:32.515]] ifn=null])
Sun 2/17 10:32:23.872 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@393eacd7] VF processing job VFJob[WatchMF r=0.0 t=0 file=MediaFile[id=21712514 A[21712516,21712515,"101 Dalmatians (1996)",0@1227.23:22,79,V] mask=V host=MOL-HTPC encodedBy= format=AVI 1:19:45 2900 kbps [#0 Video[MPEG4-Video 23.98 fps 720x544 45:34 progressive]#1 Audio[AC3 48000 Hz 6 channels 448 kbps idx=1]{SeriesInfoID=1697220}] M:\Movies\Family\101 Dalmatians (1996).avi, Seg0[Sat 12/27 23:22:46.695-Sun 12/28 0:42:32.515]] ifn=null] nPlayin=false
Sun 2/17 10:32:23.890 [AWT-EventQueue-0@4794d88c] VF processing on UI Thread VFJob[WatchMF r=0.0 t=0 file=MediaFile[id=21712514 A[21712516,21712515,"101 Dalmatians (1996)",0@1227.23:22,79,V] mask=V host=MOL-HTPC encodedBy= format=AVI 1:19:45 2900 kbps [#0 Video[MPEG4-Video 23.98 fps 720x544 45:34 progressive]#1 Audio[AC3 48000 Hz 6 channels 448 kbps idx=1]{SeriesInfoID=1697220}] M:\Movies\Family\101 Dalmatians (1996).avi, Seg0[Sat 12/27 23:22:46.695-Sun 12/28 0:42:32.515]] ifn=null]
Sun 2/17 10:32:23.896 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@393eacd7] VF processing job VFJob[LoadMF r=0.0 t=0 file=MediaFile[id=21712514 A[21712516,21712515,"101 Dalmatians (1996)",0@1227.23:22,79,V] mask=V host=MOL-HTPC encodedBy= format=AVI 1:19:45 2900 kbps [#0 Video[MPEG4-Video 23.98 fps 720x544 45:34 progressive]#1 Audio[AC3 48000 Hz 6 channels 448 kbps idx=1]{SeriesInfoID=1697220}] M:\Movies\Family\101 Dalmatians (1996).avi, Seg0[Sat 12/27 23:22:46.695-Sun 12/28 0:42:32.515]] ifn=null] nPlayin=false
Sun 2/17 10:32:23.940 [AsyncWatch@6f1de026] setUI(sage.PseudoMenu@5d940d86[MediaPlayer OSD]) histIdx=2 uiHistory=[sage.PseudoMenu@4b88ffb4[Main Menu], sage.PseudoMenu@680b0553[Gemstone Flows], sage.PseudoMenu@5d940d86[MediaPlayer OSD]] redo=false performingActivation=null
Sun 2/17 10:32:23.945 [AWT-EventQueue-0@4794d88c] VF processing on UI Thread VFJob[LoadMF r=0.0 t=0 file=MediaFile[id=21712514 A[21712516,21712515,"101 Dalmatians (1996)",0@1227.23:22,79,V] mask=V host=MOL-HTPC encodedBy= format=AVI 1:19:45 2900 kbps [#0 Video[MPEG4-Video 23.98 fps 720x544 45:34 progressive]#1 Audio[AC3 48000 Hz 6 channels 448 kbps idx=1]{SeriesInfoID=1697220}] M:\Movies\Family\101 Dalmatians (1996).avi, Seg0[Sat 12/27 23:22:46.695-Sun 12/28 0:42:32.515]] ifn=null]
Sun 2/17 10:32:23.956 [AsyncWatch@6f1de026] BEGIN: Get all imported video files
Sun 2/17 10:32:23.964 [AWT-EventQueue-0@4794d88c] VideoFrame creating new media player for file:MediaFile[id=21712514 A[21712516,21712515,"101 Dalmatians (1996)",0@1227.23:22,79,V] mask=V host=MOL-HTPC encodedBy= format=AVI 1:19:45 2900 kbps [#0 Video[MPEG4-Video 23.98 fps 720x544 45:34 progressive]#1 Audio[AC3 48000 Hz 6 channels 448 kbps idx=1]{SeriesInfoID=1697220}] M:\Movies\Family\101 Dalmatians (1996).avi, Seg0[Sat 12/27 23:22:46.695-Sun 12/28 0:42:32.515]]
Sun 2/17 10:32:23.970 [AsyncWatch@6f1de026]  ==> Get all 2599 imported video files. GetMediaFiles(VDL) Time = '2'
Sun 2/17 10:32:23.976 [AWT-EventQueue-0@4794d88c] VF file=MediaFile[id=21712514 A[21712516,21712515,"101 Dalmatians (1996)",0@1227.23:22,79,V] mask=V host=MOL-HTPC encodedBy= format=AVI 1:19:45 2900 kbps [#0 Video[MPEG4-Video 23.98 fps 720x544 45:34 progressive]#1 Audio[AC3 48000 Hz 6 channels 448 kbps idx=1]{SeriesInfoID=1697220}] M:\Movies\Family\101 Dalmatians (1996).avi, Seg0[Sat 12/27 23:22:46.695-Sun 12/28 0:42:32.515]] targetTime = Sat 12/27 23:22:46.695
Sun 2/17 10:32:23.981 [AsyncWatch@6f1de026]  ==> Get all imported video files. Filter by not IsTVFile Time = '1'
Sun 2/17 10:32:23.988 [AWT-EventQueue-0@4794d88c] VideoFrame.timeSelected(Sat 12/27 23:22:46.695, true) currFile=MediaFile[id=21712514 A[21712516,21712515,"101 Dalmatians (1996)",0@1227.23:22,79,V] mask=V host=MOL-HTPC encodedBy= format=AVI 1:19:45 2900 kbps [#0 Video[MPEG4-Video 23.98 fps 720x544 45:34 progressive]#1 Audio[AC3 48000 Hz 6 channels 448 kbps idx=1]{SeriesInfoID=1697220}] M:\Movies\Family\101 Dalmatians (1996).avi, Seg0[Sat 12/27 23:22:46.695-Sun 12/28 0:42:32.515]]
Sun 2/17 10:32:23.994 [AsyncWatch@6f1de026] END: Get all imported video files. Found 2598 videos. Total Time = '25'
Sun 2/17 10:32:23.998 [AWT-EventQueue-0@4794d88c] DShowPlayer createGraph0 called
Sun 2/17 10:32:24.005 [AWT-EventQueue-0@4794d88c] Creating GraphPluginHandler...
Sun 2/17 10:32:24.005 [AWT-EventQueue-0@4794d88c] Done creating GraphPluginHandler
Sun 2/17 10:32:24.005 [AWT-EventQueue-0@4794d88c] DShowPlayer setVideoRendererFilter0({51B4ABF3-748F-4E3B-A276-C828330E926A}) called
Sun 2/17 10:32:24.013 [AWT-EventQueue-0@4794d88c] Using VMR9 for video rendering
Sun 2/17 10:32:24.020 [AWT-EventQueue-0@4794d88c] Setting up VMR9 deinterlacing
Sun 2/17 10:32:24.020 [AWT-EventQueue-0@4794d88c] Curr Mix Prefs=0x1015
Sun 2/17 10:32:24.020 [AWT-EventQueue-0@4794d88c] Set to 0x2015, hr=0x0, New Mix Prefs=0x2015
Sun 2/17 10:32:24.020 [AWT-EventQueue-0@4794d88c] DShowPlayer setAudioRendererFilter0(SAMSUNG (Intel(R) Display Audio)) called
Sun 2/17 10:32:24.040 [AWT-EventQueue-0@4794d88c] DShowPlayer setAudioDecoderFilter0(LAV Audio Decoder) called
Sun 2/17 10:32:24.128 [AWT-EventQueue-0@4794d88c] DShowPlayer setTimeshift=0 buffer=0
Sun 2/17 10:32:24.129 [AWT-EventQueue-0@4794d88c] Using the default source filter
Sun 2/17 10:32:24.131 [AWT-EventQueue-0@4794d88c] NATIVE Loading the source file
Sun 2/17 10:32:24.161 [BGLoader2-SAGETV_PROCESS_LOCAL_UI@1e1acf27] Loading RawImage of size 100x139 for M:\Movies\Family\101 Dalmatians (1996).jpg fileSize=6386
Sun 2/17 10:32:24.192 [AWT-EventQueue-0@4794d88c] NATIVE setting up the AVI demux
Sun 2/17 10:32:24.192 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@10ee9a17] VideoFrame got registration of a subtitle UI component: sage.ZCCLabel[loc=java.awt.Point[x=288,y=820] size=java.awt.Dimension[width=1344,height=217]]
Sun 2/17 10:32:24.198 [BGLoader2-SAGETV_PROCESS_LOCAL_UI@1e1acf27] Loading 0x0 image from file M:\Movies\Family\101 Dalmatians (1996).jpg
Sun 2/17 10:32:24.198 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@10ee9a17] VideoFrame got registration of a cc UI component: sage.ZCCLabel[loc=java.awt.Point[x=192,y=108] size=java.awt.Dimension[width=1536,height=864]]
Sun 2/17 10:32:24.204 [BGLoader2-SAGETV_PROCESS_LOCAL_UI@1e1acf27] Creating DirectX9 Texture from nio buffer w=100 h=139
Sun 2/17 10:32:24.205 [BGLoader2-SAGETV_PROCESS_LOCAL_UI@1e1acf27] ImageUtils loading file M:\Movies\Family\101 Dalmatians (1996).jpg
Sun 2/17 10:32:24.227 [AWT-EventQueue-0@4794d88c] Calling GraphCreated for the PluginHandler
Sun 2/17 10:32:24.227 [AWT-EventQueue-0@4794d88c] Done calling GraphCreated for the PluginHandler
Sun 2/17 10:32:24.227 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Loading RawImage of size 12x316 for C:\Program Files\SageTV\SageTV\.\STVs\SageTV7\Themes\Gemstone\OSDBGTop.png fileSize=1696
Sun 2/17 10:32:24.232 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Loading 0x0 image from file C:\Program Files\SageTV\SageTV\.\STVs\SageTV7\Themes\Gemstone\OSDBGTop.png
Sun 2/17 10:32:24.233 [BGLoader2-SAGETV_PROCESS_LOCAL_UI@1e1acf27] ImageUtils creating BI copy sun.awt.image.ToolkitImage@76d34921 w=100 h=139 freeMem=142265240 totalMem=487063552
Sun 2/17 10:32:24.237 [AWT-EventQueue-0@4794d88c] Audio Stream #1 format Other channels 6 freq 48000
Sun 2/17 10:32:24.238 [AWT-EventQueue-0@4794d88c] NATIVE RenderAudio called stream=1
Sun 2/17 10:32:24.238 [AWT-EventQueue-0@4794d88c] NATIVE RenderAudio step 1
Sun 2/17 10:32:24.238 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Creating DirectX9 Texture from nio buffer w=12 h=316
Sun 2/17 10:32:24.238 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Loading RawImage of size 100x100 for C:\Program Files\SageTV\SageTV\.\STVs\SageTV7\Themes\Gemstone\InsetOSDDetails.png fileSize=1768
Sun 2/17 10:32:24.247 [AWT-EventQueue-0@4794d88c] NATIVE RenderAudio step 2
Sun 2/17 10:32:24.247 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Loading 0x0 image from file C:\Program Files\SageTV\SageTV\.\STVs\SageTV7\Themes\Gemstone\InsetOSDDetails.png
Sun 2/17 10:32:24.247 [AWT-EventQueue-0@4794d88c] NATIVE RenderAudio step 3
Sun 2/17 10:32:24.248 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Creating DirectX9 Texture from nio buffer w=100 h=100
Sun 2/17 10:32:24.249 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Loading RawImage of size 11x142 for C:\Program Files\SageTV\SageTV\.\STVs\SageTV7\Themes\Gemstone\OSDBGBottom.png fileSize=1674
Sun 2/17 10:32:24.255 [AWT-EventQueue-0@4794d88c] NATIVE RenderVideo called
Sun 2/17 10:32:24.255 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Loading 0x0 image from file C:\Program Files\SageTV\SageTV\.\STVs\SageTV7\Themes\Gemstone\OSDBGBottom.png
Sun 2/17 10:32:24.255 [AWT-EventQueue-0@4794d88c] NATIVE RenderVideo step 1
Sun 2/17 10:32:24.256 [AWT-EventQueue-0@4794d88c] NATIVE RenderVideo step 2
Sun 2/17 10:32:24.256 [AWT-EventQueue-0@4794d88c] Video source pin information:
Sun 2/17 10:32:24.256 [AWT-EventQueue-0@4794d88c] PIN is not connected yet!Sun 2/17 10:32:24.256 [AWT-EventQueue-0@4794d88c] M type MEDIATYPE_Video  S type Unknown GUID Name F type FORMAT_VideoInfo
Sun 2/17 10:32:24.256 [AWT-EventQueue-0@4794d88c] M type MEDIATYPE_Video  S type Unknown GUID Name F type FORMAT_VideoInfo
Sun 2/17 10:32:24.256 [AWT-EventQueue-0@4794d88c] NATIVE RenderVideo step 3
Sun 2/17 10:32:24.260 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Creating DirectX9 Texture from nio buffer w=11 h=142
Sun 2/17 10:32:24.261 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Loading RawImage of size 100x100 for C:\Program Files\SageTV\SageTV\.\STVs\SageTV7\Themes\Gemstone\OSDStatusPause.png fileSize=3267
Sun 2/17 10:32:24.277 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Loading 0x0 image from file C:\Program Files\SageTV\SageTV\.\STVs\SageTV7\Themes\Gemstone\OSDStatusPause.png
Sun 2/17 10:32:24.277 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Creating DirectX9 Texture from nio buffer w=100 h=100
Sun 2/17 10:32:24.281 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Loading RawImage of size 145x95 for C:\Program Files\SageTV\SageTV\.\STVs\SageTV7\Themes\Gemstone\MediaIcons\video\AVI.png fileSize=3207
Sun 2/17 10:32:24.298 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Loading 0x0 image from file C:\Program Files\SageTV\SageTV\.\STVs\SageTV7\Themes\Gemstone\MediaIcons\video\AVI.png
Sun 2/17 10:32:24.299 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Creating DirectX9 Texture from nio buffer w=145 h=95
Sun 2/17 10:32:24.306 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Loading RawImage of size 145x95 for C:\Program Files\SageTV\SageTV\.\STVs\SageTV7\Themes\Gemstone\MediaIcons\video\MPEG4-Video.png fileSize=3596
Sun 2/17 10:32:24.331 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Loading 0x0 image from file C:\Program Files\SageTV\SageTV\.\STVs\SageTV7\Themes\Gemstone\MediaIcons\video\MPEG4-Video.png
Sun 2/17 10:32:24.332 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Creating DirectX9 Texture from nio buffer w=145 h=95
Sun 2/17 10:32:24.333 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Creating new RawImage for font rendering w=128 h=128
Sun 2/17 10:32:24.335 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Rendered new font to raw cache index=0 font=MetaFont[STVs\SageTV7\Themes\Gemstone\Fonts\MediaRes, size=33, style=0, height=33.0, ascent=27.0, descent=7.0, leading=-1.0, class=class sage.FreetypeFont]
Sun 2/17 10:32:24.352 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Creating DirectX9 Texture from nio buffer w=128 h=128
Sun 2/17 10:32:24.360 [AWT-EventQueue-0@4794d88c] VMR9 alloc 720x544 Offscreen DefaultPool  format=YUY2 minBuffs=1 arx=720 ary=544 nativeWidth=720 nativeHeight=544 reqNumBuff=1 allocNumBuff=1 hr=0x0
Sun 2/17 10:32:24.360 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Creating new RawImage for font rendering w=128 h=128
Sun 2/17 10:32:24.362 [AWT-EventQueue-0@4794d88c] Setting up VMR9 deinterlacing
Sun 2/17 10:32:24.362 [AWT-EventQueue-0@4794d88c] Actual deinterlace: hr=0x0 guid={00000000-0000-0000-0000-000000000000}
Sun 2/17 10:32:24.362 [AWT-EventQueue-0@4794d88c] deinterlace mode: hr=0x1 guid={00000000-0000-0000-0000-000000000000}
Sun 2/17 10:32:24.362 [AWT-EventQueue-0@4794d88c] Setting deinterlace mode to actual mode...
Sun 2/17 10:32:24.362 [AWT-EventQueue-0@4794d88c] deinterlace mode: hr=0x1 guid={00000000-0000-0000-0000-000000000000}
Sun 2/17 10:32:24.362 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Rendered new font to raw cache index=1 font=MetaFont[STVs\SageTV7\Themes\Gemstone\Fonts\MediaRes, size=33, style=0, height=33.0, ascent=27.0, descent=7.0, leading=-1.0, class=class sage.FreetypeFont]
Sun 2/17 10:32:24.367 [AWT-EventQueue-0@4794d88c] Filter Graph Video Renderer Info:
Sun 2/17 10:32:24.367 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Creating DirectX9 Texture from nio buffer w=128 h=128
Sun 2/17 10:32:24.367 [AWT-EventQueue-0@4794d88c] Video Renderer:CLSID_VideoMixingRenderer9
Sun 2/17 10:32:24.367 [AWT-EventQueue-0@4794d88c] M type MEDIATYPE_Video  S type MEDIASUBTYPE_NV12 F type FORMAT_VideoInfo
Sun 2/17 10:32:24.367 [AWT-EventQueue-0@4794d88c] DShowGraphFilters=AudRend,VidRend,Mpeg4s Decoder DMO,Audio Decoder,AVI Demultiplexer,M:\Movies\Family\101 Dalmatians (1996).avi,
Sun 2/17 10:32:24.367 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Creating new RawImage for font rendering w=128 h=128
Sun 2/17 10:32:24.369 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Rendered new font to raw cache index=2 font=MetaFont[STVs\SageTV7\Themes\Gemstone\Fonts\MediaRes, size=33, style=0, height=33.0, ascent=27.0, descent=7.0, leading=-1.0, class=class sage.FreetypeFont]
Sun 2/17 10:32:24.373 [AWT-EventQueue-0@4794d88c] ----------->Get getDurationMillis0=4785822.
Sun 2/17 10:32:24.374 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Creating DirectX9 Texture from nio buffer w=128 h=128
Sun 2/17 10:32:24.374 [AWT-EventQueue-0@4794d88c] VideoFrame.timeSelected2(Sat 12/27 23:22:46.695, true) currFile=MediaFile[id=21712514 A[21712516,21712515,"101 Dalmatians (1996)",0@1227.23:22,79,V] mask=V host=MOL-HTPC encodedBy= format=AVI 1:19:45 2900 kbps [#0 Video[MPEG4-Video 23.98 fps 720x544 45:34 progressive]#1 Audio[AC3 48000 Hz 6 channels 448 kbps idx=1]{SeriesInfoID=1697220}] M:\Movies\Family\101 Dalmatians (1996).avi, Seg0[Sat 12/27 23:22:46.695-Sun 12/28 0:42:32.515]] realDur=4785822
Sun 2/17 10:32:24.378 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Loading RawImage of size 145x95 for C:\Program Files\SageTV\SageTV\.\STVs\SageTV7\Themes\Gemstone\MediaIcons\audio\AC3.png fileSize=4028
Sun 2/17 10:32:24.383 [AWT-EventQueue-0@4794d88c] About to perform media time selection for 0
Sun 2/17 10:32:24.383 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Loading 0x0 image from file C:\Program Files\SageTV\SageTV\.\STVs\SageTV7\Themes\Gemstone\MediaIcons\audio\AC3.png
Sun 2/17 10:32:24.383 [AWT-EventQueue-0@4794d88c] Running the playback graph.
Sun 2/17 10:32:24.383 [main@685f4c2e] VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null])
Sun 2/17 10:32:24.388 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Creating DirectX9 Texture from nio buffer w=145 h=95
Sun 2/17 10:32:24.389 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Loading RawImage of size 145x95 for C:\Program Files\SageTV\SageTV\.\STVs\SageTV7\Themes\Gemstone\MediaIcons\audio\6.png fileSize=2351
Sun 2/17 10:32:24.394 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Loading 0x0 image from file C:\Program Files\SageTV\SageTV\.\STVs\SageTV7\Themes\Gemstone\MediaIcons\audio\6.png
Sun 2/17 10:32:24.394 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Creating DirectX9 Texture from nio buffer w=145 h=95
Sun 2/17 10:32:24.437 [AWT-EventQueue-0@4794d88c] Channel Change Time=1550421144437 NOTE: Not valid if this was not a direct channel change!
Sun 2/17 10:32:24.445 [AWT-EventQueue-0@4794d88c] Sending event to server for PlaybackStarted args={MediaFile=MediaFile[id=21712514 A[21712516,21712515,"101 Dalmatians (1996)",0@1227.23:22,79,V] mask=V host=MOL-HTPC encodedBy= format=AVI 1:19:45 2900 kbps [#0 Video[MPEG4-Video 23.98 fps 720x544 45:34 progressive]#1 Audio[AC3 48000 Hz 6 channels 448 kbps idx=1]{SeriesInfoID=1697220}] M:\Movies\Family\101 Dalmatians (1996).avi, Seg0[Sat 12/27 23:22:46.695-Sun 12/28 0:42:32.515]], ChapterNum=0, UIContext=/127.0.0.1:50400, MediaTime=1230441766695, Duration=4785820, TitleNum=0}
Sun 2/17 10:32:24.461 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@393eacd7] VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true
Sun 2/17 10:32:24.467 [ReProcessHook@6f1de026] Start looking for max channel digits
Sun 2/17 10:32:24.473 [AWT-EventQueue-0@4794d88c] VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null]
Sun 2/17 10:32:24.478 [ReProcessHook@6f1de026] New max channel = 2, from channel 2-1 on lineup 'Local Over the Air Broadcast  - 55044 (sdepg)'
Sun 2/17 10:32:24.484 [AWT-EventQueue-0@4794d88c] DShowMediaPlayer is consuming the events...
Sun 2/17 10:32:24.490 [ReProcessHook@6f1de026] New max channel = 3, from channel 41-5 on lineup 'Local Over the Air Broadcast  - 55044 (sdepg)'
Sun 2/17 10:32:24.559 [AWT-EventQueue-0@4794d88c] Event: 0xd l1=0x0 l2=0x0
Sun 2/17 10:32:24.561 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@393eacd7] VF processing job null nPlayin=true
Sun 2/17 10:32:24.589 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Loading RawImage of size 100x100 for C:\Program Files\SageTV\SageTV\.\STVs\SageTV7\Themes\Gemstone\OSDStatusPlay.png fileSize=4033
Sun 2/17 10:32:24.594 [ReProcessHook@6f1de026] Done looking for max channel digits; elapsed time: 100
Sun 2/17 10:32:24.602 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Loading 0x0 image from file C:\Program Files\SageTV\SageTV\.\STVs\SageTV7\Themes\Gemstone\OSDStatusPlay.png
Sun 2/17 10:32:24.602 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@393eacd7] isRec=false rd=4785822 base=0 eos=false
Sun 2/17 10:32:24.607 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7e272c9e] Creating DirectX9 Texture from nio buffer w=100 h=100
Sun 2/17 10:32:24.607 [Fork-JREkiwi-615771@1fa29567] Starting Comskip Playback v2.1.3 Thread: Thread[Fork-JREkiwi-615771,5,main], for UI context SAGETV_PROCESS_LOCAL_UI
Sun 2/17 10:32:24.623 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@393eacd7] VF thread is now waiting for 1:19:45.572
Sun 2/17 10:32:26.024 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@393eacd7] VF processing job null nPlayin=true
Sun 2/17 10:32:26.039 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@393eacd7] isRec=false rd=4785822 base=0 eos=false
Sun 2/17 10:32:26.056 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@393eacd7] VF thread is now waiting for 1:19:45.572