nova-video-player / aos-AVP

NOVA opeN sOurce Video plAyer: main repository to build them all
Apache License 2.0
3.47k stars 201 forks source link

[Bug]: Scraping does not work on latest build (v6.0.39) #553

Closed bronnel closed 2 years ago

bronnel commented 2 years ago

Problem description

Media scraping is not working in the latest builds AutoScrapeService is not launching

Steps to reproduce the issue

just launching the app and waiting for videos to be added , nothing will be added to the library

Expected behavior

No response

Your phone/tablet/androidTV model

LG V50

Operating system version

Android 10

Application version and app store

v6.0.39

Additional system information

this is an ongoing issue since v6.0.37

Debug logs

D/com.archos.mediascraper.AutoScrapeService: [Binder:25995_2] DEBUG c.a.mediascraper.AutoScrapeService - registerObserver: onChange getting 0 videos not yet scraped -> not launching service!

courville commented 2 years ago

AutoScrapeService is not launched in your case because it does not find any video on your device after initial VideoStoreImportService. It should be "auto" relaunched if a video is detected. Can you check if there is no video to be scraped (if this is not the case this is a bug)?

bronnel commented 2 years ago

@courville v6.0.36 Google play internal (non public) release have no issue finding and scraping all the videos on my device , from v6.0.36 onward cannot detect videos, I can confirm this is a bug

courville commented 2 years ago

Interesting. Main difference between 6.0.36 and 6.0.39 is the fact that we now target API31. In which directory do you store your videos? When you browse the internal storage in folder mode, do you see the video files? Can you please check that you see your video files doing: adb shell content query --uri "content://media/external/video/media" --projection _data This checks if the media files are inside the Android media library (it should). Note that I do not reproduce the problem for some reasons on my pixel phone.

bronnel commented 2 years ago

@courville , that command found all of the mp4 videos and movies on the device

output example

Row: 286 _data=/storage/emulated/0/DCIM/Camera/20220117_082558.mp4
Row: 287 _data=/storage/emulated/0/DCIM/Camera/20220117_093123.mp4
Row: 288 _data=/storage/emulated/0/DCIM/Camera/20220117_093136.mp4
Row: 289 _data=/storage/emulated/0/DCIM/Camera/20220117_093434.mp4

I also had another device (LG V30) running android 9 , and it is the same behaviour

it is an endless searching for videos loop

any log or debug you need I will provide it here

courville commented 2 years ago

OK thanks. Camera videos are blacklisted on nova but I trust that you got your more entertainment videos listed too. I am puzzled by the no videos scraped. Are you running your custom builds? I guess so since it is 6.0.39 ;-) Would you mind testing this build too to see if it is the same result: https://drive.google.com/file/d/1i6axywhEjEHMr5jkPpjWZwbw5lLyg7ux/view?usp=sharing

bronnel commented 2 years ago

@courville , off course I have the lovely movies and tv shows in dedicated folders

Row: 15 _data=/storage/emulated/0/Movies/inception.mp4
Row: 16 _data=/storage/emulated/0/Movies/taken 2009.mp4
Row: 17 _data=/storage/emulated/0/Movies/taken 2.mp4
Row: 18 _data=/storage/emulated/0/Movies/the call of the wild.mp4
Row: 20 _data=/storage/emulated/0/TV Shows/arrow/s04/arrow.s4.e1.mp4
Row: 21 _data=/storage/emulated/0/TV Shows/arrow/s04/arrow.s4.e2.mp4
Row: 22 _data=/storage/emulated/0/TV Shows/arrow/s04/arrow.s4.e3.mp4
Row: 23 _data=/storage/emulated/0/TV Shows/arrow/s04/arrow.s4.e4.mp4
Row: 220 _data=/storage/emulated/0/TV Shows/fringe/s04/fringe.s4.e1.mp4
Row: 221 _data=/storage/emulated/0/TV Shows/suits/s04/suits.s4.e1.mp4
Row: 222 _data=/storage/emulated/0/TV Shows/chernobyl/s01/chernobyl.s1.e1.mp4
Row: 225 _data=/storage/emulated/0/TV Shows/attack on titan/s01/attack on titan.s1.e1.mp4
Row: 228 _data=/storage/emulated/0/Movies/wolf creek.mp4
Row: 229 _data=/storage/emulated/0/Movies/wolf creek 2.mp4

Yes I'm running custom builds that I build myself

I tested that build it has the same behavior

bronnel commented 2 years ago

@courville when I say custom build, I mean I just build it myself, but I have not done any modifications yet.

BTW during the build process I get the following error, are you also getting this error? could this be the cause?

Exception in thread "main" java.lang.NoClassDefFoundError: javax/xml/bind/annotation/XmlSchema
    at com.android.repository.api.SchemaModule$SchemaModuleVersion.<init>(SchemaModule.java:156)
    at com.android.repository.api.SchemaModule.<init>(SchemaModule.java:75)
    at com.android.sdklib.repository.AndroidSdkHandler.<clinit>(AndroidSdkHandler.java:81)
    at com.android.sdklib.tool.sdkmanager.SdkManagerCli.main(SdkManagerCli.java:73)
    at com.android.sdklib.tool.sdkmanager.SdkManagerCli.main(SdkManagerCli.java:48)
Caused by: java.lang.ClassNotFoundException: javax.xml.bind.annotation.XmlSchema
    at java.base/jdk.internal.loader.BuiltinClassLoader.loadClass(BuiltinClassLoader.java:641)
    at java.base/jdk.internal.loader.ClassLoaders$AppClassLoader.loadClass(ClassLoaders.java:188)
    at java.base/java.lang.ClassLoader.loadClass(ClassLoader.java:520)
    ... 5 more
Exception in thread "main" java.lang.NoClassDefFoundError: javax/xml/bind/annotation/XmlSchema
    at com.android.repository.api.SchemaModule$SchemaModuleVersion.<init>(SchemaModule.java:156)
    at com.android.repository.api.SchemaModule.<init>(SchemaModule.java:75)
    at com.android.sdklib.repository.AndroidSdkHandler.<clinit>(AndroidSdkHandler.java:81)
    at com.android.sdklib.tool.sdkmanager.SdkManagerCli.main(SdkManagerCli.java:73)
    at com.android.sdklib.tool.sdkmanager.SdkManagerCli.main(SdkManagerCli.java:48)
Caused by: java.lang.ClassNotFoundException: javax.xml.bind.annotation.XmlSchema
    at java.base/jdk.internal.loader.BuiltinClassLoader.loadClass(BuiltinClassLoader.java:641)
    at java.base/jdk.internal.loader.ClassLoaders$AppClassLoader.loadClass(ClassLoaders.java:188)
    at java.base/java.lang.ClassLoader.loadClass(ClassLoader.java:520)
    ... 5 more
courville commented 2 years ago

We will need to debug this for sure for me this is a blocker. Quick question, when you browse your folders using file browsing and enter the dedicated Movies and TV Shows directories, can you confirm i) that files are listed, ii) that you can play the files? I try to understand why it happens with your phone and not mine...

bronnel commented 2 years ago

@courville ,yes I confirm that I can browse folders and see all files in internal storage , I can also play videos. I don't have any ad-block or antivrus installed, it is not even rooted

@courville here is a debug log


