[mythtv-users] I can record from live tv but not from the schedule

Lee McLaren lists at lrm.com.au
Wed May 6 22:50:39 UTC 2009


David Watkins wrote:
>> I have gone through the channels with a fine tooth comb, the channel ID
>> and number is unique, I have captured logs of live tv and recording and
>> there seems to be some differences in theses parts:
>> Both seem to be recording the same channel:
>>     
>
> Actually those backend logs look like they coincide with the attempt
> to replay the recording, rather than create it.
>
> I would expect to see a line like the following
>
> 2009-04-19 14:48:34.390 Started recording: The First Wives Club:
> channel 1014 on cardid 1, sourceid 1
>
> Can you find anything like that?
> _______________________________________________
> mythtv-users mailing list
> mythtv-users at mythtv.org
> http://mythtv.org/cgi-bin/mailman/listinfo/mythtv-users
> ------------------------------------------------------------------------
>
>
> No virus found in this incoming message.
> Checked by AVG - www.avg.com 
> Version: 8.5.287 / Virus Database: 270.12.20/2100 - Release Date: 05/06/09 06:04:00
>
>   
Thanks again David, I have put the complete logs at:

http://pastebin.com/m34eca092

The relevant sections are below:

Greg:
I have done both the normal and extended checks on the database, no
problems reported.




SCHEDULED
#######################
2009-05-06 22:25:06.404 Started recording: Night on Earth: channel 1003
on cardid 1, sourceid 1
2009-05-06 22:25:06.406 scheduler: Started recording: Night on Earth:
channel 1003 on cardid 1, sourceid 1
2009-05-06 22:25:06.571 SM(0)::AddFlags: Seen() Match() Wait(Sig,)
2009-05-06 22:25:06.627 SM(0)::AddFlags: Seen() Match() Wait(Sig,)
2009-05-06 22:25:06.682 SM(0)::AddFlags: Seen() Match() Wait(Sig,)
2009-05-06 22:25:06.689 DVBSM(0): UpdateValues -- Signal Locked
2009-05-06 22:25:06.689 DVBSH(0): AddListener(0x9f924d8) -- begin
2009-05-06 22:25:06.689 DVBSH(0): AddListener(0x9f924d8) -- locked
2009-05-06 22:25:06.689 DVBSH(0): AddListener(0x9f924d8) -- end
2009-05-06 22:25:06.689 DVBSH(0): AddPIDFilter(0x0) priority 2
2009-05-06 22:25:06.689 PIDInfo(0): Opening filter for pid 0x0
2009-05-06 22:25:06.689 DVBSH(0): RemovePIDFilter(0x0)
2009-05-06 22:25:06.689 PIDInfo(0): Closing filter for pid 0x0
2009-05-06 22:25:06.692 DVBSH(0): RunTS(): begin
2009-05-06 22:25:06.692 DVBSH(0): AddPIDFilter(0x0) priority 2
2009-05-06 22:25:06.692 PIDInfo(0): Opening filter for pid 0x0
2009-05-06 22:25:06.692 DVBSH(0): AddPIDFilter(0x10) priority 2
2009-05-06 22:25:06.692 PIDInfo(0): Opening filter for pid 0x10
2009-05-06 22:25:06.692 DVBSH(0): AddPIDFilter(0x11) priority 2
2009-05-06 22:25:06.692 PIDInfo(0): Opening filter for pid 0x11
2009-05-06 22:25:06.692 DVBSH(0): AddPIDFilter(0x14) priority 2
2009-05-06 22:25:06.692 PIDInfo(0): Opening filter for pid 0x14
2009-05-06 22:25:06.725 SM(0)::AddFlags: Seen(PAT,) Match() Wait()
2009-05-06 22:25:06.725 SM(0)::AddFlags: Seen() Match(PAT,) Wait()
2009-05-06 22:25:06.725 CreatePATSingleProgram()
2009-05-06 22:25:06.726 PAT in input stream
2009-05-06 22:25:06.726 Program Association Table
 PSIP tableID(0x0) length(41) extension(0x380)
      version(0) current(1) section(0) last_section(0)
         tsid: 896
 programCount: 8
  program number     0 has PID 0x  10   data  0x 0 0x 0 0xe0 0x10
  program number   897 has PID 0x 401   data  0x 3 0x81 0xe4 0x 1
  program number   898 has PID 0x 402   data  0x 3 0x82 0xe4 0x 2
  program number   899 has PID 0x 408   data  0x 3 0x83 0xe4 0x 8
  program number   900 has PID 0x 409   data  0x 3 0x84 0xe4 0x 9
  program number   901 has PID 0x 400   data  0x 3 0x85 0xe4 0x 0
  program number   910 has PID 0x 403   data  0x 3 0x8e 0xe4 0x 3
  program number   911 has PID 0x 404   data  0x 3 0x8f 0xe4 0x 4

