2021-03-29 23:55:34,274 INFO [startup] [SymmetricUtils] [main] _____ __ _ ____ _____ / ___/ __ _____ __ ___ __ ___ _/ /_ ____(_)___ / __ | / ___/ \__ \ / / / / _ `_ \/ _ `_ \/ _ \/_ __// __/ / __/ / / / / \__ \ ___/ // /_/ / // // / // // / __// / / / / / /_ / /_/ / ___/ / /____/ \__ /_//_//_/_//_//_/\___/ \_/ /_/ /_/\__/ /_____/ /____/ /____/ +-----------------------------------------------------------------+ | Copyright (C) 2007-2021 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 | +-----------------------------------------------------------------+ 2021-03-29 23:55:34,387 INFO [startup] [SymmetricWebServer] [main] About to start SymmetricDS web server on 0.0.0.0:31415:HTTP/1.1 2021-03-29 23:55:35,055 INFO [startup] [SymmetricEngineHolder] [main] Current directory is C:\Users\matth\OneDrive - University of Sussex\University of Sussex\Final Year Project\symmetric-server-3.12.7-SQLiteTest\symmetric-server-3.12.7 2021-03-29 23:55:35,055 INFO [startup] [SymmetricEngineHolder] [main] Starting in multi-server mode with engines directory at C:\Users\matth\OneDrive - University of Sussex\University of Sussex\Final Year Project\symmetric-server-3.12.7-SQLiteTest\symmetric-server-3.12.7/engines 2021-03-29 23:55:35,142 INFO [node-002] [AbstractSymmetricEngine] [symmetric-engine-startup-3] Initializing connection to database 2021-03-29 23:55:35,142 INFO [master-000] [AbstractSymmetricEngine] [symmetric-engine-startup-1] Initializing connection to database 2021-03-29 23:55:35,142 INFO [node-001] [AbstractSymmetricEngine] [symmetric-engine-startup-2] Initializing connection to database 2021-03-29 23:55:35,472 INFO [node-002] [JdbcDatabasePlatformFactory] [symmetric-engine-startup-3] Detected database 'SQLite', version '3', protocol 'sqlite' 2021-03-29 23:55:35,494 INFO [node-002] [JdbcDatabasePlatformFactory] [symmetric-engine-startup-3] The IDatabasePlatform being used is org.jumpmind.db.platform.sqlite.SqliteDatabasePlatform 2021-03-29 23:55:35,591 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] The DbDialect being used is org.jumpmind.symmetric.db.sqlite.SqliteJdbcSymmetricDialect 2021-03-29 23:55:35,631 INFO [node-002] [StagingManager] [symmetric-engine-startup-3] The staging directory was initialized at the following location: C:\Users\matth\OneDrive - University of Sussex\University of Sussex\Final Year Project\symmetric-server-3.12.7-SQLiteTest\symmetric-server-3.12.7\tmp\node-002 2021-03-29 23:55:36,627 INFO [node-002] [ClientExtensionService] [symmetric-engine-startup-3] Found 8 extension points from spring that will be registered 2021-03-29 23:55:36,645 INFO [node-002] [AbstractSymmetricEngine] [symmetric-engine-startup-3] Initializing SymmetricDS database 2021-03-29 23:55:36,645 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] Checking if SymmetricDS tables need created or altered 2021-03-29 23:55:36,852 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] There are SymmetricDS tables that needed altered 2021-03-29 23:55:36,867 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_channel"( "channel_id" VARCHAR NOT NULL PRIMARY KEY , "processing_order" INTEGER DEFAULT (1) NOT NULL, "max_batch_size" INTEGER DEFAULT (1000) NOT NULL, "max_batch_to_send" INTEGER DEFAULT (60) NOT NULL, "max_data_to_route" INTEGER DEFAULT (100000) NOT NULL, "extract_period_millis" INTEGER DEFAULT (0) NOT NULL, "enabled" INTEGER DEFAULT (1) NOT NULL, "use_old_data_to_route" INTEGER DEFAULT (1) NOT NULL, "use_row_data_to_route" INTEGER DEFAULT (1) NOT NULL, "use_pk_data_to_route" INTEGER DEFAULT (1) NOT NULL, "reload_flag" INTEGER DEFAULT (0) NOT NULL, "file_sync_flag" INTEGER DEFAULT (0) NOT NULL, "contains_big_lob" INTEGER DEFAULT (0) NOT NULL, "batch_algorithm" VARCHAR DEFAULT ('default') NOT NULL, "data_loader_type" VARCHAR DEFAULT ('default') NOT NULL, "description" VARCHAR, "queue" VARCHAR DEFAULT ('default') NOT NULL, "max_network_kbps" DECIMAL DEFAULT (0.000) NOT NULL, "data_event_action" VARCHAR, "create_time" TIMESTAMP, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP ) 2021-03-29 23:55:36,879 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_conflict"( "conflict_id" VARCHAR NOT NULL PRIMARY KEY , "source_node_group_id" VARCHAR NOT NULL, "target_node_group_id" VARCHAR NOT NULL, "target_channel_id" VARCHAR, "target_catalog_name" VARCHAR, "target_schema_name" VARCHAR, "target_table_name" VARCHAR, "detect_type" VARCHAR NOT NULL, "detect_expression" VARCHAR, "resolve_type" VARCHAR NOT NULL, "ping_back" VARCHAR NOT NULL, "resolve_changes_only" INTEGER DEFAULT (0), "resolve_row_only" INTEGER DEFAULT (0), "create_time" TIMESTAMP NOT NULL, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP NOT NULL, FOREIGN KEY ("source_node_group_id", "target_node_group_id") REFERENCES "sym_node_group_link" ("source_node_group_id", "target_node_group_id") ) 2021-03-29 23:55:36,891 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_context"( "name" VARCHAR NOT NULL PRIMARY KEY , "context_value" VARCHAR, "create_time" TIMESTAMP, "last_update_time" TIMESTAMP ) 2021-03-29 23:55:36,902 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_data"( "data_id" INTEGER NOT NULL PRIMARY KEY AUTOINCREMENT, "table_name" VARCHAR NOT NULL, "event_type" VARCHAR NOT NULL, "row_data" VARCHAR, "pk_data" VARCHAR, "old_data" VARCHAR, "trigger_hist_id" INTEGER NOT NULL, "channel_id" VARCHAR, "transaction_id" VARCHAR, "source_node_id" VARCHAR, "external_data" VARCHAR, "node_list" VARCHAR, "is_prerouted" INTEGER DEFAULT (0) NOT NULL, "create_time" TIMESTAMP ) 2021-03-29 23:55:36,913 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE UNIQUE INDEX "sym_idx_d_channel_id" ON "sym_data" ("data_id", "channel_id") 2021-03-29 23:55:36,925 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_data_event"( "data_id" INTEGER NOT NULL, "batch_id" INTEGER NOT NULL, "create_time" TIMESTAMP, PRIMARY KEY ("data_id", "batch_id") ) 2021-03-29 23:55:36,936 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE INDEX "sym_idx_de_batchid" ON "sym_data_event" ("batch_id") 2021-03-29 23:55:36,947 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_data_gap"( "start_id" INTEGER NOT NULL, "end_id" INTEGER NOT NULL, "create_time" TIMESTAMP NOT NULL, "last_update_hostname" VARCHAR, PRIMARY KEY ("start_id", "end_id") ) 2021-03-29 23:55:36,958 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_extension"( "extension_id" VARCHAR NOT NULL PRIMARY KEY , "extension_type" VARCHAR NOT NULL, "interface_name" VARCHAR, "node_group_id" VARCHAR NOT NULL, "enabled" INTEGER DEFAULT (1) NOT NULL, "extension_order" INTEGER DEFAULT (1) NOT NULL, "extension_text" VARCHAR, "create_time" TIMESTAMP, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP ) 2021-03-29 23:55:36,970 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_extract_request"( "request_id" INTEGER NOT NULL PRIMARY KEY , "node_id" VARCHAR NOT NULL, "queue" VARCHAR, "status" VARCHAR, "start_batch_id" INTEGER NOT NULL, "end_batch_id" INTEGER NOT NULL, "trigger_id" VARCHAR NOT NULL, "router_id" VARCHAR NOT NULL, "load_id" INTEGER, "table_name" VARCHAR, "extracted_rows" INTEGER DEFAULT (0) NOT NULL, "extracted_millis" INTEGER DEFAULT (0) NOT NULL, "transferred_rows" INTEGER DEFAULT (0) NOT NULL, "transferred_millis" INTEGER DEFAULT (0) NOT NULL, "last_transferred_batch_id" INTEGER, "loaded_rows" INTEGER DEFAULT (0) NOT NULL, "loaded_millis" INTEGER DEFAULT (0) NOT NULL, "last_loaded_batch_id" INTEGER, "total_rows" INTEGER, "loaded_time" TIMESTAMP, "parent_request_id" INTEGER DEFAULT (0) NOT NULL, "last_update_time" TIMESTAMP, "create_time" TIMESTAMP ) 2021-03-29 23:55:36,981 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_file_incoming"( "relative_dir" VARCHAR NOT NULL, "file_name" VARCHAR NOT NULL, "last_event_type" VARCHAR NOT NULL, "node_id" VARCHAR NOT NULL, "file_modified_time" INTEGER, PRIMARY KEY ("relative_dir", "file_name") ) 2021-03-29 23:55:36,984 INFO [startup] [SymmetricWebServer] [main] Joining the web server main thread 2021-03-29 23:55:36,991 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_file_snapshot"( "trigger_id" VARCHAR NOT NULL, "router_id" VARCHAR NOT NULL, "relative_dir" VARCHAR NOT NULL, "file_name" VARCHAR NOT NULL, "channel_id" VARCHAR DEFAULT ('filesync') NOT NULL, "reload_channel_id" VARCHAR DEFAULT ('filesync_reload') NOT NULL, "last_event_type" VARCHAR NOT NULL, "crc32_checksum" INTEGER, "file_size" INTEGER, "file_modified_time" INTEGER, "last_update_time" TIMESTAMP NOT NULL, "last_update_by" VARCHAR, "create_time" TIMESTAMP NOT NULL, PRIMARY KEY ("trigger_id", "router_id", "relative_dir", "file_name") ) 2021-03-29 23:55:37,001 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE INDEX "sym_idx_f_snpsht_chid" ON "sym_file_snapshot" ("reload_channel_id") 2021-03-29 23:55:37,012 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_file_trigger"( "trigger_id" VARCHAR NOT NULL PRIMARY KEY , "channel_id" VARCHAR DEFAULT ('filesync') NOT NULL, "reload_channel_id" VARCHAR DEFAULT ('filesync_reload') NOT NULL, "base_dir" VARCHAR NOT NULL, "recurse" INTEGER DEFAULT (1) NOT NULL, "includes_files" VARCHAR, "excludes_files" VARCHAR, "sync_on_create" INTEGER DEFAULT (1) NOT NULL, "sync_on_modified" INTEGER DEFAULT (1) NOT NULL, "sync_on_delete" INTEGER DEFAULT (1) NOT NULL, "sync_on_ctl_file" INTEGER DEFAULT (0) NOT NULL, "delete_after_sync" INTEGER DEFAULT (0) NOT NULL, "before_copy_script" VARCHAR, "after_copy_script" VARCHAR, "create_time" TIMESTAMP NOT NULL, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP NOT NULL, "description" VARCHAR ) 2021-03-29 23:55:37,023 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_file_trigger_router"( "trigger_id" VARCHAR NOT NULL, "router_id" VARCHAR NOT NULL, "enabled" INTEGER DEFAULT (1) NOT NULL, "initial_load_enabled" INTEGER DEFAULT (1) NOT NULL, "target_base_dir" VARCHAR, "conflict_strategy" VARCHAR DEFAULT ('source_wins') NOT NULL, "create_time" TIMESTAMP NOT NULL, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP NOT NULL, "description" VARCHAR, PRIMARY KEY ("trigger_id", "router_id"), FOREIGN KEY ("trigger_id") REFERENCES "sym_file_trigger" ("trigger_id"), FOREIGN KEY ("router_id") REFERENCES "sym_router" ("router_id") ) 2021-03-29 23:55:37,035 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_grouplet"( "grouplet_id" VARCHAR NOT NULL PRIMARY KEY , "grouplet_link_policy" VARCHAR DEFAULT ('I') NOT NULL, "description" VARCHAR, "create_time" TIMESTAMP NOT NULL, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP NOT NULL ) 2021-03-29 23:55:37,045 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_grouplet_link"( "grouplet_id" VARCHAR NOT NULL, "external_id" VARCHAR NOT NULL, "create_time" TIMESTAMP NOT NULL, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP NOT NULL, PRIMARY KEY ("grouplet_id", "external_id"), FOREIGN KEY ("grouplet_id") REFERENCES "sym_grouplet" ("grouplet_id") ) 2021-03-29 23:55:37,057 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_incoming_batch"( "batch_id" INTEGER NOT NULL, "node_id" VARCHAR NOT NULL, "channel_id" VARCHAR, "status" VARCHAR, "error_flag" INTEGER DEFAULT (0), "sql_state" VARCHAR, "sql_code" INTEGER DEFAULT (0) NOT NULL, "sql_message" VARCHAR, "last_update_hostname" VARCHAR, "last_update_time" TIMESTAMP, "create_time" TIMESTAMP, "summary" VARCHAR, "ignore_count" INTEGER DEFAULT (0) NOT NULL, "byte_count" INTEGER DEFAULT (0) NOT NULL, "load_flag" INTEGER DEFAULT (0), "extract_count" INTEGER DEFAULT (0) NOT NULL, "sent_count" INTEGER DEFAULT (0) NOT NULL, "load_count" INTEGER DEFAULT (0) NOT NULL, "reload_row_count" INTEGER DEFAULT (0) NOT NULL, "other_row_count" INTEGER DEFAULT (0) NOT NULL, "data_row_count" INTEGER DEFAULT (0) NOT NULL, "extract_row_count" INTEGER DEFAULT (0) NOT NULL, "load_row_count" INTEGER DEFAULT (0) NOT NULL, "data_insert_row_count" INTEGER DEFAULT (0) NOT NULL, "data_update_row_count" INTEGER DEFAULT (0) NOT NULL, "data_delete_row_count" INTEGER DEFAULT (0) NOT NULL, "extract_insert_row_count" INTEGER DEFAULT (0) NOT NULL, "extract_update_row_count" INTEGER DEFAULT (0) NOT NULL, "extract_delete_row_count" INTEGER DEFAULT (0) NOT NULL, "load_insert_row_count" INTEGER DEFAULT (0) NOT NULL, "load_update_row_count" INTEGER DEFAULT (0) NOT NULL, "load_delete_row_count" INTEGER DEFAULT (0) NOT NULL, "network_millis" INTEGER DEFAULT (0) NOT NULL, "filter_millis" INTEGER DEFAULT (0) NOT NULL, "load_millis" INTEGER DEFAULT (0) NOT NULL, "router_millis" INTEGER DEFAULT (0) NOT NULL, "extract_millis" INTEGER DEFAULT (0) NOT NULL, "transform_extract_millis" INTEGER DEFAULT (0) NOT NULL, "transform_load_millis" INTEGER DEFAULT (0) NOT NULL, "load_id" INTEGER, "common_flag" INTEGER DEFAULT (0), "fallback_insert_count" INTEGER DEFAULT (0) NOT NULL, "fallback_update_count" INTEGER DEFAULT (0) NOT NULL, "ignore_row_count" INTEGER DEFAULT (0) NOT NULL, "missing_delete_count" INTEGER DEFAULT (0) NOT NULL, "skip_count" INTEGER DEFAULT (0) NOT NULL, "failed_row_number" INTEGER DEFAULT (0) NOT NULL, "failed_line_number" INTEGER DEFAULT (0) NOT NULL, "failed_data_id" INTEGER DEFAULT (0) NOT NULL, PRIMARY KEY ("batch_id", "node_id") ) 2021-03-29 23:55:37,069 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE INDEX "sym_idx_ib_time_status" ON "sym_incoming_batch" ("create_time", "status") 2021-03-29 23:55:37,079 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE INDEX "sym_idx_ib_in_error" ON "sym_incoming_batch" ("error_flag") 2021-03-29 23:55:37,090 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_incoming_error"( "batch_id" INTEGER NOT NULL, "node_id" VARCHAR NOT NULL, "failed_row_number" INTEGER NOT NULL, "failed_line_number" INTEGER DEFAULT (0) NOT NULL, "target_catalog_name" VARCHAR, "target_schema_name" VARCHAR, "target_table_name" VARCHAR NOT NULL, "event_type" VARCHAR NOT NULL, "binary_encoding" VARCHAR DEFAULT ('HEX') NOT NULL, "column_names" VARCHAR NOT NULL, "pk_column_names" VARCHAR NOT NULL, "row_data" VARCHAR, "old_data" VARCHAR, "cur_data" VARCHAR, "resolve_data" VARCHAR, "resolve_ignore" INTEGER DEFAULT (0), "conflict_id" VARCHAR, "create_time" TIMESTAMP, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP NOT NULL, PRIMARY KEY ("batch_id", "node_id", "failed_row_number") ) 2021-03-29 23:55:37,101 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_job"( "job_name" VARCHAR NOT NULL PRIMARY KEY , "job_type" VARCHAR NOT NULL, "requires_registration" INTEGER DEFAULT (1) NOT NULL, "job_expression" VARCHAR, "description" VARCHAR, "default_schedule" VARCHAR, "default_auto_start" INTEGER DEFAULT (1) NOT NULL, "node_group_id" VARCHAR NOT NULL, "create_by" VARCHAR, "create_time" TIMESTAMP, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP ) 2021-03-29 23:55:37,113 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_load_filter"( "load_filter_id" VARCHAR NOT NULL PRIMARY KEY , "load_filter_type" VARCHAR NOT NULL, "source_node_group_id" VARCHAR NOT NULL, "target_node_group_id" VARCHAR NOT NULL, "target_catalog_name" VARCHAR, "target_schema_name" VARCHAR, "target_table_name" VARCHAR, "filter_on_update" INTEGER DEFAULT (1) NOT NULL, "filter_on_insert" INTEGER DEFAULT (1) NOT NULL, "filter_on_delete" INTEGER DEFAULT (1) NOT NULL, "before_write_script" VARCHAR, "after_write_script" VARCHAR, "batch_complete_script" VARCHAR, "batch_commit_script" VARCHAR, "batch_rollback_script" VARCHAR, "handle_error_script" VARCHAR, "create_time" TIMESTAMP NOT NULL, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP NOT NULL, "load_filter_order" INTEGER DEFAULT (1) NOT NULL, "fail_on_error" INTEGER DEFAULT (0) NOT NULL ) 2021-03-29 23:55:37,124 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_lock"( "lock_action" VARCHAR NOT NULL PRIMARY KEY , "lock_type" VARCHAR NOT NULL, "locking_server_id" VARCHAR, "lock_time" TIMESTAMP, "shared_count" INTEGER DEFAULT (0) NOT NULL, "shared_enable" INTEGER DEFAULT (0) NOT NULL, "last_lock_time" TIMESTAMP, "last_locking_server_id" VARCHAR ) 2021-03-29 23:55:37,134 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_node"( "node_id" VARCHAR NOT NULL PRIMARY KEY , "node_group_id" VARCHAR NOT NULL, "external_id" VARCHAR NOT NULL, "sync_enabled" INTEGER DEFAULT (0), "sync_url" VARCHAR, "schema_version" VARCHAR, "symmetric_version" VARCHAR, "config_version" VARCHAR, "database_type" VARCHAR, "database_version" VARCHAR, "database_name" VARCHAR, "batch_to_send_count" INTEGER DEFAULT (0), "batch_in_error_count" INTEGER DEFAULT (0), "created_at_node_id" VARCHAR, "deployment_type" VARCHAR, "deployment_sub_type" VARCHAR ) 2021-03-29 23:55:37,145 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_node_communication"( "node_id" VARCHAR NOT NULL, "queue" VARCHAR DEFAULT ('default') NOT NULL, "communication_type" VARCHAR NOT NULL, "lock_time" TIMESTAMP, "locking_server_id" VARCHAR, "last_lock_time" TIMESTAMP, "last_lock_millis" INTEGER DEFAULT (0), "success_count" INTEGER DEFAULT (0), "fail_count" INTEGER DEFAULT (0), "skip_count" INTEGER DEFAULT (0), "total_success_count" INTEGER DEFAULT (0), "total_fail_count" INTEGER DEFAULT (0), "total_success_millis" INTEGER DEFAULT (0), "total_fail_millis" INTEGER DEFAULT (0), "batch_to_send_count" INTEGER DEFAULT (0), "node_priority" INTEGER DEFAULT (0), PRIMARY KEY ("node_id", "queue", "communication_type") ) 2021-03-29 23:55:37,156 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_node_channel_ctl"( "node_id" VARCHAR NOT NULL, "channel_id" VARCHAR NOT NULL, "suspend_enabled" INTEGER DEFAULT (0), "ignore_enabled" INTEGER DEFAULT (0), "last_extract_time" TIMESTAMP, PRIMARY KEY ("node_id", "channel_id") ) 2021-03-29 23:55:37,167 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_node_group"( "node_group_id" VARCHAR NOT NULL PRIMARY KEY , "description" VARCHAR, "create_time" TIMESTAMP, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP ) 2021-03-29 23:55:37,177 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_node_group_channel_wnd"( "node_group_id" VARCHAR NOT NULL, "channel_id" VARCHAR NOT NULL, "start_time" TIMESTAMP NOT NULL, "end_time" TIMESTAMP NOT NULL, "enabled" INTEGER DEFAULT (0) NOT NULL, PRIMARY KEY ("node_group_id", "channel_id", "start_time", "end_time") ) 2021-03-29 23:55:37,187 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_node_group_link"( "source_node_group_id" VARCHAR NOT NULL, "target_node_group_id" VARCHAR NOT NULL, "data_event_action" VARCHAR DEFAULT ('W') NOT NULL, "sync_config_enabled" INTEGER DEFAULT (1) NOT NULL, "is_reversible" INTEGER DEFAULT (0) NOT NULL, "create_time" TIMESTAMP, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP, PRIMARY KEY ("source_node_group_id", "target_node_group_id"), FOREIGN KEY ("source_node_group_id") REFERENCES "sym_node_group" ("node_group_id"), FOREIGN KEY ("target_node_group_id") REFERENCES "sym_node_group" ("node_group_id") ) 2021-03-29 23:55:37,197 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_node_host"( "node_id" VARCHAR NOT NULL, "host_name" VARCHAR NOT NULL, "instance_id" VARCHAR, "ip_address" VARCHAR, "os_user" VARCHAR, "os_name" VARCHAR, "os_arch" VARCHAR, "os_version" VARCHAR, "available_processors" INTEGER DEFAULT (0), "free_memory_bytes" INTEGER DEFAULT (0), "total_memory_bytes" INTEGER DEFAULT (0), "max_memory_bytes" INTEGER DEFAULT (0), "java_version" VARCHAR, "java_vendor" VARCHAR, "jdbc_version" VARCHAR, "symmetric_version" VARCHAR, "timezone_offset" VARCHAR, "heartbeat_time" TIMESTAMP, "last_restart_time" TIMESTAMP NOT NULL, "create_time" TIMESTAMP NOT NULL, PRIMARY KEY ("node_id", "host_name") ) 2021-03-29 23:55:37,208 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_node_host_channel_stats"( "node_id" VARCHAR NOT NULL, "host_name" VARCHAR NOT NULL, "channel_id" VARCHAR NOT NULL, "start_time" TIMESTAMP NOT NULL, "end_time" TIMESTAMP NOT NULL, "data_routed" INTEGER DEFAULT (0), "data_unrouted" INTEGER DEFAULT (0), "data_event_inserted" INTEGER DEFAULT (0), "data_extracted" INTEGER DEFAULT (0), "data_bytes_extracted" INTEGER DEFAULT (0), "data_extracted_errors" INTEGER DEFAULT (0), "data_bytes_sent" INTEGER DEFAULT (0), "data_sent" INTEGER DEFAULT (0), "data_sent_errors" INTEGER DEFAULT (0), "data_loaded" INTEGER DEFAULT (0), "data_bytes_loaded" INTEGER DEFAULT (0), "data_loaded_errors" INTEGER DEFAULT (0), "data_loaded_outgoing" INTEGER DEFAULT (0), "data_bytes_loaded_outgoing" INTEGER DEFAULT (0), "data_loaded_outgoing_errors" INTEGER DEFAULT (0), PRIMARY KEY ("node_id", "host_name", "channel_id", "start_time", "end_time") ) 2021-03-29 23:55:37,219 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE INDEX "sym_idx_nd_hst_chnl_sts" ON "sym_node_host_channel_stats" ("node_id", "start_time", "end_time") 2021-03-29 23:55:37,229 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_node_host_job_stats"( "node_id" VARCHAR NOT NULL, "host_name" VARCHAR NOT NULL, "job_name" VARCHAR NOT NULL, "start_time" TIMESTAMP NOT NULL, "end_time" TIMESTAMP NOT NULL, "processed_count" INTEGER DEFAULT (0), "target_node_id" VARCHAR, "target_node_count" INTEGER DEFAULT (0), PRIMARY KEY ("node_id", "host_name", "job_name", "start_time", "end_time") ) 2021-03-29 23:55:37,239 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE INDEX "sym_idx_nd_hst_job" ON "sym_node_host_job_stats" ("node_id", "start_time", "end_time") 2021-03-29 23:55:37,250 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_node_host_stats"( "node_id" VARCHAR NOT NULL, "host_name" VARCHAR NOT NULL, "start_time" TIMESTAMP NOT NULL, "end_time" TIMESTAMP NOT NULL, "restarted" INTEGER DEFAULT (0) NOT NULL, "nodes_pulled" INTEGER DEFAULT (0), "total_nodes_pull_time" INTEGER DEFAULT (0), "nodes_pushed" INTEGER DEFAULT (0), "total_nodes_push_time" INTEGER DEFAULT (0), "nodes_rejected" INTEGER DEFAULT (0), "nodes_registered" INTEGER DEFAULT (0), "nodes_loaded" INTEGER DEFAULT (0), "nodes_disabled" INTEGER DEFAULT (0), "purged_data_rows" INTEGER DEFAULT (0), "purged_data_event_rows" INTEGER DEFAULT (0), "purged_batch_outgoing_rows" INTEGER DEFAULT (0), "purged_batch_incoming_rows" INTEGER DEFAULT (0), "triggers_created_count" INTEGER, "triggers_rebuilt_count" INTEGER, "triggers_removed_count" INTEGER, PRIMARY KEY ("node_id", "host_name", "start_time", "end_time") ) 2021-03-29 23:55:37,260 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE INDEX "sym_idx_nd_hst_sts" ON "sym_node_host_stats" ("node_id", "start_time", "end_time") 2021-03-29 23:55:37,270 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_node_identity"( "node_id" VARCHAR NOT NULL PRIMARY KEY , FOREIGN KEY ("node_id") REFERENCES "sym_node" ("node_id") ) 2021-03-29 23:55:37,281 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_node_security"( "node_id" VARCHAR NOT NULL PRIMARY KEY , "node_password" VARCHAR NOT NULL, "registration_enabled" INTEGER DEFAULT (0), "registration_time" TIMESTAMP, "initial_load_enabled" INTEGER DEFAULT (0), "initial_load_time" TIMESTAMP, "initial_load_end_time" TIMESTAMP, "initial_load_id" INTEGER, "initial_load_create_by" VARCHAR, "rev_initial_load_enabled" INTEGER DEFAULT (0), "rev_initial_load_time" TIMESTAMP, "rev_initial_load_id" INTEGER, "rev_initial_load_create_by" VARCHAR, "failed_logins" INTEGER DEFAULT (0), "created_at_node_id" VARCHAR, FOREIGN KEY ("node_id") REFERENCES "sym_node" ("node_id") ) 2021-03-29 23:55:37,292 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_monitor"( "monitor_id" VARCHAR NOT NULL PRIMARY KEY , "node_group_id" VARCHAR DEFAULT ('ALL') NOT NULL, "external_id" VARCHAR DEFAULT ('ALL') NOT NULL, "type" VARCHAR NOT NULL, "expression" VARCHAR, "threshold" INTEGER DEFAULT (0) NOT NULL, "run_period" INTEGER DEFAULT (0) NOT NULL, "run_count" INTEGER DEFAULT (0) NOT NULL, "severity_level" INTEGER DEFAULT (0) NOT NULL, "enabled" INTEGER DEFAULT (0) NOT NULL, "create_time" TIMESTAMP, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP ) 2021-03-29 23:55:37,302 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_monitor_event"( "monitor_id" VARCHAR NOT NULL, "node_id" VARCHAR NOT NULL, "event_time" TIMESTAMP NOT NULL, "host_name" VARCHAR, "type" VARCHAR NOT NULL, "threshold" INTEGER DEFAULT (0) NOT NULL, "event_value" INTEGER DEFAULT (0) NOT NULL, "event_count" INTEGER DEFAULT (0) NOT NULL, "severity_level" INTEGER DEFAULT (0) NOT NULL, "is_resolved" INTEGER DEFAULT (0) NOT NULL, "is_notified" INTEGER DEFAULT (0) NOT NULL, "details" VARCHAR, "last_update_time" TIMESTAMP, PRIMARY KEY ("monitor_id", "node_id", "event_time") ) 2021-03-29 23:55:37,312 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_notification"( "notification_id" VARCHAR NOT NULL PRIMARY KEY , "node_group_id" VARCHAR DEFAULT ('ALL') NOT NULL, "external_id" VARCHAR DEFAULT ('ALL') NOT NULL, "severity_level" INTEGER DEFAULT (0) NOT NULL, "type" VARCHAR NOT NULL, "expression" VARCHAR, "enabled" INTEGER DEFAULT (0) NOT NULL, "create_time" TIMESTAMP, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP ) 2021-03-29 23:55:37,324 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_outgoing_batch"( "batch_id" INTEGER NOT NULL, "node_id" VARCHAR NOT NULL, "channel_id" VARCHAR, "status" VARCHAR, "error_flag" INTEGER DEFAULT (0), "sql_state" VARCHAR, "sql_code" INTEGER DEFAULT (0) NOT NULL, "sql_message" VARCHAR, "last_update_hostname" VARCHAR, "last_update_time" TIMESTAMP, "create_time" TIMESTAMP, "summary" VARCHAR, "ignore_count" INTEGER DEFAULT (0) NOT NULL, "byte_count" INTEGER DEFAULT (0) NOT NULL, "load_flag" INTEGER DEFAULT (0), "extract_count" INTEGER DEFAULT (0) NOT NULL, "sent_count" INTEGER DEFAULT (0) NOT NULL, "load_count" INTEGER DEFAULT (0) NOT NULL, "reload_row_count" INTEGER DEFAULT (0) NOT NULL, "other_row_count" INTEGER DEFAULT (0) NOT NULL, "data_row_count" INTEGER DEFAULT (0) NOT NULL, "extract_row_count" INTEGER DEFAULT (0) NOT NULL, "load_row_count" INTEGER DEFAULT (0) NOT NULL, "data_insert_row_count" INTEGER DEFAULT (0) NOT NULL, "data_update_row_count" INTEGER DEFAULT (0) NOT NULL, "data_delete_row_count" INTEGER DEFAULT (0) NOT NULL, "extract_insert_row_count" INTEGER DEFAULT (0) NOT NULL, "extract_update_row_count" INTEGER DEFAULT (0) NOT NULL, "extract_delete_row_count" INTEGER DEFAULT (0) NOT NULL, "load_insert_row_count" INTEGER DEFAULT (0) NOT NULL, "load_update_row_count" INTEGER DEFAULT (0) NOT NULL, "load_delete_row_count" INTEGER DEFAULT (0) NOT NULL, "network_millis" INTEGER DEFAULT (0) NOT NULL, "filter_millis" INTEGER DEFAULT (0) NOT NULL, "load_millis" INTEGER DEFAULT (0) NOT NULL, "router_millis" INTEGER DEFAULT (0) NOT NULL, "extract_millis" INTEGER DEFAULT (0) NOT NULL, "transform_extract_millis" INTEGER DEFAULT (0) NOT NULL, "transform_load_millis" INTEGER DEFAULT (0) NOT NULL, "load_id" INTEGER, "common_flag" INTEGER DEFAULT (0), "fallback_insert_count" INTEGER DEFAULT (0) NOT NULL, "fallback_update_count" INTEGER DEFAULT (0) NOT NULL, "ignore_row_count" INTEGER DEFAULT (0) NOT NULL, "missing_delete_count" INTEGER DEFAULT (0) NOT NULL, "skip_count" INTEGER DEFAULT (0) NOT NULL, "total_extract_millis" INTEGER DEFAULT (0) NOT NULL, "total_load_millis" INTEGER DEFAULT (0) NOT NULL, "extract_job_flag" INTEGER DEFAULT (0), "extract_start_time" TIMESTAMP, "transfer_start_time" TIMESTAMP, "load_start_time" TIMESTAMP, "failed_data_id" INTEGER DEFAULT (0) NOT NULL, "failed_line_number" INTEGER DEFAULT (0) NOT NULL, "create_by" VARCHAR, PRIMARY KEY ("batch_id", "node_id") ) 2021-03-29 23:55:37,336 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE INDEX "sym_idx_ob_node_status" ON "sym_outgoing_batch" ("node_id", "status") 2021-03-29 23:55:37,348 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE INDEX "sym_idx_ob_status" ON "sym_outgoing_batch" ("status") 2021-03-29 23:55:37,357 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE INDEX "sym_idx_ob_in_error" ON "sym_outgoing_batch" ("error_flag") 2021-03-29 23:55:37,367 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_parameter"( "external_id" VARCHAR NOT NULL, "node_group_id" VARCHAR NOT NULL, "param_key" VARCHAR NOT NULL, "param_value" VARCHAR, "create_time" TIMESTAMP, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP, PRIMARY KEY ("external_id", "node_group_id", "param_key") ) 2021-03-29 23:55:37,377 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_registration_redirect"( "registrant_external_id" VARCHAR NOT NULL PRIMARY KEY , "registration_node_id" VARCHAR NOT NULL ) 2021-03-29 23:55:37,387 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_registration_request"( "node_group_id" VARCHAR NOT NULL, "external_id" VARCHAR NOT NULL, "status" VARCHAR NOT NULL, "host_name" VARCHAR NOT NULL, "ip_address" VARCHAR NOT NULL, "attempt_count" INTEGER DEFAULT (0), "registered_node_id" VARCHAR, "error_message" VARCHAR, "create_time" TIMESTAMP NOT NULL, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP NOT NULL, PRIMARY KEY ("node_group_id", "external_id", "create_time") ) 2021-03-29 23:55:37,398 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE INDEX "sym_idx_reg_req_1" ON "sym_registration_request" ("node_group_id", "external_id", "status", "host_name", "ip_address") 2021-03-29 23:55:37,409 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE INDEX "sym_idx_reg_req_2" ON "sym_registration_request" ("status") 2021-03-29 23:55:37,420 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_router"( "router_id" VARCHAR NOT NULL PRIMARY KEY , "target_catalog_name" VARCHAR, "target_schema_name" VARCHAR, "target_table_name" VARCHAR, "source_node_group_id" VARCHAR NOT NULL, "target_node_group_id" VARCHAR NOT NULL, "router_type" VARCHAR DEFAULT ('default') NOT NULL, "router_expression" VARCHAR, "sync_on_update" INTEGER DEFAULT (1) NOT NULL, "sync_on_insert" INTEGER DEFAULT (1) NOT NULL, "sync_on_delete" INTEGER DEFAULT (1) NOT NULL, "use_source_catalog_schema" INTEGER DEFAULT (1) NOT NULL, "create_time" TIMESTAMP NOT NULL, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP NOT NULL, "description" VARCHAR, FOREIGN KEY ("source_node_group_id", "target_node_group_id") REFERENCES "sym_node_group_link" ("source_node_group_id", "target_node_group_id") ) 2021-03-29 23:55:37,431 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_sequence"( "sequence_name" VARCHAR NOT NULL PRIMARY KEY , "current_value" INTEGER DEFAULT (0) NOT NULL, "increment_by" INTEGER DEFAULT (1) NOT NULL, "min_value" INTEGER DEFAULT (1) NOT NULL, "max_value" INTEGER DEFAULT (9999999999) NOT NULL, "cycle_flag" INTEGER DEFAULT (0), "cache_size" INTEGER DEFAULT (0) NOT NULL, "create_time" TIMESTAMP, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP NOT NULL ) 2021-03-29 23:55:37,443 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_table_reload_request"( "target_node_id" VARCHAR NOT NULL, "source_node_id" VARCHAR NOT NULL, "trigger_id" VARCHAR NOT NULL, "router_id" VARCHAR NOT NULL, "create_time" TIMESTAMP NOT NULL, "create_table" INTEGER DEFAULT (0) NOT NULL, "delete_first" INTEGER DEFAULT (0) NOT NULL, "reload_select" VARCHAR, "before_custom_sql" VARCHAR, "reload_time" TIMESTAMP, "load_id" INTEGER, "processed" INTEGER DEFAULT (0) NOT NULL, "channel_id" VARCHAR, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP NOT NULL, PRIMARY KEY ("target_node_id", "source_node_id", "trigger_id", "router_id", "create_time") ) 2021-03-29 23:55:37,454 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_table_reload_status"( "load_id" INTEGER NOT NULL, "source_node_id" VARCHAR NOT NULL, "target_node_id" VARCHAR NOT NULL, "start_time" TIMESTAMP, "end_time" TIMESTAMP, "completed" INTEGER DEFAULT (0) NOT NULL, "cancelled" INTEGER DEFAULT (0) NOT NULL, "full_load" INTEGER DEFAULT (0) NOT NULL, "start_data_batch_id" INTEGER, "end_data_batch_id" INTEGER, "setup_batch_count" INTEGER DEFAULT (0) NOT NULL, "data_batch_count" INTEGER DEFAULT (0) NOT NULL, "finalize_batch_count" INTEGER DEFAULT (0) NOT NULL, "setup_batch_loaded" INTEGER DEFAULT (0) NOT NULL, "data_batch_loaded" INTEGER DEFAULT (0) NOT NULL, "finalize_batch_loaded" INTEGER DEFAULT (0) NOT NULL, "table_count" INTEGER DEFAULT (0) NOT NULL, "rows_loaded" INTEGER DEFAULT (0) NOT NULL, "rows_count" INTEGER DEFAULT (0) NOT NULL, "error_flag" INTEGER DEFAULT (0) NOT NULL, "sql_state" VARCHAR, "sql_code" INTEGER DEFAULT (0) NOT NULL, "sql_message" VARCHAR, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP NOT NULL, PRIMARY KEY ("load_id", "source_node_id") ) 2021-03-29 23:55:37,465 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_transform_table"( "transform_id" VARCHAR NOT NULL, "source_node_group_id" VARCHAR NOT NULL, "target_node_group_id" VARCHAR NOT NULL, "transform_point" VARCHAR NOT NULL, "source_catalog_name" VARCHAR, "source_schema_name" VARCHAR, "source_table_name" VARCHAR NOT NULL, "target_catalog_name" VARCHAR, "target_schema_name" VARCHAR, "target_table_name" VARCHAR, "update_first" INTEGER DEFAULT (0), "update_action" VARCHAR DEFAULT ('UPDATE_COL') NOT NULL, "delete_action" VARCHAR NOT NULL, "transform_order" INTEGER DEFAULT (1) NOT NULL, "column_policy" VARCHAR DEFAULT ('SPECIFIED') NOT NULL, "create_time" TIMESTAMP, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP, "description" VARCHAR, PRIMARY KEY ("transform_id", "source_node_group_id", "target_node_group_id"), FOREIGN KEY ("source_node_group_id", "target_node_group_id") REFERENCES "sym_node_group_link" ("source_node_group_id", "target_node_group_id") ) 2021-03-29 23:55:37,475 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_transform_column"( "transform_id" VARCHAR NOT NULL, "include_on" VARCHAR DEFAULT ('*') NOT NULL, "target_column_name" VARCHAR NOT NULL, "source_column_name" VARCHAR, "pk" INTEGER DEFAULT (0), "transform_type" VARCHAR DEFAULT ('copy'), "transform_expression" VARCHAR, "transform_order" INTEGER DEFAULT (1) NOT NULL, "create_time" TIMESTAMP, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP, "description" VARCHAR, PRIMARY KEY ("transform_id", "include_on", "target_column_name") ) 2021-03-29 23:55:37,488 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_trigger"( "trigger_id" VARCHAR NOT NULL PRIMARY KEY , "source_catalog_name" VARCHAR, "source_schema_name" VARCHAR, "source_table_name" VARCHAR NOT NULL, "channel_id" VARCHAR NOT NULL, "reload_channel_id" VARCHAR DEFAULT ('reload') NOT NULL, "sync_on_update" INTEGER DEFAULT (1) NOT NULL, "sync_on_insert" INTEGER DEFAULT (1) NOT NULL, "sync_on_delete" INTEGER DEFAULT (1) NOT NULL, "sync_on_incoming_batch" INTEGER DEFAULT (0) NOT NULL, "name_for_update_trigger" VARCHAR, "name_for_insert_trigger" VARCHAR, "name_for_delete_trigger" VARCHAR, "sync_on_update_condition" VARCHAR, "sync_on_insert_condition" VARCHAR, "sync_on_delete_condition" VARCHAR, "custom_before_update_text" VARCHAR, "custom_before_insert_text" VARCHAR, "custom_before_delete_text" VARCHAR, "custom_on_update_text" VARCHAR, "custom_on_insert_text" VARCHAR, "custom_on_delete_text" VARCHAR, "external_select" VARCHAR, "tx_id_expression" VARCHAR, "channel_expression" VARCHAR, "excluded_column_names" VARCHAR, "included_column_names" VARCHAR, "sync_key_names" VARCHAR, "use_stream_lobs" INTEGER DEFAULT (0) NOT NULL, "use_capture_lobs" INTEGER DEFAULT (0) NOT NULL, "use_capture_old_data" INTEGER DEFAULT (1) NOT NULL, "use_handle_key_updates" INTEGER DEFAULT (1) NOT NULL, "stream_row" INTEGER DEFAULT (0) NOT NULL, "create_time" TIMESTAMP NOT NULL, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP NOT NULL, "description" VARCHAR, FOREIGN KEY ("channel_id") REFERENCES "sym_channel" ("channel_id"), FOREIGN KEY ("reload_channel_id") REFERENCES "sym_channel" ("channel_id") ) 2021-03-29 23:55:37,499 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_trigger_hist"( "trigger_hist_id" INTEGER NOT NULL PRIMARY KEY , "trigger_id" VARCHAR NOT NULL, "source_table_name" VARCHAR NOT NULL, "source_catalog_name" VARCHAR, "source_schema_name" VARCHAR, "name_for_update_trigger" VARCHAR, "name_for_insert_trigger" VARCHAR, "name_for_delete_trigger" VARCHAR, "table_hash" INTEGER DEFAULT (0) NOT NULL, "trigger_row_hash" INTEGER DEFAULT (0) NOT NULL, "trigger_template_hash" INTEGER DEFAULT (0) NOT NULL, "column_names" VARCHAR NOT NULL, "pk_column_names" VARCHAR NOT NULL, "last_trigger_build_reason" VARCHAR NOT NULL, "error_message" VARCHAR, "create_time" TIMESTAMP NOT NULL, "inactive_time" TIMESTAMP ) 2021-03-29 23:55:37,509 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE INDEX "sym_idx_trigg_hist_1" ON "sym_trigger_hist" ("trigger_id", "inactive_time") 2021-03-29 23:55:37,520 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_trigger_router"( "trigger_id" VARCHAR NOT NULL, "router_id" VARCHAR NOT NULL, "enabled" INTEGER DEFAULT (1) NOT NULL, "initial_load_order" INTEGER DEFAULT (1) NOT NULL, "initial_load_select" VARCHAR, "initial_load_delete_stmt" VARCHAR, "ping_back_enabled" INTEGER DEFAULT (0) NOT NULL, "create_time" TIMESTAMP NOT NULL, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP NOT NULL, "description" VARCHAR, PRIMARY KEY ("trigger_id", "router_id"), FOREIGN KEY ("trigger_id") REFERENCES "sym_trigger" ("trigger_id"), FOREIGN KEY ("router_id") REFERENCES "sym_router" ("router_id") ) 2021-03-29 23:55:37,530 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] DDL applied: CREATE TABLE "sym_trigger_router_grouplet"( "grouplet_id" VARCHAR NOT NULL, "trigger_id" VARCHAR NOT NULL, "router_id" VARCHAR NOT NULL, "applies_when" VARCHAR NOT NULL, "create_time" TIMESTAMP NOT NULL, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP NOT NULL, PRIMARY KEY ("grouplet_id", "trigger_id", "router_id", "applies_when"), FOREIGN KEY ("grouplet_id") REFERENCES "sym_grouplet" ("grouplet_id"), FOREIGN KEY ("trigger_id", "router_id") REFERENCES "sym_trigger_router" ("trigger_id", "router_id") ) 2021-03-29 23:55:37,533 INFO [node-002] [ClusterService] [symmetric-engine-startup-3] This node picked a server id of LAPTOP-UQHGHI89 2021-03-29 23:55:37,534 INFO [node-002] [TriggerRouterService] [symmetric-engine-startup-3] Synchronizing triggers 2021-03-29 23:55:37,544 INFO [node-002] [TriggerRouterService] [symmetric-engine-startup-3] Done synchronizing triggers 2021-03-29 23:55:37,545 INFO [node-002] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-3] Done with auto update of SymmetricDS tables 2021-03-29 23:55:37,546 INFO [node-002] [ConfigurationService] [symmetric-engine-startup-3] Auto-configuring config channel 2021-03-29 23:55:37,558 INFO [node-002] [ConfigurationService] [symmetric-engine-startup-3] Auto-configuring reload channel 2021-03-29 23:55:37,568 INFO [node-002] [ConfigurationService] [symmetric-engine-startup-3] Auto-configuring monitor channel 2021-03-29 23:55:37,578 INFO [node-002] [ConfigurationService] [symmetric-engine-startup-3] Auto-configuring heartbeat channel 2021-03-29 23:55:37,590 INFO [node-002] [ConfigurationService] [symmetric-engine-startup-3] Auto-configuring default channel 2021-03-29 23:55:37,600 INFO [node-002] [ConfigurationService] [symmetric-engine-startup-3] Auto-configuring dynamic channel 2021-03-29 23:55:37,674 INFO [node-002] [ExtensionService] [symmetric-engine-startup-3] Found 0 extension points from the database that will be registered 2021-03-29 23:55:37,676 INFO [node-002] [ClientExtensionService] [symmetric-engine-startup-3] Found 8 extension points from spring that will be registered 2021-03-29 23:55:37,678 INFO [node-002] [AbstractSymmetricEngine] [symmetric-engine-startup-3] Done initializing SymmetricDS database 2021-03-29 23:55:37,726 INFO [node-002] [AbstractSymmetricEngine] [symmetric-engine-startup-3] SymmetricDS database version : null 2021-03-29 23:55:37,726 INFO [node-002] [AbstractSymmetricEngine] [symmetric-engine-startup-3] SymmetricDS software version : 3.12.7 2021-03-29 23:55:37,735 INFO [node-002] [AbstractSymmetricEngine] [symmetric-engine-startup-3] Starting unregistered node [group=node, externalId=002] 2021-03-29 23:55:37,765 INFO [node-002] [RouterJob] [symmetric-engine-startup-3] Starting Routing on periodic schedule: every 5000ms with the first run at 2021-03-29T23:55:42.255+0100 2021-03-29 23:55:37,771 INFO [node-002] [PushJob] [symmetric-engine-startup-3] Starting Push on periodic schedule: every 10000ms with the first run at 2021-03-29T23:55:42.261+0100 2021-03-29 23:55:37,772 INFO [node-002] [PullJob] [symmetric-engine-startup-3] Starting Pull on periodic schedule: every 10000ms with the first run at 2021-03-29T23:55:42.262+0100 2021-03-29 23:55:37,774 INFO [node-002] [JobManager] [symmetric-engine-startup-3] Job Offline Push not configured for auto start 2021-03-29 23:55:37,774 INFO [node-002] [JobManager] [symmetric-engine-startup-3] Job Offline Pull not configured for auto start 2021-03-29 23:55:37,779 INFO [node-002] [OutgoingPurgeJob] [symmetric-engine-startup-3] Starting job 'Purge Outgoing' with cron expression: '0 0 */4 * * *' 2021-03-29 23:55:37,782 INFO [node-002] [IncomingPurgeJob] [symmetric-engine-startup-3] Starting job 'Purge Incoming' with cron expression: '0 0 */4 * * *' 2021-03-29 23:55:37,784 INFO [node-002] [StatisticFlushJob] [symmetric-engine-startup-3] Starting job 'Stat Flush' with cron expression: '0 0/5 * * * *' 2021-03-29 23:55:37,785 INFO [node-002] [SyncTriggersJob] [symmetric-engine-startup-3] Starting job 'SyncTriggers' with cron expression: '0 0 0 * * *' 2021-03-29 23:55:37,786 INFO [node-002] [HeartbeatJob] [symmetric-engine-startup-3] Starting Heartbeat on periodic schedule: every 900000ms with the first run at 2021-03-29T23:55:42.276+0100 2021-03-29 23:55:37,787 INFO [node-002] [WatchdogJob] [symmetric-engine-startup-3] Starting Watchdog on periodic schedule: every 3600000ms with the first run at 2021-03-29T23:55:42.277+0100 2021-03-29 23:55:37,819 INFO [node-002] [StageManagementJob] [symmetric-engine-startup-3] Starting job 'Stage Management' with cron expression: '0 0 * * * *' 2021-03-29 23:55:37,820 INFO [node-002] [JobManager] [symmetric-engine-startup-3] Job Refresh Cache not configured for auto start 2021-03-29 23:55:37,820 INFO [node-002] [JobManager] [symmetric-engine-startup-3] Job File Sync Tracker not configured for auto start 2021-03-29 23:55:37,821 INFO [node-002] [JobManager] [symmetric-engine-startup-3] Job File Sync Pull not configured for auto start 2021-03-29 23:55:37,822 INFO [node-002] [JobManager] [symmetric-engine-startup-3] Job File Sync Push not configured for auto start 2021-03-29 23:55:37,829 INFO [node-002] [InitialLoadExtractorJob] [symmetric-engine-startup-3] Starting Initial Load Extract on periodic schedule: every 10000ms with the first run at 2021-03-29T23:55:42.319+0100 2021-03-29 23:55:37,830 INFO [node-002] [MonitorJob] [symmetric-engine-startup-3] Starting Monitor on periodic schedule: every 60000ms with the first run at 2021-03-29T23:55:42.320+0100 2021-03-29 23:55:37,832 INFO [node-002] [JobManager] [symmetric-engine-startup-3] Job Report Status not configured for auto start 2021-03-29 23:55:37,833 INFO [node-002] [JobManager] [symmetric-engine-startup-3] Job Log Miner not configured for auto start 2021-03-29 23:55:37,834 INFO [node-002] [InitialLoadJob] [symmetric-engine-startup-3] Starting Initial Load Queue on periodic schedule: every 10000ms with the first run at 2021-03-29T23:55:42.324+0100 2021-03-29 23:55:37,839 INFO [node-002] [AbstractSymmetricEngine] [symmetric-engine-startup-3] SymmetricDS Node STARTED: nodeId=002 groupId=node type=server subType=null name=node-002 softwareVersion=3.12.7 databaseName=SQLite databaseVersion=3.32 driverName=SQLite JDBC driverVersion=3.32.3.2 uptime=0 sec. 2021-03-29 23:55:40,988 INFO [master-000] [JdbcDatabasePlatformFactory] [symmetric-engine-startup-1] Detected database 'MySQL', version '5', protocol 'mariadb' 2021-03-29 23:55:40,997 INFO [master-000] [JdbcDatabasePlatformFactory] [symmetric-engine-startup-1] The IDatabasePlatform being used is org.jumpmind.db.platform.mysql.MySqlDatabasePlatform 2021-03-29 23:55:40,997 INFO [node-001] [JdbcDatabasePlatformFactory] [symmetric-engine-startup-2] Detected database 'SQLite', version '3', protocol 'sqlite' 2021-03-29 23:55:40,998 INFO [node-001] [JdbcDatabasePlatformFactory] [symmetric-engine-startup-2] The IDatabasePlatform being used is org.jumpmind.db.platform.sqlite.SqliteDatabasePlatform 2021-03-29 23:55:41,011 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] The DbDialect being used is org.jumpmind.symmetric.db.sqlite.SqliteJdbcSymmetricDialect 2021-03-29 23:55:41,016 INFO [node-001] [StagingManager] [symmetric-engine-startup-2] The staging directory was initialized at the following location: C:\Users\matth\OneDrive - University of Sussex\University of Sussex\Final Year Project\symmetric-server-3.12.7-SQLiteTest\symmetric-server-3.12.7\tmp\node-001 2021-03-29 23:55:41,199 INFO [node-001] [ClientExtensionService] [symmetric-engine-startup-2] Found 8 extension points from spring that will be registered 2021-03-29 23:55:41,200 INFO [node-001] [AbstractSymmetricEngine] [symmetric-engine-startup-2] Initializing SymmetricDS database 2021-03-29 23:55:41,201 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] Checking if SymmetricDS tables need created or altered 2021-03-29 23:55:41,288 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] There are SymmetricDS tables that needed altered 2021-03-29 23:55:41,308 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_channel"( "channel_id" VARCHAR NOT NULL PRIMARY KEY , "processing_order" INTEGER DEFAULT (1) NOT NULL, "max_batch_size" INTEGER DEFAULT (1000) NOT NULL, "max_batch_to_send" INTEGER DEFAULT (60) NOT NULL, "max_data_to_route" INTEGER DEFAULT (100000) NOT NULL, "extract_period_millis" INTEGER DEFAULT (0) NOT NULL, "enabled" INTEGER DEFAULT (1) NOT NULL, "use_old_data_to_route" INTEGER DEFAULT (1) NOT NULL, "use_row_data_to_route" INTEGER DEFAULT (1) NOT NULL, "use_pk_data_to_route" INTEGER DEFAULT (1) NOT NULL, "reload_flag" INTEGER DEFAULT (0) NOT NULL, "file_sync_flag" INTEGER DEFAULT (0) NOT NULL, "contains_big_lob" INTEGER DEFAULT (0) NOT NULL, "batch_algorithm" VARCHAR DEFAULT ('default') NOT NULL, "data_loader_type" VARCHAR DEFAULT ('default') NOT NULL, "description" VARCHAR, "queue" VARCHAR DEFAULT ('default') NOT NULL, "max_network_kbps" DECIMAL DEFAULT (0.000) NOT NULL, "data_event_action" VARCHAR, "create_time" TIMESTAMP, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP ) 2021-03-29 23:55:41,320 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_conflict"( "conflict_id" VARCHAR NOT NULL PRIMARY KEY , "source_node_group_id" VARCHAR NOT NULL, "target_node_group_id" VARCHAR NOT NULL, "target_channel_id" VARCHAR, "target_catalog_name" VARCHAR, "target_schema_name" VARCHAR, "target_table_name" VARCHAR, "detect_type" VARCHAR NOT NULL, "detect_expression" VARCHAR, "resolve_type" VARCHAR NOT NULL, "ping_back" VARCHAR NOT NULL, "resolve_changes_only" INTEGER DEFAULT (0), "resolve_row_only" INTEGER DEFAULT (0), "create_time" TIMESTAMP NOT NULL, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP NOT NULL, FOREIGN KEY ("source_node_group_id", "target_node_group_id") REFERENCES "sym_node_group_link" ("source_node_group_id", "target_node_group_id") ) 2021-03-29 23:55:41,330 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_context"( "name" VARCHAR NOT NULL PRIMARY KEY , "context_value" VARCHAR, "create_time" TIMESTAMP, "last_update_time" TIMESTAMP ) 2021-03-29 23:55:41,340 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_data"( "data_id" INTEGER NOT NULL PRIMARY KEY AUTOINCREMENT, "table_name" VARCHAR NOT NULL, "event_type" VARCHAR NOT NULL, "row_data" VARCHAR, "pk_data" VARCHAR, "old_data" VARCHAR, "trigger_hist_id" INTEGER NOT NULL, "channel_id" VARCHAR, "transaction_id" VARCHAR, "source_node_id" VARCHAR, "external_data" VARCHAR, "node_list" VARCHAR, "is_prerouted" INTEGER DEFAULT (0) NOT NULL, "create_time" TIMESTAMP ) 2021-03-29 23:55:41,350 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE UNIQUE INDEX "sym_idx_d_channel_id" ON "sym_data" ("data_id", "channel_id") 2021-03-29 23:55:41,360 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_data_event"( "data_id" INTEGER NOT NULL, "batch_id" INTEGER NOT NULL, "create_time" TIMESTAMP, PRIMARY KEY ("data_id", "batch_id") ) 2021-03-29 23:55:41,370 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE INDEX "sym_idx_de_batchid" ON "sym_data_event" ("batch_id") 2021-03-29 23:55:41,380 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_data_gap"( "start_id" INTEGER NOT NULL, "end_id" INTEGER NOT NULL, "create_time" TIMESTAMP NOT NULL, "last_update_hostname" VARCHAR, PRIMARY KEY ("start_id", "end_id") ) 2021-03-29 23:55:41,390 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_extension"( "extension_id" VARCHAR NOT NULL PRIMARY KEY , "extension_type" VARCHAR NOT NULL, "interface_name" VARCHAR, "node_group_id" VARCHAR NOT NULL, "enabled" INTEGER DEFAULT (1) NOT NULL, "extension_order" INTEGER DEFAULT (1) NOT NULL, "extension_text" VARCHAR, "create_time" TIMESTAMP, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP ) 2021-03-29 23:55:41,399 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_extract_request"( "request_id" INTEGER NOT NULL PRIMARY KEY , "node_id" VARCHAR NOT NULL, "queue" VARCHAR, "status" VARCHAR, "start_batch_id" INTEGER NOT NULL, "end_batch_id" INTEGER NOT NULL, "trigger_id" VARCHAR NOT NULL, "router_id" VARCHAR NOT NULL, "load_id" INTEGER, "table_name" VARCHAR, "extracted_rows" INTEGER DEFAULT (0) NOT NULL, "extracted_millis" INTEGER DEFAULT (0) NOT NULL, "transferred_rows" INTEGER DEFAULT (0) NOT NULL, "transferred_millis" INTEGER DEFAULT (0) NOT NULL, "last_transferred_batch_id" INTEGER, "loaded_rows" INTEGER DEFAULT (0) NOT NULL, "loaded_millis" INTEGER DEFAULT (0) NOT NULL, "last_loaded_batch_id" INTEGER, "total_rows" INTEGER, "loaded_time" TIMESTAMP, "parent_request_id" INTEGER DEFAULT (0) NOT NULL, "last_update_time" TIMESTAMP, "create_time" TIMESTAMP ) 2021-03-29 23:55:41,410 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_file_incoming"( "relative_dir" VARCHAR NOT NULL, "file_name" VARCHAR NOT NULL, "last_event_type" VARCHAR NOT NULL, "node_id" VARCHAR NOT NULL, "file_modified_time" INTEGER, PRIMARY KEY ("relative_dir", "file_name") ) 2021-03-29 23:55:41,420 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_file_snapshot"( "trigger_id" VARCHAR NOT NULL, "router_id" VARCHAR NOT NULL, "relative_dir" VARCHAR NOT NULL, "file_name" VARCHAR NOT NULL, "channel_id" VARCHAR DEFAULT ('filesync') NOT NULL, "reload_channel_id" VARCHAR DEFAULT ('filesync_reload') NOT NULL, "last_event_type" VARCHAR NOT NULL, "crc32_checksum" INTEGER, "file_size" INTEGER, "file_modified_time" INTEGER, "last_update_time" TIMESTAMP NOT NULL, "last_update_by" VARCHAR, "create_time" TIMESTAMP NOT NULL, PRIMARY KEY ("trigger_id", "router_id", "relative_dir", "file_name") ) 2021-03-29 23:55:41,430 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE INDEX "sym_idx_f_snpsht_chid" ON "sym_file_snapshot" ("reload_channel_id") 2021-03-29 23:55:41,440 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_file_trigger"( "trigger_id" VARCHAR NOT NULL PRIMARY KEY , "channel_id" VARCHAR DEFAULT ('filesync') NOT NULL, "reload_channel_id" VARCHAR DEFAULT ('filesync_reload') NOT NULL, "base_dir" VARCHAR NOT NULL, "recurse" INTEGER DEFAULT (1) NOT NULL, "includes_files" VARCHAR, "excludes_files" VARCHAR, "sync_on_create" INTEGER DEFAULT (1) NOT NULL, "sync_on_modified" INTEGER DEFAULT (1) NOT NULL, "sync_on_delete" INTEGER DEFAULT (1) NOT NULL, "sync_on_ctl_file" INTEGER DEFAULT (0) NOT NULL, "delete_after_sync" INTEGER DEFAULT (0) NOT NULL, "before_copy_script" VARCHAR, "after_copy_script" VARCHAR, "create_time" TIMESTAMP NOT NULL, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP NOT NULL, "description" VARCHAR ) 2021-03-29 23:55:41,450 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_file_trigger_router"( "trigger_id" VARCHAR NOT NULL, "router_id" VARCHAR NOT NULL, "enabled" INTEGER DEFAULT (1) NOT NULL, "initial_load_enabled" INTEGER DEFAULT (1) NOT NULL, "target_base_dir" VARCHAR, "conflict_strategy" VARCHAR DEFAULT ('source_wins') NOT NULL, "create_time" TIMESTAMP NOT NULL, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP NOT NULL, "description" VARCHAR, PRIMARY KEY ("trigger_id", "router_id"), FOREIGN KEY ("trigger_id") REFERENCES "sym_file_trigger" ("trigger_id"), FOREIGN KEY ("router_id") REFERENCES "sym_router" ("router_id") ) 2021-03-29 23:55:41,461 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_grouplet"( "grouplet_id" VARCHAR NOT NULL PRIMARY KEY , "grouplet_link_policy" VARCHAR DEFAULT ('I') NOT NULL, "description" VARCHAR, "create_time" TIMESTAMP NOT NULL, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP NOT NULL ) 2021-03-29 23:55:41,471 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_grouplet_link"( "grouplet_id" VARCHAR NOT NULL, "external_id" VARCHAR NOT NULL, "create_time" TIMESTAMP NOT NULL, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP NOT NULL, PRIMARY KEY ("grouplet_id", "external_id"), FOREIGN KEY ("grouplet_id") REFERENCES "sym_grouplet" ("grouplet_id") ) 2021-03-29 23:55:41,482 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_incoming_batch"( "batch_id" INTEGER NOT NULL, "node_id" VARCHAR NOT NULL, "channel_id" VARCHAR, "status" VARCHAR, "error_flag" INTEGER DEFAULT (0), "sql_state" VARCHAR, "sql_code" INTEGER DEFAULT (0) NOT NULL, "sql_message" VARCHAR, "last_update_hostname" VARCHAR, "last_update_time" TIMESTAMP, "create_time" TIMESTAMP, "summary" VARCHAR, "ignore_count" INTEGER DEFAULT (0) NOT NULL, "byte_count" INTEGER DEFAULT (0) NOT NULL, "load_flag" INTEGER DEFAULT (0), "extract_count" INTEGER DEFAULT (0) NOT NULL, "sent_count" INTEGER DEFAULT (0) NOT NULL, "load_count" INTEGER DEFAULT (0) NOT NULL, "reload_row_count" INTEGER DEFAULT (0) NOT NULL, "other_row_count" INTEGER DEFAULT (0) NOT NULL, "data_row_count" INTEGER DEFAULT (0) NOT NULL, "extract_row_count" INTEGER DEFAULT (0) NOT NULL, "load_row_count" INTEGER DEFAULT (0) NOT NULL, "data_insert_row_count" INTEGER DEFAULT (0) NOT NULL, "data_update_row_count" INTEGER DEFAULT (0) NOT NULL, "data_delete_row_count" INTEGER DEFAULT (0) NOT NULL, "extract_insert_row_count" INTEGER DEFAULT (0) NOT NULL, "extract_update_row_count" INTEGER DEFAULT (0) NOT NULL, "extract_delete_row_count" INTEGER DEFAULT (0) NOT NULL, "load_insert_row_count" INTEGER DEFAULT (0) NOT NULL, "load_update_row_count" INTEGER DEFAULT (0) NOT NULL, "load_delete_row_count" INTEGER DEFAULT (0) NOT NULL, "network_millis" INTEGER DEFAULT (0) NOT NULL, "filter_millis" INTEGER DEFAULT (0) NOT NULL, "load_millis" INTEGER DEFAULT (0) NOT NULL, "router_millis" INTEGER DEFAULT (0) NOT NULL, "extract_millis" INTEGER DEFAULT (0) NOT NULL, "transform_extract_millis" INTEGER DEFAULT (0) NOT NULL, "transform_load_millis" INTEGER DEFAULT (0) NOT NULL, "load_id" INTEGER, "common_flag" INTEGER DEFAULT (0), "fallback_insert_count" INTEGER DEFAULT (0) NOT NULL, "fallback_update_count" INTEGER DEFAULT (0) NOT NULL, "ignore_row_count" INTEGER DEFAULT (0) NOT NULL, "missing_delete_count" INTEGER DEFAULT (0) NOT NULL, "skip_count" INTEGER DEFAULT (0) NOT NULL, "failed_row_number" INTEGER DEFAULT (0) NOT NULL, "failed_line_number" INTEGER DEFAULT (0) NOT NULL, "failed_data_id" INTEGER DEFAULT (0) NOT NULL, PRIMARY KEY ("batch_id", "node_id") ) 2021-03-29 23:55:41,492 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE INDEX "sym_idx_ib_time_status" ON "sym_incoming_batch" ("create_time", "status") 2021-03-29 23:55:41,503 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE INDEX "sym_idx_ib_in_error" ON "sym_incoming_batch" ("error_flag") 2021-03-29 23:55:41,513 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_incoming_error"( "batch_id" INTEGER NOT NULL, "node_id" VARCHAR NOT NULL, "failed_row_number" INTEGER NOT NULL, "failed_line_number" INTEGER DEFAULT (0) NOT NULL, "target_catalog_name" VARCHAR, "target_schema_name" VARCHAR, "target_table_name" VARCHAR NOT NULL, "event_type" VARCHAR NOT NULL, "binary_encoding" VARCHAR DEFAULT ('HEX') NOT NULL, "column_names" VARCHAR NOT NULL, "pk_column_names" VARCHAR NOT NULL, "row_data" VARCHAR, "old_data" VARCHAR, "cur_data" VARCHAR, "resolve_data" VARCHAR, "resolve_ignore" INTEGER DEFAULT (0), "conflict_id" VARCHAR, "create_time" TIMESTAMP, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP NOT NULL, PRIMARY KEY ("batch_id", "node_id", "failed_row_number") ) 2021-03-29 23:55:41,523 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_job"( "job_name" VARCHAR NOT NULL PRIMARY KEY , "job_type" VARCHAR NOT NULL, "requires_registration" INTEGER DEFAULT (1) NOT NULL, "job_expression" VARCHAR, "description" VARCHAR, "default_schedule" VARCHAR, "default_auto_start" INTEGER DEFAULT (1) NOT NULL, "node_group_id" VARCHAR NOT NULL, "create_by" VARCHAR, "create_time" TIMESTAMP, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP ) 2021-03-29 23:55:41,533 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_load_filter"( "load_filter_id" VARCHAR NOT NULL PRIMARY KEY , "load_filter_type" VARCHAR NOT NULL, "source_node_group_id" VARCHAR NOT NULL, "target_node_group_id" VARCHAR NOT NULL, "target_catalog_name" VARCHAR, "target_schema_name" VARCHAR, "target_table_name" VARCHAR, "filter_on_update" INTEGER DEFAULT (1) NOT NULL, "filter_on_insert" INTEGER DEFAULT (1) NOT NULL, "filter_on_delete" INTEGER DEFAULT (1) NOT NULL, "before_write_script" VARCHAR, "after_write_script" VARCHAR, "batch_complete_script" VARCHAR, "batch_commit_script" VARCHAR, "batch_rollback_script" VARCHAR, "handle_error_script" VARCHAR, "create_time" TIMESTAMP NOT NULL, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP NOT NULL, "load_filter_order" INTEGER DEFAULT (1) NOT NULL, "fail_on_error" INTEGER DEFAULT (0) NOT NULL ) 2021-03-29 23:55:41,544 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_lock"( "lock_action" VARCHAR NOT NULL PRIMARY KEY , "lock_type" VARCHAR NOT NULL, "locking_server_id" VARCHAR, "lock_time" TIMESTAMP, "shared_count" INTEGER DEFAULT (0) NOT NULL, "shared_enable" INTEGER DEFAULT (0) NOT NULL, "last_lock_time" TIMESTAMP, "last_locking_server_id" VARCHAR ) 2021-03-29 23:55:41,554 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_node"( "node_id" VARCHAR NOT NULL PRIMARY KEY , "node_group_id" VARCHAR NOT NULL, "external_id" VARCHAR NOT NULL, "sync_enabled" INTEGER DEFAULT (0), "sync_url" VARCHAR, "schema_version" VARCHAR, "symmetric_version" VARCHAR, "config_version" VARCHAR, "database_type" VARCHAR, "database_version" VARCHAR, "database_name" VARCHAR, "batch_to_send_count" INTEGER DEFAULT (0), "batch_in_error_count" INTEGER DEFAULT (0), "created_at_node_id" VARCHAR, "deployment_type" VARCHAR, "deployment_sub_type" VARCHAR ) 2021-03-29 23:55:41,565 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_node_communication"( "node_id" VARCHAR NOT NULL, "queue" VARCHAR DEFAULT ('default') NOT NULL, "communication_type" VARCHAR NOT NULL, "lock_time" TIMESTAMP, "locking_server_id" VARCHAR, "last_lock_time" TIMESTAMP, "last_lock_millis" INTEGER DEFAULT (0), "success_count" INTEGER DEFAULT (0), "fail_count" INTEGER DEFAULT (0), "skip_count" INTEGER DEFAULT (0), "total_success_count" INTEGER DEFAULT (0), "total_fail_count" INTEGER DEFAULT (0), "total_success_millis" INTEGER DEFAULT (0), "total_fail_millis" INTEGER DEFAULT (0), "batch_to_send_count" INTEGER DEFAULT (0), "node_priority" INTEGER DEFAULT (0), PRIMARY KEY ("node_id", "queue", "communication_type") ) 2021-03-29 23:55:41,575 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_node_channel_ctl"( "node_id" VARCHAR NOT NULL, "channel_id" VARCHAR NOT NULL, "suspend_enabled" INTEGER DEFAULT (0), "ignore_enabled" INTEGER DEFAULT (0), "last_extract_time" TIMESTAMP, PRIMARY KEY ("node_id", "channel_id") ) 2021-03-29 23:55:41,586 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_node_group"( "node_group_id" VARCHAR NOT NULL PRIMARY KEY , "description" VARCHAR, "create_time" TIMESTAMP, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP ) 2021-03-29 23:55:41,595 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_node_group_channel_wnd"( "node_group_id" VARCHAR NOT NULL, "channel_id" VARCHAR NOT NULL, "start_time" TIMESTAMP NOT NULL, "end_time" TIMESTAMP NOT NULL, "enabled" INTEGER DEFAULT (0) NOT NULL, PRIMARY KEY ("node_group_id", "channel_id", "start_time", "end_time") ) 2021-03-29 23:55:41,607 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_node_group_link"( "source_node_group_id" VARCHAR NOT NULL, "target_node_group_id" VARCHAR NOT NULL, "data_event_action" VARCHAR DEFAULT ('W') NOT NULL, "sync_config_enabled" INTEGER DEFAULT (1) NOT NULL, "is_reversible" INTEGER DEFAULT (0) NOT NULL, "create_time" TIMESTAMP, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP, PRIMARY KEY ("source_node_group_id", "target_node_group_id"), FOREIGN KEY ("source_node_group_id") REFERENCES "sym_node_group" ("node_group_id"), FOREIGN KEY ("target_node_group_id") REFERENCES "sym_node_group" ("node_group_id") ) 2021-03-29 23:55:41,617 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_node_host"( "node_id" VARCHAR NOT NULL, "host_name" VARCHAR NOT NULL, "instance_id" VARCHAR, "ip_address" VARCHAR, "os_user" VARCHAR, "os_name" VARCHAR, "os_arch" VARCHAR, "os_version" VARCHAR, "available_processors" INTEGER DEFAULT (0), "free_memory_bytes" INTEGER DEFAULT (0), "total_memory_bytes" INTEGER DEFAULT (0), "max_memory_bytes" INTEGER DEFAULT (0), "java_version" VARCHAR, "java_vendor" VARCHAR, "jdbc_version" VARCHAR, "symmetric_version" VARCHAR, "timezone_offset" VARCHAR, "heartbeat_time" TIMESTAMP, "last_restart_time" TIMESTAMP NOT NULL, "create_time" TIMESTAMP NOT NULL, PRIMARY KEY ("node_id", "host_name") ) 2021-03-29 23:55:41,628 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_node_host_channel_stats"( "node_id" VARCHAR NOT NULL, "host_name" VARCHAR NOT NULL, "channel_id" VARCHAR NOT NULL, "start_time" TIMESTAMP NOT NULL, "end_time" TIMESTAMP NOT NULL, "data_routed" INTEGER DEFAULT (0), "data_unrouted" INTEGER DEFAULT (0), "data_event_inserted" INTEGER DEFAULT (0), "data_extracted" INTEGER DEFAULT (0), "data_bytes_extracted" INTEGER DEFAULT (0), "data_extracted_errors" INTEGER DEFAULT (0), "data_bytes_sent" INTEGER DEFAULT (0), "data_sent" INTEGER DEFAULT (0), "data_sent_errors" INTEGER DEFAULT (0), "data_loaded" INTEGER DEFAULT (0), "data_bytes_loaded" INTEGER DEFAULT (0), "data_loaded_errors" INTEGER DEFAULT (0), "data_loaded_outgoing" INTEGER DEFAULT (0), "data_bytes_loaded_outgoing" INTEGER DEFAULT (0), "data_loaded_outgoing_errors" INTEGER DEFAULT (0), PRIMARY KEY ("node_id", "host_name", "channel_id", "start_time", "end_time") ) 2021-03-29 23:55:41,639 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE INDEX "sym_idx_nd_hst_chnl_sts" ON "sym_node_host_channel_stats" ("node_id", "start_time", "end_time") 2021-03-29 23:55:41,650 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_node_host_job_stats"( "node_id" VARCHAR NOT NULL, "host_name" VARCHAR NOT NULL, "job_name" VARCHAR NOT NULL, "start_time" TIMESTAMP NOT NULL, "end_time" TIMESTAMP NOT NULL, "processed_count" INTEGER DEFAULT (0), "target_node_id" VARCHAR, "target_node_count" INTEGER DEFAULT (0), PRIMARY KEY ("node_id", "host_name", "job_name", "start_time", "end_time") ) 2021-03-29 23:55:41,660 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE INDEX "sym_idx_nd_hst_job" ON "sym_node_host_job_stats" ("node_id", "start_time", "end_time") 2021-03-29 23:55:41,670 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_node_host_stats"( "node_id" VARCHAR NOT NULL, "host_name" VARCHAR NOT NULL, "start_time" TIMESTAMP NOT NULL, "end_time" TIMESTAMP NOT NULL, "restarted" INTEGER DEFAULT (0) NOT NULL, "nodes_pulled" INTEGER DEFAULT (0), "total_nodes_pull_time" INTEGER DEFAULT (0), "nodes_pushed" INTEGER DEFAULT (0), "total_nodes_push_time" INTEGER DEFAULT (0), "nodes_rejected" INTEGER DEFAULT (0), "nodes_registered" INTEGER DEFAULT (0), "nodes_loaded" INTEGER DEFAULT (0), "nodes_disabled" INTEGER DEFAULT (0), "purged_data_rows" INTEGER DEFAULT (0), "purged_data_event_rows" INTEGER DEFAULT (0), "purged_batch_outgoing_rows" INTEGER DEFAULT (0), "purged_batch_incoming_rows" INTEGER DEFAULT (0), "triggers_created_count" INTEGER, "triggers_rebuilt_count" INTEGER, "triggers_removed_count" INTEGER, PRIMARY KEY ("node_id", "host_name", "start_time", "end_time") ) 2021-03-29 23:55:41,680 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE INDEX "sym_idx_nd_hst_sts" ON "sym_node_host_stats" ("node_id", "start_time", "end_time") 2021-03-29 23:55:41,691 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_node_identity"( "node_id" VARCHAR NOT NULL PRIMARY KEY , FOREIGN KEY ("node_id") REFERENCES "sym_node" ("node_id") ) 2021-03-29 23:55:41,702 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_node_security"( "node_id" VARCHAR NOT NULL PRIMARY KEY , "node_password" VARCHAR NOT NULL, "registration_enabled" INTEGER DEFAULT (0), "registration_time" TIMESTAMP, "initial_load_enabled" INTEGER DEFAULT (0), "initial_load_time" TIMESTAMP, "initial_load_end_time" TIMESTAMP, "initial_load_id" INTEGER, "initial_load_create_by" VARCHAR, "rev_initial_load_enabled" INTEGER DEFAULT (0), "rev_initial_load_time" TIMESTAMP, "rev_initial_load_id" INTEGER, "rev_initial_load_create_by" VARCHAR, "failed_logins" INTEGER DEFAULT (0), "created_at_node_id" VARCHAR, FOREIGN KEY ("node_id") REFERENCES "sym_node" ("node_id") ) 2021-03-29 23:55:41,712 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_monitor"( "monitor_id" VARCHAR NOT NULL PRIMARY KEY , "node_group_id" VARCHAR DEFAULT ('ALL') NOT NULL, "external_id" VARCHAR DEFAULT ('ALL') NOT NULL, "type" VARCHAR NOT NULL, "expression" VARCHAR, "threshold" INTEGER DEFAULT (0) NOT NULL, "run_period" INTEGER DEFAULT (0) NOT NULL, "run_count" INTEGER DEFAULT (0) NOT NULL, "severity_level" INTEGER DEFAULT (0) NOT NULL, "enabled" INTEGER DEFAULT (0) NOT NULL, "create_time" TIMESTAMP, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP ) 2021-03-29 23:55:41,722 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_monitor_event"( "monitor_id" VARCHAR NOT NULL, "node_id" VARCHAR NOT NULL, "event_time" TIMESTAMP NOT NULL, "host_name" VARCHAR, "type" VARCHAR NOT NULL, "threshold" INTEGER DEFAULT (0) NOT NULL, "event_value" INTEGER DEFAULT (0) NOT NULL, "event_count" INTEGER DEFAULT (0) NOT NULL, "severity_level" INTEGER DEFAULT (0) NOT NULL, "is_resolved" INTEGER DEFAULT (0) NOT NULL, "is_notified" INTEGER DEFAULT (0) NOT NULL, "details" VARCHAR, "last_update_time" TIMESTAMP, PRIMARY KEY ("monitor_id", "node_id", "event_time") ) 2021-03-29 23:55:41,733 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_notification"( "notification_id" VARCHAR NOT NULL PRIMARY KEY , "node_group_id" VARCHAR DEFAULT ('ALL') NOT NULL, "external_id" VARCHAR DEFAULT ('ALL') NOT NULL, "severity_level" INTEGER DEFAULT (0) NOT NULL, "type" VARCHAR NOT NULL, "expression" VARCHAR, "enabled" INTEGER DEFAULT (0) NOT NULL, "create_time" TIMESTAMP, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP ) 2021-03-29 23:55:41,744 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_outgoing_batch"( "batch_id" INTEGER NOT NULL, "node_id" VARCHAR NOT NULL, "channel_id" VARCHAR, "status" VARCHAR, "error_flag" INTEGER DEFAULT (0), "sql_state" VARCHAR, "sql_code" INTEGER DEFAULT (0) NOT NULL, "sql_message" VARCHAR, "last_update_hostname" VARCHAR, "last_update_time" TIMESTAMP, "create_time" TIMESTAMP, "summary" VARCHAR, "ignore_count" INTEGER DEFAULT (0) NOT NULL, "byte_count" INTEGER DEFAULT (0) NOT NULL, "load_flag" INTEGER DEFAULT (0), "extract_count" INTEGER DEFAULT (0) NOT NULL, "sent_count" INTEGER DEFAULT (0) NOT NULL, "load_count" INTEGER DEFAULT (0) NOT NULL, "reload_row_count" INTEGER DEFAULT (0) NOT NULL, "other_row_count" INTEGER DEFAULT (0) NOT NULL, "data_row_count" INTEGER DEFAULT (0) NOT NULL, "extract_row_count" INTEGER DEFAULT (0) NOT NULL, "load_row_count" INTEGER DEFAULT (0) NOT NULL, "data_insert_row_count" INTEGER DEFAULT (0) NOT NULL, "data_update_row_count" INTEGER DEFAULT (0) NOT NULL, "data_delete_row_count" INTEGER DEFAULT (0) NOT NULL, "extract_insert_row_count" INTEGER DEFAULT (0) NOT NULL, "extract_update_row_count" INTEGER DEFAULT (0) NOT NULL, "extract_delete_row_count" INTEGER DEFAULT (0) NOT NULL, "load_insert_row_count" INTEGER DEFAULT (0) NOT NULL, "load_update_row_count" INTEGER DEFAULT (0) NOT NULL, "load_delete_row_count" INTEGER DEFAULT (0) NOT NULL, "network_millis" INTEGER DEFAULT (0) NOT NULL, "filter_millis" INTEGER DEFAULT (0) NOT NULL, "load_millis" INTEGER DEFAULT (0) NOT NULL, "router_millis" INTEGER DEFAULT (0) NOT NULL, "extract_millis" INTEGER DEFAULT (0) NOT NULL, "transform_extract_millis" INTEGER DEFAULT (0) NOT NULL, "transform_load_millis" INTEGER DEFAULT (0) NOT NULL, "load_id" INTEGER, "common_flag" INTEGER DEFAULT (0), "fallback_insert_count" INTEGER DEFAULT (0) NOT NULL, "fallback_update_count" INTEGER DEFAULT (0) NOT NULL, "ignore_row_count" INTEGER DEFAULT (0) NOT NULL, "missing_delete_count" INTEGER DEFAULT (0) NOT NULL, "skip_count" INTEGER DEFAULT (0) NOT NULL, "total_extract_millis" INTEGER DEFAULT (0) NOT NULL, "total_load_millis" INTEGER DEFAULT (0) NOT NULL, "extract_job_flag" INTEGER DEFAULT (0), "extract_start_time" TIMESTAMP, "transfer_start_time" TIMESTAMP, "load_start_time" TIMESTAMP, "failed_data_id" INTEGER DEFAULT (0) NOT NULL, "failed_line_number" INTEGER DEFAULT (0) NOT NULL, "create_by" VARCHAR, PRIMARY KEY ("batch_id", "node_id") ) 2021-03-29 23:55:41,755 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE INDEX "sym_idx_ob_node_status" ON "sym_outgoing_batch" ("node_id", "status") 2021-03-29 23:55:41,765 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE INDEX "sym_idx_ob_status" ON "sym_outgoing_batch" ("status") 2021-03-29 23:55:41,775 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE INDEX "sym_idx_ob_in_error" ON "sym_outgoing_batch" ("error_flag") 2021-03-29 23:55:41,785 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_parameter"( "external_id" VARCHAR NOT NULL, "node_group_id" VARCHAR NOT NULL, "param_key" VARCHAR NOT NULL, "param_value" VARCHAR, "create_time" TIMESTAMP, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP, PRIMARY KEY ("external_id", "node_group_id", "param_key") ) 2021-03-29 23:55:41,795 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_registration_redirect"( "registrant_external_id" VARCHAR NOT NULL PRIMARY KEY , "registration_node_id" VARCHAR NOT NULL ) 2021-03-29 23:55:41,805 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_registration_request"( "node_group_id" VARCHAR NOT NULL, "external_id" VARCHAR NOT NULL, "status" VARCHAR NOT NULL, "host_name" VARCHAR NOT NULL, "ip_address" VARCHAR NOT NULL, "attempt_count" INTEGER DEFAULT (0), "registered_node_id" VARCHAR, "error_message" VARCHAR, "create_time" TIMESTAMP NOT NULL, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP NOT NULL, PRIMARY KEY ("node_group_id", "external_id", "create_time") ) 2021-03-29 23:55:41,815 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE INDEX "sym_idx_reg_req_1" ON "sym_registration_request" ("node_group_id", "external_id", "status", "host_name", "ip_address") 2021-03-29 23:55:41,825 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE INDEX "sym_idx_reg_req_2" ON "sym_registration_request" ("status") 2021-03-29 23:55:41,835 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_router"( "router_id" VARCHAR NOT NULL PRIMARY KEY , "target_catalog_name" VARCHAR, "target_schema_name" VARCHAR, "target_table_name" VARCHAR, "source_node_group_id" VARCHAR NOT NULL, "target_node_group_id" VARCHAR NOT NULL, "router_type" VARCHAR DEFAULT ('default') NOT NULL, "router_expression" VARCHAR, "sync_on_update" INTEGER DEFAULT (1) NOT NULL, "sync_on_insert" INTEGER DEFAULT (1) NOT NULL, "sync_on_delete" INTEGER DEFAULT (1) NOT NULL, "use_source_catalog_schema" INTEGER DEFAULT (1) NOT NULL, "create_time" TIMESTAMP NOT NULL, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP NOT NULL, "description" VARCHAR, FOREIGN KEY ("source_node_group_id", "target_node_group_id") REFERENCES "sym_node_group_link" ("source_node_group_id", "target_node_group_id") ) 2021-03-29 23:55:41,845 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_sequence"( "sequence_name" VARCHAR NOT NULL PRIMARY KEY , "current_value" INTEGER DEFAULT (0) NOT NULL, "increment_by" INTEGER DEFAULT (1) NOT NULL, "min_value" INTEGER DEFAULT (1) NOT NULL, "max_value" INTEGER DEFAULT (9999999999) NOT NULL, "cycle_flag" INTEGER DEFAULT (0), "cache_size" INTEGER DEFAULT (0) NOT NULL, "create_time" TIMESTAMP, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP NOT NULL ) 2021-03-29 23:55:41,856 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_table_reload_request"( "target_node_id" VARCHAR NOT NULL, "source_node_id" VARCHAR NOT NULL, "trigger_id" VARCHAR NOT NULL, "router_id" VARCHAR NOT NULL, "create_time" TIMESTAMP NOT NULL, "create_table" INTEGER DEFAULT (0) NOT NULL, "delete_first" INTEGER DEFAULT (0) NOT NULL, "reload_select" VARCHAR, "before_custom_sql" VARCHAR, "reload_time" TIMESTAMP, "load_id" INTEGER, "processed" INTEGER DEFAULT (0) NOT NULL, "channel_id" VARCHAR, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP NOT NULL, PRIMARY KEY ("target_node_id", "source_node_id", "trigger_id", "router_id", "create_time") ) 2021-03-29 23:55:41,866 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_table_reload_status"( "load_id" INTEGER NOT NULL, "source_node_id" VARCHAR NOT NULL, "target_node_id" VARCHAR NOT NULL, "start_time" TIMESTAMP, "end_time" TIMESTAMP, "completed" INTEGER DEFAULT (0) NOT NULL, "cancelled" INTEGER DEFAULT (0) NOT NULL, "full_load" INTEGER DEFAULT (0) NOT NULL, "start_data_batch_id" INTEGER, "end_data_batch_id" INTEGER, "setup_batch_count" INTEGER DEFAULT (0) NOT NULL, "data_batch_count" INTEGER DEFAULT (0) NOT NULL, "finalize_batch_count" INTEGER DEFAULT (0) NOT NULL, "setup_batch_loaded" INTEGER DEFAULT (0) NOT NULL, "data_batch_loaded" INTEGER DEFAULT (0) NOT NULL, "finalize_batch_loaded" INTEGER DEFAULT (0) NOT NULL, "table_count" INTEGER DEFAULT (0) NOT NULL, "rows_loaded" INTEGER DEFAULT (0) NOT NULL, "rows_count" INTEGER DEFAULT (0) NOT NULL, "error_flag" INTEGER DEFAULT (0) NOT NULL, "sql_state" VARCHAR, "sql_code" INTEGER DEFAULT (0) NOT NULL, "sql_message" VARCHAR, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP NOT NULL, PRIMARY KEY ("load_id", "source_node_id") ) 2021-03-29 23:55:41,876 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_transform_table"( "transform_id" VARCHAR NOT NULL, "source_node_group_id" VARCHAR NOT NULL, "target_node_group_id" VARCHAR NOT NULL, "transform_point" VARCHAR NOT NULL, "source_catalog_name" VARCHAR, "source_schema_name" VARCHAR, "source_table_name" VARCHAR NOT NULL, "target_catalog_name" VARCHAR, "target_schema_name" VARCHAR, "target_table_name" VARCHAR, "update_first" INTEGER DEFAULT (0), "update_action" VARCHAR DEFAULT ('UPDATE_COL') NOT NULL, "delete_action" VARCHAR NOT NULL, "transform_order" INTEGER DEFAULT (1) NOT NULL, "column_policy" VARCHAR DEFAULT ('SPECIFIED') NOT NULL, "create_time" TIMESTAMP, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP, "description" VARCHAR, PRIMARY KEY ("transform_id", "source_node_group_id", "target_node_group_id"), FOREIGN KEY ("source_node_group_id", "target_node_group_id") REFERENCES "sym_node_group_link" ("source_node_group_id", "target_node_group_id") ) 2021-03-29 23:55:41,887 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_transform_column"( "transform_id" VARCHAR NOT NULL, "include_on" VARCHAR DEFAULT ('*') NOT NULL, "target_column_name" VARCHAR NOT NULL, "source_column_name" VARCHAR, "pk" INTEGER DEFAULT (0), "transform_type" VARCHAR DEFAULT ('copy'), "transform_expression" VARCHAR, "transform_order" INTEGER DEFAULT (1) NOT NULL, "create_time" TIMESTAMP, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP, "description" VARCHAR, PRIMARY KEY ("transform_id", "include_on", "target_column_name") ) 2021-03-29 23:55:41,897 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_trigger"( "trigger_id" VARCHAR NOT NULL PRIMARY KEY , "source_catalog_name" VARCHAR, "source_schema_name" VARCHAR, "source_table_name" VARCHAR NOT NULL, "channel_id" VARCHAR NOT NULL, "reload_channel_id" VARCHAR DEFAULT ('reload') NOT NULL, "sync_on_update" INTEGER DEFAULT (1) NOT NULL, "sync_on_insert" INTEGER DEFAULT (1) NOT NULL, "sync_on_delete" INTEGER DEFAULT (1) NOT NULL, "sync_on_incoming_batch" INTEGER DEFAULT (0) NOT NULL, "name_for_update_trigger" VARCHAR, "name_for_insert_trigger" VARCHAR, "name_for_delete_trigger" VARCHAR, "sync_on_update_condition" VARCHAR, "sync_on_insert_condition" VARCHAR, "sync_on_delete_condition" VARCHAR, "custom_before_update_text" VARCHAR, "custom_before_insert_text" VARCHAR, "custom_before_delete_text" VARCHAR, "custom_on_update_text" VARCHAR, "custom_on_insert_text" VARCHAR, "custom_on_delete_text" VARCHAR, "external_select" VARCHAR, "tx_id_expression" VARCHAR, "channel_expression" VARCHAR, "excluded_column_names" VARCHAR, "included_column_names" VARCHAR, "sync_key_names" VARCHAR, "use_stream_lobs" INTEGER DEFAULT (0) NOT NULL, "use_capture_lobs" INTEGER DEFAULT (0) NOT NULL, "use_capture_old_data" INTEGER DEFAULT (1) NOT NULL, "use_handle_key_updates" INTEGER DEFAULT (1) NOT NULL, "stream_row" INTEGER DEFAULT (0) NOT NULL, "create_time" TIMESTAMP NOT NULL, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP NOT NULL, "description" VARCHAR, FOREIGN KEY ("channel_id") REFERENCES "sym_channel" ("channel_id"), FOREIGN KEY ("reload_channel_id") REFERENCES "sym_channel" ("channel_id") ) 2021-03-29 23:55:41,908 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_trigger_hist"( "trigger_hist_id" INTEGER NOT NULL PRIMARY KEY , "trigger_id" VARCHAR NOT NULL, "source_table_name" VARCHAR NOT NULL, "source_catalog_name" VARCHAR, "source_schema_name" VARCHAR, "name_for_update_trigger" VARCHAR, "name_for_insert_trigger" VARCHAR, "name_for_delete_trigger" VARCHAR, "table_hash" INTEGER DEFAULT (0) NOT NULL, "trigger_row_hash" INTEGER DEFAULT (0) NOT NULL, "trigger_template_hash" INTEGER DEFAULT (0) NOT NULL, "column_names" VARCHAR NOT NULL, "pk_column_names" VARCHAR NOT NULL, "last_trigger_build_reason" VARCHAR NOT NULL, "error_message" VARCHAR, "create_time" TIMESTAMP NOT NULL, "inactive_time" TIMESTAMP ) 2021-03-29 23:55:41,918 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE INDEX "sym_idx_trigg_hist_1" ON "sym_trigger_hist" ("trigger_id", "inactive_time") 2021-03-29 23:55:41,928 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_trigger_router"( "trigger_id" VARCHAR NOT NULL, "router_id" VARCHAR NOT NULL, "enabled" INTEGER DEFAULT (1) NOT NULL, "initial_load_order" INTEGER DEFAULT (1) NOT NULL, "initial_load_select" VARCHAR, "initial_load_delete_stmt" VARCHAR, "ping_back_enabled" INTEGER DEFAULT (0) NOT NULL, "create_time" TIMESTAMP NOT NULL, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP NOT NULL, "description" VARCHAR, PRIMARY KEY ("trigger_id", "router_id"), FOREIGN KEY ("trigger_id") REFERENCES "sym_trigger" ("trigger_id"), FOREIGN KEY ("router_id") REFERENCES "sym_router" ("router_id") ) 2021-03-29 23:55:41,939 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] DDL applied: CREATE TABLE "sym_trigger_router_grouplet"( "grouplet_id" VARCHAR NOT NULL, "trigger_id" VARCHAR NOT NULL, "router_id" VARCHAR NOT NULL, "applies_when" VARCHAR NOT NULL, "create_time" TIMESTAMP NOT NULL, "last_update_by" VARCHAR, "last_update_time" TIMESTAMP NOT NULL, PRIMARY KEY ("grouplet_id", "trigger_id", "router_id", "applies_when"), FOREIGN KEY ("grouplet_id") REFERENCES "sym_grouplet" ("grouplet_id"), FOREIGN KEY ("trigger_id", "router_id") REFERENCES "sym_trigger_router" ("trigger_id", "router_id") ) 2021-03-29 23:55:41,939 INFO [node-001] [ClusterService] [symmetric-engine-startup-2] This node picked a server id of LAPTOP-UQHGHI89 2021-03-29 23:55:41,940 INFO [node-001] [TriggerRouterService] [symmetric-engine-startup-2] Synchronizing triggers 2021-03-29 23:55:41,943 INFO [node-001] [TriggerRouterService] [symmetric-engine-startup-2] Done synchronizing triggers 2021-03-29 23:55:41,944 INFO [node-001] [SqliteJdbcSymmetricDialect] [symmetric-engine-startup-2] Done with auto update of SymmetricDS tables 2021-03-29 23:55:41,947 INFO [node-001] [ConfigurationService] [symmetric-engine-startup-2] Auto-configuring config channel 2021-03-29 23:55:41,958 INFO [node-001] [ConfigurationService] [symmetric-engine-startup-2] Auto-configuring reload channel 2021-03-29 23:55:41,969 INFO [node-001] [ConfigurationService] [symmetric-engine-startup-2] Auto-configuring monitor channel 2021-03-29 23:55:41,979 INFO [node-001] [ConfigurationService] [symmetric-engine-startup-2] Auto-configuring heartbeat channel 2021-03-29 23:55:41,990 INFO [node-001] [ConfigurationService] [symmetric-engine-startup-2] Auto-configuring default channel 2021-03-29 23:55:42,000 INFO [node-001] [ConfigurationService] [symmetric-engine-startup-2] Auto-configuring dynamic channel 2021-03-29 23:55:42,060 INFO [node-001] [ExtensionService] [symmetric-engine-startup-2] Found 0 extension points from the database that will be registered 2021-03-29 23:55:42,061 INFO [node-001] [ClientExtensionService] [symmetric-engine-startup-2] Found 8 extension points from spring that will be registered 2021-03-29 23:55:42,063 INFO [node-001] [AbstractSymmetricEngine] [symmetric-engine-startup-2] Done initializing SymmetricDS database 2021-03-29 23:55:42,064 INFO [node-001] [AbstractSymmetricEngine] [symmetric-engine-startup-2] SymmetricDS database version : null 2021-03-29 23:55:42,064 INFO [node-001] [AbstractSymmetricEngine] [symmetric-engine-startup-2] SymmetricDS software version : 3.12.7 2021-03-29 23:55:42,070 INFO [node-001] [AbstractSymmetricEngine] [symmetric-engine-startup-2] Starting unregistered node [group=node, externalId=001] 2021-03-29 23:55:42,074 INFO [node-001] [RouterJob] [symmetric-engine-startup-2] Starting Routing on periodic schedule: every 5000ms with the first run at 2021-03-29T23:55:49.440+0100 2021-03-29 23:55:42,075 INFO [node-001] [PushJob] [symmetric-engine-startup-2] Starting Push on periodic schedule: every 10000ms with the first run at 2021-03-29T23:55:49.441+0100 2021-03-29 23:55:42,076 INFO [node-001] [PullJob] [symmetric-engine-startup-2] Starting Pull on periodic schedule: every 10000ms with the first run at 2021-03-29T23:55:49.441+0100 2021-03-29 23:55:42,076 INFO [node-001] [JobManager] [symmetric-engine-startup-2] Job Offline Push not configured for auto start 2021-03-29 23:55:42,077 INFO [node-001] [JobManager] [symmetric-engine-startup-2] Job Offline Pull not configured for auto start 2021-03-29 23:55:42,077 INFO [node-001] [OutgoingPurgeJob] [symmetric-engine-startup-2] Starting job 'Purge Outgoing' with cron expression: '0 0 */4 * * *' 2021-03-29 23:55:42,078 INFO [node-001] [IncomingPurgeJob] [symmetric-engine-startup-2] Starting job 'Purge Incoming' with cron expression: '0 0 */4 * * *' 2021-03-29 23:55:42,080 INFO [node-001] [StatisticFlushJob] [symmetric-engine-startup-2] Starting job 'Stat Flush' with cron expression: '0 0/5 * * * *' 2021-03-29 23:55:42,081 INFO [node-001] [SyncTriggersJob] [symmetric-engine-startup-2] Starting job 'SyncTriggers' with cron expression: '0 0 0 * * *' 2021-03-29 23:55:42,082 INFO [node-001] [HeartbeatJob] [symmetric-engine-startup-2] Starting Heartbeat on periodic schedule: every 900000ms with the first run at 2021-03-29T23:55:49.447+0100 2021-03-29 23:55:42,082 INFO [node-001] [WatchdogJob] [symmetric-engine-startup-2] Starting Watchdog on periodic schedule: every 3600000ms with the first run at 2021-03-29T23:55:49.448+0100 2021-03-29 23:55:42,084 INFO [node-001] [StageManagementJob] [symmetric-engine-startup-2] Starting job 'Stage Management' with cron expression: '0 0 * * * *' 2021-03-29 23:55:42,084 INFO [node-001] [JobManager] [symmetric-engine-startup-2] Job Refresh Cache not configured for auto start 2021-03-29 23:55:42,085 INFO [node-001] [JobManager] [symmetric-engine-startup-2] Job File Sync Tracker not configured for auto start 2021-03-29 23:55:42,085 INFO [node-001] [JobManager] [symmetric-engine-startup-2] Job File Sync Pull not configured for auto start 2021-03-29 23:55:42,086 INFO [node-001] [JobManager] [symmetric-engine-startup-2] Job File Sync Push not configured for auto start 2021-03-29 23:55:42,087 INFO [node-001] [InitialLoadExtractorJob] [symmetric-engine-startup-2] Starting Initial Load Extract on periodic schedule: every 10000ms with the first run at 2021-03-29T23:55:49.453+0100 2021-03-29 23:55:42,087 INFO [node-001] [MonitorJob] [symmetric-engine-startup-2] Starting Monitor on periodic schedule: every 60000ms with the first run at 2021-03-29T23:55:49.453+0100 2021-03-29 23:55:42,090 INFO [node-001] [JobManager] [symmetric-engine-startup-2] Job Report Status not configured for auto start 2021-03-29 23:55:42,092 INFO [node-001] [JobManager] [symmetric-engine-startup-2] Job Log Miner not configured for auto start 2021-03-29 23:55:42,093 INFO [node-001] [InitialLoadJob] [symmetric-engine-startup-2] Starting Initial Load Queue on periodic schedule: every 10000ms with the first run at 2021-03-29T23:55:49.459+0100 2021-03-29 23:55:42,094 INFO [node-001] [AbstractSymmetricEngine] [symmetric-engine-startup-2] SymmetricDS Node STARTED: nodeId=001 groupId=node type=server subType=null name=node-001 softwareVersion=3.12.7 databaseName=SQLite databaseVersion=3.32 driverName=SQLite JDBC driverVersion=3.32.3.2 uptime=0 sec. 2021-03-29 23:55:42,261 INFO [node-002] [RouterJob] [node-002-job-1] Did not run the 'Routing' job because the engine is not registered. 2021-03-29 23:55:42,263 INFO [node-002] [PushJob] [node-002-job-1] Did not run the 'Push' job because the engine is not registered. 2021-03-29 23:55:42,274 INFO [node-002] [RegistrationService] [node-002-job-14] This node is unregistered. It will attempt to register using the registration.url 2021-03-29 23:55:42,322 INFO [node-002] [InitialLoadExtractorJob] [node-002-job-4] Did not run the 'Initial Load Extract' job because the engine is not registered. 2021-03-29 23:55:42,322 INFO [node-002] [MonitorJob] [node-002-job-5] Did not run the 'Monitor' job because the engine is not registered. 2021-03-29 23:55:42,325 INFO [node-002] [InitialLoadJob] [node-002-job-18] Did not run the 'Initial Load Queue' job because the engine is not registered. 2021-03-29 23:55:42,572 INFO [node-002] [DataLoaderService] [node-002-job-14] Using registration URL of http://localhost:31415/sync/master-000/registration 2021-03-29 23:55:42,678 INFO [?] [SymmetricServlet] [qtp647973805-18] Requests for engine master-000 are being rejected because nodes are still initializing 2021-03-29 23:55:42,696 WARN [node-002] [RegistrationService] [node-002-job-14] Unable to register with server because the service is not available. It may be starting up. 2021-03-29 23:55:42,698 INFO [node-002] [RegistrationService] [node-002-job-14] Could not register. Sleeping for 20000ms before attempting again. 2021-03-29 23:55:44,108 INFO [master-000] [MySqlSymmetricDialect] [symmetric-engine-startup-1] The DbDialect being used is org.jumpmind.symmetric.db.mysql.MySqlSymmetricDialect 2021-03-29 23:55:45,381 INFO [master-000] [ExtensionService] [symmetric-engine-startup-1] Found 0 extension points from the database that will be registered 2021-03-29 23:55:45,384 INFO [master-000] [StagingManager] [symmetric-engine-startup-1] The staging directory was initialized at the following location: C:\Users\matth\OneDrive - University of Sussex\University of Sussex\Final Year Project\symmetric-server-3.12.7-SQLiteTest\symmetric-server-3.12.7\tmp\master-000 2021-03-29 23:55:46,124 INFO [master-000] [ExtensionService] [symmetric-engine-startup-1] Found 0 extension points from the database that will be registered 2021-03-29 23:55:46,125 INFO [master-000] [ClientExtensionService] [symmetric-engine-startup-1] Found 8 extension points from spring that will be registered 2021-03-29 23:55:46,127 INFO [master-000] [AbstractSymmetricEngine] [symmetric-engine-startup-1] Initializing SymmetricDS database 2021-03-29 23:55:46,228 INFO [master-000] [MySqlSymmetricDialect] [symmetric-engine-startup-1] Checking if SymmetricDS tables need created or altered 2021-03-29 23:55:49,447 INFO [node-001] [RouterJob] [node-001-job-1] Did not run the 'Routing' job because the engine is not registered. 2021-03-29 23:55:49,456 INFO [node-001] [RegistrationService] [node-001-job-2] This node is unregistered. It will attempt to register using the registration.url 2021-03-29 23:55:49,463 INFO [node-001] [PushJob] [node-001-job-3] Did not run the 'Push' job because the engine is not registered. 2021-03-29 23:55:49,464 INFO [node-001] [InitialLoadExtractorJob] [node-001-job-6] Did not run the 'Initial Load Extract' job because the engine is not registered. 2021-03-29 23:55:49,464 INFO [node-001] [MonitorJob] [node-001-job-5] Did not run the 'Monitor' job because the engine is not registered. 2021-03-29 23:55:49,479 INFO [node-001] [InitialLoadJob] [node-001-job-7] Did not run the 'Initial Load Queue' job because the engine is not registered. 2021-03-29 23:55:49,717 INFO [node-001] [DataLoaderService] [node-001-job-2] Using registration URL of http://localhost:31415/sync/master-000/registration 2021-03-29 23:55:49,722 INFO [master-000] [SymmetricServlet] [qtp647973805-19] Requests for engine master-000 are being rejected while it is starting 2021-03-29 23:55:49,724 WARN [node-001] [RegistrationService] [node-001-job-2] Unable to register with server because the service is not available. It may be starting up. 2021-03-29 23:55:49,725 INFO [node-001] [RegistrationService] [node-001-job-2] Could not register. Sleeping for 6000ms before attempting again. 2021-03-29 23:55:55,730 INFO [node-001] [RegistrationService] [node-001-job-2] This node is unregistered. It will attempt to register using the registration.url 2021-03-29 23:55:56,024 INFO [node-001] [DataLoaderService] [node-001-job-2] Using registration URL of http://localhost:31415/sync/master-000/registration 2021-03-29 23:55:56,030 WARN [node-001] [RegistrationService] [node-001-job-2] Unable to register with server because the service is not available. It may be starting up. 2021-03-29 23:55:56,031 INFO [node-001] [RegistrationService] [node-001-job-2] Could not register. Sleeping for 17000ms before attempting again. 2021-03-29 23:56:02,709 INFO [node-002] [RegistrationService] [node-002-job-14] This node is unregistered. It will attempt to register using the registration.url 2021-03-29 23:56:02,979 INFO [node-002] [DataLoaderService] [node-002-job-14] Using registration URL of http://localhost:31415/sync/master-000/registration 2021-03-29 23:56:02,985 WARN [node-002] [RegistrationService] [node-002-job-14] Unable to register with server because the service is not available. It may be starting up. 2021-03-29 23:56:02,986 INFO [node-002] [RegistrationService] [node-002-job-14] Could not register. Sleeping for 1000ms before attempting again. 2021-03-29 23:56:04,002 INFO [node-002] [RegistrationService] [node-002-job-14] This node is unregistered. It will attempt to register using the registration.url 2021-03-29 23:56:04,221 INFO [node-002] [DataLoaderService] [node-002-job-14] Using registration URL of http://localhost:31415/sync/master-000/registration 2021-03-29 23:56:04,227 WARN [node-002] [RegistrationService] [node-002-job-14] Unable to register with server because the service is not available. It may be starting up. 2021-03-29 23:56:04,228 INFO [node-002] [RegistrationService] [node-002-job-14] Could not register. Sleeping for 13000ms before attempting again. 2021-03-29 23:56:13,040 INFO [node-001] [RegistrationService] [node-001-job-2] This node is unregistered. It will attempt to register using the registration.url 2021-03-29 23:56:13,272 INFO [node-001] [DataLoaderService] [node-001-job-2] Using registration URL of http://localhost:31415/sync/master-000/registration 2021-03-29 23:56:13,278 WARN [node-001] [RegistrationService] [node-001-job-2] Unable to register with server because the service is not available. It may be starting up. 2021-03-29 23:56:13,279 INFO [node-001] [RegistrationService] [node-001-job-2] Could not register. Sleeping for 9000ms before attempting again. 2021-03-29 23:56:17,237 INFO [node-002] [RegistrationService] [node-002-job-14] This node is unregistered. It will attempt to register using the registration.url 2021-03-29 23:56:17,486 INFO [node-002] [DataLoaderService] [node-002-job-14] Using registration URL of http://localhost:31415/sync/master-000/registration 2021-03-29 23:56:17,491 WARN [node-002] [RegistrationService] [node-002-job-14] Unable to register with server because the service is not available. It may be starting up. 2021-03-29 23:56:17,492 INFO [node-002] [RegistrationService] [node-002-job-14] Could not register. Sleeping for 17000ms before attempting again. 2021-03-29 23:56:21,305 INFO [master-000] [ConfigurationService] [symmetric-engine-startup-1] Auto-configuring config channel 2021-03-29 23:56:21,509 INFO [master-000] [ConfigurationService] [symmetric-engine-startup-1] Auto-configuring reload channel 2021-03-29 23:56:21,705 INFO [master-000] [ConfigurationService] [symmetric-engine-startup-1] Auto-configuring monitor channel 2021-03-29 23:56:21,904 INFO [master-000] [ConfigurationService] [symmetric-engine-startup-1] Auto-configuring heartbeat channel 2021-03-29 23:56:22,111 INFO [master-000] [ConfigurationService] [symmetric-engine-startup-1] Auto-configuring default channel 2021-03-29 23:56:22,295 INFO [node-001] [RegistrationService] [node-001-job-2] This node is unregistered. It will attempt to register using the registration.url 2021-03-29 23:56:22,319 INFO [master-000] [ConfigurationService] [symmetric-engine-startup-1] Auto-configuring dynamic channel 2021-03-29 23:56:22,535 INFO [node-001] [DataLoaderService] [node-001-job-2] Using registration URL of http://localhost:31415/sync/master-000/registration 2021-03-29 23:56:22,541 WARN [node-001] [RegistrationService] [node-001-job-2] Unable to register with server because the service is not available. It may be starting up. 2021-03-29 23:56:22,542 INFO [node-001] [RegistrationService] [node-001-job-2] Could not register. Sleeping for 4000ms before attempting again. 2021-03-29 23:56:26,547 INFO [node-001] [RegistrationService] [node-001-job-2] This node is unregistered. It will attempt to register using the registration.url 2021-03-29 23:56:26,764 INFO [node-001] [DataLoaderService] [node-001-job-2] Using registration URL of http://localhost:31415/sync/master-000/registration 2021-03-29 23:56:27,308 WARN [node-001] [RegistrationService] [node-001-job-2] Unable to register with server because the service is not available. It may be starting up. 2021-03-29 23:56:27,309 INFO [node-001] [RegistrationService] [node-001-job-2] Could not register. Sleeping for 15000ms before attempting again. 2021-03-29 23:56:28,572 INFO [master-000] [ExtensionService] [symmetric-engine-startup-1] Found 0 extension points from the database that will be registered 2021-03-29 23:56:28,572 INFO [master-000] [ClientExtensionService] [symmetric-engine-startup-1] Found 8 extension points from spring that will be registered 2021-03-29 23:56:29,156 INFO [master-000] [AbstractSymmetricEngine] [symmetric-engine-startup-1] Inserting rows for node, security, identity and group for registration server 2021-03-29 23:56:31,867 INFO [master-000] [AbstractSymmetricEngine] [symmetric-engine-startup-1] Done initializing SymmetricDS database 2021-03-29 23:56:31,867 INFO [master-000] [AbstractSymmetricEngine] [symmetric-engine-startup-1] SymmetricDS database version : 3.12.7 2021-03-29 23:56:31,869 INFO [master-000] [AbstractSymmetricEngine] [symmetric-engine-startup-1] SymmetricDS software version : 3.12.7 2021-03-29 23:56:32,461 INFO [master-000] [AbstractSymmetricEngine] [symmetric-engine-startup-1] Starting registered node [group=master, id=000, nodeId=000] 2021-03-29 23:56:32,462 INFO [master-000] [ClusterService] [symmetric-engine-startup-1] This node picked a server id of LAPTOP-UQHGHI89 2021-03-29 23:56:32,464 INFO [master-000] [TriggerRouterService] [symmetric-engine-startup-1] Synchronizing triggers 2021-03-29 23:56:34,505 INFO [node-002] [RegistrationService] [node-002-job-14] This node is unregistered. It will attempt to register using the registration.url 2021-03-29 23:56:34,753 INFO [node-002] [DataLoaderService] [node-002-job-14] Using registration URL of http://localhost:31415/sync/master-000/registration 2021-03-29 23:56:34,758 WARN [node-002] [RegistrationService] [node-002-job-14] Unable to register with server because the service is not available. It may be starting up. 2021-03-29 23:56:34,759 INFO [node-002] [RegistrationService] [node-002-job-14] Could not register. Sleeping for 2000ms before attempting again. 2021-03-29 23:56:36,771 INFO [node-002] [RegistrationService] [node-002-job-14] This node is unregistered. It will attempt to register using the registration.url 2021-03-29 23:56:37,051 INFO [node-002] [DataLoaderService] [node-002-job-14] Using registration URL of http://localhost:31415/sync/master-000/registration 2021-03-29 23:56:37,056 WARN [node-002] [RegistrationService] [node-002-job-14] Unable to register with server because the service is not available. It may be starting up. 2021-03-29 23:56:37,057 INFO [node-002] [RegistrationService] [node-002-job-14] Could not register. Sleeping for 7000ms before attempting again. 2021-03-29 23:56:40,775 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_RTR_MSTR trigger for swimDB.sym_router 2021-03-29 23:56:41,284 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_RTR_MSTR trigger for swimDB.sym_router 2021-03-29 23:56:41,786 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_RTR_MSTR trigger for swimDB.sym_router 2021-03-29 23:56:42,323 INFO [node-001] [RegistrationService] [node-001-job-2] This node is unregistered. It will attempt to register using the registration.url 2021-03-29 23:56:42,582 INFO [node-001] [DataLoaderService] [node-001-job-2] Using registration URL of http://localhost:31415/sync/master-000/registration 2021-03-29 23:56:42,588 WARN [node-001] [RegistrationService] [node-001-job-2] Unable to register with server because the service is not available. It may be starting up. 2021-03-29 23:56:42,588 INFO [node-001] [RegistrationService] [node-001-job-2] Could not register. Sleeping for 18000ms before attempting again. 2021-03-29 23:56:44,062 INFO [node-002] [RegistrationService] [node-002-job-14] This node is unregistered. It will attempt to register using the registration.url 2021-03-29 23:56:44,289 INFO [node-002] [DataLoaderService] [node-002-job-14] Using registration URL of http://localhost:31415/sync/master-000/registration 2021-03-29 23:56:44,295 WARN [node-002] [RegistrationService] [node-002-job-14] Unable to register with server because the service is not available. It may be starting up. 2021-03-29 23:56:44,296 INFO [node-002] [RegistrationService] [node-002-job-14] Could not register. Sleeping for 24000ms before attempting again. 2021-03-29 23:56:47,765 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_TRNSFRM_TBL_MSTR trigger for swimDB.sym_transform_table 2021-03-29 23:56:48,282 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_TRNSFRM_TBL_MSTR trigger for swimDB.sym_transform_table 2021-03-29 23:56:48,800 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_TRNSFRM_TBL_MSTR trigger for swimDB.sym_transform_table 2021-03-29 23:56:52,170 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_I_FOR_MT_MSTR trigger for swimDB.Meet 2021-03-29 23:56:52,678 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_U_FOR_MT_MSTR trigger for swimDB.Meet 2021-03-29 23:56:53,194 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_D_FOR_MT_MSTR trigger for swimDB.Meet 2021-03-29 23:56:56,106 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_PRMTR_MSTR trigger for swimDB.sym_parameter 2021-03-29 23:56:56,617 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_PRMTR_MSTR trigger for swimDB.sym_parameter 2021-03-29 23:56:57,139 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_PRMTR_MSTR trigger for swimDB.sym_parameter 2021-03-29 23:57:00,070 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_FL_TRGGR_RTR_MSTR trigger for swimDB.sym_file_trigger_router 2021-03-29 23:57:00,574 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_FL_TRGGR_RTR_MSTR trigger for swimDB.sym_file_trigger_router 2021-03-29 23:57:00,601 INFO [node-001] [RegistrationService] [node-001-job-2] This node is unregistered. It will attempt to register using the registration.url 2021-03-29 23:57:00,785 INFO [node-001] [DataLoaderService] [node-001-job-2] Using registration URL of http://localhost:31415/sync/master-000/registration 2021-03-29 23:57:00,789 WARN [node-001] [RegistrationService] [node-001-job-2] Unable to register with server because the service is not available. It may be starting up. 2021-03-29 23:57:00,790 INFO [node-001] [RegistrationService] [node-001-job-2] Could not register. Sleeping for 2000ms before attempting again. 2021-03-29 23:57:01,089 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_FL_TRGGR_RTR_MSTR trigger for swimDB.sym_file_trigger_router 2021-03-29 23:57:02,802 INFO [node-001] [RegistrationService] [node-001-job-2] This node is unregistered. It will attempt to register using the registration.url 2021-03-29 23:57:02,980 INFO [node-001] [DataLoaderService] [node-001-job-2] Using registration URL of http://localhost:31415/sync/master-000/registration 2021-03-29 23:57:02,985 WARN [node-001] [RegistrationService] [node-001-job-2] Unable to register with server because the service is not available. It may be starting up. 2021-03-29 23:57:02,986 INFO [node-001] [RegistrationService] [node-001-job-2] Could not register. Sleeping for 17000ms before attempting again. 2021-03-29 23:57:04,221 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_TBL_RLD_RQST_MSTR trigger for swimDB.sym_table_reload_request 2021-03-29 23:57:04,750 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_TBL_RLD_RQST_MSTR trigger for swimDB.sym_table_reload_request 2021-03-29 23:57:05,273 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_TBL_RLD_RQST_MSTR trigger for swimDB.sym_table_reload_request 2021-03-29 23:57:08,302 INFO [node-002] [RegistrationService] [node-002-job-14] This node is unregistered. It will attempt to register using the registration.url 2021-03-29 23:57:08,499 INFO [node-002] [DataLoaderService] [node-002-job-14] Using registration URL of http://localhost:31415/sync/master-000/registration 2021-03-29 23:57:08,504 WARN [node-002] [RegistrationService] [node-002-job-14] Unable to register with server because the service is not available. It may be starting up. 2021-03-29 23:57:08,505 INFO [node-002] [RegistrationService] [node-002-job-14] Could not register. Sleeping for 18000ms before attempting again. 2021-03-29 23:57:12,425 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_GRPLT_LNK_MSTR trigger for swimDB.sym_grouplet_link 2021-03-29 23:57:12,934 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_GRPLT_LNK_MSTR trigger for swimDB.sym_grouplet_link 2021-03-29 23:57:13,431 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_GRPLT_LNK_MSTR trigger for swimDB.sym_grouplet_link 2021-03-29 23:57:16,280 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_GRPLT_MSTR trigger for swimDB.sym_grouplet 2021-03-29 23:57:16,790 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_GRPLT_MSTR trigger for swimDB.sym_grouplet 2021-03-29 23:57:17,304 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_GRPLT_MSTR trigger for swimDB.sym_grouplet 2021-03-29 23:57:19,996 INFO [node-001] [RegistrationService] [node-001-job-2] This node is unregistered. It will attempt to register using the registration.url 2021-03-29 23:57:20,191 INFO [node-001] [DataLoaderService] [node-001-job-2] Using registration URL of http://localhost:31415/sync/master-000/registration 2021-03-29 23:57:20,195 WARN [node-001] [RegistrationService] [node-001-job-2] Unable to register with server because the service is not available. It may be starting up. 2021-03-29 23:57:20,196 INFO [node-001] [RegistrationService] [node-001-job-2] Could not register. Sleeping for 5000ms before attempting again. 2021-03-29 23:57:23,367 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_FL_TRGGR_MSTR trigger for swimDB.sym_file_trigger 2021-03-29 23:57:23,871 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_FL_TRGGR_MSTR trigger for swimDB.sym_file_trigger 2021-03-29 23:57:24,388 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_FL_TRGGR_MSTR trigger for swimDB.sym_file_trigger 2021-03-29 23:57:25,204 INFO [node-001] [RegistrationService] [node-001-job-2] This node is unregistered. It will attempt to register using the registration.url 2021-03-29 23:57:25,386 INFO [node-001] [DataLoaderService] [node-001-job-2] Using registration URL of http://localhost:31415/sync/master-000/registration 2021-03-29 23:57:25,390 WARN [node-001] [RegistrationService] [node-001-job-2] Unable to register with server because the service is not available. It may be starting up. 2021-03-29 23:57:25,391 INFO [node-001] [RegistrationService] [node-001-job-2] Could not register. Sleeping for 28000ms before attempting again. 2021-03-29 23:57:26,517 INFO [node-002] [RegistrationService] [node-002-job-14] This node is unregistered. It will attempt to register using the registration.url 2021-03-29 23:57:26,711 INFO [node-002] [DataLoaderService] [node-002-job-14] Using registration URL of http://localhost:31415/sync/master-000/registration 2021-03-29 23:57:26,716 WARN [node-002] [RegistrationService] [node-002-job-14] Unable to register with server because the service is not available. It may be starting up. 2021-03-29 23:57:26,716 INFO [node-002] [RegistrationService] [node-002-job-14] Could not register. Sleeping for 13000ms before attempting again. 2021-03-29 23:57:27,391 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_TRNSFRM_CLMN_MSTR trigger for swimDB.sym_transform_column 2021-03-29 23:57:27,900 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_TRNSFRM_CLMN_MSTR trigger for swimDB.sym_transform_column 2021-03-29 23:57:28,441 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_TRNSFRM_CLMN_MSTR trigger for swimDB.sym_transform_column 2021-03-29 23:57:31,650 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_I_FOR_VNTS_MSTR trigger for swimDB.Events 2021-03-29 23:57:32,185 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_U_FOR_VNTS_MSTR trigger for swimDB.Events 2021-03-29 23:57:32,698 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_D_FOR_VNTS_MSTR trigger for swimDB.Events 2021-03-29 23:57:35,647 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_JB_MSTR trigger for swimDB.sym_job 2021-03-29 23:57:36,157 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_JB_MSTR trigger for swimDB.sym_job 2021-03-29 23:57:36,666 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_JB_MSTR trigger for swimDB.sym_job 2021-03-29 23:57:39,720 INFO [node-002] [RegistrationService] [node-002-job-14] This node is unregistered. It will attempt to register using the registration.url 2021-03-29 23:57:39,824 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_TRGGR_RTR_MSTR trigger for swimDB.sym_trigger_router 2021-03-29 23:57:39,951 INFO [node-002] [DataLoaderService] [node-002-job-14] Using registration URL of http://localhost:31415/sync/master-000/registration 2021-03-29 23:57:39,956 WARN [node-002] [RegistrationService] [node-002-job-14] Unable to register with server because the service is not available. It may be starting up. 2021-03-29 23:57:39,957 INFO [node-002] [RegistrationService] [node-002-job-14] Could not register. Sleeping for 19000ms before attempting again. 2021-03-29 23:57:40,349 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_TRGGR_RTR_MSTR trigger for swimDB.sym_trigger_router 2021-03-29 23:57:40,900 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_TRGGR_RTR_MSTR trigger for swimDB.sym_trigger_router 2021-03-29 23:57:43,727 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_ND_MSTR trigger for swimDB.sym_node 2021-03-29 23:57:44,239 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_ND_MSTR trigger for swimDB.sym_node 2021-03-29 23:57:44,759 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_ND_MSTR trigger for swimDB.sym_node 2021-03-29 23:57:48,238 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_I_FOR_SWMMRS_MSTR trigger for swimDB.Swimmers 2021-03-29 23:57:48,738 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_U_FOR_SWMMRS_MSTR trigger for swimDB.Swimmers 2021-03-29 23:57:49,248 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_D_FOR_SWMMRS_MSTR trigger for swimDB.Swimmers 2021-03-29 23:57:52,215 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_I_FOR_SSSNS_MSTR trigger for swimDB.Sessions 2021-03-29 23:57:52,732 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_U_FOR_SSSNS_MSTR trigger for swimDB.Sessions 2021-03-29 23:57:53,242 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_D_FOR_SSSNS_MSTR trigger for swimDB.Sessions 2021-03-29 23:57:53,403 INFO [node-001] [RegistrationService] [node-001-job-2] This node is unregistered. It will attempt to register using the registration.url 2021-03-29 23:57:53,581 INFO [node-001] [DataLoaderService] [node-001-job-2] Using registration URL of http://localhost:31415/sync/master-000/registration 2021-03-29 23:57:53,586 WARN [node-001] [RegistrationService] [node-001-job-2] Unable to register with server because the service is not available. It may be starting up. 2021-03-29 23:57:53,587 INFO [node-001] [RegistrationService] [node-001-job-2] Could not register. Sleeping for 22000ms before attempting again. 2021-03-29 23:57:56,099 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_ND_GRP_CHNNL_WND_MSTR trigger for swimDB.sym_node_group_channel_wnd 2021-03-29 23:57:56,599 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_ND_GRP_CHNNL_WND_MSTR trigger for swimDB.sym_node_group_channel_wnd 2021-03-29 23:57:57,102 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_ND_GRP_CHNNL_WND_MSTR trigger for swimDB.sym_node_group_channel_wnd 2021-03-29 23:57:58,958 INFO [node-002] [RegistrationService] [node-002-job-14] This node is unregistered. It will attempt to register using the registration.url 2021-03-29 23:57:59,153 INFO [node-002] [DataLoaderService] [node-002-job-14] Using registration URL of http://localhost:31415/sync/master-000/registration 2021-03-29 23:57:59,157 WARN [node-002] [RegistrationService] [node-002-job-14] Unable to register with server because the service is not available. It may be starting up. 2021-03-29 23:57:59,157 INFO [node-002] [RegistrationService] [node-002-job-14] Could not register. Sleeping for 9000ms before attempting again. 2021-03-29 23:58:00,032 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_NTFCTN_MSTR trigger for swimDB.sym_notification 2021-03-29 23:58:00,531 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_NTFCTN_MSTR trigger for swimDB.sym_notification 2021-03-29 23:58:01,041 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_NTFCTN_MSTR trigger for swimDB.sym_notification 2021-03-29 23:58:03,970 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_ND_GRP_LNK_MSTR trigger for swimDB.sym_node_group_link 2021-03-29 23:58:04,487 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_ND_GRP_LNK_MSTR trigger for swimDB.sym_node_group_link 2021-03-29 23:58:04,993 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_ND_GRP_LNK_MSTR trigger for swimDB.sym_node_group_link 2021-03-29 23:58:07,852 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_ND_GRP_MSTR trigger for swimDB.sym_node_group 2021-03-29 23:58:08,162 INFO [node-002] [RegistrationService] [node-002-job-14] This node is unregistered. It will attempt to register using the registration.url 2021-03-29 23:58:08,340 INFO [node-002] [DataLoaderService] [node-002-job-14] Using registration URL of http://localhost:31415/sync/master-000/registration 2021-03-29 23:58:08,345 WARN [node-002] [RegistrationService] [node-002-job-14] Unable to register with server because the service is not available. It may be starting up. 2021-03-29 23:58:08,346 INFO [node-002] [RegistrationService] [node-002-job-14] Could not register. Sleeping for 6000ms before attempting again. 2021-03-29 23:58:08,371 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_ND_GRP_MSTR trigger for swimDB.sym_node_group 2021-03-29 23:58:08,877 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_ND_GRP_MSTR trigger for swimDB.sym_node_group 2021-03-29 23:58:11,719 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_I_FOR_QLFYNG_TMS_MSTR trigger for swimDB.Qualifying_Times 2021-03-29 23:58:12,218 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_U_FOR_QLFYNG_TMS_MSTR trigger for swimDB.Qualifying_Times 2021-03-29 23:58:12,729 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_D_FOR_QLFYNG_TMS_MSTR trigger for swimDB.Qualifying_Times 2021-03-29 23:58:14,349 INFO [node-002] [RegistrationService] [node-002-job-14] This node is unregistered. It will attempt to register using the registration.url 2021-03-29 23:58:14,536 INFO [node-002] [DataLoaderService] [node-002-job-14] Using registration URL of http://localhost:31415/sync/master-000/registration 2021-03-29 23:58:14,540 WARN [node-002] [RegistrationService] [node-002-job-14] Unable to register with server because the service is not available. It may be starting up. 2021-03-29 23:58:14,541 INFO [node-002] [RegistrationService] [node-002-job-14] Could not register. Sleeping for 9000ms before attempting again. 2021-03-29 23:58:15,560 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_ND_SCRTY_MSTR trigger for swimDB.sym_node_security 2021-03-29 23:58:15,597 INFO [node-001] [RegistrationService] [node-001-job-2] This node is unregistered. It will attempt to register using the registration.url 2021-03-29 23:58:15,796 INFO [node-001] [DataLoaderService] [node-001-job-2] Using registration URL of http://localhost:31415/sync/master-000/registration 2021-03-29 23:58:15,801 WARN [node-001] [RegistrationService] [node-001-job-2] Unable to register with server because the service is not available. It may be starting up. 2021-03-29 23:58:15,801 INFO [node-001] [RegistrationService] [node-001-job-2] Could not register. Sleeping for 23000ms before attempting again. 2021-03-29 23:58:16,071 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_ND_SCRTY_MSTR trigger for swimDB.sym_node_security 2021-03-29 23:58:16,583 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_ND_SCRTY_MSTR trigger for swimDB.sym_node_security 2021-03-29 23:58:20,040 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_LD_FLTR_MSTR trigger for swimDB.sym_load_filter 2021-03-29 23:58:20,552 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_LD_FLTR_MSTR trigger for swimDB.sym_load_filter 2021-03-29 23:58:21,062 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_LD_FLTR_MSTR trigger for swimDB.sym_load_filter 2021-03-29 23:58:23,549 INFO [node-002] [RegistrationService] [node-002-job-14] This node is unregistered. It will attempt to register using the registration.url 2021-03-29 23:58:23,735 INFO [node-002] [DataLoaderService] [node-002-job-14] Using registration URL of http://localhost:31415/sync/master-000/registration 2021-03-29 23:58:23,740 WARN [node-002] [RegistrationService] [node-002-job-14] Unable to register with server because the service is not available. It may be starting up. 2021-03-29 23:58:23,741 INFO [node-002] [RegistrationService] [node-002-job-14] Could not register. Sleeping for 11000ms before attempting again. 2021-03-29 23:58:24,032 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_MNTR_MSTR trigger for swimDB.sym_monitor 2021-03-29 23:58:24,534 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_MNTR_MSTR trigger for swimDB.sym_monitor 2021-03-29 23:58:25,042 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_MNTR_MSTR trigger for swimDB.sym_monitor 2021-03-29 23:58:28,023 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_XTNSN_MSTR trigger for swimDB.sym_extension 2021-03-29 23:58:28,530 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_XTNSN_MSTR trigger for swimDB.sym_extension 2021-03-29 23:58:29,050 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_XTNSN_MSTR trigger for swimDB.sym_extension 2021-03-29 23:58:31,996 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_CNFLCT_MSTR trigger for swimDB.sym_conflict 2021-03-29 23:58:32,544 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_CNFLCT_MSTR trigger for swimDB.sym_conflict 2021-03-29 23:58:33,049 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_CNFLCT_MSTR trigger for swimDB.sym_conflict 2021-03-29 23:58:34,753 INFO [node-002] [RegistrationService] [node-002-job-14] This node is unregistered. It will attempt to register using the registration.url 2021-03-29 23:58:34,943 INFO [node-002] [DataLoaderService] [node-002-job-14] Using registration URL of http://localhost:31415/sync/master-000/registration 2021-03-29 23:58:34,947 WARN [node-002] [RegistrationService] [node-002-job-14] Unable to register with server because the service is not available. It may be starting up. 2021-03-29 23:58:34,948 INFO [node-002] [RegistrationService] [node-002-job-14] Could not register. Sleeping for 4000ms before attempting again. 2021-03-29 23:58:37,448 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_TRGGR_MSTR trigger for swimDB.sym_trigger 2021-03-29 23:58:37,986 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_TRGGR_MSTR trigger for swimDB.sym_trigger 2021-03-29 23:58:38,502 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_TRGGR_MSTR trigger for swimDB.sym_trigger 2021-03-29 23:58:38,803 INFO [node-001] [RegistrationService] [node-001-job-2] This node is unregistered. It will attempt to register using the registration.url 2021-03-29 23:58:38,961 INFO [node-002] [RegistrationService] [node-002-job-14] This node is unregistered. It will attempt to register using the registration.url 2021-03-29 23:58:38,995 INFO [node-001] [DataLoaderService] [node-001-job-2] Using registration URL of http://localhost:31415/sync/master-000/registration 2021-03-29 23:58:39,000 WARN [node-001] [RegistrationService] [node-001-job-2] Unable to register with server because the service is not available. It may be starting up. 2021-03-29 23:58:39,001 INFO [node-001] [RegistrationService] [node-001-job-2] Could not register. Sleeping for 4000ms before attempting again. 2021-03-29 23:58:39,160 INFO [node-002] [DataLoaderService] [node-002-job-14] Using registration URL of http://localhost:31415/sync/master-000/registration 2021-03-29 23:58:39,165 WARN [node-002] [RegistrationService] [node-002-job-14] Unable to register with server because the service is not available. It may be starting up. 2021-03-29 23:58:39,166 INFO [node-002] [RegistrationService] [node-002-job-14] Could not register. Sleeping for 4000ms before attempting again. 2021-03-29 23:58:41,373 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_CHNNL_MSTR trigger for swimDB.sym_channel 2021-03-29 23:58:41,884 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_CHNNL_MSTR trigger for swimDB.sym_channel 2021-03-29 23:58:42,401 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_CHNNL_MSTR trigger for swimDB.sym_channel 2021-03-29 23:58:43,008 INFO [node-001] [RegistrationService] [node-001-job-2] This node is unregistered. It will attempt to register using the registration.url 2021-03-29 23:58:43,167 INFO [node-002] [RegistrationService] [node-002-job-14] This node is unregistered. It will attempt to register using the registration.url 2021-03-29 23:58:43,224 INFO [node-001] [DataLoaderService] [node-001-job-2] Using registration URL of http://localhost:31415/sync/master-000/registration 2021-03-29 23:58:43,229 WARN [node-001] [RegistrationService] [node-001-job-2] Unable to register with server because the service is not available. It may be starting up. 2021-03-29 23:58:43,230 INFO [node-001] [RegistrationService] [node-001-job-2] Could not register. Sleeping for 20000ms before attempting again. 2021-03-29 23:58:43,383 INFO [node-002] [DataLoaderService] [node-002-job-14] Using registration URL of http://localhost:31415/sync/master-000/registration 2021-03-29 23:58:43,387 WARN [node-002] [RegistrationService] [node-002-job-14] Unable to register with server because the service is not available. It may be starting up. 2021-03-29 23:58:43,388 INFO [node-002] [RegistrationService] [node-002-job-14] Could not register. Sleeping for 1000ms before attempting again. 2021-03-29 23:58:44,398 INFO [node-002] [RegistrationService] [node-002-job-14] This node is unregistered. It will attempt to register using the registration.url 2021-03-29 23:58:44,597 INFO [node-002] [DataLoaderService] [node-002-job-14] Using registration URL of http://localhost:31415/sync/master-000/registration 2021-03-29 23:58:44,601 WARN [node-002] [RegistrationService] [node-002-job-14] Unable to register with server because the service is not available. It may be starting up. 2021-03-29 23:58:44,602 INFO [node-002] [RegistrationService] [node-002-job-14] Could not register. Sleeping for 16000ms before attempting again. 2021-03-29 23:58:45,457 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_I_FOR_CLBS_MSTR trigger for swimDB.Clubs 2021-03-29 23:58:45,965 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_U_FOR_CLBS_MSTR trigger for swimDB.Clubs 2021-03-29 23:58:46,467 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_D_FOR_CLBS_MSTR trigger for swimDB.Clubs 2021-03-29 23:58:49,321 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_TRGGR_RTR_GRPLT_MSTR trigger for swimDB.sym_trigger_router_grouplet 2021-03-29 23:58:49,837 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_TRGGR_RTR_GRPLT_MSTR trigger for swimDB.sym_trigger_router_grouplet 2021-03-29 23:58:50,340 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_TRGGR_RTR_GRPLT_MSTR trigger for swimDB.sym_trigger_router_grouplet 2021-03-29 23:58:53,208 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_ND_HST_MSTR trigger for swimDB.sym_node_host 2021-03-29 23:58:53,736 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_ND_HST_MSTR trigger for swimDB.sym_node_host 2021-03-29 23:58:54,251 INFO [master-000] [MySqlSymmetricDialect] [master-000-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_ND_HST_MSTR trigger for swimDB.sym_node_host 2021-03-29 23:58:54,610 INFO [master-000] [TriggerRouterService] [symmetric-engine-startup-1] Done synchronizing triggers 2021-03-29 23:58:55,190 INFO [master-000] [RouterJob] [symmetric-engine-startup-1] Starting Routing on periodic schedule: every 5000ms with the first run at 2021-03-29T23:59:04.931+0100 2021-03-29 23:58:55,192 INFO [master-000] [PushJob] [symmetric-engine-startup-1] Starting Push on periodic schedule: every 10000ms with the first run at 2021-03-29T23:59:04.933+0100 2021-03-29 23:58:55,193 INFO [master-000] [PullJob] [symmetric-engine-startup-1] Starting Pull on periodic schedule: every 10000ms with the first run at 2021-03-29T23:59:04.934+0100 2021-03-29 23:58:55,194 INFO [master-000] [JobManager] [symmetric-engine-startup-1] Job Offline Push not configured for auto start 2021-03-29 23:58:55,195 INFO [master-000] [JobManager] [symmetric-engine-startup-1] Job Offline Pull not configured for auto start 2021-03-29 23:58:55,196 INFO [master-000] [OutgoingPurgeJob] [symmetric-engine-startup-1] Starting job 'Purge Outgoing' with cron expression: '0 0 */4 * * *' 2021-03-29 23:58:55,197 INFO [master-000] [IncomingPurgeJob] [symmetric-engine-startup-1] Starting job 'Purge Incoming' with cron expression: '0 0 */4 * * *' 2021-03-29 23:58:55,199 INFO [master-000] [StatisticFlushJob] [symmetric-engine-startup-1] Starting job 'Stat Flush' with cron expression: '0 0/5 * * * *' 2021-03-29 23:58:55,199 INFO [master-000] [SyncTriggersJob] [symmetric-engine-startup-1] Starting job 'SyncTriggers' with cron expression: '0 0 0 * * *' 2021-03-29 23:58:55,200 INFO [master-000] [HeartbeatJob] [symmetric-engine-startup-1] Starting Heartbeat on periodic schedule: every 900000ms with the first run at 2021-03-29T23:59:04.941+0100 2021-03-29 23:58:55,201 INFO [master-000] [WatchdogJob] [symmetric-engine-startup-1] Starting Watchdog on periodic schedule: every 3600000ms with the first run at 2021-03-29T23:59:04.942+0100 2021-03-29 23:58:55,202 INFO [master-000] [StageManagementJob] [symmetric-engine-startup-1] Starting job 'Stage Management' with cron expression: '0 0 * * * *' 2021-03-29 23:58:55,202 INFO [master-000] [JobManager] [symmetric-engine-startup-1] Job Refresh Cache not configured for auto start 2021-03-29 23:58:55,203 INFO [master-000] [JobManager] [symmetric-engine-startup-1] Job File Sync Tracker not configured for auto start 2021-03-29 23:58:55,203 INFO [master-000] [JobManager] [symmetric-engine-startup-1] Job File Sync Pull not configured for auto start 2021-03-29 23:58:55,204 INFO [master-000] [JobManager] [symmetric-engine-startup-1] Job File Sync Push not configured for auto start 2021-03-29 23:58:55,204 INFO [master-000] [InitialLoadExtractorJob] [symmetric-engine-startup-1] Starting Initial Load Extract on periodic schedule: every 10000ms with the first run at 2021-03-29T23:59:04.945+0100 2021-03-29 23:58:55,205 INFO [master-000] [MonitorJob] [symmetric-engine-startup-1] Starting Monitor on periodic schedule: every 60000ms with the first run at 2021-03-29T23:59:04.946+0100 2021-03-29 23:58:55,206 INFO [master-000] [JobManager] [symmetric-engine-startup-1] Job Report Status not configured for auto start 2021-03-29 23:58:55,206 INFO [master-000] [JobManager] [symmetric-engine-startup-1] Job Log Miner not configured for auto start 2021-03-29 23:58:55,206 INFO [master-000] [InitialLoadJob] [symmetric-engine-startup-1] Starting Initial Load Queue on periodic schedule: every 10000ms with the first run at 2021-03-29T23:59:04.947+0100 2021-03-29 23:58:55,207 INFO [master-000] [AbstractSymmetricEngine] [symmetric-engine-startup-1] SymmetricDS Node STARTED: nodeId=000 groupId=master type=server subType=null name=master-000 softwareVersion=3.12.7 databaseName=MySQL databaseVersion=5.7 driverName=MariaDB Connector/J driverVersion=2.7.2 uptime=0 sec. 2021-03-29 23:59:00,608 INFO [node-002] [RegistrationService] [node-002-job-14] This node is unregistered. It will attempt to register using the registration.url 2021-03-29 23:59:00,794 INFO [node-002] [DataLoaderService] [node-002-job-14] Using registration URL of http://localhost:31415/sync/master-000/registration 2021-03-29 23:59:03,243 INFO [node-001] [RegistrationService] [node-001-job-2] This node is unregistered. It will attempt to register using the registration.url 2021-03-29 23:59:03,425 INFO [node-001] [DataLoaderService] [node-001-job-2] Using registration URL of http://localhost:31415/sync/master-000/registration 2021-03-29 23:59:04,954 INFO [master-000] [PushHeartbeatListener] [master-000-job-4] Some attribute(s) of node changed. Recording changes 2021-03-29 23:59:04,958 INFO [master-000] [PushHeartbeatListener] [master-000-job-4] Updating my node configuration info according to the symmetric properties 2021-03-29 23:59:05,305 INFO [master-000] [RegistrationService] [qtp647973805-15] Just opened registration for external id of 002 and a node group of node and a node id of 002 2021-03-29 23:59:05,916 INFO [master-000] [DataService] [master-000-job-1] Inserting missing last data gap: { startId: 1, endId: 50000001, createTime: "Mon Mar 29 23:59:05 BST 2021" } 2021-03-29 23:59:06,563 INFO [master-000] [RegistrationService] [qtp647973805-15] Completed registration of node node:002:002 2021-03-29 23:59:06,887 INFO [master-000] [DataGapFastDetector] [master-000-job-1] Full gap analysis is running 2021-03-29 23:59:06,960 INFO [master-000] [NodeCommunicationService] [master-000-job-2] push will use 10 threads 2021-03-29 23:59:06,963 INFO [master-000] [NodeCommunicationService] [master-000-job-3] pull will use 10 threads 2021-03-29 23:59:07,865 INFO [master-000] [RegistrationService] [qtp647973805-18] Just opened registration for external id of 001 and a node group of node and a node id of 001 2021-03-29 23:59:08,238 INFO [master-000] [DataGapFastDetector] [master-000-job-1] Querying data in gaps from database took 1350 ms 2021-03-29 23:59:08,239 INFO [master-000] [DataGapFastDetector] [master-000-job-1] Full gap analysis is done after 1351 ms 2021-03-29 23:59:09,119 INFO [master-000] [RegistrationService] [qtp647973805-18] Completed registration of node node:001:001 2021-03-29 23:59:20,375 INFO [master-000] [ConfigurationChangedDataRouter] [master-000-job-1] About to refresh the cache of nodes because new configuration came through the data router 2021-03-29 23:59:20,376 INFO [master-000] [ConfigurationChangedDataRouter] [master-000-job-1] About to refresh the cache of node security because new configuration came through the data router 2021-03-29 23:59:24,384 INFO [master-000] [RouterService] [master-000-job-1] Routed 13 data events in 17497 ms 2021-03-29 23:59:28,753 WARN [master-000] [PushService] [master-000-push-default-4] Registration is needed before communicating with node:002:002 at http://LAPTOP-UQHGHI89:31415/sync/node-002 2021-03-29 23:59:28,753 WARN [master-000] [PushService] [master-000-push-default-5] Registration is needed before communicating with node:001:001 at http://LAPTOP-UQHGHI89:31415/sync/node-001 2021-03-29 23:59:32,994 INFO [master-000] [ConfigurationChangedDataRouter] [master-000-job-15] About to refresh the cache of node security because new configuration came through the data router 2021-03-29 23:59:33,091 INFO [master-000] [RouterService] [master-000-job-15] Routed 1 data events in 3224 ms 2021-03-29 23:59:39,320 WARN [master-000] [PushService] [master-000-push-default-6] Registration is needed before communicating with node:002:002 at http://LAPTOP-UQHGHI89:31415/sync/node-002 2021-03-29 23:59:39,331 WARN [master-000] [PushService] [master-000-push-default-7] Registration is needed before communicating with node:001:001 at http://LAPTOP-UQHGHI89:31415/sync/node-001 2021-03-29 23:59:49,315 WARN [master-000] [PushService] [master-000-push-default-8] Registration is needed before communicating with node:002:002 at http://LAPTOP-UQHGHI89:31415/sync/node-002 2021-03-29 23:59:49,320 WARN [master-000] [PushService] [master-000-push-default-9] Registration is needed before communicating with node:001:001 at http://LAPTOP-UQHGHI89:31415/sync/node-001 2021-03-29 23:59:59,338 WARN [master-000] [PushService] [master-000-push-default-1] Registration is needed before communicating with node:001:001 at http://LAPTOP-UQHGHI89:31415/sync/node-001 2021-03-29 23:59:59,338 WARN [master-000] [PushService] [master-000-push-default-10] Registration is needed before communicating with node:002:002 at http://LAPTOP-UQHGHI89:31415/sync/node-002 2021-03-30 00:00:00,000 INFO [node-002] [StageManagementJob] [node-002-job-8] Did not run the 'Stage Management' job because the engine is not registered. 2021-03-30 00:00:00,001 INFO [node-002] [StatisticFlushJob] [node-002-job-12] Did not run the 'Stat Flush' job because the engine is not registered. 2021-03-30 00:00:00,001 INFO [node-002] [IncomingPurgeJob] [node-002-job-11] Did not run the 'Purge Incoming' job because the engine is not registered. 2021-03-30 00:00:00,002 INFO [master-000] [PurgeService] [master-000-job-8] The incoming purge process is about to run 2021-03-30 00:00:00,003 INFO [node-001] [SyncTriggersJob] [node-001-job-14] Did not run the 'SyncTriggers' job because the engine is not registered. 2021-03-30 00:00:00,003 INFO [node-001] [IncomingPurgeJob] [node-001-job-10] Did not run the 'Purge Incoming' job because the engine is not registered. 2021-03-30 00:00:00,003 INFO [master-000] [PurgeService] [master-000-job-6] The outgoing purge process is about to run for data older than 29 Mar 2021, 22:00:00 2021-03-30 00:00:00,004 INFO [node-001] [StageManagementJob] [node-001-job-16] Did not run the 'Stage Management' job because the engine is not registered. 2021-03-30 00:00:00,004 INFO [master-000] [TriggerRouterService] [master-000-job-14] Synchronizing triggers 2021-03-30 00:00:00,004 INFO [node-002] [SyncTriggersJob] [node-002-job-9] Did not run the 'SyncTriggers' job because the engine is not registered. 2021-03-30 00:00:00,005 INFO [master-000] [PurgeService] [master-000-job-6] Looking for old nodes in batches 2021-03-30 00:00:00,006 INFO [node-002] [TriggerRouterService] [node-002-job-9] Synchronizing triggers 2021-03-30 00:00:00,007 INFO [node-002] [OutgoingPurgeJob] [node-002-job-13] Did not run the 'Purge Outgoing' job because the engine is not registered. 2021-03-30 00:00:00,007 INFO [node-001] [PurgeService] [node-001-job-10] The incoming purge process is about to run 2021-03-30 00:00:00,008 INFO [node-001] [StatisticFlushJob] [node-001-job-9] Did not run the 'Stat Flush' job because the engine is not registered. 2021-03-30 00:00:00,008 INFO [node-002] [StagingManager] [node-002-job-8] Cleaning staging... 2021-03-30 00:00:00,009 INFO [node-001] [TriggerRouterService] [node-001-job-14] Synchronizing triggers 2021-03-30 00:00:00,009 INFO [node-001] [OutgoingPurgeJob] [node-001-job-1] Did not run the 'Purge Outgoing' job because the engine is not registered. 2021-03-30 00:00:00,010 INFO [master-000] [PurgeService] [master-000-job-8] Getting range for incoming batch 2021-03-30 00:00:00,010 INFO [node-002] [PurgeService] [node-002-job-11] The incoming purge process is about to run 2021-03-30 00:00:00,015 INFO [node-001] [PurgeService] [node-001-job-1] The outgoing purge process is about to run for data older than 29 Mar 2021, 22:00:00 2021-03-30 00:00:00,019 INFO [node-001] [PurgeService] [node-001-job-10] Getting range for incoming batch 2021-03-30 00:00:00,020 INFO [node-002] [PurgeService] [node-002-job-13] The outgoing purge process is about to run for data older than 29 Mar 2021, 22:00:00 2021-03-30 00:00:00,020 INFO [node-001] [TriggerRouterService] [node-001-job-14] Done synchronizing triggers 2021-03-30 00:00:00,023 INFO [node-001] [StagingManager] [node-001-job-16] Cleaning staging... 2021-03-30 00:00:00,024 INFO [node-002] [TriggerRouterService] [node-002-job-9] Done synchronizing triggers 2021-03-30 00:00:00,024 INFO [node-002] [PurgeService] [node-002-job-13] Looking for old nodes in batches 2021-03-30 00:00:00,025 INFO [node-001] [PurgeService] [node-001-job-1] Looking for old nodes in batches 2021-03-30 00:00:00,026 INFO [node-001] [PurgeService] [node-001-job-10] About to purge incoming batch 2021-03-30 00:00:00,029 INFO [node-001] [PurgeService] [node-001-job-1] Looking for old channels in batches 2021-03-30 00:00:00,029 INFO [node-002] [PurgeService] [node-002-job-11] Getting range for incoming batch 2021-03-30 00:00:00,030 INFO [node-001] [PurgeService] [node-001-job-10] Done purging 0 incoming batch rows 2021-03-30 00:00:00,031 INFO [node-002] [PurgeService] [node-002-job-13] Looking for old channels in batches 2021-03-30 00:00:00,033 INFO [node-002] [PurgeService] [node-002-job-13] Getting range for data 2021-03-30 00:00:00,033 INFO [node-001] [PurgeService] [node-001-job-10] Purging incoming error rows 2021-03-30 00:00:00,034 INFO [node-002] [PurgeService] [node-002-job-11] About to purge incoming batch 2021-03-30 00:00:00,035 INFO [node-001] [PurgeService] [node-001-job-1] Getting range for data 2021-03-30 00:00:00,035 INFO [node-001] [PurgeService] [node-001-job-10] Purged 0 incoming error rows 2021-03-30 00:00:00,037 INFO [node-002] [PurgeService] [node-002-job-11] Done purging 0 incoming batch rows 2021-03-30 00:00:00,038 INFO [node-002] [PurgeService] [node-002-job-13] Found range for data of 0 through 0 2021-03-30 00:00:00,038 INFO [node-001] [PurgeService] [node-001-job-1] Found range for data of 0 through 0 2021-03-30 00:00:00,038 INFO [node-002] [PurgeService] [node-002-job-11] Purging incoming error rows 2021-03-30 00:00:00,039 INFO [node-001] [PurgeService] [node-001-job-10] Purging registration requests that are older than 2021-03-24T23:00:00.039+0000 2021-03-30 00:00:00,040 INFO [node-002] [PurgeService] [node-002-job-13] Getting count of outstanding batches 2021-03-30 00:00:00,041 INFO [node-002] [PurgeService] [node-002-job-11] Purged 0 incoming error rows 2021-03-30 00:00:00,041 INFO [node-001] [PurgeService] [node-001-job-1] Getting count of outstanding batches 2021-03-30 00:00:00,042 INFO [node-002] [PurgeService] [node-002-job-13] Found 0 outstanding batches, threshold is 100000 2021-03-30 00:00:00,044 INFO [node-002] [StagingManager] [node-002-job-8] Purged 2 staging files, freed 1 KB of disk space. 2021-03-30 00:00:00,046 INFO [node-001] [PurgeService] [node-001-job-1] Found 0 outstanding batches, threshold is 100000 2021-03-30 00:00:00,046 INFO [node-002] [StagingManager] [node-002-job-8] Finished cleaning staging in 0 seconds. 2021-03-30 00:00:00,048 INFO [node-002] [PurgeService] [node-002-job-11] Purging registration requests that are older than 2021-03-24T23:00:00.047+0000 2021-03-30 00:00:00,048 INFO [node-001] [PurgeService] [node-001-job-10] Purging monitor events that are older than 2021-03-29T22:00:00.048+0100 2021-03-30 00:00:00,048 INFO [node-001] [PurgeService] [node-001-job-1] About to purge data_range using range 0 through -1 2021-03-30 00:00:00,048 INFO [node-002] [PurgeService] [node-002-job-13] About to purge data_range using range 0 through -1 2021-03-30 00:00:00,049 INFO [node-002] [PurgeService] [node-002-job-13] Done purging 0 of data_range rows 2021-03-30 00:00:00,050 INFO [node-001] [PurgeService] [node-001-job-1] Done purging 0 of data_range rows 2021-03-30 00:00:00,051 INFO [node-001] [PurgeService] [node-001-job-10] The incoming purge process has completed 2021-03-30 00:00:00,052 INFO [node-002] [PurgeService] [node-002-job-11] Purging monitor events that are older than 2021-03-29T22:00:00.052+0100 2021-03-30 00:00:00,052 INFO [node-001] [PurgeService] [node-001-job-1] About to purge data using range 1 through 0 2021-03-30 00:00:00,052 INFO [node-002] [PurgeService] [node-002-job-13] About to purge data using range 1 through 0 2021-03-30 00:00:00,054 INFO [node-001] [PurgeService] [node-001-job-1] Done purging 0 of data rows 2021-03-30 00:00:00,054 INFO [node-001] [StagingManager] [node-001-job-16] Finished cleaning staging in 0 seconds. 2021-03-30 00:00:00,055 INFO [node-002] [PurgeService] [node-002-job-11] The incoming purge process has completed 2021-03-30 00:00:00,055 INFO [node-002] [PurgeService] [node-002-job-13] Done purging 0 of data rows 2021-03-30 00:00:00,056 INFO [node-001] [PurgeService] [node-001-job-1] Getting range for outgoing batch 2021-03-30 00:00:00,056 INFO [node-002] [PurgeService] [node-002-job-13] Getting range for outgoing batch 2021-03-30 00:00:00,059 INFO [node-001] [PurgeService] [node-001-job-1] Getting first batch_id for outstanding batches 2021-03-30 00:00:00,059 INFO [node-002] [PurgeService] [node-002-job-13] Getting first batch_id for outstanding batches 2021-03-30 00:00:00,061 INFO [node-001] [PurgeService] [node-001-job-1] About to purge data_event_range using range 0 through 0 2021-03-30 00:00:00,061 INFO [node-002] [PurgeService] [node-002-job-13] About to purge data_event_range using range 0 through 0 2021-03-30 00:00:00,063 INFO [node-001] [PurgeService] [node-001-job-1] Done purging 0 of data_event_range rows 2021-03-30 00:00:00,063 INFO [node-002] [PurgeService] [node-002-job-13] Done purging 0 of data_event_range rows 2021-03-30 00:00:00,063 INFO [node-001] [PurgeService] [node-001-job-1] About to purge outgoing_batch_range using range 0 through 0 2021-03-30 00:00:00,064 INFO [node-002] [PurgeService] [node-002-job-13] About to purge outgoing_batch_range using range 0 through 0 2021-03-30 00:00:00,064 INFO [node-001] [PurgeService] [node-001-job-1] Done purging 0 of outgoing_batch_range rows 2021-03-30 00:00:00,065 INFO [node-002] [PurgeService] [node-002-job-13] Done purging 0 of outgoing_batch_range rows 2021-03-30 00:00:00,065 INFO [node-001] [PurgeService] [node-001-job-1] About to purge data_event using range 0 through -1 2021-03-30 00:00:00,066 INFO [node-002] [PurgeService] [node-002-job-13] About to purge data_event using range 0 through -1 2021-03-30 00:00:00,066 INFO [node-001] [PurgeService] [node-001-job-1] Done purging 0 of data_event rows 2021-03-30 00:00:00,067 INFO [node-002] [PurgeService] [node-002-job-13] Done purging 0 of data_event rows 2021-03-30 00:00:00,067 INFO [node-001] [PurgeService] [node-001-job-1] About to purge outgoing_batch using range 0 through -1 2021-03-30 00:00:00,067 INFO [node-002] [PurgeService] [node-002-job-13] About to purge outgoing_batch using range 0 through -1 2021-03-30 00:00:00,068 INFO [node-001] [PurgeService] [node-001-job-1] Done purging 0 of outgoing_batch rows 2021-03-30 00:00:00,068 INFO [node-002] [PurgeService] [node-002-job-13] Done purging 0 of outgoing_batch rows 2021-03-30 00:00:00,069 INFO [node-001] [PurgeService] [node-001-job-1] Done purging 0 lingering batches and 0 rows 2021-03-30 00:00:00,070 INFO [node-002] [PurgeService] [node-002-job-13] Done purging 0 lingering batches and 0 rows 2021-03-30 00:00:00,070 INFO [node-001] [PurgeService] [node-001-job-1] Getting range for stranded data events 2021-03-30 00:00:00,071 INFO [node-002] [PurgeService] [node-002-job-13] Getting range for stranded data events 2021-03-30 00:00:00,073 INFO [node-001] [PurgeService] [node-001-job-1] About to purge stranded_data_event using range 0 through -1 2021-03-30 00:00:00,073 INFO [node-002] [PurgeService] [node-002-job-13] About to purge stranded_data_event using range 0 through -1 2021-03-30 00:00:00,073 INFO [node-001] [PurgeService] [node-001-job-1] Done purging 0 of stranded_data_event rows 2021-03-30 00:00:00,074 INFO [node-002] [PurgeService] [node-002-job-13] Done purging 0 of stranded_data_event rows 2021-03-30 00:00:00,076 INFO [node-001] [PurgeService] [node-001-job-1] Getting range for stranded data 2021-03-30 00:00:00,077 INFO [node-002] [PurgeService] [node-002-job-13] Getting range for stranded data 2021-03-30 00:00:00,078 INFO [node-001] [PurgeService] [node-001-job-1] About to purge stranded_data using range 0 through -1 2021-03-30 00:00:00,078 INFO [node-001] [PurgeService] [node-001-job-1] Done purging 0 of stranded_data rows 2021-03-30 00:00:00,078 INFO [node-002] [PurgeService] [node-002-job-13] About to purge stranded_data using range 0 through -1 2021-03-30 00:00:00,079 INFO [node-001] [PurgeService] [node-001-job-1] Purging extract requests that are older than 2021-03-19T23:00:00.079+0000 2021-03-30 00:00:00,079 INFO [node-002] [PurgeService] [node-002-job-13] Done purging 0 of stranded_data rows 2021-03-30 00:00:00,080 INFO [node-002] [PurgeService] [node-002-job-13] Purging extract requests that are older than 2021-03-19T23:00:00.080+0000 2021-03-30 00:00:00,080 INFO [node-001] [PurgeService] [node-001-job-1] Looking for old channels in data 2021-03-30 00:00:00,081 INFO [node-002] [PurgeService] [node-002-job-13] Looking for old channels in data 2021-03-30 00:00:00,081 INFO [node-001] [PurgeService] [node-001-job-1] The outgoing purge process has completed 2021-03-30 00:00:00,081 INFO [node-002] [PurgeService] [node-002-job-13] The outgoing purge process has completed 2021-03-30 00:00:00,585 INFO [master-000] [PurgeService] [master-000-job-8] About to purge incoming batch 2021-03-30 00:00:00,585 INFO [master-000] [PurgeService] [master-000-job-8] Done purging 0 incoming batch rows 2021-03-30 00:00:00,587 INFO [master-000] [PurgeService] [master-000-job-8] Purging incoming error rows 2021-03-30 00:00:00,591 INFO [master-000] [PurgeService] [master-000-job-6] Looking for old channels in batches 2021-03-30 00:00:00,683 INFO [master-000] [PurgeService] [master-000-job-8] Purged 0 incoming error rows 2021-03-30 00:00:00,684 INFO [master-000] [PurgeService] [master-000-job-8] Purging registration requests that are older than 2021-03-24T23:00:00.684+0000 2021-03-30 00:00:00,780 INFO [master-000] [PurgeService] [master-000-job-8] Purging monitor events that are older than 2021-03-29T22:00:00.780+0100 2021-03-30 00:00:00,875 INFO [master-000] [PurgeService] [master-000-job-8] The incoming purge process has completed 2021-03-30 00:00:01,147 INFO [master-000] [StagingManager] [master-000-job-15] Cleaning staging... 2021-03-30 00:00:01,169 INFO [master-000] [PurgeService] [master-000-job-6] Getting range for data 2021-03-30 00:00:01,401 INFO [master-000] [StagingManager] [master-000-job-15] Purged 104 staging files, freed 67 KB of disk space. 2021-03-30 00:00:01,402 INFO [master-000] [StagingManager] [master-000-job-15] Finished cleaning staging in 0 seconds. 2021-03-30 00:00:02,039 INFO [master-000] [PurgeService] [master-000-job-6] Found range for data of 1 through 0 2021-03-30 00:00:02,132 INFO [master-000] [PurgeService] [master-000-job-6] Getting count of outstanding batches 2021-03-30 00:00:02,230 INFO [master-000] [PurgeService] [master-000-job-6] Found 6 outstanding batches, threshold is 100000 2021-03-30 00:00:02,230 INFO [master-000] [PurgeService] [master-000-job-6] Getting first data_id for outstanding batches 2021-03-30 00:00:02,332 INFO [master-000] [PurgeService] [master-000-job-6] About to purge data_range using range 1 through 0 2021-03-30 00:00:02,332 INFO [master-000] [PurgeService] [master-000-job-6] Done purging 0 of data_range rows 2021-03-30 00:00:02,334 INFO [master-000] [PurgeService] [master-000-job-6] About to purge data using range 1 through -1 2021-03-30 00:00:02,335 INFO [master-000] [PurgeService] [master-000-job-6] Done purging 0 of data rows 2021-03-30 00:00:02,335 INFO [master-000] [PurgeService] [master-000-job-6] Getting range for outgoing batch 2021-03-30 00:00:02,832 INFO [master-000] [PurgeService] [master-000-job-6] Getting first batch_id for outstanding batches 2021-03-30 00:00:02,926 INFO [master-000] [PurgeService] [master-000-job-6] About to purge data_event_range using range 2 through 0 2021-03-30 00:00:02,926 INFO [master-000] [PurgeService] [master-000-job-6] Done purging 0 of data_event_range rows 2021-03-30 00:00:02,928 INFO [master-000] [PurgeService] [master-000-job-6] About to purge outgoing_batch_range using range 2 through 0 2021-03-30 00:00:02,928 INFO [master-000] [PurgeService] [master-000-job-6] Done purging 0 of outgoing_batch_range rows 2021-03-30 00:00:02,929 INFO [master-000] [PurgeService] [master-000-job-6] About to purge data_event using range 2 through -1 2021-03-30 00:00:02,930 INFO [master-000] [PurgeService] [master-000-job-6] Done purging 0 of data_event rows 2021-03-30 00:00:02,930 INFO [master-000] [PurgeService] [master-000-job-6] About to purge outgoing_batch using range 2 through -1 2021-03-30 00:00:02,931 INFO [master-000] [PurgeService] [master-000-job-6] Done purging 0 of outgoing_batch rows 2021-03-30 00:00:03,028 INFO [master-000] [PurgeService] [master-000-job-6] Done purging 0 lingering batches and 0 rows 2021-03-30 00:00:03,028 INFO [master-000] [PurgeService] [master-000-job-6] Getting range for stranded data events 2021-03-30 00:00:03,717 INFO [master-000] [PurgeService] [master-000-job-6] About to purge stranded_data_event using range 0 through -1 2021-03-30 00:00:03,717 INFO [master-000] [PurgeService] [master-000-job-6] Done purging 0 of stranded_data_event rows 2021-03-30 00:00:03,719 INFO [master-000] [PurgeService] [master-000-job-6] Getting range for stranded data 2021-03-30 00:00:03,917 INFO [master-000] [PurgeService] [master-000-job-6] About to purge stranded_data using range 1 through 0 2021-03-30 00:00:03,917 INFO [master-000] [PurgeService] [master-000-job-6] Done purging 0 of stranded_data rows 2021-03-30 00:00:03,919 INFO [master-000] [PurgeService] [master-000-job-6] Purging extract requests that are older than 2021-03-19T23:00:03.919+0000 2021-03-30 00:00:04,017 INFO [master-000] [PurgeService] [master-000-job-6] Looking for old channels in data 2021-03-30 00:00:04,597 INFO [master-000] [PurgeService] [master-000-job-6] The outgoing purge process has completed 2021-03-30 00:00:16,803 WARN [master-000] [PushService] [master-000-push-default-2] Registration is needed before communicating with node:002:002 at http://LAPTOP-UQHGHI89:31415/sync/node-002 2021-03-30 00:00:16,803 WARN [master-000] [PushService] [master-000-push-default-3] Registration is needed before communicating with node:001:001 at http://LAPTOP-UQHGHI89:31415/sync/node-001 2021-03-30 00:00:19,329 WARN [master-000] [PushService] [master-000-push-default-5] Registration is needed before communicating with node:001:001 at http://LAPTOP-UQHGHI89:31415/sync/node-001 2021-03-30 00:00:19,329 WARN [master-000] [PushService] [master-000-push-default-4] Registration is needed before communicating with node:002:002 at http://LAPTOP-UQHGHI89:31415/sync/node-002 2021-03-30 00:00:29,321 WARN [master-000] [PushService] [master-000-push-default-7] Registration is needed before communicating with node:001:001 at http://LAPTOP-UQHGHI89:31415/sync/node-001 2021-03-30 00:00:29,324 WARN [master-000] [PushService] [master-000-push-default-6] Registration is needed before communicating with node:002:002 at http://LAPTOP-UQHGHI89:31415/sync/node-002 2021-03-30 00:00:30,810 ERROR [node-002] [DataLoaderService] [node-002-job-14] Failed to process batch StackTraceKey.init [SocketTimeoutException:4235605605] java.net.SocketTimeoutException: Read timed out at java.base/sun.nio.ch.NioSocketImpl.timedRead(NioSocketImpl.java:283) at java.base/sun.nio.ch.NioSocketImpl.implRead(NioSocketImpl.java:309) at java.base/sun.nio.ch.NioSocketImpl.read(NioSocketImpl.java:350) at java.base/sun.nio.ch.NioSocketImpl$1.read(NioSocketImpl.java:803) at java.base/java.net.Socket$SocketInputStream.read(Socket.java:981) at java.base/java.io.BufferedInputStream.fill(BufferedInputStream.java:244) at java.base/java.io.BufferedInputStream.read1(BufferedInputStream.java:284) at java.base/java.io.BufferedInputStream.read(BufferedInputStream.java:343) at java.base/sun.net.www.http.HttpClient.parseHTTPHeader(HttpClient.java:754) at java.base/sun.net.www.http.HttpClient.parseHTTP(HttpClient.java:689) at java.base/sun.net.www.protocol.http.HttpURLConnection.getInputStream0(HttpURLConnection.java:1623) at java.base/sun.net.www.protocol.http.HttpURLConnection.getInputStream(HttpURLConnection.java:1528) at java.base/java.net.HttpURLConnection.getResponseCode(HttpURLConnection.java:527) at org.jumpmind.symmetric.transport.http.HttpConnection.getResponseCode(HttpConnection.java:125) at org.jumpmind.symmetric.transport.http.HttpIncomingTransport.openConnectionCheckRedirects(HttpIncomingTransport.java:208) at org.jumpmind.symmetric.transport.http.HttpIncomingTransport.openStream(HttpIncomingTransport.java:139) at org.jumpmind.symmetric.transport.http.HttpIncomingTransport.openReader(HttpIncomingTransport.java:175) at org.jumpmind.symmetric.service.impl.DataLoaderService.loadDataFromTransport(DataLoaderService.java:599) at org.jumpmind.symmetric.service.impl.DataLoaderService.loadDataFromPull(DataLoaderService.java:308) at org.jumpmind.symmetric.service.impl.DataLoaderService.loadDataFromPull(DataLoaderService.java:256) at org.jumpmind.symmetric.service.impl.RegistrationService.attemptToRegisterWithServer(RegistrationService.java:501) at org.jumpmind.symmetric.service.impl.RegistrationService.registerWithServer(RegistrationService.java:476) at org.jumpmind.symmetric.service.impl.PullService.pullData(PullService.java:91) at org.jumpmind.symmetric.job.PullJob.doJob(PullJob.java:48) at org.jumpmind.symmetric.job.AbstractJob.invoke(AbstractJob.java:227) at org.jumpmind.symmetric.job.AbstractJob.run(AbstractJob.java:298) at org.springframework.scheduling.support.DelegatingErrorHandlingRunnable.run(DelegatingErrorHandlingRunnable.java:54) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515) at java.base/java.util.concurrent.FutureTask.runAndReset(FutureTask.java:305) at java.base/java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:305) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:630) at java.base/java.lang.Thread.run(Thread.java:832) 2021-03-30 00:00:30,818 INFO [node-002] [RegistrationService] [node-002-job-14] Could not register. Sleeping for 20000ms before attempting again. 2021-03-30 00:00:33,430 ERROR [node-001] [DataLoaderService] [node-001-job-2] Failed to process batch StackTraceKey [SocketTimeoutException:4235605605] 2021-03-30 00:00:33,432 INFO [node-001] [RegistrationService] [node-001-job-2] Could not register. Sleeping for 24000ms before attempting again. 2021-03-30 00:00:39,340 WARN [master-000] [PushService] [master-000-push-default-8] Registration is needed before communicating with node:002:002 at http://LAPTOP-UQHGHI89:31415/sync/node-002 2021-03-30 00:00:39,344 WARN [master-000] [PushService] [master-000-push-default-9] Registration is needed before communicating with node:001:001 at http://LAPTOP-UQHGHI89:31415/sync/node-001 2021-03-30 00:00:49,329 WARN [master-000] [PushService] [master-000-push-default-10] Registration is needed before communicating with node:001:001 at http://LAPTOP-UQHGHI89:31415/sync/node-001 2021-03-30 00:00:49,334 WARN [master-000] [PushService] [master-000-push-default-1] Registration is needed before communicating with node:002:002 at http://LAPTOP-UQHGHI89:31415/sync/node-002 2021-03-30 00:00:50,823 INFO [node-002] [RegistrationService] [node-002-job-14] This node is unregistered. It will attempt to register using the registration.url 2021-03-30 00:00:51,037 INFO [node-002] [DataLoaderService] [node-002-job-14] Using registration URL of http://localhost:31415/sync/master-000/registration 2021-03-30 00:00:52,851 INFO [master-000] [RegistrationService] [qtp647973805-18] Completed registration of node node:002:002 2021-03-30 00:00:57,436 INFO [node-001] [RegistrationService] [node-001-job-2] This node is unregistered. It will attempt to register using the registration.url 2021-03-30 00:00:57,672 INFO [node-001] [DataLoaderService] [node-001-job-2] Using registration URL of http://localhost:31415/sync/master-000/registration 2021-03-30 00:00:58,387 INFO [master-000] [ConfigurationChangedDataRouter] [master-000-job-1] About to refresh the cache of nodes because new configuration came through the data router 2021-03-30 00:00:58,387 INFO [master-000] [ConfigurationChangedDataRouter] [master-000-job-1] About to refresh the cache of node security because new configuration came through the data router 2021-03-30 00:00:58,483 INFO [master-000] [RouterService] [master-000-job-1] Routed 2 data events in 5902 ms 2021-03-30 00:00:59,492 INFO [master-000] [RegistrationService] [qtp647973805-15] Completed registration of node node:001:001 2021-03-30 00:01:00,477 WARN [master-000] [PushService] [master-000-push-default-2] Registration is needed before communicating with node:002:002 at http://LAPTOP-UQHGHI89:31415/sync/node-002 2021-03-30 00:01:00,480 WARN [master-000] [PushService] [master-000-push-default-3] Registration is needed before communicating with node:001:001 at http://LAPTOP-UQHGHI89:31415/sync/node-001 2021-03-30 00:01:08,662 INFO [master-000] [ConfigurationChangedDataRouter] [master-000-job-8] About to refresh the cache of nodes because new configuration came through the data router 2021-03-30 00:01:08,662 INFO [master-000] [ConfigurationChangedDataRouter] [master-000-job-8] About to refresh the cache of node security because new configuration came through the data router 2021-03-30 00:01:08,759 INFO [master-000] [RouterService] [master-000-job-8] Routed 4 data events in 4799 ms 2021-03-30 00:01:11,640 WARN [master-000] [PushService] [master-000-push-default-5] Registration is needed before communicating with node:002:002 at http://LAPTOP-UQHGHI89:31415/sync/node-002 2021-03-30 00:01:11,640 WARN [master-000] [PushService] [master-000-push-default-4] Registration is needed before communicating with node:001:001 at http://LAPTOP-UQHGHI89:31415/sync/node-001 2021-03-30 00:01:19,345 INFO [master-000] [TriggerRouterService] [master-000-job-14] Done synchronizing triggers 2021-03-30 00:01:21,629 WARN [master-000] [PushService] [master-000-push-default-6] Registration is needed before communicating with node:001:001 at http://LAPTOP-UQHGHI89:31415/sync/node-001 2021-03-30 00:01:21,639 WARN [master-000] [PushService] [master-000-push-default-7] Registration is needed before communicating with node:002:002 at http://LAPTOP-UQHGHI89:31415/sync/node-002 2021-03-30 00:01:31,637 WARN [master-000] [PushService] [master-000-push-default-9] Registration is needed before communicating with node:001:001 at http://LAPTOP-UQHGHI89:31415/sync/node-001 2021-03-30 00:01:31,641 WARN [master-000] [PushService] [master-000-push-default-8] Registration is needed before communicating with node:002:002 at http://LAPTOP-UQHGHI89:31415/sync/node-002 2021-03-30 00:01:41,641 WARN [master-000] [PushService] [master-000-push-default-1] Registration is needed before communicating with node:001:001 at http://LAPTOP-UQHGHI89:31415/sync/node-001 2021-03-30 00:01:41,644 WARN [master-000] [PushService] [master-000-push-default-10] Registration is needed before communicating with node:002:002 at http://LAPTOP-UQHGHI89:31415/sync/node-002 2021-03-30 00:01:46,120 INFO [node-002] [ConfigurationChangedDatabaseWriterFilter] [node-002-dataloader-1] Grouplets flushed because new grouplet config came through the data loader 2021-03-30 00:01:46,121 INFO [node-002] [ConfigurationChangedDatabaseWriterFilter] [node-002-dataloader-1] Load filters flushed because new filter config came through the data loader 2021-03-30 00:01:46,122 INFO [node-002] [ConfigurationChangedDatabaseWriterFilter] [node-002-dataloader-1] Channels flushed because new channels came through the data loader 2021-03-30 00:01:46,123 INFO [node-002] [ConfigurationChangedDatabaseWriterFilter] [node-002-dataloader-1] About to refresh the cache of conflict settings because new configuration came through the data loader 2021-03-30 00:01:46,124 INFO [node-002] [ConfigurationChangedDatabaseWriterFilter] [node-002-dataloader-1] About to refresh the cache of parameters because new configuration came through the data loader 2021-03-30 00:01:46,132 INFO [node-002] [ConfigurationChangedDatabaseWriterFilter] [node-002-dataloader-1] Extensions flushed because new extensions came through the data loader 2021-03-30 00:01:46,133 INFO [node-002] [ExtensionService] [node-002-dataloader-1] Found 0 extension points from the database that will be registered 2021-03-30 00:01:46,133 INFO [node-002] [ClientExtensionService] [node-002-dataloader-1] Found 8 extension points from spring that will be registered 2021-03-30 00:01:46,134 INFO [node-002] [ConfigurationChangedDatabaseWriterFilter] [node-002-dataloader-1] About to refresh the cache of node security because new configuration came through the data loader 2021-03-30 00:01:46,137 INFO [node-002] [ConfigurationChangedDatabaseWriterFilter] [node-002-job-14] About to refresh the cache of transformation because new configuration came through the data loader 2021-03-30 00:01:46,138 INFO [node-002] [ConfigurationChangedDatabaseWriterFilter] [node-002-job-14] About to clear the staging area because new transform configuration came through the data loader 2021-03-30 00:01:46,138 INFO [node-002] [StagingManager] [node-002-job-14] Cleaning staging... 2021-03-30 00:01:46,166 INFO [node-002] [StagingManager] [node-002-job-14] Purged 11 staging files, freed 18 KB of disk space. 2021-03-30 00:01:46,166 INFO [node-002] [StagingManager] [node-002-job-14] Finished cleaning staging in 0 seconds. 2021-03-30 00:01:46,167 INFO [node-002] [ConfigurationChangedDatabaseWriterFilter] [node-002-job-14] About to syncTriggers because new configuration came through the data loader 2021-03-30 00:01:46,168 INFO [node-002] [TriggerRouterService] [node-002-job-14] Synchronizing triggers 2021-03-30 00:01:46,213 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_RTR_ND trigger for sym_router 2021-03-30 00:01:46,233 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_RTR_ND trigger for sym_router 2021-03-30 00:01:46,250 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_RTR_ND trigger for sym_router 2021-03-30 00:01:46,317 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_TRNSFRM_TBL_ND trigger for sym_transform_table 2021-03-30 00:01:46,337 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_TRNSFRM_TBL_ND trigger for sym_transform_table 2021-03-30 00:01:46,356 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_TRNSFRM_TBL_ND trigger for sym_transform_table 2021-03-30 00:01:46,399 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_I_FOR_MT_ND trigger for Meet 2021-03-30 00:01:46,413 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_U_FOR_MT_ND trigger for Meet 2021-03-30 00:01:46,430 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_D_FOR_MT_ND trigger for Meet 2021-03-30 00:01:46,470 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_PRMTR_ND trigger for sym_parameter 2021-03-30 00:01:46,485 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_PRMTR_ND trigger for sym_parameter 2021-03-30 00:01:46,500 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_PRMTR_ND trigger for sym_parameter 2021-03-30 00:01:46,541 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_FL_TRGGR_RTR_ND trigger for sym_file_trigger_router 2021-03-30 00:01:46,557 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_FL_TRGGR_RTR_ND trigger for sym_file_trigger_router 2021-03-30 00:01:46,573 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_FL_TRGGR_RTR_ND trigger for sym_file_trigger_router 2021-03-30 00:01:46,614 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_TBL_RLD_RQST_ND trigger for sym_table_reload_request 2021-03-30 00:01:46,635 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_TBL_RLD_RQST_ND trigger for sym_table_reload_request 2021-03-30 00:01:46,652 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_TBL_RLD_RQST_ND trigger for sym_table_reload_request 2021-03-30 00:01:46,719 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_GRPLT_LNK_ND trigger for sym_grouplet_link 2021-03-30 00:01:46,732 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_GRPLT_LNK_ND trigger for sym_grouplet_link 2021-03-30 00:01:46,747 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_GRPLT_LNK_ND trigger for sym_grouplet_link 2021-03-30 00:01:46,786 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_GRPLT_ND trigger for sym_grouplet 2021-03-30 00:01:46,800 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_GRPLT_ND trigger for sym_grouplet 2021-03-30 00:01:46,813 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_GRPLT_ND trigger for sym_grouplet 2021-03-30 00:01:46,880 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_FL_TRGGR_ND trigger for sym_file_trigger 2021-03-30 00:01:46,897 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_FL_TRGGR_ND trigger for sym_file_trigger 2021-03-30 00:01:46,914 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_FL_TRGGR_ND trigger for sym_file_trigger 2021-03-30 00:01:46,954 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_TRNSFRM_CLMN_ND trigger for sym_transform_column 2021-03-30 00:01:46,969 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_TRNSFRM_CLMN_ND trigger for sym_transform_column 2021-03-30 00:01:46,984 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_TRNSFRM_CLMN_ND trigger for sym_transform_column 2021-03-30 00:01:47,044 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_I_FOR_VNTS_ND trigger for Events 2021-03-30 00:01:47,060 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_U_FOR_VNTS_ND trigger for Events 2021-03-30 00:01:47,075 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_D_FOR_VNTS_ND trigger for Events 2021-03-30 00:01:47,118 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_JB_ND trigger for sym_job 2021-03-30 00:01:47,133 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_JB_ND trigger for sym_job 2021-03-30 00:01:47,149 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_JB_ND trigger for sym_job 2021-03-30 00:01:47,191 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_TRGGR_RTR_ND trigger for sym_trigger_router 2021-03-30 00:01:47,208 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_TRGGR_RTR_ND trigger for sym_trigger_router 2021-03-30 00:01:47,223 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_TRGGR_RTR_ND trigger for sym_trigger_router 2021-03-30 00:01:47,265 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_ND_ND trigger for sym_node 2021-03-30 00:01:47,280 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_ND_ND trigger for sym_node 2021-03-30 00:01:47,295 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_ND_ND trigger for sym_node 2021-03-30 00:01:47,342 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_I_FOR_SWMMRS_ND trigger for Swimmers 2021-03-30 00:01:47,358 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_U_FOR_SWMMRS_ND trigger for Swimmers 2021-03-30 00:01:47,375 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_D_FOR_SWMMRS_ND trigger for Swimmers 2021-03-30 00:01:47,423 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_I_FOR_SSSNS_ND trigger for Sessions 2021-03-30 00:01:47,435 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_U_FOR_SSSNS_ND trigger for Sessions 2021-03-30 00:01:47,448 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_D_FOR_SSSNS_ND trigger for Sessions 2021-03-30 00:01:47,488 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_ND_GRP_CHNNL_WND_ND trigger for sym_node_group_channel_wnd 2021-03-30 00:01:47,502 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_ND_GRP_CHNNL_WND_ND trigger for sym_node_group_channel_wnd 2021-03-30 00:01:47,516 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_ND_GRP_CHNNL_WND_ND trigger for sym_node_group_channel_wnd 2021-03-30 00:01:47,560 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_NTFCTN_ND trigger for sym_notification 2021-03-30 00:01:47,574 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_NTFCTN_ND trigger for sym_notification 2021-03-30 00:01:47,588 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_NTFCTN_ND trigger for sym_notification 2021-03-30 00:01:47,631 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_ND_GRP_LNK_ND trigger for sym_node_group_link 2021-03-30 00:01:47,645 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_ND_GRP_LNK_ND trigger for sym_node_group_link 2021-03-30 00:01:47,659 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_ND_GRP_LNK_ND trigger for sym_node_group_link 2021-03-30 00:01:47,702 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_ND_GRP_ND trigger for sym_node_group 2021-03-30 00:01:47,716 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_ND_GRP_ND trigger for sym_node_group 2021-03-30 00:01:47,729 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_ND_GRP_ND trigger for sym_node_group 2021-03-30 00:01:47,754 INFO [node-002] [DataService] [node-002-job-16] Inserting missing last data gap: { startId: 1, endId: 50000001, createTime: "Tue Mar 30 00:01:47 BST 2021" } 2021-03-30 00:01:47,775 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_I_FOR_QLFYNG_TMS_ND trigger for Qualifying_Times 2021-03-30 00:01:47,787 INFO [node-002] [DataGapFastDetector] [node-002-job-16] Full gap analysis is running 2021-03-30 00:01:47,788 INFO [node-002] [DataGapFastDetector] [node-002-job-16] Querying data in gaps from database took 1 ms 2021-03-30 00:01:47,789 INFO [node-002] [DataGapFastDetector] [node-002-job-16] Full gap analysis is done after 2 ms 2021-03-30 00:01:47,800 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_U_FOR_QLFYNG_TMS_ND trigger for Qualifying_Times 2021-03-30 00:01:47,823 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_D_FOR_QLFYNG_TMS_ND trigger for Qualifying_Times 2021-03-30 00:01:47,880 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_ND_SCRTY_ND trigger for sym_node_security 2021-03-30 00:01:47,897 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_ND_SCRTY_ND trigger for sym_node_security 2021-03-30 00:01:47,913 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_ND_SCRTY_ND trigger for sym_node_security 2021-03-30 00:01:47,959 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_LD_FLTR_ND trigger for sym_load_filter 2021-03-30 00:01:47,977 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_LD_FLTR_ND trigger for sym_load_filter 2021-03-30 00:01:47,994 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_LD_FLTR_ND trigger for sym_load_filter 2021-03-30 00:01:48,045 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_MNTR_ND trigger for sym_monitor 2021-03-30 00:01:48,062 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_MNTR_ND trigger for sym_monitor 2021-03-30 00:01:48,078 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_MNTR_ND trigger for sym_monitor 2021-03-30 00:01:48,123 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_XTNSN_ND trigger for sym_extension 2021-03-30 00:01:48,138 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_XTNSN_ND trigger for sym_extension 2021-03-30 00:01:48,154 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_XTNSN_ND trigger for sym_extension 2021-03-30 00:01:48,204 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_CNFLCT_ND trigger for sym_conflict 2021-03-30 00:01:48,221 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_CNFLCT_ND trigger for sym_conflict 2021-03-30 00:01:48,241 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_CNFLCT_ND trigger for sym_conflict 2021-03-30 00:01:48,292 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_TRGGR_ND trigger for sym_trigger 2021-03-30 00:01:48,313 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_TRGGR_ND trigger for sym_trigger 2021-03-30 00:01:48,337 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_TRGGR_ND trigger for sym_trigger 2021-03-30 00:01:48,392 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_CHNNL_ND trigger for sym_channel 2021-03-30 00:01:48,412 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_CHNNL_ND trigger for sym_channel 2021-03-30 00:01:48,431 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_CHNNL_ND trigger for sym_channel 2021-03-30 00:01:48,482 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_I_FOR_CLBS_ND trigger for Clubs 2021-03-30 00:01:48,496 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_U_FOR_CLBS_ND trigger for Clubs 2021-03-30 00:01:48,510 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_D_FOR_CLBS_ND trigger for Clubs 2021-03-30 00:01:48,561 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_TRGGR_RTR_GRPLT_ND trigger for sym_trigger_router_grouplet 2021-03-30 00:01:48,577 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_TRGGR_RTR_GRPLT_ND trigger for sym_trigger_router_grouplet 2021-03-30 00:01:48,592 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_TRGGR_RTR_GRPLT_ND trigger for sym_trigger_router_grouplet 2021-03-30 00:01:48,643 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_ND_HST_ND trigger for sym_node_host 2021-03-30 00:01:48,660 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_ND_HST_ND trigger for sym_node_host 2021-03-30 00:01:48,677 INFO [node-002] [SqliteJdbcSymmetricDialect] [node-002-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_ND_HST_ND trigger for sym_node_host 2021-03-30 00:01:48,692 INFO [node-002] [TriggerRouterService] [node-002-job-14] Done synchronizing triggers 2021-03-30 00:01:48,804 INFO [node-002] [RegistrationService] [node-002-job-14] Successfully registered node [id=002] 2021-03-30 00:01:48,805 INFO [node-002] [ExtensionService] [node-002-job-14] Found 0 extension points from the database that will be registered 2021-03-30 00:01:48,806 INFO [node-002] [ClientExtensionService] [node-002-job-14] Found 8 extension points from spring that will be registered 2021-03-30 00:01:48,807 INFO [node-002] [PushHeartbeatListener] [node-002-job-14] Some attribute(s) of node changed. Recording changes 2021-03-30 00:01:48,808 INFO [node-002] [PushHeartbeatListener] [node-002-job-14] Updating my node configuration info according to the symmetric properties 2021-03-30 00:01:49,074 INFO [node-002] [PullService] [node-002-job-14] Node node:002 just registered, not pulling yet 2021-03-30 00:01:52,222 INFO [node-001] [ConfigurationChangedDatabaseWriterFilter] [node-001-dataloader-1] Grouplets flushed because new grouplet config came through the data loader 2021-03-30 00:01:52,222 INFO [node-001] [ConfigurationChangedDatabaseWriterFilter] [node-001-dataloader-1] Load filters flushed because new filter config came through the data loader 2021-03-30 00:01:52,224 INFO [node-001] [ConfigurationChangedDatabaseWriterFilter] [node-001-dataloader-1] Channels flushed because new channels came through the data loader 2021-03-30 00:01:52,224 INFO [node-001] [ConfigurationChangedDatabaseWriterFilter] [node-001-dataloader-1] About to refresh the cache of conflict settings because new configuration came through the data loader 2021-03-30 00:01:52,225 INFO [node-001] [ConfigurationChangedDatabaseWriterFilter] [node-001-dataloader-1] About to refresh the cache of parameters because new configuration came through the data loader 2021-03-30 00:01:52,231 INFO [node-001] [ConfigurationChangedDatabaseWriterFilter] [node-001-dataloader-1] Extensions flushed because new extensions came through the data loader 2021-03-30 00:01:52,232 INFO [node-001] [ExtensionService] [node-001-dataloader-1] Found 0 extension points from the database that will be registered 2021-03-30 00:01:52,232 INFO [node-001] [ClientExtensionService] [node-001-dataloader-1] Found 8 extension points from spring that will be registered 2021-03-30 00:01:52,233 INFO [node-001] [ConfigurationChangedDatabaseWriterFilter] [node-001-dataloader-1] About to refresh the cache of node security because new configuration came through the data loader 2021-03-30 00:01:52,236 INFO [node-001] [ConfigurationChangedDatabaseWriterFilter] [node-001-job-2] About to refresh the cache of transformation because new configuration came through the data loader 2021-03-30 00:01:52,237 INFO [node-001] [ConfigurationChangedDatabaseWriterFilter] [node-001-job-2] About to clear the staging area because new transform configuration came through the data loader 2021-03-30 00:01:52,238 INFO [node-001] [StagingManager] [node-001-job-2] Cleaning staging... 2021-03-30 00:01:52,280 INFO [node-001] [StagingManager] [node-001-job-2] Purged 17 staging files, freed 21 KB of disk space. 2021-03-30 00:01:52,280 INFO [node-001] [StagingManager] [node-001-job-2] Finished cleaning staging in 0 seconds. 2021-03-30 00:01:52,282 INFO [node-001] [ConfigurationChangedDatabaseWriterFilter] [node-001-job-2] About to syncTriggers because new configuration came through the data loader 2021-03-30 00:01:52,282 INFO [node-001] [TriggerRouterService] [node-001-job-2] Synchronizing triggers 2021-03-30 00:01:52,320 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_RTR_ND trigger for sym_router 2021-03-30 00:01:52,337 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_RTR_ND trigger for sym_router 2021-03-30 00:01:52,353 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_RTR_ND trigger for sym_router 2021-03-30 00:01:52,417 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_TRNSFRM_TBL_ND trigger for sym_transform_table 2021-03-30 00:01:52,433 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_TRNSFRM_TBL_ND trigger for sym_transform_table 2021-03-30 00:01:52,450 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_TRNSFRM_TBL_ND trigger for sym_transform_table 2021-03-30 00:01:52,492 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_I_FOR_MT_ND trigger for Meet 2021-03-30 00:01:52,506 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_U_FOR_MT_ND trigger for Meet 2021-03-30 00:01:52,520 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_D_FOR_MT_ND trigger for Meet 2021-03-30 00:01:52,540 INFO [node-002] [NodeCommunicationService] [node-002-job-1] push will use 10 threads 2021-03-30 00:01:52,561 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_PRMTR_ND trigger for sym_parameter 2021-03-30 00:01:52,574 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_PRMTR_ND trigger for sym_parameter 2021-03-30 00:01:52,590 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_PRMTR_ND trigger for sym_parameter 2021-03-30 00:01:52,628 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_FL_TRGGR_RTR_ND trigger for sym_file_trigger_router 2021-03-30 00:01:52,644 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_FL_TRGGR_RTR_ND trigger for sym_file_trigger_router 2021-03-30 00:01:52,659 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_FL_TRGGR_RTR_ND trigger for sym_file_trigger_router 2021-03-30 00:01:52,698 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_TBL_RLD_RQST_ND trigger for sym_table_reload_request 2021-03-30 00:01:52,716 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_TBL_RLD_RQST_ND trigger for sym_table_reload_request 2021-03-30 00:01:52,732 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_TBL_RLD_RQST_ND trigger for sym_table_reload_request 2021-03-30 00:01:52,795 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_GRPLT_LNK_ND trigger for sym_grouplet_link 2021-03-30 00:01:52,808 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_GRPLT_LNK_ND trigger for sym_grouplet_link 2021-03-30 00:01:52,822 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_GRPLT_LNK_ND trigger for sym_grouplet_link 2021-03-30 00:01:52,866 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_GRPLT_ND trigger for sym_grouplet 2021-03-30 00:01:52,879 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_GRPLT_ND trigger for sym_grouplet 2021-03-30 00:01:52,892 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_GRPLT_ND trigger for sym_grouplet 2021-03-30 00:01:52,933 INFO [node-002] [ConfigurationChangedDataRouter] [node-002-job-10] About to refresh the cache of nodes because new configuration came through the data router 2021-03-30 00:01:52,963 INFO [node-002] [RouterService] [node-002-job-10] Routed 2 data events in 105 ms 2021-03-30 00:01:52,966 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_FL_TRGGR_ND trigger for sym_file_trigger 2021-03-30 00:01:52,983 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_FL_TRGGR_ND trigger for sym_file_trigger 2021-03-30 00:01:53,000 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_FL_TRGGR_ND trigger for sym_file_trigger 2021-03-30 00:01:53,043 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_TRNSFRM_CLMN_ND trigger for sym_transform_column 2021-03-30 00:01:53,058 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_TRNSFRM_CLMN_ND trigger for sym_transform_column 2021-03-30 00:01:53,073 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_TRNSFRM_CLMN_ND trigger for sym_transform_column 2021-03-30 00:01:53,114 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_I_FOR_VNTS_ND trigger for Events 2021-03-30 00:01:53,128 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_U_FOR_VNTS_ND trigger for Events 2021-03-30 00:01:53,145 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_D_FOR_VNTS_ND trigger for Events 2021-03-30 00:01:53,186 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_JB_ND trigger for sym_job 2021-03-30 00:01:53,201 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_JB_ND trigger for sym_job 2021-03-30 00:01:53,217 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_JB_ND trigger for sym_job 2021-03-30 00:01:53,260 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_TRGGR_RTR_ND trigger for sym_trigger_router 2021-03-30 00:01:53,275 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_TRGGR_RTR_ND trigger for sym_trigger_router 2021-03-30 00:01:53,289 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_TRGGR_RTR_ND trigger for sym_trigger_router 2021-03-30 00:01:53,331 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_ND_ND trigger for sym_node 2021-03-30 00:01:53,348 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_ND_ND trigger for sym_node 2021-03-30 00:01:53,366 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_ND_ND trigger for sym_node 2021-03-30 00:01:53,409 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_I_FOR_SWMMRS_ND trigger for Swimmers 2021-03-30 00:01:53,425 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_U_FOR_SWMMRS_ND trigger for Swimmers 2021-03-30 00:01:53,440 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_D_FOR_SWMMRS_ND trigger for Swimmers 2021-03-30 00:01:53,483 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_I_FOR_SSSNS_ND trigger for Sessions 2021-03-30 00:01:53,496 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_U_FOR_SSSNS_ND trigger for Sessions 2021-03-30 00:01:53,508 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_D_FOR_SSSNS_ND trigger for Sessions 2021-03-30 00:01:53,552 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_ND_GRP_CHNNL_WND_ND trigger for sym_node_group_channel_wnd 2021-03-30 00:01:53,567 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_ND_GRP_CHNNL_WND_ND trigger for sym_node_group_channel_wnd 2021-03-30 00:01:53,581 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_ND_GRP_CHNNL_WND_ND trigger for sym_node_group_channel_wnd 2021-03-30 00:01:53,624 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_NTFCTN_ND trigger for sym_notification 2021-03-30 00:01:53,642 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_NTFCTN_ND trigger for sym_notification 2021-03-30 00:01:53,658 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_NTFCTN_ND trigger for sym_notification 2021-03-30 00:01:53,702 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_ND_GRP_LNK_ND trigger for sym_node_group_link 2021-03-30 00:01:53,718 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_ND_GRP_LNK_ND trigger for sym_node_group_link 2021-03-30 00:01:53,734 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_ND_GRP_LNK_ND trigger for sym_node_group_link 2021-03-30 00:01:53,777 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_ND_GRP_ND trigger for sym_node_group 2021-03-30 00:01:53,791 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_ND_GRP_ND trigger for sym_node_group 2021-03-30 00:01:53,805 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_ND_GRP_ND trigger for sym_node_group 2021-03-30 00:01:53,848 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_I_FOR_QLFYNG_TMS_ND trigger for Qualifying_Times 2021-03-30 00:01:53,862 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_U_FOR_QLFYNG_TMS_ND trigger for Qualifying_Times 2021-03-30 00:01:53,875 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_D_FOR_QLFYNG_TMS_ND trigger for Qualifying_Times 2021-03-30 00:01:53,923 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_ND_SCRTY_ND trigger for sym_node_security 2021-03-30 00:01:53,939 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_ND_SCRTY_ND trigger for sym_node_security 2021-03-30 00:01:53,955 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_ND_SCRTY_ND trigger for sym_node_security 2021-03-30 00:01:54,001 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_LD_FLTR_ND trigger for sym_load_filter 2021-03-30 00:01:54,018 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_LD_FLTR_ND trigger for sym_load_filter 2021-03-30 00:01:54,034 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_LD_FLTR_ND trigger for sym_load_filter 2021-03-30 00:01:54,081 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_MNTR_ND trigger for sym_monitor 2021-03-30 00:01:54,098 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_MNTR_ND trigger for sym_monitor 2021-03-30 00:01:54,114 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_MNTR_ND trigger for sym_monitor 2021-03-30 00:01:54,158 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_XTNSN_ND trigger for sym_extension 2021-03-30 00:01:54,174 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_XTNSN_ND trigger for sym_extension 2021-03-30 00:01:54,189 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_XTNSN_ND trigger for sym_extension 2021-03-30 00:01:54,237 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_CNFLCT_ND trigger for sym_conflict 2021-03-30 00:01:54,254 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_CNFLCT_ND trigger for sym_conflict 2021-03-30 00:01:54,271 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_CNFLCT_ND trigger for sym_conflict 2021-03-30 00:01:54,319 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_TRGGR_ND trigger for sym_trigger 2021-03-30 00:01:54,342 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_TRGGR_ND trigger for sym_trigger 2021-03-30 00:01:54,363 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_TRGGR_ND trigger for sym_trigger 2021-03-30 00:01:54,417 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_CHNNL_ND trigger for sym_channel 2021-03-30 00:01:54,438 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_CHNNL_ND trigger for sym_channel 2021-03-30 00:01:54,456 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_CHNNL_ND trigger for sym_channel 2021-03-30 00:01:54,508 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_I_FOR_CLBS_ND trigger for Clubs 2021-03-30 00:01:54,521 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_U_FOR_CLBS_ND trigger for Clubs 2021-03-30 00:01:54,535 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_D_FOR_CLBS_ND trigger for Clubs 2021-03-30 00:01:54,583 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_TRGGR_RTR_GRPLT_ND trigger for sym_trigger_router_grouplet 2021-03-30 00:01:54,598 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_TRGGR_RTR_GRPLT_ND trigger for sym_trigger_router_grouplet 2021-03-30 00:01:54,613 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_TRGGR_RTR_GRPLT_ND trigger for sym_trigger_router_grouplet 2021-03-30 00:01:54,665 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_I_FOR_SYM_ND_HST_ND trigger for sym_node_host 2021-03-30 00:01:54,681 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_U_FOR_SYM_ND_HST_ND trigger for sym_node_host 2021-03-30 00:01:54,698 INFO [node-001] [SqliteJdbcSymmetricDialect] [node-001-sync-triggers-1] Creating SYM_ON_D_FOR_SYM_ND_HST_ND trigger for sym_node_host 2021-03-30 00:01:54,712 INFO [node-001] [TriggerRouterService] [node-001-job-2] Done synchronizing triggers 2021-03-30 00:01:54,822 INFO [node-001] [RegistrationService] [node-001-job-2] Successfully registered node [id=001] 2021-03-30 00:01:54,823 INFO [node-001] [ExtensionService] [node-001-job-2] Found 0 extension points from the database that will be registered 2021-03-30 00:01:54,824 INFO [node-001] [ClientExtensionService] [node-001-job-2] Found 8 extension points from spring that will be registered 2021-03-30 00:01:54,825 INFO [node-001] [PushHeartbeatListener] [node-001-job-2] Some attribute(s) of node changed. Recording changes 2021-03-30 00:01:54,825 INFO [node-001] [PushHeartbeatListener] [node-001-job-2] Updating my node configuration info according to the symmetric properties 2021-03-30 00:01:54,884 INFO [node-001] [DataService] [node-001-job-19] Inserting missing last data gap: { startId: 1, endId: 50000001, createTime: "Tue Mar 30 00:01:54 BST 2021" } 2021-03-30 00:01:54,896 INFO [node-001] [DataGapFastDetector] [node-001-job-19] Full gap analysis is running 2021-03-30 00:01:54,897 INFO [node-001] [DataGapFastDetector] [node-001-job-19] Querying data in gaps from database took 1 ms 2021-03-30 00:01:54,898 INFO [node-001] [DataGapFastDetector] [node-001-job-19] Full gap analysis is done after 2 ms 2021-03-30 00:01:54,973 INFO [node-001] [ConfigurationChangedDataRouter] [node-001-job-19] About to refresh the cache of nodes because new configuration came through the data router 2021-03-30 00:01:54,973 INFO [node-001] [RouterService] [node-001-job-19] Routed 1 data events in 77 ms 2021-03-30 00:01:55,102 INFO [node-001] [PullService] [node-001-job-2] Node node:001 just registered, not pulling yet 2021-03-30 00:01:56,374 INFO [master-000] [ConfigurationChangedDataRouter] [master-000-job-19] About to refresh the cache of node security because new configuration came through the data router 2021-03-30 00:01:56,469 INFO [master-000] [RouterService] [master-000-job-19] Routed 1 data events in 3213 ms 2021-03-30 00:01:58,216 INFO [master-000] [InitialLoadService] [master-000-job-4] Creating load request from node 000 to node 001 2021-03-30 00:01:58,783 INFO [master-000] [PushService] [master-000-push-default-3] Push data sent to node:001:001 2021-03-30 00:01:58,784 INFO [node-001] [DataLoaderService] [qtp647973805-18] 2 data and 2 batches loaded during push request from master:000:000 2021-03-30 00:01:59,076 INFO [node-002] [NodeCommunicationService] [node-002-job-19] pull will use 10 threads 2021-03-30 00:01:59,720 INFO [node-001] [NodeCommunicationService] [node-001-job-8] push will use 10 threads 2021-03-30 00:02:00,020 INFO [node-001] [ConfigurationChangedDataRouter] [node-001-job-4] About to refresh the cache of nodes because new configuration came through the data router 2021-03-30 00:02:00,040 INFO [master-000] [InitialLoadService] [master-000-job-4] Creating load request from node 000 to node 002 2021-03-30 00:02:00,057 INFO [node-001] [RouterService] [node-001-job-4] Routed 3 data events in 72 ms 2021-03-30 00:02:00,358 INFO [node-001] [PushService] [node-001-push-default-1] Push data sent to master:000:000 2021-03-30 00:02:00,709 INFO [master-000] [PushService] [master-000-push-default-3] Pushed data to node node:001:001. 2 data and 2 batches were processed. (sym_node, sym_node_host) 2021-03-30 00:02:01,624 INFO [master-000] [PushService] [master-000-push-default-2] Push data sent to node:002:002 2021-03-30 00:02:01,625 INFO [node-002] [DataLoaderService] [qtp647973805-18] 2 data and 2 batches loaded during push request from master:000:000 2021-03-30 00:02:03,011 INFO [node-002] [ConfigurationChangedDataRouter] [node-002-job-9] About to refresh the cache of nodes because new configuration came through the data router 2021-03-30 00:02:03,017 INFO [master-000] [InitialLoadService] [master-000-job-4] Found 2 table reload requests to process. 2021-03-30 00:02:03,035 INFO [node-002] [RouterService] [node-002-job-9] Routed 2 data events in 60 ms 2021-03-30 00:02:03,108 INFO [master-000] [DataLoaderService] [qtp647973805-17] 1 data and 1 batches loaded during push request from node:001:001 2021-03-30 00:02:03,269 INFO [node-002] [PushService] [node-002-push-default-2] Push data sent to master:000:000 2021-03-30 00:02:03,543 INFO [master-000] [PushService] [master-000-push-default-2] Pushed data to node node:002:002. 2 data and 2 batches were processed. (sym_node, sym_node_host) 2021-03-30 00:02:03,707 INFO [node-001] [PushService] [node-001-push-default-1] Pushed data to node master:000:000. 1 data and 1 batches were processed. (sym_node) 2021-03-30 00:02:03,735 INFO [node-001] [PushService] [node-001-push-default-1] Push data sent to master:000:000 2021-03-30 00:02:05,102 INFO [node-001] [NodeCommunicationService] [node-001-job-18] pull will use 10 threads 2021-03-30 00:02:05,190 INFO [node-002] [ConfigurationChangedDatabaseWriterFilter] [node-002-dataloader-3] About to refresh the cache of node security because new configuration came through the data loader 2021-03-30 00:02:05,275 INFO [master-000] [DataLoaderService] [qtp647973805-15] 1 data and 1 batches loaded during push request from node:001:001 2021-03-30 00:02:05,515 INFO [master-000] [PushService] [master-000-push-default-2] Push data sent to node:002:002 2021-03-30 00:02:05,516 INFO [node-002] [DataLoaderService] [qtp647973805-17] 1 data and 1 batches loaded during push request from master:000:000 2021-03-30 00:02:05,870 INFO [node-001] [PushService] [node-001-push-default-1] Pushed data to node master:000:000. 1 data and 1 batches were processed. (sym_node_host) 2021-03-30 00:02:05,925 INFO [master-000] [DataService] [master-000-job-4] Queueing up an initial load to node 001 2021-03-30 00:02:06,423 INFO [master-000] [DataLoaderService] [qtp647973805-19] 2 data and 2 batches loaded during push request from node:002:002 2021-03-30 00:02:06,517 INFO [master-000] [PushService] [master-000-push-default-2] Pushed data to node node:002:002. 1 data and 1 batches were processed. (sym_node_security) 2021-03-30 00:02:07,061 INFO [node-002] [PushService] [node-002-push-default-2] Pushed data to node master:000:000. 2 data and 2 batches were processed. (sym_node, sym_node_host) 2021-03-30 00:02:07,478 INFO [master-000] [ConfigurationChangedDataRouter] [master-000-job-10] About to refresh the cache of nodes because new configuration came through the data router 2021-03-30 00:02:07,478 INFO [master-000] [ConfigurationChangedDataRouter] [master-000-job-10] About to refresh the cache of node security because new configuration came through the data router 2021-03-30 00:02:07,573 INFO [master-000] [RouterService] [master-000-job-10] Routed 6 data events in 5629 ms 2021-03-30 00:02:08,079 INFO [node-002] [ConfigurationChangedDataRouter] [node-002-job-9] About to refresh the cache of node security because new configuration came through the data router 2021-03-30 00:02:08,079 INFO [node-002] [RouterService] [node-002-job-9] Routed 1 data events in 33 ms 2021-03-30 00:02:16,168 INFO [node-001] [ConfigurationChangedDatabaseWriterFilter] [node-001-dataloader-3] About to refresh the cache of node security because new configuration came through the data loader 2021-03-30 00:02:16,480 INFO [master-000] [PushService] [master-000-push-default-4] Push data sent to node:002:002 2021-03-30 00:02:16,481 INFO [node-002] [DataLoaderService] [qtp647973805-15] 1 data and 1 batches loaded during push request from master:000:000 2021-03-30 00:02:16,487 INFO [master-000] [PushService] [master-000-push-default-6] Push data sent to node:001:001 2021-03-30 00:02:16,488 INFO [node-001] [DataLoaderService] [qtp647973805-76] 2 data and 1 batches loaded during push request from master:000:000 2021-03-30 00:02:17,086 INFO [master-000] [ConfigurationChangedDataRouter] [master-000-job-5] About to refresh the cache of nodes because new configuration came through the data router 2021-03-30 00:02:17,450 INFO [master-000] [PushService] [master-000-push-default-4] Pushed data to node node:002:002. 1 data and 1 batches were processed. (sym_table_reload_request) 2021-03-30 00:02:17,466 INFO [master-000] [PushService] [master-000-push-default-6] Pushed data to node node:001:001. 2 data and 1 batches were processed. (sym_node_security, sym_table_reload_request) 2021-03-30 00:02:18,129 INFO [node-002] [RouterService] [node-002-job-13] Routed 1 data events in 36 ms 2021-03-30 00:02:19,691 INFO [master-000] [RouterService] [master-000-job-5] Routed 4 data events in 6628 ms 2021-03-30 00:02:20,100 INFO [node-001] [ConfigurationChangedDataRouter] [node-001-job-14] About to refresh the cache of node security because new configuration came through the data router 2021-03-30 00:02:20,101 INFO [node-001] [RouterService] [node-001-job-14] Routed 2 data events in 27 ms 2021-03-30 00:02:20,561 INFO [master-000] [PushService] [master-000-push-default-6] Push data sent to node:001:001 2021-03-30 00:02:20,562 INFO [node-001] [DataLoaderService] [qtp647973805-74] 1 data and 1 batches loaded during push request from master:000:000 2021-03-30 00:02:21,519 INFO [master-000] [PushService] [master-000-push-default-6] Pushed data to node node:001:001. 1 data and 1 batches were processed. (sym_table_reload_request) 2021-03-30 00:02:25,150 INFO [node-001] [RouterService] [node-001-job-19] Routed 1 data events in 37 ms 2021-03-30 00:02:26,564 INFO [master-000] [DataService] [master-000-job-4] Table reload request(s) for load id 2 have been processed. 2021-03-30 00:02:26,868 INFO [master-000] [PurgeService] [master-000-job-4] Purged all 2 incoming batch for node 001 2021-03-30 00:02:27,116 INFO [master-000] [NodeCommunicationService] [master-000-job-6] extract will use 20 threads 2021-03-30 00:02:28,111 INFO [master-000] [DataService] [master-000-job-4] Queueing up an initial load to node 002 2021-03-30 00:02:32,849 INFO [master-000] [DataExtractorService] [master-000-extract-default-1] Starting request 2 to extract table Meet into batches 22 through 22 for node 001. 2021-03-30 00:02:36,676 INFO [node-001] [ConfigurationChangedDatabaseWriterFilter] [node-001-dataloader-5] Initial load started for me 2021-03-30 00:02:36,687 INFO [node-001] [ConfigurationChangedDatabaseWriterFilter] [node-001-dataloader-5] About to refresh the cache of node security because new configuration came through the data loader 2021-03-30 00:02:36,925 INFO [master-000] [ConfigurationChangedDataRouter] [master-000-job-3] About to refresh the cache of node security because new configuration came through the data router 2021-03-30 00:02:37,014 INFO [master-000] [DataExtractorService] [master-000-extract-default-1] Done with request 2 to extract table Meet into batches 22 through 22 for node 001 2021-03-30 00:02:37,202 INFO [master-000] [DataExtractorService] [master-000-extract-default-1] Starting request 3 to extract table Sessions into batches 23 through 23 for node 001. 2021-03-30 00:02:37,786 INFO [master-000] [RouterService] [master-000-job-3] Routed 3 data events in 5527 ms 2021-03-30 00:02:39,815 INFO [master-000] [DataService] [master-000-job-4] Table reload request(s) for load id 3 have been processed. 2021-03-30 00:02:40,112 INFO [master-000] [PurgeService] [master-000-job-4] Purged all 2 incoming batch for node 002 2021-03-30 00:02:40,148 INFO [node-001] [ConfigurationChangedDatabaseWriterFilter] [node-001-dataloader-5] About to refresh the cache of nodes because new configuration came through the data loader 2021-03-30 00:02:40,191 INFO [node-001] [ConfigurationChangedDataRouter] [node-001-job-13] About to refresh the cache of node security because new configuration came through the data router 2021-03-30 00:02:40,191 INFO [node-001] [RouterService] [node-001-job-13] Routed 1 data events in 25 ms 2021-03-30 00:02:40,209 INFO [master-000] [DataExtractorService] [master-000-job-4] Releasing 1 child extract requests that missed processing by parent node 2021-03-30 00:02:40,307 ERROR [master-000] [InitialLoadService] [master-000-job-4] Error while queuing initial loads StackTraceKey.init [SqlException:2046816050] org.jumpmind.db.sql.SqlException: (conn=97) You can't specify target table 'sym_extract_request' for update in FROM clause at org.jumpmind.db.sql.AbstractSqlTemplate.translate(AbstractSqlTemplate.java:313) at org.jumpmind.db.sql.AbstractSqlTemplate.translate(AbstractSqlTemplate.java:302) at org.jumpmind.db.sql.JdbcSqlTemplate.execute(JdbcSqlTemplate.java:523) at org.jumpmind.db.sql.JdbcSqlTemplate.update(JdbcSqlTemplate.java:362) at org.jumpmind.db.sql.AbstractSqlTemplate.update(AbstractSqlTemplate.java:235) at org.jumpmind.symmetric.service.impl.DataExtractorService.releaseMissedExtractRequests(DataExtractorService.java:2288) at org.jumpmind.symmetric.service.impl.DataService.insertReloadEvents(DataService.java:1095) at org.jumpmind.symmetric.service.impl.InitialLoadService.processTableRequestLoads(InitialLoadService.java:282) at org.jumpmind.symmetric.service.impl.InitialLoadService.queueLoads(InitialLoadService.java:98) at org.jumpmind.symmetric.job.InitialLoadJob.doJob(InitialLoadJob.java:43) at org.jumpmind.symmetric.job.AbstractJob.invoke(AbstractJob.java:227) at org.jumpmind.symmetric.job.AbstractJob.run(AbstractJob.java:298) at org.springframework.scheduling.support.DelegatingErrorHandlingRunnable.run(DelegatingErrorHandlingRunnable.java:54) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515) at java.base/java.util.concurrent.FutureTask.runAndReset(FutureTask.java:305) at java.base/java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:305) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:630) at java.base/java.lang.Thread.run(Thread.java:832) Caused by: java.sql.SQLTransientConnectionException: (conn=97) You can't specify target table 'sym_extract_request' for update in FROM clause at org.mariadb.jdbc.internal.util.exceptions.ExceptionFactory.createException(ExceptionFactory.java:79) at org.mariadb.jdbc.internal.util.exceptions.ExceptionFactory.create(ExceptionFactory.java:153) at org.mariadb.jdbc.MariaDbStatement.executeExceptionEpilogue(MariaDbStatement.java:274) at org.mariadb.jdbc.ClientSidePreparedStatement.executeInternal(ClientSidePreparedStatement.java:229) at org.mariadb.jdbc.ClientSidePreparedStatement.execute(ClientSidePreparedStatement.java:149) at org.apache.commons.dbcp.DelegatingPreparedStatement.execute(DelegatingPreparedStatement.java:172) at org.apache.commons.dbcp.DelegatingPreparedStatement.execute(DelegatingPreparedStatement.java:172) at org.jumpmind.db.sql.JdbcSqlTemplate$5.execute(JdbcSqlTemplate.java:399) at org.jumpmind.db.sql.JdbcSqlTemplate$5.execute(JdbcSqlTemplate.java:362) at org.jumpmind.db.sql.JdbcSqlTemplate.execute(JdbcSqlTemplate.java:521) ... 16 more Caused by: org.mariadb.jdbc.internal.util.exceptions.MariaDbSqlException: You can't specify target table 'sym_extract_request' for update in FROM clause at org.mariadb.jdbc.internal.util.exceptions.MariaDbSqlException.of(MariaDbSqlException.java:34) at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.exceptionWithQuery(AbstractQueryProtocol.java:192) at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.exceptionWithQuery(AbstractQueryProtocol.java:175) at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.executeQuery(AbstractQueryProtocol.java:319) at jdk.internal.reflect.GeneratedMethodAccessor46.invoke(Unknown Source) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:564) at org.mariadb.jdbc.internal.failover.impl.MastersReplicasListener.invoke(MastersReplicasListener.java:233) at org.mariadb.jdbc.internal.failover.FailoverProxy.executeInvocation(FailoverProxy.java:301) at org.mariadb.jdbc.internal.failover.FailoverProxy.invoke(FailoverProxy.java:294) at com.sun.proxy.$Proxy50.executeQuery(Unknown Source) at org.mariadb.jdbc.ClientSidePreparedStatement.executeInternal(ClientSidePreparedStatement.java:220) ... 22 more Caused by: java.sql.SQLException: You can't specify target table 'sym_extract_request' for update in FROM clause at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.readErrorPacket(AbstractQueryProtocol.java:1681) at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.readPacket(AbstractQueryProtocol.java:1543) at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.getResult(AbstractQueryProtocol.java:1506) at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.executeQuery(AbstractQueryProtocol.java:316) ... 30 more 2021-03-30 00:02:41,342 INFO [master-000] [DataExtractorService] [master-000-extract-default-1] Done with request 3 to extract table Sessions into batches 23 through 23 for node 001 2021-03-30 00:02:41,531 INFO [master-000] [DataExtractorService] [master-000-extract-default-1] Releasing 2 child extract requests that missed processing by parent node 2021-03-30 00:02:41,625 WARN [master-000] [DataExtractorService] [master-000-extract-default-1] Failed on request 3 to extract table Sessions into batches 23 through 23 for node 001 2021-03-30 00:02:41,626 ERROR [master-000] [NodeCommunicationService] [master-000-extract-default-1] Failed to execute EXTRACT for node 001 and channel default StackTraceKey.init [SqlException:2523666910] org.jumpmind.db.sql.SqlException: (conn=104) You can't specify target table 'sym_extract_request' for update in FROM clause at org.jumpmind.db.sql.AbstractSqlTemplate.translate(AbstractSqlTemplate.java:313) at org.jumpmind.db.sql.AbstractSqlTemplate.translate(AbstractSqlTemplate.java:302) at org.jumpmind.db.sql.JdbcSqlTemplate.execute(JdbcSqlTemplate.java:523) at org.jumpmind.db.sql.JdbcSqlTemplate.update(JdbcSqlTemplate.java:362) at org.jumpmind.db.sql.AbstractSqlTemplate.update(AbstractSqlTemplate.java:235) at org.jumpmind.symmetric.service.impl.DataExtractorService.releaseMissedExtractRequests(DataExtractorService.java:2288) at org.jumpmind.symmetric.service.impl.DataExtractorService.execute(DataExtractorService.java:2159) at org.jumpmind.symmetric.service.impl.NodeCommunicationService$1.run(NodeCommunicationService.java:536) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:630) at java.base/java.lang.Thread.run(Thread.java:832) Caused by: java.sql.SQLTransientConnectionException: (conn=104) You can't specify target table 'sym_extract_request' for update in FROM clause at org.mariadb.jdbc.internal.util.exceptions.ExceptionFactory.createException(ExceptionFactory.java:79) at org.mariadb.jdbc.internal.util.exceptions.ExceptionFactory.create(ExceptionFactory.java:153) at org.mariadb.jdbc.MariaDbStatement.executeExceptionEpilogue(MariaDbStatement.java:274) at org.mariadb.jdbc.ClientSidePreparedStatement.executeInternal(ClientSidePreparedStatement.java:229) at org.mariadb.jdbc.ClientSidePreparedStatement.execute(ClientSidePreparedStatement.java:149) at org.apache.commons.dbcp.DelegatingPreparedStatement.execute(DelegatingPreparedStatement.java:172) at org.apache.commons.dbcp.DelegatingPreparedStatement.execute(DelegatingPreparedStatement.java:172) at org.jumpmind.db.sql.JdbcSqlTemplate$5.execute(JdbcSqlTemplate.java:399) at org.jumpmind.db.sql.JdbcSqlTemplate$5.execute(JdbcSqlTemplate.java:362) at org.jumpmind.db.sql.JdbcSqlTemplate.execute(JdbcSqlTemplate.java:521) ... 8 more Caused by: org.mariadb.jdbc.internal.util.exceptions.MariaDbSqlException: You can't specify target table 'sym_extract_request' for update in FROM clause at org.mariadb.jdbc.internal.util.exceptions.MariaDbSqlException.of(MariaDbSqlException.java:34) at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.exceptionWithQuery(AbstractQueryProtocol.java:192) at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.exceptionWithQuery(AbstractQueryProtocol.java:175) at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.executeQuery(AbstractQueryProtocol.java:319) at jdk.internal.reflect.GeneratedMethodAccessor46.invoke(Unknown Source) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:564) at org.mariadb.jdbc.internal.failover.impl.MastersReplicasListener.invoke(MastersReplicasListener.java:233) at org.mariadb.jdbc.internal.failover.FailoverProxy.executeInvocation(FailoverProxy.java:301) at org.mariadb.jdbc.internal.failover.FailoverProxy.invoke(FailoverProxy.java:294) at com.sun.proxy.$Proxy50.executeQuery(Unknown Source) at org.mariadb.jdbc.ClientSidePreparedStatement.executeInternal(ClientSidePreparedStatement.java:220) ... 14 more Caused by: java.sql.SQLException: You can't specify target table 'sym_extract_request' for update in FROM clause at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.readErrorPacket(AbstractQueryProtocol.java:1681) at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.readPacket(AbstractQueryProtocol.java:1543) at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.getResult(AbstractQueryProtocol.java:1506) at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.executeQuery(AbstractQueryProtocol.java:316) ... 22 more 2021-03-30 00:02:41,656 INFO [master-000] [PushService] [master-000-push-default-1] Push data sent to node:001:001 2021-03-30 00:02:41,657 INFO [node-001] [DataLoaderService] [qtp647973805-15] 3 data and 3 batches loaded during push request from master:000:000 2021-03-30 00:02:46,309 INFO [master-000] [PushService] [master-000-push-default-1] Pushed data to node node:001:001. 3 data and 3 batches were processed. (sym_node_security, sym_node, meet) 2021-03-30 00:02:46,310 INFO [master-000] [PushService] [master-000-push-default-1] Pushing to node:001:001 again because the last push contained reload batches 2021-03-30 00:02:46,959 INFO [master-000] [ConfigurationChangedDataRouter] [master-000-job-19] About to refresh the cache of node security because new configuration came through the data router 2021-03-30 00:02:47,816 INFO [master-000] [RouterService] [master-000-job-19] Routed 2 data events in 4452 ms 2021-03-30 00:02:47,922 INFO [node-001] [ConfigurationChangedDatabaseWriterFilter] [node-001-dataloader-6] About to refresh the cache of node security because new configuration came through the data loader 2021-03-30 00:02:48,202 INFO [node-002] [RouterService] [node-002-job-15] Routed 1 data events in 55 ms 2021-03-30 00:02:48,226 INFO [node-002] [ConfigurationChangedDatabaseWriterFilter] [node-002-dataloader-5] Initial load started for me 2021-03-30 00:02:48,237 INFO [node-002] [ConfigurationChangedDatabaseWriterFilter] [node-002-dataloader-5] About to refresh the cache of node security because new configuration came through the data loader 2021-03-30 00:02:49,088 INFO [master-000] [PushService] [master-000-push-default-1] Push data sent to node:001:001 2021-03-30 00:02:49,088 INFO [node-001] [DataLoaderService] [qtp647973805-76] 2 data and 2 batches loaded during push request from master:000:000 2021-03-30 00:02:49,222 INFO [node-002] [ConfigurationChangedDatabaseWriterFilter] [node-002-dataloader-5] About to refresh the cache of nodes because new configuration came through the data loader 2021-03-30 00:02:49,951 INFO [master-000] [PushService] [master-000-push-default-10] Push data sent to node:002:002 2021-03-30 00:02:49,952 INFO [node-002] [DataLoaderService] [qtp647973805-18] 3 data and 3 batches loaded during push request from master:000:000 2021-03-30 00:02:50,229 INFO [node-001] [ConfigurationChangedDataRouter] [node-001-job-16] About to refresh the cache of node security because new configuration came through the data router 2021-03-30 00:02:50,230 INFO [node-001] [RouterService] [node-001-job-16] Routed 2 data events in 26 ms 2021-03-30 00:02:51,780 INFO [master-000] [PushService] [master-000-push-default-1] Pushed data to node node:001:001. 2 data and 2 batches were processed. (sym_node_security, sym_table_reload_request, sessions) 2021-03-30 00:02:51,781 INFO [master-000] [PushService] [master-000-push-default-1] Pushing to node:001:001 again because the last push contained reload batches 2021-03-30 00:02:53,245 INFO [node-002] [ConfigurationChangedDataRouter] [node-002-job-2] About to refresh the cache of node security because new configuration came through the data router 2021-03-30 00:02:53,245 INFO [node-002] [RouterService] [node-002-job-2] Routed 1 data events in 32 ms 2021-03-30 00:02:53,999 INFO [master-000] [PushService] [master-000-push-default-10] Pushed data to node node:002:002. 3 data and 3 batches were processed. (sym_table_reload_request, sym_node_security, sym_node) 2021-03-30 00:02:53,999 INFO [master-000] [PushService] [master-000-push-default-10] Pushing to node:002:002 again because the last push contained reload batches 2021-03-30 00:02:55,143 INFO [master-000] [DataExtractorService] [master-000-extract-default-2] Starting request 4 to extract table Events into batches 24 through 24 for node 001. 2021-03-30 00:02:55,614 INFO [node-002] [ConfigurationChangedDatabaseWriterFilter] [node-002-dataloader-6] About to refresh the cache of node security because new configuration came through the data loader 2021-03-30 00:02:55,942 INFO [master-000] [PushService] [master-000-push-default-10] Push data sent to node:002:002 2021-03-30 00:02:55,943 INFO [node-002] [DataLoaderService] [qtp647973805-18] 2 data and 1 batches loaded during push request from master:000:000 2021-03-30 00:02:56,108 INFO [master-000] [DataExtractorService] [master-000-extract-default-2] Ordering rows for table Events using self-referencing foreign key heat_events_number -> event_number 2021-03-30 00:02:56,109 INFO [master-000] [DataExtractorService] [master-000-extract-default-2] Querying level 0 for table Events: 1=1 and (heat_events_number is null or heat_events_number = event_number) 2021-03-30 00:02:56,902 INFO [master-000] [PushService] [master-000-push-default-10] Pushed data to node node:002:002. 2 data and 1 batches were processed. (sym_node_security, sym_table_reload_request) 2021-03-30 00:02:58,287 INFO [node-002] [ConfigurationChangedDataRouter] [node-002-job-2] About to refresh the cache of node security because new configuration came through the data router 2021-03-30 00:02:58,287 INFO [node-002] [RouterService] [node-002-job-2] Routed 2 data events in 28 ms 2021-03-30 00:03:00,357 INFO [master-000] [DataExtractorService] [master-000-extract-default-2] Done with request 4 to extract table Events into batches 24 through 24 for node 001 2021-03-30 00:03:00,546 INFO [master-000] [DataExtractorService] [master-000-extract-default-2] Releasing 2 child extract requests that missed processing by parent node 2021-03-30 00:03:00,640 WARN [master-000] [DataExtractorService] [master-000-extract-default-2] Failed on request 4 to extract table Events into batches 24 through 24 for node 001 2021-03-30 00:03:00,641 ERROR [master-000] [NodeCommunicationService] [master-000-extract-default-2] Failed to execute EXTRACT for node 001 and channel default StackTraceKey.init [SqlException:3773053937] org.jumpmind.db.sql.SqlException: (conn=99) You can't specify target table 'sym_extract_request' for update in FROM clause at org.jumpmind.db.sql.AbstractSqlTemplate.translate(AbstractSqlTemplate.java:313) at org.jumpmind.db.sql.AbstractSqlTemplate.translate(AbstractSqlTemplate.java:302) at org.jumpmind.db.sql.JdbcSqlTemplate.execute(JdbcSqlTemplate.java:523) at org.jumpmind.db.sql.JdbcSqlTemplate.update(JdbcSqlTemplate.java:362) at org.jumpmind.db.sql.AbstractSqlTemplate.update(AbstractSqlTemplate.java:235) at org.jumpmind.symmetric.service.impl.DataExtractorService.releaseMissedExtractRequests(DataExtractorService.java:2288) at org.jumpmind.symmetric.service.impl.DataExtractorService.execute(DataExtractorService.java:2159) at org.jumpmind.symmetric.service.impl.NodeCommunicationService$1.run(NodeCommunicationService.java:536) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:630) at java.base/java.lang.Thread.run(Thread.java:832) Caused by: java.sql.SQLTransientConnectionException: (conn=99) You can't specify target table 'sym_extract_request' for update in FROM clause at org.mariadb.jdbc.internal.util.exceptions.ExceptionFactory.createException(ExceptionFactory.java:79) at org.mariadb.jdbc.internal.util.exceptions.ExceptionFactory.create(ExceptionFactory.java:153) at org.mariadb.jdbc.MariaDbStatement.executeExceptionEpilogue(MariaDbStatement.java:274) at org.mariadb.jdbc.ClientSidePreparedStatement.executeInternal(ClientSidePreparedStatement.java:229) at org.mariadb.jdbc.ClientSidePreparedStatement.execute(ClientSidePreparedStatement.java:149) at org.apache.commons.dbcp.DelegatingPreparedStatement.execute(DelegatingPreparedStatement.java:172) at org.apache.commons.dbcp.DelegatingPreparedStatement.execute(DelegatingPreparedStatement.java:172) at org.jumpmind.db.sql.JdbcSqlTemplate$5.execute(JdbcSqlTemplate.java:399) at org.jumpmind.db.sql.JdbcSqlTemplate$5.execute(JdbcSqlTemplate.java:362) at org.jumpmind.db.sql.JdbcSqlTemplate.execute(JdbcSqlTemplate.java:521) ... 8 more Caused by: org.mariadb.jdbc.internal.util.exceptions.MariaDbSqlException: You can't specify target table 'sym_extract_request' for update in FROM clause at org.mariadb.jdbc.internal.util.exceptions.MariaDbSqlException.of(MariaDbSqlException.java:34) at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.exceptionWithQuery(AbstractQueryProtocol.java:192) at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.exceptionWithQuery(AbstractQueryProtocol.java:175) at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.executeQuery(AbstractQueryProtocol.java:319) at jdk.internal.reflect.GeneratedMethodAccessor46.invoke(Unknown Source) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:564) at org.mariadb.jdbc.internal.failover.impl.MastersReplicasListener.invoke(MastersReplicasListener.java:233) at org.mariadb.jdbc.internal.failover.FailoverProxy.executeInvocation(FailoverProxy.java:301) at org.mariadb.jdbc.internal.failover.FailoverProxy.invoke(FailoverProxy.java:294) at com.sun.proxy.$Proxy50.executeQuery(Unknown Source) at org.mariadb.jdbc.ClientSidePreparedStatement.executeInternal(ClientSidePreparedStatement.java:220) ... 14 more Caused by: java.sql.SQLException: You can't specify target table 'sym_extract_request' for update in FROM clause at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.readErrorPacket(AbstractQueryProtocol.java:1681) at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.readPacket(AbstractQueryProtocol.java:1543) at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.getResult(AbstractQueryProtocol.java:1506) at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.executeQuery(AbstractQueryProtocol.java:316) ... 22 more 2021-03-30 00:03:07,045 INFO [master-000] [PushService] [master-000-push-default-2] Push data sent to node:001:001 2021-03-30 00:03:07,045 INFO [node-001] [DataLoaderService] [qtp647973805-74] 0 data and 1 batches loaded during push request from master:000:000 2021-03-30 00:03:08,580 INFO [master-000] [PushService] [master-000-push-default-2] Pushed data to node node:001:001. 0 data and 1 batches were processed. (events) 2021-03-30 00:03:08,581 INFO [master-000] [PushService] [master-000-push-default-2] Pushing to node:001:001 again because the last push contained reload batches 2021-03-30 00:03:15,185 INFO [master-000] [DataExtractorService] [master-000-extract-default-3] Starting request 5 to extract table Clubs into batches 25 through 25 for node 001. 2021-03-30 00:03:20,338 INFO [master-000] [DataExtractorService] [master-000-extract-default-3] Done with request 5 to extract table Clubs into batches 25 through 25 for node 001 2021-03-30 00:03:20,534 INFO [master-000] [DataExtractorService] [master-000-extract-default-3] Releasing 2 child extract requests that missed processing by parent node 2021-03-30 00:03:20,629 WARN [master-000] [DataExtractorService] [master-000-extract-default-3] Failed on request 5 to extract table Clubs into batches 25 through 25 for node 001 2021-03-30 00:03:20,630 ERROR [master-000] [NodeCommunicationService] [master-000-extract-default-3] Failed to execute EXTRACT for node 001 and channel default StackTraceKey [SqlException:3773053937] 2021-03-30 00:03:27,052 INFO [master-000] [PushService] [master-000-push-default-9] Push data sent to node:001:001 2021-03-30 00:03:27,053 INFO [node-001] [DataLoaderService] [qtp647973805-76] 1 data and 1 batches loaded during push request from master:000:000 2021-03-30 00:03:28,629 INFO [master-000] [PushService] [master-000-push-default-9] Pushed data to node node:001:001. 1 data and 1 batches were processed. (clubs) 2021-03-30 00:03:28,629 INFO [master-000] [PushService] [master-000-push-default-9] Pushing to node:001:001 again because the last push contained reload batches 2021-03-30 00:03:35,495 INFO [master-000] [DataExtractorService] [master-000-extract-default-4] Starting request 6 to extract table Swimmers into batches 26 through 26 for node 001. 2021-03-30 00:03:40,749 INFO [master-000] [DataExtractorService] [master-000-extract-default-4] Done with request 6 to extract table Swimmers into batches 26 through 26 for node 001 2021-03-30 00:03:40,938 INFO [master-000] [DataExtractorService] [master-000-extract-default-4] Releasing 2 child extract requests that missed processing by parent node 2021-03-30 00:03:41,034 WARN [master-000] [DataExtractorService] [master-000-extract-default-4] Failed on request 6 to extract table Swimmers into batches 26 through 26 for node 001 2021-03-30 00:03:41,035 ERROR [master-000] [NodeCommunicationService] [master-000-extract-default-4] Failed to execute EXTRACT for node 001 and channel default StackTraceKey [SqlException:2523666910] 2021-03-30 00:03:44,608 INFO [master-000] [DataExtractorService] [master-000-extract-default-5] Starting request 7 to extract table Qualifying_Times into batches 27 through 27 for node 001. 2021-03-30 00:03:47,046 INFO [master-000] [PushService] [master-000-push-default-10] Push data sent to node:001:001 2021-03-30 00:03:47,047 INFO [node-001] [DataLoaderService] [qtp647973805-74] 2 data and 1 batches loaded during push request from master:000:000 2021-03-30 00:03:48,585 INFO [master-000] [PushService] [master-000-push-default-10] Pushed data to node node:001:001. 2 data and 1 batches were processed. (swimmers) 2021-03-30 00:03:48,585 INFO [master-000] [PushService] [master-000-push-default-10] Pushing to node:001:001 again because the last push contained reload batches 2021-03-30 00:03:49,855 INFO [master-000] [DataExtractorService] [master-000-extract-default-5] Done with request 7 to extract table Qualifying_Times into batches 27 through 27 for node 001 2021-03-30 00:03:50,041 INFO [master-000] [PushService] [master-000-push-default-10] Push data sent to node:001:001 2021-03-30 00:03:50,042 INFO [node-001] [DataLoaderService] [qtp647973805-19] 0 data and 1 batches loaded during push request from master:000:000 2021-03-30 00:03:50,061 INFO [master-000] [DataExtractorService] [master-000-extract-default-5] Releasing 2 child extract requests that missed processing by parent node 2021-03-30 00:03:50,155 WARN [master-000] [DataExtractorService] [master-000-extract-default-5] Failed on request 7 to extract table Qualifying_Times into batches 27 through 27 for node 001 2021-03-30 00:03:50,155 ERROR [master-000] [NodeCommunicationService] [master-000-extract-default-5] Failed to execute EXTRACT for node 001 and channel default StackTraceKey.init [SqlException:578916366] org.jumpmind.db.sql.SqlException: (conn=103) You can't specify target table 'sym_extract_request' for update in FROM clause at org.jumpmind.db.sql.AbstractSqlTemplate.translate(AbstractSqlTemplate.java:313) at org.jumpmind.db.sql.AbstractSqlTemplate.translate(AbstractSqlTemplate.java:302) at org.jumpmind.db.sql.JdbcSqlTemplate.execute(JdbcSqlTemplate.java:523) at org.jumpmind.db.sql.JdbcSqlTemplate.update(JdbcSqlTemplate.java:362) at org.jumpmind.db.sql.AbstractSqlTemplate.update(AbstractSqlTemplate.java:235) at org.jumpmind.symmetric.service.impl.DataExtractorService.releaseMissedExtractRequests(DataExtractorService.java:2288) at org.jumpmind.symmetric.service.impl.DataExtractorService.execute(DataExtractorService.java:2159) at org.jumpmind.symmetric.service.impl.NodeCommunicationService$1.run(NodeCommunicationService.java:536) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:630) at java.base/java.lang.Thread.run(Thread.java:832) Caused by: java.sql.SQLTransientConnectionException: (conn=103) You can't specify target table 'sym_extract_request' for update in FROM clause at org.mariadb.jdbc.internal.util.exceptions.ExceptionFactory.createException(ExceptionFactory.java:79) at org.mariadb.jdbc.internal.util.exceptions.ExceptionFactory.create(ExceptionFactory.java:153) at org.mariadb.jdbc.MariaDbStatement.executeExceptionEpilogue(MariaDbStatement.java:274) at org.mariadb.jdbc.ClientSidePreparedStatement.executeInternal(ClientSidePreparedStatement.java:229) at org.mariadb.jdbc.ClientSidePreparedStatement.execute(ClientSidePreparedStatement.java:149) at org.apache.commons.dbcp.DelegatingPreparedStatement.execute(DelegatingPreparedStatement.java:172) at org.apache.commons.dbcp.DelegatingPreparedStatement.execute(DelegatingPreparedStatement.java:172) at org.jumpmind.db.sql.JdbcSqlTemplate$5.execute(JdbcSqlTemplate.java:399) at org.jumpmind.db.sql.JdbcSqlTemplate$5.execute(JdbcSqlTemplate.java:362) at org.jumpmind.db.sql.JdbcSqlTemplate.execute(JdbcSqlTemplate.java:521) ... 8 more Caused by: org.mariadb.jdbc.internal.util.exceptions.MariaDbSqlException: You can't specify target table 'sym_extract_request' for update in FROM clause at org.mariadb.jdbc.internal.util.exceptions.MariaDbSqlException.of(MariaDbSqlException.java:34) at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.exceptionWithQuery(AbstractQueryProtocol.java:192) at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.exceptionWithQuery(AbstractQueryProtocol.java:175) at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.executeQuery(AbstractQueryProtocol.java:319) at jdk.internal.reflect.GeneratedMethodAccessor46.invoke(Unknown Source) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:564) at org.mariadb.jdbc.internal.failover.impl.MastersReplicasListener.invoke(MastersReplicasListener.java:233) at org.mariadb.jdbc.internal.failover.FailoverProxy.executeInvocation(FailoverProxy.java:301) at org.mariadb.jdbc.internal.failover.FailoverProxy.invoke(FailoverProxy.java:294) at com.sun.proxy.$Proxy50.executeQuery(Unknown Source) at org.mariadb.jdbc.ClientSidePreparedStatement.executeInternal(ClientSidePreparedStatement.java:220) ... 14 more Caused by: java.sql.SQLException: You can't specify target table 'sym_extract_request' for update in FROM clause at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.readErrorPacket(AbstractQueryProtocol.java:1681) at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.readPacket(AbstractQueryProtocol.java:1543) at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.getResult(AbstractQueryProtocol.java:1506) at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.executeQuery(AbstractQueryProtocol.java:316) ... 22 more 2021-03-30 00:03:51,382 INFO [master-000] [DataExtractorService] [master-000-push-default-10] Initial load ended for node 001 2021-03-30 00:03:52,252 INFO [master-000] [PushService] [master-000-push-default-10] Pushed data to node node:001:001. 0 data and 1 batches were processed. (qualifying_times) 2021-03-30 00:03:52,252 INFO [master-000] [PushService] [master-000-push-default-10] Pushing to node:001:001 again because the last push contained reload batches 2021-03-30 00:03:59,927 INFO [master-000] [ConfigurationChangedDataRouter] [master-000-job-13] About to refresh the cache of node security because new configuration came through the data router 2021-03-30 00:04:00,786 INFO [master-000] [RouterService] [master-000-job-13] Routed 1 data events in 3967 ms 2021-03-30 00:04:07,274 INFO [node-001] [ConfigurationChangedDatabaseWriterFilter] [node-001-dataloader-11] About to refresh the cache of node security because new configuration came through the data loader 2021-03-30 00:04:07,634 INFO [master-000] [PushService] [master-000-push-default-6] Push data sent to node:001:001 2021-03-30 00:04:07,635 INFO [node-001] [ConfigurationChangedDatabaseWriterFilter] [qtp647973805-22] Initial load ended for me 2021-03-30 00:04:07,636 INFO [node-001] [DataLoaderService] [qtp647973805-22] 1 data and 1 batches loaded during push request from master:000:000 2021-03-30 00:04:08,608 INFO [master-000] [PushService] [master-000-push-default-6] Pushed data to node node:001:001. 1 data and 1 batches were processed. (sym_node_security) 2021-03-30 00:04:10,320 INFO [node-001] [ConfigurationChangedDataRouter] [node-001-job-4] About to refresh the cache of node security because new configuration came through the data router 2021-03-30 00:04:10,321 INFO [node-001] [RouterService] [node-001-job-4] Routed 1 data events in 37 ms 2021-03-30 00:10:43,651 INFO [node-002] [RouterService] [node-002-job-17] Routed 1 data events in 38 ms 2021-03-30 00:10:50,615 INFO [node-001] [RouterService] [node-001-job-3] Routed 1 data events in 38 ms 2021-03-30 00:10:52,686 INFO [node-002] [PushService] [node-002-push-default-5] Push data sent to master:000:000 2021-03-30 00:10:54,228 INFO [master-000] [DataLoaderService] [qtp647973805-74] 1 data and 1 batches loaded during push request from node:002:002 2021-03-30 00:10:54,845 INFO [node-002] [PushService] [node-002-push-default-5] Pushed data to node master:000:000. 1 data and 1 batches were processed. (sym_node_host) 2021-03-30 00:10:59,893 INFO [node-001] [PushService] [node-001-push-default-5] Push data sent to master:000:000 2021-03-30 00:11:01,441 INFO [master-000] [DataLoaderService] [qtp647973805-22] 1 data and 1 batches loaded during push request from node:001:001 2021-03-30 00:11:02,043 INFO [node-001] [PushService] [node-001-push-default-5] Pushed data to node master:000:000. 1 data and 1 batches were processed. (sym_node_host) 2021-03-30 00:11:03,534 INFO [master-000] [RouterService] [master-000-job-1] Routed 2 data events in 5657 ms 2021-03-30 00:12:19,545 INFO [master-000] [RouterService] [master-000-job-17] Routed 1 data events in 5919 ms 2021-03-30 00:12:34,844 INFO [master-000] [PushService] [master-000-push-default-4] Push data sent to node:001:001 2021-03-30 00:12:34,845 INFO [node-001] [DataLoaderService] [qtp647973805-15] 1 data and 1 batches loaded during push request from master:000:000 2021-03-30 00:12:35,811 INFO [master-000] [PushService] [master-000-push-default-4] Pushed data to node node:001:001. 1 data and 1 batches were processed. (swimmers) 2021-03-30 00:14:17,718 INFO [master-000] [RouterService] [master-000-job-9] Routed 1 data events in 4711 ms 2021-03-30 00:14:20,229 INFO [master-000] [PushService] [master-000-push-default-7] Push data sent to node:001:001 2021-03-30 00:14:20,229 INFO [master-000] [PushService] [master-000-push-default-9] Push data sent to node:002:002 2021-03-30 00:14:20,230 INFO [node-001] [DataLoaderService] [qtp647973805-76] 1 data and 1 batches loaded during push request from master:000:000 2021-03-30 00:14:20,232 INFO [node-002] [DataLoaderService] [qtp647973805-19] 1 data and 1 batches loaded during push request from master:000:000 2021-03-30 00:14:20,853 INFO [node-001] [RouterService] [node-001-job-8] Routed 1 data events in 47 ms 2021-03-30 00:14:21,196 INFO [master-000] [PushService] [master-000-push-default-9] Pushed data to node node:002:002. 1 data and 1 batches were processed. (sym_node_host) 2021-03-30 00:14:21,206 INFO [master-000] [PushService] [master-000-push-default-7] Pushed data to node node:001:001. 1 data and 1 batches were processed. (sym_node_host) 2021-03-30 00:14:23,886 INFO [node-002] [RouterService] [node-002-job-16] Routed 1 data events in 36 ms 2021-03-30 00:16:48,838 INFO [master-000] [RouterService] [master-000-job-16] Routed 1 data events in 3543 ms 2021-03-30 00:17:00,242 INFO [master-000] [PushService] [master-000-push-default-8] Push data sent to node:001:001 2021-03-30 00:17:00,243 INFO [node-001] [DataLoaderService] [qtp647973805-15] 1 data and 1 batches loaded during push request from master:000:000 2021-03-30 00:17:01,197 INFO [master-000] [PushService] [master-000-push-default-8] Pushed data to node node:001:001. 1 data and 1 batches were processed. (clubs) 2021-03-30 00:22:01,127 INFO [node-001] [RouterService] [node-001-job-4] Routed 1 data events in 44 ms 2021-03-30 00:22:10,019 INFO [node-001] [PushService] [node-001-push-default-2] Push data sent to master:000:000 2021-03-30 00:22:13,167 INFO [master-000] [DataLoaderService] [qtp647973805-74] 1 data and 1 batches loaded during push request from node:001:001 2021-03-30 00:22:13,758 INFO [node-001] [PushService] [node-001-push-default-2] Pushed data to node master:000:000. 1 data and 1 batches were processed. (clubs) 2021-03-30 00:24:54,237 INFO [node-002] [RouterService] [node-002-job-17] Routed 1 data events in 60 ms 2021-03-30 00:25:03,362 INFO [node-002] [PushService] [node-002-push-default-10] Push data sent to master:000:000 2021-03-30 00:25:06,635 INFO [master-000] [DataLoaderService] [qtp647973805-22] 1 data and 1 batches loaded during push request from node:002:002 2021-03-30 00:25:07,218 INFO [node-002] [PushService] [node-002-push-default-10] Pushed data to node master:000:000. 1 data and 1 batches were processed. (clubs) 2021-03-30 00:25:44,318 INFO [node-002] [RouterService] [node-002-job-11] Routed 1 data events in 42 ms 2021-03-30 00:25:51,282 INFO [node-001] [RouterService] [node-001-job-5] Routed 1 data events in 55 ms 2021-03-30 00:25:52,797 INFO [node-002] [PushService] [node-002-push-default-5] Push data sent to master:000:000 2021-03-30 00:25:54,329 INFO [master-000] [DataLoaderService] [qtp647973805-15] 1 data and 1 batches loaded during push request from node:002:002 2021-03-30 00:25:54,906 INFO [node-002] [PushService] [node-002-push-default-5] Pushed data to node master:000:000. 1 data and 1 batches were processed. (sym_node_host) 2021-03-30 00:26:00,039 INFO [node-001] [PushService] [node-001-push-default-5] Push data sent to master:000:000 2021-03-30 00:26:01,567 INFO [master-000] [DataLoaderService] [qtp647973805-305] 1 data and 1 batches loaded during push request from node:001:001 2021-03-30 00:26:02,179 INFO [node-001] [PushService] [node-001-push-default-5] Pushed data to node master:000:000. 1 data and 1 batches were processed. (sym_node_host) 2021-03-30 00:26:02,763 INFO [master-000] [RouterService] [master-000-job-4] Routed 1 data events in 6207 ms 2021-03-30 00:26:03,445 INFO [master-000] [DataGapFastDetector] [master-000-job-4] Expired 2 data gap(s) between data_id 34 and 40 and between create_time 2021-03-30T00:02:32.258+0100 and 2021-03-30T00:02:43.364+0100 2021-03-30 00:26:11,606 INFO [master-000] [RouterService] [master-000-job-13] Routed 1 data events in 3160 ms 2021-03-30 00:29:15,642 INFO [master-000] [RouterService] [master-000-job-16] Routed 1 data events in 3416 ms 2021-03-30 00:29:25,483 INFO [master-000] [PushService] [master-000-push-default-9] Push data sent to node:001:001 2021-03-30 00:29:25,483 INFO [master-000] [PushService] [master-000-push-default-7] Push data sent to node:002:002 2021-03-30 00:29:25,484 INFO [node-001] [DataLoaderService] [qtp647973805-305] 1 data and 1 batches loaded during push request from master:000:000 2021-03-30 00:29:25,487 INFO [node-002] [DataLoaderService] [qtp647973805-287] 1 data and 1 batches loaded during push request from master:000:000 2021-03-30 00:29:26,396 INFO [node-001] [RouterService] [node-001-job-8] Routed 1 data events in 26 ms 2021-03-30 00:29:26,456 INFO [master-000] [PushService] [master-000-push-default-9] Pushed data to node node:001:001. 1 data and 1 batches were processed. (sym_node_host) 2021-03-30 00:29:26,477 INFO [master-000] [PushService] [master-000-push-default-7] Pushed data to node node:002:002. 1 data and 1 batches were processed. (sym_node_host) 2021-03-30 00:29:29,437 INFO [node-002] [RouterService] [node-002-job-15] Routed 1 data events in 31 ms 2021-03-30 00:40:44,938 INFO [node-002] [RouterService] [node-002-job-2] Routed 1 data events in 48 ms 2021-03-30 00:40:51,942 INFO [node-001] [RouterService] [node-001-job-5] Routed 1 data events in 35 ms 2021-03-30 00:40:53,544 INFO [node-002] [PushService] [node-002-push-default-5] Push data sent to master:000:000 2021-03-30 00:40:57,937 INFO [master-000] [DataLoaderService] [qtp647973805-305] 1 data and 1 batches loaded during push request from node:002:002 2021-03-30 00:40:58,547 INFO [node-002] [PushService] [node-002-push-default-5] Pushed data to node master:000:000. 1 data and 1 batches were processed. (sym_node_host) 2021-03-30 00:41:00,228 INFO [node-001] [PushService] [node-001-push-default-5] Push data sent to master:000:000 2021-03-30 00:41:01,766 INFO [master-000] [DataLoaderService] [qtp647973805-15] 1 data and 1 batches loaded during push request from node:001:001 2021-03-30 00:41:02,367 INFO [node-001] [PushService] [node-001-push-default-5] Pushed data to node master:000:000. 1 data and 1 batches were processed. (sym_node_host) 2021-03-30 00:41:04,535 INFO [master-000] [RouterService] [master-000-job-20] Routed 1 data events in 7213 ms 2021-03-30 00:41:13,224 INFO [master-000] [RouterService] [master-000-job-5] Routed 1 data events in 3206 ms 2021-03-30 00:44:15,289 INFO [master-000] [RouterService] [master-000-job-17] Routed 1 data events in 3356 ms 2021-03-30 00:44:28,081 INFO [master-000] [PushService] [master-000-push-default-7] Push data sent to node:001:001 2021-03-30 00:44:28,081 INFO [master-000] [PushService] [master-000-push-default-9] Push data sent to node:002:002 2021-03-30 00:44:28,082 INFO [node-001] [DataLoaderService] [qtp647973805-22] 1 data and 1 batches loaded during push request from master:000:000 2021-03-30 00:44:28,083 INFO [node-002] [DataLoaderService] [qtp647973805-305] 1 data and 1 batches loaded during push request from master:000:000 2021-03-30 00:44:29,067 INFO [master-000] [PushService] [master-000-push-default-7] Pushed data to node node:001:001. 1 data and 1 batches were processed. (sym_node_host) 2021-03-30 00:44:29,067 INFO [master-000] [PushService] [master-000-push-default-9] Pushed data to node node:002:002. 1 data and 1 batches were processed. (sym_node_host) 2021-03-30 00:44:30,240 INFO [node-002] [RouterService] [node-002-job-15] Routed 1 data events in 36 ms 2021-03-30 00:44:32,244 INFO [node-001] [RouterService] [node-001-job-17] Routed 1 data events in 42 ms