2022-02-03 10:25:54.421 7017-7194/org.courville.nova D/avos_player: device_config.cpu_count   8
2022-02-03 10:25:54.421 7017-7194/org.courville.nova D/avos_player: audio_interface_init: audiotrack_java success
2022-02-03 10:25:54.422 7017-7194/org.courville.nova D/avos_player: creating mainloop (for debug only)
2022-02-03 10:25:54.466 7017-7017/org.courville.nova D/NetworkSecurityConfig: Using Network Security Config from resource network_security_config debugBuild: true
2022-02-03 10:25:54.853 7017-7017/org.courville.nova I/SQLiteOpenHelper: Create credentials_db
2022-02-03 10:25:54.874 7017-7017/org.courville.nova D/SambaConfiguration: Updating credentials cache
2022-02-03 10:25:54.889 7017-7017/org.courville.nova E/com.archos.mediacenter.video.CustomApplication: [main] ERROR c.a.m.video.CustomApplication - updateVersionState: cannot split application previous version 0.0.0
2022-02-03 10:25:55.099 7017-7017/org.courville.nova D/PhoneWindow: windowLightStatusBar : false, disable View.SYSTEM_UI_FLAG_LIGHT_STATUS_BAR
2022-02-03 10:25:55.156 7017-7017/org.courville.nova W/ActivityThread: handleWindowVisibility: no activity for token android.os.BinderProxy@f195c53
2022-02-03 10:25:55.201 7017-7017/org.courville.nova D/PhoneWindow: windowLightStatusBar : false, disable View.SYSTEM_UI_FLAG_LIGHT_STATUS_BAR
2022-02-03 10:25:55.230 7017-7017/org.courville.nova W/.courville.nov: Accessing hidden method Landroid/view/View;->computeFitSystemWindows(Landroid/graphics/Rect;Landroid/graphics/Rect;)Z (greylist, reflection, allowed)
2022-02-03 10:25:55.230 7017-7017/org.courville.nova W/.courville.nov: Accessing hidden method Landroid/view/ViewGroup;->makeOptionalFitsSystemWindows()V (greylist, reflection, allowed)
2022-02-03 10:25:55.392 7017-7017/org.courville.nova W/.courville.nov: Accessing hidden method Landroid/os/ServiceManager;->getService(Ljava/lang/String;)Landroid/os/IBinder; (greylist, reflection, allowed)
2022-02-03 10:25:55.392 7017-7017/org.courville.nova W/.courville.nov: Accessing hidden method Landroid/os/storage/IStorageManager$Stub;->asInterface(Landroid/os/IBinder;)Landroid/os/storage/IStorageManager; (greylist, reflection, allowed)
2022-02-03 10:25:55.392 7017-7017/org.courville.nova W/.courville.nov: Accessing hidden method Landroid/os/storage/StorageVolume;->getPath()Ljava/lang/String; (greylist, reflection, allowed)
2022-02-03 10:25:55.392 7017-7017/org.courville.nova W/.courville.nov: Accessing hidden method Landroid/os/storage/StorageManager;->findVolumeByUuid(Ljava/lang/String;)Landroid/os/storage/VolumeInfo; (greylist, reflection, allowed)
2022-02-03 10:25:55.392 7017-7017/org.courville.nova W/.courville.nov: Accessing hidden method Landroid/os/storage/VolumeInfo;->getFsUuid()Ljava/lang/String; (greylist, reflection, allowed)
2022-02-03 10:25:55.392 7017-7017/org.courville.nova W/.courville.nov: Accessing hidden method Landroid/os/storage/VolumeInfo;->isMountedReadable()Z (greylist, reflection, allowed)
2022-02-03 10:25:55.392 7017-7017/org.courville.nova W/.courville.nov: Accessing hidden method Landroid/os/storage/VolumeInfo;->getDisk()Landroid/os/storage/DiskInfo; (greylist, reflection, allowed)
2022-02-03 10:25:55.392 7017-7017/org.courville.nova W/.courville.nov: Accessing hidden method Landroid/os/storage/VolumeInfo;->getPath()Ljava/io/File; (greylist, reflection, allowed)
2022-02-03 10:25:55.393 7017-7017/org.courville.nova W/.courville.nov: Accessing hidden method Landroid/os/storage/DiskInfo;->isSd()Z (greylist, reflection, allowed)
2022-02-03 10:25:55.393 7017-7017/org.courville.nova W/.courville.nov: Accessing hidden method Landroid/os/storage/DiskInfo;->isUsb()Z (greylist, reflection, allowed)
2022-02-03 10:25:55.393 7017-7017/org.courville.nova W/.courville.nov: Accessing hidden field Landroid/os/storage/VolumeInfo;->type:I (greylist, reflection, allowed)
2022-02-03 10:25:55.393 7017-7017/org.courville.nova W/.courville.nov: Accessing hidden field Landroid/os/storage/VolumeInfo;->fsLabel:Ljava/lang/String; (greylist, reflection, allowed)
2022-02-03 10:25:55.393 7017-7017/org.courville.nova W/.courville.nov: Accessing hidden method Landroid/os/storage/DiskInfo;->getDescription()Ljava/lang/String; (greylist, reflection, allowed)
2022-02-03 10:25:55.544 7017-7222/org.courville.nova I/SQLiteOpenHelper: Create media.db
2022-02-03 10:25:55.581 7017-7017/org.courville.nova I/TouchFilterInputStageHelper: [needTouchEventFilter] Displayid : 0
2022-02-03 10:25:55.586 7017-7017/org.courville.nova D/BezellessGripSuppressionFilter: getdisplaysize, x : 1440 y : 3120
2022-02-03 10:25:55.617 7017-7222/org.courville.nova D/create: CREATE TABLE list_table (_id INTEGER PRIMARY KEY AUTOINCREMENT,title TEXT,trakt_id INTEGER UNIQUE ON CONFLICT REPLACE,sync_status INTEGER)
2022-02-03 10:25:55.627 7017-7017/org.courville.nova I/SQLiteOpenHelper: Create blacklisteds_db
2022-02-03 10:25:55.718 7017-7017/org.courville.nova D/com.archos.mediacenter.video.browser.MainActivity: [main] DEBUG c.a.m.video.browser.MainActivity - device with cutout
2022-02-03 10:25:55.729 7017-7017/org.courville.nova W/.courville.nov: Accessing hidden method Landroid/view/View;->getViewRootImpl()Landroid/view/ViewRootImpl; (greylist, reflection, allowed)
2022-02-03 10:25:55.729 7017-7017/org.courville.nova W/.courville.nov: Accessing hidden field Landroid/view/View$AttachInfo;->mVisibleInsets:Landroid/graphics/Rect; (greylist, reflection, allowed)
2022-02-03 10:25:55.729 7017-7017/org.courville.nova W/.courville.nov: Accessing hidden field Landroid/view/ViewRootImpl;->mAttachInfo:Landroid/view/View$AttachInfo; (greylist, reflection, allowed)
2022-02-03 10:25:55.777 7017-7210/org.courville.nova I/AdrenoGLES: QUALCOMM build                   : ce6447e, Ic1977df6c2
    Build Date                       : 10/09/20
    OpenGL ES Shader Compiler Version: EV031.27.05.02
    Local Branch                     : 
    Remote Branch                    : refs/tags/AU_LINUX_ANDROID_LA.UM.8.1.R1.10.00.00.529.107
    Remote Branch                    : NONE
    Reconstruct Branch               : NOTHING
