[mythtv-users] Occasional zero length file from a scheduled recording?

[Tom Dexter]

On Thu, Jan 10, 2008 at 7:37 PM, Tom Dexter <digitalaudiorock at gmail.com> wrote:
> Today I had something occur that's only happened one other time since
>  I built my mythtv system:
>
>  A scheduled recording for some reason created a zero length recording,
>  and everything in the backend log looks fine:
>
>  2008-01-10 16:00:02.922 TVRec(1): Changing from None to RecordingOnly
>  2008-01-10 16:00:02.931 TVRec(1): HW Tuner: 1->1
>  2008-01-10 16:00:02.935 DVBChan(0) Warning: Symbol Rate setting (0) is
>  out of range (min/max:5056941/10762000)
>  2008-01-10 16:00:02.975 Started recording: Oprah Winfrey: channel 1071
>  on cardid 1, sourceid 1
>  2008-01-10 17:00:00.377 TVRec(1): Changing from RecordingOnly to None
>  2008-01-10 17:00:00.812 Finished recording Oprah Winfrey: channel 1071
>  2008-01-10 17:00:00.825 Reschedule requested for id 0.
>  2008-01-10 17:00:00.921 Scheduled 23 items in 0.1 = 0.01 match + 0.09 place
>
>  ...It appears to have recorded one hour like it should have, but the
>  file was zero bytes.  I just deleted it via mythweb.
>
>  Again, this has only happened to me one other time.  I'm aware that
>  live tv can create zero length files in addition to the correct files
>  when changing channels.  I believe that's a known issue and is
>  harmless...the empty files just get expired.  This is something
>  different, and I'm stumped as to what could cause it.
>
>  There are no errors anywhere I can see...I have 1/2 TB of disk
>  left...not a clue.
>
>  The only think I can think of is, being that I'm recording OTA,
>  something may have been causing severe interference at the time of the
>  recording.  However, I'd expect that to fail and show as much in the
>  backend log.
>
>  Anyone else ever get this?  Thanks.  Oh...I'm running 0.20.2 svn 14814
>  under Gentoo.
>
>  Tom
>

Nobody ever replied to this one.  I just had the same thing occur
again.  What's more, my OTA reception and signal strength on this
channel is excellent tonight.

Here are the logs from when the recording started (or thought it started):

2008-03-06 21:00:07.669 TVRec(2): Changing from None to RecordingOnly
2008-03-06 21:00:07.675 TVRec(2): HW Tuner: 2->2
2008-03-06 21:00:07.679 DVBChan(1) Warning: Symbol Rate setting (0) is
out of range (min/max:5056941
/10762000)
2008-03-06 21:00:07.697 Started recording: Lost "The Other Woman":
channel 1071 on cardid 2, sourcei
d 1
2008-03-06 21:00:08.703 Reschedule requested for id 0.
2008-03-06 21:00:09.190 Scheduled 37 items in 0.5 = 0.00 match + 0.49 place

When I checked the list of recorded programs about 12 minutes into the
show it showed 0 bytes but was acting as though it was recording with
absolutely no sign of an error in the log.  Actually I think what's
happening is that I get no file at all rather than zero length.  In my
rush to rerecord the show I neglected to check before deleting the
recording.  This is what the logs showed when I deleted the recording
from the frontend:

2008-03-06 21:12:08.410 Error deleting
'/video/recordings/1071_20080306210000.mpg' could not open
                        eno: No such file or directory (2)
2008-03-06 21:12:08.416 Delete Error '/video/recordings/1071_20080306210000.mpg'
                        eno: No such file or directory (2)


Currently I'm running 0.20.2 SVN 14972 as apposed to 14814 that I was
running the last time this occurred.

Has anyone else had this happen?  I'm can't imagine how this can occur
and show no errors or any sign that the backend is even aware
anythings wrong.  It's as though it's mysteriously writing into
nowhere or something.

I'm running with important and general logging.  I hate to increase
that, as I'd probably have to write massive logs for months waiting
for this rare occurrence.  I'd certainly expect anything that prevents
creating the file altogether to generate an important or general
message if the backend was aware there was an issue.

Seriously annoying...glad it doesn't happen more often.

Tom