Video preview thumbnails are no longer being generated automatically

Thank you for your help as well!

It is late for me here as well, only an hour behind you…

Yes, all thumbnails were generated for the media that was added in the last 1.5 days during the course of the Scheduled Task run, however, I continue to add new media since the Scheduled Task completed and no new thumbnails are being generated. :frowning:

I may try to temporarily remove some of those “problem files” to see if that has any impact as well.

Damn! I was really hopeful moving out those “problem files” would fix this.

I ran another Scheduled Task last night and identified all of the files that Plex would attempt to generate thumbnails for every time - it ended up being about 10 files - some movies, some TV. Again, no issues playing these files via Plex, they just don’t have thumbnails.

I removed all of those files and re-scheduled my Task window, restarted the server, etc.

Scheduled Task ran this morning at 9AM - it realized there was media that was added last night that needed thumbnails and it generated those successfully. It did not attempt to generate thumbnails for any “old” files - like what I was seeing with Ben-Hur, Memento, RoboCop, etc. The Scheduled Tasks completed in about 15 minutes (faster than usual since it didn’t attempt to generate thumbnails for those problem files that I had removed.)

I added new media after the Scheduled Task completed - Pooch Perfect S1E8 - no thumbnails generated. :frowning:

I have attached some new logs. Please let me know if you would like me to try anything else - happy to work with you again - thanks!

Plex Media Server Logs_2021-05-19_09-23-17.zip (3.0 MB)

At this point, we need to wait for Engineering to swoop in and triage this.

Wish there was more that I can do but I’ve given all your logs.

Hopefully they can see what the issue is.

Sure thing - thanks @ChuckPa.

I have also recreated the issue with verbose logging enabled, in the event that they would like those logs. I am hesitant to post those logs here because I am not sure the additional level of detail they provide on my connection/server, etc. compared to the standard debug logs. Please PM me if you want them.

These are the steps I took.

  • Verbose logging activated.
  • Get Smart added at approximately 2:43PM on 5/19.
  • System did not generate thumbnails.
  • Logs saved.
  • Verbose logging deactivated.
  • Removed Get Smart from media folder - scanned Movies library to ensure Plex saw the removal.
  • Restarted Plex.
  • Verbose logging activated.
  • Get Smart added to media folder at approximately 3:08PM on 5/19.
  • System generated thumbnails.
  • Logs saved.
  • Verbose logging deactivated.

Hopefully this helps the Engineering team track down the issue.

Verbose logging is of no help. You may discard those logs.

Verbose logging only retains 2 minutes of elapsed time which isn’t enough for this task.

Good thought though.

Please turn VERBOSE off and keep DEBUG on.

We need to wait for Engineering to triage.

Ok, if you say so. I definitely see the video thumbnail generation/movie addition in the logs.

I did enable/disable verbose logging very quickly for each of these tasks because I know the amount of noise verbose logging can generate.

Snippet from when thumbnail generation did not work - I don’t know what all of the calls to com.plexapp.system are, but I do know they don’t appear in the other log (where thumbnail generation works.)

We see it enter thumbnailing state -

