Intermittent, constant buffering

ghost commented 3 years ago

Checklist

[x] I am using the latest version - 0.21.8
[x] I checked, but didn't find any duplicates (open OR closed) of this issue in the repo.
[x] I have read the contribution guidelines given at https://github.com/TeamNewPipe/NewPipe/blob/HEAD/.github/CONTRIBUTING.md.
[x] This issue contains only one bug. I will open one issue for every bug report I want to file.

Steps to reproduce the bug

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 https://github.com/TeamNewPipe/NewPipe/issues/5516#issuecomment-901382592. Simply enforcing the 25 second minimum probably wouldn't fix the underlying issue, though.

Screenshots/Screen recordings

https://user-images.githubusercontent.com/43770697/130306929-8e92318c-5629-47ca-99ef-df0826f8ccae.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

SameenAhnaf commented 3 years ago

@Ammako Does apk in #6841 solve the bug for you?

ghost commented 3 years ago

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 commented 3 years ago

Same thing happens for me.

coder9 commented 3 years ago

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

https://github.com/anxdpanic/plugin.video.youtube/issues/163

https://github.com/ytdl-org/youtube-dl/issues/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.

Flam3z commented 3 years ago

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 commented 2 years ago

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 commented 2 years ago

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 commented 2 years ago

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:

https://github.com/yt-dlp/yt-dlp/pull/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 commented 2 years ago

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 commented 2 years ago

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 commented 2 years ago

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 commented 2 years ago

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

A-Nicoladie commented 2 years ago

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 commented 2 years ago

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.

1reverseengineer commented 2 years ago

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.

Pompous arrogant sh- head. Go outside and touch some gras.

If you would actually have more than one neuron or axon up there, you'd have seen that I already differentiated pipe and vanced from each other, contributed by stating the issue + versioning + preview of gif but who cares if you can sound like the really cool kids these days right...

How arrogant can you be to then tell me to screw off unless I contribute. Go eat s-, I will delete all my comments except this one, because you are not even worth a single ounce of support.

Good luck finding someone to help you with new pipe and your issues above your shoulders, the latter being definitely the greater one...

Donkey-Doug commented 2 years ago

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 commented 2 years ago

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

Donkey-Doug commented 2 years ago

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 commented 2 years ago

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 commented 2 years ago

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

dscottboggs commented 2 years ago

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 commented 2 years ago

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 commented 2 years ago

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

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

https://github.com/ytdl-org/youtube-dl/issues/29326#issuecomment-938337251

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

https://github.com/anxdpanic/plugin.video.youtube/issues/163#issuecomment-894859991

https://github.com/anxdpanic/plugin.video.youtube/issues/163#issuecomment-939156545

what-aboot commented 2 years ago

Newpipe running on Firestick 4K, crash

uierror ACRA report version 0.21.10 OS version Linux NHG47K 7.1.2-25

"Failed to allocate a 4355412 byte allocation with 3617176 free bytes avail at dalvik.system.VMRuntime.newNonMovableArray(Native Method)

Have watched maybe 40 blind auditions, and subscribing to maybe 13 channels. I don't think it's releasing memory.

opusforlife2 commented 2 years ago

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

AudricV commented 2 years ago

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

ghost commented 2 years ago

I switched back to 720p and I can't seem to get the buffering to happen again right now, on 0.21.13, so I'm not sure if I would be able to tell a difference. I got a different phone nowadays, and it might be doing things differently in a way where this problem doesn't happen.

quickdude111 commented 2 years ago

I'm here to report I am also experiencing this issue. Ver. 0.21.13

opusforlife2 commented 2 years ago

I'm here to report I am also experiencing this issue. Ver. 0.21.13

@quickdude111 There is no point in that. You can help us more if you test the APK as asked two comments above yours.

quickdude111 commented 2 years ago

@opusforlife2 @TiA4f8R I have now tested this apk and it shows no change in the issue. it's as if i'm being throttled nonstop.

zeropi2021 commented 2 years ago

Hi,

