I set iTunesUpdate logging to Debug, and played a song. Here's the log file:
[11-01-10 21:08:59.9927] Plugins::iTunesUpdate::Plugin::startTimingNewSong (1101) Starting a new song [11-01-10 21:08:59.9932] Plugins::iTunesUpdate::Plugin::getTrackObject (1325) Getting Track for URL file:///D:/My%20Music/iTunes/iTunes%20Music/Simply%20Red/Men%20And%20Women/01%20The%20Right%20Thing.mp3 [11-01-10 21:08:59.9990] Plugins::iTunesUpdate::Plugin::_searchiTunes (1575) URL: file:///D:/My%20Music/iTunes/iTunes%20Music/Simply%20Red/Men%20And%20Women/01%20The%20Right%20Thing.mp3 [11-01-10 21:08:59.9993] Plugins::iTunesUpdate::Plugin::_searchiTunes (1577) fileLoc: D:\My Music\iTunes\iTunes Music\Simply Red\Men And Women\01 The Right Thing.mp3 [11-01-10 21:08:59.9997] Plugins::iTunesUpdate::Plugin::_searchiTunes (1594) Searching iTunes for "Simply Red Men And Women The Right Thing" [11-01-10 21:09:00.0241] Plugins::iTunesUpdate::Plugin::_searchiTunesWin (1628) Found 1 track(s) in iTunes [11-01-10 21:09:00.0288] Plugins::iTunesUpdate::Plugin::_searchiTunesWin (1641) Found track in iTunes [11-01-10 21:09:00.0308] Plugins::iTunesUpdate::Plugin::getTrackObject (1329) Getting Track for ID track.id=17719 [11-01-10 21:09:00.0336] Plugins::iTunesUpdate::Plugin::startTimingNewSong (1151) Starting to time file:///D:/My%20Music/iTunes/iTunes%20Music/Simply%20Red/Men%20And%20Women/01%20The%20Right%20Thing.mp3 [11-01-10 21:09:00.6530] Plugins::iTunesUpdate::Plugin::stopTimingSong (1214) Stopping timing file:///D:/My%20Music/iTunes/iTunes%20Music/Simply%20Red/Men%20And%20Women/01%20The%20Right%20Thing.mp3 [11-01-10 21:09:00.6534] Plugins::iTunesUpdate::Plugin::getActionForTrackPlay (1259) Time actually played in track: 0.655 [11-01-10 21:09:00.6536] Plugins::iTunesUpdate::Plugin::getActionForTrackPlay (1279) "The Right Thing" NOT played long enough: Played 0.655; needed to play 5 seconds. [11-01-10 21:09:00.6538] Plugins::iTunesUpdate::Plugin::startTimingNewSong (1101) Starting a new song [11-01-10 21:09:00.6540] Plugins::iTunesUpdate::Plugin::getTrackObject (1325) Getting Track for URL file:///D:/My%20Music/iTunes/iTunes%20Music/Simply%20Red/Men%20And%20Women/01%20The%20Right%20Thing.mp3 [11-01-10 21:09:00.6554] Plugins::iTunesUpdate::Plugin::_searchiTunes (1575) URL: file:///D:/My%20Music/iTunes/iTunes%20Music/Simply%20Red/Men%20And%20Women/01%20The%20Right%20Thing.mp3 [11-01-10 21:09:00.6556] Plugins::iTunesUpdate::Plugin::_searchiTunes (1577) fileLoc: D:\My Music\iTunes\iTunes Music\Simply Red\Men And Women\01 The Right Thing.mp3 [11-01-10 21:09:00.6559] Plugins::iTunesUpdate::Plugin::_searchiTunes (1594) Searching iTunes for "Simply Red Men And Women The Right Thing" [11-01-10 21:09:00.6799] Plugins::iTunesUpdate::Plugin::_searchiTunesWin (1628) Found 1 track(s) in iTunes [11-01-10 21:09:00.6815] Plugins::iTunesUpdate::Plugin::_searchiTunesWin (1641) Found track in iTunes [11-01-10 21:09:00.6827] Plugins::iTunesUpdate::Plugin::getTrackObject (1329) Getting Track for ID track.id=17719 [11-01-10 21:09:00.6853] Plugins::iTunesUpdate::Plugin::startTimingNewSong (1151) Starting to time file:///D:/My%20Music/iTunes/iTunes%20Music/Simply%20Red/Men%20And%20Women/01%20The%20Right%20Thing.mp3 [11-01-10 21:13:08.9463] Plugins::iTunesUpdate::Plugin::stopTimingSong (1214) Stopping timing file:///D:/My%20Music/iTunes/iTunes%20Music/Simply%20Red/Men%20And%20Women/01%20The%20Right%20Thing.mp3 [11-01-10 21:13:08.9468] Plugins::iTunesUpdate::Plugin::getActionForTrackPlay (1259) Time actually played in track: 248.291691 [11-01-10 21:13:08.9472] Plugins::iTunesUpdate::Plugin::getActionForTrackPlay (1286) "The Right Thing" was played long enough to count as played. [11-01-10 21:13:08.9476] Plugins::iTunesUpdate::Plugin::getActionForTrackPlay (1287) Played past percentage threshold of 155.1672 seconds. [11-01-10 21:13:08.9513] Plugins::iTunesUpdate::Plugin::_searchiTunes (1575) URL: file:///D:/My%20Music/iTunes/iTunes%20Music/Simply%20Red/Men%20And%20Women/01%20The%20Right%20Thing.mp3 [11-01-10 21:13:08.9517] Plugins::iTunesUpdate::Plugin::_searchiTunes (1577) fileLoc: D:\My Music\iTunes\iTunes Music\Simply Red\Men And Women\01 The Right Thing.mp3 [11-01-10 21:13:08.9575] Plugins::iTunesUpdate::Plugin::_searchiTunes (1594) Searching iTunes for "Simply Red Men And Women The Right Thing" [11-01-10 21:13:08.9965] Plugins::iTunesUpdate::Plugin::_searchiTunesWin (1628) Found 1 track(s) in iTunes [11-01-10 21:13:08.9989] Plugins::iTunesUpdate::Plugin::_searchiTunesWin (1641) Found track in iTunes [11-01-10 21:13:08.9998] Plugins::iTunesUpdate::Plugin::_logTrackToiTunes (1483) Marking as played in iTunes The times noted in the log file are exactly the same time as what my computer reports -- that's good. However, in iTunes the "Last played" value is exactly five hours less. That is, this song played at 9:13pm, but iTunes reports that it was played at 4:13pm. please note that i only played this song once, but it looks like the log file indicates it was played twice. that must be a reporting pattern i don't understand. so now what? :) -- eschurr ------------------------------------------------------------------------ eschurr's Profile: http://forums.slimdevices.com/member.php?userid=2007 View this thread: http://forums.slimdevices.com/showthread.php?t=84389 _______________________________________________ plugins mailing list [email protected] http://lists.slimdevices.com/mailman/listinfo/plugins
