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

Intermittent, constant buffering #6949

Closed
4 tasks done
ghost opened this issue Aug 21, 2021 · 114 comments
Closed
4 tasks done

Intermittent, constant buffering #6949

ghost opened this issue Aug 21, 2021 · 114 comments
Labels
bug Issue is related to a bug player Issues related to any player (main, popup and background) youtube Service, https://www.youtube.com/

Comments

@ghost
Copy link

ghost commented Aug 21, 2021

Checklist

Steps to reproduce the bug

  1. Use the app to watch videos for a while

I use WebM, if that matters.

Actual behavior

Eventually, seemingly at random, a video will decide it wants to endlessly buffer on/off, making it unwatchable.

When this happens, I can see that download speed consistently stays at around 60 KB/s. Closing out of the video, clearing cached metadata, then returning to that same video makes it work as normal again, varying between 100 B/s to 1-2 MB/s as you would expect.

Expected behavior

For one, the app is supposed to buffer at least 25 seconds ahead before playback resumes, as per #5516 (comment). Simply enforcing the 25 second minimum probably wouldn't fix the underlying issue, though.

Screenshots/Screen recordings

ScreenRecord-2021-08-20-21-22-38.mp4

Logs

Cleaned up to remove screen recorder spam, from the moment I enabled the recorder to the end of the recording. I hope that's enough?

