Koozali.org: home of the SME Server

Errore - Plugin logging::logterse, hook queue returned DECLINED,

Offline filloweb

  • ****
  • 166
  • +0/-0
Ciao a tutti.

Ho uno SME up2date che da stamani non riceveva piu mail sull'indirizzo destinatario@destdom.it

Nei Log di QPSMTPD ho trovato questo:

Code: [Select]
2011-06-30 15:34:44.875540500 21402 running plugin (post-connection): tls
2011-06-30 15:34:44.875701500 21402 Plugin tls, hook post-connection returned DECLINED,
2011-06-30 15:34:45.799757500 4053 cleaning up after 21402
2011-06-30 15:38:57.920306500 4053 running plugin (pre-connection): hosts_allow
2011-06-30 15:38:57.920309500 4053 Plugin hosts_allow, hook pre-connection returned DECLINED,
2011-06-30 15:38:57.961378500 21469 Accepted connection 0/40 from 212.97.32.73 / smtp-out-05.comm2000.it
2011-06-30 15:38:57.961382500 21469 Connection from smtp-out-05.comm2000.it [212.97.32.73]
2011-06-30 15:38:57.961384500 21469 running plugin (set_hooks): peers
2011-06-30 15:38:57.961386500 21469 peers hooking valid_auth
2011-06-30 15:38:57.961388500 21469 peers hooking set_hooks
2011-06-30 15:38:57.961390500 21469 logging::logterse hooking queue
2011-06-30 15:38:57.961392500 21469 logging::logterse hooking deny
2011-06-30 15:38:57.961394500 21469 tls plugin (init): ciphers: ALL:!aNULL:!ADH:!eNULL:!LOW:!EXP:RC4+RSA:+HIGH:+MEDIUM
2011-06-30 15:38:57.961412500 21469 tls hooking connect
2011-06-30 15:38:57.961414500 21469 tls hooking ehlo
2011-06-30 15:38:57.961416500 21469 tls hooking helo
2011-06-30 15:38:57.961418500 21469 tls hooking rcpt
2011-06-30 15:38:57.961420500 21469 tls hooking mail
2011-06-30 15:38:57.961422500 21469 tls hooking data
2011-06-30 15:38:57.961431500 21469 tls hooking post-connection
2011-06-30 15:38:57.961480500 21469 tls hooking unrecognized_command
2011-06-30 15:38:57.962222500 21469 check_earlytalker hooking connect
2011-06-30 15:38:57.962267500 21469 check_earlytalker hooking data
2011-06-30 15:38:57.962434500 21469 count_unrecognized_commands hooking connect
2011-06-30 15:38:57.962603500 21469 count_unrecognized_commands hooking unrecognized_command
2011-06-30 15:38:57.962815500 21469 check_relay hooking connect
2011-06-30 15:38:57.963124500 21469 check_norelay hooking connect
2011-06-30 15:38:57.963465500 21469 require_resolvable_fromhost hooking mail
2011-06-30 15:38:57.963828500 21469 check_basicheaders hooking data_post
2011-06-30 15:38:57.964130500 21469 check_badmailfrom hooking rcpt
2011-06-30 15:38:57.964189500 21469 check_badmailfrom hooking mail
2011-06-30 15:38:57.964452500 21469 check_badrcptto_patterns hooking rcpt
2011-06-30 15:38:57.964758500 21469 check_badrcptto hooking rcpt
2011-06-30 15:38:57.965017500 21469 check_spamhelo hooking ehlo
2011-06-30 15:38:57.965077500 21469 check_spamhelo hooking helo
2011-06-30 15:38:57.965461500 21469 check_goodrcptto hooking rcpt
2011-06-30 15:38:57.965690500 21469 rcpt_ok hooking rcpt
2011-06-30 15:38:57.966087500 21469 tnef2mime hooking data_post
2011-06-30 15:38:57.966319500 21469 spamassassin hooking data_post
2011-06-30 15:38:57.966630500 21469 virus::clamav hooking data_post
2011-06-30 15:38:57.967065500 21469 queue::qmail_2dqueue hooking queue
2011-06-30 15:38:57.967456500 21469 Plugin peers, hook set_hooks returned DECLINED,
2011-06-30 15:38:57.967555500 21469 running plugin (connect): tls
2011-06-30 15:38:57.967627500 21469 Plugin tls, hook connect returned DECLINED,
2011-06-30 15:38:57.967677500 21469 running plugin (connect): check_earlytalker
2011-06-30 15:38:58.968653500 21469 check_earlytalker plugin (connect): remote host said nothing spontaneous, proceeding
2011-06-30 15:38:58.968736500 21469 Plugin check_earlytalker, hook connect returned DECLINED,
2011-06-30 15:38:58.968771500 21469 running plugin (connect): count_unrecognized_commands
2011-06-30 15:38:58.968865500 21469 Plugin count_unrecognized_commands, hook connect returned DECLINED,
2011-06-30 15:38:58.968901500 21469 running plugin (connect): check_relay
2011-06-30 15:38:58.969006500 21469 trying to get config for relayclients
2011-06-30 15:38:58.969673500 21469 trying to get config for morerelayclients
2011-06-30 15:38:58.969857500 21469 Plugin check_relay, hook connect returned DECLINED,
2011-06-30 15:38:58.969896500 21469 running plugin (connect): check_norelay
2011-06-30 15:38:58.969940500 21469 trying to get config for norelayclients
2011-06-30 15:38:58.970207500 21469 Plugin check_norelay, hook connect returned DECLINED,
2011-06-30 15:38:58.970280500 21469 trying to get config for smtpgreeting
2011-06-30 15:38:58.970479500 21469 220 mail.destdom.it ESMTP
2011-06-30 15:38:58.970622500 21469 trying to get config for timeoutsmtpd
2011-06-30 15:38:59.006999500 21469 dispatching EHLO smtp-out-05.comm2000.it
2011-06-30 15:38:59.007274500 21469 running plugin (ehlo): tls
2011-06-30 15:38:59.007403500 21469 Plugin tls, hook ehlo returned DECLINED,
2011-06-30 15:38:59.007436500 21469 running plugin (ehlo): check_spamhelo
2011-06-30 15:38:59.007506500 21469 trying to get config for badhelo
2011-06-30 15:38:59.007763500 21469 Plugin check_spamhelo, hook ehlo returned DECLINED,
2011-06-30 15:38:59.007891500 21469 trying to get config for tls_before_auth
2011-06-30 15:38:59.008108500 21469 trying to get config for me
2011-06-30 15:38:59.008254500 21469 trying to get config for databytes
2011-06-30 15:38:59.008404500 21469 250-destdom.it Hi smtp-out-05.comm2000.it [212.97.32.73]
2011-06-30 15:38:59.008435500 21469 250-PIPELINING
2011-06-30 15:38:59.008463500 21469 250-8BITMIME
2011-06-30 15:38:59.008509500 21469 250-SIZE 50000000
2011-06-30 15:38:59.008548500 21469 250 STARTTLS
2011-06-30 15:38:59.047426500 21469 dispatching MAIL FROM:<mittente@mittdom.it> SIZE=1348 BODY=8BITMIME
2011-06-30 15:38:59.047649500 21469 full from_parameter: FROM:<mittente@mittdom.it> SIZE=1348 BODY=8BITMIME
2011-06-30 15:38:59.047851500 21469 from email address : [<mittente@mittdom.it>]
2011-06-30 15:38:59.048239500 21469 running plugin (mail): tls
2011-06-30 15:38:59.048311500 21469 Plugin tls, hook mail returned DECLINED,
2011-06-30 15:38:59.048344500 21469 running plugin (mail): require_resolvable_fromhost
2011-06-30 15:38:59.048421500 21469 trying to get config for invalid_resolvable_fromhost
2011-06-30 15:38:59.049066500 21469 trying to get config for require_resolvable_fromhost
2011-06-30 15:38:59.049286500 21469 Plugin require_resolvable_fromhost, hook mail returned DECLINED,
2011-06-30 15:38:59.049320500 21469 running plugin (mail): check_badmailfrom
2011-06-30 15:38:59.049387500 21469 trying to get config for badmailfrom
2011-06-30 15:38:59.049633500 21469 Plugin check_badmailfrom, hook mail returned DECLINED,
2011-06-30 15:38:59.049725500 21469 getting mail from <mittente@mittdom.it>
2011-06-30 15:38:59.049782500 21469 250 <mittente@mittdom.it>, sender OK - how exciting to get mail from you!
2011-06-30 15:38:59.049903500 21469 dispatching RCPT TO:<destinatario@destdom.it>
2011-06-30 15:38:59.050074500 21469 to email address : [<destinatario@destdom.it>]
2011-06-30 15:38:59.050188500 21469 running plugin (rcpt): tls
2011-06-30 15:38:59.050253500 21469 Plugin tls, hook rcpt returned DECLINED,
2011-06-30 15:38:59.050284500 21469 running plugin (rcpt): check_badmailfrom
2011-06-30 15:38:59.050343500 21469 Plugin check_badmailfrom, hook rcpt returned DECLINED,
2011-06-30 15:38:59.050374500 21469 running plugin (rcpt): check_badrcptto_patterns
2011-06-30 15:38:59.050441500 21469 trying to get config for badrcptto_patterns
2011-06-30 15:38:59.050785500 21469 Plugin check_badrcptto_patterns, hook rcpt returned DECLINED,
2011-06-30 15:38:59.050824500 21469 running plugin (rcpt): check_badrcptto
2011-06-30 15:38:59.050875500 21469 trying to get config for badrcptto
2011-06-30 15:38:59.051239500 21469 Plugin check_badrcptto, hook rcpt returned DECLINED,
2011-06-30 15:38:59.051274500 21469 running plugin (rcpt): check_goodrcptto
2011-06-30 15:38:59.051346500 21469 check_goodrcptto plugin (rcpt): stripping '-' extensions
2011-06-30 15:38:59.051382500 21469 trying to get config for goodrcptto
2011-06-30 15:38:59.052240500 21469 check_goodrcptto plugin (rcpt): address includes extn '-', checking users: ricambi
2011-06-30 15:38:59.052629500 21469 Plugin check_goodrcptto, hook rcpt returned DECLINED,
2011-06-30 15:38:59.052662500 21469 running plugin (rcpt): rcpt_ok
2011-06-30 15:38:59.052729500 21469 trying to get config for rcpthosts
2011-06-30 15:38:59.052987500 21469 Plugin rcpt_ok, hook rcpt returned OK,
2011-06-30 15:38:59.053081500 21469 250 <destinatario@destdom.it>, recipient ok
2011-06-30 15:38:59.053178500 21469 dispatching DATA
2011-06-30 15:38:59.053266500 21469 running plugin (data): tls
2011-06-30 15:38:59.053338500 21469 Plugin tls, hook data returned DECLINED,
2011-06-30 15:38:59.053370500 21469 running plugin (data): check_earlytalker
2011-06-30 15:38:59.053497500 21469 Plugin check_earlytalker, hook data returned DECLINED,
2011-06-30 15:38:59.053626500 21469 354 go ahead
2011-06-30 15:38:59.053674500 21469 max_size: 50000000 / size: 0
2011-06-30 15:38:59.053837500 21469 trying to get config for timeout
2011-06-30 15:38:59.164558500 21469 spooling message to disk
2011-06-30 15:38:59.166853500 21469 max_size: 50000000 / size: 1311
2011-06-30 15:38:59.167243500 21469 running plugin (data_post): check_basicheaders
2011-06-30 15:38:59.167431500 21469 Plugin check_basicheaders, hook data_post returned DECLINED,
2011-06-30 15:38:59.167482500 21469 running plugin (data_post): tnef2mime
2011-06-30 15:38:59.173915500 21469 Plugin tnef2mime, hook data_post returned DECLINED,
2011-06-30 15:38:59.173935500 21469 running plugin (data_post): spamassassin
2011-06-30 15:38:59.174023500 21469 spamassassin plugin (data_post): check_spam
2011-06-30 15:38:59.174518500 21469 spamassassin plugin (data_post): check_spam: connected to spamd
2011-06-30 15:38:59.175279500 21469 spamassassin plugin (data_post): check_spam: finished sending to spamd
2011-06-30 15:39:02.963549500 21469 spamassassin plugin (data_post): check_spam: spamd: SPAMD/1.1 0 EX_OK
2011-06-30 15:39:02.963552500 21469 spamassassin plugin (data_post): check_spam: spamd: Content-length: 18
2011-06-30 15:39:02.963555500 21469 spamassassin plugin (data_post): check_spam: spamd: Spam: False ; 0.0 / 5.0
2011-06-30 15:39:02.963557500 21469 spamassassin plugin (data_post): check_spam: spamd:
2011-06-30 15:39:02.964872500 21469 spamassassin plugin (data_post): check_spam: finished reading from spamd
2011-06-30 15:39:02.964875500 21469 spamassassin plugin (data_post): check_spam: No, hits=0.0, required=5.0, tests=RCVD_IN_DNSWL_NONE
2011-06-30 15:39:02.964877500 21469 Plugin spamassassin, hook data_post returned DECLINED,
2011-06-30 15:39:02.964879500 21469 running plugin (data_post): virus::clamav
2011-06-30 15:39:02.964881500 21469 virus::clamav plugin (data_post): Changing permissions on file to permit scanner access
2011-06-30 15:39:02.964892500 21469 virus::clamav plugin (data_post): Running: /usr/bin/clamdscan --stdout  --config-file=/etc/clamd.conf --no-summary /var/spool/qpsmtpd/1309441139:21469:0 2>&1
2011-06-30 15:39:02.975809500 21469 virus::clamav plugin (data_post): clamscan results: /var/spool/qpsmtpd/1309441139:21469:0: OK
2011-06-30 15:39:02.975812500 21469 Plugin virus::clamav, hook data_post returned DECLINED,
2011-06-30 15:39:02.975815500 21469 running plugin (queue): logging::logterse
2011-06-30 15:39:02.975817500 21469 logging::logterse plugin (queue): ` 212.97.32.73    smtp-out-05.comm2000.it smtp-out-05.comm2000.it <mittente@mittdom.it>      <destinatario@destdom.it>        queued          <ba84fc2e6efc7a495e1ec574e3abbb04.squirrel@webmail.kpnqwest.it> No, hits=0.0 required=5.0_
2011-06-30 15:39:02.975840500 21469 Plugin logging::logterse, hook queue returned DECLINED,
2011-06-30 15:39:02.975842500 21469 running plugin (queue): queue::qmail_2dqueue
2011-06-30 15:39:02.975844500 21479 queue::qmail_2dqueue plugin (queue): (for 21469 ) Queuing qp 21479 to /var/qmail/bin/qmail-queue
2011-06-30 15:39:02.984050500 21469 Plugin queue::qmail_2dqueue, hook queue returned OK, Queued! 1309441142 qp 21479 <ba84fc2e6efc7a495e1ec574e3abbb04.squirrel@webmail.kpnqwest.it>
2011-06-30 15:39:02.984346500 21469 250 Queued! 1309441142 qp 21479 <ba84fc2e6efc7a495e1ec574e3abbb04.squirrel@webmail.kpnqwest.it>
2011-06-30 15:39:02.984918500 21469 dispatching QUIT
2011-06-30 15:39:02.985117500 21469 221 destdom.it closing connection. Have a wonderful day.
2011-06-30 15:39:02.985178500 21469 click, disconnecting

Ho quindi eseguito un "signal-event post-upgrade; signal-event reboot"
ed ora ricevo le mail.
Il problema e' che ci continuano ad essere messaggi strani:

Code: [Select]
2011-06-30 16:22:27.495254500 5812 Plugin tls, hook rcpt returned DECLINED,
2011-06-30 16:22:27.495285500 5812 running plugin (rcpt): check_badmailfrom
2011-06-30 16:22:27.495346500 5812 Plugin check_badmailfrom, hook rcpt returned DECLINED,
2011-06-30 16:22:27.495390500 5812 running plugin (rcpt): check_badrcptto_patterns
2011-06-30 16:22:27.495452500 5812 Plugin check_badrcptto_patterns, hook rcpt returned DECLINED,
2011-06-30 16:22:27.495484500 5812 running plugin (rcpt): check_badrcptto
2011-06-30 16:22:27.495562500 5812 Plugin check_badrcptto, hook rcpt returned DECLINED,
2011-06-30 16:22:27.495594500 5812 running plugin (rcpt): check_goodrcptto
2011-06-30 16:22:27.495655500 5812 Plugin check_goodrcptto, hook rcpt returned DECLINED,
2011-06-30 16:22:27.495686500 5812 running plugin (rcpt): rcpt_ok
2011-06-30 16:22:27.495738500 5812 trying to get config for rcpthosts
2011-06-30 16:22:27.495999500 5812 Plugin rcpt_ok, hook rcpt returned OK,
2011-06-30 16:22:27.496093500 5812 250 <destinatario@destdom.it>, recipient ok
2011-06-30 16:22:27.496920500 5812 dispatching DATA
2011-06-30 16:22:27.497004500 5812 running plugin (data): tls
2011-06-30 16:22:27.497079500 5812 Plugin tls, hook data returned DECLINED,
2011-06-30 16:22:27.497190500 5812 354 go ahead
2011-06-30 16:22:27.497270500 5812 max_size: 50000000 / size: 0

Qualche idea?!?
Grazie.
filloweb

Offline Stefano

  • *
  • 10,850
  • +2/-0
Re: Errore - Plugin logging::logterse, hook queue returned DECLINED,
« Reply #1 on: June 30, 2011, 05:07:45 PM »
che versione di SME?

hai qualche customizzazione?

il messaggio รจ stato consegnato (queued), ma effettivamente quei declined non li riscontro nei log delle mie macchine..

Offline filloweb

  • ****
  • 166
  • +0/-0
Re: Errore - Plugin logging::logterse, hook queue returned DECLINED,
« Reply #2 on: June 30, 2011, 07:28:38 PM »
E' una 7.5.1 up2date installata in aprile.

leggevo che consigliano di reinstallare qmail con opzione force xke e' corrotto... mi sembra un po assurdo...
domani controllero' qualche altro sme che ho in giro ma onestamente non saprei...

dimenticavo che e' una virtuale su vsphere 4.1 con vmware tools installati... potrebbe influire? anche se ne ho altre 4 sparse in giro di virtuali e non ho avuto problemi...

grazie.
filloweb

Offline Stefano

  • *
  • 10,850
  • +2/-0
Re: Errore - Plugin logging::logterse, hook queue returned DECLINED,
« Reply #3 on: June 30, 2011, 09:48:18 PM »
leggevo che consigliano di reinstallare qmail con opzione force xke e' corrotto... mi sembra un po assurdo...

dove e chi consiglia una cosa del genere?  hai un link?