A small observation on my part. This may not be a direct problem with buffering, but the slow movement between items / channels. Sometimes the effect is that it takes a few seconds for the channel to load.

This problem has been around for a very long time for at least several versions. Recently, I looked closely at it and the conclusions that came out of it...

The problem is due to the very strange behavior of the dns cache. If the device or server has an old cache for the domain www.youtube.com or no cache at all, NP lags. If I dig www.youtube.com earlier and repeat it every minute, then the dns cache is current and fresh and, surprisingly, NP does not lag. This looks like a strange problem with the short TTL for the domain and allocating the nearest CDN via dns.

For me, www.youtube.com points to: ;www.youtube.com. IN A

;; ANSWER SECTION: www.youtube.com. 21s IN CNAME youtube-ui.l.google.com. youtube-ui.l.google.com. 21s IN A 216.58.209.14 youtube-ui.l.google.com. 21s IN A 216.58.215.110 youtube-ui.l.google.com. 21s IN A 216.58.215.78 youtube-ui.l.google.com. 21s IN A 172.217.16.46 youtube-ui.l.google.com. 21s IN A 172.217.16.14 youtube-ui.l.google.com. 21s IN A 172.217.20.206 youtube-ui.l.google.com. 21s IN A 172.217.20.174 youtube-ui.l.google.com. 21s IN A 142.250.203.142 youtube-ui.l.google.com. 21s IN A 142.250.186.206 youtube-ui.l.google.com. 21s IN A 142.250.75.14 youtube-ui.l.google.com. 21s IN A 216.58.208.206 youtube-ui.l.google.com. 21s IN A 142.250.203.206

;youtube-ui.l.google.com. IN A

;; ANSWER SECTION: youtube-ui.l.google.com. 4m16s IN A 172.217.16.46 youtube-ui.l.google.com. 4m16s IN A 172.217.16.14 youtube-ui.l.google.com. 4m16s IN A 172.217.20.206 youtube-ui.l.google.com. 4m16s IN A 172.217.20.174 youtube-ui.l.google.com. 4m16s IN A 142.250.203.142 youtube-ui.l.google.com. 4m16s IN A 142.250.186.206 youtube-ui.l.google.com. 4m16s IN A 142.250.75.14 youtube-ui.l.google.com. 4m16s IN A 216.58.208.206 youtube-ui.l.google.com. 4m16s IN A 142.250.203.206 youtube-ui.l.google.com. 4m16s IN A 216.58.209.14 youtube-ui.l.google.com. 4m16s IN A 216.58.215.110 youtube-ui.l.google.com. 4m16s IN A 216.58.215.78

I also made sure that youtube-ui.l.google.com is not blocked anywhere. If someone uses pihole or their own dns, they should note that the first query for the domain is executed and cached, but the client does not receive it anyway and only the second query proceeds normally. You can also see that the cache for www.youtube.com is very short.

Setting dig www.youtube.com in the background to run every minute solves the lag problem... as long as the OS or dns server has a fresh cache for the domain all the time.

Can someone check if similar behavior is taking place? If you do not have a dns server then perform domain polling directly on the NP device. In my case, such continuous querying of the domain brought a surprising improvement in the operation of NP.

Perhaps devs could implement a small piece of NP code that will notoriously poll dns servers every minute for www.youtube.com?

A separate issue is the behavior of google / youtube.com on the desktop and firefox... When I go to the website, FF tries to make UDP 443 connections to IP addresses that dns returns for youtube-ui.l.google.com regardless of the system dns 53. It looks that google generated additional connections using its JS script to its infrastructure omitting the normal dns...

I speculate that this may also affect NP.

:/

AudricV commented 2 years ago

@zeropi2021 This is not related to this issue because here we are talking about video and audio streaming which is served with playback hosts from googlevideo.com servers (like r5--sn--4g5edndz.googlevideo.com).

However, the player data is fetched indeed from www.youtube.com, and also from youtubei.googleapis.com.

zeropi2021 commented 2 years ago

