Help troubleshooting HD100 freezes with Sage v7

[motulal]

Hi,

Hoping the community can help me troubleshoot frequent HD100 freezes after upgrading to Sage v7. A power cycle of the extender will bring it back into business until the next random freeze. The front LED lights continue to be lit and flicker in response to remote key presses. We've noticed that closed captioning stops about 30 seconds before the extender freezes ( or video output goes dark ).

The setup has run flawlessly for about 2 years on Sage v6.

The error message in the log indicate that a "ERROR: MiniUIClient receiver timed out waiting for response from the MiniClient!" followed by another timeout after about 30 seconds - "[MCSRReconnect@36f0c9] MCSR reconnect daemon timed out w/no reconnection, kill the UI!".

SageTV version 7.1.9.256
Java 1.6.0_29
OS Windows XP
HD100 with latest firmware
SageTV7.xml (version 7.1.9.6 )
JVM Heap max 512 MB.

The only plugins used are 'Commercial Detector', 'Commercial Detector UI', 'Comskip Playback', 'comskip', 'google weather' and 'sagex-api'.


Both 'server' and extender are plugged into the same switch. I've replaced the switch and network cables with no luck. Tried a different NIC as well with no success. There are no pertinent messages in the Windows event log and the hangs / freezes occur even when the machine is not recording or commercial detecting. The freezes do appear to be random and only started after the upgrade to Sage v7.


Any suggestions ? What can i do to to eliminate those timeouts ?

Rupert

