Logs schreiben XML Inhalt mit?

Ich habe von meinem Provider eine Beschwerde erhalten, dass

im “php_error.log merkwürdigerweise ganze XML Elemente geloggt werden - das könnte ein Programmierfehler einer Applikation sein.”

Betroffen sind bei mir alle Podlove Installationen, zum Beispiel auf https://www.bienenpodcast.at

Das sieht dann so aus - wisst ihr da was darüber?

[16-Aug-2019 02:22:21 UTC] Intro – Inhaltsübersicht
[16-Aug-2019 02:22:21 UTC] Intro: Andreas Dabsch, Arzt
[16-Aug-2019 02:22:21 UTC] Apitherapie - was bedeutet Therapie? Immunstatus
[16-Aug-2019 02:22:21 UTC] Interesse an Forschung
[16-Aug-2019 02:22:21 UTC] Wundheilung
[16-Aug-2019 02:22:21 UTC] Makrobiotik - Lokales - Entdeckelungswachs
[16-Aug-2019 02:22:21 UTC] Hormone und Bienen
[16-Aug-2019 02:22:21 UTC] Waldforschung
[16-Aug-2019 02:22:21 UTC] Entzündung und Hexenschuss
[16-Aug-2019 02:22:21 UTC] Manuka Honig
[16-Aug-2019 02:22:21 UTC] Bienengift
[16-Aug-2019 02:22:21 UTC] Was darf man als Arzt?
[16-Aug-2019 02:22:21 UTC] Sterben, Sprechart, Gut & Böse
[16-Aug-2019 02:22:21 UTC] Zwischenbilanz
[16-Aug-2019 02:22:21 UTC] Gifte und Vergiftung
[16-Aug-2019 02:22:21 UTC] Wenn Imker/innen gestochen werden
[16-Aug-2019 02:22:21 UTC] An die Grenzen kommen
[16-Aug-2019 02:22:21 UTC] Fachartikel: Lithiumchlorid
[16-Aug-2019 02:22:21 UTC] Artikel: Abstract
[16-Aug-2019 02:22:21 UTC] Artikel: Einführung
[16-Aug-2019 02:22:21 UTC] Artikel: Results and Discussion
[16-Aug-2019 02:22:21 UTC] Artikel: Effektive Konzentration
[16-Aug-2019 02:22:21 UTC] Artikel: Dauer der Behandlung
[16-Aug-2019 02:22:21 UTC] Artikel: Genaue Dosis
[16-Aug-2019 02:22:21 UTC] Artikel: Auswirkung auf Bienen
[16-Aug-2019 02:22:21 UTC] Artikel: Kunstschwärme
[16-Aug-2019 02:22:21 UTC] Artikel: Andere Lithiumverbindungen
[16-Aug-2019 02:22:21 UTC] Artikel: Potenzial der Lithiumverbindungen als Varroazid
[16-Aug-2019 02:22:21 UTC] Fazit und Zusammenschau
[16-Aug-2019 02:22:21 UTC] Korrespondent: Jürgen Binder
[16-Aug-2019 02:22:21 UTC] Verabschiedung und Hinweis auf Stadtgespräch
[16-Aug-2019 02:22:21 UTC] <?xml version="1.0"?>
<psc:chapters xmlns:psc=“http://podlove.org/simple-chapters” version=“1.2”><psc:chapter start=“00:00:00.000” title=“Intro – Inhaltsübersicht”/><psc:chapter start=“00:01:44.188” title=“Intro: Andreas Dabsch, Arzt” href=“http://dabsch.at/praxis/dr-andreas-dabsch/”/><psc:chapter start=“00:04:22.172” title=“Apitherapie - was bedeutet Therapie? Immunstatus”/><psc:chapter start=“00:10:55.953” title=“Interesse an Forschung”/><psc:chapter start=“00:16:03.427” title=“Wundheilung”/><psc:chapter start=“00:20:07.967” title=“Makrobiotik - Lokales - Entdeckelungswachs”/><psc:chapter start=“00:26:40.823” title=“Hormone und Bienen”/><psc:chapter start=“00:30:09.701” title=“Waldforschung”/><psc:chapter start=“00:32:53.780” title=“Entzündung und Hexenschuss”/><psc:chapter start=“00:40:41.687” title=“Manuka Honig”/><psc:chapter start=“00:42:41.828” title=“Bienengift”/><psc:chapter start=“00:45:07.989” title=“Was darf man als Arzt?”/><psc:chapter start=“00:52:58.511” title=“Sterben, Sprechart, Gut & Böse”/><psc:chapter start=“01:07:22.222” title=“Zwischenbilanz”/><psc:chapter start=“01:12:49.834” title=“Gifte und Vergiftung”/><psc:chapter start=“01:28:06.400” title=“Wenn Imker/innen gestochen werden”/><psc:chapter start=“01:30:56.128” title=“An die Grenzen kommen”/><psc:chapter start=“01:40:59.867” title=“Fachartikel: Lithiumchlorid” href=“https://www.nature.com/articles/s41598-017-19137-5”/><psc:chapter start=“01:45:31.823” title=“Artikel: Abstract”/><psc:chapter start=“01:54:12.778” title=“Artikel: Einführung”/><psc:chapter start=“02:04:58.494” title=“Artikel: Results and Discussion”/><psc:chapter start=“02:10:39.981” title=“Artikel: Effektive Konzentration”/><psc:chapter start=“02:13:05.849” title=“Artikel: Dauer der Behandlung”/><psc:chapter start=“02:16:18.154” title=“Artikel: Genaue Dosis”/><psc:chapter start=“02:19:18.080” title=“Artikel: Auswirkung auf Bienen”/><psc:chapter start=“02:25:16.931” title=“Artikel: Kunstschwärme”/><psc:chapter start=“02:28:40.925” title=“Artikel: Andere Lithiumverbindungen”/><psc:chapter start=“02:34:28.356” title=“Artikel: Potenzial der Lithiumverbindungen als Varroazid”/><psc:chapter start=“02:41:48.984” title=“Fazit und Zusammenschau”/><psc:chapter start=“02:46:07.938” title=“Korrespondent: Jürgen Binder” href=“http://www.honigmanufaktur.com”/><psc:chapter start=“03:18:11.000” title=“Verabschiedung und Hinweis auf Stadtgespräch” href=“http://sg.sprechkontakt.at/sg012/”/></psc:chapters>

