Jump to content

Playback very slow in MiBox and MiTV3

wolong_zb

By wolong_zb
in Android TV / Fire TV

 Share

Recommended Posts

wolong_zb

wolong_zb   8

Posted
Posted (edited)

Playback very slow in MiBox3 and MiTV3, only few fps

 

Any bit rate video play is not smooth, caden;

For example, 720p/4Mbps, 1080p/15Mbps, mkv files.

If play with external player (MX player, VLC), playback is normal.

 

What log information do I need to provide?

 

MiTV3 model info：

https://www.displayspecifications.com/en/model/96ee3f8

 

MiBox

https://www.mi.com/global/mibox/

 

 

Thanks

Edited by wolong_zb
Link to comment
Share on other sites
wolong_zb

wolong_zb   8

Posted
  • Author
Posted (edited)

I send a debug log from android tv app

utc time:  2019/3/23 15:44         2019/3/23 16:02   

utc+8 time: 2019/3/23 23:44      2019/3/24 00:02

Emby user : wolong

Emby server ip: 172.16.0.9

AndroidTv 1.6.96g

 

 

 

test2.jpg

Edited by wolong_zb
Link to comment
Share on other sites
ebr Emby Team

ebr   14958

Posted
Posted

Oh, this is one of those old not really Android TV boxes.  Sorry, I thought it was a current Mi 3 Android TV device.

 

I'm not sure but the log shows a ton of dropped frames and also timestamp issues with the media.

W/AudioTrack(16354): Spurious audio timestamp (frame position mismatch): 210208, 197186210081, 197186210631, 196010666, 9418752, 9418752
W/AudioTrack(16354): Spurious audio timestamp (frame position mismatch): 210208, 197186210081, 197186219154, 196010666, 9418752, 9418752
W/AudioTrack(16354): Spurious audio timestamp (frame position mismatch): 236608, 197186760055, 197186760559, 196565333, 9443328, 9443328

What happens if you use "Playback Correction..." to force it to transcode?  Or, lower the quality setting to below 3Mb/s.

Link to comment
Share on other sites
wolong_zb

wolong_zb   8

Posted
  • Author
Posted (edited)

I use "Playback Correction..." to force it to transcode, same issue.

 

I send a debug log from android tv app again

 

utc time:  2019/3/23 16:30    

utc+8 time: 2019/3/24 00:30

Emby user : wolong

Emby server ip: 172.16.0.9

 

AndroidTv 1.6.96g

 

https://pt.wozz.top/test3.jpg

Edited by wolong_zb
Link to comment
Share on other sites
chali

chali   11

Posted
Posted

what happens if you set the bitrate to AUTO in Emby tv app?  it sound like you trying to create a larger file then what you have.  so try it to Auto, if it still acting up try to set 720p to 1mb/s, does it play fine? 

I had this problem in the beginning when i tried to use a larger bitrate then what the mkv file was 

 

I use "Playback Correction..." to force it to transcode, same issue.

 

I send a debug log from android tv app again

 

utc time:  2019/3/23 16:30    

utc+8 time: 2019/3/24 00:30

Emby user : wolong

Emby server ip: 172.16.0.9

 

AndroidTv 1.6.96g

 

https://pt.wozz.top/test3.jpg

Link to comment
Share on other sites
wolong_zb

wolong_zb   8

Posted
  • Author
Posted (edited)

I use "Playback Correction..." to force it to transcode, same issue.

 

I send a debug log from android tv app again

 

utc time:  2019/3/23 16:30    

utc+8 time: 2019/3/24 00:30

Emby user : wolong

Emby server ip: 172.16.0.9

 

AndroidTv 1.6.96g

 

https://pt.wozz.top/test3.jpg

 

When playing, the CPU  is very low

 

 

Mem: 927876K used, 180616K free, 0K shrd, 4104K buff, 91144K cached
CPU:  4.0% usr  2.2% sys  0.0% nic 93.2% idle  0.2% io  0.0% irq  0.1% sirq
Load average: 1.50 1.78 1.86 2/1369 27523
  PID  PPID USER     STAT   VSZ %VSZ CPU %CPU COMMAND
