[JBoss JIRA] (JBTM-2886) Automatize XTS ssl quickstart to be tested in CI on Windows
by Ondra Chaloupka (JIRA)
Ondra Chaloupka created JBTM-2886:
-------------------------------------
Summary: Automatize XTS ssl quickstart to be tested in CI on Windows
Key: JBTM-2886
URL: https://issues.jboss.org/browse/JBTM-2886
Project: JBoss Transaction Manager
Issue Type: Enhancement
Components: XTS
Affects Versions: 5.5.24.Final
Reporter: Ondra Chaloupka
Assignee: Ondra Chaloupka
There was created a shell script for JBTM-2882 which automatize testing of XTS over SSL. The steps were already written in `README.md` but that was not run automatically on CI.
The linux version with shell script was provided but we need windows version with `.bat`. This is a followup task to provide the bat script for the automatization on Windows.
--
This message was sent by Atlassian JIRA
(v7.2.3#72005)
7 years, 8 months
[JBoss JIRA] (JBTM-2885) Orphan detection may attempt to rollback XID even if XAR did not report Xid due to failure
by Tom Jenkinson (JIRA)
Tom Jenkinson created JBTM-2885:
-----------------------------------
Summary: Orphan detection may attempt to rollback XID even if XAR did not report Xid due to failure
Key: JBTM-2885
URL: https://issues.jboss.org/browse/JBTM-2885
Project: JBoss Transaction Manager
Issue Type: Bug
Reporter: Tom Jenkinson
Assignee: Tom Jenkinson
Priority: Blocker
Fix For: 5.5.25.Final, 5.next
If the XAR returns a Xid from recover(FIRST_PASS) to XARM but then goes offline we may attempt to rollback the Xid thinking it is stale. If the XAR returns an XAE at that point we should clear the _xidScans so we pick it up next time.
--
This message was sent by Atlassian JIRA
(v7.2.3#72005)
7 years, 8 months
[JBoss JIRA] (JBTM-2884) (7.0.z) Provide way of getting suppressed exceptions out of SubordinateTransaction
by Bartosz Spyrko-Śmietanko (JIRA)
Bartosz Spyrko-Śmietanko created JBTM-2884:
----------------------------------------------
Summary: (7.0.z) Provide way of getting suppressed exceptions out of SubordinateTransaction
Key: JBTM-2884
URL: https://issues.jboss.org/browse/JBTM-2884
Project: JBoss Transaction Manager
Issue Type: Feature Request
Components: Transaction Core
Affects Versions: 4.17.38, 5.5.5.Final
Reporter: Bartosz Spyrko-Śmietanko
Assignee: Ondra Chaloupka
We need to provide way how to pass suppressed exceptions of of the `SubordinateTransaction` to the caller.
This request came from customer case and https://bugzilla.redhat.com/show_bug.cgi?id=1435549 as we need to provide exceptions thrown from transaction resource.
The interface is used for controlling propagated transaction from one server to another in EAP/WFLY.
Callers are is ejb3 subsystem in EAP 6.4/7.0 and WFTC in EAP 7.1.
--
This message was sent by Atlassian JIRA
(v7.2.3#72005)
7 years, 8 months
[JBoss JIRA] (JBTM-2883) Narayana should not hide exception traces even for internal or protocol errors in WS txn
by Ondra Chaloupka (JIRA)
[ https://issues.jboss.org/browse/JBTM-2883?page=com.atlassian.jira.plugin.... ]
Ondra Chaloupka updated JBTM-2883:
----------------------------------
Description:
Narayana hides stacktraces of exception when some internal error (e.g. protocol, communication...) happens in XTS. This particular problem reveales in case of customer case https://access.redhat.com/support/cases/#/case/01810386 where .NET application communicates with JBoss EAP over WS and WS-AT should be used. .NET (probably) uses non-standard header/message that caused Narayana response being null.
The original error info was only
{code}
ERROR [org.jboss.jbossts.txbridge] (http-/0.0.0.0:8543-1) com.arjuna.wst.SystemException: java.lang.NullPointerException
TRACE [org.jboss.jbossts.txbridge] (http-/0.0.0.0:8543-1) JaxWSTxInboundBridgeHandler.close()
INFO [org.apache.cxf.services.IntegrationFrameworkServiceWsService.IntegrationFrameworkServiceWsPort.IntegrationFrameworkServiceWs] (http-/0.0.0.0:8543-1) Outbound Message
{code}
which is quite not much to start tracking reason behind the problem.
There should be shown stacktrace in log to get more detailed information for investigation to start. E.g. it should be something like
{code}
09:21:36,155 ERROR [stderr] (http-0.0.0.0:8443-1) RICKY: response=null
09:21:36,156 ERROR [stderr] (http-0.0.0.0:8443-1) java.lang.NullPointerException
09:21:36,156 ERROR [stderr] (http-0.0.0.0:8443-1) at com.arjuna.wsc11.RegistrationCoordinator.register(RegistrationCoordinator.java:58)
09:21:36,156 ERROR [stderr] (http-0.0.0.0:8443-1) at com.arjuna.mwlabs.wst11.at.remote.TransactionManagerImple.registerParticipant(TransactionManagerImple.java:156)
09:21:36,156 ERROR [stderr] (http-0.0.0.0:8443-1) at com.arjuna.mwlabs.wst11.at.remote.TransactionManagerImple.enlistForDurableTwoPhase(TransactionManagerImple.java:41)
09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.quickstarts.wsat.simple.RestaurantServiceATImpl.makeBooking(RestaurantServiceATImpl.java:74)
09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at java.lang.reflect.Method.invoke(Method.java:498)
09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.ee.component.ManagedReferenceMethodInterceptor.processInvocation(ManagedReferenceMethodInterceptor.java:52)
09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53)
09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:63)
09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53)
09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:63)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.InitialInterceptor.processInvocation(InitialInterceptor.java:21)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.ee.component.interceptors.ComponentDispatcherInterceptor.processInvocation(ComponentDispatcherInterceptor.java:53)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.webservices.deployers.WSComponentInstanceAssociationInterceptor.processInvocation(WSComponentInstanceAssociationInterceptor.java:49)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.ee.component.ViewService$View.invoke(ViewService.java:189)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.webservices.invocation.AbstractInvocationHandler.invoke(AbstractInvocationHandler.java:129)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.wsf.stack.cxf.JBossWSInvoker.performInvocation(JBossWSInvoker.java:177)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.service.invoker.AbstractInvoker.invoke(AbstractInvoker.java:104)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.jaxws.AbstractJAXWSMethodInvoker.invoke(AbstractJAXWSMethodInvoker.java:237)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.jaxws.JAXWSMethodInvoker.invoke(JAXWSMethodInvoker.java:69)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.wsf.stack.cxf.JBossWSInvoker.invoke(JBossWSInvoker.java:146)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.interceptor.ServiceInvokerInterceptor$1.run(ServiceInvokerInterceptor.java:58)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at java.util.concurrent.FutureTask.run(FutureTask.java:266)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.workqueue.SynchronousExecutor.execute(SynchronousExecutor.java:37)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.interceptor.ServiceInvokerInterceptor.handleMessage(ServiceInvokerInterceptor.java:107)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:272)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.transport.ChainInitiationObserver.onMessage(ChainInitiationObserver.java:121)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.transport.http.AbstractHTTPDestination.invoke(AbstractHTTPDestination.java:249)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.wsf.stack.cxf.RequestHandlerImpl.handleHttpRequest(RequestHandlerImpl.java:97)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.wsf.stack.cxf.transport.ServletHelper.callRequestHandler(ServletHelper.java:131)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.wsf.stack.cxf.CXFServletExt.invoke(CXFServletExt.java:88)
09:21:36,160 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.transport.servlet.AbstractHTTPServlet.handleRequest(AbstractHTTPServlet.java:289)
09:21:36,160 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.transport.servlet.AbstractHTTPServlet.doPost(AbstractHTTPServlet.java:209)
09:21:36,160 ERROR [stderr] (http-0.0.0.0:8443-1) at javax.servlet.http.HttpServlet.service(HttpServlet.java:754)
09:21:36,160 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.wsf.stack.cxf.CXFServletExt.service(CXFServletExt.java:136)
09:21:36,160 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.wsf.spi.deployment.WSFServlet.service(WSFServlet.java:140)
09:21:36,164 ERROR [stderr] (http-0.0.0.0:8443-1) at javax.servlet.http.HttpServlet.service(HttpServlet.java:847)
09:21:36,164 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:295)
09:21:36,164 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:214)
09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:231)
09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:149)
09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:512)
09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.web.security.SecurityContextAssociationValve.invoke(SecurityContextAssociationValve.java:169)
09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:150)
09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:97)
09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:102)
09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:344)
09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:854)
09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.process(Http11Protocol.java:656)
09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.tomcat.util.net.JIoEndpoint$Worker.run(JIoEndpoint.java:926)
09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at java.lang.Thread.run(Thread.java:745)
09:21:36,167 ERROR [org.jboss.as.webservices.invocation.InvocationHandlerJAXWS] (http-0.0.0.0:8443-1) JBAS015594: Method invocation failed with exception: Error when enlisting participant: org.jboss.as.quickstarts.wsat.simple.RestaurantException: Error when enlisting participant
at org.jboss.as.quickstarts.wsat.simple.RestaurantServiceATImpl.makeBooking(RestaurantServiceATImpl.java:76) [classes:]
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.8.0_102]
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [rt.jar:1.8.0_102]
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.8.0_102]
at java.lang.reflect.Method.invoke(Method.java:498) [rt.jar:1.8.0_102]
at org.jboss.as.ee.component.ManagedReferenceMethodInterceptor.processInvocation(ManagedReferenceMethodInterceptor.java:52) [jboss-as-ee-7.5.12.Final-redhat-1.jar:7.5.12.Final-redhat-1]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:63) [jboss-as-ee-7.5.12.Final-redhat-1.jar:7.5.12.Final-redhat-1]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:63) [jboss-as-ee-7.5.12.Final-redhat-1.jar:7.5.12.Final-redhat-1]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
at org.jboss.invocation.InitialInterceptor.processInvocation(InitialInterceptor.java:21) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
at org.jboss.as.ee.component.interceptors.ComponentDispatcherInterceptor.processInvocation(ComponentDispatcherInterceptor.java:53) [jboss-as-ee-7.5.12.Final-redhat-1.jar:7.5.12.Final-redhat-1]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.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.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
at org.jboss.as.ee.component.ViewService$View.invoke(ViewService.java:189) [jboss-as-ee-7.5.12.Final-redhat-1.jar:7.5.12.Final-redhat-1]
at org.jboss.as.webservices.invocation.AbstractInvocationHandler.invoke(AbstractInvocationHandler.java:129)
at org.jboss.wsf.stack.cxf.JBossWSInvoker.performInvocation(JBossWSInvoker.java:177)
at org.apache.cxf.service.invoker.AbstractInvoker.invoke(AbstractInvoker.java:104)
at org.apache.cxf.jaxws.AbstractJAXWSMethodInvoker.invoke(AbstractJAXWSMethodInvoker.java:237)
at org.apache.cxf.jaxws.JAXWSMethodInvoker.invoke(JAXWSMethodInvoker.java:69)
at org.jboss.wsf.stack.cxf.JBossWSInvoker.invoke(JBossWSInvoker.java:146)
at org.apache.cxf.interceptor.ServiceInvokerInterceptor$1.run(ServiceInvokerInterceptor.java:58)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [rt.jar:1.8.0_102]
at java.util.concurrent.FutureTask.run(FutureTask.java:266) [rt.jar:1.8.0_102]
at org.apache.cxf.workqueue.SynchronousExecutor.execute(SynchronousExecutor.java:37)
at org.apache.cxf.interceptor.ServiceInvokerInterceptor.handleMessage(ServiceInvokerInterceptor.java:107)
at org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:272)
at org.apache.cxf.transport.ChainInitiationObserver.onMessage(ChainInitiationObserver.java:121)
at org.apache.cxf.transport.http.AbstractHTTPDestination.invoke(AbstractHTTPDestination.java:249)
at org.jboss.wsf.stack.cxf.RequestHandlerImpl.handleHttpRequest(RequestHandlerImpl.java:97)
at org.jboss.wsf.stack.cxf.transport.ServletHelper.callRequestHandler(ServletHelper.java:131)
at org.jboss.wsf.stack.cxf.CXFServletExt.invoke(CXFServletExt.java:88)
at org.apache.cxf.transport.servlet.AbstractHTTPServlet.handleRequest(AbstractHTTPServlet.java:289)
at org.apache.cxf.transport.servlet.AbstractHTTPServlet.doPost(AbstractHTTPServlet.java:209)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:754) [jboss-servlet-api_3.0_spec-1.0.2.Final-redhat-2.jar:1.0.2.Final-redhat-2]
at org.jboss.wsf.stack.cxf.CXFServletExt.service(CXFServletExt.java:136)
at org.jboss.wsf.spi.deployment.WSFServlet.service(WSFServlet.java:140) [jbossws-spi-2.3.1.Final-redhat-1.jar:2.3.1.Final-redhat-1]
at javax.servlet.http.HttpServlet.service(HttpServlet.java:847) [jboss-servlet-api_3.0_spec-1.0.2.Final-redhat-2.jar:1.0.2.Final-redhat-2]
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:295) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:214) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:231) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:149) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:512) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
at org.jboss.as.web.security.SecurityContextAssociationValve.invoke(SecurityContextAssociationValve.java:169) [jboss-as-web-7.5.12.Final-redhat-1.jar:7.5.12.Final-redhat-1]
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:150) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:97) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:102) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:344) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:854) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.process(Http11Protocol.java:656) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
at org.apache.tomcat.util.net.JIoEndpoint$Worker.run(JIoEndpoint.java:926) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
at java.lang.Thread.run(Thread.java:745) [rt.jar:1.8.0_102]
Caused by: com.arjuna.wst.SystemException: java.lang.NullPointerException
at com.arjuna.mwlabs.wst11.at.remote.TransactionManagerImple.registerParticipant(TransactionManagerImple.java:177) [jbossxts-4.17.38.Final-redhat-1.jar:4.17.38.Final-redhat-1]
at com.arjuna.mwlabs.wst11.at.remote.TransactionManagerImple.enlistForDurableTwoPhase(TransactionManagerImple.java:41) [jbossxts-4.17.38.Final-redhat-1.jar:4.17.38.Final-redhat-1]
at org.jboss.as.quickstarts.wsat.simple.RestaurantServiceATImpl.makeBooking(RestaurantServiceATImpl.java:74) [classes:]
... 58 more
{code}
The goal of this enhancement is to provide such logging on places where exception stacktrace is currently thrown away (not written to log).
was:
Narayana hides stacktraces of exception when some internal error (e.g. protocol, communication...) happens in XTS. This particular problem reveales in case of customer case https://access.redhat.com/support/cases/#/case/01810386 where .NET application communicates with JBoss EAP over WS and WS-AT should be used. .NET (probably) uses non-standard header/message that caused Narayana response being null.
The original error info was only
{code}
17:43:33,846 ERROR [org.jboss.jbossts.txbridge] (http-/0.0.0.0:8543-1) com.arjuna.wst.SystemException: java.lang.NullPointerException17:43:33,852 TRACE [org.jboss.jbossts.txbridge] (http-/0.0.0.0:8543-1) JaxWSTxInboundBridgeHandler.close()17:43:33,854 INFO [org.apache.cxf.services.IntegrationFrameworkServiceWsService.IntegrationFrameworkServiceWsPort.IntegrationFrameworkServiceWs] (http-/0.0.0.0:8543-1) Outbound Message
{code}
which is quite not much to start tracking reason behind the problem.
There should be shown stacktrace in log to get more detailed information for investigation to start. E.g. it should be something like
{code}
09:21:36,155 ERROR [stderr] (http-0.0.0.0:8443-1) RICKY: response=null
09:21:36,156 ERROR [stderr] (http-0.0.0.0:8443-1) java.lang.NullPointerException
09:21:36,156 ERROR [stderr] (http-0.0.0.0:8443-1) at com.arjuna.wsc11.RegistrationCoordinator.register(RegistrationCoordinator.java:58)
09:21:36,156 ERROR [stderr] (http-0.0.0.0:8443-1) at com.arjuna.mwlabs.wst11.at.remote.TransactionManagerImple.registerParticipant(TransactionManagerImple.java:156)
09:21:36,156 ERROR [stderr] (http-0.0.0.0:8443-1) at com.arjuna.mwlabs.wst11.at.remote.TransactionManagerImple.enlistForDurableTwoPhase(TransactionManagerImple.java:41)
09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.quickstarts.wsat.simple.RestaurantServiceATImpl.makeBooking(RestaurantServiceATImpl.java:74)
09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at java.lang.reflect.Method.invoke(Method.java:498)
09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.ee.component.ManagedReferenceMethodInterceptor.processInvocation(ManagedReferenceMethodInterceptor.java:52)
09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53)
09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:63)
09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53)
09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:63)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.InitialInterceptor.processInvocation(InitialInterceptor.java:21)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.ee.component.interceptors.ComponentDispatcherInterceptor.processInvocation(ComponentDispatcherInterceptor.java:53)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.webservices.deployers.WSComponentInstanceAssociationInterceptor.processInvocation(WSComponentInstanceAssociationInterceptor.java:49)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.ee.component.ViewService$View.invoke(ViewService.java:189)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.webservices.invocation.AbstractInvocationHandler.invoke(AbstractInvocationHandler.java:129)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.wsf.stack.cxf.JBossWSInvoker.performInvocation(JBossWSInvoker.java:177)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.service.invoker.AbstractInvoker.invoke(AbstractInvoker.java:104)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.jaxws.AbstractJAXWSMethodInvoker.invoke(AbstractJAXWSMethodInvoker.java:237)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.jaxws.JAXWSMethodInvoker.invoke(JAXWSMethodInvoker.java:69)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.wsf.stack.cxf.JBossWSInvoker.invoke(JBossWSInvoker.java:146)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.interceptor.ServiceInvokerInterceptor$1.run(ServiceInvokerInterceptor.java:58)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at java.util.concurrent.FutureTask.run(FutureTask.java:266)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.workqueue.SynchronousExecutor.execute(SynchronousExecutor.java:37)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.interceptor.ServiceInvokerInterceptor.handleMessage(ServiceInvokerInterceptor.java:107)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:272)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.transport.ChainInitiationObserver.onMessage(ChainInitiationObserver.java:121)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.transport.http.AbstractHTTPDestination.invoke(AbstractHTTPDestination.java:249)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.wsf.stack.cxf.RequestHandlerImpl.handleHttpRequest(RequestHandlerImpl.java:97)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.wsf.stack.cxf.transport.ServletHelper.callRequestHandler(ServletHelper.java:131)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.wsf.stack.cxf.CXFServletExt.invoke(CXFServletExt.java:88)
09:21:36,160 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.transport.servlet.AbstractHTTPServlet.handleRequest(AbstractHTTPServlet.java:289)
09:21:36,160 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.transport.servlet.AbstractHTTPServlet.doPost(AbstractHTTPServlet.java:209)
09:21:36,160 ERROR [stderr] (http-0.0.0.0:8443-1) at javax.servlet.http.HttpServlet.service(HttpServlet.java:754)
09:21:36,160 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.wsf.stack.cxf.CXFServletExt.service(CXFServletExt.java:136)
09:21:36,160 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.wsf.spi.deployment.WSFServlet.service(WSFServlet.java:140)
09:21:36,164 ERROR [stderr] (http-0.0.0.0:8443-1) at javax.servlet.http.HttpServlet.service(HttpServlet.java:847)
09:21:36,164 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:295)
09:21:36,164 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:214)
09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:231)
09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:149)
09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:512)
09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.web.security.SecurityContextAssociationValve.invoke(SecurityContextAssociationValve.java:169)
09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:150)
09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:97)
09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:102)
09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:344)
09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:854)
09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.process(Http11Protocol.java:656)
09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.tomcat.util.net.JIoEndpoint$Worker.run(JIoEndpoint.java:926)
09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at java.lang.Thread.run(Thread.java:745)
09:21:36,167 ERROR [org.jboss.as.webservices.invocation.InvocationHandlerJAXWS] (http-0.0.0.0:8443-1) JBAS015594: Method invocation failed with exception: Error when enlisting participant: org.jboss.as.quickstarts.wsat.simple.RestaurantException: Error when enlisting participant
at org.jboss.as.quickstarts.wsat.simple.RestaurantServiceATImpl.makeBooking(RestaurantServiceATImpl.java:76) [classes:]
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.8.0_102]
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [rt.jar:1.8.0_102]
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.8.0_102]
at java.lang.reflect.Method.invoke(Method.java:498) [rt.jar:1.8.0_102]
at org.jboss.as.ee.component.ManagedReferenceMethodInterceptor.processInvocation(ManagedReferenceMethodInterceptor.java:52) [jboss-as-ee-7.5.12.Final-redhat-1.jar:7.5.12.Final-redhat-1]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:63) [jboss-as-ee-7.5.12.Final-redhat-1.jar:7.5.12.Final-redhat-1]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:63) [jboss-as-ee-7.5.12.Final-redhat-1.jar:7.5.12.Final-redhat-1]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
at org.jboss.invocation.InitialInterceptor.processInvocation(InitialInterceptor.java:21) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
at org.jboss.as.ee.component.interceptors.ComponentDispatcherInterceptor.processInvocation(ComponentDispatcherInterceptor.java:53) [jboss-as-ee-7.5.12.Final-redhat-1.jar:7.5.12.Final-redhat-1]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.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.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
at org.jboss.as.ee.component.ViewService$View.invoke(ViewService.java:189) [jboss-as-ee-7.5.12.Final-redhat-1.jar:7.5.12.Final-redhat-1]
at org.jboss.as.webservices.invocation.AbstractInvocationHandler.invoke(AbstractInvocationHandler.java:129)
at org.jboss.wsf.stack.cxf.JBossWSInvoker.performInvocation(JBossWSInvoker.java:177)
at org.apache.cxf.service.invoker.AbstractInvoker.invoke(AbstractInvoker.java:104)
at org.apache.cxf.jaxws.AbstractJAXWSMethodInvoker.invoke(AbstractJAXWSMethodInvoker.java:237)
at org.apache.cxf.jaxws.JAXWSMethodInvoker.invoke(JAXWSMethodInvoker.java:69)
at org.jboss.wsf.stack.cxf.JBossWSInvoker.invoke(JBossWSInvoker.java:146)
at org.apache.cxf.interceptor.ServiceInvokerInterceptor$1.run(ServiceInvokerInterceptor.java:58)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [rt.jar:1.8.0_102]
at java.util.concurrent.FutureTask.run(FutureTask.java:266) [rt.jar:1.8.0_102]
at org.apache.cxf.workqueue.SynchronousExecutor.execute(SynchronousExecutor.java:37)
at org.apache.cxf.interceptor.ServiceInvokerInterceptor.handleMessage(ServiceInvokerInterceptor.java:107)
at org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:272)
at org.apache.cxf.transport.ChainInitiationObserver.onMessage(ChainInitiationObserver.java:121)
at org.apache.cxf.transport.http.AbstractHTTPDestination.invoke(AbstractHTTPDestination.java:249)
at org.jboss.wsf.stack.cxf.RequestHandlerImpl.handleHttpRequest(RequestHandlerImpl.java:97)
at org.jboss.wsf.stack.cxf.transport.ServletHelper.callRequestHandler(ServletHelper.java:131)
at org.jboss.wsf.stack.cxf.CXFServletExt.invoke(CXFServletExt.java:88)
at org.apache.cxf.transport.servlet.AbstractHTTPServlet.handleRequest(AbstractHTTPServlet.java:289)
at org.apache.cxf.transport.servlet.AbstractHTTPServlet.doPost(AbstractHTTPServlet.java:209)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:754) [jboss-servlet-api_3.0_spec-1.0.2.Final-redhat-2.jar:1.0.2.Final-redhat-2]
at org.jboss.wsf.stack.cxf.CXFServletExt.service(CXFServletExt.java:136)
at org.jboss.wsf.spi.deployment.WSFServlet.service(WSFServlet.java:140) [jbossws-spi-2.3.1.Final-redhat-1.jar:2.3.1.Final-redhat-1]
at javax.servlet.http.HttpServlet.service(HttpServlet.java:847) [jboss-servlet-api_3.0_spec-1.0.2.Final-redhat-2.jar:1.0.2.Final-redhat-2]
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:295) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:214) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:231) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:149) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:512) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
at org.jboss.as.web.security.SecurityContextAssociationValve.invoke(SecurityContextAssociationValve.java:169) [jboss-as-web-7.5.12.Final-redhat-1.jar:7.5.12.Final-redhat-1]
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:150) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:97) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:102) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:344) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:854) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.process(Http11Protocol.java:656) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
at org.apache.tomcat.util.net.JIoEndpoint$Worker.run(JIoEndpoint.java:926) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
at java.lang.Thread.run(Thread.java:745) [rt.jar:1.8.0_102]
Caused by: com.arjuna.wst.SystemException: java.lang.NullPointerException
at com.arjuna.mwlabs.wst11.at.remote.TransactionManagerImple.registerParticipant(TransactionManagerImple.java:177) [jbossxts-4.17.38.Final-redhat-1.jar:4.17.38.Final-redhat-1]
at com.arjuna.mwlabs.wst11.at.remote.TransactionManagerImple.enlistForDurableTwoPhase(TransactionManagerImple.java:41) [jbossxts-4.17.38.Final-redhat-1.jar:4.17.38.Final-redhat-1]
at org.jboss.as.quickstarts.wsat.simple.RestaurantServiceATImpl.makeBooking(RestaurantServiceATImpl.java:74) [classes:]
... 58 more
{code}
The goal of this enhancement is to provide such logging on places where exception stacktrace is currently thrown away (not written to log).
> Narayana should not hide exception traces even for internal or protocol errors in WS txn
> ----------------------------------------------------------------------------------------
>
> Key: JBTM-2883
> URL: https://issues.jboss.org/browse/JBTM-2883
> Project: JBoss Transaction Manager
> Issue Type: Enhancement
> Components: XTS
> Affects Versions: 5.5.6.Final
> Reporter: Ondra Chaloupka
> Assignee: Ondra Chaloupka
>
> Narayana hides stacktraces of exception when some internal error (e.g. protocol, communication...) happens in XTS. This particular problem reveales in case of customer case https://access.redhat.com/support/cases/#/case/01810386 where .NET application communicates with JBoss EAP over WS and WS-AT should be used. .NET (probably) uses non-standard header/message that caused Narayana response being null.
> The original error info was only
> {code}
> ERROR [org.jboss.jbossts.txbridge] (http-/0.0.0.0:8543-1) com.arjuna.wst.SystemException: java.lang.NullPointerException
> TRACE [org.jboss.jbossts.txbridge] (http-/0.0.0.0:8543-1) JaxWSTxInboundBridgeHandler.close()
> INFO [org.apache.cxf.services.IntegrationFrameworkServiceWsService.IntegrationFrameworkServiceWsPort.IntegrationFrameworkServiceWs] (http-/0.0.0.0:8543-1) Outbound Message
> {code}
> which is quite not much to start tracking reason behind the problem.
> There should be shown stacktrace in log to get more detailed information for investigation to start. E.g. it should be something like
> {code}
> 09:21:36,155 ERROR [stderr] (http-0.0.0.0:8443-1) RICKY: response=null
> 09:21:36,156 ERROR [stderr] (http-0.0.0.0:8443-1) java.lang.NullPointerException
> 09:21:36,156 ERROR [stderr] (http-0.0.0.0:8443-1) at com.arjuna.wsc11.RegistrationCoordinator.register(RegistrationCoordinator.java:58)
> 09:21:36,156 ERROR [stderr] (http-0.0.0.0:8443-1) at com.arjuna.mwlabs.wst11.at.remote.TransactionManagerImple.registerParticipant(TransactionManagerImple.java:156)
> 09:21:36,156 ERROR [stderr] (http-0.0.0.0:8443-1) at com.arjuna.mwlabs.wst11.at.remote.TransactionManagerImple.enlistForDurableTwoPhase(TransactionManagerImple.java:41)
> 09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.quickstarts.wsat.simple.RestaurantServiceATImpl.makeBooking(RestaurantServiceATImpl.java:74)
> 09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> 09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
> 09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> 09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at java.lang.reflect.Method.invoke(Method.java:498)
> 09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.ee.component.ManagedReferenceMethodInterceptor.processInvocation(ManagedReferenceMethodInterceptor.java:52)
> 09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
> 09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53)
> 09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:63)
> 09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
> 09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53)
> 09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:63)
> 09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
> 09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.InitialInterceptor.processInvocation(InitialInterceptor.java:21)
> 09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
> 09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61)
> 09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.ee.component.interceptors.ComponentDispatcherInterceptor.processInvocation(ComponentDispatcherInterceptor.java:53)
> 09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
> 09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.webservices.deployers.WSComponentInstanceAssociationInterceptor.processInvocation(WSComponentInstanceAssociationInterceptor.java:49)
> 09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
> 09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61)
> 09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.ee.component.ViewService$View.invoke(ViewService.java:189)
> 09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.webservices.invocation.AbstractInvocationHandler.invoke(AbstractInvocationHandler.java:129)
> 09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.wsf.stack.cxf.JBossWSInvoker.performInvocation(JBossWSInvoker.java:177)
> 09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.service.invoker.AbstractInvoker.invoke(AbstractInvoker.java:104)
> 09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.jaxws.AbstractJAXWSMethodInvoker.invoke(AbstractJAXWSMethodInvoker.java:237)
> 09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.jaxws.JAXWSMethodInvoker.invoke(JAXWSMethodInvoker.java:69)
> 09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.wsf.stack.cxf.JBossWSInvoker.invoke(JBossWSInvoker.java:146)
> 09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.interceptor.ServiceInvokerInterceptor$1.run(ServiceInvokerInterceptor.java:58)
> 09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
> 09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at java.util.concurrent.FutureTask.run(FutureTask.java:266)
> 09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.workqueue.SynchronousExecutor.execute(SynchronousExecutor.java:37)
> 09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.interceptor.ServiceInvokerInterceptor.handleMessage(ServiceInvokerInterceptor.java:107)
> 09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:272)
> 09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.transport.ChainInitiationObserver.onMessage(ChainInitiationObserver.java:121)
> 09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.transport.http.AbstractHTTPDestination.invoke(AbstractHTTPDestination.java:249)
> 09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.wsf.stack.cxf.RequestHandlerImpl.handleHttpRequest(RequestHandlerImpl.java:97)
> 09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.wsf.stack.cxf.transport.ServletHelper.callRequestHandler(ServletHelper.java:131)
> 09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.wsf.stack.cxf.CXFServletExt.invoke(CXFServletExt.java:88)
> 09:21:36,160 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.transport.servlet.AbstractHTTPServlet.handleRequest(AbstractHTTPServlet.java:289)
> 09:21:36,160 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.transport.servlet.AbstractHTTPServlet.doPost(AbstractHTTPServlet.java:209)
> 09:21:36,160 ERROR [stderr] (http-0.0.0.0:8443-1) at javax.servlet.http.HttpServlet.service(HttpServlet.java:754)
> 09:21:36,160 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.wsf.stack.cxf.CXFServletExt.service(CXFServletExt.java:136)
> 09:21:36,160 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.wsf.spi.deployment.WSFServlet.service(WSFServlet.java:140)
> 09:21:36,164 ERROR [stderr] (http-0.0.0.0:8443-1) at javax.servlet.http.HttpServlet.service(HttpServlet.java:847)
> 09:21:36,164 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:295)
> 09:21:36,164 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:214)
> 09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:231)
> 09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:149)
> 09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:512)
> 09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.web.security.SecurityContextAssociationValve.invoke(SecurityContextAssociationValve.java:169)
> 09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:150)
> 09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:97)
> 09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:102)
> 09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:344)
> 09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:854)
> 09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.process(Http11Protocol.java:656)
> 09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.tomcat.util.net.JIoEndpoint$Worker.run(JIoEndpoint.java:926)
> 09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at java.lang.Thread.run(Thread.java:745)
> 09:21:36,167 ERROR [org.jboss.as.webservices.invocation.InvocationHandlerJAXWS] (http-0.0.0.0:8443-1) JBAS015594: Method invocation failed with exception: Error when enlisting participant: org.jboss.as.quickstarts.wsat.simple.RestaurantException: Error when enlisting participant
> at org.jboss.as.quickstarts.wsat.simple.RestaurantServiceATImpl.makeBooking(RestaurantServiceATImpl.java:76) [classes:]
> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.8.0_102]
> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [rt.jar:1.8.0_102]
> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.8.0_102]
> at java.lang.reflect.Method.invoke(Method.java:498) [rt.jar:1.8.0_102]
> at org.jboss.as.ee.component.ManagedReferenceMethodInterceptor.processInvocation(ManagedReferenceMethodInterceptor.java:52) [jboss-as-ee-7.5.12.Final-redhat-1.jar:7.5.12.Final-redhat-1]
> at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
> at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
> at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:63) [jboss-as-ee-7.5.12.Final-redhat-1.jar:7.5.12.Final-redhat-1]
> at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
> at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
> at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:63) [jboss-as-ee-7.5.12.Final-redhat-1.jar:7.5.12.Final-redhat-1]
> at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
> at org.jboss.invocation.InitialInterceptor.processInvocation(InitialInterceptor.java:21) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
> at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
> at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
> at org.jboss.as.ee.component.interceptors.ComponentDispatcherInterceptor.processInvocation(ComponentDispatcherInterceptor.java:53) [jboss-as-ee-7.5.12.Final-redhat-1.jar:7.5.12.Final-redhat-1]
> at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.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.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
> at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
> at org.jboss.as.ee.component.ViewService$View.invoke(ViewService.java:189) [jboss-as-ee-7.5.12.Final-redhat-1.jar:7.5.12.Final-redhat-1]
> at org.jboss.as.webservices.invocation.AbstractInvocationHandler.invoke(AbstractInvocationHandler.java:129)
> at org.jboss.wsf.stack.cxf.JBossWSInvoker.performInvocation(JBossWSInvoker.java:177)
> at org.apache.cxf.service.invoker.AbstractInvoker.invoke(AbstractInvoker.java:104)
> at org.apache.cxf.jaxws.AbstractJAXWSMethodInvoker.invoke(AbstractJAXWSMethodInvoker.java:237)
> at org.apache.cxf.jaxws.JAXWSMethodInvoker.invoke(JAXWSMethodInvoker.java:69)
> at org.jboss.wsf.stack.cxf.JBossWSInvoker.invoke(JBossWSInvoker.java:146)
> at org.apache.cxf.interceptor.ServiceInvokerInterceptor$1.run(ServiceInvokerInterceptor.java:58)
> at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [rt.jar:1.8.0_102]
> at java.util.concurrent.FutureTask.run(FutureTask.java:266) [rt.jar:1.8.0_102]
> at org.apache.cxf.workqueue.SynchronousExecutor.execute(SynchronousExecutor.java:37)
> at org.apache.cxf.interceptor.ServiceInvokerInterceptor.handleMessage(ServiceInvokerInterceptor.java:107)
> at org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:272)
> at org.apache.cxf.transport.ChainInitiationObserver.onMessage(ChainInitiationObserver.java:121)
> at org.apache.cxf.transport.http.AbstractHTTPDestination.invoke(AbstractHTTPDestination.java:249)
> at org.jboss.wsf.stack.cxf.RequestHandlerImpl.handleHttpRequest(RequestHandlerImpl.java:97)
> at org.jboss.wsf.stack.cxf.transport.ServletHelper.callRequestHandler(ServletHelper.java:131)
> at org.jboss.wsf.stack.cxf.CXFServletExt.invoke(CXFServletExt.java:88)
> at org.apache.cxf.transport.servlet.AbstractHTTPServlet.handleRequest(AbstractHTTPServlet.java:289)
> at org.apache.cxf.transport.servlet.AbstractHTTPServlet.doPost(AbstractHTTPServlet.java:209)
> at javax.servlet.http.HttpServlet.service(HttpServlet.java:754) [jboss-servlet-api_3.0_spec-1.0.2.Final-redhat-2.jar:1.0.2.Final-redhat-2]
> at org.jboss.wsf.stack.cxf.CXFServletExt.service(CXFServletExt.java:136)
> at org.jboss.wsf.spi.deployment.WSFServlet.service(WSFServlet.java:140) [jbossws-spi-2.3.1.Final-redhat-1.jar:2.3.1.Final-redhat-1]
> at javax.servlet.http.HttpServlet.service(HttpServlet.java:847) [jboss-servlet-api_3.0_spec-1.0.2.Final-redhat-2.jar:1.0.2.Final-redhat-2]
> at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:295) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
> at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:214) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
> at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:231) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
> at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:149) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
> at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:512) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
> at org.jboss.as.web.security.SecurityContextAssociationValve.invoke(SecurityContextAssociationValve.java:169) [jboss-as-web-7.5.12.Final-redhat-1.jar:7.5.12.Final-redhat-1]
> at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:150) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
> at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:97) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
> at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:102) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
> at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:344) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
> at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:854) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
> at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.process(Http11Protocol.java:656) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
> at org.apache.tomcat.util.net.JIoEndpoint$Worker.run(JIoEndpoint.java:926) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
> at java.lang.Thread.run(Thread.java:745) [rt.jar:1.8.0_102]
> Caused by: com.arjuna.wst.SystemException: java.lang.NullPointerException
> at com.arjuna.mwlabs.wst11.at.remote.TransactionManagerImple.registerParticipant(TransactionManagerImple.java:177) [jbossxts-4.17.38.Final-redhat-1.jar:4.17.38.Final-redhat-1]
> at com.arjuna.mwlabs.wst11.at.remote.TransactionManagerImple.enlistForDurableTwoPhase(TransactionManagerImple.java:41) [jbossxts-4.17.38.Final-redhat-1.jar:4.17.38.Final-redhat-1]
> at org.jboss.as.quickstarts.wsat.simple.RestaurantServiceATImpl.makeBooking(RestaurantServiceATImpl.java:74) [classes:]
> ... 58 more
> {code}
> The goal of this enhancement is to provide such logging on places where exception stacktrace is currently thrown away (not written to log).
--
This message was sent by Atlassian JIRA
(v7.2.3#72005)
7 years, 8 months
[JBoss JIRA] (JBTM-2883) Narayana should not hide exception traces even for internal or protocol errors in WS txn
by Ondra Chaloupka (JIRA)
[ https://issues.jboss.org/browse/JBTM-2883?page=com.atlassian.jira.plugin.... ]
Ondra Chaloupka updated JBTM-2883:
----------------------------------
Description:
Narayana hides stacktraces of exception when some internal error (e.g. protocol, communication...) happens in XTS. This particular problem reveales in case of customer case https://access.redhat.com/support/cases/#/case/01810386 where .NET application communicates with JBoss EAP over WS and WS-AT should be used. .NET (probably) uses non-standard header/message that caused Narayana response being null.
The original error info was only
{code}
17:43:33,846 ERROR [org.jboss.jbossts.txbridge] (http-/0.0.0.0:8543-1) com.arjuna.wst.SystemException: java.lang.NullPointerException17:43:33,852 TRACE [org.jboss.jbossts.txbridge] (http-/0.0.0.0:8543-1) JaxWSTxInboundBridgeHandler.close()17:43:33,854 INFO [org.apache.cxf.services.IntegrationFrameworkServiceWsService.IntegrationFrameworkServiceWsPort.IntegrationFrameworkServiceWs] (http-/0.0.0.0:8543-1) Outbound Message
{code}
which is quite not much to start tracking reason behind the problem.
There should be shown stacktrace in log to get more detailed information for investigation to start. E.g. it should be something like
{code}
09:21:36,155 ERROR [stderr] (http-0.0.0.0:8443-1) RICKY: response=null
09:21:36,156 ERROR [stderr] (http-0.0.0.0:8443-1) java.lang.NullPointerException
09:21:36,156 ERROR [stderr] (http-0.0.0.0:8443-1) at com.arjuna.wsc11.RegistrationCoordinator.register(RegistrationCoordinator.java:58)
09:21:36,156 ERROR [stderr] (http-0.0.0.0:8443-1) at com.arjuna.mwlabs.wst11.at.remote.TransactionManagerImple.registerParticipant(TransactionManagerImple.java:156)
09:21:36,156 ERROR [stderr] (http-0.0.0.0:8443-1) at com.arjuna.mwlabs.wst11.at.remote.TransactionManagerImple.enlistForDurableTwoPhase(TransactionManagerImple.java:41)
09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.quickstarts.wsat.simple.RestaurantServiceATImpl.makeBooking(RestaurantServiceATImpl.java:74)
09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at java.lang.reflect.Method.invoke(Method.java:498)
09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.ee.component.ManagedReferenceMethodInterceptor.processInvocation(ManagedReferenceMethodInterceptor.java:52)
09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53)
09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:63)
09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53)
09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:63)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.InitialInterceptor.processInvocation(InitialInterceptor.java:21)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.ee.component.interceptors.ComponentDispatcherInterceptor.processInvocation(ComponentDispatcherInterceptor.java:53)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.webservices.deployers.WSComponentInstanceAssociationInterceptor.processInvocation(WSComponentInstanceAssociationInterceptor.java:49)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.ee.component.ViewService$View.invoke(ViewService.java:189)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.webservices.invocation.AbstractInvocationHandler.invoke(AbstractInvocationHandler.java:129)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.wsf.stack.cxf.JBossWSInvoker.performInvocation(JBossWSInvoker.java:177)
09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.service.invoker.AbstractInvoker.invoke(AbstractInvoker.java:104)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.jaxws.AbstractJAXWSMethodInvoker.invoke(AbstractJAXWSMethodInvoker.java:237)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.jaxws.JAXWSMethodInvoker.invoke(JAXWSMethodInvoker.java:69)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.wsf.stack.cxf.JBossWSInvoker.invoke(JBossWSInvoker.java:146)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.interceptor.ServiceInvokerInterceptor$1.run(ServiceInvokerInterceptor.java:58)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at java.util.concurrent.FutureTask.run(FutureTask.java:266)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.workqueue.SynchronousExecutor.execute(SynchronousExecutor.java:37)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.interceptor.ServiceInvokerInterceptor.handleMessage(ServiceInvokerInterceptor.java:107)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:272)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.transport.ChainInitiationObserver.onMessage(ChainInitiationObserver.java:121)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.transport.http.AbstractHTTPDestination.invoke(AbstractHTTPDestination.java:249)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.wsf.stack.cxf.RequestHandlerImpl.handleHttpRequest(RequestHandlerImpl.java:97)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.wsf.stack.cxf.transport.ServletHelper.callRequestHandler(ServletHelper.java:131)
09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.wsf.stack.cxf.CXFServletExt.invoke(CXFServletExt.java:88)
09:21:36,160 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.transport.servlet.AbstractHTTPServlet.handleRequest(AbstractHTTPServlet.java:289)
09:21:36,160 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.transport.servlet.AbstractHTTPServlet.doPost(AbstractHTTPServlet.java:209)
09:21:36,160 ERROR [stderr] (http-0.0.0.0:8443-1) at javax.servlet.http.HttpServlet.service(HttpServlet.java:754)
09:21:36,160 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.wsf.stack.cxf.CXFServletExt.service(CXFServletExt.java:136)
09:21:36,160 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.wsf.spi.deployment.WSFServlet.service(WSFServlet.java:140)
09:21:36,164 ERROR [stderr] (http-0.0.0.0:8443-1) at javax.servlet.http.HttpServlet.service(HttpServlet.java:847)
09:21:36,164 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:295)
09:21:36,164 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:214)
09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:231)
09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:149)
09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:512)
09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.web.security.SecurityContextAssociationValve.invoke(SecurityContextAssociationValve.java:169)
09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:150)
09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:97)
09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:102)
09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:344)
09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:854)
09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.process(Http11Protocol.java:656)
09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.tomcat.util.net.JIoEndpoint$Worker.run(JIoEndpoint.java:926)
09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at java.lang.Thread.run(Thread.java:745)
09:21:36,167 ERROR [org.jboss.as.webservices.invocation.InvocationHandlerJAXWS] (http-0.0.0.0:8443-1) JBAS015594: Method invocation failed with exception: Error when enlisting participant: org.jboss.as.quickstarts.wsat.simple.RestaurantException: Error when enlisting participant
at org.jboss.as.quickstarts.wsat.simple.RestaurantServiceATImpl.makeBooking(RestaurantServiceATImpl.java:76) [classes:]
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.8.0_102]
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [rt.jar:1.8.0_102]
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.8.0_102]
at java.lang.reflect.Method.invoke(Method.java:498) [rt.jar:1.8.0_102]
at org.jboss.as.ee.component.ManagedReferenceMethodInterceptor.processInvocation(ManagedReferenceMethodInterceptor.java:52) [jboss-as-ee-7.5.12.Final-redhat-1.jar:7.5.12.Final-redhat-1]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:63) [jboss-as-ee-7.5.12.Final-redhat-1.jar:7.5.12.Final-redhat-1]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:63) [jboss-as-ee-7.5.12.Final-redhat-1.jar:7.5.12.Final-redhat-1]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
at org.jboss.invocation.InitialInterceptor.processInvocation(InitialInterceptor.java:21) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
at org.jboss.as.ee.component.interceptors.ComponentDispatcherInterceptor.processInvocation(ComponentDispatcherInterceptor.java:53) [jboss-as-ee-7.5.12.Final-redhat-1.jar:7.5.12.Final-redhat-1]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.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.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
at org.jboss.as.ee.component.ViewService$View.invoke(ViewService.java:189) [jboss-as-ee-7.5.12.Final-redhat-1.jar:7.5.12.Final-redhat-1]
at org.jboss.as.webservices.invocation.AbstractInvocationHandler.invoke(AbstractInvocationHandler.java:129)
at org.jboss.wsf.stack.cxf.JBossWSInvoker.performInvocation(JBossWSInvoker.java:177)
at org.apache.cxf.service.invoker.AbstractInvoker.invoke(AbstractInvoker.java:104)
at org.apache.cxf.jaxws.AbstractJAXWSMethodInvoker.invoke(AbstractJAXWSMethodInvoker.java:237)
at org.apache.cxf.jaxws.JAXWSMethodInvoker.invoke(JAXWSMethodInvoker.java:69)
at org.jboss.wsf.stack.cxf.JBossWSInvoker.invoke(JBossWSInvoker.java:146)
at org.apache.cxf.interceptor.ServiceInvokerInterceptor$1.run(ServiceInvokerInterceptor.java:58)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [rt.jar:1.8.0_102]
at java.util.concurrent.FutureTask.run(FutureTask.java:266) [rt.jar:1.8.0_102]
at org.apache.cxf.workqueue.SynchronousExecutor.execute(SynchronousExecutor.java:37)
at org.apache.cxf.interceptor.ServiceInvokerInterceptor.handleMessage(ServiceInvokerInterceptor.java:107)
at org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:272)
at org.apache.cxf.transport.ChainInitiationObserver.onMessage(ChainInitiationObserver.java:121)
at org.apache.cxf.transport.http.AbstractHTTPDestination.invoke(AbstractHTTPDestination.java:249)
at org.jboss.wsf.stack.cxf.RequestHandlerImpl.handleHttpRequest(RequestHandlerImpl.java:97)
at org.jboss.wsf.stack.cxf.transport.ServletHelper.callRequestHandler(ServletHelper.java:131)
at org.jboss.wsf.stack.cxf.CXFServletExt.invoke(CXFServletExt.java:88)
at org.apache.cxf.transport.servlet.AbstractHTTPServlet.handleRequest(AbstractHTTPServlet.java:289)
at org.apache.cxf.transport.servlet.AbstractHTTPServlet.doPost(AbstractHTTPServlet.java:209)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:754) [jboss-servlet-api_3.0_spec-1.0.2.Final-redhat-2.jar:1.0.2.Final-redhat-2]
at org.jboss.wsf.stack.cxf.CXFServletExt.service(CXFServletExt.java:136)
at org.jboss.wsf.spi.deployment.WSFServlet.service(WSFServlet.java:140) [jbossws-spi-2.3.1.Final-redhat-1.jar:2.3.1.Final-redhat-1]
at javax.servlet.http.HttpServlet.service(HttpServlet.java:847) [jboss-servlet-api_3.0_spec-1.0.2.Final-redhat-2.jar:1.0.2.Final-redhat-2]
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:295) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:214) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:231) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:149) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:512) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
at org.jboss.as.web.security.SecurityContextAssociationValve.invoke(SecurityContextAssociationValve.java:169) [jboss-as-web-7.5.12.Final-redhat-1.jar:7.5.12.Final-redhat-1]
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:150) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:97) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:102) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:344) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:854) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.process(Http11Protocol.java:656) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
at org.apache.tomcat.util.net.JIoEndpoint$Worker.run(JIoEndpoint.java:926) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
at java.lang.Thread.run(Thread.java:745) [rt.jar:1.8.0_102]
Caused by: com.arjuna.wst.SystemException: java.lang.NullPointerException
at com.arjuna.mwlabs.wst11.at.remote.TransactionManagerImple.registerParticipant(TransactionManagerImple.java:177) [jbossxts-4.17.38.Final-redhat-1.jar:4.17.38.Final-redhat-1]
at com.arjuna.mwlabs.wst11.at.remote.TransactionManagerImple.enlistForDurableTwoPhase(TransactionManagerImple.java:41) [jbossxts-4.17.38.Final-redhat-1.jar:4.17.38.Final-redhat-1]
at org.jboss.as.quickstarts.wsat.simple.RestaurantServiceATImpl.makeBooking(RestaurantServiceATImpl.java:74) [classes:]
... 58 more
{code}
The goal of this enhancement is to provide such logging on places where exception stacktrace is currently thrown away (not written to log).
was:
Narayana hides stacktraces of exception when some internal error (e.g. protocol, communication...) happens in XTS. This particular problem reveales in case of customer case https://access.redhat.com/support/cases/#/case/01810386 where .NET application communicates with JBoss EAP over WS and WS-AT should be used. .NET (probably) uses non-standard header/message that caused Narayana response being null.
The original error info was only
{code}
17:43:33,846 ERROR [org.jboss.jbossts.txbridge] (http-/0.0.0.0:8543-1) com.arjuna.wst.SystemException: java.lang.NullPointerException17:43:33,852 TRACE [org.jboss.jbossts.txbridge] (http-/0.0.0.0:8543-1) JaxWSTxInboundBridgeHandler.close()17:43:33,854 INFO [org.apache.cxf.services.IntegrationFrameworkServiceWsService.IntegrationFrameworkServiceWsPort.IntegrationFrameworkServiceWs] (http-/0.0.0.0:8543-1) Outbound Message
{code}
which is quite not much to start tracking reason behind the problem.
There should be shown stacktrace in log to get more detailed information for investigation to start. E.g. it should be something like
{code}
{code}
The goal of this enhancement is to provide such logging on places where exception stacktrace is currently thrown away (not written to log).
> Narayana should not hide exception traces even for internal or protocol errors in WS txn
> ----------------------------------------------------------------------------------------
>
> Key: JBTM-2883
> URL: https://issues.jboss.org/browse/JBTM-2883
> Project: JBoss Transaction Manager
> Issue Type: Enhancement
> Components: XTS
> Affects Versions: 5.5.6.Final
> Reporter: Ondra Chaloupka
> Assignee: Ondra Chaloupka
>
> Narayana hides stacktraces of exception when some internal error (e.g. protocol, communication...) happens in XTS. This particular problem reveales in case of customer case https://access.redhat.com/support/cases/#/case/01810386 where .NET application communicates with JBoss EAP over WS and WS-AT should be used. .NET (probably) uses non-standard header/message that caused Narayana response being null.
> The original error info was only
> {code}
> 17:43:33,846 ERROR [org.jboss.jbossts.txbridge] (http-/0.0.0.0:8543-1) com.arjuna.wst.SystemException: java.lang.NullPointerException17:43:33,852 TRACE [org.jboss.jbossts.txbridge] (http-/0.0.0.0:8543-1) JaxWSTxInboundBridgeHandler.close()17:43:33,854 INFO [org.apache.cxf.services.IntegrationFrameworkServiceWsService.IntegrationFrameworkServiceWsPort.IntegrationFrameworkServiceWs] (http-/0.0.0.0:8543-1) Outbound Message
> {code}
> which is quite not much to start tracking reason behind the problem.
> There should be shown stacktrace in log to get more detailed information for investigation to start. E.g. it should be something like
> {code}
> 09:21:36,155 ERROR [stderr] (http-0.0.0.0:8443-1) RICKY: response=null
> 09:21:36,156 ERROR [stderr] (http-0.0.0.0:8443-1) java.lang.NullPointerException
> 09:21:36,156 ERROR [stderr] (http-0.0.0.0:8443-1) at com.arjuna.wsc11.RegistrationCoordinator.register(RegistrationCoordinator.java:58)
> 09:21:36,156 ERROR [stderr] (http-0.0.0.0:8443-1) at com.arjuna.mwlabs.wst11.at.remote.TransactionManagerImple.registerParticipant(TransactionManagerImple.java:156)
> 09:21:36,156 ERROR [stderr] (http-0.0.0.0:8443-1) at com.arjuna.mwlabs.wst11.at.remote.TransactionManagerImple.enlistForDurableTwoPhase(TransactionManagerImple.java:41)
> 09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.quickstarts.wsat.simple.RestaurantServiceATImpl.makeBooking(RestaurantServiceATImpl.java:74)
> 09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> 09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
> 09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> 09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at java.lang.reflect.Method.invoke(Method.java:498)
> 09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.ee.component.ManagedReferenceMethodInterceptor.processInvocation(ManagedReferenceMethodInterceptor.java:52)
> 09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
> 09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53)
> 09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:63)
> 09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
> 09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53)
> 09:21:36,157 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:63)
> 09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
> 09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.InitialInterceptor.processInvocation(InitialInterceptor.java:21)
> 09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
> 09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61)
> 09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.ee.component.interceptors.ComponentDispatcherInterceptor.processInvocation(ComponentDispatcherInterceptor.java:53)
> 09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
> 09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.webservices.deployers.WSComponentInstanceAssociationInterceptor.processInvocation(WSComponentInstanceAssociationInterceptor.java:49)
> 09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288)
> 09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61)
> 09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.ee.component.ViewService$View.invoke(ViewService.java:189)
> 09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.webservices.invocation.AbstractInvocationHandler.invoke(AbstractInvocationHandler.java:129)
> 09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.wsf.stack.cxf.JBossWSInvoker.performInvocation(JBossWSInvoker.java:177)
> 09:21:36,158 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.service.invoker.AbstractInvoker.invoke(AbstractInvoker.java:104)
> 09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.jaxws.AbstractJAXWSMethodInvoker.invoke(AbstractJAXWSMethodInvoker.java:237)
> 09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.jaxws.JAXWSMethodInvoker.invoke(JAXWSMethodInvoker.java:69)
> 09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.wsf.stack.cxf.JBossWSInvoker.invoke(JBossWSInvoker.java:146)
> 09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.interceptor.ServiceInvokerInterceptor$1.run(ServiceInvokerInterceptor.java:58)
> 09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
> 09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at java.util.concurrent.FutureTask.run(FutureTask.java:266)
> 09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.workqueue.SynchronousExecutor.execute(SynchronousExecutor.java:37)
> 09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.interceptor.ServiceInvokerInterceptor.handleMessage(ServiceInvokerInterceptor.java:107)
> 09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:272)
> 09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.transport.ChainInitiationObserver.onMessage(ChainInitiationObserver.java:121)
> 09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.transport.http.AbstractHTTPDestination.invoke(AbstractHTTPDestination.java:249)
> 09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.wsf.stack.cxf.RequestHandlerImpl.handleHttpRequest(RequestHandlerImpl.java:97)
> 09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.wsf.stack.cxf.transport.ServletHelper.callRequestHandler(ServletHelper.java:131)
> 09:21:36,159 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.wsf.stack.cxf.CXFServletExt.invoke(CXFServletExt.java:88)
> 09:21:36,160 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.transport.servlet.AbstractHTTPServlet.handleRequest(AbstractHTTPServlet.java:289)
> 09:21:36,160 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.cxf.transport.servlet.AbstractHTTPServlet.doPost(AbstractHTTPServlet.java:209)
> 09:21:36,160 ERROR [stderr] (http-0.0.0.0:8443-1) at javax.servlet.http.HttpServlet.service(HttpServlet.java:754)
> 09:21:36,160 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.wsf.stack.cxf.CXFServletExt.service(CXFServletExt.java:136)
> 09:21:36,160 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.wsf.spi.deployment.WSFServlet.service(WSFServlet.java:140)
> 09:21:36,164 ERROR [stderr] (http-0.0.0.0:8443-1) at javax.servlet.http.HttpServlet.service(HttpServlet.java:847)
> 09:21:36,164 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:295)
> 09:21:36,164 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:214)
> 09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:231)
> 09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:149)
> 09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:512)
> 09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.jboss.as.web.security.SecurityContextAssociationValve.invoke(SecurityContextAssociationValve.java:169)
> 09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:150)
> 09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:97)
> 09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:102)
> 09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:344)
> 09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:854)
> 09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.process(Http11Protocol.java:656)
> 09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at org.apache.tomcat.util.net.JIoEndpoint$Worker.run(JIoEndpoint.java:926)
> 09:21:36,165 ERROR [stderr] (http-0.0.0.0:8443-1) at java.lang.Thread.run(Thread.java:745)
> 09:21:36,167 ERROR [org.jboss.as.webservices.invocation.InvocationHandlerJAXWS] (http-0.0.0.0:8443-1) JBAS015594: Method invocation failed with exception: Error when enlisting participant: org.jboss.as.quickstarts.wsat.simple.RestaurantException: Error when enlisting participant
> at org.jboss.as.quickstarts.wsat.simple.RestaurantServiceATImpl.makeBooking(RestaurantServiceATImpl.java:76) [classes:]
> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.8.0_102]
> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [rt.jar:1.8.0_102]
> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.8.0_102]
> at java.lang.reflect.Method.invoke(Method.java:498) [rt.jar:1.8.0_102]
> at org.jboss.as.ee.component.ManagedReferenceMethodInterceptor.processInvocation(ManagedReferenceMethodInterceptor.java:52) [jboss-as-ee-7.5.12.Final-redhat-1.jar:7.5.12.Final-redhat-1]
> at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
> at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
> at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:63) [jboss-as-ee-7.5.12.Final-redhat-1.jar:7.5.12.Final-redhat-1]
> at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
> at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
> at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:63) [jboss-as-ee-7.5.12.Final-redhat-1.jar:7.5.12.Final-redhat-1]
> at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
> at org.jboss.invocation.InitialInterceptor.processInvocation(InitialInterceptor.java:21) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
> at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
> at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
> at org.jboss.as.ee.component.interceptors.ComponentDispatcherInterceptor.processInvocation(ComponentDispatcherInterceptor.java:53) [jboss-as-ee-7.5.12.Final-redhat-1.jar:7.5.12.Final-redhat-1]
> at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.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.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
> at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.3.Final-redhat-1.jar:1.1.3.Final-redhat-1]
> at org.jboss.as.ee.component.ViewService$View.invoke(ViewService.java:189) [jboss-as-ee-7.5.12.Final-redhat-1.jar:7.5.12.Final-redhat-1]
> at org.jboss.as.webservices.invocation.AbstractInvocationHandler.invoke(AbstractInvocationHandler.java:129)
> at org.jboss.wsf.stack.cxf.JBossWSInvoker.performInvocation(JBossWSInvoker.java:177)
> at org.apache.cxf.service.invoker.AbstractInvoker.invoke(AbstractInvoker.java:104)
> at org.apache.cxf.jaxws.AbstractJAXWSMethodInvoker.invoke(AbstractJAXWSMethodInvoker.java:237)
> at org.apache.cxf.jaxws.JAXWSMethodInvoker.invoke(JAXWSMethodInvoker.java:69)
> at org.jboss.wsf.stack.cxf.JBossWSInvoker.invoke(JBossWSInvoker.java:146)
> at org.apache.cxf.interceptor.ServiceInvokerInterceptor$1.run(ServiceInvokerInterceptor.java:58)
> at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [rt.jar:1.8.0_102]
> at java.util.concurrent.FutureTask.run(FutureTask.java:266) [rt.jar:1.8.0_102]
> at org.apache.cxf.workqueue.SynchronousExecutor.execute(SynchronousExecutor.java:37)
> at org.apache.cxf.interceptor.ServiceInvokerInterceptor.handleMessage(ServiceInvokerInterceptor.java:107)
> at org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:272)
> at org.apache.cxf.transport.ChainInitiationObserver.onMessage(ChainInitiationObserver.java:121)
> at org.apache.cxf.transport.http.AbstractHTTPDestination.invoke(AbstractHTTPDestination.java:249)
> at org.jboss.wsf.stack.cxf.RequestHandlerImpl.handleHttpRequest(RequestHandlerImpl.java:97)
> at org.jboss.wsf.stack.cxf.transport.ServletHelper.callRequestHandler(ServletHelper.java:131)
> at org.jboss.wsf.stack.cxf.CXFServletExt.invoke(CXFServletExt.java:88)
> at org.apache.cxf.transport.servlet.AbstractHTTPServlet.handleRequest(AbstractHTTPServlet.java:289)
> at org.apache.cxf.transport.servlet.AbstractHTTPServlet.doPost(AbstractHTTPServlet.java:209)
> at javax.servlet.http.HttpServlet.service(HttpServlet.java:754) [jboss-servlet-api_3.0_spec-1.0.2.Final-redhat-2.jar:1.0.2.Final-redhat-2]
> at org.jboss.wsf.stack.cxf.CXFServletExt.service(CXFServletExt.java:136)
> at org.jboss.wsf.spi.deployment.WSFServlet.service(WSFServlet.java:140) [jbossws-spi-2.3.1.Final-redhat-1.jar:2.3.1.Final-redhat-1]
> at javax.servlet.http.HttpServlet.service(HttpServlet.java:847) [jboss-servlet-api_3.0_spec-1.0.2.Final-redhat-2.jar:1.0.2.Final-redhat-2]
> at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:295) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
> at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:214) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
> at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:231) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
> at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:149) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
> at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:512) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
> at org.jboss.as.web.security.SecurityContextAssociationValve.invoke(SecurityContextAssociationValve.java:169) [jboss-as-web-7.5.12.Final-redhat-1.jar:7.5.12.Final-redhat-1]
> at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:150) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
> at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:97) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
> at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:102) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
> at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:344) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
> at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:854) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
> at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.process(Http11Protocol.java:656) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
> at org.apache.tomcat.util.net.JIoEndpoint$Worker.run(JIoEndpoint.java:926) [jbossweb-7.5.19.Final-redhat-1.jar:7.5.19.Final-redhat-1]
> at java.lang.Thread.run(Thread.java:745) [rt.jar:1.8.0_102]
> Caused by: com.arjuna.wst.SystemException: java.lang.NullPointerException
> at com.arjuna.mwlabs.wst11.at.remote.TransactionManagerImple.registerParticipant(TransactionManagerImple.java:177) [jbossxts-4.17.38.Final-redhat-1.jar:4.17.38.Final-redhat-1]
> at com.arjuna.mwlabs.wst11.at.remote.TransactionManagerImple.enlistForDurableTwoPhase(TransactionManagerImple.java:41) [jbossxts-4.17.38.Final-redhat-1.jar:4.17.38.Final-redhat-1]
> at org.jboss.as.quickstarts.wsat.simple.RestaurantServiceATImpl.makeBooking(RestaurantServiceATImpl.java:74) [classes:]
> ... 58 more
> {code}
> The goal of this enhancement is to provide such logging on places where exception stacktrace is currently thrown away (not written to log).
--
This message was sent by Atlassian JIRA
(v7.2.3#72005)
7 years, 8 months
[JBoss JIRA] (JBTM-2883) Narayana should not hide exception traces even for internal or protocol errors in WS txn
by Ondra Chaloupka (JIRA)
Ondra Chaloupka created JBTM-2883:
-------------------------------------
Summary: Narayana should not hide exception traces even for internal or protocol errors in WS txn
Key: JBTM-2883
URL: https://issues.jboss.org/browse/JBTM-2883
Project: JBoss Transaction Manager
Issue Type: Enhancement
Components: XTS
Affects Versions: 5.5.6.Final
Reporter: Ondra Chaloupka
Assignee: Ondra Chaloupka
Narayana hides stacktraces of exception when some internal error (e.g. protocol, communication...) happens in XTS. This particular problem reveales in case of customer case https://access.redhat.com/support/cases/#/case/01810386 where .NET application communicates with JBoss EAP over WS and WS-AT should be used. .NET (probably) uses non-standard header/message that caused Narayana response being null.
The original error info was only
{code}
17:43:33,846 ERROR [org.jboss.jbossts.txbridge] (http-/0.0.0.0:8543-1) com.arjuna.wst.SystemException: java.lang.NullPointerException17:43:33,852 TRACE [org.jboss.jbossts.txbridge] (http-/0.0.0.0:8543-1) JaxWSTxInboundBridgeHandler.close()17:43:33,854 INFO [org.apache.cxf.services.IntegrationFrameworkServiceWsService.IntegrationFrameworkServiceWsPort.IntegrationFrameworkServiceWs] (http-/0.0.0.0:8543-1) Outbound Message
{code}
which is quite not much to start tracking reason behind the problem.
There should be shown stacktrace in log to get more detailed information for investigation to start. E.g. it should be something like
{code}
{code}
The goal of this enhancement is to provide such logging on places where exception stacktrace is currently thrown away (not written to log).
--
This message was sent by Atlassian JIRA
(v7.2.3#72005)
7 years, 8 months
[JBoss JIRA] (JBTM-2194) Activity cancelled by coordinator in CloseTest
by Ondra Chaloupka (JIRA)
[ https://issues.jboss.org/browse/JBTM-2194?page=com.atlassian.jira.plugin.... ]
Ondra Chaloupka commented on JBTM-2194:
---------------------------------------
[~gytis] I see, thank you for the clarification. I haven't understood that before. I'm going to leave it open for now and then we'll see.
> Activity cancelled by coordinator in CloseTest
> ----------------------------------------------
>
> Key: JBTM-2194
> URL: https://issues.jboss.org/browse/JBTM-2194
> Project: JBoss Transaction Manager
> Issue Type: Bug
> Components: XTS
> Reporter: Gytis Trikleris
> Assignee: Tom Jenkinson
> Fix For: 5.later
>
>
> {code}
> -------------------------------------------------------------------------------
> Test set: com.arjuna.wstx.tests.arq.ba.CloseTest
> -------------------------------------------------------------------------------
> Tests run: 1, Failures: 0, Errors: 1, Skipped: 0, Time elapsed: 5.866 sec <<< FAILURE!
> testClose(com.arjuna.wstx.tests.arq.ba.CloseTest) Time elapsed: 2.375 sec <<< ERROR!
> com.arjuna.wst.TransactionRolledBackException: null
> at com.arjuna.wst11.stub.BusinessActivityTerminatorStub.close(BusinessActivityTerminatorStub.java:95)
> at com.arjuna.mwlabs.wst11.ba.remote.UserBusinessActivityImple.close(UserBusinessActivityImple.java:157)
> at com.arjuna.wstx.tests.arq.ba.CloseTest.testClose(CloseTest.java:64)
> {code}
> {code}
> [0m18:45:37,613 INFO [org.jboss.as.repository] (management-handler-thread - 8) WFLYDR0001: Content added at location /home/hudson/workspace/narayana/PROFILE/XTS/jdk/jdk7.latest/label/linux/jboss-as/build/target/wildfly-9.0.0.Alpha1-SNAPSHOT/standalone/data/content/2a/0685005c0b26622b16a38150f088bad88f5ed8/content
> [0m[0m18:45:37,616 INFO [org.jboss.as.server.deployment] (MSC service thread 1-1) WFLYSRV0027: Starting deployment of "test.war" (runtime-name: "test.war")
> [0m[33m18:45:37,860 WARN [org.jboss.as.dependency.private] (MSC service thread 1-1) WFLYSRV0018: Deployment "deployment.test.war" is using a private module ("org.jboss.jts:main") which may be changed or removed in future versions without notice.
> [0m[0m18:45:37,927 INFO [org.jboss.weld.deployer] (MSC service thread 1-1) WFLYWELD0003: Processing weld deployment test.war
> [0m[0m18:45:37,941 INFO [org.jboss.weld.deployer] (MSC service thread 1-1) WFLYWELD0006: Starting Services for CDI deployment: test.war
> [0m[0m18:45:37,946 INFO [org.jboss.weld.deployer] (MSC service thread 1-2) WFLYWELD0009: Starting weld service for deployment test.war
> [0m[0m18:45:38,228 INFO [org.wildfly.extension.undertow] (MSC service thread 1-1) WFLYUT0021: Registered web context: /test
> [0m[0m18:45:38,406 INFO [org.jboss.as.server] (management-handler-thread - 8) WFLYSRV0010: Deployed "test.war" (runtime-name : "test.war")
> [0m[0m18:45:38,418 INFO [stdout] (Thread-0) TransformListener() : handling connection on port 9091
> [0m[0m18:45:38,492 INFO [stdout] (Thread-0) retransforming org.jboss.jbossts.xts.bytemanSupport.participantCompletion.ParticipantCompletionCoordinatorRules
> [0m[0m18:45:38,492 INFO [stdout] (Thread-0) retransforming com.arjuna.wst11.messaging.engines.ParticipantCompletionCoordinatorEngine
> [0m[0m18:45:38,493 INFO [stdout] (Thread-0) retransforming com.arjuna.webservices11.wsarjtx.sei.TerminationCoordinatorPortTypeImpl
> [0m[0m18:45:38,495 INFO [stdout] (Thread-0) org.jboss.byteman.agent.Transformer : possible trigger for rule create counter in class org.jboss.jbossts.xts.bytemanSupport.participantCompletion.ParticipantCompletionCoordinatorRules
> [0m[0m18:45:38,496 INFO [stdout] (Thread-0) RuleTriggerMethodAdapter.injectTriggerPoint : inserting trigger into org.jboss.jbossts.xts.bytemanSupport.participantCompletion.ParticipantCompletionCoordinatorRules.setParticipantCount(java.lang.Integer) void for rule create counter
> [0m[0m18:45:38,497 INFO [stdout] (Thread-0) org.jboss.byteman.agent.Transformer : inserted trigger for create counter in class org.jboss.jbossts.xts.bytemanSupport.participantCompletion.ParticipantCompletionCoordinatorRules
> [0m[0m18:45:38,514 INFO [stdout] (Thread-0) org.jboss.byteman.agent.Transformer : possible trigger for rule complete called in class com.arjuna.wst11.messaging.engines.ParticipantCompletionCoordinatorEngine
> [0m[0m18:45:38,517 INFO [stdout] (Thread-0) RuleTriggerMethodAdapter.injectTriggerPoint : inserting trigger into com.arjuna.wst11.messaging.engines.ParticipantCompletionCoordinatorEngine.completed(org.oasis_open.docs.ws_tx.wsba._2006._06.NotificationType,org.jboss.ws.api.addressing.MAP,com.arjuna.webservices11.wsarj.ArjunaContext) void for rule complete called
> [0m[0m18:45:38,536 INFO [stdout] (Thread-0) org.jboss.byteman.agent.Transformer : inserted trigger for complete called in class com.arjuna.wst11.messaging.engines.ParticipantCompletionCoordinatorEngine
> [0m[0m18:45:38,552 INFO [stdout] (Thread-0) org.jboss.byteman.agent.Transformer : possible trigger for rule cancel called in class com.arjuna.webservices11.wsarjtx.sei.TerminationCoordinatorPortTypeImpl
> [0m[0m18:45:38,554 INFO [stdout] (Thread-0) RuleTriggerMethodAdapter.injectTriggerPoint : inserting trigger into com.arjuna.webservices11.wsarjtx.sei.TerminationCoordinatorPortTypeImpl.cancelOperation(com.arjuna.schemas.ws._2005._10.wsarjtx.NotificationType) void for rule cancel called
> [0m[0m18:45:38,556 INFO [stdout] (Thread-0) org.jboss.byteman.agent.Transformer : inserted trigger for cancel called in class com.arjuna.webservices11.wsarjtx.sei.TerminationCoordinatorPortTypeImpl
> [0m[0m18:45:38,558 INFO [stdout] (Thread-0) org.jboss.byteman.agent.Transformer : possible trigger for rule close called in class com.arjuna.webservices11.wsarjtx.sei.TerminationCoordinatorPortTypeImpl
> [0m[0m18:45:38,559 INFO [stdout] (Thread-0) RuleTriggerMethodAdapter.injectTriggerPoint : inserting trigger into com.arjuna.webservices11.wsarjtx.sei.TerminationCoordinatorPortTypeImpl.closeOperation(com.arjuna.schemas.ws._2005._10.wsarjtx.NotificationType) void for rule close called
> [0m[0m18:45:38,560 INFO [stdout] (Thread-0) org.jboss.byteman.agent.Transformer : inserted trigger for close called in class com.arjuna.webservices11.wsarjtx.sei.TerminationCoordinatorPortTypeImpl
> [0m[0m18:45:39,123 INFO [stdout] (default task-16) Rule.execute called for create counter_3
> [0m[0m18:45:39,124 INFO [stdout] (default task-16) HelperManager.install for helper class org.jboss.byteman.rule.helper.Helper
> [0m[0m18:45:39,124 INFO [stdout] (default task-16) calling activated() for helper class org.jboss.byteman.rule.helper.Helper
> [0m[0m18:45:39,124 INFO [stdout] (default task-16) Default helper activated
> [0m[0m18:45:39,124 INFO [stdout] (default task-16) calling installed(create counter) for helper classorg.jboss.byteman.rule.helper.Helper
> [0m[0m18:45:39,125 INFO [stdout] (default task-16) Installed rule using default helper : create counter
> [0m[0m18:45:39,135 INFO [stdout] (default task-16) create counter execute
> [0m[0m18:45:39,135 INFO [stdout] (default task-16) rule.debug{create counter} : participant_completion.counter.create: 1
> [0m[0m18:45:39,158 INFO [org.apache.cxf.service.factory.ReflectionServiceFactoryBean] (default task-16) Creating Service {http://docs.oasis-open.org/ws-tx/wscoor/2006/06}ActivationService from WSDL: jar:file:/home/hudson/workspace/narayana/PROFILE/XTS/jdk/jdk7.latest/label/linux/jboss-as/build/target/wildfly-9.0.0.Alpha1-SNAPSHOT/modules/system/layers/base/org/jboss/xts/main/jbossxts-5.0.3.Final-SNAPSHOT.jar!/org/oasis_open/docs/ws_tx/wscoor/_2006/_06/wsdl/wscoor-activation-binding.wsdl
> [0m[0m18:45:39,205 INFO [org.apache.cxf.service.factory.ReflectionServiceFactoryBean] (default task-16) Creating Service {http://docs.oasis-open.org/ws-tx/wscoor/2006/06}ActivationService from WSDL: jar:file:/home/hudson/workspace/narayana/PROFILE/XTS/jdk/jdk7.latest/label/linux/jboss-as/build/target/wildfly-9.0.0.Alpha1-SNAPSHOT/modules/system/layers/base/org/jboss/xts/main/jbossxts-5.0.3.Final-SNAPSHOT.jar!/org/oasis_open/docs/ws_tx/wscoor/_2006/_06/wsdl/wscoor-activation-binding.wsdl
> [0m[0m18:45:39,282 INFO [org.apache.cxf.service.factory.ReflectionServiceFactoryBean] (default task-16) Creating Service {http://docs.oasis-open.org/ws-tx/wscoor/2006/06}RegistrationService from WSDL: jar:file:/home/hudson/workspace/narayana/PROFILE/XTS/jdk/jdk7.latest/label/linux/jboss-as/build/target/wildfly-9.0.0.Alpha1-SNAPSHOT/modules/system/layers/base/org/jboss/xts/main/jbossxts-5.0.3.Final-SNAPSHOT.jar!/org/oasis_open/docs/ws_tx/wscoor/_2006/_06/wsdl/wscoor-registration-binding.wsdl
> [0m[33m18:45:40,131 WARN [com.arjuna.wst] (default task-16) ARJUNA043225: Could not save recovery state for non-serializable WS-BA participant 1235
> [0m[0m18:45:40,188 INFO [org.apache.cxf.service.factory.ReflectionServiceFactoryBean] (default task-16) Creating Service {http://docs.oasis-open.org/ws-tx/wsba/2006/06}BusinessAgreementWithParticipantCompletionCoordinatorService from WSDL: jar:file:/home/hudson/workspace/narayana/PROFILE/XTS/jdk/jdk7.latest/label/linux/jboss-as/build/target/wildfly-9.0.0.Alpha1-SNAPSHOT/modules/system/layers/base/org/jboss/xts/main/jbossxts-5.0.3.Final-SNAPSHOT.jar!/org/oasis_open/docs/ws_tx/wsba/_2006/_06/wsdl/wsba-participant-completion-coordinator-binding.wsdl
> [0m[0m18:45:41,372 INFO [org.apache.cxf.service.factory.ReflectionServiceFactoryBean] (Timer-1) Creating Service {http://docs.oasis-open.org/ws-tx/wsba/2006/06}BusinessAgreementWithParticipantCompletionCoordinatorService from WSDL: jar:file:/home/hudson/workspace/narayana/PROFILE/XTS/jdk/jdk7.latest/label/linux/jboss-as/build/target/wildfly-9.0.0.Alpha1-SNAPSHOT/modules/system/layers/base/org/jboss/xts/main/jbossxts-5.0.3.Final-SNAPSHOT.jar!/org/oasis_open/docs/ws_tx/wsba/_2006/_06/wsdl/wsba-participant-completion-coordinator-binding.wsdl
> [0m[0m18:45:42,052 INFO [org.apache.cxf.service.factory.ReflectionServiceFactoryBean] (default task-16) Creating Service {http://docs.oasis-open.org/ws-tx/wscoor/2006/06}RegistrationService from WSDL: jar:file:/home/hudson/workspace/narayana/PROFILE/XTS/jdk/jdk7.latest/label/linux/jboss-as/build/target/wildfly-9.0.0.Alpha1-SNAPSHOT/modules/system/layers/base/org/jboss/xts/main/jbossxts-5.0.3.Final-SNAPSHOT.jar!/org/oasis_open/docs/ws_tx/wscoor/_2006/_06/wsdl/wscoor-registration-binding.wsdl
> [0m[0m18:45:42,090 INFO [org.apache.cxf.service.factory.ReflectionServiceFactoryBean] (default task-16) Creating Service {http://schemas.arjuna.com/ws/2005/10/wsarjtx}TerminationCoordinatorService from WSDL: jar:file:/home/hudson/workspace/narayana/PROFILE/XTS/jdk/jdk7.latest/label/linux/jboss-as/build/target/wildfly-9.0.0.Alpha1-SNAPSHOT/modules/system/layers/base/org/jboss/xts/main/jbossxts-5.0.3.Final-SNAPSHOT.jar!/com/arjuna/schemas/ws/_2005/_10/wsarjtx/wsdl/wsarjtx-termination-coordinator-binding.wsdl
> [0m[0m18:45:42,409 INFO [stdout] (default-workqueue-2) Rule.execute called for close called_6
> [0m[0m18:45:42,410 INFO [stdout] (default-workqueue-2) HelperManager.install for helper class org.jboss.byteman.rule.helper.Helper
> [0m[0m18:45:42,411 INFO [stdout] (default-workqueue-2) calling installed(close called) for helper classorg.jboss.byteman.rule.helper.Helper
> [0m[0m18:45:42,411 INFO [stdout] (default-workqueue-2) Installed rule using default helper : close called
> [0m[0m18:45:42,411 INFO [stdout] (default-workqueue-2) close called execute
> [0m[0m18:45:42,412 INFO [stdout] (default-workqueue-2) rule.debug{close called} : participant_completion.close.waiting
> [0m[0m18:45:42,412 INFO [stdout] (TaskWorker-2) Rule.execute called for complete called_4
> [0m[0m18:45:42,413 INFO [stdout] (TaskWorker-2) HelperManager.install for helper class org.jboss.byteman.rule.helper.Helper
> [0m[0m18:45:42,413 INFO [stdout] (TaskWorker-2) calling installed(complete called) for helper classorg.jboss.byteman.rule.helper.Helper
> [0m[0m18:45:42,413 INFO [stdout] (TaskWorker-2) Installed rule using default helper : complete called
> [0m[0m18:45:42,413 INFO [stdout] (TaskWorker-2) complete called execute
> [0m[0m18:45:42,414 INFO [stdout] (TaskWorker-2) rule.debug{complete called} : participant_completion.counter.decrement
> [0m[0m18:45:42,414 INFO [stdout] (TaskWorker-2) rule.debug{complete called} : participant_completion.called.waking
> [0m[0m18:45:42,414 INFO [stdout] (default-workqueue-2) rule.debug{close called} : participant_completion.close.woken
> [0m[0m18:45:42,415 INFO [stdout] (TaskWorker-2) rule.debug{complete called} : participant_completion.called.donewake
> [0m[33m18:45:42,415 WARN [com.arjuna.mw.wstx] (TaskWorker-2) ARJUNA045062: Coordinator cancelled the activity
> [0m[0m18:45:42,428 INFO [org.apache.cxf.service.factory.ReflectionServiceFactoryBean] (TaskWorker-2) Creating Service {http://schemas.arjuna.com/ws/2005/10/wsarjtx}TerminationParticipantService from WSDL: jar:file:/home/hudson/workspace/narayana/PROFILE/XTS/jdk/jdk7.latest/label/linux/jboss-as/build/target/wildfly-9.0.0.Alpha1-SNAPSHOT/modules/system/layers/base/org/jboss/xts/main/jbossxts-5.0.3.Final-SNAPSHOT.jar!/com/arjuna/schemas/ws/_2005/_10/wsarjtx/wsdl/wsarjtx-termination-participant-binding.wsdl
> [0m[0m18:45:42,439 INFO [stdout] (TaskWorker-1) Rule.execute called for complete called_4
> [0m[0m18:45:42,441 INFO [stdout] (TaskWorker-1) complete called execute
> [0m[0m18:45:42,496 INFO [stdout] (Thread-0) TransformListener() : handling connection on port 9091
> [0m[0m18:45:42,598 INFO [stdout] (Thread-0) retransforming org.jboss.jbossts.xts.bytemanSupport.participantCompletion.ParticipantCompletionCoordinatorRules
> [0m[0m18:45:42,599 INFO [stdout] (Thread-0) retransforming com.arjuna.wst11.messaging.engines.ParticipantCompletionCoordinatorEngine
> [0m[0m18:45:42,599 INFO [stdout] (Thread-0) retransforming com.arjuna.webservices11.wsarjtx.sei.TerminationCoordinatorPortTypeImpl
> [0m[0m18:45:42,815 INFO [stdout] (Thread-0) HelperManager.uninstall for helper class org.jboss.byteman.rule.helper.Helper
> [0m[0m18:45:42,816 INFO [stdout] (Thread-0) calling uninstalled(create counter) for helper class org.jboss.byteman.rule.helper.Helper
> [0m[0m18:45:42,816 INFO [stdout] (Thread-0) Uninstalled rule using default helper : create counter
> [0m[0m18:45:42,817 INFO [stdout] (Thread-0) HelperManager.uninstall for helper class org.jboss.byteman.rule.helper.Helper
> [0m[0m18:45:42,817 INFO [stdout] (Thread-0) calling uninstalled(complete called) for helper class org.jboss.byteman.rule.helper.Helper
> [0m[0m18:45:42,818 INFO [stdout] (Thread-0) Uninstalled rule using default helper : complete called
> [0m[0m18:45:42,818 INFO [stdout] (Thread-0) HelperManager.uninstall for helper class org.jboss.byteman.rule.helper.Helper
> [0m[0m18:45:42,819 INFO [stdout] (Thread-0) calling uninstalled(close called) for helper class org.jboss.byteman.rule.helper.Helper
> [0m[0m18:45:42,819 INFO [stdout] (Thread-0) Uninstalled rule using default helper : close called
> [0m[0m18:45:42,819 INFO [stdout] (Thread-0) calling deactivated() for helper classorg.jboss.byteman.rule.helper.Helper
> [0m[0m18:45:42,820 INFO [stdout] (Thread-0) Default helper deactivated
> [0m[0m18:45:42,830 INFO [org.wildfly.extension.undertow] (MSC service thread 1-1) WFLYUT0022: Unregistered web context: /test
> [0m[0m18:45:42,845 INFO [org.jboss.weld.deployer] (MSC service thread 1-1) WFLYWELD0010: Stopping weld service for deployment test.war
> [0m[0m18:45:42,855 INFO [org.jboss.as.server.deployment] (MSC service thread 1-1) WFLYSRV0028: Stopped deployment test.war (runtime-name: test.war) in 26ms
> [0m[0m18:45:42,942 INFO [org.jboss.as.repository] (management-handler-thread - 7) WFLYDR0002: Content removed from location /home/hudson/workspace/narayana/PROFILE/XTS/jdk/jdk7.latest/label/linux/jboss-as/build/target/wildfly-9.0.0.Alpha1-SNAPSHOT/standalone/data/content/2a/0685005c0b26622b16a38150f088bad88f5ed8/content
> [0m[0m18:45:42,942 INFO [org.jboss.as.server] (management-handler-thread - 7) WFLYSRV0009: Undeployed "test.war" (runtime-name: "test.war")
> [0m
> {code}
--
This message was sent by Atlassian JIRA
(v7.2.3#72005)
7 years, 8 months