/ Development  

Remote debugging an AWP stack trace

Hi there AppWorks fans,

Welcome to a new installment of AppWorks tips.

For this week (and the last one for this year), we have a high-valuable skill to share. It’s all about finding your way when things start to fail on the platform. This blog site already explained you about logfiles, log settings, and the PIM artifact. Only, when things really, really start to fail, and you end up with an unexplained stack trace in you logging, it’s time to debug the code…Line by line within the back of your mind the experience we have with the platform and the solution build on top of it. So, let’s start with a list of ingredients we need for this post:

  • Build an error scenario…an easy task…right? 😏
  • Throw your error (and monitor your logging on the stack trace)
  • Check the responsible class file and corresponding row number where it happens
  • Find the related JAR/Class file and save it locally
  • Place Tomcat in remote debug mode with JPDA
  • Create an empty Java/Maven project in IntelliJ
  • Add the JAR on the classpath of the project or as dependency in the pom.xml (with a system reference)
  • Open the class from the external libraries list (IntelliJ is smart enough to decompile it)
  • Place a ‘Method entry’ debug point on the related method call
  • Connect to the remote JVM from your IDE
  • Throw your error again and watch the magic passing by!

With all the ingredients in place, we can take off…


Let get right into it…

The first step is to start failing at something (and eventually learn from it)…We as low-code developers always create everything 100% in perfection (😇), but when end-users (or better…the test-team) starts to play with your crafted solution they always find something to break! For this post we want to break something, so it will deliver us a nice stack trace in the logfile of the AppWorks platform to continue playing with.

How hard can it be? Well, start your VM, login to your favorite organization with (in my case) the account awdev. Now open the artifact ‘iHub Connection Manager’ (just because we can) and click the test button:

debug_001

There you have it…You can find the stack trace for this error on the AWP server: sudo tail -999f /opt/opentext/AppWorksPlatform/defaultInst/Logs/Application_Server.xml.
It looks like this (cleaned from overhead information!) including the important ‘Caused by’ line:

1
2
3
4
5
6
7
8
9
10
11
12
13
14
15
16
17
18
19
20
21
22
23
24
25
26
27
28
29
30
31
32
33
34
35
36
37
38
39
<log4j:event logger="com.eibus.web.gateway.SOAPTransaction" timestamp="1666339772889" 
time="2022-10-21T10:09:32.889+02:00" level="ERROR" thread="http-nio-8080-exec-7">
<log4j:message><![CDATA[Error occurred: [com.eibus.exception.BusException: All the
service containers that respond to messages for 'iHub' in this JVM either stopped or never started.]]]></log4j:message>
<log4j:MDC><![CDATA[host=appworks processid=1446]]></log4j:MDC>
<log4j:throwable><![CDATA[com.eibus.exception.ExceptionGroup:
[com.eibus.exception.BusException: All the service containers that respond to messages
for 'iHub' in this JVM either stopped or never started.]
at com.eibus.transport.Middleware.lambda$sendMessageToRegisteredTargetOrThrowException$5(Middleware.java:928)
at java.base/java.util.Optional.orElseThrow(Optional.java:408)
at com.eibus.transport.Middleware.sendMessageToRegisteredTargetOrThrowException(Middleware.java:928)
...
Caused by: com.eibus.exception.BusException: All the service containers that respond
to messages for 'iHub' in this JVM either stopped or never started.
... 124 more
com.eibus.exception.BusException: All the service containers that respond to messages
for 'iHub' in this JVM either stopped or never started.
at com.eibus.transport.Middleware.lambda$sendMessageToRegisteredTargetOrThrowException$5(Middleware.java:928)
at java.base/java.util.Optional.orElseThrow(Optional.java:408)
at com.eibus.transport.Middleware.sendMessageToRegisteredTargetOrThrowException(Middleware.java:928)
at com.eibus.transport.Middleware.residesInThisVM(Middleware.java:880)
at com.eibus.transport.Middleware.send(Middleware.java:689)
at com.eibus.web.gateway.BusGateway.send(BusGateway.java:412)
at com.eibus.web.gateway.SOAPTransaction.execute(SOAPTransaction.java:420)
at com.eibus.web.gateway.SOAPTransaction.<init>(SOAPTransaction.java:253)
at com.eibus.web.gateway.SOAPTransaction.<init>(SOAPTransaction.java:217)
at com.eibus.web.soap.Gateway.service(Gateway.java:86)
at com.eibus.web.isapi.WebApplication.handleExtensionControlBlock(WebApplication.java:101)
at com.eibus.web.isapi.ServletExtensionControlBlock.handleExtensionControlBlock(ServletExtensionControlBlock.java:92)
at com.eibus.web.isapi.ExtensionControlBlock.handleMethod(ExtensionControlBlock.java:156)
at com.eibus.web.isapi.ExtensionControlBlock.execute(ExtensionControlBlock.java:112)
at com.eibus.web.isapi.Engine$SynchronousRequestHandler.run(Engine.java:121)
at com.eibus.web.isapi.Engine.processAndLog(Engine.java:94)
at com.eibus.web.isapi.Engine.handleSynchronousExtensionControlBlock(Engine.java:109)
at com.cordys.applicationserver.servlet.GatewayServlet.service(GatewayServlet.java:38)
...
]]></log4j:throwable>
<log4j:locationInfo class="com.eibus.web.gateway.SOAPTransaction" method="raiseSOAPFault" file="SOAPTransaction.java" line="1201"/>
</log4j:event>

