[jira] [Assigned] (KAFKA-9182) Flaky Test org.apache.kafka.streams.integration.KTableSourceTopicRestartIntegrationTest.shouldRestoreAndProgressWhenTopicWrittenToDuringRestorationWithEosEnabled

[Matthias J. Sax (Jira)]

     [ 
https://issues.apache.org/jira/browse/KAFKA-9182?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel
 ]

Matthias J. Sax reassigned KAFKA-9182:
--------------------------------------

    Assignee:     (was: Matthias J. Sax)

> Flaky Test 
> org.apache.kafka.streams.integration.KTableSourceTopicRestartIntegrationTest.shouldRestoreAndProgressWhenTopicWrittenToDuringRestorationWithEosEnabled
> -----------------------------------------------------------------------------------------------------------------------------------------------------------------
>
>                 Key: KAFKA-9182
>                 URL: https://issues.apache.org/jira/browse/KAFKA-9182
>             Project: Kafka
>          Issue Type: Test
>          Components: streams
>            Reporter: Bill Bejeck
>            Priority: Major
>              Labels: flaky-test, tests
>
> Failed in 
> [https://builds.apache.org/job/kafka-pr-jdk8-scala2.11/26571/testReport/junit/org.apache.kafka.streams.integration/KTableSourceTopicRestartIntegrationTest/shouldRestoreAndProgressWhenTopicWrittenToDuringRestorationWithEosEnabled/]
>  
> {noformat}
> Error Messagejava.lang.AssertionError: Condition not met within timeout 
> 30000. Table did not read all valuesStacktracejava.lang.AssertionError: 
> Condition not met within timeout 30000. Table did not read all values
>       at org.hamcrest.MatcherAssert.assertThat(MatcherAssert.java:24)
>       at 
> org.apache.kafka.test.TestUtils.lambda$waitForCondition$4(TestUtils.java:369)
>       at 
> org.apache.kafka.test.TestUtils.retryOnExceptionWithTimeout(TestUtils.java:417)
>       at 
> org.apache.kafka.test.TestUtils.retryOnExceptionWithTimeout(TestUtils.java:385)
>       at org.apache.kafka.test.TestUtils.waitForCondition(TestUtils.java:368)
>       at org.apache.kafka.test.TestUtils.waitForCondition(TestUtils.java:356)
>       at 
> org.apache.kafka.streams.integration.KTableSourceTopicRestartIntegrationTest.assertNumberValuesRead(KTableSourceTopicRestartIntegrationTest.java:187)
>       at 
> org.apache.kafka.streams.integration.KTableSourceTopicRestartIntegrationTest.shouldRestoreAndProgressWhenTopicWrittenToDuringRestorationWithEosEnabled(KTableSourceTopicRestartIntegrationTest.java:141)
>       at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>       at 
> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
>       at 
> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
>       at java.lang.reflect.Method.invoke(Method.java:498)
>       at 
> org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:59)
>       at 
> org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
>       at 
> org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:56)
>       at 
> org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
>       at 
> org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
>       at 
> org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27)
>       at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:305)
>       at 
> org.junit.runners.BlockJUnit4ClassRunner$1.evaluate(BlockJUnit4ClassRunner.java:100)
>       at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:365)
>       at 
> org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:103)
>       at 
> org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:63)
>       at org.junit.runners.ParentRunner$4.run(ParentRunner.java:330)
>       at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:78)
>       at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:328)
>       at org.junit.runners.ParentRunner.access$100(ParentRunner.java:65)
>       at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:292)
>       at 
> org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
>       at org.junit.rules.ExternalResource$1.evaluate(ExternalResource.java:54)
>       at org.junit.rules.RunRules.evaluate(RunRules.java:20)
>       at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:305)
>       at org.junit.runners.ParentRunner.run(ParentRunner.java:412)
>       at 
> org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecutor.runTestClass(JUnitTestClassExecutor.java:110)
>       at 
> org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecutor.execute(JUnitTestClassExecutor.java:58)
>       at 
> org.gradle.api.internal.tasks.testing.junit.JUnitTestClassExecutor.execute(JUnitTestClassExecutor.java:38)
>       at 
> org.gradle.api.internal.tasks.testing.junit.AbstractJUnitTestClassProcessor.processTestClass(AbstractJUnitTestClassProcessor.java:62)
>       at 
> org.gradle.api.internal.tasks.testing.SuiteTestClassProcessor.processTestClass(SuiteTestClassProcessor.java:51)
>       at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>       at 
> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
>       at 
> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
>       at java.lang.reflect.Method.invoke(Method.java:498)
>       at 
> org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:36)
>       at 
> org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:24)
>       at 
> org.gradle.internal.dispatch.ContextClassLoaderDispatch.dispatch(ContextClassLoaderDispatch.java:33)
>       at 
> org.gradle.internal.dispatch.ProxyDispatchAdapter$DispatchingInvocationHandler.invoke(ProxyDispatchAdapter.java:94)
>       at com.sun.proxy.$Proxy2.processTestClass(Unknown Source)
>       at 
> org.gradle.api.internal.tasks.testing.worker.TestWorker.processTestClass(TestWorker.java:118)
>       at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>       at 
> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
>       at 
> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
>       at java.lang.reflect.Method.invoke(Method.java:498)
>       at 
> org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:36)
>       at 
> org.gradle.internal.dispatch.ReflectionDispatch.dispatch(ReflectionDispatch.java:24)
>       at 
> org.gradle.internal.remote.internal.hub.MessageHubBackedObjectConnection$DispatchWrapper.dispatch(MessageHubBackedObjectConnection.java:182)
>       at 
> org.gradle.internal.remote.internal.hub.MessageHubBackedObjectConnection$DispatchWrapper.dispatch(MessageHubBackedObjectConnection.java:164)
>       at 
> org.gradle.internal.remote.internal.hub.MessageHub$Handler.run(MessageHub.java:412)
>       at 
> org.gradle.internal.concurrent.ExecutorPolicy$CatchAndRecordFailures.onExecute(ExecutorPolicy.java:64)
>       at 
> org.gradle.internal.concurrent.ManagedExecutorImpl$1.run(ManagedExecutorImpl.java:48)
>       at 
> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
>       at 
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
>       at 
> org.gradle.internal.concurrent.ThreadFactoryImpl$ManagedThreadRunnable.run(ThreadFactoryImpl.java:56)
>       at java.lang.Thread.run(Thread.java:748)
> Standard Output[2019-11-13 06:04:49,595] INFO zookeeper.snapshot.trust.empty 
> : false (org.apache.zookeeper.server.persistence.FileTxnSnapLog:103)
> [2019-11-13 06:04:49,595] INFO zookeeper.snapshotSizeFactor = 0.33 
> (org.apache.zookeeper.server.ZKDatabase:117)
> [2019-11-13 06:04:49,596] INFO minSessionTimeout set to 1600 
> (org.apache.zookeeper.server.ZooKeeperServer:938)
> [2019-11-13 06:04:49,596] INFO maxSessionTimeout set to 16000 
> (org.apache.zookeeper.server.ZooKeeperServer:947)
> [2019-11-13 06:04:49,596] INFO Created server with tickTime 800 
> minSessionTimeout 1600 maxSessionTimeout 16000 datadir 
> /tmp/kafka-8546929362712488246/version-2 snapdir 
> /tmp/kafka-5999627801426978574/version-2 
> (org.apache.zookeeper.server.ZooKeeperServer:166)
> [2019-11-13 06:04:49,596] INFO Configuring NIO connection handler with 10s 
> sessionless connection timeout, 3 selector thread(s), 48 worker threads, and 
> 64 kB direct buffers. (org.apache.zookeeper.server.NIOServerCnxnFactory:673)
> [2019-11-13 06:04:49,597] INFO binding to port /127.0.0.1:0 
> (org.apache.zookeeper.server.NIOServerCnxnFactory:686)
> [2019-11-13 06:04:49,598] INFO Snapshotting: 0x0 to 
> /tmp/kafka-5999627801426978574/version-2/snapshot.0 
> (org.apache.zookeeper.server.persistence.FileTxnSnapLog:384)
> [2019-11-13 06:04:49,598] INFO Snapshotting: 0x0 to 
> /tmp/kafka-5999627801426978574/version-2/snapshot.0 
> (org.apache.zookeeper.server.persistence.FileTxnSnapLog:384)
> [2019-11-13 06:04:49,600] INFO KafkaConfig values: 
>       advertised.host.name = null
>       advertised.listeners = null
>       advertised.port = null
>       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.id = 0
>       broker.id.generation.enable = true
>       broker.rack = null
>       client.quota.callback.class = null
>       compression.type = producer
>       connection.failed.authentication.delay.ms = 100
>       connections.max.idle.ms = 600000
>       connections.max.reauth.ms = 0
>       control.plane.listener.name = null
>       controlled.shutdown.enable = true
>       controlled.shutdown.max.retries = 3
>       controlled.shutdown.retry.backoff.ms = 5000
>       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.master.key = null
>       delegation.token.max.lifetime.ms = 604800000
>       delete.records.purgatory.purge.interval.requests = 1
>       delete.topic.enable = true
>       fetch.max.bytes = 57671680
>       fetch.purgatory.purge.interval.requests = 1000
>       group.initial.rebalance.delay.ms = 0
>       group.max.session.timeout.ms = 1800000
>       group.max.size = 2147483647
>       group.min.session.timeout.ms = 0
>       host.name = localhost
>       inter.broker.listener.name = null
>       inter.broker.protocol.version = 2.4-IV1
>       kafka.metrics.polling.interval.secs = 10
>       kafka.metrics.reporters = []
>       leader.imbalance.check.interval.seconds = 300
>       leader.imbalance.per.broker.percentage = 10
>       listener.security.protocol.map = 
> PLAINTEXT:PLAINTEXT,SSL:SSL,SASL_PLAINTEXT:SASL_PLAINTEXT,SASL_SSL:SASL_SSL
>       listeners = null
>       log.cleaner.backoff.ms = 15000
>       log.cleaner.dedupe.buffer.size = 2097152
>       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/junit6760496041183144599/junit6110490013242643385
>       log.dirs = null
>       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.message.downconversion.enable = true
>       log.message.format.version = 2.4-IV1
>       log.message.timestamp.difference.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.connections = 2147483647
>       max.connections.per.ip = 2147483647
>       max.connections.per.ip.overrides = 
>       max.incremental.fetch.session.cache.slots = 1000
>       message.max.bytes = 1000000
>       metric.reporters = []
>       metrics.num.samples = 2
>       metrics.recording.level = INFO
>       metrics.sample.window.ms = 30000
>       min.insync.replicas = 1
>       num.io.threads = 8
>       num.network.threads = 3
>       num.partitions = 1
>       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.required.acks = -1
>       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 = 5
>       offsets.topic.replication.factor = 1
>       offsets.topic.segment.bytes = 104857600
>       password.encoder.cipher.algorithm = AES/CBC/PKCS5Padding
>       password.encoder.iterations = 4096
>       password.encoder.key.length = 128
>       password.encoder.keyfactory.algorithm = null
>       password.encoder.old.secret = null
>       password.encoder.secret = null
>       port = 0
>       principal.builder.class = null
>       producer.purgatory.purge.interval.requests = 1000
>       queued.max.request.bytes = -1
>       queued.max.requests = 500
>       quota.consumer.default = 9223372036854775807
>       quota.producer.default = 9223372036854775807
>       quota.window.num = 11
>       quota.window.size.seconds = 1
>       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
>       reserved.broker.max.id = 1000
>       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.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.mechanism.inter.broker.protocol = GSSAPI
>       sasl.server.callback.handler.class = null
>       security.inter.broker.protocol = PLAINTEXT
>       security.providers = null
>       socket.receive.buffer.bytes = 102400
>       socket.request.max.bytes = 104857600
>       socket.send.buffer.bytes = 102400
>       ssl.cipher.suites = []
>       ssl.client.auth = none
>       ssl.enabled.protocols = [TLSv1.2, TLSv1.1, TLSv1]
>       ssl.endpoint.identification.algorithm = https
>       ssl.key.password = null
>       ssl.keymanager.algorithm = SunX509
>       ssl.keystore.location = null
>       ssl.keystore.password = null
>       ssl.keystore.type = JKS
>       ssl.principal.mapping.rules = DEFAULT
>       ssl.protocol = TLS
>       ssl.provider = null
>       ssl.secure.random.implementation = null
>       ssl.trustmanager.algorithm = PKIX
>       ssl.truststore.location = null
>       ssl.truststore.password = null
>       ssl.truststore.type = JKS
>       transaction.abort.timed.out.transaction.cleanup.interval.ms = 60000
>       transaction.max.timeout.ms = 900000
>       transaction.remove.expired.transaction.cleanup.interval.ms = 3600000
>       transaction.state.log.load.buffer.size = 5242880
>       transaction.state.log.min.isr = 2
>       transaction.state.log.num.partitions = 50
>       transaction.state.log.replication.factor = 3
>       transaction.state.log.segment.bytes = 104857600
>       transactional.id.expiration.ms = 604800000
>       unclean.leader.election.enable = false
>       zookeeper.connect = 127.0.0.1:34936
>       zookeeper.connection.timeout.ms = null
>       zookeeper.max.in.flight.requests = 10
>       zookeeper.session.timeout.ms = 10000
>       zookeeper.set.acl = false
>       zookeeper.sync.time.ms = 2000
>  (kafka.server.KafkaConfig:347)
> [2019-11-13 06:04:49,602] INFO starting (kafka.server.KafkaServer:66)
> [2019-11-13 06:04:49,602] INFO Connecting to zookeeper on 127.0.0.1:34936 
> (kafka.server.KafkaServer:66)
> [2019-11-13 06:04:49,603] INFO [ZooKeeperClient Kafka server] Initializing a 
> new session to 127.0.0.1:34936. (kafka.zookeeper.ZooKeeperClient:66)
> [2019-11-13 06:04:49,603] INFO Initiating client connection, 
> connectString=127.0.0.1:34936 sessionTimeout=10000 
> watcher=kafka.zookeeper.ZooKeeperClient$ZooKeeperClientWatcher$@6a99449d 
> (org.apache.zookeeper.ZooKeeper:868)
> [2019-11-13 06:04:49,603] INFO jute.maxbuffer value is 4194304 Bytes 
> (org.apache.zookeeper.ClientCnxnSocket:237)
> [2019-11-13 06:04:49,604] INFO zookeeper.request.timeout value is 0. feature 
> enabled= (org.apache.zookeeper.ClientCnxn:1653)
> [2019-11-13 06:04:49,604] INFO [ZooKeeperClient Kafka server] Waiting until 
> connected. (kafka.zookeeper.ZooKeeperClient:66)
> [2019-11-13 06:04:49,604] INFO Opening socket connection to server 
> localhost/127.0.0.1:34936. Will not attempt to authenticate using SASL 
> (unknown error) (org.apache.zookeeper.ClientCnxn:1112)
> [2019-11-13 06:04:49,605] INFO Socket connection established, initiating 
> session, client: /127.0.0.1:46826, server: localhost/127.0.0.1:34936 
> (org.apache.zookeeper.ClientCnxn:959)
> [2019-11-13 06:04:49,606] INFO Creating new log file: log.1 
> (org.apache.zookeeper.server.persistence.FileTxnLog:216)
> [2019-11-13 06:04:49,607] INFO Session establishment complete on server 
> localhost/127.0.0.1:34936, sessionid = 0x100df7ef30e0000, negotiated timeout 
> = 10000 (org.apache.zookeeper.ClientCnxn:1394)
> [2019-11-13 06:04:49,607] INFO [ZooKeeperClient Kafka server] Connected. 
> (kafka.zookeeper.ZooKeeperClient:66)
> [2019-11-13 06:04:49,634] INFO Cluster ID = kot2gqC3SryRv2wZkPzlAA 
> (kafka.server.KafkaServer:66)
> [2019-11-13 06:04:49,635] WARN No meta.properties file under dir 
> /tmp/junit6760496041183144599/junit6110490013242643385/meta.properties 
> (kafka.server.BrokerMetadataCheckpoint:70)
> [2019-11-13 06:04:49,639] INFO KafkaConfig values: 
>       advertised.host.name = null
>       advertised.listeners = null
>       advertised.port = null
>       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.id = 0
>       broker.id.generation.enable = true
>       broker.rack = null
>       client.quota.callback.class = null
>       compression.type = producer
>       connection.failed.authentication.delay.ms = 100
>       connections.max.idle.ms = 600000
>       connections.max.reauth.ms = 0
>       control.plane.listener.name = null
>       controlled.shutdown.enable = true
>       controlled.shutdown.max.retries = 3
>       controlled.shutdown.retry.backoff.ms = 5000
>       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.master.key = null
>       delegation.token.max.lifetime.ms = 604800000
>       delete.records.purgatory.purge.interval.requests = 1
>       delete.topic.enable = true
>       fetch.max.bytes = 57671680
>       fetch.purgatory.purge.interval.requests = 1000
>       group.initial.rebalance.delay.ms = 0
>       group.max.session.timeout.ms = 1800000
>       group.max.size = 2147483647
>       group.min.session.timeout.ms = 0
>       host.name = localhost
>       inter.broker.listener.name = null
>       inter.broker.protocol.version = 2.4-IV1
>       kafka.metrics.polling.interval.secs = 10
>       kafka.metrics.reporters = []
>       leader.imbalance.check.interval.seconds = 300
>       leader.imbalance.per.broker.percentage = 10
>       listener.security.protocol.map = 
> PLAINTEXT:PLAINTEXT,SSL:SSL,SASL_PLAINTEXT:SASL_PLAINTEXT,SASL_SSL:SASL_SSL
>       listeners = null
>       log.cleaner.backoff.ms = 15000
>       log.cleaner.dedupe.buffer.size = 2097152
>       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/junit6760496041183144599/junit6110490013242643385
>       log.dirs = null
>       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.message.downconversion.enable = true
>       log.message.format.version = 2.4-IV1
>       log.message.timestamp.difference.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.connections = 2147483647
>       max.connections.per.ip = 2147483647
>       max.connections.per.ip.overrides = 
>       max.incremental.fetch.session.cache.slots = 1000
>       message.max.bytes = 1000000
>       metric.reporters = []
>       metrics.num.samples = 2
>       metrics.recording.level = INFO
>       metrics.sample.window.ms = 30000
>       min.insync.replicas = 1
>       num.io.threads = 8
>       num.network.threads = 3
>       num.partitions = 1
>       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.required.acks = -1
>       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 = 5
>       offsets.topic.replication.factor = 1
>       offsets.topic.segment.bytes = 104857600
>       password.encoder.cipher.algorithm = AES/CBC/PKCS5Padding
>       password.encoder.iterations = 4096
>       password.encoder.key.length = 128
>       password.encoder.keyfactory.algorithm = null
>       password.encoder.old.secret = null
>       password.encoder.secret = null
>       port = 0
>       principal.builder.class = null
>       producer.purgatory.purge.interval.requests = 1000
>       queued.max.request.bytes = -1
>       queued.max.requests = 500
>       quota.consumer.default = 9223372036854775807
>       quota.producer.default = 9223372036854775807
>       quota.window.num = 11
>       quota.window.size.seconds = 1
>       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
>       reserved.broker.max.id = 1000
>       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.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.mechanism.inter.broker.protocol = GSSAPI
>       sasl.server.callback.handler.class = null
>       security.inter.broker.protocol = PLAINTEXT
>       security.providers = null
>       socket.receive.buffer.bytes = 102400
>       socket.request.max.bytes = 104857600
>       socket.send.buffer.bytes = 102400
>       ssl.cipher.suites = []
>       ssl.client.auth = none
>       ssl.enabled.protocols = [TLSv1.2, TLSv1.1, TLSv1]
>       ssl.endpoint.identification.algorithm = https
>       ssl.key.password = null
>       ssl.keymanager.algorithm = SunX509
>       ssl.keystore.location = null
>       ssl.keystore.password = null
>       ssl.keystore.type = JKS
>       ssl.principal.mapping.rules = DEFAULT
>       ssl.protocol = TLS
>       ssl.provider = null
>       ssl.secure.random.implementation = null
>       ssl.trustmanager.algorithm = PKIX
>       ssl.truststore.location = null
>       ssl.truststore.password = null
>       ssl.truststore.type = JKS
>       transaction.abort.timed.out.transaction.cleanup.interval.ms = 60000
>       transaction.max.timeout.ms = 900000
>       transaction.remove.expired.transaction.cleanup.interval.ms = 3600000
>       transaction.state.log.load.buffer.size = 5242880
>       transaction.state.log.min.isr = 2
>       transaction.state.log.num.partitions = 50
>       transaction.state.log.replication.factor = 3
>       transaction.state.log.segment.bytes = 104857600
>       transactional.id.expiration.ms = 604800000
>       unclean.leader.election.enable = false
>       zookeeper.connect = 127.0.0.1:34936
>       zookeeper.connection.timeout.ms = null
>       zookeeper.max.in.flight.requests = 10
>       zookeeper.session.timeout.ms = 10000
>       zookeeper.set.acl = false
>       zookeeper.sync.time.ms = 2000
>  (kafka.server.KafkaConfig:347)
> [2019-11-13 06:04:49,642] INFO KafkaConfig values: 
>       advertised.host.name = null
>       advertised.listeners = null
>       advertised.port = null
>       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.id = 0
>       broker.id.generation.enable = true
>       broker.rack = null
>       client.quota.callback.class = null
>       compression.type = producer
>       connection.failed.authentication.delay.ms = 100
>       connections.max.idle.ms = 600000
>       connections.max.reauth.ms = 0
>       control.plane.listener.name = null
>       controlled.shutdown.enable = true
>       controlled.shutdown.max.retries = 3
>       controlled.shutdown.retry.backoff.ms = 5000
>       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.master.key = null
>       delegation.token.max.lifetime.ms = 604800000
>       delete.records.purgatory.purge.interval.requests = 1
>       delete.topic.enable = true
>       fetch.max.bytes = 57671680
>       fetch.purgatory.purge.interval.requests = 1000
>       group.initial.rebalance.delay.ms = 0
>       group.max.session.timeout.ms = 1800000
>       group.max.size = 2147483647
>       group.min.session.timeout.ms = 0
>       host.name = localhost
>       inter.broker.listener.name = null
>       inter.broker.protocol.version = 2.4-IV1
>       kafka.metrics.polling.interval.secs = 10
>       kafka.metrics.reporters = []
>       leader.imbalance.check.interval.seconds = 300
>       leader.imbalance.per.broker.percentage = 10
>       listener.security.protocol.map = 
> PLAINTEXT:PLAINTEXT,SSL:SSL,SASL_PLAINTEXT:SASL_PLAINTEXT,SASL_SSL:SASL_SSL
>       listeners = null
>       log.cleaner.backoff.ms = 15000
>       log.cleaner.dedupe.buffer.size = 2097152
>       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/junit6760496041183144599/junit6110490013242643385
>       log.dirs = null
>       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.message.downconversion.enable = true
>       log.message.format.version = 2.4-IV1
>       log.message.timestamp.difference.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.connections = 2147483647
>       max.connections.per.ip = 2147483647
>       max.connections.per.ip.overrides = 
>       max.incremental.fetch.session.cache.slots = 1000
>       message.max.bytes = 1000000
>       metric.reporters = []
>       metrics.num.samples = 2
>       metrics.recording.level = INFO
>       metrics.sample.window.ms = 30000
>       min.insync.replicas = 1
>       num.io.threads = 8
>       num.network.threads = 3
>       num.partitions = 1
>       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.required.acks = -1
>       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 = 5
>       offsets.topic.replication.factor = 1
>       offsets.topic.segment.bytes = 104857600
>       password.encoder.cipher.algorithm = AES/CBC/PKCS5Padding
>       password.encoder.iterations = 4096
>       password.encoder.key.length = 128
>       password.encoder.keyfactory.algorithm = null
>       password.encoder.old.secret = null
>       password.encoder.secret = null
>       port = 0
>       principal.builder.class = null
>       producer.purgatory.purge.interval.requests = 1000
>       queued.max.request.bytes = -1
>       queued.max.requests = 500
>       quota.consumer.default = 9223372036854775807
>       quota.producer.default = 9223372036854775807
>       quota.window.num = 11
>       quota.window.size.seconds = 1
>       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
>       reserved.broker.max.id = 1000
>       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.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.mechanism.inter.broker.protocol = GSSAPI
>       sasl.server.callback.handler.class = null
>       security.inter.broker.protocol = PLAINTEXT
>       security.providers = null
>       socket.receive.buffer.bytes = 102400
>       socket.request.max.bytes = 104857600
>       socket.send.buffer.bytes = 102400
>       ssl.cipher.suites = []
>       ssl.client.auth = none
>       ssl.enabled.protocols = [TLSv1.2, TLSv1.1, TLSv1]
>       ssl.endpoint.identification.algorithm = https
>       ssl.key.password = null
>       ssl.keymanager.algorithm = SunX509
>       ssl.keystore.location = null
>       ssl.keystore.password = null
>       ssl.keystore.type = JKS
>       ssl.principal.mapping.rules = DEFAULT
>       ssl.protocol = TLS
>       ssl.provider = null
>       ssl.secure.random.implementation = null
>       ssl.trustmanager.algorithm = PKIX
>       ssl.truststore.location = null
>       ssl.truststore.password = null
>       ssl.truststore.type = JKS
>       transaction.abort.timed.out.transaction.cleanup.interval.ms = 60000
>       transaction.max.timeout.ms = 900000
>       transaction.remove.expired.transaction.cleanup.interval.ms = 3600000
>       transaction.state.log.load.buffer.size = 5242880
>       transaction.state.log.min.isr = 2
>       transaction.state.log.num.partitions = 50
>       transaction.state.log.replication.factor = 3
>       transaction.state.log.segment.bytes = 104857600
>       transactional.id.expiration.ms = 604800000
>       unclean.leader.election.enable = false
>       zookeeper.connect = 127.0.0.1:34936
>       zookeeper.connection.timeout.ms = null
>       zookeeper.max.in.flight.requests = 10
>       zookeeper.session.timeout.ms = 10000
>       zookeeper.set.acl = false
>       zookeeper.sync.time.ms = 2000
>  (kafka.server.KafkaConfig:347)
> [2019-11-13 06:04:49,645] INFO [ThrottledChannelReaper-Fetch]: Starting 
> (kafka.server.ClientQuotaManager$ThrottledChannelReaper:66)
> [2019-11-13 06:04:49,646] INFO [ThrottledChannelReaper-Produce]: Starting 
> (kafka.server.ClientQuotaManager$ThrottledChannelReaper:66)
> [2019-11-13 06:04:49,646] INFO [ThrottledChannelReaper-Request]: Starting 
> (kafka.server.ClientQuotaManager$ThrottledChannelReaper:66)
> [2019-11-13 06:04:49,648] INFO Loading logs. (kafka.log.LogManager:66)
> [2019-11-13 06:04:49,649] INFO Logs loading complete in 0 ms. 
> (kafka.log.LogManager:66)
> [2019-11-13 06:04:49,649] INFO Starting log cleanup with a period of 300000 
> ms. (kafka.log.LogManager:66)
> [2019-11-13 06:04:49,650] INFO Starting log flusher with a default period of 
> 9223372036854775807 ms. (kafka.log.LogManager:66)
> [2019-11-13 06:04:49,650] INFO Starting the log cleaner 
> (kafka.log.LogCleaner:66)
> [2019-11-13 06:04:49,652] INFO [kafka-log-cleaner-thread-0]: Starting 
> (kafka.log.LogCleaner:66)
> [2019-11-13 06:04:49,677] INFO Awaiting socket connections on 
> localhost:37288. (kafka.network.Acceptor:66)
> [2019-11-13 06:04:49,681] INFO [SocketServer brokerId=0] Created data-plane 
> acceptor and processors for endpoint : 
> EndPoint(localhost,0,ListenerName(PLAINTEXT),PLAINTEXT) 
> (kafka.network.SocketServer:66)
> [2019-11-13 06:04:49,681] INFO [SocketServer brokerId=0] Started 1 acceptor 
> threads for data-plane (kafka.network.SocketServer:66)
> [2019-11-13 06:04:49,682] INFO [ExpirationReaper-0-Produce]: Starting 
> (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper:66)
> [2019-11-13 06:04:49,682] INFO [ExpirationReaper-0-Fetch]: Starting 
> (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper:66)
> [2019-11-13 06:04:49,683] INFO [ExpirationReaper-0-DeleteRecords]: Starting 
> (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper:66)
> [2019-11-13 06:04:49,683] INFO [ExpirationReaper-0-ElectLeader]: Starting 
> (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper:66)
> [2019-11-13 06:04:49,685] INFO [LogDirFailureHandler]: Starting 
> (kafka.server.ReplicaManager$LogDirFailureHandler:66)
> [2019-11-13 06:04:49,687] INFO Creating /brokers/ids/0 (is it secure? false) 
> (kafka.zk.KafkaZkClient:66)
> [2019-11-13 06:04:49,688] INFO Stat of the created znode at /brokers/ids/0 
> is: 24,24,1573625089687,1573625089687,1,0,0,72303330374582272,190,0,24
>  (kafka.zk.KafkaZkClient:66)
> [2019-11-13 06:04:49,689] INFO Registered broker 0 at path /brokers/ids/0 
> with addresses: 
> ArrayBuffer(EndPoint(localhost,37288,ListenerName(PLAINTEXT),PLAINTEXT)), 
> czxid (broker epoch): 24 (kafka.zk.KafkaZkClient:66)
> [2019-11-13 06:04:49,831] INFO [ControllerEventThread controllerId=0] 
> Starting (kafka.controller.ControllerEventManager$ControllerEventThread:66)
> [2019-11-13 06:04:49,831] INFO [ExpirationReaper-0-topic]: Starting 
> (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper:66)
> [2019-11-13 06:04:49,832] INFO [ExpirationReaper-0-Heartbeat]: Starting 
> (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper:66)
> [2019-11-13 06:04:49,832] INFO [ExpirationReaper-0-Rebalance]: Starting 
> (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper:66)
> [2019-11-13 06:04:49,833] INFO [GroupCoordinator 0]: Starting up. 
> (kafka.coordinator.group.GroupCoordinator:66)
> [2019-11-13 06:04:49,834] INFO [GroupCoordinator 0]: Startup complete. 
> (kafka.coordinator.group.GroupCoordinator:66)
> [2019-11-13 06:04:49,834] INFO [GroupMetadataManager brokerId=0] Removed 0 
> expired offsets in 0 milliseconds. 
> (kafka.coordinator.group.GroupMetadataManager:66)
> [2019-11-13 06:04:49,834] INFO Successfully created /controller_epoch with 
> initial epoch 0 (kafka.zk.KafkaZkClient:66)
> [2019-11-13 06:04:49,836] INFO [ProducerId Manager 0]: Acquired new 
> producerId block (brokerId:0,blockStartProducerId:0,blockEndProducerId:999) 
> by writing to Zk with path version 1 
> (kafka.coordinator.transaction.ProducerIdManager:66)
> [2019-11-13 06:04:49,836] INFO [Controller id=0] 0 successfully elected as 
> the controller. Epoch incremented to 1 and epoch zk version is now 1 
> (kafka.controller.KafkaController:66)
> [2019-11-13 06:04:49,836] INFO [Controller id=0] Registering handlers 
> (kafka.controller.KafkaController:66)
> [2019-11-13 06:04:49,837] INFO [Controller id=0] Deleting log dir event 
> notifications (kafka.controller.KafkaController:66)
> [2019-11-13 06:04:49,838] INFO [TransactionCoordinator id=0] Starting up. 
> (kafka.coordinator.transaction.TransactionCoordinator:66)
> [2019-11-13 06:04:49,838] INFO [Controller id=0] Deleting isr change 
> notifications (kafka.controller.KafkaController:66)
> [2019-11-13 06:04:49,838] INFO [TransactionCoordinator id=0] Startup 
> complete. (kafka.coordinator.transaction.TransactionCoordinator:66)
> [2019-11-13 06:04:49,839] INFO [Transaction Marker Channel Manager 0]: 
> Starting (kafka.coordinator.transaction.TransactionMarkerChannelManager:66)
> [2019-11-13 06:04:49,839] INFO [Controller id=0] Initializing controller 
> context (kafka.controller.KafkaController:66)
> [2019-11-13 06:04:49,840] INFO [ExpirationReaper-0-AlterAcls]: Starting 
> (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper:66)
> [2019-11-13 06:04:49,841] INFO [Controller id=0] Initialized broker epochs 
> cache: Map(0 -> 24) (kafka.controller.KafkaController:66)
> [2019-11-13 06:04:49,842] INFO [/config/changes-event-process-thread]: 
> Starting 
> (kafka.common.ZkNodeChangeNotificationListener$ChangeEventProcessThread:66)
> [2019-11-13 06:04:49,845] INFO [Controller id=0] Currently active brokers in 
> the cluster: Set(0) (kafka.controller.KafkaController:66)
> [2019-11-13 06:04:49,845] INFO [RequestSendThread controllerId=0] Starting 
> (kafka.controller.RequestSendThread:66)
> [2019-11-13 06:04:49,845] INFO [Controller id=0] Currently shutting brokers 
> in the cluster: Set() (kafka.controller.KafkaController:66)
> [2019-11-13 06:04:49,846] INFO [Controller id=0] Current list of topics in 
> the cluster: Set() (kafka.controller.KafkaController:66)
> [2019-11-13 06:04:49,846] INFO [Controller id=0] Fetching topic deletions in 
> progress (kafka.controller.KafkaController:66)
> [2019-11-13 06:04:49,846] INFO [SocketServer brokerId=0] Started data-plane 
> processors for 1 acceptors (kafka.network.SocketServer:66)
> [2019-11-13 06:04:49,846] INFO Kafka version: 2.5.0-SNAPSHOT 
> (org.apache.kafka.common.utils.AppInfoParser:117)
> [2019-11-13 06:04:49,846] INFO Kafka commitId: 6d664f6df7f721ae 
> (org.apache.kafka.common.utils.AppInfoParser:118)
> [2019-11-13 06:04:49,846] INFO [Controller id=0] List of topics to be 
> deleted:  (kafka.controller.KafkaController:66)
> [2019-11-13 06:04:49,847] INFO Kafka startTimeMs: 1573625089594 
> (org.apache.kafka.common.utils.AppInfoParser:119)
> [2019-11-13 06:04:49,847] INFO [Controller id=0] List of topics ineligible 
> for deletion:  (kafka.controller.KafkaController:66)
> [2019-11-13 06:04:49,847] INFO [KafkaServer id=0] started 
> (kafka.server.KafkaServer:66)
> [2019-11-13 06:04:49,847] INFO [Controller id=0] Initializing topic deletion 
> manager (kafka.controller.KafkaController:66)
> [2019-11-13 06:04:49,847] INFO [Topic Deletion Manager 0] Initializing 
> manager with initial deletions: Set(), initial ineligible deletions: Set() 
> (kafka.controller.TopicDeletionManager:66)
> [2019-11-13 06:04:49,847] INFO [Controller id=0] Sending update metadata 
> request (kafka.controller.KafkaController:66)
> [2019-11-13 06:04:49,848] INFO [ReplicaStateMachine controllerId=0] 
> Initializing replica state (kafka.controller.ZkReplicaStateMachine:66)
> [2019-11-13 06:04:49,848] INFO [ReplicaStateMachine controllerId=0] 
> Triggering online replica state changes 
> (kafka.controller.ZkReplicaStateMachine:66)
> [2019-11-13 06:04:49,848] INFO [ReplicaStateMachine controllerId=0] 
> Triggering offline replica state changes 
> (kafka.controller.ZkReplicaStateMachine:66)
> [2019-11-13 06:04:49,848] INFO [PartitionStateMachine controllerId=0] 
> Initializing partition state (kafka.controller.ZkPartitionStateMachine:66)
> [2019-11-13 06:04:49,848] INFO [PartitionStateMachine controllerId=0] 
> Triggering online partition state changes 
> (kafka.controller.ZkPartitionStateMachine:66)
> [2019-11-13 06:04:49,848] INFO KafkaConfig values: 
>       advertised.host.name = null
>       advertised.listeners = null
>       advertised.port = null
>       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.id = 1
>       broker.id.generation.enable = true
>       broker.rack = null
>       client.quota.callback.class = null
>       compression.type = producer
>       connection.failed.authentication.delay.ms = 100
>       connections.max.idle.ms = 600000
>       connections.max.reauth.ms = 0
>       control.plane.listener.name = null
>       controlled.shutdown.enable = true
>       controlled.shutdown.max.retries = 3
>       controlled.shutdown.retry.backoff.ms = 5000
>       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.master.key = null
>       delegation.token.max.lifetime.ms = 604800000
>       delete.records.purgatory.purge.interval.requests = 1
>       delete.topic.enable = true
>       fetch.max.bytes = 57671680
>       fetch.purgatory.purge.interval.requests = 1000
>       group.initial.rebalance.delay.ms = 0
>       group.max.session.timeout.ms = 1800000
>       group.max.size = 2147483647
>       group.min.session.timeout.ms = 0
>       host.name = localhost
>       inter.broker.listener.name = null
>       inter.broker.protocol.version = 2.4-IV1
>       kafka.metrics.polling.interval.secs = 10
>       kafka.metrics.reporters = []
>       leader.imbalance.check.interval.seconds = 300
>       leader.imbalance.per.broker.percentage = 10
>       listener.security.protocol.map = 
> PLAINTEXT:PLAINTEXT,SSL:SSL,SASL_PLAINTEXT:SASL_PLAINTEXT,SASL_SSL:SASL_SSL
>       listeners = null
>       log.cleaner.backoff.ms = 15000
>       log.cleaner.dedupe.buffer.size = 2097152
>       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/junit5414548266621944218/junit92696306455778432
>       log.dirs = null
>       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.message.downconversion.enable = true
>       log.message.format.version = 2.4-IV1
>       log.message.timestamp.difference.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.connections = 2147483647
>       max.connections.per.ip = 2147483647
>       max.connections.per.ip.overrides = 
>       max.incremental.fetch.session.cache.slots = 1000
>       message.max.bytes = 1000000
>       metric.reporters = []
>       metrics.num.samples = 2
>       metrics.recording.level = INFO
>       metrics.sample.window.ms = 30000
>       min.insync.replicas = 1
>       num.io.threads = 8
>       num.network.threads = 3
>       num.partitions = 1
>       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.required.acks = -1
>       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 = 5
>       offsets.topic.replication.factor = 1
>       offsets.topic.segment.bytes = 104857600
>       password.encoder.cipher.algorithm = AES/CBC/PKCS5Padding
>       password.encoder.iterations = 4096
>       password.encoder.key.length = 128
>       password.encoder.keyfactory.algorithm = null
>       password.encoder.old.secret = null
>       password.encoder.secret = null
>       port = 0
>       principal.builder.class = null
>       producer.purgatory.purge.interval.requests = 1000
>       queued.max.request.bytes = -1
>       queued.max.requests = 500
>       quota.consumer.default = 9223372036854775807
>       quota.producer.default = 9223372036854775807
>       quota.window.num = 11
>       quota.window.size.seconds = 1
>       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
>       reserved.broker.max.id = 1000
>       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.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.mechanism.inter.broker.protocol = GSSAPI
>       sasl.server.callback.handler.class = null
>       security.inter.broker.protocol = PLAINTEXT
>       security.providers = null
>       socket.receive.buffer.bytes = 102400
>       socket.request.max.bytes = 104857600
>       socket.send.buffer.bytes = 102400
>       ssl.cipher.suites = []
>       ssl.client.auth = none
>       ssl.enabled.protocols = [TLSv1.2, TLSv1.1, TLSv1]
>       ssl.endpoint.identification.algorithm = https
>       ssl.key.password = null
>       ssl.keymanager.algorithm = SunX509
>       ssl.keystore.location = null
>       ssl.keystore.password = null
>       ssl.keystore.type = JKS
>       ssl.principal.mapping.rules = DEFAULT
>       ssl.protocol = TLS
>       ssl.provider = null
>       ssl.secure.random.implementation = null
>       ssl.trustmanager.algorithm = PKIX
>       ssl.truststore.location = null
>       ssl.truststore.password = null
>       ssl.truststore.type = JKS
>       transaction.abort.timed.out.transaction.cleanup.interval.ms = 60000
>       transaction.max.timeout.ms = 900000
>       transaction.remove.expired.transaction.cleanup.interval.ms = 3600000
>       transaction.state.log.load.buffer.size = 5242880
>       transaction.state.log.min.isr = 2
>       transaction.state.log.num.partitions = 50
>       transaction.state.log.replication.factor = 3
>       transaction.state.log.segment.bytes = 104857600
>       transactional.id.expiration.ms = 604800000
>       unclean.leader.election.enable = false
>       zookeeper.connect = 127.0.0.1:34936
>       zookeeper.connection.timeout.ms = null
>       zookeeper.max.in.flight.requests = 10
>       zookeeper.session.timeout.ms = 10000
>       zookeeper.set.acl = false
>       zookeeper.sync.time.ms = 2000
>  (kafka.server.KafkaConfig:347)
> [2019-11-13 06:04:49,849] INFO [RequestSendThread controllerId=0] Controller 
> 0 connected to localhost:37288 (id: 0 rack: null) for sending state change 
> requests (kafka.controller.RequestSendThread:66)
> [2019-11-13 06:04:49,849] INFO [Controller id=0] Ready to serve as the new 
> controller with epoch 1 (kafka.controller.KafkaController:66)
> [2019-11-13 06:04:49,851] INFO starting (kafka.server.KafkaServer:66)
> [2019-11-13 06:04:49,851] INFO Connecting to zookeeper on 127.0.0.1:34936 
> (kafka.server.KafkaServer:66)
> [2019-11-13 06:04:49,851] INFO [Controller id=0] Partitions undergoing 
> preferred replica election:  (kafka.controller.KafkaController:66)
> [2019-11-13 06:04:49,851] INFO [ZooKeeperClient Kafka server] Initializing a 
> new session to 127.0.0.1:34936. (kafka.zookeeper.ZooKeeperClient:66)
> [2019-11-13 06:04:49,851] INFO [Controller id=0] Partitions that completed 
> preferred replica election:  (kafka.controller.KafkaController:66)
> [2019-11-13 06:04:49,851] INFO Initiating client connection, 
> connectString=127.0.0.1:34936 sessionTimeout=10000 
> watcher=kafka.zookeeper.ZooKeeperClient$ZooKeeperClientWatcher$@52276192 
> (org.apache.zookeeper.ZooKeeper:868)
> [2019-11-13 06:04:49,851] INFO [Controller id=0] Skipping preferred replica 
> election for partitions due to topic deletion:  
> (kafka.controller.KafkaController:66)
> [2019-11-13 06:04:49,852] INFO [Controller id=0] Resuming preferred replica 
> election for partitions:  (kafka.controller.KafkaController:66)
> [2019-11-13 06:04:49,852] INFO [Controller id=0] Starting replica leader 
> election (PREFERRED) for partitions  triggered by ZkTriggered 
> (kafka.controller.KafkaController:66)
> [2019-11-13 06:04:49,852] INFO jute.maxbuffer value is 4194304 Bytes 
> (org.apache.zookeeper.ClientCnxnSocket:237)
> [2019-11-13 06:04:49,852] INFO zookeeper.request.timeout value is 0. feature 
> enabled= (org.apache.zookeeper.ClientCnxn:1653)
> [2019-11-13 06:04:49,853] INFO [ZooKeeperClient Kafka server] Waiting until 
> connected. (kafka.zookeeper.ZooKeeperClient:66)
> [2019-11-13 06:04:49,853] INFO [Controller id=0] Starting the controller 
> scheduler (kafka.controller.KafkaController:66)
> [2019-11-13 06:04:49,853] INFO Opening socket connection to server 
> localhost/127.0.0.1:34936. Will not attempt to authenticate using SASL 
> (unknown error) (org.apache.zookeeper.ClientCnxn:1112)
> [2019-11-13 06:04:49,854] INFO Socket connection established, initiating 
> session, client: /127.0.0.1:46830, server: localhost/127.0.0.1:34936 
> (org.apache.zookeeper.ClientCnxn:959)
> [2019-11-13 06:04:49,855] INFO Session establishment complete on server 
> localhost/127.0.0.1:34936, sessionid = 0x100df7ef30e0001, negotiated timeout 
> = 10000 (org.apache.zookeeper.ClientCnxn:1394)
> [2019-11-13 06:04:49,855] INFO [ZooKeeperClient Kafka server] Connected. 
> (kafka.zookeeper.ZooKeeperClient:66)
> [2019-11-13 06:04:49,861] INFO Cluster ID = kot2gqC3SryRv2wZkPzlAA 
> (kafka.server.KafkaServer:66)
> [2019-11-13 06:04:49,862] WARN No meta.properties file under dir 
> /tmp/junit5414548266621944218/junit92696306455778432/meta.properties 
> (kafka.server.BrokerMetadataCheckpoint:70)
> [2019-11-13 06:04:49,864] INFO KafkaConfig values: 
>       advertised.host.name = null
>       advertised.listeners = null
>       advertised.port = null
>       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.id = 1
>       broker.id.generation.enable = true
>       broker.rack = null
>       client.quota.callback.class = null
>       compression.type = producer
>       connection.failed.authentication.delay.ms = 100
>       connections.max.idle.ms = 600000
>       connections.max.reauth.ms = 0
>       control.plane.listener.name = null
>       controlled.shutdown.enable = true
>       controlled.shutdown.max.retries = 3
>       controlled.shutdown.retry.backoff.ms = 5000
>       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.master.key = null
>       delegation.token.max.lifetime.ms = 604800000
>       delete.records.purgatory.purge.interval.requests = 1
>       delete.topic.enable = true
>       fetch.max.bytes = 57671680
>       fetch.purgatory.purge.interval.requests = 1000
>       group.initial.rebalance.delay.ms = 0
>       group.max.session.timeout.ms = 1800000
>       group.max.size = 2147483647
>       group.min.session.timeout.ms = 0
>       host.name = localhost
>       inter.broker.listener.name = null
>       inter.broker.protocol.version = 2.4-IV1
>       kafka.metrics.polling.interval.secs = 10
>       kafka.metrics.reporters = []
>       leader.imbalance.check.interval.seconds = 300
>       leader.imbalance.per.broker.percentage = 10
>       listener.security.protocol.map = 
> PLAINTEXT:PLAINTEXT,SSL:SSL,SASL_PLAINTEXT:SASL_PLAINTEXT,SASL_SSL:SASL_SSL
>       listeners = null
>       log.cleaner.backoff.ms = 15000
>       log.cleaner.dedupe.buffer.size = 2097152
>       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/junit5414548266621944218/junit92696306455778432
>       log.dirs = null
>       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.message.downconversion.enable = true
>       log.message.format.version = 2.4-IV1
>       log.message.timestamp.difference.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.connections = 2147483647
>       max.connections.per.ip = 2147483647
>       max.connections.per.ip.overrides = 
>       max.incremental.fetch.session.cache.slots = 1000
>       message.max.bytes = 1000000
>       metric.reporters = []
>       metrics.num.samples = 2
>       metrics.recording.level = INFO
>       metrics.sample.window.ms = 30000
>       min.insync.replicas = 1
>       num.io.threads = 8
>       num.network.threads = 3
>       num.partitions = 1
>       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.required.acks = -1
>       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 = 5
>       offsets.topic.replication.factor = 1
>       offsets.topic.segment.bytes = 104857600
>       password.encoder.cipher.algorithm = AES/CBC/PKCS5Padding
>       password.encoder.iterations = 4096
>       password.encoder.key.length = 128
>       password.encoder.keyfactory.algorithm = null
>       password.encoder.old.secret = null
>       password.encoder.secret = null
>       port = 0
>       principal.builder.class = null
>       producer.purgatory.purge.interval.requests = 1000
>       queued.max.request.bytes = -1
>       queued.max.requests = 500
>       quota.consumer.default = 9223372036854775807
>       quota.producer.default = 9223372036854775807
>       quota.window.num = 11
>       quota.window.size.seconds = 1
>       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
>       reserved.broker.max.id = 1000
>       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.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.mechanism.inter.broker.protocol = GSSAPI
>       sasl.server.callback.handler.class = null
>       security.inter.broker.protocol = PLAINTEXT
>       security.providers = null
>       socket.receive.buffer.bytes = 102400
>       socket.request.max.bytes = 104857600
>       socket.send.buffer.bytes = 102400
>       ssl.cipher.suites = []
>       ssl.client.auth = none
>       ssl.enabled.protocols = [TLSv1.2, TLSv1.1, TLSv1]
>       ssl.endpoint.identification.algorithm = https
>       ssl.key.password = null
>       ssl.keymanager.algorithm = SunX509
>       ssl.keystore.location = null
>       ssl.keystore.password = null
>       ssl.keystore.type = JKS
>       ssl.principal.mapping.rules = DEFAULT
>       ssl.protocol = TLS
>       ssl.provider = null
>       ssl.secure.random.implementation = null
>       ssl.trustmanager.algorithm = PKIX
>       ssl.truststore.location = null
>       ssl.truststore.password = null
>       ssl.truststore.type = JKS
>       transaction.abort.timed.out.transaction.cleanup.interval.ms = 60000
>       transaction.max.timeout.ms = 900000
>       tran
> ...[truncated 1188894 chars]...
> a.util.Try$.apply(Try.scala:192)
>       at 
> kafka.controller.KafkaController.processControlledShutdown(KafkaController.scala:1163)
>       at kafka.controller.KafkaController.process(KafkaController.scala:1868)
>       at kafka.controller.QueuedEvent.process(ControllerEventManager.scala:53)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply$mcV$sp(ControllerEventManager.scala:137)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply(ControllerEventManager.scala:137)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply(ControllerEventManager.scala:137)
>       at kafka.metrics.KafkaTimer.time(KafkaTimer.scala:31)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread.doWork(ControllerEventManager.scala:136)
>       at kafka.utils.ShutdownableThread.run(ShutdownableThread.scala:96)
> [2019-11-13 06:06:14,057] ERROR [Controller id=2 epoch=2] Controller 2 epoch 
> 2 failed to change state for partition __transaction_state-18 from 
> OnlinePartition to OnlinePartition (state.change.logger:76)
> kafka.common.StateChangeFailedException: Failed to elect leader for partition 
> __transaction_state-18 under strategy 
> ControlledShutdownPartitionLeaderElectionStrategy
>       at 
> kafka.controller.ZkPartitionStateMachine$$anonfun$doElectLeaderForPartitions$2.apply(PartitionStateMachine.scala:427)
>       at 
> kafka.controller.ZkPartitionStateMachine$$anonfun$doElectLeaderForPartitions$2.apply(PartitionStateMachine.scala:424)
>       at 
> scala.collection.mutable.ResizableArray$class.foreach(ResizableArray.scala:59)
>       at scala.collection.mutable.ArrayBuffer.foreach(ArrayBuffer.scala:48)
>       at 
> kafka.controller.ZkPartitionStateMachine.doElectLeaderForPartitions(PartitionStateMachine.scala:424)
>       at 
> kafka.controller.ZkPartitionStateMachine.electLeaderForPartitions(PartitionStateMachine.scala:335)
>       at 
> kafka.controller.ZkPartitionStateMachine.doHandleStateChanges(PartitionStateMachine.scala:233)
>       at 
> kafka.controller.ZkPartitionStateMachine.handleStateChanges(PartitionStateMachine.scala:154)
>       at 
> kafka.controller.KafkaController.kafka$controller$KafkaController$$doControlledShutdown(KafkaController.scala:1201)
>       at 
> kafka.controller.KafkaController$$anonfun$23.apply(KafkaController.scala:1163)
>       at 
> kafka.controller.KafkaController$$anonfun$23.apply(KafkaController.scala:1163)
>       at scala.util.Try$.apply(Try.scala:192)
>       at 
> kafka.controller.KafkaController.processControlledShutdown(KafkaController.scala:1163)
>       at kafka.controller.KafkaController.process(KafkaController.scala:1868)
>       at kafka.controller.QueuedEvent.process(ControllerEventManager.scala:53)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply$mcV$sp(ControllerEventManager.scala:137)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply(ControllerEventManager.scala:137)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply(ControllerEventManager.scala:137)
>       at kafka.metrics.KafkaTimer.time(KafkaTimer.scala:31)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread.doWork(ControllerEventManager.scala:136)
>       at kafka.utils.ShutdownableThread.run(ShutdownableThread.scala:96)
> [2019-11-13 06:06:14,058] ERROR [Controller id=2 epoch=2] Controller 2 epoch 
> 2 failed to change state for partition __transaction_state-26 from 
> OnlinePartition to OnlinePartition (state.change.logger:76)
> kafka.common.StateChangeFailedException: Failed to elect leader for partition 
> __transaction_state-26 under strategy 
> ControlledShutdownPartitionLeaderElectionStrategy
>       at 
> kafka.controller.ZkPartitionStateMachine$$anonfun$doElectLeaderForPartitions$2.apply(PartitionStateMachine.scala:427)
>       at 
> kafka.controller.ZkPartitionStateMachine$$anonfun$doElectLeaderForPartitions$2.apply(PartitionStateMachine.scala:424)
>       at 
> scala.collection.mutable.ResizableArray$class.foreach(ResizableArray.scala:59)
>       at scala.collection.mutable.ArrayBuffer.foreach(ArrayBuffer.scala:48)
>       at 
> kafka.controller.ZkPartitionStateMachine.doElectLeaderForPartitions(PartitionStateMachine.scala:424)
>       at 
> kafka.controller.ZkPartitionStateMachine.electLeaderForPartitions(PartitionStateMachine.scala:335)
>       at 
> kafka.controller.ZkPartitionStateMachine.doHandleStateChanges(PartitionStateMachine.scala:233)
>       at 
> kafka.controller.ZkPartitionStateMachine.handleStateChanges(PartitionStateMachine.scala:154)
>       at 
> kafka.controller.KafkaController.kafka$controller$KafkaController$$doControlledShutdown(KafkaController.scala:1201)
>       at 
> kafka.controller.KafkaController$$anonfun$23.apply(KafkaController.scala:1163)
>       at 
> kafka.controller.KafkaController$$anonfun$23.apply(KafkaController.scala:1163)
>       at scala.util.Try$.apply(Try.scala:192)
>       at 
> kafka.controller.KafkaController.processControlledShutdown(KafkaController.scala:1163)
>       at kafka.controller.KafkaController.process(KafkaController.scala:1868)
>       at kafka.controller.QueuedEvent.process(ControllerEventManager.scala:53)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply$mcV$sp(ControllerEventManager.scala:137)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply(ControllerEventManager.scala:137)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply(ControllerEventManager.scala:137)
>       at kafka.metrics.KafkaTimer.time(KafkaTimer.scala:31)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread.doWork(ControllerEventManager.scala:136)
>       at kafka.utils.ShutdownableThread.run(ShutdownableThread.scala:96)
> [2019-11-13 06:06:14,058] ERROR [Controller id=2 epoch=2] Controller 2 epoch 
> 2 failed to change state for partition __transaction_state-36 from 
> OnlinePartition to OnlinePartition (state.change.logger:76)
> kafka.common.StateChangeFailedException: Failed to elect leader for partition 
> __transaction_state-36 under strategy 
> ControlledShutdownPartitionLeaderElectionStrategy
>       at 
> kafka.controller.ZkPartitionStateMachine$$anonfun$doElectLeaderForPartitions$2.apply(PartitionStateMachine.scala:427)
>       at 
> kafka.controller.ZkPartitionStateMachine$$anonfun$doElectLeaderForPartitions$2.apply(PartitionStateMachine.scala:424)
>       at 
> scala.collection.mutable.ResizableArray$class.foreach(ResizableArray.scala:59)
>       at scala.collection.mutable.ArrayBuffer.foreach(ArrayBuffer.scala:48)
>       at 
> kafka.controller.ZkPartitionStateMachine.doElectLeaderForPartitions(PartitionStateMachine.scala:424)
>       at 
> kafka.controller.ZkPartitionStateMachine.electLeaderForPartitions(PartitionStateMachine.scala:335)
>       at 
> kafka.controller.ZkPartitionStateMachine.doHandleStateChanges(PartitionStateMachine.scala:233)
>       at 
> kafka.controller.ZkPartitionStateMachine.handleStateChanges(PartitionStateMachine.scala:154)
>       at 
> kafka.controller.KafkaController.kafka$controller$KafkaController$$doControlledShutdown(KafkaController.scala:1201)
>       at 
> kafka.controller.KafkaController$$anonfun$23.apply(KafkaController.scala:1163)
>       at 
> kafka.controller.KafkaController$$anonfun$23.apply(KafkaController.scala:1163)
>       at scala.util.Try$.apply(Try.scala:192)
>       at 
> kafka.controller.KafkaController.processControlledShutdown(KafkaController.scala:1163)
>       at kafka.controller.KafkaController.process(KafkaController.scala:1868)
>       at kafka.controller.QueuedEvent.process(ControllerEventManager.scala:53)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply$mcV$sp(ControllerEventManager.scala:137)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply(ControllerEventManager.scala:137)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply(ControllerEventManager.scala:137)
>       at kafka.metrics.KafkaTimer.time(KafkaTimer.scala:31)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread.doWork(ControllerEventManager.scala:136)
>       at kafka.utils.ShutdownableThread.run(ShutdownableThread.scala:96)
> [2019-11-13 06:06:14,058] ERROR [Controller id=2 epoch=2] Controller 2 epoch 
> 2 failed to change state for partition __transaction_state-5 from 
> OnlinePartition to OnlinePartition (state.change.logger:76)
> kafka.common.StateChangeFailedException: Failed to elect leader for partition 
> __transaction_state-5 under strategy 
> ControlledShutdownPartitionLeaderElectionStrategy
>       at 
> kafka.controller.ZkPartitionStateMachine$$anonfun$doElectLeaderForPartitions$2.apply(PartitionStateMachine.scala:427)
>       at 
> kafka.controller.ZkPartitionStateMachine$$anonfun$doElectLeaderForPartitions$2.apply(PartitionStateMachine.scala:424)
>       at 
> scala.collection.mutable.ResizableArray$class.foreach(ResizableArray.scala:59)
>       at scala.collection.mutable.ArrayBuffer.foreach(ArrayBuffer.scala:48)
>       at 
> kafka.controller.ZkPartitionStateMachine.doElectLeaderForPartitions(PartitionStateMachine.scala:424)
>       at 
> kafka.controller.ZkPartitionStateMachine.electLeaderForPartitions(PartitionStateMachine.scala:335)
>       at 
> kafka.controller.ZkPartitionStateMachine.doHandleStateChanges(PartitionStateMachine.scala:233)
>       at 
> kafka.controller.ZkPartitionStateMachine.handleStateChanges(PartitionStateMachine.scala:154)
>       at 
> kafka.controller.KafkaController.kafka$controller$KafkaController$$doControlledShutdown(KafkaController.scala:1201)
>       at 
> kafka.controller.KafkaController$$anonfun$23.apply(KafkaController.scala:1163)
>       at 
> kafka.controller.KafkaController$$anonfun$23.apply(KafkaController.scala:1163)
>       at scala.util.Try$.apply(Try.scala:192)
>       at 
> kafka.controller.KafkaController.processControlledShutdown(KafkaController.scala:1163)
>       at kafka.controller.KafkaController.process(KafkaController.scala:1868)
>       at kafka.controller.QueuedEvent.process(ControllerEventManager.scala:53)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply$mcV$sp(ControllerEventManager.scala:137)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply(ControllerEventManager.scala:137)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply(ControllerEventManager.scala:137)
>       at kafka.metrics.KafkaTimer.time(KafkaTimer.scala:31)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread.doWork(ControllerEventManager.scala:136)
>       at kafka.utils.ShutdownableThread.run(ShutdownableThread.scala:96)
> [2019-11-13 06:06:14,059] ERROR [Controller id=2 epoch=2] Controller 2 epoch 
> 2 failed to change state for partition __transaction_state-8 from 
> OnlinePartition to OnlinePartition (state.change.logger:76)
> kafka.common.StateChangeFailedException: Failed to elect leader for partition 
> __transaction_state-8 under strategy 
> ControlledShutdownPartitionLeaderElectionStrategy
>       at 
> kafka.controller.ZkPartitionStateMachine$$anonfun$doElectLeaderForPartitions$2.apply(PartitionStateMachine.scala:427)
>       at 
> kafka.controller.ZkPartitionStateMachine$$anonfun$doElectLeaderForPartitions$2.apply(PartitionStateMachine.scala:424)
>       at 
> scala.collection.mutable.ResizableArray$class.foreach(ResizableArray.scala:59)
>       at scala.collection.mutable.ArrayBuffer.foreach(ArrayBuffer.scala:48)
>       at 
> kafka.controller.ZkPartitionStateMachine.doElectLeaderForPartitions(PartitionStateMachine.scala:424)
>       at 
> kafka.controller.ZkPartitionStateMachine.electLeaderForPartitions(PartitionStateMachine.scala:335)
>       at 
> kafka.controller.ZkPartitionStateMachine.doHandleStateChanges(PartitionStateMachine.scala:233)
>       at 
> kafka.controller.ZkPartitionStateMachine.handleStateChanges(PartitionStateMachine.scala:154)
>       at 
> kafka.controller.KafkaController.kafka$controller$KafkaController$$doControlledShutdown(KafkaController.scala:1201)
>       at 
> kafka.controller.KafkaController$$anonfun$23.apply(KafkaController.scala:1163)
>       at 
> kafka.controller.KafkaController$$anonfun$23.apply(KafkaController.scala:1163)
>       at scala.util.Try$.apply(Try.scala:192)
>       at 
> kafka.controller.KafkaController.processControlledShutdown(KafkaController.scala:1163)
>       at kafka.controller.KafkaController.process(KafkaController.scala:1868)
>       at kafka.controller.QueuedEvent.process(ControllerEventManager.scala:53)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply$mcV$sp(ControllerEventManager.scala:137)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply(ControllerEventManager.scala:137)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply(ControllerEventManager.scala:137)
>       at kafka.metrics.KafkaTimer.time(KafkaTimer.scala:31)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread.doWork(ControllerEventManager.scala:136)
>       at kafka.utils.ShutdownableThread.run(ShutdownableThread.scala:96)
> [2019-11-13 06:06:14,059] ERROR [Controller id=2 epoch=2] Controller 2 epoch 
> 2 failed to change state for partition __transaction_state-16 from 
> OnlinePartition to OnlinePartition (state.change.logger:76)
> kafka.common.StateChangeFailedException: Failed to elect leader for partition 
> __transaction_state-16 under strategy 
> ControlledShutdownPartitionLeaderElectionStrategy
>       at 
> kafka.controller.ZkPartitionStateMachine$$anonfun$doElectLeaderForPartitions$2.apply(PartitionStateMachine.scala:427)
>       at 
> kafka.controller.ZkPartitionStateMachine$$anonfun$doElectLeaderForPartitions$2.apply(PartitionStateMachine.scala:424)
>       at 
> scala.collection.mutable.ResizableArray$class.foreach(ResizableArray.scala:59)
>       at scala.collection.mutable.ArrayBuffer.foreach(ArrayBuffer.scala:48)
>       at 
> kafka.controller.ZkPartitionStateMachine.doElectLeaderForPartitions(PartitionStateMachine.scala:424)
>       at 
> kafka.controller.ZkPartitionStateMachine.electLeaderForPartitions(PartitionStateMachine.scala:335)
>       at 
> kafka.controller.ZkPartitionStateMachine.doHandleStateChanges(PartitionStateMachine.scala:233)
>       at 
> kafka.controller.ZkPartitionStateMachine.handleStateChanges(PartitionStateMachine.scala:154)
>       at 
> kafka.controller.KafkaController.kafka$controller$KafkaController$$doControlledShutdown(KafkaController.scala:1201)
>       at 
> kafka.controller.KafkaController$$anonfun$23.apply(KafkaController.scala:1163)
>       at 
> kafka.controller.KafkaController$$anonfun$23.apply(KafkaController.scala:1163)
>       at scala.util.Try$.apply(Try.scala:192)
>       at 
> kafka.controller.KafkaController.processControlledShutdown(KafkaController.scala:1163)
>       at kafka.controller.KafkaController.process(KafkaController.scala:1868)
>       at kafka.controller.QueuedEvent.process(ControllerEventManager.scala:53)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply$mcV$sp(ControllerEventManager.scala:137)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply(ControllerEventManager.scala:137)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply(ControllerEventManager.scala:137)
>       at kafka.metrics.KafkaTimer.time(KafkaTimer.scala:31)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread.doWork(ControllerEventManager.scala:136)
>       at kafka.utils.ShutdownableThread.run(ShutdownableThread.scala:96)
> [2019-11-13 06:06:14,059] ERROR [Controller id=2 epoch=2] Controller 2 epoch 
> 2 failed to change state for partition __transaction_state-11 from 
> OnlinePartition to OnlinePartition (state.change.logger:76)
> kafka.common.StateChangeFailedException: Failed to elect leader for partition 
> __transaction_state-11 under strategy 
> ControlledShutdownPartitionLeaderElectionStrategy
>       at 
> kafka.controller.ZkPartitionStateMachine$$anonfun$doElectLeaderForPartitions$2.apply(PartitionStateMachine.scala:427)
>       at 
> kafka.controller.ZkPartitionStateMachine$$anonfun$doElectLeaderForPartitions$2.apply(PartitionStateMachine.scala:424)
>       at 
> scala.collection.mutable.ResizableArray$class.foreach(ResizableArray.scala:59)
>       at scala.collection.mutable.ArrayBuffer.foreach(ArrayBuffer.scala:48)
>       at 
> kafka.controller.ZkPartitionStateMachine.doElectLeaderForPartitions(PartitionStateMachine.scala:424)
>       at 
> kafka.controller.ZkPartitionStateMachine.electLeaderForPartitions(PartitionStateMachine.scala:335)
>       at 
> kafka.controller.ZkPartitionStateMachine.doHandleStateChanges(PartitionStateMachine.scala:233)
>       at 
> kafka.controller.ZkPartitionStateMachine.handleStateChanges(PartitionStateMachine.scala:154)
>       at 
> kafka.controller.KafkaController.kafka$controller$KafkaController$$doControlledShutdown(KafkaController.scala:1201)
>       at 
> kafka.controller.KafkaController$$anonfun$23.apply(KafkaController.scala:1163)
>       at 
> kafka.controller.KafkaController$$anonfun$23.apply(KafkaController.scala:1163)
>       at scala.util.Try$.apply(Try.scala:192)
>       at 
> kafka.controller.KafkaController.processControlledShutdown(KafkaController.scala:1163)
>       at kafka.controller.KafkaController.process(KafkaController.scala:1868)
>       at kafka.controller.QueuedEvent.process(ControllerEventManager.scala:53)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply$mcV$sp(ControllerEventManager.scala:137)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply(ControllerEventManager.scala:137)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply(ControllerEventManager.scala:137)
>       at kafka.metrics.KafkaTimer.time(KafkaTimer.scala:31)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread.doWork(ControllerEventManager.scala:136)
>       at kafka.utils.ShutdownableThread.run(ShutdownableThread.scala:96)
> [2019-11-13 06:06:14,060] ERROR [Controller id=2 epoch=2] Controller 2 epoch 
> 2 failed to change state for partition __transaction_state-40 from 
> OnlinePartition to OnlinePartition (state.change.logger:76)
> kafka.common.StateChangeFailedException: Failed to elect leader for partition 
> __transaction_state-40 under strategy 
> ControlledShutdownPartitionLeaderElectionStrategy
>       at 
> kafka.controller.ZkPartitionStateMachine$$anonfun$doElectLeaderForPartitions$2.apply(PartitionStateMachine.scala:427)
>       at 
> kafka.controller.ZkPartitionStateMachine$$anonfun$doElectLeaderForPartitions$2.apply(PartitionStateMachine.scala:424)
>       at 
> scala.collection.mutable.ResizableArray$class.foreach(ResizableArray.scala:59)
>       at scala.collection.mutable.ArrayBuffer.foreach(ArrayBuffer.scala:48)
>       at 
> kafka.controller.ZkPartitionStateMachine.doElectLeaderForPartitions(PartitionStateMachine.scala:424)
>       at 
> kafka.controller.ZkPartitionStateMachine.electLeaderForPartitions(PartitionStateMachine.scala:335)
>       at 
> kafka.controller.ZkPartitionStateMachine.doHandleStateChanges(PartitionStateMachine.scala:233)
>       at 
> kafka.controller.ZkPartitionStateMachine.handleStateChanges(PartitionStateMachine.scala:154)
>       at 
> kafka.controller.KafkaController.kafka$controller$KafkaController$$doControlledShutdown(KafkaController.scala:1201)
>       at 
> kafka.controller.KafkaController$$anonfun$23.apply(KafkaController.scala:1163)
>       at 
> kafka.controller.KafkaController$$anonfun$23.apply(KafkaController.scala:1163)
>       at scala.util.Try$.apply(Try.scala:192)
>       at 
> kafka.controller.KafkaController.processControlledShutdown(KafkaController.scala:1163)
>       at kafka.controller.KafkaController.process(KafkaController.scala:1868)
>       at kafka.controller.QueuedEvent.process(ControllerEventManager.scala:53)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply$mcV$sp(ControllerEventManager.scala:137)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply(ControllerEventManager.scala:137)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply(ControllerEventManager.scala:137)
>       at kafka.metrics.KafkaTimer.time(KafkaTimer.scala:31)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread.doWork(ControllerEventManager.scala:136)
>       at kafka.utils.ShutdownableThread.run(ShutdownableThread.scala:96)
> [2019-11-13 06:06:14,060] ERROR [Controller id=2 epoch=2] Controller 2 epoch 
> 2 failed to change state for partition __transaction_state-19 from 
> OnlinePartition to OnlinePartition (state.change.logger:76)
> kafka.common.StateChangeFailedException: Failed to elect leader for partition 
> __transaction_state-19 under strategy 
> ControlledShutdownPartitionLeaderElectionStrategy
>       at 
> kafka.controller.ZkPartitionStateMachine$$anonfun$doElectLeaderForPartitions$2.apply(PartitionStateMachine.scala:427)
>       at 
> kafka.controller.ZkPartitionStateMachine$$anonfun$doElectLeaderForPartitions$2.apply(PartitionStateMachine.scala:424)
>       at 
> scala.collection.mutable.ResizableArray$class.foreach(ResizableArray.scala:59)
>       at scala.collection.mutable.ArrayBuffer.foreach(ArrayBuffer.scala:48)
>       at 
> kafka.controller.ZkPartitionStateMachine.doElectLeaderForPartitions(PartitionStateMachine.scala:424)
>       at 
> kafka.controller.ZkPartitionStateMachine.electLeaderForPartitions(PartitionStateMachine.scala:335)
>       at 
> kafka.controller.ZkPartitionStateMachine.doHandleStateChanges(PartitionStateMachine.scala:233)
>       at 
> kafka.controller.ZkPartitionStateMachine.handleStateChanges(PartitionStateMachine.scala:154)
>       at 
> kafka.controller.KafkaController.kafka$controller$KafkaController$$doControlledShutdown(KafkaController.scala:1201)
>       at 
> kafka.controller.KafkaController$$anonfun$23.apply(KafkaController.scala:1163)
>       at 
> kafka.controller.KafkaController$$anonfun$23.apply(KafkaController.scala:1163)
>       at scala.util.Try$.apply(Try.scala:192)
>       at 
> kafka.controller.KafkaController.processControlledShutdown(KafkaController.scala:1163)
>       at kafka.controller.KafkaController.process(KafkaController.scala:1868)
>       at kafka.controller.QueuedEvent.process(ControllerEventManager.scala:53)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply$mcV$sp(ControllerEventManager.scala:137)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply(ControllerEventManager.scala:137)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply(ControllerEventManager.scala:137)
>       at kafka.metrics.KafkaTimer.time(KafkaTimer.scala:31)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread.doWork(ControllerEventManager.scala:136)
>       at kafka.utils.ShutdownableThread.run(ShutdownableThread.scala:96)
> [2019-11-13 06:06:14,061] ERROR [Controller id=2 epoch=2] Controller 2 epoch 
> 2 failed to change state for partition __transaction_state-27 from 
> OnlinePartition to OnlinePartition (state.change.logger:76)
> kafka.common.StateChangeFailedException: Failed to elect leader for partition 
> __transaction_state-27 under strategy 
> ControlledShutdownPartitionLeaderElectionStrategy
>       at 
> kafka.controller.ZkPartitionStateMachine$$anonfun$doElectLeaderForPartitions$2.apply(PartitionStateMachine.scala:427)
>       at 
> kafka.controller.ZkPartitionStateMachine$$anonfun$doElectLeaderForPartitions$2.apply(PartitionStateMachine.scala:424)
>       at 
> scala.collection.mutable.ResizableArray$class.foreach(ResizableArray.scala:59)
>       at scala.collection.mutable.ArrayBuffer.foreach(ArrayBuffer.scala:48)
>       at 
> kafka.controller.ZkPartitionStateMachine.doElectLeaderForPartitions(PartitionStateMachine.scala:424)
>       at 
> kafka.controller.ZkPartitionStateMachine.electLeaderForPartitions(PartitionStateMachine.scala:335)
>       at 
> kafka.controller.ZkPartitionStateMachine.doHandleStateChanges(PartitionStateMachine.scala:233)
>       at 
> kafka.controller.ZkPartitionStateMachine.handleStateChanges(PartitionStateMachine.scala:154)
>       at 
> kafka.controller.KafkaController.kafka$controller$KafkaController$$doControlledShutdown(KafkaController.scala:1201)
>       at 
> kafka.controller.KafkaController$$anonfun$23.apply(KafkaController.scala:1163)
>       at 
> kafka.controller.KafkaController$$anonfun$23.apply(KafkaController.scala:1163)
>       at scala.util.Try$.apply(Try.scala:192)
>       at 
> kafka.controller.KafkaController.processControlledShutdown(KafkaController.scala:1163)
>       at kafka.controller.KafkaController.process(KafkaController.scala:1868)
>       at kafka.controller.QueuedEvent.process(ControllerEventManager.scala:53)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply$mcV$sp(ControllerEventManager.scala:137)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply(ControllerEventManager.scala:137)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply(ControllerEventManager.scala:137)
>       at kafka.metrics.KafkaTimer.time(KafkaTimer.scala:31)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread.doWork(ControllerEventManager.scala:136)
>       at kafka.utils.ShutdownableThread.run(ShutdownableThread.scala:96)
> [2019-11-13 06:06:14,061] ERROR [Controller id=2 epoch=2] Controller 2 epoch 
> 2 failed to change state for partition __transaction_state-41 from 
> OnlinePartition to OnlinePartition (state.change.logger:76)
> kafka.common.StateChangeFailedException: Failed to elect leader for partition 
> __transaction_state-41 under strategy 
> ControlledShutdownPartitionLeaderElectionStrategy
>       at 
> kafka.controller.ZkPartitionStateMachine$$anonfun$doElectLeaderForPartitions$2.apply(PartitionStateMachine.scala:427)
>       at 
> kafka.controller.ZkPartitionStateMachine$$anonfun$doElectLeaderForPartitions$2.apply(PartitionStateMachine.scala:424)
>       at 
> scala.collection.mutable.ResizableArray$class.foreach(ResizableArray.scala:59)
>       at scala.collection.mutable.ArrayBuffer.foreach(ArrayBuffer.scala:48)
>       at 
> kafka.controller.ZkPartitionStateMachine.doElectLeaderForPartitions(PartitionStateMachine.scala:424)
>       at 
> kafka.controller.ZkPartitionStateMachine.electLeaderForPartitions(PartitionStateMachine.scala:335)
>       at 
> kafka.controller.ZkPartitionStateMachine.doHandleStateChanges(PartitionStateMachine.scala:233)
>       at 
> kafka.controller.ZkPartitionStateMachine.handleStateChanges(PartitionStateMachine.scala:154)
>       at 
> kafka.controller.KafkaController.kafka$controller$KafkaController$$doControlledShutdown(KafkaController.scala:1201)
>       at 
> kafka.controller.KafkaController$$anonfun$23.apply(KafkaController.scala:1163)
>       at 
> kafka.controller.KafkaController$$anonfun$23.apply(KafkaController.scala:1163)
>       at scala.util.Try$.apply(Try.scala:192)
>       at 
> kafka.controller.KafkaController.processControlledShutdown(KafkaController.scala:1163)
>       at kafka.controller.KafkaController.process(KafkaController.scala:1868)
>       at kafka.controller.QueuedEvent.process(ControllerEventManager.scala:53)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply$mcV$sp(ControllerEventManager.scala:137)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply(ControllerEventManager.scala:137)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply(ControllerEventManager.scala:137)
>       at kafka.metrics.KafkaTimer.time(KafkaTimer.scala:31)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread.doWork(ControllerEventManager.scala:136)
>       at kafka.utils.ShutdownableThread.run(ShutdownableThread.scala:96)
> [2019-11-13 06:06:14,062] ERROR [Controller id=2 epoch=2] Controller 2 epoch 
> 2 failed to change state for partition __transaction_state-1 from 
> OnlinePartition to OnlinePartition (state.change.logger:76)
> kafka.common.StateChangeFailedException: Failed to elect leader for partition 
> __transaction_state-1 under strategy 
> ControlledShutdownPartitionLeaderElectionStrategy
>       at 
> kafka.controller.ZkPartitionStateMachine$$anonfun$doElectLeaderForPartitions$2.apply(PartitionStateMachine.scala:427)
>       at 
> kafka.controller.ZkPartitionStateMachine$$anonfun$doElectLeaderForPartitions$2.apply(PartitionStateMachine.scala:424)
>       at 
> scala.collection.mutable.ResizableArray$class.foreach(ResizableArray.scala:59)
>       at scala.collection.mutable.ArrayBuffer.foreach(ArrayBuffer.scala:48)
>       at 
> kafka.controller.ZkPartitionStateMachine.doElectLeaderForPartitions(PartitionStateMachine.scala:424)
>       at 
> kafka.controller.ZkPartitionStateMachine.electLeaderForPartitions(PartitionStateMachine.scala:335)
>       at 
> kafka.controller.ZkPartitionStateMachine.doHandleStateChanges(PartitionStateMachine.scala:233)
>       at 
> kafka.controller.ZkPartitionStateMachine.handleStateChanges(PartitionStateMachine.scala:154)
>       at 
> kafka.controller.KafkaController.kafka$controller$KafkaController$$doControlledShutdown(KafkaController.scala:1201)
>       at 
> kafka.controller.KafkaController$$anonfun$23.apply(KafkaController.scala:1163)
>       at 
> kafka.controller.KafkaController$$anonfun$23.apply(KafkaController.scala:1163)
>       at scala.util.Try$.apply(Try.scala:192)
>       at 
> kafka.controller.KafkaController.processControlledShutdown(KafkaController.scala:1163)
>       at kafka.controller.KafkaController.process(KafkaController.scala:1868)
>       at kafka.controller.QueuedEvent.process(ControllerEventManager.scala:53)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply$mcV$sp(ControllerEventManager.scala:137)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply(ControllerEventManager.scala:137)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply(ControllerEventManager.scala:137)
>       at kafka.metrics.KafkaTimer.time(KafkaTimer.scala:31)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread.doWork(ControllerEventManager.scala:136)
>       at kafka.utils.ShutdownableThread.run(ShutdownableThread.scala:96)
> [2019-11-13 06:06:14,062] ERROR [Controller id=2 epoch=2] Controller 2 epoch 
> 2 failed to change state for partition __transaction_state-34 from 
> OnlinePartition to OnlinePartition (state.change.logger:76)
> kafka.common.StateChangeFailedException: Failed to elect leader for partition 
> __transaction_state-34 under strategy 
> ControlledShutdownPartitionLeaderElectionStrategy
>       at 
> kafka.controller.ZkPartitionStateMachine$$anonfun$doElectLeaderForPartitions$2.apply(PartitionStateMachine.scala:427)
>       at 
> kafka.controller.ZkPartitionStateMachine$$anonfun$doElectLeaderForPartitions$2.apply(PartitionStateMachine.scala:424)
>       at 
> scala.collection.mutable.ResizableArray$class.foreach(ResizableArray.scala:59)
>       at scala.collection.mutable.ArrayBuffer.foreach(ArrayBuffer.scala:48)
>       at 
> kafka.controller.ZkPartitionStateMachine.doElectLeaderForPartitions(PartitionStateMachine.scala:424)
>       at 
> kafka.controller.ZkPartitionStateMachine.electLeaderForPartitions(PartitionStateMachine.scala:335)
>       at 
> kafka.controller.ZkPartitionStateMachine.doHandleStateChanges(PartitionStateMachine.scala:233)
>       at 
> kafka.controller.ZkPartitionStateMachine.handleStateChanges(PartitionStateMachine.scala:154)
>       at 
> kafka.controller.KafkaController.kafka$controller$KafkaController$$doControlledShutdown(KafkaController.scala:1201)
>       at 
> kafka.controller.KafkaController$$anonfun$23.apply(KafkaController.scala:1163)
>       at 
> kafka.controller.KafkaController$$anonfun$23.apply(KafkaController.scala:1163)
>       at scala.util.Try$.apply(Try.scala:192)
>       at 
> kafka.controller.KafkaController.processControlledShutdown(KafkaController.scala:1163)
>       at kafka.controller.KafkaController.process(KafkaController.scala:1868)
>       at kafka.controller.QueuedEvent.process(ControllerEventManager.scala:53)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply$mcV$sp(ControllerEventManager.scala:137)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply(ControllerEventManager.scala:137)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply(ControllerEventManager.scala:137)
>       at kafka.metrics.KafkaTimer.time(KafkaTimer.scala:31)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread.doWork(ControllerEventManager.scala:136)
>       at kafka.utils.ShutdownableThread.run(ShutdownableThread.scala:96)
> [2019-11-13 06:06:14,062] ERROR [Controller id=2 epoch=2] Controller 2 epoch 
> 2 failed to change state for partition __transaction_state-35 from 
> OnlinePartition to OnlinePartition (state.change.logger:76)
> kafka.common.StateChangeFailedException: Failed to elect leader for partition 
> __transaction_state-35 under strategy 
> ControlledShutdownPartitionLeaderElectionStrategy
>       at 
> kafka.controller.ZkPartitionStateMachine$$anonfun$doElectLeaderForPartitions$2.apply(PartitionStateMachine.scala:427)
>       at 
> kafka.controller.ZkPartitionStateMachine$$anonfun$doElectLeaderForPartitions$2.apply(PartitionStateMachine.scala:424)
>       at 
> scala.collection.mutable.ResizableArray$class.foreach(ResizableArray.scala:59)
>       at scala.collection.mutable.ArrayBuffer.foreach(ArrayBuffer.scala:48)
>       at 
> kafka.controller.ZkPartitionStateMachine.doElectLeaderForPartitions(PartitionStateMachine.scala:424)
>       at 
> kafka.controller.ZkPartitionStateMachine.electLeaderForPartitions(PartitionStateMachine.scala:335)
>       at 
> kafka.controller.ZkPartitionStateMachine.doHandleStateChanges(PartitionStateMachine.scala:233)
>       at 
> kafka.controller.ZkPartitionStateMachine.handleStateChanges(PartitionStateMachine.scala:154)
>       at 
> kafka.controller.KafkaController.kafka$controller$KafkaController$$doControlledShutdown(KafkaController.scala:1201)
>       at 
> kafka.controller.KafkaController$$anonfun$23.apply(KafkaController.scala:1163)
>       at 
> kafka.controller.KafkaController$$anonfun$23.apply(KafkaController.scala:1163)
>       at scala.util.Try$.apply(Try.scala:192)
>       at 
> kafka.controller.KafkaController.processControlledShutdown(KafkaController.scala:1163)
>       at kafka.controller.KafkaController.process(KafkaController.scala:1868)
>       at kafka.controller.QueuedEvent.process(ControllerEventManager.scala:53)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply$mcV$sp(ControllerEventManager.scala:137)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply(ControllerEventManager.scala:137)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread$$anonfun$doWork$1.apply(ControllerEventManager.scala:137)
>       at kafka.metrics.KafkaTimer.time(KafkaTimer.scala:31)
>       at 
> kafka.controller.ControllerEventManager$ControllerEventThread.doWork(ControllerEventManager.scala:136)
>       at kafka.utils.ShutdownableThread.run(ShutdownableThread.scala:96)
> [2019-11-13 06:06:14,065] INFO [KafkaServer id=2] Remaining partitions to 
> move: [RemainingPartition(topicName='__transaction_state', 
> partitionIndex=42), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=31), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=45), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=15), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=12), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=7), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=46), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=48), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=49), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=28), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=2), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=20), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=24), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=13), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=0), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=37), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=3), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=21), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=29), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=39), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=38), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=6), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=14), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=10), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=44), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=9), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=22), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=43), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=4), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=30), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=33), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=32), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=25), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=17), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=23), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=47), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=18), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=26), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=36), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=5), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=8), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=16), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=11), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=40), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=19), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=27), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=41), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=1), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=34), RemainingPartition(topicName='__transaction_state', 
> partitionIndex=35)] (kafka.server.KafkaServer:66)
> [2019-11-13 06:06:14,065] INFO [KafkaServer id=2] Error from controller: NONE 
> (kafka.server.KafkaServer:66)
> [2019-11-13 06:06:19,066] WARN [KafkaServer id=2] Retrying controlled 
> shutdown after the previous attempt failed... (kafka.server.KafkaServer:70)
> [2019-11-13 06:06:19,069] WARN [KafkaServer id=2] Proceeding to do an unclean 
> shutdown as all the controlled shutdown attempts failed 
> (kafka.server.KafkaServer:70)
> [2019-11-13 06:06:19,069] INFO [/config/changes-event-process-thread]: 
> Shutting down 
> (kafka.common.ZkNodeChangeNotificationListener$ChangeEventProcessThread:66)
> [2019-11-13 06:06:19,069] INFO [/config/changes-event-process-thread]: 
> Shutdown completed 
> (kafka.common.ZkNodeChangeNotificationListener$ChangeEventProcessThread:66)
> [2019-11-13 06:06:19,069] INFO [/config/changes-event-process-thread]: 
> Stopped 
> (kafka.common.ZkNodeChangeNotificationListener$ChangeEventProcessThread:66)
> [2019-11-13 06:06:19,070] INFO [SocketServer brokerId=2] Stopping socket 
> server request processors (kafka.network.SocketServer:66)
> [2019-11-13 06:06:19,074] INFO [SocketServer brokerId=2] Stopped socket 
> server request processors (kafka.network.SocketServer:66)
> [2019-11-13 06:06:19,074] INFO [data-plane Kafka Request Handler on Broker 
> 2], shutting down (kafka.server.KafkaRequestHandlerPool:66)
> [2019-11-13 06:06:19,075] INFO [data-plane Kafka Request Handler on Broker 
> 2], shut down completely (kafka.server.KafkaRequestHandlerPool:66)
> [2019-11-13 06:06:19,076] INFO [ExpirationReaper-2-AlterAcls]: Shutting down 
> (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper:66)
> [2019-11-13 06:06:19,143] INFO [ExpirationReaper-2-AlterAcls]: Stopped 
> (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper:66)
> [2019-11-13 06:06:19,143] INFO [ExpirationReaper-2-AlterAcls]: Shutdown 
> completed (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper:66)
> [2019-11-13 06:06:19,144] INFO [KafkaApi-2] Shutdown complete. 
> (kafka.server.KafkaApis:66)
> [2019-11-13 06:06:19,144] INFO [ExpirationReaper-2-topic]: Shutting down 
> (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper:66)
> [2019-11-13 06:06:19,332] INFO [ExpirationReaper-2-topic]: Shutdown completed 
> (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper:66)
> [2019-11-13 06:06:19,332] INFO [ExpirationReaper-2-topic]: Stopped 
> (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper:66)
> [2019-11-13 06:06:19,333] INFO [TransactionCoordinator id=2] Shutting down. 
> (kafka.coordinator.transaction.TransactionCoordinator:66)
> [2019-11-13 06:06:19,333] INFO [ProducerId Manager 2]: Shutdown complete: 
> last producerId assigned 2001 
> (kafka.coordinator.transaction.ProducerIdManager:66)
> [2019-11-13 06:06:19,333] INFO [Transaction State Manager 2]: Shutdown 
> complete (kafka.coordinator.transaction.TransactionStateManager:66)
> [2019-11-13 06:06:19,334] INFO [Transaction Marker Channel Manager 2]: 
> Shutting down 
> (kafka.coordinator.transaction.TransactionMarkerChannelManager:66)
> [2019-11-13 06:06:19,334] INFO [Transaction Marker Channel Manager 2]: 
> Stopped (kafka.coordinator.transaction.TransactionMarkerChannelManager:66)
> [2019-11-13 06:06:19,334] INFO [Transaction Marker Channel Manager 2]: 
> Shutdown completed 
> (kafka.coordinator.transaction.TransactionMarkerChannelManager:66)
> [2019-11-13 06:06:19,335] INFO [TransactionCoordinator id=2] Shutdown 
> complete. (kafka.coordinator.transaction.TransactionCoordinator:66)
> [2019-11-13 06:06:19,335] INFO [GroupCoordinator 2]: Shutting down. 
> (kafka.coordinator.group.GroupCoordinator:66)
> [2019-11-13 06:06:19,335] INFO [ExpirationReaper-2-Heartbeat]: Shutting down 
> (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper:66)
> [2019-11-13 06:06:19,532] INFO [ExpirationReaper-2-Heartbeat]: Shutdown 
> completed (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper:66)
> [2019-11-13 06:06:19,532] INFO [ExpirationReaper-2-Heartbeat]: Stopped 
> (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper:66)
> [2019-11-13 06:06:19,533] INFO [ExpirationReaper-2-Rebalance]: Shutting down 
> (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper:66)
> [2019-11-13 06:06:19,534] INFO [ExpirationReaper-2-Rebalance]: Shutdown 
> completed (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper:66)
> [2019-11-13 06:06:19,534] INFO [ExpirationReaper-2-Rebalance]: Stopped 
> (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper:66)
> [2019-11-13 06:06:19,535] INFO [GroupCoordinator 2]: Shutdown complete. 
> (kafka.coordinator.group.GroupCoordinator:66)
> [2019-11-13 06:06:19,535] INFO [ReplicaManager broker=2] Shutting down 
> (kafka.server.ReplicaManager:66)
> [2019-11-13 06:06:19,535] INFO [LogDirFailureHandler]: Shutting down 
> (kafka.server.ReplicaManager$LogDirFailureHandler:66)
> [2019-11-13 06:06:19,536] INFO [LogDirFailureHandler]: Shutdown completed 
> (kafka.server.ReplicaManager$LogDirFailureHandler:66)
> [2019-11-13 06:06:19,536] INFO [LogDirFailureHandler]: Stopped 
> (kafka.server.ReplicaManager$LogDirFailureHandler:66)
> [2019-11-13 06:06:19,536] INFO [ReplicaFetcherManager on broker 2] shutting 
> down (kafka.server.ReplicaFetcherManager:66)
> [2019-11-13 06:06:19,536] INFO [ReplicaFetcherManager on broker 2] shutdown 
> completed (kafka.server.ReplicaFetcherManager:66)
> [2019-11-13 06:06:19,537] INFO [ReplicaAlterLogDirsManager on broker 2] 
> shutting down (kafka.server.ReplicaAlterLogDirsManager:66)
> [2019-11-13 06:06:19,537] INFO [ReplicaAlterLogDirsManager on broker 2] 
> shutdown completed (kafka.server.ReplicaAlterLogDirsManager:66)
> [2019-11-13 06:06:19,537] INFO [ExpirationReaper-2-Fetch]: Shutting down 
> (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper:66)
> [2019-11-13 06:06:19,630] INFO [ExpirationReaper-2-Fetch]: Stopped 
> (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper:66)
> [2019-11-13 06:06:19,630] INFO [ExpirationReaper-2-Fetch]: Shutdown completed 
> (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper:66)
> [2019-11-13 06:06:19,630] INFO [ExpirationReaper-2-Produce]: Shutting down 
> (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper:66)
> [2019-11-13 06:06:19,696] INFO [ExpirationReaper-2-Produce]: Shutdown 
> completed (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper:66)
> [2019-11-13 06:06:19,696] INFO [ExpirationReaper-2-Produce]: Stopped 
> (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper:66)
> [2019-11-13 06:06:19,696] INFO [ExpirationReaper-2-DeleteRecords]: Shutting 
> down (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper:66)
> [2019-11-13 06:06:19,896] INFO [ExpirationReaper-2-DeleteRecords]: Shutdown 
> completed (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper:66)
> [2019-11-13 06:06:19,896] INFO [ExpirationReaper-2-DeleteRecords]: Stopped 
> (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper:66)
> [2019-11-13 06:06:19,897] INFO [ExpirationReaper-2-ElectLeader]: Shutting 
> down (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper:66)
> [2019-11-13 06:06:20,096] INFO [ExpirationReaper-2-ElectLeader]: Shutdown 
> completed (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper:66)
> [2019-11-13 06:06:20,096] INFO [ExpirationReaper-2-ElectLeader]: Stopped 
> (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper:66)
> [2019-11-13 06:06:20,135] INFO [ReplicaManager broker=2] Shut down completely 
> (kafka.server.ReplicaManager:66)
> [2019-11-13 06:06:20,135] INFO Shutting down. (kafka.log.LogManager:66)
> [2019-11-13 06:06:20,135] INFO Shutting down the log cleaner. 
> (kafka.log.LogCleaner:66)
> [2019-11-13 06:06:20,136] INFO [kafka-log-cleaner-thread-0]: Shutting down 
> (kafka.log.LogCleaner:66)
> [2019-11-13 06:06:20,136] INFO [kafka-log-cleaner-thread-0]: Shutdown 
> completed (kafka.log.LogCleaner:66)
> [2019-11-13 06:06:20,136] INFO [kafka-log-cleaner-thread-0]: Stopped 
> (kafka.log.LogCleaner:66)
> [2019-11-13 06:06:20,154] INFO [ProducerStateManager 
> partition=__transaction_state-25] Writing producer snapshot at offset 19 
> (kafka.log.ProducerStateManager:66)
> [2019-11-13 06:06:20,231] INFO Shutdown complete. (kafka.log.LogManager:66)
> [2019-11-13 06:06:20,231] INFO [ControllerEventThread controllerId=2] 
> Shutting down 
> (kafka.controller.ControllerEventManager$ControllerEventThread:66)
> [2019-11-13 06:06:20,231] INFO [ControllerEventThread controllerId=2] Stopped 
> (kafka.controller.ControllerEventManager$ControllerEventThread:66)
> [2019-11-13 06:06:20,231] INFO [ControllerEventThread controllerId=2] 
> Shutdown completed 
> (kafka.controller.ControllerEventManager$ControllerEventThread:66)
> [2019-11-13 06:06:20,233] INFO [PartitionStateMachine controllerId=2] Stopped 
> partition state machine (kafka.controller.ZkPartitionStateMachine:66)
> [2019-11-13 06:06:20,233] INFO [ReplicaStateMachine controllerId=2] Stopped 
> replica state machine (kafka.controller.ZkReplicaStateMachine:66)
> [2019-11-13 06:06:20,233] INFO [RequestSendThread controllerId=2] Shutting 
> down (kafka.controller.RequestSendThread:66)
> [2019-11-13 06:06:20,234] INFO [RequestSendThread controllerId=2] Stopped 
> (kafka.controller.RequestSendThread:66)
> [2019-11-13 06:06:20,234] INFO [RequestSendThread controllerId=2] Shutdown 
> completed (kafka.controller.RequestSendThread:66)
> [2019-11-13 06:06:20,237] INFO [Controller id=2] Resigned 
> (kafka.controller.KafkaController:66)
> [2019-11-13 06:06:20,237] INFO [ZooKeeperClient Kafka server] Closing. 
> (kafka.zookeeper.ZooKeeperClient:66)
> [2019-11-13 06:06:20,340] INFO Session: 0x100df7ef30e0002 closed 
> (org.apache.zookeeper.ZooKeeper:1422)
> [2019-11-13 06:06:20,340] INFO EventThread shut down for session: 
> 0x100df7ef30e0002 (org.apache.zookeeper.ClientCnxn:524)
> [2019-11-13 06:06:20,340] INFO [ZooKeeperClient Kafka server] Closed. 
> (kafka.zookeeper.ZooKeeperClient:66)
> [2019-11-13 06:06:20,341] INFO [ThrottledChannelReaper-Fetch]: Shutting down 
> (kafka.server.ClientQuotaManager$ThrottledChannelReaper:66)
> [2019-11-13 06:06:21,049] INFO [ThrottledChannelReaper-Fetch]: Stopped 
> (kafka.server.ClientQuotaManager$ThrottledChannelReaper:66)
> [2019-11-13 06:06:21,049] INFO [ThrottledChannelReaper-Fetch]: Shutdown 
> completed (kafka.server.ClientQuotaManager$ThrottledChannelReaper:66)
> [2019-11-13 06:06:21,049] INFO [ThrottledChannelReaper-Produce]: Shutting 
> down (kafka.server.ClientQuotaManager$ThrottledChannelReaper:66)
> [2019-11-13 06:06:22,049] INFO [ThrottledChannelReaper-Produce]: Stopped 
> (kafka.server.ClientQuotaManager$ThrottledChannelReaper:66)
> [2019-11-13 06:06:22,049] INFO [ThrottledChannelReaper-Produce]: Shutdown 
> completed (kafka.server.ClientQuotaManager$ThrottledChannelReaper:66)
> [2019-11-13 06:06:22,049] INFO [ThrottledChannelReaper-Request]: Shutting 
> down (kafka.server.ClientQuotaManager$ThrottledChannelReaper:66)
> [2019-11-13 06:06:23,049] INFO [ThrottledChannelReaper-Request]: Stopped 
> (kafka.server.ClientQuotaManager$ThrottledChannelReaper:66)
> [2019-11-13 06:06:23,049] INFO [ThrottledChannelReaper-Request]: Shutdown 
> completed (kafka.server.ClientQuotaManager$ThrottledChannelReaper:66)
> [2019-11-13 06:06:23,049] INFO [SocketServer brokerId=2] Shutting down socket 
> server (kafka.network.SocketServer:66)
> [2019-11-13 06:06:23,082] INFO [SocketServer brokerId=2] Shutdown completed 
> (kafka.network.SocketServer:66)
> [2019-11-13 06:06:23,084] INFO [KafkaServer id=2] shut down completed 
> (kafka.server.KafkaServer:66)
> [2019-11-13 06:06:23,097] INFO ConnnectionExpirerThread interrupted 
> (org.apache.zookeeper.server.NIOServerCnxnFactory:583)
> [2019-11-13 06:06:23,098] INFO accept thread exitted run method 
> (org.apache.zookeeper.server.NIOServerCnxnFactory:219)
> [2019-11-13 06:06:23,099] INFO selector thread exitted run method 
> (org.apache.zookeeper.server.NIOServerCnxnFactory:420)
> [2019-11-13 06:06:23,099] INFO selector thread exitted run method 
> (org.apache.zookeeper.server.NIOServerCnxnFactory:420)
> [2019-11-13 06:06:23,099] INFO selector thread exitted run method 
> (org.apache.zookeeper.server.NIOServerCnxnFactory:420)
> [2019-11-13 06:06:23,102] INFO shutting down 
> (org.apache.zookeeper.server.ZooKeeperServer:558)
> [2019-11-13 06:06:23,103] INFO Shutting down 
> (org.apache.zookeeper.server.SessionTrackerImpl:237)
> [2019-11-13 06:06:23,103] INFO Shutting down 
> (org.apache.zookeeper.server.PrepRequestProcessor:1007)
> [2019-11-13 06:06:23,103] INFO Shutting down 
> (org.apache.zookeeper.server.SyncRequestProcessor:191)
> [2019-11-13 06:06:23,103] INFO PrepRequestProcessor exited loop! 
> (org.apache.zookeeper.server.PrepRequestProcessor:155)
> [2019-11-13 06:06:23,103] INFO SyncRequestProcessor exited! 
> (org.apache.zookeeper.server.SyncRequestProcessor:169)
> [2019-11-13 06:06:23,104] INFO shutdown of request processor complete 
> (org.apache.zookeeper.server.FinalRequestProcessor:514){noformat}



--
This message was sent by Atlassian Jira
(v8.3.4#803005)