Sat 11/18 14:05:31.122 user.dir2=C:\Program Files\SageTV\SageTV Sat 11/18 14:05:31.124 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-codec-1.3.jar;JARs\commons-httpclient-2.0.2.jar;JARs\commons-httpclient-3.0.jar;JARs\commons-jxpath-1.1.jar;JARs\commons-logging-1.0.4.jar;JARs\commons-logging-api.jar;JARs\commons-logging.jar;JARs\jcifs-1.1.6.jar;JARs\jdic.jar;JARs\lib_odi.jar;JARs\mx4j-impl.jar;JARs\mx4j-jmx.jar;JARs\mx4j-remote.jar;JARs\mx4j-tools.jar;JARs\netflix.jar;JARs\nielm_getrssnews.jar;JARs\nielm_sageimdb.jar;JARs\nielm_sagemenureader.jar;JARs\nielm_sageutls.jar;JARs\rsslib4j-0.2.jar;JARs\sagemc.jar;JARs\sbbi-jmx-1.0.jar;JARs\sbbi-upnplib-1.0.3.jar;JARs\stusals_gif_anim_parser.jar;JARs\stusals_wrs.jar;JARs\xml-apis.jar Sat 11/18 14:05:31.129 JVM version=1.6.0-rc Sat 11/18 14:05:31.130 OS=Windows XP 5.1 Sat 11/18 14:05:31.131 Succesfully setup system shell hook Sat 11/18 14:05:31.131 specifiy RawInputHook Enable 0 in registery Sat 11/18 14:05:31.131 not specifiy WinkeyboardHook in registery, load default one Sat 11/18 14:05:31.484 ImageUtils loading URL jar:file:/C:/Program%20Files/SageTV/SageTV/Sage.jar!/images/splash.gif Sat 11/18 14:05:31.504 ImageUtils creating BI copy sun.awt.image.ToolkitImage@a613f8 w=520 h=350 freeMem=22391896 totalMem=25034752 Sat 11/18 14:05:31.542 SageTV V6.0.14.112 Sat 11/18 14:05:31.555 hostname=hal Sat 11/18 14:05:31.640 ImageUtils loading URL jar:file:/C:/Program%20Files/SageTV/SageTV/Sage.jar!/images/tvicon.gif Sat 11/18 14:05:31.660 ImageUtils creating BI copy sun.awt.image.ToolkitImage@1e228bc w=32 h=32 freeMem=20914080 totalMem=25034752 Sat 11/18 14:05:31.816 ImageUtils loading URL jar:file:/C:/Program%20Files/SageTV/SageTV/Sage.jar!/images/tvicon_anim0.gif Sat 11/18 14:05:31.834 ImageUtils creating BI copy sun.awt.image.ToolkitImage@8ab708 w=32 h=32 freeMem=20322928 totalMem=25034752 Sat 11/18 14:05:31.835 ImageUtils loading URL jar:file:/C:/Program%20Files/SageTV/SageTV/Sage.jar!/images/tvicon_anim1.gif Sat 11/18 14:05:31.838 ImageUtils creating BI copy sun.awt.image.ToolkitImage@5b8827 w=32 h=32 freeMem=20259264 totalMem=25034752 Sat 11/18 14:05:31.840 ImageUtils loading URL jar:file:/C:/Program%20Files/SageTV/SageTV/Sage.jar!/images/tvicon_anim2.gif Sat 11/18 14:05:31.844 ImageUtils creating BI copy sun.awt.image.ToolkitImage@cd2e33 w=32 h=32 freeMem=20195632 totalMem=25034752 Sat 11/18 14:05:31.845 ImageUtils loading URL jar:file:/C:/Program%20Files/SageTV/SageTV/Sage.jar!/images/tvicon_anim3.gif Sat 11/18 14:05:31.848 ImageUtils creating BI copy sun.awt.image.ToolkitImage@10d593e w=32 h=32 freeMem=20116280 totalMem=25034752 Sat 11/18 14:05:32.000 WARNING - MissingResource: "Judge" Sat 11/18 14:05:32.000 WARNING - MissingResource: "Narrator" Sat 11/18 14:05:32.028 Wizard starting to load database info... Sat 11/18 14:05:32.030 Wizard DONE loading database info. loadTime=0.0020 sec Sat 11/18 14:05:32.121 SageTV received connection from:Socket[addr=/127.0.0.1,port=42024,localport=1717] Sat 11/18 14:05:34.981 Wizard allocating table for Year of size 82 Sat 11/18 14:05:34.982 Wizard loading main index for Year Sat 11/18 14:05:34.983 Wizard allocating table for Network of size 1 Sat 11/18 14:05:34.983 Wizard loading main index for Network Sat 11/18 14:05:34.983 Wizard allocating table for Title of size 1893 Sat 11/18 14:05:34.986 Wizard loading main index for Title Sat 11/18 14:05:35.018 Wizard building alt. index 0 for Title Sat 11/18 14:05:35.026 Wizard allocating table for Channel of size 48 Sat 11/18 14:05:35.026 Wizard loading main index for Channel Sat 11/18 14:05:35.027 Wizard allocating table for People of size 5313 Sat 11/18 14:05:35.028 Wizard loading main index for People Sat 11/18 14:05:35.161 Wizard building alt. index 0 for People Sat 11/18 14:05:35.165 Wizard allocating table for SubCategory of size 6 Sat 11/18 14:05:35.166 Wizard loading main index for SubCategory Sat 11/18 14:05:35.166 Wizard allocating table for Rated of size 1 Sat 11/18 14:05:35.166 Wizard loading main index for Rated Sat 11/18 14:05:35.167 Wizard allocating table for ParentalRating of size 6 Sat 11/18 14:05:35.167 Wizard loading main index for ParentalRating Sat 11/18 14:05:35.167 Wizard allocating table for ExtendedRating of size 7 Sat 11/18 14:05:35.168 Wizard loading main index for ExtendedRating Sat 11/18 14:05:35.168 Wizard allocating table for Category of size 41 Sat 11/18 14:05:35.168 Wizard loading main index for Category Sat 11/18 14:05:35.169 Wizard allocating table for PrimeTitle of size 0 Sat 11/18 14:05:35.169 Wizard allocating table for Bonus of size 3 Sat 11/18 14:05:35.169 Wizard loading main index for Bonus Sat 11/18 14:05:35.170 Wizard allocating table for Show of size 7027 Sat 11/18 14:05:35.170 Wizard loading main index for Show Sat 11/18 14:05:36.946 Wizard building alt. index 0 for Show Sat 11/18 14:05:36.953 Wizard allocating table for Airing of size 11946 Sat 11/18 14:05:36.953 Wizard loading main index for Airing Sat 11/18 14:05:37.232 Wizard building alt. index 0 for Airing Sat 11/18 14:05:37.239 Wizard building alt. index 1 for Airing Sat 11/18 14:05:37.243 Wizard allocating table for ManualRecord of size 8 Sat 11/18 14:05:37.243 Wizard loading main index for ManualRecord Sat 11/18 14:05:37.246 Wizard allocating table for MediaFile of size 122 Sat 11/18 14:05:37.247 Wizard loading main index for MediaFile Sat 11/18 14:05:37.334 Wizard building alt. index 0 for MediaFile Sat 11/18 14:05:37.335 Wizard building alt. index 1 for MediaFile Sat 11/18 14:05:37.340 Wizard allocating table for Watched of size 289 Sat 11/18 14:05:37.340 Wizard loading main index for Watched Sat 11/18 14:05:37.348 Wizard building alt. index 0 for Watched Sat 11/18 14:05:37.349 Wizard allocating table for Agent of size 138 Sat 11/18 14:05:37.350 Wizard loading main index for Agent Sat 11/18 14:05:37.358 Wizard building alt. index 0 for Agent Sat 11/18 14:05:37.370 Wizard allocating table for Wasted of size 83 Sat 11/18 14:05:37.370 Wizard loading main index for Wasted Sat 11/18 14:05:37.371 Wizard allocating table for Playlist of size 4 Sat 11/18 14:05:37.371 Wizard loading main index for Playlist Sat 11/18 14:05:37.375 Wizard allocating table for TVEditorial of size 0 Sat 11/18 14:05:37.375 Wizard allocating table for SeriesInfo of size 0 Sat 11/18 14:05:37.422 SageTV received connection from:Socket[addr=/127.0.0.1,port=42024,localport=1719] Sat 11/18 14:05:37.650 MMC calling detectCaptureDevices on sage.o@185572a Sat 11/18 14:05:37.662 devices detected=[Conexant's BtPCI Capture] Sat 11/18 14:05:37.663 EncoderMap={Conexant's BtPCI Capture=Conexant's BtPCI Capture} Sat 11/18 14:05:37.785 Checking video directories for new files Sat 11/18 14:05:37.960 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, CyberLink Audio Decoder (PDVD7 UPnP), CyberLink Audio Decoder (PDVD7), CyberLink Audio Effect (PDVD7), CyberLink Audio Spectrum Analyzer (PDVD7), CyberLink AudioCD Filter (PDVD7), CyberLink Demux (PDVD7 UPnP), CyberLink Demux (PDVD7), CyberLink DVD Navigator (PDVD7), CyberLink Line21 Decoder (PDVD7), CyberLink MPEG Splitter(Scramble), CyberLink MPEG-4 Splitter (PDVD7), CyberLink Push-Mode CLStream (PDVD7), CyberLink SAC Video Decoder(PDVD7 HomeNetwork), CyberLink Streamming Filter (PDVD7), Cyberlink SubTitle Importor (PDVD7), CyberLink TimeStretch Filter (PDVD7), CyberLink Video/SP Decoder (PDVD7), Deinterlace Filter, DivX Decoder Filter, DivX Decoder Filter, DivX Demux, DivX Subtitle Decoder, DScaler Audio Decoder, DScaler Renderer, DV Muxer, DV Splitter, DV Video Decoder, DVD Navigator, ffdshow VFW decoder helper, File Source (Async.), File Source (Netshow URL), File Source (URL), File stream renderer, File writer, Frame Eater, Full Screen Renderer, G.711 Codec, Infinite Pin Tee Filter, Internal Script Command Renderer, Line 21 Decoder, Line 21 Decoder 2, LogMeIn Video Decoder, LogMeIn Video Encoder, Lyric Parser, Microsoft MPEG-4 Video Decompressor, Microsoft Screen Video Decompressor, MIDI Parser, 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 Mpeg2 Encoder, Nero Photo Source, 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 Vcd Navigator, Nero Video Analyzer, Nero Video Decoder, Nero Video Processor, Nero Video Sample Renderer, Nero Video Stream Renderer, Nogatech Decompressor, 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, PICVideo MJPEG Compressor, PICVideo MJPEG Decompressor, QT Decompressor, QuickTime Movie Parser, ReClock Audio Renderer, 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, SampleGrabber, Screen Capture filter, Shared File Source (Async.), ShotBoundaryDet, Smart Tee, StreamBufferSink, StreamBufferSource, Stretch Video, Ulead CD Audio Filter, Ulead Http Render Filter for AV control, Ulead MP3 Encoder, Ulead MPEG Muxer, Ulead MPEG Splitter, 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, 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 8 Decoder DMO, WMVideo Advanced Decoder DMO, WMVideo Decoder DMO, WST Decoder, XCapture, XML Playlist, XRenderer] Sat 11/18 14:05:38.270 VF thread is now running... Sat 11/18 14:05:38.271 VF thread is now waiting for 0:00:00.000 Sat 11/18 14:05:38.273 SetFullScreen(true) Sat 11/18 14:05:38.274 FullScreen set to true Sat 11/18 14:05:38.277 UIMgr loading UI from: C:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMC_169.xml Sat 11/18 14:05:38.280 sage.aw@df2d38 needs an update in 2:40:18 Sat 11/18 14:05:38.280 EPG needs an update in 129 minutes Sat 11/18 14:05:38.281 EPG's works is done. Waiting... Sat 11/18 14:05:38.282 MsgSend thread spawned for /127.0.0.1:42024 Sat 11/18 14:05:38.283 MsgRecv thread has spawned for /127.0.0.1:42024 Sat 11/18 14:05:38.495 StorageDeviceDetector started... Sat 11/18 14:05:39.346 AWTThread Hang Detected - hang time = 776 Sat 11/18 14:05:39.614 locale = en Sat 11/18 14:05:39.830 EVPoolSize=1 Sat 11/18 14:05:39.834 ApplicationStarted Sat 11/18 14:05:39.835 Initializing EPG categories Sat 11/18 14:05:39.973 Found category movie Sat 11/18 14:05:39.982 nowplayinglist=Playlist[Now Playing ] Sat 11/18 14:05:39.993 reading IMDB cache ... Sat 11/18 14:05:39.994 cache directory = C:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\IMDBCache Sat 11/18 14:05:39.994 cache size = 1000 Sat 11/18 14:05:40.006 45 images in cache Sat 11/18 14:05:40.039 Start AutoCompress Sat 11/18 14:05:40.040 Cleaning up orphaned auto compress files... Sat 11/18 14:05:40.052 Scanning video directory V:\ Sat 11/18 14:05:40.064 Scanning files to auto compress... Sat 11/18 14:05:40.082 7 files to scan Sat 11/18 14:05:40.089 EVPoolSize=2 Sat 11/18 14:05:40.092 AutoCompress checking mediafile The Royle Family Sat 11/18 14:05:40.094 Not a favorite recording Sat 11/18 14:05:40.095 AutoCompress checking mediafile Extraordinary People: The Girl Who Survived Rabies Sat 11/18 14:05:40.095 Not a favorite recording Sat 11/18 14:05:40.096 AutoCompress checking mediafile Bones Sat 11/18 14:05:40.097 Favorite ID=158450 Sat 11/18 14:05:40.098 AWTThread Hang Detected - hang time = 1528 Sat 11/18 14:05:40.104 Auto compression not set Sat 11/18 14:05:40.112 AutoCompress checking mediafile Newsnight: Inside Al Qaeda - A Spy's Story Sat 11/18 14:05:40.113 Not a favorite recording Sat 11/18 14:05:40.114 AutoCompress checking mediafile Movie:Red Planet ** Sat 11/18 14:05:40.114 Not a favorite recording Sat 11/18 14:05:40.115 AutoCompress checking mediafile Movie:Red Planet ** Sat 11/18 14:05:40.115 Not a favorite recording Sat 11/18 14:05:40.116 AutoCompress checking mediafile Mythbusters Sat 11/18 14:05:40.116 Favorite ID=157904 Sat 11/18 14:05:40.123 Auto compression not set Sat 11/18 14:05:40.130 AutoCompress generation waiting 5 minutes ... Sat 11/18 14:05:40.309 DatePat=EEE, d MMM orgPat=EEEE, d MMMM yyyy Sat 11/18 14:05:40.462 setUI(sage.b1@486cdd[Main Menu]) histIdx=0 uiHistory=[sage.b1@486cdd[Main Menu]] Sat 11/18 14:05:40.846 AWTThread Hang Detected - hang time = 2276 Sat 11/18 14:05:40.971 Updating weather... Sat 11/18 14:05:40.975 EVPoolSize=3 Sat 11/18 14:05:41.182 VF processing job null nPlayin=false Sat 11/18 14:05:41.191 VF thread is now waiting for 0:00:00.000 Sat 11/18 14:06:12.488 AWTThread Hang Detected - hang time = 747 Sat 11/18 14:06:13.238 AWTThread Hang Detected - hang time = 1498 Sat 11/18 14:06:13.988 AWTThread Hang Detected - hang time = 2248 Sat 11/18 14:06:14.738 AWTThread Hang Detected - hang time = 2998 Sat 11/18 14:06:15.550 AWTThread Hang Detected - hang time = 3810 Sat 11/18 14:06:16.301 AWTThread Hang Detected - hang time = 4561 Sat 11/18 14:06:17.050 AWTThread Hang Detected - hang time = 5310 Sat 11/18 14:06:17.816 AWTThread Hang Detected - hang time = 6076 Sat 11/18 14:06:18.566 AWTThread Hang Detected - hang time = 6826 Sat 11/18 14:06:19.316 AWTThread Hang Detected - hang time = 7576 Sat 11/18 14:06:20.082 AWTThread Hang Detected - hang time = 8342 Sat 11/18 14:06:20.847 AWTThread Hang Detected - hang time = 9107 Sat 11/18 14:06:21.613 AWTThread Hang Detected - hang time = 9873 Sat 11/18 14:06:26.739 AWTThread Hang Detected - hang time = 14999 Sat 11/18 14:06:26.867 Rendered new font to cache font=java.awt.Font[family=Arial,name=Arial,style=plain,size=32] numGlyphs=1674 numCachedGlyphs=301 numImages=4 Sat 11/18 14:06:27.631 Removed system shell hook Sat 11/18 14:06:27.631 Sage.exit() called. Sat 11/18 14:06:27.631 Cleaning up servers Sat 11/18 14:06:27.632 Cleaning up PM Sat 11/18 14:06:27.633 Killed Carny. Sat 11/18 14:06:27.633 Killed Scheduler. Sat 11/18 14:06:31.743 VF processing job null nPlayin=false Sat 11/18 14:06:31.744 VideoFrame thread is now exiting Sat 11/18 14:06:31.744 Killed Seeker. Sat 11/18 14:06:31.745 Cleaning up c/s connection Sat 11/18 14:06:31.746 Connection lost from: Socket[addr=/127.0.0.1,port=42024,localport=1717] by:java.net.SocketException: socket closed Sat 11/18 14:06:31.746 Cleaning up c/s connection Sat 11/18 14:06:31.747 NetworkManager CommunicationFailure : /127.0.0.1:42024 type=2 Sat 11/18 14:06:31.747 Killed EPG. Sat 11/18 14:06:31.748 Killed MMC. Sat 11/18 14:06:31.748 Killing UIMgr UIManager:localhost@@SAGETV_PROCESS_LOCAL_UI-13f991 Sat 11/18 14:06:31.749 Killed UI Timers Sat 11/18 14:06:31.796 Error communicating with server:java.io.EOFException Sat 11/18 14:06:31.796 Cleaning up c/s connection Sat 11/18 14:06:31.874 NetworkManager CommunicationFailure : /127.0.0.1:42024 type=1 Sat 11/18 14:06:31.875 MsgRecv thread is terminating for /127.0.0.1:42024 Sat 11/18 14:06:32.488 AWTThread Hang Detected - hang time = 749 Sat 11/18 14:06:32.759 Killed VideoFrame Sat 11/18 14:06:32.863 Killed EventRouter Sat 11/18 14:06:32.864 Saving properties file to C:\Program Files\SageTV\SageTV\SageClient.properties Sat 11/18 14:06:33.240 AWTThread Hang Detected - hang time = 1501 Sat 11/18 14:06:33.310 Rendered new font to cache font=java.awt.Font[family=Arial,name=Arial,style=bold,size=55] numGlyphs=1674 numCachedGlyphs=239 numImages=11 Sat 11/18 14:06:33.311 MetaImage clearNativeCache nativeImageCacheSize=0 Sat 11/18 14:06:33.988 AWTThread Hang Detected - hang time = 2249 Sat 11/18 14:06:34.738 AWTThread Hang Detected - hang time = 2999 Sat 11/18 14:06:34.863 Killed RootPanel Sat 11/18 14:06:34.870 Disposed Window Sat 11/18 14:06:34.870 Killed UIManager. Sat 11/18 14:06:34.871 Killed Wizard. Sat 11/18 14:06:34.871 Cleaning up c/s connection Sat 11/18 14:06:34.881 Saving properties file to C:\Program Files\SageTV\SageTV\SageClient.properties Sat 11/18 14:06:34.895 Bye-bye. Sat 11/18 14:06:34.898 SageTV SHUTDOWN is activating!