It's all about the answers!

Ask a question

Integrate Build Forge with Quality Manager


FU YONG (4672) | asked May 20 '10, 5:31 a.m.
Hi all,

I just integrated Build Forge with RTC, then tried to integrate Build Forge with RQM following the documentation at
http://publib.boulder.ibm.com/infocenter/rqmhelp/v1r0m0/index.jsp?topic=/com.ibm.rational.test.lm.doc/topics/t_lm_intbf.html.

However, when attempted to add a machine to Build Forge from RQM, an error occured, RQM reports below:

ERROR com.ibm.rational.test.lm.service
-class com.ibm.rational.test.lm.service.spi.integration.IntegrationService:addAsset AWXSP5007E
Encountered an error within the external provider SPI: com.ibm.rational.test.lm.spi.common.SPIException: BuildForge APIException: Unexpected exception: java.lang.IllegalArgumentException: Empty key


When attempting to synchronize the inventory history, a similar exception was thrown as:

ERROR com.ibm.rational.test.lm.service
- class com.ibm.rational.test.lm.service.spi.integration.IntegrationService:getAllAssets AWXSP5007E
Encountered an error within the external provider SPI: com.ibm.rational.test.lm.spi.common.SPIException: BuildForge APIException: Unexpected exception: java.lang.IllegalArgumentException: Empty key


May I know what might be the possible cause?

And what else can we do with the integration between Build Forge and RQM? From the link given above, only limited integrated feature was introduced.

Build Forge version: 7.1.1.4
RQM version: 2.0.1

Thanks so much for your great help.

Regards,

Fu Yong

4 answers



permanent link
Peter Birk (501145) | answered May 20 '10, 11:13 a.m.
JAZZ DEVELOPER
Not enough information from just this error message. The exception appears to be coming from something lower-level than BF (like the JDK). Almost looks like a Kerberos error from the JDK. Can you take a look at the catalina.log in tomcat/logs (if using Tomcat for RQM and/or BF) to see if there are any errors there that look suspicious? Any additional error log information would be very beneficial. Thanks!

Regards,
Pete

permanent link
FU YONG (4672) | answered May 20 '10, 10:18 p.m.
Not enough information from just this error message. The exception appears to be coming from something lower-level than BF (like the JDK). Almost looks like a Kerberos error from the JDK. Can you take a look at the catalina.log in tomcat/logs (if using Tomcat for RQM and/or BF) to see if there are any errors there that look suspicious? Any additional error log information would be very beneficial. Thanks!

Regards,
Pete


Hi Pete,

This is the catalina.log file from RQM. I am not very sure what the "connection refused" error means.

Is there anything else I can look for?

Thanks.

Fu Yong