2009-05-06 22:25:06.726 desired_program(897) pid(0x401)
2009-05-06 22:25:06.726 pmt_pid(0x401)
2009-05-06 22:25:06.726 PAT for output stream
2009-05-06 22:25:06.726 Program Association Table
 PSIP tableID(0x0) length(13) extension(0x380)
      version(0) current(1) section(0) last_section(0)
         tsid: 896
 programCount: 1
  program number     1 has PID 0x 401   data  0x 0 0x 1 0xe4 0x 1


LIVETV
##################
2009-05-06 22:32:34.219 DVBSH(3): AddPIDFilter(0x29) priority 3
2009-05-06 22:32:34.219 PIDInfo(3): Opening filter for pid 0x29
2009-05-06 22:32:34.220 DVBSH(3): AddPIDFilter(0x33) priority 3
2009-05-06 22:32:34.220 PIDInfo(3): Opening filter for pid 0x33
2009-05-06 22:32:34.220 DVBSH(3): AddPIDFilter(0x51) priority 3
2009-05-06 22:32:34.220 PIDInfo(3): Opening filter for pid 0x51
2009-05-06 22:32:34.220 DVBSH(3): AddPIDFilter(0xa1) priority 3
2009-05-06 22:32:34.220 PIDInfo(3): Opening filter for pid 0xa1
2009-05-06 22:32:34.248 DTVSM(3)::GetStatusList: WaitForPMT seen(1)
matching(1)
2009-05-06 22:32:34.249 TVRec(12): Got good signal
2009-05-06 22:32:34.249 TVRec(12): TeardownSignalMonitor() -- begin
2009-05-06 22:32:34.249 DVBSM(3): Stop() -- begin
2009-05-06 22:32:34.249 SM(3)::Stop: begin
2009-05-06 22:32:34.299 SM(3)::Stop: end
2009-05-06 22:32:34.299 DVBSH(3): RemoveListener(0x830b2d0) -- begin
2009-05-06 22:32:34.299 DVBSH(3): RemoveListener(0x830b2d0) -- locked
2009-05-06 22:32:34.323 DVBSH(3): RunTS(): shutdown
2009-05-06 22:32:34.323 DVBSH(3): RemovePIDFilter(0x0)
2009-05-06 22:32:34.323 PIDInfo(3): Closing filter for pid 0x0
2009-05-06 22:32:34.323 DVBSH(3): RemovePIDFilter(0x29)
2009-05-06 22:32:34.323 PIDInfo(3): Closing filter for pid 0x29
2009-05-06 22:32:34.323 DVBSH(3): RemovePIDFilter(0x33)
2009-05-06 22:32:34.323 PIDInfo(3): Closing filter for pid 0x33
2009-05-06 22:32:34.323 DVBSH(3): RemovePIDFilter(0x51)
2009-05-06 22:32:34.323 PIDInfo(3): Closing filter for pid 0x51
2009-05-06 22:32:34.323 DVBSH(3): RemovePIDFilter(0xa1)
2009-05-06 22:32:34.323 PIDInfo(3): Closing filter for pid 0xa1
2009-05-06 22:32:34.323 DVBSH(3): RemovePIDFilter(0x401)
2009-05-06 22:32:34.323 PIDInfo(3): Closing filter for pid 0x401
2009-05-06 22:32:34.635 DVBSH(3): RunTS(): end
2009-05-06 22:32:34.635 DVBSH(3): RemoveListener(0x830b2d0) -- end
2009-05-06 22:32:34.635 DVBSM(3): Stop() -- end
2009-05-06 22:32:34.635 DVBSM(3): Stop() -- begin
2009-05-06 22:32:34.635 SM(3)::Stop: begin
2009-05-06 22:32:34.635 SM(3)::Stop: end
2009-05-06 22:32:34.635 DVBSM(3): Stop() -- end
2009-05-06 22:32:34.636 DVBSM(3): Stop() -- begin
2009-05-06 22:32:34.636 SM(3)::Stop: begin
2009-05-06 22:32:34.636 SM(3)::Stop: end
2009-05-06 22:32:34.636 DVBSM(3): Stop() -- end
2009-05-06 22:32:34.636 SM(3)::Stop: begin
2009-05-06 22:32:34.636 SM(3)::Stop: end
2009-05-06 22:32:34.636 TVRec(12): TeardownSignalMonitor() -- end
2009-05-06 22:32:34.636 TVRec(12): ClearFlags(SignalMonitorRunning,) ->
RunMainLoop,CancelNextRecording,WaitingForSignal,NeedToStartRecorder,DummyRecorderRunning,RingBufferReady,
2009-05-06 22:32:34.636 TVRec(12): ClearFlags(WaitingForSignal,) ->
RunMainLoop,CancelNextRecording,NeedToStartRecorder,DummyRecorderRunning,RingBufferReady,
2009-05-06 22:32:34.636 TVRec(12): Starting Recorder
2009-05-06 22:32:34.636 TVRec(12): ClearFlags(DummyRecorderRunning,) ->
RunMainLoop,CancelNextRecording,NeedToStartRecorder,RingBufferReady,
2009-05-06 22:32:34.637 TVRec(12): FinishedRecording(Night on Earth) in
recgroup: LiveTV
2009-05-06 22:32:34.638 Chain: Updated endtime for '1003_20090506223233'
to 20090506223234
2009-05-06 22:32:34.639 Finished recording Night on Earth: channel 1003
2009-05-06 22:32:34.641 scheduler: Finished recording: Night on Earth:
channel 1003
2009-05-06 22:32:34.643 Using profile 'Live TV' to record
2009-05-06 22:32:34.643 TVRec(12): SwitchLiveTVRingBuffer(discont 1,
set_rec 0)
2009-05-06 22:32:34.643 TVRec(12): GetProgramRingBufferForLiveTV()
2009-05-06 22:32:35.659 TVRec(12): StartedRecording(0xa5614778)
fn(/myth/live/1003_20090506223234.mpg)
2009-05-06 22:32:35.664 TVRec(12): FinishedRecording(Night on Earth) in
recgroup: LiveTV
2009-05-06 22:32:35.664 Chain: Updated endtime for '1003_20090506223233'
to 20090506223235
2009-05-06 22:32:35.674 Finished recording Night on Earth: channel 1003
2009-05-06 22:32:35.675 Preview:
'myth://10.1.1.150:6543/1003_20090506223233.mpg' is not local,
            replacing with '/myth/live/1003_20090506223233.mpg', which
