<div dir="ltr"><br><div class="gmail_extra"><br><br><div class="gmail_quote">On Wed, Jun 4, 2014 at 5:40 PM, Jean-Yves Avenard <span dir="ltr"><<a href="mailto:jyavenard@gmail.com" target="_blank">jyavenard@gmail.com</a>></span> wrote:<br>
<blockquote class="gmail_quote" style="margin:0px 0px 0px 0.8ex;border-left:1px solid rgb(204,204,204);padding-left:1ex"><div class="">On 5 June 2014 10:05, Kevin Johnson <<a href="mailto:iitywygms@gmail.com">iitywygms@gmail.com</a>> wrote:<br>
><br>
> Jun 4 16:39:22 mythbackend mythbackend:<br>
> mythbackend[1666]: W ProcessRequest ringbuffer.cpp:1224<br>
> (WaitForReadsAllowed)<br>
> RingBuf(/var/lib/mythtv/livetv/1798_20140604233729.mpg): Taking too<br>
> long to be allowed to read..<br>
<br>
</div>Something is stalling on your backend.<br>
<br>
To know exactly where, we would need the debugging logs:<br>
run the backend with -v file --loglevel=debug<br>
<br>
it will be very verbose (unless you can compile from source, the<br>
actual massive verbosity isn't even useful, I have a small patch that<br>
removes it<br>
<div class=""><br>
<br>
><br>
> Jun 4 16:40:33 mythbackend mythbackend:<br>
> mythbackend[1666]: N Expire autoexpire.cpp:641 (SendDeleteMessages)<br>
> Expiring 0 MB for 1702 at 2014-06-04T23:34:02Z => "The Dr. Oz<br>
> Show":"Buyer Beware: Chicken From China?"<br>
<br>
</div>the backend was unable to write to the disk, hence the 0MB recording<br>
<br>
There has been no change to the backend since the merge of 0.27.1<br>
creation last week.<br>
<br>
But there was no major changes to the backend recording / disk control<br>
code since February, when all the fixes that mattered were backported.<br>
<br>
<br>
it may just be a bad coincidence, and your issue is hardware related.<br>
The logs will tell us more.<br>
<br>
Or you could revert the backend to pre 0.27.1 and see if the problem<br>
disappear. But I'd be very surprised if it did so<br>
<div class=""><div class="h5">_______________________________________________<br></div></div></blockquote></div><br><br></div><div class="gmail_extra">Okay, I think I got the important part.<br></div><div class="gmail_extra">
You were not kidding about verbose. 300 megs in 10 minutes.<br></div><div class="gmail_extra">Here is the exact time it locked.<br><br>2014-06-05 16:38:56.627521 N RingBuf(/var/lib/mythtv/livetv/1702_20140605233214.mpg): ReadPriv(..32768, normal): ReadBufAvail() == 0<br>
2014-06-05 16:38:56.658105 D RingBuf(/var/lib/mythtv/livetv/1702_20140605233214.mpg): ReadPriv(..32768, normal) @1884652 -- begin<br>2014-06-05 16:38:56.658124 N RingBuf(/var/lib/mythtv/livetv/1702_20140605233214.mpg): ReadPriv(..32768, normal): ReadBufAvail() == 0<br>
2014-06-05 16:38:56.688959 D RingBuf(/var/lib/mythtv/livetv/1702_20140605233214.mpg): ReadPriv(..32768, normal) @1884652 -- begin<br>2014-06-05 16:38:56.688979 N RingBuf(/var/lib/mythtv/livetv/1702_20140605233214.mpg): ReadPriv(..32768, normal): ReadBufAvail() == 0<br>
2014-06-05 16:38:56.736928 D RingBuf(/var/lib/mythtv/livetv/1702_20140605233214.mpg): ReadPriv(..32768, normal) @1884652 -- begin<br>2014-06-05 16:38:56.736947 N RingBuf(/var/lib/mythtv/livetv/1702_20140605233214.mpg): ReadPriv(..32768, normal): ReadBufAvail() == 0<br>
2014-06-05 16:38:57.466835 D RingBuf(/var/lib/mythtv/livetv/1702_20140605233214.mpg): We are not reading anything (totfree: 4194303 commserror:0 ateof:1 setswitchtonext:0<br>2014-06-05 16:38:57.466852 D RingBuf(/var/lib/mythtv/livetv/1702_20140605233214.mpg): @ end of read ahead loop<br>
2014-06-05 16:38:57.930617 I Maximal bitrate of busy encoders is 0 KB/min<br>2014-06-05 16:38:58.472057 D RingBuf(/var/lib/mythtv/livetv/1702_20140605233214.mpg): We are not reading anything (totfree: 4194303 commserror:0 ateof:1 setswitchtonext:0<br>
2014-06-05 16:38:58.472073 D RingBuf(/var/lib/mythtv/livetv/1702_20140605233214.mpg): @ end of read ahead loop<br>2014-06-05 16:38:59.477296 D RingBuf(/var/lib/mythtv/livetv/1702_20140605233214.mpg): We are not reading anything (totfree: 4194303 commserror:0 ateof:1 setswitchtonext:0<br>
2014-06-05 16:38:59.477313 D RingBuf(/var/lib/mythtv/livetv/1702_20140605233214.mpg): @ end of read ahead loop<br>2014-06-05 16:39:00.482543 D RingBuf(/var/lib/mythtv/livetv/1702_20140605233214.mpg): We are not reading anything (totfree: 4194303 commserror:0 ateof:1 setswitchtonext:0<br>
2014-06-05 16:39:00.482562 D RingBuf(/var/lib/mythtv/livetv/1702_20140605233214.mpg): @ end of read ahead loop<br>2014-06-05 16:39:01.246716 I calling StopReads()<br>2014-06-05 16:39:01.246730 I RingBuf(/var/lib/mythtv/livetv/1702_20140605233214.mpg): StopReads()<br>
2014-06-05 16:39:01.246841 D RingBuf(/var/lib/mythtv/livetv/1702_20140605233214.mpg): We are not reading anything (totfree: 4194303 commserror:0 ateof:1 setswitchtonext:0<br>2014-06-05 16:39:01.246885 D RingBuf(/var/lib/mythtv/livetv/1702_20140605233214.mpg): @ end of read ahead loop<br>
2014-06-05 16:39:01.247287 I RingBuf(/var/lib/mythtv/livetv/1702_20140605233214.mpg): StopReads()<br>2014-06-05 16:39:12.931573 I Maximal bitrate of busy encoders is 0 KB/min<br>2014-06-05 16:39:26.099991 C Received Terminated: Code 0, PID 16039, UID 0, Value 0x00000000<br>
2014-06-05 16:39:26.101745 N MythBackend exiting<br><br></div><div class="gmail_extra">Could it be my hdhr prime is failing? I did some test on the drives and they tested okay.<br><br><br></div></div>