It looks like the valve is causing the form parameters to be null when the content type is application/x-www-form-urlencoded....
So this is the log with the Content-Type set to application/x-www-form-urlencoded 2012-05-05 17:07:55,608 DEBUG [org.springframework.beans.factory.support.DefaultListableBeanFactory] (http-8443-1) Creating instance of bean 'ticketResource' 2012-05-05 17:07:55,608 DEBUG [org.springframework.beans.factory.annotation.InjectionMetadata] (http-8443-1) Processing injected field of bean 'ticketResource': AutowiredFieldElement for private org.jasig.cas.CentralAuthenticationService org.jasig.cas.integration.restlet.TicketResource.centralAuthenticationService 2012-05-05 17:07:55,608 DEBUG [org.springframework.beans.factory.support.DefaultListableBeanFactory] (http-8443-1) Returning cached instance of singleton bean 'centralAuthenticationService' 2012-05-05 17:07:55,612 DEBUG [org.springframework.beans.factory.support.DefaultListableBeanFactory] (http-8443-1) Finished creating instance of bean 'ticketResource' 2012-05-05 17:07:55,612 DEBUG [org.jasig.cas.integration.restlet.TicketResource] (http-8443-1) Obtaining credentials... 2012-05-05 17:07:55,612 DEBUG [org.jasig.cas.integration.restlet.TicketResource] (http-8443-1) [] 2012-05-05 17:07:55,612 DEBUG [org.jasig.cas.integration.restlet.TicketResource] (http-8443-1) [] 2012-05-05 17:07:55,612 DEBUG [org.jasig.cas.integration.restlet.TicketResource] (http-8443-1) Username from RestletWebRequest: null 2012-05-05 17:07:55,612 DEBUG [org.jasig.cas.CentralAuthenticationServiceImpl] (http-8443-1) Attempting to create TicketGrantingTicket for [username: null] 2012-05-05 17:07:55,614 DEBUG [com.noelios.restlet.ext.spring.RestletFrameworkServlet] (http-8443-1) Successfully completed request 2012-05-05 17:08:10,545 DEBUG [org.springframework.beans.factory.support.DefaultListableBeanFactory] (http-8443-1) Creating instance of bean 'ticketResource' 2012-05-05 17:08:10,545 DEBUG [org.springframework.beans.factory.annotation.InjectionMetadata] (http-8443-1) Processing injected field of bean 'ticketResource': AutowiredFieldElement for private org.jasig.cas.CentralAuthenticationService org.jasig.cas.integration.restlet.TicketResource.centralAuthenticationService 2012-05-05 17:08:10,545 DEBUG [org.springframework.beans.factory.support.DefaultListableBeanFactory] (http-8443-1) Returning cached instance of singleton bean 'centralAuthenticationService' 2012-05-05 17:08:10,552 DEBUG [org.springframework.beans.factory.support.DefaultListableBeanFactory] (http-8443-1) Finished creating instance of bean 'ticketResource' 2012-05-05 17:08:10,552 DEBUG [org.jasig.cas.integration.restlet.TicketResource] (http-8443-1) Obtaining credentials... 2012-05-05 17:08:10,554 DEBUG [com.noelios.restlet.ext.spring.RestletFrameworkServlet] (http-8443-1) Successfully completed request When the content type is text/xml 2012-05-05 17:11:08,582 DEBUG [org.springframework.beans.factory.support.DefaultListableBeanFactory] (http-8443-1) Creating instance of bean 'ticketResource' 2012-05-05 17:11:08,582 DEBUG [org.springframework.beans.factory.annotation.InjectionMetadata] (http-8443-1) Processing injected field of bean 'ticketResource': AutowiredFieldElement for private org.jasig.cas.CentralAuthenticationService org.jasig.cas.integration.restlet.TicketResource.centralAuthenticationService 2012-05-05 17:11:08,582 DEBUG [org.springframework.beans.factory.support.DefaultListableBeanFactory] (http-8443-1) Returning cached instance of singleton bean 'centralAuthenticationService' 2012-05-05 17:11:08,584 DEBUG [org.springframework.beans.factory.support.DefaultListableBeanFactory] (http-8443-1) Finished creating instance of bean 'ticketResource' 2012-05-05 17:11:08,584 DEBUG [org.jasig.cas.integration.restlet.TicketResource] (http-8443-1) Obtaining credentials... 2012-05-05 17:11:08,585 DEBUG [org.jasig.cas.integration.restlet.TicketResource] (http-8443-1) [username: user1, password: password] 2012-05-05 17:11:08,585 DEBUG [org.jasig.cas.integration.restlet.TicketResource] (http-8443-1) [username: user1, password: password] 2012-05-05 17:11:08,585 DEBUG [org.jasig.cas.integration.restlet.TicketResource] (http-8443-1) Username from RestletWebRequest: user1 2012-05-05 17:11:08,585 DEBUG [org.jasig.cas.CentralAuthenticationServiceImpl] (http-8443-1) Attempting to create TicketGrantingTicket for [username: user1] 2012-05-05 17:11:08,585 DEBUG [org.jasig.cas.adaptors.ldap.FastBindLdapAuthenticationHandler] (http-8443-1) Performing LDAP bind with credential: uid=user1,ou=organization,dc=com 2012-05-05 17:11:08,585 DEBUG [org.springframework.ldap.core.support.AbstractContextSource] (http-8443-1) Got Ldap context on server 'ldap://ldap1:389/ou=organization,dc=com' 2012-05-05 17:11:08,590 WARN [org.jasig.cas.authentication.AuthenticationManagerImpl] (http-8443-1) AuthenticationHandler: org.jasig.cas.adaptors.ldap.FastBindLdapAuthenticationHandler successfully authenticated the user which provided the following credentials: [username: user1] 2012-05-05 17:11:08,590 DEBUG [org.jasig.cas.authentication.principal.UsernamePasswordCredentialsToPrincipalResolver] (http-8443-1) Attempting to resolve a principal... 2012-05-05 17:11:08,590 DEBUG [org.jasig.cas.authentication.principal.UsernamePasswordCredentialsToPrincipalResolver] (http-8443-1) Creating SimplePrincipal for [user1] 2012-05-05 17:11:08,590 DEBUG [org.springframework.jdbc.core.JdbcTemplate] (http-8443-1) Executing prepared SQL query 2012-05-05 17:11:08,590 DEBUG [org.springframework.jdbc.core.JdbcTemplate] (http-8443-1) Executing prepared SQL statement [SELECT * FROM user_security WHERE user_id = ?] 2012-05-05 17:11:08,590 DEBUG [org.springframework.jdbc.datasource.DataSourceUtils] (http-8443-1) Fetching JDBC Connection from DataSource 2012-05-05 17:11:08,590 DEBUG [com.mchange.v2.resourcepool.BasicResourcePool] (http-8443-1) trace com.mchange.v2.resourcepool.BasicResourcePool@6e9fbdd7 [managed: 2, unused: 1, excluded: 0] (e.g. com.mchange.v2.c3p0.impl.NewPooledConnection@6fa2fa45) 2012-05-05 17:11:08,591 DEBUG [com.mchange.v2.c3p0.stmt.GooGooStatementCache] (http-8443-1) cxnStmtMgr.statementSet( com.mysql.jdbc.JDBC4Connection@75247397 ).size(): 1 2012-05-05 17:11:08,591 DEBUG [com.mchange.v2.c3p0.stmt.GooGooStatementCache] (http-8443-1) checkoutStatement: com.mchange.v2.c3p0.stmt.GlobalMaxOnlyStatementCache stats -- total size: 1; checked out: 1; num connections: 1; num keys: 1 2012-05-05 17:11:08,593 DEBUG [com.mchange.v2.c3p0.stmt.GooGooStatementCache] (http-8443-1) checkinStatement(): com.mchange.v2.c3p0.stmt.GlobalMaxOnlyStatementCache stats -- total size: 1; checked out: 0; num connections: 1; num keys: 1 2012-05-05 17:11:08,594 DEBUG [org.springframework.jdbc.datasource.DataSourceUtils] (http-8443-1) Returning JDBC Connection to DataSource 2012-05-05 17:11:08,594 DEBUG [com.mchange.v2.c3p0.stmt.GooGooStatementCache] (http-8443-1) checkinAll(): com.mchange.v2.c3p0.stmt.GlobalMaxOnlyStatementCache stats -- total size: 1; checked out: 0; num connections: 1; num keys: 1 2012-05-05 17:11:08,594 DEBUG [com.mchange.v2.resourcepool.BasicResourcePool] (http-8443-1) trace com.mchange.v2.resourcepool.BasicResourcePool@6e9fbdd7 [managed: 2, unused: 1, excluded: 0] (e.g. com.mchange.v2.c3p0.impl.NewPooledConnection@6fa2fa45) 2012-05-05 17:11:08,594 DEBUG [com.mchange.v2.c3p0.stmt.GooGooStatementCache] (com.mchange.v2.async.ThreadPoolAsynchronousRunner$PoolThread-#1) checkinAll(): com.mchange.v2.c3p0.stmt.GlobalMaxOnlyStatementCache stats -- total size: 1; checked out: 0; num connections: 1; num keys: 1 2012-05-05 17:11:08,595 DEBUG [org.jasig.cas.ticket.registry.DefaultTicketRegistry] (http-8443-1) Added ticket [TGT-3-yFm2zdXsSdAadgqS1bvyMhCkHt6eTpOY9EAXFrf2KeHF3LS1PC-cas] to registry. 2012-05-05 17:11:08,597 DEBUG [com.noelios.restlet.ext.spring.RestletFrameworkServlet] (http-8443-1) Successfully completed request On Sat, May 5, 2012 at 10:52 AM, Jamie Johnson <[email protected]> wrote: > Marvin, > > Nothing particular is jumping out at me. Is there something specific > I should be looking for? > > It should also be possible to easily replicate this since you only > need to add the valve to a tomcat instance which CAS is deployed to > and attempt to hit the endpoint below. Would it be possible for > someone to set up a quick test? > > On Fri, May 4, 2012 at 9:31 AM, Marvin S. Addison > <[email protected]> wrote: >>> This works except that I've noticed that when I now make requests to >>> /cas/v1/tickets (which is also in the same tomcat instance) with >>> content type of application/x-www-form-urlencoded this gives the >>> following 500 Internal Server Error >> >> >> Sounds like a bug, but we'll need more information to confirm. Please turn >> up container logging for the org.jasig.cas.client category and post relevant >> log excerpts. You can use the following in your >> $CATALINA_HOME/conf/logging.properties if you're using JULI: >> >> org.jasig.cas.level=FINEST >> >> M >> >> -- >> You are currently subscribed to [email protected] as: >> [email protected] >> To unsubscribe, change settings or access archives, see >> http://www.ja-sig.org/wiki/display/JSG/cas-user -- You are currently subscribed to [email protected] as: [email protected] To unsubscribe, change settings or access archives, see http://www.ja-sig.org/wiki/display/JSG/cas-user
