You are viewing a plain text version of this content. The canonical link for it is here.
Posted to commits@cassandra.apache.org by "Benjamin Lerer (Jira)" <ji...@apache.org> on 2021/02/19 16:47:01 UTC
[jira] [Commented] (CASSANDRA-16443) Fix flaky test
org.apache.cassandra.db.SinglePartitionSliceCommandTest
testPartitionDeletionRowDeletionTie
[ https://issues.apache.org/jira/browse/CASSANDRA-16443?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=17287183#comment-17287183 ]
Benjamin Lerer commented on CASSANDRA-16443:
--------------------------------------------
The problem is a timestamp issue. If the {{localDeletion}} of the deleted partition is the same as the {{localDeletion}} time of the deleted row they will be merged together and will not appear in the result that will be {{[Row[info=[ts=11] ]: c=1 | [v=1 ts=11]]}}. If the {{localDeletion}} times are not the same (which happen when the queries will not be executed within the same second) the deletions will not be merged and the result will show the row deletion.
> Fix flaky test org.apache.cassandra.db.SinglePartitionSliceCommandTest testPartitionDeletionRowDeletionTie
> ----------------------------------------------------------------------------------------------------------
>
> Key: CASSANDRA-16443
> URL: https://issues.apache.org/jira/browse/CASSANDRA-16443
> Project: Cassandra
> Issue Type: Bug
> Components: Test/unit
> Reporter: David Capwell
> Assignee: Benjamin Lerer
> Priority: Normal
> Fix For: 4.0-beta
>
>
> https://ci-cassandra.apache.org/view/patches/job/Cassandra-devbranch-test/225/jdk=jdk_11_latest,label=cassandra/testReport/junit/org.apache.cassandra.db/SinglePartitionSliceCommandTest/testPartitionDeletionRowDeletionTie/
> {code}
> Error Message
> Expected [Row[info=[ts=11] ]: c=1 | [v=1 ts=11]] but got [Row[info=[ts=11] del=deletedAt=10, localDeletion=1613085925 ]: c=1 | [v=1 ts=11]] expected: java.util.ArrayList<[[[v=1 ts=11]]]> but was: java.util.ArrayList<[[[v=1 ts=11]]]>
> Stacktrace
> junit.framework.AssertionFailedError: Expected [Row[info=[ts=11] ]: c=1 | [v=1 ts=11]] but got [Row[info=[ts=11] del=deletedAt=10, localDeletion=1613085925 ]: c=1 | [v=1 ts=11]] expected: java.util.ArrayList<[[[v=1 ts=11]]]> but was: java.util.ArrayList<[[[v=1 ts=11]]]>
> at org.apache.cassandra.db.SinglePartitionSliceCommandTest.testPartitionDeletionRowDeletionTie(SinglePartitionSliceCommandTest.java:382)
> at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
> at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> Standard Output
> INFO [main] 2021-02-11 23:25:22,114 YamlConfigurationLoader.java:93 - Configuration location: file:/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/test/conf/cassandra.yaml
> DEBUG [main] 2021-02-11 23:25:22,117 YamlConfigurationLoader.java:112 - Loading settings from file:/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/test/conf/cassandra.yaml
> DEBUG [main] 2021-02-11 23:25:22,196 InternalLoggerFactory.java:63 - Using SLF4J as the default logging framework
> DEBUG [main] 2021-02-11 23:25:22,211 PlatformDependent0.java:417 - -Dio.netty.noUnsafe: false
> DEBUG [main] 2021-02-11 23:25:22,211 PlatformDependent0.java:897 - Java version: 11
> DEBUG [main] 2021-02-11 23:25:22,213 PlatformDependent0.java:130 - sun.misc.Unsafe.theUnsafe: available
> DEBUG [main] 2021-02-11 23:25:22,213 PlatformDependent0.java:154 - sun.misc.Unsafe.copyMemory: available
> DEBUG [main] 2021-02-11 23:25:22,214 PlatformDependent0.java:192 - java.nio.Buffer.address: available
> DEBUG [main] 2021-02-11 23:25:22,216 PlatformDependent0.java:266 - direct buffer constructor: unavailable
> java.lang.UnsupportedOperationException: Reflective setAccessible(true) disabled
> at io.netty.util.internal.ReflectionUtil.trySetAccessible(ReflectionUtil.java:31)
> at io.netty.util.internal.PlatformDependent0$4.run(PlatformDependent0.java:238)
> at java.base/java.security.AccessController.doPrivileged(Native Method)
> at io.netty.util.internal.PlatformDependent0.<clinit>(PlatformDependent0.java:232)
> at io.netty.util.internal.PlatformDependent.isAndroid(PlatformDependent.java:293)
> at io.netty.util.internal.PlatformDependent.<clinit>(PlatformDependent.java:92)
> at io.netty.handler.ssl.OpenSsl.<clinit>(OpenSsl.java:124)
> at org.apache.cassandra.security.SSLFactory.<clinit>(SSLFactory.java:100)
> at org.apache.cassandra.config.EncryptionOptions.<clinit>(EncryptionOptions.java:242)
> at org.apache.cassandra.config.Config.<init>(Config.java:280)
> at java.base/jdk.internal.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
> at java.base/jdk.internal.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62)
> at java.base/jdk.internal.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45)
> at java.base/java.lang.reflect.Constructor.newInstance(Constructor.java:490)
> at org.yaml.snakeyaml.constructor.BaseConstructor.newInstance(BaseConstructor.java:330)
> at org.yaml.snakeyaml.constructor.BaseConstructor.newInstance(BaseConstructor.java:308)
> at org.yaml.snakeyaml.constructor.BaseConstructor.newInstance(BaseConstructor.java:301)
> at org.yaml.snakeyaml.constructor.Constructor$ConstructMapping.construct(Constructor.java:167)
> at org.yaml.snakeyaml.constructor.Constructor$ConstructYamlObject.construct(Constructor.java:331)
> at org.yaml.snakeyaml.constructor.BaseConstructor.constructObjectNoCheck(BaseConstructor.java:230)
> at org.yaml.snakeyaml.constructor.BaseConstructor.constructObject(BaseConstructor.java:219)
> at org.yaml.snakeyaml.constructor.BaseConstructor.constructDocument(BaseConstructor.java:173)
> at org.yaml.snakeyaml.constructor.BaseConstructor.getSingleData(BaseConstructor.java:157)
> at org.yaml.snakeyaml.Yaml.loadFromReader(Yaml.java:472)
> at org.yaml.snakeyaml.Yaml.loadAs(Yaml.java:466)
> at org.apache.cassandra.config.YamlConfigurationLoader.loadConfig(YamlConfigurationLoader.java:199)
> at org.apache.cassandra.config.YamlConfigurationLoader.loadConfig(YamlConfigurationLoader.java:129)
> at org.apache.cassandra.config.YamlConfigurationLoader.loadConfig(YamlConfigurationLoader.java:105)
> at org.apache.cassandra.OffsetAwareConfigurationLoader.loadConfig(OffsetAwareConfigurationLoader.java:55)
> at org.apache.cassandra.config.DatabaseDescriptor.loadConfig(DatabaseDescriptor.java:301)
> at org.apache.cassandra.config.DatabaseDescriptor.daemonInitialization(DatabaseDescriptor.java:177)
> at org.apache.cassandra.config.DatabaseDescriptor.daemonInitialization(DatabaseDescriptor.java:162)
> at org.apache.cassandra.db.SinglePartitionSliceCommandTest.defineSchema(SinglePartitionSliceCommandTest.java:96)
> at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
> at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> at java.base/java.lang.reflect.Method.invoke(Method.java:566)
> at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50)
> at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
> at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
> at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:24)
> at org.junit.runners.ParentRunner.run(ParentRunner.java:363)
> at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:38)
> at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:534)
> at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:1196)
> at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:1041)
> DEBUG [main] 2021-02-11 23:25:22,216 PlatformDependent0.java:331 - java.nio.Bits.unaligned: available, true
> DEBUG [main] 2021-02-11 23:25:22,218 PlatformDependent0.java:393 - jdk.internal.misc.Unsafe.allocateUninitializedArray(int): available
> DEBUG [main] 2021-02-11 23:25:22,218 PlatformDependent0.java:403 - java.nio.DirectByteBuffer.<init>(long, int): unavailable
> DEBUG [main] 2021-02-11 23:25:22,218 PlatformDependent.java:1079 - sun.misc.Unsafe: available
> DEBUG [main] 2021-02-11 23:25:22,231 PlatformDependent.java:1181 - maxDirectMemory: 1037959168 bytes (maybe)
> DEBUG [main] 2021-02-11 23:25:22,231 PlatformDependent.java:1200 - -Dio.netty.tmpdir: /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/tmp (java.io.tmpdir)
> DEBUG [main] 2021-02-11 23:25:22,231 PlatformDependent.java:1279 - -Dio.netty.bitMode: 64 (sun.arch.data.model)
> DEBUG [main] 2021-02-11 23:25:22,232 PlatformDependent.java:177 - -Dio.netty.maxDirectMemory: -1 bytes
> DEBUG [main] 2021-02-11 23:25:22,232 PlatformDependent.java:184 - -Dio.netty.uninitializedArrayAllocationThreshold: 1024
> DEBUG [main] 2021-02-11 23:25:22,233 CleanerJava9.java:71 - java.nio.ByteBuffer.cleaner(): available
> DEBUG [main] 2021-02-11 23:25:22,233 PlatformDependent.java:204 - -Dio.netty.noPreferDirect: false
> DEBUG [main] 2021-02-11 23:25:22,236 NativeLibraryLoader.java:73 - -Dio.netty.native.workdir: /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/tmp (io.netty.tmpdir)
> DEBUG [main] 2021-02-11 23:25:22,237 NativeLibraryLoader.java:78 - -Dio.netty.native.deleteLibAfterLoading: true
> DEBUG [main] 2021-02-11 23:25:22,237 NativeLibraryLoader.java:82 - -Dio.netty.native.tryPatchShadedId: true
> DEBUG [main] 2021-02-11 23:25:22,238 NativeLibraryLoader.java:346 - Unable to load the library 'netty_tcnative_linux_x86_64', trying other loading mechanism.
> java.lang.UnsatisfiedLinkError: no netty_tcnative_linux_x86_64 in java.library.path: [/usr/java/packages/lib, /usr/lib64, /lib64, /lib, /usr/lib]
> at java.base/java.lang.ClassLoader.loadLibrary(ClassLoader.java:2660)
> at java.base/java.lang.Runtime.loadLibrary0(Runtime.java:827)
> at java.base/java.lang.System.loadLibrary(System.java:1871)
> at io.netty.util.internal.NativeLibraryUtil.loadLibrary(NativeLibraryUtil.java:38)
> at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
> at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> at java.base/java.lang.reflect.Method.invoke(Method.java:566)
> at io.netty.util.internal.NativeLibraryLoader$1.run(NativeLibraryLoader.java:385)
> at java.base/java.security.AccessController.doPrivileged(Native Method)
> at io.netty.util.internal.NativeLibraryLoader.loadLibraryByHelper(NativeLibraryLoader.java:377)
> at io.netty.util.internal.NativeLibraryLoader.loadLibrary(NativeLibraryLoader.java:341)
> at io.netty.util.internal.NativeLibraryLoader.load(NativeLibraryLoader.java:136)
> at io.netty.util.internal.NativeLibraryLoader.loadFirstAvailable(NativeLibraryLoader.java:96)
> at io.netty.handler.ssl.OpenSsl.loadTcNative(OpenSsl.java:592)
> at io.netty.handler.ssl.OpenSsl.<clinit>(OpenSsl.java:136)
> at org.apache.cassandra.security.SSLFactory.<clinit>(SSLFactory.java:100)
> at org.apache.cassandra.config.EncryptionOptions.<clinit>(EncryptionOptions.java:242)
> at org.apache.cassandra.config.Config.<init>(Config.java:280)
> at java.base/jdk.internal.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
> at java.base/jdk.internal.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62)
> at java.base/jdk.internal.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45)
> at java.base/java.lang.reflect.Constructor.newInstance(Constructor.java:490)
> at org.yaml.snakeyaml.constructor.BaseConstructor.newInstance(BaseConstructor.java:330)
> at org.yaml.snakeyaml.constructor.BaseConstructor.newInstance(BaseConstructor.java:308)
> at org.yaml.snakeyaml.constructor.BaseConstructor.newInstance(BaseConstructor.java:301)
> at org.yaml.snakeyaml.constructor.Constructor$ConstructMapping.construct(Constructor.java:167)
> at org.yaml.snakeyaml.constructor.Constructor$ConstructYamlObject.construct(Constructor.java:331)
> at org.yaml.snakeyaml.constructor.BaseConstructor.constructObjectNoCheck(BaseConstructor.java:230)
> at org.yaml.snakeyaml.constructor.BaseConstructor.constructObject(BaseConstructor.java:219)
> at org.yaml.snakeyaml.constructor.BaseConstructor.constructDocument(BaseConstructor.java:173)
> at org.yaml.snakeyaml.constructor.BaseConstructor.getSingleData(BaseConstructor.java:157)
> at org.yaml.snakeyaml.Yaml.loadFromReader(Yaml.java:472)
> at org.yaml.snakeyaml.Yaml.loadAs(Yaml.java:466)
> at org.apache.cassandra.config.YamlConfigurationLoader.loadConfig(YamlConfigurationLoader.java:199)
> at org.apache.cassandra.config.YamlConfigurationLoader.loadConfig(YamlConfigurationLoader.java:129)
> at org.apache.cassandra.config.YamlConfigurationLoader.loadConfig(YamlConfigurationLoader.java:105)
> at org.apache.cassandra.OffsetAwareConfigurationLoader.loadConfig(OffsetAwareConfigurationLoader.java:55)
> at org.apache.cassandra.config.DatabaseDescriptor.loadConfig(DatabaseDescriptor.java:301)
> at org.apache.cassandra.config.DatabaseDescriptor.daemonInitialization(DatabaseDescriptor.java:177)
> at org.apache.cassandra.config.DatabaseDescriptor.daemonInitialization(DatabaseDescriptor.java:162)
> at org.apache.cassandra.db.SinglePartitionSliceCommandTest.defineSchema(SinglePartitionSliceCommandTest.java:96)
> at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
> at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> at java.base/java.lang.reflect.Method.invoke(Method.java:566)
> at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50)
> at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
> at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
> at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:24)
> at org.junit.runners.ParentRunner.run(ParentRunner.java:363)
> at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:38)
> at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:534)
> at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:1196)
> at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:1041)
> DEBUG [main] 2021-02-11 23:25:22,238 NativeLibraryLoader.java:141 - netty_tcnative_linux_x86_64 cannot be loaded from java.library.path, now trying export to -Dio.netty.native.workdir: /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/tmp
> java.lang.UnsatisfiedLinkError: no netty_tcnative_linux_x86_64 in java.library.path: [/usr/java/packages/lib, /usr/lib64, /lib64, /lib, /usr/lib]
> at java.base/java.lang.ClassLoader.loadLibrary(ClassLoader.java:2660)
> at java.base/java.lang.Runtime.loadLibrary0(Runtime.java:827)
> at java.base/java.lang.System.loadLibrary(System.java:1871)
> at io.netty.util.internal.NativeLibraryUtil.loadLibrary(NativeLibraryUtil.java:38)
> at io.netty.util.internal.NativeLibraryLoader.loadLibrary(NativeLibraryLoader.java:351)
> at io.netty.util.internal.NativeLibraryLoader.load(NativeLibraryLoader.java:136)
> at io.netty.util.internal.NativeLibraryLoader.loadFirstAvailable(NativeLibraryLoader.java:96)
> at io.netty.handler.ssl.OpenSsl.loadTcNative(OpenSsl.java:592)
> at io.netty.handler.ssl.OpenSsl.<clinit>(OpenSsl.java:136)
> at org.apache.cassandra.security.SSLFactory.<clinit>(SSLFactory.java:100)
> at org.apache.cassandra.config.EncryptionOptions.<clinit>(EncryptionOptions.java:242)
> at org.apache.cassandra.config.Config.<init>(Config.java:280)
> at java.base/jdk.internal.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
> at java.base/jdk.internal.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62)
> at java.base/jdk.internal.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45)
> at java.base/java.lang.reflect.Constructor.newInstance(Constructor.java:490)
> at org.yaml.snakeyaml.constructor.BaseConstructor.newInstance(BaseConstructor.java:330)
> at org.yaml.snakeyaml.constructor.BaseConstructor.newInstance(BaseConstructor.java:308)
> at org.yaml.snakeyaml.constructor.BaseConstructor.newInstance(BaseConstructor.java:301)
> at org.yaml.snakeyaml.constructor.Constructor$ConstructMapping.construct(Constructor.java:167)
> at org.yaml.snakeyaml.constructor.Constructor$ConstructYamlObject.construct(Constructor.java:331)
> at org.yaml.snakeyaml.constructor.BaseConstructor.constructObjectNoCheck(BaseConstructor.java:230)
> at org.yaml.snakeyaml.constructor.BaseConstructor.constructObject(BaseConstructor.java:219)
> at org.yaml.snakeyaml.constructor.BaseConstructor.constructDocument(BaseConstructor.java:173)
> at org.yaml.snakeyaml.constructor.BaseConstructor.getSingleData(BaseConstructor.java:157)
> at org.yaml.snakeyaml.Yaml.loadFromReader(Yaml.java:472)
> at org.yaml.snakeyaml.Yaml.loadAs(Yaml.java:466)
> at org.apache.cassandra.config.YamlConfigurationLoader.loadConfig(YamlConfigurationLoader.java:199)
> at org.apache.cassandra.config.YamlConfigurationLoader.loadConfig(YamlConfigurationLoader.java:129)
> at org.apache.cassandra.config.YamlConfigurationLoader.loadConfig(YamlConfigurationLoader.java:105)
> at org.apache.cassandra.OffsetAwareConfigurationLoader.loadConfig(OffsetAwareConfigurationLoader.java:55)
> at org.apache.cassandra.config.DatabaseDescriptor.loadConfig(DatabaseDescriptor.java:301)
> at org.apache.cassandra.config.DatabaseDescriptor.daemonInitialization(DatabaseDescriptor.java:177)
> at org.apache.cassandra.config.DatabaseDescriptor.daemonInitialization(DatabaseDescriptor.java:162)
> at org.apache.cassandra.db.SinglePartitionSliceCommandTest.defineSchema(SinglePartitionSliceCommandTest.java:96)
> at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
> at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> at java.base/java.lang.reflect.Method.invoke(Method.java:566)
> at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50)
> at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
> at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
> at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:24)
> at org.junit.runners.ParentRunner.run(ParentRunner.java:363)
> at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:38)
> at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:534)
> at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:1196)
> at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:1041)
> Suppressed: java.lang.UnsatisfiedLinkError: no netty_tcnative_linux_x86_64 in java.library.path: [/usr/java/packages/lib, /usr/lib64, /lib64, /lib, /usr/lib]
> at java.base/java.lang.ClassLoader.loadLibrary(ClassLoader.java:2660)
> at java.base/java.lang.Runtime.loadLibrary0(Runtime.java:827)
> at java.base/java.lang.System.loadLibrary(System.java:1871)
> at io.netty.util.internal.NativeLibraryUtil.loadLibrary(NativeLibraryUtil.java:38)
> at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
> at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> at java.base/java.lang.reflect.Method.invoke(Method.java:566)
> at io.netty.util.internal.NativeLibraryLoader$1.run(NativeLibraryLoader.java:385)
> at java.base/java.security.AccessController.doPrivileged(Native Method)
> at io.netty.util.internal.NativeLibraryLoader.loadLibraryByHelper(NativeLibraryLoader.java:377)
> at io.netty.util.internal.NativeLibraryLoader.loadLibrary(NativeLibraryLoader.java:341)
> ... 43 common frames omitted
> DEBUG [main] 2021-02-11 23:25:22,272 NativeLibraryLoader.java:342 - Successfully loaded the library /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/tmp/libnetty_tcnative_linux_x86_644195741983291477481.so
> DEBUG [main] 2021-02-11 23:25:22,272 OpenSsl.java:149 - Initialize netty-tcnative using engine: 'default'
> DEBUG [main] 2021-02-11 23:25:22,272 OpenSsl.java:174 - netty-tcnative using native library: BoringSSL
> DEBUG [main] 2021-02-11 23:25:22,443 ResourceLeakDetector.java:129 - -Dio.netty.leakDetection.level: simple
> DEBUG [main] 2021-02-11 23:25:22,443 ResourceLeakDetector.java:130 - -Dio.netty.leakDetection.targetRecords: 4
> DEBUG [main] 2021-02-11 23:25:22,451 AbstractByteBuf.java:63 - -Dio.netty.buffer.checkAccessible: true
> DEBUG [main] 2021-02-11 23:25:22,452 AbstractByteBuf.java:64 - -Dio.netty.buffer.checkBounds: true
> DEBUG [main] 2021-02-11 23:25:22,453 ResourceLeakDetectorFactory.java:196 - Loaded default ResourceLeakDetector: io.netty.util.ResourceLeakDetector@61bcd567
> DEBUG [main] 2021-02-11 23:25:22,474 InternalThreadLocalMap.java:83 - -Dio.netty.threadLocalMap.stringBuilder.initialSize: 1024
> DEBUG [main] 2021-02-11 23:25:22,474 InternalThreadLocalMap.java:86 - -Dio.netty.threadLocalMap.stringBuilder.maxSize: 4096
> DEBUG [main] 2021-02-11 23:25:22,476 PooledByteBufAllocator.java:154 - -Dio.netty.allocator.numHeapArenas: 10
> DEBUG [main] 2021-02-11 23:25:22,477 PooledByteBufAllocator.java:155 - -Dio.netty.allocator.numDirectArenas: 10
> DEBUG [main] 2021-02-11 23:25:22,477 PooledByteBufAllocator.java:157 - -Dio.netty.allocator.pageSize: 8192
> DEBUG [main] 2021-02-11 23:25:22,477 PooledByteBufAllocator.java:162 - -Dio.netty.allocator.maxOrder: 11
> DEBUG [main] 2021-02-11 23:25:22,477 PooledByteBufAllocator.java:166 - -Dio.netty.allocator.chunkSize: 16777216
> DEBUG [main] 2021-02-11 23:25:22,477 PooledByteBufAllocator.java:167 - -Dio.netty.allocator.smallCacheSize: 256
> DEBUG [main] 2021-02-11 23:25:22,477 PooledByteBufAllocator.java:168 - -Dio.netty.allocator.normalCacheSize: 64
> DEBUG [main] 2021-02-11 23:25:22,477 PooledByteBufAllocator.java:169 - -Dio.netty.allocator.maxCachedBufferCapacity: 32768
> DEBUG [main] 2021-02-11 23:25:22,477 PooledByteBufAllocator.java:170 - -Dio.netty.allocator.cacheTrimInterval: 8192
> DEBUG [main] 2021-02-11 23:25:22,477 PooledByteBufAllocator.java:171 - -Dio.netty.allocator.cacheTrimIntervalMillis: 0
> DEBUG [main] 2021-02-11 23:25:22,477 PooledByteBufAllocator.java:172 - -Dio.netty.allocator.useCacheForAllThreads: true
> DEBUG [main] 2021-02-11 23:25:22,477 PooledByteBufAllocator.java:173 - -Dio.netty.allocator.maxCachedByteBuffersPerChunk: 1023
> DEBUG [main] 2021-02-11 23:25:22,486 ByteBufUtil.java:87 - -Dio.netty.allocator.type: pooled
> DEBUG [main] 2021-02-11 23:25:22,486 ByteBufUtil.java:96 - -Dio.netty.threadLocalDirectBufferSize: 0
> DEBUG [main] 2021-02-11 23:25:22,486 ByteBufUtil.java:99 - -Dio.netty.maxThreadLocalCharBufferSize: 16384
> DEBUG [main] 2021-02-11 23:25:22,489 ResourceLeakDetectorFactory.java:196 - Loaded default ResourceLeakDetector: io.netty.util.ResourceLeakDetector@4648ce9
> DEBUG [main] 2021-02-11 23:25:22,495 Recycler.java:102 - -Dio.netty.recycler.maxCapacityPerThread: 4096
> DEBUG [main] 2021-02-11 23:25:22,495 Recycler.java:103 - -Dio.netty.recycler.maxSharedCapacityFactor: 2
> DEBUG [main] 2021-02-11 23:25:22,495 Recycler.java:104 - -Dio.netty.recycler.linkCapacity: 16
> DEBUG [main] 2021-02-11 23:25:22,495 Recycler.java:105 - -Dio.netty.recycler.ratio: 8
> DEBUG [main] 2021-02-11 23:25:22,495 Recycler.java:106 - -Dio.netty.recycler.delayedQueue.ratio: 8
> DEBUG [main] 2021-02-11 23:25:22,517 CipherSuiteConverter.java:330 - Cipher suite mapping: TLS_ECDHE_ECDSA_WITH_AES_128_GCM_SHA256 => ECDHE-ECDSA-AES128-GCM-SHA256
> DEBUG [main] 2021-02-11 23:25:22,517 CipherSuiteConverter.java:331 - Cipher suite mapping: SSL_ECDHE_ECDSA_WITH_AES_128_GCM_SHA256 => ECDHE-ECDSA-AES128-GCM-SHA256
> DEBUG [main] 2021-02-11 23:25:22,517 CipherSuiteConverter.java:330 - Cipher suite mapping: TLS_ECDHE_RSA_WITH_AES_128_GCM_SHA256 => ECDHE-RSA-AES128-GCM-SHA256
> DEBUG [main] 2021-02-11 23:25:22,517 CipherSuiteConverter.java:331 - Cipher suite mapping: SSL_ECDHE_RSA_WITH_AES_128_GCM_SHA256 => ECDHE-RSA-AES128-GCM-SHA256
> DEBUG [main] 2021-02-11 23:25:22,518 CipherSuiteConverter.java:330 - Cipher suite mapping: TLS_ECDHE_ECDSA_WITH_AES_256_GCM_SHA384 => ECDHE-ECDSA-AES256-GCM-SHA384
> DEBUG [main] 2021-02-11 23:25:22,518 CipherSuiteConverter.java:331 - Cipher suite mapping: SSL_ECDHE_ECDSA_WITH_AES_256_GCM_SHA384 => ECDHE-ECDSA-AES256-GCM-SHA384
> DEBUG [main] 2021-02-11 23:25:22,518 CipherSuiteConverter.java:330 - Cipher suite mapping: TLS_ECDHE_RSA_WITH_AES_256_GCM_SHA384 => ECDHE-RSA-AES256-GCM-SHA384
> DEBUG [main] 2021-02-11 23:25:22,518 CipherSuiteConverter.java:331 - Cipher suite mapping: SSL_ECDHE_RSA_WITH_AES_256_GCM_SHA384 => ECDHE-RSA-AES256-GCM-SHA384
> DEBUG [main] 2021-02-11 23:25:22,518 CipherSuiteConverter.java:330 - Cipher suite mapping: TLS_ECDHE_ECDSA_WITH_CHACHA20_POLY1305_SHA256 => ECDHE-ECDSA-CHACHA20-POLY1305
> DEBUG [main] 2021-02-11 23:25:22,518 CipherSuiteConverter.java:331 - Cipher suite mapping: SSL_ECDHE_ECDSA_WITH_CHACHA20_POLY1305_SHA256 => ECDHE-ECDSA-CHACHA20-POLY1305
> DEBUG [main] 2021-02-11 23:25:22,518 CipherSuiteConverter.java:330 - Cipher suite mapping: TLS_ECDHE_RSA_WITH_CHACHA20_POLY1305_SHA256 => ECDHE-RSA-CHACHA20-POLY1305
> DEBUG [main] 2021-02-11 23:25:22,518 CipherSuiteConverter.java:331 - Cipher suite mapping: SSL_ECDHE_RSA_WITH_CHACHA20_POLY1305_SHA256 => ECDHE-RSA-CHACHA20-POLY1305
> DEBUG [main] 2021-02-11 23:25:22,518 CipherSuiteConverter.java:330 - Cipher suite mapping: TLS_ECDHE_PSK_WITH_CHACHA20_POLY1305_SHA256 => ECDHE-PSK-CHACHA20-POLY1305
> DEBUG [main] 2021-02-11 23:25:22,519 CipherSuiteConverter.java:331 - Cipher suite mapping: SSL_ECDHE_PSK_WITH_CHACHA20_POLY1305_SHA256 => ECDHE-PSK-CHACHA20-POLY1305
> DEBUG [main] 2021-02-11 23:25:22,519 CipherSuiteConverter.java:330 - Cipher suite mapping: TLS_ECDHE_ECDSA_WITH_AES_128_CBC_SHA => ECDHE-ECDSA-AES128-SHA
> DEBUG [main] 2021-02-11 23:25:22,519 CipherSuiteConverter.java:331 - Cipher suite mapping: SSL_ECDHE_ECDSA_WITH_AES_128_CBC_SHA => ECDHE-ECDSA-AES128-SHA
> DEBUG [main] 2021-02-11 23:25:22,519 CipherSuiteConverter.java:330 - Cipher suite mapping: TLS_ECDHE_RSA_WITH_AES_128_CBC_SHA => ECDHE-RSA-AES128-SHA
> DEBUG [main] 2021-02-11 23:25:22,519 CipherSuiteConverter.java:331 - Cipher suite mapping: SSL_ECDHE_RSA_WITH_AES_128_CBC_SHA => ECDHE-RSA-AES128-SHA
> DEBUG [main] 2021-02-11 23:25:22,519 CipherSuiteConverter.java:330 - Cipher suite mapping: TLS_ECDHE_PSK_WITH_AES_128_CBC_SHA => ECDHE-PSK-AES128-CBC-SHA
> DEBUG [main] 2021-02-11 23:25:22,519 CipherSuiteConverter.java:331 - Cipher suite mapping: SSL_ECDHE_PSK_WITH_AES_128_CBC_SHA => ECDHE-PSK-AES128-CBC-SHA
> DEBUG [main] 2021-02-11 23:25:22,519 CipherSuiteConverter.java:330 - Cipher suite mapping: TLS_ECDHE_ECDSA_WITH_AES_256_CBC_SHA => ECDHE-ECDSA-AES256-SHA
> DEBUG [main] 2021-02-11 23:25:22,519 CipherSuiteConverter.java:331 - Cipher suite mapping: SSL_ECDHE_ECDSA_WITH_AES_256_CBC_SHA => ECDHE-ECDSA-AES256-SHA
> DEBUG [main] 2021-02-11 23:25:22,520 CipherSuiteConverter.java:330 - Cipher suite mapping: TLS_ECDHE_RSA_WITH_AES_256_CBC_SHA => ECDHE-RSA-AES256-SHA
> DEBUG [main] 2021-02-11 23:25:22,520 CipherSuiteConverter.java:331 - Cipher suite mapping: SSL_ECDHE_RSA_WITH_AES_256_CBC_SHA => ECDHE-RSA-AES256-SHA
> DEBUG [main] 2021-02-11 23:25:22,520 CipherSuiteConverter.java:330 - Cipher suite mapping: TLS_ECDHE_PSK_WITH_AES_256_CBC_SHA => ECDHE-PSK-AES256-CBC-SHA
> DEBUG [main] 2021-02-11 23:25:22,520 CipherSuiteConverter.java:331 - Cipher suite mapping: SSL_ECDHE_PSK_WITH_AES_256_CBC_SHA => ECDHE-PSK-AES256-CBC-SHA
> DEBUG [main] 2021-02-11 23:25:22,520 CipherSuiteConverter.java:330 - Cipher suite mapping: TLS_RSA_WITH_AES_128_GCM_SHA256 => AES128-GCM-SHA256
> DEBUG [main] 2021-02-11 23:25:22,520 CipherSuiteConverter.java:331 - Cipher suite mapping: SSL_RSA_WITH_AES_128_GCM_SHA256 => AES128-GCM-SHA256
> DEBUG [main] 2021-02-11 23:25:22,520 CipherSuiteConverter.java:330 - Cipher suite mapping: TLS_RSA_WITH_AES_256_GCM_SHA384 => AES256-GCM-SHA384
> DEBUG [main] 2021-02-11 23:25:22,520 CipherSuiteConverter.java:331 - Cipher suite mapping: SSL_RSA_WITH_AES_256_GCM_SHA384 => AES256-GCM-SHA384
> DEBUG [main] 2021-02-11 23:25:22,520 CipherSuiteConverter.java:330 - Cipher suite mapping: TLS_RSA_WITH_AES_128_CBC_SHA => AES128-SHA
> DEBUG [main] 2021-02-11 23:25:22,521 CipherSuiteConverter.java:331 - Cipher suite mapping: SSL_RSA_WITH_AES_128_CBC_SHA => AES128-SHA
> DEBUG [main] 2021-02-11 23:25:22,521 CipherSuiteConverter.java:330 - Cipher suite mapping: TLS_PSK_WITH_AES_128_CBC_SHA => PSK-AES128-CBC-SHA
> DEBUG [main] 2021-02-11 23:25:22,521 CipherSuiteConverter.java:331 - Cipher suite mapping: SSL_PSK_WITH_AES_128_CBC_SHA => PSK-AES128-CBC-SHA
> DEBUG [main] 2021-02-11 23:25:22,521 CipherSuiteConverter.java:330 - Cipher suite mapping: TLS_RSA_WITH_AES_256_CBC_SHA => AES256-SHA
> DEBUG [main] 2021-02-11 23:25:22,521 CipherSuiteConverter.java:331 - Cipher suite mapping: SSL_RSA_WITH_AES_256_CBC_SHA => AES256-SHA
> DEBUG [main] 2021-02-11 23:25:22,521 CipherSuiteConverter.java:330 - Cipher suite mapping: TLS_PSK_WITH_AES_256_CBC_SHA => PSK-AES256-CBC-SHA
> DEBUG [main] 2021-02-11 23:25:22,521 CipherSuiteConverter.java:331 - Cipher suite mapping: SSL_PSK_WITH_AES_256_CBC_SHA => PSK-AES256-CBC-SHA
> DEBUG [main] 2021-02-11 23:25:22,521 CipherSuiteConverter.java:330 - Cipher suite mapping: TLS_RSA_WITH_3DES_EDE_CBC_SHA => DES-CBC3-SHA
> DEBUG [main] 2021-02-11 23:25:22,521 CipherSuiteConverter.java:331 - Cipher suite mapping: SSL_RSA_WITH_3DES_EDE_CBC_SHA => DES-CBC3-SHA
> DEBUG [main] 2021-02-11 23:25:22,522 OpenSsl.java:369 - Supported protocols (OpenSSL): [SSLv2Hello, TLSv1, TLSv1.1, TLSv1.2, TLSv1.3]
> DEBUG [main] 2021-02-11 23:25:22,522 OpenSsl.java:370 - Default cipher suites (OpenSSL): [TLS_ECDHE_ECDSA_WITH_AES_256_GCM_SHA384, TLS_ECDHE_ECDSA_WITH_AES_128_GCM_SHA256, TLS_ECDHE_RSA_WITH_AES_128_GCM_SHA256, TLS_ECDHE_RSA_WITH_AES_256_GCM_SHA384, TLS_ECDHE_RSA_WITH_AES_128_CBC_SHA, TLS_ECDHE_RSA_WITH_AES_256_CBC_SHA, TLS_RSA_WITH_AES_128_GCM_SHA256, TLS_RSA_WITH_AES_128_CBC_SHA, TLS_RSA_WITH_AES_256_CBC_SHA, TLS_AES_128_GCM_SHA256, TLS_AES_256_GCM_SHA384, TLS_AES_128_GCM_SHA256, TLS_AES_256_GCM_SHA384]
> INFO [main] 2021-02-11 23:25:22,682 Config.java:687 - Node configuration:[allocate_tokens_for_keyspace=null; allocate_tokens_for_local_replication_factor=null; audit_logging_options=AuditLogOptions{enabled=false, logger='BinAuditLogger{}', included_keyspaces='', excluded_keyspaces='system,system_schema,system_virtual_schema', included_categories='', excluded_categories='', included_users='', excluded_users='', audit_logs_dir='./audit/', archive_command='', roll_cycle='HOURLY', block=true, max_queue_weight=268435456, max_log_size=17179869184}; authenticator=null; authorizer=null; auto_bootstrap=true; auto_optimise_full_repair_streams=false; auto_optimise_inc_repair_streams=false; auto_optimise_preview_repair_streams=false; auto_snapshot=true; autocompaction_on_startup_enabled=true; automatic_sstable_upgrade=false; 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; block_for_peers_in_remote_dcs=false; block_for_peers_timeout_in_secs=10; broadcast_address=null; broadcast_rpc_address=null; buffer_pool_use_heap_if_exhausted=false; cas_contention_timeout_in_ms=1000; cdc_enabled=false; cdc_free_space_check_interval_ms=250; cdc_raw_directory=build/test/cassandra/cdc_raw:176; cdc_total_space_in_mb=0; check_for_duplicate_rows_during_compaction=true; check_for_duplicate_rows_during_reads=true; 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:176; 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_group_window_in_ms=NaN; 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_builders=1; concurrent_materialized_view_writes=32; concurrent_reads=32; concurrent_replicates=null; concurrent_validations=0; concurrent_writes=32; corrupted_tombstone_strategy=exception; 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=true; data_file_directories=[Ljava.lang.String;@21a5fd96; diagnostic_events_enabled=false; 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=1.0; dynamic_snitch_reset_interval_in_ms=600000; dynamic_snitch_update_interval_in_ms=100; enable_materialized_views=true; enable_sasi_indexes=true; enable_scripted_user_defined_functions=true; enable_transient_replication=false; enable_user_defined_functions=true; enable_user_defined_functions_threads=true; endpoint_snitch=org.apache.cassandra.locator.SimpleSnitch; file_cache_enabled=true; file_cache_round_up=null; file_cache_size_in_mb=null; flush_compression=fast; full_query_logging_options=FullQueryLoggerOptions{log_dir='', archive_command='', roll_cycle='HOURLY', block=true, max_queue_weight=268435456, max_log_size=17179869184}; gc_log_threshold_in_ms=200; gc_warn_threshold_in_ms=1000; hinted_handoff_disabled_datacenters=[]; hinted_handoff_enabled=true; hinted_handoff_throttle_in_kb=1024; hints_compression=null; hints_directory=build/test/cassandra/hints:176; hints_flush_period_in_ms=10000; ideal_consistency_level=null; incremental_backups=true; index_summary_capacity_in_mb=null; index_summary_resize_interval_in_minutes=60; initial_range_tombstone_list_allocation_size=1; initial_token=null; inter_dc_stream_throughput_outbound_megabits_per_sec=200; inter_dc_tcp_nodelay=true; internode_application_receive_queue_capacity_in_bytes=4194304; internode_application_receive_queue_reserve_endpoint_capacity_in_bytes=134217728; internode_application_receive_queue_reserve_global_capacity_in_bytes=536870912; internode_application_send_queue_capacity_in_bytes=4194304; internode_application_send_queue_reserve_endpoint_capacity_in_bytes=134217728; internode_application_send_queue_reserve_global_capacity_in_bytes=536870912; internode_authenticator=null; internode_compression=none; internode_max_message_size_in_bytes=null; internode_socket_receive_buffer_size_in_bytes=0; internode_socket_send_buffer_size_in_bytes=0; internode_streaming_tcp_user_timeout_in_ms=300000; internode_tcp_connect_timeout_in_ms=2000; internode_tcp_user_timeout_in_ms=30000; key_cache_keys_to_save=2147483647; key_cache_migrate_during_compaction=true; key_cache_save_period=14400; key_cache_size_in_mb=null; keyspace_count_warn_threshold=40; listen_address=127.0.0.1; listen_interface=null; listen_interface_prefer_ipv6=false; listen_on_broadcast_address=false; local_system_data_file_directory=null; max_concurrent_automatic_sstable_upgrades=1; 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_allow_older_protocols=true; native_transport_flush_in_batches_legacy=false; native_transport_idle_timeout_in_ms=0; native_transport_max_concurrent_connections=-1; native_transport_max_concurrent_connections_per_ip=-1; native_transport_max_concurrent_requests_in_bytes=-1; native_transport_max_concurrent_requests_in_bytes_per_ip=-1; native_transport_max_frame_size_in_mb=256; native_transport_max_negotiable_protocol_version=null; native_transport_max_threads=128; native_transport_port=9218; native_transport_port_ssl=null; native_transport_receive_queue_capacity_in_bytes=1048576; network_authorizer=null; networking_cache_size_in_mb=null; num_tokens=null; otc_coalescing_enough_coalesced_messages=8; otc_coalescing_strategy=DISABLED; otc_coalescing_window_us=200; partitioner=org.apache.cassandra.dht.ByteOrderedPartitioner; periodic_commitlog_sync_lag_block_in_ms=null; 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=1; range_request_timeout_in_ms=10000; range_tombstone_list_growth_factor=1.5; read_request_timeout_in_ms=5000; reject_repair_compaction_threshold=2147483647; repair_command_pool_full_strategy=queue; repair_command_pool_size=0; repair_session_max_tree_depth=null; repair_session_space_in_mb=null; repaired_data_tracking_for_partition_reads_enabled=false; repaired_data_tracking_for_range_reads_enabled=false; report_unconfirmed_repaired_data_mismatches=false; 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:176; seed_provider=org.apache.cassandra.locator.SimpleSeedProvider{seeds=127.0.0.1:7188}; server_encryption_options=<REDACTED>; slow_query_log_timeout_in_ms=500; snapshot_before_compaction=false; snapshot_links_per_second=0; snapshot_on_duplicate_row_detection=false; snapshot_on_repaired_data_mismatch=false; ssl_storage_port=7187; sstable_preemptive_open_interval_in_mb=50; start_native_transport=true; storage_port=7188; stream_entire_sstables=true; stream_throughput_outbound_megabits_per_sec=200000000; streaming_connections_per_host=1; streaming_keep_alive_period_in_secs=300; table_count_warn_threshold=150; 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@5769e7ae; trickle_fsync=false; trickle_fsync_interval_in_kb=10240; truncate_request_timeout_in_ms=60000; unlogged_batch_across_partitions_warn_threshold=10; use_offheap_merkle_trees=true; user_defined_function_fail_timeout=1500; user_defined_function_warn_timeout=500; user_function_timeout_policy=die; validation_preview_purge_head_start_in_sec=3600; windows_timer_interval=0; write_request_timeout_in_ms=2000]
> DEBUG [main] 2021-02-11 23:25:22,682 DatabaseDescriptor.java:384 - Syncing log with batch mode
> INFO [main] 2021-02-11 23:25:22,682 DatabaseDescriptor.java:427 - DiskAccessMode is mmap, indexAccessMode is mmap
> INFO [main] 2021-02-11 23:25:22,682 DatabaseDescriptor.java:477 - Global memtable on-heap threshold is enabled at 247MB
> INFO [main] 2021-02-11 23:25:22,682 DatabaseDescriptor.java:481 - Global memtable off-heap threshold is enabled at 247MB
> DEBUG [main] 2021-02-11 23:25:22,784 YamlConfigurationLoader.java:112 - Loading settings from file:/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/test/conf/cassandra.yaml
> DEBUG [main] 2021-02-11 23:25:22,803 SSLFactory.java:384 - Initializing hot reloading SSLContext
> INFO [ScheduledTasks:1] 2021-02-11 23:25:22,831 StorageService.java:155 - Overriding RING_DELAY to 1000ms
> INFO [main] 2021-02-11 23:25:22,989 MonotonicClock.java:199 - Scheduling approximate time conversion task with an interval of 10000 milliseconds
> INFO [main] 2021-02-11 23:25:22,991 MonotonicClock.java:335 - Scheduling approximate time-check task with a precision of 2 milliseconds
> INFO [main] 2021-02-11 23:25:22,993 CommitLog.java:169 - No commitlog files found; skipping replay
> INFO [main] 2021-02-11 23:25:23,456 QueryProcessor.java:106 - Initialized prepared statement caches with 1 MB
> INFO [main] 2021-02-11 23:25:23,541 Keyspace.java:386 - Creating replication strategy system params KeyspaceParams{durable_writes=true, replication=ReplicationParams{class=org.apache.cassandra.locator.LocalStrategy}}
> DEBUG [main] 2021-02-11 23:25:23,553 Keyspace.java:390 - New replication settings for keyspace system - invalidating disk boundary caches
> INFO [main] 2021-02-11 23:25:23,604 ColumnFamilyStore.java:385 - Initializing system.IndexInfo
> INFO [main] 2021-02-11 23:25:23,709 ColumnFamilyStore.java:385 - Initializing system.batches
> INFO [main] 2021-02-11 23:25:23,721 ColumnFamilyStore.java:385 - Initializing system.paxos
> INFO [main] 2021-02-11 23:25:23,735 ColumnFamilyStore.java:385 - Initializing system.local
> INFO [main] 2021-02-11 23:25:23,743 ColumnFamilyStore.java:385 - Initializing system.peers_v2
> INFO [main] 2021-02-11 23:25:23,750 ColumnFamilyStore.java:385 - Initializing system.peers
> INFO [main] 2021-02-11 23:25:23,757 ColumnFamilyStore.java:385 - Initializing system.peer_events_v2
> INFO [main] 2021-02-11 23:25:23,764 ColumnFamilyStore.java:385 - Initializing system.peer_events
> INFO [main] 2021-02-11 23:25:23,770 ColumnFamilyStore.java:385 - Initializing system.compaction_history
> INFO [main] 2021-02-11 23:25:23,777 ColumnFamilyStore.java:385 - Initializing system.sstable_activity
> INFO [main] 2021-02-11 23:25:23,783 ColumnFamilyStore.java:385 - Initializing system.size_estimates
> INFO [main] 2021-02-11 23:25:23,789 ColumnFamilyStore.java:385 - Initializing system.table_estimates
> INFO [main] 2021-02-11 23:25:23,795 ColumnFamilyStore.java:385 - Initializing system.available_ranges_v2
> INFO [main] 2021-02-11 23:25:23,800 ColumnFamilyStore.java:385 - Initializing system.available_ranges
> INFO [main] 2021-02-11 23:25:23,806 ColumnFamilyStore.java:385 - Initializing system.transferred_ranges_v2
> INFO [main] 2021-02-11 23:25:23,812 ColumnFamilyStore.java:385 - Initializing system.transferred_ranges
> INFO [main] 2021-02-11 23:25:23,818 ColumnFamilyStore.java:385 - Initializing system.view_builds_in_progress
> INFO [main] 2021-02-11 23:25:23,824 ColumnFamilyStore.java:385 - Initializing system.built_views
> INFO [main] 2021-02-11 23:25:23,831 ColumnFamilyStore.java:385 - Initializing system.prepared_statements
> INFO [main] 2021-02-11 23:25:23,838 ColumnFamilyStore.java:385 - Initializing system.repairs
> INFO [COMMIT-LOG-WRITER] 2021-02-11 23:25:23,868 SyncUtil.java:95 - Skip fsync enabled due to property true and environment false
> DEBUG [main] 2021-02-11 23:25:23,877 AuditLogManager.java:75 - Audit logging is disabled.
> INFO [main] 2021-02-11 23:25:23,882 MigrationManager.java:92 - Create new Keyspace: KeyspaceMetadata{name=ks, kind=REGULAR, params=KeyspaceParams{durable_writes=true, replication=ReplicationParams{class=org.apache.cassandra.locator.SimpleStrategy, replication_factor=1}}, tables=[ks.tbl, ks.tbl_slices], views=[], functions=[], types=[]}
> INFO [main] 2021-02-11 23:25:23,900 Keyspace.java:386 - Creating replication strategy system_schema params KeyspaceParams{durable_writes=true, replication=ReplicationParams{class=org.apache.cassandra.locator.LocalStrategy}}
> DEBUG [main] 2021-02-11 23:25:23,901 Keyspace.java:390 - New replication settings for keyspace system_schema - invalidating disk boundary caches
> INFO [main] 2021-02-11 23:25:23,903 ColumnFamilyStore.java:385 - Initializing system_schema.keyspaces
> INFO [main] 2021-02-11 23:25:23,910 ColumnFamilyStore.java:385 - Initializing system_schema.tables
> INFO [main] 2021-02-11 23:25:23,916 ColumnFamilyStore.java:385 - Initializing system_schema.columns
> INFO [main] 2021-02-11 23:25:23,923 ColumnFamilyStore.java:385 - Initializing system_schema.triggers
> INFO [main] 2021-02-11 23:25:23,930 ColumnFamilyStore.java:385 - Initializing system_schema.dropped_columns
> INFO [main] 2021-02-11 23:25:23,935 ColumnFamilyStore.java:385 - Initializing system_schema.views
> INFO [main] 2021-02-11 23:25:23,941 ColumnFamilyStore.java:385 - Initializing system_schema.types
> INFO [main] 2021-02-11 23:25:23,947 ColumnFamilyStore.java:385 - Initializing system_schema.functions
> INFO [main] 2021-02-11 23:25:23,952 ColumnFamilyStore.java:385 - Initializing system_schema.aggregates
> INFO [main] 2021-02-11 23:25:23,958 ColumnFamilyStore.java:385 - Initializing system_schema.indexes
> INFO [main] 2021-02-11 23:25:23,970 ColumnFamilyStore.java:857 - Enqueuing flush of columns: 2.169KiB (0%) on-heap, 1.134KiB (0%) off-heap
> INFO [MemtableFlushWriter:1] 2021-02-11 23:25:24,062 BufferPools.java:49 - Global buffer pool limit is 247.000MiB for chunk-cache and 61.000MiB for networking
> INFO [PerDiskMemtableFlushWriter_0:1] 2021-02-11 23:25:24,095 Memtable.java:469 - Writing Memtable-columns@347123654(1.034KiB serialized bytes, 8 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> INFO [PerDiskMemtableFlushWriter_0:1] 2021-02-11 23:25:24,106 Memtable.java:498 - Completed flushing /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-1-big-Data.db (0.379KiB) for commitlog position CommitLogPosition(segmentId=1613085922972, position=2165)
> INFO [MemtableFlushWriter:1] 2021-02-11 23:25:24,150 LogTransaction.java:240 - Unfinished transaction log, deleting /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na_txn_flush_6a6a8ae0-6cc0-11eb-b66a-157691728e1b.log
> INFO [MemtableFlushWriter:1] 2021-02-11 23:25:24,155 CacheService.java:100 - Initializing key cache with capacity of 24 MBs.
> INFO [MemtableFlushWriter:1] 2021-02-11 23:25:24,161 CacheService.java:122 - Initializing row cache with capacity of 16 MBs
> INFO [MemtableFlushWriter:1] 2021-02-11 23:25:24,172 Uns.java:164 - OHC using Java8 Unsafe API
> INFO [MemtableFlushWriter:1] 2021-02-11 23:25:24,172 Uns.java:193 - OHC using JNA OS native malloc/free
> DEBUG [MemtableFlushWriter:1] 2021-02-11 23:25:24,173 OHCacheLinkedImpl.java:136 - OHC linked instance with 32 segments and capacity of 16777216 created.
> INFO [MemtableFlushWriter:1] 2021-02-11 23:25:24,174 CacheService.java:151 - Initializing counter cache with capacity of 12 MBs
> INFO [MemtableFlushWriter:1] 2021-02-11 23:25:24,175 CacheService.java:162 - Scheduling counter cache save to every 7200 seconds (going to save all keys).
> DEBUG [MemtableFlushWriter:1] 2021-02-11 23:25:24,203 ColumnFamilyStore.java:1176 - Flushed to [BigTableReader(path='/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-1-big-Data.db')] (1 sstables, 5.340KiB), biggest 5.340KiB, smallest 5.340KiB
> DEBUG [MemtablePostFlush:1] 2021-02-11 23:25:24,208 ColumnFamilyStore.java:912 - forceFlush requested but everything is clean in dropped_columns
> DEBUG [MemtablePostFlush:1] 2021-02-11 23:25:24,208 ColumnFamilyStore.java:912 - forceFlush requested but everything is clean in triggers
> DEBUG [MemtablePostFlush:1] 2021-02-11 23:25:24,208 ColumnFamilyStore.java:912 - forceFlush requested but everything is clean in types
> DEBUG [MemtablePostFlush:1] 2021-02-11 23:25:24,209 ColumnFamilyStore.java:912 - forceFlush requested but everything is clean in functions
> DEBUG [MemtablePostFlush:1] 2021-02-11 23:25:24,209 ColumnFamilyStore.java:912 - forceFlush requested but everything is clean in aggregates
> DEBUG [MemtablePostFlush:1] 2021-02-11 23:25:24,209 ColumnFamilyStore.java:912 - forceFlush requested but everything is clean in indexes
> INFO [main] 2021-02-11 23:25:24,210 ColumnFamilyStore.java:857 - Enqueuing flush of tables: 1.505KiB (0%) on-heap, 1.528KiB (0%) off-heap
> INFO [PerDiskMemtableFlushWriter_0:2] 2021-02-11 23:25:24,218 Memtable.java:469 - Writing Memtable-tables@641575466(1.372KiB serialized bytes, 2 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> INFO [PerDiskMemtableFlushWriter_0:2] 2021-02-11 23:25:24,221 Memtable.java:498 - Completed flushing /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-1-big-Data.db (0.813KiB) for commitlog position CommitLogPosition(segmentId=1613085922972, position=2165)
> INFO [MemtableFlushWriter:2] 2021-02-11 23:25:24,230 LogTransaction.java:240 - Unfinished transaction log, deleting /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na_txn_flush_6a8d7c30-6cc0-11eb-b66a-157691728e1b.log
> DEBUG [MemtableFlushWriter:2] 2021-02-11 23:25:24,234 ColumnFamilyStore.java:1176 - Flushed to [BigTableReader(path='/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-1-big-Data.db')] (1 sstables, 6.846KiB), biggest 6.846KiB, smallest 6.846KiB
> DEBUG [MemtablePostFlush:1] 2021-02-11 23:25:24,234 ColumnFamilyStore.java:912 - forceFlush requested but everything is clean in views
> INFO [main] 2021-02-11 23:25:24,235 ColumnFamilyStore.java:857 - Enqueuing flush of keyspaces: 0.419KiB (0%) on-heap, 0.137KiB (0%) off-heap
> INFO [PerDiskMemtableFlushWriter_0:1] 2021-02-11 23:25:24,242 Memtable.java:469 - Writing Memtable-keyspaces@520018471(0.146KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> INFO [PerDiskMemtableFlushWriter_0:1] 2021-02-11 23:25:24,243 Memtable.java:498 - Completed flushing /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-1-big-Data.db (0.109KiB) for commitlog position CommitLogPosition(segmentId=1613085922972, position=2165)
> INFO [MemtableFlushWriter:1] 2021-02-11 23:25:24,256 LogTransaction.java:240 - Unfinished transaction log, deleting /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na_txn_flush_6a9125b0-6cc0-11eb-b66a-157691728e1b.log
> DEBUG [MemtableFlushWriter:1] 2021-02-11 23:25:24,260 ColumnFamilyStore.java:1176 - Flushed to [BigTableReader(path='/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-1-big-Data.db')] (1 sstables, 5.109KiB), biggest 5.109KiB, smallest 5.109KiB
> INFO [main] 2021-02-11 23:25:24,400 Keyspace.java:386 - Creating replication strategy ks params KeyspaceParams{durable_writes=true, replication=ReplicationParams{class=org.apache.cassandra.locator.SimpleStrategy, replication_factor=1}}
> DEBUG [main] 2021-02-11 23:25:24,400 Keyspace.java:390 - New replication settings for keyspace ks - invalidating disk boundary caches
> INFO [main] 2021-02-11 23:25:24,403 ColumnFamilyStore.java:385 - Initializing ks.tbl
> INFO [main] 2021-02-11 23:25:24,408 ColumnFamilyStore.java:385 - Initializing ks.tbl_slices
> INFO [main] 2021-02-11 23:25:24,433 ColumnFamilyStore.java:2221 - Truncating ks.tbl
> DEBUG [MemtablePostFlush:1] 2021-02-11 23:25:24,434 ColumnFamilyStore.java:912 - forceFlush requested but everything is clean in tbl
> INFO
> ...[truncated 96919 chars]...
> :25:25,861 Memtable.java:498 - Completed flushing /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/ks/tbl-69c682b06cc011ebb66a157691728e1b/na-1-big-Data.db (0.024KiB) for commitlog position CommitLogPosition(segmentId=1613085922972, position=12251)
> INFO [MemtableFlushWriter:1] 2021-02-11 23:25:25,869 LogTransaction.java:240 - Unfinished transaction log, deleting /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/ks/tbl-69c682b06cc011ebb66a157691728e1b/na_txn_flush_6b887e00-6cc0-11eb-b66a-157691728e1b.log
> DEBUG [MemtableFlushWriter:1] 2021-02-11 23:25:25,873 ColumnFamilyStore.java:1176 - Flushed to [BigTableReader(path='/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/ks/tbl-69c682b06cc011ebb66a157691728e1b/na-1-big-Data.db')] (1 sstables, 4.875KiB), biggest 4.875KiB, smallest 4.875KiB
> INFO [main] 2021-02-11 23:25:25,875 ColumnFamilyStore.java:2221 - Truncating ks.tbl
> DEBUG [MemtablePostFlush:1] 2021-02-11 23:25:25,875 ColumnFamilyStore.java:912 - forceFlush requested but everything is clean in tbl
> INFO [main] 2021-02-11 23:25:25,876 ColumnFamilyStore.java:2256 - Truncating ks.tbl with truncatedAt=1613085925876
> DEBUG [MemtablePostFlush:1] 2021-02-11 23:25:25,876 ColumnFamilyStore.java:912 - forceFlush requested but everything is clean in tbl
> INFO [main] 2021-02-11 23:25:25,878 ColumnFamilyStore.java:2705 - Truncation is dropping 1 sstables and keeping 0 due to sstable.maxDataAge > truncatedAt
> INFO [main] 2021-02-11 23:25:25,883 ColumnFamilyStore.java:857 - Enqueuing flush of local: 0.411KiB (0%) on-heap, 0.072KiB (0%) off-heap
> INFO [PerDiskMemtableFlushWriter_0:2] 2021-02-11 23:25:25,896 Memtable.java:469 - Writing Memtable-local@1002106852(0.091KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> INFO [PerDiskMemtableFlushWriter_0:2] 2021-02-11 23:25:25,897 Memtable.java:498 - Completed flushing /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-27-big-Data.db (0.063KiB) for commitlog position CommitLogPosition(segmentId=1613085922972, position=12362)
> INFO [MemtableFlushWriter:2] 2021-02-11 23:25:25,905 LogTransaction.java:240 - Unfinished transaction log, deleting /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na_txn_flush_6b8cc3c0-6cc0-11eb-b66a-157691728e1b.log
> DEBUG [MemtableFlushWriter:2] 2021-02-11 23:25:25,909 ColumnFamilyStore.java:1176 - Flushed to [BigTableReader(path='/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-27-big-Data.db')] (1 sstables, 4.975KiB), biggest 4.975KiB, smallest 4.975KiB
> INFO [main] 2021-02-11 23:25:25,910 ColumnFamilyStore.java:2280 - Truncate of ks.tbl is complete
> INFO [main] 2021-02-11 23:25:25,910 ColumnFamilyStore.java:2221 - Truncating ks.tbl_slices
> DEBUG [MemtablePostFlush:1] 2021-02-11 23:25:25,910 ColumnFamilyStore.java:912 - forceFlush requested but everything is clean in tbl_slices
> INFO [main] 2021-02-11 23:25:25,910 ColumnFamilyStore.java:2256 - Truncating ks.tbl_slices with truncatedAt=1613085925910
> DEBUG [MemtablePostFlush:1] 2021-02-11 23:25:25,910 ColumnFamilyStore.java:912 - forceFlush requested but everything is clean in tbl_slices
> INFO [main] 2021-02-11 23:25:25,912 ColumnFamilyStore.java:857 - Enqueuing flush of local: 0.411KiB (0%) on-heap, 0.072KiB (0%) off-heap
> INFO [PerDiskMemtableFlushWriter_0:1] 2021-02-11 23:25:25,917 Memtable.java:469 - Writing Memtable-local@2042417907(0.091KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> INFO [PerDiskMemtableFlushWriter_0:1] 2021-02-11 23:25:25,918 Memtable.java:498 - Completed flushing /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-28-big-Data.db (0.063KiB) for commitlog position CommitLogPosition(segmentId=1613085922972, position=12473)
> INFO [MemtableFlushWriter:1] 2021-02-11 23:25:25,923 LogTransaction.java:240 - Unfinished transaction log, deleting /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na_txn_flush_6b913090-6cc0-11eb-b66a-157691728e1b.log
> DEBUG [MemtableFlushWriter:1] 2021-02-11 23:25:25,926 ColumnFamilyStore.java:1176 - Flushed to [BigTableReader(path='/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-28-big-Data.db')] (1 sstables, 4.975KiB), biggest 4.975KiB, smallest 4.975KiB
> INFO [CompactionExecutor:3] 2021-02-11 23:25:25,927 CompactionTask.java:150 - Compacting (6b935370-6cc0-11eb-b66a-157691728e1b) [/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-27-big-Data.db:level=0, /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-28-big-Data.db:level=0, /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-26-big-Data.db:level=0, /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-25-big-Data.db:level=0, ]
> INFO [main] 2021-02-11 23:25:25,928 ColumnFamilyStore.java:2280 - Truncate of ks.tbl_slices is complete
> INFO [main] 2021-02-11 23:25:25,929 ColumnFamilyStore.java:857 - Enqueuing flush of tbl_slices: 0.614KiB (0%) on-heap, 0.005KiB (0%) off-heap
> INFO [PerDiskMemtableFlushWriter_0:2] 2021-02-11 23:25:25,933 Memtable.java:469 - Writing Memtable-tbl_slices@1281198511(0.008KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> INFO [PerDiskMemtableFlushWriter_0:2] 2021-02-11 23:25:25,934 Memtable.java:498 - Completed flushing /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/ks/tbl_slices-69ca53406cc011ebb66a157691728e1b/na-3-big-Data.db (0.041KiB) for commitlog position CommitLogPosition(segmentId=1613085922972, position=12552)
> INFO [MemtableFlushWriter:2] 2021-02-11 23:25:25,940 LogTransaction.java:240 - Unfinished transaction log, deleting /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/ks/tbl_slices-69ca53406cc011ebb66a157691728e1b/na_txn_flush_6b93a190-6cc0-11eb-b66a-157691728e1b.log
> DEBUG [MemtableFlushWriter:2] 2021-02-11 23:25:25,944 ColumnFamilyStore.java:1176 - Flushed to [BigTableReader(path='/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/ks/tbl_slices-69ca53406cc011ebb66a157691728e1b/na-3-big-Data.db')] (1 sstables, 4.912KiB), biggest 4.912KiB, smallest 4.912KiB
> INFO [CompactionExecutor:3] 2021-02-11 23:25:25,944 CompactionTask.java:245 - Compacted (6b935370-6cc0-11eb-b66a-157691728e1b) 4 sstables to [/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-29-big,] to level=0. 0.518KiB to 0.310KiB (~59% of original) in 16ms. Read Throughput = 32.118KiB/s, Write Throughput = 19.210KiB/s, Row Throughput = ~2/s. 4 total partitions merged to 1. Partition merge counts were {4:1, }
> INFO [main] 2021-02-11 23:25:25,946 ColumnFamilyStore.java:2221 - Truncating ks.tbl
> DEBUG [MemtablePostFlush:1] 2021-02-11 23:25:25,946 ColumnFamilyStore.java:912 - forceFlush requested but everything is clean in tbl
> INFO [main] 2021-02-11 23:25:25,946 ColumnFamilyStore.java:2256 - Truncating ks.tbl with truncatedAt=1613085925946
> DEBUG [MemtablePostFlush:1] 2021-02-11 23:25:25,946 ColumnFamilyStore.java:912 - forceFlush requested but everything is clean in tbl
> INFO [main] 2021-02-11 23:25:25,948 ColumnFamilyStore.java:857 - Enqueuing flush of local: 0.411KiB (0%) on-heap, 0.072KiB (0%) off-heap
> INFO [PerDiskMemtableFlushWriter_0:1] 2021-02-11 23:25:25,952 Memtable.java:469 - Writing Memtable-local@438700757(0.091KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> INFO [PerDiskMemtableFlushWriter_0:1] 2021-02-11 23:25:25,953 Memtable.java:498 - Completed flushing /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-30-big-Data.db (0.063KiB) for commitlog position CommitLogPosition(segmentId=1613085922972, position=12877)
> INFO [MemtableFlushWriter:1] 2021-02-11 23:25:25,958 LogTransaction.java:240 - Unfinished transaction log, deleting /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na_txn_flush_6b9687c0-6cc0-11eb-b66a-157691728e1b.log
> DEBUG [MemtableFlushWriter:1] 2021-02-11 23:25:25,961 ColumnFamilyStore.java:1176 - Flushed to [BigTableReader(path='/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-30-big-Data.db')] (1 sstables, 4.975KiB), biggest 4.975KiB, smallest 4.975KiB
> INFO [main] 2021-02-11 23:25:25,962 ColumnFamilyStore.java:2280 - Truncate of ks.tbl is complete
> INFO [main] 2021-02-11 23:25:25,962 ColumnFamilyStore.java:2221 - Truncating ks.tbl_slices
> DEBUG [MemtablePostFlush:1] 2021-02-11 23:25:25,962 ColumnFamilyStore.java:912 - forceFlush requested but everything is clean in tbl_slices
> INFO [main] 2021-02-11 23:25:25,963 ColumnFamilyStore.java:2256 - Truncating ks.tbl_slices with truncatedAt=1613085925962
> DEBUG [MemtablePostFlush:1] 2021-02-11 23:25:25,963 ColumnFamilyStore.java:912 - forceFlush requested but everything is clean in tbl_slices
> INFO [main] 2021-02-11 23:25:25,965 ColumnFamilyStore.java:2705 - Truncation is dropping 1 sstables and keeping 0 due to sstable.maxDataAge > truncatedAt
> INFO [main] 2021-02-11 23:25:25,970 ColumnFamilyStore.java:857 - Enqueuing flush of local: 0.411KiB (0%) on-heap, 0.072KiB (0%) off-heap
> INFO [PerDiskMemtableFlushWriter_0:2] 2021-02-11 23:25:25,976 Memtable.java:469 - Writing Memtable-local@920388720(0.091KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> INFO [PerDiskMemtableFlushWriter_0:2] 2021-02-11 23:25:25,977 Memtable.java:498 - Completed flushing /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-31-big-Data.db (0.063KiB) for commitlog position CommitLogPosition(segmentId=1613085922972, position=12988)
> INFO [MemtableFlushWriter:2] 2021-02-11 23:25:25,985 LogTransaction.java:240 - Unfinished transaction log, deleting /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na_txn_flush_6b99e320-6cc0-11eb-b66a-157691728e1b.log
> DEBUG [MemtableFlushWriter:2] 2021-02-11 23:25:25,988 ColumnFamilyStore.java:1176 - Flushed to [BigTableReader(path='/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-31-big-Data.db')] (1 sstables, 4.975KiB), biggest 4.975KiB, smallest 4.975KiB
> INFO [main] 2021-02-11 23:25:25,990 ColumnFamilyStore.java:2280 - Truncate of ks.tbl_slices is complete
> INFO [MigrationStage:1] 2021-02-11 23:25:25,998 ColumnFamilyStore.java:857 - Enqueuing flush of columns: 1.216KiB (0%) on-heap, 0.637KiB (0%) off-heap
> INFO [PerDiskMemtableFlushWriter_0:1] 2021-02-11 23:25:26,003 Memtable.java:469 - Writing Memtable-columns@1439315649(0.588KiB serialized bytes, 4 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> INFO [PerDiskMemtableFlushWriter_0:1] 2021-02-11 23:25:26,004 Memtable.java:498 - Completed flushing /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-6-big-Data.db (0.265KiB) for commitlog position CommitLogPosition(segmentId=1613085922972, position=14250)
> INFO [MemtableFlushWriter:1] 2021-02-11 23:25:26,013 LogTransaction.java:240 - Unfinished transaction log, deleting /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na_txn_flush_6b9e28e0-6cc0-11eb-b66a-157691728e1b.log
> DEBUG [MemtableFlushWriter:1] 2021-02-11 23:25:26,016 ColumnFamilyStore.java:1176 - Flushed to [BigTableReader(path='/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system_schema/columns-24101c25a2ae3af787c1b40ee1aca33f/na-6-big-Data.db')] (1 sstables, 5.310KiB), biggest 5.310KiB, smallest 5.310KiB
> DEBUG [MemtablePostFlush:1] 2021-02-11 23:25:26,017 ColumnFamilyStore.java:912 - forceFlush requested but everything is clean in dropped_columns
> DEBUG [MemtablePostFlush:1] 2021-02-11 23:25:26,017 ColumnFamilyStore.java:912 - forceFlush requested but everything is clean in triggers
> DEBUG [MemtablePostFlush:1] 2021-02-11 23:25:26,017 ColumnFamilyStore.java:912 - forceFlush requested but everything is clean in types
> DEBUG [MemtablePostFlush:1] 2021-02-11 23:25:26,017 ColumnFamilyStore.java:912 - forceFlush requested but everything is clean in functions
> DEBUG [MemtablePostFlush:1] 2021-02-11 23:25:26,017 ColumnFamilyStore.java:912 - forceFlush requested but everything is clean in aggregates
> DEBUG [MemtablePostFlush:1] 2021-02-11 23:25:26,017 ColumnFamilyStore.java:912 - forceFlush requested but everything is clean in indexes
> INFO [MigrationStage:1] 2021-02-11 23:25:26,018 ColumnFamilyStore.java:857 - Enqueuing flush of tables: 0.880KiB (0%) on-heap, 0.784KiB (0%) off-heap
> INFO [PerDiskMemtableFlushWriter_0:2] 2021-02-11 23:25:26,024 Memtable.java:469 - Writing Memtable-tables@447275433(0.707KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> INFO [PerDiskMemtableFlushWriter_0:2] 2021-02-11 23:25:26,025 Memtable.java:498 - Completed flushing /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-6-big-Data.db (0.432KiB) for commitlog position CommitLogPosition(segmentId=1613085922972, position=14250)
> INFO [MemtableFlushWriter:2] 2021-02-11 23:25:26,032 LogTransaction.java:240 - Unfinished transaction log, deleting /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na_txn_flush_6ba13620-6cc0-11eb-b66a-157691728e1b.log
> DEBUG [MemtableFlushWriter:2] 2021-02-11 23:25:26,035 ColumnFamilyStore.java:1176 - Flushed to [BigTableReader(path='/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system_schema/tables-afddfb9dbc1e30688056eed6c302ba09/na-6-big-Data.db')] (1 sstables, 6.864KiB), biggest 6.864KiB, smallest 6.864KiB
> DEBUG [MemtablePostFlush:1] 2021-02-11 23:25:26,036 ColumnFamilyStore.java:912 - forceFlush requested but everything is clean in views
> INFO [MigrationStage:1] 2021-02-11 23:25:26,036 ColumnFamilyStore.java:857 - Enqueuing flush of keyspaces: 0.419KiB (0%) on-heap, 0.137KiB (0%) off-heap
> INFO [PerDiskMemtableFlushWriter_0:1] 2021-02-11 23:25:26,041 Memtable.java:469 - Writing Memtable-keyspaces@99069000(0.146KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> INFO [PerDiskMemtableFlushWriter_0:1] 2021-02-11 23:25:26,042 Memtable.java:498 - Completed flushing /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-6-big-Data.db (0.109KiB) for commitlog position CommitLogPosition(segmentId=1613085922972, position=14250)
> INFO [MemtableFlushWriter:1] 2021-02-11 23:25:26,054 LogTransaction.java:240 - Unfinished transaction log, deleting /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na_txn_flush_6ba3f540-6cc0-11eb-b66a-157691728e1b.log
> DEBUG [MemtableFlushWriter:1] 2021-02-11 23:25:26,056 ColumnFamilyStore.java:1176 - Flushed to [BigTableReader(path='/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system_schema/keyspaces-abac5682dea631c5b535b3d6cffd0fb6/na-6-big-Data.db')] (1 sstables, 5.109KiB), biggest 5.109KiB, smallest 5.109KiB
> INFO [MigrationStage:1] 2021-02-11 23:25:26,057 Keyspace.java:386 - Creating replication strategy ks params KeyspaceParams{durable_writes=true, replication=ReplicationParams{class=org.apache.cassandra.locator.SimpleStrategy, replication_factor=1}}
> INFO [MigrationStage:1] 2021-02-11 23:25:26,058 ColumnFamilyStore.java:385 - Initializing ks.partition_range_deletion
> INFO [MigrationStage:1] 2021-02-11 23:25:26,061 ViewManager.java:125 - Not submitting build tasks for views in keyspace ks as storage service is not initialized
> INFO [main] 2021-02-11 23:25:26,077 ColumnFamilyStore.java:2221 - Truncating ks.partition_range_deletion
> DEBUG [MemtablePostFlush:1] 2021-02-11 23:25:26,077 ColumnFamilyStore.java:912 - forceFlush requested but everything is clean in partition_range_deletion
> INFO [main] 2021-02-11 23:25:26,077 ColumnFamilyStore.java:2256 - Truncating ks.partition_range_deletion with truncatedAt=1613085926077
> DEBUG [MemtablePostFlush:1] 2021-02-11 23:25:26,078 ColumnFamilyStore.java:912 - forceFlush requested but everything is clean in partition_range_deletion
> INFO [main] 2021-02-11 23:25:26,082 ColumnFamilyStore.java:857 - Enqueuing flush of local: 0.466KiB (0%) on-heap, 0.148KiB (0%) off-heap
> INFO [PerDiskMemtableFlushWriter_0:2] 2021-02-11 23:25:26,089 Memtable.java:469 - Writing Memtable-local@1979840727(0.122KiB serialized bytes, 2 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> INFO [PerDiskMemtableFlushWriter_0:2] 2021-02-11 23:25:26,089 Memtable.java:498 - Completed flushing /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-32-big-Data.db (0.081KiB) for commitlog position CommitLogPosition(segmentId=1613085922972, position=14451)
> INFO [MemtableFlushWriter:2] 2021-02-11 23:25:26,099 LogTransaction.java:240 - Unfinished transaction log, deleting /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na_txn_flush_6baafa20-6cc0-11eb-b66a-157691728e1b.log
> DEBUG [MemtableFlushWriter:2] 2021-02-11 23:25:26,102 ColumnFamilyStore.java:1176 - Flushed to [BigTableReader(path='/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-32-big-Data.db')] (1 sstables, 5.048KiB), biggest 5.048KiB, smallest 5.048KiB
> INFO [CompactionExecutor:2] 2021-02-11 23:25:26,102 CompactionTask.java:150 - Compacting (6bae0760-6cc0-11eb-b66a-157691728e1b) [/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-32-big-Data.db:level=0, /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-31-big-Data.db:level=0, /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-30-big-Data.db:level=0, /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-29-big-Data.db:level=0, ]
> INFO [main] 2021-02-11 23:25:26,105 ColumnFamilyStore.java:2280 - Truncate of ks.partition_range_deletion is complete
> INFO [main] 2021-02-11 23:25:26,111 ColumnFamilyStore.java:2221 - Truncating ks.partition_range_deletion
> INFO [main] 2021-02-11 23:25:26,111 ColumnFamilyStore.java:857 - Enqueuing flush of partition_range_deletion: 0.810KiB (0%) on-heap, 0.049KiB (0%) off-heap
> INFO [PerDiskMemtableFlushWriter_0:1] 2021-02-11 23:25:26,116 Memtable.java:469 - Writing Memtable-partition_range_deletion@441699661(0.056KiB serialized bytes, 3 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> INFO [PerDiskMemtableFlushWriter_0:1] 2021-02-11 23:25:26,118 Memtable.java:498 - Completed flushing /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/ks/partition_range_deletion-6b9d17706cc011ebb66a157691728e1b/na-1-big-Data.db (0.036KiB) for commitlog position CommitLogPosition(segmentId=1613085922972, position=14670)
> INFO [CompactionExecutor:2] 2021-02-11 23:25:26,119 CompactionTask.java:245 - Compacted (6bae0760-6cc0-11eb-b66a-157691728e1b) 4 sstables to [/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-33-big,] to level=0. 0.536KiB to 0.329KiB (~61% of original) in 15ms. Read Throughput = 34.106KiB/s, Write Throughput = 20.936KiB/s, Row Throughput = ~2/s. 4 total partitions merged to 1. Partition merge counts were {4:1, }
> INFO [MemtableFlushWriter:1] 2021-02-11 23:25:26,126 LogTransaction.java:240 - Unfinished transaction log, deleting /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/ks/partition_range_deletion-6b9d17706cc011ebb66a157691728e1b/na_txn_flush_6baf8e00-6cc0-11eb-b66a-157691728e1b.log
> DEBUG [MemtableFlushWriter:1] 2021-02-11 23:25:26,129 ColumnFamilyStore.java:1176 - Flushed to [BigTableReader(path='/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/ks/partition_range_deletion-6b9d17706cc011ebb66a157691728e1b/na-1-big-Data.db')] (1 sstables, 4.978KiB), biggest 4.978KiB, smallest 4.978KiB
> INFO [main] 2021-02-11 23:25:26,129 ColumnFamilyStore.java:2256 - Truncating ks.partition_range_deletion with truncatedAt=1613085926129
> DEBUG [MemtablePostFlush:1] 2021-02-11 23:25:26,129 ColumnFamilyStore.java:912 - forceFlush requested but everything is clean in partition_range_deletion
> INFO [main] 2021-02-11 23:25:26,132 ColumnFamilyStore.java:2705 - Truncation is dropping 1 sstables and keeping 0 due to sstable.maxDataAge > truncatedAt
> INFO [main] 2021-02-11 23:25:26,138 ColumnFamilyStore.java:857 - Enqueuing flush of local: 0.411KiB (0%) on-heap, 0.072KiB (0%) off-heap
> INFO [PerDiskMemtableFlushWriter_0:2] 2021-02-11 23:25:26,143 Memtable.java:469 - Writing Memtable-local@1446053705(0.091KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> INFO [PerDiskMemtableFlushWriter_0:2] 2021-02-11 23:25:26,143 Memtable.java:498 - Completed flushing /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-34-big-Data.db (0.063KiB) for commitlog position CommitLogPosition(segmentId=1613085922972, position=14995)
> INFO [MemtableFlushWriter:2] 2021-02-11 23:25:26,151 LogTransaction.java:240 - Unfinished transaction log, deleting /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na_txn_flush_6bb385a0-6cc0-11eb-b66a-157691728e1b.log
> DEBUG [MemtableFlushWriter:2] 2021-02-11 23:25:26,154 ColumnFamilyStore.java:1176 - Flushed to [BigTableReader(path='/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-34-big-Data.db')] (1 sstables, 4.974KiB), biggest 4.974KiB, smallest 4.974KiB
> INFO [main] 2021-02-11 23:25:26,156 ColumnFamilyStore.java:2280 - Truncate of ks.partition_range_deletion is complete
> INFO [main] 2021-02-11 23:25:26,158 ColumnFamilyStore.java:857 - Enqueuing flush of partition_range_deletion: 0.638KiB (0%) on-heap, 0.008KiB (0%) off-heap
> INFO [PerDiskMemtableFlushWriter_0:1] 2021-02-11 23:25:26,163 Memtable.java:469 - Writing Memtable-partition_range_deletion@814287984(0.008KiB serialized bytes, 2 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> INFO [PerDiskMemtableFlushWriter_0:1] 2021-02-11 23:25:26,164 Memtable.java:498 - Completed flushing /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/ks/partition_range_deletion-6b9d17706cc011ebb66a157691728e1b/na-2-big-Data.db (0.019KiB) for commitlog position CommitLogPosition(segmentId=1613085922972, position=15139)
> INFO [MemtableFlushWriter:1] 2021-02-11 23:25:26,172 LogTransaction.java:240 - Unfinished transaction log, deleting /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/ks/partition_range_deletion-6b9d17706cc011ebb66a157691728e1b/na_txn_flush_6bb6b9f0-6cc0-11eb-b66a-157691728e1b.log
> DEBUG [MemtableFlushWriter:1] 2021-02-11 23:25:26,175 ColumnFamilyStore.java:1176 - Flushed to [BigTableReader(path='/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/ks/partition_range_deletion-6b9d17706cc011ebb66a157691728e1b/na-2-big-Data.db')] (1 sstables, 4.898KiB), biggest 4.898KiB, smallest 4.898KiB
> INFO [main] 2021-02-11 23:25:26,177 ColumnFamilyStore.java:857 - Enqueuing flush of partition_range_deletion: 0.388KiB (0%) on-heap, 0.049KiB (0%) off-heap
> INFO [PerDiskMemtableFlushWriter_0:2] 2021-02-11 23:25:26,181 Memtable.java:469 - Writing Memtable-partition_range_deletion@1599099(0.056KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> INFO [PerDiskMemtableFlushWriter_0:2] 2021-02-11 23:25:26,182 Memtable.java:498 - Completed flushing /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/ks/partition_range_deletion-6b9d17706cc011ebb66a157691728e1b/na-3-big-Data.db (0.036KiB) for commitlog position CommitLogPosition(segmentId=1613085922972, position=15214)
> INFO [MemtableFlushWriter:2] 2021-02-11 23:25:26,190 LogTransaction.java:240 - Unfinished transaction log, deleting /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/ks/partition_range_deletion-6b9d17706cc011ebb66a157691728e1b/na_txn_flush_6bb97910-6cc0-11eb-b66a-157691728e1b.log
> DEBUG [MemtableFlushWriter:2] 2021-02-11 23:25:26,192 ColumnFamilyStore.java:1176 - Flushed to [BigTableReader(path='/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/ks/partition_range_deletion-6b9d17706cc011ebb66a157691728e1b/na-3-big-Data.db')] (1 sstables, 4.958KiB), biggest 4.958KiB, smallest 4.958KiB
> INFO [CompactionExecutor:1] 2021-02-11 23:25:26,194 CompactionTask.java:150 - Compacting (6bbbea10-6cc0-11eb-b66a-157691728e1b) [/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/ks/partition_range_deletion-6b9d17706cc011ebb66a157691728e1b/na-3-big-Data.db:level=0, /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/ks/partition_range_deletion-6b9d17706cc011ebb66a157691728e1b/na-2-big-Data.db:level=0, ]
> INFO [CompactionExecutor:1] 2021-02-11 23:25:26,209 CompactionTask.java:245 - Compacted (6bbbea10-6cc0-11eb-b66a-157691728e1b) 2 sstables to [/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/ks/partition_range_deletion-6b9d17706cc011ebb66a157691728e1b/na-4-big,] to level=0. 0.068KiB to 0.040KiB (~58% of original) in 14ms. Read Throughput = 4.824KiB/s, Write Throughput = 2.825KiB/s, Row Throughput = ~2/s. 2 total partitions merged to 1. Partition merge counts were {2:1, }
> INFO [main] 2021-02-11 23:25:26,211 ColumnFamilyStore.java:2221 - Truncating ks.partition_range_deletion
> DEBUG [MemtablePostFlush:1] 2021-02-11 23:25:26,212 ColumnFamilyStore.java:912 - forceFlush requested but everything is clean in partition_range_deletion
> INFO [main] 2021-02-11 23:25:26,212 ColumnFamilyStore.java:2256 - Truncating ks.partition_range_deletion with truncatedAt=1613085926212
> DEBUG [MemtablePostFlush:1] 2021-02-11 23:25:26,212 ColumnFamilyStore.java:912 - forceFlush requested but everything is clean in partition_range_deletion
> INFO [main] 2021-02-11 23:25:26,214 ColumnFamilyStore.java:2705 - Truncation is dropping 1 sstables and keeping 0 due to sstable.maxDataAge > truncatedAt
> INFO [main] 2021-02-11 23:25:26,220 ColumnFamilyStore.java:857 - Enqueuing flush of local: 0.411KiB (0%) on-heap, 0.072KiB (0%) off-heap
> INFO [PerDiskMemtableFlushWriter_0:1] 2021-02-11 23:25:26,224 Memtable.java:469 - Writing Memtable-local@888227998(0.091KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> INFO [PerDiskMemtableFlushWriter_0:1] 2021-02-11 23:25:26,225 Memtable.java:498 - Completed flushing /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-35-big-Data.db (0.063KiB) for commitlog position CommitLogPosition(segmentId=1613085922972, position=15554)
> INFO [MemtableFlushWriter:1] 2021-02-11 23:25:26,232 LogTransaction.java:240 - Unfinished transaction log, deleting /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na_txn_flush_6bc008c0-6cc0-11eb-b66a-157691728e1b.log
> DEBUG [MemtableFlushWriter:1] 2021-02-11 23:25:26,235 ColumnFamilyStore.java:1176 - Flushed to [BigTableReader(path='/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-35-big-Data.db')] (1 sstables, 4.975KiB), biggest 4.975KiB, smallest 4.975KiB
> INFO [main] 2021-02-11 23:25:26,237 ColumnFamilyStore.java:2280 - Truncate of ks.partition_range_deletion is complete
> INFO [main] 2021-02-11 23:25:26,238 ColumnFamilyStore.java:857 - Enqueuing flush of partition_range_deletion: 0.263KiB (0%) on-heap, 0.008KiB (0%) off-heap
> INFO [PerDiskMemtableFlushWriter_0:2] 2021-02-11 23:25:26,243 Memtable.java:469 - Writing Memtable-partition_range_deletion@1566599800(0.008KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> INFO [PerDiskMemtableFlushWriter_0:2] 2021-02-11 23:25:26,244 Memtable.java:498 - Completed flushing /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/ks/partition_range_deletion-6b9d17706cc011ebb66a157691728e1b/na-5-big-Data.db (0.019KiB) for commitlog position CommitLogPosition(segmentId=1613085922972, position=15616)
> INFO [MemtableFlushWriter:2] 2021-02-11 23:25:26,254 LogTransaction.java:240 - Unfinished transaction log, deleting /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/ks/partition_range_deletion-6b9d17706cc011ebb66a157691728e1b/na_txn_flush_6bc2eef0-6cc0-11eb-b66a-157691728e1b.log
> DEBUG [MemtableFlushWriter:2] 2021-02-11 23:25:26,259 ColumnFamilyStore.java:1176 - Flushed to [BigTableReader(path='/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/ks/partition_range_deletion-6b9d17706cc011ebb66a157691728e1b/na-5-big-Data.db')] (1 sstables, 4.898KiB), biggest 4.898KiB, smallest 4.898KiB
> INFO [main] 2021-02-11 23:25:26,261 ColumnFamilyStore.java:857 - Enqueuing flush of partition_range_deletion: 0.614KiB (0%) on-heap, 0.008KiB (0%) off-heap
> INFO [PerDiskMemtableFlushWriter_0:1] 2021-02-11 23:25:26,267 Memtable.java:469 - Writing Memtable-partition_range_deletion@206317476(0.008KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> INFO [PerDiskMemtableFlushWriter_0:1] 2021-02-11 23:25:26,267 Memtable.java:498 - Completed flushing /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/ks/partition_range_deletion-6b9d17706cc011ebb66a157691728e1b/na-6-big-Data.db (0.044KiB) for commitlog position CommitLogPosition(segmentId=1613085922972, position=15698)
> INFO [MemtableFlushWriter:1] 2021-02-11 23:25:26,276 LogTransaction.java:240 - Unfinished transaction log, deleting /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/ks/partition_range_deletion-6b9d17706cc011ebb66a157691728e1b/na_txn_flush_6bc67160-6cc0-11eb-b66a-157691728e1b.log
> DEBUG [MemtableFlushWriter:1] 2021-02-11 23:25:26,280 ColumnFamilyStore.java:1176 - Flushed to [BigTableReader(path='/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/ks/partition_range_deletion-6b9d17706cc011ebb66a157691728e1b/na-6-big-Data.db')] (1 sstables, 4.928KiB), biggest 4.928KiB, smallest 4.928KiB
> INFO [main] 2021-02-11 23:25:26,282 ColumnFamilyStore.java:857 - Enqueuing flush of partition_range_deletion: 0.388KiB (0%) on-heap, 0.049KiB (0%) off-heap
> INFO [PerDiskMemtableFlushWriter_0:2] 2021-02-11 23:25:26,287 Memtable.java:469 - Writing Memtable-partition_range_deletion@610203203(0.056KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> INFO [PerDiskMemtableFlushWriter_0:2] 2021-02-11 23:25:26,287 Memtable.java:498 - Completed flushing /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/ks/partition_range_deletion-6b9d17706cc011ebb66a157691728e1b/na-7-big-Data.db (0.036KiB) for commitlog position CommitLogPosition(segmentId=1613085922972, position=15773)
> INFO [MemtableFlushWriter:2] 2021-02-11 23:25:26,297 LogTransaction.java:240 - Unfinished transaction log, deleting /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/ks/partition_range_deletion-6b9d17706cc011ebb66a157691728e1b/na_txn_flush_6bc97ea0-6cc0-11eb-b66a-157691728e1b.log
> DEBUG [MemtableFlushWriter:2] 2021-02-11 23:25:26,299 ColumnFamilyStore.java:1176 - Flushed to [BigTableReader(path='/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/ks/partition_range_deletion-6b9d17706cc011ebb66a157691728e1b/na-7-big-Data.db')] (1 sstables, 4.958KiB), biggest 4.958KiB, smallest 4.958KiB
> INFO [CompactionExecutor:2] 2021-02-11 23:25:26,301 CompactionTask.java:150 - Compacting (6bcc3dc0-6cc0-11eb-b66a-157691728e1b) [/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/ks/partition_range_deletion-6b9d17706cc011ebb66a157691728e1b/na-5-big-Data.db:level=0, /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/ks/partition_range_deletion-6b9d17706cc011ebb66a157691728e1b/na-6-big-Data.db:level=0, /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/ks/partition_range_deletion-6b9d17706cc011ebb66a157691728e1b/na-7-big-Data.db:level=0, ]
> INFO [CompactionExecutor:2] 2021-02-11 23:25:26,319 CompactionTask.java:245 - Compacted (6bcc3dc0-6cc0-11eb-b66a-157691728e1b) 3 sstables to [/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/ks/partition_range_deletion-6b9d17706cc011ebb66a157691728e1b/na-8-big,] to level=0. 0.113KiB to 0.040KiB (~35% of original) in 17ms. Read Throughput = 6.643KiB/s, Write Throughput = 2.348KiB/s, Row Throughput = ~2/s. 3 total partitions merged to 1. Partition merge counts were {3:1, }
> INFO [main] 2021-02-11 23:25:26,323 ColumnFamilyStore.java:2221 - Truncating ks.tbl
> DEBUG [MemtablePostFlush:1] 2021-02-11 23:25:26,323 ColumnFamilyStore.java:912 - forceFlush requested but everything is clean in tbl
> INFO [main] 2021-02-11 23:25:26,324 ColumnFamilyStore.java:2256 - Truncating ks.tbl with truncatedAt=1613085926323
> DEBUG [MemtablePostFlush:1] 2021-02-11 23:25:26,324 ColumnFamilyStore.java:912 - forceFlush requested but everything is clean in tbl
> INFO [main] 2021-02-11 23:25:26,326 ColumnFamilyStore.java:857 - Enqueuing flush of local: 0.411KiB (0%) on-heap, 0.072KiB (0%) off-heap
> INFO [PerDiskMemtableFlushWriter_0:1] 2021-02-11 23:25:26,331 Memtable.java:469 - Writing Memtable-local@141671109(0.091KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> INFO [PerDiskMemtableFlushWriter_0:1] 2021-02-11 23:25:26,332 Memtable.java:498 - Completed flushing /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-36-big-Data.db (0.063KiB) for commitlog position CommitLogPosition(segmentId=1613085922972, position=16113)
> INFO [MemtableFlushWriter:1] 2021-02-11 23:25:26,340 LogTransaction.java:240 - Unfinished transaction log, deleting /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na_txn_flush_6bd03560-6cc0-11eb-b66a-157691728e1b.log
> DEBUG [MemtableFlushWriter:1] 2021-02-11 23:25:26,343 ColumnFamilyStore.java:1176 - Flushed to [BigTableReader(path='/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-36-big-Data.db')] (1 sstables, 4.975KiB), biggest 4.975KiB, smallest 4.975KiB
> INFO [CompactionExecutor:3] 2021-02-11 23:25:26,344 CompactionTask.java:150 - Compacting (6bd2cd70-6cc0-11eb-b66a-157691728e1b) [/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-34-big-Data.db:level=0, /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-33-big-Data.db:level=0, /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-35-big-Data.db:level=0, /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-36-big-Data.db:level=0, ]
> INFO [main] 2021-02-11 23:25:26,344 ColumnFamilyStore.java:2280 - Truncate of ks.tbl is complete
> INFO [main] 2021-02-11 23:25:26,344 ColumnFamilyStore.java:2221 - Truncating ks.tbl_slices
> DEBUG [MemtablePostFlush:1] 2021-02-11 23:25:26,345 ColumnFamilyStore.java:912 - forceFlush requested but everything is clean in tbl_slices
> INFO [main] 2021-02-11 23:25:26,345 ColumnFamilyStore.java:2256 - Truncating ks.tbl_slices with truncatedAt=1613085926345
> DEBUG [MemtablePostFlush:1] 2021-02-11 23:25:26,345 ColumnFamilyStore.java:912 - forceFlush requested but everything is clean in tbl_slices
> INFO [main] 2021-02-11 23:25:26,347 ColumnFamilyStore.java:857 - Enqueuing flush of local: 0.411KiB (0%) on-heap, 0.072KiB (0%) off-heap
> INFO [PerDiskMemtableFlushWriter_0:2] 2021-02-11 23:25:26,353 Memtable.java:469 - Writing Memtable-local@2047588046(0.091KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> INFO [PerDiskMemtableFlushWriter_0:2] 2021-02-11 23:25:26,354 Memtable.java:498 - Completed flushing /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-37-big-Data.db (0.063KiB) for commitlog position CommitLogPosition(segmentId=1613085922972, position=16224)
> INFO [MemtableFlushWriter:2] 2021-02-11 23:25:26,363 LogTransaction.java:240 - Unfinished transaction log, deleting /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na_txn_flush_6bd390c0-6cc0-11eb-b66a-157691728e1b.log
> INFO [CompactionExecutor:3] 2021-02-11 23:25:26,366 CompactionTask.java:245 - Compacted (6bd2cd70-6cc0-11eb-b66a-157691728e1b) 4 sstables to [/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-38-big,] to level=0. 0.537KiB to 0.330KiB (~61% of original) in 20ms. Read Throughput = 26.729KiB/s, Write Throughput = 16.427KiB/s, Row Throughput = ~2/s. 4 total partitions merged to 1. Partition merge counts were {4:1, }
> DEBUG [MemtableFlushWriter:2] 2021-02-11 23:25:26,366 ColumnFamilyStore.java:1176 - Flushed to [BigTableReader(path='/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-37-big-Data.db')] (1 sstables, 4.974KiB), biggest 4.974KiB, smallest 4.974KiB
> INFO [main] 2021-02-11 23:25:26,368 ColumnFamilyStore.java:2280 - Truncate of ks.tbl_slices is complete
> INFO [main] 2021-02-11 23:25:26,371 ColumnFamilyStore.java:2221 - Truncating ks.tbl
> DEBUG [MemtablePostFlush:1] 2021-02-11 23:25:26,372 ColumnFamilyStore.java:912 - forceFlush requested but everything is clean in tbl
> INFO [main] 2021-02-11 23:25:26,372 ColumnFamilyStore.java:2256 - Truncating ks.tbl with truncatedAt=1613085926372
> DEBUG [MemtablePostFlush:1] 2021-02-11 23:25:26,372 ColumnFamilyStore.java:912 - forceFlush requested but everything is clean in tbl
> INFO [main] 2021-02-11 23:25:26,374 ColumnFamilyStore.java:857 - Enqueuing flush of local: 0.411KiB (0%) on-heap, 0.072KiB (0%) off-heap
> INFO [PerDiskMemtableFlushWriter_0:1] 2021-02-11 23:25:26,379 Memtable.java:469 - Writing Memtable-local@1893981495(0.091KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> INFO [PerDiskMemtableFlushWriter_0:1] 2021-02-11 23:25:26,380 Memtable.java:498 - Completed flushing /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-39-big-Data.db (0.063KiB) for commitlog position CommitLogPosition(segmentId=1613085922972, position=16628)
> INFO [MemtableFlushWriter:1] 2021-02-11 23:25:26,386 LogTransaction.java:240 - Unfinished transaction log, deleting /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na_txn_flush_6bd7af70-6cc0-11eb-b66a-157691728e1b.log
> DEBUG [MemtableFlushWriter:1] 2021-02-11 23:25:26,389 ColumnFamilyStore.java:1176 - Flushed to [BigTableReader(path='/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-39-big-Data.db')] (1 sstables, 4.975KiB), biggest 4.975KiB, smallest 4.975KiB
> INFO [main] 2021-02-11 23:25:26,391 ColumnFamilyStore.java:2280 - Truncate of ks.tbl is complete
> INFO [main] 2021-02-11 23:25:26,391 ColumnFamilyStore.java:2221 - Truncating ks.tbl_slices
> INFO [main] 2021-02-11 23:25:26,391 ColumnFamilyStore.java:857 - Enqueuing flush of tbl_slices: 0.614KiB (0%) on-heap, 0.005KiB (0%) off-heap
> INFO [PerDiskMemtableFlushWriter_0:2] 2021-02-11 23:25:26,402 Memtable.java:469 - Writing Memtable-tbl_slices@971189322(0.008KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> INFO [PerDiskMemtableFlushWriter_0:2] 2021-02-11 23:25:26,403 Memtable.java:498 - Completed flushing /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/ks/tbl_slices-69ca53406cc011ebb66a157691728e1b/na-4-big-Data.db (0.041KiB) for commitlog position CommitLogPosition(segmentId=1613085922972, position=16628)
> INFO [MemtableFlushWriter:2] 2021-02-11 23:25:26,408 LogTransaction.java:240 - Unfinished transaction log, deleting /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/ks/tbl_slices-69ca53406cc011ebb66a157691728e1b/na_txn_flush_6bda2070-6cc0-11eb-b66a-157691728e1b.log
> DEBUG [MemtableFlushWriter:2] 2021-02-11 23:25:26,411 ColumnFamilyStore.java:1176 - Flushed to [BigTableReader(path='/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/ks/tbl_slices-69ca53406cc011ebb66a157691728e1b/na-4-big-Data.db')] (1 sstables, 4.912KiB), biggest 4.912KiB, smallest 4.912KiB
> INFO [main] 2021-02-11 23:25:26,411 ColumnFamilyStore.java:2256 - Truncating ks.tbl_slices with truncatedAt=1613085926411
> DEBUG [MemtablePostFlush:1] 2021-02-11 23:25:26,411 ColumnFamilyStore.java:912 - forceFlush requested but everything is clean in tbl_slices
> INFO [main] 2021-02-11 23:25:26,414 ColumnFamilyStore.java:2705 - Truncation is dropping 1 sstables and keeping 0 due to sstable.maxDataAge > truncatedAt
> INFO [main] 2021-02-11 23:25:26,418 ColumnFamilyStore.java:857 - Enqueuing flush of local: 0.411KiB (0%) on-heap, 0.072KiB (0%) off-heap
> INFO [PerDiskMemtableFlushWriter_0:1] 2021-02-11 23:25:26,424 Memtable.java:469 - Writing Memtable-local@1323884045(0.091KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit), flushed range = (null, null]
> INFO [PerDiskMemtableFlushWriter_0:1] 2021-02-11 23:25:26,424 Memtable.java:498 - Completed flushing /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-40-big-Data.db (0.063KiB) for commitlog position CommitLogPosition(segmentId=1613085922972, position=16739)
> INFO [MemtableFlushWriter:1] 2021-02-11 23:25:26,437 LogTransaction.java:240 - Unfinished transaction log, deleting /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na_txn_flush_6bde6630-6cc0-11eb-b66a-157691728e1b.log
> DEBUG [MemtableFlushWriter:1] 2021-02-11 23:25:26,439 ColumnFamilyStore.java:1176 - Flushed to [BigTableReader(path='/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-40-big-Data.db')] (1 sstables, 4.975KiB), biggest 4.975KiB, smallest 4.975KiB
> INFO [CompactionExecutor:1] 2021-02-11 23:25:26,441 CompactionTask.java:150 - Compacting (6be19a80-6cc0-11eb-b66a-157691728e1b) [/home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-39-big-Data.db:level=0, /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-40-big-Data.db:level=0, /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-38-big-Data.db:level=0, /home/jenkins/jenkins-slave/workspace/Cassandra-devbranch-test/jdk/jdk_11_latest/label/cassandra/build/test/cassandra/data:176/system/local-7ad54392bcdd35a684174e047860b377/na-37-big-Data.db:level=0, ]
> INFO [main] 2021-02-11 23:25:26,441 ColumnFamilyStore.java:2280 - Truncate of ks.tbl_slices is complete
> {code}
--
This message was sent by Atlassian Jira
(v8.3.4#803005)
---------------------------------------------------------------------
To unsubscribe, e-mail: commits-unsubscribe@cassandra.apache.org
For additional commands, e-mail: commits-help@cassandra.apache.org