[mythtv] Update on current DVB problems

Allan Stirling Dibblahmythml0015 at pendor.org
Sun Aug 28 11:16:37 UTC 2005 

Daniel Kristjansson wrote:
> On Sun, 2005-08-28 at 00:21 +0100, Allan Stirling wrote:
> 
>>I only see this PSIP issue on one multiplex (Not sure if it's a specific 
>>channel - For me, it's the first channel in my database - "mta-muslim 
>>tv" which is FTA on Astra 28.2 (11662 H SR 27500 FEC 2/3))
>>
>>However, my lock issue is consistent over all channels (still, with 
>>current SVN).
> 
> 
> Just give me the "-v channel,record" output from startup and including
> tuning to a channel other than the one with the broken PMT and I should
> be able to fix this.
> 
> -- Daniel
> 
Is this good enough? It's two seperate startups, since a bad channel 
tune seems to throw the frontend off enough that I can't change channel.

I'll just do one tuner, since both now seem identical:

Good channel:

2005-08-28 12:11:29.704 Using runtime prefix = /usr/local
2005-08-28 12:11:29.728 New DB connection, total: 1
Starting up as the master server.
2005-08-28 12:11:29.753 New DB connection, total: 2
2005-08-28 12:11:29.754 mythbackend: MythBackend started as master server
2005-08-28 12:11:29.785 DVB#0 Device Name: 'VLSI VES1x93 DVB-S'
2005-08-28 12:11:29.785 DVB#0 Opening DVB channel
2005-08-28 12:11:29.785 DVB#0 Using DVB card 0, with frontend VLSI 
VES1x93 DVB-S.
2005-08-28 12:11:30.092 DVB#0 Trying to tune to channel 10303.
2005-08-28 12:11:30.095 New DB connection, total: 3
2005-08-28 12:11:30.098 DVB#0 Frequency: 10788000 Symbol Rate: 22000000 
Pol: V/R Inv: Auto
2005-08-28 12:11:30.405 DVB#0 DiSEqC 1.0 Switch - Port 0
2005-08-28 12:11:30.422 DVB#0 DiSEqC Sending 1.0 Command: e0 10 38 f0
2005-08-28 12:11:30.510 DVB#0 Waiting for event
2005-08-28 12:11:30.510 DVB#0 Event Status() frequency(1038000 Hz)
2005-08-28 12:11:30.510 DVB#0 Waiting for frontend event after tune.
2005-08-28 12:11:30.510 DVB#0 Frequency tuning successful.
2005-08-28 12:11:30.510 DVB#0 Tuned to frequency for channel 10303.
2005-08-28 12:11:30.510 SetSignalMonitoringRate(50, 0)
2005-08-28 12:11:30.510 SetupSignalMonitor()
2005-08-28 12:11:30.511 DVB#0 Opening DVB channel
2005-08-28 12:11:30.511 SetupSignalMonitor() -- DVB hack begin
2005-08-28 12:11:30.511 SetupSignalMonitor() -- DVB hack end
2005-08-28 12:11:30.513 SM:    AddFlags: Seen() Match() 
Wait(Sig,SNR,BER,UB,)
2005-08-28 12:11:30.513 DVBSM(0)::constructor(): initial flags 0x7400000
2005-08-28 12:11:30.513 signal monitor successfully created
2005-08-28 12:11:30.513 Setting up table monitoring.
2005-08-28 12:11:30.513 Not ATSC channel: major(-1) minor(-1).
2005-08-28 12:11:30.513 mpeg program number: 10303
2005-08-28 12:11:30.514 DTVSM(0)::SetProgramNumber(10303):
2005-08-28 12:11:30.514 SM: RemoveFlags: Seen(PMT,) Match(PMT,) Wait()
2005-08-28 12:11:30.514 SM:    AddFlags: Seen() Match() Wait(PMT,)
2005-08-28 12:11:30.517 SM:    AddFlags: Seen() Match() Wait(PAT,PMT,)
2005-08-28 12:11:30.517 Successfully set up MPEG table monitoring.
2005-08-28 12:11:30.518 SM(0)::Start: begin
2005-08-28 12:11:30.519 SM(0)::Start: end
2005-08-28 12:11:30.519 DTVSM(0)::GetStatusList: WaitForPMT seen(0) 
matching(0)
2005-08-28 12:11:30.633 DVBSM(0)::UpdateValues(): Signal Lock
2005-08-28 12:11:30.640 DVBSM(0)::RunTableMonitor(): begin (# of pids 2)
2005-08-28 12:11:30.640 DVBSM(0)::AddPIDFilter(0x0):
2005-08-28 12:11:30.641 DVBSM(0)::AddPIDFilter(0x1ffb):
2005-08-28 12:11:30.748 SM:    AddFlags: Seen(PAT,) Match() Wait()
2005-08-28 12:11:30.748 SM:    AddFlags: Seen() Match(PAT,) Wait()
2005-08-28 12:11:30.748 CreatePATSingleProgram()
2005-08-28 12:11:30.748 PAT in input stream
2005-08-28 12:11:30.749 Program Association Table
  PSIP prefix(0x0) tableID(0x0) length(41) extension(0x7fe)
       version(17) current(1) section(0) last_section(0)
          tsid: 2046
  programCount: 8
   program number 0 has PID 0x  10   data  0x0 0x0 0x224 0x16
   program number 10301 has PID 0x 102   data  0x40 0x61 0x225 0x2
   program number 10302 has PID 0x 103   data  0x40 0x62 0x225 0x3
   program number 10303 has PID 0x 104   data  0x40 0x63 0x225 0x4
   program number 10304 has PID 0x 105   data  0x40 0x64 0x225 0x5
   program number 10305 has PID 0x 106   data  0x40 0x65 0x225 0x6
   program number 10306 has PID 0x 107   data  0x40 0x66 0x225 0x7
   program number 10321 has PID 0x 108   data  0x40 0x81 0x225 0x8

2005-08-28 12:11:30.749 desired_program(10303) pid(0x104)
2005-08-28 12:11:30.749 pmt_pid(0x104)
2005-08-28 12:11:30.749 PAT for output stream
2005-08-28 12:11:30.749 Program Association Table
  PSIP prefix(0x0) tableID(0x0) length(13) extension(0x7fe)
       version(17) current(1) section(0) last_section(0)
          tsid: 2046
  programCount: 1
   program number 1 has PID 0x 104   data  0x0 0x1 0x225 0x4

2005-08-28 12:11:30.750 DVBSM(0)::AddPIDFilter(0x104):
2005-08-28 12:11:30.807 SM:    AddFlags: Seen(PMT,) Match() Wait()
2005-08-28 12:11:30.807 SM:    AddFlags: Seen() Match(PMT,) Wait()
2005-08-28 12:11:30.807 CreatePMTSingleProgram()
2005-08-28 12:11:30.807 PMT in input stream
2005-08-28 12:11:30.807 Program Map Table ver(17) pid(0x104) pnum(10303)
      Unknown Descriptor (0xe) length(3)

  Stream #0 pid(0x910) type(video-mp2  0x2)
      Unknown Descriptor (0xe) length(3)
      Unknown Descriptor (0x6) length(1)
      Stream Identifier Descriptor (0x52) length(1)
      Unknown Descriptor (0xf) length(4)
      Unknown Descriptor (0xfe) length(4)
  Stream #1 pid(0x911) type(audio-mp1-layer[1,2,3]  0x3)
      Unknown Descriptor (0xe) length(3)
      ISO-639 Language Descriptor (0xa) length(4)
      Unknown Descriptor (0xf) length(4)
      Unknown Descriptor (0xfe) length(4)
      Stream Identifier Descriptor (0x52) length(1)
  Stream #2 pid(0x912) type(unknown  0x6)
      Unknown Descriptor (0xe) length(3)
      Teletext Descriptor (0x56) length(10)
      Unknown Descriptor (0xf) length(4)
      Unknown Descriptor (0xfe) length(4)
      Stream Identifier Descriptor (0x52) length(1)
  Stream #3 pid(0x903) type(unknown  0x5)
      Unknown Descriptor (0xe) length(3)
      Stream Identifier Descriptor (0x52) length(1)
      Unknown Descriptor (0xf) length(4)
      Unknown Descriptor (0x90) length(1)
      Unknown Descriptor (0xfe) length(4)
  Stream #4 pid(0x905) type(unknown  0x5)
      Unknown Descriptor (0xe) length(3)
      Stream Identifier Descriptor (0x52) length(1)
      Unknown Descriptor (0xf) length(4)
      Unknown Descriptor (0x90) length(1)
      Unknown Descriptor (0xfe) length(4)
  Stream #5 pid(0x906) type(unknown  0x5)
      Unknown Descriptor (0xe) length(3)
      Stream Identifier Descriptor (0x52) length(1)
      Unknown Descriptor (0xf) length(4)
      Unknown Descriptor (0x90) length(1)
      Unknown Descriptor (0xfe) length(4)
  Stream #6 pid(0x907) type(unknown  0x5)
      Unknown Descriptor (0xe) length(3)
      Stream Identifier Descriptor (0x52) length(1)
      Unknown Descriptor (0xf) length(4)
      Unknown Descriptor (0x90) length(1)
      Unknown Descriptor (0xfe) length(4)
  Stream #7 pid(0x90a) type(unknown  0x5)
      Unknown Descriptor (0xe) length(3)
      Stream Identifier Descriptor (0x52) length(1)
      Unknown Descriptor (0xf) length(4)
      Unknown Descriptor (0x90) length(1)
      Unknown Descriptor (0xfe) length(4)
  Stream #8 pid(0x90b) type(unknown  0x5)
      Unknown Descriptor (0xe) length(3)
      Stream Identifier Descriptor (0x52) length(1)
      Unknown Descriptor (0xf) length(4)
      Unknown Descriptor (0x90) length(1)
      Unknown Descriptor (0xfe) length(4)
  Stream #9 pid(0x90c) type(unknown  0x5)
      Unknown Descriptor (0xe) length(3)
      Stream Identifier Descriptor (0x52) length(1)
      Unknown Descriptor (0xf) length(4)
      Unknown Descriptor (0x90) length(1)
      Unknown Descriptor (0xfe) length(4)

2005-08-28 12:11:30.809 PMT for output stream
2005-08-28 12:11:30.809 Program Map Table ver(17) pid(0x104) pnum(1)

  Stream #0 pid(0x910) type(video-mp2  0x2)
  Stream #1 pid(0x911) type(audio-mp1-layer[1,2,3]  0x3)

2005-08-28 12:11:30.828 DTVSM(0)::GetStatusList: WaitForPMT seen(1) 
matching(1)
2005-08-28 12:11:30.828 SetSignalMonitoringRate(0, 0)
2005-08-28 12:11:30.828 TeardownSignalMonitor() -- begin
2005-08-28 12:11:30.829 DVBSM(0)::Stop: begin
2005-08-28 12:11:30.829 SM(0)::Stop: begin
2005-08-28 12:11:30.842 SM(0)::Stop: end
2005-08-28 12:11:30.843 DVBSM(0)::RunTableMonitor(): shutdown
2005-08-28 12:11:30.843 DVBSM(0)::RemovePIDFilter(0x0):
2005-08-28 12:11:30.843 DVBSM(0)::RemovePIDFilter(0x104):
2005-08-28 12:11:30.844 DVBSM(0)::RemovePIDFilter(0x1ffb):
2005-08-28 12:11:30.844 DVBSM(0)::RunTableMonitor(): end
2005-08-28 12:11:30.844 DVBSM(0)::Stop: end
2005-08-28 12:11:30.845 DVBSM(0)::Stop: begin
2005-08-28 12:11:30.845 SM(0)::Stop: begin
2005-08-28 12:11:30.845 SM(0)::Stop: end
2005-08-28 12:11:30.845 DVBSM(0)::Stop: end
2005-08-28 12:11:30.845 SM(0)::Stop: begin
2005-08-28 12:11:30.845 SM(0)::Stop: end
2005-08-28 12:11:30.845 TeardownSignalMonitor() -- end


Bad channel:
2005-08-28 12:13:19.001 New DB connection, total: 2
2005-08-28 12:13:19.003 mythbackend: MythBackend started as master server
2005-08-28 12:13:19.026 DVB#0 Device Name: 'VLSI VES1x93 DVB-S'
2005-08-28 12:13:19.027 DVB#0 Opening DVB channel
2005-08-28 12:13:19.027 DVB#0 Using DVB card 0, with frontend VLSI 
VES1x93 DVB-S.
2005-08-28 12:13:19.335 DVB#0 Trying to tune to channel 51001.
2005-08-28 12:13:19.338 New DB connection, total: 3
2005-08-28 12:13:19.360 DVB#0 Frequency: 11661540 Symbol Rate: 27500000 
Pol: H/L Inv: Auto
2005-08-28 12:13:19.667 DVB#0 DiSEqC 1.0 Switch - Port 0
2005-08-28 12:13:19.684 DVB#0 DiSEqC Sending 1.0 Command: e0 10 38 f2
2005-08-28 12:13:19.772 DVB#0 Waiting for event
2005-08-28 12:13:19.772 DVB#0 Event Status() frequency(1911540 Hz)
2005-08-28 12:13:19.772 DVB#0 Waiting for frontend event after tune.
2005-08-28 12:13:19.772 DVB#0 Frequency tuning successful.
2005-08-28 12:13:19.773 DVB#0 Tuned to frequency for channel 51001.
2005-08-28 12:13:19.773 SetSignalMonitoringRate(50, 0)
2005-08-28 12:13:19.773 SetupSignalMonitor()
2005-08-28 12:13:19.773 DVB#0 Opening DVB channel
2005-08-28 12:13:19.773 SetupSignalMonitor() -- DVB hack begin
2005-08-28 12:13:19.773 SetupSignalMonitor() -- DVB hack end
2005-08-28 12:13:19.775 SM:    AddFlags: Seen() Match() 
Wait(Sig,SNR,BER,UB,)
2005-08-28 12:13:19.775 DVBSM(0)::constructor(): initial flags 0x7400000
2005-08-28 12:13:19.775 signal monitor successfully created
2005-08-28 12:13:19.775 Setting up table monitoring.
2005-08-28 12:13:19.775 Not ATSC channel: major(-1) minor(-1).
2005-08-28 12:13:19.775 mpeg program number: 51001
2005-08-28 12:13:19.776 DTVSM(0)::SetProgramNumber(51001):
2005-08-28 12:13:19.776 SM: RemoveFlags: Seen(PMT,) Match(PMT,) Wait()
2005-08-28 12:13:19.776 SM:    AddFlags: Seen() Match() Wait(PMT,)
2005-08-28 12:13:19.780 SM:    AddFlags: Seen() Match() Wait(PAT,PMT,)
2005-08-28 12:13:19.780 Successfully set up MPEG table monitoring.
2005-08-28 12:13:19.780 SM(0)::Start: begin
2005-08-28 12:13:19.781 SM(0)::Start: end
2005-08-28 12:13:19.781 DTVSM(0)::GetStatusList: WaitForPMT seen(0) 
matching(0)
2005-08-28 12:13:19.895 DVBSM(0)::UpdateValues(): Signal Lock
2005-08-28 12:13:19.902 DVBSM(0)::RunTableMonitor(): begin (# of pids 2)
2005-08-28 12:13:19.903 DVBSM(0)::AddPIDFilter(0x0):
2005-08-28 12:13:19.904 DVBSM(0)::AddPIDFilter(0x1ffb):
2005-08-28 12:13:19.985 SM:    AddFlags: Seen(PAT,) Match() Wait()
2005-08-28 12:13:19.986 SM:    AddFlags: Seen() Match(PAT,) Wait()
2005-08-28 12:13:19.986 CreatePATSingleProgram()
2005-08-28 12:13:19.986 PAT in input stream
2005-08-28 12:13:19.986 Program Association Table
  PSIP prefix(0x0) tableID(0x0) length(53) extension(0x96b)
       version(18) current(1) section(0) last_section(0)
          tsid: 2411
  programCount: 11
   program number 0 has PID 0x  10   data  0x0 0x0 0x224 0x16
   program number 51001 has PID 0x 104   data  0x199 0x57 0x225 0x4
   program number 51006 has PID 0x 103   data  0x199 0x62 0x225 0x3
   program number 51008 has PID 0x 107   data  0x199 0x64 0x225 0x7
   program number 51009 has PID 0x 108   data  0x199 0x65 0x225 0x8
   program number 51010 has PID 0x 100   data  0x199 0x66 0x225 0x0
   program number 51011 has PID 0x 10c   data  0x199 0x67 0x225 0x12
   program number 51014 has PID 0x 106   data  0x199 0x70 0x225 0x6
   program number 51019 has PID 0x 101   data  0x199 0x75 0x225 0x1
   program number 51020 has PID 0x 109   data  0x199 0x76 0x225 0x9
   program number 51022 has PID 0x 10b   data  0x199 0x78 0x225 0x11

2005-08-28 12:13:19.988 desired_program(51001) pid(0x104)
2005-08-28 12:13:19.989 pmt_pid(0x104)
2005-08-28 12:13:19.989 PAT for output stream
2005-08-28 12:13:19.989 Program Association Table
  PSIP prefix(0x0) tableID(0x0) length(13) extension(0x96b)
       version(18) current(1) section(0) last_section(0)
          tsid: 2411
  programCount: 1
   program number 1 has PID 0x 104   data  0x0 0x1 0x225 0x4

2005-08-28 12:13:19.990 DVBSM(0)::AddPIDFilter(0x104):
2005-08-28 12:13:20.001 PSIP packet failed CRC check. pid(0x104) type(0x2)

...
2005-08-28 12:13:22.767 PSIP packet failed CRC check. pid(0x104) type(0x2)
2005-08-28 12:13:22.796 SigMon Flags are: Seen(PAT,) Match(PAT,) 
Wait(PAT,PMT,Sig,SNR,BER,UB,)
2005-08-28 12:13:22.796 SML[0]: Name(slock) Val(1) thr(>=1) range(0,1) 
timeout(3000 ms) is set
2005-08-28 12:13:22.796 SML[1]: Name(signal) Val(31611) thr(>=0) 
range(0,65535) timeout(3000 ms) is set
2005-08-28 12:13:22.796 SML[2]: Name(seen_pat) Val(1) thr(>=1) 
range(0,1) timeout(0 ms) is set
2005-08-28 12:13:22.796 SML[3]: Name(matching_pat) Val(1) thr(>=1) 
range(0,1) timeout(0 ms) is set
2005-08-28 12:13:22.797 SML[4]: Name(seen_pmt) Val(0) thr(>=1) 
range(0,1) timeout(0 ms) is set
2005-08-28 12:13:22.797 SML[5]: Name(matching_pmt) Val(0) thr(>=1) 
range(0,1) timeout(0 ms) is set
2005-08-28 12:13:22.797 SML[6]: Name(snr) Val(51400) thr(>=-32768) 
range(-32768,32767) timeout(0 ms) is set
2005-08-28 12:13:22.797 SML[7]: Name(ber) Val(1656720) thr(<=6553500) 
range(0,6553500) timeout(0 ms) is set
2005-08-28 12:13:22.797 SML[8]: Name(ucb) Val(-1) thr(<=65535) 
range(0,65535) timeout(0 ms) is set
2005-08-28 12:13:22.797 TVRec: Timed out waiting for lock -- aborting 
recording
2005-08-28 12:13:22.797 SetSignalMonitoringRate(0, 0)
2005-08-28 12:13:22.797 TeardownSignalMonitor() -- begin
2005-08-28 12:13:22.797 DVBSM(0)::Stop: begin
2005-08-28 12:13:22.797 SM(0)::Stop: begin
2005-08-28 12:13:22.808 SM(0)::Stop: end
2005-08-28 12:13:22.809 DVBSM(0)::RunTableMonitor(): shutdown
2005-08-28 12:13:22.809 DVBSM(0)::RemovePIDFilter(0x0):
2005-08-28 12:13:22.809 DVBSM(0)::RemovePIDFilter(0x104):
2005-08-28 12:13:22.810 DVBSM(0)::RemovePIDFilter(0x1ffb):
2005-08-28 12:13:22.810 DVBSM(0)::RunTableMonitor(): end
2005-08-28 12:13:22.810 DVBSM(0)::Stop: end
2005-08-28 12:13:22.811 DVBSM(0)::Stop: begin
2005-08-28 12:13:22.811 SM(0)::Stop: begin
2005-08-28 12:13:22.811 SM(0)::Stop: end
2005-08-28 12:13:22.811 DVBSM(0)::Stop: end
2005-08-28 12:13:22.811 SM(0)::Stop: begin
2005-08-28 12:13:22.811 SM(0)::Stop: end
2005-08-28 12:13:22.811 TeardownSignalMonitor() -- end

More information about the mythtv-dev mailing list