search

icefields / Power-Ampache-2

second version of my popular ampache Android app
GNU General Public License v3.0
47 stars 2 forks source link

[crash] Investigate TooManyRequestsException #82

Open icefields opened 3 months ago

icefields commented 3 months ago

STEPS:

CANNOT REPRODUCE at will but it seems to be happening to more than one user.

ACRA caught a TooManyRequestsException for luci.sixsixsix.powerampache2.debug
                                                                                                    android.net.ConnectivityManager$TooManyRequestsException
                                                                                                        at android.net.ConnectivityManager.convertServiceException(ConnectivityManager.java:3378)
                                                                                                        at android.net.ConnectivityManager.sendRequestForNetwork(ConnectivityManager.java:3564)
                                                                                                        at android.net.ConnectivityManager.registerDefaultNetworkCallback(ConnectivityManager.java:3965)
                                                                                                        at android.net.ConnectivityManager.registerDefaultNetworkCallback(ConnectivityManager.java:3942)
                                                                                                        at androidx.work.impl.utils.NetworkApi24.registerDefaultNetworkCallbackCompat(NetworkApi24.kt:28)
                                                                                                        at androidx.work.impl.constraints.trackers.NetworkStateTracker24.startTracking(NetworkStateTracker.kt:138)
                                                                                                        at androidx.work.impl.constraints.trackers.ConstraintTracker.addListener(ConstraintTracker.kt:56)
                                                                                                        at androidx.work.impl.constraints.controllers.ConstraintController$track$1.invokeSuspend(ContraintControllers.kt:54)
                                                                                                        at androidx.work.impl.constraints.controllers.ConstraintController$track$1.invoke(Unknown Source:8)
                                                                                                        at androidx.work.impl.constraints.controllers.ConstraintController$track$1.invoke(Unknown Source:4)
                                                                                                        at kotlinx.coroutines.flow.ChannelFlowBuilder.collectTo$suspendImpl(Builders.kt:320)
                                                                                                        at kotlinx.coroutines.flow.ChannelFlowBuilder.collectTo(Unknown Source:0)
                                                                                                        at kotlinx.coroutines.flow.CallbackFlowBuilder.collectTo(Builders.kt:334)
                                                                                                        at kotlinx.coroutines.flow.internal.ChannelFlow$collectToFun$1.invokeSuspend(ChannelFlow.kt:60)
                                                                                                        at kotlin.coroutines.jvm.internal.BaseContinuationImpl.resumeWith(ContinuationImpl.kt:33)
                                                                                                        at kotlinx.coroutines.DispatchedTask.run(DispatchedTask.kt:108)
                                                                                                        at androidx.work.impl.utils.SerialExecutorImpl$Task.run(SerialExecutorImpl.java:96)
                                                                                                        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167)
                                                                                                        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641)
                                                                                                        at java.lang.Thread.run(Thread.java:919)
                                                                                                        Suppressed: kotlinx.coroutines.internal.DiagnosticCoroutineContextException: [StandaloneCoroutine{Cancelling}@7d6de2e, androidx.work.impl.utils.SerialExecutorImpl@3c2cdcf]
2024-04-08 17:31:53.945 17751-17808 ACRA                    pid-17751                            E  Failed to send crash reports for /data/user/0/luci.sixsixsix.powerampache2.debug/app_ACRA-approved/2024-04-08T21:31:53.718+00:00.stacktrace
icefields commented 2 months ago

Happened a second time again, after 2+ weeks from the initial but detection.

