Opened 2 years ago

Closed 2 years ago

#13002 closed Bug Report - General (Fixed)

Failure to tune to channel following commit 36e946d mpeg ts stream

Reported by: mike.bibbings@… Owned by: Stuart Auchterlonie
Priority: major Milestone: 29.0
Component: MythTV - DVB Version: Master Head
Severity: medium Keywords:
Cc: Ticket locked: no

Description

Attempting to tune to channel BBC One East on a networked tuner Vboxcomm XTI 3340 results in no lock and hence failure to watch live tv. Note tuning to other channels within the same multiplex works.At commit e12b855 everything works, at commit 36e946d Fixes #11098 - Rework table section accounting to remove code duplication.

Attached are mythbackend logs for tuning at e12b855 (works) and 36e946d (fails) together with mythbackend version information.It is possible that other channels do not tune, not checked there are 119 of them!

Attachments (4)

mythbackend_e12b855.log (260.5 KB) - added by mike.bibbings@… 2 years ago.
mythbackend_36e946d.log (408.1 KB) - added by mike.bibbings@… 2 years ago.
mythbackend_version_e12b855.txt (1.0 KB) - added by mike.bibbings@… 2 years ago.
mythbackend_version_36e946d.txt (1.0 KB) - added by mike.bibbings@… 2 years ago.

Download all attachments as: .zip

Change History (13)

Changed 2 years ago by mike.bibbings@…

Attachment: mythbackend_e12b855.log added

Changed 2 years ago by mike.bibbings@…

Attachment: mythbackend_36e946d.log added

Changed 2 years ago by mike.bibbings@…

Changed 2 years ago by mike.bibbings@…

comment:1 Changed 2 years ago by Stuart Auchterlonie

Milestone: unknown29.0
Owner: set to Stuart Auchterlonie
Status: newaccepted

comment:2 Changed 2 years ago by Stuart Auchterlonie

So it certainly looks like it starts streaming successfully, yet for some reason it thinks it's failed to get a lock