Click to reveal
08-20 21:22:16.365  2235  3117 I ActivityManager: START u0 {act=android.intent.action.MAIN cat=[android.intent.category.LAUNCHER] flg=0x10200000 cmp=org.lineageos.recorder/.RecorderActivity (has extras)} from uid 10031 on display 0
08-20 21:22:16.447  2235  3161 I ActivityManager: Start proc 10567:org.lineageos.recorder/u0a23 for activity org.lineageos.recorder/.RecorderActivity
08-20 21:22:16.522 10567 10567 I art     : Starting a blocking GC AddRemoveAppImageSpace
08-20 21:22:16.526 10567 10567 W System  : ClassLoader referenced unknown path: /system/priv-app/Recorder/lib/arm
08-20 21:22:16.672 10567 10567 W art     : Before Android 4.1, method android.graphics.PorterDuffColorFilter android.support.graphics.drawable.VectorDrawableCompat.updateTintFilter(android.graphics.PorterDuffColorFilter, android.content.res.ColorStateList, android.graphics.PorterDuff$Mode) would have incorrectly overridden the package-private method in android.graphics.drawable.Drawable
08-20 21:22:16.899  2235  3117 E WindowManager: App trying to use insecure INPUT_FEATURE_NO_INPUT_CHANNEL flag. Ignoring
08-20 21:22:16.951 10567 10588 I Adreno-EGL: : QUALCOMM Build: 10/21/15, 369a2ea, I96aee987eb
08-20 21:22:16.955 10567 10588 I OpenGLRenderer: Initialized EGL, version 1.4
08-20 21:22:16.955 10567 10588 D OpenGLRenderer: Swap behavior 1
08-20 21:22:17.166  2235  2258 I ActivityManager: Displayed org.lineageos.recorder/.RecorderActivity: +765ms
08-20 21:22:18.142  2235  2247 I ActivityManager: START u0 {act=android.content.pm.action.REQUEST_PERMISSIONS pkg=com.android.packageinstaller cmp=com.android.packageinstaller/.permission.ui.GrantPermissionsActivity (has extras)} from uid 10023 on display 0
08-20 21:22:18.282  2235  3161 E WindowManager: App trying to use insecure INPUT_FEATURE_NO_INPUT_CHANNEL flag. Ignoring
08-20 21:22:18.370  2235  2258 I ActivityManager: Displayed com.android.packageinstaller/.permission.ui.GrantPermissionsActivity: +203ms
08-20 21:22:19.148  2235  2333 D WifiStateMachine: updateCapabilities for config:[redacted]false,false
08-20 21:22:19.292  2235  2847 D VoldConnector: SND -> {18 volume remount_uid 10023 read}
08-20 21:22:19.295   152   156 D vold    : Remounting 10023 as mode read
08-20 21:22:19.313   152   156 D vold    : Found matching PID 10567
08-20 21:22:19.320  2235  2325 D VoldConnector: RCV <- {200 18 Command succeeded}
08-20 21:22:19.323  2235  2884 D VoldConnector: SND -> {19 volume remount_uid 10023 write}
08-20 21:22:19.324   152   156 D vold    : Remounting 10023 as mode write
08-20 21:22:19.336   152   156 D vold    : Found matching PID 10567
08-20 21:22:19.342  2235  2325 D VoldConnector: RCV <- {200 19 Command succeeded}
08-20 21:22:19.430 32574 32596 D OpenGLRenderer: endAllActiveAnimators on 0xaa41c100 (RippleDrawable) with handle 0x98cd0fa0
08-20 21:22:19.619   189   189 W SurfaceFlinger: couldn't log to binary event log: overflow.
08-20 21:22:19.872  3127  3476 D ProtonLogger_0: 21:22:19-4: Checking if server is not in maintenance
08-20 21:22:19.880  2235  2584 E WindowManager: App trying to use insecure INPUT_FEATURE_NO_INPUT_CHANNEL flag. Ignoring
08-20 21:22:19.890  3127  3476 D ProtonLogger_0: 21:22:19-4: [core.network.api.call] --> GET https://api.protonvpn.ch/vpn/servers/[iOKxc3Vwt8UcQksAO9QB3aUdI3wc3j1IL7bA7lFS9Av9I0_Lh7EPjiA46m9YVqzUFpU69_0HojvhmipvXLYi3A==] (auth Beare...)
08-20 21:22:20.152  2235  2245 I art     : Background partial concurrent mark sweep GC freed 38220(2MB) AllocSpace objects, 4(76KB) LOS objects, 33% free, 14MB/22MB, paused 2.315ms total 218.141ms
08-20 21:22:20.683  3127 10633 E java.net.CookieManager: Invalid cookie for https://api.protonvpn.ch/vpn/servers/[redacted]: Version=default; expires=Fri, 19 Nov 2021 01:22:20 GMT; path=/; secure
08-20 21:22:20.686  2394  2407 I art     : Background partial concurrent mark sweep GC freed 233657(13MB) AllocSpace objects, 3(72KB) LOS objects, 39% free, 23MB/38MB, paused 817us total 159.410ms
08-20 21:22:20.687  3127  3476 D ProtonLogger_0: 21:22:20-4: [core.network.api.call] <-- 200  GET https://api.protonvpn.ch/vpn/servers/[redacted] (792ms)
08-20 21:22:21.000  2394  2394 I SlideTouchEvent: vel=0.0, MinimumFlingVelocity=150
08-20 21:22:21.007  2235  2584 I ActivityManager: START u0 {flg=0x10804000 cmp=com.android.systemui/.recents.RecentsActivity} from uid 10037 on display 0
08-20 21:22:22.223  2235  3157 E ActivityManager: applyOptionsLocked: Unknown animationType=0
08-20 21:22:22.452  2235  2584 W AppOps  : Finishing op nesting under-run: uid 10076 pkg org.schabi.newpipe code 40 time=0 duration=0 nesting=0
08-20 21:22:22.551  1740 32071 W AudioFlinger::EffectModule: EffectModule 0xb5204080 destructor called with unreleased interface
08-20 21:22:22.551  1740  1740 W AudioFlinger::EffectHandle: disconnect Effect handle 0xb577d380 disconnected after thread destruction
08-20 21:22:22.632  3111 10132 D CacheFactory: initExoPlayerCache: cacheDir = /storage/emulated/0/Android/data/org.schabi.newpipe/cache/exoplayer
08-20 21:22:22.633  3111 10132 D CacheFactory: initExoPlayerCache: cacheDir = /storage/emulated/0/Android/data/org.schabi.newpipe/cache/exoplayer
08-20 21:22:22.834  1747  2561 I MediaPlayerService: MediaPlayerService::getOMX
08-20 21:22:22.843  3111 10692 I OMXClient: MuxOMX ctor
08-20 21:22:22.844  1744 32395 I OMXMaster: makeComponentInstance(OMX.google.vp9.decoder) in mediacodec process
08-20 21:22:22.854  3111 10690 I MediaCodec: [OMX.google.vp9.decoder] setting surface generation to 3185717
08-20 21:22:22.858  1744  1744 W OMXNodeInstance: [6d00081:google.vp9.decoder] component does not support metadata mode; using fallback
08-20 21:22:22.859  3111 10692 E ACodec  : [OMX.google.vp9.decoder] storeMetaDataInBuffers failed w/ err -1010
08-20 21:22:22.863  1744  1744 E OMXNodeInstance: setConfig(6d00081:google.vp9.decoder, ConfigPriority(0x6f800002)) ERROR: UnsupportedIndex(0x8000101a)
08-20 21:22:22.863  3111 10692 I ACodec  : codec does not support config priority (err -1010)
08-20 21:22:22.863  1744  2449 E OMXNodeInstance: getParameter(6d00081:google.vp9.decoder, ParamVideoAndroidVp8Encoder(0x6f600007)) ERROR: UnsupportedIndex(0x8000101a)
08-20 21:22:22.887  1747  2248 I MediaPlayerService: MediaPlayerService::getOMX
08-20 21:22:22.888  3111 10695 I OMXClient: MuxOMX ctor
08-20 21:22:22.889  1744  1744 I OMXMaster: makeComponentInstance(OMX.google.aac.decoder) in mediacodec process
08-20 21:22:22.899  1744 32395 E OMXNodeInstance: setConfig(6d00082:google.aac.decoder, ConfigPriority(0x6f800002)) ERROR: Undefined(0x80001001)
08-20 21:22:22.900  3111 10695 I ACodec  : codec does not support config priority (err -2147483648)
08-20 21:22:22.915  1744 10696 I SoftAAC2: Reconfiguring decoder: 0->44100 Hz, 0->2 channels
08-20 21:22:22.946  3111 10132 D AudioTrack: Client defaulted notificationFrames to 3675 for frameCount 11025
08-20 21:22:24.653  3111 10690 D MediaCodec: [OMX.google.vp9.decoder] setting dataspace on output surface to #104
08-20 21:22:25.499  1740  1872 D audio_hw_primary: disable_audio_route: usecase(1) reset and update mixer path: low-latency-playback
08-20 21:22:31.698  3111 10690 D SoftwareRenderer: setting dataspace on output surface to #104
08-20 21:22:31.975  2235  3165 I MediaFocusControl:  AudioFocus  requestAudioFocus() from uid/pid 10076/3111 clientId=android.media.AudioManager@caee8acorg.schabi.newpipe.player.helper.AudioReactor@f4b7cd req=1 flags=0x0
08-20 21:22:31.979  1740  1872 D audio_hw_primary: enable_audio_route: usecase(1) apply and update mixer path: low-latency-playback
08-20 21:22:32.034  2235  2328 W ConnectivityExtension: ConnectivityExt jar file not present
08-20 21:22:37.110  3111  3123 I art     : Background partial concurrent mark sweep GC freed 107821(7MB) AllocSpace objects, 81(7MB) LOS objects, 20% free, 61MB/77MB, paused 2.822ms total 292.526ms
08-20 21:22:37.646  2235  2249 I UsageStatsService: User[0] Flushing usage stats to disk
08-20 21:22:38.138  1747  1747 I MediaPlayerService: MediaPlayerService::getOMX
08-20 21:22:38.139 10567 10946 I OMXClient: MuxOMX ctor
08-20 21:22:38.142  1747  2450 I OMXMaster: makeComponentInstance(OMX.qcom.video.encoder.avc) in mediaserver process
08-20 21:22:38.264  1747  2450 E OMX-VENC: Setting session priority failed
08-20 21:22:38.265  1747  2450 I OMX-VENC: Component_init : OMX.qcom.video.encoder.avc : return = 0x0
08-20 21:22:38.269  1747  2561 E OMX-VENC: set_parameter: metamode is valid for input port only
08-20 21:22:38.269  1747  2561 W OMXNodeInstance: [6d30006:qcom.encoder.avc] component does not support metadata mode; using fallback
08-20 21:22:38.269 10567 10946 E ACodec  : [OMX.qcom.video.encoder.avc] storeMetaDataInBuffers (output) failed w/ err -1010
08-20 21:22:38.270 10567 10946 W ACodec  : do not know color format 0x7fa30c04 = 2141391876
08-20 21:22:38.271 10567 10946 W ACodec  : do not know color format 0x7f000789 = 2130708361
08-20 21:22:38.275 10567 10946 I ACodec  : setupAVCEncoderParameters with [profile: Baseline] [level: Level41]
08-20 21:22:38.276 10567 10946 I ACodec  : [OMX.qcom.video.encoder.avc] cannot encode color aspects. Ignoring.
08-20 21:22:38.277 10567 10946 I ACodec  : [OMX.qcom.video.encoder.avc] cannot encode HDR static metadata. Ignoring.
08-20 21:22:38.277 10567 10946 I ACodec  : setupVideoEncoder succeeded
08-20 21:22:38.280 10567 10946 W ACodec  : do not know color format 0x7f000789 = 2130708361
08-20 21:22:38.285  1747  2450 D GraphicBufferSource: setting dataspace: 0x104
08-20 21:22:38.285  1747  2561 E OMXNodeInstance: getParameter(6d30006:qcom.encoder.avc, ParamConsumerUsageBits(0x6f800004)) ERROR: UnsupportedIndex(0x8000101a)
08-20 21:22:38.285  1747  2248 D GraphicBufferSource: requesting color aspects (R:2(Limited), P:1(BT709_5), M:1(BT709_5), T:3(SMPTE170M))
08-20 21:22:38.438  2235 20037 I DisplayManagerService: Display device added: DisplayDeviceInfo{"hidden:screen-recording": uniqueId="virtual:org.lineageos.recorder,10023,hidden:screen-recording,0", 1080 x 1920, modeId 2, defaultModeId 2, supportedModes [{id=2, width=1080, height=1920, fps=60.0}], colorMode 0, supportedColorModes [0], HdrCapabilities null, density 1, 1.0 x 1.0 dpi, appVsyncOff 0, presDeadline 16666666, touch NONE, rotation 0, type VIRTUAL, state ON, owner org.lineageos.recorder (uid 10023), FLAG_SECURE}
08-20 21:22:38.454   189   189 I SurfaceFlinger: EGL information:
08-20 21:22:38.454   189   189 I SurfaceFlinger: vendor    : Android
08-20 21:22:38.454   189   189 I SurfaceFlinger: version   : 1.4 Android META-EGL
08-20 21:22:38.454   189   189 I SurfaceFlinger: extensions: EGL_KHR_get_all_proc_addresses EGL_ANDROID_presentation_time EGL_KHR_swap_buffers_with_damage EGL_ANDROID_create_native_client_buffer EGL_ANDROID_front_buffer_auto_refresh EGL_KHR_image EGL_KHR_image_base EGL_KHR_lock_surface EGL_KHR_gl_texture_2D_image EGL_KHR_gl_texture_3D_image EGL_KHR_gl_texture_cubemap_image EGL_KHR_gl_renderbuffer_image EGL_KHR_fence_sync EGL_KHR_create_context EGL_EXT_create_context_robustness EGL_ANDROID_image_native_buffer EGL_KHR_wait_sync EGL_ANDROID_recordable EGL_KHR_partial_update 
08-20 21:22:38.454   189   189 I SurfaceFlinger: Client API: OpenGL_ES
08-20 21:22:38.454   189   189 I SurfaceFlinger: EGLSurface: 8-8-8-8, config=0x5
08-20 21:22:38.478  1747  2562 D GraphicBufferSource: got buffer with new dataSpace #104
08-20 21:22:38.478 10567 10946 D ACodec  : dataspace changed to 0x10c10000 (R:2(Limited), P:1(BT709_5), M:1(BT709_5), T:3(SMPTE170M)) (R:2(Limited), S:1(BT709), T:3(SMPTE_170M))
08-20 21:22:38.479  2235  3161 W AppOps  : Finishing op nesting under-run: uid 10023 pkg org.lineageos.recorder code 24 time=0 duration=0 nesting=0
08-20 21:22:38.484  1747 10951 I OMX-VENC: open Color conv for RGBA888 W: 1080, H: 1920
08-20 21:22:38.685 10567 10954 I MPEG4Writer: limits: 4294967295/0 bytes/us, bit rate: -1 bps and the estimated moov size 3195 bytes
08-20 21:22:38.689 10567 10959 I MPEG4Writer: setStartTimestampUs: 312844
08-20 21:22:38.689 10567 10959 I MPEG4Writer: Earliest track starting time: 312844
08-20 21:22:38.893  2394  2407 I art     : Background partial concurrent mark sweep GC freed 94886(5MB) AllocSpace objects, 3(696KB) LOS objects, 40% free, 22MB/37MB, paused 824us total 105.167ms
08-20 21:22:40.272  2235  2333 D WifiStateMachine: updateCapabilities for config:[redacted]false,false
08-20 21:22:43.285  2235  2333 D WifiStateMachine: updateCapabilities for config:[redacted]false,false
08-20 21:22:48.465  2235  2328 W ConnectivityExtension: ConnectivityExt jar file not present
08-20 21:22:48.683  2235  2245 I art     : Background sticky concurrent mark sweep GC freed 105429(6MB) AllocSpace objects, 13(280KB) LOS objects, 31% free, 15MB/22MB, paused 6.871ms total 165.009ms
08-20 21:22:53.440  2235  2253 E BatteryStatsService: power: Missing API
08-20 21:22:53.442  2235  2253 E BatteryStatsService: no controller energy info supplied
08-20 21:22:53.443  2235  2253 E BatteryStatsService: no controller energy info supplied
08-20 21:22:53.498  2235  2253 E BatteryStatsService: modem info is invalid: ModemActivityInfo{ mTimestamp=0 mSleepTimeMs=0 mIdleTimeMs=0 mTxTimeMs[]=[0, 0, 0, 0, 0] mRxTimeMs=0 mEnergyUsed=0}
08-20 21:22:55.846  2235  2847 I ActivityManager: Setting hasTopUi=true for pid=2394
08-20 21:22:55.848  2394  2394 D PhoneStatusBar: disable: < expand ICONS* alerts SYSTEM_INFO* back home recent clock search quick_settings >
08-20 21:22:57.709  2235  2342 D NotificationSQLiteLog: Pruned event entries: 22
08-20 21:23:01.369  2235  2333 D WifiStateMachine: updateCapabilities for config:[redacted]false,false
08-20 21:23:05.038  2235  2328 W ConnectivityExtension: ConnectivityExt jar file not present
08-20 21:23:07.944  3111  3123 I art     : Background partial concurrent mark sweep GC freed 50063(2043KB) AllocSpace objects, 10(2MB) LOS objects, 21% free, 57MB/73MB, paused 1.827ms total 305.098ms
08-20 21:23:13.326  2394  2407 I art     : Background partial concurrent mark sweep GC freed 176000(10MB) AllocSpace objects, 1(24KB) LOS objects, 39% free, 23MB/38MB, paused 781us total 152.099ms
08-20 21:23:16.262  2235  3117 W InputMethodManagerService: Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@44f0159 attribute=null, token = android.os.BinderProxy@75b4a44
08-20 21:23:16.274  2235  2247 I ActivityManager: Setting hasTopUi=false for pid=2394
08-20 21:23:16.277  2394  2394 D PhoneStatusBar: disable: < expand icons* alerts system_info* back home recent clock search quick_settings >
08-20 21:23:16.492  2235  2333 D WifiStateMachine: updateCapabilities for config:[redacted]false,false
08-20 21:23:22.524  2235  2333 D WifiStateMachine: updateCapabilities for config:[redacted]false,false
08-20 21:23:24.168  2235  2328 W ConnectivityExtension: ConnectivityExt jar file not present
08-20 21:23:24.672  1740  1872 D audio_hw_primary: disable_audio_route: usecase(1) reset and update mixer path: low-latency-playback
08-20 21:23:24.734  1740  1872 D audio_hw_primary: enable_audio_route: usecase(1) apply and update mixer path: low-latency-playback
08-20 21:23:24.791  3111 10132 W AudioTrack: getTimestamp() location moved from kernel to server
08-20 21:23:24.812  3111 10132 W AudioTrack: retrograde timestamp position corrected, -2 = 1238312 - 1238314
08-20 21:23:39.571  2235  2245 I art     : Background sticky concurrent mark sweep GC freed 116004(6MB) AllocSpace objects, 0(0B) LOS objects, 30% free, 15MB/22MB, paused 2.407ms total 109.439ms
08-20 21:23:40.566  2235  2328 W ConnectivityExtension: ConnectivityExt jar file not present
08-20 21:23:40.628  2235  2333 D WifiStateMachine: updateCapabilities for config:[redacted]false,false
08-20 21:23:41.347  2235  3117 I ActivityManager: Setting hasTopUi=true for pid=2394
08-20 21:23:41.349  2394  2394 D PhoneStatusBar: disable: < expand ICONS* alerts SYSTEM_INFO* back home recent clock search quick_settings >
08-20 21:23:42.131  3111  3123 I art     : Background partial concurrent mark sweep GC freed 28593(935KB) AllocSpace objects, 0(0B) LOS objects, 21% free, 57MB/73MB, paused 2.849ms total 615.989ms
08-20 21:23:48.354  2235  2884 W InputMethodManagerService: Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@b619ea7 attribute=null, token = android.os.BinderProxy@75b4a44
08-20 21:23:48.379  2235  2847 I ActivityManager: Setting hasTopUi=false for pid=2394
08-20 21:23:48.380  2394  2394 D PhoneStatusBar: disable: < expand icons* alerts system_info* back home recent clock search quick_settings >
08-20 21:23:49.853  2394  2394 I SlideTouchEvent: vel=0.0, MinimumFlingVelocity=150
08-20 21:23:51.172  3111 11234 W Adreno-EGL: : EGL_BAD_ATTRIBUTE
08-20 21:23:51.173  3111 10690 I MediaCodec: [OMX.google.vp9.decoder] setting surface generation to 3185718
08-20 21:23:51.212  2235  3157 W AppOps  : Finishing op nesting under-run: uid 10076 pkg org.schabi.newpipe code 40 time=0 duration=0 nesting=0
08-20 21:23:51.223  3111  3111 I ExoPlayerImpl: Release 5bf32ae [ExoPlayerLib/2.12.3] [hammerhead, Nexus 5, LGE, 25] [goog.exo.core, goog.exo.mediasession]
08-20 21:23:51.290  2235  2606 I MediaFocusControl:  AudioFocus  abandonAudioFocus() from uid/pid 10076/3111 clientId=android.media.AudioManager@caee8acorg.schabi.newpipe.player.helper.AudioReactor@f4b7cd
08-20 21:23:53.499  1740  1872 D audio_hw_primary: disable_audio_route: usecase(1) reset and update mixer path: low-latency-playback
08-20 21:23:54.214  3111  3123 I art     : Background partial concurrent mark sweep GC freed 35549(1472KB) AllocSpace objects, 24(2MB) LOS objects, 21% free, 57MB/73MB, paused 1.557ms total 314.950ms
08-20 21:23:54.761  2394  2407 I art     : Background partial concurrent mark sweep GC freed 229537(13MB) AllocSpace objects, 0(0B) LOS objects, 40% free, 23MB/38MB, paused 784us total 153.795ms
08-20 21:23:56.880  3111  3111 I ExoPlayerImpl: Init 6338f35 [ExoPlayerLib/2.12.3] [hammerhead, Nexus 5, LGE, 25]
08-20 21:23:56.906  3111  3111 W Player  : Broadcast receiver already unregistered: Receiver not registered: org.schabi.newpipe.player.Player$3@51ae9b1
08-20 21:23:56.977  2394  2394 D ro      : inflating media notification
08-20 21:23:57.049  2235  2847 E WindowManager: App trying to use insecure INPUT_FEATURE_NO_INPUT_CHANNEL flag. Ignoring
08-20 21:23:57.077  3111  3111 I ExoPlayerImpl: Release 6338f35 [ExoPlayerLib/2.12.3] [hammerhead, Nexus 5, LGE, 25] [goog.exo.core, goog.exo.mediasession]
08-20 21:23:57.080  2235  2884 I MediaFocusControl:  AudioFocus  abandonAudioFocus() from uid/pid 10076/3111 clientId=android.media.AudioManager@caee8acorg.schabi.newpipe.player.helper.AudioReactor@c3f6493
08-20 21:23:57.088  3111  3111 I ExoPlayerImpl: Init 454ccd0 [ExoPlayerLib/2.12.3] [hammerhead, Nexus 5, LGE, 25]
08-20 21:23:57.364  3111 11331 D CacheFactory: initExoPlayerCache: cacheDir = /storage/emulated/0/Android/data/org.schabi.newpipe/cache/exoplayer
08-20 21:23:57.365  3111 11331 D CacheFactory: initExoPlayerCache: cacheDir = /storage/emulated/0/Android/data/org.schabi.newpipe/cache/exoplayer
08-20 21:23:57.626  1747  2248 I MediaPlayerService: MediaPlayerService::getOMX
08-20 21:23:57.629  3111 11339 I OMXClient: MuxOMX ctor
08-20 21:23:57.633  1744 32395 I OMXMaster: makeComponentInstance(OMX.google.vp9.decoder) in mediacodec process
08-20 21:23:57.644  3111 11338 I MediaCodec: [OMX.google.vp9.decoder] setting surface generation to 3185719
08-20 21:23:57.654  1744  2622 W OMXNodeInstance: [6d00083:google.vp9.decoder] component does not support metadata mode; using fallback
08-20 21:23:57.654  3111 11339 E ACodec  : [OMX.google.vp9.decoder] storeMetaDataInBuffers failed w/ err -1010
08-20 21:23:57.660  1744  2449 E OMXNodeInstance: setConfig(6d00083:google.vp9.decoder, ConfigPriority(0x6f800002)) ERROR: UnsupportedIndex(0x8000101a)
08-20 21:23:57.660  3111 11339 I ACodec  : codec does not support config priority (err -1010)
08-20 21:23:57.660  1744  1822 E OMXNodeInstance: getParameter(6d00083:google.vp9.decoder, ParamVideoAndroidVp8Encoder(0x6f600007)) ERROR: UnsupportedIndex(0x8000101a)
08-20 21:23:57.674  1747  2562 I MediaPlayerService: MediaPlayerService::getOMX
08-20 21:23:57.675  3111 11343 I OMXClient: MuxOMX ctor
08-20 21:23:57.676  1744  2622 I OMXMaster: makeComponentInstance(OMX.google.aac.decoder) in mediacodec process
08-20 21:23:57.706  1744  1744 E OMXNodeInstance: setConfig(6d00084:google.aac.decoder, ConfigPriority(0x6f800002)) ERROR: Undefined(0x80001001)
08-20 21:23:57.707  3111 11343 I ACodec  : codec does not support config priority (err -2147483648)
08-20 21:23:57.730  1744 11344 I SoftAAC2: Reconfiguring decoder: 0->44100 Hz, 0->2 channels
08-20 21:23:57.780  3111 11331 D AudioTrack: Client defaulted notificationFrames to 3675 for frameCount 11025
08-20 21:23:57.942  3111 11338 D MediaCodec: [OMX.google.vp9.decoder] setting dataspace on output surface to #104
08-20 21:23:58.684  2235  2328 W ConnectivityExtension: ConnectivityExt jar file not present
08-20 21:24:00.387  2235  2245 I art     : Background sticky concurrent mark sweep GC freed 101501(5MB) AllocSpace objects, 0(0B) LOS objects, 29% free, 15MB/22MB, paused 2.428ms total 105.996ms
08-20 21:24:01.753  2235  2333 D WifiStateMachine: updateCapabilities for config:[redacted]false,false
08-20 21:24:01.924  3111 11338 D SoftwareRenderer: setting dataspace on output surface to #104
08-20 21:24:01.934  1740  1872 D audio_hw_primary: enable_audio_route: usecase(1) apply and update mixer path: low-latency-playback
08-20 21:24:01.952  2235  2584 I MediaFocusControl:  AudioFocus  requestAudioFocus() from uid/pid 10076/3111 clientId=android.media.AudioManager@caee8acorg.schabi.newpipe.player.helper.AudioReactor@3a0b52e req=1 flags=0x0
08-20 21:24:07.788  2235  2333 D WifiStateMachine: updateCapabilities for config:[redacted]false,false
08-20 21:24:09.323  2235  2328 W ConnectivityExtension: ConnectivityExt jar file not present
08-20 21:24:09.357  3111  3123 I art     : Background partial concurrent mark sweep GC freed 45579(2MB) AllocSpace objects, 8(280KB) LOS objects, 21% free, 58MB/74MB, paused 1.734ms total 301.279ms
08-20 21:24:13.251  2394  2394 I SlideTouchEvent: vel=0.0, MinimumFlingVelocity=150
08-20 21:24:14.116  3111 11376 W Adreno-EGL: : EGL_BAD_ATTRIBUTE
08-20 21:24:14.118  3111 11338 I MediaCodec: [OMX.google.vp9.decoder] setting surface generation to 3185720
08-20 21:24:14.132  2235  2845 W AppOps  : Finishing op nesting under-run: uid 10076 pkg org.schabi.newpipe code 40 time=0 duration=0 nesting=0
08-20 21:24:14.142  3111  3111 I ExoPlayerImpl: Release 454ccd0 [ExoPlayerLib/2.12.3] [hammerhead, Nexus 5, LGE, 25] [goog.exo.core, goog.exo.mediasession]
08-20 21:24:14.216  2235  3165 I MediaFocusControl:  AudioFocus  abandonAudioFocus() from uid/pid 10076/3111 clientId=android.media.AudioManager@caee8acorg.schabi.newpipe.player.helper.AudioReactor@3a0b52e
08-20 21:24:14.291  1740  1740 W AudioFlinger::EffectModule: EffectModule 0xb4d17180 destructor called with unreleased interface
08-20 21:24:14.293  1740  1880 W AudioFlinger::EffectHandle: disconnect Effect handle 0xb527d400 disconnected after thread destruction
08-20 21:24:14.540  2235  2328 W ConnectivityExtension: ConnectivityExt jar file not present
08-20 21:24:15.751  2394  2394 I SlideTouchEvent: vel=0.0, MinimumFlingVelocity=150
08-20 21:24:17.250  1740  1872 D audio_hw_primary: disable_audio_route: usecase(1) reset and update mixer path: low-latency-playback
08-20 21:24:18.403  2235  2606 I ActivityManager: START u0 {cmp=org.schabi.newpipe/.about.AboutActivity} from uid 10076 on display 0
08-20 21:24:18.611  2235  3164 E WindowManager: App trying to use insecure INPUT_FEATURE_NO_INPUT_CHANNEL flag. Ignoring
08-20 21:24:18.922  2235  2258 I ActivityManager: Displayed org.schabi.newpipe/.about.AboutActivity: +477ms
08-20 21:24:19.008  3111  3144 D OpenGLRenderer: endAllActiveAnimators on 0x8af9ad80 (NavigationMenuItemView) with handle 0x9573b780
08-20 21:24:19.130  3111  3123 I art     : Background partial concurrent mark sweep GC freed 30338(2MB) AllocSpace objects, 84(4MB) LOS objects, 21% free, 57MB/73MB, paused 1.812ms total 271.552ms
08-20 21:24:19.854  2235  2333 D WifiStateMachine: updateCapabilities for config:[redacted]false,false
08-20 21:24:21.348  2394  2394 I SlideTouchEvent: vel=0.0, MinimumFlingVelocity=150
08-20 21:24:24.072  2235  2884 I ActivityManager: START u0 {cmp=org.schabi.newpipe/.settings.SettingsActivity} from uid 10076 on display 0
08-20 21:24:24.210  2235  2408 E WindowManager: App trying to use insecure INPUT_FEATURE_NO_INPUT_CHANNEL flag. Ignoring
08-20 21:24:24.416  2235  2258 I ActivityManager: Displayed org.schabi.newpipe/.settings.SettingsActivity: +329ms
08-20 21:24:24.501  3111  3144 D OpenGLRenderer: endAllActiveAnimators on 0x8af98e00 (NavigationMenuItemView) with handle 0x9537f9f0
08-20 21:24:25.903  2235  2333 D WifiStateMachine: updateCapabilities for config:[redacted]false,false
08-20 21:24:26.447  3127  3719 I charon  : 07[IKE] sending keep alive to 86.106.90.99[4500]
08-20 21:24:26.453  3127  3476 D ProtonLogger_0: 21:24:26-4: 07[IKE] sending keep alive to 86.106.90.99[4500]
08-20 21:24:26.623  2235  3164 E WindowManager: App trying to use insecure INPUT_FEATURE_NO_INPUT_CHANNEL flag. Ignoring
08-20 21:24:27.708  2394  2394 I SlideTouchEvent: vel=0.0, MinimumFlingVelocity=150
08-20 21:24:28.435  2394  2394 I SlideTouchEvent: vel=0.0, MinimumFlingVelocity=150
08-20 21:24:28.620  2235  2235 W WindowManager: Attempted to remove non-existing token: android.os.Binder@e6d4d58
08-20 21:24:31.508  2379  2379 W SubtypeLocaleUtils: KeyboardLayoutSet not found, use QWERTY: locale=en_AU extraValue=TrySuppressingImeSwitcher,AsciiCapable,SupportTouchPositionCorrection,EmojiCapable
08-20 21:24:31.509  2379  2379 W SubtypeLocaleUtils: KeyboardLayoutSet not found, use QWERTY: locale=hu_ZZ extraValue=AsciiCapable,SupportTouchPositionCorrection,EmojiCapable
08-20 21:24:31.510  2379  2379 W RichInputMethodSubtype: Can't find emoji subtype
08-20 21:24:31.510  2379  2379 W RichInputMethodSubtype: No input method subtype found; returning dummy subtype: Multi-lingual subtype: android.view.inputmethod.InputMethodSubtype@d78b2ed0, zz
08-20 21:24:31.640  2379  2379 I EmojiCategory: Last Emoji category id is 0
08-20 21:24:31.686  2379  2379 W ViewPager: Requested offscreen page limit 0 too small; defaulting to 1
08-20 21:24:31.696  2379  2379 I LatinIME: Starting input. Cursor position = 0,0
08-20 21:24:31.798  2379  2379 W SubtypeLocaleUtils: KeyboardLayoutSet not found, use QWERTY: locale=en_AU extraValue=TrySuppressingImeSwitcher,AsciiCapable,SupportTouchPositionCorrection,EmojiCapable
08-20 21:24:31.892  2379  2379 I Choreographer: Skipped 30 frames!  The application may be doing too much work on its main thread.
08-20 21:24:31.952  2235  2333 D WifiStateMachine: updateCapabilities for config:[redacted]false,false
08-20 21:24:32.564  2394  2394 I SlideTouchEvent: vel=0.0, MinimumFlingVelocity=150
08-20 21:24:32.571  2379  2379 W InputMethodService: Window size has been changed. This may cause jankiness of resizing window: -1 -> -2
08-20 21:24:33.095  2394  2394 I SlideTouchEvent: vel=0.0, MinimumFlingVelocity=150
08-20 21:24:33.545  3111  3111 W IInputConnectionWrapper: finishComposingText on inactive InputConnection
08-20 21:24:37.204  3111  3123 I art     : Background partial concurrent mark sweep GC freed 695677(30MB) AllocSpace objects, 47(4MB) LOS objects, 30% free, 36MB/52MB, paused 6.864ms total 464.790ms
08-20 21:24:38.000  2235  2333 D WifiStateMachine: updateCapabilities for config:[redacted]false,false
08-20 21:24:38.954  3111  3111 I ExoPlayerImpl: Init 85224d3 [ExoPlayerLib/2.12.3] [hammerhead, Nexus 5, LGE, 25]
08-20 21:24:38.979  3111  3111 W Player  : Broadcast receiver already unregistered: Receiver not registered: org.schabi.newpipe.player.Player$3@b103b2f
08-20 21:24:39.027  2394  2394 D ro      : inflating media notification
08-20 21:24:39.380  2235  3161 E WindowManager: App trying to use insecure INPUT_FEATURE_NO_INPUT_CHANNEL flag. Ignoring
08-20 21:24:39.417  3111  3111 I ExoPlayerImpl: Release 85224d3 [ExoPlayerLib/2.12.3] [hammerhead, Nexus 5, LGE, 25] [goog.exo.core, goog.exo.mediasession]
08-20 21:24:39.420  2235  2408 I MediaFocusControl:  AudioFocus  abandonAudioFocus() from uid/pid 10076/3111 clientId=android.media.AudioManager@caee8acorg.schabi.newpipe.player.helper.AudioReactor@7da7a98
08-20 21:24:39.429  3111  3111 I ExoPlayerImpl: Init 2f0b2f1 [ExoPlayerLib/2.12.3] [hammerhead, Nexus 5, LGE, 25]
08-20 21:24:39.630  3111  3123 I art     : Background partial concurrent mark sweep GC freed 134115(6MB) AllocSpace objects, 40(1592KB) LOS objects, 32% free, 32MB/48MB, paused 11.758ms total 234.595ms
08-20 21:24:39.753  3111 11701 D CacheFactory: initExoPlayerCache: cacheDir = /storage/emulated/0/Android/data/org.schabi.newpipe/cache/exoplayer
08-20 21:24:39.753  3111 11701 D CacheFactory: initExoPlayerCache: cacheDir = /storage/emulated/0/Android/data/org.schabi.newpipe/cache/exoplayer
08-20 21:24:39.886  2394  2407 I art     : Background sticky concurrent mark sweep GC freed 204981(13MB) AllocSpace objects, 0(0B) LOS objects, 33% free, 25MB/38MB, paused 5.307ms total 217.016ms
08-20 21:24:40.042  1747  2450 I MediaPlayerService: MediaPlayerService::getOMX
08-20 21:24:40.044  3111 11705 I OMXClient: MuxOMX ctor
08-20 21:24:40.049  1744 32395 I OMXMaster: makeComponentInstance(OMX.google.vp9.decoder) in mediacodec process
08-20 21:24:40.056  3111 11704 I MediaCodec: [OMX.google.vp9.decoder] setting surface generation to 3185721
08-20 21:24:40.063  1744  1744 W OMXNodeInstance: [6d00085:google.vp9.decoder] component does not support metadata mode; using fallback
08-20 21:24:40.063  3111 11705 E ACodec  : [OMX.google.vp9.decoder] storeMetaDataInBuffers failed w/ err -1010
08-20 21:24:40.070  1744  1744 E OMXNodeInstance: setConfig(6d00085:google.vp9.decoder, ConfigPriority(0x6f800002)) ERROR: UnsupportedIndex(0x8000101a)
08-20 21:24:40.073  3111 11705 I ACodec  : codec does not support config priority (err -1010)
08-20 21:24:40.073  1744  2449 E OMXNodeInstance: getParameter(6d00085:google.vp9.decoder, ParamVideoAndroidVp8Encoder(0x6f600007)) ERROR: UnsupportedIndex(0x8000101a)
08-20 21:24:40.089  1747  2450 I MediaPlayerService: MediaPlayerService::getOMX
08-20 21:24:40.092  3111 11709 I OMXClient: MuxOMX ctor
08-20 21:24:40.093  1744  1744 I OMXMaster: makeComponentInstance(OMX.google.aac.decoder) in mediacodec process
08-20 21:24:40.100  1744  1822 E OMXNodeInstance: setConfig(6d00086:google.aac.decoder, ConfigPriority(0x6f800002)) ERROR: Undefined(0x80001001)
08-20 21:24:40.100  3111 11709 I ACodec  : codec does not support config priority (err -2147483648)
08-20 21:24:40.133  1744 11710 I SoftAAC2: Reconfiguring decoder: 0->44100 Hz, 0->2 channels
08-20 21:24:40.173  3111 11701 D AudioTrack: Client defaulted notificationFrames to 3675 for frameCount 11025
08-20 21:24:40.344  3111 11704 D MediaCodec: [OMX.google.vp9.decoder] setting dataspace on output surface to #104
08-20 21:24:41.121  3111 11704 D SoftwareRenderer: setting dataspace on output surface to #104
08-20 21:24:41.685  2235  2845 I MediaFocusControl:  AudioFocus  requestAudioFocus() from uid/pid 10076/3111 clientId=android.media.AudioManager@caee8acorg.schabi.newpipe.player.helper.AudioReactor@18689b8 req=1 flags=0x0
08-20 21:24:41.691  1740  1872 D audio_hw_primary: enable_audio_route: usecase(1) apply and update mixer path: low-latency-playback
08-20 21:24:42.367  2235  2328 W ConnectivityExtension: ConnectivityExt jar file not present
08-20 21:24:43.214  2235  2328 W ConnectivityExtension: ConnectivityExt jar file not present
08-20 21:24:43.796  2235  2245 I art     : Background sticky concurrent mark sweep GC freed 89048(5MB) AllocSpace objects, 3(60KB) LOS objects, 28% free, 15MB/22MB, paused 11.435ms total 150.783ms
08-20 21:24:43.970  2235  2328 W ConnectivityExtension: ConnectivityExt jar file not present
08-20 21:24:43.986  2235  2253 E BatteryStatsService: power: Missing API
08-20 21:24:43.989  2235  2253 E BatteryStatsService: no controller energy info supplied
08-20 21:24:43.989  2235  2253 E BatteryStatsService: no controller energy info supplied
08-20 21:24:44.260  2235  2253 E BatteryStatsService: modem info is invalid: ModemActivityInfo{ mTimestamp=0 mSleepTimeMs=0 mIdleTimeMs=0 mTxTimeMs[]=[0, 0, 0, 0, 0] mRxTimeMs=0 mEnergyUsed=0}
08-20 21:24:44.500  2235  2235 W art     : Long monitor contention with owner Binder:2235_E (20037) at void com.android.server.power.PowerManagerService.acquireWakeLockInternal(android.os.IBinder, int, java.lang.String, java.lang.String, android.os.WorkSource, java.lang.String, int, int)(PowerManagerService.java:1001) waiters=1 in boolean com.android.server.power.PowerManagerService.isInteractiveInternal() for 233ms
08-20 21:24:44.505  2235  2260 W art     : Long monitor contention with owner Binder:2235_E (20037) at void com.android.server.power.PowerManagerService.acquireWakeLockInternal(android.os.IBinder, int, java.lang.String, java.lang.String, android.os.WorkSource, java.lang.String, int, int)(PowerManagerService.java:1001) waiters=0 in void com.android.server.power.PowerManagerService.handleSandman() for 238ms
08-20 21:24:49.154  2235  2328 W ConnectivityExtension: ConnectivityExt jar file not present
08-20 21:24:49.981  2235  2328 W ConnectivityExtension: ConnectivityExt jar file not present
08-20 21:24:54.833  2235  2584 I ActivityManager: Setting hasTopUi=true for pid=2394
08-20 21:24:54.836  2394  2394 D PhoneStatusBar: disable: < expand ICONS* alerts SYSTEM_INFO* back home recent clock search quick_settings >
08-20 21:24:56.195  2235  2328 W ConnectivityExtension: ConnectivityExt jar file not present
08-20 21:24:56.894  2235  2328 W ConnectivityExtension: ConnectivityExt jar file not present
08-20 21:24:57.047  2235  2245 I art     : Background sticky concurrent mark sweep GC freed 69285(5MB) AllocSpace objects, 5(116KB) LOS objects, 26% free, 16MB/22MB, paused 3.203ms total 135.176ms
08-20 21:24:57.873  2235  2328 W ConnectivityExtension: ConnectivityExt jar file not present
08-20 21:25:08.906  2235  2845 I DisplayManagerService: Display device removed: DisplayDeviceInfo{"hidden:screen-recording": uniqueId="virtual:org.lineageos.recorder,10023,hidden:screen-recording,0", 1080 x 1920, modeId 2, defaultModeId 2, supportedModes [{id=2, width=1080, height=1920, fps=60.0}], colorMode 0, supportedColorModes [0], HdrCapabilities null, density 1, 1.0 x 1.0 dpi, appVsyncOff 0, presDeadline 16666666, touch NONE, rotation 0, type VIRTUAL, state ON, owner org.lineageos.recorder (uid 10023), FLAG_SECURE}
08-20 21:25:08.960 10567 10567 I ScreencastService: Video complete: /storage/emulated/0/Movies/ScreenRecords/ScreenRecord-2021-08-20-21-22-38.mp4
08-20 21:25:09.034 10567 10954 D MPEG4Writer: Video track stopping
08-20 21:25:09.034 10567 10954 D MPEG4Writer: Video track source stopping
08-20 21:25:09.034 10567 10954 D MPEG4Writer: Video track source stopped
08-20 21:25:09.038 10567 10959 I MPEG4Writer: Received total/0-length (5236/2) buffers and encoded 5236 frames. - Video
08-20 21:25:09.040 10567 10954 D MPEG4Writer: Video track stopped
08-20 21:25:09.040 10567 10954 D MPEG4Writer: Stopping writer thread
08-20 21:25:09.044 10567 10958 D MPEG4Writer: 0 chunks are written in the last batch
08-20 21:25:09.045 10567 10954 D MPEG4Writer: Writer thread stopped
08-20 21:25:09.053 10567 10954 I MPEG4Writer: The mp4 file will not be streamable.
08-20 21:25:09.114  1747  2561 W GraphicBufferSource: Dropped back down to Loaded without Executing
08-20 21:25:09.280  1747  2562 I OMX-VENC: Component Deinit
08-20 21:25:09.333  1746  2435 I FFmpegExtractor: android-source:0xb47b4000
08-20 21:25:09.364  1746  2435 D FFmpegExtractor: supported codec (h264) by official Stagefright
08-20 21:25:09.364  1746  2435 D FFmpegExtractor: ffmpeg detected media content as 'video/mp4' with confidence 0.08
08-20 21:25:12.312  2394  2394 W StatusBar: removeNotification for unknown key: 0|org.lineageos.recorder|61|null|10023
08-20 21:25:12.834  2235  2606 W InputMethodManagerService: Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@9ccb402 attribute=null, token = android.os.BinderProxy@75b4a44
08-20 21:25:12.845  2235  2247 I ActivityManager: Setting hasTopUi=false for pid=2394
08-20 21:25:12.851  2394  2394 D PhoneStatusBar: disable: < expand icons* alerts system_info* back home recent clock search quick_settings >
08-20 21:25:14.016  2394  2394 I SlideTouchEvent: vel=0.0, MinimumFlingVelocity=150
08-20 21:25:14.429  2394  2394 I SlideTouchEvent: vel=679.0385, MinimumFlingVelocity=150
08-20 21:25:14.429  2394  2394 I SlideTouchEvent: Sliding distance is too short, can not trigger the single hand mode
08-20 21:25:14.461  2235  3165 I ActivityManager: START u0 {flg=0x10804000 cmp=com.android.systemui/.recents.RecentsActivity} from uid 10037 on display 0
08-20 21:25:14.633  2235  2250 W art     : Long monitor contention with owner Binder:2235_D (3165) at int com.android.server.am.ActivityStarter.startActivityMayWait(android.app.IApplicationThread, int, int, int, java.lang.String, android.content.Intent, java.lang.String, android.service.voice.IVoiceInteractionSession, com.android.internal.app.IVoiceInteractor, android.os.IBinder, java.lang.String, int, int, android.app.ProfilerInfo, android.app.IActivityManager$WaitResult, android.content.res.Configuration, android.os.Bundle, boolean, int, android.app.IActivityContainer, com.android.server.am.TaskRecord)(ActivityStarter.java:804) waiters=0 in void com.android.server.am.ActivityManagerService$MainHandler.handleMessage(android.os.Message) for 115ms
08-20 21:25:14.848  2235  2245 I art     : Background partial concurrent mark sweep GC freed 87641(5MB) AllocSpace objects, 3(60KB) LOS objects, 33% free, 15MB/22MB, paused 2.769ms total 311.735ms
08-20 21:25:14.943  2394  2407 I art     : Background partial concurrent mark sweep GC freed 221876(12MB) AllocSpace objects, 3(132KB) LOS objects, 39% free, 23MB/38MB, paused 14.582ms total 347.390ms
08-20 21:25:15.219  3111 11865 W Adreno-EGL: : EGL_BAD_ATTRIBUTE
08-20 21:25:15.220  3111 11704 I MediaCodec: [OMX.google.vp9.decoder] setting surface generation to 3185722
08-20 21:25:15.368  2235  2247 W AppOps  : Finishing op nesting under-run: uid 10076 pkg org.schabi.newpipe code 40 time=0 duration=0 nesting=0
08-20 21:25:15.482  1740  1880 W AudioFlinger::EffectModule: EffectModule 0xb5203780 destructor called with unreleased interface
08-20 21:25:15.482  1740  1740 W AudioFlinger::EffectHandle: disconnect Effect handle 0xb577d340 disconnected after thread destruction
08-20 21:25:15.556  3111  3123 I art     : Background sticky concurrent mark sweep GC freed 91381(6MB) AllocSpace objects, 34(2MB) LOS objects, 15% free, 41MB/48MB, paused 4.656ms total 114.688ms
08-20 21:25:15.571  3111 11701 D CacheFactory: initExoPlayerCache: cacheDir = /storage/emulated/0/Android/data/org.schabi.newpipe/cache/exoplayer
08-20 21:25:15.646  1747  2562 I MediaPlayerService: MediaPlayerService::getOMX
08-20 21:25:15.651  3111 11870 I OMXClient: MuxOMX ctor
08-20 21:25:15.660  1744  2449 I OMXMaster: makeComponentInstance(OMX.google.aac.decoder) in mediacodec process
08-20 21:25:15.666  1744  1822 E OMXNodeInstance: setConfig(6d00087:google.aac.decoder, ConfigPriority(0x6f800002)) ERROR: Undefined(0x80001001)
08-20 21:25:15.667  3111 11870 I ACodec  : codec does not support config priority (err -2147483648)
08-20 21:25:15.709  1744 11871 I SoftAAC2: Reconfiguring decoder: 0->44100 Hz, 0->2 channels
08-20 21:25:15.734  3111 11701 D AudioTrack: Client defaulted notificationFrames to 3675 for frameCount 11025
08-20 21:25:15.802  3111  3111 W BottomSheetBehavior: BottomSheetBehavior now supports multiple callbacks. `setBottomSheetCallback()` removes all existing callbacks, including ones set internally by library authors, which may result in unintended behavior. This may change in the future. Please use `addBottomSheetCallback()` and `removeBottomSheetCallback()` instead to set your own callbacks.
08-20 21:25:15.832  2235  2606 W AppOps  : Finishing op nesting under-run: uid 10076 pkg org.schabi.newpipe code 40 time=0 duration=0 nesting=0
08-20 21:25:15.838  3111  3111 I ExoPlayerImpl: Release 2f0b2f1 [ExoPlayerLib/2.12.3] [hammerhead, Nexus 5, LGE, 25] [goog.exo.core, goog.exo.mediasession]
08-20 21:25:15.850  2235  2847 I MediaFocusControl:  AudioFocus  abandonAudioFocus() from uid/pid 10076/3111 clientId=android.media.AudioManager@caee8acorg.schabi.newpipe.player.helper.AudioReactor@18689b8
08-20 21:25:15.864  3111  3111 I art     : System.exit called, status: 0
08-20 21:25:15.865  3111  3111 I AndroidRuntime: VM exiting with result code 0, cleanup skipped.
08-20 21:25:15.939  1740  1740 W AudioFlinger::EffectModule: EffectModule 0xb4d17a80 destructor called with unreleased interface
08-20 21:25:15.940  1740 32071 W AudioFlinger::EffectHandle: disconnect Effect handle 0xb577d740 disconnected after thread destruction
08-20 21:25:15.945  2235  3164 D GraphicsStats: Buffer count: 8
08-20 21:25:15.946  2235  3164 I ActivityManager: Process org.schabi.newpipe (pid 3111) has died
08-20 21:25:15.946  2235  3164 D ActivityManager: cleanUpApplicationRecord -- 3111
08-20 21:25:16.200  2235  3161 I ActivityManager: Killing 10567:org.lineageos.recorder/u0a23 (adj 1001): remove task

Device info

  • Android version/Custom ROM version: 7.1.2/LineageOS 14.1
  • Device model: Nexus 5
@ghost ghost added the bug Issue is related to a bug label Aug 21, 2021
@SameenAhnaf

This comment has been minimized.

@ghost
Copy link
Author

ghost commented Aug 21, 2021

No, and I don't use queue anyway.

In fact I got the buffering to occur after only two videos in the RC, whereas on 0.21.8 I had to watch 15-20 before it finally occured. That might have just been random chance though.

@aleksfadini
Copy link

Same thing happens for me.

@triallax triallax added the player Issues related to any player (main, popup and background) label Aug 22, 2021
@coder9
Copy link

coder9 commented Sep 14, 2021

The Kodi YouTube plug-in and youtube-dl seem to have a similar problem.

anxdpanic/plugin.video.youtube#163

ytdl-org/youtube-dl#29326

tl;dr: YT sends a .js file with some JavaScript for the browser to execute and passes a value to it. Browser must execute JavaScript which calculates the new value and returns it. If the value is wrong or not returned then the stream is eventually throttled to about 50KB/s. Some metadata is involved as you can clear the Kodi YouTube plug-in's data cache and play the same video again and that will make throttling go away for a while.

Proposed solutions in the linked issues are cancelling the download and restarting it, spoofing an Android device (devices which present themselves as Android don't seem to have this problem), creating a regex which picks out the values to be returned from JavaScript file (but that may be easily defeated by YouTube), or running a full JavaScript interpreter.

@opusforlife2 opusforlife2 pinned this issue Sep 17, 2021
@Flam3z
Copy link

Flam3z commented Sep 19, 2021

For me its very inconsistant, a 1 hour video could run fine then the next video i pick which could be around 20 minutes could slow to a halt.

@jacktheripper19
Copy link

I'm also experiencing the same issue on the latest version 0.21.11 with good connection. It's more frustrating because the majority of time, even clearing cache doesn't fix the issue.

@ghost
Copy link
Author

ghost commented Oct 12, 2021

Yeah, in recent times it's gotten a lot worse. Every time without fail, and half of the time clearing cache + restart app doesn't help.

On the plus side, I guess it's a lot easier to reproduce now, if ever needed.

@coder9
Copy link

coder9 commented Oct 13, 2021

Here is the pull request for the change which fixed (for now) the issue in yt-dlp (youtube-dl fork). They took the "spoofing an Android device" approach:

yt-dlp/yt-dlp#492

Click through to issue 319 at the bottom of the linked page about the age-gate bypass to see some more info about what parameters they pass to YT.

@ghost
Copy link
Author

ghost commented Oct 13, 2021

Would this apply to NewPipe (extractor) though? Given that it's already being ran from an Android device. Or does NewPipe spoof not being an Android device?

@coder9
Copy link

coder9 commented Oct 13, 2021

I guess NewPipe might be sending parameters in a slightly different way which means YT realises it's not the real YT Android client.

This is why it doesn't happen in Vanced, it's the real YT client with adverts stripped out.

@ghost
Copy link
Author

ghost commented Oct 17, 2021

An observation: switching video resolution to 480p, no issues, ever. 720p and above though, basically unwatchable.

I wonder if they might be doing something similar to Netflix, where 480p and lower are unrestricted, but HD resolutions require stricter authenticatiom checks?

@ghost
Copy link
Author

ghost commented Oct 17, 2021

I switched the default resolution in the settings, so videos always load at 480p directly. Reloading never fixes it for me unfortunately.

@A-Nicoladie
Copy link

A-Nicoladie commented Oct 20, 2021

Switching to Vanced for playback. NewPipe is completely unusable right now.
Lots of infinite buffering, stream background playback is absolutely a nightmare and usually ends with the playback crashing & the buffer being reloaded aka past 20secs over and over again.

I understand that this is an app developed by people in their free time without any or enough donations, but this not acceptable developement. This issue has been around for too long and if vanced can get around it, surely newpipe can too.

Hmmm... no, this development is perfectly acceptable 👍
We're talking about a bug that affect some people, indeed, but it's not a bug that affects everyone either (otherwise the repositories would be flooded with similar issues).
So it's quite conceivable that developers don't focus only on this problem. Especially since this problem is not systematic and not easily trackable.
If Vanced works, that's cool. That means that "maybe" there is a solution that "maybe" can be implemented in the future.
Let's give them time and wait patiently, or use another program in the meantime (if need), but let them do as they please. 😉

@ghost
Copy link
Author

ghost commented Oct 20, 2021

Nobody cares if you're switching from one free app to another. The world doesn't revolve around you.

Comparing Vanced to NewPipe is apples to oranges.

Either way, I'm updating the issue title, because I think the cached metadata thing may have been a red herring. Please refrain from posting comments unless you actually have something to contribute.

@ghost ghost changed the title Intermittent buffering, potentially related to cached metadata Intermittent, constant buffering Oct 20, 2021
@1reverseengineer

This comment has been minimized.

@Donkey-Doug
Copy link

Donkey-Doug commented Oct 21, 2021

We're talking about a bug that affect some people.

I have it too:

  • Sometimes it is impossible to play a video without the intermittent buffering. In that case, downloading (in an attempt to watch offline) also fails.
  • Sometimes only some resolutions play properly;
    • Everything but 720p and 720p @ 60
    • Only webp (1080p and 4k)
  • Sometimes the video will buffer the entire time (like the video above), sometimes buffering issues only start after a minute or two and sometimes the video will not start at all. In that case I am just looking at a black screen with a loading circle. Downloading also fails in that case.
  • Finally, playing only the audio always works fine. Even if playing and downloading fail, audio only mode always works flawlessly.

Xiaomi Mi 9T pro
Android 10 (lineageos without google)

@ghost
Copy link
Author

ghost commented Oct 21, 2021

Do you have problems with 480p or lower? I'm interested in seeing if this issue only affects HD and higher resolutions.

@Donkey-Doug
Copy link

Sometimes switching to a different res fixes it. See cases describes above. Usually non-720p or webp can solve the problem, but not always.

@minecraftchest1
Copy link

Are there any plans on switching to yt-dlp? I noticed it was mentioned earlier. I don't know about android, but on Linux desktop yt-dlp has a lot better speeds then yt-dl for the reasons mentioned above.

I have also noticed that switch between cellular and wifi fixes buffering for a minute or two.

@opusforlife2
Copy link
Collaborator

@minecraftchest1 Newpipe doesn't use youtube-dl. It uses the Newpipe Extractor, which has been written from scratch.

@dscottboggs
Copy link

dscottboggs commented Oct 26, 2021

We're talking about a bug that affect some people, indeed, but it's not a bug that affects everyone either (otherwise the repositories would be flooded with similar issues).
So it's quite conceivable that developers don't focus only on this problem. Especially since this problem is not systematic and not easily trackable.

I would like to chime in that I am also experiencing the issue. NewPipe is basically unusable for me for videos. I am also experiencing this issue in youtube-dl, and they showed up around the same time, so this may be IP-based.

YT sends a .js file with some JavaScript for the browser to execute and passes a value to it. Browser must execute JavaScript which calculates the new value and returns it. If the value is wrong or not returned then the stream is eventually throttled to about 50KB/s

This sounds to me like YouTube is specifically implementing a new system for suppressing traffic from 3rd-party services like NewPipe and youtube-dl. It seems to me prudent, therefore, to implement a fix which specifically targets their mechanism for implementing this check -- by executing the relevant javascript or parsing it and performing the intended operation just as a web-browser would.

I have some coding experience, and would like to help with this issue, but I'm not familiar with the internal workings of NewPipe, youtube-dl, or this javascript check which youtube has implemented. Could people familiar with the relevant moving parts provide comments here which would provide documentation to people with development experience who are users and not yet contributors to gain the background knowledge necessary to contribute? (looked into this and it's over my head, sorry)