This is not related to this issue because here we are talking about video and audio streaming which is served with playback hosts from googlevideo.com servers (like r5--sn--4g5edndz.googlevideo.com).

However, the player data is fetched indeed from www.youtube.com, and also from youtubei.googleapis.com.

@TiA4f8R

As I mentioned before... So I thought it had nothing to do with video buffering. But I thought that I would share my five cents, maybe it will be useful to someone as a tip or not... I remember once people complained not only about video buffering but also NP responsiveness but maybe newer versions improved it for others. :)

Yes, the video stream is pulled from these other domains, but they also have a short TTL. Are you saying there's absolutely no correlation there? There is no logic, yes, I do not see how it would affect video buffering. But I have evidently seen an improvement in overall NP responsiveness, although it has no effect on video buffering, of course. Although personally on 0.21.13 I am not experiencing the buffering that was previously on older versions. Although I feel sorry for those who still have this problem! :(

If my posts are totally offtopic then move them elsewhere if necessary. :)

litetex commented 2 years ago

The problem in the issue description also happens from time to time on my device, however only when I start watching a video. Usually skipping the first 10s solves the problem 😄

@zeropi2021

The problem is due to the very strange behavior of the dns cache. If the device or server has an old cache for the domain www.youtube.com or no cache at all, NP lags.

Please open a new issue.

zeropi2021 commented 2 years ago

Please open a new issue.

@litetex

I am not sure if it makes sense... Maybe I am the only one who had this problem and at the moment I am dealing with this problem with the MacGyver method so it does not make sense to do spam if others do not mention this problem at the moment. :)

dagfinnr1 commented 2 years ago

*report below from trying to watch video at 360p as normal streaming within app.

I have been having this issue at least once or twice daily for a while now. I doubt this will be helpful but it seems like it is video specific throttling of certain videos. For instance earlier today I tried downloading audio opus 50 of a specific video and my download speeds were ridiculously slow. Like 15-50 Kb/s. I Tried queuing up concurrently a couple other opus 50 audio downloads I had in the que and they proceeded to download at normal speeds while the first one just trudged along like a snail. I paused it, tried resumeing again same. I tried canceling it and starting over and the same story. Tried watching the video via streaming the normal way and constant buffering. Try watching it at different resolutions (normal is 360p for me) same buffering issues. Tryed watching different video it works as normal. Decided I would watch it later in the day. 8 hours later try watching it via streaming same buffering issues for that video. Try downloading the opus 50 again same turtles pace. Try background streaming same non stop pauses in audio. Watch a different video or download a different audio opus 50 it works perfectly. Will try to pay attention from now on if creator specific

Exception

User Action: requested stream
Request: https://www.youtube.com/watch?v=3nBFrXYAceA
Content Country: US
Content Language: en
App Language: en_CA
Service: YouTube
Version: 0.21.13
OS: Linux Android 10 - 29
Exceptions (2)

Crash log 1

