Buscar este blog

sábado, 18 de julio de 2015

JBoss - SQL Server - Error: "*** SQLJDBC_XA DTC_ERROR Context: FInitializeTransactionManager, state=1, StatusCode:-3 (0xFFFFFFFD) ***"

Error:
12:38:22,879 WARN  [org.jboss.jca.core.connectionmanager.listener.TxConnectionListener] (http-localhost/127.0.0.1:8080-7) IJ000305: Connection error occured: org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@1a7beef5[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.xa.XAManagedConnection@3e852468 connection handles=0 lastUse=1437215902877 trackByTx=true pool=org.jboss.jca.core.connectionmanager.pool.strategy.OnePool@4efe0e2b pool internal context=SemaphoreArrayListManagedConnectionPool@789acdfa[pool=seguridadDS] xaResource=XAResourceWrapperImpl@171947e9[xaResource=org.jboss.jca.adapters.jdbc.xa.XAManagedConnection@3e852468 pad=false overrideRmValue=false productName=Microsoft SQL Server productVersion=10.50.4000 jndiName=java:jboss/datasources/seguridadDS] txSync=null]: javax.transaction.xa.XAException: Error en la función START:. El estado es: -3. Error: "*** SQLJDBC_XA DTC_ERROR Context: FInitializeTransactionManager, state=1, StatusCode:-3 (0xFFFFFFFD) ***"
 at com.microsoft.sqlserver.jdbc.SQLServerXAResource.DTC_XA_Interface(SQLServerXAResource.java:550)
 at com.microsoft.sqlserver.jdbc.SQLServerXAResource.start(SQLServerXAResource.java:679)
 at org.jboss.jca.adapters.jdbc.xa.XAManagedConnection.start(XAManagedConnection.java:259)
 at org.jboss.jca.core.tx.jbossts.XAResourceWrapperImpl.start(XAResourceWrapperImpl.java:203)
 at com.arjuna.ats.internal.jta.transaction.arjunacore.TransactionImple.enlistResource(TransactionImple.java:636) [jbossjta-4.16.0.Final.jar:]
 at com.arjuna.ats.internal.jta.transaction.arjunacore.TransactionImple.enlistResource(TransactionImple.java:397) [jbossjta-4.16.0.Final.jar:]
 at org.jboss.jca.core.connectionmanager.listener.TxConnectionListener$TransactionSynchronization.enlist(TxConnectionListener.java:647)
 at org.jboss.jca.core.connectionmanager.listener.TxConnectionListener.enlist(TxConnectionListener.java:305)
 at org.jboss.jca.core.connectionmanager.tx.TxConnectionManagerImpl.managedConnectionReconnected(TxConnectionManagerImpl.java:467)
 at org.jboss.jca.core.connectionmanager.AbstractConnectionManager.reconnectManagedConnection(AbstractConnectionManager.java:599)
 at org.jboss.jca.core.connectionmanager.AbstractConnectionManager.allocateConnection(AbstractConnectionManager.java:467)
 at org.jboss.jca.adapters.jdbc.WrapperDataSource.getConnection(WrapperDataSource.java:139)
 at org.hibernate.service.jdbc.connections.internal.DatasourceConnectionProviderImpl.getConnection(DatasourceConnectionProviderImpl.java:141) [hibernate-core-4.2.7.SP1.jar:4.2.7.SP1]
 at org.hibernate.internal.AbstractSessionImpl$NonContextualJdbcConnectionAccess.obtainConnection(AbstractSessionImpl.java:292) [hibernate-core-4.2.7.SP1.jar:4.2.7.SP1]
 at org.hibernate.engine.jdbc.internal.LogicalConnectionImpl.obtainConnection(LogicalConnectionImpl.java:214) [hibernate-core-4.2.7.SP1.jar:4.2.7.SP1]
 at org.hibernate.engine.jdbc.internal.LogicalConnectionImpl.getConnection(LogicalConnectionImpl.java:157) [hibernate-core-4.2.7.SP1.jar:4.2.7.SP1]
 at org.hibernate.engine.jdbc.internal.StatementPreparerImpl.connection(StatementPreparerImpl.java:56) [hibernate-core-4.2.7.SP1.jar:4.2.7.SP1]
 at org.hibernate.engine.jdbc.internal.StatementPreparerImpl$5.doPrepare(StatementPreparerImpl.java:161) [hibernate-core-4.2.7.SP1.jar:4.2.7.SP1]
 at org.hibernate.engine.jdbc.internal.StatementPreparerImpl$StatementPreparationTemplate.prepareStatement(StatementPreparerImpl.java:182) [hibernate-core-4.2.7.SP1.jar:4.2.7.SP1]
 at org.hibernate.engine.jdbc.internal.StatementPreparerImpl.prepareQueryStatement(StatementPreparerImpl.java:159) [hibernate-core-4.2.7.SP1.jar:4.2.7.SP1]
 at org.hibernate.loader.Loader.prepareQueryStatement(Loader.java:1859) [hibernate-core-4.2.7.SP1.jar:4.2.7.SP1]
 at org.hibernate.loader.Loader.executeQueryStatement(Loader.java:1836) [hibernate-core-4.2.7.SP1.jar:4.2.7.SP1]
 at org.hibernate.loader.Loader.executeQueryStatement(Loader.java:1816) [hibernate-core-4.2.7.SP1.jar:4.2.7.SP1]
 at org.hibernate.loader.Loader.doQuery(Loader.java:900) [hibernate-core-4.2.7.SP1.jar:4.2.7.SP1]
 at org.hibernate.loader.Loader.doQueryAndInitializeNonLazyCollections(Loader.java:342) [hibernate-core-4.2.7.SP1.jar:4.2.7.SP1]
 at org.hibernate.loader.Loader.doList(Loader.java:2526) [hibernate-core-4.2.7.SP1.jar:4.2.7.SP1]
 at org.hibernate.loader.Loader.doList(Loader.java:2512) [hibernate-core-4.2.7.SP1.jar:4.2.7.SP1]
 at org.hibernate.loader.Loader.listIgnoreQueryCache(Loader.java:2342) [hibernate-core-4.2.7.SP1.jar:4.2.7.SP1]
 at org.hibernate.loader.Loader.list(Loader.java:2337) [hibernate-core-4.2.7.SP1.jar:4.2.7.SP1]
 at org.hibernate.loader.criteria.CriteriaLoader.list(CriteriaLoader.java:124) [hibernate-core-4.2.7.SP1.jar:4.2.7.SP1]
 at org.hibernate.internal.SessionImpl.list(SessionImpl.java:1668) [hibernate-core-4.2.7.SP1.jar:4.2.7.SP1]
 at org.hibernate.internal.CriteriaImpl.list(CriteriaImpl.java:374) [hibernate-core-4.2.7.SP1.jar:4.2.7.SP1]
 at es.sisifo.myapp.persistencia.dao.hibernate.PerfilDAOImpl.getPerfilesByNifAndSystem(PerfilDAOImpl.java:101) [seguridad-persistencia-1.3.0-SNAPSHOT.jar:]
 at es.sisifo.myapp.persistencia.fachada.impl.PerfilFacade.getPerfilesBySistemaNif(PerfilFacade.java:250) [seguridad-persistencia-1.3.0-SNAPSHOT.jar:]
 at es.sisifo.myapp.negocio.BusinessPerfilImpl.getPerfiles(BusinessPerfilImpl.java:177) [classes:]
 at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.7.0_21]
 at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) [rt.jar:1.7.0_21]
 at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.7.0_21]
 at java.lang.reflect.Method.invoke(Method.java:601) [rt.jar:1.7.0_21]
 at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:317) [spring-aop-3.2.4.RELEASE.jar:3.2.4.RELEASE]
 at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:183) [spring-aop-3.2.4.RELEASE.jar:3.2.4.RELEASE]
 at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:150) [spring-aop-3.2.4.RELEASE.jar:3.2.4.RELEASE]
 at org.springframework.transaction.interceptor.TransactionInterceptor$1.proceedWithInvocation(TransactionInterceptor.java:96) [spring-tx-3.2.4.RELEASE.jar:3.2.4.RELEASE]
 at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransaction(TransactionAspectSupport.java:260) [spring-tx-3.2.4.RELEASE.jar:3.2.4.RELEASE]
 at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:94) [spring-tx-3.2.4.RELEASE.jar:3.2.4.RELEASE]
 at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172) [spring-aop-3.2.4.RELEASE.jar:3.2.4.RELEASE]
 at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:204) [spring-aop-3.2.4.RELEASE.jar:3.2.4.RELEASE]
 at com.sun.proxy.$Proxy131.getPerfiles(Unknown Source)
 at es.sisifo.myapp.negocio.external.SeguridadServiceExternal.getPerfilesUsuario(SeguridadServiceExternal.java:50) [classes:]
 at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.7.0_21]
 at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) [rt.jar:1.7.0_21]
 at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.7.0_21]
 at java.lang.reflect.Method.invoke(Method.java:601) [rt.jar:1.7.0_21]
 at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:317) [spring-aop-3.2.4.RELEASE.jar:3.2.4.RELEASE]
 at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:183) [spring-aop-3.2.4.RELEASE.jar:3.2.4.RELEASE]
 at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:150) [spring-aop-3.2.4.RELEASE.jar:3.2.4.RELEASE]
 at org.springframework.transaction.interceptor.TransactionInterceptor$1.proceedWithInvocation(TransactionInterceptor.java:96) [spring-tx-3.2.4.RELEASE.jar:3.2.4.RELEASE]
 at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransaction(TransactionAspectSupport.java:260) [spring-tx-3.2.4.RELEASE.jar:3.2.4.RELEASE]
 at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:94) [spring-tx-3.2.4.RELEASE.jar:3.2.4.RELEASE]
 at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172) [spring-aop-3.2.4.RELEASE.jar:3.2.4.RELEASE]
 at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:204) [spring-aop-3.2.4.RELEASE.jar:3.2.4.RELEASE]
 at com.sun.proxy.$Proxy134.getPerfilesUsuario(Unknown Source)
 at es.sisifo.myapp.negocio.external.ws.SeguridadServiceWS.getPerfilesUsuario(SeguridadServiceWS.java:37) [classes:]
 at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.7.0_21]
 at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) [rt.jar:1.7.0_21]
 at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.7.0_21]
 at java.lang.reflect.Method.invoke(Method.java:601) [rt.jar:1.7.0_21]
 at org.jboss.as.ee.component.ManagedReferenceMethodInterceptorFactory$ManagedReferenceMethodInterceptor.processInvocation(ManagedReferenceMethodInterceptorFactory.java:72) [jboss-as-ee-7.3.0.Final-redhat-14.jar:7.3.0.Final-redhat-14]
 at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.2.Final-redhat-1.jar:1.1.2.Final-redhat-1]
 at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53) [jboss-invocation-1.1.2.Final-redhat-1.jar:1.1.2.Final-redhat-1]
 at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:58) [jboss-as-ee-7.3.0.Final-redhat-14.jar:7.3.0.Final-redhat-14]
 at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.2.Final-redhat-1.jar:1.1.2.Final-redhat-1]
 at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53) [jboss-invocation-1.1.2.Final-redhat-1.jar:1.1.2.Final-redhat-1]
 at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:58) [jboss-as-ee-7.3.0.Final-redhat-14.jar:7.3.0.Final-redhat-14]
 at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.2.Final-redhat-1.jar:1.1.2.Final-redhat-1]
 at org.jboss.invocation.InitialInterceptor.processInvocation(InitialInterceptor.java:21) [jboss-invocation-1.1.2.Final-redhat-1.jar:1.1.2.Final-redhat-1]
 at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.2.Final-redhat-1.jar:1.1.2.Final-redhat-1]
 at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.2.Final-redhat-1.jar:1.1.2.Final-redhat-1]
 at org.jboss.as.ee.component.interceptors.ComponentDispatcherInterceptor.processInvocation(ComponentDispatcherInterceptor.java:53) [jboss-as-ee-7.3.0.Final-redhat-14.jar:7.3.0.Final-redhat-14]
 at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.2.Final-redhat-1.jar:1.1.2.Final-redhat-1]
 at org.jboss.as.webservices.deployers.WSComponentInstanceAssociationInterceptor.processInvocation(WSComponentInstanceAssociationInterceptor.java:49)
 at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.2.Final-redhat-1.jar:1.1.2.Final-redhat-1]
 at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.2.Final-redhat-1.jar:1.1.2.Final-redhat-1]
 at org.jboss.as.ee.component.ViewService$View.invoke(ViewService.java:165) [jboss-as-ee-7.3.0.Final-redhat-14.jar:7.3.0.Final-redhat-14]
 at org.jboss.as.webservices.invocation.AbstractInvocationHandler.invoke(AbstractInvocationHandler.java:112)
 at org.jboss.wsf.stack.cxf.JBossWSInvoker.performInvocation(JBossWSInvoker.java:149)
 at org.apache.cxf.service.invoker.AbstractInvoker.invoke(AbstractInvoker.java:96) [cxf-api-2.7.7.redhat-1.jar:2.7.7.redhat-1]
 at org.apache.cxf.jaxws.AbstractJAXWSMethodInvoker.invoke(AbstractJAXWSMethodInvoker.java:178) [cxf-rt-frontend-jaxws-2.7.7.redhat-1.jar:2.7.7.redhat-1]
 at org.apache.cxf.jaxws.JAXWSMethodInvoker.invoke(JAXWSMethodInvoker.java:68) [cxf-rt-frontend-jaxws-2.7.7.redhat-1.jar:2.7.7.redhat-1]
 at org.jboss.wsf.stack.cxf.JBossWSInvoker.invoke(JBossWSInvoker.java:129)
 at org.apache.cxf.interceptor.ServiceInvokerInterceptor$1.run(ServiceInvokerInterceptor.java:57) [cxf-api-2.7.7.redhat-1.jar:2.7.7.redhat-1]
 at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471) [rt.jar:1.7.0_21]
 at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334) [rt.jar:1.7.0_21]
 at java.util.concurrent.FutureTask.run(FutureTask.java:166) [rt.jar:1.7.0_21]
 at org.apache.cxf.workqueue.SynchronousExecutor.execute(SynchronousExecutor.java:37) [cxf-api-2.7.7.redhat-1.jar:2.7.7.redhat-1]
 at org.apache.cxf.interceptor.ServiceInvokerInterceptor.handleMessage(ServiceInvokerInterceptor.java:106) [cxf-api-2.7.7.redhat-1.jar:2.7.7.redhat-1]
 at org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:272) [cxf-api-2.7.7.redhat-1.jar:2.7.7.redhat-1]
 at org.apache.cxf.transport.ChainInitiationObserver.onMessage(ChainInitiationObserver.java:121) [cxf-api-2.7.7.redhat-1.jar:2.7.7.redhat-1]
 at org.apache.cxf.transport.http.AbstractHTTPDestination.invoke(AbstractHTTPDestination.java:239) [cxf-rt-transports-http-2.7.7.redhat-1.jar:2.7.7.redhat-1]
 at org.jboss.wsf.stack.cxf.RequestHandlerImpl.handleHttpRequest(RequestHandlerImpl.java:92)
 at org.jboss.wsf.stack.cxf.transport.ServletHelper.callRequestHandler(ServletHelper.java:143)
 at org.jboss.wsf.stack.cxf.CXFServletExt.invoke(CXFServletExt.java:87)
 at org.apache.cxf.transport.servlet.AbstractHTTPServlet.handleRequest(AbstractHTTPServlet.java:286) [cxf-rt-transports-http-2.7.7.redhat-1.jar:2.7.7.redhat-1]
 at org.apache.cxf.transport.servlet.AbstractHTTPServlet.doPost(AbstractHTTPServlet.java:206) [cxf-rt-transports-http-2.7.7.redhat-1.jar:2.7.7.redhat-1]
 at javax.servlet.http.HttpServlet.service(HttpServlet.java:754) [jboss-servlet-api_3.0_spec-1.0.2.Final-redhat-1.jar:1.0.2.Final-redhat-1]
 at org.jboss.wsf.stack.cxf.CXFServletExt.service(CXFServletExt.java:135)
 at org.jboss.wsf.spi.deployment.WSFServlet.service(WSFServlet.java:140) [jbossws-spi-2.2.2.Final-redhat-1.jar:2.2.2.Final-redhat-1]
 at javax.servlet.http.HttpServlet.service(HttpServlet.java:847) [jboss-servlet-api_3.0_spec-1.0.2.Final-redhat-1.jar:1.0.2.Final-redhat-1]
 at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:295) [jbossweb-7.2.2.Final-redhat-1.jar:7.2.2.Final-redhat-1]
 at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:214) [jbossweb-7.2.2.Final-redhat-1.jar:7.2.2.Final-redhat-1]
 at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:230) [jbossweb-7.2.2.Final-redhat-1.jar:7.2.2.Final-redhat-1]
 at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:149) [jbossweb-7.2.2.Final-redhat-1.jar:7.2.2.Final-redhat-1]
 at org.jboss.as.web.session.ClusteredSessionValve.handleRequest(ClusteredSessionValve.java:134) [jboss-as-web-7.3.0.Final-redhat-14.jar:7.3.0.Final-redhat-14]
 at org.jboss.as.web.session.ClusteredSessionValve.invoke(ClusteredSessionValve.java:99) [jboss-as-web-7.3.0.Final-redhat-14.jar:7.3.0.Final-redhat-14]
 at org.jboss.as.web.session.JvmRouteValve.invoke(JvmRouteValve.java:92) [jboss-as-web-7.3.0.Final-redhat-14.jar:7.3.0.Final-redhat-14]
 at org.jboss.as.web.session.LockingValve.invoke(LockingValve.java:64) [jboss-as-web-7.3.0.Final-redhat-14.jar:7.3.0.Final-redhat-14]
 at org.jboss.as.web.security.SecurityContextAssociationValve.invoke(SecurityContextAssociationValve.java:169) [jboss-as-web-7.3.0.Final-redhat-14.jar:7.3.0.Final-redhat-14]
 at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:145) [jbossweb-7.2.2.Final-redhat-1.jar:7.2.2.Final-redhat-1]
 at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:97) [jbossweb-7.2.2.Final-redhat-1.jar:7.2.2.Final-redhat-1]
 at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:102) [jbossweb-7.2.2.Final-redhat-1.jar:7.2.2.Final-redhat-1]
 at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:336) [jbossweb-7.2.2.Final-redhat-1.jar:7.2.2.Final-redhat-1]
 at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:856) [jbossweb-7.2.2.Final-redhat-1.jar:7.2.2.Final-redhat-1]
 at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.process(Http11Protocol.java:653) [jbossweb-7.2.2.Final-redhat-1.jar:7.2.2.Final-redhat-1]
 at org.apache.tomcat.util.net.JIoEndpoint$Worker.run(JIoEndpoint.java:920) [jbossweb-7.2.2.Final-redhat-1.jar:7.2.2.Final-redhat-1]
 at java.lang.Thread.run(Thread.java:722) [rt.jar:1.7.0_21]
 
(...)


12:38:22,938 INFO  [stdout] (http-localhost/127.0.0.1:8080-7) [2015-07-18 12:38:22,938] (SqlExceptionHelper.java:145) WARN http-localhost/127.0.0.1:8080-7 org.hibernate.engine.jdbc.spi.SqlExceptionHelper SQL Error: 0, SQLState: null
12:38:22,939 INFO  [stdout] (http-localhost/127.0.0.1:8080-7) [2015-07-18 12:38:22,939] (SqlExceptionHelper.java:147) ERROR http-localhost/127.0.0.1:8080-7 org.hibernate.engine.jdbc.spi.SqlExceptionHelper javax.resource.ResourceException: IJ000457: Unchecked throwable in managedConnectionReconnected() cl=org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@1a7beef5[state=DESTROYED managed connection=org.jboss.jca.adapters.jdbc.xa.XAManagedConnection@3e852468 connection handles=0 lastUse=1437215902877 trackByTx=false pool=org.jboss.jca.core.connectionmanager.pool.strategy.OnePool@4efe0e2b pool internal context=SemaphoreArrayListManagedConnectionPool@789acdfa[pool=seguridadDS] xaResource=XAResourceWrapperImpl@171947e9[xaResource=org.jboss.jca.adapters.jdbc.xa.XAManagedConnection@3e852468 pad=false overrideRmValue=false productName=Microsoft SQL Server productVersion=10.50.4000 jndiName=java:jboss/datasources/seguridadDS] txSync=null]
12:38:22,940 INFO  [stdout] (http-localhost/127.0.0.1:8080-7) [2015-07-18 12:38:22,939] (PerfilFacade.java:259) ERROR http-localhost/127.0.0.1:8080-7 es.sisifo.myapp.persistencia.fachada.impl.PerfilFacade PerfilFacade: getPerfilesBySistemaNif Could not open connection
12:38:22,940 INFO  [stdout] (http-localhost/127.0.0.1:8080-7) [2015-07-18 12:38:22,940] (BusinessPerfilImpl.java:187) ERROR http-localhost/127.0.0.1:8080-7 es.sisifo.myapp.negocio.BusinessPerfilImpl BusinessPerfilImpl: getPerfil(nif, sistema) PerfilFacade:getPerfilesBySistemaNif Could not open connection
12:38:22,941 ERROR [stderr] (http-localhost/127.0.0.1:8080-7) es.sisifo.myapp.api.exceptions.BussinessException: BusinessPerfilImpl: getPerfil(nif, sistema) PerfilFacade:getPerfilesBySistemaNif Could not open connection
12:38:22,941 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at es.sisifo.myapp.negocio.BusinessPerfilImpl.getPerfiles(BusinessPerfilImpl.java:188)
12:38:22,941 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
12:38:22,941 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
12:38:22,942 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
12:38:22,942 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at java.lang.reflect.Method.invoke(Method.java:601)
12:38:22,942 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:317)
12:38:22,942 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:183)
12:38:22,942 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:150)
12:38:22,943 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.springframework.transaction.interceptor.TransactionInterceptor$1.proceedWithInvocation(TransactionInterceptor.java:96)
12:38:22,943 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransaction(TransactionAspectSupport.java:260)
12:38:22,943 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:94)
12:38:22,943 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172)
12:38:22,943 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:204)
12:38:22,944 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at com.sun.proxy.$Proxy131.getPerfiles(Unknown Source)
12:38:22,944 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at es.sisifo.myapp.negocio.external.SeguridadServiceExternal.getPerfilesUsuario(SeguridadServiceExternal.java:50)
12:38:22,944 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
12:38:22,944 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
12:38:22,944 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
12:38:22,945 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at java.lang.reflect.Method.invoke(Method.java:601)
12:38:22,945 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:317)
12:38:22,945 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:183)
12:38:22,945 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:150)
12:38:22,945 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.springframework.transaction.interceptor.TransactionInterceptor$1.proceedWithInvocation(TransactionInterceptor.java:96)
12:38:22,946 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransaction(TransactionAspectSupport.java:260)
12:38:22,946 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:94)
12:38:22,946 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172)
12:38:22,946 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:204)
12:38:22,946 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at com.sun.proxy.$Proxy134.getPerfilesUsuario(Unknown Source)
12:38:22,947 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at es.sisifo.myapp.negocio.external.ws.SeguridadServiceWS.getPerfilesUsuario(SeguridadServiceWS.java:37)
12:38:22,947 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
12:38:22,947 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
12:38:22,947 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
12:38:22,947 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at java.lang.reflect.Method.invoke(Method.java:601)
12:38:22,948 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.as.ee.component.ManagedReferenceMethodInterceptorFactory$ManagedReferenceMethodInterceptor.processInvocation(ManagedReferenceMethodInterceptorFactory.java:72)
12:38:22,948 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
12:38:22,948 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53)
12:38:22,948 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:58)
12:38:22,948 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
12:38:22,949 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53)
12:38:22,949 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:58)
12:38:22,949 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
12:38:22,949 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.invocation.InitialInterceptor.processInvocation(InitialInterceptor.java:21)
12:38:22,949 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
12:38:22,949 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61)
12:38:22,950 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.as.ee.component.interceptors.ComponentDispatcherInterceptor.processInvocation(ComponentDispatcherInterceptor.java:53)
12:38:22,950 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
12:38:22,950 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.as.webservices.deployers.WSComponentInstanceAssociationInterceptor.processInvocation(WSComponentInstanceAssociationInterceptor.java:49)
12:38:22,950 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
12:38:22,950 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61)
12:38:22,951 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.as.ee.component.ViewService$View.invoke(ViewService.java:165)
12:38:22,951 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.as.webservices.invocation.AbstractInvocationHandler.invoke(AbstractInvocationHandler.java:112)
12:38:22,951 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.wsf.stack.cxf.JBossWSInvoker.performInvocation(JBossWSInvoker.java:149)
12:38:22,951 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.apache.cxf.service.invoker.AbstractInvoker.invoke(AbstractInvoker.java:96)
12:38:22,951 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.apache.cxf.jaxws.AbstractJAXWSMethodInvoker.invoke(AbstractJAXWSMethodInvoker.java:178)
12:38:22,952 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.apache.cxf.jaxws.JAXWSMethodInvoker.invoke(JAXWSMethodInvoker.java:68)
12:38:22,952 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.wsf.stack.cxf.JBossWSInvoker.invoke(JBossWSInvoker.java:129)
12:38:22,952 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.apache.cxf.interceptor.ServiceInvokerInterceptor$1.run(ServiceInvokerInterceptor.java:57)
12:38:22,952 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
12:38:22,953 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334)
12:38:22,953 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at java.util.concurrent.FutureTask.run(FutureTask.java:166)
12:38:22,953 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.apache.cxf.workqueue.SynchronousExecutor.execute(SynchronousExecutor.java:37)
12:38:22,953 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.apache.cxf.interceptor.ServiceInvokerInterceptor.handleMessage(ServiceInvokerInterceptor.java:106)
12:38:22,953 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:272)
12:38:22,954 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.apache.cxf.transport.ChainInitiationObserver.onMessage(ChainInitiationObserver.java:121)
12:38:22,954 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.apache.cxf.transport.http.AbstractHTTPDestination.invoke(AbstractHTTPDestination.java:239)
12:38:22,954 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.wsf.stack.cxf.RequestHandlerImpl.handleHttpRequest(RequestHandlerImpl.java:92)
12:38:22,954 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.wsf.stack.cxf.transport.ServletHelper.callRequestHandler(ServletHelper.java:143)
12:38:22,954 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.wsf.stack.cxf.CXFServletExt.invoke(CXFServletExt.java:87)
12:38:22,954 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.apache.cxf.transport.servlet.AbstractHTTPServlet.handleRequest(AbstractHTTPServlet.java:286)
12:38:22,955 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.apache.cxf.transport.servlet.AbstractHTTPServlet.doPost(AbstractHTTPServlet.java:206)
12:38:22,955 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at javax.servlet.http.HttpServlet.service(HttpServlet.java:754)
12:38:22,955 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.wsf.stack.cxf.CXFServletExt.service(CXFServletExt.java:135)
12:38:22,955 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.wsf.spi.deployment.WSFServlet.service(WSFServlet.java:140)
12:38:22,955 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at javax.servlet.http.HttpServlet.service(HttpServlet.java:847)
12:38:22,956 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:295)
12:38:22,956 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:214)
12:38:22,956 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:230)
12:38:22,956 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:149)
12:38:22,956 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.as.web.session.ClusteredSessionValve.handleRequest(ClusteredSessionValve.java:134)
12:38:22,957 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.as.web.session.ClusteredSessionValve.invoke(ClusteredSessionValve.java:99)
12:38:22,957 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.as.web.session.JvmRouteValve.invoke(JvmRouteValve.java:92)
12:38:22,957 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.as.web.session.LockingValve.invoke(LockingValve.java:64)
12:38:22,957 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.as.web.security.SecurityContextAssociationValve.invoke(SecurityContextAssociationValve.java:169)
12:38:22,957 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:145)
12:38:22,958 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:97)
12:38:22,958 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:102)
12:38:22,958 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:336)
12:38:22,958 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:856)
12:38:22,958 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.process(Http11Protocol.java:653)
12:38:22,959 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.apache.tomcat.util.net.JIoEndpoint$Worker.run(JIoEndpoint.java:920)
12:38:22,959 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at java.lang.Thread.run(Thread.java:722)
12:38:22,959 ERROR [stderr] (http-localhost/127.0.0.1:8080-7) Caused by: es.sisifo.myapp.persistencia.exceptions.PersistenceException: PerfilFacade:getPerfilesBySistemaNif Could not open connection
12:38:22,959 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at es.sisifo.myapp.persistencia.fachada.impl.PerfilFacade.getPerfilesBySistemaNif(PerfilFacade.java:262)
12:38:22,960 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at es.sisifo.myapp.negocio.BusinessPerfilImpl.getPerfiles(BusinessPerfilImpl.java:177)
12:38:22,960 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  ... 90 more
12:38:22,960 ERROR [stderr] (http-localhost/127.0.0.1:8080-7) Caused by: org.hibernate.exception.GenericJDBCException: Could not open connection
12:38:22,961 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.hibernate.exception.internal.StandardSQLExceptionConverter.convert(StandardSQLExceptionConverter.java:54)
12:38:22,961 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.hibernate.engine.jdbc.spi.SqlExceptionHelper.convert(SqlExceptionHelper.java:125)
12:38:22,961 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.hibernate.engine.jdbc.spi.SqlExceptionHelper.convert(SqlExceptionHelper.java:110)
12:38:22,961 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.hibernate.engine.jdbc.internal.LogicalConnectionImpl.obtainConnection(LogicalConnectionImpl.java:221)
12:38:22,961 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.hibernate.engine.jdbc.internal.LogicalConnectionImpl.getConnection(LogicalConnectionImpl.java:157)
12:38:22,962 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.hibernate.engine.jdbc.internal.StatementPreparerImpl.connection(StatementPreparerImpl.java:56)
12:38:22,962 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.hibernate.engine.jdbc.internal.StatementPreparerImpl$5.doPrepare(StatementPreparerImpl.java:161)
12:38:22,962 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.hibernate.engine.jdbc.internal.StatementPreparerImpl$StatementPreparationTemplate.prepareStatement(StatementPreparerImpl.java:182)
12:38:22,962 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.hibernate.engine.jdbc.internal.StatementPreparerImpl.prepareQueryStatement(StatementPreparerImpl.java:159)
12:38:22,962 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.hibernate.loader.Loader.prepareQueryStatement(Loader.java:1859)
12:38:22,963 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.hibernate.loader.Loader.executeQueryStatement(Loader.java:1836)
12:38:22,963 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.hibernate.loader.Loader.executeQueryStatement(Loader.java:1816)
12:38:22,963 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.hibernate.loader.Loader.doQuery(Loader.java:900)
12:38:22,963 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.hibernate.loader.Loader.doQueryAndInitializeNonLazyCollections(Loader.java:342)
12:38:22,963 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.hibernate.loader.Loader.doList(Loader.java:2526)
12:38:22,964 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.hibernate.loader.Loader.doList(Loader.java:2512)
12:38:22,964 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.hibernate.loader.Loader.listIgnoreQueryCache(Loader.java:2342)
12:38:22,964 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.hibernate.loader.Loader.list(Loader.java:2337)
12:38:22,964 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.hibernate.loader.criteria.CriteriaLoader.list(CriteriaLoader.java:124)
12:38:22,964 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.hibernate.internal.SessionImpl.list(SessionImpl.java:1668)
12:38:22,964 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.hibernate.internal.CriteriaImpl.list(CriteriaImpl.java:374)
12:38:22,965 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at es.sisifo.myapp.persistencia.dao.hibernate.PerfilDAOImpl.getPerfilesByNifAndSystem(PerfilDAOImpl.java:101)
12:38:22,965 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at es.sisifo.myapp.persistencia.fachada.impl.PerfilFacade.getPerfilesBySistemaNif(PerfilFacade.java:250)
12:38:22,965 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  ... 91 more
12:38:22,966 ERROR [stderr] (http-localhost/127.0.0.1:8080-7) Caused by: java.sql.SQLException: javax.resource.ResourceException: IJ000457: Unchecked throwable in managedConnectionReconnected() cl=org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@1a7beef5[state=DESTROYED managed connection=org.jboss.jca.adapters.jdbc.xa.XAManagedConnection@3e852468 connection handles=0 lastUse=1437215902877 trackByTx=false pool=org.jboss.jca.core.connectionmanager.pool.strategy.OnePool@4efe0e2b pool internal context=SemaphoreArrayListManagedConnectionPool@789acdfa[pool=seguridadDS] xaResource=XAResourceWrapperImpl@171947e9[xaResource=org.jboss.jca.adapters.jdbc.xa.XAManagedConnection@3e852468 pad=false overrideRmValue=false productName=Microsoft SQL Server productVersion=10.50.4000 jndiName=java:jboss/datasources/seguridadDS] txSync=null]
12:38:22,966 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.jca.adapters.jdbc.WrapperDataSource.getConnection(WrapperDataSource.java:147)
12:38:22,966 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.hibernate.service.jdbc.connections.internal.DatasourceConnectionProviderImpl.getConnection(DatasourceConnectionProviderImpl.java:141)
12:38:22,966 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.hibernate.internal.AbstractSessionImpl$NonContextualJdbcConnectionAccess.obtainConnection(AbstractSessionImpl.java:292)
12:38:22,966 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.hibernate.engine.jdbc.internal.LogicalConnectionImpl.obtainConnection(LogicalConnectionImpl.java:214)
12:38:22,967 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  ... 110 more
12:38:22,967 ERROR [stderr] (http-localhost/127.0.0.1:8080-7) Caused by: javax.resource.ResourceException: IJ000457: Unchecked throwable in managedConnectionReconnected() cl=org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@1a7beef5[state=DESTROYED managed connection=org.jboss.jca.adapters.jdbc.xa.XAManagedConnection@3e852468 connection handles=0 lastUse=1437215902877 trackByTx=false pool=org.jboss.jca.core.connectionmanager.pool.strategy.OnePool@4efe0e2b pool internal context=SemaphoreArrayListManagedConnectionPool@789acdfa[pool=seguridadDS] xaResource=XAResourceWrapperImpl@171947e9[xaResource=org.jboss.jca.adapters.jdbc.xa.XAManagedConnection@3e852468 pad=false overrideRmValue=false productName=Microsoft SQL Server productVersion=10.50.4000 jndiName=java:jboss/datasources/seguridadDS] txSync=null]
12:38:22,967 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.jca.core.connectionmanager.AbstractConnectionManager.reconnectManagedConnection(AbstractConnectionManager.java:604)
12:38:22,967 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.jca.core.connectionmanager.AbstractConnectionManager.allocateConnection(AbstractConnectionManager.java:467)
12:38:22,968 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.jca.adapters.jdbc.WrapperDataSource.getConnection(WrapperDataSource.java:139)
12:38:22,968 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  ... 113 more
12:38:22,968 ERROR [stderr] (http-localhost/127.0.0.1:8080-7) Caused by: javax.resource.ResourceException: IJ000461: Could not enlist in transaction on entering meta-aware object
12:38:22,968 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.jca.core.connectionmanager.tx.TxConnectionManagerImpl.managedConnectionReconnected(TxConnectionManagerImpl.java:474)
12:38:22,969 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.jca.core.connectionmanager.AbstractConnectionManager.reconnectManagedConnection(AbstractConnectionManager.java:599)
12:38:22,969 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  ... 115 more
12:38:22,969 ERROR [stderr] (http-localhost/127.0.0.1:8080-7) Caused by: javax.transaction.SystemException: IJ000356: Failed to enlist: java.lang.Throwable: Unabled to enlist resource, see the previous warnings. tx=TransactionImple < ac, BasicAction: 0:ffffc0a80120:2e261a98:55aa2c5e:4d status: ActionStatus.ABORT_ONLY >
12:38:22,969 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.jca.core.connectionmanager.listener.TxConnectionListener$TransactionSynchronization.checkEnlisted(TxConnectionListener.java:612)
12:38:22,970 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.jca.core.connectionmanager.listener.TxConnectionListener.enlist(TxConnectionListener.java:323)
12:38:22,970 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  at org.jboss.jca.core.connectionmanager.tx.TxConnectionManagerImpl.managedConnectionReconnected(TxConnectionManagerImpl.java:467)
12:38:22,970 ERROR [stderr] (http-localhost/127.0.0.1:8080-7)  ... 116 more