[16-Aug-2019 02:22:21 UTC] Begrüßung, Newsletter, Inhalt
[16-Aug-2019 02:22:21 UTC] Intro: Franz Essl
[16-Aug-2019 02:22:21 UTC] Neophyten
[16-Aug-2019 02:22:21 UTC] Forschung an Neophyten
[16-Aug-2019 02:22:21 UTC] Wo wachsen Neophyten
[16-Aug-2019 02:22:21 UTC] Kontext und Robinie
[16-Aug-2019 02:22:21 UTC] Richtiges oder angepasstes Verhalten
[16-Aug-2019 02:22:21 UTC] ÖKO-L- Artikel
[16-Aug-2019 02:22:21 UTC] Einfach nicht kümmern?
[16-Aug-2019 02:22:21 UTC] Neophyten für Imker
[16-Aug-2019 02:22:21 UTC] Douglasie
[16-Aug-2019 02:22:21 UTC] Späte Mahd ist ein Konflikt?
[16-Aug-2019 02:22:21 UTC] Wissenschaftliche Artikel - Auswanderung aus Europa
[16-Aug-2019 02:22:21 UTC] Hinweis: Zeitsprung / Hanse
[16-Aug-2019 02:22:21 UTC] Selbstbestäubung hilft Neophyten
[16-Aug-2019 02:22:21 UTC] Positionierung des Gesprächs
[16-Aug-2019 02:22:21 UTC] Korrespondent: Marl-Rainer Koch
[16-Aug-2019 02:22:21 UTC] Programm
[16-Aug-2019 02:22:21 UTC] Buch: Bruder Adam
[16-Aug-2019 02:22:21 UTC] Verabschiedung - Bring die Biene auf die Schiene
[16-Aug-2019 02:22:21 UTC] <?xml version="1.0"?>
<psc:chapters xmlns:psc=“http://podlove.org/simple-chapters” version=“1.2”><psc:chapter start=“00:00:00.000” title=“Begrüßung, Newsletter, Inhalt” href=“http://www.bienenpodcast.at”/><psc:chapter start=“00:01:45.129” title=“Intro: Franz Essl” href=“https://ufind.univie.ac.at/de/person.html?id=18824”/><psc:chapter start=“00:04:37.274” title=“Neophyten”/><psc:chapter start=“00:09:53.289” title=“Forschung an Neophyten”/><psc:chapter start=“00:19:39.232” title=“Wo wachsen Neophyten”/><psc:chapter start=“00:21:46.731” title=“Kontext und Robinie”/><psc:chapter start=“00:24:45.765” title=“Richtiges oder angepasstes Verhalten”/><psc:chapter start=“00:28:33.172” title=“ÖKO-L- Artikel” href=“https://www.linz.at/umwelt/4043.asp”/><psc:chapter start=“00:30:07.899” title=“Einfach nicht kümmern?”/><psc:chapter start=“00:43:09.814” title=“Neophyten für Imker”/><psc:chapter start=“00:47:00.401” title=“Douglasie”/><psc:chapter start=“00:51:44.996” title=“Späte Mahd ist ein Konflikt?”/><psc:chapter start=“00:53:46.541” title=“Wissenschaftliche Artikel - Auswanderung aus Europa” href=“https://www.researchgate.net/profile/Franz_Essl”/><psc:chapter start=“00:59:45.696” title=“Hinweis: Zeitsprung / Hanse” href=“https://www.zeitsprung.fm/podcast/zs115/”/><psc:chapter start=“01:02:55.588” title=“Selbstbestäubung hilft Neophyten”/><psc:chapter start=“01:06:59.998” title=“Positionierung des Gesprächs”/><psc:chapter start=“01:11:26.962” title=“Korrespondent: Marl-Rainer Koch” href=“http://beecome.org”/><psc:chapter start=“01:22:17.352” title=“Programm” href=“https://www.erwerbsimkerbund.at/agenda-beecome-23-25-2-2018+2500+1137775”/><psc:chapter start=“01:26:05.334” title=“Buch: Bruder Adam” href=“http://www.imkerei-technik.de/default.htm”/><psc:chapter start=“01:29:00.378” title=“Verabschiedung - Bring die Biene auf die Schiene” href=“http://www.bienenpodcast.at/bahnkarte-gesucht/”/></psc:chapters>

