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.


------------------------------------------------------------------------
goharbourview123's Profile: 
http://forums.slimdevices.com/member.php?userid=23031
View this thread: http://forums.slimdevices.com/showthread.php?t=96124

_______________________________________________
plugins mailing list
[email protected]
http://lists.slimdevices.com/mailman/listinfo/plugins

Reply via email to