Uploaded image for project: 'Debezium'
  1. Debezium
  2. DBZ-7543

BlockingSnapshotIT#executeBlockingSnapshotWhileStreaming fails randomly

XMLWordPrintable

    • False
    • None
    • False

      BlockingSnapshotIT#executeBlockingSnapshotWhileStreaming fails (e.g. here) with

      2024-02-21T12:46:50.5457539Z [ERROR] io.debezium.connector.informix.BlockingSnapshotIT.executeBlockingSnapshotWhileStreaming -- Time elapsed: 20.00 s <<< ERROR!
      2024-02-21T12:46:50.5459143Z java.util.concurrent.ExecutionException: java.lang.RuntimeException: java.lang.RuntimeException: java.sql.SQLException: Could not insert new row into the table.
      2024-02-21T12:46:50.5460321Z    at java.base/java.util.concurrent.FutureTask.report(FutureTask.java:122)
      2024-02-21T12:46:50.5461264Z    at java.base/java.util.concurrent.FutureTask.get(FutureTask.java:205)
      2024-02-21T12:46:50.5463234Z    at io.debezium.pipeline.AbstractBlockingSnapshotTest.executeBlockingSnapshotWhileStreaming(AbstractBlockingSnapshotTest.java:120)
      2024-02-21T12:46:50.5465148Z    at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
      2024-02-21T12:46:50.5466636Z    at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77)
      2024-02-21T12:46:50.5468695Z    at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
      2024-02-21T12:46:50.5470230Z    at java.base/java.lang.reflect.Method.invoke(Method.java:568)
      2024-02-21T12:46:50.5471505Z    at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:59)
      2024-02-21T12:46:50.5473418Z    at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
      2024-02-21T12:46:50.5474970Z    at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:56)
      2024-02-21T12:46:50.5476530Z    at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
      2024-02-21T12:46:50.5478101Z    at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
      2024-02-21T12:46:50.5479537Z    at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27)
      2024-02-21T12:46:50.5480883Z    at org.junit.rules.TestWatcher$1.evaluate(TestWatcher.java:61)
      2024-02-21T12:46:50.5481946Z    at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
      2024-02-21T12:46:50.5483531Z    at org.junit.runners.BlockJUnit4ClassRunner$1.evaluate(BlockJUnit4ClassRunner.java:100)
      2024-02-21T12:46:50.5484947Z    at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:366)
      2024-02-21T12:46:50.5486272Z    at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:103)
      2024-02-21T12:46:50.5487801Z    at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:63)
      2024-02-21T12:46:50.5489158Z    at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
      2024-02-21T12:46:50.5490204Z    at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
      2024-02-21T12:46:50.5491388Z    at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
      2024-02-21T12:46:50.5492636Z    at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
      2024-02-21T12:46:50.5493795Z    at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
      2024-02-21T12:46:50.5494930Z    at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
      2024-02-21T12:46:50.5496108Z    at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
      2024-02-21T12:46:50.5497352Z    at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:316)
      2024-02-21T12:46:50.5498943Z    at org.apache.maven.surefire.junit4.JUnit4Provider.executeWithRerun(JUnit4Provider.java:240)
      2024-02-21T12:46:50.5500715Z    at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:214)
      2024-02-21T12:46:50.5502271Z    at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:155)
      2024-02-21T12:46:50.5503951Z    at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:385)
      2024-02-21T12:46:50.5505576Z    at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:162)
      2024-02-21T12:46:50.5507198Z    at org.apache.maven.surefire.booter.ForkedBooter.run(ForkedBooter.java:507)
      2024-02-21T12:46:50.5508589Z    at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:495)
      2024-02-21T12:46:50.5510190Z Caused by: java.lang.RuntimeException: java.lang.RuntimeException: java.sql.SQLException: Could not insert new row into the table.
      2024-02-21T12:46:50.5511424Z    at io.debezium.pipeline.AbstractBlockingSnapshotTest.lambda$insertTask$5(AbstractBlockingSnapshotTest.java:205)
      2024-02-21T12:46:50.5512833Z    at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:539)
      2024-02-21T12:46:50.5513843Z    at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
      2024-02-21T12:46:50.5514878Z    at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136)
      2024-02-21T12:46:50.5516245Z    at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)
      2024-02-21T12:46:50.5517022Z    at java.base/java.lang.Thread.run(Thread.java:840)
      2024-02-21T12:46:50.5518012Z Caused by: java.lang.RuntimeException: java.sql.SQLException: Could not insert new row into the table.
      2024-02-21T12:46:50.5519514Z    at io.debezium.pipeline.AbstractBlockingSnapshotTest.insertRecordsWithRandomSleep(AbstractBlockingSnapshotTest.java:304)
      2024-02-21T12:46:50.5521445Z    at io.debezium.pipeline.AbstractBlockingSnapshotTest.insertRecordsWithRandomSleep(AbstractBlockingSnapshotTest.java:310)
      2024-02-21T12:46:50.5523540Z    at io.debezium.pipeline.AbstractBlockingSnapshotTest.lambda$insertTask$5(AbstractBlockingSnapshotTest.java:202)
      2024-02-21T12:46:50.5524857Z    ... 5 more
      2024-02-21T12:46:50.5525474Z Caused by: java.sql.SQLException: Could not insert new row into the table.
      2024-02-21T12:46:50.5526695Z    at com.informix.util.IfxErrMsg.buildExceptionWithMessage(IfxErrMsg.java:421)
      2024-02-21T12:46:50.5527573Z    at com.informix.util.IfxErrMsg.buildIsamException(IfxErrMsg.java:400)
      2024-02-21T12:46:50.5528640Z    at com.informix.jdbc.IfxSqli.addException(IfxSqli.java:3023)
      2024-02-21T12:46:50.5529891Z    at com.informix.jdbc.IfxSqli.receiveError(IfxSqli.java:3274)
      2024-02-21T12:46:50.5530957Z    at com.informix.jdbc.IfxSqli.dispatchMsg(IfxSqli.java:2269)
      2024-02-21T12:46:50.5532261Z    at com.informix.jdbc.IfxSqli.receiveMessage(IfxSqli.java:2194)
      2024-02-21T12:46:50.5533414Z    at com.informix.jdbc.IfxSqli.sendStatementExecute(IfxSqli.java:1282)
      2024-02-21T12:46:50.5534460Z    at com.informix.jdbc.IfxSqli.executeExecute(IfxSqli.java:2122)
      2024-02-21T12:46:50.5535710Z    at com.informix.jdbc.IfxResultSet.executeExecute(IfxResultSet.java:302)
      2024-02-21T12:46:50.5537134Z    at com.informix.jdbc.IfxStatement.executeImpl(IfxStatement.java:1017)
      2024-02-21T12:46:50.5538320Z    at com.informix.jdbc.IfxStatement.executeImpl(IfxStatement.java:997)
      2024-02-21T12:46:50.5539540Z    at com.informix.jdbc.IfxStatement.executeBody(IfxStatement.java:745)
      2024-02-21T12:46:50.5540940Z    at com.informix.jdbc.IfxStatement.execute(IfxStatement.java:687)
      2024-02-21T12:46:50.5542156Z    at io.debezium.jdbc.JdbcConnection.lambda$execute$3(JdbcConnection.java:417)
      2024-02-21T12:46:50.5543365Z    at io.debezium.jdbc.JdbcConnection.execute(JdbcConnection.java:434)
      2024-02-21T12:46:50.5544746Z    at io.debezium.jdbc.JdbcConnection.execute(JdbcConnection.java:411)
      2024-02-21T12:46:50.5546614Z    at io.debezium.pipeline.AbstractBlockingSnapshotTest.insertRecordsWithRandomSleep(AbstractBlockingSnapshotTest.java:293)
      2024-02-21T12:46:50.5548186Z    ... 7 more
      2024-02-21T12:46:50.5548889Z Caused by: java.sql.SQLException: ISAM error:  the file is locked.
      2024-02-21T12:46:50.5550162Z    at com.informix.util.IfxErrMsg.buildExceptionWithMessage(IfxErrMsg.java:421)
      2024-02-21T12:46:50.5551542Z    at com.informix.util.IfxErrMsg.buildException(IfxErrMsg.java:396)
      2024-02-21T12:46:50.5552780Z    at com.informix.util.IfxErrMsg.getSQLException(IfxErrMsg.java:370)
      2024-02-21T12:46:50.5553503Z    at com.informix.jdbc.IfxSqli.receiveError(IfxSqli.java:3278)
      2024-02-21T12:46:50.5554138Z    ... 20 more
      2024-02-21T12:46:50.5554311Z
      

      Full test log is attached.

            Unassigned Unassigned
            vjuranek@redhat.com Vojtech Juranek
            Votes:
            0 Vote for this issue
            Watchers:
            1 Start watching this issue

              Created:
              Updated: