[mythtv-users] Active EIT scan get "stuck"

Tue Apr 30 15:12:21 UTC 2013

I'm having problems with my EIT program guide not filling up, leaving a lot
of empty timeslots in the EPG.
I using dvb-s and I have 88 multiplexes and a total of three tuner cards,
all with active EIT enabled.

When I have started to look into it I notice that there may be some very
long periods (many hours) without any "StartActiveScan called with 64
multiplexes" logged to the backend log. I'm wondering if the active eit
scanner may be stuck on a channel and unable to jump to the next multiplex?

Have a look at the following snippet. After this "StartActiveScan" there
has not been any EIT activity for 8 hours! I guess this has to be a bug?

2013-04-30 09:33:59.708448 I [17317/17341] TVRecEvent eitscanner.cpp:269
(StartActiveScan) - EITScanner (4): StartActiveScan called with 64
multiplexes
2013-04-30 09:34:00.225062 I [17317/17342] EIT tv_rec.cpp:3113
(QueueEITChannelChange) - TVRec(4): QueueEITChannelChange(50310) -- begin
2013-04-30 09:34:00.225077 I [17317/17342] EIT tv_rec.cpp:3131
(QueueEITChannelChange) - TVRec(4): QueueEITChannelChange(50310) -- end -->
1
2013-04-30 09:34:00.225084 I [17317/17342] EIT eitscanner.cpp:141 (run) -
EITScanner (4): Now looking for EIT data on multiplex of channel 50310
2013-04-30 09:34:00.225124 I [17317/17342] EIT eitcache.cpp:386
(PruneOldEntries) - EITCache: Pruning all entries that ended before UTC
2013-04-29T07:39:20Z
2013-04-30 09:34:00.378386 I [17317/17342] EIT eitcache.cpp:112
(delete_in_db) - EITCache: Deleting old cache entries from the database
2013-04-30 09:34:00.865726 I [17317/17341] TVRecEvent dvbchannel.cpp:175
(Open) - DVBChan(4:/dev/dvb/adapter4/frontend0): Opening DVB channel
2013-04-30 09:34:00.865740 I [17317/17341] TVRecEvent dtvchannel.cpp:181
(SetChannelByString) - DTVChan(/dev/dvb/adapter4/frontend0):
SetChannelByString(50310):
2013-04-30 09:34:00.867339 I [17317/17341] TVRecEvent dvbchannel.cpp:392
(CheckOptions) - DVBChan(4:/dev/dvb/adapter4/frontend0): 11526920 qpsk a
auto auto a a auto a v fec: 2/3 msys: DVB-S rolloff: 0.35
2013-04-30 09:34:00.868498 I [17317/17341] TVRecEvent diseqc.cpp:738
(SetVoltage) - DiSEqCDevTree: Changing LNB voltage to 13V
2013-04-30 09:34:01.071014 I [17317/17341] TVRecEvent diseqc.cpp:1592
(ExecuteDiseqc) - DiSEqCDevTree: Changing to DiSEqC switch port 4/4
2013-04-30 09:34:01.071029 I [17317/17341] TVRecEvent diseqc.cpp:662
(SendCommand) - DiSEqCDevTree: Sending DiSEqC Command: e0 10 38 fc
2013-04-30 09:34:01.628317 I [17317/17341] TVRecEvent dvbchannel.cpp:725
(Tune) - DVBChan(4:/dev/dvb/adapter4/frontend0): Old Params: 10964250 qpsk
a auto auto a a auto a h fec: 5/6 msys: DVB-S rolloff: 0.35
            DVBChan(4:/dev/dvb/adapter4/frontend0): New Params: 11526920
