kafka.zookeeper.ZooKeeperClientTimeoutException: Timed out waiting for connection while in state: CONNECTING

启动Kafka提示错误日志如下

[root@abcdocker logs]#  /opt/kafka/bin/kafka-server-start.sh /opt/kafka/config/server.properties
[2023-12-21 11:21:59,612] INFO Registered kafka:type=kafka.Log4jController MBean (kafka.utils.Log4jControllerRegistration$)
[2023-12-21 11:21:59,834] INFO starting (kafka.server.KafkaServer)
[2023-12-21 11:21:59,834] INFO Connecting to zookeeper on 10.111.167.10:2181 (kafka.server.KafkaServer)
[2023-12-21 11:21:59,845] INFO [ZooKeeperClient] Initializing a new session to 10.111.167.10:2181. (kafka.zookeeper.ZooKeeperClient)

[2023-12-21 11:22:13,694] INFO Client environment:zookeeper.version=3.4.13-2d71af4dbe22557fda74f9a9b4309b15a7487f03, built on 06/29/2018 00:39 GMT (org.apache.zookeeper.ZooKeeper)
[2023-12-21 11:22:13,694] INFO Client environment:host.name=ops-dev-middleware-test (org.apache.zookeeper.ZooKeeper)
[2023-12-21 11:22:13,694] INFO Client environment:java.version=1.8.0_231 (org.apache.zookeeper.ZooKeeper)
[2023-12-21 11:22:13,694] INFO Client environment:java.vendor=Oracle Corporation (org.apache.zookeeper.ZooKeeper)
[2023-12-21 11:22:13,694] INFO Client environment:java.home=/usr/local/jdk1.8.0_231/jre (org.apache.zookeeper.ZooKeeper)
[2023-12-21 11:22:13,694] INFO Client environment:java.class.path=.:/usr/local/jdk/lib:/usr/local/jdk/jre/lib:/usr/local/jdk/lib/tools.jar:/opt/kafka/bin/../libs/activation-1.1.1.jar:/opt/kafka/bin/../libs/aopalliance-repackaged-2.5.0-b42.jar:/opt/kafka/bin/../libs/argparse4j-0.7.0.jar:/opt/kafka/bin/../libs/audience-annotations-0.5.0.jar:/opt/kafka/bin/../libs/commons-lang3-3.8.1.jar:/opt/kafka/bin/../libs/connect-api-2.1.1.jar:/opt/kafka/bin/../libs/connect-basic-auth-extension-2.1.1.jar:/opt/kafka/bin/../libs/connect-file-2.1.1.jar:/opt/kafka/bin/../libs/connect-json-2.1.1.jar:/opt/kafka/bin/../libs/connect-runtime-2.1.1.jar:/opt/kafka/bin/../libs/connect-transforms-2.1.1.jar:/opt/kafka/bin/../libs/guava-20.0.jar:/opt/kafka/bin/../libs/hk2-api-2.5.0-b42.jar:/opt/kafka/bin/../libs/hk2-locator-2.5.0-b42.jar:/opt/kafka/bin/../libs/hk2-utils-2.5.0-b42.jar:/opt/kafka/bin/../libs/jackson-annotations-2.9.8.jar:/opt/kafka/bin/../libs/jackson-core-2.9.8.jar:/opt/kafka/bin/../libs/jackson-databind-2.9.8.jar:/opt/kafka/bin/../libs/jackson-jaxrs-base-2.9.8.jar:/opt/kafka/bin/../libs/jackson-jaxrs-json-provider-2.9.8.jar:/opt/kafka/bin/../libs/jackson-module-jaxb-annotations-2.9.8.jar:/opt/kafka/bin/../libs/javassist-3.22.0-CR2.jar:/opt/kafka/bin/../libs/javax.annotation-api-1.2.jar:/opt/kafka/bin/../libs/javax.inject-1.jar:/opt/kafka/bin/../libs/javax.inject-2.5.0-b42.jar:/opt/kafka/bin/../libs/javax.servlet-api-3.1.0.jar:/opt/kafka/bin/../libs/javax.ws.rs-api-2.1.1.jar:/opt/kafka/bin/../libs/javax.ws.rs-api-2.1.jar:/opt/kafka/bin/../libs/jaxb-api-2.3.0.jar:/opt/kafka/bin/../libs/jersey-client-2.27.jar:/opt/kafka/bin/../libs/jersey-common-2.27.jar:/opt/kafka/bin/../libs/jersey-container-servlet-2.27.jar:/opt/kafka/bin/../libs/jersey-container-servlet-core-2.27.jar:/opt/kafka/bin/../libs/jersey-hk2-2.27.jar:/opt/kafka/bin/../libs/jersey-media-jaxb-2.27.jar:/opt/kafka/bin/../libs/jersey-server-2.27.jar:/opt/kafka/bin/../libs/jetty-client-9.4.12.v20180830.jar:/opt/kafka/bin/../libs/jetty-continuation-9.4.12.v20180830.jar:/opt/kafka/bin/../libs/jetty-http-9.4.12.v20180830.jar:/opt/kafka/bin/../libs/jetty-io-9.4.12.v20180830.jar:/opt/kafka/bin/../libs/jetty-security-9.4.12.v20180830.jar:/opt/kafka/bin/../libs/jetty-server-9.4.12.v20180830.jar:/opt/kafka/bin/../libs/jetty-servlet-9.4.12.v20180830.jar:/opt/kafka/bin/../libs/jetty-servlets-9.4.12.v20180830.jar:/opt/kafka/bin/../libs/jetty-util-9.4.12.v20180830.jar:/opt/kafka/bin/../libs/jopt-simple-5.0.4.jar:/opt/kafka/bin/../libs/kafka_2.11-2.1.1.jar:/opt/kafka/bin/../libs/kafka_2.11-2.1.1-sources.jar:/opt/kafka/bin/../libs/kafka-clients-2.1.1.jar:/opt/kafka/bin/../libs/kafka-log4j-appender-2.1.1.jar:/opt/kafka/bin/../libs/kafka-streams-2.1.1.jar:/opt/kafka/bin/../libs/kafka-streams-examples-2.1.1.jar:/opt/kafka/bin/../libs/kafka-streams-scala_2.11-2.1.1.jar:/opt/kafka/bin/../libs/kafka-streams-test-utils-2.1.1.jar:/opt/kafka/bin/../libs/kafka-tools-2.1.1.jar:/opt/kafka/bin/../libs/log4j-1.2.17.jar:/opt/kafka/bin/../libs/lz4-java-1.5.0.jar:/opt/kafka/bin/../libs/maven-artifact-3.6.0.jar:/opt/kafka/bin/../libs/metrics-core-2.2.0.jar:/opt/kafka/bin/../libs/osgi-resource-locator-1.0.1.jar:/opt/kafka/bin/../libs/plexus-utils-3.1.0.jar:/opt/kafka/bin/../libs/reflections-0.9.11.jar:/opt/kafka/bin/../libs/rocksdbjni-5.14.2.jar:/opt/kafka/bin/../libs/scala-library-2.11.12.jar:/opt/kafka/bin/../libs/scala-logging_2.11-3.9.0.jar:/opt/kafka/bin/../libs/scala-reflect-2.11.12.jar:/opt/kafka/bin/../libs/slf4j-api-1.7.25.jar:/opt/kafka/bin/../libs/slf4j-log4j12-1.7.25.jar:/opt/kafka/bin/../libs/snappy-java-1.1.7.2.jar:/opt/kafka/bin/../libs/validation-api-1.1.0.Final.jar:/opt/kafka/bin/../libs/zkclient-0.11.jar:/opt/kafka/bin/../libs/zookeeper-3.4.13.jar:/opt/kafka/bin/../libs/zstd-jni-1.3.7-1.jar (org.apache.zookeeper.ZooKeeper)
[2023-12-21 11:22:13,694] INFO Client environment:java.library.path=/usr/java/packages/lib/amd64:/usr/lib64:/lib64:/lib:/usr/lib (org.apache.zookeeper.ZooKeeper)
[2023-12-21 11:22:13,694] INFO Client environment:java.io.tmpdir=/tmp (org.apache.zookeeper.ZooKeeper)
[2023-12-21 11:22:13,694] INFO Client environment:java.compiler=<NA> (org.apache.zookeeper.ZooKeeper)
[2023-12-21 11:22:13,694] INFO Client environment:os.name=Linux (org.apache.zookeeper.ZooKeeper)
[2023-12-21 11:22:13,694] INFO Client environment:os.arch=amd64 (org.apache.zookeeper.ZooKeeper)
[2023-12-21 11:22:13,694] INFO Client environment:os.version=3.10.0-1160.el7.x86_64 (org.apache.zookeeper.ZooKeeper)
[2023-12-21 11:22:13,694] INFO Client environment:user.name=root (org.apache.zookeeper.ZooKeeper)
[2023-12-21 11:22:13,694] INFO Client environment:user.home=/root (org.apache.zookeeper.ZooKeeper)
[2023-12-21 11:22:13,695] INFO Client environment:user.dir=/opt/kafka/logs (org.apache.zookeeper.ZooKeeper)
[2023-12-21 11:22:13,696] INFO Initiating client connection, connectString=10.111.167.10:2181 sessionTimeout=6000 watcher=kafka.zookeeper.ZooKeeperClient$ZooKeeperClientWatcher$@c8c12ac (org.apache.zookeeper.ZooKeeper)
[2023-12-21 11:22:13,705] INFO [ZooKeeperClient] Waiting until connected. (kafka.zookeeper.ZooKeeperClient)
[2023-12-21 11:22:19,706] INFO [ZooKeeperClient] Closing. (kafka.zookeeper.ZooKeeperClient)
[2023-12-21 11:22:28,712] INFO Opening socket connection to server 10.111.167.10/10.111.167.10:2181. Will not attempt to authenticate using SASL (unknown error) (org.apache.zookeeper.ClientCnxn)
[2023-12-21 11:22:28,716] WARN Client session timed out, have not heard from server in 15012ms for sessionid 0x0 (org.apache.zookeeper.ClientCnxn)
[2023-12-21 11:22:28,818] INFO Session: 0x0 closed (org.apache.zookeeper.ZooKeeper)
[2023-12-21 11:22:28,819] INFO EventThread shut down for session: 0x0 (org.apache.zookeeper.ClientCnxn)
[2023-12-21 11:22:28,820] INFO [ZooKeeperClient] Closed. (kafka.zookeeper.ZooKeeperClient)
[2023-12-21 11:22:28,822] ERROR Fatal error during KafkaServer startup. Prepare to shutdown (kafka.server.KafkaServer)
kafka.zookeeper.ZooKeeperClientTimeoutException: Timed out waiting for connection while in state: CONNECTING
        at kafka.zookeeper.ZooKeeperClient$$anonfun$kafka$zookeeper$ZooKeeperClient$$waitUntilConnected$1.apply$mcV$sp(ZooKeeperClient.scala:268)
        at kafka.zookeeper.ZooKeeperClient$$anonfun$kafka$zookeeper$ZooKeeperClient$$waitUntilConnected$1.apply(ZooKeeperClient.scala:264)
        at kafka.zookeeper.ZooKeeperClient$$anonfun$kafka$zookeeper$ZooKeeperClient$$waitUntilConnected$1.apply(ZooKeeperClient.scala:264)
        at kafka.utils.CoreUtils$.inLock(CoreUtils.scala:251)
        at kafka.zookeeper.ZooKeeperClient.kafka$zookeeper$ZooKeeperClient$$waitUntilConnected(ZooKeeperClient.scala:264)
        at kafka.zookeeper.ZooKeeperClient.<init>(ZooKeeperClient.scala:97)
        at kafka.zk.KafkaZkClient$.apply(KafkaZkClient.scala:1693)
        at kafka.server.KafkaServer.kafka$server$KafkaServer$$createZkClient$1(KafkaServer.scala:348)
        at kafka.server.KafkaServer.initZkClient(KafkaServer.scala:372)
        at kafka.server.KafkaServer.startup(KafkaServer.scala:202)
        at kafka.server.KafkaServerStartable.startup(KafkaServerStartable.scala:38)
        at kafka.Kafka$.main(Kafka.scala:75)
        at kafka.Kafka.main(Kafka.scala)