@what-aboot
Copy link

I was having this issue (constant buffering) and thought it might be resolution based, so it was showing 720, so I tapped it, and selected 480, and the app crashed. It came up with a Guru Mediation, as below:
1 Phone is OnePlus 5T.
2 I was watching blind auditions voice worldwide
3 I never gave it on auto queue
4 I was selecting the next to watch by opening the channel of each, and seeing if there was sufficient material to warrant subscribing.
5 In other words there never was a playlist (maybe its buffering based on not finding a playlist?)

Exception

  • User Action: ui error
  • Request: ACRA report
  • Content Country: GB
  • Content Language: en-GB
  • App Language: en_GB
  • Service: none
  • Version: 0.21.13
  • OS: Linux Android 10 - 29
Crash log

java.lang.IllegalArgumentException: Play Queue has not been initialized.
	at org.schabi.newpipe.player.playback.MediaSourceManager.<init>(MediaSourceManager.java:141)
	at org.schabi.newpipe.player.playback.MediaSourceManager.<init>(MediaSourceManager.java:130)
	at org.schabi.newpipe.player.Player.reloadPlayQueueManager(Player.java:884)
	at org.schabi.newpipe.player.Player.onMenuItemClick(Player.java:3495)
	at android.widget.PopupMenu$1.onMenuItemSelected(PopupMenu.java:108)
	at com.android.internal.view.menu.MenuBuilder.dispatchMenuItemSelected(MenuBuilder.java:787)
	at com.android.internal.view.menu.MenuItemImpl.invoke(MenuItemImpl.java:151)
	at com.android.internal.view.menu.MenuBuilder.performItemAction(MenuBuilder.java:934)
	at com.android.internal.view.menu.MenuBuilder.performItemAction(MenuBuilder.java:924)
	at com.android.internal.view.menu.MenuPopup.onItemClick(MenuPopup.java:128)
	at android.widget.AdapterView.performItemClick(AdapterView.java:330)
	at android.widget.AbsListView.performItemClick(AbsListView.java:1257)
	at android.widget.AbsListView$PerformClick.run(AbsListView.java:3265)
	at android.os.Handler.handleCallback(Handler.java:883)
	at android.os.Handler.dispatchMessage(Handler.java:100)
	at android.os.Looper.loop(Looper.java:214)
	at android.app.ActivityThread.main(ActivityThread.java:7697)
	at java.lang.reflect.Method.invoke(Native Method)
	at com.android.internal.os.RuntimeInit$MethodAndArgsCaller.run(RuntimeInit.java:516)
	at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:950)


