You are viewing a plain text version of this content. The canonical link for it is here.
Posted to server-user@james.apache.org by cryptearth <cr...@cryptearth.de> on 2020/10/03 07:29:42 UTC

v.3.5 - issues enable jSPF

Hey there all,

Matt here.

So, as it was mentioned in the other topic, I didn't yet had the SPF 
check enable cause it failed with some weird error in earlier versions. 
So, I thought to give another try, and encountered the same issue again. 
As far as I understand the stacktrace and the source there're two issues 
interlinked with eachother.

Here's the trace (1st from my root to home backup using ipv4, 2nd same 
but ipv6, 3rd from gmail via ipv6):

INFO   | jvm 1    | 2020/10/03 08:50:55 | 03-Okt.-2020 08:50:55.454 INFO 
[smtpserver-executor-73] 
org.apache.james.protocols.netty.BasicChannelUpstreamHandler.channelConnected:93 
- Connection established from 91.121.4.115
INFO   | jvm 1    | 2020/10/03 08:51:11 | 03-Okt.-2020 08:51:11.691 INFO 
[smtpserver-executor-78] 
org.apache.james.smtpserver.fastfail.SPFHandler.doSPFCheck:124 - No 
Sender or HELO/EHLO present
INFO   | jvm 1    | 2020/10/03 08:51:42 | 03-Okt.-2020 08:51:42.215 
ERROR [smtpserver-executor-90] 
org.apache.james.protocols.netty.BasicChannelUpstreamHandler.exceptionCaught:228 
- Unable to process request
INFO   | jvm 1    | 2020/10/03 08:51:42 | 
java.util.NoSuchElementException: No value present
INFO   | jvm 1    | 2020/10/03 08:51:42 |       at 
java.util.Optional.get(Optional.java:148) ~[?:?]
INFO   | jvm 1    | 2020/10/03 08:51:42 |       at 
org.apache.james.smtpserver.fastfail.SPFHandler.onMessage(SPFHandler.java:283) 
~[james-server-protocols-smtp-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:51:42 |       at 
org.apache.james.smtpserver.DataLineJamesMessageHookHandler.processExtensions(DataLineJamesMessageHookHandler.java:173) 
~[james-server-protocols-smtp-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:51:42 |       at 
org.apache.james.smtpserver.DataLineJamesMessageHookHandler.onLine(DataLineJamesMessageHookHandler.java:106) 
~[james-server-protocols-smtp-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:51:42 |       at 
org.apache.james.protocols.smtp.core.DataCmdHandler$DataLineFilterWrapper.onLine(DataCmdHandler.java:101) 
~[protocols-smtp-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:51:42 |       at 
org.apache.james.protocols.smtp.core.DataCmdHandler$DataLineFilterWrapper.onLine(DataCmdHandler.java:88) 
~[protocols-smtp-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:51:42 |       at 
org.apache.james.protocols.smtp.core.SeparatingDataLineFilter.onBodyLine(SeparatingDataLineFilter.java:109) 
~[protocols-smtp-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:51:42 |       at 
org.apache.james.protocols.smtp.core.SeparatingDataLineFilter.onLine(SeparatingDataLineFilter.java:67) 
~[protocols-smtp-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:51:42 |       at 
org.apache.james.protocols.smtp.core.DataCmdHandler$DataLineFilterWrapper.onLine(DataCmdHandler.java:101) 
~[protocols-smtp-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:51:42 |       at 
org.apache.james.protocols.smtp.core.DataCmdHandler$DataLineFilterWrapper.onLine(DataCmdHandler.java:88) 
~[protocols-smtp-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:51:42 |       at 
org.apache.james.protocols.smtp.core.esmtp.MailSizeEsmtpExtension.onLine(MailSizeEsmtpExtension.java:154) 
~[protocols-smtp-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:51:42 |       at 
org.apache.james.protocols.smtp.core.DataCmdHandler$DataLineFilterWrapper.onLine(DataCmdHandler.java:101) 
~[protocols-smtp-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:51:42 |       at 
org.apache.james.protocols.smtp.core.DataCmdHandler$DataLineFilterWrapper.onLine(DataCmdHandler.java:88) 
~[protocols-smtp-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:51:42 |       at 
org.apache.james.protocols.netty.LineHandlerUpstreamHandler.messageReceived(LineHandlerUpstreamHandler.java:50) 
~[protocols-netty-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:51:42 |       at 
org.jboss.netty.channel.SimpleChannelUpstreamHandler.handleUpstream(SimpleChannelUpstreamHandler.java:70) 
[netty-3.10.6.Final.jar:?]
INFO   | jvm 1    | 2020/10/03 08:51:42 |       at 
org.jboss.netty.channel.DefaultChannelPipeline.sendUpstream(DefaultChannelPipeline.java:564) 
[netty-3.10.6.Final.jar:?]
INFO   | jvm 1    | 2020/10/03 08:51:42 |       at 
org.jboss.netty.channel.DefaultChannelPipeline$DefaultChannelHandlerContext.sendUpstream(DefaultChannelPipeline.java:791) 
[netty-3.10.6.Final.jar:?]
INFO   | jvm 1    | 2020/10/03 08:51:42 |       at 
org.jboss.netty.channel.SimpleChannelUpstreamHandler.messageReceived(SimpleChannelUpstreamHandler.java:124) 
[netty-3.10.6.Final.jar:?]
INFO   | jvm 1    | 2020/10/03 08:51:42 |       at 
org.jboss.netty.channel.SimpleChannelUpstreamHandler.handleUpstream(SimpleChannelUpstreamHandler.java:70) 
[netty-3.10.6.Final.jar:?]
INFO   | jvm 1    | 2020/10/03 08:51:42 |       at 
org.jboss.netty.channel.DefaultChannelPipeline.sendUpstream(DefaultChannelPipeline.java:564) 
[netty-3.10.6.Final.jar:?]
INFO   | jvm 1    | 2020/10/03 08:51:42 |       at 
org.jboss.netty.channel.DefaultChannelPipeline$DefaultChannelHandlerContext.sendUpstream(DefaultChannelPipeline.java:791) 
[netty-3.10.6.Final.jar:?]
INFO   | jvm 1    | 2020/10/03 08:51:42 |       at 
org.jboss.netty.handler.execution.ChannelUpstreamEventRunnable.doRun(ChannelUpstreamEventRunnable.java:43) 
[netty-3.10.6.Final.jar:?]
INFO   | jvm 1    | 2020/10/03 08:51:42 |       at 
org.jboss.netty.handler.execution.ChannelEventRunnable.run(ChannelEventRunnable.java:67) 
[netty-3.10.6.Final.jar:?]
INFO   | jvm 1    | 2020/10/03 08:51:42 |       at 
org.jboss.netty.handler.execution.OrderedMemoryAwareThreadPoolExecutor$ChildExecutor.run(OrderedMemoryAwareThreadPoolExecutor.java:314) 
[netty-3.10.6.Final.jar:?]
INFO   | jvm 1    | 2020/10/03 08:51:42 |       at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) 
[?:?]
INFO   | jvm 1    | 2020/10/03 08:51:42 |       at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) 
[?:?]
INFO   | jvm 1    | 2020/10/03 08:51:42 |       at 
java.lang.Thread.run(Thread.java:834) [?:?]
INFO   | jvm 1    | 2020/10/03 08:51:42 | 03-Okt.-2020 08:51:42.227 INFO 
[smtpserver-executor-90] 
org.apache.james.protocols.netty.BasicChannelUpstreamHandler.channelClosed:171 
- Connection closed for 91.121.4.115

INFO   | jvm 1    | 2020/10/03 08:52:28 | 03-Okt.-2020 08:52:28.020 INFO 
[smtpserver-executor-93] 
org.apache.james.protocols.netty.BasicChannelUpstreamHandler.channelConnected:93 
- Connection established from 2001:41d0:1:5773:0:0:0:1
INFO   | jvm 1    | 2020/10/03 08:52:53 | 03-Okt.-2020 08:52:53.951 INFO 
[smtpserver-executor-100] 
org.apache.james.smtpserver.fastfail.SPFHandler.doSPFCheck:124 - No 
Sender or HELO/EHLO present
INFO   | jvm 1    | 2020/10/03 08:53:25 | 03-Okt.-2020 08:53:25.535 
ERROR [smtpserver-executor-112] 
org.apache.james.protocols.netty.BasicChannelUpstreamHandler.exceptionCaught:228 
- Unable to process request
INFO   | jvm 1    | 2020/10/03 08:53:25 | 
java.util.NoSuchElementException: No value present
INFO   | jvm 1    | 2020/10/03 08:53:25 |       at 
java.util.Optional.get(Optional.java:148) ~[?:?]
INFO   | jvm 1    | 2020/10/03 08:53:25 |       at 
org.apache.james.smtpserver.fastfail.SPFHandler.onMessage(SPFHandler.java:283) 
~[james-server-protocols-smtp-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:53:25 |       at 
org.apache.james.smtpserver.DataLineJamesMessageHookHandler.processExtensions(DataLineJamesMessageHookHandler.java:173) 
~[james-server-protocols-smtp-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:53:25 |       at 
org.apache.james.smtpserver.DataLineJamesMessageHookHandler.onLine(DataLineJamesMessageHookHandler.java:106) 
~[james-server-protocols-smtp-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:53:25 |       at 
org.apache.james.protocols.smtp.core.DataCmdHandler$DataLineFilterWrapper.onLine(DataCmdHandler.java:101) 
~[protocols-smtp-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:53:25 |       at 
org.apache.james.protocols.smtp.core.DataCmdHandler$DataLineFilterWrapper.onLine(DataCmdHandler.java:88) 
~[protocols-smtp-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:53:25 |       at 
org.apache.james.protocols.smtp.core.SeparatingDataLineFilter.onBodyLine(SeparatingDataLineFilter.java:109) 
~[protocols-smtp-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:53:25 |       at 
org.apache.james.protocols.smtp.core.SeparatingDataLineFilter.onLine(SeparatingDataLineFilter.java:67) 
~[protocols-smtp-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:53:25 |       at 
org.apache.james.protocols.smtp.core.DataCmdHandler$DataLineFilterWrapper.onLine(DataCmdHandler.java:101) 
~[protocols-smtp-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:53:25 |       at 
org.apache.james.protocols.smtp.core.DataCmdHandler$DataLineFilterWrapper.onLine(DataCmdHandler.java:88) 
~[protocols-smtp-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:53:25 |       at 
org.apache.james.protocols.smtp.core.esmtp.MailSizeEsmtpExtension.onLine(MailSizeEsmtpExtension.java:154) 
~[protocols-smtp-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:53:25 |       at 
org.apache.james.protocols.smtp.core.DataCmdHandler$DataLineFilterWrapper.onLine(DataCmdHandler.java:101) 
~[protocols-smtp-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:53:25 |       at 
org.apache.james.protocols.smtp.core.DataCmdHandler$DataLineFilterWrapper.onLine(DataCmdHandler.java:88) 
~[protocols-smtp-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:53:25 |       at 
org.apache.james.protocols.netty.LineHandlerUpstreamHandler.messageReceived(LineHandlerUpstreamHandler.java:50) 
~[protocols-netty-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:53:25 |       at 
org.jboss.netty.channel.SimpleChannelUpstreamHandler.handleUpstream(SimpleChannelUpstreamHandler.java:70) 
[netty-3.10.6.Final.jar:?]
INFO   | jvm 1    | 2020/10/03 08:53:25 |       at 
org.jboss.netty.channel.DefaultChannelPipeline.sendUpstream(DefaultChannelPipeline.java:564) 
[netty-3.10.6.Final.jar:?]
INFO   | jvm 1    | 2020/10/03 08:53:25 |       at 
org.jboss.netty.channel.DefaultChannelPipeline$DefaultChannelHandlerContext.sendUpstream(DefaultChannelPipeline.java:791) 
[netty-3.10.6.Final.jar:?]
INFO   | jvm 1    | 2020/10/03 08:53:25 |       at 
org.jboss.netty.channel.SimpleChannelUpstreamHandler.messageReceived(SimpleChannelUpstreamHandler.java:124) 
[netty-3.10.6.Final.jar:?]
INFO   | jvm 1    | 2020/10/03 08:53:25 |       at 
org.jboss.netty.channel.SimpleChannelUpstreamHandler.handleUpstream(SimpleChannelUpstreamHandler.java:70) 
[netty-3.10.6.Final.jar:?]
INFO   | jvm 1    | 2020/10/03 08:53:25 |       at 
org.jboss.netty.channel.DefaultChannelPipeline.sendUpstream(DefaultChannelPipeline.java:564) 
[netty-3.10.6.Final.jar:?]
INFO   | jvm 1    | 2020/10/03 08:53:25 |       at 
org.jboss.netty.channel.DefaultChannelPipeline$DefaultChannelHandlerContext.sendUpstream(DefaultChannelPipeline.java:791) 
[netty-3.10.6.Final.jar:?]
INFO   | jvm 1    | 2020/10/03 08:53:25 |       at 
org.jboss.netty.handler.execution.ChannelUpstreamEventRunnable.doRun(ChannelUpstreamEventRunnable.java:43) 
[netty-3.10.6.Final.jar:?]
INFO   | jvm 1    | 2020/10/03 08:53:25 |       at 
org.jboss.netty.handler.execution.ChannelEventRunnable.run(ChannelEventRunnable.java:67) 
[netty-3.10.6.Final.jar:?]
INFO   | jvm 1    | 2020/10/03 08:53:25 |       at 
org.jboss.netty.handler.execution.OrderedMemoryAwareThreadPoolExecutor$ChildExecutor.run(OrderedMemoryAwareThreadPoolExecutor.java:314) 
[netty-3.10.6.Final.jar:?]
INFO   | jvm 1    | 2020/10/03 08:53:25 |       at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) 
[?:?]
INFO   | jvm 1    | 2020/10/03 08:53:25 |       at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) 
[?:?]
INFO   | jvm 1    | 2020/10/03 08:53:25 |       at 
java.lang.Thread.run(Thread.java:834) [?:?]
INFO   | jvm 1    | 2020/10/03 08:53:25 | 03-Okt.-2020 08:53:25.543 INFO 
[smtpserver-executor-112] 
org.apache.james.protocols.netty.BasicChannelUpstreamHandler.channelClosed:171 
- Connection closed for 2001:41d0:1:5773:0:0:0:1

INFO   | jvm 1    | 2020/10/03 08:57:57 | 03-Okt.-2020 08:57:57.247 INFO 
[smtpserver-executor-115] 
org.apache.james.protocols.netty.BasicChannelUpstreamHandler.channelConnected:93 
- Connection established from 2607:f8b0:4864:20:0:0:0:42f
INFO   | jvm 1    | 2020/10/03 08:57:58 | 03-Okt.-2020 08:57:58.790 INFO 
[smtpserver-executor-129] 
org.apache.james.smtpserver.fastfail.SPFHandler.doSPFCheck:124 - No 
Sender or HELO/EHLO present
INFO   | jvm 1    | 2020/10/03 08:57:59 | 03-Okt.-2020 08:57:59.041 
ERROR [smtpserver-executor-115] 
org.apache.james.protocols.netty.BasicChannelUpstreamHandler.exceptionCaught:228 
- Unable to process request
INFO   | jvm 1    | 2020/10/03 08:57:59 | 
java.util.NoSuchElementException: No value present
INFO   | jvm 1    | 2020/10/03 08:57:59 |       at 
java.util.Optional.get(Optional.java:148) ~[?:?]
INFO   | jvm 1    | 2020/10/03 08:57:59 |       at 
org.apache.james.smtpserver.fastfail.SPFHandler.onMessage(SPFHandler.java:283) 
~[james-server-protocols-smtp-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:57:59 |       at 
org.apache.james.smtpserver.DataLineJamesMessageHookHandler.processExtensions(DataLineJamesMessageHookHandler.java:173) 
~[james-server-protocols-smtp-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:57:59 |       at 
org.apache.james.smtpserver.DataLineJamesMessageHookHandler.onLine(DataLineJamesMessageHookHandler.java:106) 
~[james-server-protocols-smtp-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:57:59 |       at 
org.apache.james.protocols.smtp.core.DataCmdHandler$DataLineFilterWrapper.onLine(DataCmdHandler.java:101) 
~[protocols-smtp-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:57:59 |       at 
org.apache.james.protocols.smtp.core.DataCmdHandler$DataLineFilterWrapper.onLine(DataCmdHandler.java:88) 
~[protocols-smtp-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:57:59 |       at 
org.apache.james.protocols.smtp.core.SeparatingDataLineFilter.onBodyLine(SeparatingDataLineFilter.java:109) 
~[protocols-smtp-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:57:59 |       at 
org.apache.james.protocols.smtp.core.SeparatingDataLineFilter.onLine(SeparatingDataLineFilter.java:67) 
~[protocols-smtp-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:57:59 |       at 
org.apache.james.protocols.smtp.core.DataCmdHandler$DataLineFilterWrapper.onLine(DataCmdHandler.java:101) 
~[protocols-smtp-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:57:59 |       at 
org.apache.james.protocols.smtp.core.DataCmdHandler$DataLineFilterWrapper.onLine(DataCmdHandler.java:88) 
~[protocols-smtp-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:57:59 |       at 
org.apache.james.protocols.smtp.core.esmtp.MailSizeEsmtpExtension.onLine(MailSizeEsmtpExtension.java:154) 
~[protocols-smtp-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:57:59 |       at 
org.apache.james.protocols.smtp.core.DataCmdHandler$DataLineFilterWrapper.onLine(DataCmdHandler.java:101) 
~[protocols-smtp-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:57:59 |       at 
org.apache.james.protocols.smtp.core.DataCmdHandler$DataLineFilterWrapper.onLine(DataCmdHandler.java:88) 
~[protocols-smtp-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:57:59 |       at 
org.apache.james.protocols.netty.LineHandlerUpstreamHandler.messageReceived(LineHandlerUpstreamHandler.java:50) 
~[protocols-netty-3.5.0.jar:3.5.0]
INFO   | jvm 1    | 2020/10/03 08:57:59 |       at 
org.jboss.netty.channel.SimpleChannelUpstreamHandler.handleUpstream(SimpleChannelUpstreamHandler.java:70) 
[netty-3.10.6.Final.jar:?]
INFO   | jvm 1    | 2020/10/03 08:57:59 |       at 
org.jboss.netty.channel.DefaultChannelPipeline.sendUpstream(DefaultChannelPipeline.java:564) 
[netty-3.10.6.Final.jar:?]
INFO   | jvm 1    | 2020/10/03 08:57:59 |       at 
org.jboss.netty.channel.DefaultChannelPipeline$DefaultChannelHandlerContext.sendUpstream(DefaultChannelPipeline.java:791) 
[netty-3.10.6.Final.jar:?]
INFO   | jvm 1    | 2020/10/03 08:57:59 |       at 
org.jboss.netty.channel.SimpleChannelUpstreamHandler.messageReceived(SimpleChannelUpstreamHandler.java:124) 
[netty-3.10.6.Final.jar:?]
INFO   | jvm 1    | 2020/10/03 08:57:59 |       at 
org.jboss.netty.channel.SimpleChannelUpstreamHandler.handleUpstream(SimpleChannelUpstreamHandler.java:70) 
[netty-3.10.6.Final.jar:?]
INFO   | jvm 1    | 2020/10/03 08:57:59 |       at 
org.jboss.netty.channel.DefaultChannelPipeline.sendUpstream(DefaultChannelPipeline.java:564) 
[netty-3.10.6.Final.jar:?]
INFO   | jvm 1    | 2020/10/03 08:57:59 |       at 
org.jboss.netty.channel.DefaultChannelPipeline$DefaultChannelHandlerContext.sendUpstream(DefaultChannelPipeline.java:791) 
[netty-3.10.6.Final.jar:?]
INFO   | jvm 1    | 2020/10/03 08:57:59 |       at 
org.jboss.netty.handler.execution.ChannelUpstreamEventRunnable.doRun(ChannelUpstreamEventRunnable.java:43) 
[netty-3.10.6.Final.jar:?]
INFO   | jvm 1    | 2020/10/03 08:57:59 |       at 
org.jboss.netty.handler.execution.ChannelEventRunnable.run(ChannelEventRunnable.java:67) 
[netty-3.10.6.Final.jar:?]
INFO   | jvm 1    | 2020/10/03 08:57:59 |       at 
org.jboss.netty.handler.execution.OrderedMemoryAwareThreadPoolExecutor$ChildExecutor.run(OrderedMemoryAwareThreadPoolExecutor.java:314) 
[netty-3.10.6.Final.jar:?]
INFO   | jvm 1    | 2020/10/03 08:57:59 |       at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) 
[?:?]
INFO   | jvm 1    | 2020/10/03 08:57:59 |       at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) 
[?:?]
INFO   | jvm 1    | 2020/10/03 08:57:59 |       at 
java.lang.Thread.run(Thread.java:834) [?:?]
INFO   | jvm 1    | 2020/10/03 08:57:59 | 03-Okt.-2020 08:57:59.064 INFO 
[smtpserver-executor-117] 
org.apache.james.protocols.netty.BasicChannelUpstreamHandler.channelClosed:171 
- Connection closed for 2607:f8b0:4864:20:0:0:0:42f

So, SPFHandler.doSPFCheck complains "No Sender or HELO/EHLO present" and 
SPFHandler.onMessage fails with some NoSuchElementException.
What I did to activate it? Just removed the <!-- and --> from 
smtpserver.xml at line 191:

<handler class="org.apache.james.smtpserver.fastfail.SPFHandler">
<blockSoftFail>false</blockSoftFail>
<blockPermError>true</blockPermError>
</handler>

SPFHandler.onMessage only contains this one line:

mail.setAttribute(new Attribute(SPF_HEADER_MAIL_ATTRIBUTE_NAME, 
AttributeValue.of(session.getAttachment(SPF_HEADER, 
State.Transaction).get())));

As the trace says "java.util.Optional.get" I suspect the issue is within 
the innermost paranthesis: session.getAttachment(SPF_HEADER, 
State.Transaction).get()
If session itself would be null or getAttachment() would return null the 
exception would be a simple NullPointerException. So by this we can tell 
that both session itself and whatever session.getAttachment() returns is 
valid and only the final .get() fails.
The test-data I send manual via TELNET matches what GMail sends - no 
matter if ipv4 or ipv6:

cryptearth@root1:~> telnet home.cryptearth.de 25
Trying 2a0c:d242:3803:9400::137...
Connected to home.cryptearth.de.
Escape character is '^]'.
220 home.cryptearth.de JAMES SMTP Server Server (JAMES SMTP Server ) ready
EHLO mail.cryptearth.de
250-home.cryptearth.de Hello mail.cryptearth.de [2001:41d0:1:5773:0:0:0:1])
250-AUTH LOGIN PLAIN
250-AUTH=LOGIN PLAIN
250-PIPELINING
250-ENHANCEDSTATUSCODES
250-8BITMIME
250 STARTTLS
MAIL FROM:<te...@cryptearth.de>
250 2.1.0 Sender <te...@cryptearth.de> OK
RCPT TO:<lo...@cryptearth.de>
250 2.1.5 Recipient <lo...@cryptearth.de> OK
DATA
354 Ok Send data ending with <CRLF>.<CRLF>
From: test@cryptearth.de
To: local-service@cryptearth.de
Subject: Test

Test
.
451 Unable to process request
Connection closed by foreign host.
cryptearth@root1:~>

So, although I'd like to enable the SPF check I'm unable to and also 
unable to figure out what I'm doing wrong by myself. Any help appreciated.

So long,

Matt

---------------------------------------------------------------------
To unsubscribe, e-mail: server-user-unsubscribe@james.apache.org
For additional commands, e-mail: server-user-help@james.apache.org