Return-Path: X-Original-To: apmail-cassandra-user-archive@www.apache.org Delivered-To: apmail-cassandra-user-archive@www.apache.org Received: from mail.apache.org (hermes.apache.org [140.211.11.3]) by minotaur.apache.org (Postfix) with SMTP id ED562928A for ; Wed, 25 Apr 2012 07:37:25 +0000 (UTC) Received: (qmail 95340 invoked by uid 500); 25 Apr 2012 07:37:23 -0000 Delivered-To: apmail-cassandra-user-archive@cassandra.apache.org Received: (qmail 95137 invoked by uid 500); 25 Apr 2012 07:37:22 -0000 Mailing-List: contact user-help@cassandra.apache.org; run by ezmlm Precedence: bulk List-Help: List-Unsubscribe: List-Post: List-Id: Reply-To: user@cassandra.apache.org Delivered-To: mailing list user@cassandra.apache.org Received: (qmail 95129 invoked by uid 99); 25 Apr 2012 07:37:22 -0000 Received: from nike.apache.org (HELO nike.apache.org) (192.87.106.230) by apache.org (qpsmtpd/0.29) with ESMTP; Wed, 25 Apr 2012 07:37:22 +0000 X-ASF-Spam-Status: No, hits=2.2 required=5.0 tests=HTML_MESSAGE,RCVD_IN_DNSWL_LOW,SPF_NEUTRAL X-Spam-Check-By: apache.org Received-SPF: neutral (nike.apache.org: local policy) Received: from [74.125.82.44] (HELO mail-wg0-f44.google.com) (74.125.82.44) by apache.org (qpsmtpd/0.29) with ESMTP; Wed, 25 Apr 2012 07:37:12 +0000 Received: by wgbdr13 with SMTP id dr13so1186142wgb.25 for ; Wed, 25 Apr 2012 00:36:52 -0700 (PDT) X-Google-DKIM-Signature: v=1; a=rsa-sha256; c=relaxed/relaxed; d=google.com; s=20120113; h=from:to:subject:date:message-id:mime-version:content-type:x-mailer :thread-index:content-language:x-gm-message-state; bh=lIrVUIfZN+W0uHq3lJNfruMKjSfn5M9P8mWzkhJz/zs=; b=dU+pHgzRboAVaZx+L+X4Rn9XmTK1pqVU0L7jWHmL3hlV7iHIXJ/zxemytPVK2taz8E 9rgakNr8vyizelh15LLQMkTpNQ+xGbsTdF4GN3xDMNez4sVSruRo2GmhKVbd5SBoLtoC Z1+TBsDgnQrJBEeFgUcwyzPJs/vTpeYIJQyj3ZDA+kTq0zuwSWWM0mFMbgL9UAYMHQ5X Ea0Bht4RlRQZ0CWoXYMS8xjOdZg32CnFkNxCY1ifjO3Cp8TNSeAjWCcub3FeS5PcyDwJ K6FdWG3OlC6LOqo1dhrg/i99ejWGddxfh1p04OeRqtf9dwB48EmP3X+8SXINFhOAx9LN h8sQ== Received: by 10.180.79.135 with SMTP id j7mr38169677wix.19.1335339412051; Wed, 25 Apr 2012 00:36:52 -0700 (PDT) Received: from SNOWWHITE (sat78-2-82-237-57-246.fbx.proxad.net. [82.237.57.246]) by mx.google.com with ESMTPS id ex2sm55894433wib.8.2012.04.25.00.36.50 (version=TLSv1/SSLv3 cipher=OTHER); Wed, 25 Apr 2012 00:36:51 -0700 (PDT) From: "Pierre Chalamet" To: Subject: Crash by truncate with cassandra 1.1 Date: Wed, 25 Apr 2012 09:36:49 +0200 Message-ID: <007c01cd22b6$2dde0650$899a12f0$@chalamet.net> MIME-Version: 1.0 Content-Type: multipart/alternative; boundary="----=_NextPart_000_007D_01CD22C6.F17BE4F0" X-Mailer: Microsoft Outlook 14.0 Thread-Index: Ac0ithgjDtb1SQS4QtqFCWsdp/9dRg== Content-Language: fr X-Gm-Message-State: ALoCoQmENGBXk+ne2tXPmryUjH/rKluf16UnXsrN1YLkW2nhW7yZmhRKUyTZvvFQERap5Ac89XlC This is a multipart message in MIME format. ------=_NextPart_000_007D_01CD22C6.F17BE4F0 Content-Type: text/plain; charset="us-ascii" Content-Transfer-Encoding: 7bit Hi, With Cassandra 1.1, I have the following crash on a fresh new single node cluster running on Windows 7. On client side: create keyspace toto; create column family titi; truncate titi; The crash server side (the server is dead then) : D:\Cassandra\apache-cassandra-1.1.0\bin>cassandra.bat Starting Cassandra Server INFO 09:30:29,768 Logging initialized INFO 09:30:29,889 JVM vendor/version: Java HotSpot(TM) Client VM/1.6.0_31 INFO 09:30:29,889 Heap size: 1070399488/1070399488 INFO 09:30:29,890 Classpath: D:\Cassandra\apache-cassandra-1.1.0\conf;D:\Cassandra\apache-cassandra-1.1.0 \lib\antlr-3.2.jar;D:\Cassandra\apache-cassandra-1.1.0\lib\apache-cassandra- 1.1.0.jar;D:\Cassandra\apache-cassandra-1.1.0\lib\apache-cassandra-clientuti l-1.1.0.jar;D:\Cassandra\apache-cassandra-1.1.0\lib\apache-cassandra-thrift- 1.1.0.jar;D:\Cassandra\apache-cassandra-1.1.0\lib\avro-1.4.0-fixes.jar;D:\Ca ssandra\apache-cassandra-1.1.0\lib\avro-1.4.0-sources-fixes.jar;D:\Cassandra \apache-cassandra-1.1.0\lib\commons-cli-1.1.jar;D:\Cassandra\apache-cassandr a-1.1.0\lib\commons-codec-1.2.jar;D:\Cassandra\apache-cassandra-1.1.0\lib\co mmons-lang-2.4.jar;D:\Cassandra\apache-cassandra-1.1.0\lib\compress-lzf-0.8. 4.jar;D:\Cassandra\apache-cassandra-1.1.0\lib\concurrentlinkedhashmap-lru-1. 2.jar;D:\Cassandra\apache-cassandra-1.1.0\lib\guava-r08.jar;D:\Cassandra\apa che-cassandra-1.1.0\lib\high-scale-lib-1.1.2.jar;D:\Cassandra\apache-cassand ra-1.1.0\lib\jackson-core-asl-1.9.2.jar;D:\Cassandra\apache-cassandra-1.1.0\ lib\jackson-mapper-asl-1.9.2.jar;D:\Cassandra\apache-cassandra-1.1.0\lib\jam m-0.2.5.jar;D:\Cassandra\apache-cassandra-1.1.0\lib\jline-0.9.94.jar;D:\Cass andra\apache-cassandra-1.1.0\lib\json-simple-1.1.jar;D:\Cassandra\apache-cas sandra-1.1.0\lib\libthrift-0.7.0.jar;D:\Cassandra\apache-cassandra-1.1.0\lib \log4j-1.2.16.jar;D:\Cassandra\apache-cassandra-1.1.0\lib\metrics-core-2.0.3 .jar;D:\Cassandra\apache-cassandra-1.1.0\lib\servlet-api-2.5-20081211.jar;D: \Cassandra\apache-cassandra-1.1.0\lib\slf4j-api-1.6.1.jar;D:\Cassandra\apach e-cassandra-1.1.0\lib\slf4j-log4j12-1.6.1.jar;D:\Cassandra\apache-cassandra- 1.1.0\lib\snakeyaml-1.6.jar;D:\Cassandra\apache-cassandra-1.1.0\lib\snappy-j ava-1.0.4.1.jar;D:\Cassandra\apache-cassandra-1.1.0\lib\snaptree-0.1.jar;D:\ Cassandra\apache-cassandra-1.1.0\build\classes\main;D:\Cassandra\apache-cass andra-1.1.0\build\classes\thrift;D:\Cassandra\apache-cassandra-1.1.0\lib\jam m-0.2.5.jar INFO 09:30:29,901 JNA not found. Native methods will be disabled. INFO 09:30:29,955 Loading settings from file:/D:/Cassandra/apache-cassandra-1.1.0/conf/cassandra.yaml INFO 09:30:30,243 DiskAccessMode 'auto' determined to be standard, indexAccessMode is standard INFO 09:30:30,708 Global memtable threshold is enabled at 340MB INFO 09:30:31,478 Initializing key cache with capacity of 51 MBs. INFO 09:30:31,573 Scheduling key cache save to each 14400 seconds (going to save all keys). INFO 09:30:31,576 Initializing row cache with capacity of 0 MBs and provider org.apache.cassandra.cache.SerializingCacheProvider INFO 09:30:31,614 Scheduling row cache save to each 0 seconds (going to save all keys). INFO 09:30:32,101 Couldn't detect any schema definitions in local storage. INFO 09:30:32,101 Found table data in data directories. Consider using the CLI to define your schema. INFO 09:30:32,174 No commitlog files found; skipping replay INFO 09:30:32,235 Cassandra version: 1.1.0 INFO 09:30:32,237 Thrift API version: 19.30.0 INFO 09:30:32,252 CQL supported versions: 2.0.0,3.0.0-beta1 (default: 2.0.0) INFO 09:30:32,589 Loading persisted ring state INFO 09:30:32,592 Starting up server gossip INFO 09:30:32,634 Enqueuing flush of Memtable-LocationInfo@24914065(126/157 serialized/live bytes, 3 ops) INFO 09:30:32,635 Writing Memtable-LocationInfo@24914065(126/157 serialized/live bytes, 3 ops) INFO 09:30:33,193 Completed flushing D:\Cassandra\apache-cassandra-1.1.0\storage\data\system\LocationInfo\system- LocationInfo-hc-1-Data.db (234 bytes) INFO 09:30:33,254 Starting Messaging Service on port 7000 INFO 09:30:33,262 This node will not auto bootstrap because it is configured to be a seed node. INFO 09:30:33,271 Saved token not found. Using 0 from configuration INFO 09:30:33,274 Enqueuing flush of Memtable-LocationInfo@5474676(38/47 serialized/live bytes, 2 ops) INFO 09:30:33,275 Writing Memtable-LocationInfo@5474676(38/47 serialized/live bytes, 2 ops) INFO 09:30:33,507 Completed flushing D:\Cassandra\apache-cassandra-1.1.0\storage\data\system\LocationInfo\system- LocationInfo-hc-2-Data.db (148 bytes) INFO 09:30:33,514 Node /127.0.0.1 state jump to normal INFO 09:30:33,516 Bootstrap/Replace/Move completed! Now serving reads. INFO 09:30:33,521 Will not load MX4J, mx4j-tools.jar is not in the classpath INFO 09:30:33,627 Binding thrift service to /127.0.0.1:9160 INFO 09:30:33,632 Using TFastFramedTransport with a max frame size of 15728640 bytes. INFO 09:30:33,636 Using synchronous/threadpool thrift server on /127.0.0.1 : 9160 INFO 09:30:33,638 Listening for thrift clients... INFO 09:30:58,334 Enqueuing flush of Memtable-schema_keyspaces@18093512(184/230 serialized/live bytes, 4 ops) INFO 09:30:58,336 Writing Memtable-schema_keyspaces@18093512(184/230 serialized/live bytes, 4 ops) INFO 09:30:58,853 Completed flushing D:\Cassandra\apache-cassandra-1.1.0\storage\data\system\schema_keyspaces\sys tem-schema_keyspaces-hc-1-Data.db (238 bytes) INFO 09:31:18,695 Enqueuing flush of Memtable-schema_columnfamilies@22440556(1138/1422 serialized/live bytes, 20 ops) INFO 09:31:18,695 Writing Memtable-schema_columnfamilies@22440556(1138/1422 serialized/live bytes, 20 ops) INFO 09:31:18,883 Completed flushing D:\Cassandra\apache-cassandra-1.1.0\storage\data\system\schema_columnfamilie s\system-schema_columnfamilies-hc-1-Data.db (1200 bytes) INFO 09:31:56,690 Enqueuing flush of Memtable-Versions@1878808(83/103 serialized/live bytes, 3 ops) INFO 09:31:56,691 Writing Memtable-Versions@1878808(83/103 serialized/live bytes, 3 ops) INFO 09:31:56,911 Completed flushing D:\Cassandra\apache-cassandra-1.1.0\storage\data\system\Versions\system-Vers ions-hc-1-Data.db (247 bytes) ERROR 09:31:57,093 Exception in thread Thread[COMMIT-LOG-ALLOCATOR,5,main] java.io.IOError: java.io.IOException: Map failed at org.apache.cassandra.db.commitlog.CommitLogSegment.(CommitLogSegment.j ava:127) at org.apache.cassandra.db.commitlog.CommitLogSegment.recycle(CommitLogSegment. java:202) at org.apache.cassandra.db.commitlog.CommitLogAllocator$2.run(CommitLogAllocato r.java:159) at org.apache.cassandra.db.commitlog.CommitLogAllocator$1.runMayThrow(CommitLog Allocator.java:95) at org.apache.cassandra.utils.WrappedRunnable.run(WrappedRunnable.java:30) at java.lang.Thread.run(Unknown Source) Caused by: java.io.IOException: Map failed at sun.nio.ch.FileChannelImpl.map(Unknown Source) at org.apache.cassandra.db.commitlog.CommitLogSegment.(CommitLogSegment.j ava:119) ... 5 more Caused by: java.lang.OutOfMemoryError: Map failed at sun.nio.ch.FileChannelImpl.map0(Native Method) ... 7 more INFO 09:31:57,116 Stop listening to thrift clients INFO 09:31:57,117 Waiting for messaging service to quiesce INFO 09:31:57,136 MessagingService shutting down server thread. Is this a known issue ? Thanks, - Pierre ------=_NextPart_000_007D_01CD22C6.F17BE4F0 Content-Type: text/html; charset="us-ascii" Content-Transfer-Encoding: quoted-printable

