Skip to content

Append callback error: The memory mapped buffer for log of test-topic-0000000-0150-106 is already closed #534

@Chillax-0v0

Description

@Chillax-0v0

server.log:

[ec2-user@i-03a72abb12e71394a automq]$ less logs/server.log | grep test-topic-0000000-0150-106
[2023-12-11 08:32:13,806] INFO [ReplicaFetcherManager on broker 2] Removed fetcher for partitions Set(test-topic-0000000-0150-106) (kafka.server.ReplicaFetcherManager)
[2023-12-11 08:32:17,349] INFO [ElasticLog partition=test-topic-0000000-0150-106 epoch=2] opened existing meta stream: stream_id=353 (kafka.log.streamaspect.ElasticLog$)
[2023-12-11 08:32:17,523] INFO [ElasticLog partition=test-topic-0000000-0150-106 epoch=2] loaded partition meta: ElasticPartitionMeta{startOffset=0, cleanerOffset=0, recoverOffset=7244, cleanedShutdown=true} (kafka.log.streamaspect.ElasticLog$)
[2023-12-11 08:32:17,523] INFO [ElasticLog partition=test-topic-0000000-0150-106 epoch=2] loaded 1 producer snapshots, offsets(filenames) are Set(7244)  (kafka.log.streamaspect.ElasticLog$)
[2023-12-11 08:32:17,560] INFO [ElasticProducerStateManager partition=test-topic-0000000-0150-106] Loading producer state from snapshot file 'SnapshotFile(7244.snapshot,7244)' (kafka.log.streamaspect.ElasticProducerStateManager)
[2023-12-11 08:32:17,581] INFO [ElasticLogLoader partition=test-topic-0000000-0150-106, dir=/data/kafka/kraft-broker-logs] Producer state recovery took 22ms for snapshot load and 0ms for segment recovery from offset 7244 (kafka.log.streamaspect.ElasticUnifiedLog$)
[2023-12-11 08:32:17,581] INFO [ElasticLog partition=test-topic-0000000-0150-106 epoch=2] loaded log meta: ElasticLogMeta{streamMap={log=414, tim=461, txn=-1}, lastNthSegmentMetas=[ElasticStreamSegmentMeta{baseOffset=0, createTimestamp=1702283488521, lastModifiedTimestamp=1702283527281, streamSuffix='', logSize=29781394, log=[0, -1], time=[0, -1], txn=[0, -1], firstBatchTimestamp=1702283494681, timeIndexLastEntry=TimestampOffsetData{timestamp=1702283517186, offset=5102}}]} (kafka.log.streamaspect.ElasticLog$)
[2023-12-11 08:32:17,581] INFO [ElasticLog partition=test-topic-0000000-0150-106 epoch=2] loaded leader epoch checkpoint with 1 entries (kafka.log.streamaspect.ElasticLog$)
[2023-12-11 08:32:17,581] INFO [ElasticLog partition=test-topic-0000000-0150-106 epoch=2] last leaderEpoch entry is: EpochEntry(epoch=0, startOffset=0) (kafka.log.streamaspect.ElasticLog$)
[2023-12-11 08:32:17,645] INFO [ElasticLog partition=test-topic-0000000-0150-106 epoch=2] [ElasticLog partition=test-topic-0000000-0150-106 epoch=2] save partition meta ElasticPartitionMeta{startOffset=0, cleanerOffset=0, recoverOffset=7244, cleanedShutdown=false} (kafka.log.streamaspect.ElasticLog)
[2023-12-11 08:32:17,647] INFO ElasticUnifiedLog test-topic-0000000-0150-106 opened time cost: 3821 ms (kafka.log.UnifiedLog$)
[2023-12-11 08:32:17,647] INFO Created log for partition test-topic-0000000-0150-106 in /data/kafka/kraft-broker-logs/test-topic-0000000-0150-106 with properties {elasticstream.replication.factor=3, flush.messages=1, min.insync.replicas=1, retention.ms=86400000}, cost=3828ms (kafka.log.LogManager)
[2023-12-11 08:32:17,647] INFO [Partition test-topic-0000000-0150-106 broker=2] Log loaded for partition test-topic-0000000-0150-106 with initial high watermark 7244 (kafka.cluster.Partition)
[2023-12-11 08:32:17,672] INFO [ReplicaFetcherManager on broker 2] Removed fetcher for partitions Set(test-topic-0000000-0150-106) (kafka.server.ReplicaFetcherManager)
[2023-12-11 08:32:17,672] INFO [ReplicaAlterLogDirsManager on broker 2] Removed fetcher for partitions Set(test-topic-0000000-0150-106) (kafka.server.ReplicaAlterLogDirsManager)
[2023-12-11 08:32:17,684] INFO [Partition test-topic-0000000-0150-106 broker=2] Closing partition (kafka.cluster.Partition)
[2023-12-11 08:32:17,710] INFO [ElasticProducerStateManager partition=test-topic-0000000-0150-106] Wrote producer snapshot at offset 7294 with 4 producer ids in 9 ms. (kafka.log.streamaspect.ElasticProducerStateManager)
[2023-12-11 08:32:17,737] INFO [ElasticLog partition=test-topic-0000000-0150-106 epoch=2] save log meta ElasticLogMeta{streamMap={log=414, tim=461, txn=-1}, lastNthSegmentMetas=[ElasticStreamSegmentMeta{baseOffset=0, createTimestamp=1702283488521, lastModifiedTimestamp=1702283537693, streamSuffix='', logSize=29986888, log=[0, -1], time=[0, -1], txn=[0, -1], firstBatchTimestamp=1702283494681, timeIndexLastEntry=TimestampOffsetData{timestamp=1702283517186, offset=5102}}]} (kafka.log.streamaspect.ElasticLog$)
[2023-12-11 08:32:17,745] INFO [ElasticLog partition=test-topic-0000000-0150-106 epoch=2] [ElasticLog partition=test-topic-0000000-0150-106 epoch=2] save partition meta ElasticPartitionMeta{startOffset=0, cleanerOffset=0, recoverOffset=7294, cleanedShutdown=true} (kafka.log.streamaspect.ElasticLog)
[2023-12-11 08:32:17,746] INFO [ElasticLog partition=test-topic-0000000-0150-106 epoch=2] log(except for streams) closed (kafka.log.streamaspect.ElasticLog)
[2023-12-11 08:32:17,767] ERROR [ElasticLog partition=test-topic-0000000-0150-106 epoch=2] append callback error (kafka.log.streamaspect.ElasticLog)
org.apache.kafka.common.errors.KafkaStorageException: The memory mapped buffer for log of test-topic-0000000-0150-106 is already closed
[2023-12-11 08:32:23,061] INFO [ReplicaManager broker=2] partition test-topic-0000000-0150-106 is closed, trigger leader election (kafka.server.ReplicaManager)

Metadata

Metadata

Assignees

Labels

bugSomething isn't working

Type

No type

Projects

No projects

Milestone

No milestone

Relationships

None yet

Development

No branches or pull requests

Issue actions