cassandra-user mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Saurabh Sethi <Saurabh_Se...@symantec.com>
Subject Re: Unable to create a keyspace
Date Sat, 31 Jan 2015 01:42:03 GMT
I repeat the test after verifying that the keyspace has been dropped.

Also, I do not want any replication as of now that’s why replication factor is 1. But I
don’t think that should be the reason for the command not propagating to other nodes.

One more thing that I observed right now is that if I create the keyspace from node 1 and
node 2, it doesn’t get created but if I try to create it from node 3, it does get created.
Node1 and Node 2 are Vms hosted on the same physical hardware, not sure if that has anything
to do.

Thanks,
Saurabh
From: Asit KAUSHIK <asitkaushiknosql@gmail.com<mailto:asitkaushiknosql@gmail.com>>
Reply-To: "user@cassandra.apache.org<mailto:user@cassandra.apache.org>" <user@cassandra.apache.org<mailto:user@cassandra.apache.org>>
Date: Friday, January 30, 2015 at 5:33 PM
To: "user@cassandra.apache.org<mailto:user@cassandra.apache.org>" <user@cassandra.apache.org<mailto:user@cassandra.apache.org>>
Subject: Re: Unable to create a keyspace


Saurabh a vague suggestion when you are dropping can you wait for sometime to let the change
propagate to other node.Also I see a replication factor 1 but you have 3 nodes....

On Jan 31, 2015 6:28 AM, "Saurabh Sethi" <Saurabh_Sethi@symantec.com<mailto:Saurabh_Sethi@symantec.com>>
wrote:
Thanks Adam. I upgraded to 2.1.2 but still seeing this issue. Let me go in a bit more detail
as to what I am seeing – When I create a keyspace for the first time in a 3 node cluster,
it works fine but if I drop the keyspace and try to recreate it, I see that the node received
the request to create it but it didn’t delegate the request to other nodes because of which
the keyspace didn’t get created on other two nodes.

But the request for creating a table does get propagated to other nodes and since they can’t
find that keyspace they throw an exception.

I have 2 nodes as seeds, so the seeds property in cassandra.yaml for all 3 nodes looks like
– seeds: "<node1ip>,<node3ip>"

Following is that I see in system.log file when I enable DEBUG mode:

DEBUG [SharedPool-Worker-3] 2015-01-30 16:39:37,363 Message.java:437 - Received: STARTUP {CQL_VERSION=3.0.0},
v=3
DEBUG [SharedPool-Worker-3] 2015-01-30 16:39:37,364 Message.java:452 - Responding: READY,
v=3
DEBUG [SharedPool-Worker-2] 2015-01-30 16:39:37,365 Message.java:437 - Received: QUERY select
cluster_name from system.local, v=3
DEBUG [SharedPool-Worker-2] 2015-01-30 16:39:37,366 StorageProxy.java:1534 - Estimated result
rows per range: 20.057144; requested rows: 2147483647, ranges.size(): 1; concurrent range
requests: 1
DEBUG [SharedPool-Worker-2] 2015-01-30 16:39:37,369 Tracing.java:157 - request complete
DEBUG [SharedPool-Worker-2] 2015-01-30 16:39:37,369 Message.java:452 - Responding: ROWS [cluster_name(system,
local), org.apache.cassandra.db.marshal.UTF8Type]
 | CASSANDRAEDPDEVCLUSTER
---, v=3
DEBUG [SharedPool-Worker-1] 2015-01-30 16:39:37,386 Message.java:437 - Received: QUERY CREATE
KEYSPACE IF NOT EXISTS TestMaxColumnsKeySpace WITH REPLICATION = { 'class' : 'SimpleStrategy',
'replication_factor' : 1 };, v=3
INFO  [SharedPool-Worker-1] 2015-01-30 16:39:37,387 MigrationManager.java:229 - Create new
Keyspace: KSMetaData{name=testmaxcolumnskeyspace, strategyClass=SimpleStrategy, strategyOptions={replication_factor=1},
cfMetaData={}, durableWrites=true, userTypes=org.apache.cassandra.config.UTMetaData@5485ec68}
DEBUG [MigrationStage:1] 2015-01-30 16:39:37,388 FileCacheService.java:150 - Estimated memory
usage is 1182141 compared to actual usage 262698
DEBUG [MigrationStage:1] 2015-01-30 16:39:37,389 FileCacheService.java:102 - Evicting cold
readers for /usr/share/apache-cassandra-2.1.2/bin/../data/data/system/schema_columnfamilies-45f5b36024bc3f83a3631034ea4fa697/system-schema_columnfamilies-ka-3-Data.db
DEBUG [MigrationStage:1] 2015-01-30 16:39:37,390 FileCacheService.java:150 - Estimated memory
usage is 1182141 compared to actual usage 394047
DEBUG [MigrationStage:1] 2015-01-30 16:39:37,390 FileCacheService.java:102 - Evicting cold
readers for /usr/share/apache-cassandra-2.1.2/bin/../data/data/system/schema_usertypes-3aa752254f82350b8d5c430fa221fa0a/system-schema_usertypes-ka-1-Data.db
DEBUG [MigrationStage:1] 2015-01-30 16:39:37,390 FileCacheService.java:150 - Estimated memory
usage is 1182141 compared to actual usage 525396
INFO  [MigrationStage:1] 2015-01-30 16:39:37,392 ColumnFamilyStore.java:840 - Enqueuing flush
of schema_keyspaces: 496 (0%) on-heap, 0 (0%) off-heap
DEBUG [MigrationStage:1] 2015-01-30 16:39:37,392 ColumnFamilyStore.java:166 - scheduling flush
in 3600000 ms
INFO  [MemtableFlushWriter:10] 2015-01-30 16:39:37,394 Memtable.java:325 - Writing Memtable-schema_keyspaces@922450609(138
serialized bytes, 3 ops, 0%/0% of on/off-heap limit)
DEBUG [MemtableFlushWriter:10] 2015-01-30 16:39:37,410 FileUtils.java:161 - Renaming bin/../data/data/system/schema_keyspaces-b0f2235744583cdb9631c43e59ce3676/system-schema_keyspaces-tmp-ka-10-Statistics.db
to bin/../data/data/system/schema_keyspaces-b0f2235744583cdb9631c43e59ce3676/system-schema_keyspaces-ka-10-Statistics.db
DEBUG [MemtableFlushWriter:10] 2015-01-30 16:39:37,410 FileUtils.java:161 - Renaming bin/../data/data/system/schema_keyspaces-b0f2235744583cdb9631c43e59ce3676/system-schema_keyspaces-tmp-ka-10-Filter.db
to bin/../data/data/system/schema_keyspaces-b0f2235744583cdb9631c43e59ce3676/system-schema_keyspaces-ka-10-Filter.db
DEBUG [MemtableFlushWriter:10] 2015-01-30 16:39:37,410 FileUtils.java:161 - Renaming bin/../data/data/system/schema_keyspaces-b0f2235744583cdb9631c43e59ce3676/system-schema_keyspaces-tmp-ka-10-TOC.txt
to bin/../data/data/system/schema_keyspaces-b0f2235744583cdb9631c43e59ce3676/system-schema_keyspaces-ka-10-TOC.txt
DEBUG [MemtableFlushWriter:10] 2015-01-30 16:39:37,411 FileUtils.java:161 - Renaming bin/../data/data/system/schema_keyspaces-b0f2235744583cdb9631c43e59ce3676/system-schema_keyspaces-tmp-ka-10-Digest.sha1
to bin/../data/data/system/schema_keyspaces-b0f2235744583cdb9631c43e59ce3676/system-schema_keyspaces-ka-10-Digest.sha1
DEBUG [MemtableFlushWriter:10] 2015-01-30 16:39:37,411 FileUtils.java:161 - Renaming bin/../data/data/system/schema_keyspaces-b0f2235744583cdb9631c43e59ce3676/system-schema_keyspaces-tmp-ka-10-CompressionInfo.db
to bin/../data/data/system/schema_keyspaces-b0f2235744583cdb9631c43e59ce3676/system-schema_keyspaces-ka-10-CompressionInfo.db
DEBUG [MemtableFlushWriter:10] 2015-01-30 16:39:37,411 FileUtils.java:161 - Renaming bin/../data/data/system/schema_keyspaces-b0f2235744583cdb9631c43e59ce3676/system-schema_keyspaces-tmp-ka-10-Index.db
to bin/../data/data/system/schema_keyspaces-b0f2235744583cdb9631c43e59ce3676/system-schema_keyspaces-ka-10-Index.db
DEBUG [MemtableFlushWriter:10] 2015-01-30 16:39:37,412 FileUtils.java:161 - Renaming bin/../data/data/system/schema_keyspaces-b0f2235744583cdb9631c43e59ce3676/system-schema_keyspaces-tmp-ka-10-Data.db
to bin/../data/data/system/schema_keyspaces-b0f2235744583cdb9631c43e59ce3676/system-schema_keyspaces-ka-10-Data.db
INFO  [MemtableFlushWriter:10] 2015-01-30 16:39:37,413 Memtable.java:364 - Completed flushing
/usr/share/apache-cassandra-2.1.2/bin/../data/data/system/schema_keyspaces-b0f2235744583cdb9631c43e59ce3676/system-schema_keyspaces-ka-10-Data.db
(175 bytes) for commitlog position ReplayPosition(segmentId=1422663061374, position=3040)
DEBUG [MemtableFlushWriter:10] 2015-01-30 16:39:37,413 DataTracker.java:440 - adding bin/../data/data/system/schema_keyspaces-b0f2235744583cdb9631c43e59ce3676/system-schema_keyspaces-ka-10
to list of files tracked for system.schema_keyspaces
DEBUG [MemtableFlushWriter:10] 2015-01-30 16:39:37,413 CompactionManager.java:179 - Scheduling
a background task check for system.schema_keyspaces with SizeTieredCompactionStrategy
DEBUG [MemtablePostFlush:24] 2015-01-30 16:39:37,414 CommitLog.java:265 - discard completed
log segments for ReplayPosition(segmentId=1422663061374, position=3040), column family b0f22357-4458-3cdb-9631-c43e59ce3676
DEBUG [CompactionExecutor:13] 2015-01-30 16:39:37,414 CompactionManager.java:218 - Checking
system.schema_keyspaces
DEBUG [MemtablePostFlush:24] 2015-01-30 16:39:37,414 CommitLog.java:283 - Not safe to delete
active commit log segment CommitLogSegment(bin/../data/commitlog/CommitLog-4-1422663061374.log);
dirty is peers (37f71aca-7dc2-383b-a706-72528af04d4f), compaction_history (b4dbb7b4-dc49-3fb5-b3bf-ce6e434832ca),
local (7ad54392-bcdd-35a6-8417-4e047860b377),
DEBUG [MemtablePostFlush:24] 2015-01-30 16:39:37,415 ColumnFamilyStore.java:879 - forceFlush
requested but everything is clean in schema_columnfamilies
DEBUG [CompactionExecutor:13] 2015-01-30 16:39:37,415 SizeTieredCompactionStrategy.java:86
- Compaction buckets are [[SSTableReader(path='/usr/share/apache-cassandra-2.1.2/bin/../data/data/system/schema_keyspaces-b0f2235744583cdb9631c43e59ce3676/system-schema_keyspaces-ka-10-Data.db'),
SSTableReader(path='/usr/share/apache-cassandra-2.1.2/bin/../data/data/system/schema_keyspaces-b0f2235744583cdb9631c43e59ce3676/system-schema_keyspaces-ka-9-Data.db')]]
DEBUG [MemtablePostFlush:24] 2015-01-30 16:39:37,415 ColumnFamilyStore.java:879 - forceFlush
requested but everything is clean in schema_columns
DEBUG [CompactionExecutor:13] 2015-01-30 16:39:37,415 SizeTieredCompactionStrategy.java:86
- Compaction buckets are []
DEBUG [MemtablePostFlush:24] 2015-01-30 16:39:37,415 ColumnFamilyStore.java:879 - forceFlush
requested but everything is clean in schema_triggers
DEBUG [CompactionExecutor:13] 2015-01-30 16:39:37,415 CompactionManager.java:229 - No tasks
available
DEBUG [MemtablePostFlush:24] 2015-01-30 16:39:37,416 ColumnFamilyStore.java:879 - forceFlush
requested but everything is clean in schema_usertypes
DEBUG [MigrationStage:1] 2015-01-30 16:39:37,416 FileCacheService.java:150 - Estimated memory
usage is 1182141 compared to actual usage 525396
DEBUG [MigrationStage:1] 2015-01-30 16:39:37,417 FileCacheService.java:150 - Estimated memory
usage is 1182141 compared to actual usage 525396
DEBUG [MigrationStage:1] 2015-01-30 16:39:37,417 FileCacheService.java:150 - Estimated memory
usage is 1182141 compared to actual usage 525396
DEBUG [MigrationStage:1] 2015-01-30 16:39:37,425 MigrationManager.java:418 - Gossiping my
schema version b5291c1d-6635-3627-928f-f5a0f0c27ec1
DEBUG [SharedPool-Worker-1] 2015-01-30 16:39:37,425 Tracing.java:157 - request complete
DEBUG [SharedPool-Worker-1] 2015-01-30 16:39:37,425 Message.java:452 - Responding: RESULT
schema change CREATED KEYSPACE testmaxcolumnskeyspace, v=3
DEBUG [SharedPool-Worker-1] 2015-01-30 16:39:37,502 Message.java:437 - Received: QUERY SELECT
peer, rpc_address, schema_version FROM system.peers, v=3
DEBUG [SharedPool-Worker-2] 2015-01-30 16:39:37,502 Message.java:437 - Received: QUERY SELECT
schema_version FROM system.local WHERE key='local', v=3
DEBUG [SharedPool-Worker-1] 2015-01-30 16:39:37,503 StorageProxy.java:1534 - Estimated result
rows per range: 23.2875; requested rows: 2147483647, ranges.size(): 1; concurrent range requests:
1
DEBUG [SharedPool-Worker-2] 2015-01-30 16:39:37,504 FileCacheService.java:150 - Estimated
memory usage is 1050792 compared to actual usage 394047
DEBUG [SharedPool-Worker-2] 2015-01-30 16:39:37,505 FileCacheService.java:150 - Estimated
memory usage is 1182141 compared to actual usage 525396
DEBUG [SharedPool-Worker-2] 2015-01-30 16:39:37,505 StorageProxy.java:1271 - Read: 2 ms.
DEBUG [SharedPool-Worker-1] 2015-01-30 16:39:37,505 Tracing.java:157 - request complete
DEBUG [SharedPool-Worker-2] 2015-01-30 16:39:37,506 Tracing.java:157 - request complete
DEBUG [SharedPool-Worker-1] 2015-01-30 16:39:37,506 Message.java:452 - Responding: ROWS [peer(system,
peers), org.apache.cassandra.db.marshal.InetAddressType][rpc_address(system, peers), org.apache.cassandra.db.marshal.InetAddressType][schema_version(system,
peers), org.apache.cassandra.db.marshal.UUIDType]
 | 10.65.119.193 | 10.65.119.193 | b5291c1d-6635-3627-928f-f5a0f0c27ec1
 | 10.65.58.24 | 10.65.58.24 | b5291c1d-6635-3627-928f-f5a0f0c27ec1
---, v=3
DEBUG [SharedPool-Worker-2] 2015-01-30 16:39:37,506 Message.java:452 - Responding: ROWS [schema_version(system,
local), org.apache.cassandra.db.marshal.UUIDType]
 | b5291c1d-6635-3627-928f-f5a0f0c27ec1
---, v=3
DEBUG [SharedPool-Worker-3] 2015-01-30 16:39:37,509 Message.java:437 - Received: QUERY SELECT
* FROM system.schema_keyspaces WHERE keyspace_name = 'testmaxcolumnskeyspace', v=3
DEBUG [SharedPool-Worker-1] 2015-01-30 16:39:37,509 Message.java:437 - Received: QUERY SELECT
* FROM system.schema_usertypes WHERE keyspace_name = 'testmaxcolumnskeyspace', v=3
DEBUG [SharedPool-Worker-4] 2015-01-30 16:39:37,510 FileCacheService.java:150 - Estimated
memory usage is 1182141 compared to actual usage 525396
DEBUG [SharedPool-Worker-5] 2015-01-30 16:39:37,510 Message.java:437 - Received: QUERY SELECT
* FROM system.schema_columnfamilies WHERE keyspace_name = 'testmaxcolumnskeyspace', v=3
DEBUG [SharedPool-Worker-2] 2015-01-30 16:39:37,510 FileCacheService.java:150 - Estimated
memory usage is 1050792 compared to actual usage 394047
DEBUG [SharedPool-Worker-3] 2015-01-30 16:39:37,510 StorageProxy.java:1271 - Read: 0 ms.
DEBUG [SharedPool-Worker-6] 2015-01-30 16:39:37,510 Message.java:437 - Received: QUERY SELECT
* FROM system.schema_columns WHERE keyspace_name = 'testmaxcolumnskeyspace', v=3
DEBUG [SharedPool-Worker-1] 2015-01-30 16:39:37,510 StorageProxy.java:1271 - Read: 0 ms.
DEBUG [SharedPool-Worker-3] 2015-01-30 16:39:37,511 Tracing.java:157 - request complete
DEBUG [SharedPool-Worker-4] 2015-01-30 16:39:37,511 FileCacheService.java:150 - Estimated
memory usage is 1182141 compared to actual usage 525396
DEBUG [SharedPool-Worker-1] 2015-01-30 16:39:37,511 Tracing.java:157 - request complete
DEBUG [SharedPool-Worker-3] 2015-01-30 16:39:37,511 Message.java:452 - Responding: ROWS [keyspace_name(system,
schema_keyspaces), org.apache.cassandra.db.marshal.UTF8Type][durable_writes(system, schema_keyspaces),
org.apache.cassandra.db.marshal.BooleanType][strategy_class(system, schema_keyspaces), org.apache.cassandra.db.marshal.UTF8Type][strategy_options(system,
schema_keyspaces), org.apache.cassandra.db.marshal.UTF8Type]
---, v=3
DEBUG [SharedPool-Worker-2] 2015-01-30 16:39:37,511 FileCacheService.java:102 - Evicting cold
readers for /usr/share/apache-cassandra-2.1.2/bin/../data/data/system/schema_columns-296e9c049bec3085827dc17d3df2122a/system-schema_columns-ka-3-Data.db
DEBUG [SharedPool-Worker-5] 2015-01-30 16:39:37,511 StorageProxy.java:1271 - Read: 0 ms.
DEBUG [SharedPool-Worker-1] 2015-01-30 16:39:37,511 Message.java:452 - Responding: ROWS [keyspace_name(system,
schema_usertypes), org.apache.cassandra.db.marshal.UTF8Type][type_name(system, schema_usertypes),
org.apache.cassandra.db.marshal.UTF8Type][field_names(system, schema_usertypes), org.apache.cassandra.db.marshal.ListType(org.apache.cassandra.db.marshal.UTF8Type)][field_types(system,
schema_usertypes), org.apache.cassandra.db.marshal.ListType(org.apache.cassandra.db.marshal.UTF8Type)]
---, v=3
DEBUG [SharedPool-Worker-5] 2015-01-30 16:39:37,513 Tracing.java:157 - request complete
DEBUG [SharedPool-Worker-2] 2015-01-30 16:39:37,513 FileCacheService.java:150 - Estimated
memory usage is 1182141 compared to actual usage 656745
DEBUG [SharedPool-Worker-5] 2015-01-30 16:39:37,513 Message.java:452 - Responding: ROWS [keyspace_name(system,
schema_columnfamilies), org.apache.cassandra.db.marshal.UTF8Type][columnfamily_name(system,
schema_columnfamilies), org.apache.cassandra.db.marshal.UTF8Type][bloom_filter_fp_chance(system,
schema_columnfamilies), org.apache.cassandra.db.marshal.DoubleType][caching(system, schema_columnfamilies),
org.apache.cassandra.db.marshal.UTF8Type][cf_id(system, schema_columnfamilies), org.apache.cassandra.db.marshal.UUIDType][column_aliases(system,
schema_columnfamilies), org.apache.cassandra.db.marshal.UTF8Type][comment(system, schema_columnfamilies),
org.apache.cassandra.db.marshal.UTF8Type][compaction_strategy_class(system, schema_columnfamilies),
org.apache.cassandra.db.marshal.UTF8Type][compaction_strategy_options(system, schema_columnfamilies),
org.apache.cassandra.db.marshal.UTF8Type][comparator(system, schema_columnfamilies), org.apache.cassandra.db.marshal.UTF8Type][compression_parameters(system,
schema_columnfamilies), org.apache.cassandra.db.marshal.UTF8Type][default_time_to_live(system,
schema_columnfamilies), org.apache.cassandra.db.marshal.Int32Type][default_validator(system,
schema_columnfamilies), org.apache.cassandra.db.marshal.UTF8Type][dropped_columns(system,
schema_columnfamilies), org.apache.cassandra.db.marshal.MapType(org.apache.cassandra.db.marshal.UTF8Type,org.apache.cassandra.db.marshal.LongType)][gc_grace_seconds(system,
schema_columnfamilies), org.apache.cassandra.db.marshal.Int32Type][index_interval(system,
schema_columnfamilies), org.apache.cassandra.db.marshal.Int32Type][is_dense(system, schema_columnfamilies),
org.apache.cassandra.db.marshal.BooleanType][key_aliases(system, schema_columnfamilies), org.apache.cassandra.db.marshal.UTF8Type][key_validator(system,
schema_columnfamilies), org.apache.cassandra.db.marshal.UTF8Type][local_read_repair_chance(system,
schema_columnfamilies), org.apache.cassandra.db.marshal.DoubleType][max_compaction_threshold(system,
schema_columnfamilies), org.apache.cassandra.db.marshal.Int32Type][max_index_interval(system,
schema_columnfamilies), org.apache.cassandra.db.marshal.Int32Type][memtable_flush_period_in_ms(system,
schema_columnfamilies), org.apache.cassandra.db.marshal.Int32Type][min_compaction_threshold(system,
schema_columnfamilies), org.apache.cassandra.db.marshal.Int32Type][min_index_interval(system,
schema_columnfamilies), org.apache.cassandra.db.marshal.Int32Type][read_repair_chance(system,
schema_columnfamilies), org.apache.cassandra.db.marshal.DoubleType][speculative_retry(system,
schema_columnfamilies), org.apache.cassandra.db.marshal.UTF8Type][subcomparator(system, schema_columnfamilies),
org.apache.cassandra.db.marshal.UTF8Type][type(system, schema_columnfamilies), org.apache.cassandra.db.marshal.UTF8Type][value_alias(system,
schema_columnfamilies), org.apache.cassandra.db.marshal.UTF8Type]
---, v=3
DEBUG [SharedPool-Worker-6] 2015-01-30 16:39:37,514 StorageProxy.java:1271 - Read: 2 ms.
DEBUG [SharedPool-Worker-6] 2015-01-30 16:39:37,514 Tracing.java:157 - request complete
DEBUG [SharedPool-Worker-6] 2015-01-30 16:39:37,514 Message.java:452 - Responding: ROWS [keyspace_name(system,
schema_columns), org.apache.cassandra.db.marshal.UTF8Type][columnfamily_name(system, schema_columns),
org.apache.cassandra.db.marshal.UTF8Type][column_name(system, schema_columns), org.apache.cassandra.db.marshal.UTF8Type][component_index(system,
schema_columns), org.apache.cassandra.db.marshal.Int32Type][index_name(system, schema_columns),
org.apache.cassandra.db.marshal.UTF8Type][index_options(system, schema_columns), org.apache.cassandra.db.marshal.UTF8Type][index_type(system,
schema_columns), org.apache.cassandra.db.marshal.UTF8Type][type(system, schema_columns), org.apache.cassandra.db.marshal.UTF8Type][validator(system,
schema_columns), org.apache.cassandra.db.marshal.UTF8Type]
---, v=3
DEBUG [SharedPool-Worker-6] 2015-01-30 16:39:37,516 Message.java:437 - Received: QUERY SELECT
* FROM system.local WHERE key='local', v=3
DEBUG [SharedPool-Worker-2] 2015-01-30 16:39:37,516 Message.java:437 - Received: QUERY SELECT
* FROM system.peers, v=3
DEBUG [SharedPool-Worker-2] 2015-01-30 16:39:37,516 StorageProxy.java:1534 - Estimated result
rows per range: 23.2875; requested rows: 2147483647, ranges.size(): 1; concurrent range requests:
1
DEBUG [SharedPool-Worker-5] 2015-01-30 16:39:37,517 FileCacheService.java:150 - Estimated
memory usage is 1050792 compared to actual usage 525396
DEBUG [SharedPool-Worker-5] 2015-01-30 16:39:37,517 FileCacheService.java:150 - Estimated
memory usage is 1182141 compared to actual usage 656745
DEBUG [SharedPool-Worker-6] 2015-01-30 16:39:37,518 StorageProxy.java:1271 - Read: 1 ms.
DEBUG [SharedPool-Worker-6] 2015-01-30 16:39:37,518 Tracing.java:157 - request complete
DEBUG [SharedPool-Worker-6] 2015-01-30 16:39:37,518 Message.java:452 - Responding: ROWS [key(system,
local), org.apache.cassandra.db.marshal.UTF8Type][bootstrapped(system, local), org.apache.cassandra.db.marshal.UTF8Type][cluster_name(system,
local), org.apache.cassandra.db.marshal.UTF8Type][cql_version(system, local), org.apache.cassandra.db.marshal.UTF8Type][data_center(system,
local), org.apache.cassandra.db.marshal.UTF8Type][gossip_generation(system, local), org.apache.cassandra.db.marshal.Int32Type][host_id(system,
local), org.apache.cassandra.db.marshal.UUIDType][native_protocol_version(system, local),
org.apache.cassandra.db.marshal.UTF8Type][partitioner(system, local), org.apache.cassandra.db.marshal.UTF8Type][rack(system,
local), org.apache.cassandra.db.marshal.UTF8Type][release_version(system, local), org.apache.cassandra.db.marshal.UTF8Type][schema_version(system,
local), org.apache.cassandra.db.marshal.UUIDType][thrift_version(system, local), org.apache.cassandra.db.marshal.UTF8Type][tokens(system,
local), org.apache.cassandra.db.marshal.SetType(org.apache.cassandra.db.marshal.UTF8Type)][truncated_at(system,
local), org.apache.cassandra.db.marshal.MapType(org.apache.cassandra.db.marshal.UUIDType,org.apache.cassandra.db.marshal.BytesType)]
 | local | COMPLETED | CASSANDRAEDPDEVCLUSTER | 3.2.0 | DC1 | 1422663061 | 19dbb3ec-ada4-4af0-9d39-95eb89a0a8e7
| 3 | org.apache.cassandra.dht.Murmur3Partitioner | RAC1 | 2.1.2 | b5291c1d-6635-3627-928f-f5a0f0c27ec1
| 19.39.0 | …
---, v=3
DEBUG [SharedPool-Worker-2] 2015-01-30 16:39:37,519 Tracing.java:157 - request complete
DEBUG [SharedPool-Worker-2] 2015-01-30 16:39:37,519 Message.java:452 - Responding: ROWS [peer(system,
peers), org.apache.cassandra.db.marshal.InetAddressType][data_center(system, peers), org.apache.cassandra.db.marshal.UTF8Type][host_id(system,
peers), org.apache.cassandra.db.marshal.UUIDType][preferred_ip(system, peers), org.apache.cassandra.db.marshal.InetAddressType][rack(system,
peers), org.apache.cassandra.db.marshal.UTF8Type][release_version(system, peers), org.apache.cassandra.db.marshal.UTF8Type][rpc_address(system,
peers), org.apache.cassandra.db.marshal.InetAddressType][schema_version(system, peers), org.apache.cassandra.db.marshal.UUIDType][tokens(system,
peers), org.apache.cassandra.db.marshal.SetType(org.apache.cassandra.db.marshal.UTF8Type)]
 | 10.65.119.193 | DC1 | 12bdc695-1647-462c-8167-e386603643c9 | null | RAC1 | 2.1.2 | 10.65.119.193