qpsk a auto auto a a auto a v fec: 2/3 msys: DVB-S rolloff: 0.35
2013-04-30 09:34:01.628330 I [17317/17341] TVRecEvent dvbchannel.cpp:737
(Tune) - DVBChan(4:/dev/dvb/adapter4/frontend0): Tune(): Tuning to
1776920kHz
2013-04-30 09:34:01.691452 I [17317/17341] TVRecEvent dvbchannel.cpp:1224
(wait_for_backend) - DVBChan: wait_for_backend: Status: Signal,Carrier,FEC
Stable,Sync,Lock,
2013-04-30 09:34:01.691466 I [17317/17341] TVRecEvent dvbchannel.cpp:814
(Tune) - DVBChan(4:/dev/dvb/adapter4/frontend0): Tune(): Frequency tuning
successful.
2013-04-30 09:34:01.691472 I [17317/17341] TVRecEvent dtvchannel.cpp:332
(SetChannelByString) - DTVChan(/dev/dvb/adapter4/frontend0):
SetChannelByString(50310): success
2013-04-30 09:34:01.691485 I [17317/17341] TVRecEvent dvbchannel.cpp:175
(Open) - DVBChan(4:/dev/dvb/adapter4/frontend0): Opening DVB channel
2013-04-30 09:34:01.699329 I [17317/17341] TVRecEvent
dvbsignalmonitor.cpp:86 (DVBSignalMonitor) -
DVBSM(/dev/dvb/adapter4/frontend0): Can measure Signal Strength
2013-04-30 09:34:01.700912 I [17317/17341] TVRecEvent
dvbsignalmonitor.cpp:88 (DVBSignalMonitor) -
DVBSM(/dev/dvb/adapter4/frontend0): Can measure S/N
2013-04-30 09:34:01.709488 I [17317/17341] TVRecEvent
dvbsignalmonitor.cpp:90 (DVBSignalMonitor) -
DVBSM(/dev/dvb/adapter4/frontend0): Can measure Bit Error Rate
2013-04-30 09:34:01.716303 I [17317/17341] TVRecEvent
dvbsignalmonitor.cpp:92 (DVBSignalMonitor) -
DVBSM(/dev/dvb/adapter4/frontend0): Can count Uncorrected Blocks
2013-04-30 09:34:01.716319 I [17317/17341] TVRecEvent
dvbsignalmonitor.cpp:99 (DVBSignalMonitor) -
DVBSM(/dev/dvb/adapter4/frontend0): DVBSignalMonitor::ctor initial flags
Seen() Match() Wait(Sig,SNR,BER,UB,)
2013-04-30 09:34:01.718020 I [17317/17341] TVRecEvent
dtvsignalmonitor.cpp:237 (SetDVBService) -
DTVSM(/dev/dvb/adapter4/frontend0)::SetDVBService(transport_id: 2404,
network_id: 2, service_id: 50310):
2013-04-30 09:34:01.742664 I [17317/29809] SignalMonitor
dvbsignalmonitor.cpp:299 (UpdateValues) -
DVBSM(/dev/dvb/adapter4/frontend0): UpdateValues -- Signal Locked
2013-04-30 09:34:01.802988 E [17317/29810] DVBRead dtvsignalmonitor.cpp:321
(HandlePAT) - DTVSM(/dev/dvb/adapter4/frontend0): Program #50310 not found
in PAT!
Program Association Section
 PSIP tableID(0x0) length(33) extension(0x964)
      version(24) current(1) section(0) last_section(0)
      tsid(2404) programCount(6)
  program number 50325 has PID 0x0112
  program number 50345 has PID 0x0103
  program number 50350 has PID 0x0100
  program number 50360 has PID 0x0113
  program number 50361 has PID 0x0114
  program number 50365 has PID 0x011a

2013-04-30 09:34:02.218834 E [17317/29810] DVBRead
mpeg/mpegstreamdata.cpp:817 (ProcessPAT) - ProcessPAT: Program not found in
PAT. Rescan your transports.
2013-04-30 09:34:02.218850 E [17317/29810] DVBRead
mpeg/mpegstreamdata.cpp:423 (CreatePATSingleProgram) - Desired program
#50310 not found in PAT.
            Cannot create single program PAT.
2013-04-30 09:34:03.307066 I [17317/29810] DVBRead dtvsignalmonitor.cpp:494
(HandleSDT) - DTVSM(/dev/dvb/adapter4/frontend0)::SetSDT(): tsid = 2404
orig_net_id = 2
2013-04-30 09:34:05.209941 I [17317/29810] DVBRead dtvsignalmonitor.cpp:474
(HandleNIT) - DTVSM(/dev/dvb/adapter4/frontend0)::SetNIT(): net_id = 32
2013-04-30 09:34:12.183270 I [17317/29810] DVBRead dtvsignalmonitor.cpp:474
(HandleNIT) - DTVSM(/dev/dvb/adapter4/frontend0)::SetNIT(): net_id = 32
2013-04-30 09:35:17.091391 N [17317/17355] Expire autoexpire.cpp:264
(CalcParams) - AutoExpire: CalcParams(): Max required Free Space: 1.0 GB
w/freq: 15 min
2013-04-30 09:36:02.891632 I [17317/17341] TVRecEvent
dvbsignalmonitor.cpp:146 (Stop) - DVBSM(/dev/dvb/adapter4/frontend0):
Stop() -- begin
2013-04-30 09:36:03.124179 I [17317/17341] TVRecEvent
dvbsignalmonitor.cpp:152 (Stop) - DVBSM(/dev/dvb/adapter4/frontend0):
Stop() -- end
2013-04-30 09:36:03.124974 I [17317/17341] TVRecEvent eitscanner.cpp:210
(StartPassiveScan) - EITScanner (4): Started passive scan.

-- 
Jarle Thorsen
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://www.mythtv.org/pipermail/mythtv-users/attachments/20130430/0453ad8d/attachment.html>