Using jmeter (I modified
https://github.com/Jasig/cas/blob/v4.1.1/etc/jmeter/tests/simpleCasLoginTest.jmx
to add execution parameter so that it works), it seems I can now
reproduce easily the issue with KryoTranscoder on my dev workstation CAS.
I added a log line to have the stack trace (cf
MemCacheTicketRegistry.java-error.diff).
Please see attached the catalina.out.
The same jmeter test without KryoTranscoder works well (without any errors).
Thank you,
Vincent.
On 22/10/2015 18:29, Misagh Moayyed wrote:
> OK. Do provide the logs please when you get the chance.
>
>> -----Original Message-----
>> From: Vincent Bonamy [mailto:vincent.bon...@univ-rouen.fr]
>> Sent: Thursday, October 22, 2015 9:22 AM
>> To: cas-user@lists.jasig.org
>> Subject: [cas-user] RE: [cas-user] CAS 4.1.1 and KryoTranscoder ?
>>
>> Actually , I logged in to a non proxied and a proxied app successfully
>> just
>> after the cas started.
>> But because of the cpu charge (we switched on this new CAS for all our
>> users
>> at 13 o'clock today...), next the cas server couldn't answer anymore
>> quickly
>> ... and it crashed.
>>
>> I didn't have time to check that I could log in all our proxied apps ...
>>
>>
>> Le Jeudi 22 Octobre 2015 18:01 CEST, Misagh Moayyed <mmoay...@unicon.net>
>> a
>> écrit:
>>
>>> It's probably an issue with PGTs. Can you log into a non-proxied app?
>>>
>>>> -----Original Message-----
>>>> From: Vincent Bonamy [mailto:vincent.bon...@univ-rouen.fr]
>>>> Sent: Thursday, October 22, 2015 7:04 AM
>>>> To: cas-user@lists.jasig.org
>>>> Subject: [cas-user] CAS 4.1.1 and KryoTranscoder ?
>>>>
>>>> Hi All,
>>>>
>>>> Today we tried to update our production CAS server on 4.1.1 version.
>>>> But we failed and we went back to our 3.5.2.1
>>>>
>>>> After starting, the CAS answered correctly and I logged in to my
>>>> webmail (proxy cas) successfully for example.
>>>>
>>>> But the CPU charge was 100% and we had errors like this (we don't
>>>> have the stack trace, I don't know why ...) :
>>>> org.jasig.cas.ticket.registry.MemCacheTicketRegistry] - <Failed
>>>> fetching
>>>> [PGT-************************************************cEQOZjuIUV-cas.
>>>> univ-
>>>> rouen.fr,
>>>> java.lang.RuntimeException: Exception waiting for v alue] >
>>>>
>>>> We also got a crash of the JVM (!) :
>>>> """
>>>> # Problematic frame:
>>>> # J
>>>> com.esotericsoftware.kryo.serializers.ObjectField.write(Lcom/esoteri
>>>> csoftware /kryo/io/Output;Ljava/lang/Object;)V
>>>> """"
>>>>
>>>> We enabled some features on this CAS 4.1.1 - we set up memcached
>>>> like described on the doc - so we used kryoTranscoder :
>>>> http://jasig.github.io/cas/4.1.x/installation/Memcached-Ticket-
>>>> Registry.html#object-serialization
>>>>
>>>> So I think we will retry to update our CAS on 4.1.1 in production
>>>> but without using this kryoTranscoder (on our 3.5.2.1 we're using
>>>> memcached without
>>>> kryoTranscoder)
>>>>
>>>> Thanks for any ideas/advices about that.
>>>> --
>>>> Vincent Bonamy
>>>> Pôle SI
>>>> Direction de l'informatique &
>>>> des systèmes d'information
>>>> Université de ROUEN
>>>>
>>>> --
>>>> You are currently subscribed to cas-user@lists.jasig.org as:
>>>> mmoay...@unicon.net To unsubscribe, change settings or access
>>>> archives, see http://www.ja-sig.org/wiki/display/JSG/cas-user
>>>
>>> --
>>> You are currently subscribed to cas-user@lists.jasig.org as:
>>> vincent.bon...@univ-rouen.fr To unsubscribe, change settings or access
>>> archives, see http://www.ja-sig.org/wiki/display/JSG/cas-user
>>
>>
>>
>>
>> --
>> You are currently subscribed to cas-user@lists.jasig.org as:
>> mmoay...@unicon.net To unsubscribe, change settings or access archives,
>> see
>> http://www.ja-sig.org/wiki/display/JSG/cas-user
>
>
--
You are currently subscribed to cas-user@lists.jasig.org as:
arch...@mail-archive.com
To unsubscribe, change settings or access archives, see
http://www.ja-sig.org/wiki/display/JSG/cas-user
Java HotSpot(TM) Server VM warning: ignoring option MaxPermSize=512m; support
was removed in 8.0
Please use CMSClassUnloadingEnabled in place of CMSPermGenSweepingEnabled in
the future
23-Oct-2015 08:54:39.200 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Server version:
Apache Tomcat/8.0.28
23-Oct-2015 08:54:39.201 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Server built:
Oct 7 2015 18:25:21 UTC
23-Oct-2015 08:54:39.201 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Server number:
8.0.28.0
23-Oct-2015 08:54:39.201 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log OS Name:
Linux
23-Oct-2015 08:54:39.201 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log OS Version:
3.10-3-686-pae
23-Oct-2015 08:54:39.201 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Architecture:
i386
23-Oct-2015 08:54:39.201 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Java Home:
/usr/local/jdk1.8.0_60/jre
23-Oct-2015 08:54:39.201 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log JVM Version:
1.8.0_60-b27
23-Oct-2015 08:54:39.202 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log JVM Vendor:
Oracle Corporation
23-Oct-2015 08:54:39.202 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log CATALINA_BASE:
/opt/apache-tomcat-8.0.28-cas
23-Oct-2015 08:54:39.202 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log CATALINA_HOME:
/opt/apache-tomcat-8.0.28-cas
23-Oct-2015 08:54:39.202 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Command line argument:
-Djava.util.logging.config.file=/opt/tomcat-cas-4/conf/logging.properties
23-Oct-2015 08:54:39.202 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Command line argument:
-Djava.util.logging.manager=org.apache.juli.ClassLoaderLogManager
23-Oct-2015 08:54:39.202 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Command line argument:
-DrunnEntServerHostNum=dsi-2.univ-rouen.fr
23-Oct-2015 08:54:39.202 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Command line argument:
-DrunnEntServerHost=dsi-2.univ-rouen.fr
23-Oct-2015 08:54:39.202 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Command line argument:
-DrunnEntServerName=dsi-2
23-Oct-2015 08:54:39.203 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Command line argument:
-Xms1024m
23-Oct-2015 08:54:39.203 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Command line argument:
-Xmx1024m
23-Oct-2015 08:54:39.203 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Command line argument:
-XX:MaxPermSize=512m
23-Oct-2015 08:54:39.203 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Command line argument:
-Dical4j.parsing.relaxed=true
23-Oct-2015 08:54:39.203 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Command line argument:
-Djavax.net.ssl.trustStore=/opt/env-runn/trustore/cacerts-vincent-121213.trustore
23-Oct-2015 08:54:39.203 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Command line argument:
-Djavax.net.ssl.trustStorePassword=****
23-Oct-2015 08:54:39.203 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Command line argument:
-XX:+CMSClassUnloadingEnabled
23-Oct-2015 08:54:39.203 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Command line argument:
-XX:+CMSPermGenSweepingEnabled
23-Oct-2015 08:54:39.203 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Command line argument:
-XX:-DoEscapeAnalysis
23-Oct-2015 08:54:39.203 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Command line argument:
-Djava.endorsed.dirs=/opt/tomcat-cas-4/endorsed
23-Oct-2015 08:54:39.203 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Command line argument:
-Dcatalina.base=/opt/tomcat-cas-4
23-Oct-2015 08:54:39.203 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Command line argument:
-Dcatalina.home=/opt/tomcat-cas-4
23-Oct-2015 08:54:39.204 INFO [main]
org.apache.catalina.startup.VersionLoggerListener.log Command line argument:
-Djava.io.tmpdir=/opt/tomcat-cas-4/temp
23-Oct-2015 08:54:39.204 INFO [main]
org.apache.catalina.core.AprLifecycleListener.lifecycleEvent The APR based
Apache Tomcat Native library which allows optimal performance in production
environments was not found on the java.library.path:
/usr/java/packages/lib/i386:/lib:/usr/lib
23-Oct-2015 08:54:39.300 INFO [main] org.apache.coyote.AbstractProtocol.init
Initializing ProtocolHandler ["http-nio-8080"]
23-Oct-2015 08:54:39.310 INFO [main]
org.apache.tomcat.util.net.NioSelectorPool.getSharedSelector Using a shared
selector for servlet write/read
23-Oct-2015 08:54:39.312 INFO [main] org.apache.coyote.AbstractProtocol.init
Initializing ProtocolHandler ["ajp-nio-8009"]
23-Oct-2015 08:54:39.313 INFO [main]
org.apache.tomcat.util.net.NioSelectorPool.getSharedSelector Using a shared
selector for servlet write/read
23-Oct-2015 08:54:39.313 INFO [main] org.apache.catalina.startup.Catalina.load
Initialization processed in 355 ms
23-Oct-2015 08:54:39.329 INFO [main]
org.apache.catalina.core.StandardService.startInternal Démarrage du service
Catalina
23-Oct-2015 08:54:39.329 INFO [main]
org.apache.catalina.core.StandardEngine.startInternal Starting Servlet Engine:
Apache Tomcat/8.0.28
23-Oct-2015 08:54:39.334 INFO [localhost-startStop-1]
org.apache.catalina.startup.HostConfig.deployDirectory Déploiement du
répertoire /opt/apache-tomcat-8.0.28-cas/webapps/ROOT de l'application web
23-Oct-2015 08:54:41.697 INFO [localhost-startStop-1]
org.apache.jasper.servlet.TldScanner.scanJars At least one JAR was scanned for
TLDs yet contained no TLDs. Enable debug logging for this logger for a complete
list of JARs that were scanned but no TLDs were found in them. Skipping
unneeded JARs during scanning can improve startup time and JSP compilation time.
SLF4J: Class path contains multiple SLF4J bindings.
SLF4J: Found binding in
[jar:file:/opt/apache-tomcat-8.0.28-cas/webapps/ROOT/WEB-INF/lib/cas-server-core-4.1.1.jar!/org/slf4j/impl/StaticLoggerBinder.class]
SLF4J: Found binding in
[jar:file:/opt/apache-tomcat-8.0.28-cas/webapps/ROOT/WEB-INF/lib/log4j-slf4j-impl-2.3.jar!/org/slf4j/impl/StaticLoggerBinder.class]
SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation.
SLF4J: ILoggerFactory to be used for logging is:
org.apache.logging.slf4j.Log4jLoggerFactory
SLF4J: Actual binding is of type [org.slf4j.impl.CasLoggerFactory]
SLF4J: The following set of substitute loggers may have been accessed
SLF4J: during the initialization phase. Logging calls during this
SLF4J: phase were not honored. However, subsequent logging calls to these
SLF4J: loggers will work as normally expected.
SLF4J: See also http://www.slf4j.org/codes.html#substituteLogger
SLF4J: org.reflections.Reflections
log4j:WARN No appenders could be found for logger (org.jboss.logging).
log4j:WARN Please initialize the log4j system properly.
log4j:WARN See http://logging.apache.org/log4j/1.2/faq.html#noconfig for more
info.
2015-10-23 08:54:44.030 INFO net.spy.memcached.MemcachedConnection: Added {QA
sa=localhost/127.0.0.1:11211, #Rops=0, #Wops=0, #iq=0, topRop=null,
topWop=null, toWrite=0, interested=0} to connect queue
2015-10-23 08:54:44.337 INFO net.spy.memcached.MemcachedConnection: Added {QA
sa=localhost/127.0.0.1:11211, #Rops=0, #Wops=0, #iq=0, topRop=null,
topWop=null, toWrite=0, interested=0} to connect queue
2015-10-23 08:54:44,746 WARN
[org.jasig.cas.services.InMemoryServiceRegistryDaoImpl] - <Runtime memory is
used as the persistence storage for retrieving and persisting service
definitions. Changes that are made to service definitions during runtime will
be LOST upon container restarts.>
23-Oct-2015 08:54:46.918 INFO [localhost-startStop-1]
org.apache.catalina.startup.HostConfig.deployDirectory Deployment of web
application directory /opt/apache-tomcat-8.0.28-cas/webapps/ROOT has finished
in 7 583 ms
23-Oct-2015 08:54:46.921 INFO [main] org.apache.coyote.AbstractProtocol.start
Starting ProtocolHandler ["http-nio-8080"]
23-Oct-2015 08:54:46.926 INFO [main] org.apache.coyote.AbstractProtocol.start
Starting ProtocolHandler ["ajp-nio-8009"]
23-Oct-2015 08:54:46.927 INFO [main] org.apache.catalina.startup.Catalina.start
Server startup in 7613 ms
2015-10-23 08:54:52,513 ERROR
[org.jasig.cas.ticket.registry.MemCacheTicketRegistry] - <Failed fetching
[TGT-**********************************************cfbI4fb9Xw-cas.univ-rouen.fr,
java.lang.RuntimeException: Exception waiting for value] >
2015-10-23 08:54:52,515 ERROR
[org.jasig.cas.ticket.registry.MemCacheTicketRegistry] - <error:
java.lang.RuntimeException: Exception waiting for value
at net.spy.memcached.MemcachedClient.get(MemcachedClient.java:1237)
at net.spy.memcached.MemcachedClient.get(MemcachedClient.java:1257)
at
org.jasig.cas.ticket.registry.MemCacheTicketRegistry.getTicket(MemCacheTicketRegistry.java:197)
at
org.jasig.cas.extension.clearpass.TicketRegistryDecorator.getTicket_aroundBody2(TicketRegistryDecorator.java:79)
at
org.jasig.cas.extension.clearpass.TicketRegistryDecorator$AjcClosure3.run_aroundBody0(TicketRegistryDecorator.java:1)
at
org.jasig.cas.extension.clearpass.TicketRegistryDecorator$AjcClosure3$AjcClosure1.run(TicketRegistryDecorator.java:1)
at
org.aspectj.runtime.reflect.JoinPointImpl.proceed(JoinPointImpl.java:149)
at
org.jasig.inspektr.aspect.TraceLogAspect.traceMethod(TraceLogAspect.java:44)
at
org.jasig.cas.extension.clearpass.TicketRegistryDecorator$AjcClosure3.run(TicketRegistryDecorator.java:1)
at
org.aspectj.runtime.reflect.JoinPointImpl.proceed(JoinPointImpl.java:149)
at
org.jasig.inspektr.aspect.TraceLogAspect.traceMethod(TraceLogAspect.java:44)
at
org.jasig.cas.extension.clearpass.TicketRegistryDecorator.getTicket(TicketRegistryDecorator.java:79)
at
org.jasig.cas.ticket.registry.AbstractTicketRegistry.getTicket_aroundBody0(AbstractTicketRegistry.java:50)
at
org.jasig.cas.ticket.registry.AbstractTicketRegistry$AjcClosure1.run(AbstractTicketRegistry.java:1)
at
org.aspectj.runtime.reflect.JoinPointImpl.proceed(JoinPointImpl.java:149)
at
org.jasig.inspektr.aspect.TraceLogAspect.traceMethod(TraceLogAspect.java:44)
at
org.jasig.cas.ticket.registry.AbstractTicketRegistry.getTicket(AbstractTicketRegistry.java:48)
at
org.jasig.cas.CentralAuthenticationServiceImpl.getTicket_aroundBody12(CentralAuthenticationServiceImpl.java:516)
at
org.jasig.cas.CentralAuthenticationServiceImpl$AjcClosure13.run_aroundBody0(CentralAuthenticationServiceImpl.java:1)
at
org.jasig.cas.CentralAuthenticationServiceImpl$AjcClosure13$AjcClosure1.run(CentralAuthenticationServiceImpl.java:1)
at
org.aspectj.runtime.reflect.JoinPointImpl.proceed(JoinPointImpl.java:149)
at
org.jasig.inspektr.aspect.TraceLogAspect.traceMethod(TraceLogAspect.java:44)
at
org.jasig.cas.CentralAuthenticationServiceImpl$AjcClosure13.run(CentralAuthenticationServiceImpl.java:1)
at
org.aspectj.runtime.reflect.JoinPointImpl.proceed(JoinPointImpl.java:149)
at
org.jasig.inspektr.aspect.TraceLogAspect.traceMethod(TraceLogAspect.java:44)
at
org.jasig.cas.CentralAuthenticationServiceImpl.getTicket(CentralAuthenticationServiceImpl.java:515)
at
org.jasig.cas.CentralAuthenticationServiceImpl.destroyTicketGrantingTicket_aroundBody0(CentralAuthenticationServiceImpl.java:216)
at
org.jasig.cas.CentralAuthenticationServiceImpl$AjcClosure1.run_aroundBody0(CentralAuthenticationServiceImpl.java:1)
at
org.jasig.cas.CentralAuthenticationServiceImpl$AjcClosure1$AjcClosure1.run_aroundBody0(CentralAuthenticationServiceImpl.java:1)
at
org.jasig.cas.CentralAuthenticationServiceImpl$AjcClosure1$AjcClosure1$AjcClosure1.run(CentralAuthenticationServiceImpl.java:1)
at
org.aspectj.runtime.reflect.JoinPointImpl.proceed(JoinPointImpl.java:149)
at
org.jasig.inspektr.aspect.TraceLogAspect.traceMethod(TraceLogAspect.java:44)
at
org.jasig.cas.CentralAuthenticationServiceImpl$AjcClosure1$AjcClosure1.run(CentralAuthenticationServiceImpl.java:1)
at
org.aspectj.runtime.reflect.JoinPointImpl.proceed(JoinPointImpl.java:149)
at
org.jasig.inspektr.aspect.TraceLogAspect.traceMethod(TraceLogAspect.java:44)
at
org.jasig.cas.CentralAuthenticationServiceImpl$AjcClosure1.run(CentralAuthenticationServiceImpl.java:1)
at
org.aspectj.runtime.reflect.JoinPointImpl.proceed(JoinPointImpl.java:149)
at
org.jasig.inspektr.aspect.TraceLogAspect.traceMethod(TraceLogAspect.java:44)
at
org.jasig.cas.CentralAuthenticationServiceImpl.destroyTicketGrantingTicket(CentralAuthenticationServiceImpl.java:215)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:497)
at
org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:317)
at
org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:190)
at
org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:157)
at
org.springframework.aop.aspectj.MethodInvocationProceedingJoinPoint.proceed(MethodInvocationProceedingJoinPoint.java:85)
at
org.jasig.inspektr.audit.AuditTrailManagementAspect.handleAuditTrail(AuditTrailManagementAspect.java:128)
at sun.reflect.GeneratedMethodAccessor63.invoke(Unknown Source)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:497)
at
org.springframework.aop.aspectj.AbstractAspectJAdvice.invokeAdviceMethodWithGivenArgs(AbstractAspectJAdvice.java:621)
at
org.springframework.aop.aspectj.AbstractAspectJAdvice.invokeAdviceMethod(AbstractAspectJAdvice.java:610)
at
org.springframework.aop.aspectj.AspectJAroundAdvice.invoke(AspectJAroundAdvice.java:68)
at
org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:168)
at
org.springframework.aop.interceptor.ExposeInvocationInterceptor.invoke(ExposeInvocationInterceptor.java:92)
at
org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179)
at
com.ryantenney.metrics.spring.MeteredMethodInterceptor.invoke(MeteredMethodInterceptor.java:45)
at
com.ryantenney.metrics.spring.MeteredMethodInterceptor.invoke(MeteredMethodInterceptor.java:32)
at
com.ryantenney.metrics.spring.AbstractMetricMethodInterceptor.invoke(AbstractMetricMethodInterceptor.java:59)
at
org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179)
at
com.ryantenney.metrics.spring.TimedMethodInterceptor.invoke(TimedMethodInterceptor.java:48)
at
com.ryantenney.metrics.spring.TimedMethodInterceptor.invoke(TimedMethodInterceptor.java:34)
at
com.ryantenney.metrics.spring.AbstractMetricMethodInterceptor.invoke(AbstractMetricMethodInterceptor.java:59)
at
org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179)
at
org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:207)
at com.sun.proxy.$Proxy53.destroyTicketGrantingTicket(Unknown Source)
at
org.jasig.cas.web.flow.TerminateSessionAction.terminate_aroundBody0(TerminateSessionAction.java:86)
at
org.jasig.cas.web.flow.TerminateSessionAction$AjcClosure1.run_aroundBody0(TerminateSessionAction.java:1)
at
org.jasig.cas.web.flow.TerminateSessionAction$AjcClosure1$AjcClosure1.run(TerminateSessionAction.java:1)
at
org.aspectj.runtime.reflect.JoinPointImpl.proceed(JoinPointImpl.java:149)
at
org.jasig.inspektr.aspect.TraceLogAspect.traceMethod(TraceLogAspect.java:44)
at
org.jasig.cas.web.flow.TerminateSessionAction$AjcClosure1.run(TerminateSessionAction.java:1)
at
org.aspectj.runtime.reflect.JoinPointImpl.proceed(JoinPointImpl.java:149)
at
org.jasig.inspektr.aspect.TraceLogAspect.traceMethod(TraceLogAspect.java:44)
at
org.jasig.cas.web.flow.TerminateSessionAction.terminate(TerminateSessionAction.java:79)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:497)
at
org.springframework.expression.spel.support.ReflectiveMethodExecutor.execute(ReflectiveMethodExecutor.java:112)
at
org.springframework.expression.spel.ast.MethodReference.getValueInternal(MethodReference.java:102)
at
org.springframework.expression.spel.ast.MethodReference.access$000(MethodReference.java:49)
at
org.springframework.expression.spel.ast.MethodReference$MethodValueRef.getValue(MethodReference.java:342)
at
org.springframework.expression.spel.ast.CompoundExpression.getValueInternal(CompoundExpression.java:88)
at
org.springframework.expression.spel.ast.SpelNodeImpl.getTypedValue(SpelNodeImpl.java:131)
at
org.springframework.expression.spel.standard.SpelExpression.getValue(SpelExpression.java:299)
at
org.springframework.binding.expression.spel.SpringELExpression.getValue(SpringELExpression.java:84)
at
org.springframework.webflow.action.EvaluateAction.doExecute(EvaluateAction.java:75)
at
org.springframework.webflow.action.AbstractAction.execute(AbstractAction.java:188)
at
org.springframework.webflow.execution.AnnotatedAction.execute(AnnotatedAction.java:145)
at
org.springframework.webflow.execution.ActionExecutor.execute(ActionExecutor.java:51)
at
org.springframework.webflow.engine.ActionState.doEnter(ActionState.java:101)
at org.springframework.webflow.engine.State.enter(State.java:194)
at org.springframework.webflow.engine.Flow.start(Flow.java:527)
at
org.springframework.webflow.engine.impl.FlowExecutionImpl.start(FlowExecutionImpl.java:368)
at
org.springframework.webflow.engine.impl.FlowExecutionImpl.start(FlowExecutionImpl.java:223)
at
org.springframework.webflow.executor.FlowExecutorImpl.launchExecution(FlowExecutorImpl.java:140)
at
org.springframework.webflow.mvc.servlet.FlowHandlerAdapter.handle(FlowHandlerAdapter.java:238)
at
org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:959)
at
org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:893)
at
org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:966)
at
org.springframework.web.servlet.FrameworkServlet.doGet(FrameworkServlet.java:857)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:622)
at
org.springframework.web.servlet.FrameworkServlet.service(FrameworkServlet.java:842)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:729)
at
org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:291)
at
org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206)
at
org.apache.tomcat.websocket.server.WsFilter.doFilter(WsFilter.java:52)
at
org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:239)
at
org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206)
at
org.jasig.cas.security.RequestParameterPolicyEnforcementFilter.doFilter(RequestParameterPolicyEnforcementFilter.java:296)
at
org.springframework.web.filter.DelegatingFilterProxy.invokeDelegate(DelegatingFilterProxy.java:344)
at
org.springframework.web.filter.DelegatingFilterProxy.doFilter(DelegatingFilterProxy.java:261)
at
org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:239)
at
org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206)
at
org.jasig.inspektr.common.web.ClientInfoThreadLocalFilter.doFilter(ClientInfoThreadLocalFilter.java:62)
at
org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:239)
at
org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206)
at
org.springframework.web.filter.CharacterEncodingFilter.doFilterInternal(CharacterEncodingFilter.java:85)
at
org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:107)
at
org.springframework.web.filter.DelegatingFilterProxy.invokeDelegate(DelegatingFilterProxy.java:344)
at
org.springframework.web.filter.DelegatingFilterProxy.doFilter(DelegatingFilterProxy.java:261)
at
org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:239)
at
org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206)
at
org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:217)
at
org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:106)
at
org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:502)
at
org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:142)
at
org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:79)
at
org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:88)
at
org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:518)
at
org.apache.coyote.ajp.AbstractAjpProcessor.process(AbstractAjpProcessor.java:844)
at
org.apache.coyote.AbstractProtocol$AbstractConnectionHandler.process(AbstractProtocol.java:673)
at
org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1500)
at
org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.run(NioEndpoint.java:1456)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at
org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61)
at java.lang.Thread.run(Thread.java:745)
Caused by: java.util.concurrent.ExecutionException:
com.esotericsoftware.kryo.KryoException: Encountered unregistered class ID: 115
Serialization trace:
attributes (org.jasig.cas.authentication.principal.SimplePrincipal)
principal (org.jasig.cas.authentication.DefaultHandlerResult)
successes (org.jasig.cas.authentication.ImmutableAuthentication)
authentication (org.jasig.cas.ticket.TicketGrantingTicketImpl)
at java.util.concurrent.FutureTask.report(FutureTask.java:122)
at java.util.concurrent.FutureTask.get(FutureTask.java:192)
at
net.spy.memcached.transcoders.TranscodeService$Task.get(TranscodeService.java:97)
at net.spy.memcached.internal.GetFuture.get(GetFuture.java:70)
at net.spy.memcached.MemcachedClient.get(MemcachedClient.java:1230)
... 139 more
Caused by: com.esotericsoftware.kryo.KryoException: Encountered unregistered
class ID: 115
Serialization trace:
attributes (org.jasig.cas.authentication.principal.SimplePrincipal)
principal (org.jasig.cas.authentication.DefaultHandlerResult)
successes (org.jasig.cas.authentication.ImmutableAuthentication)
authentication (org.jasig.cas.ticket.TicketGrantingTicketImpl)
at
com.esotericsoftware.kryo.util.DefaultClassResolver.readClass(DefaultClassResolver.java:137)
at com.esotericsoftware.kryo.Kryo.readClass(Kryo.java:667)
at com.esotericsoftware.kryo.Kryo.readClassAndObject(Kryo.java:778)
at
com.esotericsoftware.kryo.serializers.MapSerializer.read(MapSerializer.java:153)
at
com.esotericsoftware.kryo.serializers.MapSerializer.read(MapSerializer.java:39)
at com.esotericsoftware.kryo.Kryo.readObject(Kryo.java:708)
at
com.esotericsoftware.kryo.serializers.ObjectField.read(ObjectField.java:125)
at
com.esotericsoftware.kryo.serializers.FieldSerializer.read(FieldSerializer.java:551)
at com.esotericsoftware.kryo.Kryo.readObject(Kryo.java:708)
at
com.esotericsoftware.kryo.serializers.ObjectField.read(ObjectField.java:125)
at
com.esotericsoftware.kryo.serializers.FieldSerializer.read(FieldSerializer.java:551)
at com.esotericsoftware.kryo.Kryo.readClassAndObject(Kryo.java:790)
at
com.esotericsoftware.kryo.serializers.MapSerializer.read(MapSerializer.java:161)
at
com.esotericsoftware.kryo.serializers.MapSerializer.read(MapSerializer.java:39)
at com.esotericsoftware.kryo.Kryo.readObject(Kryo.java:708)
at
com.esotericsoftware.kryo.serializers.ObjectField.read(ObjectField.java:125)
at
com.esotericsoftware.kryo.serializers.FieldSerializer.read(FieldSerializer.java:551)
at com.esotericsoftware.kryo.Kryo.readObject(Kryo.java:708)
at
com.esotericsoftware.kryo.serializers.ObjectField.read(ObjectField.java:125)
at
com.esotericsoftware.kryo.serializers.FieldSerializer.read(FieldSerializer.java:551)
at com.esotericsoftware.kryo.Kryo.readClassAndObject(Kryo.java:790)
at
org.jasig.cas.ticket.registry.support.kryo.KryoTranscoder.decode_aroundBody6(KryoTranscoder.java:185)
at
org.jasig.cas.ticket.registry.support.kryo.KryoTranscoder$AjcClosure7.run_aroundBody0(KryoTranscoder.java:1)
at
org.jasig.cas.ticket.registry.support.kryo.KryoTranscoder$AjcClosure7$AjcClosure1.run_aroundBody0(KryoTranscoder.java:1)
at
org.jasig.cas.ticket.registry.support.kryo.KryoTranscoder$AjcClosure7$AjcClosure1$AjcClosure1.run(KryoTranscoder.java:1)
at
org.aspectj.runtime.reflect.JoinPointImpl.proceed(JoinPointImpl.java:149)
at
org.jasig.inspektr.aspect.TraceLogAspect.traceMethod(TraceLogAspect.java:44)
at
org.jasig.cas.ticket.registry.support.kryo.KryoTranscoder$AjcClosure7$AjcClosure1.run(KryoTranscoder.java:1)
at
org.aspectj.runtime.reflect.JoinPointImpl.proceed(JoinPointImpl.java:149)
at
org.jasig.inspektr.aspect.TraceLogAspect.traceMethod(TraceLogAspect.java:44)
at
org.jasig.cas.ticket.registry.support.kryo.KryoTranscoder$AjcClosure7.run(KryoTranscoder.java:1)
at
org.aspectj.runtime.reflect.JoinPointImpl.proceed(JoinPointImpl.java:149)
at
org.jasig.inspektr.aspect.TraceLogAspect.traceMethod(TraceLogAspect.java:44)
at
org.jasig.cas.ticket.registry.support.kryo.KryoTranscoder.decode(KryoTranscoder.java:183)
at
net.spy.memcached.transcoders.TranscodeService$1.call(TranscodeService.java:63)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at
net.spy.memcached.transcoders.TranscodeService$Task.run(TranscodeService.java:110)
at
net.spy.memcached.transcoders.TranscodeService$Task.get(TranscodeService.java:96)
... 141 more
>
diff --git a/cas-server-integration-memcached/src/main/java/org/jasig/cas/ticket/registry/MemCacheTicketRegistry.java b/cas-server-integration-memcached/src/main/java/org/jasig/cas/ticket/registry/MemCacheTicketRegistry.java
index ddb0bb2..bb97bab 100644
--- a/cas-server-integration-memcached/src/main/java/org/jasig/cas/ticket/registry/MemCacheTicketRegistry.java
+++ b/cas-server-integration-memcached/src/main/java/org/jasig/cas/ticket/registry/MemCacheTicketRegistry.java
@@ -200,6 +200,7 @@ public final class MemCacheTicketRegistry extends AbstractDistributedTicketRegis
}
} catch (final Exception e) {
logger.error("Failed fetching {} ", ticketId, e);
+ logger.error(e);
}
return null;
}
