[mythtv-users] canceled recording (Recorder Failed) mystery

Bob Gamble kiksadiweb at gmail.com
Sun Feb 28 00:00:57 UTC 2010


I'll try to give the exact errors per event.  This is what I got tonight
when a scheduled recording failed...this is the backend log:

2010-02-22 18:21:04.955 UPnpMedia: BuildMediaMap VIDEO scan starting in
:/var/lib/mythtv/videos:
2010-02-22 18:21:04.958 UPnpMedia: BuildMediaMap Done. Found 4 objects
2010-02-22 18:28:01.093 AutoExpire: CalcParams(): Max required Free Space:
1.0 GB w/freq: 15 min
2010-02-22 18:43:01.152 AutoExpire: CalcParams(): Max required Free Space:
1.0 GB w/freq: 15 min
2010-02-22 18:51:06.960 UPnpMedia: BuildMediaMap VIDEO scan starting in
:/var/lib/mythtv/videos:
2010-02-22 18:51:06.963 UPnpMedia: BuildMediaMap Done. Found 4 objects
2010-02-22 18:58:01.210 AutoExpire: CalcParams(): Max required Free Space:
1.0 GB w/freq: 15 min
2010-02-22 18:59:00.949 Reschedule requested for id 0.
2010-02-22 18:59:01.441 Scheduled 162 items in 0.5 = 0.00 match + 0.49 place
2010-02-22 18:59:01.444 scheduler: Scheduled items: Scheduled 162 items in
0.5 = 0.00 match + 0.49 place
2010-02-22 19:00:05.181 AutoExpire: CalcParams(): Max required Free Space:
1.0 GB w/freq: 15 min
2010-02-22 19:00:05.183 Canceled recording (Recorder Failed): XXI Winter
Olympics "Figure Skating, Freestyle Skiing, Ski Jumping": channel 1005 on
cardid 2, sourceid 1
2010-02-22 19:00:05.185 scheduler: Canceled recording (Recorder Failed): XXI
Winter Olympics "Figure Skating, Freestyle Skiing, Ski Jumping": channel
1005 on cardid 2, sourceid 1
2010-02-22 19:00:06.187 Reschedule requested for id 0.
2010-02-22 19:00:06.687 Scheduled 162 items in 0.5 = 0.00 match + 0.50 place
2010-02-22 19:00:06.690 scheduler: Scheduled items: Scheduled 162 items in
0.5 = 0.00 match + 0.50 place
2010-02-22 19:00:12.423 Reschedule requested for id 0.

But then (a few days later) I lost ability on my other tuner with the
"Excessive channel retries" error showing up repeatedly.  After a restarting
mythtv-backend, rebooting, and resetting the directv box it finally came
back.  I would get the same "Irrecoverable error" showing on the screen when
tryint to change
channels.  This time I got a good chunk of interesting errors, most of which
I've seen before but couldn't figure out.  The first line had repeated
multiple times, I think from when I tried changing a channel when on live
tv:

2010-02-27 14:07:26.343 [mpeg2video @ 0x69406c0]Missing picture start code
2010-02-27 14:07:51.915 mythbackend: Running housekeeping thread
2010-02-27 14:19:08.849 MainServer::ANN Playback
2010-02-27 14:19:08.893 adding: katlian as a client (events: 0)
2010-02-27 14:19:08.942 TVRec(2): Changing from None to Watching
WatchingLiveTV
2010-02-27 14:19:08.989 TVRec(2): HW Tuner: 2->2
2010-02-27 14:19:10.168 ret_pid(3926) child(3926) status(0x0)
2010-02-27 14:19:10.219 External Tuning program exited with no error
 *********************** WARNING ***********************
 ivtv drivers prior to 0.10.0 can cause lockups when
 reading VBI. Drivers between 0.10.5 and 1.0.3+ do not
 properly capture VBI data on PVR-250 and PVR-350 cards.

