cassandra-commits mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From "Edward Capriolo (JIRA)" <j...@apache.org>
Subject [jira] [Commented] (CASSANDRA-4944) 1.2.0 beta-2 does not start (with ccm)
Date Sun, 11 Nov 2012 05:11:12 GMT

    [ https://issues.apache.org/jira/browse/CASSANDRA-4944?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=13494827#comment-13494827
] 

Edward Capriolo commented on CASSANDRA-4944:
--------------------------------------------

This issue took me two hours to troubleshoot. I opened a ticket then left to get a hot dog.
By the time I got back from my hot dog the issue was closed without investigation. 

You say known bug, what is the bug? We don't know what the bug is. We are just guessing it
is the JVM and not Cassandra. It has happened to me that something is working on a particular
JVM or OS in spite of buggy code. For example, you might be working on a MAC and the mac JVM
will never hit this condition. That does not make the code right, it just makes the code lucky.

Again I have used this JVM for versions of cassandra since 0.7.0 (and all types of java development)
never had a problem. I think it is a bit curious that Cassandra does not even start and it
could be a sign of deeper issues, but maybe not. But we will never know if we just instantly
write the problem off as a jvm problem. 

I will try a few other versions and report back.


                
> 1.2.0 beta-2 does not start (with ccm)
> --------------------------------------
>
>                 Key: CASSANDRA-4944
>                 URL: https://issues.apache.org/jira/browse/CASSANDRA-4944
>             Project: Cassandra
>          Issue Type: Bug
>    Affects Versions: 1.2.0 beta 2
>            Reporter: Edward Capriolo
>
> [edward@tablitha ccm]$ ./ccm remove
> [edward@tablitha ccm]$ ./ccm create 12 -v 1.2.0-beta2
> Current cluster is now: 12
> [edward@tablitha ccm]$ ./ccm populate -n 1
> [edward@tablitha ccm]$ echo $JAVA_HOME
> /usr/java/latest
> [edward@tablitha ccm]$ ./ccm start
> Error starting node1.
> Standard error output is:
> Log looks like this...
>  INFO [main] 2012-11-10 16:11:11,228 CassandraDaemon.java (line 100) Logging initialized
>  INFO [main] 2012-11-10 16:11:11,251 CassandraDaemon.java (line 122) JVM vendor/version:
Java HotSpot(TM) 64-Bit Server VM/1
> .6.0_23
>  INFO [main] 2012-11-10 16:11:11,252 CassandraDaemon.java (line 123) Heap size: 1009778688/1010827264
>  INFO [main] 2012-11-10 16:11:11,252 CassandraDaemon.java (line 124) Classpath: /home/edward/.ccm/12/node1/conf:/home/edward
> /.ccm/repository/1.2.0-beta2/build/classes/main:/home/edward/.ccm/repository/1.2.0-beta2/build/classes/thrift:/home/edward/.
> ccm/repository/1.2.0-beta2/lib/antlr-3.2.jar:/home/edward/.ccm/repository/1.2.0-beta2/lib/avro-1.4.0-fixes.jar:/home/edward/
> .ccm/repository/1.2.0-beta2/lib/avro-1.4.0-sources-fixes.jar:/home/edward/.ccm/repository/1.2.0-beta2/lib/commons-cli-1.1.ja
> r:/home/edward/.ccm/repository/1.2.0-beta2/lib/commons-codec-1.2.jar:/home/edward/.ccm/repository/1.2.0-beta2/lib/commons-la
> ng-2.6.jar:/home/edward/.ccm/repository/1.2.0-beta2/lib/compress-lzf-0.8.4.jar:/home/edward/.ccm/repository/1.2.0-beta2/lib/
> concurrentlinkedhashmap-lru-1.3.jar:/home/edward/.ccm/repository/1.2.0-beta2/lib/guava-13.0.1.jar:/home/edward/.ccm/reposito
> ry/1.2.0-beta2/lib/high-scale-lib-1.1.2.jar:/home/edward/.ccm/repository/1.2.0-beta2/lib/jackson-core-asl-1.9.2.jar:/home/ed
> ward/.ccm/repository/1.2.0-beta2/lib/jackson-mapper-asl-1.9.2.jar:/home/edward/.ccm/repository/1.2.0-beta2/lib/jamm-0.2.5.ja
> r:/home/edward/.ccm/repository/1.2.0-beta2/lib/jline-1.0.jar:/home/edward/.ccm/repository/1.2.0-beta2/lib/json-simple-1.1.ja
> r:/home/edward/.ccm/repository/1.2.0-beta2/lib/libthrift-0.7.0.jar:/home/edward/.ccm/repository/1.2.0-beta2/lib/log4j-1.2.16
> .jar:/home/edward/.ccm/repository/1.2.0-beta2/lib/metrics-core-2.0.3.jar:/home/edward/.ccm/repository/1.2.0-beta2/lib/netty-
> 3.5.9.Final.jar:/home/edward/.ccm/repository/1.2.0-beta2/lib/servlet-api-2.5-20081211.jar:/home/edward/.ccm/repository/1.2.0
> -beta2/lib/slf4j-api-1.6.1.jar:/home/edward/.ccm/repository/1.2.0-beta2/lib/slf4j-log4j12-1.6.1.jar:/home/edward/.ccm/reposi
> tory/1.2.0-beta2/lib/snakeyaml-1.6.jar:/home/edward/.ccm/repository/1.2.0-beta2/lib/snappy-java-1.0.4.1.jar:/home/edward/.cc
> m/repository/1.2.0-beta2/lib/snaptree-0.1.jar:/home/edward/.ccm/repository/1.2.0-beta2/lib/jamm-0.2.5.jar
>  INFO [main] 2012-11-10 16:11:11,254 CLibrary.java (line 61) JNA not found. Native methods
will be disabled.
>  INFO [main] 2012-11-10 16:11:11,271 DatabaseDescriptor.java (line 130) Loading settings
from file:/home/edward/.ccm/12/node
> 1/conf/cassandra.yaml
>  INFO [main] 2012-11-10 16:11:11,458 DatabaseDescriptor.java (line 189) DiskAccessMode
'auto' determined to be mmap, indexAc
> cessMode is mmap
>  INFO [main] 2012-11-10 16:11:11,458 DatabaseDescriptor.java (line 203) disk_failure_policy
is stop
>  INFO [main] 2012-11-10 16:11:11,839 DatabaseDescriptor.java (line 258) Global memtable
threshold is enabled at 321MB
>  INFO [main] 2012-11-10 16:11:12,734 CacheService.java (line 111) Initializing key cache
with capacity of 48 MBs.
>  INFO [main] 2012-11-10 16:11:12,749 CacheService.java (line 140) Scheduling key cache
save to each 14400 seconds (going to 
> save all keys).
>  INFO [main] 2012-11-10 16:11:12,750 CacheService.java (line 154) Initializing row cache
with capacity of 0 MBs and provider
>  org.apache.cassandra.cache.SerializingCacheProvider
>  INFO [main] 2012-11-10 16:11:12,759 CacheService.java (line 166) Scheduling row cache
save to each 0 seconds (going to save
>  all keys).
>  INFO [main] 2012-11-10 16:11:13,254 DatabaseDescriptor.java (line 526) Couldn't detect
any schema definitions in local stor
> age.
>  INFO [main] 2012-11-10 16:11:13,255 DatabaseDescriptor.java (line 529) Found table data
in data directories. Consider using
>  the CLI to define your schema.
>  INFO [main] 2012-11-10 16:11:13,317 CommitLog.java (line 120) No commitlog files found;
skipping replay
>  INFO [main] 2012-11-10 16:11:13,659 StorageService.java (line 403) Cassandra version:
1.2.0-beta2-SNAPSHOT
>  INFO [main] 2012-11-10 16:11:13,659 StorageService.java (line 404) Thrift API version:
19.35.0
>  INFO [main] 2012-11-10 16:11:13,659 StorageService.java (line 405) CQL supported versions:
2.0.0,3.0.0 (default: 3.0.0)
>  INFO [main] 2012-11-10 16:11:13,713 StorageService.java (line 429) Loading persisted
ring state
>  INFO [main] 2012-11-10 16:11:13,717 StorageService.java (line 511) Starting up server
gossip
>  WARN [main] 2012-11-10 16:11:13,728 SystemTable.java (line 470) No host ID found, created
a3af5577-9539-44e0-8e0c-41545bc20
> db8 (Note: This should happen exactly once per node).
>  INFO [main] 2012-11-10 16:11:13,747 ColumnFamilyStore.java (line 646) Enqueuing flush
of Memtable-local@1920333239(260/260 
> serialized/live bytes, 12 ops)
>  INFO [FlushWriter:1] 2012-11-10 16:11:13,757 Memtable.java (line 436) Writing Memtable-local@1920333239(260/260
serialized/
> live bytes, 12 ops)
>  INFO [FlushWriter:1] 2012-11-10 16:11:13,988 Memtable.java (line 470) Completed flushing
/home/edward/.ccm/12/node1/data/sy
> stem/local/system-local-ia-1-Data.db (268 bytes) for commitlog position ReplayPosition(segmentId=1352581873198,
position=457
> 95)
> ERROR [main] 2012-11-10 16:11:14,032 CassandraDaemon.java (line 410) Exception encountered
during startup
> FSReadError in /home/edward/.ccm/12/node1/data/system/local/system-local-ia-1-Data.db
> 	at org.apache.cassandra.io.compress.CompressedRandomAccessReader.close(CompressedRandomAccessReader.java:167)
> 	at sun.nio.ch.FileChannelImpl.implCloseChannel(FileChannelImpl.java:121)
> 	at java.nio.channels.spi.AbstractInterruptibleChannel.close(AbstractInterruptibleChannel.java:97)
> 	at java.io.RandomAccessFile.close(RandomAccessFile.java:541)
> 	at org.apache.cassandra.io.util.RandomAccessReader.close(RandomAccessReader.java:249)
> 	at org.apache.cassandra.io.compress.CompressedRandomAccessReader.close(CompressedRandomAccessReader.java:160)
> 	at org.apache.cassandra.db.columniterator.SimpleSliceReader.close(SimpleSliceReader.java:123)
> 	at org.apache.cassandra.db.columniterator.SSTableSliceIterator.close(SSTableSliceIterator.java:106)
> 	at org.apache.cassandra.io.util.FileUtils.closeQuietly(FileUtils.java:164)
> 	at org.apache.cassandra.db.CollationController.collectAllData(CollationController.java:295)
> 	at org.apache.cassandra.db.CollationController.getTopLevelColumns(CollationController.java:60)
> 	at org.apache.cassandra.db.ColumnFamilyStore.getTopLevelColumns(ColumnFamilyStore.java:1359)
> 	at org.apache.cassandra.db.ColumnFamilyStore.getColumnFamily(ColumnFamilyStore.java:1219)
> 	at org.apache.cassandra.db.ColumnFamilyStore.getColumnFamily(ColumnFamilyStore.java:1131)
> 	at org.apache.cassandra.db.Table.getRow(Table.java:341)
> 	at org.apache.cassandra.db.SliceFromReadCommand.getRow(SliceFromReadCommand.java:70)
> 	at org.apache.cassandra.cql3.statements.SelectStatement.readLocally(SelectStatement.java:155)
> 	at org.apache.cassandra.cql3.statements.SelectStatement.executeInternal(SelectStatement.java:163)
> 	at org.apache.cassandra.cql3.statements.SelectStatement.executeInternal(SelectStatement.java:61)
> 	at org.apache.cassandra.cql3.QueryProcessor.processInternal(QueryProcessor.java:151)
> 	at org.apache.cassandra.db.SystemTable.getLocalHostId(SystemTable.java:460)
> 	at org.apache.cassandra.service.StorageService.joinTokenRing(StorageService.java:525)
> 	at org.apache.cassandra.service.StorageService.initServer(StorageService.java:501)
> 	at org.apache.cassandra.service.StorageService.initServer(StorageService.java:398)
> 	at org.apache.cassandra.service.CassandraDaemon.setup(CassandraDaemon.java:305)
> 	at org.apache.cassandra.service.CassandraDaemon.activate(CassandraDaemon.java:393)
> 	at org.apache.cassandra.service.CassandraDaemon.main(CassandraDaemon.java:436)
> Caused by: java.io.IOException: Bad file descriptor
> 	at sun.nio.ch.FileDispatcher.preClose0(Native Method)
> 	at sun.nio.ch.FileDispatcher.preClose(FileDispatcher.java:59)
> 	at sun.nio.ch.FileChannelImpl.implCloseChannel(FileChannelImpl.java:96)
> 	at java.nio.channels.spi.AbstractInterruptibleChannel.close(AbstractInterruptibleChannel.java:97)
> 	at java.io.FileInputStream.close(FileInputStream.java:258)
> 	at org.apache.cassandra.io.compress.CompressedRandomAccessReader.close(CompressedRandomAccessReader.java:163)
> 	... 26 more
> ERROR [StorageServiceShutdownHook] 2012-11-10 16:11:14,079 CassandraDaemon.java (line
132) Exception in thread Thread[Storag
> eServiceShutdownHook,5,main]
> java.lang.NullPointerException
> 	at org.apache.cassandra.service.StorageService.stopRPCServer(StorageService.java:306)
> 	at org.apache.cassandra.service.StorageService$1.runMayThrow(StorageService.java:462)
> 	at org.apache.cassandra.utils.WrappedRunnable.run(WrappedRunnable.java:28)
> 	at java.lang.Thread.run(Thread.java:662)

--
This message is automatically generated by JIRA.
If you think it was sent incorrectly, please contact your JIRA administrators
For more information on JIRA, see: http://www.atlassian.com/software/jira

Mime
View raw message