Login at Kodi Home

sub3 · 2016-04-04, 04:20

(2016-04-04, 03:29)MrReis Wrote: The two odd things about this problem are (1) there is no obvious reason why some channels don't display correctly (0% buffering) - at least it's not the signal strength, signal quality or network rate and (2) the channels that don't display correctly change with time (usually days).

I've no idea how they do it behind the scenes in Kodi, but it's probably something like they're waiting a maximum amount of time for the PMT (which lists the streams for that channel), and I'm guessing they're timing out waiting for it. Alternatively, some channels sometimes have weird but legal PMT tables, and the kodi live demuxer doesn't handle this.

MrReis · (This post was last modified: 2016-04-18, 06:00 by MrReis.)

I wanted to submit this problem to the KODI Bug tracker but did not because the "HOW-TO:Submit a bug report" (http://kodi.wiki/view/HOW-TO:Submit_a_bug_report) states
"Before posting your bug report, it is important to ensure that you haven't been beat to it. There are two places to look, the Kodi Forum and Bug Tracker."

How can I find out if this problem is being investigated by who ever it is that investigated KODI bugs?? I added all the new information I could to this discussion as suggested.

rogbott · 2016-04-11, 23:34

Did you find anything related via the bug tracker search? I am seeing the same problem and I think other folks have posted logs, but it is entirely possible that no one has actually submitted it as a bug. I think if you have not found anything via the Bug Tracker search you may be the first to actually file.

MrReis · (This post was last modified: 2016-05-25, 19:54 by MrReis.)

(2016-04-11, 23:34)rogbott Wrote: ...it is entirely possible that no one has actually submitted it as a bug. I think if you have not found anything via the Bug Tracker search you may be the first to actually file.

Yes. I think that is the case.

#16678 new Bugs: Random Live TV channels do not load in Kodi, only buffer (Buffering ... 0%)
#16740 new Bugs: KODI-17 - Some live TV channels randomly fail to play
#16744 new Bugs: KODI-17 - Some live TV channels randomly fail to play

MrReis · 2016-05-25, 22:41

(2016-04-04, 04:20)sub3 Wrote: I've no idea how they do it behind the scenes in Kodi, but it's probably something like they're waiting a maximum amount of time for the PMT (which lists the streams for that channel), and I'm guessing they're timing out waiting for it. Alternatively, some channels sometimes have weird but legal PMT tables, and the kodi live demuxer doesn't handle this.

I had a PM exchange with FernetMenta (the owner of #16740 newBugs: KODI-17 - Some live TV channels randomly fail to play) about this problem. FernetMenta agrees with you that this problem is caused by the PMT. He goes on to specifically state that the backend (NextPVR) is forwarding a "multiple program mpegts" stream to KODI which KODI doesn't support (according to KODI's interface specification).

I pointed out that XBMC-13.2 does not have this problem and that it only started with KODI-14. FernetMenta responded "[XBMC] never supported multiple programs. If this was working then only by chance."

My understanding now is that this problem needs to be fixed in NextPVR. As FernetMenta put it "... a backend can't just forward the raw stream from the tuner to Kodi. It has to construct a proper PAT/PMT and send this with the stream." Is there any chance that someone would be able and willing to do this for NextPVR?

sub3 · (This post was last modified: 2016-05-26, 03:19 by sub3.)

(2016-05-25, 22:41)MrReis Wrote: He goes on to specifically state that the backend (NextPVR) is forwarding a "multiple program mpegts" stream to KODI which KODI doesn't support (according to KODI's interface specification).

Nope, it's not doing that. NextPVR only ever delivers a SPTS (single program transport stream) to Kodi.

Quote:My understanding now is that this problem needs to be fixed in NextPVR. As FernetMenta put it "... a backend can't just forward the raw stream from the tuner to Kodi. It has to construct a proper PAT/PMT and send this with the stream." Is there any chance that someone would be able and willing to do this for NextPVR?

It's already doing exactly that. The stream that kodi receives will have the constructed PAT that only has the single channel listed.

FernetMenta · 2016-05-26, 07:30

(2016-05-26, 03:18)sub3 Wrote: It's already doing exactly that. The stream that kodi receives will have the constructed PAT that only has the single channel listed.

How do you explain the difference in PMT reported by ffmpeg? http://trac.kodi.tv/ticket/16740#comment:1

sub3 · (This post was last modified: 2016-05-26, 22:09 by sub3.)

(2016-05-26, 07:30)FernetMenta Wrote:
(2016-05-26, 03:18)sub3 Wrote: It's already doing exactly that. The stream that kodi receives will have the constructed PAT that only has the single channel listed.

How do you explain the difference in PMT reported by ffmpeg? http://trac.kodi.tv/ticket/16740#comment:1

They're different times of the day, so PMT could easily be different, to reflect differences in the streams available. I'm not familiar with exactly what messages ffmpeg is outputting - it looks like both examples are reporting a PAT with single channel though, so not the scenario MrReis tried to relay above. The difference is in the actual PMT, which is something the broadcaster generates (not NextPVR).

MrReis, if you can capture and supply a full transport stream from that frequency that carries channel 760, I can investigate what exactly this mux is carrying (in relation to those messages from your ticket).

To capture a full transport stream, you can use tscapture from http://tscapture.com. The eval lets you capture a minute at a time. I'd only need a 30 second or so recording.

At a time of day when 760 fails, is it failing on every attempt at that time, or some work, some don't?

MrReis · (This post was last modified: 2016-05-27, 00:34 by MrReis.)

(2016-05-26, 21:30)sub3 Wrote: At a time of day when 760 fails, is it failing on every attempt at that time, or some work, some don't?

With KODI-14, and newer, repeated attempts to play channel 760 (or what ever channel is failing that day) consistently fails over a long period of time (usually the whole day). The same channel consistently succeeds on other days. That is, there is not a string of failures and then a success followed by another sting of failures (or vise versa).

MrReis · (This post was last modified: 2016-05-28, 05:17 by MrReis.)

The following are snippets of an XBMC13.2 log and a KODI-16.2 log (between “NOTICE: Creating Demuxer” and “DEBUG: ------ Window Init (DialogseekBar.xml) ------“). The logs were created at the same time on the same computer when channel 670 has been selected to play in Live TV in both XBMC and KODI.

XBMC-13.2 successfully played channel 760 and KODI-16.2 did not play channel 760 (showing "Buffering ... 0%").

To me it looks like XBMC struggles to play channel 760 – a lot of stream “probing” and 25 errors (24 ERROR: ffmpeg[1668]: [mpeg2video] 0x0 is invalid followed by one ERROR: ffmpeg[1668]: [mpeg2video] 0x0 is invalid). However, XBMC ends up playing channel 760.

On the other hand, KODI only has one error (ERROR: CSelectionStreams::Get - failed to get stream), but failed to play channel 760.

xbmc.log

Code:
00:59 T:5736  NOTICE: Creating Demuxer

01:02 T:5736   DEBUG: CDVDDemuxFFmpeg::Open - avformat_find_stream_info starting

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] File position before avformat_find_stream_info() is 0

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] stream=0 stream_type=0 pid=f97 prog_reg_desc=

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2500

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] Probe with size=10839, packets=1 detected ico with score=33

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2499

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] Probe with size=43091, packets=2 detected ico with score=33

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2498

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2497

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] Probe with size=65950, packets=4 detected ico with score=33

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2496

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2495

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2494

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] stream=1 stream_type=0 pid=f98 prog_reg_desc=

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2493

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] Probe with size=156810, packets=8 detected ico with score=33

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2492

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2491

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2490

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2489

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2488

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] Probe with size=268413, packets=13 detected ico with score=33

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2487

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2486

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2485

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 1 pp:2500

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] Probe with size=7680, packets=1 detected ac3 with score=51

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probed stream 1

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2484

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2483

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2482

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2481

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2480

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2479

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2478

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] Probe with size=538433, packets=23 detected ico with score=33

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2477

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2476

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2475

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2474

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2473

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2472

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2471

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2470

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2469

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2468

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2467

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2466

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2465

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2464

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2463

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2462

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2461

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] Probe with size=1062461, packets=40 detected mpegvideo with score=51

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probed stream 0

