2024-05-02 12:23:35,590 INFO [startup] [AbstractCommandLauncher] [main] Command: {} 2024-05-02 12:23:35,592 INFO [startup] [AbstractCommandLauncher] [main] Option: name=max-idle-time, value={90000} 2024-05-02 12:23:35,592 INFO [startup] [AbstractCommandLauncher] [main] Option: name=no-log-console, value={} 2024-05-02 12:23:35,778 INFO [startup] [SymmetricUtils] [main] _____ __ _ ____ _____ / ___/ __ _____ __ ___ __ ___ _/ /_ ____(_)___ / __ | / ___/ \__ \ / / / / _ `_ \/ _ `_ \/ _ \/_ __// __/ / __/ / / / / \__ \ ___/ // /_/ / // // / // // / __// / / / / / /_ / /_/ / ___/ / /____/ \__ /_//_//_/_//_//_/\___/ \_/ /_/ /_/\__/ /_____/ /____/ /____/ +-----------------------------------------------------------------+ | Copyright (C) 2007-2024 JumpMind, Inc. | | | | Licensed under the GNU General Public License version 3. | | This software comes with ABSOLUTELY NO WARRANTY. | | See http://www.gnu.org/licenses/gpl.html | +-----------------------------------------------------------------+ 2024-05-02 12:23:35,778 INFO [startup] [SymmetricWebServer] [main] About to start SymmetricDS web server on 0.0.0.0:31415:HTTP/1.1 with context path / 2024-05-02 12:23:36,520 INFO [startup] [SymmetricLauncher] [main] Starting SymmetricLauncher v3.15.5 using Java 17.0.11 with PID 3974 (/opt/symmetric-server-3.15.5/web/WEB-INF/lib/symmetric-server-3.15.5.jar started by root in /opt/symmetric-server-3.15.5) 2024-05-02 12:23:36,521 INFO [startup] [SymmetricLauncher] [main] No active profile set, falling back to 1 default profile: "default" 2024-05-02 12:23:38,517 INFO [startup] [SymmetricEngineHolder] [main] Current directory is /opt/symmetric-server-3.15.5 2024-05-02 12:23:38,517 INFO [startup] [SymmetricEngineHolder] [main] Starting in single-server mode 2024-05-02 12:23:38,726 INFO [edoc-001] [ClientSymmetricEngine] [symmetric-engine-startup-1] Initializing connection to database 2024-05-02 12:23:39,175 INFO [startup] [SymmetricLauncher] [main] Started SymmetricLauncher in 2.905 seconds (process running for 5.17) 2024-05-02 12:23:39,204 INFO [edoc-001] [JdbcDatabasePlatformFactory] [symmetric-engine-startup-1] Detected database 'SQLite', version '3', protocol 'sqlite' 2024-05-02 12:23:39,211 INFO [edoc-001] [JdbcDatabasePlatformFactory] [symmetric-engine-startup-1] The IDatabasePlatform being used is org.jumpmind.db.platform.sqlite.SqliteDatabasePlatform 2024-05-02 12:23:39,382 INFO [edoc-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-1] The DbDialect being used is org.jumpmind.symmetric.db.sqlite.SqliteJdbcSymmetricDialect 2024-05-02 12:23:39,448 INFO [edoc-001] [ExtensionService] [symmetric-engine-startup-1] Found 0 extension points from the database that will be registered 2024-05-02 12:23:39,454 INFO [edoc-001] [StagingManager] [symmetric-engine-startup-1] The staging directory was initialized at the following location: tmp/edoc-001 2024-05-02 12:23:39,829 INFO [edoc-001] [ExtensionService] [symmetric-engine-startup-1] Found 0 extension points from the database that will be registered 2024-05-02 12:23:39,831 INFO [edoc-001] [ClientExtensionService] [symmetric-engine-startup-1] Found 7 extension points from spring that will be registered 2024-05-02 12:23:39,836 INFO [edoc-001] [AbstractSymmetricEngine] [symmetric-engine-startup-1] Initializing SymmetricDS database 2024-05-02 12:23:39,863 INFO [edoc-001] [AbstractSymmetricEngine] [symmetric-engine-startup-1] Version matches for tables and objects 2024-05-02 12:23:39,875 INFO [edoc-001] [AbstractSymmetricEngine] [symmetric-engine-startup-1] Done initializing SymmetricDS database 2024-05-02 12:23:39,875 INFO [edoc-001] [AbstractSymmetricEngine] [symmetric-engine-startup-1] SymmetricDS database version : 3.15.5 2024-05-02 12:23:39,876 INFO [edoc-001] [AbstractSymmetricEngine] [symmetric-engine-startup-1] SymmetricDS software version : 3.15.5 2024-05-02 12:23:39,879 INFO [edoc-001] [AbstractSymmetricEngine] [symmetric-engine-startup-1] Starting registered node [group=edoc, id=001, nodeId=001] 2024-05-02 12:23:39,901 INFO [edoc-001] [AbstractSymmetricEngine] [symmetric-engine-startup-1] auto.sync.triggers.at.startup is turned off 2024-05-02 12:23:39,916 INFO [edoc-001] [RouterJob] [symmetric-engine-startup-1] Starting job 'Routing' on periodic schedule every 5000ms with the first run at 2024-05-02T12:23:41.423+0300 2024-05-02 12:23:39,925 INFO [edoc-001] [PushJob] [symmetric-engine-startup-1] Starting job 'Push' on periodic schedule every 10000ms with the first run at 2024-05-02T12:23:45.888+0300 2024-05-02 12:23:39,926 INFO [edoc-001] [PullJob] [symmetric-engine-startup-1] Starting job 'Pull' on periodic schedule every 10000ms with the first run at 2024-05-02T12:23:47.337+0300 2024-05-02 12:23:39,926 INFO [edoc-001] [OfflinePushJob] [symmetric-engine-startup-1] Starting job 'Offline Push' on periodic schedule every 10000ms with the first run at 2024-05-02T12:23:49.140+0300 2024-05-02 12:23:39,927 INFO [edoc-001] [OfflinePullJob] [symmetric-engine-startup-1] Starting job 'Offline Pull' on periodic schedule every 10000ms with the first run at 2024-05-02T12:23:45.217+0300 2024-05-02 12:23:39,934 INFO [edoc-001] [OutgoingPurgeJob] [symmetric-engine-startup-1] Starting job 'Purge Outgoing' on cron schedule '0 0 */4 * * *' with the first run at 2024-05-02T16:00:00.000+0300 2024-05-02 12:23:39,935 INFO [edoc-001] [IncomingPurgeJob] [symmetric-engine-startup-1] Starting job 'Purge Incoming' on cron schedule '0 0 */4 * * *' with the first run at 2024-05-02T16:00:00.000+0300 2024-05-02 12:23:39,936 INFO [edoc-001] [StatisticFlushJob] [symmetric-engine-startup-1] Starting job 'Stat Flush' on cron schedule '0 0/5 * * * *' with the first run at 2024-05-02T12:25:00.000+0300 2024-05-02 12:23:39,937 INFO [edoc-001] [SyncTriggersJob] [symmetric-engine-startup-1] Starting job 'SyncTriggers' on cron schedule '0 0 0 * * *' with the first run at 2024-05-03T00:00:00.000+0300 2024-05-02 12:23:39,938 INFO [edoc-001] [HeartbeatJob] [symmetric-engine-startup-1] Starting job 'Heartbeat' on periodic schedule every 900000ms with the first run at 2024-05-02T12:23:49.152+0300 2024-05-02 12:23:39,938 INFO [edoc-001] [WatchdogJob] [symmetric-engine-startup-1] Starting job 'Watchdog' on periodic schedule every 3600000ms with the first run at 2024-05-02T12:23:40.939+0300 2024-05-02 12:23:39,944 INFO [edoc-001] [StageManagementJob] [symmetric-engine-startup-1] Starting job 'Stage Management' on cron schedule '0 0 * * * *' with the first run at 2024-05-02T13:00:00.000+0300 2024-05-02 12:23:39,944 INFO [edoc-001] [JobManager] [symmetric-engine-startup-1] Job Refresh Cache not configured for auto start 2024-05-02 12:23:39,944 INFO [edoc-001] [JobManager] [symmetric-engine-startup-1] Job File Sync Tracker not configured for auto start 2024-05-02 12:23:39,945 INFO [edoc-001] [JobManager] [symmetric-engine-startup-1] Job File Sync Pull not configured for auto start 2024-05-02 12:23:39,945 INFO [edoc-001] [JobManager] [symmetric-engine-startup-1] Job File Sync Push not configured for auto start 2024-05-02 12:23:39,945 INFO [edoc-001] [InitialLoadExtractorJob] [symmetric-engine-startup-1] Starting job 'Initial Load Extract' on periodic schedule every 10000ms with the first run at 2024-05-02T12:23:43.296+0300 2024-05-02 12:23:39,945 INFO [edoc-001] [JobManager] [symmetric-engine-startup-1] Job Report Status not configured for auto start 2024-05-02 12:23:39,945 INFO [edoc-001] [JobManager] [symmetric-engine-startup-1] Job Log Miner not configured for auto start 2024-05-02 12:23:39,946 INFO [edoc-001] [InitialLoadJob] [symmetric-engine-startup-1] Starting job 'Initial Load Queue' on periodic schedule every 10000ms with the first run at 2024-05-02T12:23:44.959+0300 2024-05-02 12:23:39,948 INFO [edoc-001] [ClusterService] [symmetric-engine-startup-1] This node picked a server id of edoc 2024-05-02 12:23:39,959 INFO [edoc-001] [AbstractSymmetricEngine] [symmetric-engine-startup-1] SymmetricDS Node STARTED: nodeId=001 groupId=edoc type=null subType=trigger-based name=edoc-001 softwareVersion=3.15.5 databaseName=SQLite databaseVersion=3.45 driverName=SQLite JDBC driverVersion=3.45.3.0 uptime=0 sec. 2024-05-02 12:23:41,497 INFO [edoc-001] [DataGapFastDetector] [edoc-001-job-2] Full gap analysis is running 2024-05-02 12:23:41,500 INFO [edoc-001] [DataGapFastDetector] [edoc-001-job-2] Querying data in gaps from database took 2 ms 2024-05-02 12:23:41,500 INFO [edoc-001] [DataGapFastDetector] [edoc-001-job-2] Full gap analysis is done after 2 ms 2024-05-02 12:23:45,304 INFO [edoc-001] [OfflinePullService] [edoc-001-offln_pull-default-1] Offline pull data read for main:000:000. 2 rows and 2 batches were processed 2024-05-02 12:23:45,330 INFO [edoc-001] [OfflinePullService] [edoc-001-offln_pull-default-1] Offline pull data read for main:000:000. 5 rows and 4 batches were processed 2024-05-02 12:23:45,344 INFO [edoc-001] [OfflinePullService] [edoc-001-offln_pull-default-1] Offline pull data read for main:000:000. 7 rows and 6 batches were processed 2024-05-02 12:23:45,366 INFO [edoc-001] [OfflinePullService] [edoc-001-offln_pull-default-1] Offline pull data read for main:000:000. 11 rows and 8 batches were processed 2024-05-02 12:23:45,371 INFO [edoc-001] [OfflinePullService] [edoc-001-offln_pull-default-1] Offline pull data read for main:000:000. 14 rows and 9 batches were processed 2024-05-02 12:23:45,390 INFO [edoc-001] [OfflinePullService] [edoc-001-offln_pull-default-1] Offline pull data read for main:000:000. 18 rows and 11 batches were processed 2024-05-02 12:23:45,400 INFO [edoc-001] [OfflinePullService] [edoc-001-offln_pull-default-1] Offline pull data read for main:000:000. 21 rows and 12 batches were processed 2024-05-02 12:23:45,419 INFO [edoc-001] [OfflinePullService] [edoc-001-offln_pull-default-1] Offline pull data read for main:000:000. 23 rows and 14 batches were processed 2024-05-02 12:23:45,467 INFO [edoc-001] [OfflinePullService] [edoc-001-offln_pull-default-1] Offline pull data read for main:000:000. 32 rows and 17 batches were processed 2024-05-02 12:23:45,503 INFO [edoc-001] [OfflinePullService] [edoc-001-offln_pull-default-1] Offline pull data read for main:000:000. 37 rows and 21 batches were processed 2024-05-02 12:23:45,509 INFO [edoc-001] [OfflinePullService] [edoc-001-offln_pull-default-1] Offline pull data read for main:000:000. 38 rows and 22 batches were processed 2024-05-02 12:23:45,513 INFO [edoc-001] [OfflinePullService] [edoc-001-offln_pull-default-1] Offline pull data read for main:000:000. 39 rows and 23 batches were processed 2024-05-02 12:23:45,539 INFO [edoc-001] [OfflinePullService] [edoc-001-offln_pull-default-1] Offline pull data read for main:000:000. 41 rows and 25 batches were processed 2024-05-02 12:23:45,550 INFO [edoc-001] [OfflinePullService] [edoc-001-offln_pull-default-1] Offline pull data read for main:000:000. 42 rows and 26 batches were processed 2024-05-02 12:23:45,556 INFO [edoc-001] [OfflinePullService] [edoc-001-offln_pull-default-1] Offline pull data read for main:000:000. 43 rows and 27 batches were processed 2024-05-02 12:23:45,573 INFO [edoc-001] [OfflinePullService] [edoc-001-offln_pull-default-1] Offline pull data read for main:000:000. 44 rows and 28 batches were processed 2024-05-02 12:23:46,540 INFO [edoc-001] [RouterService] [edoc-001-job-7] Routed 2 data events in 37 ms 2024-05-02 12:23:47,338 INFO [edoc-001] [NodeCommunicationService] [edoc-001-job-8] pull will use 10 threads 2024-05-02 12:23:51,546 INFO [edoc-001] [RouterService] [edoc-001-job-11] Routed 1 data events in 4 ms 2024-05-02 12:23:59,189 INFO [edoc-001] [OfflinePushService] [edoc-001-offln_push-default-1] Offline push data written for main:000:000 at tmp/edoc-001/offline/outgoing 2024-05-02 12:23:59,199 INFO [edoc-001] [OfflinePushService] [edoc-001-offln_push-default-1] Offline push data written for main:000:000. 1 data and 1 batches were processed 2024-05-02 12:24:25,287 INFO [edoc-001] [OfflinePullService] [edoc-001-offln_pull-default-1] Offline pull data read for main:000:000. 3 rows and 2 batches were processed 2024-05-02 12:26:25,258 INFO [edoc-001] [OfflinePullService] [edoc-001-offln_pull-default-1] Offline pull data read for main:000:000. 2 rows and 1 batches were processed