Error enable TLS 1.2, the Java versión use is 1.8.0.151_x64. Send log[1]
[1] [ INFO] 2019-01-19 15:07:05,355 [] [] Refreshing org.springframework.context.support.FileSystemXmlApplicationContext@deb6432<mailto:org.springframework.context.support.FileSystemXmlApplicationContext@deb6432>: display name [org.springframework.context.support.FileSystemXmlApplicationContext@deb6432]; startup date [Sat Jan 19 15:07:05 COT 2019]; root of context hierarchy [DEBUG] 2019-01-19 15:07:05,380 [] [] Falling back to plain synchronized [java.util.HashMap] for concurrent map [DEBUG] 2019-01-19 15:07:05,380 [] [] Falling back to plain synchronized [java.util.HashMap] for concurrent map [DEBUG] 2019-01-19 15:07:05,381 [] [] Falling back to plain synchronized [java.util.HashMap] for concurrent map [DEBUG] 2019-01-19 15:07:05,381 [] [] Falling back to plain synchronized [java.util.HashMap] for concurrent map [DEBUG] 2019-01-19 15:07:05,381 [] [] Falling back to plain synchronized [java.util.HashMap] for concurrent map [DEBUG] 2019-01-19 15:07:05,381 [] [] Falling back to plain synchronized [java.util.HashMap] for concurrent map [DEBUG] 2019-01-19 15:07:05,385 [] [] Falling back to plain synchronized [java.util.HashMap] for concurrent map [DEBUG] 2019-01-19 15:07:05,385 [] [] Falling back to plain synchronized [java.util.HashMap] for concurrent map [ INFO] 2019-01-19 15:07:05,406 [] [] Loading XML bean definitions from file [D:\DePaso\apache-ftpserver-1.1.1\res\conf\ftpd-typical.xml] [DEBUG] 2019-01-19 15:07:05,425 [] [] Using JAXP provider [com.sun.org.apache.xerces.internal.jaxp.DocumentBuilderFactoryImpl] [DEBUG] 2019-01-19 15:07:05,464 [] [] Loading schema mappings from [META-INF/spring.schemas] [DEBUG] 2019-01-19 15:07:05,467 [] [] Loaded schema mappings: {http://www.springframework.org/schema/lang/spring-lang.xsd=org/springframework/scripting/config/spring-lang-2.5.xsd, http://www.springframework.org/schema/lang/spring-lang-2.5.xsd=org/springframework/scripting/config/spring-lang-2.5.xsd, http://www.springframework.org/schema/context/spring-context-2.5.xsd=org/springframework/context/config/spring-context-2.5.xsd, http://www.springframework.org/schema/context/spring-context.xsd=org/springframework/context/config/spring-context-2.5.xsd, http://www.springframework.org/schema/util/spring-util-2.0.xsd=org/springframework/beans/factory/xml/spring-util-2.0.xsd, http://www.springframework.org/schema/util/spring-util-2.5.xsd=org/springframework/beans/factory/xml/spring-util-2.5.xsd, http://www.springframework.org/schema/tool/spring-tool-2.0.xsd=org/springframework/beans/factory/xml/spring-tool-2.0.xsd, http://www.springframework.org/schema/beans/spring-beans-2.0.xsd=org/springframework/beans/factory/xml/spring-beans-2.0.xsd, http://www.springframework.org/schema/tool/spring-tool-2.5.xsd=org/springframework/beans/factory/xml/spring-tool-2.5.xsd, http://www.springframework.org/schema/beans/spring-beans-2.5.xsd=org/springframework/beans/factory/xml/spring-beans-2.5.xsd, http://www.springframework.org/schema/beans/spring-beans.xsd=org/springframework/beans/factory/xml/spring-beans-2.5.xsd, http://www.springframework.org/schema/jee/spring-jee.xsd=org/springframework/ejb/config/spring-jee-2.5.xsd, http://mina.apache.org/ftpserver/ftpserver-1.0.xsd=org/apache/ftpserver/config/spring/ftpserver-1.0.xsd, http://www.springframework.org/schema/tool/spring-tool.xsd=org/springframework/beans/factory/xml/spring-tool-2.5.xsd, http://www.springframework.org/schema/jee/spring-jee-2.0.xsd=org/springframework/ejb/config/spring-jee-2.0.xsd, http://www.springframework.org/schema/jee/spring-jee-2.5.xsd=org/springframework/ejb/config/spring-jee-2.5.xsd, http://www.springframework.org/schema/lang/spring-lang-2.0.xsd=org/springframework/scripting/config/spring-lang-2.0.xsd, http://www.springframework.org/schema/util/spring-util.xsd=org/springframework/beans/factory/xml/spring-util-2.5.xsd} [DEBUG] 2019-01-19 15:07:05,469 [] [] Found XML schema [http://mina.apache.org/ftpserver/ftpserver-1.0.xsd] in classpath: org/apache/ftpserver/config/spring/ftpserver-1.0.xsd [DEBUG] 2019-01-19 15:07:05,486 [] [] Found XML schema [http://www.springframework.org/schema/beans/spring-beans-2.5.xsd] in classpath: org/springframework/beans/factory/xml/spring-beans-2.5.xsd [DEBUG] 2019-01-19 15:07:05,557 [] [] Loading bean definitions [DEBUG] 2019-01-19 15:07:05,566 [] [] Loaded mappings [{http://www.springframework.org/schema/p=org.springframework.beans.factory.xml.SimplePropertyNamespaceHandler, http://www.springframework.org/schema/lang=org.springframework.scripting.config.LangNamespaceHandler, http://www.springframework.org/schema/jee=org.springframework.ejb.config.JeeNamespaceHandler, http://mina.apache.org/ftpserver/spring/v1=org.apache.ftpserver.config.spring.FtpServerNamespaceHandler, http://www.springframework.org/schema/util=org.springframework.beans.factory.xml.UtilNamespaceHandler, http://www.springframework.org/schema/context=org.springframework.context.config.ContextNamespaceHandler}] [DEBUG] 2019-01-19 15:07:05,587 [] [] Loading key store from "D:\DePaso\apache-ftpserver-1.1.1\.\res\ftpserver.jks", using the key store type "jks" [DEBUG] 2019-01-19 15:07:05,587 [] [] Trying to load store from file [DEBUG] 2019-01-19 15:07:06,563 [] [] SSL configuration found for the listener, falling back for that for the data connection [DEBUG] 2019-01-19 15:07:06,568 [] [] Loaded 4 bean definitions from location pattern [D:\DePaso\apache-ftpserver-1.1.1\res\conf\ftpd-typical.xml] [ INFO] 2019-01-19 15:07:06,568 [] [] Bean factory for application context [org.springframework.context.support.FileSystemXmlApplicationContext@deb6432]: org.springframework.beans.factory.support.DefaultListableBeanFactory@39aeed2f<mailto:org.springframework.beans.factory.support.DefaultListableBeanFactory@39aeed2f> [DEBUG] 2019-01-19 15:07:06,569 [] [] 4 beans defined in org.springframework.context.support.FileSystemXmlApplicationContext@deb6432<mailto:org.springframework.context.support.FileSystemXmlApplicationContext@deb6432>: display name [org.springframework.context.support.FileSystemXmlApplicationContext@deb6432]; startup date [Sat Jan 19 15:07:05 COT 2019]; root of context hierarchy [DEBUG] 2019-01-19 15:07:06,583 [] [] Unable to locate MessageSource with name 'messageSource': using default [org.springframework.context.support.DelegatingMessageSource@4dfa3a9d] [DEBUG] 2019-01-19 15:07:06,585 [] [] Unable to locate ApplicationEventMulticaster with name 'applicationEventMulticaster': using default [org.springframework.context.event.SimpleApplicationEventMulticaster@598067a5] [ INFO] 2019-01-19 15:07:06,586 [] [] Pre-instantiating singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@39aeed2f<mailto:org.springframework.beans.factory.support.DefaultListableBeanFactory@39aeed2f>: defining beans [org.apache.ftpserver.listener.ListenerFactory#0,org.apache.ftpserver.usermanager.PropertiesUserManagerFactory#0,org.apache.ftpserver.FtpServerFactory#0,myServer]; root of factory hierarchy [DEBUG] 2019-01-19 15:07:06,587 [] [] Creating shared instance of singleton bean 'org.apache.ftpserver.listener.ListenerFactory#0' [DEBUG] 2019-01-19 15:07:06,588 [] [] Creating instance of bean 'org.apache.ftpserver.listener.ListenerFactory#0' [DEBUG] 2019-01-19 15:07:06,605 [] [] Eagerly caching bean 'org.apache.ftpserver.listener.ListenerFactory#0' to allow for resolving potential circular references [DEBUG] 2019-01-19 15:07:06,643 [] [] Finished creating instance of bean 'org.apache.ftpserver.listener.ListenerFactory#0' [DEBUG] 2019-01-19 15:07:06,644 [] [] Creating shared instance of singleton bean 'org.apache.ftpserver.usermanager.PropertiesUserManagerFactory#0' [DEBUG] 2019-01-19 15:07:06,644 [] [] Creating instance of bean 'org.apache.ftpserver.usermanager.PropertiesUserManagerFactory#0' [DEBUG] 2019-01-19 15:07:06,645 [] [] Eagerly caching bean 'org.apache.ftpserver.usermanager.PropertiesUserManagerFactory#0' to allow for resolving potential circular references [DEBUG] 2019-01-19 15:07:06,652 [] [] Finished creating instance of bean 'org.apache.ftpserver.usermanager.PropertiesUserManagerFactory#0' [DEBUG] 2019-01-19 15:07:06,652 [] [] Creating shared instance of singleton bean 'org.apache.ftpserver.FtpServerFactory#0' [DEBUG] 2019-01-19 15:07:06,652 [] [] Creating instance of bean 'org.apache.ftpserver.FtpServerFactory#0' [DEBUG] 2019-01-19 15:07:06,698 [] [] Eagerly caching bean 'org.apache.ftpserver.FtpServerFactory#0' to allow for resolving potential circular references [DEBUG] 2019-01-19 15:07:06,699 [] [] Creating instance of bean '(inner bean)' [DEBUG] 2019-01-19 15:07:06,701 [] [] Returning cached instance of singleton bean 'org.apache.ftpserver.listener.ListenerFactory#0' [DEBUG] 2019-01-19 15:07:06,702 [] [] Finished creating instance of bean '(inner bean)' [DEBUG] 2019-01-19 15:07:06,705 [] [] Creating instance of bean '(inner bean)#1' [DEBUG] 2019-01-19 15:07:06,705 [] [] Returning cached instance of singleton bean 'org.apache.ftpserver.usermanager.PropertiesUserManagerFactory#0' [DEBUG] 2019-01-19 15:07:06,705 [] [] File configured, will try loading [DEBUG] 2019-01-19 15:07:06,705 [] [] File found on file system [DEBUG] 2019-01-19 15:07:06,706 [] [] Finished creating instance of bean '(inner bean)#1' [DEBUG] 2019-01-19 15:07:06,706 [] [] Finished creating instance of bean 'org.apache.ftpserver.FtpServerFactory#0' [DEBUG] 2019-01-19 15:07:06,706 [] [] Creating shared instance of singleton bean 'myServer' [DEBUG] 2019-01-19 15:07:06,706 [] [] Creating instance of bean 'myServer' [DEBUG] 2019-01-19 15:07:06,706 [] [] Returning cached instance of singleton bean 'org.apache.ftpserver.FtpServerFactory#0' [DEBUG] 2019-01-19 15:07:06,707 [] [] Eagerly caching bean 'myServer' to allow for resolving potential circular references [DEBUG] 2019-01-19 15:07:06,707 [] [] Finished creating instance of bean 'myServer' [DEBUG] 2019-01-19 15:07:06,707 [] [] Publishing event in context [org.springframework.context.support.FileSystemXmlApplicationContext@deb6432]: org.springframework.context.event.ContextRefreshedEvent[source=org.springframework.context.support.FileSystemXmlApplicationContext@deb6432: display name [org.springframework.context.support.FileSystemXmlApplicationContext@deb6432]; startup date [Sat Jan 19 15:07:05 COT 2019]; root of context hierarchy] [DEBUG] 2019-01-19 15:07:06,707 [] [] Returning cached instance of singleton bean 'myServer' [DEBUG] 2019-01-19 15:07:06,769 [] [] Intializing shared thread pool executor with max threads of 10 [ INFO] 2019-01-19 15:07:06,808 [] [] FTP server started [DEBUG] 2019-01-19 15:07:19,115 [] [0:0:0:0:0:0:0:1] Firing a SESSION_CREATED event for session 2 [DEBUG] 2019-01-19 15:07:19,117 [] [0:0:0:0:0:0:0:1] Firing a SESSION_CREATED event for session 2 [ INFO] 2019-01-19 15:07:19,118 [] [0:0:0:0:0:0:0:1] CREATED [DEBUG] 2019-01-19 15:07:19,125 [] [0:0:0:0:0:0:0:1] Event SESSION_CREATED has been fired for session 2 [DEBUG] 2019-01-19 15:07:19,126 [] [0:0:0:0:0:0:0:1] Event SESSION_CREATED has been fired for session 2 [DEBUG] 2019-01-19 15:07:19,126 [] [0:0:0:0:0:0:0:1] Firing a SESSION_OPENED event for session 2 [DEBUG] 2019-01-19 15:07:19,128 [] [0:0:0:0:0:0:0:1] Adding event SESSION_OPENED to session 2 Queue : [SESSION_OPENED, ] [DEBUG] 2019-01-19 15:07:19,130 [] [0:0:0:0:0:0:0:1] Event SESSION_OPENED has been fired for session 2 [DEBUG] 2019-01-19 15:07:19,130 [] [0:0:0:0:0:0:0:1] Firing a SESSION_OPENED event for session 2 [DEBUG] 2019-01-19 15:07:19,130 [] [0:0:0:0:0:0:0:1] Firing a SESSION_OPENED event for session 2 [ INFO] 2019-01-19 15:07:19,131 [] [0:0:0:0:0:0:0:1] OPENED [DEBUG] 2019-01-19 15:07:19,134 [] [0:0:0:0:0:0:0:1] Firing a WRITE event for session 2 [DEBUG] 2019-01-19 15:07:19,136 [] [0:0:0:0:0:0:0:1] Firing a WRITE event for session 2 [DEBUG] 2019-01-19 15:07:19,137 [] [0:0:0:0:0:0:0:1] Event WRITE has been fired for session 2 [DEBUG] 2019-01-19 15:07:19,139 [] [0:0:0:0:0:0:0:1] Firing a WRITE event for session 2 [DEBUG] 2019-01-19 15:07:19,140 [] [0:0:0:0:0:0:0:1] Event WRITE has been fired for session 2 [DEBUG] 2019-01-19 15:07:19,140 [] [0:0:0:0:0:0:0:1] Event WRITE has been fired for session 2 [DEBUG] 2019-01-19 15:07:19,140 [] [0:0:0:0:0:0:0:1] Event SESSION_OPENED has been fired for session 2 [DEBUG] 2019-01-19 15:07:19,140 [] [] Event SESSION_OPENED has been fired for session 2 [DEBUG] 2019-01-19 15:07:19,140 [] [0:0:0:0:0:0:0:1] Firing a MESSAGE_RECEIVED event for session 2 [DEBUG] 2019-01-19 15:07:19,141 [] [0:0:0:0:0:0:0:1] Adding event MESSAGE_RECEIVED to session 2 Queue : [MESSAGE_RECEIVED, ] [DEBUG] 2019-01-19 15:07:19,141 [] [0:0:0:0:0:0:0:1] Event MESSAGE_RECEIVED has been fired for session 2 [DEBUG] 2019-01-19 15:07:19,141 [] [] Firing a MESSAGE_RECEIVED event for session 2 [DEBUG] 2019-01-19 15:07:19,141 [] [] Processing a MESSAGE_RECEIVED for session 2 [DEBUG] 2019-01-19 15:07:19,141 [] [0:0:0:0:0:0:0:1] Firing a MESSAGE_SENT event for session 2 [DEBUG] 2019-01-19 15:07:19,141 [] [0:0:0:0:0:0:0:1] Adding event MESSAGE_SENT to session 2 Queue : [MESSAGE_SENT, ] [DEBUG] 2019-01-19 15:07:19,141 [] [0:0:0:0:0:0:0:1] Event MESSAGE_SENT has been fired for session 2 [DEBUG] 2019-01-19 15:07:19,143 [] [0:0:0:0:0:0:0:1] Firing a MESSAGE_RECEIVED event for session 2 [ INFO] 2019-01-19 15:07:19,143 [] [0:0:0:0:0:0:0:1] RECEIVED: AUTH TLS [DEBUG] 2019-01-19 15:07:19,145 [] [0:0:0:0:0:0:0:1] Adding the SSL Filter sslSessionFilter to the chain [DEBUG] 2019-01-19 15:07:19,147 [] [0:0:0:0:0:0:0:1] Session Server[2](no sslEngine) Initializing the SSL Handler [DEBUG] 2019-01-19 15:07:19,174 [] [0:0:0:0:0:0:0:1] Session Server[2](no sslEngine) SSL Handler Initialization done. [DEBUG] 2019-01-19 15:07:19,174 [] [0:0:0:0:0:0:0:1] Session Server[2](ssl...) : Starting the first handshake [DEBUG] 2019-01-19 15:07:19,175 [] [0:0:0:0:0:0:0:1] Session Server[2](ssl...) processing the NEED_UNWRAP state [DEBUG] 2019-01-19 15:07:19,175 [] [0:0:0:0:0:0:0:1] Firing a WRITE event for session 2 [DEBUG] 2019-01-19 15:07:19,176 [] [0:0:0:0:0:0:0:1] Firing a WRITE event for session 2 [DEBUG] 2019-01-19 15:07:19,176 [] [0:0:0:0:0:0:0:1] Session Server[2](ssl...): Writing Message : WriteRequest: HeapBuffer[pos=0 lim=49 cap=49: 32 33 34 20 43 6F 6D 6D 61 6E 64 20 41 55 54 48...] [DEBUG] 2019-01-19 15:07:19,181 [] [0:0:0:0:0:0:0:1] Event WRITE has been fired for session 2 [DEBUG] 2019-01-19 15:07:19,182 [] [] Session Server[2](ssl...): Message received : HeapBuffer[pos=0 lim=212 cap=2048: 16 03 01 00 CF 01 00 00 CB 03 03 5C 43 83 E2 BA...] [DEBUG] 2019-01-19 15:07:19,182 [] [0:0:0:0:0:0:0:1] Firing a WRITE event for session 2 [DEBUG] 2019-01-19 15:07:19,182 [] [] Session Server[2](ssl...) Processing the received message [DEBUG] 2019-01-19 15:07:19,182 [] [] Session Server[2](ssl...) processing the NEED_UNWRAP state [DEBUG] 2019-01-19 15:07:19,183 [] [] Session Server[2](ssl...) processing the NEED_TASK state [DEBUG] 2019-01-19 15:07:19,204 [] [] Session Server[2](ssl...) processing the NEED_WRAP state [DEBUG] 2019-01-19 15:07:19,206 [] [0:0:0:0:0:0:0:1] Firing a CLOSE event for session 2 [DEBUG] 2019-01-19 15:07:19,206 [] [0:0:0:0:0:0:0:1] Firing a CLOSE event for session 2 [DEBUG] 2019-01-19 15:07:19,207 [] [0:0:0:0:0:0:0:1] Session Server[2]: Writing Message : WriteRequest: HeapBuffer[pos=0 lim=7 cap=8: 15 03 03 00 02 02 28] [DEBUG] 2019-01-19 15:07:19,208 [] [0:0:0:0:0:0:0:1] Unexpected exception from SSLEngine.closeInbound(). javax.net.ssl.SSLException: Inbound closed before receiving peer's close_notify: possible truncation attack? at sun.security.ssl.Alerts.getSSLException(Unknown Source) at sun.security.ssl.SSLEngineImpl.fatal(Unknown Source) at sun.security.ssl.SSLEngineImpl.fatal(Unknown Source) at sun.security.ssl.SSLEngineImpl.closeInbound(Unknown Source) at org.apache.mina.filter.ssl.SslHandler.destroy(SslHandler.java:213) at org.apache.mina.filter.ssl.SslFilter.initiateClosure(SslFilter.java:755) at org.apache.mina.filter.ssl.SslFilter.filterClose(SslFilter.java:677) at org.apache.mina.core.filterchain.DefaultIoFilterChain.callPreviousFilterClose(DefaultIoFilterChain.java:648) at org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1600(DefaultIoFilterChain.java:48) at org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.filterClose(DefaultIoFilterChain.java:962) at org.apache.mina.core.filterchain.IoFilterEvent.fire(IoFilterEvent.java:88) at org.apache.mina.filter.logging.MdcInjectionFilter.filter(MdcInjectionFilter.java:135) at org.apache.mina.filter.util.CommonEventFilter.filterClose(CommonEventFilter.java:85) at org.apache.mina.core.filterchain.DefaultIoFilterChain.callPreviousFilterClose(DefaultIoFilterChain.java:648) at org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1600(DefaultIoFilterChain.java:48) at org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.filterClose(DefaultIoFilterChain.java:962) at org.apache.mina.filter.executor.ExecutorFilter.filterClose(ExecutorFilter.java:624) at org.apache.mina.core.filterchain.DefaultIoFilterChain.callPreviousFilterClose(DefaultIoFilterChain.java:648) at org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1600(DefaultIoFilterChain.java:48) at org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.filterClose(DefaultIoFilterChain.java:962) at org.apache.mina.core.filterchain.IoFilterAdapter.filterClose(IoFilterAdapter.java:130) at org.apache.mina.core.filterchain.DefaultIoFilterChain.callPreviousFilterClose(DefaultIoFilterChain.java:648) at org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1600(DefaultIoFilterChain.java:48) at org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.filterClose(DefaultIoFilterChain.java:962) at org.apache.mina.core.filterchain.IoFilterEvent.fire(IoFilterEvent.java:88) at org.apache.mina.filter.logging.MdcInjectionFilter.filter(MdcInjectionFilter.java:135) at org.apache.mina.filter.util.CommonEventFilter.filterClose(CommonEventFilter.java:85) at org.apache.mina.core.filterchain.DefaultIoFilterChain.callPreviousFilterClose(DefaultIoFilterChain.java:648) at org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1600(DefaultIoFilterChain.java:48) at org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.filterClose(DefaultIoFilterChain.java:962) at org.apache.mina.core.filterchain.IoFilterAdapter.filterClose(IoFilterAdapter.java:130) at org.apache.mina.core.filterchain.DefaultIoFilterChain.callPreviousFilterClose(DefaultIoFilterChain.java:648) at org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1600(DefaultIoFilterChain.java:48) at org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.filterClose(DefaultIoFilterChain.java:962) at org.apache.mina.core.filterchain.DefaultIoFilterChain$TailFilter.filterClose(DefaultIoFilterChain.java:886) at org.apache.mina.core.filterchain.DefaultIoFilterChain.callPreviousFilterClose(DefaultIoFilterChain.java:648) at org.apache.mina.core.filterchain.DefaultIoFilterChain.fireFilterClose(DefaultIoFilterChain.java:641) at org.apache.mina.core.session.AbstractIoSession.closeNow(AbstractIoSession.java:357) at org.apache.mina.filter.ssl.SslFilter.messageReceived(SslFilter.java:524) at org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:542) at org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1300(DefaultIoFilterChain.java:48) at org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageReceived(DefaultIoFilterChain.java:947) at org.apache.mina.core.filterchain.IoFilterAdapter.messageReceived(IoFilterAdapter.java:109) at org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:542) at org.apache.mina.core.filterchain.DefaultIoFilterChain.fireMessageReceived(DefaultIoFilterChain.java:535) at org.apache.mina.core.polling.AbstractPollingIoProcessor.read(AbstractPollingIoProcessor.java:703) at org.apache.mina.core.polling.AbstractPollingIoProcessor.process(AbstractPollingIoProcessor.java:659) at org.apache.mina.core.polling.AbstractPollingIoProcessor.process(AbstractPollingIoProcessor.java:648) at org.apache.mina.core.polling.AbstractPollingIoProcessor.access$600(AbstractPollingIoProcessor.java:68) at org.apache.mina.core.polling.AbstractPollingIoProcessor$Processor.run(AbstractPollingIoProcessor.java:1120) at org.apache.mina.util.NamePreservingRunnable.run(NamePreservingRunnable.java:64) at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source) at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source) at java.lang.Thread.run(Unknown Source) [DEBUG] 2019-01-19 15:07:19,214 [] [0:0:0:0:0:0:0:1] Event CLOSE has been fired for session 2 [DEBUG] 2019-01-19 15:07:19,214 [] [0:0:0:0:0:0:0:1] Event CLOSE has been fired for session 2 [DEBUG] 2019-01-19 15:07:19,214 [] [0:0:0:0:0:0:0:1] Firing a EXCEPTION_CAUGHT event for session 2 [DEBUG] 2019-01-19 15:07:19,214 [] [0:0:0:0:0:0:0:1] Adding event EXCEPTION_CAUGHT to session 2 Queue : [MESSAGE_SENT, , EXCEPTION_CAUGHT, ] [DEBUG] 2019-01-19 15:07:19,215 [] [0:0:0:0:0:0:0:1] Event EXCEPTION_CAUGHT has been fired for session 2 [DEBUG] 2019-01-19 15:07:19,217 [] [0:0:0:0:0:0:0:1] Firing a SESSION_CLOSED event for session 2 [DEBUG] 2019-01-19 15:07:19,217 [] [0:0:0:0:0:0:0:1] Adding event SESSION_CLOSED to session 2 Queue : [MESSAGE_SENT, , EXCEPTION_CAUGHT, , SESSION_CLOSED, ] [DEBUG] 2019-01-19 15:07:19,217 [] [0:0:0:0:0:0:0:1] Event SESSION_CLOSED has been fired for session 2 [DEBUG] 2019-01-19 15:07:19,221 [] [0:0:0:0:0:0:0:1] Session Server[2]: Writing Message : MessageWriteRequest, parent : WR WrapperWriteRequest: 234 Command AUTH okay; starting TLS connection. [DEBUG] 2019-01-19 15:07:19,221 [] [0:0:0:0:0:0:0:1] Event WRITE has been fired for session 2 [DEBUG] 2019-01-19 15:07:19,221 [] [0:0:0:0:0:0:0:1] Event WRITE has been fired for session 2 [DEBUG] 2019-01-19 15:07:19,222 [] [0:0:0:0:0:0:0:1] Event MESSAGE_RECEIVED has been fired for session 2 [DEBUG] 2019-01-19 15:07:19,222 [] [] Event MESSAGE_RECEIVED has been fired for session 2 [DEBUG] 2019-01-19 15:07:19,222 [] [] Firing a MESSAGE_SENT event for session 2 [DEBUG] 2019-01-19 15:07:19,222 [] [0:0:0:0:0:0:0:1] Firing a MESSAGE_SENT event for session 2 [ INFO] 2019-01-19 15:07:19,223 [] [0:0:0:0:0:0:0:1] SENT: 220 Service ready for new user. [DEBUG] 2019-01-19 15:07:19,223 [] [0:0:0:0:0:0:0:1] Event MESSAGE_SENT has been fired for session 2 [DEBUG] 2019-01-19 15:07:19,223 [] [] Event MESSAGE_SENT has been fired for session 2 [DEBUG] 2019-01-19 15:07:19,223 [] [] Firing a EXCEPTION_CAUGHT event for session 2 [DEBUG] 2019-01-19 15:07:19,223 [] [0:0:0:0:0:0:0:1] Firing a EXCEPTION_CAUGHT event for session 2 [ WARN] 2019-01-19 15:07:19,223 [] [0:0:0:0:0:0:0:1] EXCEPTION : javax.net.ssl.SSLHandshakeException: SSL handshake failed. at org.apache.mina.filter.ssl.SslFilter.messageReceived(SslFilter.java:519) at org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:542) at org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1300(DefaultIoFilterChain.java:48) at org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageReceived(DefaultIoFilterChain.java:947) at org.apache.mina.core.filterchain.IoFilterAdapter.messageReceived(IoFilterAdapter.java:109) at org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:542) at org.apache.mina.core.filterchain.DefaultIoFilterChain.fireMessageReceived(DefaultIoFilterChain.java:535) at org.apache.mina.core.polling.AbstractPollingIoProcessor.read(AbstractPollingIoProcessor.java:703) at org.apache.mina.core.polling.AbstractPollingIoProcessor.process(AbstractPollingIoProcessor.java:659) at org.apache.mina.core.polling.AbstractPollingIoProcessor.process(AbstractPollingIoProcessor.java:648) at org.apache.mina.core.polling.AbstractPollingIoProcessor.access$600(AbstractPollingIoProcessor.java:68) at org.apache.mina.core.polling.AbstractPollingIoProcessor$Processor.run(AbstractPollingIoProcessor.java:1120) at org.apache.mina.util.NamePreservingRunnable.run(NamePreservingRunnable.java:64) at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source) at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source) at java.lang.Thread.run(Unknown Source) Caused by: javax.net.ssl.SSLHandshakeException: no cipher suites in common at sun.security.ssl.Handshaker.checkThrown(Unknown Source) at sun.security.ssl.SSLEngineImpl.checkTaskThrown(Unknown Source) at sun.security.ssl.SSLEngineImpl.writeAppRecord(Unknown Source) at sun.security.ssl.SSLEngineImpl.wrap(Unknown Source) at javax.net.ssl.SSLEngine.wrap(Unknown Source) at org.apache.mina.filter.ssl.SslHandler.handshake(SslHandler.java:601) at org.apache.mina.filter.ssl.SslHandler.messageReceived(SslHandler.java:360) at org.apache.mina.filter.ssl.SslFilter.messageReceived(SslFilter.java:500) ... 15 more Caused by: javax.net.ssl.SSLHandshakeException: no cipher suites in common at sun.security.ssl.Alerts.getSSLException(Unknown Source) at sun.security.ssl.SSLEngineImpl.fatal(Unknown Source) at sun.security.ssl.Handshaker.fatalSE(Unknown Source) at sun.security.ssl.Handshaker.fatalSE(Unknown Source) at sun.security.ssl.ServerHandshaker.chooseCipherSuite(Unknown Source) at sun.security.ssl.ServerHandshaker.clientHello(Unknown Source) at sun.security.ssl.ServerHandshaker.processMessage(Unknown Source) at sun.security.ssl.Handshaker.processLoop(Unknown Source) at sun.security.ssl.Handshaker$1.run(Unknown Source) at sun.security.ssl.Handshaker$1.run(Unknown Source) at java.security.AccessController.doPrivileged(Native Method) at sun.security.ssl.Handshaker$DelegatedTask.run(Unknown Source) at org.apache.mina.filter.ssl.SslHandler.doTasks(SslHandler.java:793) at org.apache.mina.filter.ssl.SslHandler.handshake(SslHandler.java:567) ... 17 more [ERROR] 2019-01-19 15:07:19,225 [] [0:0:0:0:0:0:0:1] Exception caught, closing session javax.net.ssl.SSLHandshakeException: SSL handshake failed. at org.apache.mina.filter.ssl.SslFilter.messageReceived(SslFilter.java:519) at org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:542) at org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1300(DefaultIoFilterChain.java:48) at org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageReceived(DefaultIoFilterChain.java:947) at org.apache.mina.core.filterchain.IoFilterAdapter.messageReceived(IoFilterAdapter.java:109) at org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:542) at org.apache.mina.core.filterchain.DefaultIoFilterChain.fireMessageReceived(DefaultIoFilterChain.java:535) at org.apache.mina.core.polling.AbstractPollingIoProcessor.read(AbstractPollingIoProcessor.java:703) at org.apache.mina.core.polling.AbstractPollingIoProcessor.process(AbstractPollingIoProcessor.java:659) at org.apache.mina.core.polling.AbstractPollingIoProcessor.process(AbstractPollingIoProcessor.java:648) at org.apache.mina.core.polling.AbstractPollingIoProcessor.access$600(AbstractPollingIoProcessor.java:68) at org.apache.mina.core.polling.AbstractPollingIoProcessor$Processor.run(AbstractPollingIoProcessor.java:1120) at org.apache.mina.util.NamePreservingRunnable.run(NamePreservingRunnable.java:64) at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source) at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source) at java.lang.Thread.run(Unknown Source) Caused by: javax.net.ssl.SSLHandshakeException: no cipher suites in common at sun.security.ssl.Handshaker.checkThrown(Unknown Source) at sun.security.ssl.SSLEngineImpl.checkTaskThrown(Unknown Source) at sun.security.ssl.SSLEngineImpl.writeAppRecord(Unknown Source) at sun.security.ssl.SSLEngineImpl.wrap(Unknown Source) at javax.net.ssl.SSLEngine.wrap(Unknown Source) at org.apache.mina.filter.ssl.SslHandler.handshake(SslHandler.java:601) at org.apache.mina.filter.ssl.SslHandler.messageReceived(SslHandler.java:360) at org.apache.mina.filter.ssl.SslFilter.messageReceived(SslFilter.java:500) ... 15 more Caused by: javax.net.ssl.SSLHandshakeException: no cipher suites in common at sun.security.ssl.Alerts.getSSLException(Unknown Source) at sun.security.ssl.SSLEngineImpl.fatal(Unknown Source) at sun.security.ssl.Handshaker.fatalSE(Unknown Source) at sun.security.ssl.Handshaker.fatalSE(Unknown Source) at sun.security.ssl.ServerHandshaker.chooseCipherSuite(Unknown Source) at sun.security.ssl.ServerHandshaker.clientHello(Unknown Source) at sun.security.ssl.ServerHandshaker.processMessage(Unknown Source) at sun.security.ssl.Handshaker.processLoop(Unknown Source) at sun.security.ssl.Handshaker$1.run(Unknown Source) at sun.security.ssl.Handshaker$1.run(Unknown Source) at java.security.AccessController.doPrivileged(Native Method) at sun.security.ssl.Handshaker$DelegatedTask.run(Unknown Source) at org.apache.mina.filter.ssl.SslHandler.doTasks(SslHandler.java:793) at org.apache.mina.filter.ssl.SslHandler.handshake(SslHandler.java:567) ... 17 more [DEBUG] 2019-01-19 15:07:19,226 [] [0:0:0:0:0:0:0:1] Event EXCEPTION_CAUGHT has been fired for session 2 [DEBUG] 2019-01-19 15:07:19,226 [] [] Event EXCEPTION_CAUGHT has been fired for session 2 [DEBUG] 2019-01-19 15:07:19,226 [] [] Firing a SESSION_CLOSED event for session 2 [DEBUG] 2019-01-19 15:07:19,226 [] [0:0:0:0:0:0:0:1] Firing a SESSION_CLOSED event for session 2 [ INFO] 2019-01-19 15:07:19,226 [] [0:0:0:0:0:0:0:1] CLOSED [DEBUG] 2019-01-19 15:07:19,227 [] [0:0:0:0:0:0:0:1] Closing session [DEBUG] 2019-01-19 15:07:19,230 [] [0:0:0:0:0:0:0:1] Statistics login and connection count decreased due to session close [DEBUG] 2019-01-19 15:07:19,230 [] [0:0:0:0:0:0:0:1] Session closed [DEBUG] 2019-01-19 15:07:19,230 [] [0:0:0:0:0:0:0:1] Event SESSION_CLOSED has been fired for session 2 [DEBUG] 2019-01-19 15:07:19,231 [] [] Event SESSION_CLOSED has been fired for session 2 [DEBUG] 2019-01-19 15:07:24,219 [] [0:0:0:0:0:0:0:1] Firing a SESSION_CREATED event for session 3 [DEBUG] 2019-01-19 15:07:24,219 [] [0:0:0:0:0:0:0:1] Firing a SESSION_CREATED event for session 3 [ INFO] 2019-01-19 15:07:24,219 [] [0:0:0:0:0:0:0:1] CREATED [DEBUG] 2019-01-19 15:07:24,220 [] [0:0:0:0:0:0:0:1] Event SESSION_CREATED has been fired for session 3 [DEBUG] 2019-01-19 15:07:24,220 [] [0:0:0:0:0:0:0:1] Event SESSION_CREATED has been fired for session 3 [DEBUG] 2019-01-19 15:07:24,220 [] [0:0:0:0:0:0:0:1] Firing a SESSION_OPENED event for session 3 [DEBUG] 2019-01-19 15:07:24,220 [] [0:0:0:0:0:0:0:1] Adding event SESSION_OPENED to session 3 Queue : [SESSION_OPENED, ] [DEBUG] 2019-01-19 15:07:24,221 [] [0:0:0:0:0:0:0:1] Event SESSION_OPENED has been fired for session 3 [DEBUG] 2019-01-19 15:07:24,222 [] [0:0:0:0:0:0:0:1] Firing a SESSION_OPENED event for session 3 [DEBUG] 2019-01-19 15:07:24,222 [] [0:0:0:0:0:0:0:1] Firing a SESSION_OPENED event for session 3 [ INFO] 2019-01-19 15:07:24,222 [] [0:0:0:0:0:0:0:1] OPENED [DEBUG] 2019-01-19 15:07:24,223 [] [0:0:0:0:0:0:0:1] Firing a WRITE event for session 3 [DEBUG] 2019-01-19 15:07:24,224 [] [0:0:0:0:0:0:0:1] Firing a WRITE event for session 3 [DEBUG] 2019-01-19 15:07:24,224 [] [0:0:0:0:0:0:0:1] Event WRITE has been fired for session 3 [DEBUG] 2019-01-19 15:07:24,225 [] [0:0:0:0:0:0:0:1] Firing a WRITE event for session 3 [DEBUG] 2019-01-19 15:07:24,225 [] [0:0:0:0:0:0:0:1] Firing a MESSAGE_RECEIVED event for session 3 [DEBUG] 2019-01-19 15:07:24,225 [] [0:0:0:0:0:0:0:1] Event WRITE has been fired for session 3 [DEBUG] 2019-01-19 15:07:24,225 [] [0:0:0:0:0:0:0:1] Adding event MESSAGE_RECEIVED to session 3 Queue : [MESSAGE_RECEIVED, ] [DEBUG] 2019-01-19 15:07:24,225 [] [0:0:0:0:0:0:0:1] Event MESSAGE_RECEIVED has been fired for session 3 [DEBUG] 2019-01-19 15:07:24,225 [] [0:0:0:0:0:0:0:1] Event WRITE has been fired for session 3 [DEBUG] 2019-01-19 15:07:24,225 [] [0:0:0:0:0:0:0:1] Event SESSION_OPENED has been fired for session 3 [DEBUG] 2019-01-19 15:07:24,225 [] [0:0:0:0:0:0:0:1] Firing a MESSAGE_SENT event for session 3 [DEBUG] 2019-01-19 15:07:24,226 [] [0:0:0:0:0:0:0:1] Adding event MESSAGE_SENT to session 3 Queue : [MESSAGE_RECEIVED, , MESSAGE_SENT, ] [DEBUG] 2019-01-19 15:07:24,226 [] [0:0:0:0:0:0:0:1] Event MESSAGE_SENT has been fired for session 3 [DEBUG] 2019-01-19 15:07:24,227 [] [] Event SESSION_OPENED has been fired for session 3 [DEBUG] 2019-01-19 15:07:24,227 [] [] Firing a MESSAGE_RECEIVED event for session 3 [DEBUG] 2019-01-19 15:07:24,227 [] [] Processing a MESSAGE_RECEIVED for session 3 [DEBUG] 2019-01-19 15:07:24,228 [] [0:0:0:0:0:0:0:1] Firing a MESSAGE_RECEIVED event for session 3 [ INFO] 2019-01-19 15:07:24,228 [] [0:0:0:0:0:0:0:1] RECEIVED: AUTH TLS [DEBUG] 2019-01-19 15:07:24,228 [] [0:0:0:0:0:0:0:1] Adding the SSL Filter sslSessionFilter to the chain [DEBUG] 2019-01-19 15:07:24,229 [] [0:0:0:0:0:0:0:1] Session Server[3](no sslEngine) Initializing the SSL Handler [DEBUG] 2019-01-19 15:07:24,237 [] [0:0:0:0:0:0:0:1] Session Server[3](no sslEngine) SSL Handler Initialization done. [DEBUG] 2019-01-19 15:07:24,238 [] [0:0:0:0:0:0:0:1] Session Server[3](ssl...) : Starting the first handshake [DEBUG] 2019-01-19 15:07:24,238 [] [0:0:0:0:0:0:0:1] Session Server[3](ssl...) processing the NEED_UNWRAP state [DEBUG] 2019-01-19 15:07:24,238 [] [0:0:0:0:0:0:0:1] Firing a WRITE event for session 3 [DEBUG] 2019-01-19 15:07:24,238 [] [0:0:0:0:0:0:0:1] Firing a WRITE event for session 3 [DEBUG] 2019-01-19 15:07:24,239 [] [0:0:0:0:0:0:0:1] Session Server[3](ssl...): Writing Message : WriteRequest: HeapBuffer[pos=0 lim=49 cap=49: 32 33 34 20 43 6F 6D 6D 61 6E 64 20 41 55 54 48...] [DEBUG] 2019-01-19 15:07:24,240 [] [0:0:0:0:0:0:0:1] Event WRITE has been fired for session 3 [DEBUG] 2019-01-19 15:07:24,241 [] [0:0:0:0:0:0:0:1] Firing a WRITE event for session 3 [DEBUG] 2019-01-19 15:07:24,241 [] [0:0:0:0:0:0:0:1] Session Server[3](ssl...): Writing Message : MessageWriteRequest, parent : WR WrapperWriteRequest: 234 Command AUTH okay; starting TLS connection. [DEBUG] 2019-01-19 15:07:24,242 [] [0:0:0:0:0:0:0:1] Event WRITE has been fired for session 3 [DEBUG] 2019-01-19 15:07:24,242 [] [] Session Server[3](ssl...): Message received : HeapBuffer[pos=0 lim=212 cap=2048: 16 03 01 00 CF 01 00 00 CB 03 03 5C 43 83 6C 56...] [DEBUG] 2019-01-19 15:07:24,242 [] [0:0:0:0:0:0:0:1] Event WRITE has been fired for session 3 [DEBUG] 2019-01-19 15:07:24,242 [] [] Session Server[3](ssl...) Processing the received message [DEBUG] 2019-01-19 15:07:24,242 [] [] Session Server[3](ssl...) processing the NEED_UNWRAP state [DEBUG] 2019-01-19 15:07:24,242 [] [0:0:0:0:0:0:0:1] Event MESSAGE_RECEIVED has been fired for session 3 [DEBUG] 2019-01-19 15:07:24,243 [] [] Session Server[3](ssl...) processing the NEED_TASK state [DEBUG] 2019-01-19 15:07:24,243 [] [] Event MESSAGE_RECEIVED has been fired for session 3 [DEBUG] 2019-01-19 15:07:24,243 [] [] Firing a MESSAGE_SENT event for session 3 [DEBUG] 2019-01-19 15:07:24,243 [] [0:0:0:0:0:0:0:1] Firing a MESSAGE_SENT event for session 3 [ INFO] 2019-01-19 15:07:24,244 [] [0:0:0:0:0:0:0:1] SENT: 220 Service ready for new user. [DEBUG] 2019-01-19 15:07:24,244 [] [0:0:0:0:0:0:0:1] Event MESSAGE_SENT has been fired for session 3 [DEBUG] 2019-01-19 15:07:24,247 [] [] Session Server[3](ssl...) processing the NEED_WRAP state [DEBUG] 2019-01-19 15:07:24,247 [] [] Event MESSAGE_SENT has been fired for session 3 [DEBUG] 2019-01-19 15:07:24,247 [] [0:0:0:0:0:0:0:1] Firing a CLOSE event for session 3 [DEBUG] 2019-01-19 15:07:24,247 [] [0:0:0:0:0:0:0:1] Firing a CLOSE event for session 3 [DEBUG] 2019-01-19 15:07:24,247 [] [0:0:0:0:0:0:0:1] Session Server[3]: Writing Message : WriteRequest: HeapBuffer[pos=0 lim=7 cap=8: 15 03 03 00 02 02 28] [DEBUG] 2019-01-19 15:07:24,248 [] [0:0:0:0:0:0:0:1] Unexpected exception from SSLEngine.closeInbound(). javax.net.ssl.SSLException: Inbound closed before receiving peer's close_notify: possible truncation attack? at sun.security.ssl.Alerts.getSSLException(Unknown Source) at sun.security.ssl.SSLEngineImpl.fatal(Unknown Source) at sun.security.ssl.SSLEngineImpl.fatal(Unknown Source) at sun.security.ssl.SSLEngineImpl.closeInbound(Unknown Source) at org.apache.mina.filter.ssl.SslHandler.destroy(SslHandler.java:213) at org.apache.mina.filter.ssl.SslFilter.initiateClosure(SslFilter.java:755) at org.apache.mina.filter.ssl.SslFilter.filterClose(SslFilter.java:677) at org.apache.mina.core.filterchain.DefaultIoFilterChain.callPreviousFilterClose(DefaultIoFilterChain.java:648) at org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1600(DefaultIoFilterChain.java:48) at org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.filterClose(DefaultIoFilterChain.java:962) at org.apache.mina.core.filterchain.IoFilterEvent.fire(IoFilterEvent.java:88) at org.apache.mina.filter.logging.MdcInjectionFilter.filter(MdcInjectionFilter.java:135) at org.apache.mina.filter.util.CommonEventFilter.filterClose(CommonEventFilter.java:85) at org.apache.mina.core.filterchain.DefaultIoFilterChain.callPreviousFilterClose(DefaultIoFilterChain.java:648) at org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1600(DefaultIoFilterChain.java:48) at org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.filterClose(DefaultIoFilterChain.java:962) at org.apache.mina.filter.executor.ExecutorFilter.filterClose(ExecutorFilter.java:624) at org.apache.mina.core.filterchain.DefaultIoFilterChain.callPreviousFilterClose(DefaultIoFilterChain.java:648) at org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1600(DefaultIoFilterChain.java:48) at org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.filterClose(DefaultIoFilterChain.java:962) at org.apache.mina.core.filterchain.IoFilterAdapter.filterClose(IoFilterAdapter.java:130) at org.apache.mina.core.filterchain.DefaultIoFilterChain.callPreviousFilterClose(DefaultIoFilterChain.java:648) at org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1600(DefaultIoFilterChain.java:48) at org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.filterClose(DefaultIoFilterChain.java:962) at org.apache.mina.core.filterchain.IoFilterEvent.fire(IoFilterEvent.java:88) at org.apache.mina.filter.logging.MdcInjectionFilter.filter(MdcInjectionFilter.java:135) at org.apache.mina.filter.util.CommonEventFilter.filterClose(CommonEventFilter.java:85) at org.apache.mina.core.filterchain.DefaultIoFilterChain.callPreviousFilterClose(DefaultIoFilterChain.java:648) at org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1600(DefaultIoFilterChain.java:48) at org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.filterClose(DefaultIoFilterChain.java:962) at org.apache.mina.core.filterchain.IoFilterAdapter.filterClose(IoFilterAdapter.java:130) at org.apache.mina.core.filterchain.DefaultIoFilterChain.callPreviousFilterClose(DefaultIoFilterChain.java:648) at org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1600(DefaultIoFilterChain.java:48) at org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.filterClose(DefaultIoFilterChain.java:962) at org.apache.mina.core.filterchain.DefaultIoFilterChain$TailFilter.filterClose(DefaultIoFilterChain.java:886) at org.apache.mina.core.filterchain.DefaultIoFilterChain.callPreviousFilterClose(DefaultIoFilterChain.java:648) at org.apache.mina.core.filterchain.DefaultIoFilterChain.fireFilterClose(DefaultIoFilterChain.java:641) at org.apache.mina.core.session.AbstractIoSession.closeNow(AbstractIoSession.java:357) at org.apache.mina.filter.ssl.SslFilter.messageReceived(SslFilter.java:524) at org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:542) at org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1300(DefaultIoFilterChain.java:48) at org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageReceived(DefaultIoFilterChain.java:947) at org.apache.mina.core.filterchain.IoFilterAdapter.messageReceived(IoFilterAdapter.java:109) at org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:542) at org.apache.mina.core.filterchain.DefaultIoFilterChain.fireMessageReceived(DefaultIoFilterChain.java:535) at org.apache.mina.core.polling.AbstractPollingIoProcessor.read(AbstractPollingIoProcessor.java:703) at org.apache.mina.core.polling.AbstractPollingIoProcessor.process(AbstractPollingIoProcessor.java:659) at org.apache.mina.core.polling.AbstractPollingIoProcessor.process(AbstractPollingIoProcessor.java:648) at org.apache.mina.core.polling.AbstractPollingIoProcessor.access$600(AbstractPollingIoProcessor.java:68) at org.apache.mina.core.polling.AbstractPollingIoProcessor$Processor.run(AbstractPollingIoProcessor.java:1120) at org.apache.mina.util.NamePreservingRunnable.run(NamePreservingRunnable.java:64) at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source) at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source) at java.lang.Thread.run(Unknown Source) [DEBUG] 2019-01-19 15:07:24,249 [] [0:0:0:0:0:0:0:1] Event CLOSE has been fired for session 3 [DEBUG] 2019-01-19 15:07:24,249 [] [0:0:0:0:0:0:0:1] Event CLOSE has been fired for session 3 [DEBUG] 2019-01-19 15:07:24,249 [] [0:0:0:0:0:0:0:1] Firing a EXCEPTION_CAUGHT event for session 3 [DEBUG] 2019-01-19 15:07:24,249 [] [0:0:0:0:0:0:0:1] Adding event EXCEPTION_CAUGHT to session 3 Queue : [EXCEPTION_CAUGHT, ] [DEBUG] 2019-01-19 15:07:24,249 [] [0:0:0:0:0:0:0:1] Event EXCEPTION_CAUGHT has been fired for session 3 [DEBUG] 2019-01-19 15:07:24,250 [] [0:0:0:0:0:0:0:1] Firing a SESSION_CLOSED event for session 3 [DEBUG] 2019-01-19 15:07:24,255 [] [0:0:0:0:0:0:0:1] Adding event SESSION_CLOSED to session 3 Queue : [EXCEPTION_CAUGHT, , SESSION_CLOSED, ] [DEBUG] 2019-01-19 15:07:24,256 [] [0:0:0:0:0:0:0:1] Event SESSION_CLOSED has been fired for session 3 [DEBUG] 2019-01-19 15:07:24,258 [] [] Firing a EXCEPTION_CAUGHT event for session 3 [DEBUG] 2019-01-19 15:07:24,258 [] [0:0:0:0:0:0:0:1] Firing a EXCEPTION_CAUGHT event for session 3 [ WARN] 2019-01-19 15:07:24,258 [] [0:0:0:0:0:0:0:1] EXCEPTION : javax.net.ssl.SSLHandshakeException: SSL handshake failed. at org.apache.mina.filter.ssl.SslFilter.messageReceived(SslFilter.java:519) at org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:542) at org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1300(DefaultIoFilterChain.java:48) at org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageReceived(DefaultIoFilterChain.java:947) at org.apache.mina.core.filterchain.IoFilterAdapter.messageReceived(IoFilterAdapter.java:109) at org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:542) at org.apache.mina.core.filterchain.DefaultIoFilterChain.fireMessageReceived(DefaultIoFilterChain.java:535) at org.apache.mina.core.polling.AbstractPollingIoProcessor.read(AbstractPollingIoProcessor.java:703) at org.apache.mina.core.polling.AbstractPollingIoProcessor.process(AbstractPollingIoProcessor.java:659) at org.apache.mina.core.polling.AbstractPollingIoProcessor.process(AbstractPollingIoProcessor.java:648) at org.apache.mina.core.polling.AbstractPollingIoProcessor.access$600(AbstractPollingIoProcessor.java:68) at org.apache.mina.core.polling.AbstractPollingIoProcessor$Processor.run(AbstractPollingIoProcessor.java:1120) at org.apache.mina.util.NamePreservingRunnable.run(NamePreservingRunnable.java:64) at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source) at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source) at java.lang.Thread.run(Unknown Source) Caused by: javax.net.ssl.SSLHandshakeException: no cipher suites in common at sun.security.ssl.Handshaker.checkThrown(Unknown Source) at sun.security.ssl.SSLEngineImpl.checkTaskThrown(Unknown Source) at sun.security.ssl.SSLEngineImpl.writeAppRecord(Unknown Source) at sun.security.ssl.SSLEngineImpl.wrap(Unknown Source) at javax.net.ssl.SSLEngine.wrap(Unknown Source) at org.apache.mina.filter.ssl.SslHandler.handshake(SslHandler.java:601) at org.apache.mina.filter.ssl.SslHandler.messageReceived(SslHandler.java:360) at org.apache.mina.filter.ssl.SslFilter.messageReceived(SslFilter.java:500) ... 15 more Caused by: javax.net.ssl.SSLHandshakeException: no cipher suites in common at sun.security.ssl.Alerts.getSSLException(Unknown Source) at sun.security.ssl.SSLEngineImpl.fatal(Unknown Source) at sun.security.ssl.Handshaker.fatalSE(Unknown Source) at sun.security.ssl.Handshaker.fatalSE(Unknown Source) at sun.security.ssl.ServerHandshaker.chooseCipherSuite(Unknown Source) at sun.security.ssl.ServerHandshaker.clientHello(Unknown Source) at sun.security.ssl.ServerHandshaker.processMessage(Unknown Source) at sun.security.ssl.Handshaker.processLoop(Unknown Source) at sun.security.ssl.Handshaker$1.run(Unknown Source) at sun.security.ssl.Handshaker$1.run(Unknown Source) at java.security.AccessController.doPrivileged(Native Method) at sun.security.ssl.Handshaker$DelegatedTask.run(Unknown Source) at org.apache.mina.filter.ssl.SslHandler.doTasks(SslHandler.java:793) at org.apache.mina.filter.ssl.SslHandler.handshake(SslHandler.java:567) ... 17 more [ERROR] 2019-01-19 15:07:24,261 [] [0:0:0:0:0:0:0:1] Exception caught, closing session javax.net.ssl.SSLHandshakeException: SSL handshake failed. at org.apache.mina.filter.ssl.SslFilter.messageReceived(SslFilter.java:519) at org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:542) at org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1300(DefaultIoFilterChain.java:48) at org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageReceived(DefaultIoFilterChain.java:947) at org.apache.mina.core.filterchain.IoFilterAdapter.messageReceived(IoFilterAdapter.java:109) at org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:542) at org.apache.mina.core.filterchain.DefaultIoFilterChain.fireMessageReceived(DefaultIoFilterChain.java:535) at org.apache.mina.core.polling.AbstractPollingIoProcessor.read(AbstractPollingIoProcessor.java:703) at org.apache.mina.core.polling.AbstractPollingIoProcessor.process(AbstractPollingIoProcessor.java:659) at org.apache.mina.core.polling.AbstractPollingIoProcessor.process(AbstractPollingIoProcessor.java:648) at org.apache.mina.core.polling.AbstractPollingIoProcessor.access$600(AbstractPollingIoProcessor.java:68) at org.apache.mina.core.polling.AbstractPollingIoProcessor$Processor.run(AbstractPollingIoProcessor.java:1120) at org.apache.mina.util.NamePreservingRunnable.run(NamePreservingRunnable.java:64) at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source) at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source) at java.lang.Thread.run(Unknown Source) Caused by: javax.net.ssl.SSLHandshakeException: no cipher suites in common at sun.security.ssl.Handshaker.checkThrown(Unknown Source) at sun.security.ssl.SSLEngineImpl.checkTaskThrown(Unknown Source) at sun.security.ssl.SSLEngineImpl.writeAppRecord(Unknown Source) at sun.security.ssl.SSLEngineImpl.wrap(Unknown Source) at javax.net.ssl.SSLEngine.wrap(Unknown Source) at org.apache.mina.filter.ssl.SslHandler.handshake(SslHandler.java:601) at org.apache.mina.filter.ssl.SslHandler.messageReceived(SslHandler.java:360) at org.apache.mina.filter.ssl.SslFilter.messageReceived(SslFilter.java:500) ... 15 more Caused by: javax.net.ssl.SSLHandshakeException: no cipher suites in common at sun.security.ssl.Alerts.getSSLException(Unknown Source) at sun.security.ssl.SSLEngineImpl.fatal(Unknown Source) at sun.security.ssl.Handshaker.fatalSE(Unknown Source) at sun.security.ssl.Handshaker.fatalSE(Unknown Source) at sun.security.ssl.ServerHandshaker.chooseCipherSuite(Unknown Source) at sun.security.ssl.ServerHandshaker.clientHello(Unknown Source) at sun.security.ssl.ServerHandshaker.processMessage(Unknown Source) at sun.security.ssl.Handshaker.processLoop(Unknown Source) at sun.security.ssl.Handshaker$1.run(Unknown Source) at sun.security.ssl.Handshaker$1.run(Unknown Source) at java.security.AccessController.doPrivileged(Native Method) at sun.security.ssl.Handshaker$DelegatedTask.run(Unknown Source) at org.apache.mina.filter.ssl.SslHandler.doTasks(SslHandler.java:793) at org.apache.mina.filter.ssl.SslHandler.handshake(SslHandler.java:567) ... 17 more [DEBUG] 2019-01-19 15:07:24,262 [] [0:0:0:0:0:0:0:1] Event EXCEPTION_CAUGHT has been fired for session 3 [DEBUG] 2019-01-19 15:07:24,262 [] [] Event EXCEPTION_CAUGHT has been fired for session 3 [DEBUG] 2019-01-19 15:07:24,262 [] [] Firing a SESSION_CLOSED event for session 3 [DEBUG] 2019-01-19 15:07:24,262 [] [0:0:0:0:0:0:0:1] Firing a SESSION_CLOSED event for session 3 [ INFO] 2019-01-19 15:07:24,262 [] [0:0:0:0:0:0:0:1] CLOSED [DEBUG] 2019-01-19 15:07:24,262 [] [0:0:0:0:0:0:0:1] Closing session [DEBUG] 2019-01-19 15:07:24,262 [] [0:0:0:0:0:0:0:1] Statistics login and connection count decreased due to session close [DEBUG] 2019-01-19 15:07:24,262 [] [0:0:0:0:0:0:0:1] Session closed [DEBUG] 2019-01-19 15:07:24,263 [] [0:0:0:0:0:0:0:1] Event SESSION_CLOSED has been fired for session 3 [DEBUG] 2019-01-19 15:07:24,263 [] [] Event SESSION_CLOSED has been fired for session 3 AVISO LEGAL: ASIC S.A.S. Este mensaje es confidencial, puede contener información privilegiada y no puede ser usado ni divulgado por personas distintas de su destinatario. Si obtiene esta transmisión por error, por favor destruya su contenido y avise a su remitente. Esta prohibida su retención, grabación, utilización, aprovechamiento o divulgación con cualquier propósito. Este mensaje ha sido sometido a programas antivirus. No obstante, ASIC S.A.S. no asume ninguna responsabilidad por eventuales daños generados por el recibo y el uso de este material, siendo responsabilidad del destinatario verificar con sus propios medios la existencia de virus u otros defectos. El presente correo electrónico solo refleja la opinión de su Remitente y no representa necesariamente la opinión oficial de ASIC S.A.S. o de sus Directivos Antes de imprimir este correo piense bien si es necesario. El medio Ambiente es cuestión de todos. ASIC S.A.S.<https://www.asicamericas.com>