@coder9
Copy link

coder9 commented Oct 30, 2021

Solution for Kodi's YT Plugin seems to be the following:

  1. Implement non-standard HTTP chunk headers in client as described here.

ytdl-org/youtube-dl#29326 (comment)

  1. Implement 'n' calculator as described here (this is Python code, not Java):

anxdpanic/plugin.video.youtube#163 (comment)

anxdpanic/plugin.video.youtube#163 (comment)

@what-aboot

This comment has been minimized.

@opusforlife2
Copy link
Collaborator

@what-aboot That's a completely unrelated error. Please open a new issue for it, after checking for duplicates.

@AudricV
Copy link
Member

AudricV commented Nov 2, 2021

Could you please test the APK of #6537 which makes the app use the streaming URLs of the WEB YouTube client first (with the n param unthrottled (it is the case for these URLs since version 0.21.8 of the app) and with some other params of official clients too) and see if you have buffering issues with this APK? Thank you in advance.

Direct link of the APK: https://github.com/TeamNewPipe/NewPipe/suites/4224687319/artifacts/109290035

@igorcafe
Copy link

igorcafe commented May 4, 2022

I'm not sure if related, but I noticed that videos and audio load faster when downloading then watching.

If I try to download a 44min video, 720p, it will finish in a minute or two.
But if I try to watch it, even after waiting a minute, it will stop to buffer many times during the video, because the buffering speed seems to be slow.