(...)

This error appears when you use a XA-DATASOURCE from JBoss to connect to a database in SQL Server, and it does not have XA TRANSACTIONS activated.

The key error lines are:
org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@1a7beef5[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.xa.XAManagedConnection@3e852468 connection handles=0 lastUse=1437215902877 trackByTx=true pool=org.jboss.jca.core.connectionmanager.pool.strategy.OnePool@4efe0e2b pool internal context=SemaphoreArrayListManagedConnectionPool@789acdfa[pool=seguridadDS] xaResource=XAResourceWrapperImpl@171947e9[xaResource=org.jboss.jca.adapters.jdbc.xa.XAManagedConnection@3e852468 pad=false overrideRmValue=false productName=Microsoft SQL Server productVersion=10.50.4000 jndiName=java:jboss/datasources/seguridadDS] txSync=null]: javax.transaction.xa.XAException: Error en la función START:. El estado es: -3. Error: "*** SQLJDBC_XA DTC_ERROR Context: FInitializeTransactionManager, state=1, StatusCode:-3 (0xFFFFFFFD) ***"
And:
javax.transaction.SystemException: IJ000356: Failed to enlist: java.lang.Throwable: Unabled to enlist resource, see the previous warnings. tx=TransactionImple < ac, BasicAction: 0:ffffc0a80120:2e261a98:55aa2c5e:4d status: ActionStatus.ABORT_ONLY >
The first one says that there was an error when you tried to open a new transaction, and the second says that you can not enlist a xa-resource in a transaction with errors.