| b5291c1d-6635-3627-928f-f5a0f0c27ec1 | …
 | 10.65.58.24 | DC1 | a1cf7f2c-fa1b-4d7d-95c9-381bcc2b36f9 | null | RAC1 | 2.1.2 | 10.65.58.24
| b5291c1d-6635-3627-928f-f5a0f0c27ec1 | …
---, v=3

Thanks,
Saurabh
From: Adam Holmberg <adam.holmberg@datastax.com<mailto:adam.holmberg@datastax.com>>
Reply-To: "user@cassandra.apache.org<mailto:user@cassandra.apache.org>" <user@cassandra.apache.org<mailto:user@cassandra.apache.org>>
Date: Friday, January 30, 2015 at 9:25 AM
To: "user@cassandra.apache.org<mailto:user@cassandra.apache.org>" <user@cassandra.apache.org<mailto:user@cassandra.apache.org>>
Subject: Re: Unable to create a keyspace

I would first ask if you could upgrade to the latest version of Cassandra 2.1.x (presently
2.1.2).

If the issue still occurs consistently, it would be interesting to turn up logging on the
client side and see if something is causing the client to disconnect during the metadata refresh
following the schema change. If this yields further information, please raise the issue on
the driver's user mailing list.

Adam Holmberg

On Wed, Jan 28, 2015 at 8:19 PM, Saurabh Sethi <Saurabh_Sethi@symantec.com<mailto:Saurabh_Sethi@symantec.com>>
wrote:
I have a 3 node Cassandra 2.1.0 cluster and I am using datastax 2.1.4 driver to create a keyspace
followed by creating a column family within that keyspace from my unit test.

