Hang detected?

[beelzerob]

I've been playing with the studio, and so I probably screwed something up. But all of the sudden, when I try to do ANYTHING in Sage it takes forever. The console screen is telling me a hang was detected. So, I rebooted. Didn't fix it. I replaced the sagetv3.xml file....didn't fix it. I uninstalled and reinstalled Sage...didn't fix it.

The studio finally does come up now, but anything like navigating a directory takes about 20 seconds per click because "EventThread - SAGETV_PROCESS_LOCAL_UI Hang Detected."

[gplasky]

Something hosed on your java install? Have 2 versions installed?

Gerry

[beelzerob]

Not that I'm aware of or would have intentionally done. How would I even be able to tell if I did have 2 java's installed?

Looking in the add/remove window, I have the Java development kit and 4 different updates for java 6 listed.

This problem only seems to happen when I open the studio...just regular sage doesn't appear to have a problem.

I guess I can uninstall, delete the entire sage directory, reboot, and then try again....unless anyone else has a suggestion?

[matt91]

Gerry has previously recommended this (for java):

http://forums.sagetv.com/forums/showthread.php?t=32125

you could give it a try

PS I use it too, and it works fine.

[gplasky]

Just uninstall all the versions of java except the latest from add/remove. See if that helps.

Gerry

[beelzerob]

Ok...complete uninstall, directory removal and reboot. Then reinstalled the latest sage. No difference except now, instead of actually telling me in the console screen that hang was detected, it doesn't say anything...but the delay is still there. The studio screen takes about 1 minute to come up, and trying to open a new STV takes about 20 seconds per directory entry.

I tried javara. It said I had the latest java, and it deleted about 3 different older java versions, but that was all I saw it do.

I'm wondering if the registry is hosed somehow because for one thing, the console is still coming up, even though I uninstalled everything. It also doesn't ask me for my registration key.

[gplasky]

I think the registration key is stored somewhere in the registry and it usually will not ask you again if you're reinstalling on the same PC. (Registry is a guess but it is stored somewhere on the PC.)

Other than the standard "Did you install anything lately" since the last time you knew it worked I'm not sure. Mine comes up in 5 seconds. And I don't know if a firewall change could prevent Studio from working correctly but you might try turning that off.

If system restore is turned on you could try going back a week or two if it doesn't cause you to lose too much. (Just new apps installed should be all you lose for the most part)

Gerry

[beelzerob]

Good grief.

I've uninstalled and reinstalled java and sage. I turned off my firewall and antivirus'. No difference. It still takes about 30 seconds for the studio to come up and when i try to open a new stv, clicking on each directory in the file browser causes about a 20 second wait.

Short of a complete system reinstall, I'm not sure what to do. I don't know if I have system restore available....I'll look into that.

[Opus4]

I don't remember if the console has more info than the debug log, but you could check.

You could also check your java heap size.

- Andy

[beelzerob]

well, I think I'm slowly screwing myself into a full system reinstall.

I found a system restore point of over a week ago. I know I've played with the studio since then. I restored...now sage doesn't start at all. When I click the icon, the black outline of the console window flashes for a second and then it's gone...and that's all that happens. I tried reinstalling sage, and it STILL only does that.

[beelzerob]

Ok...java was the problem there. So I installed the latest java again. Now, sage comes up, and I'm finally back to the point where....it is at least TELLING me about the hang being detected. But same problem...it keeps spitting out "Hang detected" messages while I'm waiting for the studio to come up. Then driving through directories takes forever.

[beelzerob]

Nothing more in the sagetv_0.txt file that I can see. Just this over and over again while I wait for it to continue.

Sat 9/6 13:04:59.150 EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 8257
Sat 9/6 13:04:59.900 EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 9007
Sat 9/6 13:05:00.650 EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 9757
Sat 9/6 13:05:01.400 EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 10507
Sat 9/6 13:05:02.150 EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 11257

[Opus4]

There was nothing before that point in the log that might be related?

Have you tried increasing Java's max heap size?

You could try renaming or moving all the .properties files & their .autobackup copies & try reconfiguring. I don't know if you've done that already, but uninstalling & reinstalling doesn't clear the properties files unless you manually get rid of them.

Otherwise, check with tech support for more ideas.

- Andy

[beelzerob]

Well, I haven't tried the java heapsize thing just because, as far as I know, I haven't done anything different that should have affected that since it last worked. But, heck, I'll give it a try.

There MIGHT be something more in the log, but it's not obvious to me. For me, I'd need something surrounded by *ERROR ERROR* to notice it.

I did completely uninstall and I then renamed the old Sage directory, so when it reinstalled it created a new one. Do I need to do more than that, or is Sage wiley enough to find it's old .property files?

Edit: changed javaheapmaxsize from 0 to 0x200...no difference (assuming I just had to restart sage, not reboot)

[beelzerob]

Well, I looked over the log. I'm getting one of those hang detected notices before I even try to start the studio. Here is the first notice, and all of the log before it.

Sun 9/7 9:30:29.288 user.dir2=C:\Program Files\SageTV\SageTV
Sun 9/7 9:30:29.289 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\Java\jre1.6.0_03\lib\ext\QTJava.zip;JARs\commons-jxpath-1.1.jar;JARs\commons-logging-api.jar;JARs\commons-logging.jar;JARs\gkusnick.sagetv.jar;JARs\jcifs-1.1.6.jar;JARs\jdic.jar;JARs\mx4j-impl.jar;JARs\mx4j-jmx.jar;JARs\mx4j-remote.jar;JARs\mx4j-tools.jar;JARs\nielm_sageimdb.jar;JARs\nielm_sagemenureader.jar;JARs\nielm_sageutls.jar;JARs\SageCQC.jar;JARs\sbbi-jmx-1.0.jar;JARs\sbbi-upnplib-1.0.3.jar;JARs\testMain.jar
Sun 9/7 9:30:29.289 JVM version=1.6.0_07
Sun 9/7 9:30:29.289 OS=Windows XP 5.1
Sun 9/7 9:30:29.309 Succesfully setup system shell hook
Sun 9/7 9:30:29.309 not specifiy WinkeyboardHook in registery, load default one
Sun 9/7 9:30:29.488 ImageUtils loading URL jar:file:/C:/Program%20Files/SageTV/SageTV/Sage.jar!/images/splash.gif
Sun 9/7 9:30:29.503 ImageUtils creating BI copy sun.awt.image.ToolkitImage@26e431 w=520 h=350 freeMem=22291120 totalMem=25034752
Sun 9/7 9:30:29.521 SageTV V6.4.8.184
Sun 9/7 9:30:29.527 hostname=bengals
Sun 9/7 9:30:29.586 ImageUtils loading URL jar:file:/C:/Program%20Files/SageTV/SageTV/Sage.jar!/images/tvicon.gif
Sun 9/7 9:30:29.588 ImageUtils creating BI copy sun.awt.image.ToolkitImage@6eb38a w=32 h=32 freeMem=21019616 totalMem=25034752
Sun 9/7 9:30:29.768 Wizard starting to load database info...
Sun 9/7 9:30:29.772 DBFile at version 65 FileSize=4436
Sun 9/7 9:30:29.772 Wizard allocating table for Year of size 0
Sun 9/7 9:30:29.774 Wizard allocating table for Network of size 0
Sun 9/7 9:30:29.775 Wizard allocating table for Title of size 10
Sun 9/7 9:30:29.775 Wizard loading main index for Title
Sun 9/7 9:30:29.776 Wizard building alt. index 0 for Title
Sun 9/7 9:30:29.776 Wizard allocating table for Channel of size 1
Sun 9/7 9:30:29.777 Wizard loading main index for Channel
Sun 9/7 9:30:29.777 Wizard allocating table for People of size 1
Sun 9/7 9:30:29.778 Wizard loading main index for People
Sun 9/7 9:30:29.778 Wizard building alt. index 0 for People
Sun 9/7 9:30:29.779 Wizard allocating table for SubCategory of size 0
Sun 9/7 9:30:29.779 Wizard allocating table for Rated of size 0
Sun 9/7 9:30:29.779 Wizard allocating table for ParentalRating of size 0
Sun 9/7 9:30:29.780 Wizard allocating table for ExtendedRating of size 0
Sun 9/7 9:30:29.780 Wizard allocating table for Category of size 0
Sun 9/7 9:30:29.781 Wizard allocating table for PrimeTitle of size 0
Sun 9/7 9:30:29.781 Wizard allocating table for Bonus of size 0
Sun 9/7 9:30:29.781 Wizard allocating table for Show of size 10
Sun 9/7 9:30:29.782 Wizard loading main index for Show
Sun 9/7 9:30:29.782 Wizard building alt. index 0 for Show
Sun 9/7 9:30:29.783 Wizard allocating table for Airing of size 15
Sun 9/7 9:30:29.783 Wizard loading main index for Airing
Sun 9/7 9:30:29.784 Wizard building alt. index 0 for Airing
Sun 9/7 9:30:29.784 Wizard building alt. index 1 for Airing
Sun 9/7 9:30:29.785 Wizard allocating table for ManualRecord of size 0
Sun 9/7 9:30:29.786 Wizard allocating table for MediaFile of size 10
Sun 9/7 9:30:29.786 Wizard loading main index for MediaFile
Sun 9/7 9:30:29.795 Wizard building alt. index 0 for MediaFile
Sun 9/7 9:30:29.795 Wizard building alt. index 1 for MediaFile
Sun 9/7 9:30:29.796 Wizard allocating table for Watched of size 1
Sun 9/7 9:30:29.797 Wizard loading main index for Watched
Sun 9/7 9:30:29.797 Wizard building alt. index 0 for Watched
Sun 9/7 9:30:29.798 Wizard allocating table for Agent of size 0
Sun 9/7 9:30:29.798 Wizard allocating table for Wasted of size 0
Sun 9/7 9:30:29.799 Wizard allocating table for Playlist of size 0
Sun 9/7 9:30:29.799 Wizard allocating table for TVEditorial of size 0
Sun 9/7 9:30:29.799 Wizard allocating table for SeriesInfo of size 0
Sun 9/7 9:30:29.800 Wizard performing validation on database objects...
Sun 9/7 9:30:29.802 Wizard DONE loading database info. loadTime=0.033 sec
Sun 9/7 9:30:29.861 MMC calling detectCaptureDevices on sage.cb@a1807c
Sun 9/7 9:30:29.862 devices detected=[]
Sun 9/7 9:30:29.863 EncoderMap={}
Sun 9/7 9:30:29.863 MMC calling detectCaptureDevices on sage.l@fa7e74
Sun 9/7 9:30:29.868 Device detecting->:{65E8773D-8F56-11D0-A3B9-00A0C9223196}
Sun 9/7 9:30:29.878 Device detecting->:{FD0A5AF4-B41D-11d2-9C95-00C04F7971E0}
Sun 9/7 9:30:29.879 Device detecting->:{71985F48-1CA1-11d3-9CC8-00C04F7971E0}
Sun 9/7 9:30:29.880 systemCapDevices=[Realtek HD Digital input]
Sun 9/7 9:30:29.880 EncoderMap1={}
Sun 9/7 9:30:29.881 Processing new system dev:Realtek HD Digital input
Sun 9/7 9:30:29.881 devices detected=[]
Sun 9/7 9:30:29.881 EncoderMap={}
Sun 9/7 9:30:29.917 Checking video directories for new files
Sun 9/7 9:30:29.950 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, Canon Actual Data Length Setter, Canon Custom Resizer SaveMode, Canon G.726 Decoder, Canon G.726 DMO Decoder, Canon Image Rotation Filter 1.1, Canon MDP Motion-JPEG Decoder, Canon Motion-JPEG Decoder, Canon Motion-JPEG Encoder, Canon Resizer, Canon Text Source Filter, Canon WAV Dest, Color Space Converter, Deinterlace Filter, DV Muxer, DV Scenes, DV Source Filter, DV Splitter, DV Video Decoder, DVD Navigator, File Source (Async.), File Source (Netshow URL), File Source (URL), File stream renderer, File writer, Frame Eater, Full Screen Renderer, G.711 Codec, G2M Session Decoder, Indeo® audio software, Indeo® video 4.4 Compression Filter, Indeo® video 4.4 Decompression Filter, Indeo® video 5.10 Compression Filter, Indeo® video 5.10 Decompression Filter, Infinite Pin Tee Filter, Internal Script Command Renderer, Line 21 Decoder, Line 21 Decoder 2, 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 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, NSC file Parser, Null Renderer, Overlay Mixer, Overlay Mixer2, psWav Dest, QT Decompressor, QuickTime Movie Parser, Record Queue, SageTV Layer II Audio Decoder, SageTV Layer II Audio Encoder, SageTV MPEG Audio Decoder, SageTV MPEG Demultiplexer, SageTV MPEG Layer II Audio Encoder, SageTV MPEG Multiplexer, SageTV MPEG Multiplexer-Plus, SageTV MPEG Video Decoder, SageTV MPEG-2 Video Decoder, SageTV MPEG-2 Video Encoder, SageTV MpegDeMux, SageTV MpegMux, SageTV Music Visualization, SageTV Stream Parser, SageTV TS Splitter 1.0, SAMI (CC) Parser, SampleGrabber, Screen Capture filter, Shared File Source (Async.), Smart Tee, StreamBufferSink, StreamBufferSource, Stretch Video, 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 source filter, Windows Media Update Filter, Windows Media Video Decoder, Windows Media Video Decoder, WM ASF Reader, WM ASF Writer, WMA Voice Decoder DMO, WMAPro over S/PDIF DMO, WMAudio 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 Advanced Decoder DMO, WMVideo Decoder DMO, WST Decoder, XML Playlist]
Sun 9/7 9:30:29.975 CARNY Processing 0 Agents & 0 Airs
Sun 9/7 9:30:29.975 CARNY Negative Energy Size: 0
Sun 9/7 9:30:29.976 CARNY Traitors:[]
Sun 9/7 9:30:29.978 Verifying existence of all TV media files in database fixDurs=true avoidArchive=false
Sun 9/7 9:30:29.985 Carny waiting for awhile...
Sun 9/7 9:30:30.010 EPG needs an update in 212 minutes
Sun 9/7 9:30:30.010 FSManager is running...
Sun 9/7 9:30:30.010 EPG's works is done. Waiting...
Sun 9/7 9:30:30.011 Scheduler.updateSchedule() called time=Sun 9/7 9:30:30.011 manual=[] schedules={} scheduleRandSize=0
Sun 9/7 9:30:30.322 Checking video directories for new files
Sun 9/7 9:30:30.322 Diskspace checking is running
Sun 9/7 9:30:30.323 Verifying existence of all TV media files in database fixDurs=false avoidArchive=true
Sun 9/7 9:30:30.323 Enforcing keep at most limits for the files...
Sun 9/7 9:30:30.323 Seeker clearing unwanted and partial files...
Sun 9/7 9:30:30.325 Seeker waiting for 153722846934342 mins.
Sun 9/7 9:30:30.326 Seeker awoken
Sun 9/7 9:30:30.327 MemStats: Used=4MB Total=25MB Max=532MB
Sun 9/7 9:30:30.327 Checking video directories for new files
Sun 9/7 9:30:30.328 Diskspace checking is running
Sun 9/7 9:30:30.328 Verifying existence of all TV media files in database fixDurs=false avoidArchive=true
Sun 9/7 9:30:30.328 Enforcing keep at most limits for the files...
Sun 9/7 9:30:30.329 Seeker clearing unwanted and partial files...
Sun 9/7 9:30:30.329 Seeker waiting for 153722846934342 mins.
Sun 9/7 9:30:30.822 Seeker is starting the library import scan...
Sun 9/7 9:30:30.833 Increased StringBuffer pool to size=1
Sun 9/7 9:30:30.834 Skipping video import dir that's also a recording dir:C:\Documents and Settings\Rob\My Documents\My Videos\SageTV
Sun 9/7 9:30:30.840 Seeker has finished the library import scan.
Sun 9/7 9:30:34.985 Ministry is starting
Sun 9/7 9:30:34.986 Ministry is waiting for 180 sec
Sun 9/7 9:30:39.989 Trying to find lan network interface
Sun 9/7 9:30:39.990 SageTVServer was instantiated.
Sun 9/7 9:30:39.992 SageTVDiscoveryServer was instantiated.
Sun 9/7 9:30:39.994 SageTVMiniDiscoveryServer was instantiated.
Sun 9/7 9:30:39.996 addr: /127.0.0.1
Sun 9/7 9:30:39.996 addr: /192.168.0.2
Sun 9/7 9:30:39.996 Miniserver running on 192.168.0.2
Sun 9/7 9:30:39.997 Parsed 0 clients
Sun 9/7 9:30:40.004 Loading locator keys from filesystem since they already exist.
Sun 9/7 9:30:40.007 0.0.0.0/0.0.0.0 16867
Sun 9/7 9:30:40.021 VF thread is now running...
Sun 9/7 9:30:40.023 0.0.0.0/0.0.0.0 16881
Sun 9/7 9:30:40.024 0.0.0.0/0.0.0.0 16869
Sun 9/7 9:30:40.025 VF thread is now waiting for 0:00:00.000
Sun 9/7 9:30:40.027 UIMgr loading UI from: C:\Program Files\SageTV\SageTV\STVs\SageTV3\SageTV3.xml
Sun 9/7 9:30:40.029 Starting UPnP NAT Manager...
Sun 9/7 9:30:40.030 StorageDeviceDetector started...
Sun 9/7 9:30:40.846 locale = en
Sun 9/7 9:30:41.084 EventThread-SAGETV_PROCESS_LOCAL_UI Hang Detected - hang time = 889
Sun 9/7 9:30:41.175 UIMgr done loading UI from: C:\Program Files\SageTV\SageTV\STVs\SageTV3\SageTV3.xml
Sun 9/7 9:30:41.212 Increased vector pool to size=1
Sun 9/7 9:30:41.232 Hidden Extras are DISABLED

[beelzerob]

Well, I went in and deleted all the .properties files and the autobackup property file, and it had the result of removing the hang message. Note that it does STILL hang because it still takes about 30 seconds or more for Studio to load...but now it doesn't actually tell me it is hanging.

I think I'll try one more complete uninstall and reinstall before I talk to tech support. What a pain.

[gplasky]

Shot in the dark.
You don't happen to have a path defined as a recording drive or an import path that for some reason right now doesn't exist? Like a USB drive or a network drive that for some reason has fallen off the face of the earth?

Gerry

[beelzerob]

None that I can think of, but even if I did, wouldn't a complete uninstall/reinstall fix that? It takes me back through the setup process where I'd setup any import directories and I just hit next.

I've now done as much of an uninstall and clearing as I can...I even went into the registry and deleted whatever looked sagelike.

When I start sage, it seems fine. Then I hit Shift-Ctrl-F12, and I get the little swirly "I'm busy" indication, and about 30-40 seconds later Studio finally comes up. If I then close studio and hit Shift-Ctrl-F12 again, then studio comes right up. But if I close Sage, restart it, and hit it, it again takes 40 seconds or so.

Off to tech support I go, I guess. How bizarre.

[gplasky]

This is a PC client, correct? Reboots, reinstalls-all on the PC client. During any of this do you have Sage server and did you reboot the Sage server?

Gerry

[beelzerob]

my server and client are all on the same PC. Currently I'm only using sage for studio development purposes, so it's just installed on my desktop PC and only runs when I start it up.