"Mon 11/14 0:14:12.359 [VideoFrame-001e40b6b8a1@1db1c5] VF is updating the CC text now
Mon 11/14 0:14:12.359 [VideoFrame-001e40b6b8a1@1db1c5] VF ttu after for cc=15000
Mon 11/14 0:14:12.360 [VideoFrame-001e40b6b8a1@1db1c5] VF thread is now waiting for 0:00:15.000
Mon 11/14 0:14:13.668 [VideoFrame-001e40b6b8a1@1db1c5] VF processing job null nPlayin=true
Mon 11/14 0:14:13.683 [VideoFrame-001e40b6b8a1@1db1c5] isRec=false rd=3599475 base=1556145 eos=false
Mon 11/14 0:14:13.684 [VideoFrame-001e40b6b8a1@1db1c5] VF ttu for cc=0
Mon 11/14 0:14:13.685 [VideoFrame-001e40b6b8a1@1db1c5] VF is updating the CC text now
Mon 11/14 0:14:13.685 [VideoFrame-001e40b6b8a1@1db1c5] VF ttu after for cc=604800000
Mon 11/14 0:14:13.685 [VideoFrame-001e40b6b8a1@1db1c5] VF thread is now waiting for 0:34:03.080
Mon 11/14 0:14:13.746 [VideoFrame-001e40b6b8a1@1db1c5] VF processing job null nPlayin=true
Mon 11/14 0:14:13.746 [VideoFrame-001e40b6b8a1@1db1c5] isRec=false rd=3599475 base=1556145 eos=false
Mon 11/14 0:14:13.747 [VideoFrame-001e40b6b8a1@1db1c5] VF ttu for cc=0
Mon 11/14 0:14:13.747 [VideoFrame-001e40b6b8a1@1db1c5] VF is updating the CC text now
Mon 11/14 0:14:13.747 [VideoFrame-001e40b6b8a1@1db1c5] VF ttu after for cc=15000
Mon 11/14 0:14:13.748 [VideoFrame-001e40b6b8a1@1db1c5] VF thread is now waiting for 0:00:15.000
Mon 11/14 0:14:15.245 [FinalRender-001e40b6b8a1@1d48085] ERROR: MiniUIClient receiver timed out waiting for response from the MiniClient!
Mon 11/14 0:14:15.246 [MCSRReconnect@36f0c9] Preparing the media player for a reload...
Mon 11/14 0:14:15.246 [FinalRender-001e40b6b8a1@1d48085] MiniUI client error23:java.lang.ArrayIndexOutOfBoundsException: Array index out of range: 0
Mon 11/14 0:14:15.246 [MCSRReconnect@36f0c9] VF.submitJob(VFJob[ReloadPrepareMF r=0.0 t=0 file=null ifn=null])
Mon 11/14 0:14:15.246 [FinalRender-001e40b6b8a1@1d48085] java.lang.ArrayIndexOutOfBoundsException: Array index out of range: 0
Mon 11/14 0:14:15.246 [VideoFrame-001e40b6b8a1@1db1c5] VF processing job VFJob[ReloadPrepareMF r=0.0 t=0 file=null ifn=null] nPlayin=true
Mon 11/14 0:14:15.246 [FinalRender-001e40b6b8a1@1d48085] java.util.Vector.remove(Unknown Source)
Mon 11/14 0:14:15.247 [VideoFrame-001e40b6b8a1@1db1c5] VF processing on UI Thread VFJob[ReloadPrepareMF r=0.0 t=0 file=null ifn=null]
Mon 11/14 0:14:15.247 [FinalRender-001e40b6b8a1@1d48085] sage.bu$d.do(Unknown Source)
Mon 11/14 0:14:15.247 [FinalRender-001e40b6b8a1@1d48085] sage.bu$d.new(Unknown Source)
Mon 11/14 0:14:15.247 [FinalRender-001e40b6b8a1@1d48085] sage.bu.U(Unknown Source)
Mon 11/14 0:14:15.247 [FinalRender-001e40b6b8a1@1d48085] sage.bu.a(Unknown Source)
Mon 11/14 0:14:15.247 [FinalRender-001e40b6b8a1@1d48085] sage.bx.a(Unknown Source)
Mon 11/14 0:14:15.247 [FinalRender-001e40b6b8a1@1d48085] sage.bx.int(Unknown Source)
Mon 11/14 0:14:15.247 [FinalRender-001e40b6b8a1@1d48085] sage.bx$1.run(Unknown Source)
Mon 11/14 0:14:15.250 [VideoFrame-001e40b6b8a1@1db1c5] stopPush0()
Mon 11/14 0:14:15.255 [VideoFrame-001e40b6b8a1@1db1c5] Closing down MiniPlayer
Mon 11/14 0:14:15.255 [VideoFrame-001e40b6b8a1@1db1c5] closeDriver0()
Mon 11/14 0:14:15.364 [VideoFrame-001e40b6b8a1@1db1c5] VF processing job null nPlayin=false
Mon 11/14 0:14:15.364 [MCSRReconnect@36f0c9] MediaPlayer is ready for the reload.
Mon 11/14 0:14:15.364 [VideoFrame-001e40b6b8a1@1db1c5] isRec=false rd=3599999 base=0 eos=false
Mon 11/14 0:14:15.364 [MCSRReconnect@36f0c9] MCSR reconnect daemon has started...wait up to 30 seconds for a client reconnect...
Mon 11/14 0:14:15.364 [VideoFrame-001e40b6b8a1@1db1c5] VF ttu for cc=1571145
Mon 11/14 0:14:15.364 [VideoFrame-001e40b6b8a1@1db1c5] VF thread is now waiting for 0:00:00.000
Mon 11/14 0:14:15.438 [MiniUIServer@9c67db] MiniUI got connection from java.nio.channels.SocketChannel[connected local=/192.168.123.167:31099 remote=/192.168.123.162:1062]
Mon 11/14 0:14:15.439 [MiniUIServerConnection@1933da1] MiniPlayer is adding to its map:001e40b6b8a1
Mon 11/14 0:14:46.353 [MCSRReconnect@36f0c9] MCSR reconnect daemon timed out w/no reconnection, kill the UI!
Mon 11/14 0:14:46.354 [KillUIMgr@d6a3d1] Killing UIMgr UIManager:localhost@@001e40b6b8a1-e2bc8d
Mon 11/14 0:14:46.354 [KillUIMgr@d6a3d1] Killed UI Timers
Mon 11/14 0:14:46.356 [KillUIMgr@d6a3d1] Updated:Watched[id=3060273 Airing=A[3007899,3007868,"Terra Nova",19616@1107.19:00,60], WatchStart=Mon 11/7 19:00:00.002, WatchEnd=Mon 11/7 19:25:57.940, RealStart=Sat 11/12 23:27:32.928, RealEnd=Mon 11/14 0:14:46.355]
Mon 11/14 0:14:46.356 [KillUIMgr@d6a3d1] VF logFileWatch doneAir=A[3007899,3007868,"Terra Nova",19616@1107.19:00,60] theTime=Mon 11/7 19:25:57.940 recTime=Mon 11/7 19:00:00.002
Mon 11/14 0:14:46.356 [KillUIMgr@d6a3d1] Closing down MiniPlayer
Mon 11/14 0:14:46.356 [KillUIMgr@d6a3d1] closeDriver0()
Mon 11/14 0:14:46.356 [KillUIMgr@d6a3d1] java.lang.NullPointerException
Mon 11/14 0:14:46.357 [KillUIMgr@d6a3d1] Seeker.finishWatch(UIManager:localhost@@001e40b6b8a1-e2bc8d)
Mon 11/14 0:14:46.357 [KillUIMgr@d6a3d1] Killed VideoFrame
Mon 11/14 0:14:46.357 [Seeker@1f52b85] Seeker awoken
Mon 11/14 0:14:46.358 [VideoFrame-001e40b6b8a1@1db1c5] VF processing job null nPlayin=false
Mon 11/14 0:14:46.358 [VideoFrame-001e40b6b8a1@1db1c5] VideoFrame thread is now exiting
Mon 11/14 0:14:46.358 [Scheduler@167f48c] Scheduler awoken
Mon 11/14 0:14:46.359 [Seeker@1f52b85] MemStats: Used=132MB Total=190MB Max=518MB"

