Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Disable tunneling on internal Surface related Exceptions #9620

Closed
wants to merge 4 commits into from

Conversation

Redirion
Copy link
Member

@Redirion Redirion commented Jan 3, 2023

What is it?

  • Bugfix (user facing)
  • Feature (user facing)
  • Codebase improvement (dev facing)
  • Meta improvement to the project (dev facing)

Description of the changes in your PR

This PR tries to automatically disable media tunneling on unrecoverable internal player exceptions. Analysis was possible thanks to the stack trace provided in this comment: #9023 (comment)
In the past we tried to disable media tunneling on devices that claim to support it but fail to do so. This was not only device specific but also frustrating for users that would have to create an issue on Github to hope for help with a new version release. With the new ExoPlayer Settings page that is still a PR (#8875) we have a general approach. However most users would still first create an issue before they would learn about these settings. So an automatic recovery for at least some of the devices seems useful.

Fixes the following issue(s)

APK testing

The APK can be found by going to the "Checks" tab below the title. On the left pane, click on "CI", scroll down to "artifacts" and click "app" to download the zip file which contains the debug APK of this PR.

Due diligence

@Redirion Redirion added player Issues related to any player (main, popup and background) device/software specific Issues that only happen on some devices or with some specific hardware/software labels Jan 3, 2023
@peat80
Copy link

peat80 commented Jan 3, 2023

Tested on my Sony A90J.
Produces different behaviour:

Pressing full screen on normal release apk switches to fullscreen, stops playing and shows error toast.

Pressing fullscreen on this prs apk does not switch to fullsceen, shows error toast but keeps playing audio in the background.
Pressing then fullscreen a second time crashes the app.

Manually disabling media tunneling on debug builds gets the fullscreen toggle working on this tv.

@Redirion
Copy link
Member Author

Redirion commented Jan 3, 2023

Thank you for testing! Is it possible to check the logs? I would be interested about the logs around the line "ExoPlayer - onPlayerError() called with:"

@pbasista
Copy link

pbasista commented Jan 3, 2023

I have also tried the artifact from this PR on an Android TV by Philips. The result is similar to what @peat80 has described. The original issue with the full-screen playback is still present, although the audio keeps playing for some reason. According to the logs, the subsequent crash seems to be related to the tunneling.

Log from unsuccessful attempt to switch to the full-screen mode:
E Player  : ExoPlayer - onPlayerError() called with:
E Player  : com.google.android.exoplayer2.ExoPlaybackException: Unexpected runtime error
E Player  :      at com.google.android.exoplayer2.ExoPlayerImplInternal.handleMessage(ExoPlayerImplInternal.java:621)
E Player  :      at android.os.Handler.dispatchMessage(Handler.java:101)
E Player  :      at android.os.Looper.loop(Looper.java:164)
E Player  :      at android.os.HandlerThread.run(HandlerThread.java:65)
E Player  : Caused by: java.lang.IllegalArgumentException
E Player  :      at android.media.MediaCodec.native_setSurface(Native Method)
E Player  :      at android.media.MediaCodec.setOutputSurface(MediaCodec.java:1987)
E Player  :      at com.google.android.exoplayer2.mediacodec.SynchronousMediaCodecAdapter.setOutputSurface(SynchronousMediaCodecAdapter.java:189)
E Player  :      at com.google.android.exoplayer2.video.MediaCodecVideoRenderer.setOutputSurfaceV23(MediaCodecVideoRenderer.java:1490)
E Player  :      at com.google.android.exoplayer2.video.MediaCodecVideoRenderer.setOutput(MediaCodecVideoRenderer.java:693)
E Player  :      at com.google.android.exoplayer2.video.MediaCodecVideoRenderer.handleMessage(MediaCodecVideoRenderer.java:631)
E Player  :      at com.google.android.exoplayer2.ExoPlayerImplInternal.deliverMessage(ExoPlayerImplInternal.java:1550)
E Player  :      at com.google.android.exoplayer2.ExoPlayerImplInternal.sendMessageToTarget(ExoPlayerImplInternal.java:1514)
E Player  :      at com.google.android.exoplayer2.ExoPlayerImplInternal.sendMessageInternal(ExoPlayerImplInternal.java:1489)
E Player  :      at com.google.android.exoplayer2.ExoPlayerImplInternal.handleMessage(ExoPlayerImplInternal.java:526)
E Player  :      ... 3 more
Log from the subsequent crash when attempting to resume playback:
E AndroidRuntime: FATAL EXCEPTION: main
E AndroidRuntime: Process: org.schabi.newpipe.debug.surfacefix, PID: 7311
E AndroidRuntime: java.lang.NullPointerException: Attempt to read from field 'boolean com.google.android.exoplayer2.RendererConfiguration.tunneling' on a null object reference
E AndroidRuntime:        at com.google.android.exoplayer2.ExoPlayerImpl.isTunnelingEnabled(ExoPlayerImpl.java:1673)
E AndroidRuntime:        at org.schabi.newpipe.player.Player.onPlayerError(Player.java:1430)
E AndroidRuntime:        at com.google.android.exoplayer2.ExoPlayerImpl.lambda$updatePlaybackInfo$16(ExoPlayerImpl.java:1902)
E AndroidRuntime:        at com.google.android.exoplayer2.ExoPlayerImpl$$ExternalSyntheticLambda15.invoke(Unknown Source:4)
E AndroidRuntime:        at com.google.android.exoplayer2.util.ListenerSet$ListenerHolder.invoke(ListenerSet.java:282)
E AndroidRuntime:        at com.google.android.exoplayer2.util.ListenerSet.lambda$queueEvent$0(ListenerSet.java:190)
E AndroidRuntime:        at com.google.android.exoplayer2.util.ListenerSet$$ExternalSyntheticLambda1.run(Unknown Source:6)
E AndroidRuntime:        at com.google.android.exoplayer2.util.ListenerSet.flushEvents(ListenerSet.java:211)
E AndroidRuntime:        at com.google.android.exoplayer2.ExoPlayerImpl.updatePlaybackInfo(ExoPlayerImpl.java:1966)
E AndroidRuntime:        at com.google.android.exoplayer2.ExoPlayerImpl.handlePlaybackInfo(ExoPlayerImpl.java:1794)
E AndroidRuntime:        at com.google.android.exoplayer2.ExoPlayerImpl.lambda$new$1$com-google-android-exoplayer2-ExoPlayerImpl(ExoPlayerImpl.java:312)
E AndroidRuntime:        at com.google.android.exoplayer2.ExoPlayerImpl$$ExternalSyntheticLambda24.run(Unknown Source:4)
E AndroidRuntime:        at android.os.Handler.handleCallback(Handler.java:789)
E AndroidRuntime:        at android.os.Handler.dispatchMessage(Handler.java:98)
E AndroidRuntime:        at android.os.Looper.loop(Looper.java:164)
E AndroidRuntime:        at android.app.ActivityThread.main(ActivityThread.java:6541)
E AndroidRuntime:        at java.lang.reflect.Method.invoke(Native Method)
E AndroidRuntime:        at com.android.internal.os.Zygote$MethodAndArgsCaller.run(Zygote.java:240)
E AndroidRuntime:        at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:767)

@Redirion
Copy link
Member Author

Redirion commented Jan 4, 2023

Thank you @pbasista
Could you try again with the new build? The logging was not really working at all.

btw. please refrain commenting NewPipe issues on Google Repositories (ExoPlayer is Google). They naturally do not like what NewPipe does.

@pbasista
Copy link

pbasista commented Jan 4, 2023

Could you try again with the new build?

Yes. The updated version produces the following log message:

E Player  : ExoPlayer - onPlayerError() called with:Bundle[{0=1004, 1=16189049, 2=Unexpected runtime error, 3=java.lang.IllegalArgumentException, 4=null, rt=2, ru=null, rv=-1, rx=4, ry=false}]

@Redirion
Copy link
Member Author

Redirion commented Jan 4, 2023

looks like the new function "isTunnelingEnabled" of ExoPlayer 2.18.2 is not usable in this context. I have changed the check. Could you try yet again please?

@pbasista
Copy link

pbasista commented Jan 4, 2023

The application now does not crash when attempting to play the video again. It still would not play though. There is a notification on the screen suggesting to check the logs.

Here are the logs from an unsuccessful attempt to resume playback in full-screen mode.
E Player  : ExoPlayer - onPlayerError() called with:Bundle[{0=1004, 1=26846270, 2=Unexpected runtime error, 3=java.lang.IllegalArgumentException, 4=null, rt=2, ru=null, rv=-1, rx=4, ry=false}]
D Player  : saveStreamProgressState() called with: progressMillis=15692, currentMetadata=[Peru 8K HDR 60FPS (FUHD)]
D Player  : Unexpected PlaybackException! Cause: java.lang.IllegalArgumentException
D Player  :      at android.media.MediaCodec.native_setSurface(Native Method)
D Player  :      at android.media.MediaCodec.setOutputSurface(MediaCodec.java:1987)
D Player  :      at com.google.android.exoplayer2.mediacodec.SynchronousMediaCodecAdapter.setOutputSurface(SynchronousMediaCodecAdapter.java:189)
D Player  :      at com.google.android.exoplayer2.video.MediaCodecVideoRenderer.setOutputSurfaceV23(MediaCodecVideoRenderer.java:1490)
D Player  :      at com.google.android.exoplayer2.video.MediaCodecVideoRenderer.setOutput(MediaCodecVideoRenderer.java:693)
D Player  :      at com.google.android.exoplayer2.video.MediaCodecVideoRenderer.handleMessage(MediaCodecVideoRenderer.java:631)
D Player  :      at com.google.android.exoplayer2.ExoPlayerImplInternal.deliverMessage(ExoPlayerImplInternal.java:1550)
D Player  :      at com.google.android.exoplayer2.ExoPlayerImplInternal.sendMessageToTarget(ExoPlayerImplInternal.java:1514)
D Player  :      at com.google.android.exoplayer2.ExoPlayerImplInternal.sendMessageInternal(ExoPlayerImplInternal.java:1489)
D Player  :      at com.google.android.exoplayer2.ExoPlayerImplInternal.handleMessage(ExoPlayerImplInternal.java:526)
D Player  :      at android.os.Handler.dispatchMessage(Handler.java:101)
D Player  :      at android.os.Looper.loop(Looper.java:164)
D Player  :      at android.os.HandlerThread.run(HandlerThread.java:65)
D Player  : onPlaybackShutdown() called
D Player  : destroy() called
D Player  : saveStreamProgressState() called with: progressMillis=15692, currentMetadata=[Peru 8K HDR 60FPS (FUHD)]
D Player  : Setting recovery, queue: 0, pos: 15692
D PlayerHolder: unbind() called
D Player  : destroyPlayer() called

The mentioned stack trace is very similar to the one which causes the playback in full-screen mode to fail for the first time. It appears to be originating from the same native code in android.media.MediaCodec.native_setSurface.

@Redirion
Copy link
Member Author

Redirion commented Jan 4, 2023

okay, I am a bit confused. "onPlaybackShutdown()" should not have been called. It should retry when detecting that the stacktrace contains the characters "Surface", which it does.

I have added some more logging again to log whether the conditions for recovery are actually met.

Could you test again please? Thanks again.

@pbasista
Copy link

pbasista commented Jan 4, 2023

Could you test again please?

Yes. With the new version, the behavior remains the same. But the logs now include the added information.

Logs from an unsuccessful attempt to resume playback in full-screen mode.
E Player  : ExoPlayer - onPlayerError() called with:Bundle[{0=1004, 1=34635276, 2=Unexpected runtime error, 3=java.lang.IllegalArgumentException, 4=null, rt=2, ru=null, rv=-1, rx=4, ry=false}]
D Player  : saveStreamProgressState() called with: progressMillis=12466, currentMetadata=[Peru 8K HDR 60FPS (FUHD)]
D Player  : Unexpected PlaybackException! Cause: java.lang.IllegalArgumentException
D Player  :      at android.media.MediaCodec.native_setSurface(Native Method)
D Player  :      at android.media.MediaCodec.setOutputSurface(MediaCodec.java:1987)
D Player  :      at com.google.android.exoplayer2.mediacodec.SynchronousMediaCodecAdapter.setOutputSurface(SynchronousMediaCodecAdapter.java:189)
D Player  :      at com.google.android.exoplayer2.video.MediaCodecVideoRenderer.setOutputSurfaceV23(MediaCodecVideoRenderer.java:1490)
D Player  :      at com.google.android.exoplayer2.video.MediaCodecVideoRenderer.setOutput(MediaCodecVideoRenderer.java:693)
D Player  :      at com.google.android.exoplayer2.video.MediaCodecVideoRenderer.handleMessage(MediaCodecVideoRenderer.java:631)
D Player  :      at com.google.android.exoplayer2.ExoPlayerImplInternal.deliverMessage(ExoPlayerImplInternal.java:1550)
D Player  :      at com.google.android.exoplayer2.ExoPlayerImplInternal.sendMessageToTarget(ExoPlayerImplInternal.java:1514)
D Player  :      at com.google.android.exoplayer2.ExoPlayerImplInternal.sendMessageInternal(ExoPlayerImplInternal.java:1489)
D Player  :      at com.google.android.exoplayer2.ExoPlayerImplInternal.handleMessage(ExoPlayerImplInternal.java:526)
D Player  :      at android.os.Handler.dispatchMessage(Handler.java:101)
D Player  :      at android.os.Looper.loop(Looper.java:164)
D Player  :      at android.os.HandlerThread.run(HandlerThread.java:65)
D Player  : Conditinns for recovery not met. Tunneling enabled?: false, Surface keyword found?: true
D Player  : onPlaybackShutdown() called
D Player  : destroy() called
D Player  : saveStreamProgressState() called with: progressMillis=12466, currentMetadata=[Peru 8K HDR 60FPS (FUHD)]
D Player  : Setting recovery, queue: 0, pos: 12466
D PlayerHolder: unbind() called
D Player  : destroyPlayer() called

@Redirion
Copy link
Member Author

Redirion commented Jan 5, 2023

so we have:
RendererConfiguration.tunneling (new since ExoPlayer 2.18.2)
DefaultTrackSelector.Parameters.tunnelingEnabled

Both ways to check if tunneling is enabled (to be able to automatically disable it and retry) do not work. This makes this PR useless. A different approach will be needed. I will keep this PR open a bit, but I am afraid that this approach is a dead end.

@Redirion Redirion added the help wanted Help is wanted in fixing this issue label Jan 5, 2023
@pbasista
Copy link

pbasista commented Jan 5, 2023

I have a very limited understanding of what the goal of this PR is. But ExoPlayer's most recent release notes specifically mention a newly added method ExoPlayer.isTunnelingEnabled for checking whether the tunneling is enabled.

If I add this line to you branch:

