Titan with embedded Cassandra -- output for a suspected race condition

gistfile1.txt

stdout

Java virtual machine options are -Xms12G -Xmx12G -javaagent:/home/meres/titan-all-0.3.1/lib/jamm-0.2.5.jar -Dcom.sun.management.jmxremote.port=7199 -Dcom.sun.management.jmxremote.ssl=false -Dcom.sun.management.jmxremote.authenticate=false

stderr

13/07/12 13:13:18 INFO service.CassandraDaemon: JVM vendor/version: Java HotSpot(TM) 64-Bit Server VM/1.7.0_25
13/07/12 13:13:18 INFO service.CassandraDaemon: Heap size: 12348030976/12348030976
13/07/12 13:13:18 INFO service.CassandraDaemon: Classpath: bin/../lib/activation-1.1.jar:bin/../lib/antlr-2.7.7.jar:bin/../lib/antlr-3.2.jar:bin/../lib/antlr-runtime-3.2.jar:bin/../lib/asm-3.1.jar:bin/../lib/asm-4.0.jar:bin/../lib/asm-analysis-3.2.jar:bin/../lib/asm-commons-3.2.jar:bin/../lib/asm-tree-3.2.jar:bin/../lib/asm-util-3.2.jar:bin/../lib/astyanax-cassandra-1.56.37.jar:bin/../lib/astyanax-core-1.56.37.jar:bin/../lib/astyanax-thrift-1.56.37.jar:bin/../lib/avro-1.4.0-cassandra-1.jar:bin/../lib/avro-ipc-1.5.3.jar:bin/../lib/blueprints-core-2.3.0.jar:bin/../lib/cassandra-all-1.2.2.jar:bin/../lib/cassandra-thrift-1.2.2.jar:bin/../lib/colt-1.2.0.jar:bin/../lib/commons-beanutils-1.7.0.jar:bin/../lib/commons-beanutils-core-1.8.0.jar:bin/../lib/commons-cli-1.1.jar:bin/../lib/commons-codec-1.7.jar:bin/../lib/commons-collections-3.2.1.jar:bin/../lib/commons-configuration-1.6.jar:bin/../lib/commons-digester-1.8.jar:bin/../lib/commons-el-1.0.jar:bin/../lib/commons-httpclient-3.1.jar:bin/../lib/commons-io-2.0.1.jar:bin/../lib/commons-lang-2.4.jar:bin/../lib/commons-logging-1.1.1.jar:bin/../lib/commons-math-2.1.jar:bin/../lib/commons-net-1.4.1.jar:bin/../lib/commons-pool-1.5.5.jar:bin/../lib/compress-lzf-0.8.4.jar:bin/../lib/concurrent-1.3.4.jar:bin/../lib/concurrentlinkedhashmap-lru-1.3.jar:bin/../lib/core-3.1.1.jar:bin/../lib/elasticsearch-0.90.0.jar:bin/../lib/frames-2.3.0.jar:bin/../lib/gmbal-3.2.0-b003.jar:bin/../lib/gremlin-groovy-2.3.0.jar:bin/../lib/gremlin-java-2.3.0.jar:bin/../lib/grizzly-core-2.2.16.jar:bin/../lib/grizzly-framework-2.2.16.jar:bin/../lib/grizzly-http-2.2.16.jar:bin/../lib/grizzly-http-server-2.2.16.jar:bin/../lib/grizzly-http-servlet-2.2.16.jar:bin/../lib/grizzly-portunif-2.2.16.jar:bin/../lib/grizzly-rcm-2.2.16.jar:bin/../lib/groovy-1.8.9.jar:bin/../lib/guava-13.0.1.jar:bin/../lib/hadoop-core-1.0.3.jar:bin/../lib/hbase-0.94.1.jar:bin/../lib/high-scale-lib-1.1.2.jar:bin/../lib/hppc-0.4.2.jar:bin/../lib/hsqldb-1.8.0.10.jar:bin/../lib/httpclient-4.0.1.jar:bin/../lib/httpcore-4.0.1.jar:bin/../lib/jackson-annotations-2.1.1.jar:bin/../lib/jackson-core-2.1.2.jar:bin/../lib/jackson-core-asl-1.9.2.jar:bin/../lib/jackson-databind-2.1.2.jar:bin/../lib/jackson-datatype-json-org-2.1.2.jar:bin/../lib/jackson-jaxrs-1.8.8.jar:bin/../lib/jackson-mapper-asl-1.9.2.jar:bin/../lib/jackson-xc-1.8.8.jar:bin/../lib/jamm-0.2.5.jar:bin/../lib/jamon-runtime-2.3.1.jar:bin/../lib/jansi-1.5.jar:bin/../lib/jasper-compiler-5.5.23.jar:bin/../lib/jasper-runtime-5.5.23.jar:bin/../lib/javassist-3.15.0-GA.jar:bin/../lib/javax.servlet-api-3.0.1.jar:bin/../lib/jaxb-api-2.1.jar:bin/../lib/jaxb-impl-2.2.3-1.jar:bin/../lib/jbcrypt-0.3m.jar:bin/../lib/je-5.0.73.jar:bin/../lib/jersey-client-1.17.jar:bin/../lib/jersey-core-1.8.jar:bin/../lib/jersey-grizzly2-1.17.jar:bin/../lib/jersey-json-1.8.jar:bin/../lib/jersey-server-1.8.jar:bin/../lib/jersey-servlet-1.17.jar:bin/../lib/jets3t-0.7.1.jar:bin/../lib/jettison-1.2.jar:bin/../lib/jetty-6.1.26.jar:bin/../lib/jetty-util-6.1.26.jar:bin/../lib/jline-1.0.jar:bin/../lib/joda-time-1.6.2.jar:bin/../lib/json-20090211.jar:bin/../lib/json-simple-1.1.jar:bin/../lib/jsp-2.1-6.1.14.jar:bin/../lib/jsp-api-2.1-6.1.14.jar:bin/../lib/jsr305-1.3.9.jar:bin/../lib/kfs-0.3.jar:bin/../lib/kryo-2.21.jar:bin/../lib/libthrift-0.7.0.jar:bin/../lib/log4j-1.2.16.jar:bin/../lib/lucene-analyzers-common-4.2.1.jar:bin/../lib/lucene-codecs-4.2.1.jar:bin/../lib/lucene-core-4.2.1.jar:bin/../lib/lucene-grouping-4.2.1.jar:bin/../lib/lucene-highlighter-4.2.1.jar:bin/../lib/lucene-join-4.2.1.jar:bin/../lib/lucene-memory-4.2.1.jar:bin/../lib/lucene-queries-4.2.1.jar:bin/../lib/lucene-queryparser-4.2.1.jar:bin/../lib/lucene-sandbox-4.2.1.jar:bin/../lib/lucene-spatial-4.2.1.jar:bin/../lib/lucene-suggest-4.2.1.jar:bin/../lib/lz4-1.1.0.jar:bin/../lib/management-api-3.0.0-b012.jar:bin/../lib/metrics-core-2.0.3.jar:bin/../lib/minlog-1.2.jar:bin/../lib/msgpack-0.6.5.jar:bin/../lib/netty-3.2.7.Final.jar:bin/../lib/objenesis-1.2.jar:bin/../lib/org.apache.servicemix.bundles.commons-csv-1.0-r706900_3.jar:bin/../lib/oro-2.0.8.jar:bin/../lib/pfl-asm-1.0.0-b001.jar:bin/../lib/pfl-basic-1.0.0-b001.jar:bin/../lib/pfl-basic-tools-1.0.0-b001.jar:bin/../lib/pfl-tf-1.0.0-b001.jar:bin/../lib/pfl-tf-tools-1.0.0-b001.jar:bin/../lib/pipes-2.3.0.jar:bin/../lib/protobuf-java-2.4.0a.jar:bin/../lib/reflectasm-1.07-shaded.jar:bin/../lib/rexster-core-2.3.0.jar:bin/../lib/rexster-protocol-2.3.0.jar:bin/../lib/rexster-server-2.3.0.jar:bin/../lib/servlet-api-2.5-6.1.14.jar:bin/../lib/servlet-api-2.5.jar:bin/../lib/slf4j-api-1.6.1.jar:bin/../lib/slf4j-log4j12-1.6.1.jar:bin/../lib/snakeyaml-1.6.jar:bin/../lib/snappy-java-1.0.5-M3.jar:bin/../lib/snaptree-0.1.jar:bin/../lib/spatial4j-0.3.jar:bin/../lib/stax-api-1.0.1.jar:bin/../lib/stringtemplate-3.2.jar:bin/../lib/titan-all-0.3.1.jar:bin/../lib/titan-berkeleyje-0.3.1.jar:bin/../lib/titan-cassandra-0.3.1.jar:bin/../lib/titan-core-0.3.1.jar:bin/../lib/titan-es-0.3.1.jar:bin/../lib/titan-hbase-0.3.1.jar:bin/../lib/uuid-3.2.jar:bin/../lib/velocity-1.7.jar:bin/../lib/xmlenc-0.52.jar:bin/../lib/zookeeper-3.4.3.jar:.:::/home/meres/titan-all-0.3.1/lib/jamm-0.2.5.jar
13/07/12 13:13:18 INFO utils.CLibrary: JNA not found. Native methods will be disabled.
13/07/12 13:13:18 INFO config.DatabaseDescriptor: Loading settings from file:/home/meres/titan-all-0.3.1/config/cassandra.yaml
13/07/12 13:13:19 INFO config.DatabaseDescriptor: DiskAccessMode 'auto' determined to be mmap, indexAccessMode is mmap
13/07/12 13:13:19 INFO config.DatabaseDescriptor: disk_failure_policy is stop
13/07/12 13:13:19 INFO config.DatabaseDescriptor: Global memtable threshold is enabled at 3925MB
13/07/12 13:13:19 INFO service.CacheService: Initializing key cache with capacity of 100 MBs.
13/07/12 13:13:19 INFO service.CacheService: Scheduling key cache save to each 14400 seconds (going to save all keys).
13/07/12 13:13:19 INFO service.CacheService: Initializing row cache with capacity of 0 MBs and provider org.apache.cassandra.cache.SerializingCacheProvider
13/07/12 13:13:19 INFO service.CacheService: Scheduling row cache save to each 0 seconds (going to save all keys).
13/07/12 13:13:19 INFO config.DatabaseDescriptor: Couldn't detect any schema definitions in local storage.
13/07/12 13:13:19 INFO config.DatabaseDescriptor: Found table data in data directories. Consider using the CLI to define your schema.
13/07/12 13:13:20 INFO commitlog.CommitLog: No commitlog files found; skipping replay
13/07/12 13:13:20 INFO service.StorageService: Cassandra version: 1.2.2
13/07/12 13:13:20 INFO service.StorageService: Thrift API version: 19.35.0
13/07/12 13:13:20 INFO service.StorageService: CQL supported versions: 2.0.0,3.0.1 (default: 3.0.1)
13/07/12 13:13:20 INFO service.StorageService: Loading persisted ring state
13/07/12 13:13:20 INFO service.StorageService: Starting up server gossip
13/07/12 13:13:20 WARN db.SystemTable: No host ID found, created 5a60ac76-e3e5-45d9-9e81-9bd981cd22b0 (Note: This should happen exactly once per node).
13/07/12 13:13:20 INFO db.ColumnFamilyStore: Enqueuing flush of Memtable-local@802095274(360/360 serialized/live bytes, 15 ops)
13/07/12 13:13:20 INFO db.Memtable: Writing Memtable-local@802095274(360/360 serialized/live bytes, 15 ops)
13/07/12 13:13:20 INFO db.Memtable: Completed flushing /tmp/cassandra/data/system/local/system-local-ib-1-Data.db (346 bytes) for commitlog position ReplayPosition(segmentId=1373627599882, position=50655)
13/07/12 13:13:20 INFO net.MessagingService: Starting Messaging Service on port 7000
13/07/12 13:13:20 WARN service.StorageService: Generated random token [113065325256129767233016343950775483406]. Random tokens will result in an unbalanced ring; see http://wiki.apache.org/cassandra/Operations
13/07/12 13:13:20 INFO db.ColumnFamilyStore: Enqueuing flush of Memtable-local@930838147(84/84 serialized/live bytes, 4 ops)
13/07/12 13:13:20 INFO db.Memtable: Writing Memtable-local@930838147(84/84 serialized/live bytes, 4 ops)
13/07/12 13:13:20 INFO db.Memtable: Completed flushing /tmp/cassandra/data/system/local/system-local-ib-2-Data.db (121 bytes) for commitlog position ReplayPosition(segmentId=1373627599882, position=50930)
13/07/12 13:13:20 INFO db.ColumnFamilyStore: Enqueuing flush of Memtable-local@898062854(70/70 serialized/live bytes, 2 ops)
13/07/12 13:13:20 INFO db.Memtable: Writing Memtable-local@898062854(70/70 serialized/live bytes, 2 ops)
13/07/12 13:13:20 INFO db.Memtable: Completed flushing /tmp/cassandra/data/system/local/system-local-ib-3-Data.db (129 bytes) for commitlog position ReplayPosition(segmentId=1373627599882, position=51124)
13/07/12 13:13:20 INFO service.StorageService: Node localhost/127.0.0.1 state jump to normal
13/07/12 13:13:20 INFO service.StorageService: Startup completed! Now serving reads.
13/07/12 13:13:20 INFO service.MigrationManager: Create new Keyspace: system_auth, rep strategy:SimpleStrategy{}, strategy_options: {replication_factor=1}, durable_writes: true
13/07/12 13:13:20 INFO db.ColumnFamilyStore: Enqueuing flush of Memtable-schema_keyspaces@120742411(389/389 serialized/live bytes, 11 ops)
13/07/12 13:13:20 INFO db.Memtable: Writing Memtable-schema_keyspaces@120742411(389/389 serialized/live bytes, 11 ops)
13/07/12 13:13:20 INFO db.Memtable: Completed flushing /tmp/cassandra/data/system/schema_keyspaces/system-schema_keyspaces-ib-1-Data.db (258 bytes) for commitlog position ReplayPosition(segmentId=1373627599882, position=51365)
13/07/12 13:13:20 INFO db.ColumnFamilyStore: Enqueuing flush of Memtable-schema_columnfamilies@1604073030(21969/21969 serialized/live bytes, 359 ops)
13/07/12 13:13:20 INFO db.Memtable: Writing Memtable-schema_columnfamilies@1604073030(21969/21969 serialized/live bytes, 359 ops)
13/07/12 13:13:20 INFO db.Memtable: Completed flushing /tmp/cassandra/data/system/schema_columnfamilies/system-schema_columnfamilies-ib-1-Data.db (4533 bytes) for commitlog position ReplayPosition(segmentId=1373627599882, position=51365)
13/07/12 13:13:20 INFO db.ColumnFamilyStore: Enqueuing flush of Memtable-schema_columns@1718991168(21903/21903 serialized/live bytes, 332 ops)
13/07/12 13:13:20 INFO db.Memtable: Writing Memtable-schema_columns@1718991168(21903/21903 serialized/live bytes, 332 ops)
13/07/12 13:13:21 INFO db.Memtable: Completed flushing /tmp/cassandra/data/system/schema_columns/system-schema_columns-ib-1-Data.db (3776 bytes) for commitlog position ReplayPosition(segmentId=1373627599882, position=51365)
13/07/12 13:13:21 INFO service.MigrationManager: Create new ColumnFamily: org.apache.cassandra.config.CFMetaData@326ee73c[cfId=473588ad-9c79-38be-8b59-e06c10456ba0,ksName=system_auth,cfName=users,cfType=Standard,comparator=org.apache.cassandra.db.marshal.CompositeType(org.apache.cassandra.db.marshal.UTF8Type),subcolumncomparator=<null>,comment=,readRepairChance=0.1,dclocalReadRepairChance=0.0,replicateOnWrite=true,gcGraceSeconds=7776000,defaultValidator=org.apache.cassandra.db.marshal.BytesType,keyValidator=org.apache.cassandra.db.marshal.UTF8Type,minCompactionThreshold=4,maxCompactionThreshold=32,keyAliases=[java.nio.HeapByteBuffer[pos=0 lim=4 cap=4]],columnAliases=[],valueAlias=<null>,column_metadata={java.nio.HeapByteBuffer[pos=0 lim=5 cap=5]=ColumnDefinition{name=7375706572, validator=org.apache.cassandra.db.marshal.BooleanType, index_type=null, index_name='null', component_index=0}},compactionStrategyClass=class org.apache.cassandra.db.compaction.SizeTieredCompactionStrategy,compactionStrategyOptions={},compressionOptions={sstable_compression=org.apache.cassandra.io.compress.SnappyCompressor},bloomFilterFpChance=0.01,caching=KEYS_ONLY,populateIoCacheOnFlush=false]
13/07/12 13:13:21 INFO db.ColumnFamilyStore: Enqueuing flush of Memtable-schema_columnfamilies@821547538(1097/1097 serialized/live bytes, 20 ops)
13/07/12 13:13:21 INFO db.Memtable: Writing Memtable-schema_columnfamilies@821547538(1097/1097 serialized/live bytes, 20 ops)
13/07/12 13:13:21 INFO db.Memtable: Completed flushing /tmp/cassandra/data/system/schema_columnfamilies/system-schema_columnfamilies-ib-2-Data.db (702 bytes) for commitlog position ReplayPosition(segmentId=1373627599882, position=53149)
13/07/12 13:13:21 INFO db.ColumnFamilyStore: Enqueuing flush of Memtable-schema_columns@1471208762(251/251 serialized/live bytes, 5 ops)
13/07/12 13:13:21 INFO db.Memtable: Writing Memtable-schema_columns@1471208762(251/251 serialized/live bytes, 5 ops)
13/07/12 13:13:21 INFO db.Memtable: Completed flushing /tmp/cassandra/data/system/schema_columns/system-schema_columns-ib-2-Data.db (209 bytes) for commitlog position ReplayPosition(segmentId=1373627599882, position=53149)
13/07/12 13:13:21 INFO service.CassandraDaemon: Not starting native transport as requested. Use JMX (StorageService->startNativeTransport()) to start it
13/07/12 13:13:21 INFO thrift.ThriftServer: Binding thrift service to localhost/127.0.0.1:9160
13/07/12 13:13:21 INFO thrift.ThriftServer: Using TFramedTransport with a max frame size of 15728640 bytes.
13/07/12 13:13:21 INFO thrift.TServerCustomFactory: Using synchronous/threadpool thrift server on localhost : 9160
13/07/12 13:13:21 INFO service.MigrationManager: Create new Keyspace: titan, rep strategy:SimpleStrategy{}, strategy_options: {replication_factor=1}, durable_writes: true
13/07/12 13:13:21 INFO thrift.ThriftServer: Listening for thrift clients...
13/07/12 13:13:21 INFO db.ColumnFamilyStore: Enqueuing flush of Memtable-schema_keyspaces@659126751(138/138 serialized/live bytes, 3 ops)
13/07/12 13:13:21 INFO db.Memtable: Writing Memtable-schema_keyspaces@659126751(138/138 serialized/live bytes, 3 ops)
13/07/12 13:13:21 INFO db.Memtable: Completed flushing /tmp/cassandra/data/system/schema_keyspaces/system-schema_keyspaces-ib-2-Data.db (167 bytes) for commitlog position ReplayPosition(segmentId=1373627599882, position=53526)
13/07/12 13:13:21 WARN embedded.CassandraEmbeddedStoreManager: Set CompressionParameters org.apache.cassandra.io.compress.CompressionParameters@f16f93aa
13/07/12 13:13:21 INFO service.MigrationManager: Create new ColumnFamily: org.apache.cassandra.config.CFMetaData@45449c55[cfId=404782f9-6583-3993-aa6a-265c09135dde,ksName=titan,cfName=titan_ids,cfType=Standard,comparator=org.apache.cassandra.db.marshal.BytesType,subcolumncomparator=<null>,comment=,readRepairChance=0.1,dclocalReadRepairChance=0.0,replicateOnWrite=true,gcGraceSeconds=864000,defaultValidator=org.apache.cassandra.db.marshal.BytesType,keyValidator=org.apache.cassandra.db.marshal.BytesType,minCompactionThreshold=4,maxCompactionThreshold=32,keyAliases=[],columnAliases=[],valueAlias=<null>,column_metadata={},compactionStrategyClass=class org.apache.cassandra.db.compaction.SizeTieredCompactionStrategy,compactionStrategyOptions={},compressionOptions={sstable_compression=org.apache.cassandra.io.compress.SnappyCompressor, chunk_length_kb=64},bloomFilterFpChance=<null>,caching=KEYS_ONLY,populateIoCacheOnFlush=false]
13/07/12 13:13:21 INFO db.ColumnFamilyStore: Enqueuing flush of Memtable-schema_columnfamilies@460567546(1142/1142 serialized/live bytes, 20 ops)
13/07/12 13:13:21 INFO db.Memtable: Writing Memtable-schema_columnfamilies@460567546(1142/1142 serialized/live bytes, 20 ops)
13/07/12 13:13:21 INFO db.Memtable: Completed flushing /tmp/cassandra/data/system/schema_columnfamilies/system-schema_columnfamilies-ib-3-Data.db (683 bytes) for commitlog position ReplayPosition(segmentId=1373627599882, position=55026)
13/07/12 13:13:21 WARN embedded.CassandraEmbeddedStoreManager: Set CompressionParameters org.apache.cassandra.io.compress.CompressionParameters@7cbb2799
13/07/12 13:13:21 INFO service.MigrationManager: Create new ColumnFamily: org.apache.cassandra.config.CFMetaData@49f3e8d7[cfId=953a627d-11d2-3d81-b6e4-c308fc44b1cf,ksName=titan,cfName=edgestore,cfType=Standard,comparator=org.apache.cassandra.db.marshal.BytesType,subcolumncomparator=<null>,comment=,readRepairChance=0.1,dclocalReadRepairChance=0.0,replicateOnWrite=true,gcGraceSeconds=864000,defaultValidator=org.apache.cassandra.db.marshal.BytesType,keyValidator=org.apache.cassandra.db.marshal.BytesType,minCompactionThreshold=4,maxCompactionThreshold=32,keyAliases=[],columnAliases=[],valueAlias=<null>,column_metadata={},compactionStrategyClass=class org.apache.cassandra.db.compaction.SizeTieredCompactionStrategy,compactionStrategyOptions={},compressionOptions={sstable_compression=org.apache.cassandra.io.compress.SnappyCompressor, chunk_length_kb=64},bloomFilterFpChance=<null>,caching=KEYS_ONLY,populateIoCacheOnFlush=false]
13/07/12 13:13:21 INFO db.ColumnFamilyStore: Enqueuing flush of Memtable-schema_columnfamilies@742105391(1142/1142 serialized/live bytes, 20 ops)
13/07/12 13:13:21 INFO db.Memtable: Writing Memtable-schema_columnfamilies@742105391(1142/1142 serialized/live bytes, 20 ops)
13/07/12 13:13:21 INFO db.Memtable: Completed flushing /tmp/cassandra/data/system/schema_columnfamilies/system-schema_columnfamilies-ib-4-Data.db (687 bytes) for commitlog position ReplayPosition(segmentId=1373627599882, position=56526)
13/07/12 13:13:21 INFO compaction.CompactionTask: Compacting [SSTableReader(path='/tmp/cassandra/data/system/schema_columnfamilies/system-schema_columnfamilies-ib-3-Data.db'), SSTableReader(path='/tmp/cassandra/data/system/schema_columnfamilies/system-schema_columnfamilies-ib-4-Data.db'), SSTableReader(path='/tmp/cassandra/data/system/schema_columnfamilies/system-schema_columnfamilies-ib-1-Data.db'), SSTableReader(path='/tmp/cassandra/data/system/schema_columnfamilies/system-schema_columnfamilies-ib-2-Data.db')]
13/07/12 13:13:22 INFO compaction.CompactionTask: Compacted 4 sstables to [/tmp/cassandra/data/system/schema_columnfamilies/system-schema_columnfamilies-ib-5,].  6,605 bytes to 5,378 (~81% of original) in 63ms = 0.081410MB/s.  5 total rows, 4 unique.  Row merge counts were {1:3, 2:1, 3:0, 4:0, }
13/07/12 13:13:22 WARN embedded.CassandraEmbeddedStoreManager: Set CompressionParameters org.apache.cassandra.io.compress.CompressionParameters@780a1337
13/07/12 13:13:22 INFO service.MigrationManager: Create new ColumnFamily: org.apache.cassandra.config.CFMetaData@60a9bbf3[cfId=ce79cef0-36fc-3abd-9042-a6c0cf72e19f,ksName=titan,cfName=edgestore_lock_,cfType=Standard,comparator=org.apache.cassandra.db.marshal.BytesType,subcolumncomparator=<null>,comment=,readRepairChance=0.1,dclocalReadRepairChance=0.0,replicateOnWrite=true,gcGraceSeconds=864000,defaultValidator=org.apache.cassandra.db.marshal.BytesType,keyValidator=org.apache.cassandra.db.marshal.BytesType,minCompactionThreshold=4,maxCompactionThreshold=32,keyAliases=[],columnAliases=[],valueAlias=<null>,column_metadata={},compactionStrategyClass=class org.apache.cassandra.db.compaction.SizeTieredCompactionStrategy,compactionStrategyOptions={},compressionOptions={sstable_compression=org.apache.cassandra.io.compress.SnappyCompressor, chunk_length_kb=64},bloomFilterFpChance=<null>,caching=KEYS_ONLY,populateIoCacheOnFlush=false]
13/07/12 13:13:22 INFO db.ColumnFamilyStore: Enqueuing flush of Memtable-schema_columnfamilies@1312292234(1262/1262 serialized/live bytes, 20 ops)
13/07/12 13:13:22 INFO db.Memtable: Writing Memtable-schema_columnfamilies@1312292234(1262/1262 serialized/live bytes, 20 ops)
13/07/12 13:13:22 INFO db.Memtable: Completed flushing /tmp/cassandra/data/system/schema_columnfamilies/system-schema_columnfamilies-ib-6-Data.db (694 bytes) for commitlog position ReplayPosition(segmentId=1373627599882, position=58146)
13/07/12 13:13:22 WARN embedded.CassandraEmbeddedStoreManager: Set CompressionParameters org.apache.cassandra.io.compress.CompressionParameters@cb06437
13/07/12 13:13:22 INFO service.MigrationManager: Create new ColumnFamily: org.apache.cassandra.config.CFMetaData@52eca6a8[cfId=853fa959-54aa-39ae-9db8-7ba34ccc1caf,ksName=titan,cfName=vertexindex,cfType=Standard,comparator=org.apache.cassandra.db.marshal.BytesType,subcolumncomparator=<null>,comment=,readRepairChance=0.1,dclocalReadRepairChance=0.0,replicateOnWrite=true,gcGraceSeconds=864000,defaultValidator=org.apache.cassandra.db.marshal.BytesType,keyValidator=org.apache.cassandra.db.marshal.BytesType,minCompactionThreshold=4,maxCompactionThreshold=32,keyAliases=[],columnAliases=[],valueAlias=<null>,column_metadata={},compactionStrategyClass=class org.apache.cassandra.db.compaction.SizeTieredCompactionStrategy,compactionStrategyOptions={},compressionOptions={sstable_compression=org.apache.cassandra.io.compress.SnappyCompressor, chunk_length_kb=64},bloomFilterFpChance=<null>,caching=ROWS_ONLY,populateIoCacheOnFlush=false]
13/07/12 13:13:22 INFO db.ColumnFamilyStore: Enqueuing flush of Memtable-schema_columnfamilies@783387168(1182/1182 serialized/live bytes, 20 ops)
13/07/12 13:13:22 INFO db.Memtable: Writing Memtable-schema_columnfamilies@783387168(1182/1182 serialized/live bytes, 20 ops)
13/07/12 13:13:22 INFO db.Memtable: Completed flushing /tmp/cassandra/data/system/schema_columnfamilies/system-schema_columnfamilies-ib-7-Data.db (688 bytes) for commitlog position ReplayPosition(segmentId=1373627599882, position=59686)
13/07/12 13:13:22 WARN embedded.CassandraEmbeddedStoreManager: Set CompressionParameters org.apache.cassandra.io.compress.CompressionParameters@fe801187
13/07/12 13:13:22 INFO service.MigrationManager: Create new ColumnFamily: org.apache.cassandra.config.CFMetaData@2c45f9ae[cfId=efe6eb52-373b-37a4-84a8-5b3d0e670d1a,ksName=titan,cfName=vertexindex_lock_,cfType=Standard,comparator=org.apache.cassandra.db.marshal.BytesType,subcolumncomparator=<null>,comment=,readRepairChance=0.1,dclocalReadRepairChance=0.0,replicateOnWrite=true,gcGraceSeconds=864000,defaultValidator=org.apache.cassandra.db.marshal.BytesType,keyValidator=org.apache.cassandra.db.marshal.BytesType,minCompactionThreshold=4,maxCompactionThreshold=32,keyAliases=[],columnAliases=[],valueAlias=<null>,column_metadata={},compactionStrategyClass=class org.apache.cassandra.db.compaction.SizeTieredCompactionStrategy,compactionStrategyOptions={},compressionOptions={sstable_compression=org.apache.cassandra.io.compress.SnappyCompressor, chunk_length_kb=64},bloomFilterFpChance=<null>,caching=ROWS_ONLY,populateIoCacheOnFlush=false]
13/07/12 13:13:22 INFO db.ColumnFamilyStore: Enqueuing flush of Memtable-schema_columnfamilies@638264631(1302/1302 serialized/live bytes, 20 ops)
13/07/12 13:13:22 INFO db.Memtable: Writing Memtable-schema_columnfamilies@638264631(1302/1302 serialized/live bytes, 20 ops)
13/07/12 13:13:22 INFO db.Memtable: Completed flushing /tmp/cassandra/data/system/schema_columnfamilies/system-schema_columnfamilies-ib-8-Data.db (695 bytes) for commitlog position ReplayPosition(segmentId=1373627599882, position=61346)
13/07/12 13:13:22 INFO compaction.CompactionTask: Compacting [SSTableReader(path='/tmp/cassandra/data/system/schema_columnfamilies/system-schema_columnfamilies-ib-8-Data.db'), SSTableReader(path='/tmp/cassandra/data/system/schema_columnfamilies/system-schema_columnfamilies-ib-5-Data.db'), SSTableReader(path='/tmp/cassandra/data/system/schema_columnfamilies/system-schema_columnfamilies-ib-6-Data.db'), SSTableReader(path='/tmp/cassandra/data/system/schema_columnfamilies/system-schema_columnfamilies-ib-7-Data.db')]
13/07/12 13:13:22 INFO compaction.CompactionTask: Compacted 4 sstables to [/tmp/cassandra/data/system/schema_columnfamilies/system-schema_columnfamilies-ib-9,].  7,455 bytes to 6,184 (~82% of original) in 92ms = 0.064103MB/s.  7 total rows, 4 unique.  Row merge counts were {1:3, 2:0, 3:0, 4:1, }
13/07/12 13:13:22 WARN embedded.CassandraEmbeddedStoreManager: Set CompressionParameters org.apache.cassandra.io.compress.CompressionParameters@5593bf3b
13/07/12 13:13:22 INFO service.MigrationManager: Create new ColumnFamily: org.apache.cassandra.config.CFMetaData@11437a26[cfId=e86937a0-a0c5-366e-bc6b-476c09790927,ksName=titan,cfName=edgeindex,cfType=Standard,comparator=org.apache.cassandra.db.marshal.BytesType,subcolumncomparator=<null>,comment=,readRepairChance=0.1,dclocalReadRepairChance=0.0,replicateOnWrite=true,gcGraceSeconds=864000,defaultValidator=org.apache.cassandra.db.marshal.BytesType,keyValidator=org.apache.cassandra.db.marshal.BytesType,minCompactionThreshold=4,maxCompactionThreshold=32,keyAliases=[],columnAliases=[],valueAlias=<null>,column_metadata={},compactionStrategyClass=class org.apache.cassandra.db.compaction.SizeTieredCompactionStrategy,compactionStrategyOptions={},compressionOptions={sstable_compression=org.apache.cassandra.io.compress.SnappyCompressor, chunk_length_kb=64},bloomFilterFpChance=<null>,caching=KEYS_ONLY,populateIoCacheOnFlush=false]
13/07/12 13:13:22 INFO db.ColumnFamilyStore: Enqueuing flush of Memtable-schema_columnfamilies@1695047076(1142/1142 serialized/live bytes, 20 ops)
13/07/12 13:13:22 INFO db.Memtable: Writing Memtable-schema_columnfamilies@1695047076(1142/1142 serialized/live bytes, 20 ops)
13/07/12 13:13:22 INFO db.Memtable: Completed flushing /tmp/cassandra/data/system/schema_columnfamilies/system-schema_columnfamilies-ib-10-Data.db (687 bytes) for commitlog position ReplayPosition(segmentId=1373627599882, position=62846)
13/07/12 13:13:22 WARN embedded.CassandraEmbeddedStoreManager: Set CompressionParameters org.apache.cassandra.io.compress.CompressionParameters@d9335d82
13/07/12 13:13:22 INFO service.MigrationManager: Create new ColumnFamily: org.apache.cassandra.config.CFMetaData@10fc040[cfId=df718c47-b235-3c54-a609-07187692ebe0,ksName=titan,cfName=system_properties,cfType=Standard,comparator=org.apache.cassandra.db.marshal.UTF8Type,subcolumncomparator=<null>,comment=,readRepairChance=0.1,dclocalReadRepairChance=0.0,replicateOnWrite=true,gcGraceSeconds=864000,defaultValidator=org.apache.cassandra.db.marshal.BytesType,keyValidator=org.apache.cassandra.db.marshal.BytesType,minCompactionThreshold=4,maxCompactionThreshold=32,keyAliases=[],columnAliases=[],valueAlias=<null>,column_metadata={},compactionStrategyClass=class org.apache.cassandra.db.compaction.SizeTieredCompactionStrategy,compactionStrategyOptions={},compressionOptions={sstable_compression=org.apache.cassandra.io.compress.SnappyCompressor, chunk_length_kb=64},bloomFilterFpChance=<null>,caching=KEYS_ONLY,populateIoCacheOnFlush=false]
13/07/12 13:13:22 INFO db.ColumnFamilyStore: Enqueuing flush of Memtable-schema_columnfamilies@823568971(1301/1301 serialized/live bytes, 20 ops)
13/07/12 13:13:22 INFO db.Memtable: Writing Memtable-schema_columnfamilies@823568971(1301/1301 serialized/live bytes, 20 ops)
13/07/12 13:13:22 INFO db.Memtable: Completed flushing /tmp/cassandra/data/system/schema_columnfamilies/system-schema_columnfamilies-ib-11-Data.db (717 bytes) for commitlog position ReplayPosition(segmentId=1373627599882, position=64505)
13/07/12 13:13:23 INFO rexster.RexsterTitanServer: []
13/07/12 13:13:23 INFO rexster.RexsterApplicationGraph: Graph [graph] - configured with allowable namespace [*:*]
13/07/12 13:13:23 INFO rexster.TitanRexsterApplication: Graph [titangraph[embeddedcassandra:null]] loaded
13/07/12 13:13:23 INFO server.RexProRexsterServer: Rexster configured with no security.
13/07/12 13:13:23 INFO protocol.EngineController: ScriptEngineManager has factory for: Groovy
13/07/12 13:13:23 INFO protocol.EngineController: ScriptEngineManager has factory for: ECMAScript
13/07/12 13:13:23 INFO protocol.EngineController: ScriptEngineManager has factory for: gremlin-groovy
13/07/12 13:13:23 INFO protocol.EngineController: Registered ScriptEngine for: gremlin-groovy
13/07/12 13:13:24 INFO server.RexProRexsterServer: Using org.glassfish.grizzly.strategies.LeaderFollowerNIOStrategy IOStrategy for RexPro.
13/07/12 13:13:24 INFO server.RexProRexsterServer: RexPro serving on port: [8184]
Jul 12, 2013 1:13:24 PM org.glassfish.grizzly.servlet.WebappContext deploy
INFO: Starting application [jersey] ...
Jul 12, 2013 1:13:24 PM com.sun.jersey.server.impl.application.WebApplicationImpl _initiate
INFO: Initiating Jersey application, version 'Jersey: 1.8 06/24/2011 12:17 PM'
Jul 12, 2013 1:13:25 PM org.glassfish.grizzly.servlet.WebappContext initServlets
INFO: [jersey] Servlet [com.sun.jersey.spi.container.servlet.ServletContainer] registered for url pattern(s) [[/*]].
Jul 12, 2013 1:13:25 PM org.glassfish.grizzly.servlet.WebappContext deploy
INFO: Application [jersey] is ready to service requests.  Root: [].
13/07/12 13:13:25 INFO server.HttpRexsterServer: Using org.glassfish.grizzly.strategies.LeaderFollowerNIOStrategy IOStrategy for HTTP/REST.
Jul 12, 2013 1:13:25 PM org.glassfish.grizzly.http.server.NetworkListener start
INFO: Started listener bound to [0.0.0.0:8182]
Jul 12, 2013 1:13:25 PM org.glassfish.grizzly.http.server.HttpServer start
INFO: [HttpServer] Started.
13/07/12 13:13:25 INFO server.HttpRexsterServer: Rexster Server running on: [http://localhost:8182]
13/07/12 13:13:25 INFO server.ShutdownManager: Bound shutdown socket to /127.0.0.1:8183. Starting listener thread for shutdown requests.
13/07/12 13:13:31 INFO auth.Auth: Created default superuser 'cassandra'