[
https://issues.apache.org/jira/browse/CXF-7867?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=16650710#comment-16650710
]
ASF GitHub Bot commented on CXF-7867:
-------------------------------------
nddipiazza commented on issue #456: CXF-7867 - Allow the
AbstractSpnegoAuthSupplier loginConfig to be used
URL: https://github.com/apache/cxf/pull/456#issuecomment-429994506
I am new to the CXF workspace.
I have built and imported CXF into Eclipse on my own branch based on 3.2.6
I am attempting to run Junit test
org.apache.cxf.systest.kerberos.wssec.spnego.SpnegoTokenTest inside eclipse.
Upon doing so I get an error message:
```
Oct 15, 2018 7:47:39 PM
org.apache.kerby.kerberos.kerb.server.request.AsRequest issueTicket
INFO: AS_REQ ISSUE: authtime 1539650859720,al...@service.ws.apache.org for
krbtgt/service.ws.apache....@service.ws.apache.org
Oct 15, 2018 7:47:39 PM
org.apache.kerby.kerberos.kerb.server.request.TgsRequest issueTicket
INFO: TGS_REQ ISSUE: authtime 1539650859732,al...@service.ws.apache.org for
bob/service.ws.apache....@service.ws.apache.org
Oct 15, 2018 7:47:39 PM
org.apache.cxf.services.SecurityTokenService.DoubleItSpnegoSymmetricPort.spnego-client.SecurityTokenService
INFO: Outbound Message
---------------------------
ID: 5
Address: http://localhost:9001/DoubleItSpnegoSymmetric
Encoding: UTF-8
Http-Method: POST
Content-Type: text/xml
Headers: {Accept=[*/*],
SOAPAction=["http://docs.oasis-open.org/ws-sx/ws-trust/200512/RST/Issue"]}
Payload: <soap:Envelope
xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/";><soap:Header><Action
xmlns="http://www.w3.org/2005/08/addressing";>http://docs.oasis-open.org/ws-sx/ws-trust/200512/RST/Issue</Action><MessageID
xmlns="http://www.w3.org/2005/08/addressing";>urn:uuid:75d15aed-804d-4f8a-a35e-11e0ca790529</MessageID><To
xmlns="http://www.w3.org/2005/08/addressing";>http://localhost:9001/DoubleItSpnegoSymmetric</To><ReplyTo
xmlns="http://www.w3.org/2005/08/addressing";><Address>http://www.w3.org/2005/08/addressing/anonymous</Address></ReplyTo></soap:Header><soap:Body><wst:RequestSecurityToken
xmlns:wst="http://docs.oasis-open.org/ws-sx/ws-trust/200512";
Context="_11750cef-9724-4705-9651-0344c30437f8"><wst:RequestType>http://docs.oasis-open.org/ws-sx/ws-trust/200512/Issue</wst:RequestType><wsp:AppliesTo
xmlns:wsp="http://www.w3.org/ns/ws-policy";><wsa:EndpointReference
xmlns:wsa="http://www.w3.org/2005/08/addressing";><wsa:Address>http://localhost:9001/DoubleItSpnegoSymmetric</wsa:Address></wsa:EndpointReference></wsp:AppliesTo><wst:TokenType>http://docs.oasis-open.org/ws-sx/ws-secureconversation/200512/sct</wst:TokenType><wst:KeySize>256</wst:KeySize><wst:BinaryExchange
EncodingType="http://docs.oasis-open.org/wss/2004/01/oasis-200401-wss-soap-message-security-1.0#Base64Binary";
ValueType="http://docs.oasis-open.org/ws-sx/ws-trust/200512/spnego";>YIICNQYGKwYBBQUCoIICKTCCAiWgDTALBgkqhkiG9xIBAgKhBAMCATaiggIMBIICCGCCAgQGCSqGSIb3EgECAgEAboIB8zCCAe+gAwIBBaEDAgEOogcDBQAAAAAAo4IBDWGCAQkwggEFoAMCAQWhFxsVc2VydmljZS53cy5hcGFjaGUub3JnoicwJaADAgEAoR4wHBsDYm9iGxVzZXJ2aWNlLndzLmFwYWNoZS5vcmejgbswgbigAwIBEaEDAgEBooGrBIGorFpqK9AENbRc+cbhenbif4zvR2TVT0lrAAG2Wm2L10JBV8rVYmLfGJT5DevSLYzXbgLfCpT4I1Hb1Cy2P5gMoYa69u3onwQFMOHOoDIK9pnqACB+w68FpMboH9ReTaJ4kfXE1IAyVtL+UnP5bIQVm05cL+fj1hUYkEydwgP4xxXkoOq5kCVKa2iIM22yAjYst00+BWyY5ZFS44EveBf9fTUcL1Vgh8jupIHIMIHFoAMCARGigb0Egbo/VO2Znw2/N5OrizxZlM3P9MJC5rtCIauG/xBTAZ0ufIRDo+GW46U6mzL/WEmQ/NWTgS7JZatlabV9+pAAqFxRdXZ5eefb3Kl3MfP82/6xXCfRqn/20XyFb6lw0EJY2bmLG/YZHxI5224lTTeY/+dLoQ6g5J61Il+5jM7xz9lt5fjHw00JKZEIeJzvshAFzA4HZdNnwKEhQe0F1G5lEJrZN/50lhkIaM/BWR/1kJeXQthKMzqTAj3AIVE=</wst:BinaryExchange><wst:Renewing/></wst:RequestSecurityToken></soap:Body></soap:Envelope>
--------------------------------------
Oct 15, 2018 7:47:39 PM
org.apache.cxf.services.DoubleItService.DoubleItSpnegoSymmetricPort.DoubleItPortType
INFO: Inbound Message
----------------------------
ID: 6
Address: http://localhost:9001/DoubleItSpnegoSymmetric
Encoding: UTF-8
Http-Method: POST
Content-Type: text/xml; charset=UTF-8
Headers: {Accept=[*/*], Cache-Control=[no-cache], connection=[keep-alive],
Content-Length=[2210], content-type=[text/xml; charset=UTF-8],
Host=[localhost:9001], Pragma=[no-cache],
SOAPAction=["http://docs.oasis-open.org/ws-sx/ws-trust/200512/RST/Issue";],
User-Agent=[Apache-CXF/${project.version}]}
Payload: <soap:Envelope
xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/";><soap:Header><Action
xmlns="http://www.w3.org/2005/08/addressing";>http://docs.oasis-open.org/ws-sx/ws-trust/200512/RST/Issue</Action><MessageID
xmlns="http://www.w3.org/2005/08/addressing";>urn:uuid:75d15aed-804d-4f8a-a35e-11e0ca790529</MessageID><To
xmlns="http://www.w3.org/2005/08/addressing";>http://localhost:9001/DoubleItSpnegoSymmetric</To><ReplyTo
xmlns="http://www.w3.org/2005/08/addressing";><Address>http://www.w3.org/2005/08/addressing/anonymous</Address></ReplyTo></soap:Header><soap:Body><wst:RequestSecurityToken
xmlns:wst="http://docs.oasis-open.org/ws-sx/ws-trust/200512";
Context="_11750cef-9724-4705-9651-0344c30437f8"><wst:RequestType>http://docs.oasis-open.org/ws-sx/ws-trust/200512/Issue</wst:RequestType><wsp:AppliesTo
xmlns:wsp="http://www.w3.org/ns/ws-policy";><wsa:EndpointReference
xmlns:wsa="http://www.w3.org/2005/08/addressing";><wsa:Address>http://localhost:9001/DoubleItSpnegoSymmetric</wsa:Address></wsa:EndpointReference></wsp:AppliesTo><wst:TokenType>http://docs.oasis-open.org/ws-sx/ws-secureconversation/200512/sct</wst:TokenType><wst:KeySize>256</wst:KeySize><wst:BinaryExchange
EncodingType="http://docs.oasis-open.org/wss/2004/01/oasis-200401-wss-soap-message-security-1.0#Base64Binary";
ValueType="http://docs.oasis-open.org/ws-sx/ws-trust/200512/spnego";>YIICNQYGKwYBBQUCoIICKTCCAiWgDTALBgkqhkiG9xIBAgKhBAMCATaiggIMBIICCGCCAgQGCSqGSIb3EgECAgEAboIB8zCCAe+gAwIBBaEDAgEOogcDBQAAAAAAo4IBDWGCAQkwggEFoAMCAQWhFxsVc2VydmljZS53cy5hcGFjaGUub3JnoicwJaADAgEAoR4wHBsDYm9iGxVzZXJ2aWNlLndzLmFwYWNoZS5vcmejgbswgbigAwIBEaEDAgEBooGrBIGorFpqK9AENbRc+cbhenbif4zvR2TVT0lrAAG2Wm2L10JBV8rVYmLfGJT5DevSLYzXbgLfCpT4I1Hb1Cy2P5gMoYa69u3onwQFMOHOoDIK9pnqACB+w68FpMboH9ReTaJ4kfXE1IAyVtL+UnP5bIQVm05cL+fj1hUYkEydwgP4xxXkoOq5kCVKa2iIM22yAjYst00+BWyY5ZFS44EveBf9fTUcL1Vgh8jupIHIMIHFoAMCARGigb0Egbo/VO2Znw2/N5OrizxZlM3P9MJC5rtCIauG/xBTAZ0ufIRDo+GW46U6mzL/WEmQ/NWTgS7JZatlabV9+pAAqFxRdXZ5eefb3Kl3MfP82/6xXCfRqn/20XyFb6lw0EJY2bmLG/YZHxI5224lTTeY/+dLoQ6g5J61Il+5jM7xz9lt5fjHw00JKZEIeJzvshAFzA4HZdNnwKEhQe0F1G5lEJrZN/50lhkIaM/BWR/1kJeXQthKMzqTAj3AIVE=</wst:BinaryExchange><wst:Renewing/></wst:RequestSecurityToken></soap:Body></soap:Envelope>
--------------------------------------
Oct 15, 2018 7:47:39 PM
org.apache.kerby.kerberos.kerb.server.request.KdcRequest preauth
INFO: The preauth data is empty.
Oct 15, 2018 7:47:39 PM org.apache.kerby.kerberos.kerb.server.KdcHandler
handleRecoverableException
INFO: KRB error occurred while processing request: Additional
pre-authentication required
Oct 15, 2018 7:47:39 PM
org.apache.kerby.kerberos.kerb.server.request.AsRequest issueTicket
INFO: AS_REQ ISSUE: authtime
1539650859771,bob/service.ws.apache....@service.ws.apache.org for
krbtgt/service.ws.apache....@service.ws.apache.org
Oct 15, 2018 7:47:39 PM org.apache.cxf.phase.PhaseInterceptorChain
doDefaultLogging
WARNING: Interceptor for
{http://docs.oasis-open.org/ws-sx/ws-trust/200512/wsdl}SecurityTokenService#{http://docs.oasis-open.org/ws-sx/ws-trust/200512/wsdl}RequestSecurityToken
has thrown exception, unwinding now
org.apache.cxf.interceptor.Fault:
net.sf.ehcache.Element.<init>(Ljava/lang/Object;Ljava/lang/Object;II)V
at
org.apache.cxf.interceptor.ServiceInvokerInterceptor.handleMessage(ServiceInvokerInterceptor.java:144)
at
org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:308)
at
org.apache.cxf.transport.ChainInitiationObserver.onMessage(ChainInitiationObserver.java:121)
at
org.apache.cxf.transport.http.AbstractHTTPDestination.invoke(AbstractHTTPDestination.java:267)
at
org.apache.cxf.transport.http_jetty.JettyHTTPDestination.doService(JettyHTTPDestination.java:247)
at
org.apache.cxf.transport.http_jetty.JettyHTTPHandler.handle(JettyHTTPHandler.java:79)
at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:132)
at
org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:257)
at
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1317)
at
org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:205)
at
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1219)
at
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:144)
at
org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:219)
at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:132)
at org.eclipse.jetty.server.Server.handle(Server.java:531)
at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:352)
at
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:260)
at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:281)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:102)
at
org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:118)
at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:762)
at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:680)
at java.lang.Thread.run(Unknown Source)
Caused by: java.lang.NoSuchMethodError:
net.sf.ehcache.Element.<init>(Ljava/lang/Object;Ljava/lang/Object;II)V
at
org.apache.cxf.ws.security.tokenstore.EHCacheTokenStore.add(EHCacheTokenStore.java:102)
at
org.apache.cxf.ws.security.policy.interceptors.SpnegoContextTokenInInterceptor$SpnegoSTSInvoker.doIssue(SpnegoContextTokenInInterceptor.java:257)
at
org.apache.cxf.ws.security.policy.interceptors.STSInvoker.invoke(STSInvoker.java:124)
at
org.apache.cxf.ws.security.policy.interceptors.SpnegoContextTokenInInterceptor$SpnegoSTSInvoker.invoke(SpnegoContextTokenInInterceptor.java:1)
at
org.apache.cxf.interceptor.ServiceInvokerInterceptor$1.run(ServiceInvokerInterceptor.java:59)
at java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source)
at java.util.concurrent.FutureTask.run(Unknown Source)
at
org.apache.cxf.interceptor.ServiceInvokerInterceptor$2.run(ServiceInvokerInterceptor.java:126)
at
org.apache.cxf.workqueue.SynchronousExecutor.execute(SynchronousExecutor.java:37)
at
org.apache.cxf.interceptor.ServiceInvokerInterceptor.handleMessage(ServiceInvokerInterceptor.java:131)
... 22 more
Oct 15, 2018 7:47:39 PM
org.apache.cxf.services.SecurityTokenService.SecurityTokenService.SecurityTokenService
INFO: Outbound Message
---------------------------
ID: 6
Response-Code: 500
Encoding: UTF-8
Content-Type: text/xml
Headers: {}
Payload: <soap:Envelope
xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/";><soap:Body><soap:Fault><faultcode>soap:Server</faultcode><faultstring>net.sf.ehcache.Element.<init>(Ljava/lang/Object;Ljava/lang/Object;II)V</faultstring></soap:Fault></soap:Body></soap:Envelope>
--------------------------------------
Oct 15, 2018 7:47:39 PM
org.apache.cxf.services.SecurityTokenService.DoubleItSpnegoSymmetricPort.spnego-client.SecurityTokenService
INFO: Inbound Message
----------------------------
ID: 5
Response-Code: 500
Encoding: UTF-8
Content-Type: text/xml;charset=utf-8
Headers: {content-type=[text/xml;charset=utf-8], Date=[Tue, 16 Oct 2018
00:47:39 GMT], Server=[Jetty(9.4.11.v20180605)], transfer-encoding=[chunked]}
Payload: <soap:Envelope
xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/";><soap:Body><soap:Fault><faultcode>soap:Server</faultcode><faultstring>net.sf.ehcache.Element.<init>(Ljava/lang/Object;Ljava/lang/Object;II)V</faultstring></soap:Fault></soap:Body></soap:Envelope>
--------------------------------------
Oct 15, 2018 7:47:39 PM org.apache.cxf.ws.addressing.soap.MAPCodec
restoreExchange
WARNING: Response message does not contain WS-Addressing properties. Not
correlating response.
Oct 15, 2018 7:47:39 PM org.apache.cxf.ws.addressing.ContextUtils
retrieveMAPs
WARNING: WS-Addressing - failed to retrieve Message Addressing Properties
from context
Oct 15, 2018 7:47:39 PM org.apache.cxf.phase.PhaseInterceptorChain
doDefaultLogging
WARNING: Interceptor for
{http://www.example.org/contract/DoubleIt}DoubleItService#{http://www.example.org/contract/DoubleIt}DoubleIt
has thrown exception, unwinding now
org.apache.cxf.binding.soap.SoapFault:
net.sf.ehcache.Element.<init>(Ljava/lang/Object;Ljava/lang/Object;II)V
at
org.apache.cxf.binding.soap.interceptor.Soap11FaultInInterceptor.unmarshalFault(Soap11FaultInInterceptor.java:87)
at
org.apache.cxf.binding.soap.interceptor.Soap11FaultInInterceptor.handleMessage(Soap11FaultInInterceptor.java:53)
at
org.apache.cxf.binding.soap.interceptor.Soap11FaultInInterceptor.handleMessage(Soap11FaultInInterceptor.java:1)
at
org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:308)
at
org.apache.cxf.interceptor.AbstractFaultChainInitiatorObserver.onMessage(AbstractFaultChainInitiatorObserver.java:112)
at
org.apache.cxf.binding.soap.interceptor.CheckFaultInterceptor.handleMessage(CheckFaultInterceptor.java:70)
at
org.apache.cxf.binding.soap.interceptor.CheckFaultInterceptor.handleMessage(CheckFaultInterceptor.java:1)
at
org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:308)
at org.apache.cxf.endpoint.ClientImpl.onMessage(ClientImpl.java:833)
at
org.apache.cxf.transport.http.HTTPConduit$WrappedOutputStream.handleResponseInternal(HTTPConduit.java:1695)
at
org.apache.cxf.transport.http.HTTPConduit$WrappedOutputStream.handleResponse(HTTPConduit.java:1572)
at
org.apache.cxf.transport.http.HTTPConduit$WrappedOutputStream.close(HTTPConduit.java:1373)
at
org.apache.cxf.io.CacheAndWriteOutputStream.postClose(CacheAndWriteOutputStream.java:56)
at
org.apache.cxf.io.CachedOutputStream.close(CachedOutputStream.java:225)
at
org.apache.cxf.transport.AbstractConduit.close(AbstractConduit.java:56)
at
org.apache.cxf.transport.http.HTTPConduit.close(HTTPConduit.java:673)
at
org.apache.cxf.interceptor.MessageSenderInterceptor$MessageSenderEndingInterceptor.handleMessage(MessageSenderInterceptor.java:63)
at
org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:308)
at org.apache.cxf.endpoint.ClientImpl.doInvoke(ClientImpl.java:537)
at org.apache.cxf.endpoint.ClientImpl.invoke(ClientImpl.java:446)
at org.apache.cxf.endpoint.ClientImpl.invoke(ClientImpl.java:361)
at org.apache.cxf.endpoint.ClientImpl.invoke(ClientImpl.java:319)
at
org.apache.cxf.ws.security.trust.AbstractSTSClient.issue(AbstractSTSClient.java:874)
at
org.apache.cxf.ws.security.trust.STSClient.requestSecurityToken(STSClient.java:61)
at
org.apache.cxf.ws.security.trust.STSClient.requestSecurityToken(STSClient.java:55)
at
org.apache.cxf.ws.security.policy.interceptors.SpnegoContextTokenOutInterceptor.issueToken(SpnegoContextTokenOutInterceptor.java:138)
at
org.apache.cxf.ws.security.policy.interceptors.SpnegoContextTokenOutInterceptor.handleMessage(SpnegoContextTokenOutInterceptor.java:75)
at
org.apache.cxf.ws.security.policy.interceptors.SpnegoContextTokenOutInterceptor.handleMessage(SpnegoContextTokenOutInterceptor.java:1)
at
org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:308)
at org.apache.cxf.endpoint.ClientImpl.doInvoke(ClientImpl.java:537)
at org.apache.cxf.endpoint.ClientImpl.invoke(ClientImpl.java:446)
at org.apache.cxf.endpoint.ClientImpl.invoke(ClientImpl.java:361)
at org.apache.cxf.endpoint.ClientImpl.invoke(ClientImpl.java:319)
at org.apache.cxf.frontend.ClientProxy.invokeSync(ClientProxy.java:96)
at
org.apache.cxf.jaxws.JaxWsClientProxy.invoke(JaxWsClientProxy.java:140)
at com.sun.proxy.$Proxy58.doubleIt(Unknown Source)
at
org.apache.cxf.systest.kerberos.wssec.spnego.SpnegoTokenTest.runKerberosTest(SpnegoTokenTest.java:241)
at
org.apache.cxf.systest.kerberos.wssec.spnego.SpnegoTokenTest.testSpnegoOverSymmetric(SpnegoTokenTest.java:132)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
at java.lang.reflect.Method.invoke(Unknown Source)
at
org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50)
at
org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
at
org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
at
org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
at
org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27)
at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325)
at
org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:78)
at
org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:57)
at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290)
at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71)
at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288)
at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58)
at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268)
at
org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
at
org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27)
at org.junit.runners.ParentRunner.run(ParentRunner.java:363)
at
org.eclipse.jdt.internal.junit4.runner.JUnit4TestReference.run(JUnit4TestReference.java:86)
at
org.eclipse.jdt.internal.junit.runner.TestExecution.run(TestExecution.java:38)
at
org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:459)
at
org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:678)
at
org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.run(RemoteTestRunner.java:382)
at
org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.main(RemoteTestRunner.java:192)
Oct 15, 2018 7:47:39 PM
org.springframework.context.support.AbstractApplicationContext prepareRefresh
INFO: Refreshing org.apache.cxf.bus.spring.BusApplicationContext@71aaf151:
startup date [Mon Oct 15 19:47:39 CDT 2018]; root of context hierarchy
Oct 15, 2018 7:47:39 PM org.apache.cxf.bus.spring.BusApplicationContext
getConfigResources
INFO: Loaded configuration file
file:/C:/lucidworks/cxf/systests/kerberos/target/test-classes/org/apache/cxf/systest/kerberos/wssec/spnego/client.xml.
Oct 15, 2018 7:47:39 PM
org.springframework.beans.factory.xml.XmlBeanDefinitionReader
loadBeanDefinitions
INFO: Loading XML bean definitions from URL
[file:/C:/lucidworks/cxf/systests/kerberos/target/test-classes/org/apache/cxf/systest/kerberos/wssec/spnego/client.xml]
Oct 15, 2018 7:47:39 PM
org.apache.cxf.wsdl.service.factory.ReflectionServiceFactoryBean
buildServiceFromWSDL
INFO: Creating Service
{http://www.example.org/contract/DoubleIt}DoubleItService from WSDL:
file:/C:/lucidworks/cxf/systests/kerberos/target/test-classes/org/apache/cxf/systest/kerberos/wssec/spnego/DoubleItSpnego.wsdl
Oct 15, 2018 7:47:39 PM
org.apache.kerby.kerberos.kerb.server.request.KdcRequest preauth
INFO: The preauth data is empty.
Oct 15, 2018 7:47:39 PM org.apache.kerby.kerberos.kerb.server.KdcHandler
handleRecoverableException
INFO: KRB error occurred while processing request: Additional
pre-authentication required
Oct 15, 2018 7:47:39 PM
org.apache.kerby.kerberos.kerb.server.request.AsRequest issueTicket
INFO: AS_REQ ISSUE: authtime 1539650859943,al...@service.ws.apache.org for
krbtgt/service.ws.apache....@service.ws.apache.org
Oct 15, 2018 7:47:39 PM
org.apache.kerby.kerberos.kerb.server.request.TgsRequest issueTicket
INFO: TGS_REQ ISSUE: authtime 1539650859950,al...@service.ws.apache.org for
bob/service.ws.apache....@service.ws.apache.org
Oct 15, 2018 7:47:39 PM
org.apache.cxf.services.SecurityTokenService.DoubleItSpnegoSymmetricEncryptBeforeSigningPort.spnego-client.SecurityTokenService
INFO: Outbound Message
---------------------------
ID: 7
Address: http://localhost:9001/DoubleItSpnegoSymmetricEncryptBeforeSigning
Encoding: UTF-8
Http-Method: POST
Content-Type: text/xml
Headers: {Accept=[*/*],
SOAPAction=["http://docs.oasis-open.org/ws-sx/ws-trust/200512/RST/Issue"]}
Payload: <soap:Envelope
xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/";><soap:Header><Action
xmlns="http://www.w3.org/2005/08/addressing";>http://docs.oasis-open.org/ws-sx/ws-trust/200512/RST/Issue</Action><MessageID
xmlns="http://www.w3.org/2005/08/addressing";>urn:uuid:deaafdc4-737b-4aff-bc41-aca16365e62a</MessageID><To
xmlns="http://www.w3.org/2005/08/addressing";>http://localhost:9001/DoubleItSpnegoSymmetricEncryptBeforeSigning</To><ReplyTo
xmlns="http://www.w3.org/2005/08/addressing";><Address>http://www.w3.org/2005/08/addressing/anonymous</Address></ReplyTo></soap:Header><soap:Body><wst:RequestSecurityToken
xmlns:wst="http://docs.oasis-open.org/ws-sx/ws-trust/200512";
Context="_e53834a7-e4c4-4631-914b-52db11115c15"><wst:RequestType>http://docs.oasis-open.org/ws-sx/ws-trust/200512/Issue</wst:RequestType><wsp:AppliesTo
xmlns:wsp="http://www.w3.org/ns/ws-policy";><wsa:EndpointReference
xmlns:wsa="http://www.w3.org/2005/08/addressing";><wsa:Address>http://localhost:9001/DoubleItSpnegoSymmetricEncryptBeforeSigning</wsa:Address></wsa:EndpointReference></wsp:AppliesTo><wst:TokenType>http://docs.oasis-open.org/ws-sx/ws-secureconversation/200512/sct</wst:TokenType><wst:KeySize>256</wst:KeySize><wst:BinaryExchange
EncodingType="http://docs.oasis-open.org/wss/2004/01/oasis-200401-wss-soap-message-security-1.0#Base64Binary";
ValueType="http://docs.oasis-open.org/ws-sx/ws-trust/200512/spnego";>YIICNQYGKwYBBQUCoIICKTCCAiWgDTALBgkqhkiG9xIBAgKhBAMCATaiggIMBIICCGCCAgQGCSqGSIb3EgECAgEAboIB8zCCAe+gAwIBBaEDAgEOogcDBQAAAAAAo4IBDWGCAQkwggEFoAMCAQWhFxsVc2VydmljZS53cy5hcGFjaGUub3JnoicwJaADAgEAoR4wHBsDYm9iGxVzZXJ2aWNlLndzLmFwYWNoZS5vcmejgbswgbigAwIBEaEDAgEBooGrBIGo9SfQKmDEPchLjK2+NmFXkG10Cq0tmPXAdkkac19Xnx+dZvcsHvTuFbj1mhVO+a02FzpqBkn4rz2rGaBTTvkSt21/MLikuQS5l4Gfxx4hJif8XOlLF116hryGgjVLgdf5iFbZZ6+3d0tnhSmnzFpCKVKeTqBBRMMB7TzBrMUJqpCPYMYWjavWuIpDUmdGfSY4rg8ugiZrPEmAGHP0Emx6nkJ7QfSaleChpIHIMIHFoAMCARGigb0EgbomOdCABtqSTmG53UqVo9kIkz5Qaedh8vqth8YKjx7UiKOsBZjfu29xv/T7m2FZhodg3cFbHI8SkcWRJkeeX6aHxvmiAKMFksbEtsUWuzvvfSd6LsZhFdjC/KYTIrkG0imkTy62MllMNX6ee00O+r4TJA1mXAFZC9G9WmflNlV+vDNbGR79ASBEaht74HUL6qMXWCmwyvoKEJOPbnnY3aklEevnHYASZER4P7YwrEzVvQRzrEWsCpsiPU4=</wst:BinaryExchange><wst:Renewing/></wst:RequestSecurityToken></soap:Body></soap:Envelope>
--------------------------------------
Oct 15, 2018 7:47:39 PM
org.apache.cxf.services.DoubleItService.DoubleItSpnegoSymmetricEncryptBeforeSigningPort.DoubleItPortType
INFO: Inbound Message
----------------------------
ID: 8
Address: http://localhost:9001/DoubleItSpnegoSymmetricEncryptBeforeSigning
Encoding: UTF-8
Http-Method: POST
Content-Type: text/xml; charset=UTF-8
Headers: {Accept=[*/*], Cache-Control=[no-cache], connection=[keep-alive],
Content-Length=[2250], content-type=[text/xml; charset=UTF-8],
Host=[localhost:9001], Pragma=[no-cache],
SOAPAction=["http://docs.oasis-open.org/ws-sx/ws-trust/200512/RST/Issue";],
User-Agent=[Apache-CXF/${project.version}]}
Payload: <soap:Envelope
xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/";><soap:Header><Action
xmlns="http://www.w3.org/2005/08/addressing";>http://docs.oasis-open.org/ws-sx/ws-trust/200512/RST/Issue</Action><MessageID
xmlns="http://www.w3.org/2005/08/addressing";>urn:uuid:deaafdc4-737b-4aff-bc41-aca16365e62a</MessageID><To
xmlns="http://www.w3.org/2005/08/addressing";>http://localhost:9001/DoubleItSpnegoSymmetricEncryptBeforeSigning</To><ReplyTo
xmlns="http://www.w3.org/2005/08/addressing";><Address>http://www.w3.org/2005/08/addressing/anonymous</Address></ReplyTo></soap:Header><soap:Body><wst:RequestSecurityToken
xmlns:wst="http://docs.oasis-open.org/ws-sx/ws-trust/200512";
Context="_e53834a7-e4c4-4631-914b-52db11115c15"><wst:RequestType>http://docs.oasis-open.org/ws-sx/ws-trust/200512/Issue</wst:RequestType><wsp:AppliesTo
xmlns:wsp="http://www.w3.org/ns/ws-policy";><wsa:EndpointReference
xmlns:wsa="http://www.w3.org/2005/08/addressing";><wsa:Address>http://localhost:9001/DoubleItSpnegoSymmetricEncryptBeforeSigning</wsa:Address></wsa:EndpointReference></wsp:AppliesTo><wst:TokenType>http://docs.oasis-open.org/ws-sx/ws-secureconversation/200512/sct</wst:TokenType><wst:KeySize>256</wst:KeySize><wst:BinaryExchange
EncodingType="http://docs.oasis-open.org/wss/2004/01/oasis-200401-wss-soap-message-security-1.0#Base64Binary";
ValueType="http://docs.oasis-open.org/ws-sx/ws-trust/200512/spnego";>YIICNQYGKwYBBQUCoIICKTCCAiWgDTALBgkqhkiG9xIBAgKhBAMCATaiggIMBIICCGCCAgQGCSqGSIb3EgECAgEAboIB8zCCAe+gAwIBBaEDAgEOogcDBQAAAAAAo4IBDWGCAQkwggEFoAMCAQWhFxsVc2VydmljZS53cy5hcGFjaGUub3JnoicwJaADAgEAoR4wHBsDYm9iGxVzZXJ2aWNlLndzLmFwYWNoZS5vcmejgbswgbigAwIBEaEDAgEBooGrBIGo9SfQKmDEPchLjK2+NmFXkG10Cq0tmPXAdkkac19Xnx+dZvcsHvTuFbj1mhVO+a02FzpqBkn4rz2rGaBTTvkSt21/MLikuQS5l4Gfxx4hJif8XOlLF116hryGgjVLgdf5iFbZZ6+3d0tnhSmnzFpCKVKeTqBBRMMB7TzBrMUJqpCPYMYWjavWuIpDUmdGfSY4rg8ugiZrPEmAGHP0Emx6nkJ7QfSaleChpIHIMIHFoAMCARGigb0EgbomOdCABtqSTmG53UqVo9kIkz5Qaedh8vqth8YKjx7UiKOsBZjfu29xv/T7m2FZhodg3cFbHI8SkcWRJkeeX6aHxvmiAKMFksbEtsUWuzvvfSd6LsZhFdjC/KYTIrkG0imkTy62MllMNX6ee00O+r4TJA1mXAFZC9G9WmflNlV+vDNbGR79ASBEaht74HUL6qMXWCmwyvoKEJOPbnnY3aklEevnHYASZER4P7YwrEzVvQRzrEWsCpsiPU4=</wst:BinaryExchange><wst:Renewing/></wst:RequestSecurityToken></soap:Body></soap:Envelope>
--------------------------------------
Oct 15, 2018 7:47:39 PM
org.apache.kerby.kerberos.kerb.server.request.KdcRequest preauth
INFO: The preauth data is empty.
Oct 15, 2018 7:47:39 PM org.apache.kerby.kerberos.kerb.server.KdcHandler
handleRecoverableException
INFO: KRB error occurred while processing request: Additional
pre-authentication required
Oct 15, 2018 7:47:39 PM
org.apache.kerby.kerberos.kerb.server.request.AsRequest issueTicket
INFO: AS_REQ ISSUE: authtime
1539650859982,bob/service.ws.apache....@service.ws.apache.org for
krbtgt/service.ws.apache....@service.ws.apache.org
Oct 15, 2018 7:47:40 PM org.apache.cxf.phase.PhaseInterceptorChain
doDefaultLogging
WARNING: Interceptor for
{http://docs.oasis-open.org/ws-sx/ws-trust/200512/wsdl}SecurityTokenService#{http://docs.oasis-open.org/ws-sx/ws-trust/200512/wsdl}RequestSecurityToken
has thrown exception, unwinding now
org.apache.cxf.interceptor.Fault:
net.sf.ehcache.Element.<init>(Ljava/lang/Object;Ljava/lang/Object;II)V
at
org.apache.cxf.interceptor.ServiceInvokerInterceptor.handleMessage(ServiceInvokerInterceptor.java:144)
at
org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:308)
at
org.apache.cxf.transport.ChainInitiationObserver.onMessage(ChainInitiationObserver.java:121)
at
org.apache.cxf.transport.http.AbstractHTTPDestination.invoke(AbstractHTTPDestination.java:267)
at
org.apache.cxf.transport.http_jetty.JettyHTTPDestination.doService(JettyHTTPDestination.java:247)
at
org.apache.cxf.transport.http_jetty.JettyHTTPHandler.handle(JettyHTTPHandler.java:79)
at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:132)
at
org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:257)
at
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1317)
at
org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:205)
at
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1219)
at
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:144)
at
org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:219)
at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:132)
at org.eclipse.jetty.server.Server.handle(Server.java:531)
at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:352)
at
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:260)
at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:281)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:102)
at
org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:118)
at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.runTask(EatWhatYouKill.java:333)
at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:310)
at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:168)
at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:132)
at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:762)
at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:680)
at java.lang.Thread.run(Unknown Source)
Caused by: java.lang.NoSuchMethodError:
net.sf.ehcache.Element.<init>(Ljava/lang/Object;Ljava/lang/Object;II)V
at
org.apache.cxf.ws.security.tokenstore.EHCacheTokenStore.add(EHCacheTokenStore.java:102)
at
org.apache.cxf.ws.security.policy.interceptors.SpnegoContextTokenInInterceptor$SpnegoSTSInvoker.doIssue(SpnegoContextTokenInInterceptor.java:257)
at
org.apache.cxf.ws.security.policy.interceptors.STSInvoker.invoke(STSInvoker.java:124)
at
org.apache.cxf.ws.security.policy.interceptors.SpnegoContextTokenInInterceptor$SpnegoSTSInvoker.invoke(SpnegoContextTokenInInterceptor.java:1)
at
org.apache.cxf.interceptor.ServiceInvokerInterceptor$1.run(ServiceInvokerInterceptor.java:59)
at java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source)
at java.util.concurrent.FutureTask.run(Unknown Source)
at
org.apache.cxf.interceptor.ServiceInvokerInterceptor$2.run(ServiceInvokerInterceptor.java:126)
at
org.apache.cxf.workqueue.SynchronousExecutor.execute(SynchronousExecutor.java:37)
at
org.apache.cxf.interceptor.ServiceInvokerInterceptor.handleMessage(ServiceInvokerInterceptor.java:131)
... 26 more
Oct 15, 2018 7:47:40 PM
org.apache.cxf.services.SecurityTokenService.SecurityTokenService.SecurityTokenService
INFO: Outbound Message
---------------------------
ID: 8
Response-Code: 500
Encoding: UTF-8
Content-Type: text/xml
Headers: {}
Payload: <soap:Envelope
xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/";><soap:Body><soap:Fault><faultcode>soap:Server</faultcode><faultstring>net.sf.ehcache.Element.<init>(Ljava/lang/Object;Ljava/lang/Object;II)V</faultstring></soap:Fault></soap:Body></soap:Envelope>
--------------------------------------
Oct 15, 2018 7:47:40 PM
org.apache.cxf.services.SecurityTokenService.DoubleItSpnegoSymmetricEncryptBeforeSigningPort.spnego-client.SecurityTokenService
INFO: Inbound Message
----------------------------
ID: 7
Response-Code: 500
Encoding: UTF-8
Content-Type: text/xml;charset=utf-8
Headers: {content-type=[text/xml;charset=utf-8], Date=[Tue, 16 Oct 2018
00:47:39 GMT], Server=[Jetty(9.4.11.v20180605)], transfer-encoding=[chunked]}
Payload: <soap:Envelope
xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/";><soap:Body><soap:Fault><faultcode>soap:Server</faultcode><faultstring>net.sf.ehcache.Element.<init>(Ljava/lang/Object;Ljava/lang/Object;II)V</faultstring></soap:Fault></soap:Body></soap:Envelope>
--------------------------------------
Oct 15, 2018 7:47:40 PM org.apache.cxf.ws.addressing.soap.MAPCodec
restoreExchange
WARNING: Response message does not contain WS-Addressing properties. Not
correlating response.
Oct 15, 2018 7:47:40 PM org.apache.cxf.ws.addressing.ContextUtils
retrieveMAPs
WARNING: WS-Addressing - failed to retrieve Message Addressing Properties
from context
Oct 15, 2018 7:47:40 PM org.apache.cxf.phase.PhaseInterceptorChain
doDefaultLogging
WARNING: Interceptor for
{http://www.example.org/contract/DoubleIt}DoubleItService#{http://www.example.org/contract/DoubleIt}DoubleIt
has thrown exception, unwinding now
org.apache.cxf.binding.soap.SoapFault:
net.sf.ehcache.Element.<init>(Ljava/lang/Object;Ljava/lang/Object;II)V
at
org.apache.cxf.binding.soap.interceptor.Soap11FaultInInterceptor.unmarshalFault(Soap11FaultInInterceptor.java:87)
at
org.apache.cxf.binding.soap.interceptor.Soap11FaultInInterceptor.handleMessage(Soap11FaultInInterceptor.java:53)
at
org.apache.cxf.binding.soap.interceptor.Soap11FaultInInterceptor.handleMessage(Soap11FaultInInterceptor.java:1)
at
org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:308)
at
org.apache.cxf.interceptor.AbstractFaultChainInitiatorObserver.onMessage(AbstractFaultChainInitiatorObserver.java:112)
at
org.apache.cxf.binding.soap.interceptor.CheckFaultInterceptor.handleMessage(CheckFaultInterceptor.java:70)
at
org.apache.cxf.binding.soap.interceptor.CheckFaultInterceptor.handleMessage(CheckFaultInterceptor.java:1)
at
org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:308)
at org.apache.cxf.endpoint.ClientImpl.onMessage(ClientImpl.java:833)
at
org.apache.cxf.transport.http.HTTPConduit$WrappedOutputStream.handleResponseInternal(HTTPConduit.java:1695)
at
org.apache.cxf.transport.http.HTTPConduit$WrappedOutputStream.handleResponse(HTTPConduit.java:1572)
at
org.apache.cxf.transport.http.HTTPConduit$WrappedOutputStream.close(HTTPConduit.java:1373)
at
org.apache.cxf.io.CacheAndWriteOutputStream.postClose(CacheAndWriteOutputStream.java:56)
at
org.apache.cxf.io.CachedOutputStream.close(CachedOutputStream.java:225)
at
org.apache.cxf.transport.AbstractConduit.close(AbstractConduit.java:56)
at
org.apache.cxf.transport.http.HTTPConduit.close(HTTPConduit.java:673)
at
org.apache.cxf.interceptor.MessageSenderInterceptor$MessageSenderEndingInterceptor.handleMessage(MessageSenderInterceptor.java:63)
at
org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:308)
at org.apache.cxf.endpoint.ClientImpl.doInvoke(ClientImpl.java:537)
at org.apache.cxf.endpoint.ClientImpl.invoke(ClientImpl.java:446)
at org.apache.cxf.endpoint.ClientImpl.invoke(ClientImpl.java:361)
at org.apache.cxf.endpoint.ClientImpl.invoke(ClientImpl.java:319)
at
org.apache.cxf.ws.security.trust.AbstractSTSClient.issue(AbstractSTSClient.java:874)
at
org.apache.cxf.ws.security.trust.STSClient.requestSecurityToken(STSClient.java:61)
at
org.apache.cxf.ws.security.trust.STSClient.requestSecurityToken(STSClient.java:55)
at
org.apache.cxf.ws.security.policy.interceptors.SpnegoContextTokenOutInterceptor.issueToken(SpnegoContextTokenOutInterceptor.java:138)
at
org.apache.cxf.ws.security.policy.interceptors.SpnegoContextTokenOutInterceptor.handleMessage(SpnegoContextTokenOutInterceptor.java:75)
at
org.apache.cxf.ws.security.policy.interceptors.SpnegoContextTokenOutInterceptor.handleMessage(SpnegoContextTokenOutInterceptor.java:1)
at
org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:308)
at org.apache.cxf.endpoint.ClientImpl.doInvoke(ClientImpl.java:537)
at org.apache.cxf.endpoint.ClientImpl.invoke(ClientImpl.java:446)
at org.apache.cxf.endpoint.ClientImpl.invoke(ClientImpl.java:361)
at org.apache.cxf.endpoint.ClientImpl.invoke(ClientImpl.java:319)
at org.apache.cxf.frontend.ClientProxy.invokeSync(ClientProxy.java:96)
at
org.apache.cxf.jaxws.JaxWsClientProxy.invoke(JaxWsClientProxy.java:140)
at com.sun.proxy.$Proxy58.doubleIt(Unknown Source)
at
org.apache.cxf.systest.kerberos.wssec.spnego.SpnegoTokenTest.runKerberosTest(SpnegoTokenTest.java:241)
at
org.apache.cxf.systest.kerberos.wssec.spnego.SpnegoTokenTest.testSpnegoOverSymmetricEncryptBeforeSigning(SpnegoTokenTest.java:158)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
at java.lang.reflect.Method.invoke(Unknown Source)
at
org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50)
at
org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
at
org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
at
org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
at
org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27)
at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325)
at
org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:78)
at
org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:57)
at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290)
at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71)
at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288)
at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58)
at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268)
at
org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
at
org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27)
at org.junit.runners.ParentRunner.run(ParentRunner.java:363)
at
org.eclipse.jdt.internal.junit4.runner.JUnit4TestReference.run(JUnit4TestReference.java:86)
at
org.eclipse.jdt.internal.junit.runner.TestExecution.run(TestExecution.java:38)
at
org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:459)
at
org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:678)
at
org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.run(RemoteTestRunner.java:382)
at
org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.main(RemoteTestRunner.java:192)
Oct 15, 2018 7:47:40 PM
org.springframework.context.support.AbstractApplicationContext prepareRefresh
INFO: Refreshing org.apache.cxf.bus.spring.BusApplicationContext@415a3f6a:
startup date [Mon Oct 15 19:47:40 CDT 2018]; root of context hierarchy
Oct 15, 2018 7:47:40 PM org.apache.cxf.bus.spring.BusApplicationContext
getConfigResources
INFO: Loaded configuration file
file:/C:/lucidworks/cxf/systests/kerberos/target/test-classes/org/apache/cxf/systest/kerberos/wssec/spnego/client.xml.
Oct 15, 2018 7:47:40 PM
org.springframework.beans.factory.xml.XmlBeanDefinitionReader
loadBeanDefinitions
INFO: Loading XML bean definitions from URL
[file:/C:/lucidworks/cxf/systests/kerberos/target/test-classes/org/apache/cxf/systest/kerberos/wssec/spnego/client.xml]
Oct 15, 2018 7:47:40 PM
org.apache.cxf.wsdl.service.factory.ReflectionServiceFactoryBean
buildServiceFromWSDL
INFO: Creating Service
{http://www.example.org/contract/DoubleIt}DoubleItService from WSDL:
file:/C:/lucidworks/cxf/systests/kerberos/target/test-classes/org/apache/cxf/systest/kerberos/wssec/spnego/DoubleItSpnego.wsdl
Oct 15, 2018 7:47:40 PM
org.apache.kerby.kerberos.kerb.server.request.KdcRequest preauth
INFO: The preauth data is empty.
Oct 15, 2018 7:47:40 PM org.apache.kerby.kerberos.kerb.server.KdcHandler
handleRecoverableException
INFO: KRB error occurred while processing request: Additional
pre-authentication required
Oct 15, 2018 7:47:40 PM
org.apache.kerby.kerberos.kerb.server.request.AsRequest issueTicket
INFO: AS_REQ ISSUE: authtime 1539650860139,al...@service.ws.apache.org for
krbtgt/service.ws.apache....@service.ws.apache.org
Oct 15, 2018 7:47:40 PM
org.apache.kerby.kerberos.kerb.server.request.TgsRequest issueTicket
INFO: TGS_REQ ISSUE: authtime 1539650860147,al...@service.ws.apache.org for
bob/service.ws.apache....@service.ws.apache.org
Oct 15, 2018 7:47:40 PM
org.apache.cxf.services.SecurityTokenService.DoubleItSpnegoTransportPort.spnego-client.SecurityTokenService
INFO: Outbound Message
---------------------------
ID: 9
Address: https://localhost:9003/DoubleItSpnegoTransport
Encoding: UTF-8
Http-Method: POST
Content-Type: text/xml
Headers: {Accept=[*/*],
SOAPAction=["http://docs.oasis-open.org/ws-sx/ws-trust/200512/RST/Issue"]}
Payload: <soap:Envelope
xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/";><soap:Header><Action
xmlns="http://www.w3.org/2005/08/addressing";>http://docs.oasis-open.org/ws-sx/ws-trust/200512/RST/Issue</Action><MessageID
xmlns="http://www.w3.org/2005/08/addressing";>urn:uuid:53420084-fcf4-44eb-9de1-e2ab8112f703</MessageID><To
xmlns="http://www.w3.org/2005/08/addressing";>https://localhost:9003/DoubleItSpnegoTransport</To><ReplyTo
xmlns="http://www.w3.org/2005/08/addressing";><Address>http://www.w3.org/2005/08/addressing/anonymous</Address></ReplyTo></soap:Header><soap:Body><wst:RequestSecurityToken
xmlns:wst="http://docs.oasis-open.org/ws-sx/ws-trust/200512";
Context="_d738bf9a-4ece-42f6-a638-96151f4b345b"><wst:RequestType>http://docs.oasis-open.org/ws-sx/ws-trust/200512/Issue</wst:RequestType><wsp:AppliesTo
xmlns:wsp="http://www.w3.org/ns/ws-policy";><wsa:EndpointReference
xmlns:wsa="http://www.w3.org/2005/08/addressing";><wsa:Address>https://localhost:9003/DoubleItSpnegoTransport</wsa:Address></wsa:EndpointReference></wsp:AppliesTo><wst:TokenType>http://docs.oasis-open.org/ws-sx/ws-secureconversation/200512/sct</wst:TokenType><wst:KeySize>256</wst:KeySize><wst:BinaryExchange
EncodingType="http://docs.oasis-open.org/wss/2004/01/oasis-200401-wss-soap-message-security-1.0#Base64Binary";
ValueType="http://docs.oasis-open.org/ws-sx/ws-trust/200512/spnego";>YIICNQYGKwYBBQUCoIICKTCCAiWgDTALBgkqhkiG9xIBAgKhBAMCATaiggIMBIICCGCCAgQGCSqGSIb3EgECAgEAboIB8zCCAe+gAwIBBaEDAgEOogcDBQAAAAAAo4IBDWGCAQkwggEFoAMCAQWhFxsVc2VydmljZS53cy5hcGFjaGUub3JnoicwJaADAgEAoR4wHBsDYm9iGxVzZXJ2aWNlLndzLmFwYWNoZS5vcmejgbswgbigAwIBEaEDAgEBooGrBIGo6p5mQF7aPJ2Pb2NMwaaB3wn6lFQhvuOGMc3VopdvP4ERYDU5MheYTSCIxMhkc8Pll4zQ/OdSi1/emYTCNFUS3K7f3zTo6uc1/ekpbL7mlzDpT9nXEzqnyFSBavL8H+iZ/PFN4y0bnDIQLnifN/d5FgRxdc+bN58yQgsH2ZLqDZFk4qBehA55Bl8BnfSfeoIULRXjxC3DIBY3f1Eqtwj/cZw6nEREaQyapIHIMIHFoAMCARGigb0Egboqm/8zY2IFdeIv7IaHNS83MoiGSTmIvaorB17fkVp3UneCL0H14AFFpBsKrBLqnioVKa2wy0i04DSmrSi28MU2vhdfMnoTJRK1K5uvk3SUwifsMAQorrt/w0rRsb82ZYTdtBpd9bStt0nkBvOAGaAQRrZOQuix3EqqqGBzu2bC4dGeYH/pLKuQhAOZ5eGfF3HZE5IGV3jRM9EQxv2+LYRx+na6LK2UfoD2tuR29meIVpfYcrE70yqUfiM=</wst:BinaryExchange><wst:Renewing/></wst:RequestSecurityToken></soap:Body></soap:Envelope>
--------------------------------------
Oct 15, 2018 7:47:40 PM
org.apache.cxf.services.DoubleItService.DoubleItSpnegoTransportPort.DoubleItPortType
INFO: Inbound Message
----------------------------
ID: 10
Address: https://localhost:9003/DoubleItSpnegoTransport
Encoding: UTF-8
Http-Method: POST
Content-Type: text/xml; charset=UTF-8
Headers: {Accept=[*/*], Cache-Control=[no-cache], connection=[keep-alive],
Content-Length=[2212], content-type=[text/xml; charset=UTF-8],
Host=[localhost:9003], Pragma=[no-cache],
SOAPAction=["http://docs.oasis-open.org/ws-sx/ws-trust/200512/RST/Issue";],
User-Agent=[Apache-CXF/${project.version}]}
Payload: <soap:Envelope
xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/";><soap:Header><Action
xmlns="http://www.w3.org/2005/08/addressing";>http://docs.oasis-open.org/ws-sx/ws-trust/200512/RST/Issue</Action><MessageID
xmlns="http://www.w3.org/2005/08/addressing";>urn:uuid:53420084-fcf4-44eb-9de1-e2ab8112f703</MessageID><To
xmlns="http://www.w3.org/2005/08/addressing";>https://localhost:9003/DoubleItSpnegoTransport</To><ReplyTo
xmlns="http://www.w3.org/2005/08/addressing";><Address>http://www.w3.org/2005/08/addressing/anonymous</Address></ReplyTo></soap:Header><soap:Body><wst:RequestSecurityToken
xmlns:wst="http://docs.oasis-open.org/ws-sx/ws-trust/200512";
Context="_d738bf9a-4ece-42f6-a638-96151f4b345b"><wst:RequestType>http://docs.oasis-open.org/ws-sx/ws-trust/200512/Issue</wst:RequestType><wsp:AppliesTo
xmlns:wsp="http://www.w3.org/ns/ws-policy";><wsa:EndpointReference
xmlns:wsa="http://www.w3.org/2005/08/addressing";><wsa:Address>https://localhost:9003/DoubleItSpnegoTransport</wsa:Address></wsa:EndpointReference></wsp:AppliesTo><wst:TokenType>http://docs.oasis-open.org/ws-sx/ws-secureconversation/200512/sct</wst:TokenType><wst:KeySize>256</wst:KeySize><wst:BinaryExchange
EncodingType="http://docs.oasis-open.org/wss/2004/01/oasis-200401-wss-soap-message-security-1.0#Base64Binary";
ValueType="http://docs.oasis-open.org/ws-sx/ws-trust/200512/spnego";>YIICNQYGKwYBBQUCoIICKTCCAiWgDTALBgkqhkiG9xIBAgKhBAMCATaiggIMBIICCGCCAgQGCSqGSIb3EgECAgEAboIB8zCCAe+gAwIBBaEDAgEOogcDBQAAAAAAo4IBDWGCAQkwggEFoAMCAQWhFxsVc2VydmljZS53cy5hcGFjaGUub3JnoicwJaADAgEAoR4wHBsDYm9iGxVzZXJ2aWNlLndzLmFwYWNoZS5vcmejgbswgbigAwIBEaEDAgEBooGrBIGo6p5mQF7aPJ2Pb2NMwaaB3wn6lFQhvuOGMc3VopdvP4ERYDU5MheYTSCIxMhkc8Pll4zQ/OdSi1/emYTCNFUS3K7f3zTo6uc1/ekpbL7mlzDpT9nXEzqnyFSBavL8H+iZ/PFN4y0bnDIQLnifN/d5FgRxdc+bN58yQgsH2ZLqDZFk4qBehA55Bl8BnfSfeoIULRXjxC3DIBY3f1Eqtwj/cZw6nEREaQyapIHIMIHFoAMCARGigb0Egboqm/8zY2IFdeIv7IaHNS83MoiGSTmIvaorB17fkVp3UneCL0H14AFFpBsKrBLqnioVKa2wy0i04DSmrSi28MU2vhdfMnoTJRK1K5uvk3SUwifsMAQorrt/w0rRsb82ZYTdtBpd9bStt0nkBvOAGaAQRrZOQuix3EqqqGBzu2bC4dGeYH/pLKuQhAOZ5eGfF3HZE5IGV3jRM9EQxv2+LYRx+na6LK2UfoD2tuR29meIVpfYcrE70yqUfiM=</wst:BinaryExchange><wst:Renewing/></wst:RequestSecurityToken></soap:Body></soap:Envelope>
--------------------------------------
Oct 15, 2018 7:47:40 PM
org.apache.kerby.kerberos.kerb.server.request.KdcRequest preauth
INFO: The preauth data is empty.
Oct 15, 2018 7:47:40 PM org.apache.kerby.kerberos.kerb.server.KdcHandler
handleRecoverableException
INFO: KRB error occurred while processing request: Additional
pre-authentication required
Oct 15, 2018 7:47:40 PM
org.apache.kerby.kerberos.kerb.server.request.AsRequest issueTicket
INFO: AS_REQ ISSUE: authtime
1539650860203,bob/service.ws.apache....@service.ws.apache.org for
krbtgt/service.ws.apache....@service.ws.apache.org
Oct 15, 2018 7:47:40 PM org.apache.cxf.phase.PhaseInterceptorChain
doDefaultLogging
WARNING: Interceptor for
{http://docs.oasis-open.org/ws-sx/ws-trust/200512/wsdl}SecurityTokenService#{http://docs.oasis-open.org/ws-sx/ws-trust/200512/wsdl}RequestSecurityToken
has thrown exception, unwinding now
org.apache.cxf.interceptor.Fault:
net.sf.ehcache.Element.<init>(Ljava/lang/Object;Ljava/lang/Object;II)V
at
org.apache.cxf.interceptor.ServiceInvokerInterceptor.handleMessage(ServiceInvokerInterceptor.java:144)
at
org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:308)
at
org.apache.cxf.transport.ChainInitiationObserver.onMessage(ChainInitiationObserver.java:121)
at
org.apache.cxf.transport.http.AbstractHTTPDestination.invoke(AbstractHTTPDestination.java:267)
at
org.apache.cxf.transport.http_jetty.JettyHTTPDestination.doService(JettyHTTPDestination.java:247)
at
org.apache.cxf.transport.http_jetty.JettyHTTPHandler.handle(JettyHTTPHandler.java:79)
at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:132)
at
org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:257)
at
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1317)
at
org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:205)
at
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1219)
at
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:144)
at
org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:219)
at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:132)
at org.eclipse.jetty.server.Server.handle(Server.java:531)
at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:352)
at
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:260)
at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:281)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:102)
at
org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:291)
at
org.eclipse.jetty.io.ssl.SslConnection$3.succeeded(SslConnection.java:151)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:102)
at
org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:118)
at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.runTask(EatWhatYouKill.java:333)
at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:310)
at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:168)
at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.run(EatWhatYouKill.java:126)
at
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:366)
at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:762)
at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:680)
at java.lang.Thread.run(Unknown Source)
Caused by: java.lang.NoSuchMethodError:
net.sf.ehcache.Element.<init>(Ljava/lang/Object;Ljava/lang/Object;II)V
at
org.apache.cxf.ws.security.tokenstore.EHCacheTokenStore.add(EHCacheTokenStore.java:102)
at
org.apache.cxf.ws.security.policy.interceptors.SpnegoContextTokenInInterceptor$SpnegoSTSInvoker.doIssue(SpnegoContextTokenInInterceptor.java:257)
at
org.apache.cxf.ws.security.policy.interceptors.STSInvoker.invoke(STSInvoker.java:124)
at
org.apache.cxf.ws.security.policy.interceptors.SpnegoContextTokenInInterceptor$SpnegoSTSInvoker.invoke(SpnegoContextTokenInInterceptor.java:1)
at
org.apache.cxf.interceptor.ServiceInvokerInterceptor$1.run(ServiceInvokerInterceptor.java:59)
at java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source)
at java.util.concurrent.FutureTask.run(Unknown Source)
at
org.apache.cxf.interceptor.ServiceInvokerInterceptor$2.run(ServiceInvokerInterceptor.java:126)
at
org.apache.cxf.workqueue.SynchronousExecutor.execute(SynchronousExecutor.java:37)
at
org.apache.cxf.interceptor.ServiceInvokerInterceptor.handleMessage(ServiceInvokerInterceptor.java:131)
... 30 more
Oct 15, 2018 7:47:40 PM
org.apache.cxf.services.SecurityTokenService.SecurityTokenService.SecurityTokenService
INFO: Outbound Message
---------------------------
ID: 10
Response-Code: 500
Encoding: UTF-8
Content-Type: text/xml
Headers: {}
Payload: <soap:Envelope
xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/";><soap:Body><soap:Fault><faultcode>soap:Server</faultcode><faultstring>net.sf.ehcache.Element.<init>(Ljava/lang/Object;Ljava/lang/Object;II)V</faultstring></soap:Fault></soap:Body></soap:Envelope>
--------------------------------------
Oct 15, 2018 7:47:40 PM
org.apache.cxf.services.SecurityTokenService.DoubleItSpnegoTransportPort.spnego-client.SecurityTokenService
INFO: Inbound Message
----------------------------
ID: 9
Response-Code: 500
Encoding: UTF-8
Content-Type: text/xml;charset=utf-8
Headers: {content-type=[text/xml;charset=utf-8], Date=[Tue, 16 Oct 2018
00:47:40 GMT], Server=[Jetty(9.4.11.v20180605)], transfer-encoding=[chunked]}
Payload: <soap:Envelope
xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/";><soap:Body><soap:Fault><faultcode>soap:Server</faultcode><faultstring>net.sf.ehcache.Element.<init>(Ljava/lang/Object;Ljava/lang/Object;II)V</faultstring></soap:Fault></soap:Body></soap:Envelope>
--------------------------------------
Oct 15, 2018 7:47:40 PM org.apache.cxf.ws.addressing.soap.MAPCodec
restoreExchange
WARNING: Response message does not contain WS-Addressing properties. Not
correlating response.
Oct 15, 2018 7:47:40 PM org.apache.cxf.ws.addressing.ContextUtils
retrieveMAPs
WARNING: WS-Addressing - failed to retrieve Message Addressing Properties
from context
Oct 15, 2018 7:47:40 PM org.apache.cxf.phase.PhaseInterceptorChain
doDefaultLogging
WARNING: Interceptor for
{http://www.example.org/contract/DoubleIt}DoubleItService#{http://www.example.org/contract/DoubleIt}DoubleIt
has thrown exception, unwinding now
org.apache.cxf.binding.soap.SoapFault:
net.sf.ehcache.Element.<init>(Ljava/lang/Object;Ljava/lang/Object;II)V
at
org.apache.cxf.binding.soap.interceptor.Soap11FaultInInterceptor.unmarshalFault(Soap11FaultInInterceptor.java:87)
at
org.apache.cxf.binding.soap.interceptor.Soap11FaultInInterceptor.handleMessage(Soap11FaultInInterceptor.java:53)
at
org.apache.cxf.binding.soap.interceptor.Soap11FaultInInterceptor.handleMessage(Soap11FaultInInterceptor.java:1)
at
org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:308)
at
org.apache.cxf.interceptor.AbstractFaultChainInitiatorObserver.onMessage(AbstractFaultChainInitiatorObserver.java:112)
at
org.apache.cxf.binding.soap.interceptor.CheckFaultInterceptor.handleMessage(CheckFaultInterceptor.java:70)
at
org.apache.cxf.binding.soap.interceptor.CheckFaultInterceptor.handleMessage(CheckFaultInterceptor.java:1)
at
org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:308)
at org.apache.cxf.endpoint.ClientImpl.onMessage(ClientImpl.java:833)
at
org.apache.cxf.transport.http.HTTPConduit$WrappedOutputStream.handleResponseInternal(HTTPConduit.java:1695)
at
org.apache.cxf.transport.http.HTTPConduit$WrappedOutputStream.handleResponse(HTTPConduit.java:1572)
at
org.apache.cxf.transport.http.HTTPConduit$WrappedOutputStream.close(HTTPConduit.java:1373)
at
org.apache.cxf.io.CacheAndWriteOutputStream.postClose(CacheAndWriteOutputStream.java:56)
at
org.apache.cxf.io.CachedOutputStream.close(CachedOutputStream.java:225)
at
org.apache.cxf.transport.AbstractConduit.close(AbstractConduit.java:56)
at
org.apache.cxf.transport.http.HTTPConduit.close(HTTPConduit.java:673)
at
org.apache.cxf.interceptor.MessageSenderInterceptor$MessageSenderEndingInterceptor.handleMessage(MessageSenderInterceptor.java:63)
at
org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:308)
at org.apache.cxf.endpoint.ClientImpl.doInvoke(ClientImpl.java:537)
at org.apache.cxf.endpoint.ClientImpl.invoke(ClientImpl.java:446)
at org.apache.cxf.endpoint.ClientImpl.invoke(ClientImpl.java:361)
at org.apache.cxf.endpoint.ClientImpl.invoke(ClientImpl.java:319)
at
org.apache.cxf.ws.security.trust.AbstractSTSClient.issue(AbstractSTSClient.java:874)
at
org.apache.cxf.ws.security.trust.STSClient.requestSecurityToken(STSClient.java:61)
at
org.apache.cxf.ws.security.trust.STSClient.requestSecurityToken(STSClient.java:55)
at
org.apache.cxf.ws.security.policy.interceptors.SpnegoContextTokenOutInterceptor.issueToken(SpnegoContextTokenOutInterceptor.java:138)
at
org.apache.cxf.ws.security.policy.interceptors.SpnegoContextTokenOutInterceptor.handleMessage(SpnegoContextTokenOutInterceptor.java:75)
at
org.apache.cxf.ws.security.policy.interceptors.SpnegoContextTokenOutInterceptor.handleMessage(SpnegoContextTokenOutInterceptor.java:1)
at
org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:308)
at org.apache.cxf.endpoint.ClientImpl.doInvoke(ClientImpl.java:537)
at org.apache.cxf.endpoint.ClientImpl.invoke(ClientImpl.java:446)
at org.apache.cxf.endpoint.ClientImpl.invoke(ClientImpl.java:361)
at org.apache.cxf.endpoint.ClientImpl.invoke(ClientImpl.java:319)
at org.apache.cxf.frontend.ClientProxy.invokeSync(ClientProxy.java:96)
at
org.apache.cxf.jaxws.JaxWsClientProxy.invoke(JaxWsClientProxy.java:140)
at com.sun.proxy.$Proxy58.doubleIt(Unknown Source)
at
org.apache.cxf.systest.kerberos.wssec.spnego.SpnegoTokenTest.runKerberosTest(SpnegoTokenTest.java:241)
at
org.apache.cxf.systest.kerberos.wssec.spnego.SpnegoTokenTest.testSpnegoOverTransport(SpnegoTokenTest.java:171)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
at java.lang.reflect.Method.invoke(Unknown Source)
at
org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50)
at
org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
at
org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
at
org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
at
org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27)
at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325)
at
org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:78)
at
org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:57)
at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290)
at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71)
at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288)
at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58)
at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268)
at
org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
at
org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27)
at org.junit.runners.ParentRunner.run(ParentRunner.java:363)
at
org.eclipse.jdt.internal.junit4.runner.JUnit4TestReference.run(JUnit4TestReference.java:86)
at
org.eclipse.jdt.internal.junit.runner.TestExecution.run(TestExecution.java:38)
at
org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:459)
at
org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:678)
at
org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.run(RemoteTestRunner.java:382)
at
org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.main(RemoteTestRunner.java:192)
Oct 15, 2018 7:47:40 PM
org.springframework.context.support.AbstractApplicationContext prepareRefresh
INFO: Refreshing org.apache.cxf.bus.spring.BusApplicationContext@119290b9:
startup date [Mon Oct 15 19:47:40 CDT 2018]; root of context hierarchy
Oct 15, 2018 7:47:40 PM org.apache.cxf.bus.spring.BusApplicationContext
getConfigResources
INFO: Loaded configuration file
file:/C:/lucidworks/cxf/systests/kerberos/target/test-classes/org/apache/cxf/systest/kerberos/wssec/spnego/client.xml.
Oct 15, 2018 7:47:40 PM
org.springframework.beans.factory.xml.XmlBeanDefinitionReader
loadBeanDefinitions
INFO: Loading XML bean definitions from URL
[file:/C:/lucidworks/cxf/systests/kerberos/target/test-classes/org/apache/cxf/systest/kerberos/wssec/spnego/client.xml]
Oct 15, 2018 7:47:40 PM
org.apache.cxf.wsdl.service.factory.ReflectionServiceFactoryBean
buildServiceFromWSDL
INFO: Creating Service
{http://www.example.org/contract/DoubleIt}DoubleItService from WSDL:
file:/C:/lucidworks/cxf/systests/kerberos/target/test-classes/org/apache/cxf/systest/kerberos/wssec/spnego/DoubleItSpnego.wsdl
Oct 15, 2018 7:47:40 PM
org.apache.kerby.kerberos.kerb.server.request.KdcRequest preauth
INFO: The preauth data is empty.
Oct 15, 2018 7:47:40 PM org.apache.kerby.kerberos.kerb.server.KdcHandler
handleRecoverableException
INFO: KRB error occurred while processing request: Additional
pre-authentication required
Oct 15, 2018 7:47:40 PM
org.apache.kerby.kerberos.kerb.server.request.AsRequest issueTicket
INFO: AS_REQ ISSUE: authtime 1539650860353,al...@service.ws.apache.org for
krbtgt/service.ws.apache....@service.ws.apache.org
Oct 15, 2018 7:47:40 PM
org.apache.kerby.kerberos.kerb.server.request.TgsRequest issueTicket
INFO: TGS_REQ ISSUE: authtime 1539650860363,al...@service.ws.apache.org for
bob/service.ws.apache....@service.ws.apache.org
Oct 15, 2018 7:47:40 PM
org.apache.cxf.services.SecurityTokenService.DoubleItSpnegoSymmetricDerivedPort.spnego-client.SecurityTokenService
INFO: Outbound Message
---------------------------
ID: 11
Address: http://localhost:9001/DoubleItSpnegoSymmetricDerived
Encoding: UTF-8
Http-Method: POST
Content-Type: text/xml
Headers: {Accept=[*/*],
SOAPAction=["http://docs.oasis-open.org/ws-sx/ws-trust/200512/RST/Issue"]}
Payload: <soap:Envelope
xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/";><soap:Header><Action
xmlns="http://www.w3.org/2005/08/addressing";>http://docs.oasis-open.org/ws-sx/ws-trust/200512/RST/Issue</Action><MessageID
xmlns="http://www.w3.org/2005/08/addressing";>urn:uuid:01875216-b23d-4a8b-bbb8-8de1a4b7b90f</MessageID><To
xmlns="http://www.w3.org/2005/08/addressing";>http://localhost:9001/DoubleItSpnegoSymmetricDerived</To><ReplyTo
xmlns="http://www.w3.org/2005/08/addressing";><Address>http://www.w3.org/2005/08/addressing/anonymous</Address></ReplyTo></soap:Header><soap:Body><wst:RequestSecurityToken
xmlns:wst="http://docs.oasis-open.org/ws-sx/ws-trust/200512";
Context="_e1924146-000c-4c87-856a-bfb922875a7c"><wst:RequestType>http://docs.oasis-open.org/ws-sx/ws-trust/200512/Issue</wst:RequestType><wsp:AppliesTo
xmlns:wsp="http://www.w3.org/ns/ws-policy";><wsa:EndpointReference
xmlns:wsa="http://www.w3.org/2005/08/addressing";><wsa:Address>http://localhost:9001/DoubleItSpnegoSymmetricDerived</wsa:Address></wsa:EndpointReference></wsp:AppliesTo><wst:TokenType>http://docs.oasis-open.org/ws-sx/ws-secureconversation/200512/sct</wst:TokenType><wst:KeySize>256</wst:KeySize><wst:BinaryExchange
EncodingType="http://docs.oasis-open.org/wss/2004/01/oasis-200401-wss-soap-message-security-1.0#Base64Binary";
ValueType="http://docs.oasis-open.org/ws-sx/ws-trust/200512/spnego";>YIICNQYGKwYBBQUCoIICKTCCAiWgDTALBgkqhkiG9xIBAgKhBAMCATaiggIMBIICCGCCAgQGCSqGSIb3EgECAgEAboIB8zCCAe+gAwIBBaEDAgEOogcDBQAAAAAAo4IBDWGCAQkwggEFoAMCAQWhFxsVc2VydmljZS53cy5hcGFjaGUub3JnoicwJaADAgEAoR4wHBsDYm9iGxVzZXJ2aWNlLndzLmFwYWNoZS5vcmejgbswgbigAwIBEaEDAgEBooGrBIGopFQwyeOwp2Hik0FHUic7x9pgHOF6VVc4A4pA/HedIFVfMntHspfvtKyCoojK10UDxgTyXa8ZtWBT15u/ikodJmtLcrtEXLWIa6kDf0Ph/66+mcyyFfjOrLqTvtysSpArDoLM8Ht6mRv3po7fELCeLCG8vLydK+4ENW0uq7zSEKj6V6Ba/C8Wg0X8C0K6RHxN/sYctkOecmQyezudbWzaCt9OiKM4PcRtpIHIMIHFoAMCARGigb0EgboApGXncZqeNzEaWDFO77RwssxBjkT1d5W0HucVfSQwIklB7GG/Erer5Ai93sJHlUQGagNOMDIqMEZQtLaS975vCLFhDA+Bz28gf4IKhooCMR+Rpt5za+TWIgTGY0jChMVcUvCgfTDr+p4jNKuplL7W0zM2P4et2YiKy0YZM0pPuS+QpyEHx27bW6TCeZLxtTvsis5jJf+QhEb2f77JTheaaSrv6+bF3Ar+fpOMT+YhBxkK9vqmcei2V7s=</wst:BinaryExchange><wst:Renewing/></wst:RequestSecurityToken></soap:Body></soap:Envelope>
--------------------------------------
Oct 15, 2018 7:47:40 PM
org.apache.cxf.services.DoubleItService.DoubleItSpnegoSymmetricDerivedPort.DoubleItPortType
INFO: Inbound Message
----------------------------
ID: 12
Address: http://localhost:9001/DoubleItSpnegoSymmetricDerived
Encoding: UTF-8
Http-Method: POST
Content-Type: text/xml; charset=UTF-8
Headers: {Accept=[*/*], Cache-Control=[no-cache], connection=[keep-alive],
Content-Length=[2224], content-type=[text/xml; charset=UTF-8],
Host=[localhost:9001], Pragma=[no-cache],
SOAPAction=["http://docs.oasis-open.org/ws-sx/ws-trust/200512/RST/Issue";],
User-Agent=[Apache-CXF/${project.version}]}
Payload: <soap:Envelope
xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/";><soap:Header><Action
xmlns="http://www.w3.org/2005/08/addressing";>http://docs.oasis-open.org/ws-sx/ws-trust/200512/RST/Issue</Action><MessageID
xmlns="http://www.w3.org/2005/08/addressing";>urn:uuid:01875216-b23d-4a8b-bbb8-8de1a4b7b90f</MessageID><To
xmlns="http://www.w3.org/2005/08/addressing";>http://localhost:9001/DoubleItSpnegoSymmetricDerived</To><ReplyTo
xmlns="http://www.w3.org/2005/08/addressing";><Address>http://www.w3.org/2005/08/addressing/anonymous</Address></ReplyTo></soap:Header><soap:Body><wst:RequestSecurityToken
xmlns:wst="http://docs.oasis-open.org/ws-sx/ws-trust/200512";
Context="_e1924146-000c-4c87-856a-bfb922875a7c"><wst:RequestType>http://docs.oasis-open.org/ws-sx/ws-trust/200512/Issue</wst:RequestType><wsp:AppliesTo
xmlns:wsp="http://www.w3.org/ns/ws-policy";><wsa:EndpointReference
xmlns:wsa="http://www.w3.org/2005/08/addressing";><wsa:Address>http://localhost:9001/DoubleItSpnegoSymmetricDerived</wsa:Address></wsa:EndpointReference></wsp:AppliesTo><wst:TokenType>http://docs.oasis-open.org/ws-sx/ws-secureconversation/200512/sct</wst:TokenType><wst:KeySize>256</wst:KeySize><wst:BinaryExchange
EncodingType="http://docs.oasis-open.org/wss/2004/01/oasis-200401-wss-soap-message-security-1.0#Base64Binary";
ValueType="http://docs.oasis-open.org/ws-sx/ws-trust/200512/spnego";>YIICNQYGKwYBBQUCoIICKTCCAiWgDTALBgkqhkiG9xIBAgKhBAMCATaiggIMBIICCGCCAgQGCSqGSIb3EgECAgEAboIB8zCCAe+gAwIBBaEDAgEOogcDBQAAAAAAo4IBDWGCAQkwggEFoAMCAQWhFxsVc2VydmljZS53cy5hcGFjaGUub3JnoicwJaADAgEAoR4wHBsDYm9iGxVzZXJ2aWNlLndzLmFwYWNoZS5vcmejgbswgbigAwIBEaEDAgEBooGrBIGopFQwyeOwp2Hik0FHUic7x9pgHOF6VVc4A4pA/HedIFVfMntHspfvtKyCoojK10UDxgTyXa8ZtWBT15u/ikodJmtLcrtEXLWIa6kDf0Ph/66+mcyyFfjOrLqTvtysSpArDoLM8Ht6mRv3po7fELCeLCG8vLydK+4ENW0uq7zSEKj6V6Ba/C8Wg0X8C0K6RHxN/sYctkOecmQyezudbWzaCt9OiKM4PcRtpIHIMIHFoAMCARGigb0EgboApGXncZqeNzEaWDFO77RwssxBjkT1d5W0HucVfSQwIklB7GG/Erer5Ai93sJHlUQGagNOMDIqMEZQtLaS975vCLFhDA+Bz28gf4IKhooCMR+Rpt5za+TWIgTGY0jChMVcUvCgfTDr+p4jNKuplL7W0zM2P4et2YiKy0YZM0pPuS+QpyEHx27bW6TCeZLxtTvsis5jJf+QhEb2f77JTheaaSrv6+bF3Ar+fpOMT+YhBxkK9vqmcei2V7s=</wst:BinaryExchange><wst:Renewing/></wst:RequestSecurityToken></soap:Body></soap:Envelope>
--------------------------------------
Oct 15, 2018 7:47:40 PM
org.apache.kerby.kerberos.kerb.server.request.KdcRequest preauth
INFO: The preauth data is empty.
Oct 15, 2018 7:47:40 PM org.apache.kerby.kerberos.kerb.server.KdcHandler
handleRecoverableException
INFO: KRB error occurred while processing request: Additional
pre-authentication required
Oct 15, 2018 7:47:40 PM
org.apache.kerby.kerberos.kerb.server.request.AsRequest issueTicket
INFO: AS_REQ ISSUE: authtime
1539650860404,bob/service.ws.apache....@service.ws.apache.org for
krbtgt/service.ws.apache....@service.ws.apache.org
Oct 15, 2018 7:47:40 PM org.apache.cxf.phase.PhaseInterceptorChain
doDefaultLogging
WARNING: Interceptor for
{http://docs.oasis-open.org/ws-sx/ws-trust/200512/wsdl}SecurityTokenService#{http://docs.oasis-open.org/ws-sx/ws-trust/200512/wsdl}RequestSecurityToken
has thrown exception, unwinding now
org.apache.cxf.interceptor.Fault:
net.sf.ehcache.Element.<init>(Ljava/lang/Object;Ljava/lang/Object;II)V
at
org.apache.cxf.interceptor.ServiceInvokerInterceptor.handleMessage(ServiceInvokerInterceptor.java:144)
at
org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:308)
at
org.apache.cxf.transport.ChainInitiationObserver.onMessage(ChainInitiationObserver.java:121)
at
org.apache.cxf.transport.http.AbstractHTTPDestination.invoke(AbstractHTTPDestination.java:267)
at
org.apache.cxf.transport.http_jetty.JettyHTTPDestination.doService(JettyHTTPDestination.java:247)
at
org.apache.cxf.transport.http_jetty.JettyHTTPHandler.handle(JettyHTTPHandler.java:79)
at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:132)
at
org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:257)
at
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1317)
at
org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:205)
at
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1219)
at
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:144)
at
org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:219)
at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:132)
at org.eclipse.jetty.server.Server.handle(Server.java:531)
at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:352)
at
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:260)
at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:281)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:102)
at
org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:118)
at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.runTask(EatWhatYouKill.java:333)
at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:310)
at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:168)
at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.run(EatWhatYouKill.java:126)
at
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:366)
at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:762)
at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:680)
at java.lang.Thread.run(Unknown Source)
Caused by: java.lang.NoSuchMethodError:
net.sf.ehcache.Element.<init>(Ljava/lang/Object;Ljava/lang/Object;II)V
at
org.apache.cxf.ws.security.tokenstore.EHCacheTokenStore.add(EHCacheTokenStore.java:102)
at
org.apache.cxf.ws.security.policy.interceptors.SpnegoContextTokenInInterceptor$SpnegoSTSInvoker.doIssue(SpnegoContextTokenInInterceptor.java:257)
at
org.apache.cxf.ws.security.policy.interceptors.STSInvoker.invoke(STSInvoker.java:124)
at
org.apache.cxf.ws.security.policy.interceptors.SpnegoContextTokenInInterceptor$SpnegoSTSInvoker.invoke(SpnegoContextTokenInInterceptor.java:1)
at
org.apache.cxf.interceptor.ServiceInvokerInterceptor$1.run(ServiceInvokerInterceptor.java:59)
at java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source)
at java.util.concurrent.FutureTask.run(Unknown Source)
at
org.apache.cxf.interceptor.ServiceInvokerInterceptor$2.run(ServiceInvokerInterceptor.java:126)
at
org.apache.cxf.workqueue.SynchronousExecutor.execute(SynchronousExecutor.java:37)
at
org.apache.cxf.interceptor.ServiceInvokerInterceptor.handleMessage(ServiceInvokerInterceptor.java:131)
... 27 more
Oct 15, 2018 7:47:40 PM
org.apache.cxf.services.SecurityTokenService.SecurityTokenService.SecurityTokenService
INFO: Outbound Message
---------------------------
ID: 12
Response-Code: 500
Encoding: UTF-8
Content-Type: text/xml
Headers: {}
Payload: <soap:Envelope
xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/";><soap:Body><soap:Fault><faultcode>soap:Server</faultcode><faultstring>net.sf.ehcache.Element.<init>(Ljava/lang/Object;Ljava/lang/Object;II)V</faultstring></soap:Fault></soap:Body></soap:Envelope>
--------------------------------------
Oct 15, 2018 7:47:40 PM
org.apache.cxf.services.SecurityTokenService.DoubleItSpnegoSymmetricDerivedPort.spnego-client.SecurityTokenService
INFO: Inbound Message
----------------------------
ID: 11
Response-Code: 500
Encoding: UTF-8
Content-Type: text/xml;charset=utf-8
Headers: {content-type=[text/xml;charset=utf-8], Date=[Tue, 16 Oct 2018
00:47:40 GMT], Server=[Jetty(9.4.11.v20180605)], transfer-encoding=[chunked]}
Payload: <soap:Envelope
xmlns:soap="http://schemas.xmlsoap.org/soap/envelope/";><soap:Body><soap:Fault><faultcode>soap:Server</faultcode><faultstring>net.sf.ehcache.Element.<init>(Ljava/lang/Object;Ljava/lang/Object;II)V</faultstring></soap:Fault></soap:Body></soap:Envelope>
--------------------------------------
Oct 15, 2018 7:47:40 PM org.apache.cxf.ws.addressing.soap.MAPCodec
restoreExchange
WARNING: Response message does not contain WS-Addressing properties. Not
correlating response.
Oct 15, 2018 7:47:40 PM org.apache.cxf.ws.addressing.ContextUtils
retrieveMAPs
WARNING: WS-Addressing - failed to retrieve Message Addressing Properties
from context
Oct 15, 2018 7:47:40 PM org.apache.cxf.phase.PhaseInterceptorChain
doDefaultLogging
WARNING: Interceptor for
{http://www.example.org/contract/DoubleIt}DoubleItService#{http://www.example.org/contract/DoubleIt}DoubleIt
has thrown exception, unwinding now
org.apache.cxf.binding.soap.SoapFault:
net.sf.ehcache.Element.<init>(Ljava/lang/Object;Ljava/lang/Object;II)V
at
org.apache.cxf.binding.soap.interceptor.Soap11FaultInInterceptor.unmarshalFault(Soap11FaultInInterceptor.java:87)
at
org.apache.cxf.binding.soap.interceptor.Soap11FaultInInterceptor.handleMessage(Soap11FaultInInterceptor.java:53)
at
org.apache.cxf.binding.soap.interceptor.Soap11FaultInInterceptor.handleMessage(Soap11FaultInInterceptor.java:1)
at
org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:308)
at
org.apache.cxf.interceptor.AbstractFaultChainInitiatorObserver.onMessage(AbstractFaultChainInitiatorObserver.java:112)
at
org.apache.cxf.binding.soap.interceptor.CheckFaultInterceptor.handleMessage(CheckFaultInterceptor.java:70)
at
org.apache.cxf.binding.soap.interceptor.CheckFaultInterceptor.handleMessage(CheckFaultInterceptor.java:1)
at
org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:308)
at org.apache.cxf.endpoint.ClientImpl.onMessage(ClientImpl.java:833)
at
org.apache.cxf.transport.http.HTTPConduit$WrappedOutputStream.handleResponseInternal(HTTPConduit.java:1695)
at
org.apache.cxf.transport.http.HTTPConduit$WrappedOutputStream.handleResponse(HTTPConduit.java:1572)
at
org.apache.cxf.transport.http.HTTPConduit$WrappedOutputStream.close(HTTPConduit.java:1373)
at
org.apache.cxf.io.CacheAndWriteOutputStream.postClose(CacheAndWriteOutputStream.java:56)
at
org.apache.cxf.io.CachedOutputStream.close(CachedOutputStream.java:225)
at
org.apache.cxf.transport.AbstractConduit.close(AbstractConduit.java:56)
at
org.apache.cxf.transport.http.HTTPConduit.close(HTTPConduit.java:673)
at
org.apache.cxf.interceptor.MessageSenderInterceptor$MessageSenderEndingInterceptor.handleMessage(MessageSenderInterceptor.java:63)
at
org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:308)
at org.apache.cxf.endpoint.ClientImpl.doInvoke(ClientImpl.java:537)
at org.apache.cxf.endpoint.ClientImpl.invoke(ClientImpl.java:446)
at org.apache.cxf.endpoint.ClientImpl.invoke(ClientImpl.java:361)
at org.apache.cxf.endpoint.ClientImpl.invoke(ClientImpl.java:319)
at
org.apache.cxf.ws.security.trust.AbstractSTSClient.issue(AbstractSTSClient.java:874)
at
org.apache.cxf.ws.security.trust.STSClient.requestSecurityToken(STSClient.java:61)
at
org.apache.cxf.ws.security.trust.STSClient.requestSecurityToken(STSClient.java:55)
at
org.apache.cxf.ws.security.policy.interceptors.SpnegoContextTokenOutInterceptor.issueToken(SpnegoContextTokenOutInterceptor.java:138)
at
org.apache.cxf.ws.security.policy.interceptors.SpnegoContextTokenOutInterceptor.handleMessage(SpnegoContextTokenOutInterceptor.java:75)
at
org.apache.cxf.ws.security.policy.interceptors.SpnegoContextTokenOutInterceptor.handleMessage(SpnegoContextTokenOutInterceptor.java:1)
at
org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:308)
at org.apache.cxf.endpoint.ClientImpl.doInvoke(ClientImpl.java:537)
at org.apache.cxf.endpoint.ClientImpl.invoke(ClientImpl.java:446)
at org.apache.cxf.endpoint.ClientImpl.invoke(ClientImpl.java:361)
at org.apache.cxf.endpoint.ClientImpl.invoke(ClientImpl.java:319)
at org.apache.cxf.frontend.ClientProxy.invokeSync(ClientProxy.java:96)
at
org.apache.cxf.jaxws.JaxWsClientProxy.invoke(JaxWsClientProxy.java:140)
at com.sun.proxy.$Proxy58.doubleIt(Unknown Source)
at
org.apache.cxf.systest.kerberos.wssec.spnego.SpnegoTokenTest.runKerberosTest(SpnegoTokenTest.java:241)
at
org.apache.cxf.systest.kerberos.wssec.spnego.SpnegoTokenTest.testSpnegoOverSymmetricDerived(SpnegoTokenTest.java:145)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
at java.lang.reflect.Method.invoke(Unknown Source)
at
org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50)
at
org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
at
org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
at
org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
at
org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27)
at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325)
at
org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:78)
at
org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:57)
at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290)
at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71)
at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288)
at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58)
at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268)
at
org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
at
org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27)
at org.junit.runners.ParentRunner.run(ParentRunner.java:363)
at
org.eclipse.jdt.internal.junit4.runner.JUnit4TestReference.run(JUnit4TestReference.java:86)
at
org.eclipse.jdt.internal.junit.runner.TestExecution.run(TestExecution.java:38)
at
org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:459)
at
org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:678)
at
org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.run(RemoteTestRunner.java:382)
at
org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.main(RemoteTestRunner.java:192)
Oct 15, 2018 7:47:40 PM org.eclipse.jetty.server.handler.ContextHandler
doStop
INFO: Stopped o.e.j.s.h.ContextHandler@4930539b{/,null,UNAVAILABLE}
Oct 15, 2018 7:47:40 PM org.eclipse.jetty.server.handler.ContextHandler
doStop
INFO: Stopped o.e.j.s.h.ContextHandler@57b75756{/,null,UNAVAILABLE}
Oct 15, 2018 7:47:40 PM org.eclipse.jetty.server.handler.ContextHandler
doStop
INFO: Stopped o.e.j.s.h.ContextHandler@2e34384c{/,null,UNAVAILABLE}
Oct 15, 2018 7:47:40 PM org.eclipse.jetty.server.handler.ContextHandler
doStop
INFO: Stopped o.e.j.s.h.ContextHandler@545e57d7{/,null,UNAVAILABLE}
Oct 15, 2018 7:47:40 PM org.eclipse.jetty.server.handler.ContextHandler
doStop
INFO: Stopped o.e.j.s.h.ContextHandler@2ba33e2c{/,null,UNAVAILABLE}
Oct 15, 2018 7:47:40 PM org.eclipse.jetty.server.handler.ContextHandler
doStop
INFO: Stopped o.e.j.s.h.ContextHandler@3fae596{/,null,UNAVAILABLE}
Oct 15, 2018 7:47:40 PM
org.springframework.context.support.AbstractApplicationContext doClose
INFO: Closing org.apache.cxf.bus.spring.BusApplicationContext@7e97551f:
startup date [Mon Oct 15 19:47:37 CDT 2018]; root of context hierarchy
Oct 15, 2018 7:47:40 PM
org.apache.cxf.transport.http_jetty.JettyHTTPServerEngine shutdown
WARNING: Failed to shutdown Jetty server on port 9001 because it is still in
use
Oct 15, 2018 7:47:40 PM org.eclipse.jetty.server.AbstractConnector doStop
INFO: Stopped ServerConnector@258ee7de{HTTP/1.1,[http/1.1]}{localhost:9002}
Oct 15, 2018 7:47:40 PM
org.apache.cxf.transport.http_jetty.JettyHTTPServerEngine shutdown
WARNING: Failed to shutdown Jetty server on port 9003 because it is still in
use
Oct 15, 2018 7:47:40 PM org.eclipse.jetty.server.AbstractConnector doStop
INFO: Stopped ServerConnector@5a67e962{ssl,[ssl, http/1.1]}{0.0.0.0:9004}
Oct 15, 2018 7:47:40 PM org.eclipse.jetty.server.handler.ContextHandler
doStop
INFO: Stopped o.e.j.s.h.ContextHandler@138a7441{/,null,UNAVAILABLE}
Oct 15, 2018 7:47:40 PM org.eclipse.jetty.server.handler.ContextHandler
doStop
INFO: Stopped o.e.j.s.h.ContextHandler@779dfe55{/,null,UNAVAILABLE}
Oct 15, 2018 7:47:40 PM org.eclipse.jetty.server.handler.ContextHandler
doStop
INFO: Stopped o.e.j.s.h.ContextHandler@775594f2{/,null,UNAVAILABLE}
Oct 15, 2018 7:47:40 PM org.eclipse.jetty.server.handler.ContextHandler
doStop
INFO: Stopped o.e.j.s.h.ContextHandler@988246e{/,null,UNAVAILABLE}
Oct 15, 2018 7:47:40 PM org.eclipse.jetty.server.handler.ContextHandler
doStop
INFO: Stopped o.e.j.s.h.ContextHandler@4d6f623d{/,null,UNAVAILABLE}
Oct 15, 2018 7:47:40 PM org.eclipse.jetty.server.handler.ContextHandler
doStop
INFO: Stopped o.e.j.s.h.ContextHandler@5e76a2bb{/,null,UNAVAILABLE}
Oct 15, 2018 7:47:40 PM org.eclipse.jetty.server.handler.ContextHandler
doStop
INFO: Stopped o.e.j.s.h.ContextHandler@4f449e8f{/,null,UNAVAILABLE}
Oct 15, 2018 7:47:40 PM
org.springframework.context.support.AbstractApplicationContext doClose
INFO: Closing org.apache.cxf.bus.spring.BusApplicationContext@c730b35:
startup date [Mon Oct 15 19:47:35 CDT 2018]; root of context hierarchy
Oct 15, 2018 7:47:40 PM org.eclipse.jetty.server.AbstractConnector doStop
INFO: Stopped ServerConnector@288a4658{HTTP/1.1,[http/1.1]}{localhost:9001}
Oct 15, 2018 7:47:40 PM org.eclipse.jetty.server.AbstractConnector doStop
INFO: Stopped ServerConnector@381cad29{ssl,[ssl, http/1.1]}{0.0.0.0:9003}
Oct 15, 2018 7:47:40 PM
org.apache.kerby.kerberos.kerb.server.impl.DefaultInternalKdcServerImpl doStop
INFO: Default Internal kdc server stopped.
```
Seems like a class incompatibility with respect to the Ehcache library.
Am I missing something? Perhaps some environment variables, etc?
----------------------------------------------------------------
This is an automated message from the Apache Git Service.
To respond to the message, please log on GitHub and use the
URL above to go to the specific comment.
For queries about this service, please contact Infrastructure at:
us...@infra.apache.org
> LoginConfig in AbstractSpnegoAuthSupplier is not used
> -----------------------------------------------------
>
> Key: CXF-7867
> URL: https://issues.apache.org/jira/browse/CXF-7867
> Project: CXF
> Issue Type: Bug
> Components: Transports
> Reporter: Nicholas DiPiazza
> Assignee: Colm O hEigeartaigh
> Priority: Minor
>
> We allow users to set the loginConfig in the AbstractSpnegoAuthSupplier
> But we do not use it. See:
> https://github.com/apache/cxf/blob/master/rt/transports/http/src/main/java/org/apache/cxf/transport/http/auth/AbstractSpnegoAuthSupplier.java#L116
> for its only usage.
> Unless I'm not understanding something, we should allow people to use it.
> Possibly naive PR: https://github.com/apache/cxf/pull/456
--
This message was sent by Atlassian JIRA
(v7.6.3#76005)