26258   146 10163    R    1566m144.4   3  1.4 tv.emby.embyatv
  165   130 0        S     724m 66.7   2  1.0 /applications/bin/tvos
  115     1 1000     S <   416m 38.3   2  0.7 /system/bin/surfaceflinger
  520   146 1000     S <  1406m129.6   2  0.5 system_server
  109     1 1036     S    26324  2.3   3  0.4 /system/bin/logd
  121     1 1013     S     947m 87.3   2  0.3 /system/bin/mediaserver
 1047   146 10052    S    1319m121.6   1  0.2 {eanbacklauncher} com.google.android.leanbacklauncher
24189   146 10053    S    1288m118.7   3  0.2 {om.shafa.market} com.shafa.market
25726     2 0        SW       0  0.0   0  0.2 [kworker/0:3]
 2707   146 1000     S    1260m116.2   1  0.2 {an.airkan.tvbox} com.duokan.airkan.tvbox
27217   146 10058    S    1274m117.5   0  0.1 {m.starcor.mango} com.starcor.mango
  125     1 1000     S    16528  1.4   0  0.1 /system/bin/sensord
23801   146 10054    S    1294m119.3   1  0.1 {ay.happyplay.aw} com.hpplay.happyplay.aw
27354 27352 0        R     2256  0.2   1  0.0 busybox top
23985   146 1000     S    1296m119.4   2  0.0 com.mi.umi
 
 
 
 
I/System.out(26258): Adding request to queue: http://172.16.0.9:8096/emby/Sessions/Playing/Progress
I/System.out(26258): Response received from: http://172.16.0.9:8096/emby/Sessions/Playing/Progress
D/EventLogger(26258): droppedFrames [383.39, 379.59, window=0, period=0, 152]
W/AudioTrack(26258): Spurious audio timestamp (frame position mismatch): 6597776, 239689290071, 239689290658, 379712000, 18233856, 18233856
W/AudioTrack(26258): Spurious audio timestamp (frame position mismatch): 6622256, 239689800094, 239689800569, 380224000, 18258432, 18258432
W/AudioTrack(26258): Spurious audio timestamp (frame position mismatch): 6652974, 239690440063, 239690440662, 380864000, 18290688, 18290688
W/AudioTrack(26258): Spurious audio timestamp (frame position mismatch): 6677934, 239690960049, 239690960587, 381376000, 18315264, 18315264
W/AudioTrack(26258): Spurious audio timestamp (frame position mismatch): 6708656, 239691600081, 239691600705, 382016000, 18347520, 18347520
W/AudioTrack(26258): Spurious audio timestamp (frame position mismatch): 6733134, 239692110063, 239692110533, 382528000, 18370560, 18370560
W/AudioTrack(26258): Spurious audio timestamp (frame position mismatch): 6763614, 239692745058, 239692745671, 383168000, 18402816, 18402816
D/EventLogger(26258): droppedFrames [387.37, 383.57, window=0, period=0, 79]
W/AudioTrack(26258): Spurious audio timestamp (frame position mismatch): 6789534, 239693285058, 239693285657, 383701333, 18427392, 18427392
W/AudioTrack(26258): Spurious audio timestamp (frame position mismatch): 6814016, 239693795075, 239693795731, 384213333, 18451968, 18451968
W/AudioTrack(26258): Spurious audio timestamp (frame position mismatch): 6838496, 239694305096, 239694305729, 384725333, 18476544, 18476544
W/AudioTrack(26258): Spurious audio timestamp (frame position mismatch): 6862974, 239694815065, 239694815767, 385237333, 18501120, 18501120
W/AudioTrack(26258): Spurious audio timestamp (frame position mismatch): 6887694, 239695330064, 239695330689, 385749333, 18525696, 18525696
W/AudioTrack(26258): Spurious audio timestamp (frame position mismatch): 6912174, 239695840057, 239695840680, 386261333, 18550272, 18550272
W/AudioTrack(26258): Spurious audio timestamp (frame position mismatch): 6936654, 239696350056, 239696350605, 386773333, 18574848, 18574848
D/EventLogger(26258): droppedFrames [391.38, 387.58, window=0, period=0, 50]
W/AudioTrack(26258): Spurious audio timestamp (frame position mismatch): 6979854, 239697250059, 239697250572, 387669333, 18617856, 18617856
D/EventLogger(26258): droppedFrames [391.88, 388.08, window=0, period=0, 60]
W/AudioTrack(26258): Spurious audio timestamp (frame position mismatch): 7006256, 239697800070, 239697800668, 388224000, 18642432, 18642432
W/AudioTrack(26258): Spurious audio timestamp (frame position mismatch): 7031214, 239698320055, 239698320418, 388736000, 18665472, 18665472
I/System.out(26258): Adding request to queue: http://172.16.0.9:8096/emby/Sessions/Playing/Progress
I/System.out(26258): Response received from: http://172.16.0.9:8096/emby/Sessions/Playing/Progress
W/AudioTrack(26258): Spurious audio timestamp (frame position mismatch): 7067694, 239699080057, 239699080640, 389504000, 18706944, 18706944
W/AudioTrack(26258): Spurious audio timestamp (frame position mismatch): 7092656, 239699600090, 239699600693, 390016000, 18731520, 18731520
W/AudioTrack(26258): Spurious audio timestamp (frame position mismatch): 7117134, 239700110066, 239700110586, 390528000, 18756096, 18756096
W/AudioTrack(26258): Spurious audio timestamp (frame position mismatch): 7147854, 239700750060, 239700750650, 391168000, 18786816, 18786816
W/AudioTrack(26258): Spurious audio timestamp (frame position mismatch): 7172336, 239701260073, 239701260725, 391680000, 18811392, 18811392
W/AudioTrack(26258): Spurious audio timestamp (frame position mismatch): 7196814, 239701770055, 239701770593, 392192000, 18835968, 18835968
Edited by wolong_zb
Link to comment
Share on other sites
wolong_zb