is local.
2009-05-06 22:32:35.685 Chain: Appended at 1 '1003_20090506223234'
2009-05-06 22:32:35.694 RecBase(12:3): SetRingBuffer(0xa56d2fd0)
'/myth/live/1003_20090506223234.mpg'
2009-05-06 22:32:35.694 DVBRec(12:3): SetPAT(897 on 0x401)
2009-05-06 22:32:35.694 CreatePATSingleProgram()
2009-05-06 22:32:35.694 PAT in input stream
2009-05-06 22:32:35.694 Program Association Table
 PSIP tableID(0x0) length(41) extension(0x380)
      version(0) current(1) section(0) last_section(0)
         tsid: 896
 programCount: 8
  program number     0 has PID 0x  10   data  0x 0 0x 0 0xe0 0x10
  program number   897 has PID 0x 401   data  0x 3 0x81 0xe4 0x 1
  program number   898 has PID 0x 402   data  0x 3 0x82 0xe4 0x 2
  program number   899 has PID 0x 408   data  0x 3 0x83 0xe4 0x 8
  program number   900 has PID 0x 409   data  0x 3 0x84 0xe4 0x 9
  program number   901 has PID 0x 400   data  0x 3 0x85 0xe4 0x 0
  program number   910 has PID 0x 403   data  0x 3 0x8e 0xe4 0x 3
  program number   911 has PID 0x 404   data  0x 3 0x8f 0xe4 0x 4