01:02 T:5736   ERROR: ffmpeg[1668]: [mpeg2video] 0x0 is invalid

01:02 T:5736   ERROR: Previous line repeats 23 times.

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] first_dts 872876334 not matching first dts 872890734 in the queue

01:02 T:5736   DEBUG: Previous line repeats 3 times.

01:02 T:5736   ERROR: ffmpeg[1668]: [mpeg2video] 0x0 is invalid

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] first_dts 872876334 not matching first dts 872905134 in the queue

01:02 T:5736   DEBUG: Previous line repeats 3 times.

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] first_dts 872876334 not matching first dts 872919533 in the queue

01:02 T:5736   DEBUG: Previous line repeats 3 times.

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] first_dts 872876334 not matching first dts 872933934 in the queue

01:02 T:5736   DEBUG: Previous line repeats 3 times.

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] first_dts 872876334 not matching first dts 872948335 in the queue

01:02 T:5736   DEBUG: Previous line repeats 3 times.

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] first_dts 872876334 not matching first dts 872962733 in the queue

01:02 T:5736   DEBUG: Previous line repeats 3 times.

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] first_dts 872876334 not matching first dts 872977134 in the queue

01:02 T:5736   DEBUG: Previous line repeats 3 times.

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] first_dts 872876334 not matching first dts 872991533 in the queue

