Problems with the MULE ESB XMPP provider

Srgjan_Srepfler · June 1, 2006, 12:59pm

We are seeing some problems with the xmpp provider in the mule (1.3-rc2) ESB. It builds on top of Smack (the distro uses smack 1.5 to build itself). We basicly created two accounts one for sending and one for receiving messages (this was because we were having problems with the connection getting closed, perhaps was also related with smack/the provider), we use the inbound as mule and use smack directly as outbound.

I must warn that here we modified the smack library a bit in order not to get the error reported in this thread http://www.jivesoftware.org/community/thread.jspa?messageID=119537&#119537

and you can see it being used when we hit:

2006-06-01 16:13:53,050 INFO Errore login Thread.sleep(1000)!

I ask if other people are having this problem and how did they resolve it. I’'ll be sending it also to the mule mailing list as they open (codehaus was hit by a disk outage).

Our mule configuration:

the log:

(PS. Notice, we’‘ve put our modified library in our ear and still the thread.sleep(1000) occured only when we used smack not when the xmpp’‘s connector kicked in, should we also reconnect the mule with it? Can we do it with the 2.6.2 version (is that problem still present in that version?), are the api’'s the same between 1.5 and 2.6.2? Is it perhaps a whole other problem whatsoever? Would you council a different reconnect strategy or configuration? Thanks in advance and sorry if this is a question on the mule lists. It really bugs me to know we had to put this thread.sleep(1000), is there any prevision when will it get resolved as an issue?

2006-06-01 16:13:44,918 INFO Starting Connector: org.mule.providers.tcp.TcpConnector

2006-06-01 16:13:44,919 INFO Connector: org.mule.providers.tcp.TcpConnector has been started

2006-06-01 16:13:44,919 INFO Connected: org.mule.providers.tcp.TcpConnector@f2794a

2006-06-01 16:13:44,919 INFO Registering Admin listener on: tcp://localhost:60504

2006-06-01 16:13:44,934 DEBUG Using exception strategy: org.mule.impl.DefaultComponentExceptionStrategy

2006-06-01 16:13:44,934 DEBUG Added Mule UMO: _muleManagerComponent

2006-06-01 16:13:44,934 INFO Initialising component: _muleManagerComponent

2006-06-01 16:13:44,935 INFO Initialising exception listener: org.mule.impl.DefaultComponentExceptionStrategy@1cfa3d2

2006-06-01 16:13:44,942 DEBUG Setting transformer name to: ByteArrayToString

2006-06-01 16:13:44,942 INFO Initialising exception listener: org.mule.impl.DefaultComponentExceptionStrategy@1cfa3d2

2006-06-01 16:13:44,943 INFO Starting ResourceManager

2006-06-01 16:13:44,944 DEBUG Restore retrieved 0 objects

2006-06-01 16:13:44,944 INFO Started ResourceManager

2006-06-01 16:13:44,945 INFO Starting Connector: org.mule.providers.xmpp.XmppConnector

2006-06-01 16:13:44,945 INFO Connector: org.mule.providers.xmpp.XmppConnector has been started

2006-06-01 16:13:44,945 INFO Connected: org.mule.providers.xmpp.XmppConnector@1b4b415

2006-06-01 16:13:44,946 INFO Connectors have been started successfully

2006-06-01 16:13:44,946 INFO Starting agents…

2006-06-01 16:13:44,946 INFO Starting agent: Mule Admin: accepting connections on tcp://localhost:60504

2006-06-01 16:13:44,946 INFO Agents Successfully Started

2006-06-01 16:13:45,051 INFO registering listener: XmppCsai on endpointUri: xmpp://testcsai:thepassword@90.90.90.90/Csai

2006-06-01 16:13:45,081 DEBUG Attempting to connect to: xmpp://testcsai:thepassword@90.90.90.90/Csai

2006-06-01 16:13:45,082 INFO Trying to find XMPP connection for uri: xmpp://testcsai:thepassword@90.90.90.90/Csai

2006-06-01 16:13:47,216 ERROR javax.net.ssl.SSLException: Connection has been shutdown: javax.net.ssl.SSLException: Received fatal alert: internal_error

2006-06-01 16:13:47,217 ERROR at com.sun.net.ssl.internal.ssl.SSLSocketImpl.checkEOF(SSLSocketImpl.java:1154)

2006-06-01 16:13:47,217 ERROR at com.sun.net.ssl.internal.ssl.SSLSocketImpl.checkWrite(SSLSocketImpl.java:1166)

2006-06-01 16:13:47,217 ERROR at com.sun.net.ssl.internal.ssl.AppOutputStream.write(AppOutputStream.java:43)

2006-06-01 16:13:47,217 ERROR at sun.nio.cs.StreamEncoder$CharsetSE.writeBytes(StreamEncoder.java:336)

2006-06-01 16:13:47,217 ERROR at sun.nio.cs.StreamEncoder$CharsetSE.implFlushBuffer(StreamEncoder.java:404)

2006-06-01 16:13:47,217 ERROR at sun.nio.cs.StreamEncoder$CharsetSE.implFlush(StreamEncoder.java:408)

2006-06-01 16:13:47,217 ERROR at sun.nio.cs.StreamEncoder.flush(StreamEncoder.java:152)

2006-06-01 16:13:47,217 ERROR at java.io.OutputStreamWriter.flush(OutputStreamWriter.java:213)

2006-06-01 16:13:47,217 ERROR at java.io.BufferedWriter.flush(BufferedWriter.java:236)

2006-06-01 16:13:47,217 ERROR at org.jivesoftware.smack.PacketWriter.writePackets(PacketWriter.java:242)

2006-06-01 16:13:47,217 ERROR at org.jivesoftware.smack.PacketWriter.access$000(PacketWriter.java:36)

2006-06-01 16:13:47,218 ERROR at org.jivesoftware.smack.PacketWriter$1.run(PacketWriter.java:70)

2006-06-01 16:13:47,218 ERROR Caused by: javax.net.ssl.SSLException: Received fatal alert: internal_error

2006-06-01 16:13:47,218 ERROR at com.sun.net.ssl.internal.ssl.Alerts.getSSLException(Alerts.java:166)

2006-06-01 16:13:47,218 ERROR at com.sun.net.ssl.internal.ssl.Alerts.getSSLException(Alerts.java:117)

2006-06-01 16:13:47,218 ERROR at com.sun.net.ssl.internal.ssl.SSLSocketImpl.recvAlert(SSLSocketImpl.java:1542)

2006-06-01 16:13:47,218 ERROR at com.sun.net.ssl.internal.ssl.SSLSocketImpl.readRecord(SSLSocketImpl.java:863)

2006-06-01 16:13:47,219 ERROR at com.sun.net.ssl.internal.ssl.SSLSocketImpl.readDataRecord(SSLSocketImpl.java:67 7)

2006-06-01 16:13:47,219 ERROR at com.sun.net.ssl.internal.ssl.AppInputStream.read(AppInputStream.java:75)

2006-06-01 16:13:47,219 ERROR at sun.nio.cs.StreamDecoder$CharsetSD.readBytes(StreamDecoder.java:411)

2006-06-01 16:13:47,219 ERROR at sun.nio.cs.StreamDecoder$CharsetSD.implRead(StreamDecoder.java:453)

2006-06-01 16:13:47,219 ERROR at sun.nio.cs.StreamDecoder.read(StreamDecoder.java:183)

2006-06-01 16:13:47,219 ERROR at java.io.InputStreamReader.read(InputStreamReader.java:167)

2006-06-01 16:13:47,219 ERROR at java.io.BufferedReader.read1(BufferedReader.java:185)

2006-06-01 16:13:47,219 ERROR at java.io.BufferedReader.read(BufferedReader.java:261)

2006-06-01 16:13:47,219 ERROR at org.xmlpull.mxp1.MXParser.fillBuf(MXParser.java:2971)

2006-06-01 16:13:47,219 ERROR at org.xmlpull.mxp1.MXParser.more(MXParser.java:3025)

2006-06-01 16:13:47,219 ERROR at org.xmlpull.mxp1.MXParser.parseProlog(MXParser.java:1410)

2006-06-01 16:13:47,219 ERROR at org.xmlpull.mxp1.MXParser.nextImpl(MXParser.java:1395)

2006-06-01 16:13:47,220 ERROR at org.xmlpull.mxp1.MXParser.next(MXParser.java:1093)

2006-06-01 16:13:47,220 ERROR at org.jivesoftware.smack.PacketReader.parsePackets(PacketReader.java:377)

2006-06-01 16:13:47,220 ERROR at org.jivesoftware.smack.PacketReader.access$000(PacketReader.java:43)

2006-06-01 16:13:47,220 ERROR at org.jivesoftware.smack.PacketReader$1.run(PacketReader.java:63)

2006-06-01 16:13:47,220 ERROR javax.net.ssl.SSLException: Received fatal alert: internal_error

2006-06-01 16:13:47,221 ERROR at com.sun.net.ssl.internal.ssl.Alerts.getSSLException(Alerts.java:166)

2006-06-01 16:13:47,221 ERROR at com.sun.net.ssl.internal.ssl.Alerts.getSSLException(Alerts.java:117)

2006-06-01 16:13:47,221 ERROR at com.sun.net.ssl.internal.ssl.SSLSocketImpl.recvAlert(SSLSocketImpl.java:1542)

2006-06-01 16:13:47,221 ERROR at com.sun.net.ssl.internal.ssl.SSLSocketImpl.readRecord(SSLSocketImpl.java:863)

2006-06-01 16:13:47,221 ERROR at com.sun.net.ssl.internal.ssl.SSLSocketImpl.readDataRecord(SSLSocketImpl.java:67 7)

2006-06-01 16:13:47,221 ERROR at com.sun.net.ssl.internal.ssl.AppInputStream.read(AppInputStream.java:75)

2006-06-01 16:13:47,221 ERROR at sun.nio.cs.StreamDecoder$CharsetSD.readBytes(StreamDecoder.java:411)

2006-06-01 16:13:47,221 ERROR at sun.nio.cs.StreamDecoder$CharsetSD.implRead(StreamDecoder.java:453)

2006-06-01 16:13:47,221 ERROR at sun.nio.cs.StreamDecoder.read(StreamDecoder.java:183)

2006-06-01 16:13:47,222 ERROR at java.io.InputStreamReader.read(InputStreamReader.java:167)

2006-06-01 16:13:47,222 ERROR at java.io.BufferedReader.read1(BufferedReader.java:185)

2006-06-01 16:13:47,222 ERROR at java.io.BufferedReader.read(BufferedReader.java:261)

2006-06-01 16:13:47,222 ERROR at org.xmlpull.mxp1.MXParser.fillBuf(MXParser.java:2971)

2006-06-01 16:13:47,222 ERROR at org.xmlpull.mxp1.MXParser.more(MXParser.java:3025)

2006-06-01 16:13:47,222 ERROR at org.xmlpull.mxp1.MXParser.parseProlog(MXParser.java:1410)

2006-06-01 16:13:47,222 ERROR at org.xmlpull.mxp1.MXParser.nextImpl(MXParser.java:1395)

2006-06-01 16:13:47,222 ERROR at org.xmlpull.mxp1.MXParser.next(MXParser.java:1093)

2006-06-01 16:13:47,222 ERROR at org.jivesoftware.smack.PacketReader.parsePackets(PacketReader.java:377)

2006-06-01 16:13:47,222 ERROR at org.jivesoftware.smack.PacketReader.access$000(PacketReader.java:43)

2006-06-01 16:13:47,222 ERROR at org.jivesoftware.smack.PacketReader$1.run(PacketReader.java:63)

2006-06-01 16:13:52,048 INFO *** account (testcsai) already exists ***

2006-06-01 16:13:52,048 DEBUG Logging in as: testcsai

2006-06-01 16:13:52,048 DEBUG pw is : thepassword

2006-06-01 16:13:52,048 DEBUG server : 90.90.90.90

2006-06-01 16:13:52,048 DEBUG resource : null

2006-06-01 16:13:53,050 INFO Errore login Thread.sleep(1000)!

2006-06-01 16:13:53,071 DEBUG Loading resource bundle: META-INF.services.org.mule.i18n.core-messages

2006-06-01 16:13:53,142 DEBUG javadoc. Url for package ‘‘org.mule.providers.ConnectException’’ is: http://mule.codehaus.org/docs/apidocs/org/mule/providers/ConnectException.html

2006-06-01 16:13:53,142 DEBUG doc. Url for package ‘‘org.mule.providers.ConnectException’’ is: null

2006-06-01 16:13:53,148 DEBUG javadoc. Url for package ‘‘org.mule.providers.FatalConnectException’’ is: http://mule.codehaus.org/docs/apidocs/org/mule/providers/FatalConnectException.h tml

2006-06-01 16:13:53,148 DEBUG doc. Url for package ‘‘org.mule.providers.FatalConnectException’’ is: null

2006-06-01 16:13:53,148 DEBUG javadoc. Url for package ‘‘org.mule.providers.FatalConnectException’’ is: http://mule.codehaus.org/docs/apidocs/org/mule/providers/FatalConnectException.h tml

2006-06-01 16:13:53,148 DEBUG doc. Url for package ‘‘org.mule.providers.FatalConnectException’’ is: null

2006-06-01 16:13:53,149 DEBUG javadoc. Url for package ‘‘org.mule.config.ConfigurationException’’ is: http://mule.codehaus.org/docs/apidocs/org/mule/config/ConfigurationException.htm l

2006-06-01 16:13:53,149 DEBUG doc. Url for package ‘‘org.mule.config.ConfigurationException’’ is: null

2006-06-01 16:13:53,150 DEBUG javadoc. Url for package ‘‘org.mule.config.ConfigurationException’’ is: http://mule.codehaus.org/docs/apidocs/org/mule/config/ConfigurationException.htm l

2006-06-01 16:13:53,150 DEBUG doc. Url for package ‘‘org.mule.config.ConfigurationException’’ is: null

2006-06-01 16:13:53,150 DEBUG javadoc. Url for package ‘‘org.mule.config.ConfigurationException’’ is: http://mule.codehaus.org/docs/apidocs/org/mule/config/ConfigurationException.htm l

2006-06-01 16:13:53,150 DEBUG doc. Url for package ‘‘org.mule.config.ConfigurationException’’ is: null

2006-06-01 16:13:53,150 ERROR [org.apache.catalina.core.ContainerBase.[jboss.web].[localhost].[/CSAIWeb]] MuleManager Failed to initialise (org.mule.config.ConfigurationException)

org.mule.config.ConfigurationException: MuleManager Failed to initialise (org.mule.config.ConfigurationException)

at org.mule.config.builders.MuleXmlConfigurationBuilder.configure(MuleXmlConfigura tionBuilder.java:196)

at org.mule.config.builders.MuleXmlBuilderContextListener.createManager(MuleXmlBui lderContextListener.java:68)

at org.mule.config.builders.MuleXmlBuilderContextListener.contextInitialized(MuleX mlBuilderContextListener.java:52)

at org.apache.catalina.core.StandardContext.listenerStart(StandardContext.java:372 9)

at org.apache.catalina.core.StandardContext.start(StandardContext.java:4187)

at org.apache.catalina.core.ContainerBase.addChildInternal(ContainerBase.java:759)

at org.apache.catalina.core.ContainerBase.addChild(ContainerBase.java:739)

at org.apache.catalina.core.StandardHost.addChild(StandardHost.java:524)

at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)

at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)

at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.ja va:25)

at java.lang.reflect.Method.invoke(Method.java:585)

at org.apache.commons.modeler.BaseModelMBean.invoke(BaseModelMBean.java:503)

at org.jboss.mx.server.RawDynamicInvoker.invoke(RawDynamicInvoker.java:164)

at org.jboss.mx.server.MBeanServerImpl.invoke(MBeanServerImpl.java:659)

at org.apache.catalina.core.StandardContext.init(StandardContext.java:5116)

at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)

at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)

at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.ja va:25)

at java.lang.reflect.Method.invoke(Method.java:585)

at org.apache.commons.modeler.BaseModelMBean.invoke(BaseModelMBean.java:503)

at org.jboss.mx.server.RawDynamicInvoker.invoke(RawDynamicInvoker.java:164)

at org.jboss.mx.server.MBeanServerImpl.invoke(MBeanServerImpl.java:659)

at org.jboss.web.tomcat.tc5.TomcatDeployer.performDeployInternal(TomcatDeployer.ja va:297)

at org.jboss.web.tomcat.tc5.TomcatDeployer.performDeploy(TomcatDeployer.java:103)

at org.jboss.web.AbstractWebDeployer.start(AbstractWebDeployer.java:371)

at org.jboss.web.WebModule.startModule(WebModule.java:83)

