Hibernate Transaction filter as below
I refine the log as below, the red text is the log entries about transaction begin and commit in the HibernateTransactionFilter
[11/01/17 14:46:56][org.apache.jasper.servlet.JspServlet#service] JspEngine --> /popupPage/CopyGrpTree.jsp
[11/01/17 14:46:56][org.apache.jasper.servlet.JspServlet#service] ServletPath: /popupPage/CopyGrpTree.jsp
[11/01/17 14:46:56][org.apache.jasper.servlet.JspServlet#service] PathInfo: null
[11/01/17 14:46:56][org.apache.jasper.servlet.JspServlet#service] RealPath: D:\workspace\.metadata\.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\iportal\popupPage\CopyGrpTree.jsp
[11/01/17 14:46:56][org.apache.jasper.servlet.JspServlet#service] RequestURI: /iportal/popupPage/CopyGrpTree.jsp
[11/01/17 14:46:56][org.apache.jasper.servlet.JspServlet#service] QueryString: null
[11/01/17 14:46:56][org.apache.jasper.servlet.JspServlet#service] Request Params:
[11/01/17 14:46:56][com.taiwanmobile.iportal.filter.HibernateSessionRequestFilter#doFilter] Filter Transaction begin...
[11/01/17 14:46:56][com.taiwanmobile.iportal.filter.HibernateSessionRequestFilter#doFilter] Transaction Begin
[11/01/17 14:46:56][com.taiwanmobile.iportal.filter.HibernateSessionRequestFilter#doFilter] Filter Transaction begin...
[11/01/17 14:46:56][com.taiwanmobile.iportal.filter.HibernateSessionRequestFilter#doFilter] Transaction Begin
[11/01/17 14:46:56][com.taiwanmobile.iportal.filter.HibernateSessionRequestFilter#doFilter] Transaction Begin ok
[11/01/17 14:46:56][org.springframework.web.servlet.DispatcherServlet#getHandler]
Testing handler map [org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping@30f369] in DispatcherServlet with name 'dispatcherServlet'
[11/01/17 14:46:56][org.springframework.web.servlet.handler.AbstractUrlHandlerMapping#getHandlerInternal] Looking up handler for [/mngGrp.do]
[11/01/17 14:46:56][org.springframework.web.servlet.DispatcherServlet#getHandlerAdapter] Testing handler adapter [org.springframework.web.servlet.mvc.HttpRequestHandlerAdapter@13cba41]
[11/01/17 14:46:56][org.springframework.web.servlet.DispatcherServlet#getHandlerAdapter] Testing handler adapter [org.springframework.web.servlet.mvc.SimpleControllerHandlerAdapter@1127c4d]
[11/01/17 14:46:56][org.springframework.web.servlet.DispatcherServlet#getLastModified] Last-Modified value for [/iportal/mngGrp.do] is: -1
[11/01/17 14:46:56][org.springframework.web.servlet.DispatcherServlet#doService] DispatcherServlet with name 'dispatcherServlet' received request for [/iportal/mngGrp.do]
[11/01/17 14:46:56][org.springframework.web.servlet.DispatcherServlet#doDispatch] Bound request context to
thread: org.apache.catalina.connector.RequestFacade@10a69f0
[11/01/17 14:46:56][org.springframework.web.servlet.DispatcherServlet#getHandlerAdapter] Testing handler adapter [org.springframework.web.servlet.mvc.HttpRequestHandlerAdapter@13cba41]
[11/01/17 14:46:56][org.springframework.web.servlet.DispatcherServlet#getHandlerAdapter] Testing handler adapter [org.springframework.web.servlet.mvc.SimpleControllerHandlerAdapter@1127c4d]
[11/01/17 14:46:56][org.springframework.beans.factory.support.AbstractBeanFactory#doGetBean] Returning cached instance of singleton bean 'CompanyInfoMap'
[11/01/17 14:46:56][org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory#invokeInitMethods] Invoking afterPropertiesSet() on bean with name 'popupPage/CopyGrpTreeLeft'
[11/01/17 14:46:56][org.springframework.web.servlet.view.AbstractCachingViewResolver#resolveViewName] Cached view [popupPage/CopyGrpTreeLeft]
[11/01/17 14:46:56][org.springframework.web.servlet.DispatcherServlet#render] Rendering view [org.springframework.web.servlet.view.JstlView: name 'popupPage/CopyGrpTreeLeft'; URL [popupPage/CopyGrpTreeLeft.jsp]] in DispatcherServlet with name 'dispatcherServlet'
[11/01/17 14:46:56][org.springframework.web.servlet.view.AbstractView#render] Rendering view with name 'popupPage/CopyGrpTreeLeft' with model {list=[com.taiwanmobile.iportal.dao.iportaldb.GrpInfo@f4ec4093, com.taiwanmobile.iportal.dao.iportaldb.GrpInfo@fe38dfc1, com.taiwanmobile.iportal.dao.iportaldb.GrpInfo@bc3e4a3, com.taiwanmobile.iportal.dao.iportaldb.GrpInfo@ef47aef9, com.taiwanmobile.iportal.dao.iportaldb.GrpInfo@a93f89c3, com.taiwanmobile.iportal.dao.iportaldb.GrpInfo@5e374a5f, com.taiwanmobile.iportal.dao.iportaldb.GrpInfo@ee90b31c, com.taiwanmobile.iportal.dao.iportaldb.GrpInfo@6c6d05a1, com.taiwanmobile.iportal.dao.iportaldb.GrpInfo@c8b41dc, com.taiwanmobile.iportal.dao.iportaldb.GrpInfo@b2cf2f6c, com.taiwanmobile.iportal.dao.iportaldb.GrpInfo@61e4e04c, com.taiwanmobile.iportal.dao.iportaldb.GrpInfo@d65f85ac, com.taiwanmobile.iportal.dao.iportaldb.GrpInfo@cea2db43, com.taiwanmobile.iportal.dao.iportaldb.GrpInfo@4e271d6e, com.taiwanmobile.iportal.dao.iportaldb.GrpInfo@c83e883, com.taiwanmobile.iportal.dao.iportaldb.GrpInfo@d914c24f, com.taiwanmobile.iportal.dao.iportaldb.GrpInfo@c3a1be35, com.taiwanmobile.iportal.dao.iportaldb.GrpInfo@99ed6515, com.taiwanmobile.iportal.dao.iportaldb.GrpInfo@f025c10b, com.taiwanmobile.iportal.dao.iportaldb.GrpInfo@98f9cf09], act=redirect_grp_query, pagingInfo=com.taiwanmobile.iportal.util.Paging@1d1358f, companyMap={1=abc, 2=def, 3=ijk , 4=mno}, queryName=} and static attributes {}
[11/01/17 14:46:56][org.springframework.web.servlet.view.AbstractView#exposeModelAsRequestAttributes] Added model object 'list' of type [java.util.ArrayList] to request in view with name 'popupPage/CopyGrpTreeLeft'
[11/01/17 14:46:56][org.springframework.web.servlet.view.AbstractView#exposeModelAsRequestAttributes] Added model object 'act' of type [java.lang.String] to request in view with name 'popupPage/CopyGrpTreeLeft'
[11/01/17 14:46:56][org.springframework.web.servlet.view.AbstractView#exposeModelAsRequestAttributes] Added model object 'companyMap' of type [java.util.HashMap] to request in view with name 'popupPage/CopyGrpTreeLeft'
[11/01/17 14:46:56][org.springframework.web.servlet.view.AbstractView#exposeModelAsRequestAttributes] Added model object 'pagingInfo' of type [com.taiwanmobile.iportal.util.Paging] to request in view with name 'popupPage/CopyGrpTreeLeft'
[11/01/17 14:46:56][org.springframework.web.servlet.view.AbstractView#exposeModelAsRequestAttributes] Added model object 'queryName' of type [java.lang.String] to request in view with name 'popupPage/CopyGrpTreeLeft'
[11/01/17 14:46:56][org.apache.catalina.core.ApplicationDispatcher#<init>] servletPath=/popupPage/CopyGrpTreeLeft.jsp, pathInfo=null, queryString=null, name=null
[11/01/17 14:46:56][org.springframework.web.servlet.view.InternalResourceView#renderMergedOutputModel] Forwarding to resource [popupPage/CopyGrpTreeLeft.jsp] in InternalResourceView 'popupPage/CopyGrpTreeLeft'
[11/01/17 14:46:56][org.apache.catalina.core.ApplicationDispatcher#doForward] Path Based Forward
[11/01/17 14:46:56][org.apache.jasper.servlet.JspServlet#service] JspEngine --> /popupPage/CopyGrpTreeLeft.jsp
[11/01/17 14:46:56][org.apache.jasper.servlet.JspServlet#service] ServletPath: /popupPage/CopyGrpTreeLeft.jsp
[11/01/17 14:46:56][org.apache.jasper.servlet.JspServlet#service] PathInfo: null
[11/01/17 14:46:56][org.apache.jasper.servlet.JspServlet#service] RealPath: D:\workspace\.metadata\.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\iportal\popupPage\CopyGrpTreeLeft.jsp
[11/01/17 14:46:56][org.apache.jasper.servlet.JspServlet#service] RequestURI: /iportal/popupPage/CopyGrpTreeLeft.jsp
[11/01/17 14:46:56][org.apache.jasper.servlet.JspServlet#service] QueryString: act=popup_grp_query
[11/01/17 14:46:56][org.apache.jasper.servlet.JspServlet#service] Request Params:
[11/01/17 14:46:56][org.apache.jasper.servlet.JspServlet#service] act = popup_grp_query
[11/01/17 14:46:56][org.apache.catalina.core.ApplicationDispatcher#<init>] servletPath=/template/CopyGrpTreePaging.jsp, pathInfo=null, queryString=null, name=null
[11/01/17 14:46:56][org.apache.catalina.core.ApplicationDispatcher#doInclude] Path Based Include
[11/01/17 14:46:56][org.apache.jasper.servlet.JspServlet#service] JspEngine --> /template/CopyGrpTreePaging.jsp
[11/01/17 14:46:56][org.apache.jasper.servlet.JspServlet#service] ServletPath: /popupPage/CopyGrpTreeLeft.jsp
[11/01/17 14:46:56][org.apache.jasper.servlet.JspServlet#service] PathInfo: null
[11/01/17 14:46:56][org.apache.jasper.servlet.JspServlet#service] RealPath: D:\workspace\.metadata\.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\iportal\template\CopyGrpTreePaging.jsp
[11/01/17 14:46:56][org.apache.jasper.servlet.JspServlet#service] RequestURI: /iportal/popupPage/CopyGrpTreeLeft.jsp
[11/01/17 14:46:56][org.apache.jasper.servlet.JspServlet#service] QueryString: act=popup_grp_query
[11/01/17 14:46:56][org.apache.jasper.servlet.JspServlet#service] Request Params:
[11/01/17 14:46:56][org.apache.jasper.servlet.JspServlet#service] act = popup_grp_query
[11/01/17 14:46:56][org.apache.catalina.core.ApplicationDispatcher#doForward] Disabling the response for futher output
[11/01/17 14:46:56][org.springframework.web.servlet.DispatcherServlet#doDispatch] Cleared thread-bound request context: org.apache.catalina.connector.RequestFacade@10a69f0
[11/01/17 14:46:56][org.springframework.web.servlet.FrameworkServlet#processRequest] Successfully completed request
[11/01/17 14:46:56][org.springframework.context.support.AbstractApplicationContext#publishEvent] Publishing event in context [org.springframework.web.context.support.XmlWebApplicationContext@1bb205a]: ServletRequestHandledEvent: url=[/iportal/mngGrp.do]; client=[127.0.0.1]; method=[GET]; servlet=[dispatcherServlet]; session=[D9440CE41C66AFA2B84DA89D928A9937]; user=[null]; time=[63ms]; status=[OK]
[11/01/17 14:46:56][com.taiwanmobile.iportal.filter.HibernateSessionRequestFilter#doFilter] Transaction commit
[11/01/17 14:47:03][com.taiwanmobile.iportal.filter.HibernateSessionRequestFilter#doFilter] Transaction Begin ok
[11/01/17 14:47:03][org.springframework.web.servlet.DispatcherServlet#getHandler] Testing handler map [org.springframework.web.servlet.handler.BeanNameUrlHandlerMapping@30f369] in DispatcherServlet with name 'dispatcherServlet'
[11/01/17 14:47:03][org.springframework.web.servlet.handler.AbstractUrlHandlerMapping#getHandlerInternal] Looking up handler for [/mngNode.do]
[11/01/17 14:47:03][org.springframework.web.servlet.DispatcherServlet#getHandlerAdapter] Testing handler adapter [org.springframework.web.servlet.mvc.HttpRequestHandlerAdapter@13cba41]
[11/01/17 14:47:03][org.springframework.web.servlet.DispatcherServlet#getHandlerAdapter] Testing handler adapter [org.springframework.web.servlet.mvc.SimpleControllerHandlerAdapter@1127c4d]
[11/01/17 14:47:03][org.springframework.web.servlet.DispatcherServlet#getLastModified] Last-Modified value for [/iportal/mngNode.do] is: -1
[11/01/17 14:47:03][org.springframework.web.servlet.DispatcherServlet#doService] DispatcherServlet with name 'dispatcherServlet' received request for [/iportal/mngNode.do]
[11/01/17 14:47:03][org.springframework.web.servlet.DispatcherServlet#doDispatch] Bound request context to thread: org.apache.catalina.connector.RequestFacade@d8431c
[11/01/17 14:47:03][org.springframework.web.servlet.DispatcherServlet#getHandlerAdapter] Testing handler adapter [org.springframework.web.servlet.mvc.HttpRequestHandlerAdapter@13cba41]
[11/01/17 14:47:03][org.springframework.web.servlet.DispatcherServlet#getHandlerAdapter] Testing handler adapter [org.springframework.web.servlet.mvc.SimpleControllerHandlerAdapter@1127c4d]
[11/01/17 14:47:03][com.taiwanmobile.iportal.facade.NodeFacade#showGrpTree] act=redirect_node_queryGrpTree01
[11/01/17 14:47:03][org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory#invokeInitMethods] Invoking afterPropertiesSet() on bean with name 'popupPage/CopyGrpTreeRight'
[11/01/17 14:47:03][org.springframework.web.servlet.view.AbstractCachingViewResolver#resolveViewName] Cached view [popupPage/CopyGrpTreeRight]
[11/01/17 14:47:03][org.springframework.web.servlet.DispatcherServlet#render] Rendering view [org.springframework.web.servlet.view.JstlView: name 'popupPage/CopyGrpTreeRight'; URL [popupPage/CopyGrpTreeRight.jsp]] in DispatcherServlet with name 'dispatcherServlet'
[11/01/17 14:47:03][org.springframework.web.servlet.view.AbstractView#render] Rendering view with name 'popupPage/CopyGrpTreeRight' with model {isNodeSaved=false, IportalTreeNodes=[]} and static attributes {}
[11/01/17 14:47:03][org.springframework.web.servlet.view.AbstractView#exposeModelAsRequestAttributes] Added model object 'isNodeSaved' of type [java.lang.Boolean] to request in view with name 'popupPage/CopyGrpTreeRight'
[11/01/17 14:47:03][org.springframework.web.servlet.view.AbstractView#exposeModelAsRequestAttributes] Added model object 'IportalTreeNodes' of type [java.util.ArrayList] to request in view with name 'popupPage/CopyGrpTreeRight'
[11/01/17 14:47:03][org.apache.catalina.core.ApplicationDispatcher#<init>] servletPath=/popupPage/CopyGrpTreeRight.jsp, pathInfo=null, queryString=null, name=null
[11/01/17 14:47:03][org.springframework.web.servlet.view.InternalResourceView#renderMergedOutputModel] Forwarding to resource [popupPage/CopyGrpTreeRight.jsp] in InternalResourceView 'popupPage/CopyGrpTreeRight'
[11/01/17 14:47:03][org.apache.catalina.core.ApplicationDispatcher#doForward] Path Based Forward
[11/01/17 14:47:03][org.apache.jasper.servlet.JspServlet#service] JspEngine --> /popupPage/CopyGrpTreeRight.jsp
[11/01/17 14:47:03][org.apache.jasper.servlet.JspServlet#service] ServletPath: /popupPage/CopyGrpTreeRight.jsp
[11/01/17 14:47:03][org.apache.jasper.servlet.JspServlet#service] PathInfo: null
[11/01/17 14:47:03][org.apache.jasper.servlet.JspServlet#service] RealPath: D:\workspace\.metadata\.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\iportal\popupPage\CopyGrpTreeRight.jsp
[11/01/17 14:47:03][org.apache.jasper.servlet.JspServlet#service] RequestURI: /iportal/popupPage/CopyGrpTreeRight.jsp
[11/01/17 14:47:03][org.apache.jasper.servlet.JspServlet#service] QueryString: act=redirect_node_queryGrpTree01&default=yes
[11/01/17 14:47:03][org.apache.jasper.servlet.JspServlet#service] Request Params:
[11/01/17 14:47:03][org.apache.jasper.servlet.JspServlet#service] act = redirect_node_queryGrpTree01
[11/01/17 14:47:03][org.apache.jasper.servlet.JspServlet#service] default = yes
[11/01/17 14:47:03][org.apache.catalina.core.ApplicationDispatcher#doForward] Disabling the response for futher output
[11/01/17 14:47:03][org.springframework.web.servlet.DispatcherServlet#doDispatch] Cleared thread-bound request context: org.apache.catalina.connector.RequestFacade@d8431c
[11/01/17 14:47:03][org.springframework.web.servlet.FrameworkServlet#processRequest] Successfully completed request
[11/01/17 14:47:03][org.springframework.context.support.AbstractApplicationContext#publishEvent] Publishing event in context [org.springframework.web.context.support.XmlWebApplicationContext@1bb205a]: ServletRequestHandledEvent: url=[/iportal/mngNode.do]; client=[127.0.0.1]; method=[GET]; servlet=[dispatcherServlet]; session=[D9440CE41C66AFA2B84DA89D928A9937]; user=[null]; time=[16ms]; status=[OK]
[11/01/17 14:47:03][com.taiwanmobile.iportal.filter.HibernateSessionRequestFilter#doFilter] Transaction commit