237	Feb 21 10:58:08 mike-Aspire-V3-571 mythbackend: mythbackend[21621]: I StreamHandler recorders/iptvsignalmonitor.cpp:71 (HandlePAT) IPTVSigMon[1](http://192.168.0.32:55555/BBC ONE East W): HandlePAT pn: 4173
238	Feb 21 10:58:08 mike-Aspire-V3-571 mythbackend: mythbackend[21621]: D StreamHandler recorders/signalmonitor.cpp:248 (AddFlags) SigMon[1](http://192.168.0.32:55555/BBC ONE East W)::AddFlags: Seen(PAT,) Match() Wait()
239	Feb 21 10:58:08 mike-Aspire-V3-571 mythbackend: mythbackend[21621]: D StreamHandler recorders/signalmonitor.cpp:248 (AddFlags) SigMon[1](http://192.168.0.32:55555/BBC ONE East W)::AddFlags: Seen() Match(PAT,) Wait()
240	Feb 21 10:58:08 mike-Aspire-V3-571 mythbackend: mythbackend[21621]: D StreamHandler mpeg/mpegstreamdata.cpp:376 (CreatePATSingleProgram) MPEGStream[1](0x7f0a18014b90): CreatePATSingleProgram()
241	Feb 21 10:58:08 mike-Aspire-V3-571 mythbackend: mythbackend[21621]: D StreamHandler mpeg/mpegstreamdata.cpp:377 (CreatePATSingleProgram) MPEGStream[1](0x7f0a18014b90): PAT in input stream
242	Feb 21 10:58:08 mike-Aspire-V3-571 mythbackend: mythbackend[21621]: D StreamHandler mpeg/mpegstreamdata.cpp:378 (CreatePATSingleProgram) MPEGStream[1](0x7f0a18014b90): Program Association Section#012 PSIP tableID(0x0) length(13) extension(0x104d)#012      version(0) current(1) section(0) last_section(0)#012      tsid(4173) programCount(1)#012  program number  4173 has PID 0x0064
243	Feb 21 10:58:08 mike-Aspire-V3-571 mythbackend: mythbackend[21621]: D StreamHandler mpeg/mpegstreamdata.cpp:386 (CreatePATSingleProgram) MPEGStream[1](0x7f0a18014b90): desired_program(4173) pid(0x64)
244	Feb 21 10:58:08 mike-Aspire-V3-571 mythbackend: mythbackend[21621]: D StreamHandler mpeg/mpegstreamdata.cpp:427 (CreatePATSingleProgram) MPEGStream[1](0x7f0a18014b90): pmt_pid(0x64)
245	Feb 21 10:58:08 mike-Aspire-V3-571 mythbackend: mythbackend[21621]: D StreamHandler mpeg/mpegstreamdata.cpp:428 (CreatePATSingleProgram) MPEGStream[1](0x7f0a18014b90): PAT for output stream
246	Feb 21 10:58:08 mike-Aspire-V3-571 mythbackend: mythbackend[21621]: D StreamHandler mpeg/mpegstreamdata.cpp:429 (CreatePATSingleProgram) MPEGStream[1](0x7f0a18014b90): Program Association Section#012 PSIP tableID(0x0) length(13) extension(0x104d)#012      version(0) current(1) section(0) last_section(0)#012      tsid(4173) programCount(1)#012  program number     1 has PID 0x0064
247	Feb 21 10:58:08 mike-Aspire-V3-571 mythbackend: mythbackend[21621]: D StreamHandler recorders/httptsstreamhandler.cpp:220 (WriteBytes) HTTPReader(http://192.168.0.32:55555/BBC ONE East W): WriteBytes: 184/13156 bytes remain
248	Feb 21 10:58:08 mike-Aspire-V3-571 mythbackend: mythbackend[21621]: D StreamHandler recorders/httptsstreamhandler.cpp:201 (ReadBytes) HTTPReader(http://192.168.0.32:55555/BBC ONE East W): ReadBytes: 1448 bytes received
....
626	Feb 21 10:58:11 mike-Aspire-V3-571 mythbackend: mythbackend[21621]: D StreamHandler recorders/httptsstreamhandler.cpp:201 (ReadBytes) HTTPReader(http://192.168.0.32:55555/BBC ONE East W): ReadBytes: 11960 bytes received
627	Feb 21 10:58:11 mike-Aspire-V3-571 mythbackend: mythbackend[21621]: D StreamHandler recorders/httptsstreamhandler.cpp:220 (WriteBytes) HTTPReader(http://192.168.0.32:55555/BBC ONE East W): WriteBytes: 52/12084 bytes remain
628	Feb 21 10:58:11 mike-Aspire-V3-571 mythbackend: mythbackend[21621]: W TVRecEvent tv_rec.cpp:4006 (TuningSignalCheck) TVRec[1]: TuningSignalCheck: taking more than 3000 ms to get a lock. marking this recording as 'Failing'.
629	Feb 21 10:58:11 mike-Aspire-V3-571 mythbackend: mythbackend[21621]: W TVRecEvent tv_rec.cpp:4008 (TuningSignalCheck) TVRec[1]: See 'Tuning timeout' in mythtv-setup for this input
630	Feb 21 10:58:11 mike-Aspire-V3-571 mythbackend: mythbackend[21621]: I TVRecEvent tv_rec.cpp:717 (SetRecordingStatus) TVRec[1]: SetRecordingStatus(Unknown->Failing) on line 4025

comment:3 Changed 2 years ago by mike.bibbings@…

Yes, it does stream, but as mythbackend is not detecting lock it fails.

comment:4 Changed 2 years ago by Stuart Auchterlonie

Noticed something here, when it's failing it's not setting the flag to say it's seen the PMT. Compare the following.

Working:

240	Feb 21 10:42:30 mike-Aspire-V3-571 mythbackend: mythbackend[3675]: D StreamHandler recorders/signalmonitor.cpp:248 (AddFlags) SigMon[1](http://192.168.0.32:55555/BBC ONE East W)::AddFlags: Seen(PAT,) Match() Wait()
241	Feb 21 10:42:30 mike-Aspire-V3-571 mythbackend: mythbackend[3675]: D StreamHandler recorders/signalmonitor.cpp:248 (AddFlags) SigMon[1](http://192.168.0.32:55555/BBC ONE East W)::AddFlags: Seen() Match(PAT,) Wait()
242	Feb 21 10:42:30 mike-Aspire-V3-571 mythbackend: mythbackend[3675]: D StreamHandler mpeg/mpegstreamdata.cpp:406 (CreatePATSingleProgram) MPEGStream[1](0x7fc31c035010): CreatePATSingleProgram()
243	Feb 21 10:42:30 mike-Aspire-V3-571 mythbackend: mythbackend[3675]: D StreamHandler mpeg/mpegstreamdata.cpp:407 (CreatePATSingleProgram) MPEGStream[1](0x7fc31c035010): PAT in input stream
244	Feb 21 10:42:30 mike-Aspire-V3-571 mythbackend: mythbackend[3675]: D StreamHandler mpeg/mpegstreamdata.cpp:408 (CreatePATSingleProgram) MPEGStream[1](0x7fc31c035010): Program Association Section#012 PSIP tableID(0x0) length(13) extension(0x104d)#012      version(0) current(1) section(0) last_section(0)#012      tsid(4173) programCount(1)#012  program number  4173 has PID 0x0064
245	Feb 21 10:42:30 mike-Aspire-V3-571 mythbackend: mythbackend[3675]: D StreamHandler mpeg/mpegstreamdata.cpp:416 (CreatePATSingleProgram) MPEGStream[1](0x7fc31c035010): desired_program(4173) pid(0x64)
246	Feb 21 10:42:30 mike-Aspire-V3-571 mythbackend: mythbackend[3675]: D StreamHandler mpeg/mpegstreamdata.cpp:457 (CreatePATSingleProgram) MPEGStream[1](0x7fc31c035010): pmt_pid(0x64)
247	Feb 21 10:42:30 mike-Aspire-V3-571 mythbackend: mythbackend[3675]: D StreamHandler mpeg/mpegstreamdata.cpp:458 (CreatePATSingleProgram) MPEGStream[1](0x7fc31c035010): PAT for output stream
248	Feb 21 10:42:30 mike-Aspire-V3-571 mythbackend: mythbackend[3675]: D StreamHandler mpeg/mpegstreamdata.cpp:459 (CreatePATSingleProgram) MPEGStream[1](0x7fc31c035010): Program Association Section#012 PSIP tableID(0x0) length(13) extension(0x104d)#012      version(0) current(1) section(0) last_section(0)#012      tsid(4173) programCount(1)#012  program number     1 has PID 0x0064
249	Feb 21 10:42:30 mike-Aspire-V3-571 mythbackend: mythbackend[3675]: D StreamHandler recorders/signalmonitor.cpp:248 (AddFlags) SigMon[1](http://192.168.0.32:55555/BBC ONE East W)::AddFlags: Seen(PMT,) Match() Wait()
250	Feb 21 10:42:30 mike-Aspire-V3-571 mythbackend: mythbackend[3675]: D StreamHandler recorders/signalmonitor.cpp:248 (AddFlags) SigMon[1](http://192.168.0.32:55555/BBC ONE East W)::AddFlags: Seen() Match(PMT,) Wait()

Not working:

238	Feb 21 10:58:08 mike-Aspire-V3-571 mythbackend: mythbackend[21621]: D StreamHandler recorders/signalmonitor.cpp:248 (AddFlags) SigMon[1](http://192.168.0.32:55555/BBC ONE East W)::AddFlags: Seen(PAT,) Match() Wait()
239	Feb 21 10:58:08 mike-Aspire-V3-571 mythbackend: mythbackend[21621]: D StreamHandler recorders/signalmonitor.cpp:248 (AddFlags) SigMon[1](http://192.168.0.32:55555/BBC ONE East W)::AddFlags: Seen() Match(PAT,) Wait()
240	Feb 21 10:58:08 mike-Aspire-V3-571 mythbackend: mythbackend[21621]: D StreamHandler mpeg/mpegstreamdata.cpp:376 (CreatePATSingleProgram) MPEGStream[1](0x7f0a18014b90): CreatePATSingleProgram()
241	Feb 21 10:58:08 mike-Aspire-V3-571 mythbackend: mythbackend[21621]: D StreamHandler mpeg/mpegstreamdata.cpp:377 (CreatePATSingleProgram) MPEGStream[1](0x7f0a18014b90): PAT in input stream
242	Feb 21 10:58:08 mike-Aspire-V3-571 mythbackend: mythbackend[21621]: D StreamHandler mpeg/mpegstreamdata.cpp:378 (CreatePATSingleProgram) MPEGStream[1](0x7f0a18014b90): Program Association Section#012 PSIP tableID(0x0) length(13) extension(0x104d)#012      version(0) current(1) section(0) last_section(0)#012      tsid(4173) programCount(1)#012  program number  4173 has PID 0x0064
243	Feb 21 10:58:08 mike-Aspire-V3-571 mythbackend: mythbackend[21621]: D StreamHandler mpeg/mpegstreamdata.cpp:386 (CreatePATSingleProgram) MPEGStream[1](0x7f0a18014b90): desired_program(4173) pid(0x64)
244	Feb 21 10:58:08 mike-Aspire-V3-571 mythbackend: mythbackend[21621]: D StreamHandler mpeg/mpegstreamdata.cpp:427 (CreatePATSingleProgram) MPEGStream[1](0x7f0a18014b90): pmt_pid(0x64)
245	Feb 21 10:58:08 mike-Aspire-V3-571 mythbackend: mythbackend[21621]: D StreamHandler mpeg/mpegstreamdata.cpp:428 (CreatePATSingleProgram) MPEGStream[1](0x7f0a18014b90): PAT for output stream
246	Feb 21 10:58:08 mike-Aspire-V3-571 mythbackend: mythbackend[21621]: D StreamHandler mpeg/mpegstreamdata.cpp:429 (CreatePATSingleProgram) MPEGStream[1](0x7f0a18014b90): Program Association Section#012 PSIP tableID(0x0) length(13) extension(0x104d)#012      version(0) current(1) section(0) last_section(0)#012      tsid(4173) programCount(1)#012  program number     1 has PID 0x0064
247	Feb 21 10:58:08 mike-Aspire-V3-571 mythbackend: mythbackend[21621]: D StreamHandler recorders/httptsstreamhandler.cpp:220 (WriteBytes) HTTPReader(http://192.168.0.32:55555/BBC ONE East W): WriteBytes: 184/13156 bytes remain
248	Feb 21 10:58:08 mike-Aspire-V3-571 mythbackend: mythbackend[21621]: D StreamHandler recorders/httptsstreamhandler.cpp:201 (ReadBytes) HTTPReader(http://192.168.0.32:55555/BBC ONE East W): ReadBytes: 1448 bytes received
....

As you can see, after it creates the output PAT, it then doesn't find the PMT, whilst it does when it works...

comment:5 Changed 2 years ago by mike.bibbings@…

I have done done some more testing.

Tuning to the same channel (BBC One East..) via DVB-T tuner (TBS 6280 PCI-e card) works correctly. Tuning to BBC Four (currently off air as transmission does not start till 19:00 UK time) also works fine i.e. it locks.

Tuning to BBC Four on the network tuner (http stream) does not lock, but it did not lock before, so no difference.

I can provide a capture of the http stream if it will help (it will be too big to attach to the ticket - I can put it in my Dropbox, unless there is some more suitable place).

The network tuner also has the capability to record the full multiplex, upto 60 seconds worth, again I can provide if it will help.

comment:6 Changed 2 years ago by Karl Dietz <dekarl@…>

comment:7 Changed 2 years ago by Karl Egly

Status: acceptedinfoneeded

Mike, can you retest with that fix? Its possible that the good PMT was ignored due to a hit in the PAT cache.

comment:8 Changed 2 years ago by mike.bibbings@…

Retested with network tuner, BBC One East channel now locks, LiveTV is working.

Thanks for the very quick fix.

Mike

comment:9 Changed 2 years ago by Karl Egly

Resolution: Fixed
Status: infoneededclosed
Note: See TracTickets for help on using tickets.