- PR -

SOAP連携での接続エラーについて

参照元記事 | 同じ記事を参照しているスレッド一覧
1
投稿者投稿内容
ITSS
会議室デビュー日: 2008/10/03
投稿数: 2
投稿日時: 2008-10-03 22:18
JavaサーブレットからWebServiceに接続しようとしています。
WebServiceは、同じTomcatにデプロイされており動作しています。
そのため、ブラウザより以下のURLにアクセスすると応答が正常に戻ってきます。
http://localhost:8888/xxxxxx/services/yyyyyyYyyService?method=getRecvDocList

しかし、JavaServletからwebServiceにアクセスした際に、
以下のようなExceptionがログに出力されてしまいます。
ただし、Exceptionが発生していても、JavaServletの実行結果は、
こちらが期待したとおりの結果となっています。

両方ともエラーとしては、AXIS内で起こっているので、
特に問題視しなくても良いのでしょうか。

どなたか詳しい方いらっしゃいましたら教えてください。
よろしくお願いします。

--------VERSIONS---------------
Java 1.4.2_06, running on Windows 2003
Tomcat 4.1.30, running on Windows 2003
Axis 1.2.1, running in same Tomcat

---------EXCEPTION(SOAPクライアント):------------------
2008-10-03 21:57:35.796 DEBUG -http-8888-Processor5- <MessageContext.setTargetService> -748- MessageContext: setTargetService(yyyyyyYyyService)
2008-10-03 21:57:35.796 DEBUG -http-8888-Processor5- <ProjectResourceBundle.handleGetObject> -72- org.apache.axis.i18n.resource::handleGetObject(noService10)
2008-10-03 21:57:35.796 DEBUG -http-8888-Processor5- <ConfigurationException.logException> -110- Exception:
org.apache.axis.ConfigurationException: サービス名yyyyyyYyyServiceは利用できません / [en]-(No service named yyyyyyYyyService is available)
org.apache.axis.ConfigurationException: サービス名yyyyyyYyyServiceは利用できません / [en]-(No service named yyyyyyYyyService is available)
at org.apache.axis.configuration.FileProvider.getService(FileProvider.java:233)
at org.apache.axis.AxisEngine.getService(AxisEngine.java:311)
at org.apache.axis.MessageContext.setTargetService(MessageContext.java:755)
at org.apache.axis.client.Call.invoke(Call.java:2671)
at org.apache.axis.client.Call.invoke(Call.java:2424)
at org.apache.axis.client.Call.invoke(Call.java:2347)
at org.apache.axis.client.Call.invoke(Call.java:1804)
（中略）
2008-10-03 21:57:35.812 DEBUG -http-8888-Processor5- <MessageContext.setService> -792- MessageContext: setServiceHandler(null)
2008-10-03 21:57:35.812 DEBUG -http-8888-Processor5- <ProjectResourceBundle.handleGetObject> -72- org.apache.axis.i18n.resource::handleGetObject(targetService)
2008-10-03 21:57:35.812 DEBUG -http-8888-Processor5- <Call.invoke> -2696- 対象のサービス: yyyyyyYyyService / [en]-(Target service: yyyyyyYyyService)
2008-10-03 21:57:35.812 DEBUG -http-8888-Processor5- <MessageContext.setTargetService> -748- MessageContext: setTargetService()
2008-10-03 21:57:35.812 DEBUG -http-8888-Processor5- <ProjectResourceBundle.handleGetObject> -72- org.apache.axis.i18n.resource::handleGetObject(noService10)
2008-10-03 21:57:35.812 DEBUG -http-8888-Processor5- <ConfigurationException.logException> -110- Exception:
org.apache.axis.ConfigurationException: サービス名は利用できません / [en]-(No service named is available)
org.apache.axis.ConfigurationException: サービス名は利用できません / [en]-(No service named is available)
at org.apache.axis.configuration.FileProvider.getService(FileProvider.java:233)
at org.apache.axis.AxisEngine.getService(AxisEngine.java:311)
at org.apache.axis.MessageContext.setTargetService(MessageContext.java:755)
at org.apache.axis.transport.http.HTTPTransport.setupMessageContextImpl(HTTPTransport.java:89)
at org.apache.axis.client.Transport.setupMessageContext(Transport.java:46)
at org.apache.axis.client.Call.invoke(Call.java:2719)
at org.apache.axis.client.Call.invoke(Call.java:2424)
at org.apache.axis.client.Call.invoke(Call.java:2347)
at org.apache.axis.client.Call.invoke(Call.java:1804)
（中略）
2008-10-03 21:57:35.953 DEBUG -http-8888-Processor5- <ProjectResourceBundle.handleGetObject> -72- org.apache.axis.i18n.resource::handleGetObject(empty00)
2008-10-03 21:57:35.953 DEBUG -http-8888-Processor5- <NSStack.pop> -113- NSPop (空 / [en]-(empty))
2008-10-03 21:57:35.953 DEBUG -http-8888-Processor5- <ProjectResourceBundle.handleGetObject> -72- org.apache.axis.i18n.resource::handleGetObject(setMsgForm)
2008-10-03 21:57:35.953 DEBUG -http-8888-Processor5- <SOAPPart.setCurrentForm> -374- FORM_OPTIMIZEDへ現在のメッセージの形式をセットしています(現在のメッセージはorg.apache.axis.utils.ByteArrayです) / [en]-(Setting current message form to: FORM_OPTIMIZED (currentMessage is now org.apache.axis.utils.ByteArray))
2008-10-03 21:57:35.953 DEBUG -http-8888-Processor5- <SOAPPart.saveChanges> -537- Exit: SOAPPart::saveChanges(): org.apache.axis.utils.ByteArray@189acb5
2008-10-03 21:57:35.953 DEBUG -http-8888-Processor5- <SOAPPart.saveChanges> -524- Enter: SOAPPart::saveChanges
2008-10-03 21:57:35.953 DEBUG -http-8888-Processor5- <SOAPPart.saveChanges> -524- Enter: SOAPPart::saveChanges
2008-10-03 21:57:35.984 DEBUG -http-8888-Processor5- <ProjectResourceBundle.handleGetObject> -72- org.apache.axis.i18n.resource::handleGetObject(createdHTTP00)
2008-10-03 21:57:35.984 DEBUG -http-8888-Processor5- <DefaultSocketFactory.create> -122- 安全でないHTTPコネクションが生成されました / [en]-(Created an insecure HTTP connection)
2008-10-03 21:57:35.984 DEBUG -http-8888-Processor5- <ProjectResourceBundle.handleGetObject> -72- org.apache.axis.i18n.resource::handleGetObject(xmlSent00)
2008-10-03 21:57:35.984 DEBUG -http-8888-Processor5- <HTTPSender.writeToSocket> -484- 送信XML: / [en]-(XML sent:)
2008-10-03 21:57:35.984 DEBUG -http-8888-Processor5- <HTTPSender.writeToSocket> -485- ---------------------------------------------------
2008-10-03 21:57:35.984 DEBUG -http-8888-Processor5- <SOAPPart.saveChanges> -524- Enter: SOAPPart::saveChanges
2008-10-03 21:57:35.984 DEBUG -http-8888-Processor5- <HTTPSender.writeToSocket> -519- POST /xxxxxx/services/yyyyyyYyyService HTTP/1.0
Content-Type: text/xml; charset=utf-8
Accept: application/soap+xml, application/dime, multipart/related, text/*
User-Agent: Axis/1.2.1
Host: 10.66.116.58:8888
Cache-Control: no-cache
Pragma: no-cache
SOAPAction: ""
Content-Length: 579

<?xml version="1.0" encoding="UTF-8"?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:xsd="http://www.w3.org/2001/XMLSchema" xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"><soapenv:Body><ns1:getRecvDocList soapenv:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/" xmlns:ns1="urn:jp.lgwan.yyyyyyYyyService"><buntoriDN xsi:type="xsd:string">cn=asumu suzuki,ou=Electronic calculation section,ou=Planning department,ou=Fukuoka City,l=Fukuoka,o=Local Governments,c=jp</buntoriDN></ns1:getRecvDocList></soapenv:Body></soapenv:Envelope>
2008-10-03 21:57:38.828 DEBUG -http-8888-Processor5- <HTTPSender.readHeadersFromSocket> -627- HTTP/1.1 200 OK
2008-10-03 21:57:38.843 DEBUG -http-8888-Processor5- <HTTPSender.readHeadersFromSocket> -627- Content-Type text/xml;charset=utf-8
2008-10-03 21:57:38.843 DEBUG -http-8888-Processor5- <HTTPSender.readHeadersFromSocket> -627- Date Fri, 03 Oct 2008 12:57:38 GMT
2008-10-03 21:57:38.843 DEBUG -http-8888-Processor5- <HTTPSender.readHeadersFromSocket> -627- Server Apache-Coyote/1.1
2008-10-03 21:57:38.843 DEBUG -http-8888-Processor5- <HTTPSender.readHeadersFromSocket> -627- Connection close
2008-10-03 21:57:38.843 DEBUG -http-8888-Processor5- <SOAPPart.<init>> -182- Enter: SOAPPart ctor(FORM_INPUTSTREAM)
2008-10-03 21:57:38.843 DEBUG -http-8888-Processor5- <ProjectResourceBundle.handleGetObject> -72- org.apache.axis.i18n.resource::handleGetObject(setMsgForm)



---------EXCEPTION(SOAPサーバー):------------------
2008-10-03 21:57:35.984 DEBUG -http-8888-Processor3- <AxisServletBase.init> -111- In AxisServletBase init
2008-10-03 21:57:35.984 DEBUG -http-8888-Processor3- <AxisServletBase.getEngine> -166- Enter: getEngine()
2008-10-03 21:57:35.984 DEBUG -http-8888-Processor3- <ProjectResourceBundle.handleGetObject> -72- org.apache.axis.i18n.resource::handleGetObject(engineFactory)
2008-10-03 21:57:35.984 DEBUG -http-8888-Processor3- <EngineConfigurationFactoryFinder$1.run> -141- EngineFactoryオブジェクトの取得: org.apache.axis.configuration.EngineConfigurationFactoryServlet / [en]-(Got EngineFactory: org.apache.axis.configuration.EngineConfigurationFactoryServlet)
2008-10-03 21:57:35.984 DEBUG -http-8888-Processor3- <DefaultAxisServerFactory.getServer> -71- Enter: DefaultAxisServerFactory::getServer
2008-10-03 21:57:35.984 DEBUG -http-8888-Processor3- <DefaultAxisServerFactory.getEngineConfiguration> -122- Enter: DefaultAxisServerFactory::getEngineConfiguration
2008-10-03 21:57:36.000 DEBUG -http-8888-Processor3- <DefaultAxisServerFactory.getEngineConfiguration> -162- Exit: DefaultAxisServerFactory::getEngineConfiguration
2008-10-03 21:57:36.000 DEBUG -http-8888-Processor3- <AxisEngine.init> -165- Enter: AxisEngine::init
2008-10-03 21:57:36.015 DEBUG -http-8888-Processor3- <ProjectResourceBundle.handleGetObject> -72- org.apache.axis.i18n.resource::handleGetObject(exception00)
2008-10-03 21:57:36.015 DEBUG -http-8888-Processor3- <BaseSerializerFactory.createFactory> -261- 例外発生: / [en]-(Exception:)
java.lang.NoSuchMethodException: org.apache.axis.encoding.ser.ArraySerializerFactory.create(java.lang.Class, javax.xml.namespace.QName)
at java.lang.Class.getMethod(Class.java:986)
at org.apache.axis.encoding.ser.BaseSerializerFactory.createFactory(BaseSerializerFactory.java:254)
at org.apache.axis.deployment.wsdd.WSDDService.deployTypeMapping(WSDDService.java:542)
at org.apache.axis.deployment.wsdd.WSDDService.initTMR(WSDDService.java:253)
at org.apache.axis.deployment.wsdd.WSDDService.<init>(WSDDService.java:233)
at org.apache.axis.deployment.wsdd.WSDDDeployment.<init>(WSDDDeployment.java:192)
at org.apache.axis.deployment.wsdd.WSDDDocument.setDocument(WSDDDocument.java:139)
at org.apache.axis.deployment.wsdd.WSDDDocument.<init>(WSDDDocument.java:65)
at org.apache.axis.configuration.FileProvider.configureEngine(FileProvider.java:179)
at org.apache.axis.AxisEngine.init(AxisEngine.java:172)
at org.apache.axis.AxisEngine.<init>(AxisEngine.java:156)
at org.apache.axis.server.AxisServer.<init>(AxisServer.java:88)
at org.apache.axis.server.DefaultAxisServerFactory.createServer(DefaultAxisServerFactory.java:109)
at org.apache.axis.server.DefaultAxisServerFactory.getServer(DefaultAxisServerFactory.java:73)
at org.apache.axis.server.AxisServer.getServer(AxisServer.java:73)
at org.apache.axis.transport.http.AxisServletBase.getEngine(AxisServletBase.java:185)
at org.apache.axis.transport.http.AxisServletBase.getOption(AxisServletBase.java:396)
at org.apache.axis.transport.http.AxisServletBase.init(AxisServletBase.java:112)
at org.apache.axis.transport.http.AxisServlet.init(AxisServlet.java:156)
（中略）
2008-10-03 21:57:38.843 DEBUG -http-8888-Processor3- <AxisServlet.doPost> -785- Exit: doPost()
2008-10-03 21:57:38.843 DEBUG -http-8888-Processor3- <AxisServlet.doPost> -789- axisServlet.doPost: /xxxxxx pre=110 invoke=2406 post=0 send=234 yyyyyyYyyService.getRecvDocList
2008-10-03 21:57:38.937 DEBUG -Finalizer- <MessageContext.dispose> -1348- disposing of message context
ITSS
会議室デビュー日: 2008/10/03
投稿数: 2
投稿日時: 2008-10-08 10:04
自己解決しました。

１．結論
①SOAPクライアント側のエラーと②SOAPサーバ側のエラーは別の原因で発生していたましたが、両エラー共に無視できるエラーであると判断しました。

２．各エラーの原因
①SOAPクライアント側のエラー
SOAPサーバのAxisサーブレットが、SOAPクライアント側の要求を受けた段階で起動していなかった場合に出てくるエラーと考えられる。Axisサーブレットが起動するまで、SOAPクライアントはリトライをし続けるため、同様のエラーが何度も発生していた可能性が高い。Axisサーブレットが起動後は、正常に動作しているように見受けられるので、特に問題はないと判断。

---------EXCEPTION(SOAPサーバー):------------------
2008-10-03 21:57:35.984 DEBUG -http-8888-Processor3- <AxisServletBase.init> -111- In AxisServletBase init
2008-10-03 21:57:35.984 DEBUG -http-8888-Processor3- <AxisServletBase.getEngine> -166- Enter: getEngine()
2008-10-03 21:57:35.984 DEBUG -http-8888-Processor3- <ProjectResourceBundle.handleGetObject> -72- org.apache.axis.i18n.resource::handleGetObject(engineFactory)

---------EXCEPTION(SOAPクライアント):------------------
2008-10-03 21:57:35.796 DEBUG -http-8888-Processor5- <ConfigurationException.logException>
2008-10-03 21:57:35.812 DEBUG -http-8888-Processor5- <ConfigurationException.logException>


②SOAPサーバ側
Axisの既存のバグ（以下のURLを参照）であり、特に問題はないと判断。
http://issues.apache.org/jira/browse/AXIS-2296
山本 裕介
ぬし
会議室デビュー日: 2003/05/22
投稿数: 2415
お住まい・勤務地: 恵比寿
投稿日時: 2008-10-08 10:10
一般的な話ですが、DEBUG レベルのメッセージは通常無害だと思います。
1

スキルアップ／キャリアアップ（JOB@IT）