[2023-12-21 11:22:28,824] INFO shutting down (kafka.server.KafkaServer)
[2023-12-21 11:22:28,826] INFO shut down completed (kafka.server.KafkaServer)
[2023-12-21 11:22:28,826] ERROR Exiting Kafka. (kafka.server.KafkaServerStartable)
[2023-12-21 11:22:28,835] INFO shutting down (kafka.server.KafkaServer)

当前配置文件如下

[root@abcdocker logs]# cat /opt/kafka/config/server.properties
broker.id=2
listeners=PLAINTEXT://:9092
num.network.threads=3
num.io.threads=8
socket.send.buffer.bytes=102400
socket.receive.buffer.bytes=102400
socket.request.max.bytes=104857600
log.dirs=/data/logs/kafaka
num.partitions=1
num.recovery.threads.per.data.dir=1
offsets.topic.replication.factor=1
transaction.state.log.replication.factor=1
transaction.state.log.min.isr=1
log.retention.hours=168
log.segment.bytes=1073741824
log.retention.check.interval.ms=300000
zookeeper.connect=10.10.10.10:2181
zookeeper.connection.timeout.ms=6000
group.initial.rebalance.delay.ms=0
delete.topic.enable=true

解决办法

将zookeeper.connect=ip.port替换为域名的方式

