[mythtv-users] Missed recordings

Mercury Morris mercury.morris at gmail.com
Fri Oct 27 18:29:49 UTC 2006


Running MythTV version 0.20.20061004-2, from SVN, since 10-16-2006,
the following failure occurred 10-25-2006:

Three recordings resulted in no file(s) being created.  The database
entries for all three looked normal, but the files never existed.  I
have attached the backend log for the first recording.

All three were "recorded" on the same DVB card, an AirStar HD5000.
And, this version of MythTV was an SVN upgrade.  Prior to the upgrade,
a "missed recording" failure had not occurred on this hardware.

I need some expertise to help interpret the log because I can't tell
if anything in the log indicates the cause of the file(s) not being
created (/video/2041_20061025210000.mpg).

There are similar examples of missed recordings in the several
archives, but no single instance gives a definite cause and/or a
specific fix.

Thanks for any help.

-- 
MM
-------------- next part --------------
2006-10-25 20:59:29.449 TVRec(2): SetFlags(AskAllowRecording,) -> RunMainLoop,AskAllowRecording,
2006-10-25 20:59:29.453 TVRec(2): ClearFlags(AskAllowRecording,) -> RunMainLoop,
2006-10-25 21:00:02.587 TVRec(2): StartRecording(CSI: NY)
2006-10-25 21:00:02.591 TVRec(2): ClearFlags(AskAllowRecording,) -> RunMainLoop,
2006-10-25 21:00:02.641 TVRec(2): StartedRecording(0x2aaaadf37b20) fn(/video/2041_20061025210000.mpg)
2006-10-25 21:00:02.655 TVRec(2): ClearFlags(CancelNextRecording,) -> RunMainLoop,
2006-10-25 21:00:02.655 TVRec(2): Changing from None to RecordingOnly
2006-10-25 21:00:02.659 TVRec(2): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,
2006-10-25 21:00:02.660 TVRec(2): SetFlags(AskAllowRecording,) -> RunMainLoop,AskAllowRecording,
2006-10-25 21:00:02.660 TVRec(2): Request: Program(yes) channel() input() flags(Recording,)
2006-10-25 21:00:02.661 TVRec(2): HW Tuner: 2->2
2006-10-25 21:00:02.662 TVRec(2): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,AskAllowRecording,
2006-10-25 21:00:02.663 DVBChan(0): Opening DVB channel
2006-10-25 21:00:02.663 DVBChan(0): SetChannelByString(41): 
2006-10-25 21:00:02.664 DVBChan(0): SetChannelByString(41): Already on channel
2006-10-25 21:00:02.664 TVRec(2): Starting Signal Monitor
2006-10-25 21:00:02.665 TVRec(2): SetupSignalMonitor(1, 0)
2006-10-25 21:00:02.665 DVBChan(0): Opening DVB channel
2006-10-25 21:00:02.666 SM(0)::AddFlags: Seen() Match() Wait(Sig,SNR,BER,UB,)
2006-10-25 21:00:02.667 DVBSM(0)::constructor(): initial flags 0x7400000
2006-10-25 21:00:02.668 TVRec(2): Signal monitor successfully created
2006-10-25 21:00:02.668 TVRec(2): Setting up table monitoring.
2006-10-25 21:00:02.669 TVRec(2): ATSC channel: 4_1
2006-10-25 21:00:02.669 DTVSM(0)::SetChannel(4, 1): 
2006-10-25 21:00:02.670 SM(0)::RemoveFlags: Seen(PAT,PMT,VCT,) Match(PAT,PMT,VCT,) Wait()
2006-10-25 21:00:02.670 SM(0)::AddFlags: Seen() Match() Wait(PAT,VCT,)
2006-10-25 21:00:02.686 SM(0)::AddFlags: Seen() Match() Wait(MGT,)
2006-10-25 21:00:02.695 TVRec(2): Successfully set up ATSC table monitoring.
2006-10-25 21:00:02.696 SM(0)::Start: begin
2006-10-25 21:00:02.697 DVBSM(0)::UpdateValues: Signal Locked
2006-10-25 21:00:02.699 SM(0)::Start: end
2006-10-25 21:00:02.707 TVRec(2): SetFlags(SignalMonitorRunning,) -> RunMainLoop,AskAllowRecording,SignalMonitorRunning,
2006-10-25 21:00:02.708 TVRec(2): ClearFlags(WaitingForSignal,) -> RunMainLoop,AskAllowRecording,SignalMonitorRunning,
2006-10-25 21:00:02.708 TVRec(2): SetFlags(WaitingForSignal,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,
2006-10-25 21:00:02.709 TVRec(2): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,
2006-10-25 21:00:02.710 TVRec(2): SetFlags(NeedToStartRecorder,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,
2006-10-25 21:00:02.703 DVBSM(0)::AddPIDFilter(0x0): 
2006-10-25 21:00:02.703 DVBSM(0)::UpdateValues: Waiting for table monitor to start
2006-10-25 21:00:02.711 Started recording: CSI: NY "Open and Shut": channel 2041 on cardid 2, sourceid 2
2006-10-25 21:00:02.721 DVBSM(0)::RemovePIDFilter(0x0): 
2006-10-25 21:00:02.727 DVBSM(0)::UpdateValues: Table monitor started
2006-10-25 21:00:02.732 scheduler: Started recording: CSI: NY "Open and Shut": channel 2041 on cardid 2, sourceid 2
2006-10-25 21:00:02.755 DVBSM(0): RunTableMonitorTS(): begin (# of pids 2)
2006-10-25 21:00:02.760 DVBSM(0)::AddPIDFilter(0x0): 
2006-10-25 21:00:02.760 DVBSM(0)::AddPIDFilter(0x1ffb): 
2006-10-25 22:00:00.818 TVRec(2): ClearFlags(FinishRecording,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,
2006-10-25 22:00:00.822 TVRec(2): Changing from RecordingOnly to None
2006-10-25 22:00:00.839 TVRec(2): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,
2006-10-25 22:00:00.839 TVRec(2): SetFlags(AskAllowRecording,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,
2006-10-25 22:00:00.840 TVRec(2): Request: Program(no) channel() input() flags(CloseRec,KillRingBuffer,)
2006-10-25 22:00:00.840 TVRec(2): TeardownSignalMonitor() -- begin
2006-10-25 22:00:00.841 DVBSM(0)::Stop: begin
2006-10-25 22:00:00.841 SM(0)::Stop: begin
2006-10-25 22:00:00.850 SM(0)::Stop: end
2006-10-25 22:00:00.862 DVBSM(0): RunTableMonitorTS(): shutdown
2006-10-25 22:00:00.866 DVBSM(0)::RemovePIDFilter(0x0): 
2006-10-25 22:00:00.867 DVBSM(0)::RemovePIDFilter(0x1ffb): 
2006-10-25 22:00:00.874 DVBSM(0): RunTableMonitorTS(): end
2006-10-25 22:00:00.875 DVBSM(0)::Stop: end
2006-10-25 22:00:00.878 TVRec(2): TeardownSignalMonitor() -- end
2006-10-25 22:00:00.879 TVRec(2): ClearFlags(SignalMonitorRunning,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,
2006-10-25 22:00:00.879 TVRec(2): ClearFlags(WaitingForSignal,) -> RunMainLoop,AskAllowRecording,NeedToStartRecorder,
2006-10-25 22:00:00.881 TVRec(2): FinishedRecording(CSI: NY) in recgroup: Default
2006-10-25 22:00:00.883 Finished recording CSI: NY "Open and Shut": channel 2041
2006-10-25 22:00:00.888 Reschedule requested for id 0.
2006-10-25 22:00:00.907 scheduler: Finished recording: CSI: NY "Open and Shut": channel 2041
2006-10-25 22:00:00.983 TVRec(2): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,AskAllowRecording,
2006-10-25 22:00:01.005 Scheduled 81 items in 0.1 = 0.03 match + 0.09 place
2006-10-25 22:00:01.011 scheduler: Scheduled items: Scheduled 81 items in 0.1 = 0.03 match + 0.09 place


More information about the mythtv-users mailing list