[mythtv-users] MythTV+HDHR crashing on some channels

Brian Walter blwalter at gmail.com
Mon May 7 19:22:07 UTC 2007


James Cotton wrote:
> I'm using a HDHomerun, and when I tune to some channels, it seems that
> frequently mythtv dies (the channels work on VLC).  From my reading of
> the logs everything looks like it is working fine, then the
> "previewer" has a problem with the  file, recording seems to stop.
> From the output of the front end it complains about the ringbuf not
> opening.  Here is the what I think relevant part of the log, then the
> frontend dump.  It's not isolated to
> HD channels because I can get PBS fine, and the other night it worked
> for ABC and now won't.  I'm wondering if it's a problem decoding the
> stream, or the previewer starts to soon and causes a quit.  Any
> guidance?  I can do a stream capture from hdhomerun_config if needed.
> I'm using quick tuning so it has pid filtering, but that doesn't seem
> to make a difference.  Using the latest svn version of mythtv (from
> this morning).  The files are created but have zero file size when I
> look at them.  Also I have permissions 777 on that directory.
>
> James
>
>
> ------------------ short backend ---------------------
>
> 2007-05-07 11:16:18.295 Preview Error: Previewer file
> '/mnt/store/1881_20070507111616.mpg' is not valid.
> 2007-05-07 11:16:18.297 MSqlQuery: DELETE FROM inuseprograms WHERE
> chanid = '1881' AND starttime = '2007-05-07T11:16:16' AND hostname =
> 'comp1-desktop' AND recusage = 'preview_generator' ;
> 2007-05-07 11:16:18.272 AddPID(0xa80)
> 2007-05-07 11:16:18.297 AddPID(0xa81)
> 2007-05-07 11:16:18.297 AddPID(0xa82)
> 2007-05-07 11:16:24.800 MythSocket(8244090:20): socket is readable
> 2007-05-07 11:16:24.800 MythSocket(8244090:20): cb->readyRead()
> 2007-05-07 11:16:24.800 MythSocket(8244090:20): UpRef: 2
> 2007-05-07 11:16:24.800 read  <- 20 32      QUERY_RECORDER 1[]:[]STOP_LIVETV
> 2007-05-07 11:16:24.800 StopLiveTV(void) curRec: 0x826dd60 pseudoRec: 0
> 2007-05-07 11:16:24.801 MSqlQuery: SELECT
> recorded.chanid,starttime,endtime,title,
> subtitle,description,channel.channum,
> channel.callsign,channel.name,channel.commmethod,
> channel.outputfilters,serie
> sid,programid,filesize,
> lastmodified,stars,previouslyshown,originalairdate,
> hostname,recordid,transcoder,playgroup,
> recorded.recpriority,progstart,progend,basename,recgroup, storagegroup
> FROM record
> ed LEFT JOIN channel ON recorded.chanid = channel.chanid WHERE
> recorded.chanid = '1881' AND starttime = '2007-05-07T11:16:18' ;
> 2007-05-07 11:16:24.802 MSqlQuery: SELECT commflagged, cutlist,
> autoexpire, editing, bookmark, stereo, closecaptioned, hdtv, watched,
> preserve FROM recorded LEFT JOIN recordedprogram ON (recorded.ch
> anid = recordedprogram.chanid AND recorded.progstart =
> recordedprogram.starttime) WHERE recorded.chanid = '1881' AND
> recorded.starttime = '2007-05-07T11:16:18' ;
> 2007-05-07 11:16:24.803 TVRec(1): Changing from WatchingLiveTV to None
> 2007-05-07 11:16:24.803 TVRec(1):
> ClearFlags(FrontendReady,CancelNextRecording,) ->
> RunMainLoop,AskAllowRecording,RecorderRunning,RingBufferReady,
> 2007-05-07 11:16:24.803 TVRec(1): SetFlags(AskAllowRecording,) ->
> RunMainLoop,AskAllowRecording,RecorderRunning,RingBufferReady,
> 2007-05-07 11:16:24.803 TVRec(1): Request: Program(no) channel()
> input() flags(KillRec,KillRingBuffer,)
> 2007-05-07 11:16:24.803 MythEvent: DONE_RECORDING 1 0
> 2007-05-07 11:16:24.803 MythSocket(8242590:16): UpRef: 2
> 2007-05-07 11:16:24.803 MythSocket(8242590:16): DownRef: 1
> 2007-05-07 11:16:24.803 MythSocket(824d840:19): UpRef: 2
> 2007-05-07 11:16:24.804 write -> 19 48
> BACKEND_MESSAGE[]:[]DONE_RECORDING 1 0[]:[]empty
> 2007-05-07 11:16:24.804 MythSocket(824d840:19): DownRef: 1
> 2007-05-07 11:16:24.804 MythSocket(8244090:20): UpRef: 3
> 2007-05-07 11:16:24.804 MythSocket(8244090:20): DownRef: 2
> 2007-05-07 11:16:24.811 HDHRRec(1): StartRecording -- ending...
> 2007-05-07 11:16:24.812 HDHRRec(1): Close()
> 2007-05-07 11:16:25.814 MSqlQuery: UPDATE recorded SET filesize = '0'
> WHERE chanid = '1881' AND starttime = '2007-05-07T11:16:18' ;
> 2007-05-07 11:16:25.814 HDHRRec(1): StartRecording -- end
> 2007-05-07 11:16:25.815 TVRec(1): ClearFlags(RecorderRunning,) ->
> RunMainLoop,AskAllowRecording,RingBufferReady,
> 2007-05-07 11:16:25.815 HDHRRec(1): Close()
> 2007-05-07 11:16:25.816 MSqlQuery: SELECT
> recorded.chanid,starttime,endtime,title,
> subtitle,description,channel.channum,
> channel.callsign,channel.name,channel.commmethod,
> channel.outputfilters,serie
> sid,programid,filesize,
> lastmodified,stars,previouslyshown,originalairdate,
> hostname,recordid,transcoder,playgroup,
> recorded.recpriority,progstart,progend,basename,recgroup, storagegroup
> FROM record
> ed LEFT JOIN channel ON recorded.chanid = channel.chanid WHERE
> recorded.chanid = '1881' AND starttime = '2007-05-07T11:16:18' ;
> 2007-05-07 11:16:25.818 MSqlQuery: SELECT commflagged, cutlist,
> autoexpire, editing, bookmark, stereo, closecaptioned, hdtv, watched,
> preserve FROM recorded LEFT JOIN recordedprogram ON (recorded.ch
> anid = recordedprogram.chanid AND recorded.progstart =
> recordedprogram.starttime) WHERE recorded.chanid = '1881' AND
> recorded.starttime = '2007-05-07T11:16:18' ;
> 2007-05-07 11:16:25.818 TVRec(1): FinishedRecording(Unknown) in recgroup: LiveTV
> 2007-05-07 11:16:25.819 MSqlQuery: UPDATE tvchain SET endtime =
> '2007-05-07T11:16:25' WHERE chanid = '1881' AND starttime =
> '2007-05-07T11:16:18' ;
> 2007-05-07 11:16:25.821 Chain: Updated endtime for
> '1881_20070507111618' to 20070507111625
> 2007-05-07 11:16:25.821 MythEvent: LIVETV_CHAIN UPDATE
> live-comp1-desktop-2007-05-07T11:16:16
> 2007-05-07 11:16:25.823 MSqlQuery: UPDATE recorded SET endtime =
> '2007-05-07T11:16:00',        duplicate = 1 WHERE chanid = '1881' AND
>   starttime = '2007-05-07T11:16:18'
> 2007-05-07 11:16:25.823 Finished recording Unknown: channel 1881
>
> ----------------------------------- frontend
> --------------------------------------
>
> 2007-05-07 11:18:30.679 MSqlQuery: SELECT DISTINCT dirname FROM
> storagegroup WHERE groupname = 'Default'
> 2007-05-07 11:18:30.680 SG(Default): FindRecordingFile: Searching for
> '1881_20070507111830.mpg'
> 2007-05-07 11:18:30.680 SG(Default): FindRecordingDir: Checking '/mnt/store'
> 2007-05-07 11:18:30.680 SG(Default): FindRecordingFile: Found
> '/mnt/store/1881_20070507111830.mpg'
> 2007-05-07 11:18:30.680 ProgramInfo: GetPlaybackURL: File is local:
> '/mnt/store/1881_20070507111830.mpg'
> 2007-05-07 11:18:30.680 RingBuf(/mnt/store/1881_20070507111828.mpg):
> OpenFile(/mnt/store/1881_20070507111830.mpg, 12)
> 2007-05-07 11:18:36.603 MythSocket(839bda8:15): socket is readable
> 2007-05-07 11:18:36.603 MythSocket(839bda8:15): cb->readyRead()
> 2007-05-07 11:18:36.603 read  <- 15 51
> BACKEND_MESSAGE[]:[]RECORDING_LIST_CHANGE[]:[]empty
> 2007-05-07 11:18:36.604 MythEvent: RECORDING_LIST_CHANGE
> 2007-05-07 11:18:37.182 RingBuf(/mnt/store/1881_20070507111830.mpg):
> Invalid file (fd -1) when opening
> '/mnt/store/1881_20070507111830.mpg'.
> 2007-05-07 11:18:37.183 RingBuf(/mnt/store/1881_20070507111830.mpg):
> CalcReadAheadThresh(2946166320 KB)
>                         -> threshhold(64 KB) min read(0 KB) blk size(32 KB)
> 2007-05-07 11:18:37.183 NVP, Error: JumpToProgram's OpenFile failed.
> 2007-05-07 11:18:37.183 NVP, Error: Unknown error, exiting decoder
> 2007-05-07 11:18:37.183 NVP: Exited decoder loop.
> 2007-05-07 11:18:37.188 TV: Attempting to change from WatchingLiveTV to None
> 2007-05-07 11:18:37.189 TV: StopStuff() -- begin
> 2007-05-07 11:18:37.189 TV: StopStuff(): stopping ring buffer[s]
> 2007-05-07 11:18:37.189 TV: StopStuff(): stopping player[s] (1/2)
> 2007-05-07 11:18:37.189 TV: StopStuff(): stopping recorder[s]
> 2007-05-07 11:18:37.189 write -> 19 32      QUERY_RECORDER 1[]:[]STOP_LIVETV
> _______________________________________________
> mythtv-users mailing list
> mythtv-users at mythtv.org
> http://mythtv.org/cgi-bin/mailman/listinfo/mythtv-users
>   
James,

Are you running a combined fe/be, or separate?   Based on the file name 
'/mnt/store....', I'm guessing  separate  FE/BE? 

If so, I had similar type problems when I mounted the video directory 
locally on the FE.  Once I unmounted it, and let the backend stream the 
info, the 'invalid fd -1' errors went away...

Brian


More information about the mythtv-users mailing list