android.net.ConnectivityManager$TooManyRequestsException
    at android.net.ConnectivityManager.convertServiceException(ConnectivityManager.java:4235)
    at android.net.ConnectivityManager.sendRequestForNetwork(ConnectivityManager.java:4436)
    at android.net.ConnectivityManager.registerDefaultNetworkCallbackForUid(ConnectivityManager.java:4965)
    at android.net.ConnectivityManager.registerDefaultNetworkCallback(ConnectivityManager.java:4932)
    at android.net.ConnectivityManager.registerDefaultNetworkCallback(ConnectivityManager.java:4906)
    at androidx.work.impl.utils.NetworkApi24.registerDefaultNetworkCallbackCompat(NetworkApi24.kt:28)
    at androidx.work.impl.constraints.trackers.NetworkStateTracker24.startTracking(NetworkStateTracker.kt:138)
    at androidx.work.impl.constraints.trackers.ConstraintTracker.addListener(ConstraintTracker.kt:56)
    at androidx.work.impl.constraints.controllers.ConstraintController$track$1.invokeSuspend(ContraintControllers.kt:54)
    at androidx.work.impl.constraints.controllers.ConstraintController$track$1.invoke(Unknown Source:8)
    at androidx.work.impl.constraints.controllers.ConstraintController$track$1.invoke(Unknown Source:4)
    at kotlinx.coroutines.flow.ChannelFlowBuilder.collectTo$suspendImpl(Builders.kt:320)
    at kotlinx.coroutines.flow.ChannelFlowBuilder.collectTo(Unknown Source:0)
    at kotlinx.coroutines.flow.CallbackFlowBuilder.collectTo(Builders.kt:334)
    at kotlinx.coroutines.flow.internal.ChannelFlow$collectToFun$1.invokeSuspend(ChannelFlow.kt:60)
    at kotlin.coroutines.jvm.internal.BaseContinuationImpl.resumeWith(ContinuationImpl.kt:33)
    at kotlinx.coroutines.DispatchedTask.run(DispatchedTask.kt:108)
    at androidx.work.impl.utils.SerialExecutorImpl$Task.run(SerialExecutorImpl.java:96)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:644)
    at java.lang.Thread.run(Thread.java:1012)
    Suppressed: kotlinx.coroutines.internal.DiagnosticCoroutineContextException: [StandaloneCoroutine{Cancelling}@8077117, androidx.work.impl.utils.SerialExecutorImpl@e6a5904]
