vlc playing only first track in m3u playlist

[dhdurgee]

No, it should be at the root of your internal memory. Something like /storage/emulated/0/vlc_logcat_[XXX].log

Perhaps it should be, but it isn't there. I also confirmed I can write a file there.

Code: Select all

SEI700TM:/storage/emulated/0 $ ls -l total 60 drwx------ 2 u0_a68 u0_a68 4096 2021-11-23 06:56 Alarms drwxrws--x 5 media_rw media_rw 4096 2021-11-23 06:56 Android drwx------ 2 u0_a68 u0_a68 4096 2021-11-23 06:56 Audiobooks drwx------ 2 u0_a68 u0_a68 4096 2022-04-22 07:15 Bluetooth drwx------ 2 u0_a68 u0_a68 4096 2021-11-23 06:56 DCIM drwx------ 2 u0_a68 u0_a68 4096 2021-11-23 06:56 Documents drwx------ 2 u0_a68 u0_a68 4096 2023-04-18 11:04 Download drwx------ 3 u0_a68 u0_a68 4096 2021-11-23 06:56 Movies drwx------ 3 u0_a68 u0_a68 4096 2022-09-04 11:34 Music drwx------ 2 u0_a68 u0_a68 4096 2021-11-23 06:56 Notifications drwx------ 3 u0_a68 u0_a68 4096 2021-11-23 06:56 Pictures drwx------ 2 u0_a68 u0_a68 4096 2021-11-23 06:56 Podcasts drwx------ 2 u0_a68 u0_a68 4096 2021-11-23 06:56 Ringtones drwx------ 2 u0_a68 u0_a68 4096 2022-04-23 20:12 irControl drwx------ 3 u0_a68 u0_a68 4096 2022-04-22 14:20 logs SEI700TM:/storage/emulated/0 $ ls -l >ls-l.log SEI700TM:/storage/emulated/0 $ ls -l total 64 drwx------ 2 u0_a68 u0_a68 4096 2021-11-23 06:56 Alarms drwxrws--x 5 media_rw media_rw 4096 2021-11-23 06:56 Android drwx------ 2 u0_a68 u0_a68 4096 2021-11-23 06:56 Audiobooks drwx------ 2 u0_a68 u0_a68 4096 2022-04-22 07:15 Bluetooth drwx------ 2 u0_a68 u0_a68 4096 2021-11-23 06:56 DCIM drwx------ 2 u0_a68 u0_a68 4096 2021-11-23 06:56 Documents drwx------ 2 u0_a68 u0_a68 4096 2023-04-18 11:04 Download drwx------ 3 u0_a68 u0_a68 4096 2021-11-23 06:56 Movies drwx------ 3 u0_a68 u0_a68 4096 2022-09-04 11:34 Music drwx------ 2 u0_a68 u0_a68 4096 2021-11-23 06:56 Notifications drwx------ 3 u0_a68 u0_a68 4096 2021-11-23 06:56 Pictures drwx------ 2 u0_a68 u0_a68 4096 2021-11-23 06:56 Podcasts drwx------ 2 u0_a68 u0_a68 4096 2021-11-23 06:56 Ringtones drwx------ 2 u0_a68 u0_a68 4096 2022-04-23 20:12 irControl drwx------ 3 u0_a68 u0_a68 4096 2022-04-22 14:20 logs -rw------- 1 u0_a68 u0_a68 996 2023-05-11 09:37 ls-l.log SEI700TM:/storage/emulated/0 $

It likewise is not in the root of the mounted USB drive:

Code: Select all