May 20, 2010 10:58:41 AM org.apache.catalina.core.AprLifecycleListener lifecycleEvent
INFO: The Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path: C:\Program Files\IBM\RQM201\server\jre\bin;.;C:\WINDOWS\system32;C:\WINDOWS;C:\WINDOWS\System32\Wbem;C:\Program Files\IBM\Infoprint Select;C:\Notes;C:\Program Files\XLView;C:\lotus\compnent;C:\Utilities;C:\Program Files\Common Files\Lenovo;C:\program files\ibm\personal communications\;C:\Program Files\IBM\Trace Facility\;C:\Program Files\Intel\WiFi\bin\;C:\Program Files\ThinkPad\ConnectUtilities;C:\PROGRA~1\IBM\SQLLIB\BIN;C:\PROGRA~1\IBM\SQLLIB\FUNCTION;C:\PROGRA~1\IBM\SQLLIB\SAMPLES\REPL
May 20, 2010 10:58:42 AM org.apache.coyote.http11.Http11BaseProtocol init
INFO: Initializing Coyote HTTP/1.1 on http-9080
May 20, 2010 10:58:43 AM org.apache.coyote.http11.Http11BaseProtocol init
INFO: Initializing Coyote HTTP/1.1 on http-9443
May 20, 2010 10:58:43 AM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 2297 ms
May 20, 2010 10:58:43 AM org.apache.catalina.core.StandardService start
INFO: Starting service Catalina
May 20, 2010 10:58:43 AM org.apache.catalina.core.StandardEngine start
INFO: Starting Servlet Engine: Apache Tomcat/5.5.28
May 20, 2010 10:58:43 AM org.apache.catalina.core.StandardHost start
INFO: XML validation disabled
May 20, 2010 10:58:44 AM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive help.war
May 20, 2010 10:59:03 AM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive jazz.war
May 20, 2010 10:59:21 AM org.apache.coyote.http11.Http11BaseProtocol start
INFO: Starting Coyote HTTP/1.1 on http-9080
May 20, 2010 10:59:21 AM org.apache.coyote.http11.Http11BaseProtocol start
INFO: Starting Coyote HTTP/1.1 on http-9443
May 20, 2010 10:59:21 AM org.apache.jk.common.ChannelSocket init
INFO: JK: ajp13 listening on /0.0.0.0:9009
May 20, 2010 10:59:21 AM org.apache.jk.server.JkMain start
INFO: Jk running ID=0 time=0/31 config=null
May 20, 2010 10:59:21 AM org.apache.catalina.storeconfig.StoreLoader load
INFO: Find registry server-registry.xml at classpath resource
May 20, 2010 10:59:21 AM org.apache.catalina.startup.Catalina start
INFO: Server startup in 37593 ms
May 20, 2010 11:15:09 AM org.apache.coyote.http11.Http11BaseProtocol pause
INFO: Pausing Coyote HTTP/1.1 on http-9080
May 20, 2010 11:15:09 AM org.apache.coyote.http11.Http11BaseProtocol pause
INFO: Pausing Coyote HTTP/1.1 on http-9443
May 20, 2010 11:15:10 AM org.apache.catalina.core.StandardService stop
INFO: Stopping service Catalina
May 20, 2010 11:15:10 AM org.apache.coyote.http11.Http11BaseProtocol destroy
INFO: Stopping Coyote HTTP/1.1 on http-9080
May 20, 2010 11:15:10 AM org.apache.coyote.http11.Http11BaseProtocol destroy
INFO: Stopping Coyote HTTP/1.1 on http-9443
May 20, 2010 11:15:10 AM org.apache.catalina.core.AprLifecycleListener lifecycleEvent
INFO: Failed shutdown of Apache Portable Runtime
May 20, 2010 11:15:32 AM org.apache.catalina.startup.Catalina stopServer
SEVERE: Catalina.stop:
java.net.ConnectException: Connection refused: connect
at java.net.PlainSocketImpl.socketConnect(Native Method)
at java.net.PlainSocketImpl.doConnect(PlainSocketImpl.java:391)
at java.net.PlainSocketImpl.connectToAddress(PlainSocketImpl.java:252)
at java.net.PlainSocketImpl.connect(PlainSocketImpl.java:239)
at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:389)
at java.net.Socket.connect(Socket.java:551)
at java.net.Socket.connect(Socket.java:501)
at java.net.Socket.<init>(Socket.java:409)
at java.net.Socket.<init>(Socket.java:223)
at org.apache.catalina.startup.Catalina.stopServer(Catalina.java:395)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:79)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:618)
at org.apache.catalina.startup.Bootstrap.stopServer(Bootstrap.java:344)
at org.apache.catalina.startup.Bootstrap.main(Bootstrap.java:435)
May 20, 2010 4:51:14 PM org.apache.catalina.core.AprLifecycleListener lifecycleEvent
INFO: The Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path: C:\Program Files\IBM\RQM201\server\jre\bin;.;C:\WINDOWS\system32;C:\WINDOWS;C:\WINDOWS\System32\Wbem;C:\Program Files\IBM\Infoprint Select;C:\Notes;C:\Program Files\XLView;C:\lotus\compnent;C:\Utilities;C:\Program Files\Common Files\Lenovo;C:\program files\ibm\personal communications\;C:\Program Files\IBM\Trace Facility\;C:\Program Files\Intel\WiFi\bin\;C:\Program Files\ThinkPad\ConnectUtilities;C:\PROGRA~1\IBM\SQLLIB\BIN;C:\PROGRA~1\IBM\SQLLIB\FUNCTION;C:\PROGRA~1\IBM\SQLLIB\SAMPLES\REPL;C:\Program Files\Rational\common
May 20, 2010 4:51:14 PM org.apache.coyote.http11.Http11BaseProtocol init
INFO: Initializing Coyote HTTP/1.1 on http-9080
May 20, 2010 4:51:16 PM org.apache.coyote.http11.Http11BaseProtocol init
INFO: Initializing Coyote HTTP/1.1 on http-9443
May 20, 2010 4:51:16 PM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 2250 ms
May 20, 2010 4:51:16 PM org.apache.catalina.core.StandardService start
INFO: Starting service Catalina
May 20, 2010 4:51:16 PM org.apache.catalina.core.StandardEngine start
INFO: Starting Servlet Engine: Apache Tomcat/5.5.28
May 20, 2010 4:51:16 PM org.apache.catalina.core.StandardHost start
INFO: XML validation disabled
May 20, 2010 4:51:26 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive help.war
May 20, 2010 4:51:30 PM org.apache.coyote.http11.Http11BaseProtocol start
INFO: Starting Coyote HTTP/1.1 on http-9080
May 20, 2010 4:51:30 PM org.apache.coyote.http11.Http11BaseProtocol start
INFO: Starting Coyote HTTP/1.1 on http-9443
May 20, 2010 4:51:30 PM org.apache.jk.common.ChannelSocket init
INFO: JK: ajp13 listening on /0.0.0.0:9009
May 20, 2010 4:51:30 PM org.apache.jk.server.JkMain start
INFO: Jk running ID=0 time=0/15 config=null
May 20, 2010 4:51:30 PM org.apache.catalina.storeconfig.StoreLoader load
INFO: Find registry server-registry.xml at classpath resource
May 20, 2010 4:51:30 PM org.apache.catalina.startup.Catalina start
INFO: Server startup in 14438 ms
May 20, 2010 4:54:58 PM org.apache.coyote.http11.Http11BaseProtocol pause
INFO: Pausing Coyote HTTP/1.1 on http-9080
May 20, 2010 4:54:58 PM org.apache.coyote.http11.Http11BaseProtocol pause
INFO: Pausing Coyote HTTP/1.1 on http-9443
May 20, 2010 4:54:59 PM org.apache.catalina.core.StandardService stop
INFO: Stopping service Catalina
May 20, 2010 4:55:05 PM org.apache.coyote.http11.Http11BaseProtocol destroy
INFO: Stopping Coyote HTTP/1.1 on http-9080
May 20, 2010 4:55:05 PM org.apache.coyote.http11.Http11BaseProtocol destroy
INFO: Stopping Coyote HTTP/1.1 on http-9443
May 20, 2010 4:55:05 PM org.apache.catalina.core.AprLifecycleListener lifecycleEvent
INFO: Failed shutdown of Apache Portable Runtime
May 20, 2010 4:55:20 PM org.apache.catalina.core.AprLifecycleListener lifecycleEvent
INFO: The Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path: C:\Program Files\IBM\RQM201\server\jre\bin;.;C:\WINDOWS\system32;C:\WINDOWS;C:\WINDOWS\System32\Wbem;C:\Program Files\IBM\Infoprint Select;C:\Notes;C:\Program Files\XLView;C:\lotus\compnent;C:\Utilities;C:\Program Files\Common Files\Lenovo;C:\program files\ibm\personal communications\;C:\Program Files\IBM\Trace Facility\;C:\Program Files\Intel\WiFi\bin\;C:\Program Files\ThinkPad\ConnectUtilities;C:\PROGRA~1\IBM\SQLLIB\BIN;C:\PROGRA~1\IBM\SQLLIB\FUNCTION;C:\PROGRA~1\IBM\SQLLIB\SAMPLES\REPL;C:\Program Files\Rational\common
May 20, 2010 4:55:20 PM org.apache.coyote.http11.Http11BaseProtocol init
INFO: Initializing Coyote HTTP/1.1 on http-9080
May 20, 2010 4:55:21 PM org.apache.coyote.http11.Http11BaseProtocol init
INFO: Initializing Coyote HTTP/1.1 on http-9443
May 20, 2010 4:55:21 PM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 1750 ms
May 20, 2010 4:55:22 PM org.apache.catalina.core.StandardService start
INFO: Starting service Catalina
May 20, 2010 4:55:22 PM org.apache.catalina.core.StandardEngine start
INFO: Starting Servlet Engine: Apache Tomcat/5.5.28
May 20, 2010 4:55:22 PM org.apache.catalina.core.StandardHost start
INFO: XML validation disabled
May 20, 2010 4:55:35 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive help.war
May 20, 2010 4:55:37 PM org.apache.coyote.http11.Http11BaseProtocol start
INFO: Starting Coyote HTTP/1.1 on http-9080
May 20, 2010 4:55:37 PM org.apache.coyote.http11.Http11BaseProtocol start
INFO: Starting Coyote HTTP/1.1 on http-9443
May 20, 2010 4:55:37 PM org.apache.jk.common.ChannelSocket init
INFO: JK: ajp13 listening on /0.0.0.0:9009
May 20, 2010 4:55:37 PM org.apache.jk.server.JkMain start
INFO: Jk running ID=0 time=0/15 config=null
May 20, 2010 4:55:37 PM org.apache.catalina.storeconfig.StoreLoader load
INFO: Find registry server-registry.xml at classpath resource
May 20, 2010 4:55:37 PM org.apache.catalina.startup.Catalina start
INFO: Server startup in 15703 ms
May 20, 2010 5:33:02 PM org.apache.coyote.http11.Http11BaseProtocol pause
INFO: Pausing Coyote HTTP/1.1 on http-9080
May 20, 2010 5:33:02 PM org.apache.coyote.http11.Http11BaseProtocol pause
INFO: Pausing Coyote HTTP/1.1 on http-9443
May 20, 2010 5:33:03 PM org.apache.catalina.core.StandardService stop
INFO: Stopping service Catalina
May 20, 2010 5:33:06 PM org.apache.catalina.startup.Catalina stopServer
SEVERE: Catalina.stop:
java.net.ConnectException: Connection refused: connect
at java.net.PlainSocketImpl.socketConnect(Native Method)
at java.net.PlainSocketImpl.doConnect(PlainSocketImpl.java:391)
at java.net.PlainSocketImpl.connectToAddress(PlainSocketImpl.java:252)
at java.net.PlainSocketImpl.connect(PlainSocketImpl.java:239)
at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:389)
at java.net.Socket.connect(Socket.java:551)
at java.net.Socket.connect(Socket.java:501)
at java.net.Socket.<init>(Socket.java:409)
at java.net.Socket.<init>(Socket.java:223)
at org.apache.catalina.startup.Catalina.stopServer(Catalina.java:395)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:79)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:618)
at org.apache.catalina.startup.Bootstrap.stopServer(Bootstrap.java:344)
at org.apache.catalina.startup.Bootstrap.main(Bootstrap.java:435)
May 20, 2010 5:33:07 PM org.apache.coyote.http11.Http11BaseProtocol destroy
INFO: Stopping Coyote HTTP/1.1 on http-9080
May 20, 2010 5:33:07 PM org.apache.coyote.http11.Http11BaseProtocol destroy
INFO: Stopping Coyote HTTP/1.1 on http-9443
May 20, 2010 5:33:07 PM org.apache.catalina.core.AprLifecycleListener lifecycleEvent
INFO: Failed shutdown of Apache Portable Runtime

