SageTV Community  

Go Back   SageTV Community > SageTV BETA Release Products > SageTV Beta Test Software
Forum Rules FAQs Community Downloads Today's Posts Search

Notices

SageTV Beta Test Software Discussion related to BETA Releases of the SageTV application produced by SageTV. Questions, issues, problems, suggestions, etc. regarding SageTV Beta Releases should be posted here.

Reply
 
Thread Tools Search this Thread Display Modes
  #1  
Old 12-04-2006, 02:33 AM
MTuckman's Avatar
MTuckman MTuckman is offline
Sage Advanced User
 
Join Date: Feb 2005
Posts: 120
Unhappy AWTThread Hang Detected - Problem getting out of hand!

I have been running into performance problems lately that are really killing the households acceptability of the SageTV software. If I hear the name Tivo one more time I am going to strangle someone.

While playing back programs, almost any interaction with the GUI will cause anything from stuttering to a complete freeze of the client, lastime sometimes a minute or more.

From looking at the sagetvclient_0.txt file, it looks like the problem is being identified by multiple AWTThread Hang Detected entries. I have seen some other conversation about this entry, but nothing that seems to determine whether the entries are a symptom or a by product of the problem.


The client is completely frozen while the entries are being written out to the log file.

Code:
Mon 12/4 3:20:41.268 DShowMediaPlayer is consuming the events...
Mon 12/4 3:20:41.268 VF processing job null nPlayin=true
Mon 12/4 3:20:41.269 isRec=false rd=5394422 base=454947
Mon 12/4 3:20:41.269 VF thread is now waiting for 1:22:19.225
Mon 12/4 3:20:43.590 VF.submitJob(VFJob[CloseMF r=0.0 t=0 file=null ifn=null])
Mon 12/4 3:20:43.590 VF processing job VFJob[CloseMF r=0.0 t=0 file=null ifn=null] nPlayin=true
Mon 12/4 3:20:43.591 CloseAndWait is executing the close job synchronously now
Mon 12/4 3:20:43.591 VF processing on UI Thread VFJob[CloseMF r=0.0 t=0 file=null ifn=null]
Mon 12/4 3:20:43.606 VF logFileWatch doneAir=A[8223280,8223243,"CBS News Sunday Morning",11717@1203.09:00,90] theTime=Sun 12/3 9:07:37.821 recTime=Sun 12/3 9:00:00.077
Mon 12/4 3:20:43.607 Stopping the playback graph.
Mon 12/4 3:20:43.700 Tearing down playback graph
Mon 12/4 3:20:43.701 NATIVE Deallocating the CPlayerData object
Mon 12/4 3:20:43.742 NATIVE Finished destroying the playback graph
Mon 12/4 3:20:43.745 VF processing job null nPlayin=false
Mon 12/4 3:20:43.746 VF thread is now waiting for 0:00:00.000
Mon 12/4 3:20:43.755 setUI(sage.b1@f48c35[SageRecordings w/ Optional Preview & AutoCategories]) histIdx=6 uiHistory=[sage.b1@36afc2[Main Menu], sage.b1@f48c35[SageRecordings w/ Optional Preview & AutoCategories], sage.b1@36afc2[Main Menu], sage.b1@1212499[Setup Menu], sage.b1@1f221b6[Detailed Setup], sage.b1@36afc2[Main Menu], sage.b1@f48c35[SageRecordings w/ Optional Preview & AutoCategories], sage.b1@19bcf14[MediaPlayer OSD]]
Mon 12/4 3:20:44.732 AWTThread Hang Detected - hang time = 750
Mon 12/4 3:20:45.482 AWTThread Hang Detected - hang time = 1500
Mon 12/4 3:20:46.232 AWTThread Hang Detected - hang time = 2250
Mon 12/4 3:20:46.996 AWTThread Hang Detected - hang time = 3014
Mon 12/4 3:20:47.746 AWTThread Hang Detected - hang time = 3764
Mon 12/4 3:20:48.496 AWTThread Hang Detected - hang time = 4514
Mon 12/4 3:20:49.246 AWTThread Hang Detected - hang time = 5264
Mon 12/4 3:20:49.996 AWTThread Hang Detected - hang time = 6014
Mon 12/4 3:20:50.746 AWTThread Hang Detected - hang time = 6764
Mon 12/4 3:20:51.504 AWTThread Hang Detected - hang time = 7522
Mon 12/4 3:20:52.255 AWTThread Hang Detected - hang time = 8273
Mon 12/4 3:20:53.012 AWTThread Hang Detected - hang time = 9030
Mon 12/4 3:20:53.762 AWTThread Hang Detected - hang time = 9780
Mon 12/4 3:20:54.513 AWTThread Hang Detected - hang time = 10531
Mon 12/4 3:20:55.263 AWTThread Hang Detected - hang time = 11281
Mon 12/4 3:20:56.013 AWTThread Hang Detected - hang time = 12031
Mon 12/4 3:20:56.763 AWTThread Hang Detected - hang time = 12781
Mon 12/4 3:20:57.529 AWTThread Hang Detected - hang time = 13547
Mon 12/4 3:20:58.279 AWTThread Hang Detected - hang time = 14297
Mon 12/4 3:20:59.029 AWTThread Hang Detected - hang time = 15047
Mon 12/4 3:20:59.208 VF processing job null nPlayin=false
Mon 12/4 3:20:59.208 VF thread is now waiting for 0:00:00.000
Mon 12/4 3:20:59.209 VF.submitJob(VFJob[CloseMF r=0.0 t=0 file=null ifn=null])
Mon 12/4 3:20:59.210 VF processing job VFJob[CloseMF r=0.0 t=0 file=null ifn=null] nPlayin=false
Mon 12/4 3:20:59.210 CloseAndWait is executing the close job synchronously now
Mon 12/4 3:20:59.223 VF processing on UI Thread VFJob[CloseMF r=0.0 t=0 file=null ifn=null]
Mon 12/4 3:20:59.224 VF processing job null nPlayin=false
Mon 12/4 3:20:59.225 VF thread is now waiting for 0:00:00.000
Mon 12/4 3:21:17.178 AWTThread Hang Detected - hang time = 749
Mon 12/4 3:21:17.928 AWTThread Hang Detected - hang time = 1499
Mon 12/4 3:21:18.678 AWTThread Hang Detected - hang time = 2249
Mon 12/4 3:21:19.308 MediaFile creating thumbnail to C:\Program Files\SageTV\SageTV\GeneratedThumbnails\SMyTVsGoodMorningJacksonvilleSaturday81282920mpg.jpg for MediaFile[id=8225545 A[8128292,5533075,"Good Morning Jacksonville Saturday",11888@1202.09:00,60] host=tuckman-server encodedBy=Hauppauge WinTV PVR PCI II Capture #2  format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 720x480 4:3 3800 kbps interlaced]#1 Audio[MP2 48000 Hz 2 channels 384 kbps]] S:\MyTVs\GoodMorningJacksonvilleSaturday-8128292-0.mpg, Seg0[Sat 12/2 9:00:00.864-Sat 12/2 10:00:00.054]]
Mon 12/4 3:21:20.704 AWTThread Hang Detected - hang time = 750
Mon 12/4 3:21:21.462 AWTThread Hang Detected - hang time = 1508
Mon 12/4 3:21:22.213 AWTThread Hang Detected - hang time = 2259
Mon 12/4 3:21:22.963 AWTThread Hang Detected - hang time = 3009
Mon 12/4 3:21:23.713 AWTThread Hang Detected - hang time = 3759
Is anyone else seeing the same log entries, and if so, are you also having lockups / stuttering?

Thanks
__________________
Mike : Technical Architect / Software Engineer
HTPC : Intel® Core 2 Q6600 2.4GHz Quad Core Processor, 3GB RAM, 1TB DASD, Vista Home Prem, HdHomerun (2x Comcast QAM)
Main TV: Samsung 56" HDTV - STX-HD100 720p - HDMI - Sony DG910
Reply With Quote
  #2  
Old 12-04-2006, 06:22 AM
salsbst's Avatar
salsbst salsbst is offline
SageTVaholic
 
Join Date: Jun 2003
Posts: 2,592
Yes and yes. Just upgraded to v6 this weekend and it's a mess!

I've got 4 machines in the mix. A Sage server with a Haup 500 and two drives for the 500 to record to, two Sage clients, and a file server that is also running a Firewire encoder and a HDHomeRun encoder.

Servers are Win2k3, clients are XP Pro... I'm going nuts trying to figure out problems. Trouble is, I keep finding new ones, from clients crashing and disappearing trying to play files, to hanging GUIs to server CPU usage, I'm going nuts.
Reply With Quote
  #3  
Old 12-04-2006, 10:09 AM
salsbst's Avatar
salsbst salsbst is offline
SageTVaholic
 
Join Date: Jun 2003
Posts: 2,592
Thanks. I just spent the weekend (that was supposed to be about catching up at workwork) messing around w/Sage, so it may be a few days before I have time to work on this again. I guess I'll "look forward" to doing relatively clean installs . This morning, the Sage service was hung on the server
Reply With Quote
  #4  
Old 12-04-2006, 09:58 PM
salsbst's Avatar
salsbst salsbst is offline
SageTVaholic
 
Join Date: Jun 2003
Posts: 2,592
I just reinstalled the server. Started it in non-service mode. It's still using 15-40% of my CPU while recording. I see almost nothing in the log file during these times:

Code:
Mon 12/4 22:45:42.450 VideoDiskspaceFreeProportion: 0.8634962830667395
Mon 12/4 22:45:45.708 Screen Saver Timeout expired....tv=false playin=false fs=false sleepy=false currSS=false
Mon 12/4 22:45:54.450 Ministry is waiting for 180 sec
Mon 12/4 22:46:45.857 Calculate space required for upcomming manual/favourite airings for next 2 days and display
Mon 12/4 22:46:47.288 Calculate size of partial recordings
Mon 12/4 22:46:47.326 Found 9 partials using 18948994688 bytes
Mon 12/4 22:46:48.063 Screen Saver Timeout expired....tv=false playin=false fs=false sleepy=false currSS=false
Mon 12/4 22:46:48.695 VideoDiskspaceReqProportion: 1.0
Mon 12/4 22:46:48.696 VideoDiskspaceFreeProportion: 0.8634959177247525
Mon 12/4 22:47:50.426 Screen Saver Timeout expired....tv=false playin=false fs=false sleepy=false currSS=false
Mon 12/4 22:47:52.154 Calculate space required for upcomming manual/favourite airings for next 2 days and display
Mon 12/4 22:47:53.556 Calculate size of partial recordings
Mon 12/4 22:47:53.579 Found 9 partials using 19282961024 bytes
Mon 12/4 22:47:54.973 VideoDiskspaceReqProportion: 1.0
Mon 12/4 22:47:54.974 VideoDiskspaceFreeProportion: 0.8634973197616775
Mon 12/4 22:48:52.791 Screen Saver Timeout expired....tv=false playin=false fs=false sleepy=false currSS=false
Mon 12/4 22:48:54.460 Ministry is waiting for 180 sec
Mon 12/4 22:48:58.484 Calculate space required for upcomming manual/favourite airings for next 2 days and display
Mon 12/4 22:48:59.932 Calculate size of partial recordings
Mon 12/4 22:48:59.964 Found 9 partials using 19620017792 bytes
Mon 12/4 22:49:01.317 VideoDiskspaceReqProportion: 1.0
Mon 12/4 22:49:01.318 VideoDiskspaceFreeProportion: 0.8634959045110757
Concering hangs, I just had a revelation and noticed that the disk space bar seemed to be hanging around in the log near the hangs... disabled it, and POOF! No more hangs. It looks like something in the disk space bar is happening in the main thread where it should probably be forked off so as not to get in the way.

Code:
Mon 12/4 21:39:56.950 FullScreen set to true
Mon 12/4 21:39:56.951 VF thread is now running...
Mon 12/4 21:39:56.952 VF thread is now waiting for 0:00:00.000
Mon 12/4 21:39:56.959 UIMgr loading UI from: C:\Program Files\SageTV\SageTV\STVs\SageTV3\SageTV3.xml
Mon 12/4 21:39:57.583 Loading startup runnable:net.sf.sageplugins.webserver.StartServer
Mon 12/4 21:39:57.587 ERROR Loading startup runnable extension of:java.lang.ClassNotFoundException: net.sf.sageplugins.webserver.StartServer
Mon 12/4 21:39:57.590 StorageDeviceDetector started...
Mon 12/4 21:39:58.324 AWTThread Hang Detected - hang time = 776
Mon 12/4 21:39:58.431 WarlockRipper got 333 channels
Mon 12/4 21:39:59.082 AWTThread Hang Detected - hang time = 1534
Mon 12/4 21:39:59.460 locale = en
Mon 12/4 21:39:59.849 AWTThread Hang Detected - hang time = 2301
Mon 12/4 21:39:59.854 EVPoolSize=1
Mon 12/4 21:39:59.905 Hidden Extras are ENABLED
Mon 12/4 21:40:00.157 DatePat=EEE, MMM d orgPat=EEEE, MMMM d, yyyy
Mon 12/4 21:40:00.183 setUI(sage.b1@15c1ec[Main Menu]) histIdx=0 uiHistory=[sage.b1@15c1ec[Main Menu]]
Mon 12/4 21:40:00.200 Calculate space required for upcomming manual/favourite airings for next 2 days and display
Mon 12/4 21:40:00.485 Enforcing keep at most limits for the files...
Mon 12/4 21:40:00.598 AWTThread Hang Detected - hang time = 3050
Mon 12/4 21:40:00.679 Seeker waiting for 17 mins.
Mon 12/4 21:40:01.348 AWTThread Hang Detected - hang time = 3800
Mon 12/4 21:40:02.098 AWTThread Hang Detected - hang time = 4550
Mon 12/4 21:40:02.127 Calculate size of partial recordings
Mon 12/4 21:40:02.151 Found 4 partials using 5096718080 bytes
Mon 12/4 21:40:02.848 AWTThread Hang Detected - hang time = 5300
Mon 12/4 21:40:03.528 VideoDiskspaceReqProportion: 1.0
Mon 12/4 21:40:03.529 VideoDiskspaceFreeProportion: 0.8634893424619869
Mon 12/4 21:40:03.598 AWTThread Hang Detected - hang time = 6050
Reply With Quote
  #5  
Old 12-05-2006, 06:50 AM
spacecadet spacecadet is offline
Sage Aficionado
 
Join Date: May 2005
Location: Lexington, MA
Posts: 388
I got this same behavior yesterday and for me it appeared to be related to Neilm's CPU/Motherboard monitoring plugin:

Code:
Mon 12/4 23:03:19.034 About to perform media time selection for 4043086
Mon 12/4 23:03:20.500 AWTThread Hang Detected - hang time = 750
Mon 12/4 23:03:20.740 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:03:21.257 AWTThread Hang Detected - hang time = 1522
Mon 12/4 23:03:22.007 AWTThread Hang Detected - hang time = 2272
Mon 12/4 23:03:22.743 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:03:22.757 AWTThread Hang Detected - hang time = 3022
Mon 12/4 23:03:23.507 AWTThread Hang Detected - hang time = 3772
Mon 12/4 23:03:24.257 AWTThread Hang Detected - hang time = 4522
Mon 12/4 23:03:24.746 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:03:25.007 AWTThread Hang Detected - hang time = 5272
Mon 12/4 23:03:25.757 AWTThread Hang Detected - hang time = 6022
Mon 12/4 23:03:26.507 AWTThread Hang Detected - hang time = 6772
Mon 12/4 23:03:26.748 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:03:27.257 AWTThread Hang Detected - hang time = 7522
Mon 12/4 23:03:28.007 AWTThread Hang Detected - hang time = 8272
Mon 12/4 23:03:28.751 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:03:28.757 AWTThread Hang Detected - hang time = 9022
Mon 12/4 23:03:29.507 AWTThread Hang Detected - hang time = 9772
Mon 12/4 23:03:30.257 AWTThread Hang Detected - hang time = 10522
Mon 12/4 23:03:30.754 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:03:31.007 AWTThread Hang Detected - hang time = 11272
Mon 12/4 23:03:31.757 AWTThread Hang Detected - hang time = 12022
Mon 12/4 23:03:32.507 AWTThread Hang Detected - hang time = 12772
Mon 12/4 23:03:32.757 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:03:33.257 AWTThread Hang Detected - hang time = 13522
Mon 12/4 23:03:34.007 AWTThread Hang Detected - hang time = 14272
Mon 12/4 23:03:34.756 AWTThread Hang Detected - hang time = 15021
Mon 12/4 23:03:34.759 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:03:35.506 AWTThread Hang Detected - hang time = 15771
Mon 12/4 23:03:36.256 AWTThread Hang Detected - hang time = 16521
Mon 12/4 23:03:36.762 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:03:37.006 AWTThread Hang Detected - hang time = 17271
Mon 12/4 23:03:37.756 AWTThread Hang Detected - hang time = 18021
Mon 12/4 23:03:38.506 AWTThread Hang Detected - hang time = 18771
Mon 12/4 23:03:38.765 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:03:39.256 AWTThread Hang Detected - hang time = 19521
Mon 12/4 23:03:40.006 AWTThread Hang Detected - hang time = 20271
Mon 12/4 23:03:40.756 AWTThread Hang Detected - hang time = 21021
Mon 12/4 23:03:40.768 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:03:41.506 AWTThread Hang Detected - hang time = 21771
Mon 12/4 23:03:42.256 AWTThread Hang Detected - hang time = 22521
Mon 12/4 23:03:42.771 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:03:43.006 AWTThread Hang Detected - hang time = 23271
Mon 12/4 23:03:43.756 AWTThread Hang Detected - hang time = 24021
Mon 12/4 23:03:44.506 AWTThread Hang Detected - hang time = 24771
Mon 12/4 23:03:44.774 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:03:45.256 AWTThread Hang Detected - hang time = 25521
Mon 12/4 23:03:46.006 AWTThread Hang Detected - hang time = 26271
Mon 12/4 23:03:46.756 AWTThread Hang Detected - hang time = 27021
Mon 12/4 23:03:46.778 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:03:47.506 AWTThread Hang Detected - hang time = 27771
Mon 12/4 23:03:48.256 AWTThread Hang Detected - hang time = 28521
Mon 12/4 23:03:48.781 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:03:49.005 AWTThread Hang Detected - hang time = 29270
Mon 12/4 23:03:49.755 AWTThread Hang Detected - hang time = 30020
Mon 12/4 23:03:50.505 AWTThread Hang Detected - hang time = 30770
Mon 12/4 23:03:50.785 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:03:51.255 AWTThread Hang Detected - hang time = 31520
Mon 12/4 23:03:52.005 AWTThread Hang Detected - hang time = 32270
Mon 12/4 23:03:52.755 AWTThread Hang Detected - hang time = 33020
Mon 12/4 23:03:52.787 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:03:53.505 AWTThread Hang Detected - hang time = 33770
Mon 12/4 23:03:54.255 AWTThread Hang Detected - hang time = 34520
Mon 12/4 23:03:54.790 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:03:55.005 AWTThread Hang Detected - hang time = 35270
Mon 12/4 23:03:55.755 AWTThread Hang Detected - hang time = 36020
Mon 12/4 23:03:56.505 AWTThread Hang Detected - hang time = 36770
Mon 12/4 23:03:56.793 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:03:57.255 AWTThread Hang Detected - hang time = 37520
Mon 12/4 23:03:58.005 AWTThread Hang Detected - hang time = 38270
Mon 12/4 23:03:58.755 AWTThread Hang Detected - hang time = 39020
Mon 12/4 23:03:58.797 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:03:59.505 AWTThread Hang Detected - hang time = 39770
Mon 12/4 23:04:00.255 AWTThread Hang Detected - hang time = 40520
Mon 12/4 23:04:00.800 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:04:01.005 AWTThread Hang Detected - hang time = 41270
Mon 12/4 23:04:01.755 AWTThread Hang Detected - hang time = 42020
Mon 12/4 23:04:02.505 AWTThread Hang Detected - hang time = 42770
Mon 12/4 23:04:02.802 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:04:03.255 AWTThread Hang Detected - hang time = 43519
Mon 12/4 23:04:04.004 AWTThread Hang Detected - hang time = 44269
Mon 12/4 23:04:04.754 AWTThread Hang Detected - hang time = 45019
Mon 12/4 23:04:04.806 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:04:05.504 AWTThread Hang Detected - hang time = 45769
Mon 12/4 23:04:06.254 AWTThread Hang Detected - hang time = 46519
Mon 12/4 23:04:06.810 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:04:07.004 AWTThread Hang Detected - hang time = 47269
Mon 12/4 23:04:07.754 AWTThread Hang Detected - hang time = 48019
Mon 12/4 23:04:08.504 AWTThread Hang Detected - hang time = 48769
Mon 12/4 23:04:08.813 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:04:09.254 AWTThread Hang Detected - hang time = 49519
Mon 12/4 23:04:10.004 AWTThread Hang Detected - hang time = 50269
Mon 12/4 23:04:10.754 AWTThread Hang Detected - hang time = 51019
Mon 12/4 23:04:10.817 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:04:11.504 AWTThread Hang Detected - hang time = 51769
Mon 12/4 23:04:12.254 AWTThread Hang Detected - hang time = 52519
Mon 12/4 23:04:12.820 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:04:13.004 AWTThread Hang Detected - hang time = 53269
Mon 12/4 23:04:13.754 AWTThread Hang Detected - hang time = 54019
Mon 12/4 23:04:14.504 AWTThread Hang Detected - hang time = 54769
Mon 12/4 23:04:14.823 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:04:15.254 AWTThread Hang Detected - hang time = 55519
Mon 12/4 23:04:16.004 AWTThread Hang Detected - hang time = 56269
Mon 12/4 23:04:16.754 AWTThread Hang Detected - hang time = 57019
Mon 12/4 23:04:16.826 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:04:17.504 AWTThread Hang Detected - hang time = 57768
Mon 12/4 23:04:18.253 AWTThread Hang Detected - hang time = 58518
Mon 12/4 23:04:18.829 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:04:19.003 AWTThread Hang Detected - hang time = 59268
Mon 12/4 23:04:19.753 AWTThread Hang Detected - hang time = 60018
Mon 12/4 23:04:20.503 AWTThread Hang Detected - hang time = 60768
Mon 12/4 23:04:20.831 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:04:21.253 AWTThread Hang Detected - hang time = 61518
Mon 12/4 23:04:22.003 AWTThread Hang Detected - hang time = 62268
Mon 12/4 23:04:22.753 AWTThread Hang Detected - hang time = 63018
Mon 12/4 23:04:22.834 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:04:23.503 AWTThread Hang Detected - hang time = 63768
Mon 12/4 23:04:24.253 AWTThread Hang Detected - hang time = 64518
Mon 12/4 23:04:24.837 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:04:25.003 AWTThread Hang Detected - hang time = 65268
Mon 12/4 23:04:25.753 AWTThread Hang Detected - hang time = 66018
Mon 12/4 23:04:26.503 AWTThread Hang Detected - hang time = 66768
Mon 12/4 23:04:26.840 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:04:27.253 AWTThread Hang Detected - hang time = 67518
Mon 12/4 23:04:28.003 AWTThread Hang Detected - hang time = 68268
Mon 12/4 23:04:28.753 AWTThread Hang Detected - hang time = 69018
Mon 12/4 23:04:28.843 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:04:29.503 AWTThread Hang Detected - hang time = 69768
Mon 12/4 23:04:30.253 AWTThread Hang Detected - hang time = 70518
Mon 12/4 23:04:30.845 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:04:31.003 AWTThread Hang Detected - hang time = 71268
Mon 12/4 23:04:31.753 AWTThread Hang Detected - hang time = 72018
Mon 12/4 23:04:32.502 AWTThread Hang Detected - hang time = 72767
Mon 12/4 23:04:32.848 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:04:33.252 AWTThread Hang Detected - hang time = 73517
Mon 12/4 23:04:34.002 AWTThread Hang Detected - hang time = 74267
Mon 12/4 23:04:34.752 AWTThread Hang Detected - hang time = 75017
Mon 12/4 23:04:34.851 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:04:35.502 AWTThread Hang Detected - hang time = 75767
Mon 12/4 23:04:36.252 AWTThread Hang Detected - hang time = 76517
Mon 12/4 23:04:36.854 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:04:37.002 AWTThread Hang Detected - hang time = 77267
Mon 12/4 23:04:37.752 AWTThread Hang Detected - hang time = 78017
Mon 12/4 23:04:38.502 AWTThread Hang Detected - hang time = 78767
Mon 12/4 23:04:38.857 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:04:39.257 AWTThread Hang Detected - hang time = 79522
Mon 12/4 23:04:40.009 AWTThread Hang Detected - hang time = 80274
Mon 12/4 23:04:40.759 AWTThread Hang Detected - hang time = 81024
Mon 12/4 23:04:40.860 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:04:41.509 AWTThread Hang Detected - hang time = 81774
Mon 12/4 23:04:42.259 AWTThread Hang Detected - hang time = 82524
Mon 12/4 23:04:42.864 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:04:43.009 AWTThread Hang Detected - hang time = 83274
Mon 12/4 23:04:43.759 AWTThread Hang Detected - hang time = 84024
Mon 12/4 23:04:44.508 AWTThread Hang Detected - hang time = 84773
Mon 12/4 23:04:44.867 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:04:45.258 AWTThread Hang Detected - hang time = 85523
Mon 12/4 23:04:46.008 AWTThread Hang Detected - hang time = 86273
Mon 12/4 23:04:46.758 AWTThread Hang Detected - hang time = 87023
Mon 12/4 23:04:46.870 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:04:47.508 AWTThread Hang Detected - hang time = 87773
Mon 12/4 23:04:48.258 AWTThread Hang Detected - hang time = 88523
Mon 12/4 23:04:48.872 Menu: Updating CPU/MotherboardData true
Mon 12/4 23:04:49.008 AWTThread Hang Detected - hang time = 89273
Mon 12/4 23:05:11.544 AWTThread Hang Detected - hang time = 111809
Mon 12/4 23:05:11.545 Menu: Updating CPU/MotherboardData true
Reply With Quote
  #6  
Old 12-05-2006, 08:39 AM
nielm's Avatar
nielm nielm is offline
SageTVaholic
 
Join Date: Oct 2003
Location: Belgium
Posts: 4,496
Quote:
Originally Posted by spacecadet
I got this same behavior yesterday and for me it appeared to be related to Neilm's CPU/Motherboard monitoring plugin:
That is just showing the background updates for my plugin occuring in the background as normal. You will see those every second throughout the logging. It is not causing the hang
__________________
Check out my enhancements for Sage in the Sage Customisations and Sageplugins Wiki
Reply With Quote
  #7  
Old 12-05-2006, 08:58 AM
spacecadet spacecadet is offline
Sage Aficionado
 
Join Date: May 2005
Location: Lexington, MA
Posts: 388
Quote:
Originally Posted by nielm
That is just showing the background updates for my plugin occuring in the background as normal. You will see those every second throughout the logging. It is not causing the hang
Okay. I had wondered about that also. Thanks for the update!

Has anyone logged a bug for this yet?
Reply With Quote
  #8  
Old 12-05-2006, 09:15 AM
Opus4's Avatar
Opus4 Opus4 is offline
Administrator
 
Join Date: Sep 2003
Location: NJ
Posts: 19,624
Quote:
Originally Posted by spacecadet
Has anyone logged a bug for this yet?
If you have a problem, always turn off all hidden features and use the unmodified default STV. If you still have a problem, submit a bug report.

If there is only a problem while using the hidden features, do NOT file a bug report - contact me or place a post in the hidden features thread. (salsbst has already been in touch about the problem he found.)

If there is a problem with a customization, contact its author instead of filing a bug report.

- Andy
__________________
SageTV Open Source v9 is available.
- Read the SageTV FAQ. Older PDF User's Guides mostly still apply: SageTV V7.0 & SageTV Studio v7.1.
- Hauppauge remote help: 1) Basics/Extending it 2) Replace it 3) Use it w/o needing focus
- HD Extenders: A) FAQs B) URC MX-700 remote setup
Note: This is a users' forum; see the Rules. For official tech support fill out a Support Request.
Reply With Quote
  #9  
