iTunesUpdater does not find track

[Lobotomizer]

Certain tracks do not get their stats updated in Itunes by the iTunesUpdate plugin when I play them. I checked the logs and it says the track cannot be found. I tried clearing and rescanning my music library, no result.
Are there any known circumstances under which this could happen? The band name happens to have a ! in it, illegal characters maybe?

Just to be clear, other tracks are updated fine so it's not the plugin malfunctioning completely.

[James]

Which OS are you using? I think there are still some issues on the Mac with UTF8 characters.

Although I had a track on Windows yesterday that wasn't working - first time in ages...

If you check the log after playing the track in question there may be some useful output printed.
If not, try changing the plugin.itunesupdate log level to Debug.

James

--------------------------------------------------------------------------
NOTICE: If received in error, please destroy, and notify sender. Sender does not intend to waive confidentiality or privilege. Use of this email is prohibited when received in error. We may monitor and store emails to the extent permitted by applicable law.

[Lobotomizer]

The OS is Windows XP SP3, iTunes version 9.0.1 (9.0.2 since yesterday), iTunesUpdate the latest version (2.7.1 I believe), Squeezecenter 7.4.1.

The log file reads for this particular track:

[09-10-26 23:24:58.5730] Plugins::iTunesUpdate::Plugin::startTimingNewSong (1101) Starting a new song
[09-10-26 23:24:58.5734] Plugins::iTunesUpdate::Plugin::getTrackObject (1325) Getting Track for URL file:///F:/Music/Godspeed%20You%20Black%20Emperor!/Yanqui%20U.X.O/Godspeed%20You%20Black%20Emperor!%20-%20Yanqui%20U.X.O.%20-%2001%20-%2009-15-00%20(Part%20One).mp3
[09-10-26 23:24:58.5761] Plugins::iTunesUpdate::Plugin::_searchiTunes (1575) URL: file:///F:/Music/Godspeed%20You%20Black%20Emperor!/Yanqui%20U.X.O/Godspeed%20You%20Black%20Emperor!%20-%20Yanqui%20U.X.O.%20-%2001%20-%2009-15-00%20(Part%20One).mp3
[09-10-26 23:24:58.5765] Plugins::iTunesUpdate::Plugin::_searchiTunes (1577) fileLoc: F:\Music\Godspeed You Black Emperor!\Yanqui U.X.O\Godspeed You Black Emperor! - Yanqui U.X.O. - 01 - 09-15-00 (Part One).mp3
[09-10-26 23:24:58.5770] Plugins::iTunesUpdate::Plugin::_searchiTunes (1594) Searching iTunes for "Godspeed You! Black Emperor Yanqui U.X.O. 09-15-00 (Part One)"
[09-10-26 23:24:58.7037] Plugins::iTunesUpdate::Plugin::_getTrackDetailsFro miTunes (1469) Track: file:///F:/Music/Godspeed%20You%20Black%20Emperor!/Yanqui%20U.X.O/Godspeed%20You%20Black%20Emperor!%20-%20Yanqui%20U.X.O.%20-%2001%20-%2009-15-00%20(Part%20One).mp3 not found in iTunes


Can I get more logging than this?
Thanks, Rob

[James]

That's all there is.
I am sure I have some tracks with "!" in them so it seems unusual.
If you paste:
Godspeed You! Black Emperor Yanqui U.X.O. 09-15-00 (Part One)
into the iTunes search box does the track show up?

James


--------------------------------------------------------------------------
NOTICE: If received in error, please destroy, and notify sender. Sender does not intend to waive confidentiality or privilege. Use of this email is prohibited when received in error. We may monitor and store emails to the extent permitted by applicable law.

[Philip Meyer]

>Godspeed You! Black Emperor
That should be "Godspeed You Black Emperor!"

[James]

Hey good point.
Looks like the OP has some issues with conflicting tags in their files?

James

--------------------------------------------------------------------------
NOTICE: If received in error, please destroy, and notify sender. Sender does not intend to waive confidentiality or privilege. Use of this email is prohibited when received in error. We may monitor and store emails to the extent permitted by applicable law.

[Lobotomizer]

Hmm, I see what you're saying. Funny enough, there's always been some confusion where the ! belongs in this band's name...

But I don't understand what's going on: in most places in the log I see it quoting the full URL for the actual mp3 file. This one has the ! at the end of the band name. This is exactly how the file is stored on disc (no surprise there I guess).
There's one call to _searchiTunes that reads something different and has the ! in the middle of the band name. Indeed, the alternative spelling so after your comments I expected a wrong tag. But: I checked the tags in mp3tag and I see no tag that has this value, the ! is at the end of the artist name here as well.

What tag is this particular call based on?