org.schabi.newpipe.extractor.exceptions.ParsingException: Could not get like count
    at org.schabi.newpipe.extractor.services.youtube.extractors.YoutubeStreamExtractor.getLikeCount(YoutubeStreamExtractor.java:359)
    at org.schabi.newpipe.extractor.stream.StreamInfo.extractOptionalData(StreamInfo.java:281)
    at org.schabi.newpipe.extractor.stream.StreamInfo.getInfo(StreamInfo.java:73)
    at org.schabi.newpipe.extractor.stream.StreamInfo.getInfo(StreamInfo.java:64)
    at org.schabi.newpipe.util.ExtractorHelper.lambda$getStreamInfo$3(ExtractorHelper.java:116)
    at org.schabi.newpipe.util.ExtractorHelper.$r8$lambda$YTHJjScxCJNO1LTCqs3IKy35iyY(Unknown Source:0)
    at org.schabi.newpipe.util.ExtractorHelper$$ExternalSyntheticLambda6.call(Unknown Source:4)
    at io.reactivex.rxjava3.internal.operators.single.SingleFromCallable.subscribeActual(SingleFromCallable.java:43)
    at io.reactivex.rxjava3.core.Single.subscribe(Single.java:4813)
    at io.reactivex.rxjava3.internal.operators.single.SingleDoOnSuccess.subscribeActual(SingleDoOnSuccess.java:35)
    at io.reactivex.rxjava3.core.Single.subscribe(Single.java:4813)
    at io.reactivex.rxjava3.internal.operators.maybe.MaybeFromSingle.subscribeActual(MaybeFromSingle.java:41)
    at io.reactivex.rxjava3.core.Maybe.subscribe(Maybe.java:5330)
    at io.reactivex.rxjava3.internal.operators.maybe.MaybeConcatArray$ConcatMaybeObserver.drain(MaybeConcatArray.java:153)
    at io.reactivex.rxjava3.internal.operators.maybe.MaybeConcatArray$ConcatMaybeObserver.request(MaybeConcatArray.java:78)
    at io.reactivex.rxjava3.internal.operators.flowable.FlowableElementAtMaybe$ElementAtSubscriber.onSubscribe(FlowableElementAtMaybe.java:66)
    at io.reactivex.rxjava3.internal.operators.maybe.MaybeConcatArray.subscribeActual(MaybeConcatArray.java:42)
    at io.reactivex.rxjava3.core.Flowable.subscribe(Flowable.java:15753)
    at io.reactivex.rxjava3.internal.operators.flowable.FlowableElementAtMaybe.subscribeActual(FlowableElementAtMaybe.java:36)
    at io.reactivex.rxjava3.core.Maybe.subscribe(Maybe.java:5330)
    at io.reactivex.rxjava3.internal.operators.maybe.MaybeToSingle.subscribeActual(MaybeToSingle.java:46)
    at io.reactivex.rxjava3.core.Single.subscribe(Single.java:4813)
    at io.reactivex.rxjava3.internal.operators.single.SingleSubscribeOn$SubscribeOnObserver.run(SingleSubscribeOn.java:89)
    at io.reactivex.rxjava3.core.Scheduler$DisposeTask.run(Scheduler.java:614)
    at io.reactivex.rxjava3.internal.schedulers.ScheduledRunnable.run(ScheduledRunnable.java:65)
    at io.reactivex.rxjava3.internal.schedulers.ScheduledRunnable.call(ScheduledRunnable.java:56)
    at java.util.concurrent.FutureTask.run(FutureTask.java:266)
    at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:301)
    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)
Caused by: org.schabi.newpipe.extractor.exceptions.ParsingException: Ratings are enabled even though the like button is missing
    at org.schabi.newpipe.extractor.services.youtube.extractors.YoutubeStreamExtractor.getLikeCount(YoutubeStreamExtractor.java:348)
    ... 30 more
Caused by: java.lang.NullPointerException: Attempt to invoke virtual method 'java.lang.String[] java.lang.String.split(java.lang.String)' on a null object reference
    at org.schabi.newpipe.extractor.services.youtube.extractors.YoutubeStreamExtractor.getLikeCount(YoutubeStreamExtractor.java:344)
    ... 30 more

Crash log 2

