movie playlist with 700+ files non-functional

[moothekow]

So - when I want to just watch a random movie - i just try to hit 'play' on my watched movies folder - which has approximately 700 files in it. It asks if I want to play all videos, or just unwatched, and regardless of which I select it does not begin playback. I can go and look at the 'now playing' playlist and see that all the videos have been added, however when I attempt to hit 'play now' on the 'now playing' playlist nothing happens (literally - the options window doesn't even go away - it just acts as if I haven't even tried to do anything).

This used to work for me, though it seems that it has stopped functioning as I added more movies. If I select a sub-folder in that directory that has less movies (say - 140) - it works just fine.

Also slightly bizzare - actually hitting the 'play' button on that smaller folder brings up a 'play all XXX videos in the "FolderName" folder' window, however hitting the 'play' button on the higher level folder with 700+ files in it does nothing. I have to actually hit the options button and try to select 'play XXX videos in this folder' from that screen.

I've reproduced this behavior both using my HD300 as well as a SageTV 9 client on windows.

Anyone have any clues or suggestions?

[Narflex]

Can you post the sagetv log file from when you reproduce this problem?

[moothekow]

I've attached both the server and client log. Part that seems relevant to me is:

Mon 1/2 13:29:38.238 [AsyncStartPlaylist@108a72] PooledThread ended w/ an exception: java.lang.NullPointerException
Mon 1/2 13:29:38.238 [AsyncStartPlaylist@108a72] java.lang.NullPointerException
Mon 1/2 13:29:38.238 [AsyncStartPlaylist@108a72] at sage.Playlist.verifyPlaylist(Playlist.java:989)
Mon 1/2 13:29:38.238 [AsyncStartPlaylist@108a72] at sage.Playlist.verifyPlaylist(Playlist.java:967)
Mon 1/2 13:29:38.238 [AsyncStartPlaylist@108a72] at sage.VideoFrame.startPlaylist(VideoFrame.java:506)
Mon 1/2 13:29:38.238 [AsyncStartPlaylist@108a72] at sage.api.MediaPlayerAPI$27$1.run(MediaPlayerAPI.java:556)
Mon 1/2 13:29:38.238 [AsyncStartPlaylist@108a72] at sage.Pooler$PooledThread.run(Pooler.java:252)

