[mythtv] zero-length recordings 0.18 vs 0.19 vs SVN

Ng Theng Kiat htpc at treblid.dyndns.org
Sat Mar 18 01:25:09 UTC 2006


Daniel Kristjansson wrote:

>>2006-03-18 08:56:01.998 ProcessPAT: PAT is missing program, setting timeout
>>    
>>
>This means the channel as defined in your channel table does not exist,
>generally it means you have to re-scan your channels.
>  
>
If I kill mythbackend, it will record that program again as seen below.. 
Why would a rescan fix this?

----
2006-03-18 09:18:30.040 New DB scheduler connection
2006-03-18 09:18:30.043 Connected to database 'mythconverg' at host: 
127.0.0.1
2006-03-18 09:18:30.055 mythbackend version: 0.19.20060226-1 www.mythtv.org
2006-03-18 09:18:30.056 Enabled verbose msgs:  important general record 
siparser channel
2006-03-18 09:18:30.057 AutoExpire: Found 4 recorders w/max rate of 555 
MiB/min
2006-03-18 09:18:30.059 AutoExpire: Required Free Space: 4.3 GB w/freq: 
5 min
2006-03-18 09:18:30.882 MainServer::HandleAnnounce Monitor
2006-03-18 09:18:30.883 adding: htpc.fishing.home as a client (events: 0)
2006-03-18 09:18:30.972 Preview Error: Previewer file 
'/home/htpc/records/1002_20060318085600.mpg' is not valid.
2006-03-18 09:18:30.973 MainServer: Failed to make preview image.
2006-03-18 09:18:30.982 MainServer::HandleAnnounce FileTransfer
2006-03-18 09:18:30.983 adding: htpc.fishing.home as a remote file transfer
2006-03-18 09:18:30.984 Could not open 
/home/htpc/records//1002_20060318085600.mpg.png.  12 retries remaining.
2006-03-18 09:18:31.490 Could not open 
/home/htpc/records//1002_20060318085600.mpg.png.  11 retries remaining.
2006-03-18 09:18:31.994 Could not open 
/home/htpc/records//1002_20060318085600.mpg.png.  10 retries remaining.
2006-03-18 09:18:32.058 Reschedule requested for id -1.
2006-03-18 09:18:32.311 Scheduled 58 items in 0.3 = 0.10 match + 0.15 place
2006-03-18 09:18:32.317 scheduler: Scheduled items: Scheduled 58 items 
in 0.3 = 0.10 match + 0.15 place
2006-03-18 09:18:32.321 Recording starts soon, AUTO-Startup assumed
2006-03-18 09:18:32.325 TVRec(1): StartRecording(Behind the News)
2006-03-18 09:18:32.326 TVRec(1): ClearFlags(AskAllowRecording,) -> 
RunMainLoop,
2006-03-18 09:18:32.390 TVRec(1): StartedRecording(0xaf96c998) 
fn(/home/htpc/records//1002_20060318091900.mpg)
2006-03-18 09:18:32.392 TVRec(1): ClearFlags(CancelNextRecording,) -> 
RunMainLoop,
2006-03-18 09:18:32.393 TVRec(1): Changing from None to RecordingOnly
2006-03-18 09:18:32.394 TVRec(1): 
ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,
2006-03-18 09:18:32.395 TVRec(1): SetFlags(AskAllowRecording,) -> 
RunMainLoop,AskAllowRecording,
2006-03-18 09:18:32.396 TVRec(1): Request: Program(yes) channel() 
input() flags(Recording,)
2006-03-18 09:18:32.398 TVRec(1): HW Tuner: 1->1
2006-03-18 09:18:32.400 TVRec(1): ClearFlags(PENDINGACTIONS,) -> 
RunMainLoop,AskAllowRecording,
2006-03-18 09:18:32.401 DVB#0 Opening DVB channel
2006-03-18 09:18:32.403 DVB#0 Using DVB card 0, with frontend 'DST DVB-T'.
2006-03-18 09:18:32.405 ChannelBase(1): Input #1: 'DVBInput' schan(10) 
sourceid(1) ccid(1)
2006-03-18 09:18:32.406 ChannelBase(1): Current Input #1: 'DVBInput'
2006-03-18 09:18:32.407 DVB#0 SetChannelByString(21)
2006-03-18 09:18:32.410 DVB#0 Frequency: 226500000 BW: 7MHz HP: 3/4 LP: 
3/4C: QAM-64 TM: 8K H: None GI: 1/16
2006-03-18 09:18:32.412 DVB#0 Old Params: freq(219500000) type(OFDM)
2006-03-18 09:18:32.413 DVB#0 New Params: freq(226500000) type(OFDM)
2006-03-18 09:18:32.414 dvbchannel.cpp:wait_for_backend: Status:
2006-03-18 09:18:32.415 DVB#0 DVBChannel::Tune: Frequency tuning successful.
2006-03-18 09:18:32.416 DVB#0 Tuned to frequency for channel 21.
2006-03-18 09:18:32.417 TVRec(1): Starting Signal Monitor
2006-03-18 09:18:32.418 TVRec(1): SetupSignalMonitor(1, 0)
2006-03-18 09:18:32.420 DVB#0 Opening DVB channel
2006-03-18 09:18:32.498 Could not open 
/home/htpc/records//1002_20060318085600.mpg.png.  9 retries remaining.
2006-03-18 09:18:32.755 DVBSignalMonitor(0)::constructor(1,Warning, can 
not measure Bit Error Rate): Operation not supported
2006-03-18 09:18:32.756 DVBSignalMonitor(0)::constructor(1,Warning, can 
not count Uncorrected Blocks): Operation not supported
2006-03-18 09:18:32.757 SM(0)::AddFlags: Seen() Match() Wait(Sig,SNR,)
2006-03-18 09:18:32.758 DVBSM(0)::constructor(): initial flags 0x1400000
2006-03-18 09:18:32.759 TVRec(1): Signal monitor successfully created
2006-03-18 09:18:32.760 TVRec(1): Setting up table monitoring.
2006-03-18 09:18:32.761 TVRec(1): MPEG program number: 738
2006-03-18 09:18:32.763 DTVSM(0)::SetProgramNumber(738):
2006-03-18 09:18:32.765 SM(0)::RemoveFlags: Seen(PMT,) Match(PMT,) Wait()
2006-03-18 09:18:32.766 SM(0)::AddFlags: Seen() Match() Wait(PMT,)
2006-03-18 09:18:32.767 SM(0)::AddFlags: Seen() Match() Wait(PAT,PMT,)
2006-03-18 09:18:32.768 TVRec(1): Successfully set up MPEG table monitoring.
2006-03-18 09:18:32.769 SM(0)::Start: begin
2006-03-18 09:18:32.770 DVBSM(0)::UpdateValues: Signal Locked
2006-03-18 09:18:32.771 DVBSM(0)::UpdateValues: Waiting for table 
monitor to start
2006-03-18 09:18:32.772 DVBSM(0)::UpdateValues: Table monitor started
2006-03-18 09:18:32.772 DVBSM(0)::AddPIDFilter(0x0):
2006-03-18 09:18:32.774 DVBSM(0)::RemovePIDFilter(0x0):
2006-03-18 09:18:32.778 SM(0)::Start: end
2006-03-18 09:18:32.779 TVRec(1): SetFlags(SignalMonitorRunning,) -> 
RunMainLoop,AskAllowRecording,SignalMonitorRunning,
2006-03-18 09:18:32.781 TVRec(1): ClearFlags(WaitingForSignal,) -> 
RunMainLoop,AskAllowRecording,SignalMonitorRunning,
2006-03-18 09:18:32.782 TVRec(1): SetFlags(WaitingForSignal,) -> 
RunMainLoop,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,
2006-03-18 09:18:32.783 TVRec(1): ClearFlags(NeedToStartRecorder,) -> 
RunMainLoop,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,
2006-03-18 09:18:32.783 DVBSM(0): RunTableMonitorTS(): begin (# of pids 1)
2006-03-18 09:18:32.784 TVRec(1): SetFlags(NeedToStartRecorder,) -> 
RunMainLoop,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,
2006-03-18 09:18:32.785 DVBSM(0)::AddPIDFilter(0x0):
2006-03-18 09:18:32.788 Started recording: Behind the News: channel 1002 
on cardid 1, sourceid 1
2006-03-18 09:18:32.793 scheduler: Started recording: Behind the News: 
channel 1002 on cardid 1, sourceid 1
2006-03-18 09:18:32.899 SM(0)::AddFlags: Seen(PAT,) Match() Wait()
2006-03-18 09:18:32.900 SM(0)::AddFlags: Seen() Match(PAT,) Wait()
2006-03-18 09:18:32.900 CreatePATSingleProgram()
2006-03-18 09:18:32.901 PAT in input stream
2006-03-18 09:18:32.903 Program Association Table
 PSIP tableID(0x0) length(37) extension(0x261)
      version(1) current(1) section(0) last_section(0)
         tsid: 609
 programCount: 7
  program number 0 has PID 0x  10   data  0x0 0x0 0x224 0x16
  program number 736 has PID 0x 102   data  0x2 0x224 0x225 0x2
  program number 737 has PID 0x 100   data  0x2 0x225 0x225 0x0
  program number 738 has PID 0x 101   data  0x2 0x226 0x225 0x1
  program number 739 has PID 0x 103   data  0x2 0x227 0x225 0x3
  program number 742 has PID 0x 105   data  0x2 0x230 0x225 0x5
  program number 743 has PID 0x 106   data  0x2 0x231 0x225 0x6

2006-03-18 09:18:32.904 desired_program(738) pid(0x101)
2006-03-18 09:18:32.905 pmt_pid(0x101)
2006-03-18 09:18:32.907 PAT for output stream
2006-03-18 09:18:32.908 Program Association Table
 PSIP tableID(0x0) length(13) extension(0x261)
      version(1) current(1) section(0) last_section(0)
         tsid: 609
 programCount: 1
  program number 1 has PID 0x 101   data  0x0 0x1 0x225 0x1

2006-03-18 09:18:32.909 DVBSM(0)::AddPIDFilter(0x101):
2006-03-18 09:18:33.003 Could not open 
/home/htpc/records//1002_20060318085600.mpg.png.  8 retries remaining.
2006-03-18 09:18:33.074 SM(0)::AddFlags: Seen(PMT,) Match() Wait()
2006-03-18 09:18:33.076 SM(0)::AddFlags: Seen() Match(PMT,) Wait()
2006-03-18 09:18:33.076 CreatePMTSingleProgram()
2006-03-18 09:18:33.077 PMT in input stream
2006-03-18 09:18:33.078 Program Map Table ver(2) pid(0x101) pnum(738) 
len(147)
  Smoothing Buffer Descriptor (0x10) length(6)

 Stream #0 pid(0x201) type(video-mpeg2  0x2)
  Video Descriptor (0x2) length(3)
  Stream Identifier Descriptor (0x52) length(1)
 Stream #1 pid(0x28b) type(audio-mp2-layer[1,2,3]  0x4)
  Audio Descriptor (0x3) length(1)
  ISO-639 Language: code(eng) canonical(eng) eng(English)
  Stream Identifier Descriptor (0x52) length(1)
 Stream #2 pid(0x241) type(private-data  0x6)
  Teletext Descriptor (0x56) length(5)
  Stream Identifier Descriptor (0x52) length(1)
 Stream #3 pid(0x907) type(private-sec  0x5)
  Application Signalling Descriptor (0x6f) length(3)
 Stream #4 pid(0x908) type(dsmcc-b std data  0x11)
  Unknown(19) Descriptor (0x13) length(25)
  Unknown(20) Descriptor (0x14) length(13)
  Data Broadcast Identifier Descriptor (0x66) length(4)
  Stream Identifier Descriptor (0x52) length(1)
 Stream #5 pid(0x90a) type(dsmcc-c NPD data  0x12)
  Stream Identifier Descriptor (0x52) length(1)
  Unknown(20) Descriptor (0x14) length(5)

2006-03-18 09:18:33.080 PMT for output stream
2006-03-18 09:18:33.081 Program Map Table ver(2) pid(0x101) pnum(1) len(23)

 Stream #0 pid(0x201) type(video-mpeg2  0x2)
 Stream #1 pid(0x28b) type(audio-mp2-layer[1,2,3]  0x4)

2006-03-18 09:18:33.110 TVRec(1): Got good signal
2006-03-18 09:18:33.111 TVRec(1): MPEG program num(738)
2006-03-18 09:18:33.112 TVRec(1): TeardownSignalMonitor() -- begin
2006-03-18 09:18:33.113 DVBSM(0)::Stop: begin
2006-03-18 09:18:33.114 SM(0)::Stop: begin
2006-03-18 09:18:33.166 SM(0)::Stop: end
2006-03-18 09:18:33.186 DVBSM(0): RunTableMonitorTS(): shutdown
2006-03-18 09:18:33.187 DVBSM(0)::RemovePIDFilter(0x0):
2006-03-18 09:18:33.188 DVBSM(0)::RemovePIDFilter(0x101):
2006-03-18 09:18:33.190 DVBSM(0): RunTableMonitorTS(): end
2006-03-18 09:18:33.192 DVBSM(0)::Stop: end
2006-03-18 09:18:33.193 DVBSM(0)::Stop: begin
2006-03-18 09:18:33.194 SM(0)::Stop: begin
2006-03-18 09:18:33.195 SM(0)::Stop: end
2006-03-18 09:18:33.196 DVBSM(0)::Stop: end
2006-03-18 09:18:33.197 TVRec(1): TeardownSignalMonitor() -- end
2006-03-18 09:18:33.197 DVBSM(0)::Stop: begin
2006-03-18 09:18:33.198 TVRec(1): 
ClearFlags(WaitingForSignal,SignalMonitorRunning,) -> 
RunMainLoop,AskAllowRecording,NeedToStartRecorder,
2006-03-18 09:18:33.199 SM(0)::Stop: begin
2006-03-18 09:18:33.200 SIParser: Setting ATSCStreamData
2006-03-18 09:18:33.201 SM(0)::Stop: end
2006-03-18 09:18:33.202 SIParser: Setting DVBStreamData
2006-03-18 09:18:33.203 DVBSM(0)::Stop: end
2006-03-18 09:18:33.205 SM(0)::Stop: begin
2006-03-18 09:18:33.208 SM(0)::Stop: end
2006-03-18 09:18:33.209 SIParser: Added initial preferred language 'eng' 
with priority 1
2006-03-18 09:18:33.211 SIParser: Added initial preferred language 'aus' 
with priority 2
2006-03-18 09:18:33.212 DVB#0 DVB SI Table Parser Started
2006-03-18 09:18:33.213 SIParser: ReinitSIParser(std dvb, service #738)
2006-03-18 09:18:33.213 DVBSIParser: Starting DVB Section Reader thread
2006-03-18 09:18:33.214 SIParser: SetTableStandard(dvb)
2006-03-18 09:18:33.215 DVBSIParser: Adding PID 0x   0 Filter 0x 0 Mask 
0xff Buffer 40960
2006-03-18 09:18:33.218 SIParser: SetStreamData(0x814fae8)
2006-03-18 09:18:33.219 SIParser: Setting ATSCStreamData
2006-03-18 09:18:33.220 SIParser: Making #738 the requested MPEG program 
number
2006-03-18 09:18:33.222 SIParser: PAT Version: 1  Tuned to TransportID: 609
2006-03-18 09:18:33.223 SIParser: NIT Present on this transport  on PID 0x0
2006-03-18 09:18:33.224 SIParser: PMT pn(738) version(2) cnt(6) pid(0x101)
2006-03-18 09:18:33.225 DVB#0 SetPMT(257) program number #738, PCRPID(0x903)
2006-03-18 09:18:33.227 TVRec(1): 
SetFlags(WaitingForSIParser,SIParserRunning,) -> 
RunMainLoop,AskAllowRecording,WaitingForSIParser,NeedToStartRecorder,SIParserRunning,
2006-03-18 09:18:33.228 TVRec(1): Got SIParser PMT
2006-03-18 09:18:33.229 TVRec(1): ClearFlags(WaitingForSIParser,) -> 
RunMainLoop,AskAllowRecording,NeedToStartRecorder,SIParserRunning,
2006-03-18 09:18:33.230 TVRec(1): Starting Recorder
2006-03-18 09:18:33.235 TVRec(1): Using profile 'Default' to record
2006-03-18 09:18:33.253 RecBase(0): SetRingBuffer(0xac705400) 
'/home/htpc/records//1002_20060318091900.mpg'
2006-03-18 09:18:33.255 RecBase(0): SetRecording(0xaf96c998) 
title(Behind the News)
2006-03-18 09:18:33.258 DVBRec(0): Card opened successfully fd(17)
2006-03-18 09:18:33.259 DVB#0 SetRecorder()
2006-03-18 09:18:33.260 DVBRec(0): SetPMT(257)
2006-03-18 09:18:33.260 SIParser: PAT Version: 1  Tuned to TransportID: 609
2006-03-18 09:18:33.261 DVBRec(0): SetPAT(NULL)
2006-03-18 09:18:33.262 SIParser: NIT Present on this transport  on PID 0x10
2006-03-18 09:18:33.263 DVBRec(0): SetOutputPMT(NULL)
2006-03-18 09:18:33.264 CreatePATSingleProgram()
2006-03-18 09:18:33.266 PAT in input stream
2006-03-18 09:18:33.268 Program Association Table
 PSIP tableID(0x0) length(37) extension(0x261)
      version(1) current(1) section(0) last_section(0)
         tsid: 609
 programCount: 7
  program number 0 has PID 0x  10   data  0x0 0x0 0x224 0x16
  program number 736 has PID 0x 102   data  0x2 0x224 0x225 0x2
  program number 737 has PID 0x 100   data  0x2 0x225 0x225 0x0
  program number 738 has PID 0x 101   data  0x2 0x226 0x225 0x1
  program number 739 has PID 0x 103   data  0x2 0x227 0x225 0x3
  program number 742 has PID 0x 105   data  0x2 0x230 0x225 0x5
  program number 743 has PID 0x 106   data  0x2 0x231 0x225 0x6

2006-03-18 09:18:33.287 desired_program(738) pid(0x101)
2006-03-18 09:18:33.287 TVRec(1): 
SetFlags(RecorderRunning,RingBufferReady,) -> 
RunMainLoop,AskAllowRecording,NeedToStartRecorder,SIParserRunning,RecorderRunning,RingBufferReady,
2006-03-18 09:18:33.288 pmt_pid(0x101)
2006-03-18 09:18:33.303 PAT for output stream
2006-03-18 09:18:33.314 Program Association Table
 PSIP tableID(0x0) length(13) extension(0x261)
      version(1) current(1) section(0) last_section(0)
         tsid: 609
 programCount: 1
  program number 1 has PID 0x 101   data  0x0 0x1 0x225 0x1

2006-03-18 09:18:33.303 TVRec(1): ClearFlags(NeedToStartRecorder,) -> 
RunMainLoop,AskAllowRecording,SIParserRunning,RecorderRunning,RingBufferReady,
2006-03-18 09:18:33.317 DevRdB(0): buffer size 19000 KB
2006-03-18 09:18:33.318 DVBSIParser: Adding PID 0x 101 Filter 0x 2 Mask 
0xff Buffer 40960
2006-03-18 09:18:33.320 DVBRec(0): Resetting Demux Filters
2006-03-18 09:18:33.321 DVBSIParser: Adding PID 0x  10 Filter 0x40 Mask 
0xff Buffer 40960
2006-03-18 09:18:33.322 DVBRec(0): Adding pid 0x201 size(3600384)
2006-03-18 09:18:33.325 DVBRec(0): Set demux buffer size for pid 0x201 
to 3600384,
                        which gives us a 1500 msec buffer.
2006-03-18 09:18:33.327 DVBRec(0): Adding pid 0x28b size(94208)
2006-03-18 09:18:33.328 DVBRec(0): Set demux buffer size for pid 0x28b t




More information about the mythtv-dev mailing list