Hi,

 

With Cassandra 1.1, I have the following crash on a = fresh new single node cluster running on Windows = 7.

 

On client side:

create keyspace = toto;

create column family = titi;

truncate = titi;

 

The crash server side (the server is dead then) = :

 

D:\Cassandra\apache-cassandra-1.1.0\bin>cassandra.ba= t

Starting = Cassandra Server

INFO 09:30:29,768 Logging = initialized

INFO 09:30:29,889 JVM vendor/version: Java HotSpot(TM) = Client VM/1.6.0_31

INFO 09:30:29,889 Heap size: = 1070399488/1070399488

INFO 09:30:29,890 Classpath: = D:\Cassandra\apache-cassandra-1.1.0\conf;D:\Cassandra\apache-cassandra-1.= 1.0\lib\antlr-3.2.jar;D:\Cassandra\apache-cassandra-1.1.0\lib\apache-cass= andra-1.1.0.jar;D:\Cassandra\apache-cassandra-1.1.0\lib\apache-cassandra-= clientutil-1.1.0.jar;D:\Cassandra\apache-cassandra-1.1.0\lib\apache-cassa= ndra-thrift-1.1.0.jar;D:\Cassandra\apache-cassandra-1.1.0\lib\avro-1.4.0-= fixes.jar;D:\Cassandra\apache-cassandra-1.1.0\lib\avro-1.4.0-sources-fixe= s.jar;D:\Cassandra\apache-cassandra-1.1.0\lib\commons-cli-1.1.jar;D:\Cass= andra\apache-cassandra-1.1.0\lib\commons-codec-1.2.jar;D:\Cassandra\apach= e-cassandra-1.1.0\lib\commons-lang-2.4.jar;D:\Cassandra\apache-cassandra-= 1.1.0\lib\compress-lzf-0.8.4.jar;D:\Cassandra\apache-cassandra-1.1.0\lib\= concurrentlinkedhashmap-lru-1.2.jar;D:\Cassandra\apache-cassandra-1.1.0\l= ib\guava-r08.jar;D:\Cassandra\apache-cassandra-1.1.0\lib\high-scale-lib-1= .1.2.jar;D:\Cassandra\apache-cassandra-1.1.0\lib\jackson-core-asl-1.9.2.j= ar;D:\Cassandra\apache-cassandra-1.1.0\lib\jackson-mapper-asl-1.9.2.jar;D= :\Cassandra\apache-cassandra-1.1.0\lib\jamm-0.2.5.jar;D:\Cassandra\apache= -cassandra-1.1.0\lib\jline-0.9.94.jar;D:\Cassandra\apache-cassandra-1.1.0= \lib\json-simple-1.1.jar;D:\Cassandra\apache-cassandra-1.1.0\lib\libthrif= t-0.7.0.jar;D:\Cassandra\apache-cassandra-1.1.0\lib\log4j-1.2.16.jar;D:\C= assandra\apache-cassandra-1.1.0\lib\metrics-core-2.0.3.jar;D:\Cassandra\a= pache-cassandra-1.1.0\lib\servlet-api-2.5-20081211.jar;D:\Cassandra\apach= e-cassandra-1.1.0\lib\slf4j-api-1.6.1.jar;D:\Cassandra\apache-cassandra-1= .1.0\lib\slf4j-log4j12-1.6.1.jar;D:\Cassandra\apache-cassandra-1.1.0\lib\= snakeyaml-1.6.jar;D:\Cassandra\apache-cassandra-1.1.0\lib\snappy-java-1.0= .4.1.jar;D:\Cassandra\apache-cassandra-1.1.0\lib\snaptree-0.1.jar;D:\Cass= andra\apache-cassandra-1.1.0\build\classes\main;D:\Cassandra\apache-cassa= ndra-1.1.0\build\classes\thrift;D:\Cassandra\apache-cassandra-1.1.0\lib\j= amm-0.2.5.jar