01:02 T:5736   DEBUG: Previous line repeats 3 times.

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] first_dts 872876334 not matching first dts 873005933 in the queue

01:02 T:5736   DEBUG: Previous line repeats 3 times.

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] first_dts 872876334 not matching first dts 873020333 in the queue

01:02 T:5736   DEBUG: Previous line repeats 3 times.

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] first_dts 872876334 not matching first dts 873034733 in the queue

01:02 T:5736   DEBUG: Previous line repeats 3 times.

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] first_dts 872876334 not matching first dts 873049133 in the queue

01:02 T:5736   DEBUG: Previous line repeats 3 times.

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] first_dts 872876334 not matching first dts 873063533 in the queue

01:02 T:5736   DEBUG: Previous line repeats 3 times.

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] first_dts 872876334 not matching first dts 873077933 in the queue

01:02 T:5736   DEBUG: Previous line repeats 3 times.

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] first_dts 872876334 not matching first dts 873092333 in the queue

01:02 T:5736   DEBUG: Previous line repeats 3 times.

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] first_dts 872876334 not matching first dts 873106733 in the queue

01:02 T:5736   DEBUG: Previous line repeats 3 times.

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] first_dts 872876334 not matching first dts 873121133 in the queue

01:02 T:5736   DEBUG: Previous line repeats 3 times.

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] Probe buffer size limit of 5000000 bytes reached

01:02 T:5736   DEBUG: ffmpeg[1668]: rfps: 59.833333 0.008091

01:02 T:5736   DEBUG: ffmpeg[1668]: rfps: 59.916667 0.000389

01:02 T:5736   DEBUG: Previous line repeats 1 times.

01:02 T:5736   DEBUG: ffmpeg[1668]: rfps: 60.000000 0.002552

01:02 T:5736   DEBUG: Previous line repeats 1 times.

01:02 T:5736   DEBUG: ffmpeg[1668]: rfps: 59.940060 0.000000

01:02 T:5736   DEBUG: Previous line repeats 1 times.

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] File position after avformat_find_stream_info() is 0

01:02 T:5736   DEBUG: CDVDDemuxFFmpeg::Open - av_find_stream_info finished

01:02 T:5736    INFO: ffmpeg[1668]: Input #0, mpegts, from 'pvr://channels/tv/All TV channels/174.pvr':

01:02 T:5736    INFO: ffmpeg[1668]:   Duration: 00:00:03.47, start: 9698.625933, bitrate: 14588 kb/s

01:02 T:5736    INFO: ffmpeg[1668]:   Program 5030

01:02 T:5736    INFO: ffmpeg[1668]:   No Program

01:02 T:5736    INFO: ffmpeg[1668]:     Stream #0:0[0xf97], 176, 1/90000: Video: mpeg2video (Main), yuv420p, 1280x720 [SAR 1:1 DAR 16:9], 59.94 fps, 59.94 tbr, 90k tbn, 119.88 tbc

01:02 T:5736    INFO: ffmpeg[1668]:     Stream #0:1[0xf98], 90, 1/90000: Audio: ac3, 48000 Hz, 5.1(side), fltp, 384 kb/s

01:02 T:5736   DEBUG: CDVDDemuxFFmpeg::AddStream(0, ...) -> 0

01:02 T:5736   DEBUG: CDVDDemuxFFmpeg::AddStream(1, ...) -> 1

01:02 T:5736  NOTICE: Opening video stream: 0 source: 256

01:02 T:5736  NOTICE: Creating video codec with codec id: 2