Das habe ich bei meiner Installation auch schon beobachtet, hat mich ziemlich irritiert. Habe auch schon ein wenig im Source gestochert, um die Ursache zu finden, aber erinnere mich leider nicht mehr genauer, was das Ergebnis war. Konnte aber zumindest keinen Grund finden, wieso das im Error-Log auftauchen sollte, hat mir aufgrund der Verbosity damals das Debuggen eines echten Fehlers durchaus ein wenig erschwert.

Merkwürdig, sieht aus als würden Kapitel einzeln und als PSC geloggt werden. Das habe ich bisher noch nicht gesehen, und finde spontan auch keine Erklärung im Code :thinking:

Hi @ericteubert, ich hab mir das in meinen Logs nochmal genauer angeschaut, tritt immer noch auf. Ich hab das error-Log (Standard-nginx auf Ubuntu mit PHP7.3) minimal reformatiert, damit es lesbarer ist. Zwischen den einzelnen Einträgen immer zwei leere Zeilen, und die ganzen "PHP message: "-Meldungen jeweils mit Umbruch versehen, im Log steht das eigentlich alles auf einer Zeile.

2019/08/18 22:26:05 [error] 1358#1358: *2328043 FastCGI sent in stderr: "start="00:09:42.790" title="News - American Pie 4"/><psc:chapter start="00:11:10.095" title="News - Scream 4"/><psc:chapter start="00:12:19.621" title="Film - Up In The Air"/><psc:chapter start="00:25:33.654" title="Serie - Seinfeld - Einf&#xFC;hrung"/><psc:chapter start="00:28:12.050" title="Serie - Seinfeld - Hauptcharaktere"/><psc:chapter start="00:44:40.771" title="Serie - Seinfeld - Nebencharaktere"/><psc:chapter start="00:47:35.439" title="Serie - Seinfeld - Story"/><psc:chapter start="00:51:36.777" title="Serie - Seinfeld - Lieblingsszenen"/><psc:chapter start="0...
PHP message: Start
PHP message: Trailer - Killers
PHP message: Trailer - The Last Airbender
PHP message: Trailer - Leaves Of Grass
PHP message: Trailer - Cop Out
PHP message: Trailer - Toy Story 3
PHP message: Trailer - Get Him To The Greek
PHP message: Superbowlspots
PHP message: News - Inception
PHP message: News - Captain Awemerica
PHP message: News - E! Online Voting
PHP message: News - 24-Kinofilm
PHP message: News - Sherlock Holmes + Lost Nachträge
PHP message: News - Deutsches Fernsehen ist toll
PHP message: News  - Metropolis
PHP message: News - HD-Werbung, endlich
PHP message: Film - Wall Street
PHP message: Film - Four Brothers
PHP message: Film - Dragnet
PHP message: Serie - Blue Mountain State
PHP message: Serie - SNL
PHP message: Feedback
PHP message: Intern: "Watch this! of the week"
PHP message: Outtakes
PHP message: <?xml version="1.0"?>
<psc:chapters xmlns:psc="http://podlove.org/simple-chapters" version="1.2"><psc:chapter start="00:00:00.000" title="Start"/><psc:chapter start="00:00:52.041" title="Trailer - Killers"/><psc:chapter start="00:02:06.999" title="Trailer - The Last Airbender"/><psc:chapter start="00:04:06.784" title="Trailer - Leaves Of Grass"/><psc:chapter start="00:05:25.055" title="Trailer - Cop Out"/><psc:chapter start="00:07:13.748" title="Trailer - Toy Story 3"/><psc:chapter start="00:09:02.741" title="Trailer - Get Him To The Greek"/><psc:chapter start="00:11:


2019/08/18 22:26:05 [error] 1358#1358: *2328043 FastCGI sent in stderr: "
PHP message: Start
PHP message: Trailer - The Losers
PHP message: Trailer - Takers
PHP message: Trailer - Wall Street: Money Never Sleeps
PHP message: Trailer - Repo Men
PHP message: News - HIMYM S06
PHP message: News - Autoren von HIMYM mit neuem Projekt
PHP message: News - Hitched, neues Projekt von Josh Schwartz
PHP message: News - Paranormal Saw 7D Ärger
PHP message: News - Miramax Studios dichtgemacht
PHP message: News - Oscarnomini" while reading upstream, client: 195.201.40.106, server: watch-th.is, request: "GET /feed/podcast/ HTTP/1.1", upstream: "fastcgi://unix:/run/php/php7.3-fpm-watchthis.sock:", host: "watch-th.is"


2019/08/18 22:26:05 [error] 1358#1358: *2328043 FastCGI sent in stderr: "erungen
PHP message: News - Lost S06 im deutschen iTunes Store
PHP message: News - Apple kämpft für 99 Cent bei TV-Folgen
PHP message: Film - Sherlock Holmes
PHP message: Film - It's Complicated
PHP message: Serie - Lost - Einführung/Inhalt
PHP message: Serie - Lost - Nervigste Gegenargumente
PHP message: Serie - Lost - Lost und wir
PHP message: Serie - Lost - !!! TEIL MIT SPOILERN !!!
PHP message: Serie - Lost - Spoilerfreier Abschluss, Trivia
PHP message: Eigenfeedback - Armored
PHP message: Eigenfeedback - Chuck
PHP message: Feedback - Buried und Happythankyoumoreplease
PHP message: Feedback - Allgemein
PHP message: Watch this! - The Shawshank Redemption
PHP message: Outtakes
PHP message: <?xml version="1.0"?>
<psc:chapters xmlns:psc="http://podlove.org/simple-chapters" version="1.2"><psc:chapter start="00:00:00.000" title="Start"/><psc:chapter start="00:00:54.936" title="Trailer - The Losers"/><psc:chapter start="00:02:29.124" title="Trailer - Takers"/><psc:chapter start="00:03:27.090" title="Trailer - Wall Street: Money Never Sleeps"/><psc:chapter start="00:04:25.540" title="Trailer - Repo Men"/><psc:chapter start="00:07:00.140" title="News - HIMYM S06"/><psc:chapter start="00:08:26.935" title="News - Autoren von HIMYM mit neuem Projekt"/><psc:chapter start="00:09:59.685" title="News - Hitched, neues Projekt von Josh Schwartz"/><psc:chapter start="00:11:46.356" title="News - Paranormal Saw 7D &#xC4;rger"/><psc:chapter start="00:14:46.341" title="News - Miramax Studios dichtgemacht"/><psc:chapter start="00:16:49.341" title="News - Oscarnominierungen"/><psc:chapter start="00:19:54.154" title="News - Lost S06 im deutschen iTunes Store"/><psc:chapter start="00:23:17.365"...
PHP message: Start
PHP message: Trailer - MacGruber
PHP message: Trailer - Buried
PHP message: Trailer - Cyrus
PHP message: Trailer - Hot Tub Time Machine
PHP message: Trailer - Iron Sky
PHP message: News - Iron Sky Marketing
PHP message: News - Marc Webb macht Spiderman
PHP message: News - 