In order solve this error, you only have to configure XA TRANSACTIONS in SQL Server.
You can check:

JBoss - HornetQ: ERROR [org.hornetq.core.client] (Old I/O client worker

Topology:
  • JBoss AS7.1.1 Standalone, profile full-ha
  • JBoss EAP 6.2 Domain,  1 DC + 2HC

All nodes are in the same machine, but under diferent binding addresses. In this image you can check the complete topology.



Standalone HornetQ config:
<subsystem xmlns="urn:jboss:domain:messaging:1.1">
 <hornetq-server>
  <clustered>true</clustered>
  <persistence-enabled>true</persistence-enabled>
  <journal-file-size>102400</journal-file-size>
  <journal-min-files>2</journal-min-files>
  <connectors>
   <netty-connector name="netty" socket-binding="messaging"/>
   <netty-connector name="netty-throughput" socket-binding="messaging-throughput">
    <param key="batch-delay" value="50"/>
   </netty-connector>
   <in-vm-connector name="in-vm" server-id="0"/>
  </connectors>
  <acceptors>
   <netty-acceptor name="netty" socket-binding="messaging"/>
   <netty-acceptor name="netty-throughput" socket-binding="messaging-throughput">
    <param key="batch-delay" value="50"/>
    <param key="direct-deliver" value="false"/>
   </netty-acceptor>
   <in-vm-acceptor name="in-vm" server-id="0"/>
  </acceptors>
  <broadcast-groups>
   <broadcast-group name="bg-group1">
    <group-address>231.7.7.7</group-address>
    <group-port>9876</group-port>
    <broadcast-period>5000</broadcast-period>
    <connector-ref>netty</connector-ref>
   </broadcast-group>
  </broadcast-groups>
  <discovery-groups>
   <discovery-group name="dg-group1">
    <group-address>231.7.7.7</group-address>
    <group-port>9876</group-port>
    <refresh-timeout>10000</refresh-timeout>
   </discovery-group>
  </discovery-groups>
  <cluster-connections>
   <cluster-connection name="my-cluster">
    <address>jms</address>
    <connector-ref>netty</connector-ref>
    <discovery-group-ref discovery-group-name="dg-group1"/>
   </cluster-connection>
  </cluster-connections>
  <security-settings>
   <security-setting match="#">
    <permission type="send" roles="guest"/>
    <permission type="consume" roles="guest"/>
    <permission type="createNonDurableQueue" roles="guest"/>
    <permission type="deleteNonDurableQueue" roles="guest"/>
   </security-setting>
  </security-settings>
  <address-settings>
   <!--default for catch all-->
   <address-setting match="#">
    <dead-letter-address>jms.queue.DLQ</dead-letter-address>
    <expiry-address>jms.queue.ExpiryQueue</expiry-address>
    <redelivery-delay>0</redelivery-delay>
    <redistribution-delay>1000</redistribution-delay>
    <max-size-bytes>10485760</max-size-bytes>
    <address-full-policy>BLOCK</address-full-policy>
    <message-counter-history-day-limit>10</message-counter-history-day-limit>
   </address-setting>
  </address-settings>
  <jms-connection-factories>
   <connection-factory name="InVmConnectionFactory">
    <connectors>
     <connector-ref connector-name="in-vm"/>
    </connectors>
    <entries>
     <entry name="java:/ConnectionFactory"/>
    </entries>
   </connection-factory>
   <connection-factory name="RemoteConnectionFactory">
    <connectors>
     <connector-ref connector-name="netty"/>
    </connectors>
    <entries>
     <entry name="RemoteConnectionFactory"/>
     <entry name="java:jboss/exported/jms/RemoteConnectionFactory"/>
    </entries>
   </connection-factory>
   <pooled-connection-factory name="hornetq-ra">
    <transaction mode="xa"/>
    <connectors>
     <connector-ref connector-name="in-vm"/>
    </connectors>
    <entries>
     <entry name="java:/JmsXA"/>
    </entries>
   </pooled-connection-factory>
  </jms-connection-factories>
  <jms-destinations>
   <jms-queue name="testQueue">
    <entry name="queue/test"/>
    <entry name="java:jboss/exported/jms/queue/test"/>
   </jms-queue>
   <jms-topic name="testTopic">
    <entry name="topic/test"/>
    <entry name="java:jboss/exported/jms/topic/test"/>
   </jms-topic>
  </jms-destinations>
 </hornetq-server>
</subsystem>

Domain HornetQ config (full-ha profile):
<subsystem xmlns="urn:jboss:domain:messaging:1.4">
 <hornetq-server name="main-culster">
  <persistence-enabled>true</persistence-enabled>
  <cluster-user>adminCluster</cluster-user>
  <cluster-password>cluster.123</cluster-password>
  <journal-type>NIO</journal-type>
  <journal-min-files>2</journal-min-files>

  <connectors>
   <netty-connector name="netty" socket-binding="messaging"/>
   <netty-connector name="netty-throughput" socket-binding="messaging-throughput">
    <param key="batch-delay" value="50"/>
   </netty-connector>
   <in-vm-connector name="in-vm" server-id="0"/>
  </connectors>

  <acceptors>
   <netty-acceptor name="netty" socket-binding="messaging"/>
   <netty-acceptor name="netty-throughput" socket-binding="messaging-throughput">
    <param key="batch-delay" value="50"/>
    <param key="direct-deliver" value="false"/>
   </netty-acceptor>
   <in-vm-acceptor name="in-vm" server-id="0"/>
  </acceptors>

  <broadcast-groups>
   <broadcast-group name="bg-group1">
    <socket-binding>messaging-group</socket-binding>
    <broadcast-period>5000</broadcast-period>
    <connector-ref>
                                netty
    </connector-ref>
   </broadcast-group>
  </broadcast-groups>

  <discovery-groups>
   <discovery-group name="dg-group1">
    <socket-binding>messaging-group</socket-binding>
    <refresh-timeout>10000</refresh-timeout>
   </discovery-group>
  </discovery-groups>

  <cluster-connections>
   <cluster-connection name="my-cluster">
    <address>jms</address>
    <connector-ref>netty</connector-ref>
    <discovery-group-ref discovery-group-name="dg-group1"/>
   </cluster-connection>
  </cluster-connections>

  <security-settings>
   <security-setting match="#">
    <permission type="send" roles="guest"/>
    <permission type="consume" roles="guest"/>
    <permission type="createNonDurableQueue" roles="guest"/>
    <permission type="deleteNonDurableQueue" roles="guest"/>
   </security-setting>
  </security-settings>

  <address-settings>
   <address-setting match="#">
    <dead-letter-address>jms.queue.DLQ</dead-letter-address>
    <expiry-address>jms.queue.ExpiryQueue</expiry-address>
    <redelivery-delay>0</redelivery-delay>
    <max-size-bytes>10485760</max-size-bytes>
    <page-size-bytes>2097152</page-size-bytes>
    <address-full-policy>PAGE</address-full-policy>
    <message-counter-history-day-limit>10</message-counter-history-day-limit>
    <redistribution-delay>1000</redistribution-delay>
   </address-setting>
  </address-settings>

  <jms-connection-factories>
   <connection-factory name="InVmConnectionFactory">
    <connectors>
     <connector-ref connector-name="in-vm"/>
    </connectors>
    <entries>
     <entry name="java:/ConnectionFactory"/>
    </entries>
   </connection-factory>
   <connection-factory name="RemoteConnectionFactory">
    <connectors>
     <connector-ref connector-name="netty"/>
    </connectors>
    <entries>
     <entry name="java:jboss/exported/jms/RemoteConnectionFactory"/>
    </entries>
    <ha>true</ha>
    <block-on-acknowledge>true</block-on-acknowledge>
    <retry-interval>1000</retry-interval>
    <retry-interval-multiplier>1.0</retry-interval-multiplier>
    <reconnect-attempts>-1</reconnect-attempts>
   </connection-factory>
   <pooled-connection-factory name="hornetq-ra">
    <transaction mode="xa"/>
    <connectors>
     <connector-ref connector-name="in-vm"/>
    </connectors>
    <entries>
     <entry name="java:/JmsXA"/>
    </entries>
   </pooled-connection-factory>
  </jms-connection-factories>

  <jms-destinations>
   <jms-queue name="testQueue">
    <entry name="queue/test"/>
    <entry name="java:jboss/exported/jms/queue/test"/>
   </jms-queue>
  </jms-destinations>
 </hornetq-server>
</subsystem>

By having the rest of configuration by default, you can get two diferent errors:
1) If AS 7.1.1 is running, when  EAP 6.2 HC starts, you get this errors:
In AS 7.1.1:
WARN  [org.hornetq.core.protocol.core.impl.HornetQPacketHandler] (Old I/O server worker (parentId: 1268068589, [id: 0x4b9530ed, /192.168.56.120:5445])) Client with version 123 and address /192.168.56.120:34031 is not compatible with server version 2.2.13.Final (HQ_2_2_13_FINAL_AS7, 122). Please ensure all clients and servers are upgraded to the same version for them to interoperate properly