wolong_zb   8

Posted
  • Author
Posted
I/System.out(26258): *** Setting track info

D/EventLogger(26258): mediaPeriodReadingStarted [0.93, 0.00, window=0, period=0]

D/EventLogger(26258): downstreamFormatChanged [0.93, 0.00, window=0, period=0, id=1, mimeType=video/avc, res=1920x750]

E/ACodec  (26258): [OMX.MS.AVC.Decoder] storeMetaDataInBuffers failed w/ err -2147483648

W/ACodec  (26258): [OMX.MS.AVC.Decoder] prepareForAdaptivePlayback failed w/ err -2147483648

W/ACodec  (26258): [OMX.MS.AVC.Decoder] setting nBufferCountActual to 6 failed: -2147483648

W/ACodec  (26258): [OMX.MS.AVC.Decoder] setting nBufferCountActual to 5 failed: -2147483648

D/EventLogger(26258): decoderInitialized [0.99, 0.00, window=0, period=0, video, OMX.MS.AVC.Decoder]

D/EventLogger(26258): decoderInputFormatChanged [0.99, 0.00, window=0, period=0, video, id=1, mimeType=video/avc, res=1920x750]

D/EventLogger(26258): downstreamFormatChanged [0.99, 0.00, window=0, period=0, id=2, mimeType=audio/vnd.dts, channels=6, sample_rate=48000, language=eng]

D/EventLogger(26258): decoderInitialized [1.06, 0.00, window=0, period=0, audio, ffmpegLavc58.14.100-dca]

D/EventLogger(26258): decoderInputFormatChanged [1.07, 0.00, window=0, period=0, audio, id=2, mimeType=audio/vnd.dts, channels=6, sample_rate=48000, language=eng]

V/AudioSystem(26258): getOutputSamplingRate() reading from output desc

V/AudioSystem(26258): getSamplingRate() output 2, sampling rate 48000

V/AudioSystem(26258): getFrameCount() output 2, frameCount 1024

V/AudioSystem(26258): getLatency() output 2, latency 10

V/AudioSystem(26258): getLatency() output 2, latency 10

V/AudioSystem(26258): getFrameCount() output 2, frameCount 1024

V/AudioSystem(26258): getOutputSamplingRate() reading from output desc

V/AudioSystem(26258): getSamplingRate() output 2, sampling rate 48000