2019/08/18 22:26:05 [error] 1358#1358: *2328043 FastCGI sent in stderr: "
PHP message: Start
PHP message: Trailer - The Good Guy
PHP message: Trailer - The A-Team
PHP message: Trailer - I Love You Phillip Morris
PHP message: Trailer - The Company Men
PHP message: Trailer - The Ghost Writer
PHP message: News - MyEpisodes.com und MyTVShows
PHP message: News - Cast von Undercovers fix
PHP message: News - Mr. Sunshine bekommt Piloten
PHP message: News - Human Target
PHP message: News - Jack Bauer im Kleid
PHP message: News - Cowboys vs. Aliens
PHP message: News - Sherlock Holmes 2
PHP message: News - Spiderman 4 ist tot
PHP message: News - Late-Night-Wars
PHP message: Film - The Illusionist
PHP message: Film - Old Dogs
PHP message: Film - There Will Be Blood
PHP message: Serie - How I Met Your Mother
PHP message: Internes - Feedback
PHP message: Internes - Formspring.me
PHP message: Internes - AAC-Umstellung erfolgt, Feedback erwünscht
PHP message: Outtakes
PHP message: <?xml version="1.0"?>
<psc:chapters xmlns:psc="http://podlove.org/simple-chapters" version="1.2"><psc:chapter start="00:00:00.000" title="Start"/><psc:chapter start="00:00:54.400" title="Trailer - The Good Guy"/><psc:chapter start="00:02:15.026" title="Trailer - The A-Team"/><psc:chapter start="00:04:39.012" title="Trailer - I Love You Phillip Morris"/><psc:chapter start="00:05:55.832" title="Trailer - The Company Men"/><psc:chapter start="00:07:46.223" title="Trailer - The Ghost Writer"/><psc:chapter start="00:08:21.669" title="News - MyEpisodes.com und MyTVShows"/><psc:chapter start="00:11:49.109" title="News - Cast von Undercovers fix"/><psc:chapter start="00:12:59.909" title="News - Mr. Sunshine bekommt Piloten"/><psc:chapter start="00:13:53.397" title="News - Human Target"/><psc:chapter start="00:17:02.157" title="News - Jack Bauer im Kleid"/><psc:chapter start="00:18:01.580" title="News - Cowboys vs. Aliens"/><psc:chapter start="00:19:56.458" title="News - Sherlock Holmes 2"/><p" while reading upstream, client: 195.201.40.106, server: watch-th.is, request: "GET /feed


