Attachment 902166 Details for Bug 1104647 – storage log from fbr-jon32-dr1-4.bc.jonqe.lab.eng.bos.redhat.com

storage log from fbr-jon32-dr1-4.bc.jonqe.lab.eng.bos.redhat.com

rhq-storage.log (text/x-log), 84.02 KB, created by Filip Brychta on 2014-06-04 12:37:19 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Filip Brychta

Created: 2014-06-04 12:37:19 UTC

Size: 84.02 KB

patch

obsolete

> INFO [main] 2014-06-04 07:44:12,550 CassandraDaemon.java (line 118) Logging initialized
> INFO [main] 2014-06-04 07:44:12,572 CassandraDaemon.java (line 145) JVM vendor/version: OpenJDK 64-Bit Server VM/1.7.0_45
> WARN [main] 2014-06-04 07:44:12,573 CassandraDaemon.java (line 150) OpenJDK is not recommended. Please upgrade to the newest Oracle Java release
> INFO [main] 2014-06-04 07:44:12,573 CassandraDaemon.java (line 183) Heap size: 523501568/523501568
> INFO [main] 2014-06-04 07:44:12,573 CassandraDaemon.java (line 184) Classpath: ./../conf:./../build/classes/main:./../build/classes/thrift:./../lib/antlr-3.2.jar:./../lib/apache-cassandra-1.2.9.jar:./../lib/apache-cassandra-clientutil-1.2.9.jar:./../lib/apache-cassandra-thrift-1.2.9.jar:./../lib/avro-1.4.0-fixes.jar:./../lib/avro-1.4.0-sources-fixes.jar:./../lib/commons-cli-1.1.jar:./../lib/commons-codec-1.2.jar:./../lib/commons-lang-2.6.jar:./../lib/compress-lzf-0.8.4.jar:./../lib/concurrentlinkedhashmap-lru-1.3.jar:./../lib/guava-13.0.1.jar:./../lib/high-scale-lib-1.1.2.jar:./../lib/jackson-core-asl-1.9.2.jar:./../lib/jackson-mapper-asl-1.9.2.jar:./../lib/jamm-0.2.5.jar:./../lib/jbcrypt-0.3m.jar:./../lib/jline-1.0.jar:./../lib/json-simple-1.1.jar:./../lib/libthrift-0.7.0.jar:./../lib/log4j-1.2.16.jar:./../lib/metrics-core-2.0.3.jar:./../lib/netty-3.6.6.Final.jar:./../lib/rhq-cassandra-auth-4.9.0.JON320GA.jar:./../lib/servlet-api-2.5-20081211.jar:./../lib/slf4j-api-1.7.2.jar:./../lib/slf4j-log4j12-1.7.2.jar:./../lib/snakeyaml-1.6.jar:./../lib/snappy-java-1.0.4.1-rhq-p1.jar:./../lib/snaptree-0.1.jar:./../lib/jamm-0.2.5.jar
> INFO [main] 2014-06-04 07:44:12,576 CLibrary.java (line 65) JNA not found. Native methods will be disabled.
> INFO [main] 2014-06-04 07:44:12,592 DatabaseDescriptor.java (line 132) Loading settings from file:/home/hudson/jon-server-3.2.0.GA/rhq-storage/conf/cassandra.yaml
> INFO [main] 2014-06-04 07:44:13,305 DatabaseDescriptor.java (line 150) Data files directories: [../../../rhq-data/data]
> INFO [main] 2014-06-04 07:44:13,306 DatabaseDescriptor.java (line 151) Commit log directory: ../../../rhq-data/commit_log
> INFO [main] 2014-06-04 07:44:13,306 DatabaseDescriptor.java (line 191) DiskAccessMode 'auto' determined to be mmap, indexAccessMode is mmap
> INFO [main] 2014-06-04 07:44:13,306 DatabaseDescriptor.java (line 205) disk_failure_policy is stop
> INFO [main] 2014-06-04 07:44:13,322 DatabaseDescriptor.java (line 276) Global memtable threshold is enabled at 166MB
> INFO [main] 2014-06-04 07:44:13,508 DatabaseDescriptor.java (line 404) Not using multi-threaded compaction
> WARN [main] 2014-06-04 07:44:13,528 SnappyCompressor.java (line 38) Cannot initialize native Snappy library. Compression on new tables will be disabled.
> INFO [main] 2014-06-04 07:44:13,825 CacheService.java (line 111) Initializing key cache with capacity of 24 MBs.
> INFO [main] 2014-06-04 07:44:13,838 CacheService.java (line 140) Scheduling key cache save to each 14400 seconds (going to save all keys).
> INFO [main] 2014-06-04 07:44:13,841 CacheService.java (line 154) Initializing row cache with capacity of 0 MBs and provider org.apache.cassandra.cache.SerializingCacheProvider
> INFO [main] 2014-06-04 07:44:13,857 CacheService.java (line 166) Scheduling row cache save to each 0 seconds (going to save all keys).
> INFO [main] 2014-06-04 07:44:13,953 ColumnFamilyStore.java (line 226) Initializing system.batchlog
> INFO [main] 2014-06-04 07:44:13,990 ColumnFamilyStore.java (line 226) Initializing system.peer_events
> INFO [main] 2014-06-04 07:44:14,000 ColumnFamilyStore.java (line 226) Initializing system.hints
> INFO [main] 2014-06-04 07:44:14,015 ColumnFamilyStore.java (line 226) Initializing system.Schema
> INFO [main] 2014-06-04 07:44:14,032 ColumnFamilyStore.java (line 226) Initializing system.schema_keyspaces
> INFO [main] 2014-06-04 07:44:14,041 ColumnFamilyStore.java (line 226) Initializing system.range_xfers
> INFO [main] 2014-06-04 07:44:14,053 ColumnFamilyStore.java (line 226) Initializing system.HintsColumnFamily
> INFO [main] 2014-06-04 07:44:14,067 ColumnFamilyStore.java (line 226) Initializing system.schema_columnfamilies
> INFO [main] 2014-06-04 07:44:14,075 ColumnFamilyStore.java (line 226) Initializing system.NodeIdInfo
> INFO [main] 2014-06-04 07:44:14,085 ColumnFamilyStore.java (line 226) Initializing system.schema_columns
> INFO [main] 2014-06-04 07:44:14,093 ColumnFamilyStore.java (line 226) Initializing system.IndexInfo
> INFO [main] 2014-06-04 07:44:14,107 ColumnFamilyStore.java (line 226) Initializing system.Migrations
> INFO [main] 2014-06-04 07:44:14,118 ColumnFamilyStore.java (line 226) Initializing system.peers
> INFO [main] 2014-06-04 07:44:14,126 ColumnFamilyStore.java (line 226) Initializing system.local
> INFO [main] 2014-06-04 07:44:14,134 ColumnFamilyStore.java (line 226) Initializing system.LocationInfo
> INFO [main] 2014-06-04 07:44:14,436 DatabaseDescriptor.java (line 538) Couldn't detect any schema definitions in local storage.
> INFO [main] 2014-06-04 07:44:14,437 DatabaseDescriptor.java (line 543) To create keyspaces and column families, see 'help create' in cqlsh.
> INFO [main] 2014-06-04 07:44:14,533 ColumnFamilyStore.java (line 226) Initializing system_traces.sessions
> INFO [main] 2014-06-04 07:44:14,543 ColumnFamilyStore.java (line 226) Initializing system_traces.events
> INFO [main] 2014-06-04 07:44:14,575 CommitLog.java (line 120) No commitlog files found; skipping replay
> INFO [main] 2014-06-04 07:44:14,993 StorageService.java (line 456) Cassandra version: 1.2.9
> INFO [main] 2014-06-04 07:44:14,993 StorageService.java (line 457) Thrift API version: 19.36.0
> INFO [main] 2014-06-04 07:44:14,993 StorageService.java (line 458) CQL supported versions: 2.0.0,3.0.5 (default: 3.0.5)
> INFO [main] 2014-06-04 07:44:15,086 StorageService.java (line 483) Loading persisted ring state
> INFO [main] 2014-06-04 07:44:15,089 StorageService.java (line 564) Starting up server gossip
> WARN [main] 2014-06-04 07:44:15,099 SystemTable.java (line 656) No host ID found, created b95d2734-37fd-40a1-a13a-44c7c5e941a2 (Note: This should happen exactly once per node).
> INFO [main] 2014-06-04 07:44:15,127 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-local@1103050127(352/352 serialized/live bytes, 15 ops)
> INFO [FlushWriter:1] 2014-06-04 07:44:15,136 Memtable.java (line 461) Writing Memtable-local@1103050127(352/352 serialized/live bytes, 15 ops)
> INFO [FlushWriter:1] 2014-06-04 07:44:15,429 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/system/local/system-local-ic-1-Data.db (460 bytes) for commitlog position ReplayPosition(segmentId=1401882254408, position=52202)
> INFO [main] 2014-06-04 07:44:15,540 MessagingService.java (line 453) Starting Messaging Service on port 7100
> INFO [main] 2014-06-04 07:44:15,664 StorageService.java (line 731) Generated random tokens. tokens are [4561179645511623689, 1516204827858533606, -242653875293069071, -1911903988468336575, -7791405691203076195, -4781625614703110413, 5054548416414845144, 6684398310163491667, 800353836620484234, 5537993005114965562, 6890490504189832932, 6523203953049731312, -4284249522040632792, 1386951491176396562, -6625929742770166495, 8600963168036977892, 232855487870227864, 6344780900196630986, 5776737464189841245, 6707644248736870652, -1139017924127592143, -2213499247048388579, 4502858714642720766, -1174407013112616731, -1074885944697090967, 1184742861491223200, 6502555294598339466, -7284249145444445505, 4117490733453846459, 6035721325900334282, 5975868129826127149, 4458744329656015691, 5856978347985599933, -1218916587827513267, -2256341203667354543, -5585995081469243890, -5809016492649502027, 2304013789942128046, 7131318286795471422, 998011913539854281, -8375307937697438448, 3719223009772136090, 6375069292309775879, 3215532129242305576, -7419402877147956910, 2733233738462200565, -6831798304104336053, 5114158111088256454, -9003346116126037549, 314763049983941309, -3896216137594306907, -5028667500161422718, 3453483096596178824, -1129817488724099979, 6014505115747648986, 2156969649203957278, 6658514774664728503, 3341032972624063803, 1129585270003058498, 5463969932972477131, 4350012570336571786, -1013632775341515348, -4591769508867923891, 3553044157136869391, -4495113453915736409, 7702374816709641275, 6885428303550024942, -2663143849140620879, 4820076342274269131, -7168561352076646944, 2261976128002610693, 3217614070501689545, 6822674562887764861, 560233902392264028, -3062797814365890954, -6164488455690549212, 4436336551369323548, 4213676628131341587, -7267409253628204737, -3438404486121177447, 3501980836878340075, -3929703036124778026, -6635283115780610476, 8227665396116934837, 7468953056957123376, 7426214507103448783, 5011605558249582682, 629801292192339009, 4879946602657094224, -6216238602933504546, 7957149038075790824, -5186074012432790790, -2971194228796492684, -6685228344602449494, 2113032008249526776, -5624249059918382228, -2653702401981397201, -2690902727590457854, 2267039190892869938, 1828597130038934054, -4009458531413934054, -2659897877125698768, -2899280730027601139, -5126813631165881991, 6833101262085563460, 4037505866163575673, -5308365129787144025, -5329739840991944561, 5693170396400649357, 3056817253416543350, 8790622376533621864, -4261488102993500044, 8426904046594705302, 7599372257571852971, 7074224292552010372, -6553044504911860749, 5972625711478016754, -833296201457482844, -5376724019935792470, -3997888833414208037, -2666730259067164474, -4815532662766596248, -6492850002116934943, -8485410280639512473, 4900522751547071625, 6460333947316027090, 6993653397705581438, 5231773051082477738, 6753175415740238057, -6936801846995952631, 5192701029289992214, -8010455092606945282, -3817536399018681468, -7022098355378670232, -7218337769340267336, 2524933299556676561, -2531238211912171311, -6208518231238748052, -3109108846769225769, 3004613488542261185, -3116920125977221920, 8800237939966300904, -1124261474895898946, -4870468400138507545, 2732372850197899168, -2040769164123166009, 160066558285427909, -2080068931966500608, -1885001901836331818, 965201212618659280, 673556823032697436, 8595458353900886191, 6144469962790688217, -5006195157373186154, -9216301343778810475, 521317868581959645, -9164106770270800549, -2293162367734193711, -7329304927515455849, -6668926340470057678, 8136275952455203246, 4365208677367073768, -4320222981914610774, 1083356822698608398, 7815012974563781825, -1116655963614576034, -1634380059051968212, -2776951507771220512, 801994914403221602, 7087722191956944129, 7628443151196710479, -2459191083959280943, 498423852183340289, -3215219083440054034, -899399771840967579, -487286655467113935, 5918938000397836779, 3059342361346952979, 1209071414165124246, -2873470864539714817, 826141644220140128, -9012262657641990388, -1103046000937880880, -38524828302844123, -4265443495819592492, 8784454425856169227, -3442539181362805226, -1390631221122315953, 5680195966495002022, -7733913590382509861, -8142369781921692299, -2991925104932534317, 2741867848420395743, -9200190789833977908, 8514500878437393302, -2719985045998393223, -8667501142167865076, 2147833130788676183, 8824336561228702850, -3361581194688858730, 5661283184964748428, -8008782264886752691, -4343857283703906517, 170407677044922885, -5542401844769406711, -5984689378262972682, 9195528099647661530, -9001150771361889660, 5728481668244335695, -8689580031027811905, 2889268129870171646, -2408974815291898635, -4549243791279622593, 5995888042257376495, -6749736206215663458, -856441344870136815, -756293943474574866, 3593022401584629406, 5084541773862225927, -7230641179701638889, 2030412363626782884, 9161404872917007466, -3637219870613245283, 5175339380178731389, -4900563512371847490, -6671721338153373980, -7153370367918910645, 8229051077500804878, -5408980511504133583, 1033017246042332651, 4529881053437851185, -8471532839789665022, -4339332250353994838, 3672875084968056821, 1569960974759724100, 5871885369715729174, -438014691452407175, -8230372149171437201, 33391380515459984, 1933954379823298709, 8215683385336656564, 5164078394729240777, 4501413881227944845, -3615236621102192956, -7097465791568813543, -2361383013033418166, 6249090464423394204, -7633855828165525069, -3815337794412721973, 1600611424681496268, 6125529599804789859, 2939505219730441984, 6648641506518563071, -9132106501151952582, 4093445094730123642, -3769791872994826531]
> INFO [main] 2014-06-04 07:44:15,666 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-local@1636769390(84/84 serialized/live bytes, 4 ops)
> INFO [FlushWriter:1] 2014-06-04 07:44:15,666 Memtable.java (line 461) Writing Memtable-local@1636769390(84/84 serialized/live bytes, 4 ops)
> INFO [FlushWriter:1] 2014-06-04 07:44:15,902 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/system/local/system-local-ic-2-Data.db (136 bytes) for commitlog position ReplayPosition(segmentId=1401882254408, position=52477)
> INFO [main] 2014-06-04 07:44:15,981 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-local@1881067133(10095/10095 serialized/live bytes, 257 ops)
> INFO [FlushWriter:1] 2014-06-04 07:44:15,982 Memtable.java (line 461) Writing Memtable-local@1881067133(10095/10095 serialized/live bytes, 257 ops)
> INFO [FlushWriter:1] 2014-06-04 07:44:16,176 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/system/local/system-local-ic-3-Data.db (11960 bytes) for commitlog position ReplayPosition(segmentId=1401882254408, position=64481)
> INFO [main] 2014-06-04 07:44:16,271 StorageService.java (line 1354) Node fbr-jon32-dr1-4.bc.jonqe.lab.eng.bos.redhat.com/10.16.23.104 state jump to normal
> INFO [main] 2014-06-04 07:44:16,289 StorageService.java (line 807) Startup completed! Now serving reads.
> INFO [main] 2014-06-04 07:44:16,294 MigrationManager.java (line 216) Create new Keyspace: system_auth, rep strategy:SimpleStrategy{}, strategy_options: {replication_factor=1}, durable_writes: true
> INFO [MigrationStage:1] 2014-06-04 07:44:16,360 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-schema_keyspaces@402128975(389/389 serialized/live bytes, 11 ops)
> INFO [FlushWriter:1] 2014-06-04 07:44:16,361 Memtable.java (line 461) Writing Memtable-schema_keyspaces@402128975(389/389 serialized/live bytes, 11 ops)
> INFO [FlushWriter:1] 2014-06-04 07:44:16,526 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/system/schema_keyspaces/system-schema_keyspaces-ic-1-Data.db (560 bytes) for commitlog position ReplayPosition(segmentId=1401882254408, position=64722)
> INFO [MigrationStage:1] 2014-06-04 07:44:16,529 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-schema_columnfamilies@1415420963(21238/21238 serialized/live bytes, 369 ops)
> INFO [FlushWriter:1] 2014-06-04 07:44:16,530 Memtable.java (line 461) Writing Memtable-schema_columnfamilies@1415420963(21238/21238 serialized/live bytes, 369 ops)
> INFO [FlushWriter:1] 2014-06-04 07:44:16,706 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/system/schema_columnfamilies/system-schema_columnfamilies-ic-1-Data.db (23878 bytes) for commitlog position ReplayPosition(segmentId=1401882254408, position=64722)
> INFO [MigrationStage:1] 2014-06-04 07:44:16,707 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-schema_columns@1694835335(23741/23741 serialized/live bytes, 386 ops)
> INFO [FlushWriter:1] 2014-06-04 07:44:16,710 Memtable.java (line 461) Writing Memtable-schema_columns@1694835335(23741/23741 serialized/live bytes, 386 ops)
> INFO [FlushWriter:1] 2014-06-04 07:44:16,892 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/system/schema_columns/system-schema_columns-ic-1-Data.db (26500 bytes) for commitlog position ReplayPosition(segmentId=1401882254408, position=64722)
> INFO [main] 2014-06-04 07:44:17,033 MigrationManager.java (line 230) Create new ColumnFamily: org.apache.cassandra.config.CFMetaData@46b74cdd[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={},bloomFilterFpChance=0.01,caching=KEYS_ONLY,populateIoCacheOnFlush=false]
> INFO [MigrationStage:1] 2014-06-04 07:44:17,077 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-schema_columnfamilies@16833437(1043/1043 serialized/live bytes, 21 ops)
> INFO [FlushWriter:1] 2014-06-04 07:44:17,077 Memtable.java (line 461) Writing Memtable-schema_columnfamilies@16833437(1043/1043 serialized/live bytes, 21 ops)
> INFO [FlushWriter:1] 2014-06-04 07:44:17,249 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/system/schema_columnfamilies/system-schema_columnfamilies-ic-2-Data.db (1227 bytes) for commitlog position ReplayPosition(segmentId=1401882254408, position=66493)
> INFO [MigrationStage:1] 2014-06-04 07:44:17,251 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-schema_columns@216412820(278/278 serialized/live bytes, 6 ops)
> INFO [FlushWriter:1] 2014-06-04 07:44:17,251 Memtable.java (line 461) Writing Memtable-schema_columns@216412820(278/278 serialized/live bytes, 6 ops)
> INFO [FlushWriter:1] 2014-06-04 07:44:17,412 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/system/schema_columns/system-schema_columns-ic-2-Data.db (357 bytes) for commitlog position ReplayPosition(segmentId=1401882254408, position=66493)
> INFO [MigrationStage:1] 2014-06-04 07:44:17,464 ColumnFamilyStore.java (line 226) Initializing system_auth.users
> INFO [main] 2014-06-04 07:44:17,518 MigrationManager.java (line 230) Create new ColumnFamily: org.apache.cassandra.config.CFMetaData@73991400[cfId=1064e0a0-1f2c-3a17-b803-cb8e23d8458f,ksName=system_auth,cfName=credentials,cfType=Standard,comparator=org.apache.cassandra.db.marshal.CompositeType(org.apache.cassandra.db.marshal.UTF8Type,org.apache.cassandra.db.marshal.ColumnToCollectionType(6f7074696f6e73:org.apache.cassandra.db.marshal.MapType(org.apache.cassandra.db.marshal.UTF8Type,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=8 cap=8]],columnAliases=[],valueAlias=<null>,column_metadata={java.nio.HeapByteBuffer[pos=0 lim=11 cap=11]=ColumnDefinition{name=73616c7465645f68617368, validator=org.apache.cassandra.db.marshal.UTF8Type, index_type=null, index_name='null', component_index=0}, java.nio.HeapByteBuffer[pos=0 lim=7 cap=7]=ColumnDefinition{name=6f7074696f6e73, validator=org.apache.cassandra.db.marshal.MapType(org.apache.cassandra.db.marshal.UTF8Type,org.apache.cassandra.db.marshal.UTF8Type), index_type=null, index_name='null', component_index=0}},compactionStrategyClass=class org.apache.cassandra.db.compaction.SizeTieredCompactionStrategy,compactionStrategyOptions={},compressionOptions={},bloomFilterFpChance=0.01,caching=KEYS_ONLY,populateIoCacheOnFlush=false]
> INFO [MigrationStage:1] 2014-06-04 07:44:17,587 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-schema_columnfamilies@2039129076(1367/1367 serialized/live bytes, 21 ops)
> INFO [FlushWriter:1] 2014-06-04 07:44:17,588 Memtable.java (line 461) Writing Memtable-schema_columnfamilies@2039129076(1367/1367 serialized/live bytes, 21 ops)
> INFO [FlushWriter:1] 2014-06-04 07:44:17,779 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/system/schema_columnfamilies/system-schema_columnfamilies-ic-3-Data.db (1551 bytes) for commitlog position ReplayPosition(segmentId=1401882254408, position=69104)
> INFO [MigrationStage:1] 2014-06-04 07:44:17,781 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-schema_columns@641905851(752/752 serialized/live bytes, 12 ops)
> INFO [FlushWriter:1] 2014-06-04 07:44:17,781 Memtable.java (line 461) Writing Memtable-schema_columns@641905851(752/752 serialized/live bytes, 12 ops)
> INFO [FlushWriter:1] 2014-06-04 07:44:17,937 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/system/schema_columns/system-schema_columns-ic-3-Data.db (873 bytes) for commitlog position ReplayPosition(segmentId=1401882254408, position=69104)
> INFO [MigrationStage:1] 2014-06-04 07:44:17,978 ColumnFamilyStore.java (line 226) Initializing system_auth.credentials
> INFO [main] 2014-06-04 07:44:18,032 MigrationManager.java (line 230) Create new ColumnFamily: org.apache.cassandra.config.CFMetaData@3142caca[cfId=2d324e48-3275-3517-8dd5-9a2c5b0856c5,ksName=system_auth,cfName=permissions,cfType=Standard,comparator=org.apache.cassandra.db.marshal.CompositeType(org.apache.cassandra.db.marshal.UTF8Type,org.apache.cassandra.db.marshal.UTF8Type,org.apache.cassandra.db.marshal.ColumnToCollectionType(7065726d697373696f6e73:org.apache.cassandra.db.marshal.SetType(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=8 cap=8]],columnAliases=[java.nio.HeapByteBuffer[pos=0 lim=8 cap=8]],valueAlias=<null>,column_metadata={java.nio.HeapByteBuffer[pos=0 lim=11 cap=11]=ColumnDefinition{name=7065726d697373696f6e73, validator=org.apache.cassandra.db.marshal.SetType(org.apache.cassandra.db.marshal.UTF8Type), index_type=null, index_name='null', component_index=1}},compactionStrategyClass=class org.apache.cassandra.db.compaction.SizeTieredCompactionStrategy,compactionStrategyOptions={},compressionOptions={},bloomFilterFpChance=0.01,caching=KEYS_ONLY,populateIoCacheOnFlush=false]
> INFO [MigrationStage:1] 2014-06-04 07:44:18,071 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-schema_columnfamilies@403680522(1385/1385 serialized/live bytes, 21 ops)
> INFO [FlushWriter:1] 2014-06-04 07:44:18,072 Memtable.java (line 461) Writing Memtable-schema_columnfamilies@403680522(1385/1385 serialized/live bytes, 21 ops)
> INFO [FlushWriter:1] 2014-06-04 07:44:18,226 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/system/schema_columnfamilies/system-schema_columnfamilies-ic-4-Data.db (1569 bytes) for commitlog position ReplayPosition(segmentId=1401882254408, position=71327)
> INFO [MigrationStage:1] 2014-06-04 07:44:18,231 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-schema_columns@1454385274(388/388 serialized/live bytes, 6 ops)
> INFO [FlushWriter:1] 2014-06-04 07:44:18,232 Memtable.java (line 461) Writing Memtable-schema_columns@1454385274(388/388 serialized/live bytes, 6 ops)
> INFO [CompactionExecutor:1] 2014-06-04 07:44:18,238 CompactionTask.java (line 105) Compacting [SSTableReader(path='../../../rhq-data/data/system/schema_columnfamilies/system-schema_columnfamilies-ic-4-Data.db'), SSTableReader(path='../../../rhq-data/data/system/schema_columnfamilies/system-schema_columnfamilies-ic-2-Data.db'), SSTableReader(path='../../../rhq-data/data/system/schema_columnfamilies/system-schema_columnfamilies-ic-1-Data.db'), SSTableReader(path='../../../rhq-data/data/system/schema_columnfamilies/system-schema_columnfamilies-ic-3-Data.db')]
> INFO [FlushWriter:1] 2014-06-04 07:44:18,468 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/system/schema_columns/system-schema_columns-ic-4-Data.db (467 bytes) for commitlog position ReplayPosition(segmentId=1401882254408, position=71327)
> INFO [MigrationStage:1] 2014-06-04 07:44:18,540 ColumnFamilyStore.java (line 226) Initializing system_auth.permissions
> INFO [CompactionExecutor:1] 2014-06-04 07:44:18,548 CompactionTask.java (line 262) Compacted 4 sstables to [../../../rhq-data/data/system/schema_columnfamilies/system-schema_columnfamilies-ic-5,].  28,225 bytes to 28,151 (~99% of original) in 302ms = 0.088897MB/s.  5 total rows, 3 unique.  Row merge counts were {1:2, 2:0, 3:1, 4:0, }
> INFO [main] 2014-06-04 07:44:18,814 Server.java (line 138) Starting listening for CQL clients on fbr-jon32-dr1-4.bc.jonqe.lab.eng.bos.redhat.com/10.16.23.104:9142...
> INFO [main] 2014-06-04 07:44:18,855 CassandraDaemon.java (line 402) Not starting RPC server as requested. Use JMX (StorageService->startRPCServer()) or nodetool (enablethrift) to start it
> INFO [NonPeriodicTasks:1] 2014-06-04 07:44:28,558 PasswordAuthenticator.java (line 228) PasswordAuthenticator created default user 'cassandra'
> INFO [NonPeriodicTasks:1] 2014-06-04 07:44:28,624 Auth.java (line 217) Created default superuser 'cassandra'
> INFO [main] 2014-06-04 07:44:50,693 CassandraDaemon.java (line 118) Logging initialized
> INFO [main] 2014-06-04 07:44:50,712 CassandraDaemon.java (line 145) JVM vendor/version: OpenJDK 64-Bit Server VM/1.7.0_45
> WARN [main] 2014-06-04 07:44:50,713 CassandraDaemon.java (line 150) OpenJDK is not recommended. Please upgrade to the newest Oracle Java release
> INFO [main] 2014-06-04 07:44:50,713 CassandraDaemon.java (line 183) Heap size: 523501568/523501568
> INFO [main] 2014-06-04 07:44:50,713 CassandraDaemon.java (line 184) Classpath: ./../conf:./../build/classes/main:./../build/classes/thrift:./../lib/antlr-3.2.jar:./../lib/apache-cassandra-1.2.9.jar:./../lib/apache-cassandra-clientutil-1.2.9.jar:./../lib/apache-cassandra-thrift-1.2.9.jar:./../lib/avro-1.4.0-fixes.jar:./../lib/avro-1.4.0-sources-fixes.jar:./../lib/commons-cli-1.1.jar:./../lib/commons-codec-1.2.jar:./../lib/commons-lang-2.6.jar:./../lib/compress-lzf-0.8.4.jar:./../lib/concurrentlinkedhashmap-lru-1.3.jar:./../lib/guava-13.0.1.jar:./../lib/high-scale-lib-1.1.2.jar:./../lib/jackson-core-asl-1.9.2.jar:./../lib/jackson-mapper-asl-1.9.2.jar:./../lib/jamm-0.2.5.jar:./../lib/jbcrypt-0.3m.jar:./../lib/jline-1.0.jar:./../lib/json-simple-1.1.jar:./../lib/libthrift-0.7.0.jar:./../lib/log4j-1.2.16.jar:./../lib/metrics-core-2.0.3.jar:./../lib/netty-3.6.6.Final.jar:./../lib/rhq-cassandra-auth-4.9.0.JON320GA.jar:./../lib/servlet-api-2.5-20081211.jar:./../lib/slf4j-api-1.7.2.jar:./../lib/slf4j-log4j12-1.7.2.jar:./../lib/snakeyaml-1.6.jar:./../lib/snappy-java-1.0.4.1-rhq-p1.jar:./../lib/snaptree-0.1.jar:./../lib/jamm-0.2.5.jar
> INFO [main] 2014-06-04 07:44:50,716 CLibrary.java (line 65) JNA not found. Native methods will be disabled.
> INFO [main] 2014-06-04 07:44:50,730 DatabaseDescriptor.java (line 132) Loading settings from file:/home/hudson/jon-server-3.2.0.GA/rhq-storage/conf/cassandra.yaml
> INFO [main] 2014-06-04 07:44:51,283 DatabaseDescriptor.java (line 150) Data files directories: [../../../rhq-data/data]
> INFO [main] 2014-06-04 07:44:51,283 DatabaseDescriptor.java (line 151) Commit log directory: ../../../rhq-data/commit_log
> INFO [main] 2014-06-04 07:44:51,284 DatabaseDescriptor.java (line 191) DiskAccessMode 'auto' determined to be mmap, indexAccessMode is mmap
> INFO [main] 2014-06-04 07:44:51,284 DatabaseDescriptor.java (line 205) disk_failure_policy is stop
> INFO [main] 2014-06-04 07:44:51,303 DatabaseDescriptor.java (line 276) Global memtable threshold is enabled at 166MB
> INFO [main] 2014-06-04 07:44:51,480 DatabaseDescriptor.java (line 404) Not using multi-threaded compaction
> WARN [main] 2014-06-04 07:44:51,499 SnappyCompressor.java (line 38) Cannot initialize native Snappy library. Compression on new tables will be disabled.
> INFO [main] 2014-06-04 07:44:51,805 CacheService.java (line 111) Initializing key cache with capacity of 24 MBs.
> INFO [main] 2014-06-04 07:44:51,816 CacheService.java (line 140) Scheduling key cache save to each 14400 seconds (going to save all keys).
> INFO [main] 2014-06-04 07:44:51,819 CacheService.java (line 154) Initializing row cache with capacity of 0 MBs and provider org.apache.cassandra.cache.SerializingCacheProvider
> INFO [main] 2014-06-04 07:44:51,827 CacheService.java (line 166) Scheduling row cache save to each 0 seconds (going to save all keys).
> INFO [main] 2014-06-04 07:44:51,920 ColumnFamilyStore.java (line 226) Initializing system.batchlog
> INFO [main] 2014-06-04 07:44:51,954 ColumnFamilyStore.java (line 226) Initializing system.peer_events
> INFO [main] 2014-06-04 07:44:51,965 ColumnFamilyStore.java (line 226) Initializing system.hints
> INFO [main] 2014-06-04 07:44:51,979 ColumnFamilyStore.java (line 226) Initializing system.Schema
> INFO [main] 2014-06-04 07:44:51,994 ColumnFamilyStore.java (line 226) Initializing system.schema_keyspaces
> INFO [main] 2014-06-04 07:44:52,004 ColumnFamilyStore.java (line 226) Initializing system.range_xfers
> INFO [main] 2014-06-04 07:44:52,011 ColumnFamilyStore.java (line 226) Initializing system.HintsColumnFamily
> INFO [main] 2014-06-04 07:44:52,021 ColumnFamilyStore.java (line 226) Initializing system.schema_columnfamilies
> INFO [main] 2014-06-04 07:44:52,029 ColumnFamilyStore.java (line 226) Initializing system.NodeIdInfo
> INFO [main] 2014-06-04 07:44:52,037 ColumnFamilyStore.java (line 226) Initializing system.schema_columns
> INFO [main] 2014-06-04 07:44:52,047 ColumnFamilyStore.java (line 226) Initializing system.IndexInfo
> INFO [main] 2014-06-04 07:44:52,058 ColumnFamilyStore.java (line 226) Initializing system.Migrations
> INFO [main] 2014-06-04 07:44:52,065 ColumnFamilyStore.java (line 226) Initializing system.peers
> INFO [main] 2014-06-04 07:44:52,075 ColumnFamilyStore.java (line 226) Initializing system.local
> INFO [main] 2014-06-04 07:44:52,083 ColumnFamilyStore.java (line 226) Initializing system.LocationInfo
> INFO [main] 2014-06-04 07:44:52,379 DatabaseDescriptor.java (line 538) Couldn't detect any schema definitions in local storage.
> INFO [main] 2014-06-04 07:44:52,449 DatabaseDescriptor.java (line 543) To create keyspaces and column families, see 'help create' in cqlsh.
> INFO [main] 2014-06-04 07:44:52,519 ColumnFamilyStore.java (line 226) Initializing system_traces.sessions
> INFO [main] 2014-06-04 07:44:52,532 ColumnFamilyStore.java (line 226) Initializing system_traces.events
> INFO [main] 2014-06-04 07:44:52,561 CommitLog.java (line 120) No commitlog files found; skipping replay
> INFO [main] 2014-06-04 07:44:53,047 StorageService.java (line 456) Cassandra version: 1.2.9
> INFO [main] 2014-06-04 07:44:53,048 StorageService.java (line 457) Thrift API version: 19.36.0
> INFO [main] 2014-06-04 07:44:53,051 StorageService.java (line 458) CQL supported versions: 2.0.0,3.0.5 (default: 3.0.5)
> INFO [main] 2014-06-04 07:44:53,097 StorageService.java (line 483) Loading persisted ring state
> INFO [main] 2014-06-04 07:44:53,100 StorageService.java (line 564) Starting up server gossip
> WARN [main] 2014-06-04 07:44:53,110 SystemTable.java (line 656) No host ID found, created b2baeffb-ffea-42fc-966a-d240c22472b2 (Note: This should happen exactly once per node).
> INFO [main] 2014-06-04 07:44:53,136 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-local@764998737(352/352 serialized/live bytes, 15 ops)
> INFO [FlushWriter:1] 2014-06-04 07:44:53,144 Memtable.java (line 461) Writing Memtable-local@764998737(352/352 serialized/live bytes, 15 ops)
> INFO [FlushWriter:1] 2014-06-04 07:44:53,512 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/system/local/system-local-ic-1-Data.db (460 bytes) for commitlog position ReplayPosition(segmentId=1401882292340, position=52202)
> INFO [main] 2014-06-04 07:44:53,698 MessagingService.java (line 453) Starting Messaging Service on port 7100
> INFO [main] 2014-06-04 07:44:53,747 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-local@2082608929(86/86 serialized/live bytes, 4 ops)
> INFO [FlushWriter:1] 2014-06-04 07:44:53,747 Memtable.java (line 461) Writing Memtable-local@2082608929(86/86 serialized/live bytes, 4 ops)
> INFO [FlushWriter:1] 2014-06-04 07:44:54,118 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/system/local/system-local-ic-2-Data.db (138 bytes) for commitlog position ReplayPosition(segmentId=1401882292340, position=52479)
> INFO [main] 2014-06-04 07:44:54,121 StorageService.java (line 914) JOINING: waiting for ring information
> INFO [HANDSHAKE-fbr-jon32-dr1-3.bc.jonqe.lab.eng.bos.redhat.com/10.16.23.63] 2014-06-04 07:44:54,558 OutboundTcpConnection.java (line 399) Handshaking version with fbr-jon32-dr1-3.bc.jonqe.lab.eng.bos.redhat.com/10.16.23.63
> INFO [HANDSHAKE-fbr-jon32-dr1.bc.jonqe.lab.eng.bos.redhat.com/10.16.23.156] 2014-06-04 07:44:55,567 OutboundTcpConnection.java (line 399) Handshaking version with fbr-jon32-dr1.bc.jonqe.lab.eng.bos.redhat.com/10.16.23.156
> INFO [GossipStage:1] 2014-06-04 07:44:55,951 Gossiper.java (line 823) Node /10.16.23.63 is now part of the cluster
> INFO [GossipStage:1] 2014-06-04 07:44:55,954 Gossiper.java (line 789) InetAddress /10.16.23.63 is now UP
> INFO [HANDSHAKE-fbr-jon32-dr1-3.bc.jonqe.lab.eng.bos.redhat.com/10.16.23.63] 2014-06-04 07:44:55,989 OutboundTcpConnection.java (line 399) Handshaking version with fbr-jon32-dr1-3.bc.jonqe.lab.eng.bos.redhat.com/10.16.23.63
> INFO [InternalResponseStage:1] 2014-06-04 07:44:56,164 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-schema_keyspaces@719361327(527/527 serialized/live bytes, 14 ops)
> INFO [FlushWriter:1] 2014-06-04 07:44:56,166 Memtable.java (line 461) Writing Memtable-schema_keyspaces@719361327(527/527 serialized/live bytes, 14 ops)
> INFO [GossipStage:1] 2014-06-04 07:44:56,196 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-peers@2120373926(10088/10088 serialized/live bytes, 257 ops)
> INFO [HANDSHAKE-fbr-jon32-dr1-3.bc.jonqe.lab.eng.bos.redhat.com/10.16.23.63] 2014-06-04 07:44:56,560 OutboundTcpConnection.java (line 399) Handshaking version with fbr-jon32-dr1-3.bc.jonqe.lab.eng.bos.redhat.com/10.16.23.63
> INFO [FlushWriter:1] 2014-06-04 07:44:57,083 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/system/schema_keyspaces/system-schema_keyspaces-ic-1-Data.db (748 bytes) for commitlog position ReplayPosition(segmentId=1401882292340, position=67553)
> INFO [InternalResponseStage:1] 2014-06-04 07:44:57,084 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-schema_columnfamilies@2099385497(32818/32818 serialized/live bytes, 558 ops)
> INFO [FlushWriter:1] 2014-06-04 07:44:57,085 Memtable.java (line 461) Writing Memtable-peers@2120373926(10088/10088 serialized/live bytes, 257 ops)
> INFO [HANDSHAKE-fbr-jon32-dr1-2.bc.jonqe.lab.eng.bos.redhat.com/10.16.23.185] 2014-06-04 07:44:57,563 OutboundTcpConnection.java (line 399) Handshaking version with fbr-jon32-dr1-2.bc.jonqe.lab.eng.bos.redhat.com/10.16.23.185
> INFO [FlushWriter:1] 2014-06-04 07:44:57,602 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/system/peers/system-peers-ic-1-Data.db (11952 bytes) for commitlog position ReplayPosition(segmentId=1401882292340, position=79549)
> INFO [FlushWriter:1] 2014-06-04 07:44:57,607 Memtable.java (line 461) Writing Memtable-schema_columnfamilies@2099385497(32818/32818 serialized/live bytes, 558 ops)
> INFO [GossipStage:1] 2014-06-04 07:44:57,613 Gossiper.java (line 823) Node /10.16.23.156 is now part of the cluster
> INFO [GossipStage:1] 2014-06-04 07:44:57,617 Gossiper.java (line 789) InetAddress /10.16.23.156 is now UP
> INFO [HANDSHAKE-fbr-jon32-dr1.bc.jonqe.lab.eng.bos.redhat.com/10.16.23.156] 2014-06-04 07:44:57,632 OutboundTcpConnection.java (line 399) Handshaking version with fbr-jon32-dr1.bc.jonqe.lab.eng.bos.redhat.com/10.16.23.156
> INFO [GossipStage:1] 2014-06-04 07:44:57,791 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-peers@1862430355(10293/10293 serialized/live bytes, 269 ops)
> INFO [HANDSHAKE-fbr-jon32-dr1.bc.jonqe.lab.eng.bos.redhat.com/10.16.23.156] 2014-06-04 07:44:58,563 OutboundTcpConnection.java (line 399) Handshaking version with fbr-jon32-dr1.bc.jonqe.lab.eng.bos.redhat.com/10.16.23.156
> INFO [FlushWriter:1] 2014-06-04 07:44:58,588 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/system/schema_columnfamilies/system-schema_columnfamilies-ic-1-Data.db (36847 bytes) for commitlog position ReplayPosition(segmentId=1401882292340, position=79549)
> INFO [InternalResponseStage:1] 2014-06-04 07:44:58,590 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-schema_columns@6557661(25159/25159 serialized/live bytes, 410 ops)
> INFO [FlushWriter:1] 2014-06-04 07:44:58,590 Memtable.java (line 461) Writing Memtable-peers@1862430355(10293/10293 serialized/live bytes, 269 ops)
> INFO [FlushWriter:1] 2014-06-04 07:44:59,275 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/system/peers/system-peers-ic-2-Data.db (12236 bytes) for commitlog position ReplayPosition(segmentId=1401882292340, position=92339)
> INFO [FlushWriter:1] 2014-06-04 07:44:59,279 Memtable.java (line 461) Writing Memtable-schema_columns@6557661(25159/25159 serialized/live bytes, 410 ops)
> INFO [GossipStage:1] 2014-06-04 07:44:59,289 Gossiper.java (line 823) Node /10.16.23.185 is now part of the cluster
> INFO [GossipStage:1] 2014-06-04 07:44:59,289 Gossiper.java (line 789) InetAddress /10.16.23.185 is now UP
> INFO [HANDSHAKE-fbr-jon32-dr1-2.bc.jonqe.lab.eng.bos.redhat.com/10.16.23.185] 2014-06-04 07:44:59,293 OutboundTcpConnection.java (line 399) Handshaking version with fbr-jon32-dr1-2.bc.jonqe.lab.eng.bos.redhat.com/10.16.23.185
> INFO [GossipStage:1] 2014-06-04 07:44:59,357 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-peers@451656(10293/10293 serialized/live bytes, 269 ops)
> INFO [HANDSHAKE-fbr-jon32-dr1-2.bc.jonqe.lab.eng.bos.redhat.com/10.16.23.185] 2014-06-04 07:44:59,564 OutboundTcpConnection.java (line 399) Handshaking version with fbr-jon32-dr1-2.bc.jonqe.lab.eng.bos.redhat.com/10.16.23.185
> INFO [FlushWriter:1] 2014-06-04 07:45:00,168 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/system/schema_columns/system-schema_columns-ic-1-Data.db (28123 bytes) for commitlog position ReplayPosition(segmentId=1401882292340, position=92339)
> INFO [FlushWriter:1] 2014-06-04 07:45:00,174 Memtable.java (line 461) Writing Memtable-peers@451656(10293/10293 serialized/live bytes, 269 ops)
> INFO [InternalResponseStage:1] 2014-06-04 07:45:00,318 ColumnFamilyStore.java (line 226) Initializing rhq.raw_metrics
> INFO [InternalResponseStage:1] 2014-06-04 07:45:00,328 ColumnFamilyStore.java (line 226) Initializing rhq.six_hour_metrics
> INFO [InternalResponseStage:1] 2014-06-04 07:45:00,334 ColumnFamilyStore.java (line 226) Initializing rhq.one_hour_metrics
> INFO [InternalResponseStage:1] 2014-06-04 07:45:00,339 ColumnFamilyStore.java (line 226) Initializing rhq.twenty_four_hour_metrics
> INFO [InternalResponseStage:1] 2014-06-04 07:45:00,350 ColumnFamilyStore.java (line 226) Initializing rhq.metrics_index
> INFO [InternalResponseStage:1] 2014-06-04 07:45:00,358 ColumnFamilyStore.java (line 226) Initializing rhq.schema_version
> INFO [InternalResponseStage:1] 2014-06-04 07:45:00,400 ColumnFamilyStore.java (line 226) Initializing system_auth.users
> INFO [InternalResponseStage:1] 2014-06-04 07:45:00,403 ColumnFamilyStore.java (line 226) Initializing system_auth.permissions
> INFO [InternalResponseStage:1] 2014-06-04 07:45:00,407 ColumnFamilyStore.java (line 226) Initializing system_auth.credentials
> INFO [HANDSHAKE-fbr-jon32-cp2-ora.bc.jonqe.lab.eng.bos.redhat.com/10.16.23.118] 2014-06-04 07:45:00,566 OutboundTcpConnection.java (line 399) Handshaking version with fbr-jon32-cp2-ora.bc.jonqe.lab.eng.bos.redhat.com/10.16.23.118
> INFO [FlushWriter:1] 2014-06-04 07:45:00,596 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/system/peers/system-peers-ic-3-Data.db (12236 bytes) for commitlog position ReplayPosition(segmentId=1401882292340, position=105129)
> INFO [GossipStage:1] 2014-06-04 07:45:00,627 Gossiper.java (line 823) Node /10.16.23.118 is now part of the cluster
> INFO [GossipStage:1] 2014-06-04 07:45:00,631 Gossiper.java (line 789) InetAddress /10.16.23.118 is now UP
> INFO [GossipStage:1] 2014-06-04 07:45:00,723 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-peers@1360589155(10292/10292 serialized/live bytes, 269 ops)
> INFO [FlushWriter:1] 2014-06-04 07:45:00,725 Memtable.java (line 461) Writing Memtable-peers@1360589155(10292/10292 serialized/live bytes, 269 ops)
> INFO [InternalResponseStage:1] 2014-06-04 07:45:00,782 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-schema_keyspaces@1016054829(276/276 serialized/live bytes, 6 ops)
> INFO [main] 2014-06-04 07:45:01,123 StorageService.java (line 914) JOINING: schema complete, ready to bootstrap
> INFO [main] 2014-06-04 07:45:01,124 StorageService.java (line 914) JOINING: getting bootstrap token
> INFO [FlushWriter:1] 2014-06-04 07:45:01,257 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/system/peers/system-peers-ic-4-Data.db (12235 bytes) for commitlog position ReplayPosition(segmentId=1401882292340, position=133134)
> INFO [FlushWriter:1] 2014-06-04 07:45:01,266 Memtable.java (line 461) Writing Memtable-schema_keyspaces@1016054829(276/276 serialized/live bytes, 6 ops)
> INFO [CompactionExecutor:1] 2014-06-04 07:45:01,292 CompactionTask.java (line 105) Compacting [SSTableReader(path='../../../rhq-data/data/system/peers/system-peers-ic-1-Data.db'), SSTableReader(path='../../../rhq-data/data/system/peers/system-peers-ic-3-Data.db'), SSTableReader(path='../../../rhq-data/data/system/peers/system-peers-ic-4-Data.db'), SSTableReader(path='../../../rhq-data/data/system/peers/system-peers-ic-2-Data.db')]
> INFO [main] 2014-06-04 07:45:01,298 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-local@412538209(10142/10142 serialized/live bytes, 259 ops)
> INFO [FlushWriter:1] 2014-06-04 07:45:01,973 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/system/schema_keyspaces/system-schema_keyspaces-ic-2-Data.db (384 bytes) for commitlog position ReplayPosition(segmentId=1401882292340, position=133134)
> INFO [InternalResponseStage:1] 2014-06-04 07:45:01,975 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-schema_columnfamilies@116036509(11580/11580 serialized/live bytes, 189 ops)
> INFO [FlushWriter:1] 2014-06-04 07:45:01,975 Memtable.java (line 461) Writing Memtable-local@412538209(10142/10142 serialized/live bytes, 259 ops)
> INFO [CompactionExecutor:1] 2014-06-04 07:45:02,221 CompactionTask.java (line 262) Compacted 4 sstables to [../../../rhq-data/data/system/peers/system-peers-ic-5,].  48,659 bytes to 48,375 (~99% of original) in 787ms = 0.058620MB/s.  7 total rows, 4 unique.  Row merge counts were {1:1, 2:3, 3:0, 4:0, }
> INFO [FlushWriter:1] 2014-06-04 07:45:02,582 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/system/local/system-local-ic-3-Data.db (12014 bytes) for commitlog position ReplayPosition(segmentId=1401882292340, position=145285)
> INFO [FlushWriter:1] 2014-06-04 07:45:02,583 Memtable.java (line 461) Writing Memtable-schema_columnfamilies@116036509(11580/11580 serialized/live bytes, 189 ops)
> INFO [HANDSHAKE-fbr-jon32-cp2-ora.bc.jonqe.lab.eng.bos.redhat.com/10.16.23.118] 2014-06-04 07:45:02,896 OutboundTcpConnection.java (line 399) Handshaking version with fbr-jon32-cp2-ora.bc.jonqe.lab.eng.bos.redhat.com/10.16.23.118
> INFO [main] 2014-06-04 07:45:03,283 StorageService.java (line 914) JOINING: sleeping 30000 ms for pending range setup
> INFO [FlushWriter:1] 2014-06-04 07:45:03,504 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/system/schema_columnfamilies/system-schema_columnfamilies-ic-2-Data.db (12969 bytes) for commitlog position ReplayPosition(segmentId=1401882292340, position=145285)
> INFO [InternalResponseStage:1] 2014-06-04 07:45:03,506 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-schema_columns@1892272951(1418/1418 serialized/live bytes, 24 ops)
> INFO [FlushWriter:1] 2014-06-04 07:45:03,506 Memtable.java (line 461) Writing Memtable-schema_columns@1892272951(1418/1418 serialized/live bytes, 24 ops)
> INFO [FlushWriter:1] 2014-06-04 07:45:04,168 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/system/schema_columns/system-schema_columns-ic-2-Data.db (1623 bytes) for commitlog position ReplayPosition(segmentId=1401882292340, position=145929)
> INFO [InternalResponseStage:1] 2014-06-04 07:45:04,376 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-schema_keyspaces@1763731159(276/276 serialized/live bytes, 6 ops)
> INFO [FlushWriter:1] 2014-06-04 07:45:04,377 Memtable.java (line 461) Writing Memtable-schema_keyspaces@1763731159(276/276 serialized/live bytes, 6 ops)
> INFO [FlushWriter:1] 2014-06-04 07:45:04,787 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/system/schema_keyspaces/system-schema_keyspaces-ic-3-Data.db (384 bytes) for commitlog position ReplayPosition(segmentId=1401882292340, position=161145)
> INFO [InternalResponseStage:1] 2014-06-04 07:45:04,788 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-schema_columnfamilies@1146848726(11580/11580 serialized/live bytes, 189 ops)
> INFO [FlushWriter:1] 2014-06-04 07:45:04,789 Memtable.java (line 461) Writing Memtable-schema_columnfamilies@1146848726(11580/11580 serialized/live bytes, 189 ops)
> INFO [FlushWriter:1] 2014-06-04 07:45:05,527 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/system/schema_columnfamilies/system-schema_columnfamilies-ic-3-Data.db (12969 bytes) for commitlog position ReplayPosition(segmentId=1401882292340, position=161145)
> INFO [InternalResponseStage:1] 2014-06-04 07:45:05,555 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-schema_columns@253818351(1418/1418 serialized/live bytes, 24 ops)
> INFO [FlushWriter:1] 2014-06-04 07:45:05,556 Memtable.java (line 461) Writing Memtable-schema_columns@253818351(1418/1418 serialized/live bytes, 24 ops)
> INFO [FlushWriter:1] 2014-06-04 07:45:06,005 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/system/schema_columns/system-schema_columns-ic-3-Data.db (1623 bytes) for commitlog position ReplayPosition(segmentId=1401882292340, position=161145)
> INFO [RMI TCP Connection(2)-127.0.0.1] 2014-06-04 07:45:21,129 CounterId.java (line 199) No saved local counter id, using newly generated: b52ecd90-ebdd-11e3-8656-016e9647bf65
> INFO [RMI TCP Connection(2)-127.0.0.1] 2014-06-04 07:45:21,134 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-NodeIdInfo@1667865770(28/28 serialized/live bytes, 1 ops)
> INFO [FlushWriter:1] 2014-06-04 07:45:21,135 Memtable.java (line 461) Writing Memtable-NodeIdInfo@1667865770(28/28 serialized/live bytes, 1 ops)
> INFO [FlushWriter:1] 2014-06-04 07:45:21,283 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/system/NodeIdInfo/system-NodeIdInfo-ic-1-Data.db (66 bytes) for commitlog position ReplayPosition(segmentId=1401882292340, position=162064)
> INFO [main] 2014-06-04 07:45:33,285 StorageService.java (line 914) JOINING: Starting to bootstrap...
> INFO [HANDSHAKE-fbr-jon32-cp2-ora.bc.jonqe.lab.eng.bos.redhat.com/10.16.23.118] 2014-06-04 07:45:33,661 OutboundTcpConnection.java (line 399) Handshaking version with fbr-jon32-cp2-ora.bc.jonqe.lab.eng.bos.redhat.com/10.16.23.118
> INFO [Thread-14] 2014-06-04 07:45:33,697 StreamInSession.java (line 199) Finished streaming session bca64580-ebdd-11e3-8656-016e9647bf65 from /10.16.23.118
> INFO [Thread-19] 2014-06-04 07:45:34,651 StreamInSession.java (line 199) Finished streaming session bca5a940-ebdd-11e3-8656-016e9647bf65 from /10.16.23.185
> INFO [Thread-23] 2014-06-04 07:45:35,480 StreamInSession.java (line 199) Finished streaming session bca64582-ebdd-11e3-8656-016e9647bf65 from /10.16.23.118
> INFO [CompactionExecutor:1] 2014-06-04 07:45:36,478 CompactionTask.java (line 105) Compacting [SSTableReader(path='../../../rhq-data/data/rhq/raw_metrics/rhq-raw_metrics-ic-3-Data.db'), SSTableReader(path='../../../rhq-data/data/rhq/raw_metrics/rhq-raw_metrics-ic-4-Data.db'), SSTableReader(path='../../../rhq-data/data/rhq/raw_metrics/rhq-raw_metrics-ic-2-Data.db'), SSTableReader(path='../../../rhq-data/data/rhq/raw_metrics/rhq-raw_metrics-ic-1-Data.db')]
> INFO [Thread-28] 2014-06-04 07:45:36,481 StreamInSession.java (line 199) Finished streaming session bca64581-ebdd-11e3-8656-016e9647bf65 from /10.16.23.185
> INFO [main] 2014-06-04 07:45:36,486 StorageService.java (line 950) Bootstrap completed! for the tokens [7528935399678358652, -1885529060572592912, 4612837161592916179, 1908502410404323741, -5307558849079064162, -5021734070397103596, -2944090217261736752, 3826373078359292716, 1627482074739735627, 6010495647551161365, -5046710261922927461, -8027974632354418933, 7512715312894771387, -4497902905065697404, -8665602357847562106, -4752695108608558866, -2179033634421425664, -8666384440977783704, 3299894858739504973, 3576587989313071892, 4330839206298396361, 6913282986444214481, 8014362178131261051, -3404848412443971033, 6682136630854350141, -4273389535300490226, 931153372283521846, -7835743907984998538, -941733393305015972, 506210201131476458, -6326587287440671877, 3999172009105390951, -8576598292145400094, 7320514548737479400, 6471518161621116797, 5361277371063689360, 842345542696149247, -4665290837761385911, 3694483324696154174, 8498973053786433783, 5710274686917052285, -2580697435322514196, -7624968271225001451, 3803917770432806483, -4372703435088920675, 3662910103675851538, -3032487110127625307, -5253301157821850568, -1589276359213093400, 6823065189415480067, -3535169520117623820, 6393416274917330874, 7545611119499269995, -2112884835207607028, -4510514766410884547, -6836965526356123675, 2076421817248312134, 1512400836880093260, -6801034420887613725, 8236767134797904572, 2462946234572613277, 2151038458624879227, 6003576082149453877, 5045884244757573071, -7062585207879822959, -1548953922561479847, 4174856754752304884, -5637241117980017477, -8426208536544189324, 8072022807347884973, -97530859149261404, -27212440445804875, -8506537231014939031, 6602443429031643908, -5739204154064313315, 8723153490889018750, -5668902220491367823, 4470619528231640900, -4213983476985928412, -5139024411826005580, -6747637854042513401, 55870997897898021, 2550413196236739184, 3116644553623609460, -6699173125175566921, -6682381321852694661, 3356524194038830876, 8333066483308586568, 8151498723348397475, -3061687227988534045, 6675796317865802091, 2006449884833434465, 1498041874215688251, -1754864700656449710, 1360156432906287928, -1584747357086041509, -6558996462521365767, 5353199329226716701, -796990835464359003, -7359931612810598336, 1563225535795482196, 3325972424355952576, -7877011565587114063, 7453588201497729751, -5074880292274013152, 237235849247558218, -696809077394742795, 3718350618147667922, -4220156944468140589, 6007886143018519947, -5319790775986131072, 3101042498312652185, 6218341329880191364, -5245470893410565903, 1826368013756112204, 8192064302676757411, 4640075363497840015, -3092909577335007615, 7639619385479979855, -7893276173929391515, -398555645081160924, 4772197848340568426, -1309222972239168253, 4994669066718001348, -6889392601356339293, 7317444237678655688, 4159261397743736464, -7141495034999640678, -1096845863013339544, -3825745000588879642, 3684844352464105100, -6056414682464835545, -8820790775769698508, -7088013340891622683, 7369644021310609186, -6756989878652719746, -7805174498732632824, -8926942417894311403, 5996511408358979832, -2898764342624317078, 2372246793319387209, 3595058776326162540, 1442117037042126907, 6828229848897467754, 8445294061058222002, 7006772743629194078, -2908788646327366472, 6880645674337085344, -6358830970642931965, -7753999594005208682, 7926814630925793576, 1273489765280302074, -1424498618964417902, -5654942062064745585, 1442591182562814335, -7293345439234908346, 6203944155284240415, 1626072032002115394, 5443959215149147424, -2285263586071695664, 5001585948720470120, 1420559767668690672, -1163035201543541982, 1865540547485479287, -3597988124901732550, 6973778839169420175, 6687462270034407765, -3615673812048955937, -2237788605612911478, -8385975816894534068, 6733070484597349753, -74129340327377030, -1483343534316308641, -5435123438374458172, 4836818195834752585, 3500718490170534508, 1889991268762707025, -8072870347771902305, 5632807144315702573, -6507879602784785303, 6513350451304464836, 7062878276611345536, -8853432156607646007, 4408368256510599058, -9193272938292187924, 2261238716118511820, -7806418536860372117, -6423574999591452599, -3540733046754247921, -8902694103634189221, 1698347708372506292, -5225285113175689517, -2626904634287416421, 8617054726222212346, -6415134441720620432, 7434290817135352223, -4182177784858397477, 6936642669072991745, -715860220449687445, -3119328199997513429, -6398493039272245521, 1238178871232300374, 7767657467408524656, -5830219839290227050, 4839241387833023884, -7719542224950035057, -1058135865035897997, 3293452185356209402, -3988372215810946750, -5137310001908435265, 2772886365457606744, 8053581782957540641, -4023524194933457104, -3087515397718149987, -3631044257194775369, 4759266133825623173, -2540445297988382405, -3831191535311407266, -7465438524298190084, 7619506701760400107, -7413363345675379997, 3476738756746478150, 5930079748487788921, 6800599744298770916, -3730344433679709185, 1608963845638686233, 1462395898144755931, -3607369789100627103, -4257173323097686270, 1022037303628374048, -8516863925607979468, 2825983014121286992, 7665965392027994406, 8446262386765516572, 3056240008217122043, 3905169143954171378, -931690222522048043, -2130624829946690260, -3561465595867247015, 713503748537797978, 5863534274627848962, -5992264530785033653, 2566153867980218626, 4553436378276753984, -4639643018287681895, -5789607323566107714, 2156140895223007849, -2792513277937215701, 8068322445280056054, 1758012356942936312, 8789580996810797524, 7769916707598261443, 780139003110702257, -7362676064809822686, -6761050546224344902, -6619272250779125814]
> INFO [main] 2014-06-04 07:45:36,489 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-local@6571565(84/84 serialized/live bytes, 6 ops)
> INFO [FlushWriter:1] 2014-06-04 07:45:36,489 Memtable.java (line 461) Writing Memtable-local@6571565(84/84 serialized/live bytes, 6 ops)
> INFO [FlushWriter:1] 2014-06-04 07:45:36,657 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/system/local/system-local-ic-4-Data.db (136 bytes) for commitlog position ReplayPosition(segmentId=1401882292340, position=163973)
> INFO [main] 2014-06-04 07:45:36,699 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-local@1305059121(10101/10101 serialized/live bytes, 257 ops)
> INFO [FlushWriter:1] 2014-06-04 07:45:36,700 Memtable.java (line 461) Writing Memtable-local@1305059121(10101/10101 serialized/live bytes, 257 ops)
> INFO [FlushWriter:1] 2014-06-04 07:45:36,840 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/system/local/system-local-ic-5-Data.db (11966 bytes) for commitlog position ReplayPosition(segmentId=1401882292340, position=175983)
> INFO [main] 2014-06-04 07:45:36,962 StorageService.java (line 1354) Node fbr-jon32-dr1-4.bc.jonqe.lab.eng.bos.redhat.com/10.16.23.104 state jump to normal
> INFO [main] 2014-06-04 07:45:36,971 StorageService.java (line 807) Startup completed! Now serving reads.
> INFO [main] 2014-06-04 07:45:37,248 Server.java (line 138) Starting listening for CQL clients on fbr-jon32-dr1-4.bc.jonqe.lab.eng.bos.redhat.com/10.16.23.104:9142...
> INFO [main] 2014-06-04 07:45:37,297 CassandraDaemon.java (line 402) Not starting RPC server as requested. Use JMX (StorageService->startRPCServer()) or nodetool (enablethrift) to start it
> INFO [CompactionExecutor:1] 2014-06-04 07:45:37,786 CompactionTask.java (line 262) Compacted 4 sstables to [../../../rhq-data/data/rhq/raw_metrics/rhq-raw_metrics-ic-5,].  187,449 bytes to 186,849 (~99% of original) in 1,306ms = 0.136442MB/s.  1,840 total rows, 1,820 unique.  Row merge counts were {1:1800, 2:20, 3:0, 4:0, }
> INFO [CompactionExecutor:1] 2014-06-04 07:45:37,787 CompactionTask.java (line 105) Compacting [SSTableReader(path='../../../rhq-data/data/rhq/one_hour_metrics/rhq-one_hour_metrics-ic-1-Data.db'), SSTableReader(path='../../../rhq-data/data/rhq/one_hour_metrics/rhq-one_hour_metrics-ic-3-Data.db'), SSTableReader(path='../../../rhq-data/data/rhq/one_hour_metrics/rhq-one_hour_metrics-ic-2-Data.db'), SSTableReader(path='../../../rhq-data/data/rhq/one_hour_metrics/rhq-one_hour_metrics-ic-4-Data.db')]
> INFO [CompactionExecutor:1] 2014-06-04 07:45:38,268 CompactionTask.java (line 262) Compacted 4 sstables to [../../../rhq-data/data/rhq/one_hour_metrics/rhq-one_hour_metrics-ic-5,].  71,154 bytes to 70,977 (~99% of original) in 478ms = 0.141609MB/s.  402 total rows, 401 unique.  Row merge counts were {1:400, 2:1, 3:0, 4:0, }
> INFO [MemoryMeter:1] 2014-06-04 07:45:59,728 Memtable.java (line 238) CFS(Keyspace='rhq', ColumnFamily='raw_metrics') liveRatio is 24.7027027027027 (just-counted was 24.7027027027027).  calculation took 67ms for 73 columns
> INFO [MemoryMeter:1] 2014-06-04 07:46:59,752 Memtable.java (line 238) CFS(Keyspace='rhq', ColumnFamily='raw_metrics') liveRatio is 24.33084353885135 (just-counted was 23.958984375).  calculation took 55ms for 128 columns
> INFO [RMI TCP Connection(10)-127.0.0.1] 2014-06-04 07:47:33,740 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-peers@895007031(196/196 serialized/live bytes, 12 ops)
> INFO [FlushWriter:2] 2014-06-04 07:47:33,741 Memtable.java (line 461) Writing Memtable-peers@895007031(196/196 serialized/live bytes, 12 ops)
> INFO [FlushWriter:2] 2014-06-04 07:47:33,991 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/system/peers/system-peers-ic-6-Data.db (275 bytes) for commitlog position ReplayPosition(segmentId=1401882292340, position=191301)
> INFO [RMI TCP Connection(10)-127.0.0.1] 2014-06-04 07:47:34,132 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-raw_metrics@618294183(5120/124573 serialized/live bytes, 160 ops)
> INFO [FlushWriter:2] 2014-06-04 07:47:34,133 Memtable.java (line 461) Writing Memtable-raw_metrics@618294183(5120/124573 serialized/live bytes, 160 ops)
> INFO [FlushWriter:2] 2014-06-04 07:47:34,370 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/rhq/raw_metrics/rhq-raw_metrics-ic-6-Data.db (10680 bytes) for commitlog position ReplayPosition(segmentId=1401882292340, position=191301)
> INFO [GossipStage:1] 2014-06-04 07:47:41,705 Gossiper.java (line 823) Node /10.16.23.114 is now part of the cluster
> INFO [GossipStage:1] 2014-06-04 07:47:41,718 Gossiper.java (line 789) InetAddress /10.16.23.114 is now UP
> INFO [HANDSHAKE-/10.16.23.114] 2014-06-04 07:47:41,718 OutboundTcpConnection.java (line 399) Handshaking version with /10.16.23.114
> INFO [HANDSHAKE-/10.16.23.114] 2014-06-04 07:47:52,952 OutboundTcpConnection.java (line 399) Handshaking version with /10.16.23.114
> INFO [MiscStage:1] 2014-06-04 07:48:15,454 StreamOut.java (line 129) Beginning transfer to /10.16.23.114
> INFO [MiscStage:1] 2014-06-04 07:48:15,457 StreamOut.java (line 104) Flushing memtables for [CFS(Keyspace='system_auth', ColumnFamily='users'), CFS(Keyspace='system_auth', ColumnFamily='credentials'), CFS(Keyspace='system_auth', ColumnFamily='permissions')]...
> INFO [MiscStage:1] 2014-06-04 07:48:15,464 StreamOut.java (line 184) Stream context metadata [], 0 sstables.
> INFO [MiscStage:1] 2014-06-04 07:48:15,464 StreamOutSession.java (line 160) Streaming to /10.16.23.114
> INFO [MiscStage:1] 2014-06-04 07:48:15,472 StreamOut.java (line 129) Beginning transfer to /10.16.23.114
> INFO [MiscStage:1] 2014-06-04 07:48:15,473 StreamOut.java (line 104) Flushing memtables for [CFS(Keyspace='rhq', ColumnFamily='twenty_four_hour_metrics'), CFS(Keyspace='rhq', ColumnFamily='raw_metrics'), CFS(Keyspace='rhq', ColumnFamily='six_hour_metrics'), CFS(Keyspace='rhq', ColumnFamily='metrics_index'), CFS(Keyspace='rhq', ColumnFamily='schema_version'), CFS(Keyspace='rhq', ColumnFamily='one_hour_metrics')]...
> INFO [MiscStage:1] 2014-06-04 07:48:15,474 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-raw_metrics@768499719(1024/24914 serialized/live bytes, 32 ops)
> INFO [FlushWriter:2] 2014-06-04 07:48:15,475 Memtable.java (line 461) Writing Memtable-raw_metrics@768499719(1024/24914 serialized/live bytes, 32 ops)
> INFO [Streaming to /10.16.23.114:1] 2014-06-04 07:48:15,492 FileStreamTask.java (line 102) Finished streaming session to /10.16.23.114
> INFO [FlushWriter:2] 2014-06-04 07:48:15,727 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/rhq/raw_metrics/rhq-raw_metrics-ic-7-Data.db (2208 bytes) for commitlog position ReplayPosition(segmentId=1401882292340, position=196061)
> INFO [MiscStage:1] 2014-06-04 07:48:16,023 StreamOut.java (line 184) Stream context metadata [../../../rhq-data/data/rhq/raw_metrics/rhq-raw_metrics-ic-6-Data.db sections=21 progress=0/2355 - 0%, ../../../rhq-data/data/rhq/raw_metrics/rhq-raw_metrics-ic-7-Data.db sections=5 progress=0/414 - 0%, ../../../rhq-data/data/rhq/raw_metrics/rhq-raw_metrics-ic-5-Data.db sections=62 progress=0/48966 - 0%, ../../../rhq-data/data/rhq/metrics_index/rhq-metrics_index-ic-1-Data.db sections=1 progress=0/151 - 0%, ../../../rhq-data/data/rhq/metrics_index/rhq-metrics_index-ic-2-Data.db sections=1 progress=0/12596 - 0%, ../../../rhq-data/data/rhq/metrics_index/rhq-metrics_index-ic-3-Data.db sections=1 progress=0/151 - 0%, ../../../rhq-data/data/rhq/one_hour_metrics/rhq-one_hour_metrics-ic-5-Data.db sections=40 progress=0/19824 - 0%], 7 sstables.
> INFO [MiscStage:1] 2014-06-04 07:48:16,023 StreamOutSession.java (line 160) Streaming to /10.16.23.114
> INFO [Streaming to /10.16.23.114:1] 2014-06-04 07:48:16,354 StreamReplyVerbHandler.java (line 44) Successfully sent ../../../rhq-data/data/rhq/one_hour_metrics/rhq-one_hour_metrics-ic-5-Data.db to /10.16.23.114
> INFO [Streaming to /10.16.23.114:1] 2014-06-04 07:48:17,231 StreamReplyVerbHandler.java (line 44) Successfully sent ../../../rhq-data/data/rhq/raw_metrics/rhq-raw_metrics-ic-5-Data.db to /10.16.23.114
> INFO [Streaming to /10.16.23.114:1] 2014-06-04 07:48:17,894 StreamReplyVerbHandler.java (line 44) Successfully sent ../../../rhq-data/data/rhq/metrics_index/rhq-metrics_index-ic-1-Data.db to /10.16.23.114
> INFO [Streaming to /10.16.23.114:1] 2014-06-04 07:48:18,211 StreamReplyVerbHandler.java (line 44) Successfully sent ../../../rhq-data/data/rhq/raw_metrics/rhq-raw_metrics-ic-6-Data.db to /10.16.23.114
> INFO [Streaming to /10.16.23.114:1] 2014-06-04 07:48:18,481 StreamReplyVerbHandler.java (line 44) Successfully sent ../../../rhq-data/data/rhq/raw_metrics/rhq-raw_metrics-ic-7-Data.db to /10.16.23.114
> INFO [Streaming to /10.16.23.114:1] 2014-06-04 07:48:18,696 StreamReplyVerbHandler.java (line 44) Successfully sent ../../../rhq-data/data/rhq/metrics_index/rhq-metrics_index-ic-3-Data.db to /10.16.23.114
> INFO [Streaming to /10.16.23.114:1] 2014-06-04 07:48:19,001 StreamReplyVerbHandler.java (line 44) Successfully sent ../../../rhq-data/data/rhq/metrics_index/rhq-metrics_index-ic-2-Data.db to /10.16.23.114
> INFO [Streaming to /10.16.23.114:1] 2014-06-04 07:48:19,009 FileStreamTask.java (line 102) Finished streaming session to /10.16.23.114
> INFO [GossipStage:1] 2014-06-04 07:48:20,731 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-peers@83577910(10290/10290 serialized/live bytes, 275 ops)
> INFO [FlushWriter:2] 2014-06-04 07:48:20,741 Memtable.java (line 461) Writing Memtable-peers@83577910(10290/10290 serialized/live bytes, 275 ops)
> INFO [FlushWriter:2] 2014-06-04 07:48:21,083 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/system/peers/system-peers-ic-7-Data.db (12196 bytes) for commitlog position ReplayPosition(segmentId=1401882292340, position=208074)
> INFO [CompactionExecutor:2] 2014-06-04 07:48:22,168 CompactionManager.java (line 587) Cleaning up SSTableReader(path='../../../rhq-data/data/rhq/raw_metrics/rhq-raw_metrics-ic-7-Data.db')
> INFO [CompactionExecutor:2] 2014-06-04 07:48:22,424 CompactionManager.java (line 680) Cleaned up to ../../../rhq-data/data/rhq/raw_metrics/rhq-raw_metrics-tmp-ic-8-Data.db.  2,208 to 1,794 (~81% of original) bytes for 26 keys.  Time: 255ms.
> INFO [CompactionExecutor:2] 2014-06-04 07:48:22,431 CompactionManager.java (line 587) Cleaning up SSTableReader(path='../../../rhq-data/data/rhq/raw_metrics/rhq-raw_metrics-ic-6-Data.db')
> INFO [CompactionExecutor:2] 2014-06-04 07:48:22,630 CompactionManager.java (line 680) Cleaned up to ../../../rhq-data/data/rhq/raw_metrics/rhq-raw_metrics-tmp-ic-9-Data.db.  10,680 to 8,877 (~83% of original) bytes for 123 keys.  Time: 199ms.
> INFO [CompactionExecutor:2] 2014-06-04 07:48:22,631 CompactionManager.java (line 587) Cleaning up SSTableReader(path='../../../rhq-data/data/rhq/raw_metrics/rhq-raw_metrics-ic-5-Data.db')
> INFO [CompactionExecutor:2] 2014-06-04 07:48:23,459 CompactionManager.java (line 680) Cleaned up to ../../../rhq-data/data/rhq/raw_metrics/rhq-raw_metrics-tmp-ic-10-Data.db.  186,849 to 160,614 (~85% of original) bytes for 1,576 keys.  Time: 828ms.
> INFO [CompactionExecutor:2] 2014-06-04 07:48:23,465 CompactionManager.java (line 587) Cleaning up SSTableReader(path='../../../rhq-data/data/rhq/metrics_index/rhq-metrics_index-ic-3-Data.db')
> INFO [CompactionExecutor:2] 2014-06-04 07:48:23,936 CompactionManager.java (line 680) Cleaned up to ../../../rhq-data/data/rhq/metrics_index/rhq-metrics_index-tmp-ic-4-Data.db.  151 to 151 (~100% of original) bytes for 1 keys.  Time: 471ms.
> INFO [CompactionExecutor:2] 2014-06-04 07:48:23,937 CompactionManager.java (line 587) Cleaning up SSTableReader(path='../../../rhq-data/data/rhq/metrics_index/rhq-metrics_index-ic-1-Data.db')
> INFO [CompactionExecutor:2] 2014-06-04 07:48:24,270 CompactionManager.java (line 680) Cleaned up to ../../../rhq-data/data/rhq/metrics_index/rhq-metrics_index-tmp-ic-5-Data.db.  151 to 151 (~100% of original) bytes for 1 keys.  Time: 333ms.
> INFO [CompactionExecutor:2] 2014-06-04 07:48:24,272 CompactionManager.java (line 587) Cleaning up SSTableReader(path='../../../rhq-data/data/rhq/metrics_index/rhq-metrics_index-ic-2-Data.db')
> INFO [CompactionExecutor:2] 2014-06-04 07:48:24,710 CompactionManager.java (line 680) Cleaned up to ../../../rhq-data/data/rhq/metrics_index/rhq-metrics_index-tmp-ic-6-Data.db.  12,596 to 12,596 (~100% of original) bytes for 1 keys.  Time: 437ms.
> INFO [CompactionExecutor:2] 2014-06-04 07:48:24,716 CompactionManager.java (line 587) Cleaning up SSTableReader(path='../../../rhq-data/data/rhq/one_hour_metrics/rhq-one_hour_metrics-ic-5-Data.db')
> INFO [CompactionExecutor:2] 2014-06-04 07:48:25,077 CompactionManager.java (line 680) Cleaned up to ../../../rhq-data/data/rhq/one_hour_metrics/rhq-one_hour_metrics-tmp-ic-6-Data.db.  70,977 to 61,419 (~86% of original) bytes for 347 keys.  Time: 361ms.
> INFO [MemoryMeter:1] 2014-06-04 07:49:30,993 Memtable.java (line 238) CFS(Keyspace='rhq', ColumnFamily='raw_metrics') liveRatio is 23.914066021052573 (just-counted was 23.497288503253795).  calculation took 1319ms for 434 columns
> INFO [CompactionExecutor:3] 2014-06-04 07:49:52,568 CompactionTask.java (line 105) Compacting [SSTableReader(path='../../../rhq-data/data/system/local/system-local-ic-4-Data.db'), SSTableReader(path='../../../rhq-data/data/system/local/system-local-ic-1-Data.db'), SSTableReader(path='../../../rhq-data/data/system/local/system-local-ic-5-Data.db'), SSTableReader(path='../../../rhq-data/data/system/local/system-local-ic-2-Data.db'), SSTableReader(path='../../../rhq-data/data/system/local/system-local-ic-3-Data.db')]
> INFO [CompactionExecutor:3] 2014-06-04 07:49:52,866 CompactionTask.java (line 262) Compacted 5 sstables to [../../../rhq-data/data/system/local/system-local-ic-6,].  24,714 bytes to 12,381 (~50% of original) in 293ms = 0.040298MB/s.  5 total rows, 1 unique.  Row merge counts were {1:0, 2:0, 3:0, 4:0, 5:1, }
> INFO [Thread-38] 2014-06-04 07:51:18,776 StreamInSession.java (line 199) Finished streaming session 8a59b9d0-ebde-11e3-9bf0-d510b7ea131b from /10.16.23.156
> INFO [Thread-42] 2014-06-04 07:51:20,797 StreamInSession.java (line 199) Finished streaming session 8ac35110-ebde-11e3-9bf0-d510b7ea131b from /10.16.23.156
> INFO [CompactionExecutor:4] 2014-06-04 07:51:20,799 CompactionTask.java (line 105) Compacting [SSTableReader(path='../../../rhq-data/data/rhq/raw_metrics/rhq-raw_metrics-ic-9-Data.db'), SSTableReader(path='../../../rhq-data/data/rhq/raw_metrics/rhq-raw_metrics-ic-13-Data.db'), SSTableReader(path='../../../rhq-data/data/rhq/raw_metrics/rhq-raw_metrics-ic-10-Data.db'), SSTableReader(path='../../../rhq-data/data/rhq/raw_metrics/rhq-raw_metrics-ic-12-Data.db'), SSTableReader(path='../../../rhq-data/data/rhq/raw_metrics/rhq-raw_metrics-ic-8-Data.db'), SSTableReader(path='../../../rhq-data/data/rhq/raw_metrics/rhq-raw_metrics-ic-11-Data.db')]
> INFO [CompactionExecutor:4] 2014-06-04 07:51:21,503 CompactionTask.java (line 262) Compacted 6 sstables to [../../../rhq-data/data/rhq/raw_metrics/rhq-raw_metrics-ic-14,].  209,214 bytes to 203,511 (~97% of original) in 700ms = 0.277262MB/s.  2,130 total rows, 1,962 unique.  Row merge counts were {1:1800, 2:156, 3:6, 4:0, 5:0, 6:0, }
> INFO [GossipStage:1] 2014-06-04 07:51:22,816 StorageService.java (line 1614) Removing tokens [-1022584735940986427, -104136052073498212, -1061073469452654534, -1165964198736718470, -1201624040321892503, -1203974454070627403, -1244064490148879837, -1321752915490246255, -1363076223888593931, -1536927960926168040, -1566670144295117038, -2005192915365238093, -2073779608634606195, -2124048255011658025, -2193045448392719622, -219493185733327425, -2197194934863192485, -2237705698787126717, -2284606837797266630, -2334903258296959833, -235748713744950324, -2418873867522466337, -2447215388367460759, -2586391611478512640, -2737287575466758981, -2741417634536182348, -276757392879066470, -2854670016797295247, -2862416364588024027, -2899157720031185303, -2916082967468158317, -2955301555894789684, -2974936494053390197, -307195003915351531, -3081455797784661792, -3096426661492721029, -3114339936990333527, -315451658519164126, -3166002923983472168, -3185748772963240017, -325579154596690002, -3268409817730295015, -3329131072195944792, -3415574208470841621, -3607628665141504924, -3671574823391905410, -369008743640146921, -3757697780333711786, -3795704765332567685, -3811614712174758068, -3845623944366795093, -3902393746991508292, -3980391845812396201, -4086399637548241453, -4195137083364852170, -4479511024549315174, -4513245785929309438, -453374051811220378, -4688502150827892448, -4743544430323851962, -481747239977609752, -4904751335684237519, -5146260621012219228, -5243536897213434528, -5250317964443821880, -5274224593243705727, -5277098660317439120, -5281849457100752370, -5327849978677434687, -5534505294129653387, -5594615768063649546, -5604559921579266214, -5711358755832377551, -5835593533496467677, -5890412924803006573, -5928273125051732242, -6060636616540141166, -6082441002860663607, -6240738499079205980, -6259788088682125126, -6636763174151370555, -6798041551333376973, -6804458411982140997, -6854596335306295636, -6868076519339523433, -6904031830319291375, -7115135322269241010, -7147100225108251925, -7220584935230528840, -7257468308462773532, -7305001793361872336, -7341184275393557277, -7411613263348025141, -7484412967257670874, -7584864213149331563, -7607130075401428824, -7614246909910348601, -7615181932283935710, -7623734069233914575, -7647630267546512181, -7695573772867114998, -7711360568886101583, -7750301788827847082, -7776703630713316215, -7787765753586295660, -7795631299042909334, -793592554587396011, -8001694124697223469, -804338404736601059, -8104691205762249743, -8180442632362164386, -8274395421547067476, -8322831560248990040, -8348957873155224452, -8485540230697923253, -8587960738608114311, -8597246481817558601, -8598593806352381492, -8623682699722288984, -8672032492246585550, -8763642954667607682, -8775266501622033155, -8859567908228525560, -89442947675301120, -8991054881258680604, -9025563659324894211, -970392287812529583, 1008642560922027395, 1014756042980621233, 104603155208828746, 1078600105927916678, 1079929879049235216, 1224099754847301941, 1305099957218355950, 1310660702409925713, 1329446955166230492, 1458271638187032959, 1467245238766265137, 1587609914574032149, 1599855420471490676, 1637888130068840705, 1642029216131363586, 1644143836093495501, 1662479080682788944, 1818788745559893689, 1888827941089389093, 1980275153197639290, 2098396679988948156, 2098531092720881181, 2099715943232963088, 2171897236834241295, 2181566073788813550, 2316569727041986248, 232668124234441418, 2407937669611363415, 2472823524646951746, 249583389409981697, 2665102008187342356, 2732193743537077638, 2781086548426863632, 2783208435481608153, 2830213490326195204, 2855013474233038529, 2865786810072864199, 2991212135868924320, 2996100920913155309, 3129753043649354996, 321733328457255277, 3567527617612409890, 3580123040168924731, 3663113229780024993, 3681518825091597326, 3694718057228833686, 3714345495404047077, 3718385067387543895, 3786778696821356526, 3834330374163904643, 3853998630634703481, 4001582362494838336, 4053512727327196618, 4100633627313257111, 4153844654587232446, 4180504919084504362, 4413070504868965518, 448331891072749947, 4494597593556894481, 4517026012454595883, 4557579278614571198, 4770059538707208371, 4870051499601508776, 4875223929035603122, 4973258471626813791, 5061457393754603993, 5108828905177159945, 5142850523358673715, 5282912280391503534, 5428922976146830100, 5477154606079186849, 5487427841579676824, 5488123737595882417, 5667600287333082626, 5668861532301649505, 5785222122247876688, 5788756075523073134, 5826941453247039716, 5850929418232286219, 5984659744976687641, 5985473054231321072, 6002699667565377492, 6044957872730545542, 6108770838056585609, 6209704580848081248, 6290680165194142475, 6324679604472252457, 6366486701479241813, 6471098366070906150, 6741099215279897920, 6845824350330120169, 6854152785897192911, 6862881251158259194, 6871895219952764263, 6907522219915257455, 6933492319498450196, 6936539223767862776, 7422330388923646219, 7441535451597408554, 7474419518053706347, 754916295423368333, 755271285383954862, 7554431678897354409, 7615284980943115022, 7671710443571845876, 7823550215549147406, 7828720895387597930, 7990215838094618269, 8058609083008966429, 8108773073233318422, 8146636366957864822, 8184857874152628655, 820728713579399839, 8365166687716718012, 8396061478329337659, 8464450992145966231, 8567015749793321858, 8575839719378632332, 8597062935219937397, 8597408557170909489, 8601356076241450284, 8755177749563275532, 8916802361174257319, 89373768228458876, 8948579655903364940, 8953870902994861346, 9002074245016058655, 9019358340240401737, 9166261336550720725] for /10.16.23.156
> INFO [OptionalTasks:1] 2014-06-04 07:51:22,819 HintedHandOffManager.java (line 177) Deleting any stored hints for /10.16.23.156
> INFO [OptionalTasks:1] 2014-06-04 07:51:22,819 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-hints@1403146854(0/0 serialized/live bytes, 1 ops)
> INFO [GossipStage:1] 2014-06-04 07:51:22,821 Gossiper.java (line 299) removed /10.16.23.156 from seeds, updated seeds list = [fbr-jon32-cp2-ora.bc.jonqe.lab.eng.bos.redhat.com/10.16.23.118, fbr-jon32-dr1-2.bc.jonqe.lab.eng.bos.redhat.com/10.16.23.185, fbr-jon32-dr1-3.bc.jonqe.lab.eng.bos.redhat.com/10.16.23.63]
> INFO [FlushWriter:3] 2014-06-04 07:51:22,825 Memtable.java (line 461) Writing Memtable-hints@1403146854(0/0 serialized/live bytes, 1 ops)
> INFO [GossipStage:1] 2014-06-04 07:51:22,827 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-peers@513234841(0/0 serialized/live bytes, 1 ops)
> INFO [HANDSHAKE-/10.16.23.156] 2014-06-04 07:51:22,954 OutboundTcpConnection.java (line 399) Handshaking version with /10.16.23.156
> INFO [FlushWriter:3] 2014-06-04 07:51:23,094 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/system/hints/system-hints-ic-1-Data.db (42 bytes) for commitlog position ReplayPosition(segmentId=1401882292340, position=286749)
> INFO [CompactionExecutor:4] 2014-06-04 07:51:23,096 CompactionTask.java (line 105) Compacting [SSTableReader(path='../../../rhq-data/data/system/hints/system-hints-ic-1-Data.db')]
> INFO [FlushWriter:3] 2014-06-04 07:51:23,101 Memtable.java (line 461) Writing Memtable-peers@513234841(0/0 serialized/live bytes, 1 ops)
> INFO [CompactionExecutor:4] 2014-06-04 07:51:23,200 CompactionTask.java (line 262) Compacted 1 sstables to [].  42 bytes to 0 (~0% of original) in 101ms = 0.000000MB/s.  1 total rows, 0 unique.  Row merge counts were {1:1, }
> INFO [FlushWriter:3] 2014-06-04 07:51:23,343 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/system/peers/system-peers-ic-8-Data.db (30 bytes) for commitlog position ReplayPosition(segmentId=1401882292340, position=286824)
> INFO [CompactionExecutor:4] 2014-06-04 07:51:23,347 CompactionTask.java (line 105) Compacting [SSTableReader(path='../../../rhq-data/data/system/peers/system-peers-ic-6-Data.db'), SSTableReader(path='../../../rhq-data/data/system/peers/system-peers-ic-5-Data.db'), SSTableReader(path='../../../rhq-data/data/system/peers/system-peers-ic-8-Data.db'), SSTableReader(path='../../../rhq-data/data/system/peers/system-peers-ic-7-Data.db')]
> INFO [CompactionExecutor:4] 2014-06-04 07:51:23,561 CompactionTask.java (line 262) Compacted 4 sstables to [../../../rhq-data/data/system/peers/system-peers-ic-9,].  60,876 bytes to 48,610 (~79% of original) in 213ms = 0.217644MB/s.  7 total rows, 4 unique.  Row merge counts were {1:3, 2:2, 3:0, 4:0, }
> INFO [CompactionExecutor:4] 2014-06-04 07:52:04,488 CompactionManager.java (line 587) Cleaning up SSTableReader(path='../../../rhq-data/data/rhq/raw_metrics/rhq-raw_metrics-ic-14-Data.db')
> INFO [CompactionExecutor:4] 2014-06-04 07:52:05,346 CompactionManager.java (line 680) Cleaned up to ../../../rhq-data/data/rhq/raw_metrics/rhq-raw_metrics-tmp-ic-15-Data.db.  203,511 to 203,511 (~100% of original) bytes for 1,962 keys.  Time: 858ms.
> INFO [CompactionExecutor:4] 2014-06-04 07:52:05,351 CompactionManager.java (line 587) Cleaning up SSTableReader(path='../../../rhq-data/data/rhq/metrics_index/rhq-metrics_index-ic-4-Data.db')
> INFO [CompactionExecutor:4] 2014-06-04 07:52:05,530 CompactionManager.java (line 680) Cleaned up to ../../../rhq-data/data/rhq/metrics_index/rhq-metrics_index-tmp-ic-7-Data.db.  151 to 151 (~100% of original) bytes for 1 keys.  Time: 179ms.
> INFO [CompactionExecutor:4] 2014-06-04 07:52:05,533 CompactionManager.java (line 587) Cleaning up SSTableReader(path='../../../rhq-data/data/rhq/metrics_index/rhq-metrics_index-ic-5-Data.db')
> INFO [CompactionExecutor:4] 2014-06-04 07:52:05,852 CompactionManager.java (line 680) Cleaned up to ../../../rhq-data/data/rhq/metrics_index/rhq-metrics_index-tmp-ic-8-Data.db.  151 to 151 (~100% of original) bytes for 1 keys.  Time: 319ms.
> INFO [CompactionExecutor:4] 2014-06-04 07:52:05,854 CompactionManager.java (line 587) Cleaning up SSTableReader(path='../../../rhq-data/data/rhq/metrics_index/rhq-metrics_index-ic-6-Data.db')
> INFO [CompactionExecutor:4] 2014-06-04 07:52:06,045 CompactionManager.java (line 680) Cleaned up to ../../../rhq-data/data/rhq/metrics_index/rhq-metrics_index-tmp-ic-9-Data.db.  12,596 to 12,596 (~100% of original) bytes for 1 keys.  Time: 190ms.
> INFO [CompactionExecutor:4] 2014-06-04 07:52:06,049 CompactionManager.java (line 587) Cleaning up SSTableReader(path='../../../rhq-data/data/rhq/one_hour_metrics/rhq-one_hour_metrics-ic-7-Data.db')
> INFO [CompactionExecutor:4] 2014-06-04 07:52:06,260 CompactionManager.java (line 680) Cleaned up to ../../../rhq-data/data/rhq/one_hour_metrics/rhq-one_hour_metrics-tmp-ic-8-Data.db.  9,027 to 9,027 (~100% of original) bytes for 51 keys.  Time: 211ms.
> INFO [CompactionExecutor:4] 2014-06-04 07:52:06,262 CompactionManager.java (line 587) Cleaning up SSTableReader(path='../../../rhq-data/data/rhq/one_hour_metrics/rhq-one_hour_metrics-ic-6-Data.db')
> INFO [CompactionExecutor:4] 2014-06-04 07:52:06,480 CompactionManager.java (line 680) Cleaned up to ../../../rhq-data/data/rhq/one_hour_metrics/rhq-one_hour_metrics-tmp-ic-9-Data.db.  61,419 to 61,419 (~100% of original) bytes for 347 keys.  Time: 218ms.
> INFO [RMI TCP Connection(19)-127.0.0.1] 2014-06-04 07:52:15,980 ColumnFamilyStore.java (line 629) Enqueuing flush of Memtable-raw_metrics@1873849919(25728/615261 serialized/live bytes, 804 ops)
> INFO [FlushWriter:3] 2014-06-04 07:52:15,981 Memtable.java (line 461) Writing Memtable-raw_metrics@1873849919(25728/615261 serialized/live bytes, 804 ops)
> INFO [FlushWriter:3] 2014-06-04 07:52:16,297 Memtable.java (line 495) Completed flushing ../../../rhq-data/data/rhq/raw_metrics/rhq-raw_metrics-ic-16-Data.db (54726 bytes) for commitlog position ReplayPosition(segmentId=1401882292340, position=297480)
> INFO [MemoryMeter:1] 2014-06-04 07:52:29,687 Memtable.java (line 238) CFS(Keyspace='rhq', ColumnFamily='raw_metrics') liveRatio is 25.053571428571427 (just-counted was 25.053571428571427).  calculation took 2ms for 28 columns
> INFO [HANDSHAKE-fbr-jon32-dr1-4.bc.jonqe.lab.eng.bos.redhat.com/10.16.23.104] 2014-06-04 08:00:04,254 OutboundTcpConnection.java (line 399) Handshaking version with fbr-jon32-dr1-4.bc.jonqe.lab.eng.bos.redhat.com/10.16.23.104
> INFO [HANDSHAKE-fbr-jon32-dr1-4.bc.jonqe.lab.eng.bos.redhat.com/10.16.23.104] 2014-06-04 08:00:04,261 OutboundTcpConnection.java (line 399) Handshaking version with fbr-jon32-dr1-4.bc.jonqe.lab.eng.bos.redhat.com/10.16.23.104
> INFO [MemoryMeter:1] 2014-06-04 08:00:13,413 Memtable.java (line 238) CFS(Keyspace='rhq', ColumnFamily='one_hour_metrics') liveRatio is 11.757575757575758 (just-counted was 11.757575757575758).  calculation took 10ms for 64 columns
> INFO [MemoryMeter:1] 2014-06-04 08:00:13,640 Memtable.java (line 238) CFS(Keyspace='rhq', ColumnFamily='one_hour_metrics') liveRatio is 11.79233798782671 (just-counted was 11.79233798782671).  calculation took 14ms for 132 columns
> INFO [MemoryMeter:1] 2014-06-04 08:00:14,123 Memtable.java (line 238) CFS(Keyspace='rhq', ColumnFamily='one_hour_metrics') liveRatio is 11.748098086718361 (just-counted was 11.703858185610011).  calculation took 48ms for 270 columns
> INFO [MemoryMeter:1] 2014-06-04 08:00:14,939 Memtable.java (line 238) CFS(Keyspace='rhq', ColumnFamily='one_hour_metrics') liveRatio is 11.875217909899991 (just-counted was 11.875217909899991).  calculation took 18ms for 519 columns
> INFO [MemoryMeter:1] 2014-06-04 08:00:16,750 Memtable.java (line 238) CFS(Keyspace='rhq', ColumnFamily='one_hour_metrics') liveRatio is 11.835910911391487 (just-counted was 11.796603912882983).  calculation took 46ms for 1024 columns
> INFO [MemoryMeter:1] 2014-06-04 08:00:20,148 Memtable.java (line 238) CFS(Keyspace='rhq', ColumnFamily='one_hour_metrics') liveRatio is 11.736678399418686 (just-counted was 11.637445887445887).  calculation took 194ms for 2070 columns
> INFO [MemoryMeter:1] 2014-06-04 08:00:25,613 Memtable.java (line 238) CFS(Keyspace='rhq', ColumnFamily='one_hour_metrics') liveRatio is 11.810349971313826 (just-counted was 11.810349971313826).  calculation took 144ms for 4128 columns
> INFO [MemoryMeter:1] 2014-06-04 08:00:34,996 Memtable.java (line 238) CFS(Keyspace='rhq', ColumnFamily='metrics_index') liveRatio is 12.458333333333334 (just-counted was 12.458333333333334).  calculation took 1ms for 64 columns
> INFO [MemoryMeter:1] 2014-06-04 08:00:35,074 Memtable.java (line 238) CFS(Keyspace='rhq', ColumnFamily='metrics_index') liveRatio is 12.010416666666668 (just-counted was 11.5625).  calculation took 0ms for 128 columns
> INFO [MemoryMeter:1] 2014-06-04 08:00:35,262 Memtable.java (line 238) CFS(Keyspace='rhq', ColumnFamily='metrics_index') liveRatio is 11.519420219638244 (just-counted was 11.02842377260982).  calculation took 2ms for 258 columns
> INFO [MemoryMeter:1] 2014-06-04 08:00:35,603 Memtable.java (line 238) CFS(Keyspace='rhq', ColumnFamily='metrics_index') liveRatio is 11.19440796556961 (just-counted was 10.869395711500974).  calculation took 2ms for 513 columns
> INFO [MemoryMeter:1] 2014-06-04 08:00:36,278 Memtable.java (line 238) CFS(Keyspace='rhq', ColumnFamily='metrics_index') liveRatio is 10.986526899451473 (just-counted was 10.778645833333334).  calculation took 4ms for 1024 columns
> INFO [MemoryMeter:1] 2014-06-04 08:00:37,554 Memtable.java (line 238) CFS(Keyspace='rhq', ColumnFamily='metrics_index') liveRatio is 10.846749554065083 (just-counted was 10.706972208678692).  calculation took 8ms for 2051 columns
> INFO [MemoryMeter:1] 2014-06-04 08:00:40,181 Memtable.java (line 238) CFS(Keyspace='rhq', ColumnFamily='metrics_index') liveRatio is 10.74601552227353 (just-counted was 10.645281490481976).  calculation took 43ms for 4115 columns
> INFO [MemoryMeter:1] 2014-06-04 08:03:29,844 Memtable.java (line 238) CFS(Keyspace='rhq', ColumnFamily='raw_metrics') liveRatio is 23.88607594936709 (just-counted was 22.71858047016275).  calculation took 120ms for 1092 columns
> INFO [MemoryMeter:1] 2014-06-04 08:10:59,694 Memtable.java (line 238) CFS(Keyspace='rhq', ColumnFamily='metrics_index') liveRatio is 10.715442630876243 (just-counted was 10.684869739478957).  calculation took 28ms for 7984 columns
> INFO [MemoryMeter:1] 2014-06-04 08:12:18,491 Memtable.java (line 238) CFS(Keyspace='rhq', ColumnFamily='raw_metrics') liveRatio is 23.550238361281483 (just-counted was 23.214400773195877).  calculation took 129ms for 3104 columns

Actions: View

Attachments on bug 1104647: 902165 | 902166