May 19, 2021 14:43:36.675 [0x80fe22400] DEBUG - Request: [127.0.0.1:24508 (Loopback)] GET /:/metadata/notify/changeItemState?librarySectionID=2&metadataItemID=70651&metadataType=1&state=-1&parentID=-1&rootID=-1&mediaState=thumbnailing (18 live) GZIP Signed-in Token (Pow4Life181) / Accept => */* / Accept-Encoding => gzip / Host => 127.0.0.1:32400 / User-Agent => PlexMediaServer/1.23.1.4528-c0513eb4c / X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
May 19, 2021 14:43:36.675 [0x8074a3400] DEBUG - Completed: [127.0.0.1:24508] 200 GET /:/metadata/notify/changeItemState?librarySectionID=2&metadataItemID=70651&metadataType=1&state=-1&parentID=-1&rootID=-1&mediaState=thumbnailing (18 live) GZIP 0ms 195 bytes (pipelined: 1955)
May 19, 2021 14:43:37.374 [0x8074a3400] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
May 19, 2021 14:43:37.374 [0x8074a3400] VERBOSE - Auth: Came in with the master token, authorization succeeded.
May 19, 2021 14:43:37.374 [0x80a43f000] DEBUG - Request: [127.0.0.1:35336 (Loopback)] GET /:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQo2CmRpY3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0CjIKczI5CmNvbS5wbGV4YXBwLmFnZW50cy5sb2NhbG1lZGlhczEwCmlkZW50aWZpZXJyMQpzMTAKYWdlbnRfaW5mbzEKcjIKMTAKcjMKczExCm1lZGlhX3R5cGVzbnMxMgphY2NlcHRzX2Zyb21uczE0CmZhbGxiYWNrX2FnZW50cjQKczE0CmNvbnRyaWJ1dGVzX3RvcjUKczkKbGFuZ3VhZ2VzYjBzMjAKcGVyc2lzdF9zdG9yZWRfZmlsZXNpMApzNwp2ZXJzaW9uYjBzMTYKcHJpbWFyeV9wcm92aWRlcmIxczUKcHJlZnNzMjcKTG9jYWwgTWVkaWEgQXNzZXRzIChNb3ZpZXMpczQKbmFtZTEKczUKTW92aWUyCnMyMwpjb20ucGxleGFwcC5hZ2VudHMuaW1kYnMyMwpjb20ucGxleGFwcC5hZ2VudHMubm9uZTEKczIKeG5yMAo_ (19 live) GZIP Signed-in Token (Pow4Life181) / Accept-Encoding => gzip / Connection => close / Cookie => com.plexapp.system=Y2VyZWFsMQozCmRpY3QKbGlzdApkaWN0CjIKcjEKczcKY29va2llc3IyCnM3CnNlc3Npb24wCjAKcjAK / Host => 127.0.0.1:32400 / User-Agent => Mozilla/5.0 (Macintosh; Intel Mac OS X 10_9_2) AppleWebKit/537.74.9 (KHTML, like Gecko) Version/7.0.2 Safari/537.74.9 / X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
May 19, 2021 14:43:37.375 [0x80a43f000] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQo2CmRpY3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0CjIKczI5CmNvbS5wbGV4YXBwLmFnZW50cy5sb2NhbG1lZGlhczEwCmlkZW50aWZpZXJyMQpzMTAKYWdlbnRfaW5mbzEKcjIKMTAKcjMKczExCm1lZGlhX3R5cGVzbnMxMgphY2NlcHRzX2Zyb21uczE0CmZhbGxiYWNrX2FnZW50cjQKczE0CmNvbnRyaWJ1dGVzX3RvcjUKczkKbGFuZ3VhZ2VzYjBzMjAKcGVyc2lzdF9zdG9yZWRfZmlsZXNpMApzNwp2ZXJzaW9uYjBzMTYKcHJpbWFyeV9wcm92aWRlcmIxczUKcHJlZnNzMjcKTG9jYWwgTWVkaWEgQXNzZXRzIChNb3ZpZXMpczQKbmFtZTEKczUKTW92aWUyCnMyMwpjb20ucGxleGFwcC5hZ2VudHMuaW1kYnMyMwpjb20ucGxleGFwcC5hZ2VudHMubm9uZTEKczIKeG5yMAo_
May 19, 2021 14:43:37.375 [0x80a43f000] DEBUG - HTTP requesting GET http://127.0.0.1:21765/:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQo2CmRpY3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0CjIKczI5CmNvbS5wbGV4YXBwLmFnZW50cy5sb2NhbG1lZGlhczEwCmlkZW50aWZpZXJyMQpzMTAKYWdlbnRfaW5mbzEKcjIKMTAKcjMKczExCm1lZGlhX3R5cGVzbnMxMgphY2NlcHRzX2Zyb21uczE0CmZhbGxiYWNrX2FnZW50cjQKczE0CmNvbnRyaWJ1dGVzX3RvcjUKczkKbGFuZ3VhZ2VzYjBzMjAKcGVyc2lzdF9zdG9yZWRfZmlsZXNpMApzNwp2ZXJzaW9uYjBzMTYKcHJpbWFyeV9wcm92aWRlcmIxczUKcHJlZnNzMjcKTG9jYWwgTWVkaWEgQXNzZXRzIChNb3ZpZXMpczQKbmFtZTEKczUKTW92aWUyCnMyMwpjb20ucGxleGFwcC5hZ2VudHMuaW1kYnMyMwpjb20ucGxleGFwcC5hZ2VudHMubm9uZTEKczIKeG5yMAo_
May 19, 2021 14:43:37.385 [0x80a43f000] DEBUG - HTTP/1.1 (0.0s) 200 response from GET http://127.0.0.1:21765/:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQo2CmRpY3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0CjIKczI5CmNvbS5wbGV4YXBwLmFnZW50cy5sb2NhbG1lZGlhczEwCmlkZW50aWZpZXJyMQpzMTAKYWdlbnRfaW5mbzEKcjIKMTAKcjMKczExCm1lZGlhX3R5cGVzbnMxMgphY2NlcHRzX2Zyb21uczE0CmZhbGxiYWNrX2FnZW50cjQKczE0CmNvbnRyaWJ1dGVzX3RvcjUKczkKbGFuZ3VhZ2VzYjBzMjAKcGVyc2lzdF9zdG9yZWRfZmlsZXNpMApzNwp2ZXJzaW9uYjBzMTYKcHJpbWFyeV9wcm92aWRlcmIxczUKcHJlZnNzMjcKTG9jYWwgTWVkaWEgQXNzZXRzIChNb3ZpZXMpczQKbmFtZTEKczUKTW92aWUyCnMyMwpjb20ucGxleGFwcC5hZ2VudHMuaW1kYnMyMwpjb20ucGxleGFwcC5hZ2VudHMubm9uZTEKczIKeG5yMAo_
May 19, 2021 14:43:37.385 [0x80a43f000] DEBUG - [com.plexapp.system] HTTP reply status 200, with 16 bytes of content.
May 19, 2021 14:43:37.385 [0x8074a3400] DEBUG - Completed: [127.0.0.1:35336] 200 GET /:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQo2CmRpY3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0CjIKczI5CmNvbS5wbGV4YXBwLmFnZW50cy5sb2NhbG1lZGlhczEwCmlkZW50aWZpZXJyMQpzMTAKYWdlbnRfaW5mbzEKcjIKMTAKcjMKczExCm1lZGlhX3R5cGVzbnMxMgphY2NlcHRzX2Zyb21uczE0CmZhbGxiYWNrX2FnZW50cjQKczE0CmNvbnRyaWJ1dGVzX3RvcjUKczkKbGFuZ3VhZ2VzYjBzMjAKcGVyc2lzdF9zdG9yZWRfZmlsZXNpMApzNwp2ZXJzaW9uYjBzMTYKcHJpbWFyeV9wcm92aWRlcmIxczUKcHJlZnNzMjcKTG9jYWwgTWVkaWEgQXNzZXRzIChNb3ZpZXMpczQKbmFtZTEKczUKTW92aWUyCnMyMwpjb20ucGxleGFwcC5hZ2VudHMuaW1kYnMyMwpjb20ucGxleGFwcC5hZ2VudHMubm9uZTEKczIKeG5yMAo_ (19 live) GZIP 10ms 415 bytes
May 19, 2021 14:43:37.388 [0x8074a3400] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
May 19, 2021 14:43:37.388 [0x8074a3400] VERBOSE - Auth: Came in with the master token, authorization succeeded.
May 19, 2021 14:43:37.388 [0x80a43f000] DEBUG - Request: [127.0.0.1:35340 (Loopback)] GET /:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxMApkaWN0Cmxpc3QKZGljdApsaXN0Cmxpc3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0CjIKczI5CmNvbS5wbGV4YXBwLmFnZW50cy5sb2NhbG1lZGlhczEwCmlkZW50aWZpZXJyMQpzMTAKYWdlbnRfaW5mbzIKcjIKcjYKMTAKcjMKczExCm1lZGlhX3R5cGVzbnMxMgphY2NlcHRzX2Zyb21uczE0CmZhbGxiYWNrX2FnZW50cjQKczE0CmNvbnRyaWJ1dGVzX3RvcjUKczkKbGFuZ3VhZ2VzYjBzMjAKcGVyc2lzdF9zdG9yZWRfZmlsZXNpMApzNwp2ZXJzaW9uYjBzMTYKcHJpbWFyeV9wcm92aWRlcmIxczUKcHJlZnNzMjcKTG9jYWwgTWVkaWEgQXNzZXRzIChNb3ZpZXMpczQKbmFtZTEKczUKTW92aWUyCnMyMwpjb20ucGxleGFwcC5hZ2VudHMuaW1kYnMyMwpjb20ucGxleGFwcC5hZ2VudHMubm9uZTEKczIKeG4xMApyNwpzMTEKbWVkaWFfdHlwZXNuczEyCmFjY2VwdHNfZnJvbW5zMTQKZmFsbGJhY2tfYWdlbnRyOApzMTQKY29udHJpYnV0ZXNfdG9yOQpzOQpsYW5ndWFnZXNiMHMyMApwZXJzaXN0X3N0b3JlZF9maWxlc2kwCnM3CnZlcnNpb25iMHMxNgpwcmltYXJ5X3Byb3ZpZGVyYjFzNQpwcmVmc3MyMwpMb2NhbCBNZWRpYSBBc3NldHMgKFRWKXM0Cm5hbWUxCnM3ClRWX1Nob3cyCnMyNgpjb20ucGxleGFwcC5hZ2VudHMudGhldHZkYnMyMwpjb20ucGxleGFwcC5hZ2VudHMubm9uZTEKczIKeG5yMAo_ (19 live) GZIP Signed-in Token (Pow4Life181) / Accept-Encoding => gzip / Connection => close / Cookie => com.plexapp.system=Y2VyZWFsMQozCmRpY3QKbGlzdApkaWN0CjIKcjEKczcKY29va2llc3IyCnM3CnNlc3Npb24wCjAKcjAK; com.plexapp.system=Y2VyZWFsMQozCmRpY3QKbGlzdApkaWN0CjIKcjEKczcKY29va2llc3IyCnM3CnNlc3Npb24wCjAKcjAK / Host => 127.0.0.1:32400 / User-Agent => Mozilla/5.0 (Macintosh; Intel Mac OS X 10_9_2) AppleWebKit/537.74.9 (KHTML, like Gecko) Version/7.0.2 Safari/537.74.9 / X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
May 19, 2021 14:43:37.388 [0x80a43f000] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxMApkaWN0Cmxpc3QKZGljdApsaXN0Cmxpc3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0CjIKczI5CmNvbS5wbGV4YXBwLmFnZW50cy5sb2NhbG1lZGlhczEwCmlkZW50aWZpZXJyMQpzMTAKYWdlbnRfaW5mbzIKcjIKcjYKMTAKcjMKczExCm1lZGlhX3R5cGVzbnMxMgphY2NlcHRzX2Zyb21uczE0CmZhbGxiYWNrX2FnZW50cjQKczE0CmNvbnRyaWJ1dGVzX3RvcjUKczkKbGFuZ3VhZ2VzYjBzMjAKcGVyc2lzdF9zdG9yZWRfZmlsZXNpMApzNwp2ZXJzaW9uYjBzMTYKcHJpbWFyeV9wcm92aWRlcmIxczUKcHJlZnNzMjcKTG9jYWwgTWVkaWEgQXNzZXRzIChNb3ZpZXMpczQKbmFtZTEKczUKTW92aWUyCnMyMwpjb20ucGxleGFwcC5hZ2VudHMuaW1kYnMyMwpjb20ucGxleGFwcC5hZ2VudHMubm9uZTEKczIKeG4xMApyNwpzMTEKbWVkaWFfdHlwZXNuczEyCmFjY2VwdHNfZnJvbW5zMTQKZmFsbGJhY2tfYWdlbnRyOApzMTQKY29udHJpYnV0ZXNfdG9yOQpzOQpsYW5ndWFnZXNiMHMyMApwZXJzaXN0X3N0b3JlZF9maWxlc2kwCnM3CnZlcnNpb25iMHMxNgpwcmltYXJ5X3Byb3ZpZGVyYjFzNQpwcmVmc3MyMwpMb2NhbCBNZWRpYSBBc3NldHMgKFRWKXM0Cm5hbWUxCnM3ClRWX1Nob3cyCnMyNgpjb20ucGxleGFwcC5hZ2VudHMudGhldHZkYnMyMwpjb20ucGxleGFwcC5hZ2VudHMubm9uZTEKczIKeG5yMAo_
May 19, 2021 14:43:37.389 [0x80a43f000] DEBUG - HTTP requesting GET http://127.0.0.1:21765/:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxMApkaWN0Cmxpc3QKZGljdApsaXN0Cmxpc3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0CjIKczI5CmNvbS5wbGV4YXBwLmFnZW50cy5sb2NhbG1lZGlhczEwCmlkZW50aWZpZXJyMQpzMTAKYWdlbnRfaW5mbzIKcjIKcjYKMTAKcjMKczExCm1lZGlhX3R5cGVzbnMxMgphY2NlcHRzX2Zyb21uczE0CmZhbGxiYWNrX2FnZW50cjQKczE0CmNvbnRyaWJ1dGVzX3RvcjUKczkKbGFuZ3VhZ2VzYjBzMjAKcGVyc2lzdF9zdG9yZWRfZmlsZXNpMApzNwp2ZXJzaW9uYjBzMTYKcHJpbWFyeV9wcm92aWRlcmIxczUKcHJlZnNzMjcKTG9jYWwgTWVkaWEgQXNzZXRzIChNb3ZpZXMpczQKbmFtZTEKczUKTW92aWUyCnMyMwpjb20ucGxleGFwcC5hZ2VudHMuaW1kYnMyMwpjb20ucGxleGFwcC5hZ2VudHMubm9uZTEKczIKeG4xMApyNwpzMTEKbWVkaWFfdHlwZXNuczEyCmFjY2VwdHNfZnJvbW5zMTQKZmFsbGJhY2tfYWdlbnRyOApzMTQKY29udHJpYnV0ZXNfdG9yOQpzOQpsYW5ndWFnZXNiMHMyMApwZXJzaXN0X3N0b3JlZF9maWxlc2kwCnM3CnZlcnNpb25iMHMxNgpwcmltYXJ5X3Byb3ZpZGVyYjFzNQpwcmVmc3MyMwpMb2NhbCBNZWRpYSBBc3NldHMgKFRWKXM0Cm5hbWUxCnM3ClRWX1Nob3cyCnMyNgpjb20ucGxleGFwcC5hZ2VudHMudGhldHZkYnMyMwpjb20ucGxleGFwcC5hZ2VudHMubm9uZTEKczIKeG5yMAo_
May 19, 2021 14:43:37.395 [0x80a43f000] DEBUG - HTTP/1.1 (0.0s) 200 response from GET http://127.0.0.1:21765/:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxMApkaWN0Cmxpc3QKZGljdApsaXN0Cmxpc3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0CjIKczI5CmNvbS5wbGV4YXBwLmFnZW50cy5sb2NhbG1lZGlhczEwCmlkZW50aWZpZXJyMQpzMTAKYWdlbnRfaW5mbzIKcjIKcjYKMTAKcjMKczExCm1lZGlhX3R5cGVzbnMxMgphY2NlcHRzX2Zyb21uczE0CmZhbGxiYWNrX2FnZW50cjQKczE0CmNvbnRyaWJ1dGVzX3RvcjUKczkKbGFuZ3VhZ2VzYjBzMjAKcGVyc2lzdF9zdG9yZWRfZmlsZXNpMApzNwp2ZXJzaW9uYjBzMTYKcHJpbWFyeV9wcm92aWRlcmIxczUKcHJlZnNzMjcKTG9jYWwgTWVkaWEgQXNzZXRzIChNb3ZpZXMpczQKbmFtZTEKczUKTW92aWUyCnMyMwpjb20ucGxleGFwcC5hZ2VudHMuaW1kYnMyMwpjb20ucGxleGFwcC5hZ2VudHMubm9uZTEKczIKeG4xMApyNwpzMTEKbWVkaWFfdHlwZXNuczEyCmFjY2VwdHNfZnJvbW5zMTQKZmFsbGJhY2tfYWdlbnRyOApzMTQKY29udHJpYnV0ZXNfdG9yOQpzOQpsYW5ndWFnZXNiMHMyMApwZXJzaXN0X3N0b3JlZF9maWxlc2kwCnM3CnZlcnNpb25iMHMxNgpwcmltYXJ5X3Byb3ZpZGVyYjFzNQpwcmVmc3MyMwpMb2NhbCBNZWRpYSBBc3NldHMgKFRWKXM0Cm5hbWUxCnM3ClRWX1Nob3cyCnMyNgpjb20ucGxleGFwcC5hZ2VudHMudGhldHZkYnMyMwpjb20ucGxleGFwcC5hZ2VudHMubm9uZTEKczIKeG5yMAo_
May 19, 2021 14:43:37.395 [0x80a43f000] DEBUG - [com.plexapp.system] HTTP reply status 200, with 16 bytes of content.
May 19, 2021 14:43:37.395 [0x8074a3400] DEBUG - Completed: [127.0.0.1:35340] 200 GET /:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxMApkaWN0Cmxpc3QKZGljdApsaXN0Cmxpc3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0CjIKczI5CmNvbS5wbGV4YXBwLmFnZW50cy5sb2NhbG1lZGlhczEwCmlkZW50aWZpZXJyMQpzMTAKYWdlbnRfaW5mbzIKcjIKcjYKMTAKcjMKczExCm1lZGlhX3R5cGVzbnMxMgphY2NlcHRzX2Zyb21uczE0CmZhbGxiYWNrX2FnZW50cjQKczE0CmNvbnRyaWJ1dGVzX3RvcjUKczkKbGFuZ3VhZ2VzYjBzMjAKcGVyc2lzdF9zdG9yZWRfZmlsZXNpMApzNwp2ZXJzaW9uYjBzMTYKcHJpbWFyeV9wcm92aWRlcmIxczUKcHJlZnNzMjcKTG9jYWwgTWVkaWEgQXNzZXRzIChNb3ZpZXMpczQKbmFtZTEKczUKTW92aWUyCnMyMwpjb20ucGxleGFwcC5hZ2VudHMuaW1kYnMyMwpjb20ucGxleGFwcC5hZ2VudHMubm9uZTEKczIKeG4xMApyNwpzMTEKbWVkaWFfdHlwZXNuczEyCmFjY2VwdHNfZnJvbW5zMTQKZmFsbGJhY2tfYWdlbnRyOApzMTQKY29udHJpYnV0ZXNfdG9yOQpzOQpsYW5ndWFnZXNiMHMyMApwZXJzaXN0X3N0b3JlZF9maWxlc2kwCnM3CnZlcnNpb25iMHMxNgpwcmltYXJ5X3Byb3ZpZGVyYjFzNQpwcmVmc3MyMwpMb2NhbCBNZWRpYSBBc3NldHMgKFRWKXM0Cm5hbWUxCnM3ClRWX1Nob3cyCnMyNgpjb20ucGxleGFwcC5hZ2VudHMudGhldHZkYnMyMwpjb20ucGxleGFwcC5hZ2VudHMubm9uZTEKczIKeG5yMAo_ (19 live) GZIP 7ms 415 bytes
May 19, 2021 14:43:37.399 [0x8074a3400] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
May 19, 2021 14:43:37.399 [0x8074a3400] VERBOSE - Auth: Came in with the master token, authorization succeeded.
May 19, 2021 14:43:37.399 [0x80a43f000] DEBUG - Request: [127.0.0.1:35344 (Loopback)] GET /:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxNApkaWN0Cmxpc3QKZGljdApsaXN0Cmxpc3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0CmRpY3QKbGlzdApsaXN0Cmxpc3QKMgpzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTAKaWRlbnRpZmllcnIxCnMxMAphZ2VudF9pbmZvMwpyMgpyNgpyMTAKMTAKcjMKczExCm1lZGlhX3R5cGVzbnMxMgphY2NlcHRzX2Zyb21uczE0CmZhbGxiYWNrX2FnZW50cjQKczE0CmNvbnRyaWJ1dGVzX3RvcjUKczkKbGFuZ3VhZ2VzYjBzMjAKcGVyc2lzdF9zdG9yZWRfZmlsZXNpMApzNwp2ZXJzaW9uYjBzMTYKcHJpbWFyeV9wcm92aWRlcmIxczUKcHJlZnNzMjcKTG9jYWwgTWVkaWEgQXNzZXRzIChNb3ZpZXMpczQKbmFtZTEKczUKTW92aWUyCnMyMwpjb20ucGxleGFwcC5hZ2VudHMuaW1kYnMyMwpjb20ucGxleGFwcC5hZ2VudHMubm9uZTEKczIKeG4xMApyNwpzMTEKbWVkaWFfdHlwZXNuczEyCmFjY2VwdHNfZnJvbW5zMTQKZmFsbGJhY2tfYWdlbnRyOApzMTQKY29udHJpYnV0ZXNfdG9yOQpzOQpsYW5ndWFnZXNiMHMyMApwZXJzaXN0X3N0b3JlZF9maWxlc2kwCnM3CnZlcnNpb25iMHMxNgpwcmltYXJ5X3Byb3ZpZGVyYjFzNQpwcmVmc3MyMwpMb2NhbCBNZWRpYSBBc3NldHMgKFRWKXM0Cm5hbWUxCnM3ClRWX1Nob3cyCnMyNgpjb20ucGxleGFwcC5hZ2VudHMudGhldHZkYnMyMwpjb20ucGxleGFwcC5hZ2VudHMubm9uZTEKczIKeG4xMApyMTEKczExCm1lZGlhX3R5cGVzbnMxMgphY2NlcHRzX2Zyb21uczE0CmZhbGxiYWNrX2FnZW50cjEyCnMxNApjb250cmlidXRlc190b3IxMwpzOQpsYW5ndWFnZXNiMHMyMApwZXJzaXN0X3N0b3JlZF9maWxlc2kwCnM3CnZlcnNpb25iMHMxNgpwcmltYXJ5X3Byb3ZpZGVyYjFzNQpwcmVmc3MyOApMb2NhbCBNZWRpYSBBc3NldHMgKEFydGlzdHMpczQKbmFtZTEKczYKQXJ0aXN0NgpzMjYKY29tLnBsZXhhcHAuYWdlbnRzLmRpc2NvZ3NzMjUKY29tLnBsZXhhcHAuYWdlbnRzLmxhc3RmbXMyOApjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljczIzCmNvbS5wbGV4YXBwLmFnZW50cy5ub25lczIwCnR2LnBsZXguYWdlbnRzLm11c2ljczI4Cm9yZy5tdXNpY2JyYWluei5hZ2VudHMubXVzaWMxCnMyCnhucjAK (19 live) GZIP Signed-in Token (Pow4Life181) / Accept-Encoding => gzip / Connection => close / Cookie => com.plexapp.system=Y2VyZWFsMQozCmRpY3QKbGlzdApkaWN0CjIKcjEKczcKY29va2llc3IyCnM3CnNlc3Npb24wCjAKcjAK; com.plexapp.system=Y2VyZWFsMQozCmRpY3QKbGlzdApkaWN0CjIKcjEKczcKY29va2llc3IyCnM3CnNlc3Npb24wCjAKcjAK / Host => 127.0.0.1:32400 / User-Agent => Mozilla/5.0 (Macintosh; Intel Mac OS X 10_9_2) AppleWebKit/537.74.9 (KHTML, like Gecko) Version/7.0.2 Safari/537.74.9 / X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
May 19, 2021 14:43:37.399 [0x80a43f000] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxNApkaWN0Cmxpc3QKZGljdApsaXN0Cmxpc3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0CmRpY3QKbGlzdApsaXN0Cmxpc3QKMgpzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTAKaWRlbnRpZmllcnIxCnMxMAphZ2VudF9pbmZvMwpyMgpyNgpyMTAKMTAKcjMKczExCm1lZGlhX3R5cGVzbnMxMgphY2NlcHRzX2Zyb21uczE0CmZhbGxiYWNrX2FnZW50cjQKczE0CmNvbnRyaWJ1dGVzX3RvcjUKczkKbGFuZ3VhZ2VzYjBzMjAKcGVyc2lzdF9zdG9yZWRfZmlsZXNpMApzNwp2ZXJzaW9uYjBzMTYKcHJpbWFyeV9wcm92aWRlcmIxczUKcHJlZnNzMjcKTG9jYWwgTWVkaWEgQXNzZXRzIChNb3ZpZXMpczQKbmFtZTEKczUKTW92aWUyCnMyMwpjb20ucGxleGFwcC5hZ2VudHMuaW1kYnMyMwpjb20ucGxleGFwcC5hZ2VudHMubm9uZTEKczIKeG4xMApyNwpzMTEKbWVkaWFfdHlwZXNuczEyCmFjY2VwdHNfZnJvbW5zMTQKZmFsbGJhY2tfYWdlbnRyOApzMTQKY29udHJpYnV0ZXNfdG9yOQpzOQpsYW5ndWFnZXNiMHMyMApwZXJzaXN0X3N0b3JlZF9maWxlc2kwCnM3CnZlcnNpb25iMHMxNgpwcmltYXJ5X3Byb3ZpZGVyYjFzNQpwcmVmc3MyMwpMb2NhbCBNZWRpYSBBc3NldHMgKFRWKXM0Cm5hbWUxCnM3ClRWX1Nob3cyCnMyNgpjb20ucGxleGFwcC5hZ2VudHMudGhldHZkYnMyMwpjb20ucGxleGFwcC5hZ2VudHMubm9uZTEKczIKeG4xMApyMTEKczExCm1lZGlhX3R5cGVzbnMxMgphY2NlcHRzX2Zyb21uczE0CmZhbGxiYWNrX2FnZW50cjEyCnMxNApjb250cmlidXRlc190b3IxMwpzOQpsYW5ndWFnZXNiMHMyMApwZXJzaXN0X3N0b3JlZF9maWxlc2kwCnM3CnZlcnNpb25iMHMxNgpwcmltYXJ5X3Byb3ZpZGVyYjFzNQpwcmVmc3MyOApMb2NhbCBNZWRpYSBBc3NldHMgKEFydGlzdHMpczQKbmFtZTEKczYKQXJ0aXN0NgpzMjYKY29tLnBsZXhhcHAuYWdlbnRzLmRpc2NvZ3NzMjUKY29tLnBsZXhhcHAuYWdlbnRzLmxhc3RmbXMyOApjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljczIzCmNvbS5wbGV4YXBwLmFnZW50cy5ub25lczIwCnR2LnBsZXguYWdlbnRzLm11c2ljczI4Cm9yZy5tdXNpY2JyYWluei5hZ2VudHMubXVzaWMxCnMyCnhucjAK
May 19, 2021 14:43:37.399 [0x80a43f000] DEBUG - HTTP requesting GET http://127.0.0.1:21765/:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxNApkaWN0Cmxpc3QKZGljdApsaXN0Cmxpc3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0CmRpY3QKbGlzdApsaXN0Cmxpc3QKMgpzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTAKaWRlbnRpZmllcnIxCnMxMAphZ2VudF9pbmZvMwpyMgpyNgpyMTAKMTAKcjMKczExCm1lZGlhX3R5cGVzbnMxMgphY2NlcHRzX2Zyb21uczE0CmZhbGxiYWNrX2FnZW50cjQKczE0CmNvbnRyaWJ1dGVzX3RvcjUKczkKbGFuZ3VhZ2VzYjBzMjAKcGVyc2lzdF9zdG9yZWRfZmlsZXNpMApzNwp2ZXJzaW9uYjBzMTYKcHJpbWFyeV9wcm92aWRlcmIxczUKcHJlZnNzMjcKTG9jYWwgTWVkaWEgQXNzZXRzIChNb3ZpZXMpczQKbmFtZTEKczUKTW92aWUyCnMyMwpjb20ucGxleGFwcC5hZ2VudHMuaW1kYnMyMwpjb20ucGxleGFwcC5hZ2VudHMubm9uZTEKczIKeG4xMApyNwpzMTEKbWVkaWFfdHlwZXNuczEyCmFjY2VwdHNfZnJvbW5zMTQKZmFsbGJhY2tfYWdlbnRyOApzMTQKY29udHJpYnV0ZXNfdG9yOQpzOQpsYW5ndWFnZXNiMHMyMApwZXJzaXN0X3N0b3JlZF9maWxlc2kwCnM3CnZlcnNpb25iMHMxNgpwcmltYXJ5X3Byb3ZpZGVyYjFzNQpwcmVmc3MyMwpMb2NhbCBNZWRpYSBBc3NldHMgKFRWKXM0Cm5hbWUxCnM3ClRWX1Nob3cyCnMyNgpjb20ucGxleGFwcC5hZ2VudHMudGhldHZkYnMyMwpjb20ucGxleGFwcC5hZ2VudHMubm9uZTEKczIKeG4xMApyMTEKczExCm1lZGlhX3R5cGVzbnMxMgphY2NlcHRzX2Zyb21uczE0CmZhbGxiYWNrX2FnZW50cjEyCnMxNApjb250cmlidXRlc190b3IxMwpzOQpsYW5ndWFnZXNiMHMyMApwZXJzaXN0X3N0b3JlZF9maWxlc2kwCnM3CnZlcnNpb25iMHMxNgpwcmltYXJ5X3Byb3ZpZGVyYjFzNQpwcmVmc3MyOApMb2NhbCBNZWRpYSBBc3NldHMgKEFydGlzdHMpczQKbmFtZTEKczYKQXJ0aXN0NgpzMjYKY29tLnBsZXhhcHAuYWdlbnRzLmRpc2NvZ3NzMjUKY29tLnBsZXhhcHAuYWdlbnRzLmxhc3RmbXMyOApjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljczIzCmNvbS5wbGV4YXBwLmFnZW50cy5ub25lczIwCnR2LnBsZXguYWdlbnRzLm11c2ljczI4Cm9yZy5tdXNpY2JyYWluei5hZ2VudHMubXVzaWMxCnMyCnhucjAK
May 19, 2021 14:43:37.406 [0x80a43f000] DEBUG - HTTP/1.1 (0.0s) 200 response from GET http://127.0.0.1:21765/:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxNApkaWN0Cmxpc3QKZGljdApsaXN0Cmxpc3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0CmRpY3QKbGlzdApsaXN0Cmxpc3QKMgpzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTAKaWRlbnRpZmllcnIxCnMxMAphZ2VudF9pbmZvMwpyMgpyNgpyMTAKMTAKcjMKczExCm1lZGlhX3R5cGVzbnMxMgphY2NlcHRzX2Zyb21uczE0CmZhbGxiYWNrX2FnZW50cjQKczE0CmNvbnRyaWJ1dGVzX3RvcjUKczkKbGFuZ3VhZ2VzYjBzMjAKcGVyc2lzdF9zdG9yZWRfZmlsZXNpMApzNwp2ZXJzaW9uYjBzMTYKcHJpbWFyeV9wcm92aWRlcmIxczUKcHJlZnNzMjcKTG9jYWwgTWVkaWEgQXNzZXRzIChNb3ZpZXMpczQKbmFtZTEKczUKTW92aWUyCnMyMwpjb20ucGxleGFwcC5hZ2VudHMuaW1kYnMyMwpjb20ucGxleGFwcC5hZ2VudHMubm9uZTEKczIKeG4xMApyNwpzMTEKbWVkaWFfdHlwZXNuczEyCmFjY2VwdHNfZnJvbW5zMTQKZmFsbGJhY2tfYWdlbnRyOApzMTQKY29udHJpYnV0ZXNfdG9yOQpzOQpsYW5ndWFnZXNiMHMyMApwZXJzaXN0X3N0b3JlZF9maWxlc2kwCnM3CnZlcnNpb25iMHMxNgpwcmltYXJ5X3Byb3ZpZGVyYjFzNQpwcmVmc3MyMwpMb2NhbCBNZWRpYSBBc3NldHMgKFRWKXM0Cm5hbWUxCnM3ClRWX1Nob3cyCnMyNgpjb20ucGxleGFwcC5hZ2VudHMudGhldHZkYnMyMwpjb20ucGxleGFwcC5hZ2VudHMubm9uZTEKczIKeG4xMApyMTEKczExCm1lZGlhX3R5cGVzbnMxMgphY2NlcHRzX2Zyb21uczE0CmZhbGxiYWNrX2FnZW50cjEyCnMxNApjb250cmlidXRlc190b3IxMwpzOQpsYW5ndWFnZXNiMHMyMApwZXJzaXN0X3N0b3JlZF9maWxlc2kwCnM3CnZlcnNpb25iMHMxNgpwcmltYXJ5X3Byb3ZpZGVyYjFzNQpwcmVmc3MyOApMb2NhbCBNZWRpYSBBc3NldHMgKEFydGlzdHMpczQKbmFtZTEKczYKQXJ0aXN0NgpzMjYKY29tLnBsZXhhcHAuYWdlbnRzLmRpc2NvZ3NzMjUKY29tLnBsZXhhcHAuYWdlbnRzLmxhc3RmbXMyOApjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljczIzCmNvbS5wbGV4YXBwLmFnZW50cy5ub25lczIwCnR2LnBsZXguYWdlbnRzLm11c2ljczI4Cm9yZy5tdXNpY2JyYWluei5hZ2VudHMubXVzaWMxCnMyCnhucjAK
May 19, 2021 14:43:37.406 [0x80a43f000] DEBUG - [com.plexapp.system] HTTP reply status 200, with 16 bytes of content.
May 19, 2021 14:43:37.407 [0x8074a3400] DEBUG - Completed: [127.0.0.1:35344] 200 GET /:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxNApkaWN0Cmxpc3QKZGljdApsaXN0Cmxpc3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0CmRpY3QKbGlzdApsaXN0Cmxpc3QKMgpzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTAKaWRlbnRpZmllcnIxCnMxMAphZ2VudF9pbmZvMwpyMgpyNgpyMTAKMTAKcjMKczExCm1lZGlhX3R5cGVzbnMxMgphY2NlcHRzX2Zyb21uczE0CmZhbGxiYWNrX2FnZW50cjQKczE0CmNvbnRyaWJ1dGVzX3RvcjUKczkKbGFuZ3VhZ2VzYjBzMjAKcGVyc2lzdF9zdG9yZWRfZmlsZXNpMApzNwp2ZXJzaW9uYjBzMTYKcHJpbWFyeV9wcm92aWRlcmIxczUKcHJlZnNzMjcKTG9jYWwgTWVkaWEgQXNzZXRzIChNb3ZpZXMpczQKbmFtZTEKczUKTW92aWUyCnMyMwpjb20ucGxleGFwcC5hZ2VudHMuaW1kYnMyMwpjb20ucGxleGFwcC5hZ2VudHMubm9uZTEKczIKeG4xMApyNwpzMTEKbWVkaWFfdHlwZXNuczEyCmFjY2VwdHNfZnJvbW5zMTQKZmFsbGJhY2tfYWdlbnRyOApzMTQKY29udHJpYnV0ZXNfdG9yOQpzOQpsYW5ndWFnZXNiMHMyMApwZXJzaXN0X3N0b3JlZF9maWxlc2kwCnM3CnZlcnNpb25iMHMxNgpwcmltYXJ5X3Byb3ZpZGVyYjFzNQpwcmVmc3MyMwpMb2NhbCBNZWRpYSBBc3NldHMgKFRWKXM0Cm5hbWUxCnM3ClRWX1Nob3cyCnMyNgpjb20ucGxleGFwcC5hZ2VudHMudGhldHZkYnMyMwpjb20ucGxleGFwcC5hZ2VudHMubm9uZTEKczIKeG4xMApyMTEKczExCm1lZGlhX3R5cGVzbnMxMgphY2NlcHRzX2Zyb21uczE0CmZhbGxiYWNrX2FnZW50cjEyCnMxNApjb250cmlidXRlc190b3IxMwpzOQpsYW5ndWFnZXNiMHMyMApwZXJzaXN0X3N0b3JlZF9maWxlc2kwCnM3CnZlcnNpb25iMHMxNgpwcmltYXJ5X3Byb3ZpZGVyYjFzNQpwcmVmc3MyOApMb2NhbCBNZWRpYSBBc3NldHMgKEFydGlzdHMpczQKbmFtZTEKczYKQXJ0aXN0NgpzMjYKY29tLnBsZXhhcHAuYWdlbnRzLmRpc2NvZ3NzMjUKY29tLnBsZXhhcHAuYWdlbnRzLmxhc3RmbXMyOApjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljczIzCmNvbS5wbGV4YXBwLmFnZW50cy5ub25lczIwCnR2LnBsZXguYWdlbnRzLm11c2ljczI4Cm9yZy5tdXNpY2JyYWluei5hZ2VudHMubXVzaWMxCnMyCnhucjAK (19 live) GZIP 7ms 415 bytes
May 19, 2021 14:43:37.411 [0x8074a3400] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
May 19, 2021 14:43:37.411 [0x8074a3400] VERBOSE - Auth: Came in with the master token, authorization succeeded.
May 19, 2021 14:43:37.411 [0x80a43f000] DEBUG - Request: [127.0.0.1:35348 (Loopback)] GET /:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxNwpkaWN0Cmxpc3QKZGljdApsaXN0Cmxpc3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0CmRpY3QKbGlzdApsaXN0Cmxpc3QKZGljdApsaXN0Cmxpc3QKMgpzMjkKY29tLnBsZXhhcHAuYWdlbnRzLmxvY2FsbWVkaWFzMTAKaWRlbnRpZmllcnIxCnMxMAphZ2VudF9pbmZvNApyMgpyNgpyMTAKcjE0CjEwCnIzCnMxMQptZWRpYV90eXBlc25zMTIKYWNjZXB0c19mcm9tbnMxNApmYWxsYmFja19hZ2VudHI0CnMxNApjb250cmlidXRlc190b3I1CnM5Cmxhbmd1YWdlc2IwczIwCnBlcnNpc3Rfc3RvcmVkX2ZpbGVzaTAKczcKdmVyc2lvbmIwczE2CnByaW1hcnlfcHJvdmlkZXJiMXM1CnByZWZzczI3CkxvY2FsIE1lZGlhIEFzc2V0cyAoTW92aWVzKXM0Cm5hbWUxCnM1Ck1vdmllMgpzMjMKY29tLnBsZXhhcHAuYWdlbnRzLmltZGJzMjMKY29tLnBsZXhhcHAuYWdlbnRzLm5vbmUxCnMyCnhuMTAKcjcKczExCm1lZGlhX3R5cGVzbnMxMgphY2NlcHRzX2Zyb21uczE0CmZhbGxiYWNrX2FnZW50cjgKczE0CmNvbnRyaWJ1dGVzX3RvcjkKczkKbGFuZ3VhZ2VzYjBzMjAKcGVyc2lzdF9zdG9yZWRfZmlsZXNpMApzNwp2ZXJzaW9uYjBzMTYKcHJpbWFyeV9wcm92aWRlcmIxczUKcHJlZnNzMjMKTG9jYWwgTWVkaWEgQXNzZXRzIChUVilzNApuYW1lMQpzNwpUVl9TaG93MgpzMjYKY29tLnBsZXhhcHAuYWdlbnRzLnRoZXR2ZGJzMjMKY29tLnBsZXhhcHAuYWdlbnRzLm5vbmUxCnMyCnhuMTAKcjExCnMxMQptZWRpYV90eXBlc25zMTIKYWNjZXB0c19mcm9tbnMxNApmYWxsYmFja19hZ2VudHIxMgpzMTQKY29udHJpYnV0ZXNfdG9yMTMKczkKbGFuZ3VhZ2VzYjBzMjAKcGVyc2lzdF9zdG9yZWRfZmlsZXNpMApzNwp2ZXJzaW9uYjBzMTYKcHJpbWFyeV9wcm92aWRlcmIxczUKcHJlZnNzMjgKTG9jYWwgTWVkaWEgQXNzZXRzIChBcnRpc3RzKXM0Cm5hbWUxCnM2CkFydGlzdDYKczI2CmNvbS5wbGV4YXBwLmFnZW50cy5kaXNjb2dzczI1CmNvbS5wbGV4YXBwLmFnZW50cy5sYXN0Zm1zMjgKY29tLnBsZXhhcHAuYWdlbnRzLnBsZXhtdXNpY3MyMwpjb20ucGxleGFwcC5hZ2VudHMubm9uZXMyMAp0di5wbGV4LmFnZW50cy5tdXNpY3MyOApvcmcubXVzaWNicmFpbnouYWdlbnRzLm11c2ljMQpzMgp4bjEwCnIxNQpzMTEKbWVkaWFfdHlwZXNuczEyCmFjY2VwdHNfZnJvbW5zMTQKZmFsbGJhY2tfYWdlbnRyMTYKczE0CmNvbnRyaWJ1dGVzX3RvcjEzCnM5Cmxhbmd1YWdlc2IwczIwCnBlcnNpc3Rfc3RvcmVkX2ZpbGVzaTIKczcKdmVyc2lvbmIwczE2CnByaW1hcnlfcHJvdmlkZXJiMXM1CnByZWZzczI4CkxvY2FsIE1lZGlhIEFzc2V0cyAoQXJ0aXN0cylzNApuYW1lMQpzNgpBcnRpc3QxCnMyOApjb20ucGxleGFwcC5hZ2VudHMucGxleG11c2ljcjAK (19 live) GZIP Signed-in Token (Pow4Life181) / Accept-Encoding => gzip / Connection => close / Cookie => com.plexapp.system=Y2VyZWFsMQozCmRpY3QKbGlzdApkaWN0CjIKcjEKczcKY29va2llc3IyCnM3CnNlc3Npb24wCjAKcjAK; com.plexapp.system=Y2VyZWFsMQozCmRpY3QKbGlzdApkaWN0CjIKcjEKczcKY29va2llc3IyCnM3CnNlc3Npb24wCjAKcjAK / Host => 127.0.0.1:32400 / User-Agent => Mozilla/5.0 (Macintosh; Intel Mac OS X 10_9_2) AppleWebKit/537.74.9 (KHTML, like Gecko) Version/7.0.2 Safari/537.74.9 / X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
May 19, 2021 14:43:37.423 [0x8074a4800] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
May 19, 2021 14:43:37.423 [0x8074a4800] VERBOSE - Auth: Came in with the master token, authorization succeeded.
May 19, 2021 14:43:37.507 [0x80a43f000] DEBUG - LongRunningJobManager [BaseIndexFrameFile]: scheduling job for item 70651, 0 pending.
May 19, 2021 14:43:37.508 [0x80a43f000] VERBOSE - It took 0.0 sec to serialize a list with 0 elements.
May 19, 2021 14:43:37.508 [0x8074a4800] DEBUG - Completed: [127.0.0.1:24508] 200 PUT /library/metadata/70651/index (18 live) GZIP 4ms 482 bytes (pipelined: 1959)
May 19, 2021 14:43:37.509 [0x8074a3400] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
May 19, 2021 14:43:37.509 [0x8074a3400] VERBOSE - Auth: Came in with the master token, authorization succeeded.
May 19, 2021 14:43:37.509 [0x80a43f000] DEBUG - Request: [127.0.0.1:24508 (Loopback)] GET /:/metadata/notify/changeItemState?librarySectionID=2&metadataItemID=70651&metadataType=1&state=1&parentID=-1&rootID=-1 (18 live) GZIP Signed-in Token (Pow4Life181) / Accept => */* / Accept-Encoding => gzip / Host => 127.0.0.1:32400 / User-Agent => PlexMediaServer/1.23.1.4528-c0513eb4c / X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
May 19, 2021 14:43:37.509 [0x8074a3400] DEBUG - Completed: [127.0.0.1:24508] 200 GET /:/metadata/notify/changeItemState?librarySectionID=2&metadataItemID=70651&metadataType=1&state=1&parentID=-1&rootID=-1 (18 live) GZIP 0ms 195 bytes (pipelined: 1960)
May 19, 2021 14:43:37.511 [0x8074a3400] VERBOSE - Didn't receive a request from 127.0.0.1:24508: End of file
May 19, 2021 14:43:37.511 [0x8074a3400] VERBOSE - Didn't receive a request from 127.0.0.1:37467: End of file
May 19, 2021 14:43:37.511 [0x8074a4800] VERBOSE - Didn't receive a request from 127.0.0.1:29595: End of file