Airing aid = wiz.getAiringForID(((Integer) segments.get(i)).intValue());
MediaFile mf = wiz.getFileForAiring(aid);
989: if (mf == null && (aid.isMusic() || (!aid.isMusic() && aid.getEndTime() < Sage.time())))
{

Would mean it's "Airing" object is null for one of the segments?

I don't have anything music imported into Sage at all.. Also - get that same call stack when attempting to play from the "now Playing" playlist screen.

Also - noticing a lot of exceptions in some sort routine - hitting a null pointer exception in Database.java on line 1947:

return (invertOrder ? -1 : 1) *
(USE_COLLATOR_SORTING ? collie.compare(trimPronouns(c1.getEpisodeName()), trimPronouns(c2.getEpisodeName())) :
trimPronouns(c1.getEpisodeName()).compareToIgnoreCase(trimPronouns(c2.getEpisodeName())));

Also - probably a completely unrelated thing - but for some reason one of my OTA channels doesn't show up in my guide -- it's enabled, i can preview the channel -- but it simply isn't listed - is skipped right over in guide. Should see channels 6, 10, 23, 47 -- but just see 6, 23, 47 .. just sharing to share in case that could somehow be indicative of some sort of DB corruption in something somewhere (assuming it is totally unrelated though :-).

[Narflex]

Yeah, Airing is null for some reason...that's the only way you'd get an NPE on that line. Not sure why that would be the case though. This should probably manifest itself in other ways though...such as a blank entry somewhere in the UI. Although on startup, SageTV ensures that all MediaFile objects have an Airing object linked to them and discards any MediaFile objects without one.

Are you comfortable modifying the Java code, recompiling it and then testing with a new JAR file? If we did that, then we could pinpoint the precise cause with some extra logging.

This also might be related to the STV you are using as it may not be filtering certain things out properly and trying to add them to a playlist (such as the DVD Drive or buffered preview streams).

There is something funky about your DB though because this line really shouldn't be showing up in the log at all:

Mon 1/2 13:24:02.652 [main@1d3c9ab] WARNING: INVALID AIRING DURATIONS DETECTED...CLEAN THE DATABASE!

That's a fix for a bug that was introduced many years ago that should not be showing up again. The only way I could see it happening now is if there's a .properties file for an imported media file with a negative value for the "AiringDuration" property.

For your OTA lineup issue...are you sure that channel isn't also mapped to another number? (i.e. it has more than one entry in Channel Setup) because then it will just pick one of the numbers to use for showing it in the Guide.

[moothekow]

I could try recompiling a try... I wouldn't say I'm uncomfortable (been a professional developer for the last 20 years - first 10 in the c++/directshow/MFC world, last ten using .NET and C#) - just never actually done anything in java (Aside from a couple super minor learn-how-it-works android apps a couple years back). So - can do it - just a mild learning curve for me to take the time to figure out how to set up an environment to compile (been some time since i've used anything other than MS Visual Studio :-).

I'm using Gemstone -- and just using the folder view exclusively for navigation.

Going to try grepping through the files to see if I can find any invalid AiringDuration entries -- will let you know what I find. UPDATE: Only thing I found was 'AiringDuration =' -- with no values to the right ever in any files.

Btw - figured out the channel thing. I had 'WILX' (the local station) from my cable provider mapped to channel 999 -- but apparently that that affected my OTA channel line-up as well where my 'WILX' was mapped as channel 10.

[Narflex]

You should have no problem rebuilding it then. If you just install the JDK and then download the source from GitHub, you can easily build the Sage.jar file by running gradlew.bat. It should end up in the build/release folder. But I found more info in the log...so you may not need to do that.

I took a look at the log again, I had forgotten I do log more information about the invalid durations. Apparently they are both from audio files.

Mon 1/2 13:23:57.719 [main@1d3c9ab] BAD AIRING DURATION: id=473262 showID=17935 time=1432043399270 duration=-1 mask= M

Mon 1/2 13:23:57.719 [main@1d3c9ab] BAD AIRING DURATION: id=473263 showID=17939 time=1432043390487 duration=-1 mask= M

mask=M indicates they are music. I don't think they are part of the problem, so we will just ignore that for now since resolving that likely won't matter much.

Then I looked at the playlist thing again and found something very relevant when it printed out all the playlist entries before starting to play it:

A[477757,146753,"Valentine's Day",0@0516.15:00,124,V], A[477758,146782,"Walk of Shame",0@0607.13:07,94,V], A[477759,146801,"Wanderlust",0@0608.08:34,98,V], null, A[477760,146818,"Warrior",0@1207.17:10,140,V], A[477729,146253,"The Watch",0@1101.20:44,102,V], A[477761,146842,"Watchmen",0@1124.11:35,215,V]

Notice that null in there? Since it's in alphabetical order, you should then be able to identify the rogue entry in the UI. Let me know what you find.

[moothekow]

Weirdness on the music - I don't currently have any music import folders set up. I literally have a single folder in my import directories setup -- and only import 'videos'.

So far as the blank entry -- I found it -- showed it as a blank entry on the list -- though I could select it and it gave me the media's file path/information. Deleted the .property file associated with the file, then moved the file out of my import folder and did a library rescan.

As expected - it removed the entry - and now the play all works swimmingly.

And once I knew it worked without that - moved the file back and re-scanned again (in case there was something wonky/reproducible about the specific media file) - and it worked just fine.

Looks like some sort of fluke thing I guess.

Thanks a lot for your help figuring that out. Now I can once again hit shuffle play on my watched movies folders to start playing a random movie to fall asleep to at night :-).

[Narflex]

Glad to see it resolved...and I was wondering why you would do playlists like that.

[moldmaker78]

When I go to videos and select a folder it will say "play all xxx videos now" except one folder.
That folder has all the Simpsons we recorded.(609)
Subfolders allows the play all option.
This has been the same since Ver 7
Thought there was a limit on number of files in a folder?