You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@hbase.apache.org by "Zheng Hu (Jira)" <ji...@apache.org> on 2019/09/09 08:40:00 UTC

[jira] [Updated] (HBASE-22995) The TestHRegionWithInMemoryFlush is broken

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

Zheng Hu updated HBASE-22995:
-----------------------------
    Description: 
{code}
2019-09-09 15:40:58,764 INFO  [Time-limited test] regionserver.HRegion(1038): Opened 9669fa00ab90e206bb967cd27169d0e5; next sequenceid=2
2019-09-09 15:40:58,771 INFO  [PutThread] regionserver.HRegion(8489): writing data to region testWritesWhileScanning,,1568014858732.9669fa00ab90e206bb967cd27169d0e5. with WAL disabled. Data may be lost in the event of a crash.
Exception in thread "PutThread" java.lang.NullPointerException
        at org.apache.hadoop.hbase.regionserver.MemStoreLABImpl.getOrMakeChunk(MemStoreLABImpl.java:334)
        at org.apache.hadoop.hbase.regionserver.MemStoreLABImpl.copyCellInto(MemStoreLABImpl.java:193)
        at org.apache.hadoop.hbase.regionserver.MemStoreLABImpl.copyCellInto(MemStoreLABImpl.java:115)
        at org.apache.hadoop.hbase.regionserver.Segment.maybeCloneWithAllocator(Segment.java:176)
        at org.apache.hadoop.hbase.regionserver.AbstractMemStore.maybeCloneWithAllocator(AbstractMemStore.java:334)
        at org.apache.hadoop.hbase.regionserver.AbstractMemStore.doAdd(AbstractMemStore.java:157)
        at org.apache.hadoop.hbase.regionserver.AbstractMemStore.doAddOrUpsert(AbstractMemStore.java:147)
        at org.apache.hadoop.hbase.regionserver.AbstractMemStore.add(AbstractMemStore.java:117)
        at org.apache.hadoop.hbase.regionserver.AbstractMemStore.add(AbstractMemStore.java:111)
        at org.apache.hadoop.hbase.regionserver.HStore.add(HStore.java:771)
        at org.apache.hadoop.hbase.regionserver.HRegion.applyToMemStore(HRegion.java:4474)
        at org.apache.hadoop.hbase.regionserver.HRegion.access$500(HRegion.java:228)
        at org.apache.hadoop.hbase.regionserver.HRegion$BatchOperation.applyFamilyMapToMemStore(HRegion.java:3533)
        at org.apache.hadoop.hbase.regionserver.HRegion$BatchOperation.lambda$writeMiniBatchOperationsToMemStore$0(HRegion.java:3224)
        at org.apache.hadoop.hbase.regionserver.HRegion$BatchOperation.visitBatchOperations(HRegion.java:3157)
        at org.apache.hadoop.hbase.regionserver.HRegion$BatchOperation.writeMiniBatchOperationsToMemStore(HRegion.java:3216)
        at org.apache.hadoop.hbase.regionserver.HRegion$MutationBatchOperation.writeMiniBatchOperationsToMemStore(HRegion.java:3698)
        at org.apache.hadoop.hbase.regionserver.HRegion.doMiniBatchMutate(HRegion.java:4112)
        at org.apache.hadoop.hbase.regionserver.HRegion.batchMutate(HRegion.java:4045)
        at org.apache.hadoop.hbase.regionserver.HRegion.batchMutate(HRegion.java:3976)
        at org.apache.hadoop.hbase.regionserver.HRegion.batchMutate(HRegion.java:3967)
        at org.apache.hadoop.hbase.regionserver.HRegion.batchMutate(HRegion.java:3981)
        at org.apache.hadoop.hbase.regionserver.HRegion.doBatchMutate(HRegion.java:4308)
        at org.apache.hadoop.hbase.regionserver.HRegion.put(HRegion.java:3100)
        at org.apache.hadoop.hbase.regionserver.TestHRegion$PutThread.run(TestHRegion.java:3704)
