2018-10-22 21:46:14,855 (17b8) :  INFO (core:349) - Starting framework core - Version: 2.6.3, Build: 10d48da (Fri Sep 21 03:46:16 UTC 2018)
2018-10-22 21:46:14,855 (17b8) :  DEBUG (core:361) - Using the elevated policy
2018-10-22 21:46:14,855 (17b8) :  DEBUG (core:450) - Starting runtime component.
2018-10-22 21:46:14,871 (17b8) :  DEBUG (core:450) - Starting caching component.
2018-10-22 21:46:14,871 (17b8) :  DEBUG (core:450) - Starting data component.
2018-10-22 21:46:14,871 (17b8) :  DEBUG (core:450) - Starting networking component.
2018-10-22 21:46:14,871 (17b8) :  DEBUG (networking:284) - Loaded HTTP cookies
2018-10-22 21:46:14,871 (17b8) :  DEBUG (networking:452) - Setting the default network timeout to 20.0
2018-10-22 21:46:14,871 (17b8) :  DEBUG (core:450) - Starting localization component.
2018-10-22 21:46:14,871 (17b8) :  INFO (localization:409) - Setting the default locale to en-us
2018-10-22 21:46:14,871 (17b8) :  DEBUG (core:450) - Starting messaging component.
2018-10-22 21:46:14,871 (17b8) :  DEBUG (core:450) - Starting debugging component.
2018-10-22 21:46:14,872 (17b8) :  DEBUG (core:450) - Starting services component.
2018-10-22 21:46:14,874 (548) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/system/messaging/clear_events/com.plexapp.agents.lyricfind'
2018-10-22 21:46:14,875 (17b8) :  DEBUG (core:450) - Starting myplex component.
2018-10-22 21:46:14,888 (17b8) :  DEBUG (core:450) - Starting notifications component.
2018-10-22 21:46:15,043 (17b8) :  DEBUG (accessor:68) - Creating a new model access point for provider com.plexapp.agents.lyricfind in namespace 'metadata'
2018-10-22 21:46:15,048 (17b8) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/resourceHashes'
2018-10-22 21:46:15,078 (e04) :  DEBUG (services:265) - Plug-in is not daemonized - loading services from system
2018-10-22 21:46:15,078 (17b8) :  DEBUG (runtime:1117) - Created a thread named 'load_all_services'
2018-10-22 21:46:15,091 (e04) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_'
2018-10-22 21:46:15,091 (17b8) :  DEBUG (runtime:1117) - Created a thread named 'get_server_info'
2018-10-22 21:46:15,091 (167c) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400'
2018-10-22 21:46:15,091 (17b8) :  DEBUG (core:150) - Finished starting framework core
2018-10-22 21:46:15,091 (17b8) :  DEBUG (core:560) - Loading plug-in code
2018-10-22 21:46:15,105 (167c) :  DEBUG (core:538) - Machine identifier is 7e0d395b9e4a10d7fb39e3151eecdf3274164576
2018-10-22 21:46:15,108 (167c) :  DEBUG (core:539) - Server version is 1.13.8.5395-10d48da0d
2018-10-22 21:46:15,171 (17b8) :  DEBUG (core:566) - Finished loading plug-in code
2018-10-22 21:46:15,173 (17b8) :  DEBUG (agentkit:1115) - Creating new agent class called LyricFindAlbumAgent
2018-10-22 21:46:15,184 (17b8) :  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-10-22 21:46:15,184 (17b8) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQo2CmRpY3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0CjIKczI4CmNvbS5wbGV4YXBwLmFnZW50cy5seXJpY2ZpbmRzMTAKaWRlbnRpZmllcnIxCnMxMAphZ2VudF9pbmZvMQpyMgoxMApyMwpzMTEKbWVkaWFfdHlwZXNuczEyCmFjY2VwdHNfZnJvbW5zMTQKZmFsbGJhY2tfYWdlbnRyNApzMTQKY29udHJpYnV0ZXNfdG9yNQpzOQpsYW5ndWFnZXNiMXMyMApwZXJzaXN0X3N0b3JlZF9maWxlc2kwCnM3CnZlcnNpb25iMHMxNgpwcmltYXJ5X3Byb3ZpZGVyYjBzNQpwcmVmc3M5Ckx5cmljRmluZHM0Cm5hbWUxCnM1CkFsYnVtMwpzMjgKY29tLnBsZXhhcHAuYWdlbnRzLnBsZXhtdXNpY3MyOQpjb20ucGxleGFwcC5hZ2VudHMubG9jYWxtZWRpYXMyNQpjb20ucGxleGFwcC5hZ2VudHMubGFzdGZtMQpzMgp4bnIwCg__'
2018-10-22 21:46:15,203 (17b8) :  INFO (core:611) - Started plug-in
2018-10-22 21:46:15,204 (17b8) :  DEBUG (socketinterface:160) - Starting socket server
2018-10-22 21:46:15,216 (17b8) :  DEBUG (runtime:1117) - Created a thread named 'start'
2018-10-22 21:46:15,216 (17b8) :  INFO (socketinterface:184) - Socket server started on port 50675
2018-10-22 21:46:15,216 (17b8) :  INFO (pipeinterface:25) - Entering run loop
2018-10-22 21:46:15,216 (17b8) :  DEBUG (runtime:717) - Handling request GET /:/prefixes
2018-10-22 21:46:15,230 (17b8) :  DEBUG (runtime:814) - Found route matching /:/prefixes
2018-10-22 21:46:15,230 (17b8) :  DEBUG (runtime:924) - Response: [200] MediaContainer, 153 bytes
2018-10-22 21:46:15,278 (2414) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjU5NnM4CnBhcmVudElEczE0CmxvY2FsOi8vMTMwMTMwczQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzMDEzMHMyCmlkcjAK
2018-10-22 21:46:15,279 (14d8) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjU5NnM4CnBhcmVudElEczE0CmxvY2FsOi8vMTMwMTI4czQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzMDEyOHMyCmlkcjAK
2018-10-22 21:46:15,282 (2414) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:46:15,282 (223c) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCmVuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjU5OXM4CnBhcmVudElEczExNApjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FsYnVtLzA1QTU5NzFEMUNBMzVFRDIvNDgwNDY4NjkwLUE1OTcxRDdCOTY2Mzk4QzcxREFDODA1RjRFQjZFOTUzP2xhbmc9ZW5zNApndWlkYjFzNQpmb3JjZXMyOApjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljczEzCnByaW1hcnlfYWdlbnRzNgoxMjI2MDBzMgppZHIwCg__
2018-10-22 21:46:15,293 (14d8) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:46:15,293 (223c) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:46:15,418 (2414) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjU5NnM4CnBhcmVudElEczE0CmxvY2FsOi8vMTMwMTMwczQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzMDEzMHMyCmlkcjAK
2018-10-22 21:46:15,418 (14d8) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjU5NnM4CnBhcmVudElEczE0CmxvY2FsOi8vMTMwMTI4czQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzMDEyOHMyCmlkcjAK
2018-10-22 21:46:15,418 (223c) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCmVuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjU5OXM4CnBhcmVudElEczExNApjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FsYnVtLzA1QTU5NzFEMUNBMzVFRDIvNDgwNDY4NjkwLUE1OTcxRDdCOTY2Mzk4QzcxREFDODA1RjRFQjZFOTUzP2xhbmc9ZW5zNApndWlkYjFzNQpmb3JjZXMyOApjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljczEzCnByaW1hcnlfYWdlbnRzNgoxMjI2MDBzMgppZHIwCg__
2018-10-22 21:46:15,418 (2414) :  INFO (agentkit:957) - Searching for matches for {'id': '130130', 'guid': 'local://130130', 'force': True, 'primary_agent': 'com.plexapp.agents.localmedia', 'parentID': '122596'}
2018-10-22 21:46:15,418 (14d8) :  INFO (agentkit:957) - Searching for matches for {'id': '130128', 'guid': 'local://130128', 'force': True, 'primary_agent': 'com.plexapp.agents.localmedia', 'parentID': '122596'}
2018-10-22 21:46:15,418 (223c) :  INFO (agentkit:957) - Searching for matches for {'id': '122600', 'guid': 'com.plexapp.agents.plexmusic://gracenote/album/05A5971D1CA35ED2/480468690-A5971D7B966398C71DAC805F4EB6E953?lang=en', 'force': True, 'primary_agent': 'com.plexapp.agents.plexmusic', 'parentID': '122599'}
2018-10-22 21:46:15,420 (2414) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/130130/tree'
2018-10-22 21:46:15,421 (14d8) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/130128/tree'
2018-10-22 21:46:15,424 (223c) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/122600/tree'
2018-10-22 21:46:15,450 (e04) :  DEBUG (services:362) - Loaded services
2018-10-22 21:46:15,453 (2414) :  DEBUG (accessor:68) - Creating a new read-only model access point for provider com.plexapp.agents.localmedia in namespace 'metadata'
2018-10-22 21:46:15,453 (14d8) :  DEBUG (accessor:68) - Creating a new read-only model access point for provider com.plexapp.agents.localmedia in namespace 'metadata'
2018-10-22 21:46:15,454 (223c) :  DEBUG (accessor:68) - Creating a new read-only model access point for provider com.plexapp.agents.plexmusic in namespace 'metadata'
2018-10-22 21:46:15,497 (207c) :  DEBUG (services:438) - No shared code to load
2018-10-22 21:46:15,513 (2414) :  DEBUG (model:32) - Loading model with GUID local://130130
2018-10-22 21:46:15,513 (14d8) :  DEBUG (model:32) - Loading model with GUID local://130128
2018-10-22 21:46:15,513 (223c) :  DEBUG (model:32) - Loading model with GUID com.plexapp.agents.plexmusic://gracenote/album/05A5971D1CA35ED2/480468690-A5971D7B966398C71DAC805F4EB6E953?lang=en
2018-10-22 21:46:15,528 (2414) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\6\40f621b1504d684af2966cf6465dcbf73d60b2a.bundle\Contents\com.plexapp.agents.localmedia\Info.xml
2018-10-22 21:46:15,528 (223c) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\b\ea28c1b71af22f2476efed0bb908812cb0ef6a2.bundle\Contents\com.plexapp.agents.plexmusic\Info.xml
2018-10-22 21:46:15,528 (14d8) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\8\5da264ba45986d4373967c2a8607df51c3857cd.bundle\Contents\com.plexapp.agents.localmedia\Info.xml
2018-10-22 21:46:15,546 (14d8) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/122596/tree'
2018-10-22 21:46:15,559 (2414) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/122596/tree'
2018-10-22 21:46:15,559 (223c) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/122599/tree'
2018-10-22 21:46:15,575 (14d8) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:46:15,575 (14d8) :  DEBUG (runtime:924) - Response: [200] str, 300 bytes
2018-10-22 21:46:15,578 (223c) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:46:15,579 (223c) :  DEBUG (runtime:924) - Response: [200] str, 300 bytes
2018-10-22 21:46:15,591 (2888) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzAxMjhzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjU5NnM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzMDEyOHM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:46:15,591 (2414) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:46:15,592 (2414) :  DEBUG (runtime:924) - Response: [200] str, 300 bytes
2018-10-22 21:46:15,592 (2888) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:46:15,605 (2888) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzAxMjhzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjU5NnM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzMDEyOHM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:46:15,605 (2888) :  DEBUG (model:32) - Loading model with GUID local://130128
2018-10-22 21:46:15,605 (2888) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\8\5da264ba45986d4373967c2a8607df51c3857cd.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:46:15,605 (2888) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/130128/tree'
2018-10-22 21:46:15,611 (2888) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Olly%20Murs&album=Dance%20With%20Me%20Tonight%20%28single%29'
2018-10-22 21:46:15,653 (17c4) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzAxMzBzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjU5NnM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzMDEzMHM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:46:15,653 (1b88) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMjI2MDBzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjU5OXM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxMTQKY29tLnBsZXhhcHAuYWdlbnRzLnBsZXhtdXNpYzovL2dyYWNlbm90ZS9hbGJ1bS8wNUE1OTcxRDFDQTM1RUQyLzQ4MDQ2ODY5MC1BNTk3MUQ3Qjk2NjM5OEM3MURBQzgwNUY0RUI2RTk1Mz9sYW5nPWVuczQKZ3VpZHM0Cm51bGxzMgppZHIwCg__
2018-10-22 21:46:15,654 (17c4) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:46:15,657 (1b88) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:46:15,668 (17c4) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzAxMzBzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjU5NnM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzMDEzMHM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:46:15,668 (1b88) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMjI2MDBzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjU5OXM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxMTQKY29tLnBsZXhhcHAuYWdlbnRzLnBsZXhtdXNpYzovL2dyYWNlbm90ZS9hbGJ1bS8wNUE1OTcxRDFDQTM1RUQyLzQ4MDQ2ODY5MC1BNTk3MUQ3Qjk2NjM5OEM3MURBQzgwNUY0RUI2RTk1Mz9sYW5nPWVuczQKZ3VpZHM0Cm51bGxzMgppZHIwCg__
2018-10-22 21:46:15,668 (17c4) :  DEBUG (model:32) - Loading model with GUID local://130130
2018-10-22 21:46:15,668 (1b88) :  DEBUG (model:32) - Loading model with GUID com.plexapp.agents.plexmusic://gracenote/album/05A5971D1CA35ED2/480468690-A5971D7B966398C71DAC805F4EB6E953?lang=en
2018-10-22 21:46:15,668 (17c4) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\6\40f621b1504d684af2966cf6465dcbf73d60b2a.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:46:15,668 (1b88) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\b\ea28c1b71af22f2476efed0bb908812cb0ef6a2.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:46:15,684 (17c4) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/130130/tree'
2018-10-22 21:46:15,684 (1b88) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/122600/tree'
2018-10-22 21:46:15,700 (1b88) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Jessie%20J%2C%20Ariana%20Grande%20%26%20Nicki%20Minaj&album=Unknown%20album%20%2825/11/2014%2013%3A28%3A49%29'
2018-10-22 21:46:15,700 (17c4) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Olly%20Murs&album=Please%20Don%27t%20Let%20Me%20Go%20%28single%29'
2018-10-22 21:46:15,730 (2888) :  DEBUG (threadkit:234) - Starting a parallel task set named MatchLyrics with 1 tasks
2018-10-22 21:46:15,730 (2364) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Olly%20Murs&track=Dance%20With%20Me%20Tonight'
2018-10-22 21:46:15,809 (17c4) :  DEBUG (threadkit:234) - Starting a parallel task set named MatchLyrics with 1 tasks
2018-10-22 21:46:15,809 (26d8) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Olly%20Murs&track=Please%20Don%27t%20Let%20Me%20Go'
2018-10-22 21:46:15,825 (1b88) :  DEBUG (threadkit:234) - Starting a parallel task set named MatchLyrics with 1 tasks
2018-10-22 21:46:15,825 (4ac) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Jessie%20J%2C%20Ariana%20Grande%20%26%20Nicki%20Minaj&track=Track%203'
2018-10-22 21:46:15,841 (2364) :  INFO (logkit:16) - Adding Lyric Dance with Me Tonight to track Dance With Me Tonight
2018-10-22 21:46:15,842 (2888) :  DEBUG (threadkit:244) - Parallel task set MatchLyrics ended
2018-10-22 21:46:15,858 (2888) :  DEBUG (model:229) - Serializing to C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\8\5da264ba45986d4373967c2a8607df51c3857cd.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:46:15,871 (2888) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:46:15,871 (2888) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
2018-10-22 21:46:15,903 (26d8) :  INFO (logkit:16) - Adding Lyric Please Don't Let Me Go to track Please Don't Let Me Go
2018-10-22 21:46:15,903 (17c4) :  DEBUG (threadkit:244) - Parallel task set MatchLyrics ended
2018-10-22 21:46:15,918 (1b88) :  DEBUG (threadkit:244) - Parallel task set MatchLyrics ended
2018-10-22 21:46:15,934 (1b88) :  DEBUG (model:229) - Serializing to C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\b\ea28c1b71af22f2476efed0bb908812cb0ef6a2.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:46:15,934 (17c4) :  DEBUG (model:229) - Serializing to C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\6\40f621b1504d684af2966cf6465dcbf73d60b2a.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:46:15,934 (1b88) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:46:15,936 (1b88) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
2018-10-22 21:46:15,950 (17c4) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:46:15,950 (17c4) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
2018-10-22 21:46:23,763 (154c) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjYxN3M4CnBhcmVudElEczE0CmxvY2FsOi8vMTMxODA2czQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzMTgwNnMyCmlkcjAK
2018-10-22 21:46:23,763 (154c) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:46:23,763 (154c) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjYxN3M4CnBhcmVudElEczE0CmxvY2FsOi8vMTMxODA2czQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzMTgwNnMyCmlkcjAK
2018-10-22 21:46:23,763 (154c) :  INFO (agentkit:957) - Searching for matches for {'id': '131806', 'guid': 'local://131806', 'force': True, 'primary_agent': 'com.plexapp.agents.localmedia', 'parentID': '122617'}
2018-10-22 21:46:23,767 (154c) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/131806/tree'
2018-10-22 21:46:23,779 (154c) :  DEBUG (model:32) - Loading model with GUID local://131806
2018-10-22 21:46:23,779 (154c) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\1\5807f77fee3b79255fb6ec869acd37f4b908390.bundle\Contents\com.plexapp.agents.localmedia\Info.xml
2018-10-22 21:46:23,795 (154c) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/122617/tree'
2018-10-22 21:46:23,799 (154c) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:46:23,799 (154c) :  DEBUG (runtime:924) - Response: [200] str, 300 bytes
2018-10-22 21:46:23,813 (27c0) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzE4MDZzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjYxN3M4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzMTgwNnM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:46:23,815 (27c0) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:46:23,826 (27c0) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzE4MDZzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjYxN3M4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzMTgwNnM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:46:23,826 (27c0) :  DEBUG (model:32) - Loading model with GUID local://131806
2018-10-22 21:46:23,842 (27c0) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\1\5807f77fee3b79255fb6ec869acd37f4b908390.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:46:23,858 (27c0) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/131806/tree'
2018-10-22 21:46:23,872 (27c0) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=The%20Script&album=Breakeven%20%28single%29'
2018-10-22 21:46:23,967 (27c0) :  DEBUG (threadkit:234) - Starting a parallel task set named MatchLyrics with 1 tasks
2018-10-22 21:46:23,997 (dc4) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=The%20Script&track=Breakeven'
2018-10-22 21:46:24,092 (dc4) :  INFO (logkit:16) - Adding Lyric Breakeven to track Breakeven
2018-10-22 21:46:24,094 (27c0) :  DEBUG (threadkit:244) - Parallel task set MatchLyrics ended
2018-10-22 21:46:24,160 (27c0) :  DEBUG (model:229) - Serializing to C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\1\5807f77fee3b79255fb6ec869acd37f4b908390.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:46:24,170 (27c0) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:46:24,170 (27c0) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
2018-10-22 21:46:26,311 (18e0) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjU5NnM4CnBhcmVudElEczE0CmxvY2FsOi8vMTMwMTMyczQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzMDEzMnMyCmlkcjAK
2018-10-22 21:46:26,311 (18e0) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:46:26,311 (18e0) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjU5NnM4CnBhcmVudElEczE0CmxvY2FsOi8vMTMwMTMyczQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzMDEzMnMyCmlkcjAK
2018-10-22 21:46:26,311 (18e0) :  INFO (agentkit:957) - Searching for matches for {'id': '130132', 'guid': 'local://130132', 'force': True, 'primary_agent': 'com.plexapp.agents.localmedia', 'parentID': '122596'}
2018-10-22 21:46:26,326 (18e0) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/130132/tree'
2018-10-22 21:46:26,331 (18e0) :  DEBUG (model:32) - Loading model with GUID local://130132
2018-10-22 21:46:26,332 (18e0) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\3\ac9a3456005c39845e490aa93a9057c7d82e703.bundle\Contents\com.plexapp.agents.localmedia\Info.xml
2018-10-22 21:46:26,342 (18e0) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/122596/tree'
2018-10-22 21:46:26,358 (18e0) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:46:26,358 (18e0) :  DEBUG (runtime:924) - Response: [200] str, 300 bytes
2018-10-22 21:46:26,374 (13d0) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzAxMzJzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjU5NnM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzMDEzMnM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:46:26,374 (13d0) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:46:26,374 (13d0) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzAxMzJzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjU5NnM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzMDEzMnM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:46:26,374 (13d0) :  DEBUG (model:32) - Loading model with GUID local://130132
2018-10-22 21:46:26,388 (13d0) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\3\ac9a3456005c39845e490aa93a9057c7d82e703.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:46:26,407 (13d0) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/130132/tree'
2018-10-22 21:46:26,420 (13d0) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Olly%20Murs&album=Thinking%20Of%20Me%20%28single%29'
2018-10-22 21:46:26,516 (13d0) :  DEBUG (threadkit:234) - Starting a parallel task set named MatchLyrics with 1 tasks
2018-10-22 21:46:26,519 (2624) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Olly%20Murs&track=Thinking%20Of%20Me'
2018-10-22 21:46:26,624 (2624) :  INFO (logkit:16) - Adding Lyric Thinking of Me to track Thinking Of Me
2018-10-22 21:46:26,624 (13d0) :  DEBUG (threadkit:244) - Parallel task set MatchLyrics ended
2018-10-22 21:46:26,670 (13d0) :  DEBUG (model:229) - Serializing to C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\3\ac9a3456005c39845e490aa93a9057c7d82e703.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:46:26,670 (13d0) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:46:26,670 (13d0) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
2018-10-22 21:46:26,720 (28e8) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjYxN3M4CnBhcmVudElEczE0CmxvY2FsOi8vMTMxODAxczQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzMTgwMXMyCmlkcjAK
2018-10-22 21:46:26,721 (28e8) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:46:26,733 (28e8) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjYxN3M4CnBhcmVudElEczE0CmxvY2FsOi8vMTMxODAxczQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzMTgwMXMyCmlkcjAK
2018-10-22 21:46:26,733 (28e8) :  INFO (agentkit:957) - Searching for matches for {'id': '131801', 'guid': 'local://131801', 'force': True, 'primary_agent': 'com.plexapp.agents.localmedia', 'parentID': '122617'}
2018-10-22 21:46:26,749 (28e8) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/131801/tree'
2018-10-22 21:46:26,763 (28e8) :  DEBUG (model:32) - Loading model with GUID local://131801
2018-10-22 21:46:26,763 (28e8) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\f\ae2cfc9ad825688fb9db534aa4c8e69b3934f8a.bundle\Contents\com.plexapp.agents.localmedia\Info.xml
2018-10-22 21:46:26,765 (28e8) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/122617/tree'
2018-10-22 21:46:26,796 (28e8) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:46:26,796 (28e8) :  DEBUG (runtime:924) - Response: [200] str, 300 bytes
2018-10-22 21:46:26,811 (2b90) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzE4MDFzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjYxN3M4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzMTgwMXM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:46:26,812 (2b90) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:46:26,815 (2b90) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzE4MDFzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjYxN3M4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzMTgwMXM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:46:26,826 (2b90) :  DEBUG (model:32) - Loading model with GUID local://131801
2018-10-22 21:46:26,826 (2b90) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\f\ae2cfc9ad825688fb9db534aa4c8e69b3934f8a.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:46:26,842 (2b90) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/131801/tree'
2018-10-22 21:46:26,874 (2b90) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=The%20Script&album=Before%20The%20Worst%20%28CDS%29'
2018-10-22 21:46:26,983 (2b90) :  DEBUG (threadkit:234) - Starting a parallel task set named MatchLyrics with 4 tasks
2018-10-22 21:46:27,046 (1aac) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=The%20Script&track=Before%20The%20Worst%20%28Album%20Version%29'
2018-10-22 21:46:27,046 (2088) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=The%20Script&track=Before%20The%20Worst%20%28Live%29-'
2018-10-22 21:46:27,046 (2be4) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=The%20Script&track=Before%20The%20Worst%20%28Demo%29'
2018-10-22 21:46:27,046 (14ac) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=The%20Script&track=Before%20The%20Worst%20%28Armand%20Van%20Helden%20Remix%29'
2018-10-22 21:46:27,201 (2b90) :  DEBUG (threadkit:244) - Parallel task set MatchLyrics ended
2018-10-22 21:46:27,217 (2b90) :  DEBUG (model:229) - Serializing to C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\f\ae2cfc9ad825688fb9db534aa4c8e69b3934f8a.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:46:27,217 (2b90) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:46:27,217 (2b90) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
2018-10-22 21:46:27,937 (18b0) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjYyMHM4CnBhcmVudElEczE0CmxvY2FsOi8vMTMzMDQzczQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzMzA0M3MyCmlkcjAK
2018-10-22 21:46:27,937 (18b0) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:46:27,937 (18b0) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjYyMHM4CnBhcmVudElEczE0CmxvY2FsOi8vMTMzMDQzczQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzMzA0M3MyCmlkcjAK
2018-10-22 21:46:27,938 (18b0) :  INFO (agentkit:957) - Searching for matches for {'id': '133043', 'guid': 'local://133043', 'force': True, 'primary_agent': 'com.plexapp.agents.localmedia', 'parentID': '122620'}
2018-10-22 21:46:27,967 (18b0) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/133043/tree'
2018-10-22 21:46:27,969 (18b0) :  DEBUG (model:32) - Loading model with GUID local://133043
2018-10-22 21:46:27,970 (18b0) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\2\6d7dd2dafb45f6b6a6b2273ef9a4bfcd874487e.bundle\Contents\com.plexapp.agents.localmedia\Info.xml
2018-10-22 21:46:27,971 (18b0) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/122620/tree'
2018-10-22 21:46:27,986 (18b0) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:46:27,986 (18b0) :  DEBUG (runtime:924) - Response: [200] str, 300 bytes
2018-10-22 21:46:28,000 (c90) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzMwNDNzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjYyMHM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzMzA0M3M0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:46:28,003 (c90) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:46:28,003 (c90) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzMwNDNzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjYyMHM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzMzA0M3M0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:46:28,015 (c90) :  DEBUG (model:32) - Loading model with GUID local://133043
2018-10-22 21:46:28,029 (c90) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\2\6d7dd2dafb45f6b6a6b2273ef9a4bfcd874487e.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:46:28,076 (c90) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/133043/tree'
2018-10-22 21:46:28,079 (c90) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=OneRepublic&album=All%20The%20Right%20Moves%20%28single%29'
2018-10-22 21:46:28,171 (c90) :  DEBUG (threadkit:234) - Starting a parallel task set named MatchLyrics with 1 tasks
2018-10-22 21:46:28,173 (a68) :  INFO (logkit:16) - Adding Lyric All the Right Moves to track All The Right Moves
2018-10-22 21:46:28,174 (c90) :  DEBUG (threadkit:244) - Parallel task set MatchLyrics ended
2018-10-22 21:46:28,233 (c90) :  DEBUG (model:229) - Serializing to C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\2\6d7dd2dafb45f6b6a6b2273ef9a4bfcd874487e.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:46:28,236 (c90) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:46:28,236 (c90) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
2018-10-22 21:46:33,953 (1d90) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjYxN3M4CnBhcmVudElEczE0CmxvY2FsOi8vMTMxODA4czQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzMTgwOHMyCmlkcjAK
2018-10-22 21:46:33,953 (1d90) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:46:33,953 (1d90) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjYxN3M4CnBhcmVudElEczE0CmxvY2FsOi8vMTMxODA4czQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzMTgwOHMyCmlkcjAK
2018-10-22 21:46:33,953 (1d90) :  INFO (agentkit:957) - Searching for matches for {'id': '131808', 'guid': 'local://131808', 'force': True, 'primary_agent': 'com.plexapp.agents.localmedia', 'parentID': '122617'}
2018-10-22 21:46:33,957 (1d90) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/131808/tree'
2018-10-22 21:46:33,967 (1d90) :  DEBUG (model:32) - Loading model with GUID local://131808
2018-10-22 21:46:33,967 (1d90) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\c\6ad45f6f169f6974731c04eb2cd28875f100619.bundle\Contents\com.plexapp.agents.localmedia\Info.xml
2018-10-22 21:46:33,969 (1d90) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/122617/tree'
2018-10-22 21:46:33,983 (1d90) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:46:33,983 (1d90) :  DEBUG (runtime:924) - Response: [200] str, 300 bytes
2018-10-22 21:46:34,000 (11e8) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzE4MDhzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjYxN3M4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzMTgwOHM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:46:34,000 (11e8) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:46:34,000 (11e8) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzE4MDhzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjYxN3M4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzMTgwOHM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:46:34,000 (11e8) :  DEBUG (model:32) - Loading model with GUID local://131808
2018-10-22 21:46:34,000 (11e8) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\c\6ad45f6f169f6974731c04eb2cd28875f100619.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:46:34,030 (11e8) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/131808/tree'
2018-10-22 21:46:34,046 (11e8) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=The%20Script&album=The%20Man%20Who%20Can%27t%20Be%20Moved%20%28single%29'
2018-10-22 21:46:34,144 (11e8) :  DEBUG (threadkit:234) - Starting a parallel task set named MatchLyrics with 1 tasks
2018-10-22 21:46:34,155 (16a4) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=The%20Script&track=The%20Man%20Who%20Can%27t%20Be%20Moved'
2018-10-22 21:46:34,250 (16a4) :  INFO (logkit:16) - Adding Lyric The Man Who Can't Be Moved to track The Man Who Can't Be Moved
2018-10-22 21:46:34,250 (11e8) :  DEBUG (threadkit:244) - Parallel task set MatchLyrics ended
2018-10-22 21:46:34,266 (11e8) :  DEBUG (model:229) - Serializing to C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\c\6ad45f6f169f6974731c04eb2cd28875f100619.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:46:34,280 (11e8) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:46:34,280 (11e8) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
2018-10-22 21:46:37,562 (2468) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjYyNnM4CnBhcmVudElEczE0CmxvY2FsOi8vMTMzMDM3czQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzMzAzN3MyCmlkcjAK
2018-10-22 21:46:37,562 (2468) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:46:37,562 (2468) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjYyNnM4CnBhcmVudElEczE0CmxvY2FsOi8vMTMzMDM3czQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzMzAzN3MyCmlkcjAK
2018-10-22 21:46:37,562 (2468) :  INFO (agentkit:957) - Searching for matches for {'id': '133037', 'guid': 'local://133037', 'force': True, 'primary_agent': 'com.plexapp.agents.localmedia', 'parentID': '122626'}
2018-10-22 21:46:37,562 (2468) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/133037/tree'
2018-10-22 21:46:37,578 (2468) :  DEBUG (model:32) - Loading model with GUID local://133037
2018-10-22 21:46:37,578 (2468) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\0\6165b7ffe22fdfb3646fa6d9e3800527b841731.bundle\Contents\com.plexapp.agents.localmedia\Info.xml
2018-10-22 21:46:37,578 (2468) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/122626/tree'
2018-10-22 21:46:37,594 (2468) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:46:37,594 (2468) :  DEBUG (runtime:924) - Response: [200] str, 300 bytes
2018-10-22 21:46:37,625 (488) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzMwMzdzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjYyNnM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzMzAzN3M0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:46:37,625 (488) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:46:37,625 (488) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzMwMzdzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjYyNnM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzMzAzN3M0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:46:37,625 (488) :  DEBUG (model:32) - Loading model with GUID local://133037
2018-10-22 21:46:37,625 (488) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\0\6165b7ffe22fdfb3646fa6d9e3800527b841731.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:46:37,641 (488) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/133037/tree'
2018-10-22 21:46:37,644 (488) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=One%20Direction&album=Little%20Things%20%28single%29'
2018-10-22 21:46:37,750 (488) :  DEBUG (threadkit:234) - Starting a parallel task set named MatchLyrics with 1 tasks
2018-10-22 21:46:37,766 (2660) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=One%20Direction&track=Little%20Things'
2018-10-22 21:46:37,862 (2660) :  INFO (logkit:16) - Adding Lyric Little Things to track Little Things
2018-10-22 21:46:37,875 (488) :  DEBUG (threadkit:244) - Parallel task set MatchLyrics ended
2018-10-22 21:46:37,905 (1b58) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjYyNnM4CnBhcmVudElEczE0CmxvY2FsOi8vMTMzMDM5czQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzMzAzOXMyCmlkcjAK
2018-10-22 21:46:37,905 (1b58) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:46:37,905 (1b58) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjYyNnM4CnBhcmVudElEczE0CmxvY2FsOi8vMTMzMDM5czQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzMzAzOXMyCmlkcjAK
2018-10-22 21:46:37,905 (1b58) :  INFO (agentkit:957) - Searching for matches for {'id': '133039', 'guid': 'local://133039', 'force': True, 'primary_agent': 'com.plexapp.agents.localmedia', 'parentID': '122626'}
2018-10-22 21:46:37,910 (1b58) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/133039/tree'
2018-10-22 21:46:37,923 (488) :  DEBUG (model:229) - Serializing to C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\0\6165b7ffe22fdfb3646fa6d9e3800527b841731.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:46:37,937 (1b58) :  DEBUG (model:32) - Loading model with GUID local://133039
2018-10-22 21:46:37,937 (1b58) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\e\0923e456e606fdd8c97823eeec78a9b42ffebef.bundle\Contents\com.plexapp.agents.localmedia\Info.xml
2018-10-22 21:46:37,937 (488) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:46:37,937 (488) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
2018-10-22 21:46:37,940 (1b58) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/122626/tree'
2018-10-22 21:46:37,953 (1b58) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:46:37,953 (1b58) :  DEBUG (runtime:924) - Response: [200] str, 300 bytes
2018-10-22 21:46:37,984 (1694) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzMwMzlzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjYyNnM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzMzAzOXM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:46:37,984 (1694) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:46:37,987 (1694) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzMwMzlzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjYyNnM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzMzAzOXM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:46:37,990 (1694) :  DEBUG (model:32) - Loading model with GUID local://133039
2018-10-22 21:46:38,000 (1694) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\e\0923e456e606fdd8c97823eeec78a9b42ffebef.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:46:38,016 (1694) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/133039/tree'
2018-10-22 21:46:38,030 (1694) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=One%20Direction&album=Live%20While%20We%27re%20Young%20%28single%29'
2018-10-22 21:46:38,155 (1694) :  DEBUG (threadkit:234) - Starting a parallel task set named MatchLyrics with 1 tasks
2018-10-22 21:46:38,155 (16f4) :  INFO (logkit:16) - Adding Lyric Live While We're Young to track Live While We're Young
2018-10-22 21:46:38,157 (1694) :  DEBUG (threadkit:244) - Parallel task set MatchLyrics ended
2018-10-22 21:46:38,312 (1694) :  DEBUG (model:229) - Serializing to C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\e\0923e456e606fdd8c97823eeec78a9b42ffebef.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:46:38,316 (1694) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:46:38,318 (1694) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
2018-10-22 21:46:39,036 (c84) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjYyNnM4CnBhcmVudElEczE0CmxvY2FsOi8vMTM2MDQ0czQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzNjA0NHMyCmlkcjAK
2018-10-22 21:46:39,048 (c84) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:46:39,048 (c84) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjYyNnM4CnBhcmVudElEczE0CmxvY2FsOi8vMTM2MDQ0czQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzNjA0NHMyCmlkcjAK
2018-10-22 21:46:39,048 (c84) :  INFO (agentkit:957) - Searching for matches for {'id': '136044', 'guid': 'local://136044', 'force': True, 'primary_agent': 'com.plexapp.agents.localmedia', 'parentID': '122626'}
2018-10-22 21:46:39,048 (c84) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/136044/tree'
2018-10-22 21:46:39,063 (c84) :  DEBUG (model:32) - Loading model with GUID local://136044
2018-10-22 21:46:39,063 (c84) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\e\1b412903bd6d47a639626c8b329b2644c9d294d.bundle\Contents\com.plexapp.agents.localmedia\Info.xml
2018-10-22 21:46:39,063 (c84) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/122626/tree'
2018-10-22 21:46:39,078 (c84) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:46:39,078 (c84) :  DEBUG (runtime:924) - Response: [200] str, 300 bytes
2018-10-22 21:46:39,095 (14cc) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzYwNDRzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjYyNnM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzNjA0NHM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:46:39,095 (14cc) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:46:39,095 (14cc) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzYwNDRzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjYyNnM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzNjA0NHM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:46:39,095 (14cc) :  DEBUG (model:32) - Loading model with GUID local://136044
2018-10-22 21:46:39,095 (14cc) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\e\1b412903bd6d47a639626c8b329b2644c9d294d.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:46:39,125 (14cc) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/136044/tree'
2018-10-22 21:46:39,131 (14cc) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=One%20Direction&album=Live%20While%20We%27re%20Young%20%28single%29'
2018-10-22 21:46:39,239 (14cc) :  DEBUG (threadkit:234) - Starting a parallel task set named MatchLyrics with 1 tasks
2018-10-22 21:46:39,240 (227c) :  INFO (logkit:16) - Adding Lyric Live While We're Young to track Live While We're Young
2018-10-22 21:46:39,250 (14cc) :  DEBUG (threadkit:244) - Parallel task set MatchLyrics ended
2018-10-22 21:46:39,299 (14cc) :  DEBUG (model:229) - Serializing to C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\e\1b412903bd6d47a639626c8b329b2644c9d294d.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:46:39,313 (14cc) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:46:39,313 (14cc) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
2018-10-22 21:46:44,313 (254c) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjYzMnM4CnBhcmVudElEczE0CmxvY2FsOi8vMTMyMzE5czQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzMjMxOXMyCmlkcjAK
2018-10-22 21:46:44,313 (254c) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:46:44,313 (254c) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjYzMnM4CnBhcmVudElEczE0CmxvY2FsOi8vMTMyMzE5czQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzMjMxOXMyCmlkcjAK
2018-10-22 21:46:44,313 (254c) :  INFO (agentkit:957) - Searching for matches for {'id': '132319', 'guid': 'local://132319', 'force': True, 'primary_agent': 'com.plexapp.agents.localmedia', 'parentID': '122632'}
2018-10-22 21:46:44,315 (254c) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/132319/tree'
2018-10-22 21:46:44,329 (254c) :  DEBUG (model:32) - Loading model with GUID local://132319
2018-10-22 21:46:44,329 (254c) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\2\8ceacefeba4a22fca04a6a0ca646b2a33504619.bundle\Contents\com.plexapp.agents.localmedia\Info.xml
2018-10-22 21:46:44,345 (254c) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/122632/tree'
2018-10-22 21:46:44,361 (254c) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:46:44,361 (254c) :  DEBUG (runtime:924) - Response: [200] str, 300 bytes
2018-10-22 21:46:44,377 (5ac) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzIzMTlzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjYzMnM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzMjMxOXM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:46:44,377 (5ac) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:46:44,377 (5ac) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzIzMTlzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjYzMnM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzMjMxOXM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:46:44,377 (5ac) :  DEBUG (model:32) - Loading model with GUID local://132319
2018-10-22 21:46:44,394 (5ac) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\2\8ceacefeba4a22fca04a6a0ca646b2a33504619.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:46:44,424 (5ac) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/132319/tree'
2018-10-22 21:46:44,438 (5ac) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=5%20Seconds%20Of%20Summer&album=She%20Looks%20So%20Perfect%20%28single%29'
2018-10-22 21:46:44,520 (5ac) :  DEBUG (threadkit:234) - Starting a parallel task set named MatchLyrics with 1 tasks
2018-10-22 21:46:44,522 (14c8) :  INFO (logkit:16) - Adding Lyric She Looks So Perfect to track She Looks So Perfect
2018-10-22 21:46:44,532 (5ac) :  DEBUG (threadkit:244) - Parallel task set MatchLyrics ended
2018-10-22 21:46:44,579 (5ac) :  DEBUG (model:229) - Serializing to C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\2\8ceacefeba4a22fca04a6a0ca646b2a33504619.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:46:44,582 (5ac) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:46:44,582 (5ac) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
2018-10-22 21:46:45,813 (109c) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjYyNnM4CnBhcmVudElEczE0CmxvY2FsOi8vMTMzMDQxczQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzMzA0MXMyCmlkcjAK
2018-10-22 21:46:45,813 (109c) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:46:45,813 (109c) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjYyNnM4CnBhcmVudElEczE0CmxvY2FsOi8vMTMzMDQxczQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzMzA0MXMyCmlkcjAK
2018-10-22 21:46:45,813 (109c) :  INFO (agentkit:957) - Searching for matches for {'id': '133041', 'guid': 'local://133041', 'force': True, 'primary_agent': 'com.plexapp.agents.localmedia', 'parentID': '122626'}
2018-10-22 21:46:45,819 (109c) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/133041/tree'
2018-10-22 21:46:45,829 (109c) :  DEBUG (model:32) - Loading model with GUID local://133041
2018-10-22 21:46:45,829 (109c) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\6\0c30b28c48d200aa3cad0e0c22eab1ad79e920a.bundle\Contents\com.plexapp.agents.localmedia\Info.xml
2018-10-22 21:46:45,831 (109c) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/122626/tree'
2018-10-22 21:46:45,845 (109c) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:46:45,845 (109c) :  DEBUG (runtime:924) - Response: [200] str, 300 bytes
2018-10-22 21:46:45,891 (e9c) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzMwNDFzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjYyNnM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzMzA0MXM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:46:45,891 (e9c) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:46:45,891 (e9c) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzMwNDFzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjYyNnM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzMzA0MXM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:46:45,891 (e9c) :  DEBUG (model:32) - Loading model with GUID local://133041
2018-10-22 21:46:45,895 (e9c) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\6\0c30b28c48d200aa3cad0e0c22eab1ad79e920a.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:46:45,913 (e9c) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/133041/tree'
2018-10-22 21:46:45,938 (e9c) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=One%20Direction&album=One%20Thing%20%28single%29'
2018-10-22 21:46:46,032 (e9c) :  DEBUG (threadkit:234) - Starting a parallel task set named MatchLyrics with 1 tasks
2018-10-22 21:46:46,033 (b44) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=One%20Direction&track=One%20Thing'
2018-10-22 21:46:46,141 (b44) :  INFO (logkit:16) - Adding Lyric One Thing to track One Thing
2018-10-22 21:46:46,141 (e9c) :  DEBUG (threadkit:244) - Parallel task set MatchLyrics ended
2018-10-22 21:46:46,177 (e9c) :  DEBUG (model:229) - Serializing to C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\6\0c30b28c48d200aa3cad0e0c22eab1ad79e920a.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:46:46,188 (e9c) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:46:46,188 (e9c) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
2018-10-22 21:46:53,128 (2150) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjYzNnM4CnBhcmVudElEczE0CmxvY2FsOi8vMTMyNzA3czQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzMjcwN3MyCmlkcjAK
2018-10-22 21:46:53,128 (2150) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:46:53,130 (2150) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjYzNnM4CnBhcmVudElEczE0CmxvY2FsOi8vMTMyNzA3czQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzMjcwN3MyCmlkcjAK
2018-10-22 21:46:53,130 (2150) :  INFO (agentkit:957) - Searching for matches for {'id': '132707', 'guid': 'local://132707', 'force': True, 'primary_agent': 'com.plexapp.agents.localmedia', 'parentID': '122636'}
2018-10-22 21:46:53,142 (2150) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/132707/tree'
2018-10-22 21:46:53,158 (2150) :  DEBUG (model:32) - Loading model with GUID local://132707
2018-10-22 21:46:53,158 (2150) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\5\1f1f584bb0450e950f019d87629e07daa8d7895.bundle\Contents\com.plexapp.agents.localmedia\Info.xml
2018-10-22 21:46:53,158 (2150) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/122636/tree'
2018-10-22 21:46:53,174 (2150) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:46:53,174 (2150) :  DEBUG (runtime:924) - Response: [200] str, 300 bytes
2018-10-22 21:46:53,190 (10bc) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzI3MDdzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjYzNnM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzMjcwN3M0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:46:53,190 (10bc) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:46:53,190 (10bc) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzI3MDdzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjYzNnM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzMjcwN3M0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:46:53,190 (10bc) :  DEBUG (model:32) - Loading model with GUID local://132707
2018-10-22 21:46:53,190 (10bc) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\5\1f1f584bb0450e950f019d87629e07daa8d7895.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:46:53,206 (10bc) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/132707/tree'
2018-10-22 21:46:53,226 (10bc) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Katy%20Perry&album=Birthday%20%28single%29'
2018-10-22 21:46:53,315 (10bc) :  DEBUG (threadkit:234) - Starting a parallel task set named MatchLyrics with 1 tasks
2018-10-22 21:46:53,315 (1008) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Katy%20Perry&track=Birthday'
2018-10-22 21:46:53,408 (1008) :  INFO (logkit:16) - Adding Lyric Birthday to track Birthday
2018-10-22 21:46:53,411 (10bc) :  DEBUG (threadkit:244) - Parallel task set MatchLyrics ended
2018-10-22 21:46:53,457 (10bc) :  DEBUG (model:229) - Serializing to C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\5\1f1f584bb0450e950f019d87629e07daa8d7895.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:46:53,471 (10bc) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:46:53,471 (10bc) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
2018-10-22 21:46:54,033 (b48) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjYzOXM4CnBhcmVudElEczE0CmxvY2FsOi8vMTM0MDM4czQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzNDAzOHMyCmlkcjAK
2018-10-22 21:46:54,033 (b48) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:46:54,033 (b48) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjYzOXM4CnBhcmVudElEczE0CmxvY2FsOi8vMTM0MDM4czQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzNDAzOHMyCmlkcjAK
2018-10-22 21:46:54,035 (b48) :  INFO (agentkit:957) - Searching for matches for {'id': '134038', 'guid': 'local://134038', 'force': True, 'primary_agent': 'com.plexapp.agents.localmedia', 'parentID': '122639'}
2018-10-22 21:46:54,036 (b48) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/134038/tree'
2018-10-22 21:46:54,049 (b48) :  DEBUG (model:32) - Loading model with GUID local://134038
2018-10-22 21:46:54,049 (b48) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\d\abeb6a248c3c7d8dd48e29acd812910abdfabb3.bundle\Contents\com.plexapp.agents.localmedia\Info.xml
2018-10-22 21:46:54,065 (b48) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/122639/tree'
2018-10-22 21:46:54,081 (b48) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:46:54,081 (b48) :  DEBUG (runtime:924) - Response: [200] str, 300 bytes
2018-10-22 21:46:54,096 (b08) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzQwMzhzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjYzOXM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzNDAzOHM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:46:54,096 (b08) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:46:54,096 (b08) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzQwMzhzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjYzOXM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzNDAzOHM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:46:54,096 (b08) :  DEBUG (model:32) - Loading model with GUID local://134038
2018-10-22 21:46:54,096 (b08) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\d\abeb6a248c3c7d8dd48e29acd812910abdfabb3.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:46:54,112 (b08) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/134038/tree'
2018-10-22 21:46:54,128 (b08) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Cheryl%20Cole&album=Didnt_I%20%28single%29'
2018-10-22 21:46:54,221 (b08) :  DEBUG (threadkit:234) - Starting a parallel task set named MatchLyrics with 1 tasks
2018-10-22 21:46:54,236 (2460) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Cheryl%20Cole&track=Didnt_I'
2018-10-22 21:46:54,331 (b08) :  DEBUG (threadkit:244) - Parallel task set MatchLyrics ended
2018-10-22 21:46:54,331 (b08) :  DEBUG (model:229) - Serializing to C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\d\abeb6a248c3c7d8dd48e29acd812910abdfabb3.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:46:54,335 (b08) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:46:54,346 (b08) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
2018-10-22 21:46:56,971 (1ee0) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjYzNnM4CnBhcmVudElEczE0CmxvY2FsOi8vMTMyNzA5czQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzMjcwOXMyCmlkcjAK
2018-10-22 21:46:56,973 (1ee0) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:46:56,973 (1ee0) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjYzNnM4CnBhcmVudElEczE0CmxvY2FsOi8vMTMyNzA5czQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzMjcwOXMyCmlkcjAK
2018-10-22 21:46:56,973 (1ee0) :  INFO (agentkit:957) - Searching for matches for {'id': '132709', 'guid': 'local://132709', 'force': True, 'primary_agent': 'com.plexapp.agents.localmedia', 'parentID': '122636'}
2018-10-22 21:46:56,974 (1ee0) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/132709/tree'
2018-10-22 21:46:56,987 (1ee0) :  DEBUG (model:32) - Loading model with GUID local://132709
2018-10-22 21:46:56,987 (1ee0) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\7\84a6a92655d39441ed4ca40086716a85943a33b.bundle\Contents\com.plexapp.agents.localmedia\Info.xml
2018-10-22 21:46:56,987 (1ee0) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/122636/tree'
2018-10-22 21:46:57,003 (1ee0) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:46:57,003 (1ee0) :  DEBUG (runtime:924) - Response: [200] str, 300 bytes
2018-10-22 21:46:57,022 (350) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzI3MDlzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjYzNnM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzMjcwOXM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:46:57,023 (350) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:46:57,035 (350) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzI3MDlzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjYzNnM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzMjcwOXM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:46:57,035 (350) :  DEBUG (model:32) - Loading model with GUID local://132709
2018-10-22 21:46:57,049 (350) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\7\84a6a92655d39441ed4ca40086716a85943a33b.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:46:57,081 (350) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/132709/tree'
2018-10-22 21:46:57,085 (350) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Katy%20Perry&album=Dark%20Horse%20ft.%20Juicy%20J%20%28single%29'
2018-10-22 21:46:57,174 (350) :  DEBUG (threadkit:234) - Starting a parallel task set named MatchLyrics with 1 tasks
2018-10-22 21:46:57,190 (29a0) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Katy%20Perry&track=Dark%20Horse%20ft.%20Juicy%20J'
2018-10-22 21:46:57,380 (350) :  DEBUG (threadkit:244) - Parallel task set MatchLyrics ended
2018-10-22 21:46:57,394 (350) :  DEBUG (model:229) - Serializing to C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\7\84a6a92655d39441ed4ca40086716a85943a33b.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:46:57,394 (350) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:46:57,394 (350) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
2018-10-22 21:47:00,911 (f94) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCmVuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjY0NXM4CnBhcmVudElEczExMgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FsYnVtLzA1RDY2MkZGMDA3ODkyM0YvNzkwMTc1OS1ENjYyRkYxMDY5N0U0OEVCMjVBODNCMDFCNzdBQUFFNj9sYW5nPWVuczQKZ3VpZGIxczUKZm9yY2VzMjgKY29tLnBsZXhhcHAuYWdlbnRzLnBsZXhtdXNpY3MxMwpwcmltYXJ5X2FnZW50czYKMTMxMTU0czIKaWRyMAo_
2018-10-22 21:47:00,911 (f94) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:47:00,913 (f94) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCmVuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjY0NXM4CnBhcmVudElEczExMgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FsYnVtLzA1RDY2MkZGMDA3ODkyM0YvNzkwMTc1OS1ENjYyRkYxMDY5N0U0OEVCMjVBODNCMDFCNzdBQUFFNj9sYW5nPWVuczQKZ3VpZGIxczUKZm9yY2VzMjgKY29tLnBsZXhhcHAuYWdlbnRzLnBsZXhtdXNpY3MxMwpwcmltYXJ5X2FnZW50czYKMTMxMTU0czIKaWRyMAo_
2018-10-22 21:47:00,914 (f94) :  INFO (agentkit:957) - Searching for matches for {'id': '131154', 'guid': 'com.plexapp.agents.plexmusic://gracenote/album/05D662FF0078923F/7901759-D662FF10697E48EB25A83B01B77AAAE6?lang=en', 'force': True, 'primary_agent': 'com.plexapp.agents.plexmusic', 'parentID': '122645'}
2018-10-22 21:47:00,926 (f94) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/131154/tree'
2018-10-22 21:47:00,927 (f94) :  DEBUG (model:32) - Loading model with GUID com.plexapp.agents.plexmusic://gracenote/album/05D662FF0078923F/7901759-D662FF10697E48EB25A83B01B77AAAE6?lang=en
2018-10-22 21:47:00,928 (f94) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\1\1403cc8602a406812fe0ce53cf5d0ad371059f1.bundle\Contents\com.plexapp.agents.plexmusic\Info.xml
2018-10-22 21:47:00,940 (f94) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/122645/tree'
2018-10-22 21:47:00,957 (f94) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:47:00,957 (f94) :  DEBUG (runtime:924) - Response: [200] str, 300 bytes
2018-10-22 21:47:00,973 (108) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzExNTRzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjY0NXM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxMTIKY29tLnBsZXhhcHAuYWdlbnRzLnBsZXhtdXNpYzovL2dyYWNlbm90ZS9hbGJ1bS8wNUQ2NjJGRjAwNzg5MjNGLzc5MDE3NTktRDY2MkZGMTA2OTdFNDhFQjI1QTgzQjAxQjc3QUFBRTY%40bGFuZz1lbnM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:47:00,973 (108) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:47:00,976 (108) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzExNTRzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjY0NXM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxMTIKY29tLnBsZXhhcHAuYWdlbnRzLnBsZXhtdXNpYzovL2dyYWNlbm90ZS9hbGJ1bS8wNUQ2NjJGRjAwNzg5MjNGLzc5MDE3NTktRDY2MkZGMTA2OTdFNDhFQjI1QTgzQjAxQjc3QUFBRTY@bGFuZz1lbnM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:47:00,976 (108) :  DEBUG (model:32) - Loading model with GUID com.plexapp.agents.plexmusic://gracenote/album/05D662FF0078923F/7901759-D662FF10697E48EB25A83B01B77AAAE6?lang=en
2018-10-22 21:47:00,976 (108) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\1\1403cc8602a406812fe0ce53cf5d0ad371059f1.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:47:01,035 (108) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/131154/tree'
2018-10-22 21:47:01,039 (108) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=The%20Veronicas&album=4ever%20%28single%29'
2018-10-22 21:47:01,131 (108) :  DEBUG (threadkit:234) - Starting a parallel task set named MatchLyrics with 1 tasks
2018-10-22 21:47:01,145 (fd4) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=The%20Veronicas&track=4ever'
2018-10-22 21:47:01,253 (fd4) :  INFO (logkit:16) - Adding Lyric 4ever to track 4ever
2018-10-22 21:47:01,253 (108) :  DEBUG (threadkit:244) - Parallel task set MatchLyrics ended
2018-10-22 21:47:01,414 (108) :  DEBUG (model:229) - Serializing to C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\1\1403cc8602a406812fe0ce53cf5d0ad371059f1.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:47:01,426 (108) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:47:01,426 (108) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
2018-10-22 21:47:04,316 (1b9c) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjYzNnM4CnBhcmVudElEczE0CmxvY2FsOi8vMTMyNzExczQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzMjcxMXMyCmlkcjAK
2018-10-22 21:47:04,316 (1b9c) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:47:04,316 (1b9c) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjYzNnM4CnBhcmVudElEczE0CmxvY2FsOi8vMTMyNzExczQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzMjcxMXMyCmlkcjAK
2018-10-22 21:47:04,316 (1b9c) :  INFO (agentkit:957) - Searching for matches for {'id': '132711', 'guid': 'local://132711', 'force': True, 'primary_agent': 'com.plexapp.agents.localmedia', 'parentID': '122636'}
2018-10-22 21:47:04,316 (1b9c) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/132711/tree'
2018-10-22 21:47:04,332 (1b9c) :  DEBUG (model:32) - Loading model with GUID local://132711
2018-10-22 21:47:04,332 (1b9c) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\d\ae72aa1480ec053bb906c02fa3ac2336da72e95.bundle\Contents\com.plexapp.agents.localmedia\Info.xml
2018-10-22 21:47:04,332 (1b9c) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/122636/tree'
2018-10-22 21:47:04,348 (1b9c) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:47:04,348 (1b9c) :  DEBUG (runtime:924) - Response: [200] str, 300 bytes
2018-10-22 21:47:04,364 (1a70) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzI3MTFzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjYzNnM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzMjcxMXM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:47:04,364 (1a70) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:47:04,364 (1a70) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzI3MTFzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjYzNnM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzMjcxMXM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:47:04,364 (1a70) :  DEBUG (model:32) - Loading model with GUID local://132711
2018-10-22 21:47:04,378 (1a70) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\d\ae72aa1480ec053bb906c02fa3ac2336da72e95.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:47:04,426 (1a70) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/132711/tree'
2018-10-22 21:47:04,441 (1a70) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Katy%20Perry&album=Firework%20%20%28single%29'
2018-10-22 21:47:04,535 (1a70) :  DEBUG (threadkit:234) - Starting a parallel task set named MatchLyrics with 1 tasks
2018-10-22 21:47:04,535 (c50) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Katy%20Perry&track=Firework'
2018-10-22 21:47:04,628 (c50) :  INFO (logkit:16) - Adding Lyric Firework to track Firework
2018-10-22 21:47:04,628 (1a70) :  DEBUG (threadkit:244) - Parallel task set MatchLyrics ended
2018-10-22 21:47:04,664 (1a70) :  DEBUG (model:229) - Serializing to C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\d\ae72aa1480ec053bb906c02fa3ac2336da72e95.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:47:04,676 (1a70) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:47:04,676 (1a70) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
2018-10-22 21:47:09,088 (21b0) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjYzOXM4CnBhcmVudElEczE0CmxvY2FsOi8vMTM0MDQwczQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzNDA0MHMyCmlkcjAK
2018-10-22 21:47:09,098 (21b0) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:47:09,098 (21b0) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjYzOXM4CnBhcmVudElEczE0CmxvY2FsOi8vMTM0MDQwczQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzNDA0MHMyCmlkcjAK
2018-10-22 21:47:09,098 (21b0) :  INFO (agentkit:957) - Searching for matches for {'id': '134040', 'guid': 'local://134040', 'force': True, 'primary_agent': 'com.plexapp.agents.localmedia', 'parentID': '122639'}
2018-10-22 21:47:09,145 (21b0) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/134040/tree'
2018-10-22 21:47:09,161 (21b0) :  DEBUG (model:32) - Loading model with GUID local://134040
2018-10-22 21:47:09,161 (21b0) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\1\f2c6ad24a8f2e43a49728aeefa9b594d05790d6.bundle\Contents\com.plexapp.agents.localmedia\Info.xml
2018-10-22 21:47:09,161 (21b0) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/122639/tree'
2018-10-22 21:47:09,177 (21b0) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:47:09,177 (21b0) :  DEBUG (runtime:924) - Response: [200] str, 300 bytes
2018-10-22 21:47:09,194 (2ba4) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzQwNDBzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjYzOXM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzNDA0MHM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:47:09,196 (2ba4) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:47:09,207 (2ba4) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzQwNDBzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjYzOXM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzNDA0MHM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:47:09,207 (2ba4) :  DEBUG (model:32) - Loading model with GUID local://134040
2018-10-22 21:47:09,207 (2ba4) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\1\f2c6ad24a8f2e43a49728aeefa9b594d05790d6.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:47:09,210 (2ba4) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/134040/tree'
2018-10-22 21:47:09,239 (2ba4) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Cheryl%20Cole&album=Fight_For_This_Love%20%28single%29'
2018-10-22 21:47:09,348 (2ba4) :  DEBUG (threadkit:234) - Starting a parallel task set named MatchLyrics with 1 tasks
2018-10-22 21:47:09,364 (1bb8) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Cheryl%20Cole&track=Fight_For_This_Love'
2018-10-22 21:47:09,473 (2ba4) :  DEBUG (threadkit:244) - Parallel task set MatchLyrics ended
2018-10-22 21:47:09,473 (2ba4) :  DEBUG (model:229) - Serializing to C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\1\f2c6ad24a8f2e43a49728aeefa9b594d05790d6.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:47:09,476 (2ba4) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:47:09,476 (2ba4) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
2018-10-22 21:47:13,365 (2a7c) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCmVuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjY0NXM4CnBhcmVudElEczExNApjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FsYnVtLzA1RDJENUREMDkyNUZGRTAvMTUzNDg1MjgwLUQyRDVERDY5OTAzMzVDRDIzOEQ0NDFDNjFBNkExMzdEP2xhbmc9ZW5zNApndWlkYjFzNQpmb3JjZXMyOApjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljczEzCnByaW1hcnlfYWdlbnRzNgoxMzExNzdzMgppZHIwCg__
2018-10-22 21:47:13,365 (2a7c) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:47:13,365 (2a7c) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCmVuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjY0NXM4CnBhcmVudElEczExNApjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FsYnVtLzA1RDJENUREMDkyNUZGRTAvMTUzNDg1MjgwLUQyRDVERDY5OTAzMzVDRDIzOEQ0NDFDNjFBNkExMzdEP2xhbmc9ZW5zNApndWlkYjFzNQpmb3JjZXMyOApjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljczEzCnByaW1hcnlfYWdlbnRzNgoxMzExNzdzMgppZHIwCg__
2018-10-22 21:47:13,365 (2a7c) :  INFO (agentkit:957) - Searching for matches for {'id': '131177', 'guid': 'com.plexapp.agents.plexmusic://gracenote/album/05D2D5DD0925FFE0/153485280-D2D5DD6990335CD238D441C61A6A137D?lang=en', 'force': True, 'primary_agent': 'com.plexapp.agents.plexmusic', 'parentID': '122645'}
2018-10-22 21:47:13,381 (2a7c) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/131177/tree'
2018-10-22 21:47:13,397 (2a7c) :  DEBUG (model:32) - Loading model with GUID com.plexapp.agents.plexmusic://gracenote/album/05D2D5DD0925FFE0/153485280-D2D5DD6990335CD238D441C61A6A137D?lang=en
2018-10-22 21:47:13,397 (2a7c) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\3\7b3fada40a243f38fcb06008c9ffce1480de5c0.bundle\Contents\com.plexapp.agents.plexmusic\Info.xml
2018-10-22 21:47:13,413 (2a7c) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/122645/tree'
2018-10-22 21:47:13,427 (2a7c) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:47:13,428 (2a7c) :  DEBUG (runtime:924) - Response: [200] str, 300 bytes
2018-10-22 21:47:13,444 (f44) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzExNzdzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjY0NXM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxMTQKY29tLnBsZXhhcHAuYWdlbnRzLnBsZXhtdXNpYzovL2dyYWNlbm90ZS9hbGJ1bS8wNUQyRDVERDA5MjVGRkUwLzE1MzQ4NTI4MC1EMkQ1REQ2OTkwMzM1Q0QyMzhENDQxQzYxQTZBMTM3RD9sYW5nPWVuczQKZ3VpZHM0Cm51bGxzMgppZHIwCg__
2018-10-22 21:47:13,444 (f44) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:47:13,446 (f44) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzExNzdzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjY0NXM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxMTQKY29tLnBsZXhhcHAuYWdlbnRzLnBsZXhtdXNpYzovL2dyYWNlbm90ZS9hbGJ1bS8wNUQyRDVERDA5MjVGRkUwLzE1MzQ4NTI4MC1EMkQ1REQ2OTkwMzM1Q0QyMzhENDQxQzYxQTZBMTM3RD9sYW5nPWVuczQKZ3VpZHM0Cm51bGxzMgppZHIwCg__
2018-10-22 21:47:13,447 (f44) :  DEBUG (model:32) - Loading model with GUID com.plexapp.agents.plexmusic://gracenote/album/05D2D5DD0925FFE0/153485280-D2D5DD6990335CD238D441C61A6A137D?lang=en
2018-10-22 21:47:13,447 (f44) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\3\7b3fada40a243f38fcb06008c9ffce1480de5c0.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:47:13,490 (f44) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/131177/tree'
2018-10-22 21:47:13,510 (f44) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=The%20Veronicas&album=Hook%20Me%20Up'
2018-10-22 21:47:13,615 (f44) :  DEBUG (threadkit:234) - Starting a parallel task set named MatchLyrics with 16 tasks
2018-10-22 21:47:13,618 (424) :  INFO (logkit:16) - Adding Lyric Untouched to track Untouched
2018-10-22 21:47:13,631 (13dc) :  INFO (logkit:16) - Adding Lyric Hook Me Up to track Hook Me Up
2018-10-22 21:47:13,647 (d50) :  INFO (logkit:16) - Adding Lyric This Is How It Feels to track This Is How It Feels
2018-10-22 21:47:13,650 (ef4) :  INFO (logkit:16) - Adding Lyric This Love to track This Love
2018-10-22 21:47:13,677 (13dc) :  INFO (logkit:16) - Adding Lyric Take Me on the Floor to track Take Me on the Floor
2018-10-22 21:47:13,683 (ef4) :  INFO (logkit:16) - Adding Lyric Popular to track Popular
2018-10-22 21:47:13,711 (d50) :  INFO (logkit:16) - Adding Lyric I Don't Wanna Wait to track I Don't Wanna Wait
2018-10-22 21:47:13,772 (d50) :  INFO (logkit:16) - Adding Lyric All I Have to track All I Have
2018-10-22 21:47:13,775 (ef4) :  INFO (logkit:16) - Adding Lyric Someone Wake Me Up to track Someone Wake Me Up
2018-10-22 21:47:13,788 (424) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=The%20Veronicas&track=I%20Can%27t%20Stay%20Away'
2018-10-22 21:47:13,803 (d50) :  INFO (logkit:16) - Adding Lyric In Another Life to track In Another Life
2018-10-22 21:47:13,835 (13dc) :  INFO (logkit:16) - Adding Lyric Revenge Is Sweeter (Than You Ever Were) to track Revenge Is Sweeter (Than You Ever Were)
2018-10-22 21:47:13,851 (ef4) :  INFO (logkit:16) - Adding Lyric Goodbye to You to track Goodbye to You
2018-10-22 21:47:13,913 (ef4) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=The%20Veronicas&track=Track%2016'
2018-10-22 21:47:13,913 (d50) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=The%20Veronicas&track=Change%20the%20World'
2018-10-22 21:47:13,930 (13dc) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=The%20Veronicas&track=Every%20Thing%20I%27m%20Not'
2018-10-22 21:47:14,069 (f44) :  DEBUG (threadkit:244) - Parallel task set MatchLyrics ended
2018-10-22 21:47:14,444 (f44) :  DEBUG (model:229) - Serializing to C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\3\7b3fada40a243f38fcb06008c9ffce1480de5c0.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:47:14,444 (f44) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:47:14,444 (f44) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
2018-10-22 21:47:15,694 (1748) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjYzOXM4CnBhcmVudElEczE0CmxvY2FsOi8vMTM0MDQyczQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzNDA0MnMyCmlkcjAK
2018-10-22 21:47:15,694 (1748) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:47:15,694 (1748) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjYzOXM4CnBhcmVudElEczE0CmxvY2FsOi8vMTM0MDQyczQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzNDA0MnMyCmlkcjAK
2018-10-22 21:47:15,694 (1748) :  INFO (agentkit:957) - Searching for matches for {'id': '134042', 'guid': 'local://134042', 'force': True, 'primary_agent': 'com.plexapp.agents.localmedia', 'parentID': '122639'}
2018-10-22 21:47:15,694 (1748) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/134042/tree'
2018-10-22 21:47:15,710 (1748) :  DEBUG (model:32) - Loading model with GUID local://134042
2018-10-22 21:47:15,710 (1748) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\c\ff5863d832ae26d1d3c249ff6197c6ef43d476d.bundle\Contents\com.plexapp.agents.localmedia\Info.xml
2018-10-22 21:47:15,710 (1748) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/122639/tree'
2018-10-22 21:47:15,724 (1748) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:47:15,724 (1748) :  DEBUG (runtime:924) - Response: [200] str, 300 bytes
2018-10-22 21:47:15,740 (21c8) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzQwNDJzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjYzOXM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzNDA0MnM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:47:15,740 (21c8) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:47:15,740 (21c8) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzQwNDJzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjYzOXM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzNDA0MnM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:47:15,740 (21c8) :  DEBUG (model:32) - Loading model with GUID local://134042
2018-10-22 21:47:15,743 (21c8) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\c\ff5863d832ae26d1d3c249ff6197c6ef43d476d.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:47:15,803 (21c8) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/134042/tree'
2018-10-22 21:47:15,819 (21c8) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Cheryl%20Cole&album=Parachute%20%28single%29'
2018-10-22 21:47:15,928 (21c8) :  DEBUG (threadkit:234) - Starting a parallel task set named MatchLyrics with 1 tasks
2018-10-22 21:47:15,928 (1f54) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Cheryl%20Cole&track=Parachute'
2018-10-22 21:47:15,928 (2238) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjYzNnM4CnBhcmVudElEczE0CmxvY2FsOi8vMTMyNzEzczQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzMjcxM3MyCmlkcjAK
2018-10-22 21:47:15,930 (2238) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:47:15,931 (2238) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjYzNnM4CnBhcmVudElEczE0CmxvY2FsOi8vMTMyNzEzczQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzMjcxM3MyCmlkcjAK
2018-10-22 21:47:15,933 (2238) :  INFO (agentkit:957) - Searching for matches for {'id': '132713', 'guid': 'local://132713', 'force': True, 'primary_agent': 'com.plexapp.agents.localmedia', 'parentID': '122636'}
2018-10-22 21:47:15,934 (2238) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/132713/tree'
2018-10-22 21:47:15,946 (2238) :  DEBUG (model:32) - Loading model with GUID local://132713
2018-10-22 21:47:15,947 (2238) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\1\1aba648e33ac9b19c7512e823412f758186178b.bundle\Contents\com.plexapp.agents.localmedia\Info.xml
2018-10-22 21:47:15,960 (2238) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/122636/tree'
2018-10-22 21:47:15,976 (2238) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:47:15,976 (2238) :  DEBUG (runtime:924) - Response: [200] str, 300 bytes
2018-10-22 21:47:15,992 (27e4) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzI3MTNzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjYzNnM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzMjcxM3M0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:47:15,992 (27e4) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:47:15,992 (27e4) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzI3MTNzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjYzNnM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzMjcxM3M0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:47:15,992 (27e4) :  DEBUG (model:32) - Loading model with GUID local://132713
2018-10-22 21:47:15,992 (27e4) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\1\1aba648e33ac9b19c7512e823412f758186178b.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:47:16,038 (21c8) :  DEBUG (threadkit:244) - Parallel task set MatchLyrics ended
2018-10-22 21:47:16,038 (21c8) :  DEBUG (model:229) - Serializing to C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\c\ff5863d832ae26d1d3c249ff6197c6ef43d476d.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:47:16,042 (27e4) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/132713/tree'
2018-10-22 21:47:16,053 (21c8) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:47:16,053 (21c8) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
2018-10-22 21:47:16,069 (27e4) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Katy%20Perry&album=Hot%20N%20Cold%20%28single%29'
2018-10-22 21:47:16,178 (27e4) :  DEBUG (threadkit:234) - Starting a parallel task set named MatchLyrics with 1 tasks
2018-10-22 21:47:16,178 (13bc) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Katy%20Perry&track=Hot%20N%20Cold'
2018-10-22 21:47:16,288 (13bc) :  INFO (logkit:16) - Adding Lyric Hot N Cold to track Hot N Cold
2018-10-22 21:47:16,288 (27e4) :  DEBUG (threadkit:244) - Parallel task set MatchLyrics ended
2018-10-22 21:47:16,369 (27e4) :  DEBUG (model:229) - Serializing to C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\1\1aba648e33ac9b19c7512e823412f758186178b.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:47:16,381 (27e4) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:47:16,381 (27e4) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
2018-10-22 21:47:24,638 (780) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjYzOXM4CnBhcmVudElEczE0CmxvY2FsOi8vMTM0MDQ0czQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzNDA0NHMyCmlkcjAK
2018-10-22 21:47:24,648 (780) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:47:24,648 (780) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjYzOXM4CnBhcmVudElEczE0CmxvY2FsOi8vMTM0MDQ0czQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzNDA0NHMyCmlkcjAK
2018-10-22 21:47:24,648 (780) :  INFO (agentkit:957) - Searching for matches for {'id': '134044', 'guid': 'local://134044', 'force': True, 'primary_agent': 'com.plexapp.agents.localmedia', 'parentID': '122639'}
2018-10-22 21:47:24,648 (780) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/134044/tree'
2018-10-22 21:47:24,648 (fe8) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjYzNnM4CnBhcmVudElEczE0CmxvY2FsOi8vMTMyNzE1czQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzMjcxNXMyCmlkcjAK
2018-10-22 21:47:24,650 (fe8) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:47:24,651 (fe8) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnhuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M1CkFsYnVtczEwCm1lZGlhX3R5cGU1CnM2CjEyMjYzNnM4CnBhcmVudElEczE0CmxvY2FsOi8vMTMyNzE1czQKZ3VpZGIxczUKZm9yY2VzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTMKcHJpbWFyeV9hZ2VudHM2CjEzMjcxNXMyCmlkcjAK
2018-10-22 21:47:24,651 (fe8) :  INFO (agentkit:957) - Searching for matches for {'id': '132715', 'guid': 'local://132715', 'force': True, 'primary_agent': 'com.plexapp.agents.localmedia', 'parentID': '122636'}
2018-10-22 21:47:24,664 (780) :  DEBUG (model:32) - Loading model with GUID local://134044
2018-10-22 21:47:24,664 (780) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\b\d96d19cb92027df1a8f0292f58bae2b598c3cce.bundle\Contents\com.plexapp.agents.localmedia\Info.xml
2018-10-22 21:47:24,664 (780) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/122639/tree'
2018-10-22 21:47:24,664 (fe8) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/132715/tree'
2018-10-22 21:47:24,680 (fe8) :  DEBUG (model:32) - Loading model with GUID local://132715
2018-10-22 21:47:24,680 (fe8) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\7\412c8d7a9b0b3154753e6c538d6373af5986f98.bundle\Contents\com.plexapp.agents.localmedia\Info.xml
2018-10-22 21:47:24,684 (fe8) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/122636/tree'
2018-10-22 21:47:24,684 (780) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:47:24,696 (780) :  DEBUG (runtime:924) - Response: [200] str, 300 bytes
2018-10-22 21:47:24,710 (584) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzQwNDRzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjYzOXM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzNDA0NHM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:47:24,710 (584) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:47:24,713 (fe8) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:47:24,714 (584) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzQwNDRzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjYzOXM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzNDA0NHM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:47:24,714 (fe8) :  DEBUG (runtime:924) - Response: [200] str, 300 bytes
2018-10-22 21:47:24,726 (584) :  DEBUG (model:32) - Loading model with GUID local://134044
2018-10-22 21:47:24,726 (584) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\b\d96d19cb92027df1a8f0292f58bae2b598c3cce.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:47:24,743 (2be0) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzI3MTVzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjYzNnM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzMjcxNXM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:47:24,743 (2be0) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2018-10-22 21:47:24,743 (2be0) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.lyricfind/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKeG5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNgoxMzI3MTVzNApkYmlkaTAKczcKdmVyc2lvbnM3Mgpjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljOi8vZ3JhY2Vub3RlL2FydGlzdC8wNUE1OTcxRDFDQTM1RUQyP2xhbmc9ZW5zMTAKcGFyZW50R1VJRHM2CjEyMjYzNnM4CnBhcmVudElEczUKQWxidW1zMTAKbWVkaWFfdHlwZXMxNApsb2NhbDovLzEzMjcxNXM0Cmd1aWRzNApudWxsczIKaWRyMAo_
2018-10-22 21:47:24,743 (2be0) :  DEBUG (model:32) - Loading model with GUID local://132715
2018-10-22 21:47:24,743 (2be0) :  DEBUG (model:234) - Deserializing from C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\7\412c8d7a9b0b3154753e6c538d6373af5986f98.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:47:24,744 (584) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/134044/tree'
2018-10-22 21:47:24,757 (2be0) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/132715/tree'
2018-10-22 21:47:24,757 (584) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Cheryl%20Cole&album=Promise%20This__Digital%20Dog%20Radio%20Edit%20%28single%29'
2018-10-22 21:47:24,773 (2be0) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Katy%20Perry&album=I%20Kissed%20A%20Girl%20%28single%29'
2018-10-22 21:47:24,882 (2be0) :  DEBUG (threadkit:234) - Starting a parallel task set named MatchLyrics with 1 tasks
2018-10-22 21:47:24,898 (25c4) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Katy%20Perry&track=I%20Kissed%20A%20Girl'
2018-10-22 21:47:24,898 (584) :  DEBUG (threadkit:234) - Starting a parallel task set named MatchLyrics with 1 tasks
2018-10-22 21:47:24,914 (b34) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/services/lyricfind/search?reqtype=default&searchtype=track&limit=100&output=json&artist=Cheryl%20Cole&track=Promise%20This__Digital%20Dog%20Radio%20Edit'
2018-10-22 21:47:25,026 (584) :  DEBUG (threadkit:244) - Parallel task set MatchLyrics ended
2018-10-22 21:47:25,055 (584) :  DEBUG (model:229) - Serializing to C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\b\d96d19cb92027df1a8f0292f58bae2b598c3cce.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:47:25,055 (25c4) :  INFO (logkit:16) - Adding Lyric I Kissed a Girl to track I Kissed A Girl
2018-10-22 21:47:25,055 (2be0) :  DEBUG (threadkit:244) - Parallel task set MatchLyrics ended
2018-10-22 21:47:25,056 (584) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:47:25,056 (584) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
2018-10-22 21:47:25,101 (2be0) :  DEBUG (model:229) - Serializing to C:\Users\craig\AppData\Local\Plex Media Server\Metadata\Albums\7\412c8d7a9b0b3154753e6c538d6373af5986f98.bundle\Contents\com.plexapp.agents.lyricfind\Info.xml
2018-10-22 21:47:25,101 (2be0) :  DEBUG (runtime:88) - Sending packed state data (109 bytes)
2018-10-22 21:47:25,101 (2be0) :  DEBUG (runtime:924) - Response: [200] str, 16 bytes