2022-02-03 10:25:55.777 7017-7210/org.courville.nova I/AdrenoGLES: Build Config                     : S P 8.0.12 AArch64
2022-02-03 10:25:55.780 7017-7210/org.courville.nova I/AdrenoGLES: PFP: 0x016ee187, ME: 0x00000000
2022-02-03 10:25:55.781 7017-7210/org.courville.nova W/AdrenoUtils: <ReadGpuID_from_sysfs:194>: Failed to open /sys/class/kgsl/kgsl-3d0/gpu_model
2022-02-03 10:25:55.781 7017-7210/org.courville.nova W/AdrenoUtils: <ReadGpuID:218>: Failed to read chip ID from gpu_model. Fallback to use the GSL path
2022-02-03 10:25:55.995 7017-7210/org.courville.nova W/Gralloc3: mapper 3.x is not supported
2022-02-03 10:25:56.285 7017-7017/org.courville.nova I/Choreographer: Skipped 33 frames!  The application may be doing too much work on its main thread.
2022-02-03 10:25:56.445 7017-7017/org.courville.nova I/Timeline: Timeline: Activity_idle id: android.os.BinderProxy@f195c53 time:6140392
2022-02-03 10:25:58.152 7017-7017/org.courville.nova I/Timeline: Timeline: Activity_idle id: android.os.BinderProxy@f195c53 time:6142098
2022-02-03 10:25:59.976 7017-7226/org.courville.nova I/SQLiteConnection: /data/user/0/org.courville.nova/databases/media.db-wal 1751032 bytes: Bigger than 1048576; truncating
2022-02-03 10:25:59.990 7017-7296/org.courville.nova D/com.archos.mediascraper.AutoScrapeService: [Binder:7017_4] DEBUG c.a.mediascraper.AutoScrapeService - registerObserver: onChange getting 0 videos not yet scraped -> not launching service!
2022-02-03 10:26:00.445 7017-7296/org.courville.nova D/com.archos.mediascraper.AutoScrapeService: [Binder:7017_4] DEBUG c.a.mediascraper.AutoScrapeService - registerObserver: onChange getting 0 videos not yet scraped -> not launching service!
2022-02-03 10:26:00.913 7017-7296/org.courville.nova D/com.archos.mediascraper.AutoScrapeService: [Binder:7017_4] DEBUG c.a.mediascraper.AutoScrapeService - registerObserver: onChange getting 0 videos not yet scraped -> not launching service!
2022-02-03 10:26:01.397 7017-7296/org.courville.nova D/com.archos.mediascraper.AutoScrapeService: [Binder:7017_4] DEBUG c.a.mediascraper.AutoScrapeService - registerObserver: onChange getting 0 videos not yet scraped -> not launching service!
2022-02-03 10:26:02.368 7017-7296/org.courville.nova I/chatty: uid=10563(org.courville.nova) Binder:7017_4 identical 2 lines
2022-02-03 10:26:02.432 7017-7296/org.courville.nova D/com.archos.mediascraper.AutoScrapeService: [Binder:7017_4] DEBUG c.a.mediascraper.AutoScrapeService - registerObserver: onChange getting 0 videos not yet scraped -> not launching service!
2022-02-03 10:26:53.906 7017-7188/org.courville.nova I/System.out: 10:26:53,905 |-INFO in ReconfigureOnChangeTask(born:1643873153900) - Empty watch file list. Disabling 

here I try to manually add a file from the folders, but nothing happnes