INFO 09:30:29,901 JNA not found. Native methods will be = disabled.

= INFO 09:30:29,955 Loading settings from = file:/D:/Cassandra/apache-cassandra-1.1.0/conf/cassandra.yaml<= /span>

INFO 09:30:30,243 = DiskAccessMode 'auto' determined to be standard, indexAccessMode is = standard

= INFO 09:30:30,708 Global memtable threshold is enabled at = 340MB

INFO = 09:30:31,478 Initializing key cache with capacity of 51 = MBs.

INFO = 09:30:31,573 Scheduling key cache save to each 14400 seconds (going to = save all keys).

INFO 09:30:31,576 Initializing row cache with capacity of = 0 MBs and provider = org.apache.cassandra.cache.SerializingCacheProvider

=

INFO 09:30:31,614 Scheduling = row cache save to each 0 seconds (going to save all = keys).

= INFO 09:30:32,101 Couldn't detect any schema definitions in local = storage.

= INFO 09:30:32,101 Found table data in data directories. Consider using = the CLI to define your schema.

INFO 09:30:32,174 No commitlog = files found; skipping replay

INFO 09:30:32,235 Cassandra = version: 1.1.0

INFO 09:30:32,237 Thrift API version: = 19.30.0

= INFO 09:30:32,252 CQL supported versions: 2.0.0,3.0.0-beta1 (default: = 2.0.0)

