Welche Dateien sind für einen Plex Transkoder Absturz verantwortlich?

The World is Flat Deutsch - German
1

Hallo,

auf einem PMS gibt es seit vielen Monden Abstürze des Plex Transcoders. Wahrscheinlich bei der Loudness-Analyse einiger Dateien.

Jetzt gibt es wohl seit neustem endlich entsprechende Logfiles für die Dumps, denen ich mich heute mal widmen wollte, doch wie finde ich heraus, welche Dateien nun hinter den Abstürzen stehen?

Auszug aus:
12cbb0ee-d9fe-4fac-0205b990-9842990f.dmp.log:

Jun 17, 2023 07:29:12.487 [23315292437248] INFO - Plex Media Scanner v1.32.3.7192-7aa441827 - Docker Docker Container x86_64 - build: linux-x86_64 - GMT 02:00
Jun 17, 2023 07:29:12.487 [23315292437248] INFO - Linux version: 6.1.33-Unraid, language: en-US
Jun 17, 2023 07:29:12.487 [23315292437248] INFO - Processor: 16-core Intel(R) Xeon(R) CPU           E5620  @ 2.40GHz
Jun 17, 2023 07:29:12.487 [23315292437248] INFO - /usr/lib/plexmediaserver/Plex Media Scanner --analyze-loudness --item 352442 --force --log-file-suffix  Deep Analysis
Jun 17, 2023 07:29:12.784 [23315230935808] WARN - [FFMPEG] - Estimating duration from bitrate, this may be inaccurate
Jun 17, 2023 07:29:12.787 [23315230792448] WARN - [FFMPEG] - Estimating duration from bitrate, this may be inaccurate
Jun 17, 2023 07:29:12.791 [23315230505728] WARN - [FFMPEG] - Estimating duration from bitrate, this may be inaccurate
Jun 17, 2023 07:29:12.796 [23315230505728] ERROR - [FFMPEG] - Header missing
Jun 17, 2023 07:29:12.796 [23315230505728] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 17, 2023 07:29:12.796 [23315230505728] INFO - [FFMPEG] - overread, skip -5 enddists: -2 -2
Jun 17, 2023 07:29:12.796 [23315230505728] ERROR - [FFMPEG] - Header missing
Jun 17, 2023 07:29:12.796 [23315230505728] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 17, 2023 07:29:12.796 [23315230505728] INFO - [FFMPEG] - overread, skip -8 enddists: -6 -6
Jun 17, 2023 07:29:12.797 [23315230649088] WARN - [FFMPEG] - Estimating duration from bitrate, this may be inaccurate
Jun 17, 2023 07:29:12.802 [23315231079168] WARN - [FFMPEG] - Estimating duration from bitrate, this may be inaccurate
Jun 17, 2023 07:29:12.836 [23315230505728] ERROR - [FFMPEG] - Header missing
Jun 17, 2023 07:29:12.836 [23315230505728] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 17, 2023 07:29:12.836 [23315230505728] ERROR - [FFMPEG] - Header missing
Jun 17, 2023 07:29:12.836 [23315230505728] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 17, 2023 07:29:12.836 [23315230505728] ERROR - [FFMPEG] - Header missing
Jun 17, 2023 07:29:12.836 [23315230505728] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 17, 2023 07:29:12.836 [23315230505728] ERROR - [FFMPEG] - Header missing
Jun 17, 2023 07:29:12.836 [23315230505728] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 17, 2023 07:29:12.836 [23315230505728] ERROR - [FFMPEG] - Header missing
Jun 17, 2023 07:29:12.836 [23315230505728] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 17, 2023 07:29:12.836 [23315230505728] ERROR - [FFMPEG] - Header missing
Jun 17, 2023 07:29:12.836 [23315230505728] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 17, 2023 07:29:12.899 [23315230219008] WARN - [FFMPEG] - Estimating duration from bitrate, this may be inaccurate
Jun 17, 2023 07:29:12.903 [23315230219008] ERROR - [FFMPEG] - Header missing
Jun 17, 2023 07:29:12.903 [23315230219008] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 17, 2023 07:29:12.903 [23315230219008] INFO - [FFMPEG] - overread, skip -10 enddists: -1 -1
Jun 17, 2023 07:29:12.903 [23315230219008] INFO - [FFMPEG] - overread, skip -9 enddists: -7 -7
Jun 17, 2023 07:29:12.903 [23315230219008] ERROR - [FFMPEG] - Header missing
Jun 17, 2023 07:29:12.903 [23315230219008] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 17, 2023 07:29:12.903 [23315230219008] INFO - [FFMPEG] - overread, skip -5 enddists: -3 -3
Jun 17, 2023 07:29:12.903 [23315230219008] INFO - [FFMPEG] - overread, skip -7 enddists: -5 -5
Jun 17, 2023 07:29:12.932 [23315230219008] ERROR - [FFMPEG] - Header missing
Jun 17, 2023 07:29:12.932 [23315230219008] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 17, 2023 07:29:12.932 [23315230219008] INFO - [FFMPEG] - overread, skip -9 enddists: -7 -7
Jun 17, 2023 07:29:12.965 [23315230792448] ERROR - [FFMPEG] - Header missing
Jun 17, 2023 07:29:12.965 [23315230792448] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 17, 2023 07:29:12.997 [23315230792448] ERROR - [FFMPEG] - Header missing
Jun 17, 2023 07:29:12.997 [23315230792448] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 17, 2023 07:29:12.997 [23315230792448] INFO - [FFMPEG] - overread, skip -7 enddists: -5 -5
Jun 17, 2023 07:29:13.005 [23315230649088] ERROR - [FFMPEG] - Header missing
Jun 17, 2023 07:29:13.005 [23315230649088] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 17, 2023 07:29:13.005 [23315230649088] INFO - [FFMPEG] - overread, skip -7 enddists: -4 -4
Jun 17, 2023 07:29:13.005 [23315230649088] ERROR - [FFMPEG] - Header missing
Jun 17, 2023 07:29:13.005 [23315230649088] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 17, 2023 07:29:13.013 [23315230505728] ERROR - [FFMPEG] - Header missing
Jun 17, 2023 07:29:13.013 [23315230505728] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 17, 2023 07:29:13.013 [23315230505728] ERROR - [FFMPEG] - Header missing
Jun 17, 2023 07:29:13.013 [23315230505728] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 17, 2023 07:29:13.013 [23315230505728] INFO - [FFMPEG] - overread, skip -6 enddists: -5 -5
Jun 17, 2023 07:29:13.029 [23315230505728] ERROR - [FFMPEG] - Header missing
Jun 17, 2023 07:29:13.029 [23315230505728] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 17, 2023 07:29:13.029 [23315230505728] INFO - [FFMPEG] - overread, skip -6 enddists: -3 -3
Jun 17, 2023 07:29:13.043 [23315230649088] ERROR - [FFMPEG] - Header missing
Jun 17, 2023 07:29:13.043 [23315230649088] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 17, 2023 07:29:13.043 [23315230649088] ERROR - [FFMPEG] - Header missing
Jun 17, 2023 07:29:13.043 [23315230649088] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 17, 2023 07:29:13.043 [23315230649088] INFO - [FFMPEG] - overread, skip -7 enddists: -2 -2
Jun 17, 2023 07:29:13.043 [23315230649088] INFO - [FFMPEG] - overread, skip -5 enddists: -2 -2
Jun 17, 2023 07:29:13.044 [23315230649088] ERROR - [FFMPEG] - Header missing
Jun 17, 2023 07:29:13.044 [23315230649088] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 17, 2023 07:29:13.044 [23315230649088] INFO - [FFMPEG] - overread, skip -5 enddists: -3 -3
Jun 17, 2023 07:29:13.045 [23315230649088] ERROR - [FFMPEG] - Header missing
Jun 17, 2023 07:29:13.045 [23315230649088] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 17, 2023 07:29:13.045 [23315230649088] INFO - [FFMPEG] - overread, skip -9 enddists: -7 -7
Jun 17, 2023 07:29:13.057 [23315231079168] ERROR - [FFMPEG] - Header missing
Jun 17, 2023 07:29:13.057 [23315231079168] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 17, 2023 07:29:13.058 [23315231079168] ERROR - [FFMPEG] - Header missing
Jun 17, 2023 07:29:13.058 [23315231079168] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 17, 2023 07:29:13.058 [23315231079168] INFO - [FFMPEG] - overread, skip -6 enddists: -5 -5
Jun 17, 2023 07:29:13.059 [23315231079168] ERROR - [FFMPEG] - Header missing

