2014-07-16 15:21:39,603 INFO [] [AbstractCommandLauncher] [main] Option: name=engine, value={corp-000} 2014-07-16 15:21:39,604 INFO [] [AbstractCommandLauncher] [main] Option: name=format, value={XML} 2014-07-16 15:21:39,767 INFO [] [JdbcDatabasePlatformFactory] [main] Detected database 'Microsoft SQL Server', version '10', protocol 'jtds' 2014-07-16 15:21:39,901 WARN [] [AbstractDatabaseWriter] [main] Did not find the item table in the target database 2014-07-16 15:21:39,908 INFO [] [DefaultDatabaseWriter] [main] About to create table using the following definition:
2014-07-16 15:21:39,915 WARN [] [AbstractDatabaseWriter] [main] Did not find the item_selling_price table in the target database 2014-07-16 15:21:39,918 INFO [] [DefaultDatabaseWriter] [main] About to create table using the following definition:
2014-07-16 15:21:39,924 WARN [] [AbstractDatabaseWriter] [main] Did not find the sale_transaction table in the target database 2014-07-16 15:21:39,927 INFO [] [DefaultDatabaseWriter] [main] About to create table using the following definition:
2014-07-16 15:21:39,931 WARN [] [AbstractDatabaseWriter] [main] Did not find the sale_return_line_item table in the target database 2014-07-16 15:21:39,934 INFO [] [DefaultDatabaseWriter] [main] About to create table using the following definition:
2014-07-16 15:22:01,102 INFO [] [AbstractCommandLauncher] [main] Option: name=engine, value={corp-000} 2014-07-16 15:22:01,615 INFO [corp-000] [JdbcDatabasePlatformFactory] [main] Detected database 'Microsoft SQL Server', version '10', protocol 'jtds' 2014-07-16 15:22:01,648 INFO [corp-000] [MsSqlSymmetricDialect] [main] The DbDialect being used is org.jumpmind.symmetric.db.mssql.MsSqlSymmetricDialect 2014-07-16 15:22:01,653 INFO [corp-000] [StagingManager] [main] The staging directory was initialized at the following location: C:\Users\user.name\symmetricds\sym-corp-fix\symmetric-3.6.3-SNAPSHOT\tmp\corp-000 2014-07-16 15:22:01,681 INFO [corp-000] [ClusterService] [main] This node picked a server id of T005583.eu.Micros.int 2014-07-16 15:22:01,774 INFO [corp-000] [ExtensionPointManager] [main] Found 8 extension points that will be registered 2014-07-16 15:22:01,777 INFO [corp-000] [AbstractSymmetricEngine] [main] Initializing SymmetricDS database 2014-07-16 15:22:01,777 INFO [corp-000] [MsSqlSymmetricDialect] [main] Checking if SymmetricDS tables need created or altered 2014-07-16 15:22:01,916 INFO [corp-000] [MsSqlSymmetricDialect] [main] There are SymmetricDS tables that needed altered 2014-07-16 15:22:01,933 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:01,934 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:01,938 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_channel"( "channel_id" VARCHAR(128) NOT NULL, "processing_order" INT DEFAULT 1 NOT NULL, "max_batch_size" INT DEFAULT 1000 NOT NULL, "max_batch_to_send" INT DEFAULT 60 NOT NULL, "max_data_to_route" INT DEFAULT 100000 NOT NULL, "extract_period_millis" INT DEFAULT 0 NOT NULL, "enabled" SMALLINT DEFAULT 1 NOT NULL, "use_old_data_to_route" SMALLINT DEFAULT 1 NOT NULL, "use_row_data_to_route" SMALLINT DEFAULT 1 NOT NULL, "use_pk_data_to_route" SMALLINT DEFAULT 1 NOT NULL, "reload_flag" SMALLINT DEFAULT 0 NOT NULL, "file_sync_flag" SMALLINT DEFAULT 0 NOT NULL, "contains_big_lob" SMALLINT DEFAULT 0 NOT NULL, "batch_algorithm" VARCHAR(50) DEFAULT 'default' NOT NULL, "data_loader_type" VARCHAR(50) DEFAULT 'default' NOT NULL, "description" VARCHAR(255), "create_time" DATETIME, "last_update_by" VARCHAR(50), "last_update_time" DATETIME, PRIMARY KEY ("channel_id") ) 2014-07-16 15:22:01,938 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:01,940 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_conflict"( "conflict_id" VARCHAR(50) NOT NULL, "source_node_group_id" VARCHAR(50) NOT NULL, "target_node_group_id" VARCHAR(50) NOT NULL, "target_channel_id" VARCHAR(128), "target_catalog_name" VARCHAR(255), "target_schema_name" VARCHAR(255), "target_table_name" VARCHAR(255), "detect_type" VARCHAR(128) NOT NULL, "detect_expression" TEXT, "resolve_type" VARCHAR(128) NOT NULL, "ping_back" VARCHAR(128) NOT NULL, "resolve_changes_only" SMALLINT DEFAULT 0, "resolve_row_only" SMALLINT DEFAULT 0, "create_time" DATETIME NOT NULL, "last_update_by" VARCHAR(50), "last_update_time" DATETIME NOT NULL, PRIMARY KEY ("conflict_id") ) 2014-07-16 15:22:01,941 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:01,942 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_data"( "data_id" BIGINT NOT NULL IDENTITY (1,1) , "table_name" VARCHAR(255) NOT NULL, "event_type" CHAR(1) NOT NULL, "row_data" TEXT, "pk_data" TEXT, "old_data" TEXT, "trigger_hist_id" INT NOT NULL, "channel_id" VARCHAR(128), "transaction_id" VARCHAR(255), "source_node_id" VARCHAR(50), "external_data" VARCHAR(50), "node_list" VARCHAR(255), "create_time" DATETIME, PRIMARY KEY ("data_id") ) 2014-07-16 15:22:01,943 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE INDEX "sym_idx_d_channel_id" ON "sym_data" ("data_id", "channel_id") 2014-07-16 15:22:01,943 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:01,944 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_data_event"( "data_id" BIGINT NOT NULL, "batch_id" BIGINT NOT NULL, "router_id" VARCHAR(50) NOT NULL, "create_time" DATETIME, PRIMARY KEY ("data_id", "batch_id", "router_id") ) 2014-07-16 15:22:01,950 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE INDEX "sym_idx_de_batchid" ON "sym_data_event" ("batch_id") 2014-07-16 15:22:01,951 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:01,951 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_data_gap"( "start_id" BIGINT NOT NULL, "end_id" BIGINT NOT NULL, "status" CHAR(2), "create_time" DATETIME NOT NULL, "last_update_hostname" VARCHAR(255), "last_update_time" DATETIME NOT NULL, PRIMARY KEY ("start_id", "end_id") ) 2014-07-16 15:22:01,962 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE INDEX "sym_idx_dg_status" ON "sym_data_gap" ("status") 2014-07-16 15:22:01,962 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:01,963 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_extract_request"( "request_id" BIGINT NOT NULL, "node_id" VARCHAR(50) NOT NULL, "status" CHAR(2), "start_batch_id" BIGINT NOT NULL, "end_batch_id" BIGINT NOT NULL, "trigger_id" VARCHAR(128) NOT NULL, "router_id" VARCHAR(50) NOT NULL, "last_update_time" DATETIME, "create_time" DATETIME, PRIMARY KEY ("request_id") ) 2014-07-16 15:22:01,974 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:01,975 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_file_incoming"( "relative_dir" VARCHAR(255) NOT NULL, "file_name" VARCHAR(128) NOT NULL, "last_event_type" CHAR(1) NOT NULL, "node_id" VARCHAR(50) NOT NULL, "file_modified_time" BIGINT, PRIMARY KEY ("relative_dir", "file_name") ) 2014-07-16 15:22:01,985 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:01,987 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_file_snapshot"( "trigger_id" VARCHAR(128) NOT NULL, "router_id" VARCHAR(50) NOT NULL, "relative_dir" VARCHAR(255) NOT NULL, "file_name" VARCHAR(128) NOT NULL, "channel_id" VARCHAR(128) DEFAULT 'filesync' NOT NULL, "reload_channel_id" VARCHAR(128) DEFAULT 'filesync_reload' NOT NULL, "last_event_type" CHAR(1) NOT NULL, "crc32_checksum" BIGINT, "file_size" BIGINT, "file_modified_time" BIGINT, "last_update_time" DATETIME NOT NULL, "last_update_by" VARCHAR(50), "create_time" DATETIME NOT NULL, PRIMARY KEY ("trigger_id", "router_id", "relative_dir", "file_name") ) 2014-07-16 15:22:01,997 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE INDEX "sym_idx_f_snpsht_chid" ON "sym_file_snapshot" ("reload_channel_id") 2014-07-16 15:22:01,998 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:02,000 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_file_trigger"( "trigger_id" VARCHAR(128) NOT NULL, "channel_id" VARCHAR(128) DEFAULT 'filesync' NOT NULL, "reload_channel_id" VARCHAR(128) DEFAULT 'filesync_reload' NOT NULL, "base_dir" VARCHAR(255) NOT NULL, "recurse" SMALLINT DEFAULT 1 NOT NULL, "includes_files" VARCHAR(255), "excludes_files" VARCHAR(255), "sync_on_create" SMALLINT DEFAULT 1 NOT NULL, "sync_on_modified" SMALLINT DEFAULT 1 NOT NULL, "sync_on_delete" SMALLINT DEFAULT 1 NOT NULL, "sync_on_ctl_file" SMALLINT DEFAULT 0 NOT NULL, "delete_after_sync" SMALLINT DEFAULT 0 NOT NULL, "before_copy_script" TEXT, "after_copy_script" TEXT, "create_time" DATETIME NOT NULL, "last_update_by" VARCHAR(50), "last_update_time" DATETIME NOT NULL, PRIMARY KEY ("trigger_id") ) 2014-07-16 15:22:02,022 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:02,023 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_file_trigger_router"( "trigger_id" VARCHAR(128) NOT NULL, "router_id" VARCHAR(50) NOT NULL, "enabled" SMALLINT DEFAULT 1 NOT NULL, "initial_load_enabled" SMALLINT DEFAULT 1 NOT NULL, "target_base_dir" VARCHAR(255), "conflict_strategy" VARCHAR(128) DEFAULT 'source_wins' NOT NULL, "create_time" DATETIME NOT NULL, "last_update_by" VARCHAR(50), "last_update_time" DATETIME NOT NULL, PRIMARY KEY ("trigger_id", "router_id") ) 2014-07-16 15:22:02,033 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:02,034 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_grouplet"( "grouplet_id" VARCHAR(50) NOT NULL, "grouplet_link_policy" CHAR(1) DEFAULT 'I' NOT NULL, "description" VARCHAR(255), "create_time" DATETIME NOT NULL, "last_update_by" VARCHAR(50), "last_update_time" DATETIME NOT NULL, PRIMARY KEY ("grouplet_id") ) 2014-07-16 15:22:02,046 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:02,047 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_grouplet_link"( "grouplet_id" VARCHAR(50) NOT NULL, "external_id" VARCHAR(50) NOT NULL, "create_time" DATETIME NOT NULL, "last_update_by" VARCHAR(50), "last_update_time" DATETIME NOT NULL, PRIMARY KEY ("grouplet_id", "external_id") ) 2014-07-16 15:22:02,057 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:02,061 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_incoming_batch"( "batch_id" BIGINT NOT NULL, "node_id" VARCHAR(50) NOT NULL, "channel_id" VARCHAR(128), "status" CHAR(2), "error_flag" SMALLINT DEFAULT 0, "network_millis" BIGINT DEFAULT 0 NOT NULL, "filter_millis" BIGINT DEFAULT 0 NOT NULL, "database_millis" BIGINT DEFAULT 0 NOT NULL, "failed_row_number" BIGINT DEFAULT 0 NOT NULL, "failed_line_number" BIGINT DEFAULT 0 NOT NULL, "byte_count" BIGINT DEFAULT 0 NOT NULL, "statement_count" BIGINT DEFAULT 0 NOT NULL, "fallback_insert_count" BIGINT DEFAULT 0 NOT NULL, "fallback_update_count" BIGINT DEFAULT 0 NOT NULL, "ignore_count" BIGINT DEFAULT 0 NOT NULL, "missing_delete_count" BIGINT DEFAULT 0 NOT NULL, "skip_count" BIGINT DEFAULT 0 NOT NULL, "sql_state" VARCHAR(10), "sql_code" INT DEFAULT 0 NOT NULL, "sql_message" TEXT, "last_update_hostname" VARCHAR(255), "last_update_time" DATETIME, "create_time" DATETIME, PRIMARY KEY ("batch_id", "node_id") ) 2014-07-16 15:22:02,082 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE INDEX "sym_idx_ib_time_status" ON "sym_incoming_batch" ("create_time", "status") 2014-07-16 15:22:02,095 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE INDEX "sym_idx_ib_in_error" ON "sym_incoming_batch" ("error_flag") 2014-07-16 15:22:02,095 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:02,098 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_incoming_error"( "batch_id" BIGINT NOT NULL, "node_id" VARCHAR(50) NOT NULL, "failed_row_number" BIGINT NOT NULL, "failed_line_number" BIGINT DEFAULT 0 NOT NULL, "target_catalog_name" VARCHAR(255), "target_schema_name" VARCHAR(255), "target_table_name" VARCHAR(255) NOT NULL, "event_type" CHAR(1) NOT NULL, "binary_encoding" VARCHAR(10) DEFAULT 'HEX' NOT NULL, "column_names" TEXT NOT NULL, "pk_column_names" TEXT NOT NULL, "row_data" TEXT, "old_data" TEXT, "cur_data" TEXT, "resolve_data" TEXT, "resolve_ignore" SMALLINT DEFAULT 0, "conflict_id" VARCHAR(50), "create_time" DATETIME, "last_update_by" VARCHAR(50), "last_update_time" DATETIME NOT NULL, PRIMARY KEY ("batch_id", "node_id", "failed_row_number") ) 2014-07-16 15:22:02,119 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:02,121 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_load_filter"( "load_filter_id" VARCHAR(50) NOT NULL, "load_filter_type" VARCHAR(10) NOT NULL, "source_node_group_id" VARCHAR(50) NOT NULL, "target_node_group_id" VARCHAR(50) NOT NULL, "target_catalog_name" VARCHAR(255), "target_schema_name" VARCHAR(255), "target_table_name" VARCHAR(255), "filter_on_update" SMALLINT DEFAULT 1 NOT NULL, "filter_on_insert" SMALLINT DEFAULT 1 NOT NULL, "filter_on_delete" SMALLINT DEFAULT 1 NOT NULL, "before_write_script" TEXT, "after_write_script" TEXT, "batch_complete_script" TEXT, "batch_commit_script" TEXT, "batch_rollback_script" TEXT, "handle_error_script" TEXT, "create_time" DATETIME NOT NULL, "last_update_by" VARCHAR(50), "last_update_time" DATETIME NOT NULL, "load_filter_order" INT DEFAULT 1 NOT NULL, "fail_on_error" SMALLINT DEFAULT 0 NOT NULL, PRIMARY KEY ("load_filter_id") ) 2014-07-16 15:22:02,144 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:02,145 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_lock"( "lock_action" VARCHAR(50) NOT NULL, "lock_type" VARCHAR(50) NOT NULL, "locking_server_id" VARCHAR(255), "lock_time" DATETIME, "shared_count" INT DEFAULT 0 NOT NULL, "shared_enable" INT DEFAULT 0 NOT NULL, "last_lock_time" DATETIME, "last_locking_server_id" VARCHAR(255), PRIMARY KEY ("lock_action") ) 2014-07-16 15:22:02,155 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:02,157 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_node"( "node_id" VARCHAR(50) NOT NULL, "node_group_id" VARCHAR(50) NOT NULL, "external_id" VARCHAR(50) NOT NULL, "sync_enabled" SMALLINT DEFAULT 0, "sync_url" VARCHAR(255), "schema_version" VARCHAR(50), "symmetric_version" VARCHAR(50), "database_type" VARCHAR(50), "database_version" VARCHAR(50), "heartbeat_time" DATETIME, "timezone_offset" VARCHAR(6), "batch_to_send_count" INT DEFAULT 0, "batch_in_error_count" INT DEFAULT 0, "created_at_node_id" VARCHAR(50), "deployment_type" VARCHAR(50), PRIMARY KEY ("node_id") ) 2014-07-16 15:22:02,179 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:02,182 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_node_communication"( "node_id" VARCHAR(50) NOT NULL, "communication_type" VARCHAR(10) NOT NULL, "lock_time" DATETIME, "locking_server_id" VARCHAR(255), "last_lock_time" DATETIME, "last_lock_millis" BIGINT DEFAULT 0, "success_count" BIGINT DEFAULT 0, "fail_count" BIGINT DEFAULT 0, "total_success_count" BIGINT DEFAULT 0, "total_fail_count" BIGINT DEFAULT 0, "total_success_millis" BIGINT DEFAULT 0, "total_fail_millis" BIGINT DEFAULT 0, PRIMARY KEY ("node_id", "communication_type") ) 2014-07-16 15:22:02,191 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:02,193 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_node_channel_ctl"( "node_id" VARCHAR(50) NOT NULL, "channel_id" VARCHAR(128) NOT NULL, "suspend_enabled" SMALLINT DEFAULT 0, "ignore_enabled" SMALLINT DEFAULT 0, "last_extract_time" DATETIME, PRIMARY KEY ("node_id", "channel_id") ) 2014-07-16 15:22:02,204 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:02,205 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_node_group"( "node_group_id" VARCHAR(50) NOT NULL, "description" VARCHAR(255), "create_time" DATETIME, "last_update_by" VARCHAR(50), "last_update_time" DATETIME, PRIMARY KEY ("node_group_id") ) 2014-07-16 15:22:02,215 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:02,216 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_node_group_channel_wnd"( "node_group_id" VARCHAR(50) NOT NULL, "channel_id" VARCHAR(128) NOT NULL, "start_time" DATETIME NOT NULL, "end_time" DATETIME NOT NULL, "enabled" SMALLINT DEFAULT 0 NOT NULL, PRIMARY KEY ("node_group_id", "channel_id", "start_time", "end_time") ) 2014-07-16 15:22:02,217 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:02,230 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_node_group_link"( "source_node_group_id" VARCHAR(50) NOT NULL, "target_node_group_id" VARCHAR(50) NOT NULL, "data_event_action" CHAR(1) DEFAULT 'W' NOT NULL, "sync_config_enabled" SMALLINT DEFAULT 1 NOT NULL, "create_time" DATETIME, "last_update_by" VARCHAR(50), "last_update_time" DATETIME, PRIMARY KEY ("source_node_group_id", "target_node_group_id") ) 2014-07-16 15:22:02,231 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:02,234 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_node_host"( "node_id" VARCHAR(50) NOT NULL, "host_name" VARCHAR(60) NOT NULL, "ip_address" VARCHAR(50), "os_user" VARCHAR(50), "os_name" VARCHAR(50), "os_arch" VARCHAR(50), "os_version" VARCHAR(50), "available_processors" INT DEFAULT 0, "free_memory_bytes" BIGINT DEFAULT 0, "total_memory_bytes" BIGINT DEFAULT 0, "max_memory_bytes" BIGINT DEFAULT 0, "java_version" VARCHAR(50), "java_vendor" VARCHAR(255), "jdbc_version" VARCHAR(255), "symmetric_version" VARCHAR(50), "timezone_offset" VARCHAR(6), "heartbeat_time" DATETIME, "last_restart_time" DATETIME NOT NULL, "create_time" DATETIME NOT NULL, PRIMARY KEY ("node_id", "host_name") ) 2014-07-16 15:22:02,237 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:02,240 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_node_host_channel_stats"( "node_id" VARCHAR(50) NOT NULL, "host_name" VARCHAR(60) NOT NULL, "channel_id" VARCHAR(128) NOT NULL, "start_time" DATETIME NOT NULL, "end_time" DATETIME NOT NULL, "data_routed" BIGINT DEFAULT 0, "data_unrouted" BIGINT DEFAULT 0, "data_event_inserted" BIGINT DEFAULT 0, "data_extracted" BIGINT DEFAULT 0, "data_bytes_extracted" BIGINT DEFAULT 0, "data_extracted_errors" BIGINT DEFAULT 0, "data_bytes_sent" BIGINT DEFAULT 0, "data_sent" BIGINT DEFAULT 0, "data_sent_errors" BIGINT DEFAULT 0, "data_loaded" BIGINT DEFAULT 0, "data_bytes_loaded" BIGINT DEFAULT 0, "data_loaded_errors" BIGINT DEFAULT 0, PRIMARY KEY ("node_id", "host_name", "channel_id", "start_time", "end_time") ) 2014-07-16 15:22:02,247 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE INDEX "sym_idx_nd_hst_chnl_sts" ON "sym_node_host_channel_stats" ("node_id", "start_time", "end_time") 2014-07-16 15:22:02,247 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:02,252 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_node_host_job_stats"( "node_id" VARCHAR(50) NOT NULL, "host_name" VARCHAR(60) NOT NULL, "job_name" VARCHAR(50) NOT NULL, "start_time" DATETIME NOT NULL, "end_time" DATETIME NOT NULL, "processed_count" BIGINT DEFAULT 0, PRIMARY KEY ("node_id", "host_name", "job_name", "start_time", "end_time") ) 2014-07-16 15:22:02,252 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE INDEX "sym_idx_nd_hst_job" ON "sym_node_host_job_stats" ("node_id", "start_time", "end_time") 2014-07-16 15:22:02,256 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:02,258 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_node_host_stats"( "node_id" VARCHAR(50) NOT NULL, "host_name" VARCHAR(60) NOT NULL, "start_time" DATETIME NOT NULL, "end_time" DATETIME NOT NULL, "restarted" BIGINT DEFAULT 0 NOT NULL, "nodes_pulled" BIGINT DEFAULT 0, "total_nodes_pull_time" BIGINT DEFAULT 0, "nodes_pushed" BIGINT DEFAULT 0, "total_nodes_push_time" BIGINT DEFAULT 0, "nodes_rejected" BIGINT DEFAULT 0, "nodes_registered" BIGINT DEFAULT 0, "nodes_loaded" BIGINT DEFAULT 0, "nodes_disabled" BIGINT DEFAULT 0, "purged_data_rows" BIGINT DEFAULT 0, "purged_data_event_rows" BIGINT DEFAULT 0, "purged_batch_outgoing_rows" BIGINT DEFAULT 0, "purged_batch_incoming_rows" BIGINT DEFAULT 0, "triggers_created_count" BIGINT, "triggers_rebuilt_count" BIGINT, "triggers_removed_count" BIGINT, PRIMARY KEY ("node_id", "host_name", "start_time", "end_time") ) 2014-07-16 15:22:02,265 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE INDEX "sym_idx_nd_hst_sts" ON "sym_node_host_stats" ("node_id", "start_time", "end_time") 2014-07-16 15:22:02,265 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:02,266 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_node_identity"( "node_id" VARCHAR(50) NOT NULL, PRIMARY KEY ("node_id") ) 2014-07-16 15:22:02,267 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:02,275 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_node_security"( "node_id" VARCHAR(50) NOT NULL, "node_password" VARCHAR(50) NOT NULL, "registration_enabled" SMALLINT DEFAULT 0, "registration_time" DATETIME, "initial_load_enabled" SMALLINT DEFAULT 0, "initial_load_time" DATETIME, "initial_load_id" BIGINT, "initial_load_create_by" VARCHAR(255), "rev_initial_load_enabled" SMALLINT DEFAULT 0, "rev_initial_load_time" DATETIME, "rev_initial_load_id" BIGINT, "rev_initial_load_create_by" VARCHAR(255), "created_at_node_id" VARCHAR(50) NOT NULL, PRIMARY KEY ("node_id") ) 2014-07-16 15:22:02,276 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:02,280 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_outgoing_batch"( "batch_id" BIGINT NOT NULL, "node_id" VARCHAR(50) NOT NULL, "channel_id" VARCHAR(128), "status" CHAR(2), "load_id" BIGINT, "extract_job_flag" SMALLINT DEFAULT 0, "load_flag" SMALLINT DEFAULT 0, "error_flag" SMALLINT DEFAULT 0, "common_flag" SMALLINT DEFAULT 0, "ignore_count" BIGINT DEFAULT 0 NOT NULL, "byte_count" BIGINT DEFAULT 0 NOT NULL, "extract_count" BIGINT DEFAULT 0 NOT NULL, "sent_count" BIGINT DEFAULT 0 NOT NULL, "load_count" BIGINT DEFAULT 0 NOT NULL, "data_event_count" BIGINT DEFAULT 0 NOT NULL, "reload_event_count" BIGINT DEFAULT 0 NOT NULL, "insert_event_count" BIGINT DEFAULT 0 NOT NULL, "update_event_count" BIGINT DEFAULT 0 NOT NULL, "delete_event_count" BIGINT DEFAULT 0 NOT NULL, "other_event_count" BIGINT DEFAULT 0 NOT NULL, "router_millis" BIGINT DEFAULT 0 NOT NULL, "network_millis" BIGINT DEFAULT 0 NOT NULL, "filter_millis" BIGINT DEFAULT 0 NOT NULL, "load_millis" BIGINT DEFAULT 0 NOT NULL, "extract_millis" BIGINT DEFAULT 0 NOT NULL, "sql_state" VARCHAR(10), "sql_code" INT DEFAULT 0 NOT NULL, "sql_message" TEXT, "failed_data_id" BIGINT DEFAULT 0 NOT NULL, "failed_line_number" BIGINT DEFAULT 0 NOT NULL, "last_update_hostname" VARCHAR(255), "last_update_time" DATETIME, "create_time" DATETIME, "create_by" VARCHAR(255), PRIMARY KEY ("batch_id", "node_id") ) 2014-07-16 15:22:02,289 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE INDEX "sym_idx_ob_node_status" ON "sym_outgoing_batch" ("node_id", "status") 2014-07-16 15:22:02,290 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE INDEX "sym_idx_ob_status" ON "sym_outgoing_batch" ("status") 2014-07-16 15:22:02,291 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE INDEX "sym_idx_ob_in_error" ON "sym_outgoing_batch" ("error_flag") 2014-07-16 15:22:02,293 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:02,294 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_parameter"( "external_id" VARCHAR(50) NOT NULL, "node_group_id" VARCHAR(50) NOT NULL, "param_key" VARCHAR(80) NOT NULL, "param_value" TEXT, "create_time" DATETIME, "last_update_by" VARCHAR(50), "last_update_time" DATETIME, PRIMARY KEY ("external_id", "node_group_id", "param_key") ) 2014-07-16 15:22:02,294 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:02,298 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_registration_redirect"( "registrant_external_id" VARCHAR(50) NOT NULL, "registration_node_id" VARCHAR(50) NOT NULL, PRIMARY KEY ("registrant_external_id") ) 2014-07-16 15:22:02,298 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:02,299 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_registration_request"( "node_group_id" VARCHAR(50) NOT NULL, "external_id" VARCHAR(50) NOT NULL, "status" CHAR(2) NOT NULL, "host_name" VARCHAR(60) NOT NULL, "ip_address" VARCHAR(50) NOT NULL, "attempt_count" INT DEFAULT 0, "registered_node_id" VARCHAR(50), "error_message" TEXT, "create_time" DATETIME NOT NULL, "last_update_by" VARCHAR(50), "last_update_time" DATETIME NOT NULL, PRIMARY KEY ("node_group_id", "external_id", "create_time") ) 2014-07-16 15:22:02,302 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE INDEX "sym_idx_reg_req_1" ON "sym_registration_request" ("node_group_id", "external_id", "status", "host_name", "ip_address") 2014-07-16 15:22:02,306 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE INDEX "sym_idx_reg_req_2" ON "sym_registration_request" ("status") 2014-07-16 15:22:02,307 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:02,316 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_router"( "router_id" VARCHAR(50) NOT NULL, "target_catalog_name" VARCHAR(255), "target_schema_name" VARCHAR(255), "target_table_name" VARCHAR(255), "source_node_group_id" VARCHAR(50) NOT NULL, "target_node_group_id" VARCHAR(50) NOT NULL, "router_type" VARCHAR(50), "router_expression" TEXT, "sync_on_update" SMALLINT DEFAULT 1 NOT NULL, "sync_on_insert" SMALLINT DEFAULT 1 NOT NULL, "sync_on_delete" SMALLINT DEFAULT 1 NOT NULL, "use_source_catalog_schema" SMALLINT DEFAULT 1 NOT NULL, "create_time" DATETIME NOT NULL, "last_update_by" VARCHAR(50), "last_update_time" DATETIME NOT NULL, PRIMARY KEY ("router_id") ) 2014-07-16 15:22:02,317 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:02,319 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_sequence"( "sequence_name" VARCHAR(50) NOT NULL, "current_value" BIGINT DEFAULT 0 NOT NULL, "increment_by" INT DEFAULT 1 NOT NULL, "min_value" BIGINT DEFAULT 1 NOT NULL, "max_value" BIGINT DEFAULT 9999999999 NOT NULL, "cycle" SMALLINT DEFAULT 0, "create_time" DATETIME, "last_update_by" VARCHAR(50), "last_update_time" DATETIME NOT NULL, PRIMARY KEY ("sequence_name") ) 2014-07-16 15:22:02,320 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:02,322 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_table_reload_request"( "target_node_id" VARCHAR(50) NOT NULL, "source_node_id" VARCHAR(50) NOT NULL, "trigger_id" VARCHAR(128) NOT NULL, "router_id" VARCHAR(50) NOT NULL, "reload_select" TEXT, "reload_delete_stmt" TEXT, "reload_enabled" SMALLINT DEFAULT 0, "reload_time" DATETIME, "create_time" DATETIME, "last_update_by" VARCHAR(50), "last_update_time" DATETIME NOT NULL, PRIMARY KEY ("target_node_id", "source_node_id", "trigger_id", "router_id") ) 2014-07-16 15:22:02,325 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:02,330 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_transform_table"( "transform_id" VARCHAR(50) NOT NULL, "source_node_group_id" VARCHAR(50) NOT NULL, "target_node_group_id" VARCHAR(50) NOT NULL, "transform_point" VARCHAR(10) NOT NULL, "source_catalog_name" VARCHAR(255), "source_schema_name" VARCHAR(255), "source_table_name" VARCHAR(255) NOT NULL, "target_catalog_name" VARCHAR(255), "target_schema_name" VARCHAR(255), "target_table_name" VARCHAR(255), "update_first" SMALLINT DEFAULT 0, "delete_action" VARCHAR(10) NOT NULL, "transform_order" INT DEFAULT 1 NOT NULL, "column_policy" VARCHAR(10) DEFAULT 'SPECIFIED' NOT NULL, "create_time" DATETIME, "last_update_by" VARCHAR(50), "last_update_time" DATETIME, PRIMARY KEY ("transform_id", "source_node_group_id", "target_node_group_id") ) 2014-07-16 15:22:02,331 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:02,332 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_transform_column"( "transform_id" VARCHAR(50) NOT NULL, "include_on" CHAR(1) DEFAULT '*' NOT NULL, "target_column_name" VARCHAR(128) NOT NULL, "source_column_name" VARCHAR(128), "pk" SMALLINT DEFAULT 0, "transform_type" VARCHAR(50) DEFAULT 'copy', "transform_expression" TEXT, "transform_order" INT DEFAULT 1 NOT NULL, "create_time" DATETIME, "last_update_by" VARCHAR(50), "last_update_time" DATETIME, PRIMARY KEY ("transform_id", "include_on", "target_column_name") ) 2014-07-16 15:22:02,340 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:02,343 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_trigger"( "trigger_id" VARCHAR(128) NOT NULL, "source_catalog_name" VARCHAR(255), "source_schema_name" VARCHAR(255), "source_table_name" VARCHAR(255) NOT NULL, "channel_id" VARCHAR(128) NOT NULL, "reload_channel_id" VARCHAR(128) DEFAULT 'reload' NOT NULL, "sync_on_update" SMALLINT DEFAULT 1 NOT NULL, "sync_on_insert" SMALLINT DEFAULT 1 NOT NULL, "sync_on_delete" SMALLINT DEFAULT 1 NOT NULL, "sync_on_incoming_batch" SMALLINT DEFAULT 0 NOT NULL, "name_for_update_trigger" VARCHAR(255), "name_for_insert_trigger" VARCHAR(255), "name_for_delete_trigger" VARCHAR(255), "sync_on_update_condition" TEXT, "sync_on_insert_condition" TEXT, "sync_on_delete_condition" TEXT, "custom_on_update_text" TEXT, "custom_on_insert_text" TEXT, "custom_on_delete_text" TEXT, "external_select" TEXT, "tx_id_expression" TEXT, "channel_expression" TEXT, "excluded_column_names" TEXT, "sync_key_names" TEXT, "use_stream_lobs" SMALLINT DEFAULT 0 NOT NULL, "use_capture_lobs" SMALLINT DEFAULT 0 NOT NULL, "use_capture_old_data" SMALLINT DEFAULT 1 NOT NULL, "use_handle_key_updates" SMALLINT DEFAULT 0 NOT NULL, "create_time" DATETIME NOT NULL, "last_update_by" VARCHAR(50), "last_update_time" DATETIME NOT NULL, PRIMARY KEY ("trigger_id") ) 2014-07-16 15:22:02,354 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:02,356 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_trigger_hist"( "trigger_hist_id" INT NOT NULL, "trigger_id" VARCHAR(128) NOT NULL, "source_table_name" VARCHAR(255) NOT NULL, "source_catalog_name" VARCHAR(255), "source_schema_name" VARCHAR(255), "name_for_update_trigger" VARCHAR(255), "name_for_insert_trigger" VARCHAR(255), "name_for_delete_trigger" VARCHAR(255), "table_hash" BIGINT DEFAULT 0 NOT NULL, "trigger_row_hash" BIGINT DEFAULT 0 NOT NULL, "trigger_template_hash" BIGINT DEFAULT 0 NOT NULL, "column_names" TEXT NOT NULL, "pk_column_names" TEXT NOT NULL, "last_trigger_build_reason" CHAR(1) NOT NULL, "error_message" TEXT, "create_time" DATETIME NOT NULL, "inactive_time" DATETIME, PRIMARY KEY ("trigger_hist_id") ) 2014-07-16 15:22:02,359 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:02,365 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_trigger_router"( "trigger_id" VARCHAR(128) NOT NULL, "router_id" VARCHAR(50) NOT NULL, "enabled" SMALLINT DEFAULT 1 NOT NULL, "initial_load_order" INT DEFAULT 1 NOT NULL, "initial_load_select" TEXT, "initial_load_delete_stmt" TEXT, "initial_load_batch_count" INT DEFAULT 1, "ping_back_enabled" SMALLINT DEFAULT 0 NOT NULL, "create_time" DATETIME NOT NULL, "last_update_by" VARCHAR(50), "last_update_time" DATETIME NOT NULL, PRIMARY KEY ("trigger_id", "router_id") ) 2014-07-16 15:22:02,368 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:22:02,369 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_trigger_router_grouplet"( "grouplet_id" VARCHAR(50) NOT NULL, "trigger_id" VARCHAR(128) NOT NULL, "router_id" VARCHAR(50) NOT NULL, "applies_when" CHAR(1) NOT NULL, "create_time" DATETIME NOT NULL, "last_update_by" VARCHAR(50), "last_update_time" DATETIME NOT NULL, PRIMARY KEY ("grouplet_id", "trigger_id", "router_id", "applies_when") ) 2014-07-16 15:22:02,374 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: ALTER TABLE "sym_conflict" ADD CONSTRAINT "sym_fk_cf_2_grp_lnk" FOREIGN KEY ("source_node_group_id", "target_node_group_id") REFERENCES "sym_node_group_link" ("source_node_group_id", "target_node_group_id") 2014-07-16 15:22:02,375 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: ALTER TABLE "sym_file_trigger_router" ADD CONSTRAINT "sym_fk_ftr_2_ftrg" FOREIGN KEY ("trigger_id") REFERENCES "sym_file_trigger" ("trigger_id") 2014-07-16 15:22:02,376 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: ALTER TABLE "sym_file_trigger_router" ADD CONSTRAINT "sym_fk_ftr_2_rtr" FOREIGN KEY ("router_id") REFERENCES "sym_router" ("router_id") 2014-07-16 15:22:02,378 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: ALTER TABLE "sym_grouplet_link" ADD CONSTRAINT "sym_fk_gpltlnk_2_gplt" FOREIGN KEY ("grouplet_id") REFERENCES "sym_grouplet" ("grouplet_id") 2014-07-16 15:22:02,379 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: ALTER TABLE "sym_node_group_link" ADD CONSTRAINT "sym_fk_lnk_2_grp_src" FOREIGN KEY ("source_node_group_id") REFERENCES "sym_node_group" ("node_group_id") 2014-07-16 15:22:02,380 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: ALTER TABLE "sym_node_group_link" ADD CONSTRAINT "sym_fk_lnk_2_grp_tgt" FOREIGN KEY ("target_node_group_id") REFERENCES "sym_node_group" ("node_group_id") 2014-07-16 15:22:02,382 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: ALTER TABLE "sym_node_identity" ADD CONSTRAINT "sym_fk_ident_2_node" FOREIGN KEY ("node_id") REFERENCES "sym_node" ("node_id") 2014-07-16 15:22:02,383 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: ALTER TABLE "sym_node_security" ADD CONSTRAINT "sym_fk_sec_2_node" FOREIGN KEY ("node_id") REFERENCES "sym_node" ("node_id") 2014-07-16 15:22:02,384 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: ALTER TABLE "sym_router" ADD CONSTRAINT "sym_fk_rt_2_grp_lnk" FOREIGN KEY ("source_node_group_id", "target_node_group_id") REFERENCES "sym_node_group_link" ("source_node_group_id", "target_node_group_id") 2014-07-16 15:22:02,406 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: ALTER TABLE "sym_transform_table" ADD CONSTRAINT "sym_fk_tt_2_grp_lnk" FOREIGN KEY ("source_node_group_id", "target_node_group_id") REFERENCES "sym_node_group_link" ("source_node_group_id", "target_node_group_id") 2014-07-16 15:22:02,407 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: ALTER TABLE "sym_trigger" ADD CONSTRAINT "sym_fk_trg_2_chnl" FOREIGN KEY ("channel_id") REFERENCES "sym_channel" ("channel_id") 2014-07-16 15:22:02,408 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: ALTER TABLE "sym_trigger" ADD CONSTRAINT "sym_fk_trg_2_rld_chnl" FOREIGN KEY ("reload_channel_id") REFERENCES "sym_channel" ("channel_id") 2014-07-16 15:22:02,409 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: ALTER TABLE "sym_trigger_router" ADD CONSTRAINT "sym_fk_tr_2_trg" FOREIGN KEY ("trigger_id") REFERENCES "sym_trigger" ("trigger_id") 2014-07-16 15:22:02,409 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: ALTER TABLE "sym_trigger_router" ADD CONSTRAINT "sym_fk_tr_2_rtr" FOREIGN KEY ("router_id") REFERENCES "sym_router" ("router_id") 2014-07-16 15:22:02,410 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: ALTER TABLE "sym_trigger_router_grouplet" ADD CONSTRAINT "sym_fk_trgplt_2_gplt" FOREIGN KEY ("grouplet_id") REFERENCES "sym_grouplet" ("grouplet_id") 2014-07-16 15:22:02,411 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: ALTER TABLE "sym_trigger_router_grouplet" ADD CONSTRAINT "sym_fk_trgplt_2_tr" FOREIGN KEY ("trigger_id", "router_id") REFERENCES "sym_trigger_router" ("trigger_id", "router_id") 2014-07-16 15:22:02,412 INFO [corp-000] [MsSqlSymmetricDialect] [main] Done with auto update of SymmetricDS tables 2014-07-16 15:22:02,424 INFO [corp-000] [MsSqlSymmetricDialect] [main] Updating indexes to prevent lock escalation 2014-07-16 15:22:02,497 INFO [corp-000] [MsSqlSymmetricDialect] [main] Just installed sym_base64_encode 2014-07-16 15:22:02,500 INFO [corp-000] [MsSqlSymmetricDialect] [main] Just installed sym_triggers_disabled 2014-07-16 15:22:02,501 INFO [corp-000] [MsSqlSymmetricDialect] [main] Just installed sym_node_disabled 2014-07-16 15:22:02,504 INFO [corp-000] [ConfigurationService] [main] Auto-configuring config channel 2014-07-16 15:22:02,513 INFO [corp-000] [ConfigurationService] [main] Auto-configuring reload channel 2014-07-16 15:22:02,514 INFO [corp-000] [ConfigurationService] [main] Auto-configuring heartbeat channel 2014-07-16 15:22:02,516 INFO [corp-000] [ConfigurationService] [main] Auto-configuring default channel 2014-07-16 15:22:02,517 INFO [corp-000] [ConfigurationService] [main] Auto-configuring dynamic channel 2014-07-16 15:22:02,518 INFO [corp-000] [ConfigurationService] [main] Auto-configuring filesync channel 2014-07-16 15:22:02,519 INFO [corp-000] [ConfigurationService] [main] Auto-configuring filesync_reload channel 2014-07-16 15:22:02,536 INFO [corp-000] [AbstractSymmetricEngine] [main] Done initializing SymmetricDS database 2014-07-16 15:22:24,412 INFO [] [AbstractCommandLauncher] [main] Option: name=engine, value={corp-000} 2014-07-16 15:22:24,571 INFO [] [JdbcDatabasePlatformFactory] [main] Detected database 'Microsoft SQL Server', version '10', protocol 'jtds' 2014-07-16 15:23:12,887 INFO [startup] [AbstractCommandLauncher] [main] Option: name=engine, value={corp-000} 2014-07-16 15:23:12,888 INFO [startup] [AbstractCommandLauncher] [main] Option: name=port, value={7070} 2014-07-16 15:23:12,985 INFO [startup] [SymmetricWebServer] [main] About to start SymmetricDS web server on host:port default:7070 2014-07-16 15:23:14,093 INFO [startup] [/] [main] Initializing Spring root WebApplicationContext 2014-07-16 15:23:14,624 INFO [corp-000] [JdbcDatabasePlatformFactory] [symmetric-startup] Detected database 'Microsoft SQL Server', version '10', protocol 'jtds' 2014-07-16 15:23:14,661 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] The DbDialect being used is org.jumpmind.symmetric.db.mssql.MsSqlSymmetricDialect 2014-07-16 15:23:14,667 INFO [corp-000] [StagingManager] [symmetric-startup] The staging directory was initialized at the following location: C:\Users\user.name\symmetricds\sym-corp-fix\symmetric-3.6.3-SNAPSHOT\tmp\corp-000 2014-07-16 15:23:14,698 INFO [corp-000] [ClusterService] [symmetric-startup] This node picked a server id of T005583.eu.Micros.int 2014-07-16 15:23:14,878 INFO [corp-000] [ExtensionPointManager] [symmetric-startup] Found 8 extension points that will be registered 2014-07-16 15:23:14,906 INFO [corp-000] [AbstractSymmetricEngine] [symmetric-startup] Initializing SymmetricDS database 2014-07-16 15:23:14,906 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Checking if SymmetricDS tables need created or altered 2014-07-16 15:23:14,955 INFO [startup] [/] [main] Initializing Spring FrameworkServlet 'rest' 2014-07-16 15:23:15,094 INFO [startup] [SymmetricWebServer] [main] Starting JMX HTTP console on port 7071 2014-07-16 15:23:15,112 INFO [startup] [SymmetricWebServer] [main] Joining the web server main thread 2014-07-16 15:23:15,483 INFO [corp-000] [AbstractSymmetricEngine] [symmetric-startup] Done initializing SymmetricDS database 2014-07-16 15:23:15,494 INFO [corp-000] [AbstractSymmetricEngine] [symmetric-startup] Starting registered node [group=corp, id=000, externalId=000] 2014-07-16 15:23:15,494 INFO [corp-000] [TriggerRouterService] [symmetric-startup] Synchronizing triggers 2014-07-16 15:23:15,545 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_LD_FLTR_CRP trigger for sym-corp.dbo.sym_load_filter 2014-07-16 15:23:15,555 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_LD_FLTR_CRP trigger for sym-corp.dbo.sym_load_filter 2014-07-16 15:23:15,560 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_LD_FLTR_CRP trigger for sym-corp.dbo.sym_load_filter 2014-07-16 15:23:15,574 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_CNFLCT_CRP trigger for sym-corp.dbo.sym_conflict 2014-07-16 15:23:15,579 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_CNFLCT_CRP trigger for sym-corp.dbo.sym_conflict 2014-07-16 15:23:15,583 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_CNFLCT_CRP trigger for sym-corp.dbo.sym_conflict 2014-07-16 15:23:15,594 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_GRPLT_CRP trigger for sym-corp.dbo.sym_grouplet 2014-07-16 15:23:15,599 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_GRPLT_CRP trigger for sym-corp.dbo.sym_grouplet 2014-07-16 15:23:15,602 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_GRPLT_CRP trigger for sym-corp.dbo.sym_grouplet 2014-07-16 15:23:15,614 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_TRGGR_RTR_GRPLT_CRP trigger for sym-corp.dbo.sym_trigger_router_grouplet 2014-07-16 15:23:15,617 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_TRGGR_RTR_GRPLT_CRP trigger for sym-corp.dbo.sym_trigger_router_grouplet 2014-07-16 15:23:15,621 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_TRGGR_RTR_GRPLT_CRP trigger for sym-corp.dbo.sym_trigger_router_grouplet 2014-07-16 15:23:15,635 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_FL_SNPSHT_CRP trigger for sym-corp.dbo.sym_file_snapshot 2014-07-16 15:23:15,639 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_FL_SNPSHT_CRP trigger for sym-corp.dbo.sym_file_snapshot 2014-07-16 15:23:15,654 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_RTR_CRP trigger for sym-corp.dbo.sym_router 2014-07-16 15:23:15,658 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_RTR_CRP trigger for sym-corp.dbo.sym_router 2014-07-16 15:23:15,662 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_RTR_CRP trigger for sym-corp.dbo.sym_router 2014-07-16 15:23:15,675 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_FL_TRGGR_RTR_CRP trigger for sym-corp.dbo.sym_file_trigger_router 2014-07-16 15:23:15,679 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_FL_TRGGR_RTR_CRP trigger for sym-corp.dbo.sym_file_trigger_router 2014-07-16 15:23:15,683 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_FL_TRGGR_RTR_CRP trigger for sym-corp.dbo.sym_file_trigger_router 2014-07-16 15:23:15,695 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_TRGGR_RTR_CRP trigger for sym-corp.dbo.sym_trigger_router 2014-07-16 15:23:15,698 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_TRGGR_RTR_CRP trigger for sym-corp.dbo.sym_trigger_router 2014-07-16 15:23:15,703 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_TRGGR_RTR_CRP trigger for sym-corp.dbo.sym_trigger_router 2014-07-16 15:23:15,715 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_ND_GRP_CHNNL_WND_CRP trigger for sym-corp.dbo.sym_node_group_channel_wnd 2014-07-16 15:23:15,718 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_ND_GRP_CHNNL_WND_CRP trigger for sym-corp.dbo.sym_node_group_channel_wnd 2014-07-16 15:23:15,721 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_ND_GRP_CHNNL_WND_CRP trigger for sym-corp.dbo.sym_node_group_channel_wnd 2014-07-16 15:23:15,733 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_TM_SLLNG_PRC_CRP trigger for sym-corp.dbo.item_selling_price 2014-07-16 15:23:15,737 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_TM_SLLNG_PRC_CRP trigger for sym-corp.dbo.item_selling_price 2014-07-16 15:23:15,742 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_TM_SLLNG_PRC_CRP trigger for sym-corp.dbo.item_selling_price 2014-07-16 15:23:15,754 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_ND_GRP_LNK_CRP trigger for sym-corp.dbo.sym_node_group_link 2014-07-16 15:23:15,757 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_ND_GRP_LNK_CRP trigger for sym-corp.dbo.sym_node_group_link 2014-07-16 15:23:15,760 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_ND_GRP_LNK_CRP trigger for sym-corp.dbo.sym_node_group_link 2014-07-16 15:23:15,780 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_ND_HST_CRP trigger for sym-corp.dbo.sym_node_host 2014-07-16 15:23:15,784 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_ND_HST_CRP trigger for sym-corp.dbo.sym_node_host 2014-07-16 15:23:15,788 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_ND_HST_CRP trigger for sym-corp.dbo.sym_node_host 2014-07-16 15:23:15,802 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_CHNNL_CRP trigger for sym-corp.dbo.sym_channel 2014-07-16 15:23:15,806 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_CHNNL_CRP trigger for sym-corp.dbo.sym_channel 2014-07-16 15:23:15,810 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_CHNNL_CRP trigger for sym-corp.dbo.sym_channel 2014-07-16 15:23:15,822 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_FL_TRGGR_CRP trigger for sym-corp.dbo.sym_file_trigger 2014-07-16 15:23:15,826 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_FL_TRGGR_CRP trigger for sym-corp.dbo.sym_file_trigger 2014-07-16 15:23:15,830 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_FL_TRGGR_CRP trigger for sym-corp.dbo.sym_file_trigger 2014-07-16 15:23:15,842 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_ND_CRP trigger for sym-corp.dbo.sym_node 2014-07-16 15:23:15,845 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_ND_CRP trigger for sym-corp.dbo.sym_node 2014-07-16 15:23:15,849 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_ND_CRP trigger for sym-corp.dbo.sym_node 2014-07-16 15:23:15,859 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_GRPLT_LNK_CRP trigger for sym-corp.dbo.sym_grouplet_link 2014-07-16 15:23:15,863 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_GRPLT_LNK_CRP trigger for sym-corp.dbo.sym_grouplet_link 2014-07-16 15:23:15,866 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_GRPLT_LNK_CRP trigger for sym-corp.dbo.sym_grouplet_link 2014-07-16 15:23:15,874 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_TM_CRP trigger for sym-corp.dbo.item 2014-07-16 15:23:15,876 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_TM_CRP trigger for sym-corp.dbo.item 2014-07-16 15:23:15,879 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_TM_CRP trigger for sym-corp.dbo.item 2014-07-16 15:23:15,941 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_ND_SCRTY_CRP trigger for sym-corp.dbo.sym_node_security 2014-07-16 15:23:15,946 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_ND_SCRTY_CRP trigger for sym-corp.dbo.sym_node_security 2014-07-16 15:23:15,949 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_ND_SCRTY_CRP trigger for sym-corp.dbo.sym_node_security 2014-07-16 15:23:15,962 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_TRGGR_CRP trigger for sym-corp.dbo.sym_trigger 2014-07-16 15:23:15,968 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_TRGGR_CRP trigger for sym-corp.dbo.sym_trigger 2014-07-16 15:23:15,973 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_TRGGR_CRP trigger for sym-corp.dbo.sym_trigger 2014-07-16 15:23:15,987 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_TRNSFRM_CLMN_CRP trigger for sym-corp.dbo.sym_transform_column 2014-07-16 15:23:15,991 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_TRNSFRM_CLMN_CRP trigger for sym-corp.dbo.sym_transform_column 2014-07-16 15:23:15,994 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_TRNSFRM_CLMN_CRP trigger for sym-corp.dbo.sym_transform_column 2014-07-16 15:23:16,006 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_TBL_RLD_RQST_CRP trigger for sym-corp.dbo.sym_table_reload_request 2014-07-16 15:23:16,009 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_TBL_RLD_RQST_CRP trigger for sym-corp.dbo.sym_table_reload_request 2014-07-16 15:23:16,014 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_TBL_RLD_RQST_CRP trigger for sym-corp.dbo.sym_table_reload_request 2014-07-16 15:23:16,025 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_ND_GRP_CRP trigger for sym-corp.dbo.sym_node_group 2014-07-16 15:23:16,028 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_ND_GRP_CRP trigger for sym-corp.dbo.sym_node_group 2014-07-16 15:23:16,048 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_ND_GRP_CRP trigger for sym-corp.dbo.sym_node_group 2014-07-16 15:23:16,060 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_PRMTR_CRP trigger for sym-corp.dbo.sym_parameter 2014-07-16 15:23:16,064 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_PRMTR_CRP trigger for sym-corp.dbo.sym_parameter 2014-07-16 15:23:16,069 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_PRMTR_CRP trigger for sym-corp.dbo.sym_parameter 2014-07-16 15:23:16,081 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_TRNSFRM_TBL_CRP trigger for sym-corp.dbo.sym_transform_table 2014-07-16 15:23:16,085 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_TRNSFRM_TBL_CRP trigger for sym-corp.dbo.sym_transform_table 2014-07-16 15:23:16,089 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_TRNSFRM_TBL_CRP trigger for sym-corp.dbo.sym_transform_table 2014-07-16 15:23:16,092 INFO [corp-000] [TriggerRouterService] [symmetric-startup] Done synchronizing triggers 2014-07-16 15:23:16,092 INFO [corp-000] [PushHeartbeatListener] [symmetric-startup] Some attribute(s) of node changed. Recording changes 2014-07-16 15:23:16,093 INFO [corp-000] [PushHeartbeatListener] [symmetric-startup] Updating my node configuration info according to the symmetric properties 2014-07-16 15:23:16,128 INFO [corp-000] [RouterJob] [symmetric-startup] Starting job.routing on periodic schedule: every 5000ms with the first run at Wed Jul 16 15:23:25 CEST 2014 2014-07-16 15:23:16,131 INFO [corp-000] [PushJob] [symmetric-startup] Starting job.push on periodic schedule: every 10000ms with the first run at Wed Jul 16 15:23:25 CEST 2014 2014-07-16 15:23:16,132 INFO [corp-000] [PullJob] [symmetric-startup] Starting job.pull on periodic schedule: every 10000ms with the first run at Wed Jul 16 15:23:25 CEST 2014 2014-07-16 15:23:16,132 INFO [corp-000] [OutgoingPurgeJob] [symmetric-startup] Starting job.purge.outgoing with cron expression: 0 0 0 * * * 2014-07-16 15:23:16,134 INFO [corp-000] [IncomingPurgeJob] [symmetric-startup] Starting job.purge.incoming with cron expression: 0 0 0 * * * 2014-07-16 15:23:16,135 INFO [corp-000] [DataGapPurgeJob] [symmetric-startup] Starting job.purge.datagaps with cron expression: 0 0 0 * * * 2014-07-16 15:23:16,135 INFO [corp-000] [StatisticFlushJob] [symmetric-startup] Starting job.stat.flush with cron expression: 0 0/5 * * * * 2014-07-16 15:23:16,135 INFO [corp-000] [SyncTriggersJob] [symmetric-startup] Starting job.synctriggers with cron expression: 0 0 0 * * * 2014-07-16 15:23:16,136 INFO [corp-000] [HeartbeatJob] [symmetric-startup] Starting job.heartbeat on periodic schedule: every 900000ms with the first run at Wed Jul 16 15:23:25 CEST 2014 2014-07-16 15:23:16,136 INFO [corp-000] [WatchdogJob] [symmetric-startup] Starting job.watchdog on periodic schedule: every 3600000ms with the first run at Wed Jul 16 15:23:25 CEST 2014 2014-07-16 15:23:16,136 INFO [corp-000] [StageManagementJob] [symmetric-startup] Starting job.stage.management on periodic schedule: every 15000ms with the first run at Wed Jul 16 15:23:25 CEST 2014 2014-07-16 15:23:16,137 INFO [corp-000] [JobManager] [symmetric-startup] Job job.refresh.cache not configured for auto start 2014-07-16 15:23:16,137 INFO [corp-000] [FileSyncTrackerJob] [symmetric-startup] Starting job.file.sync.tracker with cron expression: 0 0/5 * * * * 2014-07-16 15:23:16,137 INFO [corp-000] [FileSyncPullJob] [symmetric-startup] Starting job.file.sync.pull on periodic schedule: every 60000ms with the first run at Wed Jul 16 15:23:25 CEST 2014 2014-07-16 15:23:16,137 INFO [corp-000] [FileSyncPushJob] [symmetric-startup] Starting job.file.sync.push on periodic schedule: every 60000ms with the first run at Wed Jul 16 15:23:25 CEST 2014 2014-07-16 15:23:16,138 INFO [corp-000] [InitialLoadExtractorJob] [symmetric-startup] Starting job.initial.load.extract on periodic schedule: every 10000ms with the first run at Wed Jul 16 15:23:25 CEST 2014 2014-07-16 15:23:16,138 INFO [corp-000] [AbstractSymmetricEngine] [symmetric-startup] Started SymmetricDS 2014-07-16 15:23:16,138 INFO [corp-000] [AbstractSymmetricEngine] [symmetric-startup] SymmetricDS: type=server, name=corp-000, version=3.6.3-SNAPSHOT, groupId=corp, externalId=000, databaseName=Microsoft SQL Server, databaseVersion=10.50, driverName=jTDS Type 4 JDBC Driver for MS SQL Server and Sybase, driverVersion=1.2.4 2014-07-16 15:23:19,626 WARN [corp-000] [RegistrationUriHandler] [qtp14372770-19] store:001:? was not allowed to register. 2014-07-16 15:23:25,902 INFO [corp-000] [RouterService] [corp-000-job-5] The 'config' channel is NOT in common batch mode 2014-07-16 15:23:25,945 INFO [corp-000] [RouterService] [corp-000-job-5] The 'filesync_reload' channel is NOT in common batch mode 2014-07-16 15:23:25,947 INFO [corp-000] [RouterService] [corp-000-job-5] The 'item' channel is NOT in common batch mode 2014-07-16 15:23:25,948 INFO [corp-000] [RouterService] [corp-000-job-5] The 'reload' channel is NOT in common batch mode 2014-07-16 15:23:25,949 INFO [corp-000] [RouterService] [corp-000-job-5] The 'sale_transaction' channel is in common batch mode 2014-07-16 15:23:25,950 INFO [corp-000] [RouterService] [corp-000-job-5] The 'heartbeat' channel is NOT in common batch mode 2014-07-16 15:23:25,955 INFO [corp-000] [RouterService] [corp-000-job-5] The 'filesync' channel is NOT in common batch mode 2014-07-16 15:23:25,956 INFO [corp-000] [RouterService] [corp-000-job-5] The 'default' channel is in common batch mode 2014-07-16 15:23:25,956 INFO [corp-000] [RouterService] [corp-000-job-5] The 'dynamic' channel is in common batch mode 2014-07-16 15:23:25,957 INFO [corp-000] [RouterService] [corp-000-job-5] Routed 3 data events in 74 ms 2014-07-16 15:23:32,466 INFO [] [AbstractCommandLauncher] [main] Option: name=engine, value={corp-000} 2014-07-16 15:23:32,975 INFO [corp-000] [JdbcDatabasePlatformFactory] [main] Detected database 'Microsoft SQL Server', version '10', protocol 'jtds' 2014-07-16 15:23:33,008 INFO [corp-000] [MsSqlSymmetricDialect] [main] The DbDialect being used is org.jumpmind.symmetric.db.mssql.MsSqlSymmetricDialect 2014-07-16 15:23:33,014 INFO [corp-000] [StagingManager] [main] The staging directory was initialized at the following location: C:\Users\user.name\symmetricds\sym-corp-fix\symmetric-3.6.3-SNAPSHOT\tmp\corp-000 2014-07-16 15:23:33,042 INFO [corp-000] [ClusterService] [main] This node picked a server id of T005583.eu.Micros.int 2014-07-16 15:23:33,136 INFO [corp-000] [ExtensionPointManager] [main] Found 8 extension points that will be registered 2014-07-16 15:23:33,247 INFO [corp-000] [RegistrationService] [main] Just opened registration for external id of 001 and a node group of store and a node id of 001 2014-07-16 15:23:35,996 INFO [corp-000] [RouterService] [corp-000-job-4] Routed 2 data events in 15 ms 2014-07-16 15:23:37,510 INFO [corp-000] [MsSqlSymmetricDialect] [qtp14372770-20] This database DOES support disabling triggers during a symmetricds data load 2014-07-16 15:23:41,016 INFO [corp-000] [RouterService] [corp-000-job-8] Routed 2 data events in 16 ms 2014-07-16 15:23:46,038 INFO [corp-000] [RouterService] [corp-000-job-3] Routed 2 data events in 18 ms 2014-07-16 15:24:58,216 INFO [corp-000] [JdbcDatabasePlatformFactory] [main] Detected database 'Microsoft SQL Server', version '10', protocol 'jtds' 2014-07-16 15:24:58,251 INFO [corp-000] [MsSqlSymmetricDialect] [main] The DbDialect being used is org.jumpmind.symmetric.db.mssql.MsSqlSymmetricDialect 2014-07-16 15:24:58,257 INFO [corp-000] [StagingManager] [main] The staging directory was initialized at the following location: C:\Users\user.name\symmetricds\sym-corp-fix\symmetric-3.6.3-SNAPSHOT\tmp\corp-000 2014-07-16 15:24:58,286 INFO [corp-000] [ClusterService] [main] This node picked a server id of T005583.eu.Micros.int 2014-07-16 15:24:58,380 INFO [corp-000] [ExtensionPointManager] [main] Found 8 extension points that will be registered 2014-07-16 15:24:58,383 INFO [corp-000] [TriggerRouterService] [main] Synchronizing triggers 2014-07-16 15:24:58,708 INFO [corp-000] [MsSqlSymmetricDialect] [main] Creating SYM_ON_I_FOR_TM_CRP trigger for sym-corp.dbo.item 2014-07-16 15:24:58,715 INFO [corp-000] [MsSqlSymmetricDialect] [main] Creating SYM_ON_U_FOR_TM_CRP trigger for sym-corp.dbo.item 2014-07-16 15:24:58,719 INFO [corp-000] [MsSqlSymmetricDialect] [main] Creating SYM_ON_D_FOR_TM_CRP trigger for sym-corp.dbo.item 2014-07-16 15:24:58,737 INFO [corp-000] [TriggerRouterService] [main] Done synchronizing triggers 2014-07-16 15:25:10,083 INFO [] [AbstractCommandLauncher] [main] Option: name=node, value={001} 2014-07-16 15:25:10,595 INFO [corp-000] [JdbcDatabasePlatformFactory] [main] Detected database 'Microsoft SQL Server', version '10', protocol 'jtds' 2014-07-16 15:25:10,628 INFO [corp-000] [MsSqlSymmetricDialect] [main] The DbDialect being used is org.jumpmind.symmetric.db.mssql.MsSqlSymmetricDialect 2014-07-16 15:25:10,634 INFO [corp-000] [StagingManager] [main] The staging directory was initialized at the following location: C:\Users\user.name\symmetricds\sym-corp-fix\symmetric-3.6.3-SNAPSHOT\tmp\corp-000 2014-07-16 15:25:10,663 INFO [corp-000] [ClusterService] [main] This node picked a server id of T005583.eu.Micros.int 2014-07-16 15:25:10,756 INFO [corp-000] [ExtensionPointManager] [main] Found 8 extension points that will be registered 2014-07-16 15:25:47,760 INFO [corp-000] [JdbcDatabasePlatformFactory] [main] Detected database 'Microsoft SQL Server', version '10', protocol 'jtds' 2014-07-16 15:25:47,794 INFO [corp-000] [MsSqlSymmetricDialect] [main] The DbDialect being used is org.jumpmind.symmetric.db.mssql.MsSqlSymmetricDialect 2014-07-16 15:25:47,800 INFO [corp-000] [StagingManager] [main] The staging directory was initialized at the following location: C:\Users\user.name\symmetricds\sym-corp-fix\symmetric-3.6.3-SNAPSHOT\tmp\corp-000 2014-07-16 15:25:47,828 INFO [corp-000] [ClusterService] [main] This node picked a server id of T005583.eu.Micros.int 2014-07-16 15:25:47,923 INFO [corp-000] [ExtensionPointManager] [main] Found 8 extension points that will be registered 2014-07-16 15:25:51,382 INFO [corp-000] [PurgeService] [corp-000-job-12] Purged all 2 incoming batch for node 001 2014-07-16 15:25:51,382 INFO [corp-000] [RouterService] [corp-000-job-12] Inserted reload events for node 001 in 64 ms 2014-07-16 15:25:51,397 INFO [corp-000] [RouterService] [corp-000-job-12] Routed 2 data events in 15 ms 2014-07-16 15:25:58,014 ERROR [corp-000] [DataExtractorService] [qtp14372770-20] Failed to extract batch 001-13 org.jumpmind.symmetric.SymmetricException: The extracted row data did not have the expected (2) number of columns: "11000001","Yummy Gum" at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1598) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1576) at org.jumpmind.db.sql.JdbcSqlReadCursor.next(JdbcSqlReadCursor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.selectNext(DataExtractorService.java:1550) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.next(DataExtractorService.java:1501) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromSymDataSource.next(DataExtractorService.java:1358) at org.jumpmind.symmetric.io.data.reader.ExtractDataReader.nextTable(ExtractDataReader.java:99) at org.jumpmind.symmetric.io.data.DataProcessor.forEachTableInBatch(DataProcessor.java:160) at org.jumpmind.symmetric.io.data.DataProcessor.process(DataProcessor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService.extractOutgoingBatch(DataExtractorService.java:703) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:513) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:422) at org.jumpmind.symmetric.web.PullUriHandler.pull(PullUriHandler.java:117) at org.jumpmind.symmetric.web.PullUriHandler.handleWithCompression(PullUriHandler.java:89) at org.jumpmind.symmetric.web.AbstractCompressionUriHandler.handle(AbstractCompressionUriHandler.java:84) at org.jumpmind.symmetric.web.SymmetricServlet.service(SymmetricServlet.java:98) at javax.servlet.http.HttpServlet.service(HttpServlet.java:820) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:565) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:479) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:119) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:227) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1031) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:406) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:965) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:117) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:111) at org.eclipse.jetty.server.Server.handle(Server.java:348) at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:452) at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:884) at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:938) at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:630) at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:230) at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:77) at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:606) at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:46) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:603) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:538) at java.lang.Thread.run(Thread.java:662) 2014-07-16 15:26:07,682 ERROR [corp-000] [DataExtractorService] [qtp14372770-21] Failed to extract batch 001-13 org.jumpmind.symmetric.SymmetricException: The extracted row data did not have the expected (2) number of columns: "11000001","Yummy Gum" at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1598) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1576) at org.jumpmind.db.sql.JdbcSqlReadCursor.next(JdbcSqlReadCursor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.selectNext(DataExtractorService.java:1550) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.next(DataExtractorService.java:1501) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromSymDataSource.next(DataExtractorService.java:1358) at org.jumpmind.symmetric.io.data.reader.ExtractDataReader.nextTable(ExtractDataReader.java:99) at org.jumpmind.symmetric.io.data.DataProcessor.forEachTableInBatch(DataProcessor.java:160) at org.jumpmind.symmetric.io.data.DataProcessor.process(DataProcessor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService.extractOutgoingBatch(DataExtractorService.java:703) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:513) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:422) at org.jumpmind.symmetric.web.PullUriHandler.pull(PullUriHandler.java:117) at org.jumpmind.symmetric.web.PullUriHandler.handleWithCompression(PullUriHandler.java:89) at org.jumpmind.symmetric.web.AbstractCompressionUriHandler.handle(AbstractCompressionUriHandler.java:84) at org.jumpmind.symmetric.web.SymmetricServlet.service(SymmetricServlet.java:98) at javax.servlet.http.HttpServlet.service(HttpServlet.java:820) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:565) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:479) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:119) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:227) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1031) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:406) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:965) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:117) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:111) at org.eclipse.jetty.server.Server.handle(Server.java:348) at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:452) at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:884) at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:938) at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:630) at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:230) at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:77) at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:606) at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:46) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:603) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:538) at java.lang.Thread.run(Thread.java:662) 2014-07-16 15:26:17,687 ERROR [corp-000] [DataExtractorService] [qtp14372770-19] Failed to extract batch 001-13 org.jumpmind.symmetric.SymmetricException: The extracted row data did not have the expected (2) number of columns: "11000001","Yummy Gum" at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1598) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1576) at org.jumpmind.db.sql.JdbcSqlReadCursor.next(JdbcSqlReadCursor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.selectNext(DataExtractorService.java:1550) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.next(DataExtractorService.java:1501) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromSymDataSource.next(DataExtractorService.java:1358) at org.jumpmind.symmetric.io.data.reader.ExtractDataReader.nextTable(ExtractDataReader.java:99) at org.jumpmind.symmetric.io.data.DataProcessor.forEachTableInBatch(DataProcessor.java:160) at org.jumpmind.symmetric.io.data.DataProcessor.process(DataProcessor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService.extractOutgoingBatch(DataExtractorService.java:703) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:513) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:422) at org.jumpmind.symmetric.web.PullUriHandler.pull(PullUriHandler.java:117) at org.jumpmind.symmetric.web.PullUriHandler.handleWithCompression(PullUriHandler.java:89) at org.jumpmind.symmetric.web.AbstractCompressionUriHandler.handle(AbstractCompressionUriHandler.java:84) at org.jumpmind.symmetric.web.SymmetricServlet.service(SymmetricServlet.java:98) at javax.servlet.http.HttpServlet.service(HttpServlet.java:820) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:565) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:479) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:119) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:227) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1031) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:406) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:965) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:117) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:111) at org.eclipse.jetty.server.Server.handle(Server.java:348) at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:452) at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:884) at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:938) at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:630) at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:230) at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:77) at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:606) at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:46) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:603) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:538) at java.lang.Thread.run(Thread.java:662) 2014-07-16 15:26:27,692 ERROR [corp-000] [DataExtractorService] [qtp14372770-19] Failed to extract batch 001-13 org.jumpmind.symmetric.SymmetricException: The extracted row data did not have the expected (2) number of columns: "11000001","Yummy Gum" at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1598) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1576) at org.jumpmind.db.sql.JdbcSqlReadCursor.next(JdbcSqlReadCursor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.selectNext(DataExtractorService.java:1550) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.next(DataExtractorService.java:1501) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromSymDataSource.next(DataExtractorService.java:1358) at org.jumpmind.symmetric.io.data.reader.ExtractDataReader.nextTable(ExtractDataReader.java:99) at org.jumpmind.symmetric.io.data.DataProcessor.forEachTableInBatch(DataProcessor.java:160) at org.jumpmind.symmetric.io.data.DataProcessor.process(DataProcessor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService.extractOutgoingBatch(DataExtractorService.java:703) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:513) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:422) at org.jumpmind.symmetric.web.PullUriHandler.pull(PullUriHandler.java:117) at org.jumpmind.symmetric.web.PullUriHandler.handleWithCompression(PullUriHandler.java:89) at org.jumpmind.symmetric.web.AbstractCompressionUriHandler.handle(AbstractCompressionUriHandler.java:84) at org.jumpmind.symmetric.web.SymmetricServlet.service(SymmetricServlet.java:98) at javax.servlet.http.HttpServlet.service(HttpServlet.java:820) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:565) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:479) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:119) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:227) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1031) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:406) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:965) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:117) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:111) at org.eclipse.jetty.server.Server.handle(Server.java:348) at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:452) at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:884) at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:938) at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:630) at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:230) at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:77) at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:606) at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:46) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:603) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:538) at java.lang.Thread.run(Thread.java:662) 2014-07-16 15:26:37,700 ERROR [corp-000] [DataExtractorService] [qtp14372770-19] Failed to extract batch 001-13 org.jumpmind.symmetric.SymmetricException: The extracted row data did not have the expected (2) number of columns: "11000001","Yummy Gum" at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1598) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1576) at org.jumpmind.db.sql.JdbcSqlReadCursor.next(JdbcSqlReadCursor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.selectNext(DataExtractorService.java:1550) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.next(DataExtractorService.java:1501) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromSymDataSource.next(DataExtractorService.java:1358) at org.jumpmind.symmetric.io.data.reader.ExtractDataReader.nextTable(ExtractDataReader.java:99) at org.jumpmind.symmetric.io.data.DataProcessor.forEachTableInBatch(DataProcessor.java:160) at org.jumpmind.symmetric.io.data.DataProcessor.process(DataProcessor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService.extractOutgoingBatch(DataExtractorService.java:703) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:513) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:422) at org.jumpmind.symmetric.web.PullUriHandler.pull(PullUriHandler.java:117) at org.jumpmind.symmetric.web.PullUriHandler.handleWithCompression(PullUriHandler.java:89) at org.jumpmind.symmetric.web.AbstractCompressionUriHandler.handle(AbstractCompressionUriHandler.java:84) at org.jumpmind.symmetric.web.SymmetricServlet.service(SymmetricServlet.java:98) at javax.servlet.http.HttpServlet.service(HttpServlet.java:820) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:565) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:479) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:119) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:227) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1031) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:406) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:965) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:117) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:111) at org.eclipse.jetty.server.Server.handle(Server.java:348) at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:452) at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:884) at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:938) at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:630) at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:230) at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:77) at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:606) at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:46) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:603) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:538) at java.lang.Thread.run(Thread.java:662) 2014-07-16 15:26:47,702 ERROR [corp-000] [DataExtractorService] [qtp14372770-19] Failed to extract batch 001-13 org.jumpmind.symmetric.SymmetricException: The extracted row data did not have the expected (2) number of columns: "11000001","Yummy Gum" at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1598) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1576) at org.jumpmind.db.sql.JdbcSqlReadCursor.next(JdbcSqlReadCursor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.selectNext(DataExtractorService.java:1550) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.next(DataExtractorService.java:1501) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromSymDataSource.next(DataExtractorService.java:1358) at org.jumpmind.symmetric.io.data.reader.ExtractDataReader.nextTable(ExtractDataReader.java:99) at org.jumpmind.symmetric.io.data.DataProcessor.forEachTableInBatch(DataProcessor.java:160) at org.jumpmind.symmetric.io.data.DataProcessor.process(DataProcessor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService.extractOutgoingBatch(DataExtractorService.java:703) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:513) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:422) at org.jumpmind.symmetric.web.PullUriHandler.pull(PullUriHandler.java:117) at org.jumpmind.symmetric.web.PullUriHandler.handleWithCompression(PullUriHandler.java:89) at org.jumpmind.symmetric.web.AbstractCompressionUriHandler.handle(AbstractCompressionUriHandler.java:84) at org.jumpmind.symmetric.web.SymmetricServlet.service(SymmetricServlet.java:98) at javax.servlet.http.HttpServlet.service(HttpServlet.java:820) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:565) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:479) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:119) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:227) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1031) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:406) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:965) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:117) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:111) at org.eclipse.jetty.server.Server.handle(Server.java:348) at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:452) at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:884) at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:938) at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:630) at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:230) at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:77) at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:606) at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:46) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:603) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:538) at java.lang.Thread.run(Thread.java:662) 2014-07-16 15:26:50,086 INFO [corp-000] [JdbcDatabasePlatformFactory] [main] Detected database 'Microsoft SQL Server', version '10', protocol 'jtds' 2014-07-16 15:26:50,121 INFO [corp-000] [MsSqlSymmetricDialect] [main] The DbDialect being used is org.jumpmind.symmetric.db.mssql.MsSqlSymmetricDialect 2014-07-16 15:26:50,127 INFO [corp-000] [StagingManager] [main] The staging directory was initialized at the following location: C:\Users\user.name\symmetricds\sym-corp-fix\symmetric-3.6.3-SNAPSHOT\tmp\corp-000 2014-07-16 15:26:50,155 INFO [corp-000] [ClusterService] [main] This node picked a server id of T005583.eu.Micros.int 2014-07-16 15:26:50,248 INFO [corp-000] [ExtensionPointManager] [main] Found 8 extension points that will be registered 2014-07-16 15:26:50,251 INFO [corp-000] [TriggerRouterService] [main] Synchronizing triggers 2014-07-16 15:26:50,569 INFO [corp-000] [TriggerRouterService] [main] Done synchronizing triggers 2014-07-16 15:26:57,706 ERROR [corp-000] [DataExtractorService] [qtp14372770-19] Failed to extract batch 001-13 org.jumpmind.symmetric.SymmetricException: The extracted row data did not have the expected (2) number of columns: "11000001","Yummy Gum" at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1598) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1576) at org.jumpmind.db.sql.JdbcSqlReadCursor.next(JdbcSqlReadCursor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.selectNext(DataExtractorService.java:1550) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.next(DataExtractorService.java:1501) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromSymDataSource.next(DataExtractorService.java:1358) at org.jumpmind.symmetric.io.data.reader.ExtractDataReader.nextTable(ExtractDataReader.java:99) at org.jumpmind.symmetric.io.data.DataProcessor.forEachTableInBatch(DataProcessor.java:160) at org.jumpmind.symmetric.io.data.DataProcessor.process(DataProcessor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService.extractOutgoingBatch(DataExtractorService.java:703) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:513) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:422) at org.jumpmind.symmetric.web.PullUriHandler.pull(PullUriHandler.java:117) at org.jumpmind.symmetric.web.PullUriHandler.handleWithCompression(PullUriHandler.java:89) at org.jumpmind.symmetric.web.AbstractCompressionUriHandler.handle(AbstractCompressionUriHandler.java:84) at org.jumpmind.symmetric.web.SymmetricServlet.service(SymmetricServlet.java:98) at javax.servlet.http.HttpServlet.service(HttpServlet.java:820) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:565) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:479) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:119) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:227) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1031) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:406) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:965) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:117) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:111) at org.eclipse.jetty.server.Server.handle(Server.java:348) at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:452) at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:884) at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:938) at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:630) at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:230) at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:77) at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:606) at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:46) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:603) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:538) at java.lang.Thread.run(Thread.java:662) 2014-07-16 15:26:58,821 INFO [] [AbstractCommandLauncher] [main] Option: name=node, value={001} 2014-07-16 15:26:59,333 INFO [corp-000] [JdbcDatabasePlatformFactory] [main] Detected database 'Microsoft SQL Server', version '10', protocol 'jtds' 2014-07-16 15:26:59,367 INFO [corp-000] [MsSqlSymmetricDialect] [main] The DbDialect being used is org.jumpmind.symmetric.db.mssql.MsSqlSymmetricDialect 2014-07-16 15:26:59,373 INFO [corp-000] [StagingManager] [main] The staging directory was initialized at the following location: C:\Users\user.name\symmetricds\sym-corp-fix\symmetric-3.6.3-SNAPSHOT\tmp\corp-000 2014-07-16 15:26:59,402 INFO [corp-000] [ClusterService] [main] This node picked a server id of T005583.eu.Micros.int 2014-07-16 15:26:59,496 INFO [corp-000] [ExtensionPointManager] [main] Found 8 extension points that will be registered 2014-07-16 15:27:04,745 INFO [corp-000] [JdbcDatabasePlatformFactory] [main] Detected database 'Microsoft SQL Server', version '10', protocol 'jtds' 2014-07-16 15:27:04,779 INFO [corp-000] [MsSqlSymmetricDialect] [main] The DbDialect being used is org.jumpmind.symmetric.db.mssql.MsSqlSymmetricDialect 2014-07-16 15:27:04,785 INFO [corp-000] [StagingManager] [main] The staging directory was initialized at the following location: C:\Users\user.name\symmetricds\sym-corp-fix\symmetric-3.6.3-SNAPSHOT\tmp\corp-000 2014-07-16 15:27:04,813 INFO [corp-000] [ClusterService] [main] This node picked a server id of T005583.eu.Micros.int 2014-07-16 15:27:04,906 INFO [corp-000] [ExtensionPointManager] [main] Found 8 extension points that will be registered 2014-07-16 15:27:06,610 INFO [corp-000] [PurgeService] [corp-000-job-13] Purged all 0 incoming batch for node 001 2014-07-16 15:27:06,610 INFO [corp-000] [RouterService] [corp-000-job-13] Inserted reload events for node 001 in 56 ms 2014-07-16 15:27:06,623 INFO [corp-000] [RouterService] [corp-000-job-13] Routed 2 data events in 13 ms 2014-07-16 15:27:08,021 ERROR [corp-000] [DataExtractorService] [qtp14372770-20] Failed to extract batch 001-22 org.jumpmind.symmetric.SymmetricException: The extracted row data did not have the expected (2) number of columns: "11000001","Yummy Gum" at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1598) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1576) at org.jumpmind.db.sql.JdbcSqlReadCursor.next(JdbcSqlReadCursor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.selectNext(DataExtractorService.java:1550) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.next(DataExtractorService.java:1501) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromSymDataSource.next(DataExtractorService.java:1358) at org.jumpmind.symmetric.io.data.reader.ExtractDataReader.nextTable(ExtractDataReader.java:99) at org.jumpmind.symmetric.io.data.DataProcessor.forEachTableInBatch(DataProcessor.java:160) at org.jumpmind.symmetric.io.data.DataProcessor.process(DataProcessor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService.extractOutgoingBatch(DataExtractorService.java:703) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:513) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:422) at org.jumpmind.symmetric.web.PullUriHandler.pull(PullUriHandler.java:117) at org.jumpmind.symmetric.web.PullUriHandler.handleWithCompression(PullUriHandler.java:89) at org.jumpmind.symmetric.web.AbstractCompressionUriHandler.handle(AbstractCompressionUriHandler.java:84) at org.jumpmind.symmetric.web.SymmetricServlet.service(SymmetricServlet.java:98) at javax.servlet.http.HttpServlet.service(HttpServlet.java:820) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:565) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:479) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:119) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:227) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1031) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:406) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:965) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:117) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:111) at org.eclipse.jetty.server.Server.handle(Server.java:348) at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:452) at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:884) at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:938) at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:630) at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:230) at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:77) at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:606) at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:46) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:603) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:538) at java.lang.Thread.run(Thread.java:662) 2014-07-16 15:27:17,716 ERROR [corp-000] [DataExtractorService] [qtp14372770-19] Failed to extract batch 001-22 org.jumpmind.symmetric.SymmetricException: The extracted row data did not have the expected (2) number of columns: "11000001","Yummy Gum" at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1598) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1576) at org.jumpmind.db.sql.JdbcSqlReadCursor.next(JdbcSqlReadCursor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.selectNext(DataExtractorService.java:1550) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.next(DataExtractorService.java:1501) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromSymDataSource.next(DataExtractorService.java:1358) at org.jumpmind.symmetric.io.data.reader.ExtractDataReader.nextTable(ExtractDataReader.java:99) at org.jumpmind.symmetric.io.data.DataProcessor.forEachTableInBatch(DataProcessor.java:160) at org.jumpmind.symmetric.io.data.DataProcessor.process(DataProcessor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService.extractOutgoingBatch(DataExtractorService.java:703) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:513) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:422) at org.jumpmind.symmetric.web.PullUriHandler.pull(PullUriHandler.java:117) at org.jumpmind.symmetric.web.PullUriHandler.handleWithCompression(PullUriHandler.java:89) at org.jumpmind.symmetric.web.AbstractCompressionUriHandler.handle(AbstractCompressionUriHandler.java:84) at org.jumpmind.symmetric.web.SymmetricServlet.service(SymmetricServlet.java:98) at javax.servlet.http.HttpServlet.service(HttpServlet.java:820) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:565) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:479) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:119) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:227) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1031) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:406) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:965) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:117) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:111) at org.eclipse.jetty.server.Server.handle(Server.java:348) at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:452) at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:884) at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:938) at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:630) at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:230) at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:77) at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:606) at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:46) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:603) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:538) at java.lang.Thread.run(Thread.java:662) 2014-07-16 15:27:27,723 ERROR [corp-000] [DataExtractorService] [qtp14372770-19] Failed to extract batch 001-22 org.jumpmind.symmetric.SymmetricException: The extracted row data did not have the expected (2) number of columns: "11000001","Yummy Gum" at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1598) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1576) at org.jumpmind.db.sql.JdbcSqlReadCursor.next(JdbcSqlReadCursor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.selectNext(DataExtractorService.java:1550) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.next(DataExtractorService.java:1501) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromSymDataSource.next(DataExtractorService.java:1358) at org.jumpmind.symmetric.io.data.reader.ExtractDataReader.nextTable(ExtractDataReader.java:99) at org.jumpmind.symmetric.io.data.DataProcessor.forEachTableInBatch(DataProcessor.java:160) at org.jumpmind.symmetric.io.data.DataProcessor.process(DataProcessor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService.extractOutgoingBatch(DataExtractorService.java:703) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:513) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:422) at org.jumpmind.symmetric.web.PullUriHandler.pull(PullUriHandler.java:117) at org.jumpmind.symmetric.web.PullUriHandler.handleWithCompression(PullUriHandler.java:89) at org.jumpmind.symmetric.web.AbstractCompressionUriHandler.handle(AbstractCompressionUriHandler.java:84) at org.jumpmind.symmetric.web.SymmetricServlet.service(SymmetricServlet.java:98) at javax.servlet.http.HttpServlet.service(HttpServlet.java:820) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:565) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:479) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:119) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:227) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1031) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:406) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:965) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:117) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:111) at org.eclipse.jetty.server.Server.handle(Server.java:348) at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:452) at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:884) at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:938) at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:630) at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:230) at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:77) at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:606) at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:46) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:603) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:538) at java.lang.Thread.run(Thread.java:662) 2014-07-16 15:27:37,727 ERROR [corp-000] [DataExtractorService] [qtp14372770-19] Failed to extract batch 001-22 org.jumpmind.symmetric.SymmetricException: The extracted row data did not have the expected (2) number of columns: "11000001","Yummy Gum" at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1598) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1576) at org.jumpmind.db.sql.JdbcSqlReadCursor.next(JdbcSqlReadCursor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.selectNext(DataExtractorService.java:1550) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.next(DataExtractorService.java:1501) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromSymDataSource.next(DataExtractorService.java:1358) at org.jumpmind.symmetric.io.data.reader.ExtractDataReader.nextTable(ExtractDataReader.java:99) at org.jumpmind.symmetric.io.data.DataProcessor.forEachTableInBatch(DataProcessor.java:160) at org.jumpmind.symmetric.io.data.DataProcessor.process(DataProcessor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService.extractOutgoingBatch(DataExtractorService.java:703) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:513) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:422) at org.jumpmind.symmetric.web.PullUriHandler.pull(PullUriHandler.java:117) at org.jumpmind.symmetric.web.PullUriHandler.handleWithCompression(PullUriHandler.java:89) at org.jumpmind.symmetric.web.AbstractCompressionUriHandler.handle(AbstractCompressionUriHandler.java:84) at org.jumpmind.symmetric.web.SymmetricServlet.service(SymmetricServlet.java:98) at javax.servlet.http.HttpServlet.service(HttpServlet.java:820) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:565) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:479) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:119) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:227) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1031) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:406) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:965) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:117) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:111) at org.eclipse.jetty.server.Server.handle(Server.java:348) at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:452) at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:884) at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:938) at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:630) at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:230) at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:77) at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:606) at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:46) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:603) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:538) at java.lang.Thread.run(Thread.java:662) 2014-07-16 15:27:47,731 ERROR [corp-000] [DataExtractorService] [qtp14372770-19] Failed to extract batch 001-22 org.jumpmind.symmetric.SymmetricException: The extracted row data did not have the expected (2) number of columns: "11000001","Yummy Gum" at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1598) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1576) at org.jumpmind.db.sql.JdbcSqlReadCursor.next(JdbcSqlReadCursor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.selectNext(DataExtractorService.java:1550) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.next(DataExtractorService.java:1501) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromSymDataSource.next(DataExtractorService.java:1358) at org.jumpmind.symmetric.io.data.reader.ExtractDataReader.nextTable(ExtractDataReader.java:99) at org.jumpmind.symmetric.io.data.DataProcessor.forEachTableInBatch(DataProcessor.java:160) at org.jumpmind.symmetric.io.data.DataProcessor.process(DataProcessor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService.extractOutgoingBatch(DataExtractorService.java:703) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:513) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:422) at org.jumpmind.symmetric.web.PullUriHandler.pull(PullUriHandler.java:117) at org.jumpmind.symmetric.web.PullUriHandler.handleWithCompression(PullUriHandler.java:89) at org.jumpmind.symmetric.web.AbstractCompressionUriHandler.handle(AbstractCompressionUriHandler.java:84) at org.jumpmind.symmetric.web.SymmetricServlet.service(SymmetricServlet.java:98) at javax.servlet.http.HttpServlet.service(HttpServlet.java:820) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:565) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:479) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:119) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:227) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1031) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:406) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:965) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:117) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:111) at org.eclipse.jetty.server.Server.handle(Server.java:348) at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:452) at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:884) at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:938) at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:630) at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:230) at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:77) at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:606) at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:46) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:603) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:538) at java.lang.Thread.run(Thread.java:662) 2014-07-16 15:27:57,735 ERROR [corp-000] [DataExtractorService] [qtp14372770-19] Failed to extract batch 001-22 org.jumpmind.symmetric.SymmetricException: The extracted row data did not have the expected (2) number of columns: "11000001","Yummy Gum" at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1598) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1576) at org.jumpmind.db.sql.JdbcSqlReadCursor.next(JdbcSqlReadCursor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.selectNext(DataExtractorService.java:1550) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.next(DataExtractorService.java:1501) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromSymDataSource.next(DataExtractorService.java:1358) at org.jumpmind.symmetric.io.data.reader.ExtractDataReader.nextTable(ExtractDataReader.java:99) at org.jumpmind.symmetric.io.data.DataProcessor.forEachTableInBatch(DataProcessor.java:160) at org.jumpmind.symmetric.io.data.DataProcessor.process(DataProcessor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService.extractOutgoingBatch(DataExtractorService.java:703) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:513) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:422) at org.jumpmind.symmetric.web.PullUriHandler.pull(PullUriHandler.java:117) at org.jumpmind.symmetric.web.PullUriHandler.handleWithCompression(PullUriHandler.java:89) at org.jumpmind.symmetric.web.AbstractCompressionUriHandler.handle(AbstractCompressionUriHandler.java:84) at org.jumpmind.symmetric.web.SymmetricServlet.service(SymmetricServlet.java:98) at javax.servlet.http.HttpServlet.service(HttpServlet.java:820) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:565) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:479) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:119) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:227) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1031) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:406) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:965) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:117) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:111) at org.eclipse.jetty.server.Server.handle(Server.java:348) at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:452) at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:884) at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:938) at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:630) at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:230) at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:77) at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:606) at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:46) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:603) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:538) at java.lang.Thread.run(Thread.java:662) 2014-07-16 15:28:07,742 ERROR [corp-000] [DataExtractorService] [qtp14372770-19] Failed to extract batch 001-22 org.jumpmind.symmetric.SymmetricException: The extracted row data did not have the expected (2) number of columns: "11000001","Yummy Gum" at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1598) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1576) at org.jumpmind.db.sql.JdbcSqlReadCursor.next(JdbcSqlReadCursor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.selectNext(DataExtractorService.java:1550) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.next(DataExtractorService.java:1501) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromSymDataSource.next(DataExtractorService.java:1358) at org.jumpmind.symmetric.io.data.reader.ExtractDataReader.nextTable(ExtractDataReader.java:99) at org.jumpmind.symmetric.io.data.DataProcessor.forEachTableInBatch(DataProcessor.java:160) at org.jumpmind.symmetric.io.data.DataProcessor.process(DataProcessor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService.extractOutgoingBatch(DataExtractorService.java:703) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:513) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:422) at org.jumpmind.symmetric.web.PullUriHandler.pull(PullUriHandler.java:117) at org.jumpmind.symmetric.web.PullUriHandler.handleWithCompression(PullUriHandler.java:89) at org.jumpmind.symmetric.web.AbstractCompressionUriHandler.handle(AbstractCompressionUriHandler.java:84) at org.jumpmind.symmetric.web.SymmetricServlet.service(SymmetricServlet.java:98) at javax.servlet.http.HttpServlet.service(HttpServlet.java:820) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:565) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:479) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:119) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:227) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1031) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:406) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:965) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:117) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:111) at org.eclipse.jetty.server.Server.handle(Server.java:348) at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:452) at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:884) at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:938) at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:630) at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:230) at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:77) at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:606) at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:46) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:603) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:538) at java.lang.Thread.run(Thread.java:662) 2014-07-16 15:28:17,747 ERROR [corp-000] [DataExtractorService] [qtp14372770-18] Failed to extract batch 001-22 org.jumpmind.symmetric.SymmetricException: The extracted row data did not have the expected (2) number of columns: "11000001","Yummy Gum" at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1598) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1576) at org.jumpmind.db.sql.JdbcSqlReadCursor.next(JdbcSqlReadCursor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.selectNext(DataExtractorService.java:1550) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.next(DataExtractorService.java:1501) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromSymDataSource.next(DataExtractorService.java:1358) at org.jumpmind.symmetric.io.data.reader.ExtractDataReader.nextTable(ExtractDataReader.java:99) at org.jumpmind.symmetric.io.data.DataProcessor.forEachTableInBatch(DataProcessor.java:160) at org.jumpmind.symmetric.io.data.DataProcessor.process(DataProcessor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService.extractOutgoingBatch(DataExtractorService.java:703) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:513) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:422) at org.jumpmind.symmetric.web.PullUriHandler.pull(PullUriHandler.java:117) at org.jumpmind.symmetric.web.PullUriHandler.handleWithCompression(PullUriHandler.java:89) at org.jumpmind.symmetric.web.AbstractCompressionUriHandler.handle(AbstractCompressionUriHandler.java:84) at org.jumpmind.symmetric.web.SymmetricServlet.service(SymmetricServlet.java:98) at javax.servlet.http.HttpServlet.service(HttpServlet.java:820) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:565) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:479) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:119) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:227) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1031) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:406) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:965) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:117) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:111) at org.eclipse.jetty.server.Server.handle(Server.java:348) at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:452) at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:884) at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:938) at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:630) at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:230) at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:77) at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:606) at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:46) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:603) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:538) at java.lang.Thread.run(Thread.java:662) 2014-07-16 15:28:21,937 INFO [corp-000] [JdbcDatabasePlatformFactory] [main] Detected database 'Microsoft SQL Server', version '10', protocol 'jtds' 2014-07-16 15:28:21,971 INFO [corp-000] [MsSqlSymmetricDialect] [main] The DbDialect being used is org.jumpmind.symmetric.db.mssql.MsSqlSymmetricDialect 2014-07-16 15:28:21,977 INFO [corp-000] [StagingManager] [main] The staging directory was initialized at the following location: C:\Users\user.name\symmetricds\sym-corp-fix\symmetric-3.6.3-SNAPSHOT\tmp\corp-000 2014-07-16 15:28:22,007 INFO [corp-000] [ClusterService] [main] This node picked a server id of T005583.eu.Micros.int 2014-07-16 15:28:22,102 INFO [corp-000] [ExtensionPointManager] [main] Found 8 extension points that will be registered 2014-07-16 15:28:22,104 INFO [corp-000] [TriggerRouterService] [main] Synchronizing triggers 2014-07-16 15:28:22,417 INFO [corp-000] [MsSqlSymmetricDialect] [main] Creating SYM_ON_I_FOR_TM_CRP trigger for sym-corp.dbo.item 2014-07-16 15:28:22,425 INFO [corp-000] [MsSqlSymmetricDialect] [main] Creating SYM_ON_U_FOR_TM_CRP trigger for sym-corp.dbo.item 2014-07-16 15:28:22,430 INFO [corp-000] [MsSqlSymmetricDialect] [main] Creating SYM_ON_D_FOR_TM_CRP trigger for sym-corp.dbo.item 2014-07-16 15:28:22,446 INFO [corp-000] [TriggerRouterService] [main] Done synchronizing triggers 2014-07-16 15:28:26,673 INFO [] [AbstractCommandLauncher] [main] Option: name=node, value={001} 2014-07-16 15:28:27,186 INFO [corp-000] [JdbcDatabasePlatformFactory] [main] Detected database 'Microsoft SQL Server', version '10', protocol 'jtds' 2014-07-16 15:28:27,220 INFO [corp-000] [MsSqlSymmetricDialect] [main] The DbDialect being used is org.jumpmind.symmetric.db.mssql.MsSqlSymmetricDialect 2014-07-16 15:28:27,226 INFO [corp-000] [StagingManager] [main] The staging directory was initialized at the following location: C:\Users\user.name\symmetricds\sym-corp-fix\symmetric-3.6.3-SNAPSHOT\tmp\corp-000 2014-07-16 15:28:27,255 INFO [corp-000] [ClusterService] [main] This node picked a server id of T005583.eu.Micros.int 2014-07-16 15:28:27,347 INFO [corp-000] [ExtensionPointManager] [main] Found 8 extension points that will be registered 2014-07-16 15:28:27,751 ERROR [corp-000] [DataExtractorService] [qtp14372770-18] Failed to extract batch 001-22 org.jumpmind.symmetric.SymmetricException: The extracted row data did not have the expected (2) number of columns: "11000001","Yummy Gum" at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1598) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1576) at org.jumpmind.db.sql.JdbcSqlReadCursor.next(JdbcSqlReadCursor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.selectNext(DataExtractorService.java:1550) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.next(DataExtractorService.java:1501) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromSymDataSource.next(DataExtractorService.java:1358) at org.jumpmind.symmetric.io.data.reader.ExtractDataReader.nextTable(ExtractDataReader.java:99) at org.jumpmind.symmetric.io.data.DataProcessor.forEachTableInBatch(DataProcessor.java:160) at org.jumpmind.symmetric.io.data.DataProcessor.process(DataProcessor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService.extractOutgoingBatch(DataExtractorService.java:703) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:513) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:422) at org.jumpmind.symmetric.web.PullUriHandler.pull(PullUriHandler.java:117) at org.jumpmind.symmetric.web.PullUriHandler.handleWithCompression(PullUriHandler.java:89) at org.jumpmind.symmetric.web.AbstractCompressionUriHandler.handle(AbstractCompressionUriHandler.java:84) at org.jumpmind.symmetric.web.SymmetricServlet.service(SymmetricServlet.java:98) at javax.servlet.http.HttpServlet.service(HttpServlet.java:820) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:565) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:479) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:119) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:227) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1031) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:406) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:965) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:117) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:111) at org.eclipse.jetty.server.Server.handle(Server.java:348) at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:452) at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:884) at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:938) at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:630) at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:230) at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:77) at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:606) at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:46) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:603) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:538) at java.lang.Thread.run(Thread.java:662) 2014-07-16 15:28:30,257 INFO [corp-000] [JdbcDatabasePlatformFactory] [main] Detected database 'Microsoft SQL Server', version '10', protocol 'jtds' 2014-07-16 15:28:30,291 INFO [corp-000] [MsSqlSymmetricDialect] [main] The DbDialect being used is org.jumpmind.symmetric.db.mssql.MsSqlSymmetricDialect 2014-07-16 15:28:30,297 INFO [corp-000] [StagingManager] [main] The staging directory was initialized at the following location: C:\Users\user.name\symmetricds\sym-corp-fix\symmetric-3.6.3-SNAPSHOT\tmp\corp-000 2014-07-16 15:28:30,326 INFO [corp-000] [ClusterService] [main] This node picked a server id of T005583.eu.Micros.int 2014-07-16 15:28:30,422 INFO [corp-000] [ExtensionPointManager] [main] Found 8 extension points that will be registered 2014-07-16 15:28:31,846 INFO [corp-000] [PurgeService] [corp-000-job-8] Purged all 0 incoming batch for node 001 2014-07-16 15:28:31,847 INFO [corp-000] [RouterService] [corp-000-job-8] Inserted reload events for node 001 in 56 ms 2014-07-16 15:28:31,860 INFO [corp-000] [RouterService] [corp-000-job-8] Routed 2 data events in 13 ms 2014-07-16 15:28:38,122 ERROR [corp-000] [DataExtractorService] [qtp14372770-21] Failed to extract batch 001-31 org.jumpmind.symmetric.SymmetricException: The extracted row data did not have the expected (3) number of columns: "11000001","Yummy Gum" at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1598) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1576) at org.jumpmind.db.sql.JdbcSqlReadCursor.next(JdbcSqlReadCursor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.selectNext(DataExtractorService.java:1550) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.next(DataExtractorService.java:1501) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromSymDataSource.next(DataExtractorService.java:1358) at org.jumpmind.symmetric.io.data.reader.ExtractDataReader.nextTable(ExtractDataReader.java:99) at org.jumpmind.symmetric.io.data.DataProcessor.forEachTableInBatch(DataProcessor.java:160) at org.jumpmind.symmetric.io.data.DataProcessor.process(DataProcessor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService.extractOutgoingBatch(DataExtractorService.java:703) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:513) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:422) at org.jumpmind.symmetric.web.PullUriHandler.pull(PullUriHandler.java:117) at org.jumpmind.symmetric.web.PullUriHandler.handleWithCompression(PullUriHandler.java:89) at org.jumpmind.symmetric.web.AbstractCompressionUriHandler.handle(AbstractCompressionUriHandler.java:84) at org.jumpmind.symmetric.web.SymmetricServlet.service(SymmetricServlet.java:98) at javax.servlet.http.HttpServlet.service(HttpServlet.java:820) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:565) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:479) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:119) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:227) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1031) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:406) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:965) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:117) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:111) at org.eclipse.jetty.server.Server.handle(Server.java:348) at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:452) at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:884) at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:938) at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:630) at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:230) at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:77) at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:606) at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:46) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:603) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:538) at java.lang.Thread.run(Thread.java:662) 2014-07-16 15:42:27,770 INFO [] [AbstractCommandLauncher] [main] Option: name=engine, value={corp-000} 2014-07-16 15:42:27,771 INFO [] [AbstractCommandLauncher] [main] Option: name=format, value={XML} 2014-07-16 15:42:27,941 INFO [] [JdbcDatabasePlatformFactory] [main] Detected database 'Microsoft SQL Server', version '10', protocol 'jtds' 2014-07-16 15:42:28,078 WARN [] [AbstractDatabaseWriter] [main] Did not find the item table in the target database 2014-07-16 15:42:28,084 INFO [] [DefaultDatabaseWriter] [main] About to create table using the following definition:
2014-07-16 15:42:28,091 WARN [] [AbstractDatabaseWriter] [main] Did not find the item_selling_price table in the target database 2014-07-16 15:42:28,094 INFO [] [DefaultDatabaseWriter] [main] About to create table using the following definition:
2014-07-16 15:42:28,100 WARN [] [AbstractDatabaseWriter] [main] Did not find the sale_transaction table in the target database 2014-07-16 15:42:28,103 INFO [] [DefaultDatabaseWriter] [main] About to create table using the following definition:
2014-07-16 15:42:28,107 WARN [] [AbstractDatabaseWriter] [main] Did not find the sale_return_line_item table in the target database 2014-07-16 15:42:28,110 INFO [] [DefaultDatabaseWriter] [main] About to create table using the following definition:
2014-07-16 15:42:38,245 INFO [] [AbstractCommandLauncher] [main] Option: name=engine, value={corp-000} 2014-07-16 15:42:38,772 INFO [corp-000] [JdbcDatabasePlatformFactory] [main] Detected database 'Microsoft SQL Server', version '10', protocol 'jtds' 2014-07-16 15:42:38,806 INFO [corp-000] [MsSqlSymmetricDialect] [main] The DbDialect being used is org.jumpmind.symmetric.db.mssql.MsSqlSymmetricDialect 2014-07-16 15:42:38,812 INFO [corp-000] [StagingManager] [main] The staging directory was initialized at the following location: C:\Users\user.name\symmetricds\sym-corp-fix\symmetric-3.6.3-SNAPSHOT\tmp\corp-000 2014-07-16 15:42:38,840 INFO [corp-000] [ClusterService] [main] This node picked a server id of T005583.eu.Micros.int 2014-07-16 15:42:38,934 INFO [corp-000] [ExtensionPointManager] [main] Found 8 extension points that will be registered 2014-07-16 15:42:38,937 INFO [corp-000] [AbstractSymmetricEngine] [main] Initializing SymmetricDS database 2014-07-16 15:42:38,937 INFO [corp-000] [MsSqlSymmetricDialect] [main] Checking if SymmetricDS tables need created or altered 2014-07-16 15:42:39,074 INFO [corp-000] [MsSqlSymmetricDialect] [main] There are SymmetricDS tables that needed altered 2014-07-16 15:42:39,091 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,092 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,096 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_channel"( "channel_id" VARCHAR(128) NOT NULL, "processing_order" INT DEFAULT 1 NOT NULL, "max_batch_size" INT DEFAULT 1000 NOT NULL, "max_batch_to_send" INT DEFAULT 60 NOT NULL, "max_data_to_route" INT DEFAULT 100000 NOT NULL, "extract_period_millis" INT DEFAULT 0 NOT NULL, "enabled" SMALLINT DEFAULT 1 NOT NULL, "use_old_data_to_route" SMALLINT DEFAULT 1 NOT NULL, "use_row_data_to_route" SMALLINT DEFAULT 1 NOT NULL, "use_pk_data_to_route" SMALLINT DEFAULT 1 NOT NULL, "reload_flag" SMALLINT DEFAULT 0 NOT NULL, "file_sync_flag" SMALLINT DEFAULT 0 NOT NULL, "contains_big_lob" SMALLINT DEFAULT 0 NOT NULL, "batch_algorithm" VARCHAR(50) DEFAULT 'default' NOT NULL, "data_loader_type" VARCHAR(50) DEFAULT 'default' NOT NULL, "description" VARCHAR(255), "create_time" DATETIME, "last_update_by" VARCHAR(50), "last_update_time" DATETIME, PRIMARY KEY ("channel_id") ) 2014-07-16 15:42:39,097 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,098 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_conflict"( "conflict_id" VARCHAR(50) NOT NULL, "source_node_group_id" VARCHAR(50) NOT NULL, "target_node_group_id" VARCHAR(50) NOT NULL, "target_channel_id" VARCHAR(128), "target_catalog_name" VARCHAR(255), "target_schema_name" VARCHAR(255), "target_table_name" VARCHAR(255), "detect_type" VARCHAR(128) NOT NULL, "detect_expression" TEXT, "resolve_type" VARCHAR(128) NOT NULL, "ping_back" VARCHAR(128) NOT NULL, "resolve_changes_only" SMALLINT DEFAULT 0, "resolve_row_only" SMALLINT DEFAULT 0, "create_time" DATETIME NOT NULL, "last_update_by" VARCHAR(50), "last_update_time" DATETIME NOT NULL, PRIMARY KEY ("conflict_id") ) 2014-07-16 15:42:39,099 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,100 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_data"( "data_id" BIGINT NOT NULL IDENTITY (1,1) , "table_name" VARCHAR(255) NOT NULL, "event_type" CHAR(1) NOT NULL, "row_data" TEXT, "pk_data" TEXT, "old_data" TEXT, "trigger_hist_id" INT NOT NULL, "channel_id" VARCHAR(128), "transaction_id" VARCHAR(255), "source_node_id" VARCHAR(50), "external_data" VARCHAR(50), "node_list" VARCHAR(255), "create_time" DATETIME, PRIMARY KEY ("data_id") ) 2014-07-16 15:42:39,108 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE INDEX "sym_idx_d_channel_id" ON "sym_data" ("data_id", "channel_id") 2014-07-16 15:42:39,109 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,109 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_data_event"( "data_id" BIGINT NOT NULL, "batch_id" BIGINT NOT NULL, "router_id" VARCHAR(50) NOT NULL, "create_time" DATETIME, PRIMARY KEY ("data_id", "batch_id", "router_id") ) 2014-07-16 15:42:39,110 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE INDEX "sym_idx_de_batchid" ON "sym_data_event" ("batch_id") 2014-07-16 15:42:39,119 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,120 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_data_gap"( "start_id" BIGINT NOT NULL, "end_id" BIGINT NOT NULL, "status" CHAR(2), "create_time" DATETIME NOT NULL, "last_update_hostname" VARCHAR(255), "last_update_time" DATETIME NOT NULL, PRIMARY KEY ("start_id", "end_id") ) 2014-07-16 15:42:39,121 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE INDEX "sym_idx_dg_status" ON "sym_data_gap" ("status") 2014-07-16 15:42:39,122 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,123 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_extract_request"( "request_id" BIGINT NOT NULL, "node_id" VARCHAR(50) NOT NULL, "status" CHAR(2), "start_batch_id" BIGINT NOT NULL, "end_batch_id" BIGINT NOT NULL, "trigger_id" VARCHAR(128) NOT NULL, "router_id" VARCHAR(50) NOT NULL, "last_update_time" DATETIME, "create_time" DATETIME, PRIMARY KEY ("request_id") ) 2014-07-16 15:42:39,133 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,134 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_file_incoming"( "relative_dir" VARCHAR(255) NOT NULL, "file_name" VARCHAR(128) NOT NULL, "last_event_type" CHAR(1) NOT NULL, "node_id" VARCHAR(50) NOT NULL, "file_modified_time" BIGINT, PRIMARY KEY ("relative_dir", "file_name") ) 2014-07-16 15:42:39,144 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,146 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_file_snapshot"( "trigger_id" VARCHAR(128) NOT NULL, "router_id" VARCHAR(50) NOT NULL, "relative_dir" VARCHAR(255) NOT NULL, "file_name" VARCHAR(128) NOT NULL, "channel_id" VARCHAR(128) DEFAULT 'filesync' NOT NULL, "reload_channel_id" VARCHAR(128) DEFAULT 'filesync_reload' NOT NULL, "last_event_type" CHAR(1) NOT NULL, "crc32_checksum" BIGINT, "file_size" BIGINT, "file_modified_time" BIGINT, "last_update_time" DATETIME NOT NULL, "last_update_by" VARCHAR(50), "create_time" DATETIME NOT NULL, PRIMARY KEY ("trigger_id", "router_id", "relative_dir", "file_name") ) 2014-07-16 15:42:39,158 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE INDEX "sym_idx_f_snpsht_chid" ON "sym_file_snapshot" ("reload_channel_id") 2014-07-16 15:42:39,158 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,160 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_file_trigger"( "trigger_id" VARCHAR(128) NOT NULL, "channel_id" VARCHAR(128) DEFAULT 'filesync' NOT NULL, "reload_channel_id" VARCHAR(128) DEFAULT 'filesync_reload' NOT NULL, "base_dir" VARCHAR(255) NOT NULL, "recurse" SMALLINT DEFAULT 1 NOT NULL, "includes_files" VARCHAR(255), "excludes_files" VARCHAR(255), "sync_on_create" SMALLINT DEFAULT 1 NOT NULL, "sync_on_modified" SMALLINT DEFAULT 1 NOT NULL, "sync_on_delete" SMALLINT DEFAULT 1 NOT NULL, "sync_on_ctl_file" SMALLINT DEFAULT 0 NOT NULL, "delete_after_sync" SMALLINT DEFAULT 0 NOT NULL, "before_copy_script" TEXT, "after_copy_script" TEXT, "create_time" DATETIME NOT NULL, "last_update_by" VARCHAR(50), "last_update_time" DATETIME NOT NULL, PRIMARY KEY ("trigger_id") ) 2014-07-16 15:42:39,182 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,183 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_file_trigger_router"( "trigger_id" VARCHAR(128) NOT NULL, "router_id" VARCHAR(50) NOT NULL, "enabled" SMALLINT DEFAULT 1 NOT NULL, "initial_load_enabled" SMALLINT DEFAULT 1 NOT NULL, "target_base_dir" VARCHAR(255), "conflict_strategy" VARCHAR(128) DEFAULT 'source_wins' NOT NULL, "create_time" DATETIME NOT NULL, "last_update_by" VARCHAR(50), "last_update_time" DATETIME NOT NULL, PRIMARY KEY ("trigger_id", "router_id") ) 2014-07-16 15:42:39,193 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,194 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_grouplet"( "grouplet_id" VARCHAR(50) NOT NULL, "grouplet_link_policy" CHAR(1) DEFAULT 'I' NOT NULL, "description" VARCHAR(255), "create_time" DATETIME NOT NULL, "last_update_by" VARCHAR(50), "last_update_time" DATETIME NOT NULL, PRIMARY KEY ("grouplet_id") ) 2014-07-16 15:42:39,206 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,207 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_grouplet_link"( "grouplet_id" VARCHAR(50) NOT NULL, "external_id" VARCHAR(50) NOT NULL, "create_time" DATETIME NOT NULL, "last_update_by" VARCHAR(50), "last_update_time" DATETIME NOT NULL, PRIMARY KEY ("grouplet_id", "external_id") ) 2014-07-16 15:42:39,218 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,221 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_incoming_batch"( "batch_id" BIGINT NOT NULL, "node_id" VARCHAR(50) NOT NULL, "channel_id" VARCHAR(128), "status" CHAR(2), "error_flag" SMALLINT DEFAULT 0, "network_millis" BIGINT DEFAULT 0 NOT NULL, "filter_millis" BIGINT DEFAULT 0 NOT NULL, "database_millis" BIGINT DEFAULT 0 NOT NULL, "failed_row_number" BIGINT DEFAULT 0 NOT NULL, "failed_line_number" BIGINT DEFAULT 0 NOT NULL, "byte_count" BIGINT DEFAULT 0 NOT NULL, "statement_count" BIGINT DEFAULT 0 NOT NULL, "fallback_insert_count" BIGINT DEFAULT 0 NOT NULL, "fallback_update_count" BIGINT DEFAULT 0 NOT NULL, "ignore_count" BIGINT DEFAULT 0 NOT NULL, "missing_delete_count" BIGINT DEFAULT 0 NOT NULL, "skip_count" BIGINT DEFAULT 0 NOT NULL, "sql_state" VARCHAR(10), "sql_code" INT DEFAULT 0 NOT NULL, "sql_message" TEXT, "last_update_hostname" VARCHAR(255), "last_update_time" DATETIME, "create_time" DATETIME, PRIMARY KEY ("batch_id", "node_id") ) 2014-07-16 15:42:39,242 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE INDEX "sym_idx_ib_time_status" ON "sym_incoming_batch" ("create_time", "status") 2014-07-16 15:42:39,243 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE INDEX "sym_idx_ib_in_error" ON "sym_incoming_batch" ("error_flag") 2014-07-16 15:42:39,253 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,256 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_incoming_error"( "batch_id" BIGINT NOT NULL, "node_id" VARCHAR(50) NOT NULL, "failed_row_number" BIGINT NOT NULL, "failed_line_number" BIGINT DEFAULT 0 NOT NULL, "target_catalog_name" VARCHAR(255), "target_schema_name" VARCHAR(255), "target_table_name" VARCHAR(255) NOT NULL, "event_type" CHAR(1) NOT NULL, "binary_encoding" VARCHAR(10) DEFAULT 'HEX' NOT NULL, "column_names" TEXT NOT NULL, "pk_column_names" TEXT NOT NULL, "row_data" TEXT, "old_data" TEXT, "cur_data" TEXT, "resolve_data" TEXT, "resolve_ignore" SMALLINT DEFAULT 0, "conflict_id" VARCHAR(50), "create_time" DATETIME, "last_update_by" VARCHAR(50), "last_update_time" DATETIME NOT NULL, PRIMARY KEY ("batch_id", "node_id", "failed_row_number") ) 2014-07-16 15:42:39,278 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,280 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_load_filter"( "load_filter_id" VARCHAR(50) NOT NULL, "load_filter_type" VARCHAR(10) NOT NULL, "source_node_group_id" VARCHAR(50) NOT NULL, "target_node_group_id" VARCHAR(50) NOT NULL, "target_catalog_name" VARCHAR(255), "target_schema_name" VARCHAR(255), "target_table_name" VARCHAR(255), "filter_on_update" SMALLINT DEFAULT 1 NOT NULL, "filter_on_insert" SMALLINT DEFAULT 1 NOT NULL, "filter_on_delete" SMALLINT DEFAULT 1 NOT NULL, "before_write_script" TEXT, "after_write_script" TEXT, "batch_complete_script" TEXT, "batch_commit_script" TEXT, "batch_rollback_script" TEXT, "handle_error_script" TEXT, "create_time" DATETIME NOT NULL, "last_update_by" VARCHAR(50), "last_update_time" DATETIME NOT NULL, "load_filter_order" INT DEFAULT 1 NOT NULL, "fail_on_error" SMALLINT DEFAULT 0 NOT NULL, PRIMARY KEY ("load_filter_id") ) 2014-07-16 15:42:39,302 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,303 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_lock"( "lock_action" VARCHAR(50) NOT NULL, "lock_type" VARCHAR(50) NOT NULL, "locking_server_id" VARCHAR(255), "lock_time" DATETIME, "shared_count" INT DEFAULT 0 NOT NULL, "shared_enable" INT DEFAULT 0 NOT NULL, "last_lock_time" DATETIME, "last_locking_server_id" VARCHAR(255), PRIMARY KEY ("lock_action") ) 2014-07-16 15:42:39,314 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,315 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_node"( "node_id" VARCHAR(50) NOT NULL, "node_group_id" VARCHAR(50) NOT NULL, "external_id" VARCHAR(50) NOT NULL, "sync_enabled" SMALLINT DEFAULT 0, "sync_url" VARCHAR(255), "schema_version" VARCHAR(50), "symmetric_version" VARCHAR(50), "database_type" VARCHAR(50), "database_version" VARCHAR(50), "heartbeat_time" DATETIME, "timezone_offset" VARCHAR(6), "batch_to_send_count" INT DEFAULT 0, "batch_in_error_count" INT DEFAULT 0, "created_at_node_id" VARCHAR(50), "deployment_type" VARCHAR(50), PRIMARY KEY ("node_id") ) 2014-07-16 15:42:39,327 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,339 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_node_communication"( "node_id" VARCHAR(50) NOT NULL, "communication_type" VARCHAR(10) NOT NULL, "lock_time" DATETIME, "locking_server_id" VARCHAR(255), "last_lock_time" DATETIME, "last_lock_millis" BIGINT DEFAULT 0, "success_count" BIGINT DEFAULT 0, "fail_count" BIGINT DEFAULT 0, "total_success_count" BIGINT DEFAULT 0, "total_fail_count" BIGINT DEFAULT 0, "total_success_millis" BIGINT DEFAULT 0, "total_fail_millis" BIGINT DEFAULT 0, PRIMARY KEY ("node_id", "communication_type") ) 2014-07-16 15:42:39,350 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,351 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_node_channel_ctl"( "node_id" VARCHAR(50) NOT NULL, "channel_id" VARCHAR(128) NOT NULL, "suspend_enabled" SMALLINT DEFAULT 0, "ignore_enabled" SMALLINT DEFAULT 0, "last_extract_time" DATETIME, PRIMARY KEY ("node_id", "channel_id") ) 2014-07-16 15:42:39,363 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,363 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_node_group"( "node_group_id" VARCHAR(50) NOT NULL, "description" VARCHAR(255), "create_time" DATETIME, "last_update_by" VARCHAR(50), "last_update_time" DATETIME, PRIMARY KEY ("node_group_id") ) 2014-07-16 15:42:39,374 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,375 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_node_group_channel_wnd"( "node_group_id" VARCHAR(50) NOT NULL, "channel_id" VARCHAR(128) NOT NULL, "start_time" DATETIME NOT NULL, "end_time" DATETIME NOT NULL, "enabled" SMALLINT DEFAULT 0 NOT NULL, PRIMARY KEY ("node_group_id", "channel_id", "start_time", "end_time") ) 2014-07-16 15:42:39,375 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,377 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_node_group_link"( "source_node_group_id" VARCHAR(50) NOT NULL, "target_node_group_id" VARCHAR(50) NOT NULL, "data_event_action" CHAR(1) DEFAULT 'W' NOT NULL, "sync_config_enabled" SMALLINT DEFAULT 1 NOT NULL, "create_time" DATETIME, "last_update_by" VARCHAR(50), "last_update_time" DATETIME, PRIMARY KEY ("source_node_group_id", "target_node_group_id") ) 2014-07-16 15:42:39,383 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,385 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_node_host"( "node_id" VARCHAR(50) NOT NULL, "host_name" VARCHAR(60) NOT NULL, "ip_address" VARCHAR(50), "os_user" VARCHAR(50), "os_name" VARCHAR(50), "os_arch" VARCHAR(50), "os_version" VARCHAR(50), "available_processors" INT DEFAULT 0, "free_memory_bytes" BIGINT DEFAULT 0, "total_memory_bytes" BIGINT DEFAULT 0, "max_memory_bytes" BIGINT DEFAULT 0, "java_version" VARCHAR(50), "java_vendor" VARCHAR(255), "jdbc_version" VARCHAR(255), "symmetric_version" VARCHAR(50), "timezone_offset" VARCHAR(6), "heartbeat_time" DATETIME, "last_restart_time" DATETIME NOT NULL, "create_time" DATETIME NOT NULL, PRIMARY KEY ("node_id", "host_name") ) 2014-07-16 15:42:39,393 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,396 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_node_host_channel_stats"( "node_id" VARCHAR(50) NOT NULL, "host_name" VARCHAR(60) NOT NULL, "channel_id" VARCHAR(128) NOT NULL, "start_time" DATETIME NOT NULL, "end_time" DATETIME NOT NULL, "data_routed" BIGINT DEFAULT 0, "data_unrouted" BIGINT DEFAULT 0, "data_event_inserted" BIGINT DEFAULT 0, "data_extracted" BIGINT DEFAULT 0, "data_bytes_extracted" BIGINT DEFAULT 0, "data_extracted_errors" BIGINT DEFAULT 0, "data_bytes_sent" BIGINT DEFAULT 0, "data_sent" BIGINT DEFAULT 0, "data_sent_errors" BIGINT DEFAULT 0, "data_loaded" BIGINT DEFAULT 0, "data_bytes_loaded" BIGINT DEFAULT 0, "data_loaded_errors" BIGINT DEFAULT 0, PRIMARY KEY ("node_id", "host_name", "channel_id", "start_time", "end_time") ) 2014-07-16 15:42:39,402 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE INDEX "sym_idx_nd_hst_chnl_sts" ON "sym_node_host_channel_stats" ("node_id", "start_time", "end_time") 2014-07-16 15:42:39,403 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,405 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_node_host_job_stats"( "node_id" VARCHAR(50) NOT NULL, "host_name" VARCHAR(60) NOT NULL, "job_name" VARCHAR(50) NOT NULL, "start_time" DATETIME NOT NULL, "end_time" DATETIME NOT NULL, "processed_count" BIGINT DEFAULT 0, PRIMARY KEY ("node_id", "host_name", "job_name", "start_time", "end_time") ) 2014-07-16 15:42:39,407 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE INDEX "sym_idx_nd_hst_job" ON "sym_node_host_job_stats" ("node_id", "start_time", "end_time") 2014-07-16 15:42:39,407 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,427 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_node_host_stats"( "node_id" VARCHAR(50) NOT NULL, "host_name" VARCHAR(60) NOT NULL, "start_time" DATETIME NOT NULL, "end_time" DATETIME NOT NULL, "restarted" BIGINT DEFAULT 0 NOT NULL, "nodes_pulled" BIGINT DEFAULT 0, "total_nodes_pull_time" BIGINT DEFAULT 0, "nodes_pushed" BIGINT DEFAULT 0, "total_nodes_push_time" BIGINT DEFAULT 0, "nodes_rejected" BIGINT DEFAULT 0, "nodes_registered" BIGINT DEFAULT 0, "nodes_loaded" BIGINT DEFAULT 0, "nodes_disabled" BIGINT DEFAULT 0, "purged_data_rows" BIGINT DEFAULT 0, "purged_data_event_rows" BIGINT DEFAULT 0, "purged_batch_outgoing_rows" BIGINT DEFAULT 0, "purged_batch_incoming_rows" BIGINT DEFAULT 0, "triggers_created_count" BIGINT, "triggers_rebuilt_count" BIGINT, "triggers_removed_count" BIGINT, PRIMARY KEY ("node_id", "host_name", "start_time", "end_time") ) 2014-07-16 15:42:39,429 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE INDEX "sym_idx_nd_hst_sts" ON "sym_node_host_stats" ("node_id", "start_time", "end_time") 2014-07-16 15:42:39,429 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,430 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_node_identity"( "node_id" VARCHAR(50) NOT NULL, PRIMARY KEY ("node_id") ) 2014-07-16 15:42:39,430 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,432 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_node_security"( "node_id" VARCHAR(50) NOT NULL, "node_password" VARCHAR(50) NOT NULL, "registration_enabled" SMALLINT DEFAULT 0, "registration_time" DATETIME, "initial_load_enabled" SMALLINT DEFAULT 0, "initial_load_time" DATETIME, "initial_load_id" BIGINT, "initial_load_create_by" VARCHAR(255), "rev_initial_load_enabled" SMALLINT DEFAULT 0, "rev_initial_load_time" DATETIME, "rev_initial_load_id" BIGINT, "rev_initial_load_create_by" VARCHAR(255), "created_at_node_id" VARCHAR(50) NOT NULL, PRIMARY KEY ("node_id") ) 2014-07-16 15:42:39,435 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,440 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_outgoing_batch"( "batch_id" BIGINT NOT NULL, "node_id" VARCHAR(50) NOT NULL, "channel_id" VARCHAR(128), "status" CHAR(2), "load_id" BIGINT, "extract_job_flag" SMALLINT DEFAULT 0, "load_flag" SMALLINT DEFAULT 0, "error_flag" SMALLINT DEFAULT 0, "common_flag" SMALLINT DEFAULT 0, "ignore_count" BIGINT DEFAULT 0 NOT NULL, "byte_count" BIGINT DEFAULT 0 NOT NULL, "extract_count" BIGINT DEFAULT 0 NOT NULL, "sent_count" BIGINT DEFAULT 0 NOT NULL, "load_count" BIGINT DEFAULT 0 NOT NULL, "data_event_count" BIGINT DEFAULT 0 NOT NULL, "reload_event_count" BIGINT DEFAULT 0 NOT NULL, "insert_event_count" BIGINT DEFAULT 0 NOT NULL, "update_event_count" BIGINT DEFAULT 0 NOT NULL, "delete_event_count" BIGINT DEFAULT 0 NOT NULL, "other_event_count" BIGINT DEFAULT 0 NOT NULL, "router_millis" BIGINT DEFAULT 0 NOT NULL, "network_millis" BIGINT DEFAULT 0 NOT NULL, "filter_millis" BIGINT DEFAULT 0 NOT NULL, "load_millis" BIGINT DEFAULT 0 NOT NULL, "extract_millis" BIGINT DEFAULT 0 NOT NULL, "sql_state" VARCHAR(10), "sql_code" INT DEFAULT 0 NOT NULL, "sql_message" TEXT, "failed_data_id" BIGINT DEFAULT 0 NOT NULL, "failed_line_number" BIGINT DEFAULT 0 NOT NULL, "last_update_hostname" VARCHAR(255), "last_update_time" DATETIME, "create_time" DATETIME, "create_by" VARCHAR(255), PRIMARY KEY ("batch_id", "node_id") ) 2014-07-16 15:42:39,447 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE INDEX "sym_idx_ob_node_status" ON "sym_outgoing_batch" ("node_id", "status") 2014-07-16 15:42:39,448 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE INDEX "sym_idx_ob_status" ON "sym_outgoing_batch" ("status") 2014-07-16 15:42:39,449 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE INDEX "sym_idx_ob_in_error" ON "sym_outgoing_batch" ("error_flag") 2014-07-16 15:42:39,449 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,450 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_parameter"( "external_id" VARCHAR(50) NOT NULL, "node_group_id" VARCHAR(50) NOT NULL, "param_key" VARCHAR(80) NOT NULL, "param_value" TEXT, "create_time" DATETIME, "last_update_by" VARCHAR(50), "last_update_time" DATETIME, PRIMARY KEY ("external_id", "node_group_id", "param_key") ) 2014-07-16 15:42:39,452 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,453 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_registration_redirect"( "registrant_external_id" VARCHAR(50) NOT NULL, "registration_node_id" VARCHAR(50) NOT NULL, PRIMARY KEY ("registrant_external_id") ) 2014-07-16 15:42:39,453 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,473 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_registration_request"( "node_group_id" VARCHAR(50) NOT NULL, "external_id" VARCHAR(50) NOT NULL, "status" CHAR(2) NOT NULL, "host_name" VARCHAR(60) NOT NULL, "ip_address" VARCHAR(50) NOT NULL, "attempt_count" INT DEFAULT 0, "registered_node_id" VARCHAR(50), "error_message" TEXT, "create_time" DATETIME NOT NULL, "last_update_by" VARCHAR(50), "last_update_time" DATETIME NOT NULL, PRIMARY KEY ("node_group_id", "external_id", "create_time") ) 2014-07-16 15:42:39,474 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE INDEX "sym_idx_reg_req_1" ON "sym_registration_request" ("node_group_id", "external_id", "status", "host_name", "ip_address") 2014-07-16 15:42:39,477 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE INDEX "sym_idx_reg_req_2" ON "sym_registration_request" ("status") 2014-07-16 15:42:39,477 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,479 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_router"( "router_id" VARCHAR(50) NOT NULL, "target_catalog_name" VARCHAR(255), "target_schema_name" VARCHAR(255), "target_table_name" VARCHAR(255), "source_node_group_id" VARCHAR(50) NOT NULL, "target_node_group_id" VARCHAR(50) NOT NULL, "router_type" VARCHAR(50), "router_expression" TEXT, "sync_on_update" SMALLINT DEFAULT 1 NOT NULL, "sync_on_insert" SMALLINT DEFAULT 1 NOT NULL, "sync_on_delete" SMALLINT DEFAULT 1 NOT NULL, "use_source_catalog_schema" SMALLINT DEFAULT 1 NOT NULL, "create_time" DATETIME NOT NULL, "last_update_by" VARCHAR(50), "last_update_time" DATETIME NOT NULL, PRIMARY KEY ("router_id") ) 2014-07-16 15:42:39,479 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,481 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_sequence"( "sequence_name" VARCHAR(50) NOT NULL, "current_value" BIGINT DEFAULT 0 NOT NULL, "increment_by" INT DEFAULT 1 NOT NULL, "min_value" BIGINT DEFAULT 1 NOT NULL, "max_value" BIGINT DEFAULT 9999999999 NOT NULL, "cycle" SMALLINT DEFAULT 0, "create_time" DATETIME, "last_update_by" VARCHAR(50), "last_update_time" DATETIME NOT NULL, PRIMARY KEY ("sequence_name") ) 2014-07-16 15:42:39,482 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,483 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_table_reload_request"( "target_node_id" VARCHAR(50) NOT NULL, "source_node_id" VARCHAR(50) NOT NULL, "trigger_id" VARCHAR(128) NOT NULL, "router_id" VARCHAR(50) NOT NULL, "reload_select" TEXT, "reload_delete_stmt" TEXT, "reload_enabled" SMALLINT DEFAULT 0, "reload_time" DATETIME, "create_time" DATETIME, "last_update_by" VARCHAR(50), "last_update_time" DATETIME NOT NULL, PRIMARY KEY ("target_node_id", "source_node_id", "trigger_id", "router_id") ) 2014-07-16 15:42:39,484 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,485 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_transform_table"( "transform_id" VARCHAR(50) NOT NULL, "source_node_group_id" VARCHAR(50) NOT NULL, "target_node_group_id" VARCHAR(50) NOT NULL, "transform_point" VARCHAR(10) NOT NULL, "source_catalog_name" VARCHAR(255), "source_schema_name" VARCHAR(255), "source_table_name" VARCHAR(255) NOT NULL, "target_catalog_name" VARCHAR(255), "target_schema_name" VARCHAR(255), "target_table_name" VARCHAR(255), "update_first" SMALLINT DEFAULT 0, "delete_action" VARCHAR(10) NOT NULL, "transform_order" INT DEFAULT 1 NOT NULL, "column_policy" VARCHAR(10) DEFAULT 'SPECIFIED' NOT NULL, "create_time" DATETIME, "last_update_by" VARCHAR(50), "last_update_time" DATETIME, PRIMARY KEY ("transform_id", "source_node_group_id", "target_node_group_id") ) 2014-07-16 15:42:39,493 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,495 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_transform_column"( "transform_id" VARCHAR(50) NOT NULL, "include_on" CHAR(1) DEFAULT '*' NOT NULL, "target_column_name" VARCHAR(128) NOT NULL, "source_column_name" VARCHAR(128), "pk" SMALLINT DEFAULT 0, "transform_type" VARCHAR(50) DEFAULT 'copy', "transform_expression" TEXT, "transform_order" INT DEFAULT 1 NOT NULL, "create_time" DATETIME, "last_update_by" VARCHAR(50), "last_update_time" DATETIME, PRIMARY KEY ("transform_id", "include_on", "target_column_name") ) 2014-07-16 15:42:39,495 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,498 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_trigger"( "trigger_id" VARCHAR(128) NOT NULL, "source_catalog_name" VARCHAR(255), "source_schema_name" VARCHAR(255), "source_table_name" VARCHAR(255) NOT NULL, "channel_id" VARCHAR(128) NOT NULL, "reload_channel_id" VARCHAR(128) DEFAULT 'reload' NOT NULL, "sync_on_update" SMALLINT DEFAULT 1 NOT NULL, "sync_on_insert" SMALLINT DEFAULT 1 NOT NULL, "sync_on_delete" SMALLINT DEFAULT 1 NOT NULL, "sync_on_incoming_batch" SMALLINT DEFAULT 0 NOT NULL, "name_for_update_trigger" VARCHAR(255), "name_for_insert_trigger" VARCHAR(255), "name_for_delete_trigger" VARCHAR(255), "sync_on_update_condition" TEXT, "sync_on_insert_condition" TEXT, "sync_on_delete_condition" TEXT, "custom_on_update_text" TEXT, "custom_on_insert_text" TEXT, "custom_on_delete_text" TEXT, "external_select" TEXT, "tx_id_expression" TEXT, "channel_expression" TEXT, "excluded_column_names" TEXT, "sync_key_names" TEXT, "use_stream_lobs" SMALLINT DEFAULT 0 NOT NULL, "use_capture_lobs" SMALLINT DEFAULT 0 NOT NULL, "use_capture_old_data" SMALLINT DEFAULT 1 NOT NULL, "use_handle_key_updates" SMALLINT DEFAULT 0 NOT NULL, "create_time" DATETIME NOT NULL, "last_update_by" VARCHAR(50), "last_update_time" DATETIME NOT NULL, PRIMARY KEY ("trigger_id") ) 2014-07-16 15:42:39,509 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,510 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_trigger_hist"( "trigger_hist_id" INT NOT NULL, "trigger_id" VARCHAR(128) NOT NULL, "source_table_name" VARCHAR(255) NOT NULL, "source_catalog_name" VARCHAR(255), "source_schema_name" VARCHAR(255), "name_for_update_trigger" VARCHAR(255), "name_for_insert_trigger" VARCHAR(255), "name_for_delete_trigger" VARCHAR(255), "table_hash" BIGINT DEFAULT 0 NOT NULL, "trigger_row_hash" BIGINT DEFAULT 0 NOT NULL, "trigger_template_hash" BIGINT DEFAULT 0 NOT NULL, "column_names" TEXT NOT NULL, "pk_column_names" TEXT NOT NULL, "last_trigger_build_reason" CHAR(1) NOT NULL, "error_message" TEXT, "create_time" DATETIME NOT NULL, "inactive_time" DATETIME, PRIMARY KEY ("trigger_hist_id") ) 2014-07-16 15:42:39,518 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,520 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_trigger_router"( "trigger_id" VARCHAR(128) NOT NULL, "router_id" VARCHAR(50) NOT NULL, "enabled" SMALLINT DEFAULT 1 NOT NULL, "initial_load_order" INT DEFAULT 1 NOT NULL, "initial_load_select" TEXT, "initial_load_delete_stmt" TEXT, "initial_load_batch_count" INT DEFAULT 1, "ping_back_enabled" SMALLINT DEFAULT 0 NOT NULL, "create_time" DATETIME NOT NULL, "last_update_by" VARCHAR(50), "last_update_time" DATETIME NOT NULL, PRIMARY KEY ("trigger_id", "router_id") ) 2014-07-16 15:42:39,523 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: SET quoted_identifier on 2014-07-16 15:42:39,523 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: CREATE TABLE "sym_trigger_router_grouplet"( "grouplet_id" VARCHAR(50) NOT NULL, "trigger_id" VARCHAR(128) NOT NULL, "router_id" VARCHAR(50) NOT NULL, "applies_when" CHAR(1) NOT NULL, "create_time" DATETIME NOT NULL, "last_update_by" VARCHAR(50), "last_update_time" DATETIME NOT NULL, PRIMARY KEY ("grouplet_id", "trigger_id", "router_id", "applies_when") ) 2014-07-16 15:42:39,529 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: ALTER TABLE "sym_conflict" ADD CONSTRAINT "sym_fk_cf_2_grp_lnk" FOREIGN KEY ("source_node_group_id", "target_node_group_id") REFERENCES "sym_node_group_link" ("source_node_group_id", "target_node_group_id") 2014-07-16 15:42:39,532 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: ALTER TABLE "sym_file_trigger_router" ADD CONSTRAINT "sym_fk_ftr_2_ftrg" FOREIGN KEY ("trigger_id") REFERENCES "sym_file_trigger" ("trigger_id") 2014-07-16 15:42:39,533 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: ALTER TABLE "sym_file_trigger_router" ADD CONSTRAINT "sym_fk_ftr_2_rtr" FOREIGN KEY ("router_id") REFERENCES "sym_router" ("router_id") 2014-07-16 15:42:39,534 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: ALTER TABLE "sym_grouplet_link" ADD CONSTRAINT "sym_fk_gpltlnk_2_gplt" FOREIGN KEY ("grouplet_id") REFERENCES "sym_grouplet" ("grouplet_id") 2014-07-16 15:42:39,537 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: ALTER TABLE "sym_node_group_link" ADD CONSTRAINT "sym_fk_lnk_2_grp_src" FOREIGN KEY ("source_node_group_id") REFERENCES "sym_node_group" ("node_group_id") 2014-07-16 15:42:39,550 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: ALTER TABLE "sym_node_group_link" ADD CONSTRAINT "sym_fk_lnk_2_grp_tgt" FOREIGN KEY ("target_node_group_id") REFERENCES "sym_node_group" ("node_group_id") 2014-07-16 15:42:39,550 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: ALTER TABLE "sym_node_identity" ADD CONSTRAINT "sym_fk_ident_2_node" FOREIGN KEY ("node_id") REFERENCES "sym_node" ("node_id") 2014-07-16 15:42:39,551 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: ALTER TABLE "sym_node_security" ADD CONSTRAINT "sym_fk_sec_2_node" FOREIGN KEY ("node_id") REFERENCES "sym_node" ("node_id") 2014-07-16 15:42:39,552 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: ALTER TABLE "sym_router" ADD CONSTRAINT "sym_fk_rt_2_grp_lnk" FOREIGN KEY ("source_node_group_id", "target_node_group_id") REFERENCES "sym_node_group_link" ("source_node_group_id", "target_node_group_id") 2014-07-16 15:42:39,553 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: ALTER TABLE "sym_transform_table" ADD CONSTRAINT "sym_fk_tt_2_grp_lnk" FOREIGN KEY ("source_node_group_id", "target_node_group_id") REFERENCES "sym_node_group_link" ("source_node_group_id", "target_node_group_id") 2014-07-16 15:42:39,553 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: ALTER TABLE "sym_trigger" ADD CONSTRAINT "sym_fk_trg_2_chnl" FOREIGN KEY ("channel_id") REFERENCES "sym_channel" ("channel_id") 2014-07-16 15:42:39,554 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: ALTER TABLE "sym_trigger" ADD CONSTRAINT "sym_fk_trg_2_rld_chnl" FOREIGN KEY ("reload_channel_id") REFERENCES "sym_channel" ("channel_id") 2014-07-16 15:42:39,555 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: ALTER TABLE "sym_trigger_router" ADD CONSTRAINT "sym_fk_tr_2_trg" FOREIGN KEY ("trigger_id") REFERENCES "sym_trigger" ("trigger_id") 2014-07-16 15:42:39,556 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: ALTER TABLE "sym_trigger_router" ADD CONSTRAINT "sym_fk_tr_2_rtr" FOREIGN KEY ("router_id") REFERENCES "sym_router" ("router_id") 2014-07-16 15:42:39,556 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: ALTER TABLE "sym_trigger_router_grouplet" ADD CONSTRAINT "sym_fk_trgplt_2_gplt" FOREIGN KEY ("grouplet_id") REFERENCES "sym_grouplet" ("grouplet_id") 2014-07-16 15:42:39,557 INFO [corp-000] [MsSqlSymmetricDialect] [main] DDL applied: ALTER TABLE "sym_trigger_router_grouplet" ADD CONSTRAINT "sym_fk_trgplt_2_tr" FOREIGN KEY ("trigger_id", "router_id") REFERENCES "sym_trigger_router" ("trigger_id", "router_id") 2014-07-16 15:42:39,559 INFO [corp-000] [MsSqlSymmetricDialect] [main] Done with auto update of SymmetricDS tables 2014-07-16 15:42:39,567 INFO [corp-000] [MsSqlSymmetricDialect] [main] Updating indexes to prevent lock escalation 2014-07-16 15:42:39,643 INFO [corp-000] [MsSqlSymmetricDialect] [main] Just installed sym_base64_encode 2014-07-16 15:42:39,645 INFO [corp-000] [MsSqlSymmetricDialect] [main] Just installed sym_triggers_disabled 2014-07-16 15:42:39,647 INFO [corp-000] [MsSqlSymmetricDialect] [main] Just installed sym_node_disabled 2014-07-16 15:42:39,650 INFO [corp-000] [ConfigurationService] [main] Auto-configuring config channel 2014-07-16 15:42:39,659 INFO [corp-000] [ConfigurationService] [main] Auto-configuring reload channel 2014-07-16 15:42:39,661 INFO [corp-000] [ConfigurationService] [main] Auto-configuring heartbeat channel 2014-07-16 15:42:39,662 INFO [corp-000] [ConfigurationService] [main] Auto-configuring default channel 2014-07-16 15:42:39,663 INFO [corp-000] [ConfigurationService] [main] Auto-configuring dynamic channel 2014-07-16 15:42:39,664 INFO [corp-000] [ConfigurationService] [main] Auto-configuring filesync channel 2014-07-16 15:42:39,665 INFO [corp-000] [ConfigurationService] [main] Auto-configuring filesync_reload channel 2014-07-16 15:42:39,683 INFO [corp-000] [AbstractSymmetricEngine] [main] Done initializing SymmetricDS database 2014-07-16 15:42:50,898 INFO [] [AbstractCommandLauncher] [main] Option: name=engine, value={corp-000} 2014-07-16 15:42:51,060 INFO [] [JdbcDatabasePlatformFactory] [main] Detected database 'Microsoft SQL Server', version '10', protocol 'jtds' 2014-07-16 15:43:02,881 INFO [startup] [AbstractCommandLauncher] [main] Option: name=engine, value={corp-000} 2014-07-16 15:43:02,881 INFO [startup] [AbstractCommandLauncher] [main] Option: name=port, value={7070} 2014-07-16 15:43:02,979 INFO [startup] [SymmetricWebServer] [main] About to start SymmetricDS web server on host:port default:7070 2014-07-16 15:43:04,076 INFO [startup] [/] [main] Initializing Spring root WebApplicationContext 2014-07-16 15:43:04,624 INFO [corp-000] [JdbcDatabasePlatformFactory] [symmetric-startup] Detected database 'Microsoft SQL Server', version '10', protocol 'jtds' 2014-07-16 15:43:04,665 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] The DbDialect being used is org.jumpmind.symmetric.db.mssql.MsSqlSymmetricDialect 2014-07-16 15:43:04,673 INFO [corp-000] [StagingManager] [symmetric-startup] The staging directory was initialized at the following location: C:\Users\user.name\symmetricds\sym-corp-fix\symmetric-3.6.3-SNAPSHOT\tmp\corp-000 2014-07-16 15:43:04,703 INFO [corp-000] [ClusterService] [symmetric-startup] This node picked a server id of T005583.eu.Micros.int 2014-07-16 15:43:04,903 INFO [corp-000] [ExtensionPointManager] [symmetric-startup] Found 8 extension points that will be registered 2014-07-16 15:43:04,927 INFO [corp-000] [AbstractSymmetricEngine] [symmetric-startup] Initializing SymmetricDS database 2014-07-16 15:43:04,927 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Checking if SymmetricDS tables need created or altered 2014-07-16 15:43:04,952 INFO [startup] [/] [main] Initializing Spring FrameworkServlet 'rest' 2014-07-16 15:43:05,097 INFO [startup] [SymmetricWebServer] [main] Starting JMX HTTP console on port 7071 2014-07-16 15:43:05,111 INFO [startup] [SymmetricWebServer] [main] Joining the web server main thread 2014-07-16 15:43:05,512 INFO [corp-000] [AbstractSymmetricEngine] [symmetric-startup] Done initializing SymmetricDS database 2014-07-16 15:43:05,522 INFO [corp-000] [AbstractSymmetricEngine] [symmetric-startup] Starting registered node [group=corp, id=000, externalId=000] 2014-07-16 15:43:05,523 INFO [corp-000] [TriggerRouterService] [symmetric-startup] Synchronizing triggers 2014-07-16 15:43:05,573 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_LD_FLTR_CRP trigger for sym-corp.dbo.sym_load_filter 2014-07-16 15:43:05,583 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_LD_FLTR_CRP trigger for sym-corp.dbo.sym_load_filter 2014-07-16 15:43:05,589 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_LD_FLTR_CRP trigger for sym-corp.dbo.sym_load_filter 2014-07-16 15:43:05,603 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_CNFLCT_CRP trigger for sym-corp.dbo.sym_conflict 2014-07-16 15:43:05,608 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_CNFLCT_CRP trigger for sym-corp.dbo.sym_conflict 2014-07-16 15:43:05,612 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_CNFLCT_CRP trigger for sym-corp.dbo.sym_conflict 2014-07-16 15:43:05,624 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_GRPLT_CRP trigger for sym-corp.dbo.sym_grouplet 2014-07-16 15:43:05,628 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_GRPLT_CRP trigger for sym-corp.dbo.sym_grouplet 2014-07-16 15:43:05,631 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_GRPLT_CRP trigger for sym-corp.dbo.sym_grouplet 2014-07-16 15:43:05,643 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_TRGGR_RTR_GRPLT_CRP trigger for sym-corp.dbo.sym_trigger_router_grouplet 2014-07-16 15:43:05,647 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_TRGGR_RTR_GRPLT_CRP trigger for sym-corp.dbo.sym_trigger_router_grouplet 2014-07-16 15:43:05,652 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_TRGGR_RTR_GRPLT_CRP trigger for sym-corp.dbo.sym_trigger_router_grouplet 2014-07-16 15:43:05,665 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_FL_SNPSHT_CRP trigger for sym-corp.dbo.sym_file_snapshot 2014-07-16 15:43:05,669 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_FL_SNPSHT_CRP trigger for sym-corp.dbo.sym_file_snapshot 2014-07-16 15:43:05,683 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_RTR_CRP trigger for sym-corp.dbo.sym_router 2014-07-16 15:43:05,687 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_RTR_CRP trigger for sym-corp.dbo.sym_router 2014-07-16 15:43:05,691 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_RTR_CRP trigger for sym-corp.dbo.sym_router 2014-07-16 15:43:05,704 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_FL_TRGGR_RTR_CRP trigger for sym-corp.dbo.sym_file_trigger_router 2014-07-16 15:43:05,708 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_FL_TRGGR_RTR_CRP trigger for sym-corp.dbo.sym_file_trigger_router 2014-07-16 15:43:05,711 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_FL_TRGGR_RTR_CRP trigger for sym-corp.dbo.sym_file_trigger_router 2014-07-16 15:43:05,724 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_TRGGR_RTR_CRP trigger for sym-corp.dbo.sym_trigger_router 2014-07-16 15:43:05,728 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_TRGGR_RTR_CRP trigger for sym-corp.dbo.sym_trigger_router 2014-07-16 15:43:05,732 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_TRGGR_RTR_CRP trigger for sym-corp.dbo.sym_trigger_router 2014-07-16 15:43:05,744 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_ND_GRP_CHNNL_WND_CRP trigger for sym-corp.dbo.sym_node_group_channel_wnd 2014-07-16 15:43:05,747 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_ND_GRP_CHNNL_WND_CRP trigger for sym-corp.dbo.sym_node_group_channel_wnd 2014-07-16 15:43:05,751 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_ND_GRP_CHNNL_WND_CRP trigger for sym-corp.dbo.sym_node_group_channel_wnd 2014-07-16 15:43:05,764 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_TM_SLLNG_PRC_CRP trigger for sym-corp.dbo.item_selling_price 2014-07-16 15:43:05,767 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_TM_SLLNG_PRC_CRP trigger for sym-corp.dbo.item_selling_price 2014-07-16 15:43:05,771 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_TM_SLLNG_PRC_CRP trigger for sym-corp.dbo.item_selling_price 2014-07-16 15:43:05,783 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_ND_GRP_LNK_CRP trigger for sym-corp.dbo.sym_node_group_link 2014-07-16 15:43:05,786 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_ND_GRP_LNK_CRP trigger for sym-corp.dbo.sym_node_group_link 2014-07-16 15:43:05,790 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_ND_GRP_LNK_CRP trigger for sym-corp.dbo.sym_node_group_link 2014-07-16 15:43:05,810 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_ND_HST_CRP trigger for sym-corp.dbo.sym_node_host 2014-07-16 15:43:05,814 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_ND_HST_CRP trigger for sym-corp.dbo.sym_node_host 2014-07-16 15:43:05,820 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_ND_HST_CRP trigger for sym-corp.dbo.sym_node_host 2014-07-16 15:43:05,833 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_CHNNL_CRP trigger for sym-corp.dbo.sym_channel 2014-07-16 15:43:05,837 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_CHNNL_CRP trigger for sym-corp.dbo.sym_channel 2014-07-16 15:43:05,841 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_CHNNL_CRP trigger for sym-corp.dbo.sym_channel 2014-07-16 15:43:05,854 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_FL_TRGGR_CRP trigger for sym-corp.dbo.sym_file_trigger 2014-07-16 15:43:05,858 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_FL_TRGGR_CRP trigger for sym-corp.dbo.sym_file_trigger 2014-07-16 15:43:05,862 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_FL_TRGGR_CRP trigger for sym-corp.dbo.sym_file_trigger 2014-07-16 15:43:05,874 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_ND_CRP trigger for sym-corp.dbo.sym_node 2014-07-16 15:43:05,878 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_ND_CRP trigger for sym-corp.dbo.sym_node 2014-07-16 15:43:05,881 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_ND_CRP trigger for sym-corp.dbo.sym_node 2014-07-16 15:43:05,893 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_GRPLT_LNK_CRP trigger for sym-corp.dbo.sym_grouplet_link 2014-07-16 15:43:05,896 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_GRPLT_LNK_CRP trigger for sym-corp.dbo.sym_grouplet_link 2014-07-16 15:43:05,899 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_GRPLT_LNK_CRP trigger for sym-corp.dbo.sym_grouplet_link 2014-07-16 15:43:05,907 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_TM_CRP trigger for sym-corp.dbo.item 2014-07-16 15:43:05,910 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_TM_CRP trigger for sym-corp.dbo.item 2014-07-16 15:43:05,913 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_TM_CRP trigger for sym-corp.dbo.item 2014-07-16 15:43:05,925 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_ND_SCRTY_CRP trigger for sym-corp.dbo.sym_node_security 2014-07-16 15:43:05,929 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_ND_SCRTY_CRP trigger for sym-corp.dbo.sym_node_security 2014-07-16 15:43:05,932 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_ND_SCRTY_CRP trigger for sym-corp.dbo.sym_node_security 2014-07-16 15:43:05,945 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_TRGGR_CRP trigger for sym-corp.dbo.sym_trigger 2014-07-16 15:43:05,951 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_TRGGR_CRP trigger for sym-corp.dbo.sym_trigger 2014-07-16 15:43:05,957 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_TRGGR_CRP trigger for sym-corp.dbo.sym_trigger 2014-07-16 15:43:05,970 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_TRNSFRM_CLMN_CRP trigger for sym-corp.dbo.sym_transform_column 2014-07-16 15:43:05,973 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_TRNSFRM_CLMN_CRP trigger for sym-corp.dbo.sym_transform_column 2014-07-16 15:43:05,978 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_TRNSFRM_CLMN_CRP trigger for sym-corp.dbo.sym_transform_column 2014-07-16 15:43:05,990 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_TBL_RLD_RQST_CRP trigger for sym-corp.dbo.sym_table_reload_request 2014-07-16 15:43:05,994 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_TBL_RLD_RQST_CRP trigger for sym-corp.dbo.sym_table_reload_request 2014-07-16 15:43:05,998 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_TBL_RLD_RQST_CRP trigger for sym-corp.dbo.sym_table_reload_request 2014-07-16 15:43:06,009 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_ND_GRP_CRP trigger for sym-corp.dbo.sym_node_group 2014-07-16 15:43:06,012 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_ND_GRP_CRP trigger for sym-corp.dbo.sym_node_group 2014-07-16 15:43:06,031 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_ND_GRP_CRP trigger for sym-corp.dbo.sym_node_group 2014-07-16 15:43:06,043 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_PRMTR_CRP trigger for sym-corp.dbo.sym_parameter 2014-07-16 15:43:06,046 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_PRMTR_CRP trigger for sym-corp.dbo.sym_parameter 2014-07-16 15:43:06,050 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_PRMTR_CRP trigger for sym-corp.dbo.sym_parameter 2014-07-16 15:43:06,063 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_I_FOR_SYM_TRNSFRM_TBL_CRP trigger for sym-corp.dbo.sym_transform_table 2014-07-16 15:43:06,067 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_U_FOR_SYM_TRNSFRM_TBL_CRP trigger for sym-corp.dbo.sym_transform_table 2014-07-16 15:43:06,072 INFO [corp-000] [MsSqlSymmetricDialect] [symmetric-startup] Creating SYM_ON_D_FOR_SYM_TRNSFRM_TBL_CRP trigger for sym-corp.dbo.sym_transform_table 2014-07-16 15:43:06,074 INFO [corp-000] [TriggerRouterService] [symmetric-startup] Done synchronizing triggers 2014-07-16 15:43:06,075 INFO [corp-000] [PushHeartbeatListener] [symmetric-startup] Some attribute(s) of node changed. Recording changes 2014-07-16 15:43:06,075 INFO [corp-000] [PushHeartbeatListener] [symmetric-startup] Updating my node configuration info according to the symmetric properties 2014-07-16 15:43:06,110 INFO [corp-000] [RouterJob] [symmetric-startup] Starting job.routing on periodic schedule: every 5000ms with the first run at Wed Jul 16 15:43:15 CEST 2014 2014-07-16 15:43:06,113 INFO [corp-000] [PushJob] [symmetric-startup] Starting job.push on periodic schedule: every 10000ms with the first run at Wed Jul 16 15:43:15 CEST 2014 2014-07-16 15:43:06,113 INFO [corp-000] [PullJob] [symmetric-startup] Starting job.pull on periodic schedule: every 10000ms with the first run at Wed Jul 16 15:43:15 CEST 2014 2014-07-16 15:43:06,113 INFO [corp-000] [OutgoingPurgeJob] [symmetric-startup] Starting job.purge.outgoing with cron expression: 0 0 0 * * * 2014-07-16 15:43:06,116 INFO [corp-000] [IncomingPurgeJob] [symmetric-startup] Starting job.purge.incoming with cron expression: 0 0 0 * * * 2014-07-16 15:43:06,116 INFO [corp-000] [DataGapPurgeJob] [symmetric-startup] Starting job.purge.datagaps with cron expression: 0 0 0 * * * 2014-07-16 15:43:06,117 INFO [corp-000] [StatisticFlushJob] [symmetric-startup] Starting job.stat.flush with cron expression: 0 0/5 * * * * 2014-07-16 15:43:06,117 INFO [corp-000] [SyncTriggersJob] [symmetric-startup] Starting job.synctriggers with cron expression: 0 0 0 * * * 2014-07-16 15:43:06,117 INFO [corp-000] [HeartbeatJob] [symmetric-startup] Starting job.heartbeat on periodic schedule: every 900000ms with the first run at Wed Jul 16 15:43:15 CEST 2014 2014-07-16 15:43:06,118 INFO [corp-000] [WatchdogJob] [symmetric-startup] Starting job.watchdog on periodic schedule: every 3600000ms with the first run at Wed Jul 16 15:43:15 CEST 2014 2014-07-16 15:43:06,118 INFO [corp-000] [StageManagementJob] [symmetric-startup] Starting job.stage.management on periodic schedule: every 15000ms with the first run at Wed Jul 16 15:43:15 CEST 2014 2014-07-16 15:43:06,118 INFO [corp-000] [JobManager] [symmetric-startup] Job job.refresh.cache not configured for auto start 2014-07-16 15:43:06,118 INFO [corp-000] [FileSyncTrackerJob] [symmetric-startup] Starting job.file.sync.tracker with cron expression: 0 0/5 * * * * 2014-07-16 15:43:06,119 INFO [corp-000] [FileSyncPullJob] [symmetric-startup] Starting job.file.sync.pull on periodic schedule: every 60000ms with the first run at Wed Jul 16 15:43:15 CEST 2014 2014-07-16 15:43:06,119 INFO [corp-000] [FileSyncPushJob] [symmetric-startup] Starting job.file.sync.push on periodic schedule: every 60000ms with the first run at Wed Jul 16 15:43:15 CEST 2014 2014-07-16 15:43:06,119 INFO [corp-000] [InitialLoadExtractorJob] [symmetric-startup] Starting job.initial.load.extract on periodic schedule: every 10000ms with the first run at Wed Jul 16 15:43:15 CEST 2014 2014-07-16 15:43:06,119 INFO [corp-000] [AbstractSymmetricEngine] [symmetric-startup] Started SymmetricDS 2014-07-16 15:43:06,119 INFO [corp-000] [AbstractSymmetricEngine] [symmetric-startup] SymmetricDS: type=server, name=corp-000, version=3.6.3-SNAPSHOT, groupId=corp, externalId=000, databaseName=Microsoft SQL Server, databaseVersion=10.50, driverName=jTDS Type 4 JDBC Driver for MS SQL Server and Sybase, driverVersion=1.2.4 2014-07-16 15:43:15,882 INFO [corp-000] [RouterService] [corp-000-job-2] The 'config' channel is NOT in common batch mode 2014-07-16 15:43:15,978 INFO [corp-000] [RouterService] [corp-000-job-2] The 'filesync_reload' channel is NOT in common batch mode 2014-07-16 15:43:15,980 INFO [corp-000] [RouterService] [corp-000-job-2] The 'item' channel is NOT in common batch mode 2014-07-16 15:43:15,981 INFO [corp-000] [RouterService] [corp-000-job-2] The 'reload' channel is NOT in common batch mode 2014-07-16 15:43:15,982 INFO [corp-000] [RouterService] [corp-000-job-2] The 'sale_transaction' channel is in common batch mode 2014-07-16 15:43:15,982 INFO [corp-000] [RouterService] [corp-000-job-2] The 'heartbeat' channel is NOT in common batch mode 2014-07-16 15:43:15,988 INFO [corp-000] [RouterService] [corp-000-job-2] The 'filesync' channel is NOT in common batch mode 2014-07-16 15:43:15,989 INFO [corp-000] [RouterService] [corp-000-job-2] The 'default' channel is in common batch mode 2014-07-16 15:43:15,989 INFO [corp-000] [RouterService] [corp-000-job-2] The 'dynamic' channel is in common batch mode 2014-07-16 15:43:15,990 INFO [corp-000] [RouterService] [corp-000-job-2] Routed 3 data events in 124 ms 2014-07-16 15:43:20,686 WARN [corp-000] [RegistrationUriHandler] [qtp14372770-18] store:001:? was not allowed to register. 2014-07-16 15:43:25,358 INFO [] [AbstractCommandLauncher] [main] Option: name=engine, value={corp-000} 2014-07-16 15:43:25,869 INFO [corp-000] [JdbcDatabasePlatformFactory] [main] Detected database 'Microsoft SQL Server', version '10', protocol 'jtds' 2014-07-16 15:43:25,903 INFO [corp-000] [MsSqlSymmetricDialect] [main] The DbDialect being used is org.jumpmind.symmetric.db.mssql.MsSqlSymmetricDialect 2014-07-16 15:43:25,909 INFO [corp-000] [StagingManager] [main] The staging directory was initialized at the following location: C:\Users\user.name\symmetricds\sym-corp-fix\symmetric-3.6.3-SNAPSHOT\tmp\corp-000 2014-07-16 15:43:25,937 INFO [corp-000] [ClusterService] [main] This node picked a server id of T005583.eu.Micros.int 2014-07-16 15:43:26,032 INFO [corp-000] [ExtensionPointManager] [main] Found 8 extension points that will be registered 2014-07-16 15:43:26,144 INFO [corp-000] [RegistrationService] [main] Just opened registration for external id of 001 and a node group of store and a node id of 001 2014-07-16 15:43:27,567 INFO [corp-000] [MsSqlSymmetricDialect] [qtp14372770-20] This database DOES support disabling triggers during a symmetricds data load 2014-07-16 15:43:31,048 INFO [corp-000] [RouterService] [corp-000-job-13] Routed 4 data events in 15 ms 2014-07-16 15:43:38,557 INFO [corp-000] [JdbcDatabasePlatformFactory] [main] Detected database 'Microsoft SQL Server', version '10', protocol 'jtds' 2014-07-16 15:43:38,594 INFO [corp-000] [MsSqlSymmetricDialect] [main] The DbDialect being used is org.jumpmind.symmetric.db.mssql.MsSqlSymmetricDialect 2014-07-16 15:43:38,599 INFO [corp-000] [StagingManager] [main] The staging directory was initialized at the following location: C:\Users\user.name\symmetricds\sym-corp-fix\symmetric-3.6.3-SNAPSHOT\tmp\corp-000 2014-07-16 15:43:38,630 INFO [corp-000] [ClusterService] [main] This node picked a server id of T005583.eu.Micros.int 2014-07-16 15:43:38,727 INFO [corp-000] [ExtensionPointManager] [main] Found 8 extension points that will be registered 2014-07-16 15:43:41,143 INFO [corp-000] [PurgeService] [corp-000-job-5] Purged all 2 incoming batch for node 001 2014-07-16 15:43:41,143 INFO [corp-000] [RouterService] [corp-000-job-5] Inserted reload events for node 001 in 72 ms 2014-07-16 15:43:41,162 INFO [corp-000] [RouterService] [corp-000-job-5] Routed 4 data events in 19 ms 2014-07-16 15:46:54,554 INFO [corp-000] [JdbcDatabasePlatformFactory] [main] Detected database 'Microsoft SQL Server', version '10', protocol 'jtds' 2014-07-16 15:46:54,589 INFO [corp-000] [MsSqlSymmetricDialect] [main] The DbDialect being used is org.jumpmind.symmetric.db.mssql.MsSqlSymmetricDialect 2014-07-16 15:46:54,595 INFO [corp-000] [StagingManager] [main] The staging directory was initialized at the following location: C:\Users\user.name\symmetricds\sym-corp-fix\symmetric-3.6.3-SNAPSHOT\tmp\corp-000 2014-07-16 15:46:54,624 INFO [corp-000] [ClusterService] [main] This node picked a server id of T005583.eu.Micros.int 2014-07-16 15:46:54,717 INFO [corp-000] [ExtensionPointManager] [main] Found 8 extension points that will be registered 2014-07-16 15:46:54,720 INFO [corp-000] [TriggerRouterService] [main] Synchronizing triggers 2014-07-16 15:46:55,044 INFO [corp-000] [MsSqlSymmetricDialect] [main] Creating SYM_ON_I_FOR_TM_CRP trigger for sym-corp.dbo.item 2014-07-16 15:46:55,052 INFO [corp-000] [MsSqlSymmetricDialect] [main] Creating SYM_ON_U_FOR_TM_CRP trigger for sym-corp.dbo.item 2014-07-16 15:46:55,057 INFO [corp-000] [MsSqlSymmetricDialect] [main] Creating SYM_ON_D_FOR_TM_CRP trigger for sym-corp.dbo.item 2014-07-16 15:46:55,074 INFO [corp-000] [TriggerRouterService] [main] Done synchronizing triggers 2014-07-16 15:47:01,593 INFO [] [AbstractCommandLauncher] [main] Option: name=node, value={001} 2014-07-16 15:47:02,105 INFO [corp-000] [JdbcDatabasePlatformFactory] [main] Detected database 'Microsoft SQL Server', version '10', protocol 'jtds' 2014-07-16 15:47:02,139 INFO [corp-000] [MsSqlSymmetricDialect] [main] The DbDialect being used is org.jumpmind.symmetric.db.mssql.MsSqlSymmetricDialect 2014-07-16 15:47:02,144 INFO [corp-000] [StagingManager] [main] The staging directory was initialized at the following location: C:\Users\user.name\symmetricds\sym-corp-fix\symmetric-3.6.3-SNAPSHOT\tmp\corp-000 2014-07-16 15:47:02,174 INFO [corp-000] [ClusterService] [main] This node picked a server id of T005583.eu.Micros.int 2014-07-16 15:47:02,268 INFO [corp-000] [ExtensionPointManager] [main] Found 8 extension points that will be registered 2014-07-16 15:47:07,003 INFO [corp-000] [JdbcDatabasePlatformFactory] [main] Detected database 'Microsoft SQL Server', version '10', protocol 'jtds' 2014-07-16 15:47:07,037 INFO [corp-000] [MsSqlSymmetricDialect] [main] The DbDialect being used is org.jumpmind.symmetric.db.mssql.MsSqlSymmetricDialect 2014-07-16 15:47:07,043 INFO [corp-000] [StagingManager] [main] The staging directory was initialized at the following location: C:\Users\user.name\symmetricds\sym-corp-fix\symmetric-3.6.3-SNAPSHOT\tmp\corp-000 2014-07-16 15:47:07,072 INFO [corp-000] [ClusterService] [main] This node picked a server id of T005583.eu.Micros.int 2014-07-16 15:47:07,165 INFO [corp-000] [ExtensionPointManager] [main] Found 8 extension points that will be registered 2014-07-16 15:47:11,666 INFO [corp-000] [PurgeService] [corp-000-job-13] Purged all 0 incoming batch for node 001 2014-07-16 15:47:11,666 INFO [corp-000] [RouterService] [corp-000-job-13] Inserted reload events for node 001 in 45 ms 2014-07-16 15:47:11,679 INFO [corp-000] [RouterService] [corp-000-job-13] Routed 2 data events in 13 ms 2014-07-16 15:47:18,081 ERROR [corp-000] [DataExtractorService] [qtp14372770-20] Failed to extract batch 001-20 org.jumpmind.symmetric.SymmetricException: The extracted row data did not have the expected (2) number of columns: "11000001","Yummy Gum" at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1598) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1576) at org.jumpmind.db.sql.JdbcSqlReadCursor.next(JdbcSqlReadCursor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.selectNext(DataExtractorService.java:1550) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.next(DataExtractorService.java:1501) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromSymDataSource.next(DataExtractorService.java:1358) at org.jumpmind.symmetric.io.data.reader.ExtractDataReader.nextTable(ExtractDataReader.java:99) at org.jumpmind.symmetric.io.data.DataProcessor.forEachTableInBatch(DataProcessor.java:160) at org.jumpmind.symmetric.io.data.DataProcessor.process(DataProcessor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService.extractOutgoingBatch(DataExtractorService.java:703) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:513) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:422) at org.jumpmind.symmetric.web.PullUriHandler.pull(PullUriHandler.java:117) at org.jumpmind.symmetric.web.PullUriHandler.handleWithCompression(PullUriHandler.java:89) at org.jumpmind.symmetric.web.AbstractCompressionUriHandler.handle(AbstractCompressionUriHandler.java:84) at org.jumpmind.symmetric.web.SymmetricServlet.service(SymmetricServlet.java:98) at javax.servlet.http.HttpServlet.service(HttpServlet.java:820) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:565) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:479) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:119) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:227) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1031) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:406) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:965) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:117) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:111) at org.eclipse.jetty.server.Server.handle(Server.java:348) at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:452) at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:884) at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:938) at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:630) at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:230) at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:77) at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:606) at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:46) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:603) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:538) at java.lang.Thread.run(Thread.java:662) 2014-07-16 15:47:27,782 ERROR [corp-000] [DataExtractorService] [qtp14372770-20] Failed to extract batch 001-20 org.jumpmind.symmetric.SymmetricException: The extracted row data did not have the expected (2) number of columns: "11000001","Yummy Gum" at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1598) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1576) at org.jumpmind.db.sql.JdbcSqlReadCursor.next(JdbcSqlReadCursor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.selectNext(DataExtractorService.java:1550) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.next(DataExtractorService.java:1501) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromSymDataSource.next(DataExtractorService.java:1358) at org.jumpmind.symmetric.io.data.reader.ExtractDataReader.nextTable(ExtractDataReader.java:99) at org.jumpmind.symmetric.io.data.DataProcessor.forEachTableInBatch(DataProcessor.java:160) at org.jumpmind.symmetric.io.data.DataProcessor.process(DataProcessor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService.extractOutgoingBatch(DataExtractorService.java:703) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:513) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:422) at org.jumpmind.symmetric.web.PullUriHandler.pull(PullUriHandler.java:117) at org.jumpmind.symmetric.web.PullUriHandler.handleWithCompression(PullUriHandler.java:89) at org.jumpmind.symmetric.web.AbstractCompressionUriHandler.handle(AbstractCompressionUriHandler.java:84) at org.jumpmind.symmetric.web.SymmetricServlet.service(SymmetricServlet.java:98) at javax.servlet.http.HttpServlet.service(HttpServlet.java:820) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:565) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:479) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:119) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:227) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1031) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:406) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:965) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:117) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:111) at org.eclipse.jetty.server.Server.handle(Server.java:348) at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:452) at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:884) at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:938) at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:630) at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:230) at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:77) at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:606) at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:46) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:603) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:538) at java.lang.Thread.run(Thread.java:662) 2014-07-16 15:47:37,787 ERROR [corp-000] [DataExtractorService] [qtp14372770-20] Failed to extract batch 001-20 org.jumpmind.symmetric.SymmetricException: The extracted row data did not have the expected (2) number of columns: "11000001","Yummy Gum" at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1598) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1576) at org.jumpmind.db.sql.JdbcSqlReadCursor.next(JdbcSqlReadCursor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.selectNext(DataExtractorService.java:1550) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.next(DataExtractorService.java:1501) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromSymDataSource.next(DataExtractorService.java:1358) at org.jumpmind.symmetric.io.data.reader.ExtractDataReader.nextTable(ExtractDataReader.java:99) at org.jumpmind.symmetric.io.data.DataProcessor.forEachTableInBatch(DataProcessor.java:160) at org.jumpmind.symmetric.io.data.DataProcessor.process(DataProcessor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService.extractOutgoingBatch(DataExtractorService.java:703) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:513) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:422) at org.jumpmind.symmetric.web.PullUriHandler.pull(PullUriHandler.java:117) at org.jumpmind.symmetric.web.PullUriHandler.handleWithCompression(PullUriHandler.java:89) at org.jumpmind.symmetric.web.AbstractCompressionUriHandler.handle(AbstractCompressionUriHandler.java:84) at org.jumpmind.symmetric.web.SymmetricServlet.service(SymmetricServlet.java:98) at javax.servlet.http.HttpServlet.service(HttpServlet.java:820) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:565) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:479) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:119) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:227) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1031) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:406) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:965) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:117) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:111) at org.eclipse.jetty.server.Server.handle(Server.java:348) at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:452) at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:884) at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:938) at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:630) at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:230) at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:77) at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:606) at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:46) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:603) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:538) at java.lang.Thread.run(Thread.java:662) 2014-07-16 15:47:47,793 ERROR [corp-000] [DataExtractorService] [qtp14372770-20] Failed to extract batch 001-20 org.jumpmind.symmetric.SymmetricException: The extracted row data did not have the expected (2) number of columns: "11000001","Yummy Gum" at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1598) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1576) at org.jumpmind.db.sql.JdbcSqlReadCursor.next(JdbcSqlReadCursor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.selectNext(DataExtractorService.java:1550) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.next(DataExtractorService.java:1501) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromSymDataSource.next(DataExtractorService.java:1358) at org.jumpmind.symmetric.io.data.reader.ExtractDataReader.nextTable(ExtractDataReader.java:99) at org.jumpmind.symmetric.io.data.DataProcessor.forEachTableInBatch(DataProcessor.java:160) at org.jumpmind.symmetric.io.data.DataProcessor.process(DataProcessor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService.extractOutgoingBatch(DataExtractorService.java:703) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:513) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:422) at org.jumpmind.symmetric.web.PullUriHandler.pull(PullUriHandler.java:117) at org.jumpmind.symmetric.web.PullUriHandler.handleWithCompression(PullUriHandler.java:89) at org.jumpmind.symmetric.web.AbstractCompressionUriHandler.handle(AbstractCompressionUriHandler.java:84) at org.jumpmind.symmetric.web.SymmetricServlet.service(SymmetricServlet.java:98) at javax.servlet.http.HttpServlet.service(HttpServlet.java:820) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:565) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:479) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:119) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:227) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1031) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:406) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:965) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:117) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:111) at org.eclipse.jetty.server.Server.handle(Server.java:348) at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:452) at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:884) at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:938) at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:630) at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:230) at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:77) at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:606) at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:46) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:603) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:538) at java.lang.Thread.run(Thread.java:662) 2014-07-16 15:47:57,799 ERROR [corp-000] [DataExtractorService] [qtp14372770-20] Failed to extract batch 001-20 org.jumpmind.symmetric.SymmetricException: The extracted row data did not have the expected (2) number of columns: "11000001","Yummy Gum" at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1598) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1576) at org.jumpmind.db.sql.JdbcSqlReadCursor.next(JdbcSqlReadCursor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.selectNext(DataExtractorService.java:1550) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.next(DataExtractorService.java:1501) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromSymDataSource.next(DataExtractorService.java:1358) at org.jumpmind.symmetric.io.data.reader.ExtractDataReader.nextTable(ExtractDataReader.java:99) at org.jumpmind.symmetric.io.data.DataProcessor.forEachTableInBatch(DataProcessor.java:160) at org.jumpmind.symmetric.io.data.DataProcessor.process(DataProcessor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService.extractOutgoingBatch(DataExtractorService.java:703) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:513) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:422) at org.jumpmind.symmetric.web.PullUriHandler.pull(PullUriHandler.java:117) at org.jumpmind.symmetric.web.PullUriHandler.handleWithCompression(PullUriHandler.java:89) at org.jumpmind.symmetric.web.AbstractCompressionUriHandler.handle(AbstractCompressionUriHandler.java:84) at org.jumpmind.symmetric.web.SymmetricServlet.service(SymmetricServlet.java:98) at javax.servlet.http.HttpServlet.service(HttpServlet.java:820) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:565) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:479) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:119) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:227) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1031) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:406) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:965) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:117) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:111) at org.eclipse.jetty.server.Server.handle(Server.java:348) at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:452) at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:884) at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:938) at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:630) at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:230) at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:77) at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:606) at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:46) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:603) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:538) at java.lang.Thread.run(Thread.java:662) 2014-07-16 15:48:07,803 ERROR [corp-000] [DataExtractorService] [qtp14372770-20] Failed to extract batch 001-20 org.jumpmind.symmetric.SymmetricException: The extracted row data did not have the expected (2) number of columns: "11000001","Yummy Gum" at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1598) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1576) at org.jumpmind.db.sql.JdbcSqlReadCursor.next(JdbcSqlReadCursor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.selectNext(DataExtractorService.java:1550) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.next(DataExtractorService.java:1501) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromSymDataSource.next(DataExtractorService.java:1358) at org.jumpmind.symmetric.io.data.reader.ExtractDataReader.nextTable(ExtractDataReader.java:99) at org.jumpmind.symmetric.io.data.DataProcessor.forEachTableInBatch(DataProcessor.java:160) at org.jumpmind.symmetric.io.data.DataProcessor.process(DataProcessor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService.extractOutgoingBatch(DataExtractorService.java:703) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:513) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:422) at org.jumpmind.symmetric.web.PullUriHandler.pull(PullUriHandler.java:117) at org.jumpmind.symmetric.web.PullUriHandler.handleWithCompression(PullUriHandler.java:89) at org.jumpmind.symmetric.web.AbstractCompressionUriHandler.handle(AbstractCompressionUriHandler.java:84) at org.jumpmind.symmetric.web.SymmetricServlet.service(SymmetricServlet.java:98) at javax.servlet.http.HttpServlet.service(HttpServlet.java:820) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:565) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:479) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:119) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:227) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1031) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:406) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:965) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:117) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:111) at org.eclipse.jetty.server.Server.handle(Server.java:348) at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:452) at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:884) at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:938) at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:630) at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:230) at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:77) at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:606) at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:46) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:603) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:538) at java.lang.Thread.run(Thread.java:662) 2014-07-16 15:48:17,807 ERROR [corp-000] [DataExtractorService] [qtp14372770-20] Failed to extract batch 001-20 org.jumpmind.symmetric.SymmetricException: The extracted row data did not have the expected (2) number of columns: "11000001","Yummy Gum" at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1598) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1576) at org.jumpmind.db.sql.JdbcSqlReadCursor.next(JdbcSqlReadCursor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.selectNext(DataExtractorService.java:1550) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.next(DataExtractorService.java:1501) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromSymDataSource.next(DataExtractorService.java:1358) at org.jumpmind.symmetric.io.data.reader.ExtractDataReader.nextTable(ExtractDataReader.java:99) at org.jumpmind.symmetric.io.data.DataProcessor.forEachTableInBatch(DataProcessor.java:160) at org.jumpmind.symmetric.io.data.DataProcessor.process(DataProcessor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService.extractOutgoingBatch(DataExtractorService.java:703) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:513) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:422) at org.jumpmind.symmetric.web.PullUriHandler.pull(PullUriHandler.java:117) at org.jumpmind.symmetric.web.PullUriHandler.handleWithCompression(PullUriHandler.java:89) at org.jumpmind.symmetric.web.AbstractCompressionUriHandler.handle(AbstractCompressionUriHandler.java:84) at org.jumpmind.symmetric.web.SymmetricServlet.service(SymmetricServlet.java:98) at javax.servlet.http.HttpServlet.service(HttpServlet.java:820) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:565) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:479) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:119) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:227) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1031) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:406) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:965) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:117) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:111) at org.eclipse.jetty.server.Server.handle(Server.java:348) at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:452) at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:884) at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:938) at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:630) at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:230) at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:77) at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:606) at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:46) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:603) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:538) at java.lang.Thread.run(Thread.java:662) 2014-07-16 15:48:27,813 ERROR [corp-000] [DataExtractorService] [qtp14372770-21] Failed to extract batch 001-20 org.jumpmind.symmetric.SymmetricException: The extracted row data did not have the expected (2) number of columns: "11000001","Yummy Gum" at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1598) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1576) at org.jumpmind.db.sql.JdbcSqlReadCursor.next(JdbcSqlReadCursor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.selectNext(DataExtractorService.java:1550) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.next(DataExtractorService.java:1501) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromSymDataSource.next(DataExtractorService.java:1358) at org.jumpmind.symmetric.io.data.reader.ExtractDataReader.nextTable(ExtractDataReader.java:99) at org.jumpmind.symmetric.io.data.DataProcessor.forEachTableInBatch(DataProcessor.java:160) at org.jumpmind.symmetric.io.data.DataProcessor.process(DataProcessor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService.extractOutgoingBatch(DataExtractorService.java:703) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:513) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:422) at org.jumpmind.symmetric.web.PullUriHandler.pull(PullUriHandler.java:117) at org.jumpmind.symmetric.web.PullUriHandler.handleWithCompression(PullUriHandler.java:89) at org.jumpmind.symmetric.web.AbstractCompressionUriHandler.handle(AbstractCompressionUriHandler.java:84) at org.jumpmind.symmetric.web.SymmetricServlet.service(SymmetricServlet.java:98) at javax.servlet.http.HttpServlet.service(HttpServlet.java:820) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:565) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:479) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:119) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:227) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1031) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:406) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:965) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:117) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:111) at org.eclipse.jetty.server.Server.handle(Server.java:348) at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:452) at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:884) at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:938) at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:630) at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:230) at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:77) at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:606) at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:46) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:603) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:538) at java.lang.Thread.run(Thread.java:662) 2014-07-16 15:48:37,817 ERROR [corp-000] [DataExtractorService] [qtp14372770-21] Failed to extract batch 001-20 org.jumpmind.symmetric.SymmetricException: The extracted row data did not have the expected (2) number of columns: "11000001","Yummy Gum" at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1598) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1576) at org.jumpmind.db.sql.JdbcSqlReadCursor.next(JdbcSqlReadCursor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.selectNext(DataExtractorService.java:1550) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.next(DataExtractorService.java:1501) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromSymDataSource.next(DataExtractorService.java:1358) at org.jumpmind.symmetric.io.data.reader.ExtractDataReader.nextTable(ExtractDataReader.java:99) at org.jumpmind.symmetric.io.data.DataProcessor.forEachTableInBatch(DataProcessor.java:160) at org.jumpmind.symmetric.io.data.DataProcessor.process(DataProcessor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService.extractOutgoingBatch(DataExtractorService.java:703) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:513) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:422) at org.jumpmind.symmetric.web.PullUriHandler.pull(PullUriHandler.java:117) at org.jumpmind.symmetric.web.PullUriHandler.handleWithCompression(PullUriHandler.java:89) at org.jumpmind.symmetric.web.AbstractCompressionUriHandler.handle(AbstractCompressionUriHandler.java:84) at org.jumpmind.symmetric.web.SymmetricServlet.service(SymmetricServlet.java:98) at javax.servlet.http.HttpServlet.service(HttpServlet.java:820) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:565) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:479) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:119) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:227) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1031) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:406) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:965) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:117) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:111) at org.eclipse.jetty.server.Server.handle(Server.java:348) at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:452) at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:884) at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:938) at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:630) at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:230) at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:77) at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:606) at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:46) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:603) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:538) at java.lang.Thread.run(Thread.java:662) 2014-07-16 15:48:47,822 ERROR [corp-000] [DataExtractorService] [qtp14372770-21] Failed to extract batch 001-20 org.jumpmind.symmetric.SymmetricException: The extracted row data did not have the expected (2) number of columns: "11000001","Yummy Gum" at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1598) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1576) at org.jumpmind.db.sql.JdbcSqlReadCursor.next(JdbcSqlReadCursor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.selectNext(DataExtractorService.java:1550) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.next(DataExtractorService.java:1501) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromSymDataSource.next(DataExtractorService.java:1358) at org.jumpmind.symmetric.io.data.reader.ExtractDataReader.nextTable(ExtractDataReader.java:99) at org.jumpmind.symmetric.io.data.DataProcessor.forEachTableInBatch(DataProcessor.java:160) at org.jumpmind.symmetric.io.data.DataProcessor.process(DataProcessor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService.extractOutgoingBatch(DataExtractorService.java:703) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:513) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:422) at org.jumpmind.symmetric.web.PullUriHandler.pull(PullUriHandler.java:117) at org.jumpmind.symmetric.web.PullUriHandler.handleWithCompression(PullUriHandler.java:89) at org.jumpmind.symmetric.web.AbstractCompressionUriHandler.handle(AbstractCompressionUriHandler.java:84) at org.jumpmind.symmetric.web.SymmetricServlet.service(SymmetricServlet.java:98) at javax.servlet.http.HttpServlet.service(HttpServlet.java:820) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:565) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:479) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:119) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:227) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1031) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:406) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:965) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:117) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:111) at org.eclipse.jetty.server.Server.handle(Server.java:348) at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:452) at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:884) at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:938) at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:630) at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:230) at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:77) at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:606) at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:46) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:603) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:538) at java.lang.Thread.run(Thread.java:662) 2014-07-16 15:48:57,828 ERROR [corp-000] [DataExtractorService] [qtp14372770-21] Failed to extract batch 001-20 org.jumpmind.symmetric.SymmetricException: The extracted row data did not have the expected (2) number of columns: "11000001","Yummy Gum" at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1598) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1576) at org.jumpmind.db.sql.JdbcSqlReadCursor.next(JdbcSqlReadCursor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.selectNext(DataExtractorService.java:1550) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.next(DataExtractorService.java:1501) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromSymDataSource.next(DataExtractorService.java:1358) at org.jumpmind.symmetric.io.data.reader.ExtractDataReader.nextTable(ExtractDataReader.java:99) at org.jumpmind.symmetric.io.data.DataProcessor.forEachTableInBatch(DataProcessor.java:160) at org.jumpmind.symmetric.io.data.DataProcessor.process(DataProcessor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService.extractOutgoingBatch(DataExtractorService.java:703) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:513) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:422) at org.jumpmind.symmetric.web.PullUriHandler.pull(PullUriHandler.java:117) at org.jumpmind.symmetric.web.PullUriHandler.handleWithCompression(PullUriHandler.java:89) at org.jumpmind.symmetric.web.AbstractCompressionUriHandler.handle(AbstractCompressionUriHandler.java:84) at org.jumpmind.symmetric.web.SymmetricServlet.service(SymmetricServlet.java:98) at javax.servlet.http.HttpServlet.service(HttpServlet.java:820) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:565) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:479) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:119) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:227) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1031) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:406) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:965) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:117) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:111) at org.eclipse.jetty.server.Server.handle(Server.java:348) at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:452) at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:884) at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:938) at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:630) at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:230) at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:77) at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:606) at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:46) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:603) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:538) at java.lang.Thread.run(Thread.java:662) 2014-07-16 15:49:07,833 ERROR [corp-000] [DataExtractorService] [qtp14372770-21] Failed to extract batch 001-20 org.jumpmind.symmetric.SymmetricException: The extracted row data did not have the expected (2) number of columns: "11000001","Yummy Gum" at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1598) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1576) at org.jumpmind.db.sql.JdbcSqlReadCursor.next(JdbcSqlReadCursor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.selectNext(DataExtractorService.java:1550) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.next(DataExtractorService.java:1501) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromSymDataSource.next(DataExtractorService.java:1358) at org.jumpmind.symmetric.io.data.reader.ExtractDataReader.nextTable(ExtractDataReader.java:99) at org.jumpmind.symmetric.io.data.DataProcessor.forEachTableInBatch(DataProcessor.java:160) at org.jumpmind.symmetric.io.data.DataProcessor.process(DataProcessor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService.extractOutgoingBatch(DataExtractorService.java:703) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:513) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:422) at org.jumpmind.symmetric.web.PullUriHandler.pull(PullUriHandler.java:117) at org.jumpmind.symmetric.web.PullUriHandler.handleWithCompression(PullUriHandler.java:89) at org.jumpmind.symmetric.web.AbstractCompressionUriHandler.handle(AbstractCompressionUriHandler.java:84) at org.jumpmind.symmetric.web.SymmetricServlet.service(SymmetricServlet.java:98) at javax.servlet.http.HttpServlet.service(HttpServlet.java:820) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:565) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:479) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:119) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:227) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1031) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:406) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:965) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:117) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:111) at org.eclipse.jetty.server.Server.handle(Server.java:348) at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:452) at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:884) at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:938) at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:630) at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:230) at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:77) at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:606) at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:46) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:603) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:538) at java.lang.Thread.run(Thread.java:662) 2014-07-16 15:49:17,837 ERROR [corp-000] [DataExtractorService] [qtp14372770-21] Failed to extract batch 001-20 org.jumpmind.symmetric.SymmetricException: The extracted row data did not have the expected (2) number of columns: "11000001","Yummy Gum" at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1598) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1576) at org.jumpmind.db.sql.JdbcSqlReadCursor.next(JdbcSqlReadCursor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.selectNext(DataExtractorService.java:1550) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.next(DataExtractorService.java:1501) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromSymDataSource.next(DataExtractorService.java:1358) at org.jumpmind.symmetric.io.data.reader.ExtractDataReader.nextTable(ExtractDataReader.java:99) at org.jumpmind.symmetric.io.data.DataProcessor.forEachTableInBatch(DataProcessor.java:160) at org.jumpmind.symmetric.io.data.DataProcessor.process(DataProcessor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService.extractOutgoingBatch(DataExtractorService.java:703) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:513) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:422) at org.jumpmind.symmetric.web.PullUriHandler.pull(PullUriHandler.java:117) at org.jumpmind.symmetric.web.PullUriHandler.handleWithCompression(PullUriHandler.java:89) at org.jumpmind.symmetric.web.AbstractCompressionUriHandler.handle(AbstractCompressionUriHandler.java:84) at org.jumpmind.symmetric.web.SymmetricServlet.service(SymmetricServlet.java:98) at javax.servlet.http.HttpServlet.service(HttpServlet.java:820) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:565) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:479) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:119) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:227) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1031) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:406) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:965) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:117) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:111) at org.eclipse.jetty.server.Server.handle(Server.java:348) at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:452) at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:884) at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:938) at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:630) at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:230) at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:77) at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:606) at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:46) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:603) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:538) at java.lang.Thread.run(Thread.java:662) 2014-07-16 15:49:27,842 ERROR [corp-000] [DataExtractorService] [qtp14372770-20] Failed to extract batch 001-20 org.jumpmind.symmetric.SymmetricException: The extracted row data did not have the expected (2) number of columns: "11000001","Yummy Gum" at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1598) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1576) at org.jumpmind.db.sql.JdbcSqlReadCursor.next(JdbcSqlReadCursor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.selectNext(DataExtractorService.java:1550) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.next(DataExtractorService.java:1501) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromSymDataSource.next(DataExtractorService.java:1358) at org.jumpmind.symmetric.io.data.reader.ExtractDataReader.nextTable(ExtractDataReader.java:99) at org.jumpmind.symmetric.io.data.DataProcessor.forEachTableInBatch(DataProcessor.java:160) at org.jumpmind.symmetric.io.data.DataProcessor.process(DataProcessor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService.extractOutgoingBatch(DataExtractorService.java:703) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:513) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:422) at org.jumpmind.symmetric.web.PullUriHandler.pull(PullUriHandler.java:117) at org.jumpmind.symmetric.web.PullUriHandler.handleWithCompression(PullUriHandler.java:89) at org.jumpmind.symmetric.web.AbstractCompressionUriHandler.handle(AbstractCompressionUriHandler.java:84) at org.jumpmind.symmetric.web.SymmetricServlet.service(SymmetricServlet.java:98) at javax.servlet.http.HttpServlet.service(HttpServlet.java:820) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:565) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:479) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:119) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:227) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1031) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:406) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:965) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:117) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:111) at org.eclipse.jetty.server.Server.handle(Server.java:348) at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:452) at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:884) at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:938) at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:630) at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:230) at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:77) at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:606) at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:46) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:603) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:538) at java.lang.Thread.run(Thread.java:662) 2014-07-16 15:49:37,844 ERROR [corp-000] [DataExtractorService] [qtp14372770-20] Failed to extract batch 001-20 org.jumpmind.symmetric.SymmetricException: The extracted row data did not have the expected (2) number of columns: "11000001","Yummy Gum" at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1598) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1576) at org.jumpmind.db.sql.JdbcSqlReadCursor.next(JdbcSqlReadCursor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.selectNext(DataExtractorService.java:1550) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.next(DataExtractorService.java:1501) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromSymDataSource.next(DataExtractorService.java:1358) at org.jumpmind.symmetric.io.data.reader.ExtractDataReader.nextTable(ExtractDataReader.java:99) at org.jumpmind.symmetric.io.data.DataProcessor.forEachTableInBatch(DataProcessor.java:160) at org.jumpmind.symmetric.io.data.DataProcessor.process(DataProcessor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService.extractOutgoingBatch(DataExtractorService.java:703) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:513) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:422) at org.jumpmind.symmetric.web.PullUriHandler.pull(PullUriHandler.java:117) at org.jumpmind.symmetric.web.PullUriHandler.handleWithCompression(PullUriHandler.java:89) at org.jumpmind.symmetric.web.AbstractCompressionUriHandler.handle(AbstractCompressionUriHandler.java:84) at org.jumpmind.symmetric.web.SymmetricServlet.service(SymmetricServlet.java:98) at javax.servlet.http.HttpServlet.service(HttpServlet.java:820) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:565) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:479) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:119) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:227) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1031) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:406) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:965) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:117) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:111) at org.eclipse.jetty.server.Server.handle(Server.java:348) at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:452) at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:884) at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:938) at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:630) at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:230) at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:77) at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:606) at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:46) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:603) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:538) at java.lang.Thread.run(Thread.java:662) 2014-07-16 15:49:47,850 ERROR [corp-000] [DataExtractorService] [qtp14372770-20] Failed to extract batch 001-20 org.jumpmind.symmetric.SymmetricException: The extracted row data did not have the expected (2) number of columns: "11000001","Yummy Gum" at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1598) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1576) at org.jumpmind.db.sql.JdbcSqlReadCursor.next(JdbcSqlReadCursor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.selectNext(DataExtractorService.java:1550) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.next(DataExtractorService.java:1501) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromSymDataSource.next(DataExtractorService.java:1358) at org.jumpmind.symmetric.io.data.reader.ExtractDataReader.nextTable(ExtractDataReader.java:99) at org.jumpmind.symmetric.io.data.DataProcessor.forEachTableInBatch(DataProcessor.java:160) at org.jumpmind.symmetric.io.data.DataProcessor.process(DataProcessor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService.extractOutgoingBatch(DataExtractorService.java:703) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:513) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:422) at org.jumpmind.symmetric.web.PullUriHandler.pull(PullUriHandler.java:117) at org.jumpmind.symmetric.web.PullUriHandler.handleWithCompression(PullUriHandler.java:89) at org.jumpmind.symmetric.web.AbstractCompressionUriHandler.handle(AbstractCompressionUriHandler.java:84) at org.jumpmind.symmetric.web.SymmetricServlet.service(SymmetricServlet.java:98) at javax.servlet.http.HttpServlet.service(HttpServlet.java:820) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:565) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:479) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:119) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:227) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1031) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:406) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:965) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:117) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:111) at org.eclipse.jetty.server.Server.handle(Server.java:348) at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:452) at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:884) at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:938) at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:630) at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:230) at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:77) at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:606) at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:46) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:603) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:538) at java.lang.Thread.run(Thread.java:662) 2014-07-16 15:49:57,855 ERROR [corp-000] [DataExtractorService] [qtp14372770-20] Failed to extract batch 001-20 org.jumpmind.symmetric.SymmetricException: The extracted row data did not have the expected (2) number of columns: "11000001","Yummy Gum" at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1598) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource$1.mapRow(DataExtractorService.java:1576) at org.jumpmind.db.sql.JdbcSqlReadCursor.next(JdbcSqlReadCursor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.selectNext(DataExtractorService.java:1550) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromTableSource.next(DataExtractorService.java:1501) at org.jumpmind.symmetric.service.impl.DataExtractorService$SelectFromSymDataSource.next(DataExtractorService.java:1358) at org.jumpmind.symmetric.io.data.reader.ExtractDataReader.nextTable(ExtractDataReader.java:99) at org.jumpmind.symmetric.io.data.DataProcessor.forEachTableInBatch(DataProcessor.java:160) at org.jumpmind.symmetric.io.data.DataProcessor.process(DataProcessor.java:115) at org.jumpmind.symmetric.service.impl.DataExtractorService.extractOutgoingBatch(DataExtractorService.java:703) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:513) at org.jumpmind.symmetric.service.impl.DataExtractorService.extract(DataExtractorService.java:422) at org.jumpmind.symmetric.web.PullUriHandler.pull(PullUriHandler.java:117) at org.jumpmind.symmetric.web.PullUriHandler.handleWithCompression(PullUriHandler.java:89) at org.jumpmind.symmetric.web.AbstractCompressionUriHandler.handle(AbstractCompressionUriHandler.java:84) at org.jumpmind.symmetric.web.SymmetricServlet.service(SymmetricServlet.java:98) at javax.servlet.http.HttpServlet.service(HttpServlet.java:820) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:565) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:479) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:119) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:227) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1031) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:406) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:186) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:965) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:117) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:111) at org.eclipse.jetty.server.Server.handle(Server.java:348) at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:452) at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:884) at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:938) at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:630) at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:230) at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:77) at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:606) at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:46) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:603) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:538) at java.lang.Thread.run(Thread.java:662)