INFO | jvm 1 | 2021/07/06 08:28:52 | DEBUG [SingleConnectionDatasource ] [08:28:52,649]: Attempting to get connection. INFO | jvm 1 | 2021/07/06 08:28:52 | DEBUG [SingleConnectionDatasource ] [08:28:52,649]: SingleConnectionDS: Connection 73138268 Created INFO | jvm 1 | 2021/07/06 08:28:52 | DEBUG [SingleConnectionDatasource ] [08:28:52,655]: SingleConnectionDS: Closed id '73138268' INFO | jvm 1 | 2021/07/06 08:28:53 | DEBUG [SingleConnectionDatasource ] [08:28:53,589]: Attempting to get connection. INFO | jvm 1 | 2021/07/06 08:28:53 | DEBUG [SingleConnectionDatasource ] [08:28:53,590]: SingleConnectionDS: Connection 73138269 Created INFO | jvm 1 | 2021/07/06 08:28:53 | DEBUG [SingleConnectionDatasource ] [08:28:53,673]: Attempting to get connection. INFO | jvm 1 | 2021/07/06 08:29:18 | DEBUG [SingleConnectionDatasource ] [08:29:18,247]: Attempting to get connection. INFO | jvm 1 | 2021/07/06 08:29:23 | ERROR [SingleConnectionDatasource ] [08:29:23,673]: The following stack successfully received a connection. A new attempt was blocked for over 30000 ms INFO | jvm 1 | 2021/07/06 08:29:23 | java.lang.Throwable INFO | jvm 1 | 2021/07/06 08:29:23 | at com.inductiveautomation.ignition.gateway.localdb.sqlite.SingleConnectionDatasource.getConnection(SingleConnectionDatasource.java:43) INFO | jvm 1 | 2021/07/06 08:29:23 | at com.inductiveautomation.ignition.gateway.localdb.DelegatingDataSource.getConnection(DelegatingDataSource.java:59) INFO | jvm 1 | 2021/07/06 08:29:23 | at simpleorm.sessionjdbc.SSessionJdbc.innerOpen(SSessionJdbc.java:111) INFO | jvm 1 | 2021/07/06 08:29:23 | at com.inductiveautomation.ignition.gateway.localdb.persistence.PersistenceSession.initialize(PersistenceSession.java:28) INFO | jvm 1 | 2021/07/06 08:29:23 | at com.inductiveautomation.ignition.gateway.localdb.PersistenceInterfaceImpl.getSession(PersistenceInterfaceImpl.java:69) INFO | jvm 1 | 2021/07/06 08:29:23 | at com.inductiveautomation.ignition.gateway.localdb.PersistenceInterfaceImpl.getSession(PersistenceInterfaceImpl.java:46) INFO | jvm 1 | 2021/07/06 08:29:23 | at com.inductiveautomation.ignition.gateway.project.ProjectManagerImpl.getProjectsFull(ProjectManagerImpl.java:1457) INFO | jvm 1 | 2021/07/06 08:29:23 | at com.inductiveautomation.ignition.gateway.servlets.ProjectListServlet.doGet(ProjectListServlet.java:136) INFO | jvm 1 | 2021/07/06 08:29:23 | at javax.servlet.http.HttpServlet.service(HttpServlet.java:687) INFO | jvm 1 | 2021/07/06 08:29:23 | at javax.servlet.http.HttpServlet.service(HttpServlet.java:790) INFO | jvm 1 | 2021/07/06 08:29:23 | at com.inductiveautomation.ignition.gateway.bootstrap.MapServlet.service(MapServlet.java:85) INFO | jvm 1 | 2021/07/06 08:29:23 | at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:837) INFO | jvm 1 | 2021/07/06 08:29:23 | at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:583) INFO | jvm 1 | 2021/07/06 08:29:23 | at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143) INFO | jvm 1 | 2021/07/06 08:29:23 | at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:548) INFO | jvm 1 | 2021/07/06 08:29:23 | at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226) INFO | jvm 1 | 2021/07/06 08:29:23 | at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1160) INFO | jvm 1 | 2021/07/06 08:29:23 | at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511) INFO | jvm 1 | 2021/07/06 08:29:23 | at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185) INFO | jvm 1 | 2021/07/06 08:29:23 | at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1092) INFO | jvm 1 | 2021/07/06 08:29:23 | at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) INFO | jvm 1 | 2021/07/06 08:29:23 | at org.eclipse.jetty.server.handler.HandlerList.handle(HandlerList.java:52) INFO | jvm 1 | 2021/07/06 08:29:23 | at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134) INFO | jvm 1 | 2021/07/06 08:29:23 | at org.eclipse.jetty.server.Server.handle(Server.java:518) INFO | jvm 1 | 2021/07/06 08:29:23 | at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:308) INFO | jvm 1 | 2021/07/06 08:29:23 | at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:244) INFO | jvm 1 | 2021/07/06 08:29:23 | at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273) INFO | jvm 1 | 2021/07/06 08:29:23 | at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95) INFO | jvm 1 | 2021/07/06 08:29:23 | at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93) INFO | jvm 1 | 2021/07/06 08:29:23 | at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:246) INFO | jvm 1 | 2021/07/06 08:29:23 | at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:156) INFO | jvm 1 | 2021/07/06 08:29:23 | at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654) INFO | jvm 1 | 2021/07/06 08:29:23 | at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572) INFO | jvm 1 | 2021/07/06 08:29:23 | at java.lang.Thread.run(Unknown Source) INFO | jvm 1 | 2021/07/06 08:29:23 | ERROR [TagStore ] [08:29:23,680]: Error storing tag values. INFO | jvm 1 | 2021/07/06 08:29:23 | simpleorm.utils.SException$Jdbc: Opening com.inductiveautomation.ignition.gateway.localdb.sqlite.SingleConnectionDatasource@879d290 INFO | jvm 1 | 2021/07/06 08:29:23 | at simpleorm.sessionjdbc.SSessionJdbc.innerOpen(SSessionJdbc.java:113) INFO | jvm 1 | 2021/07/06 08:29:23 | at com.inductiveautomation.ignition.gateway.localdb.persistence.PersistenceSession.initialize(PersistenceSession.java:28) INFO | jvm 1 | 2021/07/06 08:29:23 | at com.inductiveautomation.ignition.gateway.localdb.PersistenceInterfaceImpl.getSession(PersistenceInterfaceImpl.java:69) INFO | jvm 1 | 2021/07/06 08:29:23 | at com.inductiveautomation.ignition.gateway.localdb.PersistenceInterfaceImpl.getSession(PersistenceInterfaceImpl.java:46) INFO | jvm 1 | 2021/07/06 08:29:23 | at com.inductiveautomation.ignition.gateway.sqltags.tagproviders.internal.InternalTagStore.openIfNot(InternalTagStore.java:1293) INFO | jvm 1 | 2021/07/06 08:29:23 | at com.inductiveautomation.ignition.gateway.sqltags.tagproviders.internal.InternalTagStore.internalStoreTagValues(InternalTagStore.java:1332) INFO | jvm 1 | 2021/07/06 08:29:23 | at com.inductiveautomation.ignition.gateway.sqltags.tagproviders.internal.InternalTagStore.storeTagValues(InternalTagStore.java:1241) INFO | jvm 1 | 2021/07/06 08:29:23 | at com.inductiveautomation.ignition.gateway.sqltags.providers.AbstractStoreBasedTagProvider.tagValuesChanged(AbstractStoreBasedTagProvider.java:2343) INFO | jvm 1 | 2021/07/06 08:29:23 | at com.inductiveautomation.ignition.gateway.sqltags.scanclasses.SimpleExecutableScanClass$ScanClassTagEvaluationContext.processAndReset(SimpleExecutableScanClass.java:1186) INFO | jvm 1 | 2021/07/06 08:29:23 | at com.inductiveautomation.ignition.gateway.sqltags.scanclasses.SimpleExecutableScanClass.run(SimpleExecutableScanClass.java:908) INFO | jvm 1 | 2021/07/06 08:29:23 | at com.inductiveautomation.ignition.common.execution.impl.BasicExecutionEngine$SelfSchedulingRunner.run(BasicExecutionEngine.java:502) INFO | jvm 1 | 2021/07/06 08:29:23 | at com.inductiveautomation.ignition.common.execution.impl.BasicExecutionEngine$TrackedTask.run(BasicExecutionEngine.java:584) INFO | jvm 1 | 2021/07/06 08:29:23 | at java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) INFO | jvm 1 | 2021/07/06 08:29:23 | at java.util.concurrent.FutureTask.run(Unknown Source) INFO | jvm 1 | 2021/07/06 08:29:23 | at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(Unknown Source) INFO | jvm 1 | 2021/07/06 08:29:23 | at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(Unknown Source) INFO | jvm 1 | 2021/07/06 08:29:23 | at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source) INFO | jvm 1 | 2021/07/06 08:29:23 | at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source) INFO | jvm 1 | 2021/07/06 08:29:23 | at java.lang.Thread.run(Unknown Source) INFO | jvm 1 | 2021/07/06 08:29:23 | Caused by: java.sql.SQLException: Connection is locked. Datasource only allows one connection at a time. To log the concurrent connection, turn the logger 'com.inductiveautomation.ignition.gateway.localdb.sqlite.SingleConnectionDatasource' to DEBUG. INFO | jvm 1 | 2021/07/06 08:29:23 | at com.inductiveautomation.ignition.gateway.localdb.sqlite.SingleConnectionDatasource.getConnection(SingleConnectionDatasource.java:58) INFO | jvm 1 | 2021/07/06 08:29:23 | at simpleorm.sessionjdbc.SSessionJdbc.innerOpen(SSessionJdbc.java:111) INFO | jvm 1 | 2021/07/06 08:29:23 | ... 18 more INFO | jvm 1 | 2021/07/06 08:29:26 | [Tue Jul 06 08:29:26 GMT-04:00 2021, 299162.125, 172.7949981689453] INFO | jvm 1 | 2021/07/06 08:29:27 | DEBUG [SingleConnectionDatasource ] [08:29:27,408]: Attempting to get connection. INFO | jvm 1 | 2021/07/06 08:29:27 | DEBUG [SingleConnectionDatasource ] [08:29:27,711]: Attempting to get connection. INFO | jvm 1 | 2021/07/06 08:29:48 | ERROR [SingleConnectionDatasource ] [08:29:48,247]: The following stack successfully received a connection. A new attempt was blocked for over 30000 ms INFO | jvm 1 | 2021/07/06 08:29:48 | java.lang.Throwable INFO | jvm 1 | 2021/07/06 08:29:48 | at com.inductiveautomation.ignition.gateway.localdb.sqlite.SingleConnectionDatasource.getConnection(SingleConnectionDatasource.java:43) INFO | jvm 1 | 2021/07/06 08:29:48 | at com.inductiveautomation.ignition.gateway.localdb.DelegatingDataSource.getConnection(DelegatingDataSource.java:59) INFO | jvm 1 | 2021/07/06 08:29:48 | at simpleorm.sessionjdbc.SSessionJdbc.innerOpen(SSessionJdbc.java:111) INFO | jvm 1 | 2021/07/06 08:29:48 | at com.inductiveautomation.ignition.gateway.localdb.persistence.PersistenceSession.initialize(PersistenceSession.java:28) INFO | jvm 1 | 2021/07/06 08:29:48 | at com.inductiveautomation.ignition.gateway.localdb.PersistenceInterfaceImpl.getSession(PersistenceInterfaceImpl.java:69) INFO | jvm 1 | 2021/07/06 08:29:48 | at com.inductiveautomation.ignition.gateway.localdb.PersistenceInterfaceImpl.getSession(PersistenceInterfaceImpl.java:46) INFO | jvm 1 | 2021/07/06 08:29:48 | at com.inductiveautomation.ignition.gateway.project.ProjectManagerImpl.getProjectsFull(ProjectManagerImpl.java:1457) INFO | jvm 1 | 2021/07/06 08:29:48 | at com.inductiveautomation.ignition.gateway.servlets.ProjectListServlet.doGet(ProjectListServlet.java:136) INFO | jvm 1 | 2021/07/06 08:29:48 | at javax.servlet.http.HttpServlet.service(HttpServlet.java:687) INFO | jvm 1 | 2021/07/06 08:29:48 | at javax.servlet.http.HttpServlet.service(HttpServlet.java:790) INFO | jvm 1 | 2021/07/06 08:29:48 | at com.inductiveautomation.ignition.gateway.bootstrap.MapServlet.service(MapServlet.java:85) INFO | jvm 1 | 2021/07/06 08:29:48 | at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:837) INFO | jvm 1 | 2021/07/06 08:29:48 | at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:583) INFO | jvm 1 | 2021/07/06 08:29:48 | at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143) INFO | jvm 1 | 2021/07/06 08:29:48 | at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:548) INFO | jvm 1 | 2021/07/06 08:29:48 | at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226) INFO | jvm 1 | 2021/07/06 08:29:48 | at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1160) INFO | jvm 1 | 2021/07/06 08:29:48 | at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511) INFO | jvm 1 | 2021/07/06 08:29:48 | at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185) INFO | jvm 1 | 2021/07/06 08:29:48 | at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1092) INFO | jvm 1 | 2021/07/06 08:29:48 | at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) INFO | jvm 1 | 2021/07/06 08:29:48 | at org.eclipse.jetty.server.handler.HandlerList.handle(HandlerList.java:52) INFO | jvm 1 | 2021/07/06 08:29:48 | at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134) INFO | jvm 1 | 2021/07/06 08:29:48 | at org.eclipse.jetty.server.Server.handle(Server.java:518) INFO | jvm 1 | 2021/07/06 08:29:48 | at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:308) INFO | jvm 1 | 2021/07/06 08:29:48 | at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:244) INFO | jvm 1 | 2021/07/06 08:29:48 | at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273) INFO | jvm 1 | 2021/07/06 08:29:48 | at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95) INFO | jvm 1 | 2021/07/06 08:29:48 | at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93) INFO | jvm 1 | 2021/07/06 08:29:48 | at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:246) INFO | jvm 1 | 2021/07/06 08:29:48 | at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:156) INFO | jvm 1 | 2021/07/06 08:29:48 | at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654) INFO | jvm 1 | 2021/07/06 08:29:48 | at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572) INFO | jvm 1 | 2021/07/06 08:29:48 | at java.lang.Thread.run(Unknown Source) INFO | jvm 1 | 2021/07/06 08:29:48 | DEBUG [SingleConnectionDatasource ] [08:29:48,252]: Attempting to get connection. INFO | jvm 1 | 2021/07/06 08:29:57 | ERROR [SingleConnectionDatasource ] [08:29:57,408]: The following stack successfully received a connection. A new attempt was blocked for over 30000 ms INFO | jvm 1 | 2021/07/06 08:29:57 | java.lang.Throwable INFO | jvm 1 | 2021/07/06 08:29:57 | at com.inductiveautomation.ignition.gateway.localdb.sqlite.SingleConnectionDatasource.getConnection(SingleConnectionDatasource.java:43) INFO | jvm 1 | 2021/07/06 08:29:57 | at com.inductiveautomation.ignition.gateway.localdb.DelegatingDataSource.getConnection(DelegatingDataSource.java:59) INFO | jvm 1 | 2021/07/06 08:29:57 | at simpleorm.sessionjdbc.SSessionJdbc.innerOpen(SSessionJdbc.java:111) INFO | jvm 1 | 2021/07/06 08:29:57 | at com.inductiveautomation.ignition.gateway.localdb.persistence.PersistenceSession.initialize(PersistenceSession.java:28) INFO | jvm 1 | 2021/07/06 08:29:57 | at com.inductiveautomation.ignition.gateway.localdb.PersistenceInterfaceImpl.getSession(PersistenceInterfaceImpl.java:69) INFO | jvm 1 | 2021/07/06 08:29:57 | at com.inductiveautomation.ignition.gateway.localdb.PersistenceInterfaceImpl.getSession(PersistenceInterfaceImpl.java:46) INFO | jvm 1 | 2021/07/06 08:29:57 | at com.inductiveautomation.ignition.gateway.project.ProjectManagerImpl.getProjectsFull(ProjectManagerImpl.java:1457) INFO | jvm 1 | 2021/07/06 08:29:57 | at com.inductiveautomation.ignition.gateway.servlets.ProjectListServlet.doGet(ProjectListServlet.java:136) INFO | jvm 1 | 2021/07/06 08:29:57 | at javax.servlet.http.HttpServlet.service(HttpServlet.java:687) INFO | jvm 1 | 2021/07/06 08:29:57 | at javax.servlet.http.HttpServlet.service(HttpServlet.java:790) INFO | jvm 1 | 2021/07/06 08:29:57 | at com.inductiveautomation.ignition.gateway.bootstrap.MapServlet.service(MapServlet.java:85) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:837) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:583) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:548) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1160) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1092) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.server.handler.HandlerList.handle(HandlerList.java:52) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.server.Server.handle(Server.java:518) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:308) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:244) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:246) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:156) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572) INFO | jvm 1 | 2021/07/06 08:29:57 | at java.lang.Thread.run(Unknown Source) INFO | jvm 1 | 2021/07/06 08:29:57 | ERROR [Wrapper ] [08:29:57,408]: [profileName=default] Error fetching users. INFO | jvm 1 | 2021/07/06 08:29:57 | simpleorm.utils.SException$Jdbc: Opening com.inductiveautomation.ignition.gateway.localdb.CountingDataSource@5524e2f2 INFO | jvm 1 | 2021/07/06 08:29:57 | at simpleorm.sessionjdbc.SSessionJdbc.innerOpen(SSessionJdbc.java:113) INFO | jvm 1 | 2021/07/06 08:29:57 | at com.inductiveautomation.ignition.gateway.localdb.persistence.PersistenceSession.initialize(PersistenceSession.java:28) INFO | jvm 1 | 2021/07/06 08:29:57 | at com.inductiveautomation.ignition.gateway.localdb.PersistenceInterfaceImpl.getSession(PersistenceInterfaceImpl.java:69) INFO | jvm 1 | 2021/07/06 08:29:57 | at com.inductiveautomation.ignition.gateway.localdb.PersistenceInterfaceImpl.getSession(PersistenceInterfaceImpl.java:46) INFO | jvm 1 | 2021/07/06 08:29:57 | at com.inductiveautomation.ignition.gateway.authentication.impl.InternalUserSource.getUsers(InternalUserSource.java:179) INFO | jvm 1 | 2021/07/06 08:29:57 | at com.inductiveautomation.ignition.gateway.authentication.UserSourceWrapper.updateCache(UserSourceWrapper.java:106) INFO | jvm 1 | 2021/07/06 08:29:57 | at com.inductiveautomation.ignition.gateway.authentication.UserSourceManagerImpl$UpdateCacheTask.run(UserSourceManagerImpl.java:316) INFO | jvm 1 | 2021/07/06 08:29:57 | at java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) INFO | jvm 1 | 2021/07/06 08:29:57 | at java.util.concurrent.FutureTask.run(Unknown Source) INFO | jvm 1 | 2021/07/06 08:29:57 | at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source) INFO | jvm 1 | 2021/07/06 08:29:57 | at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source) INFO | jvm 1 | 2021/07/06 08:29:57 | at java.lang.Thread.run(Unknown Source) INFO | jvm 1 | 2021/07/06 08:29:57 | Caused by: java.sql.SQLException: Connection is locked. Datasource only allows one connection at a time. To log the concurrent connection, turn the logger 'com.inductiveautomation.ignition.gateway.localdb.sqlite.SingleConnectionDatasource' to DEBUG. INFO | jvm 1 | 2021/07/06 08:29:57 | at com.inductiveautomation.ignition.gateway.localdb.sqlite.SingleConnectionDatasource.getConnection(SingleConnectionDatasource.java:58) INFO | jvm 1 | 2021/07/06 08:29:57 | at com.inductiveautomation.ignition.gateway.localdb.DelegatingDataSource.getConnection(DelegatingDataSource.java:59) INFO | jvm 1 | 2021/07/06 08:29:57 | at simpleorm.sessionjdbc.SSessionJdbc.innerOpen(SSessionJdbc.java:111) INFO | jvm 1 | 2021/07/06 08:29:57 | ... 11 more INFO | jvm 1 | 2021/07/06 08:29:57 | DEBUG [SingleConnectionDatasource ] [08:29:57,408]: Attempting to get connection. INFO | jvm 1 | 2021/07/06 08:29:57 | ERROR [SingleConnectionDatasource ] [08:29:57,712]: The following stack successfully received a connection. A new attempt was blocked for over 30000 ms INFO | jvm 1 | 2021/07/06 08:29:57 | java.lang.Throwable INFO | jvm 1 | 2021/07/06 08:29:57 | at com.inductiveautomation.ignition.gateway.localdb.sqlite.SingleConnectionDatasource.getConnection(SingleConnectionDatasource.java:43) INFO | jvm 1 | 2021/07/06 08:29:57 | at com.inductiveautomation.ignition.gateway.localdb.DelegatingDataSource.getConnection(DelegatingDataSource.java:59) INFO | jvm 1 | 2021/07/06 08:29:57 | at simpleorm.sessionjdbc.SSessionJdbc.innerOpen(SSessionJdbc.java:111) INFO | jvm 1 | 2021/07/06 08:29:57 | at com.inductiveautomation.ignition.gateway.localdb.persistence.PersistenceSession.initialize(PersistenceSession.java:28) INFO | jvm 1 | 2021/07/06 08:29:57 | at com.inductiveautomation.ignition.gateway.localdb.PersistenceInterfaceImpl.getSession(PersistenceInterfaceImpl.java:69) INFO | jvm 1 | 2021/07/06 08:29:57 | at com.inductiveautomation.ignition.gateway.localdb.PersistenceInterfaceImpl.getSession(PersistenceInterfaceImpl.java:46) INFO | jvm 1 | 2021/07/06 08:29:57 | at com.inductiveautomation.ignition.gateway.project.ProjectManagerImpl.getProjectsFull(ProjectManagerImpl.java:1457) INFO | jvm 1 | 2021/07/06 08:29:57 | at com.inductiveautomation.ignition.gateway.servlets.ProjectListServlet.doGet(ProjectListServlet.java:136) INFO | jvm 1 | 2021/07/06 08:29:57 | at javax.servlet.http.HttpServlet.service(HttpServlet.java:687) INFO | jvm 1 | 2021/07/06 08:29:57 | at javax.servlet.http.HttpServlet.service(HttpServlet.java:790) INFO | jvm 1 | 2021/07/06 08:29:57 | at com.inductiveautomation.ignition.gateway.bootstrap.MapServlet.service(MapServlet.java:85) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:837) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:583) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:548) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1160) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1092) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.server.handler.HandlerList.handle(HandlerList.java:52) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.server.Server.handle(Server.java:518) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:308) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:244) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:246) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:156) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654) INFO | jvm 1 | 2021/07/06 08:29:57 | at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572) INFO | jvm 1 | 2021/07/06 08:29:57 | at java.lang.Thread.run(Unknown Source) INFO | jvm 1 | 2021/07/06 08:29:57 | ERROR [TagStore ] [08:29:57,712]: Error storing tag values. INFO | jvm 1 | 2021/07/06 08:29:57 | simpleorm.utils.SException$Jdbc: Opening com.inductiveautomation.ignition.gateway.localdb.sqlite.SingleConnectionDatasource@879d290 INFO | jvm 1 | 2021/07/06 08:29:57 | at simpleorm.sessionjdbc.SSessionJdbc.innerOpen(SSessionJdbc.java:113) INFO | jvm 1 | 2021/07/06 08:29:57 | at com.inductiveautomation.ignition.gateway.localdb.persistence.PersistenceSession.initialize(PersistenceSession.java:28) INFO | jvm 1 | 2021/07/06 08:29:57 | at com.inductiveautomation.ignition.gateway.localdb.PersistenceInterfaceImpl.getSession(PersistenceInterfaceImpl.java:69) INFO | jvm 1 | 2021/07/06 08:29:57 | at com.inductiveautomation.ignition.gateway.localdb.PersistenceInterfaceImpl.getSession(PersistenceInterfaceImpl.java:46) INFO | jvm 1 | 2021/07/06 08:29:57 | at com.inductiveautomation.ignition.gateway.sqltags.tagproviders.internal.InternalTagStore.openIfNot(InternalTagStore.java:1293) INFO | jvm 1 | 2021/07/06 08:29:57 | at com.inductiveautomation.ignition.gateway.sqltags.tagproviders.internal.InternalTagStore.internalStoreTagValues(InternalTagStore.java:1332) INFO | jvm 1 | 2021/07/06 08:29:57 | at com.inductiveautomation.ignition.gateway.sqltags.tagproviders.internal.InternalTagStore.storeTagValues(InternalTagStore.java:1241) INFO | jvm 1 | 2021/07/06 08:29:57 | at com.inductiveautomation.ignition.gateway.sqltags.providers.AbstractStoreBasedTagProvider.tagValuesChanged(AbstractStoreBasedTagProvider.java:2343) INFO | jvm 1 | 2021/07/06 08:29:57 | at com.inductiveautomation.ignition.gateway.sqltags.scanclasses.SimpleExecutableScanClass$ScanClassTagEvaluationContext.processAndReset(SimpleExecutableScanClass.java:1186) INFO | jvm 1 | 2021/07/06 08:29:57 | at com.inductiveautomation.ignition.gateway.sqltags.scanclasses.SimpleExecutableScanClass.run(SimpleExecutableScanClass.java:908) INFO | jvm 1 | 2021/07/06 08:29:57 | at com.inductiveautomation.ignition.common.execution.impl.BasicExecutionEngine$SelfSchedulingRunner.run(BasicExecutionEngine.java:502) INFO | jvm 1 | 2021/07/06 08:29:57 | at com.inductiveautomation.ignition.common.execution.impl.BasicExecutionEngine$TrackedTask.run(BasicExecutionEngine.java:584) INFO | jvm 1 | 2021/07/06 08:29:57 | at java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) INFO | jvm 1 | 2021/07/06 08:29:57 | at java.util.concurrent.FutureTask.run(Unknown Source) INFO | jvm 1 | 2021/07/06 08:29:57 | at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(Unknown Source) INFO | jvm 1 | 2021/07/06 08:29:57 | at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(Unknown Source) INFO | jvm 1 | 2021/07/06 08:29:57 | at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source) INFO | jvm 1 | 2021/07/06 08:29:57 | at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source) INFO | jvm 1 | 2021/07/06 08:29:57 | at java.lang.Thread.run(Unknown Source) INFO | jvm 1 | 2021/07/06 08:29:57 | Caused by: java.sql.SQLException: Connection is locked. Datasource only allows one connection at a time. To log the concurrent connection, turn the logger 'com.inductiveautomation.ignition.gateway.localdb.sqlite.SingleConnectionDatasource' to DEBUG. INFO | jvm 1 | 2021/07/06 08:29:57 | at com.inductiveautomation.ignition.gateway.localdb.sqlite.SingleConnectionDatasource.getConnection(SingleConnectionDatasource.java:58) INFO | jvm 1 | 2021/07/06 08:29:57 | at simpleorm.sessionjdbc.SSessionJdbc.innerOpen(SSessionJdbc.java:111) INFO | jvm 1 | 2021/07/06 08:29:57 | ... 18 more INFO | jvm 1 | 2021/07/06 08:29:57 | DEBUG [SingleConnectionDatasource ] [08:29:57,739]: Attempting to get connection. INFO | jvm 1 | 2021/07/06 08:30:18 | ERROR [SingleConnectionDatasource ] [08:30:18,253]: The following stack successfully received a connection. A new attempt was blocked for over 30000 ms INFO | jvm 1 | 2021/07/06 08:30:18 | java.lang.Throwable INFO | jvm 1 | 2021/07/06 08:30:18 | at com.inductiveautomation.ignition.gateway.localdb.sqlite.SingleConnectionDatasource.getConnection(SingleConnectionDatasource.java:43) INFO | jvm 1 | 2021/07/06 08:30:18 | at com.inductiveautomation.ignition.gateway.localdb.DelegatingDataSource.getConnection(DelegatingDataSource.java:59) INFO | jvm 1 | 2021/07/06 08:30:18 | at simpleorm.sessionjdbc.SSessionJdbc.innerOpen(SSessionJdbc.java:111) INFO | jvm 1 | 2021/07/06 08:30:18 | at com.inductiveautomation.ignition.gateway.localdb.persistence.PersistenceSession.initialize(PersistenceSession.java:28) INFO | jvm 1 | 2021/07/06 08:30:18 | at com.inductiveautomation.ignition.gateway.localdb.PersistenceInterfaceImpl.getSession(PersistenceInterfaceImpl.java:69) INFO | jvm 1 | 2021/07/06 08:30:18 | at com.inductiveautomation.ignition.gateway.localdb.PersistenceInterfaceImpl.getSession(PersistenceInterfaceImpl.java:46) INFO | jvm 1 | 2021/07/06 08:30:18 | at com.inductiveautomation.ignition.gateway.project.ProjectManagerImpl.getProjectsFull(ProjectManagerImpl.java:1457) INFO | jvm 1 | 2021/07/06 08:30:18 | at com.inductiveautomation.ignition.gateway.servlets.ProjectListServlet.doGet(ProjectListServlet.java:136) INFO | jvm 1 | 2021/07/06 08:30:18 | at javax.servlet.http.HttpServlet.service(HttpServlet.java:687) INFO | jvm 1 | 2021/07/06 08:30:18 | at javax.servlet.http.HttpServlet.service(HttpServlet.java:790) INFO | jvm 1 | 2021/07/06 08:30:18 | at com.inductiveautomation.ignition.gateway.bootstrap.MapServlet.service(MapServlet.java:85) INFO | jvm 1 | 2021/07/06 08:30:18 | at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:837) INFO | jvm 1 | 2021/07/06 08:30:18 | at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:583) INFO | jvm 1 | 2021/07/06 08:30:18 | at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143) INFO | jvm 1 | 2021/07/06 08:30:18 | at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:548) INFO | jvm 1 | 2021/07/06 08:30:18 | at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226) INFO | jvm 1 | 2021/07/06 08:30:18 | at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1160) INFO | jvm 1 | 2021/07/06 08:30:18 | at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511) INFO | jvm 1 | 2021/07/06 08:30:18 | at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185) INFO | jvm 1 | 2021/07/06 08:30:18 | at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1092) INFO | jvm 1 | 2021/07/06 08:30:18 | at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) INFO | jvm 1 | 2021/07/06 08:30:18 | at org.eclipse.jetty.server.handler.HandlerList.handle(HandlerList.java:52) INFO | jvm 1 | 2021/07/06 08:30:18 | at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134) INFO | jvm 1 | 2021/07/06 08:30:18 | at org.eclipse.jetty.server.Server.handle(Server.java:518) INFO | jvm 1 | 2021/07/06 08:30:18 | at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:308) INFO | jvm 1 | 2021/07/06 08:30:18 | at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:244) INFO | jvm 1 | 2021/07/06 08:30:18 | at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273) INFO | jvm 1 | 2021/07/06 08:30:18 | at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95) INFO | jvm 1 | 2021/07/06 08:30:18 | at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93) INFO | jvm 1 | 2021/07/06 08:30:18 | at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:246) INFO | jvm 1 | 2021/07/06 08:30:18 | at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:156) INFO | jvm 1 | 2021/07/06 08:30:18 | at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654) INFO | jvm 1 | 2021/07/06 08:30:18 | at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572) INFO | jvm 1 | 2021/07/06 08:30:18 | at java.lang.Thread.run(Unknown Source) INFO | jvm 1 | 2021/07/06 08:30:18 | DEBUG [SingleConnectionDatasource ] [08:30:18,254]: Attempting to get connection. INFO | jvm 1 | 2021/07/06 08:30:22 | DEBUG [SingleConnectionDatasource ] [08:30:22,559]: SingleConnectionDS: Closed id '73138269' INFO | jvm 1 | 2021/07/06 08:30:22 | DEBUG [SingleConnectionDatasource ] [08:30:22,560]: Attempting to get connection. INFO | jvm 1 | 2021/07/06 08:30:22 | DEBUG [SingleConnectionDatasource ] [08:30:22,560]: SingleConnectionDS: Connection 73138270 Created INFO | jvm 1 | 2021/07/06 08:30:22 | DEBUG [SingleConnectionDatasource ] [08:30:22,567]: SingleConnectionDS: Closed id '73138270'