[mythtv-commits] Ticket #12513: IPTV: Movistar TV stops LiveTV playback after a while

MythTV noreply at mythtv.org
Fri Dec 11 08:12:58 UTC 2015


#12513: IPTV: Movistar TV stops LiveTV playback after a while
------------------------------------+--------------------------------
 Reporter:  amlopezalonso@…         |          Owner:
     Type:  Bug Report - General    |         Status:  infoneeded_new
 Priority:  minor                   |      Milestone:  unknown
Component:  MythTV - General        |        Version:  Master Head
 Severity:  medium                  |     Resolution:
 Keywords:  IPTV, playback, livetv  |  Ticket locked:  0
------------------------------------+--------------------------------
Changes (by dekarl):

 * status:  new => infoneeded_new


Comment:

 I found some time to look at this. It is the continuation after fixing RTP
 reception in #12188.

 The logfile does not contain any obvious (for me) root cause, so I'm just
 listing all suspicious parts and ask questions to try to identify the
 relevant parts.

 Just for clarity. Do recordings work reliable? Or does this affect
 recordings and LiveTV?


 {{{
 2015-09-30 00:14:17.628516 D  MMulticastSocketDevice(:25): setsockopt -
 IP_MULTICAST_IF
                         eno: No se puede asignar la dirección solicitada
 (99)
 2015-09-30 00:14:17.749717 D  MMulticastSocketDevice(:25): setsockopt -
 IP_MULTICAST_IF
                         eno: No se puede asignar la dirección solicitada
 (99)
 }}}
 Errno 99 is EADDRNOTAVAIL. It appears as if there may be an issue with the
 network configuration.

 {{{
 2015-09-30 00:14:26.901568 I  TV::HandleStateChange(): Changing from None
 to WatchingLiveTV
 2015-09-30 00:14:28.209395 I  VidOutVDPAU: InputChanged(1920,1080,1.77778)
 'None'->'H.264 VDPAU'
 2015-09-30 00:14:28.210914 W  MythPainter: 36 images not yet de-allocated.
 2015-09-30 00:14:28.694213 I  Player(0): Waiting for video buffers...
 2015-09-30 00:14:28.798315 N  Player(0): Waited 104ms for video buffers
 LLLLdAAAAAAAAAAA
 2015-09-30 00:14:28.901902 N  Player(0): Waited 207ms for video buffers
 LLLLdAAAAAAAAAAA
 2015-09-30 00:14:29.005472 N  Player(0): Waited 311ms for video buffers
 LLLLdAAAAAAAAAAA
 2015-09-30 00:14:29.108894 N  Player(0): Waited 414ms for video buffers
 LLLLdAAAAAAAAAAA
 2015-09-30 00:14:29.212503 N  Player(0): Waited 518ms for video buffers
 LLLLdAAAAAAAAAAA
 2015-09-30 00:14:29.316329 N  Player(0): Waited 622ms for video buffers
 LLLLdAAAAAAAAAAA
 2015-09-30 00:14:29.420148 N  Player(0): Waited 726ms for video buffers
 AALAdLLLAAAAAAAA
 2015-09-30 00:14:29.489943 E  PulseAudio: stream buffer under flow
 2015-09-30 00:14:29.524396 N  Player(0): Waited 830ms for video buffers
 AAAAdAAAAAALLAAA
 2015-09-30 00:14:30.236548 E  PulseAudio: stream buffer under flow
 2015-09-30 00:14:31.089868 E  PulseAudio: stream buffer under flow
 2015-09-30 00:14:31.137058 I  Player(0): Waiting for video buffers...
 2015-09-30 00:15:14.637121 I  TV::HandleStateChange(): Attempting to
 change from WatchingLiveTV to None
 }}}

 I see it pick the H.264 1920x1080 video stream and attempt to start
 decoding it via VDPAU. But more or less directly the buffering errors
 begin. Audio stream buffer under flow from Pulseaudio, waiting for video
 buffers from our Player, etc.

 Does playback even start?

 Does this happen on all channels?

 Does it happen with software decoding?

 Does it happen with ALSA for audio playback?


 {{{
 2015-09-30 00:15:19.815317 W
 RingBuf(/usr/local/share/datos/tv/livetv/1999_20150929231427.ts):
 ReadPriv(..32768, normal) -- waited 10009 ms for avail(0) > count(32768)
 2015-09-30 00:15:19.815333 E
 RingBuf(/usr/local/share/datos/tv/livetv/1999_20150929231427.ts):
 ReadPriv(..32768, normal) -- timed out waiting for data (10009 ms)
 2015-09-30 00:15:19.815582 E  decoding error
                         eno: Error desconocido 541478725 (541478725)
 }}}

 [https://sourceforge.net/p/mlt/mailman/message/33226956/ Error 541478725
 is the decimal representation of AVERROR_EOF from FFmpeg.] It appears as
 if LiveTV playback is hitting the end of the buffer or (at least) one of
 the streams ends.

 Searching for "LiveTV 541478725" turned up #11064 where the root cause was
 the network stream stopping due to the sender falling off the network.

 Can you look at the network (e.g. via wireshark) around the time where the
 error occurs?

 Does the multicast stream somehow stop? After about 50 seconds?

 Can you compare to VLC's network activity?

 Maybe we need yet another keep-alive mechanism.

--
Ticket URL: <https://code.mythtv.org/trac/ticket/12513#comment:1>
MythTV <http://www.mythtv.org>
MythTV Media Center


More information about the mythtv-commits mailing list