I updated OpenBSD to 5.5-current (using snapshots) yesterday, and THEN installed opensmtpd-latest. (this machine is "elysion", which is relevant further down)
After running for a short while, smtpd simply exits. Also, very oddly, when sending mail from my laptop (it relays via elysion), it's not getting relayed properly: root@athena # smtpctl show queue 5e1261ccff688972|inet4|mta||[email protected]|[email protected]|[email protected]|1397132065|1397477665|0|1|pending|128|Network error on destination MXs 7ea31d2abc53c0c4|local|mta|auth|@|[email protected]|[email protected]|1397119175|1397464775|0|9|pending|19238|Network error on destination MXs e67c295a4c803233|inet4|mta||[email protected]|[email protected]|[email protected]|1397131923|1397477523|0|4|pending|5986|Network error on destination MXs Here's my config and the entire output from start to end. Just a few emails (and spam) comming through, nothing odd. # cat /etc/mail/smtpd.conf # $OpenBSD: smtpd.conf,v 1.6 2013/01/26 09:38:25 gilles Exp $ # This is the smtpd server system-wide configuration file. # See smtpd.conf(5) for more information. queue encryption key <snip> table usrs db:/etc/mail/users.db table aliases db:/etc/mail/aliases.db table mydomains db:/etc/mail/mydomains.db pki mx1 certificate "/etc/mail/certs/mx1.barrera.io/chain.crt" pki mx1 key "/etc/mail/certs/mx1.barrera.io/ssl.key" pki smtp certificate "/etc/mail/certs/mx1.barrera.io/chain.crt" pki smtp key "/etc/mail/certs/mx1.barrera.io/ssl.key" listen on lo0 listen on lo0 port 10028 tag DKIM listen on egress port smtp tls pki mx1 hostname "mx1.barrera.io" listen on egress port submission tls-require pki smtp auth <usrs> hostname "smtp.barrera.io" table catchall { "@" => hugo } accept from any for local alias <aliases> deliver to mda \ "/usr/local/libexec/dovecot/dovecot-lda -d [email protected]" accept from any for domain <mydomains> virtual <catchall> deliver to mda \ "/usr/local/libexec/dovecot/dovecot-lda -d [email protected]" #accept from any for <hosteddomains> virtual <hostedvirtuals> \ deliver to mda "/usr/local/libexec/dovecot/dovecot-lda -d %{dest}" accept tagged DKIM for any relay accept for any relay via smtp://127.0.0.1:10027 # smtpd -dvv debug: init ssl-tree info: loading pki information for mx1 info: loading pki information for smtp info: OpenSMTPD 5.4.3 starting debug: bounce warning after 4h debug: using "fs" queue backend debug: using "ramqueue" scheduler backend debug: using "ram" stat backend info: startup [debug mode] debug: parent_send_config_ruleset: reloading debug: parent_send_config_mfa: reloading debug: parent_send_config: configuring pony process queue: queue encryption enabled mfa: building simple chains... mfa: building complex chains... mfa: done building complex chains mfa: done building default chain debug: mfa ready debug: smtp: listen on IPv6:2607:f2f8:a520::2 port 587 flags 0x69 pki "smtp" debug: smtp: listen on IPv6:fe80::5054:ff:fe27:2425%em0 port 587 flags 0x69 pki "smtp" debug: smtp: listen on 174.136.104.18 port 587 flags 0x69 pki "smtp" debug: smtp: listen on IPv6:2607:f2f8:a520::2 port 25 flags 0x1 pki "mx1" debug: smtp: listen on IPv6:fe80::5054:ff:fe27:2425%em0 port 25 flags 0x1 pki "mx1" debug: smtp: listen on 174.136.104.18 port 25 flags 0x1 pki "mx1" debug: smtp: listen on 127.0.0.1 port 10028 flags 0x0 pki "" debug: smtp: listen on IPv6:fe80::1%lo0 port 10028 flags 0x0 pki "" debug: smtp: listen on IPv6:::1 port 10028 flags 0x0 pki "" debug: smtp: listen on 127.0.0.1 port 25 flags 0x0 pki "" debug: smtp: listen on IPv6:fe80::1%lo0 port 25 flags 0x0 pki "" debug: smtp: listen on IPv6:::1 port 25 flags 0x0 pki "" debug: smtp: will accept at most 496 clients debug: queue: done loading queue into scheduler debug: smtpd: scanning offline queue... debug: smtpd: offline scanning donedebug: smtp: new client on listener: 0x1fd3d0a5e000 smtp-in: New session ba80c553c1a69579 from host gerolde.archlinux.org [66.211.214.132] debug: smtp: SIZE in MAIL FROM command debug: aliases_virtual_get: '[email protected]' resolved to 1 nodes debug: 0x1fd3ca654000: end of message, msgflags=0x0000 smtp-in: Accepted message 85e08cb9 on session ba80c553c1a69579: from=<[email protected]>, to=<hugo@osvaldobarrera .com.ar>, size=4971, ndest=1, proto=ESMTP debug: scheduler: evp:85e08cb906a68d4b scheduled (mda)mda: new user ba80c554517188d1 for "<getpwnam>:hugo" [52/96] debug: lka: userinfo <getpwnam>:hugo debug: mda: new session ba80c555fba3b398 for user "<getpwnam>:hugo" evpid 85e08cb906a68d4b debug: mda: no more envelope for "<getpwnam>:hugo" debug: mda: got message fd 5 for session ba80c555fba3b398 evpid 85e08cb906a68d4b debug: mda: querying mda fd for session ba80c555fba3b398 evpid 85e08cb906a68d4b debug: smtpd: forking mda for session ba80c555fba3b398: "/usr/local/libexec/dovecot/dovecot-lda -d [email protected]" as hugo debug: mda: got mda fd 6 for session ba80c555fba3b398 evpid 85e08cb906a68d4b debug: mda: end-of-file for session ba80c555fba3b398 evpid 85e08cb906a68d4b debug: mda: all data sent for session ba80c555fba3b398 evpid 85e08cb906a68d4b smtp-in: Closing session ba80c553c1a69579 debug: smtp: 0x1fd3ca654000: deleting session: done debug: smtpd: mda process done for session ba80c555fba3b398: exited okay delivery: Ok for 85e08cb906a68d4b: from=<[email protected]>, to=<[email protected]>, user=hugo, method=$ da, delay=1s, stat=Delivered debug: mda: session ba80c555fba3b398 done debug: mda: user "hugo" becomes runnable debug: mda: all done for user "<getpwnam>:hugo" debug: smtp: new client on listener: 0x1fd3cc624000 smtp-in: New session ba80c55693f3c764 from host alderaan.archlinux.org [IPv6:2a01:4f8:120:34c2::2] debug: lka: looking up pki "mx1" debug: session_start_ssl: switching to SSL smtp-in: Started TLS on session ba80c55693f3c764: version=TLSv1/SSLv3, cipher=ECDHE-RSA-AES256-GCM-SHA384, bits=256 debug: smtp: SIZE in MAIL FROM command debug: aliases_virtual_get: '[email protected]' resolved to 1 nodes debug: 0x1fd3ca654000: end of message, msgflags=0x0000 smtp-in: Accepted message 2518690a on session ba80c55693f3c764: from=<[email protected]>, to=<[email protected]>, size=15322, $ dest=1, proto=ESMTP debug: scheduler: evp:2518690a771d24ec scheduled (mda) mda: new user ba80c5570024e3af for "<getpwnam>:hugo" debug: lka: userinfo <getpwnam>:hugosmtp-in: New session ba80c55693f3c764 from host alderaan.archlinux.org [IPv6:2a01:4f8:120:34c2::2] [33/96] debug: lka: looking up pki "mx1" debug: session_start_ssl: switching to SSL smtp-in: Started TLS on session ba80c55693f3c764: version=TLSv1/SSLv3, cipher=ECDHE-RSA-AES256-GCM-SHA384, bits=256 debug: smtp: SIZE in MAIL FROM command debug: aliases_virtual_get: '[email protected]' resolved to 1 nodes debug: 0x1fd3ca654000: end of message, msgflags=0x0000 smtp-in: Accepted message 2518690a on session ba80c55693f3c764: from=<[email protected]>, to=<[email protected]>, size=15322, $ dest=1, proto=ESMTP debug: scheduler: evp:2518690a771d24ec scheduled (mda) mda: new user ba80c5570024e3af for "<getpwnam>:hugo" debug: lka: userinfo <getpwnam>:hugo debug: mda: new session ba80c558df9ea9ad for user "<getpwnam>:hugo" evpid 2518690a771d24ec debug: mda: no more envelope for "<getpwnam>:hugo" debug: mda: got message fd 5 for session ba80c558df9ea9ad evpid 2518690a771d24ec debug: mda: querying mda fd for session ba80c558df9ea9ad evpid 2518690a771d24ec debug: smtpd: forking mda for session ba80c558df9ea9ad: "/usr/local/libexec/dovecot/dovecot-lda -d [email protected]" as hugo debug: mda: got mda fd 6 for session ba80c558df9ea9ad evpid 2518690a771d24ec debug: mda: end-of-file for session ba80c558df9ea9ad evpid 2518690a771d24ec debug: mda: all data sent for session ba80c558df9ea9ad evpid 2518690a771d24ec smtp-in: Closing session ba80c55693f3c764 debug: smtp: 0x1fd3ca654000: deleting session: done debug: smtpd: mda process done for session ba80c558df9ea9ad: exited okay delivery: Ok for 2518690a771d24ec: from=<[email protected]>, to=<[email protected]>, user=hugo, method=mda, delay=1s, stat=Del$ vered debug: mda: session ba80c558df9ea9ad done debug: mda: user "hugo" becomes runnable debug: mda: all done for user "<getpwnam>:hugo" debug: smtp: new client on listener: 0x1fd3d0a5e000 smtp-in: New session ba80c55905d8ba46 from host mta153l1.r.grouponmail.com.ar [50.115.214.156] debug: aliases_virtual_get: '[email protected]' resolved to 1 nodes debug: 0x1fd3ca654000: end of message, msgflags=0x0000 smtp-in: Accepted message 70fad0a2 on session ba80c55905d8ba46: from=<3b493996ffd6de87d3615ca76fcd8089b987e7a7e00b8b8031cadad8de98e...@bounce.r.grouponmail.com.ar>, to=<[email protected]>, size=127406, ndest=1, proto=ESMTP [0/96] debug: scheduler: evp:70fad0a28cd85bec scheduled (mda) mda: new user ba80c55a61554ded for "<getpwnam>:hugo" debug: lka: userinfo <getpwnam>:hugo debug: mda: new session ba80c55bb8d70828 for user "<getpwnam>:hugo" evpid 70fad0a28cd85bec debug: mda: no more envelope for "<getpwnam>:hugo" debug: mda: got message fd 5 for session ba80c55bb8d70828 evpid 70fad0a28cd85bec debug: mda: querying mda fd for session ba80c55bb8d70828 evpid 70fad0a28cd85bec debug: smtpd: forking mda for session ba80c55bb8d70828: "/usr/local/libexec/dovecot/dovecot-lda -d [email protected]" as hugo debug: mda: got mda fd 6 for session ba80c55bb8d70828 evpid 70fad0a28cd85bec debug: mda: end-of-file for session ba80c55bb8d70828 evpid 70fad0a28cd85bec debug: mda: all data sent for session ba80c55bb8d70828 evpid 70fad0a28cd85bec debug: smtpd: mda process done for session ba80c55bb8d70828: exited okay delivery: Ok for 70fad0a28cd85bec: from=<3b493996ffd6de87d3615ca76fcd8089b987e7a7e00b8b8031cadad8de98e...@bounce.r.grouponmail.co m.ar>, to=<[email protected]>, user=hugo, method=mda, delay=2s, stat=Delivered debug: mda: session ba80c55bb8d70828 done debug: mda: user "hugo" becomes runnable debug: mda: all done for user "<getpwnam>:hugo" smtp-in: Closing session ba80c55905d8ba46 debug: smtp: 0x1fd3ca654000: deleting session: done debug: smtp: new client on listener: 0x1fd3d02c4000 smtp-in: New session ba80c55c2b4ccee5 from host hyperion.ubertech.com.ar [190.210.108.249] debug: lka: looking up pki "smtp" debug: session_start_ssl: switching to SSL smtp-in: Started TLS on session ba80c55c2b4ccee5: version=TLSv1/SSLv3, cipher=ECDHE-RSA-AES256-GCM-SHA384, bits=256 debug: lka: authenticating for usrs:[email protected] smtpd: session_imsg: unexpected IMSG_LKA_AUTHENTICATE imsg warn: lka -> pony: pipe closed warn: parent -> pony: pipe closed warn: mfa -> pony: pipe closed warn: queue -> pony: pipe closed warn: control -> pony: pipe closed warn: scheduler -> queue: pipe closed I'm guessing I should understand something from the line: "smtpd: session_imsg: unexpected IMSG_LKA_AUTHENTICATE imsg" === Ok, halfway through writing this email something odd happed. I restarted smtpd at my remote host, sent a mail from my laptop (in order to gather logs to attach), and it went through fine. So, is would seem that the smtpd-not-relaying issue can't be reproduced 100% of the time. But it does exit, eventually though, so that issue still exists. -- Hugo Osvaldo Barrera
pgpA8s_FFXTx7.pgp
Description: PGP signature
