Spring+EhCache缓存实例（详细讲解+源码下载）(转)

一、ehcahe的介绍

EhCache 是一个纯Java的进程内缓存框架，具有快速、精干等特点，是Hibernate中默认的CacheProvider。Ehcache是一种广泛使用的开源Java分布式缓存。主要面向通用缓存,Java EE和轻量级容器。它具有内存和磁盘存储，缓存加载器,缓存扩展，缓存异常处理程序，一个gzip缓存servlet过滤器，支持REST和SOAP api等特点。

优点： 
1. 快速 
2. 简单 
3. 多种缓存策略 
4. 缓存数据有两级：内存和磁盘，因此无需担心容量问题 
5. 缓存数据会在虚拟机重启的过程中写入磁盘 
6. 可以通过RMI、可插入API等方式进行分布式缓存 
7. 具有缓存和缓存管理器的侦听接口 
8. 支持多缓存管理器实例，以及一个实例的多个缓存区域 
9. 提供Hibernate的缓存实现

缺点： 
1. 使用磁盘Cache的时候非常占用磁盘空间：这是因为DiskCache的算法简单，该算法简单也导致Cache的效率非常高。它只是对元素直接追加存储。因此搜索元素的时候非常的快。如果使用DiskCache的，在很频繁的应用中，很快磁盘会满。 
2. 不能保证数据的安全：当突然kill掉java的时候，可能会产生冲突，EhCache的解决方法是如果文件冲突了，则重建cache。这对于Cache数据需要保存的时候可能不利。当然，Cache只是简单的加速，而不能保证数据的安全。如果想保证数据的存储安全，可以使用Bekeley DB Java Edition版本。这是个嵌入式数据库。可以确保存储安全和空间的利用率。

EhCache的分布式缓存有传统的RMI，1.5版的JGroups，1.6版的JMS。分布式缓存主要解决集群环境中不同的服务器间的数据的同步问题。

使用Spring的AOP进行整合，可以灵活的对方法的返回结果对象进行缓存。

下面将介绍Spring+EhCache详细实例。

二、详细实例讲解

本实例的环境 eclipse + maven + spring + ehcache + junit

2.1、相关依赖pom.xml

<?xml version="1.0" encoding="UTF-8"?>
<project xmlns="http://maven.apache.org/POM/4.0.0"
         xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xsi:schemaLocation="http://maven.apache.org/POM/4.0.0 http://maven.apache.org/xsd/maven-4.0.0.xsd">
    <modelVersion>4.0.0</modelVersion>

    <groupId>com</groupId>
    <artifactId>ehcache_demo</artifactId>
    <version>1.0-SNAPSHOT</version>

    <properties>
        <!-- spring版本号 -->
        <spring.version>3.2.8.RELEASE</spring.version>
        <!-- log4j日志文件管理包版本 -->
        <slf4j.version>1.6.6</slf4j.version>
        <log4j.version>1.2.12</log4j.version>
        <!-- junit版本号 -->
        <junit.version>4.10</junit.version>
    </properties>

    <dependencies>
        <!-- 添加Spring依赖 -->
        <dependency>
            <groupId>org.springframework</groupId>
            <artifactId>spring-core</artifactId>
            <version>${spring.version}</version>
        </dependency>
        <dependency>
            <groupId>org.springframework</groupId>
            <artifactId>spring-webmvc</artifactId>
            <version>${spring.version}</version>
        </dependency>
        <dependency>
            <groupId>org.springframework</groupId>
            <artifactId>spring-context</artifactId>
            <version>${spring.version}</version>
        </dependency>
        <dependency>
            <groupId>org.springframework</groupId>
            <artifactId>spring-context-support</artifactId>
            <version>${spring.version}</version>
        </dependency>
        <dependency>
            <groupId>org.springframework</groupId>
            <artifactId>spring-aop</artifactId>
            <version>${spring.version}</version>
        </dependency>
        <dependency>
            <groupId>org.springframework</groupId>
            <artifactId>spring-aspects</artifactId>
            <version>${spring.version}</version>
        </dependency>
        <dependency>
            <groupId>org.springframework</groupId>
            <artifactId>spring-tx</artifactId>
            <version>${spring.version}</version>
        </dependency>
        <dependency>
            <groupId>org.springframework</groupId>
            <artifactId>spring-jdbc</artifactId>
            <version>${spring.version}</version>
        </dependency>
        <dependency>
            <groupId>org.springframework</groupId>
            <artifactId>spring-web</artifactId>
            <version>${spring.version}</version>
        </dependency>

        <!--单元测试依赖 -->
        <dependency>
            <groupId>junit</groupId>
            <artifactId>junit</artifactId>
            <version>${junit.version}</version>
            <scope>test</scope>
        </dependency>

        <!--spring单元测试依赖 -->
        <dependency>
            <groupId>org.springframework</groupId>
            <artifactId>spring-test</artifactId>
            <version>${spring.version}</version>
            <scope>test</scope>
        </dependency>

        <!-- ehcache 相关依赖  -->
        <dependency>
            <groupId>net.sf.ehcache</groupId>
            <artifactId>ehcache</artifactId>
            <version>2.8.3</version>
        </dependency>

        <!-- 日志文件管理包 -->
        <!-- log start -->
        <dependency>
            <groupId>log4j</groupId>
            <artifactId>log4j</artifactId>
            <version>${log4j.version}</version>
        </dependency>
        <dependency>
            <groupId>org.slf4j</groupId>
            <artifactId>slf4j-api</artifactId>
            <version>${slf4j.version}</version>
        </dependency>
        <dependency>
            <groupId>org.slf4j</groupId>
            <artifactId>slf4j-log4j12</artifactId>
            <version>${slf4j.version}</version>
        </dependency>
    </dependencies>
    <build>
        <plugins>
            <plugin>
                <artifactId>maven-compiler-plugin</artifactId>
                <configuration>
                    <source>1.7</source>
                    <target>1.7</target>
                </configuration>
            </plugin>
        </plugins>
    </build>
</project>

2.2、添加ehcache配置文件ehcache-setting.xml

<?xml version="1.0" encoding="UTF-8"?>
<ehcache>
    <!-- 指定一个文件目录，当EhCache把数据写到硬盘上时，将把数据写到这个文件目录下 -->
    <diskStore path="java.io.tmpdir"/>
    <!-- 设定缓存的默认数据过期策略 -->
    <defaultCache
            maxElementsInMemory="10000"
            eternal="false"
            overflowToDisk="true"
            timeToIdleSeconds="10"
            timeToLiveSeconds="20"
            diskPersistent="false"
            diskExpiryThreadIntervalSeconds="120"/>

    <cache name="cacheTest"
           maxElementsInMemory="1000"
           eternal="false"
           overflowToDisk="true"
           timeToIdleSeconds="10"
           timeToLiveSeconds="20"/>

