20:43:27.334 [quartzScheduler_QuartzSchedulerThread] DEBUG o.quartz.core.QuartzSchedulerThread - batch acquisition of 0 triggers 20:43:34.972 [Thread-13] DEBUG c.r.r.service.impl.SessionWorker - Request: NXCPMessage [messageCode=4354, messageFlags=0, messageId=693, variableMap={268435456=NXCPMessageField{id=268435456, type=1, integerValue=0, realValue=0.0, stringValue='PERIOD_END', binaryValue=null, inetAddressValue=null}, 268435457=NXCPMessageField{id=268435457, type=1, integerValue=0, realValue=0.0, stringValue='2017;3;19', binaryValue=null, inetAddressValue=null}, 268435458=NXCPMessageField{id=268435458, type=1, integerValue=0, realValue=0.0, stringValue='PERIOD_START', binaryValue=null, inetAddressValue=null}, 34=NXCPMessageField{id=34, type=1, integerValue=0, realValue=0.0, stringValue='admin', binaryValue=null, inetAddressValue=null}, 268435459=NXCPMessageField{id=268435459, type=1, integerValue=0, realValue=0.0, stringValue='2017;3;19', binaryValue=null, inetAddressValue=null}, 35=NXCPMessageField{id=35, type=0, integerValue=0, realValue=0.0, stringValue='0', binaryValue=null, inetAddressValue=null}, 390=NXCPMessageField{id=390, type=4, integerValue=null, realValue=null, stringValue='null', binaryValue=[24, -78, -20, 86, -54, -58, 65, 10, -72, 110, -10, 79, -2, 73, 112, 77], inetAddressValue=null}, 137=NXCPMessageField{id=137, type=0, integerValue=2, realValue=2.0, stringValue='2', binaryValue=null, inetAddressValue=null}}, timestamp=0] 20:43:34.972 [Thread-13] DEBUG c.r.r.s.impl.QuartzReportScheduler - New job f2c190a9-76ea-4507-a81d-0616d255c3db for report 18b2ec56-cac6-410a-b86e-f64ffe49704d 20:43:34.973 [Thread-13] DEBUG o.q.i.jdbcjobstore.SimpleSemaphore - Lock 'TRIGGER_ACCESS' is desired by: Thread-13 20:43:34.973 [Thread-13] DEBUG o.q.i.jdbcjobstore.SimpleSemaphore - Lock 'TRIGGER_ACCESS' is being obtained: Thread-13 20:43:34.973 [Thread-13] DEBUG o.q.i.jdbcjobstore.SimpleSemaphore - Lock 'TRIGGER_ACCESS' given to: Thread-13 20:43:35.054 [Thread-13] DEBUG o.q.i.jdbcjobstore.SimpleSemaphore - Lock 'TRIGGER_ACCESS' retuned by: Thread-13 20:43:35.056 [Thread-13] DEBUG c.r.r.service.impl.SessionWorker - Reply: NXCPMessage [messageCode=29, messageFlags=0, messageId=693, variableMap={28=NXCPMessageField{id=28, type=0, integerValue=0, realValue=0.0, stringValue='0', binaryValue=null, inetAddressValue=null}, 331=NXCPMessageField{id=331, type=4, integerValue=0, realValue=0.0, stringValue='', binaryValue=[-14, -63, -112, -87, 118, -22, 69, 7, -88, 29, 6, 22, -46, 85, -61, -37], inetAddressValue=null}}, timestamp=0] 20:43:35.059 [Thread-13] DEBUG c.r.r.service.impl.SessionWorker - Request: NXCPMessage [messageCode=4355, messageFlags=0, messageId=694, variableMap={390=NXCPMessageField{id=390, type=4, integerValue=null, realValue=null, stringValue='null', binaryValue=[24, -78, -20, 86, -54, -58, 65, 10, -72, 110, -10, 79, -2, 73, 112, 77], inetAddressValue=null}, 34=NXCPMessageField{id=34, type=1, integerValue=0, realValue=0.0, stringValue='admin', binaryValue=null, inetAddressValue=null}, 35=NXCPMessageField{id=35, type=0, integerValue=0, realValue=0.0, stringValue='0', binaryValue=null, inetAddressValue=null}}, timestamp=0] 20:43:35.061 [Thread-13] DEBUG c.r.r.service.impl.SessionImpl - Loading report results for 18b2ec56-cac6-410a-b86e-f64ffe49704d (user=0) 20:43:35.061 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Creating new transaction with name [com.radensolutions.reporting.service.impl.ReportResultServiceImpl.list]: PROPAGATION_REQUIRED,ISOLATION_DEFAULT; '' 20:43:35.075 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Opened new Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] for Hibernate transaction 20:43:35.079 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Preparing JDBC Connection of Hibernate Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] 20:43:35.098 [Thread-13] DEBUG o.h.e.t.internal.TransactionImpl - begin 20:43:35.107 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Exposing Hibernate transaction as JDBC transaction [com.mchange.v2.c3p0.impl.NewProxyConnection@47b99e82] 20:43:35.108 [Thread-13] DEBUG org.hibernate.SQL - select reportresu0_.id as id1_1_, reportresu0_.executionTime as executio2_1_, reportresu0_.jobId as jobId3_1_, reportresu0_.reportId as reportId4_1_, reportresu0_.userId as userId5_1_ from reporting_results reportresu0_ where reportresu0_.reportId=? order by reportresu0_.executionTime desc Hibernate: select reportresu0_.id as id1_1_, reportresu0_.executionTime as executio2_1_, reportresu0_.jobId as jobId3_1_, reportresu0_.reportId as reportId4_1_, reportresu0_.userId as userId5_1_ from reporting_results reportresu0_ where reportresu0_.reportId=? order by reportresu0_.executionTime desc 20:43:35.127 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Initiating transaction commit 20:43:35.129 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Committing Hibernate transaction on Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] 20:43:35.131 [Thread-13] DEBUG o.h.e.t.internal.TransactionImpl - committing 20:43:35.133 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Closing Hibernate Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] after transaction 20:43:35.134 [Thread-13] DEBUG c.r.r.service.impl.SessionImpl - Got 0 records 20:43:35.137 [Thread-13] DEBUG c.r.r.service.impl.SessionWorker - Reply: NXCPMessage [messageCode=29, messageFlags=0, messageId=694, variableMap={28=NXCPMessageField{id=28, type=0, integerValue=0, realValue=0.0, stringValue='0', binaryValue=null, inetAddressValue=null}, 111=NXCPMessageField{id=111, type=0, integerValue=0, realValue=0.0, stringValue='0', binaryValue=null, inetAddressValue=null}}, timestamp=0] 20:43:35.137 [Thread-13] DEBUG c.r.r.service.impl.SessionWorker - Request: NXCPMessage [messageCode=4355, messageFlags=0, messageId=695, variableMap={390=NXCPMessageField{id=390, type=4, integerValue=null, realValue=null, stringValue='null', binaryValue=[24, -78, -20, 86, -54, -58, 65, 10, -72, 110, -10, 79, -2, 73, 112, 77], inetAddressValue=null}, 34=NXCPMessageField{id=34, type=1, integerValue=0, realValue=0.0, stringValue='admin', binaryValue=null, inetAddressValue=null}, 35=NXCPMessageField{id=35, type=0, integerValue=0, realValue=0.0, stringValue='0', binaryValue=null, inetAddressValue=null}}, timestamp=0] 20:43:35.138 [Thread-13] DEBUG c.r.r.service.impl.SessionImpl - Loading report results for 18b2ec56-cac6-410a-b86e-f64ffe49704d (user=0) 20:43:35.138 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Creating new transaction with name [com.radensolutions.reporting.service.impl.ReportResultServiceImpl.list]: PROPAGATION_REQUIRED,ISOLATION_DEFAULT; '' 20:43:35.139 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Opened new Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] for Hibernate transaction 20:43:35.141 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Preparing JDBC Connection of Hibernate Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] 20:43:35.144 [Thread-13] DEBUG o.h.e.t.internal.TransactionImpl - begin 20:43:35.144 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Exposing Hibernate transaction as JDBC transaction [com.mchange.v2.c3p0.impl.NewProxyConnection@7fefb4d7] 20:43:35.144 [Thread-13] DEBUG org.hibernate.SQL - select reportresu0_.id as id1_1_, reportresu0_.executionTime as executio2_1_, reportresu0_.jobId as jobId3_1_, reportresu0_.reportId as reportId4_1_, reportresu0_.userId as userId5_1_ from reporting_results reportresu0_ where reportresu0_.reportId=? order by reportresu0_.executionTime desc Hibernate: select reportresu0_.id as id1_1_, reportresu0_.executionTime as executio2_1_, reportresu0_.jobId as jobId3_1_, reportresu0_.reportId as reportId4_1_, reportresu0_.userId as userId5_1_ from reporting_results reportresu0_ where reportresu0_.reportId=? order by reportresu0_.executionTime desc 20:43:35.146 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Initiating transaction commit 20:43:35.146 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Committing Hibernate transaction on Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] 20:43:35.147 [Thread-13] DEBUG o.h.e.t.internal.TransactionImpl - committing 20:43:35.147 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Closing Hibernate Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] after transaction 20:43:35.147 [Thread-13] DEBUG c.r.r.service.impl.SessionImpl - Got 0 records 20:43:35.148 [Thread-13] DEBUG c.r.r.service.impl.SessionWorker - Reply: NXCPMessage [messageCode=29, messageFlags=0, messageId=695, variableMap={28=NXCPMessageField{id=28, type=0, integerValue=0, realValue=0.0, stringValue='0', binaryValue=null, inetAddressValue=null}, 111=NXCPMessageField{id=111, type=0, integerValue=0, realValue=0.0, stringValue='0', binaryValue=null, inetAddressValue=null}}, timestamp=0] 20:43:35.148 [Thread-13] DEBUG c.r.r.service.impl.SessionWorker - Request: NXCPMessage [messageCode=4355, messageFlags=0, messageId=696, variableMap={390=NXCPMessageField{id=390, type=4, integerValue=null, realValue=null, stringValue='null', binaryValue=[24, -78, -20, 86, -54, -58, 65, 10, -72, 110, -10, 79, -2, 73, 112, 77], inetAddressValue=null}, 34=NXCPMessageField{id=34, type=1, integerValue=0, realValue=0.0, stringValue='admin', binaryValue=null, inetAddressValue=null}, 35=NXCPMessageField{id=35, type=0, integerValue=0, realValue=0.0, stringValue='0', binaryValue=null, inetAddressValue=null}}, timestamp=0] 20:43:35.148 [Thread-13] DEBUG c.r.r.service.impl.SessionImpl - Loading report results for 18b2ec56-cac6-410a-b86e-f64ffe49704d (user=0) 20:43:35.149 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Creating new transaction with name [com.radensolutions.reporting.service.impl.ReportResultServiceImpl.list]: PROPAGATION_REQUIRED,ISOLATION_DEFAULT; '' 20:43:35.149 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Opened new Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] for Hibernate transaction 20:43:35.149 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Preparing JDBC Connection of Hibernate Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] 20:43:35.153 [Thread-13] DEBUG o.h.e.t.internal.TransactionImpl - begin 20:43:35.156 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Exposing Hibernate transaction as JDBC transaction [com.mchange.v2.c3p0.impl.NewProxyConnection@23dcd38c] 20:43:35.156 [Thread-13] DEBUG org.hibernate.SQL - select reportresu0_.id as id1_1_, reportresu0_.executionTime as executio2_1_, reportresu0_.jobId as jobId3_1_, reportresu0_.reportId as reportId4_1_, reportresu0_.userId as userId5_1_ from reporting_results reportresu0_ where reportresu0_.reportId=? order by reportresu0_.executionTime desc Hibernate: select reportresu0_.id as id1_1_, reportresu0_.executionTime as executio2_1_, reportresu0_.jobId as jobId3_1_, reportresu0_.reportId as reportId4_1_, reportresu0_.userId as userId5_1_ from reporting_results reportresu0_ where reportresu0_.reportId=? order by reportresu0_.executionTime desc 20:43:35.158 [quartzScheduler_QuartzSchedulerThread] DEBUG o.quartz.core.QuartzSchedulerThread - batch acquisition of 1 triggers 20:43:35.167 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Initiating transaction commit 20:43:35.168 [quartzScheduler_QuartzSchedulerThread] DEBUG o.q.i.jdbcjobstore.SimpleSemaphore - Lock 'TRIGGER_ACCESS' is desired by: quartzScheduler_QuartzSchedulerThread 20:43:35.169 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Committing Hibernate transaction on Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] 20:43:35.169 [quartzScheduler_QuartzSchedulerThread] DEBUG o.q.i.jdbcjobstore.SimpleSemaphore - Lock 'TRIGGER_ACCESS' is being obtained: quartzScheduler_QuartzSchedulerThread 20:43:35.170 [Thread-13] DEBUG o.h.e.t.internal.TransactionImpl - committing 20:43:35.170 [quartzScheduler_QuartzSchedulerThread] DEBUG o.q.i.jdbcjobstore.SimpleSemaphore - Lock 'TRIGGER_ACCESS' given to: quartzScheduler_QuartzSchedulerThread 20:43:35.171 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Closing Hibernate Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] after transaction 20:43:35.171 [Thread-13] DEBUG c.r.r.service.impl.SessionImpl - Got 0 records 20:43:35.172 [Thread-13] DEBUG c.r.r.service.impl.SessionWorker - Reply: NXCPMessage [messageCode=29, messageFlags=0, messageId=696, variableMap={28=NXCPMessageField{id=28, type=0, integerValue=0, realValue=0.0, stringValue='0', binaryValue=null, inetAddressValue=null}, 111=NXCPMessageField{id=111, type=0, integerValue=0, realValue=0.0, stringValue='0', binaryValue=null, inetAddressValue=null}}, timestamp=0] 20:43:35.172 [Thread-13] DEBUG c.r.r.service.impl.SessionWorker - Request: NXCPMessage [messageCode=4355, messageFlags=0, messageId=697, variableMap={390=NXCPMessageField{id=390, type=4, integerValue=null, realValue=null, stringValue='null', binaryValue=[24, -78, -20, 86, -54, -58, 65, 10, -72, 110, -10, 79, -2, 73, 112, 77], inetAddressValue=null}, 34=NXCPMessageField{id=34, type=1, integerValue=0, realValue=0.0, stringValue='admin', binaryValue=null, inetAddressValue=null}, 35=NXCPMessageField{id=35, type=0, integerValue=0, realValue=0.0, stringValue='0', binaryValue=null, inetAddressValue=null}}, timestamp=0] 20:43:35.173 [Thread-13] DEBUG c.r.r.service.impl.SessionImpl - Loading report results for 18b2ec56-cac6-410a-b86e-f64ffe49704d (user=0) 20:43:35.178 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Creating new transaction with name [com.radensolutions.reporting.service.impl.ReportResultServiceImpl.list]: PROPAGATION_REQUIRED,ISOLATION_DEFAULT; '' 20:43:35.186 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Opened new Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] for Hibernate transaction 20:43:35.187 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Preparing JDBC Connection of Hibernate Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] 20:43:35.192 [Thread-13] DEBUG o.h.e.t.internal.TransactionImpl - begin 20:43:35.193 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Exposing Hibernate transaction as JDBC transaction [com.mchange.v2.c3p0.impl.NewProxyConnection@2b47bde7] 20:43:35.196 [Thread-13] DEBUG org.hibernate.SQL - select reportresu0_.id as id1_1_, reportresu0_.executionTime as executio2_1_, reportresu0_.jobId as jobId3_1_, reportresu0_.reportId as reportId4_1_, reportresu0_.userId as userId5_1_ from reporting_results reportresu0_ where reportresu0_.reportId=? order by reportresu0_.executionTime desc Hibernate: select reportresu0_.id as id1_1_, reportresu0_.executionTime as executio2_1_, reportresu0_.jobId as jobId3_1_, reportresu0_.reportId as reportId4_1_, reportresu0_.userId as userId5_1_ from reporting_results reportresu0_ where reportresu0_.reportId=? order by reportresu0_.executionTime desc 20:43:35.201 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Initiating transaction commit 20:43:35.203 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Committing Hibernate transaction on Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] 20:43:35.204 [Thread-13] DEBUG o.h.e.t.internal.TransactionImpl - committing 20:43:35.206 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Closing Hibernate Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] after transaction 20:43:35.207 [Thread-13] DEBUG c.r.r.service.impl.SessionImpl - Got 0 records 20:43:35.208 [Thread-13] DEBUG c.r.r.service.impl.SessionWorker - Reply: NXCPMessage [messageCode=29, messageFlags=0, messageId=697, variableMap={28=NXCPMessageField{id=28, type=0, integerValue=0, realValue=0.0, stringValue='0', binaryValue=null, inetAddressValue=null}, 111=NXCPMessageField{id=111, type=0, integerValue=0, realValue=0.0, stringValue='0', binaryValue=null, inetAddressValue=null}}, timestamp=0] 20:43:35.211 [Thread-13] DEBUG c.r.r.service.impl.SessionWorker - Request: NXCPMessage [messageCode=4355, messageFlags=0, messageId=698, variableMap={390=NXCPMessageField{id=390, type=4, integerValue=null, realValue=null, stringValue='null', binaryValue=[24, -78, -20, 86, -54, -58, 65, 10, -72, 110, -10, 79, -2, 73, 112, 77], inetAddressValue=null}, 34=NXCPMessageField{id=34, type=1, integerValue=0, realValue=0.0, stringValue='admin', binaryValue=null, inetAddressValue=null}, 35=NXCPMessageField{id=35, type=0, integerValue=0, realValue=0.0, stringValue='0', binaryValue=null, inetAddressValue=null}}, timestamp=0] 20:43:35.214 [Thread-13] DEBUG c.r.r.service.impl.SessionImpl - Loading report results for 18b2ec56-cac6-410a-b86e-f64ffe49704d (user=0) 20:43:35.219 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Creating new transaction with name [com.radensolutions.reporting.service.impl.ReportResultServiceImpl.list]: PROPAGATION_REQUIRED,ISOLATION_DEFAULT; '' 20:43:35.220 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Opened new Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] for Hibernate transaction 20:43:35.221 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Preparing JDBC Connection of Hibernate Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] 20:43:35.224 [Thread-13] DEBUG o.h.e.t.internal.TransactionImpl - begin 20:43:35.230 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Exposing Hibernate transaction as JDBC transaction [com.mchange.v2.c3p0.impl.NewProxyConnection@3744c268] 20:43:35.231 [Thread-13] DEBUG org.hibernate.SQL - select reportresu0_.id as id1_1_, reportresu0_.executionTime as executio2_1_, reportresu0_.jobId as jobId3_1_, reportresu0_.reportId as reportId4_1_, reportresu0_.userId as userId5_1_ from reporting_results reportresu0_ where reportresu0_.reportId=? order by reportresu0_.executionTime desc Hibernate: select reportresu0_.id as id1_1_, reportresu0_.executionTime as executio2_1_, reportresu0_.jobId as jobId3_1_, reportresu0_.reportId as reportId4_1_, reportresu0_.userId as userId5_1_ from reporting_results reportresu0_ where reportresu0_.reportId=? order by reportresu0_.executionTime desc 20:43:35.236 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Initiating transaction commit 20:43:35.236 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Committing Hibernate transaction on Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] 20:43:35.236 [Thread-13] DEBUG o.h.e.t.internal.TransactionImpl - committing 20:43:35.237 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Closing Hibernate Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] after transaction 20:43:35.237 [Thread-13] DEBUG c.r.r.service.impl.SessionImpl - Got 0 records 20:43:35.238 [Thread-13] DEBUG c.r.r.service.impl.SessionWorker - Reply: NXCPMessage [messageCode=29, messageFlags=0, messageId=698, variableMap={28=NXCPMessageField{id=28, type=0, integerValue=0, realValue=0.0, stringValue='0', binaryValue=null, inetAddressValue=null}, 111=NXCPMessageField{id=111, type=0, integerValue=0, realValue=0.0, stringValue='0', binaryValue=null, inetAddressValue=null}}, timestamp=0] 20:43:35.239 [Thread-13] DEBUG c.r.r.service.impl.SessionWorker - Request: NXCPMessage [messageCode=4355, messageFlags=0, messageId=699, variableMap={390=NXCPMessageField{id=390, type=4, integerValue=null, realValue=null, stringValue='null', binaryValue=[24, -78, -20, 86, -54, -58, 65, 10, -72, 110, -10, 79, -2, 73, 112, 77], inetAddressValue=null}, 34=NXCPMessageField{id=34, type=1, integerValue=0, realValue=0.0, stringValue='admin', binaryValue=null, inetAddressValue=null}, 35=NXCPMessageField{id=35, type=0, integerValue=0, realValue=0.0, stringValue='0', binaryValue=null, inetAddressValue=null}}, timestamp=0] 20:43:35.242 [Thread-13] DEBUG c.r.r.service.impl.SessionImpl - Loading report results for 18b2ec56-cac6-410a-b86e-f64ffe49704d (user=0) 20:43:35.251 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Creating new transaction with name [com.radensolutions.reporting.service.impl.ReportResultServiceImpl.list]: PROPAGATION_REQUIRED,ISOLATION_DEFAULT; '' 20:43:35.257 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Opened new Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] for Hibernate transaction 20:43:35.259 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Preparing JDBC Connection of Hibernate Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] 20:43:35.263 [Thread-13] DEBUG o.h.e.t.internal.TransactionImpl - begin 20:43:35.263 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Exposing Hibernate transaction as JDBC transaction [com.mchange.v2.c3p0.impl.NewProxyConnection@fe3227a] 20:43:35.264 [Thread-13] DEBUG org.hibernate.SQL - select reportresu0_.id as id1_1_, reportresu0_.executionTime as executio2_1_, reportresu0_.jobId as jobId3_1_, reportresu0_.reportId as reportId4_1_, reportresu0_.userId as userId5_1_ from reporting_results reportresu0_ where reportresu0_.reportId=? order by reportresu0_.executionTime desc Hibernate: select reportresu0_.id as id1_1_, reportresu0_.executionTime as executio2_1_, reportresu0_.jobId as jobId3_1_, reportresu0_.reportId as reportId4_1_, reportresu0_.userId as userId5_1_ from reporting_results reportresu0_ where reportresu0_.reportId=? order by reportresu0_.executionTime desc 20:43:35.266 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Initiating transaction commit 20:43:35.268 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Committing Hibernate transaction on Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] 20:43:35.268 [Thread-13] DEBUG o.h.e.t.internal.TransactionImpl - committing 20:43:35.268 [quartzScheduler_QuartzSchedulerThread] DEBUG o.q.i.jdbcjobstore.SimpleSemaphore - Lock 'TRIGGER_ACCESS' retuned by: quartzScheduler_QuartzSchedulerThread 20:43:35.270 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Closing Hibernate Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] after transaction 20:43:35.270 [Thread-13] DEBUG c.r.r.service.impl.SessionImpl - Got 0 records 20:43:35.270 [Thread-13] DEBUG c.r.r.service.impl.SessionWorker - Reply: NXCPMessage [messageCode=29, messageFlags=0, messageId=699, variableMap={28=NXCPMessageField{id=28, type=0, integerValue=0, realValue=0.0, stringValue='0', binaryValue=null, inetAddressValue=null}, 111=NXCPMessageField{id=111, type=0, integerValue=0, realValue=0.0, stringValue='0', binaryValue=null, inetAddressValue=null}}, timestamp=0] 20:43:35.271 [quartzScheduler_QuartzSchedulerThread] DEBUG o.s.b.f.annotation.InjectionMetadata - Processing injected element of bean 'com.radensolutions.reporting.job.GeneratorJob': AutowiredFieldElement for private com.radensolutions.reporting.service.ReportManager com.radensolutions.reporting.job.GeneratorJob.reportManager 20:43:35.271 [Thread-13] DEBUG c.r.r.service.impl.SessionWorker - Request: NXCPMessage [messageCode=4355, messageFlags=0, messageId=700, variableMap={390=NXCPMessageField{id=390, type=4, integerValue=null, realValue=null, stringValue='null', binaryValue=[24, -78, -20, 86, -54, -58, 65, 10, -72, 110, -10, 79, -2, 73, 112, 77], inetAddressValue=null}, 34=NXCPMessageField{id=34, type=1, integerValue=0, realValue=0.0, stringValue='admin', binaryValue=null, inetAddressValue=null}, 35=NXCPMessageField{id=35, type=0, integerValue=0, realValue=0.0, stringValue='0', binaryValue=null, inetAddressValue=null}}, timestamp=0] 20:43:35.271 [quartzScheduler_QuartzSchedulerThread] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'reportManager' 20:43:35.272 [Thread-13] DEBUG c.r.r.service.impl.SessionImpl - Loading report results for 18b2ec56-cac6-410a-b86e-f64ffe49704d (user=0) 20:43:35.272 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Creating new transaction with name [com.radensolutions.reporting.service.impl.ReportResultServiceImpl.list]: PROPAGATION_REQUIRED,ISOLATION_DEFAULT; '' 20:43:35.272 [quartzScheduler_Worker-2] DEBUG org.quartz.core.JobRunShell - Calling execute on job 18b2ec56-cac6-410a-b86e-f64ffe49704d.f2c190a9-76ea-4507-a81d-0616d255c3db 20:43:35.273 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Opened new Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] for Hibernate transaction 20:43:35.273 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Preparing JDBC Connection of Hibernate Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] 20:43:35.273 [quartzScheduler_QuartzSchedulerThread] DEBUG o.quartz.core.QuartzSchedulerThread - batch acquisition of 0 triggers 20:43:35.277 [Thread-13] DEBUG o.h.e.t.internal.TransactionImpl - begin 20:43:35.278 [quartzScheduler_Worker-2] DEBUG o.s.b.f.s.DefaultListableBeanFactory - Returning cached instance of singleton bean 'report' 20:43:35.280 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Exposing Hibernate transaction as JDBC transaction [com.mchange.v2.c3p0.impl.NewProxyConnection@12c0d99c] 20:43:35.284 [Thread-13] DEBUG org.hibernate.SQL - select reportresu0_.id as id1_1_, reportresu0_.executionTime as executio2_1_, reportresu0_.jobId as jobId3_1_, reportresu0_.reportId as reportId4_1_, reportresu0_.userId as userId5_1_ from reporting_results reportresu0_ where reportresu0_.reportId=? order by reportresu0_.executionTime desc Hibernate: select reportresu0_.id as id1_1_, reportresu0_.executionTime as executio2_1_, reportresu0_.jobId as jobId3_1_, reportresu0_.reportId as reportId4_1_, reportresu0_.userId as userId5_1_ from reporting_results reportresu0_ where reportresu0_.reportId=? order by reportresu0_.executionTime desc 20:43:35.292 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Initiating transaction commit 20:43:35.293 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Committing Hibernate transaction on Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] 20:43:35.294 [Thread-13] DEBUG o.h.e.t.internal.TransactionImpl - committing 20:43:35.295 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Closing Hibernate Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] after transaction 20:43:35.295 [Thread-13] DEBUG c.r.r.service.impl.SessionImpl - Got 0 records 20:43:35.295 [Thread-13] DEBUG c.r.r.service.impl.SessionWorker - Reply: NXCPMessage [messageCode=29, messageFlags=0, messageId=700, variableMap={28=NXCPMessageField{id=28, type=0, integerValue=0, realValue=0.0, stringValue='0', binaryValue=null, inetAddressValue=null}, 111=NXCPMessageField{id=111, type=0, integerValue=0, realValue=0.0, stringValue='0', binaryValue=null, inetAddressValue=null}}, timestamp=0] 20:43:35.295 [Thread-13] DEBUG c.r.r.service.impl.SessionWorker - Request: NXCPMessage [messageCode=4355, messageFlags=0, messageId=701, variableMap={390=NXCPMessageField{id=390, type=4, integerValue=null, realValue=null, stringValue='null', binaryValue=[24, -78, -20, 86, -54, -58, 65, 10, -72, 110, -10, 79, -2, 73, 112, 77], inetAddressValue=null}, 34=NXCPMessageField{id=34, type=1, integerValue=0, realValue=0.0, stringValue='admin', binaryValue=null, inetAddressValue=null}, 35=NXCPMessageField{id=35, type=0, integerValue=0, realValue=0.0, stringValue='0', binaryValue=null, inetAddressValue=null}}, timestamp=0] 20:43:35.296 [Thread-13] DEBUG c.r.r.service.impl.SessionImpl - Loading report results for 18b2ec56-cac6-410a-b86e-f64ffe49704d (user=0) 20:43:35.296 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Creating new transaction with name [com.radensolutions.reporting.service.impl.ReportResultServiceImpl.list]: PROPAGATION_REQUIRED,ISOLATION_DEFAULT; '' 20:43:35.296 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Opened new Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] for Hibernate transaction 20:43:35.296 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Preparing JDBC Connection of Hibernate Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] 20:43:35.299 [Thread-13] DEBUG o.h.e.t.internal.TransactionImpl - begin 20:43:35.299 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Exposing Hibernate transaction as JDBC transaction [com.mchange.v2.c3p0.impl.NewProxyConnection@7a554d98] 20:43:35.300 [Thread-13] DEBUG org.hibernate.SQL - select reportresu0_.id as id1_1_, reportresu0_.executionTime as executio2_1_, reportresu0_.jobId as jobId3_1_, reportresu0_.reportId as reportId4_1_, reportresu0_.userId as userId5_1_ from reporting_results reportresu0_ where reportresu0_.reportId=? order by reportresu0_.executionTime desc Hibernate: select reportresu0_.id as id1_1_, reportresu0_.executionTime as executio2_1_, reportresu0_.jobId as jobId3_1_, reportresu0_.reportId as reportId4_1_, reportresu0_.userId as userId5_1_ from reporting_results reportresu0_ where reportresu0_.reportId=? order by reportresu0_.executionTime desc 20:43:35.306 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Initiating transaction commit 20:43:35.312 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Committing Hibernate transaction on Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] 20:43:35.314 [Thread-13] DEBUG o.h.e.t.internal.TransactionImpl - committing 20:43:35.319 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Closing Hibernate Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] after transaction 20:43:35.319 [Thread-13] DEBUG c.r.r.service.impl.SessionImpl - Got 0 records 20:43:35.319 [Thread-13] DEBUG c.r.r.service.impl.SessionWorker - Reply: NXCPMessage [messageCode=29, messageFlags=0, messageId=701, variableMap={28=NXCPMessageField{id=28, type=0, integerValue=0, realValue=0.0, stringValue='0', binaryValue=null, inetAddressValue=null}, 111=NXCPMessageField{id=111, type=0, integerValue=0, realValue=0.0, stringValue='0', binaryValue=null, inetAddressValue=null}}, timestamp=0] 20:43:35.319 [Thread-13] DEBUG c.r.r.service.impl.SessionWorker - Request: NXCPMessage [messageCode=4355, messageFlags=0, messageId=702, variableMap={390=NXCPMessageField{id=390, type=4, integerValue=null, realValue=null, stringValue='null', binaryValue=[24, -78, -20, 86, -54, -58, 65, 10, -72, 110, -10, 79, -2, 73, 112, 77], inetAddressValue=null}, 34=NXCPMessageField{id=34, type=1, integerValue=0, realValue=0.0, stringValue='admin', binaryValue=null, inetAddressValue=null}, 35=NXCPMessageField{id=35, type=0, integerValue=0, realValue=0.0, stringValue='0', binaryValue=null, inetAddressValue=null}}, timestamp=0] 20:43:35.320 [Thread-13] DEBUG c.r.r.service.impl.SessionImpl - Loading report results for 18b2ec56-cac6-410a-b86e-f64ffe49704d (user=0) 20:43:35.320 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Creating new transaction with name [com.radensolutions.reporting.service.impl.ReportResultServiceImpl.list]: PROPAGATION_REQUIRED,ISOLATION_DEFAULT; '' 20:43:35.321 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Opened new Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] for Hibernate transaction 20:43:35.321 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Preparing JDBC Connection of Hibernate Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] 20:43:35.324 [Thread-13] DEBUG o.h.e.t.internal.TransactionImpl - begin 20:43:35.326 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Exposing Hibernate transaction as JDBC transaction [com.mchange.v2.c3p0.impl.NewProxyConnection@7ea7a968] 20:43:35.326 [Thread-13] DEBUG org.hibernate.SQL - select reportresu0_.id as id1_1_, reportresu0_.executionTime as executio2_1_, reportresu0_.jobId as jobId3_1_, reportresu0_.reportId as reportId4_1_, reportresu0_.userId as userId5_1_ from reporting_results reportresu0_ where reportresu0_.reportId=? order by reportresu0_.executionTime desc Hibernate: select reportresu0_.id as id1_1_, reportresu0_.executionTime as executio2_1_, reportresu0_.jobId as jobId3_1_, reportresu0_.reportId as reportId4_1_, reportresu0_.userId as userId5_1_ from reporting_results reportresu0_ where reportresu0_.reportId=? order by reportresu0_.executionTime desc 20:43:35.329 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Initiating transaction commit 20:43:35.329 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Committing Hibernate transaction on Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] 20:43:35.329 [Thread-13] DEBUG o.h.e.t.internal.TransactionImpl - committing 20:43:35.330 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Closing Hibernate Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] after transaction 20:43:35.330 [Thread-13] DEBUG c.r.r.service.impl.SessionImpl - Got 0 records 20:43:35.330 [Thread-13] DEBUG c.r.r.service.impl.SessionWorker - Reply: NXCPMessage [messageCode=29, messageFlags=0, messageId=702, variableMap={28=NXCPMessageField{id=28, type=0, integerValue=0, realValue=0.0, stringValue='0', binaryValue=null, inetAddressValue=null}, 111=NXCPMessageField{id=111, type=0, integerValue=0, realValue=0.0, stringValue='0', binaryValue=null, inetAddressValue=null}}, timestamp=0] 20:43:35.331 [Thread-13] DEBUG c.r.r.service.impl.SessionWorker - Request: NXCPMessage [messageCode=4355, messageFlags=0, messageId=703, variableMap={390=NXCPMessageField{id=390, type=4, integerValue=null, realValue=null, stringValue='null', binaryValue=[24, -78, -20, 86, -54, -58, 65, 10, -72, 110, -10, 79, -2, 73, 112, 77], inetAddressValue=null}, 34=NXCPMessageField{id=34, type=1, integerValue=0, realValue=0.0, stringValue='admin', binaryValue=null, inetAddressValue=null}, 35=NXCPMessageField{id=35, type=0, integerValue=0, realValue=0.0, stringValue='0', binaryValue=null, inetAddressValue=null}}, timestamp=0] 20:43:35.331 [Thread-13] DEBUG c.r.r.service.impl.SessionImpl - Loading report results for 18b2ec56-cac6-410a-b86e-f64ffe49704d (user=0) 20:43:35.332 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Creating new transaction with name [com.radensolutions.reporting.service.impl.ReportResultServiceImpl.list]: PROPAGATION_REQUIRED,ISOLATION_DEFAULT; '' 20:43:35.332 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Opened new Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] for Hibernate transaction 20:43:35.332 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Preparing JDBC Connection of Hibernate Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] 20:43:35.335 [Thread-13] DEBUG o.h.e.t.internal.TransactionImpl - begin 20:43:35.338 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Exposing Hibernate transaction as JDBC transaction [com.mchange.v2.c3p0.impl.NewProxyConnection@300344a4] 20:43:35.338 [Thread-13] DEBUG org.hibernate.SQL - select reportresu0_.id as id1_1_, reportresu0_.executionTime as executio2_1_, reportresu0_.jobId as jobId3_1_, reportresu0_.reportId as reportId4_1_, reportresu0_.userId as userId5_1_ from reporting_results reportresu0_ where reportresu0_.reportId=? order by reportresu0_.executionTime desc Hibernate: select reportresu0_.id as id1_1_, reportresu0_.executionTime as executio2_1_, reportresu0_.jobId as jobId3_1_, reportresu0_.reportId as reportId4_1_, reportresu0_.userId as userId5_1_ from reporting_results reportresu0_ where reportresu0_.reportId=? order by reportresu0_.executionTime desc 20:43:35.352 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Initiating transaction commit 20:43:35.352 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Committing Hibernate transaction on Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] 20:43:35.353 [Thread-13] DEBUG o.h.e.t.internal.TransactionImpl - committing 20:43:35.353 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Closing Hibernate Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] after transaction 20:43:35.354 [Thread-13] DEBUG c.r.r.service.impl.SessionImpl - Got 0 records 20:43:35.354 [Thread-13] DEBUG c.r.r.service.impl.SessionWorker - Reply: NXCPMessage [messageCode=29, messageFlags=0, messageId=703, variableMap={28=NXCPMessageField{id=28, type=0, integerValue=0, realValue=0.0, stringValue='0', binaryValue=null, inetAddressValue=null}, 111=NXCPMessageField{id=111, type=0, integerValue=0, realValue=0.0, stringValue='0', binaryValue=null, inetAddressValue=null}}, timestamp=0] 20:43:36.308 [Thread-13] DEBUG c.r.r.service.impl.SessionWorker - Request: NXCPMessage [messageCode=4355, messageFlags=0, messageId=705, variableMap={390=NXCPMessageField{id=390, type=4, integerValue=null, realValue=null, stringValue='null', binaryValue=[24, -78, -20, 86, -54, -58, 65, 10, -72, 110, -10, 79, -2, 73, 112, 77], inetAddressValue=null}, 34=NXCPMessageField{id=34, type=1, integerValue=0, realValue=0.0, stringValue='admin', binaryValue=null, inetAddressValue=null}, 35=NXCPMessageField{id=35, type=0, integerValue=0, realValue=0.0, stringValue='0', binaryValue=null, inetAddressValue=null}}, timestamp=0] 20:43:36.308 [Thread-13] DEBUG c.r.r.service.impl.SessionImpl - Loading report results for 18b2ec56-cac6-410a-b86e-f64ffe49704d (user=0) 20:43:36.310 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Creating new transaction with name [com.radensolutions.reporting.service.impl.ReportResultServiceImpl.list]: PROPAGATION_REQUIRED,ISOLATION_DEFAULT; '' 20:43:36.310 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Opened new Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] for Hibernate transaction 20:43:36.312 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Preparing JDBC Connection of Hibernate Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] 20:43:36.314 [Thread-13] DEBUG o.h.e.t.internal.TransactionImpl - begin 20:43:36.314 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Exposing Hibernate transaction as JDBC transaction [com.mchange.v2.c3p0.impl.NewProxyConnection@24cd2025] 20:43:36.314 [Thread-13] DEBUG org.hibernate.SQL - select reportresu0_.id as id1_1_, reportresu0_.executionTime as executio2_1_, reportresu0_.jobId as jobId3_1_, reportresu0_.reportId as reportId4_1_, reportresu0_.userId as userId5_1_ from reporting_results reportresu0_ where reportresu0_.reportId=? order by reportresu0_.executionTime desc Hibernate: select reportresu0_.id as id1_1_, reportresu0_.executionTime as executio2_1_, reportresu0_.jobId as jobId3_1_, reportresu0_.reportId as reportId4_1_, reportresu0_.userId as userId5_1_ from reporting_results reportresu0_ where reportresu0_.reportId=? order by reportresu0_.executionTime desc 20:43:36.316 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Initiating transaction commit 20:43:36.316 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Committing Hibernate transaction on Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] 20:43:36.317 [Thread-13] DEBUG o.h.e.t.internal.TransactionImpl - committing 20:43:36.317 [Thread-13] DEBUG o.s.o.h.HibernateTransactionManager - Closing Hibernate Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] after transaction 20:43:36.317 [Thread-13] DEBUG c.r.r.service.impl.SessionImpl - Got 0 records 20:43:36.318 [Thread-13] DEBUG c.r.r.service.impl.SessionWorker - Reply: NXCPMessage [messageCode=29, messageFlags=0, messageId=705, variableMap={28=NXCPMessageField{id=28, type=0, integerValue=0, realValue=0.0, stringValue='0', binaryValue=null, inetAddressValue=null}, 111=NXCPMessageField{id=111, type=0, integerValue=0, realValue=0.0, stringValue='0', binaryValue=null, inetAddressValue=null}}, timestamp=0] 20:43:40.123 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.BaseReportFiller - Fill 1: created for Alarm Resolution Time 20:43:40.125 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.BaseReportFiller - created delayed actions 1 for filler 1 20:43:40.142 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRFillBand - Origin {reportName: null, groupName: null,bandType: BACKGROUND} for band 1023132022 20:43:40.143 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRFillDatasetRun - init return values 20:43:40.144 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRFillBand - Origin {reportName: null, groupName: null,bandType: TITLE} for band 390885732 20:43:40.147 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRFillBand - Origin {reportName: null, groupName: null,bandType: COLUMN_HEADER} for band 1230140331 20:43:40.150 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRFillBand - Origin {reportName: null, groupName: null,bandType: DETAIL} for band 521776201 20:43:40.152 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRFillBand - Origin {reportName: null, groupName: null,bandType: PAGE_FOOTER} for band 1684598049 20:43:40.153 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRVerticalFiller - Filler 1 - pageHeight: 595, columnFooterOffsetY: 558, lastPageColumnFooterOffsetY: 575 20:43:40.154 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRBaseFiller - Fill 1: filling report 20:43:40.156 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRFillDataset - Fill 1: Creating SQL query executer 20:43:40.157 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - DB is Microsoft SQL Server version 13.00.4001 (13/0) 20:43:40.161 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - driver is Microsoft JDBC Driver 4.0 for SQL Server version 4.0.2206.100 (4/0) 20:43:40.162 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - jdbc 4/0 20:43:40.162 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - connection URL is jdbc:sqlserver://localhost\sql2016:1433;authenticationScheme=nativeAuthentication;xopenStates=false;sendTimeAsDatetime=true;trustServerCertificate=false;sendStringParametersAsUnicode=true;selectMethod=direct;responseBuffering=adaptive;packetSize=8000;multiSubnetFailover=false;loginTimeout=15;lockTimeout=-1;lastUpdateCount=true;encrypt=false;disableStatementPooling=true;databaseName=NetXMS_DB;applicationName=Microsoft JDBC Driver for SQL Server;applicationIntent=readwrite; 20:43:40.163 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - system timezone is sun.util.calendar.ZoneInfo[id="Asia/Muscat",offset=14400000,dstSavings=0,useDaylight=false,transitions=3,lastRule=null] 20:43:40.163 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - report timezone is sun.util.calendar.ZoneInfo[id="Asia/Muscat",offset=14400000,dstSavings=0,useDaylight=false,transitions=3,lastRule=null] 20:43:40.164 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - JDBC timezone parameter is null 20:43:40.164 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - JDBC timezone property is null 20:43:40.164 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - JDBC parameters timezone parameter is null 20:43:40.165 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - JDBC parameters timezone property is null 20:43:40.165 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - parameters timezone null 20:43:40.166 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - JDBC fields timezone parameter is null 20:43:40.166 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - JDBC fields timezone property is null 20:43:40.171 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - fields timezone null 20:43:40.175 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - SQL query string: SELECT a.creation_time AS created, a.last_change_time - a.creation_time AS resolveTime, op.name AS source, e.event_name AS event, a.message AS message, CASE WHEN a.current_severity = 0 THEN 'Normal' WHEN a.current_severity = 1 THEN 'Warning' WHEN a.current_severity = 2 THEN 'Minor' WHEN a.current_severity = 3 THEN 'Major' WHEN a.current_severity = 4 THEN 'Critical' ELSE 'Unknown' END AS severity, u1.name AS resolvedBy, u2.name AS terminatedBy FROM alarms a LEFT JOIN object_properties op ON a.source_object_id=object_id LEFT JOIN event_cfg e ON a.source_event_code = event_code LEFT JOIN users u1 ON a.resolved_by=u1.id LEFT JOIN users u2 ON a.term_by=u2.id WHERE a.creation_time BETWEEN ? AND ? AND (alarm_state & 15) IN (2, 3) order by resolveTime DESC 20:43:40.181 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - Parameter #1 (PERIOD_START of type java.lang.Long): 1489867200 20:43:40.182 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - Parameter #2 (PERIOD_END of type java.lang.Long): 1489953599 20:43:40.189 [quartzScheduler_Worker-2] DEBUG n.s.j.e.util.DeduplicableRegistry - Added object net.sf.jasperreports.engine.base.JRBaseStyle@5188f0de 20:43:40.192 [quartzScheduler_Worker-2] DEBUG n.s.j.e.util.DeduplicableRegistry - Added object net.sf.jasperreports.engine.base.JRBaseStyle@7e1ac39f 20:43:40.194 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.JRResultSetDataSource - field created has type 4/int, class java.lang.Integer 20:43:40.194 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.JRResultSetDataSource - field resolvetime has type 4/int, class java.lang.Integer 20:43:40.195 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.JRResultSetDataSource - field source has type 12/varchar, class java.lang.String 20:43:40.195 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.JRResultSetDataSource - field event has type 12/varchar, class java.lang.String 20:43:40.195 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.JRResultSetDataSource - field message has type 12/varchar, class java.lang.String 20:43:40.196 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.JRResultSetDataSource - field severity has type 12/varchar, class java.lang.String 20:43:40.196 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.JRResultSetDataSource - field terminatedby has type 12/varchar, class java.lang.String 20:43:40.197 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.JRResultSetDataSource - field resolvedby has type 12/varchar, class java.lang.String 20:43:40.204 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRBaseFiller - Fill 1: adding page 1 20:43:40.206 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRVerticalFiller - Fill 1: title at 20 20:43:40.219 [quartzScheduler_Worker-2] DEBUG n.s.j.e.fill.SimpleTextLineWrapper - creating element font infos cache of size 2000 20:43:40.222 [quartzScheduler_Worker-2] DEBUG n.s.j.e.util.DeduplicableRegistry - Added object net.sf.jasperreports.engine.fill.JRTemplateFrame@7d016086 20:43:40.222 [quartzScheduler_Worker-2] DEBUG n.s.j.e.util.DeduplicableRegistry - Added object net.sf.jasperreports.engine.fill.JRTemplateText@4a57d96c 20:43:40.222 [quartzScheduler_Worker-2] DEBUG n.s.j.e.util.DeduplicableRegistry - Added object net.sf.jasperreports.engine.fill.JRTemplateImage@5ccfdef8 20:43:40.222 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.BaseReportFiller - Adding evaluation of net.sf.jasperreports.engine.fill.JRTemplatePrintImage@74e1f8c5 by net.sf.jasperreports.engine.fill.JRFillChart@292b38f for evaluation {type: REPORT, group: null, band: 0} 20:43:40.222 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.DelayedFillActions - 1 adding delayed action delayed evaluation {element: net.sf.jasperreports.engine.fill.JRFillChart@292b38f, printElement: net.sf.jasperreports.engine.fill.JRTemplatePrintImage@74e1f8c5} at {type: REPORT, group: null, band: 0}, key page net.sf.jasperreports.engine.base.JRBasePrintPage@76fa8608, index 0 20:43:40.223 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.DelayedFillActions - 1 running delayed actions on {type: BAND, group: null, band: 390885732} 20:43:40.223 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.DelayedFillActions - 1 running delayed actions on {type: BAND, group: null, band: 1323843166} 20:43:40.223 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRVerticalFiller - Fill 1: column header at 310 20:43:40.225 [quartzScheduler_Worker-2] DEBUG n.s.j.e.util.DeduplicableRegistry - Added object net.sf.jasperreports.engine.fill.JRTemplateText@5460ae31 20:43:40.225 [quartzScheduler_Worker-2] DEBUG n.s.j.e.util.DeduplicableRegistry - Found existing instance net.sf.jasperreports.engine.fill.JRTemplateText@5460ae31 for object net.sf.jasperreports.engine.fill.JRTemplateText@2fbc43a8 20:43:40.226 [quartzScheduler_Worker-2] DEBUG n.s.j.e.util.DeduplicableRegistry - Found existing instance net.sf.jasperreports.engine.fill.JRTemplateText@5460ae31 for object net.sf.jasperreports.engine.fill.JRTemplateText@38a5831b 20:43:40.226 [quartzScheduler_Worker-2] DEBUG n.s.j.e.util.DeduplicableRegistry - Found existing instance net.sf.jasperreports.engine.fill.JRTemplateText@5460ae31 for object net.sf.jasperreports.engine.fill.JRTemplateText@1acd88c1 20:43:40.227 [quartzScheduler_Worker-2] DEBUG n.s.j.e.util.DeduplicableRegistry - Found existing instance net.sf.jasperreports.engine.fill.JRTemplateText@5460ae31 for object net.sf.jasperreports.engine.fill.JRTemplateText@4b0dac8f 20:43:40.227 [quartzScheduler_Worker-2] DEBUG n.s.j.e.util.DeduplicableRegistry - Found existing instance net.sf.jasperreports.engine.fill.JRTemplateText@5460ae31 for object net.sf.jasperreports.engine.fill.JRTemplateText@6610745 20:43:40.232 [quartzScheduler_Worker-2] DEBUG n.s.j.e.util.DeduplicableRegistry - Found existing instance net.sf.jasperreports.engine.fill.JRTemplateText@5460ae31 for object net.sf.jasperreports.engine.fill.JRTemplateText@12c8f1c9 20:43:40.236 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.DelayedFillActions - 1 running delayed actions on {type: BAND, group: null, band: 1230140331} 20:43:40.236 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRVerticalFiller - Fill 1: detail at 335 20:43:40.236 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRFillTextField - 6e8a18f9-3f16-4298-8d1d-a09f8a22a8e7: pattern timezone property net.sf.jasperreports.pattern.timezone is null, resolved to null 20:43:40.248 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRFillTextField - 6e8a18f9-3f16-4298-8d1d-a09f8a22a8e7: formatted value Sat Dec 27 04:28:08 GST 1969 (java.util.Date/-430311712) to 27/12/69 04:28 20:43:40.252 [quartzScheduler_Worker-2] DEBUG n.s.j.e.util.DeduplicableRegistry - Added object net.sf.jasperreports.engine.fill.JRTemplateText@64b5e8d1 20:43:40.252 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRFillTextField - created net.sf.jasperreports.engine.fill.JRTemplateText@64b5e8d1 for (null, {java.util.Date, dd/MM/yy HH:mm,null,null,null}) 20:43:40.252 [quartzScheduler_Worker-2] DEBUG n.s.j.e.util.DeduplicableRegistry - Added object net.sf.jasperreports.engine.fill.JRTemplateText@42fa591c 20:43:40.252 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRFillTextField - created net.sf.jasperreports.engine.fill.JRTemplateText@42fa591c for (null, null) 20:43:40.253 [quartzScheduler_Worker-2] DEBUG n.s.j.e.util.DeduplicableRegistry - Found existing instance net.sf.jasperreports.engine.fill.JRTemplateText@42fa591c for object net.sf.jasperreports.engine.fill.JRTemplateText@4c2f2529 20:43:40.253 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRFillTextField - created net.sf.jasperreports.engine.fill.JRTemplateText@42fa591c for (null, null) 20:43:40.253 [quartzScheduler_Worker-2] DEBUG n.s.j.e.util.DeduplicableRegistry - Added object net.sf.jasperreports.engine.fill.JRTemplateText@19bcc3dc 20:43:40.254 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRFillTextField - created net.sf.jasperreports.engine.fill.JRTemplateText@19bcc3dc for (null, null) 20:43:40.254 [quartzScheduler_Worker-2] DEBUG n.s.j.e.util.DeduplicableRegistry - Found existing instance net.sf.jasperreports.engine.fill.JRTemplateText@42fa591c for object net.sf.jasperreports.engine.fill.JRTemplateText@5284535a 20:43:40.255 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRFillTextField - created net.sf.jasperreports.engine.fill.JRTemplateText@42fa591c for (null, null) 20:43:40.255 [quartzScheduler_Worker-2] DEBUG n.s.j.e.util.DeduplicableRegistry - Found existing instance net.sf.jasperreports.engine.fill.JRTemplateText@42fa591c for object net.sf.jasperreports.engine.fill.JRTemplateText@4226c2af 20:43:40.256 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRFillTextField - created net.sf.jasperreports.engine.fill.JRTemplateText@42fa591c for (null, null) 20:43:40.256 [quartzScheduler_Worker-2] DEBUG n.s.j.e.util.DeduplicableRegistry - Found existing instance net.sf.jasperreports.engine.fill.JRTemplateText@42fa591c for object net.sf.jasperreports.engine.fill.JRTemplateText@7795a1af 20:43:40.256 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRFillTextField - created net.sf.jasperreports.engine.fill.JRTemplateText@42fa591c for (null, null) 20:43:40.257 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.DelayedFillActions - 1 running delayed actions on {type: BAND, group: null, band: 521776201} 20:43:40.257 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRVerticalFiller - Fill 1: detail at 365 20:43:40.257 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRFillTextField - 6e8a18f9-3f16-4298-8d1d-a09f8a22a8e7: formatted value Sat Dec 27 08:29:39 GST 1969 (java.util.Date/-415820712) to 27/12/69 08:29 20:43:40.258 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.DelayedFillActions - 1 running delayed actions on {type: BAND, group: null, band: 521776201} 20:43:40.258 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRVerticalFiller - Fill 1: detail at 390 20:43:40.259 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRFillTextField - 6e8a18f9-3f16-4298-8d1d-a09f8a22a8e7: formatted value Sat Dec 27 08:29:39 GST 1969 (java.util.Date/-415820712) to 27/12/69 08:29 20:43:40.268 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.DelayedFillActions - 1 running delayed actions on {type: BAND, group: null, band: 521776201} 20:43:40.297 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRVerticalFiller - Fill 1: detail at 420 20:43:40.299 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRFillTextField - 6e8a18f9-3f16-4298-8d1d-a09f8a22a8e7: formatted value Sat Dec 27 04:24:49 GST 1969 (java.util.Date/-430510712) to 27/12/69 04:24 20:43:40.300 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.DelayedFillActions - 1 running delayed actions on {type: BAND, group: null, band: 521776201} 20:43:40.300 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.DelayedFillActions - 1 running delayed actions on {type: BAND, group: null, band: 1323843166} 20:43:40.301 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRVerticalFiller - Fill 1: page footer at 558 20:43:40.302 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRFillTextField - 58472c6e-a06a-4790-8639-2bcd63d41173: pattern timezone property net.sf.jasperreports.pattern.timezone is null, resolved to null 20:43:40.302 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRFillTextField - 58472c6e-a06a-4790-8639-2bcd63d41173: formatted value Sun Mar 19 20:43:40 GST 2017 (java.util.Date/1489941820302) to 3/19/17 20:43:40.303 [quartzScheduler_Worker-2] DEBUG n.s.j.e.util.DeduplicableRegistry - Added object net.sf.jasperreports.engine.fill.JRTemplateText@8c83ea2 20:43:40.303 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRFillTextField - created net.sf.jasperreports.engine.fill.JRTemplateText@8c83ea2 for (null, null) 20:43:40.303 [quartzScheduler_Worker-2] DEBUG n.s.j.e.util.DeduplicableRegistry - Added object net.sf.jasperreports.engine.fill.JRTemplateText@7826a262 20:43:40.304 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRFillTextField - created net.sf.jasperreports.engine.fill.JRTemplateText@7826a262 for (null, null) 20:43:40.304 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.BaseReportFiller - Adding evaluation of net.sf.jasperreports.engine.fill.JRTemplatePrintText@c613473 by net.sf.jasperreports.engine.fill.JRFillTextField@56a36489 for evaluation {type: REPORT, group: null, band: 0} 20:43:40.305 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.DelayedFillActions - 1 adding delayed action delayed evaluation {element: net.sf.jasperreports.engine.fill.JRFillTextField@56a36489, printElement: net.sf.jasperreports.engine.fill.JRTemplatePrintText@c613473} at {type: REPORT, group: null, band: 0}, key page net.sf.jasperreports.engine.base.JRBasePrintPage@76fa8608, index 0 20:43:40.305 [quartzScheduler_Worker-2] DEBUG n.s.j.e.util.DeduplicableRegistry - Added object net.sf.jasperreports.engine.fill.JRTemplateText@1fd76dd1 20:43:40.305 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRFillTextField - created net.sf.jasperreports.engine.fill.JRTemplateText@1fd76dd1 for (null, {java.util.Date, M/d/yy,null,null,null}) 20:43:40.306 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.DelayedFillActions - 1 running delayed actions on {type: BAND, group: null, band: 1684598049} 20:43:40.306 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.DelayedFillActions - 1 running delayed actions on {type: COLUMN, group: null, band: 0} 20:43:40.306 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.DelayedFillActions - 1 running delayed actions on {type: PAGE, group: null, band: 0} 20:43:40.307 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.DelayedFillActions - 1 running delayed actions on {type: REPORT, group: null, band: 0} 20:43:40.307 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.DelayedFillActions - 1 running actions for page net.sf.jasperreports.engine.base.JRBasePrintPage@76fa8608 at 0 20:43:40.311 [quartzScheduler_Worker-2] DEBUG n.s.j.e.fill.ElementEvaluationAction - resolving element net.sf.jasperreports.engine.fill.JRTemplatePrintImage@74e1f8c5 by net.sf.jasperreports.engine.fill.JRFillChart@292b38f on {type: REPORT, group: null, band: 0} 20:43:40.312 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.FillReturnValues - saving return variables on band net.sf.jasperreports.engine.fill.JRFillBand@174c7164 20:43:40.314 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRFillDataset - Fill 1: Creating SQL query executer 20:43:40.314 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - DB is Microsoft SQL Server version 13.00.4001 (13/0) 20:43:40.314 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - driver is Microsoft JDBC Driver 4.0 for SQL Server version 4.0.2206.100 (4/0) 20:43:40.315 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - jdbc 4/0 20:43:40.315 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - connection URL is jdbc:sqlserver://localhost\sql2016:1433;authenticationScheme=nativeAuthentication;xopenStates=false;sendTimeAsDatetime=true;trustServerCertificate=false;sendStringParametersAsUnicode=true;selectMethod=direct;responseBuffering=adaptive;packetSize=8000;multiSubnetFailover=false;loginTimeout=15;lockTimeout=-1;lastUpdateCount=true;encrypt=false;disableStatementPooling=true;databaseName=NetXMS_DB;applicationName=Microsoft JDBC Driver for SQL Server;applicationIntent=readwrite; 20:43:40.316 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - system timezone is sun.util.calendar.ZoneInfo[id="Asia/Muscat",offset=14400000,dstSavings=0,useDaylight=false,transitions=3,lastRule=null] 20:43:40.316 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - report timezone is sun.util.calendar.ZoneInfo[id="Asia/Muscat",offset=14400000,dstSavings=0,useDaylight=false,transitions=3,lastRule=null] 20:43:40.316 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - JDBC timezone parameter is null 20:43:40.317 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - JDBC timezone property is null 20:43:40.317 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - JDBC parameters timezone parameter is null 20:43:40.318 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - JDBC parameters timezone property is null 20:43:40.318 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - parameters timezone null 20:43:40.319 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - JDBC fields timezone parameter is null 20:43:40.319 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - JDBC fields timezone property is null 20:43:40.320 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - fields timezone null 20:43:40.323 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - SQL query string: SELECT '<5m' AS name, COUNT(resolveTime) AS cnt FROM (SELECT last_change_time - creation_time AS resolveTime FROM alarms WHERE creation_time BETWEEN ? AND ? AND (alarm_state & 15) IN (2, 3)) t1 WHERE t1.resolveTime BETWEEN 0 AND 300 UNION ALL SELECT '5m û 1h' AS name, COUNT(resolveTime) AS cnt FROM (SELECT last_change_time - creation_time AS resolveTime FROM alarms WHERE creation_time BETWEEN ? AND ? AND (alarm_state & 15) IN (2, 3)) t1 WHERE t1.resolveTime BETWEEN 301 AND 3600 UNION ALL SELECT '1h û 24h' AS name, COUNT(resolveTime) AS cnt FROM (SELECT last_change_time - creation_time AS resolveTime FROM alarms WHERE creation_time BETWEEN ? AND ? AND (alarm_state & 15) IN (2, 3)) t1 WHERE t1.resolveTime BETWEEN 3601 AND 24*60*60 UNION ALL SELECT '>24h' AS name, COUNT(resolveTime) AS cnt FROM (SELECT last_change_time - creation_time AS resolveTime FROM alarms WHERE creation_time BETWEEN ? AND ? AND (alarm_state & 15) IN (2, 3)) t1 WHERE t1.resolveTime > 86400 20:43:40.329 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - Parameter #1 (PERIOD_START of type java.lang.Long): 1489867200 20:43:40.329 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - Parameter #2 (PERIOD_END of type java.lang.Long): 1489953599 20:43:40.344 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - Parameter #3 (PERIOD_START of type java.lang.Long): 1489867200 20:43:40.347 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - Parameter #4 (PERIOD_END of type java.lang.Long): 1489953599 20:43:40.347 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - Parameter #5 (PERIOD_START of type java.lang.Long): 1489867200 20:43:40.349 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - Parameter #6 (PERIOD_END of type java.lang.Long): 1489953599 20:43:40.349 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - Parameter #7 (PERIOD_START of type java.lang.Long): 1489867200 20:43:40.350 [quartzScheduler_Worker-2] DEBUG n.s.j.e.query.JRJdbcQueryExecuter - Parameter #8 (PERIOD_END of type java.lang.Long): 1489953599 20:43:40.351 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.JRResultSetDataSource - field name has type 12/varchar, class java.lang.String 20:43:40.351 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.JRResultSetDataSource - field cnt has type 4/int, class java.lang.Integer 20:43:40.352 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRFillDataset - Fill 1: closing query executer 20:43:40.359 [quartzScheduler_Worker-2] DEBUG n.s.j.e.fill.ElementEvaluationAction - resolving element net.sf.jasperreports.engine.fill.JRTemplatePrintText@c613473 by net.sf.jasperreports.engine.fill.JRFillTextField@56a36489 on {type: REPORT, group: null, band: 0} 20:43:40.361 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.DelayedFillActions - 1 running delayed actions on {type: MASTER, group: null, band: 0} 20:43:40.377 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRBaseFiller - Fill 1: ended 20:43:40.379 [quartzScheduler_Worker-2] DEBUG n.s.j.engine.fill.JRFillDataset - Fill 1: closing query executer 20:43:40.390 [quartzScheduler_Worker-2] DEBUG o.s.o.h.HibernateTransactionManager - Creating new transaction with name [com.radensolutions.reporting.service.impl.ReportResultServiceImpl.save]: PROPAGATION_REQUIRED,ISOLATION_DEFAULT; '' 20:43:40.390 [quartzScheduler_Worker-2] DEBUG o.s.o.h.HibernateTransactionManager - Opened new Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] for Hibernate transaction 20:43:40.390 [quartzScheduler_Worker-2] DEBUG o.s.o.h.HibernateTransactionManager - Preparing JDBC Connection of Hibernate Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] 20:43:40.419 [quartzScheduler_Worker-2] DEBUG o.h.e.t.internal.TransactionImpl - begin 20:43:40.419 [quartzScheduler_Worker-2] DEBUG o.s.o.h.HibernateTransactionManager - Exposing Hibernate transaction as JDBC transaction [com.mchange.v2.c3p0.impl.NewProxyConnection@283e3c5e] 20:43:40.423 [quartzScheduler_Worker-2] DEBUG org.hibernate.SQL - select next_val as id_val from hibernate_sequence with (updlock, rowlock) Hibernate: select next_val as id_val from hibernate_sequence with (updlock, rowlock) 20:43:40.427 [quartzScheduler_Worker-2] ERROR o.h.id.enhanced.TableStructure - could not read a hi value com.microsoft.sqlserver.jdbc.SQLServerException: Invalid object name 'hibernate_sequence'. at com.microsoft.sqlserver.jdbc.SQLServerException.makeFromDatabaseError(SQLServerException.java:216) ~[sqljdbc4-4.0.jar:na] at com.microsoft.sqlserver.jdbc.SQLServerStatement.getNextResult(SQLServerStatement.java:1515) ~[sqljdbc4-4.0.jar:na] at com.microsoft.sqlserver.jdbc.SQLServerPreparedStatement.doExecutePreparedStatement(SQLServerPreparedStatement.java:404) ~[sqljdbc4-4.0.jar:na] at com.microsoft.sqlserver.jdbc.SQLServerPreparedStatement$PrepStmtExecCmd.doExecute(SQLServerPreparedStatement.java:350) ~[sqljdbc4-4.0.jar:na] at com.microsoft.sqlserver.jdbc.TDSCommand.execute(IOBuffer.java:5696) ~[sqljdbc4-4.0.jar:na] at com.microsoft.sqlserver.jdbc.SQLServerConnection.executeCommand(SQLServerConnection.java:1715) ~[sqljdbc4-4.0.jar:na] at com.microsoft.sqlserver.jdbc.SQLServerStatement.executeCommand(SQLServerStatement.java:180) ~[sqljdbc4-4.0.jar:na] at com.microsoft.sqlserver.jdbc.SQLServerStatement.executeStatement(SQLServerStatement.java:155) ~[sqljdbc4-4.0.jar:na] at com.microsoft.sqlserver.jdbc.SQLServerPreparedStatement.executeQuery(SQLServerPreparedStatement.java:285) ~[sqljdbc4-4.0.jar:na] at com.mchange.v2.c3p0.impl.NewProxyPreparedStatement.executeQuery(NewProxyPreparedStatement.java:76) ~[c3p0-0.9.1.1.jar:0.9.1.1] at org.hibernate.id.enhanced.TableStructure.executeQuery(TableStructure.java:224) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.id.enhanced.TableStructure.access$300(TableStructure.java:46) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.id.enhanced.TableStructure$1$1.execute(TableStructure.java:139) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.id.enhanced.TableStructure$1$1.execute(TableStructure.java:126) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.jdbc.WorkExecutor.executeReturningWork(WorkExecutor.java:55) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.jdbc.AbstractReturningWork.accept(AbstractReturningWork.java:34) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.resource.transaction.backend.jdbc.internal.JdbcIsolationDelegate.delegateWork(JdbcIsolationDelegate.java:56) [hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.id.enhanced.TableStructure$1.getNextValue(TableStructure.java:125) [hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.id.enhanced.NoopOptimizer.generate(NoopOptimizer.java:40) [hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.id.enhanced.SequenceStyleGenerator.generate(SequenceStyleGenerator.java:412) [hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.event.internal.AbstractSaveEventListener.saveWithGeneratedId(AbstractSaveEventListener.java:101) [hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.event.internal.DefaultSaveOrUpdateEventListener.saveWithGeneratedOrRequestedId(DefaultSaveOrUpdateEventListener.java:192) [hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.event.internal.DefaultSaveEventListener.saveWithGeneratedOrRequestedId(DefaultSaveEventListener.java:38) [hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.event.internal.DefaultSaveOrUpdateEventListener.entityIsTransient(DefaultSaveOrUpdateEventListener.java:177) [hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.event.internal.DefaultSaveEventListener.performSaveOrUpdate(DefaultSaveEventListener.java:32) [hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.event.internal.DefaultSaveOrUpdateEventListener.onSaveOrUpdate(DefaultSaveOrUpdateEventListener.java:73) [hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.internal.SessionImpl.fireSave(SessionImpl.java:679) [hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.internal.SessionImpl.save(SessionImpl.java:671) [hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.internal.SessionImpl.save(SessionImpl.java:666) [hibernate-core-5.0.7.Final.jar:5.0.7.Final] at com.radensolutions.reporting.dao.impl.ReportResultDAOImpl.saveResult(ReportResultDAOImpl.java:29) [reporting-server-2.0.8.jar:na] at com.radensolutions.reporting.service.impl.ReportResultServiceImpl.save(ReportResultServiceImpl.java:22) [reporting-server-2.0.8.jar:na] at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.8.0_121] at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source) ~[na:1.8.0_121] at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) ~[na:1.8.0_121] at java.lang.reflect.Method.invoke(Unknown Source) ~[na:1.8.0_121] at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:302) [spring-aop-4.2.4.RELEASE.jar:4.2.4.RELEASE] at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:190) [spring-aop-4.2.4.RELEASE.jar:4.2.4.RELEASE] at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:157) [spring-aop-4.2.4.RELEASE.jar:4.2.4.RELEASE] at org.springframework.transaction.interceptor.TransactionInterceptor$1.proceedWithInvocation(TransactionInterceptor.java:99) [spring-tx-4.2.4.RELEASE.jar:4.2.4.RELEASE] at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransaction(TransactionAspectSupport.java:281) [spring-tx-4.2.4.RELEASE.jar:4.2.4.RELEASE] at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:96) [spring-tx-4.2.4.RELEASE.jar:4.2.4.RELEASE] at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179) [spring-aop-4.2.4.RELEASE.jar:4.2.4.RELEASE] at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:208) [spring-aop-4.2.4.RELEASE.jar:4.2.4.RELEASE] at com.sun.proxy.$Proxy32.save(Unknown Source) [na:na] at com.radensolutions.reporting.service.impl.FileSystemReportManager.realExecute(FileSystemReportManager.java:338) [reporting-server-2.0.8.jar:na] at com.radensolutions.reporting.service.impl.FileSystemReportManager.execute(FileSystemReportManager.java:295) [reporting-server-2.0.8.jar:na] at com.radensolutions.reporting.job.GeneratorJob.execute(GeneratorJob.java:33) [reporting-server-2.0.8.jar:na] at org.quartz.core.JobRunShell.run(JobRunShell.java:202) [quartz-2.2.1.jar:na] at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:573) [quartz-2.2.1.jar:na] 20:43:40.429 [quartzScheduler_Worker-2] DEBUG o.h.e.jdbc.spi.SqlExceptionHelper - error performing isolated work [n/a] com.microsoft.sqlserver.jdbc.SQLServerException: Invalid object name 'hibernate_sequence'. at com.microsoft.sqlserver.jdbc.SQLServerException.makeFromDatabaseError(SQLServerException.java:216) ~[sqljdbc4-4.0.jar:na] at com.microsoft.sqlserver.jdbc.SQLServerStatement.getNextResult(SQLServerStatement.java:1515) ~[sqljdbc4-4.0.jar:na] at com.microsoft.sqlserver.jdbc.SQLServerPreparedStatement.doExecutePreparedStatement(SQLServerPreparedStatement.java:404) ~[sqljdbc4-4.0.jar:na] at com.microsoft.sqlserver.jdbc.SQLServerPreparedStatement$PrepStmtExecCmd.doExecute(SQLServerPreparedStatement.java:350) ~[sqljdbc4-4.0.jar:na] at com.microsoft.sqlserver.jdbc.TDSCommand.execute(IOBuffer.java:5696) ~[sqljdbc4-4.0.jar:na] at com.microsoft.sqlserver.jdbc.SQLServerConnection.executeCommand(SQLServerConnection.java:1715) ~[sqljdbc4-4.0.jar:na] at com.microsoft.sqlserver.jdbc.SQLServerStatement.executeCommand(SQLServerStatement.java:180) ~[sqljdbc4-4.0.jar:na] at com.microsoft.sqlserver.jdbc.SQLServerStatement.executeStatement(SQLServerStatement.java:155) ~[sqljdbc4-4.0.jar:na] at com.microsoft.sqlserver.jdbc.SQLServerPreparedStatement.executeQuery(SQLServerPreparedStatement.java:285) ~[sqljdbc4-4.0.jar:na] at com.mchange.v2.c3p0.impl.NewProxyPreparedStatement.executeQuery(NewProxyPreparedStatement.java:76) ~[c3p0-0.9.1.1.jar:0.9.1.1] at org.hibernate.id.enhanced.TableStructure.executeQuery(TableStructure.java:224) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.id.enhanced.TableStructure.access$300(TableStructure.java:46) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.id.enhanced.TableStructure$1$1.execute(TableStructure.java:139) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.id.enhanced.TableStructure$1$1.execute(TableStructure.java:126) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.jdbc.WorkExecutor.executeReturningWork(WorkExecutor.java:55) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.jdbc.AbstractReturningWork.accept(AbstractReturningWork.java:34) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.resource.transaction.backend.jdbc.internal.JdbcIsolationDelegate.delegateWork(JdbcIsolationDelegate.java:56) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.id.enhanced.TableStructure$1.getNextValue(TableStructure.java:125) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.id.enhanced.NoopOptimizer.generate(NoopOptimizer.java:40) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.id.enhanced.SequenceStyleGenerator.generate(SequenceStyleGenerator.java:412) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.event.internal.AbstractSaveEventListener.saveWithGeneratedId(AbstractSaveEventListener.java:101) [hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.event.internal.DefaultSaveOrUpdateEventListener.saveWithGeneratedOrRequestedId(DefaultSaveOrUpdateEventListener.java:192) [hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.event.internal.DefaultSaveEventListener.saveWithGeneratedOrRequestedId(DefaultSaveEventListener.java:38) [hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.event.internal.DefaultSaveOrUpdateEventListener.entityIsTransient(DefaultSaveOrUpdateEventListener.java:177) [hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.event.internal.DefaultSaveEventListener.performSaveOrUpdate(DefaultSaveEventListener.java:32) [hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.event.internal.DefaultSaveOrUpdateEventListener.onSaveOrUpdate(DefaultSaveOrUpdateEventListener.java:73) [hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.internal.SessionImpl.fireSave(SessionImpl.java:679) [hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.internal.SessionImpl.save(SessionImpl.java:671) [hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.internal.SessionImpl.save(SessionImpl.java:666) [hibernate-core-5.0.7.Final.jar:5.0.7.Final] at com.radensolutions.reporting.dao.impl.ReportResultDAOImpl.saveResult(ReportResultDAOImpl.java:29) [reporting-server-2.0.8.jar:na] at com.radensolutions.reporting.service.impl.ReportResultServiceImpl.save(ReportResultServiceImpl.java:22) [reporting-server-2.0.8.jar:na] at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.8.0_121] at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source) ~[na:1.8.0_121] at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) ~[na:1.8.0_121] at java.lang.reflect.Method.invoke(Unknown Source) ~[na:1.8.0_121] at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:302) [spring-aop-4.2.4.RELEASE.jar:4.2.4.RELEASE] at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:190) [spring-aop-4.2.4.RELEASE.jar:4.2.4.RELEASE] at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:157) [spring-aop-4.2.4.RELEASE.jar:4.2.4.RELEASE] at org.springframework.transaction.interceptor.TransactionInterceptor$1.proceedWithInvocation(TransactionInterceptor.java:99) [spring-tx-4.2.4.RELEASE.jar:4.2.4.RELEASE] at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransaction(TransactionAspectSupport.java:281) [spring-tx-4.2.4.RELEASE.jar:4.2.4.RELEASE] at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:96) [spring-tx-4.2.4.RELEASE.jar:4.2.4.RELEASE] at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179) [spring-aop-4.2.4.RELEASE.jar:4.2.4.RELEASE] at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:208) [spring-aop-4.2.4.RELEASE.jar:4.2.4.RELEASE] at com.sun.proxy.$Proxy32.save(Unknown Source) [na:na] at com.radensolutions.reporting.service.impl.FileSystemReportManager.realExecute(FileSystemReportManager.java:338) [reporting-server-2.0.8.jar:na] at com.radensolutions.reporting.service.impl.FileSystemReportManager.execute(FileSystemReportManager.java:295) [reporting-server-2.0.8.jar:na] at com.radensolutions.reporting.job.GeneratorJob.execute(GeneratorJob.java:33) [reporting-server-2.0.8.jar:na] at org.quartz.core.JobRunShell.run(JobRunShell.java:202) [quartz-2.2.1.jar:na] at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:573) [quartz-2.2.1.jar:na] 20:43:40.430 [quartzScheduler_Worker-2] WARN o.h.e.jdbc.spi.SqlExceptionHelper - SQL Error: 208, SQLState: S0002 20:43:40.431 [quartzScheduler_Worker-2] ERROR o.h.e.jdbc.spi.SqlExceptionHelper - Invalid object name 'hibernate_sequence'. 20:43:40.432 [quartzScheduler_Worker-2] DEBUG o.s.o.h.HibernateTransactionManager - Initiating transaction rollback 20:43:40.432 [quartzScheduler_Worker-2] DEBUG o.s.o.h.HibernateTransactionManager - Rolling back Hibernate transaction on Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] 20:43:40.432 [quartzScheduler_Worker-2] DEBUG o.h.e.t.internal.TransactionImpl - rolling back 20:43:40.433 [quartzScheduler_Worker-2] DEBUG o.s.o.h.HibernateTransactionManager - Closing Hibernate Session [SessionImpl(PersistenceContext[entityKeys=[],collectionKeys=[]];ActionQueue[insertions=ExecutableList{size=0} updates=ExecutableList{size=0} deletions=ExecutableList{size=0} orphanRemovals=ExecutableList{size=0} collectionCreations=ExecutableList{size=0} collectionRemovals=ExecutableList{size=0} collectionUpdates=ExecutableList{size=0} collectionQueuedOps=ExecutableList{size=0} unresolvedInsertDependencies=null])] after transaction 20:43:40.434 [quartzScheduler_Worker-2] ERROR c.r.reporting.job.GeneratorJob - Failed to execute report, job terminating org.hibernate.exception.SQLGrammarException: error performing isolated work at org.hibernate.exception.internal.SQLStateConversionDelegate.convert(SQLStateConversionDelegate.java:106) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.exception.internal.StandardSQLExceptionConverter.convert(StandardSQLExceptionConverter.java:42) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.engine.jdbc.spi.SqlExceptionHelper.convert(SqlExceptionHelper.java:109) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.engine.jdbc.spi.SqlExceptionHelper.convert(SqlExceptionHelper.java:95) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.resource.transaction.backend.jdbc.internal.JdbcIsolationDelegate.delegateWork(JdbcIsolationDelegate.java:78) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.id.enhanced.TableStructure$1.getNextValue(TableStructure.java:125) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.id.enhanced.NoopOptimizer.generate(NoopOptimizer.java:40) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.id.enhanced.SequenceStyleGenerator.generate(SequenceStyleGenerator.java:412) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.event.internal.AbstractSaveEventListener.saveWithGeneratedId(AbstractSaveEventListener.java:101) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.event.internal.DefaultSaveOrUpdateEventListener.saveWithGeneratedOrRequestedId(DefaultSaveOrUpdateEventListener.java:192) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.event.internal.DefaultSaveEventListener.saveWithGeneratedOrRequestedId(DefaultSaveEventListener.java:38) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.event.internal.DefaultSaveOrUpdateEventListener.entityIsTransient(DefaultSaveOrUpdateEventListener.java:177) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.event.internal.DefaultSaveEventListener.performSaveOrUpdate(DefaultSaveEventListener.java:32) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.event.internal.DefaultSaveOrUpdateEventListener.onSaveOrUpdate(DefaultSaveOrUpdateEventListener.java:73) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.internal.SessionImpl.fireSave(SessionImpl.java:679) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.internal.SessionImpl.save(SessionImpl.java:671) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.internal.SessionImpl.save(SessionImpl.java:666) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at com.radensolutions.reporting.dao.impl.ReportResultDAOImpl.saveResult(ReportResultDAOImpl.java:29) ~[reporting-server-2.0.8.jar:na] at com.radensolutions.reporting.service.impl.ReportResultServiceImpl.save(ReportResultServiceImpl.java:22) ~[reporting-server-2.0.8.jar:na] at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.8.0_121] at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source) ~[na:1.8.0_121] at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) ~[na:1.8.0_121] at java.lang.reflect.Method.invoke(Unknown Source) ~[na:1.8.0_121] at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:302) ~[spring-aop-4.2.4.RELEASE.jar:4.2.4.RELEASE] at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:190) ~[spring-aop-4.2.4.RELEASE.jar:4.2.4.RELEASE] at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:157) ~[spring-aop-4.2.4.RELEASE.jar:4.2.4.RELEASE] at org.springframework.transaction.interceptor.TransactionInterceptor$1.proceedWithInvocation(TransactionInterceptor.java:99) ~[spring-tx-4.2.4.RELEASE.jar:4.2.4.RELEASE] at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransaction(TransactionAspectSupport.java:281) ~[spring-tx-4.2.4.RELEASE.jar:4.2.4.RELEASE] at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:96) ~[spring-tx-4.2.4.RELEASE.jar:4.2.4.RELEASE] at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:179) ~[spring-aop-4.2.4.RELEASE.jar:4.2.4.RELEASE] at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:208) ~[spring-aop-4.2.4.RELEASE.jar:4.2.4.RELEASE] at com.sun.proxy.$Proxy32.save(Unknown Source) ~[na:na] at com.radensolutions.reporting.service.impl.FileSystemReportManager.realExecute(FileSystemReportManager.java:338) ~[reporting-server-2.0.8.jar:na] at com.radensolutions.reporting.service.impl.FileSystemReportManager.execute(FileSystemReportManager.java:295) ~[reporting-server-2.0.8.jar:na] at com.radensolutions.reporting.job.GeneratorJob.execute(GeneratorJob.java:33) ~[reporting-server-2.0.8.jar:na] at org.quartz.core.JobRunShell.run(JobRunShell.java:202) [quartz-2.2.1.jar:na] at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:573) [quartz-2.2.1.jar:na] Caused by: com.microsoft.sqlserver.jdbc.SQLServerException: Invalid object name 'hibernate_sequence'. at com.microsoft.sqlserver.jdbc.SQLServerException.makeFromDatabaseError(SQLServerException.java:216) ~[sqljdbc4-4.0.jar:na] at com.microsoft.sqlserver.jdbc.SQLServerStatement.getNextResult(SQLServerStatement.java:1515) ~[sqljdbc4-4.0.jar:na] at com.microsoft.sqlserver.jdbc.SQLServerPreparedStatement.doExecutePreparedStatement(SQLServerPreparedStatement.java:404) ~[sqljdbc4-4.0.jar:na] at com.microsoft.sqlserver.jdbc.SQLServerPreparedStatement$PrepStmtExecCmd.doExecute(SQLServerPreparedStatement.java:350) ~[sqljdbc4-4.0.jar:na] at com.microsoft.sqlserver.jdbc.TDSCommand.execute(IOBuffer.java:5696) ~[sqljdbc4-4.0.jar:na] at com.microsoft.sqlserver.jdbc.SQLServerConnection.executeCommand(SQLServerConnection.java:1715) ~[sqljdbc4-4.0.jar:na] at com.microsoft.sqlserver.jdbc.SQLServerStatement.executeCommand(SQLServerStatement.java:180) ~[sqljdbc4-4.0.jar:na] at com.microsoft.sqlserver.jdbc.SQLServerStatement.executeStatement(SQLServerStatement.java:155) ~[sqljdbc4-4.0.jar:na] at com.microsoft.sqlserver.jdbc.SQLServerPreparedStatement.executeQuery(SQLServerPreparedStatement.java:285) ~[sqljdbc4-4.0.jar:na] at com.mchange.v2.c3p0.impl.NewProxyPreparedStatement.executeQuery(NewProxyPreparedStatement.java:76) ~[c3p0-0.9.1.1.jar:0.9.1.1] at org.hibernate.id.enhanced.TableStructure.executeQuery(TableStructure.java:224) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.id.enhanced.TableStructure.access$300(TableStructure.java:46) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.id.enhanced.TableStructure$1$1.execute(TableStructure.java:139) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.id.enhanced.TableStructure$1$1.execute(TableStructure.java:126) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.jdbc.WorkExecutor.executeReturningWork(WorkExecutor.java:55) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.jdbc.AbstractReturningWork.accept(AbstractReturningWork.java:34) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] at org.hibernate.resource.transaction.backend.jdbc.internal.JdbcIsolationDelegate.delegateWork(JdbcIsolationDelegate.java:56) ~[hibernate-core-5.0.7.Final.jar:5.0.7.Final] ... 32 common frames omitted 20:43:40.434 [quartzScheduler_Worker-2] DEBUG o.q.i.jdbcjobstore.SimpleSemaphore - Lock 'TRIGGER_ACCESS' is desired by: quartzScheduler_Worker-2 20:43:40.435 [quartzScheduler_Worker-2] DEBUG o.q.i.jdbcjobstore.SimpleSemaphore - Lock 'TRIGGER_ACCESS' is being obtained: quartzScheduler_Worker-2 20:43:40.435 [quartzScheduler_Worker-2] DEBUG o.q.i.jdbcjobstore.SimpleSemaphore - Lock 'TRIGGER_ACCESS' given to: quartzScheduler_Worker-2 20:43:40.438 [quartzScheduler_Worker-2] DEBUG o.q.impl.jdbcjobstore.JobStoreTX - Deleting job: 18b2ec56-cac6-410a-b86e-f64ffe49704d.f2c190a9-76ea-4507-a81d-0616d255c3db 20:43:40.443 [quartzScheduler_Worker-2] DEBUG o.q.i.jdbcjobstore.SimpleSemaphore - Lock 'TRIGGER_ACCESS' retuned by: quartzScheduler_Worker-2