2025-04-05T17:39:49.798Z [NOTICE] [core] connect ip=::1 port=60366 local_ip=::1 local_port=25
2025-04-05T17:39:49.799Z [DEBUG] [core] running connect_init hooks
2025-04-05T17:39:49.799Z [DEBUG] [core] running connect_init hook in guard plugin
2025-04-05T17:39:49.819Z [DEBUG] [core] hook=connect_init plugin=guard function=hook_connect_init params="" retval=CONT msg=""
2025-04-05T17:39:49.819Z [DEBUG] [core] running connect_init hook in karma plugin
2025-04-05T17:39:49.820Z [DEBUG] [karma] skipping
2025-04-05T17:39:49.820Z [DEBUG] [core] hook=connect_init plugin=karma function=results_init params="" retval=CONT msg=""
2025-04-05T17:39:49.820Z [DEBUG] [core] running connect_init hook in karma plugin
2025-04-05T17:39:49.820Z [DEBUG] [core] hook=connect_init plugin=karma function=ip_history_from_redis params="" retval=CONT msg=""
2025-04-05T17:39:49.820Z [DEBUG] [core] running connect_init hook in early_talker plugin
2025-04-05T17:39:49.820Z [DEBUG] [core] hook=connect_init plugin=early_talker function=early_talker params="" retval=CONT msg=""
2025-04-05T17:39:49.820Z [DEBUG] [core] running connect_init hook in fcrdns plugin
2025-04-05T17:39:49.821Z [DEBUG] [core] hook=connect_init plugin=fcrdns function=initialize_fcrdns params="" retval=CONT msg=""
2025-04-05T17:39:49.821Z [DEBUG] [core] running connect_init hook in relay plugin
2025-04-05T17:39:49.821Z [DEBUG] [relay] checking ::1 in relay_acl_allow
2025-04-05T17:39:49.821Z [DEBUG] [relay] checking if ::1 is in 127.0.0.1/24
2025-04-05T17:39:49.822Z [DEBUG] [relay] checking if ::1 is in 172.17.0.4/32
2025-04-05T17:39:49.822Z [DEBUG] [core] hook=connect_init plugin=relay function=acl params="" retval=CONT msg=""
2025-04-05T17:39:49.822Z [DEBUG] [core] running connect_init_respond
2025-04-05T17:39:49.822Z [DEBUG] [core] running lookup_rdns hooks
2025-04-05T17:39:49.823Z [DEBUG] [core] running lookup_rdns hook in p0f plugin
2025-04-05T17:39:49.823Z [DEBUG] [core] hook=lookup_rdns plugin=p0f function=query_p0f params="" retval=CONT msg=""
2025-04-05T17:39:49.823Z [DEBUG] [core] running lookup_rdns hook in fcrdns plugin
2025-04-05T17:39:49.823Z [DEBUG] [core] hook=lookup_rdns plugin=fcrdns function=do_dns_lookups params="" retval=CONT msg=""
2025-04-05T17:39:49.823Z [DEBUG] [core] running lookup_rdns hook in uribl plugin
2025-04-05T17:39:49.826Z [DEBUG] [uribl] (rdns) found 2 items for lookup
2025-04-05T17:39:49.826Z [DEBUG] [uribl] (rdns) checking: ip6-localhost
2025-04-05T17:39:49.826Z [DEBUG] [uribl] (rdns) checking: ip6-loopback
2025-04-05T17:39:49.827Z [DEBUG] [core] hook=lookup_rdns plugin=uribl function=lookup_remote_ip params="" retval=CONT msg=""
2025-04-05T17:39:49.827Z [DEBUG] [core] running lookup_rdns hook in asn plugin
2025-04-05T17:39:49.827Z [DEBUG] [core] hook=lookup_rdns plugin=asn function=lookup_via_dns params="" retval=CONT msg=""
2025-04-05T17:39:49.827Z [DEBUG] [core] running connect hooks
2025-04-05T17:39:49.827Z [DEBUG] [core] running connect hook in guard plugin
2025-04-05T17:39:49.827Z [DEBUG] [core] hook=connect plugin=guard function=hook_connect params="" retval=CONT msg=""
2025-04-05T17:39:49.827Z [DEBUG] [core] running connect hook in karma plugin
2025-04-05T17:39:49.827Z [DEBUG] [core] hook=connect plugin=karma function=hook_connect params="" retval=CONT msg=""
2025-04-05T17:39:49.828Z [DEBUG] [core] running connect hook in dns-list plugin
2025-04-05T17:39:49.828Z [INFO] [dns-list] skip:private: ::1
2025-04-05T17:39:49.828Z [DEBUG] [core] hook=connect plugin=dns-list function=onConnect params="" retval=CONT msg=""
2025-04-05T17:39:49.828Z [DEBUG] [core] running connect hook in relay plugin
2025-04-05T17:39:49.829Z [DEBUG] [core] hook=connect plugin=relay function=pass_relaying params="" retval=CONT msg=""
2025-04-05T17:39:49.829Z [DEBUG] [core] running connect hook in geoip plugin
2025-04-05T17:39:49.832Z [DEBUG] [core] hook=connect plugin=geoip function=lookup_maxmind params="" retval=CONT msg=""
2025-04-05T17:39:49.832Z [PROTOCOL] [core] S: 220 bgmcd.org ESMTP Haraka ready
2025-04-05T17:39:49.835Z [PROTOCOL] [core] C: EHLO [127.0.0.1] state=1
2025-04-05T17:39:49.836Z [DEBUG] [core] running ehlo hooks
2025-04-05T17:39:49.836Z [DEBUG] [core] running ehlo hook in hello_block plugin
2025-04-05T17:39:49.836Z [DEBUG] [core] hook=ehlo plugin=hello_block function=check_ymlf params=[127.0.0.1] retval=CONT msg=""
2025-04-05T17:39:49.836Z [DEBUG] [core] running ehlo hook in karma plugin
2025-04-05T17:39:49.836Z [DEBUG] [core] hook=ehlo plugin=karma function=hook_ehlo params=[127.0.0.1] retval=CONT msg=""
2025-04-05T17:39:49.836Z [DEBUG] [core] running ehlo hook in helo.checks plugin
2025-04-05T17:39:49.837Z [DEBUG] [core] hook=ehlo plugin=helo.checks function=proto_mismatch_esmtp params=[127.0.0.1] retval=CONT msg=""
2025-04-05T17:39:49.837Z [DEBUG] [core] running ehlo hook in helo.checks plugin
2025-04-05T17:39:49.837Z [DEBUG] [core] hook=ehlo plugin=helo.checks function=init params=[127.0.0.1] retval=CONT msg=""
2025-04-05T17:39:49.838Z [DEBUG] [core] running ehlo hook in helo.checks plugin
2025-04-05T17:39:49.838Z [DEBUG] [core] hook=ehlo plugin=helo.checks function=match_re params=[127.0.0.1] retval=CONT msg=""
2025-04-05T17:39:49.838Z [DEBUG] [core] running ehlo hook in helo.checks plugin
2025-04-05T17:39:49.838Z [DEBUG] [core] hook=ehlo plugin=helo.checks function=bare_ip params=[127.0.0.1] retval=CONT msg=""
2025-04-05T17:39:49.838Z [DEBUG] [core] running ehlo hook in helo.checks plugin
2025-04-05T17:39:49.838Z [DEBUG] [core] hook=ehlo plugin=helo.checks function=dynamic params=[127.0.0.1] retval=CONT msg=""
2025-04-05T17:39:49.838Z [DEBUG] [core] running ehlo hook in helo.checks plugin
2025-04-05T17:39:49.839Z [DEBUG] [core] hook=ehlo plugin=helo.checks function=big_company params=[127.0.0.1] retval=CONT msg=""
2025-04-05T17:39:49.839Z [DEBUG] [core] running ehlo hook in helo.checks plugin
2025-04-05T17:39:49.839Z [DEBUG] [core] hook=ehlo plugin=helo.checks function=valid_hostname params=[127.0.0.1] retval=CONT msg=""
2025-04-05T17:39:49.839Z [DEBUG] [core] running ehlo hook in helo.checks plugin
2025-04-05T17:39:49.844Z [DEBUG] [core] hook=ehlo plugin=helo.checks function=rdns_match params=[127.0.0.1] retval=CONT msg=""
2025-04-05T17:39:49.844Z [DEBUG] [core] running ehlo hook in helo.checks plugin
2025-04-05T17:39:49.844Z [DEBUG] [core] hook=ehlo plugin=helo.checks function=forward_dns params=[127.0.0.1] retval=CONT msg=""
2025-04-05T17:39:49.844Z [DEBUG] [core] running ehlo hook in helo.checks plugin
2025-04-05T17:39:49.844Z [DEBUG] [core] hook=ehlo plugin=helo.checks function=host_mismatch params=[127.0.0.1] retval=CONT msg=""
2025-04-05T17:39:49.845Z [DEBUG] [core] running ehlo hook in helo.checks plugin
2025-04-05T17:39:49.845Z [DEBUG] [core] hook=ehlo plugin=helo.checks function=literal_mismatch params=[127.0.0.1] retval=CONT msg=""
2025-04-05T17:39:49.845Z [DEBUG] [core] running ehlo hook in helo.checks plugin
2025-04-05T17:39:49.845Z [INFO] [helo.checks] helo_host: [127.0.0.1], skip:proto_mismatch(private), match_re(private), bare_ip(private), dynamic(private), big_company(private), valid_hostname(private), rdns_match(private), forward_dns(private), host_mismatch(private), literal_mismatch(private)
2025-04-05T17:39:49.845Z [DEBUG] [core] hook=ehlo plugin=helo.checks function=emit_log params=[127.0.0.1] retval=CONT msg=""
2025-04-05T17:39:49.845Z [DEBUG] [core] running ehlo hook in mailauth/verify plugin
2025-04-05T17:39:49.845Z [DEBUG] [core] hook=ehlo plugin=mailauth/verify function=mailauth_helo params=[127.0.0.1] retval=CONT msg=""
2025-04-05T17:39:49.845Z [DEBUG] [core] running ehlo hook in uribl plugin
2025-04-05T17:39:49.845Z [DEBUG] [uribl] (helo) found 1 items for lookup
2025-04-05T17:39:49.845Z [DEBUG] [uribl] (helo) checking: 127.0.0.1
2025-04-05T17:39:49.846Z [DEBUG] [core] hook=ehlo plugin=uribl function=lookup_ehlo params=[127.0.0.1] retval=CONT msg=""
2025-04-05T17:39:49.846Z [DEBUG] [core] running capabilities hooks
2025-04-05T17:39:49.846Z [DEBUG] [core] running capabilities hook in auth/poste plugin
2025-04-05T17:39:49.846Z [DEBUG] [core] hook=capabilities plugin=auth/poste function=hook_capabilities params="" retval=CONT msg=""
2025-04-05T17:39:49.846Z [DEBUG] [core] running capabilities hook in status_http plugin
2025-04-05T17:39:49.847Z [DEBUG] [core] hook=capabilities plugin=status_http function=hook_capabilities params="" retval=CONT msg=""
2025-04-05T17:39:49.847Z [DEBUG] [core] running capabilities hook in tls plugin
2025-04-05T17:39:49.848Z [DEBUG] [core] hook=capabilities plugin=tls function=advertise_starttls params="" retval=CONT msg=""
2025-04-05T17:39:49.848Z [PROTOCOL] [core] S: 250-bgmcd.org Hello ip6-localhost [::1], , Poste.io is at your service
2025-04-05T17:39:49.848Z [PROTOCOL] [core] S: 250-PIPELINING
2025-04-05T17:39:49.849Z [PROTOCOL] [core] S: 250-8BITMIME
2025-04-05T17:39:49.849Z [PROTOCOL] [core] S: 250-SMTPUTF8
2025-04-05T17:39:49.849Z [PROTOCOL] [core] S: 250-SIZE 26214400
2025-04-05T17:39:49.849Z [PROTOCOL] [core] S: 250-STATUS
2025-04-05T17:39:49.849Z [PROTOCOL] [core] S: 250 STARTTLS
2025-04-05T17:39:49.864Z [PROTOCOL] [core] C: STARTTLS state=1
2025-04-05T17:39:49.870Z [DEBUG] [core] running unrecognized_command hooks
2025-04-05T17:39:49.871Z [DEBUG] [core] running unrecognized_command hook in auth/poste plugin
2025-04-05T17:39:49.871Z [DEBUG] [core] hook=unrecognized_command plugin=auth/poste function=hook_unrecognized_command params=STARTTLS retval=CONT msg=""
2025-04-05T17:39:49.871Z [DEBUG] [core] running unrecognized_command hook in status_http plugin
2025-04-05T17:39:49.871Z [DEBUG] [core] hook=unrecognized_command plugin=status_http function=hook_unrecognized_command params=STARTTLS retval=CONT msg=""
2025-04-05T17:39:49.871Z [DEBUG] [core] running unrecognized_command hook in karma plugin
2025-04-05T17:39:49.871Z [DEBUG] [core] hook=unrecognized_command plugin=karma function=hook_unrecognized_command params=STARTTLS retval=CONT msg=""
2025-04-05T17:39:49.871Z [DEBUG] [core] running unrecognized_command hook in tls plugin
2025-04-05T17:39:49.871Z [PROTOCOL] [core] S: 220 Go ahead.
2025-04-05T17:39:49.898Z [INFO] [tls] secured: cipher=TLS_AES_256_GCM_SHA384 version=TLSv1.3 verified=false
2025-04-05T17:39:49.898Z [INFO] [core] hook=unrecognized_command plugin=tls function=upgrade_connection params=STARTTLS retval=OK msg=""
2025-04-05T17:39:49.899Z [PROTOCOL] [core] C: EHLO [127.0.0.1] state=1
2025-04-05T17:39:49.900Z [DEBUG] [core] running ehlo hooks
2025-04-05T17:39:49.900Z [DEBUG] [core] running ehlo hook in hello_block plugin
2025-04-05T17:39:49.900Z [DEBUG] [core] hook=ehlo plugin=hello_block function=check_ymlf params=[127.0.0.1] retval=CONT msg=""
2025-04-05T17:39:49.900Z [DEBUG] [core] running ehlo hook in karma plugin
2025-04-05T17:39:49.900Z [DEBUG] [core] hook=ehlo plugin=karma function=hook_ehlo params=[127.0.0.1] retval=CONT msg=""
2025-04-05T17:39:49.900Z [DEBUG] [core] running ehlo hook in helo.checks plugin
2025-04-05T17:39:49.900Z [DEBUG] [helo.checks] SKIPPING: proto_mismatch
2025-04-05T17:39:49.900Z [DEBUG] [core] hook=ehlo plugin=helo.checks function=proto_mismatch_esmtp params=[127.0.0.1] retval=CONT msg=""
2025-04-05T17:39:49.900Z [DEBUG] [core] running ehlo hook in helo.checks plugin
2025-04-05T17:39:49.901Z [DEBUG] [core] hook=ehlo plugin=helo.checks function=init params=[127.0.0.1] retval=CONT msg=""
2025-04-05T17:39:49.901Z [DEBUG] [core] running ehlo hook in helo.checks plugin
2025-04-05T17:39:49.901Z [DEBUG] [helo.checks] SKIPPING: match_re
2025-04-05T17:39:49.901Z [DEBUG] [core] hook=ehlo plugin=helo.checks function=match_re params=[127.0.0.1] retval=CONT msg=""
2025-04-05T17:39:49.901Z [DEBUG] [core] running ehlo hook in helo.checks plugin
2025-04-05T17:39:49.901Z [DEBUG] [helo.checks] SKIPPING: bare_ip
2025-04-05T17:39:49.901Z [DEBUG] [core] hook=ehlo plugin=helo.checks function=bare_ip params=[127.0.0.1] retval=CONT msg=""
2025-04-05T17:39:49.901Z [DEBUG] [core] running ehlo hook in helo.checks plugin
2025-04-05T17:39:49.901Z [DEBUG] [helo.checks] SKIPPING: dynamic
2025-04-05T17:39:49.901Z [DEBUG] [core] hook=ehlo plugin=helo.checks function=dynamic params=[127.0.0.1] retval=CONT msg=""
2025-04-05T17:39:49.901Z [DEBUG] [core] running ehlo hook in helo.checks plugin
2025-04-05T17:39:49.902Z [DEBUG] [helo.checks] SKIPPING: big_company
2025-04-05T17:39:49.902Z [DEBUG] [core] hook=ehlo plugin=helo.checks function=big_company params=[127.0.0.1] retval=CONT msg=""
2025-04-05T17:39:49.902Z [DEBUG] [core] running ehlo hook in helo.checks plugin
2025-04-05T17:39:49.902Z [DEBUG] [helo.checks] SKIPPING: valid_hostname
2025-04-05T17:39:49.902Z [DEBUG] [core] hook=ehlo plugin=helo.checks function=valid_hostname params=[127.0.0.1] retval=CONT msg=""
2025-04-05T17:39:49.902Z [DEBUG] [core] running ehlo hook in helo.checks plugin
2025-04-05T17:39:49.902Z [DEBUG] [helo.checks] SKIPPING: rdns_match
2025-04-05T17:39:49.902Z [DEBUG] [core] hook=ehlo plugin=helo.checks function=rdns_match params=[127.0.0.1] retval=CONT msg=""
2025-04-05T17:39:49.902Z [DEBUG] [core] running ehlo hook in helo.checks plugin
2025-04-05T17:39:49.902Z [DEBUG] [helo.checks] SKIPPING: forward_dns
2025-04-05T17:39:49.902Z [DEBUG] [core] hook=ehlo plugin=helo.checks function=forward_dns params=[127.0.0.1] retval=CONT msg=""
2025-04-05T17:39:49.902Z [DEBUG] [core] running ehlo hook in helo.checks plugin
2025-04-05T17:39:49.902Z [DEBUG] [helo.checks] SKIPPING: host_mismatch
2025-04-05T17:39:49.902Z [DEBUG] [core] hook=ehlo plugin=helo.checks function=host_mismatch params=[127.0.0.1] retval=CONT msg=""
2025-04-05T17:39:49.903Z [DEBUG] [core] running ehlo hook in helo.checks plugin
2025-04-05T17:39:49.903Z [DEBUG] [helo.checks] SKIPPING: literal_mismatch
2025-04-05T17:39:49.903Z [DEBUG] [core] hook=ehlo plugin=helo.checks function=literal_mismatch params=[127.0.0.1] retval=CONT msg=""
2025-04-05T17:39:49.903Z [DEBUG] [core] running ehlo hook in helo.checks plugin
2025-04-05T17:39:49.903Z [INFO] [helo.checks] helo_host: [127.0.0.1], skip:proto_mismatch(private), match_re(private), bare_ip(private), dynamic(private), big_company(private), valid_hostname(private), rdns_match(private), forward_dns(private), host_mismatch(private), literal_mismatch(private)
2025-04-05T17:39:49.903Z [DEBUG] [core] hook=ehlo plugin=helo.checks function=emit_log params=[127.0.0.1] retval=CONT msg=""
2025-04-05T17:39:49.903Z [DEBUG] [core] running ehlo hook in mailauth/verify plugin
2025-04-05T17:39:49.903Z [DEBUG] [core] hook=ehlo plugin=mailauth/verify function=mailauth_helo params=[127.0.0.1] retval=CONT msg=""
2025-04-05T17:39:49.903Z [DEBUG] [core] running ehlo hook in uribl plugin
2025-04-05T17:39:49.903Z [DEBUG] [uribl] (helo) found 1 items for lookup
2025-04-05T17:39:49.903Z [DEBUG] [uribl] (helo) checking: 127.0.0.1
2025-04-05T17:39:49.904Z [DEBUG] [core] hook=ehlo plugin=uribl function=lookup_ehlo params=[127.0.0.1] retval=CONT msg=""
2025-04-05T17:39:49.905Z [DEBUG] [core] running capabilities hooks
2025-04-05T17:39:49.905Z [DEBUG] [core] running capabilities hook in auth/poste plugin
2025-04-05T17:39:49.905Z [DEBUG] [core] hook=capabilities plugin=auth/poste function=hook_capabilities params="" retval=CONT msg=""
2025-04-05T17:39:49.905Z [DEBUG] [core] running capabilities hook in status_http plugin
2025-04-05T17:39:49.905Z [DEBUG] [core] hook=capabilities plugin=status_http function=hook_capabilities params="" retval=CONT msg=""
2025-04-05T17:39:49.905Z [DEBUG] [core] running capabilities hook in tls plugin
2025-04-05T17:39:49.905Z [DEBUG] [core] hook=capabilities plugin=tls function=advertise_starttls params="" retval=CONT msg=""
2025-04-05T17:39:49.905Z [PROTOCOL] [core] S: 250-bgmcd.org Hello ip6-localhost [::1], , Poste.io is at your service
2025-04-05T17:39:49.905Z [PROTOCOL] [core] S: 250-PIPELINING
2025-04-05T17:39:49.905Z [PROTOCOL] [core] S: 250-8BITMIME
2025-04-05T17:39:49.905Z [PROTOCOL] [core] S: 250-SMTPUTF8
2025-04-05T17:39:49.905Z [PROTOCOL] [core] S: 250-SIZE 26214400
2025-04-05T17:39:49.905Z [PROTOCOL] [core] S: 250-AUTH PLAIN LOGIN
2025-04-05T17:39:49.905Z [PROTOCOL] [core] S: 250 STATUS
2025-04-05T17:39:49.947Z [PROTOCOL] [core] C: MAIL FROM:<postmaster+letsencrypt@bgmcd.org> state=1
2025-04-05T17:39:50.267Z [TX] [core] #67449D1A-5A89-4EAD-A745-246D36C68D66.1