D: <sip.voidptr object at 0x03732458> 20:16:07 Starting Picard 1.2 from 'C:
Program Files (x86)
MusicBrainz Picard\\library.zip\\picard
tagger.pyo'
D: <sip.voidptr object at 0x03732458> 20:16:07 Loading gettext translation, localedir='C:
Program Files (x86)
MusicBrainz Picard
locale'
D: <sip.voidptr object at 0x03732458> 20:16:07 NetworkDiskCache dir: C:/Users/lars/AppData/Local/cache/picard/
D: <sip.voidptr object at 0x03732458> 20:16:07 NetworkDiskCache size: 94366740 / 104857600
D: <sip.voidptr object at 0x03732458> 20:16:07 Loading plugin 'featartistsintitles'
D: <sip.voidptr object at 0x03732458> 20:16:07 Loading plugin 'classicdiscnumber'
D: <sip.voidptr object at 0x03732458> 20:16:07 Loading plugin 'discnumber'
D: <sip.voidptr object at 0x03732458> 20:16:07 Loading plugin 'featartist'
D: <sip.voidptr object at 0x03732458> 20:16:07 Loading plugin 'lastfmplus'
D: <sip.voidptr object at 0x03732458> 20:16:07 Loading plugin 'titlecase'
D: <sip.voidptr object at 0x03732458> 20:16:07 Starting the browser integration (port 8000)
D: <sip.voidptr object at 0x03732458> 20:16:07 Last request to (u'musicbrainz.org', 80) was 1000 ms ago, starting another one
D: <sip.voidptr object at 0x03732458> 20:16:07 GET http://musicbrainz.org:80/ws/2/collection
D: <sip.voidptr object at 0x03732458> 20:16:07 Received reply for http:/monkiibiz:*****@musicbrainz.org:80/ws/2/collection: HTTP 200 (OK) (CACHED)
D: <sip.voidptr object at 0x03732458> 20:16:09 Drop target = None
D: <sip.voidptr object at 0x03732458> 20:16:09 'Loading directory Y:\Music!Unsorted & untagged!unchecked albums\Eagle-Eye Cherry\Desireless'
D: <sip.voidptr object at 0x03732458> 20:16:09 Adding files <generator object <genexpr> at 0x034486C0>
D: <sip.voidptr object at 0x03732458> 20:16:09 Moving <File u'05 Rainbow Wings.flac'> from None to <Cluster u'Unmatched Files'>
D: <sip.voidptr object at 0x03732458> 20:16:09 Moving <File u'01 Save Tonight.flac'> from None to <Cluster u'Unmatched Files'>
D: <sip.voidptr object at 0x03732458> 20:16:09 Moving <File u'03 Comatose (In the Arms of Slumber).flac'> from None to <Cluster u'Unmatched Files'>
D: <sip.voidptr object at 0x03732458> 20:16:09 Moving <File u'04 Worried Eyes.flac'> from None to <Cluster u'Unmatched Files'>
D: <sip.voidptr object at 0x03732458> 20:16:09 Moving <File u'10 Permanent Tears.flac'> from None to <Cluster u'Unmatched Files'>
D: <sip.voidptr object at 0x03732458> 20:16:09 Moving <File u'11 Death Defied by Will.flac'> from None to <Cluster u'Unmatched Files'>
D: <sip.voidptr object at 0x03732458> 20:16:09 Moving <File u'08 When Mermaids Cry.flac'> from None to <Cluster u'Unmatched Files'>
D: <sip.voidptr object at 0x03732458> 20:16:09 Moving <File u'02 Indecision.flac'> from None to <Cluster u'Unmatched Files'>
D: <sip.voidptr object at 0x03732458> 20:16:09 Moving <File u'07 Conversation.flac'> from None to <Cluster u'Unmatched Files'>
D: <sip.voidptr object at 0x03732458> 20:16:09 Moving <File u'12 Desireless.flac'> from None to <Cluster u'Unmatched Files'>
D: <sip.voidptr object at 0x03732458> 20:16:09 Moving <File u'09 Shooting Up in Vain.flac'> from None to <Cluster u'Unmatched Files'>
D: <sip.voidptr object at 0x03732458> 20:16:09 Moving <File u'06 Falling in Love Again.flac'> from None to <Cluster u'Unmatched Files'>
D: <sip.voidptr object at 0x03732458> 20:16:09 Loading file u'Y:\\Music
!Unsorted & untagged
!unchecked albums
Eagle-Eye Cherry\\Desireless
05 Rainbow Wings.flac'
D: <sip.voidptr object at 0x03732458> 20:16:09 Loading file u'Y:\\Music
!Unsorted & untagged
!unchecked albums
Eagle-Eye Cherry\\Desireless
01 Save Tonight.flac'
D: <sip.voidptr object at 0x03732458> 20:16:09 Loading file u'Y:\\Music
!Unsorted & untagged
!unchecked albums
Eagle-Eye Cherry\\Desireless
03 Comatose (In the Arms of Slumber).flac'
D: <sip.voidptr object at 0x03732458> 20:16:09 Loading file u'Y:\\Music
!Unsorted & untagged
!unchecked albums
Eagle-Eye Cherry\\Desireless
04 Worried Eyes.flac'
D: <sip.voidptr object at 0x03732458> 20:16:09 Loading file u'Y:\\Music
!Unsorted & untagged
!unchecked albums
Eagle-Eye Cherry\\Desireless
10 Permanent Tears.flac'
D: <sip.voidptr object at 0x03732458> 20:16:09 Loading file u'Y:\\Music
!Unsorted & untagged
!unchecked albums
Eagle-Eye Cherry\\Desireless
11 Death Defied by Will.flac'
D: <sip.voidptr object at 0x03732458> 20:16:09 Loading file u'Y:\\Music
!Unsorted & untagged
!unchecked albums
Eagle-Eye Cherry\\Desireless
08 When Mermaids Cry.flac'
D: <sip.voidptr object at 0x03732458> 20:16:09 Loading file u'Y:\\Music
!Unsorted & untagged
!unchecked albums
Eagle-Eye Cherry\\Desireless
02 Indecision.flac'
D: <sip.voidptr object at 0x03732458> 20:16:09 Updating file <File u'05 Rainbow Wings.flac'>
D: <sip.voidptr object at 0x03732458> 20:16:09 'Loading album 1cbdeb3a-51be-44c3-b5a2-84d4436ee14c...'
D: <sip.voidptr object at 0x03732458> 20:16:09 Moving <File u'05 Rainbow Wings.flac'> from <Cluster u'Unmatched Files'> to <Cluster u'Unmatched Files'>
D: <sip.voidptr object at 0x03732458> 20:16:09 Updating file <File u'03 Comatose (In the Arms of Slumber).flac'>
D: <sip.voidptr object at 0x03732458> 20:16:09 Moving <File u'03 Comatose (In the Arms of Slumber).flac'> from <Cluster u'Unmatched Files'> to <Cluster u'Unmatched Files'>
D: <sip.voidptr object at 0x03732458> 20:16:09 Updating file <File u'01 Save Tonight.flac'>
D: <sip.voidptr object at 0x03732458> 20:16:09 Moving <File u'01 Save Tonight.flac'> from <Cluster u'Unmatched Files'> to <Cluster u'Unmatched Files'>
D: <sip.voidptr object at 0x03732458> 20:16:09 Updating file <File u'04 Worried Eyes.flac'>
D: <sip.voidptr object at 0x03732458> 20:16:09 Moving <File u'04 Worried Eyes.flac'> from <Cluster u'Unmatched Files'> to <Cluster u'Unmatched Files'>
D: <sip.voidptr object at 0x03732458> 20:16:09 Last request to (u'musicbrainz.org', 80) was 2526 ms ago, starting another one
D: <sip.voidptr object at 0x03732458> 20:16:09 GET http://musicbrainz.org:80/ws/2/release/1cbdeb3a-51be-44c3-b5a2-84d4436ee14c?inc=release-groups+media+recordings+artist-credits+artists+aliases+labels+isrcs+collections+artist-rels+release-rels+url-rels+recording-rels+work-rels
D: <sip.voidptr object at 0x03732458> 20:16:09 Loading file u'Y:\\Music
!Unsorted & untagged
!unchecked albums
Eagle-Eye Cherry\\Desireless
07 Conversation.flac'
D: <sip.voidptr object at 0x03732458> 20:16:09 Loading file u'Y:\\Music
!Unsorted & untagged
!unchecked albums
Eagle-Eye Cherry\\Desireless
12 Desireless.flac'
D: <sip.voidptr object at 0x03732458> 20:16:09 Loading file u'Y:\\Music
!Unsorted & untagged
!unchecked albums
Eagle-Eye Cherry\\Desireless
09 Shooting Up in Vain.flac'
D: <sip.voidptr object at 0x03732458> 20:16:09 Loading file u'Y:\\Music
!Unsorted & untagged
!unchecked albums
Eagle-Eye Cherry\\Desireless
06 Falling in Love Again.flac'
D: <sip.voidptr object at 0x03732458> 20:16:09 Updating file <File u'11 Death Defied by Will.flac'>
D: <sip.voidptr object at 0x03732458> 20:16:09 Moving <File u'11 Death Defied by Will.flac'> from <Cluster u'Unmatched Files'> to <Cluster u'Unmatched Files'>
D: <sip.voidptr object at 0x03732458> 20:16:09 Updating file <File u'08 When Mermaids Cry.flac'>
D: <sip.voidptr object at 0x03732458> 20:16:09 Moving <File u'08 When Mermaids Cry.flac'> from <Cluster u'Unmatched Files'> to <Cluster u'Unmatched Files'>
D: <sip.voidptr object at 0x03732458> 20:16:09 Updating file <File u'10 Permanent Tears.flac'>
D: <sip.voidptr object at 0x03732458> 20:16:09 Moving <File u'10 Permanent Tears.flac'> from <Cluster u'Unmatched Files'> to <Cluster u'Unmatched Files'>
D: <sip.voidptr object at 0x03732458> 20:16:09 Updating file <File u'02 Indecision.flac'>
D: <sip.voidptr object at 0x03732458> 20:16:09 Moving <File u'02 Indecision.flac'> from <Cluster u'Unmatched Files'> to <Cluster u'Unmatched Files'>
D: <sip.voidptr object at 0x03732458> 20:16:09 Updating file <File u'06 Falling in Love Again.flac'>
D: <sip.voidptr object at 0x03732458> 20:16:09 Moving <File u'06 Falling in Love Again.flac'> from <Cluster u'Unmatched Files'> to <Cluster u'Unmatched Files'>
D: <sip.voidptr object at 0x03732458> 20:16:09 Updating file <File u'12 Desireless.flac'>
D: <sip.voidptr object at 0x03732458> 20:16:09 Moving <File u'12 Desireless.flac'> from <Cluster u'Unmatched Files'> to <Cluster u'Unmatched Files'>
D: <sip.voidptr object at 0x03732458> 20:16:09 Updating file <File u'07 Conversation.flac'>
D: <sip.voidptr object at 0x03732458> 20:16:09 Moving <File u'07 Conversation.flac'> from <Cluster u'Unmatched Files'> to <Cluster u'Unmatched Files'>
D: <sip.voidptr object at 0x03732458> 20:16:09 Updating file <File u'09 Shooting Up in Vain.flac'>
D: <sip.voidptr object at 0x03732458> 20:16:09 Moving <File u'09 Shooting Up in Vain.flac'> from <Cluster u'Unmatched Files'> to <Cluster u'Unmatched Files'>
D: <sip.voidptr object at 0x03732458> 20:16:10 Received reply for http://musicbrainz.org:80/ws/2/release/1cbdeb3a-51be-44c3-b5a2-84d4436ee14c?inc=release-groups+media+recordings+artist-credits+artists+aliases+labels+isrcs+collections+artist-rels+release-rels+url-rels+recording-rels+work-rels: HTTP 200 (OK) (CACHED)
D: <sip.voidptr object at 0x03732458> 20:16:10 Loading release u'1cbdeb3a-51be-44c3-b5a2-84d4436ee14c'
D: <sip.voidptr object at 0x03732458> 20:16:10 There are no suitable images in the cover art archive for 1cbdeb3a-51be-44c3-b5a2-84d4436ee14c
D: <sip.voidptr object at 0x03732458> 20:16:10 Last request to ('ws.audioscrobbler.com', 80) was 200 ms ago, starting another one
D: <sip.voidptr object at 0x03732458> 20:16:10 GET http://ws.audioscrobbler.com:80/1.0/track/Eagle-Eye%2520Cherry/Desireless/toptags.xml
D: <sip.voidptr object at 0x03732458> 20:16:10 Received reply for http://ws.audioscrobbler.com:80/1.0/track/Eagle-Eye%20Cherry/Desireless/toptags.xml: HTTP 200 (OK) (CACHED)
D: <sip.voidptr object at 0x03732458> 20:16:11 Last request to ('ws.audioscrobbler.com', 80) was 213 ms ago, starting another one
D: <sip.voidptr object at 0x03732458> 20:16:11 GET http://ws.audioscrobbler.com:80/1.0/artist/Eagle-Eye%2520Cherry/toptags.xml
D: <sip.voidptr object at 0x03732458> 20:16:11 Received reply for http://ws.audioscrobbler.com:80/1.0/artist/Eagle-Eye%20Cherry/toptags.xml: HTTP 200 (OK) (CACHED)
D: <sip.voidptr object at 0x03732458> 20:16:11 Last request to ('ws.audioscrobbler.com', 80) was 201 ms ago, starting another one
D: <sip.voidptr object at 0x03732458> 20:16:11 GET http://ws.audioscrobbler.com:80/1.0/track/Eagle-Eye%2520Cherry/Death%2520Defied%2520by%2520Will/toptags.xml
D: <sip.voidptr object at 0x03732458> 20:16:11 Received reply for http://ws.audioscrobbler.com:80/1.0/track/Eagle-Eye%20Cherry/Death%20Defied%20by%20Will/toptags.xml: HTTP 200 (OK) (CACHED)
D: <sip.voidptr object at 0x03732458> 20:16:11 Last request to ('ws.audioscrobbler.com', 80) was 203 ms ago, starting another one
D: <sip.voidptr object at 0x03732458> 20:16:11 GET http://ws.audioscrobbler.com:80/1.0/track/Eagle-Eye%2520Cherry/Permanent%2520Tears/toptags.xml
D: <sip.voidptr object at 0x03732458> 20:16:11 Received reply for http://ws.audioscrobbler.com:80/1.0/track/Eagle-Eye%20Cherry/Permanent%20Tears/toptags.xml: HTTP 200 (OK) (CACHED)
D: <sip.voidptr object at 0x03732458> 20:16:11 Waiting 6 ms before starting another request to ('ws.audioscrobbler.com', 80)
D: <sip.voidptr object at 0x03732458> 20:16:11 Last request to ('ws.audioscrobbler.com', 80) was 213 ms ago, starting another one
D: <sip.voidptr object at 0x03732458> 20:16:11 GET http://ws.audioscrobbler.com:80/1.0/track/Eagle-Eye%2520Cherry/Shooting%2520Up%2520in%2520Vain/toptags.xml
D: <sip.voidptr object at 0x03732458> 20:16:11 Received reply for http://ws.audioscrobbler.com:80/1.0/track/Eagle-Eye%20Cherry/Shooting%20Up%20in%20Vain/toptags.xml: HTTP 200 (OK) (CACHED)
D: <sip.voidptr object at 0x03732458> 20:16:11 Last request to ('ws.audioscrobbler.com', 80) was 207 ms ago, starting another one
D: <sip.voidptr object at 0x03732458> 20:16:11 GET http://ws.audioscrobbler.com:80/1.0/track/Eagle-Eye%2520Cherry/When%2520Mermaids%2520Cry/toptags.xml
D: <sip.voidptr object at 0x03732458> 20:16:11 Received reply for http://ws.audioscrobbler.com:80/1.0/track/Eagle-Eye%20Cherry/When%20Mermaids%20Cry/toptags.xml: HTTP 200 (OK) (CACHED)
D: <sip.voidptr object at 0x03732458> 20:16:12 Last request to ('ws.audioscrobbler.com', 80) was 200 ms ago, starting another one
D: <sip.voidptr object at 0x03732458> 20:16:12 GET http://ws.audioscrobbler.com:80/1.0/track/Eagle-Eye%2520Cherry/Conversation/toptags.xml
D: <sip.voidptr object at 0x03732458> 20:16:12 Received reply for http://ws.audioscrobbler.com:80/1.0/track/Eagle-Eye%20Cherry/Conversation/toptags.xml: HTTP 200 (OK) (CACHED)
D: <sip.voidptr object at 0x03732458> 20:16:12 Last request to ('ws.audioscrobbler.com', 80) was 207 ms ago, starting another one
D: <sip.voidptr object at 0x03732458> 20:16:12 GET http://ws.audioscrobbler.com:80/1.0/track/Eagle-Eye%2520Cherry/Falling%2520in%2520Love%2520Again/toptags.xml
D: <sip.voidptr object at 0x03732458> 20:16:12 Received reply for http://ws.audioscrobbler.com:80/1.0/track/Eagle-Eye%20Cherry/Falling%20in%20Love%20Again/toptags.xml: HTTP 200 (OK) (CACHED)
D: <sip.voidptr object at 0x03732458> 20:16:12 Waiting 8 ms before starting another request to ('ws.audioscrobbler.com', 80)
D: <sip.voidptr object at 0x03732458> 20:16:12 Last request to ('ws.audioscrobbler.com', 80) was 211 ms ago, starting another one
D: <sip.voidptr object at 0x03732458> 20:16:12 GET http://ws.audioscrobbler.com:80/1.0/track/Eagle-Eye%2520Cherry/Rainbow%2520Wings/toptags.xml
D: <sip.voidptr object at 0x03732458> 20:16:12 Received reply for http://ws.audioscrobbler.com:80/1.0/track/Eagle-Eye%20Cherry/Rainbow%20Wings/toptags.xml: HTTP 200 (OK) (CACHED)
D: <sip.voidptr object at 0x03732458> 20:16:12 Last request to ('ws.audioscrobbler.com', 80) was 207 ms ago, starting another one
D: <sip.voidptr object at 0x03732458> 20:16:12 GET http://ws.audioscrobbler.com:80/1.0/track/Eagle-Eye%2520Cherry/Worried%2520Eyes/toptags.xml
D: <sip.voidptr object at 0x03732458> 20:16:12 Received reply for http://ws.audioscrobbler.com:80/1.0/track/Eagle-Eye%20Cherry/Worried%20Eyes/toptags.xml: HTTP 200 (OK) (CACHED)
D: <sip.voidptr object at 0x03732458> 20:16:12 Last request to ('ws.audioscrobbler.com', 80) was 203 ms ago, starting another one
D: <sip.voidptr object at 0x03732458> 20:16:12 GET http://ws.audioscrobbler.com:80/1.0/track/Eagle-Eye%2520Cherry/Comatose%2520%2528In%2520the%2520Arms%2520of%2520Slumber%2529/toptags.xml
D: <sip.voidptr object at 0x03732458> 20:16:12 Received reply for http://ws.audioscrobbler.com:80/1.0/track/Eagle-Eye%20Cherry/Comatose%20%28In%20the%20Arms%20of%20Slumber%29/toptags.xml: HTTP 200 (OK) (CACHED)
D: <sip.voidptr object at 0x03732458> 20:16:13 Last request to ('ws.audioscrobbler.com', 80) was 200 ms ago, starting another one
D: <sip.voidptr object at 0x03732458> 20:16:13 GET http://ws.audioscrobbler.com:80/1.0/track/Eagle-Eye%2520Cherry/Indecision/toptags.xml
D: <sip.voidptr object at 0x03732458> 20:16:13 Received reply for http://ws.audioscrobbler.com:80/1.0/track/Eagle-Eye%20Cherry/Indecision/toptags.xml: HTTP 200 (OK) (CACHED)
D: <sip.voidptr object at 0x03732458> 20:16:13 Last request to ('ws.audioscrobbler.com', 80) was 206 ms ago, starting another one
D: <sip.voidptr object at 0x03732458> 20:16:13 GET http://ws.audioscrobbler.com:80/1.0/track/Eagle-Eye%2520Cherry/Save%2520Tonight/toptags.xml
D: <sip.voidptr object at 0x03732458> 20:16:13 Received reply for http://ws.audioscrobbler.com:80/1.0/track/Eagle-Eye%20Cherry/Save%20Tonight/toptags.xml: HTTP 200 (OK) (CACHED)
D: <sip.voidptr object at 0x03732458> 20:16:13 Moving <File u'05 Rainbow Wings.flac'> from <Cluster u'Unmatched Files'> to <Track f09d9eee-fde5-4e28-817c-2c98dc1aa947 u'Rainbow Wings'>
D: <sip.voidptr object at 0x03732458> 20:16:13 Moving <File u'03 Comatose (In the Arms of Slumber).flac'> from <Cluster u'Unmatched Files'> to <Track a000a642-8c7d-4100-a36f-d78069c44068 u'Comatose (In the Arms of Slumber)'>
D: <sip.voidptr object at 0x03732458> 20:16:13 Moving <File u'01 Save Tonight.flac'> from <Cluster u'Unmatched Files'> to <Track d8a837d1-886d-44e4-aa72-d19e61180b3b u'Save Tonight'>
D: <sip.voidptr object at 0x03732458> 20:16:13 Moving <File u'04 Worried Eyes.flac'> from <Cluster u'Unmatched Files'> to <Track 3702fd7b-6786-4314-863c-07b24e875b35 u'Worried Eyes'>
D: <sip.voidptr object at 0x03732458> 20:16:13 Moving <File u'11 Death Defied by Will.flac'> from <Cluster u'Unmatched Files'> to <Track 5c64740e-574f-487e-b08a-396cfab56f96 u'Death Defied by Will'>
D: <sip.voidptr object at 0x03732458> 20:16:13 Moving <File u'08 When Mermaids Cry.flac'> from <Cluster u'Unmatched Files'> to <Track 5828251f-56b9-4071-b8de-a36688b679cd u'When Mermaids Cry'>
D: <sip.voidptr object at 0x03732458> 20:16:13 Moving <File u'10 Permanent Tears.flac'> from <Cluster u'Unmatched Files'> to <Track 99e93270-bbfa-4282-819d-70c1b2f30b61 u'Permanent Tears'>
D: <sip.voidptr object at 0x03732458> 20:16:13 Moving <File u'02 Indecision.flac'> from <Cluster u'Unmatched Files'> to <Track 4b783fb5-7657-4c87-9b4b-703d4d35d4d0 u'Indecision'>
D: <sip.voidptr object at 0x03732458> 20:16:13 Moving <File u'06 Falling in Love Again.flac'> from <Cluster u'Unmatched Files'> to <Track 4e4d88df-b925-42c0-a9ac-07ab080e945e u'Falling in Love Again'>
D: <sip.voidptr object at 0x03732458> 20:16:13 Moving <File u'12 Desireless.flac'> from <Cluster u'Unmatched Files'> to <Track 4f58bc2a-5af2-48d6-9bab-7f3ff355eb25 u'Desireless'>
D: <sip.voidptr object at 0x03732458> 20:16:13 Moving <File u'07 Conversation.flac'> from <Cluster u'Unmatched Files'> to <Track 06bcb423-fc71-4112-a92c-c3aec06e68cc u'Conversation'>
D: <sip.voidptr object at 0x03732458> 20:16:13 Moving <File u'09 Shooting Up in Vain.flac'> from <Cluster u'Unmatched Files'> to <Track 992cf58b-8e69-40f7-ae24-247ec24d15ea u'Shooting Up in Vain'>
D: <sip.voidptr object at 0x03732458> 20:16:13 u'Album 1cbdeb3a-51be-44c3-b5a2-84d4436ee14c loaded'
D: <sip.voidptr object at 0x03732458> 20:16:15 Last request to (u'musicbrainz.org', 80) was 5805 ms ago, starting another one
D: <sip.voidptr object at 0x03732458> 20:16:15 GET http://musicbrainz.org:80/ws/2/release?release-group=2386bf5d-c014-3f84-921e-7532096946c2&limit=100&inc=media+labels
D: <sip.voidptr object at 0x03732458> 20:16:16 Received reply for http://musicbrainz.org:80/ws/2/release?release-group=2386bf5d-c014-3f84-921e-7532096946c2&limit=100&inc=media+labels: HTTP 200 (OK) (CACHED)
D: <sip.voidptr object at 0x03732458> 20:16:17 Moving <File u'01 Save Tonight.flac'> from <Track d8a837d1-886d-44e4-aa72-d19e61180b3b u'Save Tonight'> to <Cluster u'Unmatched Files'>
D: <sip.voidptr object at 0x03732458> 20:16:17 Moving <File u'02 Indecision.flac'> from <Track 4b783fb5-7657-4c87-9b4b-703d4d35d4d0 u'Indecision'> to <Cluster u'Unmatched Files'>
D: <sip.voidptr object at 0x03732458> 20:16:17 Moving <File u'03 Comatose (In the Arms of Slumber).flac'> from <Track a000a642-8c7d-4100-a36f-d78069c44068 u'Comatose (In the Arms of Slumber)'> to <Cluster u'Unmatched Files'>
D: <sip.voidptr object at 0x03732458> 20:16:17 Moving <File u'04 Worried Eyes.flac'> from <Track 3702fd7b-6786-4314-863c-07b24e875b35 u'Worried Eyes'> to <Cluster u'Unmatched Files'>
D: <sip.voidptr object at 0x03732458> 20:16:17 Moving <File u'05 Rainbow Wings.flac'> from <Track f09d9eee-fde5-4e28-817c-2c98dc1aa947 u'Rainbow Wings'> to <Cluster u'Unmatched Files'>
D: <sip.voidptr object at 0x03732458> 20:16:17 Moving <File u'06 Falling in Love Again.flac'> from <Track 4e4d88df-b925-42c0-a9ac-07ab080e945e u'Falling in Love Again'> to <Cluster u'Unmatched Files'>
D: <sip.voidptr object at 0x03732458> 20:16:17 Moving <File u'07 Conversation.flac'> from <Track 06bcb423-fc71-4112-a92c-c3aec06e68cc u'Conversation'> to <Cluster u'Unmatched Files'>
D: <sip.voidptr object at 0x03732458> 20:16:17 Moving <File u'08 When Mermaids Cry.flac'> from <Track 5828251f-56b9-4071-b8de-a36688b679cd u'When Mermaids Cry'> to <Cluster u'Unmatched Files'>
D: <sip.voidptr object at 0x03732458> 20:16:17 Moving <File u'09 Shooting Up in Vain.flac'> from <Track 992cf58b-8e69-40f7-ae24-247ec24d15ea u'Shooting Up in Vain'> to <Cluster u'Unmatched Files'>
D: <sip.voidptr object at 0x03732458> 20:16:17 Moving <File u'10 Permanent Tears.flac'> from <Track 99e93270-bbfa-4282-819d-70c1b2f30b61 u'Permanent Tears'> to <Cluster u'Unmatched Files'>
D: <sip.voidptr object at 0x03732458> 20:16:17 Moving <File u'11 Death Defied by Will.flac'> from <Track 5c64740e-574f-487e-b08a-396cfab56f96 u'Death Defied by Will'> to <Cluster u'Unmatched Files'>
D: <sip.voidptr object at 0x03732458> 20:16:17 Moving <File u'12 Desireless.flac'> from <Track 4f58bc2a-5af2-48d6-9bab-7f3ff355eb25 u'Desireless'> to <Cluster u'Unmatched Files'>
D: <sip.voidptr object at 0x03732458> 20:16:17 'Loading album 0af47224-07c0-430e-8edb-fb8a598a1891...'
D: <sip.voidptr object at 0x03732458> 20:16:17 Last request to (u'musicbrainz.org', 80) was 2327 ms ago, starting another one
D: <sip.voidptr object at 0x03732458> 20:16:17 GET http://musicbrainz.org:80/ws/2/release/0af47224-07c0-430e-8edb-fb8a598a1891?inc=release-groups+media+recordings+artist-credits+artists+aliases+labels+isrcs+collections+artist-rels+release-rels+url-rels+recording-rels+work-rels
D: <sip.voidptr object at 0x03732458> 20:16:18 Received reply for http://musicbrainz.org:80/ws/2/release/0af47224-07c0-430e-8edb-fb8a598a1891?inc=release-groups+media+recordings+artist-credits+artists+aliases+labels+isrcs+collections+artist-rels+release-rels+url-rels+recording-rels+work-rels: HTTP 200 (OK) (CACHED)
D: <sip.voidptr object at 0x03732458> 20:16:18 Loading release u'0af47224-07c0-430e-8edb-fb8a598a1891'
D: <sip.voidptr object at 0x03732458> 20:16:18 There are suitable images in the cover art archive for 0af47224-07c0-430e-8edb-fb8a598a1891
D: <sip.voidptr object at 0x03732458> 20:16:18 Last request to ('coverartarchive.org', 80) was 0 ms ago, starting another one
D: <sip.voidptr object at 0x03732458> 20:16:18 GET http://coverartarchive.org:80/release/0af47224-07c0-430e-8edb-fb8a598a1891/
D: <sip.voidptr object at 0x03732458> 20:16:19 Received reply for http://coverartarchive.org:80/release/0af47224-07c0-430e-8edb-fb8a598a1891/: HTTP 307 (TEMPORARY REDIRECT)
D: <sip.voidptr object at 0x03732458> 20:16:19 Redirect to http://archive.org/download/mbid-0af47224-07c0-430e-8edb-fb8a598a1891/index.json requested
D: <sip.voidptr object at 0x03732458> 20:16:19 Setting rate limit for archive.org:80 to 0
D: <sip.voidptr object at 0x03732458> 20:16:19 Last request to ('archive.org', 80) was 0 ms ago, starting another one
D: <sip.voidptr object at 0x03732458> 20:16:19 GET http://archive.org:80/download/mbid-0af47224-07c0-430e-8edb-fb8a598a1891/index.json
D: <sip.voidptr object at 0x03732458> 20:16:19 Received reply for http://archive.org:80/download/mbid-0af47224-07c0-430e-8edb-fb8a598a1891/index.json: HTTP 302 (Moved Temporarily)
D: <sip.voidptr object at 0x03732458> 20:16:19 Redirect to http://ia601003.us.archive.org/17/items/mbid-0af47224-07c0-430e-8edb-fb8a598a1891/index.json requested
D: <sip.voidptr object at 0x03732458> 20:16:19 Setting rate limit for ia601003.us.archive.org:80 to 0
D: <sip.voidptr object at 0x03732458> 20:16:19 Last request to ('ia601003.us.archive.org', 80) was 0 ms ago, starting another one
D: <sip.voidptr object at 0x03732458> 20:16:19 GET http://ia601003.us.archive.org:80/17/items/mbid-0af47224-07c0-430e-8edb-fb8a598a1891/index.json
D: <sip.voidptr object at 0x03732458> 20:16:19 Received reply for http://ia601003.us.archive.org:80/17/items/mbid-0af47224-07c0-430e-8edb-fb8a598a1891/index.json: HTTP 200 (OK) (CACHED)
D: <sip.voidptr object at 0x03732458> 20:16:19 Adding Front image PyQt4.QtCore.QUrl(u'http://coverartarchive.org/release/0af47224-07c0-430e-8edb-fb8a598a1891/5884663153-500.jpg')
D: <sip.voidptr object at 0x03732458> 20:16:19 'Downloading http://coverartarchive.org:80/release/0af47224-07c0-430e-8edb-fb8a598a1891/5884663153-500.jpg'
D: <sip.voidptr object at 0x03732458> 20:16:19 Last request to ('coverartarchive.org', 80) was 402 ms ago, starting another one
D: <sip.voidptr object at 0x03732458> 20:16:19 GET http://coverartarchive.org:80/release/0af47224-07c0-430e-8edb-fb8a598a1891/5884663153-500.jpg
D: <sip.voidptr object at 0x03732458> 20:16:19 Received reply for http://coverartarchive.org:80/release/0af47224-07c0-430e-8edb-fb8a598a1891/5884663153-500.jpg: HTTP 307 (TEMPORARY REDIRECT)
D: <sip.voidptr object at 0x03732458> 20:16:19 Redirect to http://archive.org/download/mbid-0af47224-07c0-430e-8edb-fb8a598a1891/mbid-0af47224-07c0-430e-8edb-fb8a598a1891-5884663153_thumb500.jpg requested
D: <sip.voidptr object at 0x03732458> 20:16:19 Last request to ('archive.org', 80) was 289 ms ago, starting another one
D: <sip.voidptr object at 0x03732458> 20:16:19 GET http://archive.org:80/download/mbid-0af47224-07c0-430e-8edb-fb8a598a1891/mbid-0af47224-07c0-430e-8edb-fb8a598a1891-5884663153_thumb500.jpg
D: <sip.voidptr object at 0x03732458> 20:16:19 Received reply for http://archive.org:80/download/mbid-0af47224-07c0-430e-8edb-fb8a598a1891/mbid-0af47224-07c0-430e-8edb-fb8a598a1891-5884663153_thumb500.jpg: HTTP 302 (Moved Temporarily)
D: <sip.voidptr object at 0x03732458> 20:16:19 Redirect to http://ia801003.us.archive.org/17/items/mbid-0af47224-07c0-430e-8edb-fb8a598a1891/mbid-0af47224-07c0-430e-8edb-fb8a598a1891-5884663153_thumb500.jpg requested
D: <sip.voidptr object at 0x03732458> 20:16:19 Setting rate limit for ia801003.us.archive.org:80 to 0
D: <sip.voidptr object at 0x03732458> 20:16:19 Last request to ('ia801003.us.archive.org', 80) was 0 ms ago, starting another one
D: <sip.voidptr object at 0x03732458> 20:16:19 GET http://ia801003.us.archive.org:80/17/items/mbid-0af47224-07c0-430e-8edb-fb8a598a1891/mbid-0af47224-07c0-430e-8edb-fb8a598a1891-5884663153_thumb500.jpg
D: <sip.voidptr object at 0x03732458> 20:16:20 Received reply for http://ia801003.us.archive.org:80/17/items/mbid-0af47224-07c0-430e-8edb-fb8a598a1891/mbid-0af47224-07c0-430e-8edb-fb8a598a1891-5884663153_thumb500.jpg: HTTP 200 (OK) (CACHED)
D: <sip.voidptr object at 0x03732458> 20:16:20 'Coverart http://ia801003.us.archive.org:80/17/items/mbid-0af47224-07c0-430e-8edb-fb8a598a1891/mbid-0af47224-07c0-430e-8edb-fb8a598a1891-5884663153_thumb500.jpg downloaded'
D: <sip.voidptr object at 0x03732458> 20:16:20 Moving <File u'01 Save Tonight.flac'> from <Cluster u'Unmatched Files'> to <Track d8a837d1-886d-44e4-aa72-d19e61180b3b u'Save Tonight'>
D: <sip.voidptr object at 0x03732458> 20:16:20 Moving <File u'02 Indecision.flac'> from <Cluster u'Unmatched Files'> to <Track 4b783fb5-7657-4c87-9b4b-703d4d35d4d0 u'Indecision'>
D: <sip.voidptr object at 0x03732458> 20:16:20 Moving <File u'03 Comatose (In the Arms of Slumber).flac'> from <Cluster u'Unmatched Files'> to <Track a000a642-8c7d-4100-a36f-d78069c44068 u'Comatose (In the Arms of Slumber)'>
D: <sip.voidptr object at 0x03732458> 20:16:20 Moving <File u'04 Worried Eyes.flac'> from <Cluster u'Unmatched Files'> to <Track 3702fd7b-6786-4314-863c-07b24e875b35 u'Worried Eyes'>
D: <sip.voidptr object at 0x03732458> 20:16:20 Moving <File u'05 Rainbow Wings.flac'> from <Cluster u'Unmatched Files'> to <Track f09d9eee-fde5-4e28-817c-2c98dc1aa947 u'Rainbow Wings'>
D: <sip.voidptr object at 0x03732458> 20:16:20 Moving <File u'06 Falling in Love Again.flac'> from <Cluster u'Unmatched Files'> to <Track 4e4d88df-b925-42c0-a9ac-07ab080e945e u'Falling in Love Again'>
D: <sip.voidptr object at 0x03732458> 20:16:20 Moving <File u'07 Conversation.flac'> from <Cluster u'Unmatched Files'> to <Track 06bcb423-fc71-4112-a92c-c3aec06e68cc u'Conversation'>
D: <sip.voidptr object at 0x03732458> 20:16:20 Moving <File u'08 When Mermaids Cry.flac'> from <Cluster u'Unmatched Files'> to <Track 5828251f-56b9-4071-b8de-a36688b679cd u'When Mermaids Cry'>
D: <sip.voidptr object at 0x03732458> 20:16:20 Moving <File u'09 Shooting Up in Vain.flac'> from <Cluster u'Unmatched Files'> to <Track 992cf58b-8e69-40f7-ae24-247ec24d15ea u'Shooting Up in Vain'>
D: <sip.voidptr object at 0x03732458> 20:16:20 Moving <File u'10 Permanent Tears.flac'> from <Cluster u'Unmatched Files'> to <Track 99e93270-bbfa-4282-819d-70c1b2f30b61 u'Permanent Tears'>
D: <sip.voidptr object at 0x03732458> 20:16:20 Moving <File u'11 Death Defied by Will.flac'> from <Cluster u'Unmatched Files'> to <Track 5c64740e-574f-487e-b08a-396cfab56f96 u'Death Defied by Will'>
D: <sip.voidptr object at 0x03732458> 20:16:20 Moving <File u'12 Desireless.flac'> from <Cluster u'Unmatched Files'> to <Track 4f58bc2a-5af2-48d6-9bab-7f3ff355eb25 u'Desireless'>
D: <sip.voidptr object at 0x03732458> 20:16:20 u'Album 0af47224-07c0-430e-8edb-fb8a598a1891 loaded'
D: <sip.voidptr object at 0x03732458> 20:16:22 Updating file <File u'01 Save Tonight.flac'>
D: <sip.voidptr object at 0x03732458> 20:16:22 Updating file <File u'07 Conversation.flac'>
D: <sip.voidptr object at 0x03732458> 20:16:22 Saving file u'Y:\\Music
!Unsorted & untagged
!unchecked albums
Eagle-Eye Cherry\\Desireless
01 Save Tonight.flac'
D: <sip.voidptr object at 0x03732458> 20:16:22 Updating file <File u'03 Comatose (In the Arms of Slumber).flac'>
D: <sip.voidptr object at 0x03732458> 20:16:22 Updating file <File u'02 Indecision.flac'>
D: <sip.voidptr object at 0x03732458> 20:16:22 Updating file <File u'05 Rainbow Wings.flac'>
D: <sip.voidptr object at 0x03732458> 20:16:22 Updating file <File u'04 Worried Eyes.flac'>
D: <sip.voidptr object at 0x03732458> 20:16:22 Updating file <File u'09 Shooting Up in Vain.flac'>
D: <sip.voidptr object at 0x03732458> 20:16:22 Updating file <File u'06 Falling in Love Again.flac'>
D: <sip.voidptr object at 0x03732458> 20:16:22 Updating file <File u'11 Death Defied by Will.flac'>
D: <sip.voidptr object at 0x03732458> 20:16:22 Updating file <File u'08 When Mermaids Cry.flac'>
D: <sip.voidptr object at 0x03732458> 20:16:22 Updating file <File u'10 Permanent Tears.flac'>
D: <sip.voidptr object at 0x03732458> 20:16:22 Updating file <File u'12 Desireless.flac'>
E: <sip.voidptr object at 0x03732458> 20:16:22 Traceback (most recent call last):
File "picard\util\thread.pyo", line 58, in run_item
File "picard\file.pyo", line 167, in _save_and_rename
File "picard\formats\vorbis.pyo", line 172, in _save
File "mutagen\flac.pyo", line 652, in save
File "picard\formats_init_.pyo", line 70, in _insert_bytes_no_mmap
IOError: [Errno 13] Permission denied