= INFO 09:30:32,589 Loading persisted ring state

INFO 09:30:32,592 Starting up = server gossip

INFO 09:30:32,634 Enqueuing flush of = Memtable-LocationInfo@24914065(126/157 serialized/live bytes, 3 = ops)

INFO = 09:30:32,635 Writing Memtable-LocationInfo@24914065(126/157 = serialized/live bytes, 3 ops)

INFO 09:30:33,193 Completed = flushing = D:\Cassandra\apache-cassandra-1.1.0\storage\data\system\LocationInfo\syst= em-LocationInfo-hc-1-Data.db (234 bytes)

INFO 09:30:33,254 Starting = Messaging Service on port 7000

INFO 09:30:33,262 This node will = not auto bootstrap because it is configured to be a seed = node.

INFO = 09:30:33,271 Saved token not found. Using 0 from = configuration

INFO 09:30:33,274 Enqueuing flush of = Memtable-LocationInfo@5474676(38/47 serialized/live bytes, 2 = ops)

INFO = 09:30:33,275 Writing Memtable-LocationInfo@5474676(38/47 serialized/live = bytes, 2 ops)

INFO 09:30:33,507 Completed flushing = D:\Cassandra\apache-cassandra-1.1.0\storage\data\system\LocationInfo\syst= em-LocationInfo-hc-2-Data.db (148 bytes)