at org.jboss.web.WebModule.startService(WebModule.java:61)

at org.jboss.system.ServiceMBeanSupport.jbossInternalStart(ServiceMBeanSupport.jav a:289)

at org.jboss.system.ServiceMBeanSupport.jbossInternalLifecycle(ServiceMBeanSupport .java:245)

at sun.reflect.GeneratedMethodAccessor2.invoke(Unknown Source)

at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.ja va:25)

at java.lang.reflect.Method.invoke(Method.java:585)

at org.jboss.mx.interceptor.ReflectedDispatcher.invoke(ReflectedDispatcher.java:15 5)

at org.jboss.mx.server.Invocation.dispatch(Invocation.java:94)

at org.jboss.mx.server.Invocation.invoke(Invocation.java:86)

at org.jboss.mx.server.AbstractMBeanInvoker.invoke(AbstractMBeanInvoker.java:264)

at org.jboss.mx.server.MBeanServerImpl.invoke(MBeanServerImpl.java:659)

at org.jboss.system.ServiceController$ServiceProxy.invoke(ServiceController.java:9 78)

at $Proxy0.start(Unknown Source)

at org.jboss.system.ServiceController.start(ServiceController.java:417)

at sun.reflect.GeneratedMethodAccessor9.invoke(Unknown Source)

