[ https://issues.apache.org/jira/browse/KAFKA-9573?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=17042123#comment-17042123 ]
Nikolay Izhikov edited comment on KAFKA-9573 at 2/21/20 7:28 PM: ----------------------------------------------------------------- Error for {{test_id: kafkatest.tests.core.upgrade_test.TestUpgrade.test_upgrade.from_kafka_version=0.10.2.2.to_message_format_version=0.9.0.1.compression_types=.none}} {noformat} [2020-02-21 15:14:05,356] DEBUG Ignoring exception during shutdown input (org.apache.zookeeper.ClientCnxnSocketNIO) java.net.SocketException: Socket is not connected at java.base/sun.nio.ch.Net.translateToSocketException(Net.java:162) at java.base/sun.nio.ch.Net.translateException(Net.java:196) at java.base/sun.nio.ch.Net.translateException(Net.java:202) at java.base/sun.nio.ch.SocketAdaptor.shutdownInput(SocketAdaptor.java:400) at org.apache.zookeeper.ClientCnxnSocketNIO.cleanup(ClientCnxnSocketNIO.java:200) at org.apache.zookeeper.ClientCnxn$SendThread.cleanup(ClientCnxn.java:1246) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1182) Caused by: java.nio.channels.NotYetConnectedException at java.base/sun.nio.ch.SocketChannelImpl.shutdownInput(SocketChannelImpl.java:917) at java.base/sun.nio.ch.SocketAdaptor.shutdownInput(SocketAdaptor.java:398) ... 3 more [2020-02-21 15:14:05,359] DEBUG Ignoring exception during shutdown output (org.apache.zookeeper.ClientCnxnSocketNIO) java.net.SocketException: Socket is not connected at java.base/sun.nio.ch.Net.translateToSocketException(Net.java:162) at java.base/sun.nio.ch.Net.translateException(Net.java:196) at java.base/sun.nio.ch.Net.translateException(Net.java:202) at java.base/sun.nio.ch.SocketAdaptor.shutdownOutput(SocketAdaptor.java:408) at org.apache.zookeeper.ClientCnxnSocketNIO.cleanup(ClientCnxnSocketNIO.java:207) at org.apache.zookeeper.ClientCnxn$SendThread.cleanup(ClientCnxn.java:1246) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1182) Caused by: java.nio.channels.NotYetConnectedException at java.base/sun.nio.ch.SocketChannelImpl.shutdownOutput(SocketChannelImpl.java:934) at java.base/sun.nio.ch.SocketAdaptor.shutdownOutput(SocketAdaptor.java:406) ... 3 more [2020-02-21 15:14:05,461] DEBUG Disconnecting client for session: 0x0 (org.apache.zookeeper.ClientCnxn) [2020-02-21 15:14:05,462] INFO Session: 0x0 closed (org.apache.zookeeper.ZooKeeper) [2020-02-21 15:14:05,462] DEBUG Closing ZkClient...done (org.I0Itec.zkclient.ZkClient) [2020-02-21 15:14:05,463] FATAL Fatal error during KafkaServer startup. Prepare to shutdown (kafka.server.KafkaServer) org.I0Itec.zkclient.exception.ZkTimeoutException: Unable to connect to zookeeper server 'ducker14:2181' with timeout of 2000 ms at org.I0Itec.zkclient.ZkClient.connect(ZkClient.java:1233) at org.I0Itec.zkclient.ZkClient.<init>(ZkClient.java:157) at org.I0Itec.zkclient.ZkClient.<init>(ZkClient.java:131) at kafka.utils.ZkUtils$.createZkClientAndConnection(ZkUtils.scala:106) at kafka.utils.ZkUtils$.apply(ZkUtils.scala:88) at kafka.server.KafkaServer.initZk(KafkaServer.scala:326) at kafka.server.KafkaServer.startup(KafkaServer.scala:187) at kafka.server.KafkaServerStartable.startup(KafkaServerStartable.scala:39) at kafka.Kafka$.main(Kafka.scala:67) at kafka.Kafka.main(Kafka.scala) [2020-02-21 15:14:05,464] INFO EventThread shut down for session: 0x0 (org.apache.zookeeper.ClientCnxn) [2020-02-21 15:14:05,464] INFO shutting down (kafka.server.KafkaServer) [2020-02-21 15:14:05,468] DEBUG Shutting down task scheduler. (kafka.utils.KafkaScheduler) [2020-02-21 15:14:05,471] INFO shut down completed (kafka.server.KafkaServer) [2020-02-21 15:14:05,471] FATAL Fatal error during KafkaServerStartable startup. Prepare to shutdown (kafka.server.KafkaServerStartable) org.I0Itec.zkclient.exception.ZkTimeoutException: Unable to connect to zookeeper server 'ducker14:2181' with timeout of 2000 ms at org.I0Itec.zkclient.ZkClient.connect(ZkClient.java:1233) at org.I0Itec.zkclient.ZkClient.<init>(ZkClient.java:157) at org.I0Itec.zkclient.ZkClient.<init>(ZkClient.java:131) at kafka.utils.ZkUtils$.createZkClientAndConnection(ZkUtils.scala:106) at kafka.utils.ZkUtils$.apply(ZkUtils.scala:88) at kafka.server.KafkaServer.initZk(KafkaServer.scala:326) at kafka.server.KafkaServer.startup(KafkaServer.scala:187) at kafka.server.KafkaServerStartable.startup(KafkaServerStartable.scala:39) at kafka.Kafka$.main(Kafka.scala:67) at kafka.Kafka.main(Kafka.scala) [2020-02-21 15:14:05,472] INFO shutting down (kafka.server.KafkaServer) {noformat} was (Author: nizhikov): Error for {{test_id: kafkatest.tests.core.upgrade_test.TestUpgrade.test_upgrade.from_kafka_version=0.10.2.2.to_message_format_version=0.9.0.1.compression_types=.none}} {noformat} [2020-02-21 15:14:05,356] DEBUG Ignoring exception during shutdown input (org.apache.zookeeper.ClientCnxnSocketNIO) java.net.SocketException: Socket is not connected at java.base/sun.nio.ch.Net.translateToSocketException(Net.java:162) at java.base/sun.nio.ch.Net.translateException(Net.java:196) at java.base/sun.nio.ch.Net.translateException(Net.java:202) at java.base/sun.nio.ch.SocketAdaptor.shutdownInput(SocketAdaptor.java:400) at org.apache.zookeeper.ClientCnxnSocketNIO.cleanup(ClientCnxnSocketNIO.java:200) at org.apache.zookeeper.ClientCnxn$SendThread.cleanup(ClientCnxn.java:1246) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1182) Caused by: java.nio.channels.NotYetConnectedException at java.base/sun.nio.ch.SocketChannelImpl.shutdownInput(SocketChannelImpl.java:917) at java.base/sun.nio.ch.SocketAdaptor.shutdownInput(SocketAdaptor.java:398) ... 3 more [2020-02-21 15:14:05,359] DEBUG Ignoring exception during shutdown output (org.apache.zookeeper.ClientCnxnSocketNIO) java.net.SocketException: Socket is not connected at java.base/sun.nio.ch.Net.translateToSocketException(Net.java:162) at java.base/sun.nio.ch.Net.translateException(Net.java:196) at java.base/sun.nio.ch.Net.translateException(Net.java:202) at java.base/sun.nio.ch.SocketAdaptor.shutdownOutput(SocketAdaptor.java:408) at org.apache.zookeeper.ClientCnxnSocketNIO.cleanup(ClientCnxnSocketNIO.java:207) at org.apache.zookeeper.ClientCnxn$SendThread.cleanup(ClientCnxn.java:1246) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1182) Caused by: java.nio.channels.NotYetConnectedException at java.base/sun.nio.ch.SocketChannelImpl.shutdownOutput(SocketChannelImpl.java:934) at java.base/sun.nio.ch.SocketAdaptor.shutdownOutput(SocketAdaptor.java:406) ... 3 more [2020-02-21 15:14:05,461] DEBUG Disconnecting client for session: 0x0 (org.apache.zookeeper.ClientCnxn) [2020-02-21 15:14:05,462] INFO Session: 0x0 closed (org.apache.zookeeper.ZooKeeper) [2020-02-21 15:14:05,462] DEBUG Closing ZkClient...done (org.I0Itec.zkclient.ZkClient) [2020-02-21 15:14:05,463] FATAL Fatal error during KafkaServer startup. Prepare to shutdown (kafka.server.KafkaServer) org.I0Itec.zkclient.exception.ZkTimeoutException: Unable to connect to zookeeper server 'ducker14:2181' with timeout of 2000 ms at org.I0Itec.zkclient.ZkClient.connect(ZkClient.java:1233) at org.I0Itec.zkclient.ZkClient.<init>(ZkClient.java:157) at org.I0Itec.zkclient.ZkClient.<init>(ZkClient.java:131) at kafka.utils.ZkUtils$.createZkClientAndConnection(ZkUtils.scala:106) at kafka.utils.ZkUtils$.apply(ZkUtils.scala:88) at kafka.server.KafkaServer.initZk(KafkaServer.scala:326) at kafka.server.KafkaServer.startup(KafkaServer.scala:187) at kafka.server.KafkaServerStartable.startup(KafkaServerStartable.scala:39) at kafka.Kafka$.main(Kafka.scala:67) at kafka.Kafka.main(Kafka.scala) [2020-02-21 15:14:05,464] INFO EventThread shut down for session: 0x0 (org.apache.zookeeper.ClientCnxn) [2020-02-21 15:14:05,464] INFO shutting down (kafka.server.KafkaServer) [2020-02-21 15:14:05,468] DEBUG Shutting down task scheduler. (kafka.utils.KafkaScheduler) [2020-02-21 15:14:05,471] INFO shut down completed (kafka.server.KafkaServer) [2020-02-21 15:14:05,471] FATAL Fatal error during KafkaServerStartable startup. Prepare to shutdown (kafka.server.KafkaServerStartable) org.I0Itec.zkclient.exception.ZkTimeoutException: Unable to connect to zookeeper server 'ducker14:2181' with timeout of 2000 ms at org.I0Itec.zkclient.ZkClient.connect(ZkClient.java:1233) at org.I0Itec.zkclient.ZkClient.<init>(ZkClient.java:157) at org.I0Itec.zkclient.ZkClient.<init>(ZkClient.java:131) at kafka.utils.ZkUtils$.createZkClientAndConnection(ZkUtils.scala:106) at kafka.utils.ZkUtils$.apply(ZkUtils.scala:88) at kafka.server.KafkaServer.initZk(KafkaServer.scala:326) at kafka.server.KafkaServer.startup(KafkaServer.scala:187) at kafka.server.KafkaServerStartable.startup(KafkaServerStartable.scala:39) at kafka.Kafka$.main(Kafka.scala:67) at kafka.Kafka.main(Kafka.scala) [2020-02-21 15:14:05,472] INFO shutting down (kafka.server.KafkaServer) {noformat > TestUpgrade system test failed on Java11. > ----------------------------------------- > > Key: KAFKA-9573 > URL: https://issues.apache.org/jira/browse/KAFKA-9573 > Project: Kafka > Issue Type: Improvement > Reporter: Nikolay Izhikov > Assignee: Nikolay Izhikov > Priority: Major > > Test was runed on Jdk11 > Test result: > {noformat} > ==================================================================================================== > test_id: > kafkatest.tests.core.upgrade_test.TestUpgrade.test_upgrade.from_kafka_version=0.9.0.1.to_message_format_version=None.security_protocol=SASL_SSL.compression_types=.none > status: FAIL > run time: 1 minute 28.387 seconds > Kafka server didn't finish startup in 60 seconds > Traceback (most recent call last): > File > "/usr/local/lib/python2.7/dist-packages/ducktape/tests/runner_client.py", > line 132, in run > data = self.run_test() > File > "/usr/local/lib/python2.7/dist-packages/ducktape/tests/runner_client.py", > line 189, in run_test > return self.test_context.function(self.test) > File "/usr/local/lib/python2.7/dist-packages/ducktape/mark/_mark.py", line > 428, in wrapper > return functools.partial(f, *args, **kwargs)(*w_args, **w_kwargs) > File "/opt/kafka-dev/tests/kafkatest/tests/core/upgrade_test.py", line 133, > in test_upgrade > self.kafka.start() > File "/opt/kafka-dev/tests/kafkatest/services/kafka/kafka.py", line 242, in > start > Service.start(self) > File "/usr/local/lib/python2.7/dist-packages/ducktape/services/service.py", > line 234, in start > self.start_node(node) > File "/opt/kafka-dev/tests/kafkatest/services/kafka/kafka.py", line 357, in > start_node > err_msg="Kafka server didn't finish startup in %d seconds" % timeout_sec) > File > "/usr/local/lib/python2.7/dist-packages/ducktape/cluster/remoteaccount.py", > line 705, in wait_until > allow_fail=True) == 0, **kwargs) > File "/usr/local/lib/python2.7/dist-packages/ducktape/utils/util.py", line > 41, in wait_until > raise TimeoutError(err_msg() if callable(err_msg) else err_msg) > TimeoutError: Kafka server didn't finish startup in 60 seconds > {noformat} > Detailed output: > {noformat} > [0.001s][warning][gc] -Xloggc is deprecated. Will use > -Xlog:gc:/opt/kafka-0.9.0.1/bin/../logs/kafkaServer-gc.log instead. > Unrecognized VM option 'PrintGCDateStamps' > Error: Could not create the Java Virtual Machine. > Error: A fatal exception has occurred. Program will exit. > ~ > {noformat} -- This message was sent by Atlassian Jira (v8.3.4#803005)