``` org.schabi.newpipe.extractor.exceptions.ParsingException: Could not get dislike count at org.schabi.newpipe.extractor.services.youtube.extractors.YoutubeStreamExtractor.getDislikeCount(YoutubeStreamExtractor.java:388) at org.schabi.newpipe.extractor.stream.StreamInfo.extractOptionalData(StreamInfo.java:286) at org.schabi.newpipe.extractor.stream.StreamInfo.getInfo(StreamInfo.java:73) at org.schabi.newpipe.extractor.stream.StreamInfo.getInfo(StreamInfo.java:64) at org.schabi.newpipe.util.ExtractorHelper.lambda$getStreamInfo$3(ExtractorHelper.java:116) at org.schabi.newpipe.util.ExtractorHelper.$r8$lambda$YTHJjScxCJNO1LTCqs3IKy35iyY(Unknown Source:0) at org.schabi.newpipe.util.ExtractorHelper$$ExternalSyntheticLambda6.call(Unknown Source:4) at io.reactivex.rxjava3.internal.operators.single.SingleFromCallable.subscribeActual(SingleFromCallable.java:43) at io.reactivex.rxjava3.core.Single.subscribe(Single.java:4813) at io.reactivex.rxjava3.internal.operators.single.SingleDoOnSuccess.subscribeActual(SingleDoOnSuccess.java:35) at io.reactivex.rxjava3.core.Single.subscribe(Single.java:4813) at io.reactivex.rxjava3.internal.operators.maybe.MaybeFromSingle.subscribeActual(MaybeFromSingle.java:41) at io.reactivex.rxjava3.core.Maybe.subscribe(Maybe.java:5330) at io.reactivex.rxjava3.internal.operators.maybe.MaybeConcatArray$ConcatMaybeObserver.drain(MaybeConcatArray.java:153) at io.reactivex.rxjava3.internal.operators.maybe.MaybeConcatArray$ConcatMaybeObserver.request(MaybeConcatArray.java:78) at io.reactivex.rxjava3.internal.operators.flowable.FlowableElementAtMaybe$ElementAtSubscriber.onSubscribe(FlowableElementAtMaybe.java:66) at io.reactivex.rxjava3.internal.operators.maybe.MaybeConcatArray.subscribeActual(MaybeConcatArray.java:42) at io.reactivex.rxjava3.core.Flowable.subscribe(Flowable.java:15753) at io.reactivex.rxjava3.internal.operators.flowable.FlowableElementAtMaybe.subscribeActual(FlowableElementAtMaybe.java:36) at io.reactivex.rxjava3.core.Maybe.subscribe(Maybe.java:5330) at io.reactivex.rxjava3.internal.operators.maybe.MaybeToSingle.subscribeActual(MaybeToSingle.java:46) at io.reactivex.rxjava3.core.Single.subscribe(Single.java:4813) at io.reactivex.rxjava3.internal.operators.single.SingleSubscribeOn$SubscribeOnObserver.run(SingleSubscribeOn.java:89) at io.reactivex.rxjava3.core.Scheduler$DisposeTask.run(Scheduler.java:614) at io.reactivex.rxjava3.internal.schedulers.ScheduledRunnable.run(ScheduledRunnable.java:65) at io.reactivex.rxjava3.internal.schedulers.ScheduledRunnable.call(ScheduledRunnable.java:56) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:301) 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) Caused by: org.schabi.newpipe.extractor.exceptions.ParsingException: Ratings are enabled even though the dislike button is missing at org.schabi.newpipe.extractor.services.youtube.extractors.YoutubeStreamExtractor.getDislikeCount(YoutubeStreamExtractor.java:377) ... 30 more Caused by: java.lang.NullPointerException: Attempt to invoke virtual method 'java.lang.String[] java.lang.String.split(java.lang.String)' on a null object reference at org.schabi.newpipe.extractor.services.youtube.extractors.YoutubeStreamExtractor.getDislikeCount(YoutubeStreamExtractor.java:373) ... 30 more ```

what-aboot commented 2 years ago

I see both those exceptions are metadata ( like/dislike count ), and in opening that requested link I see YT has it "disabled". Perhaps only except on being unable to get the strea Screenshot_20211125-073539 m, with all others ignored if inaccessible after a brief timeout?

My eagerness is to watch content, not see like / dislike counters. To realise that all that f@rt1ng about was because it couldn't access a counter would be laughable if it wasn't so tragic.

litetex commented 2 years ago

@what-aboot @dagfinnr1 → https://github.com/TeamNewPipe/NewPipe/issues/7405

azat11 commented 2 years ago

APK of #6537 is 5-10 times slower for me. 0.21.13 is currently refusing to load 1080p60 videos, although I have a speed on download with it of about 1-2mbytes/s. Also, constantly flashing "something went wrong", although idk if it is related.

