Tue 11/7 20:27:11.721 user.dir2=H:\Program Files\SageTV\SageTV
Tue 11/7 20:27:11.724 classpath=H:\Program Files\SageTV\SageTV\Sage.jar;H:\Program Files\SageTV\SageTV\xerces.jar;H:\Program Files\SageTV\SageTV\plugin.jar;H:\Program Files\SageTV\SageTV\;;JARs\commons-jxpath-1.1.jar;JARs\commons-logging-api.jar;JARs\commons-logging.jar;JARs\df_sageutils.jar;JARs\jcifs-1.1.6.jar;JARs\jdic.jar;JARs\mtsa.jar;JARs\mx4j-impl.jar;JARs\mx4j-jmx.jar;JARs\mx4j-remote.jar;JARs\mx4j-tools.jar;JARs\nielm_getrssnews.jar;JARs\nielm_sageimdb.jar;JARs\nielm_sageutls.jar;JARs\nielm_sagewebserver.jar;JARs\nielm_sagexmlinfo.jar;JARs\sagemc.jar;JARs\sbbi-jmx-1.0.jar;JARs\sbbi-upnplib-1.0.3.jar;JARs\servlet.jar
Tue 11/7 20:27:11.725 JVM version=1.5.0_05
Tue 11/7 20:27:11.725 OS=Windows XP 5.1
Tue 11/7 20:27:11.727 Succesfully setup system shell hook
Tue 11/7 20:27:11.729 not specifiy WinkeyboardHook in registery, load default one
Tue 11/7 20:27:12.018 ImageUtils loading URL jar:file:/H:/Program%20Files/SageTV/SageTV/Sage.jar!/images/splash.gif
Tue 11/7 20:27:12.036 ImageUtils creating BI copy sun.awt.image.ToolkitImage@1cafa9e
Tue 11/7 20:27:12.110 SageTV V5.0.4.92
Tue 11/7 20:27:12.185 hostname=pvr
Tue 11/7 20:27:12.318 ImageUtils loading URL jar:file:/H:/Program%20Files/SageTV/SageTV/Sage.jar!/images/tvicon.gif
Tue 11/7 20:27:12.322 ImageUtils creating BI copy sun.awt.image.ToolkitImage@85af80
Tue 11/7 20:27:12.441 ImageUtils loading URL jar:file:/H:/Program%20Files/SageTV/SageTV/Sage.jar!/images/tvicon_anim0.gif
Tue 11/7 20:27:12.454 ImageUtils creating BI copy sun.awt.image.ToolkitImage@2a340e
Tue 11/7 20:27:12.455 ImageUtils loading URL jar:file:/H:/Program%20Files/SageTV/SageTV/Sage.jar!/images/tvicon_anim1.gif
Tue 11/7 20:27:12.457 ImageUtils creating BI copy sun.awt.image.ToolkitImage@1050169
Tue 11/7 20:27:12.459 ImageUtils loading URL jar:file:/H:/Program%20Files/SageTV/SageTV/Sage.jar!/images/tvicon_anim2.gif
Tue 11/7 20:27:12.461 ImageUtils creating BI copy sun.awt.image.ToolkitImage@9fef6f
Tue 11/7 20:27:12.463 ImageUtils loading URL jar:file:/H:/Program%20Files/SageTV/SageTV/Sage.jar!/images/tvicon_anim3.gif
Tue 11/7 20:27:12.466 ImageUtils creating BI copy sun.awt.image.ToolkitImage@17172ea
Tue 11/7 20:27:12.589 Wizard starting to load database info...
Tue 11/7 20:27:12.592 Wizard DONE loading database info. loadTime=0.0020 sec
Tue 11/7 20:27:12.734 SageTV received connection from:Socket[addr=localhost/127.0.0.1,port=42024,localport=1360]
Tue 11/7 20:27:13.595 Received command of:PROPERTY_SYNC 193 from Socket[addr=localhost/127.0.0.1,port=42024,localport=1360]
Tue 11/7 20:27:13.784 Received command of:WIZARD_SYNC from Socket[addr=localhost/127.0.0.1,port=42024,localport=1360]
Tue 11/7 20:27:13.785 Wizard allocating table for Year of size 91
Tue 11/7 20:27:13.786 Wizard loading main index for Year
Tue 11/7 20:27:13.787 Wizard allocating table for Network of size 27
Tue 11/7 20:27:13.796 Wizard loading main index for Network
Tue 11/7 20:27:13.798 Wizard allocating table for Title of size 10600
Tue 11/7 20:27:13.799 Wizard loading main index for Title
Tue 11/7 20:27:14.227 Wizard building alt. index 0 for Title
Tue 11/7 20:27:14.252 Wizard allocating table for Channel of size 266
Tue 11/7 20:27:14.253 Wizard loading main index for Channel
Tue 11/7 20:27:14.305 Wizard allocating table for People of size 21501
Tue 11/7 20:27:14.318 Wizard loading main index for People
Tue 11/7 20:27:14.887 Wizard building alt. index 0 for People
Tue 11/7 20:27:14.988 Wizard allocating table for SubCategory of size 121
Tue 11/7 20:27:14.988 Wizard loading main index for SubCategory
Tue 11/7 20:27:14.990 Wizard allocating table for Rated of size 7
Tue 11/7 20:27:14.990 Wizard loading main index for Rated
Tue 11/7 20:27:14.990 Wizard allocating table for ParentalRating of size 0
Tue 11/7 20:27:14.991 Wizard allocating table for ExtendedRating of size 10
Tue 11/7 20:27:14.991 Wizard loading main index for ExtendedRating
Tue 11/7 20:27:15.039 Wizard allocating table for Category of size 126
Tue 11/7 20:27:15.041 Wizard loading main index for Category
Tue 11/7 20:27:15.043 Wizard allocating table for PrimeTitle of size 0
Tue 11/7 20:27:15.044 Wizard allocating table for Bonus of size 522
Tue 11/7 20:27:15.044 Wizard loading main index for Bonus
Tue 11/7 20:27:15.052 Wizard allocating table for Show of size 27289
Tue 11/7 20:27:15.074 Wizard loading main index for Show
Tue 11/7 20:27:20.894 Wizard building alt. index 0 for Show
Tue 11/7 20:27:20.975 Wizard allocating table for Airing of size 48027
Tue 11/7 20:27:20.988 Wizard loading main index for Airing
Tue 11/7 20:27:22.894 Wizard building alt. index 0 for Airing
Tue 11/7 20:27:22.938 Wizard building alt. index 1 for Airing
Tue 11/7 20:27:22.998 Wizard allocating table for ManualRecord of size 75
Tue 11/7 20:27:22.998 Wizard loading main index for ManualRecord
Tue 11/7 20:27:23.006 Wizard allocating table for MediaFile of size 12417
Tue 11/7 20:27:23.023 Wizard loading main index for MediaFile
Tue 11/7 20:27:28.126 Wizard building alt. index 0 for MediaFile
Tue 11/7 20:27:28.141 Wizard allocating table for Watched of size 1453
Tue 11/7 20:27:28.141 Wizard loading main index for Watched
Tue 11/7 20:27:28.234 Wizard building alt. index 0 for Watched
Tue 11/7 20:27:28.237 Wizard allocating table for Agent of size 899
Tue 11/7 20:27:28.238 Wizard loading main index for Agent
Tue 11/7 20:27:28.342 Wizard building alt. index 0 for Agent
Tue 11/7 20:27:28.348 Wizard allocating table for Wasted of size 285
Tue 11/7 20:27:28.349 Wizard loading main index for Wasted
Tue 11/7 20:27:28.353 Wizard allocating table for Playlist of size 4
Tue 11/7 20:27:28.353 Wizard loading main index for Playlist
Tue 11/7 20:27:28.370 Received command of:CARNY_SYNC_CAUSEMAP 2978 from Socket[addr=localhost/127.0.0.1,port=42024,localport=1360]
Tue 11/7 20:27:28.430 Received command of:CARNY_SYNC_WPMAP 2877 from Socket[addr=localhost/127.0.0.1,port=42024,localport=1360]
Tue 11/7 20:27:28.471 Received command of:CARNY_SYNC_MUSTSEE 10 from Socket[addr=localhost/127.0.0.1,port=42024,localport=1360]
Tue 11/7 20:27:28.473 Received command of:CARNY_SYNC_LOVE 47 from Socket[addr=localhost/127.0.0.1,port=42024,localport=1360]
Tue 11/7 20:27:28.475 SageTV received connection from:Socket[addr=localhost/127.0.0.1,port=42024,localport=1363]
Tue 11/7 20:27:29.376 MMC calling detectCaptureDevices on sage.o@9abce9
Tue 11/7 20:27:29.402 devices detected=[Hauppauge WinTV PVR PCI II Capture, SGraphRecorder on 127.0.0.1:6969]
Tue 11/7 20:27:29.403 EncoderMap={SGraphRecorder on 127.0.0.1:6969=SGraphRecorder on 127.0.0.1:6969, Hauppauge WinTV PVR PCI II Capture=Hauppauge WinTV PVR PCI II Capture}
Tue 11/7 20:27:30.589 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, Audio Source, AVI Decompressor, AVI Draw, AVI Mux, AVI Splitter, AVI/WAV File Source, Bitmap Generate, CBVA Filter, CCFilter, Color Converter, Color Space Converter, Core CC Parser, CyberLink Audio Decoder, CyberLink Audio Effect (PDVD6), CyberLink Audio Spectrum Analyzer (PDVD6), CyberLink AudioCD Filter (PDVD6), CyberLink Demux (PDVD6), CyberLink DVD Navigator (PDVD6), CyberLink Line21 Decoder (PDVD6), Cyberlink SubTitle Importor (PDVD6), CyberLink TimeStretch Filter (PDVD6), CyberLink Video/SP Decoder, Deinterlace Filter, Deinterlace Filter, Dib Output, Dib Receive, DirectShow Tap (Symphony), Disk Record Queue, DivX Decoder Filter, Dump, 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, GB-PVR FileSource, GB-PVR Parser, GB-PVR Push Source, GB-PVR Shoutcast, GB-PVR Writer, Hauppauge WinTV Color Format Converter 2, Hauppauge WinTV File Reader, Hauppauge WinTV File Writer, Hauppauge WinTV MPEG Splitter, Hauppauge WinTV SnapShot, I-Media Multiple MPEG2 Source, 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 Audio Decoder, InterVideo NonCSS Audio Decoder for Hauppauge, InterVideo NonCSS Video Decoder for Hauppauge, LAME MPEG Layer III Audio Encoder, Ligos MPEG Splitter, Line 21 Decoder, Line 21 Decoder 2, 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 AAC Parser, Nero Audio CD Filter, Nero Audio Processor, Nero Audio Sample Renderer, Nero Audio Stream Renderer, Nero Digital Audio Decoder, Nero Digital Audio Encoder, Nero Digital File Writer, Nero Digital Muxer, Nero Digital Null Renderer, Nero Digital Parser, Nero Digital Video Encoder, Nero DVD Decoder, Nero DVD Navigator, Nero ES Video Reader, Nero File Source, Nero File Source / Splitter, Nero Format Converter, Nero Frame Capture, Nero Mpeg Audio Encoder, Nero QuickTime(tm) Audio Decoder, Nero QuickTime(tm) Video Decoder, Nero Scene Detector, Nero Scene Detector 2, Nero Vcd Navigator, Nero Video Decoder, Nero Video Processor, Nero Video Sample Renderer, Nero Video Stream Renderer, 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, SBDARecorderDump, Screen Capture filter, Screen Capture filter, Shared File Source (Async.), Sigma Designs .MP4 File Parser, Sigma Designs AVI Splitter, Sigma Designs MPEG Decoder (IRm), Sigma Designs MPEG Stream Splitter, Sigma Designs MPEG-2 hardware decoder, Sigma Designs PCM Swapper, Smart Tee, Sonic Audio Depth Converter (Symphony), Sonic Cinemaster MPEG Splitter (Symphony), Sonic MPEG Non-Pro Audio Decoder (Symphony), Sonic MPEG Video Decoder (Symphony), Sonic RTStreamSink (Symphony), StreamBufferSink, StreamBufferSource, Stretch Video, THPSI Parser, 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 Codec, VBI Surface Allocator, VGA 16 Color Ditherer, Video Mixing Renderer 9, Video Port Manager, Video Renderer, Video Renderer, Video Source, WAV Dest, Wave Parser, WIA Stream Snapshot Filter, Windows Media Audio Decoder, Windows Media Multiplexer, Windows Media source filter, Windows Media Update Filter, Windows Media Video Decoder, Windows Media Video Decoder, WM ASF Reader, WM ASF Writer, WMAPro over S/PDIF DMO, 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 Advanced Decoder DMO, WMVideo Decoder DMO, WST Decoder, WST Pager, WST Renderer, XML Playlist]
Tue 11/7 20:27:31.082 VF thread is now running...
Tue 11/7 20:27:31.084 VF thread is now waiting for 0:00:00.000
Tue 11/7 20:27:31.086 UIMgr loading UI from: H:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMC_169.xml
Tue 11/7 20:27:31.576 sage.aw@6b62d1 needs an update in 0:23:04
Tue 11/7 20:27:31.577 sage.aw@24c414 needs an update in 1:16:28
Tue 11/7 20:27:31.594 MsgSend thread spawned for /127.0.0.1:42024
Tue 11/7 20:27:31.596 MsgRecv thread has spawned for /127.0.0.1:42024
Tue 11/7 20:27:31.598 Received command of:NOOP from Socket[addr=localhost/127.0.0.1,port=42024,localport=1360]
Tue 11/7 20:27:31.599 EPG needs an update in 23 minutes
Tue 11/7 20:27:31.600 EPG's works is done. Waiting...
Tue 11/7 20:27:31.603 StorageDeviceDetector started...
Tue 11/7 20:27:32.349 AWTThread Hang Detected - hang time = 782
Tue 11/7 20:27:33.112 AWTThread Hang Detected - hang time = 1545
Tue 11/7 20:27:33.138 locale = en
Tue 11/7 20:27:33.926 Initializing EPG categories
Tue 11/7 20:27:33.929 AWTThread Hang Detected - hang time = 2362
Tue 11/7 20:27:34.064 reading IMDB cache ...
Tue 11/7 20:27:34.064 cache directory = H:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\IMDBCache
Tue 11/7 20:27:34.065 cache size = 1000
Tue 11/7 20:27:34.088 24 images in cache
Tue 11/7 20:27:34.402 DatePat=EEE, MMM d orgPat=EEEE, MMMM d, yyyy
Tue 11/7 20:27:34.587 setUI(sage.bz@20dcb7[Main Menu]) histIdx=0 uiHistory=[sage.bz@20dcb7[Main Menu]]
Tue 11/7 20:27:34.695 AWTThread Hang Detected - hang time = 3128
Tue 11/7 20:27:35.368 Fixing window size at:java.awt.Dimension[width=720,height=480]
Tue 11/7 20:27:35.369 SetFullScreen(false)
Tue 11/7 20:27:35.491 Allocated primary buffer: BufferedImage@9f2588: type = 2 DirectColorModel: rmask=ff0000 gmask=ff00 bmask=ff amask=ff000000 IntegerInterleavedRaster: width = 720 height = 480 #Bands = 4 xOff = 0 yOff = 0 dataOffset[0] 0
Tue 11/7 20:27:35.507 ImageUtils loading file H:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\Images\background.png
Tue 11/7 20:27:35.687 ImageUtils creating BI copy sun.awt.image.ToolkitImage@7bacb
Tue 11/7 20:27:36.571 ImageUtils creating scaled masked copy width=720 height=480 mask=null BufferedImage@41c977: type = 2 DirectColorModel: rmask=ff0000 gmask=ff00 bmask=ff amask=ff000000 IntegerInterleavedRaster: width = 720 height = 576 #Bands = 4 xOff = 0 yOff = 0 dataOffset[0] 0
Tue 11/7 20:27:36.599 Received command of:NOOP from Socket[addr=localhost/127.0.0.1,port=42024,localport=1360]
Tue 11/7 20:27:36.749 ImageUtils loading file H:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\Images\diskbar-green-light.png
Tue 11/7 20:27:36.770 ImageUtils creating BI copy sun.awt.image.ToolkitImage@53f0a8
Tue 11/7 20:27:36.771 ImageUtils creating scaled masked copy width=179 height=11 mask=java.awt.geom.RoundRectangle2D$Float@3508c0 BufferedImage@1d183b7: type = 2 DirectColorModel: rmask=ff0000 gmask=ff00 bmask=ff amask=ff000000 IntegerInterleavedRaster: width = 75 height = 75 #Bands = 4 xOff = 0 yOff = 0 dataOffset[0] 0
Tue 11/7 20:27:36.777 ImageUtils loading file H:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\Images\diskbar-green-dark.png
Tue 11/7 20:27:36.780 ImageUtils creating BI copy sun.awt.image.ToolkitImage@1f6d2e3
Tue 11/7 20:27:36.781 ImageUtils creating scaled masked copy width=171 height=11 mask=java.awt.geom.RoundRectangle2D$Float@d38976 BufferedImage@1e5c339: type = 2 DirectColorModel: rmask=ff0000 gmask=ff00 bmask=ff amask=ff000000 IntegerInterleavedRaster: width = 75 height = 75 #Bands = 4 xOff = 0 yOff = 0 dataOffset[0] 0
Tue 11/7 20:27:36.790 ImageUtils loading file H:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\Images\logo_stop.png
Tue 11/7 20:27:36.796 ImageUtils creating BI copy sun.awt.image.ToolkitImage@ceb6dd
Tue 11/7 20:27:36.797 ImageUtils creating scaled masked copy width=61 height=61 mask=null BufferedImage@47a8f3: type = 2 DirectColorModel: rmask=ff0000 gmask=ff00 bmask=ff amask=ff000000 IntegerInterleavedRaster: width = 65 height = 65 #Bands = 4 xOff = 0 yOff = 0 dataOffset[0] 0
Tue 11/7 20:27:36.807 ImageUtils loading file H:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\Images\hp_start.png
Tue 11/7 20:27:36.811 ImageUtils creating BI copy sun.awt.image.ToolkitImage@115c974
Tue 11/7 20:27:36.812 ImageUtils creating scaled masked copy width=86 height=95 mask=null BufferedImage@1082277: type = 2 DirectColorModel: rmask=ff0000 gmask=ff00 bmask=ff amask=ff000000 IntegerInterleavedRaster: width = 94 height = 103 #Bands = 4 xOff = 0 yOff = 0 dataOffset[0] 0
Tue 11/7 20:27:36.832 ImageUtils loading file H:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\Images\hover_my tv.png
Tue 11/7 20:27:36.867 ImageUtils creating BI copy sun.awt.image.ToolkitImage@165091f
Tue 11/7 20:27:36.895 ImageUtils creating scaled masked copy width=163 height=226 mask=null BufferedImage@8aaff4: type = 2 DirectColorModel: rmask=ff0000 gmask=ff00 bmask=ff amask=ff000000 IntegerInterleavedRaster: width = 162 height = 225 #Bands = 4 xOff = 0 yOff = 0 dataOffset[0] 0
Tue 11/7 20:27:36.908 ImageUtils loading file H:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\Images\hp_selectionbar.png
Tue 11/7 20:27:36.912 ImageUtils creating BI copy sun.awt.image.ToolkitImage@731f3f
Tue 11/7 20:27:36.913 ImageUtils creating scaled masked copy width=304 height=47 mask=null BufferedImage@10ac2a3: type = 2 DirectColorModel: rmask=ff0000 gmask=ff00 bmask=ff amask=ff000000 IntegerInterleavedRaster: width = 225 height = 49 #Bands = 4 xOff = 0 yOff = 0 dataOffset[0] 0
Tue 11/7 20:27:37.051 <XCARD> openOSD
Tue 11/7 20:27:37.333 <XCARD> updateOSD
Tue 11/7 20:27:37.334 XCARD <updateOSD>
Tue 11/7 20:27:37.334        update x=0 y=0 w=720 h=480
Tue 11/7 20:27:37.335        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:27:37.789 <XCARD> updateOSD
Tue 11/7 20:27:37.790 XCARD <updateOSD>
Tue 11/7 20:27:37.790        update x=0 y=0 w=720 h=480
Tue 11/7 20:27:37.790        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:27:38.473 VF processing job null nPlayin=false
Tue 11/7 20:27:38.474 VF thread is now waiting for 0:00:00.000
Tue 11/7 20:27:40.276 <XCARD> updateOSD
Tue 11/7 20:27:40.276 XCARD <updateOSD>
Tue 11/7 20:27:40.276        update x=0 y=0 w=720 h=480
Tue 11/7 20:27:40.276        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:27:41.600 Received command of:NOOP from Socket[addr=localhost/127.0.0.1,port=42024,localport=1360]
Tue 11/7 20:27:45.270 <XCARD> updateOSD
Tue 11/7 20:27:45.270 XCARD <updateOSD>
Tue 11/7 20:27:45.271        update x=0 y=0 w=720 h=480
Tue 11/7 20:27:45.271        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:27:46.601 Received command of:NOOP from Socket[addr=localhost/127.0.0.1,port=42024,localport=1360]
Tue 11/7 20:27:50.280 <XCARD> updateOSD
Tue 11/7 20:27:50.280 XCARD <updateOSD>
Tue 11/7 20:27:50.281        update x=0 y=0 w=720 h=480
Tue 11/7 20:27:50.281        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:27:51.602 Received command of:NOOP from Socket[addr=localhost/127.0.0.1,port=42024,localport=1360]
Tue 11/7 20:27:51.981 Disabled SS
Tue 11/7 20:27:52.352 ImageUtils loading file H:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\Images\hover_settings.png
Tue 11/7 20:27:52.367 ImageUtils creating BI copy sun.awt.image.ToolkitImage@eddac
Tue 11/7 20:27:52.369 ImageUtils creating scaled masked copy width=163 height=226 mask=null BufferedImage@189d7eb: type = 2 DirectColorModel: rmask=ff0000 gmask=ff00 bmask=ff amask=ff000000 IntegerInterleavedRaster: width = 162 height = 225 #Bands = 4 xOff = 0 yOff = 0 dataOffset[0] 0
Tue 11/7 20:27:52.485 <XCARD> updateOSD
Tue 11/7 20:27:52.486 XCARD <updateOSD>
Tue 11/7 20:27:52.486        update x=0 y=0 w=720 h=480
Tue 11/7 20:27:52.486        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:27:55.283 <XCARD> updateOSD
Tue 11/7 20:27:55.283 XCARD <updateOSD>
Tue 11/7 20:27:55.284        update x=0 y=0 w=720 h=480
Tue 11/7 20:27:55.284        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:27:56.603 Received command of:NOOP from Socket[addr=localhost/127.0.0.1,port=42024,localport=1360]
Tue 11/7 20:28:00.013 <XCARD> updateOSD
Tue 11/7 20:28:00.013 XCARD <updateOSD>
Tue 11/7 20:28:00.014        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:00.014        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:00.474 <XCARD> updateOSD
Tue 11/7 20:28:00.475 XCARD <updateOSD>
Tue 11/7 20:28:00.475        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:00.475        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:01.604 Received command of:NOOP from Socket[addr=localhost/127.0.0.1,port=42024,localport=1360]
Tue 11/7 20:28:05.268 <XCARD> updateOSD
Tue 11/7 20:28:05.269 XCARD <updateOSD>
Tue 11/7 20:28:05.269        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:05.269        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:06.606 Received command of:NOOP from Socket[addr=localhost/127.0.0.1,port=42024,localport=1360]
Tue 11/7 20:28:10.283 <XCARD> updateOSD
Tue 11/7 20:28:10.283 XCARD <updateOSD>
Tue 11/7 20:28:10.283        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:10.284        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:11.606 Received command of:NOOP from Socket[addr=localhost/127.0.0.1,port=42024,localport=1360]
Tue 11/7 20:28:13.014 ImageUtils loading URL jar:file:/H:/Program%20Files/SageTV/SageTV/Sage.jar!/images/zap2it_tv_2.gif
Tue 11/7 20:28:13.017 ImageUtils creating BI copy sun.awt.image.ToolkitImage@5113f0
Tue 11/7 20:28:13.072 setUI(sage.bz@1eb2473[Setup Menu]) histIdx=1 uiHistory=[sage.bz@20dcb7[Main Menu], sage.bz@1eb2473[Setup Menu]]
Tue 11/7 20:28:14.080 ImageUtils loading file H:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\Images\menu_list_focus.png
Tue 11/7 20:28:14.084 ImageUtils creating BI copy sun.awt.image.ToolkitImage@779959
Tue 11/7 20:28:14.085 ImageUtils creating scaled masked copy width=175 height=29 mask=null BufferedImage@1e06de8: type = 2 DirectColorModel: rmask=ff0000 gmask=ff00 bmask=ff amask=ff000000 IntegerInterleavedRaster: width = 213 height = 38 #Bands = 4 xOff = 0 yOff = 0 dataOffset[0] 0
Tue 11/7 20:28:14.326 ImageUtils loading file H:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\Images\menu_list_nofocus.png
Tue 11/7 20:28:14.399 ImageUtils creating BI copy sun.awt.image.ToolkitImage@113108b
Tue 11/7 20:28:14.401 ImageUtils creating scaled masked copy width=175 height=29 mask=null BufferedImage@1087d61: type = 2 DirectColorModel: rmask=ff0000 gmask=ff00 bmask=ff amask=ff000000 IntegerInterleavedRaster: width = 213 height = 38 #Bands = 4 xOff = 0 yOff = 0 dataOffset[0] 0
Tue 11/7 20:28:14.426 ImageUtils loading file H:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\Images\settings_logo.png
Tue 11/7 20:28:14.440 ImageUtils creating BI copy sun.awt.image.ToolkitImage@623367
Tue 11/7 20:28:14.445 ImageUtils creating scaled masked copy width=254 height=69 mask=null BufferedImage@4178d0: type = 2 DirectColorModel: rmask=ff0000 gmask=ff00 bmask=ff amask=ff000000 IntegerInterleavedRaster: width = 328 height = 89 #Bands = 4 xOff = 0 yOff = 0 dataOffset[0] 0
Tue 11/7 20:28:14.505 ImageUtils loading file H:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\Images\arrow_round_down_focus.png
Tue 11/7 20:28:14.507 ImageUtils creating BI copy sun.awt.image.ToolkitImage@863941
Tue 11/7 20:28:14.513 ImageUtils loading file H:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\Images\arrow_round_up_nofocus.png
Tue 11/7 20:28:14.518 ImageUtils creating BI copy sun.awt.image.ToolkitImage@af4627
Tue 11/7 20:28:14.607 <XCARD> updateOSD
Tue 11/7 20:28:14.608 XCARD <updateOSD>
Tue 11/7 20:28:14.608        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:14.608        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:16.099 <XCARD> updateOSD
Tue 11/7 20:28:16.109 XCARD <updateOSD>
Tue 11/7 20:28:16.117        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:16.125        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:18.168 Received command of:NOOP from Socket[addr=localhost/127.0.0.1,port=42024,localport=1360]
Tue 11/7 20:28:18.169 AWTThread Hang Detected - hang time = 2141
Tue 11/7 20:28:18.280 <XCARD> updateOSD
Tue 11/7 20:28:18.282 XCARD <updateOSD>
Tue 11/7 20:28:18.284        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:18.286        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:18.987 <XCARD> updateOSD
Tue 11/7 20:28:18.987 XCARD <updateOSD>
Tue 11/7 20:28:18.990        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:18.991        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:19.688 <XCARD> updateOSD
Tue 11/7 20:28:19.689 XCARD <updateOSD>
Tue 11/7 20:28:19.691        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:19.692        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:20.363 <XCARD> updateOSD
Tue 11/7 20:28:20.364 XCARD <updateOSD>
Tue 11/7 20:28:20.366        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:20.368        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:21.117 setUI(sage.bz@2136c6[Detailed Setup]) histIdx=2 uiHistory=[sage.bz@20dcb7[Main Menu], sage.bz@1eb2473[Setup Menu], sage.bz@2136c6[Detailed Setup]]
Tue 11/7 20:28:21.603 ImageUtils loading file H:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\Images\button_green_focus_150x32.png
Tue 11/7 20:28:21.610 ImageUtils creating BI copy sun.awt.image.ToolkitImage@e674d6
Tue 11/7 20:28:21.613 ImageUtils creating scaled masked copy width=182 height=34 mask=null BufferedImage@f97d27: type = 2 DirectColorModel: rmask=ff0000 gmask=ff00 bmask=ff amask=ff000000 IntegerInterleavedRaster: width = 154 height = 38 #Bands = 4 xOff = 0 yOff = 0 dataOffset[0] 0
Tue 11/7 20:28:21.776 <XCARD> updateOSD
Tue 11/7 20:28:21.777 XCARD <updateOSD>
Tue 11/7 20:28:21.777        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:21.777        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:23.169 Received command of:NOOP from Socket[addr=localhost/127.0.0.1,port=42024,localport=1360]
Tue 11/7 20:28:23.249 ImageUtils creating scaled masked copy width=182 height=30 mask=null BufferedImage@f97d27: type = 2 DirectColorModel: rmask=ff0000 gmask=ff00 bmask=ff amask=ff000000 IntegerInterleavedRaster: width = 154 height = 38 #Bands = 4 xOff = 0 yOff = 0 dataOffset[0] 0
Tue 11/7 20:28:23.422 <XCARD> updateOSD
Tue 11/7 20:28:23.422 XCARD <updateOSD>
Tue 11/7 20:28:23.423        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:23.423        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:24.148 <XCARD> updateOSD
Tue 11/7 20:28:24.149 XCARD <updateOSD>
Tue 11/7 20:28:24.149        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:24.149        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:24.589 ImageUtils loading file H:\Program Files\SageTV\SageTV\STVs\SageTV3\down.png
Tue 11/7 20:28:24.591 ImageUtils creating BI copy sun.awt.image.ToolkitImage@4703c
Tue 11/7 20:28:24.592 ImageUtils creating scaled masked copy width=33 height=31 mask=null BufferedImage@1c4bcda: type = 2 DirectColorModel: rmask=ff0000 gmask=ff00 bmask=ff amask=ff000000 IntegerInterleavedRaster: width = 26 height = 25 #Bands = 4 xOff = 0 yOff = 0 dataOffset[0] 0
Tue 11/7 20:28:24.671 <XCARD> updateOSD
Tue 11/7 20:28:24.672 XCARD <updateOSD>
Tue 11/7 20:28:24.672        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:24.672        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:25.424 <XCARD> updateOSD
Tue 11/7 20:28:25.425 XCARD <updateOSD>
Tue 11/7 20:28:25.425        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:25.425        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:26.224 <XCARD> updateOSD
Tue 11/7 20:28:26.225 XCARD <updateOSD>
Tue 11/7 20:28:26.225        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:26.225        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:26.701 <XCARD> updateOSD
Tue 11/7 20:28:26.701 XCARD <updateOSD>
Tue 11/7 20:28:26.701        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:26.702        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:27.210 <XCARD> updateOSD
Tue 11/7 20:28:27.211 XCARD <updateOSD>
Tue 11/7 20:28:27.211        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:27.211        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:27.770 processOptionsMenu optionsMenu=default:null|OptionsMenu:RightSideFileBrower
Tue 11/7 20:28:28.030 ImageUtils loading file H:\Program Files\SageTV\SageTV\STVs\SageTV3\folder.png
Tue 11/7 20:28:28.035 ImageUtils creating BI copy sun.awt.image.ToolkitImage@d591a6
Tue 11/7 20:28:28.037 ImageUtils creating scaled masked copy width=37 height=30 mask=null BufferedImage@147788d: type = 2 DirectColorModel: rmask=ff0000 gmask=ff00 bmask=ff amask=ff000000 IntegerInterleavedRaster: width = 65 height = 53 #Bands = 4 xOff = 0 yOff = 0 dataOffset[0] 0
Tue 11/7 20:28:28.059 ImageUtils creating scaled masked copy width=21 height=20 mask=null BufferedImage@1c4bcda: type = 2 DirectColorModel: rmask=ff0000 gmask=ff00 bmask=ff amask=ff000000 IntegerInterleavedRaster: width = 26 height = 25 #Bands = 4 xOff = 0 yOff = 0 dataOffset[0] 0
Tue 11/7 20:28:28.109 <XCARD> updateOSD
Tue 11/7 20:28:28.110 XCARD <updateOSD>
Tue 11/7 20:28:28.110        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:28.110        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:28.170 Received command of:NOOP from Socket[addr=localhost/127.0.0.1,port=42024,localport=1360]
Tue 11/7 20:28:29.364 <XCARD> updateOSD
Tue 11/7 20:28:29.365 XCARD <updateOSD>
Tue 11/7 20:28:29.365        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:29.365        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:30.165 processOptionsMenu optionsMenu=default:null|OptionsMenu:LoadNewSTVConfirm
Tue 11/7 20:28:30.384 <XCARD> updateOSD
Tue 11/7 20:28:30.384 XCARD <updateOSD>
Tue 11/7 20:28:30.385        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:30.385        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:31.140 <XCARD> updateOSD
Tue 11/7 20:28:31.141 XCARD <updateOSD>
Tue 11/7 20:28:31.141        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:31.141        video  x=-1 y=-1 w=0 h=0
tv.sage.b: kind=1; Module.loadXML failure
Tue 11/7 20:28:32.467 	at tv.sage.b.k.a(Unknown Source)
Tue 11/7 20:28:32.468 	at tv.sage.c.a(Unknown Source)
Tue 11/7 20:28:32.468 	at tv.sage.e.a(Unknown Source)
Tue 11/7 20:28:32.468 	at sage.UIManager.a(Unknown Source)
Tue 11/7 20:28:32.468 	at sage.c.l$1.new(Unknown Source)
Tue 11/7 20:28:32.468 	at sage.at.a(Unknown Source)
Tue 11/7 20:28:32.469 	at sage.d.d.a(Unknown Source)
Tue 11/7 20:28:32.469 	at sage.d.c.a(Unknown Source)
Tue 11/7 20:28:32.469 	at sage.d.d.a(Unknown Source)
Tue 11/7 20:28:32.469 	at sage.d.m.a(Unknown Source)
Tue 11/7 20:28:32.469 	at sage.d.a(Unknown Source)
Tue 11/7 20:28:32.471 	at sage.a6.a(Unknown Source)
Tue 11/7 20:28:32.471 	at sage.a6.a(Unknown Source)
Tue 11/7 20:28:32.472 	at sage.a6.actionPerformed(Unknown Source)
Tue 11/7 20:28:32.472 	at sage.a6.for(Unknown Source)
Tue 11/7 20:28:32.472 	at sage.bz.byte(Unknown Source)
Tue 11/7 20:28:32.472 	at sage.EventRouter.a(Unknown Source)
Tue 11/7 20:28:32.472 	at sage.EventRouter.do(Unknown Source)
Tue 11/7 20:28:32.472 	at sage.EventRouter.keyPressed(Unknown Source)
Tue 11/7 20:28:32.473 	at java.awt.Component.processKeyEvent(Unknown Source)
Tue 11/7 20:28:32.473 	at java.awt.Component.processEvent(Unknown Source)
Tue 11/7 20:28:32.473 	at java.awt.Component.dispatchEventImpl(Unknown Source)
Tue 11/7 20:28:32.473 	at java.awt.Component.dispatchEvent(Unknown Source)
Tue 11/7 20:28:32.473 	at java.awt.KeyboardFocusManager.redispatchEvent(Unknown Source)
Tue 11/7 20:28:32.474 	at java.awt.DefaultKeyboardFocusManager.dispatchKeyEvent(Unknown Source)
Tue 11/7 20:28:32.474 	at java.awt.DefaultKeyboardFocusManager.preDispatchKeyEvent(Unknown Source)
Tue 11/7 20:28:32.474 	at java.awt.DefaultKeyboardFocusManager.typeAheadAssertions(Unknown Source)
Tue 11/7 20:28:32.474 	at java.awt.DefaultKeyboardFocusManager.dispatchEvent(Unknown Source)
Tue 11/7 20:28:32.474 	at java.awt.Component.dispatchEventImpl(Unknown Source)
Tue 11/7 20:28:32.474 	at java.awt.Component.dispatchEvent(Unknown Source)
Tue 11/7 20:28:32.475 	at java.awt.EventQueue.dispatchEvent(Unknown Source)
Tue 11/7 20:28:32.475 	at java.awt.EventDispatchThread.pumpOneEventForHierarchy(Unknown Source)
Tue 11/7 20:28:32.475 	at java.awt.EventDispatchThread.pumpEventsForHierarchy(Unknown Source)
Tue 11/7 20:28:32.475 	at java.awt.EventDispatchThread.pumpEvents(Unknown Source)
Tue 11/7 20:28:32.475 	at java.awt.EventDispatchThread.pumpEvents(Unknown Source)
Tue 11/7 20:28:32.476 	at java.awt.EventDispatchThread.run(Unknown Source)
Tue 11/7 20:28:32.476 Caused by: org.xml.sax.SAXException: unrecognized tag BackgroundComponent
Tue 11/7 20:28:32.476 	at tv.sage.a.c$a.startElement(Unknown Source)
Tue 11/7 20:28:32.477 	at com.sun.org.apache.xerces.internal.parsers.AbstractSAXParser.startElement(Unknown Source)
Tue 11/7 20:28:32.477 	at com.sun.org.apache.xerces.internal.impl.XMLNSDocumentScannerImpl.scanStartElement(Unknown Source)
Tue 11/7 20:28:32.477 	at com.sun.org.apache.xerces.internal.impl.XMLDocumentFragmentScannerImpl$FragmentContentDispatcher.dispatch(Unknown Source)
Tue 11/7 20:28:32.477 	at com.sun.org.apache.xerces.internal.impl.XMLDocumentFragmentScannerImpl.scanDocument(Unknown Source)
Tue 11/7 20:28:32.478 	at com.sun.org.apache.xerces.internal.parsers.XML11Configuration.parse(Unknown Source)
Tue 11/7 20:28:32.478 	at com.sun.org.apache.xerces.internal.parsers.XML11Configuration.parse(Unknown Source)
Tue 11/7 20:28:32.478 	at com.sun.org.apache.xerces.internal.parsers.XMLParser.parse(Unknown Source)
Tue 11/7 20:28:32.478 	at com.sun.org.apache.xerces.internal.parsers.AbstractSAXParser.parse(Unknown Source)
Tue 11/7 20:28:32.478 	at tv.sage.a.c.a(Unknown Source)
Tue 11/7 20:28:32.478 	... 36 more
Tue 11/7 20:28:32.513 setUI(sage.bz@149494e[Main Menu]) histIdx=0 uiHistory=[sage.bz@149494e[Main Menu]]
Tue 11/7 20:28:32.549 AWTThread Hang Detected - hang time = 752
Tue 11/7 20:28:32.668 <XCARD> updateOSD
Tue 11/7 20:28:33.172 Received command of:NOOP from Socket[addr=localhost/127.0.0.1,port=42024,localport=1360]
Tue 11/7 20:28:33.173 XCARD <updateOSD>
Tue 11/7 20:28:33.174        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:33.174        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:33.604 <XCARD> updateOSD
Tue 11/7 20:28:33.605 XCARD <updateOSD>
Tue 11/7 20:28:33.605        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:33.605        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:34.017 <XCARD> updateOSD
Tue 11/7 20:28:34.017 XCARD <updateOSD>
Tue 11/7 20:28:34.017        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:34.018        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:35.686 <XCARD> updateOSD
Tue 11/7 20:28:35.687 XCARD <updateOSD>
Tue 11/7 20:28:35.687        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:35.687        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:36.418 ImageUtils loading file H:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\Images\hover_my explorer.png
Tue 11/7 20:28:36.443 ImageUtils creating BI copy sun.awt.image.ToolkitImage@12fae6c
Tue 11/7 20:28:36.445 ImageUtils creating scaled masked copy width=163 height=226 mask=null BufferedImage@4eb471: type = 2 DirectColorModel: rmask=ff0000 gmask=ff00 bmask=ff amask=ff000000 IntegerInterleavedRaster: width = 162 height = 225 #Bands = 4 xOff = 0 yOff = 0 dataOffset[0] 0
Tue 11/7 20:28:36.512 <XCARD> updateOSD
Tue 11/7 20:28:36.512 XCARD <updateOSD>
Tue 11/7 20:28:36.512        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:36.512        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:37.364 setUI(sage.bz@6489f0[Dynamic Menu by nielm]) histIdx=1 uiHistory=[sage.bz@149494e[Main Menu], sage.bz@6489f0[Dynamic Menu by nielm]]
Tue 11/7 20:28:37.372 Loading Menu
Tue 11/7 20:28:37.455 Failed to build MainMenu from H:\Program Files\SageTV\SageTV\menu.xml
Tue 11/7 20:28:37.455 SageMenu definition file H:\Program Files\SageTV\SageTV\menu.xml does not exist