SEI700TM:/storage/emulated/0 $ ls -l /storage/FA29-7738/ total 224 drwxrwx--- 2 root media_rw 16384 2022-06-13 12:25 Alarms drwxrwx--- 4 root media_rw 16384 2022-06-17 20:57 Android drwxrwx--- 2 root media_rw 16384 2022-06-13 12:25 Audiobooks drwxrwx--- 2 root media_rw 16384 2022-06-13 12:25 DCIM drwxrwx--- 2 root media_rw 16384 2022-06-13 12:25 Documents drwxrwx--- 2 root media_rw 16384 2023-04-18 11:06 Download drwxrwx--- 2 root media_rw 16384 2022-06-13 12:25 LOST.DIR drwxrwx--- 3 root media_rw 16384 2022-06-13 12:25 Movies drwxrwx--- 19 root media_rw 16384 2023-03-15 15:21 Music drwxrwx--- 2 root media_rw 16384 2022-06-13 12:25 Notifications drwxrwx--- 3 root media_rw 16384 2022-06-13 12:25 Pictures drwxrwx--- 2 root media_rw 16384 2022-06-13 12:25 Podcasts drwxrwx--- 2 root media_rw 16384 2022-06-13 12:25 Ringtones drwxrwx--- 2 root media_rw 16384 2022-06-13 19:02 Videos SEI700TM:/storage/emulated/0 $

I have tried this multiple times and no file is created there.

Dave

PS: I don't know if this is meaningful. but I do see these files:

Code: Select all

SEI700TM:/storage/emulated/0 $ ls -l logs/error total 10084 -rw------- 1 u0_a68 u0_a68 2968311 2023-05-10 09:03 app-GZ21060134722877-20230510-090259-APP-003_372.tar.gz -rw------- 1 u0_a68 u0_a68 3013801 2023-05-10 11:50 app-GZ21060134722877-20230510-114948-APP-003_372.tar.gz -rw------- 1 u0_a68 u0_a68 3034476 2023-05-11 08:55 app-GZ21060134722877-20230511-085459-APP-003_372.tar.gz -rw------- 1 u0_a68 u0_a68 636112 2023-05-09 14:26 cpu-GZ21060134722877-20230509-142605-CPU-004_111.tar.gz -rw------- 1 u0_a68 u0_a68 650430 2023-05-10 08:41 cpu-GZ21060134722877-20230510-084116-CPU-004_111.tar.gz SEI700TM:/storage/emulated/0 $

Could these be the logs you are looking for? Here is a link to download the latest one:

https://www.dropbox.com/s/c3fe489wcdf39 ... ar.gz?dl=0

[Aza]

You probably didn't tap the "Dump" button

[dhdurgee]

You probably didn't tap the "Dump" button

I did hit it. After I did so the shading shifted from the "START LOGGING" button to the "DUMP LOGCAT LOG" button.

Could something be different in this particular system?

Dave

[dhdurgee]

I don't know why hitting that "DUMP LOGCAT LOG" button does not create the file you want where you say it should be created. I don't know if it is simply not being created due to some sort of permission problem or if it is being created elsewhere in my file system.

I should note that I DO see some information in the logcat.txt file included with the file I posted a link to in my 11 May post show references to vlc and the single Beethoven track that loads and plays from the playlist listed in an earlier post. Is it possible that other entries in this logcat.txt might document why the file you want is not being created or where it wound up creating it?

Dave

PS: I don't know if this is relevant, but I spotted this in the logcat.txt file:

Code: Select all

