Thu 5/4 7:58:54.547 user.dir2=C:\Program Files\SageTV\SageTV Thu 5/4 7:58:54.561 classpath=C:\Program Files\SageTV\SageTV\Sage.jar;C:\Program Files\SageTV\SageTV\xerces.jar;C:\Program Files\SageTV\SageTV\plugin.jar;C:\Program Files\SageTV\SageTV\;;JARs\commons-jxpath-1.1.jar;JARs\commons-logging-api.jar;JARs\commons-logging.jar;JARs\jcifs-1.1.6.jar;JARs\jdic.jar;JARs\mx4j-impl.jar;JARs\mx4j-jmx.jar;JARs\mx4j-remote.jar;JARs\mx4j-tools.jar;JARs\sbbi-jmx-1.0.jar;JARs\sbbi-upnplib-1.0.3.jar Thu 5/4 7:58:54.562 JVM version=1.5.0_06 Thu 5/4 7:58:54.563 OS=Windows XP 5.1 Thu 5/4 7:58:54.577 Succesfully setup system shell hook Thu 5/4 7:58:54.578 not specifiy WinkeyboardHook in registery, load default one Thu 5/4 7:58:55.695 ImageUtils loading URL jar:file:/C:/Program%20Files/SageTV/SageTV/Sage.jar!/images/splash.gif Thu 5/4 7:58:55.728 ImageUtils creating BI copy sun.awt.image.ToolkitImage@86f241 Thu 5/4 7:58:55.841 SageTV V5.0.2.90 Thu 5/4 7:58:55.909 hostname=sage-pvr Thu 5/4 7:58:56.189 ImageUtils loading URL jar:file:/C:/Program%20Files/SageTV/SageTV/Sage.jar!/images/tvicon.gif Thu 5/4 7:58:56.192 ImageUtils creating BI copy sun.awt.image.ToolkitImage@a3bcc1 Thu 5/4 7:58:56.408 ImageUtils loading URL jar:file:/C:/Program%20Files/SageTV/SageTV/Sage.jar!/images/tvicon_anim0.gif Thu 5/4 7:58:56.410 ImageUtils creating BI copy sun.awt.image.ToolkitImage@9fef6f Thu 5/4 7:58:56.412 ImageUtils loading URL jar:file:/C:/Program%20Files/SageTV/SageTV/Sage.jar!/images/tvicon_anim1.gif Thu 5/4 7:58:56.427 ImageUtils creating BI copy sun.awt.image.ToolkitImage@17172ea Thu 5/4 7:58:56.429 ImageUtils loading URL jar:file:/C:/Program%20Files/SageTV/SageTV/Sage.jar!/images/tvicon_anim2.gif Thu 5/4 7:58:56.432 ImageUtils creating BI copy sun.awt.image.ToolkitImage@4b222f Thu 5/4 7:58:56.433 ImageUtils loading URL jar:file:/C:/Program%20Files/SageTV/SageTV/Sage.jar!/images/tvicon_anim3.gif Thu 5/4 7:58:56.436 ImageUtils creating BI copy sun.awt.image.ToolkitImage@7a78d3 Thu 5/4 7:58:56.588 Wizard starting to load database info... Thu 5/4 7:58:56.590 Wizard DONE loading database info. loadTime=0.0020 sec Thu 5/4 7:58:56.916 SageTV received connection from:Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 7:58:58.427 Received command of:PROPERTY_SYNC 280 from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 7:58:58.600 Received command of:WIZARD_SYNC from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 7:58:58.603 Wizard allocating table for Year of size 87 Thu 5/4 7:58:58.604 Wizard loading main index for Year Thu 5/4 7:58:58.606 Wizard allocating table for Network of size 25 Thu 5/4 7:58:58.607 Wizard loading main index for Network Thu 5/4 7:58:58.618 Wizard allocating table for Title of size 8038 Thu 5/4 7:58:58.619 Wizard loading main index for Title Thu 5/4 7:58:58.870 Wizard building alt. index 0 for Title Thu 5/4 7:58:58.900 Wizard allocating table for Channel of size 306 Thu 5/4 7:58:58.901 Wizard loading main index for Channel Thu 5/4 7:58:58.959 Wizard allocating table for People of size 31792 Thu 5/4 7:58:58.960 Wizard loading main index for People Thu 5/4 7:58:59.780 Wizard building alt. index 0 for People Thu 5/4 7:58:59.940 Wizard allocating table for SubCategory of size 129 Thu 5/4 7:58:59.941 Wizard loading main index for SubCategory Thu 5/4 7:58:59.943 Wizard allocating table for Rated of size 7 Thu 5/4 7:58:59.943 Wizard loading main index for Rated Thu 5/4 7:58:59.944 Wizard allocating table for ParentalRating of size 0 Thu 5/4 7:58:59.944 Wizard allocating table for ExtendedRating of size 10 Thu 5/4 7:58:59.945 Wizard loading main index for ExtendedRating Thu 5/4 7:58:59.945 Wizard allocating table for Category of size 95 Thu 5/4 7:58:59.946 Wizard loading main index for Category Thu 5/4 7:58:59.947 Wizard allocating table for PrimeTitle of size 0 Thu 5/4 7:58:59.948 Wizard allocating table for Bonus of size 585 Thu 5/4 7:58:59.948 Wizard loading main index for Bonus Thu 5/4 7:58:59.996 Wizard allocating table for Show of size 22634 Thu 5/4 7:58:59.997 Wizard loading main index for Show Thu 5/4 7:59:05.477 Wizard building alt. index 0 for Show Thu 5/4 7:59:05.571 Wizard allocating table for Airing of size 73024 Thu 5/4 7:59:05.586 Wizard loading main index for Airing Thu 5/4 7:59:08.313 Wizard building alt. index 0 for Airing Thu 5/4 7:59:08.411 Wizard building alt. index 1 for Airing Thu 5/4 7:59:08.526 Wizard allocating table for ManualRecord of size 119 Thu 5/4 7:59:08.528 Wizard loading main index for ManualRecord Thu 5/4 7:59:08.577 Wizard allocating table for MediaFile of size 166 Thu 5/4 7:59:08.577 Wizard loading main index for MediaFile Thu 5/4 7:59:08.600 Wizard building alt. index 0 for MediaFile Thu 5/4 7:59:08.601 Wizard allocating table for Watched of size 3660 Thu 5/4 7:59:08.602 Wizard loading main index for Watched Thu 5/4 7:59:08.833 Wizard building alt. index 0 for Watched Thu 5/4 7:59:08.838 Wizard allocating table for Agent of size 1196 Thu 5/4 7:59:08.839 Wizard loading main index for Agent Thu 5/4 7:59:08.935 Wizard building alt. index 0 for Agent Thu 5/4 7:59:08.942 Wizard allocating table for Wasted of size 135 Thu 5/4 7:59:08.942 Wizard loading main index for Wasted Thu 5/4 7:59:08.944 Wizard allocating table for Playlist of size 2 Thu 5/4 7:59:08.944 Wizard loading main index for Playlist Thu 5/4 7:59:09.046 Received command of:CARNY_SYNC_CAUSEMAP 7217 from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 7:59:09.189 Received command of:CARNY_SYNC_WPMAP 7023 from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 7:59:09.742 Received command of:CARNY_SYNC_MUSTSEE 0 from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 7:59:09.743 Received command of:CARNY_SYNC_LOVE 0 from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 7:59:09.749 SageTV received connection from:Socket[addr=/127.0.0.1,port=42024,localport=1097] Thu 5/4 7:59:10.580 MMC calling detectCaptureDevices on sage.o@197507c Thu 5/4 7:59:10.608 devices detected=[Hauppauge WinTV PVR PCI II Capture #2, Hauppauge WinTV PVR PCI II Capture] Thu 5/4 7:59:10.609 EncoderMap={Hauppauge WinTV PVR PCI II Capture #2=Hauppauge WinTV PVR PCI II Capture #2, Hauppauge WinTV PVR PCI II Capture=Hauppauge WinTV PVR PCI II Capture} Thu 5/4 7:59:12.030 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, Bitmap Generate, Color Space Converter, Deinterlace Filter, Dib Output, Dib Receive, DV Muxer, DV Scenes, DV Source Filter, DV Splitter, DV V/A ACM Source Filter, DV V/A Source Filter, DV Video Decoder, DV Video Source Filter, 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, Hauppauge WinTV File Reader, Hauppauge WinTV File Writer, Hauppauge WinTV MPEG Splitter, Hauppauge WinTV SnapShot, Indeo® audio software, Indeo® video 4.4 Compression Filter, Indeo® video 4.4 Decompression Filter, Indeo® video 5.10 Compression Filter, Indeo® video 5.10 Decompression Filter, Infinite Pin Tee Filter, Internal Script Command Renderer, InterVideo NonCSS Audio Decoder for Hauppauge, InterVideo NonCSS Video Decoder for Hauppauge, IVF source filter, 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, Nero Audio CD Filter, Nero Audio CD Navigator, Nero Audio Processor, Nero Audio Sample Renderer, Nero Audio Stream Renderer, Nero Digital Audio Decoder, Nero Digital AVC Audio Encoder, Nero Digital AVC File Writer, Nero Digital AVC Muxer, Nero Digital AVC Null Renderer, Nero Digital AVC Subpicture Enc, Nero Digital AVC Video Enc, Nero Digital Parser, Nero DV Splitter, Nero DVD Decoder, Nero DVD Navigator, Nero ES Video Reader, Nero File Source, Nero File Source (Async.), Nero File Source / Splitter, Nero Format Converter, Nero Frame Capture, Nero InteractiveGraphics Decoder, Nero Mpeg2 Encoder, Nero Overlay Mixer, Nero Photo Source, Nero PresentationGraphics Decoder, Nero PS Muxer, Nero QuickTime(tm) Audio Decoder, Nero QuickTime(tm) Video Decoder, Nero Resize, Nero Scene Detector, Nero Scene Detector 2, Nero Splitter, Nero Stream Buffer Sink, Nero Stream Buffer Source, Nero Subpicture Decoder, Nero Vcd Navigator, Nero Video Analyzer, Nero Video Decoder, Nero Video Decoder HD, Nero Video Processor, Nero Video Sample Renderer, Nero Video Stream Renderer, NSC file Parser, Null Renderer, NVIDIA ATSC File, NVIDIA Audio Decoder, NVIDIA Cd Audio Reader, NVIDIA MultiSource Filter, NVIDIA Navigator, NVIDIA Transport Demux, NVIDIA TS Info Parser, NVIDIA Video Decoder, NVIDIA Video Post Processor, 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, Ulead AC3 Audio Decoder 2, ULead File Source (Async.), ULead Infinite Pin Tee, Ulead MPEG Audio Decoder, Ulead MPEG Encoder, Ulead MPEG Muxer, Ulead MPEG Splitter, Ulead MPEG Video Decoder, Ulead Video Deinterlace Filter, 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] Thu 5/4 7:59:12.850 sage.aw@1540a77 needs an update in 9:34:39 Thu 5/4 7:59:12.851 EPG needs an update in 574 minutes Thu 5/4 7:59:12.893 MsgSend thread spawned for /127.0.0.1:42024 Thu 5/4 7:59:12.893 VF thread is now running... Thu 5/4 7:59:12.893 MsgRecv thread has spawned for /127.0.0.1:42024 Thu 5/4 7:59:12.894 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 7:59:12.894 UIMgr loading UI from: C:\Program Files\SageTV\SageTV\STVs\SageTV3\SageTV3-2.xml Thu 5/4 7:59:12.904 EPG's works is done. Waiting... Thu 5/4 7:59:12.904 StorageDeviceDetector started... Thu 5/4 7:59:12.919 VF thread is now waiting for 0:00:00.000 Thu 5/4 7:59:13.986 AWTThread Hang Detected - hang time = 795 Thu 5/4 7:59:14.490 locale = en Thu 5/4 7:59:14.767 AWTThread Hang Detected - hang time = 1576 Thu 5/4 7:59:15.527 AWTThread Hang Detected - hang time = 2336 Thu 5/4 7:59:15.733 DatePat=EEE, MMM d orgPat=EEEE, MMMM d, yyyy Thu 5/4 7:59:15.776 setUI(sage.bz@6f956[Main Menu]) histIdx=0 uiHistory=[sage.bz@6f956[Main Menu]] Thu 5/4 7:59:16.491 VideoFrame.watch(A[1182810,646857,"The Plague",14771@0504.07:00,120]) Thu 5/4 7:59:16.517 watchThisFile=null Thu 5/4 7:59:16.519 Sending requestWatch to server for A[1182810,646857,"The Plague",14771@0504.07:00,120] Thu 5/4 7:59:16.546 Received command of:WIZARD_SYNC from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 7:59:16.552 Received command of:WIZARD_SYNC from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 7:59:17.041 Received command of:PROPERTY_SYNC 1 from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 7:59:17.085 Rendered new font to cache font=java.awt.Font[family=Arial,name=Arial,style=bold,size=17] numGlyphs=1674 numCachedGlyphs=261 numImages=1 Thu 5/4 7:59:17.487 VF.submitJob(VFJob[WatchMF r=0.0 t=0 file=MediaFile[id=1308911 A[1182810,646857,"The Plague",14771@0504.07:00,120] host=sage-pvr encodedBy=Hauppauge WinTV PVR PCI II Capture #2 Good E:\Record\ThePlague-1182810-0.mpg, Seg0[Thu 5/4 7:59:16.441-Wed 12/31 18:00:00.000]] ifn=null]) Thu 5/4 7:59:17.549 VF processing job VFJob[WatchMF r=0.0 t=0 file=MediaFile[id=1308911 A[1182810,646857,"The Plague",14771@0504.07:00,120] host=sage-pvr encodedBy=Hauppauge WinTV PVR PCI II Capture #2 Good E:\Record\ThePlague-1182810-0.mpg, Seg0[Thu 5/4 7:59:16.441-Wed 12/31 18:00:00.000]] ifn=null] nPlayin=false Thu 5/4 7:59:18.352 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 7:59:18.364 VF processing on UI Thread VFJob[WatchMF r=0.0 t=0 file=MediaFile[id=1308911 A[1182810,646857,"The Plague",14771@0504.07:00,120] host=sage-pvr encodedBy=Hauppauge WinTV PVR PCI II Capture #2 Good E:\Record\ThePlague-1182810-0.mpg, Seg0[Thu 5/4 7:59:16.441-Wed 12/31 18:00:00.000]] ifn=null] Thu 5/4 7:59:18.366 VF digital TV playback detected: false Thu 5/4 7:59:18.367 VideoFrame creating new media player for file:MediaFile[id=1308911 A[1182810,646857,"The Plague",14771@0504.07:00,120] host=sage-pvr encodedBy=Hauppauge WinTV PVR PCI II Capture #2 Good E:\Record\ThePlague-1182810-0.mpg, Seg0[Thu 5/4 7:59:16.441-Wed 12/31 18:00:00.000]] Thu 5/4 7:59:18.372 VF processing job VFJob[LoadMF r=0.0 t=0 file=MediaFile[id=1308911 A[1182810,646857,"The Plague",14771@0504.07:00,120] host=sage-pvr encodedBy=Hauppauge WinTV PVR PCI II Capture #2 Good E:\Record\ThePlague-1182810-0.mpg, Seg0[Thu 5/4 7:59:16.441-Wed 12/31 18:00:00.000]] ifn=null] nPlayin=false Thu 5/4 7:59:18.372 VF network encoder playback detected: false Thu 5/4 7:59:18.407 VF processing on UI Thread VFJob[LoadMF r=0.0 t=0 file=MediaFile[id=1308911 A[1182810,646857,"The Plague",14771@0504.07:00,120] host=sage-pvr encodedBy=Hauppauge WinTV PVR PCI II Capture #2 Good E:\Record\ThePlague-1182810-0.mpg, Seg0[Thu 5/4 7:59:16.441-Wed 12/31 18:00:00.000]] ifn=null] Thu 5/4 7:59:18.411 VF file=MediaFile[id=1308911 A[1182810,646857,"The Plague",14771@0504.07:00,120] host=sage-pvr encodedBy=Hauppauge WinTV PVR PCI II Capture #2 Good E:\Record\ThePlague-1182810-0.mpg, Seg0[Thu 5/4 7:59:16.441-Wed 12/31 18:00:00.000]] targetTime = Thu 5/4 7:59:16.441 Thu 5/4 7:59:18.415 VideoFrame.timeSelected(Thu 5/4 7:59:16.441, true) currFile=MediaFile[id=1308911 A[1182810,646857,"The Plague",14771@0504.07:00,120] host=sage-pvr encodedBy=Hauppauge WinTV PVR PCI II Capture #2 Good E:\Record\ThePlague-1182810-0.mpg, Seg0[Thu 5/4 7:59:16.441-Wed 12/31 18:00:00.000]] Thu 5/4 7:59:18.492 DShowPlayer setVideoRendererFilter0({CD8743A1-3736-11D0-9E69-00C04FD7C15B}) called Thu 5/4 7:59:18.703 DShowPlayer setAudioRendererFilter0(DirectSound: Vinyl AC'97 Audio (WAVE)) called Thu 5/4 7:59:18.928 Rendered new font to cache font=java.awt.Font[family=Arial,name=Arial,style=bold,size=11] numGlyphs=1674 numCachedGlyphs=475 numImages=1 Thu 5/4 7:59:18.993 DShowPlayer setVideoDecoderFilter0(NVIDIA Video Decoder) called Thu 5/4 7:59:19.409 DShowPlayer setAudioDecoderFilter0(NVIDIA Audio Decoder) called Thu 5/4 7:59:19.695 DShowPlayer setTimeshift=1 buffer=0 Thu 5/4 7:59:19.718 Rendered new font to cache font=java.awt.Font[family=Arial,name=Arial,style=bold,size=24] numGlyphs=1674 numCachedGlyphs=255 numImages=2 Thu 5/4 7:59:19.734 NATIVE Loading the source file Thu 5/4 7:59:19.765 NATIVE Setting up the MPEG demux Thu 5/4 7:59:19.809 NATIVE RenderAudio called Thu 5/4 7:59:19.810 NATIVE RenderAudio step 1 Thu 5/4 7:59:19.838 NATIVE RenderAudio step 2 Thu 5/4 7:59:19.839 NATIVE RenderAudio step 3 Thu 5/4 7:59:19.853 AWTThread Hang Detected - hang time = 750 Thu 5/4 7:59:20.309 NATIVE RenderVideo called Thu 5/4 7:59:20.309 NATIVE RenderVideo step 1 Thu 5/4 7:59:20.329 NATIVE RenderVideo step 2 Thu 5/4 7:59:20.331 Video source pin information: Thu 5/4 7:59:20.331 PIN is not connected yet!Thu 5/4 7:59:20.331 M type MEDIATYPE_Video S type Unknown GUID Name F type FORMAT_VideoInfo2 Thu 5/4 7:59:20.332 Interlaced video Thu 5/4 7:59:20.332 Both fields per sample Thu 5/4 7:59:20.335 Field 2 first Thu 5/4 7:59:20.335 Stream never contains a Field 2 Thu 5/4 7:59:20.336 Either bob or weave mode. Thu 5/4 7:59:20.336 M type MEDIATYPE_Video S type Unknown GUID Name F type FORMAT_VideoInfo2 Thu 5/4 7:59:20.336 Interlaced video Thu 5/4 7:59:20.336 Both fields per sample Thu 5/4 7:59:20.337 Field 2 first Thu 5/4 7:59:20.337 Stream never contains a Field 2 Thu 5/4 7:59:20.337 Either bob or weave mode. Thu 5/4 7:59:20.337 M type MEDIATYPE_Video S type Unknown GUID Name F type FORMAT_VideoInfo2 Thu 5/4 7:59:20.337 Interlaced video Thu 5/4 7:59:20.337 Both fields per sample Thu 5/4 7:59:20.338 Field 2 first Thu 5/4 7:59:20.338 Stream never contains a Field 2 Thu 5/4 7:59:20.338 Either bob or weave mode. Thu 5/4 7:59:20.338 M type MEDIATYPE_Video S type Unknown GUID Name F type FORMAT_VideoInfo2 Thu 5/4 7:59:20.338 Interlaced video Thu 5/4 7:59:20.338 Both fields per sample Thu 5/4 7:59:20.339 Field 2 first Thu 5/4 7:59:20.339 Stream never contains a Field 2 Thu 5/4 7:59:20.339 Either bob or weave mode. Thu 5/4 7:59:20.339 M type MEDIATYPE_Video S type Unknown GUID Name F type FORMAT_VideoInfo2 Thu 5/4 7:59:20.339 Interlaced video Thu 5/4 7:59:20.339 Both fields per sample Thu 5/4 7:59:20.339 Field 2 first Thu 5/4 7:59:20.340 Stream never contains a Field 2 Thu 5/4 7:59:20.340 Either bob or weave mode. Thu 5/4 7:59:20.340 M type MEDIATYPE_Video S type Unknown GUID Name F type FORMAT_VideoInfo2 Thu 5/4 7:59:20.340 Interlaced video Thu 5/4 7:59:20.340 Both fields per sample Thu 5/4 7:59:20.340 Field 2 first Thu 5/4 7:59:20.341 Stream never contains a Field 2 Thu 5/4 7:59:20.341 Either bob or weave mode. Thu 5/4 7:59:20.341 M type MEDIATYPE_Video S type Unknown GUID Name F type FORMAT_VideoInfo2 Thu 5/4 7:59:20.341 Interlaced video Thu 5/4 7:59:20.341 Both fields per sample Thu 5/4 7:59:20.353 Field 2 first Thu 5/4 7:59:20.354 Stream never contains a Field 2 Thu 5/4 7:59:20.355 Either bob or weave mode. Thu 5/4 7:59:20.356 M type MEDIATYPE_Video S type Unknown GUID Name F type FORMAT_VideoInfo2 Thu 5/4 7:59:20.356 Interlaced video Thu 5/4 7:59:20.356 Both fields per sample Thu 5/4 7:59:20.356 Field 2 first Thu 5/4 7:59:20.356 Stream never contains a Field 2 Thu 5/4 7:59:20.357 Either bob or weave mode. Thu 5/4 7:59:20.357 M type MEDIATYPE_Video S type MEDIASUBTYPE_YUY2 F type FORMAT_VideoInfo2 Thu 5/4 7:59:20.357 Interlaced video Thu 5/4 7:59:20.357 Both fields per sample Thu 5/4 7:59:20.357 Field 2 first Thu 5/4 7:59:20.357 Stream never contains a Field 2 Thu 5/4 7:59:20.358 Either bob or weave mode. Thu 5/4 7:59:20.358 M type MEDIATYPE_Video S type MEDIASUBTYPE_UYVY F type FORMAT_VideoInfo2 Thu 5/4 7:59:20.358 Interlaced video Thu 5/4 7:59:20.358 Both fields per sample Thu 5/4 7:59:20.358 Field 2 first Thu 5/4 7:59:20.358 Stream never contains a Field 2 Thu 5/4 7:59:20.358 Either bob or weave mode. Thu 5/4 7:59:20.358 M type MEDIATYPE_Video S type MEDIASUBTYPE_YV12 F type FORMAT_VideoInfo2 Thu 5/4 7:59:20.359 Interlaced video Thu 5/4 7:59:20.359 Both fields per sample Thu 5/4 7:59:20.359 Field 2 first Thu 5/4 7:59:20.359 Stream never contains a Field 2 Thu 5/4 7:59:20.359 Either bob or weave mode. Thu 5/4 7:59:20.360 NATIVE RenderVideo step 3 Thu 5/4 7:59:20.603 AWTThread Hang Detected - hang time = 1500 Thu 5/4 7:59:21.045 Rendered new font to cache font=java.awt.Font[family=Arial,name=Arial,style=plain,size=26] numGlyphs=1674 numCachedGlyphs=249 numImages=2 Thu 5/4 7:59:21.353 AWTThread Hang Detected - hang time = 2250 Thu 5/4 7:59:21.660 Initializing DirectX9 Thu 5/4 7:59:21.743 Creating D3D Device Thu 5/4 7:59:22.103 AWTThread Hang Detected - hang time = 3000 Thu 5/4 7:59:22.252 Done Initializing DirectX9 Thu 5/4 7:59:22.253 Filter Graph Video Renderer Info: Thu 5/4 7:59:22.253 Video Renderer:CLSID_OverlayMixer Thu 5/4 7:59:22.254 M type MEDIATYPE_Video S type Unknown GUID Name F type FORMAT_VideoInfo2 Thu 5/4 7:59:22.254 Interlaced video Thu 5/4 7:59:22.254 Both fields per sample Thu 5/4 7:59:22.254 Field 2 first Thu 5/4 7:59:22.255 Stream never contains a Field 2 Thu 5/4 7:59:22.255 Either bob or weave mode. Thu 5/4 7:59:22.275 DShowGraphFilters=Video Renderer,AudRend,VidRend,Audio Decoder,Line21 Decoder,Video Decoder,SageTV MPEG2 Demultiplexer,E:\Record\ThePlague-1182810-0.mpg, Thu 5/4 7:59:22.276 DShowPlayer setVideoHWND(131470) Thu 5/4 7:59:22.280 ImageUtils loading file C:\Program Files\SageTV\SageTV\STVs\SageTV3\SageLogo256.png Thu 5/4 7:59:22.332 ImageUtils creating BI copy sun.awt.image.ToolkitImage@10e130c Thu 5/4 7:59:22.334 Premultiplying alpha for BuffImage... Thu 5/4 7:59:22.362 Got the default color key 0x100010 Thu 5/4 7:59:22.365 Got the default overlay color key of 0x100010 Thu 5/4 7:59:22.365 Setting the color key to 0x100010 Thu 5/4 7:59:22.366 Returning the color key as 0xff100010 Thu 5/4 7:59:22.367 Got Native Video Dimensions java.awt.Dimension[width=640,height=480] Thu 5/4 7:59:22.368 VideoFrame.timeSelected2(Thu 5/4 7:59:16.441, true) currFile=MediaFile[id=1308911 A[1182810,646857,"The Plague",14771@0504.07:00,120] host=sage-pvr encodedBy=Hauppauge WinTV PVR PCI II Capture #2 Good E:\Record\ThePlague-1182810-0.mpg, Seg0[Thu 5/4 7:59:16.441-Wed 12/31 18:00:00.000]] realDur=0 Thu 5/4 7:59:22.369 About to perform media time selection for 0 Thu 5/4 7:59:22.370 Running the playback graph. Thu 5/4 7:59:22.371 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Thu 5/4 7:59:22.440 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null]) Thu 5/4 7:59:22.470 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Thu 5/4 7:59:22.537 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Thu 5/4 7:59:22.539 DShowMediaPlayer is consuming the events... Thu 5/4 7:59:22.546 Event: 0xd Thu 5/4 7:59:22.546 Event: 0xe Thu 5/4 7:59:22.547 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true Thu 5/4 7:59:22.547 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null] Thu 5/4 7:59:22.548 DShowMediaPlayer is consuming the events... Thu 5/4 7:59:22.552 VF processing job null nPlayin=true Thu 5/4 7:59:22.553 isRec=true rd=6112 base=72 Thu 5/4 7:59:22.554 VF thread is now waiting for 1:00:43.236 Thu 5/4 7:59:22.596 Creating DirectX9 Texture from memory w=256 h=78 Thu 5/4 7:59:22.604 ImageUtils loading file C:\Program Files\SageTV\SageTV\STVs\SageTV3\GoFullscreen.png Thu 5/4 7:59:22.643 ImageUtils creating BI copy sun.awt.image.ToolkitImage@751d58 Thu 5/4 7:59:22.649 Premultiplying alpha for BuffImage... Thu 5/4 7:59:22.689 Creating DirectX9 Texture from memory w=118 h=103 Thu 5/4 7:59:22.692 ImageUtils loading file C:\Program Files\SageTV\SageTV\STVs\SageTV3\GoSleep.png Thu 5/4 7:59:22.699 ImageUtils creating BI copy sun.awt.image.ToolkitImage@65ab77 Thu 5/4 7:59:22.701 Premultiplying alpha for BuffImage... Thu 5/4 7:59:22.706 Creating DirectX9 Texture from memory w=97 h=121 Thu 5/4 7:59:22.708 Premultiplying alpha for BuffImage... Thu 5/4 7:59:22.726 Creating DirectX9 Texture from memory w=256 h=256 Thu 5/4 7:59:22.731 Premultiplying alpha for BuffImage... Thu 5/4 7:59:22.749 Creating DirectX9 Texture from memory w=256 h=256 Thu 5/4 7:59:22.752 Premultiplying alpha for BuffImage... Thu 5/4 7:59:22.771 Creating DirectX9 Texture from memory w=256 h=256 Thu 5/4 7:59:22.779 ImageUtils loading file C:\Program Files\SageTV\SageTV\STVs\SageTV3\MenuBarLong.png Thu 5/4 7:59:22.788 ImageUtils creating BI copy sun.awt.image.ToolkitImage@c7014c Thu 5/4 7:59:22.790 Premultiplying alpha for BuffImage... Thu 5/4 7:59:22.800 Creating DirectX9 Texture from memory w=586 h=47 Thu 5/4 7:59:22.807 Premultiplying alpha for BuffImage... Thu 5/4 7:59:22.824 Creating DirectX9 Texture from memory w=256 h=256 Thu 5/4 7:59:22.829 Premultiplying alpha for BuffImage... Thu 5/4 7:59:22.830 Creating DirectX9 Texture from memory w=32 h=32 Thu 5/4 7:59:22.873 Premultiplying alpha for BuffImage... Thu 5/4 7:59:22.880 Creating DirectX9 Texture from memory w=32 h=32 Thu 5/4 7:59:22.916 ImageUtils loading file C:\Program Files\SageTV\SageTV\STVs\SageTV3\RecordingNow.png Thu 5/4 7:59:22.920 ImageUtils creating BI copy sun.awt.image.ToolkitImage@e69696 Thu 5/4 7:59:22.921 Premultiplying alpha for BuffImage... Thu 5/4 7:59:22.941 Creating DirectX9 Texture from memory w=95 h=58 Thu 5/4 7:59:22.955 Premultiplying alpha for BuffImage... Thu 5/4 7:59:22.967 Creating DirectX9 Texture from memory w=32 h=32 Thu 5/4 7:59:23.379 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 7:59:24.519 VF processing job null nPlayin=true Thu 5/4 7:59:24.520 isRec=true rd=8079 base=2035 Thu 5/4 7:59:24.528 VF thread is now waiting for 1:00:41.266 Thu 5/4 7:59:28.438 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 7:59:30.043 VF processing job null nPlayin=true Thu 5/4 7:59:30.044 isRec=true rd=13603 base=7558 Thu 5/4 7:59:30.048 VF thread is now waiting for 1:00:35.747 Thu 5/4 7:59:32.259 setUI(sage.bz@a3c5b6[MediaPlayer OSD]) histIdx=1 uiHistory=[sage.bz@6f956[Main Menu], sage.bz@a3c5b6[MediaPlayer OSD]] Thu 5/4 7:59:32.464 VF.submitJob(VFJob[TimeSet r=0.0 t=1146747572464 file=null ifn=null]) Thu 5/4 7:59:32.465 VF processing job VFJob[TimeSet r=0.0 t=1146747572464 file=null ifn=null] nPlayin=true Thu 5/4 7:59:32.628 ImageUtils loading file C:\Program Files\SageTV\SageTV\ChannelLogos\HISTORY.gif Thu 5/4 7:59:32.632 ImageUtils creating BI copy sun.awt.image.ToolkitImage@10bc3c9 Thu 5/4 7:59:32.633 Premultiplying alpha for BuffImage... Thu 5/4 7:59:32.641 Creating DirectX9 Texture from memory w=52 h=39 Thu 5/4 7:59:32.989 AWTThread Hang Detected - hang time = 750 Thu 5/4 7:59:33.115 Rendered new font to cache font=java.awt.Font[family=Arial,name=Arial,style=bold,size=18] numGlyphs=1674 numCachedGlyphs=418 numImages=2 Thu 5/4 7:59:33.116 Premultiplying alpha for BuffImage... Thu 5/4 7:59:33.139 Creating DirectX9 Texture from memory w=256 h=256 Thu 5/4 7:59:33.143 ImageUtils loading file C:\Program Files\SageTV\SageTV\STVs\SageTV3\OSDChUp.png Thu 5/4 7:59:33.145 ImageUtils creating BI copy sun.awt.image.ToolkitImage@62812d Thu 5/4 7:59:33.146 Premultiplying alpha for BuffImage... Thu 5/4 7:59:33.147 Creating DirectX9 Texture from memory w=29 h=26 Thu 5/4 7:59:33.148 ImageUtils loading file C:\Program Files\SageTV\SageTV\STVs\SageTV3\OSDChDisplay.png Thu 5/4 7:59:33.151 ImageUtils creating BI copy sun.awt.image.ToolkitImage@14d82e1 Thu 5/4 7:59:33.152 Premultiplying alpha for BuffImage... Thu 5/4 7:59:33.153 Creating DirectX9 Texture from memory w=35 h=26 Thu 5/4 7:59:33.154 ImageUtils loading file C:\Program Files\SageTV\SageTV\STVs\SageTV3\OSDChDown.png Thu 5/4 7:59:33.158 ImageUtils creating BI copy sun.awt.image.ToolkitImage@4957c7 Thu 5/4 7:59:33.159 Premultiplying alpha for BuffImage... Thu 5/4 7:59:33.173 Creating DirectX9 Texture from memory w=29 h=26 Thu 5/4 7:59:33.174 ImageUtils loading file C:\Program Files\SageTV\SageTV\STVs\SageTV3\OSDStatusPlay.png Thu 5/4 7:59:33.178 ImageUtils creating BI copy sun.awt.image.ToolkitImage@43fb68 Thu 5/4 7:59:33.179 Premultiplying alpha for BuffImage... Thu 5/4 7:59:33.180 Creating DirectX9 Texture from memory w=8 h=8 Thu 5/4 7:59:33.181 ImageUtils loading file C:\Program Files\SageTV\SageTV\STVs\SageTV3\OSDVolOn.png Thu 5/4 7:59:33.183 ImageUtils creating BI copy sun.awt.image.ToolkitImage@2c4ede Thu 5/4 7:59:33.184 Premultiplying alpha for BuffImage... Thu 5/4 7:59:33.185 Creating DirectX9 Texture from memory w=16 h=13 Thu 5/4 7:59:33.186 ImageUtils loading file C:\Program Files\SageTV\SageTV\STVs\SageTV3\OSDVolBar.png Thu 5/4 7:59:33.188 ImageUtils creating BI copy sun.awt.image.ToolkitImage@132b73b Thu 5/4 7:59:33.189 Premultiplying alpha for BuffImage... Thu 5/4 7:59:33.190 Creating DirectX9 Texture from memory w=64 h=4 Thu 5/4 7:59:33.191 ImageUtils loading file C:\Program Files\SageTV\SageTV\STVs\SageTV3\OSDVolSlider.png Thu 5/4 7:59:33.193 ImageUtils creating BI copy sun.awt.image.ToolkitImage@1b77832 Thu 5/4 7:59:33.196 Premultiplying alpha for BuffImage... Thu 5/4 7:59:33.207 Creating DirectX9 Texture from memory w=9 h=15 Thu 5/4 7:59:33.208 ImageUtils loading file C:\Program Files\SageTV\SageTV\STVs\SageTV3\OSDReplay.png Thu 5/4 7:59:33.211 ImageUtils creating BI copy sun.awt.image.ToolkitImage@51b0af Thu 5/4 7:59:33.212 Premultiplying alpha for BuffImage... Thu 5/4 7:59:33.214 Creating DirectX9 Texture from memory w=29 h=26 Thu 5/4 7:59:33.214 ImageUtils loading file C:\Program Files\SageTV\SageTV\STVs\SageTV3\OSDRew.png Thu 5/4 7:59:33.219 ImageUtils creating BI copy sun.awt.image.ToolkitImage@f186b8 Thu 5/4 7:59:33.220 Premultiplying alpha for BuffImage... Thu 5/4 7:59:33.239 Creating DirectX9 Texture from memory w=30 h=26 Thu 5/4 7:59:33.240 ImageUtils loading file C:\Program Files\SageTV\SageTV\STVs\SageTV3\OSDStop.png Thu 5/4 7:59:33.244 ImageUtils creating BI copy sun.awt.image.ToolkitImage@1d92803 Thu 5/4 7:59:33.245 Premultiplying alpha for BuffImage... Thu 5/4 7:59:33.247 Creating DirectX9 Texture from memory w=30 h=26 Thu 5/4 7:59:33.248 ImageUtils loading file C:\Program Files\SageTV\SageTV\STVs\SageTV3\OSDPause.png Thu 5/4 7:59:33.250 ImageUtils creating BI copy sun.awt.image.ToolkitImage@1f23f8b Thu 5/4 7:59:33.251 Premultiplying alpha for BuffImage... Thu 5/4 7:59:33.253 Creating DirectX9 Texture from memory w=30 h=26 Thu 5/4 7:59:33.253 ImageUtils loading file C:\Program Files\SageTV\SageTV\STVs\SageTV3\OSDFwd.png Thu 5/4 7:59:33.256 ImageUtils creating BI copy sun.awt.image.ToolkitImage@1b7b32c Thu 5/4 7:59:33.257 Premultiplying alpha for BuffImage... Thu 5/4 7:59:33.258 Creating DirectX9 Texture from memory w=30 h=26 Thu 5/4 7:59:33.259 ImageUtils loading file C:\Program Files\SageTV\SageTV\STVs\SageTV3\OSDSkip.png Thu 5/4 7:59:33.263 ImageUtils creating BI copy sun.awt.image.ToolkitImage@a06d25 Thu 5/4 7:59:33.264 Premultiplying alpha for BuffImage... Thu 5/4 7:59:33.273 Creating DirectX9 Texture from memory w=29 h=26 Thu 5/4 7:59:33.286 VF processing on UI Thread VFJob[TimeSet r=0.0 t=1146747572464 file=null ifn=null] Thu 5/4 7:59:33.287 VideoFrame.timeSelected(Thu 5/4 7:59:32.464, true) currFile=MediaFile[id=1308911 A[1182810,646857,"The Plague",14771@0504.07:00,120] host=sage-pvr encodedBy=Hauppauge WinTV PVR PCI II Capture #2 Good E:\Record\ThePlague-1182810-0.mpg, Seg0[Thu 5/4 7:59:16.441-Wed 12/31 18:00:00.000]] Thu 5/4 7:59:33.287 VideoFrame.timeSelected2(Thu 5/4 7:59:32.464, true) currFile=MediaFile[id=1308911 A[1182810,646857,"The Plague",14771@0504.07:00,120] host=sage-pvr encodedBy=Hauppauge WinTV PVR PCI II Capture #2 Good E:\Record\ThePlague-1182810-0.mpg, Seg0[Thu 5/4 7:59:16.441-Wed 12/31 18:00:00.000]] realDur=0 Thu 5/4 7:59:33.288 About to perform media time selection for 16023 Thu 5/4 7:59:33.344 Premultiplying alpha for BuffImage... Thu 5/4 7:59:33.345 Creating DirectX9 Texture from memory w=32 h=32 Thu 5/4 7:59:33.439 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 7:59:33.639 VF processing job null nPlayin=true Thu 5/4 7:59:33.650 isRec=true rd=17209 base=16025 Thu 5/4 7:59:33.658 VF thread is now waiting for 1:00:27.276 Thu 5/4 7:59:38.440 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 7:59:43.441 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 7:59:48.441 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 7:59:53.446 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 7:59:58.449 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:00:03.450 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:00:08.451 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:00:13.452 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:00:18.453 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:00:23.454 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:00:28.455 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:00:33.456 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:00:38.458 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:00:43.458 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:00:48.459 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:00:53.460 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:00:58.461 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:01:03.462 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:01:08.463 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:01:13.464 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:01:18.468 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:01:23.469 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:01:28.470 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:01:33.472 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:01:38.472 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:01:43.475 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:01:48.479 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:01:53.481 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:01:58.482 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:02:03.483 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:02:08.483 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:02:13.485 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:02:18.486 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:02:23.488 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:02:28.489 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:02:33.489 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:02:38.490 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:02:43.491 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:02:48.492 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:02:53.493 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:02:58.494 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:03:03.494 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:03:08.495 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:03:13.496 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:03:18.501 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:03:23.502 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:03:28.503 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:03:33.506 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:03:38.507 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:03:43.513 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:03:48.518 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:03:53.519 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:03:58.520 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:04:03.521 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:04:08.529 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:04:13.530 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:04:18.531 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:04:23.532 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:04:28.533 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:04:30.166 VF processing job null nPlayin=true Thu 5/4 8:04:30.167 isRec=true rd=313726 base=311707 Thu 5/4 8:04:30.167 VF thread is now waiting for 0:55:31.601 Thu 5/4 8:04:33.534 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:04:38.535 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:04:43.537 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:04:48.537 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:04:52.305 processOptionsMenu optionsMenu=default:null|OptionsMenu:OSDOptions context=Context[parent=Context[parent=Context[parent=null map={}] map={MultiSpeedSkipEnabled=true, MultiSpeedSkipSeekStartTime=0, commercials2=null, DisplayInfo=false, comautoskip=true, DisplayChanStatus=false, ChannelSurf=, MultiSpeedSkip=0, DisplayTimeStatus=false, comautorunning=true, commerciallist=, MultiSpeedSkipJumpBack=500, DisplayVolTransportsTime=false, DisplayVolStatus=false, TimeScrollTime=-1, MultiSpeedSkipWasMuted=false, MultiSpeedSkipStartSpeed=8, ShowVideoBGWidget=true, forkstop=false, MaxChannel=999, MultiSpeedSkipPauseTime=100}] map={DisplayDVDInvalidOp=false, _SAGE_PASSIVELISTEN=null}] Thu 5/4 8:04:53.538 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:04:53.721 SetFullScreen(true) Thu 5/4 8:04:53.722 FullScreen set to true Thu 5/4 8:04:58.539 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:05:03.540 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:05:07.172 processOptionsMenu optionsMenu=default:null|OptionsMenu:OSDOptions context=Context[parent=Context[parent=Context[parent=null map={}] map={MultiSpeedSkipEnabled=true, MultiSpeedSkipSeekStartTime=0, commercials2=null, DisplayInfo=false, comautoskip=true, DisplayChanStatus=false, ChannelSurf=, MultiSpeedSkip=0, DisplayTimeStatus=false, comautorunning=true, commerciallist=, MultiSpeedSkipJumpBack=500, DisplayVolTransportsTime=false, DisplayVolStatus=false, TimeScrollTime=-1, MultiSpeedSkipWasMuted=false, MultiSpeedSkipStartSpeed=8, ShowVideoBGWidget=true, forkstop=false, MaxChannel=999, MultiSpeedSkipPauseTime=100}] map={DisplayDVDInvalidOp=false, _SAGE_PASSIVELISTEN=null}] Thu 5/4 8:05:07.851 Rendered new font to cache font=java.awt.Font[family=Arial,name=Arial,style=bold,size=20] numGlyphs=1674 numCachedGlyphs=360 numImages=2 Thu 5/4 8:05:07.851 Premultiplying alpha for BuffImage... Thu 5/4 8:05:07.872 Creating DirectX9 Texture from memory w=256 h=256 Thu 5/4 8:05:08.545 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:05:09.519 SetFullScreen(false) Thu 5/4 8:05:09.520 FullScreen set to false Thu 5/4 8:05:13.547 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:05:18.548 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:05:23.549 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:05:28.550 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:05:33.572 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:05:38.580 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:05:43.586 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:05:48.592 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:05:53.595 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:05:58.597 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:06:03.598 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:06:08.599 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:06:13.599 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:06:18.601 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:06:23.603 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:06:28.604 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:06:33.605 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:06:38.606 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:06:43.606 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:06:48.607 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:06:53.608 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:06:58.609 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:07:03.610 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:07:08.612 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:07:13.613 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:07:18.614 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:07:23.615 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:07:28.617 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:07:33.618 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:07:38.618 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:07:43.619 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:07:48.622 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:07:53.623 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:07:58.624 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:08:03.628 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:08:08.629 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:08:13.432 Removed system shell hook Thu 5/4 8:08:13.432 Sage.exit() called. Thu 5/4 8:08:13.433 Cleaning up servers Thu 5/4 8:08:13.434 Cleaning up PM Thu 5/4 8:08:13.435 Killed Carny. Thu 5/4 8:08:13.435 Killed Scheduler. Thu 5/4 8:08:13.443 Received command of:WIZARD_SYNC from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:08:13.445 VF logFileWatch doneAir=A[1182810,646857,"The Plague",14771@0504.07:00,120] theTime=Thu 5/4 8:08:11.389 recTime=Thu 5/4 7:59:16.441 Thu 5/4 8:08:13.446 Stopping the playback graph. Thu 5/4 8:08:13.630 Received command of:NOOP from Socket[addr=/127.0.0.1,port=42024,localport=1096] Thu 5/4 8:08:13.773 Tearing down playback graph Thu 5/4 8:08:13.774 NATIVE Deallocating the CPlayerData object Thu 5/4 8:08:13.844 NATIVE Finished destroying the playback graph Thu 5/4 8:08:13.850 Killed Seeker. Thu 5/4 8:08:13.853 VF processing job null nPlayin=false Thu 5/4 8:08:13.853 VideoFrame thread is now exiting Thu 5/4 8:08:13.855 Cleaning up c/s connection Thu 5/4 8:08:13.857 Killed EPG. Thu 5/4 8:08:13.874 Connection lost from: null by:java.net.SocketException: socket closed Thu 5/4 8:08:13.875 Cleaning up c/s connection Thu 5/4 8:08:13.875 NetworkManager CommunicationFailure : /127.0.0.1:42024 type=2 Thu 5/4 8:08:13.878 Killed MMC. Thu 5/4 8:08:13.879 Killing UIMgr UIManager:localhost@@SAGETV_PROCESS_LOCAL_UI Thu 5/4 8:08:13.891 Killed UI Timers Thu 5/4 8:08:14.000 Killed VideoFrame Thu 5/4 8:08:14.052 Killed EventRouter Thu 5/4 8:08:14.052 Killed Studio Thu 5/4 8:08:14.096 MetaImage clearNativeCache nativeImageCacheSize=2206976 Thu 5/4 8:08:14.202 Cleaning up DirectX9 Thu 5/4 8:08:14.203 Doing full DX9 cleanup. Thu 5/4 8:08:14.229 Done cleaning up DirectX9 Thu 5/4 8:08:14.879 AWTThread Hang Detected - hang time = 750 Thu 5/4 8:08:15.629 AWTThread Hang Detected - hang time = 1500 Thu 5/4 8:08:16.053 Killed RootPanel Thu 5/4 8:08:16.138 Disposed Window Thu 5/4 8:08:16.139 Killed UIManager. Thu 5/4 8:08:16.139 Killed Wizard. Thu 5/4 8:08:16.139 Cleaning up c/s connection Thu 5/4 8:08:16.146 Error communicating with server:java.net.SocketException: Socket closed Thu 5/4 8:08:16.146 Cleaning up c/s connection Thu 5/4 8:08:16.147 NetworkManager CommunicationFailure : /127.0.0.1:42024 type=1 Thu 5/4 8:08:16.147 MsgRecv thread is terminating for /127.0.0.1:42024 Thu 5/4 8:08:16.199 Bye-bye. Thu 5/4 8:08:16.202 SageTV SHUTDOWN is activating!