Return-Path: X-Original-To: archive-asf-public-internal@cust-asf2.ponee.io Delivered-To: archive-asf-public-internal@cust-asf2.ponee.io Received: from cust-asf.ponee.io (cust-asf.ponee.io [163.172.22.183]) by cust-asf2.ponee.io (Postfix) with ESMTP id CA8BC200D01 for ; Fri, 22 Sep 2017 09:20:04 +0200 (CEST) Received: by cust-asf.ponee.io (Postfix) id C2B161609BE; Fri, 22 Sep 2017 07:20:04 +0000 (UTC) Delivered-To: archive-asf-public@cust-asf.ponee.io Received: from mail.apache.org (hermes.apache.org [140.211.11.3]) by cust-asf.ponee.io (Postfix) with SMTP id B9E861609A7 for ; Fri, 22 Sep 2017 09:20:03 +0200 (CEST) Received: (qmail 19844 invoked by uid 500); 22 Sep 2017 07:20:02 -0000 Mailing-List: contact jira-help@kafka.apache.org; run by ezmlm Precedence: bulk List-Help: List-Unsubscribe: List-Post: List-Id: Reply-To: jira@kafka.apache.org Delivered-To: mailing list jira@kafka.apache.org Received: (qmail 19825 invoked by uid 99); 22 Sep 2017 07:20:02 -0000 Received: from pnap-us-west-generic-nat.apache.org (HELO spamd1-us-west.apache.org) (209.188.14.142) by apache.org (qpsmtpd/0.29) with ESMTP; Fri, 22 Sep 2017 07:20:02 +0000 Received: from localhost (localhost [127.0.0.1]) by spamd1-us-west.apache.org (ASF Mail Server at spamd1-us-west.apache.org) with ESMTP id 41C94CB8C5 for ; Fri, 22 Sep 2017 07:20:02 +0000 (UTC) X-Virus-Scanned: Debian amavisd-new at spamd1-us-west.apache.org X-Spam-Flag: NO X-Spam-Score: -100.002 X-Spam-Level: X-Spam-Status: No, score=-100.002 tagged_above=-999 required=6.31 tests=[RP_MATCHES_RCVD=-0.001, SPF_PASS=-0.001, USER_IN_WHITELIST=-100] autolearn=disabled Received: from mx1-lw-us.apache.org ([10.40.0.8]) by localhost (spamd1-us-west.apache.org [10.40.0.7]) (amavisd-new, port 10024) with ESMTP id sa_-Ib155dtJ for ; Fri, 22 Sep 2017 07:20:01 +0000 (UTC) Received: from mailrelay1-us-west.apache.org (mailrelay1-us-west.apache.org [209.188.14.139]) by mx1-lw-us.apache.org (ASF Mail Server at mx1-lw-us.apache.org) with ESMTP id D15C661132 for ; Fri, 22 Sep 2017 07:20:00 +0000 (UTC) Received: from jira-lw-us.apache.org (unknown [207.244.88.139]) by mailrelay1-us-west.apache.org (ASF Mail Server at mailrelay1-us-west.apache.org) with ESMTP id 55D86E00DF for ; Fri, 22 Sep 2017 07:20:00 +0000 (UTC) Received: from jira-lw-us.apache.org (localhost [127.0.0.1]) by jira-lw-us.apache.org (ASF Mail Server at jira-lw-us.apache.org) with ESMTP id 1777024189 for ; Fri, 22 Sep 2017 07:20:00 +0000 (UTC) Date: Fri, 22 Sep 2017 07:20:00 +0000 (UTC) From: "Mehmet Soner (JIRA)" To: jira@kafka.apache.org Message-ID: In-Reply-To: References: Subject: [jira] [Created] (KAFKA-5962) java.io.IOException: Map failed MIME-Version: 1.0 Content-Type: text/plain; charset=utf-8 Content-Transfer-Encoding: 7bit X-JIRA-FingerPrint: 30527f35849b9dde25b450d4833f0394 archived-at: Fri, 22 Sep 2017 07:20:05 -0000 Mehmet Soner created KAFKA-5962: ----------------------------------- Summary: java.io.IOException: Map failed Key: KAFKA-5962 URL: https://issues.apache.org/jira/browse/KAFKA-5962 Project: Kafka Issue Type: Bug Components: core Affects Versions: 0.11.0.0 Environment: intalling kafka version: kafka_2.12-0.11.0.0 Reporter: Mehmet Soner Priority: Critical Step to reproduce bugs: *1) Starting zookeeper by using below command.* zookeeper-server-start.sh -daemon /usr/local/Apache/kafka_2.12-0.11.0.0/config/zookeeper.properties *2) Starting kafka by using below command.* kafka-server-start.sh -daemon /usr/local/Apache/kafka_2.12-0.11.0.0/config/server0.properties *3) Writing data to topic* /prov/users/sas/bin$ $KAFKA_HOME/bin/kafka-console-producer.sh --broker-list 172.31.19.85:9092 --topic ssmtopup_topic >test1 >test2 >test3 >test4 >test5 *server.log* [2017-09-22 09:51:24,467] INFO Updated PartitionLeaderEpoch. New: {epoch:7, offset:0}, Current: {epoch:-1, offset-1} for Partition: ssmtopup_topic-0. Cache now contains 0 entries. (kafka.server.epoch.LeaderEpochFileCache) [2017-09-22 09:52:23,819] INFO [Group Metadata Manager on Broker 0]: Removed 0 expired offsets in 0 milliseconds. (kafka.coordinator.group.GroupMetadataManager) *4) Exiting by pressing CTRL+C* *5) Shutting down kafka by using below command* *a) finding pid by uisin below command* jps -lm *b) graceful shutdown* kill -15 "You can find error below" *server.log * [2017-09-22 09:52:26,179] INFO [Kafka Server 0], shutting down (kafka.server.KafkaServer) [2017-09-22 09:52:26,219] INFO [Kafka Server 0], Starting controlled shutdown (kafka.server.KafkaServer) [2017-09-22 09:52:26,346] INFO [Kafka Server 0], Controlled shutdown succeeded (kafka.server.KafkaServer) [2017-09-22 09:52:26,356] INFO [Socket Server on Broker 0], Shutting down (kafka.network.SocketServer) [2017-09-22 09:52:26,384] INFO [Socket Server on Broker 0], Shutdown completed (kafka.network.SocketServer) [2017-09-22 09:52:26,386] INFO [Kafka Request Handler on Broker 0], shutting down (kafka.server.KafkaRequestHandlerPool) [2017-09-22 09:52:26,395] INFO [Kafka Request Handler on Broker 0], shut down completely (kafka.server.KafkaRequestHandlerPool) [2017-09-22 09:52:26,411] INFO [ThrottledRequestReaper-Fetch]: Shutting down (kafka.server.ClientQuotaManager$ThrottledRequestReaper) [2017-09-22 09:52:27,032] INFO [ThrottledRequestReaper-Fetch]: Stopped (kafka.server.ClientQuotaManager$ThrottledRequestReaper) [2017-09-22 09:52:27,034] INFO [ThrottledRequestReaper-Fetch]: Shutdown completed (kafka.server.ClientQuotaManager$ThrottledRequestReaper) [2017-09-22 09:52:27,034] INFO [ThrottledRequestReaper-Produce]: Shutting down (kafka.server.ClientQuotaManager$ThrottledRequestReaper) [2017-09-22 09:52:27,701] INFO [ThrottledRequestReaper-Produce]: Shutdown completed (kafka.server.ClientQuotaManager$ThrottledRequestReaper) [2017-09-22 09:52:27,701] INFO [ThrottledRequestReaper-Produce]: Stopped (kafka.server.ClientQuotaManager$ThrottledRequestReaper) [2017-09-22 09:52:27,701] INFO [ThrottledRequestReaper-Request]: Shutting down (kafka.server.ClientQuotaManager$ThrottledRequestReaper) [2017-09-22 09:52:27,985] INFO [ThrottledRequestReaper-Request]: Shutdown completed (kafka.server.ClientQuotaManager$ThrottledRequestReaper) [2017-09-22 09:52:27,985] INFO [ThrottledRequestReaper-Request]: Stopped (kafka.server.ClientQuotaManager$ThrottledRequestReaper) [2017-09-22 09:52:27,988] INFO [KafkaApi-0] Shutdown complete. (kafka.server.KafkaApis) [2017-09-22 09:52:27,991] INFO [ExpirationReaper-0-topic]: Shutting down (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper) [2017-09-22 09:52:28,082] INFO [ExpirationReaper-0-topic]: Stopped (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper) [2017-09-22 09:52:28,088] INFO [ExpirationReaper-0-topic]: Shutdown completed (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper) [2017-09-22 09:52:28,096] INFO [Transaction Coordinator 0]: Shutting down. (kafka.coordinator.transaction.TransactionCoordinator) [2017-09-22 09:52:28,100] INFO [ProducerId Manager 0]: Shutdown complete: last producerId assigned 7000 (kafka.coordinator.transaction.ProducerIdManager) [2017-09-22 09:52:28,102] INFO [Transaction State Manager 0]: Shutdown complete (kafka.coordinator.transaction.TransactionStateManager) [2017-09-22 09:52:28,102] INFO [Transaction Marker Channel Manager 0]: Shutting down (kafka.coordinator.transaction.TransactionMarkerChannelManager) [2017-09-22 09:52:28,104] INFO [Transaction Marker Channel Manager 0]: Stopped (kafka.coordinator.transaction.TransactionMarkerChannelManager) [2017-09-22 09:52:28,104] INFO [Transaction Marker Channel Manager 0]: Shutdown completed (kafka.coordinator.transaction.TransactionMarkerChannelManager) [2017-09-22 09:52:28,105] INFO [Transaction Coordinator 0]: Shutdown complete. (kafka.coordinator.transaction.TransactionCoordinator) [2017-09-22 09:52:28,107] INFO [GroupCoordinator 0]: Shutting down. (kafka.coordinator.group.GroupCoordinator) [2017-09-22 09:52:28,108] INFO [ExpirationReaper-0-Heartbeat]: Shutting down (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper) [2017-09-22 09:52:28,112] INFO [ExpirationReaper-0-Heartbeat]: Stopped (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper) [2017-09-22 09:52:28,112] INFO [ExpirationReaper-0-Heartbeat]: Shutdown completed (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper) [2017-09-22 09:52:28,113] INFO [ExpirationReaper-0-Rebalance]: Shutting down (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper) [2017-09-22 09:52:28,113] INFO [ExpirationReaper-0-Rebalance]: Stopped (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper) [2017-09-22 09:52:28,113] INFO [ExpirationReaper-0-Rebalance]: Shutdown completed (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper) [2017-09-22 09:52:28,114] INFO [GroupCoordinator 0]: Shutdown complete. (kafka.coordinator.group.GroupCoordinator) [2017-09-22 09:52:28,116] INFO [Replica Manager on Broker 0]: Shutting down (kafka.server.ReplicaManager) [2017-09-22 09:52:28,117] INFO [ReplicaFetcherManager on broker 0] shutting down (kafka.server.ReplicaFetcherManager) [2017-09-22 09:52:28,122] INFO [ReplicaFetcherManager on broker 0] shutdown completed (kafka.server.ReplicaFetcherManager) [2017-09-22 09:52:28,122] INFO [ExpirationReaper-0-Fetch]: Shutting down (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper) [2017-09-22 09:52:28,289] INFO [ExpirationReaper-0-Fetch]: Shutdown completed (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper) [2017-09-22 09:52:28,289] INFO [ExpirationReaper-0-Fetch]: Stopped (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper) [2017-09-22 09:52:28,289] INFO [ExpirationReaper-0-Produce]: Shutting down (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper) [2017-09-22 09:52:28,318] INFO [ExpirationReaper-0-Produce]: Stopped (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper) [2017-09-22 09:52:28,318] INFO [ExpirationReaper-0-Produce]: Shutdown completed (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper) [2017-09-22 09:52:28,319] INFO [ExpirationReaper-0-DeleteRecords]: Shutting down (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper) [2017-09-22 09:52:28,379] INFO [ExpirationReaper-0-DeleteRecords]: Shutdown completed (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper) [2017-09-22 09:52:28,379] INFO [ExpirationReaper-0-DeleteRecords]: Stopped (kafka.server.DelayedOperationPurgatory$ExpiredOperationReaper) [2017-09-22 09:52:28,400] INFO [Replica Manager on Broker 0]: Shut down completely (kafka.server.ReplicaManager) [2017-09-22 09:52:28,403] INFO Shutting down. (kafka.log.LogManager) [2017-09-22 09:52:28,644] WARN Map failed (kafka.utils.CoreUtils$) java.io.IOException: Map failed at sun.nio.ch.FileChannelImpl.map(FileChannelImpl.java:943) at kafka.log.AbstractIndex.$anonfun$resize$1(AbstractIndex.scala:115) at kafka.utils.CoreUtils$.inLock(CoreUtils.scala:213) at kafka.log.AbstractIndex.resize(AbstractIndex.scala:105) at kafka.log.AbstractIndex.$anonfun$trimToValidSize$1(AbstractIndex.scala:167) at scala.runtime.java8.JFunction0$mcV$sp.apply(JFunction0$mcV$sp.java:12) at kafka.utils.CoreUtils$.inLock(CoreUtils.scala:213) at kafka.log.AbstractIndex.trimToValidSize(AbstractIndex.scala:167) at kafka.log.AbstractIndex.close(AbstractIndex.scala:178) at kafka.log.LogSegment.$anonfun$close$3(LogSegment.scala:478) at kafka.utils.CoreUtils$.swallow(CoreUtils.scala:78) at kafka.utils.Logging.swallowWarn(Logging.scala:94) at kafka.utils.Logging.swallowWarn$(Logging.scala:93) at kafka.utils.CoreUtils$.swallowWarn(CoreUtils.scala:48) at kafka.utils.Logging.swallow(Logging.scala:96) at kafka.utils.Logging.swallow$(Logging.scala:96) at kafka.utils.CoreUtils$.swallow(CoreUtils.scala:48) at kafka.log.LogSegment.close(LogSegment.scala:478) at kafka.log.Log.$anonfun$close$2(Log.scala:530) at kafka.log.Log.$anonfun$close$2$adapted(Log.scala:530) at scala.collection.Iterator.foreach(Iterator.scala:929) at scala.collection.Iterator.foreach$(Iterator.scala:929) at scala.collection.AbstractIterator.foreach(Iterator.scala:1417) at scala.collection.IterableLike.foreach(IterableLike.scala:71) at scala.collection.IterableLike.foreach$(IterableLike.scala:70) at scala.collection.AbstractIterable.foreach(Iterable.scala:54) at kafka.log.Log.close(Log.scala:530) at kafka.log.LogManager.$anonfun$shutdown$7(LogManager.scala:280) at kafka.utils.CoreUtils$$anon$1.run(CoreUtils.scala:57) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:748) Caused by: java.lang.OutOfMemoryError: Map failed at sun.nio.ch.FileChannelImpl.map0(Native Method) at sun.nio.ch.FileChannelImpl.map(FileChannelImpl.java:940) ... 33 more [2017-09-22 09:52:28,703] INFO Shutdown complete. (kafka.log.LogManager) [2017-09-22 09:52:28,725] INFO Terminate ZkClient event thread. (org.I0Itec.zkclient.ZkEventThread) [2017-09-22 09:52:28,734] INFO Processed session termination for sessionid: 0x15ea850ecaf0000 (org.apache.zookeeper.server.PrepRequestProcessor) [2017-09-22 09:52:28,739] INFO Session: 0x15ea850ecaf0000 closed (org.apache.zookeeper.ZooKeeper) [2017-09-22 09:52:28,743] INFO Closed socket connection for client /127.0.0.1:53962 which had sessionid 0x15ea850ecaf0000 (org.apache.zookeeper.server.NIOServerCnxn) [2017-09-22 09:52:28,745] INFO EventThread shut down for session: 0x15ea850ecaf0000 (org.apache.zookeeper.ClientCnxn) [2017-09-22 09:52:28,753] INFO [Kafka Server 0], shut down completed (kafka.server.KafkaServer) -- This message was sent by Atlassian JIRA (v6.4.14#64029)