Andere Log Datei 076a5fc1-f8f3-4c1b-5eb8abab-545db282.dmp.log:

Jun 19, 2023 13:40:35.107 [22430114253568] INFO - Plex Media Scanner v1.32.3.7192-7aa441827 - Docker Docker Container x86_64 - build: linux-x86_64 - GMT 02:00
Jun 19, 2023 13:40:35.108 [22430114253568] INFO - Linux version: 6.1.33-Unraid, language: en-US
Jun 19, 2023 13:40:35.108 [22430114253568] INFO - Processor: 16-core Intel(R) Xeon(R) CPU           E5620  @ 2.40GHz
Jun 19, 2023 13:40:35.108 [22430114253568] INFO - /usr/lib/plexmediaserver/Plex Media Scanner --analyze-loudness --item 1596767 --force --log-file-suffix  Deep Analysis
Jun 19, 2023 13:40:35.400 [22430053006080] WARN - [FFMPEG] - Estimating duration from bitrate, this may be inaccurate
Jun 19, 2023 13:40:35.413 [22430052289280] WARN - [FFMPEG] - Estimating duration from bitrate, this may be inaccurate
Jun 19, 2023 13:40:35.424 [22430052432640] WARN - [FFMPEG] - Estimating duration from bitrate, this may be inaccurate
Jun 19, 2023 13:40:35.433 [22430052862720] WARN - [FFMPEG] - Estimating duration from bitrate, this may be inaccurate
Jun 19, 2023 13:40:35.440 [22430052145920] WARN - [FFMPEG] - Estimating duration from bitrate, this may be inaccurate
Jun 19, 2023 13:40:35.442 [22430052002560] WARN - [FFMPEG] - Estimating duration from bitrate, this may be inaccurate
Jun 19, 2023 13:40:35.452 [22430052719360] WARN - [FFMPEG] - Estimating duration from bitrate, this may be inaccurate
Jun 19, 2023 13:40:35.483 [22430052576000] WARN - [FFMPEG] - Estimating duration from bitrate, this may be inaccurate
Jun 19, 2023 13:40:37.747 [22430052432640] WARN - [FFMPEG] - Estimating duration from bitrate, this may be inaccurate
Jun 19, 2023 13:40:37.891 [22430052862720] WARN - [FFMPEG] - Estimating duration from bitrate, this may be inaccurate
Jun 19, 2023 13:40:37.932 [22430052289280] WARN - [FFMPEG] - Estimating duration from bitrate, this may be inaccurate
Jun 19, 2023 13:40:37.933 [22430052145920] WARN - [FFMPEG] - Estimating duration from bitrate, this may be inaccurate
Jun 19, 2023 13:40:38.049 [22430053006080] WARN - [FFMPEG] - Estimating duration from bitrate, this may be inaccurate
Jun 19, 2023 13:40:38.245 [22430052002560] WARN - [FFMPEG] - Estimating duration from bitrate, this may be inaccurate
Jun 19, 2023 13:40:38.278 [22430052576000] WARN - [FFMPEG] - Estimating duration from bitrate, this may be inaccurate
Jun 19, 2023 13:40:38.873 [22430052719360] INFO - [FFMPEG] - Skipping 599 bytes of junk at 138181.
Jun 19, 2023 13:40:38.875 [22430052719360] WARN - [FFMPEG] - Estimating duration from bitrate, this may be inaccurate
Jun 19, 2023 13:40:40.040 [22430052862720] WARN - [FFMPEG] - Estimating duration from bitrate, this may be inaccurate
Jun 19, 2023 13:40:40.254 [22430052145920] WARN - [FFMPEG] - Estimating duration from bitrate, this may be inaccurate
Jun 19, 2023 13:40:40.508 [22430052289280] WARN - [FFMPEG] - Estimating duration from bitrate, this may be inaccurate
Jun 19, 2023 13:40:40.601 [22430053006080] WARN - [FFMPEG] - Estimating duration from bitrate, this may be inaccurate
Jun 19, 2023 13:40:40.821 [22430052002560] WARN - [FFMPEG] - Estimating duration from bitrate, this may be inaccurate
Jun 19, 2023 13:40:41.067 [22430052432640] WARN - [FFMPEG] - Estimating duration from bitrate, this may be inaccurate
Jun 19, 2023 13:40:41.258 [22430052719360] WARN - [FFMPEG] - Estimating duration from bitrate, this may be inaccurate
Jun 19, 2023 13:40:41.266 [22430052576000] WARN - [FFMPEG] - Estimating duration from bitrate, this may be inaccurate
Jun 19, 2023 13:40:41.429 [22430052002560] INFO - [FFMPEG] - overread, skip -7 enddists: -2 -2
Jun 19, 2023 13:40:41.958 [22430052862720] ERROR - [FFMPEG] - Header missing
Jun 19, 2023 13:40:41.958 [22430052862720] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 19, 2023 13:40:41.958 [22430052862720] INFO - [FFMPEG] - overread, skip -7 enddists: -5 -5
Jun 19, 2023 13:40:42.177 [22430052862720] ERROR - [FFMPEG] - Header missing
Jun 19, 2023 13:40:42.177 [22430052862720] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 19, 2023 13:40:42.177 [22430052862720] INFO - [FFMPEG] - overread, skip -9 enddists: -8 -8
Jun 19, 2023 13:40:42.353 [22430052862720] ERROR - [FFMPEG] - Header missing
Jun 19, 2023 13:40:42.353 [22430052862720] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 19, 2023 13:40:42.356 [22430052862720] ERROR - [FFMPEG] - Header missing
Jun 19, 2023 13:40:42.356 [22430052862720] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 19, 2023 13:40:42.358 [22430052862720] ERROR - [FFMPEG] - Header missing
Jun 19, 2023 13:40:42.358 [22430052862720] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 19, 2023 13:40:42.358 [22430052862720] INFO - [FFMPEG] - overread, skip -7 enddists: -6 -6
Jun 19, 2023 13:40:42.359 [22430052862720] ERROR - [FFMPEG] - Header missing
Jun 19, 2023 13:40:42.359 [22430052862720] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 19, 2023 13:40:42.359 [22430052862720] INFO - [FFMPEG] - overread, skip -8 enddists: -2 -2
Jun 19, 2023 13:40:42.359 [22430052862720] ERROR - [FFMPEG] - Header missing
Jun 19, 2023 13:40:42.359 [22430052862720] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 19, 2023 13:40:42.363 [22430052862720] ERROR - [FFMPEG] - Header missing
Jun 19, 2023 13:40:42.363 [22430052862720] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 19, 2023 13:40:42.365 [22430052862720] ERROR - [FFMPEG] - Header missing
Jun 19, 2023 13:40:42.365 [22430052862720] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 19, 2023 13:40:42.366 [22430052862720] ERROR - [FFMPEG] - Header missing
Jun 19, 2023 13:40:42.366 [22430052862720] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 19, 2023 13:40:42.367 [22430052862720] ERROR - [FFMPEG] - Header missing
Jun 19, 2023 13:40:42.367 [22430052862720] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 19, 2023 13:40:42.368 [22430052862720] ERROR - [FFMPEG] - Header missing
Jun 19, 2023 13:40:42.368 [22430052862720] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 19, 2023 13:40:42.369 [22430052862720] ERROR - [FFMPEG] - Header missing
Jun 19, 2023 13:40:42.369 [22430052862720] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 19, 2023 13:40:42.370 [22430052862720] ERROR - [FFMPEG] - Header missing
Jun 19, 2023 13:40:42.370 [22430052862720] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 19, 2023 13:40:42.371 [22430052862720] ERROR - [FFMPEG] - Header missing
Jun 19, 2023 13:40:42.371 [22430052862720] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 19, 2023 13:40:42.371 [22430052862720] INFO - [FFMPEG] - overread, skip -9 enddists: -7 -7
Jun 19, 2023 13:40:42.377 [22430052862720] ERROR - [FFMPEG] - Header missing
Jun 19, 2023 13:40:42.377 [22430052862720] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 19, 2023 13:40:42.377 [22430052862720] ERROR - [FFMPEG] - Header missing
Jun 19, 2023 13:40:42.377 [22430052862720] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 19, 2023 13:40:42.379 [22430052862720] ERROR - [FFMPEG] - Header missing
Jun 19, 2023 13:40:42.379 [22430052862720] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 19, 2023 13:40:42.380 [22430052862720] ERROR - [FFMPEG] - Header missing
Jun 19, 2023 13:40:42.380 [22430052862720] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 19, 2023 13:40:42.384 [22430052862720] ERROR - [FFMPEG] - Header missing
Jun 19, 2023 13:40:42.384 [22430052862720] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 19, 2023 13:40:42.393 [22430052862720] ERROR - [FFMPEG] - Header missing
Jun 19, 2023 13:40:42.393 [22430052862720] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 19, 2023 13:40:42.406 [22430052862720] ERROR - [FFMPEG] - Header missing
Jun 19, 2023 13:40:42.406 [22430052862720] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 19, 2023 13:40:42.406 [22430052862720] ERROR - [FFMPEG] - Header missing
Jun 19, 2023 13:40:42.406 [22430052862720] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 19, 2023 13:40:42.406 [22430052862720] INFO - [FFMPEG] - overread, skip -8 enddists: -1 -1
Jun 19, 2023 13:40:42.407 [22430052862720] ERROR - [FFMPEG] - Header missing
2

