Sat 12/30 12:34:07.868 user.dir2=C:\Program Files\SageTV\SageTV
Sat 12/30 12:34:07.873 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\;C:\Program Files\VERITAS\Backup Exec\NT\ECM\bumodule.jar;C:\Program Files\VERITAS\Backup Exec\NT\ECM\LOG4J-CORE.JAR;C:\Program Files\VERITAS\Backup Exec\NT\ECM\LOG4J.JAR;.;C:\Program Files\JavaSoft\JRE\1.2\lib\ext\QTJava.zip;JARs\commons-jxpath-1.1.jar;JARs\commons-logging-api.jar;JARs\commons-logging.jar;JARs\df_importer.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_sagemenureader.jar;JARs\nielm_sageutls.jar;JARs\sagemc.jar;JARs\sbbi-jmx-1.0.jar;JARs\sbbi-upnplib-1.0.3.jar
Sat 12/30 12:34:07.876 JVM version=1.5.0_10
Sat 12/30 12:34:07.877 OS=Windows 2000 5.0
Sat 12/30 12:34:07.893 Succesfully setup system shell hook
Sat 12/30 12:34:07.894 not specifiy WinkeyboardHook in registery, load default one
Sat 12/30 12:34:08.427 ImageUtils loading URL jar:file:/C:/Program%20Files/SageTV/SageTV/Sage.jar!/images/splash.gif
Sat 12/30 12:34:08.501 ImageUtils creating BI copy sun.awt.image.ToolkitImage@7fdcde w=520 h=350 freeMem=22431152 totalMem=25034752
Sat 12/30 12:34:08.574 SageTV V6.0.18.118
Sat 12/30 12:34:08.635 hostname=paul
Sat 12/30 12:34:08.834 ImageUtils loading URL jar:file:/C:/Program%20Files/SageTV/SageTV/Sage.jar!/images/tvicon.gif
Sat 12/30 12:34:08.865 ImageUtils creating BI copy sun.awt.image.ToolkitImage@a3bcc1 w=32 h=32 freeMem=21251696 totalMem=25034752
Sat 12/30 12:34:09.047 ImageUtils loading URL jar:file:/C:/Program%20Files/SageTV/SageTV/Sage.jar!/images/tvicon_anim0.gif
Sat 12/30 12:34:09.051 ImageUtils creating BI copy sun.awt.image.ToolkitImage@9fef6f w=32 h=32 freeMem=20600720 totalMem=25034752
Sat 12/30 12:34:09.053 ImageUtils loading URL jar:file:/C:/Program%20Files/SageTV/SageTV/Sage.jar!/images/tvicon_anim1.gif
Sat 12/30 12:34:09.057 ImageUtils creating BI copy sun.awt.image.ToolkitImage@17172ea w=32 h=32 freeMem=20536512 totalMem=25034752
Sat 12/30 12:34:09.059 ImageUtils loading URL jar:file:/C:/Program%20Files/SageTV/SageTV/Sage.jar!/images/tvicon_anim2.gif
Sat 12/30 12:34:09.064 ImageUtils creating BI copy sun.awt.image.ToolkitImage@4b222f w=32 h=32 freeMem=20501584 totalMem=25034752
Sat 12/30 12:34:09.066 ImageUtils loading URL jar:file:/C:/Program%20Files/SageTV/SageTV/Sage.jar!/images/tvicon_anim3.gif
Sat 12/30 12:34:09.070 ImageUtils creating BI copy sun.awt.image.ToolkitImage@7a78d3 w=32 h=32 freeMem=20428752 totalMem=25034752
Sat 12/30 12:34:09.392 Wizard starting to load database info...
Sat 12/30 12:34:09.401 DBFile at version 64 FileSize=894411
Sat 12/30 12:34:09.403 Wizard allocating table for Year of size 1
Sat 12/30 12:34:09.410 Wizard loading main index for Year
Sat 12/30 12:34:09.412 Wizard allocating table for Network of size 0
Sat 12/30 12:34:09.413 Wizard allocating table for Title of size 1283
Sat 12/30 12:34:09.414 Wizard loading main index for Title
Sat 12/30 12:34:09.452 Wizard building alt. index 0 for Title
Sat 12/30 12:34:09.459 Wizard allocating table for Channel of size 1
Sat 12/30 12:34:09.461 Wizard loading main index for Channel
Sat 12/30 12:34:09.463 Wizard allocating table for People of size 41
Sat 12/30 12:34:09.464 Wizard loading main index for People
Sat 12/30 12:34:09.465 Wizard building alt. index 0 for People
Sat 12/30 12:34:09.465 Wizard allocating table for SubCategory of size 0
Sat 12/30 12:34:09.466 Wizard allocating table for Rated of size 0
Sat 12/30 12:34:09.467 Wizard allocating table for ParentalRating of size 0
Sat 12/30 12:34:09.468 Wizard allocating table for ExtendedRating of size 0
Sat 12/30 12:34:09.469 Wizard allocating table for Category of size 5
Sat 12/30 12:34:09.470 Wizard loading main index for Category
Sat 12/30 12:34:09.471 Wizard allocating table for PrimeTitle of size 0
Sat 12/30 12:34:09.474 Wizard allocating table for Bonus of size 0
Sat 12/30 12:34:09.475 Wizard allocating table for Show of size 1688
Sat 12/30 12:34:09.475 Wizard loading main index for Show
Sat 12/30 12:34:09.651 Wizard building alt. index 0 for Show
Sat 12/30 12:34:09.675 Wizard allocating table for Airing of size 1687
Sat 12/30 12:34:09.678 Wizard loading main index for Airing
Sat 12/30 12:34:09.690 Wizard building alt. index 0 for Airing
Sat 12/30 12:34:09.694 Wizard building alt. index 1 for Airing
Sat 12/30 12:34:09.701 Wizard allocating table for ManualRecord of size 0
Sat 12/30 12:34:09.703 Wizard allocating table for MediaFile of size 1688
Sat 12/30 12:34:09.704 Wizard loading main index for MediaFile
Sat 12/30 12:34:10.097 Wizard building alt. index 0 for MediaFile
Sat 12/30 12:34:10.102 Wizard building alt. index 1 for MediaFile
Sat 12/30 12:34:10.141 Wizard allocating table for Watched of size 1
Sat 12/30 12:34:10.145 Wizard loading main index for Watched
Sat 12/30 12:34:10.150 Wizard building alt. index 0 for Watched
Sat 12/30 12:34:10.152 Wizard allocating table for Agent of size 0
Sat 12/30 12:34:10.153 Wizard allocating table for Wasted of size 0
Sat 12/30 12:34:10.154 Wizard allocating table for Playlist of size 2
Sat 12/30 12:34:10.155 Wizard loading main index for Playlist
Sat 12/30 12:34:10.167 Wizard allocating table for TVEditorial of size 0
Sat 12/30 12:34:10.168 Wizard allocating table for SeriesInfo of size 0
Sat 12/30 12:34:10.171 Wizard performing validation on database objects...
Sat 12/30 12:34:10.197 Wizard DONE loading database info. loadTime=0.805 sec
Sat 12/30 12:34:10.580 MMC calling detectCaptureDevices on sage.b7@1fee6fc
Sat 12/30 12:34:10.583 devices detected=[]
Sat 12/30 12:34:10.584 EncoderMap={}
Sat 12/30 12:34:10.585 MMC calling detectCaptureDevices on sage.k@1eed786
Sat 12/30 12:34:10.676 systemCapDevices=[SB PCI External MIDI, SB PCI, Raw Channel Access Capture/Render, Logitech QuickCam Web, Logitech Microphone (Web), USB Audio Device]
Sat 12/30 12:34:10.683 EncoderMap1={}
Sat 12/30 12:34:10.685 Processing new system dev:SB PCI External MIDI
Sat 12/30 12:34:10.686 Processing new system dev:SB PCI
Sat 12/30 12:34:10.686 Processing new system dev:Raw Channel Access Capture/Render
Sat 12/30 12:34:10.687 Processing new system dev:Logitech QuickCam Web
Sat 12/30 12:34:10.687 Processing new system dev:Logitech Microphone (Web)
Sat 12/30 12:34:10.688 Processing new system dev:USB Audio Device
Sat 12/30 12:34:10.689 devices detected=[]
Sat 12/30 12:34:10.689 EncoderMap={}
Sat 12/30 12:34:10.832 Checking video directories for new files
Sat 12/30 12:34:10.967 DShowFilters=[.RAM file Parser, AC3 Parser Filter, AC3Filter, ACDFX Filter, ACELP.net Sipro Lab Audio Decoder, ACM Wrapper, 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, BDA MPEG2 Transport Information Filter, Color Converter, Color Space Converter, Cutlist File Source, Deinterlace Filter, DV Muxer, DV Splitter, DV Video Decoder, DVBCore MPEG2 ES/AC3 Source, DVD Navigator, Essien R&D MPEG Writer Filter, File Source (Async.), File Source (Netshow URL), File Source (URL), File stream renderer, File writer, Full Screen Renderer, G.711 Codec, H261 Decode Filter, H261 Encode Filter, H263 Decode Filter, H263 Encode Filter, Image Source, Indeo® audio software, Indeo® video 5.10 Compression Filter, Indeo® video 5.10 Decompression Filter, Infinite Pin Tee Filter, Intel RTP Demux Filter, Intel RTP RPH for G.711/G.723.1, Intel RTP RPH for Generic Audio, Intel RTP RPH for H.263/H.261, Intel RTP SPH for G.711/G.723.1, Intel RTP SPH for Generic Audio, Intel RTP SPH for H.263/H.261, Internal Script Command Renderer, IVF source filter, Line 21 Decoder, Line 21 Decoder 2, Lyric Parser, Microsoft MPEG-4 Video Decompressor, Microsoft PCM Audio Mixer, 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-I Stream Splitter, MPEG2Dump, Mpeg4 Decoder DMO, Mpeg43 Decoder DMO, Mpeg4s Decoder DMO, Multi-file Parser, NSC file Parser, Null Renderer, Overlay Mixer, Overlay Mixer2, PCM Silence Suppressor, QT Decompressor, QuickTime Movie Parser, RealAudio Decoder, RealMedia Source, RealMedia Splitter, RealPlayer Audio Filter, RealVideo Decoder, RTP Render Filter, RTP Source Filter, 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, Screen Capture filter, Shared File Source (Async.), Smart Tee, VBI Surface Allocator, VGA 16 Color Ditherer, Video Mixing Renderer 9, Video Renderer, Video Source, Viscomsoft QuickTime Decoder, WAV Dest, Wave Parser, WDM Capture Device, Windows Media Audio Decoder, Windows Media Multiplexer, Windows Media source filter, Windows Media Update Filter, WM ASF Reader, WM ASF Writer, WMAudio Decoder DMO, WMSpeech Decoder DMO, WMV Screen decoder DMO, WMVideo Decoder DMO, WST Decoder, XML Playlist, XviD MPEG-4 Video Decoder]
Sat 12/30 12:34:11.021 CARNY Processing 0 Agents & 0 Airs
Sat 12/30 12:34:11.022 CARNY Negative Energy Size: 0
Sat 12/30 12:34:11.023 CARNY Traitors:[]
Sat 12/30 12:34:11.033 Verifying existence of all TV media files in database fixDurs=true avoidArchive=false
Sat 12/30 12:34:11.060 Carny waiting for awhile...
Sat 12/30 12:34:11.070 EPG needs an update in 1425 minutes
Sat 12/30 12:34:11.071 EPG's works is done. Waiting...
Sat 12/30 12:34:12.432 Checking video directories for new files
Sat 12/30 12:34:12.439 Scheduler.updateSchedule() called time=Sat 12/30 12:34:11.062 manual=[] schedules={} scheduleRandSize=0
Sat 12/30 12:34:12.440 Diskspace checking is running
Sat 12/30 12:34:12.446 Verifying existence of all TV media files in database fixDurs=false avoidArchive=true
Sat 12/30 12:34:12.447 Seeker waiting for 153722847822578 mins.
Sat 12/30 12:34:12.448 Seeker awoken
Sat 12/30 12:34:12.450 Checking video directories for new files
Sat 12/30 12:34:12.480 Diskspace checking is running
Sat 12/30 12:34:12.481 Verifying existence of all TV media files in database fixDurs=false avoidArchive=true
Sat 12/30 12:34:12.482 Enforcing keep at most limits for the files...
Sat 12/30 12:34:12.484 Seeker clearing unwanted and partial files...
Sat 12/30 12:34:12.508 Seeker waiting for 153722847822578 mins.
Sat 12/30 12:34:12.936 Seeker is starting the library import scan...
Sat 12/30 12:34:14.474 Skipping video import dir that's also a recording dir:C:\Documents and Settings\Paul1\My Documents\My Videos\SageTV
Sat 12/30 12:34:15.057 Creating playlist object for playlist file: C:\Documents and Settings\Paul1\My Documents\My Music\My Playlists\Sample Playlist.wpl
Sat 12/30 12:34:15.067 Ignoring playlist: C:\Documents and Settings\Paul1\My Documents\My Music\My Playlists\Sample Playlist.wpl due to missing element: C:\My Documents\My Music\Beck.asx
Sat 12/30 12:34:15.089 Creating playlist object for playlist file: C:\Documents and Settings\Paul1\My Documents\My Music\Sample Playlists\0049547C\Favorites -- 4 and 5 star rated.wpl
Sat 12/30 12:34:15.115 Ignoring playlist due to zero size: C:\Documents and Settings\Paul1\My Documents\My Music\Sample Playlists\0049547C\Favorites -- 4 and 5 star rated.wpl
Sat 12/30 12:34:15.116 Creating playlist object for playlist file: C:\Documents and Settings\Paul1\My Documents\My Music\Sample Playlists\0049547C\Favorites -- Have not heard recently.wpl
Sat 12/30 12:34:15.123 Ignoring playlist due to zero size: C:\Documents and Settings\Paul1\My Documents\My Music\Sample Playlists\0049547C\Favorites -- Have not heard recently.wpl
Sat 12/30 12:34:15.134 Creating playlist object for playlist file: C:\Documents and Settings\Paul1\My Documents\My Music\Sample Playlists\0049547C\Favorites -- Listen to late at night.wpl
Sat 12/30 12:34:15.137 Ignoring playlist due to zero size: C:\Documents and Settings\Paul1\My Documents\My Music\Sample Playlists\0049547C\Favorites -- Listen to late at night.wpl
Sat 12/30 12:34:15.138 Creating playlist object for playlist file: C:\Documents and Settings\Paul1\My Documents\My Music\Sample Playlists\0049547C\Favorites -- Listen to on Weekdays.wpl
Sat 12/30 12:34:15.144 Ignoring playlist due to zero size: C:\Documents and Settings\Paul1\My Documents\My Music\Sample Playlists\0049547C\Favorites -- Listen to on Weekdays.wpl
Sat 12/30 12:34:15.145 Creating playlist object for playlist file: C:\Documents and Settings\Paul1\My Documents\My Music\Sample Playlists\0049547C\Favorites -- Listen to on Weekends.wpl
Sat 12/30 12:34:15.147 Ignoring playlist due to zero size: C:\Documents and Settings\Paul1\My Documents\My Music\Sample Playlists\0049547C\Favorites -- Listen to on Weekends.wpl
Sat 12/30 12:34:15.148 Creating playlist object for playlist file: C:\Documents and Settings\Paul1\My Documents\My Music\Sample Playlists\0049547C\Favorites -- One Audio CD worth.wpl
Sat 12/30 12:34:15.152 Ignoring playlist due to zero size: C:\Documents and Settings\Paul1\My Documents\My Music\Sample Playlists\0049547C\Favorites -- One Audio CD worth.wpl
Sat 12/30 12:34:15.155 Creating playlist object for playlist file: C:\Documents and Settings\Paul1\My Documents\My Music\Sample Playlists\0049547C\Favorites -- One Data CD-R worth.wpl
Sat 12/30 12:34:15.158 Ignoring playlist due to zero size: C:\Documents and Settings\Paul1\My Documents\My Music\Sample Playlists\0049547C\Favorites -- One Data CD-R worth.wpl
Sat 12/30 12:34:15.159 Creating playlist object for playlist file: C:\Documents and Settings\Paul1\My Documents\My Music\Sample Playlists\0049547C\Fresh tracks -- yet to be played.wpl
Sat 12/30 12:34:15.162 Ignoring playlist due to zero size: C:\Documents and Settings\Paul1\My Documents\My Music\Sample Playlists\0049547C\Fresh tracks -- yet to be played.wpl
Sat 12/30 12:34:15.163 Creating playlist object for playlist file: C:\Documents and Settings\Paul1\My Documents\My Music\Sample Playlists\0049547C\Fresh tracks -- yet to be rated.wpl
Sat 12/30 12:34:15.166 Ignoring playlist due to zero size: C:\Documents and Settings\Paul1\My Documents\My Music\Sample Playlists\0049547C\Fresh tracks -- yet to be rated.wpl
Sat 12/30 12:34:15.167 Creating playlist object for playlist file: C:\Documents and Settings\Paul1\My Documents\My Music\Sample Playlists\0049547C\Fresh tracks.wpl
Sat 12/30 12:34:15.171 Ignoring playlist due to zero size: C:\Documents and Settings\Paul1\My Documents\My Music\Sample Playlists\0049547C\Fresh tracks.wpl
Sat 12/30 12:34:15.172 Creating playlist object for playlist file: C:\Documents and Settings\Paul1\My Documents\My Music\Sample Playlists\0049547C\High bitrate media in my library.wpl
Sat 12/30 12:34:15.175 Ignoring playlist due to zero size: C:\Documents and Settings\Paul1\My Documents\My Music\Sample Playlists\0049547C\High bitrate media in my library.wpl
Sat 12/30 12:34:15.180 Creating playlist object for playlist file: C:\Documents and Settings\Paul1\My Documents\My Music\Sample Playlists\0049547C\Low bitrate media in my library.wpl
Sat 12/30 12:34:15.183 Ignoring playlist due to zero size: C:\Documents and Settings\Paul1\My Documents\My Music\Sample Playlists\0049547C\Low bitrate media in my library.wpl
Sat 12/30 12:34:15.184 Creating playlist object for playlist file: C:\Documents and Settings\Paul1\My Documents\My Music\Sample Playlists\0049547C\Music tracks I dislike.wpl
Sat 12/30 12:34:15.187 Ignoring playlist due to zero size: C:\Documents and Settings\Paul1\My Documents\My Music\Sample Playlists\0049547C\Music tracks I dislike.wpl
Sat 12/30 12:34:15.188 Creating playlist object for playlist file: C:\Documents and Settings\Paul1\My Documents\My Music\Sample Playlists\0049547C\Music tracks I have not rated.wpl
Sat 12/30 12:34:15.191 Ignoring playlist due to zero size: C:\Documents and Settings\Paul1\My Documents\My Music\Sample Playlists\0049547C\Music tracks I have not rated.wpl
Sat 12/30 12:34:15.192 Creating playlist object for playlist file: C:\Documents and Settings\Paul1\My Documents\My Music\Sample Playlists\0049547C\Music tracks with content protection.wpl
Sat 12/30 12:34:15.195 Ignoring playlist due to zero size: C:\Documents and Settings\Paul1\My Documents\My Music\Sample Playlists\0049547C\Music tracks with content protection.wpl
Sat 12/30 12:34:15.398 Seeker has finished the library import scan.
Sat 12/30 12:34:15.399 Seeker invoking System.gc()
Sat 12/30 12:34:15.711 Seeker System.gc() done
Sat 12/30 12:34:16.061 Ministry is starting
Sat 12/30 12:34:16.085 Ministry is waiting for 180 sec
Sat 12/30 12:34:21.234 VF thread is now running...
Sat 12/30 12:34:21.237 VF thread is now waiting for 0:00:00.000
Sat 12/30 12:34:21.239 UIMgr loading UI from: C:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMC_169-5.xml
Sat 12/30 12:34:22.000 AWTThread Hang Detected - hang time = 752
Sat 12/30 12:34:22.761 AWTThread Hang Detected - hang time = 1513
Sat 12/30 12:34:25.294 StorageDeviceDetector started...
Sat 12/30 12:34:25.295 AWTThread Hang Detected - hang time = 2284
Sat 12/30 12:34:25.295 locale = en
Sat 12/30 12:34:26.045 AWTThread Hang Detected - hang time = 4797
Sat 12/30 12:34:26.139 EVPoolSize=1
Sat 12/30 12:34:26.145 ApplicationStarted
Sat 12/30 12:34:26.149 Initializing EPG categories
Sat 12/30 12:34:26.410 nowplayinglist=Playlist[Now Playing ]
Sat 12/30 12:34:26.472 reading IMDB cache ...
Sat 12/30 12:34:26.473 cache directory = C:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\IMDBCache
Sat 12/30 12:34:26.474 cache size = 1000
Sat 12/30 12:34:26.478 0 images in cache
Sat 12/30 12:34:26.517 SAGETV_PROCESS_LOCAL_UI: AutoCompress thread started
Sat 12/30 12:34:26.519 Cleaning up orphaned auto compress files...
Sat 12/30 12:34:26.549 Scanning video directory C:\Documents and Settings\Paul1\My Documents\My Videos\SageTV
Sat 12/30 12:34:26.557 Scanning files to auto compress...
Sat 12/30 12:34:26.558 EVPoolSize=2
Sat 12/30 12:34:26.643 0 files to scan
Sat 12/30 12:34:26.646 AutoCompress generation waiting 5 minutes ...
Sat 12/30 12:34:26.754 DatePat=EEE, MMM d orgPat=EEEE, MMMM d, yyyy
Sat 12/30 12:34:26.806 AWTThread Hang Detected - hang time = 5558
Sat 12/30 12:34:27.000 setUI(sage.b0@11756a4[Main Menu]) histIdx=0 uiHistory=[sage.b0@11756a4[Main Menu]]
Sat 12/30 12:34:27.010 BeforeMenuLoad Main Menu
Sat 12/30 12:34:27.161 SAGETV_PROCESS_LOCAL_UI: Starting Disk Space Bar Updater Thread: Thread[Thread-4,6,main]
Sat 12/30 12:34:27.164 Updating Disk Space Bar
Sat 12/30 12:34:27.168 EVPoolSize=3
Sat 12/30 12:34:27.168 Updating weather...
Sat 12/30 12:34:27.170 EVPoolSize=4
Sat 12/30 12:34:27.240 Got used/avail video diskspace
Sat 12/30 12:34:27.241 Calculate space required for upcomming manual/favourite airings for next 2 days and display
Sat 12/30 12:34:27.296 Calculate size of partial recordings
Sat 12/30 12:34:27.322 Found 0 partials using 0 bytes
Sat 12/30 12:34:27.354 VideoDiskspaceReqProportion: 0.9176995473250432
Sat 12/30 12:34:27.355 VideoDiskspaceFreeProportion: 0.9176995473250432
Sat 12/30 12:34:27.356 Disk Space Bar Update complete
Sat 12/30 12:34:27.548 Loading new font to cache font=java.awt.Font[family=Arial,name=Arial,style=bold,size=13]
Sat 12/30 12:34:27.909 Rendered new font to cache font=java.awt.Font[family=Arial,name=Arial,style=bold,size=13] numGlyphs=1674 numCachedGlyphs=313 numImages=3
Sat 12/30 12:34:27.942 Loading new font to cache font=java.awt.Font[family=Arial,name=Arial,style=plain,size=27]
Sat 12/30 12:34:28.427 Rendered new font to cache font=java.awt.Font[family=Arial,name=Arial,style=plain,size=27] numGlyphs=1674 numCachedGlyphs=235 numImages=11
Sat 12/30 12:34:28.431 Loading new font to cache font=java.awt.Font[family=Arial,name=Arial,style=bold,size=46]
Sat 12/30 12:34:29.063 Rendered new font to cache font=java.awt.Font[family=Arial,name=Arial,style=bold,size=46] numGlyphs=1674 numCachedGlyphs=242 numImages=30
Sat 12/30 12:34:29.090 Initializing DirectX9
Sat 12/30 12:34:29.108 Creating D3D Device
Sat 12/30 12:34:29.163 DX9Renderer NATIVE WARNING (non-FAILURE) line 618 hr=0x8876086c
Sat 12/30 12:34:29.164 Done Initializing DirectX9
Sat 12/30 12:34:29.165 DX9 max texture dimensions is 2048x2048
Sat 12/30 12:34:29.166 Max texture dimension was set as 2048 mine=2048 native=2048 vramlimit=47815065
Sat 12/30 12:34:29.178 Loading 720x576 image from file C:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\Images\background.png
Sat 12/30 12:34:29.280 Creating DirectX9 Texture from nio buffer w=720 h=576
Sat 12/30 12:34:30.037 Creating DirectX9 Texture from memory w=128 h=128
Sat 12/30 12:34:30.042 Creating DirectX9 Texture from memory w=128 h=128
Sat 12/30 12:34:30.046 Creating DirectX9 Texture from memory w=128 h=128
Sat 12/30 12:34:30.050 Creating DirectX9 Texture from memory w=128 h=128
Sat 12/30 12:34:30.054 Creating DirectX9 Texture from memory w=128 h=128
Sat 12/30 12:34:30.057 Loading 94x103 image from file C:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\Images\hp_start.png
Sat 12/30 12:34:30.063 Creating DirectX9 Texture from nio buffer w=94 h=103
Sat 12/30 12:34:30.078 Loading 162x225 image from file C:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\Images\hover_my tv.png
Sat 12/30 12:34:30.098 Creating DirectX9 Texture from nio buffer w=162 h=225
Sat 12/30 12:34:30.156 Loading 69x102 image from file C:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\Images\button_close_nofocus.png
Sat 12/30 12:34:30.161 Creating DirectX9 Texture from nio buffer w=69 h=102
Sat 12/30 12:34:30.180 Creating DirectX9 Texture from memory w=128 h=128
Sat 12/30 12:34:30.184 Loading 225x49 image from file C:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\Images\hp_selectionbar.png
Sat 12/30 12:34:30.190 Creating DirectX9 Texture from nio buffer w=225 h=49
Sat 12/30 12:34:30.206 Loading 128x128 image from file C:\Program Files\SageTV\SageTV\STVs\SageTV3\WeatherIcons\Images\28.png
Sat 12/30 12:34:30.220 Creating DirectX9 Texture from nio buffer w=128 h=128
Sat 12/30 12:34:30.225 Creating DirectX9 Texture from memory w=128 h=128
Sat 12/30 12:34:30.228 Creating DirectX9 Texture from memory w=128 h=128
Sat 12/30 12:34:30.232 Creating DirectX9 Texture from memory w=128 h=128
Sat 12/30 12:34:32.192 Premultiplying alpha for BuffImage...
Sat 12/30 12:34:32.197 Creating DirectX9 Texture from memory w=16 h=16
Sat 12/30 12:34:32.199 Loading new font to cache font=java.awt.Font[family=Arial,name=Arial,style=bold,size=11]
Sat 12/30 12:34:32.713 Disabled SS
Sat 12/30 12:34:32.892 Rendered new font to cache font=java.awt.Font[family=Arial,name=Arial,style=bold,size=11] numGlyphs=1674 numCachedGlyphs=263 numImages=2
Sat 12/30 12:34:32.894 Creating DirectX9 Texture from memory w=128 h=128
Sat 12/30 12:34:32.941 Loading 162x225 image from file C:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\Images\hover_my videos.png
Sat 12/30 12:34:32.957 Creating DirectX9 Texture from nio buffer w=162 h=225
Sat 12/30 12:34:33.825 Loading 162x225 image from file C:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\Images\hover_my pictures.png
Sat 12/30 12:34:33.843 Creating DirectX9 Texture from nio buffer w=162 h=225
Sat 12/30 12:34:34.290 Loading 162x225 image from file C:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\Images\hover_my music.png
Sat 12/30 12:34:34.307 Creating DirectX9 Texture from nio buffer w=162 h=225
Sat 12/30 12:34:34.850 Loading 161x163 image from file C:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\Images\hp_dvd.png
Sat 12/30 12:34:34.864 Creating DirectX9 Texture from nio buffer w=161 h=163
Sat 12/30 12:34:35.470 Loading 230x225 image from file C:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\Images\hover_my programs.png
Sat 12/30 12:34:35.496 Creating DirectX9 Texture from nio buffer w=230 h=225
Sat 12/30 12:34:36.712 Loading 162x225 image from file C:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\Images\hover_my explorer.png
Sat 12/30 12:34:36.731 Creating DirectX9 Texture from nio buffer w=162 h=225
Sat 12/30 12:34:38.608 setUI(sage.b0@1c1f5b2[Dynamic Menu by nielm]) histIdx=1 uiHistory=[sage.b0@11756a4[Main Menu], sage.b0@1c1f5b2[Dynamic Menu by nielm]]
Sat 12/30 12:34:38.629 BeforeMenuLoad Dynamic Menu
Sat 12/30 12:34:38.630 Loading Menu
Sat 12/30 12:34:38.652 Loading Menu File C:\Program Files\SageTV\SageTV\sagemc_menu.xml
Sat 12/30 12:34:38.767 MenuTree Loaded
Sat 12/30 12:34:38.769 Setting root menu widget
Sat 12/30 12:34:38.958 Setting Focus on net.sf.sageplugins.sagemenu.SageMenu@1de0b5e to net.sf.sageplugins.sagemenu.InternalScreenMenuItem@e2ecc7
Sat 12/30 12:34:38.980 Loading 250x70 image from file C:\Program Files\SageTV\SageTV\STVs\SageTV3\SageMCE\Images\select_logo.png
Sat 12/30 12:34:38.987 Creating DirectX9 Texture from nio buffer w=250 h=70
Sat 12/30 12:34:43.008 Launching menu action on net.sf.sageplugins.sagemenu.SageMenu@1de0b5e to net.sf.sageplugins.sagemenu.InternalScreenMenuItem@e2ecc7
Sat 12/30 12:34:48.140 Launching menu action on net.sf.sageplugins.sagemenu.SageMenu@1de0b5e to net.sf.sageplugins.sagemenu.InternalScreenMenuItem@272961
Sat 12/30 12:35:00.209 Removed system shell hook
Sat 12/30 12:35:00.210 Sage.exit() called.
Sat 12/30 12:35:00.211 Cleaning up servers
Sat 12/30 12:35:00.254 Cleaning up PM
Sat 12/30 12:35:00.256 Enabled SS
Sat 12/30 12:35:00.256 Killed Carny.
Sat 12/30 12:35:00.258 Killed Scheduler.
Sat 12/30 12:35:00.259 Seeker.finishWatch(UIManager:localhost@@SAGETV_PROCESS_LOCAL_UI-18fef3d)
Sat 12/30 12:35:00.260 VF processing job null nPlayin=false
Sat 12/30 12:35:00.260 VideoFrame thread is now exiting
Sat 12/30 12:35:00.263 Ministry is shutting down....destroying the converts in progress
Sat 12/30 12:35:00.265 Killed Seeker.
Sat 12/30 12:35:00.265 Killed EPG.
Sat 12/30 12:35:00.268 Killed MMC.
Sat 12/30 12:35:00.269 Killing UIMgr UIManager:localhost@@SAGETV_PROCESS_LOCAL_UI-18fef3d
Sat 12/30 12:35:00.271 Killed UI Timers
Sat 12/30 12:35:00.272 Saving properties file to C:\Program Files\SageTV\SageTV\Sage.properties
Sat 12/30 12:35:00.272 Seeker.finishWatch(UIManager:localhost@@SAGETV_PROCESS_LOCAL_UI-18fef3d)
Sat 12/30 12:35:00.273 Killed VideoFrame
Sat 12/30 12:35:00.407 ApplicationExiting
Sat 12/30 12:35:00.408 Killed EventRouter
Sat 12/30 12:35:00.410 SAGETV_PROCESS_LOCAL_UI: Shutting down Disk Space Bar Updater Thread: Thread[Thread-4,6,main]
Sat 12/30 12:35:00.522 MetaImage clearNativeCache nativeImageCacheSize=7078912
Sat 12/30 12:35:00.526 Cleaning up DirectX9
Sat 12/30 12:35:00.529 Doing full DX9 cleanup.
Sat 12/30 12:35:00.534 Done cleaning up DirectX9
Sat 12/30 12:35:01.464 AWTThread Hang Detected - hang time = 751
Sat 12/30 12:35:02.215 AWTThread Hang Detected - hang time = 1502
Sat 12/30 12:35:02.426 Killed RootPanel
Sat 12/30 12:35:02.501 Disposed Window
Sat 12/30 12:35:02.502 Killed UIManager.
Sat 12/30 12:35:02.528 Killed Wizard.
Sat 12/30 12:35:02.528 Saving properties file to C:\Program Files\SageTV\SageTV\Sage.properties
Sat 12/30 12:35:02.615 Bye-bye.
Sat 12/30 12:35:02.621 SageTV SHUTDOWN is activating!