merkwürdige symptome beim den ankommenden mails

WebTeufel

moin alle zusammen

habe seit einiger zeit seltsames verhalten meines mailservers, mails die mehrmals zugestellt werden. zumindest es ist jetzt aufgefallen

laut header haben die mails die selbe zeit wo die versendet wurden, wird aber scheinbar durch meinen server mehrmals an clients ausgeliefert

Installierte pd-admin-Version: v4.137
Installierte Reihe und Version der Serverumgebung: 7-0.477 (MariaDB 10.2.44-MariaDB)

ähnliche fehler tauchen in dem moment wo es zugestellt wird in den mail.warm und mail.log usw auf:

Code

Dec 16 22:14:00 gaia spamd[791]: plugin: eval failed: __alarm__ignore__(2662/::PerMsgStatus::check/2018) at /usr/local/pd-admin2/lib/perl5/site_perl/5.22.1/Mail/SpamAssassin/PerMsgStatus.pm line 2942, <GEN3224> line 1137.

wie kann ich der sache auf dem grund gehen und rausfinden was es ist und warum die mails so oft zugestellt werden?

Sumeragi

Kann man Mal zwei Mail Header als Beispiele bekommen?

Sumeragi

Zitat von WebTeufel

ähnliche fehler tauchen in dem moment wo es zugestellt wird in den mail.warm und mail.log usw auf:
Code Dec 16 22:14:00 gaia spamd[791]: plugin: eval failed: __alarm__ignore__(2662/::PerMsgStatus::check/2018) at /usr/local/pd-admin2/lib/perl5/site_perl/5.22.1/Mail/SpamAssassin/PerMsgStatus.pm line 2942, <GEN3224> line 1137.

Hier kommt es zu einem Timeout. Spamassassin hat ein "time_limit" von 300 Sekunden als Standardwert. Die Annahme ist, dass der Prozess die 300 Sekunden erreicht hat. Nur wieso? IIRC gibt es im Log Zeilen zu simscan, wo die Verarbeitungszeit mit angegeben ist.

WebTeufel

Zitat von Sumeragi

Kann man Mal zwei Mail Header als Beispiele bekommen?

sind die ok?

das ist z.b die erste mail:

Code

Return-Path: <bounces+42883523-6597-info=webteufel.net@em1653.eu.temuemail.com>
Delivered-To: webtenbo-webteufel.net-info@webteufel.net
Received: (qmail 29992 invoked from network); 16 Dec 2025 14:32:07 -0000
Received: by simscan 1.4.0 ppid: 29771, pid: 29783, t: 300.5083s
         scanners: clamav: 1.0.9/m:62/d:27851 spam: 4.0.2
X-Spam-Checker-Version: SpamAssassin 4.0.2 (2025-08-27) on
	gaia.webteufel-it.solutions
X-Spam-Level: 
X-Spam-Status: No, score=0.0 required=5.0 tests=none autolearn=unavailable
	version=4.0.2
Received: from wfbtdtqk.outbound-mail.sendgrid.net (159.183.215.65)
  by gaia.webteufel-it.solutions with ESMTPS (TLS_AES_128_GCM_SHA256 encrypted); 16 Dec 2025 14:27:06 -0000
DKIM-Signature: v=1; a=rsa-sha256; c=relaxed/relaxed; d=eu.temuemail.com;
	h=content-type:date:from:mime-version:subject:to:cc:content-type:date:
	from:subject:to;
	s=m2; bh=qIGOT+Spz0nVDRoF459oAntq1gFPZSvt1FbgqmQfPuY=;
	b=f3ShLEX5irrmByiu3fiPUG5Ao25QhSG4Proo1eUBaUw8c3hOFXqsxxmPmcmgy2p3bQqY
	EkAoG/bhv4s2sduY7+50rCgITuifbMxUCp269GhOiXhOodgE445h7rAXTLK+TbnblxbVHr
	PbMuxf0pFwsNpeOE5fkAfGw6RN93PSEqZtZLFGpaZcuXZcJ5ATv2Mi8XOZ7eeI9q7MPehT
	+vSf17jfahxWwa9jZ0A9LqOE9FzSdi/z8Pe33ftS3p8X6wHJJsjAVosQrOZ86mfjY9IJC7
	T8A0BqX2FiRR0U2irHXKq/pahdx3mHyHdGsOi5bKlG3LnS/0vjDJxiHM+tKMxGag==
