Uploaded image for project: 'Debezium'
  1. Debezium
  2. DBZ-2232 Intermittent test failures on CI
  3. DBZ-2221

Binary log client is not cleanly stopped in testsuite

XMLWordPrintable

    • Icon: Sub-task Sub-task
    • Resolution: Done
    • Icon: Critical Critical
    • 1.2.0.Final
    • 1.2.0.CR1
    • mysql-connector
    • None

      The testsuite frequently fails with errors like

      ERROR] Tests run: 7, Failures: 0, Errors: 1, Skipped: 0, Time elapsed: 21.701 s <<< FAILURE! - in io.debezium.connector.mysql.MySqlConnectorRegressionIT
      [ERROR] shouldConsumeAllEventsFromDecimalTableInDatabaseUsingBinlogAndNoSnapshot(io.debezium.connector.mysql.MySqlConnectorRegressionIT)  Time elapsed: 15.927 s  <<< ERROR!
      java.lang.NullPointerException
      	at io.debezium.connector.mysql.MySqlConnectorRegressionIT.shouldConsumeAllEventsFromDecimalTableInDatabaseUsingBinlogAndNoSnapshot(MySqlConnectorRegressionIT.java:948)
      

      The probale root cause are unfinished binary log clients from previous tests, see for example

      020-06-18 03:57:06,896 ERROR  MySqlConnectorRegressionIT||engine  Error while trying to run connector class 'io.debezium.connector.mysql.MySqlConnector'   [io.debezium.connector.mysql.MySqlConnectorRegressionIT]
      org.apache.kafka.connect.errors.ConnectException: A slave with the same server_uuid/server_id as this slave has connected to the master; the first event '' at 4, the last event read from './mysql-bin.000003' at 844519, the last byte read from './mysql-bin.000003' at 844519. Error code: 1236; SQLSTATE: HY000.
      	at io.debezium.connector.mysql.AbstractReader.wrap(AbstractReader.java:230)
      	at io.debezium.connector.mysql.AbstractReader.failed(AbstractReader.java:196)
      	at io.debezium.connector.mysql.BinlogReader$ReaderThreadLifecycleListener.onCommunicationFailure(BinlogReader.java:1100)
      	at com.github.shyiko.mysql.binlog.BinaryLogClient.listenForEventPackets(BinaryLogClient.java:985)
      	at com.github.shyiko.mysql.binlog.BinaryLogClient.connect(BinaryLogClient.java:581)
      	at com.github.shyiko.mysql.binlog.BinaryLogClient$7.run(BinaryLogClient.java:860)
      	at java.lang.Thread.run(Thread.java:748)
      Caused by: com.github.shyiko.mysql.binlog.network.ServerException: A slave with the same server_uuid/server_id as this slave has connected to the master; the first event '' at 4, the last event read from './mysql-bin.000003' at 844519, the last byte read from './mysql-bin.000003' at 844519.
      	at com.github.shyiko.mysql.binlog.BinaryLogClient.listenForEventPackets(BinaryLogClient.java:949)
      	... 3 more
      2020-06-18 03:57:22,322 WARN   MySQL|regression|task  After applying blacklist/whitelist filters there are no tables to monitor, please check your configuration   [io.debezium.relational.RelationalDatabaseSchema]
      Jun 18, 2020 3:57:22 AM com.github.shyiko.mysql.binlog.BinaryLogClient connect
      WARNING: Binary log position adjusted from 0 to 4
      Jun 18, 2020 3:57:22 AM com.github.shyiko.mysql.binlog.BinaryLogClient connect
      INFO: Connected to localhost:4302 at /4 (sid:18765, cid:372)
      

              jpechane Jiri Pechanec
              jpechane Jiri Pechanec
              Votes:
              0 Vote for this issue
              Watchers:
              1 Start watching this issue

                Created:
                Updated:
                Resolved: