节前的最后一天，sso登陆出现问题，多数用户无法正常登陆。经查询日志，报错如下：
错误日志截取如下
2015-02-15 08:40:30,536 INFO [org.jasig.cas.authentication.AuthenticationManagerImpl] – <com.gaochao.oa.module.sso.authentication.handler.FxLdapMixAuthenticationHandler successfully authenticated[username: wei.guo]>
2015-02-15 08:40:30,536 INFO [org.jasig.cas.authentication.AuthenticationManagerImpl] – <Resolved principal wei.guo>
2015-02-15 08:40:30,536 INFO [org.jasig.cas.authentication.AuthenticationManagerImpl] – <com.gaochao.oa.module.sso.authentication.handler.FxLdapMixAuthenticationHandler@7952dda7 authenticated wei.guo with credential [username: wei.guo].>
2015-02-15 08:40:30,537 INFO [com.github.inspektr.audit.support.Slf4jLoggingAuditTrailManager] – <Audit trail record BEGIN
2015-02-15 08:40:30,576 ERROR [com.gaochao.oa.module.sso.ticket.registry.RedisTicketRegistry] – <Failed adding TGT-18015-B0igJB5vgG03iiVqXKl5VSO0tnBtYipfauzcKLCfD2MvhVYTEP-cas01.example.org, error message :Could not get a resource from the pool>
2015-02-15 08:40:30,576 INFO [com.github.inspektr.audit.support.Slf4jLoggingAuditTrailManager] – <Audit trail record BEGIN
2015-02-15 08:40:30,955 ERROR [com.gaochao.oa.module.sso.ticket.registry.RedisTicketRegistry] – <Failed adding TGT-18016-nMaZefSqRG393dcANeR4S1Tc2ff1WWdCafrNGwESgXkwLkCfN3-cas01.example.org, error message :Could not get a resource from the pool>
通过以上日志可以看出问题代码在sso中，红色加粗部分可以看出sso服务器证书以及用户鉴权是成功的。
| 1 2 3 4 5 6 7 8 9 | if (!authenticationHandler.authenticate(credentials)) { log.info( "{} failed to authenticate {}" , handlerName, credentials); } else { log.info( "{} successfully authenticated {}" , handlerName, credentials); authenticatedClass = authenticationHandler; authenticated = true ; break ; } |
但是生成认证服务凭据ticket并且获得资源时失败
| 1 2 3 4 5 6 7 8 9 10 11 12 13 14 15 16 17 18 | try { jedis = getResource(); byte [] b = jedis.hget(SSO_HASH_ID, ticketId.getBytes()); if (b == null || b.length == 0 ) { return null ; } ByteArrayInputStream bais = new ByteArrayInputStream(b); ois = new ObjectInputStream(bais); ticket = (Ticket) ois.readObject(); } catch (JedisException e) { borrowOrOprSuccess = false ; returnBrokenResource(jedis); log.error( "Failed getTicket {}, error message :{}" , ticketId, e.getMessage()); } catch (Exception e) { log.error( "Failed getTicket {}, error message :{}" , ticketId, e.getMessage()); } |
这段代码中可能报出Redis异常和其他异常，通过Could not get a resource from the pool，可以认为是redis异常。再进一步跟踪报出异常的地方，见如下代码：
| 1 2 3 4 5 6 7 8 9 | @SuppressWarnings ( "unchecked" ) public T getResource() { try { return (T) internalPool.borrowObject(); } catch (Exception e) { throw new JedisConnectionException( "Could not get a resource from the pool" , e); } } |
在网上查找资料，一般认为这种异常都与redis的池连接配置有关：
产生红色部分的可能原因之一是客户端去redis服务器拿连接（代码描述的是租用对象borrowObject）的时候，池中无可用连接，即池中所有连接被占用，且在等待时候设定的超时时间后还没拿到时，会报出此异常。
解决办法：
1.调整JedisPoolConfig中maxActive为适合自己系统的阀值，当然这种情况下重启服务并将重建池连接是必然可行的。
我在查看我们系统的redis配置时，redis.properties中配置为redis.maxIdle=5000，
| 1 2 3 4 5 | # Redis settings redis.maxIdle=5000 redis.maxActive=5000 redis.maxWait=10000 redis.testOnBorrow=true |
理论上来说5000的并发量是足够的，不会出现拿不到资源的情况，但是我们的系统却出现了，继续查资料发现产生这问题的原因还可能是我们使用的redis2.1.0（redis自2.4.0后不需要手动归还）需要手动归还redis，而我们有的调用未归还，导致连接被长期占用；比如我们自己重写的类com.gaochao.oa.module.sso.ticket.registry.RedisTicketRegistry.java的getTickets只有获取资源，并没有归还的地方。如这里被频繁调用，在不长的时间内就很有可能在5000的情况下即出现资源连接不够用的情况。如下：
| 1 2 3 4 5 6 7 8 9 10 11 12 13 14 15 16 17 18 19 20 21 22 23 24 25 | /** * @author ** * @date 2013-7-15 下午10:13:19 * @see org.jasig.cas.ticket.registry.TicketRegistry#getTickets() * @return */ public Collection<Ticket> getTickets() { Jedis jedis = null ; jedis = getResource(); Map< byte [], byte []> map = jedis.hgetAll(SSO_HASH_ID); if (CollectionUtils.isEmpty(map)) { return new ArrayList<Ticket>(); } Map<String, Ticket> result = new HashMap(map.size()); for (Iterator<Map.Entry< byte [], byte []>> iterator = map.entrySet().iterator(); iterator.hasNext();) { Map.Entry< byte [], byte []> entry = iterator.next(); // Object jsonValue = redisSerializer.parseObject(entry.getValue()); String ticketId = new String(entry.getKey()); Ticket ticket = getTicket(ticketId); if (ticket != null ) { result.put(ticketId, ticket); } } return result.values(); } |
如是以上问题，建议
1.redis换用redis 2.4.0以上版本；
2.对我们自己写的类进行走读，凡获取redis资源的地方必须需释放（一般使用redis的地方都有一个finally即最终必须执行的代码负责归还连接）
如下：
| 1 2 3 4 5 6 7 | finally { IOUtils.close(ois); if (borrowOrOprSuccess) { //返回到资源池 returnResource(jedis); } } |
另外，其他的原因还可能是网络异常、redis服务器异常等。
节前初步解决方案是每两天重启sso、redis服务器，另外节后对代码进行走读，将获取资源后未释放的代码全部进行修复。
本文转自 gaochaojs 51CTO博客，原文链接：http://blog.51cto.com/jncumter/1615620，如需转载请自行联系原作者
