[mythtv-users] WAF Issue with Recording

[Mitchell Gore]

Hi,

I am having a weird issue that is affect the WAF a lot!  Basically the last
few airings of Desperate Housewives has either failed or giving a very small
recording file.  Last night I only got 376B.  Looking at the logs i see
nothing out of the ordinary:

2011-01-02 20:00:06.163 AutoExpire: CalcParams(): Max required Free Space:
3.0 GB w/freq: 9 min
2011-01-02 20:00:06.348 Started recording: "Desperate Housewives":Assassins:
channel 1841 on cardid 1, sourceid 2
2011-01-02 20:00:06.426 scheduler: Started recording: "Desperate
Housewives":Assassins: channel 1841 on cardid 1, sourceid 2
2011-01-02 20:00:06.704 TVRec(1): rec->GetPathname():
'/tv/d2/1841_20110102200000.mpg'
2011-01-02 20:00:06.937 TVRec(3): Changing from None to RecordingOnly
2011-01-02 20:00:07.194 TVRec(3): HW Tuner: 3->3
2011-01-02 20:00:07.421 AutoExpire: CalcParams(): Max required Free Space:
3.0 GB w/freq: 5 min

Next in the log i see the commflagg job failes:
2011-01-02 20:01:08.684 JobQueue: Commercial Detection Starting for
"Desperate Housewives":Assassins recorded from channel 1841 at 2
011-01-02T20:00:00
2011-01-02 20:01:08.700 commflag: Commercial Detection Starting: "Desperate
Housewives":Assassins recorded from channel 1841 at 2011
-01-02T20:00:00
2011-01-02 20:01:08.987 Using runtime prefix = /usr
2011-01-02 20:01:08.988 Using configuration directory = /home/mythtv/.mythtv
2011-01-02 20:01:08.989 Empty LocalHostName.
2011-01-02 20:01:08.989 Using localhost value of mythtv
2011-01-02 20:01:08.999 New DB connection, total: 1
2011-01-02 20:01:09.002 Connected to database 'mythconverg' at host:
localhost
2011-01-02 20:01:09.008 Closing DB connection named 'DBManager0'
2011-01-02 20:01:09.008 Connected to database 'mythconverg' at host:
localhost
2011-01-02 20:01:09.010 Current locale EN_US
2011-01-02 20:01:09.010 Reading locale defaults from
/usr/share/mythtv//locales/en_us.xml
2011-01-02 20:01:09.015 Loading en_us translation for module mythfrontend
2011-01-02 20:01:09.063 MythCoreContext: Connecting to backend server:
192.168.0.254:6543 (try 1 of 1)
2011-01-02 20:01:09.064 Using protocol version 63
2011-01-02 20:01:09.065 MainServer::ANN Playback
2011-01-02 20:01:09.065 adding: mythtv as a client (events: 0)
2011-01-02 20:01:09.066 MainServer::ANN Monitor
2011-01-02 20:01:09.066 adding: mythtv as a client (events: 1)
2011-01-02 20:01:09.075 RingBuf(/tv/d2/1841_20110102200000.mpg) Warning:
Peek() requested 2048 bytes, but only returning 376
2011-01-02 20:01:09.076 Player(0), Warning: OpenFile() waiting on data
2011-01-02 20:01:09.151 RingBuf(/tv/d2/1841_20110102200000.mpg) Warning:
Peek() requested 2048 bytes, but only returning 376
2011-01-02 20:01:09.152 Player(0), Warning: OpenFile() waiting on data
2011-01-02 20:01:09.202 RingBuf(/tv/d2/1841_20110102200000.mpg) Warning:
Peek() requested 2048 bytes, but only returning 376
2011-01-02 20:01:09.203 Player(0), Warning: OpenFile() waiting on data
2011-01-02 20:01:09.253 RingBuf(/tv/d2/1841_20110102200000.mpg) Warning:
Peek() requested 2048 bytes, but only returning 376
2011-01-02 20:01:09.255 Player(0), Warning: OpenFile() waiting on data
2011-01-02 20:01:09.305 RingBuf(/tv/d2/1841_20110102200000.mpg) Warning:
Peek() requested 2048 bytes, but only returning 376
2011-01-02 20:01:09.306 Player(0), Warning: OpenFile() waiting on data
2011-01-02 20:01:09.357 RingBuf(/tv/d2/1841_20110102200000.mpg) Warning:
Peek() requested 2048 bytes, but only returning 376
2011-01-02 20:01:09.357 Player(0), Warning: OpenFile() waiting on data
2011-01-02 20:01:09.408 RingBuf(/tv/d2/1841_20110102200000.mpg) Warning:
Peek() requested 2048 bytes, but only returning 376
2011-01-02 20:01:09.409 Player(0), Warning: OpenFile() waiting on data
2011-01-02 20:01:09.460 RingBuf(/tv/d2/1841_20110102200000.mpg) Warning:
Peek() requested 2048 bytes, but only returning 376
2011-01-02 20:01:09.460 Player(0), Warning: OpenFile() waiting on data
2011-01-02 20:01:09.511 RingBuf(/tv/d2/1841_20110102200000.mpg) Warning:
Peek() requested 2048 bytes, but only returning 376
2011-01-02 20:01:09.512 Player(0), Warning: OpenFile() waiting on data
2011-01-02 20:01:09.562 RingBuf(/tv/d2/1841_20110102200000.mpg) Warning:
Peek() requested 2048 bytes, but only returning 376
2011-01-02 20:01:09.563 Player(0), Warning: OpenFile() waiting on data
2011-01-02 20:01:09.614 RingBuf(/tv/d2/1841_20110102200000.mpg) Warning:
Peek() requested 2048 bytes, but only returning 376
2011-01-02 20:01:09.615 Player(0), Warning: OpenFile() waiting on data
2011-01-02 20:01:09.665 RingBuf(/tv/d2/1841_20110102200000.mpg) Warning:
Peek() requested 2048 bytes, but only returning 376
2011-01-02 20:01:09.666 Player(0), Warning: OpenFile() waiting on data
2011-01-02 20:01:09.717 RingBuf(/tv/d2/1841_20110102200000.mpg) Warning:
Peek() requested 2048 bytes, but only returning 376
2011-01-02 20:01:09.717 Player(0), Warning: OpenFile() waiting on data
2011-01-02 20:01:09.768 RingBuf(/tv/d2/1841_20110102200000.mpg) Warning:
Peek() requested 2048 bytes, but only returning 376
2011-01-02 20:01:09.769 Player(0), Warning: OpenFile() waiting on data
2011-01-02 20:01:09.820 RingBuf(/tv/d2/1841_20110102200000.mpg) Warning:
Peek() requested 2048 bytes, but only returning 376
2011-01-02 20:01:09.828 Player(0), Warning: OpenFile() waiting on data
2011-01-02 20:01:09.886 RingBuf(/tv/d2/1841_20110102200000.mpg) Warning:
Peek() requested 2048 bytes, but only returning 376
2011-01-02 20:01:09.971 Player(0), Warning: OpenFile() waiting on data
2011-01-02 20:01:10.022 RingBuf(/tv/d2/1841_20110102200000.mpg) Warning:
Peek() requested 2048 bytes, but only returning 376
2011-01-02 20:01:10.022 Player(0), Warning: OpenFile() waiting on data
2011-01-02 20:01:10.073 RingBuf(/tv/d2/1841_20110102200000.mpg) Warning:
Peek() requested 2048 bytes, but only returning 376
2011-01-02 20:01:10.074 Player(0), Warning: OpenFile() waiting on data
2011-01-02 20:01:10.124 RingBuf(/tv/d2/1841_20110102200000.mpg) Warning:
Peek() requested 2048 bytes, but only returning 376
2011-01-02 20:01:10.125 Player(0), Error: OpenFile(): Could not read first
2048 bytes of '/tv/d2/1841_20110102200000.mpg'
2011-01-02 20:01:11.173 ~MythContext waiting for threads to exit.
2011-01-02 20:01:11.766 MainServer::ANN Monitor
2011-01-02 20:01:11.766 adding: mythtv as a client (events: 0)
2011-01-02 20:01:11.767 MainServer::ANN Monitor
2011-01-02 20:01:11.768 adding: mythtv as a client (events: 1)
2011-01-02 20:01:11.865 Preview Error: Encountered problems running
'/usr/bin/mythpreviewgen --size 0x0 --chanid 1841 --starttime 20
110102200000  > /dev/null'
2011-01-02 20:01:11.869 commflag: Commercial Detection Finished: "Desperate
Housewives":Assassins recorded from channel 1841 at 2011


It cant be a tunning issue as Brothers and Sisters records right after this
program on the same tuner.  My source is QAM using HD Home Run.

Any suggestions on how to fix this?

Thanks,
Mitchell
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://mythtv.org/pipermail/mythtv-users/attachments/20110103/8e94d9ae/attachment.htm>