2025-04-05T17:39:49.955Z [DEBUG] [core] running mail hooks 2025-04-05T17:39:49.955Z [DEBUG] [core] running mail hook in guard plugin 2025-04-05T17:39:49.955Z [DEBUG] [core] hook=mail plugin=guard function=hook_mail params= retval=CONT msg="" 2025-04-05T17:39:49.955Z [DEBUG] [core] running mail hook in karma plugin 2025-04-05T17:39:49.955Z [DEBUG] [core] hook=mail plugin=karma function=hook_mail params= retval=CONT msg="" 2025-04-05T17:39:49.955Z [DEBUG] [core] running mail hook in mail_from.is_resolvable plugin 2025-04-05T17:39:49.956Z [DEBUG] [mail_from.is_resolvable] resolving MX for domain bgmcd.org 2025-04-05T17:39:50.023Z [DEBUG] [mail_from.is_resolvable] bgmcd.org: MX => [{"exchange":"mail.bgmcd.org","priority":10,"from_dns":"bgmcd.org","bind_helo":"bgmcd.org"}] 2025-04-05T17:39:50.155Z [DEBUG] [mail_from.is_resolvable] resolved MX => [{"exchange":"94.72.107.109","priority":10,"from_dns":"mail.bgmcd.org","bind_helo":"bgmcd.org"}] 2025-04-05T17:39:50.155Z [INFO] [mail_from.is_resolvable] pass:has_fwd_dns 2025-04-05T17:39:50.156Z [DEBUG] [core] hook=mail plugin=mail_from.is_resolvable function=hook_mail params= retval=CONT msg="" 2025-04-05T17:39:50.156Z [DEBUG] [core] running mail hook in mailauth/verify plugin 2025-04-05T17:39:50.217Z [DEBUG] [core] hook=mail plugin=mailauth/verify function=hook_mail params= retval=CONT msg="" 2025-04-05T17:39:50.217Z [DEBUG] [core] running mail hook in uribl plugin 2025-04-05T17:39:50.217Z [DEBUG] [uribl] (envfrom) found 1 items for lookup 2025-04-05T17:39:50.217Z [DEBUG] [uribl] (envfrom) checking: bgmcd.org 2025-04-05T17:39:50.264Z [DEBUG] [uribl] bgmcd.org.dbl.spamhaus.org. => (127.255.255.254) 2025-04-05T17:39:50.264Z [WARN] [uribl] ignoring result (127.255.255.254) for: bgmcd.org.dbl.spamhaus.org. as it did not match validation rule 2025-04-05T17:39:50.264Z [INFO] [uribl] found bgmcd.org in zone dbl.spamhaus.org (127.255.255.254) 2025-04-05T17:39:50.264Z [DEBUG] [core] hook=mail plugin=uribl function=lookup_mailfrom params= retval=CONT msg="" 2025-04-05T17:39:50.264Z [DEBUG] [core] running mail hook in known-senders plugin 2025-04-05T17:39:50.266Z [DEBUG] [known-senders] [] 2025-04-05T17:39:50.267Z [DEBUG] [core] hook=mail plugin=known-senders function=is_authenticated params= retval=CONT msg="" 2025-04-05T17:39:50.267Z [DEBUG] [core] running mail hook in bounce plugin 2025-04-05T17:39:50.267Z [DEBUG] [core] hook=mail plugin=bounce function=reject_all params= retval=CONT msg="" 2025-04-05T17:39:50.267Z [DEBUG] [core] running mail hook in log plugin 2025-04-05T17:39:50.267Z [PROTOCOL] [core] C: MAIL FROM: state=1 2025-04-05T17:39:50.267Z [DEBUG] [core] hook=mail plugin=log function=hook_mail params= retval=CONT msg="" 2025-04-05T17:39:50.268Z [DEBUG] [core] running mail hook in rcpt_database plugin 2025-04-05T17:39:50.270Z [DEBUG] [core] hook=mail plugin=rcpt_database function=is_remote_sender params= retval=CONT msg="" 2025-04-05T17:39:50.270Z [DEBUG] [core] running mail hook in dovecot_quota plugin 2025-04-05T17:39:50.270Z [DEBUG] [core] hook=mail plugin=dovecot_quota function=hook_mail params= retval=CONT msg="" 2025-04-05T17:39:50.270Z [NOTICE] [core] sender code=CONT msg="" 2025-04-05T17:39:50.270Z [PROTOCOL] [core] S: 250 sender OK 2025-04-05T17:39:50.271Z [PROTOCOL] [core] C: RCPT TO: state=1 2025-04-05T17:39:50.272Z [DEBUG] [core] running rcpt hooks 2025-04-05T17:39:50.272Z [DEBUG] [core] running rcpt hook in block_bad_connections plugin 2025-04-05T17:39:50.272Z [DEBUG] [core] hook=rcpt plugin=block_bad_connections function=hook_rcpt params= retval=CONT msg="" 2025-04-05T17:39:50.272Z [DEBUG] [core] running rcpt hook in karma plugin 2025-04-05T17:39:50.272Z [DEBUG] [core] hook=rcpt plugin=karma function=hook_rcpt params= retval=CONT msg="" 2025-04-05T17:39:50.272Z [DEBUG] [core] running rcpt hook in rcpt_database plugin 2025-04-05T17:39:50.279Z [INFO] [rcpt_database] ok, user found in user database 2025-04-05T17:39:50.284Z [INFO] [core] hook=rcpt plugin=rcpt_database function=database_rcpt params= retval=OK msg="" 2025-04-05T17:39:50.284Z [DEBUG] [core] running rcpt_ok hooks 2025-04-05T17:39:50.284Z [DEBUG] [core] running rcpt_ok hook in block_bad_connections plugin 2025-04-05T17:39:50.285Z [DEBUG] [core] hook=rcpt_ok plugin=block_bad_connections function=hook_rcpt_ok params="" retval=CONT msg="" 2025-04-05T17:39:50.285Z [DEBUG] [core] running rcpt_ok hook in karma plugin 2025-04-05T17:39:50.285Z [DEBUG] [core] hook=rcpt_ok plugin=karma function=hook_rcpt_ok params="" retval=CONT msg="" 2025-04-05T17:39:50.285Z [DEBUG] [core] running rcpt_ok hook in known-senders plugin 2025-04-05T17:39:50.285Z [DEBUG] [core] hook=rcpt_ok plugin=known-senders function=check_recipient params="" retval=CONT msg="" 2025-04-05T17:39:50.285Z [NOTICE] [core] recipient code=OK msg="" sender=postmaster+letsencrypt@bgmcd.org 2025-04-05T17:39:50.285Z [PROTOCOL] [core] S: 250 recipient OK 2025-04-05T17:39:50.287Z [PROTOCOL] [core] C: DATA state=1 2025-04-05T17:39:50.288Z [DEBUG] [core] running data hooks 2025-04-05T17:39:50.288Z [DEBUG] [core] running data hook in limits plugin 2025-04-05T17:39:50.288Z [DEBUG] [limits] Non-relaying IP or localhost, skipping... 2025-04-05T17:39:50.288Z [DEBUG] [core] hook=data plugin=limits function=hook_data params="" retval=CONT msg="" 2025-04-05T17:39:50.288Z [DEBUG] [core] running data hook in karma plugin 2025-04-05T17:39:50.288Z [DEBUG] [core] hook=data plugin=karma function=hook_data params="" retval=CONT msg="" 2025-04-05T17:39:50.288Z [DEBUG] [core] running data hook in early_talker plugin 2025-04-05T17:39:50.289Z [DEBUG] [core] hook=data plugin=early_talker function=early_talker params="" retval=CONT msg="" 2025-04-05T17:39:50.289Z [DEBUG] [core] running data hook in fcrdns plugin 2025-04-05T17:39:50.289Z [DEBUG] [core] hook=data plugin=fcrdns function=add_message_headers params="" retval=CONT msg="" 2025-04-05T17:39:50.289Z [DEBUG] [core] running data hook in uribl plugin 2025-04-05T17:39:50.289Z [DEBUG] [core] hook=data plugin=uribl function=enable_body_parsing params="" retval=CONT msg="" 2025-04-05T17:39:50.289Z [DEBUG] [core] running data hook in bounce plugin 2025-04-05T17:39:50.289Z [DEBUG] [core] hook=data plugin=bounce function=single_recipient params="" retval=CONT msg="" 2025-04-05T17:39:50.289Z [DEBUG] [core] running data hook in bounce plugin 2025-04-05T17:39:50.290Z [DEBUG] [core] hook=data plugin=bounce function=bad_rcpt params="" retval=CONT msg="" 2025-04-05T17:39:50.290Z [DEBUG] [core] running data hook in bounce plugin 2025-04-05T17:39:50.290Z [DEBUG] [core] hook=data plugin=bounce function=bounce_spf_enable params="" retval=CONT msg="" 2025-04-05T17:39:50.290Z [DEBUG] [core] running data hook in attachment plugin 2025-04-05T17:39:50.290Z [DEBUG] [core] hook=data plugin=attachment function=hook_data params="" retval=CONT msg="" 2025-04-05T17:39:50.290Z [DEBUG] [core] running data hook in clamd plugin 2025-04-05T17:39:50.290Z [DEBUG] [core] hook=data plugin=clamd function=hook_data params="" retval=CONT msg="" 2025-04-05T17:39:50.290Z [PROTOCOL] [core] S: 354 go ahead, make my day 2025-04-05T17:39:50.306Z [DEBUG] [core] running data_post hooks 2025-04-05T17:39:50.306Z [DEBUG] [core] running data_post hook in karma plugin 2025-04-05T17:39:50.307Z [DEBUG] [core] hook=data_post plugin=karma function=hook_data_post params="" retval=CONT msg="" 2025-04-05T17:39:50.307Z [DEBUG] [core] running data_post hook in p0f plugin 2025-04-05T17:39:50.307Z [DEBUG] [core] hook=data_post plugin=p0f function=add_p0f_header params="" retval=CONT msg="" 2025-04-05T17:39:50.307Z [DEBUG] [core] running data_post hook in mailauth/verify plugin 2025-04-05T17:39:50.375Z [DEBUG] [core] hook=data_post plugin=mailauth/verify function=hook_data_post params="" retval=CONT msg="" 2025-04-05T17:39:50.375Z [DEBUG] [core] running data_post hook in uribl plugin 2025-04-05T17:39:50.375Z [DEBUG] [uribl] (from) found 1 items for lookup 2025-04-05T17:39:50.375Z [DEBUG] [uribl] (from) checking: bgmcd.org 2025-04-05T17:39:50.376Z [DEBUG] [uribl] bgmcd.org.dbl.spamhaus.org. => (127.255.255.254) 2025-04-05T17:39:50.377Z [WARN] [uribl] ignoring result (127.255.255.254) for: bgmcd.org.dbl.spamhaus.org. as it did not match validation rule 2025-04-05T17:39:50.377Z [INFO] [uribl] found bgmcd.org in zone dbl.spamhaus.org (127.255.255.254) 2025-04-05T17:39:50.377Z [DEBUG] [uribl] (msgid) found 1 items for lookup 2025-04-05T17:39:50.377Z [DEBUG] [uribl] (msgid) checking: bgmcd.org 2025-04-05T17:39:50.377Z [DEBUG] [uribl] bgmcd.org.dbl.spamhaus.org. => (127.255.255.254) 2025-04-05T17:39:50.377Z [WARN] [uribl] ignoring result (127.255.255.254) for: bgmcd.org.dbl.spamhaus.org. as it did not match validation rule 2025-04-05T17:39:50.377Z [INFO] [uribl] found bgmcd.org in zone dbl.spamhaus.org (127.255.255.254) 2025-04-05T17:39:50.401Z [DEBUG] [uribl] (body) found 3 items for lookup 2025-04-05T17:39:50.401Z [DEBUG] [uribl] (body) checking: acme-v02.api.letsencrypt.org 2025-04-05T17:39:50.401Z [DEBUG] [uribl] (body) checking: bgmcd.org 2025-04-05T17:39:50.401Z [DEBUG] [uribl] (body) checking: lescript.info 2025-04-05T17:39:50.402Z [DEBUG] [uribl] bgmcd.org.dbl.spamhaus.org. => (127.255.255.254) 2025-04-05T17:39:50.402Z [WARN] [uribl] ignoring result (127.255.255.254) for: bgmcd.org.dbl.spamhaus.org. as it did not match validation rule 2025-04-05T17:39:50.402Z [INFO] [uribl] found bgmcd.org in zone dbl.spamhaus.org (127.255.255.254) 2025-04-05T17:39:54.457Z [DEBUG] [uribl] bgmcd.org.multi.surbl.org. => (Error: queryA ESERVFAIL bgmcd.org.multi.surbl.org.) 2025-04-05T17:39:54.497Z [DEBUG] [uribl] lescript.info.dbl.spamhaus.org. => (127.255.255.254) 2025-04-05T17:39:54.498Z [WARN] [uribl] ignoring result (127.255.255.254) for: lescript.info.dbl.spamhaus.org. as it did not match validation rule 2025-04-05T17:39:54.498Z [INFO] [uribl] found lescript.info in zone dbl.spamhaus.org (127.255.255.254) 2025-04-05T17:39:54.540Z [DEBUG] [uribl] acme-v02.api.letsencrypt.org.dbl.spamhaus.org. => (127.255.255.254) 2025-04-05T17:39:54.542Z [WARN] [uribl] ignoring result (127.255.255.254) for: acme-v02.api.letsencrypt.org.dbl.spamhaus.org. as it did not match validation rule 2025-04-05T17:39:54.543Z [INFO] [uribl] found acme-v02.api.letsencrypt.org in zone dbl.spamhaus.org (127.255.255.254) 2025-04-05T17:39:54.557Z [DEBUG] [uribl] letsencrypt.org.multi.uribl.com. => (127.0.0.1) 2025-04-05T17:39:54.557Z [DEBUG] [uribl] ignoring result (127.0.0.1) for: letsencrypt.org.multi.uribl.com. as the bitmask did not match 2025-04-05T17:39:55.559Z [DEBUG] [uribl] bgmcd.org.multi.uribl.com. => (Error: queryA ETIMEOUT bgmcd.org.multi.uribl.com.) 2025-04-05T17:39:55.559Z [DEBUG] [uribl] lescript.info.multi.uribl.com. => (Error: queryA ETIMEOUT lescript.info.multi.uribl.com.) 2025-04-05T17:39:55.559Z [DEBUG] [uribl] lescript.info.multi.surbl.org. => (Error: queryA ETIMEOUT lescript.info.multi.surbl.org.) 2025-04-05T17:39:56.345Z [DEBUG] [uribl] letsencrypt.org.multi.surbl.org. => (Error: queryA ETIMEOUT letsencrypt.org.multi.surbl.org.) 2025-04-05T17:39:56.345Z [DEBUG] [core] hook=data_post plugin=uribl function=lookup_header_zones params="" retval=CONT msg="" 2025-04-05T17:39:56.345Z [DEBUG] [core] running data_post hook in headers plugin 2025-04-05T17:39:56.346Z [DEBUG] [core] hook=data_post plugin=headers function=duplicate_singular params="" retval=CONT msg="" 2025-04-05T17:39:56.346Z [DEBUG] [core] running data_post hook in headers plugin 2025-04-05T17:39:56.346Z [DEBUG] [core] hook=data_post plugin=headers function=missing_required params="" retval=CONT msg="" 2025-04-05T17:39:56.346Z [DEBUG] [core] running data_post hook in headers plugin 2025-04-05T17:39:56.346Z [DEBUG] [core] hook=data_post plugin=headers function=invalid_return_path params="" retval=CONT msg="" 2025-04-05T17:39:56.346Z [DEBUG] [core] running data_post hook in headers plugin 2025-04-05T17:39:56.346Z [DEBUG] [headers] message date: Sat, 05 Apr 2025 18:39:50 +0100 2025-04-05T17:39:56.347Z [DEBUG] [core] hook=data_post plugin=headers function=invalid_date params="" retval=CONT msg="" 2025-04-05T17:39:56.347Z [DEBUG] [core] running data_post hook in headers plugin 2025-04-05T17:39:56.347Z [DEBUG] [core] hook=data_post plugin=headers function=user_agent params="" retval=CONT msg="" 2025-04-05T17:39:56.347Z [DEBUG] [core] running data_post hook in headers plugin 2025-04-05T17:39:56.347Z [DEBUG] [core] hook=data_post plugin=headers function=direct_to_mx params="" retval=CONT msg="" 2025-04-05T17:39:56.347Z [DEBUG] [core] running data_post hook in headers plugin 2025-04-05T17:39:56.349Z [DEBUG] [core] hook=data_post plugin=headers function=from_match params="" retval=CONT msg="" 2025-04-05T17:39:56.349Z [DEBUG] [core] running data_post hook in headers plugin 2025-04-05T17:39:56.349Z [DEBUG] [core] hook=data_post plugin=headers function=delivered_to params="" retval=CONT msg="" 2025-04-05T17:39:56.350Z [DEBUG] [core] running data_post hook in headers plugin 2025-04-05T17:39:56.350Z [DEBUG] [core] hook=data_post plugin=headers function=mailing_list params="" retval=CONT msg="" 2025-04-05T17:39:56.350Z [DEBUG] [core] running data_post hook in headers plugin 2025-04-05T17:39:56.350Z [DEBUG] [core] hook=data_post plugin=headers function=from_phish params="" retval=CONT msg="" 2025-04-05T17:39:56.350Z [DEBUG] [core] running data_post hook in known-senders plugin 2025-04-05T17:39:56.350Z [ERROR] [known-senders] is_dkim_authenticated: no sender_od 2025-04-05T17:39:56.350Z [DEBUG] [core] hook=data_post plugin=known-senders function=is_dkim_authenticated params="" retval=CONT msg="" 2025-04-05T17:39:56.350Z [DEBUG] [core] running data_post hook in bounce plugin 2025-04-05T17:39:56.350Z [DEBUG] [core] hook=data_post plugin=bounce function=empty_return_path params="" retval=CONT msg="" 2025-04-05T17:39:56.350Z [DEBUG] [core] running data_post hook in bounce plugin 2025-04-05T17:39:56.350Z [DEBUG] [core] hook=data_post plugin=bounce function=bounce_spf params="" retval=CONT msg="" 2025-04-05T17:39:56.350Z [DEBUG] [core] running data_post hook in bounce plugin 2025-04-05T17:39:56.351Z [DEBUG] [core] hook=data_post plugin=bounce function=non_local_msgid params="" retval=CONT msg="" 2025-04-05T17:39:56.351Z [DEBUG] [core] running data_post hook in rspamd plugin 2025-04-05T17:39:56.351Z [DEBUG] [core] hook=data_post plugin=rspamd function=hook_data_post params="" retval=CONT msg="" 2025-04-05T17:39:56.351Z [DEBUG] [core] running data_post hook in queue/decide plugin 2025-04-05T17:39:56.351Z [DEBUG] [core] hook=data_post plugin=queue/decide function=hook_data_post params="" retval=CONT msg="" 2025-04-05T17:39:56.351Z [DEBUG] [core] running data_post hook in rcpt_database plugin 2025-04-05T17:39:56.351Z [DEBUG] [core] hook=data_post plugin=rcpt_database function=hook_data_post params="" retval=CONT msg="" 2025-04-05T17:39:56.351Z [DEBUG] [core] running data_post hook in srs plugin 2025-04-05T17:39:56.351Z [DEBUG] [srs] SRS not applied (relaying: false, remote_source: false, remote_destination: undefined) 2025-04-05T17:39:56.351Z [DEBUG] [core] hook=data_post plugin=srs function=hook_data_post params="" retval=CONT msg="" 2025-04-05T17:39:56.352Z [DEBUG] [core] running data_post hook in dovecot_quota plugin 2025-04-05T17:39:56.352Z [DEBUG] [dovecot_quota] localhost is removed from quota, skipping 2025-04-05T17:39:56.352Z [DEBUG] [core] hook=data_post plugin=dovecot_quota function=hook_data_post params="" retval=CONT msg="" 2025-04-05T17:39:56.352Z [DEBUG] [core] running data_post hook in attachment plugin 2025-04-05T17:39:56.352Z [DEBUG] [core] hook=data_post plugin=attachment function=wait_for_attachment_hooks params="" retval=CONT msg="" 2025-04-05T17:39:56.352Z [DEBUG] [core] running data_post hook in attachment plugin 2025-04-05T17:39:56.352Z [DEBUG] [attachment] found content type: text/html 2025-04-05T17:39:56.352Z [DEBUG] [core] hook=data_post plugin=attachment function=check_attachments params="" retval=CONT msg="" 2025-04-05T17:39:56.352Z [DEBUG] [core] running data_post hook in clamd plugin 2025-04-05T17:39:56.352Z [DEBUG] [core] hook=data_post plugin=clamd function=hook_data_post params="" retval=CONT msg="" 2025-04-05T17:39:56.352Z [DEBUG] [core] running data_post hook in strict_from plugin 2025-04-05T17:39:56.352Z [DEBUG] [strict_from] skiping non-authenticated user 2025-04-05T17:39:56.352Z [DEBUG] [core] hook=data_post plugin=strict_from function=from_check params="" retval=CONT msg="" 2025-04-05T17:39:56.353Z [DEBUG] [core] running data_post hook in inspection plugin 2025-04-05T17:39:56.353Z [DEBUG] [core] hook=data_post plugin=inspection function=hook_data_post params="" retval=CONT msg="" 2025-04-05T17:39:56.353Z [DEBUG] [core] running data_post hook in geoip plugin 2025-04-05T17:39:56.353Z [DEBUG] [core] hook=data_post plugin=geoip function=add_headers params="" retval=CONT msg="" 2025-04-05T17:39:56.353Z [NOTICE] [core] message mid= size=4222 rcpts=1/0/0 delay=6.047 code=CONT msg="" 2025-04-05T17:39:56.354Z [DEBUG] [core] running queue hooks 2025-04-05T17:39:56.354Z [DEBUG] [core] running queue hook in karma plugin 2025-04-05T17:39:56.354Z [DEBUG] [core] hook=queue plugin=karma function=hook_queue params="" retval=CONT msg="" 2025-04-05T17:39:56.354Z [DEBUG] [core] running queue hook in discard plugin 2025-04-05T17:39:56.354Z [DEBUG] [core] hook=queue plugin=discard function=discard params="" retval=CONT msg="" 2025-04-05T17:39:56.354Z [DEBUG] [core] running queue hook in queue/dmarc-report-save plugin 2025-04-05T17:39:56.354Z [DEBUG] [core] hook=queue plugin=queue/dmarc-report-save function=hook_queue params="" retval=CONT msg="" 2025-04-05T17:39:56.354Z [DEBUG] [core] running queue hook in queue/quarantine plugin 2025-04-05T17:39:56.354Z [DEBUG] [core] hook=queue plugin=queue/quarantine function=quarantine params="" retval=CONT msg="" 2025-04-05T17:39:56.354Z [DEBUG] [core] running queue hook in queue/generic plugin 2025-04-05T17:39:56.354Z [DEBUG] [mailauth/dkim_sign] forwarding, using domain: bgmcd.org 2025-04-05T17:39:56.364Z [INFO] [core] hook=queue plugin=queue/generic function=hook_queue params="" retval=OK msg="Message Queued (67449D1A-5A89-4EAD-A745-246D36C68D66.1)" 2025-04-05T17:39:56.364Z [DEBUG] [core] running queue_ok hooks 2025-04-05T17:39:56.364Z [DEBUG] [core] running queue_ok hook in limits plugin 2025-04-05T17:39:56.364Z [DEBUG] [limits] increasing counters ["::/56"]: 1 2025-04-05T17:39:56.370Z [DEBUG] [core] hook=queue_ok plugin=limits function=hook_queue_ok params="Message Queued (67449D1A-5A89-4EAD-A745-246D36C68D66.1) (67449D1A-5A89-4EAD-A745-246D36C68D66.1)" retval=CONT msg="" 2025-04-05T17:39:56.370Z [DEBUG] [core] running queue_ok hook in stats plugin 2025-04-05T17:39:56.388Z [DEBUG] [core] hook=queue_ok plugin=stats function=hook_queue_ok params="Message Queued (67449D1A-5A89-4EAD-A745-246D36C68D66.1) (67449D1A-5A89-4EAD-A745-246D36C68D66.1)" retval=CONT msg="" 2025-04-05T17:39:56.388Z [DEBUG] [core] running queue_ok hook in known-senders plugin 2025-04-05T17:39:56.388Z [DEBUG] [core] hook=queue_ok plugin=known-senders function=update_sender params="Message Queued (67449D1A-5A89-4EAD-A745-246D36C68D66.1) (67449D1A-5A89-4EAD-A745-246D36C68D66.1)" retval=CONT msg="" 2025-04-05T17:39:56.388Z [DEBUG] [core] running queue_ok hook in queue/decide plugin 2025-04-05T17:39:56.388Z [DEBUG] [core] hook=queue_ok plugin=queue/decide function=hook_queue_ok params="Message Queued (67449D1A-5A89-4EAD-A745-246D36C68D66.1) (67449D1A-5A89-4EAD-A745-246D36C68D66.1)" retval=CONT msg="" 2025-04-05T17:39:56.388Z [DEBUG] [core] running queue_ok hook in watch plugin 2025-04-05T17:39:56.389Z [DEBUG] [core] hook=queue_ok plugin=watch function=queue_ok params="Message Queued (67449D1A-5A89-4EAD-A745-246D36C68D66.1) (67449D1A-5A89-4EAD-A745-246D36C68D66.1)" retval=CONT msg="" 2025-04-05T17:39:56.389Z [NOTICE] [core] queue code=OK msg="Message Queued (67449D1A-5A89-4EAD-A745-246D36C68D66.1) (67449D1A-5A89-4EAD-A745-246D36C68D66.1)" 2025-04-05T17:39:56.389Z [PROTOCOL] [core] S: 250 Message Queued (67449D1A-5A89-4EAD-A745-246D36C68D66.1) (67449D1A-5A89-4EAD-A745-246D36C68D66.1) 2025-04-05T17:39:56.389Z [DEBUG] [core] running reset_transaction hooks 2025-04-05T17:39:56.389Z [DEBUG] [core] running reset_transaction hook in stats plugin 2025-04-05T17:39:56.391Z [DEBUG] [core] hook=reset_transaction plugin=stats function=hook_reset_transaction params="" retval=CONT msg="" 2025-04-05T17:39:56.391Z [DEBUG] [core] running reset_transaction hook in karma plugin 2025-04-05T17:39:56.391Z [DEBUG] [core] hook=reset_transaction plugin=karma function=hook_reset_transaction params="" retval=CONT msg="" 2025-04-05T17:39:56.391Z [DEBUG] [core] running reset_transaction hook in log plugin 2025-04-05T17:39:56.391Z [DEBUG] [core] hook=reset_transaction plugin=log function=hook_reset_transaction params="" retval=CONT msg="" 2025-04-05T17:39:56.398Z [PROTOCOL] [core] C: QUIT state=1 2025-04-05T17:39:56.398Z [DEBUG] [core] running quit hooks 2025-04-05T17:39:56.398Z [PROTOCOL] [core] S: 221 bgmcd.org closing connection. Have a jolly good day. 2025-04-05T17:39:56.398Z [DEBUG] [core] client has disconnected 2025-04-05T17:39:56.399Z [DEBUG] [core] running disconnect hooks 2025-04-05T17:39:56.399Z [DEBUG] [core] client has disconnected 2025-04-05T17:39:56.399Z [DEBUG] [core] running disconnect hook in stats plugin 2025-04-05T17:39:56.400Z [DEBUG] [core] client has disconnected 2025-04-05T17:39:56.400Z [DEBUG] [core] hook=disconnect plugin=stats function=hook_disconnect params="" retval=CONT msg="" 2025-04-05T17:39:56.400Z [DEBUG] [core] client has disconnected 2025-04-05T17:39:56.400Z [DEBUG] [core] running disconnect hook in block_bad_connections plugin 2025-04-05T17:39:56.400Z [DEBUG] [core] Valid RCPT, skipping... 2025-04-05T17:39:56.400Z [DEBUG] [core] client has disconnected 2025-04-05T17:39:56.400Z [DEBUG] [core] hook=disconnect plugin=block_bad_connections function=hook_disconnect params="" retval=CONT msg="" 2025-04-05T17:39:56.400Z [DEBUG] [core] client has disconnected 2025-04-05T17:39:56.400Z [DEBUG] [core] running disconnect hook in karma plugin 2025-04-05T17:39:56.400Z [DEBUG] [core] client has disconnected 2025-04-05T17:39:56.400Z [DEBUG] [core] hook=disconnect plugin=karma function=hook_disconnect params="" retval=CONT msg="" 2025-04-05T17:39:56.405Z [DEBUG] [core] client has disconnected 2025-04-05T17:39:56.405Z [DEBUG] [core] running disconnect hook in log plugin 2025-04-05T17:39:56.405Z [DEBUG] [core] client has disconnected 2025-04-05T17:39:56.405Z [DEBUG] [core] hook=disconnect plugin=log function=hook_disconnect params="" retval=CONT msg="" 2025-04-05T17:39:56.405Z [DEBUG] [core] client has disconnected 2025-04-05T17:39:56.405Z [DEBUG] [core] running disconnect hook in tls plugin 2025-04-05T17:39:56.405Z [DEBUG] [core] client has disconnected 2025-04-05T17:39:56.406Z [DEBUG] [core] hook=disconnect plugin=tls function=hook_disconnect params="" retval=CONT msg="" 2025-04-05T17:39:56.406Z [NOTICE] [core] disconnect ip=::1 rdns=ip6-localhost helo=[127.0.0.1] relay=N early=N esmtp=Y tls=Y pipe=N errors=0 txns=1 rcpts=1/0/0 msgs=1/0/0 bytes=4222 lr="" time=6.66