Bug Random channels no longer load in Kodi, only buffer
#31
(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.
Reply
#32
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.
Reply
#33
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.
Reply
#34
(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
Reply
#35
(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?
Reply
#36
(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.
Reply
#37
(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
Reply
#38
(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?
Reply
#39
(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).
Reply
#40
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:
09:00:59 T:5736  NOTICE: Creating Demuxer
09:01:02 T:5736   DEBUG: CDVDDemuxFFmpeg::Open - avformat_find_stream_info starting
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] File position before avformat_find_stream_info() is 0
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] stream=0 stream_type=0 pid=f97 prog_reg_desc=
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2500
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] Probe with size=10839, packets=1 detected ico with score=33
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2499
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] Probe with size=43091, packets=2 detected ico with score=33
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2498
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2497
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] Probe with size=65950, packets=4 detected ico with score=33
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2496
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2495
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2494
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] stream=1 stream_type=0 pid=f98 prog_reg_desc=
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2493
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] Probe with size=156810, packets=8 detected ico with score=33
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2492
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2491
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2490
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2489
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2488
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] Probe with size=268413, packets=13 detected ico with score=33
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2487
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2486
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2485
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 1 pp:2500
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] Probe with size=7680, packets=1 detected ac3 with score=51
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probed stream 1
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2484
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2483
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2482
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2481
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2480
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2479
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2478
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] Probe with size=538433, packets=23 detected ico with score=33
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2477
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2476
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2475
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2474
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2473
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2472
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2471
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2470
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2469
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2468
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2467
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2466
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2465
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2464
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2463
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2462
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probing stream 0 pp:2461
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] Probe with size=1062461, packets=40 detected mpegvideo with score=51
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] probed stream 0
09:01:02 T:5736   ERROR: ffmpeg[1668]: [mpeg2video] 0x0 is invalid
09:01:02 T:5736   ERROR: Previous line repeats 23 times.
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] first_dts 872876334 not matching first dts 872890734 in the queue
09:01:02 T:5736   DEBUG: Previous line repeats 3 times.
09:01:02 T:5736   ERROR: ffmpeg[1668]: [mpeg2video] 0x0 is invalid
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] first_dts 872876334 not matching first dts 872905134 in the queue
09:01:02 T:5736   DEBUG: Previous line repeats 3 times.
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] first_dts 872876334 not matching first dts 872919533 in the queue
09:01:02 T:5736   DEBUG: Previous line repeats 3 times.
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] first_dts 872876334 not matching first dts 872933934 in the queue
09:01:02 T:5736   DEBUG: Previous line repeats 3 times.
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] first_dts 872876334 not matching first dts 872948335 in the queue
09:01:02 T:5736   DEBUG: Previous line repeats 3 times.
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] first_dts 872876334 not matching first dts 872962733 in the queue
09:01:02 T:5736   DEBUG: Previous line repeats 3 times.
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] first_dts 872876334 not matching first dts 872977134 in the queue
09:01:02 T:5736   DEBUG: Previous line repeats 3 times.
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] first_dts 872876334 not matching first dts 872991533 in the queue
09:01:02 T:5736   DEBUG: Previous line repeats 3 times.
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] first_dts 872876334 not matching first dts 873005933 in the queue
09:01:02 T:5736   DEBUG: Previous line repeats 3 times.
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] first_dts 872876334 not matching first dts 873020333 in the queue
09:01:02 T:5736   DEBUG: Previous line repeats 3 times.
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] first_dts 872876334 not matching first dts 873034733 in the queue
09:01:02 T:5736   DEBUG: Previous line repeats 3 times.
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] first_dts 872876334 not matching first dts 873049133 in the queue
09:01:02 T:5736   DEBUG: Previous line repeats 3 times.
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] first_dts 872876334 not matching first dts 873063533 in the queue
09:01:02 T:5736   DEBUG: Previous line repeats 3 times.
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] first_dts 872876334 not matching first dts 873077933 in the queue
09:01:02 T:5736   DEBUG: Previous line repeats 3 times.
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] first_dts 872876334 not matching first dts 873092333 in the queue
09:01:02 T:5736   DEBUG: Previous line repeats 3 times.
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] first_dts 872876334 not matching first dts 873106733 in the queue
09:01:02 T:5736   DEBUG: Previous line repeats 3 times.
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] first_dts 872876334 not matching first dts 873121133 in the queue
09:01:02 T:5736   DEBUG: Previous line repeats 3 times.
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] Probe buffer size limit of 5000000 bytes reached
09:01:02 T:5736   DEBUG: ffmpeg[1668]: rfps: 59.833333 0.008091
09:01:02 T:5736   DEBUG: ffmpeg[1668]: rfps: 59.916667 0.000389
09:01:02 T:5736   DEBUG: Previous line repeats 1 times.
09:01:02 T:5736   DEBUG: ffmpeg[1668]: rfps: 60.000000 0.002552
09:01:02 T:5736   DEBUG: Previous line repeats 1 times.
09:01:02 T:5736   DEBUG: ffmpeg[1668]: rfps: 59.940060 0.000000
09:01:02 T:5736   DEBUG: Previous line repeats 1 times.
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] File position after avformat_find_stream_info() is 0
09:01:02 T:5736   DEBUG: CDVDDemuxFFmpeg::Open - av_find_stream_info finished
09:01:02 T:5736    INFO: ffmpeg[1668]: Input #0, mpegts, from 'pvr://channels/tv/All TV channels/174.pvr':
09:01:02 T:5736    INFO: ffmpeg[1668]:   Duration: 00:00:03.47, start: 9698.625933, bitrate: 14588 kb/s
09:01:02 T:5736    INFO: ffmpeg[1668]:   Program 5030
09:01:02 T:5736    INFO: ffmpeg[1668]:   No Program
09: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
09: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
09:01:02 T:5736   DEBUG: CDVDDemuxFFmpeg::AddStream(0, ...) -> 0
09:01:02 T:5736   DEBUG: CDVDDemuxFFmpeg::AddStream(1, ...) -> 1
09:01:02 T:5736  NOTICE: Opening video stream: 0 source: 256
09:01:02 T:5736  NOTICE: Creating video codec with codec id: 2
09:01:02 T:5736   DEBUG: CDVDFactoryCodec: compiled in hardware support: CrystalHD:yes AMCodec:no MediaCodec:no DXVA:yes
09:01:02 T:5736   DEBUG: FactoryCodec - Video:  - Opening
09:01:02 T:5736   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/swscale-2.dll)
09:01:02 T:5736   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/postproc-52.dll)
09:01:02 T:5736   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/swresample-0.dll)
09:01:02 T:5736   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/avfilter-3.dll)
09:01:02 T:5736  NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: MPEG-2 video
09:01:02 T:5736   DEBUG: CDVDVideoCodecFFmpeg::Open() Keep default threading 3 by videoplayer.useframemtdec
09:01:02 T:5736   DEBUG: FactoryCodec - Video: ff-mpeg2video - Opened
09:01:02 T:6104  NOTICE: Thread VideoReferenceClock start, auto delete: false
09:01:02 T:6104   DEBUG: CVideoReferenceClock: Setting up Direct3d
09:01:02 T:6104   DEBUG: CVideoReferenceClock: SetThreadPriority failed
09:01:02 T:6104   DEBUG: CVideoReferenceClock: detected refreshrate: 30 hertz, assuming 30 hertz
09:01:02 T:5736  NOTICE: Creating video thread
09:01:02 T:5736  NOTICE: Opening audio stream: 1 source: 256
09:01:02 T:5736  NOTICE: Finding audio codec for: 86019
09:01:02 T:5736   DEBUG: FactoryCodec - Audio: passthrough - Opening
09:01:02 T:5736   DEBUG: FactoryCodec - Audio: passthrough - Failed
09:01:02 T:5736   DEBUG: FactoryCodec - Audio: FFmpeg - Opening
09:01:02 T:5736   DEBUG: FactoryCodec - Audio: FFmpeg - Opened
09:01:02 T:5736  NOTICE: Creating audio thread
09:01:02 T:5736   DEBUG: CDVDPlayer::SetCaching - caching state 2
09:01:02 T:2660  NOTICE: Thread DVDPlayerAudio start, auto delete: false
09:01:02 T:2660  NOTICE: running thread: CDVDPlayerAudio::Process()
09:01:02 T:5736   DEBUG: CApplication::OnPlayBackStarted : play state was 1, starting 1
09:01:02 T:4140  NOTICE: Thread DVDPlayerVideo start, auto delete: false
09:01:02 T:4140  NOTICE: running thread: video_thread
09:01:02 T:4140   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
09:01:02 T:4140   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(593055.888890, 1)
09:01:02 T:4140    INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback
09:01:02 T:2660   DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(0.333333, 0)
09:01:02 T:4140 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available
09:01:02 T:2660  NOTICE: Creating audio stream (codec id: 86019, channels: 6, sample rate: 48000, no pass-through)
09:01:02 T:2660   DEBUG: CDVDPlayerAudio:: synctype set to 0: clock feedback
09:01:02 T:2804    INFO: CActiveAESink::OpenSink - initialize sink
09:01:02 T:2804   DEBUG: CActiveAESink::OpenSink - trying to open device DIRECTSOUND:default
09:01:02 T:5736   DEBUG: ffmpeg[1668]: [mpegts] first_dts 872876334 not matching first dts 872890734 in the queue
09:01:02 T:804   DEBUG: Previous line repeats 3 times.
09:01:02 T:804   DEBUG: CApplication::PlayFile : OpenFile succeed, play state 2
09:01:02 T:804   DEBUG: CApplication::OnPlayBackStarted : play state was 2, starting 0
09:01:02 T:804   DEBUG: ------ Window Init (DialogSeekBar.xml) ------