But I do not see the keyspace getting created and the code for creating column family fails
because it cannot find the keyspace. I see the following in the system.log file:

INFO  [SharedPool-Worker-1] 2015-01-28 17:59:08,472 MigrationManager.java:229 - Create new
Keyspace: KSMetaData{name=testmaxcolumnskeyspace, strategyClass=SimpleStrategy, strategyOptions={replication_factor=1},
cfMetaData={}, durableWrites=true, userTypes=org.apache.cassandra.config.UTMetaData@370ad1d3}
INFO  [MigrationStage:1] 2015-01-28 17:59:08,476 ColumnFamilyStore.java:856 - Enqueuing flush
of schema_keyspaces: 512 (0%) on-heap, 0 (0%) off-heap
INFO  [MemtableFlushWriter:22] 2015-01-28 17:59:08,477 Memtable.java:326 - Writing Memtable-schema_keyspaces@1664717092(138
serialized bytes, 3 ops, 0%/0% of on/off-heap limit)
INFO  [MemtableFlushWriter:22] 2015-01-28 17:59:08,486 Memtable.java:360 - Completed flushing
/usr/share/apache-cassandra-2.1.0/bin/../data/data/system/schema_keyspaces-b0f2235744583cdb9631c43e59ce3676/system-schema_keyspaces-ka-118-Data.db
(175 bytes) for commitlog position ReplayPosition(segmentId=1422485457803, position=10514)

