2025-04-05T17:44:35.825Z [DEBUG] [core] running mail hooks 2025-04-05T17:44:35.825Z [DEBUG] [core] running mail hook in guard plugin 2025-04-05T17:44:35.825Z [DEBUG] [core] hook=mail plugin=guard function=hook_mail params= retval=CONT msg="" 2025-04-05T17:44:35.825Z [DEBUG] [core] running mail hook in karma plugin 2025-04-05T17:44:35.826Z [DEBUG] [core] hook=mail plugin=karma function=hook_mail params= retval=CONT msg="" 2025-04-05T17:44:35.826Z [DEBUG] [core] running mail hook in mail_from.is_resolvable plugin 2025-04-05T17:44:35.827Z [DEBUG] [mail_from.is_resolvable] resolving MX for domain gmail.com 2025-04-05T17:44:35.828Z [DEBUG] [core] pipeline: RCPT TO:\r 2025-04-05T17:44:35.828Z [DEBUG] [core] pipeline: RCPT TO:\r 2025-04-05T17:44:35.835Z [DEBUG] [mail_from.is_resolvable] gmail.com: MX => [{"exchange":"alt4.gmail-smtp-in.l.google.com","priority":40,"from_dns":"gmail.com","bind_helo":"bgmcd.org"},{"exchange":"alt2.gmail-smtp-in.l.google.com","priority":20,"from_dns":"gmail.com","bind_helo":"bgmcd.org"},{"exchange":"alt1.gmail-smtp-in.l.google.com","priority":10,"from_dns":"gmail.com","bind_helo":"bgmcd.org"},{"exchange":"gmail-smtp-in.l.google.com","priority":5,"from_dns":"gmail.com","bind_helo":"bgmcd.org"},{"exchange":"alt3.gmail-smtp-in.l.google.com","priority":30,"from_dns":"gmail.com","bind_helo":"bgmcd.org"}] 2025-04-05T17:44:35.938Z [DEBUG] [mail_from.is_resolvable] resolved MX => [{"exchange":"2404:6800:4003:c00::1a","priority":40,"from_dns":"alt4.gmail-smtp-in.l.google.com","bind_helo":"bgmcd.org"},{"exchange":"74.125.200.27","priority":40,"from_dns":"alt4.gmail-smtp-in.l.google.com","bind_helo":"bgmcd.org"},{"exchange":"2a00:1450:4025:c03::1a","priority":20,"from_dns":"alt2.gmail-smtp-in.l.google.com","bind_helo":"bgmcd.org"},{"exchange":"142.251.9.26","priority":20,"from_dns":"alt2.gmail-smtp-in.l.google.com","bind_helo":"bgmcd.org"},{"exchange":"2a00:1450:4013:c16::1b","priority":10,"from_dns":"alt1.gmail-smtp-in.l.google.com","bind_helo":"bgmcd.org"},{"exchange":"142.250.153.27","priority":10,"from_dns":"alt1.gmail-smtp-in.l.google.com","bind_helo":"bgmcd.org"},{"exchange":"2a00:1450:400c:c00::1b","priority":5,"from_dns":"gmail-smtp-in.l.google.com","bind_helo":"bgmcd.org"},{"exchange":"108.177.15.26","priority":5,"from_dns":"gmail-smtp-in.l.google.com","bind_helo":"bgmcd.org"},{"exchange":"2a00:1450:4010:c1c::1b","priority":30,"from_dns":"alt3.gmail-smtp-in.l.google.com","bind_helo":"bgmcd.org"},{"exchange":"142.250.150.26","priority":30,"from_dns":"alt3.gmail-smtp-in.l.google.com","bind_helo":"bgmcd.org"}] 2025-04-05T17:44:35.939Z [INFO] [mail_from.is_resolvable] pass:has_fwd_dns 2025-04-05T17:44:35.939Z [DEBUG] [core] hook=mail plugin=mail_from.is_resolvable function=hook_mail params= retval=CONT msg="" 2025-04-05T17:44:35.939Z [DEBUG] [core] running mail hook in mailauth/verify plugin 2025-04-05T17:44:35.999Z [DEBUG] [core] hook=mail plugin=mailauth/verify function=hook_mail params= retval=CONT msg="" 2025-04-05T17:44:35.999Z [DEBUG] [core] running mail hook in uribl plugin 2025-04-05T17:44:35.999Z [DEBUG] [uribl] (envfrom) found 1 items for lookup 2025-04-05T17:44:35.999Z [DEBUG] [uribl] (envfrom) checking: gmail.com 2025-04-05T17:44:36.027Z [DEBUG] [uribl] gmail.com.dbl.spamhaus.org. => (127.255.255.254) 2025-04-05T17:44:36.028Z [WARN] [uribl] ignoring result (127.255.255.254) for: gmail.com.dbl.spamhaus.org. as it did not match validation rule 2025-04-05T17:44:36.028Z [INFO] [uribl] found gmail.com in zone dbl.spamhaus.org (127.255.255.254) 2025-04-05T17:44:36.028Z [DEBUG] [core] hook=mail plugin=uribl function=lookup_mailfrom params= retval=CONT msg="" 2025-04-05T17:44:36.028Z [DEBUG] [core] running mail hook in known-senders plugin 2025-04-05T17:44:36.029Z [DEBUG] [known-senders] [ 'mail-wm1-f44.google.com' ] 2025-04-05T17:44:36.030Z [DEBUG] [core] hook=mail plugin=known-senders function=is_authenticated params= retval=CONT msg="" 2025-04-05T17:44:36.030Z [DEBUG] [core] running mail hook in bounce plugin 2025-04-05T17:44:36.030Z [DEBUG] [core] hook=mail plugin=bounce function=reject_all params= retval=CONT msg="" 2025-04-05T17:44:36.030Z [DEBUG] [core] running mail hook in log plugin 2025-04-05T17:44:36.030Z [PROTOCOL] [core] C: MAIL FROM: SIZE=31199 state=1 2025-04-05T17:44:36.030Z [DEBUG] [core] hook=mail plugin=log function=hook_mail params= retval=CONT msg="" 2025-04-05T17:44:36.030Z [DEBUG] [core] running mail hook in rcpt_database plugin 2025-04-05T17:44:36.037Z [DEBUG] [core] hook=mail plugin=rcpt_database function=is_remote_sender params= retval=CONT msg="" 2025-04-05T17:44:36.037Z [DEBUG] [core] running mail hook in dovecot_quota plugin 2025-04-05T17:44:36.037Z [DEBUG] [core] hook=mail plugin=dovecot_quota function=hook_mail params= retval=CONT msg="" 2025-04-05T17:44:36.037Z [NOTICE] [core] sender code=CONT msg="" 2025-04-05T17:44:36.038Z [PROTOCOL] [core] S: 250 sender OK 2025-04-05T17:44:36.038Z [PROTOCOL] [core] C: RCPT TO: state=1 2025-04-05T17:44:36.040Z [DEBUG] [core] running rcpt hooks 2025-04-05T17:44:36.042Z [DEBUG] [core] running rcpt hook in block_bad_connections plugin 2025-04-05T17:44:36.042Z [DEBUG] [core] hook=rcpt plugin=block_bad_connections function=hook_rcpt params= retval=CONT msg="" 2025-04-05T17:44:36.042Z [DEBUG] [core] running rcpt hook in karma plugin 2025-04-05T17:44:36.043Z [DEBUG] [core] hook=rcpt plugin=karma function=hook_rcpt params= retval=CONT msg="" 2025-04-05T17:44:36.043Z [DEBUG] [core] running rcpt hook in rcpt_database plugin 2025-04-05T17:44:36.043Z [DEBUG] [core] pipeline: DATA\r 2025-04-05T17:44:36.052Z [INFO] [rcpt_database] ok, user found in user database 2025-04-05T17:44:36.062Z [INFO] [rcpt_database] recipient redirects to beagroves@ik.me 2025-04-05T17:44:36.066Z [INFO] [core] hook=rcpt plugin=rcpt_database function=database_rcpt params= retval=OK msg="" 2025-04-05T17:44:36.066Z [DEBUG] [core] running rcpt_ok hooks 2025-04-05T17:44:36.066Z [DEBUG] [core] running rcpt_ok hook in block_bad_connections plugin 2025-04-05T17:44:36.067Z [DEBUG] [core] hook=rcpt_ok plugin=block_bad_connections function=hook_rcpt_ok params="" retval=CONT msg="" 2025-04-05T17:44:36.067Z [DEBUG] [core] running rcpt_ok hook in karma plugin 2025-04-05T17:44:36.067Z [DEBUG] [core] hook=rcpt_ok plugin=karma function=hook_rcpt_ok params="" retval=CONT msg="" 2025-04-05T17:44:36.067Z [DEBUG] [core] running rcpt_ok hook in known-senders plugin 2025-04-05T17:44:36.067Z [DEBUG] [core] hook=rcpt_ok plugin=known-senders function=check_recipient params="" retval=CONT msg="" 2025-04-05T17:44:36.067Z [NOTICE] [core] recipient code=OK msg="" sender=beagroves@gmail.com 2025-04-05T17:44:36.068Z [PROTOCOL] [core] S: 250 recipient OK 2025-04-05T17:44:36.068Z [PROTOCOL] [core] C: DATA state=1 2025-04-05T17:44:36.068Z [DEBUG] [core] running data hooks 2025-04-05T17:44:36.068Z [DEBUG] [core] running data hook in limits plugin 2025-04-05T17:44:36.068Z [DEBUG] [limits] Non-relaying IP or localhost, skipping... 2025-04-05T17:44:36.068Z [DEBUG] [core] hook=data plugin=limits function=hook_data params="" retval=CONT msg="" 2025-04-05T17:44:36.068Z [DEBUG] [core] running data hook in karma plugin 2025-04-05T17:44:36.069Z [DEBUG] [core] hook=data plugin=karma function=hook_data params="" retval=CONT msg="" 2025-04-05T17:44:36.069Z [DEBUG] [core] running data hook in early_talker plugin 2025-04-05T17:44:39.070Z [DEBUG] [core] hook=data plugin=early_talker function=early_talker params="" retval=CONT msg="" 2025-04-05T17:44:39.070Z [DEBUG] [core] running data hook in fcrdns plugin 2025-04-05T17:44:39.070Z [DEBUG] [core] hook=data plugin=fcrdns function=add_message_headers params="" retval=CONT msg="" 2025-04-05T17:44:39.070Z [DEBUG] [core] running data hook in uribl plugin 2025-04-05T17:44:39.070Z [DEBUG] [core] hook=data plugin=uribl function=enable_body_parsing params="" retval=CONT msg="" 2025-04-05T17:44:39.070Z [DEBUG] [core] running data hook in bounce plugin 2025-04-05T17:44:39.070Z [DEBUG] [core] hook=data plugin=bounce function=single_recipient params="" retval=CONT msg="" 2025-04-05T17:44:39.071Z [DEBUG] [core] running data hook in bounce plugin 2025-04-05T17:44:39.071Z [DEBUG] [core] hook=data plugin=bounce function=bad_rcpt params="" retval=CONT msg="" 2025-04-05T17:44:39.071Z [DEBUG] [core] running data hook in bounce plugin 2025-04-05T17:44:39.071Z [DEBUG] [core] hook=data plugin=bounce function=bounce_spf_enable params="" retval=CONT msg="" 2025-04-05T17:44:39.071Z [DEBUG] [core] running data hook in attachment plugin 2025-04-05T17:44:39.071Z [DEBUG] [core] hook=data plugin=attachment function=hook_data params="" retval=CONT msg="" 2025-04-05T17:44:39.071Z [DEBUG] [core] running data hook in clamd plugin 2025-04-05T17:44:39.071Z [DEBUG] [core] hook=data plugin=clamd function=hook_data params="" retval=CONT msg="" 2025-04-05T17:44:39.071Z [PROTOCOL] [core] S: 354 go ahead, make my day 2025-04-05T17:44:39.120Z [DEBUG] [attachment] found attachment file: logo-2024-a.jpg 2025-04-05T17:44:39.125Z [DEBUG] [attachment] found content type: image/jpeg 2025-04-05T17:44:39.126Z [INFO] [attachment] attach: [object Object] 2025-04-05T17:44:39.126Z [INFO] [attachment] file="logo-2024-a.jpg" ctype="image/jpeg; name="logo-2024-a.jpg"" md5=82427725182090d9f6051367b4e8b75c bytes=16668 2025-04-05T17:44:39.126Z [DEBUG] [core] running data_post hooks 2025-04-05T17:44:39.127Z [DEBUG] [core] running data_post hook in karma plugin 2025-04-05T17:44:39.127Z [DEBUG] [karma] adding header: score: 3, history: 0, awards: 089,131, asn_score: 0, fail:rcpt_to 2025-04-05T17:44:39.127Z [DEBUG] [core] hook=data_post plugin=karma function=hook_data_post params="" retval=CONT msg="" 2025-04-05T17:44:39.127Z [DEBUG] [core] running data_post hook in p0f plugin 2025-04-05T17:44:39.127Z [DEBUG] [p0f] adding header 2025-04-05T17:44:39.127Z [DEBUG] [core] hook=data_post plugin=p0f function=add_p0f_header params="" retval=CONT msg="" 2025-04-05T17:44:39.127Z [DEBUG] [core] running data_post hook in mailauth/verify plugin 2025-04-05T17:44:39.177Z [DEBUG] [core] hook=data_post plugin=mailauth/verify function=hook_data_post params="" retval=CONT msg="" 2025-04-05T17:44:39.177Z [DEBUG] [core] running data_post hook in uribl plugin 2025-04-05T17:44:39.178Z [DEBUG] [uribl] (from) found 1 items for lookup 2025-04-05T17:44:39.178Z [DEBUG] [uribl] (from) checking: gmail.com 2025-04-05T17:44:39.179Z [DEBUG] [uribl] gmail.com.dbl.spamhaus.org. => (127.255.255.254) 2025-04-05T17:44:39.179Z [WARN] [uribl] ignoring result (127.255.255.254) for: gmail.com.dbl.spamhaus.org. as it did not match validation rule 2025-04-05T17:44:39.179Z [INFO] [uribl] found gmail.com in zone dbl.spamhaus.org (127.255.255.254) 2025-04-05T17:44:39.179Z [DEBUG] [uribl] (msgid) found 1 items for lookup 2025-04-05T17:44:39.179Z [DEBUG] [uribl] (msgid) checking: gmail.com 2025-04-05T17:44:39.179Z [DEBUG] [uribl] gmail.com.dbl.spamhaus.org. => (127.255.255.254) 2025-04-05T17:44:39.179Z [WARN] [uribl] ignoring result (127.255.255.254) for: gmail.com.dbl.spamhaus.org. as it did not match validation rule 2025-04-05T17:44:39.179Z [INFO] [uribl] found gmail.com in zone dbl.spamhaus.org (127.255.255.254) 2025-04-05T17:44:39.179Z [DEBUG] [uribl] (body) no items found for lookup 2025-04-05T17:44:39.179Z [DEBUG] [core] hook=data_post plugin=uribl function=lookup_header_zones params="" retval=CONT msg="" 2025-04-05T17:44:39.179Z [DEBUG] [core] running data_post hook in headers plugin 2025-04-05T17:44:39.180Z [DEBUG] [core] hook=data_post plugin=headers function=duplicate_singular params="" retval=CONT msg="" 2025-04-05T17:44:39.180Z [DEBUG] [core] running data_post hook in headers plugin 2025-04-05T17:44:39.180Z [DEBUG] [core] hook=data_post plugin=headers function=missing_required params="" retval=CONT msg="" 2025-04-05T17:44:39.180Z [DEBUG] [core] running data_post hook in headers plugin 2025-04-05T17:44:39.180Z [DEBUG] [core] hook=data_post plugin=headers function=invalid_return_path params="" retval=CONT msg="" 2025-04-05T17:44:39.180Z [DEBUG] [core] running data_post hook in headers plugin 2025-04-05T17:44:39.180Z [DEBUG] [headers] message date: Sat, 5 Apr 2025 18:44:28 +0100 2025-04-05T17:44:39.180Z [DEBUG] [core] hook=data_post plugin=headers function=invalid_date params="" retval=CONT msg="" 2025-04-05T17:44:39.180Z [DEBUG] [core] running data_post hook in headers plugin 2025-04-05T17:44:39.180Z [DEBUG] [core] hook=data_post plugin=headers function=user_agent params="" retval=CONT msg="" 2025-04-05T17:44:39.181Z [DEBUG] [core] running data_post hook in headers plugin 2025-04-05T17:44:39.181Z [DEBUG] [core] hook=data_post plugin=headers function=direct_to_mx params="" retval=CONT msg="" 2025-04-05T17:44:39.181Z [DEBUG] [core] running data_post hook in headers plugin 2025-04-05T17:44:39.183Z [DEBUG] [core] hook=data_post plugin=headers function=from_match params="" retval=CONT msg="" 2025-04-05T17:44:39.183Z [DEBUG] [core] running data_post hook in headers plugin 2025-04-05T17:44:39.183Z [DEBUG] [core] hook=data_post plugin=headers function=delivered_to params="" retval=CONT msg="" 2025-04-05T17:44:39.183Z [DEBUG] [core] running data_post hook in headers plugin 2025-04-05T17:44:39.183Z [DEBUG] [core] hook=data_post plugin=headers function=mailing_list params="" retval=CONT msg="" 2025-04-05T17:44:39.183Z [DEBUG] [core] running data_post hook in headers plugin 2025-04-05T17:44:39.183Z [DEBUG] [core] hook=data_post plugin=headers function=from_phish params="" retval=CONT msg="" 2025-04-05T17:44:39.183Z [DEBUG] [core] running data_post hook in known-senders plugin 2025-04-05T17:44:39.184Z [ERROR] [known-senders] is_dkim_authenticated: no sender_od 2025-04-05T17:44:39.184Z [DEBUG] [core] hook=data_post plugin=known-senders function=is_dkim_authenticated params="" retval=CONT msg="" 2025-04-05T17:44:39.184Z [DEBUG] [core] running data_post hook in bounce plugin 2025-04-05T17:44:39.184Z [DEBUG] [core] hook=data_post plugin=bounce function=empty_return_path params="" retval=CONT msg="" 2025-04-05T17:44:39.184Z [DEBUG] [core] running data_post hook in bounce plugin 2025-04-05T17:44:39.184Z [DEBUG] [core] hook=data_post plugin=bounce function=bounce_spf params="" retval=CONT msg="" 2025-04-05T17:44:39.184Z [DEBUG] [core] running data_post hook in bounce plugin 2025-04-05T17:44:39.184Z [DEBUG] [core] hook=data_post plugin=bounce function=non_local_msgid params="" retval=CONT msg="" 2025-04-05T17:44:39.184Z [DEBUG] [core] running data_post hook in rspamd plugin 2025-04-05T17:44:40.087Z [INFO] [rspamd] action: no action, is_skipped: false, required_score: 15, score: -1, urls: www.bgmcd.org,asus1.sytes.net,social.bgmcd.uk, emails: beagroves@ik.me,beagroves@gmail.com,beagroves@outlook.com,bgmcd@e.email, time: 0.903 2025-04-05T17:44:40.088Z [DEBUG] [core] hook=data_post plugin=rspamd function=hook_data_post params="" retval=CONT msg="" 2025-04-05T17:44:40.088Z [DEBUG] [core] running data_post hook in queue/decide plugin 2025-04-05T17:44:40.088Z [DEBUG] [core] hook=data_post plugin=queue/decide function=hook_data_post params="" retval=CONT msg="" 2025-04-05T17:44:40.088Z [DEBUG] [core] running data_post hook in rcpt_database plugin 2025-04-05T17:44:40.088Z [DEBUG] [core] hook=data_post plugin=rcpt_database function=hook_data_post params="" retval=CONT msg="" 2025-04-05T17:44:40.088Z [DEBUG] [core] running data_post hook in srs plugin 2025-04-05T17:44:40.105Z [DEBUG] [srs] sender user: beagroves, sender host: gmail.com, redirector: bgmcd.org, rewritten: SRS0=f78d=WY=gmail.com=beagroves 2025-04-05T17:44:40.105Z [INFO] [srs] SRS applied. Changing sender from to . 2025-04-05T17:44:40.105Z [DEBUG] [srs] connection marked as relaying now 2025-04-05T17:44:40.105Z [DEBUG] [core] hook=data_post plugin=srs function=hook_data_post params="" retval=CONT msg="" 2025-04-05T17:44:40.105Z [DEBUG] [core] running data_post hook in dovecot_quota plugin 2025-04-05T17:44:40.106Z [DEBUG] [core] hook=data_post plugin=dovecot_quota function=hook_data_post params="" retval=CONT msg="" 2025-04-05T17:44:40.106Z [DEBUG] [core] running data_post hook in attachment plugin 2025-04-05T17:44:40.106Z [DEBUG] [core] hook=data_post plugin=attachment function=wait_for_attachment_hooks params="" retval=CONT msg="" 2025-04-05T17:44:40.107Z [DEBUG] [core] running data_post hook in attachment plugin 2025-04-05T17:44:40.107Z [DEBUG] [attachment] found content type: multipart/alternative 2025-04-05T17:44:40.107Z [DEBUG] [attachment] found content type: text/plain 2025-04-05T17:44:40.107Z [DEBUG] [attachment] found content type: multipart/related 2025-04-05T17:44:40.113Z [DEBUG] [core] hook=data_post plugin=attachment function=check_attachments params="" retval=CONT msg="" 2025-04-05T17:44:40.113Z [DEBUG] [core] running data_post hook in clamd plugin 2025-04-05T17:44:40.113Z [DEBUG] [clamd] trying host: /var/run/clamav/clamd.ctl 2025-04-05T17:44:40.115Z [DEBUG] [clamd] connected to host undefined:undefined 2025-04-05T17:44:40.267Z [PROTOCOL] [clamd] C:stream: OK 2025-04-05T17:44:40.268Z [INFO] [clamd] pass:clean 2025-04-05T17:44:40.268Z [DEBUG] [core] hook=data_post plugin=clamd function=hook_data_post params="" retval=CONT msg="" 2025-04-05T17:44:40.268Z [DEBUG] [core] running data_post hook in strict_from plugin 2025-04-05T17:44:40.268Z [DEBUG] [strict_from] skiping non-authenticated user 2025-04-05T17:44:40.268Z [DEBUG] [core] hook=data_post plugin=strict_from function=from_check params="" retval=CONT msg="" 2025-04-05T17:44:40.268Z [DEBUG] [core] running data_post hook in inspection plugin 2025-04-05T17:44:40.268Z [DEBUG] [core] hook=data_post plugin=inspection function=hook_data_post params="" retval=CONT msg="" 2025-04-05T17:44:40.268Z [DEBUG] [core] running data_post hook in geoip plugin 2025-04-05T17:44:40.269Z [INFO] [geoip] received=209.85.128.44 country=US 2025-04-05T17:44:40.269Z [INFO] [geoip] received=2a00:23c7:e486:e001:1051:faaf:d841:e854 country=GB 2025-04-05T17:44:40.269Z [DEBUG] [core] hook=data_post plugin=geoip function=add_headers params="" retval=CONT msg="" 2025-04-05T17:44:40.269Z [NOTICE] [core] message mid=<5b795af0-344e-4626-bd89-06195ddac757@gmail.com> size=31202 rcpts=1/0/0 delay=1.143 code=CONT msg="" 2025-04-05T17:44:40.269Z [DEBUG] [core] running queue_outbound hooks 2025-04-05T17:44:40.269Z [DEBUG] [core] running queue_outbound hook in karma plugin 2025-04-05T17:44:40.270Z [DEBUG] [karma] applied relaying:6 2025-04-05T17:44:40.270Z [DEBUG] [core] hook=queue_outbound plugin=karma function=hook_queue_outbound params="" retval=CONT msg="" 2025-04-05T17:44:40.270Z [DEBUG] [core] running queue_outbound hook in outbound_parameters plugin 2025-04-05T17:44:40.272Z [DEBUG] [core] hook=queue_outbound plugin=outbound_parameters function=hook_queue_outbound params="" retval=CONT msg="" 2025-04-05T17:44:40.273Z [DEBUG] [core] running queue_outbound hook in mailauth/dkim_sign plugin 2025-04-05T17:44:40.273Z [DEBUG] [mailauth/dkim_sign] forwarding, using domain: bgmcd.org 2025-04-05T17:44:40.274Z [ERROR] [mailauth/dkim_sign] error: Error: ENOENT: no such file or directory, stat '/opt/haraka-smtp/config/dkim/bgmcd.org' 2025-04-05T17:44:40.275Z [DEBUG] [mailauth/dkim_sign] domain: bgmcd.org, selector: undefined, private_key: undefined 2025-04-05T17:44:40.275Z [ERROR] [mailauth/dkim_sign] missing domain, selector or private_key 2025-04-05T17:44:40.275Z [DEBUG] [core] hook=queue_outbound plugin=mailauth/dkim_sign function=hook_queue_outbound params="" retval=CONT msg="" 2025-04-05T17:44:40.275Z [DEBUG] [core] running queue_outbound hook in mailauth/arc plugin 2025-04-05T17:44:40.275Z [DEBUG] [mailauth/arc] forwarding, using domain: bgmcd.org 2025-04-05T17:44:40.275Z [ERROR] [mailauth/arc] error: Error: ENOENT: no such file or directory, stat '/opt/haraka-smtp/config/dkim/bgmcd.org' 2025-04-05T17:44:40.276Z [DEBUG] [mailauth/arc] domain: bgmcd.org, selector: undefined, private_key: undefined 2025-04-05T17:44:40.276Z [ERROR] [mailauth/arc] missing domain, selector or private_key 2025-04-05T17:44:40.276Z [DEBUG] [core] hook=queue_outbound plugin=mailauth/arc function=hook_queue_outbound params="" retval=CONT msg="" 2025-04-05T17:44:40.276Z [DEBUG] [core] running queue_outbound hook in discard plugin 2025-04-05T17:44:40.276Z [DEBUG] [core] hook=queue_outbound plugin=discard function=discard params="" retval=CONT msg="" 2025-04-05T17:44:40.276Z [DEBUG] [core] running queue_outbound hook in privacy plugin 2025-04-05T17:44:40.278Z [DEBUG] [privacy] removing header "x-haraka-fcrdns: ["mail-wm1-f44.google.com","mail-wm1-f44.google.com\n"]" 2025-04-05T17:44:40.279Z [DEBUG] [privacy] removing header "x-haraka-karma: ["score: 3, history: 0, awards: 089,131, asn_score: 0, fail:rcpt_to"]" 2025-04-05T17:44:40.279Z [DEBUG] [privacy] removing header "x-p0f-result: ["os=\"Linux 2.2.x-3.x\" link_type=\"DSL\" distance=5 total_conn=1"]" 2025-04-05T17:44:40.279Z [DEBUG] [privacy] removing header "x-rspamd-bar: ["-"]" 2025-04-05T17:44:40.279Z [DEBUG] [privacy] removing header "x-rspamd-report: ["DMARC_POLICY_ALLOW(-0.5) R_DKIM_ALLOW(-0.2) MIME_GOOD(-0.1) R_SPF_ALLOW(-0.2)"]" 2025-04-05T17:44:40.279Z [DEBUG] [privacy] removing header "x-rspamd-score: ["-1"]" 2025-04-05T17:44:40.279Z [DEBUG] [privacy] removing header "x-haraka-geoip: ["US"]" 2025-04-05T17:44:40.279Z [DEBUG] [privacy] removing header "x-haraka-geoip-received: ["209.85.128.44:US,2a00:23c7:e486:e001:1051:faaf:d841:e854:GB"]" 2025-04-05T17:44:40.279Z [DEBUG] [privacy] hiding IP from header Received: "from mail-wm1-f44.google.com (mail-wm1-f44.google.com [209.85.128.44])\r\n\tby bgmcd.org (Haraka) with ESMTPS id E1FECCE5-70EF-4218-BF46-F763EF6B1E7D.1\r\n\tenvelope-from \r\n\ttls TLS_AES_256_GCM_SHA384;\r\n\tSat, 05 Apr 2025 17:44:36 +0000\n" 2025-04-05T17:44:40.280Z [DEBUG] [core] hook=queue_outbound plugin=privacy function=hook_queue_outbound params="" retval=CONT msg="" 2025-04-05T17:44:40.280Z [DEBUG] [core] running queue_outbound hook in queue/quarantine plugin 2025-04-05T17:44:40.280Z [DEBUG] [core] hook=queue_outbound plugin=queue/quarantine function=quarantine params="" retval=CONT msg="" 2025-04-05T17:44:40.281Z [NOTICE] [core] queue code=CONT msg="Message Queued (E1FECCE5-70EF-4218-BF46-F763EF6B1E7D.1)" 2025-04-05T17:44:40.281Z [DEBUG] [mailauth/dkim_sign] forwarding, using domain: bgmcd.org 2025-04-05T17:44:40.284Z [DEBUG] [mailauth/arc] forwarding, using domain: bgmcd.org 2025-04-05T17:44:40.309Z [DEBUG] [core] running queue_ok hooks 2025-04-05T17:44:40.310Z [DEBUG] [core] running queue_ok hook in limits plugin 2025-04-05T17:44:40.310Z [DEBUG] [limits] increasing counters ["209.85.128.44/32"]: 1 2025-04-05T17:44:40.312Z [DEBUG] [core] hook=queue_ok plugin=limits function=hook_queue_ok params="Message Queued (E1FECCE5-70EF-4218-BF46-F763EF6B1E7D.1)" retval=CONT msg="" 2025-04-05T17:44:40.312Z [DEBUG] [core] running queue_ok hook in stats plugin 2025-04-05T17:44:40.328Z [DEBUG] [core] hook=queue_ok plugin=stats function=hook_queue_ok params="Message Queued (E1FECCE5-70EF-4218-BF46-F763EF6B1E7D.1)" retval=CONT msg="" 2025-04-05T17:44:40.328Z [DEBUG] [core] running queue_ok hook in known-senders plugin 2025-04-05T17:44:40.329Z [INFO] [known-senders] saved bgmcd.org : ik.me : 2 2025-04-05T17:44:40.330Z [DEBUG] [core] hook=queue_ok plugin=known-senders function=update_sender params="Message Queued (E1FECCE5-70EF-4218-BF46-F763EF6B1E7D.1)" retval=CONT msg="" 2025-04-05T17:44:40.330Z [DEBUG] [core] running queue_ok hook in queue/decide plugin 2025-04-05T17:44:40.330Z [DEBUG] [core] hook=queue_ok plugin=queue/decide function=hook_queue_ok params="Message Queued (E1FECCE5-70EF-4218-BF46-F763EF6B1E7D.1)" retval=CONT msg="" 2025-04-05T17:44:40.330Z [DEBUG] [core] running queue_ok hook in watch plugin 2025-04-05T17:44:40.331Z [DEBUG] [core] hook=queue_ok plugin=watch function=queue_ok params="Message Queued (E1FECCE5-70EF-4218-BF46-F763EF6B1E7D.1)" retval=CONT msg="" 2025-04-05T17:44:40.331Z [NOTICE] [core] queue code=OK msg="Message Queued (E1FECCE5-70EF-4218-BF46-F763EF6B1E7D.1)" 2025-04-05T17:44:40.331Z [PROTOCOL] [core] S: 250 Message Queued (E1FECCE5-70EF-4218-BF46-F763EF6B1E7D.1) 2025-04-05T17:44:40.331Z [DEBUG] [core] running reset_transaction hooks 2025-04-05T17:44:40.331Z [DEBUG] [core] running reset_transaction hook in stats plugin 2025-04-05T17:44:40.335Z [DEBUG] [core] hook=reset_transaction plugin=stats function=hook_reset_transaction params="" retval=CONT msg="" 2025-04-05T17:44:40.336Z [DEBUG] [core] running reset_transaction hook in karma plugin 2025-04-05T17:44:40.336Z [INFO] [karma] score: 11, history: 0, awards: 089,131,182,232, asn_score: 0, pass:relaying, fail:rcpt_to 2025-04-05T17:44:40.336Z [DEBUG] [core] hook=reset_transaction plugin=karma function=hook_reset_transaction params="" retval=CONT msg="" 2025-04-05T17:44:40.336Z [DEBUG] [core] running reset_transaction hook in log plugin 2025-04-05T17:44:40.337Z [DEBUG] [core] hook=reset_transaction plugin=log function=hook_reset_transaction params="" retval=CONT msg="" 2025-04-05T17:44:40.346Z [PROTOCOL] [core] C: QUIT state=1 2025-04-05T17:44:40.346Z [DEBUG] [core] running quit hooks 2025-04-05T17:44:40.346Z [PROTOCOL] [core] S: 221 bgmcd.org closing connection. Have a jolly good day. 2025-04-05T17:44:40.347Z [DEBUG] [core] client has disconnected 2025-04-05T17:44:40.347Z [DEBUG] [core] running disconnect hooks 2025-04-05T17:44:40.347Z [DEBUG] [core] client has disconnected 2025-04-05T17:44:40.347Z [DEBUG] [core] running disconnect hook in stats plugin 2025-04-05T17:44:40.349Z [DEBUG] [core] client has disconnected 2025-04-05T17:44:40.349Z [DEBUG] [core] hook=disconnect plugin=stats function=hook_disconnect params="" retval=CONT msg="" 2025-04-05T17:44:40.349Z [DEBUG] [core] client has disconnected 2025-04-05T17:44:40.349Z [DEBUG] [core] running disconnect hook in block_bad_connections plugin 2025-04-05T17:44:40.349Z [DEBUG] [core] Valid RCPT, skipping... 2025-04-05T17:44:40.349Z [DEBUG] [core] client has disconnected 2025-04-05T17:44:40.349Z [DEBUG] [core] hook=disconnect plugin=block_bad_connections function=hook_disconnect params="" retval=CONT msg="" 2025-04-05T17:44:40.349Z [DEBUG] [core] client has disconnected 2025-04-05T17:44:40.349Z [DEBUG] [core] running disconnect hook in karma plugin 2025-04-05T17:44:40.350Z [INFO] [karma] score: 11, history: 0, awards: 089,131,182,232, asn_score: 0, pass:relaying, fail:rcpt_to 2025-04-05T17:44:40.350Z [DEBUG] [core] client has disconnected 2025-04-05T17:44:40.350Z [DEBUG] [core] hook=disconnect plugin=karma function=hook_disconnect params="" retval=CONT msg="" 2025-04-05T17:44:40.350Z [DEBUG] [core] client has disconnected 2025-04-05T17:44:40.350Z [DEBUG] [core] running disconnect hook in log plugin 2025-04-05T17:44:40.350Z [DEBUG] [core] client has disconnected 2025-04-05T17:44:40.350Z [DEBUG] [core] hook=disconnect plugin=log function=hook_disconnect params="" retval=CONT msg="" 2025-04-05T17:44:40.350Z [DEBUG] [core] client has disconnected 2025-04-05T17:44:40.350Z [DEBUG] [core] running disconnect hook in tls plugin 2025-04-05T17:44:40.350Z [DEBUG] [core] client has disconnected 2025-04-05T17:44:40.350Z [DEBUG] [core] hook=disconnect plugin=tls function=hook_disconnect params="" retval=CONT msg="" 2025-04-05T17:44:40.350Z [NOTICE] [core] disconnect ip=209.85.128.44 rdns=mail-wm1-f44.google.com helo=mail-wm1-f44.google.com relay=N early=N esmtp=Y tls=Y pipe=Y errors=0 txns=1 rcpts=1/0/0 msgs=1/0/0 bytes=31202 lr="" time=9.009 2025-04-05T17:44:40.354Z [DEBUG] [karma] unsubsubscribed from result-E1FECCE5-70EF-4218-BF46-F763EF6B1E7D*