Received: by recvd-78b448d76-87hs7 with SMTP id recvd-78b448d76-87hs7-1-69416C2E-69
	2025-12-16 14:26:54.812835657 +0000 UTC m=+2482069.134422772
Received: from NDI4ODM1MjM (unknown)
	by geopod-ismtpd-16 (SG) with HTTP
	id bx-ibZS6SuaOMm3pdKUXXg
	Tue, 16 Dec 2025 14:26:54.719 +0000 (UTC)
Content-Type: multipart/alternative; boundary=ae6cd18fd63a29de2ac0d5ec8a579c8cc063fadf08df8b5a78e58c12aa6a
Date: Tue, 16 Dec 2025 14:26:54 +0000 (UTC)
From: Temu <temu@eu.temuemail.com>
Mime-Version: 1.0

Alles anzeigen

das ist eine die später im client eingetroffen ist:

Code

Return-Path: <bounces+42883523-6597-info=webteufel.net@em1653.eu.temuemail.com>
Delivered-To: webtenbo-webteufel.net-info@webteufel.net
Received: (qmail 30391 invoked from network); 16 Dec 2025 14:49:27 -0000
Received: by simscan 1.4.0 ppid: 30239, pid: 30244, t: 300.4791s
         scanners: clamav: 1.0.9/m:62/d:27851 spam: 4.0.2
X-Spam-Checker-Version: SpamAssassin 4.0.2 (2025-08-27) on
	gaia.webteufel-it.solutions
X-Spam-Level: 
X-Spam-Status: No, score=0.0 required=5.0 tests=none autolearn=unavailable
	version=4.0.2
Received: from wfbtdhds.outbound-mail.sendgrid.net (159.183.208.214)
  by gaia.webteufel-it.solutions with ESMTPS (TLS_AES_128_GCM_SHA256 encrypted); 16 Dec 2025 14:44:26 -0000
DKIM-Signature: v=1; a=rsa-sha256; c=relaxed/relaxed; d=eu.temuemail.com;
	h=content-type:date:from:mime-version:subject:to:cc:content-type:date:
	from:subject:to;
	s=m2; bh=qIGOT+Spz0nVDRoF459oAntq1gFPZSvt1FbgqmQfPuY=;
	b=f3ShLEX5irrmByiu3fiPUG5Ao25QhSG4Proo1eUBaUw8c3hOFXqsxxmPmcmgy2p3bQqY
	EkAoG/bhv4s2sduY7+50rCgITuifbMxUCp269GhOiXhOodgE445h7rAXTLK+TbnblxbVHr
	PbMuxf0pFwsNpeOE5fkAfGw6RN93PSEqZtZLFGpaZcuXZcJ5ATv2Mi8XOZ7eeI9q7MPehT
	+vSf17jfahxWwa9jZ0A9LqOE9FzSdi/z8Pe33ftS3p8X6wHJJsjAVosQrOZ86mfjY9IJC7
	T8A0BqX2FiRR0U2irHXKq/pahdx3mHyHdGsOi5bKlG3LnS/0vjDJxiHM+tKMxGag==
Received: by recvd-78b448d76-87hs7 with SMTP id recvd-78b448d76-87hs7-1-69416C2E-69
	2025-12-16 14:26:54.812835657 +0000 UTC m=+2482069.134422772
Received: from NDI4ODM1MjM (unknown)
	by geopod-ismtpd-16 (SG) with HTTP
	id bx-ibZS6SuaOMm3pdKUXXg
	Tue, 16 Dec 2025 14:26:54.719 +0000 (UTC)
Content-Type: multipart/alternative; boundary=ae6cd18fd63a29de2ac0d5ec8a579c8cc063fadf08df8b5a78e58c12aa6a
Date: Tue, 16 Dec 2025 14:26:54 +0000 (UTC)
From: Temu <temu@eu.temuemail.com>
Mime-Version: 1.0

Alles anzeigen

von der mail sind am client 9 stück angekommen

das war die letzte:

Code

Return-Path: <bounces+42883523-6597-info=webteufel.net@em1653.eu.temuemail.com>
Delivered-To: webtenbo-webteufel.net-info@webteufel.net
Received: (qmail 32305 invoked from network); 16 Dec 2025 16:01:20 -0000
Received: by simscan 1.4.0 ppid: 32255, pid: 32260, t: 44.2225s
         scanners: clamav: 1.0.9/m:62/d:27851 spam: 4.0.2
X-Spam-Checker-Version: SpamAssassin 4.0.2 (2025-08-27) on
	gaia.webteufel-it.solutions
X-Spam-Level: 
X-Spam-Status: No, score=-0.1 required=5.0 tests=DKIM_SIGNED,DKIM_VALID,
	DKIM_VALID_AU,HTML_FONT_SIZE_HUGE,HTML_IMAGE_RATIO_02,HTML_MESSAGE,
	SPF_HELO_NONE autolearn=ham autolearn_force=no version=4.0.2
Received: from wfbtrnxb.outbound-mail.sendgrid.net (159.183.82.171)
  by gaia.webteufel-it.solutions with ESMTPS (TLS_AES_128_GCM_SHA256 encrypted); 16 Dec 2025 16:00:35 -0000
DKIM-Signature: v=1; a=rsa-sha256; c=relaxed/relaxed; d=eu.temuemail.com;
	h=content-type:date:from:mime-version:subject:to:cc:content-type:date:
	from:subject:to;
	s=m2; bh=qIGOT+Spz0nVDRoF459oAntq1gFPZSvt1FbgqmQfPuY=;
	b=f3ShLEX5irrmByiu3fiPUG5Ao25QhSG4Proo1eUBaUw8c3hOFXqsxxmPmcmgy2p3bQqY
	EkAoG/bhv4s2sduY7+50rCgITuifbMxUCp269GhOiXhOodgE445h7rAXTLK+TbnblxbVHr
	PbMuxf0pFwsNpeOE5fkAfGw6RN93PSEqZtZLFGpaZcuXZcJ5ATv2Mi8XOZ7eeI9q7MPehT
	+vSf17jfahxWwa9jZ0A9LqOE9FzSdi/z8Pe33ftS3p8X6wHJJsjAVosQrOZ86mfjY9IJC7
	T8A0BqX2FiRR0U2irHXKq/pahdx3mHyHdGsOi5bKlG3LnS/0vjDJxiHM+tKMxGag==
Received: by recvd-78b448d76-87hs7 with SMTP id recvd-78b448d76-87hs7-1-69416C2E-69
	2025-12-16 14:26:54.812835657 +0000 UTC m=+2482069.134422772
Received: from NDI4ODM1MjM (unknown)
	by geopod-ismtpd-16 (SG) with HTTP
	id bx-ibZS6SuaOMm3pdKUXXg
	Tue, 16 Dec 2025 14:26:54.719 +0000 (UTC)
Content-Type: multipart/alternative; boundary=ae6cd18fd63a29de2ac0d5ec8a579c8cc063fadf08df8b5a78e58c12aa6a
Date: Tue, 16 Dec 2025 14:26:54 +0000 (UTC)
From: Temu <temu@eu.temuemail.com>
Mime-Version: 1.0

Alles anzeigen

WebTeufel

Zitat von Sumeragi

Hier kommt es zu einem Timeout. Spamassassin hat ein "time_limit" von 300 Sekunden als Standardwert. Die Annahme ist, dass der Prozess die 300 Sekunden erreicht hat. Nur wieso? IIRC gibt es im Log Zeilen zu simscan, wo die Verarbeitungszeit mit angegeben ist.

hm...

habe angefangen danach zu suchen am dec 15 gab es werte von 1.5 max 4,9 sec

am 16. gibt es kein enizigen simscan erst wieder am 18 wo es wieder ruhig war mit der doppelzustellung

was sagt es aus? was sagt dieser log aus?

WebTeufel

sorry habe jetzt nach scantime gesucht und auch kleine einstellige werte gefunden

da wo es doppeltzustellung gibt sind die werte von 300.1

kurz davor ist die fehlermeldung von oben, von spamd plugin und kurz danach der hohe wert

Code

Dec 15 08:42:36 gaia spamd[671068]: plugin: eval failed: __alarm__ignore__(355675/::PerMsgStatus::check/2018) at /usr/local/pd-admin2/lib/perl5/site_perl/5.22.1/Mail/SpamAssassin/PerM>
Dec 15 08:42:36 gaia spamd[671068]: check: exceeded time limit in pms check
Dec 15 08:42:36 gaia spamd[671068]: spamd: clean message (0.0/5.0) for info@webteufel.net:1020 in 300.1 seconds, 84879 bytes.
Dec 15 08:42:36 gaia spamd[671068]: spamd: result: .  0 -  scantime=300.1,size=84879,user=