Update erst mal den Server.

3

Der Server ist aktuell (Version 1.32.4.7195), das Logfile nicht.

4

Dann schaue in den generellen /tmp Ordner nach einem Absturz.
Dort solltest du WAV Versionen der aktuell analysierten Alben finden.

5

Ja, da sind Gigabyteweise Dateien, die “Track01.wav” heissen.

Ohne JEGLICHEN Hinweis darauf, was die Ausgangsdatei ist.

Ich möchte gerne wissen wie ich herausbekomme, welche Dateien für den Abstürz verantwortlich sind. Mir fehlt ein Verweis. Ich finde nichts.

6

Hör sie doch einfach mal an.
Der Ordnername enthält evtl. auch Hinweise.

7

Hehe, Du bist lustig.

Und wie soll ich herausfinden, wo auf dem Server diese Datei dann liegt um sie mal zu analysieren?

Der Ordnername enthält evtl. auch Hinweise.

Selbsverständlich nicht. Sonst hätte ich ja nicht geschrieben, das ich Hilfe benötige.

Ausserdem liegt die Datei ja innerhalb des PMS Docker-Containers, die muss ich da erstmal mühsahm rausziehen und das würde bedeuten, ich müsste ca. 500 Dateien einzeln anhören (wenn ich Glück hätte, gäbe es Header in den WAV Dateien anhand deren ich weitere vage Informationen bekommen könnte).

