[cas-user] Strange Error in CAS Logs

[Juan Quintanilla]

Hi,

We are running CAS 3.4.7 with an Oracle Database and for the past couple of days we have encountered the error below for about 2 minutes or so and then goes away. Users then are unable to login during that time. I wanted to know if anyone would have any suggestions on the error.  It seems to me that during that time the connections are exhausted and can no longer connect.

Below is the error along with the C3P0 settings:

id="dataSource"
              class="com.mchange.v2.c3p0.ComboPooledDataSource"
              p:driverClass="oracle.jdbc.driver.OracleDriver"
              p:jdbcUrl="xxxxxxx"
              p:user="xxxxxxx"
              p:password="xxxxxxxx"
              p:initialPoolSize="25"
              p:minPoolSize="0"
              p:maxPoolSize="50"
              p:maxIdleTimeExcessConnections="1800"
              p:checkoutTimeout="900"
              p:acquireIncrement="5"
              p:acquireRetryAttempts="5"
              p:acquireRetryDelay="10"
              p:idleConnectionTestPeriod="300"
              p:preferredTestQuery="select 1 from dual"

2013-06-21 09:20:08,529 INFO [org.jasig.cas.services.DefaultServicesManagerImpl] - <Reloading registered services.>
2013-06-21 09:20:08,529 INFO [org.jasig.cas.CentralAuthenticationServiceImpl] - <Granted service ticket [ST-898887-X3ZN3ekt46PJC3s50Ung-hostname.fiu.edu] for service [https://fiu.blackboard.com/webapps/bb-auth-provider-cas-BBLEARN/execute/casLogin?cmd=login&authProviderId=_102_1&redirectUrl=https%3A%2F%2Ffiu.blackboard.com%2Fwebapps%2Fportal%2Fframeset.jsp] for user [eharr006]>
2013-06-21 09:20:09,418 ERROR [org.hibernate.util.JDBCExceptionReporter] - <An attempt by a client to checkout a Connection has timed out.>
2013-06-21 09:20:09,422 ERROR [org.hibernate.util.JDBCExceptionReporter] - <An attempt by a client to checkout a Connection has timed out.>
Exception in thread "pool-3-thread-166" org.springframework.transaction.CannotCreateTransactionException: Could not open JDBC Connection for transaction; nested exception is java.sql.SQLException: An attempt by a client to checkout a Connection has timed out.
        at org.springframework.jdbc.datasource.DataSourceTransactionManager.doBegin(DataSourceTransactionManager.java:240)
        at org.springframework.transaction.support.AbstractPlatformTransactionManager.getTransaction(AbstractPlatformTransactionManager.java:371)
        at org.springframework.transaction.support.TransactionTemplate.execute(TransactionTemplate.java:127)
        at com.github.inspektr.audit.support.JdbcAuditTrailManager$LoggingTask.run(JdbcAuditTrailManager.java:142)
        at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
        at java.lang.Thread.run(Thread.java:662)
Caused by: java.sql.SQLException: An attempt by a client to checkout a Connection has timed out.
        at com.mchange.v2.sql.SqlUtils.toSQLException(SqlUtils.java:106)
        at com.mchange.v2.sql.SqlUtils.toSQLException(SqlUtils.java:65)
        at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutPooledConnection(C3P0PooledConnectionPool.java:527)
        at com.mchange.v2.c3p0.impl.AbstractPoolBackedDataSource.getConnection(AbstractPoolBackedDataSource.java:128)
        at org.springframework.jdbc.datasource.DataSourceTransactionManager.doBegin(DataSourceTransactionManager.java:202)
        ... 6 more
Caused by: com.mchange.v2.resourcepool.TimeoutException: A client timed out while waiting to acquire a resource from com.mchange.v2.resourcepool.BasicResourcePool@6e3404f -- timeout at awaitAvailable()
        at com.mchange.v2.resourcepool.BasicResourcePool.awaitAvailable(BasicResourcePool.java:1317)
        at com.mchange.v2.resourcepool.BasicResourcePool.prelimCheckoutResource(BasicResourcePool.java:557)
        at com.mchange.v2.resourcepool.BasicResourcePool.checkoutResource(BasicResourcePool.java:477)
        at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutPooledConnection(C3P0PooledConnectionPool.java:525)
        ... 8 more
2013-06-21 09:20:09,430 ERROR [org.hibernate.util.JDBCExceptionReporter] - <An attempt by a client to checkout a Connection has timed out.>
2013-06-21 09:20:09,430 ERROR [org.quartz.core.JobRunShell] - <Job DEFAULT.serviceRegistryReloaderJobDetail threw an unhandled Exception: >

___________________
Juan Quintanilla

305-348-6573

jqui...@fiu.edu

-- 
You are currently subscribed to cas-...@lists.jasig.org as: jasig-cas-user...@googlegroups.com
To unsubscribe, change settings or access archives, see http://www.ja-sig.org/wiki/display/JSG/cas-user

[Alberto Cabello Sánchez]

On Fri, Jun 21, 2013 at 05:06:35PM +0000, Juan Quintanilla wrote:
> Hi,
>
> We are running CAS 3.4.7 with an Oracle Database and for the past couple of
> days we have encountered the error below for about 2 minutes or so and then
> goes away. Users then are unable to login during that time. I wanted to know
> if anyone would have any suggestions on the error. It seems to me that during
> that time the connections are exhausted and can no longer connect.
>
> Below is the error along with the C3P0 settings:
>
> id="dataSource"
> class="com.mchange.v2.c3p0.ComboPooledDataSource"
> p:driverClass="oracle.jdbc.driver.OracleDriver"
> p:jdbcUrl="xxxxxxx"
> p:user="xxxxxxx"
> p:password="xxxxxxxx"
> p:initialPoolSize="25"
> p:minPoolSize="0"
> p:maxPoolSize="50"
> p:maxIdleTimeExcessConnections="1800"
> p:checkoutTimeout="900"
> p:acquireIncrement="5"
> p:acquireRetryAttempts="5"
> p:acquireRetryDelay="10"
> p:idleConnectionTestPeriod="300"
> p:preferredTestQuery="select 1 from dual"
>

...

> 2013-06-21 09:20:09,418 ERROR [org.hibernate.util.JDBCExceptionReporter] - <An attempt by a client to checkout a Connection has timed out.>

AFAIK, checkoutTimeout value unit is miliseconds, so maybe you could increase it
to a higher value.

--
-----------------------
Alberto Cabello S�nchez
alb...@unex.es