`04-19 00:41:13.112 I/x.powerampache2(13078): Background concurrent mark compact GC freed 94MB AllocSpace bytes, 5(104KB) LOS objects, 75% free, 27MB/110MB, paused 738us,5.508ms total 79.682ms\n04-19 00:41:13.198 D/TrafficStats(13078): tagSocket(136) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:14.388 D/TrafficStats(13078): tagSocket(94) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:14.636 D/TrafficStats(13078): tagSocket(205) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:14.637 D/TrafficStats(13078): tagSocket(178) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:14.637 D/TrafficStats(13078): tagSocket(94) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:14.637 D/TrafficStats(13078): tagSocket(210) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:14.637 D/TrafficStats(13078): tagSocket(176) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:14.643 D/TrafficStats(13078): tagSocket(262) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:14.695 D/TrafficStats(13078): tagSocket(94) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:14.695 D/TrafficStats(13078): tagSocket(150) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:14.730 D/TrafficStats(13078): tagSocket(210) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:14.730 D/TrafficStats(13078): tagSocket(254) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:14.782 D/TrafficStats(13078): tagSocket(176) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:14.782 D/TrafficStats(13078): tagSocket(150) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:14.844 D/TrafficStats(13078): tagSocket(94) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:14.845 D/TrafficStats(13078): tagSocket(254) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:14.893 D/TrafficStats(13078): tagSocket(210) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:14.893 D/TrafficStats(13078): tagSocket(331) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:14.960 D/TrafficStats(13078): tagSocket(94) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:14.960 D/TrafficStats(13078): tagSocket(150) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:15.048 D/TrafficStats(13078): tagSocket(226) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:15.110 D/TrafficStats(13078): tagSocket(314) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:15.111 D/TrafficStats(13078): tagSocket(353) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:15.201 D/TrafficStats(13078): tagSocket(294) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:15.210 D/TrafficStats(13078): tagSocket(150) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:15.340 D/TrafficStats(13078): tagSocket(329) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:15.351 D/TrafficStats(13078): tagSocket(349) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:15.492 D/TrafficStats(13078): tagSocket(366) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:15.525 D/TrafficStats(13078): tagSocket(226) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:15.549 D/TrafficStats(13078): tagSocket(363) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:15.563 D/TrafficStats(13078): tagSocket(357) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:15.644 D/TrafficStats(13078): tagSocket(94) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:15.644 D/TrafficStats(13078): tagSocket(346) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:15.675 D/TrafficStats(13078): tagSocket(226) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:15.675 D/TrafficStats(13078): tagSocket(363) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:15.709 D/TrafficStats(13078): tagSocket(314) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:15.709 D/TrafficStats(13078): tagSocket(346) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:15.742 D/TrafficStats(13078): tagSocket(358) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:15.742 D/TrafficStats(13078): tagSocket(94) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:15.775 D/TrafficStats(13078): tagSocket(226) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:15.775 D/TrafficStats(13078): tagSocket(369) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:15.825 D/TrafficStats(13078): tagSocket(94) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:15.827 D/TrafficStats(13078): tagSocket(314) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:15.859 D/TrafficStats(13078): tagSocket(359) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:15.859 D/TrafficStats(13078): tagSocket(358) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:15.909 D/TrafficStats(13078): tagSocket(94) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:15.909 D/TrafficStats(13078): tagSocket(369) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:15.959 D/TrafficStats(13078): tagSocket(314) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:15.960 D/TrafficStats(13078): tagSocket(359) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:16.010 D/TrafficStats(13078): tagSocket(94) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:16.010 D/TrafficStats(13078): tagSocket(358) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:16.059 D/TrafficStats(13078): tagSocket(348) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:16.061 D/TrafficStats(13078): tagSocket(365) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:16.108 D/TrafficStats(13078): tagSocket(359) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:16.176 D/TrafficStats(13078): tagSocket(94) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:16.176 D/TrafficStats(13078): tagSocket(358) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:16.278 D/TrafficStats(13078): tagSocket(365) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:16.278 D/TrafficStats(13078): tagSocket(400) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:16.396 D/TrafficStats(13078): tagSocket(397) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:16.419 D/TrafficStats(13078): tagSocket(407) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:16.421 D/TrafficStats(13078): tagSocket(418) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:23.255 W/WindowOnBackDispatcher(13078): OnBackInvokedCallback is not enabled for the application.\n04-19 00:41:23.255 W/WindowOnBackDispatcher(13078): Set 'android:enableOnBackInvokedCallback="true"' in the application manifest.\n04-19 00:41:23.385 W/WindowOnBackDispatcher(13078): sendCancelIfRunning: isInProgress=falsecallback=android.view.ViewRootImpl$$ExternalSyntheticLambda11@9efb8af\n04-19 00:41:23.387 D/HWUI    (13078): endAllActiveAnimators on 0xb400007289711420 (UnprojectedRipple) with handle 0xb40000724969a200\n04-19 00:41:23.426 D/TrafficStats(13078): tagSocket(136) with statsTag=0xffffffff, statsUid=-1\n04-19 00:41:27.482 W/WindowOnBackDispatcher(13078): OnBackInvokedCallback is not enabled for the application.\n04-19 00:41:27.482 W/WindowOnBackDispatcher(13078): Set 'android:enableOnBackInvokedCallback="true"' in the application manifest.\n04-19 00:41:31.710 W/WindowOnBackDispatcher(13078): sendCancelIfRunning: isInProgress=falsecallback=android.view.ViewRootImpl$$ExternalSyntheticLambda11@65ad5ad\n04-19 00:41:31.799 I/x.powerampache2(13078): Background concurrent mark compact GC freed 73MB AllocSpace bytes, 140(2816KB) LOS objects, 73% free, 34MB/130MB, paused 442us,7.312ms total 104.160ms\n04-19 00:41:38.895 D/CompatibilityChangeReporter(13078): Compat change id reported: 194532703; UID 10284; state: ENABLED\n04-19 00:41:38.895 D/CompatibilityChangeReporter(13078): Compat change id reported: 253665015; UID 10284; state: ENABLED\n04-19 00:41:38.895 D/CompatibilityChangeReporter(13078): Compat change id reported: 311402873; UID 10284; state: DISABLED\n04-19 00:41:38.977 D/CompatibilityChangeReporter(13078): Compat change id reported: 263076149; UID 10284; state: ENABLED\n04-19 00:41:39.023 E/ACRA    (13078): ACRA caught a TooManyRequestsException for luci.sixsixsix.powerampache2\n04-19 00:41:39.023 E/ACRA    (13078): android.net.ConnectivityManager$TooManyRequestsException\n04-19 00:41:39.023 E/ACRA    (13078): \tat android.net.ConnectivityManager.convertServiceException(ConnectivityManager.java:4235)\n04-19 00:41:39.023 E/ACRA    (13078): \tat android.net.ConnectivityManager.sendRequestForNetwork(ConnectivityManager.java:4436)\n04-19 00:41:39.023 E/ACRA    (13078): \tat android.net.ConnectivityManager.registerDefaultNetworkCallbackForUid(ConnectivityManager.java:4965)\n04-19 00:41:39.023 E/ACRA    (13078): \tat android.net.ConnectivityManager.registerDefaultNetworkCallback(ConnectivityManager.java:4932)\n04-19 00:41:39.023 E/ACRA    (13078): \tat android.net.ConnectivityManager.registerDefaultNetworkCallback(ConnectivityManager.java:4906)\n04-19 00:41:39.023 E/ACRA    (13078): \tat androidx.work.impl.utils.NetworkApi24.registerDefaultNetworkCallbackCompat(NetworkApi24.kt:28)\n04-19 00:41:39.023 E/ACRA    (13078): \tat androidx.work.impl.constraints.trackers.NetworkStateTracker24.startTracking(NetworkStateTracker.kt:138)\n04-19 00:41:39.023 E/ACRA    (13078): \tat androidx.work.impl.constraints.trackers.ConstraintTracker.addListener(ConstraintTracker.kt:56)\n04-19 00:41:39.023 E/ACRA    (13078): \tat androidx.work.impl.constraints.controllers.ConstraintController$track$1.invokeSuspend(ContraintControllers.kt:54)\n04-19 00:41:39.023 E/ACRA    (13078): \tat androidx.work.impl.constraints.controllers.ConstraintController$track$1.invoke(Unknown Source:8)\n04-19 00:41:39.023 E/ACRA    (13078): \tat androidx.work.impl.constraints.controllers.ConstraintController$track$1.invoke(Unknown Source:4)\n04-19 00:41:39.023 E/ACRA    (13078): \tat kotlinx.coroutines.flow.ChannelFlowBuilder.collectTo$suspendImpl(Builders.kt:320)\n04-19 00:41:39.023 E/ACRA    (13078): \tat kotlinx.coroutines.flow.ChannelFlowBuilder.collectTo(Unknown Source:0)\n04-19 00:41:39.023 E/ACRA    (13078): \tat kotlinx.coroutines.flow.CallbackFlowBuilder.collectTo(Builders.kt:334)\n04-19 00:41:39.023 E/ACRA    (13078): \tat kotlinx.coroutines.flow.internal.ChannelFlow$collectToFun$1.invokeSuspend(ChannelFlow.kt:60)\n04-19 00:41:39.023 E/ACRA    (13078): \tat kotlin.coroutines.jvm.internal.BaseContinuationImpl.resumeWith(ContinuationImpl.kt:33)\n04-19 00:41:39.023 E/ACRA    (13078): \tat kotlinx.coroutines.DispatchedTask.run(DispatchedTask.kt:108)\n04-19 00:41:39.023 E/ACRA    (13078): \tat androidx.work.impl.utils.SerialExecutorImpl$Task.run(SerialExecutorImpl.java:96)\n04-19 00:41:39.023 E/ACRA    (13078): \tat java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)\n04-19 00:41:39.023 E/ACRA    (13078): \tat java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:644)\n04-19 00:41:39.023 E/ACRA    (13078): \tat java.lang.Thread.run(Thread.java:1012)\n04-19 00:41:39.023 E/ACRA    (13078): \tSuppressed: kotlinx.coroutines.internal.DiagnosticCoroutineContextException: [StandaloneCoroutine{Cancelling}@8077117, androidx.work.impl.utils.SerialExecutorImpl@e6a5904]\n`
icefields commented 2 months ago 
04-28 08:53:49.276 D/AudioTrack(12728): setVolume: RelativeVolumeFeature, mRelativePercentage:1.000000, left:1.000000, right:1.000000
04-28 08:53:54.797 D/BufferPoolAccessor2.0(12728): bufferpool2 0xb400007c25587e08 : 5(163840 size) total buffers - 5(163840 size) used buffers - 1/7 (recycle/alloc) - 16/7133 (fetch/transfer)
04-28 08:54:00.353 D/BufferPoolAccessor2.0(12728): bufferpool2 0xb400007c25587e08 : 5(163840 size) total buffers - 5(163840 size) used buffers - 1/7 (recycle/alloc) - 16/7253 (fetch/transfer)
04-28 08:54:05.916 D/BufferPoolAccessor2.0(12728): bufferpool2 0xb400007c25587e08 : 5(163840 size) total buffers - 5(163840 size) used buffers - 1/7 (recycle/alloc) - 16/7373 (fetch/transfer)
04-28 08:54:11.516 D/BufferPoolAccessor2.0(12728): bufferpool2 0xb400007c25587e08 : 5(163840 size) total buffers - 5(163840 size) used buffers - 1/7 (recycle/alloc) - 16/7493 (fetch/transfer)
04-28 08:54:11.907 D/AudioManager(12728): dispatching onAudioFocusChange(-1) to android.media.AudioManager@324d183androidx.media3.exoplayer.AudioFocusManager$AudioFocusListener@cd54f00
04-28 08:54:12.674 I/Choreographer(12728): Skipped 42 frames!  The application may be doing too much work on its main thread.
04-28 08:54:12.775 I/x.powerampache(12728): Background young concurrent copying GC freed 323894(10MB) AllocSpace objects, 76(1520KB) LOS objects, 24% free, 34MB/45MB, paused 13.783ms total 210.268ms
04-28 08:54:13.901 I/x.powerampache(12728): NativeAlloc concurrent copying GC freed 340042(10MB) AllocSpace objects, 11(224KB) LOS objects, 49% free, 23MB/46MB, paused 101us total 177.461ms
04-28 08:54:14.014 I/Choreographer(12728): Skipped 74 frames!  The application may be doing too much work on its main thread.
04-28 08:55:22.192 I/x.powerampache(12728): Background young concurrent copying GC freed 717365(22MB) AllocSpace objects, 0(0B) LOS objects, 47% free, 24MB/46MB, paused 105us total 102.936ms
04-28 08:55:49.045 I/MediaCodec(12728): (0xb400007c9563a2e0) flush
04-28 08:55:49.069 D/CCodecBuffers(12728): [c2.android.flac.decoder#133:1D-Output.Impl[N]] Client returned a buffer it does not own according to our record: 0
04-28 08:55:49.070 D/CCodecBuffers(12728): [c2.android.flac.decoder#133:1D-Output.Impl[N]] Client returned a buffer it does not own according to our record: 1
04-28 08:55:49.070 D/CCodecBuffers(12728): [c2.android.flac.decoder#133:1D-Output.Impl[N]] Client returned a buffer it does not own according to our record: 2
04-28 08:55:49.070 D/CCodecBuffers(12728): [c2.android.flac.decoder#133:1D-Output.Impl[N]] Client returned a buffer it does not own according to our record: 3
04-28 08:55:49.081 I/CCodecConfig(12728): query failed after returning 8 values (BAD_INDEX)
04-28 08:55:49.081 W/Codec2Client(12728): query -- param skipped: index = 1342179345.
04-28 08:55:49.081 W/Codec2Client(12728): query -- param skipped: index = 2415921170.
04-28 08:55:49.089 I/MediaCodec(12728): (0xb400007c9563a2e0) flush
04-28 08:55:49.090 I/CCodecConfig(12728): query failed after returning 8 values (BAD_INDEX)
04-28 08:55:49.090 W/Codec2Client(12728): query -- param skipped: index = 1342179345.
04-28 08:55:49.090 W/Codec2Client(12728): query -- param skipped: index = 2415921170.
04-28 08:55:49.100 D/AudioTrack(12728): ~AudioTrack(): RelativeVolumeFeature mSessionId:7057, clientId:407
04-28 08:55:49.368 D/BufferPoolAccessor2.0(12728): bufferpool2 0xb400007c25587e08 : 5(163840 size) total buffers - 5(163840 size) used buffers - 1/7 (recycle/alloc) - 16/7513 (fetch/transfer)
04-28 08:55:49.391 D/CCodecBuffers(12728): [c2.android.flac.decoder#133:Output[N]] popFromStashAndRegister: output format changed to AMessage(what = 0x00000000) = {
04-28 08:55:49.391 D/CCodecBuffers(12728):   int32_t channel-count = 2
04-28 08:55:49.391 D/CCodecBuffers(12728):   string mime = "audio/raw"
04-28 08:55:49.391 D/CCodecBuffers(12728):   int32_t pcm-encoding = 2
04-28 08:55:49.391 D/CCodecBuffers(12728):   int32_t sample-rate = 44100
04-28 08:55:49.391 D/CCodecBuffers(12728): }
04-28 08:55:49.435 D/AudioTrack(12728): createTrack_l(): RelativeVolumeFeature, mStreamType -1, streamType 3, attributes: usage=1 content=2 flags=0xa00 tags=[], percentage=1.000000 clientId=409
04-28 08:55:49.436 D/AudioTrack(12728): createTrack_l: RelativeVolumeFeature, mRelativePercentage:1.000000
04-28 08:55:49.440 D/AudioTrack(12728): setVolume: RelativeVolumeFeature, mRelativePercentage:1.000000, left:1.000000, right:1.000000
04-28 08:55:49.465 I/MediaCodec(12728): (0xb400007c9563a2e0) flush
04-28 08:55:49.466 D/CCodecBuffers(12728): [c2.android.flac.decoder#133:1D-Output.Impl[N]] Client returned a buffer it does not own according to our record: 0
04-28 08:55:49.466 D/CCodecBuffers(12728): [c2.android.flac.decoder#133:1D-Output.Impl[N]] Client returned a buffer it does not own according to our record: 1
04-28 08:55:49.466 I/CCodecConfig(12728): query failed after returning 8 values (BAD_INDEX)
04-28 08:55:49.467 W/Codec2Client(12728): query -- param skipped: index = 1342179345.
04-28 08:55:49.467 W/Codec2Client(12728): query -- param skipped: index = 2415921170.
04-28 08:55:49.470 I/MediaCodec(12728): (0xb400007c9563a2e0) flush
04-28 08:55:49.471 I/CCodecConfig(12728): query failed after returning 8 values (BAD_INDEX)
04-28 08:55:49.472 W/Codec2Client(12728): query -- param skipped: index = 1342179345.
04-28 08:55:49.472 W/Codec2Client(12728): query -- param skipped: index = 2415921170.
04-28 08:55:49.475 I/MediaCodec(12728): (0xb400007c9563a2e0) flush
04-28 08:55:49.477 I/CCodecConfig(12728): query failed after returning 8 values (BAD_INDEX)
04-28 08:55:49.477 W/Codec2Client(12728): query -- param skipped: index = 1342179345.
04-28 08:55:49.477 W/Codec2Client(12728): query -- param skipped: index = 2415921170.
04-28 08:55:49.482 D/AudioTrack(12728): ~AudioTrack(): RelativeVolumeFeature mSessionId:7057, clientId:409
04-28 08:55:49.554 D/CCodecBuffers(12728): [c2.android.flac.decoder#133:Output[N]] popFromStashAndRegister: output format changed to AMessage(what = 0x00000000) = {
04-28 08:55:49.554 D/CCodecBuffers(12728):   int32_t channel-count = 2
04-28 08:55:49.554 D/CCodecBuffers(12728):   string mime = "audio/raw"
04-28 08:55:49.554 D/CCodecBuffers(12728):   int32_t pcm-encoding = 2
04-28 08:55:49.554 D/CCodecBuffers(12728):   int32_t sample-rate = 44100
04-28 08:55:49.554 D/CCodecBuffers(12728): }
04-28 08:55:49.575 D/AudioTrack(12728): createTrack_l(): RelativeVolumeFeature, mStreamType -1, streamType 3, attributes: usage=1 content=2 flags=0xa00 tags=[], percentage=1.000000 clientId=410
04-28 08:55:49.576 D/AudioTrack(12728): createTrack_l: RelativeVolumeFeature, mRelativePercentage:1.000000
04-28 08:55:49.578 D/AudioTrack(12728): setVolume: RelativeVolumeFeature, mRelativePercentage:1.000000, left:1.000000, right:1.000000
04-28 08:55:50.521 I/Choreographer(12728): Skipped 41 frames!  The application may be doing too much work on its main thread.
04-28 08:55:50.564 I/OpenGLRenderer(12728): Davey! duration=728ms; Flags=0, IntendedVsync=69026736049628, Vsync=69027419382934, OldestInputEvent=9223372036854775807, NewestInputEvent=0, HandleInputStart=69027423153109, AnimationStart=69027423161234, PerformTraversalsStart=69027453738112, DrawStart=69027453856393, SyncQueued=69027455711966, SyncStart=69027456256029, IssueDrawCommandsStart=69027457070404, SwapBuffers=69027463911290, FrameCompleted=69027465171551, DequeueBufferDuration=591302, QueueBufferDuration=445677, GpuCompleted=68898018215165, 
04-28 08:55:50.714 I/x.powerampache(12728): NativeAlloc concurrent copying GC freed 226458(10MB) AllocSpace objects, 227(4988KB) LOS objects, 47% free, 26MB/50MB, paused 448us total 606.590ms
04-28 08:55:50.778 D/AudioTrack(12728): getTimestamp_l(871): device stall time corrected using current time 69027679910999
04-28 08:55:51.852 I/x.powerampache(12728): NativeAlloc concurrent copying GC freed 148643(6475KB) AllocSpace objects, 126(2520KB) LOS objects, 50% free, 23MB/46MB, paused 153us total 223.988ms
04-28 08:55:51.943 I/Choreographer(12728): Skipped 51 frames!  The application may be doing too much work on its main thread.
04-28 08:55:51.977 I/OpenGLRenderer(12728): Davey! duration=888ms; Flags=0, IntendedVsync=69027989122573, Vsync=69028839122539, OldestInputEvent=9223372036854775807, NewestInputEvent=0, HandleInputStart=69028844870959, AnimationStart=69028844876740, PerformTraversalsStart=69028866124294, DrawStart=69028866201951, SyncQueued=69028868422263, SyncStart=69028869174711, IssueDrawCommandsStart=69028869993514, SwapBuffers=69028877236431, FrameCompleted=69028878404504, DequeueBufferDuration=1051251, QueueBufferDuration=409688, GpuCompleted=68898097963507, 
04-28 08:55:54.598 D/BufferPoolAccessor2.0(12728): bufferpool2 0xb400007c25587e08 : 5(163840 size) total buffers - 5(163840 size) used buffers - 1/7 (recycle/alloc) - 24/7625 (fetch/transfer)
04-28 08:55:59.673 D/BufferPoolAccessor2.0(12728): bufferpool2 0xb400007c25587e08 : 5(163840 size) total buffers - 5(163840 size) used buffers - 1/7 (recycle/alloc) - 24/7735 (fetch/transfer)
04-28 08:56:02.915 I/x.powerampache(12728): Background young concurrent copying GC freed 739569(22MB) AllocSpace objects, 0(0B) LOS objects, 46% free, 24MB/46MB, paused 115us total 109.616ms
04-28 08:56:05.276 D/BufferPoolAccessor2.0(12728): bufferpool2 0xb400007c25587e08 : 5(163840 size) total buffers - 5(163840 size) used buffers - 1/7 (recycle/alloc) - 24/7855 (fetch/transfer)
04-28 08:56:10.836 D/BufferPoolAccessor2.0(12728): bufferpool2 0xb400007c25587e08 : 5(163840 size) total buffers - 5(163840 size) used buffers - 1/7 (recycle/alloc) - 24/7975 (fetch/transfer)
04-28 08:56:11.432 W/AudioTrack(12728): restoreTrack_l(871): dead IAudioTrack, PCM, creating a new one from obtainBuffer()
04-28 08:56:11.432 I/BpBinder(12728): onLastStrongRef automatically unlinking death recipients: <uncached descriptor>
04-28 08:56:11.437 I/BpBinder(12728): onLastStrongRef automatically unlinking death recipients: <uncached descriptor>
04-28 08:56:11.455 D/AudioTrack(12728): createTrack_l: RelativeVolumeFeature, mRelativePercentage:1.000000
04-28 08:56:11.456 D/AudioTrack(12728): releaseBuffer is no-op due to IAudioTrack sequence mismatch 1 != 2
04-28 08:56:16.119 D/BufferPoolAccessor2.0(12728): bufferpool2 0xb400007c25587e08 : 5(163840 size) total buffers - 5(163840 size) used buffers - 1/7 (recycle/alloc) - 29/8095 (fetch/transfer)
04-28 08:56:17.010 E/ACRA    (12728): ACRA caught a TooManyRequestsException for luci.sixsixsix.powerampache2
04-28 08:56:17.010 E/ACRA    (12728): android.net.ConnectivityManager$TooManyRequestsException
04-28 08:56:17.010 E/ACRA    (12728):   at android.net.ConnectivityManager.convertServiceException(ConnectivityManager.java:3631)
04-28 08:56:17.010 E/ACRA    (12728):   at android.net.ConnectivityManager.sendRequestForNetwork(ConnectivityManager.java:3819)
04-28 08:56:17.010 E/ACRA    (12728):   at android.net.ConnectivityManager.registerDefaultNetworkCallback(ConnectivityManager.java:4311)
04-28 08:56:17.010 E/ACRA    (12728):   at android.net.ConnectivityManager.registerDefaultNetworkCallback(ConnectivityManager.java:4278)
04-28 08:56:17.010 E/ACRA    (12728):   at androidx.work.impl.utils.NetworkApi24.registerDefaultNetworkCallbackCompat(NetworkApi24.kt:28)
04-28 08:56:17.010 E/ACRA    (12728):   at androidx.work.impl.constraints.trackers.NetworkStateTracker24.startTracking(NetworkStateTracker.kt:138)
04-28 08:56:17.010 E/ACRA    (12728):   at androidx.work.impl.constraints.trackers.ConstraintTracker.addListener(ConstraintTracker.kt:56)
04-28 08:56:17.010 E/ACRA    (12728):   at androidx.work.impl.constraints.controllers.ConstraintController$track$1.invokeSuspend(ContraintControllers.kt:54)
04-28 08:56:17.010 E/ACRA    (12728):   at androidx.work.impl.constraints.controllers.ConstraintController$track$1.invoke(Unknown Source:8)
04-28 08:56:17.010 E/ACRA    (12728):   at androidx.work.impl.constraints.controllers.ConstraintController$track$1.invoke(Unknown Source:4)
04-28 08:56:17.010 E/ACRA    (12728):   at kotlinx.coroutines.flow.ChannelFlowBuilder.collectTo$suspendImpl(Builders.kt:320)
04-28 08:56:17.010 E/ACRA    (12728):   at kotlinx.coroutines.flow.ChannelFlowBuilder.collectTo(Unknown Source:0)
04-28 08:56:17.010 E/ACRA    (12728):   at kotlinx.coroutines.flow.CallbackFlowBuilder.collectTo(Builders.kt:334)
04-28 08:56:17.010 E/ACRA    (12728):   at kotlinx.coroutines.flow.internal.ChannelFlow$collectToFun$1.invokeSuspend(ChannelFlow.kt:60)
04-28 08:56:17.010 E/ACRA    (12728):   at kotlin.coroutines.jvm.internal.BaseContinuationImpl.resumeWith(ContinuationImpl.kt:33)
04-28 08:56:17.010 E/ACRA    (12728):   at kotlinx.coroutines.DispatchedTask.run(DispatchedTask.kt:108)
04-28 08:56:17.010 E/ACRA    (12728):   at androidx.work.impl.utils.SerialExecutorImpl$Task.run(SerialExecutorImpl.java:96)
04-28 08:56:17.010 E/ACRA    (12728):   at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167)
04-28 08:56:17.010 E/ACRA    (12728):   at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641)
04-28 08:56:17.010 E/ACRA    (12728):   at java.lang.Thread.run(Thread.java:923)
04-28 08:56:17.010 E/ACRA    (12728):   Suppressed: kotlinx.coroutines.internal.DiagnosticCoroutineContextException: [StandaloneCoroutine{Cancelling}@33c3383, androidx.work.impl.utils.SerialExecutorImpl@2a60900]
icefields commented 2 months ago

https://issuetracker.google.com/issues/231499040

icefields commented 1 week ago

Crash stacktraces

Crash05.json Crash04.json Crash03.json Crash02.json Crash01.json