2022-02-03 10:35:13.930 9865-9865/org.courville.nova I/ViewRootImpl: ViewRoot's Touch Event : ACTION_DOWN
2022-02-03 10:35:14.062 9865-9865/org.courville.nova I/ViewRootImpl: ViewRoot's Touch Event : ACTION_UP
2022-02-03 10:35:14.757 9865-9865/org.courville.nova I/ViewRootImpl: ViewRoot's Touch Event : ACTION_DOWN
2022-02-03 10:35:14.825 9865-9865/org.courville.nova I/ViewRootImpl: ViewRoot's Touch Event : ACTION_UP
2022-02-03 10:35:14.900 9865-11286/org.courville.nova D/LocalStorageListingEngine: listing files for /storage/emulated/0
2022-02-03 10:35:28.536 9865-9865/org.courville.nova I/ViewRootImpl: ViewRoot's Touch Event : ACTION_DOWN
2022-02-03 10:35:28.848 9865-9865/org.courville.nova I/ViewRootImpl: ViewRoot's Touch Event : ACTION_UP
2022-02-03 10:35:28.848 9865-9865/org.courville.nova I/TouchFlickNoti: CHANGE DOWN TO UP vectorVelocity:-6601
2022-02-03 10:35:29.385 9865-9865/org.courville.nova I/ViewRootImpl: ViewRoot's Touch Event : ACTION_DOWN
2022-02-03 10:35:29.770 9865-9865/org.courville.nova I/ViewRootImpl: ViewRoot's Touch Event : ACTION_UP
2022-02-03 10:35:29.771 9865-9865/org.courville.nova I/TouchFlickNoti: CHANGE DOWN TO UP vectorVelocity:-2024
2022-02-03 10:35:30.036 9865-9865/org.courville.nova I/ViewRootImpl: ViewRoot's Touch Event : ACTION_DOWN
2022-02-03 10:35:30.418 9865-9865/org.courville.nova I/ViewRootImpl: ViewRoot's Touch Event : ACTION_UP
2022-02-03 10:35:30.418 9865-9865/org.courville.nova I/TouchFlickNoti: CHANGE DOWN TO UP vectorVelocity:-1783
2022-02-03 10:35:30.653 9865-9865/org.courville.nova I/ViewRootImpl: ViewRoot's Touch Event : ACTION_DOWN
2022-02-03 10:35:31.002 9865-9865/org.courville.nova I/ViewRootImpl: ViewRoot's Touch Event : ACTION_UP
2022-02-03 10:35:31.003 9865-9865/org.courville.nova I/TouchFlickNoti: CHANGE DOWN TO UP vectorVelocity:-3923
2022-02-03 10:35:31.359 9865-9865/org.courville.nova I/ViewRootImpl: ViewRoot's Touch Event : ACTION_DOWN
2022-02-03 10:35:31.925 9865-9865/org.courville.nova I/ViewRootImpl: ViewRoot's Touch Event : ACTION_UP
2022-02-03 10:35:31.926 9865-9865/org.courville.nova I/TouchFlickNoti: CHANGE DOWN TO UP vectorVelocity:0
2022-02-03 10:35:32.725 9865-9865/org.courville.nova I/ViewRootImpl: ViewRoot's Touch Event : ACTION_DOWN
2022-02-03 10:35:32.808 9865-9865/org.courville.nova I/ViewRootImpl: ViewRoot's Touch Event : ACTION_UP
2022-02-03 10:35:32.855 9865-11292/org.courville.nova D/LocalStorageListingEngine: listing files for /storage/emulated/0/TV Shows
2022-02-03 10:35:43.999 9865-9865/org.courville.nova I/ViewRootImpl: ViewRoot's Touch Event : ACTION_DOWN
2022-02-03 10:35:44.083 9865-9865/org.courville.nova I/ViewRootImpl: ViewRoot's Touch Event : ACTION_UP
2022-02-03 10:35:44.123 9865-11293/org.courville.nova D/LocalStorageListingEngine: listing files for /storage/emulated/0/TV Shows/attack on titan
2022-02-03 10:35:45.042 9865-9865/org.courville.nova I/ViewRootImpl: ViewRoot's Touch Event : ACTION_DOWN
2022-02-03 10:35:45.175 9865-9865/org.courville.nova I/ViewRootImpl: ViewRoot's Touch Event : ACTION_UP
2022-02-03 10:35:45.229 9865-11294/org.courville.nova D/LocalStorageListingEngine: listing files for /storage/emulated/0/TV Shows/attack on titan/s01
2022-02-03 10:35:46.712 9865-9865/org.courville.nova I/ViewRootImpl: ViewRoot's Touch Event : ACTION_DOWN
2022-02-03 10:35:46.795 9865-9865/org.courville.nova I/ViewRootImpl: ViewRoot's Touch Event : ACTION_UP
2022-02-03 10:35:46.837 9865-9865/org.courville.nova W/ActivityThread: handleWindowVisibility: no activity for token android.os.BinderProxy@b3038a6
2022-02-03 10:35:46.858 9865-9865/org.courville.nova D/PhoneWindow: windowLightStatusBar : false, disable View.SYSTEM_UI_FLAG_LIGHT_STATUS_BAR
2022-02-03 10:35:46.893 9865-9865/org.courville.nova I/TouchFilterInputStageHelper: [needTouchEventFilter] Displayid : 0
2022-02-03 10:35:46.895 9865-9865/org.courville.nova D/BezellessGripSuppressionFilter: getdisplaysize, x : 1440 y : 3120
2022-02-03 10:35:46.954 9865-10097/org.courville.nova D/avos_player: device_config.mp_decoder  0
2022-02-03 10:35:46.954 9865-10097/org.courville.nova D/avos_player: device_config.mp_audio_interface  0
2022-02-03 10:35:46.954 9865-10097/org.courville.nova D/avos_player: device_config.output_sample_rate  48000
2022-02-03 10:35:46.954 9865-10097/org.courville.nova D/avos_player: 0x7643a3e080|avos_mr_setdatasource_common: file type: video
2022-02-03 10:35:46.995 9865-10097/org.courville.nova D/avos_player: HELLO, Found 0 side data!
2022-02-03 10:35:46.997 9865-10125/org.courville.nova W/VideoMetadata: getMetadataRetrieverInt: key (9002) is null
2022-02-03 10:35:46.997 9865-10125/org.courville.nova V/avos_media_metadata_retriever: nativeRelease
2022-02-03 10:35:46.997 9865-9865/org.courville.nova W/View: requestLayout() improperly called by android.widget.RelativeLayout{79147b8 V.E...... ......ID 0,0-1440,2301 #7f0a035b app:id/scroll_content} during layout: running second layout pass
2022-02-03 10:35:46.997 9865-10097/org.courville.nova D/avos_player: total: 611  utf 611  UTF8!
2022-02-03 10:35:47.039 9865-9865/org.courville.nova I/Timeline: Timeline: Activity_idle id: android.os.BinderProxy@b3038a6 time:6730986
2022-02-03 10:35:47.060 9865-10203/org.courville.nova I/AMXVideoStore: requestIndexing: scanned /storage/emulated/0/TV Shows/attack on titan/s01/attack on titan.s1.e1.mp4:
2022-02-03 10:35:47.060 9865-10203/org.courville.nova I/AMXVideoStore: requestIndexing: -> uri=content://media/external_primary/file/34539
2022-02-03 10:35:52.224 9865-9865/org.courville.nova I/ViewRootImpl: ViewRoot's Touch Event : ACTION_DOWN
2022-02-03 10:35:52.316 9865-9865/org.courville.nova I/ViewRootImpl: ViewRoot's Touch Event : ACTION_UP
2022-02-03 10:35:52.372 9865-9892/org.courville.nova I/AMXVideoStore: requestIndexing: scanned /storage/emulated/0/TV Shows/attack on titan/s01/attack on titan.s1.e1.mp4:
2022-02-03 10:35:52.372 9865-9892/org.courville.nova I/AMXVideoStore: requestIndexing: -> uri=content://media/external_primary/file/34539
bronnel commented 2 years ago

@courville Update , I tested it on my friend's LG V50 and it worked , so I guess you are right , something was blocking it on my device , but it is very strange since I don't have any adblocking app on my phone, maybe there is some built-in sprint service that blocks certain kind of connections

courville commented 2 years ago

This is indeed strange and not systematic. It does not decrease the severity of the issue if you can still reproduce. I will need to find a way to add verbose logs to understand why nova sees no video and thus do not launch the autoScrapeService... It may sounds stupid but do you still have the issue after a proper phone reboot?

bronnel commented 2 years ago

@courville , yes it is still reproducible on my V30 and V50 , my v30 is not even a sprint device, it is unlocked, Its the same after reboot , I will provide any logs you need. I appreciate it.

courville commented 2 years ago

Could you share with me privately a dump of the nova mediaDb on your failing phone at software at courville dot org?

To dump nova mediaDb you can click 10 times on the nova settings->software decoding, it will enable more options, one of them at the end of the settings list being media database export. You will need to pull it from internal storage located in /sdcard/org.courville.nova-media.dbon v5 but located in /sdcard/Android/org.courville.nova/files/org.courville.nova-media.db on v6.

You can adb pull /sdcard/Android/org.courville.nova/files/org.courville.nova-media.db to retrieve the file.

bronnel commented 2 years ago

@courville ,I just sent it to your email, please check , thanks

courville commented 2 years ago

Thanks for sharing. What I can see is that nova sees all your videos in the files internal database. However it never got it interpreted and imported in the video database. Let's add debugs in the import part and share the apk and clean data/cache and relaunch as it would be the first time. I could do a branch on current code if you want to build yourself and test from your own builds.

bronnel commented 2 years ago

@courville , great, if you send an apk I will test it, if not then I can build your debug branch

courville commented 2 years ago

ok you can rebuild after git pull on MediaLib. Please install apk, clean nova data in settings and relaunch nova and take adb logs from initial import (it must crash somewhere and this should be noticeable in logs).

bronnel commented 2 years ago

@courville , after latest git pull for MediaLib, it still the same behaviour , I uninstalled previous build completely, but it doesn't crash like you said How to access the debug log that you mentioned? here is Logcat ,

2022-02-04 19:43:56.608 4578-4578/? I/.courville.nov: Late-enabling -Xcheck:jni
2022-02-04 19:43:56.621 4578-4578/org.courville.nova E/.courville.nov: Unknown bits set in runtime_flags: 0x8000
2022-02-04 19:43:56.652 4578-4578/org.courville.nova W/ActivityThread: Application org.courville.nova is waiting for the debugger on port 8100...
2022-02-04 19:43:56.658 4578-4578/org.courville.nova I/System.out: Sending WAIT chunk
2022-02-04 19:43:57.660 4578-4578/org.courville.nova I/System.out: Debugger has connected
2022-02-04 19:43:57.660 4578-4578/org.courville.nova I/System.out: waiting for debugger to settle...
2022-02-04 19:43:58.262 4578-4578/org.courville.nova I/chatty: uid=10575(org.courville.nova) identical 3 lines
2022-02-04 19:43:58.463 4578-4578/org.courville.nova I/System.out: waiting for debugger to settle...
2022-02-04 19:43:58.664 4578-4578/org.courville.nova I/System.out: waiting for debugger to settle...
2022-02-04 19:43:58.864 4578-4578/org.courville.nova I/System.out: waiting for debugger to settle...
2022-02-04 19:43:59.066 4578-4578/org.courville.nova I/System.out: waiting for debugger to settle...
2022-02-04 19:43:59.267 4578-4578/org.courville.nova I/System.out: debugger has settled (1499)
2022-02-04 19:43:59.284 4578-4578/org.courville.nova I/Typeface: Current DefaultTypeface ( default_roboto )
2022-02-04 19:43:59.299 4578-4578/org.courville.nova I/.courville.nov: The ClassLoaderContext is a special shared library.
2022-02-04 19:43:59.853 4578-4578/org.courville.nova I/ACRA: ACRA is enabled for org.courville.nova, initializing...
2022-02-04 19:44:00.017 4578-4578/org.courville.nova W/.courville.nov: Accessing hidden method Landroid/app/AppGlobals;->getInitialApplication()Landroid/app/Application; (greylist, reflection, allowed)
2022-02-04 19:44:00.165 4578-4578/org.courville.nova I/System.out: 19:44:00,039 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [assets/logback.xml] at [assets/logback.xml]
2022-02-04 19:44:00.167 4578-4578/org.courville.nova I/System.out: 19:44:00,040 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@2b3639c - URL [jar:file:/data/app/org.courville.nova-vCWq8dEIJBTnX3gkUYpMYQ==/base.apk!/assets/logback.xml] is not of type file
2022-02-04 19:44:00.170 4578-4578/org.courville.nova I/System.out: 19:44:00,168 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - Will scan for changes in [jar:file:/data/app/org.courville.nova-vCWq8dEIJBTnX3gkUYpMYQ==/base.apk!/assets/logback.xml] 
2022-02-04 19:44:00.171 4578-4578/org.courville.nova I/System.out: 19:44:00,170 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - Setting ReconfigureOnChangeTask scanning period to 1 minutes
2022-02-04 19:44:00.181 4578-4578/org.courville.nova I/System.out: 19:44:00,179 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.classic.android.LogcatAppender]
2022-02-04 19:44:00.183 4578-4578/org.courville.nova I/System.out: 19:44:00,182 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [logcat]
2022-02-04 19:44:00.204 4578-4578/org.courville.nova I/System.out: 19:44:00,203 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [tagEncoder] property
2022-02-04 19:44:00.256 4578-4578/org.courville.nova I/System.out: 19:44:00,254 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
2022-02-04 19:44:00.320 4578-4578/org.courville.nova I/System.out: 19:44:00,319 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
2022-02-04 19:44:00.324 4578-4578/org.courville.nova I/System.out: 19:44:00,323 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [LOG_FILE]
2022-02-04 19:44:00.358 4578-4578/org.courville.nova I/System.out: 19:44:00,357 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
2022-02-04 19:44:00.454 4578-4578/org.courville.nova I/System.out: 19:44:00,453 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@195988020 - setting totalSizeCap to 50 MB
2022-02-04 19:44:00.464 4578-4578/org.courville.nova I/System.out: 19:44:00,463 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@195988020 - No compression will be used
2022-02-04 19:44:00.469 4578-4578/org.courville.nova I/System.out: 19:44:00,468 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@195988020 - Will use the pattern /storage/emulated/0/Android/data/org.courville.nova/files/logback/nova-%d.log for the active file
2022-02-04 19:44:00.473 4578-4578/org.courville.nova I/System.out: 19:44:00,471 |-INFO in c.q.l.core.rolling.DefaultTimeBasedFileNamingAndTriggeringPolicy - The date pattern is 'yyyy-MM-dd' from file name pattern '/storage/emulated/0/Android/data/org.courville.nova/files/logback/nova-%d.log'.
2022-02-04 19:44:00.474 4578-4578/org.courville.nova I/System.out: 19:44:00,473 |-INFO in c.q.l.core.rolling.DefaultTimeBasedFileNamingAndTriggeringPolicy - Roll-over at midnight.
2022-02-04 19:44:00.512 4578-4578/org.courville.nova I/System.out: 19:44:00,511 |-INFO in c.q.l.core.rolling.DefaultTimeBasedFileNamingAndTriggeringPolicy - Setting initial period to Fri Feb 04 19:44:00 GMT+03:00 2022
2022-02-04 19:44:00.522 4578-4578/org.courville.nova I/System.out: 19:44:00,520 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[LOG_FILE] - Active log file name: /storage/emulated/0/Android/data/org.courville.nova/files/logback/nova.log
2022-02-04 19:44:00.524 4578-4578/org.courville.nova I/System.out: 19:44:00,522 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[LOG_FILE] - File property is set to [/storage/emulated/0/Android/data/org.courville.nova/files/logback/nova.log]
2022-02-04 19:44:00.527 4578-4578/org.courville.nova I/System.out: 19:44:00,526 |-ERROR in ch.qos.logback.core.rolling.RollingFileAppender[LOG_FILE] - Failed to create parent directories for [/storage/emulated/0/Android/data/org.courville.nova/files/logback/nova.log]
2022-02-04 19:44:00.535 4578-4578/org.courville.nova I/System.out: 19:44:00,528 |-ERROR in ch.qos.logback.core.rolling.RollingFileAppender[LOG_FILE] - openFile(/storage/emulated/0/Android/data/org.courville.nova/files/logback/nova.log,true) failed java.io.FileNotFoundException: /storage/emulated/0/Android/data/org.courville.nova/files/logback/nova.log: open failed: ENOENT (No such file or directory)
2022-02-04 19:44:00.535 4578-4578/org.courville.nova I/System.out:     at java.io.FileNotFoundException: /storage/emulated/0/Android/data/org.courville.nova/files/logback/nova.log: open failed: ENOENT (No such file or directory)
2022-02-04 19:44:00.536 4578-4578/org.courville.nova I/System.out:     at   at libcore.io.IoBridge.open(IoBridge.java:496)
2022-02-04 19:44:00.536 4578-4578/org.courville.nova I/System.out:     at   at java.io.FileOutputStream.<init>(FileOutputStream.java:235)
2022-02-04 19:44:00.536 4578-4578/org.courville.nova I/System.out:     at   at ch.qos.logback.core.recovery.ResilientFileOutputStream.<init>(Unknown Source:7)
2022-02-04 19:44:00.536 4578-4578/org.courville.nova I/System.out:     at   at ch.qos.logback.core.FileAppender.openFile(Unknown Source:62)
2022-02-04 19:44:00.536 4578-4578/org.courville.nova I/System.out:     at   at ch.qos.logback.core.FileAppender.start(Unknown Source:75)
2022-02-04 19:44:00.536 4578-4578/org.courville.nova I/System.out:     at   at ch.qos.logback.core.rolling.RollingFileAppender.start(Unknown Source:280)
2022-02-04 19:44:00.536 4578-4578/org.courville.nova I/System.out:     at   at ch.qos.logback.core.joran.action.AppenderAction.end(Unknown Source:11)
2022-02-04 19:44:00.537 4578-4578/org.courville.nova I/System.out:     at   at ch.qos.logback.core.joran.spi.Interpreter.callEndAction(Unknown Source:23)
2022-02-04 19:44:00.537 4578-4578/org.courville.nova I/System.out:     at   at ch.qos.logback.core.joran.spi.Interpreter.endElement(Unknown Source:32)
2022-02-04 19:44:00.537 4578-4578/org.courville.nova I/System.out:     at   at ch.qos.logback.core.joran.spi.Interpreter.endElement(Unknown Source:11)
2022-02-04 19:44:00.537 4578-4578/org.courville.nova I/System.out:     at   at ch.qos.logback.core.joran.spi.EventPlayer.play(Unknown Source:84)
2022-02-04 19:44:00.537 4578-4578/org.courville.nova I/System.out:     at   at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(Unknown Source:16)
2022-02-04 19:44:00.537 4578-4578/org.courville.nova I/System.out:     at   at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(Unknown Source:18)
2022-02-04 19:44:00.537 4578-4578/org.courville.nova I/System.out:     at   at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(Unknown Source:8)
2022-02-04 19:44:00.538 4578-4578/org.courville.nova I/System.out:     at   at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(Unknown Source:24)
2022-02-04 19:44:00.538 4578-4578/org.courville.nova I/System.out:     at   at ch.qos.logback.classic.util.ContextInitializer.autoConfig(Unknown Source:46)
2022-02-04 19:44:00.538 4578-4578/org.courville.nova I/System.out:     at   at org.slf4j.impl.StaticLoggerBinder.init(Unknown Source:7)
2022-02-04 19:44:00.538 4578-4578/org.courville.nova I/System.out:     at   at org.slf4j.impl.StaticLoggerBinder.<clinit>(Unknown Source:20)
2022-02-04 19:44:00.538 4578-4578/org.courville.nova I/System.out:     at   at org.slf4j.impl.StaticLoggerBinder.getSingleton(Unknown Source:0)
2022-02-04 19:44:00.538 4578-4578/org.courville.nova I/System.out:     at   at org.slf4j.LoggerFactory.bind(LoggerFactory.java:150)
2022-02-04 19:44:00.538 4578-4578/org.courville.nova I/System.out:     at   at org.slf4j.LoggerFactory.performInitialization(LoggerFactory.java:124)
2022-02-04 19:44:00.539 4578-4578/org.courville.nova I/System.out:     at   at org.slf4j.LoggerFactory.getILoggerFactory(LoggerFactory.java:417)
2022-02-04 19:44:00.539 4578-4578/org.courville.nova I/System.out:     at   at org.slf4j.LoggerFactory.getLogger(LoggerFactory.java:362)
2022-02-04 19:44:00.539 4578-4578/org.courville.nova I/System.out:     at   at org.slf4j.LoggerFactory.getLogger(LoggerFactory.java:388)
2022-02-04 19:44:00.539 4578-4578/org.courville.nova I/System.out:     at   at com.archos.mediaprovider.video.VideoProvider.<clinit>(VideoProvider.java:82)
2022-02-04 19:44:00.539 4578-4578/org.courville.nova I/System.out:     at   at java.lang.Class.newInstance(Native Method)
2022-02-04 19:44:00.539 4578-4578/org.courville.nova I/System.out:     at   at android.app.AppComponentFactory.instantiateProvider(AppComponentFactory.java:147)
2022-02-04 19:44:00.539 4578-4578/org.courville.nova I/System.out:     at   at androidx.core.app.CoreComponentFactory.instantiateProvider(CoreComponentFactory.java:67)
2022-02-04 19:44:00.539 4578-4578/org.courville.nova I/System.out:     at   at android.app.ActivityThread.installProvider(ActivityThread.java:7202)
2022-02-04 19:44:00.540 4578-4578/org.courville.nova I/System.out:     at   at android.app.ActivityThread.installContentProviders(ActivityThread.java:6758)
2022-02-04 19:44:00.540 4578-4578/org.courville.nova I/System.out:     at   at android.app.ActivityThread.handleBindApplication(ActivityThread.java:6653)
2022-02-04 19:44:00.540 4578-4578/org.courville.nova I/System.out:     at   at android.app.ActivityThread.access$1300(ActivityThread.java:221)
2022-02-04 19:44:00.540 4578-4578/org.courville.nova I/System.out:     at   at android.app.ActivityThread$H.handleMessage(ActivityThread.java:1893)
2022-02-04 19:44:00.540 4578-4578/org.courville.nova I/System.out:     at   at android.os.Handler.dispatchMessage(Handler.java:107)
2022-02-04 19:44:00.540 4578-4578/org.courville.nova I/System.out:     at   at android.os.Looper.loop(Looper.java:214)
2022-02-04 19:44:00.540 4578-4578/org.courville.nova I/System.out:     at   at android.app.ActivityThread.main(ActivityThread.java:7573)
2022-02-04 19:44:00.540 4578-4578/org.courville.nova I/System.out:     at   at java.lang.reflect.Method.invoke(Native Method)
2022-02-04 19:44:00.541 4578-4578/org.courville.nova I/System.out:     at   at com.android.internal.os.RuntimeInit$MethodAndArgsCaller.run(RuntimeInit.java:492)
2022-02-04 19:44:00.541 4578-4578/org.courville.nova I/System.out:     at   at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:937)
2022-02-04 19:44:00.541 4578-4578/org.courville.nova I/System.out: Caused by: android.system.ErrnoException: open failed: ENOENT (No such file or directory)
2022-02-04 19:44:00.541 4578-4578/org.courville.nova I/System.out:     at   at libcore.io.Linux.open(Native Method)
2022-02-04 19:44:00.541 4578-4578/org.courville.nova I/System.out:     at   at libcore.io.ForwardingOs.open(ForwardingOs.java:167)
2022-02-04 19:44:00.541 4578-4578/org.courville.nova I/System.out:     at   at libcore.io.BlockGuardOs.open(BlockGuardOs.java:252)
2022-02-04 19:44:00.541 4578-4578/org.courville.nova I/System.out:     at   at libcore.io.ForwardingOs.open(ForwardingOs.java:167)
2022-02-04 19:44:00.541 4578-4578/org.courville.nova I/System.out:     at   at android.app.ActivityThread$AndroidOs.open(ActivityThread.java:7490)
2022-02-04 19:44:00.542 4578-4578/org.courville.nova I/System.out:     at   at libcore.io.IoBridge.open(IoBridge.java:482)
2022-02-04 19:44:00.542 4578-4578/org.courville.nova I/System.out:  at  ... 38 common frames omitted
2022-02-04 19:44:00.545 4578-4578/org.courville.nova I/System.out: 19:44:00,543 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.archos.mediacenter.video.leanback.MainFragment] to DEBUG
2022-02-04 19:44:00.547 4578-4578/org.courville.nova I/System.out: 19:44:00,546 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.archos.mediacenter.video.browser.MainActivity] to DEBUG
2022-02-04 19:44:00.550 4578-4578/org.courville.nova I/System.out: 19:44:00,549 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.archos.mediascraper.AutoScrapeService] to DEBUG
2022-02-04 19:44:00.553 4578-4578/org.courville.nova I/System.out: 19:44:00,552 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.archos.mediascraper.xml.MovieScraper3] to DEBUG
2022-02-04 19:44:00.555 4578-4578/org.courville.nova I/System.out: 19:44:00,554 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.archos.mediascraper.xml.ShowScraper4] to DEBUG
2022-02-04 19:44:00.561 4578-4578/org.courville.nova I/System.out: 19:44:00,560 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to INFO
2022-02-04 19:44:00.563 4578-4578/org.courville.nova I/System.out: 19:44:00,562 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [logcat] to Logger[ROOT]
2022-02-04 19:44:00.565 4578-4578/org.courville.nova I/System.out: 19:44:00,564 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - End of configuration.
2022-02-04 19:44:00.567 4578-4578/org.courville.nova I/System.out: 19:44:00,566 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@fa4e05d - Registering current configuration as safe fallback point
2022-02-04 19:44:00.674 4578-4813/org.courville.nova W/linker: Warning: "/data/app/org.courville.nova-vCWq8dEIJBTnX3gkUYpMYQ==/lib/arm64/libc++_shared.so" unused DT entry: unknown processor-specific (type 0x70000001 arg 0x0) (ignoring)
2022-02-04 19:44:00.678 4578-4814/org.courville.nova D/avos_player: libavos_init
2022-02-04 19:44:00.678 4578-4814/org.courville.nova D/avos_player: device_config.has_hdd     0
2022-02-04 19:44:00.678 4578-4814/org.courville.nova D/avos_player: device_config.has_dsp     1
2022-02-04 19:44:00.678 4578-4814/org.courville.nova D/avos_player: device_config.has_dsp_od  0
2022-02-04 19:44:00.678 4578-4814/org.courville.nova D/avos_player: device_config.zone        0
2022-02-04 19:44:00.678 4578-4814/org.courville.nova D/avos_player: device_config.hw_type     unknown
2022-02-04 19:44:00.679 4578-4814/org.courville.nova D/avos_player: device_config.cpu_count   8
2022-02-04 19:44:00.679 4578-4814/org.courville.nova D/avos_player: audio_interface_init: audiotrack_java success
2022-02-04 19:44:00.679 4578-4814/org.courville.nova D/avos_player: creating mainloop (for debug only)
2022-02-04 19:44:00.728 4578-4578/org.courville.nova D/NetworkSecurityConfig: Using Network Security Config from resource network_security_config debugBuild: true
2022-02-04 19:44:01.120 4578-4578/org.courville.nova I/SQLiteOpenHelper: Create credentials_db
2022-02-04 19:44:01.141 4578-4578/org.courville.nova D/SambaConfiguration: Updating credentials cache
2022-02-04 19:44:01.158 4578-4578/org.courville.nova E/com.archos.mediacenter.video.CustomApplication: [main] ERROR c.a.m.video.CustomApplication - updateVersionState: cannot split application previous version 0.0.0
2022-02-04 19:44:01.328 4578-4578/org.courville.nova D/PhoneWindow: windowLightStatusBar : false, disable View.SYSTEM_UI_FLAG_LIGHT_STATUS_BAR
2022-02-04 19:44:01.367 4578-4578/org.courville.nova W/ActivityThread: handleWindowVisibility: no activity for token android.os.BinderProxy@65b5319
2022-02-04 19:44:01.412 4578-4578/org.courville.nova D/PhoneWindow: windowLightStatusBar : false, disable View.SYSTEM_UI_FLAG_LIGHT_STATUS_BAR
2022-02-04 19:44:01.433 4578-4578/org.courville.nova W/.courville.nov: Accessing hidden method Landroid/view/View;->computeFitSystemWindows(Landroid/graphics/Rect;Landroid/graphics/Rect;)Z (greylist, reflection, allowed)
2022-02-04 19:44:01.433 4578-4578/org.courville.nova W/.courville.nov: Accessing hidden method Landroid/view/ViewGroup;->makeOptionalFitsSystemWindows()V (greylist, reflection, allowed)
2022-02-04 19:44:01.631 4578-4578/org.courville.nova W/.courville.nov: Accessing hidden method Landroid/os/ServiceManager;->getService(Ljava/lang/String;)Landroid/os/IBinder; (greylist, reflection, allowed)
2022-02-04 19:44:01.631 4578-4578/org.courville.nova W/.courville.nov: Accessing hidden method Landroid/os/storage/IStorageManager$Stub;->asInterface(Landroid/os/IBinder;)Landroid/os/storage/IStorageManager; (greylist, reflection, allowed)
2022-02-04 19:44:01.631 4578-4578/org.courville.nova W/.courville.nov: Accessing hidden method Landroid/os/storage/StorageVolume;->getPath()Ljava/lang/String; (greylist, reflection, allowed)
2022-02-04 19:44:01.631 4578-4578/org.courville.nova W/.courville.nov: Accessing hidden method Landroid/os/storage/StorageManager;->findVolumeByUuid(Ljava/lang/String;)Landroid/os/storage/VolumeInfo; (greylist, reflection, allowed)
2022-02-04 19:44:01.631 4578-4578/org.courville.nova W/.courville.nov: Accessing hidden method Landroid/os/storage/VolumeInfo;->getFsUuid()Ljava/lang/String; (greylist, reflection, allowed)
2022-02-04 19:44:01.631 4578-4578/org.courville.nova W/.courville.nov: Accessing hidden method Landroid/os/storage/VolumeInfo;->isMountedReadable()Z (greylist, reflection, allowed)
2022-02-04 19:44:01.631 4578-4578/org.courville.nova W/.courville.nov: Accessing hidden method Landroid/os/storage/VolumeInfo;->getDisk()Landroid/os/storage/DiskInfo; (greylist, reflection, allowed)
2022-02-04 19:44:01.631 4578-4578/org.courville.nova W/.courville.nov: Accessing hidden method Landroid/os/storage/VolumeInfo;->getPath()Ljava/io/File; (greylist, reflection, allowed)
2022-02-04 19:44:01.631 4578-4578/org.courville.nova W/.courville.nov: Accessing hidden method Landroid/os/storage/DiskInfo;->isSd()Z (greylist, reflection, allowed)
2022-02-04 19:44:01.631 4578-4578/org.courville.nova W/.courville.nov: Accessing hidden method Landroid/os/storage/DiskInfo;->isUsb()Z (greylist, reflection, allowed)
2022-02-04 19:44:01.631 4578-4578/org.courville.nova W/.courville.nov: Accessing hidden field Landroid/os/storage/VolumeInfo;->type:I (greylist, reflection, allowed)
2022-02-04 19:44:01.631 4578-4578/org.courville.nova W/.courville.nov: Accessing hidden field Landroid/os/storage/VolumeInfo;->fsLabel:Ljava/lang/String; (greylist, reflection, allowed)
2022-02-04 19:44:01.631 4578-4578/org.courville.nova W/.courville.nov: Accessing hidden method Landroid/os/storage/DiskInfo;->getDescription()Ljava/lang/String; (greylist, reflection, allowed)
2022-02-04 19:44:01.784 4578-4860/org.courville.nova I/SQLiteOpenHelper: Create media.db
2022-02-04 19:44:01.813 4578-4578/org.courville.nova I/TouchFilterInputStageHelper: [needTouchEventFilter] Displayid : 0
2022-02-04 19:44:01.817 4578-4578/org.courville.nova D/BezellessGripSuppressionFilter: getdisplaysize, x : 1440 y : 3120
2022-02-04 19:44:01.855 4578-4860/org.courville.nova D/create: CREATE TABLE list_table (_id INTEGER PRIMARY KEY AUTOINCREMENT,title TEXT,trakt_id INTEGER UNIQUE ON CONFLICT REPLACE,sync_status INTEGER)
2022-02-04 19:44:01.858 4578-4578/org.courville.nova I/SQLiteOpenHelper: Create blacklisteds_db
2022-02-04 19:44:01.953 4578-4578/org.courville.nova D/com.archos.mediacenter.video.browser.MainActivity: [main] DEBUG c.a.m.video.browser.MainActivity - device with cutout
2022-02-04 19:44:01.965 4578-4578/org.courville.nova W/.courville.nov: Accessing hidden method Landroid/view/View;->getViewRootImpl()Landroid/view/ViewRootImpl; (greylist, reflection, allowed)
2022-02-04 19:44:01.965 4578-4578/org.courville.nova W/.courville.nov: Accessing hidden field Landroid/view/View$AttachInfo;->mVisibleInsets:Landroid/graphics/Rect; (greylist, reflection, allowed)
2022-02-04 19:44:01.965 4578-4578/org.courville.nova W/.courville.nov: Accessing hidden field Landroid/view/ViewRootImpl;->mAttachInfo:Landroid/view/View$AttachInfo; (greylist, reflection, allowed)
2022-02-04 19:44:02.019 4578-4838/org.courville.nova I/AdrenoGLES: QUALCOMM build                   : ce6447e, Ic1977df6c2
    Build Date                       : 10/09/20
    OpenGL ES Shader Compiler Version: EV031.27.05.02
    Local Branch                     : 
    Remote Branch                    : refs/tags/AU_LINUX_ANDROID_LA.UM.8.1.R1.10.00.00.529.107
    Remote Branch                    : NONE
    Reconstruct Branch               : NOTHING