D: <sip.voidptr object at 0x03732458> 20:16:22 Updating file <File u'01 Save Tonight.flac'>
D: <sip.voidptr object at 0x03732458> 20:16:22 Saving file u'Y:\\Music
!Unsorted & untagged
!unchecked albums
Eagle-Eye Cherry\\Desireless
07 Conversation.flac'
E: <sip.voidptr object at 0x03732458> 20:16:22 Traceback (most recent call last):
File "picard\util\thread.pyo", line 58, in run_item
File "picard\file.pyo", line 167, in _save_and_rename
File "picard\formats\vorbis.pyo", line 172, in _save
File "mutagen\flac.pyo", line 652, in save
File "picard\formats_init_.pyo", line 70, in _insert_bytes_no_mmap
IOError: [Errno 13] Permission denied

D: <sip.voidptr object at 0x03732458> 20:16:22 Updating file <File u'07 Conversation.flac'>
D: <sip.voidptr object at 0x03732458> 20:16:23 Saving file u'Y:\\Music
!Unsorted & untagged
!unchecked albums
Eagle-Eye Cherry\\Desireless
03 Comatose (In the Arms of Slumber).flac'
E: <sip.voidptr object at 0x03732458> 20:16:23 Traceback (most recent call last):
File "picard\util\thread.pyo", line 58, in run_item
File "picard\file.pyo", line 167, in _save_and_rename
File "picard\formats\vorbis.pyo", line 172, in _save
File "mutagen\flac.pyo", line 652, in save
File "picard\formats_init_.pyo", line 70, in _insert_bytes_no_mmap
IOError: [Errno 13] Permission denied

