Anyone have some suggestions on how to troubleshoot AWTThreadWatcher Hang Detected conditions?
Have started getting these sporadically and recycling Sage Service clears it up.
Code:
Fri 9/23 16:16:29.228 [Ministry@b76f2f] Ministry is waiting for 180 sec
Fri 9/23 16:19:29.237 [Ministry@b76f2f] Ministry is waiting for 180 sec
Fri 9/23 16:22:29.246 [Ministry@b76f2f] Ministry is waiting for 180 sec
Fri 9/23 16:25:29.254 [Ministry@b76f2f] Ministry is waiting for 180 sec
Fri 9/23 16:28:29.263 [Ministry@b76f2f] Ministry is waiting for 180 sec
Fri 9/23 16:30:31.829 [Seeker@f3c7ad] VideoStorage for new file: E:\TV_CR_E - Use All
Fri 9/23 16:30:31.830 [Seeker@f3c7ad] MediaFile created subfile:E:\TV_CR_E\WagonTrain-TheSamDarlandStory-1393618-0.mpg MediaFile[id=1495565 A[1393618,1393606,"Wagon Train",14765@0923.15:50,55] host=htpc-cr encodedBy=Hauppauge WinTV 418 Video Capture DVD Standard Play format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 720x480 4:3 6400 kbps interlaced]#1 Audio[MP2 48000 Hz 2 channels 384 kbps]]]
Fri 9/23 16:30:31.831 [Seeker@f3c7ad] Added:MediaFile[id=1495565 A[1393618,1393606,"Wagon Train",14765@0923.15:50,55] host=htpc-cr encodedBy=Hauppauge WinTV 418 Video Capture DVD Standard Play format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 720x480 4:3 6400 kbps interlaced]#1 Audio[MP2 48000 Hz 2 channels 384 kbps]] E:\TV_CR_E\WagonTrain-TheSamDarlandStory-1393618-0.mpg, Seg0[Fri 9/23 16:30:31.830-Wed 12/31 19:00:00.000]]
Fri 9/23 16:30:31.833 [Seeker@f3c7ad] Seeker channel string=538
Fri 9/23 16:30:31.833 [MainMsg@47040] setEncodingProperties0 1268431096 DVD Standard Play
Fri 9/23 16:30:31.833 [MainMsg@47040] Set encoding property audiooutputmode to 0
Fri 9/23 16:30:31.833 [MainMsg@47040] Set encoding property audiocrc to 0
Fri 9/23 16:30:31.833 [MainMsg@47040] Set encoding property gopsize to 15
Fri 9/23 16:30:31.833 [MainMsg@47040] Set encoding property videobitrate to 6400000
Fri 9/23 16:30:31.833 [MainMsg@47040] Set encoding property peakvideobitrate to 8000000
Fri 9/23 16:30:31.833 [MainMsg@47040] Set encoding property inversetelecine to 0
Fri 9/23 16:30:31.833 [MainMsg@47040] Set encoding property closedgop to 0
Fri 9/23 16:30:31.833 [MainMsg@47040] Set encoding property vbr to 1
Fri 9/23 16:30:31.833 [MainMsg@47040] Set encoding property outputstreamtype to 10
Fri 9/23 16:30:31.833 [MainMsg@47040] Set encoding property width to 720
Fri 9/23 16:30:31.834 [MainMsg@47040] Set encoding property height to 480
Fri 9/23 16:30:31.834 [MainMsg@47040] Set encoding property audiobitrate to 384
Fri 9/23 16:30:31.834 [MainMsg@47040] Set encoding property audiosampling to 48000
Fri 9/23 16:30:31.834 [MainMsg@47040] Set encoding property disablefilter to 1
Fri 9/23 16:30:31.834 [MainMsg@47040] Set encoding property medianfilter to 3
Fri 9/23 16:30:31.834 [MainMsg@47040] Set encoding property fps to 30
Fri 9/23 16:30:31.834 [MainMsg@47040] Set encoding property ipb to 0
Fri 9/23 16:30:31.834 [MainMsg@47040] Set encoding property deinterlace to 0
Fri 9/23 16:30:31.834 [MainMsg@47040] Set encoding property aspectratio to 1
Fri 9/23 16:30:31.834 [MainMsg@47040] setupEncoding0 called for 1268431096 'Hauppauge WinTV 418 Video Capture-0' (ver 1.0)
Fri 9/23 16:30:31.834 [MainMsg@47040] setupEncoding0 Trace1
Fri 9/23 16:30:31.834 [MainMsg@47040] setupEncoding0 Trace2
Fri 9/23 16:30:31.835 [MainMsg@47040] setupEncoding0 Trace3
Fri 9/23 16:30:31.837 [MainMsg@47040] Using encoder filter (0)
Fri 9/23 16:30:31.838 [MainMsg@47040] setupEncoding0 Trace4
Fri 9/23 16:30:31.839 [MainMsg@47040] setupEncoding0 Trace5
Fri 9/23 16:30:31.839 [MainMsg@47040] setupEncoding0 Trace6
Fri 9/23 16:30:31.839 [MainMsg@47040] is not ATI encoder.
Fri 9/23 16:30:31.839 [MainMsg@47040] setupEncoding0 Trace6-1
Fri 9/23 16:30:31.839 [MainMsg@47040] setupEncoding0 Trace7
Fri 9/23 16:30:31.839 [MainMsg@47040] Got codec interface
Fri 9/23 16:30:31.839 [MainMsg@47040] setupEncoding0 Trace7-1
Fri 9/23 16:30:31.839 [MainMsg@47040] setupEncoding0 Trace8
Fri 9/23 16:30:31.839 [MainMsg@47040] setupEncoding0 Trace9
Fri 9/23 16:30:31.840 [MainMsg@47040] setupEncoding0 Trace10
Fri 9/23 16:30:31.840 [MainMsg@47040] Encoding to file E:\TV_CR_E\WagonTrain-TheSamDarlandStory-1393618-0.mpg
Fri 9/23 16:30:31.840 [MainMsg@47040] setupEncoding0 Trace27
Fri 9/23 16:30:31.841 [MainMsg@47040] setupEncoding0 Trace28
Fri 9/23 16:30:31.841 [MainMsg@47040] startEncoding0 called for 'Hauppauge WinTV 418 Video Capture-0'
Fri 9/23 16:30:31.983 [AsyncTuner@1187172] Playing IR tune command of 538
Fri 9/23 16:30:32.115 [MainMsg@47040] GetBroadcastStandard for device:'Hauppauge WinTV 418 Video Capture-0'
Fri 9/23 16:30:32.116 [Seeker@f3c7ad] RootFile=E:\ fstype=NTFS fileLength=0
Fri 9/23 16:30:32.116 [Seeker@f3c7ad] Saving properties file to C:\SageTV\SageTV\Sage.properties
Fri 9/23 16:30:32.116 [VideoFrame-001d6a5dbb52@18d7f14] VF processing job null nPlayin=false
Fri 9/23 16:30:32.117 [VideoFrame-001d6a5dbb52@18d7f14] VF thread is now waiting for 0:00:00.000
Fri 9/23 16:30:32.178 [Seeker@f3c7ad] Checking video directories for new files
Fri 9/23 16:30:32.184 [Seeker@f3c7ad] Diskspace checking is running
Fri 9/23 16:30:32.184 [Seeker@f3c7ad] Verifying existence of all TV media files in database fixDurs=false avoidArchive=true
Fri 9/23 16:30:41.832 [FinalRender-001d6a5dbb52@106b744] MiniClient GFX_SUPPORTED_RESOLUTIONS_DIGITAL=720x480i@59.94|standard=HDMI_1440x480i59;720x480p@59.94|standard=HDMI_480p59;720x480p@60|standard=HDMI_480p60;1280x720p@59.94|standard=HDMI_720p59;1280x720p@60|standard=HDMI_720p60;1920x1080i@60|standard=HDMI_1080i60;1920x1080p@23.976|standard=HDMI_1080p23;1920x1080i@59.94|standard=HDMI_1080i59;1920x1080p@59.94|standard=HDMI_1080p59;1920x1080p@60|standard=HDMI_1080p60;
Fri 9/23 16:30:41.832 [FinalRender-001d6a5dbb52@106b744] MiniClient sending GFX_ASPECT=1.7777778
Fri 9/23 16:30:41.850 [MiniUIClientReceiver@1a5d908] Got UI size update to 1024x576
Fri 9/23 16:30:49.353 [EventRouter-001d6a5dbb52@859ff9] setUI(sage.b4@14677c4[Setup Menu]) histIdx=5 uiHistory=[sage.b4@1e27b89[Main Menu], sage.b4@a6e84d[Schedule Recordings], sage.b4@14d815c[Scheduled Recordings], sage.b4@a6e84d[Schedule Recordings], sage.b4@744f23[Main Menu], sage.b4@14677c4[Setup Menu]]
Fri 9/23 16:30:50.897 [EventRouter-001d6a5dbb52@859ff9] setUI(sage.b4@1659f10[Help Menu]) histIdx=6 uiHistory=[sage.b4@1e27b89[Main Menu], sage.b4@a6e84d[Schedule Recordings], sage.b4@14d815c[Scheduled Recordings], sage.b4@a6e84d[Schedule Recordings], sage.b4@744f23[Main Menu], sage.b4@14677c4[Setup Menu], sage.b4@1659f10[Help Menu]]
Fri 9/23 16:30:51.971 [EventRouter-001d6a5dbb52@859ff9] setUI(sage.b4@5edfac[System Messages]) histIdx=7 uiHistory=[sage.b4@1e27b89[Main Menu], sage.b4@a6e84d[Schedule Recordings], sage.b4@14d815c[Scheduled Recordings], sage.b4@a6e84d[Schedule Recordings], sage.b4@744f23[Main Menu], sage.b4@14677c4[Setup Menu], sage.b4@1659f10[Help Menu], sage.b4@5edfac[System Messages]]
Fri 9/23 16:31:05.837 [EventRouter-001d6a5dbb52@859ff9] processOptionsMenu optionsMenu=default:OPUS4A-119942|OptionsMenu:Confirm Delete All Messages
Fri 9/23 16:31:07.103 [EventRouter-001d6a5dbb52@859ff9] setUI(sage.b4@1659f10[Help Menu]) histIdx=6 uiHistory=[sage.b4@1e27b89[Main Menu], sage.b4@a6e84d[Schedule Recordings], sage.b4@14d815c[Scheduled Recordings], sage.b4@a6e84d[Schedule Recordings], sage.b4@744f23[Main Menu], sage.b4@14677c4[Setup Menu], sage.b4@1659f10[Help Menu], sage.b4@5edfac[System Messages]]
Fri 9/23 16:31:07.465 [EventRouter-001d6a5dbb52@859ff9] setUI(sage.b4@14677c4[Setup Menu]) histIdx=7 uiHistory=[sage.b4@1e27b89[Main Menu], sage.b4@a6e84d[Schedule Recordings], sage.b4@14d815c[Scheduled Recordings], sage.b4@a6e84d[Schedule Recordings], sage.b4@744f23[Main Menu], sage.b4@14677c4[Setup Menu], sage.b4@1659f10[Help Menu], sage.b4@14677c4[Setup Menu]]
Fri 9/23 16:31:07.817 [EventRouter-001d6a5dbb52@859ff9] setUI(sage.b4@744f23[Main Menu]) histIdx=8 uiHistory=[sage.b4@1e27b89[Main Menu], sage.b4@a6e84d[Schedule Recordings], sage.b4@14d815c[Scheduled Recordings], sage.b4@a6e84d[Schedule Recordings], sage.b4@744f23[Main Menu], sage.b4@14677c4[Setup Menu], sage.b4@1659f10[Help Menu], sage.b4@14677c4[Setup Menu], sage.b4@744f23[Main Menu]]
Fri 9/23 16:31:07.817 [EventRouter-001d6a5dbb52@859ff9] Global variables already set.
Fri 9/23 16:31:07.818 [EventRouter-001d6a5dbb52@859ff9] Theme settings already loaded.
Fri 9/23 16:31:07.818 [ReProcessHook@482893] GetRemoteClientVersion() = '20100909 0'; Recommended version = '20090702 0'
Fri 9/23 16:31:07.819 [Fork-OPUS4-89595@58321b] Starting Online Video properties updater thread.
Fri 9/23 16:31:07.819 [Fork-OPUS4A-122188@18f5ea0] Starting STV update availability check thread.
Fri 9/23 16:31:07.820 [Fork-OPUS4-89595@58321b] Checking remote file: http://download.sage.tv/OnlineVideos/6_6_2/version.txt, saving to: C:\SageTV\SageTV\STVs\SageTV3\OnlineVideos\version.txt
Fri 9/23 16:31:07.820 [Fork-OPUS4-89595@58321b] Download requested for files server=http://download.sage.tv/OnlineVideos/6_6_2/version.txt src=null dest=C:\SageTV\SageTV\STVs\SageTV3\OnlineVideos\version.txt
Fri 9/23 16:31:07.821 [Fork-OPUS4A-122188@18f5ea0] STV update will not be checked due to OS limitation.
Fri 9/23 16:31:07.821 [Fork-OPUS4A-122188@18f5ea0] Ending STV update availability check thread.
Fri 9/23 16:31:08.941 [Fork-OPUS4-89595@58321b] Download remoteSize=107
Fri 9/23 16:31:08.944 [FileDownload@305374] Read -1 bytes from the URL stream; download has completed
Fri 9/23 16:31:08.973 [FileDownload@305374] WARNING - MissingResource: "OK"
Fri 9/23 16:31:08.973 [FileDownload@305374] VF.submitJob(VFJob[InactiveFile r=0.0 t=0 file=null ifn=C:\SageTV\SageTV\STVs\SageTV3\OnlineVideos\version.txt])
Fri 9/23 16:31:08.974 [FileDownload@305374] VF.submitJob(VFJob[InactiveFile r=0.0 t=0 file=null ifn=C:\SageTV\SageTV\STVs\SageTV3\OnlineVideos\version.txt])
Fri 9/23 16:31:08.974 [FileDownload@305374] Download completed for files server=http://download.sage.tv/OnlineVideos/6_6_2/version.txt src=null dest=C:\SageTV\SageTV\STVs\SageTV3\OnlineVideos\version.txt abort=false
Fri 9/23 16:31:08.974 [VideoFrame-001d6a5dbb52@18d7f14] VF processing job VFJob[InactiveFile r=0.0 t=0 file=null ifn=C:\SageTV\SageTV\STVs\SageTV3\OnlineVideos\version.txt] nPlayin=false
Fri 9/23 16:31:08.974 [VideoFrame-001d6a5dbb52@18d7f14] VF discarding job VFJob[InactiveFile r=0.0 t=0 file=null ifn=C:\SageTV\SageTV\STVs\SageTV3\OnlineVideos\version.txt]
Fri 9/23 16:31:08.974 [VideoFrame-001d6a5dbb52@18d7f14] VF processing job null nPlayin=false
Fri 9/23 16:31:08.974 [VideoFrame-001d6a5dbb52@18d7f14] VF thread is now waiting for 0:00:00.000
Fri 9/23 16:31:09.405 [EventRouter-001d6a5dbb52@859ff9] setUI(sage.b4@a6e84d[Schedule Recordings]) histIdx=9 uiHistory=[sage.b4@1e27b89[Main Menu], sage.b4@a6e84d[Schedule Recordings], sage.b4@14d815c[Scheduled Recordings], sage.b4@a6e84d[Schedule Recordings], sage.b4@744f23[Main Menu], sage.b4@14677c4[Setup Menu], sage.b4@1659f10[Help Menu], sage.b4@14677c4[Setup Menu], sage.b4@744f23[Main Menu], sage.b4@a6e84d[Schedule Recordings]]
Fri 9/23 16:31:09.442 [Fork-OPUS4-89595@58321b] Done downloading remote file.
Fri 9/23 16:31:09.442 [Fork-OPUS4-89595@58321b] Created Property set w/o defaults
Fri 9/23 16:31:09.442 [Fork-OPUS4-89595@58321b] PropCacheFile = [C:\SageTV\SageTV\STVs\SageTV3\OnlineVideos\version.txt]
Fri 9/23 16:31:09.442 [Fork-OPUS4-89595@58321b] Loaded properties file: C:\SageTV\SageTV\STVs\SageTV3\OnlineVideos\version.txt
Fri 9/23 16:31:09.442 [Fork-OPUS4-89595@58321b] Created Property set w/o defaults
Fri 9/23 16:31:09.443 [Fork-OPUS4-89595@58321b] PropCacheFile = [C:\SageTV\SageTV\STVs\SageTV3\OnlineVideos\OnlineVideoLinks.properties]
Fri 9/23 16:31:09.444 [Fork-OPUS4-89595@58321b] Loaded properties file: C:\SageTV\SageTV\STVs\SageTV3\OnlineVideos\OnlineVideoLinks.properties
Fri 9/23 16:31:09.444 [Fork-OPUS4-89595@58321b] Current online video properties version=2010040201, update version number=2010040201
Fri 9/23 16:31:09.444 [Fork-OPUS4-89595@58321b] Cancelling update: online video properties file is up to date.
Fri 9/23 16:31:09.444 [Fork-OPUS4-89595@58321b] Marked property for last online video update time.
Fri 9/23 16:31:09.444 [Fork-OPUS4-89595@58321b] Ending Online Video properties updater thread. Update was completed.
Fri 9/23 16:31:10.116 [EventRouter-001d6a5dbb52@859ff9] setUI(sage.b4@7de677[RecordingSchedule - SHORTCUTS]) histIdx=9 uiHistory=[sage.b4@a6e84d[Schedule Recordings], sage.b4@14d815c[Scheduled Recordings], sage.b4@a6e84d[Schedule Recordings], sage.b4@744f23[Main Menu], sage.b4@14677c4[Setup Menu], sage.b4@1659f10[Help Menu], sage.b4@14677c4[Setup Menu], sage.b4@744f23[Main Menu], sage.b4@a6e84d[Schedule Recordings], sage.b4@7de677[RecordingSchedule - SHORTCUTS]]
Fri 9/23 16:31:10.116 [EventRouter-001d6a5dbb52@859ff9] setUI(sage.b4@14d815c[Scheduled Recordings]) histIdx=9 uiHistory=[sage.b4@a6e84d[Schedule Recordings], sage.b4@14d815c[Scheduled Recordings], sage.b4@a6e84d[Schedule Recordings], sage.b4@744f23[Main Menu], sage.b4@14677c4[Setup Menu], sage.b4@1659f10[Help Menu], sage.b4@14677c4[Setup Menu], sage.b4@744f23[Main Menu], sage.b4@a6e84d[Schedule Recordings], sage.b4@14d815c[Scheduled Recordings]]
Fri 9/23 16:31:11.227 [AWTThreadWatcher-001d6a5dbb52@1d9519] EventThread-001d6a5dbb52 Hang Detected - hang time = 750
Fri 9/23 16:31:11.977 [AWTThreadWatcher-001d6a5dbb52@1d9519] EventThread-001d6a5dbb52 Hang Detected - hang time = 1500
Fri 9/23 16:31:12.727 [AWTThreadWatcher-001d6a5dbb52@1d9519] EventThread-001d6a5dbb52 Hang Detected - hang time = 2250
Fri 9/23 16:31:13.477 [AWTThreadWatcher-001d6a5dbb52@1d9519] EventThread-001d6a5dbb52 Hang Detected - hang time = 3000
Fri 9/23 16:31:14.227 [AWTThreadWatcher-001d6a5dbb52@1d9519] EventThread-001d6a5dbb52 Hang Detected - hang time = 3750
Fri 9/23 16:31:14.977 [AWTThreadWatcher-001d6a5dbb52@1d9519] EventThread-001d6a5dbb52 Hang Detected - hang time = 4500
Fri 9/23 16:31:15.727 [AWTThreadWatcher-001d6a5dbb52@1d9519] EventThread-001d6a5dbb52 Hang Detected - hang time = 5250
Fri 9/23 16:31:16.477 [AWTThreadWatcher-001d6a5dbb52@1d9519] EventThread-001d6a5dbb52 Hang Detected - hang time = 6000
Fri 9/23 16:31:17.227 [AWTThreadWatcher-001d6a5dbb52@1d9519] EventThread-001d6a5dbb52 Hang Detected - hang time = 6750
Fri 9/23 16:31:17.977 [AWTThreadWatcher-001d6a5dbb52@1d9519] EventThread-001d6a5dbb52 Hang Detected - hang time = 7500
Fri 9/23 16:31:18.727 [AWTThreadWatcher-001d6a5dbb52@1d9519] EventThread-001d6a5dbb52 Hang Detected - hang time = 8250
Fri 9/23 16:31:19.477 [AWTThreadWatcher-001d6a5dbb52@1d9519] EventThread-001d6a5dbb52 Hang Detected - hang time = 9000
Fri 9/23 16:31:20.227 [AWTThreadWatcher-001d6a5dbb52@1d9519] EventThread-001d6a5dbb52 Hang Detected - hang time = 9750
Fri 9/23 16:31:20.977 [AWTThreadWatcher-001d6a5dbb52@1d9519] EventThread-001d6a5dbb52 Hang Detected - hang time = 10500
Fri 9/23 16:31:21.727 [AWTThreadWatcher-001d6a5dbb52@1d9519] EventThread-001d6a5dbb52 Hang Detected - hang time = 11250
Fri 9/23 16:31:22.477 [AWTThreadWatcher-001d6a5dbb52@1d9519] EventThread-001d6a5dbb52 Hang Detected - hang time = 12000
Fri 9/23 16:31:23.227 [AWTThreadWatcher-001d6a5dbb52@1d9519] EventThread-001d6a5dbb52 Hang Detected - hang time = 12750
Fri 9/23 16:31:23.977 [AWTThreadWatcher-001d6a5dbb52@1d9519] EventThread-001d6a5dbb52 Hang Detected - hang time = 13500
Fri 9/23 16:31:24.727 [AWTThreadWatcher-001d6a5dbb52@1d9519] EventThread-001d6a5dbb52 Hang Detected - hang time = 14250
Fri 9/23 16:31:25.477 [AWTThreadWatcher-001d6a5dbb52@1d9519] EventThread-001d6a5dbb52 Hang Detected - hang time = 15000
Fri 9/23 16:31:26.228 [AWTThreadWatcher-001d6a5dbb52@1d9519] EventThread-001d6a5dbb52 Hang Detected - hang time = 15751
Fri 9/23 16:31:26.978 [AWTThreadWatcher-001d6a5dbb52@1d9519] EventThread-001d6a5dbb52 Hang Detected - hang time = 16501
Fri 9/23 16:31:27.728 [AWTThreadWatcher-001d6a5dbb52@1d9519] EventThread-001d6a5dbb52 Hang Detected - hang time = 17251
Fri 9/23 16:31:28.478 [AWTThreadWatcher-001d6a5dbb52@1d9519] EventThread-001d6a5dbb52 Hang Detected - hang time = 18001
Fri 9/23 16:31:29.228 [AWTThreadWatcher-001d6a5dbb52@1d9519] EventThread-001d6a5dbb52 Hang Detected - hang time = 18751
Fri 9/23 16:31:29.272 [Ministry@b76f2f] Ministry is waiting for 180 sec
Fri 9/23 16:31:29.978 [AWTThreadWatcher-001d6a5dbb52@1d9519] EventThread-001d6a5dbb52 Hang Detected - hang time = 19501