Snippet from when thumbnail generation did work:

May 19, 2021 15:08:30.761 [0x80ce6dd00] DEBUG - Request: [127.0.0.1:49848 (Loopback)] GET /:/metadata/notify/changeItemState?librarySectionID=2&metadataItemID=70654&metadataType=1&state=-1&parentID=-1&rootID=-1&mediaState=thumbnailing (19 live) GZIP Signed-in Token (Pow4Life181) / Accept => */* / Accept-Encoding => gzip / Host => 127.0.0.1:32400 / User-Agent => PlexMediaServer/1.23.1.4528-c0513eb4c / X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
May 19, 2021 15:08:30.761 [0x8074a3400] DEBUG - Completed: [127.0.0.1:49848] 200 GET /:/metadata/notify/changeItemState?librarySectionID=2&metadataItemID=70654&metadataType=1&state=-1&parentID=-1&rootID=-1&mediaState=thumbnailing (19 live) GZIP 0ms 195 bytes (pipelined: 2287)
May 19, 2021 15:08:30.763 [0x8074a4800] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
May 19, 2021 15:08:30.763 [0x8074a4800] VERBOSE - Auth: Came in with the master token, authorization succeeded.
May 19, 2021 15:08:30.763 [0x80ce6dd00] DEBUG - Request: [127.0.0.1:49848 (Loopback)] GET /:/metadata/notify/changeItemState?librarySectionID=2&metadataItemID=70654&metadataType=1&state=-1&parentID=-1&rootID=-1&mediaState=idle (19 live) GZIP Signed-in Token (Pow4Life181) / Accept => */* / Accept-Encoding => gzip / Host => 127.0.0.1:32400 / User-Agent => PlexMediaServer/1.23.1.4528-c0513eb4c / X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
May 19, 2021 15:08:30.763 [0x8074a4800] DEBUG - Completed: [127.0.0.1:49848] 200 GET /:/metadata/notify/changeItemState?librarySectionID=2&metadataItemID=70654&metadataType=1&state=-1&parentID=-1&rootID=-1&mediaState=idle (19 live) GZIP 0ms 195 bytes (pipelined: 2288)
May 19, 2021 15:08:30.794 [0x80963f000] DEBUG - There were 1 top-level paths for Under the Dome.
May 19, 2021 15:08:30.795 [0x80963f000] DEBUG - We're going to try to auto-select an audio stream for account 1.
May 19, 2021 15:08:30.795 [0x80963f000] DEBUG - Selecting best audio stream for part ID 127354 (autoselect: 1 language: en)
May 19, 2021 15:08:30.795 [0x80963f000] DEBUG - We're going to try to auto-select a subtitle.
May 19, 2021 15:08:30.795 [0x80963f000] DEBUG - Audio Stream: 342702, Subtitle Stream: -1
May 19, 2021 15:08:30.796 [0x80963f000] DEBUG - We're going to try to auto-select an audio stream for account 1.
May 19, 2021 15:08:30.796 [0x80963f000] DEBUG - Selecting best audio stream for part ID 127336 (autoselect: 1 language: en)
May 19, 2021 15:08:30.796 [0x80963f000] DEBUG - We're going to try to auto-select a subtitle.
May 19, 2021 15:08:30.796 [0x80963f000] DEBUG - Audio Stream: 342646, Subtitle Stream: -1
May 19, 2021 15:08:30.796 [0x80963f000] DEBUG - We're going to try to auto-select an audio stream for account 1.
May 19, 2021 15:08:30.796 [0x80963f000] DEBUG - Selecting best audio stream for part ID 127335 (autoselect: 1 language: en)
May 19, 2021 15:08:30.796 [0x80963f000] DEBUG - We're going to try to auto-select a subtitle.
May 19, 2021 15:08:30.796 [0x80963f000] DEBUG - Audio Stream: 342643, Subtitle Stream: -1
May 19, 2021 15:08:30.796 [0x80963f000] DEBUG - We're going to try to auto-select an audio stream for account 1.
May 19, 2021 15:08:30.796 [0x80963f000] DEBUG - Selecting best audio stream for part ID 127334 (autoselect: 1 language: en)
May 19, 2021 15:08:30.796 [0x80963f000] DEBUG - We're going to try to auto-select a subtitle.
May 19, 2021 15:08:30.796 [0x80963f000] DEBUG - Audio Stream: 342640, Subtitle Stream: -1
May 19, 2021 15:08:30.797 [0x80963f000] DEBUG - We're going to try to auto-select an audio stream for account 1.
May 19, 2021 15:08:30.797 [0x80963f000] DEBUG - Selecting best audio stream for part ID 127333 (autoselect: 1 language: en)
May 19, 2021 15:08:30.797 [0x80963f000] DEBUG - We're going to try to auto-select a subtitle.
May 19, 2021 15:08:30.797 [0x80963f000] DEBUG - Audio Stream: 342636, Subtitle Stream: -1
May 19, 2021 15:08:30.798 [0x80963f000] DEBUG - We're going to try to auto-select an audio stream for account 1.
May 19, 2021 15:08:30.798 [0x80963f000] DEBUG - Selecting best audio stream for part ID 127318 (autoselect: 1 language: en)
May 19, 2021 15:08:30.798 [0x80963f000] DEBUG - We're going to try to auto-select a subtitle.
May 19, 2021 15:08:30.798 [0x80963f000] DEBUG - Audio Stream: 342601, Subtitle Stream: -1
May 19, 2021 15:08:30.798 [0x80963f000] DEBUG - We're going to try to auto-select an audio stream for account 1.
May 19, 2021 15:08:30.798 [0x80963f000] DEBUG - Selecting best audio stream for part ID 127317 (autoselect: 1 language: en)
May 19, 2021 15:08:30.798 [0x80963f000] DEBUG - We're going to try to auto-select a subtitle.
May 19, 2021 15:08:30.798 [0x80963f000] DEBUG - Audio Stream: 342598, Subtitle Stream: -1
May 19, 2021 15:08:30.798 [0x80963f000] DEBUG - We're going to try to auto-select an audio stream for account 1.
May 19, 2021 15:08:30.798 [0x80963f000] DEBUG - Selecting best audio stream for part ID 127316 (autoselect: 1 language: en)
May 19, 2021 15:08:30.798 [0x80963f000] DEBUG - We're going to try to auto-select a subtitle.
May 19, 2021 15:08:30.798 [0x80963f000] DEBUG - Audio Stream: 342595, Subtitle Stream: -1
May 19, 2021 15:08:30.801 [0x80963f000] DEBUG - There were 1 top-level paths for Love, Death & Robots.
May 19, 2021 15:08:30.801 [0x80963f000] VERBOSE - It took 0.8 sec to serialize a partial list with 14 elements (50 total).
May 19, 2021 15:08:30.803 [0x8074a4800] DEBUG - Completed: [192.168.1.106:58868] 200 GET /hubs/home/recentlyAdded?type=2&sectionID=1&contentDirectoryID=1&pinnedContentDirectoryID=2%2C1%2Cplaylists (19 live) TLS GZIP Page 0-13 465ms 7885 bytes (pipelined: 1)
May 19, 2021 15:08:30.824 [0x8074a3400] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
May 19, 2021 15:08:30.824 [0x8074a3400] VERBOSE - Auth: Came in with the master token, authorization succeeded.
May 19, 2021 15:08:30.825 [0x80963f000] DEBUG - Request: [127.0.0.1:49848 (Loopback)] GET /library/changestamp (19 live) GZIP Signed-in Token (Pow4Life181) / Accept => */* / Accept-Encoding => gzip / Host => 127.0.0.1:32400 / User-Agent => PlexMediaServer/1.23.1.4528-c0513eb4c / X-Plex-Internal-Request => 1 / X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
May 19, 2021 15:08:30.825 [0x80963f000] VERBOSE - It took 0.0 sec to serialize a list with 0 elements.
May 19, 2021 15:08:30.825 [0x8074a3400] DEBUG - Completed: [127.0.0.1:49848] 200 GET /library/changestamp (19 live) GZIP 0ms 499 bytes (pipelined: 2289)
May 19, 2021 15:08:30.830 [0x8074a4800] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
May 19, 2021 15:08:30.830 [0x8074a4800] VERBOSE - Auth: Came in with the master token, authorization succeeded.
May 19, 2021 15:08:30.830 [0x80963f000] DEBUG - Request: [127.0.0.1:49848 (Loopback)] PUT /library/metadata/70654/index (19 live) GZIP Signed-in Token (Pow4Life181) / Accept => */* / Accept-Encoding => gzip / Content-Length => 0 / Host => 127.0.0.1:32400 / User-Agent => PlexMediaServer/1.23.1.4528-c0513eb4c / X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
May 19, 2021 15:08:30.839 [0x80963f000] DEBUG - It took 7.812500 ms to retrieve 146 items.
May 19, 2021 15:08:30.840 [0x80963f000] DEBUG - LongRunningJobManager [BaseIndexFrameFile]: scheduling job for item 70654, 0 pending.
May 19, 2021 15:08:30.840 [0x80963f000] VERBOSE - It took 0.0 sec to serialize a list with 0 elements.
May 19, 2021 15:08:30.840 [0x8074a4800] DEBUG - Completed: [127.0.0.1:49848] 200 PUT /library/metadata/70654/index (19 live) GZIP 10ms 482 bytes (pipelined: 2290)
May 19, 2021 15:08:30.842 [0x810222900] DEBUG - BaseIndexFrameFileManager: building index (320x240) for parts for MetadataItem 70654 (Get Smart)
May 19, 2021 15:08:30.843 [0x8074a3400] VERBOSE - Auth: We found auth token (xxxxxxxxxxxxxxxxxxxx), enabling token-based authentication.
May 19, 2021 15:08:30.843 [0x8074a3400] VERBOSE - Auth: Came in with the master token, authorization succeeded.
May 19, 2021 15:08:30.843 [0x80963f000] DEBUG - Request: [127.0.0.1:49848 (Loopback)] GET /:/metadata/notify/changeItemState?librarySectionID=2&metadataItemID=70654&metadataType=1&state=1&parentID=-1&rootID=-1 (19 live) GZIP Signed-in Token (Pow4Life181) / Accept => */* / Accept-Encoding => gzip / Host => 127.0.0.1:32400 / User-Agent => PlexMediaServer/1.23.1.4528-c0513eb4c / X-Plex-Token => xxxxxxxxxxxxxxxxxxxx
May 19, 2021 15:08:30.843 [0x8074a3400] DEBUG - Completed: [127.0.0.1:49848] 200 GET /:/metadata/notify/changeItemState?librarySectionID=2&metadataItemID=70654&metadataType=1&state=1&parentID=-1&rootID=-1 (19 live) GZIP 0ms 195 bytes (pipelined: 2291)
May 19, 2021 15:08:30.843 [0x810222900] DEBUG - Activity: registered new activity 29884660-3b9e-458c-a708-20c1bf577342 - "Generating video preview thumbnails"
May 19, 2021 15:08:30.843 [0x810222900] DEBUG - [JobRunner] Job running: FFMPEG_EXTERNAL_LIBS='/usr/local/plexdata/Plex\ Media\ Server/Codecs/fa235d6-3858-freebsd-x86_64/' X_PLEX_TOKEN=xxxxxxxxxxxxxxxxxxxxL' '/usr/local/share/plexmediaserver/Plex Transcoder' '-codec:v' 'h264' '-skip_frame:v' 'nokey' '-i' '/usr/local/plexdata/Plex Media Server/media_mount/Movies/Get Smart (2008)/Get Smart(2008)[Bluray-1080p].mkv' '-threads' '0' '-nostats' '-q' '3' '-loglevel' 'quiet' '-filter_complex' '[0:V:0] fps=fps=0.500000:round=up,scale=w=320:h=240:force_original_aspect_ratio=decrease [out]' '-map' '[out]' '/usr/local/plexdata/Plex Media Server/Media/localhost/b/36485063e5be20c0be096485dbcb03159229bfe.bundle/Contents/Indexes/tmp/img-%06d.jpg' '-progressurl' 'http://127.0.0.1:32400/video/:/transcode/session/bif/29884660-3b9e-458c-a708-20c1bf577342/progress'
May 19, 2021 15:08:30.844 [0x810222900] DEBUG - [JobRunner] Jobs: Starting child process with pid 94726
May 19, 2021 15:08:30.844 [0x8074a4800] VERBOSE - Didn't receive a request from 127.0.0.1:49848: End of file
May 19, 2021 15:08:30.844 [0x8074a3400] VERBOSE - Didn't receive a request from 127.0.0.1:49869: End of file
May 19, 2021 15:08:30.844 [0x8074a4800] VERBOSE - Didn't receive a request from 127.0.0.1:49849: End of file

No idea why the changeItemState GET request returns a 200 for both snippets, right before it is supposed to Generate thumbnails, but then it just doesn’t.

TO ALL FOLLOWING HERE:

I wanted to come back and let you know Engineering fixed this yesterday.

Please look for it in an upcoming release of PMS.

2 Likes

Wow! Thank you @ChuckPa @Pow4Life181, and the Plex engineering team.

Thanks so much for the update @ChuckPa!

@ChuckPa - Is this the fix?

(Jobs) The server could get into a state where it no longer processed media index files until the next restart (#12698)

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