GPU-Live/kafka4/logs/kafka.out

634 lines
76 KiB
Plaintext

[2025-05-27 20:15:42,946] INFO Registered kafka:type=kafka.Log4jController MBean (kafka.utils.Log4jControllerRegistration$)
[2025-05-27 20:15:43,229] INFO Registered signal handlers for TERM, INT, HUP (org.apache.kafka.common.utils.LoggingSignalHandler)
[2025-05-27 20:15:43,231] INFO [ControllerServer id=1] Starting controller (kafka.server.ControllerServer)
[2025-05-27 20:15:43,501] INFO Updated connection-accept-rate max connection creation rate to 2147483647 (kafka.network.ConnectionQuotas)
[2025-05-27 20:15:43,530] INFO [SocketServer listenerType=CONTROLLER, nodeId=1] Created data-plane acceptor and processors for endpoint : ListenerName(CONTROLLER) (kafka.network.SocketServer)
[2025-05-27 20:15:43,536] INFO authorizerStart completed for endpoint CONTROLLER. Endpoint is now READY. (org.apache.kafka.server.network.EndpointReadyFutures)
[2025-05-27 20:15:43,538] INFO [SharedServer id=1] Starting SharedServer (kafka.server.SharedServer)
[2025-05-27 20:15:43,583] INFO [LogLoader partition=__cluster_metadata-0, dir=/app/kafka4/data/metadata-logs] Loading producer state till offset 0 (org.apache.kafka.storage.internals.log.UnifiedLog)
[2025-05-27 20:15:43,584] INFO [LogLoader partition=__cluster_metadata-0, dir=/app/kafka4/data/metadata-logs] Reloading from producer snapshot and rebuilding producer state from offset 0 (org.apache.kafka.storage.internals.log.UnifiedLog)
[2025-05-27 20:15:43,586] INFO [LogLoader partition=__cluster_metadata-0, dir=/app/kafka4/data/metadata-logs] Producer state recovery took 0ms for snapshot load and 0ms for segment recovery from offset 0 (org.apache.kafka.storage.internals.log.UnifiedLog)
[2025-05-27 20:15:43,612] INFO Initialized snapshots with IDs SortedSet() from /app/kafka4/data/metadata-logs/__cluster_metadata-0 (kafka.raft.KafkaMetadataLog$)
[2025-05-27 20:15:43,628] INFO [raft-expiration-reaper]: Starting (kafka.raft.TimingWheelExpirationService$ExpiredOperationReaper)
[2025-05-27 20:15:43,634] INFO [RaftManager id=1] Starting request manager with bootstrap servers: [192.168.0.87:9093 (id: -2 rack: null isFenced: false), 192.168.0.73:9093 (id: -3 rack: null isFenced: false), 192.168.0.88:9093 (id: -4 rack: null isFenced: false)] (org.apache.kafka.raft.KafkaRaftClient)
[2025-05-27 20:15:43,639] INFO [RaftManager id=1] Reading KRaft snapshot and log as part of the initialization (org.apache.kafka.raft.KafkaRaftClient)
[2025-05-27 20:15:43,641] INFO [RaftManager id=1] Starting voters are VoterSet(voters={1=VoterNode(voterKey=ReplicaKey(id=1, directoryId=<undefined>), listeners=Endpoints(endpoints={ListenerName(CONTROLLER)=/192.168.0.87:9093}), supportedKRaftVersion=SupportedVersionRange[min_version:0, max_version:0]), 2=VoterNode(voterKey=ReplicaKey(id=2, directoryId=<undefined>), listeners=Endpoints(endpoints={ListenerName(CONTROLLER)=/192.168.0.73:9093}), supportedKRaftVersion=SupportedVersionRange[min_version:0, max_version:0]), 3=VoterNode(voterKey=ReplicaKey(id=3, directoryId=<undefined>), listeners=Endpoints(endpoints={ListenerName(CONTROLLER)=/192.168.0.88:9093}), supportedKRaftVersion=SupportedVersionRange[min_version:0, max_version:0])}) (org.apache.kafka.raft.KafkaRaftClient)
[2025-05-27 20:15:43,644] INFO [RaftManager id=1] Attempting durable transition to UnattachedState(epoch=0, leaderId=OptionalInt.empty, votedKey=Optional.empty, voters=[1, 2, 3], electionTimeoutMs=1542, highWatermark=Optional.empty) from null (org.apache.kafka.raft.QuorumState)
[2025-05-27 20:15:43,658] INFO [RaftManager id=1] Completed transition to UnattachedState(epoch=0, leaderId=OptionalInt.empty, votedKey=Optional.empty, voters=[1, 2, 3], electionTimeoutMs=1542, highWatermark=Optional.empty) from null (org.apache.kafka.raft.QuorumState)
[2025-05-27 20:15:43,661] INFO [kafka-1-raft-outbound-request-thread]: Starting (org.apache.kafka.raft.KafkaNetworkChannel$SendThread)
[2025-05-27 20:15:43,661] INFO [kafka-1-raft-io-thread]: Starting (org.apache.kafka.raft.KafkaRaftClientDriver)
[2025-05-27 20:15:43,673] INFO [MetadataLoader id=1] initializeNewPublishers: the loader is still catching up because we still don't know the high water mark yet. (org.apache.kafka.image.loader.MetadataLoader)
[2025-05-27 20:15:43,674] INFO [RaftManager id=1] Registered the listener org.apache.kafka.image.loader.MetadataLoader@1531319744 (org.apache.kafka.raft.KafkaRaftClient)
[2025-05-27 20:15:43,674] INFO [ControllerServer id=1] Waiting for controller quorum voters future (kafka.server.ControllerServer)
[2025-05-27 20:15:43,674] INFO [ControllerServer id=1] Finished waiting for controller quorum voters future (kafka.server.ControllerServer)
[2025-05-27 20:15:43,682] INFO [RaftManager id=1] Node -2 disconnected. (org.apache.kafka.clients.NetworkClient)
[2025-05-27 20:15:43,682] WARN [RaftManager id=1] Connection to node -2 (/192.168.0.87:9093) could not be established. Node may not be available. (org.apache.kafka.clients.NetworkClient)
[2025-05-27 20:15:43,688] INFO [RaftManager id=1] Node -3 disconnected. (org.apache.kafka.clients.NetworkClient)
[2025-05-27 20:15:43,689] WARN [RaftManager id=1] Connection to node -3 (/192.168.0.73:9093) could not be established. Node may not be available. (org.apache.kafka.clients.NetworkClient)
[2025-05-27 20:15:43,696] INFO [RaftManager id=1] Node -4 disconnected. (org.apache.kafka.clients.NetworkClient)
[2025-05-27 20:15:43,696] WARN [RaftManager id=1] Connection to node -4 (/192.168.0.88:9093) could not be established. Node may not be available. (org.apache.kafka.clients.NetworkClient)
[2025-05-27 20:15:43,702] INFO [RaftManager id=1] Registered the listener org.apache.kafka.controller.QuorumController$QuorumMetaLogListener@1801348204 (org.apache.kafka.raft.KafkaRaftClient)
[2025-05-27 20:15:43,706] INFO [controller-1-ThrottledChannelReaper-Produce]: Starting (kafka.server.ClientQuotaManager$ThrottledChannelReaper)
[2025-05-27 20:15:43,706] INFO [controller-1-ThrottledChannelReaper-Fetch]: Starting (kafka.server.ClientQuotaManager$ThrottledChannelReaper)
[2025-05-27 20:15:43,707] INFO [controller-1-ThrottledChannelReaper-Request]: Starting (kafka.server.ClientQuotaManager$ThrottledChannelReaper)
[2025-05-27 20:15:43,708] INFO [controller-1-ThrottledChannelReaper-ControllerMutation]: Starting (kafka.server.ClientQuotaManager$ThrottledChannelReaper)
[2025-05-27 20:15:43,720] INFO [ExpirationReaper-0-null]: Starting (org.apache.kafka.server.purgatory.DelayedOperationPurgatory$ExpiredOperationReaper)
[2025-05-27 20:15:43,732] INFO [ControllerServer id=1] Waiting for the controller metadata publishers to be installed (kafka.server.ControllerServer)
[2025-05-27 20:15:43,732] INFO [ControllerServer id=1] Finished waiting for the controller metadata publishers to be installed (kafka.server.ControllerServer)
[2025-05-27 20:15:43,732] INFO [MetadataLoader id=1] initializeNewPublishers: the loader is still catching up because we still don't know the high water mark yet. (org.apache.kafka.image.loader.MetadataLoader)
[2025-05-27 20:15:43,733] INFO [SocketServer listenerType=CONTROLLER, nodeId=1] Enabling request processing. (kafka.network.SocketServer)
[2025-05-27 20:15:43,735] INFO Awaiting socket connections on 0.0.0.0:9093. (kafka.network.DataPlaneAcceptor)
[2025-05-27 20:15:43,742] INFO [controller-1-to-controller-registration-channel-manager]: Starting (kafka.server.NodeToControllerRequestThread)
[2025-05-27 20:15:43,742] INFO [ControllerRegistrationManager id=1 incarnation=K3W9NstrSjGCWNgeFAZuLw] initialized channel manager. (kafka.server.ControllerRegistrationManager)
[2025-05-27 20:15:43,742] INFO [ControllerRegistrationManager id=1 incarnation=K3W9NstrSjGCWNgeFAZuLw] maybeSendControllerRegistration: cannot register yet because the metadata.version is not known yet. (kafka.server.ControllerRegistrationManager)
[2025-05-27 20:15:43,743] INFO [ControllerServer id=1] Waiting for all of the authorizer futures to be completed (kafka.server.ControllerServer)
[2025-05-27 20:15:43,743] INFO [ControllerServer id=1] Finished waiting for all of the authorizer futures to be completed (kafka.server.ControllerServer)
[2025-05-27 20:15:43,743] INFO [ControllerServer id=1] Waiting for all of the SocketServer Acceptors to be started (kafka.server.ControllerServer)
[2025-05-27 20:15:43,743] INFO [ControllerServer id=1] Finished waiting for all of the SocketServer Acceptors to be started (kafka.server.ControllerServer)
[2025-05-27 20:15:43,744] INFO [BrokerServer id=1] Transition from SHUTDOWN to STARTING (kafka.server.BrokerServer)
[2025-05-27 20:15:43,745] INFO [BrokerServer id=1] Starting broker (kafka.server.BrokerServer)
[2025-05-27 20:15:43,759] INFO [broker-1-ThrottledChannelReaper-Fetch]: Starting (kafka.server.ClientQuotaManager$ThrottledChannelReaper)
[2025-05-27 20:15:43,761] INFO [broker-1-ThrottledChannelReaper-Request]: Starting (kafka.server.ClientQuotaManager$ThrottledChannelReaper)
[2025-05-27 20:15:43,761] INFO [broker-1-ThrottledChannelReaper-Produce]: Starting (kafka.server.ClientQuotaManager$ThrottledChannelReaper)
[2025-05-27 20:15:43,770] INFO [broker-1-ThrottledChannelReaper-ControllerMutation]: Starting (kafka.server.ClientQuotaManager$ThrottledChannelReaper)
[2025-05-27 20:15:43,798] INFO [BrokerServer id=1] Waiting for controller quorum voters future (kafka.server.BrokerServer)
[2025-05-27 20:15:43,798] INFO [BrokerServer id=1] Finished waiting for controller quorum voters future (kafka.server.BrokerServer)
[2025-05-27 20:15:43,800] INFO [broker-1-to-controller-forwarding-channel-manager]: Starting (kafka.server.NodeToControllerRequestThread)
[2025-05-27 20:15:43,810] INFO [client-metrics-reaper]: Starting (org.apache.kafka.server.util.timer.SystemTimerReaper$Reaper)
[2025-05-27 20:15:43,831] INFO Updated connection-accept-rate max connection creation rate to 2147483647 (kafka.network.ConnectionQuotas)
[2025-05-27 20:15:43,833] INFO [MetadataLoader id=1] initializeNewPublishers: the loader is still catching up because we still don't know the high water mark yet. (org.apache.kafka.image.loader.MetadataLoader)
[2025-05-27 20:15:43,833] INFO [SocketServer listenerType=BROKER, nodeId=1] Created data-plane acceptor and processors for endpoint : ListenerName(INTERNAL) (kafka.network.SocketServer)
[2025-05-27 20:15:43,834] INFO Updated connection-accept-rate max connection creation rate to 2147483647 (kafka.network.ConnectionQuotas)
[2025-05-27 20:15:43,836] INFO [SocketServer listenerType=BROKER, nodeId=1] Created data-plane acceptor and processors for endpoint : ListenerName(EXTERNAL) (kafka.network.SocketServer)
[2025-05-27 20:15:43,840] INFO [broker-1-to-controller-alter-partition-channel-manager]: Starting (kafka.server.NodeToControllerRequestThread)
[2025-05-27 20:15:43,851] INFO [broker-1-to-controller-directory-assignments-channel-manager]: Starting (kafka.server.NodeToControllerRequestThread)
[2025-05-27 20:15:43,859] INFO [ExpirationReaper-0-null]: Starting (org.apache.kafka.server.purgatory.DelayedOperationPurgatory$ExpiredOperationReaper)
[2025-05-27 20:15:43,860] INFO [ExpirationReaper-0-null]: Starting (org.apache.kafka.server.purgatory.DelayedOperationPurgatory$ExpiredOperationReaper)
[2025-05-27 20:15:43,861] INFO [ExpirationReaper-0-null]: Starting (org.apache.kafka.server.purgatory.DelayedOperationPurgatory$ExpiredOperationReaper)
[2025-05-27 20:15:43,863] INFO [ExpirationReaper-0-null]: Starting (org.apache.kafka.server.purgatory.DelayedOperationPurgatory$ExpiredOperationReaper)
[2025-05-27 20:15:43,863] INFO [ExpirationReaper-0-null]: Starting (org.apache.kafka.server.purgatory.DelayedOperationPurgatory$ExpiredOperationReaper)
[2025-05-27 20:15:43,863] INFO [ExpirationReaper-0-null]: Starting (org.apache.kafka.server.purgatory.DelayedOperationPurgatory$ExpiredOperationReaper)
[2025-05-27 20:15:43,884] INFO [BrokerServer id=1] Using no op persister (kafka.server.BrokerServer)
[2025-05-27 20:15:43,892] INFO [group-coordinator-reaper]: Starting (org.apache.kafka.server.util.timer.SystemTimerReaper$Reaper)
[2025-05-27 20:15:43,906] INFO [group-coordinator-event-processor-0]: Starting (org.apache.kafka.coordinator.common.runtime.MultiThreadedEventProcessor$EventProcessorThread)
[2025-05-27 20:15:43,914] INFO [group-coordinator-event-processor-1]: Starting (org.apache.kafka.coordinator.common.runtime.MultiThreadedEventProcessor$EventProcessorThread)
[2025-05-27 20:15:43,914] INFO [group-coordinator-event-processor-2]: Starting (org.apache.kafka.coordinator.common.runtime.MultiThreadedEventProcessor$EventProcessorThread)
[2025-05-27 20:15:43,916] INFO [group-coordinator-event-processor-3]: Starting (org.apache.kafka.coordinator.common.runtime.MultiThreadedEventProcessor$EventProcessorThread)
[2025-05-27 20:15:43,933] INFO [MetadataLoader id=1] initializeNewPublishers: the loader is still catching up because we still don't know the high water mark yet. (org.apache.kafka.image.loader.MetadataLoader)
[2025-05-27 20:15:43,934] INFO Unable to read the broker epoch in /app/kafka4/data/kraft-combined-logs. (kafka.log.LogManager)
[2025-05-27 20:15:43,939] INFO [broker-1-to-controller-heartbeat-channel-manager]: Starting (kafka.server.NodeToControllerRequestThread)
[2025-05-27 20:15:43,940] INFO [BrokerLifecycleManager id=1] Incarnation d-m3sk0uRiOv4Xb_gjgAMA of broker 1 in cluster VcD4VONhTsGM90xh5WBCZg is now STARTING. (kafka.server.BrokerLifecycleManager)
[2025-05-27 20:15:43,947] INFO [share-group-lock-timeout-reaper]: Starting (org.apache.kafka.server.util.timer.SystemTimerReaper$Reaper)
[2025-05-27 20:15:43,957] INFO [ExpirationReaper-0-null]: Starting (org.apache.kafka.server.purgatory.DelayedOperationPurgatory$ExpiredOperationReaper)
[2025-05-27 20:15:43,984] INFO [BrokerServer id=1] Waiting for the broker metadata publishers to be installed (kafka.server.BrokerServer)
[2025-05-27 20:15:43,984] INFO [MetadataLoader id=1] initializeNewPublishers: the loader is still catching up because we still don't know the high water mark yet. (org.apache.kafka.image.loader.MetadataLoader)
[2025-05-27 20:15:43,984] INFO [BrokerServer id=1] Finished waiting for the broker metadata publishers to be installed (kafka.server.BrokerServer)
[2025-05-27 20:15:43,984] INFO [BrokerServer id=1] Waiting for the controller to acknowledge that we are caught up (kafka.server.BrokerServer)
[2025-05-27 20:15:44,084] INFO [MetadataLoader id=1] initializeNewPublishers: the loader is still catching up because we still don't know the high water mark yet. (org.apache.kafka.image.loader.MetadataLoader)
[2025-05-27 20:15:44,184] INFO [MetadataLoader id=1] initializeNewPublishers: the loader is still catching up because we still don't know the high water mark yet. (org.apache.kafka.image.loader.MetadataLoader)
[2025-05-27 20:15:44,285] INFO [MetadataLoader id=1] initializeNewPublishers: the loader is still catching up because we still don't know the high water mark yet. (org.apache.kafka.image.loader.MetadataLoader)
[2025-05-27 20:15:44,385] INFO [MetadataLoader id=1] initializeNewPublishers: the loader is still catching up because we still don't know the high water mark yet. (org.apache.kafka.image.loader.MetadataLoader)
[2025-05-27 20:15:44,485] INFO [MetadataLoader id=1] initializeNewPublishers: the loader is still catching up because we still don't know the high water mark yet. (org.apache.kafka.image.loader.MetadataLoader)
[2025-05-27 20:15:44,586] INFO [MetadataLoader id=1] initializeNewPublishers: the loader is still catching up because we still don't know the high water mark yet. (org.apache.kafka.image.loader.MetadataLoader)
[2025-05-27 20:15:44,686] INFO [MetadataLoader id=1] initializeNewPublishers: the loader is still catching up because we still don't know the high water mark yet. (org.apache.kafka.image.loader.MetadataLoader)
[2025-05-27 20:15:44,786] INFO [MetadataLoader id=1] initializeNewPublishers: the loader is still catching up because we still don't know the high water mark yet. (org.apache.kafka.image.loader.MetadataLoader)
[2025-05-27 20:15:44,887] INFO [MetadataLoader id=1] initializeNewPublishers: the loader is still catching up because we still don't know the high water mark yet. (org.apache.kafka.image.loader.MetadataLoader)
[2025-05-27 20:15:44,987] INFO [MetadataLoader id=1] initializeNewPublishers: the loader is still catching up because we still don't know the high water mark yet. (org.apache.kafka.image.loader.MetadataLoader)
[2025-05-27 20:15:45,087] INFO [MetadataLoader id=1] initializeNewPublishers: the loader is still catching up because we still don't know the high water mark yet. (org.apache.kafka.image.loader.MetadataLoader)
[2025-05-27 20:15:45,098] INFO [RaftManager id=1] Vote request VoteRequestData(clusterId='VcD4VONhTsGM90xh5WBCZg', voterId=1, topics=[TopicData(topicName='__cluster_metadata', partitions=[PartitionData(partitionIndex=0, replicaEpoch=0, replicaId=2, replicaDirectoryId=POjNTqRztN9tDBcLAf5Cqw, voterDirectoryId=AAAAAAAAAAAAAAAAAAAAAA, lastOffsetEpoch=0, lastOffset=0, preVote=true)])]) with epoch 0 is granted (org.apache.kafka.raft.KafkaRaftClient)
[2025-05-27 20:15:45,104] INFO [RaftManager id=1] Attempting durable transition to UnattachedState(epoch=1, leaderId=OptionalInt.empty, votedKey=Optional.empty, voters=[1, 2, 3], electionTimeoutMs=82, highWatermark=Optional.empty) from UnattachedState(epoch=0, leaderId=OptionalInt.empty, votedKey=Optional.empty, voters=[1, 2, 3], electionTimeoutMs=1542, highWatermark=Optional.empty) (org.apache.kafka.raft.QuorumState)
[2025-05-27 20:15:45,108] INFO [RaftManager id=1] Completed transition to UnattachedState(epoch=1, leaderId=OptionalInt.empty, votedKey=Optional.empty, voters=[1, 2, 3], electionTimeoutMs=82, highWatermark=Optional.empty) from UnattachedState(epoch=0, leaderId=OptionalInt.empty, votedKey=Optional.empty, voters=[1, 2, 3], electionTimeoutMs=1542, highWatermark=Optional.empty) (org.apache.kafka.raft.QuorumState)
[2025-05-27 20:15:45,110] INFO [RaftManager id=1] Attempting durable transition to UnattachedState(epoch=1, leaderId=OptionalInt.empty, votedKey=Optional[ReplicaKey(id=2, directoryId=POjNTqRztN9tDBcLAf5Cqw)], voters=[1, 2, 3], electionTimeoutMs=1346, highWatermark=Optional.empty) from UnattachedState(epoch=1, leaderId=OptionalInt.empty, votedKey=Optional.empty, voters=[1, 2, 3], electionTimeoutMs=82, highWatermark=Optional.empty) (org.apache.kafka.raft.QuorumState)
[2025-05-27 20:15:45,112] INFO [RaftManager id=1] Completed transition to UnattachedState(epoch=1, leaderId=OptionalInt.empty, votedKey=Optional[ReplicaKey(id=2, directoryId=POjNTqRztN9tDBcLAf5Cqw)], voters=[1, 2, 3], electionTimeoutMs=1346, highWatermark=Optional.empty) from UnattachedState(epoch=1, leaderId=OptionalInt.empty, votedKey=Optional.empty, voters=[1, 2, 3], electionTimeoutMs=82, highWatermark=Optional.empty) (org.apache.kafka.raft.QuorumState)
[2025-05-27 20:15:45,112] INFO [RaftManager id=1] Vote request VoteRequestData(clusterId='VcD4VONhTsGM90xh5WBCZg', voterId=1, topics=[TopicData(topicName='__cluster_metadata', partitions=[PartitionData(partitionIndex=0, replicaEpoch=1, replicaId=2, replicaDirectoryId=POjNTqRztN9tDBcLAf5Cqw, voterDirectoryId=AAAAAAAAAAAAAAAAAAAAAA, lastOffsetEpoch=0, lastOffset=0, preVote=false)])]) with epoch 1 is granted (org.apache.kafka.raft.KafkaRaftClient)
[2025-05-27 20:15:45,157] INFO [RaftManager id=1] Attempting durable transition to FollowerState(fetchTimeoutMs=2000, epoch=1, leader=2, leaderEndpoints=Endpoints(endpoints={ListenerName(CONTROLLER)=192.168.0.73/<unresolved>:9093}), votedKey=Optional[ReplicaKey(id=2, directoryId=POjNTqRztN9tDBcLAf5Cqw)], voters=[1, 2, 3], highWatermark=Optional.empty, fetchingSnapshot=Optional.empty) from UnattachedState(epoch=1, leaderId=OptionalInt.empty, votedKey=Optional[ReplicaKey(id=2, directoryId=POjNTqRztN9tDBcLAf5Cqw)], voters=[1, 2, 3], electionTimeoutMs=1346, highWatermark=Optional.empty) (org.apache.kafka.raft.QuorumState)
[2025-05-27 20:15:45,159] INFO [RaftManager id=1] Completed transition to FollowerState(fetchTimeoutMs=2000, epoch=1, leader=2, leaderEndpoints=Endpoints(endpoints={ListenerName(CONTROLLER)=192.168.0.73/<unresolved>:9093}), votedKey=Optional[ReplicaKey(id=2, directoryId=POjNTqRztN9tDBcLAf5Cqw)], voters=[1, 2, 3], highWatermark=Optional.empty, fetchingSnapshot=Optional.empty) from UnattachedState(epoch=1, leaderId=OptionalInt.empty, votedKey=Optional[ReplicaKey(id=2, directoryId=POjNTqRztN9tDBcLAf5Cqw)], voters=[1, 2, 3], electionTimeoutMs=1346, highWatermark=Optional.empty) (org.apache.kafka.raft.QuorumState)
[2025-05-27 20:15:45,188] INFO [MetadataLoader id=1] initializeNewPublishers: the loader is still catching up because we still don't know the high water mark yet. (org.apache.kafka.image.loader.MetadataLoader)
[2025-05-27 20:15:45,203] INFO [broker-1-to-controller-forwarding-channel-manager]: Recorded new KRaft controller, from now on will use node 192.168.0.73:9093 (id: 2 rack: null isFenced: false) (kafka.server.NodeToControllerRequestThread)
[2025-05-27 20:15:45,242] INFO [broker-1-to-controller-heartbeat-channel-manager]: Recorded new KRaft controller, from now on will use node 192.168.0.73:9093 (id: 2 rack: null isFenced: false) (kafka.server.NodeToControllerRequestThread)
[2025-05-27 20:15:45,243] INFO [broker-1-to-controller-alter-partition-channel-manager]: Recorded new KRaft controller, from now on will use node 192.168.0.73:9093 (id: 2 rack: null isFenced: false) (kafka.server.NodeToControllerRequestThread)
[2025-05-27 20:15:45,246] INFO [controller-1-to-controller-registration-channel-manager]: Recorded new KRaft controller, from now on will use node 192.168.0.73:9093 (id: 2 rack: null isFenced: false) (kafka.server.NodeToControllerRequestThread)
[2025-05-27 20:15:45,247] INFO [RaftManager id=1] High watermark set to Optional[LogOffsetMetadata(offset=1, metadata=Optional.empty)] for the first time for epoch 1 (org.apache.kafka.raft.FollowerState)
[2025-05-27 20:15:45,249] INFO [RaftManager id=1] Setting the next offset of org.apache.kafka.image.loader.MetadataLoader@1531319744 to 0 since there are no snapshots (org.apache.kafka.raft.KafkaRaftClient)
[2025-05-27 20:15:45,250] INFO [RaftManager id=1] Setting the next offset of org.apache.kafka.controller.QuorumController$QuorumMetaLogListener@1801348204 to 0 since there are no snapshots (org.apache.kafka.raft.KafkaRaftClient)
[2025-05-27 20:15:45,250] INFO [MetadataLoader id=1] maybePublishMetadata(LOG_DELTA): The loader is still catching up because we have not loaded a controller record as of offset 0 and high water mark is 1 (org.apache.kafka.image.loader.MetadataLoader)
[2025-05-27 20:15:45,253] INFO [broker-1-to-controller-directory-assignments-channel-manager]: Recorded new KRaft controller, from now on will use node 192.168.0.73:9093 (id: 2 rack: null isFenced: false) (kafka.server.NodeToControllerRequestThread)
[2025-05-27 20:15:45,276] INFO [MetadataLoader id=1] maybePublishMetadata(LOG_DELTA): The loader finished catching up to the current high water mark of 7 (org.apache.kafka.image.loader.MetadataLoader)
[2025-05-27 20:15:45,279] INFO [MetadataLoader id=1] InitializeNewPublishers: initializing SnapshotGenerator with a snapshot at offset 6 (org.apache.kafka.image.loader.MetadataLoader)
[2025-05-27 20:15:45,280] INFO [MetadataLoader id=1] InitializeNewPublishers: initializing KRaftMetadataCachePublisher with a snapshot at offset 6 (org.apache.kafka.image.loader.MetadataLoader)
[2025-05-27 20:15:45,280] INFO [MetadataLoader id=1] InitializeNewPublishers: initializing FeaturesPublisher with a snapshot at offset 6 (org.apache.kafka.image.loader.MetadataLoader)
[2025-05-27 20:15:45,282] INFO [ControllerServer id=1] Loaded new metadata Features(metadataVersion=4.0-IV3, finalizedFeatures={group.version=1, transaction.version=2, metadata.version=25}, finalizedFeaturesEpoch=6). (org.apache.kafka.metadata.publisher.FeaturesPublisher)
[2025-05-27 20:15:45,282] INFO [MetadataLoader id=1] InitializeNewPublishers: initializing ControllerRegistrationsPublisher with a snapshot at offset 6 (org.apache.kafka.image.loader.MetadataLoader)
[2025-05-27 20:15:45,282] INFO [MetadataLoader id=1] InitializeNewPublishers: initializing ControllerRegistrationManager with a snapshot at offset 6 (org.apache.kafka.image.loader.MetadataLoader)
[2025-05-27 20:15:45,283] INFO [MetadataLoader id=1] InitializeNewPublishers: initializing DynamicConfigPublisher controller id=1 with a snapshot at offset 6 (org.apache.kafka.image.loader.MetadataLoader)
[2025-05-27 20:15:45,284] INFO [MetadataLoader id=1] InitializeNewPublishers: initializing DynamicClientQuotaPublisher controller id=1 with a snapshot at offset 6 (org.apache.kafka.image.loader.MetadataLoader)
[2025-05-27 20:15:45,284] INFO [MetadataLoader id=1] InitializeNewPublishers: initializing DynamicTopicClusterQuotaPublisher controller id=1 with a snapshot at offset 6 (org.apache.kafka.image.loader.MetadataLoader)
[2025-05-27 20:15:45,285] INFO [MetadataLoader id=1] InitializeNewPublishers: initializing ScramPublisher controller id=1 with a snapshot at offset 6 (org.apache.kafka.image.loader.MetadataLoader)
[2025-05-27 20:15:45,286] INFO [MetadataLoader id=1] InitializeNewPublishers: initializing DelegationTokenPublisher controller id=1 with a snapshot at offset 6 (org.apache.kafka.image.loader.MetadataLoader)
[2025-05-27 20:15:45,287] INFO [MetadataLoader id=1] InitializeNewPublishers: initializing ControllerMetadataMetricsPublisher with a snapshot at offset 6 (org.apache.kafka.image.loader.MetadataLoader)
[2025-05-27 20:15:45,287] INFO [MetadataLoader id=1] InitializeNewPublishers: initializing AclPublisher controller id=1 with a snapshot at offset 6 (org.apache.kafka.image.loader.MetadataLoader)
[2025-05-27 20:15:45,287] INFO [ControllerRegistrationManager id=1 incarnation=K3W9NstrSjGCWNgeFAZuLw] sendControllerRegistration: attempting to send ControllerRegistrationRequestData(controllerId=1, incarnationId=K3W9NstrSjGCWNgeFAZuLw, zkMigrationReady=false, listeners=[Listener(name='CONTROLLER', host='192.168.0.87', port=9093, securityProtocol=0)], features=[Feature(name='group.version', minSupportedVersion=0, maxSupportedVersion=1), Feature(name='transaction.version', minSupportedVersion=0, maxSupportedVersion=2), Feature(name='eligible.leader.replicas.version', minSupportedVersion=0, maxSupportedVersion=1), Feature(name='kraft.version', minSupportedVersion=0, maxSupportedVersion=1), Feature(name='metadata.version', minSupportedVersion=7, maxSupportedVersion=25)]) (kafka.server.ControllerRegistrationManager)
[2025-05-27 20:15:45,288] INFO [MetadataLoader id=1] InitializeNewPublishers: initializing MetadataVersionPublisher(id=1) with a snapshot at offset 6 (org.apache.kafka.image.loader.MetadataLoader)
[2025-05-27 20:15:45,288] INFO [MetadataLoader id=1] InitializeNewPublishers: initializing BrokerMetadataPublisher with a snapshot at offset 6 (org.apache.kafka.image.loader.MetadataLoader)
[2025-05-27 20:15:45,290] INFO [BrokerMetadataPublisher id=1] Publishing initial metadata at offset OffsetAndEpoch(offset=6, epoch=1) with metadata.version Optional[4.0-IV3]. (kafka.server.metadata.BrokerMetadataPublisher)
[2025-05-27 20:15:45,291] INFO [BrokerLifecycleManager id=1] Successfully registered broker 1 with broker epoch 7 (kafka.server.BrokerLifecycleManager)
[2025-05-27 20:15:45,291] INFO Loading logs from log dirs ArrayBuffer(/app/kafka4/data/kraft-combined-logs) (kafka.log.LogManager)
[2025-05-27 20:15:45,294] INFO No logs found to be loaded in /app/kafka4/data/kraft-combined-logs (kafka.log.LogManager)
[2025-05-27 20:15:45,301] INFO Loaded 0 logs in 8ms (kafka.log.LogManager)
[2025-05-27 20:15:45,302] INFO Starting log cleanup with a period of 300000 ms. (kafka.log.LogManager)
[2025-05-27 20:15:45,302] INFO Starting log flusher with a default period of 9223372036854775807 ms. (kafka.log.LogManager)
[2025-05-27 20:15:45,320] INFO [ControllerRegistrationManager id=1 incarnation=K3W9NstrSjGCWNgeFAZuLw] RegistrationResponseHandler: controller acknowledged ControllerRegistrationRequest. (kafka.server.ControllerRegistrationManager)
[2025-05-27 20:15:45,371] INFO [kafka-log-cleaner-thread-0]: Starting (kafka.log.LogCleaner$CleanerThread)
[2025-05-27 20:15:45,379] INFO [LogDirFailureHandler]: Starting (kafka.server.ReplicaManager$LogDirFailureHandler)
[2025-05-27 20:15:45,380] INFO [AddPartitionsToTxnSenderThread-1]: Starting (kafka.server.AddPartitionsToTxnManager)
[2025-05-27 20:15:45,380] INFO [GroupCoordinator id=1] Starting up. (org.apache.kafka.coordinator.group.GroupCoordinatorService)
[2025-05-27 20:15:45,381] INFO [GroupCoordinator id=1] Startup complete. (org.apache.kafka.coordinator.group.GroupCoordinatorService)
[2025-05-27 20:15:45,382] INFO [TransactionCoordinator id=1] Starting up. (kafka.coordinator.transaction.TransactionCoordinator)
[2025-05-27 20:15:45,383] INFO [TxnMarkerSenderThread-1]: Starting (kafka.coordinator.transaction.TransactionMarkerChannelManager)
[2025-05-27 20:15:45,383] INFO [TransactionCoordinator id=1] Startup complete. (kafka.coordinator.transaction.TransactionCoordinator)
[2025-05-27 20:15:45,392] INFO [MetadataLoader id=1] InitializeNewPublishers: initializing BrokerRegistrationTracker(id=1) with a snapshot at offset 6 (org.apache.kafka.image.loader.MetadataLoader)
[2025-05-27 20:15:45,400] INFO [ControllerRegistrationManager id=1 incarnation=K3W9NstrSjGCWNgeFAZuLw] Our registration has been persisted to the metadata log. (kafka.server.ControllerRegistrationManager)
[2025-05-27 20:15:45,413] INFO [BrokerLifecycleManager id=1] The broker has caught up. Transitioning from STARTING to RECOVERY. (kafka.server.BrokerLifecycleManager)
[2025-05-27 20:15:45,413] INFO [BrokerServer id=1] Finished waiting for the controller to acknowledge that we are caught up (kafka.server.BrokerServer)
[2025-05-27 20:15:45,413] INFO [BrokerServer id=1] Waiting for the initial broker metadata update to be published (kafka.server.BrokerServer)
[2025-05-27 20:15:45,414] INFO [BrokerServer id=1] Finished waiting for the initial broker metadata update to be published (kafka.server.BrokerServer)
[2025-05-27 20:15:45,415] INFO KafkaConfig values:
add.partitions.to.txn.retry.backoff.max.ms = 100
add.partitions.to.txn.retry.backoff.ms = 20
advertised.listeners = INTERNAL://192.168.0.87:9094,EXTERNAL://114.110.129.227:19092,CONTROLLER://192.168.0.87:9093
alter.config.policy.class.name = null
alter.log.dirs.replication.quota.window.num = 11
alter.log.dirs.replication.quota.window.size.seconds = 1
authorizer.class.name =
auto.create.topics.enable = true
auto.leader.rebalance.enable = true
background.threads = 10
broker.heartbeat.interval.ms = 2000
broker.id = 1
broker.rack = null
broker.session.timeout.ms = 9000
client.quota.callback.class = null
compression.gzip.level = -1
compression.lz4.level = 9
compression.type = producer
compression.zstd.level = 3
connection.failed.authentication.delay.ms = 100
connections.max.idle.ms = 600000
connections.max.reauth.ms = 0
controlled.shutdown.enable = true
controller.listener.names = CONTROLLER
controller.performance.always.log.threshold.ms = 2000
controller.performance.sample.period.ms = 60000
controller.quorum.append.linger.ms = 25
controller.quorum.bootstrap.servers = [192.168.0.87:9093, 192.168.0.73:9093, 192.168.0.88:9093]
controller.quorum.election.backoff.max.ms = 1000
controller.quorum.election.timeout.ms = 1000
controller.quorum.fetch.timeout.ms = 2000
controller.quorum.request.timeout.ms = 2000
controller.quorum.retry.backoff.ms = 20
controller.quorum.voters = [1@192.168.0.87:9093, 2@192.168.0.73:9093, 3@192.168.0.88:9093]
controller.quota.window.num = 11
controller.quota.window.size.seconds = 1
controller.socket.timeout.ms = 30000
create.topic.policy.class.name = null
default.replication.factor = 1
delegation.token.expiry.check.interval.ms = 3600000
delegation.token.expiry.time.ms = 86400000
delegation.token.max.lifetime.ms = 604800000
delegation.token.secret.key = null
delete.records.purgatory.purge.interval.requests = 1
delete.topic.enable = true
early.start.listeners = null
fetch.max.bytes = 57671680
fetch.purgatory.purge.interval.requests = 1000
group.consumer.assignors = [uniform, range]
group.consumer.heartbeat.interval.ms = 5000
group.consumer.max.heartbeat.interval.ms = 15000
group.consumer.max.session.timeout.ms = 60000
group.consumer.max.size = 2147483647
group.consumer.migration.policy = bidirectional
group.consumer.min.heartbeat.interval.ms = 5000
group.consumer.min.session.timeout.ms = 45000
group.consumer.session.timeout.ms = 45000
group.coordinator.append.linger.ms = 5
group.coordinator.new.enable = true
group.coordinator.rebalance.protocols = [classic, consumer]
group.coordinator.threads = 4
group.initial.rebalance.delay.ms = 3000
group.max.session.timeout.ms = 1800000
group.max.size = 2147483647
group.min.session.timeout.ms = 6000
group.share.delivery.count.limit = 5
group.share.enable = false
group.share.heartbeat.interval.ms = 5000
group.share.max.groups = 10
group.share.max.heartbeat.interval.ms = 15000
group.share.max.record.lock.duration.ms = 60000
group.share.max.session.timeout.ms = 60000
group.share.max.size = 200
group.share.min.heartbeat.interval.ms = 5000
group.share.min.record.lock.duration.ms = 15000
group.share.min.session.timeout.ms = 45000
group.share.partition.max.record.locks = 200
group.share.persister.class.name = org.apache.kafka.server.share.persister.DefaultStatePersister
group.share.record.lock.duration.ms = 30000
group.share.session.timeout.ms = 45000
initial.broker.registration.timeout.ms = 60000
inter.broker.listener.name = INTERNAL
kafka.metrics.polling.interval.secs = 10
kafka.metrics.reporters = []
leader.imbalance.check.interval.seconds = 300
listener.security.protocol.map = INTERNAL:PLAINTEXT,EXTERNAL:PLAINTEXT,CONTROLLER:PLAINTEXT,PLAINTEXT:PLAINTEXT,SSL:SSL,SASL_PLAINTEXT:SASL_PLAINTEXT,SASL_SSL:SASL_SSL
listeners = INTERNAL://0.0.0.0:9094,EXTERNAL://0.0.0.0:9092,CONTROLLER://0.0.0.0:9093
log.cleaner.backoff.ms = 15000
log.cleaner.dedupe.buffer.size = 134217728
log.cleaner.delete.retention.ms = 86400000
log.cleaner.enable = true
log.cleaner.io.buffer.load.factor = 0.9
log.cleaner.io.buffer.size = 524288
log.cleaner.io.max.bytes.per.second = 1.7976931348623157E308
log.cleaner.max.compaction.lag.ms = 9223372036854775807
log.cleaner.min.cleanable.ratio = 0.5
log.cleaner.min.compaction.lag.ms = 0
log.cleaner.threads = 1
log.cleanup.policy = [delete]
log.dir = /tmp/kafka-logs
log.dir.failure.timeout.ms = 30000
log.dirs = /app/kafka4/data/kraft-combined-logs
log.flush.interval.messages = 9223372036854775807
log.flush.interval.ms = null
log.flush.offset.checkpoint.interval.ms = 60000
log.flush.scheduler.interval.ms = 9223372036854775807
log.flush.start.offset.checkpoint.interval.ms = 60000
log.index.interval.bytes = 4096
log.index.size.max.bytes = 10485760
log.initial.task.delay.ms = 30000
log.local.retention.bytes = -2
log.local.retention.ms = -2
log.message.timestamp.after.max.ms = 3600000
log.message.timestamp.before.max.ms = 9223372036854775807
log.message.timestamp.type = CreateTime
log.preallocate = false
log.retention.bytes = -1
log.retention.check.interval.ms = 300000
log.retention.hours = 168
log.retention.minutes = null
log.retention.ms = null
log.roll.hours = 168
log.roll.jitter.hours = 0
log.roll.jitter.ms = null
log.roll.ms = null
log.segment.bytes = 1073741824
log.segment.delete.delay.ms = 60000
max.connection.creation.rate = 2147483647
max.connections = 2147483647
max.connections.per.ip = 2147483647
max.connections.per.ip.overrides =
max.incremental.fetch.session.cache.slots = 1000
max.request.partition.size.limit = 2000
message.max.bytes = 1048588
metadata.log.dir = /app/kafka4/data/metadata-logs
metadata.log.max.record.bytes.between.snapshots = 20971520
metadata.log.max.snapshot.interval.ms = 3600000
metadata.log.segment.bytes = 1073741824
metadata.log.segment.min.bytes = 8388608
metadata.log.segment.ms = 604800000
metadata.max.idle.interval.ms = 500
metadata.max.retention.bytes = 104857600
metadata.max.retention.ms = 604800000
metric.reporters = [org.apache.kafka.common.metrics.JmxReporter]
metrics.num.samples = 2
metrics.recording.level = INFO
metrics.sample.window.ms = 30000
min.insync.replicas = 1
node.id = 1
num.io.threads = 2
num.network.threads = 2
num.partitions = 3
num.recovery.threads.per.data.dir = 1
num.replica.alter.log.dirs.threads = null
num.replica.fetchers = 1
offset.metadata.max.bytes = 4096
offsets.commit.timeout.ms = 5000
offsets.load.buffer.size = 5242880
offsets.retention.check.interval.ms = 600000
offsets.retention.minutes = 10080
offsets.topic.compression.codec = 0
offsets.topic.num.partitions = 50
offsets.topic.replication.factor = 1
offsets.topic.segment.bytes = 104857600
principal.builder.class = class org.apache.kafka.common.security.authenticator.DefaultKafkaPrincipalBuilder
process.roles = [broker, controller]
producer.id.expiration.check.interval.ms = 600000
producer.id.expiration.ms = 86400000
producer.purgatory.purge.interval.requests = 1000
queued.max.request.bytes = -1
queued.max.requests = 500
quota.window.num = 11
quota.window.size.seconds = 1
remote.fetch.max.wait.ms = 500
remote.list.offsets.request.timeout.ms = 30000
remote.log.index.file.cache.total.size.bytes = 1073741824
remote.log.manager.copier.thread.pool.size = 10
remote.log.manager.copy.max.bytes.per.second = 9223372036854775807
remote.log.manager.copy.quota.window.num = 11
remote.log.manager.copy.quota.window.size.seconds = 1
remote.log.manager.expiration.thread.pool.size = 10
remote.log.manager.fetch.max.bytes.per.second = 9223372036854775807
remote.log.manager.fetch.quota.window.num = 11
remote.log.manager.fetch.quota.window.size.seconds = 1
remote.log.manager.task.interval.ms = 30000
remote.log.manager.task.retry.backoff.max.ms = 30000
remote.log.manager.task.retry.backoff.ms = 500
remote.log.manager.task.retry.jitter = 0.2
remote.log.manager.thread.pool.size = 2
remote.log.metadata.custom.metadata.max.bytes = 128
remote.log.metadata.manager.class.name = org.apache.kafka.server.log.remote.metadata.storage.TopicBasedRemoteLogMetadataManager
remote.log.metadata.manager.class.path = null
remote.log.metadata.manager.impl.prefix = rlmm.config.
remote.log.metadata.manager.listener.name = null
remote.log.reader.max.pending.tasks = 100
remote.log.reader.threads = 10
remote.log.storage.manager.class.name = null
remote.log.storage.manager.class.path = null
remote.log.storage.manager.impl.prefix = rsm.config.
remote.log.storage.system.enable = false
replica.fetch.backoff.ms = 1000
replica.fetch.max.bytes = 1048576
replica.fetch.min.bytes = 1
replica.fetch.response.max.bytes = 10485760
replica.fetch.wait.max.ms = 500
replica.high.watermark.checkpoint.interval.ms = 5000
replica.lag.time.max.ms = 30000
replica.selector.class = null
replica.socket.receive.buffer.bytes = 65536
replica.socket.timeout.ms = 30000
replication.quota.window.num = 11
replication.quota.window.size.seconds = 1
request.timeout.ms = 30000
sasl.client.callback.handler.class = null
sasl.enabled.mechanisms = [GSSAPI]
sasl.jaas.config = null
sasl.kerberos.kinit.cmd = /usr/bin/kinit
sasl.kerberos.min.time.before.relogin = 60000
sasl.kerberos.principal.to.local.rules = [DEFAULT]
sasl.kerberos.service.name = null
sasl.kerberos.ticket.renew.jitter = 0.05
sasl.kerberos.ticket.renew.window.factor = 0.8
sasl.login.callback.handler.class = null
sasl.login.class = null
sasl.login.connect.timeout.ms = null
sasl.login.read.timeout.ms = null
sasl.login.refresh.buffer.seconds = 300
sasl.login.refresh.min.period.seconds = 60
sasl.login.refresh.window.factor = 0.8
sasl.login.refresh.window.jitter = 0.05
sasl.login.retry.backoff.max.ms = 10000
sasl.login.retry.backoff.ms = 100
sasl.mechanism.controller.protocol = GSSAPI
sasl.mechanism.inter.broker.protocol = GSSAPI
sasl.oauthbearer.clock.skew.seconds = 30
sasl.oauthbearer.expected.audience = null
sasl.oauthbearer.expected.issuer = null
sasl.oauthbearer.jwks.endpoint.refresh.ms = 3600000
sasl.oauthbearer.jwks.endpoint.retry.backoff.max.ms = 10000
sasl.oauthbearer.jwks.endpoint.retry.backoff.ms = 100
sasl.oauthbearer.jwks.endpoint.url = null
sasl.oauthbearer.scope.claim.name = scope
sasl.oauthbearer.sub.claim.name = sub
sasl.oauthbearer.token.endpoint.url = null
sasl.server.callback.handler.class = null
sasl.server.max.receive.size = 524288
security.inter.broker.protocol = PLAINTEXT
security.providers = null
server.max.startup.time.ms = 9223372036854775807
share.coordinator.append.linger.ms = 10
share.coordinator.load.buffer.size = 5242880
share.coordinator.snapshot.update.records.per.snapshot = 500
share.coordinator.state.topic.compression.codec = 0
share.coordinator.state.topic.min.isr = 1
share.coordinator.state.topic.num.partitions = 50
share.coordinator.state.topic.prune.interval.ms = 300000
share.coordinator.state.topic.replication.factor = 1
share.coordinator.state.topic.segment.bytes = 104857600
share.coordinator.threads = 1
share.coordinator.write.timeout.ms = 5000
share.fetch.max.fetch.records = 2147483647
share.fetch.purgatory.purge.interval.requests = 1000
socket.connection.setup.timeout.max.ms = 30000
socket.connection.setup.timeout.ms = 10000
socket.listen.backlog.size = 50
socket.receive.buffer.bytes = 102400
socket.request.max.bytes = 104857600
socket.send.buffer.bytes = 102400
ssl.allow.dn.changes = false
ssl.allow.san.changes = false
ssl.cipher.suites = []
ssl.client.auth = none
ssl.enabled.protocols = [TLSv1.2, TLSv1.3]
ssl.endpoint.identification.algorithm = https
ssl.engine.factory.class = null
ssl.key.password = null
ssl.keymanager.algorithm = SunX509
ssl.keystore.certificate.chain = null
ssl.keystore.key = null
ssl.keystore.location = null
ssl.keystore.password = null
ssl.keystore.type = JKS
ssl.principal.mapping.rules = DEFAULT
ssl.protocol = TLSv1.3
ssl.provider = null
ssl.secure.random.implementation = null
ssl.trustmanager.algorithm = PKIX
ssl.truststore.certificates = null
ssl.truststore.location = null
ssl.truststore.password = null
ssl.truststore.type = JKS
telemetry.max.bytes = 1048576
transaction.abort.timed.out.transaction.cleanup.interval.ms = 10000
transaction.max.timeout.ms = 900000
transaction.partition.verification.enable = true
transaction.remove.expired.transaction.cleanup.interval.ms = 3600000
transaction.state.log.load.buffer.size = 5242880
transaction.state.log.min.isr = 1
transaction.state.log.num.partitions = 50
transaction.state.log.replication.factor = 1
transaction.state.log.segment.bytes = 104857600
transactional.id.expiration.ms = 604800000
unclean.leader.election.enable = false
unclean.leader.election.interval.ms = 300000
unstable.api.versions.enable = false
unstable.feature.versions.enable = false
(org.apache.kafka.common.config.AbstractConfig)
[2025-05-27 20:15:45,418] INFO [BrokerServer id=1] Waiting for the broker to be unfenced (kafka.server.BrokerServer)
[2025-05-27 20:15:45,451] INFO [BrokerLifecycleManager id=1] The broker has been unfenced. Transitioning from RECOVERY to RUNNING. (kafka.server.BrokerLifecycleManager)
[2025-05-27 20:15:45,451] INFO [BrokerServer id=1] Finished waiting for the broker to be unfenced (kafka.server.BrokerServer)
[2025-05-27 20:15:45,455] INFO authorizerStart completed for endpoint INTERNAL. Endpoint is now READY. (org.apache.kafka.server.network.EndpointReadyFutures)
[2025-05-27 20:15:45,455] INFO authorizerStart completed for endpoint EXTERNAL. Endpoint is now READY. (org.apache.kafka.server.network.EndpointReadyFutures)
[2025-05-27 20:15:45,455] INFO [SocketServer listenerType=BROKER, nodeId=1] Enabling request processing. (kafka.network.SocketServer)
[2025-05-27 20:15:45,455] INFO Awaiting socket connections on 0.0.0.0:9094. (kafka.network.DataPlaneAcceptor)
[2025-05-27 20:15:45,456] INFO Awaiting socket connections on 0.0.0.0:9092. (kafka.network.DataPlaneAcceptor)
[2025-05-27 20:15:45,459] INFO [BrokerServer id=1] Waiting for all of the authorizer futures to be completed (kafka.server.BrokerServer)
[2025-05-27 20:15:45,459] INFO [BrokerServer id=1] Finished waiting for all of the authorizer futures to be completed (kafka.server.BrokerServer)
[2025-05-27 20:15:45,459] INFO [BrokerServer id=1] Waiting for all of the SocketServer Acceptors to be started (kafka.server.BrokerServer)
[2025-05-27 20:15:45,459] INFO [BrokerServer id=1] Finished waiting for all of the SocketServer Acceptors to be started (kafka.server.BrokerServer)
[2025-05-27 20:15:45,460] INFO [BrokerServer id=1] Transition from STARTING to STARTED (kafka.server.BrokerServer)
[2025-05-27 20:15:45,460] INFO Kafka version: 4.0.0 (org.apache.kafka.common.utils.AppInfoParser)
[2025-05-27 20:15:45,460] INFO Kafka commitId: 985bc99521dd22bb (org.apache.kafka.common.utils.AppInfoParser)
[2025-05-27 20:15:45,460] INFO Kafka startTimeMs: 1748344545460 (org.apache.kafka.common.utils.AppInfoParser)
[2025-05-27 20:15:45,461] INFO [KafkaRaftServer nodeId=1] Kafka Server started (kafka.server.KafkaRaftServer)
[2025-05-27 20:23:30,818] INFO [ReplicaFetcherManager on broker 1] Removed fetcher for partitions Set(test-topic-0) (kafka.server.ReplicaFetcherManager)
[2025-05-27 20:23:30,832] INFO [LogLoader partition=test-topic-0, dir=/app/kafka4/data/kraft-combined-logs] Loading producer state till offset 0 (org.apache.kafka.storage.internals.log.UnifiedLog)
[2025-05-27 20:23:30,835] INFO Created log for partition test-topic-0 in /app/kafka4/data/kraft-combined-logs/test-topic-0 with properties {} (kafka.log.LogManager)
[2025-05-27 20:23:30,836] INFO [Partition test-topic-0 broker=1] No checkpointed highwatermark is found for partition test-topic-0 (kafka.cluster.Partition)
[2025-05-27 20:23:30,837] INFO [Partition test-topic-0 broker=1] Log loaded for partition test-topic-0 with initial high watermark 0 (kafka.cluster.Partition)
[2025-05-27 20:25:45,137] INFO [RaftManager id=1] Node -4 disconnected. (org.apache.kafka.clients.NetworkClient)
[2025-05-27 20:25:45,344] INFO [RaftManager id=1] Node -3 disconnected. (org.apache.kafka.clients.NetworkClient)
[2025-05-27 20:25:45,345] INFO [NodeToControllerChannelManager id=1 name=registration] Node 2 disconnected. (org.apache.kafka.clients.NetworkClient)
[2025-05-27 20:26:03,853] INFO [ReplicaFetcherManager on broker 1] Removed fetcher for partitions Set(__consumer_offsets-13, __consumer_offsets-46, __consumer_offsets-9, __consumer_offsets-42, __consumer_offsets-22, __consumer_offsets-17, __consumer_offsets-49, __consumer_offsets-18, __consumer_offsets-30, __consumer_offsets-27, __consumer_offsets-25, __consumer_offsets-39, __consumer_offsets-8, __consumer_offsets-38, __consumer_offsets-3, __consumer_offsets-33, __consumer_offsets-2) (kafka.server.ReplicaFetcherManager)
[2025-05-27 20:26:03,856] INFO [LogLoader partition=__consumer_offsets-13, dir=/app/kafka4/data/kraft-combined-logs] Loading producer state till offset 0 (org.apache.kafka.storage.internals.log.UnifiedLog)
[2025-05-27 20:26:03,857] INFO Created log for partition __consumer_offsets-13 in /app/kafka4/data/kraft-combined-logs/__consumer_offsets-13 with properties {cleanup.policy=compact, compression.type="producer", segment.bytes=104857600} (kafka.log.LogManager)
[2025-05-27 20:26:03,857] INFO [Partition __consumer_offsets-13 broker=1] No checkpointed highwatermark is found for partition __consumer_offsets-13 (kafka.cluster.Partition)
[2025-05-27 20:26:03,858] INFO [Partition __consumer_offsets-13 broker=1] Log loaded for partition __consumer_offsets-13 with initial high watermark 0 (kafka.cluster.Partition)
[2025-05-27 20:26:03,862] INFO [LogLoader partition=__consumer_offsets-46, dir=/app/kafka4/data/kraft-combined-logs] Loading producer state till offset 0 (org.apache.kafka.storage.internals.log.UnifiedLog)
[2025-05-27 20:26:03,863] INFO Created log for partition __consumer_offsets-46 in /app/kafka4/data/kraft-combined-logs/__consumer_offsets-46 with properties {cleanup.policy=compact, compression.type="producer", segment.bytes=104857600} (kafka.log.LogManager)
[2025-05-27 20:26:03,863] INFO [Partition __consumer_offsets-46 broker=1] No checkpointed highwatermark is found for partition __consumer_offsets-46 (kafka.cluster.Partition)
[2025-05-27 20:26:03,864] INFO [Partition __consumer_offsets-46 broker=1] Log loaded for partition __consumer_offsets-46 with initial high watermark 0 (kafka.cluster.Partition)
[2025-05-27 20:26:03,868] INFO [LogLoader partition=__consumer_offsets-9, dir=/app/kafka4/data/kraft-combined-logs] Loading producer state till offset 0 (org.apache.kafka.storage.internals.log.UnifiedLog)
[2025-05-27 20:26:03,868] INFO Created log for partition __consumer_offsets-9 in /app/kafka4/data/kraft-combined-logs/__consumer_offsets-9 with properties {cleanup.policy=compact, compression.type="producer", segment.bytes=104857600} (kafka.log.LogManager)
[2025-05-27 20:26:03,868] INFO [Partition __consumer_offsets-9 broker=1] No checkpointed highwatermark is found for partition __consumer_offsets-9 (kafka.cluster.Partition)
[2025-05-27 20:26:03,868] INFO [Partition __consumer_offsets-9 broker=1] Log loaded for partition __consumer_offsets-9 with initial high watermark 0 (kafka.cluster.Partition)
[2025-05-27 20:26:03,872] INFO [LogLoader partition=__consumer_offsets-42, dir=/app/kafka4/data/kraft-combined-logs] Loading producer state till offset 0 (org.apache.kafka.storage.internals.log.UnifiedLog)
[2025-05-27 20:26:03,872] INFO Created log for partition __consumer_offsets-42 in /app/kafka4/data/kraft-combined-logs/__consumer_offsets-42 with properties {cleanup.policy=compact, compression.type="producer", segment.bytes=104857600} (kafka.log.LogManager)
[2025-05-27 20:26:03,872] INFO [Partition __consumer_offsets-42 broker=1] No checkpointed highwatermark is found for partition __consumer_offsets-42 (kafka.cluster.Partition)
[2025-05-27 20:26:03,873] INFO [Partition __consumer_offsets-42 broker=1] Log loaded for partition __consumer_offsets-42 with initial high watermark 0 (kafka.cluster.Partition)
[2025-05-27 20:26:03,877] INFO [LogLoader partition=__consumer_offsets-22, dir=/app/kafka4/data/kraft-combined-logs] Loading producer state till offset 0 (org.apache.kafka.storage.internals.log.UnifiedLog)
[2025-05-27 20:26:03,877] INFO Created log for partition __consumer_offsets-22 in /app/kafka4/data/kraft-combined-logs/__consumer_offsets-22 with properties {cleanup.policy=compact, compression.type="producer", segment.bytes=104857600} (kafka.log.LogManager)
[2025-05-27 20:26:03,877] INFO [Partition __consumer_offsets-22 broker=1] No checkpointed highwatermark is found for partition __consumer_offsets-22 (kafka.cluster.Partition)
[2025-05-27 20:26:03,877] INFO [Partition __consumer_offsets-22 broker=1] Log loaded for partition __consumer_offsets-22 with initial high watermark 0 (kafka.cluster.Partition)
[2025-05-27 20:26:03,882] INFO [LogLoader partition=__consumer_offsets-17, dir=/app/kafka4/data/kraft-combined-logs] Loading producer state till offset 0 (org.apache.kafka.storage.internals.log.UnifiedLog)
[2025-05-27 20:26:03,883] INFO Created log for partition __consumer_offsets-17 in /app/kafka4/data/kraft-combined-logs/__consumer_offsets-17 with properties {cleanup.policy=compact, compression.type="producer", segment.bytes=104857600} (kafka.log.LogManager)
[2025-05-27 20:26:03,883] INFO [Partition __consumer_offsets-17 broker=1] No checkpointed highwatermark is found for partition __consumer_offsets-17 (kafka.cluster.Partition)
[2025-05-27 20:26:03,883] INFO [Partition __consumer_offsets-17 broker=1] Log loaded for partition __consumer_offsets-17 with initial high watermark 0 (kafka.cluster.Partition)
[2025-05-27 20:26:03,888] INFO [LogLoader partition=__consumer_offsets-49, dir=/app/kafka4/data/kraft-combined-logs] Loading producer state till offset 0 (org.apache.kafka.storage.internals.log.UnifiedLog)
[2025-05-27 20:26:03,888] INFO Created log for partition __consumer_offsets-49 in /app/kafka4/data/kraft-combined-logs/__consumer_offsets-49 with properties {cleanup.policy=compact, compression.type="producer", segment.bytes=104857600} (kafka.log.LogManager)
[2025-05-27 20:26:03,889] INFO [Partition __consumer_offsets-49 broker=1] No checkpointed highwatermark is found for partition __consumer_offsets-49 (kafka.cluster.Partition)
[2025-05-27 20:26:03,889] INFO [Partition __consumer_offsets-49 broker=1] Log loaded for partition __consumer_offsets-49 with initial high watermark 0 (kafka.cluster.Partition)
[2025-05-27 20:26:03,895] INFO [LogLoader partition=__consumer_offsets-18, dir=/app/kafka4/data/kraft-combined-logs] Loading producer state till offset 0 (org.apache.kafka.storage.internals.log.UnifiedLog)
[2025-05-27 20:26:03,895] INFO Created log for partition __consumer_offsets-18 in /app/kafka4/data/kraft-combined-logs/__consumer_offsets-18 with properties {cleanup.policy=compact, compression.type="producer", segment.bytes=104857600} (kafka.log.LogManager)
[2025-05-27 20:26:03,896] INFO [Partition __consumer_offsets-18 broker=1] No checkpointed highwatermark is found for partition __consumer_offsets-18 (kafka.cluster.Partition)
[2025-05-27 20:26:03,896] INFO [Partition __consumer_offsets-18 broker=1] Log loaded for partition __consumer_offsets-18 with initial high watermark 0 (kafka.cluster.Partition)
[2025-05-27 20:26:03,900] INFO [LogLoader partition=__consumer_offsets-30, dir=/app/kafka4/data/kraft-combined-logs] Loading producer state till offset 0 (org.apache.kafka.storage.internals.log.UnifiedLog)
[2025-05-27 20:26:03,901] INFO Created log for partition __consumer_offsets-30 in /app/kafka4/data/kraft-combined-logs/__consumer_offsets-30 with properties {cleanup.policy=compact, compression.type="producer", segment.bytes=104857600} (kafka.log.LogManager)
[2025-05-27 20:26:03,901] INFO [Partition __consumer_offsets-30 broker=1] No checkpointed highwatermark is found for partition __consumer_offsets-30 (kafka.cluster.Partition)
[2025-05-27 20:26:03,901] INFO [Partition __consumer_offsets-30 broker=1] Log loaded for partition __consumer_offsets-30 with initial high watermark 0 (kafka.cluster.Partition)
[2025-05-27 20:26:03,905] INFO [LogLoader partition=__consumer_offsets-27, dir=/app/kafka4/data/kraft-combined-logs] Loading producer state till offset 0 (org.apache.kafka.storage.internals.log.UnifiedLog)
[2025-05-27 20:26:03,905] INFO Created log for partition __consumer_offsets-27 in /app/kafka4/data/kraft-combined-logs/__consumer_offsets-27 with properties {cleanup.policy=compact, compression.type="producer", segment.bytes=104857600} (kafka.log.LogManager)
[2025-05-27 20:26:03,905] INFO [Partition __consumer_offsets-27 broker=1] No checkpointed highwatermark is found for partition __consumer_offsets-27 (kafka.cluster.Partition)
[2025-05-27 20:26:03,905] INFO [Partition __consumer_offsets-27 broker=1] Log loaded for partition __consumer_offsets-27 with initial high watermark 0 (kafka.cluster.Partition)
[2025-05-27 20:26:03,910] INFO [LogLoader partition=__consumer_offsets-25, dir=/app/kafka4/data/kraft-combined-logs] Loading producer state till offset 0 (org.apache.kafka.storage.internals.log.UnifiedLog)
[2025-05-27 20:26:03,910] INFO Created log for partition __consumer_offsets-25 in /app/kafka4/data/kraft-combined-logs/__consumer_offsets-25 with properties {cleanup.policy=compact, compression.type="producer", segment.bytes=104857600} (kafka.log.LogManager)
[2025-05-27 20:26:03,910] INFO [Partition __consumer_offsets-25 broker=1] No checkpointed highwatermark is found for partition __consumer_offsets-25 (kafka.cluster.Partition)
[2025-05-27 20:26:03,910] INFO [Partition __consumer_offsets-25 broker=1] Log loaded for partition __consumer_offsets-25 with initial high watermark 0 (kafka.cluster.Partition)
[2025-05-27 20:26:03,914] INFO [LogLoader partition=__consumer_offsets-39, dir=/app/kafka4/data/kraft-combined-logs] Loading producer state till offset 0 (org.apache.kafka.storage.internals.log.UnifiedLog)
[2025-05-27 20:26:03,915] INFO Created log for partition __consumer_offsets-39 in /app/kafka4/data/kraft-combined-logs/__consumer_offsets-39 with properties {cleanup.policy=compact, compression.type="producer", segment.bytes=104857600} (kafka.log.LogManager)
[2025-05-27 20:26:03,916] INFO [Partition __consumer_offsets-39 broker=1] No checkpointed highwatermark is found for partition __consumer_offsets-39 (kafka.cluster.Partition)
[2025-05-27 20:26:03,916] INFO [Partition __consumer_offsets-39 broker=1] Log loaded for partition __consumer_offsets-39 with initial high watermark 0 (kafka.cluster.Partition)
[2025-05-27 20:26:03,919] INFO [LogLoader partition=__consumer_offsets-8, dir=/app/kafka4/data/kraft-combined-logs] Loading producer state till offset 0 (org.apache.kafka.storage.internals.log.UnifiedLog)
[2025-05-27 20:26:03,920] INFO Created log for partition __consumer_offsets-8 in /app/kafka4/data/kraft-combined-logs/__consumer_offsets-8 with properties {cleanup.policy=compact, compression.type="producer", segment.bytes=104857600} (kafka.log.LogManager)
[2025-05-27 20:26:03,920] INFO [Partition __consumer_offsets-8 broker=1] No checkpointed highwatermark is found for partition __consumer_offsets-8 (kafka.cluster.Partition)
[2025-05-27 20:26:03,920] INFO [Partition __consumer_offsets-8 broker=1] Log loaded for partition __consumer_offsets-8 with initial high watermark 0 (kafka.cluster.Partition)
[2025-05-27 20:26:03,925] INFO [LogLoader partition=__consumer_offsets-38, dir=/app/kafka4/data/kraft-combined-logs] Loading producer state till offset 0 (org.apache.kafka.storage.internals.log.UnifiedLog)
[2025-05-27 20:26:03,925] INFO Created log for partition __consumer_offsets-38 in /app/kafka4/data/kraft-combined-logs/__consumer_offsets-38 with properties {cleanup.policy=compact, compression.type="producer", segment.bytes=104857600} (kafka.log.LogManager)
[2025-05-27 20:26:03,925] INFO [Partition __consumer_offsets-38 broker=1] No checkpointed highwatermark is found for partition __consumer_offsets-38 (kafka.cluster.Partition)
[2025-05-27 20:26:03,925] INFO [Partition __consumer_offsets-38 broker=1] Log loaded for partition __consumer_offsets-38 with initial high watermark 0 (kafka.cluster.Partition)
[2025-05-27 20:26:03,929] INFO [LogLoader partition=__consumer_offsets-3, dir=/app/kafka4/data/kraft-combined-logs] Loading producer state till offset 0 (org.apache.kafka.storage.internals.log.UnifiedLog)
[2025-05-27 20:26:03,930] INFO Created log for partition __consumer_offsets-3 in /app/kafka4/data/kraft-combined-logs/__consumer_offsets-3 with properties {cleanup.policy=compact, compression.type="producer", segment.bytes=104857600} (kafka.log.LogManager)
[2025-05-27 20:26:03,930] INFO [Partition __consumer_offsets-3 broker=1] No checkpointed highwatermark is found for partition __consumer_offsets-3 (kafka.cluster.Partition)
[2025-05-27 20:26:03,930] INFO [Partition __consumer_offsets-3 broker=1] Log loaded for partition __consumer_offsets-3 with initial high watermark 0 (kafka.cluster.Partition)
[2025-05-27 20:26:03,934] INFO [LogLoader partition=__consumer_offsets-33, dir=/app/kafka4/data/kraft-combined-logs] Loading producer state till offset 0 (org.apache.kafka.storage.internals.log.UnifiedLog)
[2025-05-27 20:26:03,934] INFO Created log for partition __consumer_offsets-33 in /app/kafka4/data/kraft-combined-logs/__consumer_offsets-33 with properties {cleanup.policy=compact, compression.type="producer", segment.bytes=104857600} (kafka.log.LogManager)
[2025-05-27 20:26:03,934] INFO [Partition __consumer_offsets-33 broker=1] No checkpointed highwatermark is found for partition __consumer_offsets-33 (kafka.cluster.Partition)
[2025-05-27 20:26:03,935] INFO [Partition __consumer_offsets-33 broker=1] Log loaded for partition __consumer_offsets-33 with initial high watermark 0 (kafka.cluster.Partition)
[2025-05-27 20:26:03,939] INFO [LogLoader partition=__consumer_offsets-2, dir=/app/kafka4/data/kraft-combined-logs] Loading producer state till offset 0 (org.apache.kafka.storage.internals.log.UnifiedLog)
[2025-05-27 20:26:03,940] INFO Created log for partition __consumer_offsets-2 in /app/kafka4/data/kraft-combined-logs/__consumer_offsets-2 with properties {cleanup.policy=compact, compression.type="producer", segment.bytes=104857600} (kafka.log.LogManager)
[2025-05-27 20:26:03,940] INFO [Partition __consumer_offsets-2 broker=1] No checkpointed highwatermark is found for partition __consumer_offsets-2 (kafka.cluster.Partition)
[2025-05-27 20:26:03,940] INFO [Partition __consumer_offsets-2 broker=1] Log loaded for partition __consumer_offsets-2 with initial high watermark 0 (kafka.cluster.Partition)
[2025-05-27 20:26:03,944] INFO [GroupCoordinator id=1] Scheduling loading of metadata from __consumer_offsets-13 with epoch 0 (org.apache.kafka.coordinator.common.runtime.CoordinatorRuntime)
[2025-05-27 20:26:03,948] INFO [GroupCoordinator id=1] Scheduling loading of metadata from __consumer_offsets-46 with epoch 0 (org.apache.kafka.coordinator.common.runtime.CoordinatorRuntime)
[2025-05-27 20:26:03,948] INFO [GroupCoordinator id=1] Scheduling loading of metadata from __consumer_offsets-9 with epoch 0 (org.apache.kafka.coordinator.common.runtime.CoordinatorRuntime)
[2025-05-27 20:26:03,948] INFO [GroupCoordinator id=1] Scheduling loading of metadata from __consumer_offsets-42 with epoch 0 (org.apache.kafka.coordinator.common.runtime.CoordinatorRuntime)
[2025-05-27 20:26:03,949] INFO [GroupCoordinator id=1] Scheduling loading of metadata from __consumer_offsets-22 with epoch 0 (org.apache.kafka.coordinator.common.runtime.CoordinatorRuntime)
[2025-05-27 20:26:03,949] INFO [GroupCoordinator id=1] Scheduling loading of metadata from __consumer_offsets-17 with epoch 0 (org.apache.kafka.coordinator.common.runtime.CoordinatorRuntime)
[2025-05-27 20:26:03,949] INFO [GroupCoordinator id=1] Scheduling loading of metadata from __consumer_offsets-49 with epoch 0 (org.apache.kafka.coordinator.common.runtime.CoordinatorRuntime)
[2025-05-27 20:26:03,949] INFO [GroupCoordinator id=1] Scheduling loading of metadata from __consumer_offsets-18 with epoch 0 (org.apache.kafka.coordinator.common.runtime.CoordinatorRuntime)
[2025-05-27 20:26:03,950] INFO [GroupCoordinator id=1] Scheduling loading of metadata from __consumer_offsets-30 with epoch 0 (org.apache.kafka.coordinator.common.runtime.CoordinatorRuntime)
[2025-05-27 20:26:03,951] INFO [GroupCoordinator id=1] Scheduling loading of metadata from __consumer_offsets-27 with epoch 0 (org.apache.kafka.coordinator.common.runtime.CoordinatorRuntime)
[2025-05-27 20:26:03,952] INFO [GroupCoordinator id=1] Scheduling loading of metadata from __consumer_offsets-25 with epoch 0 (org.apache.kafka.coordinator.common.runtime.CoordinatorRuntime)
[2025-05-27 20:26:03,952] INFO [GroupCoordinator id=1] Scheduling loading of metadata from __consumer_offsets-39 with epoch 0 (org.apache.kafka.coordinator.common.runtime.CoordinatorRuntime)
[2025-05-27 20:26:03,952] INFO [GroupCoordinator id=1] Scheduling loading of metadata from __consumer_offsets-8 with epoch 0 (org.apache.kafka.coordinator.common.runtime.CoordinatorRuntime)
[2025-05-27 20:26:03,952] INFO [GroupCoordinator id=1] Scheduling loading of metadata from __consumer_offsets-38 with epoch 0 (org.apache.kafka.coordinator.common.runtime.CoordinatorRuntime)
[2025-05-27 20:26:03,952] INFO [GroupCoordinator id=1] Scheduling loading of metadata from __consumer_offsets-3 with epoch 0 (org.apache.kafka.coordinator.common.runtime.CoordinatorRuntime)
[2025-05-27 20:26:03,952] INFO [GroupCoordinator id=1] Scheduling loading of metadata from __consumer_offsets-33 with epoch 0 (org.apache.kafka.coordinator.common.runtime.CoordinatorRuntime)
[2025-05-27 20:26:03,952] INFO [GroupCoordinator id=1] Scheduling loading of metadata from __consumer_offsets-2 with epoch 0 (org.apache.kafka.coordinator.common.runtime.CoordinatorRuntime)
[2025-05-27 20:26:03,956] INFO [DynamicConfigPublisher broker id=1] Updating topic __consumer_offsets with new configuration : compression.type -> producer,cleanup.policy -> compact,segment.bytes -> 104857600 (kafka.server.metadata.DynamicConfigPublisher)
[2025-05-27 20:26:03,966] INFO [GroupCoordinator id=1] Finished loading of metadata from __consumer_offsets-9 with epoch 0 in 4ms where 4ms was spent in the scheduler. Loaded 0 records which total to 0 bytes. (org.apache.kafka.coordinator.common.runtime.CoordinatorRuntime)
[2025-05-27 20:26:03,966] INFO [GroupCoordinator id=1] Finished loading of metadata from __consumer_offsets-46 with epoch 0 in 4ms where 4ms was spent in the scheduler. Loaded 0 records which total to 0 bytes. (org.apache.kafka.coordinator.common.runtime.CoordinatorRuntime)
[2025-05-27 20:26:03,966] INFO [GroupCoordinator id=1] Finished loading of metadata from __consumer_offsets-13 with epoch 0 in 4ms where 4ms was spent in the scheduler. Loaded 0 records which total to 0 bytes. (org.apache.kafka.coordinator.common.runtime.CoordinatorRuntime)
[2025-05-27 20:26:03,967] INFO [GroupCoordinator id=1] Finished loading of metadata from __consumer_offsets-39 with epoch 0 in 2ms where 2ms was spent in the scheduler. Loaded 0 records which total to 0 bytes. (org.apache.kafka.coordinator.common.runtime.CoordinatorRuntime)
[2025-05-27 20:26:03,967] INFO [GroupCoordinator id=1] Finished loading of metadata from __consumer_offsets-49 with epoch 0 in 1ms where 1ms was spent in the scheduler. Loaded 0 records which total to 0 bytes. (org.apache.kafka.coordinator.common.runtime.CoordinatorRuntime)
[2025-05-27 20:26:03,967] INFO [GroupCoordinator id=1] Finished loading of metadata from __consumer_offsets-25 with epoch 0 in 1ms where 1ms was spent in the scheduler. Loaded 0 records which total to 0 bytes. (org.apache.kafka.coordinator.common.runtime.CoordinatorRuntime)
[2025-05-27 20:26:03,967] INFO [GroupCoordinator id=1] Finished loading of metadata from __consumer_offsets-42 with epoch 0 in 4ms where 2ms was spent in the scheduler. Loaded 0 records which total to 0 bytes. (org.apache.kafka.coordinator.common.runtime.CoordinatorRuntime)
[2025-05-27 20:26:03,967] INFO [GroupCoordinator id=1] Finished loading of metadata from __consumer_offsets-27 with epoch 0 in 2ms where 2ms was spent in the scheduler. Loaded 0 records which total to 0 bytes. (org.apache.kafka.coordinator.common.runtime.CoordinatorRuntime)
[2025-05-27 20:26:03,967] INFO [GroupCoordinator id=1] Finished loading of metadata from __consumer_offsets-8 with epoch 0 in 2ms where 2ms was spent in the scheduler. Loaded 0 records which total to 0 bytes. (org.apache.kafka.coordinator.common.runtime.CoordinatorRuntime)
[2025-05-27 20:26:03,967] INFO [GroupCoordinator id=1] Finished loading of metadata from __consumer_offsets-18 with epoch 0 in 2ms where 2ms was spent in the scheduler. Loaded 0 records which total to 0 bytes. (org.apache.kafka.coordinator.common.runtime.CoordinatorRuntime)
[2025-05-27 20:26:03,967] INFO [GroupCoordinator id=1] Finished loading of metadata from __consumer_offsets-2 with epoch 0 in 1ms where 1ms was spent in the scheduler. Loaded 0 records which total to 0 bytes. (org.apache.kafka.coordinator.common.runtime.CoordinatorRuntime)
[2025-05-27 20:26:03,967] INFO [GroupCoordinator id=1] Finished loading of metadata from __consumer_offsets-17 with epoch 0 in 1ms where 1ms was spent in the scheduler. Loaded 0 records which total to 0 bytes. (org.apache.kafka.coordinator.common.runtime.CoordinatorRuntime)
[2025-05-27 20:26:03,967] INFO [GroupCoordinator id=1] Finished loading of metadata from __consumer_offsets-3 with epoch 0 in 1ms where 1ms was spent in the scheduler. Loaded 0 records which total to 0 bytes. (org.apache.kafka.coordinator.common.runtime.CoordinatorRuntime)
[2025-05-27 20:26:03,967] INFO [GroupCoordinator id=1] Finished loading of metadata from __consumer_offsets-22 with epoch 0 in 1ms where 1ms was spent in the scheduler. Loaded 0 records which total to 0 bytes. (org.apache.kafka.coordinator.common.runtime.CoordinatorRuntime)
[2025-05-27 20:26:03,967] INFO [GroupCoordinator id=1] Finished loading of metadata from __consumer_offsets-33 with epoch 0 in 1ms where 1ms was spent in the scheduler. Loaded 0 records which total to 0 bytes. (org.apache.kafka.coordinator.common.runtime.CoordinatorRuntime)
[2025-05-27 20:26:03,967] INFO [GroupCoordinator id=1] Finished loading of metadata from __consumer_offsets-38 with epoch 0 in 2ms where 2ms was spent in the scheduler. Loaded 0 records which total to 0 bytes. (org.apache.kafka.coordinator.common.runtime.CoordinatorRuntime)
[2025-05-27 20:26:03,967] INFO [GroupCoordinator id=1] Finished loading of metadata from __consumer_offsets-30 with epoch 0 in 1ms where 1ms was spent in the scheduler. Loaded 0 records which total to 0 bytes. (org.apache.kafka.coordinator.common.runtime.CoordinatorRuntime)
[2025-05-27 20:26:04,395] INFO [GroupCoordinator id=1 topic=__consumer_offsets partition=27] Dynamic member with unknown member id joins group console-consumer-78795 in Empty state. Created a new member id console-consumer-d4a94e16-d5b2-43b7-973f-5751f06c343c and requesting the member to rejoin with this id. (org.apache.kafka.coordinator.group.GroupMetadataManager)
[2025-05-27 20:26:04,402] INFO [GroupCoordinator id=1 topic=__consumer_offsets partition=27] Pending dynamic member with id console-consumer-d4a94e16-d5b2-43b7-973f-5751f06c343c joins group console-consumer-78795 in Empty state. Adding to the group now. (org.apache.kafka.coordinator.group.GroupMetadataManager)
[2025-05-27 20:26:04,403] INFO [GroupCoordinator id=1 topic=__consumer_offsets partition=27] Preparing to rebalance group console-consumer-78795 in state PreparingRebalance with old generation 0 (reason: Adding new member console-consumer-d4a94e16-d5b2-43b7-973f-5751f06c343c with group instance id null; client reason: need to re-join with the given member-id: console-consumer-d4a94e16-d5b2-43b7-973f-5751f06c343c). (org.apache.kafka.coordinator.group.GroupMetadataManager)
[2025-05-27 20:26:07,408] INFO [GroupCoordinator id=1 topic=__consumer_offsets partition=27] Stabilized group console-consumer-78795 generation 1 with 1 members. (org.apache.kafka.coordinator.group.GroupMetadataManager)
[2025-05-27 20:26:07,426] INFO [GroupCoordinator id=1 topic=__consumer_offsets partition=27] Assignment received from leader console-consumer-d4a94e16-d5b2-43b7-973f-5751f06c343c for group console-consumer-78795 for generation 1. The group has 1 members, 0 of which are static. (org.apache.kafka.coordinator.group.GroupMetadataManager)
[2025-05-27 20:28:02,333] INFO [GroupCoordinator id=1 topic=__consumer_offsets partition=27] [Group console-consumer-78795] Member console-consumer-d4a94e16-d5b2-43b7-973f-5751f06c343c has left group through explicit `LeaveGroup` request; client reason: the consumer is being closed (org.apache.kafka.coordinator.group.GroupMetadataManager)
[2025-05-27 20:28:02,334] INFO [GroupCoordinator id=1 topic=__consumer_offsets partition=27] Preparing to rebalance group console-consumer-78795 in state PreparingRebalance with old generation 1 (reason: explicit `LeaveGroup` request for (console-consumer-d4a94e16-d5b2-43b7-973f-5751f06c343c) members.). (org.apache.kafka.coordinator.group.GroupMetadataManager)
[2025-05-27 20:28:02,334] INFO [GroupCoordinator id=1 topic=__consumer_offsets partition=27] Group console-consumer-78795 with generation 2 is now empty. (org.apache.kafka.coordinator.group.GroupMetadataManager)
[2025-05-27 20:34:44,934] INFO [NodeToControllerChannelManager id=1 name=forwarding] Node 2 disconnected. (org.apache.kafka.clients.NetworkClient)
[2025-05-27 20:36:03,968] INFO [GroupCoordinator id=1 topic=__consumer_offsets partition=27] Generated 1 tombstone records while cleaning up group metadata in 0 milliseconds. (org.apache.kafka.coordinator.group.GroupCoordinatorShard)
[2025-05-27 21:15:45,356] INFO [SnapshotGenerator id=1] Creating new KRaft snapshot file snapshot 00000000000000007271-0000000001 because we have waited at least 60 minute(s). (org.apache.kafka.image.publisher.SnapshotGenerator)
[2025-05-27 21:15:45,377] INFO [SnapshotEmitter id=1] Successfully wrote snapshot 00000000000000007271-0000000001 (org.apache.kafka.image.publisher.SnapshotEmitter)
[2025-05-27 22:15:45,423] INFO [SnapshotGenerator id=1] Creating new KRaft snapshot file snapshot 00000000000000014470-0000000001 because we have waited at least 60 minute(s). (org.apache.kafka.image.publisher.SnapshotGenerator)
[2025-05-27 22:15:45,429] INFO [SnapshotEmitter id=1] Successfully wrote snapshot 00000000000000014470-0000000001 (org.apache.kafka.image.publisher.SnapshotEmitter)
[2025-05-27 23:15:45,469] INFO [SnapshotGenerator id=1] Creating new KRaft snapshot file snapshot 00000000000000021669-0000000001 because we have waited at least 60 minute(s). (org.apache.kafka.image.publisher.SnapshotGenerator)
[2025-05-27 23:15:45,473] INFO [SnapshotEmitter id=1] Successfully wrote snapshot 00000000000000021669-0000000001 (org.apache.kafka.image.publisher.SnapshotEmitter)
[2025-05-28 00:15:45,536] INFO [SnapshotGenerator id=1] Creating new KRaft snapshot file snapshot 00000000000000028868-0000000001 because we have waited at least 60 minute(s). (org.apache.kafka.image.publisher.SnapshotGenerator)
[2025-05-28 00:15:45,540] INFO [SnapshotEmitter id=1] Successfully wrote snapshot 00000000000000028868-0000000001 (org.apache.kafka.image.publisher.SnapshotEmitter)
[2025-05-28 01:15:45,595] INFO [SnapshotGenerator id=1] Creating new KRaft snapshot file snapshot 00000000000000036067-0000000001 because we have waited at least 60 minute(s). (org.apache.kafka.image.publisher.SnapshotGenerator)
[2025-05-28 01:15:45,599] INFO [SnapshotEmitter id=1] Successfully wrote snapshot 00000000000000036067-0000000001 (org.apache.kafka.image.publisher.SnapshotEmitter)
[2025-05-28 02:15:45,654] INFO [SnapshotGenerator id=1] Creating new KRaft snapshot file snapshot 00000000000000043266-0000000001 because we have waited at least 60 minute(s). (org.apache.kafka.image.publisher.SnapshotGenerator)
[2025-05-28 02:15:45,658] INFO [SnapshotEmitter id=1] Successfully wrote snapshot 00000000000000043266-0000000001 (org.apache.kafka.image.publisher.SnapshotEmitter)
[2025-05-28 03:15:45,716] INFO [SnapshotGenerator id=1] Creating new KRaft snapshot file snapshot 00000000000000050465-0000000001 because we have waited at least 60 minute(s). (org.apache.kafka.image.publisher.SnapshotGenerator)
[2025-05-28 03:15:45,720] INFO [SnapshotEmitter id=1] Successfully wrote snapshot 00000000000000050465-0000000001 (org.apache.kafka.image.publisher.SnapshotEmitter)
[2025-05-28 04:15:45,789] INFO [SnapshotGenerator id=1] Creating new KRaft snapshot file snapshot 00000000000000057664-0000000001 because we have waited at least 60 minute(s). (org.apache.kafka.image.publisher.SnapshotGenerator)
[2025-05-28 04:15:45,799] INFO [SnapshotEmitter id=1] Successfully wrote snapshot 00000000000000057664-0000000001 (org.apache.kafka.image.publisher.SnapshotEmitter)
[2025-05-28 05:15:45,877] INFO [SnapshotGenerator id=1] Creating new KRaft snapshot file snapshot 00000000000000064863-0000000001 because we have waited at least 60 minute(s). (org.apache.kafka.image.publisher.SnapshotGenerator)
[2025-05-28 05:15:45,887] INFO [SnapshotEmitter id=1] Successfully wrote snapshot 00000000000000064863-0000000001 (org.apache.kafka.image.publisher.SnapshotEmitter)
[2025-05-28 06:15:45,963] INFO [SnapshotGenerator id=1] Creating new KRaft snapshot file snapshot 00000000000000072062-0000000001 because we have waited at least 60 minute(s). (org.apache.kafka.image.publisher.SnapshotGenerator)
[2025-05-28 06:15:45,974] INFO [SnapshotEmitter id=1] Successfully wrote snapshot 00000000000000072062-0000000001 (org.apache.kafka.image.publisher.SnapshotEmitter)
[2025-05-28 07:15:46,044] INFO [SnapshotGenerator id=1] Creating new KRaft snapshot file snapshot 00000000000000079261-0000000001 because we have waited at least 60 minute(s). (org.apache.kafka.image.publisher.SnapshotGenerator)
[2025-05-28 07:15:46,053] INFO [SnapshotEmitter id=1] Successfully wrote snapshot 00000000000000079261-0000000001 (org.apache.kafka.image.publisher.SnapshotEmitter)
[2025-05-28 08:15:46,132] INFO [SnapshotGenerator id=1] Creating new KRaft snapshot file snapshot 00000000000000086460-0000000001 because we have waited at least 60 minute(s). (org.apache.kafka.image.publisher.SnapshotGenerator)
[2025-05-28 08:15:46,150] INFO [SnapshotEmitter id=1] Successfully wrote snapshot 00000000000000086460-0000000001 (org.apache.kafka.image.publisher.SnapshotEmitter)
[2025-05-28 09:15:46,225] INFO [SnapshotGenerator id=1] Creating new KRaft snapshot file snapshot 00000000000000093659-0000000001 because we have waited at least 60 minute(s). (org.apache.kafka.image.publisher.SnapshotGenerator)
[2025-05-28 09:15:46,240] INFO [SnapshotEmitter id=1] Successfully wrote snapshot 00000000000000093659-0000000001 (org.apache.kafka.image.publisher.SnapshotEmitter)
[2025-05-28 10:15:46,321] INFO [SnapshotGenerator id=1] Creating new KRaft snapshot file snapshot 00000000000000100858-0000000001 because we have waited at least 60 minute(s). (org.apache.kafka.image.publisher.SnapshotGenerator)
[2025-05-28 10:15:46,334] INFO [SnapshotEmitter id=1] Successfully wrote snapshot 00000000000000100858-0000000001 (org.apache.kafka.image.publisher.SnapshotEmitter)
[2025-05-28 11:15:46,414] INFO [SnapshotGenerator id=1] Creating new KRaft snapshot file snapshot 00000000000000108057-0000000001 because we have waited at least 60 minute(s). (org.apache.kafka.image.publisher.SnapshotGenerator)
[2025-05-28 11:15:46,428] INFO [SnapshotEmitter id=1] Successfully wrote snapshot 00000000000000108057-0000000001 (org.apache.kafka.image.publisher.SnapshotEmitter)
[2025-05-28 12:15:46,497] INFO [SnapshotGenerator id=1] Creating new KRaft snapshot file snapshot 00000000000000115256-0000000001 because we have waited at least 60 minute(s). (org.apache.kafka.image.publisher.SnapshotGenerator)
[2025-05-28 12:15:46,509] INFO [SnapshotEmitter id=1] Successfully wrote snapshot 00000000000000115256-0000000001 (org.apache.kafka.image.publisher.SnapshotEmitter)