2018-09-24 18:38:46,562 (7f1ad1afc700) :  INFO (core:349) - Starting framework core - Version: 2.6.3, Build: 21ab172 (Sat Aug 18 04:15:06 UTC 2018)
2018-09-24 18:38:46,563 (7f1ad1afc700) :  DEBUG (core:361) - Using the elevated policy
2018-09-24 18:38:46,563 (7f1ad1afc700) :  DEBUG (core:450) - Starting runtime component.
2018-09-24 18:38:46,566 (7f1ad1afc700) :  DEBUG (core:450) - Starting caching component.
2018-09-24 18:38:46,567 (7f1ad1afc700) :  DEBUG (core:450) - Starting data component.
2018-09-24 18:38:46,567 (7f1ad1afc700) :  DEBUG (core:450) - Starting networking component.
2018-09-24 18:38:46,568 (7f1ad1afc700) :  DEBUG (networking:284) - Loaded HTTP cookies
2018-09-24 18:38:46,638 (7f1ad1afc700) :  DEBUG (networking:452) - Setting the default network timeout to 20.0
2018-09-24 18:38:46,640 (7f1ad1afc700) :  DEBUG (core:450) - Starting localization component.
2018-09-24 18:38:46,640 (7f1ad1afc700) :  INFO (localization:409) - Setting the default locale to en-us
2018-09-24 18:38:46,641 (7f1ad1afc700) :  DEBUG (core:450) - Starting messaging component.
2018-09-24 18:38:46,642 (7f1ad1afc700) :  DEBUG (core:450) - Starting debugging component.
2018-09-24 18:38:46,643 (7f1ad1afc700) :  DEBUG (core:450) - Starting services component.
2018-09-24 18:38:46,643 (7f1aabd11700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/system/messaging/clear_events/com.plexapp.agents.lyricfind'
2018-09-24 18:38:46,643 (7f1ad1afc700) :  DEBUG (core:450) - Starting myplex component.
2018-09-24 18:38:46,645 (7f1ad1afc700) :  DEBUG (core:450) - Starting notifications component.
2018-09-24 18:38:46,918 (7f1ad1afc700) :  DEBUG (accessor:68) - Creating a new model access point for provider com.plexapp.agents.lyricfind in namespace 'metadata'
2018-09-24 18:38:46,929 (7f1ad1afc700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/resourceHashes'
2018-09-24 18:38:46,961 (7f1aabd11700) :  DEBUG (services:265) - Plug-in is not daemonized - loading services from system
2018-09-24 18:38:46,962 (7f1ad1afc700) :  DEBUG (runtime:1117) - Created a thread named 'load_all_services'
2018-09-24 18:38:46,963 (7f1aabd11700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_'
2018-09-24 18:38:46,969 (7f1ad1afc700) :  DEBUG (runtime:1117) - Created a thread named 'get_server_info'
2018-09-24 18:38:46,970 (7f1ad1afc700) :  DEBUG (core:150) - Finished starting framework core
2018-09-24 18:38:46,970 (7f1aab5f5700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400'
2018-09-24 18:38:46,970 (7f1ad1afc700) :  DEBUG (core:560) - Loading plug-in code
2018-09-24 18:38:46,978 (7f1aab5f5700) :  DEBUG (core:538) - Machine identifier is 0527976522a83a79b0b9961b3b2e99b955460851
2018-09-24 18:38:46,978 (7f1aab5f5700) :  DEBUG (core:539) - Server version is 1.13.5.5332-21ab172de
2018-09-24 18:38:47,041 (7f1ad1afc700) :  DEBUG (core:566) - Finished loading plug-in code
2018-09-24 18:38:47,042 (7f1ad1afc700) :  DEBUG (agentkit:1115) - Creating new agent class called LyricFindAlbumAgent
2018-09-24 18:38:47,043 (7f1ad1afc700) :  DEBUG (agentkit:933) - Updating agent information: [{'media_types': ['Album'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.plexmusic', 'com.plexapp.agents.localmedia', 'com.plexapp.agents.lastfm'], 'languages': ['xn'], 'persist_stored_files': True, 'version': 0, 'primary_provider': False, 'prefs': False, 'name': 'LyricFind'}]
2018-09-24 18:38:47,045 (7f1ad1afc700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQo2CmRpY3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0CjIKczI4CmNvbS5wbGV4YXBwLmFnZW50cy5seXJpY2ZpbmRzMTAKaWRlbnRpZmllcnIxCnMxMAphZ2VudF9pbmZvMQpyMgoxMApyMwpzMTEKbWVkaWFfdHlwZXNuczEyCmFjY2VwdHNfZnJvbW5zMTQKZmFsbGJhY2tfYWdlbnRyNApzMTQKY29udHJpYnV0ZXNfdG9yNQpzOQpsYW5ndWFnZXNiMXMyMApwZXJzaXN0X3N0b3JlZF9maWxlc2kwCnM3CnZlcnNpb25iMHMxNgpwcmltYXJ5X3Byb3ZpZGVyYjBzNQpwcmVmc3M5Ckx5cmljRmluZHM0Cm5hbWUxCnM1CkFsYnVtMwpzMjgKY29tLnBsZXhhcHAuYWdlbnRzLnBsZXhtdXNpY3MyOQpjb20ucGxleGFwcC5hZ2VudHMubG9jYWxtZWRpYXMyNQpjb20ucGxleGFwcC5hZ2VudHMubGFzdGZtMQpzMgp4bnIwCg__'
2018-09-24 18:38:47,239 (7f1aabd11700) :  DEBUG (services:362) - Loaded services
2018-09-24 18:38:47,249 (7f1aab8e3700) :  DEBUG (services:438) - No shared code to load
2018-09-24 18:38:47,251 (7f1ad1afc700) :  INFO (core:611) - Started plug-in
2018-09-24 18:38:47,252 (7f1ad1afc700) :  DEBUG (socketinterface:160) - Starting socket server
2018-09-24 18:38:47,253 (7f1ad1afc700) :  DEBUG (runtime:1117) - Created a thread named 'start'
2018-09-24 18:38:47,253 (7f1ad1afc700) :  INFO (socketinterface:184) - Socket server started on port 34184
2018-09-24 18:38:47,254 (7f1ad1afc700) :  INFO (pipeinterface:25) - Entering run loop
2018-09-24 18:38:47,254 (7f1ad1afc700) :  DEBUG (runtime:717) - Handling request GET /:/prefixes
2018-09-24 18:38:47,257 (7f1ad1afc700) :  DEBUG (runtime:814) - Found route matching /:/prefixes
2018-09-24 18:38:47,258 (7f1ad1afc700) :  DEBUG (runtime:924) - Response: [200] MediaContainer, 153 bytes
2018-09-24 18:38:48,477 (7f1aabd11700) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM0CjE4NDJzOApwYXJlbnRJRHMxMgpsb2NhbDovLzI0OTRzNApndWlkYjFzNQpmb3JjZXMyOQpjb20ucGxleGFwcC5hZ2VudHMubG9jYWxtZWRpYXMxMwpwcmltYXJ5X2FnZW50czQKMjQ5NHMyCmlkcjAK
2018-09-24 18:38:48,478 (7f1aabd11700) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-09-24 18:38:48,502 (7f1aabd11700) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM0CjE4NDJzOApwYXJlbnRJRHMxMgpsb2NhbDovLzI0OTRzNApndWlkYjFzNQpmb3JjZXMyOQpjb20ucGxleGFwcC5hZ2VudHMubG9jYWxtZWRpYXMxMwpwcmltYXJ5X2FnZW50czQKMjQ5NHMyCmlkcjAK
2018-09-24 18:38:48,502 (7f1aabd11700) :  INFO (agentkit:957) - Searching for matches for {'id': '2494', 'guid': 'local://2494', 'force': True, 'primary_agent': 'com.plexapp.agents.localmedia', 'parentID': '1842'}
2018-09-24 18:38:48,531 (7f1aabd11700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/2494/tree'
2018-09-24 18:38:48,549 (7f1aabd11700) :  DEBUG (accessor:68) - Creating a new read-only model access point for provider com.plexapp.agents.localmedia in namespace 'metadata'
2018-09-24 18:38:48,557 (7f1aabd11700) :  DEBUG (model:32) - Loading model with GUID local://2494
2018-09-24 18:38:48,560 (7f1aabd11700) :  DEBUG (model:234) - Deserializing from /volume1/Plex/Library/Application Support/Plex Media Server/Metadata/Albums/7/1c97418cdb61039b4608b941dee94b6dbae25d8.bundle/Contents/com.plexapp.agents.localmedia/Info.xml
2018-09-24 18:38:48,571 (7f1aabd11700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/1842/tree'
2018-09-24 18:38:48,600 (7f1aabd11700) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-09-24 18:38:48,601 (7f1aabd11700) :  DEBUG (runtime:924) - Response: [200] str, 300 bytes
2018-09-24 18:38:48,628 (7f1aabd11700) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNAoyNDk0czQKZGJpZGkwCnM3CnZlcnNpb25zNTEKY29tLnBsZXhhcHAuYWdlbnRzLmxhc3RmbTovL0FyaWFuYSUyMEdyYW5kZT9sYW5nPWVuczEwCnBhcmVudEdVSURzNAoxODQyczgKcGFyZW50SURzNQpBbGJ1bXMxMAptZWRpYV90eXBlczEyCmxvY2FsOi8vMjQ5NHM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-09-24 18:38:48,629 (7f1aabd11700) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-09-24 18:38:48,631 (7f1aabd11700) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNAoyNDk0czQKZGJpZGkwCnM3CnZlcnNpb25zNTEKY29tLnBsZXhhcHAuYWdlbnRzLmxhc3RmbTovL0FyaWFuYSUyMEdyYW5kZT9sYW5nPWVuczEwCnBhcmVudEdVSURzNAoxODQyczgKcGFyZW50SURzNQpBbGJ1bXMxMAptZWRpYV90eXBlczEyCmxvY2FsOi8vMjQ5NHM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-09-24 18:38:48,632 (7f1aabd11700) :  DEBUG (model:32) - Loading model with GUID local://2494
2018-09-24 18:38:48,633 (7f1aabd11700) :  ERROR (model:205) - Cannot read model from /volume1/Plex/Library/Application Support/Plex Media Server/Metadata/Albums/7/1c97418cdb61039b4608b941dee94b6dbae25d8.bundle/Contents/com.plexapp.agents.lyricfind
2018-09-24 18:38:48,634 (7f1aabd11700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/2494/tree'
2018-09-24 18:38:49,059 (7f1aabd11700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Ariana%20Grande&album=Greatest%20Songs'
2018-09-24 18:38:49,820 (7f1aabd11700) :  DEBUG (threadkit:234) - Starting a parallel task set named MatchLyrics with 20 tasks
2018-09-24 18:38:49,946 (7f1aab247700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Ariana%20Grande&track=No%20Tears%20Left%20To%20Cry'
2018-09-24 18:38:49,959 (7f1aab5f5700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Ariana%20Grande&track=Focus'
2018-09-24 18:38:49,977 (7f1aaac6b700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Ariana%20Grande&track=Bang%20Bang%20%28Feat.%20Jessie%20J%20%26%20Nicki%20Minaj%29'
2018-09-24 18:38:49,984 (7f1aaaf59700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Ariana%20Grande&track=Almost%20Is%20Never%20Enough'
2018-09-24 18:38:50,385 (7f1aab247700) :  INFO (__init__:32) - Adding Lyric No Tears Left to Cry to track No Tears Left To Cry
2018-09-24 18:38:50,390 (7f1aab5f5700) :  INFO (__init__:32) - Adding Lyric Focus to track Focus
2018-09-24 18:38:50,411 (7f1aaaf59700) :  INFO (__init__:32) - Adding Lyric Almost is Never Enough to track Almost Is Never Enough
2018-09-24 18:38:50,440 (7f1aab5f5700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Ariana%20Grande&track=Greedy'
2018-09-24 18:38:50,476 (7f1aab247700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Ariana%20Grande&track=The%20Way%20%28Feat.%20Mac%20Miller%29'
2018-09-24 18:38:50,490 (7f1aaaf59700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Ariana%20Grande&track=Everyday%20%28Feat.%20Future%29'
2018-09-24 18:38:50,773 (7f1aaac6b700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Ariana%20Grande&track=Break%20Fee%20%28Feat.%20Zedd%29'
2018-09-24 18:38:50,849 (7f1aab5f5700) :  INFO (__init__:32) - Adding Lyric Greedy to track Greedy
2018-09-24 18:38:50,851 (7f1aab5f5700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Ariana%20Grande&track=God%20Is%20A%20Woman'
2018-09-24 18:38:50,894 (7f1aab247700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Ariana%20Grande&track=The%20Light%20Is%20Coming%20%28Feat.%20Nicki%20Minaj%29'
2018-09-24 18:38:51,263 (7f1aab5f5700) :  INFO (__init__:32) - Adding Lyric God Is a woman to track God Is A Woman
2018-09-24 18:38:51,291 (7f1aab5f5700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Ariana%20Grande&track=Right%20There%20%28Feat.%20Big%20Sean%29'
2018-09-24 18:38:51,307 (7f1aab247700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Ariana%20Grande&track=Side%20to%20Side%20%28Feat.%20Nicki%20Minaj%29'
2018-09-24 18:38:51,333 (7f1aaaf59700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Ariana%20Grande&track=Dangerous%20Woman'
2018-09-24 18:38:51,532 (7f1aaac6b700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Ariana%20Grande&track=Let%20Me%20Love%20You%20%28Feat.%20Lil%20Wayne%29'
2018-09-24 18:38:51,705 (7f1aab5f5700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Ariana%20Grande&track=Into%20You'
2018-09-24 18:38:51,756 (7f1aaaf59700) :  INFO (__init__:32) - Adding Lyric Dangerous Woman to track Dangerous Woman
2018-09-24 18:38:51,777 (7f1aaaf59700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Ariana%20Grande&track=Problem%20%28Feat.%20Iggy%20Azalea%29'
2018-09-24 18:38:52,137 (7f1aab5f5700) :  INFO (__init__:32) - Adding Lyric Into You to track Into You
2018-09-24 18:38:52,186 (7f1aab5f5700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Ariana%20Grande&track=Be%20Alright'
2018-09-24 18:38:52,187 (7f1aab247700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Ariana%20Grande&track=Love%20Me%20Harder%20%28Feat.%20The%20Weeknd%29'
2018-09-24 18:38:52,215 (7f1aaaf59700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Ariana%20Grande&track=Baby%20I'
2018-09-24 18:38:52,385 (7f1aaac6b700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Ariana%20Grande&track=One%20Last%20Time'
2018-09-24 18:38:52,626 (7f1aab5f5700) :  INFO (__init__:32) - Adding Lyric Be Alright to track Be Alright
2018-09-24 18:38:52,646 (7f1aaaf59700) :  INFO (__init__:32) - Adding Lyric Baby I to track Baby I
2018-09-24 18:38:52,816 (7f1aaac6b700) :  INFO (__init__:32) - Adding Lyric One Last Time to track One Last Time
2018-09-24 18:38:52,817 (7f1aabd11700) :  DEBUG (threadkit:244) - Parallel task set MatchLyrics ended
2018-09-24 18:38:52,865 (7f1aabd11700) :  DEBUG (model:229) - Serializing to /volume1/Plex/Library/Application Support/Plex Media Server/Metadata/Albums/7/1c97418cdb61039b4608b941dee94b6dbae25d8.bundle/Contents/com.plexapp.agents.lyricfind/Info.xml
2018-09-24 18:38:52,868 (7f1aabd11700) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-09-24 18:38:52,868 (7f1aabd11700) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
2018-09-24 18:38:53,665 (7f1aabd11700) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCmVuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM0CjE4NDJzOApwYXJlbnRJRHM2MQpjb20ucGxleGFwcC5hZ2VudHMubGFzdGZtOi8vQXJpYW5hJTIwR3JhbmRlL1N3ZWV0ZW5lcj9sYW5nPWVuczQKZ3VpZGIxczUKZm9yY2VzMjUKY29tLnBsZXhhcHAuYWdlbnRzLmxhc3RmbXMxMwpwcmltYXJ5X2FnZW50czQKMTg0M3MyCmlkcjAK
2018-09-24 18:38:53,667 (7f1aabd11700) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-09-24 18:38:53,669 (7f1aabd11700) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCmVuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM0CjE4NDJzOApwYXJlbnRJRHM2MQpjb20ucGxleGFwcC5hZ2VudHMubGFzdGZtOi8vQXJpYW5hJTIwR3JhbmRlL1N3ZWV0ZW5lcj9sYW5nPWVuczQKZ3VpZGIxczUKZm9yY2VzMjUKY29tLnBsZXhhcHAuYWdlbnRzLmxhc3RmbXMxMwpwcmltYXJ5X2FnZW50czQKMTg0M3MyCmlkcjAK
2018-09-24 18:38:53,669 (7f1aabd11700) :  INFO (agentkit:957) - Searching for matches for {'id': '1843', 'guid': 'com.plexapp.agents.lastfm://Ariana%20Grande/Sweetener?lang=en', 'force': True, 'primary_agent': 'com.plexapp.agents.lastfm', 'parentID': '1842'}
2018-09-24 18:38:53,704 (7f1aabd11700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/1843/tree'
2018-09-24 18:38:53,728 (7f1aabd11700) :  DEBUG (accessor:68) - Creating a new read-only model access point for provider com.plexapp.agents.lastfm in namespace 'metadata'
2018-09-24 18:38:53,736 (7f1aabd11700) :  DEBUG (model:32) - Loading model with GUID com.plexapp.agents.lastfm://Ariana%20Grande/Sweetener?lang=en
2018-09-24 18:38:53,737 (7f1aabd11700) :  DEBUG (model:234) - Deserializing from /volume1/Plex/Library/Application Support/Plex Media Server/Metadata/Albums/6/c12f0ddb5a11ed43dc15335707f4fc212273b3e.bundle/Contents/com.plexapp.agents.lastfm/Info.xml
2018-09-24 18:38:53,749 (7f1aabd11700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/1842/tree'
2018-09-24 18:38:53,783 (7f1aabd11700) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-09-24 18:38:53,784 (7f1aabd11700) :  DEBUG (runtime:924) - Response: [200] str, 300 bytes
2018-09-24 18:38:53,816 (7f1aabd11700) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNAoxODQzczQKZGJpZGkwCnM3CnZlcnNpb25zNTEKY29tLnBsZXhhcHAuYWdlbnRzLmxhc3RmbTovL0FyaWFuYSUyMEdyYW5kZT9sYW5nPWVuczEwCnBhcmVudEdVSURzNAoxODQyczgKcGFyZW50SURzNQpBbGJ1bXMxMAptZWRpYV90eXBlczYxCmNvbS5wbGV4YXBwLmFnZW50cy5sYXN0Zm06Ly9BcmlhbmElMjBHcmFuZGUvU3dlZXRlbmVyP2xhbmc9ZW5zNApndWlkczQKbnVsbHMyCmlkcjAK
2018-09-24 18:38:53,817 (7f1aabd11700) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-09-24 18:38:53,819 (7f1aabd11700) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNAoxODQzczQKZGJpZGkwCnM3CnZlcnNpb25zNTEKY29tLnBsZXhhcHAuYWdlbnRzLmxhc3RmbTovL0FyaWFuYSUyMEdyYW5kZT9sYW5nPWVuczEwCnBhcmVudEdVSURzNAoxODQyczgKcGFyZW50SURzNQpBbGJ1bXMxMAptZWRpYV90eXBlczYxCmNvbS5wbGV4YXBwLmFnZW50cy5sYXN0Zm06Ly9BcmlhbmElMjBHcmFuZGUvU3dlZXRlbmVyP2xhbmc9ZW5zNApndWlkczQKbnVsbHMyCmlkcjAK
2018-09-24 18:38:53,820 (7f1aabd11700) :  DEBUG (model:32) - Loading model with GUID com.plexapp.agents.lastfm://Ariana%20Grande/Sweetener?lang=en
2018-09-24 18:38:53,821 (7f1aabd11700) :  DEBUG (model:234) - Deserializing from /volume1/Plex/Library/Application Support/Plex Media Server/Metadata/Albums/6/c12f0ddb5a11ed43dc15335707f4fc212273b3e.bundle/Contents/com.plexapp.agents.lyricfind/Info.xml
2018-09-24 18:38:53,893 (7f1aabd11700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/1843/tree'
2018-09-24 18:38:53,919 (7f1aabd11700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Ariana%20Grande&album=Sweetener'
2018-09-24 18:38:54,254 (7f1aabd11700) :  DEBUG (threadkit:234) - Starting a parallel task set named MatchLyrics with 15 tasks
2018-09-24 18:38:54,266 (7f1aaaf59700) :  INFO (__init__:32) - Adding Lyric R.E.M to track R.E.M
2018-09-24 18:38:54,288 (7f1aaac6b700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Ariana%20Grande&track=blazed%20%28feat.%20Pharrell%20Williams%29'
2018-09-24 18:38:54,290 (7f1aab247700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Ariana%20Grande&track=the%20light%20is%20coming%20%28feat.%20Nicki%20Minaj%29'
2018-09-24 18:38:54,292 (7f1aaaf59700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Ariana%20Grande&track=God%20is%20a%20woman'
2018-09-24 18:38:54,297 (7f1aab5f5700) :  INFO (__init__:32) - Adding Lyric raindrops (an angel cried) to track raindrops (an angel cried)
2018-09-24 18:38:54,300 (7f1aab5f5700) :  INFO (__init__:32) - Adding Lyric sweetener to track sweetener
2018-09-24 18:38:54,303 (7f1aab5f5700) :  INFO (__init__:32) - Adding Lyric successful to track successful
2018-09-24 18:38:54,305 (7f1aab5f5700) :  INFO (__init__:32) - Adding Lyric everytime to track everytime
2018-09-24 18:38:54,307 (7f1aab5f5700) :  INFO (__init__:32) - Adding Lyric breathin to track breathin
2018-09-24 18:38:54,313 (7f1aab5f5700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Ariana%20Grande&track=no%20tears%20left%20to%20cry'
2018-09-24 18:38:54,637 (7f1aab5f5700) :  INFO (__init__:32) - Adding Lyric No Tears Left to Cry to track no tears left to cry
2018-09-24 18:38:54,645 (7f1aab5f5700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Ariana%20Grande&track=borderline%20%28feat.%20Missy%20Elliott%29'
2018-09-24 18:38:54,658 (7f1aaac6b700) :  INFO (__init__:32) - Adding Lyric better off to track better off
2018-09-24 18:38:54,665 (7f1aaac6b700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Ariana%20Grande&track=goodnight%20n%20go'
2018-09-24 18:38:54,673 (7f1aaaf59700) :  INFO (__init__:32) - Adding Lyric God Is a woman to track God is a woman
2018-09-24 18:38:54,676 (7f1aaaf59700) :  INFO (__init__:32) - Adding Lyric pete davidson to track pete davidson
2018-09-24 18:38:54,677 (7f1aaaf59700) :  INFO (__init__:32) - Adding Lyric get well soon to track get well soon
2018-09-24 18:38:55,008 (7f1aabd11700) :  DEBUG (threadkit:244) - Parallel task set MatchLyrics ended
2018-09-24 18:38:55,130 (7f1aabd11700) :  DEBUG (model:229) - Serializing to /volume1/Plex/Library/Application Support/Plex Media Server/Metadata/Albums/6/c12f0ddb5a11ed43dc15335707f4fc212273b3e.bundle/Contents/com.plexapp.agents.lyricfind/Info.xml
2018-09-24 18:38:55,132 (7f1aabd11700) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-09-24 18:38:55,133 (7f1aabd11700) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
2018-09-24 18:39:14,607 (7f1aabd11700) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCmVuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM0CjI1MTVzOApwYXJlbnRJRHM3Mgpjb20ucGxleGFwcC5hZ2VudHMubGFzdGZtOi8vQ2hyaXN0aW5hJTIwQWd1aWxlcmEvR3JlYXRlc3QlMjBIaXRzP2xhbmc9ZW5zNApndWlkYjFzNQpmb3JjZXMyNQpjb20ucGxleGFwcC5hZ2VudHMubGFzdGZtczEzCnByaW1hcnlfYWdlbnRzNAoyNTE2czIKaWRyMAo_
2018-09-24 18:39:14,609 (7f1aabd11700) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-09-24 18:39:14,611 (7f1aabd11700) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCmVuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM0CjI1MTVzOApwYXJlbnRJRHM3Mgpjb20ucGxleGFwcC5hZ2VudHMubGFzdGZtOi8vQ2hyaXN0aW5hJTIwQWd1aWxlcmEvR3JlYXRlc3QlMjBIaXRzP2xhbmc9ZW5zNApndWlkYjFzNQpmb3JjZXMyNQpjb20ucGxleGFwcC5hZ2VudHMubGFzdGZtczEzCnByaW1hcnlfYWdlbnRzNAoyNTE2czIKaWRyMAo_
2018-09-24 18:39:14,611 (7f1aabd11700) :  INFO (agentkit:957) - Searching for matches for {'id': '2516', 'guid': 'com.plexapp.agents.lastfm://Christina%20Aguilera/Greatest%20Hits?lang=en', 'force': True, 'primary_agent': 'com.plexapp.agents.lastfm', 'parentID': '2515'}
2018-09-24 18:39:14,612 (7f1aabd11700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/2516/tree'
2018-09-24 18:39:14,630 (7f1aabd11700) :  DEBUG (model:32) - Loading model with GUID com.plexapp.agents.lastfm://Christina%20Aguilera/Greatest%20Hits?lang=en
2018-09-24 18:39:14,631 (7f1aabd11700) :  DEBUG (model:234) - Deserializing from /volume1/Plex/Library/Application Support/Plex Media Server/Metadata/Albums/7/16a8549ae941e0041c7e981bf9bbea443c50dd5.bundle/Contents/com.plexapp.agents.lastfm/Info.xml
2018-09-24 18:39:14,648 (7f1aabd11700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/2515/tree'
2018-09-24 18:39:14,667 (7f1aabd11700) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-09-24 18:39:14,667 (7f1aabd11700) :  DEBUG (runtime:924) - Response: [200] str, 300 bytes
2018-09-24 18:39:14,679 (7f1aabd11700) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNAoyNTE2czQKZGJpZGkwCnM3CnZlcnNpb25zNTYKY29tLnBsZXhhcHAuYWdlbnRzLmxhc3RmbTovL0NocmlzdGluYSUyMEFndWlsZXJhP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM0CjI1MTVzOApwYXJlbnRJRHM1CkFsYnVtczEwCm1lZGlhX3R5cGVzNzIKY29tLnBsZXhhcHAuYWdlbnRzLmxhc3RmbTovL0NocmlzdGluYSUyMEFndWlsZXJhL0dyZWF0ZXN0JTIwSGl0cz9sYW5nPWVuczQKZ3VpZHM0Cm51bGxzMgppZHIwCg__
2018-09-24 18:39:14,681 (7f1aabd11700) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-09-24 18:39:14,682 (7f1aabd11700) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNAoyNTE2czQKZGJpZGkwCnM3CnZlcnNpb25zNTYKY29tLnBsZXhhcHAuYWdlbnRzLmxhc3RmbTovL0NocmlzdGluYSUyMEFndWlsZXJhP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM0CjI1MTVzOApwYXJlbnRJRHM1CkFsYnVtczEwCm1lZGlhX3R5cGVzNzIKY29tLnBsZXhhcHAuYWdlbnRzLmxhc3RmbTovL0NocmlzdGluYSUyMEFndWlsZXJhL0dyZWF0ZXN0JTIwSGl0cz9sYW5nPWVuczQKZ3VpZHM0Cm51bGxzMgppZHIwCg__
2018-09-24 18:39:14,683 (7f1aabd11700) :  DEBUG (model:32) - Loading model with GUID com.plexapp.agents.lastfm://Christina%20Aguilera/Greatest%20Hits?lang=en
2018-09-24 18:39:14,684 (7f1aabd11700) :  ERROR (model:205) - Cannot read model from /volume1/Plex/Library/Application Support/Plex Media Server/Metadata/Albums/7/16a8549ae941e0041c7e981bf9bbea443c50dd5.bundle/Contents/com.plexapp.agents.lyricfind
2018-09-24 18:39:14,685 (7f1aabd11700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/2516/tree'
2018-09-24 18:39:14,702 (7f1aabd11700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Christina%20Aguilera&album=Greatest%20Hits'
2018-09-24 18:39:14,819 (7f1aabd11700) :  DEBUG (threadkit:234) - Starting a parallel task set named MatchLyrics with 20 tasks
2018-09-24 18:39:14,824 (7f1aab5f5700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Christina%20Aguilera&track=Accelerate'
2018-09-24 18:39:14,839 (7f1aab247700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Christina%20Aguilera&track=The%20Voice%20Within'
2018-09-24 18:39:14,839 (7f1aaac6b700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Christina%20Aguilera&track=Dirrty%20%28Feat.%20Redman%29'
2018-09-24 18:39:14,840 (7f1aaaf59700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Christina%20Aguilera&track=Beautiful'
2018-09-24 18:39:14,952 (7f1aaaf59700) :  INFO (__init__:32) - Adding Lyric Beautiful to track Beautiful
2018-09-24 18:39:14,962 (7f1aab247700) :  INFO (__init__:32) - Adding Lyric The Voice Within to track The Voice Within
2018-09-24 18:39:14,965 (7f1aab247700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Christina%20Aguilera&track=Not%20Myself%20Tonight'
2018-09-24 18:39:14,975 (7f1aab5f5700) :  INFO (__init__:32) - Adding Lyric Accelerate to track Accelerate
2018-09-24 18:39:14,982 (7f1aaaf59700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Christina%20Aguilera&track=Fall%20In%20Line'
2018-09-24 18:39:15,007 (7f1aab5f5700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Christina%20Aguilera&track=What%20a%20Girl%20Wants'
2018-09-24 18:39:15,087 (7f1aab247700) :  INFO (__init__:32) - Adding Lyric Not Myself Tonight to track Not Myself Tonight
2018-09-24 18:39:15,090 (7f1aab247700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Christina%20Aguilera&track=Genie%20in%20a%20Bottle'
2018-09-24 18:39:15,103 (7f1aaaf59700) :  INFO (__init__:32) - Adding Lyric Fall in Line to track Fall In Line
2018-09-24 18:39:15,106 (7f1aaaf59700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Christina%20Aguilera&track=You%20Lost%20Me'
2018-09-24 18:39:15,127 (7f1aab5f5700) :  INFO (__init__:32) - Adding Lyric What a Girl Wants to track What a Girl Wants
2018-09-24 18:39:15,130 (7f1aab5f5700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Christina%20Aguilera&track=Blank%20Page'
2018-09-24 18:39:15,217 (7f1aab247700) :  INFO (__init__:32) - Adding Lyric Genie in a Bottle to track Genie in a Bottle
2018-09-24 18:39:15,220 (7f1aab247700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Christina%20Aguilera&track=Like%20I%20Do'
2018-09-24 18:39:15,226 (7f1aaaf59700) :  INFO (__init__:32) - Adding Lyric You Lost Me to track You Lost Me
2018-09-24 18:39:15,236 (7f1aaaf59700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Christina%20Aguilera&track=Your%20Body'
2018-09-24 18:39:15,252 (7f1aab5f5700) :  INFO (__init__:32) - Adding Lyric Blank Page to track Blank Page
2018-09-24 18:39:15,290 (7f1aab5f5700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Christina%20Aguilera&track=Ain%27t%20No%20Other%20Man'
2018-09-24 18:39:15,350 (7f1aaac6b700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Christina%20Aguilera&track=I%20Turn%20to%20You'
2018-09-24 18:39:15,368 (7f1aab247700) :  INFO (__init__:32) - Adding Lyric Like I Do to track Like I Do
2018-09-24 18:39:15,371 (7f1aab247700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Christina%20Aguilera&track=Candyman'
2018-09-24 18:39:15,377 (7f1aaaf59700) :  INFO (__init__:32) - Adding Lyric Your Body to track Your Body
2018-09-24 18:39:15,380 (7f1aaaf59700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Christina%20Aguilera&track=Sing%20for%20Me'
2018-09-24 18:39:15,437 (7f1aab5f5700) :  INFO (__init__:32) - Adding Lyric Ain't No Other Man to track Ain't No Other Man
2018-09-24 18:39:15,440 (7f1aab5f5700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Christina%20Aguilera&track=Oh%20Mother'
2018-09-24 18:39:15,481 (7f1aaac6b700) :  INFO (__init__:32) - Adding Lyric I Turn to You to track I Turn to You
2018-09-24 18:39:15,484 (7f1aaac6b700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Christina%20Aguilera&track=Hurt'
2018-09-24 18:39:15,505 (7f1aab247700) :  INFO (__init__:32) - Adding Lyric Candyman to track Candyman
2018-09-24 18:39:15,509 (7f1aab247700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Christina%20Aguilera&track=Can%27t%20Hold%20Us%20Down%20%28Feat.%20Lil%27%20Kim%29'
2018-09-24 18:39:15,516 (7f1aaaf59700) :  INFO (__init__:32) - Adding Lyric Sing for Me to track Sing for Me
2018-09-24 18:39:15,520 (7f1aaaf59700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Christina%20Aguilera&track=Come%20on%20Over%20%28All%20I%20Want%20Is%20You%29'
2018-09-24 18:39:15,585 (7f1aab5f5700) :  INFO (__init__:32) - Adding Lyric Oh Mother to track Oh Mother
2018-09-24 18:39:15,610 (7f1aaac6b700) :  INFO (__init__:32) - Adding Lyric Hurt to track Hurt
2018-09-24 18:39:16,020 (7f1aaaf59700) :  INFO (__init__:32) - Adding Lyric Come on Over (All I Want Is You) to track Come on Over (All I Want Is You)
2018-09-24 18:39:16,022 (7f1aabd11700) :  DEBUG (threadkit:244) - Parallel task set MatchLyrics ended
2018-09-24 18:39:16,079 (7f1aabd11700) :  DEBUG (model:229) - Serializing to /volume1/Plex/Library/Application Support/Plex Media Server/Metadata/Albums/7/16a8549ae941e0041c7e981bf9bbea443c50dd5.bundle/Contents/com.plexapp.agents.lyricfind/Info.xml
2018-09-24 18:39:16,082 (7f1aabd11700) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-09-24 18:39:16,083 (7f1aabd11700) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
2018-09-24 18:39:21,628 (7f1aabd11700) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCmVuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM0CjI0NjBzOApwYXJlbnRJRHMxMDYKY29tLnBsZXhhcHAuYWdlbnRzLmxhc3RmbTovL0JyaXRuZXklMjBTcGVhcnMvVGhlJTIwRXNzZW50aWFsJTIwQnJpdG5leSUyMFNwZWFycyUyMCUyOFJlbWFzdGVyZWQlMjk%40bGFuZz1lbnM0Cmd1aWRiMXM1CmZvcmNlczI1CmNvbS5wbGV4YXBwLmFnZW50cy5sYXN0Zm1zMTMKcHJpbWFyeV9hZ2VudHM0CjI0NjFzMgppZHIwCg__
2018-09-24 18:39:21,630 (7f1aabd11700) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-09-24 18:39:21,631 (7f1aabd11700) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCmVuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM0CjI0NjBzOApwYXJlbnRJRHMxMDYKY29tLnBsZXhhcHAuYWdlbnRzLmxhc3RmbTovL0JyaXRuZXklMjBTcGVhcnMvVGhlJTIwRXNzZW50aWFsJTIwQnJpdG5leSUyMFNwZWFycyUyMCUyOFJlbWFzdGVyZWQlMjk@bGFuZz1lbnM0Cmd1aWRiMXM1CmZvcmNlczI1CmNvbS5wbGV4YXBwLmFnZW50cy5sYXN0Zm1zMTMKcHJpbWFyeV9hZ2VudHM0CjI0NjFzMgppZHIwCg__
2018-09-24 18:39:21,632 (7f1aabd11700) :  INFO (agentkit:957) - Searching for matches for {'id': '2461', 'guid': 'com.plexapp.agents.lastfm://Britney%20Spears/The%20Essential%20Britney%20Spears%20%28Remastered%29?lang=en', 'force': True, 'primary_agent': 'com.plexapp.agents.lastfm', 'parentID': '2460'}
2018-09-24 18:39:21,633 (7f1aabd11700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/2461/tree'
2018-09-24 18:39:21,656 (7f1aabd11700) :  DEBUG (model:32) - Loading model with GUID com.plexapp.agents.lastfm://Britney%20Spears/The%20Essential%20Britney%20Spears%20%28Remastered%29?lang=en
2018-09-24 18:39:21,657 (7f1aabd11700) :  DEBUG (model:234) - Deserializing from /volume1/Plex/Library/Application Support/Plex Media Server/Metadata/Albums/5/9515aefc58817d34eaa85b13e81c9667c8151e9.bundle/Contents/com.plexapp.agents.lastfm/Info.xml
2018-09-24 18:39:21,675 (7f1aabd11700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/2460/tree'
2018-09-24 18:39:21,699 (7f1aabd11700) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-09-24 18:39:21,699 (7f1aabd11700) :  DEBUG (runtime:924) - Response: [200] str, 300 bytes
2018-09-24 18:39:21,718 (7f1aabd11700) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNAoyNDYxczQKZGJpZGkwCnM3CnZlcnNpb25zNTIKY29tLnBsZXhhcHAuYWdlbnRzLmxhc3RmbTovL0JyaXRuZXklMjBTcGVhcnM%40bGFuZz1lbnMxMApwYXJlbnRHVUlEczQKMjQ2MHM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxMDYKY29tLnBsZXhhcHAuYWdlbnRzLmxhc3RmbTovL0JyaXRuZXklMjBTcGVhcnMvVGhlJTIwRXNzZW50aWFsJTIwQnJpdG5leSUyMFNwZWFycyUyMCUyOFJlbWFzdGVyZWQlMjk%40bGFuZz1lbnM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-09-24 18:39:21,719 (7f1aabd11700) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-09-24 18:39:21,721 (7f1aabd11700) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNAoyNDYxczQKZGJpZGkwCnM3CnZlcnNpb25zNTIKY29tLnBsZXhhcHAuYWdlbnRzLmxhc3RmbTovL0JyaXRuZXklMjBTcGVhcnM@bGFuZz1lbnMxMApwYXJlbnRHVUlEczQKMjQ2MHM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxMDYKY29tLnBsZXhhcHAuYWdlbnRzLmxhc3RmbTovL0JyaXRuZXklMjBTcGVhcnMvVGhlJTIwRXNzZW50aWFsJTIwQnJpdG5leSUyMFNwZWFycyUyMCUyOFJlbWFzdGVyZWQlMjk@bGFuZz1lbnM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-09-24 18:39:21,722 (7f1aabd11700) :  DEBUG (model:32) - Loading model with GUID com.plexapp.agents.lastfm://Britney%20Spears/The%20Essential%20Britney%20Spears%20%28Remastered%29?lang=en
2018-09-24 18:39:21,723 (7f1aabd11700) :  ERROR (model:205) - Cannot read model from /volume1/Plex/Library/Application Support/Plex Media Server/Metadata/Albums/5/9515aefc58817d34eaa85b13e81c9667c8151e9.bundle/Contents/com.plexapp.agents.lyricfind
2018-09-24 18:39:21,724 (7f1aabd11700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/2461/tree'
2018-09-24 18:39:21,746 (7f1aabd11700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Britney%20Spears&album=The%20Essential%20Britney%20Spears%20%28Remastered%29'
2018-09-24 18:39:21,863 (7f1aabd11700) :  DEBUG (threadkit:234) - Starting a parallel task set named MatchLyrics with 32 tasks
2018-09-24 18:39:21,874 (7f1aaaf59700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Britney%20Spears&track=...Baby%20One%20More%20Time%20%28Remastered%29'
2018-09-24 18:39:21,899 (7f1aab5f5700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Britney%20Spears&track=Sometimes%20%28Radio%20Edit%20-%20Remastered%29'
2018-09-24 18:39:21,903 (7f1aaac6b700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Britney%20Spears&track=My%20Prerogative%20%28Remastered%29'
2018-09-24 18:39:21,926 (7f1aab247700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Britney%20Spears&track=Do%20Somethin%27%20%28Remastered%29'
2018-09-24 18:39:22,032 (7f1aab5f5700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Britney%20Spears&track=%28You%20Drive%20Me%29%20Crazy%20%5BThe%20Stop%20Remix%21%5D%20%28Remastered%29'
2018-09-24 18:39:22,070 (7f1aaac6b700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Britney%20Spears&track=Gimme%20More%20%28Remastered%29'
2018-09-24 18:39:22,097 (7f1aaaf59700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Britney%20Spears&track=From%20the%20Bottom%20of%20My%20Broken%20Heart%20%28Radio%20Edit%20-%20Remastered%29'
2018-09-24 18:39:22,129 (7f1aab247700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Britney%20Spears&track=Piece%20of%20Me%20%28Remastered%29'
2018-09-24 18:39:22,169 (7f1aab5f5700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Britney%20Spears&track=Oops%21...I%20Did%20It%20Again%20%28Remastered%29'
2018-09-24 18:39:22,202 (7f1aaac6b700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Britney%20Spears&track=Radar%20%28Remastered%29'
2018-09-24 18:39:22,228 (7f1aaaf59700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Britney%20Spears&track=Break%20the%20Ice%20%28Remastered%29'
2018-09-24 18:39:22,262 (7f1aab247700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Britney%20Spears&track=Lucky%20%28Remastered%29'
2018-09-24 18:39:22,478 (7f1aab5f5700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Britney%20Spears&track=Hot%20as%20Ice'
2018-09-24 18:39:22,492 (7f1aaac6b700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Britney%20Spears&track=Stronger%20%28Remastered%29'
2018-09-24 18:39:22,529 (7f1aab247700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Britney%20Spears&track=I%27m%20a%20Slave%204%20U%20%28Remastered%29'
2018-09-24 18:39:22,533 (7f1aaaf59700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Britney%20Spears&track=Womanizer%20%28Remastered%29'
2018-09-24 18:39:22,607 (7f1aab5f5700) :  INFO (__init__:32) - Adding Lyric Hot as Ice to track Hot as Ice
2018-09-24 18:39:22,627 (7f1aaac6b700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Britney%20Spears&track=I%27m%20Not%20a%20Girl%2C%20Not%20Yet%20a%20Woman%20%28Remastered%29'
2018-09-24 18:39:22,634 (7f1aab5f5700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Britney%20Spears&track=Circus%20%28Remastered%29'
2018-09-24 18:39:22,660 (7f1aab247700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Britney%20Spears&track=If%20U%20Seek%20Amy%20%28Remastered%29'
2018-09-24 18:39:22,678 (7f1aaaf59700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Britney%20Spears&track=Overprotected%20%28The%20Darkchild%20Remix%20-%20Remastered%29'
2018-09-24 18:39:22,768 (7f1aab5f5700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Britney%20Spears&track=Boys%20%28The%20Co-Ed%20Remix%29%20%28Remastered%29'
2018-09-24 18:39:22,791 (7f1aab247700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Britney%20Spears&track=Out%20from%20Under'
2018-09-24 18:39:22,800 (7f1aaac6b700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Britney%20Spears&track=3'
2018-09-24 18:39:22,815 (7f1aaaf59700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Britney%20Spears&track=Me%20Against%20the%20Music%20%28Video%20Mix%20-%20Remastered%29'
2018-09-24 18:39:22,889 (7f1aab5f5700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Britney%20Spears&track=Hold%20It%20Against%20Me'
2018-09-24 18:39:22,917 (7f1aab247700) :  INFO (__init__:32) - Adding Lyric Out from Under to track Out from Under
2018-09-24 18:39:22,924 (7f1aab247700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Britney%20Spears&track=Toxic%20%28Remastered%29'
2018-09-24 18:39:22,930 (7f1aaac6b700) :  INFO (__init__:32) - Adding Lyric 3 to track 3
2018-09-24 18:39:22,939 (7f1aaac6b700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Britney%20Spears&track=Everytime%20%28Remastered%29'
2018-09-24 18:39:22,951 (7f1aaaf59700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Britney%20Spears&track=Till%20the%20World%20Ends'
2018-09-24 18:39:23,014 (7f1aab5f5700) :  INFO (__init__:32) - Adding Lyric Hold It Against Me to track Hold It Against Me
2018-09-24 18:39:23,035 (7f1aab5f5700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Britney%20Spears&track=I%20Wanna%20Go'
2018-09-24 18:39:23,061 (7f1aab247700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Britney%20Spears&track=Outrageous%20%28Remastered%29'
2018-09-24 18:39:23,073 (7f1aaac6b700) :  INFO (__init__:32) - Adding Lyric Criminal to track Criminal
2018-09-24 18:39:23,086 (7f1aaaf59700) :  INFO (__init__:32) - Adding Lyric Till the World Ends to track Till the World Ends
2018-09-24 18:39:23,094 (7f1aaac6b700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Britney%20Spears&track=Scream%20%26%20Shout%20%28Radio%20Edit%29'
2018-09-24 18:39:23,159 (7f1aab5f5700) :  INFO (__init__:32) - Adding Lyric I Wanna Go to track I Wanna Go
2018-09-24 18:39:23,211 (7f1aabd11700) :  DEBUG (threadkit:244) - Parallel task set MatchLyrics ended
2018-09-24 18:39:23,259 (7f1aabd11700) :  DEBUG (model:229) - Serializing to /volume1/Plex/Library/Application Support/Plex Media Server/Metadata/Albums/5/9515aefc58817d34eaa85b13e81c9667c8151e9.bundle/Contents/com.plexapp.agents.lyricfind/Info.xml
2018-09-24 18:39:23,262 (7f1aabd11700) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-09-24 18:39:23,262 (7f1aabd11700) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
