Phil Mikhailov created KAFKA-7074: ------------------------------------- Summary: Race condition between Kafka log deletion and compaction Key: KAFKA-7074 URL: https://issues.apache.org/jira/browse/KAFKA-7074 Project: Kafka Issue Type: Bug Components: streams Affects Versions: 0.10.2.1 Reporter: Phil Mikhailov
We have one of standard options of deploying Kafka-based EventSourcing microservice - deployment with reset. It includes running {{kafka-reset-tool}} before deploying and running microservice which should reset offsets for input topics and delete intermediate topics to allow microservice rebuild its internal state. We have faced a problem several times (its not 100% reproducible) that {{LogCleaner}} crashed with {{NoSuchFileException}} during compaction routing after such deployment. See detailed log: {code} Cleaning mechanism disable possible compaction: [2018-06-14 18:25:01,464] INFO The cleaning for partition reports-app-ReportsContractExpansionStateStore-changelog-7 is aborted Cleaning happended: [2018-06-14 18:25:56,761] INFO Deleting index /var/lib/kafka/data/reports-app-ReportsContractExpansionStateStore-changelog-7/00000000000000000000.timeindex (kafka.log.TimeIndex) Compaction failed 'cause it can't find file: [2018-06-14 18:25:57,402] ERROR [kafka-log-cleaner-thread-0], Error due to (kafka.log.LogCleaner) kafka.common.KafkaStorageException: Failed to change the timeindex file suffix from to .deleted for log segment 0 at kafka.log.LogSegment.kafkaStorageException$1(LogSegment.scala:340) at kafka.log.LogSegment.changeFileSuffixes(LogSegment.scala:350) at kafka.log.Log.kafka$log$Log$$asyncDeleteSegment(Log.scala:981) at kafka.log.Log$$anonfun$replaceSegments$1.apply(Log.scala:1027) at kafka.log.Log$$anonfun$replaceSegments$1.apply(Log.scala:1022) at scala.collection.immutable.List.foreach(List.scala:381) at kafka.log.Log.replaceSegments(Log.scala:1022) at kafka.log.Cleaner.cleanSegments(LogCleaner.scala:426) at kafka.log.Cleaner$$anonfun$clean$4.apply(LogCleaner.scala:363) at kafka.log.Cleaner$$anonfun$clean$4.apply(LogCleaner.scala:362) at scala.collection.immutable.List.foreach(List.scala:381) at kafka.log.Cleaner.clean(LogCleaner.scala:362) at kafka.log.LogCleaner$CleanerThread.cleanOrSleep(LogCleaner.scala:241) at kafka.log.LogCleaner$CleanerThread.doWork(LogCleaner.scala:220) at kafka.utils.ShutdownableThread.run(ShutdownableThread.scala:63) Caused by: java.nio.file.NoSuchFileException: /var/lib/kafka/data/reports-app-ReportsContractExpansionStateStore-changelog-7/00000000000000000000.timeindex at sun.nio.fs.UnixException.translateToIOException(UnixException.java:86) at sun.nio.fs.UnixException.rethrowAsIOException(UnixException.java:102) at sun.nio.fs.UnixException.rethrowAsIOException(UnixException.java:107) at sun.nio.fs.UnixCopyFile.move(UnixCopyFile.java:409) at sun.nio.fs.UnixFileSystemProvider.move(UnixFileSystemProvider.java:262) at java.nio.file.Files.move(Files.java:1395) at org.apache.kafka.common.utils.Utils.atomicMoveWithFallback(Utils.java:711) at kafka.log.AbstractIndex.renameTo(AbstractIndex.scala:126) ... 14 more Suppressed: java.nio.file.NoSuchFileException: /var/lib/kafka/data/reports-app-ReportsContractExpansionStateStore-changelog-7/00000000000000000000.timeindex -> /var/lib/kafka/data/reports-app-ReportsContractExpansionStateStore-changelog-7/00000000000000000000.timeindex.deleted at sun.nio.fs.UnixException.translateToIOException(UnixException.java:86) at sun.nio.fs.UnixException.rethrowAsIOException(UnixException.java:102) at sun.nio.fs.UnixCopyFile.move(UnixCopyFile.java:396) at sun.nio.fs.UnixFileSystemProvider.move(UnixFileSystemProvider.java:262) at java.nio.file.Files.move(Files.java:1395) at org.apache.kafka.common.utils.Utils.atomicMoveWithFallback(Utils.java:708) ... 15 more {code} It looks like that disabling compaction while deleting log doesn't work. -- This message was sent by Atlassian JIRA (v7.6.3#76005)