D: <sip.voidptr object at 0x03732458> 20:16:23 Updating file <File u'03 Comatose (In the Arms of Slumber).flac'>
D: <sip.voidptr object at 0x03732458> 20:16:23 Saving file u'Y:\\Music
!Unsorted & untagged
!unchecked albums
Eagle-Eye Cherry\\Desireless
02 Indecision.flac'
E: <sip.voidptr object at 0x03732458> 20:16:23 Traceback (most recent call last):
File "picard\util\thread.pyo", line 58, in run_item
File "picard\file.pyo", line 167, in _save_and_rename
File "picard\formats\vorbis.pyo", line 172, in _save
File "mutagen\flac.pyo", line 652, in save
File "picard\formats_init_.pyo", line 70, in _insert_bytes_no_mmap
IOError: [Errno 13] Permission denied

D: <sip.voidptr object at 0x03732458> 20:16:23 Updating file <File u'02 Indecision.flac'>
D: <sip.voidptr object at 0x03732458> 20:16:23 Saving file u'Y:\\Music
!Unsorted & untagged
!unchecked albums
Eagle-Eye Cherry\\Desireless
05 Rainbow Wings.flac'
E: <sip.voidptr object at 0x03732458> 20:16:23 Traceback (most recent call last):
File "picard\util\thread.pyo", line 58, in run_item
File "picard\file.pyo", line 167, in _save_and_rename
File "picard\formats\vorbis.pyo", line 172, in _save
File "mutagen\flac.pyo", line 652, in save
File "picard\formats_init_.pyo", line 70, in _insert_bytes_no_mmap
IOError: [Errno 13] Permission denied

D: <sip.voidptr object at 0x03732458> 20:16:23 Updating file <File u'05 Rainbow Wings.flac'>
D: <sip.voidptr object at 0x03732458> 20:16:23 Saving file u'Y:\\Music
!Unsorted & untagged
!unchecked albums
Eagle-Eye Cherry\\Desireless
04 Worried Eyes.flac'
E: <sip.voidptr object at 0x03732458> 20:16:23 Traceback (most recent call last):
File "picard\util\thread.pyo", line 58, in run_item
File "picard\file.pyo", line 167, in _save_and_rename
File "picard\formats\vorbis.pyo", line 172, in _save
File "mutagen\flac.pyo", line 652, in save
File "picard\formats_init_.pyo", line 70, in _insert_bytes_no_mmap
IOError: [Errno 13] Permission denied

D: <sip.voidptr object at 0x03732458> 20:16:23 Updating file <File u'04 Worried Eyes.flac'>
D: <sip.voidptr object at 0x03732458> 20:16:23 Saving file u'Y:\\Music
!Unsorted & untagged
!unchecked albums
Eagle-Eye Cherry\\Desireless
09 Shooting Up in Vain.flac'
E: <sip.voidptr object at 0x03732458> 20:16:23 Traceback (most recent call last):
File "picard\util\thread.pyo", line 58, in run_item
File "picard\file.pyo", line 167, in _save_and_rename
File "picard\formats\vorbis.pyo", line 172, in _save
File "mutagen\flac.pyo", line 652, in save
File "picard\formats_init_.pyo", line 70, in _insert_bytes_no_mmap
IOError: [Errno 13] Permission denied