[gplasky]

Try deleting the client.properties file for that HD100 extender. Fire it up and use it with no plugins first. Add them and test one at a time. Since this was an upgrade deleting the .properties file and re-setting it up may help. (The .properties file is in the "clients" folder with the mac address followed by .properties.)

Gerry

[motulal]

Thanks for the reply. I will try that tonight.

[motulal]

Thought that (deleting the .properties file and disabling all the plugins) did the trick but unfortunately the time outs continue. They are not as frequent though. Have only had one hang per day so far as opposed to as many as 2 to 3 per hour previously.

Could it be that my HD100 cannot handle v7 ?

Motu.

[RayGannon]

My HD100 has been working fine with version 7 of Sage. In the past I did have a problem with seemingly random bouts of frequent lockups. That problem turned out to be a bad portion of the hard drive in the media server. Replacing the hard drive resolved the issue and it has not come back since.

[motulal]

Had four lockups while watching the AMA's. Extremely irritating.
Thanks for the info regarding a possible bad hard drive. I'll try to run a diag on my media server hard disk.

Motu

[motulal]

HD Diags completed with no issues. I am going to try an revert back to v6.

Motu.

[vividweb]

Are the caps ok in the power supply? Maybe they are on the verge of bursting.

[motulal]

I have that question in the back of my mind. I replaced them a few years ago but maybe the new ones are going as well. I'll open up the HD100 today or tomorrow.

For the time being, i started with a fresh install of v7 and crossing my fingers.

Motu.

[motulal]

Update:
Checked the CAP's and they look fine. Took some pictures and uploaded to a few friends with more electronics experience, and they concur.

Hangs still occur but it would appear to be an extender problem and not an issue with the sagetv software.

At this point, i am going to pursue a couple of different avenues

a) Go back to Sage6 on XP.

b) Install Sage7 on Win7.


Motu.

[motulal]

Reverted back to Sage v6 on XP and no extender freezes.

So, at least one vote against HD100 with v7 on XP.

Motu.

[sungod]

The only time I have lockups with the HD100 is when I try to run something it was never designed to run, such as Blu-ray. The HD200 and HD300 have no problems, but the HD100 locks. I just watch other stuff on there with no issues.

[sic0048]

Originally Posted by RayGannon

My HD100 has been working fine with version 7 of Sage. In the past I did have a problem with seemingly random bouts of frequent lockups. That problem turned out to be a bad portion of the hard drive in the media server. Replacing the hard drive resolved the issue and it has not come back since.

I had similar issues with my HD-100 extenders freezing. It was also a hard drive issue. Once I replaced the drive, I've had smooth sailing again.