INFO 09:30:33,514 Node /127.0.0.1 = state jump to normal

INFO 09:30:33,516 Bootstrap/Replace/Move completed! Now = serving reads.

INFO 09:30:33,521 Will not load MX4J, mx4j-tools.jar is = not in the classpath

INFO 09:30:33,627 Binding thrift service to = /127.0.0.1:9160

INFO 09:30:33,632 Using TFastFramedTransport with a max = frame size of 15728640 bytes.

INFO 09:30:33,636 Using = synchronous/threadpool thrift server on /127.0.0.1 : = 9160

INFO = 09:30:33,638 Listening for thrift clients...

INFO 09:30:58,334 Enqueuing flush = of Memtable-schema_keyspaces@18093512(184/230 serialized/live bytes, 4 = ops)

INFO = 09:30:58,336 Writing Memtable-schema_keyspaces@18093512(184/230 = serialized/live bytes, 4 ops)

INFO 09:30:58,853 Completed = flushing = D:\Cassandra\apache-cassandra-1.1.0\storage\data\system\schema_keyspaces\= system-schema_keyspaces-hc-1-Data.db (238 bytes)

INFO 09:31:18,695 Enqueuing flush = of Memtable-schema_columnfamilies@22440556(1138/1422 serialized/live = bytes, 20 ops)

