Plex Can't Find Sidecar Subtitles

Plex Media Server Metadata & Adding Files
1

Server Version#: 1.21.0.3711
Player Version#: N/a

The problem appear to be that Plex cannot find sidecar subtitles (or likely any local metadata assets) in folders where the season number is more than 2 digits. This is a problem since many series on TVDB will list their season number as the release year. (eg. Looney Tunes or Mythbusters). So matching the series requires the Season number to be 4 digits, but the Local Media Assets scanner does not appear to be able to handle this correctly.

As an example, I have the SRT files named exactly the same as the video files and in the same directory, for instance:

Z:\Media\TV\Looney Tunes\Season 1947\Looney Tunes - S1947E07 - Tweetie Pie.mkv
Z:\Media\TV\Looney Tunes\Season 1947\Looney Tunes - S1947E07 - Tweetie Pie.eng.srt

But the scanner is unable to find them. On the file’s page, it just says “Subtitles: None”.

I also made sure that the Local Media Assets scanner is enabled and at the top of the list for all the Agents. And I did the Plex dance to remove and re-add the affected TV series to no avail.

Here’s the excerpt from the logs when I run a refresh metadata on an affected episode:

Dec 06, 2020 19:13:39.973 [0x7fb3ff7fe700] DEBUG - Refreshing metadata for 'Tweetie Pie' (agent: com.plexapp.agents.thetvdb)
Dec 06, 2020 19:13:39.974 [0x7fb3ff7fe700] DEBUG - Refreshing GUID: 'com.plexapp.agents.thetvdb://72514/1947/7?lang=en'
Dec 06, 2020 19:13:39.974 [0x7fb3ff7fe700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/system/agents/update?mediaType=4&force=1&respectTags=0&parentGUID=com%2Eplexapp%2Eagents%2Ethetvdb%3A%2F%2F72514%2F1947%3Flang%3Den&parentID=16359&guid=com%2Eplexapp%2Eagents%2Ethetvdb%3A%2F%2F72514%2F1947%2F7%3Flang%3Den&id=16362
Dec 06, 2020 19:13:39.975 [0x7fb39affd700] DEBUG - Request: [127.0.0.1:55878 (Loopback)] GET /system/agents/update?mediaType=4&force=1&respectTags=0&parentGUID=com%2Eplexapp%2Eagents%2Ethetvdb%3A%2F%2F72514%2F1947%3Flang%3Den&parentID=16359&guid=com%2Eplexapp%2Eagents%2Ethetvdb%3A%2F%2F72514%2F1947%2F7%3Flang%3Den&id=16362 (9 live) GZIP Signed-in
Dec 06, 2020 19:13:39.976 [0x7fb39affd700] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /system/agents/update?mediaType=4&force=1&respectTags=0&parentGUID=com%2Eplexapp%2Eagents%2Ethetvdb%3A%2F%2F72514%2F1947%3Flang%3Den&parentID=16359&guid=com%2Eplexapp%2Eagents%2Ethetvdb%3A%2F%2F72514%2F1947%2F7%3Flang%3Den&id=16362
Dec 06, 2020 19:13:39.976 [0x7fb39affd700] DEBUG - HTTP requesting GET http://127.0.0.1:36511/system/agents/update?mediaType=4&force=1&respectTags=0&parentGUID=com%2Eplexapp%2Eagents%2Ethetvdb%3A%2F%2F72514%2F1947%3Flang%3Den&parentID=16359&guid=com%2Eplexapp%2Eagents%2Ethetvdb%3A%2F%2F72514%2F1947%2F7%3Flang%3Den&id=16362
Dec 06, 2020 19:13:39.983 [0x7fb404b85700] DEBUG - Request: [127.0.0.1:55884 (Loopback)] GET /:/plugins (10 live) GZIP Signed-in Token (JagYuki)
Dec 06, 2020 19:13:39.983 [0x7fb405386700] DEBUG - Completed: [127.0.0.1:55884] 200 GET /:/plugins (10 live) GZIP 0ms 613 bytes
Dec 06, 2020 19:13:39.989 [0x7fb39affd700] DEBUG - HTTP 200 response from GET http://127.0.0.1:36511/system/agents/update?mediaType=4&force=1&respectTags=0&parentGUID=com%2Eplexapp%2Eagents%2Ethetvdb%3A%2F%2F72514%2F1947%3Flang%3Den&parentID=16359&guid=com%2Eplexapp%2Eagents%2Ethetvdb%3A%2F%2F72514%2F1947%2F7%3Flang%3Den&id=16362
Dec 06, 2020 19:13:39.990 [0x7fb39affd700] DEBUG - [com.plexapp.system] HTTP reply status 200, with 161 bytes of content.
Dec 06, 2020 19:13:39.990 [0x7fb3ff7fe700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/system/agents/update?mediaType=4&force=1&respectTags=0&parentGUID=com%2Eplexapp%2Eagents%2Ethetvdb%3A%2F%2F72514%2F1947%3Flang%3Den&parentID=16359&guid=com%2Eplexapp%2Eagents%2Ethetvdb%3A%2F%2F72514%2F1947%2F7%3Flang%3Den&id=16362
Dec 06, 2020 19:13:39.991 [0x7fb405386700] DEBUG - Completed: [127.0.0.1:55878] 200 GET /system/agents/update?mediaType=4&force=1&respectTags=0&parentGUID=com%2Eplexapp%2Eagents%2Ethetvdb%3A%2F%2F72514%2F1947%3Flang%3Den&parentID=16359&guid=com%2Eplexapp%2Eagents%2Ethetvdb%3A%2F%2F72514%2F1947%2F7%3Flang%3Den&id=16362 (9 live) GZIP 15ms 438 bytes
Dec 06, 2020 19:13:39.991 [0x7fb405386700] DEBUG - Completed: [192.168.1.27:61218] 200 PUT /library/metadata/16362/refresh (9 live) TLS GZIP 18ms 526 bytes (pipelined: 29)
Dec 06, 2020 19:13:39.996 [0x7fb39bfff700] DEBUG - Request: [127.0.0.1:55886 (Loopback)] GET /:/plugins/com.plexapp.agents.thetvdb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNQoxNjM2MnM0CmRiaWRpMApzNwp2ZXJzaW9uczQ3CmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRiOi8vNzI1MTQvMTk0Nz9sYW5nPWVuczEwCnBhcmVudEdVSURzNQoxNjM1OXM4CnBhcmVudElEczcKVFZfU2hvd3MxMAptZWRpYV90eXBlczQ5CmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRiOi8vNzI1MTQvMTk0Ny83P2xhbmc9ZW5zNApndWlkczUKNzI1MTRzMgppZHIwCg__ (9 live) GZIP Signed-in Token (JagYuki)
Dec 06, 2020 19:13:39.996 [0x7fb39bfff700] DEBUG - [com.plexapp.agents.thetvdb] Sending command over HTTP (GET): /:/plugins/com.plexapp.agents.thetvdb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNQoxNjM2MnM0CmRiaWRpMApzNwp2ZXJzaW9uczQ3CmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRiOi8vNzI1MTQvMTk0Nz9sYW5nPWVuczEwCnBhcmVudEdVSURzNQoxNjM1OXM4CnBhcmVudElEczcKVFZfU2hvd3MxMAptZWRpYV90eXBlczQ5CmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRiOi8vNzI1MTQvMTk0Ny83P2xhbmc9ZW5zNApndWlkczUKNzI1MTRzMgppZHIwCg__
Dec 06, 2020 19:13:39.996 [0x7fb39bfff700] DEBUG - HTTP requesting GET http://127.0.0.1:34468/:/plugins/com.plexapp.agents.thetvdb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNQoxNjM2MnM0CmRiaWRpMApzNwp2ZXJzaW9uczQ3CmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRiOi8vNzI1MTQvMTk0Nz9sYW5nPWVuczEwCnBhcmVudEdVSURzNQoxNjM1OXM4CnBhcmVudElEczcKVFZfU2hvd3MxMAptZWRpYV90eXBlczQ5CmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRiOi8vNzI1MTQvMTk0Ny83P2xhbmc9ZW5zNApndWlkczUKNzI1MTRzMgppZHIwCg__
Dec 06, 2020 19:13:39.998 [0x7fb404b85700] DEBUG - Request: [127.0.0.1:55890 (Loopback)] GET /:/metadata/processing?id=16362 (10 live) GZIP Signed-in Token (JagYuki)
Dec 06, 2020 19:13:39.999 [0x7fb405386700] DEBUG - Completed: [127.0.0.1:55890] 200 GET /:/metadata/processing?id=16362 (10 live) GZIP 1ms 166 bytes
Dec 06, 2020 19:13:40.021 [0x7fb39affd700] DEBUG - Request: [127.0.0.1:55894 (Loopback)] GET /library/metadata/16362/tree (10 live) GZIP Signed-in Token (JagYuki)
Dec 06, 2020 19:13:40.026 [0x7fb405386700] DEBUG - Completed: [127.0.0.1:55894] 200 GET /library/metadata/16362/tree (10 live) GZIP 5ms 1504 bytes
Dec 06, 2020 19:13:40.415 [0x7fb3ff7fe700] DEBUG - Request: [127.0.0.1:55898 (Loopback)] GET /services/tmdb?uri=%2Ffind%2F72514%3Fexternal_source%3Dtvdb_id (10 live) GZIP Signed-in Token (JagYuki)
Dec 06, 2020 19:13:40.572 [0x7fb405b87700] DEBUG - Completed: [127.0.0.1:55898] 200 GET /services/tmdb?uri=%2Ffind%2F72514%3Fexternal_source%3Dtvdb_id (10 live) GZIP 157ms 535 bytes
Dec 06, 2020 19:13:50.486 [0x7fb39bfff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:34468/:/plugins/com.plexapp.agents.thetvdb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNQoxNjM2MnM0CmRiaWRpMApzNwp2ZXJzaW9uczQ3CmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRiOi8vNzI1MTQvMTk0Nz9sYW5nPWVuczEwCnBhcmVudEdVSURzNQoxNjM1OXM4CnBhcmVudElEczcKVFZfU2hvd3MxMAptZWRpYV90eXBlczQ5CmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRiOi8vNzI1MTQvMTk0Ny83P2xhbmc9ZW5zNApndWlkczUKNzI1MTRzMgppZHIwCg__
Dec 06, 2020 19:13:50.486 [0x7fb39bfff700] DEBUG - [com.plexapp.agents.thetvdb] HTTP reply status 200, with 16 bytes of content.
Dec 06, 2020 19:13:50.486 [0x7fb405386700] DEBUG - Completed: [127.0.0.1:55886] 200 GET /:/plugins/com.plexapp.agents.thetvdb/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNQoxNjM2MnM0CmRiaWRpMApzNwp2ZXJzaW9uczQ3CmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRiOi8vNzI1MTQvMTk0Nz9sYW5nPWVuczEwCnBhcmVudEdVSURzNQoxNjM1OXM4CnBhcmVudElEczcKVFZfU2hvd3MxMAptZWRpYV90eXBlczQ5CmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRiOi8vNzI1MTQvMTk0Ny83P2xhbmc9ZW5zNApndWlkczUKNzI1MTRzMgppZHIwCg__ (6 live) GZIP 10490ms 923 bytes
Dec 06, 2020 19:13:50.508 [0x7fb3ff7fe700] DEBUG - Request: [127.0.0.1:55936 (Loopback)] GET /:/plugins (6 live) GZIP Signed-in Token (JagYuki)
Dec 06, 2020 19:13:50.509 [0x7fb405b87700] DEBUG - Completed: [127.0.0.1:55936] 200 GET /:/plugins (6 live) GZIP 0ms 613 bytes
Dec 06, 2020 19:13:50.514 [0x7fb39bfff700] DEBUG - Request: [127.0.0.1:55938 (Loopback)] GET /:/plugins/com.plexapp.agents.localmedia/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCmVuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M3ClRWX1Nob3dzMTAKbWVkaWFfdHlwZTUKczUKMTYzNTlzOApwYXJlbnRJRHM0OQpjb20ucGxleGFwcC5hZ2VudHMudGhldHZkYjovLzcyNTE0LzE5NDcvNz9sYW5nPWVuczQKZ3VpZGIxczUKZm9yY2VzMjYKY29tLnBsZXhhcHAuYWdlbnRzLnRoZXR2ZGJzMTMKcHJpbWFyeV9hZ2VudHM1CjE2MzYyczIKaWRyMAo_ (6 live) GZIP Signed-in Token (JagYuki)
Dec 06, 2020 19:13:50.515 [0x7fb39bfff700] DEBUG - [com.plexapp.agents.localmedia] Sending command over HTTP (GET): /:/plugins/com.plexapp.agents.localmedia/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCmVuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M3ClRWX1Nob3dzMTAKbWVkaWFfdHlwZTUKczUKMTYzNTlzOApwYXJlbnRJRHM0OQpjb20ucGxleGFwcC5hZ2VudHMudGhldHZkYjovLzcyNTE0LzE5NDcvNz9sYW5nPWVuczQKZ3VpZGIxczUKZm9yY2VzMjYKY29tLnBsZXhhcHAuYWdlbnRzLnRoZXR2ZGJzMTMKcHJpbWFyeV9hZ2VudHM1CjE2MzYyczIKaWRyMAo_
Dec 06, 2020 19:13:50.515 [0x7fb39bfff700] DEBUG - HTTP requesting GET http://127.0.0.1:36405/:/plugins/com.plexapp.agents.localmedia/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCmVuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M3ClRWX1Nob3dzMTAKbWVkaWFfdHlwZTUKczUKMTYzNTlzOApwYXJlbnRJRHM0OQpjb20ucGxleGFwcC5hZ2VudHMudGhldHZkYjovLzcyNTE0LzE5NDcvNz9sYW5nPWVuczQKZ3VpZGIxczUKZm9yY2VzMjYKY29tLnBsZXhhcHAuYWdlbnRzLnRoZXR2ZGJzMTMKcHJpbWFyeV9hZ2VudHM1CjE2MzYyczIKaWRyMAo_
Dec 06, 2020 19:13:50.523 [0x7fb3ff7fe700] DEBUG - Request: [127.0.0.1:55944 (Loopback)] GET /library/metadata/16362/tree (7 live) GZIP Signed-in Token (JagYuki)
Dec 06, 2020 19:13:50.528 [0x7fb405386700] DEBUG - Completed: [127.0.0.1:55944] 200 GET /library/metadata/16362/tree (7 live) GZIP 5ms 1504 bytes
Dec 06, 2020 19:13:50.550 [0x7fb39bfff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:36405/:/plugins/com.plexapp.agents.localmedia/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCmVuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M3ClRWX1Nob3dzMTAKbWVkaWFfdHlwZTUKczUKMTYzNTlzOApwYXJlbnRJRHM0OQpjb20ucGxleGFwcC5hZ2VudHMudGhldHZkYjovLzcyNTE0LzE5NDcvNz9sYW5nPWVuczQKZ3VpZGIxczUKZm9yY2VzMjYKY29tLnBsZXhhcHAuYWdlbnRzLnRoZXR2ZGJzMTMKcHJpbWFyeV9hZ2VudHM1CjE2MzYyczIKaWRyMAo_
Dec 06, 2020 19:13:50.550 [0x7fb39bfff700] DEBUG - [com.plexapp.agents.localmedia] HTTP reply status 200, with 600 bytes of content.
Dec 06, 2020 19:13:50.550 [0x7fb405386700] DEBUG - Completed: [127.0.0.1:55938] 200 GET /:/plugins/com.plexapp.agents.localmedia/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCmVuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M3ClRWX1Nob3dzMTAKbWVkaWFfdHlwZTUKczUKMTYzNTlzOApwYXJlbnRJRHM0OQpjb20ucGxleGFwcC5hZ2VudHMudGhldHZkYjovLzcyNTE0LzE5NDcvNz9sYW5nPWVuczQKZ3VpZGIxczUKZm9yY2VzMjYKY29tLnBsZXhhcHAuYWdlbnRzLnRoZXR2ZGJzMTMKcHJpbWFyeV9hZ2VudHM1CjE2MzYyczIKaWRyMAo_ (6 live) GZIP 35ms 811 bytes
Dec 06, 2020 19:13:50.556 [0x7fb3ff7fe700] DEBUG - Request: [127.0.0.1:55946 (Loopback)] GET /:/plugins/com.plexapp.agents.localmedia/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNQoxNjM2MnM0CmRiaWRpMApzNwp2ZXJzaW9uczQ3CmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRiOi8vNzI1MTQvMTk0Nz9sYW5nPWVuczEwCnBhcmVudEdVSURzNQoxNjM1OXM4CnBhcmVudElEczcKVFZfU2hvd3MxMAptZWRpYV90eXBlczQ5CmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRiOi8vNzI1MTQvMTk0Ny83P2xhbmc9ZW5zNApndWlkczQKbnVsbHMyCmlkcjAK (6 live) GZIP Signed-in Token (JagYuki)
Dec 06, 2020 19:13:50.556 [0x7fb3ff7fe700] DEBUG - [com.plexapp.agents.localmedia] Sending command over HTTP (GET): /:/plugins/com.plexapp.agents.localmedia/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNQoxNjM2MnM0CmRiaWRpMApzNwp2ZXJzaW9uczQ3CmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRiOi8vNzI1MTQvMTk0Nz9sYW5nPWVuczEwCnBhcmVudEdVSURzNQoxNjM1OXM4CnBhcmVudElEczcKVFZfU2hvd3MxMAptZWRpYV90eXBlczQ5CmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRiOi8vNzI1MTQvMTk0Ny83P2xhbmc9ZW5zNApndWlkczQKbnVsbHMyCmlkcjAK
Dec 06, 2020 19:13:50.556 [0x7fb3ff7fe700] DEBUG - HTTP requesting GET http://127.0.0.1:36405/:/plugins/com.plexapp.agents.localmedia/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNQoxNjM2MnM0CmRiaWRpMApzNwp2ZXJzaW9uczQ3CmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRiOi8vNzI1MTQvMTk0Nz9sYW5nPWVuczEwCnBhcmVudEdVSURzNQoxNjM1OXM4CnBhcmVudElEczcKVFZfU2hvd3MxMAptZWRpYV90eXBlczQ5CmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRiOi8vNzI1MTQvMTk0Ny83P2xhbmc9ZW5zNApndWlkczQKbnVsbHMyCmlkcjAK
Dec 06, 2020 19:13:50.569 [0x7fb39bfff700] DEBUG - Request: [127.0.0.1:55952 (Loopback)] GET /library/metadata/16362/tree (7 live) GZIP Signed-in Token (JagYuki)
Dec 06, 2020 19:13:50.574 [0x7fb405386700] DEBUG - Completed: [127.0.0.1:55952] 200 GET /library/metadata/16362/tree (7 live) GZIP 5ms 1504 bytes
Dec 06, 2020 19:13:50.637 [0x7fb3ff7fe700] DEBUG - HTTP 200 response from GET http://127.0.0.1:36405/:/plugins/com.plexapp.agents.localmedia/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNQoxNjM2MnM0CmRiaWRpMApzNwp2ZXJzaW9uczQ3CmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRiOi8vNzI1MTQvMTk0Nz9sYW5nPWVuczEwCnBhcmVudEdVSURzNQoxNjM1OXM4CnBhcmVudElEczcKVFZfU2hvd3MxMAptZWRpYV90eXBlczQ5CmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRiOi8vNzI1MTQvMTk0Ny83P2xhbmc9ZW5zNApndWlkczQKbnVsbHMyCmlkcjAK
Dec 06, 2020 19:13:50.637 [0x7fb3ff7fe700] DEBUG - [com.plexapp.agents.localmedia] HTTP reply status 200, with 16 bytes of content.
Dec 06, 2020 19:13:50.638 [0x7fb405386700] DEBUG - Completed: [127.0.0.1:55946] 200 GET /:/plugins/com.plexapp.agents.localmedia/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNQoxNjM2MnM0CmRiaWRpMApzNwp2ZXJzaW9uczQ3CmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRiOi8vNzI1MTQvMTk0Nz9sYW5nPWVuczEwCnBhcmVudEdVSURzNQoxNjM1OXM4CnBhcmVudElEczcKVFZfU2hvd3MxMAptZWRpYV90eXBlczQ5CmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRiOi8vNzI1MTQvMTk0Ny83P2xhbmc9ZW5zNApndWlkczQKbnVsbHMyCmlkcjAK (6 live) GZIP 81ms 426 bytes
Dec 06, 2020 19:13:50.642 [0x7fb39bfff700] DEBUG - Request: [127.0.0.1:55954 (Loopback)] GET /:/plugins (6 live) GZIP Signed-in Token (JagYuki)
Dec 06, 2020 19:13:50.643 [0x7fb405386700] DEBUG - Completed: [127.0.0.1:55954] 200 GET /:/plugins (6 live) GZIP 0ms 613 bytes
Dec 06, 2020 19:13:50.648 [0x7fb3ff7fe700] DEBUG - Request: [127.0.0.1:55956 (Loopback)] GET /:/plugins/com.plexapp.agents.plexthememusic/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCmVuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M3ClRWX1Nob3dzMTAKbWVkaWFfdHlwZTUKczUKMTYzNTlzOApwYXJlbnRJRHM0OQpjb20ucGxleGFwcC5hZ2VudHMudGhldHZkYjovLzcyNTE0LzE5NDcvNz9sYW5nPWVuczQKZ3VpZGIxczUKZm9yY2VzMjYKY29tLnBsZXhhcHAuYWdlbnRzLnRoZXR2ZGJzMTMKcHJpbWFyeV9hZ2VudHM1CjE2MzYyczIKaWRyMAo_ (6 live) GZIP Signed-in Token (JagYuki)
Dec 06, 2020 19:13:50.648 [0x7fb3ff7fe700] DEBUG - [com.plexapp.agents.plexthememusic] Sending command over HTTP (GET): /:/plugins/com.plexapp.agents.plexthememusic/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCmVuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M3ClRWX1Nob3dzMTAKbWVkaWFfdHlwZTUKczUKMTYzNTlzOApwYXJlbnRJRHM0OQpjb20ucGxleGFwcC5hZ2VudHMudGhldHZkYjovLzcyNTE0LzE5NDcvNz9sYW5nPWVuczQKZ3VpZGIxczUKZm9yY2VzMjYKY29tLnBsZXhhcHAuYWdlbnRzLnRoZXR2ZGJzMTMKcHJpbWFyeV9hZ2VudHM1CjE2MzYyczIKaWRyMAo_
Dec 06, 2020 19:13:50.648 [0x7fb3ff7fe700] DEBUG - HTTP requesting GET http://127.0.0.1:44742/:/plugins/com.plexapp.agents.plexthememusic/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCmVuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M3ClRWX1Nob3dzMTAKbWVkaWFfdHlwZTUKczUKMTYzNTlzOApwYXJlbnRJRHM0OQpjb20ucGxleGFwcC5hZ2VudHMudGhldHZkYjovLzcyNTE0LzE5NDcvNz9sYW5nPWVuczQKZ3VpZGIxczUKZm9yY2VzMjYKY29tLnBsZXhhcHAuYWdlbnRzLnRoZXR2ZGJzMTMKcHJpbWFyeV9hZ2VudHM1CjE2MzYyczIKaWRyMAo_
Dec 06, 2020 19:13:50.656 [0x7fb39bfff700] DEBUG - Request: [127.0.0.1:55962 (Loopback)] GET /library/metadata/16362/tree (7 live) GZIP Signed-in Token (JagYuki)
Dec 06, 2020 19:13:50.661 [0x7fb405386700] DEBUG - Completed: [127.0.0.1:55962] 200 GET /library/metadata/16362/tree (7 live) GZIP 5ms 1504 bytes
Dec 06, 2020 19:13:50.683 [0x7fb3ff7fe700] DEBUG - HTTP 200 response from GET http://127.0.0.1:44742/:/plugins/com.plexapp.agents.plexthememusic/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCmVuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M3ClRWX1Nob3dzMTAKbWVkaWFfdHlwZTUKczUKMTYzNTlzOApwYXJlbnRJRHM0OQpjb20ucGxleGFwcC5hZ2VudHMudGhldHZkYjovLzcyNTE0LzE5NDcvNz9sYW5nPWVuczQKZ3VpZGIxczUKZm9yY2VzMjYKY29tLnBsZXhhcHAuYWdlbnRzLnRoZXR2ZGJzMTMKcHJpbWFyeV9hZ2VudHM1CjE2MzYyczIKaWRyMAo_
Dec 06, 2020 19:13:50.683 [0x7fb3ff7fe700] DEBUG - [com.plexapp.agents.plexthememusic] HTTP reply status 200, with 604 bytes of content.
Dec 06, 2020 19:13:50.683 [0x7fb405386700] DEBUG - Completed: [127.0.0.1:55956] 200 GET /:/plugins/com.plexapp.agents.plexthememusic/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCmVuczQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M3ClRWX1Nob3dzMTAKbWVkaWFfdHlwZTUKczUKMTYzNTlzOApwYXJlbnRJRHM0OQpjb20ucGxleGFwcC5hZ2VudHMudGhldHZkYjovLzcyNTE0LzE5NDcvNz9sYW5nPWVuczQKZ3VpZGIxczUKZm9yY2VzMjYKY29tLnBsZXhhcHAuYWdlbnRzLnRoZXR2ZGJzMTMKcHJpbWFyeV9hZ2VudHM1CjE2MzYyczIKaWRyMAo_ (6 live) GZIP 35ms 825 bytes
Dec 06, 2020 19:13:50.689 [0x7fb39bfff700] DEBUG - Request: [127.0.0.1:55964 (Loopback)] GET /:/plugins/com.plexapp.agents.plexthememusic/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNQoxNjM2MnM0CmRiaWRpMApzNwp2ZXJzaW9uczQ3CmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRiOi8vNzI1MTQvMTk0Nz9sYW5nPWVuczEwCnBhcmVudEdVSURzNQoxNjM1OXM4CnBhcmVudElEczcKVFZfU2hvd3MxMAptZWRpYV90eXBlczQ5CmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRiOi8vNzI1MTQvMTk0Ny83P2xhbmc9ZW5zNApndWlkczUKNzI1MTRzMgppZHIwCg__ (6 live) GZIP Signed-in Token (JagYuki)
Dec 06, 2020 19:13:50.689 [0x7fb39bfff700] DEBUG - [com.plexapp.agents.plexthememusic] Sending command over HTTP (GET): /:/plugins/com.plexapp.agents.plexthememusic/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNQoxNjM2MnM0CmRiaWRpMApzNwp2ZXJzaW9uczQ3CmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRiOi8vNzI1MTQvMTk0Nz9sYW5nPWVuczEwCnBhcmVudEdVSURzNQoxNjM1OXM4CnBhcmVudElEczcKVFZfU2hvd3MxMAptZWRpYV90eXBlczQ5CmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRiOi8vNzI1MTQvMTk0Ny83P2xhbmc9ZW5zNApndWlkczUKNzI1MTRzMgppZHIwCg__
Dec 06, 2020 19:13:50.689 [0x7fb39bfff700] DEBUG - HTTP requesting GET http://127.0.0.1:44742/:/plugins/com.plexapp.agents.plexthememusic/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNQoxNjM2MnM0CmRiaWRpMApzNwp2ZXJzaW9uczQ3CmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRiOi8vNzI1MTQvMTk0Nz9sYW5nPWVuczEwCnBhcmVudEdVSURzNQoxNjM1OXM4CnBhcmVudElEczcKVFZfU2hvd3MxMAptZWRpYV90eXBlczQ5CmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRiOi8vNzI1MTQvMTk0Ny83P2xhbmc9ZW5zNApndWlkczUKNzI1MTRzMgppZHIwCg__
Dec 06, 2020 19:13:50.701 [0x7fb3ff7fe700] DEBUG - Request: [127.0.0.1:55970 (Loopback)] GET /library/metadata/16362/tree (7 live) GZIP Signed-in Token (JagYuki)
Dec 06, 2020 19:13:50.706 [0x7fb405386700] DEBUG - Completed: [127.0.0.1:55970] 200 GET /library/metadata/16362/tree (7 live) GZIP 5ms 1504 bytes
Dec 06, 2020 19:13:50.978 [0x7fb39bfff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:44742/:/plugins/com.plexapp.agents.plexthememusic/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNQoxNjM2MnM0CmRiaWRpMApzNwp2ZXJzaW9uczQ3CmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRiOi8vNzI1MTQvMTk0Nz9sYW5nPWVuczEwCnBhcmVudEdVSURzNQoxNjM1OXM4CnBhcmVudElEczcKVFZfU2hvd3MxMAptZWRpYV90eXBlczQ5CmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRiOi8vNzI1MTQvMTk0Ny83P2xhbmc9ZW5zNApndWlkczUKNzI1MTRzMgppZHIwCg__
Dec 06, 2020 19:13:50.978 [0x7fb39bfff700] DEBUG - [com.plexapp.agents.plexthememusic] HTTP reply status 200, with 16 bytes of content.
Dec 06, 2020 19:13:50.978 [0x7fb405386700] DEBUG - Completed: [127.0.0.1:55964] 200 GET /:/plugins/com.plexapp.agents.plexthememusic/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKZW5zNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzNQoxNjM2MnM0CmRiaWRpMApzNwp2ZXJzaW9uczQ3CmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRiOi8vNzI1MTQvMTk0Nz9sYW5nPWVuczEwCnBhcmVudEdVSURzNQoxNjM1OXM4CnBhcmVudElEczcKVFZfU2hvd3MxMAptZWRpYV90eXBlczQ5CmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRiOi8vNzI1MTQvMTk0Ny83P2xhbmc9ZW5zNApndWlkczUKNzI1MTRzMgppZHIwCg__ (6 live) GZIP 289ms 939 bytes
Dec 06, 2020 19:13:51.158 [0x7fb3ff7fe700] DEBUG - Request: [127.0.0.1:55974 (Loopback)] GET /library/metadata/16362/tree (6 live) GZIP Signed-in Token (JagYuki)
Dec 06, 2020 19:13:51.163 [0x7fb405386700] DEBUG - Completed: [127.0.0.1:55974] 200 GET /library/metadata/16362/tree (6 live) GZIP 5ms 1504 bytes
Dec 06, 2020 19:13:51.176 [0x7fb39bfff700] DEBUG - Request: [127.0.0.1:55976 (Loopback)] GET /:/metadata/notify?guid=com.plexapp.agents.thetvdb%3A%2F%2F72514%2F1947%2F7%3Flang%3Den&path=TV+Shows%2F3%2F0d2dce034e98bfefba5452a0a929b2f4ced5902.bundle&force=1&queueSize=0&id=16362&success=1&async=1 (6 live) GZIP Signed-in Token (JagYuki)
Dec 06, 2020 19:13:51.178 [0x7fb39bfff700] DEBUG - Notification of new metadata for com.plexapp.agents.thetvdb://72514/1947/7?lang=en [id=16362] (success=1) for 1 items.
Dec 06, 2020 19:13:51.180 [0x7fb39bfff700] WARN - Unable to load episode file ["seasons/1947/episodes/7.xml"]
Dec 06, 2020 19:13:51.181 [0x7fb39bfff700] DEBUG - Item 16362 (Tweetie Pie) Scanning metadata graphic elements in XML file "seasons/1947/episodes"/7.xml
Dec 06, 2020 19:13:51.183 [0x7fb39bfff700] DEBUG - Item 16362 (Tweetie Pie) Scanning metadata graphic elements in XML file "seasons/1947/episodes"/7.xml
Dec 06, 2020 19:13:51.184 [0x7fb39a7fc700] DEBUG - HTTP requesting GET http://127.0.0.1:36511/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Ethetvdb%3A%2F%2F72514%2F1947%2F7%3Flang%3Den&mediaType=4&url=metadata%3A%2F%2Fseasons%2F1947%2Fepisodes%2F7%2Fthumbs%2Fcom%2Eplexapp%2Eagents%2Ethetvdb_1ed61d64272f02ff79d49935a4c936f15521a01a
Dec 06, 2020 19:13:51.191 [0x7fb39a7fc700] DEBUG - HTTP 200 response from GET http://127.0.0.1:36511/system/agents/media/get?guid=com%2Eplexapp%2Eagents%2Ethetvdb%3A%2F%2F72514%2F1947%2F7%3Flang%3Den&mediaType=4&url=metadata%3A%2F%2Fseasons%2F1947%2Fepisodes%2F7%2Fthumbs%2Fcom%2Eplexapp%2Eagents%2Ethetvdb_1ed61d64272f02ff79d49935a4c936f15521a01a
Dec 06, 2020 19:13:51.191 [0x7fb39bfff700] DEBUG - Brought media local (metadata://seasons/1947/episodes/7/thumbs/com.plexapp.agents.thetvdb_1ed61d64272f02ff79d49935a4c936f15521a01a) in 7ms.
Dec 06, 2020 19:13:51.191 [0x7fb39bfff700] DEBUG - Loading information from media bundle for part ID 26529 from "/config/Library/Application Support/Plex Media Server/Media/localhost/f/d7d7cd210be5019f7cf61b45411a8a694e5c3ea.bundle/Contents"
Dec 06, 2020 19:13:51.217 [0x7fb39bfff700] DEBUG - Loaded metadata for Tweetie Pie (ID 16362) in 37ms
Dec 06, 2020 19:13:51.217 [0x7fb39bfff700] DEBUG - Done with metadata update for 16362
Dec 06, 2020 19:13:51.218 [0x7fb405b87700] DEBUG - Completed: [127.0.0.1:55976] 200 GET /:/metadata/notify?guid=com.plexapp.agents.thetvdb%3A%2F%2F72514%2F1947%2F7%3Flang%3Den&path=TV+Shows%2F3%2F0d2dce034e98bfefba5452a0a929b2f4ced5902.bundle&force=1&queueSize=0&id=16362&success=1&async=1 (6 live) GZIP 41ms 166 bytes
Dec 06, 2020 19:13:51.392 [0x7fb405b87700] DEBUG - Auth: authenticated user 1 as JagYuki
Dec 06, 2020 19:13:51.392 [0x7fb3ff7fe700] DEBUG - Request: [192.168.1.27:61218 (Subnet)] GET /library/metadata/16362?includeExternalMedia=1&skipRefresh=1 (5 live) TLS GZIP Signed-in Token (JagYuki)
Dec 06, 2020 19:13:51.396 [0x7fb3ff7fe700] DEBUG - We're going to try to auto-select an audio stream for account 1.
Dec 06, 2020 19:13:51.396 [0x7fb3ff7fe700] DEBUG - Selecting best audio stream for part ID 26529 (autoselect: 1 language: en)
Dec 06, 2020 19:13:51.396 [0x7fb3ff7fe700] DEBUG - We're going to try to auto-select a subtitle.
Dec 06, 2020 19:13:51.396 [0x7fb3ff7fe700] DEBUG - Audio Stream: 86529, Subtitle Stream: -1
Dec 06, 2020 19:13:51.397 [0x7fb405386700] DEBUG - Completed: [192.168.1.27:61218] 200 GET /library/metadata/16362?includeExternalMedia=1&skipRefresh=1 (5 live) TLS GZIP 5ms 1554 bytes (pipelined: 30)
Dec 06, 2020 19:13:51.450 [0x7fb405b87700] DEBUG - Auth: authenticated user 1 as JagYuki
Dec 06, 2020 19:13:51.450 [0x7fb39bfff700] DEBUG - Request: [192.168.1.27:61218 (Subnet)] GET /library/metadata/16362?includeConcerts=1&includeExtras=1&includeOnDeck=1&includePopularLeaves=1&includePreferences=1&includeReviews=1&includeChapters=1&includeStations=1&includeExternalMedia=1&asyncAugmentMetadata=1&asyncCheckFiles=1&asyncRefreshAnalysis=1&asyncRefreshLocalMediaAgent=1 (5 live) TLS GZIP Signed-in Token (JagYuki)
Dec 06, 2020 19:13:51.455 [0x7fb39bfff700] DEBUG - We're going to try to auto-select an audio stream for account 1.
Dec 06, 2020 19:13:51.455 [0x7fb39bfff700] DEBUG - Selecting best audio stream for part ID 26529 (autoselect: 1 language: en)
Dec 06, 2020 19:13:51.455 [0x7fb39bfff700] DEBUG - We're going to try to auto-select a subtitle.
Dec 06, 2020 19:13:51.455 [0x7fb39bfff700] DEBUG - Audio Stream: 86529, Subtitle Stream: -1
Dec 06, 2020 19:13:51.455 [0x7fb39bfff700] DEBUG - Activity: registered new activity b7136992-e7a2-4008-b3cc-16d5612a682e - Refreshing
Dec 06, 2020 19:13:51.455 [0x7fb3c3fff700] DEBUG - Activity: updated activity b7136992-e7a2-4008-b3cc-16d5612a682e - completed 0.0% - Refreshing
Dec 06, 2020 19:13:51.456 [0x7fb405b87700] DEBUG - Completed: [192.168.1.27:61218] 200 GET /library/metadata/16362?includeConcerts=1&includeExtras=1&includeOnDeck=1&includePopularLeaves=1&includePreferences=1&includeReviews=1&includeChapters=1&includeStations=1&includeExternalMedia=1&asyncAugmentMetadata=1&asyncCheckFiles=1&asyncRefreshAnalysis=1&asyncRefreshLocalMediaAgent=1 (5 live) TLS GZIP 5ms 1681 bytes (pipelined: 31)
Dec 06, 2020 19:13:51.456 [0x7fb3c3fff700] DEBUG - Activity: updated activity b7136992-e7a2-4008-b3cc-16d5612a682e - completed 33.0% - Refreshing
Dec 06, 2020 19:13:51.456 [0x7fb3c3fff700] DEBUG - Activity: updated activity b7136992-e7a2-4008-b3cc-16d5612a682e - completed 66.0% - Refreshing
Dec 06, 2020 19:13:51.456 [0x7fb3c3fff700] DEBUG - Activity: Ended activity b7136992-e7a2-4008-b3cc-16d5612a682e.
Dec 06, 2020 19:13:51.467 [0x7fb405b87700] DEBUG - Auth: authenticated user 1 as JagYuki
Dec 06, 2020 19:13:51.467 [0x7fb39bfff700] DEBUG - Request: [192.168.1.27:61218 (Subnet)] GET /library/metadata/16359/children?excludeAllLeaves=1 (5 live) TLS GZIP Signed-in Token (JagYuki)
Dec 06, 2020 19:13:51.477 [0x7fb405b87700] DEBUG - Completed: [192.168.1.27:61218] 200 GET /library/metadata/16359/children?excludeAllLeaves=1 (5 live) TLS GZIP 10ms 2922 bytes (pipelined: 32)
Dec 06, 2020 19:13:57.183 [0x7fb405b87700] DEBUG - Auth: authenticated user 1 as JagYuki
Dec 06, 2020 19:13:57.184 [0x7fb3ff7fe700] DEBUG - Request: [192.168.1.27:61218 (Subnet)] GET /:/prefs (4 live) TLS GZIP Signed-in Token (JagYuki)
Dec 06, 2020 19:13:57.189 [0x7fb405b87700] DEBUG - Completed: [192.168.1.27:61218] 200 GET /:/prefs (7 live) TLS GZIP 5ms 6827 bytes (pipelined: 33)
Dec 06, 2020 19:13:57.193 [0x7fb405386700] DEBUG - Auth: authenticated user 1 as JagYuki
Dec 06, 2020 19:13:57.193 [0x7fb39bfff700] DEBUG - Request: [192.168.1.27:61223 (Subnet)] GET /accounts/1 (7 live) TLS GZIP Signed-in Token (JagYuki)
Dec 06, 2020 19:13:57.194 [0x7fb405386700] DEBUG - Completed: [192.168.1.27:61223] 200 GET /accounts/1 (7 live) TLS GZIP 0ms 599 bytes (pipelined: 1)
Dec 06, 2020 19:13:57.194 [0x7fb405b87700] DEBUG - Auth: authenticated user 1 as JagYuki
Dec 06, 2020 19:13:57.194 [0x7fb3ff7fe700] DEBUG - Request: [192.168.1.27:61224 (Subnet)] GET /myplex/account (7 live) TLS GZIP Signed-in Token (JagYuki)
Dec 06, 2020 19:13:57.195 [0x7fb405b87700] DEBUG - Completed: [192.168.1.27:61224] 200 GET /myplex/account (7 live) TLS GZIP 0ms 2095 bytes (pipelined: 1)
Dec 06, 2020 19:13:57.196 [0x7fb405386700] DEBUG - Auth: authenticated user 1 as JagYuki
Dec 06, 2020 19:13:57.196 [0x7fb39bfff700] DEBUG - Request: [192.168.1.27:61225 (Subnet)] GET /system/:/prefs (7 live) TLS GZIP Signed-in Token (JagYuki)
Dec 06, 2020 19:13:57.196 [0x7fb39bfff700] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /system/:/prefs
Dec 06, 2020 19:13:57.196 [0x7fb39bfff700] DEBUG - HTTP requesting GET http://127.0.0.1:36511/system/:/prefs
Dec 06, 2020 19:13:57.205 [0x7fb39bfff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:36511/system/:/prefs
Dec 06, 2020 19:13:57.205 [0x7fb39bfff700] DEBUG - [com.plexapp.system] HTTP reply status 200, with 418 bytes of content.
Dec 06, 2020 19:13:57.205 [0x7fb405386700] DEBUG - Completed: [192.168.1.27:61225] 200 GET /system/:/prefs (7 live) TLS GZIP 9ms 813 bytes (pipelined: 1)
Dec 06, 2020 19:13:58.916 [0x7fb405b87700] DEBUG - WebSocket: client initiated close
Dec 06, 2020 19:13:58.916 [0x7fb405386700] DEBUG - NotificationStream: Removing because of close
Dec 06, 2020 19:13:58.929 [0x7fb405386700] DEBUG - Auth: authenticated user 1 as JagYuki
Dec 06, 2020 19:13:58.929 [0x7fb39bfff700] DEBUG - Request: [192.168.1.27:61226 (Subnet)] GET /diagnostics/logs (8 live) TLS GZIP Signed-in Token (JagYuki)
Dec 06, 2020 19:13:58.929 [0x7fb39bfff700] DEBUG - Diagnostics: Building logfile zip
2

I just ran a test, and it appears that the Season number in the filename is the problem. So where it says “S1947E07” appears to be causing the local media assets scanner to not recognize it as a proper file.

To perform this test, I changed the folder name to “Season 47”, and while the file still matched correctly, it did not have subtitles. So the folder name is not the problem.

I then changed the video and subtitle filenames to “Looney Tunes - S47E07 - Tweetie Pie.mkv / .eng.srt”, and the subtitles were then found correctly, but the file could not be matched because there’s no Season 47 in TheTVDB. Therefore the problem is that the scanner cannot recognize four digit season numbers in the filenames of local metadata files.

So there needs to be a change to the Local Media Assets scanner to properly handle four digit (or preferably any length) of season number in the filename.

3

This is an old and known issue with the old tv show scanner.
This canner and agent is currently being rewritten. This issue will very likely not re-occur with the new software.

1 Like
4

Oh good. I would hate to think I ripped and OCRd all my DVD subtitles for no reason.

Thanks.

5

EDIT: Never mind. The below paragraph just makes the SRT External tag show up in the Plex UI, but if you do this then try to watch an episode, it will say there are subtitles on but display nothing. And if you turn the subtitles off then on again, the player will crash and claim transcoding failed.

If anyone needs this kludgy workaround, I used a renaming tool to remove the first 2 numbers of any file that had a four digit season number, did a library scan. This got all the episodes tagged with subtitles in Plex. I then reverted the filename changes and did a library scan and metadata refresh on the affected TV series. This fixed identifying the episodes with TVDB while still retaining the relationship with the sidecar subtitle files.

6

This topic was automatically closed 90 days after the last reply. New replies are no longer allowed.