01:02 T:5736   DEBUG: CDVDFactoryCodec: compiled in hardware support: CrystalHD:yes AMCodec:no MediaCodec:no DXVA:yes

01:02 T:5736   DEBUG: FactoryCodec - Video:  - Opening

01:02 T:5736   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/swscale-2.dll)

01:02 T:5736   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/postproc-52.dll)

01:02 T:5736   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/swresample-0.dll)

01:02 T:5736   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/avfilter-3.dll)

01:02 T:5736  NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: MPEG-2 video

01:02 T:5736   DEBUG: CDVDVideoCodecFFmpeg::Open() Keep default threading 3 by videoplayer.useframemtdec

01:02 T:5736   DEBUG: FactoryCodec - Video: ff-mpeg2video - Opened

01:02 T:6104  NOTICE: Thread VideoReferenceClock start, auto delete: false

01:02 T:6104   DEBUG: CVideoReferenceClock: Setting up Direct3d

01:02 T:6104   DEBUG: CVideoReferenceClock: SetThreadPriority failed

01:02 T:6104   DEBUG: CVideoReferenceClock: detected refreshrate: 30 hertz, assuming 30 hertz

01:02 T:5736  NOTICE: Creating video thread

01:02 T:5736  NOTICE: Opening audio stream: 1 source: 256

01:02 T:5736  NOTICE: Finding audio codec for: 86019

01:02 T:5736   DEBUG: FactoryCodec - Audio: passthrough - Opening

01:02 T:5736   DEBUG: FactoryCodec - Audio: passthrough - Failed

01:02 T:5736   DEBUG: FactoryCodec - Audio: FFmpeg - Opening

01:02 T:5736   DEBUG: FactoryCodec - Audio: FFmpeg - Opened

01:02 T:5736  NOTICE: Creating audio thread

01:02 T:5736   DEBUG: CDVDPlayer::SetCaching - caching state 2

01:02 T:2660  NOTICE: Thread DVDPlayerAudio start, auto delete: false

01:02 T:2660  NOTICE: running thread: CDVDPlayerAudio::Process()

01:02 T:5736   DEBUG: CApplication::OnPlayBackStarted : play state was 1, starting 1

01:02 T:4140  NOTICE: Thread DVDPlayerVideo start, auto delete: false

01:02 T:4140  NOTICE: running thread: video_thread

01:02 T:4140   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE

01:02 T:4140   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(593055.888890, 1)

01:02 T:4140    INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback

01:02 T:2660   DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(0.333333, 0)

01:02 T:4140 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available

01:02 T:2660  NOTICE: Creating audio stream (codec id: 86019, channels: 6, sample rate: 48000, no pass-through)

01:02 T:2660   DEBUG: CDVDPlayerAudio:: synctype set to 0: clock feedback

01:02 T:2804    INFO: CActiveAESink::OpenSink - initialize sink

01:02 T:2804   DEBUG: CActiveAESink::OpenSink - trying to open device DIRECTSOUND:default

01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] first_dts 872876334 not matching first dts 872890734 in the queue

01:02 T:804   DEBUG: Previous line repeats 3 times.

01:02 T:804   DEBUG: CApplication::PlayFile : OpenFile succeed, play state 2

01:02 T:804   DEBUG: CApplication::OnPlayBackStarted : play state was 2, starting 0

01:02 T:804   DEBUG: ------ Window Init (DialogSeekBar.xml) ------

kodi.log

Code:
00:59 T:1960  NOTICE: Creating Demuxer

00:59 T:1292   DEBUG: ------ Window Deinit (Pointer.xml) ------

00:59 T:1960   DEBUG: ffmpeg[7A8]: score: 44, dvhs_score: -2, fec_score: -2

00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] Filter: pid=0x11

00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] Filter: pid=0x0

00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:

00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] sid=0x13a6 pid=0x37

00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] new_program: id=0x13a6

00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] Filter: pid=0x37

00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24

00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] sid=0x13 sec_num=0/218 version=19

00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:

00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24

00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:

00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24

00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:

00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24

00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:

00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24

00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:

00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24

00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:

01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24

01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:

01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24

01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:

01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24

01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:

01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24

01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:

01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24

01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:

01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24

01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:

01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24

01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:

01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24

01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:

01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24

01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:

01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24

01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:

01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24

01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:

01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24

01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:

01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24

