-->
These old forums are deprecated now and set to read-only. We are waiting for you on our new forums!
More modern, Discourse-based and with GitHub/Google/Twitter authentication built-in.

All times are UTC - 5 hours [ DST ]



Forum locked This topic is locked, you cannot edit posts or make further replies.  [ 4 posts ] 
Author Message
 Post subject: Problem with hibernate search indexing
PostPosted: Tue Sep 09, 2014 5:11 am 
Newbie

Joined: Fri Jul 16, 2010 6:29 am
Posts: 5
I am experiencing a problem when indexing all my documents using
FullTextSession fullTextSession = Search.getFullTextSession(session);
fullTextSession.createIndexer().startAndWait();

The problem does not occur in the dev environment with what we understand to be the same data in the database.

There is a lot of different errors here but have tried investigated all without coming to a solution.
I have shown the full stacktrace of all the errors just in case but I am sure some of would be irrelevant

Any tips/thoughts/angles to investigate would be helpful.

Let me know if you require further information

Thanks
Vishal

Using:
Hibernate 3.6.10
Hibernate Search 3.4.1


Code:
08:47:04,823 INFO  [STDOUT] 08:47:04,822  INFO SimpleIndexingProgressMonitor:97 - 99650 documents indexed in 294955 ms
08:47:04,823 INFO  [STDOUT] 08:47:04,823  INFO SimpleIndexingProgressMonitor:100 - Indexing speed: 337.84814 documents/second; progress: 45.626873%
08:47:04,890 INFO  [STDOUT] 08:47:04,890  INFO SimpleIndexingProgressMonitor:97 - 99700 documents indexed in 295022 ms
08:47:04,891 INFO  [STDOUT] 08:47:04,891  INFO SimpleIndexingProgressMonitor:100 - Indexing speed: 337.9409 documents/second; progress: 45.649765%
08:47:04,965 INFO  [STDOUT] 08:47:04,964  INFO BasicResourcePool:1392 - A checked-out resource is overdue, and will be destroyed: com.mchange.v2.c3p0.impl.NewPooledConnection@ee64cf
08:47:04,971 INFO  [STDOUT] 08:47:04,966  INFO BasicResourcePool:1395 - Logging the stack trace by which the overdue resource was checked-out.
08:47:04,972 INFO  [STDOUT] java.lang.Exception: DEBUG ONLY: Overdue resource check-out stack trace.
08:47:04,972 INFO  [STDOUT]    at com.mchange.v2.resourcepool.BasicResourcePool.checkoutResource(BasicResourcePool.java:506)
08:47:04,972 INFO  [STDOUT]    at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutPooledConnection(C3P0PooledConnectionPool.java:525)
08:47:04,972 INFO  [STDOUT]    at com.mchange.v2.c3p0.impl.AbstractPoolBackedDataSource.getConnection(AbstractPoolBackedDataSource.java:128)
08:47:04,972 INFO  [STDOUT]    at org.hibernate.connection.C3P0ConnectionProvider.getConnection(C3P0ConnectionProvider.java:78)
08:47:04,973 INFO  [STDOUT]    at org.hibernate.jdbc.ConnectionManager.openConnection(ConnectionManager.java:446)
08:47:04,973 INFO  [STDOUT]    at org.hibernate.jdbc.ConnectionManager.getConnection(ConnectionManager.java:167)
08:47:04,973 INFO  [STDOUT]    at org.hibernate.jdbc.JDBCContext.connection(JDBCContext.java:160)
08:47:04,973 INFO  [STDOUT]    at org.hibernate.transaction.JDBCTransaction.begin(JDBCTransaction.java:81)
08:47:04,973 INFO  [STDOUT]    at org.hibernate.impl.SessionImpl.beginTransaction(SessionImpl.java:1473)
08:47:04,974 INFO  [STDOUT]    at app.dao.AbstractDAO.initiateLuceneFullReindex(AbstractDAO.java:213)
08:47:04,974 INFO  [STDOUT]    at app.services.HotelManager.initiateReindex(HotelManager.java:146)
08:47:04,974 INFO  [STDOUT]    at WICKET_app.services.HotelManager$$FastClassByCGLIB$$e65ccd9e.invoke(<generated>)
08:47:04,974 INFO  [STDOUT]    at net.sf.cglib.proxy.MethodProxy.invoke(MethodProxy.java:191)
08:47:04,974 INFO  [STDOUT]    at org.apache.wicket.proxy.LazyInitProxyFactory$CGLibInterceptor.intercept(LazyInitProxyFactory.java:333)
08:47:04,974 INFO  [STDOUT]    at WICKET_app.services.HotelManager$$EnhancerByCGLIB$$1b4b869d.initiateReindex(<generated>)
08:47:04,975 INFO  [STDOUT]    at app.web.pages.admin.AddUpdateStaticData$11.onClick(AddUpdateStaticData.java:254)
08:47:04,975 INFO  [STDOUT]    at org.apache.wicket.ajax.markup.html.AjaxLink$1.onEvent(AjaxLink.java:86)
08:47:04,975 INFO  [STDOUT]    at org.apache.wicket.ajax.AjaxEventBehavior.respond(AjaxEventBehavior.java:123)
08:47:04,975 INFO  [STDOUT]    at org.apache.wicket.ajax.AbstractDefaultAjaxBehavior.onRequest(AbstractDefaultAjaxBehavior.java:633)
08:47:04,975 INFO  [STDOUT]    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
08:47:04,976 INFO  [STDOUT]    at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
08:47:04,976 INFO  [STDOUT]    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
08:47:04,976 INFO  [STDOUT]    at java.lang.reflect.Method.invoke(Method.java:597)
08:47:04,976 INFO  [STDOUT]    at org.apache.wicket.RequestListenerInterface.internalInvoke(RequestListenerInterface.java:258)
08:47:04,976 INFO  [STDOUT]    at org.apache.wicket.RequestListenerInterface.invoke(RequestListenerInterface.java:241)
08:47:04,976 INFO  [STDOUT]    at org.apache.wicket.core.request.handler.ListenerInterfaceRequestHandler.invokeListener(ListenerInterfaceRequestHandler.java:250)
08:47:04,977 INFO  [STDOUT]    at org.apache.wicket.core.request.handler.ListenerInterfaceRequestHandler.respond(ListenerInterfaceRequestHandler.java:236)
08:47:04,977 INFO  [STDOUT]    at org.apache.wicket.request.cycle.RequestCycle$HandlerExecutor.respond(RequestCycle.java:862)
08:47:04,977 INFO  [STDOUT]    at org.apache.wicket.request.RequestHandlerStack.execute(RequestHandlerStack.java:64)
08:47:04,977 INFO  [STDOUT]    at org.apache.wicket.request.cycle.RequestCycle.execute(RequestCycle.java:261)
08:47:04,977 INFO  [STDOUT]    at org.apache.wicket.request.cycle.RequestCycle.processRequest(RequestCycle.java:218)
08:47:04,978 INFO  [STDOUT]    at org.apache.wicket.request.cycle.RequestCycle.processRequestAndDetach(RequestCycle.java:289)
08:47:04,978 INFO  [STDOUT]    at org.apache.wicket.protocol.http.WicketFilter.processRequestCycle(WicketFilter.java:259)
08:47:04,978 INFO  [STDOUT]    at org.apache.wicket.protocol.http.WicketFilter.processRequest(WicketFilter.java:201)
08:47:04,978 INFO  [STDOUT]    at org.apache.wicket.protocol.http.WicketFilter.doFilter(WicketFilter.java:282)
08:47:04,978 INFO  [STDOUT]    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:274)
08:47:04,978 INFO  [STDOUT]    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:242)
08:47:04,979 INFO  [STDOUT]    at org.springframework.orm.hibernate3.support.OpenSessionInViewFilter.doFilterInternal(OpenSessionInViewFilter.java:198)
08:47:04,979 INFO  [STDOUT]    at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:76)
08:47:04,979 INFO  [STDOUT]    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:274)
08:47:04,979 INFO  [STDOUT]    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:242)
08:47:04,979 INFO  [STDOUT]    at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:275)
08:47:04,980 INFO  [STDOUT]    at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:191)
08:47:04,980 INFO  [STDOUT]    at org.jboss.web.tomcat.security.JaccContextValve.invoke(JaccContextValve.java:88)
08:47:04,980 INFO  [STDOUT]    at org.jboss.web.tomcat.security.SecurityContextEstablishmentValve.invoke(SecurityContextEstablishmentValve.java:100)
08:47:04,980 INFO  [STDOUT]    at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
08:47:04,980 INFO  [STDOUT]    at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:102)
08:47:04,980 INFO  [STDOUT]    at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:109)
08:47:04,981 INFO  [STDOUT]    at org.jboss.web.tomcat.service.request.ActiveRequestResponseCacheValve.invoke(ActiveRequestResponseCacheValve.java:53)
08:47:04,981 INFO  [STDOUT]    at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:362)
08:47:04,981 INFO  [STDOUT]    at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:877)
08:47:04,981 INFO  [STDOUT]    at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.process(Http11Protocol.java:654)
08:47:04,981 INFO  [STDOUT]    at org.apache.tomcat.util.net.JIoEndpoint$Worker.run(JIoEndpoint.java:951)
08:47:04,981 INFO  [STDOUT]    at java.lang.Thread.run(Thread.java:662)
08:47:05,027 INFO  [STDOUT] 08:47:05,027  INFO SimpleIndexingProgressMonitor:97 - 99750 documents indexed in 295159 ms
08:47:05,028 INFO  [STDOUT] 08:47:05,028  INFO SimpleIndexingProgressMonitor:100 - Indexing speed: 337.95343 documents/second; progress: 45.672657%
08:47:05,162 INFO  [STDOUT] 08:47:05,161  INFO SimpleIndexingProgressMonitor:97 - 99800 documents indexed in 295294 ms
08:47:05,162 INFO  [STDOUT] 08:47:05,162  INFO SimpleIndexingProgressMonitor:100 - Indexing speed: 337.96826 documents/second; progress: 45.695553%
08:47:05,224 INFO  [STDOUT] 08:47:05,224  INFO SimpleIndexingProgressMonitor:97 - 99850 documents indexed in 295356 ms

...

08:47:07,800 INFO  [STDOUT] 08:47:07,799  INFO SimpleIndexingProgressMonitor:97 - 101200 documents indexed in 297932 ms
08:47:07,800 INFO  [STDOUT] 08:47:07,800  INFO SimpleIndexingProgressMonitor:100 - Indexing speed: 339.67484 documents/second; progress: 46.33657%
08:47:07,867 INFO  [STDOUT] 08:47:07,867  INFO SimpleIndexingProgressMonitor:97 - 101250 documents indexed in 297999 ms
08:47:07,893 INFO  [STDOUT] 08:47:07,893  INFO SimpleIndexingProgressMonitor:100 - Indexing speed: 339.76624 documents/second; progress: 46.359467%
08:47:07,963 INFO  [STDOUT] 08:47:07,963  INFO SimpleIndexingProgressMonitor:97 - 101300 documents indexed in 298095 ms
08:47:07,964 INFO  [STDOUT] 08:47:07,964  INFO SimpleIndexingProgressMonitor:100 - Indexing speed: 339.82455 documents/second; progress: 46.38236%
08:47:07,989 INFO  [STDOUT] 08:47:07,989  INFO BasicResourcePool:1392 - A checked-out resource is overdue, and will be destroyed: com.mchange.v2.c3p0.impl.NewPooledConnection@1cea63e
08:47:08,011 INFO  [STDOUT] 08:47:07,989  INFO BasicResourcePool:1395 - Logging the stack trace by which the overdue resource was checked-out.
08:47:08,011 INFO  [STDOUT] java.lang.Exception: DEBUG ONLY: Overdue resource check-out stack trace.
08:47:08,012 INFO  [STDOUT]    at com.mchange.v2.resourcepool.BasicResourcePool.checkoutResource(BasicResourcePool.java:506)
08:47:08,012 INFO  [STDOUT]    at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutPooledConnection(C3P0PooledConnectionPool.java:525)
08:47:08,012 INFO  [STDOUT]    at com.mchange.v2.c3p0.impl.AbstractPoolBackedDataSource.getConnection(AbstractPoolBackedDataSource.java:128)
08:47:08,012 INFO  [STDOUT]    at org.hibernate.connection.C3P0ConnectionProvider.getConnection(C3P0ConnectionProvider.java:78)
08:47:08,012 INFO  [STDOUT]    at org.hibernate.jdbc.ConnectionManager.openConnection(ConnectionManager.java:446)
08:47:08,013 INFO  [STDOUT]    at org.hibernate.jdbc.ConnectionManager.getConnection(ConnectionManager.java:167)
08:47:08,037 INFO  [STDOUT]    at org.hibernate.jdbc.JDBCContext.connection(JDBCContext.java:160)
08:47:08,037 INFO  [STDOUT]    at org.hibernate.transaction.JDBCTransaction.begin(JDBCTransaction.java:81)
08:47:08,037 INFO  [STDOUT]    at org.hibernate.search.batchindexing.EntityConsumerLuceneworkProducer.run(EntityConsumerLuceneworkProducer.java:98)
08:47:08,037 INFO  [STDOUT]    at org.hibernate.search.batchindexing.OptionallyWrapInJTATransaction.run(OptionallyWrapInJTATransaction.java:107)
08:47:08,037 INFO  [STDOUT]    at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:895)
08:47:08,037 INFO  [STDOUT]    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:918)
08:47:08,038 INFO  [STDOUT]    at java.lang.Thread.run(Thread.java:662)
08:47:08,038 INFO  [STDOUT] 08:47:08,038  INFO BasicResourcePool:1392 - A checked-out resource is overdue, and will be destroyed: com.mchange.v2.c3p0.impl.NewPooledConnection@11c4af
08:47:08,039 INFO  [STDOUT] 08:47:08,039  INFO BasicResourcePool:1395 - Logging the stack trace by which the overdue resource was checked-out.
08:47:08,039 INFO  [STDOUT] java.lang.Exception: DEBUG ONLY: Overdue resource check-out stack trace.
08:47:08,039 INFO  [STDOUT]    at com.mchange.v2.resourcepool.BasicResourcePool.checkoutResource(BasicResourcePool.java:506)
08:47:08,041 INFO  [STDOUT]    at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutPooledConnection(C3P0PooledConnectionPool.java:525)
08:47:08,042 INFO  [STDOUT]    at com.mchange.v2.c3p0.impl.AbstractPoolBackedDataSource.getConnection(AbstractPoolBackedDataSource.java:128)
08:47:08,043 INFO  [STDOUT]    at org.hibernate.connection.C3P0ConnectionProvider.getConnection(C3P0ConnectionProvider.java:78)
08:47:08,043 INFO  [STDOUT]    at org.hibernate.jdbc.ConnectionManager.openConnection(ConnectionManager.java:446)
08:47:08,044 INFO  [STDOUT]    at org.hibernate.jdbc.ConnectionManager.getConnection(ConnectionManager.java:167)
08:47:08,044 INFO  [STDOUT]    at org.hibernate.jdbc.JDBCContext.connection(JDBCContext.java:160)
08:47:08,045 INFO  [STDOUT]    at org.hibernate.transaction.JDBCTransaction.begin(JDBCTransaction.java:81)
08:47:08,045 INFO  [STDOUT]    at org.hibernate.search.batchindexing.EntityConsumerLuceneworkProducer.run(EntityConsumerLuceneworkProducer.java:98)
08:47:08,046 INFO  [STDOUT]    at org.hibernate.search.batchindexing.OptionallyWrapInJTATransaction.run(OptionallyWrapInJTATransaction.java:107)
08:47:08,047 INFO  [STDOUT]    at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:895)
08:47:08,047 INFO  [STDOUT]    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:918)
08:47:08,048 INFO  [STDOUT]    at java.lang.Thread.run(Thread.java:662)
08:47:08,049 INFO  [STDOUT] 08:47:08,049  INFO BasicResourcePool:1392 - A checked-out resource is overdue, and will be destroyed: com.mchange.v2.c3p0.impl.NewPooledConnection@3812b1
08:47:08,055 INFO  [STDOUT] 08:47:08,050  INFO BasicResourcePool:1395 - Logging the stack trace by which the overdue resource was checked-out.
08:47:08,056 INFO  [STDOUT] java.lang.Exception: DEBUG ONLY: Overdue resource check-out stack trace.
08:47:08,056 INFO  [STDOUT]    at com.mchange.v2.resourcepool.BasicResourcePool.checkoutResource(BasicResourcePool.java:506)
08:47:08,058 INFO  [STDOUT]    at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutPooledConnection(C3P0PooledConnectionPool.java:525)
08:47:08,059 INFO  [STDOUT]    at com.mchange.v2.c3p0.impl.AbstractPoolBackedDataSource.getConnection(AbstractPoolBackedDataSource.java:128)
08:47:08,059 INFO  [STDOUT]    at org.hibernate.connection.C3P0ConnectionProvider.getConnection(C3P0ConnectionProvider.java:78)
08:47:08,060 INFO  [STDOUT]    at org.hibernate.jdbc.ConnectionManager.openConnection(ConnectionManager.java:446)
08:47:08,060 INFO  [STDOUT]    at org.hibernate.jdbc.ConnectionManager.getConnection(ConnectionManager.java:167)
08:47:08,061 INFO  [STDOUT]    at org.hibernate.jdbc.JDBCContext.connection(JDBCContext.java:160)
08:47:08,061 INFO  [STDOUT]    at org.hibernate.transaction.JDBCTransaction.begin(JDBCTransaction.java:81)
08:47:08,085 INFO  [STDOUT]    at org.hibernate.search.batchindexing.IdentifierConsumerEntityProducer.run(IdentifierConsumerEntityProducer.java:86)
08:47:08,085 INFO  [STDOUT]    at org.hibernate.search.batchindexing.OptionallyWrapInJTATransaction.run(OptionallyWrapInJTATransaction.java:107)
08:47:08,085 INFO  [STDOUT]    at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:895)
08:47:08,086 INFO  [STDOUT]    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:918)
08:47:08,086 INFO  [STDOUT]    at java.lang.Thread.run(Thread.java:662)
08:47:08,087 INFO  [STDOUT] 08:47:08,087  INFO BasicResourcePool:1392 - A checked-out resource is overdue, and will be destroyed: com.mchange.v2.c3p0.impl.NewPooledConnection@6353e6
08:47:08,090 INFO  [STDOUT] 08:47:08,088  INFO BasicResourcePool:1395 - Logging the stack trace by which the overdue resource was checked-out.
08:47:08,091 INFO  [STDOUT] java.lang.Exception: DEBUG ONLY: Overdue resource check-out stack trace.
08:47:08,091 INFO  [STDOUT]    at com.mchange.v2.resourcepool.BasicResourcePool.checkoutResource(BasicResourcePool.java:506)
08:47:08,092 INFO  [STDOUT]    at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutPooledConnection(C3P0PooledConnectionPool.java:525)
08:47:08,095 INFO  [STDOUT]    at com.mchange.v2.c3p0.impl.AbstractPoolBackedDataSource.getConnection(AbstractPoolBackedDataSource.java:128)
08:47:08,095 INFO  [STDOUT]    at org.hibernate.connection.C3P0ConnectionProvider.getConnection(C3P0ConnectionProvider.java:78)
08:47:08,095 INFO  [STDOUT]    at org.hibernate.jdbc.ConnectionManager.openConnection(ConnectionManager.java:446)
08:47:08,096 INFO  [STDOUT]    at org.hibernate.jdbc.ConnectionManager.getConnection(ConnectionManager.java:167)
08:47:08,096 INFO  [STDOUT]    at org.hibernate.jdbc.JDBCContext.connection(JDBCContext.java:160)
08:47:08,096 INFO  [STDOUT]    at org.hibernate.transaction.JDBCTransaction.begin(JDBCTransaction.java:81)
08:47:08,096 INFO  [STDOUT]    at org.hibernate.search.batchindexing.EntityConsumerLuceneworkProducer.run(EntityConsumerLuceneworkProducer.java:98)
08:47:08,096 INFO  [STDOUT]    at org.hibernate.search.batchindexing.OptionallyWrapInJTATransaction.run(OptionallyWrapInJTATransaction.java:107)
08:47:08,098 INFO  [STDOUT]    at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:895)
08:47:08,098 INFO  [STDOUT]    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:918)
08:47:08,098 INFO  [STDOUT]    at java.lang.Thread.run(Thread.java:662)
08:47:08,099 INFO  [STDOUT] 08:47:08,099  INFO BasicResourcePool:1392 - A checked-out resource is overdue, and will be destroyed: com.mchange.v2.c3p0.impl.NewPooledConnection@1d43b84
08:47:08,100 INFO  [STDOUT] 08:47:08,099  INFO BasicResourcePool:1395 - Logging the stack trace by which the overdue resource was checked-out.
08:47:08,101 INFO  [STDOUT] java.lang.Exception: DEBUG ONLY: Overdue resource check-out stack trace.
08:47:08,101 INFO  [STDOUT]    at com.mchange.v2.resourcepool.BasicResourcePool.checkoutResource(BasicResourcePool.java:506)
08:47:08,102 INFO  [STDOUT]    at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutPooledConnection(C3P0PooledConnectionPool.java:525)
08:47:08,102 INFO  [STDOUT]    at com.mchange.v2.c3p0.impl.AbstractPoolBackedDataSource.getConnection(AbstractPoolBackedDataSource.java:128)
08:47:08,103 INFO  [STDOUT]    at org.hibernate.connection.C3P0ConnectionProvider.getConnection(C3P0ConnectionProvider.java:78)
08:47:08,104 INFO  [STDOUT]    at org.hibernate.jdbc.ConnectionManager.openConnection(ConnectionManager.java:446)
08:47:08,104 INFO  [STDOUT]    at org.hibernate.jdbc.ConnectionManager.getConnection(ConnectionManager.java:167)
08:47:08,104 INFO  [STDOUT]    at org.hibernate.jdbc.JDBCContext.connection(JDBCContext.java:160)
08:47:08,105 INFO  [STDOUT]    at org.hibernate.transaction.JDBCTransaction.begin(JDBCTransaction.java:81)
08:47:08,105 INFO  [STDOUT]    at org.hibernate.search.batchindexing.IdentifierConsumerEntityProducer.run(IdentifierConsumerEntityProducer.java:86)
08:47:08,106 INFO  [STDOUT]    at org.hibernate.search.batchindexing.OptionallyWrapInJTATransaction.run(OptionallyWrapInJTATransaction.java:107)
08:47:08,106 INFO  [STDOUT]    at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:895)
08:47:08,106 INFO  [STDOUT]    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:918)
08:47:08,133 INFO  [STDOUT]    at java.lang.Thread.run(Thread.java:662)
08:47:08,134 INFO  [STDOUT] 08:47:08,133  INFO BasicResourcePool:1392 - A checked-out resource is overdue, and will be destroyed: com.mchange.v2.c3p0.impl.NewPooledConnection@1f175dc
08:47:08,134 INFO  [STDOUT] 08:47:08,134  INFO BasicResourcePool:1395 - Logging the stack trace by which the overdue resource was checked-out.
08:47:08,135 INFO  [STDOUT] java.lang.Exception: DEBUG ONLY: Overdue resource check-out stack trace.
08:47:08,135 INFO  [STDOUT]    at com.mchange.v2.resourcepool.BasicResourcePool.checkoutResource(BasicResourcePool.java:506)
08:47:08,135 INFO  [STDOUT]    at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutPooledConnection(C3P0PooledConnectionPool.java:525)
08:47:08,135 INFO  [STDOUT]    at com.mchange.v2.c3p0.impl.AbstractPoolBackedDataSource.getConnection(AbstractPoolBackedDataSource.java:128)
08:47:08,135 INFO  [STDOUT]    at org.hibernate.connection.C3P0ConnectionProvider.getConnection(C3P0ConnectionProvider.java:78)
08:47:08,136 INFO  [STDOUT]    at org.hibernate.jdbc.ConnectionManager.openConnection(ConnectionManager.java:446)
08:47:08,136 INFO  [STDOUT]    at org.hibernate.jdbc.ConnectionManager.getConnection(ConnectionManager.java:167)
08:47:08,136 INFO  [STDOUT]    at org.hibernate.jdbc.JDBCContext.connection(JDBCContext.java:160)
08:47:08,136 INFO  [STDOUT]    at org.hibernate.transaction.JDBCTransaction.begin(JDBCTransaction.java:81)
08:47:08,136 INFO  [STDOUT]    at org.hibernate.search.batchindexing.EntityConsumerLuceneworkProducer.run(EntityConsumerLuceneworkProducer.java:98)
08:47:08,136 INFO  [STDOUT]    at org.hibernate.search.batchindexing.OptionallyWrapInJTATransaction.run(OptionallyWrapInJTATransaction.java:107)
08:47:08,137 INFO  [STDOUT]    at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:895)
08:47:08,137 INFO  [STDOUT]    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:918)
08:47:08,137 INFO  [STDOUT]    at java.lang.Thread.run(Thread.java:662)
08:47:08,137 INFO  [STDOUT] 08:47:08,137  INFO BasicResourcePool:1392 - A checked-out resource is overdue, and will be destroyed: com.mchange.v2.c3p0.impl.NewPooledConnection@1c17645
08:47:08,138 INFO  [STDOUT] 08:47:08,138  INFO BasicResourcePool:1395 - Logging the stack trace by which the overdue resource was checked-out.
08:47:08,138 INFO  [STDOUT] java.lang.Exception: DEBUG ONLY: Overdue resource check-out stack trace.
08:47:08,139 INFO  [STDOUT]    at com.mchange.v2.resourcepool.BasicResourcePool.checkoutResource(BasicResourcePool.java:506)
08:47:08,139 INFO  [STDOUT]    at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutPooledConnection(C3P0PooledConnectionPool.java:525)
08:47:08,139 INFO  [STDOUT]    at com.mchange.v2.c3p0.impl.AbstractPoolBackedDataSource.getConnection(AbstractPoolBackedDataSource.java:128)
08:47:08,139 INFO  [STDOUT]    at org.hibernate.connection.C3P0ConnectionProvider.getConnection(C3P0ConnectionProvider.java:78)
08:47:08,139 INFO  [STDOUT]    at org.hibernate.jdbc.ConnectionManager.openConnection(ConnectionManager.java:446)
08:47:08,139 INFO  [STDOUT]    at org.hibernate.jdbc.ConnectionManager.getConnection(ConnectionManager.java:167)
08:47:08,139 INFO  [STDOUT]    at org.hibernate.jdbc.JDBCContext.connection(JDBCContext.java:160)
08:47:08,140 INFO  [STDOUT]    at org.hibernate.transaction.JDBCTransaction.begin(JDBCTransaction.java:81)
08:47:08,140 INFO  [STDOUT]    at org.hibernate.search.batchindexing.IdentifierProducer.inTransactionWrapper(IdentifierProducer.java:110)
08:47:08,140 INFO  [STDOUT]    at org.hibernate.search.batchindexing.IdentifierProducer.run(IdentifierProducer.java:92)
08:47:08,140 INFO  [STDOUT]    at org.hibernate.search.batchindexing.OptionallyWrapInJTATransaction.run(OptionallyWrapInJTATransaction.java:110)
08:47:08,140 INFO  [STDOUT]    at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:895)
08:47:08,140 INFO  [STDOUT]    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:918)
08:47:08,141 INFO  [STDOUT]    at java.lang.Thread.run(Thread.java:662)
08:47:08,154 INFO  [STDOUT] 08:47:08,154  WARN JDBCExceptionReporter:233 - SQL Error: 0, SQLState: S1000
08:47:08,244 INFO  [STDOUT] 08:47:08,244 ERROR JDBCExceptionReporter:234 - Operation not allowed after ResultSet closed
08:47:08,247 INFO  [STDOUT] 08:47:08,246 ERROR IdentifierConsumerEntityProducer:91 - error during batch indexing:
08:47:08,252 INFO  [STDOUT] org.hibernate.exception.GenericJDBCException: could not execute query
08:47:08,253 INFO  [STDOUT]    at org.hibernate.exception.SQLStateConverter.handledNonSpecificException(SQLStateConverter.java:140)
08:47:08,253 INFO  [STDOUT]    at org.hibernate.exception.SQLStateConverter.convert(SQLStateConverter.java:128)
08:47:08,277 INFO  [STDOUT]    at org.hibernate.exception.JDBCExceptionHelper.convert(JDBCExceptionHelper.java:66)
08:47:08,277 INFO  [STDOUT]    at org.hibernate.loader.Loader.doList(Loader.java:2545)
08:47:08,277 INFO  [STDOUT]    at org.hibernate.loader.Loader.listIgnoreQueryCache(Loader.java:2276)
08:47:08,277 INFO  [STDOUT]    at org.hibernate.loader.Loader.list(Loader.java:2271)
08:47:08,277 INFO  [STDOUT]    at org.hibernate.loader.criteria.CriteriaLoader.list(CriteriaLoader.java:119)
08:47:08,277 INFO  [STDOUT]    at org.hibernate.impl.SessionImpl.list(SessionImpl.java:1716)
08:47:08,278 INFO  [STDOUT]    at org.hibernate.impl.CriteriaImpl.list(CriteriaImpl.java:347)
08:47:08,278 INFO  [STDOUT]    at org.hibernate.search.batchindexing.IdentifierConsumerEntityProducer.loadList(IdentifierConsumerEntityProducer.java:141)
08:47:08,278 INFO  [STDOUT]    at org.hibernate.search.batchindexing.IdentifierConsumerEntityProducer.loadAllFromQueue(IdentifierConsumerEntityProducer.java:110)
08:47:08,278 INFO  [STDOUT]    at org.hibernate.search.batchindexing.IdentifierConsumerEntityProducer.run(IdentifierConsumerEntityProducer.java:87)
08:47:08,278 INFO  [STDOUT]    at org.hibernate.search.batchindexing.OptionallyWrapInJTATransaction.run(OptionallyWrapInJTATransaction.java:107)
08:47:08,278 INFO  [STDOUT]    at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:895)
08:47:08,278 INFO  [STDOUT]    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:918)
08:47:08,278 INFO  [STDOUT]    at java.lang.Thread.run(Thread.java:662)
08:47:08,278 INFO  [STDOUT] Caused by: java.sql.SQLException: Operation not allowed after ResultSet closed
08:47:08,278 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:1073)
08:47:08,278 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:987)
08:47:08,278 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:982)
08:47:08,278 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:927)
08:47:08,278 INFO  [STDOUT]    at com.mysql.jdbc.ResultSetImpl.checkClosed(ResultSetImpl.java:794)
08:47:08,278 INFO  [STDOUT]    at com.mysql.jdbc.ResultSetImpl.next(ResultSetImpl.java:7139)
08:47:08,278 INFO  [STDOUT]    at com.mchange.v2.c3p0.impl.NewProxyResultSet.next(NewProxyResultSet.java:2859)
08:47:08,278 INFO  [STDOUT]    at org.hibernate.loader.Loader.doQuery(Loader.java:825)
08:47:08,279 INFO  [STDOUT]    at org.hibernate.loader.Loader.doQueryAndInitializeNonLazyCollections(Loader.java:274)
08:47:08,279 INFO  [STDOUT]    at org.hibernate.loader.Loader.doList(Loader.java:2542)
08:47:08,279 INFO  [STDOUT]    ... 12 more
08:47:08,284 INFO  [STDOUT] 08:47:08,229  WARN JDBCExceptionReporter:233 - SQL Error: 0, SQLState: S1000
08:47:08,284 INFO  [STDOUT] 08:47:08,284 ERROR JDBCExceptionReporter:234 - Operation not allowed after ResultSet closed
08:47:08,285 INFO  [STDOUT] 08:47:08,285 ERROR JDBCTransaction:151 - JDBC commit failed
08:47:08,285 INFO  [STDOUT] com.mysql.jdbc.exceptions.jdbc4.MySQLNonTransientConnectionException: No operations allowed after connection closed.
08:47:08,286 INFO  [STDOUT]    at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
08:47:08,286 INFO  [STDOUT]    at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:39)
08:47:08,286 INFO  [STDOUT]    at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:27)
08:47:08,286 INFO  [STDOUT]    at java.lang.reflect.Constructor.newInstance(Constructor.java:513)
08:47:08,286 INFO  [STDOUT]    at com.mysql.jdbc.Util.handleNewInstance(Util.java:411)
08:47:08,286 INFO  [STDOUT]    at com.mysql.jdbc.Util.getInstance(Util.java:386)
08:47:08,286 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:1013)
08:47:08,286 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:987)
08:47:08,286 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:982)
08:47:08,286 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:927)
08:47:08,286 INFO  [STDOUT]    at com.mysql.jdbc.ConnectionImpl.throwConnectionClosedException(ConnectionImpl.java:1206)
08:47:08,286 INFO  [STDOUT]    at com.mysql.jdbc.ConnectionImpl.checkClosed(ConnectionImpl.java:1198)
08:47:08,286 INFO  [STDOUT]    at com.mysql.jdbc.ConnectionImpl.commit(ConnectionImpl.java:1625)
08:47:08,286 INFO  [STDOUT]    at com.mchange.v2.c3p0.impl.NewProxyConnection.commit(NewProxyConnection.java:803)
08:47:08,286 INFO  [STDOUT]    at org.hibernate.transaction.JDBCTransaction.commitAndResetAutoCommit(JDBCTransaction.java:166)
08:47:08,286 INFO  [STDOUT]    at org.hibernate.transaction.JDBCTransaction.commit(JDBCTransaction.java:142)
08:47:08,287 INFO  [STDOUT]    at org.hibernate.search.batchindexing.EntityConsumerLuceneworkProducer.run(EntityConsumerLuceneworkProducer.java:100)
08:47:08,287 INFO  [STDOUT]    at org.hibernate.search.batchindexing.OptionallyWrapInJTATransaction.run(OptionallyWrapInJTATransaction.java:107)
08:47:08,287 INFO  [STDOUT]    at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:895)
08:47:08,287 INFO  [STDOUT]    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:918)
08:47:08,287 INFO  [STDOUT]    at java.lang.Thread.run(Thread.java:662)
08:47:08,289 INFO  [STDOUT] 08:47:08,287 ERROR EntityConsumerLuceneworkProducer:103 - error during batch indexing:
08:47:08,289 INFO  [STDOUT] org.hibernate.TransactionException: JDBC commit failed
08:47:08,289 INFO  [STDOUT]    at org.hibernate.transaction.JDBCTransaction.commit(JDBCTransaction.java:157)
08:47:08,289 INFO  [STDOUT]    at org.hibernate.search.batchindexing.EntityConsumerLuceneworkProducer.run(EntityConsumerLuceneworkProducer.java:100)
08:47:08,289 INFO  [STDOUT]    at org.hibernate.search.batchindexing.OptionallyWrapInJTATransaction.run(OptionallyWrapInJTATransaction.java:107)
08:47:08,289 INFO  [STDOUT]    at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:895)
08:47:08,289 INFO  [STDOUT]    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:918)
08:47:08,289 INFO  [STDOUT]    at java.lang.Thread.run(Thread.java:662)
08:47:08,289 INFO  [STDOUT] Caused by: com.mysql.jdbc.exceptions.jdbc4.MySQLNonTransientConnectionException: No operations allowed after connection closed.
08:47:08,289 INFO  [STDOUT]    at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
08:47:08,289 INFO  [STDOUT]    at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:39)
08:47:08,289 INFO  [STDOUT]    at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:27)
08:47:08,289 INFO  [STDOUT]    at java.lang.reflect.Constructor.newInstance(Constructor.java:513)
08:47:08,292 INFO  [STDOUT]    at com.mysql.jdbc.Util.handleNewInstance(Util.java:411)
08:47:08,293 INFO  [STDOUT]    at com.mysql.jdbc.Util.getInstance(Util.java:386)
08:47:08,293 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:1013)
08:47:08,293 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:987)
08:47:08,293 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:982)
08:47:08,293 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:927)
08:47:08,293 INFO  [STDOUT]    at com.mysql.jdbc.ConnectionImpl.throwConnectionClosedException(ConnectionImpl.java:1206)
08:47:08,293 INFO  [STDOUT]    at com.mysql.jdbc.ConnectionImpl.checkClosed(ConnectionImpl.java:1198)
08:47:08,293 INFO  [STDOUT]    at com.mysql.jdbc.ConnectionImpl.commit(ConnectionImpl.java:1625)
08:47:08,293 INFO  [STDOUT]    at com.mchange.v2.c3p0.impl.NewProxyConnection.commit(NewProxyConnection.java:803)
08:47:08,293 INFO  [STDOUT]    at org.hibernate.transaction.JDBCTransaction.commitAndResetAutoCommit(JDBCTransaction.java:166)
08:47:08,293 INFO  [STDOUT]    at org.hibernate.transaction.JDBCTransaction.commit(JDBCTransaction.java:142)
08:47:08,293 INFO  [STDOUT]    ... 5 more
08:47:08,296 INFO  [STDOUT] 08:47:08,288 ERROR IdentifierConsumerEntityProducer:91 - error during batch indexing:
08:47:08,296 INFO  [STDOUT] org.hibernate.exception.GenericJDBCException: could not initialize a collection: [app.model.hotel.Hotel.images#63486]
08:47:08,297 INFO  [STDOUT]    at org.hibernate.exception.SQLStateConverter.handledNonSpecificException(SQLStateConverter.java:140)
08:47:08,297 INFO  [STDOUT]    at org.hibernate.exception.SQLStateConverter.convert(SQLStateConverter.java:128)
08:47:08,297 INFO  [STDOUT]    at org.hibernate.exception.JDBCExceptionHelper.convert(JDBCExceptionHelper.java:66)
08:47:08,297 INFO  [STDOUT]    at org.hibernate.loader.Loader.loadCollection(Loader.java:2173)
08:47:08,297 INFO  [STDOUT]    at org.hibernate.loader.collection.CollectionLoader.initialize(CollectionLoader.java:62)
08:47:08,297 INFO  [STDOUT]    at org.hibernate.persister.collection.AbstractCollectionPersister.initialize(AbstractCollectionPersister.java:627)
08:47:08,297 INFO  [STDOUT]    at org.hibernate.event.def.DefaultInitializeCollectionEventListener.onInitializeCollection(DefaultInitializeCollectionEventListener.java:83)
08:47:08,297 INFO  [STDOUT]    at org.hibernate.impl.SessionImpl.initializeCollection(SessionImpl.java:1863)
08:47:08,297 INFO  [STDOUT]    at org.hibernate.collection.AbstractPersistentCollection.forceInitialization(AbstractPersistentCollection.java:479)
08:47:08,297 INFO  [STDOUT]    at org.hibernate.engine.StatefulPersistenceContext.initializeNonLazyCollections(StatefulPersistenceContext.java:900)
08:47:08,297 INFO  [STDOUT]    at org.hibernate.loader.Loader.doQueryAndInitializeNonLazyCollections(Loader.java:279)
08:47:08,297 INFO  [STDOUT]    at org.hibernate.loader.Loader.doList(Loader.java:2542)
08:47:08,297 INFO  [STDOUT]    at org.hibernate.loader.Loader.listIgnoreQueryCache(Loader.java:2276)
08:47:08,297 INFO  [STDOUT]    at org.hibernate.loader.Loader.list(Loader.java:2271)
08:47:08,297 INFO  [STDOUT]    at org.hibernate.loader.criteria.CriteriaLoader.list(CriteriaLoader.java:119)
08:47:08,297 INFO  [STDOUT]    at org.hibernate.impl.SessionImpl.list(SessionImpl.java:1716)
08:47:08,298 INFO  [STDOUT]    at org.hibernate.impl.CriteriaImpl.list(CriteriaImpl.java:347)
08:47:08,298 INFO  [STDOUT]    at org.hibernate.search.batchindexing.IdentifierConsumerEntityProducer.loadList(IdentifierConsumerEntityProducer.java:141)
08:47:08,298 INFO  [STDOUT]    at org.hibernate.search.batchindexing.IdentifierConsumerEntityProducer.loadAllFromQueue(IdentifierConsumerEntityProducer.java:110)
08:47:08,298 INFO  [STDOUT]    at org.hibernate.search.batchindexing.IdentifierConsumerEntityProducer.run(IdentifierConsumerEntityProducer.java:87)
08:47:08,298 INFO  [STDOUT]    at org.hibernate.search.batchindexing.OptionallyWrapInJTATransaction.run(OptionallyWrapInJTATransaction.java:107)
08:47:08,298 INFO  [STDOUT]    at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:895)
08:47:08,298 INFO  [STDOUT]    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:918)
08:47:08,298 INFO  [STDOUT]    at java.lang.Thread.run(Thread.java:662)
08:47:08,298 INFO  [STDOUT] Caused by: java.sql.SQLException: Operation not allowed after ResultSet closed
08:47:08,298 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:1073)
08:47:08,298 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:987)
08:47:08,298 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:982)
08:47:08,298 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:927)
08:47:08,298 INFO  [STDOUT]    at com.mysql.jdbc.ResultSetImpl.checkClosed(ResultSetImpl.java:794)
08:47:08,298 INFO  [STDOUT]    at com.mysql.jdbc.ResultSetImpl.next(ResultSetImpl.java:7139)
08:47:08,298 INFO  [STDOUT]    at com.mchange.v2.c3p0.impl.NewProxyResultSet.next(NewProxyResultSet.java:2859)
08:47:08,298 INFO  [STDOUT]    at org.hibernate.loader.Loader.doQuery(Loader.java:825)
08:47:08,299 INFO  [STDOUT]    at org.hibernate.loader.Loader.doQueryAndInitializeNonLazyCollections(Loader.java:274)
08:47:08,299 INFO  [STDOUT]    at org.hibernate.loader.Loader.loadCollection(Loader.java:2166)
08:47:08,299 INFO  [STDOUT]    ... 20 more
08:47:08,300 INFO  [STDOUT] 08:47:08,288 ERROR JDBCTransaction:151 - JDBC commit failed
08:47:08,300 INFO  [STDOUT] com.mysql.jdbc.exceptions.jdbc4.MySQLNonTransientConnectionException: No operations allowed after connection closed.
08:47:08,300 INFO  [STDOUT]    at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
08:47:08,300 INFO  [STDOUT]    at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:39)
08:47:08,300 INFO  [STDOUT]    at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:27)
08:47:08,300 INFO  [STDOUT]    at java.lang.reflect.Constructor.newInstance(Constructor.java:513)
08:47:08,300 INFO  [STDOUT]    at com.mysql.jdbc.Util.handleNewInstance(Util.java:411)
08:47:08,300 INFO  [STDOUT]    at com.mysql.jdbc.Util.getInstance(Util.java:386)
08:47:08,300 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:1013)
08:47:08,300 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:987)
08:47:08,300 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:982)
08:47:08,300 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:927)
08:47:08,300 INFO  [STDOUT]    at com.mysql.jdbc.ConnectionImpl.throwConnectionClosedException(ConnectionImpl.java:1206)
08:47:08,300 INFO  [STDOUT]    at com.mysql.jdbc.ConnectionImpl.checkClosed(ConnectionImpl.java:1198)
08:47:08,300 INFO  [STDOUT]    at com.mysql.jdbc.ConnectionImpl.commit(ConnectionImpl.java:1625)
08:47:08,301 INFO  [STDOUT]    at com.mchange.v2.c3p0.impl.NewProxyConnection.commit(NewProxyConnection.java:803)
08:47:08,301 INFO  [STDOUT]    at org.hibernate.transaction.JDBCTransaction.commitAndResetAutoCommit(JDBCTransaction.java:166)
08:47:08,301 INFO  [STDOUT]    at org.hibernate.transaction.JDBCTransaction.commit(JDBCTransaction.java:142)
08:47:08,301 INFO  [STDOUT]    at org.hibernate.search.batchindexing.EntityConsumerLuceneworkProducer.run(EntityConsumerLuceneworkProducer.java:100)
08:47:08,373 INFO  [STDOUT]    at org.hibernate.search.batchindexing.OptionallyWrapInJTATransaction.run(OptionallyWrapInJTATransaction.java:107)
08:47:08,373 INFO  [STDOUT]    at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:895)
08:47:08,374 INFO  [STDOUT]    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:918)
08:47:08,374 INFO  [STDOUT]    at java.lang.Thread.run(Thread.java:662)
08:47:08,375 INFO  [STDOUT] 08:47:08,288 ERROR JDBCTransaction:151 - JDBC commit failed
08:47:08,375 INFO  [STDOUT] com.mysql.jdbc.exceptions.jdbc4.MySQLNonTransientConnectionException: No operations allowed after connection closed.
08:47:08,375 INFO  [STDOUT]    at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
08:47:08,375 INFO  [STDOUT]    at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:39)
08:47:08,375 INFO  [STDOUT]    at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:27)
08:47:08,375 INFO  [STDOUT]    at java.lang.reflect.Constructor.newInstance(Constructor.java:513)
08:47:08,376 INFO  [STDOUT]    at com.mysql.jdbc.Util.handleNewInstance(Util.java:411)
08:47:08,376 INFO  [STDOUT]    at com.mysql.jdbc.Util.getInstance(Util.java:386)
08:47:08,376 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:1013)
08:47:08,376 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:987)
08:47:08,376 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:982)
08:47:08,376 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:927)
08:47:08,376 INFO  [STDOUT]    at com.mysql.jdbc.ConnectionImpl.throwConnectionClosedException(ConnectionImpl.java:1206)
08:47:08,377 INFO  [STDOUT]    at com.mysql.jdbc.ConnectionImpl.checkClosed(ConnectionImpl.java:1198)
08:47:08,377 INFO  [STDOUT]    at com.mysql.jdbc.ConnectionImpl.commit(ConnectionImpl.java:1625)
08:47:08,377 INFO  [STDOUT]    at com.mchange.v2.c3p0.impl.NewProxyConnection.commit(NewProxyConnection.java:803)
08:47:08,377 INFO  [STDOUT]    at org.hibernate.transaction.JDBCTransaction.commitAndResetAutoCommit(JDBCTransaction.java:166)
08:47:08,377 INFO  [STDOUT]    at org.hibernate.transaction.JDBCTransaction.commit(JDBCTransaction.java:142)
08:47:08,377 INFO  [STDOUT]    at org.hibernate.search.batchindexing.EntityConsumerLuceneworkProducer.run(EntityConsumerLuceneworkProducer.java:100)
08:47:08,377 INFO  [STDOUT]    at org.hibernate.search.batchindexing.OptionallyWrapInJTATransaction.run(OptionallyWrapInJTATransaction.java:107)
08:47:08,378 INFO  [STDOUT]    at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:895)
08:47:08,378 INFO  [STDOUT]    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:918)
08:47:08,378 INFO  [STDOUT]    at java.lang.Thread.run(Thread.java:662)
08:47:08,379 INFO  [STDOUT] 08:47:08,287 ERROR JDBCTransaction:151 - JDBC commit failed
08:47:08,379 INFO  [STDOUT] com.mysql.jdbc.exceptions.jdbc4.MySQLNonTransientConnectionException: No operations allowed after connection closed.
08:47:08,379 INFO  [STDOUT]    at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
08:47:08,379 INFO  [STDOUT]    at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:39)
08:47:08,379 INFO  [STDOUT]    at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:27)
08:47:08,379 INFO  [STDOUT]    at java.lang.reflect.Constructor.newInstance(Constructor.java:513)
08:47:08,379 INFO  [STDOUT]    at com.mysql.jdbc.Util.handleNewInstance(Util.java:411)
08:47:08,380 INFO  [STDOUT]    at com.mysql.jdbc.Util.getInstance(Util.java:386)
08:47:08,380 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:1013)
08:47:08,380 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:987)
08:47:08,380 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:982)
08:47:08,380 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:927)
08:47:08,380 INFO  [STDOUT]    at com.mysql.jdbc.ConnectionImpl.throwConnectionClosedException(ConnectionImpl.java:1206)
08:47:08,380 INFO  [STDOUT]    at com.mysql.jdbc.ConnectionImpl.checkClosed(ConnectionImpl.java:1198)
08:47:08,381 INFO  [STDOUT]    at com.mysql.jdbc.ConnectionImpl.commit(ConnectionImpl.java:1625)
08:47:08,381 INFO  [STDOUT]    at com.mchange.v2.c3p0.impl.NewProxyConnection.commit(NewProxyConnection.java:803)
08:47:08,381 INFO  [STDOUT]    at org.hibernate.transaction.JDBCTransaction.commitAndResetAutoCommit(JDBCTransaction.java:166)
08:47:08,381 INFO  [STDOUT]    at org.hibernate.transaction.JDBCTransaction.commit(JDBCTransaction.java:142)
08:47:08,381 INFO  [STDOUT]    at org.hibernate.search.batchindexing.EntityConsumerLuceneworkProducer.run(EntityConsumerLuceneworkProducer.java:100)
08:47:08,381 INFO  [STDOUT]    at org.hibernate.search.batchindexing.OptionallyWrapInJTATransaction.run(OptionallyWrapInJTATransaction.java:107)
08:47:08,381 INFO  [STDOUT]    at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:895)
08:47:08,382 INFO  [STDOUT]    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:918)
08:47:08,382 INFO  [STDOUT]    at java.lang.Thread.run(Thread.java:662)
08:47:08,382 INFO  [STDOUT] 08:47:08,334  WARN LoadContexts:132 - fail-safe cleanup (collections) : org.hibernate.engine.loading.CollectionLoadContext@17601d0<rs=com.mchange.v2.c3p0.impl.NewProxyResultSet@121b338>
08:47:08,383 INFO  [STDOUT] 08:47:08,382  WARN CollectionLoadContext:361 - On CollectionLoadContext#cleanup, localLoadingCollectionKeys contained [1] entries
08:47:08,384 INFO  [STDOUT] 08:47:08,374 ERROR EntityConsumerLuceneworkProducer:103 - error during batch indexing:
08:47:08,384 INFO  [STDOUT] org.hibernate.TransactionException: JDBC commit failed
08:47:08,384 INFO  [STDOUT]    at org.hibernate.transaction.JDBCTransaction.commit(JDBCTransaction.java:157)
08:47:08,384 INFO  [STDOUT]    at org.hibernate.search.batchindexing.EntityConsumerLuceneworkProducer.run(EntityConsumerLuceneworkProducer.java:100)
08:47:08,384 INFO  [STDOUT]    at org.hibernate.search.batchindexing.OptionallyWrapInJTATransaction.run(OptionallyWrapInJTATransaction.java:107)
08:47:08,384 INFO  [STDOUT]    at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:895)
08:47:08,385 INFO  [STDOUT]    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:918)
08:47:08,385 INFO  [STDOUT]    at java.lang.Thread.run(Thread.java:662)
08:47:08,385 INFO  [STDOUT] Caused by: com.mysql.jdbc.exceptions.jdbc4.MySQLNonTransientConnectionException: No operations allowed after connection closed.
08:47:08,385 INFO  [STDOUT]    at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
08:47:08,385 INFO  [STDOUT]    at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:39)
08:47:08,385 INFO  [STDOUT]    at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:27)
08:47:08,385 INFO  [STDOUT]    at java.lang.reflect.Constructor.newInstance(Constructor.java:513)
08:47:08,386 INFO  [STDOUT]    at com.mysql.jdbc.Util.handleNewInstance(Util.java:411)
08:47:08,386 INFO  [STDOUT]    at com.mysql.jdbc.Util.getInstance(Util.java:386)
08:47:08,386 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:1013)
08:47:08,386 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:987)
08:47:08,386 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:982)
08:47:08,386 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:927)
08:47:08,386 INFO  [STDOUT]    at com.mysql.jdbc.ConnectionImpl.throwConnectionClosedException(ConnectionImpl.java:1206)
08:47:08,387 INFO  [STDOUT]    at com.mysql.jdbc.ConnectionImpl.checkClosed(ConnectionImpl.java:1198)
08:47:08,387 INFO  [STDOUT]    at com.mysql.jdbc.ConnectionImpl.commit(ConnectionImpl.java:1625)
08:47:08,387 INFO  [STDOUT]    at com.mchange.v2.c3p0.impl.NewProxyConnection.commit(NewProxyConnection.java:803)
08:47:08,387 INFO  [STDOUT]    at org.hibernate.transaction.JDBCTransaction.commitAndResetAutoCommit(JDBCTransaction.java:166)
08:47:08,387 INFO  [STDOUT]    at org.hibernate.transaction.JDBCTransaction.commit(JDBCTransaction.java:142)
08:47:08,387 INFO  [STDOUT]    ... 5 more
08:47:08,388 INFO  [STDOUT] 08:47:08,383 ERROR EntityConsumerLuceneworkProducer:103 - error during batch indexing:
08:47:08,388 INFO  [STDOUT] org.hibernate.TransactionException: JDBC commit failed
08:47:08,388 INFO  [STDOUT]    at org.hibernate.transaction.JDBCTransaction.commit(JDBCTransaction.java:157)
08:47:08,389 INFO  [STDOUT]    at org.hibernate.search.batchindexing.EntityConsumerLuceneworkProducer.run(EntityConsumerLuceneworkProducer.java:100)
08:47:08,389 INFO  [STDOUT]    at org.hibernate.search.batchindexing.OptionallyWrapInJTATransaction.run(OptionallyWrapInJTATransaction.java:107)
08:47:08,389 INFO  [STDOUT]    at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:895)
08:47:08,389 INFO  [STDOUT]    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:918)
08:47:08,389 INFO  [STDOUT]    at java.lang.Thread.run(Thread.java:662)
08:47:08,390 INFO  [STDOUT] Caused by: com.mysql.jdbc.exceptions.jdbc4.MySQLNonTransientConnectionException: No operations allowed after connection closed.
08:47:08,390 INFO  [STDOUT]    at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
08:47:08,390 INFO  [STDOUT]    at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:39)
08:47:08,390 INFO  [STDOUT]    at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:27)
08:47:08,390 INFO  [STDOUT]    at java.lang.reflect.Constructor.newInstance(Constructor.java:513)
08:47:08,390 INFO  [STDOUT]    at com.mysql.jdbc.Util.handleNewInstance(Util.java:411)
08:47:08,390 INFO  [STDOUT]    at com.mysql.jdbc.Util.getInstance(Util.java:386)
08:47:08,390 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:1013)
08:47:08,391 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:987)
08:47:08,391 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:982)
08:47:08,391 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:927)
08:47:08,391 INFO  [STDOUT]    at com.mysql.jdbc.ConnectionImpl.throwConnectionClosedException(ConnectionImpl.java:1206)
08:47:08,391 INFO  [STDOUT]    at com.mysql.jdbc.ConnectionImpl.checkClosed(ConnectionImpl.java:1198)
08:47:08,391 INFO  [STDOUT]    at com.mysql.jdbc.ConnectionImpl.commit(ConnectionImpl.java:1625)
08:47:08,391 INFO  [STDOUT]    at com.mchange.v2.c3p0.impl.NewProxyConnection.commit(NewProxyConnection.java:803)
08:47:08,392 INFO  [STDOUT]    at org.hibernate.transaction.JDBCTransaction.commitAndResetAutoCommit(JDBCTransaction.java:166)
08:47:08,392 INFO  [STDOUT]    at org.hibernate.transaction.JDBCTransaction.commit(JDBCTransaction.java:142)
08:47:08,392 INFO  [STDOUT]    ... 5 more
08:47:08,392 INFO  [STDOUT] 08:47:08,383 ERROR EntityConsumerLuceneworkProducer:103 - error during batch indexing:
08:47:08,393 INFO  [STDOUT] org.hibernate.TransactionException: JDBC commit failed
08:47:08,393 INFO  [STDOUT]    at org.hibernate.transaction.JDBCTransaction.commit(JDBCTransaction.java:157)
08:47:08,393 INFO  [STDOUT]    at org.hibernate.search.batchindexing.EntityConsumerLuceneworkProducer.run(EntityConsumerLuceneworkProducer.java:100)
08:47:08,393 INFO  [STDOUT]    at org.hibernate.search.batchindexing.OptionallyWrapInJTATransaction.run(OptionallyWrapInJTATransaction.java:107)
08:47:08,393 INFO  [STDOUT]    at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:895)
08:47:08,393 INFO  [STDOUT]    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:918)
08:47:08,394 INFO  [STDOUT]    at java.lang.Thread.run(Thread.java:662)
08:47:08,394 INFO  [STDOUT] Caused by: com.mysql.jdbc.exceptions.jdbc4.MySQLNonTransientConnectionException: No operations allowed after connection closed.
08:47:08,394 INFO  [STDOUT]    at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
08:47:08,394 INFO  [STDOUT]    at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:39)
08:47:08,394 INFO  [STDOUT]    at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:27)
08:47:08,394 INFO  [STDOUT]    at java.lang.reflect.Constructor.newInstance(Constructor.java:513)
08:47:08,394 INFO  [STDOUT]    at com.mysql.jdbc.Util.handleNewInstance(Util.java:411)
08:47:08,394 INFO  [STDOUT]    at com.mysql.jdbc.Util.getInstance(Util.java:386)
08:47:08,395 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:1013)
08:47:08,395 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:987)
08:47:08,395 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:982)
08:47:08,395 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:927)
08:47:08,395 INFO  [STDOUT]    at com.mysql.jdbc.ConnectionImpl.throwConnectionClosedException(ConnectionImpl.java:1206)
08:47:08,395 INFO  [STDOUT]    at com.mysql.jdbc.ConnectionImpl.checkClosed(ConnectionImpl.java:1198)
08:47:08,395 INFO  [STDOUT]    at com.mysql.jdbc.ConnectionImpl.commit(ConnectionImpl.java:1625)
08:47:08,396 INFO  [STDOUT]    at com.mchange.v2.c3p0.impl.NewProxyConnection.commit(NewProxyConnection.java:803)
08:47:08,396 INFO  [STDOUT]    at org.hibernate.transaction.JDBCTransaction.commitAndResetAutoCommit(JDBCTransaction.java:166)
08:47:08,396 INFO  [STDOUT]    at org.hibernate.transaction.JDBCTransaction.commit(JDBCTransaction.java:142)
08:47:08,396 INFO  [STDOUT]    ... 5 more
08:47:11,707 INFO  [STDOUT] 08:47:11,706  INFO SimpleIndexingProgressMonitor:88 - Reindexed 218402 entities
08:47:11,710 INFO  [STDOUT] 08:47:11,708 ERROR JDBCTransaction:151 - JDBC commit failed
08:47:11,710 INFO  [STDOUT] com.mysql.jdbc.exceptions.jdbc4.MySQLNonTransientConnectionException: No operations allowed after connection closed.
08:47:11,710 INFO  [STDOUT]    at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
08:47:11,711 INFO  [STDOUT]    at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:39)
08:47:11,711 INFO  [STDOUT]    at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:27)
08:47:11,711 INFO  [STDOUT]    at java.lang.reflect.Constructor.newInstance(Constructor.java:513)
08:47:11,711 INFO  [STDOUT]    at com.mysql.jdbc.Util.handleNewInstance(Util.java:411)
08:47:11,711 INFO  [STDOUT]    at com.mysql.jdbc.Util.getInstance(Util.java:386)
08:47:11,711 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:1013)
08:47:11,712 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:987)
08:47:11,712 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:982)
08:47:11,712 INFO  [STDOUT]    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:927)
08:47:11,712 INFO  [STDOUT]    at com.mysql.jdbc.ConnectionImpl.throwConnectionClosedException(ConnectionImpl.java:1206)
08:47:11,712 INFO  [STDOUT]    at com.mysql.jdbc.ConnectionImpl.checkClosed(ConnectionImpl.java:1198)
08:47:11,712 INFO  [STDOUT]    at com.mysql.jdbc.ConnectionImpl.commit(ConnectionImpl.java:1625)
08:47:11,713 INFO  [STDOUT]    at com.mchange.v2.c3p0.impl.NewProxyConnection.commit(NewProxyConnection.java:803)
08:47:11,713 INFO  [STDOUT]    at org.hibernate.transaction.JDBCTransaction.commitAndResetAutoCommit(JDBCTransaction.java:166)
08:47:11,713 INFO  [STDOUT]    at org.hibernate.transaction.JDBCTransaction.commit(JDBCTransaction.java:142)
08:47:11,713 INFO  [STDOUT]    at app.dao.AbstractDAO.initiateLuceneFullReindex(AbstractDAO.java:218)
08:47:11,713 INFO  [STDOUT]    at app.services.HotelManager.initiateReindex(HotelManager.java:146)
08:47:11,713 INFO  [STDOUT]    at WICKET_app.services.HotelManager$$FastClassByCGLIB$$e65ccd9e.invoke(<generated>)
08:47:11,714 INFO  [STDOUT]    at net.sf.cglib.proxy.MethodProxy.invoke(MethodProxy.java:191)
08:47:11,714 INFO  [STDOUT]    at org.apache.wicket.proxy.LazyInitProxyFactory$CGLibInterceptor.intercept(LazyInitProxyFactory.java:333)
08:47:11,714 INFO  [STDOUT]    at WICKET_app.services.HotelManager$$EnhancerByCGLIB$$1b4b869d.initiateReindex(<generated>)
08:47:11,714 INFO  [STDOUT]    at app.web.pages.admin.AddUpdateStaticData$11.onClick(AddUpdateStaticData.java:254)
08:47:11,714 INFO  [STDOUT]    at org.apache.wicket.ajax.markup.html.AjaxLink$1.onEvent(AjaxLink.java:86)
08:47:11,714 INFO  [STDOUT]    at org.apache.wicket.ajax.AjaxEventBehavior.respond(AjaxEventBehavior.java:123)
08:47:11,714 INFO  [STDOUT]    at org.apache.wicket.ajax.AbstractDefaultAjaxBehavior.onRequest(AbstractDefaultAjaxBehavior.java:633)
08:47:11,715 INFO  [STDOUT]    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
08:47:11,715 INFO  [STDOUT]    at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
08:47:11,715 INFO  [STDOUT]    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
08:47:11,715 INFO  [STDOUT]    at java.lang.reflect.Method.invoke(Method.java:597)
08:47:11,715 INFO  [STDOUT]    at org.apache.wicket.RequestListenerInterface.internalInvoke(RequestListenerInterface.java:258)
08:47:11,716 INFO  [STDOUT]    at org.apache.wicket.RequestListenerInterface.invoke(RequestListenerInterface.java:241)
08:47:11,716 INFO  [STDOUT]    at org.apache.wicket.core.request.handler.ListenerInterfaceRequestHandler.invokeListener(ListenerInterfaceRequestHandler.java:250)
08:47:11,716 INFO  [STDOUT]    at org.apache.wicket.core.request.handler.ListenerInterfaceRequestHandler.respond(ListenerInterfaceRequestHandler.java:236)
08:47:11,716 INFO  [STDOUT]    at org.apache.wicket.request.cycle.RequestCycle$HandlerExecutor.respond(RequestCycle.java:862)
08:47:11,716 INFO  [STDOUT]    at org.apache.wicket.request.RequestHandlerStack.execute(RequestHandlerStack.java:64)
08:47:11,716 INFO  [STDOUT]    at org.apache.wicket.request.cycle.RequestCycle.execute(RequestCycle.java:261)
08:47:11,717 INFO  [STDOUT]    at org.apache.wicket.request.cycle.RequestCycle.processRequest(RequestCycle.java:218)
08:47:11,717 INFO  [STDOUT]    at org.apache.wicket.request.cycle.RequestCycle.processRequestAndDetach(RequestCycle.java:289)
08:47:11,717 INFO  [STDOUT]    at org.apache.wicket.protocol.http.WicketFilter.processRequestCycle(WicketFilter.java:259)
08:47:11,717 INFO  [STDOUT]    at org.apache.wicket.protocol.http.WicketFilter.processRequest(WicketFilter.java:201)
08:47:11,717 INFO  [STDOUT]    at org.apache.wicket.protocol.http.WicketFilter.doFilter(WicketFilter.java:282)
08:47:11,717 INFO  [STDOUT]    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:274)
08:47:11,718 INFO  [STDOUT]    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:242)
08:47:11,718 INFO  [STDOUT]    at org.springframework.orm.hibernate3.support.OpenSessionInViewFilter.doFilterInternal(OpenSessionInViewFilter.java:198)
08:47:11,718 INFO  [STDOUT]    at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:76)
08:47:11,718 INFO  [STDOUT]    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:274)
08:47:11,718 INFO  [STDOUT]    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:242)
08:47:11,718 INFO  [STDOUT]    at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:275)
08:47:11,719 INFO  [STDOUT]    at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:191)
08:47:11,719 INFO  [STDOUT]    at org.jboss.web.tomcat.security.JaccContextValve.invoke(JaccContextValve.java:88)
08:47:11,719 INFO  [STDOUT]    at org.jboss.web.tomcat.security.SecurityContextEstablishmentValve.invoke(SecurityContextEstablishmentValve.java:100)
08:47:11,719 INFO  [STDOUT]    at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
08:47:11,719 INFO  [STDOUT]    at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:102)
08:47:11,719 INFO  [STDOUT]    at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:109)
08:47:11,720 INFO  [STDOUT]    at org.jboss.web.tomcat.service.request.ActiveRequestResponseCacheValve.invoke(ActiveRequestResponseCacheValve.java:53)
08:47:11,720 INFO  [STDOUT]    at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:362)
08:47:11,720 INFO  [STDOUT]    at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:877)
08:47:11,720 INFO  [STDOUT]    at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.process(Http11Protocol.java:654)
08:47:11,720 INFO  [STDOUT]    at org.apache.tomcat.util.net.JIoEndpoint$Worker.run(JIoEndpoint.java:951)
08:47:11,720 INFO  [STDOUT]    at java.lang.Thread.run(Thread.java:662)