Old 12-05-2006, 09:21 AM
srothwell's Avatar
srothwell srothwell is offline
Sage Icon
 
Join Date: Jul 2004
Location: Richmond, VA
Posts: 1,064
Everyone please also remember that is a beta-version of software.

I get an earful from my wife as well when things go wrong, like hangs but it's beta software and we're the ones who agreed to test it (with all the problems that go with it).

Best regards,

Stacy
Reply With Quote
  #10  
Old 12-14-2006, 01:53 PM
gwgunter's Avatar
gwgunter gwgunter is offline
Sage User
 
Join Date: Dec 2006
Location: Oklahoma
Posts: 32
Not running in service mode. This has happened 3 times now. In the last instance, I thought I'd disable the sage standby as my wife hates to turn on the TV and see a menu. This was my only change. The system froze later that night (AM).
The application just hangs... Looking in perf mon you couldn't tell a thing is wrong.

If I leave it alone, it does appear to be much more stable.

Thu 12/14 1:40:18.789 Seeker awoken
Thu 12/14 1:40:18.790 MARK 1 currRecord=A[45123,44759,"Entertainment Studios.com",10462@1214.01:40,30] enc=Hauppauge WinTV PVR PCI II Capture clients=[UIManager:localhost@@SAGETV_PROCESS_LOCAL_UI-aa9835] ir=false
Thu 12/14 1:40:18.790 Seeker in AUTOMATIC mode nextRecord=A[26630,26404,"Top 20 Countdown",10138@1214.15:00,180] nextTTA=47981210
Thu 12/14 1:40:18.790 FORCE WATCH abandoned because it's currently being recorded clients=[UIManager:localhost@@SAGETV_PROCESS_LOCAL_UI-aa9835]
Thu 12/14 1:40:18.791 newRecord=A[45123,44759,"Entertainment Studios.com",10462@1214.01:40,30]
Thu 12/14 1:40:18.791 Keeping record just the way it is.
Thu 12/14 1:40:18.794 RootFile=C:\ fstype=NTFS fileLength=9736128
Thu 12/14 1:40:18.795 VF processing job null nPlayin=false
Thu 12/14 1:40:18.795 Saving properties file to C:\Program Files\SageTV\SageTV\Sage.properties
Thu 12/14 1:40:18.795 VF thread is now waiting for 0:00:00.000
Thu 12/14 1:40:18.912 AWTThread Hang Detected - hang time = 2313
Thu 12/14 1:40:19.743 AWTThread Hang Detected - hang time = 3218
Thu 12/14 1:40:20.493 AWTThread Hang Detected - hang time = 3968
Thu 12/14 1:40:20.534 Checking video directories for new files
Thu 12/14 1:40:20.566 Diskspace checking is running
Thu 12/14 1:40:20.567 Verifying existence of all TV media files in database fixDurs=false avoidArchive=true
Thu 12/14 1:40:20.568 Enforcing keep at most limits for the files...
Thu 12/14 1:40:20.569 Seeker clearing unwanted and partial files...
Thu 12/14 1:40:20.571 needFreeSize = 0.4941 GB currFreeSize=231.4260224 GB
Thu 12/14 1:40:20.571 Seeker waiting for 29 mins.
Thu 12/14 1:40:21.243 AWTThread Hang Detected - hang time = 4718
Thu 12/14 1:40:21.421 CARNY Processing 212 Agents & 28321 Airs
Thu 12/14 1:40:21.993 AWTThread Hang Detected - hang time = 5468
Thu 12/14 1:40:22.743 AWTThread Hang Detected - hang time = 6218
Thu 12/14 1:40:23.493 AWTThread Hang Detected - hang time = 6968
Thu 12/14 1:40:24.243 AWTThread Hang Detected - hang time = 7718
Thu 12/14 1:40:24.993 AWTThread Hang Detected - hang time = 8468
Thu 12/14 1:40:25.743 AWTThread Hang Detected - hang time = 9218
Thu 12/14 1:40:26.493 AWTThread Hang Detected - hang time = 9968
Thu 12/14 1:40:27.243 AWTThread Hang Detected - hang time = 10718
Thu 12/14 1:40:27.993 AWTThread Hang Detected - hang time = 11468
Thu 12/14 1:40:28.743 AWTThread Hang Detected - hang time = 12218