05-11 08:54:17.753 16417 16905 E AndroidRuntime: FATAL EXCEPTION: Thread-6 05-11 08:54:17.753 16417 16905 E AndroidRuntime: Process: org.videolan.vlc:logger, PID: 16417 05-11 08:54:17.753 16417 16905 E AndroidRuntime: java.lang.NullPointerException: Parameter specified as non-null is null: method kotlin.jvm.internal.Intrinsics.checkNotNullParameter, parameter path 05-11 08:54:17.753 16417 16905 E AndroidRuntime: at android.os.Parcel.createExceptionOrNull(Parcel.java:2379) 05-11 08:54:17.753 16417 16905 E AndroidRuntime: at android.os.Parcel.createException(Parcel.java:2357) 05-11 08:54:17.753 16417 16905 E AndroidRuntime: at android.os.Parcel.readException(Parcel.java:2340) 05-11 08:54:17.753 16417 16905 E AndroidRuntime: at android.os.Parcel.readException(Parcel.java:2282) 05-11 08:54:17.753 16417 16905 E AndroidRuntime: at org.videolan.vlc.IDebugLogServiceCallback$Stub$Proxy.onSaved(IDebugLogServiceCallback.java:191) 05-11 08:54:17.753 16417 16905 E AndroidRuntime: at org.videolan.vlc.DebugLogService.sendMessage(DebugLogService.kt:106) 05-11 08:54:17.753 16417 16905 E AndroidRuntime: at org.videolan.vlc.DebugLogService.run(DebugLogService.kt:212) 05-11 08:54:17.753 16417 16905 E AndroidRuntime: at java.lang.Thread.run(Thread.java:923) 05-11 08:54:17.767 16417 16447 E AndroidRuntime: FATAL EXCEPTION: Thread-5 05-11 08:54:17.767 16417 16447 E AndroidRuntime: Process: org.videolan.vlc:logger, PID: 16417 05-11 08:54:17.767 16417 16447 E AndroidRuntime: java.lang.IllegalStateException: beginBroadcast() called while already in a broadcast 05-11 08:54:17.767 16417 16447 E AndroidRuntime: at android.os.RemoteCallbackList.beginBroadcast(RemoteCallbackList.java:242) 05-11 08:54:17.767 16417 16447 E AndroidRuntime: at org.videolan.vlc.DebugLogService.sendMessage(DebugLogService.kt:95) 05-11 08:54:17.767 16417 16447 E AndroidRuntime: at org.videolan.vlc.DebugLogService.onLog(DebugLogService.kt:120) 05-11 08:54:17.767 16417 16447 E AndroidRuntime: at org.videolan.tools.Logcat.run(Logcat.kt:75) 05-11 08:54:17.767 16417 16447 E AndroidRuntime: at java.lang.Thread.run(Thread.java:923) 05-11 08:54:17.785 16417 16447 E VLC/VlcCrashHandler: java.lang.IllegalStateException: beginBroadcast() called while already in a broadcast 05-11 08:54:17.785 16417 16447 E VLC/VlcCrashHandler: at android.os.RemoteCallbackList.beginBroadcast(RemoteCallbackList.java:242) 05-11 08:54:17.785 16417 16447 E VLC/VlcCrashHandler: at org.videolan.vlc.DebugLogService.sendMessage(DebugLogService.kt:95) 05-11 08:54:17.785 16417 16447 E VLC/VlcCrashHandler: at org.videolan.vlc.DebugLogService.onLog(DebugLogService.kt:120) 05-11 08:54:17.785 16417 16447 E VLC/VlcCrashHandler: at org.videolan.tools.Logcat.run(Logcat.kt:75) 05-11 08:54:17.785 16417 16447 E VLC/VlcCrashHandler: at java.lang.Thread.run(Thread.java:923) 05-11 08:54:17.785 16417 16447 E VLC/VlcCrashHandler: at Android.MODEL(TVision HUB v2) 05-11 08:54:17.785 16417 16447 E VLC/VlcCrashHandler: at Android.VERSION(11) 05-11 08:54:17.785 16417 16447 E VLC/VlcCrashHandler: at Android.FINGERPRINT(TVision/SEI700TM/SEI700TM:11/RTT0.210618.003/2487:user/release-keys) 05-11 08:54:17.787 16417 16905 E VLC/VlcCrashHandler: java.lang.NullPointerException: Parameter specified as non-null is null: method kotlin.jvm.internal.Intrinsics.checkNotNullParameter, parameter path 05-11 08:54:17.787 16417 16905 E VLC/VlcCrashHandler: at android.os.Parcel.createExceptionOrNull(Parcel.java:2379) 05-11 08:54:17.787 16417 16905 E VLC/VlcCrashHandler: at android.os.Parcel.createException(Parcel.java:2357) 05-11 08:54:17.787 16417 16905 E VLC/VlcCrashHandler: at android.os.Parcel.readException(Parcel.java:2340) 05-11 08:54:17.787 16417 16905 E VLC/VlcCrashHandler: at android.os.Parcel.readException(Parcel.java:2282) 05-11 08:54:17.787 16417 16905 E VLC/VlcCrashHandler: at org.videolan.vlc.IDebugLogServiceCallback$Stub$Proxy.onSaved(IDebugLogServiceCallback.java:191) 05-11 08:54:17.787 16417 16905 E VLC/VlcCrashHandler: at org.videolan.vlc.DebugLogService.sendMessage(DebugLogService.kt:106) 05-11 08:54:17.787 16417 16905 E VLC/VlcCrashHandler: at org.videolan.vlc.DebugLogService.run(DebugLogService.kt:212) 05-11 08:54:17.787 16417 16905 E VLC/VlcCrashHandler: at java.lang.Thread.run(Thread.java:923) 05-11 08:54:17.787 16417 16905 E VLC/VlcCrashHandler: at Android.MODEL(TVision HUB v2) 05-11 08:54:17.787 16417 16905 E VLC/VlcCrashHandler: at Android.VERSION(11) 05-11 08:54:17.787 16417 16905 E VLC/VlcCrashHandler: at Android.FINGERPRINT(TVision/SEI700TM/SEI700TM:11/RTT0.210618.003/2487:user/release-keys) 05-11 08:54:17.819 564 3583 I system_server: oneway function results will be dropped but finished with status OK and parcel size 4 05-11 08:54:18.277 16417 16905 I Process : Sending signal. PID: 16417 SIG: 9 05-11 08:54:18.304 564 3583 I ActivityManager: Process org.videolan.vlc:logger (pid 16417) has died: vis BTOP 05-11 08:54:18.305 564 3583 W ActivityManager: Scheduling restart of crashed service org.videolan.vlc/.DebugLogService in 1000ms for start-requested