V/AudioFlinger(  121): acquiring 1141 from 26258, for 26258

D/EventLogger(26258): audioSessionId [1.10, 0.00, window=0, period=0, 1141]

D/EventLogger(26258): videoSizeChanged [1.12, 0.00, window=0, period=0, 1920, 750]

D/EventLogger(26258): renderedFirstFrame [1.13, 0.00, window=0, period=0, Surface(name=null)/@0x302f3bfa]

D/EventLogger(26258): surfaceSizeChanged [1.16, 0.00, window=0, period=0, 1920, 750]

D/EventLogger(26258): state [1.24, 0.00, window=0, period=0, true, READY]

I/System.out(26258): ******** Exoplayer state change to: true/3

I/System.out(26258): Display prefs loaded from cache 61745

I/System.out(26258): Play method: Direct

I/System.out(26258): Selecting default sub stream: 4

I/System.out(26258): Setting subtitle index to: 4

I/System.out(26258): *** Setting Exo subtitle track to index 0

I/System.out(26258): Multiple Audio tracks found: 3

I/System.out(26258): Subtitle tracks found: 3

I/System.out(26258): Emby audio track: {"BitRate":640000,"ChannelLayout":"5.1","Channels":6,"Codec":"ac3","CodecTimeBase":"1/48000","DisplayTitle":"Chi Dolby Digital 5.1","Index":2,"IsDefault":false,"IsExternal":false,"IsForced":false,"IsInterlaced":false,"Language":"chi","Level":0.0,"SampleRate":48000,"SupportsExternalStream":false,"TimeBase":"1/1000","Type":"Audio"}

I/System.out(26258): Exo audio track: {"accessibilityChannel":-1,"bitrate":-1,"channelCount":6,"encoderDelay":0,"encoderPadding":0,"frameRate":-1.0,"hashCode":0,"height":-1,"id":"2","initializationData":[],"language":"eng","maxInputSize":-1,"pcmEncoding":-1,"pixelWidthHeightRatio":1.0,"rotationDegrees":0,"sampleMimeType":"audio/vnd.dts","sampleRate":48000,"selectionFlags":1,"stereoMode":-1,"subsampleOffsetUs":9223372036854775807,"width":-1}

I/System.out(26258): Exo audio track: {"accessibilityChannel":-1,"bitrate":-1,"channelCount":6,"encoderDelay":0,"encoderPadding":0,"frameRate":-1.0,"hashCode":0,"height":-1,"id":"3","initializationData":[],"language":"chi","maxInputSize":-1,"pcmEncoding":-1,"pixelWidthHeightRatio":1.0,"rotationDegrees":0,"sampleMimeType":"audio/ac3","sampleRate":48000,"selectionFlags":0,"stereoMode":-1,"subsampleOffsetUs":9223372036854775807,"width":-1}

I/System.out(26258): Found matching audio track at renderer 2 group: 1

D/EventLogger(26258): state [1.47, 0.00, window=0, period=0, false, READY]

I/System.out(26258): ******** Exoplayer state change to: false/3

I/System.out(26258): *** Setting Exo audio track to group 1 index 0

D/EventLogger(26258): state [1.47, 0.00, window=0, period=0, true, READY]

I/System.out(26258): ******** Exoplayer state change to: true/3

D/EventLogger(26258): seekStarted [1.48, 0.00, window=0, period=0]

D/EventLogger(26258): positionDiscontinuity [1.48, 594.81, window=0, period=0, SEEK]

I/System.out(26258): **** Time Left: 3988861

I/System.out(26258): Emby audio track: {"BitRate":640000,"ChannelLayout":"5.1","Channels":6,"Codec":"ac3","CodecTimeBase":"1/48000","DisplayTitle":"Chi Dolby Digital 5.1","Index":2,"IsDefault":false,"IsExternal":false,"IsForced":false,"IsInterlaced":false,"Language":"chi","Level":0.0,"SampleRate":48000,"SupportsExternalStream":false,"TimeBase":"1/1000","Type":"Audio"}