kodi.log
Code:
09:00:59 T:1960  NOTICE: Creating Demuxer
09:00:59 T:1292   DEBUG: ------ Window Deinit (Pointer.xml) ------
09:00:59 T:1960   DEBUG: ffmpeg[7A8]: score: 44, dvhs_score: -2, fec_score: -2
09:00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] Filter: pid=0x11
09:00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] Filter: pid=0x0
09:00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:
09:00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] sid=0x13a6 pid=0x37
09:00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] new_program: id=0x13a6
09:00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] Filter: pid=0x37
09:00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24
09:00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] sid=0x13 sec_num=0/218 version=19
09:00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:
09:00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24
09:00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:
09:00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24
09:00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:
09:00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24
09:00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:
09:00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24
09:00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:
09:00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24
09:00:59 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:
09:01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24
09:01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:
09:01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24
09:01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:
09:01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24
09:01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:
09:01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24
09:01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:
09:01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24
09:01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:
09:01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24
09:01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:
09:01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24
09:01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:
09:01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24
09:01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:
09:01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24
09:01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:
09:01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24
09:01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:
09:01:00 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24
09:01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:
09:01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24
09:01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:
09:01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24
09:01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:
09:01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24
09:01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:
09:01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24
09:01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:
09:01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PMT: len 24
09:01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] PAT:
09:01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] tuning done
09:01:01 T:1960    INFO: ffmpeg[7A8]: Input #0, mpegts, pvr://channels/tv/All channels/pvr.nextpvr_7923.pv':
09:01:01 T:1960    INFO: ffmpeg[7A8]:   Duration: N/A, bitrate: N/A
09:01:01 T:1960    INFO: ffmpeg[7A8]:   Program 5030
09:01:01 T:1960   ERROR: CSelectionStreams::Get - failed to get stream
09:01:01 T:1960   DEBUG: CDVDPlayer::SetCaching - caching state 2
09:01:01 T:1960 WARNING: CDVDMessageQueue(audio)::Put MSGQ_NOT_INITIALIZED
09:01:01 T:1960 WARNING: CDVDMessageQueue(video)::Put MSGQ_NOT_INITIALIZED
09:01:01 T:1960   DEBUG: CApplication::OnPlayBackStarted: play state was 1, starting 1
09:01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] Skipping after seek
09:01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] Filter: pid=0xf97
09:01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] pid=f97 pes_code=0x1e0
09:01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] stream=0 stream_type=0 pid=f97 prog_reg_desc=
09:01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] pid=f97 stream_type=0 probing
09:01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] pid=f97 pes_code=0x1e0
09:01:01 T:1960   DEBUG: ffmpeg[7A8]: [mpegts] probing stream 0 pp:2500
09:01:01 T:1292   DEBUG: CApplication::PlayFile: OpenFile succeed, play state 2
09:01:01 T:1292   DEBUG: CApplication::OnPlayBackStarted: play state was 2, starting 0
09:01:01 T:1292   DEBUG: ------ Window Init (DialogSeekBar.xml) ------
Reply
#41
(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.
Reply
#42
(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.
Reply
#43
Note that PAT/PMT is analyzed by ffmpeg, not Kodi, and v13 had a much older version of ffmpeg than we have now.
Reply
#44
(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.
Reply
#45
This has nothing to do with an API. Kodi depends on libraries like ffmpeg and we upgrade the libs on a regular basis.
Reply

Logout Mark Read Team Forum Stats Members Help
Random channels no longer load in Kodi, only buffer0
This forum uses Lukasz Tkacz MyBB addons.