</ehcache>
        <!--
        cache元素的属性：
        name：缓存名称
        maxElementsInMemory：内存中最大缓存对象数
        maxElementsOnDisk：硬盘中最大缓存对象数，若是0表示无穷大
        eternal：true表示对象永不过期，此时会忽略timeToIdleSeconds和timeToLiveSeconds属性，默认为false
        overflowToDisk：true表示当内存缓存的对象数目达到了
        maxElementsInMemory界限后，会把溢出的对象写到硬盘缓存中。注意：如果缓存的对象要写入到硬盘中的话，则该对象必须实现了Serializable接口才行。
        diskSpoolBufferSizeMB：磁盘缓存区大小，默认为30MB。每个Cache都应该有自己的一个缓存区。
        diskPersistent：是否缓存虚拟机重启期数据，是否持久化磁盘缓存,当这个属性的值为true时,系统在初始化时会在磁盘中查找文件名为cache名称,后缀名为index的文件，这个文件中存放了已经持久化在磁盘中的cache的index,找到后会把cache加载到内存，要想把cache真正持久化到磁盘,写程序时注意执行net.sf.ehcache.Cache.put(Element element)后要调用flush()方法。
        diskExpiryThreadIntervalSeconds：磁盘失效线程运行时间间隔，默认为120秒
        timeToIdleSeconds： 设定允许对象处于空闲状态的最长时间，以秒为单位。当对象自从最近一次被访问后，如果处于空闲状态的时间超过了timeToIdleSeconds属性值，这个对象就会过期，EHCache将把它从缓存中清空。只有当eternal属性为false，该属性才有效。如果该属性值为0，则表示对象可以无限期地处于空闲状态
        timeToLiveSeconds：设定对象允许存在于缓存中的最长时间，以秒为单位。当对象自从被存放到缓存中后，如果处于缓存中的时间超过了 timeToLiveSeconds属性值，这个对象就会过期，EHCache将把它从缓存中清除。只有当eternal属性为false，该属性才有效。如果该属性值为0，则表示对象可以无限期地存在于缓存中。timeToLiveSeconds必须大于timeToIdleSeconds属性，才有意义
        memoryStoreEvictionPolicy：当达到maxElementsInMemory限制时，Ehcache将会根据指定的策略去清理内存。可选策略有：LRU（最近最少使用，默认策略）、FIFO（先进先出）、LFU（最少访问次数）。
        -->

这里我们配置了cacheTest策略，10秒过期。

2.3、spring配置文件application.xml

<?xml version="1.0" encoding="UTF-8"?>
<beans xmlns="http://www.springframework.org/schema/beans"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xmlns:cache="http://www.springframework.org/schema/cache"
       xmlns:context="http://www.springframework.org/schema/context"
       xmlns:aop="http://www.springframework.org/schema/aop"
       xsi:schemaLocation="
           http://www.springframework.org/schema/beans
           http://www.springframework.org/schema/beans/spring-beans-3.0.xsd
           http://www.springframework.org/schema/aop
           http://www.springframework.org/schema/aop/spring-aop-3.0.xsd
           http://www.springframework.org/schema/context
           http://www.springframework.org/schema/context/spring-context-3.0.xsd
           http://www.springframework.org/schema/cache
           http://www.springframework.org/schema/cache/spring-cache-3.1.xsd">
    <!-- 自动扫描注解的bean -->
    <context:component-scan base-package="com.service"/>

    <cache:annotation-driven cache-manager="cacheManager"/>

    <bean id="cacheManager" class="org.springframework.cache.ehcache.EhCacheCacheManager">
        <property name="cacheManager" ref="ehcache"></property>
    </bean>

    <bean id="ehcache" class="org.springframework.cache.ehcache.EhCacheManagerFactoryBean">
        <property name="configLocation" value="classpath:ehcache-setting.xml"></property>
    </bean>
</beans>

2.4、EhCacheTestService接口

package com.service;

public interface EhCacheTestService {
    public String getTimestamp(String param);
}

2.5、EhCacheTestService接口实现

package com.service.impl;

import com.service.EhCacheTestService;
import org.springframework.cache.annotation.Cacheable;
import org.springframework.stereotype.Service;

@Service
public class EhCacheTestServiceImpl implements EhCacheTestService {
    @Cacheable(value = "cacheTest", key = "#param")//注解中value=”cacheTest”与ehcache-setting.xml中的cache名称属性值一致
    public String getTimestamp(String param) {
        Long timestamp = System.currentTimeMillis();
        return timestamp.toString();
    }
}

2.6、单元测试类

package com.service.impl;

import org.junit.runner.RunWith;
import org.springframework.test.context.ContextConfiguration;
import org.springframework.test.context.junit4.SpringJUnit4ClassRunner;

/**
 * Created by MyWorld on 2016/6/26.
 */
@ContextConfiguration(locations = {"classpath:application.xml"})
@RunWith(SpringJUnit4ClassRunner.class)
public class SpringTestCase {
}

package com.service.impl;

import com.service.EhCacheTestService;
import org.junit.Test;
import org.slf4j.Logger;
import org.slf4j.LoggerFactory;

import javax.annotation.Resource;

import java.util.concurrent.TimeUnit;

import static org.junit.Assert.*;

/**
 * Created by MyWorld on 2016/6/26.
 */
public class EhCacheTestServiceImplTest extends SpringTestCase {
    private Logger LOGGER = LoggerFactory.getLogger(EhCacheTestServiceImplTest.class);
    @Resource
    private EhCacheTestService ehCacheTestService;

    @Test
    public void testGetTimestamp() throws Exception {
        LOGGER.info("First Invoke:{}", ehCacheTestService.getTimestamp("param"));
        TimeUnit.SECONDS.sleep(2);
        LOGGER.info("Invoke After 2 second:{}", ehCacheTestService.getTimestamp("param"));
        TimeUnit.SECONDS.sleep(11);
        LOGGER.info("Invoke After 11 second:{}", ehCacheTestService.getTimestamp("param"));
    }
}

log4j.properties

log4j.rootLogger=debug, R1,console
log4j.appender.R1=org.apache.log4j.DailyRollingFileAppender
log4j.appender.R1.File=logs/ehcache.log
log4j.appender.R1.DatePattern='_'yyyy-MM-dd'.log'
log4j.appender.R1.layout=org.apache.log4j.PatternLayout
log4j.appender.R1.layout.ConversionPattern=[%d] [%t][%c] %p - %m%n


log4j.appender.console=org.apache.log4j.ConsoleAppender
log4j.appender.console.layout=org.apache.log4j.PatternLayout
log4j.appender.console.layout.ConversionPattern=[%d] [%t][%c] %p - %m%n

2.7、运行结果:

[2016-06-26 00:33:18,226] [main][org.springframework.test.context.junit4.SpringJUnit4ClassRunner] DEBUG - SpringJUnit4ClassRunner constructor called with [class com.service.impl.EhCacheTestServiceImplTest].
[2016-06-26 00:33:18,305] [main][org.springframework.test.context.support.AbstractDelegatingSmartContextLoader] DEBUG - Delegating to GenericXmlContextLoader to process context configuration [ContextConfigurationAttributes@6de728 declaringClass = 'com.service.impl.SpringTestCase', locations = '{classpath:application.xml}', classes = '{}', inheritLocations = true, initializers = '{}', inheritInitializers = true, name = [null], contextLoaderClass = 'org.springframework.test.context.ContextLoader'].
[2016-06-26 00:33:18,352] [main][org.springframework.test.context.ContextLoaderUtils] DEBUG - Could not find an 'annotation declaring class' for annotation type [org.springframework.test.context.ActiveProfiles] and class [com.service.impl.EhCacheTestServiceImplTest]
[2016-06-26 00:33:18,359] [main][org.springframework.test.context.TestContextManager] DEBUG - @TestExecutionListeners is not present for class [class com.service.impl.EhCacheTestServiceImplTest]: using defaults.
[2016-06-26 00:33:18,365] [main][org.springframework.test.context.TestContextManager] INFO - Could not instantiate TestExecutionListener class [org.springframework.test.context.web.ServletTestExecutionListener]. Specify custom listener classes or make the default listener classes (and their dependencies) available.
[2016-06-26 00:33:18,388] [main][org.springframework.test.annotation.ProfileValueUtils] DEBUG - Retrieved @ProfileValueSourceConfiguration [null] for test class [com.service.impl.EhCacheTestServiceImplTest]
[2016-06-26 00:33:18,389] [main][org.springframework.test.annotation.ProfileValueUtils] DEBUG - Retrieved ProfileValueSource type [class org.springframework.test.annotation.SystemProfileValueSource] for class [com.service.impl.EhCacheTestServiceImplTest]
[2016-06-26 00:33:18,402] [main][org.springframework.test.annotation.ProfileValueUtils] DEBUG - Retrieved @ProfileValueSourceConfiguration [null] for test class [com.service.impl.EhCacheTestServiceImplTest]
[2016-06-26 00:33:18,403] [main][org.springframework.test.annotation.ProfileValueUtils] DEBUG - Retrieved ProfileValueSource type [class org.springframework.test.annotation.SystemProfileValueSource] for class [com.service.impl.EhCacheTestServiceImplTest]
[2016-06-26 00:33:18,408] [main][org.springframework.test.annotation.ProfileValueUtils] DEBUG - Retrieved @ProfileValueSourceConfiguration [null] for test class [com.service.impl.EhCacheTestServiceImplTest]
[2016-06-26 00:33:18,410] [main][org.springframework.test.annotation.ProfileValueUtils] DEBUG - Retrieved ProfileValueSource type [class org.springframework.test.annotation.SystemProfileValueSource] for class [com.service.impl.EhCacheTestServiceImplTest]
[2016-06-26 00:33:18,417] [main][org.springframework.test.annotation.ProfileValueUtils] DEBUG - Retrieved @ProfileValueSourceConfiguration [null] for test class [com.service.impl.EhCacheTestServiceImplTest]
[2016-06-26 00:33:18,418] [main][org.springframework.test.annotation.ProfileValueUtils] DEBUG - Retrieved ProfileValueSource type [class org.springframework.test.annotation.SystemProfileValueSource] for class [com.service.impl.EhCacheTestServiceImplTest]
[2016-06-26 00:33:18,424] [main][org.springframework.test.annotation.ProfileValueUtils] DEBUG - Retrieved @ProfileValueSourceConfiguration [null] for test class [com.service.impl.EhCacheTestServiceImplTest]
[2016-06-26 00:33:18,425] [main][org.springframework.test.annotation.ProfileValueUtils] DEBUG - Retrieved ProfileValueSource type [class org.springframework.test.annotation.SystemProfileValueSource] for class [com.service.impl.EhCacheTestServiceImplTest]
[2016-06-26 00:33:18,441] [main][org.springframework.test.context.support.DependencyInjectionTestExecutionListener] DEBUG - Performing dependency injection for test context [[TestContext@108b2d7 testClass = EhCacheTestServiceImplTest, testInstance = com.service.impl.EhCacheTestServiceImplTest@154909b, testMethod = [null], testException = [null], mergedContextConfiguration = [MergedContextConfiguration@1f256fa testClass = EhCacheTestServiceImplTest, locations = '{classpath:application.xml}', classes = '{}', contextInitializerClasses = '[]', activeProfiles = '{}', contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]].
[2016-06-26 00:33:18,444] [main][org.springframework.test.context.support.AbstractDelegatingSmartContextLoader] DEBUG - Delegating to GenericXmlContextLoader to load context from [MergedContextConfiguration@1f256fa testClass = EhCacheTestServiceImplTest, locations = '{classpath:application.xml}', classes = '{}', contextInitializerClasses = '[]', activeProfiles = '{}', contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]].
[2016-06-26 00:33:18,447] [main][org.springframework.test.context.support.AbstractGenericContextLoader] DEBUG - Loading ApplicationContext for merged context configuration [[MergedContextConfiguration@1f256fa testClass = EhCacheTestServiceImplTest, locations = '{classpath:application.xml}', classes = '{}', contextInitializerClasses = '[]', activeProfiles = '{}', contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
[2016-06-26 00:33:18,631] [main][org.springframework.core.env.StandardEnvironment] DEBUG - Adding [systemProperties] PropertySource with lowest search precedence
[2016-06-26 00:33:18,634] [main][org.springframework.core.env.StandardEnvironment] DEBUG - Adding [systemEnvironment] PropertySource with lowest search precedence
[2016-06-26 00:33:18,635] [main][org.springframework.core.env.StandardEnvironment] DEBUG - Initialized StandardEnvironment with PropertySources [systemProperties,systemEnvironment]
[2016-06-26 00:33:18,671] [main][org.springframework.beans.factory.xml.XmlBeanDefinitionReader] INFO - Loading XML bean definitions from class path resource [application.xml]
[2016-06-26 00:33:18,737] [main][org.springframework.beans.factory.xml.DefaultDocumentLoader] DEBUG - Using JAXP provider [com.sun.org.apache.xerces.internal.jaxp.DocumentBuilderFactoryImpl]
[2016-06-26 00:33:18,803] [main][org.springframework.beans.factory.xml.PluggableSchemaResolver] DEBUG - Loading schema mappings from [META-INF/spring.schemas]
[2016-06-26 00:33:18,810] [main][org.springframework.beans.factory.xml.PluggableSchemaResolver] DEBUG - Loaded schema mappings: {http://www.springframework.org/schema/util/spring-util.xsd=org/springframework/beans/factory/xml/spring-util-3.2.xsd, http://www.springframework.org/schema/jee/spring-jee-3.2.xsd=org/springframework/ejb/config/spring-jee-3.2.xsd, http://www.springframework.org/schema/mvc/spring-mvc-3.1.xsd=org/springframework/web/servlet/config/spring-mvc-3.1.xsd, http://www.springframework.org/schema/task/spring-task.xsd=org/springframework/scheduling/config/spring-task-3.2.xsd, http://www.springframework.org/schema/beans/spring-beans-3.1.xsd=org/springframework/beans/factory/xml/spring-beans-3.1.xsd, http://www.springframework.org/schema/cache/spring-cache.xsd=org/springframework/cache/config/spring-cache-3.2.xsd, http://www.springframework.org/schema/aop/spring-aop-3.0.xsd=org/springframework/aop/config/spring-aop-3.0.xsd, http://www.springframework.org/schema/aop/spring-aop-2.0.xsd=org/springframework/aop/config/spring-aop-2.0.xsd, http://www.springframework.org/schema/task/spring-task-3.1.xsd=org/springframework/scheduling/config/spring-task-3.1.xsd, http://www.springframework.org/schema/tool/spring-tool-2.5.xsd=org/springframework/beans/factory/xml/spring-tool-2.5.xsd, http://www.springframework.org/schema/beans/spring-beans.xsd=org/springframework/beans/factory/xml/spring-beans-3.2.xsd, http://www.springframework.org/schema/jee/spring-jee-2.5.xsd=org/springframework/ejb/config/spring-jee-2.5.xsd, http://www.springframework.org/schema/jdbc/spring-jdbc-3.1.xsd=org/springframework/jdbc/config/spring-jdbc-3.1.xsd, http://www.springframework.org/schema/tool/spring-tool-3.1.xsd=org/springframework/beans/factory/xml/spring-tool-3.1.xsd, http://www.springframework.org/schema/aop/spring-aop.xsd=org/springframework/aop/config/spring-aop-3.2.xsd, http://www.springframework.org/schema/jee/spring-jee-3.1.xsd=org/springframework/ejb/config/spring-jee-3.1.xsd, http://www.springframework.org/schema/tx/spring-tx-3.2.xsd=org/springframework/transaction/config/spring-tx-3.2.xsd, http://www.springframework.org/schema/context/spring-context-3.2.xsd=org/springframework/context/config/spring-context-3.2.xsd, http://www.springframework.org/schema/beans/spring-beans-2.0.xsd=org/springframework/beans/factory/xml/spring-beans-2.0.xsd, http://www.springframework.org/schema/util/spring-util-3.2.xsd=org/springframework/beans/factory/xml/spring-util-3.2.xsd, http://www.springframework.org/schema/lang/spring-lang-3.2.xsd=org/springframework/scripting/config/spring-lang-3.2.xsd, http://www.springframework.org/schema/mvc/spring-mvc-3.0.xsd=org/springframework/web/servlet/config/spring-mvc-3.0.xsd, http://www.springframework.org/schema/beans/spring-beans-3.0.xsd=org/springframework/beans/factory/xml/spring-beans-3.0.xsd, http://www.springframework.org/schema/cache/spring-cache-3.2.xsd=org/springframework/cache/config/spring-cache-3.2.xsd, http://www.springframework.org/schema/task/spring-task-3.0.xsd=org/springframework/scheduling/config/spring-task-3.0.xsd, http://www.springframework.org/schema/tx/spring-tx-2.5.xsd=org/springframework/transaction/config/spring-tx-2.5.xsd, http://www.springframework.org/schema/context/spring-context-2.5.xsd=org/springframework/context/config/spring-context-2.5.xsd, http://www.springframework.org/schema/jdbc/spring-jdbc-3.0.xsd=org/springframework/jdbc/config/spring-jdbc-3.0.xsd, http://www.springframework.org/schema/tool/spring-tool-3.0.xsd=org/springframework/beans/factory/xml/spring-tool-3.0.xsd, http://www.springframework.org/schema/tx/spring-tx.xsd=org/springframework/transaction/config/spring-tx-3.2.xsd, http://www.springframework.org/schema/lang/spring-lang.xsd=org/springframework/scripting/config/spring-lang-3.2.xsd, http://www.springframework.org/schema/tool/spring-tool-2.0.xsd=org/springframework/beans/factory/xml/spring-tool-2.0.xsd, http://www.springframework.org/schema/util/spring-util-2.5.xsd=org/springframework/beans/factory/xml/spring-util-2.5.xsd, http://www.springframework.org/schema/lang/spring-lang-2.5.xsd=org/springframework/scripting/config/spring-lang-2.5.xsd, http://www.springframework.org/schema/aop/spring-aop-3.2.xsd=org/springframework/aop/config/spring-aop-3.2.xsd, http://www.springframework.org/schema/jee/spring-jee-3.0.xsd=org/springframework/ejb/config/spring-jee-3.0.xsd, http://www.springframework.org/schema/tx/spring-tx-3.1.xsd=org/springframework/transaction/config/spring-tx-3.1.xsd, http://www.springframework.org/schema/jee/spring-jee-2.0.xsd=org/springframework/ejb/config/spring-jee-2.0.xsd, http://www.springframework.org/schema/context/spring-context-3.1.xsd=org/springframework/context/config/spring-context-3.1.xsd, http://www.springframework.org/schema/util/spring-util-3.1.xsd=org/springframework/beans/factory/xml/spring-util-3.1.xsd, http://www.springframework.org/schema/lang/spring-lang-3.1.xsd=org/springframework/scripting/config/spring-lang-3.1.xsd, http://www.springframework.org/schema/cache/spring-cache-3.1.xsd=org/springframework/cache/config/spring-cache-3.1.xsd, http://www.springframework.org/schema/context/spring-context.xsd=org/springframework/context/config/spring-context-3.2.xsd, http://www.springframework.org/schema/jee/spring-jee.xsd=org/springframework/ejb/config/spring-jee-3.2.xsd, http://www.springframework.org/schema/aop/spring-aop-2.5.xsd=org/springframework/aop/config/spring-aop-2.5.xsd, http://www.springframework.org/schema/mvc/spring-mvc.xsd=org/springframework/web/servlet/config/spring-mvc-3.2.xsd, http://www.springframework.org/schema/jdbc/spring-jdbc.xsd=org/springframework/jdbc/config/spring-jdbc-3.2.xsd, http://www.springframework.org/schema/mvc/spring-mvc-3.2.xsd=org/springframework/web/servlet/config/spring-mvc-3.2.xsd, http://www.springframework.org/schema/beans/spring-beans-3.2.xsd=org/springframework/beans/factory/xml/spring-beans-3.2.xsd, http://www.springframework.org/schema/tx/spring-tx-2.0.xsd=org/springframework/transaction/config/spring-tx-2.0.xsd, http://www.springframework.org/schema/aop/spring-aop-3.1.xsd=org/springframework/aop/config/spring-aop-3.1.xsd, http://www.springframework.org/schema/task/spring-task-3.2.xsd=org/springframework/scheduling/config/spring-task-3.2.xsd, http://www.springframework.org/schema/tx/spring-tx-3.0.xsd=org/springframework/transaction/config/spring-tx-3.0.xsd, http://www.springframework.org/schema/context/spring-context-3.0.xsd=org/springframework/context/config/spring-context-3.0.xsd, http://www.springframework.org/schema/tool/spring-tool.xsd=org/springframework/beans/factory/xml/spring-tool-3.2.xsd, http://www.springframework.org/schema/util/spring-util-3.0.xsd=org/springframework/beans/factory/xml/spring-util-3.0.xsd, http://www.springframework.org/schema/lang/spring-lang-3.0.xsd=org/springframework/scripting/config/spring-lang-3.0.xsd, http://www.springframework.org/schema/util/spring-util-2.0.xsd=org/springframework/beans/factory/xml/spring-util-2.0.xsd, http://www.springframework.org/schema/lang/spring-lang-2.0.xsd=org/springframework/scripting/config/spring-lang-2.0.xsd, http://www.springframework.org/schema/jdbc/spring-jdbc-3.2.xsd=org/springframework/jdbc/config/spring-jdbc-3.2.xsd, http://www.springframework.org/schema/tool/spring-tool-3.2.xsd=org/springframework/beans/factory/xml/spring-tool-3.2.xsd, http://www.springframework.org/schema/beans/spring-beans-2.5.xsd=org/springframework/beans/factory/xml/spring-beans-2.5.xsd}
[2016-06-26 00:33:18,856] [main][org.springframework.beans.factory.xml.PluggableSchemaResolver] DEBUG - Found XML schema [http://www.springframework.org/schema/beans/spring-beans-3.0.xsd] in classpath: org/springframework/beans/factory/xml/spring-beans-3.0.xsd
[2016-06-26 00:33:18,925] [main][org.springframework.beans.factory.xml.PluggableSchemaResolver] DEBUG - Found XML schema [http://www.springframework.org/schema/context/spring-context-3.0.xsd] in classpath: org/springframework/context/config/spring-context-3.0.xsd
[2016-06-26 00:33:18,935] [main][org.springframework.beans.factory.xml.PluggableSchemaResolver] DEBUG - Found XML schema [http://www.springframework.org/schema/tool/spring-tool-3.0.xsd] in classpath: org/springframework/beans/factory/xml/spring-tool-3.0.xsd
[2016-06-26 00:33:18,946] [main][org.springframework.beans.factory.xml.PluggableSchemaResolver] DEBUG - Found XML schema [http://www.springframework.org/schema/cache/spring-cache-3.1.xsd] in classpath: org/springframework/cache/config/spring-cache-3.1.xsd
[2016-06-26 00:33:18,961] [main][org.springframework.beans.factory.xml.DefaultBeanDefinitionDocumentReader] DEBUG - Loading bean definitions
[2016-06-26 00:33:18,986] [main][org.springframework.beans.factory.xml.DefaultNamespaceHandlerResolver] DEBUG - Loaded NamespaceHandler mappings: {http://www.springframework.org/schema/p=org.springframework.beans.factory.xml.SimplePropertyNamespaceHandler, http://www.springframework.org/schema/mvc=org.springframework.web.servlet.config.MvcNamespaceHandler, http://www.springframework.org/schema/util=org.springframework.beans.factory.xml.UtilNamespaceHandler, http://www.springframework.org/schema/jee=org.springframework.ejb.config.JeeNamespaceHandler, http://www.springframework.org/schema/aop=org.springframework.aop.config.AopNamespaceHandler, http://www.springframework.org/schema/jdbc=org.springframework.jdbc.config.JdbcNamespaceHandler, http://www.springframework.org/schema/cache=org.springframework.cache.config.CacheNamespaceHandler, http://www.springframework.org/schema/c=org.springframework.beans.factory.xml.SimpleConstructorNamespaceHandler, http://www.springframework.org/schema/tx=org.springframework.transaction.config.TxNamespaceHandler, http://www.springframework.org/schema/task=org.springframework.scheduling.config.TaskNamespaceHandler, http://www.springframework.org/schema/lang=org.springframework.scripting.config.LangNamespaceHandler, http://www.springframework.org/schema/context=org.springframework.context.config.ContextNamespaceHandler}
[2016-06-26 00:33:19,046] [main][org.springframework.core.io.support.PathMatchingResourcePatternResolver] DEBUG - Looking for matching resources in directory tree [E:javastsworkspaceehcache_project	arget	est-classescomservice]
[2016-06-26 00:33:19,048] [main][org.springframework.core.io.support.PathMatchingResourcePatternResolver] DEBUG - Searching directory [E:javastsworkspaceehcache_project	arget	est-classescomservice] for files matching pattern [E:/java/sts/workspace/ehcache_project/target/test-classes/com/service/**/*.class]
[2016-06-26 00:33:19,053] [main][org.springframework.core.io.support.PathMatchingResourcePatternResolver] DEBUG - Searching directory [E:javastsworkspaceehcache_project	arget	est-classescomserviceimpl] for files matching pattern [E:/java/sts/workspace/ehcache_project/target/test-classes/com/service/**/*.class]
[2016-06-26 00:33:19,061] [main][org.springframework.core.io.support.PathMatchingResourcePatternResolver] DEBUG - Looking for matching resources in directory tree [E:javastsworkspaceehcache_project	argetclassescomservice]
[2016-06-26 00:33:19,062] [main][org.springframework.core.io.support.PathMatchingResourcePatternResolver] DEBUG - Searching directory [E:javastsworkspaceehcache_project	argetclassescomservice] for files matching pattern [E:/java/sts/workspace/ehcache_project/target/classes/com/service/**/*.class]
[2016-06-26 00:33:19,064] [main][org.springframework.core.io.support.PathMatchingResourcePatternResolver] DEBUG - Searching directory [E:javastsworkspaceehcache_project	argetclassescomserviceimpl] for files matching pattern [E:/java/sts/workspace/ehcache_project/target/classes/com/service/**/*.class]
[2016-06-26 00:33:19,067] [main][org.springframework.core.io.support.PathMatchingResourcePatternResolver] DEBUG - Resolved location pattern [classpath*:com/service/**/*.class] to resources [file [E:javastsworkspaceehcache_project	arget	est-classescomserviceimplEhCacheTestServiceImplTest.class], file [E:javastsworkspaceehcache_project	arget	est-classescomserviceimplSpringTestCase.class], file [E:javastsworkspaceehcache_project	argetclassescomserviceEhCacheTestService.class], file [E:javastsworkspaceehcache_project	argetclassescomserviceimplEhCacheTestServiceImpl.class]]
[2016-06-26 00:33:19,131] [main][org.springframework.context.annotation.ClassPathBeanDefinitionScanner] DEBUG - Identified candidate component class: file [E:javastsworkspaceehcache_project	argetclassescomserviceimplEhCacheTestServiceImpl.class]
[2016-06-26 00:33:19,200] [main][org.springframework.beans.factory.xml.XmlBeanDefinitionReader] DEBUG - Loaded 11 bean definitions from location pattern [classpath:application.xml]
[2016-06-26 00:33:19,221] [main][org.springframework.context.support.GenericApplicationContext] INFO - Refreshing org.springframework.context.support.GenericApplicationContext@13fcdbd: startup date [Sun Jun 26 00:33:19 CST 2016]; root of context hierarchy
[2016-06-26 00:33:19,222] [main][org.springframework.context.support.GenericApplicationContext] DEBUG - Bean factory for org.springframework.context.support.GenericApplicationContext@13fcdbd: org.springframework.beans.factory.support.DefaultListableBeanFactory@4a7dd4: defining beans [ehCacheTestServiceImpl,org.springframework.context.annotation.internalConfigurationAnnotationProcessor,org.springframework.context.annotation.internalAutowiredAnnotationProcessor,org.springframework.context.annotation.internalRequiredAnnotationProcessor,org.springframework.context.annotation.internalCommonAnnotationProcessor,org.springframework.aop.config.internalAutoProxyCreator,org.springframework.cache.annotation.AnnotationCacheOperationSource#0,org.springframework.cache.interceptor.CacheInterceptor#0,org.springframework.cache.config.internalCacheAdvisor,cacheManager,ehcache]; root of factory hierarchy
[2016-06-26 00:33:19,267] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Creating shared instance of singleton bean 'org.springframework.context.annotation.internalConfigurationAnnotationProcessor'
[2016-06-26 00:33:19,271] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Creating instance of bean 'org.springframework.context.annotation.internalConfigurationAnnotationProcessor'
[2016-06-26 00:33:19,309] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Eagerly caching bean 'org.springframework.context.annotation.internalConfigurationAnnotationProcessor' to allow for resolving potential circular references
[2016-06-26 00:33:19,317] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Finished creating instance of bean 'org.springframework.context.annotation.internalConfigurationAnnotationProcessor'
[2016-06-26 00:33:19,375] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Creating shared instance of singleton bean 'org.springframework.context.annotation.internalAutowiredAnnotationProcessor'
[2016-06-26 00:33:19,377] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Creating instance of bean 'org.springframework.context.annotation.internalAutowiredAnnotationProcessor'
[2016-06-26 00:33:19,379] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Eagerly caching bean 'org.springframework.context.annotation.internalAutowiredAnnotationProcessor' to allow for resolving potential circular references
[2016-06-26 00:33:19,380] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Finished creating instance of bean 'org.springframework.context.annotation.internalAutowiredAnnotationProcessor'
[2016-06-26 00:33:19,383] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Creating shared instance of singleton bean 'org.springframework.context.annotation.internalRequiredAnnotationProcessor'
[2016-06-26 00:33:19,384] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Creating instance of bean 'org.springframework.context.annotation.internalRequiredAnnotationProcessor'
[2016-06-26 00:33:19,386] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Eagerly caching bean 'org.springframework.context.annotation.internalRequiredAnnotationProcessor' to allow for resolving potential circular references
[2016-06-26 00:33:19,387] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Finished creating instance of bean 'org.springframework.context.annotation.internalRequiredAnnotationProcessor'
[2016-06-26 00:33:19,388] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Creating shared instance of singleton bean 'org.springframework.context.annotation.internalCommonAnnotationProcessor'
[2016-06-26 00:33:19,389] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Creating instance of bean 'org.springframework.context.annotation.internalCommonAnnotationProcessor'
[2016-06-26 00:33:19,396] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Eagerly caching bean 'org.springframework.context.annotation.internalCommonAnnotationProcessor' to allow for resolving potential circular references
[2016-06-26 00:33:19,397] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Finished creating instance of bean 'org.springframework.context.annotation.internalCommonAnnotationProcessor'
[2016-06-26 00:33:19,398] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Creating shared instance of singleton bean 'org.springframework.context.annotation.ConfigurationClassPostProcessor.importAwareProcessor'
[2016-06-26 00:33:19,399] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Creating instance of bean 'org.springframework.context.annotation.ConfigurationClassPostProcessor.importAwareProcessor'
[2016-06-26 00:33:19,399] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Eagerly caching bean 'org.springframework.context.annotation.ConfigurationClassPostProcessor.importAwareProcessor' to allow for resolving potential circular references
[2016-06-26 00:33:19,400] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Finished creating instance of bean 'org.springframework.context.annotation.ConfigurationClassPostProcessor.importAwareProcessor'
[2016-06-26 00:33:19,403] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Creating shared instance of singleton bean 'org.springframework.aop.config.internalAutoProxyCreator'
[2016-06-26 00:33:19,404] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Creating instance of bean 'org.springframework.aop.config.internalAutoProxyCreator'
[2016-06-26 00:33:19,424] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Eagerly caching bean 'org.springframework.aop.config.internalAutoProxyCreator' to allow for resolving potential circular references
[2016-06-26 00:33:19,472] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Finished creating instance of bean 'org.springframework.aop.config.internalAutoProxyCreator'
[2016-06-26 00:33:19,477] [main][org.springframework.context.support.GenericApplicationContext] DEBUG - Unable to locate MessageSource with name 'messageSource': using default [org.springframework.context.support.DelegatingMessageSource@11302d6]
[2016-06-26 00:33:19,483] [main][org.springframework.context.support.GenericApplicationContext] DEBUG - Unable to locate ApplicationEventMulticaster with name 'applicationEventMulticaster': using default [org.springframework.context.event.SimpleApplicationEventMulticaster@1918c79]
[2016-06-26 00:33:19,487] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] INFO - Pre-instantiating singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@4a7dd4: defining beans [ehCacheTestServiceImpl,org.springframework.context.annotation.internalConfigurationAnnotationProcessor,org.springframework.context.annotation.internalAutowiredAnnotationProcessor,org.springframework.context.annotation.internalRequiredAnnotationProcessor,org.springframework.context.annotation.internalCommonAnnotationProcessor,org.springframework.aop.config.internalAutoProxyCreator,org.springframework.cache.annotation.AnnotationCacheOperationSource#0,org.springframework.cache.interceptor.CacheInterceptor#0,org.springframework.cache.config.internalCacheAdvisor,cacheManager,ehcache,org.springframework.context.annotation.ConfigurationClassPostProcessor.importAwareProcessor]; root of factory hierarchy
[2016-06-26 00:33:19,492] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Creating shared instance of singleton bean 'ehCacheTestServiceImpl'
[2016-06-26 00:33:19,494] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Creating instance of bean 'ehCacheTestServiceImpl'
[2016-06-26 00:33:19,498] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Eagerly caching bean 'ehCacheTestServiceImpl' to allow for resolving potential circular references
[2016-06-26 00:33:19,501] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Creating shared instance of singleton bean 'org.springframework.cache.config.internalCacheAdvisor'
[2016-06-26 00:33:19,502] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Creating instance of bean 'org.springframework.cache.config.internalCacheAdvisor'
[2016-06-26 00:33:19,812] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Eagerly caching bean 'org.springframework.cache.config.internalCacheAdvisor' to allow for resolving potential circular references
[2016-06-26 00:33:19,837] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Creating shared instance of singleton bean 'org.springframework.cache.annotation.AnnotationCacheOperationSource#0'
[2016-06-26 00:33:19,838] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Creating instance of bean 'org.springframework.cache.annotation.AnnotationCacheOperationSource#0'
[2016-06-26 00:33:19,842] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Eagerly caching bean 'org.springframework.cache.annotation.AnnotationCacheOperationSource#0' to allow for resolving potential circular references
[2016-06-26 00:33:19,851] [main][org.springframework.aop.framework.autoproxy.BeanFactoryAdvisorRetrievalHelper] DEBUG - Skipping currently created advisor 'org.springframework.cache.config.internalCacheAdvisor'
[2016-06-26 00:33:19,856] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Finished creating instance of bean 'org.springframework.cache.annotation.AnnotationCacheOperationSource#0'
[2016-06-26 00:33:19,857] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Finished creating instance of bean 'org.springframework.cache.config.internalCacheAdvisor'
[2016-06-26 00:33:19,862] [main][org.springframework.cache.annotation.AnnotationCacheOperationSource] DEBUG - Adding cacheable method 'getTimestamp' with attribute: [CacheableOperation[public java.lang.String com.service.impl.EhCacheTestServiceImpl.getTimestamp(java.lang.String)] caches=[cacheTest] | key='#param' | condition='' | unless='']
[2016-06-26 00:33:19,872] [main][org.springframework.aop.framework.autoproxy.InfrastructureAdvisorAutoProxyCreator] DEBUG - Creating implicit proxy for bean 'ehCacheTestServiceImpl' with 0 common interceptors and 1 specific interceptors
[2016-06-26 00:33:19,874] [main][org.springframework.aop.framework.JdkDynamicAopProxy] DEBUG - Creating JDK dynamic proxy: target source is SingletonTargetSource for target object [com.service.impl.EhCacheTestServiceImpl@909414]
[2016-06-26 00:33:19,881] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Finished creating instance of bean 'ehCacheTestServiceImpl'
[2016-06-26 00:33:19,881] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Returning cached instance of singleton bean 'org.springframework.context.annotation.internalConfigurationAnnotationProcessor'
[2016-06-26 00:33:19,883] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Returning cached instance of singleton bean 'org.springframework.context.annotation.internalAutowiredAnnotationProcessor'
[2016-06-26 00:33:19,884] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Returning cached instance of singleton bean 'org.springframework.context.annotation.internalRequiredAnnotationProcessor'
[2016-06-26 00:33:19,885] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Returning cached instance of singleton bean 'org.springframework.context.annotation.internalCommonAnnotationProcessor'
[2016-06-26 00:33:19,887] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Returning cached instance of singleton bean 'org.springframework.aop.config.internalAutoProxyCreator'
[2016-06-26 00:33:19,887] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Returning cached instance of singleton bean 'org.springframework.cache.annotation.AnnotationCacheOperationSource#0'
[2016-06-26 00:33:19,889] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Creating shared instance of singleton bean 'org.springframework.cache.interceptor.CacheInterceptor#0'
[2016-06-26 00:33:19,889] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Creating instance of bean 'org.springframework.cache.interceptor.CacheInterceptor#0'
[2016-06-26 00:33:19,894] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Eagerly caching bean 'org.springframework.cache.interceptor.CacheInterceptor#0' to allow for resolving potential circular references
[2016-06-26 00:33:19,899] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Creating shared instance of singleton bean 'cacheManager'
[2016-06-26 00:33:19,899] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Creating instance of bean 'cacheManager'
[2016-06-26 00:33:19,906] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Eagerly caching bean 'cacheManager' to allow for resolving potential circular references
[2016-06-26 00:33:19,913] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Creating shared instance of singleton bean 'ehcache'
[2016-06-26 00:33:19,914] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Creating instance of bean 'ehcache'
[2016-06-26 00:33:19,943] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Eagerly caching bean 'ehcache' to allow for resolving potential circular references
[2016-06-26 00:33:19,947] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Invoking afterPropertiesSet() on bean with name 'ehcache'
[2016-06-26 00:33:19,947] [main][org.springframework.cache.ehcache.EhCacheManagerFactoryBean] INFO - Initializing EhCache CacheManager
[2016-06-26 00:33:19,975] [main][net.sf.ehcache.config.ConfigurationFactory] DEBUG - Configuring ehcache from InputStream
[2016-06-26 00:33:20,106] [main][net.sf.ehcache.config.DiskStoreConfiguration] DEBUG - Disk Store Path: C:UsersADMINI~1AppDataLocalTemp
[2016-06-26 00:33:20,195] [main][net.sf.ehcache.util.PropertyUtil] DEBUG - propertiesString is null.
[2016-06-26 00:33:20,214] [main][net.sf.ehcache.config.ConfigurationHelper] DEBUG - No CacheManagerEventListenerFactory class specified. Skipping...
[2016-06-26 00:33:21,030] [main][net.sf.ehcache.Cache] DEBUG - No BootstrapCacheLoaderFactory class specified. Skipping...
[2016-06-26 00:33:21,031] [main][net.sf.ehcache.Cache] DEBUG - CacheWriter factory not configured. Skipping...
[2016-06-26 00:33:21,031] [main][net.sf.ehcache.config.ConfigurationHelper] DEBUG - No CacheExceptionHandlerFactory class specified. Skipping...
[2016-06-26 00:33:21,048] [main][net.sf.ehcache.Cache] DEBUG - No BootstrapCacheLoaderFactory class specified. Skipping...
[2016-06-26 00:33:21,049] [main][net.sf.ehcache.Cache] DEBUG - CacheWriter factory not configured. Skipping...
[2016-06-26 00:33:21,050] [main][net.sf.ehcache.config.ConfigurationHelper] DEBUG - No CacheExceptionHandlerFactory class specified. Skipping...
[2016-06-26 00:33:21,124] [main][net.sf.ehcache.DiskStorePathManager] DEBUG - Using diskstore path C:UsersADMINI~1AppDataLocalTemp
[2016-06-26 00:33:21,124] [main][net.sf.ehcache.DiskStorePathManager] DEBUG - Holding exclusive lock on C:UsersADMINI~1AppDataLocalTemp.ehcache-diskstore.lock
[2016-06-26 00:33:21,126] [main][net.sf.ehcache.store.disk.DiskStorageFactory] DEBUG - Failed to delete file cache%0054est.data
[2016-06-26 00:33:21,127] [main][net.sf.ehcache.store.disk.DiskStorageFactory] DEBUG - Failed to delete file cache%0054est.index
[2016-06-26 00:33:21,144] [main][net.sf.ehcache.store.disk.DiskStorageFactory] DEBUG - Matching data file missing (or empty) for index file. Deleting index file C:UsersADMINI~1AppDataLocalTempcache%0054est.index
[2016-06-26 00:33:21,146] [main][net.sf.ehcache.store.disk.DiskStorageFactory] DEBUG - Failed to delete file cache%0054est.index
[2016-06-26 00:33:21,235] [main][net.sf.ehcache.statistics.extended.ExtendedStatisticsImpl] DEBUG - Mocking Pass-Through Statistic: LOCAL_OFFHEAP_SIZE
[2016-06-26 00:33:21,237] [main][net.sf.ehcache.statistics.extended.ExtendedStatisticsImpl] DEBUG - Mocking Pass-Through Statistic: LOCAL_OFFHEAP_SIZE_BYTES
[2016-06-26 00:33:21,239] [main][net.sf.ehcache.statistics.extended.ExtendedStatisticsImpl] DEBUG - Mocking Pass-Through Statistic: WRITER_QUEUE_LENGTH
[2016-06-26 00:33:21,241] [main][net.sf.ehcache.statistics.extended.ExtendedStatisticsImpl] DEBUG - Mocking Pass-Through Statistic: REMOTE_SIZE
[2016-06-26 00:33:21,242] [main][net.sf.ehcache.statistics.extended.ExtendedStatisticsImpl] DEBUG - Mocking Pass-Through Statistic: LAST_REJOIN_TIMESTAMP
[2016-06-26 00:33:21,266] [main][net.sf.ehcache.statistics.extended.ExtendedStatisticsImpl] DEBUG - Mocking Operation Statistic: OFFHEAP_GET
[2016-06-26 00:33:21,268] [main][net.sf.ehcache.statistics.extended.ExtendedStatisticsImpl] DEBUG - Mocking Operation Statistic: OFFHEAP_PUT
[2016-06-26 00:33:21,269] [main][net.sf.ehcache.statistics.extended.ExtendedStatisticsImpl] DEBUG - Mocking Operation Statistic: OFFHEAP_REMOVE
[2016-06-26 00:33:21,272] [main][net.sf.ehcache.statistics.extended.ExtendedStatisticsImpl] DEBUG - Mocking Operation Statistic: XA_COMMIT
[2016-06-26 00:33:21,274] [main][net.sf.ehcache.statistics.extended.ExtendedStatisticsImpl] DEBUG - Mocking Operation Statistic: XA_ROLLBACK
[2016-06-26 00:33:21,275] [main][net.sf.ehcache.statistics.extended.ExtendedStatisticsImpl] DEBUG - Mocking Operation Statistic: XA_RECOVERY
[2016-06-26 00:33:21,277] [main][net.sf.ehcache.statistics.extended.ExtendedStatisticsImpl] DEBUG - Mocking Operation Statistic: CLUSTER_EVENT
[2016-06-26 00:33:21,278] [main][net.sf.ehcache.statistics.extended.ExtendedStatisticsImpl] DEBUG - Mocking Operation Statistic: NONSTOP
[2016-06-26 00:33:21,286] [main][net.sf.ehcache.Cache] DEBUG - Initialised cache: cacheTest
[2016-06-26 00:33:21,287] [main][net.sf.ehcache.config.ConfigurationHelper] DEBUG - CacheDecoratorFactory not configured. Skipping for 'cacheTest'.
[2016-06-26 00:33:21,287] [main][net.sf.ehcache.config.ConfigurationHelper] DEBUG - CacheDecoratorFactory not configured for defaultCache. Skipping for 'cacheTest'.
[2016-06-26 00:33:21,296] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Returning cached instance of singleton bean 'org.springframework.cache.config.internalCacheAdvisor'
[2016-06-26 00:33:21,298] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Finished creating instance of bean 'ehcache'
[2016-06-26 00:33:21,299] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Returning cached instance of singleton bean 'org.springframework.cache.config.internalCacheAdvisor'
[2016-06-26 00:33:21,302] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Invoking afterPropertiesSet() on bean with name 'cacheManager'
[2016-06-26 00:33:21,304] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Returning cached instance of singleton bean 'org.springframework.cache.config.internalCacheAdvisor'
[2016-06-26 00:33:21,306] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Finished creating instance of bean 'cacheManager'
[2016-06-26 00:33:21,306] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Returning cached instance of singleton bean 'org.springframework.cache.annotation.AnnotationCacheOperationSource#0'
[2016-06-26 00:33:21,341] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Invoking afterPropertiesSet() on bean with name 'org.springframework.cache.interceptor.CacheInterceptor#0'
[2016-06-26 00:33:21,342] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Finished creating instance of bean 'org.springframework.cache.interceptor.CacheInterceptor#0'
[2016-06-26 00:33:21,343] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Returning cached instance of singleton bean 'org.springframework.cache.config.internalCacheAdvisor'
[2016-06-26 00:33:21,343] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Returning cached instance of singleton bean 'cacheManager'
[2016-06-26 00:33:21,345] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Returning cached instance of singleton bean 'ehcache'
[2016-06-26 00:33:21,346] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Returning cached instance of singleton bean 'org.springframework.context.annotation.ConfigurationClassPostProcessor.importAwareProcessor'
[2016-06-26 00:33:21,349] [main][org.springframework.context.support.GenericApplicationContext] DEBUG - Unable to locate LifecycleProcessor with name 'lifecycleProcessor': using default [org.springframework.context.support.DefaultLifecycleProcessor@103b9fe]
[2016-06-26 00:33:21,350] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Returning cached instance of singleton bean 'lifecycleProcessor'
[2016-06-26 00:33:21,354] [main][org.springframework.core.env.PropertySourcesPropertyResolver] DEBUG - Searching for key 'spring.liveBeansView.mbeanDomain' in [systemProperties]
[2016-06-26 00:33:21,355] [main][org.springframework.core.env.PropertySourcesPropertyResolver] DEBUG - Searching for key 'spring.liveBeansView.mbeanDomain' in [systemEnvironment]
[2016-06-26 00:33:21,356] [main][org.springframework.core.env.PropertySourcesPropertyResolver] DEBUG - Could not find key 'spring.liveBeansView.mbeanDomain' in any property source. Returning [null]
[2016-06-26 00:33:21,358] [main][org.springframework.test.context.CacheAwareContextLoaderDelegate] DEBUG - Storing ApplicationContext in cache under key [[MergedContextConfiguration@1f256fa testClass = EhCacheTestServiceImplTest, locations = '{classpath:application.xml}', classes = '{}', contextInitializerClasses = '[]', activeProfiles = '{}', contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]].
[2016-06-26 00:33:21,364] [main][org.springframework.beans.factory.annotation.InjectionMetadata] DEBUG - Processing injected method of bean 'com.service.impl.EhCacheTestServiceImplTest': ResourceElement for private com.service.EhCacheTestService com.service.impl.EhCacheTestServiceImplTest.ehCacheTestService
[2016-06-26 00:33:21,367] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Returning cached instance of singleton bean 'ehCacheTestServiceImpl'
[2016-06-26 00:33:21,368] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Returning cached instance of singleton bean 'org.springframework.cache.config.internalCacheAdvisor'
[2016-06-26 00:33:21,385] [main][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Returning cached instance of singleton bean 'org.springframework.cache.interceptor.CacheInterceptor#0'
[2016-06-26 00:33:21,443] [main][net.sf.ehcache.store.disk.Segment] DEBUG - put added 0 on heap
[2016-06-26 00:33:21,444] [main][com.service.impl.EhCacheTestServiceImplTest] INFO - First Invoke:1466872401441
[2016-06-26 00:33:21,500] [cache%0054est.data][net.sf.ehcache.store.disk.Segment] DEBUG - fault removed 0 from heap
[2016-06-26 00:33:21,500] [cache%0054est.data][net.sf.ehcache.store.disk.Segment] DEBUG - fault added 0 on disk
[2016-06-26 00:33:23,446] [main][com.service.impl.EhCacheTestServiceImplTest] INFO - Invoke After 2 second:1466872401441
[2016-06-26 00:33:34,483] [main][net.sf.ehcache.store.disk.Segment] DEBUG - remove deleted 0 from heap
[2016-06-26 00:33:34,484] [main][net.sf.ehcache.store.disk.Segment] DEBUG - remove deleted 0 from disk
[2016-06-26 00:33:34,485] [main][net.sf.ehcache.store.disk.Segment] DEBUG - put added 0 on heap
[2016-06-26 00:33:34,485] [main][com.service.impl.EhCacheTestServiceImplTest] INFO - Invoke After 11 second:1466872414485
[2016-06-26 00:33:34,486] [cache%0054est.data][net.sf.ehcache.store.disk.Segment] DEBUG - fault removed 0 from heap
[2016-06-26 00:33:34,487] [cache%0054est.data][net.sf.ehcache.store.disk.Segment] DEBUG - fault added 0 on disk
[2016-06-26 00:33:34,487] [main][org.springframework.test.context.support.DirtiesContextTestExecutionListener] DEBUG - After test method: context [[TestContext@108b2d7 testClass = EhCacheTestServiceImplTest, testInstance = com.service.impl.EhCacheTestServiceImplTest@154909b, testMethod = testGetTimestamp@EhCacheTestServiceImplTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@1f256fa testClass = EhCacheTestServiceImplTest, locations = '{classpath:application.xml}', classes = '{}', contextInitializerClasses = '[]', activeProfiles = '{}', contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]], class dirties context [false], class mode [null], method dirties context [false].
[2016-06-26 00:33:34,493] [main][org.springframework.test.context.support.DirtiesContextTestExecutionListener] DEBUG - After test class: context [[TestContext@108b2d7 testClass = EhCacheTestServiceImplTest, testInstance = [null], testMethod = [null], testException = [null], mergedContextConfiguration = [MergedContextConfiguration@1f256fa testClass = EhCacheTestServiceImplTest, locations = '{classpath:application.xml}', classes = '{}', contextInitializerClasses = '[]', activeProfiles = '{}', contextLoader = 'org.springframework.test.context.support.DelegatingSmartContextLoader', parent = [null]]]], dirtiesContext [false].
[2016-06-26 00:33:34,498] [Thread-2][org.springframework.context.support.GenericApplicationContext] INFO - Closing org.springframework.context.support.GenericApplicationContext@13fcdbd: startup date [Sun Jun 26 00:33:19 CST 2016]; root of context hierarchy
[2016-06-26 00:33:34,499] [Thread-2][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Returning cached instance of singleton bean 'lifecycleProcessor'
[2016-06-26 00:33:34,500] [Thread-2][org.springframework.beans.factory.support.DefaultListableBeanFactory] INFO - Destroying singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@4a7dd4: defining beans [ehCacheTestServiceImpl,org.springframework.context.annotation.internalConfigurationAnnotationProcessor,org.springframework.context.annotation.internalAutowiredAnnotationProcessor,org.springframework.context.annotation.internalRequiredAnnotationProcessor,org.springframework.context.annotation.internalCommonAnnotationProcessor,org.springframework.aop.config.internalAutoProxyCreator,org.springframework.cache.annotation.AnnotationCacheOperationSource#0,org.springframework.cache.interceptor.CacheInterceptor#0,org.springframework.cache.config.internalCacheAdvisor,cacheManager,ehcache,org.springframework.context.annotation.ConfigurationClassPostProcessor.importAwareProcessor]; root of factory hierarchy
[2016-06-26 00:33:34,500] [Thread-2][org.springframework.beans.factory.support.DisposableBeanAdapter] DEBUG - Invoking destroy() on bean with name 'ehcache'
[2016-06-26 00:33:34,500] [Thread-2][org.springframework.cache.ehcache.EhCacheManagerFactoryBean] INFO - Shutting down EhCache CacheManager
[2016-06-26 00:33:34,541] [Thread-2][org.springframework.beans.factory.support.DefaultListableBeanFactory] DEBUG - Retrieved dependent beans for bean 'ehCacheTestServiceImpl': [com.service.impl.EhCacheTestServiceImplTest]

https://github.com/helloworldtang/ehcache_project

http://blog.csdn.net/u013142781/article/details/50507607