Skip to content

MPEG-TS - Freezing / PTS / PCR problems / picture might be displayed late (missing 0 ms)

Description

Movie is not playing smooth. Missing frames.

  • HW ACCEL : Disabled -> Playing. Not Missing frames. Speed of playback looks like Half of FPS.
  • HW ACCEL : Decoding -> Playing. Missing Frames. Jump effect from frame to frame.
  • HW ACCEL : FULL -> Playing. Missing Frames. Jump effect from frame to frame.

LOG

2021-04-01 14:32:54.084 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:54.124 4578-7700/? I/chatty: uid=10038(org.videolan.vlc) AWindowHandler identical 1 line
2021-04-01 14:32:54.164 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:54.180 4578-7690/? D/VLC: [87c7b830/1e0a] libvlc input: waiting decoder fifos to empty
2021-04-01 14:32:54.204 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:54.245 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:54.280 4578-7690/? D/VLC: [87c7b830/1e0a] libvlc input: waiting decoder fifos to empty
2021-04-01 14:32:54.284 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:54.324 4578-7700/? I/chatty: uid=10038(org.videolan.vlc) AWindowHandler identical 1 line
2021-04-01 14:32:54.364 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:54.380 4578-7690/? D/VLC: [87c7b830/1e0a] libvlc input: waiting decoder fifos to empty
2021-04-01 14:32:54.404 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:54.444 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:54.481 4578-7690/? D/VLC: [87c7b830/1e0a] libvlc input: waiting decoder fifos to empty
2021-04-01 14:32:54.484 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:54.524 4578-7700/? I/chatty: uid=10038(org.videolan.vlc) AWindowHandler identical 1 line
2021-04-01 14:32:54.564 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:54.581 4578-7690/? D/VLC: [87c7b830/1e0a] libvlc input: waiting decoder fifos to empty
2021-04-01 14:32:54.604 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:54.644 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:54.681 4578-7690/? D/VLC: [87c7b830/1e0a] libvlc input: waiting decoder fifos to empty
2021-04-01 14:32:54.683 3201-3372/? I/AudioFlinger: BUFFER TIMEOUT: remove(3) from active list on thread 0xae783900
2021-04-01 14:32:54.684 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:54.724 4578-7700/? I/chatty: uid=10038(org.videolan.vlc) AWindowHandler identical 1 line
2021-04-01 14:32:54.764 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:54.781 4578-7690/? D/VLC: [87c7b830/1e0a] libvlc input: waiting decoder fifos to empty
2021-04-01 14:32:54.804 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:54.844 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:54.882 4578-7690/? D/VLC: [87c7b830/1e0a] libvlc input: waiting decoder fifos to empty
2021-04-01 14:32:54.884 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:54.924 4578-7700/? I/chatty: uid=10038(org.videolan.vlc) AWindowHandler identical 1 line
2021-04-01 14:32:54.964 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:54.982 4578-7690/? D/VLC: [87c7b830/1e0a] libvlc input: waiting decoder fifos to empty
2021-04-01 14:32:55.004 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:55.044 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:55.082 4578-7690/? D/VLC: [87c7b830/1e0a] libvlc input: waiting decoder fifos to empty
2021-04-01 14:32:55.084 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:55.124 4578-7700/? I/chatty: uid=10038(org.videolan.vlc) AWindowHandler identical 1 line
2021-04-01 14:32:55.164 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:55.182 4578-7690/? D/VLC: [87c7b830/1e0a] libvlc input: waiting decoder fifos to empty
2021-04-01 14:32:55.206 4578-7696/? E/VLC: [8a513930/1e10] libvlc decoder: Decoder is draining
2021-04-01 14:32:55.204 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:55.244 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:55.247 4578-7696/? W/VLC: [8a513930/1e10] libvlc decoder: EOS sent, waiting for OutThread
2021-04-01 14:32:55.247 3273-7710/? D/AmlogicVideoDecoderAwesome: mInputTimeStampChanged = true,mLastInputTimeStamp=83885304,bufferHdr.nTimeStamp=0
2021-04-01 14:32:55.247 3273-7710/? I/amcodec: codec_set_eos is_eos =1
2021-04-01 14:32:55.247 3273-7710/? D/AmlogicVideoDecoderAwesome: set eos to decoder
2021-04-01 14:32:55.247 3273-7710/? D/AmlogicVideoDecoderAwesome: 	===mEosStamp 0 ==
2021-04-01 14:32:55.282 4578-7690/? D/VLC: [87c7b830/1e0a] libvlc input: waiting decoder fifos to empty
2021-04-01 14:32:55.284 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:55.324 4578-7700/? I/chatty: uid=10038(org.videolan.vlc) AWindowHandler identical 1 line
2021-04-01 14:32:55.364 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:55.383 4578-7690/? D/VLC: [87c7b830/1e0a] libvlc input: waiting decoder fifos to empty
2021-04-01 14:32:55.404 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:55.444 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:55.483 4578-7690/? D/VLC: [87c7b830/1e0a] libvlc input: waiting decoder fifos to empty
2021-04-01 14:32:55.484 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:55.524 4578-7700/? I/chatty: uid=10038(org.videolan.vlc) AWindowHandler identical 1 line
2021-04-01 14:32:55.564 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:55.583 4578-7690/? D/VLC: [87c7b830/1e0a] libvlc input: waiting decoder fifos to empty
2021-04-01 14:32:55.604 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:55.644 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:55.684 4578-7690/? D/VLC: [87c7b830/1e0a] libvlc input: waiting decoder fifos to empty
2021-04-01 14:32:55.684 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:55.724 4578-7700/? I/chatty: uid=10038(org.videolan.vlc) AWindowHandler identical 1 line
2021-04-01 14:32:55.764 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:55.784 4578-7690/? D/VLC: [87c7b830/1e0a] libvlc input: waiting decoder fifos to empty
2021-04-01 14:32:55.804 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:55.844 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:55.884 4578-7690/? D/VLC: [87c7b830/1e0a] libvlc input: waiting decoder fifos to empty
2021-04-01 14:32:55.884 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:55.924 4578-7700/? I/chatty: uid=10038(org.videolan.vlc) AWindowHandler identical 1 line
2021-04-01 14:32:55.964 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:55.984 4578-7690/? D/VLC: [87c7b830/1e0a] libvlc input: waiting decoder fifos to empty
2021-04-01 14:32:56.002 3393-3474/? D/WifiStateMachine:  ConnectedState !CMD_RSSI_POLL rt=4562644/4562644 1 0 "ZyXEL WAP3205 v3" 98:0d:67:a2:f8:14 rssi=-39 f=2417 sc=60 link=300 tx=5.1, 0.0, 0.0  rx=10.5 bcn=0 [on:0 tx:0 rx:0 period:3000] from screen [on:0 period:-1925894590] score=60
2021-04-01 14:32:56.003 3393-3474/? D/WifiStateMachine:  L2ConnectedState !CMD_RSSI_POLL rt=4562647/4562647 1 0 "ZyXEL WAP3205 v3" 98:0d:67:a2:f8:14 rssi=-39 f=2417 sc=60 link=300 tx=5.1, 0.0, 0.0  rx=10.5 bcn=0 [on:0 tx:0 rx:0 period:1] from screen [on:0 period:-1925894589] score=60
2021-04-01 14:32:56.004 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:56.008 3393-3474/? E/WifiVendorHal: getWifiLinkLayerStats(l.937) failed {.code = ERROR_NOT_AVAILABLE, .description = }
2021-04-01 14:32:56.010 3393-3474/? D/WifiStateMachine: fetchRssiLinkSpeedAndFrequencyNative rssi=-42 linkspeed=300 freq=2417
2021-04-01 14:32:56.010 3393-3474/? V/WifiConfigManager: Updating scan detail cache freq=2417 BSSID=98:0d:67:a2:f8:14 RSSI=-40 for "ZyXEL WAP3205 v3"WPA_PSK
2021-04-01 14:32:56.013 3947-3947/? D/MainBrowseFragment: netReceiver         action = android.net.wifi.RSSI_CHANGED
2021-04-01 14:32:56.014 3393-3811/? I/WifiService: getConnectionInfo uid=1000
2021-04-01 14:32:56.044 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:56.084 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:56.085 4578-7690/? D/VLC: [87c7b830/1e0a] libvlc input: waiting decoder fifos to empty
2021-04-01 14:32:56.125 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:56.164 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:56.185 4578-7690/? D/VLC: [87c7b830/1e0a] libvlc input: waiting decoder fifos to empty
2021-04-01 14:32:56.204 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:56.255 3273-7709/? D/AmlogicVideoDecoderAwesome: mEosCheckCount=0, mInPutFrameCount=2953, mOutBufferNo=2922, mMaxInputTimeStamp=83885364889, mLastTimeStamp=83885344889
2021-04-01 14:32:56.284 4578-7700/? D/VLC: [899fd030/1e14] libvlc video output: picture might be displayed late (missing 0 ms)
2021-04-01 14:32:56.285 4578-7690/? D/VLC: [87c7b830/1e0a] libvlc input: waiting decoder fifos to empty

Most of problems does MPEG-TS has,

Expected behavior

Play smooth video.

Actual behavior

Not playing smooth video.

VIDEO for TEST

TS: https://we.tl/t-N1DJ9EDwbL

Steps to reproduce

  1. Play movie

Context

App version

GIT build.

Android version

Android TV 9/10

Device model

MiBox S / 3 / MeCool 6 / TCL TV

General Problem of most of MPEG-TS from DVB.

App mode

RELEASE / DEBUG

TV

Edited by Jean-Baptiste Kempf