You are viewing a plain text version of this content. The canonical link for it is here.
Posted to commits@cassandra.apache.org by "Blake Eggleston (JIRA)" <ji...@apache.org> on 2017/02/22 18:19:44 UTC

[jira] [Assigned] (CASSANDRA-13248) testall failure in org.apache.cassandra.db.compaction.PendingRepairManagerTest.userDefinedTaskTest

     [ https://issues.apache.org/jira/browse/CASSANDRA-13248?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel ]

Blake Eggleston reassigned CASSANDRA-13248:
-------------------------------------------

    Assignee: Blake Eggleston

> testall failure in org.apache.cassandra.db.compaction.PendingRepairManagerTest.userDefinedTaskTest
> --------------------------------------------------------------------------------------------------
>
>                 Key: CASSANDRA-13248
>                 URL: https://issues.apache.org/jira/browse/CASSANDRA-13248
>             Project: Cassandra
>          Issue Type: Bug
>          Components: Testing
>            Reporter: Sean McCarthy
>            Assignee: Blake Eggleston
>              Labels: test-failure, testall
>         Attachments: TEST-org.apache.cassandra.db.compaction.PendingRepairManagerTest.log
>
>
> example failure:
> http://cassci.datastax.com/job/trunk_testall/1416/testReport/org.apache.cassandra.db.compaction/PendingRepairManagerTest/userDefinedTaskTest
> {code}
> Error Message
> expected:<1> but was:<0>
> {code}{code}
> Stacktrace
> junit.framework.AssertionFailedError: expected:<1> but was:<0>
> 	at org.apache.cassandra.db.compaction.PendingRepairManagerTest.userDefinedTaskTest(PendingRepairManagerTest.java:194)
> {code}{code}
> Standard Output
> ERROR [main] 2017-02-21 17:00:01,792 ?:? - SLF4J: stderr
> INFO  [main] 2017-02-21 17:00:02,001 ?:? - Configuration location: file:/home/automaton/cassandra/test/conf/cassandra.yaml
> DEBUG [main] 2017-02-21 17:00:02,002 ?:? - Loading settings from file:/home/automaton/cassandra/test/conf/cassandra.yaml
> INFO  [main] 2017-02-21 17:00:02,530 ?:? - Node configuration:[allocate_tokens_for_keyspace=null; authenticator=null; authorizer=null; auto_bootstrap=true; auto_snapshot=true; back_pressure_enabled=false; back_pressure_strategy=null; batch_size_fail_threshold_in_kb=50; batch_size_warn_threshold_in_kb=5; batchlog_replay_throttle_in_kb=1024; broadcast_address=null; broadcast_rpc_address=null; buffer_pool_use_heap_if_exhausted=true; cas_contention_timeout_in_ms=1000; cdc_enabled=false; cdc_free_space_check_interval_ms=250; cdc_raw_directory=build/test/cassandra/cdc_raw:165; cdc_total_space_in_mb=0; client_encryption_options=<REDACTED>; cluster_name=Test Cluster; column_index_cache_size_in_kb=2; column_index_size_in_kb=4; commit_failure_policy=stop; commitlog_compression=null; commitlog_directory=build/test/cassandra/commitlog:165; commitlog_max_compression_buffers_in_pool=3; commitlog_periodic_queue_size=-1; commitlog_segment_size_in_mb=5; commitlog_sync=batch; commitlog_sync_batch_window_in_ms=1.0; commitlog_sync_period_in_ms=0; commitlog_total_space_in_mb=null; compaction_large_partition_warning_threshold_mb=100; compaction_throughput_mb_per_sec=0; concurrent_compactors=4; concurrent_counter_writes=32; concurrent_materialized_view_writes=32; concurrent_reads=32; concurrent_replicates=null; concurrent_writes=32; counter_cache_keys_to_save=2147483647; counter_cache_save_period=7200; counter_cache_size_in_mb=null; counter_write_request_timeout_in_ms=5000; credentials_cache_max_entries=1000; credentials_update_interval_in_ms=-1; credentials_validity_in_ms=2000; cross_node_timeout=false; data_file_directories=[Ljava.lang.String;@1757cd72; disk_access_mode=mmap; disk_failure_policy=ignore; disk_optimization_estimate_percentile=0.95; disk_optimization_page_cross_chance=0.1; disk_optimization_strategy=ssd; dynamic_snitch=true; dynamic_snitch_badness_threshold=0.1; dynamic_snitch_reset_interval_in_ms=600000; dynamic_snitch_update_interval_in_ms=100; enable_scripted_user_defined_functions=true; enable_user_defined_functions=true; enable_user_defined_functions_threads=true; encryption_options=null; endpoint_snitch=org.apache.cassandra.locator.SimpleSnitch; file_cache_size_in_mb=null; gc_log_threshold_in_ms=200; gc_warn_threshold_in_ms=0; hinted_handoff_disabled_datacenters=[]; hinted_handoff_enabled=true; hinted_handoff_throttle_in_kb=1024; hints_compression=null; hints_directory=build/test/cassandra/hints:165; hints_flush_period_in_ms=10000; incremental_backups=true; index_interval=null; index_summary_capacity_in_mb=null; index_summary_resize_interval_in_minutes=60; initial_token=null; inter_dc_stream_throughput_outbound_megabits_per_sec=200; inter_dc_tcp_nodelay=true; internode_authenticator=null; internode_compression=none; internode_recv_buff_size_in_bytes=0; internode_send_buff_size_in_bytes=0; key_cache_keys_to_save=2147483647; key_cache_save_period=14400; key_cache_size_in_mb=null; listen_address=127.0.0.1; listen_interface=null; listen_interface_prefer_ipv6=false; listen_on_broadcast_address=false; max_hint_window_in_ms=10800000; max_hints_delivery_threads=2; max_hints_file_size_in_mb=128; max_mutation_size_in_kb=null; max_streaming_retries=3; max_value_size_in_mb=256; memtable_allocation_type=offheap_objects; memtable_cleanup_threshold=null; memtable_flush_writers=0; memtable_heap_space_in_mb=null; memtable_offheap_space_in_mb=null; min_free_space_per_drive_in_mb=50; native_transport_max_concurrent_connections=-1; native_transport_max_concurrent_connections_per_ip=-1; native_transport_max_frame_size_in_mb=256; native_transport_max_threads=128; native_transport_port=9207; native_transport_port_ssl=null; num_tokens=1; otc_coalescing_enough_coalesced_messages=8; otc_coalescing_strategy=TIMEHORIZON; otc_coalescing_window_us=200; partitioner=org.apache.cassandra.dht.ByteOrderedPartitioner; permissions_cache_max_entries=1000; permissions_update_interval_in_ms=-1; permissions_validity_in_ms=2000; phi_convict_threshold=8.0; prepared_statements_cache_size_mb=null; range_request_timeout_in_ms=10000; read_request_timeout_in_ms=5000; request_timeout_in_ms=10000; role_manager=null; roles_cache_max_entries=1000; roles_update_interval_in_ms=-1; roles_validity_in_ms=2000; row_cache_class_name=org.apache.cassandra.cache.OHCProvider; row_cache_keys_to_save=2147483647; row_cache_save_period=0; row_cache_size_in_mb=16; rpc_address=null; rpc_interface=null; rpc_interface_prefer_ipv6=false; rpc_keepalive=true; saved_caches_directory=build/test/cassandra/saved_caches:165; seed_provider=org.apache.cassandra.locator.SimpleSeedProvider{seeds=127.0.0.1}; server_encryption_options=<REDACTED>; slow_query_log_timeout_in_ms=500; snapshot_before_compaction=false; ssl_storage_port=7001; sstable_preemptive_open_interval_in_mb=50; start_native_transport=true; storage_port=7175; stream_throughput_outbound_megabits_per_sec=200; streaming_connections_per_host=1; streaming_keep_alive_period_in_secs=300; streaming_socket_timeout_in_ms=86400000; tombstone_failure_threshold=100000; tombstone_warn_threshold=1000; tracetype_query_ttl=86400; tracetype_repair_ttl=604800; transparent_data_encryption_options=org.apache.cassandra.config.TransparentDataEncryptionOptions@445b295b; trickle_fsync=false; trickle_fsync_interval_in_kb=10240; truncate_request_timeout_in_ms=60000; unlogged_batch_across_partitions_warn_threshold=10; user_defined_function_fail_timeout=1500; user_defined_function_warn_timeout=500; user_function_timeout_policy=die; windows_timer_interval=0; write_request_timeout_in_ms=2000]
> DEBUG [main] 2017-02-21 17:00:02,531 ?:? - Syncing log with a batch window of 1.0
> INFO  [main] 2017-02-21 17:00:02,531 ?:? - DiskAccessMode is mmap, indexAccessMode is mmap
> INFO  [main] 2017-02-21 17:00:02,531 ?:? - Global memtable on-heap threshold is enabled at 227MB
> INFO  [main] 2017-02-21 17:00:02,531 ?:? - Global memtable off-heap threshold is enabled at 227MB
> INFO  [main] 2017-02-21 17:00:03,109 ?:? - Initialized back-pressure with high ratio: 0.9, factor: 5, flow: FAST, window size: 2000.
> INFO  [main] 2017-02-21 17:00:03,109 ?:? - Back-pressure is disabled with strategy null.
> DEBUG [main] 2017-02-21 17:00:03,251 ?:? - Loading settings from file:/home/automaton/cassandra/test/conf/cassandra.yaml
> INFO  [ScheduledTasks:1] 2017-02-21 17:00:03,253 ?:? - Overriding RING_DELAY to 1000ms
> WARN  [main] 2017-02-21 17:00:03,573 ?:? - Protocol Version 5/v5-beta not supported by java driver
> DEBUG [COMMIT-LOG-ALLOCATOR] 2017-02-21 17:00:03,897 ?:? - No segments in reserve; creating a fresh one
> DEBUG [COMMIT-LOG-ALLOCATOR] 2017-02-21 17:00:03,965 ?:? - No segments in reserve; creating a fresh one
> DEBUG [main] 2017-02-21 17:00:03,980 ?:? - CLSM closing and clearing existing commit log segments...
> DEBUG [COMMIT-LOG-ALLOCATOR] 2017-02-21 17:00:04,004 ?:? - No segments in reserve; creating a fresh one
> INFO  [main] 2017-02-21 17:00:04,009 ?:? - No commitlog files found; skipping replay
> DEBUG [main] 2017-02-21 17:00:04,513 ?:? - Using SLF4J as the default logging framework
> DEBUG [main] 2017-02-21 17:00:04,517 ?:? - -Dio.netty.recycler.maxCapacity.default: 32768
> DEBUG [main] 2017-02-21 17:00:04,517 ?:? - -Dio.netty.recycler.maxSharedCapacityFactor: 2
> DEBUG [main] 2017-02-21 17:00:04,517 ?:? - -Dio.netty.recycler.linkCapacity: 16
> DEBUG [main] 2017-02-21 17:00:04,518 ?:? - -Dio.netty.recycler.ratio: 8
> INFO  [main] 2017-02-21 17:00:04,891 ?:? - Initialized prepared statement caches with 10 MB
> INFO  [main] 2017-02-21 17:00:05,206 ?:? - Initializing SIGAR library
> DEBUG [main] 2017-02-21 17:00:05,246 ?:? - no libsigar-amd64-linux.so in java.library.path
> org.hyperic.sigar.SigarException: no libsigar-amd64-linux.so in java.library.path
> 	at org.hyperic.sigar.Sigar.loadLibrary(Sigar.java:172) ~[sigar-1.6.4.jar:na]
> 	at org.hyperic.sigar.Sigar.<clinit>(Sigar.java:100) ~[sigar-1.6.4.jar:na]
> 	at org.apache.cassandra.utils.SigarLibrary.<init>(SigarLibrary.java:47) [main/:na]
> 	at org.apache.cassandra.utils.SigarLibrary.<clinit>(SigarLibrary.java:28) [main/:na]
> 	at org.apache.cassandra.utils.UUIDGen.hash(UUIDGen.java:388) [main/:na]
> 	at org.apache.cassandra.utils.UUIDGen.makeNode(UUIDGen.java:367) [main/:na]
> 	at org.apache.cassandra.utils.UUIDGen.makeClockSeqAndNode(UUIDGen.java:300) [main/:na]
> 	at org.apache.cassandra.utils.UUIDGen.<clinit>(UUIDGen.java:41) [main/:na]
> 	at org.apache.cassandra.utils.ByteBufferUtil.bytes(ByteBufferUtil.java:602) [main/:na]
> 	at org.apache.cassandra.schema.TableId.toHexString(TableId.java:77) [main/:na]
> 	at org.apache.cassandra.db.Directories.<init>(Directories.java:201) [main/:na]
> 	at org.apache.cassandra.db.ColumnFamilyStore.createColumnFamilyStore(ColumnFamilyStore.java:609) [main/:na]
> 	at org.apache.cassandra.db.ColumnFamilyStore.createColumnFamilyStore(ColumnFamilyStore.java:601) [main/:na]
> 	at org.apache.cassandra.db.Keyspace.initCf(Keyspace.java:420) [main/:na]
> 	at org.apache.cassandra.db.Keyspace.<init>(Keyspace.java:333) [main/:na]
> 	at org.apache.cassandra.db.Keyspace.open(Keyspace.java:133) [main/:na]
> 	at org.apache.cassandra.db.Keyspace.open(Keyspace.java:110) [main/:na]
> 	at org.apache.cassandra.db.Keyspace.openAndGetStore(Keyspace.java:168) [main/:na]
> 	at org.apache.cassandra.cql3.statements.UpdatesCollector.validateIndexedColumns(UpdatesCollector.java:91) [main/:na]
> 	at org.apache.cassandra.cql3.statements.ModificationStatement.getMutations(ModificationStatement.java:623) [main/:na]
> 	at org.apache.cassandra.cql3.statements.ModificationStatement.executeInternalWithoutCondition(ModificationStatement.java:573) [main/:na]
> 	at org.apache.cassandra.cql3.statements.ModificationStatement.executeInternal(ModificationStatement.java:568) [main/:na]
> 	at org.apache.cassandra.cql3.QueryProcessor.executeOnceInternal(QueryProcessor.java:339) [main/:na]
> 	at org.apache.cassandra.db.SystemKeyspace.persistLocalMetadata(SystemKeyspace.java:388) [main/:na]
> 	at org.apache.cassandra.cql3.CQLTester.prepareServer(CQLTester.java:199) [classes/:na]
> 	at org.apache.cassandra.SchemaLoader.prepareServer(SchemaLoader.java:70) [classes/:na]
> 	at org.apache.cassandra.db.compaction.AbstractPendingRepairTest.setupClass(AbstractPendingRepairTest.java:63) [classes/:na]
> 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.8.0_45]
> 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[na:1.8.0_45]
> 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[na:1.8.0_45]
> 	at java.lang.reflect.Method.invoke(Method.java:497) ~[na:1.8.0_45]
> 	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44) [junit-4.6.jar:na]
> 	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15) [junit-4.6.jar:na]
> 	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41) [junit-4.6.jar:na]
> 	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:27) [junit-4.6.jar:na]
> 	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:31) [junit-4.6.jar:na]
> 	at org.junit.runners.ParentRunner.run(ParentRunner.java:220) [junit-4.6.jar:na]
> 	at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39) [junit-4.6.jar:na]
> 	at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:535) [ant-junit-1.9.6.jar:na]
> 	at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:1182) [ant-junit-1.9.6.jar:na]
> 	at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:1033) [ant-junit-1.9.6.jar:na]
> INFO  [main] 2017-02-21 17:00:05,254 ?:? - Could not initialize SIGAR library org.hyperic.sigar.Sigar.getFileSystemListNative()[Lorg/hyperic/sigar/FileSystem; 
> INFO  [main] 2017-02-21 17:00:05,500 ?:? - Initializing system.IndexInfo
> INFO  [main] 2017-02-21 17:00:05,744 ?:? - Initializing system.batches
> INFO  [main] 2017-02-21 17:00:05,766 ?:? - Initializing system.paxos
> INFO  [main] 2017-02-21 17:00:05,775 ?:? - Initializing system.local
> INFO  [main] 2017-02-21 17:00:05,798 ?:? - Initializing system.peers
> INFO  [main] 2017-02-21 17:00:05,822 ?:? - Initializing system.peer_events
> INFO  [main] 2017-02-21 17:00:05,847 ?:? - Initializing system.range_xfers
> INFO  [main] 2017-02-21 17:00:05,879 ?:? - Initializing system.compaction_history
> INFO  [main] 2017-02-21 17:00:05,896 ?:? - Initializing system.sstable_activity
> INFO  [main] 2017-02-21 17:00:05,920 ?:? - Initializing system.size_estimates
> INFO  [main] 2017-02-21 17:00:05,949 ?:? - Initializing system.available_ranges
> INFO  [main] 2017-02-21 17:00:05,964 ?:? - Initializing system.transferred_ranges
> INFO  [main] 2017-02-21 17:00:05,985 ?:? - Initializing system.views_builds_in_progress
> INFO  [main] 2017-02-21 17:00:06,039 ?:? - Initializing system.built_views
> INFO  [main] 2017-02-21 17:00:06,050 ?:? - Initializing system.prepared_statements
> INFO  [main] 2017-02-21 17:00:06,074 ?:? - Initializing system.repairs
> INFO  [main] 2017-02-21 17:00:06,080 ?:? - Not submitting build tasks for views in keyspace system as storage service is not initialized
> DEBUG [COMMIT-LOG-ALLOCATOR] 2017-02-21 17:00:06,203 ?:? - No segments in reserve; creating a fresh one
> WARN  [COMMIT-LOG-WRITER] 2017-02-21 17:00:06,208 ?:? - Out of 1 commit log syncs over the past 0.00s with average duration of 2.17ms, 1 have exceeded the configured commit interval by an average of 1.17ms
> INFO  [main] 2017-02-21 17:00:06,409 ?:? - Create new Keyspace: KeyspaceMetadata{name=ks_1487696406397, params=KeyspaceParams{durable_writes=true, replication=ReplicationParams{class=org.apache.cassandra.locator.SimpleStrategy, replication_factor=1}}, tables=[ks_1487696406397.tbl], views=[], functions=[], types=[]}
> INFO  [main] 2017-02-21 17:00:06,513 ?:? - Initializing system_schema.keyspaces
> INFO  [main] 2017-02-21 17:00:06,531 ?:? - Initializing system_schema.tables
> INFO  [main] 2017-02-21 17:00:06,548 ?:? - Initializing system_schema.columns
> INFO  [main] 2017-02-21 17:00:06,567 ?:? - Initializing system_schema.triggers
> INFO  [main] 2017-02-21 17:00:06,585 ?:? - Initializing system_schema.dropped_columns
> INFO  [main] 2017-02-21 17:00:06,608 ?:? - Initializing system_schema.views
> INFO  [main] 2017-02-21 17:00:06,627 ?:? - Initializing system_schema.types
> INFO  [main] 2017-02-21 17:00:06,640 ?:? - Initializing system_schema.functions
> INFO  [main] 2017-02-21 17:00:06,651 ?:? - Initializing system_schema.aggregates
> INFO  [main] 2017-02-21 17:00:06,660 ?:? - Initializing system_schema.indexes
> INFO  [main] 2017-02-21 17:00:06,662 ?:? - Not submitting build tasks for views in keyspace system_schema as storage service is not initialized
> DEBUG [main] 2017-02-21 17:00:06,672 ?:? - Enqueuing flush of keyspaces: 0.293KiB (0%) on-heap, 0.150KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:07,041 ?:? - Writing Memtable-keyspaces@482559506(0.146KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:07,056 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-1-big-Data.db (0.123KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=1454)
> INFO  [MemtableFlushWriter:1] 2017-02-21 17:00:07,219 ?:? - Initializing key cache with capacity of 12 MBs.
> INFO  [MemtableFlushWriter:1] 2017-02-21 17:00:07,243 ?:? - Initializing row cache with capacity of 16 MBs
> INFO  [MemtableFlushWriter:1] 2017-02-21 17:00:07,288 ?:? - OHC using Java8 Unsafe API
> INFO  [MemtableFlushWriter:1] 2017-02-21 17:00:07,289 ?:? - OHC using JNA OS native malloc/free
> DEBUG [MemtableFlushWriter:1] 2017-02-21 17:00:07,290 ?:? - OHC instance with 8 segments and capacity of 16777216 created.
> INFO  [MemtableFlushWriter:1] 2017-02-21 17:00:07,291 ?:? - Initializing counter cache with capacity of 6 MBs
> INFO  [MemtableFlushWriter:1] 2017-02-21 17:00:07,291 ?:? - Scheduling counter cache save to every 7200 seconds (going to save all keys).
> DEBUG [MemtableFlushWriter:1] 2017-02-21 17:00:07,372 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-1-big-Data.db')] (1 sstables, 5.091KiB), biggest 5.091KiB, smallest 5.091KiB
> DEBUG [main] 2017-02-21 17:00:07,374 ?:? - Enqueuing flush of tables: 0.699KiB (0%) on-heap, 0.763KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:07,402 ?:? - Writing Memtable-tables@876336209(0.682KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:07,403 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-1-big-Data.db (0.447KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=1454)
> DEBUG [MemtableFlushWriter:2] 2017-02-21 17:00:07,441 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-1-big-Data.db')] (1 sstables, 6.697KiB), biggest 6.697KiB, smallest 6.697KiB
> DEBUG [main] 2017-02-21 17:00:07,442 ?:? - Enqueuing flush of columns: 0.590KiB (0%) on-heap, 0.293KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:07,446 ?:? - Writing Memtable-columns@35154192(0.256KiB serialized bytes, 2 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:07,448 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-1-big-Data.db (0.112KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=1454)
> DEBUG [MemtableFlushWriter:1] 2017-02-21 17:00:07,472 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-1-big-Data.db')] (1 sstables, 5.188KiB), biggest 5.188KiB, smallest 5.188KiB
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:07,473 ?:? - forceFlush requested but everything is clean in dropped_columns
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:07,474 ?:? - forceFlush requested but everything is clean in triggers
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:07,474 ?:? - forceFlush requested but everything is clean in views
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:07,474 ?:? - forceFlush requested but everything is clean in types
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:07,475 ?:? - forceFlush requested but everything is clean in functions
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:07,475 ?:? - forceFlush requested but everything is clean in aggregates
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:07,475 ?:? - forceFlush requested but everything is clean in indexes
> INFO  [main] 2017-02-21 17:00:07,581 ?:? - Global buffer pool is enabled, when pool is exhausted (max is 227.000MiB) it will allocate on heap
> INFO  [main] 2017-02-21 17:00:07,635 ?:? - Scheduling approximate time-check task with a precision of 10 milliseconds
> INFO  [main] 2017-02-21 17:00:07,830 ?:? - Initializing ks_1487696406397.tbl
> INFO  [main] 2017-02-21 17:00:07,833 ?:? - Not submitting build tasks for views in keyspace ks_1487696406397 as storage service is not initialized
> DEBUG [main] 2017-02-21 17:00:07,883 ?:? - Enqueuing flush of tbl: 0.254KiB (0%) on-heap, 0.036KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:07,890 ?:? - Writing Memtable-tbl@989605030(0.048KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:07,891 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/ks_1487696406397/tbl-31dfe9e0f85711e69a5eddfbe8dfd0c8/na-1-big-Data.db (0.027KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=1806)
> DEBUG [MemtableFlushWriter:2] 2017-02-21 17:00:07,929 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/ks_1487696406397/tbl-31dfe9e0f85711e69a5eddfbe8dfd0c8/na-1-big-Data.db')] (1 sstables, 4.760KiB), biggest 4.760KiB, smallest 4.760KiB
> DEBUG [main] 2017-02-21 17:00:07,939 ?:? - Creating ks_1487696406397.tbl compaction strategy for pending repair: 32bc4020-f857-11e6-9a5e-ddfbe8dfd0c8
> INFO  [main] 2017-02-21 17:00:07,948 ?:? - Create new Keyspace: KeyspaceMetadata{name=ks_1487696407944, params=KeyspaceParams{durable_writes=true, replication=ReplicationParams{class=org.apache.cassandra.locator.SimpleStrategy, replication_factor=1}}, tables=[ks_1487696407944.tbl], views=[], functions=[], types=[]}
> DEBUG [main] 2017-02-21 17:00:07,961 ?:? - Enqueuing flush of keyspaces: 0.293KiB (0%) on-heap, 0.150KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:07,973 ?:? - Writing Memtable-keyspaces@1643745133(0.146KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:07,974 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-2-big-Data.db (0.123KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=2910)
> DEBUG [MemtableFlushWriter:1] 2017-02-21 17:00:07,988 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-2-big-Data.db')] (1 sstables, 5.092KiB), biggest 5.092KiB, smallest 5.092KiB
> DEBUG [main] 2017-02-21 17:00:07,989 ?:? - Enqueuing flush of tables: 0.699KiB (0%) on-heap, 0.763KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:07,993 ?:? - Writing Memtable-tables@1053015841(0.682KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:07,994 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-2-big-Data.db (0.447KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=2910)
> DEBUG [MemtableFlushWriter:2] 2017-02-21 17:00:08,004 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-2-big-Data.db')] (1 sstables, 6.697KiB), biggest 6.697KiB, smallest 6.697KiB
> DEBUG [main] 2017-02-21 17:00:08,005 ?:? - Enqueuing flush of columns: 0.590KiB (0%) on-heap, 0.293KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:08,011 ?:? - Writing Memtable-columns@918244190(0.256KiB serialized bytes, 2 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:08,012 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-2-big-Data.db (0.112KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=2910)
> DEBUG [MemtableFlushWriter:1] 2017-02-21 17:00:08,064 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-2-big-Data.db')] (1 sstables, 5.188KiB), biggest 5.188KiB, smallest 5.188KiB
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,067 ?:? - forceFlush requested but everything is clean in dropped_columns
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,067 ?:? - forceFlush requested but everything is clean in triggers
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,067 ?:? - forceFlush requested but everything is clean in views
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,067 ?:? - forceFlush requested but everything is clean in types
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,068 ?:? - forceFlush requested but everything is clean in functions
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,068 ?:? - forceFlush requested but everything is clean in aggregates
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,068 ?:? - forceFlush requested but everything is clean in indexes
> INFO  [main] 2017-02-21 17:00:08,098 ?:? - Initializing ks_1487696407944.tbl
> INFO  [main] 2017-02-21 17:00:08,101 ?:? - Not submitting build tasks for views in keyspace ks_1487696407944 as storage service is not initialized
> DEBUG [main] 2017-02-21 17:00:08,123 ?:? - Enqueuing flush of tbl: 0.254KiB (0%) on-heap, 0.036KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:08,129 ?:? - Writing Memtable-tbl@2076255901(0.048KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:08,129 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/ks_1487696407944/tbl-32cbf790f85711e69a5eddfbe8dfd0c8/na-1-big-Data.db (0.027KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=3262)
> DEBUG [MemtableFlushWriter:2] 2017-02-21 17:00:08,139 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/ks_1487696407944/tbl-32cbf790f85711e69a5eddfbe8dfd0c8/na-1-big-Data.db')] (1 sstables, 4.760KiB), biggest 4.760KiB, smallest 4.760KiB
> DEBUG [main] 2017-02-21 17:00:08,144 ?:? - Creating ks_1487696407944.tbl compaction strategy for pending repair: 32e3ec60-f857-11e6-9a5e-ddfbe8dfd0c8
> INFO  [main] 2017-02-21 17:00:08,157 ?:? - Create new Keyspace: KeyspaceMetadata{name=ks_1487696408156, params=KeyspaceParams{durable_writes=true, replication=ReplicationParams{class=org.apache.cassandra.locator.SimpleStrategy, replication_factor=1}}, tables=[ks_1487696408156.tbl], views=[], functions=[], types=[]}
> DEBUG [main] 2017-02-21 17:00:08,169 ?:? - Enqueuing flush of keyspaces: 0.293KiB (0%) on-heap, 0.150KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:08,174 ?:? - Writing Memtable-keyspaces@928518457(0.146KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:08,174 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-3-big-Data.db (0.123KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=4654)
> DEBUG [MemtableFlushWriter:1] 2017-02-21 17:00:08,230 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-3-big-Data.db')] (1 sstables, 5.092KiB), biggest 5.092KiB, smallest 5.092KiB
> DEBUG [main] 2017-02-21 17:00:08,231 ?:? - Enqueuing flush of tables: 0.699KiB (0%) on-heap, 0.763KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:08,249 ?:? - Writing Memtable-tables@296942824(0.682KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:08,250 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-3-big-Data.db (0.447KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=4654)
> DEBUG [MemtableFlushWriter:2] 2017-02-21 17:00:08,268 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-3-big-Data.db')] (1 sstables, 6.697KiB), biggest 6.697KiB, smallest 6.697KiB
> DEBUG [main] 2017-02-21 17:00:08,269 ?:? - Enqueuing flush of columns: 0.590KiB (0%) on-heap, 0.293KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:08,272 ?:? - Writing Memtable-columns@1984544299(0.256KiB serialized bytes, 2 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:08,273 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-3-big-Data.db (0.112KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=4654)
> DEBUG [MemtableFlushWriter:1] 2017-02-21 17:00:08,291 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-3-big-Data.db')] (1 sstables, 5.188KiB), biggest 5.188KiB, smallest 5.188KiB
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,291 ?:? - forceFlush requested but everything is clean in dropped_columns
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,291 ?:? - forceFlush requested but everything is clean in triggers
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,291 ?:? - forceFlush requested but everything is clean in views
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,292 ?:? - forceFlush requested but everything is clean in types
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,292 ?:? - forceFlush requested but everything is clean in functions
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,292 ?:? - forceFlush requested but everything is clean in aggregates
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,292 ?:? - forceFlush requested but everything is clean in indexes
> INFO  [main] 2017-02-21 17:00:08,315 ?:? - Initializing ks_1487696408156.tbl
> INFO  [main] 2017-02-21 17:00:08,315 ?:? - Not submitting build tasks for views in keyspace ks_1487696408156 as storage service is not initialized
> DEBUG [main] 2017-02-21 17:00:08,334 ?:? - Enqueuing flush of tbl: 0.254KiB (0%) on-heap, 0.036KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:08,337 ?:? - Writing Memtable-tbl@1248885604(0.048KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:08,337 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/ks_1487696408156/tbl-32ec29c0f85711e69a5eddfbe8dfd0c8/na-1-big-Data.db (0.027KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=5006)
> DEBUG [MemtableFlushWriter:2] 2017-02-21 17:00:08,346 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/ks_1487696408156/tbl-32ec29c0f85711e69a5eddfbe8dfd0c8/na-1-big-Data.db')] (1 sstables, 4.760KiB), biggest 4.760KiB, smallest 4.760KiB
> DEBUG [main] 2017-02-21 17:00:08,357 ?:? - Creating ks_1487696408156.tbl compaction strategy for pending repair: 3305cc40-f857-11e6-9a5e-ddfbe8dfd0c8
> INFO  [main] 2017-02-21 17:00:08,367 ?:? - Create new Keyspace: KeyspaceMetadata{name=ks_1487696408366, params=KeyspaceParams{durable_writes=true, replication=ReplicationParams{class=org.apache.cassandra.locator.SimpleStrategy, replication_factor=1}}, tables=[ks_1487696408366.tbl], views=[], functions=[], types=[]}
> DEBUG [main] 2017-02-21 17:00:08,381 ?:? - Enqueuing flush of keyspaces: 0.293KiB (0%) on-heap, 0.150KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:08,384 ?:? - Writing Memtable-keyspaces@1541850472(0.146KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:08,385 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-4-big-Data.db (0.123KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=6398)
> DEBUG [MemtableFlushWriter:1] 2017-02-21 17:00:08,398 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-4-big-Data.db')] (1 sstables, 5.092KiB), biggest 5.092KiB, smallest 5.092KiB
> DEBUG [main] 2017-02-21 17:00:08,403 ?:? - Enqueuing flush of tables: 0.699KiB (0%) on-heap, 0.763KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:08,407 ?:? - Writing Memtable-tables@1776943036(0.682KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:08,408 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-4-big-Data.db (0.447KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=6398)
> DEBUG [CompactionExecutor:1] 2017-02-21 17:00:08,411 ?:? - Compacting (33116500-f857-11e6-9a5e-ddfbe8dfd0c8) [/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-2-big-Data.db:level=0, /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-1-big-Data.db:level=0, /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-4-big-Data.db:level=0, /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-3-big-Data.db:level=0, ]
> DEBUG [CompactionExecutor:2] 2017-02-21 17:00:08,418 ?:? - Compacting (33142420-f857-11e6-9a5e-ddfbe8dfd0c8) [/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-3-big-Data.db:level=0, /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-4-big-Data.db:level=0, /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-2-big-Data.db:level=0, /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-1-big-Data.db:level=0, ]
> DEBUG [MemtableFlushWriter:2] 2017-02-21 17:00:08,427 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-4-big-Data.db')] (1 sstables, 6.697KiB), biggest 6.697KiB, smallest 6.697KiB
> DEBUG [main] 2017-02-21 17:00:08,433 ?:? - Enqueuing flush of columns: 0.590KiB (0%) on-heap, 0.293KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:08,436 ?:? - Writing Memtable-columns@938181873(0.256KiB serialized bytes, 2 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:08,437 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-4-big-Data.db (0.112KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=6398)
> DEBUG [MemtableFlushWriter:1] 2017-02-21 17:00:08,451 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-4-big-Data.db')] (1 sstables, 5.188KiB), biggest 5.188KiB, smallest 5.188KiB
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,456 ?:? - forceFlush requested but everything is clean in dropped_columns
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,456 ?:? - forceFlush requested but everything is clean in triggers
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,456 ?:? - forceFlush requested but everything is clean in views
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,457 ?:? - forceFlush requested but everything is clean in types
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,457 ?:? - forceFlush requested but everything is clean in functions
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,457 ?:? - forceFlush requested but everything is clean in aggregates
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,457 ?:? - forceFlush requested but everything is clean in indexes
> DEBUG [CompactionExecutor:3] 2017-02-21 17:00:08,468 ?:? - Compacting (331b9e30-f857-11e6-9a5e-ddfbe8dfd0c8) [/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-2-big-Data.db:level=0, /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-4-big-Data.db:level=0, /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-1-big-Data.db:level=0, /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-3-big-Data.db:level=0, ]
> INFO  [main] 2017-02-21 17:00:08,492 ?:? - Initializing ks_1487696408366.tbl
> INFO  [main] 2017-02-21 17:00:08,494 ?:? - Not submitting build tasks for views in keyspace ks_1487696408366 as storage service is not initialized
> INFO  [main] 2017-02-21 17:00:08,497 ?:? - Create new Keyspace: KeyspaceMetadata{name=ks_1487696408495, params=KeyspaceParams{durable_writes=true, replication=ReplicationParams{class=org.apache.cassandra.locator.SimpleStrategy, replication_factor=1}}, tables=[ks_1487696408495.tbl], views=[], functions=[], types=[]}
> DEBUG [main] 2017-02-21 17:00:08,504 ?:? - Enqueuing flush of keyspaces: 0.293KiB (0%) on-heap, 0.150KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:08,508 ?:? - Writing Memtable-keyspaces@468638162(0.146KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:08,508 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-6-big-Data.db (0.123KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=7502)
> DEBUG [MemtableFlushWriter:2] 2017-02-21 17:00:08,521 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-6-big-Data.db')] (1 sstables, 5.092KiB), biggest 5.092KiB, smallest 5.092KiB
> DEBUG [main] 2017-02-21 17:00:08,522 ?:? - Enqueuing flush of tables: 0.699KiB (0%) on-heap, 0.763KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:08,529 ?:? - Writing Memtable-tables@1078823660(0.682KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:08,530 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-6-big-Data.db (0.447KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=7502)
> DEBUG [MemtableFlushWriter:1] 2017-02-21 17:00:08,554 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-6-big-Data.db')] (1 sstables, 6.696KiB), biggest 6.696KiB, smallest 6.696KiB
> DEBUG [main] 2017-02-21 17:00:08,572 ?:? - Enqueuing flush of columns: 0.590KiB (0%) on-heap, 0.293KiB (0%) off-heap
> DEBUG [CompactionExecutor:2] 2017-02-21 17:00:08,578 ?:? - Compacted (33142420-f857-11e6-9a5e-ddfbe8dfd0c8) 4 sstables to [/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-5-big,] to level=0.  1.543KiB to 0.463KiB (~30% of original) in 143ms.  Read Throughput = 10.767KiB/s, Write Throughput = 3.229KiB/s, Row Throughput = ~8/s.  4 total partitions merged to 4.  Partition merge counts were {1:4, }
> DEBUG [CompactionExecutor:1] 2017-02-21 17:00:08,579 ?:? - Compacted (33116500-f857-11e6-9a5e-ddfbe8dfd0c8) 4 sstables to [/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-5-big,] to level=0.  0.523KiB to 0.180KiB (~34% of original) in 145ms.  Read Throughput = 3.593KiB/s, Write Throughput = 1.233KiB/s, Row Throughput = ~8/s.  4 total partitions merged to 4.  Partition merge counts were {1:4, }
> DEBUG [CompactionExecutor:3] 2017-02-21 17:00:08,582 ?:? - Compacted (331b9e30-f857-11e6-9a5e-ddfbe8dfd0c8) 4 sstables to [/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-5-big,] to level=0.  0.441KiB to 0.182KiB (~41% of original) in 112ms.  Read Throughput = 3.930KiB/s, Write Throughput = 1.617KiB/s, Row Throughput = ~12/s.  4 total partitions merged to 4.  Partition merge counts were {1:4, }
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:08,583 ?:? - Writing Memtable-columns@490550267(0.256KiB serialized bytes, 2 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:08,584 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-6-big-Data.db (0.112KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=7716)
> DEBUG [MemtableFlushWriter:2] 2017-02-21 17:00:08,596 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-6-big-Data.db')] (1 sstables, 5.188KiB), biggest 5.188KiB, smallest 5.188KiB
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,598 ?:? - forceFlush requested but everything is clean in dropped_columns
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,598 ?:? - forceFlush requested but everything is clean in triggers
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,598 ?:? - forceFlush requested but everything is clean in views
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,598 ?:? - forceFlush requested but everything is clean in types
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,598 ?:? - forceFlush requested but everything is clean in functions
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,598 ?:? - forceFlush requested but everything is clean in aggregates
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,598 ?:? - forceFlush requested but everything is clean in indexes
> INFO  [main] 2017-02-21 17:00:08,634 ?:? - Initializing ks_1487696408495.tbl
> INFO  [main] 2017-02-21 17:00:08,636 ?:? - Not submitting build tasks for views in keyspace ks_1487696408495 as storage service is not initialized
> DEBUG [main] 2017-02-21 17:00:08,655 ?:? - Enqueuing flush of tbl: 0.254KiB (0%) on-heap, 0.036KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:08,658 ?:? - Writing Memtable-tbl@2068765736(0.048KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:08,658 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/ks_1487696408495/tbl-33200b00f85711e69a5eddfbe8dfd0c8/na-1-big-Data.db (0.027KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=8968)
> DEBUG [MemtableFlushWriter:1] 2017-02-21 17:00:08,672 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/ks_1487696408495/tbl-33200b00f85711e69a5eddfbe8dfd0c8/na-1-big-Data.db')] (1 sstables, 4.760KiB), biggest 4.760KiB, smallest 4.760KiB
> DEBUG [main] 2017-02-21 17:00:08,677 ?:? - Creating ks_1487696408495.tbl compaction strategy for pending repair: 333567c0-f857-11e6-9a5e-ddfbe8dfd0c8
> INFO  [main] 2017-02-21 17:00:08,678 ?:? - Create new Keyspace: KeyspaceMetadata{name=ks_1487696408678, params=KeyspaceParams{durable_writes=true, replication=ReplicationParams{class=org.apache.cassandra.locator.SimpleStrategy, replication_factor=1}}, tables=[ks_1487696408678.tbl], views=[], functions=[], types=[]}
> DEBUG [main] 2017-02-21 17:00:08,685 ?:? - Enqueuing flush of keyspaces: 0.293KiB (0%) on-heap, 0.150KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:08,689 ?:? - Writing Memtable-keyspaces@1415565411(0.146KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:08,689 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-7-big-Data.db (0.123KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=10328)
> DEBUG [MemtableFlushWriter:2] 2017-02-21 17:00:08,699 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-7-big-Data.db')] (1 sstables, 5.092KiB), biggest 5.092KiB, smallest 5.092KiB
> DEBUG [main] 2017-02-21 17:00:08,702 ?:? - Enqueuing flush of tables: 0.699KiB (0%) on-heap, 0.763KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:08,707 ?:? - Writing Memtable-tables@376343468(0.682KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:08,708 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-7-big-Data.db (0.447KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=10425)
> DEBUG [MemtableFlushWriter:1] 2017-02-21 17:00:08,716 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-7-big-Data.db')] (1 sstables, 6.697KiB), biggest 6.697KiB, smallest 6.697KiB
> DEBUG [main] 2017-02-21 17:00:08,717 ?:? - Enqueuing flush of columns: 0.590KiB (0%) on-heap, 0.293KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:08,721 ?:? - Writing Memtable-columns@1928188235(0.256KiB serialized bytes, 2 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:08,721 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-7-big-Data.db (0.112KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=10514)
> DEBUG [MemtableFlushWriter:2] 2017-02-21 17:00:08,732 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-7-big-Data.db')] (1 sstables, 5.188KiB), biggest 5.188KiB, smallest 5.188KiB
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,732 ?:? - forceFlush requested but everything is clean in dropped_columns
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,732 ?:? - forceFlush requested but everything is clean in triggers
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,733 ?:? - forceFlush requested but everything is clean in views
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,733 ?:? - forceFlush requested but everything is clean in types
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,733 ?:? - forceFlush requested but everything is clean in functions
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,733 ?:? - forceFlush requested but everything is clean in aggregates
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,733 ?:? - forceFlush requested but everything is clean in indexes
> INFO  [main] 2017-02-21 17:00:08,749 ?:? - Initializing ks_1487696408678.tbl
> INFO  [main] 2017-02-21 17:00:08,750 ?:? - Not submitting build tasks for views in keyspace ks_1487696408678 as storage service is not initialized
> DEBUG [main] 2017-02-21 17:00:08,761 ?:? - Enqueuing flush of tbl: 0.254KiB (0%) on-heap, 0.036KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:08,765 ?:? - Writing Memtable-tbl@2110343580(0.048KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:08,766 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/ks_1487696408678/tbl-333bd060f85711e69a5eddfbe8dfd0c8/na-1-big-Data.db (0.027KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=11044)
> DEBUG [MemtableFlushWriter:1] 2017-02-21 17:00:08,774 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/ks_1487696408678/tbl-333bd060f85711e69a5eddfbe8dfd0c8/na-1-big-Data.db')] (1 sstables, 4.760KiB), biggest 4.760KiB, smallest 4.760KiB
> DEBUG [main] 2017-02-21 17:00:08,776 ?:? - Creating ks_1487696408678.tbl compaction strategy for pending repair: 3346cce0-f857-11e6-9a5e-ddfbe8dfd0c8
> INFO  [main] 2017-02-21 17:00:08,780 ?:? - Create new Keyspace: KeyspaceMetadata{name=ks_1487696408779, params=KeyspaceParams{durable_writes=true, replication=ReplicationParams{class=org.apache.cassandra.locator.SimpleStrategy, replication_factor=1}}, tables=[ks_1487696408779.tbl], views=[], functions=[], types=[]}
> DEBUG [main] 2017-02-21 17:00:08,784 ?:? - Enqueuing flush of keyspaces: 0.293KiB (0%) on-heap, 0.150KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:08,794 ?:? - Writing Memtable-keyspaces@530622093(0.146KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:08,794 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-8-big-Data.db (0.123KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=12436)
> DEBUG [MemtableFlushWriter:2] 2017-02-21 17:00:08,818 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-8-big-Data.db')] (1 sstables, 5.092KiB), biggest 5.092KiB, smallest 5.092KiB
> DEBUG [main] 2017-02-21 17:00:08,820 ?:? - Enqueuing flush of tables: 0.699KiB (0%) on-heap, 0.763KiB (0%) off-heap
> DEBUG [CompactionExecutor:4] 2017-02-21 17:00:08,828 ?:? - Compacting (33515430-f857-11e6-9a5e-ddfbe8dfd0c8) [/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-7-big-Data.db:level=0, /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-8-big-Data.db:level=0, /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-6-big-Data.db:level=0, /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-5-big-Data.db:level=0, ]
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:08,832 ?:? - Writing Memtable-tables@1375712803(0.682KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:08,833 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-8-big-Data.db (0.447KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=12436)
> DEBUG [MemtableFlushWriter:1] 2017-02-21 17:00:08,844 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-8-big-Data.db')] (1 sstables, 6.697KiB), biggest 6.697KiB, smallest 6.697KiB
> DEBUG [main] 2017-02-21 17:00:08,844 ?:? - Enqueuing flush of columns: 0.590KiB (0%) on-heap, 0.293KiB (0%) off-heap
> DEBUG [CompactionExecutor:3] 2017-02-21 17:00:08,844 ?:? - Compacting (335524c0-f857-11e6-9a5e-ddfbe8dfd0c8) [/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-7-big-Data.db:level=0, /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-8-big-Data.db:level=0, /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-6-big-Data.db:level=0, /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-5-big-Data.db:level=0, ]
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:08,847 ?:? - Writing Memtable-columns@1802959977(0.256KiB serialized bytes, 2 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:08,848 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-8-big-Data.db (0.112KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=12436)
> DEBUG [CompactionExecutor:1] 2017-02-21 17:00:08,862 ?:? - Compacting (3357e3e0-f857-11e6-9a5e-ddfbe8dfd0c8) [/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-8-big-Data.db:level=0, /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-7-big-Data.db:level=0, /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-5-big-Data.db:level=0, /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-6-big-Data.db:level=0, ]
> DEBUG [MemtableFlushWriter:2] 2017-02-21 17:00:08,865 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-8-big-Data.db')] (1 sstables, 5.188KiB), biggest 5.188KiB, smallest 5.188KiB
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,869 ?:? - forceFlush requested but everything is clean in dropped_columns
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,869 ?:? - forceFlush requested but everything is clean in triggers
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,869 ?:? - forceFlush requested but everything is clean in views
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,869 ?:? - forceFlush requested but everything is clean in types
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,869 ?:? - forceFlush requested but everything is clean in functions
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,869 ?:? - forceFlush requested but everything is clean in aggregates
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:08,869 ?:? - forceFlush requested but everything is clean in indexes
> INFO  [main] 2017-02-21 17:00:08,898 ?:? - Initializing ks_1487696408779.tbl
> INFO  [main] 2017-02-21 17:00:08,900 ?:? - Not submitting build tasks for views in keyspace ks_1487696408779 as storage service is not initialized
> DEBUG [CompactionExecutor:4] 2017-02-21 17:00:08,912 ?:? - Compacted (33515430-f857-11e6-9a5e-ddfbe8dfd0c8) 4 sstables to [/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-9-big,] to level=0.  0.572KiB to 0.221KiB (~38% of original) in 72ms.  Read Throughput = 7.861KiB/s, Write Throughput = 3.031KiB/s, Row Throughput = ~14/s.  7 total partitions merged to 7.  Partition merge counts were {1:7, }
> DEBUG [CompactionExecutor:1] 2017-02-21 17:00:08,935 ?:? - Compacted (3357e3e0-f857-11e6-9a5e-ddfbe8dfd0c8) 4 sstables to [/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-9-big,] to level=0.  0.513KiB to 0.248KiB (~48% of original) in 68ms.  Read Throughput = 7.460KiB/s, Write Throughput = 3.609KiB/s, Row Throughput = ~21/s.  7 total partitions merged to 7.  Partition merge counts were {1:7, }
> DEBUG [main] 2017-02-21 17:00:08,938 ?:? - Enqueuing flush of tbl: 0.254KiB (0%) on-heap, 0.036KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:08,942 ?:? - Writing Memtable-tbl@1558024104(0.048KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:08,942 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/ks_1487696408779/tbl-334b39b0f85711e69a5eddfbe8dfd0c8/na-1-big-Data.db (0.027KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=13576)
> DEBUG [CompactionExecutor:3] 2017-02-21 17:00:08,948 ?:? - Compacted (335524c0-f857-11e6-9a5e-ddfbe8dfd0c8) 4 sstables to [/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-9-big,] to level=0.  1.620KiB to 0.530KiB (~32% of original) in 102ms.  Read Throughput = 15.839KiB/s, Write Throughput = 5.184KiB/s, Row Throughput = ~14/s.  7 total partitions merged to 7.  Partition merge counts were {1:7, }
> DEBUG [MemtableFlushWriter:1] 2017-02-21 17:00:08,952 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/ks_1487696408779/tbl-334b39b0f85711e69a5eddfbe8dfd0c8/na-1-big-Data.db')] (1 sstables, 4.760KiB), biggest 4.760KiB, smallest 4.760KiB
> DEBUG [main] 2017-02-21 17:00:08,983 ?:? - Creating ks_1487696408779.tbl compaction strategy for pending repair: 335db040-f857-11e6-9a5e-ddfbe8dfd0c8
> DEBUG [main] 2017-02-21 17:00:08,993 ?:? - Enqueuing flush of tbl: 0.254KiB (0%) on-heap, 0.036KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:08,997 ?:? - Writing Memtable-tbl@1090581932(0.048KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:08,997 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/ks_1487696408779/tbl-334b39b0f85711e69a5eddfbe8dfd0c8/na-2-big-Data.db (0.027KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=14858)
> DEBUG [MemtableFlushWriter:2] 2017-02-21 17:00:09,046 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/ks_1487696408779/tbl-334b39b0f85711e69a5eddfbe8dfd0c8/na-2-big-Data.db')] (1 sstables, 4.758KiB), biggest 4.758KiB, smallest 4.758KiB
> DEBUG [main] 2017-02-21 17:00:09,048 ?:? - Creating ks_1487696408779.tbl compaction strategy for pending repair: 336a5a70-f857-11e6-9a5e-ddfbe8dfd0c8
> INFO  [main] 2017-02-21 17:00:09,052 ?:? - Create new Keyspace: KeyspaceMetadata{name=ks_1487696409052, params=KeyspaceParams{durable_writes=true, replication=ReplicationParams{class=org.apache.cassandra.locator.SimpleStrategy, replication_factor=1}}, tables=[ks_1487696409052.tbl], views=[], functions=[], types=[]}
> DEBUG [main] 2017-02-21 17:00:09,055 ?:? - Enqueuing flush of keyspaces: 0.293KiB (0%) on-heap, 0.150KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:09,058 ?:? - Writing Memtable-keyspaces@1049382004(0.146KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:09,059 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-10-big-Data.db (0.123KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=16250)
> DEBUG [MemtableFlushWriter:1] 2017-02-21 17:00:09,068 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-10-big-Data.db')] (1 sstables, 5.092KiB), biggest 5.092KiB, smallest 5.092KiB
> DEBUG [main] 2017-02-21 17:00:09,068 ?:? - Enqueuing flush of tables: 0.699KiB (0%) on-heap, 0.763KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:09,072 ?:? - Writing Memtable-tables@1576735566(0.682KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:09,072 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-10-big-Data.db (0.447KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=16250)
> DEBUG [MemtableFlushWriter:2] 2017-02-21 17:00:09,084 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-10-big-Data.db')] (1 sstables, 6.696KiB), biggest 6.696KiB, smallest 6.696KiB
> DEBUG [main] 2017-02-21 17:00:09,084 ?:? - Enqueuing flush of columns: 0.590KiB (0%) on-heap, 0.293KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:09,087 ?:? - Writing Memtable-columns@155088784(0.256KiB serialized bytes, 2 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:09,087 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-10-big-Data.db (0.112KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=16250)
> DEBUG [MemtableFlushWriter:1] 2017-02-21 17:00:09,094 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-10-big-Data.db')] (1 sstables, 5.188KiB), biggest 5.188KiB, smallest 5.188KiB
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:09,095 ?:? - forceFlush requested but everything is clean in dropped_columns
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:09,095 ?:? - forceFlush requested but everything is clean in triggers
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:09,095 ?:? - forceFlush requested but everything is clean in views
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:09,095 ?:? - forceFlush requested but everything is clean in types
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:09,096 ?:? - forceFlush requested but everything is clean in functions
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:09,096 ?:? - forceFlush requested but everything is clean in aggregates
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:09,096 ?:? - forceFlush requested but everything is clean in indexes
> INFO  [main] 2017-02-21 17:00:09,112 ?:? - Initializing ks_1487696409052.tbl
> INFO  [main] 2017-02-21 17:00:09,120 ?:? - Not submitting build tasks for views in keyspace ks_1487696409052 as storage service is not initialized
> INFO  [main] 2017-02-21 17:00:09,121 ?:? - Create new Keyspace: KeyspaceMetadata{name=ks_1487696409121, params=KeyspaceParams{durable_writes=true, replication=ReplicationParams{class=org.apache.cassandra.locator.SimpleStrategy, replication_factor=1}}, tables=[ks_1487696409121.tbl], views=[], functions=[], types=[]}
> DEBUG [main] 2017-02-21 17:00:09,152 ?:? - Enqueuing flush of keyspaces: 0.293KiB (0%) on-heap, 0.150KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:09,161 ?:? - Writing Memtable-keyspaces@1207259826(0.146KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:09,162 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-11-big-Data.db (0.123KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=17354)
> DEBUG [MemtableFlushWriter:2] 2017-02-21 17:00:09,170 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-11-big-Data.db')] (1 sstables, 5.092KiB), biggest 5.092KiB, smallest 5.092KiB
> DEBUG [main] 2017-02-21 17:00:09,171 ?:? - Enqueuing flush of tables: 0.699KiB (0%) on-heap, 0.763KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:09,175 ?:? - Writing Memtable-tables@635209274(0.682KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:09,176 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-11-big-Data.db (0.447KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=17354)
> DEBUG [MemtableFlushWriter:1] 2017-02-21 17:00:09,194 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-11-big-Data.db')] (1 sstables, 6.697KiB), biggest 6.697KiB, smallest 6.697KiB
> DEBUG [main] 2017-02-21 17:00:09,194 ?:? - Enqueuing flush of columns: 0.590KiB (0%) on-heap, 0.293KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:09,198 ?:? - Writing Memtable-columns@456948625(0.256KiB serialized bytes, 2 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:09,198 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-11-big-Data.db (0.112KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=17354)
> DEBUG [MemtableFlushWriter:2] 2017-02-21 17:00:09,205 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-11-big-Data.db')] (1 sstables, 5.188KiB), biggest 5.188KiB, smallest 5.188KiB
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:09,208 ?:? - forceFlush requested but everything is clean in dropped_columns
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:09,208 ?:? - forceFlush requested but everything is clean in triggers
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:09,209 ?:? - forceFlush requested but everything is clean in views
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:09,209 ?:? - forceFlush requested but everything is clean in types
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:09,209 ?:? - forceFlush requested but everything is clean in functions
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:09,209 ?:? - forceFlush requested but everything is clean in aggregates
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:09,209 ?:? - forceFlush requested but everything is clean in indexes
> INFO  [main] 2017-02-21 17:00:09,234 ?:? - Initializing ks_1487696409121.tbl
> INFO  [main] 2017-02-21 17:00:09,234 ?:? - Not submitting build tasks for views in keyspace ks_1487696409121 as storage service is not initialized
> DEBUG [main] 2017-02-21 17:00:09,238 ?:? - Enqueuing flush of tbl: 0.254KiB (0%) on-heap, 0.036KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:09,244 ?:? - Writing Memtable-tbl@357363174(0.048KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:09,244 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/ks_1487696409121/tbl-337f6910f85711e69a5eddfbe8dfd0c8/na-1-big-Data.db (0.027KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=17706)
> DEBUG [MemtableFlushWriter:1] 2017-02-21 17:00:09,259 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/ks_1487696409121/tbl-337f6910f85711e69a5eddfbe8dfd0c8/na-1-big-Data.db')] (1 sstables, 4.760KiB), biggest 4.760KiB, smallest 4.760KiB
> DEBUG [main] 2017-02-21 17:00:09,266 ?:? - Creating ks_1487696409121.tbl compaction strategy for pending repair: 3390a720-f857-11e6-9a5e-ddfbe8dfd0c8
> INFO  [main] 2017-02-21 17:00:09,270 ?:? - Create new Keyspace: KeyspaceMetadata{name=ks_1487696409269, params=KeyspaceParams{durable_writes=true, replication=ReplicationParams{class=org.apache.cassandra.locator.SimpleStrategy, replication_factor=1}}, tables=[ks_1487696409269.tbl], views=[], functions=[], types=[]}
> DEBUG [main] 2017-02-21 17:00:09,273 ?:? - Enqueuing flush of keyspaces: 0.293KiB (0%) on-heap, 0.150KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:09,276 ?:? - Writing Memtable-keyspaces@1574387919(0.146KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:09,277 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-12-big-Data.db (0.123KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=19098)
> DEBUG [CompactionExecutor:1] 2017-02-21 17:00:09,307 ?:? - Compacting (339bcab0-f857-11e6-9a5e-ddfbe8dfd0c8) [/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-11-big-Data.db:level=0, /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-12-big-Data.db:level=0, /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-10-big-Data.db:level=0, /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-9-big-Data.db:level=0, ]
> DEBUG [MemtableFlushWriter:2] 2017-02-21 17:00:09,314 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-12-big-Data.db')] (1 sstables, 5.092KiB), biggest 5.092KiB, smallest 5.092KiB
> DEBUG [main] 2017-02-21 17:00:09,326 ?:? - Enqueuing flush of tables: 0.699KiB (0%) on-heap, 0.763KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:09,329 ?:? - Writing Memtable-tables@1233120471(0.682KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:09,329 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-12-big-Data.db (0.447KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=19098)
> DEBUG [MemtableFlushWriter:1] 2017-02-21 17:00:09,338 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-12-big-Data.db')] (1 sstables, 6.697KiB), biggest 6.697KiB, smallest 6.697KiB
> DEBUG [CompactionExecutor:2] 2017-02-21 17:00:09,339 ?:? - Compacting (33a085a0-f857-11e6-9a5e-ddfbe8dfd0c8) [/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-10-big-Data.db:level=0, /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-9-big-Data.db:level=0, /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-12-big-Data.db:level=0, /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-11-big-Data.db:level=0, ]
> DEBUG [main] 2017-02-21 17:00:09,342 ?:? - Enqueuing flush of columns: 0.590KiB (0%) on-heap, 0.293KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:09,365 ?:? - Writing Memtable-columns@1488144728(0.256KiB serialized bytes, 2 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:09,365 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-12-big-Data.db (0.112KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=19098)
> DEBUG [CompactionExecutor:1] 2017-02-21 17:00:09,396 ?:? - Compacted (339bcab0-f857-11e6-9a5e-ddfbe8dfd0c8) 4 sstables to [/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-13-big,] to level=0.  0.613KiB to 0.259KiB (~42% of original) in 84ms.  Read Throughput = 7.229KiB/s, Write Throughput = 3.050KiB/s, Row Throughput = ~20/s.  10 total partitions merged to 10.  Partition merge counts were {1:10, }
> DEBUG [CompactionExecutor:4] 2017-02-21 17:00:09,411 ?:? - Compacting (33aba930-f857-11e6-9a5e-ddfbe8dfd0c8) [/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-12-big-Data.db:level=0, /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-9-big-Data.db:level=0, /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-11-big-Data.db:level=0, /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-10-big-Data.db:level=0, ]
> DEBUG [MemtableFlushWriter:2] 2017-02-21 17:00:09,417 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-12-big-Data.db')] (1 sstables, 5.188KiB), biggest 5.188KiB, smallest 5.188KiB
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:09,418 ?:? - forceFlush requested but everything is clean in dropped_columns
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:09,418 ?:? - forceFlush requested but everything is clean in triggers
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:09,418 ?:? - forceFlush requested but everything is clean in views
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:09,418 ?:? - forceFlush requested but everything is clean in types
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:09,418 ?:? - forceFlush requested but everything is clean in functions
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:09,418 ?:? - forceFlush requested but everything is clean in aggregates
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:09,418 ?:? - forceFlush requested but everything is clean in indexes
> INFO  [main] 2017-02-21 17:00:09,432 ?:? - Initializing ks_1487696409269.tbl
> INFO  [main] 2017-02-21 17:00:09,433 ?:? - Not submitting build tasks for views in keyspace ks_1487696409269 as storage service is not initialized
> DEBUG [main] 2017-02-21 17:00:09,438 ?:? - Enqueuing flush of tbl: 0.254KiB (0%) on-heap, 0.036KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:09,449 ?:? - Writing Memtable-tbl@864518303(0.048KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:09,449 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/ks_1487696409269/tbl-33962560f85711e69a5eddfbe8dfd0c8/na-1-big-Data.db (0.027KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=19751)
> DEBUG [MemtableFlushWriter:1] 2017-02-21 17:00:09,475 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/ks_1487696409269/tbl-33962560f85711e69a5eddfbe8dfd0c8/na-1-big-Data.db')] (1 sstables, 4.760KiB), biggest 4.760KiB, smallest 4.760KiB
> DEBUG [CompactionExecutor:2] 2017-02-21 17:00:09,476 ?:? - Compacted (33a085a0-f857-11e6-9a5e-ddfbe8dfd0c8) 4 sstables to [/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-13-big,] to level=0.  1.688KiB to 0.594KiB (~35% of original) in 134ms.  Read Throughput = 12.515KiB/s, Write Throughput = 4.403KiB/s, Row Throughput = ~20/s.  10 total partitions merged to 10.  Partition merge counts were {1:10, }
> DEBUG [main] 2017-02-21 17:00:09,477 ?:? - Creating ks_1487696409269.tbl compaction strategy for pending repair: 33af2ba0-f857-11e6-9a5e-ddfbe8dfd0c8
> DEBUG [CompactionExecutor:3] 2017-02-21 17:00:09,482 ?:? - Setting repairedAt to 0 on BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/ks_1487696409269/tbl-33962560f85711e69a5eddfbe8dfd0c8/na-1-big-Data.db') for 33af2ba0-f857-11e6-9a5e-ddfbe8dfd0c8
> DEBUG [CompactionExecutor:3] 2017-02-21 17:00:09,489 ?:? - Removing compaction strategy for pending repair 33af2ba0-f857-11e6-9a5e-ddfbe8dfd0c8 on  ks_1487696409269.tbl
> INFO  [main] 2017-02-21 17:00:09,500 ?:? - Create new Keyspace: KeyspaceMetadata{name=ks_1487696409496, params=KeyspaceParams{durable_writes=true, replication=ReplicationParams{class=org.apache.cassandra.locator.SimpleStrategy, replication_factor=1}}, tables=[ks_1487696409496.tbl], views=[], functions=[], types=[]}
> DEBUG [main] 2017-02-21 17:00:09,508 ?:? - Enqueuing flush of keyspaces: 0.293KiB (0%) on-heap, 0.150KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:09,520 ?:? - Writing Memtable-keyspaces@893313086(0.146KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:09,521 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-14-big-Data.db (0.123KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=21429)
> DEBUG [MemtableFlushWriter:2] 2017-02-21 17:00:09,528 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-14-big-Data.db')] (1 sstables, 5.092KiB), biggest 5.092KiB, smallest 5.092KiB
> DEBUG [main] 2017-02-21 17:00:09,532 ?:? - Enqueuing flush of tables: 0.699KiB (0%) on-heap, 0.763KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:09,537 ?:? - Writing Memtable-tables@1923820931(0.682KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:09,537 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-14-big-Data.db (0.447KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=21429)
> DEBUG [CompactionExecutor:4] 2017-02-21 17:00:09,540 ?:? - Compacted (33aba930-f857-11e6-9a5e-ddfbe8dfd0c8) 4 sstables to [/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-13-big,] to level=0.  0.579KiB to 0.311KiB (~53% of original) in 127ms.  Read Throughput = 4.548KiB/s, Write Throughput = 2.438KiB/s, Row Throughput = ~30/s.  10 total partitions merged to 10.  Partition merge counts were {1:10, }
> DEBUG [MemtableFlushWriter:1] 2017-02-21 17:00:09,549 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-14-big-Data.db')] (1 sstables, 6.697KiB), biggest 6.697KiB, smallest 6.697KiB
> DEBUG [main] 2017-02-21 17:00:09,549 ?:? - Enqueuing flush of columns: 0.590KiB (0%) on-heap, 0.293KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:09,552 ?:? - Writing Memtable-columns@1294394875(0.256KiB serialized bytes, 2 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:09,553 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-14-big-Data.db (0.112KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=21919)
> DEBUG [MemtableFlushWriter:2] 2017-02-21 17:00:09,565 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-14-big-Data.db')] (1 sstables, 5.188KiB), biggest 5.188KiB, smallest 5.188KiB
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:09,565 ?:? - forceFlush requested but everything is clean in dropped_columns
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:09,565 ?:? - forceFlush requested but everything is clean in triggers
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:09,566 ?:? - forceFlush requested but everything is clean in views
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:09,566 ?:? - forceFlush requested but everything is clean in types
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:09,566 ?:? - forceFlush requested but everything is clean in functions
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:09,566 ?:? - forceFlush requested but everything is clean in aggregates
> DEBUG [MemtablePostFlush:1] 2017-02-21 17:00:09,566 ?:? - forceFlush requested but everything is clean in indexes
> INFO  [main] 2017-02-21 17:00:09,588 ?:? - Initializing ks_1487696409496.tbl
> INFO  [main] 2017-02-21 17:00:09,591 ?:? - Not submitting build tasks for views in keyspace ks_1487696409496 as storage service is not initialized
> DEBUG [main] 2017-02-21 17:00:09,597 ?:? - Enqueuing flush of tbl: 0.254KiB (0%) on-heap, 0.036KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:09,600 ?:? - Writing Memtable-tbl@16440813(0.048KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:1] 2017-02-21 17:00:09,601 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/ks_1487696409496/tbl-33b916b0f85711e69a5eddfbe8dfd0c8/na-1-big-Data.db (0.027KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=22072)
> DEBUG [MemtableFlushWriter:1] 2017-02-21 17:00:09,609 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/ks_1487696409496/tbl-33b916b0f85711e69a5eddfbe8dfd0c8/na-1-big-Data.db')] (1 sstables, 4.760KiB), biggest 4.760KiB, smallest 4.760KiB
> DEBUG [main] 2017-02-21 17:00:09,610 ?:? - Enqueuing flush of tbl: 0.254KiB (0%) on-heap, 0.036KiB (0%) off-heap
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:09,614 ?:? - Writing Memtable-tbl@705693096(0.048KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> DEBUG [PerDiskMemtableFlushWriter_0:2] 2017-02-21 17:00:09,614 ?:? - Completed flushing /home/automaton/cassandra/build/test/cassandra/data:165/ks_1487696409496/tbl-33b916b0f85711e69a5eddfbe8dfd0c8/na-2-big-Data.db (0.027KiB) for commitlog position CommitLogPosition(segmentId=1487696403904, position=22136)
> DEBUG [MemtableFlushWriter:2] 2017-02-21 17:00:09,636 ?:? - Flushed to [BigTableReader(path='/home/automaton/cassandra/build/test/cassandra/data:165/ks_1487696409496/tbl-33b916b0f85711e69a5eddfbe8dfd0c8/na-2-big-Data.db')] (1 sstables, 4.758KiB), biggest 4.758KiB, smallest 4.758KiB
> DEBUG [main] 2017-02-21 17:00:09,640 ?:? - Creating ks_1487696409496.tbl compaction strategy for pending repair: 33c72070-f857-11e6-9a5e-ddfbe8dfd0c8
> DEBUG [main] 2017-02-21 17:00:09,641 ?:? - Creating ks_1487696409496.tbl compaction strategy for pending repair: 33c72071-f857-11e6-9a5e-ddfbe8dfd0c8
> {code}



--
This message was sent by Atlassian JIRA
(v6.3.15#6346)