0 Replies Latest reply on Jul 13, 2011 11:38 AM by valerio de minico

    AS 5.1.0: problem accessing Web Service

    valerio de minico Newbie

      Hi all,

      I have a problem invoking an external WS from an enterprise app (two tier application, where the business tier invokes ws). WS is on HTTPS, and I have server certifies into server's keystore.

       

      Trying to connect to ws, I obtain this log:

       

       

      2011-07-13 16:59:39,799 INFO  [it.citel.timsocial.be.scheduler.manager.RegistrationManager] (WorkerThread#0[10.188.47.201:43522] ) Invoking WS.... [WSendopoint=https://IBCOLR4.COLLAUDO.TIM.IT:12002/IB/services/MobileNumberProvisioningFeatureQuery-v1?wsdl]
      2011-07-13 16:59:40,363 WARN  [org.jboss.util.xml.JBossEntityResolver] (WorkerThread#0[10.188.47.201:43522] ) Trying to resolve systemId as a non-file URL: https://IBCOLR4.COLLAUDO.TIM.IT:12002/IB/services/MobileNumberProvisioningFeatureQuery-v1?xsd=SOAPHeader.xsd
      2011-07-13 16:59:40,389 WARN  [org.jboss.util.xml.JBossEntityResolver] (WorkerThread#0[10.188.47.201:43522] ) Trying to resolve systemId as a non-file URL: https://IBCOLR4.COLLAUDO.TIM.IT:12002/IB/services/MobileNumberProvisioningFeatureQuery-v1?xsd=MobileNumberProvisioningFeatureQuery.xsd
      2011-07-13 16:59:40,413 WARN  [org.jboss.util.xml.JBossEntityResolver] (WorkerThread#0[10.188.47.201:43522] ) Trying to resolve systemId as a non-file URL: https://IBCOLR4.COLLAUDO.TIM.IT:12002/IB/services/MobileNumberProvisioningFeatureQueryEntities.xsd
      2011-07-13 16:59:40,869 WARN  [org.jboss.util.xml.JBossEntityResolver] (WorkerThread#0[10.188.47.201:43522] ) Trying to resolve systemId as a non-file URL: https://IBCOLR4.COLLAUDO.TIM.IT:12002/IB/services/MobileNumberProvisioningFeatureQueryEntities.xsd
      2011-07-13 16:59:40,920 WARN  [org.jboss.util.xml.JBossEntityResolver] (WorkerThread#0[10.188.47.201:43522] ) Trying to resolve systemId as a non-file URL: https://IBCOLR4.COLLAUDO.TIM.IT:12002/IB/services/MobileNumberProvisioningFeatureQuery-v1?xsd=SOAPHeader.xsd
      2011-07-13 16:59:40,942 WARN  [org.jboss.util.xml.JBossEntityResolver] (WorkerThread#0[10.188.47.201:43522] ) Trying to resolve systemId as a non-file URL: https://IBCOLR4.COLLAUDO.TIM.IT:12002/IB/services/MobileNumberProvisioningFeatureQuery-v1?xsd=MobileNumberProvisioningFeatureQuery.xsd
      2011-07-13 16:59:41,363 INFO  [STDOUT] (WorkerThread#0[10.188.47.201:43522] ) Invoking getTypology...
      2011-07-13 17:00:44,517 ERROR [org.jboss.ws.core.CommonClient] (WorkerThread#0[10.188.47.201:43522] ) Exception caught while (preparing for) performing the invocation: 
      java.io.IOException: Could not transmit message
                at org.jboss.ws.core.client.HTTPRemotingConnection.invoke(HTTPRemotingConnection.java:265)
                at org.jboss.ws.core.client.SOAPProtocolConnectionHTTP.invoke(SOAPProtocolConnectionHTTP.java:71)
                at org.jboss.ws.core.CommonClient.invoke(CommonClient.java:340)
                at org.jboss.ws.core.jaxws.client.ClientImpl.invoke(ClientImpl.java:290)
                at org.jboss.ws.core.jaxws.client.ClientProxy.invoke(ClientProxy.java:170)
                at org.jboss.ws.core.jaxws.client.ClientProxy.invoke(ClientProxy.java:150)
                at $Proxy322.getTypology(Unknown Source)
                at it.telecomitalia.soa.callservice.CallServiceNumberProvisioning.call(CallServiceNumberProvisioning.java:55)
                at it.citel.timsocial.be.scheduler.manager.RegistrationManager.scheduleCommand(RegistrationManager.java:90)
                at it.citel.timsocial.be.scheduler.manager.ScheduleManeger.drawInput(ScheduleManeger.java:22)
                at it.citel.timsocial.be.scheduler.service.SchedulerService.requestScheduler(SchedulerService.java:33)
                at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
                at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
                at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
                at java.lang.reflect.Method.invoke(Method.java:616)
                at org.jboss.aop.joinpoint.MethodInvocation.invokeTarget(MethodInvocation.java:122)
                at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:111)
                at org.jboss.ejb3.EJBContainerInvocationWrapper.invokeNext(EJBContainerInvocationWrapper.java:69)
                at org.jboss.ejb3.interceptors.aop.InterceptorSequencer.invoke(InterceptorSequencer.java:73)
                at org.jboss.ejb3.interceptors.aop.InterceptorSequencer.aroundInvoke(InterceptorSequencer.java:59)
                at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
                at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
                at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
                at java.lang.reflect.Method.invoke(Method.java:616)
                at org.jboss.aop.advice.PerJoinpointAdvice.invoke(PerJoinpointAdvice.java:174)
                at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
                at org.jboss.ejb3.interceptors.aop.InvocationContextInterceptor.fillMethod(InvocationContextInterceptor.java:72)
                at org.jboss.aop.advice.org.jboss.ejb3.interceptors.aop.InvocationContextInterceptor_z_fillMethod_2042579307.invoke(InvocationContextInterceptor_z_fillMethod_2042579307.java)
                at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
                at org.jboss.ejb3.interceptors.aop.InvocationContextInterceptor.setup(InvocationContextInterceptor.java:88)
                at org.jboss.aop.advice.org.jboss.ejb3.interceptors.aop.InvocationContextInterceptor_z_setup_2042579307.invoke(InvocationContextInterceptor_z_setup_2042579307.java)
                at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
                at org.jboss.ejb3.connectionmanager.CachedConnectionInterceptor.invoke(CachedConnectionInterceptor.java:62)
                at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
                at org.jboss.ejb3.entity.TransactionScopedEntityManagerInterceptor.invoke(TransactionScopedEntityManagerInterceptor.java:56)
                at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
                at org.jboss.ejb3.AllowedOperationsInterceptor.invoke(AllowedOperationsInterceptor.java:47)
                at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
                at org.jboss.ejb3.tx.NullInterceptor.invoke(NullInterceptor.java:42)
                at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
                at org.jboss.ejb3.stateless.StatelessInstanceInterceptor.invoke(StatelessInstanceInterceptor.java:68)
                at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
                at org.jboss.aspects.tx.TxPolicy.invokeInOurTx(TxPolicy.java:79)
                at org.jboss.aspects.tx.TxInterceptor$Required.invoke(TxInterceptor.java:190)
                at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
                at org.jboss.aspects.tx.TxPropagationInterceptor.invoke(TxPropagationInterceptor.java:67)
                at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
                at org.jboss.ejb3.tx.NullInterceptor.invoke(NullInterceptor.java:42)
                at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
                at org.jboss.ejb3.security.Ejb3AuthenticationInterceptorv2.invoke(Ejb3AuthenticationInterceptorv2.java:186)
                at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
                at org.jboss.ejb3.ENCPropagationInterceptor.invoke(ENCPropagationInterceptor.java:41)
                at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
                at org.jboss.ejb3.BlockContainerShutdownInterceptor.invoke(BlockContainerShutdownInterceptor.java:67)
                at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
                at org.jboss.aspects.currentinvocation.CurrentInvocationInterceptor.invoke(CurrentInvocationInterceptor.java:67)
                at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
                at org.jboss.ejb3.stateless.StatelessContainer.dynamicInvoke(StatelessContainer.java:421)
                at org.jboss.ejb3.session.InvokableContextClassProxyHack._dynamicInvoke(InvokableContextClassProxyHack.java:53)
                at org.jboss.aop.Dispatcher.invoke(Dispatcher.java:91)
                at org.jboss.aspects.remoting.AOPRemotingInvocationHandler.invoke(AOPRemotingInvocationHandler.java:82)
                at org.jboss.remoting.ServerInvoker.invoke(ServerInvoker.java:891)
                at org.jboss.remoting.transport.socket.ServerThread.completeInvocation(ServerThread.java:744)
                at org.jboss.remoting.transport.socket.ServerThread.processInvocation(ServerThread.java:697)
                at org.jboss.remoting.transport.socket.ServerThread.dorun(ServerThread.java:524)
                at org.jboss.remoting.transport.socket.ServerThread.run(ServerThread.java:232)
      Caused by: org.jboss.remoting.CannotConnectException: Can not connect http client invoker after 1 attempt(s)
                at org.jboss.remoting.transport.http.HTTPClientInvoker.makeInvocation(HTTPClientInvoker.java:249)
                at org.jboss.remoting.transport.http.HTTPClientInvoker.transport(HTTPClientInvoker.java:161)
                at org.jboss.remoting.MicroRemoteClientInvoker.invoke(MicroRemoteClientInvoker.java:165)
                at org.jboss.remoting.Client.invoke(Client.java:1724)
                at org.jboss.remoting.Client.invoke(Client.java:629)
                at org.jboss.ws.core.client.HTTPRemotingConnection.invoke(HTTPRemotingConnection.java:243)
                ... 65 more
      Caused by: java.net.ConnectException: Connection timed out
                at java.net.PlainSocketImpl.socketConnect(Native Method)
                at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:327)
                at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:193)
                at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:180)
                at java.net.Socket.connect(Socket.java:546)
                at sun.net.NetworkClient.doConnect(NetworkClient.java:169)
                at sun.net.www.http.HttpClient.openServer(HttpClient.java:409)
                at sun.net.www.http.HttpClient.openServer(HttpClient.java:530)
                at sun.net.www.protocol.https.HttpsClient.<init>(HttpsClient.java:289)
                at sun.net.www.protocol.https.HttpsClient.New(HttpsClient.java:346)
                at sun.net.www.protocol.https.AbstractDelegateHttpsURLConnection.getNewHttpClient(AbstractDelegateHttpsURLConnection.java:191)
                at sun.net.www.protocol.http.HttpURLConnection.plainConnect(HttpURLConnection.java:876)
                at sun.net.www.protocol.https.AbstractDelegateHttpsURLConnection.connect(AbstractDelegateHttpsURLConnection.java:177)
                at sun.net.www.protocol.http.HttpURLConnection.getOutputStream(HttpURLConnection.java:979)
                at sun.net.www.protocol.https.HttpsURLConnectionImpl.getOutputStream(HttpsURLConnectionImpl.java:250)
                at org.jboss.remoting.transport.http.HTTPClientInvoker.getOutputStream(HTTPClientInvoker.java:1214)
                at org.jboss.remoting.transport.http.HTTPClientInvoker.useHttpURLConnection(HTTPClientInvoker.java:334)
                at org.jboss.remoting.transport.http.HTTPClientInvoker.makeInvocation(HTTPClientInvoker.java:231)
                ... 70 more
      2011-07-13 17:00:44,520 ERROR [it.citel.timsocial.be.scheduler.manager.RegistrationManager] (WorkerThread#0[10.188.47.201:43522] ) Exception invoking ws
      javax.xml.ws.WebServiceException: java.io.IOException: Could not transmit message
                at org.jboss.ws.core.jaxws.client.ClientImpl.handleRemoteException(ClientImpl.java:396)
                at org.jboss.ws.core.jaxws.client.ClientImpl.invoke(ClientImpl.java:302)
                at org.jboss.ws.core.jaxws.client.ClientProxy.invoke(ClientProxy.java:170)
                at org.jboss.ws.core.jaxws.client.ClientProxy.invoke(ClientProxy.java:150)
                at $Proxy322.getTypology(Unknown Source)
                at it.telecomitalia.soa.callservice.CallServiceNumberProvisioning.call(CallServiceNumberProvisioning.java:55)
                at it.citel.timsocial.be.scheduler.manager.RegistrationManager.scheduleCommand(RegistrationManager.java:90)
                at it.citel.timsocial.be.scheduler.manager.ScheduleManeger.drawInput(ScheduleManeger.java:22)
                at it.citel.timsocial.be.scheduler.service.SchedulerService.requestScheduler(SchedulerService.java:33)
                at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
                at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
                at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
                at java.lang.reflect.Method.invoke(Method.java:616)
                at org.jboss.aop.joinpoint.MethodInvocation.invokeTarget(MethodInvocation.java:122)
                at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:111)
                at org.jboss.ejb3.EJBContainerInvocationWrapper.invokeNext(EJBContainerInvocationWrapper.java:69)
                at org.jboss.ejb3.interceptors.aop.InterceptorSequencer.invoke(InterceptorSequencer.java:73)
                at org.jboss.ejb3.interceptors.aop.InterceptorSequencer.aroundInvoke(InterceptorSequencer.java:59)
                at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
                at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
                at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
                at java.lang.reflect.Method.invoke(Method.java:616)
                at org.jboss.aop.advice.PerJoinpointAdvice.invoke(PerJoinpointAdvice.java:174)
                at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
                at org.jboss.ejb3.interceptors.aop.InvocationContextInterceptor.fillMethod(InvocationContextInterceptor.java:72)
                at org.jboss.aop.advice.org.jboss.ejb3.interceptors.aop.InvocationContextInterceptor_z_fillMethod_2042579307.invoke(InvocationContextInterceptor_z_fillMethod_2042579307.java)
                at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
                at org.jboss.ejb3.interceptors.aop.InvocationContextInterceptor.setup(InvocationContextInterceptor.java:88)
                at org.jboss.aop.advice.org.jboss.ejb3.interceptors.aop.InvocationContextInterceptor_z_setup_2042579307.invoke(InvocationContextInterceptor_z_setup_2042579307.java)
                at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
                at org.jboss.ejb3.connectionmanager.CachedConnectionInterceptor.invoke(CachedConnectionInterceptor.java:62)
                at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
                at org.jboss.ejb3.entity.TransactionScopedEntityManagerInterceptor.invoke(TransactionScopedEntityManagerInterceptor.java:56)
                at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
                at org.jboss.ejb3.AllowedOperationsInterceptor.invoke(AllowedOperationsInterceptor.java:47)
                at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
                at org.jboss.ejb3.tx.NullInterceptor.invoke(NullInterceptor.java:42)
                at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
                at org.jboss.ejb3.stateless.StatelessInstanceInterceptor.invoke(StatelessInstanceInterceptor.java:68)
                at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
                at org.jboss.aspects.tx.TxPolicy.invokeInOurTx(TxPolicy.java:79)
                at org.jboss.aspects.tx.TxInterceptor$Required.invoke(TxInterceptor.java:190)
                at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
                at org.jboss.aspects.tx.TxPropagationInterceptor.invoke(TxPropagationInterceptor.java:67)
                at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
                at org.jboss.ejb3.tx.NullInterceptor.invoke(NullInterceptor.java:42)
                at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
                at org.jboss.ejb3.security.Ejb3AuthenticationInterceptorv2.invoke(Ejb3AuthenticationInterceptorv2.java:186)
                at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
                at org.jboss.ejb3.ENCPropagationInterceptor.invoke(ENCPropagationInterceptor.java:41)
                at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
                at org.jboss.ejb3.BlockContainerShutdownInterceptor.invoke(BlockContainerShutdownInterceptor.java:67)
                at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
                at org.jboss.aspects.currentinvocation.CurrentInvocationInterceptor.invoke(CurrentInvocationInterceptor.java:67)
                at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:102)
                at org.jboss.ejb3.stateless.StatelessContainer.dynamicInvoke(StatelessContainer.java:421)
                at org.jboss.ejb3.session.InvokableContextClassProxyHack._dynamicInvoke(InvokableContextClassProxyHack.java:53)
                at org.jboss.aop.Dispatcher.invoke(Dispatcher.java:91)
                at org.jboss.aspects.remoting.AOPRemotingInvocationHandler.invoke(AOPRemotingInvocationHandler.java:82)
                at org.jboss.remoting.ServerInvoker.invoke(ServerInvoker.java:891)
                at org.jboss.remoting.transport.socket.ServerThread.completeInvocation(ServerThread.java:744)
                at org.jboss.remoting.transport.socket.ServerThread.processInvocation(ServerThread.java:697)
                at org.jboss.remoting.transport.socket.ServerThread.dorun(ServerThread.java:524)
                at org.jboss.remoting.transport.socket.ServerThread.run(ServerThread.java:232)
      Caused by: java.io.IOException: Could not transmit message
                at org.jboss.ws.core.client.HTTPRemotingConnection.invoke(HTTPRemotingConnection.java:265)
                at org.jboss.ws.core.client.SOAPProtocolConnectionHTTP.invoke(SOAPProtocolConnectionHTTP.java:71)
                at org.jboss.ws.core.CommonClient.invoke(CommonClient.java:340)
                at org.jboss.ws.core.jaxws.client.ClientImpl.invoke(ClientImpl.java:290)
                ... 62 more
      Caused by: org.jboss.remoting.CannotConnectException: Can not connect http client invoker after 1 attempt(s)
                at org.jboss.remoting.transport.http.HTTPClientInvoker.makeInvocation(HTTPClientInvoker.java:249)
                at org.jboss.remoting.transport.http.HTTPClientInvoker.transport(HTTPClientInvoker.java:161)
                at org.jboss.remoting.MicroRemoteClientInvoker.invoke(MicroRemoteClientInvoker.java:165)
                at org.jboss.remoting.Client.invoke(Client.java:1724)
                at org.jboss.remoting.Client.invoke(Client.java:629)
                at org.jboss.ws.core.client.HTTPRemotingConnection.invoke(HTTPRemotingConnection.java:243)
                ... 65 more
      Caused by: java.net.ConnectException: Connection timed out
                at java.net.PlainSocketImpl.socketConnect(Native Method)
                at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:327)
                at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:193)
                at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:180)
                at java.net.Socket.connect(Socket.java:546)
                at sun.net.NetworkClient.doConnect(NetworkClient.java:169)
                at sun.net.www.http.HttpClient.openServer(HttpClient.java:409)
                at sun.net.www.http.HttpClient.openServer(HttpClient.java:530)
                at sun.net.www.protocol.https.HttpsClient.<init>(HttpsClient.java:289)
                at sun.net.www.protocol.https.HttpsClient.New(HttpsClient.java:346)
                at sun.net.www.protocol.https.AbstractDelegateHttpsURLConnection.getNewHttpClient(AbstractDelegateHttpsURLConnection.java:191)
                at sun.net.www.protocol.http.HttpURLConnection.plainConnect(HttpURLConnection.java:876)
                at sun.net.www.protocol.https.AbstractDelegateHttpsURLConnection.connect(AbstractDelegateHttpsURLConnection.java:177)
                at sun.net.www.protocol.http.HttpURLConnection.getOutputStream(HttpURLConnection.java:979)
                at sun.net.www.protocol.https.HttpsURLConnectionImpl.getOutputStream(HttpsURLConnectionImpl.java:250)
                at org.jboss.remoting.transport.http.HTTPClientInvoker.getOutputStream(HTTPClientInvoker.java:1214)
                at org.jboss.remoting.transport.http.HTTPClientInvoker.useHttpURLConnection(HTTPClientInvoker.java:334)
                at org.jboss.remoting.transport.http.HTTPClientInvoker.makeInvocation(HTTPClientInvoker.java:231)
                ... 70 more
      
      

       

      Of course there's connectivity between client and server, in fact client correctly accesses wsdl file to read metadata.

       

      I see also a strange thing... On logs there is this information about the executing thread:

       

      (WorkerThread#0[10.188.47.201:43522] )

       

      Note that this IP address is the address of caller ear... I have two tier, the former (frontend) has ip 10.188.47.201, the latter (invoking ws) 10.188.47.203. It coud be a normal log4j behaviour... but it's very strange and confusing....

       

      Thanks,

      Valerio.