mxplayer didn't send onCompletion message

allen_kim1 — Mon, 12 Sep 2016 09:44:25 GMT

Dear Community

our customer has a problem on android (5.1.1_2.1.0 GA , imx6Q SDB)

phenomenon : some movie clip doesn't play on background mode ( movie clip of continuously play is OK in forground mode ) , they also use MXplayer ( in google play store )

MXplayer has a function that is continuously play (that is why they use MXplayer )

They want continuously play in backgroud mode but some movie clip cannot play on backgroud mode

Also they cross check that movie clip tested on galxy note 3

in Galxy note 3 is OK ( movie clip's continuously play is OK on background mode )

in MXplayer has a selection of SW codec or HW codec , They also selected HW codec

i don't know what root cause in this problem

1 some movie clip : maybe that clip corrupted file ?

2 MXplayer : maybe that player has a bug ?

i know omxplayer ( freescale ) but omxplayer has not function of continuously play

i will attach movie clip

abnormal log --------------------------------------------------------------------------------------------------------------------------------

----------------------------------------------------------------------------------------------------------------------------------------------------

normal log -----------------------------------------------------------------------------------------------------------------------------------------

01-01 02:18:16.186 W/audio_hw_primary( 212): do_out_standby... -1249270016
01-01 02:18:19.512 W/AudioTrack( 488): AUDIO_OUTPUT_FLAG_FAST denied by client
--------- beginning of system
01-01 02:18:19.516 I/ActivityManager( 488): START u0 {act=android.intent.action.VIEW dat=file:///storage/extsd/RecordFiles/CH01-20160721-163821-163852.avi cmp=com.mxtech.videoplayer.ad/.ActivityScreen (has extras)} from uid 10048 on display 0
01-01 02:18:19.516 I/audio_hw_primary( 212): start_output_stream... -1249270016, device 2
01-01 02:18:19.521 V/WindowManager( 488): addAppToken: AppWindowToken{1ef913bd token=Token{136fef14 ActivityRecord{58c5567 u0 com.mxtech.videoplayer.ad/.ActivityScreen t38}}} to stack=1 task=38 at 1
01-01 02:18:19.536 V/MX.Player.Screen( 1779): onCreate (com.mxtech.videoplayer.ad.ActivityScreen@1c263fae) dat=file:///storage/extsd/RecordFiles/CH01-20160721-163821-163852.avi
01-01 02:18:19.536 V/MX.Player.Screen( 1779): << Extra >>
01-01 02:18:19.536 V/MX.Player.Screen( 1779): 1) video_list=[Landroid.os.Parcelable;@1244514f
01-01 02:18:19.562 W/audio_hw_primary( 212): card 0, port 0 device 0x2
01-01 02:18:19.562 W/audio_hw_primary( 212): rate 44100, channel 2 period_size 0xc0
01-01 02:18:19.562 I/AppCompatViewInflater( 1779): app:theme is now deprecated. Please move to using android:theme instead.
01-01 02:18:19.568 I/AppCompatViewInflater( 1779): app:theme is now deprecated. Please move to using android:theme instead.
01-01 02:18:19.585 V/MX.Player.MediaUtils( 1779): Canonicalizing URI file:///storage/extsd/RecordFiles/CH01-20160721-163821-163852.avi -> file:///storage/extsd/RecordFiles/CH01-20160721-163821-163852.avi
01-01 02:18:19.590 I/MediaFocusControl( 488): AudioFocus abandonAudioFocus() from android.media.AudioManager@c09d916dga@15aa8f62
01-01 02:18:19.591 D/MX.Player.AudioFocus( 1779): Abandon granted.
01-01 02:18:19.592 V/MX.Player.FF( 1779): === Begin closing soft player
01-01 02:18:19.594 V/PhoneStatusBar( 573): DEBUG_MEDIA: Disconnecting from old controller: android.media.session.MediaController@a127947
01-01 02:18:19.595 V/MX.Player.FF( 1779): === End closing soft player
01-01 02:18:19.595 V/MX.Player.Builtin( 1779): === Begin closing built-in player
01-01 02:18:19.596 I/OMXPlayer( 212): GMPlayer Stop
01-01 02:18:19.612 V/MX.Player.Builtin( 1779): === End closing built-in player
01-01 02:18:19.612 V/MX.Player.MediaUtils( 1779): Canonicalizing URI file:///storage/extsd/RecordFiles/CH01-20160721-163821-163852.avi -> file:///storage/extsd/RecordFiles/CH01-20160721-163821-163852.avi
01-01 02:18:19.612 V/MX.Player.MediaUtils( 1779): Canonicalizing URI file:///storage/extsd/RecordFiles/CH01-20160721-163906-165005.avi -> file:///storage/extsd/RecordFiles/CH01-20160721-163906-165005.avi
01-01 02:18:19.612 V/MX.Player.MediaUtils( 1779): Canonicalizing URI file:///storage/extsd/RecordFiles/CH04-20160722-043343-043402.avi -> file:///storage/extsd/RecordFiles/CH04-20160722-043343-043402.avi
01-01 02:18:19.613 V/MX.Player.MediaUtils( 1779): Canonicalizing URI file:///storage/extsd/RecordFiles/CH04-20160725-085559-085724.avi -> file:///storage/extsd/RecordFiles/CH04-20160725-085559-085724.avi
01-01 02:18:19.613 V/MX.Player.Player( 1779): Canonicalizing URI(2) file:///storage/extsd/RecordFiles/CH01-20160721-163821-163852.avi -> file:///storage/extsd/RecordFiles/CH01-20160721-163821-163852.avi
01-01 02:18:19.614 V/MX.Player.Screen( 1779): onStart (com.mxtech.videoplayer.ad.ActivityScreen@1c263fae): video-uri=file:///storage/extsd/RecordFiles/CH01-20160721-163821-163852.avi
01-01 02:18:19.615 I/MediaFocusControl( 488): AudioFocus requestAudioFocus() from android.media.AudioManager@c09d916dga@1bed66c2 req=1flags=0x0
01-01 02:18:19.616 D/MX.Player.AudioFocus( 1779): Request granted.
01-01 02:18:19.616 V/MX.DeviceUtils( 1779): Brightness for com.android.internal.policy.impl.PhoneWindow@35700cd3: -1.0 --> 0.5
01-01 02:18:19.623 V/MX.Player.Screen( 1779): onResume (com.mxtech.videoplayer.ad.ActivityScreen@1c263fae): uri=file:///storage/extsd/RecordFiles/CH01-20160721-163821-163852.avi
01-01 02:18:19.628 V/WindowManager( 488): Adding window Window{2093fd75 u0 com.mxtech.videoplayer.ad/com.mxtech.videoplayer.ad.ActivityScreen} at 3 of 8 (after Window{359d758f u0 com.mxtech.videoplayer.ad/com.mxtech.videoplayer.ad.ActivityMediaList})
01-01 02:18:19.672 E/BufferQueueProducer( 206): [com.mxtech.videoplayer.ad/com.mxtech.videoplayer.ad.ActivityScreen] dequeueBuffer: can't dequeue multiple buffers without setting the buffer count
01-01 02:18:19.681 V/WindowManager( 488): Adding window Window{21b3fbf1 u0 SurfaceView} at 3 of 9 (before Window{2093fd75 u0 com.mxtech.videoplayer.ad/com.mxtech.videoplayer.ad.ActivityScreen})
01-01 02:18:19.695 D/MX.Player.Screen( 1779): === Enter surfaceCreated. holder=android.view.SurfaceView$4@3ecb4ac5 _surfaceHolderCreated=null_surfaceView=android.view.SurfaceView{6b50c1a V.E..... ......ID 0,0-1024,768 #7f0f0025 app:id/surfaceView}
01-01 02:18:19.695 V/MX.Player.Screen( 1779): HW Accel=true
01-01 02:18:19.698 D/MX.Player.Screen( 1779): === Leave surfaceCreated.
01-01 02:18:19.788 I/ActivityManager( 488): Displayed com.mxtech.videoplayer.ad/.ActivityScreen: +261ms
01-01 02:18:19.795 D/MX.Player.Builtin( 1779): Calibrating 0ms
01-01 02:18:19.797 V/MX.Player.Joint( 1779): Creating a joint player. 1st=cng@b077d40 2nd=com.mxtech.media.FFPlayer@19da0479 mix=0
01-01 02:18:19.798 D/MX.Player.Screen( 1779): Set fullscreen = false
01-01 02:18:19.804 V/MX.Player.MediaUtils( 1779): Canonicalizing URI file:///storage/extsd/RecordFiles/CH01-20160721-163821-163852.avi -> file:///storage/extsd/RecordFiles/CH01-20160721-163821-163852.avi
01-01 02:18:19.871 D/OpenGLRenderer( 1779): endAllStagingAnimators on 0x8e557f00 (FlatListView) with handle 0x90bb5520
01-01 02:18:19.943 I/MX ( 1779): 1894 | Container format='avi'
01-01 02:18:19.943 I/MX.FFmpeg( 1779): Input #0, avi, from '(null)':
01-01 02:18:19.943 I/MX.FFmpeg( 1779): Duration:
01-01 02:18:19.943 I/MX.FFmpeg( 1779): 00:00:32.03
01-01 02:18:19.943 I/MX.FFmpeg( 1779): , start:
01-01 02:18:19.943 I/MX.FFmpeg( 1779): 0.000000
01-01 02:18:19.943 I/MX.FFmpeg( 1779): , bitrate:
01-01 02:18:19.943 I/MX.FFmpeg( 1779): 1056 kb/s
01-01 02:18:19.943 I/MX.FFmpeg( 1779):
01-01 02:18:19.943 I/MX.FFmpeg( 1779): Stream #0:0
01-01 02:18:19.943 I/MX.FFmpeg( 1779): : Video: h264 (Main) (H264 / 0x34363248), yuv420p, 704x240, 1051 kb/s
01-01 02:18:19.943 I/MX.FFmpeg( 1779): ,
01-01 02:18:19.943 I/MX.FFmpeg( 1779): 29.97 fps,
01-01 02:18:19.943 I/MX.FFmpeg( 1779): 29.97 tbr,
01-01 02:18:19.943 I/MX.FFmpeg( 1779): 29.97 tbn,
01-01 02:18:19.943 I/MX.FFmpeg( 1779): 59.94 tbc
01-01 02:18:19.943 I/MX.FFmpeg( 1779):
01-01 02:18:19.944 W/MX.MediaPlayer( 1779): 1894 | audio stream finding failed. status=-1381258232
01-01 02:18:19.944 W/MX.MediaPlayer( 1779): 1894 | Best subtitle stream finding failed. status=-1381258232
01-01 02:18:19.944 I/MX.MediaPlayer( 1779): 1894 | start_time: 0ms, duration: 32031ms
01-01 02:18:19.947 I/OMXPlayer( 212): Loading content: sharedfd://29:0:4229898:0
01-01 02:18:19.947 I/OMXPlayer( 212): LEVEL: 1 FUNCTION: MediaTypeInspect LINE: 1965
01-01 02:18:19.947 I/OMXPlayer( 212): Can't inspect media content type by subfix.
01-01 02:18:19.947 I/OMXPlayer( 212): MediaTypeInspectByContent role: parser.avi
01-01 02:18:19.971 I/OMXPlayer( 212): Core parser AVI_PARSER_03.05.20 build on May 25 2015 17:01:24
01-01 02:18:19.972 I/OMXPlayer( 212): LEVEL: 1 FUNCTION: ExportIndexTable LINE: 175
01-01 02:18:19.972 I/OMXPlayer( 212): Fail to open index file to export index: sharedfd://.idx
01-01 02:18:20.027 I/OMXPlayer( 212): nPreCacheSize = 132184
01-01 02:18:20.039 I/vpu-lib ( 212): <gpu> alloc handle: 0xb599f0a0, paddr: 0x2763a000, vaddr: 0xa6c5e000
01-01 02:18:20.039 I/vpu-lib ( 212): <gpu> alloc handle: 0xb599f0e0, paddr: 0x27964000, vaddr: 0xa6f88000
01-01 02:18:20.040 I/vpu-lib ( 212): <gpu> alloc handle: 0xb599f160, paddr: 0x279a3000, vaddr: 0xa6fc7000
01-01 02:18:20.048 I/vpu-lib ( 212): Product Info: i.MX6Q/D/S
01-01 02:18:20.053 I/vpu-lib ( 212): <gpu> alloc handle: 0xb599f1c0, paddr: 0x29a0c000, vaddr: 0xa9030000
01-01 02:18:20.054 I/vpu-lib ( 212): <gpu> alloc handle: 0xb599f1e0, paddr: 0x287a0000, vaddr: 0xa7dc4000
01-01 02:18:20.054 I/vpu-lib ( 212): bitstreamMode 1, chromaInterleave 1, mapType 0, tiled2LinearEnable 0
01-01 02:18:20.072 I/vpu-lib ( 212): <gpu> free handle: 0xb599f0a0, paddr: 0x2763a000, vaddr: 0xa6c5e000
01-01 02:18:20.072 I/vpu-lib ( 212): <gpu> free handle: 0xb599f0e0, paddr: 0x27964000, vaddr: 0xa6f88000
01-01 02:18:20.072 I/vpu-lib ( 212): <gpu> free handle: 0xb599f160, paddr: 0x279a3000, vaddr: 0xa6fc7000
01-01 02:18:20.093 I/OMXPlayer( 212): port index 1
01-01 02:18:20.093 I/vpu-lib ( 212): <gpu> alloc handle: 0xb599f190, paddr: 0x2894c000, vaddr: 0xa7f70000
01-01 02:18:20.094 V/MX.Player.Joint( 1779): Video size: 704 x 240
01-01 02:18:20.094 V/MX.Player.Joint( 1779): Primary width:704, Secondary width:704
01-01 02:18:20.094 V/MX.Player.Joint( 1779): Primary height:240, Secondary height:240
01-01 02:18:20.096 E/MediaPlayer( 1779): Should have subtitle controller already set
01-01 02:18:20.096 V/MX.Player.Joint( 1779): 1st prepared. duration=32031ms
01-01 02:18:20.098 D/MX.MediaPlayer( 1779): 1779 | [Audio] setVolumeModifier = 1.000000
01-01 02:18:20.098 D/MX.MediaPlayer( 1779): 1779 | [Audio] setVolumeModifier = 1.000000
01-01 02:18:20.101 V/MX.Player.Joint( 1779): start
01-01 02:18:20.103 W/MediaPlayer( 1779): info/warning (3, 0)

01-01 02:18:22.773 W/audio_hw_primary( 212): do_out_standby... -1249270016

01-01 02:18:23.291 V/MX.Player.Database( 1779): Release database. thread-contexts:1, reference-count:0

01-01 02:18:29.903 W/ScreenOrientationListener( 1779): Removing an inexistent observer!
01-01 02:18:51.803 I/OMXPlayer( 212): GetOneSample() send eos , track 0
01-01 02:18:52.002 I/OMXPlayer( 212): tsmGetFrmTs: warning: can't get one valid ts
01-01 02:18:52.103 I/OMXPlayer( 212): GMPlayer Pause
01-01 02:18:52.104 V/MX.Player.Database( 1779): Open database.
01-01 02:18:52.151 V/MX.Player.MediaUtils( 1779): Canonicalizing URI file:///storage/extsd/RecordFiles/CH01-20160721-163821-163852.avi -> file:///storage/extsd/RecordFiles/CH01-20160721-163821-163852.avi
01-01 02:18:52.154 V/MX.Player.FF( 1779): === Begin closing soft player
01-01 02:18:52.156 V/MX.Player.FF( 1779): === End closing soft player
01-01 02:18:52.156 V/MX.Player.Builtin( 1779): === Begin closing built-in player
01-01 02:18:52.156 I/OMXPlayer( 212): GMPlayer Stop
01-01 02:18:52.194 I/vpu-lib ( 212): <gpu> free handle: 0xb599f1e0, paddr: 0x287a0000, vaddr: 0xa7dc4000
01-01 02:18:52.194 I/vpu-lib ( 212): <gpu> free handle: 0xb599f1c0, paddr: 0x29a0c000, vaddr: 0xa9030000
01-01 02:18:52.194 I/vpu-lib ( 212): <gpu> free handle: 0xb599f190, paddr: 0x2894c000, vaddr: 0xa7f70000
01-01 02:18:52.205 E/BufferQueueProducer( 206): [SurfaceView] cancelBuffer: slot 0 is not owned by the producer (state = 0)
01-01 02:18:52.205 E/BufferQueueProducer( 206): [SurfaceView] cancelBuffer: slot 1 is not owned by the producer (state = 0)
01-01 02:18:52.206 E/BufferQueueProducer( 206): [SurfaceView] cancelBuffer: slot 2 is not owned by the producer (state = 0)
01-01 02:18:52.206 E/BufferQueueProducer( 206): [SurfaceView] cancelBuffer: slot 3 is not owned by the producer (state = 0)
01-01 02:18:52.229 V/MX.Player.Builtin( 1779): === End closing built-in player
01-01 02:18:52.230 V/MX.Player.Player( 1779): Canonicalizing URI(2) file:///storage/extsd/RecordFiles/CH01-20160721-163906-165005.avi -> file:///storage/extsd/RecordFiles/CH01-20160721-163906-165005.avi
01-01 02:18:52.233 D/MX.Player.Builtin( 1779): Calibrating 0ms
01-01 02:18:52.234 V/MX.Player.Joint( 1779): Creating a joint player. 1st=cng@3ad9fe96 2nd=com.mxtech.media.FFPlayer@38674a17 mix=0
01-01 02:18:52.235 D/MX.Player.Screen( 1779): Set fullscreen = false
01-01 02:18:52.236 V/MX.Player.MediaUtils( 1779): Canonicalizing URI file:///storage/extsd/RecordFiles/CH01-20160721-163821-163852.avi -> file:///storage/extsd/RecordFiles/CH01-20160721-163821-163852.avi
01-01 02:18:52.423 I/MX ( 1779): 1901 | Container format='avi'
01-01 02:18:52.423 I/MX.FFmpeg( 1779): Input #0, avi, from '(null)':
01-01 02:18:52.423 I/MX.FFmpeg( 1779): Duration:
01-01 02:18:52.423 I/MX.FFmpeg( 1779): 00:11:00.65
01-01 02:18:52.423 I/MX.FFmpeg( 1779): , start:
01-01 02:18:52.423 I/MX.FFmpeg( 1779): 0.000000
01-01 02:18:52.423 I/MX.FFmpeg( 1779): , bitrate:
01-01 02:18:52.424 I/MX.FFmpeg( 1779): 1055 kb/s
01-01 02:18:52.424 I/MX.FFmpeg( 1779):
01-01 02:18:52.424 I/MX.FFmpeg( 1779): Stream #0:0
01-01 02:18:52.424 I/MX.FFmpeg( 1779): : Video: h264 (Main) (H264 / 0x34363248), yuv420p, 704x240, 1050 kb/s
01-01 02:18:52.424 I/MX.FFmpeg( 1779): ,
01-01 02:18:52.424 I/MX.FFmpeg( 1779): 29.97 fps,
01-01 02:18:52.424 I/MX.FFmpeg( 1779): 29.97 tbr,
01-01 02:18:52.424 I/MX.FFmpeg( 1779): 29.97 tbn,
01-01 02:18:52.424 I/MX.FFmpeg( 1779): 59.94 tbc
01-01 02:18:52.424 I/MX.FFmpeg( 1779):
01-01 02:18:52.424 W/MX.MediaPlayer( 1779): 1901 | audio stream finding failed. status=-1381258232
01-01 02:18:52.424 W/MX.MediaPlayer( 1779): 1901 | Best subtitle stream finding failed. status=-1381258232
01-01 02:18:52.424 I/MX.MediaPlayer( 1779): 1901 | start_time: 0ms, duration: 660646ms
01-01 02:18:52.427 I/OMXPlayer( 212): Loading content: sharedfd://28:0:87193906:0
01-01 02:18:52.427 I/OMXPlayer( 212): LEVEL: 1 FUNCTION: MediaTypeInspect LINE: 1965
01-01 02:18:52.427 I/OMXPlayer( 212): Can't inspect media content type by subfix.
01-01 02:18:52.428 I/OMXPlayer( 212): MediaTypeInspectByContent role: parser.avi
01-01 02:18:52.449 I/OMXPlayer( 212): Core parser AVI_PARSER_03.05.20 build on May 25 2015 17:01:24
01-01 02:18:52.452 I/OMXPlayer( 212): LEVEL: 1 FUNCTION: ExportIndexTable LINE: 175
01-01 02:18:52.452 I/OMXPlayer( 212): Fail to open index file to export index: sharedfd://.idx
01-01 02:18:52.503 I/OMXPlayer( 212): nPreCacheSize = 132111
01-01 02:18:52.514 I/vpu-lib ( 212): <gpu> alloc handle: 0xb599f0d0, paddr: 0x2763a000, vaddr: 0xa6c5e000
01-01 02:18:52.515 I/vpu-lib ( 212): <gpu> alloc handle: 0xb599f150, paddr: 0x27964000, vaddr: 0xa6f88000
01-01 02:18:52.515 I/vpu-lib ( 212): <gpu> alloc handle: 0xb599f180, paddr: 0x279a3000, vaddr: 0xa6fc7000
01-01 02:18:52.517 I/vpu-lib ( 212): Product Info: i.MX6Q/D/S
01-01 02:18:52.520 I/vpu-lib ( 212): <gpu> alloc handle: 0xb599f1e0, paddr: 0x29a0c000, vaddr: 0xa9030000
01-01 02:18:52.521 I/vpu-lib ( 212): <gpu> alloc handle: 0xb599f200, paddr: 0x287a0000, vaddr: 0xa7dc4000
01-01 02:18:52.521 I/vpu-lib ( 212): bitstreamMode 1, chromaInterleave 1, mapType 0, tiled2LinearEnable 0
01-01 02:18:52.535 I/vpu-lib ( 212): <gpu> free handle: 0xb599f0d0, paddr: 0x2763a000, vaddr: 0xa6c5e000
01-01 02:18:52.535 I/vpu-lib ( 212): <gpu> free handle: 0xb599f150, paddr: 0x27964000, vaddr: 0xa6f88000
01-01 02:18:52.535 I/vpu-lib ( 212): <gpu> free handle: 0xb599f180, paddr: 0x279a3000, vaddr: 0xa6fc7000
01-01 02:18:52.546 I/OMXPlayer( 212): port index 1
01-01 02:18:52.546 I/vpu-lib ( 212): <gpu> alloc handle: 0xb599f1b0, paddr: 0x2898e000, vaddr: 0xa7fb2000
01-01 02:18:52.546 V/MX.Player.Joint( 1779): Video size: 704 x 240
01-01 02:18:52.546 V/MX.Player.Joint( 1779): Primary width:704, Secondary width:704
01-01 02:18:52.546 V/MX.Player.Joint( 1779): Primary height:240, Secondary height:240
01-01 02:18:52.548 E/MediaPlayer( 1779): Should have subtitle controller already set
01-01 02:18:52.549 V/MX.Player.Joint( 1779): 1st prepared. duration=660646ms
01-01 02:18:52.550 D/MX.MediaPlayer( 1779): 1779 | [Audio] setVolumeModifier = 1.000000
01-01 02:18:52.551 D/MX.MediaPlayer( 1779): 1779 | [Audio] setVolumeModifier = 1.000000
01-01 02:18:52.553 V/MX.Player.Joint( 1779): start
01-01 02:18:52.555 W/MediaPlayer( 1779): info/warning (3, 0)

i.MX Processorsのトピックmxplayer didn't send onCompletion message

mxplayer didn't send onCompletion message