tbc233

Mir fallen hier zwei Dinge ein aus der Vergangenheit: Namensauflösung und korrupte Bayes Datenbank.

Flutscht die Namensauflösung auf dem Host? Ansonsten kann es zu Timeouts bei Blacklist Abfragen etc. kommen.

Auch eine beschädigte Bayes Datenbank kann Timeouts verursachen. Wäre interessant, die bestehenden Bayes DB Dateien mal weg zu moven (vorher Serverumgebung stoppen und dann wieder starten). Dann wird eine neue angelegt. Ich erinnere mich aber grad um die Burg nicht, wo diese Dateien liegen.

WebTeufel

Zitat von tbc233

Mir fallen hier zwei Dinge ein aus der Vergangenheit: Namensauflösung und korrupte Bayes Datenbank.
Flutscht die Namensauflösung auf dem Host? Ansonsten kann es zu Timeouts bei Blacklist Abfragen etc. kommen.
Auch eine beschädigte Bayes Datenbank kann Timeouts verursachen. Wäre interessant, die bestehenden Bayes DB Dateien mal weg zu moven (vorher Serverumgebung stoppen und dann wieder starten). Dann wird eine neue angelegt. Ich erinnere mich aber grad um die Burg nicht, wo diese Dateien liegen.

du meinst den clamav ordner?

die letzten tage ist es auch wieder ruhe im karton

war ja auch davor nie das problem, wer weiß was da war, aber aktuell erst mal ruhe

diese fehlermeldungen mit plugin tauchen auch nur an den tagen wo es doppelt kam, jetzt ist da auch ruhe

in der mail.warn gibt es aktuell noch andere sachen mit verschiedenen domains, hier ein beispiel:

Code

Dec 19 06:00:02 gaia spawn-filter: ignore_wrong_answer = 1
Dec 19 06:00:02 gaia spawn-filter: ignore_wrong_answer = 1
Dec 19 06:00:02 gaia spawn-filter: canonhost = <web.de>
Dec 19 06:00:02 gaia spawn-filter: dns_cname = 0

was sagt das aus?

tbc233

Das ist normal. Hat mit dem Parameter ignorewronganswer (/var/qmail/control/ignorewronganswer) zu tun, der vor einigen Jahren eingeführt wurde weil qmail probleme mit langen DNS Antworten hatte. Also diese Meldungen sind kein Grund zur Sorge.

Sumeragi

Zitat von WebTeufel

da wo es doppeltzustellung gibt sind die werte von 300.1

Hier ist der Scan dann an das time_limit gestoßen. Wenn dies zu den Doppelzustellungen passt, dann hängt dies wohl damit zusammen. 300 Sekunden ist schon ziemlich lang. Ich würde den Wert einmal runter stellen und beobachten.

WebTeufel

das waren wohl nur die 2 tage, aktuell nichts mehr zu bemängeln

interessant wäre zu erfahren was genau da los war, aber wird wohl so bleiben

Daniel Bradler

Es ist uns aufgefallen, dass SpamAssassin 4 teilweise sehr lange fuer den Scan von E-Mails benoetigt. Das fuehrt zu einem Timeout auf der Gegenseite und damit leider zu Mehrfachzustellungen. Genau geklaert ist die Ursache leider nicht; ursaechlich scheinen aber DNS-basierte RBL-Checks zu sein. Mit den folgenden Aenderungen ist der Fehler bei uns bislang aber nicht mehr aufgetreten:

Code

dns_query_restriction deny bl.score.senderscore.com
dns_query_restriction deny sa-accredit.habeas.com
dns_query_restriction deny sa-trusted.bondedsender.org
time_limit 90

WebTeufel

bis auf die paar tage ist es bei mir auch nicht mehr aufgetreten, aber dennoch ...

wo trägt man die werte ein? wie wendet man die an?

Sumeragi

Die Konfiguration findet man unter

/usr/local/pd-admin2/etc/mail/spamassassin/

Die Werte werden in der local.cf eingetragen.