azat11 commented 2 years ago

After installing VancedYT and VancedMicroG NewPipe actually started buffering faster. Idk if it's a coincidence.

foldfree commented 2 years ago

After installing VancedYT and VancedMicroG NewPipe actually started buffering faster. Idk if it's a coincidence.

Installing vancedMicroG alone worked for me. Thank you for the tip. https://github.com/YTVanced/VancedMicroG

zeropi2021 commented 2 years ago

After installing VancedYT and VancedMicroG NewPipe actually started buffering faster. Idk if it's a coincidence.

Installing vancedMicroG alone worked for me. Thank you for the tip. https://github.com/YTVanced/VancedMicroG

And what exactly does MicroG have to do with the newpipe?

litetex commented 2 years ago

As far as I know NewPipe is a completely standalone application - so nothing else (besides Android) should be required to run it. So it's likely a coincidence.

Resetting cached metadata (under "History and cache>wipe cached metadata" might help.

coder9 commented 2 years ago

Perhaps there is something that VancedYT and VancedMicroG are doing that convinces the YT server that it's talking to the official YT app, so the server doesn't throttle the client's IP?

zeropi2021 commented 2 years ago

Perhaps there is something that VancedYT and VancedMicroG are doing that convinces the YT server that it's talking to the official YT app, so the server doesn't throttle the client's IP?

I have big doubts whether youtube performs this type of analysis per IP and not a per cative tcp session... If they were doing something per IP, such behavior on a lot of GSM and VPN operators and any NAT where you have a lot of people per IP would be quickly noticed.

Besides, I don't use "VancedYT and VancedMicroG" and in my case the newpipe doesn't show buffering for a long time. I would say that with version 0.21.13 the problem stopped / decreased. I do not see buffering at the moment also in 0.21.14 RC2

The only thing I notice sometimes is the allocation of a distant CDN (1e100.net) to the source and the fact that there are CDNs much closer. Teretically this could cause buffering at times.

wifislow commented 2 years ago

dirkf fixed this issue for youtube-dl (written in python) here, this might work for NewPipe when converted to Java. Fix: https://raw.githubusercontent.com/ytdl-org/youtube-dl/d69983a8756fa75e16606bcd1b2ba50ec115ed16/youtube_dl/extractor/youtube.py Context: https://github.com/ytdl-org/youtube-dl/issues/29326#issuecomment-977026306 PR: https://github.com/ytdl-org/youtube-dl/pull/30184

azat11 commented 2 years ago

The issue returned for me, again constant buffering. Idk what is the reason, but the app is unusable this way. And I quite like it. Maybe I can help sharing some logs or smth? I really want it to work, and I don't know nearly enough to understand what is the reason this happens. I would think there would be a way to force the app to buffer more, or to make a setting for minimal buffering time, or smth..but these things are probably outside of the app's control, I'm guessing YT servers responsible for these things. Anyhow, hope this gets resolved. Again. And that I can return to using NewPipe.

ghost commented 2 years ago

The issue returned for me, again constant buffering. Idk what is the reason, but the app is unusable this way. And I quite like it. Maybe I can help sharing some logs or smth? I really want it to work, and I don't know nearly enough to understand what is the reason this happens. I would think there would be a way to force the app to buffer more, or to make a setting for minimal buffering time, or smth..but these things are probably outside of the app's control, I'm guessing YT servers responsible for these things. Anyhow, hope this gets resolved. Again. And that I can return to using NewPipe.

Yeah...some videos load very slowly despite having a connection speed of 15MB/s. IMHO...buffering cache need to be resized. Maybe now it's too conservative.

vehosah commented 2 years ago

The Buffering problem is still not fixed with the new version :(

vehosah commented 2 years ago

As far as I know NewPipe is a completely standalone application - so nothing else (besides Android) should be required to run it. So it's likely a coincidence.

Resetting cached metadata (under "History and cache>wipe cached metadata" might help.

It didn't fix anything for me

TeamNewPipe / NewPipe