[root@abcdocker logs]# cat /etc/hosts
127.0.0.1   localhost localhost.localdomain localhost4 localhost4.localdomain4
::1         localhost localhost.localdomain localhost6 localhost6.localdomain6

10.10.10.10 zookeeper

修改Kafka配置文件

broker.id=2
listeners=PLAINTEXT://:9092
num.network.threads=3
num.io.threads=8
socket.send.buffer.bytes=102400
socket.receive.buffer.bytes=102400
socket.request.max.bytes=104857600
log.dirs=/data/logs/kafaka
num.partitions=1
num.recovery.threads.per.data.dir=1
offsets.topic.replication.factor=1
transaction.state.log.replication.factor=1
transaction.state.log.min.isr=1
log.retention.hours=168
log.segment.bytes=1073741824
log.retention.check.interval.ms=300000
zookeeper.connect=zookeeper:2181        #此处修改为域名:prot
zookeeper.connection.timeout.ms=6000
group.initial.rebalance.delay.ms=0
delete.topic.enable=true

前台启动测试

$ /opt/kafka/bin/kafka-server-start.sh /opt/kafka/config/server.properties
... (kafka.common.ZkNodeChangeNotificationListener$ChangeEventProcessThread)
[2023-12-21 13:56:45,831] INFO [SocketServer brokerId=2] Started processors for 1 acceptors (kafka.network.SocketServer)
[2023-12-21 13:56:45,833] INFO Kafka version : 2.1.1 (org.apache.kafka.common.utils.AppInfoParser)
[2023-12-21 13:56:45,833] INFO Kafka commitId : 21234bee31165527 (org.apache.kafka.common.utils.AppInfoParser)
[2023-12-21 13:56:45,834] INFO [KafkaServer id=2] started (kafka.server.KafkaServer)