(btw if I enter that value in iTunes search nothing shows up. I can remove/add the album again and see if that helps but I recently regenerated my complete iTunes library so I don't really expect outdated tags)

[Philip Meyer]

>But I don't understand what's going on: in most places in the log I see
>it quoting the full URL for the actual mp3 file. This one has the ! at
>the end of the band name. This is exactly how the file is stored on disc
>(no surprise there I guess).
>
If it uses the artist search name database field, it could be that it's picked up the wrong name from bad tags (could be from another source file). If the artist name matches, it may not take or read the correct artist sort tag content.

Could be due to this: http://bugs.slimdevices.com/show_bug.cgi?id=10324

I suggest you check all of your artist/artist sort tags are the same across all of your Godspeed You Black Emperor! songs, and then do a full clean+rescan.

Or, get MySQL Query Browser, connect to the Squeezebox Server DB, and check to see what the database holds internally for any contributor like '%godspeed%'

[Lobotomizer]

Thanks, this solved my problem! I checked in iTunes and another album had the alternative spelling of the artist name. So I made them consistent, rescanned the library, and iTunesUpdate can find the track now. Still think it is odd that it (is this the plugin or SC itself?) considers these the same artist, tag issues like this are easier to track if you simply see the artist popping up twice in the list. Anyway, glad it's fixed.

While checking the logs it looks like there is another issue though. I see it starts timing the song, and after the song finished, there are a lot of exceptions in the log like the one below:

[09-11-02 20:50:30.0974] Plugins::iTunesUpdate::Plugin::startTimingNewSong (1151) Starting to time file:///F:/Music/Godspeed%20You%20Black%20Emperor!/Yanqui%20U.X.O/Godspeed%20You%20Black%20Emperor!%20-%20Yanqui%20U.X.O.%20-%2001%20-%2009-15-00%20(Part%20One).mp3
[09-11-02 21:09:51.1095] Slim::Schema::Storage::throw_exception (82) Error: DBI Exception: DBD::mysql::st execute failed: Can't create/write to file 'C:\Documents and Settings\All Users\Application Data\Squeezebox\Cache\MySQL\#sql_ce0_0.MYD' (Errcode: 13) [for Statement "SELECT contributor.id, contributor.name, contributor.namesort, contributor.musicmagic_mixable, contributor.namesearch, contributor.musicbrainz_id FROM contributor_track me JOIN contributors contributor ON contributor.id = me.contributor WHERE ( ( role IN ( ? ) AND me.track = ? ) ) GROUP BY contributor.id ORDER BY role desc"]
[09-11-02 21:09:51.1103] Slim::Schema::Storage::throw_exception (82) Backtrace:

frame 0: Slim::Utils::Log::logBacktrace (/<C:\PROGRA~1\SQUEEZ~1\server\SQUEEZ~3.EXE>Slim/Schema/Storage.pm line 82)
frame 1: Slim::Schema::Storage::throw_exception (/<C:\PROGRA~1\SQUEEZ~1\server\SQUEEZ~3.EXE>DBIx/Class/Storage/DBI.pm line 957)
frame 2: DBIx::Class::Storage:BI::__ANON__ (/<C:\PROGRA~1\SQUEEZ~1\server\SQUEEZ~3.EXE>DBIx/Class/Storage/DBI.pm line 1217)

.... (cut) ...

frame 22: Slim::Networking::IO::Select::__ANON__ (/<C:\PROGRA~1\SQUEEZ~1\server\SQUEEZ~3.EXE>Slim/Networking/IO/Select.pm line 183)
frame 23: (eval) (/<C:\PROGRA~1\SQUEEZ~1\server\SQUEEZ~3.EXE>Slim/Networking/IO/Select.pm line 183)
frame 24: Slim::Networking::IO::Select::loop (slimserver.pl line 620)
frame 25: main::idle (slimserver.pl line 574)
frame 26: main::main (slimserver.pl line 98)
frame 27: PerlSvc::Interactive (/<C:\PROGRA~1\SQUEEZ~1\server\SQUEEZ~3.EXE>PerlSvc. pm line 99)
frame 28: PerlSvc::_interactive (slimserver.pl line 0)
frame 29: (eval) (slimserver.pl line 0)

There are several of these. In the end it stops timing and marks the track as played so the end result is ok. I see similar exceptions in my scanner log, where they seem to abort the scan prematurely (Merge various artists fails in seemingly random spots). From the stack trace this does not look iTunesUpdate related, should I follow this one up in another forum?

[Philip Meyer]

>Thanks, this solved my problem! I checked in iTunes and another album
>had the alternative spelling of the artist name. So I made them
>consistent, rescanned the library, and iTunesUpdate can find the track
>now. Still think it is odd that it (is this the plugin or SC itself?)
>considers these the same artist, tag issues like this are easier to
>track if you simply see the artist popping up twice in the list. Anyway,
>glad it's fixed.
>
I believe that the Squeezebox Server scanner strips out punctuation from artist name tags to create a version of the name used for searching and uniqueness matching, rather than the artist name. So where the artist name differs only in diacritic characters or punctuation, these names are seen as the same, an one version of the artist name is taken as the name to report in the application. I think it's the first version of the artist name tag that is scanned that is used in the music library (and each time you rescan the library, you could get a different result as it could pick a different order to process files). You cannot correct tags and scan for new/changed files - the only way to fix it is the painfull process of finding the difference in tags, fix, and then do a full clean+rescan.

You may want to add your feelings to bug 10324 (http://bugs.slimdevices.com/show_bug.cgi?id=10324) and vote, or create a new bug (this bug was about diacritics, but the same seems to apply to punctuation too).

>While checking the logs it looks like there is another issue though. I
>see it starts timing the song, and after the song finished, there are a
>lot of exceptions in the log like the one below:
>
That could be the common issue of a firewall/virus scanner blocking access to *.myd file types.