ERROR [org.hornetq.core.protocol.core.impl.HornetQPacketHandler] (Old I/O server worker (parentId: 1268068589, [id: 0x4b9530ed, /192.168.56.120:5445])) Failed to create session : HornetQException[errorCode=108 message=Server and client versions incompatible]

In HC:
ERROR [org.hornetq.core.client] (Old I/O client worker ([id: 0xe27d6774, /192.168.56.120:34041 => /192.168.56.120:5445])) HQ214013: Failed to decode packet: java.lang.IndexOutOfBoundsException: Readable byte limit exceeded: 207

2) If EAP 6.2 HCs are running, when AS 7.1.1 starts, you get this errors in HCs:
In HC1:
ERROR [org.hornetq.core.server] (Old I/O server worker (parentId: -2000364733, [id: 0x88c4db43, /192.168.56.102:5595])) HQ224018: Failed to create session: HornetQException[errorType=SECURITY_EXCEPTION message=HQ119031: Unable to validate user: HORNETQ.CLUSTER.ADMIN.USER]

In HC2:
ERROR [org.hornetq.core.server] (Old I/O server worker (parentId: -1549800239, [id: 0xa39fecd1, /192.168.56.103:5595])) HQ224018: Failed to create session: HornetQException[errorType=SECURITY_EXCEPTION message=HQ119031: Unable to validate user: HORNETQ.CLUSTER.ADMIN.USER]