Das ist ein Ratespiel für das ich mich nicht angemeldet habe.

Es muss doch irgendwo eine Log Datei geben, die mir sagt, welche Datei nun den Dump verursacht hat.

Dazu sind Log Dateien doch da. Jedenfalls in der normalen Welt der Software. ;-D

8

Hi,

hab leider ein aehnliches problem, neuen Server aufgesetzt und Daten neu gescannt da bei mir die migration der Datenbank nur abstuerze am neuen Server verursacht hat.

Jetzt habe ich gesehn dass die taeglichen Tasks bei mir leider zu transkoder abstuerzen fuehren, und auch eine menge an daten analysiert werden sollen, aber das log mit folgendenden Eintraegen geflutet wird (sind zig tausende)

::

Jun 22, 2023 09:55:55.247 [140192056146744] ERROR - [Req#24fca/Transcode/aaa644ec-32b3-4b8b-9d63-9f5194e4cc06/ff66bdd7-db26-4f30-9a6c-c3bbb08b8c94] [mp3 @ 0x7fd69b93d5c0] Header missing
Jun 22, 2023 09:55:55.247 [140192101452600] ERROR - [Req#24fcb/Transcode/aaa644ec-32b3-4b8b-9d63-9f5194e4cc06/ff66bdd7-db26-4f30-9a6c-c3bbb08b8c94] Error while decoding stream #0:1: Invalid data found when processing input
Jun 22, 2023 09:55:55.247 [140192056146744] ERROR - [Req#24fcc/Transcode/aaa644ec-32b3-4b8b-9d63-9f5194e4cc06/ff66bdd7-db26-4f30-9a6c-c3bbb08b8c94] [mp3 @ 0x7fd69b93d5c0] Header missing
Jun 22, 2023 09:55:55.247 [140192101452600] ERROR - [Req#24fcd/Transcode/aaa644ec-32b3-4b8b-9d63-9f5194e4cc06/ff66bdd7-db26-4f30-9a6c-c3bbb08b8c94] Error while decoding stream #0:1: Invalid data found when processing input
Jun 22, 2023 09:55:55.247 [140192056146744] ERROR - [Req#24fce/Transcode/aaa644ec-32b3-4b8b-9d63-9f5194e4cc06/ff66bdd7-db26-4f30-9a6c-c3bbb08b8c94] [mp3 @ 0x7fd69b93d5c0] Header missing
Jun 22, 2023 09:55:55.248 [140192101452600] ERROR - [Req#24fcf/Transcode/aaa644ec-32b3-4b8b-9d63-9f5194e4cc06/ff66bdd7-db26-4f30-9a6c-c3bbb08b8c94] Error while decoding stream #0:1: Invalid data found when processing input
Jun 22, 2023 09:55:55.248 [140192056146744] ERROR - [Req#24fd0/Transcode/aaa644ec-32b3-4b8b-9d63-9f5194e4cc06/ff66bdd7-db26-4f30-9a6c-c3bbb08b8c94] [mp3 @ 0x7fd69b93d5c0] Header missing
Jun 22, 2023 09:55:55.248 [140192101452600] ERROR - [Req#24fd1/Transcode/aaa644ec-32b3-4b8b-9d63-9f5194e4cc06/ff66bdd7-db26-4f30-9a6c-c3bbb08b8c94] Error while decoding stream #0:1: Invalid data found when processing input
Jun 22, 2023 09:55:55.248 [140192056146744] ERROR - [Req#24fd2/Transcode/aaa644ec-32b3-4b8b-9d63-9f5194e4cc06/ff66bdd7-db26-4f30-9a6c-c3bbb08b8c94] [mp3 @ 0x7fd69b93d5c0] Header missing
Jun 22, 2023 09:55:55.248 [140192101452600] ERROR - [Req#24fd3/Transcode/aaa644ec-32b3-4b8b-9d63-9f5194e4cc06/ff66bdd7-db26-4f30-9a6c-c3bbb08b8c94] Error while decoding stream #0:1: Invalid data found when processing input

wobei im syslog auch immer wieder dir crashes des media scanners verzeichnet werden:

Jun 22 09:46:26 plex Plex Media Server[13217]: ****** PLEX MEDIA SCANNER CRASHED, CRASH REPORT WRITTEN: /var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Crash Reports/1.32.4.7195-7c8f9d3b6/PLEX MEDIA SCANNER/fb07c643-f815-438a-c03714bd-606158b3.dmp
Jun 22 09:46:26 plex kernel: [ 7617.375124] PMS LoudnessCmd[13221]: segfault at 0 ip 00007f6331a10060 sp 00007f632de410d8 error 4 in libswresample.so.4[7f6331a08000+18000]
Jun 22 09:46:26 plex kernel: [ 7617.375135] Code: 01 cf 4c 39 c7 72 e3 c3 cc cc 8d 04 49 48 98 4d 89 c1 49 29 c1 48 63 c2 48 63 c9 49 39 f9 76 75 f2 0f 10 05 22 05 ff ff 66 90 <0f> bf 16 0f 57 c9 f2 0f 2a ca f2 0f 59 c8 f2 0f 11 0f 0f bf 14 06
Jun 22 09:46:30 plex Plex Media Server[13240]: ****** PLEX MEDIA SCANNER CRASHED, CRASH REPORT WRITTEN: /var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Crash Reports/1.32.4.7195-7c8f9d3b6/PLEX MEDIA SCANNER/99d11d26-c266-4287-198347b0-8f936d92.dmp
Jun 22 09:46:30 plex kernel: [ 7621.503837] PMS LoudnessCmd[13247]: segfault at 0 ip 00007fc8572d5060 sp 00007fc85369d0d8 error 4 in libswresample.so.4[7fc8572cd000+18000]
Jun 22 09:46:30 plex kernel: [ 7621.503844] Code: 01 cf 4c 39 c7 72 e3 c3 cc cc 8d 04 49 48 98 4d 89 c1 49 29 c1 48 63 c2 48 63 c9 49 39 f9 76 75 f2 0f 10 05 22 05 ff ff 66 90 <0f> bf 16 0f 57 c9 f2 0f 2a ca f2 0f 59 c8 f2 0f 11 0f 0f bf 14 06
Jun 22 10:17:01 plex CRON[17707]: (root) CMD (   cd / && run-parts --report /etc/cron.hourly)
Jun 22 11:06:34 plex Plex Media Server[17958]: ****** PLEX MEDIA SCANNER CRASHED, CRASH REPORT WRITTEN: /var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Crash Reports/1.32.4.7195-7c8f9d3b6/PLEX MEDIA SCANNER/185c1e4e-ef02-4d08-26dbaaad-f70712e4.dmp
Jun 22 11:06:34 plex kernel: [12425.384536] PMS LoudnessCmd[17962]: segfault at 0 ip 00007f9eab91f060 sp 00007f9ea7d590d8 error 4 in libswresample.so.4[7f9eab917000+18000]
Jun 22 11:06:34 plex kernel: [12425.384547] Code: 01 cf 4c 39 c7 72 e3 c3 cc cc 8d 04 49 48 98 4d 89 c1 49 29 c1 48 63 c2 48 63 c9 49 39 f9 76 75 f2 0f 10 05 22 05 ff ff 66 90 <0f> bf 16 0f 57 c9 f2 0f 2a ca f2 0f 59 c8 f2 0f 11 0f 0f bf 14 06
Jun 22 11:06:37 plex Plex Media Server[17981]: ****** PLEX MEDIA SCANNER CRASHED, CRASH REPORT WRITTEN: /var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Crash Reports/1.32.4.7195-7c8f9d3b6/PLEX MEDIA SCANNER/69361c88-cf5c-468f-7812168d-3bad1bdb.dmp
Jun 22 11:06:37 plex kernel: [12428.732406] PMS LoudnessCmd[17985]: segfault at 0 ip 00007fd1cc36d060 sp 00007fd1c87a70d8 error 4 in libswresample.so.4[7fd1cc365000+18000]
Jun 22 11:06:37 plex kernel: [12428.732413] Code: 01 cf 4c 39 c7 72 e3 c3 cc cc 8d 04 49 48 98 4d 89 c1 49 29 c1 48 63 c2 48 63 c9 49 39 f9 76 75 f2 0f 10 05 22 05 ff ff 66 90 <0f> bf 16 0f 57 c9 f2 0f 2a ca f2 0f 59 c8 f2 0f 11 0f 0f bf 14 06

Jemand eine idee wie man hier weiter vorgeht, da ich den eindruck habe, dass das bei jedem backgroundtask beginn immer wieder von vorne passiert …

LG,
Martin

9

Ja, das weitere Vorgehen wäre, die entsprechenden originalen Dateien unter die Lupe zu nehmen.
(Allerdings müsste man genau wissen, welche das nun sind. Hier erhoffe ich mir, das der Support mal bei den Entwicklern nachfragt, oder in seiner schlauen Fibel nachguckt, welche der vielen Logdateien zusammengehören und Queerverweise haben, so dass der geneigte User letztendlich die möglichen fehlerhaften Dateien beseitigen und aus der Analysier-Absturz-Schleife entfernen kann)

Ich persönlich würde die Analyse der gefundenen Dateien mit Foobar2000 (unter Windows) machen.
Dort gibt es eine Funktion “Verify Integrity” welche die Dateien auf Herz&Nieren prüft.
Funktioniert hier seit Jahren verlässlich, indem es z.B. die Header der Dateien und den Stream analysiert und Auskunft darüber gibt, was nicht in Ordnung ist.
Hat man dann Dateien gefunden, die Probleme machen könnten, kann man diese z.B. neu enkodieren oder den Header (z.B. bei VBR oder FLAC) neu schreiben lassen.
Wenn das nicht hilft und die Datei aussichtslos defekt ist: Löschen und/oder neu besorgen.
In seltenen Fällen kommt es auch z.B. vor, dass der Datentransfer auf den PMS die Daten korrumpiert hat und nur 0Byte oder abgeschnittene Dateien dort landeten. Dies kann auch zu den besagten Abstürzen führen.

Unter *nix würde ich wohl ffmpeg benutzen um die Dateien analysieren und ggf. reparieren zu lassen. Hier müsste ich aber erst wieder Dokumentationen lesen und Skripte schreiben, so das ich persönlich erst einmal den zeitsparenden Klick&Guck Weg einschlage.

Im einfachsten Fall, neu von der Quelle rippen oder vom jeweiligen Serviceanbieter/Dienst herunterladen.

Du könntest natürlich auch den von @OttoKerner vorgeschlagenen Weg probieren und die übriggebliebenen *.WAV Dateien analsysieren (Zb. auf vorhandene Header) doch soweit ich das schon dutzende Male gemacht habe, denn das ist ja die einzige Möglichkeit einen Schritt mit diesem Thema weiter zu kommen, wird einem damit nicht geholfen, da die Dateien (verständlicherweise) von all ihren Metadaten befreit werden, bevor sie vom Transkoder analysiert werden. Ist also (aber nur meiner Erfahrung nach) eine Sackgasse.

Was die Analyse der *.DMP Dateien angeht, habe ich keinerlei Erfahrungen, ob da irgendwo ein Pfad zur Ursprungsdatei stehen könnte, ich vermute allerdings nicht. Höchstens ein Pfad zur Datei, die zum Absturz führt, also die *.WAV Datei und die bringt uns ja nichts.

Der Vorschlag von @OttoKerner mittels reinlauschen die Datei auf dem Server zu identifizieren, ist, wenn es nur 3 wären und man nur 30 Alben auf dem Server hat, bestimmt ein schöner Zeitvertreib, aber sicherlich kein ernstgemeinter Lösungsansatz für Menschen, die viele 1.000 an Dateien haben.
Man stelle sich vor, man identifiziert (z.B. indem man eine der *.WAV Dateien Shazam vorspielt) den tollen Hit aus den 70ern, der auf 10 verschiedenen 70er Jahre Collections vorhanden ist… ja, viel Spaß ;-D

Mein Senf…

Ich freue mich, wenn ein Supporter nochmal nähere Auskünfte geben könnte, wie man an die besagten Ursprungsdateien kommt. Ob nun mit Logdateien oder sonst wie anders. Hauptsache es ist zu bewerkstelligen mit überschaubaren Aufwand.

EDIT:
Screenshot vom foobar2000 Kontextmenü, um z.B. mp3 Dateien anzugehen:

fb2k
fb2k719×695 64.9 KB

10

@FlexiPlexi danke fuer die ausfuherliche erklaerung der analyse, aber wie du schon gesagt hast hab ich keine Ahnung welche Dateien betroffen sind und es sind einfach viel zu viele um da auf verdacht wo reinzuhoeren und was sinnvolles dabei rauszukriegen.

Bei mir bleiben im temp ordner auch keine wave files zurueck. Ich habe hier mehr den eindruck dass die analyse queue gefuellt wird (mit ein paar tausend items) und dann durch den crash oder etwas anderem,alle items ab dem problem-item den fehler hervorrufen … ist aber nur mein eindruck soweit.

11

Inspiziere die server logs unmittelbar nach dem Absturz.
Schaue auf die Datei-Zeitstempel und die Zeitstempel innerhalb der Logs.

In vielen Fällen scheitern die diversen Analysen auch an Platzmangel im globalen /tmp Ordner, insbesondere wenn der Server in einer Art Container/VM/Jail ausgeführt wird. (nein, hier ist nicht der Transcoder-Temp Ordner gemeint)
Suche nach Alben mit besonders vielen Titeln. (Box Sets, Anthologien etc. ) Entferne diese vorübergehend aus der Mediathek und schaue dann ob das Problem immer noch auftritt.

12

Oder achte einfach ein halbes Jahr lang auf diese Anzeige:
jaja

Dann fallen dir Alben, die regelmäßig vorkommen auf.
Das sind dann diejenigen, die die Dateien enthalten, mit denen der Transkoder nicht klarkommt.

13

Platzmangel ist hier nicht der Fall. Die Abstürze kommen seit vielen Monden regelmäßig wiederkehrend, und es wurden schon diverse Umstrukturierungen bzgl. der /tmp Orte vorgenommen um das auszuschließen.
Die übriggebliebenen Ordner mit den *.WAV Dateien weisen mal 5, mal 150 Dateien auf. Und alles dazwischen. Keine Regelmäßigkeit in der Anzahl der Dateien zu entdecken.

Gut, ich hätte gerne eine genauere Aussage, aber die scheint es nicht geben zu können, da, nachdem ich wieder mal alle Logs durchforstet habe, nirgends ein (für mich identifizierbarer) Anhaltspunkt auf die Originaldateien zu finden ist.

Sagen wir, der Server wirft diese Meldung:
Jun 22 00:26:59 UnRaid kernel: PMS LoudnessCmd[6739]: segfault at 0 ip 000014b310e97060 sp 000014b30bc5c0d8 error 4 in libswresample.so.4[14b310e8f000+18000] likely >
(Nicht nur diese eine, sondern viele um diese Uhrzeit im 3 Stunden Radius herum)

Dann finde ich z.B. in Plex Crash Uploader.2.log:

Jun 21, 2023 23:59:07.271 [22417170860856] INFO - Crash Uploader - Platform: Linux ServerUUID: 1234 UserId: ich@woanders.de Version: 1.32.4.7195-7c8f9d3b6
Jun 21, 2023 23:59:07.271 [22417170860856] INFO - Pre-processed minidump directory: /config/Library/Application Support/Plex Media Server/Crash Reports/1.32.4.7195-7c8f9d3b6
Jun 21, 2023 23:59:07.272 [22417170860856] INFO - Post-processed minidump directory: /tmp
Jun 21, 2023 23:59:07.490 [22417178126344] INFO - Successfully reported crashdump 4f98fb8d-efae-44d9-d348d0b9-2d511a7c
Jun 21, 2023 23:59:07.491 [22417178126344] INFO - Crash Uploader - Processing Complete.

Den Verweis auf 4f98fb8d-efae-44d9-d348d0b9-2d511a7c.dmp.log (aus dem Ordner ..\Crash Reports\1.32.4.7195-7c8f9d3b6\PLEX MEDIA SCANNER\) welche den (hier stark gekürzten) Inhalt hat:

Jun 21, 2023 23:59:06.055 [23389900880640] INFO - Plex Media Scanner v1.32.4.7195-7c8f9d3b6 - Docker Docker Container x86_64 - build: linux-x86_64 - GMT 02:00
Jun 21, 2023 23:59:06.055 [23389900880640] INFO - Linux version: 6.1.34-Unraid, language: en-US
Jun 21, 2023 23:59:06.055 [23389900880640] INFO - Processor: 16-core Intel(R) Xeon(R) CPU           E5620  @ 2.40GHz
Jun 21, 2023 23:59:06.055 [23389900880640] INFO - /usr/lib/plexmediaserver/Plex Media Scanner --analyze-loudness --item 229169 --force --log-file-suffix  Deep Analysis
Jun 21, 2023 23:59:06.313 [23389839440640] INFO - [FFMPEG] - Skipping 417 bytes of junk at 65054.
Jun 21, 2023 23:59:06.316 [23389839440640] WARN - [FFMPEG] - Estimating duration from bitrate, this may be inaccurate
Jun 21, 2023 23:59:06.350 [23389839153920] ERROR - [FFMPEG] - Header missing
Jun 21, 2023 23:59:06.350 [23389839153920] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 21, 2023 23:59:06.350 [23389839153920] ERROR - [FFMPEG] - Header missing
Jun 21, 2023 23:59:06.350 [23389839153920] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 21, 2023 23:59:06.350 [23389839153920] INFO - [FFMPEG] - overread, skip -8 enddists: -3 -3
Jun 21, 2023 23:59:06.350 [23389839153920] INFO - [FFMPEG] - overread, skip -7 enddists: -6 -6
Jun 21, 2023 23:59:07.131 [23389839297280] ERROR - Analysis: Codec error 'Invalid data found when processing input'.
Jun 21, 2023 23:59:07.131 [23389839297280] ERROR - [FFMPEG] - Header missing
Jun 21, 2023 23:59:07.131 [23389839297280] ERROR - Analysis: Codec error 'Invalid data found when processing input'.

Im übrigend gibt es in der com.plexapp.system.log.1 einen Sprung um die besagten Urzeiten. Da wird also nichts mitprotokolliert.

...
2023-06-21 21:26:04,611 (14c046dd8b38) :  DEBUG (runtime:924) - Response: [200] str, 0 bytes
2023-06-21 21:26:52,558 (14c046dd8b38) :  DEBUG (runtime:717) - Handling request GET /system/notify/serverUpdated?host=192.168.178.241
2023-06-21 21:26:52,560 (14c046dd8b38) :  DEBUG (runtime:814) - Found route matching /system/notify/serverUpdated
2023-06-21 21:26:52,561 (14c046dd8b38) :  DEBUG (peerservice:386) - Handling server update notification (192.168.178.241)
2023-06-21 21:26:52,561 (14c046dd8b38) :  DEBUG (peerservice:189) - Updating servers (True/False True/True/True)
2023-06-21 21:26:52,561 (14c046dd8b38) :  DEBUG (peerservice:164) - Fetching the current list of servers
2023-06-21 21:26:52,562 (14c046dd8b38) :  DEBUG (networking:144) - Requesting 'http://127.0.0.1:32400/servers'
2023-06-21 21:26:52,566 (14c046dd8b38) :  DEBUG (peerservice:198) - Found 2 servers
2023-06-21 21:26:52,566 (14c046dd8b38) :  DEBUG (peerservice:214) - Ignoring dfac931bd445fb441c9002b52cd7ac1bb0685a90 because host != 192.168.178.241 (192.168.178.242)
2023-06-21 21:26:52,567 (14c046dd8b38) :  DEBUG (networking:144) - Requesting 'http://127.0.0.1:32400/library/sections'
2023-06-21 21:26:52,574 (14c046dd8b38) :  DEBUG (networking:144) - Requesting 'http://127.0.0.1:32400/channels/all'
2023-06-21 21:26:52,579 (14c046dd8b38) :  DEBUG (runtime:924) - Response: [200] str, 0 bytes
2023-06-23 02:40:33,012 (14c046dd8b38) :  DEBUG (runtime:717) - Handling request GET /system/agents/media/get?guid=mbid%3A%2F%2F07447912-f377-43bf-87d9-b10f074487f9&mediaType=9&url=metadata%3A%2F%2Fposters%2Fcom%2Eplexapp%2Eagents%2Elocalmedia_21890e043136866bdcd2a6424937eb821ddefa7a
2023-06-23 02:40:33,023 (14c046d87b38) :  DEBUG (runtime:717) - Handling request GET /system/agents/media/get?guid=mbid%3A%2F%2Ff1fd671f-70c8-4c3f-9625-92d8996149e6&mediaType=9&url=metadata%3A%2F%2Fposters%2Fcom%2Eplexapp%2Eagents%2Elocalmedia_0d79e95505cb286cd5f1072cce7bec4eb61df32e
2023-06-23 02:40:33,025 (14c046dd8b38) :  DEBUG (runtime:814) - Found route matching /system/agents/media/get
2023-06-23 02:40:33,026 (14c046d87b38) :  DEBUG (runtime:814) - Found route matching /system/agents/media/get
2023-06-23 02:40:33,028 (14c046dd8b38) :  DEBUG (accessor:68) - Creating a new read-only model access point for provider org.musicbrainz.agents.music in namespace 'metadata'
...

Und dann habe ich, wie von @OttoKerner erwähnt, noch die *.WAV Dateien, die ich jetzt auf das Erstellungsdatum hin überprüfen kann.

Also WANN wurden diese Dateien erstellt und passt das ungefähr mit den Zeitstempeln im Dump-Log zusammen.

Und was genau habe ich dann damit gewonnen?

Es fehlt mir immer noch die genaue Zuordnung, welches nun die entsprechenden Dateien in den vom PMS indizierten Ordnern sind.

Folgende KLARE Aussage täte hier ungemein weiterhelfen:

Name der Logdatei(en), die den Klarnamen oder eine ID enthalten, die mich zu der Urspungsdatei führen, welche den PMS zum Absturz bringt.

Welche Logdateien können mittels dieser ID verknüpft werden, um mich zu der Urspungsdatei führen?

Also ich werde das Logging mal auf VERBOSE stellen, evtl. ist dann mehr zu finden…

14

Und siehe da, schon stehen Pfade und Dateinamen im Log der Dumps.

Ich denke allerdings, soweit ich die Logs lese, reicht auch ein Debug, denn die entsprechenden Meldungen kommen im Debug-Level, nicht im Verbose.

Also, um meine eigene Frage zu beantworten:

Server-Logs auf DEBUG stellen:

Bildschirmfoto 2023-06-23 um 15.46.28
Bildschirmfoto 2023-06-23 um 15.46.281874×300 60.6 KB

Dann kann man in den *.DMP.LOG Dateien (Z.B diese aus dem Ordner ..\Library\Application Support\Plex Media Server\Crash Reports\1.32.4.7195-7c8f9d3b6\PLEX MEDIA SCANNER\) etwa folgendes lesen:

Jun 23, 2023 15:16:22.126 [23238770563904] VERBOSE - [FFMPEG] - Loading external lib /config/Library/Application Support/Plex Media Server/Codecs/8217c1c-4565-linux-x86_64/libwavpack_decoder.so
Jun 23, 2023 15:16:22.126 [23238770563904] DEBUG - Opening 20 database sessions to library (com.plexapp.plugins.library), SQLite 3.39.4, threadsafe=1
Jun 23, 2023 15:16:22.332 [23238674529024] DEBUG - [MI] Opening input file: "/mnt/user/bla/fasel/musikdatei1.mp3"
Jun 23, 2023 15:16:22.332 [23238674012928] DEBUG - [MI] Opening input file: "/mnt/user/bla/fasel/musikdatei2.mp3"
Jun 23, 2023 15:16:22.333 [23238674012928] DEBUG - [FFMPEG] - Opening '/mnt/user/bla/fasel/musikdatei3.mp3' for reading
Jun 23, 2023 15:16:22.333 [23238674529024] DEBUG - [FFMPEG] - Opening '/mnt/user/bla/fasel/musikdatei4.mp3' for reading

Da steht jetzt nirgends etwas von einem Absturz oder ähnlichem, ich denke allerdings, wenn die Datei *.DMP.LOG heisst, wird es sich um die den PMS zum Absturz bringenden Dateien handeln.

Jedenfalls kann ich nun Pfade und Dateien sammeln um diese dann in einigen Tagen/Wochen gesammelt zu analysieren und/oder aus dem PMS zu entfernen und gucken, ob die Abstürze noch so häufig auftreten…

Zumindestens also, bin ich nun einen guten Schritt vorangekommen und um es mit den Worten von Bart Simpson zu sagen: “Lieber Gott, wir danken Dir für gar nichts; wir haben alles selbst bezahlt!” ;-D

15

Der Screenshot zeigt aber Verbose Logging als aktiv.

16

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