This issue doesn’t happen always. My test runs fine sometimes but once it gets into this
state, it remains there for a while and I can constantly reproduce this.

Also, when this issue happens for the first time, I also see the following error message in
system.log file:


ERROR [SharedPool-Worker-1] 2015-01-28 15:08:24,286 ErrorMessage.java:218 - Unexpected exception
during request
java.io.IOException: Connection reset by peer
        at sun.nio.ch.FileDispatcherImpl.read0(Native Method) ~[na:1.8.0_05]
        at sun.nio.ch.SocketDispatcher.read(SocketDispatcher.java:39) ~[na:1.8.0_05]
        at sun.nio.ch.IOUtil.readIntoNativeBuffer(IOUtil.java:223) ~[na:1.8.0_05]
        at sun.nio.ch.IOUtil.read(IOUtil.java:192) ~[na:1.8.0_05]
        at sun.nio.ch.SocketChannelImpl.read(SocketChannelImpl.java:375) ~[na:1.8.0_05]
        at io.netty.buffer.PooledUnsafeDirectByteBuf.setBytes(PooledUnsafeDirectByteBuf.java:311)
~[netty-all-4.0.20.Final.jar:4.0.20.Final]
        at io.netty.buffer.AbstractByteBuf.writeBytes(AbstractByteBuf.java:878) ~[netty-all-4.0.20.Final.jar:4.0.20.Final]
        at io.netty.channel.socket.nio.NioSocketChannel.doReadBytes(NioSocketChannel.java:225)