I/System.out(26258): Exo audio track: {"accessibilityChannel":-1,"bitrate":-1,"channelCount":6,"encoderDelay":0,"encoderPadding":0,"frameRate":-1.0,"hashCode":-1752689090,"height":-1,"id":"2","initializationData":[],"language":"eng","maxInputSize":-1,"pcmEncoding":-1,"pixelWidthHeightRatio":1.0,"rotationDegrees":0,"sampleMimeType":"audio/vnd.dts","sampleRate":48000,"selectionFlags":1,"stereoMode":-1,"subsampleOffsetUs":9223372036854775807,"width":-1}

I/System.out(26258): Exo audio track: {"accessibilityChannel":-1,"bitrate":-1,"channelCount":6,"encoderDelay":0,"encoderPadding":0,"frameRate":-1.0,"hashCode":880006706,"height":-1,"id":"3","initializationData":[],"language":"chi","maxInputSize":-1,"pcmEncoding":-1,"pixelWidthHeightRatio":1.0,"rotationDegrees":0,"sampleMimeType":"audio/ac3","sampleRate":48000,"selectionFlags":0,"stereoMode":-1,"subsampleOffsetUs":9223372036854775807,"width":-1}

I/System.out(26258): Found matching audio track at renderer 2 group: 1

D/EventLogger(26258): state [1.53, 594.81, window=0, period=0, false, READY]

I/System.out(26258): ******** Exoplayer state change to: false/3

I/System.out(26258): *** Setting Exo audio track to group 1 index 0

D/EventLogger(26258): state [1.53, 594.81, window=0, period=0, true, READY]

I/System.out(26258): ******** Exoplayer state change to: true/3

D/EventLogger(26258): downstreamFormatChanged [1.64, 594.81, window=0, period=0, id=5, mimeType=application/x-subrip, language=chi]

D/EventLogger(26258): decoderDisabled [1.78, 594.81, window=0, period=0, audio]

D/EventLogger(26258): decoderEnabled [1.78, 594.81, window=0, period=0, audio]

D/EventLogger(26258): droppedFrames [1.78, 594.81, window=0, period=0, 1]

V/AudioFlinger(  121): releasing 1141 from 26258 for 26258

D/EventLogger(26258): tracksChanged [1.79, 594.81, window=0, period=0, 

D/EventLogger(26258):   Renderer:0 [

D/EventLogger(26258):     Group:0, adaptive_supported=N/A [

D/EventLogger(26258):       [X] Track:0, id=1, mimeType=video/avc, res=1920x750, supported=YES

D/EventLogger(26258):     ]

D/EventLogger(26258):   ]

D/EventLogger(26258):   Renderer:2 [

D/EventLogger(26258):     Group:0, adaptive_supported=N/A [

D/EventLogger(26258):       [ ] Track:0, id=2, mimeType=audio/vnd.dts, channels=6, sample_rate=48000, language=eng, supported=YES

D/EventLogger(26258):     ]

D/EventLogger(26258):     Group:1, adaptive_supported=N/A [

D/EventLogger(26258):       [X] Track:0, id=3, mimeType=audio/ac3, channels=6, sample_rate=48000, language=chi, supported=YES

D/EventLogger(26258):     ]

D/EventLogger(26258):     Group:2, adaptive_supported=N/A [

D/EventLogger(26258):       [ ] Track:0, id=4, mimeType=audio/mp4a-latm, channels=2, sample_rate=48000, language=eng, supported=YES

D/EventLogger(26258):     ]

D/EventLogger(26258):   ]

D/EventLogger(26258):   Renderer:4 [

D/EventLogger(26258):     Group:0, adaptive_supported=N/A [

D/EventLogger(26258):       [X] Track:0, id=5, mimeType=application/x-subrip, language=chi, supported=YES

D/EventLogger(26258):     ]

D/EventLogger(26258):     Group:1, adaptive_supported=N/A [

D/EventLogger(26258):       [ ] Track:0, id=6, mimeType=application/x-subrip, language=und, supported=YES

D/EventLogger(26258):     ]

D/EventLogger(26258):     Group:2, adaptive_supported=N/A [

D/EventLogger(26258):       [ ] Track:0, id=7, mimeType=application/x-subrip, language=eng, supported=YES

D/EventLogger(26258):     ]

D/EventLogger(26258):   ]

D/EventLogger(26258): ]