2010-02-27 14:19:10.699 MainServer::ANN Playback
2010-02-27 14:19:10.920 adding: katlian as a client (events: 0)
2010-02-27 14:19:10.963 MainServer::HandleAnnounce FileTransfer
2010-02-27 14:19:11.003 adding: katlian as a remote file transfer
2010-02-27 14:19:12.784 RecBase(2:/dev/video0):
GetKeyframePositions(1,9223372036854775807,#2) out of 3
2010-02-27 14:19:30.517 TVRec(2): HW Tuner: 2->2
2010-02-27 14:19:31.804 ret_pid(0) child(3942) status(0x0)
2010-02-27 14:19:32.833 ret_pid(0) child(3942) status(0x0)
Excessive channel change retries, commanded 202 got 247
2010-02-27 14:19:33.668 ret_pid(3942) child(3942) status(0xff00)
2010-02-27 14:19:33.707 ChannelBase: external tuning program exited with
error 255
2010-02-27 14:19:33.741 TVRec(2) Error: Failed to set channel to 202.
Reverting to kState_None
2010-02-27 14:19:33.774 TVRec(2): Changing from Watching WatchingLiveTV to
None
2010-02-27 14:19:33.892 Unknown type, recording width was 0
2010-02-27 14:19:39.070 MainServer::ANN Playback
2010-02-27 14:19:39.114 adding: katlian as a client (events: 0)
2010-02-27 14:19:39.193 MainServer::ANN Playback
2010-02-27 14:19:39.239 adding: katlian as a client (events: 0)
2010-02-27 14:19:39.285 TVRec(2): Changing from None to Watching
WatchingLiveTV
2010-02-27 14:19:39.336 TVRec(2): HW Tuner: 2->2
2010-02-27 14:19:40.399 ret_pid(3947) child(3947) status(0x0)
2010-02-27 14:19:40.457 External Tuning program exited with no error
 *********************** WARNING ***********************
 ivtv drivers prior to 0.10.0 can cause lockups when
 reading VBI. Drivers between 0.10.5 and 1.0.3+ do not
 properly capture VBI data on PVR-250 and PVR-350 cards.

2010-02-27 14:19:40.936 MainServer, Warning: Unknown socket closing
MythSocket(0xffffffffb430c428)
2010-02-27 14:19:40.946 MainServer::ANN Playback
2010-02-27 14:19:41.033 adding: katlian as a client (events: 0)
2010-02-27 14:19:40.984 MythSocket(ffffffffb430c428:-1): writeStringList:
Error, socket went unconnected.
            We wrote 0 of 10 bytes with 1 errors
2010-02-27 14:19:41.076 MainServer::HandleAnnounce FileTransfer
2010-02-27 14:19:41.175 adding: katlian as a remote file transfer
2010-02-27 14:19:41.544 TVRec(2): Changing from Watching WatchingLiveTV to
None
2010-02-27 14:19:41.594 Unknown type, recording width was 0
2010-02-27 14:19:41.941 Finished recording The King of Queens "Dog Shelter":
channel 1247
2010-02-27 14:19:41.998 scheduler: Finished recording: The King of Queens
"Dog Shelter": channel 1247

So there is probably a good capture of the errors I have seen while trying
to figure this problem out.  Periodically the tuners will lose connection
and throw the "excessive retries" error.  At that point the only way to
recover is to unplug the usb connection that connects the directv box
to the computer.  Then resetting the directv box a couple times until it
grabs the connection again.  Strange.

On Sun, Feb 21, 2010 at 8:07 AM, David Gesswein <djg at pdp8online.com> wrote:

> > Using my Harmony 880 however was unsuccessful nearly every time. I would
> > see a blank screen for several seconds then it would bounce back to the
> main
> > menu with "Irrecoverable error."
> >
> What does the mythbackend log say went wrong at the time this failed? If
> it is an error from the directv script like the retry message we need to
> try changing both the myth external channel change command to verbose and
> then try the same from the command line to try to figure out why they act
> different.
>
> > Again, it wouldn't let me watch livetv. It came up with the
> > message on the screen "Could not connect to
> > the master backend server -- is it running?
> >
> You may have more than one problem. Does the backend log have channel
> change errors at this time or is it a different error? Does the front end
> messages say anything useful? I wouldn't expect the connection problem to
> be
> related to the directv script.
>
> The exact error messages are important for trying to track down the problem
>
> > I noticed though, when changing with the keyboard, before it changed to
> the
> > right channel, the channel I was originally on (NBC), would
> > quickly flash on the screen. Even if I was on that channel several
> channel
> > changes previous. So for example, I started on channel 5, NBC. I changed
> > to 206 successfuly. I changed to 550, and
> > before changing to that channel, it would flash channel 5 on the screen.
> >
> I have seen this on my system also. I see it as a static picture of the
> wrong channel before the correct video starts displaying. It isn't coming
> from my box. I assume myth is reusing old data but I have not looked into
> it since it doesn't seem to cause problems.
>
> _______________________________________________
> mythtv-users mailing list
> mythtv-users at mythtv.org
> http://mythtv.org/cgi-bin/mailman/listinfo/mythtv-users
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://mythtv.org/pipermail/mythtv-users/attachments/20100227/b109bc0c/attachment.htm>


More information about the mythtv-users mailing list