[mythtv] Assistance debugging a DVB/PMT tuning problem

[Janne Grunau]

On Wednesday 23 January 2008 21:36:12 Tom Dexter wrote:
> On Jan 23, 2008 3:21 PM, Janne Grunau <janne-mythtv at grunau.be> wrote:
> > On Wednesday 23 January 2008 21:06:29 Tom Dexter wrote:

> > > Mythtv gets a lock on the channel but simply can't get a PMT.  On
> > > the frontend I get (LA_VG).  Here's the "-v channel" verbose
> > > output
> >
> > to be useful it needs be a -v channel,record,siparser log.

> 2008-01-23 15:32:03.848 TVRec(3): SetChannel() -- end
> 2008-01-23 15:32:03.844 DVBSM(2)::UpdateValues: Waiting for table monitor to start
> 2008-01-23 15:32:03.855 DVBSM(2)::UpdateValues: Table monitor started
> 2008-01-23 15:32:03.844 DVBSM(2): RunTableMonitorTS(): begin (# of pids 2)
> 2008-01-23 15:32:03.858 DVBSM(2)::AddPIDFilter(0x0): 
> 2008-01-23 15:32:03.859 DVBSM(2)::AddPIDFilter(0x1ffb):
> 0: start_time: 3710.083 duration: 2.535
> 1: start_time: 3710.050 duration: 2.546
> stream: start_time: 41222.775 duration: 28.529 bitrate=17049 kb/s
> 2008-01-23 15:32:03.919 AFD: Opened codec 0x8230140, id(MPEG2VIDEO) type(Video)
> 2008-01-23 15:32:03.923 AFD: Opened codec 0x81df7e0, id(AC3) type(Audio)
> 2008-01-23 15:32:03.967 SM(2)::AddFlags: Seen(MGT,) Match() Wait()
> 2008-01-23 15:32:03.970 SM(2)::AddFlags: Seen() Match(MGT,) Wait() 
> 2008-01-23 15:32:03.971 DVBRec(2): SetPAT(): Ignoring PAT not containing our desired program...

this is a little bit suspicious, there should be only one PAT

> 2008-01-23 15:32:03.972 SM(2)::AddFlags: Seen(PAT,) Match() Wait()
> [mpeg2video @ 0xb73814a8]00 motion_type at 100 63
> [mpeg2video @ 0xb73814a8]00 motion_type at 50 64
> [mpeg2video @ 0xb73814a8]00 motion_type at 60 64
> [mpeg2video @ 0xb73814a8]ac-tex damaged at 81 64
> [mpeg2video @ 0xb73814a8]ac-tex damaged at 1 65
> [mpeg2video @ 0xb73814a8]invalid mb type in P Frame at 45 65
> [mpeg2video @ 0xb73814a8]00 motion_type at 102 65
> [mpeg2video @ 0xb73814a8]00 motion_type at 5 66
> [mpeg2video @ 0xb73814a8]00 motion_type at 44 66
> [mpeg2video @ 0xb73814a8]00 motion_type at 83 66
> [mpeg2video @ 0xb73814a8]00 motion_type at 16 67
> [mpeg2video @ 0xb73814a8]invalid mb type in P Frame at 57 67
> [mpeg2video @ 0xb73814a8]mb incr damaged
> 2008-01-23 15:32:04.238 SM(2)::AddFlags: Seen(VCT,TVCT,) Match() Wait()
> 2008-01-23 15:32:04.242 DTVSM(2)::SetVCT(): tvct->ProgramNumber(idx 0): prog num 3 
> 2008-01-23 15:32:04.243 DTVSM(2)::SetProgramNumber(3):
> 2008-01-23 15:32:04.244 SM(2)::RemoveFlags: Seen(PMT,) Match(PMT,) Wait() 
> 2008-01-23 15:32:04.244 DVBRec(2): SetPAT(3 on 0x30) 
> 2008-01-23 15:32:04.245 SM(2)::AddFlags: Seen(PAT,) Match() Wait()
> 2008-01-23 15:32:04.245 SM(2)::AddFlags: Seen() Match(PAT,) Wait()
> 2008-01-23 15:32:04.246 CreatePATSingleProgram()
> 2008-01-23 15:32:04.247 PAT in input stream
> 2008-01-23 15:32:04.247 Program Association Table
>  PSIP tableID(0x0) length(21) extension(0x7d9)
>       version(4) current(1) section(0) last_section(0)
>          tsid: 2009
>  programCount: 3
>   program number 3 has PID 0x  30   data  0x0 0x3 0x224 0x48
>   program number 5 has PID 0x  50   data  0x0 0x5 0x224 0x80
>   program number 6 has PID 0x  60   data  0x0 0x6 0x224 0x96
>
> 2008-01-23 15:32:04.248 desired_program(3) pid(0x30)
> 2008-01-23 15:32:04.249 pmt_pid(0x30)

mythtv finds the desired program in the PAT
...

> 2008-01-23 15:32:04.250 SM(2)::AddFlags: Seen() Match() Wait(PMT,)
> 2008-01-23 15:32:04.251 SM(2)::AddFlags: Seen() Match(VCT,TVCT,) Wait()
> 2008-01-23 15:32:04.252 DVBSM(2)::AddPIDFilter(0x30): 
> 2008-01-23 15:32:04.302 DTVSM(2)::GetStatusList: WaitForPMT seen(0) matching(0)

mythtv starts listening on the announced PID for the PMT

> 2008-01-23 15:32:24.408 StopLiveTV(void) curRec: 0x820d260 pseudoRec: 0
> 2008-01-23 15:32:24.414 TVRec(3): Changing from WatchingLiveTV to None

but haven't received any in 20 seconds.

The cable provider doesn't seem to transmit a PMT
on the announced PID. I don't know where dvbscan gets the video and
audio from. running dvbsnoop on PID 0x0 and 0x30 might give further
hints.

Janne