at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.ja va:25)

at java.lang.reflect.Method.invoke(Method.java:585)

at org.jboss.mx.interceptor.ReflectedDispatcher.invoke(ReflectedDispatcher.java:15 5)

at org.jboss.mx.server.Invocation.dispatch(Invocation.java:94)

at org.jboss.mx.server.Invocation.invoke(Invocation.java:86)

at org.jboss.mx.server.AbstractMBeanInvoker.invoke(AbstractMBeanInvoker.java:264)

at org.jboss.mx.server.MBeanServerImpl.invoke(MBeanServerImpl.java:659)

at org.jboss.mx.util.MBeanProxyExt.invoke(MBeanProxyExt.java:210)

at $Proxy30.start(Unknown Source)

at org.jboss.web.AbstractWebContainer.start(AbstractWebContainer.java:466)

at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)

at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)

at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.ja va:25)

at java.lang.reflect.Method.invoke(Method.java:585)

at org.jboss.mx.interceptor.ReflectedDispatcher.invoke(ReflectedDispatcher.java:15 5)

at org.jboss.mx.server.Invocation.dispatch(Invocation.java:94)

at org.jboss.mx.interceptor.AbstractInterceptor.invoke(AbstractInterceptor.java:13 3)

at org.jboss.mx.server.Invocation.invoke(Invocation.java:88)