Well, this is what I think is happening.
When AS 7.1.1 is running, and one HC starts, the last one tries to enlist in the existing 2.2.13 HornetQ Cluster. But as the versions are diferent, the message formats don't match.
In the error, the ip adress shown belong to the AS 7.1.1 server.


When EAP domain is running, and AS 7.1.1 starts, the last one tries to enlist in the 2.3.12 HornetQ Cluster. In this case the cluster understands the messages, but the credentials send by AS 7.1.1 are not valid.
You can change the credentials in AS 7.1.1 standalone-full-ha, and in this case you will get the following warning in HC:
WARN  [org.hornetq.core.client] (hornetq-discovery-group-thread-dg-group1) HQ212034: There are more than one servers on the network broadcasting the same node id. You will see this message exactly once (per node) if a node is restarted, in which case it can be safely ignored. But if it is logged continuously it means you really do have more than one node on the same network active concurrently with the same node id. This could occur if you have a backup node active at the same time as its live node. nodeID=d03a0cf1-2d35-11e5-ae4b-0800276d9dbc

This happens because you are trying to configure two master nodes in AS 7.1.1 and EAP, and both are identified with the same parameters.

But what I want is take both clusters isolated, so they to not interfere with each other.
The simplest way is change multicast address.

In domain config, multicast address is configured as a socket binding refered from broadcast-group and discovery-group. It is named messaging-group:
<socket-binding-group name="full-ha-sockets" default-interface="public">
 (...)
 <socket-binding name="messaging" port="5445"/>
 <socket-binding name="messaging-group" port="0" multicast-address="${jboss.messaging.group.address:231.7.7.7}" multicast-port="${jboss.messaging.group.port:9876}"/>
 <socket-binding name="messaging-throughput" port="5455"/>
 (...)