~[netty-all-4.0.20.Final.jar:4.0.20.Final]
        at io.netty.channel.nio.AbstractNioByteChannel$NioByteUnsafe.read(AbstractNioByteChannel.java:114)
~[netty-all-4.0.20.Final.jar:4.0.20.Final]
        at io.netty.channel.nio.NioEventLoop.processSelectedKey(NioEventLoop.java:507) ~[netty-all-4.0.20.Final.jar:4.0.20.Final]
        at io.netty.channel.nio.NioEventLoop.processSelectedKeysOptimized(NioEventLoop.java:464)
~[netty-all-4.0.20.Final.jar:4.0.20.Final]
        at io.netty.channel.nio.NioEventLoop.processSelectedKeys(NioEventLoop.java:378) ~[netty-all-4.0.20.Final.jar:4.0.20.Final]
        at io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:350) ~[netty-all-4.0.20.Final.jar:4.0.20.Final]
        at io.netty.util.concurrent.SingleThreadEventExecutor$2.run(SingleThreadEventExecutor.java:116)
~[netty-all-4.0.20.Final.jar:4.0.20.Final]
        at java.lang.Thread.run(Thread.java:745) [na:1.8.0_05]

Anyone has any idea what might be going on here?

Thanks,
Saurabh


Mime
View raw message