Amavis : Requesting process rundown after 24 tasks

Amavis : Requesting process rundown after 24 tasks - Logiciels - Linux et OS Alternatifs

Marsh Posté le 17-01-2008 à 11:09:27    

Salut,
 
 
Je tourne sous Debian Etch, Kernel 2.6.18-4-686.
La version d'amavis : amavisd-new-2.5.2 (20070627).
 
J'ai actuellement des problèmes avec certaines réceptions de mail.
Dans les logs, le mail en question est marqué comme ayant été déposé dans le maildir cependant ce mail n'a jamais été reçu par le destinataire...
Voici un extrait des logs :
 

Code :
  1. Jan 16 11:49:20 serveur postfix/smtpd[4384]: connect from smtp.client.fr[X]
  2. Jan 16 11:49:20 serveur postfix/smtpd[4384]: 6BAE27D8C: client=smtp.client.fr[X]
  3. Jan 16 11:49:20 serveur postfix/cleanup[4387]: 6BAE27D8C: message-id=<478DE16F.9020408@client.fr>
  4. Jan 16 11:49:20 serveur postfix/smtpd[4384]: disconnect from smtp.client.fr[X]
  5. Jan 16 11:49:20 serveur postfix/qmgr[2867]: 6BAE27D8C: from=<client@client.fr>, size=3467, nrcpt=1 (queue active)
  6. Jan 16 11:49:20 serveur amavis[11649]: (11649-20) ESMTP::10024 /var/amavis/tmp/amavis-20080116T073922-11649: <client@client.fr> -> <toto@mydomain.com> SIZE=3467 BODY=8BITMIME Received: from serveur.mydomain.com ([127.0.0.1]) by localhost (serveur.mydomain.com [127.0.0.1]) (amavisd-new, port 10024) with ESMTP for <toto@mydomain.com>; Wed, 16 Jan 2008 11:49:20 +0100 (CET)
  7. Jan 16 11:49:20 serveur amavis[11649]: (11649-20) Checking: cg7D85g8elPB [X] <client@client.fr> -> <toto@mydomain.com>
  8. Jan 16 11:49:20 serveur amavis[11649]: (11649-20) p003 1 Content-Type: multipart/alternative
  9. Jan 16 11:49:20 serveur amavis[11649]: (11649-20) p001 1/1 Content-Type: text/plain, size: 578 B, name:
  10. Jan 16 11:49:20 serveur amavis[11649]: (11649-20) p002 1/2 Content-Type: text/html, size: 1386 B, name:
  11. Jan 16 11:49:21 serveur amavis[11649]: (11649-20) SPAM-TAG, <client@client.fr> -> <toto@mydomain.com>, No, score=0.001 tagged_above=-9999.9 required=5 tests=[HTML_MESSAGE=0.001]
  12. Jan 16 11:49:21 serveur postfix/smtpd[4393]: connect from localhost[127.0.0.1]
  13. Jan 16 11:49:21 serveur postfix/smtpd[4393]: 927707D9A: client=localhost[127.0.0.1]
  14. Jan 16 11:49:21 serveur postfix/cleanup[4387]: 927707D9A: message-id=<478DE16F.9020408@client.fr>
  15. Jan 16 11:49:21 serveur postfix/smtpd[4393]: disconnect from localhost[127.0.0.1]
  16. Jan 16 11:49:21 serveur amavis[11649]: (11649-20) FWD via SMTP: <client@client.fr> -> <toto@mydomain.com>,BODY=8BITMIME 250 2.6.0 Ok, id=11649-20, from MTA([127.0.0.1]:10025): 250 2.0.0 Ok: queued as 927707D9A
  17. Jan 16 11:49:21 serveur amavis[11649]: (11649-20) Passed CLEAN, [X] [X] <client@client.fr> -> <toto@mydomain.com>, Message-ID: <478DE16F.9020408@client.fr>, mail_id: cg7D85g8elPB, Hits: 0.001, size: 3467, queued_as: 927707D9A, 982 ms
  18. Jan 16 11:49:21 serveur amavis[11649]: (11649-20) TIMING [total 988 ms] - SMTP greeting: 3 (0%)0, SMTP EHLO: 1 (0%)0, SMTP pre-MAIL: 1 (0%)0, SMTP pre-DATA-flush: 4 (0%)1, SMTP DATA: 35 (4%)4, check_init: 1 (0%)5, digest_hdr: 1 (0%)5, digest_body: 0 (0%)5, gen_mail_id: 1 (0%)5, mime_decode: 19 (2%)7, get-file-type2: 17 (2%)8, parts_decode: 1 (0%)8, check_header: 2 (0%)9, AV-scan-1: 13 (1%)10, spam-wb-list: 2 (0%)10, SA parse: 4 (0%)11, SA check: 637 (65%)75, update_cache: 8 (1%)76, decide_mail_destiny: 2 (0%)76, fwd-connect: 41 (4%)80, fwd-mail-pip: 43 (4%)85, fwd-rcpt-pip: 0 (0%)85, fwd-data-chkpnt: 0 (0%)85, write-header: 1 (0%)85, fwd-data-contents: 0 (0%)85, fwd-end-chkpnt: 132 (13%)98, prepare-dsn: 1 (0%)98, main_log_entry: 13 (1%)100, update_snmp: 2 (0%)100, SMTP pre-response: 1 (0%)100, SMTP response: 0 (0%)100, unlink-2-files: 0 (0%)100, rundown: 0 (0%)100
  19. Jan 16 11:49:21 serveur postfix/smtp[4388]: 6BAE27D8C: to=<toto@mydomain.com>, relay=127.0.0.1[127.0.0.1]:10024, delay=1.5, delays=0.5/0.03/0.01/0.98, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as 927707D9A)
  20. Jan 16 11:49:21 serveur amavis[11649]: (11649-20) Requesting process rundown after 20 tasks (and 20 sessions)
  21. Jan 16 11:49:21 serveur postfix/qmgr[2867]: 927707D9A: from=<client@client.fr>, size=4039, nrcpt=1 (queue active)
  22. Jan 16 11:49:21 serveur amavis[4395]: TIMING [total 10 ms] - bdb-open: 10 (100%)100, rundown: 0 (0%)100
  23. Jan 16 11:49:21 serveur postfix/local[4396]: 927707D9A: to=<toto@mydomain.com>, relay=local, delay=0.35, delays=0.26/0.01/0/0.07, dsn=2.0.0, status=sent (delivered to maildir)
  24. Jan 16 11:49:21 serveur postfix/qmgr[2867]: 6BAE27D8C: removed
  25. Jan 16 11:49:22 serveur postfix/qmgr[2867]: 927707D9A: removed
  26. Jan 16 11:54:26 serveur postfix/anvil[4385]: statistics: max connection rate 1/60s for (smtp:X) at Jan 16 11:49:20
  27. Jan 16 11:54:26 serveur postfix/anvil[4385]: statistics: max connection count 1 for (smtp:X) at Jan 16 11:49:20
  28. Jan 16 11:54:26 serveur postfix/anvil[4385]: statistics: max cache size 1 at Jan 16 11:49:20


 