2019/08/18 22:26:26 [error] 1358#1358: *2328067 FastCGI sent in stderr: "
PHP message: Start
PHP message: Trailer - Inception
PHP message: Trailer - From Paris with Love
PHP message: Trailer - Cop Out
PHP message: Trailer - The Karate Kid
PHP message: Trailer - Knight & Day
PHP message: Trailer - The Ghost Writer
PHP message: Trailer - Kick-Ass
PHP message: News- IMDB Top 25 of the Decade
PHP message: News - Nachfolger zu Before Sunrise/Sunset
PHP message: News - Sam Raimi hasst das Skript für Spiderman 4
PHP message: News - Interview mit Neill Blomkamp
PHP message: News - happythankyoumoreplease
PHP message: News - "Immer schön der Reihe nach"
PHP message: News - Sony verschenkt "Armored"
PHP message: Film - Armored
PHP message: Film - The Prestige
PHP message: Film - Star Trek
PHP message: Diese Woche (fast) keine Serien
PHP message: Eigenfeedback - Damages S02
PHP message: Eigenfeedback - NCIS
PHP message: Eigenfeedback - The Hurt Locker
PHP message: Eigenfeedback - Watchmen Ultimate Edition
PHP message: Eigenfeedback - The Tournament
PHP message: Eigenfeedback - Nick & Norah's Infinite Playlist
PHP message: Internes - Feedback
PHP message: Internes - AAC-Umstellung
PHP message: Internes - Team-Seite
PHP message: Internes - DIE LISTE
PHP message: Internes - Easteregg
PHP message: Internes - Feedback
PHP message: Outtakes
PHP message: <?xml version="1.0"?>
<psc:chapters xmlns:psc="http://podlove.org/simple-chapters" version="1.2"><psc:chapter start="00:00:00.000" title="Start"/><psc:chapter start="00:00:35.583" title="Trailer - Inception"/><psc:chapter start="00:02:30.283" title="Trailer - From Paris with Love"/><psc:chapter start="00:04:06.774" title="Trailer - Cop Out"/><psc:chapter start="00:05:27.512" title="Trailer - The Karate Kid"/><psc:chapter start="00:07:09.473" title="Trailer - Knight &amp; Day"/><psc:chapter start="00:08:37.711" title="Trailer - The Ghost Writer"/><psc:chapter start="00:11:17.821" title="Trailer - Kick-Ass"/><psc:chapter start="00:13:10.989" title="News- IMDB Top 25 of the Decade"/><psc:chapter start="00:15:17.4

Kurzer Check (zgrep 'PHP message' /var/log/nginx/error.log* | grep request) ergibt, dass das immer nur bei Anfragen auf einen Feed geschieht.

Ah, gefunden.

vendor/podlove/podlove-timeline/lib/Podlove/Chapters/Printer/PSC.php, da sind aus unerfindenlichen Gründen zwei error_log Zeilen. Entferne ich im nächsten Update, könnt ihr aber auch schon mal manuell entfernen wenn ihr nicht warten möchtet.

4 Like