You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@hbase.apache.org by Andrew Purtell <ap...@apache.org> on 2013/09/07 21:10:37 UTC

"Column family prefix used twice" (was Re: Build failed in Jenkins: HBase-0.94 #443)

I'm looking into several recent failed 0.94 builds on EC2 Jenkins. Several
of the failures look like this:

Error Message


Column family prefix used twice: cf.cf.bt.Data.fsReadnumops


Stacktrace


java.lang.AssertionError: Column family prefix used twice:
cf.cf.bt.Data.fsReadnumops

	at org.apache.hadoop.hbase.regionserver.metrics.SchemaMetrics.validateMetricChanges(SchemaMetrics.java:885)

	at org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingKeyRange.testScannerSelection(TestScannerSelectionUsingKeyRange.java:125)


Running the failing tests locally 100 times in a loop does not reproduce,
I'm only seeing this on the EC2 test slaves.

At this point I don't know enough to implicate any particular recent
change. Could also be some kind of formerly latent bug. Going to try test
reverts of recent changes.

I've also increased the build frequency for the EC2 HBase-0.94 job to on
every checkin plus every 4 hours.


On Sat, Sep 7, 2013 at 9:20 AM, <ap...@apache.org> wrote:

> See <http://jenkins-public.iridiant.net/job/HBase-0.94/443/>
>
> ------------------------------------------
> [...truncated 7739 lines...]
> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.152 sec
> Running
> org.apache.hadoop.hbase.regionserver.TestBatchHRegionLockingAndWrites
> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.34 sec
> Running org.apache.hadoop.hbase.regionserver.TestColumnSeeking
> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.941 sec
> Running
> org.apache.hadoop.hbase.regionserver.TestMiniBatchOperationInProgress
> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.106 sec
> Running org.apache.hadoop.hbase.regionserver.TestCompaction
> Tests run: 17, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 52.15 sec
> Running org.apache.hadoop.hbase.regionserver.metrics.TestSchemaConfigured
> Tests run: 11, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.084 sec
> Running org.apache.hadoop.hbase.regionserver.TestCompoundBloomFilter
> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 20.302 sec
> Running org.apache.hadoop.hbase.regionserver.TestCompactSelection
> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.063 sec
> Running org.apache.hadoop.hbase.regionserver.TestScanner
> Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.683 sec
> Running
> org.apache.hadoop.hbase.regionserver.TestMultiVersionConsistencyControl
> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 10.009 sec
> Running org.apache.hadoop.hbase.regionserver.TestMemStore
> Tests run: 24, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 18.905 sec
> Running org.apache.hadoop.hbase.TestHDFSBlocksDistribution
> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.003 sec
> Running org.apache.hadoop.hbase.TestSerialization
> Tests run: 19, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.072 sec
> Running org.apache.hadoop.hbase.metrics.TestExponentiallyDecayingSample
> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.016 sec
> Running org.apache.hadoop.hbase.metrics.TestMetricsHistogram
> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.023 sec
> Running org.apache.hadoop.hbase.metrics.TestExactCounterMetric
> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.007 sec
> Running org.apache.hadoop.hbase.metrics.file.TestTimeStampingMetricsContext
> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.015 sec
> Running org.apache.hadoop.hbase.TestNodeHealthCheckChore
> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.054 sec
> Running org.apache.hadoop.hbase.coprocessor.TestRegionObserverStacking
> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.062 sec
> Running
> org.apache.hadoop.hbase.coprocessor.TestRegionObserverScannerOpenHook
> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 11.409 sec
> Running org.apache.hadoop.hbase.coprocessor.TestCoprocessorInterface
> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.786 sec
> Running org.apache.hadoop.hbase.filter.TestColumnPrefixFilter
> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.754 sec
> Running org.apache.hadoop.hbase.filter.TestFuzzyRowFilter
> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.012 sec
> Running org.apache.hadoop.hbase.filter.TestInclusiveStopFilter
> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 sec
> Running org.apache.hadoop.hbase.filter.TestBitComparator
> Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
> Running org.apache.hadoop.hbase.filter.TestPageFilter
> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
> Running org.apache.hadoop.hbase.filter.TestSingleColumnValueExcludeFilter
> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
> Running org.apache.hadoop.hbase.filter.TestColumnPaginationFilter
> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
> Running org.apache.hadoop.hbase.filter.TestFilterList
> Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.003 sec
> Running org.apache.hadoop.hbase.filter.TestColumnCountGetFilter
> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.077 sec
> Running org.apache.hadoop.hbase.filter.TestRandomRowFilter
> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.289 sec
> Running org.apache.hadoop.hbase.filter.TestDependentColumnFilter
> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.142 sec
> Running org.apache.hadoop.hbase.filter.TestParseFilter
> Tests run: 34, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.169 sec
> Running org.apache.hadoop.hbase.filter.TestInvocationRecordFilter
> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.03 sec
> Running org.apache.hadoop.hbase.filter.TestMultipleColumnPrefixFilter
> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.082 sec
> Running org.apache.hadoop.hbase.filter.TestFilter
> Tests run: 20, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.305 sec
> Running org.apache.hadoop.hbase.filter.TestSingleColumnValueFilter
> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.03 sec
> Running org.apache.hadoop.hbase.filter.TestPrefixFilter
> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 sec
> Running org.apache.hadoop.hbase.util.TestDynamicClassLoader
> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.93 sec
> Running org.apache.hadoop.hbase.util.TestKeying
> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.003 sec
> Running org.apache.hadoop.hbase.util.TestBytes
> Tests run: 15, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.389 sec
> Running org.apache.hadoop.hbase.util.TestByteBufferUtils
> Tests run: 11, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.04 sec
> Running org.apache.hadoop.hbase.util.TestThreads
> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 5.008 sec
> Running org.apache.hadoop.hbase.util.TestRegionSplitCalculator
> Tests run: 15, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.085 sec
> Running org.apache.hadoop.hbase.util.TestLoadTestKVGenerator
> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.488 sec
> Running org.apache.hadoop.hbase.util.TestBase64
> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
> Running org.apache.hadoop.hbase.util.TestByteBloomFilter
> Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.717 sec
> Running org.apache.hadoop.hbase.util.TestCompressionTest
> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.042 sec
> Running org.apache.hadoop.hbase.util.TestHBaseFsckComparator
> Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.029 sec
> Running org.apache.hadoop.hbase.util.TestIncrementingEnvironmentEdge
> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.005 sec
> Running org.apache.hadoop.hbase.util.TestSortedCopyOnWriteSet
> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.008 sec
> Running org.apache.hadoop.hbase.util.TestRootPath
> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
> Running org.apache.hadoop.hbase.util.TestHFileArchiveUtil
> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.01 sec
> Running org.apache.hadoop.hbase.TestServerName
> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.019 sec
> Running org.apache.hadoop.hbase.io.TestHbaseObjectWritable
> Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.062 sec
> Running org.apache.hadoop.hbase.io.TestHalfStoreFileReader
> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.065 sec
> Running org.apache.hadoop.hbase.io.TestImmutableBytesWritable
> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
> Running org.apache.hadoop.hbase.io.TestHeapSize
> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.004 sec
> Running org.apache.hadoop.hbase.io.encoding.TestBufferedDataBlockEncoder
> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 21.544 sec
> Running org.apache.hadoop.hbase.io.encoding.TestEncodedSeekers
> Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 32.483 sec
> Running org.apache.hadoop.hbase.io.hfile.TestCachedBlockQueue
> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.005 sec
> Running org.apache.hadoop.hbase.io.hfile.TestReseekTo
> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.026 sec
> Running org.apache.hadoop.hbase.io.hfile.TestBlockCacheColumnFamilySummary
> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.023 sec
> Running org.apache.hadoop.hbase.io.hfile.TestHFileDataBlockEncoder
> Tests run: 42, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.028 sec
> Running
> org.apache.hadoop.hbase.io.hfile.TestHFileInlineToRootChunkConversion
> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.011 sec
> Running org.apache.hadoop.hbase.io.hfile.slab.TestSlab
> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.017 sec
> Running org.apache.hadoop.hbase.io.hfile.TestHFile
> Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.114 sec
> Running org.apache.hadoop.hbase.io.hfile.TestSeekTo
> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.052 sec
> Running org.apache.hadoop.hbase.io.hfile.TestHFileWriterV2
> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.557 sec
> Running org.apache.hadoop.hbase.security.TestUser
> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.049 sec
> Running org.apache.hadoop.hbase.TestHTableDescriptor
> Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.002 sec
> Running org.apache.hadoop.hbase.master.TestCatalogJanitor
> Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 9.564 sec
> Running org.apache.hadoop.hbase.master.snapshot.TestSnapshotManager
> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.084 sec
> Running org.apache.hadoop.hbase.master.snapshot.TestSnapshotHFileCleaner
> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.008 sec
> Running org.apache.hadoop.hbase.master.snapshot.TestSnapshotLogCleaner
> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.006 sec
> Running org.apache.hadoop.hbase.master.cleaner.TestCleanerChore
> Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.054 sec
> Running org.apache.hadoop.hbase.master.cleaner.TestHFileLinkCleaner
> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 10.015 sec
> Running org.apache.hadoop.hbase.TestHServerAddress
> Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.055 sec
> Running org.apache.hadoop.hbase.TestClassFinder
> Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.864 sec
> Running org.apache.hadoop.hbase.mapreduce.hadoopbackport.TestJarFinder
> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.085 sec
> Running org.apache.hadoop.hbase.mapreduce.TestSimpleTotalOrderPartitioner
> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.016 sec
> Running org.apache.hadoop.hbase.mapreduce.TestTableSplit
> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.011 sec
> Running org.apache.hadoop.hbase.TestHRegionLocation
> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 270.276 sec
> Running org.apache.hadoop.hbase.io.hfile.TestHFileReaderV1
> Tests run: 1, Failures: 1, Errors: 0, Skipped: 0, Time elapsed: 270.276
> sec <<< FAILURE!
> Running org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingKeyRange
> Tests run: 3, Failures: 3, Errors: 0, Skipped: 0, Time elapsed: 270.276
> sec <<< FAILURE!
> Running org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL
> Tests run: 6, Failures: 6, Errors: 0, Skipped: 0, Time elapsed: 270.276
> sec <<< FAILURE!
>
> Results :
>
> Failed tests:
> testReadingExistingVersion1HFile(org.apache.hadoop.hbase.io.hfile.TestHFileReaderV1):
> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>
> testScannerSelection[0](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingKeyRange):
> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>
> testScannerSelection[1](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingKeyRange):
> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>
> testScannerSelection[2](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingKeyRange):
> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>
> testScannerSelection[0](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>
> testScannerSelection[1](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>
> testScannerSelection[2](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>
> testScannerSelection[3](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>
> testScannerSelection[4](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>
> testScannerSelection[5](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>
> Tests run: 693, Failures: 10, Errors: 0, Skipped: 0
>
> [JENKINS] Recording test results
> [INFO]
> ------------------------------------------------------------------------
> [INFO] BUILD FAILURE
> [INFO]
> ------------------------------------------------------------------------
> [INFO] Total time: 9:23.804s
> [INFO] Finished at: Sat Sep 07 16:20:48 UTC 2013
> [INFO] Final Memory: 62M/398M
> [INFO]
> ------------------------------------------------------------------------
> [JENKINS] Archiving <
> http://jenkins-public.iridiant.net/job/HBase-0.94/ws/pom.xml> to
> /var/lib/jenkins/jobs/HBase-0.94/modules/org.apache.hbase$hbase/builds/2013-09-07_16-11-18/archive/org.apache.hbase/hbase/0.94.12-SNAPSHOT/hbase-0.94.12-SNAPSHOT.pom
> Waiting for Jenkins to finish collecting data
> mavenExecutionResult exceptions not empty
> message : Failed to execute goal
> org.apache.maven.plugins:maven-surefire-plugin:2.12-TRUNK-HBASE-2:test
> (default-test) on project hbase: There are test failures.
>
> Please refer to <
> http://jenkins-public.iridiant.net/job/HBase-0.94/ws/target/surefire-reports>
> for the individual test results.
> cause : There are test failures.
>
> Please refer to <
> http://jenkins-public.iridiant.net/job/HBase-0.94/ws/target/surefire-reports>
> for the individual test results.
> Stack trace :
> org.apache.maven.lifecycle.LifecycleExecutionException: Failed to execute
> goal org.apache.maven.plugins:maven-surefire-plugin:2.12-TRUNK-HBASE-2:test
> (default-test) on project hbase: There are test failures.
>
> Please refer to <
> http://jenkins-public.iridiant.net/job/HBase-0.94/ws/target/surefire-reports>
> for the individual test results.
>         at
> org.apache.maven.lifecycle.internal.MojoExecutor.execute(MojoExecutor.java:213)
>         at
> org.apache.maven.lifecycle.internal.MojoExecutor.execute(MojoExecutor.java:153)
>         at
> org.apache.maven.lifecycle.internal.MojoExecutor.execute(MojoExecutor.java:145)
>         at
> org.apache.maven.lifecycle.internal.LifecycleModuleBuilder.buildProject(LifecycleModuleBuilder.java:84)
>         at
> org.apache.maven.lifecycle.internal.LifecycleModuleBuilder.buildProject(LifecycleModuleBuilder.java:59)
>         at
> org.apache.maven.lifecycle.internal.LifecycleStarter.singleThreadedBuild(LifecycleStarter.java:183)
>         at
> org.apache.maven.lifecycle.internal.LifecycleStarter.execute(LifecycleStarter.java:161)
>         at org.apache.maven.DefaultMaven.doExecute(DefaultMaven.java:320)
>         at org.apache.maven.DefaultMaven.execute(DefaultMaven.java:156)
>         at
> org.jvnet.hudson.maven3.launcher.Maven3Launcher.main(Maven3Launcher.java:79)
>         at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>         at
> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
>         at
> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
>         at java.lang.reflect.Method.invoke(Method.java:597)
>         at
> org.codehaus.plexus.classworlds.launcher.Launcher.launchStandard(Launcher.java:329)
>         at
> org.codehaus.plexus.classworlds.launcher.Launcher.launch(Launcher.java:239)
>         at
> org.jvnet.hudson.maven3.agent.Maven3Main.launch(Maven3Main.java:158)
>         at hudson.maven.Maven3Builder.call(Maven3Builder.java:100)
>         at hudson.maven.Maven3Builder.call(Maven3Builder.java:66)
>         at hudson.remoting.UserRequest.perform(UserRequest.java:118)
>         at hudson.remoting.UserRequest.perform(UserRequest.java:48)
>         at hudson.remoting.Request$2.run(Request.java:326)
>         at
> hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:72)
>         at
> java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
>         at java.util.concurrent.FutureTask.run(FutureTask.java:138)
>         at
> java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:895)
>         at
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:918)
>         at java.lang.Thread.run(Thread.java:662)
> Caused by: org.apache.maven.plugin.MojoFailureException: There are test
> failures.
>
> Please refer to <
> http://jenkins-public.iridiant.net/job/HBase-0.94/ws/target/surefire-reports>
> for the individual test results.
>         at
> org.apache.maven.plugin.surefire.SurefireHelper.reportExecution(SurefireHelper.java:87)
>         at
> org.apache.maven.plugin.surefire.SurefirePlugin.writeSummary(SurefirePlugin.java:651)
>         at
> org.apache.maven.plugin.surefire.SurefirePlugin.handleSummary(SurefirePlugin.java:625)
>         at
> org.apache.maven.plugin.surefire.AbstractSurefireMojo.executeAfterPreconditionsChecked(AbstractSurefireMojo.java:137)
>         at
> org.apache.maven.plugin.surefire.AbstractSurefireMojo.execute(AbstractSurefireMojo.java:98)
>         at
> org.apache.maven.plugin.DefaultBuildPluginManager.executeMojo(DefaultBuildPluginManager.java:101)
>         at
> org.apache.maven.lifecycle.internal.MojoExecutor.execute(MojoExecutor.java:209)
>         ... 27 more
> channel stopped
> Archiving artifacts
>



-- 
Best regards,

   - Andy

Problems worthy of attack prove their worth by hitting back. - Piet Hein
(via Tom White)

Re: "Column family prefix used twice" (was Re: Build failed in Jenkins: HBase-0.94 #443)

Posted by lars hofhansl <la...@apache.org>.
I 'd say this is the suspect. I'll roll it back. In the apache jenkins these did not happen before this.

-- Lars


________________________________
 From: Andrew Purtell <ap...@apache.org>
To: "dev@hbase.apache.org" <de...@hbase.apache.org>; Lars Hofhansl <lh...@yahoo.com> 
Cc: builds@hbase.apache.org 
Sent: Sunday, September 8, 2013 2:54 PM
Subject: Re: "Column family prefix used twice" (was Re: Build failed in Jenkins: HBase-0.94 #443)
 

A bisect confirmed with a test Jenkins job points to

2b6e4e62b6a1e110b8219e4bf20ee4e20e226b17 is the first bad commit
commit 2b6e4e62b6a1e110b8219e4bf20ee4e20e226b17
Author: Lars Hofhansl <la...@apache.org>
Date:   Wed Sep 4 23:23:51 2013 +0000

    HBASE-8930 Filter evaluates KVs outside requested columns (Vasu
Mariyala)

    git-svn-id:
https://svn.apache.org/repos/asf/hbase/branches/0.94@152017113f79535-47bb-0310-9956-ffa450edef68




On Sat, Sep 7, 2013 at 12:10 PM, Andrew Purtell <ap...@apache.org> wrote:

> I'm looking into several recent failed 0.94 builds on EC2 Jenkins. Several
> of the failures look like this:
>
> Error Message
>
>
> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>
>
>
>
>
> Stacktrace
>
>
> java.lang.AssertionError: Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>
>     at org.apache.hadoop.hbase.regionserver.metrics.SchemaMetrics.validateMetricChanges(SchemaMetrics.java:885)
>
>     at org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingKeyRange.testScannerSelection(TestScannerSelectionUsingKeyRange.java:125)
>
>
> Running the failing tests locally 100 times in a loop does not reproduce,
> I'm only seeing this on the EC2 test slaves.
>
> At this point I don't know enough to implicate any particular recent
> change. Could also be some kind of formerly latent bug. Going to try test
> reverts of recent changes.
>
> I've also increased the build frequency for the EC2 HBase-0.94 job to on
> every checkin plus every 4 hours.
>
>
> On Sat, Sep 7, 2013 at 9:20 AM, <ap...@apache.org> wrote:
>
>> See <http://jenkins-public.iridiant.net/job/HBase-0.94/443/>
>>
>> ------------------------------------------
>> [...truncated 7739 lines...]
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.152 sec
>> Running
>> org.apache.hadoop.hbase.regionserver.TestBatchHRegionLockingAndWrites
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.34 sec
>> Running org.apache.hadoop.hbase.regionserver.TestColumnSeeking
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.941 sec
>> Running
>> org.apache.hadoop.hbase.regionserver.TestMiniBatchOperationInProgress
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.106 sec
>> Running org.apache.hadoop.hbase.regionserver.TestCompaction
>> Tests run: 17, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 52.15 sec
>> Running org.apache.hadoop.hbase.regionserver.metrics.TestSchemaConfigured
>> Tests run: 11, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.084 sec
>> Running org.apache.hadoop.hbase.regionserver.TestCompoundBloomFilter
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 20.302 sec
>> Running org.apache.hadoop.hbase.regionserver.TestCompactSelection
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.063 sec
>> Running org.apache.hadoop.hbase.regionserver.TestScanner
>> Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.683 sec
>> Running
>> org.apache.hadoop.hbase.regionserver.TestMultiVersionConsistencyControl
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 10.009 sec
>> Running org.apache.hadoop.hbase.regionserver.TestMemStore
>> Tests run: 24, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 18.905
>> sec
>> Running org.apache.hadoop.hbase.TestHDFSBlocksDistribution
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.003 sec
>> Running org.apache.hadoop.hbase.TestSerialization
>> Tests run: 19, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.072 sec
>> Running org.apache.hadoop.hbase.metrics.TestExponentiallyDecayingSample
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.016 sec
>> Running org.apache.hadoop.hbase.metrics.TestMetricsHistogram
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.023 sec
>> Running org.apache.hadoop.hbase.metrics.TestExactCounterMetric
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.007 sec
>> Running
>> org.apache.hadoop.hbase.metrics.file.TestTimeStampingMetricsContext
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.015 sec
>> Running org.apache.hadoop.hbase.TestNodeHealthCheckChore
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.054 sec
>> Running org.apache.hadoop.hbase.coprocessor.TestRegionObserverStacking
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.062 sec
>> Running
>> org.apache.hadoop.hbase.coprocessor.TestRegionObserverScannerOpenHook
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 11.409 sec
>> Running org.apache.hadoop.hbase.coprocessor.TestCoprocessorInterface
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.786 sec
>> Running org.apache.hadoop.hbase.filter.TestColumnPrefixFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.754 sec
>> Running org.apache.hadoop.hbase.filter.TestFuzzyRowFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.012 sec
>> Running org.apache.hadoop.hbase.filter.TestInclusiveStopFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 sec
>> Running org.apache.hadoop.hbase.filter.TestBitComparator
>> Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.filter.TestPageFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.filter.TestSingleColumnValueExcludeFilter
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.filter.TestColumnPaginationFilter
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.filter.TestFilterList
>> Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.003 sec
>> Running org.apache.hadoop.hbase.filter.TestColumnCountGetFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.077 sec
>> Running org.apache.hadoop.hbase.filter.TestRandomRowFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.289 sec
>> Running org.apache.hadoop.hbase.filter.TestDependentColumnFilter
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.142 sec
>> Running org.apache.hadoop.hbase.filter.TestParseFilter
>> Tests run: 34, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.169 sec
>> Running org.apache.hadoop.hbase.filter.TestInvocationRecordFilter
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.03 sec
>> Running org.apache.hadoop.hbase.filter.TestMultipleColumnPrefixFilter
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.082 sec
>> Running org.apache.hadoop.hbase.filter.TestFilter
>> Tests run: 20, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.305 sec
>> Running org.apache.hadoop.hbase.filter.TestSingleColumnValueFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.03 sec
>> Running org.apache.hadoop.hbase.filter.TestPrefixFilter
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 sec
>> Running org.apache.hadoop.hbase.util.TestDynamicClassLoader
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.93 sec
>> Running org.apache.hadoop.hbase.util.TestKeying
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.003 sec
>> Running org.apache.hadoop.hbase.util.TestBytes
>> Tests run: 15, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.389 sec
>> Running org.apache.hadoop.hbase.util.TestByteBufferUtils
>> Tests run: 11, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.04 sec
>> Running org.apache.hadoop.hbase.util.TestThreads
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 5.008 sec
>> Running org.apache.hadoop.hbase.util.TestRegionSplitCalculator
>> Tests run: 15, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.085 sec
>> Running org.apache.hadoop.hbase.util.TestLoadTestKVGenerator
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.488 sec
>> Running org.apache.hadoop.hbase.util.TestBase64
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.util.TestByteBloomFilter
>> Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.717 sec
>> Running org.apache.hadoop.hbase.util.TestCompressionTest
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.042 sec
>> Running org.apache.hadoop.hbase.util.TestHBaseFsckComparator
>> Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.029 sec
>> Running org.apache.hadoop.hbase.util.TestIncrementingEnvironmentEdge
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.005 sec
>> Running org.apache.hadoop.hbase.util.TestSortedCopyOnWriteSet
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.008 sec
>> Running org.apache.hadoop.hbase.util.TestRootPath
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.util.TestHFileArchiveUtil
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.01 sec
>> Running org.apache.hadoop.hbase.TestServerName
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.019 sec
>> Running org.apache.hadoop.hbase.io.TestHbaseObjectWritable
>> Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.062 sec
>> Running org.apache.hadoop.hbase.io.TestHalfStoreFileReader
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.065 sec
>> Running org.apache.hadoop.hbase.io.TestImmutableBytesWritable
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.io.TestHeapSize
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.004 sec
>> Running org.apache.hadoop.hbase.io.encoding.TestBufferedDataBlockEncoder
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 21.544 sec
>> Running org.apache.hadoop.hbase.io.encoding.TestEncodedSeekers
>> Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 32.483 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestCachedBlockQueue
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.005 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestReseekTo
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.026 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestBlockCacheColumnFamilySummary
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.023 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestHFileDataBlockEncoder
>> Tests run: 42, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.028 sec
>> Running
>> org.apache.hadoop.hbase.io.hfile.TestHFileInlineToRootChunkConversion
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.011 sec
>> Running org.apache.hadoop.hbase.io.hfile.slab.TestSlab
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.017 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestHFile
>> Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.114 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestSeekTo
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.052 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestHFileWriterV2
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.557 sec
>> Running org.apache.hadoop.hbase.security.TestUser
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.049 sec
>> Running org.apache.hadoop.hbase.TestHTableDescriptor
>> Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.002 sec
>> Running org.apache.hadoop.hbase.master.TestCatalogJanitor
>> Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 9.564 sec
>> Running org.apache.hadoop.hbase.master.snapshot.TestSnapshotManager
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.084 sec
>> Running org.apache.hadoop.hbase.master.snapshot.TestSnapshotHFileCleaner
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.008 sec
>> Running org.apache.hadoop.hbase.master.snapshot.TestSnapshotLogCleaner
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.006 sec
>> Running org.apache.hadoop.hbase.master.cleaner.TestCleanerChore
>> Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.054 sec
>> Running org.apache.hadoop.hbase.master.cleaner.TestHFileLinkCleaner
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 10.015 sec
>> Running org.apache.hadoop.hbase.TestHServerAddress
>> Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.055 sec
>> Running org.apache.hadoop.hbase.TestClassFinder
>> Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.864 sec
>> Running org.apache.hadoop.hbase.mapreduce.hadoopbackport.TestJarFinder
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.085 sec
>> Running org.apache.hadoop.hbase.mapreduce.TestSimpleTotalOrderPartitioner
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.016 sec
>> Running org.apache.hadoop.hbase.mapreduce.TestTableSplit
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.011 sec
>> Running org.apache.hadoop.hbase.TestHRegionLocation
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 270.276
>> sec
>> Running org.apache.hadoop.hbase.io.hfile.TestHFileReaderV1
>> Tests run: 1, Failures: 1, Errors: 0, Skipped: 0, Time elapsed: 270.276
>> sec <<< FAILURE!
>> Running org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingKeyRange
>> Tests run: 3, Failures: 3, Errors: 0, Skipped: 0, Time elapsed: 270.276
>> sec <<< FAILURE!
>> Running org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL
>> Tests run: 6, Failures: 6, Errors: 0, Skipped: 0, Time elapsed: 270.276
>> sec <<< FAILURE!
>>
>> Results :
>>
>> Failed tests:
>> testReadingExistingVersion1HFile(org.apache.hadoop.hbase.io.hfile.TestHFileReaderV1):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[0](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingKeyRange):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[1](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingKeyRange):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[2](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingKeyRange):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[0](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[1](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[2](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[3](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[4](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[5](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> Tests run: 693, Failures: 10, Errors: 0, Skipped: 0
>>
>

-- 
Best regards,

   - Andy

Problems worthy of attack prove their worth by hitting back. - Piet Hein
(via Tom White)

Re: "Column family prefix used twice" (was Re: Build failed in Jenkins: HBase-0.94 #443)

Posted by Stack <st...@duboce.net>.
On Mon, Sep 9, 2013 at 5:54 AM, Andrew Purtell <ap...@apache.org> wrote:

> A bisect confirmed with a test Jenkins job points to
>
> 2b6e4e62b6a1e110b8219e4bf20ee4e20e226b17 is the first bad commit
> commit 2b6e4e62b6a1e110b8219e4bf20ee4e20e226b17
> Author: Lars Hofhansl <la...@apache.org>
> Date:   Wed Sep 4 23:23:51 2013 +0000
>
>     HBASE-8930 Filter evaluates KVs outside requested columns (Vasu
> Mariyala)
>
>     git-svn-id:
>
> https://svn.apache.org/repos/asf/hbase/branches/0.94@152017113f79535-47bb-0310-9956-ffa450edef68
>
>
>
Good one Andrew,
St.Ack

Re: "Column family prefix used twice" (was Re: Build failed in Jenkins: HBase-0.94 #443)

Posted by lars hofhansl <la...@apache.org>.
I 'd say this is the suspect. I'll roll it back. In the apache jenkins these did not happen before this.

-- Lars


________________________________
 From: Andrew Purtell <ap...@apache.org>
To: "dev@hbase.apache.org" <de...@hbase.apache.org>; Lars Hofhansl <lh...@yahoo.com> 
Cc: builds@hbase.apache.org 
Sent: Sunday, September 8, 2013 2:54 PM
Subject: Re: "Column family prefix used twice" (was Re: Build failed in Jenkins: HBase-0.94 #443)
 

A bisect confirmed with a test Jenkins job points to

2b6e4e62b6a1e110b8219e4bf20ee4e20e226b17 is the first bad commit
commit 2b6e4e62b6a1e110b8219e4bf20ee4e20e226b17
Author: Lars Hofhansl <la...@apache.org>
Date:   Wed Sep 4 23:23:51 2013 +0000

    HBASE-8930 Filter evaluates KVs outside requested columns (Vasu
Mariyala)

    git-svn-id:
https://svn.apache.org/repos/asf/hbase/branches/0.94@152017113f79535-47bb-0310-9956-ffa450edef68




On Sat, Sep 7, 2013 at 12:10 PM, Andrew Purtell <ap...@apache.org> wrote:

> I'm looking into several recent failed 0.94 builds on EC2 Jenkins. Several
> of the failures look like this:
>
> Error Message
>
>
> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>
>
>
>
>
> Stacktrace
>
>
> java.lang.AssertionError: Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>
>     at org.apache.hadoop.hbase.regionserver.metrics.SchemaMetrics.validateMetricChanges(SchemaMetrics.java:885)
>
>     at org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingKeyRange.testScannerSelection(TestScannerSelectionUsingKeyRange.java:125)
>
>
> Running the failing tests locally 100 times in a loop does not reproduce,
> I'm only seeing this on the EC2 test slaves.
>
> At this point I don't know enough to implicate any particular recent
> change. Could also be some kind of formerly latent bug. Going to try test
> reverts of recent changes.
>
> I've also increased the build frequency for the EC2 HBase-0.94 job to on
> every checkin plus every 4 hours.
>
>
> On Sat, Sep 7, 2013 at 9:20 AM, <ap...@apache.org> wrote:
>
>> See <http://jenkins-public.iridiant.net/job/HBase-0.94/443/>
>>
>> ------------------------------------------
>> [...truncated 7739 lines...]
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.152 sec
>> Running
>> org.apache.hadoop.hbase.regionserver.TestBatchHRegionLockingAndWrites
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.34 sec
>> Running org.apache.hadoop.hbase.regionserver.TestColumnSeeking
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.941 sec
>> Running
>> org.apache.hadoop.hbase.regionserver.TestMiniBatchOperationInProgress
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.106 sec
>> Running org.apache.hadoop.hbase.regionserver.TestCompaction
>> Tests run: 17, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 52.15 sec
>> Running org.apache.hadoop.hbase.regionserver.metrics.TestSchemaConfigured
>> Tests run: 11, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.084 sec
>> Running org.apache.hadoop.hbase.regionserver.TestCompoundBloomFilter
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 20.302 sec
>> Running org.apache.hadoop.hbase.regionserver.TestCompactSelection
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.063 sec
>> Running org.apache.hadoop.hbase.regionserver.TestScanner
>> Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.683 sec
>> Running
>> org.apache.hadoop.hbase.regionserver.TestMultiVersionConsistencyControl
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 10.009 sec
>> Running org.apache.hadoop.hbase.regionserver.TestMemStore
>> Tests run: 24, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 18.905
>> sec
>> Running org.apache.hadoop.hbase.TestHDFSBlocksDistribution
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.003 sec
>> Running org.apache.hadoop.hbase.TestSerialization
>> Tests run: 19, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.072 sec
>> Running org.apache.hadoop.hbase.metrics.TestExponentiallyDecayingSample
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.016 sec
>> Running org.apache.hadoop.hbase.metrics.TestMetricsHistogram
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.023 sec
>> Running org.apache.hadoop.hbase.metrics.TestExactCounterMetric
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.007 sec
>> Running
>> org.apache.hadoop.hbase.metrics.file.TestTimeStampingMetricsContext
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.015 sec
>> Running org.apache.hadoop.hbase.TestNodeHealthCheckChore
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.054 sec
>> Running org.apache.hadoop.hbase.coprocessor.TestRegionObserverStacking
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.062 sec
>> Running
>> org.apache.hadoop.hbase.coprocessor.TestRegionObserverScannerOpenHook
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 11.409 sec
>> Running org.apache.hadoop.hbase.coprocessor.TestCoprocessorInterface
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.786 sec
>> Running org.apache.hadoop.hbase.filter.TestColumnPrefixFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.754 sec
>> Running org.apache.hadoop.hbase.filter.TestFuzzyRowFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.012 sec
>> Running org.apache.hadoop.hbase.filter.TestInclusiveStopFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 sec
>> Running org.apache.hadoop.hbase.filter.TestBitComparator
>> Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.filter.TestPageFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.filter.TestSingleColumnValueExcludeFilter
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.filter.TestColumnPaginationFilter
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.filter.TestFilterList
>> Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.003 sec
>> Running org.apache.hadoop.hbase.filter.TestColumnCountGetFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.077 sec
>> Running org.apache.hadoop.hbase.filter.TestRandomRowFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.289 sec
>> Running org.apache.hadoop.hbase.filter.TestDependentColumnFilter
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.142 sec
>> Running org.apache.hadoop.hbase.filter.TestParseFilter
>> Tests run: 34, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.169 sec
>> Running org.apache.hadoop.hbase.filter.TestInvocationRecordFilter
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.03 sec
>> Running org.apache.hadoop.hbase.filter.TestMultipleColumnPrefixFilter
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.082 sec
>> Running org.apache.hadoop.hbase.filter.TestFilter
>> Tests run: 20, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.305 sec
>> Running org.apache.hadoop.hbase.filter.TestSingleColumnValueFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.03 sec
>> Running org.apache.hadoop.hbase.filter.TestPrefixFilter
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 sec
>> Running org.apache.hadoop.hbase.util.TestDynamicClassLoader
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.93 sec
>> Running org.apache.hadoop.hbase.util.TestKeying
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.003 sec
>> Running org.apache.hadoop.hbase.util.TestBytes
>> Tests run: 15, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.389 sec
>> Running org.apache.hadoop.hbase.util.TestByteBufferUtils
>> Tests run: 11, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.04 sec
>> Running org.apache.hadoop.hbase.util.TestThreads
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 5.008 sec
>> Running org.apache.hadoop.hbase.util.TestRegionSplitCalculator
>> Tests run: 15, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.085 sec
>> Running org.apache.hadoop.hbase.util.TestLoadTestKVGenerator
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.488 sec
>> Running org.apache.hadoop.hbase.util.TestBase64
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.util.TestByteBloomFilter
>> Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.717 sec
>> Running org.apache.hadoop.hbase.util.TestCompressionTest
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.042 sec
>> Running org.apache.hadoop.hbase.util.TestHBaseFsckComparator
>> Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.029 sec
>> Running org.apache.hadoop.hbase.util.TestIncrementingEnvironmentEdge
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.005 sec
>> Running org.apache.hadoop.hbase.util.TestSortedCopyOnWriteSet
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.008 sec
>> Running org.apache.hadoop.hbase.util.TestRootPath
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.util.TestHFileArchiveUtil
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.01 sec
>> Running org.apache.hadoop.hbase.TestServerName
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.019 sec
>> Running org.apache.hadoop.hbase.io.TestHbaseObjectWritable
>> Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.062 sec
>> Running org.apache.hadoop.hbase.io.TestHalfStoreFileReader
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.065 sec
>> Running org.apache.hadoop.hbase.io.TestImmutableBytesWritable
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.io.TestHeapSize
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.004 sec
>> Running org.apache.hadoop.hbase.io.encoding.TestBufferedDataBlockEncoder
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 21.544 sec
>> Running org.apache.hadoop.hbase.io.encoding.TestEncodedSeekers
>> Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 32.483 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestCachedBlockQueue
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.005 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestReseekTo
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.026 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestBlockCacheColumnFamilySummary
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.023 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestHFileDataBlockEncoder
>> Tests run: 42, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.028 sec
>> Running
>> org.apache.hadoop.hbase.io.hfile.TestHFileInlineToRootChunkConversion
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.011 sec
>> Running org.apache.hadoop.hbase.io.hfile.slab.TestSlab
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.017 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestHFile
>> Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.114 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestSeekTo
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.052 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestHFileWriterV2
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.557 sec
>> Running org.apache.hadoop.hbase.security.TestUser
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.049 sec
>> Running org.apache.hadoop.hbase.TestHTableDescriptor
>> Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.002 sec
>> Running org.apache.hadoop.hbase.master.TestCatalogJanitor
>> Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 9.564 sec
>> Running org.apache.hadoop.hbase.master.snapshot.TestSnapshotManager
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.084 sec
>> Running org.apache.hadoop.hbase.master.snapshot.TestSnapshotHFileCleaner
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.008 sec
>> Running org.apache.hadoop.hbase.master.snapshot.TestSnapshotLogCleaner
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.006 sec
>> Running org.apache.hadoop.hbase.master.cleaner.TestCleanerChore
>> Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.054 sec
>> Running org.apache.hadoop.hbase.master.cleaner.TestHFileLinkCleaner
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 10.015 sec
>> Running org.apache.hadoop.hbase.TestHServerAddress
>> Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.055 sec
>> Running org.apache.hadoop.hbase.TestClassFinder
>> Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.864 sec
>> Running org.apache.hadoop.hbase.mapreduce.hadoopbackport.TestJarFinder
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.085 sec
>> Running org.apache.hadoop.hbase.mapreduce.TestSimpleTotalOrderPartitioner
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.016 sec
>> Running org.apache.hadoop.hbase.mapreduce.TestTableSplit
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.011 sec
>> Running org.apache.hadoop.hbase.TestHRegionLocation
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 270.276
>> sec
>> Running org.apache.hadoop.hbase.io.hfile.TestHFileReaderV1
>> Tests run: 1, Failures: 1, Errors: 0, Skipped: 0, Time elapsed: 270.276
>> sec <<< FAILURE!
>> Running org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingKeyRange
>> Tests run: 3, Failures: 3, Errors: 0, Skipped: 0, Time elapsed: 270.276
>> sec <<< FAILURE!
>> Running org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL
>> Tests run: 6, Failures: 6, Errors: 0, Skipped: 0, Time elapsed: 270.276
>> sec <<< FAILURE!
>>
>> Results :
>>
>> Failed tests:
>> testReadingExistingVersion1HFile(org.apache.hadoop.hbase.io.hfile.TestHFileReaderV1):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[0](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingKeyRange):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[1](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingKeyRange):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[2](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingKeyRange):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[0](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[1](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[2](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[3](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[4](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[5](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> Tests run: 693, Failures: 10, Errors: 0, Skipped: 0
>>
>

-- 
Best regards,

   - Andy

Problems worthy of attack prove their worth by hitting back. - Piet Hein
(via Tom White)

Re: "Column family prefix used twice" (was Re: Build failed in Jenkins: HBase-0.94 #443)

Posted by lars hofhansl <lh...@yahoo.com>.
And thanks for tracking it down, Andy!

-- Lars



________________________________
 From: Andrew Purtell <ap...@apache.org>
To: "dev@hbase.apache.org" <de...@hbase.apache.org>; Lars Hofhansl <lh...@yahoo.com> 
Cc: builds@hbase.apache.org 
Sent: Sunday, September 8, 2013 2:54 PM
Subject: Re: "Column family prefix used twice" (was Re: Build failed in Jenkins: HBase-0.94 #443)
 

A bisect confirmed with a test Jenkins job points to

2b6e4e62b6a1e110b8219e4bf20ee4e20e226b17 is the first bad commit
commit 2b6e4e62b6a1e110b8219e4bf20ee4e20e226b17
Author: Lars Hofhansl <la...@apache.org>
Date:   Wed Sep 4 23:23:51 2013 +0000

    HBASE-8930 Filter evaluates KVs outside requested columns (Vasu
Mariyala)

    git-svn-id:
https://svn.apache.org/repos/asf/hbase/branches/0.94@152017113f79535-47bb-0310-9956-ffa450edef68




On Sat, Sep 7, 2013 at 12:10 PM, Andrew Purtell <ap...@apache.org> wrote:

> I'm looking into several recent failed 0.94 builds on EC2 Jenkins. Several
> of the failures look like this:
>
> Error Message
>
>
> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>
>
>
>
>
> Stacktrace
>
>
> java.lang.AssertionError: Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>
>     at org.apache.hadoop.hbase.regionserver.metrics.SchemaMetrics.validateMetricChanges(SchemaMetrics.java:885)
>
>     at org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingKeyRange.testScannerSelection(TestScannerSelectionUsingKeyRange.java:125)
>
>
> Running the failing tests locally 100 times in a loop does not reproduce,
> I'm only seeing this on the EC2 test slaves.
>
> At this point I don't know enough to implicate any particular recent
> change. Could also be some kind of formerly latent bug. Going to try test
> reverts of recent changes.
>
> I've also increased the build frequency for the EC2 HBase-0.94 job to on
> every checkin plus every 4 hours.
>
>
> On Sat, Sep 7, 2013 at 9:20 AM, <ap...@apache.org> wrote:
>
>> See <http://jenkins-public.iridiant.net/job/HBase-0.94/443/>
>>
>> ------------------------------------------
>> [...truncated 7739 lines...]
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.152 sec
>> Running
>> org.apache.hadoop.hbase.regionserver.TestBatchHRegionLockingAndWrites
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.34 sec
>> Running org.apache.hadoop.hbase.regionserver.TestColumnSeeking
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.941 sec
>> Running
>> org.apache.hadoop.hbase.regionserver.TestMiniBatchOperationInProgress
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.106 sec
>> Running org.apache.hadoop.hbase.regionserver.TestCompaction
>> Tests run: 17, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 52.15 sec
>> Running org.apache.hadoop.hbase.regionserver.metrics.TestSchemaConfigured
>> Tests run: 11, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.084 sec
>> Running org.apache.hadoop.hbase.regionserver.TestCompoundBloomFilter
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 20.302 sec
>> Running org.apache.hadoop.hbase.regionserver.TestCompactSelection
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.063 sec
>> Running org.apache.hadoop.hbase.regionserver.TestScanner
>> Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.683 sec
>> Running
>> org.apache.hadoop.hbase.regionserver.TestMultiVersionConsistencyControl
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 10.009 sec
>> Running org.apache.hadoop.hbase.regionserver.TestMemStore
>> Tests run: 24, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 18.905
>> sec
>> Running org.apache.hadoop.hbase.TestHDFSBlocksDistribution
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.003 sec
>> Running org.apache.hadoop.hbase.TestSerialization
>> Tests run: 19, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.072 sec
>> Running org.apache.hadoop.hbase.metrics.TestExponentiallyDecayingSample
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.016 sec
>> Running org.apache.hadoop.hbase.metrics.TestMetricsHistogram
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.023 sec
>> Running org.apache.hadoop.hbase.metrics.TestExactCounterMetric
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.007 sec
>> Running
>> org.apache.hadoop.hbase.metrics.file.TestTimeStampingMetricsContext
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.015 sec
>> Running org.apache.hadoop.hbase.TestNodeHealthCheckChore
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.054 sec
>> Running org.apache.hadoop.hbase.coprocessor.TestRegionObserverStacking
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.062 sec
>> Running
>> org.apache.hadoop.hbase.coprocessor.TestRegionObserverScannerOpenHook
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 11.409 sec
>> Running org.apache.hadoop.hbase.coprocessor.TestCoprocessorInterface
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.786 sec
>> Running org.apache.hadoop.hbase.filter.TestColumnPrefixFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.754 sec
>> Running org.apache.hadoop.hbase.filter.TestFuzzyRowFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.012 sec
>> Running org.apache.hadoop.hbase.filter.TestInclusiveStopFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 sec
>> Running org.apache.hadoop.hbase.filter.TestBitComparator
>> Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.filter.TestPageFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.filter.TestSingleColumnValueExcludeFilter
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.filter.TestColumnPaginationFilter
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.filter.TestFilterList
>> Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.003 sec
>> Running org.apache.hadoop.hbase.filter.TestColumnCountGetFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.077 sec
>> Running org.apache.hadoop.hbase.filter.TestRandomRowFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.289 sec
>> Running org.apache.hadoop.hbase.filter.TestDependentColumnFilter
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.142 sec
>> Running org.apache.hadoop.hbase.filter.TestParseFilter
>> Tests run: 34, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.169 sec
>> Running org.apache.hadoop.hbase.filter.TestInvocationRecordFilter
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.03 sec
>> Running org.apache.hadoop.hbase.filter.TestMultipleColumnPrefixFilter
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.082 sec
>> Running org.apache.hadoop.hbase.filter.TestFilter
>> Tests run: 20, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.305 sec
>> Running org.apache.hadoop.hbase.filter.TestSingleColumnValueFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.03 sec
>> Running org.apache.hadoop.hbase.filter.TestPrefixFilter
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 sec
>> Running org.apache.hadoop.hbase.util.TestDynamicClassLoader
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.93 sec
>> Running org.apache.hadoop.hbase.util.TestKeying
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.003 sec
>> Running org.apache.hadoop.hbase.util.TestBytes
>> Tests run: 15, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.389 sec
>> Running org.apache.hadoop.hbase.util.TestByteBufferUtils
>> Tests run: 11, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.04 sec
>> Running org.apache.hadoop.hbase.util.TestThreads
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 5.008 sec
>> Running org.apache.hadoop.hbase.util.TestRegionSplitCalculator
>> Tests run: 15, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.085 sec
>> Running org.apache.hadoop.hbase.util.TestLoadTestKVGenerator
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.488 sec
>> Running org.apache.hadoop.hbase.util.TestBase64
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.util.TestByteBloomFilter
>> Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.717 sec
>> Running org.apache.hadoop.hbase.util.TestCompressionTest
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.042 sec
>> Running org.apache.hadoop.hbase.util.TestHBaseFsckComparator
>> Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.029 sec
>> Running org.apache.hadoop.hbase.util.TestIncrementingEnvironmentEdge
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.005 sec
>> Running org.apache.hadoop.hbase.util.TestSortedCopyOnWriteSet
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.008 sec
>> Running org.apache.hadoop.hbase.util.TestRootPath
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.util.TestHFileArchiveUtil
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.01 sec
>> Running org.apache.hadoop.hbase.TestServerName
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.019 sec
>> Running org.apache.hadoop.hbase.io.TestHbaseObjectWritable
>> Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.062 sec
>> Running org.apache.hadoop.hbase.io.TestHalfStoreFileReader
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.065 sec
>> Running org.apache.hadoop.hbase.io.TestImmutableBytesWritable
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.io.TestHeapSize
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.004 sec
>> Running org.apache.hadoop.hbase.io.encoding.TestBufferedDataBlockEncoder
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 21.544 sec
>> Running org.apache.hadoop.hbase.io.encoding.TestEncodedSeekers
>> Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 32.483 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestCachedBlockQueue
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.005 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestReseekTo
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.026 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestBlockCacheColumnFamilySummary
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.023 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestHFileDataBlockEncoder
>> Tests run: 42, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.028 sec
>> Running
>> org.apache.hadoop.hbase.io.hfile.TestHFileInlineToRootChunkConversion
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.011 sec
>> Running org.apache.hadoop.hbase.io.hfile.slab.TestSlab
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.017 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestHFile
>> Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.114 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestSeekTo
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.052 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestHFileWriterV2
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.557 sec
>> Running org.apache.hadoop.hbase.security.TestUser
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.049 sec
>> Running org.apache.hadoop.hbase.TestHTableDescriptor
>> Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.002 sec
>> Running org.apache.hadoop.hbase.master.TestCatalogJanitor
>> Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 9.564 sec
>> Running org.apache.hadoop.hbase.master.snapshot.TestSnapshotManager
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.084 sec
>> Running org.apache.hadoop.hbase.master.snapshot.TestSnapshotHFileCleaner
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.008 sec
>> Running org.apache.hadoop.hbase.master.snapshot.TestSnapshotLogCleaner
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.006 sec
>> Running org.apache.hadoop.hbase.master.cleaner.TestCleanerChore
>> Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.054 sec
>> Running org.apache.hadoop.hbase.master.cleaner.TestHFileLinkCleaner
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 10.015 sec
>> Running org.apache.hadoop.hbase.TestHServerAddress
>> Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.055 sec
>> Running org.apache.hadoop.hbase.TestClassFinder
>> Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.864 sec
>> Running org.apache.hadoop.hbase.mapreduce.hadoopbackport.TestJarFinder
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.085 sec
>> Running org.apache.hadoop.hbase.mapreduce.TestSimpleTotalOrderPartitioner
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.016 sec
>> Running org.apache.hadoop.hbase.mapreduce.TestTableSplit
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.011 sec
>> Running org.apache.hadoop.hbase.TestHRegionLocation
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 270.276
>> sec
>> Running org.apache.hadoop.hbase.io.hfile.TestHFileReaderV1
>> Tests run: 1, Failures: 1, Errors: 0, Skipped: 0, Time elapsed: 270.276
>> sec <<< FAILURE!
>> Running org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingKeyRange
>> Tests run: 3, Failures: 3, Errors: 0, Skipped: 0, Time elapsed: 270.276
>> sec <<< FAILURE!
>> Running org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL
>> Tests run: 6, Failures: 6, Errors: 0, Skipped: 0, Time elapsed: 270.276
>> sec <<< FAILURE!
>>
>> Results :
>>
>> Failed tests:
>> testReadingExistingVersion1HFile(org.apache.hadoop.hbase.io.hfile.TestHFileReaderV1):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[0](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingKeyRange):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[1](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingKeyRange):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[2](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingKeyRange):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[0](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[1](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[2](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[3](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[4](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[5](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> Tests run: 693, Failures: 10, Errors: 0, Skipped: 0
>>
>

-- 
Best regards,

   - Andy

Problems worthy of attack prove their worth by hitting back. - Piet Hein
(via Tom White)

Re: "Column family prefix used twice" (was Re: Build failed in Jenkins: HBase-0.94 #443)

Posted by Stack <st...@duboce.net>.
On Mon, Sep 9, 2013 at 5:54 AM, Andrew Purtell <ap...@apache.org> wrote:

> A bisect confirmed with a test Jenkins job points to
>
> 2b6e4e62b6a1e110b8219e4bf20ee4e20e226b17 is the first bad commit
> commit 2b6e4e62b6a1e110b8219e4bf20ee4e20e226b17
> Author: Lars Hofhansl <la...@apache.org>
> Date:   Wed Sep 4 23:23:51 2013 +0000
>
>     HBASE-8930 Filter evaluates KVs outside requested columns (Vasu
> Mariyala)
>
>     git-svn-id:
>
> https://svn.apache.org/repos/asf/hbase/branches/0.94@152017113f79535-47bb-0310-9956-ffa450edef68
>
>
>
Good one Andrew,
St.Ack

Re: "Column family prefix used twice" (was Re: Build failed in Jenkins: HBase-0.94 #443)

Posted by lars hofhansl <lh...@yahoo.com>.
And thanks for tracking it down, Andy!

-- Lars



________________________________
 From: Andrew Purtell <ap...@apache.org>
To: "dev@hbase.apache.org" <de...@hbase.apache.org>; Lars Hofhansl <lh...@yahoo.com> 
Cc: builds@hbase.apache.org 
Sent: Sunday, September 8, 2013 2:54 PM
Subject: Re: "Column family prefix used twice" (was Re: Build failed in Jenkins: HBase-0.94 #443)
 

A bisect confirmed with a test Jenkins job points to

2b6e4e62b6a1e110b8219e4bf20ee4e20e226b17 is the first bad commit
commit 2b6e4e62b6a1e110b8219e4bf20ee4e20e226b17
Author: Lars Hofhansl <la...@apache.org>
Date:   Wed Sep 4 23:23:51 2013 +0000

    HBASE-8930 Filter evaluates KVs outside requested columns (Vasu
Mariyala)

    git-svn-id:
https://svn.apache.org/repos/asf/hbase/branches/0.94@152017113f79535-47bb-0310-9956-ffa450edef68




On Sat, Sep 7, 2013 at 12:10 PM, Andrew Purtell <ap...@apache.org> wrote:

> I'm looking into several recent failed 0.94 builds on EC2 Jenkins. Several
> of the failures look like this:
>
> Error Message
>
>
> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>
>
>
>
>
> Stacktrace
>
>
> java.lang.AssertionError: Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>
>     at org.apache.hadoop.hbase.regionserver.metrics.SchemaMetrics.validateMetricChanges(SchemaMetrics.java:885)
>
>     at org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingKeyRange.testScannerSelection(TestScannerSelectionUsingKeyRange.java:125)
>
>
> Running the failing tests locally 100 times in a loop does not reproduce,
> I'm only seeing this on the EC2 test slaves.
>
> At this point I don't know enough to implicate any particular recent
> change. Could also be some kind of formerly latent bug. Going to try test
> reverts of recent changes.
>
> I've also increased the build frequency for the EC2 HBase-0.94 job to on
> every checkin plus every 4 hours.
>
>
> On Sat, Sep 7, 2013 at 9:20 AM, <ap...@apache.org> wrote:
>
>> See <http://jenkins-public.iridiant.net/job/HBase-0.94/443/>
>>
>> ------------------------------------------
>> [...truncated 7739 lines...]
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.152 sec
>> Running
>> org.apache.hadoop.hbase.regionserver.TestBatchHRegionLockingAndWrites
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.34 sec
>> Running org.apache.hadoop.hbase.regionserver.TestColumnSeeking
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.941 sec
>> Running
>> org.apache.hadoop.hbase.regionserver.TestMiniBatchOperationInProgress
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.106 sec
>> Running org.apache.hadoop.hbase.regionserver.TestCompaction
>> Tests run: 17, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 52.15 sec
>> Running org.apache.hadoop.hbase.regionserver.metrics.TestSchemaConfigured
>> Tests run: 11, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.084 sec
>> Running org.apache.hadoop.hbase.regionserver.TestCompoundBloomFilter
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 20.302 sec
>> Running org.apache.hadoop.hbase.regionserver.TestCompactSelection
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.063 sec
>> Running org.apache.hadoop.hbase.regionserver.TestScanner
>> Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.683 sec
>> Running
>> org.apache.hadoop.hbase.regionserver.TestMultiVersionConsistencyControl
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 10.009 sec
>> Running org.apache.hadoop.hbase.regionserver.TestMemStore
>> Tests run: 24, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 18.905
>> sec
>> Running org.apache.hadoop.hbase.TestHDFSBlocksDistribution
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.003 sec
>> Running org.apache.hadoop.hbase.TestSerialization
>> Tests run: 19, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.072 sec
>> Running org.apache.hadoop.hbase.metrics.TestExponentiallyDecayingSample
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.016 sec
>> Running org.apache.hadoop.hbase.metrics.TestMetricsHistogram
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.023 sec
>> Running org.apache.hadoop.hbase.metrics.TestExactCounterMetric
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.007 sec
>> Running
>> org.apache.hadoop.hbase.metrics.file.TestTimeStampingMetricsContext
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.015 sec
>> Running org.apache.hadoop.hbase.TestNodeHealthCheckChore
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.054 sec
>> Running org.apache.hadoop.hbase.coprocessor.TestRegionObserverStacking
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.062 sec
>> Running
>> org.apache.hadoop.hbase.coprocessor.TestRegionObserverScannerOpenHook
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 11.409 sec
>> Running org.apache.hadoop.hbase.coprocessor.TestCoprocessorInterface
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.786 sec
>> Running org.apache.hadoop.hbase.filter.TestColumnPrefixFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.754 sec
>> Running org.apache.hadoop.hbase.filter.TestFuzzyRowFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.012 sec
>> Running org.apache.hadoop.hbase.filter.TestInclusiveStopFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 sec
>> Running org.apache.hadoop.hbase.filter.TestBitComparator
>> Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.filter.TestPageFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.filter.TestSingleColumnValueExcludeFilter
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.filter.TestColumnPaginationFilter
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.filter.TestFilterList
>> Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.003 sec
>> Running org.apache.hadoop.hbase.filter.TestColumnCountGetFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.077 sec
>> Running org.apache.hadoop.hbase.filter.TestRandomRowFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.289 sec
>> Running org.apache.hadoop.hbase.filter.TestDependentColumnFilter
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.142 sec
>> Running org.apache.hadoop.hbase.filter.TestParseFilter
>> Tests run: 34, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.169 sec
>> Running org.apache.hadoop.hbase.filter.TestInvocationRecordFilter
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.03 sec
>> Running org.apache.hadoop.hbase.filter.TestMultipleColumnPrefixFilter
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.082 sec
>> Running org.apache.hadoop.hbase.filter.TestFilter
>> Tests run: 20, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.305 sec
>> Running org.apache.hadoop.hbase.filter.TestSingleColumnValueFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.03 sec
>> Running org.apache.hadoop.hbase.filter.TestPrefixFilter
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 sec
>> Running org.apache.hadoop.hbase.util.TestDynamicClassLoader
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.93 sec
>> Running org.apache.hadoop.hbase.util.TestKeying
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.003 sec
>> Running org.apache.hadoop.hbase.util.TestBytes
>> Tests run: 15, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.389 sec
>> Running org.apache.hadoop.hbase.util.TestByteBufferUtils
>> Tests run: 11, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.04 sec
>> Running org.apache.hadoop.hbase.util.TestThreads
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 5.008 sec
>> Running org.apache.hadoop.hbase.util.TestRegionSplitCalculator
>> Tests run: 15, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.085 sec
>> Running org.apache.hadoop.hbase.util.TestLoadTestKVGenerator
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.488 sec
>> Running org.apache.hadoop.hbase.util.TestBase64
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.util.TestByteBloomFilter
>> Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.717 sec
>> Running org.apache.hadoop.hbase.util.TestCompressionTest
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.042 sec
>> Running org.apache.hadoop.hbase.util.TestHBaseFsckComparator
>> Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.029 sec
>> Running org.apache.hadoop.hbase.util.TestIncrementingEnvironmentEdge
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.005 sec
>> Running org.apache.hadoop.hbase.util.TestSortedCopyOnWriteSet
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.008 sec
>> Running org.apache.hadoop.hbase.util.TestRootPath
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.util.TestHFileArchiveUtil
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.01 sec
>> Running org.apache.hadoop.hbase.TestServerName
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.019 sec
>> Running org.apache.hadoop.hbase.io.TestHbaseObjectWritable
>> Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.062 sec
>> Running org.apache.hadoop.hbase.io.TestHalfStoreFileReader
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.065 sec
>> Running org.apache.hadoop.hbase.io.TestImmutableBytesWritable
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.io.TestHeapSize
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.004 sec
>> Running org.apache.hadoop.hbase.io.encoding.TestBufferedDataBlockEncoder
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 21.544 sec
>> Running org.apache.hadoop.hbase.io.encoding.TestEncodedSeekers
>> Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 32.483 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestCachedBlockQueue
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.005 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestReseekTo
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.026 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestBlockCacheColumnFamilySummary
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.023 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestHFileDataBlockEncoder
>> Tests run: 42, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.028 sec
>> Running
>> org.apache.hadoop.hbase.io.hfile.TestHFileInlineToRootChunkConversion
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.011 sec
>> Running org.apache.hadoop.hbase.io.hfile.slab.TestSlab
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.017 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestHFile
>> Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.114 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestSeekTo
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.052 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestHFileWriterV2
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.557 sec
>> Running org.apache.hadoop.hbase.security.TestUser
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.049 sec
>> Running org.apache.hadoop.hbase.TestHTableDescriptor
>> Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.002 sec
>> Running org.apache.hadoop.hbase.master.TestCatalogJanitor
>> Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 9.564 sec
>> Running org.apache.hadoop.hbase.master.snapshot.TestSnapshotManager
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.084 sec
>> Running org.apache.hadoop.hbase.master.snapshot.TestSnapshotHFileCleaner
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.008 sec
>> Running org.apache.hadoop.hbase.master.snapshot.TestSnapshotLogCleaner
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.006 sec
>> Running org.apache.hadoop.hbase.master.cleaner.TestCleanerChore
>> Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.054 sec
>> Running org.apache.hadoop.hbase.master.cleaner.TestHFileLinkCleaner
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 10.015 sec
>> Running org.apache.hadoop.hbase.TestHServerAddress
>> Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.055 sec
>> Running org.apache.hadoop.hbase.TestClassFinder
>> Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.864 sec
>> Running org.apache.hadoop.hbase.mapreduce.hadoopbackport.TestJarFinder
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.085 sec
>> Running org.apache.hadoop.hbase.mapreduce.TestSimpleTotalOrderPartitioner
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.016 sec
>> Running org.apache.hadoop.hbase.mapreduce.TestTableSplit
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.011 sec
>> Running org.apache.hadoop.hbase.TestHRegionLocation
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 270.276
>> sec
>> Running org.apache.hadoop.hbase.io.hfile.TestHFileReaderV1
>> Tests run: 1, Failures: 1, Errors: 0, Skipped: 0, Time elapsed: 270.276
>> sec <<< FAILURE!
>> Running org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingKeyRange
>> Tests run: 3, Failures: 3, Errors: 0, Skipped: 0, Time elapsed: 270.276
>> sec <<< FAILURE!
>> Running org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL
>> Tests run: 6, Failures: 6, Errors: 0, Skipped: 0, Time elapsed: 270.276
>> sec <<< FAILURE!
>>
>> Results :
>>
>> Failed tests:
>> testReadingExistingVersion1HFile(org.apache.hadoop.hbase.io.hfile.TestHFileReaderV1):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[0](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingKeyRange):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[1](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingKeyRange):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[2](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingKeyRange):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[0](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[1](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[2](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[3](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[4](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[5](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> Tests run: 693, Failures: 10, Errors: 0, Skipped: 0
>>
>

-- 
Best regards,

   - Andy

Problems worthy of attack prove their worth by hitting back. - Piet Hein
(via Tom White)

Re: "Column family prefix used twice" (was Re: Build failed in Jenkins: HBase-0.94 #443)

Posted by Andrew Purtell <ap...@apache.org>.
A bisect confirmed with a test Jenkins job points to

2b6e4e62b6a1e110b8219e4bf20ee4e20e226b17 is the first bad commit
commit 2b6e4e62b6a1e110b8219e4bf20ee4e20e226b17
Author: Lars Hofhansl <la...@apache.org>
Date:   Wed Sep 4 23:23:51 2013 +0000

    HBASE-8930 Filter evaluates KVs outside requested columns (Vasu
Mariyala)

    git-svn-id:
https://svn.apache.org/repos/asf/hbase/branches/0.94@152017113f79535-47bb-0310-9956-ffa450edef68




On Sat, Sep 7, 2013 at 12:10 PM, Andrew Purtell <ap...@apache.org> wrote:

> I'm looking into several recent failed 0.94 builds on EC2 Jenkins. Several
> of the failures look like this:
>
> Error Message
>
>
> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>
>
>
>
>
> Stacktrace
>
>
> java.lang.AssertionError: Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>
> 	at org.apache.hadoop.hbase.regionserver.metrics.SchemaMetrics.validateMetricChanges(SchemaMetrics.java:885)
>
> 	at org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingKeyRange.testScannerSelection(TestScannerSelectionUsingKeyRange.java:125)
>
>
> Running the failing tests locally 100 times in a loop does not reproduce,
> I'm only seeing this on the EC2 test slaves.
>
> At this point I don't know enough to implicate any particular recent
> change. Could also be some kind of formerly latent bug. Going to try test
> reverts of recent changes.
>
> I've also increased the build frequency for the EC2 HBase-0.94 job to on
> every checkin plus every 4 hours.
>
>
> On Sat, Sep 7, 2013 at 9:20 AM, <ap...@apache.org> wrote:
>
>> See <http://jenkins-public.iridiant.net/job/HBase-0.94/443/>
>>
>> ------------------------------------------
>> [...truncated 7739 lines...]
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.152 sec
>> Running
>> org.apache.hadoop.hbase.regionserver.TestBatchHRegionLockingAndWrites
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.34 sec
>> Running org.apache.hadoop.hbase.regionserver.TestColumnSeeking
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.941 sec
>> Running
>> org.apache.hadoop.hbase.regionserver.TestMiniBatchOperationInProgress
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.106 sec
>> Running org.apache.hadoop.hbase.regionserver.TestCompaction
>> Tests run: 17, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 52.15 sec
>> Running org.apache.hadoop.hbase.regionserver.metrics.TestSchemaConfigured
>> Tests run: 11, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.084 sec
>> Running org.apache.hadoop.hbase.regionserver.TestCompoundBloomFilter
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 20.302 sec
>> Running org.apache.hadoop.hbase.regionserver.TestCompactSelection
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.063 sec
>> Running org.apache.hadoop.hbase.regionserver.TestScanner
>> Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.683 sec
>> Running
>> org.apache.hadoop.hbase.regionserver.TestMultiVersionConsistencyControl
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 10.009 sec
>> Running org.apache.hadoop.hbase.regionserver.TestMemStore
>> Tests run: 24, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 18.905
>> sec
>> Running org.apache.hadoop.hbase.TestHDFSBlocksDistribution
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.003 sec
>> Running org.apache.hadoop.hbase.TestSerialization
>> Tests run: 19, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.072 sec
>> Running org.apache.hadoop.hbase.metrics.TestExponentiallyDecayingSample
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.016 sec
>> Running org.apache.hadoop.hbase.metrics.TestMetricsHistogram
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.023 sec
>> Running org.apache.hadoop.hbase.metrics.TestExactCounterMetric
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.007 sec
>> Running
>> org.apache.hadoop.hbase.metrics.file.TestTimeStampingMetricsContext
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.015 sec
>> Running org.apache.hadoop.hbase.TestNodeHealthCheckChore
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.054 sec
>> Running org.apache.hadoop.hbase.coprocessor.TestRegionObserverStacking
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.062 sec
>> Running
>> org.apache.hadoop.hbase.coprocessor.TestRegionObserverScannerOpenHook
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 11.409 sec
>> Running org.apache.hadoop.hbase.coprocessor.TestCoprocessorInterface
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.786 sec
>> Running org.apache.hadoop.hbase.filter.TestColumnPrefixFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.754 sec
>> Running org.apache.hadoop.hbase.filter.TestFuzzyRowFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.012 sec
>> Running org.apache.hadoop.hbase.filter.TestInclusiveStopFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 sec
>> Running org.apache.hadoop.hbase.filter.TestBitComparator
>> Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.filter.TestPageFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.filter.TestSingleColumnValueExcludeFilter
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.filter.TestColumnPaginationFilter
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.filter.TestFilterList
>> Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.003 sec
>> Running org.apache.hadoop.hbase.filter.TestColumnCountGetFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.077 sec
>> Running org.apache.hadoop.hbase.filter.TestRandomRowFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.289 sec
>> Running org.apache.hadoop.hbase.filter.TestDependentColumnFilter
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.142 sec
>> Running org.apache.hadoop.hbase.filter.TestParseFilter
>> Tests run: 34, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.169 sec
>> Running org.apache.hadoop.hbase.filter.TestInvocationRecordFilter
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.03 sec
>> Running org.apache.hadoop.hbase.filter.TestMultipleColumnPrefixFilter
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.082 sec
>> Running org.apache.hadoop.hbase.filter.TestFilter
>> Tests run: 20, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.305 sec
>> Running org.apache.hadoop.hbase.filter.TestSingleColumnValueFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.03 sec
>> Running org.apache.hadoop.hbase.filter.TestPrefixFilter
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 sec
>> Running org.apache.hadoop.hbase.util.TestDynamicClassLoader
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.93 sec
>> Running org.apache.hadoop.hbase.util.TestKeying
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.003 sec
>> Running org.apache.hadoop.hbase.util.TestBytes
>> Tests run: 15, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.389 sec
>> Running org.apache.hadoop.hbase.util.TestByteBufferUtils
>> Tests run: 11, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.04 sec
>> Running org.apache.hadoop.hbase.util.TestThreads
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 5.008 sec
>> Running org.apache.hadoop.hbase.util.TestRegionSplitCalculator
>> Tests run: 15, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.085 sec
>> Running org.apache.hadoop.hbase.util.TestLoadTestKVGenerator
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.488 sec
>> Running org.apache.hadoop.hbase.util.TestBase64
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.util.TestByteBloomFilter
>> Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.717 sec
>> Running org.apache.hadoop.hbase.util.TestCompressionTest
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.042 sec
>> Running org.apache.hadoop.hbase.util.TestHBaseFsckComparator
>> Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.029 sec
>> Running org.apache.hadoop.hbase.util.TestIncrementingEnvironmentEdge
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.005 sec
>> Running org.apache.hadoop.hbase.util.TestSortedCopyOnWriteSet
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.008 sec
>> Running org.apache.hadoop.hbase.util.TestRootPath
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.util.TestHFileArchiveUtil
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.01 sec
>> Running org.apache.hadoop.hbase.TestServerName
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.019 sec
>> Running org.apache.hadoop.hbase.io.TestHbaseObjectWritable
>> Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.062 sec
>> Running org.apache.hadoop.hbase.io.TestHalfStoreFileReader
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.065 sec
>> Running org.apache.hadoop.hbase.io.TestImmutableBytesWritable
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.io.TestHeapSize
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.004 sec
>> Running org.apache.hadoop.hbase.io.encoding.TestBufferedDataBlockEncoder
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 21.544 sec
>> Running org.apache.hadoop.hbase.io.encoding.TestEncodedSeekers
>> Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 32.483 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestCachedBlockQueue
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.005 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestReseekTo
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.026 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestBlockCacheColumnFamilySummary
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.023 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestHFileDataBlockEncoder
>> Tests run: 42, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.028 sec
>> Running
>> org.apache.hadoop.hbase.io.hfile.TestHFileInlineToRootChunkConversion
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.011 sec
>> Running org.apache.hadoop.hbase.io.hfile.slab.TestSlab
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.017 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestHFile
>> Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.114 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestSeekTo
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.052 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestHFileWriterV2
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.557 sec
>> Running org.apache.hadoop.hbase.security.TestUser
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.049 sec
>> Running org.apache.hadoop.hbase.TestHTableDescriptor
>> Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.002 sec
>> Running org.apache.hadoop.hbase.master.TestCatalogJanitor
>> Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 9.564 sec
>> Running org.apache.hadoop.hbase.master.snapshot.TestSnapshotManager
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.084 sec
>> Running org.apache.hadoop.hbase.master.snapshot.TestSnapshotHFileCleaner
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.008 sec
>> Running org.apache.hadoop.hbase.master.snapshot.TestSnapshotLogCleaner
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.006 sec
>> Running org.apache.hadoop.hbase.master.cleaner.TestCleanerChore
>> Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.054 sec
>> Running org.apache.hadoop.hbase.master.cleaner.TestHFileLinkCleaner
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 10.015 sec
>> Running org.apache.hadoop.hbase.TestHServerAddress
>> Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.055 sec
>> Running org.apache.hadoop.hbase.TestClassFinder
>> Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.864 sec
>> Running org.apache.hadoop.hbase.mapreduce.hadoopbackport.TestJarFinder
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.085 sec
>> Running org.apache.hadoop.hbase.mapreduce.TestSimpleTotalOrderPartitioner
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.016 sec
>> Running org.apache.hadoop.hbase.mapreduce.TestTableSplit
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.011 sec
>> Running org.apache.hadoop.hbase.TestHRegionLocation
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 270.276
>> sec
>> Running org.apache.hadoop.hbase.io.hfile.TestHFileReaderV1
>> Tests run: 1, Failures: 1, Errors: 0, Skipped: 0, Time elapsed: 270.276
>> sec <<< FAILURE!
>> Running org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingKeyRange
>> Tests run: 3, Failures: 3, Errors: 0, Skipped: 0, Time elapsed: 270.276
>> sec <<< FAILURE!
>> Running org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL
>> Tests run: 6, Failures: 6, Errors: 0, Skipped: 0, Time elapsed: 270.276
>> sec <<< FAILURE!
>>
>> Results :
>>
>> Failed tests:
>> testReadingExistingVersion1HFile(org.apache.hadoop.hbase.io.hfile.TestHFileReaderV1):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[0](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingKeyRange):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[1](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingKeyRange):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[2](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingKeyRange):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[0](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[1](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[2](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[3](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[4](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[5](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> Tests run: 693, Failures: 10, Errors: 0, Skipped: 0
>>
>

-- 
Best regards,

   - Andy

Problems worthy of attack prove their worth by hitting back. - Piet Hein
(via Tom White)

Re: "Column family prefix used twice" (was Re: Build failed in Jenkins: HBase-0.94 #443)

Posted by Andrew Purtell <ap...@apache.org>.
A bisect confirmed with a test Jenkins job points to

2b6e4e62b6a1e110b8219e4bf20ee4e20e226b17 is the first bad commit
commit 2b6e4e62b6a1e110b8219e4bf20ee4e20e226b17
Author: Lars Hofhansl <la...@apache.org>
Date:   Wed Sep 4 23:23:51 2013 +0000

    HBASE-8930 Filter evaluates KVs outside requested columns (Vasu
Mariyala)

    git-svn-id:
https://svn.apache.org/repos/asf/hbase/branches/0.94@152017113f79535-47bb-0310-9956-ffa450edef68




On Sat, Sep 7, 2013 at 12:10 PM, Andrew Purtell <ap...@apache.org> wrote:

> I'm looking into several recent failed 0.94 builds on EC2 Jenkins. Several
> of the failures look like this:
>
> Error Message
>
>
> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>
>
>
>
>
> Stacktrace
>
>
> java.lang.AssertionError: Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>
> 	at org.apache.hadoop.hbase.regionserver.metrics.SchemaMetrics.validateMetricChanges(SchemaMetrics.java:885)
>
> 	at org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingKeyRange.testScannerSelection(TestScannerSelectionUsingKeyRange.java:125)
>
>
> Running the failing tests locally 100 times in a loop does not reproduce,
> I'm only seeing this on the EC2 test slaves.
>
> At this point I don't know enough to implicate any particular recent
> change. Could also be some kind of formerly latent bug. Going to try test
> reverts of recent changes.
>
> I've also increased the build frequency for the EC2 HBase-0.94 job to on
> every checkin plus every 4 hours.
>
>
> On Sat, Sep 7, 2013 at 9:20 AM, <ap...@apache.org> wrote:
>
>> See <http://jenkins-public.iridiant.net/job/HBase-0.94/443/>
>>
>> ------------------------------------------
>> [...truncated 7739 lines...]
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.152 sec
>> Running
>> org.apache.hadoop.hbase.regionserver.TestBatchHRegionLockingAndWrites
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.34 sec
>> Running org.apache.hadoop.hbase.regionserver.TestColumnSeeking
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.941 sec
>> Running
>> org.apache.hadoop.hbase.regionserver.TestMiniBatchOperationInProgress
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.106 sec
>> Running org.apache.hadoop.hbase.regionserver.TestCompaction
>> Tests run: 17, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 52.15 sec
>> Running org.apache.hadoop.hbase.regionserver.metrics.TestSchemaConfigured
>> Tests run: 11, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.084 sec
>> Running org.apache.hadoop.hbase.regionserver.TestCompoundBloomFilter
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 20.302 sec
>> Running org.apache.hadoop.hbase.regionserver.TestCompactSelection
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.063 sec
>> Running org.apache.hadoop.hbase.regionserver.TestScanner
>> Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.683 sec
>> Running
>> org.apache.hadoop.hbase.regionserver.TestMultiVersionConsistencyControl
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 10.009 sec
>> Running org.apache.hadoop.hbase.regionserver.TestMemStore
>> Tests run: 24, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 18.905
>> sec
>> Running org.apache.hadoop.hbase.TestHDFSBlocksDistribution
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.003 sec
>> Running org.apache.hadoop.hbase.TestSerialization
>> Tests run: 19, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.072 sec
>> Running org.apache.hadoop.hbase.metrics.TestExponentiallyDecayingSample
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.016 sec
>> Running org.apache.hadoop.hbase.metrics.TestMetricsHistogram
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.023 sec
>> Running org.apache.hadoop.hbase.metrics.TestExactCounterMetric
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.007 sec
>> Running
>> org.apache.hadoop.hbase.metrics.file.TestTimeStampingMetricsContext
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.015 sec
>> Running org.apache.hadoop.hbase.TestNodeHealthCheckChore
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.054 sec
>> Running org.apache.hadoop.hbase.coprocessor.TestRegionObserverStacking
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.062 sec
>> Running
>> org.apache.hadoop.hbase.coprocessor.TestRegionObserverScannerOpenHook
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 11.409 sec
>> Running org.apache.hadoop.hbase.coprocessor.TestCoprocessorInterface
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.786 sec
>> Running org.apache.hadoop.hbase.filter.TestColumnPrefixFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.754 sec
>> Running org.apache.hadoop.hbase.filter.TestFuzzyRowFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.012 sec
>> Running org.apache.hadoop.hbase.filter.TestInclusiveStopFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 sec
>> Running org.apache.hadoop.hbase.filter.TestBitComparator
>> Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.filter.TestPageFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.filter.TestSingleColumnValueExcludeFilter
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.filter.TestColumnPaginationFilter
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.filter.TestFilterList
>> Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.003 sec
>> Running org.apache.hadoop.hbase.filter.TestColumnCountGetFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.077 sec
>> Running org.apache.hadoop.hbase.filter.TestRandomRowFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.289 sec
>> Running org.apache.hadoop.hbase.filter.TestDependentColumnFilter
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.142 sec
>> Running org.apache.hadoop.hbase.filter.TestParseFilter
>> Tests run: 34, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.169 sec
>> Running org.apache.hadoop.hbase.filter.TestInvocationRecordFilter
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.03 sec
>> Running org.apache.hadoop.hbase.filter.TestMultipleColumnPrefixFilter
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.082 sec
>> Running org.apache.hadoop.hbase.filter.TestFilter
>> Tests run: 20, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.305 sec
>> Running org.apache.hadoop.hbase.filter.TestSingleColumnValueFilter
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.03 sec
>> Running org.apache.hadoop.hbase.filter.TestPrefixFilter
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 sec
>> Running org.apache.hadoop.hbase.util.TestDynamicClassLoader
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.93 sec
>> Running org.apache.hadoop.hbase.util.TestKeying
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.003 sec
>> Running org.apache.hadoop.hbase.util.TestBytes
>> Tests run: 15, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.389 sec
>> Running org.apache.hadoop.hbase.util.TestByteBufferUtils
>> Tests run: 11, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.04 sec
>> Running org.apache.hadoop.hbase.util.TestThreads
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 5.008 sec
>> Running org.apache.hadoop.hbase.util.TestRegionSplitCalculator
>> Tests run: 15, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.085 sec
>> Running org.apache.hadoop.hbase.util.TestLoadTestKVGenerator
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.488 sec
>> Running org.apache.hadoop.hbase.util.TestBase64
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.util.TestByteBloomFilter
>> Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.717 sec
>> Running org.apache.hadoop.hbase.util.TestCompressionTest
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.042 sec
>> Running org.apache.hadoop.hbase.util.TestHBaseFsckComparator
>> Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.029 sec
>> Running org.apache.hadoop.hbase.util.TestIncrementingEnvironmentEdge
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.005 sec
>> Running org.apache.hadoop.hbase.util.TestSortedCopyOnWriteSet
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.008 sec
>> Running org.apache.hadoop.hbase.util.TestRootPath
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.util.TestHFileArchiveUtil
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.01 sec
>> Running org.apache.hadoop.hbase.TestServerName
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.019 sec
>> Running org.apache.hadoop.hbase.io.TestHbaseObjectWritable
>> Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.062 sec
>> Running org.apache.hadoop.hbase.io.TestHalfStoreFileReader
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.065 sec
>> Running org.apache.hadoop.hbase.io.TestImmutableBytesWritable
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
>> Running org.apache.hadoop.hbase.io.TestHeapSize
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.004 sec
>> Running org.apache.hadoop.hbase.io.encoding.TestBufferedDataBlockEncoder
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 21.544 sec
>> Running org.apache.hadoop.hbase.io.encoding.TestEncodedSeekers
>> Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 32.483 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestCachedBlockQueue
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.005 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestReseekTo
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.026 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestBlockCacheColumnFamilySummary
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.023 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestHFileDataBlockEncoder
>> Tests run: 42, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.028 sec
>> Running
>> org.apache.hadoop.hbase.io.hfile.TestHFileInlineToRootChunkConversion
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.011 sec
>> Running org.apache.hadoop.hbase.io.hfile.slab.TestSlab
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.017 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestHFile
>> Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.114 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestSeekTo
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.052 sec
>> Running org.apache.hadoop.hbase.io.hfile.TestHFileWriterV2
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.557 sec
>> Running org.apache.hadoop.hbase.security.TestUser
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.049 sec
>> Running org.apache.hadoop.hbase.TestHTableDescriptor
>> Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.002 sec
>> Running org.apache.hadoop.hbase.master.TestCatalogJanitor
>> Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 9.564 sec
>> Running org.apache.hadoop.hbase.master.snapshot.TestSnapshotManager
>> Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.084 sec
>> Running org.apache.hadoop.hbase.master.snapshot.TestSnapshotHFileCleaner
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.008 sec
>> Running org.apache.hadoop.hbase.master.snapshot.TestSnapshotLogCleaner
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.006 sec
>> Running org.apache.hadoop.hbase.master.cleaner.TestCleanerChore
>> Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.054 sec
>> Running org.apache.hadoop.hbase.master.cleaner.TestHFileLinkCleaner
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 10.015 sec
>> Running org.apache.hadoop.hbase.TestHServerAddress
>> Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.055 sec
>> Running org.apache.hadoop.hbase.TestClassFinder
>> Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.864 sec
>> Running org.apache.hadoop.hbase.mapreduce.hadoopbackport.TestJarFinder
>> Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.085 sec
>> Running org.apache.hadoop.hbase.mapreduce.TestSimpleTotalOrderPartitioner
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.016 sec
>> Running org.apache.hadoop.hbase.mapreduce.TestTableSplit
>> Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.011 sec
>> Running org.apache.hadoop.hbase.TestHRegionLocation
>> Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 270.276
>> sec
>> Running org.apache.hadoop.hbase.io.hfile.TestHFileReaderV1
>> Tests run: 1, Failures: 1, Errors: 0, Skipped: 0, Time elapsed: 270.276
>> sec <<< FAILURE!
>> Running org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingKeyRange
>> Tests run: 3, Failures: 3, Errors: 0, Skipped: 0, Time elapsed: 270.276
>> sec <<< FAILURE!
>> Running org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL
>> Tests run: 6, Failures: 6, Errors: 0, Skipped: 0, Time elapsed: 270.276
>> sec <<< FAILURE!
>>
>> Results :
>>
>> Failed tests:
>> testReadingExistingVersion1HFile(org.apache.hadoop.hbase.io.hfile.TestHFileReaderV1):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[0](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingKeyRange):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[1](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingKeyRange):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[2](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingKeyRange):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[0](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[1](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[2](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[3](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[4](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> testScannerSelection[5](org.apache.hadoop.hbase.io.hfile.TestScannerSelectionUsingTTL):
>> Column family prefix used twice: cf.cf.bt.Data.fsReadnumops
>>
>> Tests run: 693, Failures: 10, Errors: 0, Skipped: 0
>>
>

-- 
Best regards,

   - Andy

Problems worthy of attack prove their worth by hitting back. - Piet Hein
(via Tom White)