[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