Mon 12/5 17:12:17.647 user.dir2=D:\Program Files\SageTV\SageTV
Mon 12/5 17:12:17.649 classpath=D:\Program Files\SageTV\SageTV\Sage.jar;D:\Program Files\SageTV\SageTV\xerces.jar;D:\Program Files\SageTV\SageTV\plugin.jar;D:\Program Files\SageTV\SageTV\;;JARs\jcifs-1.1.6.jar;JARs\jdic.jar
Mon 12/5 17:12:17.650 JVM version=1.5.0_06
Mon 12/5 17:12:17.650 OS=Windows XP 5.1
Mon 12/5 17:12:17.651 Succesfully setup system shell hook
Mon 12/5 17:12:17.679 ImageUtils loading URL jar:file:/D:/Program%20Files/SageTV/SageTV/Sage.jar!/images/CloseWindow.gif
Mon 12/5 17:12:17.778 ImageUtils creating BI copy BufferedImage@1ffbd68: type = 13 IndexColorModel: #pixelBits = 8 numComponents = 4 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 2 transIndex   = 0 has alpha = true isAlphaPre = false ByteInterleavedRaster: width = 16 height = 14 #numDataElements 1 dataOff[0] = 0
Mon 12/5 17:12:17.839 ImageUtils loading URL jar:file:/D:/Program%20Files/SageTV/SageTV/Sage.jar!/images/CloseWindowPressed.gif
Mon 12/5 17:12:17.851 ImageUtils creating BI copy BufferedImage@337838: type = 13 IndexColorModel: #pixelBits = 8 numComponents = 4 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 2 transIndex   = 0 has alpha = true isAlphaPre = false ByteInterleavedRaster: width = 16 height = 14 #numDataElements 1 dataOff[0] = 0
Mon 12/5 17:12:17.852 ImageUtils loading URL jar:file:/D:/Program%20Files/SageTV/SageTV/Sage.jar!/images/MinWindow.gif
Mon 12/5 17:12:17.859 ImageUtils creating BI copy BufferedImage@18a47e0: type = 13 IndexColorModel: #pixelBits = 8 numComponents = 4 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 2 transIndex   = 0 has alpha = true isAlphaPre = false ByteInterleavedRaster: width = 16 height = 14 #numDataElements 1 dataOff[0] = 0
Mon 12/5 17:12:17.868 ImageUtils loading URL jar:file:/D:/Program%20Files/SageTV/SageTV/Sage.jar!/images/MinWindowPressed.gif
Mon 12/5 17:12:17.872 ImageUtils creating BI copy BufferedImage@179c285: type = 13 IndexColorModel: #pixelBits = 8 numComponents = 4 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 2 transIndex   = 0 has alpha = true isAlphaPre = false ByteInterleavedRaster: width = 16 height = 14 #numDataElements 1 dataOff[0] = 0
Mon 12/5 17:12:17.948 ImageUtils loading URL jar:file:/D:/Program%20Files/SageTV/SageTV/Sage.jar!/images/splash.gif
Mon 12/5 17:12:17.975 ImageUtils creating BI copy BufferedImage@1abc7b9: type = 13 IndexColorModel: #pixelBits = 8 numComponents = 3 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 1 transIndex   = -1 has alpha = false isAlphaPre = false ByteInterleavedRaster: width = 520 height = 350 #numDataElements 1 dataOff[0] = 0
Mon 12/5 17:12:18.041 hostname=desktop
Mon 12/5 17:12:18.406 SageTV V4.0.0.56
Mon 12/5 17:12:18.408 ImageUtils loading URL jar:file:/D:/Program%20Files/SageTV/SageTV/Sage.jar!/images/tvicon.gif
Mon 12/5 17:12:18.426 ImageUtils creating BI copy BufferedImage@119c082: type = 13 IndexColorModel: #pixelBits = 8 numComponents = 4 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 2 transIndex   = 25 has alpha = true isAlphaPre = false ByteInterleavedRaster: width = 32 height = 32 #numDataElements 1 dataOff[0] = 0
Mon 12/5 17:12:18.508 ImageUtils loading URL jar:file:/D:/Program%20Files/SageTV/SageTV/Sage.jar!/images/tvicon_anim0.gif
Mon 12/5 17:12:18.513 ImageUtils creating BI copy BufferedImage@17182c1: type = 13 IndexColorModel: #pixelBits = 8 numComponents = 4 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 2 transIndex   = 25 has alpha = true isAlphaPre = false ByteInterleavedRaster: width = 32 height = 32 #numDataElements 1 dataOff[0] = 0
Mon 12/5 17:12:18.514 ImageUtils loading URL jar:file:/D:/Program%20Files/SageTV/SageTV/Sage.jar!/images/tvicon_anim1.gif
Mon 12/5 17:12:18.519 ImageUtils creating BI copy BufferedImage@1cde100: type = 13 IndexColorModel: #pixelBits = 8 numComponents = 4 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 2 transIndex   = 25 has alpha = true isAlphaPre = false ByteInterleavedRaster: width = 32 height = 32 #numDataElements 1 dataOff[0] = 0
Mon 12/5 17:12:18.520 ImageUtils loading URL jar:file:/D:/Program%20Files/SageTV/SageTV/Sage.jar!/images/tvicon_anim2.gif
Mon 12/5 17:12:18.523 ImageUtils creating BI copy BufferedImage@45a877: type = 13 IndexColorModel: #pixelBits = 8 numComponents = 4 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 2 transIndex   = 25 has alpha = true isAlphaPre = false ByteInterleavedRaster: width = 32 height = 32 #numDataElements 1 dataOff[0] = 0
Mon 12/5 17:12:18.524 ImageUtils loading URL jar:file:/D:/Program%20Files/SageTV/SageTV/Sage.jar!/images/tvicon_anim3.gif
Mon 12/5 17:12:18.535 ImageUtils creating BI copy BufferedImage@192d342: type = 13 IndexColorModel: #pixelBits = 8 numComponents = 4 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 2 transIndex   = 25 has alpha = true isAlphaPre = false ByteInterleavedRaster: width = 32 height = 32 #numDataElements 1 dataOff[0] = 0
Mon 12/5 17:12:18.545 Wizard starting to load database info...
Mon 12/5 17:12:18.549 DBFile at version 53 FileSize=2494850
Mon 12/5 17:12:18.549 Wizard allocating table for Year of size 79
Mon 12/5 17:12:18.552 Wizard loading main index for Year
Mon 12/5 17:12:18.554 Wizard allocating table for Network of size 32
Mon 12/5 17:12:18.554 Wizard loading main index for Network
Mon 12/5 17:12:18.555 Wizard allocating table for Title of size 2451
Mon 12/5 17:12:18.555 Wizard loading main index for Title
Mon 12/5 17:12:18.584 Wizard building alt. index 0 for Title
Mon 12/5 17:12:18.594 Wizard allocating table for Channel of size 701
Mon 12/5 17:12:18.595 Wizard loading main index for Channel
Mon 12/5 17:12:18.601 Wizard allocating table for People of size 11753
Mon 12/5 17:12:18.603 Wizard loading main index for People
Mon 12/5 17:12:18.671 Wizard building alt. index 0 for People
Mon 12/5 17:12:18.693 Wizard allocating table for SubCategory of size 102
Mon 12/5 17:12:18.696 Wizard loading main index for SubCategory
Mon 12/5 17:12:18.697 Wizard allocating table for Rated of size 7
Mon 12/5 17:12:18.697 Wizard loading main index for Rated
Mon 12/5 17:12:18.697 Wizard allocating table for ParentalRating of size 0
Mon 12/5 17:12:18.697 Wizard allocating table for ExtendedRating of size 10
Mon 12/5 17:12:18.698 Wizard loading main index for ExtendedRating
Mon 12/5 17:12:18.698 Wizard allocating table for Category of size 70
Mon 12/5 17:12:18.698 Wizard loading main index for Category
Mon 12/5 17:12:18.698 Wizard allocating table for PrimeTitle of size 0
Mon 12/5 17:12:18.699 Wizard allocating table for Bonus of size 171
Mon 12/5 17:12:18.699 Wizard loading main index for Bonus
Mon 12/5 17:12:18.699 Wizard allocating table for Show of size 5474
Mon 12/5 17:12:18.700 Wizard loading main index for Show
Mon 12/5 17:12:18.808 Wizard building alt. index 0 for Show
Mon 12/5 17:12:18.825 Wizard allocating table for Airing of size 32996
Mon 12/5 17:12:18.829 Wizard loading main index for Airing
Mon 12/5 17:12:18.900 Wizard building alt. index 0 for Airing
Mon 12/5 17:12:18.934 Wizard building alt. index 1 for Airing
Mon 12/5 17:12:18.960 Wizard allocating table for ManualRecord of size 0
Mon 12/5 17:12:18.961 Wizard allocating table for MediaFile of size 17
Mon 12/5 17:12:18.961 Wizard loading main index for MediaFile
Mon 12/5 17:12:18.962 Wizard building alt. index 0 for MediaFile
Mon 12/5 17:12:18.962 Wizard allocating table for Watched of size 2
Mon 12/5 17:12:18.963 Wizard loading main index for Watched
Mon 12/5 17:12:18.963 Wizard building alt. index 0 for Watched
Mon 12/5 17:12:18.963 Wizard allocating table for Agent of size 0
Mon 12/5 17:12:18.963 Wizard allocating table for Wasted of size 0
Mon 12/5 17:12:18.964 Wizard allocating table for Playlist of size 0
Mon 12/5 17:12:18.964 Wizard processing transactional records...
Mon 12/5 17:12:19.103 Wizard performing validation on database objects...
Mon 12/5 17:12:19.156 Wizard DONE loading database info. loadTime=0.611 sec
Mon 12/5 17:12:19.191 Wizard backing up database file...
Mon 12/5 17:12:19.193 Wizard compressing new file...
Mon 12/5 17:12:19.195 Wizard writing out table info for Year
Mon 12/5 17:12:19.199 Wizard writing out table info for Network
Mon 12/5 17:12:19.204 Wizard writing out table info for Title
Mon 12/5 17:12:19.221 Wizard writing out table info for Channel
Mon 12/5 17:12:19.226 Wizard writing out table info for People
Mon 12/5 17:12:19.264 Wizard writing out table info for SubCategory
Mon 12/5 17:12:19.266 Wizard writing out table info for Rated
Mon 12/5 17:12:19.267 Wizard writing out table info for ParentalRating
Mon 12/5 17:12:19.268 Wizard writing out table info for ExtendedRating
Mon 12/5 17:12:19.269 Wizard writing out table info for Category
Mon 12/5 17:12:19.271 Wizard writing out table info for PrimeTitle
Mon 12/5 17:12:19.272 Wizard writing out table info for Bonus
Mon 12/5 17:12:19.274 Wizard writing out table info for Show
Mon 12/5 17:12:19.367 Wizard writing out table info for Airing
Mon 12/5 17:12:19.445 Wizard writing out table info for ManualRecord
Mon 12/5 17:12:19.447 Wizard writing out table info for MediaFile
Mon 12/5 17:12:19.460 Wizard writing out table info for Watched
Mon 12/5 17:12:19.466 Wizard writing out table info for Agent
Mon 12/5 17:12:19.469 Wizard writing out table info for Wasted
Mon 12/5 17:12:19.471 Wizard writing out table info for Playlist
Mon 12/5 17:12:19.609 Wizard DONE saving database info.
Mon 12/5 17:12:19.610 Loading Widget File:D:\Program Files\SageTV\SageTV\STVs\SageTV3\SageTV3.stv
Mon 12/5 17:12:19.611 Widget DBFile at version 53 FileSize=1635031
Mon 12/5 17:12:19.612 Wizard allocating table for Widget of size 17751
Mon 12/5 17:12:19.612 Wizard loading main index for Widget
Mon 12/5 17:12:19.682 rb=en
Mon 12/5 17:12:20.030 Wizard performing validation on database objects...
Mon 12/5 17:12:20.550 MMC calling detectCaptureDevices on sage.bv@1bc4459
Mon 12/5 17:12:20.552 devices detected=[]
Mon 12/5 17:12:20.552 EncoderMap={}
Mon 12/5 17:12:20.553 MMC calling detectCaptureDevices on sage.j@12b6651
Mon 12/5 17:12:20.585 systemCapDevices=[Realtek AC97 Audio, Hauppauge WinTV PVR PCI II Capture]
Mon 12/5 17:12:20.587 Checking encoder key:1642691032
Mon 12/5 17:12:20.607 Created DShowCapDev object for:Hauppauge WinTV PVR PCI II Capture
Mon 12/5 17:12:20.607 EncoderMap1={Hauppauge WinTV PVR PCI II Capture=Hauppauge WinTV PVR PCI II Capture}
Mon 12/5 17:12:20.643 BDA capture device found:@device:pnp:\\?\root#system#0000#{fd0a5af4-b41d-11d2-9c95-00c04f7971e0}\{03884cb6-e89a-4deb-b69e-8dc621686e6a}&global.
Mon 12/5 17:12:20.643 BDA capture is not found on bus:PCI:0-7 for Hauppauge WinTV PVR PCI II Capture.
Mon 12/5 17:12:20.652 DeviceCap: 0x810
Mon 12/5 17:12:20.682 BDA capture device found:@device:pnp:\\?\root#system#0000#{fd0a5af4-b41d-11d2-9c95-00c04f7971e0}\{03884cb6-e89a-4deb-b69e-8dc621686e6a}&global.
Mon 12/5 17:12:20.682 BDA capture is not found on bus:PCI:0-7 for Hauppauge WinTV PVR PCI II Capture.
Mon 12/5 17:12:20.683 Found the pin2 ;)
Mon 12/5 17:12:20.688 Encoder passed the check:Hauppauge WinTV PVR PCI II Capture
Mon 12/5 17:12:20.729 Processing new system dev:Realtek AC97 Audio
Mon 12/5 17:12:20.729 Processing new system dev:Hauppauge WinTV PVR PCI II Capture
Mon 12/5 17:12:20.730 Device already has been processed
Mon 12/5 17:12:20.730 devices detected=[Hauppauge WinTV PVR PCI II Capture]
Mon 12/5 17:12:20.730 EncoderMap={Hauppauge WinTV PVR PCI II Capture=Hauppauge WinTV PVR PCI II Capture}
Mon 12/5 17:12:21.235 DShowFilters=[.RAM file Parser, 9x8Resize, AC3 Parser Filter, AC3Filter, ACELP.net Sipro Lab Audio Decoder, ACM Wrapper, Allocator Fix, ASF ACM Handler, ASF DIB Handler, ASF DJPEG Handler, ASF embedded stuff Handler, ASF ICM Handler, ASF JPEG Handler, ASF URL Handler, ASX file Parser, ASX v.2 file Parser, AVI Decompressor, AVI Draw, AVI Mux, AVI Splitter, AVI/WAV File Source, BDA MPEG2 Transport Information Filter, Bitmap Generate, Color Space Converter, Deinterlace Filter, DivX Decoder Filter, DV Muxer, DV Splitter, DV Video Decoder, DVD Navigator, File Source (Async.), File Source (Netshow URL), File Source (URL), File stream renderer, File writer, Frame Eater, Full Screen Renderer, G.711 Codec, Hauppauge WinTV Color Format Converter 2, Hauppauge WinTV File Reader, Hauppauge WinTV File Writer, Hauppauge WinTV MPEG Splitter, Hauppauge WinTV SnapShot, Infinite Pin Tee Filter, Internal Script Command Renderer, InterVideo NonCSS Audio Decoder for Hauppauge, InterVideo NonCSS Video Decoder for Hauppauge, Line 21 Decoder, Line 21 Decoder 2, Lyric Parser, Microsoft MPEG-4 Video Decompressor, Microsoft Screen Video Decompressor, MIDI Parser, Minimal Null, MJPEG Decompressor, MPEG Audio Decoder, MPEG Layer-3 Decoder, MPEG Video Decoder, MPEG-2 Demultiplexer, MPEG-2 Sections and Tables, MPEG-2 Splitter, MPEG-2 Video Stream Analyzer, MPEG-I Stream Splitter, MPEG2Dump, Mpeg4 Decoder DMO, Mpeg43 Decoder DMO, Mpeg4s Decoder DMO, Multi-file Parser, NSC file Parser, Null Renderer, Overlay Mixer, Overlay Mixer2, QT Decompressor, QuickTime Movie Parser, Record Queue, SageTV MPEG Audio Decoder, SageTV MPEG Audio Encoder, SageTV MPEG Encoder, SageTV MPEG Layer II Audio Encoder, SageTV MPEG Multiplexer, SageTV MPEG Splitter, SageTV MPEG Video Decoder, SageTV MPEG Video Encoder, SageTV MpegDeMux, SageTV MpegMux, SageTV Music Visualization, SageTV TS Splitter 1.0, SAMI (CC) Parser, SampleGrabber, Shared File Source (Async.), ShotBoundaryDet, Smart Tee, StreamBufferSink, StreamBufferSource, Stretch Video, Uncompressed Domain Shot Detection Filter, VBI Surface Allocator, VGA 16 Color Ditherer, Video Mixing Renderer 9, Video Port Manager, Video Renderer, Video Renderer, Wave Parser, WIA Stream Snapshot Filter, Windows Media Audio Decoder, Windows Media Multiplexer, Windows Media Pad VU Data Grabber, Windows Media source filter, Windows Media Update Filter, Windows Media Video Decoder, Windows Media Video Decoder, WM ASF Reader, WM ASF Writer, WMAudio Decoder DMO, WMSpeech Decoder DMO, WMT AudioAnalyzer, WMT Black Frame Generator, WMT DirectX Transform Wrapper, WMT DV Extract, WMT Format Conversion, WMT Import Filter, WMT Interlacer, WMT Log Filter, WMT MuxDeMux Filter, WMT Sample Information Filter, WMT Screen Capture filter, WMT Switch Filter, WMT VIH2 Fix, WMT Virtual Renderer, WMT Virtual Source, WMT Volume, WMV Screen decoder DMO, WMVideo Decoder DMO, WST Decoder, XML Playlist]
Mon 12/5 17:12:21.462 CARNY Processing 0 Agents & 13825 Airs
Mon 12/5 17:12:21.463 CARNY Negative Energy Size: 0
Mon 12/5 17:12:21.465 CARNY Traitors:[]
Mon 12/5 17:12:21.727 VF thread is now running...
Mon 12/5 17:12:21.737 VF thread is now waiting for 0:00:00.000
Mon 12/5 17:12:21.937 Carny waiting for awhile...
Mon 12/5 17:12:22.276 initGraph0 called capDev=Hauppauge WinTV PVR PCI II Capture capDevNum=0
Mon 12/5 17:12:22.276 VF processing job null nPlayin=false
Mon 12/5 17:12:22.276 Seeker waiting for 153722848383900 mins.
Mon 12/5 17:12:22.276 VF thread is now waiting for 0:00:00.000
Mon 12/5 17:12:22.280 sage.aq@1a683e6 needs an update in 23:58:45
Mon 12/5 17:12:22.281 sage.aq@11d9f05 needs an update in 0:00:00
Mon 12/5 17:12:22.281 sage.aq@1b323af needs an update in 2562047788015:12:55
Mon 12/5 17:12:22.281 Add analog filters for device=Hauppauge WinTV PVR PCI II Capture
Mon 12/5 17:12:22.281 EPG needs an update in 0 minutes
Mon 12/5 17:12:22.345 EPG attempting to expand Undefined Source Name
Mon 12/5 17:12:22.346 expand called on Undefined Source Name at Mon 12/5 17:12:22.346 expandedUntil=Tue 12/6 17:11:08.107 confirmedUntil=Wed 12/31 19:00:00.000
Mon 12/5 17:12:22.346 EPG attempting to expand DISH Washington - Washington
Mon 12/5 17:12:22.347 expand called on DISH Washington - Washington at Mon 12/5 17:12:22.347 expandedUntil=Mon 12/5 17:11:11.330 confirmedUntil=Wed 12/31 19:00:00.000
Mon 12/5 17:12:22.347 EPG Expanding DISH Washington - Washington at Mon 12/5 17:12:22.347
Mon 12/5 17:12:22.362 Found the pin2 ;)
Mon 12/5 17:12:22.370 Found the pin2 ;)
Mon 12/5 17:12:22.385 switchToConnector0 70996552 type=1 index=0
Mon 12/5 17:12:22.510 DONE: switchToConnector0 70996552 type=1 index=0
Mon 12/5 17:12:22.553 Scheduler.updateSchedule() called time=Mon 12/5 17:12:22.552 manual=[] schedules={Hauppauge WinTV PVR PCI II Capture=[Sched=[] MustSee=[]]} scheduleRandSize=0
Mon 12/5 17:12:22.554 # Airs=0
Mon 12/5 17:12:22.556 MUST SEE FINAL-Hauppauge WinTV PVR PCI II Capture-[]
Mon 12/5 17:12:22.556 Evaluating Potentials
Mon 12/5 17:12:22.556 COMPLETE SCHEDULE-----**&^%&*-------COMPLETE SCHEDULE
Hauppauge WinTV PVR PCI II Capture
Mon 12/5 17:12:22.557 []
Mon 12/5 17:12:22.557 Seeker awoken
Mon 12/5 17:12:22.557 Seeker adding new Encoder: Hauppauge WinTV PVR PCI II Capture
Mon 12/5 17:12:22.576 MARK 1 currRecord=null enc=Hauppauge WinTV PVR PCI II Capture clients=[]
Mon 12/5 17:12:22.577 Seeker in AUTOMATIC mode nextRecord=null nextTTA=9223372036854775807
Mon 12/5 17:12:22.579 newRecord=null
Mon 12/5 17:12:22.579 NOTHING TO RECORD FOR NOW...
Mon 12/5 17:12:22.580 VF processing job null nPlayin=false
Mon 12/5 17:12:22.580 VF thread is now waiting for 0:00:00.000
Mon 12/5 17:12:22.580 Seeker waiting for -18897012 mins.
Mon 12/5 17:12:22.582 Seeker awoken
Mon 12/5 17:12:22.584 MARK 1 currRecord=null enc=Hauppauge WinTV PVR PCI II Capture clients=[]
Mon 12/5 17:12:22.584 Seeker in AUTOMATIC mode nextRecord=null nextTTA=9223372036854775807
Mon 12/5 17:12:22.584 newRecord=null
Mon 12/5 17:12:22.584 NOTHING TO RECORD FOR NOW...
Mon 12/5 17:12:22.593 VF processing job null nPlayin=false
Mon 12/5 17:12:22.593 VF thread is now waiting for 0:00:00.000
Mon 12/5 17:12:22.616 Seeker clearing unwanted and partial files...
Mon 12/5 17:12:22.619 Seeker waiting for 153722848383900 mins.
Mon 12/5 17:12:22.652 WarlockRipper logged in OK.
Mon 12/5 17:12:23.043 DatePat=EEE, MMM d orgPat=EEEE, MMMM d, yyyy
Mon 12/5 17:12:23.080 setUI(sage.bo@1d394ab[Main Menu]) histIdx=0 uiHistory=[sage.bo@1d394ab[Main Menu]]
Mon 12/5 17:12:23.212 StorageDeviceDetector started...
Mon 12/5 17:12:23.422 Seeker invoking System.gc()
Mon 12/5 17:12:23.673 Rendered new font to cache font=java.awt.Font[family=Arial,name=Arial,style=bold,size=17] numGlyphs=1674 numCachedGlyphs=266 numImages=1
Mon 12/5 17:12:23.677 Seeker System.gc() done
Mon 12/5 17:12:23.818 WarlockRipper got 700 channels
Mon 12/5 17:12:23.974 Rendered new font to cache font=java.awt.Font[family=Arial,name=Arial,style=bold,size=25] numGlyphs=1674 numCachedGlyphs=248 numImages=2
Mon 12/5 17:12:24.310 Rendered new font to cache font=java.awt.Font[family=Arial,name=Arial,style=plain,size=27] numGlyphs=1674 numCachedGlyphs=306 numImages=3
Mon 12/5 17:12:24.316 Initializing DirectX9
Mon 12/5 17:12:24.322 Creating D3D Device
Mon 12/5 17:12:24.344 Done Initializing DirectX9
Mon 12/5 17:12:24.346 ImageUtils loading file D:\Program Files\SageTV\SageTV\STVs\SageTV3\Background.jpg
Mon 12/5 17:12:24.405 ImageUtils creating BI copy BufferedImage@1bdaaaa: type = 5 ColorModel: #pixelBits = 24 numComponents = 3 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 1 has alpha = false isAlphaPre = false ByteInterleavedRaster: width = 600 height = 450 #numDataElements 3 dataOff[0] = 2
Mon 12/5 17:12:24.423 Premultiplying alpha for BuffImage...
Mon 12/5 17:12:24.523 Creating DirectX9 Texture from memory w=600 h=450
Mon 12/5 17:12:24.579 ImageUtils loading file D:\Program Files\SageTV\SageTV\STVs\SageTV3\SageLogo256.png
Mon 12/5 17:12:24.591 ImageUtils creating BI copy BufferedImage@1a38913: type = 0 ColorModel: #pixelBits = 32 numComponents = 4 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 3 has alpha = true isAlphaPre = false ByteInterleavedRaster: width = 256 height = 78 #numDataElements 4 dataOff[0] = 0
Mon 12/5 17:12:24.635 Premultiplying alpha for BuffImage...
Mon 12/5 17:12:24.653 Creating DirectX9 Texture from memory w=256 h=78
Mon 12/5 17:12:24.655 ImageUtils loading file D:\Program Files\SageTV\SageTV\STVs\SageTV3\GoFullscreen.png
Mon 12/5 17:12:24.660 ImageUtils creating BI copy BufferedImage@150b06b: type = 0 ColorModel: #pixelBits = 32 numComponents = 4 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 3 has alpha = true isAlphaPre = false ByteInterleavedRaster: width = 118 height = 103 #numDataElements 4 dataOff[0] = 0
Mon 12/5 17:12:24.666 Premultiplying alpha for BuffImage...
Mon 12/5 17:12:24.671 Creating DirectX9 Texture from memory w=118 h=103
Mon 12/5 17:12:24.673 ImageUtils loading file D:\Program Files\SageTV\SageTV\STVs\SageTV3\GoSleep.png
Mon 12/5 17:12:24.680 ImageUtils creating BI copy BufferedImage@8bcf49: type = 0 ColorModel: #pixelBits = 32 numComponents = 4 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 3 has alpha = true isAlphaPre = false ByteInterleavedRaster: width = 97 height = 121 #numDataElements 4 dataOff[0] = 0
Mon 12/5 17:12:24.683 Premultiplying alpha for BuffImage...
Mon 12/5 17:12:24.686 Creating DirectX9 Texture from memory w=97 h=121
Mon 12/5 17:12:24.694 Premultiplying alpha for BuffImage...
Mon 12/5 17:12:24.708 Creating DirectX9 Texture from memory w=256 h=256
Mon 12/5 17:12:24.711 Premultiplying alpha for BuffImage...
Mon 12/5 17:12:24.726 Creating DirectX9 Texture from memory w=256 h=256
Mon 12/5 17:12:24.736 ImageUtils loading file D:\Program Files\SageTV\SageTV\STVs\SageTV3\MenuBarLong.png
Mon 12/5 17:12:24.743 ImageUtils creating BI copy BufferedImage@9ee0f1: type = 0 ColorModel: #pixelBits = 32 numComponents = 4 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 3 has alpha = true isAlphaPre = false ByteInterleavedRaster: width = 586 height = 47 #numDataElements 4 dataOff[0] = 0
Mon 12/5 17:12:24.753 Premultiplying alpha for BuffImage...
Mon 12/5 17:12:24.761 Creating DirectX9 Texture from memory w=586 h=47
Mon 12/5 17:12:24.773 Premultiplying alpha for BuffImage...
Mon 12/5 17:12:24.788 Creating DirectX9 Texture from memory w=256 h=256
Mon 12/5 17:12:26.936 Ministry is starting
Mon 12/5 17:12:26.936 Ministry is waiting for 180 sec
Mon 12/5 17:12:26.981 PM currState=3 wakeupTime=Wed 12/31/1969 19:00:00.000
Mon 12/5 17:12:26.982 Disabled SS
Mon 12/5 17:12:27.345 setUI(sage.bo@1d451d2[MediaPlayer OSD]) histIdx=1 uiHistory=[sage.bo@1d394ab[Main Menu], sage.bo@1d451d2[MediaPlayer OSD]]
Mon 12/5 17:12:27.367 PM currState=3 wakeupTime=Wed 12/31/1969 19:00:00.000
Mon 12/5 17:12:27.737 VideoFrame.watch(A[221089,220717,"Tiny Tots for Jesus",10002@1205.17:00,30])
Mon 12/5 17:12:27.738 watchThisFile=null
Mon 12/5 17:12:27.739 Called Seeker.requestWatch(A[221089,220717,"Tiny Tots for Jesus",10002@1205.17:00,30]) hostname=SAGETV PROCESS VF
Mon 12/5 17:12:27.739 findBestEncoderForNow(A[221089,220717,"Tiny Tots for Jesus",10002@1205.17:00,30] record=false host=SAGETV PROCESS VF)
Mon 12/5 17:12:27.739 foundBestEncoder3=sage.bw$c@1e7d8b1[Hauppauge WinTV PVR PCI II Capture]
Mon 12/5 17:12:27.739 MARK 1 currRecord=null enc=Hauppauge WinTV PVR PCI II Capture clients=[SAGETV PROCESS VF]
Mon 12/5 17:12:27.739 defaultRecord=A[221089,220717,"Tiny Tots for Jesus",10002@1205.17:00,30]
Mon 12/5 17:12:27.740 Seeker in AUTOMATIC mode nextRecord=null nextTTA=9223372036854775807
Mon 12/5 17:12:27.740 FORCE WATCH executing clients=[SAGETV PROCESS VF]
Mon 12/5 17:12:27.740 newRecord=A[221089,220717,"Tiny Tots for Jesus",10002@1205.17:00,30]
Mon 12/5 17:12:27.740 Change in record to another show. Entering device record mode. - LATER
Mon 12/5 17:12:27.740 Change in record to another show. Entering device record mode. - NOW
Mon 12/5 17:12:27.741 Seeker.startRecord(Hauppauge WinTV PVR PCI II Capture A[221089,220717,"Tiny Tots for Jesus",10002@1205.17:00,30], currTime=Mon 12/5 17:12:27.739) currRecord=null switch=false
Mon 12/5 17:12:27.741 Setting up MMC video for recording new show & tuning channel conn=Hauppauge WinTV PVR PCI II Capture TV Tuner
Mon 12/5 17:12:27.742 VideoStorage for new file: D:\tv recordings - Leave Free 2.0 GB
Mon 12/5 17:12:27.821 Rendered new font to cache font=java.awt.Font[family=Arial,name=Arial,style=bold,size=19] numGlyphs=1674 numCachedGlyphs=407 numImages=2
Mon 12/5 17:12:27.822 Premultiplying alpha for BuffImage...
Mon 12/5 17:12:27.837 MediaFile created subfile:D:\tv recordings\TinyTotsforJesus-221089-0.mpg MediaFile[id=292387 A[221089,220717,"Tiny Tots for Jesus",10002@1205.17:00,30] host=desktop encodedBy=Hauppauge WinTV PVR PCI II Capture Great]
Mon 12/5 17:12:27.839 Added:MediaFile[id=292387 A[221089,220717,"Tiny Tots for Jesus",10002@1205.17:00,30] host=desktop encodedBy=Hauppauge WinTV PVR PCI II Capture Great D:\tv recordings\TinyTotsforJesus-221089-0.mpg, Seg0[Mon 12/5 17:12:27.742-Wed 12/31 19:00:00.000]]
Mon 12/5 17:12:27.854 Creating DirectX9 Texture from memory w=256 h=256
Mon 12/5 17:12:27.883 Seeker channel string=9710
Mon 12/5 17:12:27.884 autotune0 70996552 hr=0x0 num=9710
Mon 12/5 17:12:27.884 DONE: autotune0 70996552 hr=0x1 result=0
Mon 12/5 17:12:27.884 setEncodingProperties0 70996552 Great
Mon 12/5 17:12:27.885 Set encoding property audiooutputmode to 0
Mon 12/5 17:12:27.885 Set encoding property audiocrc to 0
Mon 12/5 17:12:27.885 Set encoding property gopsize to 15
Mon 12/5 17:12:27.885 Set encoding property videobitrate to 3800000
Mon 12/5 17:12:27.885 Set encoding property inversetelecine to 0
Mon 12/5 17:12:27.885 Set encoding property closedgop to 0
Mon 12/5 17:12:27.885 Set encoding property vbr to 0
Mon 12/5 17:12:27.885 Set encoding property outputstreamtype to 10
Mon 12/5 17:12:27.885 Set encoding property width to 720
Mon 12/5 17:12:27.885 Set encoding property height to 480
Mon 12/5 17:12:27.885 Set encoding property audiobitrate to 384
Mon 12/5 17:12:27.886 Set encoding property audiosampling to 48000
Mon 12/5 17:12:27.886 Set encoding property disablefilter to 1
Mon 12/5 17:12:27.886 Set encoding property medianfilter to 3
Mon 12/5 17:12:27.886 Set encoding property fps to 30
Mon 12/5 17:12:27.886 Set encoding property ipb to 0
Mon 12/5 17:12:27.886 Set encoding property deinterlace to 0
Mon 12/5 17:12:27.886 Set encoding property aspectratio to 1
Mon 12/5 17:12:27.886 setupEncoding0 called for 70996552 Hauppauge WinTV PVR PCI II Capture #1
Mon 12/5 17:12:27.988 Using encoder filter
Mon 12/5 17:12:27.995 is not ATI encoder.
Mon 12/5 17:12:27.995 configureHCWEncoder is running for Hauppauge WinTV PVR PCI II Capture #0
Mon 12/5 17:12:28.045 Encoding to file D:\tv recordings\TinyTotsforJesus-221089-0.mpg
Mon 12/5 17:12:28.045 startEncoding0 called for Hauppauge WinTV PVR PCI II Capture #1
Mon 12/5 17:12:28.911 VF.submitJob(VFJob[WatchMF r=0.0 t=0 file=MediaFile[id=292387 A[221089,220717,"Tiny Tots for Jesus",10002@1205.17:00,30] host=desktop encodedBy=Hauppauge WinTV PVR PCI II Capture Great D:\tv recordings\TinyTotsforJesus-221089-0.mpg, Seg0[Mon 12/5 17:12:27.742-Wed 12/31 19:00:00.000]] ifn=null])
Mon 12/5 17:12:28.911 VF processing job VFJob[WatchMF r=0.0 t=0 file=MediaFile[id=292387 A[221089,220717,"Tiny Tots for Jesus",10002@1205.17:00,30] host=desktop encodedBy=Hauppauge WinTV PVR PCI II Capture Great D:\tv recordings\TinyTotsforJesus-221089-0.mpg, Seg0[Mon 12/5 17:12:27.742-Wed 12/31 19:00:00.000]] ifn=null] nPlayin=false
Mon 12/5 17:12:28.913 VF processing on UI Thread VFJob[WatchMF r=0.0 t=0 file=MediaFile[id=292387 A[221089,220717,"Tiny Tots for Jesus",10002@1205.17:00,30] host=desktop encodedBy=Hauppauge WinTV PVR PCI II Capture Great D:\tv recordings\TinyTotsforJesus-221089-0.mpg, Seg0[Mon 12/5 17:12:27.742-Wed 12/31 19:00:00.000]] ifn=null]
Mon 12/5 17:12:28.914 VideoFrame creating new media player for file:MediaFile[id=292387 A[221089,220717,"Tiny Tots for Jesus",10002@1205.17:00,30] host=desktop encodedBy=Hauppauge WinTV PVR PCI II Capture Great D:\tv recordings\TinyTotsforJesus-221089-0.mpg, Seg0[Mon 12/5 17:12:27.742-Wed 12/31 19:00:00.000]]
Mon 12/5 17:12:28.915 VF processing job VFJob[LoadMF r=0.0 t=0 file=MediaFile[id=292387 A[221089,220717,"Tiny Tots for Jesus",10002@1205.17:00,30] host=desktop encodedBy=Hauppauge WinTV PVR PCI II Capture Great D:\tv recordings\TinyTotsforJesus-221089-0.mpg, Seg0[Mon 12/5 17:12:27.742-Wed 12/31 19:00:00.000]] ifn=null] nPlayin=false
Mon 12/5 17:12:28.915 VF network encoder playback detected: false
Mon 12/5 17:12:28.950 VF waiting for data to appear in new file...liveWait=-1208
Mon 12/5 17:12:28.950 VF thread is now waiting for 0:00:00.200
Mon 12/5 17:12:29.027 ImageUtils loading file D:\Program Files\SageTV\SageTV\STVs\SageTV3\OSDChUp.png
Mon 12/5 17:12:29.029 ImageUtils creating BI copy BufferedImage@3fe922: type = 0 ColorModel: #pixelBits = 32 numComponents = 4 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 3 has alpha = true isAlphaPre = false ByteInterleavedRaster: width = 29 height = 26 #numDataElements 4 dataOff[0] = 0
Mon 12/5 17:12:29.030 Premultiplying alpha for BuffImage...
Mon 12/5 17:12:29.030 Creating DirectX9 Texture from memory w=29 h=26
Mon 12/5 17:12:29.031 ImageUtils loading file D:\Program Files\SageTV\SageTV\STVs\SageTV3\OSDChDisplay.png
Mon 12/5 17:12:29.034 ImageUtils creating BI copy BufferedImage@161fded: type = 0 ColorModel: #pixelBits = 32 numComponents = 4 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 3 has alpha = true isAlphaPre = false ByteInterleavedRaster: width = 35 height = 26 #numDataElements 4 dataOff[0] = 0
Mon 12/5 17:12:29.035 Premultiplying alpha for BuffImage...
Mon 12/5 17:12:29.036 Creating DirectX9 Texture from memory w=35 h=26
Mon 12/5 17:12:29.036 ImageUtils loading file D:\Program Files\SageTV\SageTV\STVs\SageTV3\OSDChDown.png
Mon 12/5 17:12:29.039 ImageUtils creating BI copy BufferedImage@12f15b0: type = 0 ColorModel: #pixelBits = 32 numComponents = 4 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 3 has alpha = true isAlphaPre = false ByteInterleavedRaster: width = 29 height = 26 #numDataElements 4 dataOff[0] = 0
Mon 12/5 17:12:29.046 Premultiplying alpha for BuffImage...
Mon 12/5 17:12:29.047 Creating DirectX9 Texture from memory w=29 h=26
Mon 12/5 17:12:29.048 ImageUtils loading file D:\Program Files\SageTV\SageTV\STVs\SageTV3\OSDStatusPause.png
Mon 12/5 17:12:29.049 ImageUtils creating BI copy BufferedImage@84c229: type = 0 ColorModel: #pixelBits = 32 numComponents = 4 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 3 has alpha = true isAlphaPre = false ByteInterleavedRaster: width = 6 height = 8 #numDataElements 4 dataOff[0] = 0
Mon 12/5 17:12:29.050 Premultiplying alpha for BuffImage...
Mon 12/5 17:12:29.050 Creating DirectX9 Texture from memory w=6 h=8
Mon 12/5 17:12:29.050 ImageUtils loading file D:\Program Files\SageTV\SageTV\STVs\SageTV3\OSDVolOn.png
Mon 12/5 17:12:29.052 ImageUtils creating BI copy BufferedImage@269101: type = 0 ColorModel: #pixelBits = 32 numComponents = 4 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 3 has alpha = true isAlphaPre = false ByteInterleavedRaster: width = 16 height = 13 #numDataElements 4 dataOff[0] = 0
Mon 12/5 17:12:29.054 Premultiplying alpha for BuffImage...
Mon 12/5 17:12:29.054 Creating DirectX9 Texture from memory w=16 h=13
Mon 12/5 17:12:29.054 ImageUtils loading file D:\Program Files\SageTV\SageTV\STVs\SageTV3\OSDVolBar.png
Mon 12/5 17:12:29.057 ImageUtils creating BI copy BufferedImage@1f5376c: type = 0 ColorModel: #pixelBits = 32 numComponents = 4 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 3 has alpha = true isAlphaPre = false ByteInterleavedRaster: width = 64 height = 4 #numDataElements 4 dataOff[0] = 0
Mon 12/5 17:12:29.058 Premultiplying alpha for BuffImage...
Mon 12/5 17:12:29.058 Creating DirectX9 Texture from memory w=64 h=4
Mon 12/5 17:12:29.059 ImageUtils loading file D:\Program Files\SageTV\SageTV\STVs\SageTV3\OSDVolSlider.png
Mon 12/5 17:12:29.060 ImageUtils creating BI copy BufferedImage@184747e: type = 0 ColorModel: #pixelBits = 32 numComponents = 4 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 3 has alpha = true isAlphaPre = false ByteInterleavedRaster: width = 9 height = 15 #numDataElements 4 dataOff[0] = 0
Mon 12/5 17:12:29.061 Premultiplying alpha for BuffImage...
Mon 12/5 17:12:29.061 Creating DirectX9 Texture from memory w=9 h=15
Mon 12/5 17:12:29.062 ImageUtils loading file D:\Program Files\SageTV\SageTV\STVs\SageTV3\OSDReplay.png
Mon 12/5 17:12:29.063 ImageUtils creating BI copy BufferedImage@e041be: type = 0 ColorModel: #pixelBits = 32 numComponents = 4 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 3 has alpha = true isAlphaPre = false ByteInterleavedRaster: width = 29 height = 26 #numDataElements 4 dataOff[0] = 0
Mon 12/5 17:12:29.064 Premultiplying alpha for BuffImage...
Mon 12/5 17:12:29.064 Creating DirectX9 Texture from memory w=29 h=26
Mon 12/5 17:12:29.065 ImageUtils loading file D:\Program Files\SageTV\SageTV\STVs\SageTV3\OSDRew.png
Mon 12/5 17:12:29.086 ImageUtils creating BI copy BufferedImage@151c2b4: type = 0 ColorModel: #pixelBits = 32 numComponents = 4 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 3 has alpha = true isAlphaPre = false ByteInterleavedRaster: width = 30 height = 26 #numDataElements 4 dataOff[0] = 0
Mon 12/5 17:12:29.086 Premultiplying alpha for BuffImage...
Mon 12/5 17:12:29.087 Creating DirectX9 Texture from memory w=30 h=26
Mon 12/5 17:12:29.087 ImageUtils loading file D:\Program Files\SageTV\SageTV\STVs\SageTV3\OSDStop.png
Mon 12/5 17:12:29.089 ImageUtils creating BI copy BufferedImage@b98117: type = 0 ColorModel: #pixelBits = 32 numComponents = 4 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 3 has alpha = true isAlphaPre = false ByteInterleavedRaster: width = 30 height = 26 #numDataElements 4 dataOff[0] = 0
Mon 12/5 17:12:29.090 Premultiplying alpha for BuffImage...
Mon 12/5 17:12:29.090 Creating DirectX9 Texture from memory w=30 h=26
Mon 12/5 17:12:29.091 ImageUtils loading file D:\Program Files\SageTV\SageTV\STVs\SageTV3\OSDPlay.png
Mon 12/5 17:12:29.092 ImageUtils creating BI copy BufferedImage@694b7e: type = 0 ColorModel: #pixelBits = 32 numComponents = 4 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 3 has alpha = true isAlphaPre = false ByteInterleavedRaster: width = 30 height = 26 #numDataElements 4 dataOff[0] = 0
Mon 12/5 17:12:29.093 Premultiplying alpha for BuffImage...
Mon 12/5 17:12:29.093 Creating DirectX9 Texture from memory w=30 h=26
Mon 12/5 17:12:29.094 ImageUtils loading file D:\Program Files\SageTV\SageTV\STVs\SageTV3\OSDFwd.png
Mon 12/5 17:12:29.095 ImageUtils creating BI copy BufferedImage@2f594d: type = 0 ColorModel: #pixelBits = 32 numComponents = 4 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 3 has alpha = true isAlphaPre = false ByteInterleavedRaster: width = 30 height = 26 #numDataElements 4 dataOff[0] = 0
Mon 12/5 17:12:29.096 Premultiplying alpha for BuffImage...
Mon 12/5 17:12:29.097 Creating DirectX9 Texture from memory w=30 h=26
Mon 12/5 17:12:29.097 ImageUtils loading file D:\Program Files\SageTV\SageTV\STVs\SageTV3\OSDSkip.png
Mon 12/5 17:12:29.100 ImageUtils creating BI copy BufferedImage@e0cdc9: type = 0 ColorModel: #pixelBits = 32 numComponents = 4 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 3 has alpha = true isAlphaPre = false ByteInterleavedRaster: width = 29 height = 26 #numDataElements 4 dataOff[0] = 0
Mon 12/5 17:12:29.101 Premultiplying alpha for BuffImage...
Mon 12/5 17:12:29.102 Creating DirectX9 Texture from memory w=29 h=26
Mon 12/5 17:12:29.107 Got Native Video Dimensions null
Mon 12/5 17:12:29.107 Got Native Video Dimensions null
Mon 12/5 17:12:29.152 VF processing job VFJob[LoadMF r=0.0 t=0 file=MediaFile[id=292387 A[221089,220717,"Tiny Tots for Jesus",10002@1205.17:00,30] host=desktop encodedBy=Hauppauge WinTV PVR PCI II Capture Great D:\tv recordings\TinyTotsforJesus-221089-0.mpg, Seg0[Mon 12/5 17:12:27.742-Wed 12/31 19:00:00.000]] ifn=null] nPlayin=false
Mon 12/5 17:12:29.152 VF network encoder playback detected: false
Mon 12/5 17:12:29.152 VF waiting for data to appear in new file...liveWait=-1410
Mon 12/5 17:12:29.153 VF thread is now waiting for 0:00:00.200
Mon 12/5 17:12:29.169 Scheduler awoken
Mon 12/5 17:12:29.172 Scheduler.updateSchedule() called time=Mon 12/5 17:12:29.172 manual=[] schedules={Hauppauge WinTV PVR PCI II Capture=[Sched=[] MustSee=[]]} scheduleRandSize=0
Mon 12/5 17:12:29.172 # Airs=0
Mon 12/5 17:12:29.173 MUST SEE FINAL-Hauppauge WinTV PVR PCI II Capture-[]
Mon 12/5 17:12:29.173 Evaluating Potentials
Mon 12/5 17:12:29.173 COMPLETE SCHEDULE-----**&^%&*-------COMPLETE SCHEDULE
Hauppauge WinTV PVR PCI II Capture
Mon 12/5 17:12:29.173 [A[221089,220717,"Tiny Tots for Jesus",10002@1205.17:00,30]]
Mon 12/5 17:12:29.174 Seeker awoken
Mon 12/5 17:12:29.174 MARK 1 currRecord=A[221089,220717,"Tiny Tots for Jesus",10002@1205.17:00,30] enc=Hauppauge WinTV PVR PCI II Capture clients=[SAGETV PROCESS VF]
Mon 12/5 17:12:29.175 Seeker in AUTOMATIC mode nextRecord=null nextTTA=9223372036854775807
Mon 12/5 17:12:29.175 FORCE WATCH abandoned because it's currently being recorded clients=[SAGETV PROCESS VF]
Mon 12/5 17:12:29.175 newRecord=A[221089,220717,"Tiny Tots for Jesus",10002@1205.17:00,30]
Mon 12/5 17:12:29.175 Keeping record just the way it is.
Mon 12/5 17:12:29.176 RootFile=D:\ fstype=NTFS fileLength=165824
Mon 12/5 17:12:29.193 VF processing job VFJob[LoadMF r=0.0 t=0 file=MediaFile[id=292387 A[221089,220717,"Tiny Tots for Jesus",10002@1205.17:00,30] host=desktop encodedBy=Hauppauge WinTV PVR PCI II Capture Great D:\tv recordings\TinyTotsforJesus-221089-0.mpg, Seg0[Mon 12/5 17:12:27.742-Wed 12/31 19:00:00.000]] ifn=null] nPlayin=false
Mon 12/5 17:12:29.193 VF network encoder playback detected: false
Mon 12/5 17:12:29.193 VF waiting for data to appear in new file...liveWait=-1451
Mon 12/5 17:12:29.193 VF thread is now waiting for 0:00:00.200
Mon 12/5 17:12:29.215 Seeker clearing unwanted and partial files...
Mon 12/5 17:12:29.220 needFreeSize = 0.4941 GB currFreeSize=6.5277696 GB
Mon 12/5 17:12:29.220 Seeker waiting for 17 mins.
Mon 12/5 17:12:29.257 Got Native Video Dimensions null
Mon 12/5 17:12:29.257 Got Native Video Dimensions null
Mon 12/5 17:12:29.403 VF processing job VFJob[LoadMF r=0.0 t=0 file=MediaFile[id=292387 A[221089,220717,"Tiny Tots for Jesus",10002@1205.17:00,30] host=desktop encodedBy=Hauppauge WinTV PVR PCI II Capture Great D:\tv recordings\TinyTotsforJesus-221089-0.mpg, Seg0[Mon 12/5 17:12:27.742-Wed 12/31 19:00:00.000]] ifn=null] nPlayin=false
Mon 12/5 17:12:29.403 VF network encoder playback detected: false
Mon 12/5 17:12:29.403 VF waiting for data to appear in new file...liveWait=-1661
Mon 12/5 17:12:29.406 VF thread is now waiting for 0:00:00.200
Mon 12/5 17:12:29.612 VF processing job VFJob[LoadMF r=0.0 t=0 file=MediaFile[id=292387 A[221089,220717,"Tiny Tots for Jesus",10002@1205.17:00,30] host=desktop encodedBy=Hauppauge WinTV PVR PCI II Capture Great D:\tv recordings\TinyTotsforJesus-221089-0.mpg, Seg0[Mon 12/5 17:12:27.742-Wed 12/31 19:00:00.000]] ifn=null] nPlayin=false
Mon 12/5 17:12:29.613 VF network encoder playback detected: false
Mon 12/5 17:12:29.613 VF waiting for data to appear in new file...liveWait=-1871
Mon 12/5 17:12:29.613 VF thread is now waiting for 0:00:00.200
Mon 12/5 17:12:29.814 VF processing job VFJob[LoadMF r=0.0 t=0 file=MediaFile[id=292387 A[221089,220717,"Tiny Tots for Jesus",10002@1205.17:00,30] host=desktop encodedBy=Hauppauge WinTV PVR PCI II Capture Great D:\tv recordings\TinyTotsforJesus-221089-0.mpg, Seg0[Mon 12/5 17:12:27.742-Wed 12/31 19:00:00.000]] ifn=null] nPlayin=false
Mon 12/5 17:12:29.814 VF network encoder playback detected: false
Mon 12/5 17:12:29.814 VF waiting for data to appear in new file...liveWait=-2072
Mon 12/5 17:12:29.815 VF thread is now waiting for 0:00:00.200
Mon 12/5 17:12:30.015 VF processing job VFJob[LoadMF r=0.0 t=0 file=MediaFile[id=292387 A[221089,220717,"Tiny Tots for Jesus",10002@1205.17:00,30] host=desktop encodedBy=Hauppauge WinTV PVR PCI II Capture Great D:\tv recordings\TinyTotsforJesus-221089-0.mpg, Seg0[Mon 12/5 17:12:27.742-Wed 12/31 19:00:00.000]] ifn=null] nPlayin=false
Mon 12/5 17:12:30.015 VF network encoder playback detected: false
Mon 12/5 17:12:30.016 VF waiting for data to appear in new file...liveWait=-2274
Mon 12/5 17:12:30.016 VF thread is now waiting for 0:00:00.200
Mon 12/5 17:12:30.028 Got Native Video Dimensions null
Mon 12/5 17:12:30.029 Got Native Video Dimensions null
Mon 12/5 17:12:30.216 VF processing job VFJob[LoadMF r=0.0 t=0 file=MediaFile[id=292387 A[221089,220717,"Tiny Tots for Jesus",10002@1205.17:00,30] host=desktop encodedBy=Hauppauge WinTV PVR PCI II Capture Great D:\tv recordings\TinyTotsforJesus-221089-0.mpg, Seg0[Mon 12/5 17:12:27.742-Wed 12/31 19:00:00.000]] ifn=null] nPlayin=false
Mon 12/5 17:12:30.216 VF network encoder playback detected: false
Mon 12/5 17:12:30.217 VF processing on UI Thread VFJob[LoadMF r=0.0 t=0 file=MediaFile[id=292387 A[221089,220717,"Tiny Tots for Jesus",10002@1205.17:00,30] host=desktop encodedBy=Hauppauge WinTV PVR PCI II Capture Great D:\tv recordings\TinyTotsforJesus-221089-0.mpg, Seg0[Mon 12/5 17:12:27.742-Wed 12/31 19:00:00.000]] ifn=null]
Mon 12/5 17:12:30.217 VF file=MediaFile[id=292387 A[221089,220717,"Tiny Tots for Jesus",10002@1205.17:00,30] host=desktop encodedBy=Hauppauge WinTV PVR PCI II Capture Great D:\tv recordings\TinyTotsforJesus-221089-0.mpg, Seg0[Mon 12/5 17:12:27.742-Wed 12/31 19:00:00.000]] targetTime = Mon 12/5 17:12:27.742
Mon 12/5 17:12:30.217 VideoFrame.timeSelected(Mon 12/5 17:12:27.742, true) currFile=MediaFile[id=292387 A[221089,220717,"Tiny Tots for Jesus",10002@1205.17:00,30] host=desktop encodedBy=Hauppauge WinTV PVR PCI II Capture Great D:\tv recordings\TinyTotsforJesus-221089-0.mpg, Seg0[Mon 12/5 17:12:27.742-Wed 12/31 19:00:00.000]]
Mon 12/5 17:12:30.219 DShowPlayer setVideoRendererFilter0({CD8743A1-3736-11D0-9E69-00C04FD7C15B}) called
Mon 12/5 17:12:30.270 DShowPlayer setVideoDecoderFilter0(SageTV MPEG Video Decoder) called
Mon 12/5 17:12:30.494 WIN32 FAILURE HR=0x8000ffff FILE=.\PlaybackGraph.cpp LINE=79
Mon 12/5 17:12:30.495 WIN32 FAILURE HR=0x8000ffff FILE=.\PlaybackGraph.cpp LINE=91
Mon 12/5 17:12:30.495 DShowPlayer setAudioDecoderFilter0(SageTV MPEG Audio Decoder) called
Mon 12/5 17:12:30.505 DShowPlayer setTimeshift=1 buffer=0
Mon 12/5 17:12:30.554 NATIVE Loading the source file
Mon 12/5 17:12:30.555 NATIVE Setting up the MPEG demux
Mon 12/5 17:12:30.602 NATIVE RenderAudio called
Mon 12/5 17:12:30.602 NATIVE RenderAudio step 1
Mon 12/5 17:12:30.603 NATIVE RenderAudio step 2
Mon 12/5 17:12:30.603 NATIVE RenderAudio step 3
Mon 12/5 17:12:30.603 NATIVE RenderAudio step 4
Mon 12/5 17:12:30.787 NATIVE RenderVideo called
Mon 12/5 17:12:30.787 NATIVE RenderVideo step 1
Mon 12/5 17:12:30.788 NATIVE RenderVideo step 2
Mon 12/5 17:12:30.788 Video source pin information:
Mon 12/5 17:12:30.788 PIN is not connected yet!Mon 12/5 17:12:30.801 M type MEDIATYPE_Video  S type MEDIASUBTYPE_YUY2 F type FORMAT_VideoInfo2
Mon 12/5 17:12:30.801 Progressive video
Mon 12/5 17:12:30.801 M type MEDIATYPE_Video  S type MEDIASUBTYPE_UYVY F type FORMAT_VideoInfo2
Mon 12/5 17:12:30.801 Progressive video
Mon 12/5 17:12:30.801 M type MEDIATYPE_Video  S type MEDIASUBTYPE_RGB24 F type FORMAT_VideoInfo2
Mon 12/5 17:12:30.801 Progressive video
Mon 12/5 17:12:30.801 M type MEDIATYPE_Video  S type MEDIASUBTYPE_RGB565 F type FORMAT_VideoInfo2
Mon 12/5 17:12:30.801 Progressive video
Mon 12/5 17:12:30.802 M type MEDIATYPE_Video  S type MEDIASUBTYPE_RGB555 F type FORMAT_VideoInfo2
Mon 12/5 17:12:30.802 Progressive video
Mon 12/5 17:12:30.802 M type MEDIATYPE_Video  S type MEDIASUBTYPE_RGB32 F type FORMAT_VideoInfo2
Mon 12/5 17:12:30.802 Progressive video
Mon 12/5 17:12:30.802 M type MEDIATYPE_Video  S type MEDIASUBTYPE_YUY2 F type FORMAT_VideoInfo
Mon 12/5 17:12:30.802 M type MEDIATYPE_Video  S type MEDIASUBTYPE_UYVY F type FORMAT_VideoInfo
Mon 12/5 17:12:30.803 M type MEDIATYPE_Video  S type MEDIASUBTYPE_RGB24 F type FORMAT_VideoInfo
Mon 12/5 17:12:30.803 M type MEDIATYPE_Video  S type MEDIASUBTYPE_RGB565 F type FORMAT_VideoInfo
Mon 12/5 17:12:30.803 M type MEDIATYPE_Video  S type MEDIASUBTYPE_RGB555 F type FORMAT_VideoInfo
Mon 12/5 17:12:30.803 M type MEDIATYPE_Video  S type MEDIASUBTYPE_RGB32 F type FORMAT_VideoInfo
Mon 12/5 17:12:30.803 NATIVE RenderVideo step 3
Mon 12/5 17:12:30.902 Filter Graph Video Renderer Info:
Mon 12/5 17:12:30.902 Video Renderer:CLSID_OverlayMixer
Mon 12/5 17:12:30.902 M type MEDIATYPE_Video  S type MEDIASUBTYPE_YUY2 F type FORMAT_VideoInfo2
Mon 12/5 17:12:30.902 Progressive video
Mon 12/5 17:12:30.903 DShowPlayer setVideoHWND(197546)
Mon 12/5 17:12:30.916 Got Native Video Dimensions java.awt.Dimension[width=720,height=540]
Mon 12/5 17:12:30.916 Got the default color key 0x100010
Mon 12/5 17:12:30.916 Got the default overlay color key of 0x100010
Mon 12/5 17:12:30.916 Returning the color key as 0xff100010
Mon 12/5 17:12:30.917 VideoFrame.timeSelected2(Mon 12/5 17:12:27.742, true) currFile=MediaFile[id=292387 A[221089,220717,"Tiny Tots for Jesus",10002@1205.17:00,30] host=desktop encodedBy=Hauppauge WinTV PVR PCI II Capture Great D:\tv recordings\TinyTotsforJesus-221089-0.mpg, Seg0[Mon 12/5 17:12:27.742-Wed 12/31 19:00:00.000]] realDur=0
Mon 12/5 17:12:30.918 About to perform media time selection for 0
Mon 12/5 17:12:30.918 Did Media Time Select Millis 0
Mon 12/5 17:12:30.918 Running the playback graph.
Mon 12/5 17:12:30.918 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null])
Mon 12/5 17:12:31.009 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true
Mon 12/5 17:12:31.010 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null]
Mon 12/5 17:12:31.010 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null])
Mon 12/5 17:12:31.020 DShowMediaPlayer is consuming the events...
Mon 12/5 17:12:31.021 Event: 0xd
Mon 12/5 17:12:31.021 Event: 0xe
Mon 12/5 17:12:31.051 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true
Mon 12/5 17:12:31.051 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null]
Mon 12/5 17:12:31.051 DShowMediaPlayer is consuming the events...
Mon 12/5 17:12:31.052 VF processing job null nPlayin=true
Mon 12/5 17:12:31.052 isRec=true rd=3310 base=0
Mon 12/5 17:12:31.052 VF thread is now waiting for 0:17:32.008
Mon 12/5 17:12:31.124 ImageUtils loading file D:\Program Files\SageTV\SageTV\STVs\SageTV3\OSDStatusPlay.png
Mon 12/5 17:12:31.126 ImageUtils creating BI copy BufferedImage@103b97: type = 0 ColorModel: #pixelBits = 32 numComponents = 4 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 3 has alpha = true isAlphaPre = false ByteInterleavedRaster: width = 8 height = 8 #numDataElements 4 dataOff[0] = 0
Mon 12/5 17:12:31.149 Premultiplying alpha for BuffImage...
Mon 12/5 17:12:31.152 Creating DirectX9 Texture from memory w=8 h=8
Mon 12/5 17:12:31.173 ImageUtils loading file D:\Program Files\SageTV\SageTV\STVs\SageTV3\OSDPause.png
Mon 12/5 17:12:31.175 ImageUtils creating BI copy BufferedImage@147cab0: type = 0 ColorModel: #pixelBits = 32 numComponents = 4 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 3 has alpha = true isAlphaPre = false ByteInterleavedRaster: width = 30 height = 26 #numDataElements 4 dataOff[0] = 0
Mon 12/5 17:12:31.175 Premultiplying alpha for BuffImage...
Mon 12/5 17:12:31.176 Creating DirectX9 Texture from memory w=30 h=26
Mon 12/5 17:12:33.305 PM currState=3 wakeupTime=Wed 12/31/1969 19:00:00.000
Mon 12/5 17:12:33.307 processOptionsMenu optionsMenu=Widget[OSDOptions id=274932 OptionsMenu Layout=Vertical AnchorX=0.5 AnchorY=0.5 PadY=0.005 Insets=0.01 IgnoreThemeProps=false down=[275354,274706,275355,275356,] up=[275087,] context=Context[parent=Context[parent=Context[parent=null map={}] map={DisplayVolTransportsTime=false, TimeScrollTime=-1, DisplayVolStatus=false, DisplayInfo=false, ChannelSurf=, DisplayChanStatus=false, MaxChannel=158, DisplayTimeStatus=false}] map={_SAGE_PASSIVELISTEN=null}]
Mon 12/5 17:12:35.022 setUI(sage.bo@72a921[LiveTVGuide w/ Optional Preview]) histIdx=2 uiHistory=[sage.bo@1d394ab[Main Menu], sage.bo@1d451d2[MediaPlayer OSD], sage.bo@72a921[LiveTVGuide w/ Optional Preview]]
Mon 12/5 17:12:35.127 setUI(sage.bo@1f72465[LiveTVGuide w/ Optional Preview]) histIdx=2 uiHistory=[sage.bo@1d394ab[Main Menu], sage.bo@1d451d2[MediaPlayer OSD], sage.bo@1f72465[LiveTVGuide w/ Optional Preview]]
Mon 12/5 17:12:35.797 PM currState=3 wakeupTime=Wed 12/31/1969 19:00:00.000
Mon 12/5 17:12:36.014 ImageUtils loading file D:\Program Files\SageTV\SageTV\STVs\SageTV3\RecordingNow.png
Mon 12/5 17:12:36.021 ImageUtils creating BI copy BufferedImage@487471: type = 0 ColorModel: #pixelBits = 32 numComponents = 4 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 3 has alpha = true isAlphaPre = false ByteInterleavedRaster: width = 95 height = 58 #numDataElements 4 dataOff[0] = 0
Mon 12/5 17:12:36.023 Premultiplying alpha for BuffImage...
Mon 12/5 17:12:36.046 Creating DirectX9 Texture from memory w=95 h=58
Mon 12/5 17:12:36.049 ImageUtils loading file D:\Program Files\SageTV\SageTV\STVs\SageTV3\guideLeft.png
Mon 12/5 17:12:36.052 ImageUtils creating BI copy BufferedImage@2423e2: type = 0 ColorModel: #pixelBits = 32 numComponents = 4 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 3 has alpha = true isAlphaPre = false ByteInterleavedRaster: width = 14 height = 71 #numDataElements 4 dataOff[0] = 0
Mon 12/5 17:12:36.054 Premultiplying alpha for BuffImage...
Mon 12/5 17:12:36.054 Creating DirectX9 Texture from memory w=14 h=71
Mon 12/5 17:12:36.411 Rendered new font to cache font=java.awt.Font[family=Arial,name=Arial,style=bold,size=16] numGlyphs=1674 numCachedGlyphs=270 numImages=1
Mon 12/5 17:12:36.412 Premultiplying alpha for BuffImage...
Mon 12/5 17:12:36.450 Creating DirectX9 Texture from memory w=256 h=256
Mon 12/5 17:12:36.483 ImageUtils loading file D:\Program Files\SageTV\SageTV\STVs\SageTV3\left.png
Mon 12/5 17:12:36.485 ImageUtils creating BI copy BufferedImage@129dda: type = 0 ColorModel: #pixelBits = 32 numComponents = 4 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 3 has alpha = true isAlphaPre = false ByteInterleavedRaster: width = 24 height = 29 #numDataElements 4 dataOff[0] = 0
Mon 12/5 17:12:36.486 Premultiplying alpha for BuffImage...
Mon 12/5 17:12:36.486 Creating DirectX9 Texture from memory w=24 h=29
Mon 12/5 17:12:36.487 ImageUtils loading file D:\Program Files\SageTV\SageTV\STVs\SageTV3\right.png
Mon 12/5 17:12:36.490 ImageUtils creating BI copy BufferedImage@51aee0: type = 0 ColorModel: #pixelBits = 32 numComponents = 4 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 3 has alpha = true isAlphaPre = false ByteInterleavedRaster: width = 25 height = 27 #numDataElements 4 dataOff[0] = 0
Mon 12/5 17:12:36.491 Premultiplying alpha for BuffImage...
Mon 12/5 17:12:36.492 Creating DirectX9 Texture from memory w=25 h=27
Mon 12/5 17:12:36.492 ImageUtils loading file D:\Program Files\SageTV\SageTV\STVs\SageTV3\guideRight.png
Mon 12/5 17:12:36.516 ImageUtils creating BI copy BufferedImage@13aa36a: type = 0 ColorModel: #pixelBits = 32 numComponents = 4 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 3 has alpha = true isAlphaPre = false ByteInterleavedRaster: width = 15 height = 71 #numDataElements 4 dataOff[0] = 0
Mon 12/5 17:12:36.517 Premultiplying alpha for BuffImage...
Mon 12/5 17:12:36.518 Creating DirectX9 Texture from memory w=15 h=71
Mon 12/5 17:12:36.518 ImageUtils loading file D:\Program Files\SageTV\SageTV\STVs\SageTV3\RecordAny.png
Mon 12/5 17:12:36.522 ImageUtils creating BI copy BufferedImage@b6dff: type = 0 ColorModel: #pixelBits = 32 numComponents = 4 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 3 has alpha = true isAlphaPre = false ByteInterleavedRaster: width = 90 height = 91 #numDataElements 4 dataOff[0] = 0
Mon 12/5 17:12:36.526 Premultiplying alpha for BuffImage...
Mon 12/5 17:12:36.547 Creating DirectX9 Texture from memory w=90 h=91
Mon 12/5 17:12:36.549 ImageUtils loading file D:\Program Files\SageTV\SageTV\STVs\SageTV3\up.png
Mon 12/5 17:12:36.552 ImageUtils creating BI copy BufferedImage@1bea611: type = 0 ColorModel: #pixelBits = 32 numComponents = 4 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 3 has alpha = true isAlphaPre = false ByteInterleavedRaster: width = 27 height = 25 #numDataElements 4 dataOff[0] = 0
Mon 12/5 17:12:36.553 Premultiplying alpha for BuffImage...
Mon 12/5 17:12:36.553 Creating DirectX9 Texture from memory w=27 h=25
Mon 12/5 17:12:36.553 ImageUtils loading file D:\Program Files\SageTV\SageTV\STVs\SageTV3\down.png
Mon 12/5 17:12:36.583 ImageUtils creating BI copy BufferedImage@6f5bef: type = 0 ColorModel: #pixelBits = 32 numComponents = 4 color space = java.awt.color.ICC_ColorSpace@ec16a4 transparency = 3 has alpha = true isAlphaPre = false ByteInterleavedRaster: width = 26 height = 25 #numDataElements 4 dataOff[0] = 0
Mon 12/5 17:12:36.584 Premultiplying alpha for BuffImage...
Mon 12/5 17:12:36.584 Creating DirectX9 Texture from memory w=26 h=25
Mon 12/5 17:12:36.791 processOptionsMenu optionsMenu=Widget[Show Options for an Airing, Recording, File, etc. id=276600 OptionsMenu Layout=Vertical AnchorX=0.5 AnchorY=0.5 FixedWidth=0.85 PadY=0.01 Insets=0.03 IgnoreThemeProps=true down=[278603,278604,276462,278605,278606,276463,278279,278607,275308,278608,278609,278610,278611,278612,278613,278614,] up=[278615,] context=Context[parent=Context[parent=Context[parent=Context[parent=Context[parent=Context[parent=Context[parent=Context[parent=null map={newNumRows=5, newNumCols=3, newFontSize=18}] map={EPGFontSize=18, NumChannelRows=5, ScheduledRecordings=[Lsage.aa;@166c37e, NumericEntry=, NumChannelCols=3, MaxChannel=158, CurrTimeSpan=1133820000000}] map=null] map={IsLastPage=false, NumCols=2, IsLastVPage=false, IsFirstHPage=false, IsFirstVPage=false, IsFirstPage=false, NumRows=426, NumPages=0, IsLastHPage=false}] map={ChanRow=Channel[stationID=36078, Name=SPIRIT, Network=Cablecast], TableCol=1, TableRow=398, TimeCol=[Ljava.lang.Long;@1acbf5c}] map={Airing=A[215975,17755,"No Data",36078@1205.17:00,120]}] map={MarkIRRecordings=true}] map={AddDetailedInfoOption=true, MediaFile=null, UseBackAfterDelete=false}]
Mon 12/5 17:12:36.889 PM currState=3 wakeupTime=Wed 12/31/1969 19:00:00.000
Mon 12/5 17:12:38.226 PM currState=3 wakeupTime=Wed 12/31/1969 19:00:00.000
Mon 12/5 17:12:38.755 PM currState=3 wakeupTime=Wed 12/31/1969 19:00:00.000
Mon 12/5 17:12:38.855 PM currState=3 wakeupTime=Wed 12/31/1969 19:00:00.000
Mon 12/5 17:12:39.287 PM currState=3 wakeupTime=Wed 12/31/1969 19:00:00.000
Mon 12/5 17:12:39.416 PM currState=3 wakeupTime=Wed 12/31/1969 19:00:00.000
Mon 12/5 17:12:39.544 PM currState=3 wakeupTime=Wed 12/31/1969 19:00:00.000
Mon 12/5 17:12:40.053 PM currState=3 wakeupTime=Wed 12/31/1969 19:00:00.000
Mon 12/5 17:12:40.599 PM currState=3 wakeupTime=Wed 12/31/1969 19:00:00.000
Mon 12/5 17:12:40.750 PM currState=3 wakeupTime=Wed 12/31/1969 19:00:00.000
Mon 12/5 17:12:41.224 PM currState=3 wakeupTime=Wed 12/31/1969 19:00:00.000
Mon 12/5 17:12:41.315 PM currState=3 wakeupTime=Wed 12/31/1969 19:00:00.000
Mon 12/5 17:12:41.752 PM currState=3 wakeupTime=Wed 12/31/1969 19:00:00.000
Mon 12/5 17:12:42.126 PM currState=3 wakeupTime=Wed 12/31/1969 19:00:00.000
Mon 12/5 17:12:42.566 PM currState=3 wakeupTime=Wed 12/31/1969 19:00:00.000
Mon 12/5 17:12:42.686 PM currState=3 wakeupTime=Wed 12/31/1969 19:00:00.000
Mon 12/5 17:12:43.035 PM currState=3 wakeupTime=Wed 12/31/1969 19:00:00.000
Mon 12/5 17:12:43.191 PM currState=3 wakeupTime=Wed 12/31/1969 19:00:00.000
Mon 12/5 17:12:43.522 PM currState=3 wakeupTime=Wed 12/31/1969 19:00:00.000
Mon 12/5 17:12:43.962 PM currState=3 wakeupTime=Wed 12/31/1969 19:00:00.000
Mon 12/5 17:12:44.093 PM currState=3 wakeupTime=Wed 12/31/1969 19:00:00.000
Mon 12/5 17:12:44.331 PM currState=3 wakeupTime=Wed 12/31/1969 19:00:00.000
Mon 12/5 17:12:44.729 PM currState=3 wakeupTime=Wed 12/31/1969 19:00:00.000
Mon 12/5 17:12:44.950 PM currState=3 wakeupTime=Wed 12/31/1969 19:00:00.000
Mon 12/5 17:12:45.018 PM currState=3 wakeupTime=Wed 12/31/1969 19:00:00.000
Mon 12/5 17:12:45.137 PM currState=3 wakeupTime=Wed 12/31/1969 19:00:00.000
Mon 12/5 17:12:46.554 Rendered new font to cache font=java.awt.Font[family=Arial,name=Arial,style=bold,size=10] numGlyphs=1674 numCachedGlyphs=587 numImages=1
Mon 12/5 17:12:46.555 Premultiplying alpha for BuffImage...
Mon 12/5 17:12:46.604 Creating DirectX9 Texture from memory w=256 h=256
Mon 12/5 17:12:47.548 processOptionsMenu optionsMenu=Widget[Show Options for an Airing, Recording, File, etc. id=276600 OptionsMenu Layout=Vertical AnchorX=0.5 AnchorY=0.5 FixedWidth=0.85 PadY=0.01 Insets=0.03 IgnoreThemeProps=true down=[278603,278604,276462,278605,278606,276463,278279,278607,275308,278608,278609,278610,278611,278612,278613,278614,] up=[278615,] context=Context[parent=Context[parent=Context[parent=Context[parent=Context[parent=Context[parent=Context[parent=Context[parent=null map={newNumRows=5, newNumCols=3, newFontSize=18}] map={EPGFontSize=18, NumChannelRows=5, ScheduledRecordings=[Lsage.aa;@166c37e, NumericEntry=, NumChannelCols=3, MaxChannel=158, CurrTimeSpan=1133820000000}] map=null] map={IsLastPage=false, NumCols=2, IsLastVPage=false, IsFirstHPage=false, IsFirstVPage=false, IsFirstPage=false, NumRows=426, NumPages=0, IsLastHPage=false}] map={ChanRow=Channel[stationID=10149, Name=COMEDY, Network=Satellite], TableCol=1, TableRow=20, TimeCol=[Ljava.lang.Long;@997c11}] map={Airing=A[232122,231525,"Police Academy 5: Assignment Miami Beach",10149@1205.16:00,120]}] map={MarkIRRecordings=true}] map={AddDetailedInfoOption=true, MediaFile=null, UseBackAfterDelete=false}]
Mon 12/5 17:12:47.569 PM currState=3 wakeupTime=Wed 12/31/1969 19:00:00.000
Mon 12/5 17:12:47.663 PM currState=3 wakeupTime=Wed 12/31/1969 19:00:00.000
Mon 12/5 17:12:49.457 VideoFrame.watch(A[232122,231525,"Police Academy 5: Assignment Miami Beach",10149@1205.16:00,120])
Mon 12/5 17:12:49.458 watchThisFile=null
Mon 12/5 17:12:49.458 Called Seeker.requestWatch(A[232122,231525,"Police Academy 5: Assignment Miami Beach",10149@1205.16:00,120]) hostname=SAGETV PROCESS VF
Mon 12/5 17:12:49.458 findBestEncoderForNow(A[232122,231525,"Police Academy 5: Assignment Miami Beach",10149@1205.16:00,120] record=false host=SAGETV PROCESS VF)
Mon 12/5 17:12:49.459 foundBestEncoder3=sage.bw$c@1e7d8b1[Hauppauge WinTV PVR PCI II Capture]
Mon 12/5 17:12:49.459 MARK 1 currRecord=A[221089,220717,"Tiny Tots for Jesus",10002@1205.17:00,30] enc=Hauppauge WinTV PVR PCI II Capture clients=[SAGETV PROCESS VF]
Mon 12/5 17:12:49.459 Seeker in AUTOMATIC mode nextRecord=null nextTTA=9223372036854775807
Mon 12/5 17:12:49.459 FORCE WATCH executing clients=[SAGETV PROCESS VF]
Mon 12/5 17:12:49.460 newRecord=A[232122,231525,"Police Academy 5: Assignment Miami Beach",10149@1205.16:00,120]
Mon 12/5 17:12:49.460 Change in record, logging recorded data.
Mon 12/5 17:12:49.460 Seeker.endRecord(Mon 12/5 17:12:49.459) currRecord=A[221089,220717,"Tiny Tots for Jesus",10002@1205.17:00,30]
Mon 12/5 17:12:49.460 VF.submitJob(VFJob[InactiveFile r=0.0 t=0 file=null ifn=D:\tv recordings\TinyTotsforJesus-221089-0.mpg])
Mon 12/5 17:12:49.461 VF processing job VFJob[InactiveFile r=0.0 t=0 file=null ifn=D:\tv recordings\TinyTotsforJesus-221089-0.mpg] nPlayin=true
Mon 12/5 17:12:49.461 VF processing on UI Thread VFJob[InactiveFile r=0.0 t=0 file=null ifn=D:\tv recordings\TinyTotsforJesus-221089-0.mpg]
Mon 12/5 17:12:49.461 Change in record to another show. Entering device record mode. - LATER
Mon 12/5 17:12:49.461 Change in record to another show. Entering device record mode. - NOW
Mon 12/5 17:12:49.462 Seeker.startRecord(Hauppauge WinTV PVR PCI II Capture A[232122,231525,"Police Academy 5: Assignment Miami Beach",10149@1205.16:00,120], currTime=Mon 12/5 17:12:49.459) currRecord=null switch=true
Mon 12/5 17:12:49.462 Setting up MMC video for recording new show & tuning channel conn=Hauppauge WinTV PVR PCI II Capture TV Tuner
Mon 12/5 17:12:49.462 VideoStorage for new file: D:\tv recordings - Leave Free 2.0 GB
Mon 12/5 17:12:49.463 VF notified of Inactive File
Mon 12/5 17:12:49.463 VF processing job null nPlayin=true
Mon 12/5 17:12:49.472 MediaFile created subfile:D:\tv recordings\PoliceAcademy5AssignmentMiamiBeach-232122-0.mpg MediaFile[id=294069 A[232122,231525,"Police Academy 5: Assignment Miami Beach",10149@1205.16:00,120] host=desktop encodedBy=Hauppauge WinTV PVR PCI II Capture Great]
Mon 12/5 17:12:49.472 isRec=false rd=21717 base=18407
Mon 12/5 17:12:49.472 VF thread is now waiting for 0:00:03.060
Mon 12/5 17:12:49.475 Added:MediaFile[id=294069 A[232122,231525,"Police Academy 5: Assignment Miami Beach",10149@1205.16:00,120] host=desktop encodedBy=Hauppauge WinTV PVR PCI II Capture Great D:\tv recordings\PoliceAcademy5AssignmentMiamiBeach-232122-0.mpg, Seg0[Mon 12/5 17:12:49.471-Wed 12/31 19:00:00.000]]
Mon 12/5 17:12:49.487 PM currState=3 wakeupTime=Wed 12/31/1969 19:00:00.000
Mon 12/5 17:12:49.488 Seeker channel string=107
Mon 12/5 17:12:49.488 autotune0 70996552 hr=0x0 num=107
Mon 12/5 17:12:50.086 DONE: autotune0 70996552 hr=0x1 result=0
Mon 12/5 17:12:50.097 switchOutputFile0 called
Mon 12/5 17:12:50.097 Switching Encoding to file D:\tv recordings\PoliceAcademy5AssignmentMiamiBeach-232122-0.mpg
Mon 12/5 17:12:50.098 VF processing job null nPlayin=true
Mon 12/5 17:12:50.099 isRec=false rd=21717 base=19035
Mon 12/5 17:12:50.099 VF thread is now waiting for 0:00:02.432
Mon 12/5 17:12:50.100 VF.submitJob(VFJob[WatchMF r=0.0 t=0 file=MediaFile[id=294069 A[232122,231525,"Police Academy 5: Assignment Miami Beach",10149@1205.16:00,120] host=desktop encodedBy=Hauppauge WinTV PVR PCI II Capture Great D:\tv recordings\PoliceAcademy5AssignmentMiamiBeach-232122-0.mpg, Seg0[Mon 12/5 17:12:49.471-Wed 12/31 19:00:00.000]] ifn=null])
Mon 12/5 17:12:50.100 VF processing job VFJob[WatchMF r=0.0 t=0 file=MediaFile[id=294069 A[232122,231525,"Police Academy 5: Assignment Miami Beach",10149@1205.16:00,120] host=desktop encodedBy=Hauppauge WinTV PVR PCI II Capture Great D:\tv recordings\PoliceAcademy5AssignmentMiamiBeach-232122-0.mpg, Seg0[Mon 12/5 17:12:49.471-Wed 12/31 19:00:00.000]] ifn=null] nPlayin=true
Mon 12/5 17:12:50.101 VF processing on UI Thread VFJob[WatchMF r=0.0 t=0 file=MediaFile[id=294069 A[232122,231525,"Police Academy 5: Assignment Miami Beach",10149@1205.16:00,120] host=desktop encodedBy=Hauppauge WinTV PVR PCI II Capture Great D:\tv recordings\PoliceAcademy5AssignmentMiamiBeach-232122-0.mpg, Seg0[Mon 12/5 17:12:49.471-Wed 12/31 19:00:00.000]] ifn=null]
Mon 12/5 17:12:50.102 Added:Watched[id=294133 Airing=A[221089,220717,"Tiny Tots for Jesus",10002@1205.17:00,30], WatchStart=Mon 12/5 17:12:27.742, WatchEnd=Mon 12/5 17:12:46.779, RealStart=Mon 12/5 17:12:30.217, RealEnd=Mon 12/5 17:12:50.101]
Mon 12/5 17:12:50.102 VF logFileWatch doneAir=A[221089,220717,"Tiny Tots for Jesus",10002@1205.17:00,30]A[221089,220717,"Tiny Tots for Jesus",10002@1205.17:00,30] theTime=Mon 12/5 17:12:46.779 recTime=Mon 12/5 17:12:27.742
Mon 12/5 17:12:50.103 Stopping the playback graph.
Mon 12/5 17:12:50.104 setUI(sage.bo@1d451d2[MediaPlayer OSD]) histIdx=3 uiHistory=[sage.bo@1d394ab[Main Menu], sage.bo@1d451d2[MediaPlayer OSD], sage.bo@1f72465[LiveTVGuide w/ Optional Preview], sage.bo@1d451d2[MediaPlayer OSD]]
Mon 12/5 17:12:50.148 VF processing job VFJob[LoadMF r=0.0 t=0 file=MediaFile[id=294069 A[232122,231525,"Police Academy 5: Assignment Miami Beach",10149@1205.16:00,120] host=desktop encodedBy=Hauppauge WinTV PVR PCI II Capture Great D:\tv recordings\PoliceAcademy5AssignmentMiamiBeach-232122-0.mpg, Seg0[Mon 12/5 17:12:49.471-Wed 12/31 19:00:00.000]] ifn=null] nPlayin=false
Mon 12/5 17:12:50.149 VF network encoder playback detected: false
Mon 12/5 17:12:50.149 VF waiting for data to appear in new file...liveWait=-678
Mon 12/5 17:12:50.149 VF thread is now waiting for 0:00:00.200
Mon 12/5 17:12:50.353 VF processing job VFJob[LoadMF r=0.0 t=0 file=MediaFile[id=294069 A[232122,231525,"Police Academy 5: Assignment Miami Beach",10149@1205.16:00,120] host=desktop encodedBy=Hauppauge WinTV PVR PCI II Capture Great D:\tv recordings\PoliceAcademy5AssignmentMiamiBeach-232122-0.mpg, Seg0[Mon 12/5 17:12:49.471-Wed 12/31 19:00:00.000]] ifn=null] nPlayin=false
Mon 12/5 17:12:50.353 VF network encoder playback detected: false
Mon 12/5 17:12:50.354 VF waiting for data to appear in new file...liveWait=-882
Mon 12/5 17:12:50.354 VF thread is now waiting for 0:00:00.200
Mon 12/5 17:12:50.357 Scheduler awoken
Mon 12/5 17:12:50.359 Scheduler.updateSchedule() called time=Mon 12/5 17:12:50.358 manual=[] schedules={Hauppauge WinTV PVR PCI II Capture=[Sched=[A[221089,220717,"Tiny Tots for Jesus",10002@1205.17:00,30]] MustSee=[]]} scheduleRandSize=0
Mon 12/5 17:12:50.359 # Airs=0
Mon 12/5 17:12:50.359 MUST SEE FINAL-Hauppauge WinTV PVR PCI II Capture-[]
Mon 12/5 17:12:50.360 Scheduler cleanup - Removing A[221089,220717,"Tiny Tots for Jesus",10002@1205.17:00,30] from schedule because it has no WP.
Mon 12/5 17:12:50.360 Evaluating Potentials
Mon 12/5 17:12:50.360 COMPLETE SCHEDULE-----**&^%&*-------COMPLETE SCHEDULE
Hauppauge WinTV PVR PCI II Capture
Mon 12/5 17:12:50.361 [A[232122,231525,"Police Academy 5: Assignment Miami Beach",10149@1205.16:00,120]]
Mon 12/5 17:12:50.361 Seeker awoken
Mon 12/5 17:12:50.362 MARK 1 currRecord=A[232122,231525,"Police Academy 5: Assignment Miami Beach",10149@1205.16:00,120] enc=Hauppauge WinTV PVR PCI II Capture clients=[SAGETV PROCESS VF]
Mon 12/5 17:12:50.362 Seeker in AUTOMATIC mode nextRecord=null nextTTA=9223372036854775807
Mon 12/5 17:12:50.362 FORCE WATCH abandoned because it's currently being recorded clients=[SAGETV PROCESS VF]
Mon 12/5 17:12:50.362 newRecord=A[232122,231525,"Police Academy 5: Assignment Miami Beach",10149@1205.16:00,120]
Mon 12/5 17:12:50.362 Keeping record just the way it is.
Mon 12/5 17:12:50.363 RootFile=D:\ fstype=NTFS fileLength=0
Mon 12/5 17:12:50.375 VF processing job VFJob[LoadMF r=0.0 t=0 file=MediaFile[id=294069 A[232122,231525,"Police Academy 5: Assignment Miami Beach",10149@1205.16:00,120] host=desktop encodedBy=Hauppauge WinTV PVR PCI II Capture Great D:\tv recordings\PoliceAcademy5AssignmentMiamiBeach-232122-0.mpg, Seg0[Mon 12/5 17:12:49.471-Wed 12/31 19:00:00.000]] ifn=null] nPlayin=false
Mon 12/5 17:12:50.375 VF network encoder playback detected: false
Mon 12/5 17:12:50.397 VF waiting for data to appear in new file...liveWait=-925
Mon 12/5 17:12:50.400 VF thread is now waiting for 0:00:00.200
Mon 12/5 17:12:50.403 Seeker clearing unwanted and partial files...
Mon 12/5 17:12:50.403 needFreeSize = 0.4941 GB currFreeSize=6.515956736 GB
Mon 12/5 17:12:50.404 Seeker waiting for 47 mins.
Mon 12/5 17:12:50.600 VF processing job VFJob[LoadMF r=0.0 t=0 file=MediaFile[id=294069 A[232122,231525,"Police Academy 5: Assignment Miami Beach",10149@1205.16:00,120] host=desktop encodedBy=Hauppauge WinTV PVR PCI II Capture Great D:\tv recordings\PoliceAcademy5AssignmentMiamiBeach-232122-0.mpg, Seg0[Mon 12/5 17:12:49.471-Wed 12/31 19:00:00.000]] ifn=null] nPlayin=false
Mon 12/5 17:12:50.600 VF network encoder playback detected: false
Mon 12/5 17:12:50.601 VF waiting for data to appear in new file...liveWait=-1129
Mon 12/5 17:12:50.601 VF thread is now waiting for 0:00:00.200
Mon 12/5 17:12:50.801 VF processing job VFJob[LoadMF r=0.0 t=0 file=MediaFile[id=294069 A[232122,231525,"Police Academy 5: Assignment Miami Beach",10149@1205.16:00,120] host=desktop encodedBy=Hauppauge WinTV PVR PCI II Capture Great D:\tv recordings\PoliceAcademy5AssignmentMiamiBeach-232122-0.mpg, Seg0[Mon 12/5 17:12:49.471-Wed 12/31 19:00:00.000]] ifn=null] nPlayin=false
Mon 12/5 17:12:50.801 VF network encoder playback detected: false
Mon 12/5 17:12:50.802 VF waiting for data to appear in new file...liveWait=-1331
Mon 12/5 17:12:50.802 VF thread is now waiting for 0:00:00.200
Mon 12/5 17:12:51.002 VF processing job VFJob[LoadMF r=0.0 t=0 file=MediaFile[id=294069 A[232122,231525,"Police Academy 5: Assignment Miami Beach",10149@1205.16:00,120] host=desktop encodedBy=Hauppauge WinTV PVR PCI II Capture Great D:\tv recordings\PoliceAcademy5AssignmentMiamiBeach-232122-0.mpg, Seg0[Mon 12/5 17:12:49.471-Wed 12/31 19:00:00.000]] ifn=null] nPlayin=false
Mon 12/5 17:12:51.003 VF network encoder playback detected: false
Mon 12/5 17:12:51.003 VF waiting for data to appear in new file...liveWait=-1532
Mon 12/5 17:12:51.003 VF thread is now waiting for 0:00:00.200
Mon 12/5 17:12:51.203 VF processing job VFJob[LoadMF r=0.0 t=0 file=MediaFile[id=294069 A[232122,231525,"Police Academy 5: Assignment Miami Beach",10149@1205.16:00,120] host=desktop encodedBy=Hauppauge WinTV PVR PCI II Capture Great D:\tv recordings\PoliceAcademy5AssignmentMiamiBeach-232122-0.mpg, Seg0[Mon 12/5 17:12:49.471-Wed 12/31 19:00:00.000]] ifn=null] nPlayin=false
Mon 12/5 17:12:51.204 VF network encoder playback detected: false
Mon 12/5 17:12:51.204 VF waiting for data to appear in new file...liveWait=-1733
Mon 12/5 17:12:51.204 VF thread is now waiting for 0:00:00.200
Mon 12/5 17:12:51.405 VF processing job VFJob[LoadMF r=0.0 t=0 file=MediaFile[id=294069 A[232122,231525,"Police Academy 5: Assignment Miami Beach",10149@1205.16:00,120] host=desktop encodedBy=Hauppauge WinTV PVR PCI II Capture Great D:\tv recordings\PoliceAcademy5AssignmentMiamiBeach-232122-0.mpg, Seg0[Mon 12/5 17:12:49.471-Wed 12/31 19:00:00.000]] ifn=null] nPlayin=false
Mon 12/5 17:12:51.405 VF network encoder playback detected: false
Mon 12/5 17:12:51.405 VF waiting for data to appear in new file...liveWait=-1934
Mon 12/5 17:12:51.405 VF thread is now waiting for 0:00:00.200
Mon 12/5 17:12:51.606 VF processing job VFJob[LoadMF r=0.0 t=0 file=MediaFile[id=294069 A[232122,231525,"Police Academy 5: Assignment Miami Beach",10149@1205.16:00,120] host=desktop encodedBy=Hauppauge WinTV PVR PCI II Capture Great D:\tv recordings\PoliceAcademy5AssignmentMiamiBeach-232122-0.mpg, Seg0[Mon 12/5 17:12:49.471-Wed 12/31 19:00:00.000]] ifn=null] nPlayin=false
Mon 12/5 17:12:51.607 VF network encoder playback detected: false
Mon 12/5 17:12:51.615 VF processing on UI Thread VFJob[LoadMF r=0.0 t=0 file=MediaFile[id=294069 A[232122,231525,"Police Academy 5: Assignment Miami Beach",10149@1205.16:00,120] host=desktop encodedBy=Hauppauge WinTV PVR PCI II Capture Great D:\tv recordings\PoliceAcademy5AssignmentMiamiBeach-232122-0.mpg, Seg0[Mon 12/5 17:12:49.471-Wed 12/31 19:00:00.000]] ifn=null]
Mon 12/5 17:12:51.615 VF file=MediaFile[id=294069 A[232122,231525,"Police Academy 5: Assignment Miami Beach",10149@1205.16:00,120] host=desktop encodedBy=Hauppauge WinTV PVR PCI II Capture Great D:\tv recordings\PoliceAcademy5AssignmentMiamiBeach-232122-0.mpg, Seg0[Mon 12/5 17:12:49.471-Wed 12/31 19:00:00.000]] targetTime = Mon 12/5 17:12:49.471
Mon 12/5 17:12:51.616 VideoFrame.timeSelected(Mon 12/5 17:12:49.471, true) currFile=MediaFile[id=294069 A[232122,231525,"Police Academy 5: Assignment Miami Beach",10149@1205.16:00,120] host=desktop encodedBy=Hauppauge WinTV PVR PCI II Capture Great D:\tv recordings\PoliceAcademy5AssignmentMiamiBeach-232122-0.mpg, Seg0[Mon 12/5 17:12:49.471-Wed 12/31 19:00:00.000]]
Mon 12/5 17:12:51.616 DShowPlayer setTimeshift=1 buffer=0
Mon 12/5 17:12:51.616 NATIVE Loading the source file
Mon 12/5 17:12:51.617 About to perform media time selection for 0
Mon 12/5 17:12:51.617 Did Media Time Select Millis 0
Mon 12/5 17:12:51.617 Pausing the playback graph.
Mon 12/5 17:12:51.661 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null])
Mon 12/5 17:12:51.662 VideoFrame.timeSelected2(Mon 12/5 17:12:49.471, true) currFile=MediaFile[id=294069 A[232122,231525,"Police Academy 5: Assignment Miami Beach",10149@1205.16:00,120] host=desktop encodedBy=Hauppauge WinTV PVR PCI II Capture Great D:\tv recordings\PoliceAcademy5AssignmentMiamiBeach-232122-0.mpg, Seg0[Mon 12/5 17:12:49.471-Wed 12/31 19:00:00.000]] realDur=0
Mon 12/5 17:12:51.662 About to perform media time selection for 0
Mon 12/5 17:12:51.885 Did Media Time Select Millis 0
Mon 12/5 17:12:51.885 Running the playback graph.
Mon 12/5 17:12:51.909 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null])
Mon 12/5 17:12:51.957 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true
Mon 12/5 17:12:51.958 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null]
Mon 12/5 17:12:51.958 DShowMediaPlayer is consuming the events...
Mon 12/5 17:12:51.958 Event: 0xe
Mon 12/5 17:12:51.958 Event: 0xe
Mon 12/5 17:12:51.962 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true
Mon 12/5 17:12:51.963 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null]
Mon 12/5 17:12:51.963 DShowMediaPlayer is consuming the events...
Mon 12/5 17:12:51.963 VF processing job null nPlayin=true
Mon 12/5 17:12:51.963 isRec=true rd=2492 base=14
Mon 12/5 17:12:51.964 VF thread is now waiting for 0:47:10.265
Mon 12/5 17:12:56.017 Removed system shell hook
Mon 12/5 17:12:56.017 Sage.exit() called.
Mon 12/5 17:12:56.018 Cleaning up servers
Mon 12/5 17:12:56.023 Cleaning up PM
Mon 12/5 17:12:56.028 PM currState=3 wakeupTime=Wed 12/31/1969 19:00:00.000
Mon 12/5 17:12:56.028 Enabled SS
Mon 12/5 17:12:56.031 Killed Carny.
Mon 12/5 17:12:56.032 Killed Scheduler.
Mon 12/5 17:12:56.032 VF logFileWatch doneAir=A[232122,231525,"Police Academy 5: Assignment Miami Beach",10149@1205.16:00,120]A[232122,231525,"Police Academy 5: Assignment Miami Beach",10149@1205.16:00,120] theTime=Mon 12/5 17:12:53.491 recTime=Mon 12/5 17:12:49.471
Mon 12/5 17:12:56.033 Stopping the playback graph.
Mon 12/5 17:12:56.094 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null])
Mon 12/5 17:12:56.094 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=false
Mon 12/5 17:12:56.095 Tearing down playback graph
Mon 12/5 17:12:56.095 NATIVE Deallocating the CPlayerData object
Mon 12/5 17:12:56.113 NATIVE Finished destroying the playback graph
Mon 12/5 17:12:56.114 Ministry is shutting down....destroying the converts in progress
Mon 12/5 17:12:56.114 Seeker.endRecord(Mon 12/5 17:12:56.114) currRecord=A[232122,231525,"Police Academy 5: Assignment Miami Beach",10149@1205.16:00,120]
Mon 12/5 17:12:56.115 VF.submitJob(VFJob[InactiveFile r=0.0 t=0 file=null ifn=D:\tv recordings\PoliceAcademy5AssignmentMiamiBeach-232122-0.mpg])
Mon 12/5 17:12:56.115 stopEncoding0 called
Mon 12/5 17:12:56.152 Stopped graph res=0x0
Mon 12/5 17:12:56.523 Killed Seeker.
Mon 12/5 17:12:56.523 Killed EPG.
Mon 12/5 17:12:56.550 stopEncoding0 called
Mon 12/5 17:12:56.552 Stopped graph res=0x0
Mon 12/5 17:12:56.553 teardownGraph0 called for device=Hauppauge WinTV PVR PCI II Capture
Mon 12/5 17:12:56.675 Killed MMC.
Mon 12/5 17:12:56.676 Killed Studio
Mon 12/5 17:12:56.951 ERROR Updating EPG Source DISH Washington - Washington
Mon 12/5 17:12:56.952 ErrorText:expand called on DISH Washington - Washington at Mon 12/5 17:12:22.347 expandedUntil=Mon 12/5 17:11:11.330 confirmedUntil=Wed 12/31 19:00:00.000
EPG Expanding DISH Washington - Washington at Mon 12/5 17:12:22.347

Mon 12/5 17:12:57.014 MetaImage clearNativeCache nativeImageCacheSize=4374016
Mon 12/5 17:12:57.015 Cleaning up DirectX9
Mon 12/5 17:12:57.016 Doing full DX9 cleanup.
Mon 12/5 17:12:57.019 Done cleaning up DirectX9
Mon 12/5 17:12:57.285 AWTThread Hang Detected - hang time = 750
Mon 12/5 17:12:58.035 AWTThread Hang Detected - hang time = 1500
Mon 12/5 17:12:58.676 Killed RootPanel
Mon 12/5 17:12:58.693 Disposed Window
Mon 12/5 17:12:58.694 Killed UIManager.
Mon 12/5 17:12:58.713 Killed Wizard.
Mon 12/5 17:12:58.724 Bye-bye.
Mon 12/5 17:12:58.728 SageTV SHUTDOWN is activating!