It happens more frequently at high speeds like 2x, with fast-forward during silence enabled.

Is it the same issue?

@lf-
Copy link

lf- commented May 4, 2022

Possibly related: I downloaded a video or several and watched the download speed: there were periods of saturating the wireless connection and getting some 40MByte/s and every couple of seconds, there's massive throttling to less than 50KByte/s.

If it's not possible to fix the periodic throttling, can the allowed amount to buffer ahead of playback be increased instead? My connection can grab like half the video in a couple of seconds, as soon as the throttling is relaxed.

Also, as suggested, I messed with the playback interval size trying every value, restarting the app between, and it had no obvious effect. I think this lack of effect is in line with YouTube periodically throttling the heck out of the video load.

@igorcafe
Copy link

igorcafe commented May 4, 2022

If it's not possible to fix the periodic throttling, can the allowed amount to buffer ahead of playback be increased instead? My connection can grab like half the video in a couple of seconds, as soon as the throttling is relaxed.

That would be a good solution for my case.

@Gravity2106
Copy link

Gravity2106 commented May 4, 2022

Constant buffering doesn't matter the resolution or the configuration. Only audio works more or less okey, but videos are unwatchable

@devnoname120
Copy link
Contributor

I couldn't find this information but why doesn't NewPipe just use https://github.com/yt-dlp/yt-dlp instead of having their own https://github.com/TeamNewPipe/NewPipeExtractor implementation?