D: <sip.voidptr object at 0x03732458> 20:16:23 Updating file <File u'09 Shooting Up in Vain.flac'>
D: <sip.voidptr object at 0x03732458> 20:16:23 Saving file u'Y:\\Music
!Unsorted & untagged
!unchecked albums
Eagle-Eye Cherry\\Desireless
06 Falling in Love Again.flac'
E: <sip.voidptr object at 0x03732458> 20:16:23 Traceback (most recent call last):
File "picard\util\thread.pyo", line 58, in run_item
File "picard\file.pyo", line 167, in _save_and_rename
File "picard\formats\vorbis.pyo", line 172, in _save
File "mutagen\flac.pyo", line 652, in save
File "picard\formats_init_.pyo", line 70, in _insert_bytes_no_mmap
IOError: [Errno 13] Permission denied

D: <sip.voidptr object at 0x03732458> 20:16:23 Updating file <File u'06 Falling in Love Again.flac'>
D: <sip.voidptr object at 0x03732458> 20:16:23 Saving file u'Y:\\Music
!Unsorted & untagged
!unchecked albums
Eagle-Eye Cherry\\Desireless
11 Death Defied by Will.flac'
E: <sip.voidptr object at 0x03732458> 20:16:23 Traceback (most recent call last):
File "picard\util\thread.pyo", line 58, in run_item
File "picard\file.pyo", line 167, in _save_and_rename
File "picard\formats\vorbis.pyo", line 172, in _save
File "mutagen\flac.pyo", line 652, in save
File "picard\formats_init_.pyo", line 70, in _insert_bytes_no_mmap
IOError: [Errno 13] Permission denied