2022-02-04 19:44:02.020 4578-4838/org.courville.nova I/AdrenoGLES: Build Config                     : S P 8.0.12 AArch64
2022-02-04 19:44:02.022 4578-4838/org.courville.nova I/AdrenoGLES: PFP: 0x016ee187, ME: 0x00000000
2022-02-04 19:44:02.023 4578-4838/org.courville.nova W/AdrenoUtils: <ReadGpuID_from_sysfs:194>: Failed to open /sys/class/kgsl/kgsl-3d0/gpu_model
2022-02-04 19:44:02.023 4578-4838/org.courville.nova W/AdrenoUtils: <ReadGpuID:218>: Failed to read chip ID from gpu_model. Fallback to use the GSL path
2022-02-04 19:44:02.236 4578-4838/org.courville.nova W/Gralloc3: mapper 3.x is not supported
2022-02-04 19:44:02.708 4578-4578/org.courville.nova I/Timeline: Timeline: Activity_idle id: android.os.BinderProxy@65b5319 time:3967435
2022-02-04 19:44:03.390 4578-4578/org.courville.nova I/Timeline: Timeline: Activity_idle id: android.os.BinderProxy@65b5319 time:3968117
2022-02-04 19:44:04.121 4578-4860/org.courville.nova I/SQLiteConnection: /data/user/0/org.courville.nova/databases/media.db-wal 1751032 bytes: Bigger than 1048576; truncating
2022-02-04 19:44:04.127 4578-4953/org.courville.nova D/com.archos.mediascraper.AutoScrapeService: [Binder:4578_4] DEBUG c.a.mediascraper.AutoScrapeService - registerObserver: onChange getting 0 videos not yet scraped -> not launching service!
2022-02-04 19:44:04.581 4578-4953/org.courville.nova D/com.archos.mediascraper.AutoScrapeService: [Binder:4578_4] DEBUG c.a.mediascraper.AutoScrapeService - registerObserver: onChange getting 0 videos not yet scraped -> not launching service!
2022-02-04 19:44:05.049 4578-4953/org.courville.nova D/com.archos.mediascraper.AutoScrapeService: [Binder:4578_4] DEBUG c.a.mediascraper.AutoScrapeService - registerObserver: onChange getting 0 videos not yet scraped -> not launching service!
2022-02-04 19:44:05.546 4578-4953/org.courville.nova D/com.archos.mediascraper.AutoScrapeService: [Binder:4578_4] DEBUG c.a.mediascraper.AutoScrapeService - registerObserver: onChange getting 0 videos not yet scraped -> not launching service!
2022-02-04 19:44:06.023 4578-4953/org.courville.nova D/com.archos.mediascraper.AutoScrapeService: [Binder:4578_4] DEBUG c.a.mediascraper.AutoScrapeService - registerObserver: onChange getting 0 videos not yet scraped -> not launching service!
2022-02-04 19:44:06.444 4578-4953/org.courville.nova D/com.archos.mediascraper.AutoScrapeService: [Binder:4578_4] DEBUG c.a.mediascraper.AutoScrapeService - registerObserver: onChange getting 0 videos not yet scraped -> not launching service!
2022-02-04 19:45:00.173 4578-4808/org.courville.nova I/System.out: 19:45:00,172 |-INFO in ReconfigureOnChangeTask(born:1643993040168) - Empty watch file list. Disabling 
courville commented 2 years ago