@PixelCode01
Copy link

PixelCode01 commented May 17, 2022

After testing old and new version I found out that buffering is present in new version if we increase speed there is more buffer and clearing cache also not work in new version

@vaibhavgupta20
Copy link

I have tried both version on Samsung one UI and they have the same problem.

This bug has opened long time back. Any recent updates?

@tutacat
Copy link

tutacat commented May 28, 2022

It seems something is causing the app to either (just download at a slow speed) or (use only a single thread for download)

Does the app use multiple threads while watching? Or only downloading?

It's possible that it may be faster using HTTP/2 and maybe google is throttling HTTP/1 as well, but it might need reworking? And possibly websockets?

@PixelCode01
Copy link

PixelCode01 commented May 28, 2022 via email

@AudricV
Copy link
Member

AudricV commented May 28, 2022

Yeah I also think same but why newpipe team is not taking the issue serious

No, we are, everything is explained in this Reddit post: https://www.reddit.com/r/NewPipe/comments/u5wf7m/about_youtube_buffering_issues/

It's possible that it may be faster using HTTP/2 and maybe google is throttling HTTP/1 as well, but it might need reworking? And possibly websockets?

That's not possible, unfortunately, see the post.

@nikhilCad
Copy link

For now just use apk in Checks tab of this PR #8153 its debug apk so its little slow but there is no buffering. Using it since last few weeks.

