-
Sub-task
-
Resolution: Done
-
Major
-
None
-
None
See https://travis-ci.org/github/debezium/debezium/jobs/723384407
[ERROR] Failures:
[ERROR] DatatypesFromSnapshotIT>AbstractSqlServerDatatypesTest.stringTypes:244 expecting actual value not to be null
2020-09-02 10:02:06,158 INFO CaseSensitivenessIT||test Starting test io.debezium.connector.sqlserver.DatatypesFromSnapshotIT#stringTypes [io.debezium.connector.sqlserver.DatatypesFromSnapshotIT] 2020-09-02 10:02:06,160 INFO DatatypesFromSnapshotIT||test Worker configuration property 'internal.key.converter' is deprecated and may be removed in an upcoming release. The specified value 'org.apache.kafka.connect.json.JsonConverter' matches the default, so this property can be safely removed from the worker configuration. [org.apache.kafka.connect.runtime.WorkerConfig] 2020-09-02 10:02:06,160 INFO DatatypesFromSnapshotIT||test Worker configuration property 'internal.value.converter' is deprecated and may be removed in an upcoming release. The specified value 'org.apache.kafka.connect.json.JsonConverter' matches the default, so this property can be safely removed from the worker configuration. [org.apache.kafka.connect.runtime.WorkerConfig] 2020-09-02 10:02:06,164 WARN DatatypesFromSnapshotIT||test Variables cannot be used in the 'plugin.path' property, since the property is used by plugin scanning before the config providers that replace the variables are initialized. The raw value 'null' was used for plugin scanning, as opposed to the transformed value 'null', and this may cause unexpected results. [org.apache.kafka.connect.runtime.WorkerConfig] 2020-09-02 10:02:06,165 INFO DatatypesFromSnapshotIT||engine Starting FileOffsetBackingStore with file /home/travis/build/debezium/debezium/debezium-connector-sqlserver/target/data/file-connector-offsets.txt [org.apache.kafka.connect.storage.FileOffsetBackingStore] 2020-09-02 10:02:06,166 WARN DatatypesFromSnapshotIT||engine Using configuration property "column.whitelist" is deprecated and will be removed in future versions. Please use "column.include.list" instead. [io.debezium.config.Configuration] 2020-09-02 10:02:06,166 WARN DatatypesFromSnapshotIT||engine Using configuration property "column.blacklist" is deprecated and will be removed in future versions. Please use "column.exclude.list" instead. [io.debezium.config.Configuration] 2020-09-02 10:02:06,166 WARN DatatypesFromSnapshotIT||engine Using configuration property "column.whitelist" is deprecated and will be removed in future versions. Please use "column.include.list" instead. [io.debezium.config.Configuration] 2020-09-02 10:02:06,166 WARN DatatypesFromSnapshotIT||engine Using configuration property "column.blacklist" is deprecated and will be removed in future versions. Please use "column.exclude.list" instead. [io.debezium.config.Configuration] 2020-09-02 10:02:06,166 WARN DatatypesFromSnapshotIT||engine Using configuration property "table.whitelist" is deprecated and will be removed in future versions. Please use "table.include.list" instead. [io.debezium.config.Configuration] 2020-09-02 10:02:06,166 WARN DatatypesFromSnapshotIT||engine Using configuration property "table.blacklist" is deprecated and will be removed in future versions. Please use "table.exclude.list" instead. [io.debezium.config.Configuration] 2020-09-02 10:02:06,166 WARN DatatypesFromSnapshotIT||engine Using configuration property "table.whitelist" is deprecated and will be removed in future versions. Please use "table.include.list" instead. [io.debezium.config.Configuration] 2020-09-02 10:02:06,166 WARN DatatypesFromSnapshotIT||engine Using configuration property "table.blacklist" is deprecated and will be removed in future versions. Please use "table.exclude.list" instead. [io.debezium.config.Configuration] 2020-09-02 10:02:06,166 INFO DatatypesFromSnapshotIT||engine Starting SqlServerConnectorTask with configuration: [io.debezium.connector.common.BaseSourceTask] 2020-09-02 10:02:06,166 INFO DatatypesFromSnapshotIT||engine connector.class = io.debezium.connector.sqlserver.SqlServerConnector [io.debezium.connector.common.BaseSourceTask] 2020-09-02 10:02:06,166 INFO DatatypesFromSnapshotIT||engine database.history.file.filename = /home/travis/build/debezium/debezium/debezium-connector-sqlserver/target/data/file-db-history-connect.txt [io.debezium.connector.common.BaseSourceTask] 2020-09-02 10:02:06,166 INFO DatatypesFromSnapshotIT||engine database.user = sa [io.debezium.connector.common.BaseSourceTask] 2020-09-02 10:02:06,166 INFO DatatypesFromSnapshotIT||engine database.dbname = testdb [io.debezium.connector.common.BaseSourceTask] 2020-09-02 10:02:06,166 INFO DatatypesFromSnapshotIT||engine time.precision.mode = adaptive [io.debezium.connector.common.BaseSourceTask] 2020-09-02 10:02:06,166 INFO DatatypesFromSnapshotIT||engine database.server.name = server1 [io.debezium.connector.common.BaseSourceTask] 2020-09-02 10:02:06,166 INFO DatatypesFromSnapshotIT||engine include.schema.changes = false [io.debezium.connector.common.BaseSourceTask] 2020-09-02 10:02:06,166 INFO DatatypesFromSnapshotIT||engine database.port = 1433 [io.debezium.connector.common.BaseSourceTask] 2020-09-02 10:02:06,166 INFO DatatypesFromSnapshotIT||engine offset.flush.interval.ms = 0 [io.debezium.connector.common.BaseSourceTask] 2020-09-02 10:02:06,166 INFO DatatypesFromSnapshotIT||engine offset.storage.file.filename = /home/travis/build/debezium/debezium/debezium-connector-sqlserver/target/data/file-connector-offsets.txt [io.debezium.connector.common.BaseSourceTask] 2020-09-02 10:02:06,166 INFO DatatypesFromSnapshotIT||engine database.hostname = localhost [io.debezium.connector.common.BaseSourceTask] 2020-09-02 10:02:06,166 INFO DatatypesFromSnapshotIT||engine database.password = ******** [io.debezium.connector.common.BaseSourceTask] 2020-09-02 10:02:06,166 INFO DatatypesFromSnapshotIT||engine name = testing-connector [io.debezium.connector.common.BaseSourceTask] 2020-09-02 10:02:06,166 INFO DatatypesFromSnapshotIT||engine snapshot.mode = initial [io.debezium.connector.common.BaseSourceTask] 2020-09-02 10:02:06,166 INFO DatatypesFromSnapshotIT||engine database.history = io.debezium.relational.history.FileDatabaseHistory [io.debezium.connector.common.BaseSourceTask] 2020-09-02 10:02:06,167 WARN DatatypesFromSnapshotIT||engine Using configuration property "schema.whitelist" is deprecated and will be removed in future versions. Please use "schema.include.list" instead. [io.debezium.config.Configuration] 2020-09-02 10:02:06,167 WARN DatatypesFromSnapshotIT||engine Using configuration property "schema.blacklist" is deprecated and will be removed in future versions. Please use "schema.exclude.list" instead. [io.debezium.config.Configuration] 2020-09-02 10:02:06,167 WARN DatatypesFromSnapshotIT||engine Using configuration property "table.whitelist" is deprecated and will be removed in future versions. Please use "table.include.list" instead. [io.debezium.config.Configuration] 2020-09-02 10:02:06,167 WARN DatatypesFromSnapshotIT||engine Using configuration property "table.blacklist" is deprecated and will be removed in future versions. Please use "table.exclude.list" instead. [io.debezium.config.Configuration] 2020-09-02 10:02:06,167 WARN DatatypesFromSnapshotIT||engine Using configuration property "column.blacklist" is deprecated and will be removed in future versions. Please use "column.exclude.list" instead. [io.debezium.config.Configuration] 2020-09-02 10:02:06,249 WARN DatatypesFromSnapshotIT||engine Unable to register the MBean 'debezium.sql_server:type=connector-metrics,context=schema-history,server=server1': debezium.sql_server:type=connector-metrics,context=schema-history,server=server1 [io.debezium.relational.history.DatabaseHistoryMetrics] 2020-09-02 10:02:06,253 INFO DatatypesFromSnapshotIT||engine Requested thread factory for connector SqlServerConnector, id = server1 named = change-event-source-coordinator [io.debezium.util.Threads] 2020-09-02 10:02:06,255 INFO DatatypesFromSnapshotIT||engine Creating thread debezium-sqlserverconnector-server1-change-event-source-coordinator [io.debezium.util.Threads] 2020-09-02 10:02:06,263 INFO DatatypesFromSnapshotIT||engine Metrics registered [io.debezium.pipeline.ChangeEventSourceCoordinator] 2020-09-02 10:02:06,263 INFO DatatypesFromSnapshotIT||engine Context created [io.debezium.pipeline.ChangeEventSourceCoordinator] 2020-09-02 10:02:06,264 INFO DatatypesFromSnapshotIT||engine No previous offset has been found [io.debezium.connector.sqlserver.SqlServerSnapshotChangeEventSource] 2020-09-02 10:02:06,264 INFO DatatypesFromSnapshotIT||engine According to the connector configuration both schema and data will be snapshotted [io.debezium.connector.sqlserver.SqlServerSnapshotChangeEventSource] 2020-09-02 10:02:06,264 INFO DatatypesFromSnapshotIT||engine Snapshot step 1 - Preparing [io.debezium.relational.RelationalSnapshotChangeEventSource] 2020-09-02 10:02:06,265 INFO DatatypesFromSnapshotIT||engine Snapshot step 2 - Determining captured tables [io.debezium.relational.RelationalSnapshotChangeEventSource] 2020-09-02 10:02:06,373 WARN DatatypesFromSnapshotIT||engine Using configuration property "table.whitelist" is deprecated and will be removed in future versions. Please use "table.include.list" instead. [io.debezium.config.Configuration] 2020-09-02 10:02:06,373 INFO DatatypesFromSnapshotIT||engine Snapshot step 3 - Locking captured tables [io.debezium.relational.RelationalSnapshotChangeEventSource] 2020-09-02 10:02:06,373 INFO DatatypesFromSnapshotIT||engine Setting locking timeout to 10 s [io.debezium.connector.sqlserver.SqlServerSnapshotChangeEventSource] 2020-09-02 10:02:06,375 INFO DatatypesFromSnapshotIT||engine Executing schema locking [io.debezium.connector.sqlserver.SqlServerSnapshotChangeEventSource] 2020-09-02 10:02:06,375 INFO DatatypesFromSnapshotIT||engine Locking table testDB.dbo.type_fp [io.debezium.connector.sqlserver.SqlServerSnapshotChangeEventSource] 2020-09-02 10:02:06,376 INFO DatatypesFromSnapshotIT||engine Locking table testDB.dbo.type_int [io.debezium.connector.sqlserver.SqlServerSnapshotChangeEventSource] 2020-09-02 10:02:06,380 INFO DatatypesFromSnapshotIT||engine Locking table testDB.dbo.type_string [io.debezium.connector.sqlserver.SqlServerSnapshotChangeEventSource] 2020-09-02 10:02:06,381 INFO DatatypesFromSnapshotIT||engine Locking table testDB.dbo.type_time [io.debezium.connector.sqlserver.SqlServerSnapshotChangeEventSource] 2020-09-02 10:02:06,382 INFO DatatypesFromSnapshotIT||engine Locking table testDB.dbo.type_xml [io.debezium.connector.sqlserver.SqlServerSnapshotChangeEventSource] 2020-09-02 10:02:06,383 INFO DatatypesFromSnapshotIT||engine Snapshot step 4 - Determining snapshot offset [io.debezium.relational.RelationalSnapshotChangeEventSource] Inserted 2020-09-02 10:02:08,572 INFO DatatypesFromSnapshotIT||engine Snapshot - Final stage [io.debezium.pipeline.source.AbstractSnapshotChangeEventSource] 2020-09-02 10:02:08,573 INFO DatatypesFromSnapshotIT||engine Removing locking timeout [io.debezium.connector.sqlserver.SqlServerSnapshotChangeEventSource] 2020-09-02 10:02:08,574 ERROR DatatypesFromSnapshotIT||engine Producer failure [io.debezium.pipeline.ErrorHandler] java.lang.RuntimeException: com.microsoft.sqlserver.jdbc.SQLServerException: Transaction (Process ID 51) was deadlocked on lock resources with another process and has been chosen as the deadlock victim. Rerun the transaction. at io.debezium.pipeline.source.AbstractSnapshotChangeEventSource.execute(AbstractSnapshotChangeEventSource.java:76) at io.debezium.pipeline.ChangeEventSourceCoordinator.lambda$start$0(ChangeEventSourceCoordinator.java:96) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) Caused by: com.microsoft.sqlserver.jdbc.SQLServerException: Transaction (Process ID 51) was deadlocked on lock resources with another process and has been chosen as the deadlock victim. Rerun the transaction. at com.microsoft.sqlserver.jdbc.SQLServerException.makeFromDatabaseError(SQLServerException.java:262) at com.microsoft.sqlserver.jdbc.SQLServerResultSet$FetchBuffer.nextRow(SQLServerResultSet.java:5427) at com.microsoft.sqlserver.jdbc.SQLServerResultSet.fetchBufferNext(SQLServerResultSet.java:1758) at com.microsoft.sqlserver.jdbc.SQLServerResultSet.next(SQLServerResultSet.java:1016) at io.debezium.jdbc.JdbcConnection.lambda$singleResultMapper$6(JdbcConnection.java:1237) at io.debezium.jdbc.JdbcConnection.queryAndMap(JdbcConnection.java:575) at io.debezium.jdbc.JdbcConnection.queryAndMap(JdbcConnection.java:443) at io.debezium.connector.sqlserver.SqlServerConnection.getMaxLsn(SqlServerConnection.java:129) at io.debezium.connector.sqlserver.SqlServerSnapshotChangeEventSource.determineSnapshotOffset(SqlServerSnapshotChangeEventSource.java:158) at io.debezium.relational.RelationalSnapshotChangeEventSource.doExecute(RelationalSnapshotChangeEventSource.java:120) at io.debezium.pipeline.source.AbstractSnapshotChangeEventSource.execute(AbstractSnapshotChangeEventSource.java:63) ... 6 more 2020-09-02 10:02:08,574 INFO DatatypesFromSnapshotIT||engine Connected metrics set to 'false' [io.debezium.pipeline.metrics.StreamingChangeEventSourceMetrics] 2020-09-02 10:02:08,753 INFO DatatypesFromSnapshotIT||engine Stopping down connector [io.debezium.connector.common.BaseSourceTask] 2020-09-02 10:02:08,754 INFO DatatypesFromSnapshotIT||engine Stopped FileOffsetBackingStore [org.apache.kafka.connect.storage.FileOffsetBackingStore] 2020-09-02 10:02:08,754 ERROR DatatypesFromSnapshotIT||engine Error while trying to run connector class 'io.debezium.connector.sqlserver.SqlServerConnector' [io.debezium.connector.sqlserver.DatatypesFromSnapshotIT] org.apache.kafka.connect.errors.ConnectException: An exception occurred in the change event producer. This connector will be stopped. at io.debezium.pipeline.ErrorHandler.setProducerThrowable(ErrorHandler.java:42) at io.debezium.pipeline.ChangeEventSourceCoordinator.lambda$start$0(ChangeEventSourceCoordinator.java:117) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) Caused by: java.lang.RuntimeException: com.microsoft.sqlserver.jdbc.SQLServerException: Transaction (Process ID 51) was deadlocked on lock resources with another process and has been chosen as the deadlock victim. Rerun the transaction. at io.debezium.pipeline.source.AbstractSnapshotChangeEventSource.execute(AbstractSnapshotChangeEventSource.java:76) at io.debezium.pipeline.ChangeEventSourceCoordinator.lambda$start$0(ChangeEventSourceCoordinator.java:96) ... 5 more Caused by: com.microsoft.sqlserver.jdbc.SQLServerException: Transaction (Process ID 51) was deadlocked on lock resources with another process and has been chosen as the deadlock victim. Rerun the transaction. at com.microsoft.sqlserver.jdbc.SQLServerException.makeFromDatabaseError(SQLServerException.java:262) at com.microsoft.sqlserver.jdbc.SQLServerResultSet$FetchBuffer.nextRow(SQLServerResultSet.java:5427) at com.microsoft.sqlserver.jdbc.SQLServerResultSet.fetchBufferNext(SQLServerResultSet.java:1758) at com.microsoft.sqlserver.jdbc.SQLServerResultSet.next(SQLServerResultSet.java:1016) at io.debezium.jdbc.JdbcConnection.lambda$singleResultMapper$6(JdbcConnection.java:1237) at io.debezium.jdbc.JdbcConnection.queryAndMap(JdbcConnection.java:575) at io.debezium.jdbc.JdbcConnection.queryAndMap(JdbcConnection.java:443) at io.debezium.connector.sqlserver.SqlServerConnection.getMaxLsn(SqlServerConnection.java:129) at io.debezium.connector.sqlserver.SqlServerSnapshotChangeEventSource.determineSnapshotOffset(SqlServerSnapshotChangeEventSource.java:158) at io.debezium.relational.RelationalSnapshotChangeEventSource.doExecute(RelationalSnapshotChangeEventSource.java:120) at io.debezium.pipeline.source.AbstractSnapshotChangeEventSource.execute(AbstractSnapshotChangeEventSource.java:63) ... 6 more Stopped connector 2020-09-02 10:02:22,264 INFO DatatypesFromSnapshotIT||test Stopping the connector [io.debezium.connector.sqlserver.DatatypesFromSnapshotIT] 2020-09-02 10:02:22,264 INFO DatatypesFromSnapshotIT||test Interrupting the engine [io.debezium.connector.sqlserver.DatatypesFromSnapshotIT] 2020-09-02 10:02:22,265 INFO DatatypesFromSnapshotIT||test Test io.debezium.connector.sqlserver.DatatypesFromSnapshotIT#stringTypes failed [io.debezium.connector.sqlserver.DatatypesFromSnapshotIT]