--- a/app/src/main/java/org/schabi/newpipe/player/Player.java
+++ b/app/src/main/java/org/schabi/newpipe/player/Player.java
@@ -1426,6 +1426,7 @@ public final class Player implements PlaybackListener, Listener {
                 // Try to handle tunneling related exceptions
                 final String stackTrace = Log.getStackTraceString(error.getCause());
                 Log.d(TAG, "Unexpected PlaybackException! Cause: " + stackTrace);
+                Log.d(TAG, "Tunneling enabled: " + simpleExoPlayer.isTunnelingEnabled());
                 if (trackSelector.getParameters().tunnelingEnabled
                         && stackTrace.contains("Surface")) {
                     trackSelector.setParameters(trackSelector.buildUponParameters()

It produces the following output:

D Player  : Tunneling enabled: true

@Redirion
Copy link
Member Author

Redirion commented Jan 5, 2023

that was, what I initially had... strange.
You can see it in your first "Log from the subsequent crash when attempting to resume playback:"

E AndroidRuntime: java.lang.NullPointerException: Attempt to read from field 'boolean com.google.android.exoplayer2.RendererConfiguration.tunneling' on a null object reference E AndroidRuntime: at com.google.android.exoplayer2.ExoPlayerImpl.isTunnelingEnabled(ExoPlayerImpl.java:1673) E AndroidRuntime: at org.schabi.newpipe.player.Player.onPlayerError(Player.java:1430)

@pbasista
Copy link

pbasista commented Jan 5, 2023

Calling simpleExoPlayer.isTunnelingEnabled() seems to only work when ExoPlayer raises the first playback exception. Then something changes, the tunneling is supposedly disabled and perhaps some other adjustments are made.

After that, when the same ExoPlayer exception occurs for the second time, then calling simpleExoPlayer.isTunnelingEnabled() from the same place in the Player.onPlayerError method causes NewPipe to crash due to the following exception:

--------- beginning of crash
E AndroidRuntime: FATAL EXCEPTION: main
E AndroidRuntime: Process: org.schabi.newpipe.debug.surfacefix, PID: 17138
E AndroidRuntime: java.lang.NullPointerException: Attempt to read from field 'boolean com.google.android.exoplayer2.RendererConfiguration.tunneling' on a null object reference
E AndroidRuntime:        at com.google.android.exoplayer2.ExoPlayerImpl.isTunnelingEnabled(ExoPlayerImpl.java:1673)
E AndroidRuntime:        at org.schabi.newpipe.player.Player.onPlayerError(Player.java:1433)
E AndroidRuntime:        at com.google.android.exoplayer2.ExoPlayerImpl.lambda$updatePlaybackInfo$16(ExoPlayerImpl.java:1902)
E AndroidRuntime:        at com.google.android.exoplayer2.ExoPlayerImpl$$ExternalSyntheticLambda15.invoke(Unknown Source:4)
E AndroidRuntime:        at com.google.android.exoplayer2.util.ListenerSet$ListenerHolder.invoke(ListenerSet.java:282)
E AndroidRuntime:        at com.google.android.exoplayer2.util.ListenerSet.lambda$queueEvent$0(ListenerSet.java:190)
E AndroidRuntime:        at com.google.android.exoplayer2.util.ListenerSet$$ExternalSyntheticLambda1.run(Unknown Source:6)
E AndroidRuntime:        at com.google.android.exoplayer2.util.ListenerSet.flushEvents(ListenerSet.java:211)
E AndroidRuntime:        at com.google.android.exoplayer2.ExoPlayerImpl.updatePlaybackInfo(ExoPlayerImpl.java:1966)
E AndroidRuntime:        at com.google.android.exoplayer2.ExoPlayerImpl.handlePlaybackInfo(ExoPlayerImpl.java:1794)
E AndroidRuntime:        at com.google.android.exoplayer2.ExoPlayerImpl.lambda$new$1$com-google-android-exoplayer2-ExoPlayerImpl(ExoPlayerImpl.java:312)
E AndroidRuntime:        at com.google.android.exoplayer2.ExoPlayerImpl$$ExternalSyntheticLambda24.run(Unknown Source:4)
E AndroidRuntime:        at android.os.Handler.handleCallback(Handler.java:789)
E AndroidRuntime:        at android.os.Handler.dispatchMessage(Handler.java:98)
E AndroidRuntime:        at android.os.Looper.loop(Looper.java:164)
E AndroidRuntime:        at android.app.ActivityThread.main(ActivityThread.java:6541)
E AndroidRuntime:        at java.lang.reflect.Method.invoke(Native Method)
E AndroidRuntime:        at com.android.internal.os.Zygote$MethodAndArgsCaller.run(Zygote.java:240)
E AndroidRuntime:        at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:767)

@Redirion
Copy link
Member Author

Redirion commented Jan 6, 2023

not sure, maybe we just need to call prepare() again. Can you try again what happens now?

@pbasista
Copy link

pbasista commented Jan 6, 2023

The updated version no longer causes the entire application to crash when toggling the full-screen mode. During the first attempt, the simpleExoPlayer.isTunnelingEnabled() method can be called successfully and reports that the tunneling is enabled. During the second attempt, it raises the previously mentioned null pointer exception.

After the first attempt, the audio keeps playing. There are some audio-related messages in the log which might help with understanding the root cause of this behavior. For instance:

W ACodec  : cannot change tunneled surface
Full log from two subsequent attempts to toggle the full-screen mode.
01-06 15:43:45.852  7244  7244 D VideoPlayerUi: onClick() called with: v = [androidx.appcompat.widget.AppCompatImageButton{8bc1bdd VFED..C.. .F....ID 1088,0-1168,80 #7f0a033a app:id/screenRotationButton}]
01-06 15:43:45.856  7244  7244 D MainPlayerUi: toggleFullscreen() called
01-06 15:43:45.856  7244  7244 D VideoPlayerUi: hideControls() called with: duration = [0], delay = [0]
01-06 15:43:45.864  7244  7244 D VideoDetailFragment@1f4b634: hideSystemUi() called
01-06 15:43:45.884  7244  7244 D ViewUtils: animate():     true →  [View:playbackControlsShadow] [ALPHA 300:0] execOnEnd=null
01-06 15:43:45.884  7244  7244 D ViewUtils: animate(): view was already visible > view = [android.view.View{ed5a6a3 V.ED..... ........ 0,0-1200,540 #7f0a02f5 app:id/playbackControlsShadow}]
01-06 15:43:45.885  7244  7244 D ViewUtils: animate():     true →  [View:playerTopShadow] [ALPHA 300:0] execOnEnd=null
01-06 15:43:45.887  7244  7244 D ViewUtils: animate(): view was already visible > view = [android.view.View{ecfcda0 V.ED..... ........ 0,0-1200,60 #7f0a0302 app:id/playerTopShadow}]
01-06 15:43:45.888  7244  7244 D ViewUtils: animate():     true →  [View:playerBottomShadow] [ALPHA 300:0] execOnEnd=null
01-06 15:43:45.889  7244  7244 D ViewUtils: animate(): view was already visible > view = [android.view.View{8e17d59 V.ED..... ........ 0,480-1200,540 #7f0a0300 app:id/playerBottomShadow}]
01-06 15:43:45.891  7244  7244 D ViewUtils: animate():     true →  [RelativeLayout:playbackControlRoot] [ALPHA 300:0] execOnEnd=org.schabi.newpipe.player.ui.VideoPlayerUi$$ExternalSyntheticLambda33@8cbcc2f
01-06 15:43:45.892  7244  7244 D ViewUtils: animate(): view was already visible > view = [android.widget.RelativeLayout{21209ff V.E...... ......ID 0,0-1200,540 #7f0a02f4 app:id/playbackControlRoot}]
01-06 15:43:45.892  7244  7244 D VideoPlayerUi: hideControls() called with: duration = [0], delay = [0]
01-06 15:43:45.976  1269  1269 E hw-IPCThreadState: binder thread pool (1 threads) starved for 124 ms
01-06 15:43:46.005  7244  7244 D MainPlayerUi: maxGestureLength = 810
01-06 15:43:46.015  1282  1282 D MTK_KL  : <4>[  743.066601] [OSD]Before PQ Module offset:i4H=402 i4V=6
01-06 15:43:46.015  1282  1282 D MTK_KL  : <4>[  743.066614] [OSD]DBG XvYCC bypass
01-06 15:43:46.015  1282  1282 D MTK_KL  : <4>[  743.066618] [OSD]DBG Gamma position 0 or 1
01-06 15:43:46.015  1282  1282 D MTK_KL  : <4>[  743.066623] [OSD]After PQ Module offset:i4H=259 i4V=6
01-06 15:43:46.101  1269  1269 E hw-IPCThreadState: binder thread pool (1 threads) starved for 123 ms
01-06 15:43:46.121  7244  7412 D SurfaceUtils: connecting to surface 0x80be9808, reason connectToSurface
01-06 15:43:46.121  7244  7412 I MediaCodec: [OMX.MTK.VIDEO.DECODER.AVC] setting surface generation to 7417858
01-06 15:43:46.122  7244  7412 D SurfaceUtils: disconnecting from surface 0x80be9808, reason connectToSurface(reconnect)
01-06 15:43:46.122  7244  7412 D SurfaceUtils: connecting to surface 0x80be9808, reason connectToSurface(reconnect)
01-06 15:43:46.122  7244  7413 W ACodec  : cannot change tunneled surface
01-06 15:43:46.133  7244  7263 D LeakCanary: Setting up flushing for Thread[ExoPlayer:PlaceholderSurface,5,main]
01-06 15:43:46.139  7244  7400 E ExoPlayerImplInternal: Playback error
01-06 15:43:46.139  7244  7400 E ExoPlayerImplInternal:   com.google.android.exoplayer2.ExoPlaybackException: Unexpected runtime error
01-06 15:43:46.139  7244  7400 E ExoPlayerImplInternal:       at com.google.android.exoplayer2.ExoPlayerImplInternal.handleMessage(ExoPlayerImplInternal.java:621)
01-06 15:43:46.139  7244  7400 E ExoPlayerImplInternal:       at android.os.Handler.dispatchMessage(Handler.java:101)
01-06 15:43:46.139  7244  7400 E ExoPlayerImplInternal:       at android.os.Looper.loop(Looper.java:164)
01-06 15:43:46.139  7244  7400 E ExoPlayerImplInternal:       at android.os.HandlerThread.run(HandlerThread.java:65)
01-06 15:43:46.139  7244  7400 E ExoPlayerImplInternal:   Caused by: java.lang.IllegalStateException
01-06 15:43:46.139  7244  7400 E ExoPlayerImplInternal:       at android.media.MediaCodec.native_setSurface(Native Method)
01-06 15:43:46.139  7244  7400 E ExoPlayerImplInternal:       at android.media.MediaCodec.setOutputSurface(MediaCodec.java:1987)
01-06 15:43:46.139  7244  7400 E ExoPlayerImplInternal:       at com.google.android.exoplayer2.mediacodec.SynchronousMediaCodecAdapter.setOutputSurface(SynchronousMediaCodecAdapter.java:189)
01-06 15:43:46.139  7244  7400 E ExoPlayerImplInternal:       at com.google.android.exoplayer2.video.MediaCodecVideoRenderer.setOutputSurfaceV23(MediaCodecVideoRenderer.java:1490)
01-06 15:43:46.139  7244  7400 E ExoPlayerImplInternal:       at com.google.android.exoplayer2.video.MediaCodecVideoRenderer.setOutput(MediaCodecVideoRenderer.java:693)
01-06 15:43:46.139  7244  7400 E ExoPlayerImplInternal:       at com.google.android.exoplayer2.video.MediaCodecVideoRenderer.handleMessage(MediaCodecVideoRenderer.java:631)
01-06 15:43:46.139  7244  7400 E ExoPlayerImplInternal:       at com.google.android.exoplayer2.ExoPlayerImplInternal.deliverMessage(ExoPlayerImplInternal.java:1550)
01-06 15:43:46.139  7244  7400 E ExoPlayerImplInternal:       at com.google.android.exoplayer2.ExoPlayerImplInternal.sendMessageToTarget(ExoPlayerImplInternal.java:1514)
01-06 15:43:46.139  7244  7400 E ExoPlayerImplInternal:       at com.google.android.exoplayer2.ExoPlayerImplInternal.sendMessageInternal(ExoPlayerImplInternal.java:1489)
01-06 15:43:46.139  7244  7400 E ExoPlayerImplInternal:       at com.google.android.exoplayer2.ExoPlayerImplInternal.handleMessage(ExoPlayerImplInternal.java:526)
01-06 15:43:46.139  7244  7400 E ExoPlayerImplInternal:       ... 3 more
01-06 15:43:46.140  1300  1995 D MtkOmxVdec: ae808600: MtkOmxVdec::SendCommand cmd=OMX_CommandFlush
01-06 15:43:46.140  1300  7419 D MtkOmxVdec: ae808600: # Got general command (OMX_CommandFlush)
01-06 15:43:46.140  1300  7419 D MtkOmxVdec: ae808600: MtkOmxVdec::HandleFlush nPortIndex(0xFFFFFFFF)
01-06 15:43:46.140  1300  7419 D MtkOmxVdec: ae808600: +FlushInputPort
01-06 15:43:46.140  1300  7419 D MtkOmxVdec: ae808600: FlushInputPort -> mNumPendingInput(0)
01-06 15:43:46.140  1300  7419 D MtkOmxVdec: ae808600: get mWaitDecSemLock 1
01-06 15:43:46.141  1300  7419 D MtkOmxVdec: ae808600: -FlushInputPort
01-06 15:43:46.141  1300  7419 D MtkOmxVdec: ae808600: +FlushOutputPort
01-06 15:43:46.141  1300  7419 D MtkOmxVdec: +MtkOmxVdec::FlushOutputDecoder, mFlushMode = 1
01-06 15:43:46.144  1300  7419 D MtkOmxVdec: -MtkOmxVdec::FlushOutputDecoder
01-06 15:43:46.144  1300  7418 D MtkOmxVdec: Flush Done Event received!
01-06 15:43:46.144  1300  7418 D MtkOmxVdec: 0xae808600:mDecodeDoneQ.size = 0
01-06 15:43:46.144  1300  7419 D MtkOmxVdec: ae808600: -FlushOutputPort
01-06 15:43:46.145  1282  1282 D MTK_KL  : <4>[  743.196350] [vomx] flush
01-06 15:43:46.145  1282  1282 D MTK_KL  : <4>[  743.197098] [FBM]after flush,the first FBG/FB/ID/SOC [0-26-241-1]
01-06 15:43:46.145  1282  1282 D MTK_KL  : <4>[  743.199838] [vomx] flush done
01-06 15:43:46.145  1282  1282 D MTK_KL  : <4>[  743.199853] [vomx] pause vdec
01-06 15:43:46.145  1282  1282 D MTK_KL  : <4>[  743.199863] [vomx] flush trigger Pb restart
01-06 15:43:46.145  1282  1282 D MTK_KL  : <4>[  743.199873] [AUD]A
01-06 15:43:46.145  1282  1282 D MTK_KL  : <4>[  743.199882] [VDEC]UD_Dr
01-06 15:43:46.145  1282  1282 D MTK_KL  : <4>[  743.199892] Es1
01-06 15:43:46.145  1282  1282 D MTK_KL  : <4>[  743.199898] vSt
01-06 15:43:46.145  1282  1282 D MTK_KL  : <4>[  743.199903] Mat
01-06 15:43:46.145  1282  1282 D MTK_KL  : <4>[  743.199908] Mus
01-06 15:43:46.145  1282  1282 D MTK_KL  : <4>[  743.199913] A C
01-06 15:43:46.145  1282  1282 D MTK_KL  : <4>[  743.199918] oha
01-06 15:43:46.145  1282  1282 D MTK_KL  : <4>[  743.199922] ung
01-06 15:43:46.145  1282  1282 D MTK_KL  : <4>[  743.199928] te
01-06 15:43:46.145  1282  1282 D MTK_KL  : <4>[  743.199932] E1
01-06 15:43:46.145  1282  1282 D MTK_KL  : <4>[  743.199937] nto
01-06 15:43:46.145  1282  1282 D MTK_KL  : <4>[  743.199942] a 7
01-06 15:43:46.145  1282  1282 D MTK_KL  : <4>[  743.199947] b
01-06 15:43:46.145  1282  1282 D MTK_KL  : <4>[  743.199952] le u1DecId(0)fgEnable(1)notify(0)state(0)
01-06 15:43:46.152  1300  2655 D MtkOmxVdec: ae808600: MtkOmxVdec::SendCommand cmd=OMX_CommandStateSet
01-06 15:43:46.152  1300  2655 D MtkOmxVdec: ae808600: set MTK_OMX_VDEC_IDLE_PENDING
01-06 15:43:46.152  1300  7419 D MtkOmxVdec: ae808600: # Got general command (OMX_CommandStateSet)
01-06 15:43:46.152  1300  7419 D MtkOmxVdec: ae808600: MtkOmxVdec::HandleStateSet 2
01-06 15:43:46.152  1300  7419 D MtkOmxVdec: ae808600: Request [OMX_StateExecuting]-> [OMX_StateIdle]
01-06 15:43:46.152  1300  7419 D MtkOmxVdec: ae808600: +FlushInputPort
01-06 15:43:46.152  1300  7419 D MtkOmxVdec: ae808600: FlushInputPort -> mNumPendingInput(0)
01-06 15:43:46.152  1300  7419 D MtkOmxVdec: ae808600: -FlushInputPort
01-06 15:43:46.152  1300  7419 D MtkOmxVdec: ae808600: +FlushOutputPort
01-06 15:43:46.152  1300  7419 D MtkOmxVdec: +MtkOmxVdec::FlushOutputDecoder, mFlushMode = 1
01-06 15:43:46.152  1300  7419 D MtkOmxVdec: -MtkOmxVdec::FlushOutputDecoder
01-06 15:43:46.152  1300  7418 D MtkOmxVdec: Flush Done Event received!
01-06 15:43:46.152  1300  7418 D MtkOmxVdec: 0xae808600:mDecodeDoneQ.size = 0
01-06 15:43:46.152  1300  7419 D MtkOmxVdec: ae808600: -FlushOutputPort
01-06 15:43:46.153  1300  2581 D MtkOmxVdec: ae808600: MtkOmxVdec::SendCommand cmd=OMX_CommandStateSet
01-06 15:43:46.153  1300  2581 D MtkOmxVdec: ae808600: set MTK_OMX_VDEC_LOADED_PENDING
01-06 15:43:46.153  1300  7419 D MtkOmxVdec: ae808600: # Got general command (OMX_CommandStateSet)
01-06 15:43:46.153  1300  7419 D MtkOmxVdec: ae808600: MtkOmxVdec::HandleStateSet 1
01-06 15:43:46.153  1300  7419 D MtkOmxVdec: ae808600: Request [OMX_StateIdle]-> [OMX_StateLoaded]
01-06 15:43:46.153  1300  2581 D MtkOmxVdec: 0xae808600: MtkOmxVdec::FreeBuffer input idx[1] hdr(0xaedaf6c0) pBuffer(0xab963e90)
01-06 15:43:46.154  1300  1995 D MtkOmxVdec: 0xae808600: MtkOmxVdec::FreeBuffer input idx[0] hdr(0xaedaf850) pBuffer(0xac664000)
01-06 15:43:46.154  1300  1995 D MtkOmxVdec: ae808600: MtkOmxVdec::FreeBuffer all input buffers have been freed!!! signal mInPortFreeDoneSem(1)
01-06 15:43:46.154  1300  7419 D MtkOmxVdec: ae808600: +DeInitVideoDecodeHW
01-06 15:43:46.155  1282  1282 D MTK_KL  : <4>[  743.207672] [vomx] flush
01-06 15:43:46.155  1282  1282 D MTK_KL  : <4>[  743.207834] [vomx] flush done
01-06 15:43:46.155  1282  1282 D MTK_KL  : <4>[  743.207845] [vomx] pause vdec
01-06 15:43:46.155  1282  1282 D MTK_KL  : <4>[  743.207855] [vomx] flush trigger Pb restart
01-06 15:43:46.155  1282  1282 D MTK_KL  : <4>[  743.207869] [AUD]AUD_DrvMMAoutEnable u1DecId(0)fgEnable(1)notify(0)state(0)
01-06 15:43:46.155  1282  1282 D MTK_KL  : <4>[  743.209860] [vomx] vdecomx_deinit
01-06 15:43:46.155  1282  1282 D MTK_KL  : <4>[  743.209860]
01-06 15:43:46.155  1282  1282 D MTK_KL  : <4>[  743.210047] [VDEC]Es1 Status Change 7 to 0
01-06 15:43:46.155  1282  1282 D MTK_KL  : <4>[  743.210531] ++pqsoccontrolR_vfeat_updateMetadata(NONE (signal status =0)
01-06 15:43:46.155  1282  1282 D MTK_KL  : <1>[  743.210564] pqsocctrlP_glue_notifyModeDetectionDone resolution[1920 x 1080 @ 60Hz] Type[0] Presence[0] return 0
01-06 15:43:46.156  1260  1457 I audio_hal: [out_pause:1001]output_type = 3
01-06 15:43:46.156  1260  1457 D audio_hal: [out_pause:1004]pause for Tunal PCM/AC3 new
01-06 15:43:46.156  1260  1260 I audio_hal: [out_flush:1096]output_type = 3
01-06 15:43:46.156  1260  1260 I audio_hal: [do_output_standby:429]output_type = 3 drain = 0
01-06 15:43:46.165  1282  1282 D MTK_KL  : <4>[  743.216088] AUD_DeInitALSAPlayback_MixSnd(3)  #### For DSP Decoder
01-06 15:43:46.171  1300  7419 D MtkOmxVdec: ae808600: -DeInitVideoDecodeHW
01-06 15:43:46.171  1300  2655 D MtkOmxVdec: ae808600: MtkOmxVdec::GetState (mState=OMX_StateLoaded)
01-06 15:43:46.171  1300  2655 D MtkOmxCore: Mtk_OMX_FreeHandle
01-06 15:43:46.171  1300  2655 D MtkOmxVdec: ae808600: +MtkOmxVdec::ComponentDeInit
01-06 15:43:46.171  1300  7420 D MtkOmxVdec: 0xae808600: MtkOmxVdecDecodeThread terminated
01-06 15:43:46.171  1300  7419 D MtkOmxVdec: ae808600: MtkOmxVdecThread terminated
01-06 15:43:46.171  1300  7418 D MtkOmxVdec: MtkOmxVdecOutputThread will exited, signal mFlushSem
01-06 15:43:46.171  1300  7418 D MtkOmxVdec: MtkOmxVdecOutputThread terminated
01-06 15:43:46.175  1282  1282 D MTK_KL  : <4>[  743.225997] [FBM][FBM_ReleaseGroup-2910]Fbg(0) release.
01-06 15:43:46.175  1282  1282 D MTK_KL  : <4>[  743.226075] [FBM]FBM free addr 0x72852000
01-06 15:43:46.175  1282  1282 D MTK_KL  : <4>[  743.226107] [FBM]FBM free addr 0x733a2000
01-06 15:43:46.175  1282  1282 D MTK_KL  : <4>[  743.226138] [FBM]Release Group 111 0d9eda020
01-06 15:43:46.175  1282  1282 D MTK_KL  : <4>[  743.226209] [FBM]Release Group 222 0d9eda020
01-06 15:43:46.175  1282  1282 D MTK_KL  : <4>[  743.226294] [vomx] vdecomx_deinit done
01-06 15:43:46.175  1282  1282 D MTK_KL  : <4>[  743.226294]
01-06 15:43:46.175  1282  1282 D MTK_KL  : <4>[  743.226274] [VDEC]VDEC[1] Stop notify done
01-06 15:43:46.175  1282  1282 D MTK_KL  : <4>[  743.226312] [VDEC]VDEC[1] Stop done
01-06 15:43:46.182  1300  7417 D VCodecDrv: Last Event Got
01-06 15:43:46.183  1300  2655 D MtkOmxVdec: ae808600: +ReleaseHwResource 0xaea27420
01-06 15:43:46.183  1300  2655 I GRM     : MTKRmReleaseAllResource(587) thiz = 0x0xaea27420.
01-06 15:43:46.183  1300  2655 E GRM     : mtkrm_get_cur_id@line:488!! MTKRM_IPCR_NOT_OPENED
01-06 15:43:46.183  1300  2655 E GRM     : mtkrm_ipc_do_op@line:1645!! MTKRM_IPCR_NOT_OPENED
01-06 15:43:46.183  1300  2655 E GRM     : Open client:IMtkRmClientComponentReleaseAll #190 try to auto connect
01-06 15:43:46.184  1365  7454 I GRM     : (MtkOmxVdec)Release All Resource(0xaa05f000)
01-06 15:43:46.184  1300  2655 I GRM     : MTKRmReleaseAllResource ret=1.
01-06 15:43:46.184  1300  2655 D MtkOmxVdec: ae808600: -ReleaseHwResource
01-06 15:43:46.184  1300  2655 D MtkOmxVdec: ae808600: ~MtkOmxVdec call RMDestoryComponent(0xaea27420)
01-06 15:43:46.184  1300  2655 I GRM     : MTKRmReleaseAllResource(587) thiz = 0x0xaea27420.
01-06 15:43:46.185  1365  7454 I GRM     : (MtkOmxVdec)Release All Resource(0xaa05f000)
01-06 15:43:46.185  1300  2655 I GRM     : MTKRmReleaseAllResource ret=1.
01-06 15:43:46.185  1300  2655 I GRM     : MTKRmCallbackDone(613) thiz = 0x0xaea27420.
01-06 15:43:46.185  1365  7454 I GRM     : (MtkOmxVdec)check the callback done or not(0xaa05f000)
01-06 15:43:46.185  1300  2655 I GRM     : MTKRmCallbackDone ret=1.
01-06 15:43:46.185  1300  2655 I GRM     : Destroy Component!!! thiz = 0x0xaea27420
01-06 15:43:46.185  1365  7454 I GRM     : ============================Start==============================
01-06 15:43:46.185  1365  7454 I GRM     : Componet Name:AudioHal3, Pid:1260, priority:100, preempt:FALSE, fg:TRUE.
01-06 15:43:46.185  1365  7454 I GRM     :      Resource Name:AudioDecoder, type: 0, value: 2, enable: TRUE
01-06 15:43:46.185  1365  7454 I GRM     : Component Count: 12
01-06 15:43:46.185  1365  7454 I GRM     : =============================End===============================
01-06 15:43:46.185  1365  7454 I GRM     : MtkRmServiceDestoryComponent(1654) destory component:MtkOmxVdec
01-06 15:43:46.185  1365  7454 I GRM     : ============================Start==============================
01-06 15:43:46.185  1365  7454 I GRM     : Componet Name:AudioHal3, Pid:1260, priority:100, preempt:FALSE, fg:TRUE.
01-06 15:43:46.185  1365  7454 I GRM     :      Resource Name:AudioDecoder, type: 0, value: 2, enable: TRUE
01-06 15:43:46.185  1365  7454 I GRM     : Component Count: 11
01-06 15:43:46.185  1365  7454 I GRM     : =============================End===============================
01-06 15:43:46.185  1365  7454 I GRM     : MtkRmServiceDestoryComponent(1713) return
01-06 15:43:46.186  1282  1282 D MTK_KL  : <4>[  743.237921] [VDP]VdpId(0) fgPause(0)!
01-06 15:43:46.186  1282  1282 D MTK_KL  : <4>[  743.237959] [FBM]FBM free addr 0x6b804000
01-06 15:43:46.186  1282  1282 D MTK_KL  : <4>[  743.238022] [MPV]lock flush sema 1 super freeze 0 2655:HwBinder:1300_5
01-06 15:43:46.186  1282  1282 D MTK_KL  : <4>[  743.238208] [VDEC]
01-06 15:43:46.186  1282  1282 D MTK_KL  : <4>[  743.238212] [MPV]lock flush sema done 1
01-06 15:43:46.186  1282  1282 D MTK_KL  : <4>[  743.238256] V[DMX]
01-06 15:43:46.186  1282  1282 D MTK_KL  : <4>[  743.238262] D
01-06 15:43:46.186  1282  1282 D MTK_KL  : <4>[  743.238262] free
01-06 15:43:46.186  1282  1282 D MTK_KL  : <4>[  743.238270] EC[1] Stop done
01-06 15:43:46.186  1282  1282 D MTK_KL  : <4>[  743.238298] PID header buffer! pidx: 0, addr: 0xe1000020 Phy addr: 0x371e0020
01-06 15:43:46.186  1282  1282 D MTK_KL  : <4>[  743.238414] [DMX]_DMX_MUL_FreeTsIdx: u1Inst 1, u1TsIdx 3
01-06 15:43:46.186  1282  1282 D MTK_KL  : <4>[  743.238462] [FBM]FBM free addr 0x7d800000
01-06 15:43:46.186  1282  1282 D MTK_KL  : <4>[  743.238767] [VDP]VDP(0) disable B2R(0)
01-06 15:43:46.186  1282  1282 D MTK_KL  : <4>[  743.238939] [VDP]DTV Unmute B2R Switch VDP(0)
01-06 15:43:46.186  1282  1282 D MTK_KL  : <4>[  743.238973] [VDP]DTV Unmute B2R Switch VDP(1)
01-06 15:43:46.195  1300  2655 D MtkOmxVdec: ae808600: -MtkOmxVdec::ComponentDeInit
01-06 15:43:46.195  1300  2655 D MtkOmxVdec: 0xae808600: ~MtkOmxVdec
01-06 15:43:46.195  1300  2655 D MtkOmxCore: free_inst_handle dlclose(0xf3fe4df1), free(0xae808604)
01-06 15:43:46.212  1260  1260 D audio_hal: [ReleaseHwResource:85]+ReleaseHwResource 0xaa6cc300
01-06 15:43:46.212  1260  1260 I GRM     : MTKRmReleaseAllResource(587) thiz = 0x0xaa6cc300.
01-06 15:43:46.212  1260  1260 E GRM     : mtkrm_get_cur_id@line:488!! MTKRM_IPCR_NOT_OPENED
01-06 15:43:46.212  1260  1260 E GRM     : mtkrm_ipc_do_op@line:1645!! MTKRM_IPCR_NOT_OPENED
01-06 15:43:46.212  1260  1260 E GRM     : Open client:IMtkRmClientComponentReleaseAll #190 try to auto connect
01-06 15:43:46.213  1365  7456 I GRM     : (AudioHal3)Release All Resource(0xa9d273c0)
01-06 15:43:46.213  1260  1260 I GRM     : MTKRmReleaseAllResource ret=1.
01-06 15:43:46.213  1260  1260 D audio_hal: [ReleaseHwResource:95]-ReleaseHwResource
01-06 15:43:46.213  1260  1260 D audio_hal: [out_flush:1110]flush for Tunal PCM/AC3
01-06 15:43:46.213  1260  1260 W StreamHAL: Error from HAL stream in function flush: Function not implemented
01-06 15:43:46.215  1282  1282 D MTK_KL  : <4>[  743.266497] [AUD]====> vAprocDec_Close 1
01-06 15:43:46.215  1282  1282 D MTK_KL  : <4>[  743.266539] [AUD][AUD][A]vComm_Dec1_Close
01-06 15:43:46.215  1282  1282 D MTK_KL  : <4>[  743.266577] vAprocWaitCmdDoneEx ...
01-06 15:43:46.215  1282  1282 D MTK_KL  : <4>[  743.267316] [AUD][A]Dec1 close ...!!!
01-06 15:43:46.215  1282  1282 D MTK_KL  : <4>[  743.267346] [AUD]====> vA2MCommDec1CloseDone
01-06 15:43:46.215  1282  1282 D MTK_KL  : <4>[  743.267388] [AUD]vAprocWaitCmdDone(14): wake-up!
01-06 15:43:46.215  1282  1282 D MTK_KL  : <4>[  743.267427] [AUD]AUD_Aproc_SetOutputSel to Dec(0)
01-06 15:43:46.216  1300  2655 I GRM     : Already free memory
01-06 15:43:46.218  7244  7412 D SurfaceUtils: disconnecting from surface 0x80adb808, reason disconnectFromSurface
01-06 15:43:46.220  1282  1282 D MTK_KL  : <4>[  743.272061] [AUD][A]Reinit vAprocPcmr:pcmr_init(1),mmdType(0,1)
01-06 15:43:46.220  1295  1295 D MediaAnalyticsService: MediaAnalyticsService::newSummarizerSet
01-06 15:43:46.231  1269  1269 E hw-IPCThreadState: binder thread pool (1 threads) starved for 128 ms
01-06 15:43:46.238  1273  1453 E SurfaceFlinger: Failed to find layer (SurfaceView - org.schabi.newpipe.debug.surfacefix/org.schabi.newpipe.MainActivity#0) in layer parent (no-parent).
01-06 15:43:46.239  1273  1601 E SurfaceFlinger: Failed to find layer (Background for - SurfaceView - org.schabi.newpipe.debug.surfacefix/org.schabi.newpipe.MainActivity#0) in layer parent (no-parent).
01-06 15:43:46.251  7244  7244 D ViewUtils: animate():    false →  [View:playbackControlsShadow] [ALPHA 0:0] execOnEnd=null
01-06 15:43:46.254  7244  7244 D ViewUtils: animate():    false →  [View:playerTopShadow] [ALPHA 0:0] execOnEnd=null
01-06 15:43:46.256  7244  7244 D ViewUtils: animate():    false →  [View:playerBottomShadow] [ALPHA 0:0] execOnEnd=null
01-06 15:43:46.258  7244  7244 D ViewUtils: animate():    false →  [RelativeLayout:playbackControlRoot] [ALPHA 0:0] execOnEnd=org.schabi.newpipe.player.ui.VideoPlayerUi$$ExternalSyntheticLambda38@bd31227
01-06 15:43:46.260  1282  1282 D MTK_KL  : <4>[  743.314134] AP set Output Window Width or Height is 0
01-06 15:43:46.261  7244  7244 D VideoDetailFragment@1f4b634: hideSystemUi() called
01-06 15:43:46.309  1260  7439 D audio_hal: [get_sound_device_by_card:301]Get a card with (mtk - mtk, NULL, 1) =  0 [mtk            ]: mtk - mtk
01-06 15:43:46.309  1260  7439 D audio_hal:  .
01-06 15:43:46.309  1260  7439 D audio_hal: [AcquireHwResource:157]+AcquireHwResource
01-06 15:43:46.309  1260  7439 D audio_hal: [AcquireHwResource:166]waiting for the client creatation
01-06 15:43:46.309  1260  7439 D audio_hal: [AcquireHwResource:181]Client created done
01-06 15:43:46.309  1365  7443 I GRM     : MtkRmServiceQueryResource enter! resName: AudioDecoder.
01-06 15:43:46.309  1365  7443 I GRM     : MtkRmServiceQueryResource exit! Matched.
01-06 15:43:46.309  1365  7443 I GRM     : add resource AudioDecoder(2)
01-06 15:43:46.309  1365  7443 I GRM     : addResource.1739, AudioHal3 add resource AudioDecoder(2)
01-06 15:43:46.309  1365  7443 I GRM     : Resource Type matched, RESOURCE_TYPE_NUMBERNIC!
01-06 15:43:46.309  1365  7443 I GRM     : Resource(AudioDecoder,2) already exist in your component list!
01-06 15:43:46.309  1365  7443 I GRM     : add resource AudioDecoder(2), return 1
01-06 15:43:46.309  1260  7439 I GRM     : AllocResource!!!
01-06 15:43:46.310  1365  7443 I GRM     : client(AudioHal3) alloc resource
01-06 15:43:46.310  1365  7443 I GRM     : component(AudioHal3): i4_ret=0, u1DecId=2, bIsFree=1, u1NumCandidateToKick=0, u4AddInfo=0
01-06 15:43:46.310  1365  7443 I GRM     : ============================Start==============================
01-06 15:43:46.310  1365  7443 I GRM     : Componet Name:AudioHal3, Pid:1260, priority:100, preempt:FALSE, fg:TRUE.
01-06 15:43:46.310  1365  7443 I GRM     :      Resource Name:AudioDecoder, type: 0, value: 2, enable: TRUE
01-06 15:43:46.310  1365  7443 I GRM     : Component Count: 11
01-06 15:43:46.310  1365  7443 I GRM     : =============================End===============================
01-06 15:43:46.310  1260  7439 D audio_hal: [AcquireHwResource:209]-AcquireHwResource
01-06 15:43:46.310  1282  1282 D MTK_KL  : <4>[  743.365872]
01-06 15:43:46.310  1282  1282 D MTK_KL  : <4>[  743.365872] AUD_InitALSAPlayback_MixSnd(3)   #### For DSP Decoder #### do-nothing !
01-06 15:43:46.315  1282  1282 D MTK_KL  : <5>[  743.366163] [ALSA PCM] SNDRV_PCM_RATE_44100
01-06 15:43:46.315  1282  1282 D MTK_KL  : <4>[  743.366174] AUD_PlayMixSndRingFifo Stream(0x3)   #### For DSP Decoder #### Need to PLAY DSP !
01-06 15:43:46.315  1282  1282 D MTK_KL  : <4>[  743.366192] [AUD]AUD_PlayMixSndRingFifo: AUD_SetAvSynMode as slave mode for stream = 3, u1StereoOnOff=0x82
01-06 15:43:46.315  1282  1282 D MTK_KL  : <4>[  743.367091]
01-06 15:43:46.315  1282  1282 D MTK_KL  : <4>[  743.367091] [Aud_if] LPCM Info: 1 8 15 0 128 0 0 0 13 0 0
01-06 15:43:46.315  1282  1282 D MTK_KL  : <4>[  743.367107]
01-06 15:43:46.315  1282  1282 D MTK_KL  : <4>[  743.367107] [Aud_if] LPCM Info: u1DecId = 1
01-06 15:43:46.315  1282  1282 D MTK_KL  : <4>[  743.367131] [AUD]====> vAprocDecc_Open 1
01-06 15:43:46.315  1282  1282 D MTK_KL  : <4>[  743.367197] [AUD]vAprocWaitCmdDone ...
01-06 15:43:46.315  1282  1282 D MTK_KL  : <4>[  743.367770] [AUD][A]Dec1 open ...!!!
01-06 15:43:46.315  1282  1282 D MTK_KL  : <4>[  743.367902] [AUD]vAprocWaitCmdDone(21): wake-up!
01-06 15:43:46.315  1282  1282 D MTK_KL  : <4>[  743.368324] [AUD]AUD_Aproc_SetOutputSel to Dec(1)
01-06 15:43:46.319  7244  7244 E Player  : ExoPlayer - onPlayerError() called with:Bundle[{0=1004, 1=41364358, 2=Unexpected runtime error, 3=java.lang.IllegalStateException, 4=null, rt=2, ru=null, rv=-1, rx=4, ry=false}]
01-06 15:43:46.321  7244  7244 D Player  : saveStreamProgressState() called with: progressMillis=20637, currentMetadata=[Peru 8K HDR 60FPS (FUHD)]
01-06 15:43:46.326  7244  7244 D Player  : Unexpected PlaybackException! Cause: java.lang.IllegalStateException
01-06 15:43:46.326  7244  7244 D Player  :      at android.media.MediaCodec.native_setSurface(Native Method)
01-06 15:43:46.326  7244  7244 D Player  :      at android.media.MediaCodec.setOutputSurface(MediaCodec.java:1987)
01-06 15:43:46.326  7244  7244 D Player  :      at com.google.android.exoplayer2.mediacodec.SynchronousMediaCodecAdapter.setOutputSurface(SynchronousMediaCodecAdapter.java:189)
01-06 15:43:46.326  7244  7244 D Player  :      at com.google.android.exoplayer2.video.MediaCodecVideoRenderer.setOutputSurfaceV23(MediaCodecVideoRenderer.java:1490)
01-06 15:43:46.326  7244  7244 D Player  :      at com.google.android.exoplayer2.video.MediaCodecVideoRenderer.setOutput(MediaCodecVideoRenderer.java:693)
01-06 15:43:46.326  7244  7244 D Player  :      at com.google.android.exoplayer2.video.MediaCodecVideoRenderer.handleMessage(MediaCodecVideoRenderer.java:631)
01-06 15:43:46.326  7244  7244 D Player  :      at com.google.android.exoplayer2.ExoPlayerImplInternal.deliverMessage(ExoPlayerImplInternal.java:1550)
01-06 15:43:46.326  7244  7244 D Player  :      at com.google.android.exoplayer2.ExoPlayerImplInternal.sendMessageToTarget(ExoPlayerImplInternal.java:1514)
01-06 15:43:46.326  7244  7244 D Player  :      at com.google.android.exoplayer2.ExoPlayerImplInternal.sendMessageInternal(ExoPlayerImplInternal.java:1489)
01-06 15:43:46.326  7244  7244 D Player  :      at com.google.android.exoplayer2.ExoPlayerImplInternal.handleMessage(ExoPlayerImplInternal.java:526)
01-06 15:43:46.326  7244  7244 D Player  :      at android.os.Handler.dispatchMessage(Handler.java:101)
01-06 15:43:46.326  7244  7244 D Player  :      at android.os.Looper.loop(Looper.java:164)
01-06 15:43:46.326  7244  7244 D Player  :      at android.os.HandlerThread.run(HandlerThread.java:65)
01-06 15:43:46.328  7244  7244 D Player  : Disable tunneling and reload
01-06 15:43:46.328  7244  7244 D Player  : Setting recovery, queue: 0, pos: 20637
01-06 15:43:46.329  7244  7244 D MediaSourceManager@118837252: close() called.
01-06 15:43:46.335  1282  1282 D MTK_KL  : <4>[  743.386409] [AUD][_AudDspSetIec:3409]eIecCfg(0),fgEnable(1) play:1
01-06 15:43:46.335  1282  1282 D MTK_KL  : <4>[  743.386433] [AUD]netflix or exoplayer use AUX decoder
01-06 15:43:46.335  1282  1282 D MTK_KL  : <4>[  743.389451] [AUD][A]Reinit vAprocPcmr:pcmr_init(1),mmdType(1,0)
01-06 15:43:46.365  1269  1269 E hw-IPCThreadState: binder thread pool (1 threads) starved for 135 ms
01-06 15:43:46.405  1282  1282 D MTK_KL  : <4>[  743.456014] [AUD][PLAY_MUTE](1)!!!!!gogogo Audio UnMute!!!!!
01-06 15:43:46.420  7244  7244 D MainPlayerUi: toggleFullscreen() called
01-06 15:43:46.423  7244  7244 D VideoDetailFragment@1f4b634: showSystemUi() called
01-06 15:43:46.434  1727  2143 W Binder  : Binder call failed.
01-06 15:43:46.434  1727  2143 W Binder  : java.lang.IllegalArgumentException: Wake lock not active: android.os.BinderProxy@15bf4db from uid 1041
01-06 15:43:46.434  1727  2143 W Binder  :      at com.android.server.power.PowerManagerService.updateWakeLockWorkSourceInternal(PowerManagerService.java:1197)
01-06 15:43:46.434  1727  2143 W Binder  :      at com.android.server.power.PowerManagerService.-wrap36(Unknown Source:0)
01-06 15:43:46.434  1727  2143 W Binder  :      at com.android.server.power.PowerManagerService$BinderService.updateWakeLockWorkSource(PowerManagerService.java:4205)
01-06 15:43:46.434  1727  2143 W Binder  :      at com.android.server.power.PowerManagerService$BinderService.updateWakeLockUids(PowerManagerService.java:4185)
01-06 15:43:46.434  1727  2143 W Binder  :      at android.os.IPowerManager$Stub.onTransact(IPowerManager.java:105)
01-06 15:43:46.434  1727  2143 W Binder  :      at android.os.Binder.execTransact(Binder.java:674)
01-06 15:43:46.437  1273  1455 E SurfaceFlinger: Failed to find layer (SurfaceView - org.schabi.newpipe.debug.surfacefix/org.schabi.newpipe.MainActivity#0) in layer parent (no-parent).
01-06 15:43:46.437  1273  2296 E SurfaceFlinger: Failed to find layer (Background for - SurfaceView - org.schabi.newpipe.debug.surfacefix/org.schabi.newpipe.MainActivity#0) in layer parent (no-parent).
01-06 15:43:46.443  7244  7244 D PlayerService: stopForImmediateReusing() called
01-06 15:43:46.445  1288  1462 D AudioPolicyManagerMediatek: AudioPolicyManagerMediatek::getDeviceForStrategy reroute STRATEGY_ACCESSIBILITY to STRATEGY_MEDIA
01-06 15:43:46.446  1288  1462 D AudioPolicyManagerMediatek: AudioPolicyManagerMediatek::getDeviceForStrategy reroute STRATEGY_ACCESSIBILITY to STRATEGY_MEDIA
01-06 15:43:46.446  7244  7244 D Player  : Setting recovery, queue: 0, pos: 20637
01-06 15:43:46.447  1260  1517 D audio_hal: [out_standby:486]stream = 0xa97b3e40
01-06 15:43:46.447  1260  1517 I audio_hal: [do_output_standby:429]output_type = 3 drain = 1
01-06 15:43:46.447  7244  7244 D VideoPlayerUi: hideControls() called with: duration = [0], delay = [0]
01-06 15:43:46.450  7244  7244 D Player  : ExoPlayer - onPlaybackStateChanged() called with: playbackState = [1]
01-06 15:43:46.450  7244  7244 D Player  : ExoPlayer - updatePlaybackState() called with: playWhenReady = [true], playbackState = [1]
01-06 15:43:46.457  3375  3375 D NowPlayingListener: updatePlayback() called with: state = [PlaybackState {state=7, position=20637, buffered position=20637, speed=0.0, updated=41364689, actions=2364287, custom actions=[], active item id=0, error=null}] and now playing listener: dqv@dc6a376
01-06 15:43:46.457  3292  3694 I katniss_interactor_MediaSessionStateTrackerImpl: We do not track the playback state: PlaybackState {state=7, position=20637, buffered position=20637, speed=0.0, updated=41364689, actions=2364287, custom actions=[], active item id=0, error=null}
01-06 15:43:46.458  3375  3375 D NowPlayingManager: onClientPlaybackStateUpdate() called with: state = [7], stateChangeTimeMs = [41364689], currentPosMs = [20637]
01-06 15:43:46.460  1727  1727 W TelecomManager: Telecom Service not found.
01-06 15:43:46.467  3375  3375 D NowPlayingManager: A notification for Now Playing Card has been canceled
01-06 15:43:46.468  3375  3375 D NowPlayingManager: onClientChanged() called
01-06 15:43:46.468  3375  3375 D NowPlayingManager: A notification for Now Playing Card has been canceled
01-06 15:43:46.470  1282  1282 D MTK_KL  : <4>[  743.521127] AUD_DeInitALSAPlayback_MixSnd(3)  #### For DSP Decoder
01-06 15:43:46.475  3766  3766 D BasicMediaStatusFactory: Supported media session actions: 2364287
01-06 15:43:46.496  1269  1269 E hw-IPCThreadState: binder thread pool (1 threads) starved for 130 ms
01-06 15:43:46.517  1260  1517 D audio_hal: [ReleaseHwResource:85]+ReleaseHwResource 0xaa6cc300
01-06 15:43:46.517  1260  1517 I GRM     : MTKRmReleaseAllResource(587) thiz = 0x0xaa6cc300.
01-06 15:43:46.517  1260  1517 E GRM     : mtkrm_get_cur_id@line:488!! MTKRM_IPCR_NOT_OPENED
01-06 15:43:46.517  1260  1517 E GRM     : mtkrm_ipc_do_op@line:1645!! MTKRM_IPCR_NOT_OPENED
01-06 15:43:46.517  1260  1517 E GRM     : Open client:IMtkRmClientComponentReleaseAll #190 try to auto connect
01-06 15:43:46.519  1365  7458 I GRM     : (AudioHal3)Release All Resource(0xa9d273c0)
01-06 15:43:46.519  1260  1517 I GRM     : MTKRmReleaseAllResource ret=1.
01-06 15:43:46.519  1260  1517 D audio_hal: [ReleaseHwResource:95]-ReleaseHwResource
01-06 15:43:46.520  1282  1282 D MTK_KL  : <4>[  743.571328] [AUD]====> vAprocDec_Close 1
01-06 15:43:46.520  1282  1282 D MTK_KL  : <4>[  743.571377] [AUD]vAprocWaitCmdDoneEx ...
01-06 15:43:46.520  1282  1282 D MTK_KL  : <4>[  743.571537] [AUD][A]vComm_Dec1_Close
01-06 15:43:46.520  1282  1282 D MTK_KL  : <4>[  743.572171] [AUD][A]Dec1 close ...!!!
01-06 15:43:46.520  1282  1282 D MTK_KL  : <4>[  743.572202] [AUD]====> vA2MCommDec1CloseDone
01-06 15:43:46.520  1282  1282 D MTK_KL  : <4>[  743.572247] [AUD]vAprocWaitCmdDone(14): wake-up!
01-06 15:43:46.520  1282  1282 D MTK_KL  : <4>[  743.572286] [AUD]AUD_Aproc_SetOutputSel to Dec(0)
01-06 15:43:46.521  1727  3469 I PowerManagerService: skip acquire wake lock tag:AudioDirectOut
01-06 15:43:46.522  1727  3469 W Binder  : Binder call failed.
01-06 15:43:46.522  1727  3469 W Binder  : java.lang.IllegalArgumentException: Wake lock not active: android.os.BinderProxy@a3e019a from uid 1041
01-06 15:43:46.522  1727  3469 W Binder  :      at com.android.server.power.PowerManagerService.updateWakeLockWorkSourceInternal(PowerManagerService.java:1197)
01-06 15:43:46.522  1727  3469 W Binder  :      at com.android.server.power.PowerManagerService.-wrap36(Unknown Source:0)
01-06 15:43:46.522  1727  3469 W Binder  :      at com.android.server.power.PowerManagerService$BinderService.updateWakeLockWorkSource(PowerManagerService.java:4205)
01-06 15:43:46.522  1727  3469 W Binder  :      at com.android.server.power.PowerManagerService$BinderService.updateWakeLockUids(PowerManagerService.java:4185)
01-06 15:43:46.522  1727  3469 W Binder  :      at android.os.IPowerManager$Stub.onTransact(IPowerManager.java:105)
01-06 15:43:46.522  1727  3469 W Binder  :      at android.os.Binder.execTransact(Binder.java:674)
01-06 15:43:46.522  1260  1457 D audio_hal: [removePatch:220]handle = 2
01-06 15:43:46.522  1260  1457 D audio_hal: [dumpAudioPort:68]============================= 10 start =============================
01-06 15:43:46.522  1260  1457 D audio_hal: [dumpAudioPort:70]port[10] role = source, type = mix
01-06 15:43:46.523  1260  1457 D audio_hal: [dumpAudioPort:79]port[10] module = 10, io handle = 21, usecase = ffffffff
01-06 15:43:46.523  1260  1457 D audio_hal: [dumpAudioPort:81]port[10] mute = 1, volume = 0
01-06 15:43:46.523  1260  1457 D audio_hal: [dumpAudioPort:82]============================== 10 end ==============================
01-06 15:43:46.523  1260  1457 D audio_hal: [decreaseRef:43]Device(10) ref = 0
01-06 15:43:46.523  1260  1457 D audio_hal: [dumpAudioPort:68]============================= 1 start =============================
01-06 15:43:46.523  1260  1457 D audio_hal: [dumpAudioPort:70]port[1] role = sink, type = device
01-06 15:43:46.523  1260  1457 D audio_hal: [getDeviceConfig:101]devices = 2
01-06 15:43:46.523  1260  1457 D audio_hal: [dumpAudioPort:72]port[1] name = speaker
01-06 15:43:46.523  1260  1457 D audio_hal: [dumpAudioPort:75]port[1] module = 10, device type = 0x2, address =
01-06 15:43:46.523  1260  1457 D audio_hal: [dumpAudioPort:81]port[1] mute = 0, volume = 20
01-06 15:43:46.523  1260  1457 D audio_hal: [dumpAudioPort:82]============================== 1 end ==============================
01-06 15:43:46.523  1260  1457 D audio_hal: [decreaseRef:43]Device(1) ref = 1
01-06 15:43:46.523  1260  1457 I audio_hal: [mute:25]bt mute = 0
01-06 15:43:46.523  1260  1457 D audio_hal: [mute:98]Un-mute 21 and 22
01-06 15:43:46.523  1260  1457 I audio_hal: [mute:25]speaker mute = 0
01-06 15:43:46.523  1260  1457 D audio_hal: [mute:98]Un-mute 0 and 1
01-06 15:43:46.525  1282  1282 D MTK_KL  : <4>[  743.576089] [AUD][A]Reinit vAprocPcmr:pcmr_init(1),mmdType(0,1)
01-06 15:43:46.527  1727  1737 I PowerManagerService: skip acquire wake lock tag:AudioDirectOut
01-06 15:43:46.528  1727  1737 W Binder  : Binder call failed.
01-06 15:43:46.528  1727  1737 W Binder  : java.lang.IllegalArgumentException: Wake lock not active: android.os.BinderProxy@bb562a8 from uid 1041
01-06 15:43:46.528  1727  1737 W Binder  :      at com.android.server.power.PowerManagerService.updateWakeLockWorkSourceInternal(PowerManagerService.java:1197)
01-06 15:43:46.528  1727  1737 W Binder  :      at com.android.server.power.PowerManagerService.-wrap36(Unknown Source:0)
01-06 15:43:46.528  1727  1737 W Binder  :      at com.android.server.power.PowerManagerService$BinderService.updateWakeLockWorkSource(PowerManagerService.java:4205)
01-06 15:43:46.528  1727  1737 W Binder  :      at com.android.server.power.PowerManagerService$BinderService.updateWakeLockUids(PowerManagerService.java:4185)
01-06 15:43:46.528  1727  1737 W Binder  :      at android.os.IPowerManager$Stub.onTransact(IPowerManager.java:105)
01-06 15:43:46.528  1727  1737 W Binder  :      at android.os.Binder.execTransact(Binder.java:674)
01-06 15:43:46.530  1260  1867 I audio_hal: [adev_close_output_stream:1392]out = 0xa97b3e40, out->output_type = 3
01-06 15:43:46.530  1260  1867 D audio_hal: [out_standby:486]stream = 0xa97b3e40
01-06 15:43:46.530  1260  1867 I audio_hal: [do_output_standby:429]output_type = 3 drain = 1
01-06 15:43:46.530  1260  1867 D audio_hal: [adev_close_output_stream:1418]FreeStc, Id = 0
01-06 15:43:46.530  1260  1867 D audio_hal: [DestroyHwResource:100]+DestroyHwResource 0xaa6cc300
01-06 15:43:46.530  1260  1867 D audio_hal: [DestroyHwResource:108]Start wait callback doen
01-06 15:43:46.530  1260  1867 I GRM     : MTKRmCallbackDone(613) thiz = 0x0xaa6cc300.
01-06 15:43:46.530  1260  1867 E GRM     : mtkrm_get_cur_id@line:488!! MTKRM_IPCR_NOT_OPENED
01-06 15:43:46.530  1260  1867 E GRM     : mtkrm_ipc_do_op@line:1645!! MTKRM_IPCR_NOT_OPENED
01-06 15:43:46.530  1260  1867 E GRM     : Open client:IMtkRmClientComponentCallbackDone #197 try to auto connect
01-06 15:43:46.531  1727  1737 W Binder  : Binder call failed.
01-06 15:43:46.531  1727  1737 W Binder  : java.lang.IllegalArgumentException: Wake lock not active: android.os.BinderProxy@cea9d66 from uid 1041
01-06 15:43:46.531  1727  1737 W Binder  :      at com.android.server.power.PowerManagerService.updateWakeLockWorkSourceInternal(PowerManagerService.java:1197)
01-06 15:43:46.531  1727  1737 W Binder  :      at com.android.server.power.PowerManagerService.-wrap36(Unknown Source:0)
01-06 15:43:46.531  1727  1737 W Binder  :      at com.android.server.power.PowerManagerService$BinderService.updateWakeLockWorkSource(PowerManagerService.java:4205)
01-06 15:43:46.531  1727  1737 W Binder  :      at com.android.server.power.PowerManagerService$BinderService.updateWakeLockUids(PowerManagerService.java:4185)
01-06 15:43:46.531  1727  1737 W Binder  :      at android.os.IPowerManager$Stub.onTransact(IPowerManager.java:105)
01-06 15:43:46.531  1727  1737 W Binder  :      at android.os.Binder.execTransact(Binder.java:674)
01-06 15:43:46.533  1365  7460 I GRM     : (AudioHal3)check the callback done or not(0xa9d273c0)
01-06 15:43:46.533  1260  1867 I GRM     : MTKRmCallbackDone ret=1.
01-06 15:43:46.533  1260  1867 D audio_hal: [ReleaseHwResource:85]+ReleaseHwResource 0xaa6cc300
01-06 15:43:46.533  1260  1867 I GRM     : MTKRmReleaseAllResource(587) thiz = 0x0xaa6cc300.
01-06 15:43:46.533  1365  7460 I GRM     : (AudioHal3)Release All Resource(0xa9d273c0)
01-06 15:43:46.533  1260  1867 I GRM     : MTKRmReleaseAllResource ret=1.
01-06 15:43:46.533  1260  1867 D audio_hal: [ReleaseHwResource:95]-ReleaseHwResource
01-06 15:43:46.533  1260  1867 I GRM     : Destroy Component!!! thiz = 0x0xaa6cc300
01-06 15:43:46.533  1365  7460 I GRM     : ============================Start==============================
01-06 15:43:46.533  1365  7460 I GRM     : Component Count: 11
01-06 15:43:46.533  1365  7460 I GRM     : =============================End===============================
01-06 15:43:46.533  1365  7460 I GRM     : MtkRmServiceDestoryComponent(1654) destory component:AudioHal3
01-06 15:43:46.533  1365  7460 I GRM     : ============================Start==============================
01-06 15:43:46.534  1365  7460 I GRM     : Component Count: 10
01-06 15:43:46.534  1365  7460 I GRM     : =============================End===============================
01-06 15:43:46.534  1365  7460 I GRM     : MtkRmServiceDestoryComponent(1713) return
01-06 15:43:46.544  1260  7440 D audio_hal: [createComponentThread:149]createComponentThread exit
01-06 15:43:46.545  1260  7440 E GRM     : mtkrm_ipc_close_client@line:2114!! MTKRM_IPCR_NOT_OPENED
01-06 15:43:46.545  1260  1867 D audio_hal: [DestroyHwResource:119]-DestroyHwResource
01-06 15:43:46.582  7244  7244 D MediaSourceManager@72657347: maybeBlock() called.
01-06 15:43:46.582  7244  7244 D Player  : Playback - onPlaybackBlock() called
01-06 15:43:46.584  7244  7244 D Player  : changeState() called with: state = [123]
01-06 15:43:46.585  7244  7244 D Player  : onBlocked() called
01-06 15:43:46.585  7244  7244 D NotificationUtil: updateNotification()
01-06 15:43:46.611  7244  7244 D VideoPlayerUi: hideControls() called with: duration = [300], delay = [0]
01-06 15:43:46.616  7244  7244 D ViewUtils: animate():     true →  [RelativeLayout:loading_panel] [ALPHA 0:0] execOnEnd=null
01-06 15:43:46.619  7244  7244 D ViewUtils: animate():     true →  [View:surfaceForeground] [ALPHA 100:0] execOnEnd=null
01-06 15:43:46.626  1269  1269 E hw-IPCThreadState: binder thread pool (1 threads) starved for 129 ms
01-06 15:43:46.626  7244  7244 D ViewUtils: animate():    false →  [AppCompatImageButton:playPauseButton] [SCALE_AND_ALPHA 100:0] execOnEnd=null
01-06 15:43:46.629  7244  7244 D ViewUtils: animate():    false →  [AppCompatImageButton:playPreviousButton] [SCALE_AND_ALPHA 100:0] execOnEnd=null
01-06 15:43:46.630  7244  7244 D ViewUtils: animate(): view was already gone > view = [androidx.appcompat.widget.AppCompatImageButton{6a38b21 IFED..C.. ......I. 427,500-768,580 #7f0a02f1 app:id/playPreviousButton}]
01-06 15:43:46.631  7244  7244 D ViewUtils: animate():    false →  [AppCompatImageButton:playNextButton] [SCALE_AND_ALPHA 100:0] execOnEnd=null
01-06 15:43:46.631  7244  7244 D ViewUtils: animate(): view was already gone > view = [androidx.appcompat.widget.AppCompatImageButton{48c7b46 IFED..C.. ......I. 1150,500-1492,580 #7f0a02ef app:id/playNextButton}]
01-06 15:43:46.635  7244  7244 D MediaSourceManager@72657347: resetSources() called.
01-06 15:43:46.635  7244  7244 D MediaSourceManager@72657347: populateSources() called.
01-06 15:43:46.636  7244  7244 D MediaSourceManager@72657347: MediaSource - loadImmediate() called
01-06 15:43:46.637  7244  7244 D MediaSourceManager@72657347: MediaSource - maybeClearLoaders() called.
01-06 15:43:46.637  7244  7244 D MediaSourceManager@72657347: maybeLoadItem() called.
01-06 15:43:46.638  7244  7244 D MediaSourceManager@72657347: MediaSource - Loading=[Peru 8K HDR 60FPS (FUHD)] with url=[https://www.youtube.com/watch?v=1La4QzGeaaQ]
01-06 15:43:46.640  7244  7287 D InfoCache: getFromKey() called with: serviceId = [0], url = [https://www.youtube.com/watch?v=1La4QzGeaaQ]
01-06 15:43:46.640  7244  7287 D ExtractorHelper: loadFromCache() called, info > StreamInfo[url="https://www.youtube.com/watch?v=1La4QzGeaaQ", name="Peru 8K HDR 60FPS (FUHD)"]
01-06 15:43:46.659  3375  3385 I zygote  : Background concurrent copying GC freed 28683(1457KB) AllocSpace objects, 6(120KB) LOS objects, 56% free, 1206KB/2MB, paused 6.219ms total 78.677ms
01-06 15:43:46.756  1269  1269 E hw-IPCThreadState: binder thread pool (1 threads) starved for 129 ms
01-06 15:43:46.759  1266  1266 D gralloc : mali_gralloc_select_format: req_format=0x00000001 req_fmt_mapped=0x1 internal_format=0x1 usage=0x900
01-06 15:43:46.759  1266  1266 D gralloc : set_ion_flags heap_mask:0x1 usage:0x900
01-06 15:43:46.759  1273  2296 I vndksupport: sphal namespace is not configured for this process. Loading /vendor/lib/hw/gralloc.mt5891.so from the current namespace instead.
01-06 15:43:46.760  1266  1266 D gralloc : mali_gralloc_select_format: req_format=0x00000001 req_fmt_mapped=0x1 internal_format=0x1 usage=0x900
01-06 15:43:46.760  1266  1266 D gralloc : set_ion_flags heap_mask:0x1 usage:0x900
01-06 15:43:46.761  1273  2296 I vndksupport: sphal namespace is not configured for this process. Loading /vendor/lib/hw/gralloc.mt5891.so from the current namespace instead.
01-06 15:43:46.762  1266  1266 D gralloc : mali_gralloc_select_format: req_format=0x00000001 req_fmt_mapped=0x1 internal_format=0x1 usage=0x900
01-06 15:43:46.762  1266  1266 D gralloc : set_ion_flags heap_mask:0x1 usage:0x900
01-06 15:43:46.763  1273  2296 I vndksupport: sphal namespace is not configured for this process. Loading /vendor/lib/hw/gralloc.mt5891.so from the current namespace instead.
01-06 15:43:46.765  7244  7274 D mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, egl_color_buffer_format *, EGLBoolean) returns 0x3000
01-06 15:43:46.769  7244  7244 D ViewUtils: animate():    false →  [View:playbackControlsShadow] [ALPHA 300:0] execOnEnd=null
01-06 15:43:46.770  7244  7244 D ViewUtils: animate(): view was already gone > view = [android.view.View{ed5a6a3 G.ED..... ......ID 0,0-1920,1080 #7f0a02f5 app:id/playbackControlsShadow}]
01-06 15:43:46.771  7244  7244 D ViewUtils: animate():    false →  [View:playerTopShadow] [ALPHA 300:0] execOnEnd=null
01-06 15:43:46.771  7244  7244 D ViewUtils: animate(): view was already gone > view = [android.view.View{ecfcda0 G.ED..... ......ID 0,0-1920,60 #7f0a0302 app:id/playerTopShadow}]
01-06 15:43:46.772  7244  7244 D ViewUtils: animate():    false →  [View:playerBottomShadow] [ALPHA 300:0] execOnEnd=null
01-06 15:43:46.772  7244  7244 D ViewUtils: animate(): view was already gone > view = [android.view.View{8e17d59 G.ED..... ......ID 0,1020-1920,1080 #7f0a0300 app:id/playerBottomShadow}]
01-06 15:43:46.774  7244  7244 D ViewUtils: animate():    false →  [RelativeLayout:playbackControlRoot] [ALPHA 300:0] execOnEnd=org.schabi.newpipe.player.ui.VideoPlayerUi$$ExternalSyntheticLambda38@43f4b22
01-06 15:43:46.774  7244  7244 D ViewUtils: animate(): view was already gone > view = [android.widget.RelativeLayout{21209ff G.E...... ......ID 0,0-1920,1080 #7f0a02f4 app:id/playbackControlRoot}]
01-06 15:43:46.796  1266  1266 D gralloc : mali_gralloc_select_format: req_format=0x00000001 req_fmt_mapped=0x1 internal_format=0x1 usage=0xb00
01-06 15:43:46.796  1266  1266 D gralloc : set_ion_flags heap_mask:0x1 usage:0xb00
01-06 15:43:46.798  1273  2296 I vndksupport: sphal namespace is not configured for this process. Loading /vendor/lib/hw/gralloc.mt5891.so from the current namespace instead.
01-06 15:43:46.803  7244  7274 I vndksupport: sphal namespace is not configured for this process. Loading /vendor/lib/hw/gralloc.mt5891.so from the current namespace instead.
01-06 15:43:46.876  1269  1269 E hw-IPCThreadState: binder thread pool (1 threads) starved for 119 ms
01-06 15:43:46.943  1266  1266 D gralloc : mali_gralloc_select_format: req_format=0x00000001 req_fmt_mapped=0x1 internal_format=0x1 usage=0xb00
01-06 15:43:46.943  1266  1266 D gralloc : set_ion_flags heap_mask:0x1 usage:0xb00
01-06 15:43:46.944  1273  1601 I vndksupport: sphal namespace is not configured for this process. Loading /vendor/lib/hw/gralloc.mt5891.so from the current namespace instead.
01-06 15:43:46.945  7244  7274 I vndksupport: sphal namespace is not configured for this process. Loading /vendor/lib/hw/gralloc.mt5891.so from the current namespace instead.
01-06 15:43:46.950  7244  7244 D MediaSourceManager@72657347: MediaSource - Loaded=[Peru 8K HDR 60FPS (FUHD)] with url=[https://www.youtube.com/watch?v=1La4QzGeaaQ]
01-06 15:43:46.951  7244  7244 D MediaSourceManager@72657347: MediaSource - Updating index=[0] with title=[Peru 8K HDR 60FPS (FUHD)] at url=[https://www.youtube.com/watch?v=1La4QzGeaaQ]
01-06 15:43:46.958  7244  7244 D MediaSourceManager@72657347: maybeUnblock() called.
01-06 15:43:46.958  7244  7244 D Player  : Playback - onPlaybackUnblock() called
01-06 15:43:46.958  7244  7244 D Player  : changeState() called with: state = [125]
01-06 15:43:46.958  7244  7244 D Player  : onBuffering() called
01-06 15:43:46.968  7244  7244 D Player  : ExoPlayer - onPositionDiscontinuity() called with oldPositionIndex = [0], oldPositionMs = [20637], newPositionIndex = [0], newPositionMs = [20637], discontinuityReason = [4]
01-06 15:43:46.968  7244  7244 D Player  : ExoPlayer - onSeekProcessed() called
01-06 15:43:46.971  7244  7244 D Player  : ExoPlayer - onTracksChanged(), track group size = 0
01-06 15:43:46.982  7244  7244 D Player  : ExoPlayer - onPlaybackStateChanged() called with: playbackState = [2]
01-06 15:43:46.982  7244  7244 D Player  : ExoPlayer - updatePlaybackState() called with: playWhenReady = [true], playbackState = [2]
01-06 15:43:46.983  7244  7244 D MediaSourceManager@72657347: maybeSync() called.
01-06 15:43:46.983  7244  7244 D Player  : Playback - onPlaybackSynchronize(was blocked: true) called with item=[Peru 8K HDR 60FPS (FUHD)], url=[https://www.youtube.com/watch?v=1La4QzGeaaQ]
01-06 15:43:46.983  7244  7244 D Player  : Playback - Rewinding to correct index=[0], from=[0], size=[1].
01-06 15:43:46.983  7244  7244 D MediaSessUi: buildMediaMetadata called
01-06 15:43:46.993  7244  7244 D NotificationUtil: updateThumbnail() called with thumbnail = [0], title = [[Neznámy]]
01-06 15:43:46.997  3766  3766 D BasicMediaStatusFactory: Supported media session actions: 2364287
01-06 15:43:46.999  1273  1273 D SurfaceFlinger: Backpressure trigger, skipping transaction & refresh!
01-06 15:43:47.000  3766  3766 W chromium: [3766:3766:WARNING:media_trait_handler_impl.cc(679)] No media status
01-06 15:43:47.001  1269  1269 E hw-IPCThreadState: binder thread pool (1 threads) starved for 125 ms
01-06 15:43:47.001  1727  1727 D HDMI    : [P]:AllocatedAddress=[]
01-06 15:43:47.010  7244  7244 D Player  : ExoPlayer - onPositionDiscontinuity() called with oldPositionIndex = [0], oldPositionMs = [20637], newPositionIndex = [0], newPositionMs = [20637], discontinuityReason = [1]
01-06 15:43:47.010  7244  7244 D Player  : ExoPlayer - onSeekProcessed() called
01-06 15:43:47.013  7244  7244 D Player  : ExoPlayer - onEvents() update stream info: Peru 8K HDR 60FPS (FUHD)
01-06 15:43:47.013  7244  7244 D Player  : Playback - onMetadataChanged() called, playing: Peru 8K HDR 60FPS (FUHD)
01-06 15:43:47.015  7244  7244 D Player  : Thumbnail - loadCurrentThumbnail() called with url = [https://i.ytimg.com/vi_webp/1La4QzGeaaQ/maxresdefault.webp]
01-06 15:43:47.016  7244  7244 D Player  : Thumbnail - onBitmapLoaded() called with: bitmap = [android.graphics.Bitmap@9b29c00 -> 400x225], from = [MEMORY]
01-06 15:43:47.016  7244  7244 D MediaSessUi: buildMediaMetadata called
01-06 15:43:47.019  1267  1267 I vndksupport: sphal namespace is not configured for this process. Loading /vendor/lib/hw/gralloc.mt5891.so from the current namespace instead.
01-06 15:43:47.031  7244  7244 D NotificationUtil: updateThumbnail() called with thumbnail = [9b29c00], title = [Peru 8K HDR 60FPS (FUHD)]
01-06 15:43:47.054  7244  7244 D VideoPlayerUi: Thumbnail - onThumbnailLoaded() called with: currentThumbnail = [android.graphics.Bitmap@9b29c00], 400x225, scaled end screen height = 225.0, scaled end screen width = 400
01-06 15:43:47.061  7244  7244 D NotificationUtil: createNotification()
01-06 15:43:47.066  7244  7244 D NotificationUtil: updateNotification()
01-06 15:43:47.078  3766  3766 D BasicMediaStatusFactory: Supported media session actions: 2364287
01-06 15:43:47.085  3766  3766 W chromium: [3766:3766:WARNING:media_trait_handler_impl.cc(679)] No media status
01-06 15:43:47.125  7244  7469 I OMXClient: Treble IOmx obtained
01-06 15:43:47.128  1300  2655 I OMXMaster: makeComponentInstance(OMX.MTK.VIDEO.DECODER.AVC) in omx@1.0-service process
01-06 15:43:47.129  1300  2655 D MtkOmxCore: Mtk_OMX_GetHandle (OMX.MTK.VIDEO.DECODER.AVC)
01-06 15:43:47.129  1300  2655 D MtkOmxCore: comp_index(6), path(libMtkOmxVdec.so)
01-06 15:43:47.137  7244  7470 D SeekbarPrevThumbHolder: Clearing seekbarPreviewData
01-06 15:43:47.137  7244  7470 D SeekbarPrevThumbHolder: Strategy for seekbarPreviewData: high quality
01-06 15:43:47.138  7244  7470 D SeekbarPrevThumbHolder: Frameset quality info: [width=160, heigh=90]
01-06 15:43:47.138  7244  7470 D SeekbarPrevThumbHolder: Starting generation of seekbarPreviewData
01-06 15:43:47.138  7244  7470 D SeekbarPrevThumbHolder: Downloading bitmap for seekbarPreview from 'https://i.ytimg.com/sb/1La4QzGeaaQ/storyboard3_L2/M0.jpg?sqp=-oaymwENSDfyq4qpAwVwAcABBqLzl_8DBgjYtpiaBg==&sigh=rs$AOn4CLCBwAZWuVF7rTf3JbKGSKZPrhGXng'
01-06 15:43:47.145  3292  3694 I katniss_interactor_MediaSessionStateTrackerImpl: We do not track the playback state: PlaybackState {state=6, position=20637, buffered position=20637, speed=0.0, updated=41365376, actions=2363959, custom actions=[], active item id=0, error=null}
01-06 15:43:47.146  7244  7244 D MediaSessUi: buildMediaMetadata called
01-06 15:43:47.146  3375  3375 D NowPlayingListener: updateNowPlayingNotification with controller: NowPlayingMediaController {packageName = org.schabi.newpipe.debug.surfacefix, state = 6, metadata = Peru 8K HDR 60FPS (FUHD), Jacob + Katie Schwarz, null}
01-06 15:43:47.146  3375  3375 D NowPlayingListener: updateMetadata() called with: metadata description = [Peru 8K HDR 60FPS (FUHD), Jacob + Katie Schwarz, null] and now playing listener: dqv@dc6a376
01-06 15:43:47.147  1300  2655 D MtkOmxVdec: 0xae808600: MtkOmxVdec::MtkOmxVdec
01-06 15:43:47.148  1300  2655 D MtkOmxVdec: 0xae808600: MtkOmxComponentCreate mCompHandle(0xae808604)
01-06 15:43:47.148  1300  2655 D MtkOmxVdec: ae808600: MtkOmxVdec::ComponentInit (OMX.MTK.VIDEO.DECODER.AVC)
01-06 15:43:47.148  1300  2655 I GRM     : Create Component: MtkOmxVdec
01-06 15:43:47.148  1300  2655 I GRM     : REG CB HNDLR RMResourceDemandReleaseCallback, 0x0xae463e31
01-06 15:43:47.159  1365  7471 I GRM     : Process(1300) name(media.codec) start at 574!
01-06 15:43:47.159  1365  7471 I GRM     : MtkRmServiceCreateComponent.1534, create component MtkOmxVdec(0xa9d27410) exit...
01-06 15:43:47.159  1365  7471 D GRM     : MtkRmServiceCreateComponent.1540, create component exit...
01-06 15:43:47.159  1300  2655 I GRM     : Return Component: thiz = 0x0xaea27420.
01-06 15:43:47.160  1365  7471 I GRM     : Set Component(MtkOmxVdec) priority(100) successful!
01-06 15:43:47.160  1300  2655 D MtkOmxVdec: ae808600: MtkOmxVdec call RMCreateComponent return 0xaea27420, priority:100
01-06 15:43:47.160  1300  2655 D MtkOmxVdec: kick equal enabled
01-06 15:43:47.160  1300  2655 D MtkOmxVdec: ae808600: +AcquireHwResource, 0xaea27420
01-06 15:43:47.160  1300  2655 D MtkOmxVdec: ae808600: AcquireHwResource Enable Kick Equal Priority Client
01-06 15:43:47.160  1365  7471 I GRM     : Set Component(MtkOmxVdec) preempt equal:(TRUE) successful!
01-06 15:43:47.160  1365  7471 I GRM     : MtkRmServiceQueryResource enter! resName: VideoDecoder.
01-06 15:43:47.160  1365  7471 I GRM     : MtkRmServiceQueryResource exit! Matched.
01-06 15:43:47.160  1365  7471 I GRM     : MtkRmServiceQueryResource enter! resName: DMXPlaybackPID.
01-06 15:43:47.160  1365  7471 I GRM     : MtkRmServiceQueryResource exit! Matched.
01-06 15:43:47.161  1365  7471 I GRM     : component(0xa9d27410), query resource(VideoDecoder), value(1)
01-06 15:43:47.161  1365  7471 I GRM     : Resource(VideoDecoder), value(1) is free
01-06 15:43:47.161  1365  7471 I GRM     : add resource VideoDecoder(1)
01-06 15:43:47.161  1365  7471 I GRM     : addResource.1739, MtkOmxVdec add resource VideoDecoder(1)
01-06 15:43:47.161  1365  7471 I GRM     : Resource Type matched, RESOURCE_TYPE_NUMBERNIC!
01-06 15:43:47.161  1365  7471 I GRM     : add resource VideoDecoder(1), return 1
01-06 15:43:47.161  1300  2655 I GRM     : AllocResource!!!
01-06 15:43:47.161  1365  7471 I GRM     : client(MtkOmxVdec) alloc resource
01-06 15:43:47.161  1365  7471 I GRM     : ============================Start==============================
01-06 15:43:47.161  1365  7471 I GRM     : Componet Name:MtkOmxVdec, Pid:1300, priority:100, preempt:TRUE, fg:TRUE.
01-06 15:43:47.161  1365  7471 I GRM     :      Resource Name:VideoDecoder, type: 0, value: 1, enable: TRUE
01-06 15:43:47.161  1365  7471 I GRM     : Component Count: 11
01-06 15:43:47.161  1365  7471 I GRM     : =============================End===============================
01-06 15:43:47.161  1300  2655 D MtkOmxVdec: ae808600: -AcquireHwResource
01-06 15:43:47.165  3375  3375 D NowPlayingManager: onMediaDataUpdated() called with: NowPlayingData [dqs@2b82c1c, title=Peru 8K HDR 60FPS (FUHD), artist=Jacob + Katie Schwarz]
01-06 15:43:47.165  3375  3375 D NowPlayingListener: updatePlayback() called with: state = [PlaybackState {state=6, position=20637, buffered position=20637, speed=0.0, updated=41365376, actions=2363959, custom actions=[], active item id=0, error=null}] and now playing listener: dqv@dc6a376
01-06 15:43:47.165  3375  3375 D NowPlayingManager: onClientPlaybackStateUpdate() called with: state = [6], stateChangeTimeMs = [41365376], currentPosMs = [20637]
01-06 15:43:47.165  1282  1282 D MTK_KL  : <4>[  744.217352] [FBM]FBM alloc Feeder
01-06 15:43:47.165  1282  1282 D MTK_KL  : <4>[  744.217444] [DMX]_DMX_MUL_AllocTsIdx: inst 1, u1TsIdx 3, eConnType 7
01-06 15:43:47.165  1282  1282 D MTK_KL  : <4>[  744.217474] _DMXMMAllocBuf - Pidx 0 sets buffer addr 0x7d800000
01-06 15:43:47.165  1282  1282 D MTK_KL  : <4>[  744.217874] [vomx] vdecomx_create done mode=0 fmt=2 vdecId=1
01-06 15:43:47.169  3375  3375 D NowPlayingManager: A notification for Now Playing Card has been canceled
01-06 15:43:47.173  1300  7474 D MtkOmxVdec: MtkOmxVdecOutputThread created pVdec=0xae808600, tid=7474
01-06 15:43:47.174  3766  3766 D BasicMediaStatusFactory: Supported media session actions: 2363959
01-06 15:43:47.175  7244  7468 D SurfaceUtils: connecting to surface 0x80adb808, reason connectToSurface
01-06 15:43:47.176  7244  7468 I MediaCodec: [OMX.MTK.VIDEO.DECODER.AVC] setting surface generation to 7417859
01-06 15:43:47.176  7244  7468 D SurfaceUtils: disconnecting from surface 0x80adb808, reason connectToSurface(reconnect)
01-06 15:43:47.177  7244  7468 D SurfaceUtils: connecting to surface 0x80adb808, reason connectToSurface(reconnect)
01-06 15:43:47.178  1300  7475 D MtkOmxVdec: MtkOmxVdecThread created pVdec=0xae808600, tid=7475
01-06 15:43:47.182  1300  2581 D MtkOmxVdec: 0xae808600 SetParameter index(OMX_IndexParamStandardComponentRole, 0x01000017)
01-06 15:43:47.183  1300  2581 D MtkOmxVdec: 0xae808600 SetParameter index(OMX_GoogleAndroidIndexEnableAndroidNativeBuffers, 0x7F000100)
01-06 15:43:47.183  1300  2581 D MtkOmxVdec: ae808600: OMX_GoogleAndroidIndexEnableAndroidNativeBuffers enable(1)
01-06 15:43:47.183  1300  2581 D MtkOmxVdec: 0xae808600 SetParameter index(OMX_GoogleAndroidIndexAllocateNativeHandle, 0x7F00010B)
01-06 15:43:47.183  1300  2581 E MtkOmxVdec: 0xae808600: OMX_GoogleAndroidIndexAllocateNativeHandle: invalid port index(1)
01-06 15:43:47.183  1300  2581 E OMXNodeInstance: setParameter(0xae808604:MTK.DECODER.AVC, OMX.google.android.index.allocateNativeHandle(0x7f00010b): Output:1 en=0) ERROR: BadParameter(0x80001005)
01-06 15:43:47.183  1300  2581 W OMXNodeInstance: [0xae808604:MTK.DECODER.AVC] component does not support metadata mode; using fallback
01-06 15:43:47.183  7244  7469 E ACodec  : [OMX.MTK.VIDEO.DECODER.AVC] setPortMode on output to DynamicANWBuffer failed w/ err -1010
01-06 15:43:47.184  1300  1481 D MtkOmxVdec: 0xae808600 SetParameter index(OMX_GoogleAndroidIndexPrepareForAdaptivePlayback, 0x7F000104)
01-06 15:43:47.184  1300  1481 D MtkOmxVdec: Client try to enable adaptive playback, Max W:1280 H:720
01-06 15:43:47.184  1300  1481 D MtkOmxVdec: Adaptive Playback Enabled
01-06 15:43:47.184  1300  2655 D MtkOmxVdec: 0xae808600 SetParameter index(OMX_GoogleAndroidIndexAllocateNativeHandle, 0x7F00010B)
01-06 15:43:47.184  1300  2655 E MtkOmxVdec: 0xae808600: OMX_GoogleAndroidIndexAllocateNativeHandle: invalid port index(1)
01-06 15:43:47.184  1300  2655 E OMXNodeInstance: setParameter(0xae808604:MTK.DECODER.AVC, OMX.google.android.index.allocateNativeHandle(0x7f00010b): Output:1 en=0) ERROR: BadParameter(0x80001005)
01-06 15:43:47.184  1300  2655 D MtkOmxVdec: 0xae808600 SetParameter index(OMX_GoogleAndroidIndexEnableAndroidNativeBuffers, 0x7F000100)
01-06 15:43:47.184  1300  2655 D MtkOmxVdec: ae808600: OMX_GoogleAndroidIndexEnableAndroidNativeBuffers enable(1)
01-06 15:43:47.184  1300  2655 W OMXNodeInstance: [0xae808604:MTK.DECODER.AVC] component does not support metadata mode; using fallback
01-06 15:43:47.184  1300  1480 D MtkOmxVdec: 0xae808600 GetParameter index(OMX_IndexParamVideoPortFormat, 0x06000001)
01-06 15:43:47.184  1300  1995 D MtkOmxVdec: 0xae808600 SetParameter index(OMX_IndexParamVideoPortFormat, 0x06000001)
01-06 15:43:47.185  1300  1995 D MtkOmxVdec: 0xae808600 GetParameter index(OMX_IndexParamVideoPortFormat, 0x06000001)
01-06 15:43:47.185  1300  2655 D MtkOmxVdec: 0xae808600 SetParameter index(OMX_IndexParamVideoPortFormat, 0x06000001)
01-06 15:43:47.185  1300  2655 D MtkOmxVdec: ae808600: output color format set to 0x7f000101
01-06 15:43:47.185  1300  1481 D MtkOmxVdec: 0xae808600 GetParameter index(OMX_IndexParamPortDefinition, 0x02000001)
01-06 15:43:47.185  1300  1481 D MtkOmxVdec: ae808600: Get OMX_IndexParamPortDefinition Input Buffer Size: 6815376, Count: 2
01-06 15:43:47.185  1300  1480 D MtkOmxVdec: 0xae808600 SetParameter index(OMX_IndexParamPortDefinition, 0x02000001)
01-06 15:43:47.185  1300  1480 D MtkOmxVdec: us 0x67fe90 vs need 0x67fe90
01-06 15:43:47.185  1300  2581 D MtkOmxVdec: 0xae808600 GetParameter index(OMX_IndexParamPortDefinition, 0x02000001)
01-06 15:43:47.185  1300  2581 D MtkOmxVdec: 0xae808600: Get OMX_IndexParamPortDefinition Output Buffer Size: 38016
01-06 15:43:47.185  1300  1995 D MtkOmxVdec: 0xae808600 SetParameter index(OMX_IndexParamPortDefinition, 0x02000001)
01-06 15:43:47.186  1300  1995 D MtkOmxVdec: 0xae808600 GetParameter index(OMX_IndexParamPortDefinition, 0x02000001)
01-06 15:43:47.186  1300  1995 D MtkOmxVdec: ae808600: Get OMX_IndexParamPortDefinition Input Buffer Size: 6815376, Count: 2
01-06 15:43:47.186  1300  2581 D MtkOmxVdec: 0xae808600 SetConfig index((null), 0x6F800002)
01-06 15:43:47.186  1300  2581 W MtkOmxVdec: 0xae808600 SetConfig: unsupported index: 0x6F800002
01-06 15:43:47.186  1300  2581 E OMXNodeInstance: setConfig(0xae808604:MTK.DECODER.AVC, ConfigPriority(0x6f800002)) ERROR: UnsupportedIndex(0x8000101a)
01-06 15:43:47.186  7244  7469 I ACodec  : codec does not support config priority (err -1010)
01-06 15:43:47.187  1300  1480 D MtkOmxVdec: 0xae808600 SetConfig index((null), 0x6F800003)
01-06 15:43:47.187  1300  1480 W MtkOmxVdec: 0xae808600 SetConfig: unsupported index: 0x6F800003
01-06 15:43:47.187  1300  1480 E OMXNodeInstance: setConfig(0xae808604:MTK.DECODER.AVC, ConfigOperatingRate(0x6f800003)) ERROR: UnsupportedIndex(0x8000101a)
01-06 15:43:47.187  7244  7469 I ACodec  : codec does not support config operating rate (err -1010)
01-06 15:43:47.187  1300  1481 D MtkOmxVdec: 0xae808600 GetParameter index(OMX_IndexParamPortDefinition, 0x02000001)
01-06 15:43:47.187  1300  1481 D MtkOmxVdec: ae808600: Get OMX_IndexParamPortDefinition Input Buffer Size: 6815376, Count: 2
01-06 15:43:47.187  1300  1481 D MtkOmxVdec: 0xae808600 GetConfig index(OMX_IndexConfigAndroidVendorExtension, 0x6F100004)
01-06 15:43:47.187  1300  1995 D MtkOmxVdec: 0xae808600 GetConfig index(OMX_IndexConfigAndroidVendorExtension, 0x6F100004)
01-06 15:43:47.187  1300  1480 D MtkOmxVdec: 0xae808600 GetParameter index(OMX_IndexParamPortDefinition, 0x02000001)
01-06 15:43:47.188  1300  1480 D MtkOmxVdec: 0xae808600: Get OMX_IndexParamPortDefinition Output Buffer Size: 1382400
01-06 15:43:47.188  1300  2581 D MtkOmxVdec: 0xae808600 GetConfig index(OMX_IndexConfigCommonOutputCrop, 0x0700000F)
01-06 15:43:47.188  1300  2581 D MtkOmxVdec: 0xae808600 GetConfig index(OMX_IndexConfigAndroidVendorExtension, 0x6F100004)
01-06 15:43:47.188  1300  1480 D MtkOmxVdec: 0xae808600 GetConfig index(OMX_IndexConfigAndroidVendorExtension, 0x6F100004)
01-06 15:43:47.194  1300  1481 D MtkOmxVdec: ae808600: MtkOmxVdec::SendCommand cmd=OMX_CommandStateSet
01-06 15:43:47.194  1300  1481 D MtkOmxVdec: ae808600: set MTK_OMX_VDEC_IDLE_PENDING
01-06 15:43:47.194  1300  1995 D MtkOmxVdec: 0xae808600 GetParameter index(OMX_IndexParamPortDefinition, 0x02000001)
01-06 15:43:47.194  1300  1995 D MtkOmxVdec: ae808600: Get OMX_IndexParamPortDefinition Input Buffer Size: 6815376, Count: 2
01-06 15:43:47.195  1300  7475 D MtkOmxVdec: ae808600: # Got general command (OMX_CommandStateSet)
01-06 15:43:47.195  1300  7475 D MtkOmxVdec: ae808600: MtkOmxVdec::HandleStateSet 2
01-06 15:43:47.195  1300  7475 D MtkOmxVdec: ae808600: Request [OMX_StateLoaded]-> [OMX_StateIdle]
01-06 15:43:47.196  7244  7244 D Player  : ExoPlayer - onTracksChanged(), track group size = 2
01-06 15:43:47.205  1259  1259 W /system/bin/hw/android.hidl.allocator@1.0-service: ashmem_create_region(6815376) returning hidl_memory(0xb4818990, 6815376)
01-06 15:43:47.206  1300  2581 D MtkOmxVdec: ae808600: AllocateBuffer, nSizeBytes: 6815376
01-06 15:43:47.207  1300  2581 D MtkOmxVdec: ae808600: MtkOmxVdec::AllocateBuffer port(0), idx[0], pBuffHead(0xaedaf580), pBuffer(0xac761000) size(6815376)
01-06 15:43:47.209  7244  7244 D Player  : ExoPlayer - onEvents() update stream info: Peru 8K HDR 60FPS (FUHD)
01-06 15:43:47.210  1259  1259 W /system/bin/hw/android.hidl.allocator@1.0-service: ashmem_create_region(6815376) returning hidl_memory(0xb4818990, 6815376)
01-06 15:43:47.216  1300  1480 D MtkOmxVdec: ae808600: AllocateBuffer, nSizeBytes: 6815376
01-06 15:43:47.216  1300  1480 D MtkOmxVdec: ae808600: MtkOmxVdec::AllocateBuffer port(0), idx[1], pBuffHead(0xaedaf440), pBuffer(0xaba60e90) size(6815376)
01-06 15:43:47.216  1300  1480 D MtkOmxVdec: ae808600: AllocateBuffer:: input port populated
01-06 15:43:47.217  1300  2655 D MtkOmxVdec: 0xae808600 GetParameter index(OMX_IndexParamPortDefinition, 0x02000001)
01-06 15:43:47.217  1300  2655 D MtkOmxVdec: 0xae808600: Get OMX_IndexParamPortDefinition Output Buffer Size: 1382400
01-06 15:43:47.217  1300  1995 D MtkOmxVdec: 0xae808600 GetParameter index(OMX_IndexParamPortDefinition, 0x02000001)
01-06 15:43:47.217  1300  1995 D MtkOmxVdec: 0xae808600: Get OMX_IndexParamPortDefinition Output Buffer Size: 1382400
01-06 15:43:47.218  1300  2581 D MtkOmxVdec: 0xae808600 SetParameter index(OMX_GoogleAndroidIndexAndroidNativeBufferConsumerUsage, 0x7F00010A)
01-06 15:43:47.218  1300  2581 D MtkOmxVdec: ae808600: AndroidNativeBufferConsumerUsage 2304
01-06 15:43:47.218  1300  2581 D MtkOmxVdec: ae808600: SurfaceView Mode
01-06 15:43:47.218  1300  1995 D MtkOmxVdec: 0xae808600 GetParameter index(OMX_GoogleAndroidIndexGetAndroidNativeBufferUsage, 0x7F000102)
01-06 15:43:47.218  1300  1995 E GRM     : mtkrm_get_cur_id@line:488!! MTKRM_IPCR_NOT_OPENED
01-06 15:43:47.218  1300  1995 E GRM     : mtkrm_ipc_do_op@line:1645!! MTKRM_IPCR_NOT_OPENED
01-06 15:43:47.218  1300  1995 E GRM     : Open client:IMtkRmClientComponentQueryResource #218 try to auto connect
01-06 15:43:47.221  7244  7244 D MediaSessUi: buildMediaMetadata called
01-06 15:43:47.222  1365  7478 I GRM     : component(0xa9d27410), query resource(VideoPath), value(0)
01-06 15:43:47.222  1365  7478 I GRM     : Resource(VideoPath), value(0) is free
01-06 15:43:47.222  1300  1995 D MtkOmxVdec: ae808600: set usage to vdp0
01-06 15:43:47.222  1300  1995 D MtkOmxVdec: ae808600: MtkOmxVdec::GetParameter nUsage(0x30000000)
01-06 15:43:47.222  7244  7469 D SurfaceUtils: disconnecting from surface 0x80adb808, reason setNativeWindowSizeFormatAndUsage
01-06 15:43:47.223  7244  7469 D SurfaceUtils: connecting to surface 0x80adb808, reason setNativeWindowSizeFormatAndUsage
01-06 15:43:47.223  7244  7469 D SurfaceUtils: set up nativeWindow 0x80adb808 for 1280x720, color 0x7f000101, rotation 0, usage 0x30002900
01-06 15:43:47.224  1300  2581 D MtkOmxVdec: 0xae808600 SetParameter index(OMX_IndexParamPortDefinition, 0x02000001)
01-06 15:43:47.224  1300  2581 D MtkOmxVdec: nBufferCountActual = 20 vs nBufferCountMin = 16
01-06 15:43:47.224  1300  2581 E OMXNodeInstance: setParameter(0xae808604:MTK.DECODER.AVC, ParamPortDefinition(0x2000001)) ERROR: BadParameter(0x80001005)
01-06 15:43:47.224  7244  7469 W ACodec  : [OMX.MTK.VIDEO.DECODER.AVC] setting nBufferCountActual to 20 failed: -22
01-06 15:43:47.224  1300  1481 D MtkOmxVdec: 0xae808600 SetParameter index(OMX_IndexParamPortDefinition, 0x02000001)
01-06 15:43:47.224  1300  1481 D MtkOmxVdec: nBufferCountActual = 19 vs nBufferCountMin = 16
01-06 15:43:47.224  1300  1481 E OMXNodeInstance: setParameter(0xae808604:MTK.DECODER.AVC, ParamPortDefinition(0x2000001)) ERROR: BadParameter(0x80001005)
01-06 15:43:47.224  7244  7469 W ACodec  : [OMX.MTK.VIDEO.DECODER.AVC] setting nBufferCountActual to 19 failed: -22
01-06 15:43:47.224  1300  2655 D MtkOmxVdec: 0xae808600 SetParameter index(OMX_IndexParamPortDefinition, 0x02000001)
01-06 15:43:47.225  3292  3694 I katniss_interactor_MediaSessionStateTrackerImpl: We do not track the playback state: PlaybackState {state=6, position=20637, buffered position=20637, speed=0.0, updated=41365452, actions=2364287, custom actions=[], active item id=0, error=null}
01-06 15:43:47.225  1273  1601 W GrallocMapperPassthrough: buffer descriptor with invalid usage bits 0x2000
01-06 15:43:47.227  1266  1266 D gralloc : mali_gralloc_select_format: req_format=0x7f000101 req_fmt_mapped=0x7f000101 internal_format=0x7f000101 usage=0x30002900
01-06 15:43:47.227  1266  1266 D gralloc : set_ion_flags heap_mask:0x1 usage:0x30002900
01-06 15:43:47.227  1266  1266 D gralloc : mtk_gralloc_ion_allocate() implement to FBM, usg=0x30002900, w=1280, h=720, format=0x7f000101, *pHandle=0xb09c10c0
01-06 15:43:47.227  3375  3375 D NowPlayingListener: updateNowPlayingNotification with controller: NowPlayingMediaController {packageName = org.schabi.newpipe.debug.surfacefix, state = 6, metadata = Peru 8K HDR 60FPS (FUHD), Jacob + Katie Schwarz, null}
01-06 15:43:47.227  3375  3375 D NowPlayingListener: updateMetadata() called with: metadata description = [Peru 8K HDR 60FPS (FUHD), Jacob + Katie Schwarz, null] and now playing listener: dqv@dc6a376
01-06 15:43:47.244  1300  1480 I vndksupport: sphal namespace is not configured for this process. Loading /vendor/lib/hw/gralloc.mt5891.so from the current namespace instead.
01-06 15:43:47.246  7244  7244 D MediaSourceManager@72657347: MediaSource - loadImmediate() called
01-06 15:43:47.246  7244  7244 D MediaSourceManager@72657347: MediaSource - maybeClearLoaders() called.
01-06 15:43:47.247  7244  7244 D MediaSourceManager@72657347: maybeLoadItem() called.
01-06 15:43:47.248  3766  3766 D BasicMediaStatusFactory: Supported media session actions: 2364287
01-06 15:43:47.255  3375  3375 D NowPlayingManager: onMediaDataUpdated() called with: NowPlayingData [dqs@f838025, title=Peru 8K HDR 60FPS (FUHD), artist=Jacob + Katie Schwarz]
01-06 15:43:47.256  3375  3375 D NowPlayingListener: updatePlayback() called with: state = [PlaybackState {state=6, position=20637, buffered position=20637, speed=0.0, updated=41365452, actions=2364287, custom actions=[], active item id=0, error=null}] and now playing listener: dqv@dc6a376
01-06 15:43:47.256  3375  3375 D NowPlayingManager: onClientPlaybackStateUpdate() called with: state = [6], stateChangeTimeMs = [41365452], currentPosMs = [20637]
01-06 15:43:47.256  3375  3375 D NowPlayingManager: onClientPlaybackStateUpdate: Skipped update, state: 6 was unchanged
01-06 15:43:47.281  1300  1480 D MtkOmxVdec: 0xae808600 SetParameter index(OMX_GoogleAndroidIndexUseAndroidNativeBuffer, 0x7F000101)
01-06 15:43:47.281  1300  1480 E GRM     : mtkrm_get_cur_id@line:488!! MTKRM_IPCR_NOT_OPENED
01-06 15:43:47.281  1300  1480 E GRM     : mtkrm_ipc_do_op@line:1645!! MTKRM_IPCR_NOT_OPENED
01-06 15:43:47.281  1300  1480 E GRM     : Open client:IMtkRmClientComponentAddResource #96 try to auto connect
01-06 15:43:47.287  1365  7481 I GRM     : add resource VideoPath(0)
01-06 15:43:47.287  1365  7481 I GRM     : addResource.1739, MtkOmxVdec add resource VideoPath(0)
01-06 15:43:47.287  1365  7481 I GRM     : Resource Type matched, RESOURCE_TYPE_NUMBERNIC!
01-06 15:43:47.287  1365  7481 I GRM     : add resource VideoPath(0), return 1
01-06 15:43:47.287  1300  1480 I GRM     : AllocResource!!!
01-06 15:43:47.290  1365  7481 I GRM     : client(MtkOmxVdec) alloc resource
01-06 15:43:47.290  1365  7481 I GRM     : ============================Start==============================
01-06 15:43:47.290  1365  7481 I GRM     : Componet Name:MtkOmxVdec, Pid:1300, priority:100, preempt:TRUE, fg:TRUE.
01-06 15:43:47.290  1365  7481 I GRM     :      Resource Name:VideoPath, type: 0, value: 0, enable: TRUE
01-06 15:43:47.290  1365  7481 I GRM     :      Resource Name:VideoDecoder, type: 0, value: 1, enable: TRUE
01-06 15:43:47.290  1365  7481 I GRM     : Component Count: 11
01-06 15:43:47.290  1365  7481 I GRM     : =============================End===============================
01-06 15:43:47.291  1300  1480 D MtkOmxVdec: ae808600: got VDP0
01-06 15:43:47.295  1300  1480 D MtkOmxVdec: 0xae808600: u64fbmId=1
01-06 15:43:47.295  1300  1480 D MtkOmxVdec: 0xae808600: alloc mGpuIds
01-06 15:43:47.296  1300  1480 D MtkOmxVdec: MtkOmxVdec::UseGraphBuffer port(1), idx[0], pBuffHead(0xaea1c140), pBuffer(0xaea103c0), 1280x720, size(1382400), mGpuIds(0x1)
01-06 15:43:47.296  1273  1601 W GrallocMapperPassthrough: buffer descriptor with invalid usage bits 0x2000
01-06 15:43:47.296  1266  1266 D gralloc : mali_gralloc_select_format: req_format=0x7f000101 req_fmt_mapped=0x7f000101 internal_format=0x7f000101 usage=0x30002900
01-06 15:43:47.296  1266  1266 D gralloc : set_ion_flags heap_mask:0x1 usage:0x30002900
01-06 15:43:47.296  1266  1266 D gralloc : mtk_gralloc_ion_allocate() implement to FBM, usg=0x30002900, w=1280, h=720, format=0x7f000101, *pHandle=0xb09c10c0
01-06 15:43:47.298  1300  1480 D MtkOmxVdec: 0xae808600 SetParameter index(OMX_GoogleAndroidIndexUseAndroidNativeBuffer, 0x7F000101)
01-06 15:43:47.298  1300  1480 D MtkOmxVdec: 0xae808600: u64fbmId=2
01-06 15:43:47.298  1300  1480 D MtkOmxVdec: MtkOmxVdec::UseGraphBuffer port(1), idx[1], pBuffHead(0xaedaf210), pBuffer(0xaea10480), 1280x720, size(1382400), mGpuIds(0x2)
01-06 15:43:47.298  1273  1455 W GrallocMapperPassthrough: buffer descriptor with invalid usage bits 0x2000
01-06 15:43:47.299  1266  1266 D gralloc : mali_gralloc_select_format: req_format=0x7f000101 req_fmt_mapped=0x7f000101 internal_format=0x7f000101 usage=0x30002900
01-06 15:43:47.299  1266  1266 D gralloc : set_ion_flags heap_mask:0x1 usage:0x30002900
01-06 15:43:47.299  1266  1266 D gralloc : mtk_gralloc_ion_allocate() implement to FBM, usg=0x30002900, w=1280, h=720, format=0x7f000101, *pHandle=0xb09c10c0
01-06 15:43:47.300  1300  2655 D MtkOmxVdec: 0xae808600 SetParameter index(OMX_GoogleAndroidIndexUseAndroidNativeBuffer, 0x7F000101)
01-06 15:43:47.300  1300  2655 D MtkOmxVdec: 0xae808600: u64fbmId=3
01-06 15:43:47.300  1300  2655 D MtkOmxVdec: MtkOmxVdec::UseGraphBuffer port(1), idx[2], pBuffHead(0xaedaf2b0), pBuffer(0xaeddd780), 1280x720, size(1382400), mGpuIds(0x3)
01-06 15:43:47.300  1282  1282 D MTK_KL  : <4>[  744.346728] [VDP]VDP(0) Enable B2R(0)
01-06 15:43:47.300  1282  1282 D MTK_KL  : <4>[  744.351835] AP set Output Window Width or Height is 0
01-06 15:43:47.301  1273  2306 W GrallocMapperPassthrough: buffer descriptor with invalid usage bits 0x2000
01-06 15:43:47.301  1266  1266 D gralloc : mali_gralloc_select_format: req_format=0x7f000101 req_fmt_mapped=0x7f000101 internal_format=0x7f000101 usage=0x30002900
01-06 15:43:47.301  1266  1266 D gralloc : set_ion_flags heap_mask:0x1 usage:0x30002900
01-06 15:43:47.301  1266  1266 D gralloc : mtk_gralloc_ion_allocate() implement to FBM, usg=0x30002900, w=1280, h=720, format=0x7f000101, *pHandle=0xb09c10c0
01-06 15:43:47.303  1300  2581 D MtkOmxVdec: 0xae808600 SetParameter index(OMX_GoogleAndroidIndexUseAndroidNativeBuffer, 0x7F000101)
01-06 15:43:47.303  1300  2581 D MtkOmxVdec: 0xae808600: u64fbmId=4
01-06 15:43:47.303  1300  2581 D MtkOmxVdec: MtkOmxVdec::UseGraphBuffer port(1), idx[3], pBuffHead(0xaedaf350), pBuffer(0xaea10840), 1280x720, size(1382400), mGpuIds(0x4)
01-06 15:43:47.303  1273  2296 W GrallocMapperPassthrough: buffer descriptor with invalid usage bits 0x2000
01-06 15:43:47.304  1266  1266 D gralloc : mali_gralloc_select_format: req_format=0x7f000101 req_fmt_mapped=0x7f000101 internal_format=0x7f000101 usage=0x30002900
01-06 15:43:47.304  1266  1266 D gralloc : set_ion_flags heap_mask:0x1 usage:0x30002900
01-06 15:43:47.304  1266  1266 D gralloc : mtk_gralloc_ion_allocate() implement to FBM, usg=0x30002900, w=1280, h=720, format=0x7f000101, *pHandle=0xb09c10c0
01-06 15:43:47.305  1300  1481 D MtkOmxVdec: 0xae808600 SetParameter index(OMX_GoogleAndroidIndexUseAndroidNativeBuffer, 0x7F000101)
01-06 15:43:47.305  1300  1481 D MtkOmxVdec: 0xae808600: u64fbmId=5
01-06 15:43:47.305  1300  1481 D MtkOmxVdec: MtkOmxVdec::UseGraphBuffer port(1), idx[4], pBuffHead(0xaedaf3a0), pBuffer(0xaeddd840), 1280x720, size(1382400), mGpuIds(0x5)
01-06 15:43:47.306  1273  1601 W GrallocMapperPassthrough: buffer descriptor with invalid usage bits 0x2000
01-06 15:43:47.306  1266  1266 D gralloc : mali_gralloc_select_format: req_format=0x7f000101 req_fmt_mapped=0x7f000101 internal_format=0x7f000101 usage=0x30002900
01-06 15:43:47.306  1266  1266 D gralloc : set_ion_flags heap_mask:0x1 usage:0x30002900
01-06 15:43:47.306  1266  1266 D gralloc : mtk_gralloc_ion_allocate() implement to FBM, usg=0x30002900, w=1280, h=720, format=0x7f000101, *pHandle=0xb09c10c0
01-06 15:43:47.308  1300  1995 D MtkOmxVdec: 0xae808600 SetParameter index(OMX_GoogleAndroidIndexUseAndroidNativeBuffer, 0x7F000101)
01-06 15:43:47.308  1300  1995 D MtkOmxVdec: 0xae808600: u64fbmId=6
01-06 15:43:47.308  1300  1995 D MtkOmxVdec: MtkOmxVdec::UseGraphBuffer port(1), idx[5], pBuffHead(0xaedaf620), pBuffer(0xaedddcc0), 1280x720, size(1382400), mGpuIds(0x6)
01-06 15:43:47.308  1273  2296 W GrallocMapperPassthrough: buffer descriptor with invalid usage bits 0x2000
01-06 15:43:47.308  1266  1266 D gralloc : mali_gralloc_select_format: req_format=0x7f000101 req_fmt_mapped=0x7f000101 internal_format=0x7f000101 usage=0x30002900
01-06 15:43:47.308  1266  1266 D gralloc : set_ion_flags heap_mask:0x1 usage:0x30002900
01-06 15:43:47.308  1266  1266 D gralloc : mtk_gralloc_ion_allocate() implement to FBM, usg=0x30002900, w=1280, h=720, format=0x7f000101, *pHandle=0xb09c10c0
01-06 15:43:47.311  1300  2655 D MtkOmxVdec: 0xae808600 SetParameter index(OMX_GoogleAndroidIndexUseAndroidNativeBuffer, 0x7F000101)
01-06 15:43:47.311  1300  2655 D MtkOmxVdec: 0xae808600: u64fbmId=7
01-06 15:43:47.311  1300  2655 D MtkOmxVdec: MtkOmxVdec::UseGraphBuffer port(1), idx[6], pBuffHead(0xaedaf990), pBuffer(0xaeddde40), 1280x720, size(1382400), mGpuIds(0x7)
01-06 15:43:47.311  1273  2296 W GrallocMapperPassthrough: buffer descriptor with invalid usage bits 0x2000
01-06 15:43:47.312  1266  1266 D gralloc : mali_gralloc_select_format: req_format=0x7f000101 req_fmt_mapped=0x7f000101 internal_format=0x7f000101 usage=0x30002900
01-06 15:43:47.312  1266  1266 D gralloc : set_ion_flags heap_mask:0x1 usage:0x30002900
01-06 15:43:47.312  1266  1266 D gralloc : mtk_gralloc_ion_allocate() implement to FBM, usg=0x30002900, w=1280, h=720, format=0x7f000101, *pHandle=0xb09c10c0
01-06 15:43:47.313  1300  1480 D MtkOmxVdec: 0xae808600 SetParameter index(OMX_GoogleAndroidIndexUseAndroidNativeBuffer, 0x7F000101)
01-06 15:43:47.313  1300  1480 D MtkOmxVdec: 0xae808600: u64fbmId=8
01-06 15:43:47.313  1300  1480 D MtkOmxVdec: MtkOmxVdec::UseGraphBuffer port(1), idx[7], pBuffHead(0xaea1c0f0), pBuffer(0xaea10540), 1280x720, size(1382400), mGpuIds(0x8)
01-06 15:43:47.314  1273  1453 W GrallocMapperPassthrough: buffer descriptor with invalid usage bits 0x2000
01-06 15:43:47.314  1266  1266 D gralloc : mali_gralloc_select_format: req_format=0x7f000101 req_fmt_mapped=0x7f000101 internal_format=0x7f000101 usage=0x30002900
01-06 15:43:47.314  1266  1266 D gralloc : set_ion_flags heap_mask:0x1 usage:0x30002900
01-06 15:43:47.314  1266  1266 D gralloc : mtk_gralloc_ion_allocate() implement to FBM, usg=0x30002900, w=1280, h=720, format=0x7f000101, *pHandle=0xb09c10c0
01-06 15:43:47.316  1300  2581 D MtkOmxVdec: 0xae808600 SetParameter index(OMX_GoogleAndroidIndexUseAndroidNativeBuffer, 0x7F000101)
01-06 15:43:47.316  1300  2581 D MtkOmxVdec: 0xae808600: u64fbmId=9
01-06 15:43:47.316  1300  2581 D MtkOmxVdec: MtkOmxVdec::UseGraphBuffer port(1), idx[8], pBuffHead(0xaea1c0a0), pBuffer(0xaea10900), 1280x720, size(1382400), mGpuIds(0x9)
01-06 15:43:47.316  1273  1601 W GrallocMapperPassthrough: buffer descriptor with invalid usage bits 0x2000
01-06 15:43:47.317  1266  1266 D gralloc : mali_gralloc_select_format: req_format=0x7f000101 req_fmt_mapped=0x7f000101 internal_format=0x7f000101 usage=0x30002900
01-06 15:43:47.317  1266  1266 D gralloc : set_ion_flags heap_mask:0x1 usage:0x30002900
01-06 15:43:47.317  1266  1266 D gralloc : mtk_gralloc_ion_allocate() implement to FBM, usg=0x30002900, w=1280, h=720, format=0x7f000101, *pHandle=0xb09c10c0
01-06 15:43:47.319  7244  7470 D SeekbarPrevThumbHolder: Downloading bitmap for seekbarPreview from 'https://i.ytimg.com/sb/1La4QzGeaaQ/storyboard3_L2/M1.jpg?sqp=-oaymwENSDfyq4qpAwVwAcABBqLzl_8DBgjYtpiaBg==&sigh=rs$AOn4CLCBwAZWuVF7rTf3JbKGSKZPrhGXng'
01-06 15:43:47.320  1300  1481 D MtkOmxVdec: 0xae808600 SetParameter index(OMX_GoogleAndroidIndexUseAndroidNativeBuffer, 0x7F000101)
01-06 15:43:47.320  1300  1481 D MtkOmxVdec: 0xae808600: u64fbmId=10
01-06 15:43:47.320  1300  1481 D MtkOmxVdec: MtkOmxVdec::UseGraphBuffer port(1), idx[9], pBuffHead(0xaedaf710), pBuffer(0xaeddd900), 1280x720, size(1382400), mGpuIds(0xa)
01-06 15:43:47.321  1273  1455 W GrallocMapperPassthrough: buffer descriptor with invalid usage bits 0x2000
01-06 15:43:47.321  1266  1266 D gralloc : mali_gralloc_select_format: req_format=0x7f000101 req_fmt_mapped=0x7f000101 internal_format=0x7f000101 usage=0x30002900
01-06 15:43:47.321  1266  1266 D gralloc : set_ion_flags heap_mask:0x1 usage:0x30002900
01-06 15:43:47.321  1266  1266 D gralloc : mtk_gralloc_ion_allocate() implement to FBM, usg=0x30002900, w=1280, h=720, format=0x7f000101, *pHandle=0xb09c10c0
01-06 15:43:47.323  1300  1995 D MtkOmxVdec: 0xae808600 SetParameter index(OMX_GoogleAndroidIndexUseAndroidNativeBuffer, 0x7F000101)
01-06 15:43:47.323  1300  1995 D MtkOmxVdec: 0xae808600: u64fbmId=11
01-06 15:43:47.323  1300  1995 D MtkOmxVdec: MtkOmxVdec::UseGraphBuffer port(1), idx[10], pBuffHead(0xaedaf530), pBuffer(0xaedddd80), 1280x720, size(1382400), mGpuIds(0xb)
01-06 15:43:47.324  1273  1455 W GrallocMapperPassthrough: buffer descriptor with invalid usage bits 0x2000
01-06 15:43:47.324  1266  1266 D gralloc : mali_gralloc_select_format: req_format=0x7f000101 req_fmt_mapped=0x7f000101 internal_format=0x7f000101 usage=0x30002900
01-06 15:43:47.324  1266  1266 D gralloc : set_ion_flags heap_mask:0x1 usage:0x30002900
01-06 15:43:47.324  1266  1266 D gralloc : mtk_gralloc_ion_allocate() implement to FBM, usg=0x30002900, w=1280, h=720, format=0x7f000101, *pHandle=0xb09c10c0
01-06 15:43:47.327  1300  2655 D MtkOmxVdec: 0xae808600 SetParameter index(OMX_GoogleAndroidIndexUseAndroidNativeBuffer, 0x7F000101)
01-06 15:43:47.327  1300  2655 D MtkOmxVdec: 0xae808600: u64fbmId=12
01-06 15:43:47.327  1300  2655 D MtkOmxVdec: MtkOmxVdec::UseGraphBuffer port(1), idx[11], pBuffHead(0xaedaf940), pBuffer(0xaedddf00), 1280x720, size(1382400), mGpuIds(0xc)
01-06 15:43:47.327  1273  2306 W GrallocMapperPassthrough: buffer descriptor with invalid usage bits 0x2000
01-06 15:43:47.328  1266  1266 D gralloc : mali_gralloc_select_format: req_format=0x7f000101 req_fmt_mapped=0x7f000101 internal_format=0x7f000101 usage=0x30002900
01-06 15:43:47.328  1266  1266 D gralloc : set_ion_flags heap_mask:0x1 usage:0x30002900
01-06 15:43:47.328  1266  1266 D gralloc : mtk_gralloc_ion_allocate() implement to FBM, usg=0x30002900, w=1280, h=720, format=0x7f000101, *pHandle=0xb09c10c0
01-06 15:43:47.330  1300  1480 D MtkOmxVdec: 0xae808600 SetParameter index(OMX_GoogleAndroidIndexUseAndroidNativeBuffer, 0x7F000101)
01-06 15:43:47.330  1300  1480 D MtkOmxVdec: 0xae808600: u64fbmId=13
01-06 15:43:47.330  1300  1480 D MtkOmxVdec: MtkOmxVdec::UseGraphBuffer port(1), idx[12], pBuffHead(0xaea1c190), pBuffer(0xaea10c00), 1280x720, size(1382400), mGpuIds(0xd)
01-06 15:43:47.331  1273  1453 W GrallocMapperPassthrough: buffer descriptor with invalid usage bits 0x2000
01-06 15:43:47.331  1266  1266 D gralloc : mali_gralloc_select_format: req_format=0x7f000101 req_fmt_mapped=0x7f000101 internal_format=0x7f000101 usage=0x30002900
01-06 15:43:47.331  1266  1266 D gralloc : set_ion_flags heap_mask:0x1 usage:0x30002900
01-06 15:43:47.331  1266  1266 D gralloc : mtk_gralloc_ion_allocate() implement to FBM, usg=0x30002900, w=1280, h=720, format=0x7f000101, *pHandle=0xb09c10c0
01-06 15:43:47.336  1300  2581 D MtkOmxVdec: 0xae808600 SetParameter index(OMX_GoogleAndroidIndexUseAndroidNativeBuffer, 0x7F000101)
01-06 15:43:47.336  1300  2581 D MtkOmxVdec: 0xae808600: u64fbmId=14
01-06 15:43:47.336  1300  2581 D MtkOmxVdec: MtkOmxVdec::UseGraphBuffer port(1), idx[13], pBuffHead(0xaedaf300), pBuffer(0xaea109c0), 1280x720, size(1382400), mGpuIds(0xe)
01-06 15:43:47.337  1273  1453 W GrallocMapperPassthrough: buffer descriptor with invalid usage bits 0x2000
01-06 15:43:47.337  1266  1266 D gralloc : mali_gralloc_select_format: req_format=0x7f000101 req_fmt_mapped=0x7f000101 internal_format=0x7f000101 usage=0x30002900
01-06 15:43:47.337  1266  1266 D gralloc : set_ion_flags heap_mask:0x1 usage:0x30002900
01-06 15:43:47.337  1266  1266 D gralloc : mtk_gralloc_ion_allocate() implement to FBM, usg=0x30002900, w=1280, h=720, format=0x7f000101, *pHandle=0xb09c10c0
01-06 15:43:47.342  1300  1481 D MtkOmxVdec: 0xae808600 SetParameter index(OMX_GoogleAndroidIndexUseAndroidNativeBuffer, 0x7F000101)
01-06 15:43:47.342  1300  1481 D MtkOmxVdec: 0xae808600: u64fbmId=15
01-06 15:43:47.342  1300  1481 D MtkOmxVdec: MtkOmxVdec::UseGraphBuffer port(1), idx[14], pBuffHead(0xaea1c3c0), pBuffer(0xaeddd9c0), 1280x720, size(1382400), mGpuIds(0xf)
01-06 15:43:47.343  1273  2296 W GrallocMapperPassthrough: buffer descriptor with invalid usage bits 0x2000
01-06 15:43:47.343  1266  1266 D gralloc : mali_gralloc_select_format: req_format=0x7f000101 req_fmt_mapped=0x7f000101 internal_format=0x7f000101 usage=0x30002900
01-06 15:43:47.343  1266  1266 D gralloc : set_ion_flags heap_mask:0x1 usage:0x30002900
01-06 15:43:47.343  1266  1266 D gralloc : mtk_gralloc_ion_allocate() implement to FBM, usg=0x30002900, w=1280, h=720, format=0x7f000101, *pHandle=0xb09c10c0
01-06 15:43:47.346  1300  1995 D MtkOmxVdec: 0xae808600 SetParameter index(OMX_GoogleAndroidIndexUseAndroidNativeBuffer, 0x7F000101)
01-06 15:43:47.346  1300  1995 D MtkOmxVdec: 0xae808600: u64fbmId=16
01-06 15:43:47.346  1300  1995 D MtkOmxVdec: MtkOmxVdec::UseGraphBuffer port(1), idx[15], pBuffHead(0xaea1cb40), pBuffer(0xaedde140), 1280x720, size(1382400), mGpuIds(0x10)
01-06 15:43:47.347  1273  2306 W GrallocMapperPassthrough: buffer descriptor with invalid usage bits 0x2000
01-06 15:43:47.347  1266  1266 D gralloc : mali_gralloc_select_format: req_format=0x7f000101 req_fmt_mapped=0x7f000101 internal_format=0x7f000101 usage=0x30002900
01-06 15:43:47.347  1266  1266 D gralloc : set_ion_flags heap_mask:0x1 usage:0x30002900
01-06 15:43:47.347  1266  1266 D gralloc : mtk_gralloc_ion_allocate() implement to FBM, usg=0x30002900, w=1280, h=720, format=0x7f000101, *pHandle=0xb09c10c0
01-06 15:43:47.349  1300  2655 D MtkOmxVdec: 0xae808600 SetParameter index(OMX_GoogleAndroidIndexUseAndroidNativeBuffer, 0x7F000101)
01-06 15:43:47.349  1300  2655 D MtkOmxVdec: 0xae808600: u64fbmId=17
01-06 15:43:47.349  1300  2655 D MtkOmxVdec: MtkOmxVdec::UseGraphBuffer port(1), idx[16], pBuffHead(0xaedaf800), pBuffer(0xaedddfc0), 1280x720, size(1382400), mGpuIds(0x11)
01-06 15:43:47.350  1273  1601 W GrallocMapperPassthrough: buffer descriptor with invalid usage bits 0x2000
01-06 15:43:47.354  1266  1266 D gralloc : mali_gralloc_select_format: req_format=0x7f000101 req_fmt_mapped=0x7f000101 internal_format=0x7f000101 usage=0x30002900
01-06 15:43:47.354  1266  1266 D gralloc : set_ion_flags heap_mask:0x1 usage:0x30002900
01-06 15:43:47.354  1266  1266 D gralloc : mtk_gralloc_ion_allocate() implement to FBM, usg=0x30002900, w=1280, h=720, format=0x7f000101, *pHandle=0xb09c10c0
01-06 15:43:47.356  1300  1480 D MtkOmxVdec: 0xae808600 SetParameter index(OMX_GoogleAndroidIndexUseAndroidNativeBuffer, 0x7F000101)
01-06 15:43:47.356  1300  1480 D MtkOmxVdec: 0xae808600: u64fbmId=18
01-06 15:43:47.356  1300  1480 D MtkOmxVdec: MtkOmxVdec::UseGraphBuffer port(1), idx[17], pBuffHead(0xaea1c1e0), pBuffer(0xaea10cc0), 1280x720, size(1382400), mGpuIds(0x12)
01-06 15:43:47.356  1300  1480 D MtkOmxVdec: UseGraphBuffer:: output port populated
01-06 15:43:47.358  1300  2581 D MtkOmxVdec: ae808600: MtkOmxVdec::SendCommand cmd=OMX_CommandStateSet
01-06 15:43:47.359  1300  7475 D MtkOmxVdec: ae808600: # Got general command (OMX_CommandStateSet)
01-06 15:43:47.359  1300  7475 D MtkOmxVdec: ae808600: MtkOmxVdec::HandleStateSet 3
01-06 15:43:47.359  1300  7475 D MtkOmxVdec: ae808600: Request [OMX_StateIdle]-> [OMX_StateExecuting]
01-06 15:43:47.359  1300  7475 D MtkOmxVdec: ae808600: state changes to OMX_StateExecuting
01-06 15:43:47.359  1300  7475 D MtkOmxVdec: ae808600: delay 10ms to workaround google flush issue
01-06 15:43:47.387  1300  7476 D MtkOmxVdec: ae808600: set picture info: frame rate 60 width 1280 height 720
01-06 15:43:47.387  1300  7476 E GRM     : mtkrm_get_cur_id@line:488!! MTKRM_IPCR_NOT_OPENED
01-06 15:43:47.387  1300  7476 E GRM     : mtkrm_ipc_do_op@line:1645!! MTKRM_IPCR_NOT_OPENED
01-06 15:43:47.388  1300  7476 E GRM     : Open client:IMtkRmClientComponentAddResource #96 try to auto connect
01-06 15:43:47.390  1365  7484 I GRM     : add resource DMXPlaybackPID(1)
01-06 15:43:47.390  1365  7484 I GRM     : addResource.1739, MtkOmxVdec add resource DMXPlaybackPID(1)
01-06 15:43:47.390  1365  7484 I GRM     : Resource Type matched, RESOURCE_TYPE_AMOUNT!
01-06 15:43:47.390  1365  7484 I GRM     : add resource DMXPlaybackPID(1), return 1
01-06 15:43:47.390  1300  7476 I GRM     : AllocResource!!!
01-06 15:43:47.390  1365  7484 I GRM     : client(MtkOmxVdec) alloc resource
01-06 15:43:47.390  1365  7484 I GRM     : (DMXPlaybackPID)Amount:96, valid:96.
01-06 15:43:47.390  1365  7484 I GRM     : ============================Start==============================
01-06 15:43:47.390  1365  7484 I GRM     : Componet Name:MtkOmxVdec, Pid:1300, priority:100, preempt:TRUE, fg:TRUE.
01-06 15:43:47.390  1365  7484 I GRM     :      Resource Name:DMXPlaybackPID, type: 1, value: 1, enable: TRUE
01-06 15:43:47.390  1365  7484 I GRM     :      Resource Name:VideoPath, type: 0, value: 0, enable: TRUE
01-06 15:43:47.390  1365  7484 I GRM     :      Resource Name:VideoDecoder, type: 0, value: 1, enable: TRUE
01-06 15:43:47.390  1365  7484 I GRM     : Component Count: 11
01-06 15:43:47.390  1365  7484 I GRM     : =============================End===============================
01-06 15:43:47.391  1300  7476 D MtkOmxVdec: ae808600: Set Vdp Id to 0
01-06 15:43:47.391  1300  7476 D VCodecDrv: eVDecDrvSetParam(L:1106) set SEAMLESS_PLAY
01-06 15:43:47.391  1300  7476 D MtkOmxVdec: ae808600: Enable Vdec Seamless Playback, Target W:1280 H:720
01-06 15:43:47.392  1300  7476 D MtkOmxVdec: ae808600: InitVideoDecodeHW OK iDisplayWidth(0), iDisplayHeight(0), nFrameWidth(1280), nFrameHeight(720)
01-06 15:43:47.396  7244  7483 I OMXClient: Treble IOmx obtained
01-06 15:43:47.397  1300  1480 I OMXMaster: makeComponentInstance(OMX.google.aac.decoder) in omx@1.0-service process
01-06 15:43:47.401  1282  1282 D MTK_KL  : <4>[  744.446753] [vomx] use vdp0
01-06 15:43:47.401  1282  1282 D MTK_KL  : <4>[  744.446857] [VDEC][VDEC-SET 1] Seamless target[1280 x 720]
01-06 15:43:47.401  1282  1282 D MTK_KL  : <4>[  744.446864] [vomx] adaptive playback enabled, max size: 1280x720
01-06 15:43:47.401  1282  1282 D MTK_KL  : <4>[  744.446943] [VDEC][VPUSH-1] Play(1) fmt=2
01-06 15:43:47.401  1282  1282 D MTK_KL  : <4>[  744.446978] [VDEC]VDEC[1] Stop done
01-06 15:43:47.401  1282  1282 D MTK_KL  : <4>[  744.447240] [VDEC]VDEC_Play Esid(1), eFmt(2)
01-06 15:43:47.401  1282  1282 D MTK_KL  : <4>[  744.447275] [VDEC][VPUSH] fgFifoFull=0
01-06 15:43:47.401  1282  1282 D MTK_KL  : <4>[  744.447423] [VDEC]Es1 Status Change 0 to 1
01-06 15:43:47.401  1282  1282 D MTK_KL  : <4>[  744.447452] [VDEC]_VDEC_DecCfg(1), eCurFMT:2 fgMMPlayback 1
01-06 15:43:47.401  1282  1282 D MTK_KL  : <4>[  744.449576] [VDEC]pStartBuff d475eb9c, pEndBuff d475ecc7, u4BitTotalBuffBitCount 2392
01-06 15:43:47.401  1282  1282 D MTK_KL  : <4>[  744.449614] [VDEC]Pre-Parser: W/H(1280x720 P @5997fps).
01-06 15:43:47.401  1282  1282 D MTK_KL  : <4>[  744.449658] [VDEC]seamless disable UFO.
01-06 15:43:47.410  1300  1481 E OMXNodeInstance: setConfig(0xaea272a0:google.aac.decoder, ConfigPriority(0x6f800002)) ERROR: Undefined(0x80001001)
01-06 15:43:47.410  7244  7483 I ACodec  : codec does not support config priority (err -2147483648)
01-06 15:43:47.410  1300  1480 E OMXNodeInstance: getConfig(0xaea272a0:google.aac.decoder, ConfigAndroidVendorExtension(0x6f100004)) ERROR: Undefined(0x80001001)
01-06 15:43:47.423  1259  1259 W /system/bin/hw/android.hidl.allocator@1.0-service: ashmem_create_region(8192) returning hidl_memory(0xb4818990, 8192)
01-06 15:43:47.427  1259  1259 I chatty  : uid=1000(system) allocator@1.0-s identical 2 lines
01-06 15:43:47.429  1259  1259 W /system/bin/hw/android.hidl.allocator@1.0-service: ashmem_create_region(8192) returning hidl_memory(0xb4818990, 8192)
01-06 15:43:47.432  1259  1259 W /system/bin/hw/android.hidl.allocator@1.0-service: ashmem_create_region(32768) returning hidl_memory(0xb4818990, 32768)
01-06 15:43:47.440  1259  1259 I chatty  : uid=1000(system) allocator@1.0-s identical 2 lines
01-06 15:43:47.443  1259  1259 W /system/bin/hw/android.hidl.allocator@1.0-service: ashmem_create_region(32768) returning hidl_memory(0xb4818990, 32768)
01-06 15:43:47.455  1300  7486 I SoftAAC2: Reconfiguring decoder: 0->44100 Hz, 0->2 channels
01-06 15:43:47.466  1282  1282 D MTK_KL  : <4>[  744.506817] [FBM]FBM_CreateGroupExt: FbgType(1) Codec(1) HV(1280, 720) 10Bit(0) UFO(0) SeamlessMode(1028) .ref(3)
01-06 15:43:47.466  1282  1282 D MTK_KL  : <4>[  744.506945] [FBM]Prepare mv Buffer Start Addr 0x751b87d8
01-06 15:43:47.471  7244  7470 D SeekbarPrevThumbHolder: Downloading bitmap for seekbarPreview from 'https://i.ytimg.com/sb/1La4QzGeaaQ/storyboard3_L2/M2.jpg?sqp=-oaymwENSDfyq4qpAwVwAcABBqLzl_8DBgjYtpiaBg==&sigh=rs$AOn4CLCBwAZWuVF7rTf3JbKGSKZPrhGXng'
01-06 15:43:47.474  1259  1259 W /system/bin/hw/android.hidl.allocator@1.0-service: ashmem_create_region(32768) returning hidl_memory(0xb4818990, 32768)
01-06 15:43:47.478  1259  1259 I chatty  : uid=1000(system) allocator@1.0-s identical 2 lines
01-06 15:43:47.480  1259  1259 W /system/bin/hw/android.hidl.allocator@1.0-service: ashmem_create_region(32768) returning hidl_memory(0xb4818990, 32768)
01-06 15:43:47.485  1282  1282 D MTK_KL  : <4>[  744.524156] [FBM]Creat Fbg1 cost -> 17 ms
01-06 15:43:47.485  1282  1282 D MTK_KL  : <4>[  744.524332] [VDEC]register callbackFBM_CB_FUNC_FB_READY_EX_IND 0,0
01-06 15:43:47.485  1282  1282 D MTK_KL  : <4>[  744.524396] [FBM]FBM_SetSeqChgFbId ucFbgId  0 ucFbId 20
01-06 15:43:47.485  1282  1282 D MTK_KL  : <4>[  744.524553] [VDEC]resolution chg [0x0] -> [1280x720]
01-06 15:43:47.533  1288  1288 E IAudioPolicyService: Bander after getOutputForAttr
01-06 15:43:47.534  1288  1483 W AudioFlinger: createTrack_l(): mismatch between requested flags (00000008) and output flags (00000002)
01-06 15:43:47.535  1300  2581 D MtkOmxVdec: 0xae808600 GetParameter index(OMX_IndexParamPortDefinition, 0x02000001)
01-06 15:43:47.536  1300  2581 D MtkOmxVdec: 0xae808600: Get OMX_IndexParamPortDefinition Output Buffer Size: 1382400
01-06 15:43:47.536  1300  1480 D MtkOmxVdec: 0xae808600 GetConfig index(OMX_IndexConfigCommonOutputCrop, 0x0700000F)
01-06 15:43:47.536  1300  1995 D MtkOmxVdec: 0xae808600 GetConfig index(OMX_IndexConfigAndroidVendorExtension, 0x6F100004)
01-06 15:43:47.536  1300  2655 D MtkOmxVdec: 0xae808600 GetConfig index(OMX_IndexConfigAndroidVendorExtension, 0x6F100004)
01-06 15:43:47.544  7244  7400 D AudioTrack: Client defaulted notificationFrames to 5034 for frameCount 15104
01-06 15:43:47.582  7244  7244 D Player  : onVideoSizeChanged() called with: width / height = [1280 / 720 = 1.7777778], unappliedRotationDegrees = [0], pixelWidthHeightRatio = [1.0]
01-06 15:43:47.592  7244  7244 D ViewUtils: animate():    false →  [View:surfaceForeground] [ALPHA 300:0] execOnEnd=null
01-06 15:43:47.610  1288  1482 D AudioPolicyManagerMediatek: AudioPolicyManagerMediatek::getDeviceForStrategy reroute STRATEGY_ACCESSIBILITY to STRATEGY_MEDIA
01-06 15:43:47.611  1288  1482 D AudioPolicyManagerMediatek: AudioPolicyManagerMediatek::getDeviceForStrategy reroute STRATEGY_ACCESSIBILITY to STRATEGY_MEDIA
01-06 15:43:47.615  7244  7244 D Player  : ExoPlayer - onPlaybackStateChanged() called with: playbackState = [3]
01-06 15:43:47.616  7244  7244 D Player  : ExoPlayer - updatePlaybackState() called with: playWhenReady = [true], playbackState = [3]
01-06 15:43:47.616  7244  7244 D Player  : onPrepared() called with: playWhenReady = [true]
01-06 15:43:47.620  1727  2143 I MediaFocusControl:  AudioFocus  requestAudioFocus() from uid/pid 10073/7244 clientId=android.media.AudioManager@cba20bcorg.schabi.newpipe.player.helper.AudioReactor@ea16845 req=1 flags=0x2
01-06 15:43:47.620  1282  1282 D MTK_KL  : <4>[  744.671080] [VDP]nptv seamless with (1920 1080)
01-06 15:43:47.620  1282  1282 D MTK_KL  : <4>[  744.671142] [VDP]First seq change need tell NPTV
01-06 15:43:47.620  1282  1282 D MTK_KL  : <4>[  744.671188] [FBM]u4Width 1920 u4Height 1080 u4OrgWidth 1280 u4OrgHeight 720
01-06 15:43:47.620  7244  7244 D Player  : changeState() called with: state = [124]
01-06 15:43:47.620  7244  7244 D Player  : onPlaying() called
01-06 15:43:47.621  7244  7244 D NotificationUtil: updateNotification()
01-06 15:43:47.630  1282  1282 D MTK_KL  : <4>[  744.683457] [OSD]Before PQ Module offset:i4H=402 i4V=6
01-06 15:43:47.630  1282  1282 D MTK_KL  : <4>[  744.683479] [OSD]DBG XvYCC bypass
01-06 15:43:47.630  1282  1282 D MTK_KL  : <4>[  744.683484] [OSD]DBG Gamma position 0 or 1
01-06 15:43:47.630  1282  1282 D MTK_KL  : <4>[  744.683489] [OSD]After PQ Module offset:i4H=259 i4V=6
01-06 15:43:47.636  1288  1516 D AudioFlinger: current stream 3 vol 0.047179 vlf 1.000000 vrf 1.000000 vaf 0.000000
01-06 15:43:47.636  1288  1516 D AudioFlinger: setMusicVolume to hal, lastVolume -1.000000 currentVolume 0.047179
01-06 15:43:47.636  1260  1867 D audio_hal: [out_set_volume:769]left = 0.047179, right = 0.047179, index = 20
01-06 15:43:47.637  1260  1867 I audio_hal: [setActiveDevicesVolume:287]Set volume 20 to port bt, isMute 0
01-06 15:43:47.637  1260  1867 I audio_hal: [setActiveDevicesVolume:287]Set volume 20 to port speaker, isMute 0
01-06 15:43:47.661  1282  1282 D MTK_KL  : <4>[  744.713693] ++pqsoccontrolR_vfeat_updateMetadata(NONE (signal status =3)
01-06 15:43:47.661  1282  1282 D MTK_KL  : <1>[  744.713760] pqsocctrlP_glue_notifyModeDetectionDone resolution[1920 x 1080 @ 60Hz] Type[0] Presence[1] return 0
01-06 15:43:47.661  1282  1282 D MTK_KL  : <4>[  744.713797] VDP_HDR_MODE_CHG_INFO_T bSigMode = 3
01-06 15:43:47.661  1282  1282 D MTK_KL  : <4>[  744.714511]
01-06 15:43:47.661  1282  1282 D MTK_KL  : <4>[  744.714511] Online Video - YouTube[NPTV]goks ++Calling currentSource[10] ++
01-06 15:43:47.661  1282  1282 D MTK_KL  : <1>[  744.714620] <PQCTRL><pqsoccontrolP_ntf_setCurrentSource:871]> Source=APP_VID (OTHERS)
01-06 15:43:47.661  1282  1282 D MTK_KL  : <4>[  744.714746] <IMvideoP_GetBackLightPWMFrequency:1923]> Mvideo: IMvideoP_GetBackLightPWMFrequency() wFrequency = 120, freq = 60
01-06 15:43:47.661  1282  1282 D MTK_KL  : <4>[  744.714746]
01-06 15:43:47.661  1282  1282 D MTK_KL  : <4>[  744.714780]
01-06 15:43:47.661  1282  1282 D MTK_KL  : <4>[  744.714780]
01-06 15:43:47.661  1282  1282 D MTK_KL  : <4>[  744.714780] [IMvideoP_SetCurrentSource] Source = 15
01-06 15:43:47.661  1282  1282 D MTK_KL  : <4>[  744.714780]
01-06 15:43:47.665  1282  1282 D MTK_KL  : <4>[  744.719774] [NPTV] Netflix option video play=1
01-06 15:43:47.665  1282  1282 D MTK_KL  : <4>[  744.719827] [4KBE] Skip switch panel mode(6).
01-06 15:43:47.665  1282  1282 D MTK_KL  : <4>[  744.720058] [NPTV]InOut:1
01-06 15:43:47.680  1282  1282 D MTK_KL  : <4>[  744.731598] [OSD]Before PQ Module offset:i4H=402 i4V=6
01-06 15:43:47.680  1282  1282 D MTK_KL  : <4>[  744.731623] [OSD]DBG XvYCC bypass
01-06 15:43:47.680  1282  1282 D MTK_KL  : <4>[  744.731629] [OSD]DBG Gamma position 0 or 1
01-06 15:43:47.680  1282  1282 D MTK_KL  : <4>[  744.731636] [OSD]After PQ Module offset:i4H=259 i4V=6
01-06 15:43:47.694  1260  7491 D audio_hal: [get_sound_device_by_card:301]Get a card with (mtk - mtk, NULL, 1) =  0 [mtk            ]: mtk - mtk
01-06 15:43:47.694  1260  7491 D audio_hal:  .
01-06 15:43:47.695  1282  1282 D MTK_KL  : <4>[  744.748768] [AUD]=====>>> Delay Routine Done <<<======
01-06 15:43:47.695  1282  1282 D MTK_KL  : <4>[  744.749994]
01-06 15:43:47.695  1282  1282 D MTK_KL  : <4>[  744.749994]  AUD_InitALSAPlayback_MixSnd(0)##### For Aproc SW Mixsnd
01-06 15:43:47.695  1282  1282 D MTK_KL  : <4>[  744.750037]
01-06 15:43:47.695  1282  1282 D MTK_KL  : <4>[  744.750037]  SA=0x8b4415f0, SZ=18432, EA=0x8b445df0, DestAddr=0x8b4421f0
01-06 15:43:47.695  1282  1282 D MTK_KL  : <4>[  744.750342] [AUD][_AudDspSetIec:3409]eIecCfg(0),fgEnable(1) play:1
01-06 15:43:47.695  1282  1282 D MTK_KL  : <4>[  744.750413] [AUD]No decode output force pcm
01-06 15:43:47.695  1282  1282 D MTK_KL  : <1>[  744.751104] <PQCTRL><pqsoccontrolP_ntf_onSmartModeChanged:935]> SMARTMODE=STANDARD(3)
01-06 15:43:47.696  7244  7244 D ViewUtils: animate():    false →  [NewPipeTextView:currentDisplaySeek] [SCALE_AND_ALPHA 200:0] execOnEnd=null
01-06 15:43:47.697  7244  7244 D ViewUtils: animate(): view was already gone > view = [org.schabi.newpipe.views.NewPipeTextView{2735ccb G.ED..... ......I. 0,0-0,0 #7f0a00cb app:id/currentDisplaySeek}]
01-06 15:43:47.698  7244  7244 D ViewUtils: animate():    false →  [AppCompatImageButton:playPauseButton] [SCALE_AND_ALPHA 80:0] execOnEnd=org.schabi.newpipe.player.ui.VideoPlayerUi$$ExternalSyntheticLambda42@8e8c61b
01-06 15:43:47.700  7244  7244 D ViewUtils: animate(): view was already gone > view = [androidx.appcompat.widget.AppCompatImageButton{97543c1 GFED..C.. ......ID 788,480-1130,600 #7f0a02f0 app:id/playPauseButton}]
01-06 15:43:47.701  1282  1282 D MTK_KL  : <4>[  744.751321] [AUD]Set RAW Data delay i2Delay=28,u4DelayFrame=0 u1SampleRate=48000,eDecFormat=3
01-06 15:43:47.702  2050  2215 D MtkTvConfig_jni: g_video__picture_mode
01-06 15:43:47.702  2050  2215 D TVCallback: DO_notifyConfigValuechanged cfgId=g_video__picture_mode
01-06 15:43:47.705  1282  1282 D MTK_KL  : <4>[  744.759428] [AUD]=====>>> Delay Routine Done <<<======
01-06 15:43:47.709  7244  7244 D ViewUtils: animate():     true →  [AppCompatImageButton:playPauseButton] [SCALE_AND_ALPHA 200:0] execOnEnd=null
01-06 15:43:47.710  1282  1282 D MTK_KL  : <4>[  744.761230] [AUD]Set RAW Data delay i2Delay=28,u4DelayFrame=0 u1SampleRate=48000,eDecFormat=3
01-06 15:43:47.711  2102  5295 D TvVideoManagerImpl: notifyConfigValuechanged cfgId = g_video__picture_mode
01-06 15:43:47.714  2380  2405 D TvVideoManagerImpl: ivideomanagerListeners.size()==0, return
01-06 15:43:47.715  2102  5295 D TvVideoManagerImpl: [GOT][MtkTvTVCallbackHandler] MtkTvConfigType.CFG_VIDEO_PIC_MODE, current value = 3
01-06 15:43:47.715  2102  5295 D TvVideoManagerImpl: [GOT][MtkTvTVCallbackHandler] postEvent() VIDMGR_PROPERTY_PICTURESTYLE       = 38
01-06 15:43:47.715  2102  5295 D TvVideoManagerImpl: [GOT][MtkTvTVCallbackHandler] postEvent() tpv_video_manager_picture_style_val = 3
01-06 15:43:47.715  2102  5295 D TvVideoManagerImpl:  listenertype = 0 listenerMethod = 0 param1 = 38 param2 = 3 param3 = 0
01-06 15:43:47.715  2102  2102 D TvVideoManagerImpl:  msg.what = 0 msg.arg1 = 0 msg.arg2 = 38
01-06 15:43:47.715  2102  2102 I ThreedSettings: sendmessge
01-06 15:43:47.716  2102  2102 I ThreedSettings: handle message:: THREED_MANAGER
01-06 15:43:47.720  1282  1282 D MTK_KL  : <4>[  744.772107] [AUD]=====>>> Delay Routine Done <<<======
01-06 15:43:47.725  1282  1282 D MTK_KL  : <4>[  744.776310] [AUD]Set RAW Data delay i2Delay=28,u4DelayFrame=0 u1SampleRate=48000,eDecFormat=3
01-06 15:43:47.732  3292  3694 I katniss_interactor_MediaSessionStateTrackerImpl: The mediaSession's app package name does not match the cached package name.
01-06 15:43:47.732  1282  1282 D MTK_KL  : <4>[  744.781491] [AUD]=====>>> Delay Routine Done <<<======
01-06 15:43:47.732  3375  3375 D NowPlayingListener: updateNowPlayingNotification with controller: NowPlayingMediaController {packageName = org.schabi.newpipe.debug.surfacefix, state = 3, metadata = Peru 8K HDR 60FPS (FUHD), Jacob + Katie Schwarz, null}
01-06 15:43:47.732  3375  3375 D NowPlayingListener: updateMetadata() called with: metadata description = [Peru 8K HDR 60FPS (FUHD), Jacob + Katie Schwarz, null] and now playing listener: dqv@dc6a376
01-06 15:43:47.741  1282  1282 D MTK_KL  : <4>[  744.788067] [AUD]Set RAW Data delay i2Delay=28,u4DelayFrame=0 u1SampleRate=48000,eDecFormat=3
01-06 15:43:47.749  3375  3375 D NowPlayingManager: onMediaDataUpdated() called with: NowPlayingData [dqs@d4be7ab, title=Peru 8K HDR 60FPS (FUHD), artist=Jacob + Katie Schwarz]
01-06 15:43:47.750  7244  7244 D MediaSourceManager@72657347: MediaSource - loadImmediate() called
01-06 15:43:47.751  7244  7244 D MediaSourceManager@72657347: MediaSource - maybeClearLoaders() called.
01-06 15:43:47.751  7244  7244 D MediaSourceManager@72657347: maybeLoadItem() called.
01-06 15:43:47.754  3375  3375 D NowPlayingListener: updatePlayback() called with: state = [PlaybackState {state=3, position=20686, buffered position=27343, speed=1.0, updated=41365961, actions=2364287, custom actions=[], active item id=0, error=null}] and now playing listener: dqv@dc6a376
01-06 15:43:47.754  3375  3375 D NowPlayingManager: onClientPlaybackStateUpdate() called with: state = [3], stateChangeTimeMs = [41365961], currentPosMs = [20686]
01-06 15:43:47.761  3375  3375 D NowPlayingManager: A notification for Now Playing Card has been canceled
01-06 15:43:47.761  3375  3375 D NowPlayingListener: updateMetadata() called with: metadata description = [Peru 8K HDR 60FPS (FUHD), Jacob + Katie Schwarz, null] and now playing listener: dqv@dc6a376
01-06 15:43:47.761  3766  3766 D BasicMediaStatusFactory: Supported media session actions: 2364287
01-06 15:43:47.775  3375  3375 D NowPlayingManager: onMediaDataUpdated() called with: NowPlayingData [dqs@329ee08, title=Peru 8K HDR 60FPS (FUHD), artist=Jacob + Katie Schwarz]
01-06 15:43:47.801  1288  1516 D AudioFlinger: mixer(0xaef838c0) throttle end: throttle time(45)
01-06 15:43:47.814  3375  3375 D NowPlayingManager: onMediaDataUpdated: A notification for Now Playing Card has been posted with NowPlayingData [title=Peru 8K HDR 60FPS (FUHD), artist=Jacob + Katie Schwarz]
01-06 15:43:47.945  1282  1282 D MTK_KL  : <4>[  744.997384] [MUTE]MJC_MUTE(0)
01-06 15:43:47.960  1282  1282 D MTK_KL  : <4>[  745.014625] [NPTV][Dynamic HDR Meta Plan_B]----> Test time start
01-06 15:43:48.083  1273  1273 D SurfaceFlinger: Backpressure trigger, skipping transaction & refresh!
01-06 15:43:48.150  1273  1273 D SurfaceFlinger: Backpressure trigger, skipping transaction & refresh!
01-06 15:43:48.159  3292  3292 I katniss_interactor_KatnissIpcConnection: Will disconnect service connection. .KatnissSearchProcessService
01-06 15:43:48.160  3902  3902 I katniss_search_KatnissIpcConnection: Will disconnect service connection. .LatencyLoggerService
01-06 15:43:48.165  1727  1744 E memtrack: Couldn't load memtrack module
01-06 15:43:48.165  1727  1744 W android.os.Debug: failed to get memory consumption info: -1
01-06 15:43:48.166  3902  3902 I katniss_search_KatnissIpcConnection: Will disconnect service connection. .KatnissInteractorProcessService
01-06 15:43:48.188  2733  5128 D ImageSticking_JNI: threadStart:277: KEY_PRESSED is TRUE reseting count
01-06 15:43:48.188  2733  5128 D ImageSticking_JNI:
01-06 15:43:48.250  1273  1273 D SurfaceFlinger: Backpressure trigger, skipping transaction & refresh!
01-06 15:43:48.311  1288  1516 D AudioFlinger: mixer(0xaef838c0) throttle end: throttle time(1)
01-06 15:43:48.317  1273  1273 D SurfaceFlinger: Backpressure trigger, skipping transaction & refresh!
01-06 15:43:48.417  1273  1273 D SurfaceFlinger: Backpressure trigger, skipping transaction & refresh!
01-06 15:43:48.432  1273  1601 E BufferQueueProducer: [Toast#0] disconnect: not connected (req=1)
01-06 15:43:48.432  7244  7274 W libEGL  : EGLNativeWindowType 0x8043a008 disconnect failed
01-06 15:43:48.442  1727  1727 W WindowManager: removeWindowToken: Attempted to remove non-existing token: android.os.Binder@9d0b2af
01-06 15:43:48.456  7244  7244 D LeakCanary: Watching instance of android.widget.LinearLayout (android.widget.LinearLayout received View#onDetachedFromWindow() callback) with key 827f6b46-d2a8-45fe-85ff-bcba73223ef5
01-06 15:43:48.467  1273  1273 D SurfaceFlinger: Backpressure trigger, skipping transaction & refresh!
01-06 15:43:48.567  2733  5129 I ImageStickingService: List = org.schabi.newpipe.MainActivity
01-06 15:43:48.573  2733  5129 I ImageStickingService: videoType = 416 FHD video
01-06 15:43:48.582  2733  5129 I ImageStickingService:
01-06 15:43:48.582  2733  5129 I ImageStickingService:  VIDEO_SCREEN_SAVER_STATUS from FRC = 0
01-06 15:43:48.850  7244  7255 I zygote  : Background concurrent copying GC freed 69903(3MB) AllocSpace objects, 392(25MB) LOS objects, 40% free, 34MB/58MB, paused 607us total 329.721ms
01-06 15:43:48.962  3766  6166 I chromium: [3766:6166:INFO:ssdp_device.c(101)] SSDP packets sent for 121 seconds = 8
01-06 15:43:48.985  1273  1273 D SurfaceFlinger: Backpressure trigger, skipping transaction & refresh!
01-06 15:43:50.284  3214  3214 D NettvLoggerLocalService: usagelogger LogKeyPressEvent event.getKeyCode()=19 mBinder=org.droidtv.usagelogger.ILoggerImpl$Proxy@9d2132e
01-06 15:43:50.285  1282  1282 D MTK_KL  : <4>[  747.338611] [0x3] KEY 0x3f002 map to 103 2 0 1
01-06 15:43:50.288  2681  2724 D org.droidtv.candeebug.Gateway: Returning successfully for event: {"event-type":"unknown.15","boot-count":3,"standby-count":4,"kernel-time":744091,"data":{"original-event-type":15,"device_name":0,"key_group":11}}
01-06 15:43:50.291  7244  7244 D VideoPlayerUi: showControlsThenHide() called
01-06 15:43:50.295  7244  7244 D ViewUtils: animate():     true →  [View:playbackControlsShadow] [ALPHA 300:0] execOnEnd=null
01-06 15:43:50.298  7244  7244 D ViewUtils: animate():     true →  [View:playerTopShadow] [ALPHA 300:0] execOnEnd=null
01-06 15:43:50.299  7244  7244 D ViewUtils: animate():     true →  [View:playerBottomShadow] [ALPHA 300:0] execOnEnd=null
01-06 15:43:50.303  7244  7244 D ViewUtils: animate():     true →  [RelativeLayout:playbackControlRoot] [ALPHA 300:0] execOnEnd=org.schabi.newpipe.player.ui.VideoPlayerUi$$ExternalSyntheticLambda11@1ffdd93
01-06 15:43:50.603  1906  1906 D EmojiAltPhysicalKeyDetector: onKeyUp() : KeyEvent { action=ACTION_UP, keyCode=KEYCODE_DPAD_UP, scanCode=103, metaState=0, flags=0x8, repeatCount=0, eventTime=744405, downTime=744087, deviceId=4, source=0x301 }
01-06 15:43:50.605  1282  1282 D MTK_KL  : <4>[  747.656040] [0x3] KEY 0x3f002 map to 103 2 0 0
01-06 15:43:50.606  7244  7244 D VideoPlayerUi: hideControls() called with: duration = [300], delay = [7000]
01-06 15:43:50.929  3214  3214 D NettvLoggerLocalService: usagelogger LogKeyPressEvent event.getKeyCode()=19 mBinder=org.droidtv.usagelogger.ILoggerImpl$Proxy@9d2132e
01-06 15:43:50.931  2681  2724 D org.droidtv.candeebug.Gateway: Returning successfully for event: {"event-type":"unknown.15","boot-count":3,"standby-count":4,"kernel-time":744734,"data":{"original-event-type":15,"device_name":0,"key_group":11}}
01-06 15:43:50.931  1282  1282 D MTK_KL  : <4>[  747.983727] [0x3] KEY 0x3f002 map to 103 2 0 1
01-06 15:43:50.932  7244  7244 D VideoPlayerUi: hideControls() called with: duration = [300], delay = [7000]
01-06 15:43:51.035  1288  1516 D AudioFlinger: mixer(0xaef838c0) throttle end: throttle time(1)
01-06 15:43:51.140  1282  1282 D MTK_KL  : <4>[  748.191024] <PQCTRL><pqdrivers_oledtcon_ctrl_SetGlobalLuminanceGain:501]> pqdrivers_oledtcon_ctrl_SetGlobalLuminanceGain: gain=155
01-06 15:43:51.248  1906  1906 D EmojiAltPhysicalKeyDetector: onKeyUp() : KeyEvent { action=ACTION_UP, keyCode=KEYCODE_DPAD_UP, scanCode=103, metaState=0, flags=0x8, repeatCount=0, eventTime=745050, downTime=744732, deviceId=4, source=0x301 }
01-06 15:43:51.250  1282  1282 D MTK_KL  : <4>[  748.301053] [0x3] KEY 0x3f002 map to 103 2 0 0
01-06 15:43:52.715  1282  1282 D MTK_KL  : <4>[  749.768387] [0x4] KEY 0x4f000 map to 352 2 0 1
01-06 15:43:52.718  3214  3214 D NettvLoggerLocalService: usagelogger LogKeyPressEvent event.getKeyCode()=23 mBinder=org.droidtv.usagelogger.ILoggerImpl$Proxy@9d2132e
01-06 15:43:52.721  2681  2724 D org.droidtv.candeebug.Gateway: Returning successfully for event: {"event-type":"unknown.15","boot-count":3,"standby-count":4,"kernel-time":746525,"data":{"original-event-type":15,"device_name":0,"key_group":11}}
01-06 15:43:52.934  1906  1906 D EmojiAltPhysicalKeyDetector: onKeyUp() : KeyEvent { action=ACTION_UP, keyCode=KEYCODE_DPAD_CENTER, scanCode=352, metaState=0, flags=0x8, repeatCount=0, eventTime=746735, downTime=746517, deviceId=4, source=0x301 }
01-06 15:43:52.939  1282  1282 D MTK_KL  : <4>[  749.986312] [0x4] KEY 0x4f000 map to 352 2 0 0
01-06 15:43:52.953  7244  7244 D Player  : Setting recovery, queue: 0, pos: 25855
01-06 15:43:52.958  7244  7244 D SerializedCache: put() called with: key = [18a8d5a5-d236-4233-837b-e5dd29c851fe], item = [org.schabi.newpipe.player.playqueue.SinglePlayQueue@8445041]
01-06 15:43:53.022  7244  7468 D SurfaceUtils: connecting to surface 0x80be6808, reason connectToSurface
01-06 15:43:53.022  7244  7468 E BufferQueueProducer: [SurfaceTexture-1-7244-0] connect: already connected (cur=3 req=3)
01-06 15:43:53.022  7244  7468 E SurfaceUtils: Failed to connect to surface 0x80be6808, err -22
01-06 15:43:53.022  7244  7468 E MediaCodec: nativeWindowConnect returned an error: Invalid argument (-22)
01-06 15:43:53.023  1273  1453 D BufferQueueProducer: About to force-disconnect API_MEDIA, mode=1
01-06 15:43:53.023  1273  1455 E BufferQueueProducer: [SurfaceView - org.schabi.newpipe.debug.surfacefix/org.schabi.newpipe.MainActivity#0] dequeueBuffer: BufferQueue has been disconnect
01-06 15:43:53.023  7244  7469 E ACodec  : dequeueBuffer failed: NO_INIT(-19).
01-06 15:43:53.024  1273  1453 E SurfaceFlinger: Failed to find layer (SurfaceView - org.schabi.newpipe.debug.surfacefix/org.schabi.newpipe.MainActivity#0) in layer parent (no-parent).
01-06 15:43:53.024  1273  1453 E SurfaceFlinger: Failed to find layer (Background for - SurfaceView - org.schabi.newpipe.debug.surfacefix/org.schabi.newpipe.MainActivity#0) in layer parent (no-parent).
01-06 15:43:53.026  1273  1273 D gralloc : unregister FBM buffer
01-06 15:43:53.027  1273  1273 I chatty  : uid=1000(system) /system/bin/surfaceflinger identical 13 lines
01-06 15:43:53.027  1273  1273 D gralloc : unregister FBM buffer
01-06 15:43:53.027  1267  1267 D gralloc : unregister FBM buffer
01-06 15:43:53.027  1267  1267 I chatty  : uid=1000(system) composer@2.1-se identical 16 lines
01-06 15:43:53.027  1267  1267 D gralloc : unregister FBM buffer
01-06 15:43:53.028  1273  1273 D gralloc : unregister FBM buffer
01-06 15:43:53.029  1273  1273 I chatty  : uid=1000(system) /system/bin/surfaceflinger identical 1 line
01-06 15:43:53.029  1273  1273 D gralloc : unregister FBM buffer
01-06 15:43:53.032  7244  7400 E ExoPlayerImplInternal: Playback error
01-06 15:43:53.032  7244  7400 E ExoPlayerImplInternal:   com.google.android.exoplayer2.ExoPlaybackException: Unexpected runtime error
01-06 15:43:53.032  7244  7400 E ExoPlayerImplInternal:       at com.google.android.exoplayer2.ExoPlayerImplInternal.handleMessage(ExoPlayerImplInternal.java:621)
01-06 15:43:53.032  7244  7400 E ExoPlayerImplInternal:       at android.os.Handler.dispatchMessage(Handler.java:101)
01-06 15:43:53.032  7244  7400 E ExoPlayerImplInternal:       at android.os.Looper.loop(Looper.java:164)
01-06 15:43:53.032  7244  7400 E ExoPlayerImplInternal:       at android.os.HandlerThread.run(HandlerThread.java:65)
01-06 15:43:53.032  7244  7400 E ExoPlayerImplInternal:   Caused by: java.lang.IllegalArgumentException
01-06 15:43:53.032  7244  7400 E ExoPlayerImplInternal:       at android.media.MediaCodec.native_setSurface(Native Method)
01-06 15:43:53.032  7244  7400 E ExoPlayerImplInternal:       at android.media.MediaCodec.setOutputSurface(MediaCodec.java:1987)
01-06 15:43:53.032  7244  7400 E ExoPlayerImplInternal:       at com.google.android.exoplayer2.mediacodec.SynchronousMediaCodecAdapter.setOutputSurface(SynchronousMediaCodecAdapter.java:189)
01-06 15:43:53.032  7244  7400 E ExoPlayerImplInternal:       at com.google.android.exoplayer2.video.MediaCodecVideoRenderer.setOutputSurfaceV23(MediaCodecVideoRenderer.java:1490)
01-06 15:43:53.032  7244  7400 E ExoPlayerImplInternal:       at com.google.android.exoplayer2.video.MediaCodecVideoRenderer.setOutput(MediaCodecVideoRenderer.java:693)
01-06 15:43:53.032  7244  7400 E ExoPlayerImplInternal:       at com.google.android.exoplayer2.video.MediaCodecVideoRenderer.handleMessage(MediaCodecVideoRenderer.java:631)
01-06 15:43:53.032  7244  7400 E ExoPlayerImplInternal:       at com.google.android.exoplayer2.ExoPlayerImplInternal.deliverMessage(ExoPlayerImplInternal.java:1550)
01-06 15:43:53.032  7244  7400 E ExoPlayerImplInternal:       at com.google.android.exoplayer2.ExoPlayerImplInternal.sendMessageToTarget(ExoPlayerImplInternal.java:1514)
01-06 15:43:53.032  7244  7400 E ExoPlayerImplInternal:       at com.google.android.exoplayer2.ExoPlayerImplInternal.sendMessageInternal(ExoPlayerImplInternal.java:1489)
01-06 15:43:53.032  7244  7400 E ExoPlayerImplInternal:       at com.google.android.exoplayer2.ExoPlayerImplInternal.handleMessage(ExoPlayerImplInternal.java:526)
01-06 15:43:53.032  7244  7400 E ExoPlayerImplInternal:       ... 3 more
01-06 15:43:53.035  1300  2581 D MtkOmxVdec: ae808600: MtkOmxVdec::SendCommand cmd=OMX_CommandFlush
01-06 15:43:53.036  1300  7475 D MtkOmxVdec: ae808600: # Got general command (OMX_CommandFlush)
01-06 15:43:53.036  1300  7475 D MtkOmxVdec: ae808600: MtkOmxVdec::HandleFlush nPortIndex(0xFFFFFFFF)
01-06 15:43:53.036  1300  7475 D MtkOmxVdec: ae808600: +FlushInputPort
01-06 15:43:53.036  1300  7475 D MtkOmxVdec: ae808600: FlushInputPort -> mNumPendingInput(0)
01-06 15:43:53.036  1300  7475 D MtkOmxVdec: ae808600: -FlushInputPort
01-06 15:43:53.036  1300  7475 D MtkOmxVdec: ae808600: +FlushOutputPort
01-06 15:43:53.036  1300  7475 D MtkOmxVdec: +MtkOmxVdec::FlushOutputDecoder, mFlushMode = 1
01-06 15:43:53.036  1300  7475 D MtkOmxVdec: -MtkOmxVdec::FlushOutputDecoder
01-06 15:43:53.036  1300  7474 D MtkOmxVdec: Flush Done Event received!
01-06 15:43:53.036  1300  7474 D MtkOmxVdec: 0xae808600:mDecodeDoneQ.size = 0
01-06 15:43:53.037  1300  7475 D MtkOmxVdec: ae808600: -FlushOutputPort
01-06 15:43:53.038  1273  1455 E BufferQueueProducer: [SurfaceView - org.schabi.newpipe.debug.surfacefix/org.schabi.newpipe.MainActivity#0] dequeueBuffer: BufferQueue has been abandoned
01-06 15:43:53.038  7244  7469 E ACodec  : dequeueBuffer failed: NO_INIT(-19).
01-06 15:43:53.041  1282  1282 D MTK_KL  : <4>[  750.091572] [vomx] flush
01-06 15:43:53.041  1282  1282 D MTK_KL  : <4>[  750.091923] [VDEC]ES(1) _VDecReceiveEs Flush
01-06 15:43:53.041  1282  1282 D MTK_KL  : <4>[  750.092090] [vomx] flush done
01-06 15:43:53.044  7244  7244 D PlayerService: onStartCommand() called with: intent = [Intent { cmp=org.schabi.newpipe.debug.surfacefix/org.schabi.newpipe.player.PlayerService (has extras) }], flags = [0], startId = [3]
01-06 15:43:53.045  7244  7244 D SerializedCache: take() called with: key = [18a8d5a5-d236-4233-837b-e5dd29c851fe]
01-06 15:43:53.048  1300  2655 D MtkOmxVdec: ae808600: MtkOmxVdec::SendCommand cmd=OMX_CommandStateSet
01-06 15:43:53.048  1300  2655 D MtkOmxVdec: ae808600: set MTK_OMX_VDEC_IDLE_PENDING
01-06 15:43:53.048  1300  7475 D MtkOmxVdec: ae808600: # Got general command (OMX_CommandStateSet)
01-06 15:43:53.048  1300  7475 D MtkOmxVdec: ae808600: MtkOmxVdec::HandleStateSet 2
01-06 15:43:53.048  1300  7475 D MtkOmxVdec: ae808600: Request [OMX_StateExecuting]-> [OMX_StateIdle]
01-06 15:43:53.048  1300  7475 D MtkOmxVdec: 0xae808600:sleep 90 ms for CTS issue
01-06 15:43:53.052  7244  7244 D Player  : ExoPlayer - onPositionDiscontinuity() called with oldPositionIndex = [0], oldPositionMs = [25927], newPositionIndex = [0], newPositionMs = [25855], discontinuityReason = [1]
01-06 15:43:53.052  7244  7244 D Player  : ExoPlayer - onSeekProcessed() called
01-06 15:43:53.053  7244  7244 D Player  : saveStreamProgressState() called with: progressMillis=25855, currentMetadata=[Peru 8K HDR 60FPS (FUHD)]
01-06 15:43:53.055  7244  7244 D Player  : ExoPlayer - onPlaybackStateChanged() called with: playbackState = [2]
01-06 15:43:53.055  7244  7244 D Player  : ExoPlayer - updatePlaybackState() called with: playWhenReady = [true], playbackState = [2]
01-06 15:43:53.055  7244  7244 D Player  : changeState() called with: state = [125]
01-06 15:43:53.055  7244  7244 D Player  : onBuffering() called
01-06 15:43:53.056  7244  7244 D NotificationUtil: updateNotification()
01-06 15:43:53.075  1282  1282 D MTK_KL  : <4>[  750.126103] [OSD]Before PQ Module offset:i4H=402 i4V=6
01-06 15:43:53.075  1282  1282 D MTK_KL  : <4>[  750.126116] [OSD]DBG XvYCC bypass
01-06 15:43:53.075  1282  1282 D MTK_KL  : <4>[  750.126121] [OSD]DBG Gamma position 0 or 1
01-06 15:43:53.075  1282  1282 D MTK_KL  : <4>[  750.126126] [OSD]After PQ Module offset:i4H=259 i4V=6
01-06 15:43:53.075  1282  1282 D MTK_KL  : <4>[  750.126386] AP set Output Window Width or Height is 0
01-06 15:43:53.086  1282  1282 D MTK_KL  : <4>[  750.140951] ++pqsoccontrolR_vfeat_updateMetadata(NONE (signal status =0)
01-06 15:43:53.086  1282  1282 D MTK_KL  : <1>[  750.141086] pqsocctrlP_glue_notifyModeDetectionDone resolution[1920 x 1080 @ 60Hz] Type[0] Presence[0] return 0
01-06 15:43:53.088  7244  7244 D ViewUtils: animateRotation: duration = [300], from 0.0 to → 0 in: androidx.appcompat.widget.AppCompatImageButton{5c74bf8 VFED..CL. ......ID 1784,0-1856,72 #7f0a0270 app:id/moreOptionsButton}
01-06 15:43:53.091  7244  7249 I zygote  : Do full code cache collection, code=1520KB, data=1172KB
01-06 15:43:53.100  7244  7249 I zygote  : After code cache collection, code=1479KB, data=985KB
01-06 15:43:53.107  7244  7244 D Player  : play() called
01-06 15:43:53.108  1727  1737 I MediaFocusControl:  AudioFocus  requestAudioFocus() from uid/pid 10073/7244 clientId=android.media.AudioManager@cba20bcorg.schabi.newpipe.player.helper.AudioReactor@ea16845 req=1 flags=0x2
01-06 15:43:53.110  7244  7244 D Player  : saveStreamProgressState() called with: progressMillis=25855, currentMetadata=[Peru 8K HDR 60FPS (FUHD)]
01-06 15:43:53.121  3292  3694 I katniss_interactor_MediaSessionStateTrackerImpl: We do not track the playback state: PlaybackState {state=6, position=25855, buffered position=25855, speed=0.0, updated=41371350, actions=2364287, custom actions=[], active item id=0, error=null}
01-06 15:43:53.122  3375  3375 D NowPlayingListener: updateNowPlayingNotification with controller: NowPlayingMediaController {packageName = org.schabi.newpipe.debug.surfacefix, state = 6, metadata = Peru 8K HDR 60FPS (FUHD), Jacob + Katie Schwarz, null}
01-06 15:43:53.122  3375  3375 D NowPlayingListener: updateMetadata() called with: metadata description = [Peru 8K HDR 60FPS (FUHD), Jacob + Katie Schwarz, null] and now playing listener: dqv@dc6a376
01-06 15:43:53.126  3375  3375 D NowPlayingManager: onMediaDataUpdated() called with: NowPlayingData [dqs@85f5387, title=Peru 8K HDR 60FPS (FUHD), artist=Jacob + Katie Schwarz]
01-06 15:43:53.132  3766  3766 D BasicMediaStatusFactory: Supported media session actions: 2364287
01-06 15:43:53.138  1300  7475 D MtkOmxVdec: ae808600: +FlushInputPort
01-06 15:43:53.139  1300  7475 D MtkOmxVdec: ae808600: FlushInputPort -> mNumPendingInput(0)
01-06 15:43:53.139  1300  7475 D MtkOmxVdec: ae808600: -FlushInputPort
01-06 15:43:53.139  1300  7475 D MtkOmxVdec: ae808600: +FlushOutputPort
01-06 15:43:53.139  1300  7475 D MtkOmxVdec: +MtkOmxVdec::FlushOutputDecoder, mFlushMode = 1
01-06 15:43:53.139  1300  7475 D MtkOmxVdec: -MtkOmxVdec::FlushOutputDecoder
01-06 15:43:53.139  1300  7474 D MtkOmxVdec: Flush Done Event received!
01-06 15:43:53.139  1300  7474 D MtkOmxVdec: 0xae808600:mDecodeDoneQ.size = 0
01-06 15:43:53.139  1300  7475 D MtkOmxVdec: ae808600: -FlushOutputPort
01-06 15:43:53.139  7244  7244 D MainPlayerUi: maxGestureLength = 405
01-06 15:43:53.140  1300  2581 D MtkOmxVdec: ae808600: MtkOmxVdec::SendCommand cmd=OMX_CommandStateSet
01-06 15:43:53.140  1300  2581 D MtkOmxVdec: ae808600: set MTK_OMX_VDEC_LOADED_PENDING
01-06 15:43:53.141  1300  2581 D MtkOmxVdec: 0xae808600: MtkOmxVdec::FreeBuffer input idx[1] hdr(0xaedaf440) pBuffer(0xaba60e90)
01-06 15:43:53.141  1300  7475 D MtkOmxVdec: ae808600: # Got general command (OMX_CommandStateSet)
01-06 15:43:53.141  1300  7475 D MtkOmxVdec: ae808600: MtkOmxVdec::HandleStateSet 1
01-06 15:43:53.141  1300  7475 D MtkOmxVdec: ae808600: Request [OMX_StateIdle]-> [OMX_StateLoaded]
01-06 15:43:53.142  1300  1995 D MtkOmxVdec: 0xae808600: MtkOmxVdec::FreeBuffer input idx[0] hdr(0xaedaf580) pBuffer(0xac761000)
01-06 15:43:53.142  1300  1995 D MtkOmxVdec: ae808600: MtkOmxVdec::FreeBuffer all input buffers have been freed!!! signal mInPortFreeDoneSem(1)
01-06 15:43:53.142  1282  1282 D MTK_KL  : <4>[  750.194411] [vomx] flush
01-06 15:43:53.142  1282  1282 D MTK_KL  : <4>[  750.194626] [VDEC]ES(1) _VDecReceiveEs Flush
01-06 15:43:53.142  1282  1282 D MTK_KL  : <4>[  750.194791] [vomx] flush done
01-06 15:43:53.143  1273  2306 E BufferQueueProducer: [SurfaceView - org.schabi.newpipe.debug.surfacefix/org.schabi.newpipe.MainActivity#0] cancelBuffer: BufferQueue has been abandoned
01-06 15:43:53.145  1300  1480 D MtkOmxVdec: 0xae808600: MtkOmxVdec::FreeBuffer output idx[17] hdr(0xaea1c1e0) pBuffer(0xaea10cc0)
01-06 15:43:53.145  1300  1480 D gralloc : unregister FBM buffer
01-06 15:43:53.146  1300  1480 D MtkOmxVdec: 0xae808600: MtkOmxVdec::FreeBuffer output idx[16] hdr(0xaedaf800) pBuffer(0xaedddfc0)
01-06 15:43:53.146  1300  1480 D gralloc : unregister FBM buffer
01-06 15:43:53.147  1273  1455 E BufferQueueProducer: [SurfaceView - org.schabi.newpipe.debug.surfacefix/org.schabi.newpipe.MainActivity#0] cancelBuffer: BufferQueue has been abandoned
01-06 15:43:53.147  1300  1480 D MtkOmxVdec: 0xae808600: MtkOmxVdec::FreeBuffer output idx[15] hdr(0xaea1cb40) pBuffer(0xaedde140)
01-06 15:43:53.147  1300  1480 D gralloc : unregister FBM buffer
01-06 15:43:53.148  1300  2655 D MtkOmxVdec: 0xae808600: MtkOmxVdec::FreeBuffer output idx[14] hdr(0xaea1c3c0) pBuffer(0xaeddd9c0)
01-06 15:43:53.148  1300  2655 D gralloc : unregister FBM buffer
01-06 15:43:53.148  1273  2296 E BufferQueueProducer: [SurfaceView - org.schabi.newpipe.debug.surfacefix/org.schabi.newpipe.MainActivity#0] cancelBuffer: BufferQueue has been abandoned
01-06 15:43:53.148  1300  2655 D MtkOmxVdec: 0xae808600: MtkOmxVdec::FreeBuffer output idx[13] hdr(0xaedaf300) pBuffer(0xaea109c0)
01-06 15:43:53.148  1300  2655 D gralloc : unregister FBM buffer
01-06 15:43:53.149  1273  2306 E BufferQueueProducer: [SurfaceView - org.schabi.newpipe.debug.surfacefix/org.schabi.newpipe.MainActivity#0] cancelBuffer: BufferQueue has been abandoned
01-06 15:43:53.149  1300  1480 D MtkOmxVdec: 0xae808600: MtkOmxVdec::FreeBuffer output idx[12] hdr(0xaea1c190) pBuffer(0xaea10c00)
01-06 15:43:53.149  1300  1480 D gralloc : unregister FBM buffer
01-06 15:43:53.149  1273  1453 E BufferQueueProducer: [SurfaceView - org.schabi.newpipe.debug.surfacefix/org.schabi.newpipe.MainActivity#0] cancelBuffer: BufferQueue has been abandoned
01-06 15:43:53.149  1300  2655 D MtkOmxVdec: 0xae808600: MtkOmxVdec::FreeBuffer output idx[11] hdr(0xaedaf940) pBuffer(0xaedddf00)
01-06 15:43:53.150  1300  2655 D gralloc : unregister FBM buffer
01-06 15:43:53.150  1273  1601 E BufferQueueProducer: [SurfaceView - org.schabi.newpipe.debug.surfacefix/org.schabi.newpipe.MainActivity#0] cancelBuffer: BufferQueue has been abandoned
01-06 15:43:53.150  1300  1481 D MtkOmxVdec: 0xae808600: MtkOmxVdec::FreeBuffer output idx[10] hdr(0xaedaf530) pBuffer(0xaedddd80)
01-06 15:43:53.150  1300  1481 D gralloc : unregister FBM buffer
01-06 15:43:53.151  1300  1995 D MtkOmxVdec: 0xae808600: MtkOmxVdec::FreeBuffer output idx[9] hdr(0xaedaf710) pBuffer(0xaeddd900)
01-06 15:43:53.151  1300  1995 D gralloc : unregister FBM buffer
01-06 15:43:53.151  1273  1455 E BufferQueueProducer: [SurfaceView - org.schabi.newpipe.debug.surfacefix/org.schabi.newpipe.MainActivity#0] cancelBuffer: BufferQueue has been abandoned
01-06 15:43:53.151  1300  1480 D MtkOmxVdec: 0xae808600: MtkOmxVdec::FreeBuffer output idx[8] hdr(0xaea1c0a0) pBuffer(0xaea10900)
01-06 15:43:53.151  1300  1480 D gralloc : unregister FBM buffer
01-06 15:43:53.152  1273  2296 E BufferQueueProducer: [SurfaceView - org.schabi.newpipe.debug.surfacefix/org.schabi.newpipe.MainActivity#0] cancelBuffer: BufferQueue has been abandoned
01-06 15:43:53.152  1300  2655 D MtkOmxVdec: 0xae808600: MtkOmxVdec::FreeBuffer output idx[7] hdr(0xaea1c0f0) pBuffer(0xaea10540)
01-06 15:43:53.152  1300  2655 D gralloc : unregister FBM buffer
01-06 15:43:53.152  1273  2306 E BufferQueueProducer: [SurfaceView - org.schabi.newpipe.debug.surfacefix/org.schabi.newpipe.MainActivity#0] cancelBuffer: BufferQueue has been abandoned
01-06 15:43:53.152  1300  2581 D MtkOmxVdec: 0xae808600: MtkOmxVdec::FreeBuffer output idx[6] hdr(0xaedaf990) pBuffer(0xaeddde40)
01-06 15:43:53.153  1300  2581 D gralloc : unregister FBM buffer
01-06 15:43:53.153  1273  1453 E BufferQueueProducer: [SurfaceView - org.schabi.newpipe.debug.surfacefix/org.schabi.newpipe.MainActivity#0] cancelBuffer: BufferQueue has been abandoned
01-06 15:43:53.153  1300  1481 D MtkOmxVdec: 0xae808600: MtkOmxVdec::FreeBuffer output idx[5] hdr(0xaedaf620) pBuffer(0xaedddcc0)
01-06 15:43:53.153  3375  3375 D NowPlayingManager: onMediaDataUpdated: A notification for Now Playing Card has been posted with NowPlayingData [title=Peru 8K HDR 60FPS (FUHD), artist=Jacob + Katie Schwarz]
01-06 15:43:53.153  1300  1481 D gralloc : unregister FBM buffer
01-06 15:43:53.153  3375  3375 D NowPlayingListener: updatePlayback() called with: state = [PlaybackState {state=6, position=25855, buffered position=25855, speed=0.0, updated=41371350, actions=2364287, custom actions=[], active item id=0, error=null}] and now playing listener: dqv@dc6a376
01-06 15:43:53.153  3375  3375 D NowPlayingManager: onClientPlaybackStateUpdate() called with: state = [6], stateChangeTimeMs = [41371350], currentPosMs = [25855]
01-06 15:43:53.154  1273  2296 E BufferQueueProducer: [SurfaceView - org.schabi.newpipe.debug.surfacefix/org.schabi.newpipe.MainActivity#0] cancelBuffer: BufferQueue has been abandoned
01-06 15:43:53.154  1300  1995 D MtkOmxVdec: 0xae808600: MtkOmxVdec::FreeBuffer output idx[4] hdr(0xaedaf3a0) pBuffer(0xaeddd840)
01-06 15:43:53.154  1300  1995 D gralloc : unregister FBM buffer
01-06 15:43:53.154  3375  3375 D NowPlayingManager: A notification for Now Playing Card has been canceled
01-06 15:43:53.155  1273  1455 E BufferQueueProducer: [SurfaceView - org.schabi.newpipe.debug.surfacefix/org.schabi.newpipe.MainActivity#0] cancelBuffer: BufferQueue has been abandoned
01-06 15:43:53.155  1300  1480 D MtkOmxVdec: 0xae808600: MtkOmxVdec::FreeBuffer output idx[3] hdr(0xaedaf350) pBuffer(0xaea10840)
01-06 15:43:53.155  1300  1480 D gralloc : unregister FBM buffer
01-06 15:43:53.155  1273  2306 E BufferQueueProducer: [SurfaceView - org.schabi.newpipe.debug.surfacefix/org.schabi.newpipe.MainActivity#0] cancelBuffer: BufferQueue has been abandoned
01-06 15:43:53.156  1300  2655 D MtkOmxVdec: 0xae808600: MtkOmxVdec::FreeBuffer output idx[2] hdr(0xaedaf2b0) pBuffer(0xaeddd780)
01-06 15:43:53.156  1300  2655 D gralloc : unregister FBM buffer
01-06 15:43:53.156  1273  1453 E BufferQueueProducer: [SurfaceView - org.schabi.newpipe.debug.surfacefix/org.schabi.newpipe.MainActivity#0] cancelBuffer: BufferQueue has been abandoned
01-06 15:43:53.157  1300  2581 D MtkOmxVdec: 0xae808600: MtkOmxVdec::FreeBuffer output idx[1] hdr(0xaedaf210) pBuffer(0xaea10480)
01-06 15:43:53.157  1300  2581 D gralloc : unregister FBM buffer
01-06 15:43:53.158  1273  1455 E BufferQueueProducer: [SurfaceView - org.schabi.newpipe.debug.surfacefix/org.schabi.newpipe.MainActivity#0] cancelBuffer: BufferQueue has been abandoned
01-06 15:43:53.158  1300  1995 D MtkOmxVdec: 0xae808600: MtkOmxVdec::FreeBuffer output idx[0] hdr(0xaea1c140) pBuffer(0xaea103c0)
01-06 15:43:53.158  1300  1995 D MtkOmxVdec: ae808600: MtkOmxVdec::FreeBuffer all output buffers have been freed!!! signal mOutPortFreeDoneSem(1)
01-06 15:43:53.158  1300  1995 D gralloc : unregister FBM buffer
01-06 15:43:53.158  1300  7475 D MtkOmxVdec: ae808600: +DeInitVideoDecodeHW
01-06 15:43:53.160  1727  1727 W TelecomManager: Telecom Service not found.
01-06 15:43:53.160  1282  1282 D MTK_KL  : <4>[  750.213731] [vomx] vdecomx_deinit
01-06 15:43:53.160  1282  1282 D MTK_KL  : <4>[  750.213731]
01-06 15:43:53.160  1282  1282 D MTK_KL  : <4>[  750.213866] [VDEC]Es1 Status Change 1 to 0
01-06 15:43:53.160  1282  1282 D MTK_KL  : <4>[  750.215287] ++pqsoccontrolR_vfeat_updateMetadata(NONE (signal status =0)
01-06 15:43:53.160  1282  1282 D MTK_KL  : <1>[  750.215336] pqsocctrlP_glue_notifyModeDetectionDone resolution[1920 x 1080 @ 60Hz] Type[0] Presence[0] return 0
01-06 15:43:53.160  1282  1282 D MTK_KL  : <4>[  750.216066] <PQCTRL><pqdrivers_oledtcon_ctrl_SetGlobalLuminanceGain:501]> pqdrivers_oledtcon_ctrl_SetGlobalLuminanceGain: gain=153
01-06 15:43:53.181  1300  7475 D MtkOmxVdec: ae808600: -DeInitVideoDecodeHW
01-06 15:43:53.181  1300  1480 D MtkOmxVdec: ae808600: MtkOmxVdec::GetState (mState=OMX_StateLoaded)
01-06 15:43:53.181  1300  1480 D MtkOmxCore: Mtk_OMX_FreeHandle
01-06 15:43:53.181  1300  1480 D MtkOmxVdec: ae808600: +MtkOmxVdec::ComponentDeInit
01-06 15:43:53.181  1300  7476 D MtkOmxVdec: 0xae808600: MtkOmxVdecDecodeThread terminated
01-06 15:43:53.181  1300  7475 D MtkOmxVdec: ae808600: MtkOmxVdecThread terminated
01-06 15:43:53.182  1300  7474 D MtkOmxVdec: MtkOmxVdecOutputThread will exited, signal mFlushSem
01-06 15:43:53.182  1300  7474 D MtkOmxVdec: MtkOmxVdecOutputThread terminated
01-06 15:43:53.185  1282  1282 D MTK_KL  : <4>[  750.236029] [FBM][FBM_ReleaseGroup-2910]Fbg(0) release.
01-06 15:43:53.185  1282  1282 D MTK_KL  : <4>[  750.236091] [FBM]FBM free addr 0x733a2000
01-06 15:43:53.185  1282  1282 D MTK_KL  : <4>[  750.236125] [FBM]Release Group 111 0d9eda020
01-06 15:43:53.185  1282  1282 D MTK_KL  : <4>[  750.236216] [FBM]Release Group 222 0d9eda020
01-06 15:43:53.185  1282  1282 D MTK_KL  : <4>[  750.236310] [vomx] vdecomx_deinit done
01-06 15:43:53.185  1282  1282 D MTK_KL  : <4>[  750.236310]
01-06 15:43:53.185  1282  1282 D MTK_KL  : <4>[  750.236394] [VDEC]VDEC[1] Stop notify done
01-06 15:43:53.185  1282  1282 D MTK_KL  : <4>[  750.236430] [VDEC]VDEC[1] Stop done
01-06 15:43:53.188  1288  1462 D AudioPolicyManagerMediatek: AudioPolicyManagerMediatek::getDeviceForStrategy reroute STRATEGY_ACCESSIBILITY to STRATEGY_MEDIA
01-06 15:43:53.188  1288  1462 D AudioPolicyManagerMediatek: AudioPolicyManagerMediatek::getDeviceForStrategy reroute STRATEGY_ACCESSIBILITY to STRATEGY_MEDIA
01-06 15:43:53.192  1300  7473 D VCodecDrv: Last Event Got
01-06 15:43:53.193  1300  1480 D MtkOmxVdec: ae808600: +ReleaseHwResource 0xaea27420
01-06 15:43:53.193  1300  1480 I GRM     : MTKRmReleaseAllResource(587) thiz = 0x0xaea27420.
01-06 15:43:53.194  1365  7481 I GRM     : (MtkOmxVdec)Release All Resource(0xa9d27410)
01-06 15:43:53.194  1300  1480 I GRM     : MTKRmReleaseAllResource ret=1.
01-06 15:43:53.194  1300  1480 D MtkOmxVdec: ae808600: -ReleaseHwResource
01-06 15:43:53.194  1300  1480 D MtkOmxVdec: ae808600: ~MtkOmxVdec call RMDestoryComponent(0xaea27420)
01-06 15:43:53.194  1300  1480 I GRM     : MTKRmReleaseAllResource(587) thiz = 0x0xaea27420.
01-06 15:43:53.194  1365  7481 I GRM     : (MtkOmxVdec)Release All Resource(0xa9d27410)
01-06 15:43:53.194  1300  1480 I GRM     : MTKRmReleaseAllResource ret=1.
01-06 15:43:53.194  1300  1480 I GRM     : MTKRmCallbackDone(613) thiz = 0x0xaea27420.
01-06 15:43:53.194  1365  7481 I GRM     : (MtkOmxVdec)check the callback done or not(0xa9d27410)
01-06 15:43:53.194  1300  1480 I GRM     : MTKRmCallbackDone ret=1.
01-06 15:43:53.194  1300  1480 I GRM     : Destroy Component!!! thiz = 0x0xaea27420
01-06 15:43:53.194  1365  7481 I GRM     : ============================Start==============================
01-06 15:43:53.194  1365  7481 I GRM     : Component Count: 11
01-06 15:43:53.194  1365  7481 I GRM     : =============================End===============================
01-06 15:43:53.194  1365  7481 I GRM     : MtkRmServiceDestoryComponent(1654) destory component:MtkOmxVdec
01-06 15:43:53.194  1365  7481 I GRM     : ============================Start==============================
01-06 15:43:53.194  1365  7481 I GRM     : Component Count: 10
01-06 15:43:53.194  1365  7481 I GRM     : =============================End===============================
01-06 15:43:53.194  1365  7481 I GRM     : MtkRmServiceDestoryComponent(1713) return
01-06 15:43:53.195  1282  1282 D MTK_KL  : <4>[  750.248067] [VDP]VdpId(0) fgPause(0)!
01-06 15:43:53.195  1282  1282 D MTK_KL  : <4>[  750.248108] [FBM]FBM free addr 0x6b804000
01-06 15:43:53.195  1282  1282 D MTK_KL  : <4>[  750.248165] [MPV]lock flush sema 1 super freeze 0 1480:HwBinder:1300_1
01-06 15:43:53.195  1282  1282 D MTK_KL  : <4>[  750.248257] [VDEC]VDEC[1] Stop done
01-06 15:43:53.195  1282  1282 D MTK_KL  : <4>[  750.248286] [MPV]lock flush sema done 1
01-06 15:43:53.195  1282  1282 D MTK_KL  : <4>[  750.248320] [DMX]free PID header buffer! pidx: 0, addr: 0xe1000020 Phy addr: 0x371e0020
01-06 15:43:53.195  1282  1282 D MTK_KL  : <4>[  750.248455] [DMX]_DMX_MUL_FreeTsIdx: u1Inst 1, u1TsIdx 3
01-06 15:43:53.195  1282  1282 D MTK_KL  : <4>[  750.248503] [FBM]FBM free addr 0x7d800000
01-06 15:43:53.195  1282  1282 D MTK_KL  : <4>[  750.248877] [VDP]VDP(0) disable B2R(0)
01-06 15:43:53.195  1282  1282 D MTK_KL  : <4>[  750.249058] [VDP]DTV Unmute B2R Switch VDP(0)
01-06 15:43:53.195  1282  1282 D MTK_KL  : <4>[  750.249093] [VDP]DTV Unmute B2R Switch VDP(1)
01-06 15:43:53.205  1300  1480 D MtkOmxVdec: ae808600: -MtkOmxVdec::ComponentDeInit
01-06 15:43:53.205  1300  1480 D MtkOmxVdec: 0xae808600: ~MtkOmxVdec
01-06 15:43:53.205  1300  1480 D MtkOmxCore: free_inst_handle dlclose(0x47f30ad7), free(0xae808604)
01-06 15:43:53.205  1282  1282 D MTK_KL  : <4>[  750.257750] AP set Output Window Width or Height is 0
01-06 15:43:53.221  1300  1480 I GRM     : Already free memory
01-06 15:43:53.222  7244  7468 D SurfaceUtils: disconnecting from surface 0x80adb808, reason disconnectFromSurface
01-06 15:43:53.222  7244  7468 D gralloc : unregister FBM buffer
01-06 15:43:53.223  7244  7468 I chatty  : uid=10073(u0_a73) org.schabi.newpipe.debug.surfacefix identical 16 lines
01-06 15:43:53.223  7244  7468 D gralloc : unregister FBM buffer
01-06 15:43:53.282  7244  7244 E Player  : ExoPlayer - onPlayerError() called with:Bundle[{0=1004, 1=41371258, 2=Unexpected runtime error, 3=java.lang.IllegalArgumentException, 4=null, rt=2, ru=null, rv=-1, rx=4, ry=false}]
01-06 15:43:53.283  7244  7244 D Player  : saveStreamProgressState() called with: progressMillis=25855, currentMetadata=[Peru 8K HDR 60FPS (FUHD)]
01-06 15:43:53.289  7244  7244 D Player  : Unexpected PlaybackException! Cause: java.lang.IllegalArgumentException
01-06 15:43:53.289  7244  7244 D Player  :      at android.media.MediaCodec.native_setSurface(Native Method)
01-06 15:43:53.289  7244  7244 D Player  :      at android.media.MediaCodec.setOutputSurface(MediaCodec.java:1987)
01-06 15:43:53.289  7244  7244 D Player  :      at com.google.android.exoplayer2.mediacodec.SynchronousMediaCodecAdapter.setOutputSurface(SynchronousMediaCodecAdapter.java:189)
01-06 15:43:53.289  7244  7244 D Player  :      at com.google.android.exoplayer2.video.MediaCodecVideoRenderer.setOutputSurfaceV23(MediaCodecVideoRenderer.java:1490)
01-06 15:43:53.289  7244  7244 D Player  :      at com.google.android.exoplayer2.video.MediaCodecVideoRenderer.setOutput(MediaCodecVideoRenderer.java:693)
01-06 15:43:53.289  7244  7244 D Player  :      at com.google.android.exoplayer2.video.MediaCodecVideoRenderer.handleMessage(MediaCodecVideoRenderer.java:631)
01-06 15:43:53.289  7244  7244 D Player  :      at com.google.android.exoplayer2.ExoPlayerImplInternal.deliverMessage(ExoPlayerImplInternal.java:1550)
01-06 15:43:53.289  7244  7244 D Player  :      at com.google.android.exoplayer2.ExoPlayerImplInternal.sendMessageToTarget(ExoPlayerImplInternal.java:1514)
01-06 15:43:53.289  7244  7244 D Player  :      at com.google.android.exoplayer2.ExoPlayerImplInternal.sendMessageInternal(ExoPlayerImplInternal.java:1489)
01-06 15:43:53.289  7244  7244 D Player  :      at com.google.android.exoplayer2.ExoPlayerImplInternal.handleMessage(ExoPlayerImplInternal.java:526)
01-06 15:43:53.289  7244  7244 D Player  :      at android.os.Handler.dispatchMessage(Handler.java:101)
01-06 15:43:53.289  7244  7244 D Player  :      at android.os.Looper.loop(Looper.java:164)
01-06 15:43:53.289  7244  7244 D Player  :      at android.os.HandlerThread.run(HandlerThread.java:65)
01-06 15:43:53.292  7244  7244 D Player  : Unable to check tunneling enablement status: java.lang.NullPointerException: Attempt to read from field 'boolean com.google.android.exoplayer2.RendererConfiguration.tunneling' on a null object reference
01-06 15:43:53.292  7244  7244 D Player  :      at com.google.android.exoplayer2.ExoPlayerImpl.isTunnelingEnabled(ExoPlayerImpl.java:1673)
01-06 15:43:53.292  7244  7244 D Player  :      at org.schabi.newpipe.player.Player.onPlayerError(Player.java:1431)
01-06 15:43:53.292  7244  7244 D Player  :      at com.google.android.exoplayer2.ExoPlayerImpl.lambda$updatePlaybackInfo$16(ExoPlayerImpl.java:1902)
01-06 15:43:53.292  7244  7244 D Player  :      at com.google.android.exoplayer2.ExoPlayerImpl$$ExternalSyntheticLambda15.invoke(Unknown Source:4)
01-06 15:43:53.292  7244  7244 D Player  :      at com.google.android.exoplayer2.util.ListenerSet$ListenerHolder.invoke(ListenerSet.java:282)
01-06 15:43:53.292  7244  7244 D Player  :      at com.google.android.exoplayer2.util.ListenerSet.lambda$queueEvent$0(ListenerSet.java:190)
01-06 15:43:53.292  7244  7244 D Player  :      at com.google.android.exoplayer2.util.ListenerSet$$ExternalSyntheticLambda1.run(Unknown Source:6)
01-06 15:43:53.292  7244  7244 D Player  :      at com.google.android.exoplayer2.util.ListenerSet.flushEvents(ListenerSet.java:211)
01-06 15:43:53.292  7244  7244 D Player  :      at com.google.android.exoplayer2.ExoPlayerImpl.updatePlaybackInfo(ExoPlayerImpl.java:1966)
01-06 15:43:53.292  7244  7244 D Player  :      at com.google.android.exoplayer2.ExoPlayerImpl.handlePlaybackInfo(ExoPlayerImpl.java:1794)
01-06 15:43:53.292  7244  7244 D Player  :      at com.google.android.exoplayer2.ExoPlayerImpl.lambda$new$1$com-google-android-exoplayer2-ExoPlayerImpl(ExoPlayerImpl.java:312)
01-06 15:43:53.292  7244  7244 D Player  :      at com.google.android.exoplayer2.ExoPlayerImpl$$ExternalSyntheticLambda24.run(Unknown Source:4)
01-06 15:43:53.292  7244  7244 D Player  :      at android.os.Handler.handleCallback(Handler.java:789)
01-06 15:43:53.292  7244  7244 D Player  :      at android.os.Handler.dispatchMessage(Handler.java:98)
01-06 15:43:53.292  7244  7244 D Player  :      at android.os.Looper.loop(Looper.java:164)
01-06 15:43:53.292  7244  7244 D Player  :      at android.app.ActivityThread.main(ActivityThread.java:6541)
01-06 15:43:53.292  7244  7244 D Player  :      at java.lang.reflect.Method.invoke(Native Method)
01-06 15:43:53.292  7244  7244 D Player  :      at com.android.internal.os.Zygote$MethodAndArgsCaller.run(Zygote.java:240)
01-06 15:43:53.292  7244  7244 D Player  :      at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:767)
01-06 15:43:53.292  7244  7244 D Player  : Conditinns for recovery not met. Tunneling enabled?: false, Surface keyword found?: true
01-06 15:43:53.292  7244  7244 D Player  : onPlaybackShutdown() called
01-06 15:43:53.293  7244  7244 D Player  : destroy() called
01-06 15:43:53.294  7244  7244 D Player  : saveStreamProgressState() called with: progressMillis=25855, currentMetadata=[Peru 8K HDR 60FPS (FUHD)]
01-06 15:43:53.296  7244  7244 D Player  : Setting recovery, queue: 0, pos: 25855
01-06 15:43:53.301  7244  7244 D PlayerHolder: unbind() called
01-06 15:43:53.304  7244  7244 D Player  : destroyPlayer() called
01-06 15:43:53.310  3292  3694 I katniss_interactor_MediaSessionStateTrackerImpl: We do not track the playback state: PlaybackState {state=0, position=0, buffered position=0, speed=0.0, updated=41371540, actions=0, custom actions=[], active item id=-1, error=null}
01-06 15:43:53.314  3375  3375 D NowPlayingListener: updatePlayback() called with: state = [PlaybackState {state=0, position=0, buffered position=0, speed=0.0, updated=41371540, actions=0, custom actions=[], active item id=-1, error=null}] and now playing listener: dqv@dc6a376
01-06 15:43:53.314  3375  3375 D NowPlayingManager: onClientPlaybackStateUpdate() called with: state = [0], stateChangeTimeMs = [41371540], currentPosMs = [0]
01-06 15:43:53.324  1727  1944 D MediaSessionService: Media button session is changed to null
01-06 15:43:53.326  3375  3375 D NowPlayingManager: A notification for Now Playing Card has been canceled
01-06 15:43:53.326  3375  3375 D NowPlayingManager: onClientChanged() called
01-06 15:43:53.329  3375  3375 D NowPlayingManager: A notification for Now Playing Card has been canceled
01-06 15:43:53.330  3766  3766 D BasicMediaStatusFactory: Supported media session actions: 0
01-06 15:43:53.332  3375  3375 D NowPlayingListener: onActiveSessionsChanged() called with: controllers = [[]], lastActiveMediaController = null, lastUpdatedAppPackageName = org.schabi.newpipe.debug.surfacefix
01-06 15:43:53.332  3375  3375 D NowPlayingManager: onClientChanged() called
01-06 15:43:53.340  7244  7244 I ExoPlayerImpl: Release e2f4e79 [ExoPlayerLib/2.18.2] [PH7M_EU_5596, TPM171E, Philips, 26] [goog.exo.core, goog.exo.database, goog.exo.exoplayer, goog.exo.decoder, goog.exo.mediasession, goog.exo.dash, goog.exo.datasource, goog.exo.extractor]
01-06 15:43:53.340  3375  3375 D NowPlayingManager: A notification for Now Playing Card has been canceled
01-06 15:43:53.340  3375  3375 D NowPlayingListener: onActiveSessionsChanged() called with: controllers = [[]], lastActiveMediaController = null, lastUpdatedAppPackageName = null
01-06 15:43:53.341  3375  3375 D NowPlayingManager: onClientChanged() called
01-06 15:43:53.342  3375  3375 D NowPlayingManager: A notification for Now Playing Card has been canceled
01-06 15:43:53.348  1727  5921 I MediaFocusControl:  AudioFocus  abandonAudioFocus() from uid/pid 10073/7244 clientId=android.media.AudioManager@cba20bcorg.schabi.newpipe.player.helper.AudioReactor@ea16845
01-06 15:43:53.350  3766  3766 D BasicMediaStatusFactory: Supported media session actions: 0
01-06 15:43:53.350  2380  2380 D AudioManager: dispatching onAudioFocusChange(1) to android.media.AudioManager@fa7091corg.droidtv.playtv.PlayTvActivity@43271a9
01-06 15:43:53.351  2380  2380 D PlayTvActivity: AudioFocus lost GAIN
01-06 15:43:53.353  7244  7244 D MediaSourceManager@72657347: close() called.
01-06 15:43:53.357  3766  3766 D WargMsAppMgr: A new media session detected: null
01-06 15:43:53.371  3766  3766 D WargMsAppMgr: A new media session detected: null
01-06 15:43:53.373  3766  3766 W chromium: [3766:3766:WARNING:media_trait_handler_impl.cc(679)] No media status
01-06 15:43:53.382  3766  3766 I chromium: [3766:3766:INFO:application_manager_impl.cc(1784)] App stopping: AndroidNativeApp (NewPipe surfacefix), session_id=3a5c1efd-08b2-4429-a4b6-abd2fd509070
01-06 15:43:53.383  3766  3766 I chromium: [3766:3766:INFO:application_manager_impl.cc(1789)] App stopped: AndroidNativeApp (NewPipe surfacefix), session_id=3a5c1efd-08b2-4429-a4b6-abd2fd509070
01-06 15:43:53.384  3766  3766 E chromium: [3766:3766:ERROR:cast_web_service.cc(234)] Failed to erase session: 3a5c1efd-08b2-4429-a4b6-abd2fd509070
01-06 15:43:53.385  3766  3766 I chromium: [3766:3766:INFO:resource_manager_impl.cc(245)] All resources released for app AndroidNativeApp (NewPipe surfacefix), session_id=3a5c1efd-08b2-4429-a4b6-abd2fd509070
01-06 15:43:53.385  3766  3766 E chromium: [3766:3766:ERROR:legacy_app_id_mapper_impl.cc(58)] Unknown app_id AndroidNativeApp
01-06 15:43:53.385  3766  3766 E chromium: [3766:3766:ERROR:cast_metrics_helper.cc(130)] No start time for app: app_id=E8C28D3C
01-06 15:43:53.386  3766  3766 I chromium: [3766:3766:INFO:auto_volume.cc(515)] No current app anymore
01-06 15:43:53.386  1727  1727 W AudioService: couldn't find receiver package for effect intent
01-06 15:43:53.387  3766  3766 W chromium: [3766:3766:WARNING:media_control_handler.cc(59)] Unknown player state:
01-06 15:43:53.388  3766  4507 I chromium: [3766:4507:INFO:metrics_recorder.cc(188)] Cast v2 action(socket_id=local-client.12): CastV2.Connection.Connect.In
01-06 15:43:53.388  3766  3766 I chromium: [3766:3766:INFO:application_manager_impl.cc(2070)] Focusing foreground application: session=7709733e-f4c7-429e-9bbf-1cc940e545cc
01-06 15:43:53.389  3766  3766 I chromium: [3766:3766:INFO:api_reboot_idle_checker.cc(104)] active_activities count=0
01-06 15:43:53.389  3766  3766 I chromium: [3766:3766:INFO:media_classifier_manager.cc(159)] app_id: E8C28D3C, is_spoken_word_app: 0
01-06 15:43:53.389  3766  4507 I chromium: [3766:4507:INFO:metrics_recorder.cc(188)] Cast v2 action(socket_id=local-client.13): CastV2.Connection.Connect.In
01-06 15:43:53.389  3766  3766 I chromium: [3766:3766:INFO:media_classifier_manager.cc(169)] app_id: E8C28D3C, is_movie_app: 0
01-06 15:43:53.389  3766  3766 I chromium: [3766:3766:INFO:cast_session_manager_impl.cc(850)] Sending 0 media sessions. (from:OnCurrentAppChanged@chromecast/internal/receiver/cast_session/cast_session_manager_impl.cc:782)
01-06 15:43:53.389  3766  3766 W chromium: [3766:3766:WARNING:media_control_handler.cc(59)] Unknown player state:
01-06 15:43:53.394  3766  4507 I chromium: [3766:4507:INFO:metrics_recorder.cc(188)] Cast v2 action(socket_id=local-client.14): CastV2.Connection.Connect.In
01-06 15:43:53.396  3766  4506 I chromium: [3766:4506:INFO:mdns_cast_service.cc(759)] Device discovery state is idle
01-06 15:43:53.399  3766  3766 I chromium: [3766:3766:INFO:application_message_handler.cc(853)] Cast V2 IPC closed: app_id=AndroidNativeApp
01-06 15:43:53.407  7244  7244 W ExoPlayerImplInternal: Ignoring messages sent after release.
01-06 15:43:53.411  1727  1727 W TelecomManager: Telecom Service not found.
01-06 15:43:53.412  3766  4507 I chromium: [3766:4507:INFO:v2_transport.cc(451)] Removed Cast V2 endpoint: id=3a5c1efd-08b2-4429-a4b6-abd2fd509070
01-06 15:43:53.412  3766  4507 I chromium: [3766:4507:INFO:v2_transport.cc(1215)] Heartbeat for V2TransportImpl stopping
01-06 15:43:53.414  1273  1453 E SurfaceFlinger: Failed to find layer (SurfaceView - org.schabi.newpipe.debug.surfacefix/org.schabi.newpipe.MainActivity#0) in layer parent (no-parent).
01-06 15:43:53.415  1273  2306 E SurfaceFlinger: Failed to find layer (Background for - SurfaceView - org.schabi.newpipe.debug.surfacefix/org.schabi.newpipe.MainActivity#0) in layer parent (no-parent).
01-06 15:43:53.416  3766  3766 D cr_CastToNative: [NativeApplication.java:387] onDestroyed
01-06 15:43:53.454  3766  4506 I chromium: [3766:4506:INFO:mdns_app_filter.cc(3154)] MdnsAppFilter: responses sent in 40 seconds: 3
01-06 15:43:53.475  3766  4507 I chromium: [3766:4507:INFO:v2_ssl_socket.cc(342)] Stop reading on pending closed socket
01-06 15:43:53.492  7244  7244 D PlayerService: destroy() called
01-06 15:43:53.494  7244  7244 D LeakCanary: Watching instance of org.schabi.newpipe.player.PlayerService (org.schabi.newpipe.player.PlayerService received Service#onDestroy() callback) with key 75954c11-9c0b-4cb2-aa8b-ce9413954361
01-06 15:43:53.533  1266  1266 D gralloc : mali_gralloc_select_format: req_format=0x00000001 req_fmt_mapped=0x1 internal_format=0x1 usage=0x900
01-06 15:43:53.533  1266  1266 D gralloc : set_ion_flags heap_mask:0x1 usage:0x900
01-06 15:43:53.534  1273  2296 I vndksupport: sphal namespace is not configured for this process. Loading /vendor/lib/hw/gralloc.mt5891.so from the current namespace instead.
01-06 15:43:53.535  1266  1266 D gralloc : mali_gralloc_select_format: req_format=0x00000001 req_fmt_mapped=0x1 internal_format=0x1 usage=0x900
01-06 15:43:53.535  1266  1266 D gralloc : set_ion_flags heap_mask:0x1 usage:0x900
01-06 15:43:53.536  1273  2296 I vndksupport: sphal namespace is not configured for this process. Loading /vendor/lib/hw/gralloc.mt5891.so from the current namespace instead.
01-06 15:43:53.537  1266  1266 D gralloc : mali_gralloc_select_format: req_format=0x00000001 req_fmt_mapped=0x1 internal_format=0x1 usage=0x900
01-06 15:43:53.537  1266  1266 D gralloc : set_ion_flags heap_mask:0x1 usage:0x900
01-06 15:43:53.538  1273  2296 I vndksupport: sphal namespace is not configured for this process. Loading /vendor/lib/hw/gralloc.mt5891.so from the current namespace instead.
01-06 15:43:53.540  7244  7274 D mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, egl_color_buffer_format *, EGLBoolean) returns 0x3000
01-06 15:43:53.562  1266  1266 D gralloc : mali_gralloc_select_format: req_format=0x00000001 req_fmt_mapped=0x1 internal_format=0x1 usage=0xb00
01-06 15:43:53.562  1266  1266 D gralloc : set_ion_flags heap_mask:0x1 usage:0xb00
01-06 15:43:53.563  1273  1455 I vndksupport: sphal namespace is not configured for this process. Loading /vendor/lib/hw/gralloc.mt5891.so from the current namespace instead.
01-06 15:43:53.564  7244  7274 I vndksupport: sphal namespace is not configured for this process. Loading /vendor/lib/hw/gralloc.mt5891.so from the current namespace instead.
01-06 15:43:53.568  1266  1266 D gralloc : mali_gralloc_select_format: req_format=0x00000001 req_fmt_mapped=0x1 internal_format=0x1 usage=0xb00
01-06 15:43:53.568  1266  1266 D gralloc : set_ion_flags heap_mask:0x1 usage:0xb00
01-06 15:43:53.569  1273  2306 I vndksupport: sphal namespace is not configured for this process. Loading /vendor/lib/hw/gralloc.mt5891.so from the current namespace instead.
01-06 15:43:53.570  7244  7274 I vndksupport: sphal namespace is not configured for this process. Loading /vendor/lib/hw/gralloc.mt5891.so from the current namespace instead.
01-06 15:43:53.611  1267  1537 I vndksupport: sphal namespace is not configured for this process. Loading /vendor/lib/hw/gralloc.mt5891.so from the current namespace instead.
01-06 15:43:53.637  2975  7494 D org.droidtv.gel.gathering.modules.HomeTestModule: HomeTest scanner onTimedNotification
01-06 15:43:53.653  2975  7494 D org.droidtv.gel.gathering.modules.AppUsageModule: AppUsage onTimedNotification
01-06 15:43:53.664  2975  7494 D org.droidtv.gel.gathering.modules.CpuUsageModule: CpuUsage onTimedNotification
01-06 15:43:53.767  2975  7494 D org.droidtv.gel.gathering.modules.RamUsageModule: MemoryUsage onTimedNotification
01-06 15:43:53.773  2532  6875 I NetworkScheduler.Stats: Task com.google.android.gms/com.google.android.gms.checkin.CheckinService started execution. cause:4 exec_start_elapsed_seconds: 41371 [CONTEXT service_id=218 ]
01-06 15:43:53.780  2975  7494 D org.droidtv.gel.gathering.modules.WifiQualityModule: WifiQuality onTimedNotification
01-06 15:43:53.782  2532  7307 I NetworkScheduler.Stats: Task com.google.android.gms/com.google.android.gms.checkin.CheckinService finished executing. cause:4 result: 3 elapsed_millis: 65 uptime_millis: 64 exec_start_elapsed_seconds: 41371 [CONTEXT service_id=218 ]
01-06 15:43:53.829  2975  7494 D org.droidtv.gel.gathering.modules.SoundModule: SoundModule onTimedNotification
01-06 15:43:53.836  2975  7494 D org.droidtv.gel.gathering.modules.DebugActionModule: DebugActionModule onTimedNotification
01-06 15:43:53.872  2532  6875 I NetworkScheduler.Stats: Task com.google.android.gms/com.google.android.gms.ads.social.GcmSchedulerWakeupService started execution. cause:5 exec_start_elapsed_seconds: 41372 [CONTEXT service_id=218 ]
01-06 15:43:53.926  1727  1736 I zygote  : Background concurrent copying GC freed 73520(5MB) AllocSpace objects, 9(208KB) LOS objects, 42% free, 10MB/18MB, paused 600us total 188.202ms
01-06 15:43:53.941  2532  2532 D BoundBrokerSvc: onBind: Intent { act=com.google.android.gms.auth.account.workaccount.START dat=chimera-action: cmp=com.google.android.gms/.chimera.PersistentApiService }
01-06 15:43:53.941  2532  2532 D BoundBrokerSvc: Loading bound service for intent: Intent { act=com.google.android.gms.auth.account.workaccount.START dat=chimera-action: cmp=com.google.android.gms/.chimera.PersistentApiService }
01-06 15:43:53.988  3549  6399 E Ads     : Failed to connect to https://googleads.g.doubleclick.net/pagead/drt/m. No DSID retrieved.
01-06 15:43:53.993  2532  7307 I NetworkScheduler.Stats: Task com.google.android.gms/com.google.android.gms.ads.social.GcmSchedulerWakeupService finished executing. cause:5 result: 3 elapsed_millis: 150 uptime_millis: 150 exec_start_elapsed_seconds: 41372 [CONTEXT service_id=218 ]
01-06 15:43:54.278  2607  2651 D TvProvider: Inside new Thread run metod
01-06 15:43:54.278  2607  2651 D TvProvider: checkDBSizeOverThreshold isDBSizeMax = false
01-06 15:43:54.282  2607  2651 I TvProvider: checkDBSizeOverThreshold /user_setting/rw/tv.db size = 256
01-06 15:43:54.380  1282  1282 D MTK_KL  : <4>[  751.431004] <PQCTRL><pqdrivers_oledtcon_ctrl_SetGlobalLuminanceGain:501]> pqdrivers_oledtcon_ctrl_SetGlobalLuminanceGain: gain=152
01-06 15:43:55.400  3766  4506 I chromium: [3766:4506:INFO:mdns_app_filter.cc(1768)] MdnsAppFilter: Done announcing.
01-06 15:43:55.462  1273  2306 E BufferQueueProducer: [Toast#0] disconnect: not connected (req=1)
01-06 15:43:55.462  7244  7274 W libEGL  : EGLNativeWindowType 0x80735808 disconnect failed
01-06 15:43:55.463  1727  1727 W WindowManager: removeWindowToken: Attempted to remove non-existing token: android.os.Binder@9fe3d31
01-06 15:43:55.467  7244  7244 D LeakCanary: Watching instance of android.widget.LinearLayout (android.widget.LinearLayout received View#onDetachedFromWindow() callback) with key 568c2349-5eb3-4891-9604-0b389b0b92d2
01-06 15:43:55.644  3766  4507 I chromium: [3766:4507:INFO:metrics_recorder.cc(188)] Cast v2 action(socket_id=4f403fb8-ccc9-aa01-f785-faac31cb235a.15): CastV2.Connection.Connect.In
01-06 15:43:56.051  1260  1260 D audio_hal: [out_standby:486]stream = 0xaad68a80
01-06 15:43:56.051  1260  1260 I audio_hal: [do_output_standby:429]output_type = 0 drain = 1
01-06 15:43:56.060  1282  1282 D MTK_KL  : <4>[  753.111048]
01-06 15:43:56.060  1282  1282 D MTK_KL  : <4>[  753.111048]  AUD_DeInitALSAPlayback_MixSnd(0)##### For Aproc SW Mixsnd
01-06 15:43:56.188  3549  7500 W GAv4-SVC: Network compressed POST connection error: java.net.ConnectException: Failed to connect to ssl.google-analytics.com/:::443
01-06 15:43:57.497  3214  3214 D NettvLoggerLocalService: usagelogger LogKeyPressEvent event.getKeyCode()=19 mBinder=org.droidtv.usagelogger.ILoggerImpl$Proxy@9d2132e
01-06 15:43:57.498  2681  2724 D org.droidtv.candeebug.Gateway: Returning successfully for event: {"event-type":"unknown.15","boot-count":3,"standby-count":4,"kernel-time":751302,"data":{"original-event-type":15,"device_name":0,"key_group":11}}
01-06 15:43:57.500  1282  1282 D MTK_KL  : <4>[  754.551569] [0x3] KEY 0x3f002 map to 103 2 0 1
01-06 15:43:57.817  1906  1906 D EmojiAltPhysicalKeyDetector: onKeyUp() : KeyEvent { action=ACTION_UP, keyCode=KEYCODE_DPAD_UP, scanCode=103, metaState=0, flags=0x8, repeatCount=0, eventTime=751620, downTime=751300, deviceId=4, source=0x301 }
01-06 15:43:57.820  1282  1282 D MTK_KL  : <4>[  754.871013] [0x3] KEY 0x3f002 map to 103 2 0 0
01-06 15:43:57.935  7244  7244 D ViewUtils: animate():    false →  [View:playbackControlsShadow] [ALPHA 300:0] execOnEnd=null
01-06 15:43:57.937  7244  7244 D ViewUtils: animate():    false →  [View:playerTopShadow] [ALPHA 300:0] execOnEnd=null
01-06 15:43:57.939  7244  7244 D ViewUtils: animate():    false →  [View:playerBottomShadow] [ALPHA 300:0] execOnEnd=null
01-06 15:43:57.940  7244  7244 D ViewUtils: animate():    false →  [RelativeLayout:playbackControlRoot] [ALPHA 300:0] execOnEnd=org.schabi.newpipe.player.ui.VideoPlayerUi$$ExternalSyntheticLambda38@aaaa69f
01-06 15:43:58.067  3214  3214 D NettvLoggerLocalService: usagelogger LogKeyPressEvent event.getKeyCode()=19 mBinder=org.droidtv.usagelogger.ILoggerImpl$Proxy@9d2132e
01-06 15:43:58.069  2681  2724 D org.droidtv.candeebug.Gateway: Returning successfully for event: {"event-type":"unknown.15","boot-count":3,"standby-count":4,"kernel-time":751872,"data":{"original-event-type":15,"device_name":0,"key_group":11}}
01-06 15:43:58.070  1282  1282 D MTK_KL  : <4>[  755.121683] [0x3] KEY 0x3f002 map to 103 2 0 1
01-06 15:43:58.194  2733  5128 D ImageSticking_JNI: threadStart:277: KEY_PRESSED is TRUE reseting count
01-06 15:43:58.194  2733  5128 D ImageSticking_JNI:
01-06 15:43:58.387  1906  1906 D EmojiAltPhysicalKeyDetector: onKeyUp() : KeyEvent { action=ACTION_UP, keyCode=KEYCODE_DPAD_UP, scanCode=103, metaState=0, flags=0x8, repeatCount=0, eventTime=752190, downTime=751870, deviceId=4, source=0x301 }
01-06 15:43:58.390  1282  1282 D MTK_KL  : <4>[  755.441010] [0x3] KEY 0x3f002 map to 103 2 0 0
01-06 15:43:58.465  1282  1282 D MTK_KL  : <4>[  755.520711] [0x3] KEY 0x3f002 map to 103 2 0 1
01-06 15:43:58.466  3214  3214 D NettvLoggerLocalService: usagelogger LogKeyPressEvent event.getKeyCode()=19 mBinder=org.droidtv.usagelogger.ILoggerImpl$Proxy@9d2132e
01-06 15:43:58.467  2681  2724 D org.droidtv.candeebug.Gateway: Returning successfully for event: {"event-type":"unknown.15","boot-count":3,"standby-count":4,"kernel-time":752271,"data":{"original-event-type":15,"device_name":0,"key_group":11}}
01-06 15:43:58.495  7244  7261 D LeakCanary: LeakCanary is currently disabled: LeakCanary.Config.dumpHeap is set to false.
01-06 15:43:58.583  2733  5129 I ImageStickingService: List = org.schabi.newpipe.MainActivity
01-06 15:43:58.585  2733  5129 I ImageStickingService: videoType = 416 FHD video
01-06 15:43:58.587  2733  5129 I ImageStickingService:
01-06 15:43:58.587  2733  5129 I ImageStickingService:  VIDEO_SCREEN_SAVER_STATUS from FRC = 0

@sonarcloud
Copy link

sonarcloud bot commented Jan 16, 2023

Kudos, SonarCloud Quality Gate passed!    Quality Gate passed

Bug A 0 Bugs
Vulnerability A 0 Vulnerabilities
Security Hotspot A 0 Security Hotspots
Code Smell A 1 Code Smell

0.0% 0.0% Coverage
0.0% 0.0% Duplication

@peat80
Copy link

peat80 commented Jan 16, 2023

Latest commit does help here. First video plays windowed and second video shows an error toast but plays in fullscreen instead of crashing the app here on my bravia a90j.
Tried a few times, no crash, only an error toast. 😎👌

@pbasista
Copy link

shows an error toast but plays in fullscreen

I have also tried it now on an Android TV manufactured by Philips. The behavior in my case was that there was an error toast with a note to check the logs for exception. The application did not crash. But the video playback stopped and the player window was replaced with a non-interactive view of its thumbnail with an overlay of video title, duration and last playback position.

Exception detail
E ExoPlayerImplInternal: Playback error
E ExoPlayerImplInternal:   com.google.android.exoplayer2.ExoPlaybackException: Unexpected runtime error
E ExoPlayerImplInternal:       at com.google.android.exoplayer2.ExoPlayerImplInternal.handleMessage(ExoPlayerImplInternal.java:621)
E ExoPlayerImplInternal:       at android.os.Handler.dispatchMessage(Handler.java:101)
E ExoPlayerImplInternal:       at android.os.Looper.loop(Looper.java:164)
E ExoPlayerImplInternal:       at android.os.HandlerThread.run(HandlerThread.java:65)
E ExoPlayerImplInternal:   Caused by: java.lang.IllegalArgumentException
E ExoPlayerImplInternal:       at android.media.MediaCodec.native_setSurface(Native Method)
E ExoPlayerImplInternal:       at android.media.MediaCodec.setOutputSurface(MediaCodec.java:1987)
E ExoPlayerImplInternal:       at com.google.android.exoplayer2.mediacodec.SynchronousMediaCodecAdapter.setOutputSurface(SynchronousMediaCodecAdapter.java:189)
E ExoPlayerImplInternal:       at com.google.android.exoplayer2.video.MediaCodecVideoRenderer.setOutputSurfaceV23(MediaCodecVideoRenderer.java:1490)
E ExoPlayerImplInternal:       at com.google.android.exoplayer2.video.MediaCodecVideoRenderer.setOutput(MediaCodecVideoRenderer.java:693)
E ExoPlayerImplInternal:       at com.google.android.exoplayer2.video.MediaCodecVideoRenderer.handleMessage(MediaCodecVideoRenderer.java:631)
E ExoPlayerImplInternal:       at com.google.android.exoplayer2.ExoPlayerImplInternal.deliverMessage(ExoPlayerImplInternal.java:1550)
E ExoPlayerImplInternal:       at com.google.android.exoplayer2.ExoPlayerImplInternal.sendMessageToTarget(ExoPlayerImplInternal.java:1514)
E ExoPlayerImplInternal:       at com.google.android.exoplayer2.ExoPlayerImplInternal.sendMessageInternal(ExoPlayerImplInternal.java:1489)
E ExoPlayerImplInternal:       at com.google.android.exoplayer2.ExoPlayerImplInternal.handleMessage(ExoPlayerImplInternal.java:526)
E ExoPlayerImplInternal:       ... 3 more

@peat80
Copy link

peat80 commented Jan 16, 2023

This is the behaviour i get when try to manually press the fullscreen button on the running video. If i navigate to the right and choose a second video it plays fullscreen.

@AudricV
Copy link
Member

AudricV commented Dec 29, 2023

Closing, as users have the control on this setting on every device and on every build variant since #8875 has been merged. This PR also doesn't seem do anything useful in the end unfortunately.

@AudricV AudricV closed this Dec 29, 2023
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
device/software specific Issues that only happen on some devices or with some specific hardware/software help wanted Help is wanted in fixing this issue player Issues related to any player (main, popup and background)
Projects
None yet
Development

Successfully merging this pull request may close these issues.

4 participants