@zeref-dragneel
Copy link

The Firefox browser and UC browser have support to increase the cache size for faster viewing. NewPipe can refer to features and updates.
https://www.reddit.com/r/firefox/comments/i9kmdo/comment/g1fp3vv/?utm_source=share&utm_medium=web2x&context=3
https://www.reddit.com/r/firefox/comments/ukh2tv/does_firefox_browser_support_speeding_up_like_uc/

@vaibhavgupta20
Copy link

Yeah I also think same but why newpipe team is not taking the issue serious

No, we are, everything is explained in this Reddit post: https://www.reddit.com/r/NewPipe/comments/u5wf7m/about_youtube_buffering_issues/

This new version works in Samsung device. Thanks for your effort.

@degarb
Copy link

degarb commented Jun 25, 2022

I exclusively use NewPipe at 2.7 speed and the silence taken out at 240p to 480p, with closed captions to catch a few words that I might miss. 2x seems very, very slow to me anymore.

However recently, I find NewPipe is unusable because of buffering. I think after the latest upgrade. Even at 144p and a tiresome slow 2x or 1.75 x, it is constantly and consistently buffering, while youtu.be doesn't buffer at 2x and 720p.

It has to deliberate throttling by youtu.be to stop detected NewPipe users. I may have been easy to detect, due to the fast speed I use and the number of videos I can cram into an hour. .

I have been defaulting back to the Yt client, which works fine at 2x at all resolutions.

The previous version of new pipe, I noticed that only 360p worked. 480 and 240 constantly buffered. Maybe they patched the offers on the Yt server side.

I was thinking that they probably carried 144, 360, 720p60fps, 1080. But 240, 480, was being transcoded on the fly, which was causing the buffer at lower resolution.

240 and 480 are my favorite resolutions, because of the bitrate v. Clarity of the two. 4k might have a place on cad tutorials, where 1080 seems blurry.

@MarcelRobitaille
Copy link

@degarb I don't think they are detecting it with playback speed alone. I regularly watch at 3x or 4x speed on desktop (youtube.com and document.querySelector('video').playbackRate = 3) 720p with no buffering at all. I can't watch in NewPipe at 2x speed 360p (a playback speed supported by YouTube) without constant buffering.

@AudricV
Copy link
Member

AudricV commented Jun 25, 2022

Please try the release candidate, available in #8548. Does the issue is improved?

@Pipeuse
Copy link

Pipeuse commented Jun 27, 2022

Hi,

I always had delay and slow loading in the last few Newpipe versions (~4-6 months or so, and also in v0.23.0).
I often use the skip during silence feature. After some update I had problems with it, it was slower and didnt skip as fast, also watching the bandwith it uses it downloads at relatively slow (compared to before).
Even changing to lower resolution like 360p didn't help that much. Somehow it always seemed bandwith capped and slow and delayed.

So I just downloaded the debug release (Release v0.23.1 #8548) and installed the apk.

All the slow load/buffer/slow skip issues are fixed, everything works fine in the new debug version I installed. Thank you very much!
It's so fast and fresh, the skip during silence is very smooth (and you even see the video moving speeding fast forward smoothly during silence, which wasn't the case before, previously it just showed a loading circle, now I never see the loading circle.)

Comparing it to the last version, it's like double the speed now at least.

Thanks again and good work

@djuarezr
Copy link

Same here, everything works. No buffering at all at all these days using #8548. No issue either using as daily driver for more than a month the app at PR #8153.

@degarb

This comment was marked as spam.

@AudricV
Copy link
Member

AudricV commented Jun 29, 2022

@degarb Instead of complaining, why not using the debug APK of the release candidate of 0.23.1? According to the feedbacks we received and my intensive testing since more than a month of the change from progressive playback to DASH playback for YouTube contents, the issue should be solved.

@nikhilCad
Copy link

Isn't this fixed now?

@opusforlife2
Copy link
Collaborator

Indeed. Let's close this now. If the problem crops up again, it should be discussed in a new issue.

@opusforlife2 opusforlife2 unpinned this issue Jul 10, 2022
@Donkey-Doug
Copy link

This issue is back since 2 days now.

Version 0.23.2
Android 10 without google

@AudricV
Copy link
Member

AudricV commented Aug 19, 2022

@Donkey-Doug Is the content on which you got the issue age-restricted or did you use the 720p stream on a 720p60 or higher video? If so, that's related to the decryption failure of the throttling parameter.

Also remember that:

If the problem crops up again, it should be discussed in a new issue.

@Donkey-Doug
Copy link

Donkey-Doug commented Aug 20, 2022

Not age restricted and only occurs on 720p and 720p @ 60Hz

It only happens sometimes so I decided to wait before making an new issue until I know when it occurs.

@TeamNewPipe TeamNewPipe locked as resolved and limited conversation to collaborators Aug 20, 2022
Sign up for free to subscribe to this conversation on GitHub. Already have an account? Sign in.
Labels
bug Issue is related to a bug player Issues related to any player (main, popup and background) youtube Service, https://www.youtube.com/
Projects
None yet
Development

No branches or pull requests