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!