此时可以看到已经启动成功，接下来去ZK看一下是否有Broker ID为2的节点

[root@abcdocker ~]# /opt/zookeeper/bin/zkCli.sh
Connecting to localhost:2181
2023-12-21 13:59:04,057 [myid:] - INFO  [main:Environment@100] - Client environment:zookeeper.version=3.4.13-2d71af4dbe22557fda74f9a9b4309b15a7487f03, built on 06/29/2018 04:05 GMT
2023-12-21 13:59:04,060 [myid:] - INFO  [main:Environment@100] - Client environment:host.name=ops-dev-middleware-test
2023-12-21 13:59:04,060 [myid:] - INFO  [main:Environment@100] - Client environment:java.version=1.8.0_231
2023-12-21 13:59:04,062 [myid:] - INFO  [main:Environment@100] - Client environment:java.vendor=Oracle Corporation
2023-12-21 13:59:04,062 [myid:] - INFO  [main:Environment@100] - Client environment:java.home=/usr/local/jdk1.8.0_231/jre
2023-12-21 13:59:04,062 [myid:] - INFO  [main:Environment@100] - Client environment:java.class.path=/opt/zookeeper/bin/../build/classes:/opt/zookeeper/bin/../build/lib/*.jar:/opt/zookeeper/bin/../lib/slf4j-log4j12-1.7.25.jar:/opt/zookeeper/bin/../lib/slf4j-api-1.7.25.jar:/opt/zookeeper/bin/../lib/netty-3.10.6.Final.jar:/opt/zookeeper/bin/../lib/log4j-1.2.17.jar:/opt/zookeeper/bin/../lib/jline-0.9.94.jar:/opt/zookeeper/bin/../lib/audience-annotations-0.5.0.jar:/opt/zookeeper/bin/../zookeeper-3.4.13.jar:/opt/zookeeper/bin/../src/java/lib/*.jar:/opt/zookeeper/bin/../conf:.:/usr/local/jdk/lib:/usr/local/jdk/jre/lib:/usr/local/jdk/lib/tools.jar
2023-12-21 13:59:04,063 [myid:] - INFO  [main:Environment@100] - Client environment:java.library.path=/usr/java/packages/lib/amd64:/usr/lib64:/lib64:/lib:/usr/lib
2023-12-21 13:59:04,063 [myid:] - INFO  [main:Environment@100] - Client environment:java.io.tmpdir=/tmp
2023-12-21 13:59:04,063 [myid:] - INFO  [main:Environment@100] - Client environment:java.compiler=<NA>
2023-12-21 13:59:04,063 [myid:] - INFO  [main:Environment@100] - Client environment:os.name=Linux
2023-12-21 13:59:04,063 [myid:] - INFO  [main:Environment@100] - Client environment:os.arch=amd64
2023-12-21 13:59:04,063 [myid:] - INFO  [main:Environment@100] - Client environment:os.version=3.10.0-1160.el7.x86_64
2023-12-21 13:59:04,063 [myid:] - INFO  [main:Environment@100] - Client environment:user.name=root
2023-12-21 13:59:04,063 [myid:] - INFO  [main:Environment@100] - Client environment:user.home=/root
2023-12-21 13:59:04,063 [myid:] - INFO  [main:Environment@100] - Client environment:user.dir=/root
2023-12-21 13:59:04,064 [myid:] - INFO  [main:ZooKeeper@442] - Initiating client connection, connectString=localhost:2181 sessionTimeout=30000 watcher=org.apache.zookeeper.ZooKeeperMain$MyWatcher@25f38edc
Welcome to ZooKeeper!
2023-12-21 13:59:04,079 [myid:] - INFO  [main-SendThread(localhost:2181):ClientCnxn$SendThread@1029] - Opening socket connection to server localhost/0:0:0:0:0:0:0:1:2181. Will not attempt to authenticate using SASL (unknown error)
JLine support is enabled
2023-12-21 13:59:04,126 [myid:] - INFO  [main-SendThread(localhost:2181):ClientCnxn$SendThread@879] - Socket connection established to localhost/0:0:0:0:0:0:0:1:2181, initiating session
2023-12-21 13:59:04,134 [myid:] - INFO  [main-SendThread(localhost:2181):ClientCnxn$SendThread@1303] - Session establishment complete on server localhost/0:0:0:0:0:0:0:1:2181, sessionid = 0x1057843d61d0003, negotiated timeout = 30000

WATCHER::

WatchedEvent state:SyncConnected type:None path:null

[zk: localhost:2181(CONNECTED) 8] ls /brokers/ids
[2]     #这里就可以看到有一个Broker ID为2的节点

接下来我们就可以让Kafka后台运行了

 /opt/kafka/bin/kafka-server-start.sh -daemon /opt/kafka/config/server.properties