ASLF4J: Failed to load class "org.slf4j.impl.StaticLoggerBinder". >SLF4J: Defaulting to no-operation (NOP) logger implementation SSLF4J: See http://www.slf4j.org/codes.html#StaticLoggerBinder for further details. KJul 31, 2024 10:45:30 AM com.ustadmobile.door.log.NapierAntilog performLog ^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete KJul 31, 2024 10:45:30 AM com.ustadmobile.door.log.NapierAntilog performLog ÀFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[ExampleEntity3, OutgoingReplication] KJul 31, 2024 10:45:30 AM com.ustadmobile.door.log.NapierAntilog performLog –FINE: [DEBUG] DoorLog - [NodeEventJdbcImplListenerSqlite - jdbc:sqlite::memory:] emitting 1 events com.ustadmobile.door.nodeevent.NodeEvent@618d086a KJul 31, 2024 10:45:30 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:30 AM com.ustadmobile.door.log.NapierAntilog performLog ^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete KJul 31, 2024 10:45:30 AM com.ustadmobile.door.log.NapierAntilog performLog ÁFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[ExampleEntity3, ReplicationOperation] KJul 31, 2024 10:45:30 AM com.ustadmobile.door.log.NapierAntilog performLog ˆFINE: [DEBUG] DoorLog - [NodeEventManager - jdbc:sqlite::memory:] receiveMessage with 1 replications: inserts done/transaction finished KJul 31, 2024 10:45:30 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool  KJul 31, 2024 10:45:30 AM com.ustadmobile.door.log.NapierAntilog performLog  ^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete  KJul 31, 2024 10:45:30 AM com.ustadmobile.door.log.NapierAntilog performLog  ÀFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[ExampleEntity3, OutgoingReplication]  KJul 31, 2024 10:45:30 AM com.ustadmobile.door.log.NapierAntilog performLog  –FINE: [DEBUG] DoorLog - [NodeEventJdbcImplListenerSqlite - jdbc:sqlite::memory:] emitting 1 events com.ustadmobile.door.nodeevent.NodeEvent@5e91c0f6  KJul 31, 2024 10:45:30 AM com.ustadmobile.door.log.NapierAntilog performLog  °FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #3 : SQLite Change Tracker: Changed tables=[OutgoingReplication]  KJul 31, 2024 10:45:30 AM com.ustadmobile.door.log.NapierAntilog performLog  @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool  KJul 31, 2024 10:45:30 AM com.ustadmobile.door.log.NapierAntilog performLog  ^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete  KJul 31, 2024 10:45:31 AM com.ustadmobile.door.log.NapierAntilog performLog  ŸFINE: [DEBUG] ReplicationRouteTest$givenServerSentEventsClientConnected_whenNewOutgoingReplicationIsPending_thenWillReceiveEvent$invokeSuspend - insert entity  KJul 31, 2024 10:45:31 AM com.ustadmobile.door.log.NapierAntilog performLog  ¤FINE: [DEBUG] ReplicationRouteTest$givenServerSentEventsClientConnected_whenNewOutgoingReplicationIsPending_thenWillReceiveEvent$invokeSuspend - insert replication  KJul 31, 2024 10:45:31 AM com.ustadmobile.door.log.NapierAntilog performLog  ÀFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[ExampleEntity3, OutgoingReplication]  KJul 31, 2024 10:45:31 AM com.ustadmobile.door.log.NapierAntilog performLog  –FINE: [DEBUG] DoorLog - [NodeEventJdbcImplListenerSqlite - jdbc:sqlite::memory:] emitting 1 events com.ustadmobile.door.nodeevent.NodeEvent@2417856a  KJul 31, 2024 10:45:31 AM com.ustadmobile.door.log.NapierAntilog performLog  ŠSEVERE: [ERROR] DoorEventSource$eventSourceListener$1$onFailure$invokeSuspend - [DoorEventSource@com.ustadmobile.door.sse.DoorEventSource@28a8c71f - http://localhost:8094/sse?door-node=123%2Fsecret] error: java.io.EOFException . Attempting to reconnect after 1000ms  KJul 31, 2024 10:45:32 AM com.ustadmobile.door.log.NapierAntilog performLog  @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool  KJul 31, 2024 10:45:32 AM com.ustadmobile.door.log.NapierAntilog performLog  •FINE: [DEBUG] DoorLog - [DoorEventSource@com.ustadmobile.door.sse.DoorEventSource@28a8c71f - http://localhost:8094/sse?door-node=123%2Fsecret] close KJul 31, 2024 10:45:32 AM com.ustadmobile.door.log.NapierAntilog performLog ^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete KJul 31, 2024 10:45:32 AM com.ustadmobile.door.log.NapierAntilog performLog ^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete KJul 31, 2024 10:45:32 AM com.ustadmobile.door.log.NapierAntilog performLog ÀFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[ExampleEntity3, OutgoingReplication] KJul 31, 2024 10:45:32 AM com.ustadmobile.door.log.NapierAntilog performLog –FINE: [DEBUG] DoorLog - [NodeEventJdbcImplListenerSqlite - jdbc:sqlite::memory:] emitting 1 events com.ustadmobile.door.nodeevent.NodeEvent@50536310 KJul 31, 2024 10:45:32 AM com.ustadmobile.door.log.NapierAntilog performLog ÁFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[ExampleEntity3, ReplicationOperation] KJul 31, 2024 10:45:32 AM com.ustadmobile.door.log.NapierAntilog performLog ˆFINE: [DEBUG] DoorLog - [NodeEventManager - jdbc:sqlite::memory:] receiveMessage with 1 replications: inserts done/transaction finished KJul 31, 2024 10:45:32 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:32 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:32 AM com.ustadmobile.door.log.NapierAntilog performLog ^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete KJul 31, 2024 10:45:32 AM com.ustadmobile.door.log.NapierAntilog performLog ÀFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[ExampleEntity3, OutgoingReplication] KJul 31, 2024 10:45:32 AM com.ustadmobile.door.log.NapierAntilog performLog –FINE: [DEBUG] DoorLog - [NodeEventJdbcImplListenerSqlite - jdbc:sqlite::memory:] emitting 1 events com.ustadmobile.door.nodeevent.NodeEvent@1f7ad3c5  *Received nodeEvent for 620960926043062272 KJul 31, 2024 10:45:32 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:32 AM com.ustadmobile.door.log.NapierAntilog performLog RINFO: [INFO] DoorLog - [DatabaseBuilder.build - clientDb] database build complete KJul 31, 2024 10:45:32 AM com.ustadmobile.door.log.NapierAntilog performLog RINFO: [INFO] DoorLog - [DatabaseBuilder.build - serverDb] database build complete KJul 31, 2024 10:45:32 AM com.ustadmobile.door.log.NapierAntilog performLog —FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - serverDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[Member] KJul 31, 2024 10:45:32 AM com.ustadmobile.door.log.NapierAntilog performLog ŸFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - serverDb] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[DiscussionPost] KJul 31, 2024 10:45:32 AM com.ustadmobile.door.log.NapierAntilog performLog lFINE: [DEBUG] DoorLog - [DoorRepositoryReplicationClient - clientDb - endpoint=http://localhost:8094/] init KJul 31, 2024 10:45:32 AM com.ustadmobile.door.log.NapierAntilog performLog ©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] KJul 31, 2024 10:45:32 AM com.ustadmobile.door.log.NapierAntilog performLog ©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] KJul 31, 2024 10:45:32 AM com.ustadmobile.door.log.NapierAntilog performLog ‘FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #3 : SQLite Change Tracker: Changed tables=[] KJul 31, 2024 10:45:32 AM com.ustadmobile.door.log.NapierAntilog performLog ½FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #4 : SQLite Change Tracker: Changed tables=[DiscussionPost, Member, ReplicationOperation] KJul 31, 2024 10:45:32 AM com.ustadmobile.door.log.NapierAntilog performLog |FINE: [DEBUG] DoorLog - [NodeEventManager - clientDb] receiveMessage with 2 replications: inserts done/transaction finished KJul 31, 2024 10:45:32 AM com.ustadmobile.door.log.NapierAntilog performLog ŸFINE: [DEBUG] DoorLog - [DoorEventSource@com.ustadmobile.door.sse.DoorEventSource@4492eede - http://localhost:8094/replication/sse?door-node=2%2Fsecret] close KJul 31, 2024 10:45:33 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:33 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:33 AM com.ustadmobile.door.log.NapierAntilog performLog RINFO: [INFO] DoorLog - [DatabaseBuilder.build - clientDb] database build complete KJul 31, 2024 10:45:33 AM com.ustadmobile.door.log.NapierAntilog performLog RINFO: [INFO] DoorLog - [DatabaseBuilder.build - serverDb] database build complete KJul 31, 2024 10:45:33 AM com.ustadmobile.door.log.NapierAntilog performLog —FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - serverDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[Member] KJul 31, 2024 10:45:33 AM com.ustadmobile.door.log.NapierAntilog performLog ŸFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - serverDb] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[DiscussionPost] KJul 31, 2024 10:45:33 AM com.ustadmobile.door.log.NapierAntilog performLog lFINE: [DEBUG] DoorLog - [DoorRepositoryReplicationClient - clientDb - endpoint=http://localhost:8094/] init KJul 31, 2024 10:45:33 AM com.ustadmobile.door.log.NapierAntilog performLog ©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] KJul 31, 2024 10:45:33 AM com.ustadmobile.door.log.NapierAntilog performLog ©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] KJul 31, 2024 10:45:33 AM com.ustadmobile.door.log.NapierAntilog performLog ‘FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #3 : SQLite Change Tracker: Changed tables=[] KJul 31, 2024 10:45:33 AM com.ustadmobile.door.log.NapierAntilog performLog ŸFINE: [DEBUG] DoorLog - [DoorEventSource@com.ustadmobile.door.sse.DoorEventSource@3531f3ca - http://localhost:8094/replication/sse?door-node=2%2Fsecret] close KJul 31, 2024 10:45:34 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:34 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:34 AM com.ustadmobile.door.log.NapierAntilog performLog RINFO: [INFO] DoorLog - [DatabaseBuilder.build - clientDb] database build complete KJul 31, 2024 10:45:34 AM com.ustadmobile.door.log.NapierAntilog performLog RINFO: [INFO] DoorLog - [DatabaseBuilder.build - serverDb] database build complete KJul 31, 2024 10:45:34 AM com.ustadmobile.door.log.NapierAntilog performLog —FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - serverDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[Member] KJul 31, 2024 10:45:34 AM com.ustadmobile.door.log.NapierAntilog performLog ŸFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - serverDb] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[DiscussionPost] KJul 31, 2024 10:45:34 AM com.ustadmobile.door.log.NapierAntilog performLog ŸFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - serverDb] - useNewConnectionAsyncInternal connection #3 : SQLite Change Tracker: Changed tables=[DiscussionPost] KJul 31, 2024 10:45:34 AM com.ustadmobile.door.log.NapierAntilog performLog lFINE: [DEBUG] DoorLog - [DoorRepositoryReplicationClient - clientDb - endpoint=http://localhost:8094/] init KJul 31, 2024 10:45:34 AM com.ustadmobile.door.log.NapierAntilog performLog ©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] KJul 31, 2024 10:45:34 AM com.ustadmobile.door.log.NapierAntilog performLog ©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] KJul 31, 2024 10:45:34 AM com.ustadmobile.door.log.NapierAntilog performLog ‘FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #3 : SQLite Change Tracker: Changed tables=[] KJul 31, 2024 10:45:34 AM com.ustadmobile.door.log.NapierAntilog performLog µFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #4 : SQLite Change Tracker: Changed tables=[DiscussionPost, ReplicationOperation] KJul 31, 2024 10:45:34 AM com.ustadmobile.door.log.NapierAntilog performLog |FINE: [DEBUG] DoorLog - [NodeEventManager - clientDb] receiveMessage with 2 replications: inserts done/transaction finished KJul 31, 2024 10:45:34 AM com.ustadmobile.door.log.NapierAntilog performLog ŸFINE: [DEBUG] DoorLog - [DoorEventSource@com.ustadmobile.door.sse.DoorEventSource@63411512 - http://localhost:8094/replication/sse?door-node=2%2Fsecret] close KJul 31, 2024 10:45:35 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:35 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:35 AM com.ustadmobile.door.log.NapierAntilog performLog RINFO: [INFO] DoorLog - [DatabaseBuilder.build - clientDb] database build complete KJul 31, 2024 10:45:35 AM com.ustadmobile.door.log.NapierAntilog performLog RINFO: [INFO] DoorLog - [DatabaseBuilder.build - serverDb] database build complete KJul 31, 2024 10:45:35 AM com.ustadmobile.door.log.NapierAntilog performLog —FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - serverDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[Member] KJul 31, 2024 10:45:35 AM com.ustadmobile.door.log.NapierAntilog performLog ŸFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - serverDb] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[DiscussionPost] KJul 31, 2024 10:45:35 AM com.ustadmobile.door.log.NapierAntilog performLog lFINE: [DEBUG] DoorLog - [DoorRepositoryReplicationClient - clientDb - endpoint=http://localhost:8094/] init KJul 31, 2024 10:45:35 AM com.ustadmobile.door.log.NapierAntilog performLog ©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] KJul 31, 2024 10:45:35 AM com.ustadmobile.door.log.NapierAntilog performLog ŸFINE: [DEBUG] DoorLog - [DoorEventSource@com.ustadmobile.door.sse.DoorEventSource@3e17a0a1 - http://localhost:8094/replication/sse?door-node=2%2Fsecret] close KJul 31, 2024 10:45:35 AM com.ustadmobile.door.log.NapierAntilog performLog ©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #3 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] KJul 31, 2024 10:45:35 AM com.ustadmobile.door.log.NapierAntilog performLog ‘FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #4 : SQLite Change Tracker: Changed tables=[] KJul 31, 2024 10:45:36 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:36 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:36 AM com.ustadmobile.door.log.NapierAntilog performLog RINFO: [INFO] DoorLog - [DatabaseBuilder.build - clientDb] database build complete KJul 31, 2024 10:45:36 AM com.ustadmobile.door.log.NapierAntilog performLog RINFO: [INFO] DoorLog - [DatabaseBuilder.build - serverDb] database build complete KJul 31, 2024 10:45:36 AM com.ustadmobile.door.log.NapierAntilog performLog —FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - serverDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[Member] KJul 31, 2024 10:45:36 AM com.ustadmobile.door.log.NapierAntilog performLog ŸFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - serverDb] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[DiscussionPost] KJul 31, 2024 10:45:36 AM com.ustadmobile.door.log.NapierAntilog performLog ŸFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - serverDb] - useNewConnectionAsyncInternal connection #3 : SQLite Change Tracker: Changed tables=[DiscussionPost] KJul 31, 2024 10:45:36 AM com.ustadmobile.door.log.NapierAntilog performLog lFINE: [DEBUG] DoorLog - [DoorRepositoryReplicationClient - clientDb - endpoint=http://localhost:8094/] init KJul 31, 2024 10:45:36 AM com.ustadmobile.door.log.NapierAntilog performLog ©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] KJul 31, 2024 10:45:36 AM com.ustadmobile.door.log.NapierAntilog performLog ©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #3 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] KJul 31, 2024 10:45:36 AM com.ustadmobile.door.log.NapierAntilog performLog ‘FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #4 : SQLite Change Tracker: Changed tables=[] KJul 31, 2024 10:45:36 AM com.ustadmobile.door.log.NapierAntilog performLog µFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #5 : SQLite Change Tracker: Changed tables=[DiscussionPost, ReplicationOperation] KJul 31, 2024 10:45:36 AM com.ustadmobile.door.log.NapierAntilog performLog |FINE: [DEBUG] DoorLog - [NodeEventManager - clientDb] receiveMessage with 2 replications: inserts done/transaction finished KJul 31, 2024 10:45:36 AM com.ustadmobile.door.log.NapierAntilog performLog £FINE: [DEBUG] DoorLimitOffsetPagingSource$InvalidationTracker$onInvalidated - DoorLimitOffsetPagingSource: invalidated tables=DiscussionPost, ReplicationOperation  fInvalidated PagingSource com.ustadmobile.door.paging.DoorRepositoryReplicatePullPagingSource@1204b54b KJul 31, 2024 10:45:36 AM com.ustadmobile.door.log.NapierAntilog performLog ŸFINE: [DEBUG] DoorLog - [DoorEventSource@com.ustadmobile.door.sse.DoorEventSource@3e7c4815 - http://localhost:8094/replication/sse?door-node=2%2Fsecret] close KJul 31, 2024 10:45:37 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:37 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:37 AM com.ustadmobile.door.log.NapierAntilog performLog RINFO: [INFO] DoorLog - [DatabaseBuilder.build - clientDb] database build complete KJul 31, 2024 10:45:37 AM com.ustadmobile.door.log.NapierAntilog performLog RINFO: [INFO] DoorLog - [DatabaseBuilder.build - serverDb] database build complete KJul 31, 2024 10:45:37 AM com.ustadmobile.door.log.NapierAntilog performLog —FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - serverDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[Member] KJul 31, 2024 10:45:37 AM com.ustadmobile.door.log.NapierAntilog performLog ŸFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - serverDb] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[DiscussionPost] KJul 31, 2024 10:45:37 AM com.ustadmobile.door.log.NapierAntilog performLog lFINE: [DEBUG] DoorLog - [DoorRepositoryReplicationClient - clientDb - endpoint=http://localhost:8094/] init KJul 31, 2024 10:45:37 AM com.ustadmobile.door.log.NapierAntilog performLog ©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] KJul 31, 2024 10:45:37 AM com.ustadmobile.door.log.NapierAntilog performLog ©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #3 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] KJul 31, 2024 10:45:37 AM com.ustadmobile.door.log.NapierAntilog performLog ‘FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #4 : SQLite Change Tracker: Changed tables=[] KJul 31, 2024 10:45:37 AM com.ustadmobile.door.log.NapierAntilog performLog ½FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #5 : SQLite Change Tracker: Changed tables=[DiscussionPost, Member, ReplicationOperation] KJul 31, 2024 10:45:37 AM com.ustadmobile.door.log.NapierAntilog performLog |FINE: [DEBUG] DoorLog - [NodeEventManager - clientDb] receiveMessage with 2 replications: inserts done/transaction finished KJul 31, 2024 10:45:37 AM com.ustadmobile.door.log.NapierAntilog performLog ŸFINE: [DEBUG] DoorLog - [DoorEventSource@com.ustadmobile.door.sse.DoorEventSource@3a08078c - http://localhost:8094/replication/sse?door-node=2%2Fsecret] close KJul 31, 2024 10:45:38 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:38 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:38 AM com.ustadmobile.door.log.NapierAntilog performLog RINFO: [INFO] DoorLog - [DatabaseBuilder.build - clientDb] database build complete KJul 31, 2024 10:45:38 AM com.ustadmobile.door.log.NapierAntilog performLog RINFO: [INFO] DoorLog - [DatabaseBuilder.build - serverDb] database build complete KJul 31, 2024 10:45:38 AM com.ustadmobile.door.log.NapierAntilog performLog –FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - serverDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[Badge] KJul 31, 2024 10:45:38 AM com.ustadmobile.door.log.NapierAntilog performLog lFINE: [DEBUG] DoorLog - [DoorRepositoryReplicationClient - clientDb - endpoint=http://localhost:8094/] init KJul 31, 2024 10:45:38 AM com.ustadmobile.door.log.NapierAntilog performLog ©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] KJul 31, 2024 10:45:38 AM com.ustadmobile.door.log.NapierAntilog performLog ©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] KJul 31, 2024 10:45:38 AM com.ustadmobile.door.log.NapierAntilog performLog ‘FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #3 : SQLite Change Tracker: Changed tables=[] KJul 31, 2024 10:45:38 AM com.ustadmobile.door.log.NapierAntilog performLog ¬FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #4 : SQLite Change Tracker: Changed tables=[ReplicationOperation, Badge] KJul 31, 2024 10:45:38 AM com.ustadmobile.door.log.NapierAntilog performLog |FINE: [DEBUG] DoorLog - [NodeEventManager - clientDb] receiveMessage with 1 replications: inserts done/transaction finished KJul 31, 2024 10:45:38 AM com.ustadmobile.door.log.NapierAntilog performLog ŸFINE: [DEBUG] DoorLog - [DoorEventSource@com.ustadmobile.door.sse.DoorEventSource@35f639fa - http://localhost:8094/replication/sse?door-node=2%2Fsecret] close KJul 31, 2024 10:45:39 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:39 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:39 AM com.ustadmobile.door.log.NapierAntilog performLog RINFO: [INFO] DoorLog - [DatabaseBuilder.build - clientDb] database build complete KJul 31, 2024 10:45:39 AM com.ustadmobile.door.log.NapierAntilog performLog RINFO: [INFO] DoorLog - [DatabaseBuilder.build - serverDb] database build complete KJul 31, 2024 10:45:39 AM com.ustadmobile.door.log.NapierAntilog performLog —FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - serverDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[Member] KJul 31, 2024 10:45:39 AM com.ustadmobile.door.log.NapierAntilog performLog ŸFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - serverDb] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[DiscussionPost] KJul 31, 2024 10:45:39 AM com.ustadmobile.door.log.NapierAntilog performLog ŸFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - serverDb] - useNewConnectionAsyncInternal connection #3 : SQLite Change Tracker: Changed tables=[DiscussionPost] KJul 31, 2024 10:45:39 AM com.ustadmobile.door.log.NapierAntilog performLog lFINE: [DEBUG] DoorLog - [DoorRepositoryReplicationClient - clientDb - endpoint=http://localhost:8094/] init KJul 31, 2024 10:45:39 AM com.ustadmobile.door.log.NapierAntilog performLog ©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] KJul 31, 2024 10:45:39 AM com.ustadmobile.door.log.NapierAntilog performLog ©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] KJul 31, 2024 10:45:39 AM com.ustadmobile.door.log.NapierAntilog performLog ‘FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #3 : SQLite Change Tracker: Changed tables=[] KJul 31, 2024 10:45:39 AM com.ustadmobile.door.log.NapierAntilog performLog µFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #4 : SQLite Change Tracker: Changed tables=[DiscussionPost, ReplicationOperation] KJul 31, 2024 10:45:39 AM com.ustadmobile.door.log.NapierAntilog performLog |FINE: [DEBUG] DoorLog - [NodeEventManager - clientDb] receiveMessage with 1 replications: inserts done/transaction finished KJul 31, 2024 10:45:39 AM com.ustadmobile.door.log.NapierAntilog performLog ŸFINE: [DEBUG] DoorLog - [DoorEventSource@com.ustadmobile.door.sse.DoorEventSource@38aafb53 - http://localhost:8094/replication/sse?door-node=5%2Fsecret] close KJul 31, 2024 10:45:40 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:40 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:40 AM com.ustadmobile.door.log.NapierAntilog performLog RINFO: [INFO] DoorLog - [DatabaseBuilder.build - clientDb] database build complete KJul 31, 2024 10:45:40 AM com.ustadmobile.door.log.NapierAntilog performLog RINFO: [INFO] DoorLog - [DatabaseBuilder.build - serverDb] database build complete KJul 31, 2024 10:45:40 AM com.ustadmobile.door.log.NapierAntilog performLog —FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - serverDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[Member] KJul 31, 2024 10:45:40 AM com.ustadmobile.door.log.NapierAntilog performLog ŸFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - serverDb] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[DiscussionPost] KJul 31, 2024 10:45:40 AM com.ustadmobile.door.log.NapierAntilog performLog lFINE: [DEBUG] DoorLog - [DoorRepositoryReplicationClient - clientDb - endpoint=http://localhost:8094/] init KJul 31, 2024 10:45:40 AM com.ustadmobile.door.log.NapierAntilog performLog ©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] KJul 31, 2024 10:45:40 AM com.ustadmobile.door.log.NapierAntilog performLog ©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] KJul 31, 2024 10:45:40 AM com.ustadmobile.door.log.NapierAntilog performLog ‘FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #3 : SQLite Change Tracker: Changed tables=[] KJul 31, 2024 10:45:40 AM com.ustadmobile.door.log.NapierAntilog performLog ½FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #4 : SQLite Change Tracker: Changed tables=[DiscussionPost, Member, ReplicationOperation] KJul 31, 2024 10:45:40 AM com.ustadmobile.door.log.NapierAntilog performLog |FINE: [DEBUG] DoorLog - [NodeEventManager - clientDb] receiveMessage with 2 replications: inserts done/transaction finished KJul 31, 2024 10:45:40 AM com.ustadmobile.door.log.NapierAntilog performLog ŸFINE: [DEBUG] DoorLog - [DoorEventSource@com.ustadmobile.door.sse.DoorEventSource@245ec1a6 - http://localhost:8094/replication/sse?door-node=2%2Fsecret] close KJul 31, 2024 10:45:41 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:41 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:41 AM com.ustadmobile.door.log.NapierAntilog performLog RINFO: [INFO] DoorLog - [DatabaseBuilder.build - clientDb] database build complete KJul 31, 2024 10:45:41 AM com.ustadmobile.door.log.NapierAntilog performLog RINFO: [INFO] DoorLog - [DatabaseBuilder.build - serverDb] database build complete KJul 31, 2024 10:45:41 AM com.ustadmobile.door.log.NapierAntilog performLog —FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - serverDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[Member] KJul 31, 2024 10:45:41 AM com.ustadmobile.door.log.NapierAntilog performLog lFINE: [DEBUG] DoorLog - [DoorRepositoryReplicationClient - clientDb - endpoint=http://localhost:8094/] init KJul 31, 2024 10:45:41 AM com.ustadmobile.door.log.NapierAntilog performLog ©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] KJul 31, 2024 10:45:41 AM com.ustadmobile.door.log.NapierAntilog performLog ŸFINE: [DEBUG] DoorLog - [DoorEventSource@com.ustadmobile.door.sse.DoorEventSource@5cbe2654 - http://localhost:8094/replication/sse?door-node=2%2Fsecret] close KJul 31, 2024 10:45:41 AM com.ustadmobile.door.log.NapierAntilog performLog ©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] KJul 31, 2024 10:45:41 AM com.ustadmobile.door.log.NapierAntilog performLog ‘FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #3 : SQLite Change Tracker: Changed tables=[] KJul 31, 2024 10:45:42 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:42 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:42 AM com.ustadmobile.door.log.NapierAntilog performLog RINFO: [INFO] DoorLog - [DatabaseBuilder.build - clientDb] database build complete KJul 31, 2024 10:45:42 AM com.ustadmobile.door.log.NapierAntilog performLog RINFO: [INFO] DoorLog - [DatabaseBuilder.build - serverDb] database build complete KJul 31, 2024 10:45:42 AM com.ustadmobile.door.log.NapierAntilog performLog ŸFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - serverDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[DiscussionPost] KJul 31, 2024 10:45:42 AM com.ustadmobile.door.log.NapierAntilog performLog lFINE: [DEBUG] DoorLog - [DoorRepositoryReplicationClient - clientDb - endpoint=http://localhost:8094/] init KJul 31, 2024 10:45:42 AM com.ustadmobile.door.log.NapierAntilog performLog ©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] KJul 31, 2024 10:45:42 AM com.ustadmobile.door.log.NapierAntilog performLog ŸFINE: [DEBUG] DoorLog - [DoorEventSource@com.ustadmobile.door.sse.DoorEventSource@3bddc676 - http://localhost:8094/replication/sse?door-node=2%2Fsecret] close KJul 31, 2024 10:45:42 AM com.ustadmobile.door.log.NapierAntilog performLog ©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] KJul 31, 2024 10:45:43 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:43 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:43 AM com.ustadmobile.door.log.NapierAntilog performLog RINFO: [INFO] DoorLog - [DatabaseBuilder.build - clientDb] database build complete KJul 31, 2024 10:45:43 AM com.ustadmobile.door.log.NapierAntilog performLog RINFO: [INFO] DoorLog - [DatabaseBuilder.build - serverDb] database build complete KJul 31, 2024 10:45:43 AM com.ustadmobile.door.log.NapierAntilog performLog  FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - serverDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[StatementEntity] KJul 31, 2024 10:45:43 AM com.ustadmobile.door.log.NapierAntilog performLog lFINE: [DEBUG] DoorLog - [DoorRepositoryReplicationClient - clientDb - endpoint=http://localhost:8094/] init KJul 31, 2024 10:45:43 AM com.ustadmobile.door.log.NapierAntilog performLog ©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] KJul 31, 2024 10:45:43 AM com.ustadmobile.door.log.NapierAntilog performLog ©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] KJul 31, 2024 10:45:43 AM com.ustadmobile.door.log.NapierAntilog performLog ‘FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #3 : SQLite Change Tracker: Changed tables=[] KJul 31, 2024 10:45:43 AM com.ustadmobile.door.log.NapierAntilog performLog ¶FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #4 : SQLite Change Tracker: Changed tables=[ReplicationOperation, StatementEntity] KJul 31, 2024 10:45:43 AM com.ustadmobile.door.log.NapierAntilog performLog |FINE: [DEBUG] DoorLog - [NodeEventManager - clientDb] receiveMessage with 1 replications: inserts done/transaction finished KJul 31, 2024 10:45:43 AM com.ustadmobile.door.log.NapierAntilog performLog ŸFINE: [DEBUG] DoorLog - [DoorEventSource@com.ustadmobile.door.sse.DoorEventSource@2241f05b - http://localhost:8094/replication/sse?door-node=2%2Fsecret] close KJul 31, 2024 10:45:44 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:44 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:44 AM com.ustadmobile.door.log.NapierAntilog performLog RINFO: [INFO] DoorLog - [DatabaseBuilder.build - clientDb] database build complete KJul 31, 2024 10:45:44 AM com.ustadmobile.door.log.NapierAntilog performLog RINFO: [INFO] DoorLog - [DatabaseBuilder.build - serverDb] database build complete KJul 31, 2024 10:45:44 AM com.ustadmobile.door.log.NapierAntilog performLog —FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - serverDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[Member] KJul 31, 2024 10:45:44 AM com.ustadmobile.door.log.NapierAntilog performLog ŸFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - serverDb] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[DiscussionPost] KJul 31, 2024 10:45:44 AM com.ustadmobile.door.log.NapierAntilog performLog lFINE: [DEBUG] DoorLog - [DoorRepositoryReplicationClient - clientDb - endpoint=http://localhost:8094/] init KJul 31, 2024 10:45:44 AM com.ustadmobile.door.log.NapierAntilog performLog ©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] KJul 31, 2024 10:45:44 AM com.ustadmobile.door.log.NapierAntilog performLog ½FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[DiscussionPost, Member, ReplicationOperation] KJul 31, 2024 10:45:44 AM com.ustadmobile.door.log.NapierAntilog performLog |FINE: [DEBUG] DoorLog - [NodeEventManager - clientDb] receiveMessage with 2 replications: inserts done/transaction finished KJul 31, 2024 10:45:44 AM com.ustadmobile.door.log.NapierAntilog performLog ©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #3 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] KJul 31, 2024 10:45:44 AM com.ustadmobile.door.log.NapierAntilog performLog ‘FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #4 : SQLite Change Tracker: Changed tables=[] KJul 31, 2024 10:45:44 AM com.ustadmobile.door.log.NapierAntilog performLog ­FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #6 : SQLite Change Tracker: Changed tables=[Member, ReplicationOperation] KJul 31, 2024 10:45:44 AM com.ustadmobile.door.log.NapierAntilog performLog |FINE: [DEBUG] DoorLog - [NodeEventManager - clientDb] receiveMessage with 2 replications: inserts done/transaction finished KJul 31, 2024 10:45:44 AM com.ustadmobile.door.log.NapierAntilog performLog ŸFINE: [DEBUG] DoorLog - [DoorEventSource@com.ustadmobile.door.sse.DoorEventSource@37e0292a - http://localhost:8094/replication/sse?door-node=2%2Fsecret] close KJul 31, 2024 10:45:45 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:45 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:45 AM com.ustadmobile.door.log.NapierAntilog performLog RINFO: [INFO] DoorLog - [DatabaseBuilder.build - clientDb] database build complete KJul 31, 2024 10:45:45 AM com.ustadmobile.door.log.NapierAntilog performLog RINFO: [INFO] DoorLog - [DatabaseBuilder.build - serverDb] database build complete KJul 31, 2024 10:45:45 AM com.ustadmobile.door.log.NapierAntilog performLog —FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - serverDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[Member] KJul 31, 2024 10:45:45 AM com.ustadmobile.door.log.NapierAntilog performLog ŸFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - serverDb] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[DiscussionPost] KJul 31, 2024 10:45:45 AM com.ustadmobile.door.log.NapierAntilog performLog lFINE: [DEBUG] DoorLog - [DoorRepositoryReplicationClient - clientDb - endpoint=http://localhost:8094/] init KJul 31, 2024 10:45:45 AM com.ustadmobile.door.log.NapierAntilog performLog ©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] KJul 31, 2024 10:45:45 AM com.ustadmobile.door.log.NapierAntilog performLog ©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] KJul 31, 2024 10:45:45 AM com.ustadmobile.door.log.NapierAntilog performLog ‘FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #3 : SQLite Change Tracker: Changed tables=[] KJul 31, 2024 10:45:45 AM com.ustadmobile.door.log.NapierAntilog performLog ŸFINE: [DEBUG] DoorLog - [DoorEventSource@com.ustadmobile.door.sse.DoorEventSource@472a11ae - http://localhost:8094/replication/sse?door-node=2%2Fsecret] close KJul 31, 2024 10:45:46 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:46 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:46 AM com.ustadmobile.door.log.NapierAntilog performLog RINFO: [INFO] DoorLog - [DatabaseBuilder.build - clientDb] database build complete KJul 31, 2024 10:45:46 AM com.ustadmobile.door.log.NapierAntilog performLog RINFO: [INFO] DoorLog - [DatabaseBuilder.build - serverDb] database build complete KJul 31, 2024 10:45:46 AM com.ustadmobile.door.log.NapierAntilog performLog —FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - serverDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[Member] KJul 31, 2024 10:45:46 AM com.ustadmobile.door.log.NapierAntilog performLog ŸFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - serverDb] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[DiscussionPost] KJul 31, 2024 10:45:46 AM com.ustadmobile.door.log.NapierAntilog performLog lFINE: [DEBUG] DoorLog - [DoorRepositoryReplicationClient - clientDb - endpoint=http://localhost:8094/] init KJul 31, 2024 10:45:46 AM com.ustadmobile.door.log.NapierAntilog performLog ©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] KJul 31, 2024 10:45:46 AM com.ustadmobile.door.log.NapierAntilog performLog ©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] KJul 31, 2024 10:45:46 AM com.ustadmobile.door.log.NapierAntilog performLog ‘FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #3 : SQLite Change Tracker: Changed tables=[] KJul 31, 2024 10:45:46 AM com.ustadmobile.door.log.NapierAntilog performLog µFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #4 : SQLite Change Tracker: Changed tables=[DiscussionPost, ReplicationOperation] KJul 31, 2024 10:45:46 AM com.ustadmobile.door.log.NapierAntilog performLog |FINE: [DEBUG] DoorLog - [NodeEventManager - clientDb] receiveMessage with 1 replications: inserts done/transaction finished KJul 31, 2024 10:45:46 AM com.ustadmobile.door.log.NapierAntilog performLog ŸFINE: [DEBUG] DoorLog - [DoorEventSource@com.ustadmobile.door.sse.DoorEventSource@292158f8 - http://localhost:8094/replication/sse?door-node=2%2Fsecret] close KJul 31, 2024 10:45:47 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:47 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:47 AM com.ustadmobile.door.log.NapierAntilog performLog RINFO: [INFO] DoorLog - [DatabaseBuilder.build - clientDb] database build complete KJul 31, 2024 10:45:47 AM com.ustadmobile.door.log.NapierAntilog performLog RINFO: [INFO] DoorLog - [DatabaseBuilder.build - serverDb] database build complete KJul 31, 2024 10:45:47 AM com.ustadmobile.door.log.NapierAntilog performLog lFINE: [DEBUG] DoorLog - [DoorRepositoryReplicationClient - clientDb - endpoint=http://localhost:8094/] init KJul 31, 2024 10:45:47 AM com.ustadmobile.door.log.NapierAntilog performLog ©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] KJul 31, 2024 10:45:47 AM com.ustadmobile.door.log.NapierAntilog performLog žFINE: [DEBUG] DoorLog - [DoorEventSource@com.ustadmobile.door.sse.DoorEventSource@8851ce1 - http://localhost:8094/replication/sse?door-node=2%2Fsecret] close KJul 31, 2024 10:45:47 AM com.ustadmobile.door.log.NapierAntilog performLog ©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] KJul 31, 2024 10:45:48 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:48 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:48 AM com.ustadmobile.door.log.NapierAntilog performLog RINFO: [INFO] DoorLog - [DatabaseBuilder.build - clientDb] database build complete KJul 31, 2024 10:45:48 AM com.ustadmobile.door.log.NapierAntilog performLog RINFO: [INFO] DoorLog - [DatabaseBuilder.build - serverDb] database build complete KJul 31, 2024 10:45:48 AM com.ustadmobile.door.log.NapierAntilog performLog —FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - serverDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[Member] KJul 31, 2024 10:45:48 AM com.ustadmobile.door.log.NapierAntilog performLog ŸFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - serverDb] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[DiscussionPost] KJul 31, 2024 10:45:48 AM com.ustadmobile.door.log.NapierAntilog performLog lFINE: [DEBUG] DoorLog - [DoorRepositoryReplicationClient - clientDb - endpoint=http://localhost:8094/] init KJul 31, 2024 10:45:48 AM com.ustadmobile.door.log.NapierAntilog performLog ©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] KJul 31, 2024 10:45:48 AM com.ustadmobile.door.log.NapierAntilog performLog ©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #3 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] KJul 31, 2024 10:45:48 AM com.ustadmobile.door.log.NapierAntilog performLog ‘FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #4 : SQLite Change Tracker: Changed tables=[] KJul 31, 2024 10:45:48 AM com.ustadmobile.door.log.NapierAntilog performLog ½FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #5 : SQLite Change Tracker: Changed tables=[DiscussionPost, Member, ReplicationOperation] KJul 31, 2024 10:45:48 AM com.ustadmobile.door.log.NapierAntilog performLog |FINE: [DEBUG] DoorLog - [NodeEventManager - clientDb] receiveMessage with 2 replications: inserts done/transaction finished KJul 31, 2024 10:45:48 AM com.ustadmobile.door.log.NapierAntilog performLog ŸFINE: [DEBUG] DoorLog - [DoorEventSource@com.ustadmobile.door.sse.DoorEventSource@2849434b - http://localhost:8094/replication/sse?door-node=2%2Fsecret] close KJul 31, 2024 10:45:49 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool KJul 31, 2024 10:45:49 AM com.ustadmobile.door.log.NapierAntilog performLog @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool  KJul 31, 2024 10:45:49 AM com.ustadmobile.door.log.NapierAntilog performLog  RINFO: [INFO] DoorLog - [DatabaseBuilder.build - clientDb] database build complete  KJul 31, 2024 10:45:49 AM com.ustadmobile.door.log.NapierAntilog performLog  RINFO: [INFO] DoorLog - [DatabaseBuilder.build - serverDb] database build complete  KJul 31, 2024 10:45:49 AM com.ustadmobile.door.log.NapierAntilog performLog  —FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - serverDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[Member]  KJul 31, 2024 10:45:49 AM com.ustadmobile.door.log.NapierAntilog performLog  ŸFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - serverDb] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[DiscussionPost]  KJul 31, 2024 10:45:49 AM com.ustadmobile.door.log.NapierAntilog performLog  lFINE: [DEBUG] DoorLog - [DoorRepositoryReplicationClient - clientDb - endpoint=http://localhost:8094/] init  KJul 31, 2024 10:45:49 AM com.ustadmobile.door.log.NapierAntilog performLog  mWARNING: [WARN] DoorLog - [NodeEventSseClient localNodeId=2 remoteEndpoint=http://localhost:8094/] : onError  Ijava.net.ConnectException: Failed to connect to localhost/127.0.0.1:8094  T at okhttp3.internal.connection.RealConnection.connectSocket(RealConnection.kt:297)  N at okhttp3.internal.connection.RealConnection.connect(RealConnection.kt:207)  U at okhttp3.internal.connection.ExchangeFinder.findConnection(ExchangeFinder.kt:226)  \ at okhttp3.internal.connection.ExchangeFinder.findHealthyConnection(ExchangeFinder.kt:106)  J at okhttp3.internal.connection.ExchangeFinder.find(ExchangeFinder.kt:74)  N at okhttp3.internal.connection.RealCall.initExchange$okhttp(RealCall.kt:255)  W at okhttp3.internal.connection.ConnectInterceptor.intercept(ConnectInterceptor.kt:32)  T at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.kt:109)  N at okhttp3.internal.cache.CacheInterceptor.intercept(CacheInterceptor.kt:95)  T at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.kt:109)  O at okhttp3.internal.http.BridgeInterceptor.intercept(BridgeInterceptor.kt:83)  T at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.kt:109)  c at okhttp3.internal.http.RetryAndFollowUpInterceptor.intercept(RetryAndFollowUpInterceptor.kt:76)  T at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.kt:109)  a at okhttp3.internal.connection.RealCall.getResponseWithInterceptorChain$okhttp(RealCall.kt:201)  H at okhttp3.internal.connection.RealCall$AsyncCall.run(RealCall.kt:517)  ^ at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136)  ^ at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)  4 at java.base/java.lang.Thread.run(Thread.java:840)  9Caused by: java.net.ConnectException: Connection refused  8 at java.base/sun.nio.ch.Net.pollConnect(Native Method)  : at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672)  R at java.base/sun.nio.ch.NioSocketImpl.timedFinishConnect(NioSocketImpl.java:547)  G at java.base/sun.nio.ch.NioSocketImpl.connect(NioSocketImpl.java:602)  I at java.base/java.net.SocksSocketImpl.connect(SocksSocketImpl.java:327)  7 at java.base/java.net.Socket.connect(Socket.java:633)  F at okhttp3.internal.platform.Platform.connectSocket(Platform.kt:128)  T at okhttp3.internal.connection.RealConnection.connectSocket(RealConnection.kt:295)  ... 18 more    KJul 31, 2024 10:45:49 AM com.ustadmobile.door.log.NapierAntilog performLog  ©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[PendingRepositorySession]  KJul 31, 2024 10:45:49 AM com.ustadmobile.door.log.NapierAntilog performLog  ÈSEVERE: [ERROR] DoorEventSource$eventSourceListener$1$onFailure$invokeSuspend - [DoorEventSource@com.ustadmobile.door.sse.DoorEventSource@23c83cea - http://localhost:8094/replication/sse?door-node=2%2Fsecret] error: java.net.ConnectException: Failed to connect to localhost/127.0.0.1:8094 . Attempting to reconnect after 2000ms  KJul 31, 2024 10:45:49 AM com.ustadmobile.door.log.NapierAntilog performLog  œWARNING: [WARN] DoorLog - [DoorRepositoryReplicationClient - clientDb - endpoint=http://localhost:8094/] getRemoteNodeId : exception getting remote node id  Ijava.net.ConnectException: Failed to connect to localhost/127.0.0.1:8094  5 at _COROUTINE._BOUNDARY._(CoroutineDebugging.kt:42)  V at io.ktor.client.engine.okhttp.OkHttpEngine.executeHttpRequest(OkHttpEngine.kt:103)  J at io.ktor.client.engine.okhttp.OkHttpEngine.execute(OkHttpEngine.kt:70)  l at io.ktor.client.engine.HttpClientEngine$executeWithinCallContext$2.invokeSuspend(HttpClientEngine.kt:99)  j at io.ktor.client.engine.HttpClientEngine$DefaultImpls.executeWithinCallContext(HttpClientEngine.kt:100)  [ at io.ktor.client.engine.HttpClientEngine$install$1.invokeSuspend(HttpClientEngine.kt:70)  K at io.ktor.client.plugins.HttpSend$DefaultSender.execute(HttpSend.kt:138)  [ at io.ktor.client.plugins.HttpRedirect$Plugin$install$1.invokeSuspend(HttpRedirect.kt:64)  i at io.ktor.client.plugins.HttpCallValidator$Companion$install$3.invokeSuspend(HttpCallValidator.kt:151)  T at io.ktor.client.plugins.HttpSend$Plugin$install$1.invokeSuspend(HttpSend.kt:104)  i at io.ktor.client.plugins.HttpCallValidator$Companion$install$1.invokeSuspend(HttpCallValidator.kt:130)  k at io.ktor.client.plugins.HttpRequestLifecycle$Plugin$install$1.invokeSuspend(HttpRequestLifecycle.kt:38)  J at io.ktor.client.HttpClient.execute$ktor_client_core(HttpClient.kt:191)  O at io.ktor.client.statement.HttpStatement.executeUnsafe(HttpStatement.kt:108)  H at io.ktor.client.statement.HttpStatement.execute(HttpStatement.kt:47)  } at com.ustadmobile.door.replication.DoorRepositoryReplicationClient$1.invokeSuspend(DoorRepositoryReplicationClient.kt:492)  TCaused by: java.net.ConnectException: Failed to connect to localhost/127.0.0.1:8094  T at okhttp3.internal.connection.RealConnection.connectSocket(RealConnection.kt:297)  N at okhttp3.internal.connection.RealConnection.connect(RealConnection.kt:207)  U at okhttp3.internal.connection.ExchangeFinder.findConnection(ExchangeFinder.kt:226)  \ at okhttp3.internal.connection.ExchangeFinder.findHealthyConnection(ExchangeFinder.kt:106)  J at okhttp3.internal.connection.ExchangeFinder.find(ExchangeFinder.kt:74)  N at okhttp3.internal.connection.RealCall.initExchange$okhttp(RealCall.kt:255)  W at okhttp3.internal.connection.ConnectInterceptor.intercept(ConnectInterceptor.kt:32)  T at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.kt:109)  N at okhttp3.internal.cache.CacheInterceptor.intercept(CacheInterceptor.kt:95)  T at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.kt:109)  O at okhttp3.internal.http.BridgeInterceptor.intercept(BridgeInterceptor.kt:83)  T at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.kt:109)  c at okhttp3.internal.http.RetryAndFollowUpInterceptor.intercept(RetryAndFollowUpInterceptor.kt:76)  T at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.kt:109)  a at okhttp3.internal.connection.RealCall.getResponseWithInterceptorChain$okhttp(RealCall.kt:201)  H at okhttp3.internal.connection.RealCall$AsyncCall.run(RealCall.kt:517)  ^ at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136)  ^ at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)  4 at java.base/java.lang.Thread.run(Thread.java:840)  9Caused by: java.net.ConnectException: Connection refused  8 at java.base/sun.nio.ch.Net.pollConnect(Native Method)  : at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672)  R at java.base/sun.nio.ch.NioSocketImpl.timedFinishConnect(NioSocketImpl.java:547)  G at java.base/sun.nio.ch.NioSocketImpl.connect(NioSocketImpl.java:602)  I at java.base/java.net.SocksSocketImpl.connect(SocksSocketImpl.java:327)  7 at java.base/java.net.Socket.connect(Socket.java:633)  F at okhttp3.internal.platform.Platform.connectSocket(Platform.kt:128)  T at okhttp3.internal.connection.RealConnection.connectSocket(RealConnection.kt:295)  ... 18 more    KJul 31, 2024 10:45:50 AM com.ustadmobile.door.log.NapierAntilog performLog  †WARNING: [WARN] DoorLog - db3.ExampleDb3_Repo@22a6e998: repoHttpRequest: exception for DiscussionPostDao/getNumPostsSinceTimeHttpOnly  Ijava.net.ConnectException: Failed to connect to localhost/127.0.0.1:8094  5 at _COROUTINE._BOUNDARY._(CoroutineDebugging.kt:42)  V at io.ktor.client.engine.okhttp.OkHttpEngine.executeHttpRequest(OkHttpEngine.kt:103)  J at io.ktor.client.engine.okhttp.OkHttpEngine.execute(OkHttpEngine.kt:70)  l at io.ktor.client.engine.HttpClientEngine$executeWithinCallContext$2.invokeSuspend(HttpClientEngine.kt:99)  j at io.ktor.client.engine.HttpClientEngine$DefaultImpls.executeWithinCallContext(HttpClientEngine.kt:100)  [ at io.ktor.client.engine.HttpClientEngine$install$1.invokeSuspend(HttpClientEngine.kt:70)  K at io.ktor.client.plugins.HttpSend$DefaultSender.execute(HttpSend.kt:138)  [ at io.ktor.client.plugins.HttpRedirect$Plugin$install$1.invokeSuspend(HttpRedirect.kt:64)  i at io.ktor.client.plugins.HttpCallValidator$Companion$install$3.invokeSuspend(HttpCallValidator.kt:151)  T at io.ktor.client.plugins.HttpSend$Plugin$install$1.invokeSuspend(HttpSend.kt:104)  i at io.ktor.client.plugins.HttpCallValidator$Companion$install$1.invokeSuspend(HttpCallValidator.kt:130)  k at io.ktor.client.plugins.HttpRequestLifecycle$Plugin$install$1.invokeSuspend(HttpRequestLifecycle.kt:38)  J at io.ktor.client.HttpClient.execute$ktor_client_core(HttpClient.kt:191)  O at io.ktor.client.statement.HttpStatement.executeUnsafe(HttpStatement.kt:108)  H at io.ktor.client.statement.HttpStatement.execute(HttpStatement.kt:47)  [ at db3.DiscussionPostDao_Repo.getNumPostsSinceTimeHttpOnly(DiscussionPostDao_Repo.kt:448)  Ñ at com.ustadmobile.door.replication.PullIntegrationTest$givenEntitiesCreatedOnServer_whenClientUsesHttpWithoutFallbackAndServerIsUnreachable_thenWillThrowException$1.invokeSuspend(PullIntegrationTest.kt:267)   at com.ustadmobile.door.replication.PullIntegrationTest$clientServerIntegrationTest$1.invokeSuspend(PullIntegrationTest.kt:107)  TCaused by: java.net.ConnectException: Failed to connect to localhost/127.0.0.1:8094  T at okhttp3.internal.connection.RealConnection.connectSocket(RealConnection.kt:297)  N at okhttp3.internal.connection.RealConnection.connect(RealConnection.kt:207)  U at okhttp3.internal.connection.ExchangeFinder.findConnection(ExchangeFinder.kt:226)  \ at okhttp3.internal.connection.ExchangeFinder.findHealthyConnection(ExchangeFinder.kt:106)  J at okhttp3.internal.connection.ExchangeFinder.find(ExchangeFinder.kt:74)  N at okhttp3.internal.connection.RealCall.initExchange$okhttp(RealCall.kt:255)  W at okhttp3.internal.connection.ConnectInterceptor.intercept(ConnectInterceptor.kt:32)  T at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.kt:109)  N at okhttp3.internal.cache.CacheInterceptor.intercept(CacheInterceptor.kt:95)  T at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.kt:109)  O at okhttp3.internal.http.BridgeInterceptor.intercept(BridgeInterceptor.kt:83)  T at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.kt:109)  c at okhttp3.internal.http.RetryAndFollowUpInterceptor.intercept(RetryAndFollowUpInterceptor.kt:76)  T at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.kt:109)  a at okhttp3.internal.connection.RealCall.getResponseWithInterceptorChain$okhttp(RealCall.kt:201)  H at okhttp3.internal.connection.RealCall$AsyncCall.run(RealCall.kt:517)  ^ at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136)  ^ at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)  4 at java.base/java.lang.Thread.run(Thread.java:840)  9Caused by: java.net.ConnectException: Connection refused  8 at java.base/sun.nio.ch.Net.pollConnect(Native Method)  : at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672)  R at java.base/sun.nio.ch.NioSocketImpl.timedFinishConnect(NioSocketImpl.java:547)  G at java.base/sun.nio.ch.NioSocketImpl.connect(NioSocketImpl.java:602)  I at java.base/java.net.SocksSocketImpl.connect(SocksSocketImpl.java:327)  7 at java.base/java.net.Socket.connect(Socket.java:633)  F at okhttp3.internal.platform.Platform.connectSocket(Platform.kt:128)  T at okhttp3.internal.connection.RealConnection.connectSocket(RealConnection.kt:295)  ... 18 more    KJul 31, 2024 10:45:50 AM com.ustadmobile.door.log.NapierAntilog performLog  ŸFINE: [DEBUG] DoorLog - [DoorEventSource@com.ustadmobile.door.sse.DoorEventSource@23c83cea - http://localhost:8094/replication/sse?door-node=2%2Fsecret] close  KJul 31, 2024 10:45:50 AM com.ustadmobile.door.log.NapierAntilog performLog  @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool  KJul 31, 2024 10:45:50 AM com.ustadmobile.door.log.NapierAntilog performLog  @FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool !KJul 31, 2024 10:45:50 AM com.ustadmobile.door.log.NapierAntilog performLog !RINFO: [INFO] DoorLog - [DatabaseBuilder.build - clientDb] database build complete !KJul 31, 2024 10:45:50 AM com.ustadmobile.door.log.NapierAntilog performLog !RINFO: [INFO] DoorLog - [DatabaseBuilder.build - serverDb] database build complete !KJul 31, 2024 10:45:50 AM com.ustadmobile.door.log.NapierAntilog performLog !ŸFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - serverDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[DiscussionPost] !KJul 31, 2024 10:45:50 AM com.ustadmobile.door.log.NapierAntilog performLog !ŸFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - serverDb] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[DiscussionPost] !false !KJul 31, 2024 10:45:50 AM com.ustadmobile.door.log.NapierAntilog performLog !lFINE: [DEBUG] DoorLog - [DoorRepositoryReplicationClient - clientDb - endpoint=http://localhost:8094/] init !KJul 31, 2024 10:45:50 AM com.ustadmobile.door.log.NapierAntilog performLog !©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] !KJul 31, 2024 10:45:50 AM com.ustadmobile.door.log.NapierAntilog performLog !×SEVERE: [ERROR] DoorLog - $[onClientRepoDoorMessageHttpResponse - clientDb] - http://localhost:8094/DiscussionPostDao/findRepliesWithAuthCheck?postUid=620961002988453888 - unexpected response status = 403 Forbidden !KJul 31, 2024 10:45:50 AM com.ustadmobile.door.log.NapierAntilog performLog !©FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] !KJul 31, 2024 10:45:50 AM com.ustadmobile.door.log.NapierAntilog performLog !‘FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - clientDb] - useNewConnectionAsyncInternal connection #3 : SQLite Change Tracker: Changed tables=[] !KJul 31, 2024 10:45:50 AM com.ustadmobile.door.log.NapierAntilog performLog !ŸFINE: [DEBUG] DoorLog - [DoorEventSource@com.ustadmobile.door.sse.DoorEventSource@455c1d8c - http://localhost:8094/replication/sse?door-node=2%2Fsecret] close !KJul 31, 2024 10:45:51 AM com.ustadmobile.door.log.NapierAntilog performLog !@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool !KJul 31, 2024 10:45:51 AM com.ustadmobile.door.log.NapierAntilog performLog !@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool #"KJul 31, 2024 10:45:51 AM com.ustadmobile.door.log.NapierAntilog performLog #"^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete #"KJul 31, 2024 10:45:51 AM com.ustadmobile.door.log.NapierAntilog performLog #"^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete #"KJul 31, 2024 10:45:51 AM com.ustadmobile.door.log.NapierAntilog performLog #"ÀFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[ExampleEntity3, OutgoingReplication] #"KJul 31, 2024 10:45:51 AM com.ustadmobile.door.log.NapierAntilog performLog #"–FINE: [DEBUG] DoorLog - [NodeEventJdbcImplListenerSqlite - jdbc:sqlite::memory:] emitting 1 events com.ustadmobile.door.nodeevent.NodeEvent@7f40e733 #"KJul 31, 2024 10:45:51 AM com.ustadmobile.door.log.NapierAntilog performLog #"lFINE: [DEBUG] DoorLog - [DoorRepositoryReplicationClient - clientDb - endpoint=http://localhost:8094/] init #"KJul 31, 2024 10:45:51 AM com.ustadmobile.door.log.NapierAntilog performLog #"µFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] #"KJul 31, 2024 10:45:51 AM com.ustadmobile.door.log.NapierAntilog performLog #"µFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #3 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] #"KJul 31, 2024 10:45:51 AM com.ustadmobile.door.log.NapierAntilog performLog #"FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #4 : SQLite Change Tracker: Changed tables=[] #"KJul 31, 2024 10:45:51 AM com.ustadmobile.door.log.NapierAntilog performLog #"ÁFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #5 : SQLite Change Tracker: Changed tables=[ExampleEntity3, ReplicationOperation] #"KJul 31, 2024 10:45:51 AM com.ustadmobile.door.log.NapierAntilog performLog #"ˆFINE: [DEBUG] DoorLog - [NodeEventManager - jdbc:sqlite::memory:] receiveMessage with 1 replications: inserts done/transaction finished #"KJul 31, 2024 10:45:51 AM com.ustadmobile.door.log.NapierAntilog performLog #"ŸFINE: [DEBUG] DoorLog - [DoorEventSource@com.ustadmobile.door.sse.DoorEventSource@121bb45b - http://localhost:8094/replication/sse?door-node=2%2Fsecret] close #"KJul 31, 2024 10:45:51 AM com.ustadmobile.door.log.NapierAntilog performLog #"°FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #3 : SQLite Change Tracker: Changed tables=[OutgoingReplication] #"KJul 31, 2024 10:45:52 AM com.ustadmobile.door.log.NapierAntilog performLog #"@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool #"KJul 31, 2024 10:45:52 AM com.ustadmobile.door.log.NapierAntilog performLog #"@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool #$KJul 31, 2024 10:45:52 AM com.ustadmobile.door.log.NapierAntilog performLog #$^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete #$KJul 31, 2024 10:45:52 AM com.ustadmobile.door.log.NapierAntilog performLog #$^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete #$KJul 31, 2024 10:45:52 AM com.ustadmobile.door.log.NapierAntilog performLog #$lFINE: [DEBUG] DoorLog - [DoorRepositoryReplicationClient - clientDb - endpoint=http://localhost:8094/] init #$KJul 31, 2024 10:45:52 AM com.ustadmobile.door.log.NapierAntilog performLog #$mWARNING: [WARN] DoorLog - [NodeEventSseClient localNodeId=2 remoteEndpoint=http://localhost:8094/] : onError #$Ijava.net.ConnectException: Failed to connect to localhost/127.0.0.1:8094 #$T at okhttp3.internal.connection.RealConnection.connectSocket(RealConnection.kt:297) #$N at okhttp3.internal.connection.RealConnection.connect(RealConnection.kt:207) #$U at okhttp3.internal.connection.ExchangeFinder.findConnection(ExchangeFinder.kt:226) #$\ at okhttp3.internal.connection.ExchangeFinder.findHealthyConnection(ExchangeFinder.kt:106) #$J at okhttp3.internal.connection.ExchangeFinder.find(ExchangeFinder.kt:74) #$N at okhttp3.internal.connection.RealCall.initExchange$okhttp(RealCall.kt:255) #$W at okhttp3.internal.connection.ConnectInterceptor.intercept(ConnectInterceptor.kt:32) #$T at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.kt:109) #$N at okhttp3.internal.cache.CacheInterceptor.intercept(CacheInterceptor.kt:95) #$T at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.kt:109) #$O at okhttp3.internal.http.BridgeInterceptor.intercept(BridgeInterceptor.kt:83) #$T at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.kt:109) #$c at okhttp3.internal.http.RetryAndFollowUpInterceptor.intercept(RetryAndFollowUpInterceptor.kt:76) #$T at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.kt:109) #$a at okhttp3.internal.connection.RealCall.getResponseWithInterceptorChain$okhttp(RealCall.kt:201) #$H at okhttp3.internal.connection.RealCall$AsyncCall.run(RealCall.kt:517) #$^ at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136) #$^ at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) #$4 at java.base/java.lang.Thread.run(Thread.java:840) #$9Caused by: java.net.ConnectException: Connection refused #$8 at java.base/sun.nio.ch.Net.pollConnect(Native Method) #$: at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) #$R at java.base/sun.nio.ch.NioSocketImpl.timedFinishConnect(NioSocketImpl.java:547) #$G at java.base/sun.nio.ch.NioSocketImpl.connect(NioSocketImpl.java:602) #$I at java.base/java.net.SocksSocketImpl.connect(SocksSocketImpl.java:327) #$7 at java.base/java.net.Socket.connect(Socket.java:633) #$F at okhttp3.internal.platform.Platform.connectSocket(Platform.kt:128) #$T at okhttp3.internal.connection.RealConnection.connectSocket(RealConnection.kt:295) #$ ... 18 more #$ #$KJul 31, 2024 10:45:52 AM com.ustadmobile.door.log.NapierAntilog performLog #$ÈSEVERE: [ERROR] DoorEventSource$eventSourceListener$1$onFailure$invokeSuspend - [DoorEventSource@com.ustadmobile.door.sse.DoorEventSource@5d05fb3a - http://localhost:8094/replication/sse?door-node=2%2Fsecret] error: java.net.ConnectException: Failed to connect to localhost/127.0.0.1:8094 . Attempting to reconnect after 2000ms #$KJul 31, 2024 10:45:52 AM com.ustadmobile.door.log.NapierAntilog performLog #$µFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] #$KJul 31, 2024 10:45:52 AM com.ustadmobile.door.log.NapierAntilog performLog #$œWARNING: [WARN] DoorLog - [DoorRepositoryReplicationClient - clientDb - endpoint=http://localhost:8094/] getRemoteNodeId : exception getting remote node id #$Ijava.net.ConnectException: Failed to connect to localhost/127.0.0.1:8094 #$5 at _COROUTINE._BOUNDARY._(CoroutineDebugging.kt:42) #$V at io.ktor.client.engine.okhttp.OkHttpEngine.executeHttpRequest(OkHttpEngine.kt:103) #$J at io.ktor.client.engine.okhttp.OkHttpEngine.execute(OkHttpEngine.kt:70) #$l at io.ktor.client.engine.HttpClientEngine$executeWithinCallContext$2.invokeSuspend(HttpClientEngine.kt:99) #$j at io.ktor.client.engine.HttpClientEngine$DefaultImpls.executeWithinCallContext(HttpClientEngine.kt:100) #$[ at io.ktor.client.engine.HttpClientEngine$install$1.invokeSuspend(HttpClientEngine.kt:70) #$K at io.ktor.client.plugins.HttpSend$DefaultSender.execute(HttpSend.kt:138) #$[ at io.ktor.client.plugins.HttpRedirect$Plugin$install$1.invokeSuspend(HttpRedirect.kt:64) #$i at io.ktor.client.plugins.HttpCallValidator$Companion$install$3.invokeSuspend(HttpCallValidator.kt:151) #$T at io.ktor.client.plugins.HttpSend$Plugin$install$1.invokeSuspend(HttpSend.kt:104) #$i at io.ktor.client.plugins.HttpCallValidator$Companion$install$1.invokeSuspend(HttpCallValidator.kt:130) #$k at io.ktor.client.plugins.HttpRequestLifecycle$Plugin$install$1.invokeSuspend(HttpRequestLifecycle.kt:38) #$J at io.ktor.client.HttpClient.execute$ktor_client_core(HttpClient.kt:191) #$O at io.ktor.client.statement.HttpStatement.executeUnsafe(HttpStatement.kt:108) #$H at io.ktor.client.statement.HttpStatement.execute(HttpStatement.kt:47) #$} at com.ustadmobile.door.replication.DoorRepositoryReplicationClient$1.invokeSuspend(DoorRepositoryReplicationClient.kt:492) #$TCaused by: java.net.ConnectException: Failed to connect to localhost/127.0.0.1:8094 #$T at okhttp3.internal.connection.RealConnection.connectSocket(RealConnection.kt:297) #$N at okhttp3.internal.connection.RealConnection.connect(RealConnection.kt:207) #$U at okhttp3.internal.connection.ExchangeFinder.findConnection(ExchangeFinder.kt:226) #$\ at okhttp3.internal.connection.ExchangeFinder.findHealthyConnection(ExchangeFinder.kt:106) #$J at okhttp3.internal.connection.ExchangeFinder.find(ExchangeFinder.kt:74) #$N at okhttp3.internal.connection.RealCall.initExchange$okhttp(RealCall.kt:255) #$W at okhttp3.internal.connection.ConnectInterceptor.intercept(ConnectInterceptor.kt:32) #$T at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.kt:109) #$N at okhttp3.internal.cache.CacheInterceptor.intercept(CacheInterceptor.kt:95) #$T at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.kt:109) #$O at okhttp3.internal.http.BridgeInterceptor.intercept(BridgeInterceptor.kt:83) #$T at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.kt:109) #$c at okhttp3.internal.http.RetryAndFollowUpInterceptor.intercept(RetryAndFollowUpInterceptor.kt:76) #$T at okhttp3.internal.http.RealInterceptorChain.proceed(RealInterceptorChain.kt:109) #$a at okhttp3.internal.connection.RealCall.getResponseWithInterceptorChain$okhttp(RealCall.kt:201) #$H at okhttp3.internal.connection.RealCall$AsyncCall.run(RealCall.kt:517) #$^ at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136) #$^ at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) #$4 at java.base/java.lang.Thread.run(Thread.java:840) #$9Caused by: java.net.ConnectException: Connection refused #$8 at java.base/sun.nio.ch.Net.pollConnect(Native Method) #$: at java.base/sun.nio.ch.Net.pollConnectNow(Net.java:672) #$R at java.base/sun.nio.ch.NioSocketImpl.timedFinishConnect(NioSocketImpl.java:547) #$G at java.base/sun.nio.ch.NioSocketImpl.connect(NioSocketImpl.java:602) #$I at java.base/java.net.SocksSocketImpl.connect(SocksSocketImpl.java:327) #$7 at java.base/java.net.Socket.connect(Socket.java:633) #$F at okhttp3.internal.platform.Platform.connectSocket(Platform.kt:128) #$T at okhttp3.internal.connection.RealConnection.connectSocket(RealConnection.kt:295) #$ ... 18 more #$ #$KJul 31, 2024 10:45:52 AM com.ustadmobile.door.log.NapierAntilog performLog #$ÀFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[ExampleEntity3, OutgoingReplication] #$KJul 31, 2024 10:45:52 AM com.ustadmobile.door.log.NapierAntilog performLog #$–FINE: [DEBUG] DoorLog - [NodeEventJdbcImplListenerSqlite - jdbc:sqlite::memory:] emitting 1 events com.ustadmobile.door.nodeevent.NodeEvent@6b847771 #$KJul 31, 2024 10:45:53 AM com.ustadmobile.door.log.NapierAntilog performLog #$µFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #3 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] #$KJul 31, 2024 10:45:53 AM com.ustadmobile.door.log.NapierAntilog performLog #$ÊFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #4 : SQLite Change Tracker: Changed tables=[OutgoingReplication, PendingRepositorySession] #$KJul 31, 2024 10:45:53 AM com.ustadmobile.door.log.NapierAntilog performLog #$FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #5 : SQLite Change Tracker: Changed tables=[] #$KJul 31, 2024 10:45:53 AM com.ustadmobile.door.log.NapierAntilog performLog #$ÁFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[ExampleEntity3, ReplicationOperation] #$KJul 31, 2024 10:45:53 AM com.ustadmobile.door.log.NapierAntilog performLog #$ˆFINE: [DEBUG] DoorLog - [NodeEventManager - jdbc:sqlite::memory:] receiveMessage with 1 replications: inserts done/transaction finished #$KJul 31, 2024 10:45:53 AM com.ustadmobile.door.log.NapierAntilog performLog #$ŸFINE: [DEBUG] DoorLog - [DoorEventSource@com.ustadmobile.door.sse.DoorEventSource@5d05fb3a - http://localhost:8094/replication/sse?door-node=2%2Fsecret] close #$KJul 31, 2024 10:45:54 AM com.ustadmobile.door.log.NapierAntilog performLog #$@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool #$KJul 31, 2024 10:45:54 AM com.ustadmobile.door.log.NapierAntilog performLog #$@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool #%KJul 31, 2024 10:45:54 AM com.ustadmobile.door.log.NapierAntilog performLog #%^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete #%KJul 31, 2024 10:45:55 AM com.ustadmobile.door.log.NapierAntilog performLog #%^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete #%KJul 31, 2024 10:45:55 AM com.ustadmobile.door.log.NapierAntilog performLog #%lFINE: [DEBUG] DoorLog - [DoorRepositoryReplicationClient - clientDb - endpoint=http://localhost:8094/] init #%KJul 31, 2024 10:45:55 AM com.ustadmobile.door.log.NapierAntilog performLog #%µFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] #%KJul 31, 2024 10:45:55 AM com.ustadmobile.door.log.NapierAntilog performLog #%µFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] #%KJul 31, 2024 10:45:55 AM com.ustadmobile.door.log.NapierAntilog performLog #%FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #3 : SQLite Change Tracker: Changed tables=[] #%KJul 31, 2024 10:45:55 AM com.ustadmobile.door.log.NapierAntilog performLog #%ÁFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #4 : SQLite Change Tracker: Changed tables=[OutgoingReplication, StatementEntity] #%KJul 31, 2024 10:45:55 AM com.ustadmobile.door.log.NapierAntilog performLog #%•FINE: [DEBUG] DoorLog - [NodeEventJdbcImplListenerSqlite - jdbc:sqlite::memory:] emitting 1 events com.ustadmobile.door.nodeevent.NodeEvent@bf4c0db #%KJul 31, 2024 10:45:55 AM com.ustadmobile.door.log.NapierAntilog performLog #%FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #5 : SQLite Change Tracker: Changed tables=[] #%KJul 31, 2024 10:45:55 AM com.ustadmobile.door.log.NapierAntilog performLog #%ÂFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #3 : SQLite Change Tracker: Changed tables=[ReplicationOperation, StatementEntity] #%KJul 31, 2024 10:45:55 AM com.ustadmobile.door.log.NapierAntilog performLog #%ˆFINE: [DEBUG] DoorLog - [NodeEventManager - jdbc:sqlite::memory:] receiveMessage with 1 replications: inserts done/transaction finished #%KJul 31, 2024 10:45:55 AM com.ustadmobile.door.log.NapierAntilog performLog #%ŸFINE: [DEBUG] DoorLog - [DoorEventSource@com.ustadmobile.door.sse.DoorEventSource@21afcdb3 - http://localhost:8094/replication/sse?door-node=2%2Fsecret] close #%KJul 31, 2024 10:45:55 AM com.ustadmobile.door.log.NapierAntilog performLog #%°FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #6 : SQLite Change Tracker: Changed tables=[OutgoingReplication] #%KJul 31, 2024 10:45:56 AM com.ustadmobile.door.log.NapierAntilog performLog #%@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool #%KJul 31, 2024 10:45:56 AM com.ustadmobile.door.log.NapierAntilog performLog #%@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool #&KJul 31, 2024 10:45:56 AM com.ustadmobile.door.log.NapierAntilog performLog #&^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete #&KJul 31, 2024 10:45:56 AM com.ustadmobile.door.log.NapierAntilog performLog #&^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete #&KJul 31, 2024 10:45:56 AM com.ustadmobile.door.log.NapierAntilog performLog #&ÀFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[ExampleEntity3, OutgoingReplication] #&KJul 31, 2024 10:45:56 AM com.ustadmobile.door.log.NapierAntilog performLog #&–FINE: [DEBUG] DoorLog - [NodeEventJdbcImplListenerSqlite - jdbc:sqlite::memory:] emitting 1 events com.ustadmobile.door.nodeevent.NodeEvent@3fc49db2 #&KJul 31, 2024 10:45:56 AM com.ustadmobile.door.log.NapierAntilog performLog #&lFINE: [DEBUG] DoorLog - [DoorRepositoryReplicationClient - clientDb - endpoint=http://localhost:8094/] init #&KJul 31, 2024 10:45:56 AM com.ustadmobile.door.log.NapierAntilog performLog #&µFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] #&KJul 31, 2024 10:45:56 AM com.ustadmobile.door.log.NapierAntilog performLog #&µFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #3 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] #&KJul 31, 2024 10:45:56 AM com.ustadmobile.door.log.NapierAntilog performLog #&FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #4 : SQLite Change Tracker: Changed tables=[] #&KJul 31, 2024 10:45:56 AM com.ustadmobile.door.log.NapierAntilog performLog #&ÁFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #5 : SQLite Change Tracker: Changed tables=[ExampleEntity3, ReplicationOperation] #&KJul 31, 2024 10:45:56 AM com.ustadmobile.door.log.NapierAntilog performLog #&ˆFINE: [DEBUG] DoorLog - [NodeEventManager - jdbc:sqlite::memory:] receiveMessage with 1 replications: inserts done/transaction finished #&KJul 31, 2024 10:45:56 AM com.ustadmobile.door.log.NapierAntilog performLog #&ŸFINE: [DEBUG] DoorLog - [DoorEventSource@com.ustadmobile.door.sse.DoorEventSource@1305c126 - http://localhost:8094/replication/sse?door-node=2%2Fsecret] close #&KJul 31, 2024 10:45:56 AM com.ustadmobile.door.log.NapierAntilog performLog #&°FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #3 : SQLite Change Tracker: Changed tables=[OutgoingReplication] #&KJul 31, 2024 10:45:57 AM com.ustadmobile.door.log.NapierAntilog performLog #&@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool #&KJul 31, 2024 10:45:57 AM com.ustadmobile.door.log.NapierAntilog performLog #&@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool #'KJul 31, 2024 10:45:57 AM com.ustadmobile.door.log.NapierAntilog performLog #'^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete #'KJul 31, 2024 10:45:57 AM com.ustadmobile.door.log.NapierAntilog performLog #'^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete #'KJul 31, 2024 10:45:57 AM com.ustadmobile.door.log.NapierAntilog performLog #'lFINE: [DEBUG] DoorLog - [DoorRepositoryReplicationClient - clientDb - endpoint=http://localhost:8094/] init #'KJul 31, 2024 10:45:57 AM com.ustadmobile.door.log.NapierAntilog performLog #'µFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] #'KJul 31, 2024 10:45:57 AM com.ustadmobile.door.log.NapierAntilog performLog #'µFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] #'KJul 31, 2024 10:45:57 AM com.ustadmobile.door.log.NapierAntilog performLog #'FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #3 : SQLite Change Tracker: Changed tables=[] #'KJul 31, 2024 10:45:58 AM com.ustadmobile.door.log.NapierAntilog performLog #'ÀFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #4 : SQLite Change Tracker: Changed tables=[ExampleEntity3, OutgoingReplication] #'KJul 31, 2024 10:45:58 AM com.ustadmobile.door.log.NapierAntilog performLog #'–FINE: [DEBUG] DoorLog - [NodeEventJdbcImplListenerSqlite - jdbc:sqlite::memory:] emitting 1 events com.ustadmobile.door.nodeevent.NodeEvent@70493716 #'KJul 31, 2024 10:45:58 AM com.ustadmobile.door.log.NapierAntilog performLog #'FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #5 : SQLite Change Tracker: Changed tables=[] #'KJul 31, 2024 10:45:58 AM com.ustadmobile.door.log.NapierAntilog performLog #'ÁFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #3 : SQLite Change Tracker: Changed tables=[ExampleEntity3, ReplicationOperation] #'KJul 31, 2024 10:45:58 AM com.ustadmobile.door.log.NapierAntilog performLog #'ˆFINE: [DEBUG] DoorLog - [NodeEventManager - jdbc:sqlite::memory:] receiveMessage with 1 replications: inserts done/transaction finished #'KJul 31, 2024 10:45:58 AM com.ustadmobile.door.log.NapierAntilog performLog #'ŸFINE: [DEBUG] DoorLog - [DoorEventSource@com.ustadmobile.door.sse.DoorEventSource@19e9a285 - http://localhost:8094/replication/sse?door-node=2%2Fsecret] close #'KJul 31, 2024 10:45:59 AM com.ustadmobile.door.log.NapierAntilog performLog #'@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool #'KJul 31, 2024 10:45:59 AM com.ustadmobile.door.log.NapierAntilog performLog #'@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool #(KJul 31, 2024 10:45:59 AM com.ustadmobile.door.log.NapierAntilog performLog #(^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete #(KJul 31, 2024 10:45:59 AM com.ustadmobile.door.log.NapierAntilog performLog #(^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete #(KJul 31, 2024 10:45:59 AM com.ustadmobile.door.log.NapierAntilog performLog #(ÀFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[ExampleEntity3, OutgoingReplication] #(KJul 31, 2024 10:45:59 AM com.ustadmobile.door.log.NapierAntilog performLog #(–FINE: [DEBUG] DoorLog - [NodeEventJdbcImplListenerSqlite - jdbc:sqlite::memory:] emitting 1 events com.ustadmobile.door.nodeevent.NodeEvent@2a4e2033 #(KJul 31, 2024 10:45:59 AM com.ustadmobile.door.log.NapierAntilog performLog #(lFINE: [DEBUG] DoorLog - [DoorRepositoryReplicationClient - clientDb - endpoint=http://localhost:8094/] init #(KJul 31, 2024 10:45:59 AM com.ustadmobile.door.log.NapierAntilog performLog #(µFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] #(KJul 31, 2024 10:45:59 AM com.ustadmobile.door.log.NapierAntilog performLog #(µFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #3 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] #(KJul 31, 2024 10:45:59 AM com.ustadmobile.door.log.NapierAntilog performLog #(FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #4 : SQLite Change Tracker: Changed tables=[] #(KJul 31, 2024 10:45:59 AM com.ustadmobile.door.log.NapierAntilog performLog #(ÁFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #3 : SQLite Change Tracker: Changed tables=[ExampleEntity3, ReplicationOperation] #(KJul 31, 2024 10:45:59 AM com.ustadmobile.door.log.NapierAntilog performLog #(ˆFINE: [DEBUG] DoorLog - [NodeEventManager - jdbc:sqlite::memory:] receiveMessage with 1 replications: inserts done/transaction finished #(KJul 31, 2024 10:45:59 AM com.ustadmobile.door.log.NapierAntilog performLog #(ŸFINE: [DEBUG] DoorLog - [DoorEventSource@com.ustadmobile.door.sse.DoorEventSource@411c6d44 - http://localhost:8094/replication/sse?door-node=2%2Fsecret] close #(KJul 31, 2024 10:45:59 AM com.ustadmobile.door.log.NapierAntilog performLog #(°FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #5 : SQLite Change Tracker: Changed tables=[OutgoingReplication] #(KJul 31, 2024 10:46:00 AM com.ustadmobile.door.log.NapierAntilog performLog #(@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool #(KJul 31, 2024 10:46:00 AM com.ustadmobile.door.log.NapierAntilog performLog #(@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool #)KJul 31, 2024 10:46:00 AM com.ustadmobile.door.log.NapierAntilog performLog #)^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete #)KJul 31, 2024 10:46:00 AM com.ustadmobile.door.log.NapierAntilog performLog #)^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete #)KJul 31, 2024 10:46:00 AM com.ustadmobile.door.log.NapierAntilog performLog #)lFINE: [DEBUG] DoorLog - [DoorRepositoryReplicationClient - clientDb - endpoint=http://localhost:8094/] init #)KJul 31, 2024 10:46:00 AM com.ustadmobile.door.log.NapierAntilog performLog #)µFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] #)KJul 31, 2024 10:46:00 AM com.ustadmobile.door.log.NapierAntilog performLog #)µFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[PendingRepositorySession] #)KJul 31, 2024 10:46:00 AM com.ustadmobile.door.log.NapierAntilog performLog #)FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #3 : SQLite Change Tracker: Changed tables=[] #)KJul 31, 2024 10:46:00 AM com.ustadmobile.door.log.NapierAntilog performLog #)ÀFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[ExampleEntity3, OutgoingReplication] #)KJul 31, 2024 10:46:00 AM com.ustadmobile.door.log.NapierAntilog performLog #)–FINE: [DEBUG] DoorLog - [NodeEventJdbcImplListenerSqlite - jdbc:sqlite::memory:] emitting 1 events com.ustadmobile.door.nodeevent.NodeEvent@75c00d60 #)KJul 31, 2024 10:46:00 AM com.ustadmobile.door.log.NapierAntilog performLog #)FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #5 : SQLite Change Tracker: Changed tables=[] #)KJul 31, 2024 10:46:00 AM com.ustadmobile.door.log.NapierAntilog performLog #)ˆFINE: [DEBUG] DoorLog - [NodeEventManager - jdbc:sqlite::memory:] receiveMessage with 0 replications: inserts done/transaction finished #)KJul 31, 2024 10:46:00 AM com.ustadmobile.door.log.NapierAntilog performLog #)ÁFINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #6 : SQLite Change Tracker: Changed tables=[ExampleEntity3, ReplicationOperation] #)KJul 31, 2024 10:46:00 AM com.ustadmobile.door.log.NapierAntilog performLog #)ˆFINE: [DEBUG] DoorLog - [NodeEventManager - jdbc:sqlite::memory:] receiveMessage with 1 replications: inserts done/transaction finished #)KJul 31, 2024 10:46:00 AM com.ustadmobile.door.log.NapierAntilog performLog #)ŸFINE: [DEBUG] DoorLog - [DoorEventSource@com.ustadmobile.door.sse.DoorEventSource@4f89331f - http://localhost:8094/replication/sse?door-node=2%2Fsecret] close #)KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog #)@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool #)KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog #)@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool +*KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +*JFINE: [DEBUG] BasicCrudIntegrationTest$setup - Start time = 1722415561689 +* +*KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +*^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete +*KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +*«FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[ExampleEntity2] +*KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +*@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool +,KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +,JFINE: [DEBUG] BasicCrudIntegrationTest$setup - Start time = 1722415561699 +, +,KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +,^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete +,KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +,«FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[ExampleEntity2] +,KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +,@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool +-KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +-JFINE: [DEBUG] BasicCrudIntegrationTest$setup - Start time = 1722415561708 +- +-KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +-^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete +-KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +-«FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[ExampleEntity2] +-KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +-@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool +.KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +.JFINE: [DEBUG] BasicCrudIntegrationTest$setup - Start time = 1722415561716 +. +.KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +.^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete +.KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +.@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool +/KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +/JFINE: [DEBUG] BasicCrudIntegrationTest$setup - Start time = 1722415561720 +/ +/KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +/^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete +/KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +/«FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[ExampleEntity2] +/KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +/®FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[ExampleLinkEntity] +/KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +/@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool +0KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +0JFINE: [DEBUG] BasicCrudIntegrationTest$setup - Start time = 1722415561728 +0 +0KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +0^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete +0KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +0«FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[ExampleEntity2] +0KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +0«FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #3 : SQLite Change Tracker: Changed tables=[ExampleEntity2] +0KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +0@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool +1KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +1JFINE: [DEBUG] BasicCrudIntegrationTest$setup - Start time = 1722415561740 +1 +1KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +1^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete +1KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +1«FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[ExampleEntity2] +1KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +1@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool +2KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +2JFINE: [DEBUG] BasicCrudIntegrationTest$setup - Start time = 1722415561773 +2 +2KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +2^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete +2KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +2«FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[ExampleEntity2] +2KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +2«FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[ExampleEntity2] +2KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +2@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool +3KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +3JFINE: [DEBUG] BasicCrudIntegrationTest$setup - Start time = 1722415561782 +3 +3KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +3^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete +3KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +3«FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[ExampleEntity2] +3KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +3«FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[ExampleEntity2] +3KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +3«FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #3 : SQLite Change Tracker: Changed tables=[ExampleEntity2] +3KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +3@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool +4KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +4JFINE: [DEBUG] BasicCrudIntegrationTest$setup - Start time = 1722415561794 +4 +4KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +4^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete +4KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +4@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool +5KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +5JFINE: [DEBUG] BasicCrudIntegrationTest$setup - Start time = 1722415561798 +5 +5KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +5^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete +5KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +5«FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[ExampleEntity2] +5KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +5«FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #3 : SQLite Change Tracker: Changed tables=[ExampleEntity2] +5KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +5@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool +6KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +6JFINE: [DEBUG] BasicCrudIntegrationTest$setup - Start time = 1722415561805 +6 +6KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +6^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete +6KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +6«FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[ExampleEntity2] +6KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +6FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #2 : SQLite Change Tracker: Changed tables=[] +6KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +6@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool +7KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +7JFINE: [DEBUG] BasicCrudIntegrationTest$setup - Start time = 1722415561813 +7 +7KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +7^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete +7KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +7«FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[ExampleEntity2] +7KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +7@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool +8KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +8JFINE: [DEBUG] BasicCrudIntegrationTest$setup - Start time = 1722415561821 +8 +8KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +8^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete +8KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +8«FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[ExampleEntity2] +8KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +8@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool +9KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +9JFINE: [DEBUG] BasicCrudIntegrationTest$setup - Start time = 1722415561829 +9 +9KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +9^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete +9KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +9«FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[ExampleEntity2] +9KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +9@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool +:KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +:JFINE: [DEBUG] BasicCrudIntegrationTest$setup - Start time = 1722415561838 +: +:KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +:^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete +:KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +:«FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - jdbc:sqlite::memory:] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[ExampleEntity2] +:KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog +:@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool <;KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog <;^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete <;KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog <;@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool >=KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog >=^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete >=KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog >=@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool >?KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog >?^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete >?KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog >?@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool >@KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog >@^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete >@KJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog >@@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool >AKJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog >A^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete >AKJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog >A@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool >BKJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog >B^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete >BKJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog >B@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool >CKJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog >C^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete >CKJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog >C@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool >DKJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog >D^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete >DKJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog >D@FINE: [DEBUG] DoorLog - Closed HikariDataSource connection pool FEKJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog FE^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete FGKJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog FG^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete FHKJul 31, 2024 10:46:01 AM com.ustadmobile.door.log.NapierAntilog performLog FH^INFO: [INFO] DoorLog - [DatabaseBuilder.build - jdbc:sqlite::memory:] database build complete JIKJul 31, 2024 10:46:02 AM com.ustadmobile.door.log.NapierAntilog performLog JIgINFO: [INFO] DoorLog - [DatabaseBuilder.build - java:/comp/env/jdbc/RepDbSpy1] database build complete JIKJul 31, 2024 10:46:02 AM com.ustadmobile.door.log.NapierAntilog performLog JI‰SEVERE: [ERROR] DoorLog - [RoomJdbcImplHelper - java:/comp/env/jdbc/RepDbSpy1] - useNewConnectionAsyncInternal connection #1 exception JI/java.lang.Exception: Exception in transaction! JIÝ at com.ustadmobile.lib.annotationprocessor.core.transaction.TestWithDoorTransaction$givenTransactionStartedAsync_whenExceptionThrown_thenConnectionShouldRollbackAndClose$1$1.invokeSuspend(TestWithDoorTransaction.kt:178) JIÒ at com.ustadmobile.lib.annotationprocessor.core.transaction.TestWithDoorTransaction$givenTransactionStartedAsync_whenExceptionThrown_thenConnectionShouldRollbackAndClose$1$1.invoke(TestWithDoorTransaction.kt) JIÒ at com.ustadmobile.lib.annotationprocessor.core.transaction.TestWithDoorTransaction$givenTransactionStartedAsync_whenExceptionThrown_thenConnectionShouldRollbackAndClose$1$1.invoke(TestWithDoorTransaction.kt) JIu at com.ustadmobile.door.ext.DoorDatabaseExtJvmKt$withDoorTransactionAsync$2.invokeSuspend(DoorDatabaseExtJvm.kt:24) JIk at com.ustadmobile.door.ext.DoorDatabaseExtJvmKt$withDoorTransactionAsync$2.invoke(DoorDatabaseExtJvm.kt) JIk at com.ustadmobile.door.ext.DoorDatabaseExtJvmKt$withDoorTransactionAsync$2.invoke(DoorDatabaseExtJvm.kt) JI at com.ustadmobile.door.room.RoomDatabaseJdbcImplHelperCommon$useNewConnectionAsyncInternal$result$1.invokeSuspend(RoomDatabaseJdbcImplHelperCommon.kt:136) JI’ at com.ustadmobile.door.room.RoomDatabaseJdbcImplHelperCommon$useNewConnectionAsyncInternal$result$1.invoke(RoomDatabaseJdbcImplHelperCommon.kt) JI’ at com.ustadmobile.door.room.RoomDatabaseJdbcImplHelperCommon$useNewConnectionAsyncInternal$result$1.invoke(RoomDatabaseJdbcImplHelperCommon.kt) JI_ at kotlinx.coroutines.intrinsics.UndispatchedKt.startUndispatchedOrReturn(Undispatched.kt:61) JIY at kotlinx.coroutines.BuildersKt__Builders_commonKt.withContext(Builders.common.kt:163) JI> at kotlinx.coroutines.BuildersKt.withContext(Unknown Source) JI† at com.ustadmobile.door.room.RoomDatabaseJdbcImplHelperCommon.useNewConnectionAsyncInternal(RoomDatabaseJdbcImplHelperCommon.kt:135) JIŒ at com.ustadmobile.door.room.RoomDatabaseJdbcImplHelperCommon.access$useNewConnectionAsyncInternal(RoomDatabaseJdbcImplHelperCommon.kt:21) JI’ at com.ustadmobile.door.room.RoomDatabaseJdbcImplHelperCommon$useNewConnectionAsyncInternal$1.invokeSuspend(RoomDatabaseJdbcImplHelperCommon.kt) JI5 at _COROUTINE._BOUNDARY._(CoroutineDebugging.kt:42) JI† at com.ustadmobile.door.room.RoomDatabaseJdbcImplHelperCommon.useNewConnectionAsyncInternal(RoomDatabaseJdbcImplHelperCommon.kt:135) JI at com.ustadmobile.door.room.RoomDatabaseJdbcImplHelperCommon$useConnectionAsync$2$2.invokeSuspend(RoomDatabaseJdbcImplHelperCommon.kt:237) JI‹ at com.ustadmobile.door.room.RoomDatabaseJdbcImplHelperCommon$useConnectionAsync$2.invokeSuspend(RoomDatabaseJdbcImplHelperCommon.kt:235) JIÛ at com.ustadmobile.lib.annotationprocessor.core.transaction.TestWithDoorTransaction$givenTransactionStartedAsync_whenExceptionThrown_thenConnectionShouldRollbackAndClose$1.invokeSuspend(TestWithDoorTransaction.kt:177) JI:Caused by: java.lang.Exception: Exception in transaction! JIÝ at com.ustadmobile.lib.annotationprocessor.core.transaction.TestWithDoorTransaction$givenTransactionStartedAsync_whenExceptionThrown_thenConnectionShouldRollbackAndClose$1$1.invokeSuspend(TestWithDoorTransaction.kt:178) JIÒ at com.ustadmobile.lib.annotationprocessor.core.transaction.TestWithDoorTransaction$givenTransactionStartedAsync_whenExceptionThrown_thenConnectionShouldRollbackAndClose$1$1.invoke(TestWithDoorTransaction.kt) JIÒ at com.ustadmobile.lib.annotationprocessor.core.transaction.TestWithDoorTransaction$givenTransactionStartedAsync_whenExceptionThrown_thenConnectionShouldRollbackAndClose$1$1.invoke(TestWithDoorTransaction.kt) JIu at com.ustadmobile.door.ext.DoorDatabaseExtJvmKt$withDoorTransactionAsync$2.invokeSuspend(DoorDatabaseExtJvm.kt:24) JIk at com.ustadmobile.door.ext.DoorDatabaseExtJvmKt$withDoorTransactionAsync$2.invoke(DoorDatabaseExtJvm.kt) JIk at com.ustadmobile.door.ext.DoorDatabaseExtJvmKt$withDoorTransactionAsync$2.invoke(DoorDatabaseExtJvm.kt) JI at com.ustadmobile.door.room.RoomDatabaseJdbcImplHelperCommon$useNewConnectionAsyncInternal$result$1.invokeSuspend(RoomDatabaseJdbcImplHelperCommon.kt:136) JI’ at com.ustadmobile.door.room.RoomDatabaseJdbcImplHelperCommon$useNewConnectionAsyncInternal$result$1.invoke(RoomDatabaseJdbcImplHelperCommon.kt) JI’ at com.ustadmobile.door.room.RoomDatabaseJdbcImplHelperCommon$useNewConnectionAsyncInternal$result$1.invoke(RoomDatabaseJdbcImplHelperCommon.kt) JI_ at kotlinx.coroutines.intrinsics.UndispatchedKt.startUndispatchedOrReturn(Undispatched.kt:61) JIY at kotlinx.coroutines.BuildersKt__Builders_commonKt.withContext(Builders.common.kt:163) JI> at kotlinx.coroutines.BuildersKt.withContext(Unknown Source) JI† at com.ustadmobile.door.room.RoomDatabaseJdbcImplHelperCommon.useNewConnectionAsyncInternal(RoomDatabaseJdbcImplHelperCommon.kt:135) JIŒ at com.ustadmobile.door.room.RoomDatabaseJdbcImplHelperCommon.access$useNewConnectionAsyncInternal(RoomDatabaseJdbcImplHelperCommon.kt:21) JI’ at com.ustadmobile.door.room.RoomDatabaseJdbcImplHelperCommon$useNewConnectionAsyncInternal$1.invokeSuspend(RoomDatabaseJdbcImplHelperCommon.kt) JI[ at kotlin.coroutines.jvm.internal.BaseContinuationImpl.resumeWith(ContinuationImpl.kt:33) JIA at kotlinx.coroutines.DispatchedTask.run(DispatchedTask.kt:104) JIZ at kotlinx.coroutines.scheduling.CoroutineScheduler.runSafely(CoroutineScheduler.kt:585) JIc at kotlinx.coroutines.scheduling.CoroutineScheduler$Worker.executeTask(CoroutineScheduler.kt:802) JIa at kotlinx.coroutines.scheduling.CoroutineScheduler$Worker.runWorker(CoroutineScheduler.kt:706) JI[ at kotlinx.coroutines.scheduling.CoroutineScheduler$Worker.run(CoroutineScheduler.kt:693) JI JIKJul 31, 2024 10:46:02 AM com.ustadmobile.door.log.NapierAntilog performLog JI¡INFO: [INFO] DoorLog - [RoomJdbcImplHelper - java:/comp/env/jdbc/RepDbSpy1] - useNewConnectionAsyncInternal connection #1 Attempting to rollback transaction #1 JIKJul 31, 2024 10:46:02 AM com.ustadmobile.door.log.NapierAntilog performLog JIINFO: [INFO] DoorLog - [RoomJdbcImplHelper - java:/comp/env/jdbc/RepDbSpy1] - useNewConnectionAsyncInternal connection #1 Rolled back changes JKKJul 31, 2024 10:46:02 AM com.ustadmobile.door.log.NapierAntilog performLog JKgINFO: [INFO] DoorLog - [DatabaseBuilder.build - java:/comp/env/jdbc/RepDbSpy1] database build complete JLKJul 31, 2024 10:46:02 AM com.ustadmobile.door.log.NapierAntilog performLog JLgINFO: [INFO] DoorLog - [DatabaseBuilder.build - java:/comp/env/jdbc/RepDbSpy1] database build complete JMKJul 31, 2024 10:46:02 AM com.ustadmobile.door.log.NapierAntilog performLog JMgINFO: [INFO] DoorLog - [DatabaseBuilder.build - java:/comp/env/jdbc/RepDbSpy1] database build complete JMKJul 31, 2024 10:46:02 AM com.ustadmobile.door.log.NapierAntilog performLog JM}SEVERE: [ERROR] DoorLog - [RoomJdbcImplHelper - java:/comp/env/jdbc/RepDbSpy1] - newConnectionInternal - Thread #1 exception JM/java.lang.Exception: Exception in transaction! JMÄ at com.ustadmobile.lib.annotationprocessor.core.transaction.TestWithDoorTransaction$givenTransactionStarted_whenExceptionThrown_thenConnectionShouldClose$1.invoke(TestWithDoorTransaction.kt:161) JMÄ at com.ustadmobile.lib.annotationprocessor.core.transaction.TestWithDoorTransaction$givenTransactionStarted_whenExceptionThrown_thenConnectionShouldClose$1.invoke(TestWithDoorTransaction.kt:160) JMi at com.ustadmobile.door.ext.DoorDatabaseExtJvmKt$withDoorTransaction$1.invoke(DoorDatabaseExtJvm.kt:35) JMi at com.ustadmobile.door.ext.DoorDatabaseExtJvmKt$withDoorTransaction$1.invoke(DoorDatabaseExtJvm.kt:32) JMt at com.ustadmobile.door.room.RoomDatabaseJdbcImplHelper.useNewConnectionInternal(RoomDatabaseJdbcImplHelper.kt:79) JM{ at com.ustadmobile.door.room.RoomDatabaseJdbcImplHelper.access$useNewConnectionInternal(RoomDatabaseJdbcImplHelper.kt:23) JM| at com.ustadmobile.door.room.RoomDatabaseJdbcImplHelper$useConnection$1$1.invokeSuspend(RoomDatabaseJdbcImplHelper.kt:131) JMq at com.ustadmobile.door.room.RoomDatabaseJdbcImplHelper$useConnection$1$1.invoke(RoomDatabaseJdbcImplHelper.kt) JMq at com.ustadmobile.door.room.RoomDatabaseJdbcImplHelper$useConnection$1$1.invoke(RoomDatabaseJdbcImplHelper.kt) JMl at kotlinx.coroutines.intrinsics.UndispatchedKt.startUndispatchedOrReturnIgnoreTimeout(Undispatched.kt:72) JM> at kotlinx.coroutines.TimeoutKt.setupTimeout(Timeout.kt:148) JM< at kotlinx.coroutines.TimeoutKt.withTimeout(Timeout.kt:43) JMz at com.ustadmobile.door.room.RoomDatabaseJdbcImplHelper$useConnection$1.invokeSuspend(RoomDatabaseJdbcImplHelper.kt:129) JM[ at kotlin.coroutines.jvm.internal.BaseContinuationImpl.resumeWith(ContinuationImpl.kt:33) JMA at kotlinx.coroutines.DispatchedTask.run(DispatchedTask.kt:104) JMS at kotlinx.coroutines.EventLoopImplBase.processNextEvent(EventLoop.common.kt:277) JMF at kotlinx.coroutines.BlockingCoroutine.joinBlocking(Builders.kt:95) JMJ at kotlinx.coroutines.BuildersKt__BuildersKt.runBlocking(Builders.kt:69) JM> at kotlinx.coroutines.BuildersKt.runBlocking(Unknown Source) JMR at kotlinx.coroutines.BuildersKt__BuildersKt.runBlocking$default(Builders.kt:48) JMF at kotlinx.coroutines.BuildersKt.runBlocking$default(Unknown Source) JMj at com.ustadmobile.door.room.RoomDatabaseJdbcImplHelper.useConnection(RoomDatabaseJdbcImplHelper.kt:128) JM` at com.ustadmobile.door.ext.DoorDatabaseExtJvmKt.withDoorTransaction(DoorDatabaseExtJvm.kt:32) JMh at com.ustadmobile.door.ext.DoorDatabaseExtJvmKt.withDoorTransaction$default(DoorDatabaseExtJvm.kt:28) JM» at com.ustadmobile.lib.annotationprocessor.core.transaction.TestWithDoorTransaction.givenTransactionStarted_whenExceptionThrown_thenConnectionShouldClose(TestWithDoorTransaction.kt:160) JMS at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) JMe at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77) JMm at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) JM? at java.base/java.lang.reflect.Method.invoke(Method.java:568) JMY at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:59) JMX at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) JMW at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:56) JMV at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) JMR at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26) JMP at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27) JME at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306) JMY at org.junit.runners.BlockJUnit4ClassRunner$1.evaluate(BlockJUnit4ClassRunner.java:100) JMB at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:366) JMW at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:103) JMV at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:63) JM@ at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331) JMD at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79) JMF at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329) JMD at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66) JME at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293) JME at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306) JM> at org.junit.runners.ParentRunner.run(ParentRunner.java:413) JMu at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecutor.runTestClass(JUnitTestClassExecutor.java:112) JMo at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecutor.execute(JUnitTestClassExecutor.java:58) JMo at org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecutor.execute(JUnitTestClassExecutor.java:40) JMŠ at org.gradle.api.internal.tasks.testing.junit.AbstractJUnitTestClassProcessor.processTestClass(AbstractJUnitTestClassProcessor.java:60) JMt at org.gradle.api.internal.tasks.testing.SuiteTestClassProcessor.processTestClass(SuiteTestClassProcessor.java:52) JMS at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) JMe at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77) JMm at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) JM? at java.base/java.lang.reflect.Method.invoke(Method.java:568) JMY at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:36) JMY at org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:24) JMi at org.gradle.internal.dispatch.ContextClassLoaderDispatch.dispatch(ContextClassLoaderDispatch.java:33) JMx at org.gradle.internal.dispatch.ProxyDispatchAdapter$DispatchingInvocationHandler.invoke(ProxyDispatchAdapter.java:94) JMC at jdk.proxy1/jdk.proxy1.$Proxy2.processTestClass(Unknown Source) JMW at org.gradle.api.internal.tasks.testing.worker.TestWorker$2.run(TestWorker.java:176) JMn at org.gradle.api.internal.tasks.testing.worker.TestWorker.executeAndMaintainThreadName(TestWorker.java:129) JMY at org.gradle.api.internal.tasks.testing.worker.TestWorker.execute(TestWorker.java:100) JMX at org.gradle.api.internal.tasks.testing.worker.TestWorker.execute(TestWorker.java:60) JMj at org.gradle.process.internal.worker.child.ActionExecutionWorker.execute(ActionExecutionWorker.java:56) JM‚ at org.gradle.process.internal.worker.child.SystemApplicationClassLoaderWorker.call(SystemApplicationClassLoaderWorker.java:113) JM at org.gradle.process.internal.worker.child.SystemApplicationClassLoaderWorker.call(SystemApplicationClassLoaderWorker.java:65) JM] at worker.org.gradle.process.internal.worker.GradleWorkerMain.run(GradleWorkerMain.java:69) JM^ at worker.org.gradle.process.internal.worker.GradleWorkerMain.main(GradleWorkerMain.java:74) JM JNKJul 31, 2024 10:46:02 AM com.ustadmobile.door.log.NapierAntilog performLog JNgINFO: [INFO] DoorLog - [DatabaseBuilder.build - java:/comp/env/jdbc/RepDbSpy1] database build complete JNKJul 31, 2024 10:46:02 AM com.ustadmobile.door.log.NapierAntilog performLog JN¹FINE: [DEBUG] DoorLog - [RoomJdbcImplHelper - java:/comp/env/jdbc/RepDbSpy1] - useNewConnectionAsyncInternal connection #1 : SQLite Change Tracker: Changed tables=[RepEntity, DoorNode]