permanent link
Peter Birk (501145) | answered May 24 '10, 9:09 a.m.
JAZZ DEVELOPER
I don't believe the "connection refused" errors here are pertinent. They are occurring during a stop server and it's probably normal. I don't see anything in the log you posted that would help us debug this further. You might want to post the same question to the Quality Manager forum as they might understand better how BF is getting invoked and where to look for errors from that and better instructions for setting it all up. If you don't get a good response from that forum, we can pursue this further but might need to look at QM logs to see the real stack coming from the connection problem.

Regards,
Pete

permanent link
Pawan Ranganath (622) | answered Apr 11 '11, 3:26 a.m.
JAZZ DEVELOPER
Hello

Im facing the same problem as mentioned above. But the entries in my catalina.out seem to be different:

Apr 11, 2011 2:37:16 AM com.buildforge.services.server.api.APIServerConnection process
WARNING: !!!
java.lang.IllegalArgumentException: Empty key
at javax.crypto.spec.SecretKeySpec.<init>(Unknown Source)
at com.buildforge.services.server.api.auth.ChallengeResponse.respond(ChallengeResponse.java:109)
at com.buildforge.services.server.api.AuthContext.answerChallenge(AuthContext.java:593)
at com.buildforge.services.server.api.commands.AuthCommands.doLoginResponse(AuthCommands.java:234)
at com.buildforge.services.server.api.commands.AuthCommands.doLogin(AuthCommands.java:305)
at com.buildforge.services.server.api.commands.AuthCommands.invoke(AuthCommands.java:88)
at com.buildforge.services.server.api.APICommandProcessor.process(APICommandProcessor.java:262)
at com.buildforge.services.server.api.APIServerConnection.handleRequest(APIServerConnection.java:165)
at com.buildforge.services.server.api.APIServerConnection.process(APIServerConnection.java:123)
at com.buildforge.services.server.dispatch.handler.BufferedConnection.run(BufferedConnection.java:244)
at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:665)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:690)
at java.lang.Thread.run(Thread.java:810)


Can you plz help with this?

Your answer


Register or to post your answer.


Dashboards and work items are no longer publicly available, so some links may be invalid. We now provide similar information through other means. Learn more here.