at org.jboss.mx.interceptor.ModelMBeanOperationInterceptor.invoke(ModelMBeanOperat ionInterceptor.java:142)

at org.jboss.mx.interceptor.DynamicInterceptor.invoke(DynamicInterceptor.java:97)

at org.jboss.system.InterceptorServiceMBeanSupport.invokeNext(InterceptorServiceMB eanSupport.java:238)

at org.jboss.ws.server.WebServiceDeployer.start(WebServiceDeployer.java:117)

at org.jboss.deployment.SubDeployerInterceptorSupport$XMBeanInterceptor.start(SubD eployerInterceptorSupport.java:188)

at org.jboss.deployment.SubDeployerInterceptor.invoke(SubDeployerInterceptor.java: 95)

at org.jboss.mx.server.Invocation.invoke(Invocation.java:88)

at org.jboss.mx.server.AbstractMBeanInvoker.invoke(AbstractMBeanInvoker.java:264)

at org.jboss.mx.server.MBeanServerImpl.invoke(MBeanServerImpl.java:659)

at org.jboss.mx.util.MBeanProxyExt.invoke(MBeanProxyExt.java:210)

at $Proxy31.start(Unknown Source)

at org.jboss.deployment.MainDeployer.start(MainDeployer.java:1007)

at org.jboss.deployment.MainDeployer.start(MainDeployer.java:997)

at org.jboss.deployment.MainDeployer.deploy(MainDeployer.java:808)

at org.jboss.deployment.MainDeployer.deploy(MainDeployer.java:771)

at sun.reflect.GeneratedMethodAccessor56.invoke(Unknown Source)