net.sf.sageplugins.sagemenu.MenuException: SageMenu definition file H:\Program Files\SageTV\SageTV\menu.xml does not exist
Tue 11/7 20:28:37.456 	at net.sf.sageplugins.sagemenu.SageMenuReader.readMenuFile(SageMenuReader.java:53)
Tue 11/7 20:28:37.457 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
Tue 11/7 20:28:37.457 	at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
Tue 11/7 20:28:37.457 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
Tue 11/7 20:28:37.457 	at java.lang.reflect.Method.invoke(Unknown Source)
Tue 11/7 20:28:37.458 	at sage.d$d.a(Unknown Source)
Tue 11/7 20:28:37.458 	at sage.d.d.a(Unknown Source)
Tue 11/7 20:28:37.458 	at sage.d.c.a(Unknown Source)
Tue 11/7 20:28:37.458 	at sage.d.d.a(Unknown Source)
Tue 11/7 20:28:37.458 	at sage.d.m.a(Unknown Source)
Tue 11/7 20:28:37.458 	at sage.d.a(Unknown Source)
Tue 11/7 20:28:37.459 	at sage.a6.a(Unknown Source)
Tue 11/7 20:28:37.459 	at sage.a6.a(Unknown Source)
Tue 11/7 20:28:37.459 	at sage.d.a(Unknown Source)
Tue 11/7 20:28:37.459 	at sage.d.a(Unknown Source)
Tue 11/7 20:28:37.459 	at sage.d.a(Unknown Source)
Tue 11/7 20:28:37.487 	at sage.bz.G(Unknown Source)
Tue 11/7 20:28:37.487 	at sage.UIManager.a(Unknown Source)
Tue 11/7 20:28:37.488 	at sage.UIManager.a(Unknown Source)
Tue 11/7 20:28:37.488 	at sage.UIManager.a(Unknown Source)
Tue 11/7 20:28:37.488 	at sage.a6.a(Unknown Source)
Tue 11/7 20:28:37.488 	at sage.a6.a(Unknown Source)
Tue 11/7 20:28:37.488 	at sage.a6.actionPerformed(Unknown Source)
Tue 11/7 20:28:37.488 	at sage.a6.for(Unknown Source)
Tue 11/7 20:28:37.489 	at sage.bz.byte(Unknown Source)
Tue 11/7 20:28:37.489 	at sage.EventRouter.a(Unknown Source)
Tue 11/7 20:28:37.489 	at sage.EventRouter.do(Unknown Source)
Tue 11/7 20:28:37.489 	at sage.EventRouter.keyPressed(Unknown Source)
Tue 11/7 20:28:37.489 	at java.awt.Component.processKeyEvent(Unknown Source)
Tue 11/7 20:28:37.490 	at java.awt.Component.processEvent(Unknown Source)
Tue 11/7 20:28:37.490 	at java.awt.Component.dispatchEventImpl(Unknown Source)
Tue 11/7 20:28:37.490 	at java.awt.Component.dispatchEvent(Unknown Source)
Tue 11/7 20:28:37.490 	at java.awt.KeyboardFocusManager.redispatchEvent(Unknown Source)
Tue 11/7 20:28:37.490 	at java.awt.DefaultKeyboardFocusManager.dispatchKeyEvent(Unknown Source)
Tue 11/7 20:28:37.490 	at java.awt.DefaultKeyboardFocusManager.preDispatchKeyEvent(Unknown Source)
Tue 11/7 20:28:37.491 	at java.awt.DefaultKeyboardFocusManager.typeAheadAssertions(Unknown Source)
Tue 11/7 20:28:37.491 	at java.awt.DefaultKeyboardFocusManager.dispatchEvent(Unknown Source)
Tue 11/7 20:28:37.491 	at java.awt.Component.dispatchEventImpl(Unknown Source)
Tue 11/7 20:28:37.491 	at java.awt.Component.dispatchEvent(Unknown Source)
Tue 11/7 20:28:37.491 	at java.awt.EventQueue.dispatchEvent(Unknown Source)
Tue 11/7 20:28:37.491 	at java.awt.EventDispatchThread.pumpOneEventForHierarchy(Unknown Source)
Tue 11/7 20:28:37.492 	at java.awt.EventDispatchThread.pumpEventsForHierarchy(Unknown Source)
Tue 11/7 20:28:37.492 	at java.awt.EventDispatchThread.pumpEvents(Unknown Source)
Tue 11/7 20:28:37.493 	at java.awt.EventDispatchThread.pumpEvents(Unknown Source)
Tue 11/7 20:28:37.494 	at java.awt.EventDispatchThread.run(Unknown Source)
Tue 11/7 20:28:37.495 MenuTree Loaded
Tue 11/7 20:28:37.495 Setting root menu widget
Tue 11/7 20:28:38.163 ImageUtils loading file H:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\Images\select_logo.png
Tue 11/7 20:28:38.169 ImageUtils creating BI copy sun.awt.image.ToolkitImage@481958
Tue 11/7 20:28:38.170 ImageUtils creating scaled masked copy width=246 height=69 mask=null BufferedImage@1544e44: type = 2 DirectColorModel: rmask=ff0000 gmask=ff00 bmask=ff amask=ff000000 IntegerInterleavedRaster: width = 250 height = 70 #Bands = 4 xOff = 0 yOff = 0 dataOffset[0] 0
Tue 11/7 20:28:38.173 Received command of:NOOP from Socket[addr=localhost/127.0.0.1,port=42024,localport=1360]
Tue 11/7 20:28:38.238 <XCARD> updateOSD
Tue 11/7 20:28:38.238 XCARD <updateOSD>
Tue 11/7 20:28:38.238        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:38.239        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:40.307 processOptionsMenu optionsMenu=default:null|OptionsMenu:Options
Tue 11/7 20:28:40.377 ImageUtils creating scaled masked copy width=283 height=28 mask=null BufferedImage@1e06de8: type = 2 DirectColorModel: rmask=ff0000 gmask=ff00 bmask=ff amask=ff000000 IntegerInterleavedRaster: width = 213 height = 38 #Bands = 4 xOff = 0 yOff = 0 dataOffset[0] 0
Tue 11/7 20:28:40.381 ImageUtils creating scaled masked copy width=283 height=28 mask=null BufferedImage@1087d61: type = 2 DirectColorModel: rmask=ff0000 gmask=ff00 bmask=ff amask=ff000000 IntegerInterleavedRaster: width = 213 height = 38 #Bands = 4 xOff = 0 yOff = 0 dataOffset[0] 0
Tue 11/7 20:28:40.456 <XCARD> updateOSD
Tue 11/7 20:28:40.457 XCARD <updateOSD>
Tue 11/7 20:28:40.458        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:40.459        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:41.398 <XCARD> updateOSD
Tue 11/7 20:28:41.399 XCARD <updateOSD>
Tue 11/7 20:28:41.399        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:41.400        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:42.356 processOptionsMenu optionsMenu=default:null|OptionsMenu:Options
Tue 11/7 20:28:42.472 <XCARD> updateOSD
Tue 11/7 20:28:42.472 XCARD <updateOSD>
Tue 11/7 20:28:42.473        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:42.473        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:43.127 <XCARD> updateOSD
Tue 11/7 20:28:43.129 XCARD <updateOSD>
Tue 11/7 20:28:43.129        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:43.130        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:43.174 Received command of:NOOP from Socket[addr=localhost/127.0.0.1,port=42024,localport=1360]
Tue 11/7 20:28:43.683 <XCARD> updateOSD
Tue 11/7 20:28:43.684 XCARD <updateOSD>
Tue 11/7 20:28:43.684        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:43.684        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:44.029 processOptionsMenu optionsMenu=default:null|OptionsMenu:Prompt Internal Screen
Tue 11/7 20:28:44.336 ImageUtils creating scaled masked copy width=337 height=28 mask=null BufferedImage@1e06de8: type = 2 DirectColorModel: rmask=ff0000 gmask=ff00 bmask=ff amask=ff000000 IntegerInterleavedRaster: width = 213 height = 38 #Bands = 4 xOff = 0 yOff = 0 dataOffset[0] 0
Tue 11/7 20:28:44.340 ImageUtils creating scaled masked copy width=337 height=52 mask=null BufferedImage@1087d61: type = 2 DirectColorModel: rmask=ff0000 gmask=ff00 bmask=ff amask=ff000000 IntegerInterleavedRaster: width = 213 height = 38 #Bands = 4 xOff = 0 yOff = 0 dataOffset[0] 0
Tue 11/7 20:28:44.403 <XCARD> updateOSD
Tue 11/7 20:28:44.404 XCARD <updateOSD>
Tue 11/7 20:28:44.404        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:44.404        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:45.899 ImageUtils creating scaled masked copy width=337 height=28 mask=null BufferedImage@1087d61: type = 2 DirectColorModel: rmask=ff0000 gmask=ff00 bmask=ff amask=ff000000 IntegerInterleavedRaster: width = 213 height = 38 #Bands = 4 xOff = 0 yOff = 0 dataOffset[0] 0
Tue 11/7 20:28:45.916 ImageUtils creating scaled masked copy width=337 height=52 mask=null BufferedImage@1e06de8: type = 2 DirectColorModel: rmask=ff0000 gmask=ff00 bmask=ff amask=ff000000 IntegerInterleavedRaster: width = 213 height = 38 #Bands = 4 xOff = 0 yOff = 0 dataOffset[0] 0
Tue 11/7 20:28:45.946 <XCARD> updateOSD
Tue 11/7 20:28:45.946 XCARD <updateOSD>
Tue 11/7 20:28:45.946        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:45.947        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:46.563 <XCARD> updateOSD
Tue 11/7 20:28:46.564 XCARD <updateOSD>
Tue 11/7 20:28:46.564        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:46.564        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:47.213 <XCARD> updateOSD
Tue 11/7 20:28:47.213 XCARD <updateOSD>
Tue 11/7 20:28:47.214        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:47.214        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:47.864 <XCARD> updateOSD
Tue 11/7 20:28:47.865 XCARD <updateOSD>
Tue 11/7 20:28:47.865        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:47.866        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:48.176 Received command of:NOOP from Socket[addr=localhost/127.0.0.1,port=42024,localport=1360]
Tue 11/7 20:28:48.533 <XCARD> updateOSD
Tue 11/7 20:28:48.534 XCARD <updateOSD>
Tue 11/7 20:28:48.534        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:48.534        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:49.157 <XCARD> updateOSD
Tue 11/7 20:28:49.158 XCARD <updateOSD>
Tue 11/7 20:28:49.158        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:49.158        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:49.823 <XCARD> updateOSD
Tue 11/7 20:28:49.823 XCARD <updateOSD>
Tue 11/7 20:28:49.824        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:49.824        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:50.470 <XCARD> updateOSD
Tue 11/7 20:28:50.470 XCARD <updateOSD>
Tue 11/7 20:28:50.471        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:50.471        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:51.140 <XCARD> updateOSD
Tue 11/7 20:28:51.141 XCARD <updateOSD>
Tue 11/7 20:28:51.141        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:51.141        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:51.844 <XCARD> updateOSD
Tue 11/7 20:28:51.844 XCARD <updateOSD>
Tue 11/7 20:28:51.844        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:51.849        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:52.457 <XCARD> updateOSD
Tue 11/7 20:28:52.458 XCARD <updateOSD>
Tue 11/7 20:28:52.458        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:52.458        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:53.063 <XCARD> updateOSD
Tue 11/7 20:28:53.064 XCARD <updateOSD>
Tue 11/7 20:28:53.064        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:53.065        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:53.177 Received command of:NOOP from Socket[addr=localhost/127.0.0.1,port=42024,localport=1360]
Tue 11/7 20:28:53.662 <XCARD> updateOSD
Tue 11/7 20:28:53.662 XCARD <updateOSD>
Tue 11/7 20:28:53.663        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:53.663        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:54.223 <XCARD> updateOSD
Tue 11/7 20:28:54.224 XCARD <updateOSD>
Tue 11/7 20:28:54.224        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:54.224        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:56.503 <XCARD> updateOSD
Tue 11/7 20:28:56.503 XCARD <updateOSD>
Tue 11/7 20:28:56.503        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:56.504        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:58.104 <XCARD> updateOSD
Tue 11/7 20:28:58.105 XCARD <updateOSD>
Tue 11/7 20:28:58.105        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:58.105        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:28:58.178 Received command of:NOOP from Socket[addr=localhost/127.0.0.1,port=42024,localport=1360]
Tue 11/7 20:28:59.755 <XCARD> updateOSD
Tue 11/7 20:28:59.756 XCARD <updateOSD>
Tue 11/7 20:28:59.756        update x=0 y=0 w=720 h=480
Tue 11/7 20:28:59.756        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:29:00.326 <XCARD> updateOSD
Tue 11/7 20:29:00.327 XCARD <updateOSD>
Tue 11/7 20:29:00.327        update x=0 y=0 w=720 h=480
Tue 11/7 20:29:00.327        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:29:03.112 <XCARD> updateOSD
Tue 11/7 20:29:03.112 XCARD <updateOSD>
Tue 11/7 20:29:03.112        update x=0 y=0 w=720 h=480
Tue 11/7 20:29:03.113        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:29:03.179 Received command of:NOOP from Socket[addr=localhost/127.0.0.1,port=42024,localport=1360]
Tue 11/7 20:29:03.719 <XCARD> updateOSD
Tue 11/7 20:29:03.720 XCARD <updateOSD>
Tue 11/7 20:29:03.720        update x=0 y=0 w=720 h=480
Tue 11/7 20:29:03.720        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:29:08.099 <XCARD> updateOSD
Tue 11/7 20:29:08.100 XCARD <updateOSD>
Tue 11/7 20:29:08.100        update x=0 y=0 w=720 h=480
Tue 11/7 20:29:08.100        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:29:08.180 Received command of:NOOP from Socket[addr=localhost/127.0.0.1,port=42024,localport=1360]
Tue 11/7 20:29:08.689 <XCARD> updateOSD
Tue 11/7 20:29:08.690 XCARD <updateOSD>
Tue 11/7 20:29:08.690        update x=0 y=0 w=720 h=480
Tue 11/7 20:29:08.690        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:29:11.730 <XCARD> updateOSD
Tue 11/7 20:29:11.731 XCARD <updateOSD>
Tue 11/7 20:29:11.731        update x=0 y=0 w=720 h=480
Tue 11/7 20:29:11.731        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:29:13.121 <XCARD> updateOSD
Tue 11/7 20:29:13.121 XCARD <updateOSD>
Tue 11/7 20:29:13.122        update x=0 y=0 w=720 h=480
Tue 11/7 20:29:13.122        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:29:13.181 Received command of:NOOP from Socket[addr=localhost/127.0.0.1,port=42024,localport=1360]
Tue 11/7 20:29:13.828 <XCARD> updateOSD
Tue 11/7 20:29:13.829 XCARD <updateOSD>
Tue 11/7 20:29:13.829        update x=0 y=0 w=720 h=480
Tue 11/7 20:29:13.829        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:29:15.019 <XCARD> updateOSD
Tue 11/7 20:29:15.020 XCARD <updateOSD>
Tue 11/7 20:29:15.020        update x=0 y=0 w=720 h=480
Tue 11/7 20:29:15.020        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:29:18.109 <XCARD> updateOSD
Tue 11/7 20:29:18.109 XCARD <updateOSD>
Tue 11/7 20:29:18.110        update x=0 y=0 w=720 h=480
Tue 11/7 20:29:18.110        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:29:18.182 Received command of:NOOP from Socket[addr=localhost/127.0.0.1,port=42024,localport=1360]
Tue 11/7 20:29:19.132 <XCARD> updateOSD
Tue 11/7 20:29:19.132 XCARD <updateOSD>
Tue 11/7 20:29:19.133        update x=0 y=0 w=720 h=480
Tue 11/7 20:29:19.133        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:29:22.258 setUI(sage.bz@149494e[Main Menu]) histIdx=2 uiHistory=[sage.bz@149494e[Main Menu], sage.bz@6489f0[Dynamic Menu by nielm], sage.bz@149494e[Main Menu]]
Tue 11/7 20:29:22.956 <XCARD> updateOSD
Tue 11/7 20:29:22.957 XCARD <updateOSD>
Tue 11/7 20:29:22.958        update x=0 y=0 w=720 h=480
Tue 11/7 20:29:22.958        video  x=-1 y=-1 w=0 h=0
Tue 11/7 20:29:23.183 Received command of:NOOP from Socket[addr=localhost/127.0.0.1,port=42024,localport=1360]
Tue 11/7 20:29:25.733 Removed system shell hook
Tue 11/7 20:29:25.734 Sage.exit() called.
Tue 11/7 20:29:25.734 Cleaning up servers
Tue 11/7 20:29:25.734 Cleaning up PM
Tue 11/7 20:29:25.735 Enabled SS
Tue 11/7 20:29:25.735 Killed Carny.
Tue 11/7 20:29:25.736 Killed Scheduler.
Tue 11/7 20:29:25.739 Killed Seeker.
Tue 11/7 20:29:25.740 Cleaning up c/s connection
Tue 11/7 20:29:25.740 Killed EPG.
Tue 11/7 20:29:25.758 VF processing job null nPlayin=false
Tue 11/7 20:29:25.759 Connection lost from: null by:java.net.SocketException: socket closed
Tue 11/7 20:29:25.760 Killed MMC.
Tue 11/7 20:29:25.761 VideoFrame thread is now exiting
Tue 11/7 20:29:25.761 Killing UIMgr UIManager:localhost@@SAGETV_PROCESS_LOCAL_UI
Tue 11/7 20:29:25.762 Killed UI Timers
Tue 11/7 20:29:25.763 Cleaning up c/s connection
Tue 11/7 20:29:25.764 NetworkManager CommunicationFailure : /127.0.0.1:42024 type=2
Tue 11/7 20:29:25.766 Killed VideoFrame
Tue 11/7 20:29:25.770 Killed EventRouter
Tue 11/7 20:29:25.771 Killed Studio
Tue 11/7 20:29:25.881 <XCARD> closeOSD
Tue 11/7 20:29:26.621 AWTThread Hang Detected - hang time = 750
Tue 11/7 20:29:27.371 AWTThread Hang Detected - hang time = 1500
Tue 11/7 20:29:27.771 Killed RootPanel
Tue 11/7 20:29:27.897 Disposed Window
Tue 11/7 20:29:27.897 Killed UIManager.
Tue 11/7 20:29:27.898 Killed Wizard.
Tue 11/7 20:29:27.898 Cleaning up c/s connection
Tue 11/7 20:29:27.901 Error communicating with server:java.net.SocketException: Socket closed
Tue 11/7 20:29:27.902 Cleaning up c/s connection
Tue 11/7 20:29:27.923 NetworkManager CommunicationFailure : /127.0.0.1:42024 type=1
Tue 11/7 20:29:27.924 MsgRecv thread is terminating for /127.0.0.1:42024
Tue 11/7 20:29:27.968 Bye-bye.
Tue 11/7 20:29:27.972 SageTV SHUTDOWN is activating!