OK thanks let's add in logback.xml files (both of them i.e. amazon and noamazon), this will provide more logs and insights:

    <logger name="com.archos.mediascraper.AutoScrapeService" level="DEBUG"/>
    <logger name="com.archos.mediaprovider.video.VideoStoreImportReceiver" level="DEBUG"/>
    <logger name="com.archos.mediaprovider.video.VideoStoreImportService" level="DEBUG"/>
    <logger name="com.archos.mediaprovider.video.VideoStoreImportImpl" level="DEBUG"/>

and restart the whole app data cleaning relaunch. You can zip the logs and if you do not want to share with all, email is fine.

bronnel commented 2 years ago

@courville , I just new debug logs, BTW is it safe to share those logs here publically to be seen by other people I mean?

courville commented 2 years ago

Thanks for sharing the logs. Yes I think this is safe to share.

bronnel commented 2 years ago

@courville , are logs provide good info , or should I send you more?

courville commented 2 years ago

Unfortunately not. Will try to add more logs.

courville commented 2 years ago

OK you are off the hook: I can reproduce on my wife's phone (samsung galaxy s9).

bronnel commented 2 years ago

@courville , Thank god , I'm not the only one hhhhh

courville commented 2 years ago

First bug: import in loop not finishing

D/com.archos.mediaprovider.video.VideoStoreImportImpl(  920): copyData: new batch fetching cursor from index=4974, window=0 -> index+window=4974<=4974
courville commented 2 years ago

@bronnel please confirm that this fixes the issue on your side (it does on my side...). Nasty bug.

bronnel commented 2 years ago

@courville , problem solved thanks to you, you can close the issue now, Thank you again

courville commented 2 years ago

Thanks for reporting it and the support!