D: <sip.voidptr object at 0x03732458> 20:16:23 Updating file <File u'11 Death Defied by Will.flac'>
D: <sip.voidptr object at 0x03732458> 20:16:24 Saving file u'Y:\\Music
!Unsorted & untagged
!unchecked albums
Eagle-Eye Cherry\\Desireless
08 When Mermaids Cry.flac'
E: <sip.voidptr object at 0x03732458> 20:16:24 Traceback (most recent call last):
File "picard\util\thread.pyo", line 58, in run_item
File "picard\file.pyo", line 167, in _save_and_rename
File "picard\formats\vorbis.pyo", line 172, in _save
File "mutagen\flac.pyo", line 652, in save
File "picard\formats_init_.pyo", line 70, in _insert_bytes_no_mmap
IOError: [Errno 13] Permission denied

D: <sip.voidptr object at 0x03732458> 20:16:24 Updating file <File u'08 When Mermaids Cry.flac'>
D: <sip.voidptr object at 0x03732458> 20:16:24 Saving file u'Y:\\Music
!Unsorted & untagged
!unchecked albums
Eagle-Eye Cherry\\Desireless
10 Permanent Tears.flac'
E: <sip.voidptr object at 0x03732458> 20:16:24 Traceback (most recent call last):
File "picard\util\thread.pyo", line 58, in run_item
File "picard\file.pyo", line 167, in _save_and_rename
File "picard\formats\vorbis.pyo", line 172, in _save
File "mutagen\flac.pyo", line 652, in save
File "picard\formats_init_.pyo", line 70, in _insert_bytes_no_mmap
IOError: [Errno 13] Permission denied

D: <sip.voidptr object at 0x03732458> 20:16:24 Updating file <File u'10 Permanent Tears.flac'>
D: <sip.voidptr object at 0x03732458> 20:16:24 Saving file u'Y:\\Music
!Unsorted & untagged
!unchecked albums
Eagle-Eye Cherry\\Desireless
12 Desireless.flac'
E: <sip.voidptr object at 0x03732458> 20:16:24 Traceback (most recent call last):
File "picard\util\thread.pyo", line 58, in run_item
File "picard\file.pyo", line 167, in _save_and_rename
File "picard\formats\vorbis.pyo", line 172, in _save
File "mutagen\flac.pyo", line 652, in save
File "picard\formats_init_.pyo", line 70, in _insert_bytes_no_mmap
IOError: [Errno 13] Permission denied

D: <sip.voidptr object at 0x03732458> 20:16:24 Updating file <File u'12 Desireless.flac'>

Files can be moved around, renamed and tagged using Windows Explorer, indicating that the correct permissions are in place and that files are not read-only, but when Picard tries to save to them, the Permission Denied error is received. Other FLAC files can be written to/from the same directories.