Il y a une chose qui m'intrigue dans ces logs, à savoir :

Code :
  1. Requesting process rundown after 20 tasks (and 20 sessions)


 
Ceci correspond bien à une demande d'arrêt d'un process ?
Est-ce un message "normal" ou dois-je m'en inquiéter ?
Merci d'avance.


Message édité par jaymzwise le 17-01-2008 à 11:09:48
Reply

Marsh Posté le 17-01-2008 à 11:09:27   

Reply

Marsh Posté le 17-01-2008 à 14:33:33    

Code :
  1. Requesting process rundown after 20 tasks (and 20 sessions)

 c'est normal  
 
rien de suspect dans les logs
 
fais voir ton postconf -n et cherche dans le repertoire du mailbox du user si tu vois le fichier


---------------
Messagerie dédiée, Relais Mail Antispam/Antivirus, Infogérance 24/7: http://www.eole-its.com
Reply

Marsh Posté le 17-01-2008 à 14:48:04    

Postconf -n :

Code :
  1. alias_database = hash:/etc/postfix/aliases
  2. alias_maps = hash:/etc/postfix/aliases
  3. append_dot_mydomain = no
  4. biff = no
  5. bounce_template_file = /etc/postfix/bounce.cf
  6. config_directory = /etc/postfix
  7. content_filter = smtp-amavis:[127.0.0.1]:10024
  8. header_checks = regexp:/etc/postfix/header_checks
  9. home_mailbox = Maildir/
  10. inet_interfaces = all
  11. local_recipient_maps = $alias_maps
  12. mailbox_size_limit = 0
  13. message_size_limit = 4500000
  14. mydestination = $mydomain, $myhostname.$mydomain, localhost.$mydomain
  15. mydomain = x
  16. myhostname = x
  17. mynetworks = x, 127.0.0.0/8
  18. myorigin = $mydomain
  19. receive_override_options = no_address_mappings
  20. recipient_delimiter = +
  21. relay_domains = x.x
  22. relayhost = [smtp.orange.fr]
  23. smtp_sasl_auth_enable = yes
  24. smtp_sasl_password_maps = hash:/etc/postfix/sasl_passwd
  25. smtp_sasl_security_options =
  26. smtpd_banner = $myhostname ESMTP $mail_name (Debian/GNU)
  27. smtpd_client_restrictions = permit_mynetworks
  28. smtpd_delay_reject = yes
  29. smtpd_helo_required = yes
  30. smtpd_helo_restrictions = permit_mynetworks, reject_invalid_hostname, reject_unauth_pipelining, reject_non_fqdn_hostname
  31. smtpd_recipient_restrictions = permit_mynetworks,       check_sender_access hash:/etc/postfix/sender_whitelist, permit_sasl_authenticated,      reject_unverified_recipient, reject_non_fqdn_sender, reject_non_fqdn_recipient,      reject_unknown_sender_domain,   reject_unknown_recipient_domain,        reject_unauth_destination,   permit
  32. smtpd_sasl_auth_enable = yes
  33. smtpd_sender_restrictions = permit_mynetworks,  check_sender_access hash:/etc/postfix/sender_whitelist, reject_unknown_sender_domain,   reject_unauth_destination


 
J'ai cherché dans le répertoire Maildir du user mais aucune trace du mail.

Reply

Marsh Posté le 17-01-2008 à 14:55:09    

fais voir le contenu du maildir et les sous dossiers


---------------
Messagerie dédiée, Relais Mail Antispam/Antivirus, Infogérance 24/7: http://www.eole-its.com
Reply

Marsh Posté le 17-01-2008 à 16:01:37    

Bon, j'ai de nouvelles infos...
L'utilisateur en question s'est planté, il a bien reçu les mails envoyés par le client hier mais les a supprimé entre temps, il était cependant persuadé qu'il ne les avait pas reçus...
Par contre, d'autres mails envoyés par le client le 15 n'ont pas été reçus. Là, fort heureusement, j'ai quelque chose de très parlant dans les logs :
 

Code :
  1. Jan 15 16:22:26 x postfix/smtpd[24119]: connect from smtp.client.fr[X]
  2. Jan 15 16:22:27 x postfix/smtpd[24119]: NOQUEUE: reject: RCPT from smtp.client.fr[X]: 504 5.5.2 <u050034>: Helo command rejected: need fully-qualified hostname; from=<user@client.fr> to=<user@mydomain.com> proto=ESMTP helo=<u050034>
  3. Jan 15 16:22:27 x postfix/smtpd[24119]: disconnect from smtp.client.fr[X]


 
Il semblerait que le problème provienne du serveur smtp du client.
Le problème était temporaire (Envois du 15) car les mails envoyés hier du serveur smtp du client nous sont parvenus.

Reply

Marsh Posté le 17-01-2008 à 19:08:31    

oui le pb vient bien du smtp client
 
il presente un helo qui n'est pas un FQDN  (u050034)
 


---------------
Messagerie dédiée, Relais Mail Antispam/Antivirus, Infogérance 24/7: http://www.eole-its.com
Reply

Sujets relatifs:

Leave a Replay

Make sure you enter the(*)required information where indicate.HTML code is not allowed