INFO 09:31:18,695 Writing = Memtable-schema_columnfamilies@22440556(1138/1422 serialized/live bytes, = 20 ops)

= INFO 09:31:18,883 Completed flushing = D:\Cassandra\apache-cassandra-1.1.0\storage\data\system\schema_columnfami= lies\system-schema_columnfamilies-hc-1-Data.db (1200 = bytes)

= INFO 09:31:56,690 Enqueuing flush of Memtable-Versions@1878808(83/103 = serialized/live bytes, 3 ops)

INFO 09:31:56,691 Writing = Memtable-Versions@1878808(83/103 serialized/live bytes, 3 = ops)

INFO = 09:31:56,911 Completed flushing = D:\Cassandra\apache-cassandra-1.1.0\storage\data\system\Versions\system-V= ersions-hc-1-Data.db (247 bytes)

ERROR 09:31:57,093 Exception in = thread Thread[COMMIT-LOG-ALLOCATOR,5,main]

java.io.IOError: = java.io.IOException: Map failed

        at = org.apache.cassandra.db.commitlog.CommitLogSegment.<init>(CommitLog= Segment.java:127)

        at = org.apache.cassandra.db.commitlog.CommitLogSegment.recycle(CommitLogSegme= nt.java:202)

        at = org.apache.cassandra.db.commitlog.CommitLogAllocator$2.run(CommitLogAlloc= ator.java:159)

        at = org.apache.cassandra.db.commitlog.CommitLogAllocator$1.runMayThrow(Commit= LogAllocator.java:95)

        at = org.apache.cassandra.utils.WrappedRunnable.run(WrappedRunnable.java:30)

        at = java.lang.Thread.run(Unknown Source)

Caused by: java.io.IOException: Map = failed

        at = sun.nio.ch.FileChannelImpl.map(Unknown Source)

        at = org.apache.cassandra.db.commitlog.CommitLogSegment.<init>(CommitLog= Segment.java:119)

        ... 5 = more

Caused = by: java.lang.OutOfMemoryError: Map failed

        at = sun.nio.ch.FileChannelImpl.map0(Native Method)

        ... 7 = more

INFO = 09:31:57,116 Stop listening to thrift clients

INFO 09:31:57,117 Waiting for = messaging service to quiesce

INFO 09:31:57,136 MessagingService = shutting down server thread.

 

Is this a known issue = ?

 

Thanks,

- Pierre

 

------=_NextPart_000_007D_01CD22C6.F17BE4F0--