01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:

01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24

01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:

01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24

01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:

01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24

01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:

01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] tuning done

01:01 T:1960    INFO: ffmpeg[7A8]: Input #0, mpegts, pvr://channels/tv/All channels/pvr.nextpvr_7923.pv':

01:01 T:1960    INFO: ffmpeg[7A8]:   Duration: N/A, bitrate: N/A

01:01 T:1960    INFO: ffmpeg[7A8]:   Program 5030

01:01 T:1960   ERROR: CSelectionStreams::Get - failed to get stream

01:01 T:1960   DEBUG: CDVDPlayer::SetCaching - caching state 2

01:01 T:1960 WARNING: CDVDMessageQueue(audio)::Put MSGQ_NOT_INITIALIZED

01:01 T:1960 WARNING: CDVDMessageQueue(video)::Put MSGQ_NOT_INITIALIZED

01:01 T:1960   DEBUG: CApplication::OnPlayBackStarted: play state was 1, starting 1

01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] Skipping after seek

01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] Filter: pid=0xf97

01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] pid=f97 pes_code=0x1e0

01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] stream=0 stream_type=0 pid=f97 prog_reg_desc=

01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] pid=f97 stream_type=0 probing

01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] pid=f97 pes_code=0x1e0

01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] probing stream 0 pp:2500

01:01 T:1292   DEBUG: CApplication::PlayFile: OpenFile succeed, play state 2

01:01 T:1292   DEBUG: CApplication::OnPlayBackStarted: play state was 2, starting 0

01:01 T:1292   DEBUG: ------ Window Init (DialogSeekBar.xml) ------

sub3 · (This post was last modified: 2016-05-27, 01:28 by sub3.)

(2016-05-27, 00:50)MrReis Wrote: XBMC-13.2 successfully played channel 760 and KODI-16.2 did not channel 760 (showing "Buffering ... 0%").

To me it looks like XBMC struggles to play channel 760 – a lot of stream “probing” and 25 errors (24 ERROR: ffmpeg[1668]: [mpeg2video] 0x0 is invalid followed by one ERROR: ffmpeg[1668]: [mpeg2video] 0x0 is invalid). However, XBMC ends up playing channel 760.

On the other hand, KODI only has one error (ERROR: CSelectionStreams::Get - failed to get stream), but failed to play channel 760.

Yeah, from memory Margro did some major changes to how the channel streams were identified around the time they moved from XBMC to Kodi, with the intention of speeding up channel changes. It used to spend quite a bit of time probing the streams, and this was removed. I think these newer changes are not coping as well with odd PMT records that broadcasters can generate, where as old XBMC, and NextPVR own player etc handle them fine.

MrReis, if you supply that live-FOXNEWSHD-9104-1.ts file to FernetMenta, he might be better placed to see why Kodi doesn't like it.

FernetMenta · 2016-05-27, 11:11

(2016-05-26, 21:30)sub3 Wrote: The difference is in the actual PMT, which is something the broadcaster generates (not NextPVR).

Maybe this is the problem. I am the author of VNSI (VDR) and I do create PAT/PMT myself.

FernetMenta · 2016-05-27, 11:17

Note that PAT/PMT is analyzed by ffmpeg, not Kodi, and v13 had a much older version of ffmpeg than we have now.

MrReis · (This post was last modified: 2016-05-27, 19:31 by MrReis.)

(2016-05-27, 11:17)FernetMenta Wrote: Note that PAT/PMT is analyzed by ffmpeg, not Kodi, and v13 had a much older version of ffmpeg than we have now.

Is the API for the “much older version of ffmpeg” (used with XBMC-13) the same as the API for the current version of ffmpeg being used with KODI? If the API’s are the same, then perhaps including both versions of ffmpeg in KODI and giving the user an installation option to select which version of ffmpeg to use (the older version used by XBMC-13 or the version currently being used by KODI) may solve this problem for users that are not able to reliably play some live TV streams that contain PATs/PMTs that may apparently not compatible with the current version of ffmpeg used by KODI-14 and newer.

If the API for the “much older version of ffmpeg” is not the same as the API for the current version of ffmpeg being used with KODI, then I guess the above suggestion would be a lot more work and not very likely to happen.

FernetMenta · 2016-05-28, 09:13

This has nothing to do with an API. Kodi depends on libraries like ffmpeg and we upgrade the libs on a regular basis.