2019-09-09 15:40:58,842 DEBUG [Time-limited test] compactions.SortedCompactionPolicy(66): Selecting compaction from 0 store files, 0 compacting, 0 eligible, 16 blocking
2019-09-09 15:40:58,845 DEBUG [Time-limited test] compactions.SortedCompactionPolicy(66): Selecting compaction from 0 store files, 0 compacting, 0 eligible, 16 blocking
2019-09-09 15:40:58,845 DEBUG [Time-limited test] compactions.SortedCompactionPolicy(66): Selecting compaction from 0 store files, 0 compacting, 0 eligible, 16 blocking
2019-09-09 15:40:58,846 DEBUG [Time-limited test] compactions.SortedCompactionPolicy(66): Selecting compaction from 0 store files, 0 compacting, 0 eligible, 16 blocking
2019-09-09 15:40:58,846 DEBUG [Time-limited test] compactions.SortedCompactionPolicy(66): Selecting compaction from 0 store files, 0 compacting, 0 eligible, 16 blocking
2019-09-09 15:40:58,846 DEBUG [Time-limited test] compactions.SortedCompactionPolicy(66): Selecting compaction from 0 store files, 0 compacting, 0 eligible, 16 blocking
2019-09-09 15:40:58,846 DEBUG [Time-limited test] compactions.SortedCompactionPolicy(66): Selecting compaction from 0 store files, 0 compacting, 0 eligible, 16 blocking
2019-09-09 15:40:58,846 DEBUG [Time-limited test] compactions.SortedCompactionPolicy(66): Selecting compaction from 0 store files, 0 compacting, 0 eligible, 16 blocking
2019-09-09 15:40:58,846 DEBUG [Time-limited test] compactions.SortedCompactionPolicy(66): Selecting compaction from 0 store files, 0 compacting, 0 eligible, 16 blocking
2019-09-09 15:40:58,847 DEBUG [Time-limited test] compactions.SortedCompactionPolicy(66): Selecting compaction from 0 store files, 0 compacting, 0 eligible, 16 blocking
2019-09-09 15:40:59,837 WARN  [FlushThread] regionserver.MultiVersionConcurrencyControl(228): STUCK: MultiVersionConcurrencyControl{readPoint=1, writePoint=3}
2019-09-09 15:41:00,846 WARN  [FlushThread] regionserver.MultiVersionConcurrencyControl(228): STUCK: MultiVersionConcurrencyControl{readPoint=1, writePoint=3}
2019-09-09 15:41:01,855 WARN  [FlushThread] regionserver.MultiVersionConcurrencyControl(228): STUCK: MultiVersionConcurrencyControl{readPoint=1, writePoint=3}
2019-09-09 15:41:02,874 WARN  [FlushThread] regionserver.MultiVersionConcurrencyControl(228): STUCK: MultiVersionConcurrencyControl{readPoint=1, writePoint=3}
2019-09-09 15:41:03,882 WARN  [FlushThread] regionserver.MultiVersionConcurrencyControl(228): STUCK: MultiVersionConcurrencyControl{readPoint=1, writePoint=3}
2019-09-09 15:41:04,891 WARN  [FlushThread] regionserver.MultiVersionConcurrencyControl(228): STUCK: MultiVersionConcurrencyControl{readPoint=1, writePoint=3}
2019-09-09 15:41:05,901 WARN  [FlushThread] regionserver.MultiVersionConcurrencyControl(228): STUCK: MultiVersionConcurrencyControl{readPoint=1, writePoint=3}
2019-09-09 15:41:06,909 WARN  [FlushThread] regionserver.MultiVersionConcurrencyControl(228): STUCK: MultiVersionConcurrencyControl{readPoint=1, writePoint=3}

