Uploaded image for project: 'Spring Web Services'
  1. Spring Web Services
  2. SWS-764

SoapEnvelopeLoggingInterceptor logging only partial request/response when Axis SAAJ API is used along with Xalan 2.7.1 and log4j 1.2.16 (using %m option)

    Details

    • Type: Defect
    • Status: Closed
    • Priority: Minor
    • Resolution: Invalid
    • Affects Version/s: 2.0.2
    • Fix Version/s: 2.0.5
    • Component/s: Core
    • Environment:
      Tomcat 6.0.14, Log4j 1.2.16, JDK 1.5.0_19, Xalan 2.7.1

      Description

      Excerpt of Catalina log:

      Apr 16, 2012 3:33:33 PM org.apache.catalina.core.ApplicationContext log
      INFO: Initializing Spring FrameworkServlet 'spring-ws'
      2012-04-16 15:33:33,803 INFO [transport.http.MessageDispatcherServlet] - FrameworkServlet 'spring-ws': initialization started
      2012-04-16 15:33:33,991 INFO [context.support.XmlWebApplicationContext] - Refreshing WebApplicationContext for namespace 'spring-ws-servlet': startup date [Mon Apr 16 15:33:33 IST 2012]; root of context hierarchy
      2012-04-16 15:33:34,756 INFO [factory.xml.XmlBeanDefinitionReader] - Loading XML bean definitions from ServletContext resource [/WEB-INF/spring-ws-servlet.xml]
      2012-04-16 15:33:39,428 INFO [addressing.server.AnnotationActionEndpointMapping] - Supporting [WS-Addressing August 2004, WS-Addressing 1.0]
      2012-04-16 15:33:39,568 INFO [factory.support.DefaultListableBeanFactory] - Pre-instantiating singletons in org.s[email protected]188c838: defining beans [stubHumanResourceService,holidayEndpoint,org.springframework.context.annotation.internalConfigurationAnnotationProcessor,org.springframework.context.annotation.internalAutowiredAnnotationProcessor,org.springframework.context.annotation.internalRequiredAnnotationProcessor,org.springframework.context.annotation.internalCommonAnnotationProcessor,org.springframework.ws.server.endpoint.mapping.PayloadRootAnnotationMethodEndpointMapping#0,org.springframework.ws.soap.server.endpoint.mapping.SoapActionAnnotationMethodEndpointMapping#0,org.springframework.ws.soap.addressing.server.AnnotationActionEndpointMapping#0,org.springframework.ws.server.endpoint.adapter.method.dom.DomPayloadMethodProcessor#0,org.springframework.ws.server.endpoint.adapter.method.SourcePayloadMethodProcessor#0,org.springframework.ws.server.endpoint.adapter.method.dom.JDomPayloadMethodProcessor#0,org.springframework.ws.server.endpoint.adapter.DefaultMethodEndpointAdapter#0,org.springframework.ws.soap.server.endpoint.interceptor.DelegatingSmartSoapEndpointInterceptor#0,org.springframework.ws.soap.server.endpoint.interceptor.PayloadRootSmartSoapEndpointInterceptor#0,org.springframework.xml.xsd.commons.CommonsXsdSchemaCollection#0,holiday]; root of factory hierarchy
      2012-04-16 15:33:41,818 INFO [xsd.commons.CommonsXsdSchemaCollection] - Loaded ServletContext resource [/WEB-INF/holiday.xsd]
      2012-04-16 15:33:43,130 INFO [soap.saaj.SaajSoapMessageFactory] - Creating SAAJ 1.3 MessageFactory with SOAP 1.1 Protocol
      2012-04-16 15:33:43,209 INFO [transport.http.MessageDispatcherServlet] - FrameworkServlet 'spring-ws': initialization completed in 9406 ms
      2012-04-16 15:33:44,990 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Request: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas">
         <soapenv:Header/>
         <soapenv:Body>
            <sch:HolidayRequest>
               <sch:Holiday>
                  <sch:StartDate>2006-03-03
      2012-04-16 15:33:45,224 INFO [hr.service.StubHumanResourceService] - Booking holiday from [03-Mar-06] to [07-Mar-06] for employee [Mahesh Kandpal]
      2012-04-16 15:33:45,255 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Response: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas"><soapenv:Header/><soapenv:Body><sch:HolidayResponse xmlns:sch="http://mycompany.com/hr/schemas"><sch:Status xmlns:sch="http://mycompany.com/hr/schemas">Booked
      2012-04-16 15:33:59,379 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Request: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas">
         <soapenv:Header/>
         <soapenv:Body>
            <sch:HolidayRequest>
               <sch:Holiday>
                  <sch:StartDate>2006-03-03
      2012-04-16 15:33:59,379 INFO [hr.service.StubHumanResourceService] - Booking holiday from [03-Mar-06] to [01-Mar-06] for employee [Mahesh Kandpal]
      2012-04-16 15:33:59,379 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Response: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas"><soapenv:Header/><soapenv:Body><sch:HolidayResponse xmlns:sch="http://mycompany.com/hr/schemas"><sch:Status xmlns:sch="http://mycompany.com/hr/schemas">Not Booked
      2012-04-16 15:34:16,845 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Request: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas">
         <soapenv:Header/>
         <soapenv:Body>
            <sch:HolidayRequest>
               <sch:Holiday>
                  <sch:StartDate>2006-03-03
      2012-04-16 15:34:16,845 INFO [hr.service.StubHumanResourceService] - Booking holiday from [03-Mar-06] to [07-Mar-06] for employee [Mahesh Kandpal]
      2012-04-16 15:34:16,845 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Response: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas"><soapenv:Header/><soapenv:Body><sch:HolidayResponse xmlns:sch="http://mycompany.com/hr/schemas"><sch:Status xmlns:sch="http://mycompany.com/hr/schemas">Booked
      2012-04-16 15:34:31,890 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Request: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas">
         <soapenv:Header/>
         <soapenv:Body>
            <sch:HolidayRequest>
               <sch:Holiday>
                  <sch:StartDate>2006-03-03
      2012-04-16 15:34:31,890 INFO [hr.service.StubHumanResourceService] - Booking holiday from [03-Mar-06] to [07-Mar-06] for employee [Mahesh Kandpal]
      2012-04-16 15:34:31,890 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Response: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas"><soapenv:Header/><soapenv:Body><sch:HolidayResponse xmlns:sch="http://mycompany.com/hr/schemas"><sch:Status xmlns:sch="http://mycompany.com/hr/schemas">Booked

      When I exclude Xalan from the axis-saaj-api dependency, it correctly displays the request/response in the log.

      INFO: Initializing Spring FrameworkServlet 'spring-ws'
      2012-04-16 16:16:49,950 INFO [transport.http.MessageDispatcherServlet] - FrameworkServlet 'spring-ws': initialization started
      2012-04-16 16:16:49,997 INFO [context.support.XmlWebApplicationContext] - Refreshing WebApplicationContext for namespace 'spring-ws-servlet': startup date [Mon Apr 16 16:16:49 IST 2012]; root of context hierarchy
      2012-04-16 16:16:50,168 INFO [factory.xml.XmlBeanDefinitionReader] - Loading XML bean definitions from ServletContext resource [/WEB-INF/spring-ws-servlet.xml]
      2012-04-16 16:16:51,481 INFO [addressing.server.AnnotationActionEndpointMapping] - Supporting [WS-Addressing August 2004, WS-Addressing 1.0]
      2012-04-16 16:16:51,512 INFO [factory.support.DefaultListableBeanFactory] - Pre-instantiating singletons in org.s[email protected]1085e92: defining beans [stubHumanResourceService,holidayEndpoint,org.springframework.context.annotation.internalConfigurationAnnotationProcessor,org.springframework.context.annotation.internalAutowiredAnnotationProcessor,org.springframework.context.annotation.internalRequiredAnnotationProcessor,org.springframework.context.annotation.internalCommonAnnotationProcessor,org.springframework.ws.server.endpoint.mapping.PayloadRootAnnotationMethodEndpointMapping#0,org.springframework.ws.soap.server.endpoint.mapping.SoapActionAnnotationMethodEndpointMapping#0,org.springframework.ws.soap.addressing.server.AnnotationActionEndpointMapping#0,org.springframework.ws.server.endpoint.adapter.method.dom.DomPayloadMethodProcessor#0,org.springframework.ws.server.endpoint.adapter.method.SourcePayloadMethodProcessor#0,org.springframework.ws.server.endpoint.adapter.method.dom.JDomPayloadMethodProcessor#0,org.springframework.ws.server.endpoint.adapter.DefaultMethodEndpointAdapter#0,org.springframework.ws.soap.server.endpoint.interceptor.DelegatingSmartSoapEndpointInterceptor#0,org.springframework.ws.soap.server.endpoint.interceptor.PayloadRootSmartSoapEndpointInterceptor#0,org.springframework.xml.xsd.commons.CommonsXsdSchemaCollection#0,holiday]; root of factory hierarchy
      2012-04-16 16:16:52,231 INFO [xsd.commons.CommonsXsdSchemaCollection] - Loaded ServletContext resource [/WEB-INF/holiday.xsd]
      2012-04-16 16:16:52,512 INFO [soap.saaj.SaajSoapMessageFactory] - Creating SAAJ 1.3 MessageFactory with SOAP 1.1 Protocol
      2012-04-16 16:16:52,543 INFO [transport.http.MessageDispatcherServlet] - FrameworkServlet 'spring-ws': initialization completed in 2593 ms
      2012-04-16 16:16:52,902 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Request: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas">
         <soapenv:Header/>
         <soapenv:Body>
            <sch:HolidayRequest>
               <sch:Holiday>
                  <sch:StartDate>2006-03-03</sch:StartDate>
                  <sch:EndDate>2006-03-07</sch:EndDate>
               </sch:Holiday>
               <sch:Employee>
                  <sch:Number>67</sch:Number>
                  <sch:FirstName>Mahesh</sch:FirstName>
                  <sch:LastName>Kandpal</sch:LastName>
               </sch:Employee>
            </sch:HolidayRequest>
         </soapenv:Body>
      </soapenv:Envelope>
      2012-04-16 16:16:52,949 INFO [hr.service.StubHumanResourceService] - Booking holiday from [03-Mar-06] to [07-Mar-06] for employee [Mahesh Kandpal]
      2012-04-16 16:16:52,980 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Response: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas"><soapenv:Header/><soapenv:Body><sch:HolidayResponse><sch:Status>Booked</sch:Status><sch:Duration>4</sch:Duration><sch:EmployeeNumber>67</sch:EmployeeNumber></sch:HolidayResponse></soapenv:Body></soapenv:Envelope>
      2012-04-16 16:17:00,729 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Request: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas">
         <soapenv:Header/>
         <soapenv:Body>
            <sch:HolidayRequest>
               <sch:Holiday>
                  <sch:StartDate>2006-03-03</sch:StartDate>
                  <sch:EndDate>2006-03-01</sch:EndDate>
               </sch:Holiday>
               <sch:Employee>
                  <sch:Number>67</sch:Number>
                  <sch:FirstName>Mahesh</sch:FirstName>
                  <sch:LastName>Kandpal</sch:LastName>
               </sch:Employee>
            </sch:HolidayRequest>
         </soapenv:Body>
      </soapenv:Envelope>
      2012-04-16 16:17:00,729 INFO [hr.service.StubHumanResourceService] - Booking holiday from [03-Mar-06] to [01-Mar-06] for employee [Mahesh Kandpal]
      2012-04-16 16:17:00,729 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Response: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas"><soapenv:Header/><soapenv:Body><sch:HolidayResponse><sch:Status>Not Booked</sch:Status><sch:Duration>-2</sch:Duration><sch:EmployeeNumber>67</sch:EmployeeNumber></sch:HolidayResponse></soapenv:Body></soapenv:Envelope>
      2012-04-16 16:17:12,039 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Request: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas">
         <soapenv:Header/>
         <soapenv:Body>
            <sch:HolidayRequest>
               <sch:Holiday>
                  <sch:StartDate>2006-03-03</sch:StartDate>
                  <sch:EndDate>2006-03-07</sch:EndDate>
               </sch:Holiday>
               <sch:Employee>
                  <sch:Number>67</sch:Number>
                  <sch:FirstName>Mahesh</sch:FirstName>
                  <sch:LastName>Kandpal</sch:LastName>
               </sch:Employee>
            </sch:HolidayRequest>
         </soapenv:Body>
      </soapenv:Envelope>
      2012-04-16 16:17:12,070 INFO [hr.service.StubHumanResourceService] - Booking holiday from [03-Mar-06] to [07-Mar-06] for employee [Mahesh Kandpal]
      2012-04-16 16:17:12,070 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Response: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas"><soapenv:Header/><soapenv:Body><sch:HolidayResponse><sch:Status>Booked</sch:Status><sch:Duration>4</sch:Duration><sch:EmployeeNumber>67</sch:EmployeeNumber></sch:HolidayResponse></soapenv:Body></soapenv:Envelope>

      I had used Xalan 2.7.1 initially with the default Sun SAAJ API as I was facing some issues w.r.t Response Payload as mentioned somewhere in the WS documentation.

      Please look into the same. I have included the POM, log4j.properties as well as the Xalan-free WAR so as to fit inside 10M limit.

      Thanks & Regards
      Mahesh

      1. holiday.war
        9.00 MB
        Mahesh Kandpal
      2. log4j.properties
        0.6 kB
        Mahesh Kandpal
      3. pom.xml
        5 kB
        Mahesh Kandpal

        Activity

        maheshkandpal Mahesh Kandpal created issue -
        arjen.poutsma Arjen Poutsma made changes -
        Field Original Value New Value
        Assignee Arjen Poutsma [ arjen.poutsma ]
        arjen.poutsma Arjen Poutsma made changes -
        Description Excerpt of Catalina log:

        Apr 16, 2012 3:33:33 PM org.apache.catalina.core.ApplicationContext log
        INFO: Initializing Spring FrameworkServlet 'spring-ws'
        2012-04-16 15:33:33,803 INFO [transport.http.MessageDispatcherServlet] - FrameworkServlet 'spring-ws': initialization started
        2012-04-16 15:33:33,991 INFO [context.support.XmlWebApplicationContext] - Refreshing WebApplicationContext for namespace 'spring-ws-servlet': startup date [Mon Apr 16 15:33:33 IST 2012]; root of context hierarchy
        2012-04-16 15:33:34,756 INFO [factory.xml.XmlBeanDefinitionReader] - Loading XML bean definitions from ServletContext resource [/WEB-INF/spring-ws-servlet.xml]
        2012-04-16 15:33:39,428 INFO [addressing.server.AnnotationActionEndpointMapping] - Supporting [WS-Addressing August 2004, WS-Addressing 1.0]
        2012-04-16 15:33:39,568 INFO [factory.support.DefaultListableBeanFactory] - Pre-instantiating singletons in org.s[email protected]188c838: defining beans [stubHumanResourceService,holidayEndpoint,org.springframework.context.annotation.internalConfigurationAnnotationProcessor,org.springframework.context.annotation.internalAutowiredAnnotationProcessor,org.springframework.context.annotation.internalRequiredAnnotationProcessor,org.springframework.context.annotation.internalCommonAnnotationProcessor,org.springframework.ws.server.endpoint.mapping.PayloadRootAnnotationMethodEndpointMapping#0,org.springframework.ws.soap.server.endpoint.mapping.SoapActionAnnotationMethodEndpointMapping#0,org.springframework.ws.soap.addressing.server.AnnotationActionEndpointMapping#0,org.springframework.ws.server.endpoint.adapter.method.dom.DomPayloadMethodProcessor#0,org.springframework.ws.server.endpoint.adapter.method.SourcePayloadMethodProcessor#0,org.springframework.ws.server.endpoint.adapter.method.dom.JDomPayloadMethodProcessor#0,org.springframework.ws.server.endpoint.adapter.DefaultMethodEndpointAdapter#0,org.springframework.ws.soap.server.endpoint.interceptor.DelegatingSmartSoapEndpointInterceptor#0,org.springframework.ws.soap.server.endpoint.interceptor.PayloadRootSmartSoapEndpointInterceptor#0,org.springframework.xml.xsd.commons.CommonsXsdSchemaCollection#0,holiday]; root of factory hierarchy
        2012-04-16 15:33:41,818 INFO [xsd.commons.CommonsXsdSchemaCollection] - Loaded ServletContext resource [/WEB-INF/holiday.xsd]
        2012-04-16 15:33:43,130 INFO [soap.saaj.SaajSoapMessageFactory] - Creating SAAJ 1.3 MessageFactory with SOAP 1.1 Protocol
        2012-04-16 15:33:43,209 INFO [transport.http.MessageDispatcherServlet] - FrameworkServlet 'spring-ws': initialization completed in 9406 ms
        2012-04-16 15:33:44,990 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Request: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas">
           <soapenv:Header/>
           <soapenv:Body>
              <sch:HolidayRequest>
                 <sch:Holiday>
                    <sch:StartDate>2006-03-03
        2012-04-16 15:33:45,224 INFO [hr.service.StubHumanResourceService] - Booking holiday from [03-Mar-06] to [07-Mar-06] for employee [Mahesh Kandpal]
        2012-04-16 15:33:45,255 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Response: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas"><soapenv:Header/><soapenv:Body><sch:HolidayResponse xmlns:sch="http://mycompany.com/hr/schemas"><sch:Status xmlns:sch="http://mycompany.com/hr/schemas">Booked
        2012-04-16 15:33:59,379 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Request: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas">
           <soapenv:Header/>
           <soapenv:Body>
              <sch:HolidayRequest>
                 <sch:Holiday>
                    <sch:StartDate>2006-03-03
        2012-04-16 15:33:59,379 INFO [hr.service.StubHumanResourceService] - Booking holiday from [03-Mar-06] to [01-Mar-06] for employee [Mahesh Kandpal]
        2012-04-16 15:33:59,379 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Response: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas"><soapenv:Header/><soapenv:Body><sch:HolidayResponse xmlns:sch="http://mycompany.com/hr/schemas"><sch:Status xmlns:sch="http://mycompany.com/hr/schemas">Not Booked
        2012-04-16 15:34:16,845 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Request: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas">
           <soapenv:Header/>
           <soapenv:Body>
              <sch:HolidayRequest>
                 <sch:Holiday>
                    <sch:StartDate>2006-03-03
        2012-04-16 15:34:16,845 INFO [hr.service.StubHumanResourceService] - Booking holiday from [03-Mar-06] to [07-Mar-06] for employee [Mahesh Kandpal]
        2012-04-16 15:34:16,845 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Response: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas"><soapenv:Header/><soapenv:Body><sch:HolidayResponse xmlns:sch="http://mycompany.com/hr/schemas"><sch:Status xmlns:sch="http://mycompany.com/hr/schemas">Booked
        2012-04-16 15:34:31,890 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Request: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas">
           <soapenv:Header/>
           <soapenv:Body>
              <sch:HolidayRequest>
                 <sch:Holiday>
                    <sch:StartDate>2006-03-03
        2012-04-16 15:34:31,890 INFO [hr.service.StubHumanResourceService] - Booking holiday from [03-Mar-06] to [07-Mar-06] for employee [Mahesh Kandpal]
        2012-04-16 15:34:31,890 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Response: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas"><soapenv:Header/><soapenv:Body><sch:HolidayResponse xmlns:sch="http://mycompany.com/hr/schemas"><sch:Status xmlns:sch="http://mycompany.com/hr/schemas">Booked


        When I exclude Xalan from the axis-saaj-api dependency, it correctly displays the request/response in the log.


        INFO: Initializing Spring FrameworkServlet 'spring-ws'
        2012-04-16 16:16:49,950 INFO [transport.http.MessageDispatcherServlet] - FrameworkServlet 'spring-ws': initialization started
        2012-04-16 16:16:49,997 INFO [context.support.XmlWebApplicationContext] - Refreshing WebApplicationContext for namespace 'spring-ws-servlet': startup date [Mon Apr 16 16:16:49 IST 2012]; root of context hierarchy
        2012-04-16 16:16:50,168 INFO [factory.xml.XmlBeanDefinitionReader] - Loading XML bean definitions from ServletContext resource [/WEB-INF/spring-ws-servlet.xml]
        2012-04-16 16:16:51,481 INFO [addressing.server.AnnotationActionEndpointMapping] - Supporting [WS-Addressing August 2004, WS-Addressing 1.0]
        2012-04-16 16:16:51,512 INFO [factory.support.DefaultListableBeanFactory] - Pre-instantiating singletons in org.s[email protected]1085e92: defining beans [stubHumanResourceService,holidayEndpoint,org.springframework.context.annotation.internalConfigurationAnnotationProcessor,org.springframework.context.annotation.internalAutowiredAnnotationProcessor,org.springframework.context.annotation.internalRequiredAnnotationProcessor,org.springframework.context.annotation.internalCommonAnnotationProcessor,org.springframework.ws.server.endpoint.mapping.PayloadRootAnnotationMethodEndpointMapping#0,org.springframework.ws.soap.server.endpoint.mapping.SoapActionAnnotationMethodEndpointMapping#0,org.springframework.ws.soap.addressing.server.AnnotationActionEndpointMapping#0,org.springframework.ws.server.endpoint.adapter.method.dom.DomPayloadMethodProcessor#0,org.springframework.ws.server.endpoint.adapter.method.SourcePayloadMethodProcessor#0,org.springframework.ws.server.endpoint.adapter.method.dom.JDomPayloadMethodProcessor#0,org.springframework.ws.server.endpoint.adapter.DefaultMethodEndpointAdapter#0,org.springframework.ws.soap.server.endpoint.interceptor.DelegatingSmartSoapEndpointInterceptor#0,org.springframework.ws.soap.server.endpoint.interceptor.PayloadRootSmartSoapEndpointInterceptor#0,org.springframework.xml.xsd.commons.CommonsXsdSchemaCollection#0,holiday]; root of factory hierarchy
        2012-04-16 16:16:52,231 INFO [xsd.commons.CommonsXsdSchemaCollection] - Loaded ServletContext resource [/WEB-INF/holiday.xsd]
        2012-04-16 16:16:52,512 INFO [soap.saaj.SaajSoapMessageFactory] - Creating SAAJ 1.3 MessageFactory with SOAP 1.1 Protocol
        2012-04-16 16:16:52,543 INFO [transport.http.MessageDispatcherServlet] - FrameworkServlet 'spring-ws': initialization completed in 2593 ms
        2012-04-16 16:16:52,902 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Request: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas">
           <soapenv:Header/>
           <soapenv:Body>
              <sch:HolidayRequest>
                 <sch:Holiday>
                    <sch:StartDate>2006-03-03</sch:StartDate>
                    <sch:EndDate>2006-03-07</sch:EndDate>
                 </sch:Holiday>
                 <sch:Employee>
                    <sch:Number>67</sch:Number>
                    <sch:FirstName>Mahesh</sch:FirstName>
                    <sch:LastName>Kandpal</sch:LastName>
                 </sch:Employee>
              </sch:HolidayRequest>
           </soapenv:Body>
        </soapenv:Envelope>
        2012-04-16 16:16:52,949 INFO [hr.service.StubHumanResourceService] - Booking holiday from [03-Mar-06] to [07-Mar-06] for employee [Mahesh Kandpal]
        2012-04-16 16:16:52,980 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Response: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas"><soapenv:Header/><soapenv:Body><sch:HolidayResponse><sch:Status>Booked</sch:Status><sch:Duration>4</sch:Duration><sch:EmployeeNumber>67</sch:EmployeeNumber></sch:HolidayResponse></soapenv:Body></soapenv:Envelope>
        2012-04-16 16:17:00,729 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Request: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas">
           <soapenv:Header/>
           <soapenv:Body>
              <sch:HolidayRequest>
                 <sch:Holiday>
                    <sch:StartDate>2006-03-03</sch:StartDate>
                    <sch:EndDate>2006-03-01</sch:EndDate>
                 </sch:Holiday>
                 <sch:Employee>
                    <sch:Number>67</sch:Number>
                    <sch:FirstName>Mahesh</sch:FirstName>
                    <sch:LastName>Kandpal</sch:LastName>
                 </sch:Employee>
              </sch:HolidayRequest>
           </soapenv:Body>
        </soapenv:Envelope>
        2012-04-16 16:17:00,729 INFO [hr.service.StubHumanResourceService] - Booking holiday from [03-Mar-06] to [01-Mar-06] for employee [Mahesh Kandpal]
        2012-04-16 16:17:00,729 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Response: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas"><soapenv:Header/><soapenv:Body><sch:HolidayResponse><sch:Status>Not Booked</sch:Status><sch:Duration>-2</sch:Duration><sch:EmployeeNumber>67</sch:EmployeeNumber></sch:HolidayResponse></soapenv:Body></soapenv:Envelope>
        2012-04-16 16:17:12,039 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Request: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas">
           <soapenv:Header/>
           <soapenv:Body>
              <sch:HolidayRequest>
                 <sch:Holiday>
                    <sch:StartDate>2006-03-03</sch:StartDate>
                    <sch:EndDate>2006-03-07</sch:EndDate>
                 </sch:Holiday>
                 <sch:Employee>
                    <sch:Number>67</sch:Number>
                    <sch:FirstName>Mahesh</sch:FirstName>
                    <sch:LastName>Kandpal</sch:LastName>
                 </sch:Employee>
              </sch:HolidayRequest>
           </soapenv:Body>
        </soapenv:Envelope>
        2012-04-16 16:17:12,070 INFO [hr.service.StubHumanResourceService] - Booking holiday from [03-Mar-06] to [07-Mar-06] for employee [Mahesh Kandpal]
        2012-04-16 16:17:12,070 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Response: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas"><soapenv:Header/><soapenv:Body><sch:HolidayResponse><sch:Status>Booked</sch:Status><sch:Duration>4</sch:Duration><sch:EmployeeNumber>67</sch:EmployeeNumber></sch:HolidayResponse></soapenv:Body></soapenv:Envelope>


        I had used Xalan 2.7.1 initially with the default Sun SAAJ API as I was facing some issues w.r.t Response Payload as mentioned somewhere in the WS documentation.

        Please look into the same. I have included the POM, log4j.properties as well as the Xalan-free WAR so as to fit inside 10M limit.

        Thanks & Regards
        Mahesh
        Excerpt of Catalina log:

        {noformat}
        Apr 16, 2012 3:33:33 PM org.apache.catalina.core.ApplicationContext log
        INFO: Initializing Spring FrameworkServlet 'spring-ws'
        2012-04-16 15:33:33,803 INFO [transport.http.MessageDispatcherServlet] - FrameworkServlet 'spring-ws': initialization started
        2012-04-16 15:33:33,991 INFO [context.support.XmlWebApplicationContext] - Refreshing WebApplicationContext for namespace 'spring-ws-servlet': startup date [Mon Apr 16 15:33:33 IST 2012]; root of context hierarchy
        2012-04-16 15:33:34,756 INFO [factory.xml.XmlBeanDefinitionReader] - Loading XML bean definitions from ServletContext resource [/WEB-INF/spring-ws-servlet.xml]
        2012-04-16 15:33:39,428 INFO [addressing.server.AnnotationActionEndpointMapping] - Supporting [WS-Addressing August 2004, WS-Addressing 1.0]
        2012-04-16 15:33:39,568 INFO [factory.support.DefaultListableBeanFactory] - Pre-instantiating singletons in org.s[email protected]188c838: defining beans [stubHumanResourceService,holidayEndpoint,org.springframework.context.annotation.internalConfigurationAnnotationProcessor,org.springframework.context.annotation.internalAutowiredAnnotationProcessor,org.springframework.context.annotation.internalRequiredAnnotationProcessor,org.springframework.context.annotation.internalCommonAnnotationProcessor,org.springframework.ws.server.endpoint.mapping.PayloadRootAnnotationMethodEndpointMapping#0,org.springframework.ws.soap.server.endpoint.mapping.SoapActionAnnotationMethodEndpointMapping#0,org.springframework.ws.soap.addressing.server.AnnotationActionEndpointMapping#0,org.springframework.ws.server.endpoint.adapter.method.dom.DomPayloadMethodProcessor#0,org.springframework.ws.server.endpoint.adapter.method.SourcePayloadMethodProcessor#0,org.springframework.ws.server.endpoint.adapter.method.dom.JDomPayloadMethodProcessor#0,org.springframework.ws.server.endpoint.adapter.DefaultMethodEndpointAdapter#0,org.springframework.ws.soap.server.endpoint.interceptor.DelegatingSmartSoapEndpointInterceptor#0,org.springframework.ws.soap.server.endpoint.interceptor.PayloadRootSmartSoapEndpointInterceptor#0,org.springframework.xml.xsd.commons.CommonsXsdSchemaCollection#0,holiday]; root of factory hierarchy
        2012-04-16 15:33:41,818 INFO [xsd.commons.CommonsXsdSchemaCollection] - Loaded ServletContext resource [/WEB-INF/holiday.xsd]
        2012-04-16 15:33:43,130 INFO [soap.saaj.SaajSoapMessageFactory] - Creating SAAJ 1.3 MessageFactory with SOAP 1.1 Protocol
        2012-04-16 15:33:43,209 INFO [transport.http.MessageDispatcherServlet] - FrameworkServlet 'spring-ws': initialization completed in 9406 ms
        2012-04-16 15:33:44,990 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Request: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas">
           <soapenv:Header/>
           <soapenv:Body>
              <sch:HolidayRequest>
                 <sch:Holiday>
                    <sch:StartDate>2006-03-03
        2012-04-16 15:33:45,224 INFO [hr.service.StubHumanResourceService] - Booking holiday from [03-Mar-06] to [07-Mar-06] for employee [Mahesh Kandpal]
        2012-04-16 15:33:45,255 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Response: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas"><soapenv:Header/><soapenv:Body><sch:HolidayResponse xmlns:sch="http://mycompany.com/hr/schemas"><sch:Status xmlns:sch="http://mycompany.com/hr/schemas">Booked
        2012-04-16 15:33:59,379 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Request: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas">
           <soapenv:Header/>
           <soapenv:Body>
              <sch:HolidayRequest>
                 <sch:Holiday>
                    <sch:StartDate>2006-03-03
        2012-04-16 15:33:59,379 INFO [hr.service.StubHumanResourceService] - Booking holiday from [03-Mar-06] to [01-Mar-06] for employee [Mahesh Kandpal]
        2012-04-16 15:33:59,379 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Response: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas"><soapenv:Header/><soapenv:Body><sch:HolidayResponse xmlns:sch="http://mycompany.com/hr/schemas"><sch:Status xmlns:sch="http://mycompany.com/hr/schemas">Not Booked
        2012-04-16 15:34:16,845 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Request: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas">
           <soapenv:Header/>
           <soapenv:Body>
              <sch:HolidayRequest>
                 <sch:Holiday>
                    <sch:StartDate>2006-03-03
        2012-04-16 15:34:16,845 INFO [hr.service.StubHumanResourceService] - Booking holiday from [03-Mar-06] to [07-Mar-06] for employee [Mahesh Kandpal]
        2012-04-16 15:34:16,845 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Response: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas"><soapenv:Header/><soapenv:Body><sch:HolidayResponse xmlns:sch="http://mycompany.com/hr/schemas"><sch:Status xmlns:sch="http://mycompany.com/hr/schemas">Booked
        2012-04-16 15:34:31,890 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Request: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas">
           <soapenv:Header/>
           <soapenv:Body>
              <sch:HolidayRequest>
                 <sch:Holiday>
                    <sch:StartDate>2006-03-03
        2012-04-16 15:34:31,890 INFO [hr.service.StubHumanResourceService] - Booking holiday from [03-Mar-06] to [07-Mar-06] for employee [Mahesh Kandpal]
        2012-04-16 15:34:31,890 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Response: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas"><soapenv:Header/><soapenv:Body><sch:HolidayResponse xmlns:sch="http://mycompany.com/hr/schemas"><sch:Status xmlns:sch="http://mycompany.com/hr/schemas">Booked
        {noformat}

        When I exclude Xalan from the axis-saaj-api dependency, it correctly displays the request/response in the log.

        {noformat}
        INFO: Initializing Spring FrameworkServlet 'spring-ws'
        2012-04-16 16:16:49,950 INFO [transport.http.MessageDispatcherServlet] - FrameworkServlet 'spring-ws': initialization started
        2012-04-16 16:16:49,997 INFO [context.support.XmlWebApplicationContext] - Refreshing WebApplicationContext for namespace 'spring-ws-servlet': startup date [Mon Apr 16 16:16:49 IST 2012]; root of context hierarchy
        2012-04-16 16:16:50,168 INFO [factory.xml.XmlBeanDefinitionReader] - Loading XML bean definitions from ServletContext resource [/WEB-INF/spring-ws-servlet.xml]
        2012-04-16 16:16:51,481 INFO [addressing.server.AnnotationActionEndpointMapping] - Supporting [WS-Addressing August 2004, WS-Addressing 1.0]
        2012-04-16 16:16:51,512 INFO [factory.support.DefaultListableBeanFactory] - Pre-instantiating singletons in org.s[email protected]1085e92: defining beans [stubHumanResourceService,holidayEndpoint,org.springframework.context.annotation.internalConfigurationAnnotationProcessor,org.springframework.context.annotation.internalAutowiredAnnotationProcessor,org.springframework.context.annotation.internalRequiredAnnotationProcessor,org.springframework.context.annotation.internalCommonAnnotationProcessor,org.springframework.ws.server.endpoint.mapping.PayloadRootAnnotationMethodEndpointMapping#0,org.springframework.ws.soap.server.endpoint.mapping.SoapActionAnnotationMethodEndpointMapping#0,org.springframework.ws.soap.addressing.server.AnnotationActionEndpointMapping#0,org.springframework.ws.server.endpoint.adapter.method.dom.DomPayloadMethodProcessor#0,org.springframework.ws.server.endpoint.adapter.method.SourcePayloadMethodProcessor#0,org.springframework.ws.server.endpoint.adapter.method.dom.JDomPayloadMethodProcessor#0,org.springframework.ws.server.endpoint.adapter.DefaultMethodEndpointAdapter#0,org.springframework.ws.soap.server.endpoint.interceptor.DelegatingSmartSoapEndpointInterceptor#0,org.springframework.ws.soap.server.endpoint.interceptor.PayloadRootSmartSoapEndpointInterceptor#0,org.springframework.xml.xsd.commons.CommonsXsdSchemaCollection#0,holiday]; root of factory hierarchy
        2012-04-16 16:16:52,231 INFO [xsd.commons.CommonsXsdSchemaCollection] - Loaded ServletContext resource [/WEB-INF/holiday.xsd]
        2012-04-16 16:16:52,512 INFO [soap.saaj.SaajSoapMessageFactory] - Creating SAAJ 1.3 MessageFactory with SOAP 1.1 Protocol
        2012-04-16 16:16:52,543 INFO [transport.http.MessageDispatcherServlet] - FrameworkServlet 'spring-ws': initialization completed in 2593 ms
        2012-04-16 16:16:52,902 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Request: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas">
           <soapenv:Header/>
           <soapenv:Body>
              <sch:HolidayRequest>
                 <sch:Holiday>
                    <sch:StartDate>2006-03-03</sch:StartDate>
                    <sch:EndDate>2006-03-07</sch:EndDate>
                 </sch:Holiday>
                 <sch:Employee>
                    <sch:Number>67</sch:Number>
                    <sch:FirstName>Mahesh</sch:FirstName>
                    <sch:LastName>Kandpal</sch:LastName>
                 </sch:Employee>
              </sch:HolidayRequest>
           </soapenv:Body>
        </soapenv:Envelope>
        2012-04-16 16:16:52,949 INFO [hr.service.StubHumanResourceService] - Booking holiday from [03-Mar-06] to [07-Mar-06] for employee [Mahesh Kandpal]
        2012-04-16 16:16:52,980 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Response: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas"><soapenv:Header/><soapenv:Body><sch:HolidayResponse><sch:Status>Booked</sch:Status><sch:Duration>4</sch:Duration><sch:EmployeeNumber>67</sch:EmployeeNumber></sch:HolidayResponse></soapenv:Body></soapenv:Envelope>
        2012-04-16 16:17:00,729 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Request: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas">
           <soapenv:Header/>
           <soapenv:Body>
              <sch:HolidayRequest>
                 <sch:Holiday>
                    <sch:StartDate>2006-03-03</sch:StartDate>
                    <sch:EndDate>2006-03-01</sch:EndDate>
                 </sch:Holiday>
                 <sch:Employee>
                    <sch:Number>67</sch:Number>
                    <sch:FirstName>Mahesh</sch:FirstName>
                    <sch:LastName>Kandpal</sch:LastName>
                 </sch:Employee>
              </sch:HolidayRequest>
           </soapenv:Body>
        </soapenv:Envelope>
        2012-04-16 16:17:00,729 INFO [hr.service.StubHumanResourceService] - Booking holiday from [03-Mar-06] to [01-Mar-06] for employee [Mahesh Kandpal]
        2012-04-16 16:17:00,729 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Response: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas"><soapenv:Header/><soapenv:Body><sch:HolidayResponse><sch:Status>Not Booked</sch:Status><sch:Duration>-2</sch:Duration><sch:EmployeeNumber>67</sch:EmployeeNumber></sch:HolidayResponse></soapenv:Body></soapenv:Envelope>
        2012-04-16 16:17:12,039 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Request: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas">
           <soapenv:Header/>
           <soapenv:Body>
              <sch:HolidayRequest>
                 <sch:Holiday>
                    <sch:StartDate>2006-03-03</sch:StartDate>
                    <sch:EndDate>2006-03-07</sch:EndDate>
                 </sch:Holiday>
                 <sch:Employee>
                    <sch:Number>67</sch:Number>
                    <sch:FirstName>Mahesh</sch:FirstName>
                    <sch:LastName>Kandpal</sch:LastName>
                 </sch:Employee>
              </sch:HolidayRequest>
           </soapenv:Body>
        </soapenv:Envelope>
        2012-04-16 16:17:12,070 INFO [hr.service.StubHumanResourceService] - Booking holiday from [03-Mar-06] to [07-Mar-06] for employee [Mahesh Kandpal]
        2012-04-16 16:17:12,070 DEBUG [endpoint.interceptor.SoapEnvelopeLoggingInterceptor] - Response: <soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/" xmlns:sch="http://mycompany.com/hr/schemas"><soapenv:Header/><soapenv:Body><sch:HolidayResponse><sch:Status>Booked</sch:Status><sch:Duration>4</sch:Duration><sch:EmployeeNumber>67</sch:EmployeeNumber></sch:HolidayResponse></soapenv:Body></soapenv:Envelope>
        {noformat}

        I had used Xalan 2.7.1 initially with the default Sun SAAJ API as I was facing some issues w.r.t Response Payload as mentioned somewhere in the WS documentation.

        Please look into the same. I have included the POM, log4j.properties as well as the Xalan-free WAR so as to fit inside 10M limit.

        Thanks & Regards
        Mahesh
        Fix Version/s 2.0.5 [ 12848 ]
        arjen.poutsma Arjen Poutsma made changes -
        Status Open [ 1 ] Resolved [ 5 ]
        Resolution Invalid [ 6 ]
        arjen.poutsma Arjen Poutsma made changes -
        Status Resolved [ 5 ] Closed [ 6 ]

          People

          • Assignee:
            arjen.poutsma Arjen Poutsma
            Reporter:
            maheshkandpal Mahesh Kandpal
          • Votes:
            0 Vote for this issue
            Watchers:
            0 Start watching this issue

            Dates

            • Created:
              Updated:
              Resolved:

              Time Tracking

              Estimated:
              Original Estimate - 2d 4.5h
              2d 4.5h
              Remaining:
              Remaining Estimate - 2d 4.5h
              2d 4.5h
              Logged:
              Time Spent - Not Specified
              Not Specified