I/System.out(26258): *** Setting track info

D/EventLogger(26258): state [1.79, 594.81, window=0, period=0, true, BUFFERING]

I/System.out(26258): ******** Exoplayer state change to: true/2

D/EventLogger(26258): seekProcessed [1.79, 594.81, window=0, period=0]

V/AudioFlinger(  121): removeClient_l() pid 26258, calling pid 121

D/EventLogger(26258): downstreamFormatChanged [1.90, 594.81, window=0, period=0, id=3, mimeType=audio/ac3, channels=6, sample_rate=48000, language=chi]

D/EventLogger(26258): decoderInitialized [1.91, 594.81, window=0, period=0, audio, ffmpegLavc58.14.100-ac3]

D/EventLogger(26258): decoderInputFormatChanged [1.91, 594.81, window=0, period=0, audio, id=3, mimeType=audio/ac3, channels=6, sample_rate=48000, language=chi]

I/System.out(26258): **** Time Left: 3988861

I/System.out(26258): Adding request to queue: http://172.16.0.9:8096/emby/Sessions/Playing/Progress

I/System.out(26258): Response received from: http://172.16.0.9:8096/emby/Sessions/Playing/Progress

V/AudioSystem(26258): getOutputSamplingRate() reading from output desc

V/AudioSystem(26258): getSamplingRate() output 2, sampling rate 48000

V/AudioSystem(26258): getFrameCount() output 2, frameCount 1024

V/AudioSystem(26258): getLatency() output 2, latency 10

V/AudioSystem(26258): getLatency() output 2, latency 10

V/AudioSystem(26258): getFrameCount() output 2, frameCount 1024

V/AudioSystem(26258): getOutputSamplingRate() reading from output desc

V/AudioSystem(26258): getSamplingRate() output 2, sampling rate 48000

V/AudioFlinger(  121): acquiring 1142 from 26258, for 26258

D/EventLogger(26258): audioSessionId [2.24, 594.81, window=0, period=0, 1142]

D/EventLogger(26258): renderedFirstFrame [2.37, 594.81, window=0, period=0, Surface(name=null)/@0x302f3bfa]

D/EventLogger(26258): state [2.54, 594.81, window=0, period=0, true, READY]

I/System.out(26258): ******** Exoplayer state change to: true/3

D/EventLogger(26258): droppedFrames [4.56, 596.34, window=0, period=0, 4]

D/EventLogger(26258): state [4.56, 596.85, window=0, period=0, true, BUFFERING]

I/System.out(26258): ******** Exoplayer state change to: true/2

D/EventLogger(26258): state [4.99, 596.85, window=0, period=0, true, READY]

I/System.out(26258): ******** Exoplayer state change to: true/3

D/EventLogger(26258): droppedFrames [10.60, 602.53, window=0, period=0, 158]

I/System.out(26258): Adding request to queue: http://172.16.0.9:8096/emby/Sessions/Playing/Progress

I/System.out(26258): Response received from: http://172.16.0.9:8096/emby/Sessions/Playing/Progress

D/EventLogger(26258): droppedFrames [15.52, 607.43, window=0, period=0, 110]

Link to comment
Share on other sites
ebr Emby Team

ebr   14958

Posted
Posted

Other than a better box and/or re-encode of the media, I'm not sure there is.

 

It is hard to tell if this is a bad encode or a bad implementation in the hardware/software.

Link to comment
Share on other sites
wolong_zb

wolong_zb   8

Posted
  • Author
Posted

Other than a better box and/or re-encode of the media, I'm not sure there is.

 

It is hard to tell if this is a bad encode or a bad implementation in the hardware/software.

 

 

If you install Emby mobile Apps in MiTV3, play video basically smooth and slightly jammed.

Is there any difference between the video decoding implementation of these two players?

Link to comment
Share on other sites

Create an account or sign in to comment

You need to be a member in order to leave a comment

Create an account

Sign up for a new account in our community. It's easy!

Register a new account

Sign in

Already have an account? Sign in here.

Sign In Now
 Share
Go to topic listing
×
×
  • Create New...