{code}

  was:
{code}
java.lang.NullPointerException
	at org.apache.hadoop.hbase.regionserver.MemStoreLABImpl.getOrMakeChunk(MemStoreLABImpl.java:334)
	at org.apache.hadoop.hbase.regionserver.MemStoreLABImpl.copyCellInto(MemStoreLABImpl.java:193)
	at org.apache.hadoop.hbase.regionserver.MemStoreLABImpl.copyCellInto(MemStoreLABImpl.java:115)
	at org.apache.hadoop.hbase.regionserver.Segment.maybeCloneWithAllocator(Segment.java:176)
	at org.apache.hadoop.hbase.regionserver.AbstractMemStore.maybeCloneWithAllocator(AbstractMemStore.java:334)
	at org.apache.hadoop.hbase.regionserver.AbstractMemStore.doAdd(AbstractMemStore.java:157)
	at org.apache.hadoop.hbase.regionserver.AbstractMemStore.doAddOrUpsert(AbstractMemStore.java:147)
	at org.apache.hadoop.hbase.regionserver.AbstractMemStore.add(AbstractMemStore.java:117)
	at org.apache.hadoop.hbase.regionserver.AbstractMemStore.add(AbstractMemStore.java:111)
	at org.apache.hadoop.hbase.regionserver.HStore.add(HStore.java:771)
	at org.apache.hadoop.hbase.regionserver.HRegion.applyToMemStore(HRegion.java:4474)
	at org.apache.hadoop.hbase.regionserver.HRegion.access$500(HRegion.java:228)
	at org.apache.hadoop.hbase.regionserver.HRegion$BatchOperation.applyFamilyMapToMemStore(HRegion.java:3533)
	at org.apache.hadoop.hbase.regionserver.HRegion$BatchOperation.lambda$writeMiniBatchOperationsToMemStore$0(HRegion.java:3224)
	at org.apache.hadoop.hbase.regionserver.HRegion$BatchOperation.visitBatchOperations(HRegion.java:3157)
	at org.apache.hadoop.hbase.regionserver.HRegion$BatchOperation.writeMiniBatchOperationsToMemStore(HRegion.java:3216)
	at org.apache.hadoop.hbase.regionserver.HRegion$MutationBatchOperation.writeMiniBatchOperationsToMemStore(HRegion.java:3698)
	at org.apache.hadoop.hbase.regionserver.HRegion.doMiniBatchMutate(HRegion.java:4112)
	at org.apache.hadoop.hbase.regionserver.HRegion.batchMutate(HRegion.java:4045)
	at org.apache.hadoop.hbase.regionserver.HRegion.batchMutate(HRegion.java:3976)
	at org.apache.hadoop.hbase.regionserver.HRegion.batchMutate(HRegion.java:3967)
	at org.apache.hadoop.hbase.regionserver.HRegion.batchMutate(HRegion.java:3981)
	at org.apache.hadoop.hbase.regionserver.HRegion.doBatchMutate(HRegion.java:4308)
	at org.apache.hadoop.hbase.regionserver.HRegion.put(HRegion.java:3100)
	at org.apache.hadoop.hbase.regionserver.TestHRegionWithInMemoryFlush.testFlushAndMemstoreSizeCounting(TestHRegionWithInMemoryFlush.java:85)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:498)
	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.InvokeMethod.evaluate(InvokeMethod.java:17)
	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27)
	at org.junit.rules.TestWatcher$1.evaluate(TestWatcher.java:55)
	at org.junit.rules.ExpectedException$ExpectedExceptionStatement.evaluate(ExpectedException.java:239)
	at org.junit.rules.RunRules.evaluate(RunRules.java:20)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:78)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:57)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268)
	at org.junit.internal.runners.statements.FailOnTimeout$CallableStatement.call(FailOnTimeout.java:298)
	at org.junit.internal.runners.statements.FailOnTimeout$CallableStatement.call(FailOnTimeout.java:292)
	at java.util.concurrent.FutureTask.run(FutureTask.java:266)
	at java.lang.Thread.run(Thread.java:745)
{code}


