[mythtv-users] HDPVR lockup - new

Thu Dec 5 00:50:33 UTC 2013

Thanks for that idea!  Although the sat receivers are identical models, the channel change takes slightly longer on this one which causes my channel change script to hickup.

I added a 2 second pause on the end of the channel change and now it works!  Interesting...I will investigate more

Thanks!
________________________________
From: mythtv-users-bounces at mythtv.org [mythtv-users-bounces at mythtv.org] On Behalf Of John P Poet [jppoet at gmail.com]
Sent: Wednesday, December 04, 2013 7:18 PM
To: Myth TV Users List
Subject: Re: [mythtv-users] HDPVR lockup - new

On Wed, Dec 4, 2013 at 5:11 PM, Michelle Dupuis <mdupuis at ocg.ca<mailto:mdupuis at ocg.ca>> wrote:
My HDPVR is connected to a satelite box, and has been running great for years.  After switching out the receiver for an identical one, I now have problems in myth-HDPVR

SD channels seem to work fine (based on testing so far), but switching to a HD channel causes the image to lockup and the frontend to eventually show "Video frame budder failed too many times".  I captured the backend output below, and see "Device error detected".  What does that mean?  How do I fix it?

I flashed my HDPVR to the 1.7.1 firmware but that doesn't make a difference....

help!?

--------------------------------------------------------------------------------------------------------------------

2013-12-04 19:05:00.739559 I  adding: mythlivingroom as a client (events: 0)
2013-12-04 19:05:00.751537 I  TVRec(1): Changing from None to WatchingLiveTV
2013-12-04 19:05:00.752898 I  TVRec(1): HW Tuner: 1->1
2013-12-04 19:05:00.767934 I  V4LChannel(/dev/HDPVR): SetInputAndFormat(1, NTSC) (v4l v2) input_switch: 0 mode_switch: 0
2013-12-04 19:05:00.929419 N  AutoExpire: CalcParams(): Max required Free Space: 3.0 GB w/freq: 15 min
2013-12-04 19:05:01.927840 I  MainServer::ANN Playback
2013-12-04 19:05:01.927846 I  adding: mythlivingroom as a client (events: 0)
2013-12-04 19:05:01.929745 I  MainServer::HandleAnnounce FileTransfer
2013-12-04 19:05:01.929749 I  adding: mythlivingroom as a remote file transfer
2013-12-04 19:05:03.300243 N  AutoExpire: CalcParams(): Max required Free Space: 3.0 GB w/freq: 15 min
2013-12-04 19:05:03.414922 I  MainServer::ANN Playback
2013-12-04 19:05:03.414928 I  adding: mythlivingroom as a client (events: 0)
2013-12-04 19:05:03.416886 I  MainServer::HandleAnnounce FileTransfer
2013-12-04 19:05:03.416890 I  adding: mythlivingroom as a remote file transfer
2013-12-04 19:05:05.580139 I  RingBuf(/mythstorage/livetv/1500_20131204190503.mpg): Waited 0.2 seconds for data
                        to become available... 65144 < 196608
2013-12-04 19:05:05.830265 I  RingBuf(/mythstorage/livetv/1500_20131204190503.mpg): Waited 0.5 seconds for data
                        to become available... 65144 < 196608
2013-12-04 19:05:06.330465 I  RingBuf(/mythstorage/livetv/1500_20131204190503.mpg): Waited 1.0 seconds for data
                        to become available... 65144 < 196608
2013-12-04 19:05:07.330876 I  RingBuf(/mythstorage/livetv/1500_20131204190503.mpg): Waited 2.0 seconds for data
                        to become available... 65144 < 196608
2013-12-04 19:05:07.766811 E  DevRdB(/dev/HDPVR): Poll giving up 2
2013-12-04 19:05:07.766923 E  MPEGRec(/dev/HDPVR): Device error detected
2013-12-04 19:05:10.549648 E  DevRdB(/dev/HDPVR): Poll giving up 2
2013-12-04 19:05:10.549731 E  MPEGRec(/dev/HDPVR): Device error detected
2013-12-04 19:05:13.295229 E  DevRdB(/dev/HDPVR): Poll giving up 2
2013-12-04 19:05:13.295328 E  MPEGRec(/dev/HDPVR): Device error detected
2013-12-04 19:05:24.743063 I  RecBase(1:/dev/HDPVR): GetKeyframePositions(287,9223372036854775807,#0) out of 4
2013-12-04 19:05:24.763134 I  RecBase(1:/dev/HDPVR): GetKeyframePositions(287,9223372036854775807,#0) out of 4
2013-12-04 19:05:42.594878 I  JobQueue: Metadata Lookup Starting for "Erin Burnett OutFront" recorded from channel 1500 at 2013-12-04T19:05:01
2013-12-04 19:05:43.024259 E  JobQueue: Metadata Lookup Errored: "Erin Burnett OutFront" recorded from channel 1500 at 2013-12-04T19:05:01 (Failed with exit status 128)
2013-12-04 19:05:55.060626 I  TVRec(1): Changing from WatchingLiveTV to None
2013-12-04 19:05:55.311596 I  TVRec(1): FinishedRecording(1500_2013-12-04T19:05:03) damaged recq:<RecordingQuality overall_score="0" key="1500_2013-12-04T19:05:03" countinuity_error_count="2" packet_count="337374">
    <Gap start="2013-12-04T19:00:00" end="2013-12-04T19:05:04" duration="304" />
    <Gap start="2013-12-04T19:05:50" end="2013-12-04T20:00:00" duration="3250" />
</RecordingQuality>
2013-12-04 19:05:55.325370 I  MainServer::ANN Playback
2013-12-04 19:05:55.325376 I  adding: mythlivingroom as a client (events: 0)
2013-12-04 19:05:55.336421 I  TVRec(1): Changing from None to WatchingLiveTV
2013-12-04 19:05:55.337630 I  TVRec(1): HW Tuner: 1->1
2013-12-04 19:05:55.352855 I  V4LChannel(/dev/HDPVR): SetInputAndFormat(1, NTSC) (v4l v2) input_switch: 0 mode_switch: 0
2013-12-04 19:05:55.400242 N  AutoExpire: CalcParams(): Max required Free Space: 3.0 GB w/freq: 15 min
2013-12-04 19:05:55.492189 I  TVRec(1): Changing from WatchingLiveTV to None

The first thing to try in a situation like this, is to add a longer sleep to the end of your channel change script.

With Directv, I can control it via USB, which also means I can query the STB to find out what channel it thinks it is on.  That helps quite a bit, since I don't return from the channel change script until the STB says it is done changing channels.  I still have to sleep for one second, to give the STB a chance to stabilize, though.  The HD-PVR does not handle "garbage in" well at all, so if it is told to "start encoding" when the input is still in flux (changing resolutions), it can get wedged.

John
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://www.mythtv.org/pipermail/mythtv-users/attachments/20131204/9955cf48/attachment.html>