Last edited by gwgunter; 12-18-2006 at 09:30 AM.
Reply With Quote
  #11  
Old 12-14-2006, 03:06 PM
mickp's Avatar
mickp mickp is offline
Sage Aficionado
 
Join Date: Oct 2006
Posts: 468
AWTThread hang detected

I can easily get my server to produce the AWTThread hang detected error by running it in service mode as the default system user. Changing it to run as the local administrator fixes the problem.


Mick.
Reply With Quote
  #12  
Old 01-04-2007, 04:58 PM
gwgunter's Avatar
gwgunter gwgunter is offline
Sage User
 
Join Date: Dec 2006
Location: Oklahoma
Posts: 32
This problem is finally solved. JAVA!!! I uninstalled everything Java related and sage. Upon reinstall, I saw for the first time (ever) the Java installation within Sage. Apparently, my z540 had an incompatilbe version that came with the system. I went from to Now I must
Reply With Quote
Reply


Currently Active Users Viewing This Thread: 1 (0 members and 1 guests)
 

Posting Rules
You may not post new threads
You may not post replies
You may not post attachments
You may not edit your posts

BB code is On
Smilies are On
[IMG] code is On
HTML code is Off

Forum Jump


All times are GMT -6. The time now is 05:17 PM.


Powered by vBulletin® Version 3.8.11
Copyright ©2000 - 2023, vBulletin Solutions Inc.
Copyright 2003-2005 SageTV, LLC. All rights reserved.