</socket-binding-group>

In standalone config, multicast address is configigured directly in hornetQ-server:
<broadcast-groups>
 <broadcast-group name="bg-group1">
  <group-address>231.7.7.7</group-address>
  <group-port>9876</group-port>
  <broadcast-period>5000</broadcast-period>
  <connector-ref>netty</connector-ref>
 </broadcast-group>
</broadcast-groups>
<discovery-groups>
 <discovery-group name="dg-group1">
  <group-address>231.7.7.7</group-address>
  <group-port>9876</group-port>
  <refresh-timeout>10000</refresh-timeout>
 </discovery-group>
</discovery-groups>

So, we have two clusters broadcasting to the same dir and same port. Thats why the are colliding.
I tried to change the multicast address, but they still collide.
The solution was to change the port. (I tried to change multicast IP but this didn´t work)

miércoles, 1 de julio de 2015

PuTTY - Configure SSH Tunel

I have two machines, M1 and M2. M1 can see M2, but M2 can not see M1.
The objective of this post is explain how to set up a tunnel from M1 to M2, in order to M2 could access to services published in M1.
In this case, M1 has an Apache server published in port 80, and I want M2 could be able to call it.

The simplest way is by using PuTTY (https://es.wikipedia.org/wiki/PuTTY)

In M1, you have to open  PuTTY and go to Connection > SSH > Tunnels. In this page you have to configure:
  • Source port: This is the port we use to trick M2. When M2 call sfor localhost and this port, it will be being calling another direction instead.
  • Destination: This is the URL M2 will be being calling when it called localhost and source port.

In this example, source port is 8088 (it could be any free port in M2) and it will point to localhost:80 (localhost is M1).


Once the tunnel is configured, go to Session and set the Host Name (or IP) of M2 to open a connection.


With this configuration, anytime someone (say a user, a web app, a portlet, etc.) in M2 call for http://localhost:8088/xxxx it will be redirected to http;//M1:80/xxxx.

For example, you can type the following command in order to verify the tunnel:
[root@M2 ~]# curl localhost:8088
<<html><body><h1>It works!</h1></body></html>
[root@M2 ~]#

Note that the "it works" is the default page of Apache httpd in M1, called from M2!