Semi-regularly, I am getting the Tagging Data from MusicBrainz sort of just quietly stops, and I sit there forever looking at the progress bar.
I look on both console and debug, and it says nothing about any problems or what is happening or what might be killing the thing or grinding it to a halt. Literally there are no new entries on the logs since I started the tagging process.
any other ideas?
eventually these errors show up on the console, although jaicoz is still doing nothing, silently.
14/01/2008 02.10.11:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:SEVERE: Problem doing RESTQuery:IOExceptionConnection reset
14/01/2008 02.14.12:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:SEVERE: Problem doing RESTQuery:IOExceptionConnection reset
the cpu/memory/etc is all fine – no process has gone insane, or anthing like that.
After a very long wait, I get this error dialog thrown
this the the relevant section from the debug log.
14/01/2008 02.10.11:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:SEVERE: Problem doing RESTQuery:IOExceptionConnection reset
14/01/2008 02.14.12:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:SEVERE: Problem doing RESTQuery:IOExceptionConnection reset
14/01/2008 02.18.12:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:SEVERE: Problem doing RESTQuery:IOExceptionConnection reset
14/01/2008 02.22.13:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:SEVERE: Problem doing RESTQuery:IOExceptionConnection reset
14/01/2008 02.28.15:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:SEVERE: Problem doing RESTQuery:IOExceptionConnection reset
During this time, my network connections were normal, and thingsn were otherwise not disrupted.
Should point out, that when i re-run the process, it hangs on the exact same file number. So I don’t think this can be put to spurious network issue.
[quote=karavshin]Should point out, that when i re-run the process, it hangs on the exact same file number. So I don’t think this can be put to spurious network issue.
[/quote]
Ok, so thats the issue, so I need your log files and the file that it is hanging on ( it might be the file immediately after) then I should be able to reolve this.
The logs are not saying which file it is. What level should I set the -l and -m parameters to to catch that ?
(also, how do I launch this file from osx while specifying the parameters?)
Here is the messaging (m5 l5) from the terminal where I launch jaikoz from. You can see where it tried five times to connect to musicBrainz and failed each time. Finally it gives up with the error message listed above.
I am attaching the tail of the debug file.
I checked the mp3 file - it is playable in iTunes with no complaints.
4/01/2008 07.55.29:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery:findMatch:CONFIG: Rec No:180 No match
14/01/2008 07.55.29:com.jthink.jaikoz.manipulate.TagFromMusicBrainzRowAnalyser$WorkerThread:analyse:CONFIG: Thread ID:0:about to match tag:181
14/01/2008 07.55.29:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:INFO: 07:55:29:731:URL:http://musicbrainz.org/ws/1/track/?type=xml&puid=80ac6a8e-34be-71e6-af18-ab29057e27f3
14/01/2008 07.55.30:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:CONFIG: Delaying for539milliseconds
14/01/2008 07.55.30:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:INFO: 07:55:30:731:URL:http://musicbrainz.org/ws/1/track/?type=xml&limit=1&query=(track:“Symphony N? 6 In F Major, Op.68 Allegro Ma Non Troppo”^8 ) AND (artist:“Glenn Gould”^6 release:“Glenn Gould Edition 4 Liszt Piano Transcriptions”^4 tnum:“4” ) AND qdur:(296 297 298 299 300 )
14/01/2008 07.55.31:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery:findMatch:CONFIG: Rec No:181 No match
14/01/2008 07.55.31:com.jthink.jaikoz.manipulate.TagFromMusicBrainzRowAnalyser$WorkerThread:analyse:CONFIG: Thread ID:0:about to match tag:182
14/01/2008 07.55.31:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:CONFIG: Delaying for683milliseconds
14/01/2008 07.55.31:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:INFO: 07:55:31:731:URL:http://musicbrainz.org/ws/1/track/?type=xml&puid=206519d9-ae5c-2ee5-af1d-8678ba2d8cd6
14/01/2008 07.55.32:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:59
14/01/2008 07.55.32:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:64
14/01/2008 07.55.32:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:95
14/01/2008 07.55.32:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery:findMatch:CONFIG: Selecting puid track with score of:95
14/01/2008 07.55.32:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery:updateTagFromMusicBrainz:CONFIG: RecNo:182 is being updated
14/01/2008 07.55.32:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery:updateTagFromMusicBrainz:CONFIG: RecNo:182:Number of releases for track:1
14/01/2008 07.55.32:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:CONFIG: Delaying for793milliseconds
14/01/2008 07.55.32:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:INFO: 07:55:32:731:URL:http://musicbrainz.org/ws/1/release/1610ce4c-e1da-498c-82a1-1dfc32f89200?type=xml&inc=counts release-events url-rels artist discs
14/01/2008 07.55.33:com.jthink.jaikoz.manipulate.ArtworkCache:add:FINE: Adding image for key:B00018D5US
14/01/2008 07.55.33:com.jthink.jaikoz.celldata.Images:addImage:INFO: Image already exists
14/01/2008 07.55.33:com.jthink.jaikoz.manipulate.TagFromMusicBrainzRowAnalyser$WorkerThread:analyse:CONFIG: Thread ID:0:about to match tag:183
14/01/2008 07.55.33:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:CONFIG: Delaying for582milliseconds
14/01/2008 07.55.33:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:INFO: 07:55:33:731:URL:http://musicbrainz.org/ws/1/track/?type=xml&puid=358b83a3-2ce9-2166-17e2-253c4a13b500
14/01/2008 07.55.34:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:59
14/01/2008 07.55.34:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:59
14/01/2008 07.55.34:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:64
14/01/2008 07.55.34:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:95
14/01/2008 07.55.34:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery:findMatch:CONFIG: Selecting puid track with score of:95
14/01/2008 07.55.34:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery:updateTagFromMusicBrainz:CONFIG: RecNo:183 is being updated
14/01/2008 07.55.34:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery:updateTagFromMusicBrainz:CONFIG: RecNo:183:Number of releases for track:1
14/01/2008 07.55.34:com.jthink.jaikoz.manipulate.TagFromMusicBrainzRowAnalyser$WorkerThread:analyse:CONFIG: Thread ID:0:about to match tag:184
14/01/2008 07.55.34:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:CONFIG: Delaying for457milliseconds
14/01/2008 07.55.34:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:INFO: 07:55:34:732:URL:http://musicbrainz.org/ws/1/track/?type=xml&puid=db3db0e9-666e-8c67-6a51-f5d6f3f3cb98
14/01/2008 07.55.35:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:59
14/01/2008 07.55.35:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:64
14/01/2008 07.55.35:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:95
14/01/2008 07.55.35:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery:findMatch:CONFIG: Selecting puid track with score of:95
14/01/2008 07.55.35:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery:updateTagFromMusicBrainz:CONFIG: RecNo:184 is being updated
14/01/2008 07.55.35:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery:updateTagFromMusicBrainz:CONFIG: RecNo:184:Number of releases for track:1
14/01/2008 07.55.35:com.jthink.jaikoz.manipulate.TagFromMusicBrainzRowAnalyser$WorkerThread:analyse:CONFIG: Thread ID:0:about to match tag:185
14/01/2008 07.55.35:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:CONFIG: Delaying for552milliseconds
14/01/2008 07.55.35:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:INFO: 07:55:35:732:URL:http://musicbrainz.org/ws/1/track/?type=xml&puid=2a6748b7-6336-8add-6d91-3e513f5ffd6f
14/01/2008 07.55.36:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:59
14/01/2008 07.55.36:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:64
14/01/2008 07.55.36:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:59
14/01/2008 07.55.36:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:64
14/01/2008 07.55.36:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:95
14/01/2008 07.55.36:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery:findMatch:CONFIG: Selecting puid track with score of:95
14/01/2008 07.55.36:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery:updateTagFromMusicBrainz:CONFIG: RecNo:185 is being updated
14/01/2008 07.55.36:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery:updateTagFromMusicBrainz:CONFIG: RecNo:185:Number of releases for track:1
14/01/2008 07.55.36:com.jthink.jaikoz.manipulate.TagFromMusicBrainzRowAnalyser$WorkerThread:analyse:CONFIG: Thread ID:0:about to match tag:186
14/01/2008 07.55.36:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:CONFIG: Delaying for628milliseconds
14/01/2008 07.55.36:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:INFO: 07:55:36:732:URL:http://musicbrainz.org/ws/1/track/?type=xml&puid=f1aa644b-f0bb-dd8c-81e1-c5417a362f07
14/01/2008 07.55.37:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:67
14/01/2008 07.55.37:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:50
14/01/2008 07.55.37:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:64
14/01/2008 07.55.37:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:59
14/01/2008 07.55.37:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:64
14/01/2008 07.55.37:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:95
14/01/2008 07.55.37:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery:findMatch:CONFIG: Selecting puid track with score of:95
14/01/2008 07.55.37:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery:updateTagFromMusicBrainz:CONFIG: RecNo:186 is being updated
14/01/2008 07.55.37:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery:updateTagFromMusicBrainz:CONFIG: RecNo:186:Number of releases for track:1
14/01/2008 07.55.37:com.jthink.jaikoz.manipulate.TagFromMusicBrainzRowAnalyser$WorkerThread:analyse:CONFIG: Thread ID:0:about to match tag:187
14/01/2008 07.55.37:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:CONFIG: Delaying for539milliseconds
14/01/2008 07.55.37:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:INFO: 07:55:37:732:URL:http://musicbrainz.org/ws/1/track/?type=xml&puid=fb975303-00e5-5ff0-6820-b7e8aea553e5
14/01/2008 07.55.38:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:64
14/01/2008 07.55.38:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:64
14/01/2008 07.55.38:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:95
14/01/2008 07.55.38:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery:findMatch:CONFIG: Selecting puid track with score of:95
14/01/2008 07.55.38:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery:updateTagFromMusicBrainz:CONFIG: RecNo:187 is being updated
14/01/2008 07.55.38:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery:updateTagFromMusicBrainz:CONFIG: RecNo:187:Number of releases for track:1
14/01/2008 07.55.38:com.jthink.jaikoz.manipulate.TagFromMusicBrainzRowAnalyser$WorkerThread:analyse:CONFIG: Thread ID:0:about to match tag:188
14/01/2008 07.55.38:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:CONFIG: Delaying for453milliseconds
14/01/2008 07.55.38:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:INFO: 07:55:38:733:URL:http://musicbrainz.org/ws/1/track/?type=xml&puid=3743f70a-a72c-da26-9202-77779d389885
14/01/2008 07.55.39:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:59
14/01/2008 07.55.39:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:64
14/01/2008 07.55.39:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:95
14/01/2008 07.55.39:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery:findMatch:CONFIG: Selecting puid track with score of:95
14/01/2008 07.55.39:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery:updateTagFromMusicBrainz:CONFIG: RecNo:188 is being updated
14/01/2008 07.55.39:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery:updateTagFromMusicBrainz:CONFIG: RecNo:188:Number of releases for track:1
14/01/2008 07.55.39:com.jthink.jaikoz.manipulate.TagFromMusicBrainzRowAnalyser$WorkerThread:analyse:CONFIG: Thread ID:0:about to match tag:189
14/01/2008 07.55.39:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:CONFIG: Delaying for592milliseconds
14/01/2008 07.55.39:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:INFO: 07:55:39:733:URL:http://musicbrainz.org/ws/1/track/?type=xml&puid=4b28547e-ef9e-6776-4765-2914116dce7d
14/01/2008 07.55.40:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:59
14/01/2008 07.55.40:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:100
14/01/2008 07.55.40:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:75
14/01/2008 07.55.40:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery:findMatch:CONFIG: Selecting puid track with score of:100
14/01/2008 07.55.40:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery:updateTagFromMusicBrainz:CONFIG: RecNo:189 is being updated
14/01/2008 07.55.40:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery:updateTagFromMusicBrainz:CONFIG: RecNo:189:Number of releases for track:1
14/01/2008 07.55.40:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:CONFIG: Delaying for383milliseconds
14/01/2008 07.55.40:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:INFO: 07:55:40:733:URL:http://musicbrainz.org/ws/1/release/b304abb5-c039-494f-bc50-37490aca74c5?type=xml&inc=counts release-events url-rels artist discs
14/01/2008 07.55.41:com.jthink.jaikoz.manipulate.ArtworkCache:add:FINE: Adding image for key:B0000025PM
14/01/2008 07.55.41:com.jthink.jaikoz.celldata.Images:addImage:INFO: Image already exists
14/01/2008 07.55.41:com.jthink.jaikoz.manipulate.TagFromMusicBrainzRowAnalyser$WorkerThread:analyse:CONFIG: Thread ID:0:about to match tag:190
14/01/2008 07.55.41:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:CONFIG: Delaying for792milliseconds
14/01/2008 07.55.41:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:INFO: 07:55:41:733:URL:http://musicbrainz.org/ws/1/track/?type=xml&puid=f9a732eb-b9ee-f1e1-1aac-be25a7ff3d2e
14/01/2008 07.55.42:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:59
14/01/2008 07.55.42:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:59
14/01/2008 07.55.42:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:64
14/01/2008 07.55.42:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:95
14/01/2008 07.55.42:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery:findMatch:CONFIG: Selecting puid track with score of:95
14/01/2008 07.55.42:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery:updateTagFromMusicBrainz:CONFIG: RecNo:190 is being updated
14/01/2008 07.55.42:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery:updateTagFromMusicBrainz:CONFIG: RecNo:190:Number of releases for track:1
14/01/2008 07.55.42:com.jthink.jaikoz.manipulate.TagFromMusicBrainzRowAnalyser$WorkerThread:analyse:CONFIG: Thread ID:0:about to match tag:191
14/01/2008 07.55.42:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:CONFIG: Delaying for429milliseconds
14/01/2008 07.55.42:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:INFO: 07:55:42:734:URL:http://musicbrainz.org/ws/1/track/?type=xml&puid=ef7c9c5e-48db-22df-3b4d-a98b1f26160e
14/01/2008 07.55.43:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:59
14/01/2008 07.55.43:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:59
14/01/2008 07.55.43:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:64
14/01/2008 07.55.43:com.jthink.jaikoz.manipulate.musicbrainzhelper.TrackWithUnnormalizationScore::CONFIG: Score is:95
14/01/2008 07.55.43:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery:findMatch:CONFIG: Selecting puid track with score of:95
14/01/2008 07.55.43:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery:updateTagFromMusicBrainz:CONFIG: RecNo:191 is being updated
14/01/2008 07.55.43:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery:updateTagFromMusicBrainz:CONFIG: RecNo:191:Number of releases for track:1
14/01/2008 07.55.43:com.jthink.jaikoz.manipulate.TagFromMusicBrainzRowAnalyser$WorkerThread:analyse:CONFIG: Thread ID:0:about to match tag:192
14/01/2008 07.55.43:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:CONFIG: Delaying for340milliseconds
14/01/2008 07.55.43:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:INFO: 07:55:43:734:URL:http://musicbrainz.org/ws/1/track/?type=xml&puid=abe05251-34e6-0f10-d028-cf5ffe0231ee
14/01/2008 07.59.04:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:SEVERE: Problem doing RESTQuery:IOExceptionConnection reset
14/01/2008 07.59.04:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:INFO: 07:59:04:655:URL:http://musicbrainz.org/ws/1/track/?type=xml&puid=abe05251-34e6-0f10-d028-cf5ffe0231ee
14/01/2008 08.03.05:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:SEVERE: Problem doing RESTQuery:IOExceptionConnection reset
14/01/2008 08.03.05:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:INFO: 08:03:05:363:URL:http://musicbrainz.org/ws/1/track/?type=xml&puid=abe05251-34e6-0f10-d028-cf5ffe0231ee
14/01/2008 08.07.06:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:SEVERE: Problem doing RESTQuery:IOExceptionConnection reset
14/01/2008 08.07.06:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:INFO: 08:07:06:029:URL:http://musicbrainz.org/ws/1/track/?type=xml&puid=abe05251-34e6-0f10-d028-cf5ffe0231ee
14/01/2008 08.11.06:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:SEVERE: Problem doing RESTQuery:IOExceptionConnection reset
14/01/2008 08.11.06:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:INFO: 08:11:06:737:URL:http://musicbrainz.org/ws/1/track/?type=xml&puid=abe05251-34e6-0f10-d028-cf5ffe0231ee
14/01/2008 08.15.07:com.jthink.jaikoz.manipulate.MusicBrainzRESTQuery$MusicBrainzServerQuery:performQuery:SEVERE: Problem doing RESTQuery:IOExceptionConnection reset
14/01/2008 08.15.07:com.jthink.jaikoz.settings.LanguagePreferences:getValue:FINE: messagetitles.c0
14/01/2008 08.15.07:com.jthink.jaikoz.settings.LanguagePreferences:getValue:FINE: messagetitles.c1
14/01/2008 08.15.07:com.jthink.jaikoz.settings.LanguagePreferences:getValue:FINE: messagetitles.c2
14/01/2008 08.15.07:com.jthink.jaikoz.settings.LanguagePreferences:getValue:FINE: messagetitles.c3
14/01/2008 08.15.07:com.jthink.jaikoz.settings.LanguagePreferences:getValue:FINE: messagetitles.c4
14/01/2008 08.15.07:com.jthink.jaikoz.settings.LanguagePreferences:getValue:FINE: messagetitles.c5
14/01/2008 08.15.07:com.jthink.jaikoz.settings.LanguagePreferences:getValue:FINE: messagetitles.c6
14/01/2008 08.15.07:com.jthink.jaikoz.settings.LanguagePreferences:getValue:FINE: messagetitles.c7
14/01/2008 08.15.07:com.jthink.jaikoz.settings.LanguagePreferences:getValue:FINE: messagetitles.c8
14/01/2008 08.15.07:com.jthink.jaikoz.settings.LanguagePreferences:getValue:FINE: messagetitles.c9
14/01/2008 08.15.07:com.jthink.jaikoz.settings.LanguagePreferences:getValue:FINE: messagetitles.c10
14/01/2008 08.15.07:com.jthink.jaikoz.settings.LanguagePreferences:getValue:FINE: messagetitles.c11
14/01/2008 08.15.07:com.jthink.jaikoz.indexed.DataIndexer:reindex:INFO: Reindex start:Mon Jan 14 08:15:07 SGT 2008
14/01/2008 08.15.07:com.jthink.jaikoz.indexed.DataIndexer:reindex:INFO: Reindex end:Mon Jan 14 08:15:07 SGT 2008
14/01/2008 08.15.07:com.jthink.jaikoz.indexed.DataIndexerManager:startListening:CONFIG: DataIndexer:startlistening
I tried to go to the url complained about in the logfile
http://musicbrainz.org/ws/1/track/?type=xml&puid=abe05251-34e6-0f10-d028-cf5ffe0231ee
The first time, it opened up fine. Subsequent attempts to open that url seem to time out. Not sure why.
And also, this url is for a Glenn Gould song, not a Johnny Cash song. I must have misread the debug report about what it was failing on. At any rate, this file also happily plays inside iTunes.
Rather than running the update tags on the entire directory, I filtered down to just the one album which contains teh troublesome song. I still get the exact same hanging results. It doesn’t appear to matter which context the file is checked from.
I have tried this url a few times, from different browsers. On the first query, I can always download it. Sometimes if I attempt to reload it seems uncooperative.
even if this is what’s going on, musicbrain timing out, shouldn’t the program be robust and walk past this?
Hi, thanks for spending some time trying to track down the problem. Firstly Jaikoz does handle network problems robustly in that it reattempts the connection fives times before eventually giving up, this allows it to cope with blips in service. But normally a failed mb lookup will return in a few seconds rather than a few minutes, I have never seen the behaviour that you are seeing.
There is nothing obviously problematic about the particular query that seem to be causing the problem but if it is still not working, and it is always this particular file that is causing the problem please send me the actual file so that I can properly replicate the problem. Without the file I cannot replicate the problem.
Paul
Oh no!
I happened to have upgraded my mac yesterday – 3gb of memory + installed Leopard OSX.
I ran jaikoz today, and no problems. I just processed my whole library without anything funny happening.
I guess unfortunately this means I can’t help diagnose what was breaking yesterday.