Wed 1/2 22:21:02.160 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] VF processing job null nPlayin=false
Wed 1/2 22:21:02.161 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] VF thread is now waiting for 0:00:00.000
Wed 1/2 22:21:47.045 [AWT-EventQueue-0@128a415] setUI(sage.cb@da05a8[SageRecordings SHORTCUTS]) histIdx=7 uiHistory=[sage.cb@1b4cf46[Main Menu], sage.cb@151448c[TV Explorer], sage.cb@102aa10[Main Menu], sage.cb@2667a2[Plugin List], sage.cb@1b4cf46[Main Menu], sage.cb@1b1cd95[Scheduled Recordings], sage.cb@1b4cf46[Main Menu], sage.cb@da05a8[SageRecordings SHORTCUTS]] redo=false
Wed 1/2 22:21:47.086 [AWT-EventQueue-0@128a415] setUI(sage.cb@151448c[TV Explorer]) histIdx=7 uiHistory=[sage.cb@1b4cf46[Main Menu], sage.cb@151448c[TV Explorer], sage.cb@102aa10[Main Menu], sage.cb@2667a2[Plugin List], sage.cb@1b4cf46[Main Menu], sage.cb@1b1cd95[Scheduled Recordings], sage.cb@1b4cf46[Main Menu], sage.cb@151448c[TV Explorer]] redo=false
Wed 1/2 22:21:47.087 [AWT-EventQueue-0@128a415] Get Imported TV Files - Start
Wed 1/2 22:21:47.088 [AWT-EventQueue-0@128a415] Display ImportedTV = true
Wed 1/2 22:21:47.088 [AWT-EventQueue-0@128a415] LimitSearchPaths = None
Wed 1/2 22:21:47.088 [AWT-EventQueue-0@128a415] TCED: Non-null TVImportFiles 222
Wed 1/2 22:21:47.089 [AWT-EventQueue-0@128a415] Get Imported TV Files - Done
Wed 1/2 22:21:47.089 [AWT-EventQueue-0@128a415] Get Recorded Files - Start
Wed 1/2 22:21:47.121 [AWT-EventQueue-0@128a415] Get Recorded Files - Done
Wed 1/2 22:21:47.121 [AWT-EventQueue-0@128a415] Get Scheduled Files - Start
Wed 1/2 22:21:47.122 [AWT-EventQueue-0@128a415] Get Scheduled Files - Done
Wed 1/2 22:21:47.122 [AWT-EventQueue-0@128a415] Start applying filters
Wed 1/2 22:21:47.123 [AWT-EventQueue-0@128a415] Done applying filters
Wed 1/2 22:21:47.123 [AWT-EventQueue-0@128a415] Start Grouping
Wed 1/2 22:21:47.161 [AWT-EventQueue-0@128a415] Done Grouping
Wed 1/2 22:21:47.161 [AWT-EventQueue-0@128a415] Starting EpSorting
Wed 1/2 22:21:47.161 [AWT-EventQueue-0@128a415] Done Episode Filtering
Wed 1/2 22:21:47.188 [AWT-EventQueue-0@128a415] Group Focus Changed
Wed 1/2 22:21:47.188 [AWT-EventQueue-0@128a415] Starting EpSorting
Wed 1/2 22:21:47.461 [Fork-OPUS4-108092@b6a6dc] ENDING Forked weather thread.
Wed 1/2 22:21:48.026 [AWT-EventQueue-0@128a415] Setting Focus on Episode Panel
Wed 1/2 22:21:50.510 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Loading RawImage of size 30x30 for C:\Program Files (x86)\SageTV\SageTV\STVs\SageTV7\Themes\George\MarkerW.png
Wed 1/2 22:21:50.511 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Loading 0x0 image from file C:\Program Files (x86)\SageTV\SageTV\STVs\SageTV7\Themes\George\MarkerW.png
Wed 1/2 22:21:50.512 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=30 h=30
Wed 1/2 22:21:53.852 [AWT-EventQueue-0@128a415] VF.submitJob(VFJob[CloseMF r=0.0 t=0 file=null ifn=null])
Wed 1/2 22:21:53.852 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] VF processing job VFJob[CloseMF r=0.0 t=0 file=null ifn=null] nPlayin=false
Wed 1/2 22:21:53.852 [AWT-EventQueue-0@128a415] CloseAndWait is executing the close job synchronously now
Wed 1/2 22:21:53.852 [AWT-EventQueue-0@128a415] VF processing on UI Thread VFJob[CloseMF r=0.0 t=0 file=null ifn=null]
Wed 1/2 22:21:53.852 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] VF processing job null nPlayin=false
Wed 1/2 22:21:53.853 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] VF thread is now waiting for 0:00:00.000
Wed 1/2 22:21:53.853 [AsyncWatch@19eedef] VideoFrame.watch(A[12823703,119699,"Aliens vs. Predator: Requiem",58574@1228.00:00,120])
Wed 1/2 22:21:53.854 [AsyncWatch@19eedef] watchThisFile=MediaFile[id=12947004 A[12823703,119699,"Aliens vs. Predator: Requiem",58574@1228.00:00,120] mask=TV host=SageTV-VM encodedBy=Hauppauge HD PVR Capture Device HDPVRMax format=MPEG2-TS 1:59:51 2884 kbps [#0 Video[H.264 29.97003 fps 1920x1080 16:9 interlaced id=1011]#1 Audio[AC3 48000 Hz 2 channels 384 kbps MAIN idx=1 id=1100]{ScrapedBy=Phoenix, IMDBID=tt0758730, MediaType=Movie, ScrapedDate=1350790824345, MediaProviderDataID=tt0758730, MediaTitle=AVPR: Aliens vs Predator - Requiem, DiscNumber=0, UserRating=47, MediaProviderID=imdb}] \\W7-Server\Recordings (DVR)\AliensvsPredatorRequiem-12823703-0.ts, Seg0[Wed 12/28 0:00:00.014-Wed 12/28 1:59:51.494]]
Wed 1/2 22:21:53.858 [AsyncWatch@19eedef] Watch airing is a file & over, do that instead dvd=false
Wed 1/2 22:21:53.862 [AsyncWatch@19eedef] VF.submitJob(VFJob[WatchMF r=0.0 t=0 file=MediaFile[id=12947004 A[12823703,119699,"Aliens vs. Predator: Requiem",58574@1228.00:00,120] mask=TV host=SageTV-VM encodedBy=Hauppauge HD PVR Capture Device HDPVRMax format=MPEG2-TS 1:59:51 2884 kbps [#0 Video[H.264 29.97003 fps 1920x1080 16:9 interlaced id=1011]#1 Audio[AC3 48000 Hz 2 channels 384 kbps MAIN idx=1 id=1100]{ScrapedBy=Phoenix, IMDBID=tt0758730, MediaType=Movie, ScrapedDate=1350790824345, MediaProviderDataID=tt0758730, MediaTitle=AVPR: Aliens vs Predator - Requiem, DiscNumber=0, UserRating=47, MediaProviderID=imdb}] \\W7-Server\Recordings (DVR)\AliensvsPredatorRequiem-12823703-0.ts, Seg0[Wed 12/28 0:00:00.014-Wed 12/28 1:59:51.494]] ifn=null])
Wed 1/2 22:21:53.863 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] VF processing job VFJob[WatchMF r=0.0 t=0 file=MediaFile[id=12947004 A[12823703,119699,"Aliens vs. Predator: Requiem",58574@1228.00:00,120] mask=TV host=SageTV-VM encodedBy=Hauppauge HD PVR Capture Device HDPVRMax format=MPEG2-TS 1:59:51 2884 kbps [#0 Video[H.264 29.97003 fps 1920x1080 16:9 interlaced id=1011]#1 Audio[AC3 48000 Hz 2 channels 384 kbps MAIN idx=1 id=1100]{ScrapedBy=Phoenix, IMDBID=tt0758730, MediaType=Movie, ScrapedDate=1350790824345, MediaProviderDataID=tt0758730, MediaTitle=AVPR: Aliens vs Predator - Requiem, DiscNumber=0, UserRating=47, MediaProviderID=imdb}] \\W7-Server\Recordings (DVR)\AliensvsPredatorRequiem-12823703-0.ts, Seg0[Wed 12/28 0:00:00.014-Wed 12/28 1:59:51.494]] ifn=null] nPlayin=false
Wed 1/2 22:21:53.869 [AWT-EventQueue-0@128a415] VF processing on UI Thread VFJob[WatchMF r=0.0 t=0 file=MediaFile[id=12947004 A[12823703,119699,"Aliens vs. Predator: Requiem",58574@1228.00:00,120] mask=TV host=SageTV-VM encodedBy=Hauppauge HD PVR Capture Device HDPVRMax format=MPEG2-TS 1:59:51 2884 kbps [#0 Video[H.264 29.97003 fps 1920x1080 16:9 interlaced id=1011]#1 Audio[AC3 48000 Hz 2 channels 384 kbps MAIN idx=1 id=1100]{ScrapedBy=Phoenix, IMDBID=tt0758730, MediaType=Movie, ScrapedDate=1350790824345, MediaProviderDataID=tt0758730, MediaTitle=AVPR: Aliens vs Predator - Requiem, DiscNumber=0, UserRating=47, MediaProviderID=imdb}] \\W7-Server\Recordings (DVR)\AliensvsPredatorRequiem-12823703-0.ts, Seg0[Wed 12/28 0:00:00.014-Wed 12/28 1:59:51.494]] ifn=null]
Wed 1/2 22:21:53.870 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] VF processing job VFJob[LoadMF r=0.0 t=0 file=MediaFile[id=12947004 A[12823703,119699,"Aliens vs. Predator: Requiem",58574@1228.00:00,120] mask=TV host=SageTV-VM encodedBy=Hauppauge HD PVR Capture Device HDPVRMax format=MPEG2-TS 1:59:51 2884 kbps [#0 Video[H.264 29.97003 fps 1920x1080 16:9 interlaced id=1011]#1 Audio[AC3 48000 Hz 2 channels 384 kbps MAIN idx=1 id=1100]{ScrapedBy=Phoenix, IMDBID=tt0758730, MediaType=Movie, ScrapedDate=1350790824345, MediaProviderDataID=tt0758730, MediaTitle=AVPR: Aliens vs Predator - Requiem, DiscNumber=0, UserRating=47, MediaProviderID=imdb}] \\W7-Server\Recordings (DVR)\AliensvsPredatorRequiem-12823703-0.ts, Seg0[Wed 12/28 0:00:00.014-Wed 12/28 1:59:51.494]] ifn=null] nPlayin=false
Wed 1/2 22:21:53.870 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] VF network encoder playback detected: false
Wed 1/2 22:21:53.874 [AsyncWatch@19eedef] setUI(sage.cb@1009d04[MediaPlayer OSD]) histIdx=8 uiHistory=[sage.cb@1b4cf46[Main Menu], sage.cb@151448c[TV Explorer], sage.cb@102aa10[Main Menu], sage.cb@2667a2[Plugin List], sage.cb@1b4cf46[Main Menu], sage.cb@1b1cd95[Scheduled Recordings], sage.cb@1b4cf46[Main Menu], sage.cb@151448c[TV Explorer], sage.cb@1009d04[MediaPlayer OSD]] redo=false
Wed 1/2 22:21:53.875 [AWT-EventQueue-0@128a415] VF processing on UI Thread VFJob[LoadMF r=0.0 t=0 file=MediaFile[id=12947004 A[12823703,119699,"Aliens vs. Predator: Requiem",58574@1228.00:00,120] mask=TV host=SageTV-VM encodedBy=Hauppauge HD PVR Capture Device HDPVRMax format=MPEG2-TS 1:59:51 2884 kbps [#0 Video[H.264 29.97003 fps 1920x1080 16:9 interlaced id=1011]#1 Audio[AC3 48000 Hz 2 channels 384 kbps MAIN idx=1 id=1100]{ScrapedBy=Phoenix, IMDBID=tt0758730, MediaType=Movie, ScrapedDate=1350790824345, MediaProviderDataID=tt0758730, MediaTitle=AVPR: Aliens vs Predator - Requiem, DiscNumber=0, UserRating=47, MediaProviderID=imdb}] \\W7-Server\Recordings (DVR)\AliensvsPredatorRequiem-12823703-0.ts, Seg0[Wed 12/28 0:00:00.014-Wed 12/28 1:59:51.494]] ifn=null]
Wed 1/2 22:21:53.875 [AWT-EventQueue-0@128a415] VideoFrame creating new media player for file:MediaFile[id=12947004 A[12823703,119699,"Aliens vs. Predator: Requiem",58574@1228.00:00,120] mask=TV host=SageTV-VM encodedBy=Hauppauge HD PVR Capture Device HDPVRMax format=MPEG2-TS 1:59:51 2884 kbps [#0 Video[H.264 29.97003 fps 1920x1080 16:9 interlaced id=1011]#1 Audio[AC3 48000 Hz 2 channels 384 kbps MAIN idx=1 id=1100]{ScrapedBy=Phoenix, IMDBID=tt0758730, MediaType=Movie, ScrapedDate=1350790824345, MediaProviderDataID=tt0758730, MediaTitle=AVPR: Aliens vs Predator - Requiem, DiscNumber=0, UserRating=47, MediaProviderID=imdb}] \\W7-Server\Recordings (DVR)\AliensvsPredatorRequiem-12823703-0.ts, Seg0[Wed 12/28 0:00:00.014-Wed 12/28 1:59:51.494]]
Wed 1/2 22:21:53.875 [AWT-EventQueue-0@128a415] VF file=MediaFile[id=12947004 A[12823703,119699,"Aliens vs. Predator: Requiem",58574@1228.00:00,120] mask=TV host=SageTV-VM encodedBy=Hauppauge HD PVR Capture Device HDPVRMax format=MPEG2-TS 1:59:51 2884 kbps [#0 Video[H.264 29.97003 fps 1920x1080 16:9 interlaced id=1011]#1 Audio[AC3 48000 Hz 2 channels 384 kbps MAIN idx=1 id=1100]{ScrapedBy=Phoenix, IMDBID=tt0758730, MediaType=Movie, ScrapedDate=1350790824345, MediaProviderDataID=tt0758730, MediaTitle=AVPR: Aliens vs Predator - Requiem, DiscNumber=0, UserRating=47, MediaProviderID=imdb}] \\W7-Server\Recordings (DVR)\AliensvsPredatorRequiem-12823703-0.ts, Seg0[Wed 12/28 0:00:00.014-Wed 12/28 1:59:51.494]] targetTime = Wed 12/28 0:00:00.014
Wed 1/2 22:21:53.876 [AWT-EventQueue-0@128a415] VideoFrame.timeSelected(Wed 12/28 0:00:00.014, true) currFile=MediaFile[id=12947004 A[12823703,119699,"Aliens vs. Predator: Requiem",58574@1228.00:00,120] mask=TV host=SageTV-VM encodedBy=Hauppauge HD PVR Capture Device HDPVRMax format=MPEG2-TS 1:59:51 2884 kbps [#0 Video[H.264 29.97003 fps 1920x1080 16:9 interlaced id=1011]#1 Audio[AC3 48000 Hz 2 channels 384 kbps MAIN idx=1 id=1100]{ScrapedBy=Phoenix, IMDBID=tt0758730, MediaType=Movie, ScrapedDate=1350790824345, MediaProviderDataID=tt0758730, MediaTitle=AVPR: Aliens vs Predator - Requiem, DiscNumber=0, UserRating=47, MediaProviderID=imdb}] \\W7-Server\Recordings (DVR)\AliensvsPredatorRequiem-12823703-0.ts, Seg0[Wed 12/28 0:00:00.014-Wed 12/28 1:59:51.494]]
Wed 1/2 22:21:53.887 [AWT-EventQueue-0@128a415] Creating GraphPluginHandler...
Wed 1/2 22:21:53.887 [AWT-EventQueue-0@128a415] Done creating GraphPluginHandler
Wed 1/2 22:21:53.888 [AWT-EventQueue-0@128a415] DShowPlayer setVideoRendererFilter0({FA10746C-9B63-4B6C-BC49-FC300EA5F256}) called
Wed 1/2 22:21:53.888 [AWT-EventQueue-0@128a415] Using EVR for video render
Wed 1/2 22:21:53.915 [AWT-EventQueue-0@128a415] Using 3 input pins on the EVR
Wed 1/2 22:21:53.915 [AWT-EventQueue-0@128a415] Finished with EVR configuration OK
Wed 1/2 22:21:53.915 [AWT-EventQueue-0@128a415] DShowPlayer setVideoDecoderFilter0(Microsoft DTV-DVD Video Decoder) called
Wed 1/2 22:21:53.922 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] VideoFrame got registration of a subtitle UI component: sage.q[loc=java.awt.Point[x=133,y=470] size=java.awt.Dimension[width=621,height=125]]
Wed 1/2 22:21:53.923 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] VideoFrame got registration of a cc UI component: sage.q[loc=java.awt.Point[x=88,y=61] size=java.awt.Dimension[width=711,height=497]]
Wed 1/2 22:21:53.923 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] VideoFrame got registration of a subtitle UI component: sage.q[loc=java.awt.Point[x=50,y=148] size=java.awt.Dimension[width=237,height=40]]
Wed 1/2 22:21:53.923 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] VideoFrame got registration of a cc UI component: sage.q[loc=java.awt.Point[x=33,y=19] size=java.awt.Dimension[width=271,height=158]]
Wed 1/2 22:21:53.947 [AWT-EventQueue-0@128a415] DShowPlayer setAudioDecoderFilter0(ffdshow Audio Decoder) called
Wed 1/2 22:21:53.961 [AWT-EventQueue-0@128a415] DShowPlayer setTimeshift=0 buffer=0
Wed 1/2 22:21:53.964 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] VideoFrame got registration of a subtitle UI component: sage.q[loc=java.awt.Point[x=133,y=470] size=java.awt.Dimension[width=621,height=125]]
Wed 1/2 22:21:53.965 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] VideoFrame got registration of a cc UI component: sage.q[loc=java.awt.Point[x=88,y=61] size=java.awt.Dimension[width=711,height=497]]
Wed 1/2 22:21:53.965 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] VideoFrame got registration of a subtitle UI component: sage.q[loc=java.awt.Point[x=50,y=148] size=java.awt.Dimension[width=237,height=40]]
Wed 1/2 22:21:53.965 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] VideoFrame got registration of a cc UI component: sage.q[loc=java.awt.Point[x=33,y=19] size=java.awt.Dimension[width=271,height=158]]
Wed 1/2 22:21:53.969 [AsyncWatch@19eedef] VideoFrame got registration of a subtitle UI component: null
Wed 1/2 22:21:53.970 [AWT-EventQueue-0@128a415] Using the default source filter
Wed 1/2 22:21:53.970 [AsyncWatch@19eedef] VideoFrame got registration of a cc UI component: null
Wed 1/2 22:21:53.970 [AWT-EventQueue-0@128a415] NATIVE Loading the source file
Wed 1/2 22:21:53.988 [AWT-EventQueue-0@128a415] NATIVE Setting up the MPEG demux
Wed 1/2 22:21:54.007 [AWT-EventQueue-0@128a415] Calling GraphCreated for the PluginHandler
Wed 1/2 22:21:54.007 [AWT-EventQueue-0@128a415] Done calling GraphCreated for the PluginHandler
Wed 1/2 22:21:54.007 [AWT-EventQueue-0@128a415] Audio Stream #1 format AC3 channels 2 freq 48000
Wed 1/2 22:21:54.007 [AWT-EventQueue-0@128a415] NATIVE RenderAudio called stream=1
Wed 1/2 22:21:54.008 [AWT-EventQueue-0@128a415] NATIVE RenderAudio step 1
Wed 1/2 22:21:54.014 [AWT-EventQueue-0@128a415] NATIVE RenderAudio step 2
Wed 1/2 22:21:54.014 [AWT-EventQueue-0@128a415] NATIVE RenderAudio step 3
Wed 1/2 22:21:54.014 [AWT-EventQueue-0@128a415] NATIVE RenderAudio step 4
Wed 1/2 22:21:54.035 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] VideoFrame got registration of a subtitle UI component: sage.q[loc=java.awt.Point[x=133,y=470] size=java.awt.Dimension[width=621,height=125]]
Wed 1/2 22:21:54.035 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] VideoFrame got registration of a cc UI component: sage.q[loc=java.awt.Point[x=88,y=61] size=java.awt.Dimension[width=711,height=497]]
Wed 1/2 22:21:54.070 [AWT-EventQueue-0@128a415] NATIVE RenderVideo called
Wed 1/2 22:21:54.071 [AWT-EventQueue-0@128a415] NATIVE RenderVideo step 1
Wed 1/2 22:21:54.071 [AWT-EventQueue-0@128a415] NATIVE RenderVideo step 2
Wed 1/2 22:21:54.071 [AWT-EventQueue-0@128a415] Video source pin information:
Wed 1/2 22:21:54.071 [AWT-EventQueue-0@128a415] PIN is not connected yet!Wed 1/2 22:21:54.071 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type Unknown GUID Name F type FORMAT_VideoInfo2
Wed 1/2 22:21:54.071 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:21:54.071 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:21:54.071 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:21:54.071 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:21:54.072 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:21:54.072 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type Unknown GUID Name F type FORMAT_VideoInfo2
Wed 1/2 22:21:54.072 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:21:54.072 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:21:54.072 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:21:54.072 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:21:54.072 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:21:54.072 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type Unknown GUID Name F type FORMAT_VideoInfo2
Wed 1/2 22:21:54.072 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:21:54.072 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:21:54.072 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:21:54.072 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:21:54.073 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:21:54.073 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type Unknown GUID Name F type FORMAT_VideoInfo2
Wed 1/2 22:21:54.073 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:21:54.073 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:21:54.073 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:21:54.073 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:21:54.073 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:21:54.073 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type MEDIASUBTYPE_NV12 F type FORMAT_VideoInfo2
Wed 1/2 22:21:54.073 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:21:54.073 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:21:54.073 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:21:54.073 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:21:54.074 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:21:54.074 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type MEDIASUBTYPE_NV12 F type FORMAT_VideoInfo2
Wed 1/2 22:21:54.074 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:21:54.074 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:21:54.074 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:21:54.074 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:21:54.074 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:21:54.074 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type Unknown GUID Name F type FORMAT_VideoInfo2
Wed 1/2 22:21:54.074 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:21:54.074 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:21:54.074 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:21:54.074 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:21:54.074 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:21:54.075 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type Unknown GUID Name F type FORMAT_VideoInfo2
Wed 1/2 22:21:54.075 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:21:54.075 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:21:54.075 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:21:54.075 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:21:54.075 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:21:54.075 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type MEDIASUBTYPE_YUY2 F type FORMAT_VideoInfo2
Wed 1/2 22:21:54.075 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:21:54.075 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:21:54.075 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:21:54.075 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:21:54.075 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:21:54.076 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type MEDIASUBTYPE_YUY2 F type FORMAT_VideoInfo2
Wed 1/2 22:21:54.076 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:21:54.076 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:21:54.076 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:21:54.076 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:21:54.076 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:21:54.076 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type MEDIASUBTYPE_YV12 F type FORMAT_VideoInfo2
Wed 1/2 22:21:54.076 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:21:54.076 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:21:54.076 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:21:54.076 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:21:54.076 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:21:54.076 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type MEDIASUBTYPE_YV12 F type FORMAT_VideoInfo2
Wed 1/2 22:21:54.077 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:21:54.077 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:21:54.077 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:21:54.077 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:21:54.077 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:21:54.077 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type MEDIASUBTYPE_IMC4 F type FORMAT_VideoInfo2
Wed 1/2 22:21:54.077 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:21:54.077 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:21:54.077 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:21:54.077 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:21:54.077 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:21:54.077 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type MEDIASUBTYPE_IMC4 F type FORMAT_VideoInfo2
Wed 1/2 22:21:54.077 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:21:54.078 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:21:54.078 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:21:54.078 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:21:54.078 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:21:54.078 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type MEDIASUBTYPE_IMC3 F type FORMAT_VideoInfo2
Wed 1/2 22:21:54.078 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:21:54.078 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:21:54.078 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:21:54.078 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:21:54.078 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:21:54.078 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type MEDIASUBTYPE_IMC3 F type FORMAT_VideoInfo2
Wed 1/2 22:21:54.078 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:21:54.079 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:21:54.079 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:21:54.079 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:21:54.079 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:21:54.079 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type MEDIASUBTYPE_S340 F type FORMAT_VideoInfo2
Wed 1/2 22:21:54.079 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:21:54.079 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:21:54.079 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:21:54.079 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:21:54.079 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:21:54.079 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type MEDIASUBTYPE_S340 F type FORMAT_VideoInfo2
Wed 1/2 22:21:54.079 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:21:54.079 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:21:54.080 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:21:54.080 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:21:54.080 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:21:54.080 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type MEDIASUBTYPE_NV24 F type FORMAT_VideoInfo2
Wed 1/2 22:21:54.080 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:21:54.080 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:21:54.080 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:21:54.080 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:21:54.080 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:21:54.080 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type MEDIASUBTYPE_NV24 F type FORMAT_VideoInfo2
Wed 1/2 22:21:54.080 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:21:54.080 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:21:54.081 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:21:54.081 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:21:54.081 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:21:54.081 [AWT-EventQueue-0@128a415] NATIVE RenderVideo step 3
Wed 1/2 22:21:54.311 [AWT-EventQueue-0@128a415] Setting up video processing mode for EVR
Wed 1/2 22:21:54.311 [AWT-EventQueue-0@128a415] EVR VideoProcMode 0 - {3C5323C1-6FB7-44F5-9081-056BF2EE449D}
Wed 1/2 22:21:54.312 [AWT-EventQueue-0@128a415] EVR VideoProcMode 1 - {552C0DAD-CCBC-420B-83C8-74943CF9F1A6}
Wed 1/2 22:21:54.312 [AWT-EventQueue-0@128a415] EVR VideoProcMode 2 - {6E8329FF-B642-418B-BCF0-BCB6591E255F}
Wed 1/2 22:21:54.312 [AWT-EventQueue-0@128a415] EVR VideoProcMode 3 - {335AA36E-7884-43A4-9C91-7F87FAF3E37E}
Wed 1/2 22:21:54.312 [AWT-EventQueue-0@128a415] EVR VideoProcMode 4 - {5A54A0C9-C7EC-4BD9-8EDE-F3C75DC4393B}
Wed 1/2 22:21:54.312 [AWT-EventQueue-0@128a415] EVR set the video processing mode to index 0! hr=0x0
Wed 1/2 22:21:54.312 [AWT-EventQueue-0@128a415] Filter Graph Video Renderer Info:
Wed 1/2 22:21:54.312 [AWT-EventQueue-0@128a415] Video Renderer:CLSID_EnhancedVideoRenderer
Wed 1/2 22:21:54.312 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type MEDIASUBTYPE_NV12 F type FORMAT_VideoInfo2
Wed 1/2 22:21:54.312 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:21:54.312 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:21:54.313 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:21:54.313 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:21:54.313 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:21:54.313 [AWT-EventQueue-0@128a415] VMR9 filter detected, using line 21 decoder 2.
Wed 1/2 22:21:54.315 [AWT-EventQueue-0@128a415] DShowGraphFilters=Default DirectSound Device,VidRend,Line21 Decoder,Audio Decoder,Video Decoder,SageTV MPEG2 Demultiplexer,\\W7-Server\Recordings (DVR)\AliensvsPredatorRequiem-12823703-0.ts,
Wed 1/2 22:21:54.315 [AWT-EventQueue-0@128a415] ----------->Get getDurationMillis0=7191380.
Wed 1/2 22:21:54.315 [AWT-EventQueue-0@128a415] VideoFrame.timeSelected2(Wed 12/28 0:00:00.014, true) currFile=MediaFile[id=12947004 A[12823703,119699,"Aliens vs. Predator: Requiem",58574@1228.00:00,120] mask=TV host=SageTV-VM encodedBy=Hauppauge HD PVR Capture Device HDPVRMax format=MPEG2-TS 1:59:51 2884 kbps [#0 Video[H.264 29.97003 fps 1920x1080 16:9 interlaced id=1011]#1 Audio[AC3 48000 Hz 2 channels 384 kbps MAIN idx=1 id=1100]{ScrapedBy=Phoenix, IMDBID=tt0758730, MediaType=Movie, ScrapedDate=1350790824345, MediaProviderDataID=tt0758730, MediaTitle=AVPR: Aliens vs Predator - Requiem, DiscNumber=0, UserRating=47, MediaProviderID=imdb}] \\W7-Server\Recordings (DVR)\AliensvsPredatorRequiem-12823703-0.ts, Seg0[Wed 12/28 0:00:00.014-Wed 12/28 1:59:51.494]] realDur=7191380
Wed 1/2 22:21:54.316 [AWT-EventQueue-0@128a415] About to perform media time selection for 0
Wed 1/2 22:21:54.316 [AWT-EventQueue-0@128a415] Running the playback graph.
Wed 1/2 22:21:54.316 [main@136bdda] VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null])
Wed 1/2 22:21:54.393 [main@136bdda] VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null])
Wed 1/2 22:21:54.673 [Thread-571@14ef7da] VMR9 info has changed width=1920 height=1080 arx=0 ary=0
Wed 1/2 22:21:55.034 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] =======>Get getMediaTimeMillis0 cur:509 s0:0 s1:0 new:509.
Wed 1/2 22:21:55.289 [AWTThreadWatcher-SAGETV_PROCESS_LOCAL_UI@374534] EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 750
Wed 1/2 22:21:56.039 [AWTThreadWatcher-SAGETV_PROCESS_LOCAL_UI@374534] EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 1500
Wed 1/2 22:21:56.050 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] =======>Get getMediaTimeMillis0 cur:2634 s0:0 s1:0 new:2634.
Wed 1/2 22:21:56.072 [AWT-EventQueue-0@128a415] Sending event to server for PlaybackStarted args={UIContext=/192.168.1.100:55539, MediaTime=1325048402668, ChapterNum=0, MediaFile=MediaFile[id=12947004 A[12823703,119699,"Aliens vs. Predator: Requiem",58574@1228.00:00,120] mask=TV host=SageTV-VM encodedBy=Hauppauge HD PVR Capture Device HDPVRMax format=MPEG2-TS 1:59:51 2884 kbps [#0 Video[H.264 29.97003 fps 1920x1080 16:9 interlaced id=1011]#1 Audio[AC3 48000 Hz 2 channels 384 kbps MAIN idx=1 id=1100]{ScrapedBy=Phoenix, IMDBID=tt0758730, MediaType=Movie, ScrapedDate=1350790824345, MediaProviderDataID=tt0758730, MediaTitle=AVPR: Aliens vs Predator - Requiem, DiscNumber=0, UserRating=47, MediaProviderID=imdb}] \\W7-Server\Recordings (DVR)\AliensvsPredatorRequiem-12823703-0.ts, Seg0[Wed 12/28 0:00:00.014-Wed 12/28 1:59:51.494]], Duration=7191480, TitleNum=0}
Wed 1/2 22:21:56.072 [ReProcessHook@b6a6dc] Start looking for max channel digits
Wed 1/2 22:21:56.073 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true
Wed 1/2 22:21:56.073 [AWT-EventQueue-0@128a415] VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null]
Wed 1/2 22:21:56.073 [AWT-EventQueue-0@128a415] DShowMediaPlayer is consuming the events...
Wed 1/2 22:21:56.073 [ReProcessHook@b6a6dc] New max channel = 3, from channel 618 on lineup 'DIRECTV New York - New York'
Wed 1/2 22:21:56.075 [AWT-EventQueue-0@128a415] Event: 0xd l1=0x0 l2=0x0
Wed 1/2 22:21:56.076 [AWT-EventQueue-0@128a415] Event: 0xe l1=0x0 l2=0x0
Wed 1/2 22:21:56.076 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true
Wed 1/2 22:21:56.077 [AWT-EventQueue-0@128a415] VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null]
Wed 1/2 22:21:56.077 [AWT-EventQueue-0@128a415] DShowMediaPlayer is consuming the events...
Wed 1/2 22:21:56.079 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] VF processing job null nPlayin=true
Wed 1/2 22:21:56.080 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] isRec=false rd=7191380 base=2663 eos=false
Wed 1/2 22:21:56.080 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] VF thread is now waiting for 1:59:48.467
Wed 1/2 22:21:56.094 [ReProcessHook@b6a6dc] Done looking for max channel digits; elapsed time: 22
Wed 1/2 22:21:56.232 [Thread-619@1121811] VMR9 info has changed width=1280 height=720 arx=0 ary=0
Wed 1/2 22:21:57.054 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] =======>Get getMediaTimeMillis0 cur:3638 s0:0 s1:0 new:3638.
Wed 1/2 22:21:58.036 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] =======>Get getMediaTimeMillis0 cur:4620 s0:0 s1:0 new:4620.
Wed 1/2 22:21:59.051 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] =======>Get getMediaTimeMillis0 cur:5636 s0:0 s1:0 new:5636.
Wed 1/2 22:22:00.008 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] =======>Get getMediaTimeMillis0 cur:6593 s0:0 s1:0 new:6593.
Wed 1/2 22:22:01.039 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] =======>Get getMediaTimeMillis0 cur:7623 s0:0 s1:0 new:7623.
Wed 1/2 22:22:01.765 [AWT-EventQueue-0@128a415] VF.submitJob(VFJob[CloseMF r=0.0 t=0 file=null ifn=null])
Wed 1/2 22:22:01.765 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] VF processing job VFJob[CloseMF r=0.0 t=0 file=null ifn=null] nPlayin=true
Wed 1/2 22:22:01.766 [AWT-EventQueue-0@128a415] CloseAndWait is executing the close job synchronously now
Wed 1/2 22:22:01.766 [AWT-EventQueue-0@128a415] VF processing on UI Thread VFJob[CloseMF r=0.0 t=0 file=null ifn=null]
Wed 1/2 22:22:01.768 [AWT-EventQueue-0@128a415] VF logFileWatch doneAir=A[12823703,119699,"Aliens vs. Predator: Requiem",58574@1228.00:00,120] theTime=Wed 12/28 0:00:08.366 recTime=Wed 12/28 0:00:00.014
Wed 1/2 22:22:01.769 [main@136bdda] Stopping the playback graph.
Wed 1/2 22:22:01.876 [main@136bdda] Calling GraphStopped for the PluginHandler
Wed 1/2 22:22:01.876 [main@136bdda] Done calling GraphStopped for the PluginHandler
Wed 1/2 22:22:01.876 [AWT-EventQueue-0@128a415] Tearing down playback graph
Wed 1/2 22:22:01.877 [AWT-EventQueue-0@128a415] NATIVE Deallocating the CPlayerData object
Wed 1/2 22:22:01.877 [AWT-EventQueue-0@128a415] ....RemoveFilter [Default DirectSound Device] .
Wed 1/2 22:22:01.877 [AWT-EventQueue-0@128a415] ....RemoveFilter [VidRend] .
Wed 1/2 22:22:01.879 [AWT-EventQueue-0@128a415] ....RemoveFilter [Audio Decoder] .
Wed 1/2 22:22:01.895 [AWT-EventQueue-0@128a415] ....RemoveFilter [Line21 Decoder] .
Wed 1/2 22:22:01.896 [AWT-EventQueue-0@128a415] ....RemoveFilter [Video Decoder] .
Wed 1/2 22:22:01.897 [AWT-EventQueue-0@128a415] ....RemoveFilter [SageTV MPEG2 Demultiplexer] .
Wed 1/2 22:22:01.901 [AWT-EventQueue-0@128a415] ....RemoveFilter [\\W7-Server\Recordings (DVR)\AliensvsPredatorRequiem-12823703-0.ts] .
Wed 1/2 22:22:01.902 [AWT-EventQueue-0@128a415] NATIVE Finished destroying the playback graph
Wed 1/2 22:22:01.904 [AWT-EventQueue-0@128a415] Calling GraphDestroyed for GraphPlugins
Wed 1/2 22:22:01.904 [AWT-EventQueue-0@128a415] Done calling GraphDestroyed for GraphPlugins. Destroying the plugin object now.
Wed 1/2 22:22:01.904 [AWT-EventQueue-0@128a415] Done destroying the GraphPlugin object
Wed 1/2 22:22:01.904 [AWT-EventQueue-0@128a415] Sending event to server for PlaybackStopped args={UIContext=/192.168.1.100:55539, MediaTime=1325048408369, ChapterNum=0, MediaFile=MediaFile[id=12947004 A[12823703,119699,"Aliens vs. Predator: Requiem",58574@1228.00:00,120] mask=TV host=SageTV-VM encodedBy=Hauppauge HD PVR Capture Device HDPVRMax format=MPEG2-TS 1:59:51 2884 kbps [#0 Video[H.264 29.97003 fps 1920x1080 16:9 interlaced id=1011]#1 Audio[AC3 48000 Hz 2 channels 384 kbps MAIN idx=1 id=1100]{ScrapedBy=Phoenix, IMDBID=tt0758730, MediaType=Movie, ScrapedDate=1350790824345, MediaProviderDataID=tt0758730, MediaTitle=AVPR: Aliens vs Predator - Requiem, DiscNumber=0, UserRating=47, MediaProviderID=imdb}] \\W7-Server\Recordings (DVR)\AliensvsPredatorRequiem-12823703-0.ts, Seg0[Wed 12/28 0:00:00.014-Wed 12/28 1:59:51.494]], Duration=7191480, TitleNum=0}
Wed 1/2 22:22:01.905 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] VF processing job null nPlayin=false
Wed 1/2 22:22:01.905 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] VF thread is now waiting for 0:00:00.000
Wed 1/2 22:22:02.059 [AWT-EventQueue-0@128a415] setUI(sage.cb@151448c[TV Explorer]) histIdx=7 uiHistory=[sage.cb@1b4cf46[Main Menu], sage.cb@151448c[TV Explorer], sage.cb@102aa10[Main Menu], sage.cb@2667a2[Plugin List], sage.cb@1b4cf46[Main Menu], sage.cb@1b1cd95[Scheduled Recordings], sage.cb@1b4cf46[Main Menu], sage.cb@151448c[TV Explorer], sage.cb@1009d04[MediaPlayer OSD]] redo=true
Wed 1/2 22:22:02.059 [AWT-EventQueue-0@128a415] VideoFrame got registration of a subtitle UI component: null
Wed 1/2 22:22:02.059 [AWT-EventQueue-0@128a415] VideoFrame got registration of a cc UI component: null
Wed 1/2 22:22:02.060 [AWT-EventQueue-0@128a415] Get Imported TV Files - Start
Wed 1/2 22:22:02.060 [AWT-EventQueue-0@128a415] Display ImportedTV = true
Wed 1/2 22:22:02.060 [AWT-EventQueue-0@128a415] LimitSearchPaths = None
Wed 1/2 22:22:02.060 [AWT-EventQueue-0@128a415] TCED: Non-null TVImportFiles 222
Wed 1/2 22:22:02.061 [AWT-EventQueue-0@128a415] Get Imported TV Files - Done
Wed 1/2 22:22:02.061 [AWT-EventQueue-0@128a415] Get Recorded Files - Start
Wed 1/2 22:22:02.092 [AWT-EventQueue-0@128a415] Get Recorded Files - Done
Wed 1/2 22:22:02.093 [AWT-EventQueue-0@128a415] Get Scheduled Files - Start
Wed 1/2 22:22:02.823 [AWTThreadWatcher-SAGETV_PROCESS_LOCAL_UI@374534] EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 750
Wed 1/2 22:22:03.573 [AWTThreadWatcher-SAGETV_PROCESS_LOCAL_UI@374534] EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 1500
Wed 1/2 22:22:04.323 [AWTThreadWatcher-SAGETV_PROCESS_LOCAL_UI@374534] EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 2250
Wed 1/2 22:22:05.073 [AWTThreadWatcher-SAGETV_PROCESS_LOCAL_UI@374534] EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 3000
Wed 1/2 22:22:05.823 [AWTThreadWatcher-SAGETV_PROCESS_LOCAL_UI@374534] EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 3750
Wed 1/2 22:22:06.573 [AWTThreadWatcher-SAGETV_PROCESS_LOCAL_UI@374534] EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 4500
Wed 1/2 22:22:07.323 [AWTThreadWatcher-SAGETV_PROCESS_LOCAL_UI@374534] EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 5250
Wed 1/2 22:22:08.073 [AWTThreadWatcher-SAGETV_PROCESS_LOCAL_UI@374534] EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 6000
Wed 1/2 22:22:08.823 [AWTThreadWatcher-SAGETV_PROCESS_LOCAL_UI@374534] EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 6750
Wed 1/2 22:22:09.573 [AWTThreadWatcher-SAGETV_PROCESS_LOCAL_UI@374534] EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 7499
Wed 1/2 22:22:10.323 [AWTThreadWatcher-SAGETV_PROCESS_LOCAL_UI@374534] EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 8249
Wed 1/2 22:22:11.072 [AWTThreadWatcher-SAGETV_PROCESS_LOCAL_UI@374534] EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 8999
Wed 1/2 22:22:11.500 [AWT-EventQueue-0@128a415] Get Scheduled Files - Done
Wed 1/2 22:22:11.500 [AWT-EventQueue-0@128a415] Start applying filters
Wed 1/2 22:22:11.501 [AWT-EventQueue-0@128a415] Done applying filters
Wed 1/2 22:22:11.501 [AWT-EventQueue-0@128a415] Start Grouping
Wed 1/2 22:22:11.539 [AWT-EventQueue-0@128a415] Done Grouping
Wed 1/2 22:22:11.539 [AWT-EventQueue-0@128a415] Starting EpSorting
Wed 1/2 22:22:11.822 [AWTThreadWatcher-SAGETV_PROCESS_LOCAL_UI@374534] EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 9749
Wed 1/2 22:22:12.045 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] VF processing job null nPlayin=false
Wed 1/2 22:22:12.046 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] VF thread is now waiting for 0:00:00.000
Wed 1/2 22:22:13.109 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] VF processing job null nPlayin=false
Wed 1/2 22:22:13.109 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] VF thread is now waiting for 0:00:00.000
Wed 1/2 22:24:19.390 [Timer-3@66a47a] Screen Saver Timeout expired....tv=false playin=false fs=false sleepy=false currSS=false
Wed 1/2 22:25:03.402 [AWT-EventQueue-0@128a415] Group Focus Changed
Wed 1/2 22:25:04.201 [AWT-EventQueue-0@128a415] Setting Focus on Episode Panel
Wed 1/2 22:25:06.102 [AWT-EventQueue-0@128a415] setUI(sage.cb@9c05d2[Main Menu]) histIdx=8 uiHistory=[sage.cb@1b4cf46[Main Menu], sage.cb@151448c[TV Explorer], sage.cb@102aa10[Main Menu], sage.cb@2667a2[Plugin List], sage.cb@1b4cf46[Main Menu], sage.cb@1b1cd95[Scheduled Recordings], sage.cb@1b4cf46[Main Menu], sage.cb@151448c[TV Explorer], sage.cb@9c05d2[Main Menu]] redo=false
Wed 1/2 22:25:06.159 [AWT-EventQueue-0@128a415] Global variables already set.
Wed 1/2 22:25:06.159 [AWT-EventQueue-0@128a415] Theme settings already loaded.
Wed 1/2 22:25:06.161 [AWT-EventQueue-0@128a415] Done with Category BG color mapping; 7 items in gCategoryBGColorMap={xDefaultBGColor=[C:\Program Files (x86)\SageTV\SageTV\STVs\SageTV7\Themes\George\GuideAiringBGDefault.png, C:\Program Files (x86)\SageTV\SageTV\STVs\SageTV7\Themes\George\GuideAiringBGDefault2.png], Movie=[C:\Program Files (x86)\SageTV\SageTV\STVs\SageTV7\Themes\George\GuideAiringBGMovie.png, C:\Program Files (x86)\SageTV\SageTV\STVs\SageTV7\Themes\George\GuideAiringBGMovie2.png], Sports talk=[C:\Program Files (x86)\SageTV\SageTV\STVs\SageTV7\Themes\George\GuideAiringBGSports.png, C:\Program Files (x86)\SageTV\SageTV\STVs\SageTV7\Themes\George\GuideAiringBGSports2.png], Film=[C:\Program Files (x86)\SageTV\SageTV\STVs\SageTV7\Themes\George\GuideAiringBGMovie.png, C:\Program Files (x86)\SageTV\SageTV\STVs\SageTV7\Themes\George\GuideAiringBGMovie2.png], Sports event=[C:\Program Files (x86)\SageTV\SageTV\STVs\SageTV7\Themes\George\GuideAiringBGSports.png, C:\Program Files (x86)\SageTV\SageTV\STVs\SageTV7\Themes\George\GuideAiringBGSports2.png], News=[C:\Program Files (x86)\SageTV\SageTV\STVs\SageTV7\Themes\George\GuideAiringBGNews.png, C:\Program Files (x86)\SageTV\SageTV\STVs\SageTV7\Themes\George\GuideAiringBGNews2.png], Sports non-event=[C:\Program Files (x86)\SageTV\SageTV\STVs\SageTV7\Themes\George\GuideAiringBGSports.png, C:\Program Files (x86)\SageTV\SageTV\STVs\SageTV7\Themes\George\GuideAiringBGSports2.png]}
Wed 1/2 22:25:06.163 [AWT-EventQueue-0@128a415] Hulu command HuluCommand=[null]
Wed 1/2 22:25:06.163 [AWT-EventQueue-0@128a415] For location '', found instance= sage.google.weather.WeatherUnderground@15aba6c
Wed 1/2 22:25:06.163 [AWT-EventQueue-0@128a415] instance for '' = sage.google.weather.WeatherUnderground@15aba6c
Wed 1/2 22:25:06.163 [AWT-EventQueue-0@128a415] The Weather Underground instance = 'sage.google.weather.WeatherUnderground@15aba6c'
Wed 1/2 22:25:06.163 [AWT-EventQueue-0@128a415] The Weather Underground WeatherLoc = '{neighborhood=, state=NJ, loccode=08872, country=US, city=Matawan}'
Wed 1/2 22:25:06.164 [Fork-BASE-71232@19eedef]    Not time to update weather yet.
Wed 1/2 22:25:06.164 [AWT-EventQueue-0@128a415] BEGIN: Sort video playlists.
Wed 1/2 22:25:06.165 [AWT-EventQueue-0@128a415] END: Sort video playlists. Sorted 1 playlists. Total Time = '0'
Wed 1/2 22:25:06.166 [AWT-EventQueue-0@128a415] BEGIN: Sort playlists.
Wed 1/2 22:25:06.166 [AWT-EventQueue-0@128a415] END: Sort playlists. Sorted 2 playlists. Total Time = '0'
Wed 1/2 22:25:06.204 [AWT-EventQueue-0@128a415] UIManager.gotoSleep(false) isTaskbar=false
Wed 1/2 22:25:06.425 [AWT-EventQueue-0@128a415] SetFullScreen(true)
Wed 1/2 22:25:06.426 [AWT-EventQueue-0@128a415] FullScreen set to true
Wed 1/2 22:25:06.434 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] UIManager is updating the window size-2 of 1920x1080 because we're in FS Mode and the window size doesn't match our rendering size of 887x619
Wed 1/2 22:25:06.436 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] UIManager is updating the window size-2 of 1920x1080 because we're in FS Mode and the window size doesn't match our rendering size of 887x619
Wed 1/2 22:25:06.456 [ReProcessHook@19eedef] processOptionsMenu optionsMenu=default:NFLX1-1589415|OptionsMenu:Ask to restart SageTV for plugins
Wed 1/2 22:25:06.465 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] Deriving FreeType font face for fonts\DejaVuSans size=49 style=0 from=C:\Program Files (x86)\SageTV\SageTV\fonts\DejaVuSans.ttf
Wed 1/2 22:25:06.465 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] Loading new font to cache font=MetaFont[fonts\DejaVuSans, size=49, style=0, height=57.0, ascent=46.0, descent=12.0, leading=-1.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:06.470 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] Deriving FreeType font face for fonts\DejaVuSans size=40 style=0 from=C:\Program Files (x86)\SageTV\SageTV\fonts\DejaVuSansB.ttf
Wed 1/2 22:25:06.470 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] Loading new font to cache font=MetaFont[fonts\DejaVuSans, size=40, style=1, height=47.0, ascent=38.0, descent=10.0, leading=-1.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:06.475 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] Deriving FreeType font face for fonts\DejaVuSansMono size=40 style=0 from=C:\Program Files (x86)\SageTV\SageTV\fonts\DejaVuSansMono.ttf
Wed 1/2 22:25:06.476 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] Loading new font to cache font=MetaFont[fonts\DejaVuSansMono, size=40, style=0, height=47.0, ascent=38.0, descent=10.0, leading=-1.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:06.484 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] Deriving FreeType font face for fonts\DejaVuSans size=33 style=0 from=C:\Program Files (x86)\SageTV\SageTV\fonts\DejaVuSansB.ttf
Wed 1/2 22:25:06.485 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] Loading new font to cache font=MetaFont[fonts\DejaVuSans, size=33, style=1, height=38.0, ascent=31.0, descent=8.0, leading=-1.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:06.489 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] Deriving FreeType font face for fonts\DejaVuSans size=81 style=0 from=C:\Program Files (x86)\SageTV\SageTV\fonts\DejaVuSans.ttf
Wed 1/2 22:25:06.490 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] Loading new font to cache font=MetaFont[fonts\DejaVuSans, size=81, style=0, height=94.0, ascent=76.0, descent=20.0, leading=-2.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:06.495 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] Deriving FreeType font face for fonts\DejaVuSans size=58 style=0 from=C:\Program Files (x86)\SageTV\SageTV\fonts\DejaVuSans.ttf
Wed 1/2 22:25:06.495 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] Loading new font to cache font=MetaFont[fonts\DejaVuSans, size=58, style=0, height=68.0, ascent=54.0, descent=14.0, leading=0.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:06.502 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] Deriving FreeType font face for fonts\DejaVuSans size=54 style=0 from=C:\Program Files (x86)\SageTV\SageTV\fonts\DejaVuSans.ttf
Wed 1/2 22:25:06.502 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] Loading new font to cache font=MetaFont[fonts\DejaVuSans, size=54, style=0, height=63.0, ascent=51.0, descent=13.0, leading=-1.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:06.510 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] Deriving FreeType font face for fonts\DejaVuSans size=40 style=0 from=C:\Program Files (x86)\SageTV\SageTV\fonts\DejaVuSans.ttf
Wed 1/2 22:25:06.511 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] Loading new font to cache font=MetaFont[fonts\DejaVuSans, size=40, style=0, height=47.0, ascent=38.0, descent=10.0, leading=-1.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:06.528 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating new RawImage for font rendering w=128 h=128
Wed 1/2 22:25:06.529 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Rendered new font to raw cache index=13 font=MetaFont[fonts\DejaVuSans, size=81, style=0, height=94.0, ascent=76.0, descent=20.0, leading=-2.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:06.529 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=128 h=128
Wed 1/2 22:25:06.530 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating new RawImage for font rendering w=128 h=128
Wed 1/2 22:25:06.531 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Rendered new font to raw cache index=17 font=MetaFont[fonts\DejaVuSans, size=81, style=0, height=94.0, ascent=76.0, descent=20.0, leading=-2.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:06.531 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=128 h=128
Wed 1/2 22:25:06.531 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating new RawImage for font rendering w=128 h=128
Wed 1/2 22:25:06.532 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Rendered new font to raw cache index=16 font=MetaFont[fonts\DejaVuSans, size=81, style=0, height=94.0, ascent=76.0, descent=20.0, leading=-2.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:06.532 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=128 h=128
Wed 1/2 22:25:06.533 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating new RawImage for font rendering w=128 h=128
Wed 1/2 22:25:06.534 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Rendered new font to raw cache index=18 font=MetaFont[fonts\DejaVuSans, size=81, style=0, height=94.0, ascent=76.0, descent=20.0, leading=-2.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:06.534 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=128 h=128
Wed 1/2 22:25:06.535 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating new RawImage for font rendering w=128 h=128
Wed 1/2 22:25:06.535 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Rendered new font to raw cache index=11 font=MetaFont[fonts\DejaVuSans, size=81, style=0, height=94.0, ascent=76.0, descent=20.0, leading=-2.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:06.535 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=128 h=128
Wed 1/2 22:25:06.536 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating new RawImage for font rendering w=128 h=128
Wed 1/2 22:25:06.536 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Rendered new font to raw cache index=15 font=MetaFont[fonts\DejaVuSans, size=81, style=0, height=94.0, ascent=76.0, descent=20.0, leading=-2.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:06.537 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=128 h=128
Wed 1/2 22:25:06.537 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating new RawImage for font rendering w=128 h=128
Wed 1/2 22:25:06.538 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Rendered new font to raw cache index=9 font=MetaFont[fonts\DejaVuSans, size=81, style=0, height=94.0, ascent=76.0, descent=20.0, leading=-2.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:06.538 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=128 h=128
Wed 1/2 22:25:06.538 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating new RawImage for font rendering w=128 h=128
Wed 1/2 22:25:06.539 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Rendered new font to raw cache index=19 font=MetaFont[fonts\DejaVuSans, size=81, style=0, height=94.0, ascent=76.0, descent=20.0, leading=-2.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:06.539 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=128 h=128
Wed 1/2 22:25:06.540 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating new RawImage for font rendering w=128 h=128
Wed 1/2 22:25:06.541 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Rendered new font to raw cache index=2 font=MetaFont[fonts\DejaVuSans, size=40, style=0, height=47.0, ascent=38.0, descent=10.0, leading=-1.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:06.541 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=128 h=128
Wed 1/2 22:25:06.541 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating new RawImage for font rendering w=128 h=128
Wed 1/2 22:25:06.542 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Rendered new font to raw cache index=3 font=MetaFont[fonts\DejaVuSans, size=40, style=0, height=47.0, ascent=38.0, descent=10.0, leading=-1.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:06.543 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=128 h=128
Wed 1/2 22:25:06.543 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating new RawImage for font rendering w=128 h=128
Wed 1/2 22:25:06.544 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Rendered new font to raw cache index=4 font=MetaFont[fonts\DejaVuSans, size=40, style=0, height=47.0, ascent=38.0, descent=10.0, leading=-1.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:06.544 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=128 h=128
Wed 1/2 22:25:06.545 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating new RawImage for font rendering w=128 h=128
Wed 1/2 22:25:06.546 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Rendered new font to raw cache index=0 font=MetaFont[fonts\DejaVuSans, size=40, style=0, height=47.0, ascent=38.0, descent=10.0, leading=-1.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:06.546 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=128 h=128
Wed 1/2 22:25:06.547 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating new RawImage for font rendering w=128 h=128
Wed 1/2 22:25:06.548 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Rendered new font to raw cache index=1 font=MetaFont[fonts\DejaVuSans, size=40, style=0, height=47.0, ascent=38.0, descent=10.0, leading=-1.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:06.548 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=128 h=128
Wed 1/2 22:25:06.549 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating new RawImage for font rendering w=128 h=128
Wed 1/2 22:25:06.550 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Rendered new font to raw cache index=0 font=MetaFont[fonts\DejaVuSansMono, size=40, style=0, height=47.0, ascent=38.0, descent=10.0, leading=-1.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:06.551 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=128 h=128
Wed 1/2 22:25:06.551 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating new RawImage for font rendering w=128 h=128
Wed 1/2 22:25:06.552 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Rendered new font to raw cache index=1 font=MetaFont[fonts\DejaVuSansMono, size=40, style=0, height=47.0, ascent=38.0, descent=10.0, leading=-1.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:06.552 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=128 h=128
Wed 1/2 22:25:06.553 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating new RawImage for font rendering w=128 h=128
Wed 1/2 22:25:06.554 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Rendered new font to raw cache index=5 font=MetaFont[fonts\DejaVuSansMono, size=40, style=0, height=47.0, ascent=38.0, descent=10.0, leading=-1.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:06.554 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=128 h=128
Wed 1/2 22:25:06.555 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating new RawImage for font rendering w=128 h=128
Wed 1/2 22:25:06.556 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Rendered new font to raw cache index=2 font=MetaFont[fonts\DejaVuSansMono, size=40, style=0, height=47.0, ascent=38.0, descent=10.0, leading=-1.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:06.556 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=128 h=128
Wed 1/2 22:25:06.556 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating new RawImage for font rendering w=128 h=128
Wed 1/2 22:25:06.557 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Rendered new font to raw cache index=3 font=MetaFont[fonts\DejaVuSansMono, size=40, style=0, height=47.0, ascent=38.0, descent=10.0, leading=-1.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:06.557 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=128 h=128
Wed 1/2 22:25:09.958 [Fork-OPUS4-89595@b6a6dc] Starting Online Video properties updater thread.
Wed 1/2 22:25:09.959 [Fork-OPUS4A-122188@a26fda] Starting STV update availability check thread.
Wed 1/2 22:25:09.959 [Fork-OPUS4-89595@b6a6dc] Ending Online Video properties updater thread. No Update needed or it isn't time to check again.
Wed 1/2 22:25:09.960 [Fork-OPUS4A-199218@b6a6dc] Starting SageTV & Firmware version upgrade availability check thread.
Wed 1/2 22:25:09.960 [ReProcessHook@19eedef] The Google weather plugin has been found; name = 'googleweather', version = '2.0.2'
Wed 1/2 22:25:09.960 [ReProcessHook@19eedef] For location '', found instance= sage.google.weather.WeatherUnderground@15aba6c
Wed 1/2 22:25:09.960 [ReProcessHook@19eedef] instance for '' = sage.google.weather.WeatherUnderground@15aba6c
Wed 1/2 22:25:09.961 [ReProcessHook@19eedef] The Weather Underground instance = 'sage.google.weather.WeatherUnderground@15aba6c'
Wed 1/2 22:25:09.961 [ReProcessHook@19eedef] The Weather Underground WeatherLoc = '{neighborhood=, state=NJ, loccode=08872, country=US, city=Matawan}'
Wed 1/2 22:25:09.961 [ReProcessHook@19eedef] The Google weather JAR has been loaded, version: '2.0.2'. Required version: '2.0.1'
Wed 1/2 22:25:09.961 [Fork-OPUS4A-199218@b6a6dc] Is it time to check for a new SageTV software version?
Wed 1/2 22:25:09.962 [Fork-OPUS4-108092@172f59e] STARTING Forked weather thread.
Wed 1/2 22:25:09.962 [Fork-OPUS4A-122188@a26fda] STV update will not be checked because it is not time to check again. Last check was on Jan 2, 2013 at 8:11:02 PM
Wed 1/2 22:25:09.963 [Fork-OPUS4A-122188@a26fda] Ending STV update availability check thread.
Wed 1/2 22:25:09.963 [Fork-OPUS4A-199218@b6a6dc] No, it is not time to check for a new version. Last check was on Jan 2, 2013 at 8:11:02 PM
Wed 1/2 22:25:09.963 [Fork-OPUS4A-199218@b6a6dc] SageTV upgrade will not be checked because it is not time to check again.
Wed 1/2 22:25:09.963 [Fork-OPUS4A-199218@b6a6dc] Ending SageTV & Firmware version upgrade availability check thread.
Wed 1/2 22:25:10.962 [Fork-OPUS4-108092@172f59e] Updating weather
Wed 1/2 22:25:10.963 [Fork-BASE-71232@19eedef]    Not time to update weather yet.
Wed 1/2 22:25:11.307 [BGLoader2-SAGETV_PROCESS_LOCAL_UI@e9d3e8] Loading RawImage of size 1920x1080 for C:\Program Files (x86)\SageTV\SageTV\STVs\SageTV7\Themes\George\VideoBackground.jpg
Wed 1/2 22:25:11.307 [BGLoader2-SAGETV_PROCESS_LOCAL_UI@e9d3e8] Loading 0x0 image from file C:\Program Files (x86)\SageTV\SageTV\STVs\SageTV7\Themes\George\VideoBackground.jpg
Wed 1/2 22:25:11.394 [BGLoader2-SAGETV_PROCESS_LOCAL_UI@e9d3e8] Creating DirectX9 Texture from nio buffer w=1920 h=1080
Wed 1/2 22:25:13.378 [AWT-EventQueue-0@128a415] setUI(sage.cb@da05a8[SageRecordings SHORTCUTS]) histIdx=9 uiHistory=[sage.cb@1b4cf46[Main Menu], sage.cb@151448c[TV Explorer], sage.cb@102aa10[Main Menu], sage.cb@2667a2[Plugin List], sage.cb@1b4cf46[Main Menu], sage.cb@1b1cd95[Scheduled Recordings], sage.cb@1b4cf46[Main Menu], sage.cb@151448c[TV Explorer], sage.cb@9c05d2[Main Menu], sage.cb@da05a8[SageRecordings SHORTCUTS]] redo=false
Wed 1/2 22:25:13.408 [AWT-EventQueue-0@128a415] setUI(sage.cb@151448c[TV Explorer]) histIdx=9 uiHistory=[sage.cb@1b4cf46[Main Menu], sage.cb@151448c[TV Explorer], sage.cb@102aa10[Main Menu], sage.cb@2667a2[Plugin List], sage.cb@1b4cf46[Main Menu], sage.cb@1b1cd95[Scheduled Recordings], sage.cb@1b4cf46[Main Menu], sage.cb@151448c[TV Explorer], sage.cb@9c05d2[Main Menu], sage.cb@151448c[TV Explorer]] redo=false
Wed 1/2 22:25:13.410 [AWT-EventQueue-0@128a415] Get Imported TV Files - Start
Wed 1/2 22:25:13.410 [AWT-EventQueue-0@128a415] Display ImportedTV = true
Wed 1/2 22:25:13.410 [AWT-EventQueue-0@128a415] LimitSearchPaths = None
Wed 1/2 22:25:13.411 [AWT-EventQueue-0@128a415] TCED: Non-null TVImportFiles 222
Wed 1/2 22:25:13.411 [AWT-EventQueue-0@128a415] Get Imported TV Files - Done
Wed 1/2 22:25:13.412 [AWT-EventQueue-0@128a415] Get Recorded Files - Start
Wed 1/2 22:25:13.443 [AWT-EventQueue-0@128a415] Get Recorded Files - Done
Wed 1/2 22:25:13.444 [AWT-EventQueue-0@128a415] Get Scheduled Files - Start
Wed 1/2 22:25:13.445 [AWT-EventQueue-0@128a415] Get Scheduled Files - Done
Wed 1/2 22:25:13.445 [AWT-EventQueue-0@128a415] Start applying filters
Wed 1/2 22:25:13.445 [AWT-EventQueue-0@128a415] Done applying filters
Wed 1/2 22:25:13.445 [AWT-EventQueue-0@128a415] Start Grouping
Wed 1/2 22:25:13.484 [AWT-EventQueue-0@128a415] Done Grouping
Wed 1/2 22:25:13.484 [AWT-EventQueue-0@128a415] Starting EpSorting
Wed 1/2 22:25:13.484 [AWT-EventQueue-0@128a415] Done Episode Filtering
Wed 1/2 22:25:13.509 [AWT-EventQueue-0@128a415] Deriving FreeType font face for fonts\DejaVuSans size=27 style=0 from=C:\Program Files (x86)\SageTV\SageTV\fonts\DejaVuSansB.ttf
Wed 1/2 22:25:13.510 [AWT-EventQueue-0@128a415] Loading new font to cache font=MetaFont[fonts\DejaVuSans, size=27, style=1, height=31.0, ascent=26.0, descent=7.0, leading=-2.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:13.532 [AWT-EventQueue-0@128a415] Group Focus Changed
Wed 1/2 22:25:13.533 [AWT-EventQueue-0@128a415] Starting EpSorting
Wed 1/2 22:25:13.544 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] Loading new font to cache font=MetaFont[Arial, size=27, style=1, height=31.047363, ascent=24.884033, descent=5.2800293, leading=0.8833008, class=class sage.MetaFont$a]
Wed 1/2 22:25:13.598 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] Loaded font cache info for MetaFont[Arial, size=27, style=1, height=31.047363, ascent=24.884033, descent=5.2800293, leading=0.8833008, class=class sage.MetaFont$a] numGlyphs=3417 maxGlyph=2147483647
Wed 1/2 22:25:13.662 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Rendered new font to cache index=1 font=java.awt.Font[family=Arial,name=Arial,style=bold,size=27]
Wed 1/2 22:25:13.662 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=128 h=128
Wed 1/2 22:25:13.665 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Rendered new font to cache index=2 font=java.awt.Font[family=Arial,name=Arial,style=bold,size=27]
Wed 1/2 22:25:13.665 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] Deriving FreeType font face for fonts\DejaVuSans size=20 style=0 from=C:\Program Files (x86)\SageTV\SageTV\fonts\DejaVuSansB.ttf
Wed 1/2 22:25:13.665 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=128 h=128
Wed 1/2 22:25:13.667 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Rendered new font to cache index=0 font=java.awt.Font[family=Arial,name=Arial,style=bold,size=27]
Wed 1/2 22:25:13.668 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=128 h=128
Wed 1/2 22:25:13.669 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating new RawImage for font rendering w=128 h=128
Wed 1/2 22:25:13.669 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] Loading new font to cache font=MetaFont[fonts\DejaVuSans, size=20, style=1, height=23.0, ascent=19.0, descent=5.0, leading=-1.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:13.670 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Rendered new font to raw cache index=3 font=MetaFont[fonts\DejaVuSans, size=40, style=1, height=47.0, ascent=38.0, descent=10.0, leading=-1.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:13.670 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=128 h=128
Wed 1/2 22:25:13.672 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating new RawImage for font rendering w=128 h=128
Wed 1/2 22:25:13.673 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Rendered new font to raw cache index=2 font=MetaFont[fonts\DejaVuSans, size=40, style=1, height=47.0, ascent=38.0, descent=10.0, leading=-1.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:13.673 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=128 h=128
Wed 1/2 22:25:13.674 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating new RawImage for font rendering w=128 h=128
Wed 1/2 22:25:13.675 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Rendered new font to raw cache index=5 font=MetaFont[fonts\DejaVuSans, size=40, style=1, height=47.0, ascent=38.0, descent=10.0, leading=-1.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:13.675 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=128 h=128
Wed 1/2 22:25:13.675 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating new RawImage for font rendering w=128 h=128
Wed 1/2 22:25:13.676 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Rendered new font to raw cache index=4 font=MetaFont[fonts\DejaVuSans, size=40, style=1, height=47.0, ascent=38.0, descent=10.0, leading=-1.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:13.677 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=128 h=128
Wed 1/2 22:25:13.695 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating new RawImage for font rendering w=128 h=128
Wed 1/2 22:25:13.697 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Rendered new font to raw cache index=0 font=MetaFont[fonts\DejaVuSans, size=20, style=1, height=23.0, ascent=19.0, descent=5.0, leading=-1.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:13.698 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=128 h=128
Wed 1/2 22:25:13.699 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating new RawImage for font rendering w=128 h=128
Wed 1/2 22:25:13.700 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Rendered new font to raw cache index=1 font=MetaFont[fonts\DejaVuSans, size=27, style=1, height=31.0, ascent=26.0, descent=7.0, leading=-2.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:13.700 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=128 h=128
Wed 1/2 22:25:13.701 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating new RawImage for font rendering w=128 h=128
Wed 1/2 22:25:13.703 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Rendered new font to raw cache index=2 font=MetaFont[fonts\DejaVuSans, size=27, style=1, height=31.0, ascent=26.0, descent=7.0, leading=-2.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:13.703 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=128 h=128
Wed 1/2 22:25:13.703 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating new RawImage for font rendering w=128 h=128
Wed 1/2 22:25:13.705 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Rendered new font to raw cache index=0 font=MetaFont[fonts\DejaVuSans, size=27, style=1, height=31.0, ascent=26.0, descent=7.0, leading=-2.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:13.705 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=128 h=128
Wed 1/2 22:25:13.962 [Fork-OPUS4-108092@172f59e] ENDING Forked weather thread.
Wed 1/2 22:25:14.552 [AWT-EventQueue-0@128a415] Setting Focus on Episode Panel
Wed 1/2 22:25:16.239 [BGLoader2-SAGETV_PROCESS_LOCAL_UI@e9d3e8] Loading RawImage of size 713x1002 for .\userdata\Phoenix\cache\imagetrans\TVExplorerPosters\d3d0616f83472d44ac835deb9ef8e30e.jpg
Wed 1/2 22:25:16.240 [BGLoader2-SAGETV_PROCESS_LOCAL_UI@e9d3e8] Loading 0x0 image from file .\userdata\Phoenix\cache\imagetrans\TVExplorerPosters\d3d0616f83472d44ac835deb9ef8e30e.jpg
Wed 1/2 22:25:16.240 [BGLoader2-SAGETV_PROCESS_LOCAL_UI@e9d3e8] FAILED to load the image file!
Wed 1/2 22:25:16.242 [BGLoader2-SAGETV_PROCESS_LOCAL_UI@e9d3e8] Creating DirectX9 Texture from nio buffer w=713 h=1002
Wed 1/2 22:25:16.247 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Loading RawImage of size 1280x720 for \\W7-Server\Fanart\Movies\American History X\Backgrounds\20edeab9bff035fc1a107ef6666495a0-aEhlpnfcnQr9kzoZsvUoGSE8C21.jpg
Wed 1/2 22:25:16.247 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Loading 0x0 image from file \\W7-Server\Fanart\Movies\American History X\Backgrounds\20edeab9bff035fc1a107ef6666495a0-aEhlpnfcnQr9kzoZsvUoGSE8C21.jpg
Wed 1/2 22:25:16.276 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=1280 h=720
Wed 1/2 22:25:16.289 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Loading RawImage of size 569x686 for C:\Program Files (x86)\SageTV\SageTV\STVs\SageTV7\TVExplorer\Images\MovieSleeve.png
Wed 1/2 22:25:16.289 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Loading 0x0 image from file C:\Program Files (x86)\SageTV\SageTV\STVs\SageTV7\TVExplorer\Images\MovieSleeve.png
Wed 1/2 22:25:16.315 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=569 h=686
Wed 1/2 22:25:16.324 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Loading RawImage of size 315x454 for C:\Program Files (x86)\SageTV\SageTV\STVs\SageTV7\TVExplorer\Images\MaskPoster.png
Wed 1/2 22:25:16.324 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Loading 0x0 image from file C:\Program Files (x86)\SageTV\SageTV\STVs\SageTV7\TVExplorer\Images\MaskPoster.png
Wed 1/2 22:25:16.332 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=315 h=454
Wed 1/2 22:25:21.719 [AWT-EventQueue-0@128a415] VF.submitJob(VFJob[CloseMF r=0.0 t=0 file=null ifn=null])
Wed 1/2 22:25:21.719 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] VF processing job VFJob[CloseMF r=0.0 t=0 file=null ifn=null] nPlayin=false
Wed 1/2 22:25:21.719 [AWT-EventQueue-0@128a415] CloseAndWait is executing the close job synchronously now
Wed 1/2 22:25:21.720 [AWT-EventQueue-0@128a415] VF processing on UI Thread VFJob[CloseMF r=0.0 t=0 file=null ifn=null]
Wed 1/2 22:25:21.720 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] VF processing job null nPlayin=false
Wed 1/2 22:25:21.720 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] VF thread is now waiting for 0:00:00.000
Wed 1/2 22:25:21.721 [AsyncWatch@19eedef] VideoFrame.watch(A[12823703,119699,"Aliens vs. Predator: Requiem",58574@1228.00:00,120])
Wed 1/2 22:25:21.721 [AsyncWatch@19eedef] watchThisFile=MediaFile[id=12947004 A[12823703,119699,"Aliens vs. Predator: Requiem",58574@1228.00:00,120] mask=TV host=SageTV-VM encodedBy=Hauppauge HD PVR Capture Device HDPVRMax format=MPEG2-TS 1:59:51 2884 kbps [#0 Video[H.264 29.97003 fps 1920x1080 16:9 interlaced id=1011]#1 Audio[AC3 48000 Hz 2 channels 384 kbps MAIN idx=1 id=1100]{ScrapedBy=Phoenix, IMDBID=tt0758730, MediaType=Movie, ScrapedDate=1350790824345, MediaProviderDataID=tt0758730, MediaTitle=AVPR: Aliens vs Predator - Requiem, DiscNumber=0, UserRating=47, MediaProviderID=imdb}] \\W7-Server\Recordings (DVR)\AliensvsPredatorRequiem-12823703-0.ts, Seg0[Wed 12/28 0:00:00.014-Wed 12/28 1:59:51.494]]
Wed 1/2 22:25:21.725 [AsyncWatch@19eedef] Watch airing is a file & over, do that instead dvd=false
Wed 1/2 22:25:21.729 [AsyncWatch@19eedef] VF.submitJob(VFJob[WatchMF r=0.0 t=0 file=MediaFile[id=12947004 A[12823703,119699,"Aliens vs. Predator: Requiem",58574@1228.00:00,120] mask=TV host=SageTV-VM encodedBy=Hauppauge HD PVR Capture Device HDPVRMax format=MPEG2-TS 1:59:51 2884 kbps [#0 Video[H.264 29.97003 fps 1920x1080 16:9 interlaced id=1011]#1 Audio[AC3 48000 Hz 2 channels 384 kbps MAIN idx=1 id=1100]{ScrapedBy=Phoenix, IMDBID=tt0758730, MediaType=Movie, ScrapedDate=1350790824345, MediaProviderDataID=tt0758730, MediaTitle=AVPR: Aliens vs Predator - Requiem, DiscNumber=0, UserRating=47, MediaProviderID=imdb}] \\W7-Server\Recordings (DVR)\AliensvsPredatorRequiem-12823703-0.ts, Seg0[Wed 12/28 0:00:00.014-Wed 12/28 1:59:51.494]] ifn=null])
Wed 1/2 22:25:21.730 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] VF processing job VFJob[WatchMF r=0.0 t=0 file=MediaFile[id=12947004 A[12823703,119699,"Aliens vs. Predator: Requiem",58574@1228.00:00,120] mask=TV host=SageTV-VM encodedBy=Hauppauge HD PVR Capture Device HDPVRMax format=MPEG2-TS 1:59:51 2884 kbps [#0 Video[H.264 29.97003 fps 1920x1080 16:9 interlaced id=1011]#1 Audio[AC3 48000 Hz 2 channels 384 kbps MAIN idx=1 id=1100]{ScrapedBy=Phoenix, IMDBID=tt0758730, MediaType=Movie, ScrapedDate=1350790824345, MediaProviderDataID=tt0758730, MediaTitle=AVPR: Aliens vs Predator - Requiem, DiscNumber=0, UserRating=47, MediaProviderID=imdb}] \\W7-Server\Recordings (DVR)\AliensvsPredatorRequiem-12823703-0.ts, Seg0[Wed 12/28 0:00:00.014-Wed 12/28 1:59:51.494]] ifn=null] nPlayin=false
Wed 1/2 22:25:21.732 [AsyncWatch@19eedef] setUI(sage.cb@1009d04[MediaPlayer OSD]) histIdx=9 uiHistory=[sage.cb@151448c[TV Explorer], sage.cb@102aa10[Main Menu], sage.cb@2667a2[Plugin List], sage.cb@1b4cf46[Main Menu], sage.cb@1b1cd95[Scheduled Recordings], sage.cb@1b4cf46[Main Menu], sage.cb@151448c[TV Explorer], sage.cb@9c05d2[Main Menu], sage.cb@151448c[TV Explorer], sage.cb@1009d04[MediaPlayer OSD]] redo=false
Wed 1/2 22:25:21.734 [AWT-EventQueue-0@128a415] VF processing on UI Thread VFJob[WatchMF r=0.0 t=0 file=MediaFile[id=12947004 A[12823703,119699,"Aliens vs. Predator: Requiem",58574@1228.00:00,120] mask=TV host=SageTV-VM encodedBy=Hauppauge HD PVR Capture Device HDPVRMax format=MPEG2-TS 1:59:51 2884 kbps [#0 Video[H.264 29.97003 fps 1920x1080 16:9 interlaced id=1011]#1 Audio[AC3 48000 Hz 2 channels 384 kbps MAIN idx=1 id=1100]{ScrapedBy=Phoenix, IMDBID=tt0758730, MediaType=Movie, ScrapedDate=1350790824345, MediaProviderDataID=tt0758730, MediaTitle=AVPR: Aliens vs Predator - Requiem, DiscNumber=0, UserRating=47, MediaProviderID=imdb}] \\W7-Server\Recordings (DVR)\AliensvsPredatorRequiem-12823703-0.ts, Seg0[Wed 12/28 0:00:00.014-Wed 12/28 1:59:51.494]] ifn=null]
Wed 1/2 22:25:21.735 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] VF processing job VFJob[LoadMF r=0.0 t=0 file=MediaFile[id=12947004 A[12823703,119699,"Aliens vs. Predator: Requiem",58574@1228.00:00,120] mask=TV host=SageTV-VM encodedBy=Hauppauge HD PVR Capture Device HDPVRMax format=MPEG2-TS 1:59:51 2884 kbps [#0 Video[H.264 29.97003 fps 1920x1080 16:9 interlaced id=1011]#1 Audio[AC3 48000 Hz 2 channels 384 kbps MAIN idx=1 id=1100]{ScrapedBy=Phoenix, IMDBID=tt0758730, MediaType=Movie, ScrapedDate=1350790824345, MediaProviderDataID=tt0758730, MediaTitle=AVPR: Aliens vs Predator - Requiem, DiscNumber=0, UserRating=47, MediaProviderID=imdb}] \\W7-Server\Recordings (DVR)\AliensvsPredatorRequiem-12823703-0.ts, Seg0[Wed 12/28 0:00:00.014-Wed 12/28 1:59:51.494]] ifn=null] nPlayin=false
Wed 1/2 22:25:21.735 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] VF network encoder playback detected: false
Wed 1/2 22:25:21.741 [AWT-EventQueue-0@128a415] VF processing on UI Thread VFJob[LoadMF r=0.0 t=0 file=MediaFile[id=12947004 A[12823703,119699,"Aliens vs. Predator: Requiem",58574@1228.00:00,120] mask=TV host=SageTV-VM encodedBy=Hauppauge HD PVR Capture Device HDPVRMax format=MPEG2-TS 1:59:51 2884 kbps [#0 Video[H.264 29.97003 fps 1920x1080 16:9 interlaced id=1011]#1 Audio[AC3 48000 Hz 2 channels 384 kbps MAIN idx=1 id=1100]{ScrapedBy=Phoenix, IMDBID=tt0758730, MediaType=Movie, ScrapedDate=1350790824345, MediaProviderDataID=tt0758730, MediaTitle=AVPR: Aliens vs Predator - Requiem, DiscNumber=0, UserRating=47, MediaProviderID=imdb}] \\W7-Server\Recordings (DVR)\AliensvsPredatorRequiem-12823703-0.ts, Seg0[Wed 12/28 0:00:00.014-Wed 12/28 1:59:51.494]] ifn=null]
Wed 1/2 22:25:21.741 [AWT-EventQueue-0@128a415] VideoFrame creating new media player for file:MediaFile[id=12947004 A[12823703,119699,"Aliens vs. Predator: Requiem",58574@1228.00:00,120] mask=TV host=SageTV-VM encodedBy=Hauppauge HD PVR Capture Device HDPVRMax format=MPEG2-TS 1:59:51 2884 kbps [#0 Video[H.264 29.97003 fps 1920x1080 16:9 interlaced id=1011]#1 Audio[AC3 48000 Hz 2 channels 384 kbps MAIN idx=1 id=1100]{ScrapedBy=Phoenix, IMDBID=tt0758730, MediaType=Movie, ScrapedDate=1350790824345, MediaProviderDataID=tt0758730, MediaTitle=AVPR: Aliens vs Predator - Requiem, DiscNumber=0, UserRating=47, MediaProviderID=imdb}] \\W7-Server\Recordings (DVR)\AliensvsPredatorRequiem-12823703-0.ts, Seg0[Wed 12/28 0:00:00.014-Wed 12/28 1:59:51.494]]
Wed 1/2 22:25:21.741 [AWT-EventQueue-0@128a415] VF file=MediaFile[id=12947004 A[12823703,119699,"Aliens vs. Predator: Requiem",58574@1228.00:00,120] mask=TV host=SageTV-VM encodedBy=Hauppauge HD PVR Capture Device HDPVRMax format=MPEG2-TS 1:59:51 2884 kbps [#0 Video[H.264 29.97003 fps 1920x1080 16:9 interlaced id=1011]#1 Audio[AC3 48000 Hz 2 channels 384 kbps MAIN idx=1 id=1100]{ScrapedBy=Phoenix, IMDBID=tt0758730, MediaType=Movie, ScrapedDate=1350790824345, MediaProviderDataID=tt0758730, MediaTitle=AVPR: Aliens vs Predator - Requiem, DiscNumber=0, UserRating=47, MediaProviderID=imdb}] \\W7-Server\Recordings (DVR)\AliensvsPredatorRequiem-12823703-0.ts, Seg0[Wed 12/28 0:00:00.014-Wed 12/28 1:59:51.494]] targetTime = Wed 12/28 0:00:00.014
Wed 1/2 22:25:21.741 [AWT-EventQueue-0@128a415] VideoFrame.timeSelected(Wed 12/28 0:00:00.014, true) currFile=MediaFile[id=12947004 A[12823703,119699,"Aliens vs. Predator: Requiem",58574@1228.00:00,120] mask=TV host=SageTV-VM encodedBy=Hauppauge HD PVR Capture Device HDPVRMax format=MPEG2-TS 1:59:51 2884 kbps [#0 Video[H.264 29.97003 fps 1920x1080 16:9 interlaced id=1011]#1 Audio[AC3 48000 Hz 2 channels 384 kbps MAIN idx=1 id=1100]{ScrapedBy=Phoenix, IMDBID=tt0758730, MediaType=Movie, ScrapedDate=1350790824345, MediaProviderDataID=tt0758730, MediaTitle=AVPR: Aliens vs Predator - Requiem, DiscNumber=0, UserRating=47, MediaProviderID=imdb}] \\W7-Server\Recordings (DVR)\AliensvsPredatorRequiem-12823703-0.ts, Seg0[Wed 12/28 0:00:00.014-Wed 12/28 1:59:51.494]]
Wed 1/2 22:25:21.753 [AWT-EventQueue-0@128a415] Creating GraphPluginHandler...
Wed 1/2 22:25:21.754 [AWT-EventQueue-0@128a415] Done creating GraphPluginHandler
Wed 1/2 22:25:21.754 [AWT-EventQueue-0@128a415] DShowPlayer setVideoRendererFilter0({FA10746C-9B63-4B6C-BC49-FC300EA5F256}) called
Wed 1/2 22:25:21.754 [AWT-EventQueue-0@128a415] Using EVR for video render
Wed 1/2 22:25:21.763 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] VideoFrame got registration of a subtitle UI component: sage.q[loc=java.awt.Point[x=109,y=259] size=java.awt.Dimension[width=512,height=69]]
Wed 1/2 22:25:21.764 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] VideoFrame got registration of a cc UI component: sage.q[loc=java.awt.Point[x=72,y=34] size=java.awt.Dimension[width=585,height=274]]
Wed 1/2 22:25:21.769 [AsyncWatch@19eedef] VideoFrame got registration of a subtitle UI component: null
Wed 1/2 22:25:21.769 [AsyncWatch@19eedef] VideoFrame got registration of a cc UI component: null
Wed 1/2 22:25:21.782 [AWT-EventQueue-0@128a415] Using 3 input pins on the EVR
Wed 1/2 22:25:21.782 [AWT-EventQueue-0@128a415] Finished with EVR configuration OK
Wed 1/2 22:25:21.783 [AWT-EventQueue-0@128a415] DShowPlayer setVideoDecoderFilter0(Microsoft DTV-DVD Video Decoder) called
Wed 1/2 22:25:21.805 [AsyncWatch@19eedef] Deriving FreeType font face for fonts\DejaVuSansMono size=33 style=0 from=C:\Program Files (x86)\SageTV\SageTV\fonts\DejaVuSansMono.ttf
Wed 1/2 22:25:21.805 [AsyncWatch@19eedef] Loading new font to cache font=MetaFont[fonts\DejaVuSansMono, size=33, style=0, height=38.0, ascent=31.0, descent=8.0, leading=-1.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:21.814 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] VideoFrame got registration of a subtitle UI component: sage.q[loc=java.awt.Point[x=288,y=820] size=java.awt.Dimension[width=1344,height=217]]
Wed 1/2 22:25:21.814 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] VideoFrame got registration of a cc UI component: sage.q[loc=java.awt.Point[x=192,y=108] size=java.awt.Dimension[width=1536,height=864]]
Wed 1/2 22:25:21.817 [AWT-EventQueue-0@128a415] DShowPlayer setAudioDecoderFilter0(ffdshow Audio Decoder) called
Wed 1/2 22:25:21.817 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating new RawImage for font rendering w=128 h=128
Wed 1/2 22:25:21.818 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Rendered new font to raw cache index=0 font=MetaFont[fonts\DejaVuSans, size=40, style=1, height=47.0, ascent=38.0, descent=10.0, leading=-1.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:21.818 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=128 h=128
Wed 1/2 22:25:21.819 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating new RawImage for font rendering w=128 h=128
Wed 1/2 22:25:21.820 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Rendered new font to raw cache index=1 font=MetaFont[fonts\DejaVuSans, size=40, style=1, height=47.0, ascent=38.0, descent=10.0, leading=-1.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:21.820 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=128 h=128
Wed 1/2 22:25:21.822 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating new RawImage for font rendering w=128 h=128
Wed 1/2 22:25:21.823 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Rendered new font to raw cache index=1 font=MetaFont[fonts\DejaVuSansMono, size=33, style=0, height=38.0, ascent=31.0, descent=8.0, leading=-1.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:21.823 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=128 h=128
Wed 1/2 22:25:21.824 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating new RawImage for font rendering w=128 h=128
Wed 1/2 22:25:21.826 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Rendered new font to raw cache index=2 font=MetaFont[fonts\DejaVuSansMono, size=33, style=0, height=38.0, ascent=31.0, descent=8.0, leading=-1.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:21.826 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=128 h=128
Wed 1/2 22:25:21.827 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating new RawImage for font rendering w=128 h=128
Wed 1/2 22:25:21.829 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Rendered new font to raw cache index=0 font=MetaFont[fonts\DejaVuSansMono, size=33, style=0, height=38.0, ascent=31.0, descent=8.0, leading=-1.0, class=class sage.FreetypeFont]
Wed 1/2 22:25:21.830 [FinalRender-SAGETV_PROCESS_LOCAL_UI@7658b3] Creating DirectX9 Texture from nio buffer w=128 h=128
Wed 1/2 22:25:21.837 [AWT-EventQueue-0@128a415] DShowPlayer setTimeshift=0 buffer=0
Wed 1/2 22:25:21.844 [AWT-EventQueue-0@128a415] Using the default source filter
Wed 1/2 22:25:21.844 [AWT-EventQueue-0@128a415] NATIVE Loading the source file
Wed 1/2 22:25:21.864 [AWT-EventQueue-0@128a415] NATIVE Setting up the MPEG demux
Wed 1/2 22:25:21.881 [AWT-EventQueue-0@128a415] Calling GraphCreated for the PluginHandler
Wed 1/2 22:25:21.881 [AWT-EventQueue-0@128a415] Done calling GraphCreated for the PluginHandler
Wed 1/2 22:25:21.881 [AWT-EventQueue-0@128a415] Audio Stream #1 format AC3 channels 2 freq 48000
Wed 1/2 22:25:21.881 [AWT-EventQueue-0@128a415] NATIVE RenderAudio called stream=1
Wed 1/2 22:25:21.881 [AWT-EventQueue-0@128a415] NATIVE RenderAudio step 1
Wed 1/2 22:25:21.887 [AWT-EventQueue-0@128a415] NATIVE RenderAudio step 2
Wed 1/2 22:25:21.887 [AWT-EventQueue-0@128a415] NATIVE RenderAudio step 3
Wed 1/2 22:25:21.887 [AWT-EventQueue-0@128a415] NATIVE RenderAudio step 4
Wed 1/2 22:25:21.913 [AWT-EventQueue-0@128a415] NATIVE RenderVideo called
Wed 1/2 22:25:21.914 [AWT-EventQueue-0@128a415] NATIVE RenderVideo step 1
Wed 1/2 22:25:21.914 [AWT-EventQueue-0@128a415] NATIVE RenderVideo step 2
Wed 1/2 22:25:21.914 [AWT-EventQueue-0@128a415] Video source pin information:
Wed 1/2 22:25:21.914 [AWT-EventQueue-0@128a415] PIN is not connected yet!Wed 1/2 22:25:21.914 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type Unknown GUID Name F type FORMAT_VideoInfo2
Wed 1/2 22:25:21.914 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:25:21.914 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:25:21.914 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:25:21.915 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:25:21.915 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:25:21.915 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type Unknown GUID Name F type FORMAT_VideoInfo2
Wed 1/2 22:25:21.915 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:25:21.915 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:25:21.915 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:25:21.915 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:25:21.915 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:25:21.915 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type Unknown GUID Name F type FORMAT_VideoInfo2
Wed 1/2 22:25:21.915 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:25:21.915 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:25:21.915 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:25:21.915 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:25:21.916 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:25:21.916 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type Unknown GUID Name F type FORMAT_VideoInfo2
Wed 1/2 22:25:21.916 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:25:21.916 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:25:21.916 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:25:21.916 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:25:21.916 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:25:21.916 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type MEDIASUBTYPE_NV12 F type FORMAT_VideoInfo2
Wed 1/2 22:25:21.916 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:25:21.916 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:25:21.916 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:25:21.916 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:25:21.916 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:25:21.917 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type MEDIASUBTYPE_NV12 F type FORMAT_VideoInfo2
Wed 1/2 22:25:21.917 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:25:21.917 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:25:21.917 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:25:21.917 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:25:21.917 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:25:21.917 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type Unknown GUID Name F type FORMAT_VideoInfo2
Wed 1/2 22:25:21.917 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:25:21.917 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:25:21.917 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:25:21.917 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:25:21.917 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:25:21.918 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type Unknown GUID Name F type FORMAT_VideoInfo2
Wed 1/2 22:25:21.918 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:25:21.918 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:25:21.918 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:25:21.918 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:25:21.918 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:25:21.918 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type MEDIASUBTYPE_YUY2 F type FORMAT_VideoInfo2
Wed 1/2 22:25:21.918 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:25:21.918 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:25:21.918 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:25:21.918 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:25:21.918 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:25:21.918 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type MEDIASUBTYPE_YUY2 F type FORMAT_VideoInfo2
Wed 1/2 22:25:21.919 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:25:21.919 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:25:21.919 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:25:21.919 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:25:21.919 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:25:21.919 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type MEDIASUBTYPE_YV12 F type FORMAT_VideoInfo2
Wed 1/2 22:25:21.919 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:25:21.919 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:25:21.919 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:25:21.919 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:25:21.919 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:25:21.919 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type MEDIASUBTYPE_YV12 F type FORMAT_VideoInfo2
Wed 1/2 22:25:21.920 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:25:21.920 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:25:21.920 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:25:21.920 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:25:21.920 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:25:21.920 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type MEDIASUBTYPE_IMC4 F type FORMAT_VideoInfo2
Wed 1/2 22:25:21.920 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:25:21.920 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:25:21.920 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:25:21.920 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:25:21.920 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:25:21.920 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type MEDIASUBTYPE_IMC4 F type FORMAT_VideoInfo2
Wed 1/2 22:25:21.920 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:25:21.921 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:25:21.921 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:25:21.921 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:25:21.921 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:25:21.921 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type MEDIASUBTYPE_IMC3 F type FORMAT_VideoInfo2
Wed 1/2 22:25:21.921 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:25:21.921 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:25:21.921 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:25:21.921 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:25:21.921 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:25:21.921 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type MEDIASUBTYPE_IMC3 F type FORMAT_VideoInfo2
Wed 1/2 22:25:21.921 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:25:21.922 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:25:21.922 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:25:21.922 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:25:21.922 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:25:21.922 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type MEDIASUBTYPE_S340 F type FORMAT_VideoInfo2
Wed 1/2 22:25:21.922 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:25:21.922 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:25:21.922 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:25:21.922 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:25:21.922 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:25:21.922 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type MEDIASUBTYPE_S340 F type FORMAT_VideoInfo2
Wed 1/2 22:25:21.922 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:25:21.922 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:25:21.923 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:25:21.923 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:25:21.923 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:25:21.923 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type MEDIASUBTYPE_NV24 F type FORMAT_VideoInfo2
Wed 1/2 22:25:21.923 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:25:21.923 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:25:21.923 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:25:21.923 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:25:21.923 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:25:21.923 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type MEDIASUBTYPE_NV24 F type FORMAT_VideoInfo2
Wed 1/2 22:25:21.923 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:25:21.923 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:25:21.924 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:25:21.924 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:25:21.924 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:25:21.924 [AWT-EventQueue-0@128a415] NATIVE RenderVideo step 3
Wed 1/2 22:25:22.191 [AWT-EventQueue-0@128a415] Setting up video processing mode for EVR
Wed 1/2 22:25:22.191 [AWT-EventQueue-0@128a415] EVR VideoProcMode 0 - {3C5323C1-6FB7-44F5-9081-056BF2EE449D}
Wed 1/2 22:25:22.191 [AWT-EventQueue-0@128a415] EVR VideoProcMode 1 - {552C0DAD-CCBC-420B-83C8-74943CF9F1A6}
Wed 1/2 22:25:22.192 [AWT-EventQueue-0@128a415] EVR VideoProcMode 2 - {6E8329FF-B642-418B-BCF0-BCB6591E255F}
Wed 1/2 22:25:22.192 [AWT-EventQueue-0@128a415] EVR VideoProcMode 3 - {335AA36E-7884-43A4-9C91-7F87FAF3E37E}
Wed 1/2 22:25:22.192 [AWT-EventQueue-0@128a415] EVR VideoProcMode 4 - {5A54A0C9-C7EC-4BD9-8EDE-F3C75DC4393B}
Wed 1/2 22:25:22.192 [AWT-EventQueue-0@128a415] EVR set the video processing mode to index 0! hr=0x0
Wed 1/2 22:25:22.192 [AWT-EventQueue-0@128a415] Filter Graph Video Renderer Info:
Wed 1/2 22:25:22.192 [AWT-EventQueue-0@128a415] Video Renderer:CLSID_EnhancedVideoRenderer
Wed 1/2 22:25:22.192 [AWT-EventQueue-0@128a415] M type MEDIATYPE_Video  S type MEDIASUBTYPE_NV12 F type FORMAT_VideoInfo2
Wed 1/2 22:25:22.192 [AWT-EventQueue-0@128a415] Interlaced video
Wed 1/2 22:25:22.192 [AWT-EventQueue-0@128a415] Both fields per sample
Wed 1/2 22:25:22.193 [AWT-EventQueue-0@128a415] Field 2 first
Wed 1/2 22:25:22.193 [AWT-EventQueue-0@128a415] Stream never contains a Field 2
Wed 1/2 22:25:22.193 [AWT-EventQueue-0@128a415] Either bob or weave mode.
Wed 1/2 22:25:22.193 [AWT-EventQueue-0@128a415] VMR9 filter detected, using line 21 decoder 2.
Wed 1/2 22:25:22.195 [AWT-EventQueue-0@128a415] DShowGraphFilters=Default DirectSound Device,VidRend,Line21 Decoder,Audio Decoder,Video Decoder,SageTV MPEG2 Demultiplexer,\\W7-Server\Recordings (DVR)\AliensvsPredatorRequiem-12823703-0.ts,
Wed 1/2 22:25:22.195 [AWT-EventQueue-0@128a415] ----------->Get getDurationMillis0=7191380.
Wed 1/2 22:25:22.195 [AWT-EventQueue-0@128a415] VideoFrame.timeSelected2(Wed 12/28 0:00:00.014, true) currFile=MediaFile[id=12947004 A[12823703,119699,"Aliens vs. Predator: Requiem",58574@1228.00:00,120] mask=TV host=SageTV-VM encodedBy=Hauppauge HD PVR Capture Device HDPVRMax format=MPEG2-TS 1:59:51 2884 kbps [#0 Video[H.264 29.97003 fps 1920x1080 16:9 interlaced id=1011]#1 Audio[AC3 48000 Hz 2 channels 384 kbps MAIN idx=1 id=1100]{ScrapedBy=Phoenix, IMDBID=tt0758730, MediaType=Movie, ScrapedDate=1350790824345, MediaProviderDataID=tt0758730, MediaTitle=AVPR: Aliens vs Predator - Requiem, DiscNumber=0, UserRating=47, MediaProviderID=imdb}] \\W7-Server\Recordings (DVR)\AliensvsPredatorRequiem-12823703-0.ts, Seg0[Wed 12/28 0:00:00.014-Wed 12/28 1:59:51.494]] realDur=7191380
Wed 1/2 22:25:22.195 [AWT-EventQueue-0@128a415] About to perform media time selection for 0
Wed 1/2 22:25:22.196 [AWT-EventQueue-0@128a415] Running the playback graph.
Wed 1/2 22:25:22.197 [main@136bdda] VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null])
Wed 1/2 22:25:22.265 [main@136bdda] VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null])
Wed 1/2 22:25:22.496 [Thread-943@184d6fe] VMR9 info has changed width=1920 height=1080 arx=0 ary=0
Wed 1/2 22:25:22.549 [AWTThreadWatcher-SAGETV_PROCESS_LOCAL_UI@374534] EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 750
Wed 1/2 22:25:22.567 [Thread-946@ff1fbd] Loading RawImage of size 86x86 for images/tvicon_anim2.png
Wed 1/2 22:25:22.567 [Thread-946@ff1fbd] Loading 86x86 image from file C:\Users\GEORGE~1.BAR\AppData\Local\Temp\stv3910214104391529652.img
Wed 1/2 22:25:22.570 [Thread-946@ff1fbd] Creating DirectX9 Texture from nio buffer w=86 h=86
Wed 1/2 22:25:22.573 [Thread-947@146e626] Loading RawImage of size 86x86 for images/tvicon_anim3.png
Wed 1/2 22:25:22.574 [Thread-947@146e626] Loading 86x86 image from file C:\Users\GEORGE~1.BAR\AppData\Local\Temp\stv3831169675539826699.img
Wed 1/2 22:25:22.577 [Thread-947@146e626] Creating DirectX9 Texture from nio buffer w=86 h=86
Wed 1/2 22:25:22.607 [Thread-948@9c506d] Loading RawImage of size 86x86 for images/tvicon_anim4.png
Wed 1/2 22:25:22.607 [Thread-948@9c506d] Loading 86x86 image from file C:\Users\GEORGE~1.BAR\AppData\Local\Temp\stv8962765296840115526.img
Wed 1/2 22:25:22.610 [Thread-948@9c506d] Creating DirectX9 Texture from nio buffer w=86 h=86
Wed 1/2 22:25:22.628 [Thread-949@9ff577] Loading RawImage of size 86x86 for images/tvicon_anim5.png
Wed 1/2 22:25:22.629 [Thread-949@9ff577] Loading 86x86 image from file C:\Users\GEORGE~1.BAR\AppData\Local\Temp\stv7670647911311500336.img
Wed 1/2 22:25:22.631 [Thread-949@9ff577] Creating DirectX9 Texture from nio buffer w=86 h=86
Wed 1/2 22:25:22.649 [Thread-950@1dc0fcb] Loading RawImage of size 86x86 for images/tvicon_anim6.png
Wed 1/2 22:25:22.649 [Thread-950@1dc0fcb] Loading 86x86 image from file C:\Users\GEORGE~1.BAR\AppData\Local\Temp\stv5497215272212954229.img
Wed 1/2 22:25:22.652 [Thread-950@1dc0fcb] Creating DirectX9 Texture from nio buffer w=86 h=86
Wed 1/2 22:25:22.670 [Thread-951@15e57be] Loading RawImage of size 86x86 for images/tvicon_anim7.png
Wed 1/2 22:25:22.671 [Thread-951@15e57be] Loading 86x86 image from file C:\Users\GEORGE~1.BAR\AppData\Local\Temp\stv6097132401292186234.img
Wed 1/2 22:25:22.673 [Thread-951@15e57be] Creating DirectX9 Texture from nio buffer w=86 h=86
Wed 1/2 22:25:22.692 [Thread-952@1110e7a] Loading RawImage of size 86x86 for images/tvicon_anim0.png
Wed 1/2 22:25:22.693 [Thread-952@1110e7a] Loading 86x86 image from file C:\Users\GEORGE~1.BAR\AppData\Local\Temp\stv1682437115536753947.img
Wed 1/2 22:25:22.695 [Thread-952@1110e7a] Creating DirectX9 Texture from nio buffer w=86 h=86
Wed 1/2 22:25:22.724 [Thread-953@aaf166] Loading RawImage of size 86x86 for images/tvicon_anim1.png
Wed 1/2 22:25:22.725 [Thread-953@aaf166] Loading 86x86 image from file C:\Users\GEORGE~1.BAR\AppData\Local\Temp\stv2575626130258595739.img
Wed 1/2 22:25:22.728 [Thread-953@aaf166] Creating DirectX9 Texture from nio buffer w=86 h=86
Wed 1/2 22:25:22.817 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] =======>Get getMediaTimeMillis0 cur:423 s0:0 s1:0 new:423.
Wed 1/2 22:25:23.299 [AWTThreadWatcher-SAGETV_PROCESS_LOCAL_UI@374534] EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 1500
Wed 1/2 22:25:23.813 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] =======>Get getMediaTimeMillis0 cur:2529 s0:0 s1:0 new:2529.
Wed 1/2 22:25:23.976 [AWT-EventQueue-0@128a415] =======>Get getMediaTimeMillis0 cur:2691 s0:0 s1:0 new:2691.
Wed 1/2 22:25:23.976 [AWT-EventQueue-0@128a415] Sending event to server for PlaybackStarted args={UIContext=/192.168.1.100:55539, MediaTime=1325048402705, ChapterNum=0, MediaFile=MediaFile[id=12947004 A[12823703,119699,"Aliens vs. Predator: Requiem",58574@1228.00:00,120] mask=TV host=SageTV-VM encodedBy=Hauppauge HD PVR Capture Device HDPVRMax format=MPEG2-TS 1:59:51 2884 kbps [#0 Video[H.264 29.97003 fps 1920x1080 16:9 interlaced id=1011]#1 Audio[AC3 48000 Hz 2 channels 384 kbps MAIN idx=1 id=1100]{ScrapedBy=Phoenix, IMDBID=tt0758730, MediaType=Movie, ScrapedDate=1350790824345, MediaProviderDataID=tt0758730, MediaTitle=AVPR: Aliens vs Predator - Requiem, DiscNumber=0, UserRating=47, MediaProviderID=imdb}] \\W7-Server\Recordings (DVR)\AliensvsPredatorRequiem-12823703-0.ts, Seg0[Wed 12/28 0:00:00.014-Wed 12/28 1:59:51.494]], Duration=7191480, TitleNum=0}
Wed 1/2 22:25:23.977 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true
Wed 1/2 22:25:23.977 [ReProcessHook@19eedef] Start looking for max channel digits
Wed 1/2 22:25:23.978 [AWT-EventQueue-0@128a415] VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null]
Wed 1/2 22:25:23.978 [AWT-EventQueue-0@128a415] DShowMediaPlayer is consuming the events...
Wed 1/2 22:25:23.978 [ReProcessHook@19eedef] New max channel = 3, from channel 618 on lineup 'DIRECTV New York - New York'
Wed 1/2 22:25:23.978 [AWT-EventQueue-0@128a415] Event: 0xd l1=0x0 l2=0x0
Wed 1/2 22:25:23.978 [AWT-EventQueue-0@128a415] Event: 0xe l1=0x0 l2=0x0
Wed 1/2 22:25:23.979 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true
Wed 1/2 22:25:23.979 [AWT-EventQueue-0@128a415] VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null]
Wed 1/2 22:25:23.979 [AWT-EventQueue-0@128a415] DShowMediaPlayer is consuming the events...
Wed 1/2 22:25:23.980 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] VF processing job null nPlayin=true
Wed 1/2 22:25:23.980 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] isRec=false rd=7191380 base=2696 eos=false
Wed 1/2 22:25:23.980 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] VF thread is now waiting for 1:59:48.434
Wed 1/2 22:25:23.997 [ReProcessHook@19eedef] Done looking for max channel digits; elapsed time: 20
Wed 1/2 22:25:24.118 [Thread-985@1a0e5bc] VMR9 info has changed width=1280 height=720 arx=0 ary=0
Wed 1/2 22:25:25.835 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] =======>Get getMediaTimeMillis0 cur:4551 s0:0 s1:0 new:4551.
Wed 1/2 22:25:26.823 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] =======>Get getMediaTimeMillis0 cur:5538 s0:0 s1:0 new:5538.
Wed 1/2 22:25:27.836 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] =======>Get getMediaTimeMillis0 cur:6552 s0:0 s1:0 new:6552.
Wed 1/2 22:25:28.825 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] =======>Get getMediaTimeMillis0 cur:7540 s0:0 s1:0 new:7540.
Wed 1/2 22:25:29.023 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@17b227c] =======>Get getMediaTimeMillis0 cur:7738 s0:0 s1:0 new:7738.
Wed 1/2 22:25:30.515 [AWT-EventQueue-0@128a415] VF.submitJob(VFJob[CloseMF r=0.0 t=0 file=null ifn=null])
Wed 1/2 22:25:30.515 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] VF processing job VFJob[CloseMF r=0.0 t=0 file=null ifn=null] nPlayin=true
Wed 1/2 22:25:30.515 [AWT-EventQueue-0@128a415] CloseAndWait is executing the close job synchronously now
Wed 1/2 22:25:30.516 [AWT-EventQueue-0@128a415] VF processing on UI Thread VFJob[CloseMF r=0.0 t=0 file=null ifn=null]
Wed 1/2 22:25:30.516 [AWT-EventQueue-0@128a415] =======>Get getMediaTimeMillis0 cur:9232 s0:0 s1:0 new:9232.
Wed 1/2 22:25:30.518 [AWT-EventQueue-0@128a415] VF logFileWatch doneAir=A[12823703,119699,"Aliens vs. Predator: Requiem",58574@1228.00:00,120] theTime=Wed 12/28 0:00:09.246 recTime=Wed 12/28 0:00:00.014
Wed 1/2 22:25:30.519 [main@136bdda] Stopping the playback graph.
Wed 1/2 22:25:30.648 [main@136bdda] Calling GraphStopped for the PluginHandler
Wed 1/2 22:25:30.648 [main@136bdda] Done calling GraphStopped for the PluginHandler
Wed 1/2 22:25:30.648 [AWT-EventQueue-0@128a415] Tearing down playback graph
Wed 1/2 22:25:30.648 [AWT-EventQueue-0@128a415] NATIVE Deallocating the CPlayerData object
Wed 1/2 22:25:30.648 [AWT-EventQueue-0@128a415] ....RemoveFilter [Default DirectSound Device] .
Wed 1/2 22:25:30.649 [AWT-EventQueue-0@128a415] ....RemoveFilter [VidRend] .
Wed 1/2 22:25:30.651 [AWT-EventQueue-0@128a415] ....RemoveFilter [Audio Decoder] .
Wed 1/2 22:25:30.655 [AWT-EventQueue-0@128a415] ....RemoveFilter [Line21 Decoder] .
Wed 1/2 22:25:30.655 [AWT-EventQueue-0@128a415] ....RemoveFilter [Video Decoder] .
Wed 1/2 22:25:30.657 [AWT-EventQueue-0@128a415] ....RemoveFilter [SageTV MPEG2 Demultiplexer] .
Wed 1/2 22:25:30.661 [AWT-EventQueue-0@128a415] ....RemoveFilter [\\W7-Server\Recordings (DVR)\AliensvsPredatorRequiem-12823703-0.ts] .
Wed 1/2 22:25:30.662 [AWT-EventQueue-0@128a415] NATIVE Finished destroying the playback graph
Wed 1/2 22:25:30.664 [AWT-EventQueue-0@128a415] Calling GraphDestroyed for GraphPlugins
Wed 1/2 22:25:30.664 [AWT-EventQueue-0@128a415] Done calling GraphDestroyed for GraphPlugins. Destroying the plugin object now.
Wed 1/2 22:25:30.664 [AWT-EventQueue-0@128a415] Done destroying the GraphPlugin object
Wed 1/2 22:25:30.664 [AWT-EventQueue-0@128a415] Sending event to server for PlaybackStopped args={UIContext=/192.168.1.100:55539, MediaTime=1325048409249, ChapterNum=0, MediaFile=MediaFile[id=12947004 A[12823703,119699,"Aliens vs. Predator: Requiem",58574@1228.00:00,120] mask=TV host=SageTV-VM encodedBy=Hauppauge HD PVR Capture Device HDPVRMax format=MPEG2-TS 1:59:51 2884 kbps [#0 Video[H.264 29.97003 fps 1920x1080 16:9 interlaced id=1011]#1 Audio[AC3 48000 Hz 2 channels 384 kbps MAIN idx=1 id=1100]{ScrapedBy=Phoenix, IMDBID=tt0758730, MediaType=Movie, ScrapedDate=1350790824345, MediaProviderDataID=tt0758730, MediaTitle=AVPR: Aliens vs Predator - Requiem, DiscNumber=0, UserRating=47, MediaProviderID=imdb}] \\W7-Server\Recordings (DVR)\AliensvsPredatorRequiem-12823703-0.ts, Seg0[Wed 12/28 0:00:00.014-Wed 12/28 1:59:51.494]], Duration=7191480, TitleNum=0}
Wed 1/2 22:25:30.665 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] VF processing job null nPlayin=false
Wed 1/2 22:25:30.665 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] VF thread is now waiting for 0:00:00.000
Wed 1/2 22:25:30.777 [AWT-EventQueue-0@128a415] setUI(sage.cb@151448c[TV Explorer]) histIdx=8 uiHistory=[sage.cb@151448c[TV Explorer], sage.cb@102aa10[Main Menu], sage.cb@2667a2[Plugin List], sage.cb@1b4cf46[Main Menu], sage.cb@1b1cd95[Scheduled Recordings], sage.cb@1b4cf46[Main Menu], sage.cb@151448c[TV Explorer], sage.cb@9c05d2[Main Menu], sage.cb@151448c[TV Explorer], sage.cb@1009d04[MediaPlayer OSD]] redo=true
Wed 1/2 22:25:30.777 [AWT-EventQueue-0@128a415] VideoFrame got registration of a subtitle UI component: null
Wed 1/2 22:25:30.777 [AWT-EventQueue-0@128a415] VideoFrame got registration of a cc UI component: null
Wed 1/2 22:25:30.778 [AWT-EventQueue-0@128a415] Get Imported TV Files - Start
Wed 1/2 22:25:30.778 [AWT-EventQueue-0@128a415] Display ImportedTV = true
Wed 1/2 22:25:30.778 [AWT-EventQueue-0@128a415] LimitSearchPaths = None
Wed 1/2 22:25:30.778 [AWT-EventQueue-0@128a415] TCED: Non-null TVImportFiles 222
Wed 1/2 22:25:30.779 [AWT-EventQueue-0@128a415] Get Imported TV Files - Done
Wed 1/2 22:25:30.779 [AWT-EventQueue-0@128a415] Get Recorded Files - Start
Wed 1/2 22:25:30.811 [AWT-EventQueue-0@128a415] Get Recorded Files - Done
Wed 1/2 22:25:30.811 [AWT-EventQueue-0@128a415] Get Scheduled Files - Start
Wed 1/2 22:25:31.475 [AWTThreadWatcher-SAGETV_PROCESS_LOCAL_UI@374534] EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 750
Wed 1/2 22:25:32.225 [AWTThreadWatcher-SAGETV_PROCESS_LOCAL_UI@374534] EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 1500
Wed 1/2 22:25:32.975 [AWTThreadWatcher-SAGETV_PROCESS_LOCAL_UI@374534] EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 2250
Wed 1/2 22:25:33.725 [AWTThreadWatcher-SAGETV_PROCESS_LOCAL_UI@374534] EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 3000
Wed 1/2 22:25:34.475 [AWTThreadWatcher-SAGETV_PROCESS_LOCAL_UI@374534] EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 3750
Wed 1/2 22:25:35.225 [AWTThreadWatcher-SAGETV_PROCESS_LOCAL_UI@374534] EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 4500
Wed 1/2 22:25:35.975 [AWTThreadWatcher-SAGETV_PROCESS_LOCAL_UI@374534] EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 5250
Wed 1/2 22:25:36.725 [AWTThreadWatcher-SAGETV_PROCESS_LOCAL_UI@374534] EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 6000
Wed 1/2 22:25:37.475 [AWTThreadWatcher-SAGETV_PROCESS_LOCAL_UI@374534] EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 6750
Wed 1/2 22:25:38.225 [AWTThreadWatcher-SAGETV_PROCESS_LOCAL_UI@374534] EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 7500
Wed 1/2 22:25:38.975 [AWTThreadWatcher-SAGETV_PROCESS_LOCAL_UI@374534] EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 8250
Wed 1/2 22:25:39.725 [AWTThreadWatcher-SAGETV_PROCESS_LOCAL_UI@374534] EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 9000
Wed 1/2 22:25:40.475 [AWTThreadWatcher-SAGETV_PROCESS_LOCAL_UI@374534] EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 9750
Wed 1/2 22:25:41.225 [AWTThreadWatcher-SAGETV_PROCESS_LOCAL_UI@374534] EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 10500
Wed 1/2 22:25:41.975 [AWTThreadWatcher-SAGETV_PROCESS_LOCAL_UI@374534] EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 11250
Wed 1/2 22:25:42.725 [AWTThreadWatcher-SAGETV_PROCESS_LOCAL_UI@374534] EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 12000
Wed 1/2 22:25:43.475 [AWTThreadWatcher-SAGETV_PROCESS_LOCAL_UI@374534] EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 12750
Wed 1/2 22:25:44.225 [AWTThreadWatcher-SAGETV_PROCESS_LOCAL_UI@374534] EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 13500
Wed 1/2 22:25:44.754 [AWT-EventQueue-0@128a415] Get Scheduled Files - Done
Wed 1/2 22:25:44.754 [AWT-EventQueue-0@128a415] Start applying filters
Wed 1/2 22:25:44.755 [AWT-EventQueue-0@128a415] Done applying filters
Wed 1/2 22:25:44.755 [AWT-EventQueue-0@128a415] Start Grouping
Wed 1/2 22:25:44.793 [AWT-EventQueue-0@128a415] Done Grouping
Wed 1/2 22:25:44.793 [AWT-EventQueue-0@128a415] Starting EpSorting
Wed 1/2 22:25:44.966 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] VF processing job null nPlayin=false
Wed 1/2 22:25:44.967 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] VF thread is now waiting for 0:00:00.000
Wed 1/2 22:25:44.979 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] VF processing job null nPlayin=false
Wed 1/2 22:25:44.980 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@18f4f91] VF thread is now waiting for 0:00:00.000