Yes, I know that we know what’s going wrong here, but that’s not the point of this post…Keep on reading!

So, now what?…Well, imagine yourself that you don’t have a clue what is going wrong here, and you would like a deep dive into the code for further investigation on the stack trace!? Would that be possible? Even if we don’t have the sources of the platform available? WHAT!? Yes, my friend…Don’t worry, it’s possible with a trick that will blow your mind!

But first…Where is it going wrong? That’s our ‘caused by’ and when you take a closer look it’s just a service call via the AWP GatewayServlet class, managed by the WebApplication class, and eventually send by the Middleware class. The great question is here where to find these classes? Well, for that (I’m on Unix) I always use this command:

1
2
sudo find /opt/opentext/AppWorksPlatform/defaultInst/ -type f -name '*.jar' -print0\
| xargs -0 -I '{}' sh -c 'jar tf {} | grep Middleware.class && echo {}'

I also figured out a faster command:
sudo grep -l -R --text com.eibus.transport.Middleware /opt/opentext/AppWorksPlatform/defaultInst/ | grep '.jar'.
This last call simply searches for a corresponding text; the first call searches for the real class file in the JAR.

For windows enthusiasts, there are also JAR file search tools available:

Both my search commands receive this jar file /opt/opentext/AppWorksPlatform/defaultInst/components/esbclient/esbclient.jar. Save this file locally (if you haven’t already) and decompile the file with JD-GUI. You will have a clear view on the Middleware.send() method of our stack trace with line 689 calling the residesInThisVM() method (also in the same class!):

debug_002

So, would it not be great to have a debug breakpoint available on that line and walk through it? YES!…Tell me, tell me…Only, before we can do this we need to run our TomEE instance in debug mode. Apache made this easy via the Java Platform Debugger Architecture (JPDA) and with simple command we can make it happen on our Unix VM:

1
2
3
4
systemctl stop tomee
export JPDA_ADDRESS="192.168.56.107:8000"
sudo JPDA_ADDRESS=$JPDA_ADDRESS sh /opt/tomee/latest/bin/catalina.sh jpda run
# Watch the logging for: Listening for transport dt_socket at address: 8000

JPDA is for JVM debugging and JMX monitoring!

So, your AWP should be available again, but this time in debug mode which makes us developers very happy…Watch this…

I always work with IntelliJ which is my favorite IDE as Java developer. After you start it up, you get a ‘Welcome’ screen where we just create a new Java project:

debug_003

You can also create a ‘Maven’ project and get a grip on any dependencies, but it’s not required for our use-case! At a customer I would recommend to always use a Maven project for any Java related topic on the AppWorks platform.

Open the ‘Project structure’ from the ‘File’ menu and add the JAR library we found on our server, related to the stack trace, and saved locally:

debug_004

When we’re back in the project overview, you can open the ‘External Libraries’ section of the project and open the Middleware.class again (like we did with JD-GUI!). IntelliJ is smart enough to decompile it for you…How nice!

debug_005

Now watch those line numbers again! Do you see any difference? Yes, the residesInThisVM() is now on row number 496! This does not match the 689 line of our stack trace and because of that it’s not possible to set a debug breakpoint at line 496. Also, a breakpoint at line 689 is not useful in this case. Now what? Well, you can also set a so-called ‘Method-entry’ breakpoint!

debug_006

Nice feature!…With this breakpoint in place, it’s time to connect our IDE to our remote debuggable TomEE instance…From the ‘Run’ menu, open the ‘Run Configurations’ screen. Here you can add a new ‘Remote JVM Debug’ configuration; Like this:

debug_007

After saving it, you can start a new remote ‘Debug’ session in the top-bar of IntelliJ. If all is fine (including firewall pass through on the server!), you should receive a message on a successful remote connection:

debug_008

You will see that your debugging point gets triggered already! That’s because the Middleware.send() method is the heart of our platform which is triggered too by internal tasks. You can fix this by adding a condition to the breakpoint like this message.getTargets()[0].contains("iHub").

debug_009

So, move back to your error initialization (the test-button in the iHub Connection Manager artifact)…Hit it, and watch what happens in your IDE! It will “halt” on-method-entry, and you can already view some interesting data:

debug_010

Now what? Well, you have a ‘Blue pill, red pill’ option to make:

  1. BLUE pill (<F9>); the story ends, you wake up in your bed and believe whatever you want to believe! 😵
  2. RED pill (<F8>); you stay in wonderland, and I show you how deep the rabbit hole goes. 🤓

Well, comment me what choice you’ve made!? For me, it’s already a high-valued “DONE” on this post where we provided guidance to your next level experience on the AppWorks platform. With this information any stack trace is manageable again with great new insights. Make it your best debugging weekend and have yourself a great turn of the year…I see you in another great topic in 2023!

Don’t forget to subscribe to get updates on the activities happening on this site. Have you noticed the quiz where you find out if you are also “The AppWorks guy”?