Home of the Squeezebox™ & Transporter® network music players.
Page 2 of 6 FirstFirst 1234 ... LastLast
Results 11 to 20 of 53
  1. #11
    Senior Member
    Join Date
    Apr 2007
    Posts
    289
    Quote Originally Posted by pallfreeman View Post
    Just a thought: do you have dbhighmem enabled? (Settings->Advanced->Performance)
    Yes.

  2. #12
    I've also been having long start-up times with TrackStat (up to 20 minutes), and periodic pauses in playback with the server apparently unavailable (I think caused by Spicefly Sugarcube's interaction with TrackStat). Initially, I'd taken to disabling "Refresh on Startup" as a way around this, but followed the advice to set TrackStat logging to debug to narrow down the issue, and it seems that MusicBrainz ID's are the problem (I do have a fair few duplicate track ids from tracks duplicated from compilations). This is from the Server log:

    Code:
    [12-08-23 10:00:11.6192] main::init (354) Starting Logitech Media Server (v7.8.0, 1343433580, Wed Aug  8 03:08:53 PDT 2012) perl 5.014001
    
    (...)
    
    [12-08-23 10:00:15.8102] Plugins::TrackStat::Plugin::initPlugin (2426) initialising
    
    (...)
    
    [12-08-23 10:00:15.8372] Plugins::TrackStat::Storage::refreshTracks (1236) TrackStat: Synchronizing TrackStat data, please wait...
    [12-08-23 10:00:15.8374] Plugins::TrackStat::Storage::refreshTracks (1286) Starting to update urls in statistic data based on musicbrainz ids
    [12-08-23 10:15:30.5831] Plugins::TrackStat::Storage::refreshTracks (1365) Finished updating urls in statistic data based on musicbrainz ids, updated 52110 items : It took 914.745658 seconds
    [12-08-23 10:15:30.5834] Plugins::TrackStat::Storage::refreshTracks (1371) Starting analyzing track_statistics table
    [12-08-23 10:15:30.9292] Plugins::TrackStat::Storage::refreshTracks (1373) Finished analyzing track_statistics table : It took 0.345733 seconds
    [12-08-23 10:15:30.9294] Plugins::TrackStat::Storage::refreshTracks (1381) Starting to update md5 in statistic data based on urls
    [12-08-23 10:15:31.4172] Plugins::TrackStat::Storage::refreshTracks (1399) Finished updating md5 in statistic data based on urls, updated 0 items : It took 0.487631 seconds
    
    (...)
    
    [12-08-23 10:15:51.2225] Plugins::TrackStat::Plugin::postinitPlugin (2732) Added rating support for Plugins::TrackStat::Plugin
    [12-08-23 10:15:51.2228] Plugins::TrackStat::Plugin::postinitPlugin (2736) Added play count support for Plugins::TrackStat::Plugin
    So disabling MusicBrainz tags seemed to be the solution, but having this setting for a few days I noticed that TrackStat wasn't updating playcounts (because Spicefly Sugarcube started offering up more repeated songs that should have been blocked by playcount. I can't see any difference in the logs however:

    With Musicbrainz tags enabled, playcount incremented:
    Code:
    [12-09-04 15:15:34.1039] Plugins::TrackStat::Plugin::commandCallback65 (4133) Entering commandCallback65
    [12-09-04 15:15:34.1044] Plugins::TrackStat::Plugin::stopTimingSong (4358) Stopping timing file:///S:/My%20Music/Various%20Artists/Remix%20Trax,%20Volume%204%20-%20US%20House%20Issue/02~I%20Need%20You%20(Nu%20Solution%20Mix)%20(Feat.%20Tonya%20Wynne).flac
    [12-09-04 15:15:34.1046] Plugins::TrackStat::Plugin::stopTimingSong (4359) Total elapsed time in seconds: 422.837363 
    [12-09-04 15:15:34.1048] Plugins::TrackStat::Plugin::trackWasPlayedEnoughToCountAsAListen (4562) Time actually played in track: 422.837363
    [12-09-04 15:15:34.1050] Plugins::TrackStat::Plugin::trackWasPlayedEnoughToCountAsAListen (4580) "I Need You (Nu Solution Mix) (Feat. Tonya Wynne)" was played long enough to count as played.
    [12-09-04 15:15:34.1052] Plugins::TrackStat::Plugin::trackWasPlayedEnoughToCountAsAListen (4581) Played past percentage threshold of 215.933 seconds.
    [12-09-04 15:15:34.1054] Plugins::TrackStat::Plugin::markedAsPlayed (4455) Entering markedAsPlayed
    [12-09-04 15:15:34.1078] Plugins::TrackStat::Storage::findTrack (533) findTrack(): URL: file:///S:/My%20Music/Various%20Artists/Remix%20Trax,%20Volume%204%20-%20US%20House%20Issue/02~I%20Need%20You%20(Nu%20Solution%20Mix)%20(Feat.%20Tonya%20Wynne).flac
    [12-09-04 15:15:34.1099] Plugins::TrackStat::Storage::findTrack (533) findTrack(): URL: file:///S:/My%20Music/Various%20Artists/Remix%20Trax,%20Volume%204%20-%20US%20House%20Issue/02~I%20Need%20You%20(Nu%20Solution%20Mix)%20(Feat.%20Tonya%20Wynne).flac
    [12-09-04 15:15:34.1104] Plugins::TrackStat::Storage::savePlayCountAndLastPlayed (745) Marking as played in storage
    [12-09-04 15:15:34.1482] Plugins::TrackStat::Storage::addToHistory (802) Entering addToHistory
    [12-09-04 15:15:34.3309] Plugins::TrackStat::Storage::addToHistory (925) Exiting addToHistory
    [12-09-04 15:15:34.3320] Plugins::TrackStat::Plugin::markedAsPlayed (4502) Calling Plugins::TrackStat::Plugin
    [12-09-04 15:15:34.3322] Plugins::TrackStat::Plugin::setTrackStatStatistic (4997) Entering setTrackStatStatistic
    [12-09-04 15:15:34.4356] Plugins::TrackStat::Plugin::setTrackStatStatistic (5010) Exiting setTrackStatStatistic
    [12-09-04 15:15:34.4362] Plugins::TrackStat::Plugin::markedAsPlayed (4510) Exiting markedAsPlayed
    [12-09-04 15:15:34.4365] Plugins::TrackStat::Plugin::startTimingNewSong (4250) Starting a new song
    [12-09-04 15:15:34.4426] Plugins::TrackStat::Plugin::startTimingNewSong (4292) Starting to time file:///T:/My%20Music/Inner%20City/Testament%2093/02~Till%20We%20Meet%20Again%20(Brothers%20In%20Rhythm%20Mix).mp3
    [12-09-04 15:15:34.4429] Plugins::TrackStat::Plugin::commandCallback65 (4240) Exiting commandCallback65
    With Musicbrainz tags disabled, playcount not incrementing:
    Code:
    [12-09-04 15:22:41.2854] Plugins::TrackStat::Plugin::commandCallback65 (4133) Entering commandCallback65
    [12-09-04 15:22:41.2857] Plugins::TrackStat::Plugin::stopTimingSong (4358) Stopping timing file:///T:/My%20Music/Inner%20City/Testament%2093/02~Till%20We%20Meet%20Again%20(Brothers%20In%20Rhythm%20Mix).mp3
    [12-09-04 15:22:41.2859] Plugins::TrackStat::Plugin::stopTimingSong (4359) Total elapsed time in seconds: 426.709575 
    [12-09-04 15:22:41.2861] Plugins::TrackStat::Plugin::trackWasPlayedEnoughToCountAsAListen (4562) Time actually played in track: 426.709575
    [12-09-04 15:22:41.2863] Plugins::TrackStat::Plugin::trackWasPlayedEnoughToCountAsAListen (4580) "Till We Meet Again (Brothers In Rhythm Mix)" was played long enough to count as played.
    [12-09-04 15:22:41.2865] Plugins::TrackStat::Plugin::trackWasPlayedEnoughToCountAsAListen (4581) Played past percentage threshold of 218.0045 seconds.
    [12-09-04 15:22:41.2867] Plugins::TrackStat::Plugin::markedAsPlayed (4455) Entering markedAsPlayed
    [12-09-04 15:22:41.2887] Plugins::TrackStat::Storage::findTrack (533) findTrack(): URL: file:///T:/My%20Music/Inner%20City/Testament%2093/02~Till%20We%20Meet%20Again%20(Brothers%20In%20Rhythm%20Mix).mp3
    [12-09-04 15:22:41.2889] Plugins::TrackStat::Storage::findTrack (534) findTrack(): mbId: 0f81ea3e-aee2-4395-85a5-3f511281c9c3
    [12-09-04 15:22:41.2908] Plugins::TrackStat::Storage::findTrack (533) findTrack(): URL: file:///T:/My%20Music/Inner%20City/Testament%2093/02~Till%20We%20Meet%20Again%20(Brothers%20In%20Rhythm%20Mix).mp3
    [12-09-04 15:22:41.2910] Plugins::TrackStat::Storage::findTrack (534) findTrack(): mbId: 0f81ea3e-aee2-4395-85a5-3f511281c9c3
    [12-09-04 15:22:41.2915] Plugins::TrackStat::Storage::savePlayCountAndLastPlayed (745) Marking as played in storage
    [12-09-04 15:22:41.2920] Plugins::TrackStat::Storage::addToHistory (802) Entering addToHistory
    [12-09-04 15:22:41.3890] Plugins::TrackStat::Storage::addToHistory (925) Exiting addToHistory
    [12-09-04 15:22:41.3900] Plugins::TrackStat::Plugin::markedAsPlayed (4502) Calling Plugins::TrackStat::Plugin
    [12-09-04 15:22:41.3902] Plugins::TrackStat::Plugin::setTrackStatStatistic (4997) Entering setTrackStatStatistic
    [12-09-04 15:22:41.4107] Plugins::TrackStat::Plugin::setTrackStatStatistic (5010) Exiting setTrackStatStatistic
    [12-09-04 15:22:41.4111] Plugins::TrackStat::Plugin::markedAsPlayed (4510) Exiting markedAsPlayed
    [12-09-04 15:22:41.4113] Plugins::TrackStat::Plugin::startTimingNewSong (4250) Starting a new song
    [12-09-04 15:22:41.4159] Plugins::TrackStat::Plugin::startTimingNewSong (4292) Starting to time file:///S:/My%20Music/Various%20Artists/Warp%2010-2-%20The%20Classics%201989-1992/1.04~Hey%20Hey!%20Can%20U%20Relate.flac
    [12-09-04 15:22:41.4162] Plugins::TrackStat::Plugin::commandCallback65 (4240) Exiting commandCallback65
    Perhaps this is also a matter of how TrackStat and Spicefly Sugarcube play together?

    I wouldn't have thought hardware was a problem: running LMS Version: 7.8.0 - 1346230927 on Windows 7 64-bit, desktop PC with Intel Pentium Core Duo @2.4 GHz with 4GB RAM, and "Performance>Database Memory Config" set to High.

    As disabling "Refresh on Startup" seems to offer a viable workaround, I can't say this problem is urgent, but thought I'd contribute another data point.

  3. #13
    Senior Member
    Join Date
    Mar 2007
    Posts
    413
    I can't believe I came across this thread. I'm going through the same issue after parking at 7.3.4 for a couple of years with only musicip/sugarcube on my readynas pro (low end dual-core x86), I've recently moved to 7.7.2 and I'm going through the same growing pains. My old system had a couple of bugs but running LMS with Sugarcube/Erland suite on a Windows XP Virtualbox image, I'm seeing the odd time out and lots of loss of sync.

    Looking at task manager on the vm I'm not sure its a cpu issue, in my case at least I think its more I/O. I see spikes but in general once the scanning is done the cpu stays low. I'm using the high end database setting, but I don't see memory use of more than 1GB in total. There's another thread about moving the cache directory to a ram disk and that seems like it may have some merit. My cache directory is

    I don't have any start up issues, but my trackstat is pretty new so that could be something I have to look forward to. Please share any troubleshooting tips regarding logging as I've generally found the logs pretty cryptic.

  4. #14
    Senior Member erland's Avatar
    Join Date
    Dec 2005
    Location
    Sweden
    Posts
    11,290
    Quote Originally Posted by sander View Post
    I can't believe I came across this thread. I'm going through the same issue after parking at 7.3.4 for a couple of years with only musicip/sugarcube on my readynas pro (low end dual-core x86), I've recently moved to 7.7.2 and I'm going through the same growing pains. My old system had a couple of bugs but running LMS with Sugarcube/Erland suite on a Windows XP Virtualbox image, I'm seeing the odd time out and lots of loss of sync.

    Looking at task manager on the vm I'm not sure its a cpu issue, in my case at least I think its more I/O. I see spikes but in general once the scanning is done the cpu stays low. I'm using the high end database setting, but I don't see memory use of more than 1GB in total. There's another thread about moving the cache directory to a ram disk and that seems like it may have some merit. My cache directory is

    I don't have any start up issues, but my trackstat is pretty new so that could be something I have to look forward to. Please share any troubleshooting tips regarding logging as I've generally found the logs pretty cryptic.
    Are you using Custom Scan or only TrackStat ?
    The only situation where either Custom Scan or TrackStat can cause problems is:
    1. At startup
    2. During scanning
    3. When browsing either TrackStat menus or Custom Browse menus using Custom Scan data

    In 1 and 2, both TrackStat and Custom Scan runs refresh operations, I generally advice people to disable the startup refresh in their respective settings pages but keep the refresh after rescan if possible. The refresh operation is most important after you have renamed/moved a file.

    I plan to take a look at this to see if it's possible to optimize the refresh queries a bit, I think they have generally become a lot slower since the switch to SQLite database in 7.6. However, in the near future I need to prioritize some other things, but something that would help me is if people startup SBS/LMS with debug logging as I described earlier in this thread and post the log together with information about library size and which hardware you are using because that will show if everyone have issues with the same thing or if it's multiple issues depending on how your library looks like and which hardware you are using.

    I believe davidfox2116, the starter of this thread, mostly had issues with point 3 (browsing performance). What I've seen myself regarding this is that browsing performance can be a bit inconsistent depending on if the database data is cached by SQLite or if it needs to be retrieved from the disk. Usually it's first slow and after you have browse a menu it works fast for a while until the data is removed from the cache and then it's slow again until you have accessed it once again. This is a new problem with SQLite, it was a lot more consistent with MySQL as I remember it.
    Erland Isaksson (My homepage)
    Developer of many plugins/applets
    Starting with LMS 8.0 I no longer support my plugins/applets (see here for more information )

  5. #15
    Senior Member
    Join Date
    Mar 2007
    Posts
    413
    I'm only using trackstat so that makes sense. I'm still exploring your plugins, but I was primarily interested in trackstat, dynamic playlists, and sugarcube (not your problem of course) so that's most of what I'm using. My problems so far are hard to attribute to anything specific, but I do think there is an I/O slowdown if for no other reason than the extreme lag in the web ui sometimes.
    I think there are some issues with sqlite like you said. The speed and inconsistency of searches is frustrating. My understanding from other threads is you can force the backend to use mysql, but I'm unclear if all the plugins which appear to be hardcoded for sqlite (like sugarcube) will work, and you indicated there have been other optimizations made which would lost. It also seems there are no other changes that can be made to sqlite which will help along the same line as moonbase's tweaks to mysql.

  6. #16
    Senior Member pallfreeman's Avatar
    Join Date
    Apr 2010
    Location
    Squeezebox Graveyard
    Posts
    500
    Quote Originally Posted by sander View Post
    It also seems there are no other changes that can be made to sqlite which will help along the same line as moonbase's tweaks to mysql.
    If the comments in SQLiteHelper.pm are correct, dbhighmem changes the cache from 2MB to 20MB.

    Simply inserting a couple of 0s in there (cache_size = 2000 changed to 200000) allows the whole db to reside in memory. Easy unless you're running Windows.

    With just the default plugins, 200K+ tracks occupy about half a gig. There should be a "dbhugemem" pref.
    Don't push your love too far
    Your wounds won't leave a scar
    Right now is where you are
    In a broken dream.

  7. #17
    Senior Member
    Join Date
    Mar 2007
    Posts
    413
    Quote Originally Posted by pallfreeman View Post
    Easy unless you're running Windows.
    Why should this make a difference? I chose Windows because of the MusicIP stuff (1.9 beta goodies, compatible with 1.4 genpuid) maybe I need to reconsider? I have thought the smb access to my nas could be an issue as well, but my workstation is pretty fast.

  8. #18
    Senior Member erland's Avatar
    Join Date
    Dec 2005
    Location
    Sweden
    Posts
    11,290
    Quote Originally Posted by sander View Post
    Why should this make a difference? I chose Windows because of the MusicIP stuff (1.9 beta goodies, compatible with 1.4 genpuid) maybe I need to reconsider? I have thought the smb access to my nas could be an issue as well, but my workstation is pretty fast.
    Windows version of LMS is compiled into exe files, so you can't easily change the code.
    You can of course still install ActiveState perl and get the source code version of LMS, change the file and run it with ActiveState perl.
    Erland Isaksson (My homepage)
    Developer of many plugins/applets
    Starting with LMS 8.0 I no longer support my plugins/applets (see here for more information )

  9. #19
    Senior Member
    Join Date
    Mar 2007
    Posts
    413
    Quote Originally Posted by pallfreeman View Post
    With just the default plugins, 200K+ tracks occupy about half a gig. There should be a "dbhugemem" pref.
    It would be even better if there was a field where we could put a parameter. I'll have to see if there's a bug...

  10. #20
    Senior Member pallfreeman's Avatar
    Join Date
    Apr 2010
    Location
    Squeezebox Graveyard
    Posts
    500
    Quote Originally Posted by sander View Post
    It would be even better if there was a field where we could put a parameter. I'll have to see if there's a bug...
    +2. But:

    First, it would be classed as an "enhancement", so immediately it's given low priority.

    Second, it involves adding a new preference. For some reason the devs decided a few years ago that prefs were a bad thing, and seem very reluctant to add any new ones. I don't know if this is because it's such a pain (I could never get my head around the "migrate" function) or because of this newly omnipresent concept that people are stupid and can't deal with such dreadful complexity.

    Good luck, mate!
    Don't push your love too far
    Your wounds won't leave a scar
    Right now is where you are
    In a broken dream.

Tags for this Thread

Posting Permissions

  • You may not post new threads
  • You may not post replies
  • You may not post attachments
  • You may not edit your posts
  •