> The TestHRegionWithInMemoryFlush is broken
> ------------------------------------------
>
>                 Key: HBASE-22995
>                 URL: https://issues.apache.org/jira/browse/HBASE-22995
>             Project: HBase
>          Issue Type: Bug
>            Reporter: Zheng Hu
>            Priority: Major
>
> {code}
> 2019-09-09 15:40:58,764 INFO  [Time-limited test] regionserver.HRegion(1038): Opened 9669fa00ab90e206bb967cd27169d0e5; next sequenceid=2
> 2019-09-09 15:40:58,771 INFO  [PutThread] regionserver.HRegion(8489): writing data to region testWritesWhileScanning,,1568014858732.9669fa00ab90e206bb967cd27169d0e5. with WAL disabled. Data may be lost in the event of a crash.
> Exception in thread "PutThread" java.lang.NullPointerException
>         at org.apache.hadoop.hbase.regionserver.MemStoreLABImpl.getOrMakeChunk(MemStoreLABImpl.java:334)
>         at org.apache.hadoop.hbase.regionserver.MemStoreLABImpl.copyCellInto(MemStoreLABImpl.java:193)
>         at org.apache.hadoop.hbase.regionserver.MemStoreLABImpl.copyCellInto(MemStoreLABImpl.java:115)
>         at org.apache.hadoop.hbase.regionserver.Segment.maybeCloneWithAllocator(Segment.java:176)
>         at org.apache.hadoop.hbase.regionserver.AbstractMemStore.maybeCloneWithAllocator(AbstractMemStore.java:334)
>         at org.apache.hadoop.hbase.regionserver.AbstractMemStore.doAdd(AbstractMemStore.java:157)
>         at org.apache.hadoop.hbase.regionserver.AbstractMemStore.doAddOrUpsert(AbstractMemStore.java:147)
>         at org.apache.hadoop.hbase.regionserver.AbstractMemStore.add(AbstractMemStore.java:117)
>         at org.apache.hadoop.hbase.regionserver.AbstractMemStore.add(AbstractMemStore.java:111)
>         at org.apache.hadoop.hbase.regionserver.HStore.add(HStore.java:771)
>         at org.apache.hadoop.hbase.regionserver.HRegion.applyToMemStore(HRegion.java:4474)
>         at org.apache.hadoop.hbase.regionserver.HRegion.access$500(HRegion.java:228)
>         at org.apache.hadoop.hbase.regionserver.HRegion$BatchOperation.applyFamilyMapToMemStore(HRegion.java:3533)
>         at org.apache.hadoop.hbase.regionserver.HRegion$BatchOperation.lambda$writeMiniBatchOperationsToMemStore$0(HRegion.java:3224)
>         at org.apache.hadoop.hbase.regionserver.HRegion$BatchOperation.visitBatchOperations(HRegion.java:3157)
>         at org.apache.hadoop.hbase.regionserver.HRegion$BatchOperation.writeMiniBatchOperationsToMemStore(HRegion.java:3216)
>         at org.apache.hadoop.hbase.regionserver.HRegion$MutationBatchOperation.writeMiniBatchOperationsToMemStore(HRegion.java:3698)
>         at org.apache.hadoop.hbase.regionserver.HRegion.doMiniBatchMutate(HRegion.java:4112)
>         at org.apache.hadoop.hbase.regionserver.HRegion.batchMutate(HRegion.java:4045)
>         at org.apache.hadoop.hbase.regionserver.HRegion.batchMutate(HRegion.java:3976)
>         at org.apache.hadoop.hbase.regionserver.HRegion.batchMutate(HRegion.java:3967)
>         at org.apache.hadoop.hbase.regionserver.HRegion.batchMutate(HRegion.java:3981)
>         at org.apache.hadoop.hbase.regionserver.HRegion.doBatchMutate(HRegion.java:4308)
>         at org.apache.hadoop.hbase.regionserver.HRegion.put(HRegion.java:3100)
>         at org.apache.hadoop.hbase.regionserver.TestHRegion$PutThread.run(TestHRegion.java:3704)
> 2019-09-09 15:40:58,842 DEBUG [Time-limited test] compactions.SortedCompactionPolicy(66): Selecting compaction from 0 store files, 0 compacting, 0 eligible, 16 blocking
> 2019-09-09 15:40:58,845 DEBUG [Time-limited test] compactions.SortedCompactionPolicy(66): Selecting compaction from 0 store files, 0 compacting, 0 eligible, 16 blocking
> 2019-09-09 15:40:58,845 DEBUG [Time-limited test] compactions.SortedCompactionPolicy(66): Selecting compaction from 0 store files, 0 compacting, 0 eligible, 16 blocking
> 2019-09-09 15:40:58,846 DEBUG [Time-limited test] compactions.SortedCompactionPolicy(66): Selecting compaction from 0 store files, 0 compacting, 0 eligible, 16 blocking
> 2019-09-09 15:40:58,846 DEBUG [Time-limited test] compactions.SortedCompactionPolicy(66): Selecting compaction from 0 store files, 0 compacting, 0 eligible, 16 blocking
> 2019-09-09 15:40:58,846 DEBUG [Time-limited test] compactions.SortedCompactionPolicy(66): Selecting compaction from 0 store files, 0 compacting, 0 eligible, 16 blocking
> 2019-09-09 15:40:58,846 DEBUG [Time-limited test] compactions.SortedCompactionPolicy(66): Selecting compaction from 0 store files, 0 compacting, 0 eligible, 16 blocking
> 2019-09-09 15:40:58,846 DEBUG [Time-limited test] compactions.SortedCompactionPolicy(66): Selecting compaction from 0 store files, 0 compacting, 0 eligible, 16 blocking
> 2019-09-09 15:40:58,846 DEBUG [Time-limited test] compactions.SortedCompactionPolicy(66): Selecting compaction from 0 store files, 0 compacting, 0 eligible, 16 blocking
> 2019-09-09 15:40:58,847 DEBUG [Time-limited test] compactions.SortedCompactionPolicy(66): Selecting compaction from 0 store files, 0 compacting, 0 eligible, 16 blocking
> 2019-09-09 15:40:59,837 WARN  [FlushThread] regionserver.MultiVersionConcurrencyControl(228): STUCK: MultiVersionConcurrencyControl{readPoint=1, writePoint=3}
> 2019-09-09 15:41:00,846 WARN  [FlushThread] regionserver.MultiVersionConcurrencyControl(228): STUCK: MultiVersionConcurrencyControl{readPoint=1, writePoint=3}
> 2019-09-09 15:41:01,855 WARN  [FlushThread] regionserver.MultiVersionConcurrencyControl(228): STUCK: MultiVersionConcurrencyControl{readPoint=1, writePoint=3}
> 2019-09-09 15:41:02,874 WARN  [FlushThread] regionserver.MultiVersionConcurrencyControl(228): STUCK: MultiVersionConcurrencyControl{readPoint=1, writePoint=3}
> 2019-09-09 15:41:03,882 WARN  [FlushThread] regionserver.MultiVersionConcurrencyControl(228): STUCK: MultiVersionConcurrencyControl{readPoint=1, writePoint=3}
> 2019-09-09 15:41:04,891 WARN  [FlushThread] regionserver.MultiVersionConcurrencyControl(228): STUCK: MultiVersionConcurrencyControl{readPoint=1, writePoint=3}
> 2019-09-09 15:41:05,901 WARN  [FlushThread] regionserver.MultiVersionConcurrencyControl(228): STUCK: MultiVersionConcurrencyControl{readPoint=1, writePoint=3}
> 2019-09-09 15:41:06,909 WARN  [FlushThread] regionserver.MultiVersionConcurrencyControl(228): STUCK: MultiVersionConcurrencyControl{readPoint=1, writePoint=3}
> {code}



--
This message was sent by Atlassian Jira
(v8.3.2#803003)