This is around the time I was attempting to log the problem, but I don't know how it relates to my actions.

[dhdurgee]

I have tried multiple times to create the requested logcat and none of them have created a file in the storage root directory. Given this either the file is being created elsewhere or is not being created at all. At this point I suspect it is not being created for some reason. Look at the following via adb shell:

Code: Select all

SEI700TM:/storage $ find -ctime -7 . ./FA29-7738/Music/.thumbnails ./FA29-7738/Pictures/.thumbnails ./FA29-7738/Movies/.thumbnails ./emulated ./emulated/0/Pictures/.thumbnails ./emulated/0/Music/.thumbnails ./emulated/0/logs/error ./emulated/0/Android/data find: ./emulated/0/Android/data: Permission denied ./emulated/0/Android/obb find: ./emulated/0/Android/obb: Permission denied ./emulated/0/Movies/.thumbnails ./self ./self/primary 1|SEI700TM:/storage $

This appears to show no such file created in the past week.

What else can I do to get you what you need?

Dave

[Aza]

This is really weird as nobody complained about not able to create the logs. What you can do is "copy" instead of "dump" and then paste it in a text file.

[dhdurgee]

OK, I did the following:

1) Start Logging
2) Clear log
3) goto playlists and load one playlist
4) back up and load the Beethoven playlist (only the first file shows up to be played)
5) started playback
6) copied log to clipboard

Here is the log:

https://www.dropbox.com/s/nwrdb3mkaod80 ... g.txt?dl=0

The extended time range is because I had to go shopping before I could figure out how to get at the log in the clipboard.

I'm not sure there is anything in this that reflects the processing of the playlist file.

Let me know if this helps and if not what else I can do.

Dave

[dhdurgee]

Did the latest logs I finally figured out how to copy/paste and make available shed any light on this?

This whole issue is a puzzle, as my post on 23 April at 20:23 shows that each line of the m3u file in question references an accessible file. Why only the first line is being loaded into the playlist is the problem. This is the only m3u I have created with this problem.

Dave

[Aza]

I don't get it. The logs doesn't show any playback other than the first track, nor any error. How do you start your playlist: could you tell me exactly where you go in the app and on what you click?

[dhdurgee]

I don't get it. The logs doesn't show any playback other than the first track, nor any error. How do you start your playlist: could you tell me exactly where you go in the app and on what you click?

The error occurs during the processing to load the m3u file. As you can see from my post on 23 April at 20:23 the m3u file contains a list of present and accessible files, but only the first one gets loaded for playback.

