Server Version#: 1.23.5.4862
Hi guys, i noticed that my plex server keep doing always the same thing after a library scan.
Sometimes this happens when the library scan get stuck while scanning the latest directory, while in other cases it happens after the library scan is completed.
It continues to starting and killing new processes. I also noticed that sometimes after a library scan any media doesn’t play anymore and i get a generic “Playback error” until i restart the server.
Here below there’s a portion of the log, the pattern is always the same, it creates a child, does something with FFMPEG (i think), removes an itee and then kills the job.
Jul 24, 2021 11:15:54.365 [0xb21f7d48] Debug — [JobRunner] Jobs: Starting child process with pid 6364
Jul 24, 2021 11:15:54.728 [0xb22aad48] Debug — Request: [127.0.0.1:51600 (Loopback)] GET /library/changestamp (13 live) GZIP Signed-in Token (alecaputo13)
Jul 24, 2021 11:15:54.730 [0xb2445d48] Debug — Completed: [127.0.0.1:51600] 200 GET /library/changestamp (13 live) GZIP 1ms 498 bytes (pipelined: 3)
Jul 24, 2021 11:15:54.749 [0xb3a67d48] Debug — Jobs: '/usr/lib/plexmediaserver/Plex Media Scanner' exit code for process 6358 is 0 (success)
Jul 24, 2021 11:15:54.749 [0xb2102d48] Debug — Killing job.
Jul 24, 2021 11:15:54.749 [0xb2102d48] Debug — Signalling job ID 6358 with 9
Jul 24, 2021 11:15:54.750 [0xb2102d48] Debug — Media Analyzer: Background analysis completed in 4.4 seconds, removing 1 IDs
Jul 24, 2021 11:15:54.750 [0xb2102d48] Debug — Media Analyzer: Performing on-the-fly analysis on 1 item.
Jul 24, 2021 11:15:54.750 [0xb2102d48] Debug — [JobRunner] Job running: FFMPEG_EXTERNAL_LIBS='/var/lib/plexmediaserver/Library/Application\ Support/Plex\ Media\ Server/Codecs/fa235d6-3858-linux-armv7neon/' X_PLEX_TOKEN='xxxxxxxxxxxxxxxxxxxx' '/usr/lib/plexmediaserver/Plex Media Scanner' '--analyze' '--log-file-suffix' ' Analysis' '--no-thumbs' '--item' '62840'
Jul 24, 2021 11:15:54.750 [0xb2102d48] Debug — [JobRunner] Jobs: Starting child process with pid 6368
Jul 24, 2021 11:16:02.355 [0xb22aad48] Debug — Request: [127.0.0.1:51616 (Loopback)] GET /:/metadata/notify/changeItemState?librarySectionID=7&metadataItemID=62840&metadataType=1&state=-1&parentID=-1&rootID=-1&mediaState=analyzing (13 live) GZIP Signed-in Token (alecaputo13)
Jul 24, 2021 11:16:02.358 [0xb2445d48] Debug — Completed: [127.0.0.1:51616] 200 GET /:/metadata/notify/changeItemState?librarySectionID=7&metadataItemID=62840&metadataType=1&state=-1&parentID=-1&rootID=-1&mediaState=analyzing (13 live) GZIP 5ms 195 bytes (pipelined: 1)
Jul 24, 2021 11:16:02.361 [0xb3352d48] Debug — Request: [127.0.0.1:51616 (Loopback)] GET /:/metadata/notify/changeItemState?librarySectionID=7&metadataItemID=62840&metadataType=1&state=-1&parentID=-1&rootID=-1&mediaState=idle (13 live) GZIP Signed-in Token (alecaputo13)
Jul 24, 2021 11:16:02.363 [0xb2445d48] Debug — Completed: [127.0.0.1:51616] 200 GET /:/metadata/notify/changeItemState?librarySectionID=7&metadataItemID=62840&metadataType=1&state=-1&parentID=-1&rootID=-1&mediaState=idle (13 live) GZIP 1ms 195 bytes (pipelined: 2)
Jul 24, 2021 11:16:06.337 [0xb22aad48] Debug — Request: [127.0.0.1:51616 (Loopback)] GET /library/changestamp (8 live) GZIP Signed-in Token (alecaputo13)
Jul 24, 2021 11:16:06.338 [0xb2468d48] Debug — Completed: [127.0.0.1:51616] 200 GET /library/changestamp (8 live) GZIP 1ms 497 bytes (pipelined: 3)
Jul 24, 2021 11:16:06.354 [0xb3a67d48] Debug — Jobs: '/usr/lib/plexmediaserver/Plex Media Scanner' exit code for process 6368 is 0 (success)
Jul 24, 2021 11:16:06.354 [0xb2102d48] Debug — Killing job.
Jul 24, 2021 11:16:06.354 [0xb2102d48] Debug — Signalling job ID 6368 with 9
Jul 24, 2021 11:16:06.355 [0xb2102d48] Debug — Media Analyzer: Background analysis completed in 11.6 seconds, removing 1 IDs
Jul 24, 2021 11:16:06.355 [0xb2102d48] Debug — Media Analyzer: Performing on-the-fly analysis on 1 item.
Jul 24, 2021 11:16:06.355 [0xb2102d48] Debug — [JobRunner] Job running: FFMPEG_EXTERNAL_LIBS='/var/lib/plexmediaserver/Library/Application\ Support/Plex\ Media\ Server/Codecs/fa235d6-3858-linux-armv7neon/' X_PLEX_TOKEN='xxxxxxxxxxxxxxxxxxxx' '/usr/lib/plexmediaserver/Plex Media Scanner' '--analyze' '--log-file-suffix' ' Analysis' '--no-thumbs' '--item' '31193'
Jul 24, 2021 11:16:06.355 [0xb2102d48] Debug — [JobRunner] Jobs: Starting child process with pid 6378
Jul 24, 2021 11:16:07.330 [0xb22aad48] Debug — Request: [127.0.0.1:51638 (Loopback)] GET /:/metadata/notify/changeItemState?librarySectionID=7&metadataItemID=62029&metadataType=1&state=-1&parentID=-1&rootID=-1&mediaState=analyzing (8 live) GZIP Signed-in Token (alecaputo13)
Jul 24, 2021 11:16:07.332 [0xb2445d48] Debug — Completed: [127.0.0.1:51638] 200 GET /:/metadata/notify/changeItemState?librarySectionID=7&metadataItemID=62029&metadataType=1&state=-1&parentID=-1&rootID=-1&mediaState=analyzing (8 live) GZIP 1ms 195 bytes (pipelined: 1)
Jul 24, 2021 11:16:07.337 [0xb3352d48] Debug — Request: [127.0.0.1:51638 (Loopback)] GET /:/metadata/notify/changeItemState?librarySectionID=7&metadataItemID=62029&metadataType=1&state=-1&parentID=-1&rootID=-1&mediaState=idle (8 live) GZIP Signed-in Token (alecaputo13)
Jul 24, 2021 11:16:07.337 [0xb2445d48] Debug — Completed: [127.0.0.1:51638] 200 GET /:/metadata/notify/changeItemState?librarySectionID=7&metadataItemID=62029&metadataType=1&state=-1&parentID=-1&rootID=-1&mediaState=idle (8 live) GZIP 0ms 195 bytes (pipelined: 2)
Jul 24, 2021 11:16:11.054 [0xb22aad48] Debug — Request: [127.0.0.1:51650 (Loopback)] GET /:/metadata/notify/changeItemState?librarySectionID=7&metadataItemID=31193&metadataType=1&state=-1&parentID=-1&rootID=-1&mediaState=analyzing (9 live) GZIP Signed-in Token (alecaputo13)
Jul 24, 2021 11:16:11.054 [0xb2468d48] Debug — Completed: [127.0.0.1:51650] 200 GET /:/metadata/notify/changeItemState?librarySectionID=7&metadataItemID=31193&metadataType=1&state=-1&parentID=-1&rootID=-1&mediaState=analyzing (9 live) GZIP 1ms 195 bytes (pipelined: 1)
Jul 24, 2021 11:16:11.058 [0xb3352d48] Debug — Request: [127.0.0.1:51650 (Loopback)] GET /:/metadata/notify/changeItemState?librarySectionID=7&metadataItemID=31193&metadataType=1&state=-1&parentID=-1&rootID=-1&mediaState=idle (9 live) GZIP Signed-in Token (alecaputo13)
Jul 24, 2021 11:16:11.060 [0xb2445d48] Debug — Completed: [127.0.0.1:51650] 200 GET /:/metadata/notify/changeItemState?librarySectionID=7&metadataItemID=31193&metadataType=1&state=-1&parentID=-1&rootID=-1&mediaState=idle (9 live) GZIP 3ms 195 bytes (pipelined: 2)
Jul 24, 2021 11:16:11.462 [0xb22aad48] Debug — Request: [127.0.0.1:51650 (Loopback)] GET /library/changestamp (9 live) GZIP Signed-in Token (alecaputo13)
Jul 24, 2021 11:16:11.463 [0xb2468d48] Debug — Completed: [127.0.0.1:51650] 200 GET /library/changestamp (9 live) GZIP 1ms 498 bytes (pipelined: 3)
Jul 24, 2021 11:16:11.478 [0xb3a67d48] Debug — Jobs: '/usr/lib/plexmediaserver/Plex Media Scanner' exit code for process 6378 is 0 (success)
Jul 24, 2021 11:16:11.478 [0xb2102d48] Debug — Killing job.
Jul 24, 2021 11:16:11.478 [0xb2102d48] Debug — Signalling job ID 6378 with 9
Jul 24, 2021 11:16:11.479 [0xb2102d48] Debug — Media Analyzer: Background analysis completed in 5.1 seconds, removing 1 IDs
Jul 24, 2021 11:16:11.479 [0xb2102d48] Debug — Media Analyzer: Performing on-the-fly analysis on 1 item.
Jul 24, 2021 11:16:11.479 [0xb2102d48] Debug — [JobRunner] Job running: FFMPEG_EXTERNAL_LIBS='/var/lib/plexmediaserver/Library/Application\ Support/Plex\ Media\ Server/Codecs/fa235d6-3858-linux-armv7neon/' X_PLEX_TOKEN='xxxxxxxxxxxxxxxxxxxx' '/usr/lib/plexmediaserver/Plex Media Scanner' '--analyze' '--log-file-suffix' ' Analysis' '--no-thumbs' '--item' '19986'
Jul 24, 2021 11:16:11.480 [0xb2102d48] Debug — [JobRunner] Jobs: Starting child process with pid 6384