Top
 Profile  
 
 Post subject: Re: Problem with hibernate search indexing
PostPosted: Tue Sep 23, 2014 5:55 pm 
Hibernate Team
Hibernate Team

Joined: Fri Oct 05, 2007 4:47 pm
Posts: 2536
Location: Third rock from the Sun
It looks like that C3P0 is terminating the database connection as the indexing process didn't complete in a specific timeout it is assiging to connections.

Hibernate Search will need more time, you should remove such timeouts from the C3P0 configuration.

_________________
Sanne
http://in.relation.to/


Top
 Profile  
 
 Post subject: Re: Problem with hibernate search indexing
PostPosted: Thu Oct 02, 2014 11:32 am 
Newbie

Joined: Fri Jul 16, 2010 6:29 am
Posts: 5
Thanks for your suggestion. I have tried increasing hibernate.c3p0.timeout from 100 to 500 and then also 1000 but no change.
Are the numbers I set it to in the right type of range?
Is there anything I can check to see what settings may be going to high?
Thanks


Top
 Profile  
 
 Post subject: Re: Problem with hibernate search indexing
PostPosted: Fri Oct 03, 2014 7:04 am 
Newbie

Joined: Fri Jul 16, 2010 6:29 am
Posts: 5
I have solved this- thank you Sanne for your help!

I previously had the following settings:
<property name="hibernate.c3p0.timeout">100</property> <!-- seconds -->
<property name="hibernate.c3p0.debugUnreturnedConnectionStackTraces">true</property>
<property name="hibernate.c3p0.unreturnedConnectionTimeout">300</property><!-- seconds -->

I changed the settings to the following just for the reindex:
hibernate.c3p0.timeout=1000
hibernate.c3p0.debugUnreturnedConnectionStackTraces=false
hibernate.c3p0.unreturnedConnectionTimeout=1000

I am not sure if all of the above is required to be changed for it to work though.
As the reindex is only to be done every so often, to change the to the above settings temporarily is fine for me.


Top
 Profile  
 
Display posts from previous:  Sort by  
Forum locked This topic is locked, you cannot edit posts or make further replies.  [ 4 posts ] 

All times are UTC - 5 hours [ DST ]


You cannot post new topics in this forum
You cannot reply to topics in this forum
You cannot edit your posts in this forum
You cannot delete your posts in this forum

Search for:
© Copyright 2014, Red Hat Inc. All rights reserved. JBoss and Hibernate are registered trademarks and servicemarks of Red Hat, Inc.