2009-05-06 22:32:35.694 desired_program(897) pid(0x401)
2009-05-06 22:32:35.694 pmt_pid(0x401)
2009-05-06 22:32:35.694 PAT for output stream
2009-05-06 22:32:35.694 Program Association Table
 PSIP tableID(0x0) length(13) extension(0x380)
      version(0) current(1) section(0) last_section(0)
         tsid: 896
 programCount: 1
  program number     1 has PID 0x 401   data  0x 0 0x 1 0xe4 0x 1

2009-05-06 22:32:35.694 DVBRec(12:3): Saw PAT but did not write to disk yet
2009-05-06 22:32:35.694 DVBRec(12:3): SetPMT(897)
2009-05-06 22:32:35.694 CreatePMTSingleProgram()
2009-05-06 22:32:35.694 PMT in input stream
2009-05-06 22:32:35.695 Program Map Table ver(2) pid(0x401) pnum(897)
len(100)
  Maximum Bitrate Descriptor (0xe) length(3)
  Multiplex Buffer Utilization Descriptor (0xc) length(4)

 Stream #0 pid(0xa1) type(video-mpeg2  0x2)
  Stream Identifier Descriptor (0x52) length(1)
  Video Descriptor (0x2) length(3)
  Unknown(6) Descriptor (0x6) length(1)
  Maximum Bitrate Descriptor (0xe) length(3)
 Stream #1 pid(0x51) type(audio-mp2-layer[1,2,3]  0x4)
  Stream Identifier Descriptor (0x52) length(1)
  ISO-639 Language: code(eng) canonical(eng) eng(English)
  Audio Descriptor (0x3) length(1)
  Maximum Bitrate Descriptor (0xe) length(3)
 Stream #2 pid(0x29) type(private-data  0x6)
  Stream Identifier Descriptor (0x52) length(1)
  Maximum Bitrate Descriptor (0xe) length(3)
  Teletext Descriptor (0x56) length(5)
 Stream #3 pid(0x33) type(private-data  0x6)
  Stream Identifier Descriptor (0x52) length(1)
  Maximum Bitrate Descriptor (0xe) length(3)

2009-05-06 22:32:35.695 Created PMT
Program Map Table ver(2) pid(0x401) pnum(1) len(100)
  Maximum Bitrate Descriptor (0xe) length(3)
  Multiplex Buffer Utilization Descriptor (0xc) length(4)

 Stream #0 pid(0xa1) type(video-mpeg2  0x2)
  Stream Identifier Descriptor (0x52) length(1)
  Video Descriptor (0x2) length(3)
  Unknown(6) Descriptor (0x6) length(1)
  Maximum Bitrate Descriptor (0xe) length(3)
 Stream #1 pid(0x51) type(audio-mp2-layer[1,2,3]  0x4)
  Stream Identifier Descriptor (0x52) length(1)
  ISO-639 Language: code(eng) canonical(eng) eng(English)
  Audio Descriptor (0x3) length(1)
  Maximum Bitrate Descriptor (0xe) length(3)
 Stream #2 pid(0x29) type(private-data  0x6)
  Stream Identifier Descriptor (0x52) length(1)
  Maximum Bitrate Descriptor (0xe) length(3)
  Teletext Descriptor (0x56) length(5)
 Stream #3 pid(0x33) type(private-data  0x6)
  Stream Identifier Descriptor (0x52) length(1)
  Maximum Bitrate Descriptor (0xe) length(3)

