[mythtv-users] Problems commflagging on HDPVR

Justin Johnson justin.johnson3 at gmail.com
Fri Jul 30 13:45:58 UTC 2010


I've recently upgraded to an HDPVR and find it to be the absolute
bee's knees but I'm having some issues with commflagging. First of
all, it takes much longer to commflag, in order to commflag in "real
time" on 1080i I had to lower the bitrate for high resolution
recordings. That's not my problem so much, as it's perfectly
understandable. My system is a core2duo 2.66GHz so I'm just barely not
able to watch HDPVR recordings using software decoding, so I expect
the commflagger to have problems keeping up as well, like I said
that's not the issue. The problem is that sometimes, rarely, the
commflagger doesn't start, I see a number of these messages in
mythbackend.log:

2010-07-29 22:30:19.025
RingBuf(/var/lib/mythtv/recordings/1855_20100729223000.mpg): Invalid
file (fd -1) when opening
/var/lib/mythtv/recordings/1855_20100729223000.mpg'.

It seems to indicate that the file hasn't been synced to disk yet, or
something. The recording is fine and I'm able to watch, but it shows
up as not flagged. Now, this particular recording happened to start
just as mythfilldatabase was also running, so that may have had
something to do with it, but my recordings are on a different drive
than the db. I thought maybe it was due to limiting the number of
simultaneous jobs to 2, so I increased to 4 but got this problem
recording just a couple hours later. It only seems to be a problem
when there are a number of shows in a row that are recording. If I
requeue the commflag job, it runs just fine. I've only noticed it in
situations similar to this:

9:00pm: 2 recordings, one on QAM and one on HDPVR (1080i)
10:00pm: 1 recording on HDPVR (1080i)

The 10pm recording failed to start commflagging. A more complete log is this:

2010-07-27 22:00:12.826 JobQueue: Commercial Flagging Starting for
Covert Affairs "South Bound Suarez" recorded from channel 1842 at Tue
Jul 27 22:00:00 2010
2010-07-27 22:00:12.942 Using runtime prefix = /usr
2010-07-27 22:00:12.943 Using configuration directory = /home/mythtv/.mythtv
2010-07-27 22:00:12.944 Empty LocalHostName.
2010-07-27 22:00:12.943 ProgramInfo(): Updated pathname '':'' ->
'1842_20100727220000.mpg'
2010-07-27 22:00:12.948 Using localhost value of mythbox
2010-07-27 22:00:12.958 New DB connection, total: 1
2010-07-27 22:00:13.001 Connected to database 'mythconverg' at host: 127.0.0.1
2010-07-27 22:00:13.008 Closing DB connection named 'DBManager0'
2010-07-27 22:00:13.052 Connected to database 'mythconverg' at host: 127.0.0.1
2010-07-27 22:00:13.103 ProgramInfo(): Updated pathname '':'' ->
'1842_20100727220000.mpg'
2010-07-27 22:00:14.676 Scheduled 1830 items in 3.3 = 0.01 match + 3.31 place
2010-07-27 22:00:19.607
RingBuf(/var/lib/mythtv/recordings/1842_20100727220000.mpg): Invalid
file (fd -1) when opening
'/var/lib/mythtv/recordings/1842_20100727220000.mpg'.
2010-07-27 22:00:19.689 MythContext: Connecting to backend server:
192.168.1.51:6543 (try 1 of 1)
2010-07-27 22:00:19.690 Using protocol version 23056
2010-07-27 22:00:19.692 MainServer::ANN Playback
2010-07-27 22:00:19.695 adding: mythbox as a client (events: 0)
2010-07-27 22:00:19.701 MainServer::ANN Monitor
2010-07-27 22:00:19.706 adding: mythbox as a client (events: 1)
2010-07-27 22:00:19.742 ProgramInfo(): Updated pathname '':'' ->
'1842_20100727220000.mpg'
2010-07-27 22:00:31.760
RingBuf(/var/lib/mythtv/recordings/1842_20100727220000.mpg) Error:
Invalid file descriptor in 'safe_read()'
2010-07-27 22:00:31.761
RingBuf(/var/lib/mythtv/recordings/1842_20100727220000.mpg) Warning:
Peek() requested 2048 bytes, but only returning 0
2010-07-27 22:00:31.768 NVP::OpenFile(): Error, couldn't read file:
/var/lib/mythtv/recordings/1842_20100727220000.mpg
2010-07-27 22:00:31.826 ProgramInfo(): Updated pathname '':'' ->
'1842_20100727220000.mpg'
2010-07-27 22:00:32.779 ~MythContext waiting for threads to exit.
2010-07-27 22:00:32.832 ProgramInfo(): Updated pathname '':'' ->
'1842_20100727220000.mpg'
2010-07-27 22:00:32.892 ProgramInfo(): Updated pathname '':'' ->
'1842_20100727220000.mpg'

One second after this, a preview is generated fine, so the file
clearly exists. Anyone else see this at times? What can be done?

--Justin Johnson


More information about the mythtv-users mailing list