The steps below created the last log you saw:

1) start logging
2) clear log
3) back arrow 4 times to main menu
4) up cursor 3 times to "Playlists"
5) "OK" to enter playlists line
6) "OK" to enter alphabetic list of playlists
7) right cursor to highlight "Beethoven" playlist
"OK" to select and start playback
9) wait for playback to finish
10) back arrow 4 times to main menu
11) down arrow 3 times to "Other"
12) "OK" to enter other list
13) "OK" to enter settings
14) proceed to debug log and copy to clipboard
15) save clipboard contents as a file

When I hit the OK in step 8 playback starts and only the first entry in the playlist shows to be played.

If I missed anything above let me know.

Dave

[Aza]

So, to make it clear: in that screen, you only have Beethoven, right?

[dhdurgee]

The image should be above, don't know why it isn't showing. Here is a link:

https://www.dropbox.com/s/vy2grbpcjp9xb ... n.jpg?dl=0


Dave

[dhdurgee]

Also, to be clear, there is only one Beethoven.m3u on the system:

Code: Select all

SEI700TM:/storage/FA29-7738 $ find ../emulated/0/Music/ -name 'Beethoven.m3u' SEI700TM:/storage/FA29-7738 $ find . -name 'Beethoven.m3u' ./Music/Beethoven.m3u SEI700TM:/storage/FA29-7738 $

So there is no possibility of a file of the same name being processed by vlc with different content.

Dave

[Aza]

Ok! If all the tracks are not shown here, it's a medialibrary issue then. Could you list the files in /storage/FA29-7738/Music/Beethoven/Symp_1/ ?

[dhdurgee]

Ok! If all the tracks are not shown here, it's a medialibrary issue then. Could you list the files in /storage/FA29-7738/Music/Beethoven/Symp_1/ ?

Code: Select all

SEI700TM:/storage/FA29-7738 $ ls -l Music/Beethoven/Symp_1 total 18752 -rwxrwx--- 1 root media_rw 6731701 2022-06-13 18:42 05-Symphony_#1,_Op_21__Adagio_molto-_Allegro_con_brio.mp3 -rwxrwx--- 1 root media_rw 5056027 2022-06-13 18:42 06-Andante_cantabile_con_moto.mp3 -rwxrwx--- 1 root media_rw 2739560 2022-06-13 18:42 07-Menuatto-_Allegro_molto_e_vivace.mp3 -rwxrwx--- 1 root media_rw 4592344 2022-06-13 18:42 08-Adagio;_Allegro_molto_e_vivace.mp3 -rwxrwx--- 1 root media_rw 1994 2022-06-13 18:42 Symphonies\ Nos.\ 1\ &\ 3.log -rwxrwx--- 1 root media_rw 636 2022-06-13 18:42 mp3gain.log -rwxrwx--- 1 root media_rw 756 2022-06-13 18:42 mp3gain.rpt SEI700TM:/storage/FA29-7738 $

[dhdurgee]

Ok! If all the tracks are not shown here, it's a medialibrary issue then. Could you list the files in /storage/FA29-7738/Music/Beethoven/Symp_1/ ?

Can debugging be enabled for the medialibrary module? If the problem is there I would expect a debug log to show what is causing it to return only the first of 38 tracks in a playlist.

Dave

[Aza]

Someone from the medialibrary team is looking into it. In the meantime, could you please tell me what happens if you try to launch the playlist from the in-app browser? If it fails the same way, could you please share some logs again?

[dhdurgee]

Someone from the medialibrary team is looking into it. In the meantime, could you please tell me what happens if you try to launch the playlist from the in-app browser? If it fails the same way, could you please share some logs again?

Launching from the browser does load the entire playlist. Behavior is different as display does not go immediately to the "Playing" screen, but when I go to it I see the first entry playing and the others loaded to play afterwards.

Dave

[dhdurgee]

Does the behavior I am seeing give the medialibrary team what they need to track this down and correct it? If not, tell me what else I can do.

Dave

[dhdurgee]

Has the medialibrary team created an issue for this? Do they need any additional information from me to recreate it and develop a fix?

Dave