2009-05-06 22:32:35.695 PMT for output stream
2009-05-06 22:32:35.695 Program Map Table ver(2) pid(0x401) pnum(1) len(100)
  Maximum Bitrate Descriptor (0xe) length(3)
  Multiplex Buffer Utilization Descriptor (0xc) length(4)

 Stream #0 pid(0xa1) type(video-mpeg2  0x2)
  Stream Identifier Descriptor (0x52) length(1)
  Video Descriptor (0x2) length(3)
  Unknown(6) Descriptor (0x6) length(1)
  Maximum Bitrate Descriptor (0xe) length(3)
 Stream #1 pid(0x51) type(audio-mp2-layer[1,2,3]  0x4)
  Stream Identifier Descriptor (0x52) length(1)
  ISO-639 Language: code(eng) canonical(eng) eng(English)
  Audio Descriptor (0x3) length(1)
  Maximum Bitrate Descriptor (0xe) length(3)
 Stream #2 pid(0x29) type(private-data  0x6)
  Stream Identifier Descriptor (0x52) length(1)
  Maximum Bitrate Descriptor (0xe) length(3)
  Teletext Descriptor (0x56) length(5)
 Stream #3 pid(0x33) type(private-data  0x6)
  Stream Identifier Descriptor (0x52) length(1)
  Maximum Bitrate Descriptor (0xe) length(3)

2009-05-06 22:32:35.695 DVBRec(12:3): Saw PMT but did not write to disk yet
2009-05-06 22:32:35.695 RecBase(12:3): SetRecording(0xa5b421c0)
title(Night on Earth)
2009-05-06 22:32:35.696 DVBRec(12:3): Card opened successfully fd(-1)
2009-05-06 22:32:35.696 TVRec(12): SetFlags(FrontendReady,) ->
FrontendReady,RunMainLoop,CancelNextRecording,NeedToStartRecorder,RingBufferReady,
2009-05-06 22:32:35.696 DVBRec(12:3): Wrote PAT @0 + 0
2009-05-06 22:32:35.696 DVBRec(12:3): Wrote PMT @188 + 0
2009-05-06 22:32:35.696 DVBSH(3): AddListener(0x830b2d0) -- begin
2009-05-06 22:32:35.696 DVBSH(3): AddListener(0x830b2d0) -- locked
2009-05-06 22:32:35.697 AutoExpire: CalcParams(): Max required Free
Space: 52.0 GB w/freq: 15 min
2009-05-06 22:32:35.701 TVRec(12):
SetFlags(RecorderRunning,RingBufferReady,) ->
FrontendReady,RunMainLoop,CancelNextRecording,NeedToStartRecorder,RecorderRunning,RingBufferReady,
2009-05-06 22:32:35.701 TVRec(12): ClearFlags(NeedToStartRecorder,) ->
FrontendReady,RunMainLoop,CancelNextRecording,RecorderRunning,RingBufferReady,
2009-05-06 22:32:35.712 DevRdB(3): buffer size 9400 KB
2009-05-06 22:32:35.712 DVBSH(3): AddListener(0x830b2d0) -- end
2009-05-06 22:32:35.712 DVBSH(3): RunTS(): begin
2009-05-06 22:32:35.712 DVBSH(3): AddPIDFilter(0x0) priority 2
2009-05-06 22:32:35.712 PIDInfo(3): Opening filter for pid 0x0
2009-05-06 22:32:35.714 DVBSH(3): AddPIDFilter(0x10) priority 1
2009-05-06 22:32:35.714 PIDInfo(3): Opening filter for pid 0x10
2009-05-06 22:32:35.714 DVBSH(3): AddPIDFilter(0x14) priority 2
2009-05-06 22:32:35.714 PIDInfo(3): Opening filter for pid 0x14
2009-05-06 22:32:35.714 DVBSH(3): AddPIDFilter(0x29) priority 3
2009-05-06 22:32:35.714 PIDInfo(3): Opening filter for pid 0x29
2009-05-06 22:32:35.714 DVBSH(3): AddPIDFilter(0x33) priority 3
2009-05-06 22:32:35.714 PIDInfo(3): Opening filter for pid 0x33
2009-05-06 22:32:35.714 DVBSH(3): AddPIDFilter(0x51) priority 3
2009-05-06 22:32:35.714 PIDInfo(3): Opening filter for pid 0x51
-------------- next part --------------

No virus found in this outgoing message.
Checked by AVG - www.avg.com 
Version: 8.5.287 / Virus Database: 270.12.20/2100 - Release Date: 05/06/09 06:04:00


More information about the mythtv-users mailing list