See
<https://builds.apache.org/job/Accumulo-1.5/org.apache.accumulo$accumulo-core/3/changes>
Changes:
[kturner] ACCUMULO-1077 fixed deadlock w/ walog recovery and made walog
recovery retry w/ backoff.... failed log recoveries were not retrying
[ecn] ACCUMULO-1004 fixing functional tests
------------------------------------------
[...truncated 369 lines...]
13/02/28 02:19:49 INFO mapred.JobClient: FILE_BYTES_READ=1437
13/02/28 02:19:49 INFO mapred.JobClient: FILE_BYTES_WRITTEN=270001
13/02/28 02:19:49 INFO mapred.JobClient: Map-Reduce Framework
13/02/28 02:19:49 INFO mapred.JobClient: Map input records=1
13/02/28 02:19:49 INFO mapred.JobClient: Physical memory (bytes) snapshot=0
13/02/28 02:19:49 INFO mapred.JobClient: Spilled Records=0
13/02/28 02:19:49 INFO mapred.JobClient: Total committed heap usage
(bytes)=182321152
13/02/28 02:19:49 INFO mapred.JobClient: CPU time spent (ms)=0
13/02/28 02:19:49 INFO mapred.JobClient: Virtual memory (bytes) snapshot=0
13/02/28 02:19:49 INFO mapred.JobClient: SPLIT_RAW_BYTES=93
13/02/28 02:19:49 INFO mapred.JobClient: Map output records=1
13/02/28 02:19:49 WARN mapred.JobClient: No job jar file set. User classes may
not be found. See JobConf(Class) or JobConf#setJar(String).
13/02/28 02:19:49 INFO mapred.JobClient: Running job: job_local_0009
13/02/28 02:19:49 INFO mapred.Task: Using ResourceCalculatorPlugin :
org.apache.hadoop.util.LinuxResourceCalculatorPlugin@c7057c
13/02/28 02:19:49 INFO mapred.Task: Task:attempt_local_0009_m_000000_0 is done.
And is in the process of commiting
13/02/28 02:19:49 INFO mapred.LocalJobRunner:
13/02/28 02:19:49 INFO mapred.Task: Task attempt_local_0009_m_000000_0 is
allowed to commit now
13/02/28 02:19:49 INFO output.FileOutputCommitter: Saved output of task
'attempt_local_0009_m_000000_0' to
/tmp/junit8505793174799300186/junit9162985491569838177.tmp
13/02/28 02:19:50 INFO mapred.JobClient: map 0% reduce 0%
13/02/28 02:19:52 INFO mapred.LocalJobRunner:
13/02/28 02:19:52 INFO mapred.Task: Task 'attempt_local_0009_m_000000_0' done.
13/02/28 02:19:53 INFO mapred.JobClient: map 100% reduce 0%
13/02/28 02:19:53 INFO mapred.JobClient: Job complete: job_local_0009
13/02/28 02:19:53 INFO mapred.JobClient: Counters: 12
13/02/28 02:19:53 INFO mapred.JobClient: File Output Format Counters
13/02/28 02:19:53 INFO mapred.JobClient: Bytes Written=224
13/02/28 02:19:53 INFO mapred.JobClient: File Input Format Counters
13/02/28 02:19:53 INFO mapred.JobClient: Bytes Read=0
13/02/28 02:19:53 INFO mapred.JobClient: FileSystemCounters
13/02/28 02:19:53 INFO mapred.JobClient: FILE_BYTES_READ=1586
13/02/28 02:19:53 INFO mapred.JobClient: FILE_BYTES_WRITTEN=303953
13/02/28 02:19:53 INFO mapred.JobClient: Map-Reduce Framework
13/02/28 02:19:53 INFO mapred.JobClient: Map input records=2
13/02/28 02:19:53 INFO mapred.JobClient: Physical memory (bytes) snapshot=0
13/02/28 02:19:53 INFO mapred.JobClient: Spilled Records=0
13/02/28 02:19:53 INFO mapred.JobClient: Total committed heap usage
(bytes)=182321152
13/02/28 02:19:53 INFO mapred.JobClient: CPU time spent (ms)=0
13/02/28 02:19:53 INFO mapred.JobClient: Virtual memory (bytes) snapshot=0
13/02/28 02:19:53 INFO mapred.JobClient: SPLIT_RAW_BYTES=93
13/02/28 02:19:53 INFO mapred.JobClient: Map output records=2
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 12.17 sec
Running org.apache.accumulo.core.client.mapreduce.AccumuloOutputFormatTest
13/02/28 02:19:53 WARN mapred.JobClient: No job jar file set. User classes may
not be found. See JobConf(Class) or JobConf#setJar(String).
13/02/28 02:19:53 INFO mapred.JobClient: Running job: job_local_0010
13/02/28 02:19:53 INFO mapred.Task: Using ResourceCalculatorPlugin :
org.apache.hadoop.util.LinuxResourceCalculatorPlugin@1406eb6
13/02/28 02:19:53 INFO mapred.Task: Task:attempt_local_0010_m_000000_0 is done.
And is in the process of commiting
13/02/28 02:19:54 INFO mapred.JobClient: map 0% reduce 0%
13/02/28 02:19:56 INFO mapred.LocalJobRunner:
13/02/28 02:19:56 INFO mapred.Task: Task 'attempt_local_0010_m_000000_0' done.
13/02/28 02:19:56 WARN mapred.FileOutputCommitter: Output path is null in
cleanup
13/02/28 02:19:57 INFO mapred.JobClient: map 100% reduce 0%
13/02/28 02:19:57 INFO mapred.JobClient: Job complete: job_local_0010
13/02/28 02:19:57 INFO mapred.JobClient: Counters: 12
13/02/28 02:19:57 INFO mapred.JobClient: File Output Format Counters
13/02/28 02:19:57 INFO mapred.JobClient: Bytes Written=0
13/02/28 02:19:57 INFO mapred.JobClient: File Input Format Counters
13/02/28 02:19:57 INFO mapred.JobClient: Bytes Read=0
13/02/28 02:19:57 INFO mapred.JobClient: FileSystemCounters
13/02/28 02:19:57 INFO mapred.JobClient: FILE_BYTES_READ=1735
13/02/28 02:19:57 INFO mapred.JobClient: FILE_BYTES_WRITTEN=339709
13/02/28 02:19:57 INFO mapred.JobClient: Map-Reduce Framework
13/02/28 02:19:57 INFO mapred.JobClient: Map input records=100
13/02/28 02:19:57 INFO mapred.JobClient: Physical memory (bytes) snapshot=0
13/02/28 02:19:57 INFO mapred.JobClient: Spilled Records=0
13/02/28 02:19:57 INFO mapred.JobClient: Total committed heap usage
(bytes)=182321152
13/02/28 02:19:57 INFO mapred.JobClient: CPU time spent (ms)=0
13/02/28 02:19:57 INFO mapred.JobClient: Virtual memory (bytes) snapshot=0
13/02/28 02:19:57 INFO mapred.JobClient: SPLIT_RAW_BYTES=93
13/02/28 02:19:57 INFO mapred.JobClient: Map output records=1
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.04 sec
Running org.apache.accumulo.core.client.mapreduce.AccumuloInputFormatTest
13/02/28 02:19:57 WARN mapred.JobClient: No job jar file set. User classes may
not be found. See JobConf(Class) or JobConf#setJar(String).
13/02/28 02:19:57 INFO mapred.JobClient: Running job: job_local_0011
13/02/28 02:19:57 INFO mapred.Task: Using ResourceCalculatorPlugin :
org.apache.hadoop.util.LinuxResourceCalculatorPlugin@1e6696c
13/02/28 02:19:57 INFO mapred.Task: Task:attempt_local_0011_m_000000_0 is done.
And is in the process of commiting
13/02/28 02:19:58 INFO mapred.JobClient: map 0% reduce 0%
13/02/28 02:20:00 INFO mapred.LocalJobRunner:
13/02/28 02:20:00 INFO mapred.Task: Task 'attempt_local_0011_m_000000_0' done.
13/02/28 02:20:00 WARN mapred.FileOutputCommitter: Output path is null in
cleanup
13/02/28 02:20:01 INFO mapred.JobClient: map 100% reduce 0%
13/02/28 02:20:01 INFO mapred.JobClient: Job complete: job_local_0011
13/02/28 02:20:01 INFO mapred.JobClient: Counters: 12
13/02/28 02:20:01 INFO mapred.JobClient: File Output Format Counters
13/02/28 02:20:01 INFO mapred.JobClient: Bytes Written=0
13/02/28 02:20:01 INFO mapred.JobClient: File Input Format Counters
13/02/28 02:20:01 INFO mapred.JobClient: Bytes Read=0
13/02/28 02:20:01 INFO mapred.JobClient: FileSystemCounters
13/02/28 02:20:01 INFO mapred.JobClient: FILE_BYTES_READ=1884
13/02/28 02:20:01 INFO mapred.JobClient: FILE_BYTES_WRITTEN=373119
13/02/28 02:20:01 INFO mapred.JobClient: Map-Reduce Framework
13/02/28 02:20:01 INFO mapred.JobClient: Map input records=100
13/02/28 02:20:01 INFO mapred.JobClient: Physical memory (bytes) snapshot=0
13/02/28 02:20:01 INFO mapred.JobClient: Spilled Records=0
13/02/28 02:20:01 INFO mapred.JobClient: Total committed heap usage
(bytes)=182321152
13/02/28 02:20:01 INFO mapred.JobClient: CPU time spent (ms)=0
13/02/28 02:20:01 INFO mapred.JobClient: Virtual memory (bytes) snapshot=0
13/02/28 02:20:01 INFO mapred.JobClient: SPLIT_RAW_BYTES=93
13/02/28 02:20:01 INFO mapred.JobClient: Map output records=0
Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.087 sec
Running org.apache.accumulo.core.client.mapreduce.AccumuloRowInputFormatTest
13/02/28 02:20:01 WARN mapred.JobClient: No job jar file set. User classes may
not be found. See JobConf(Class) or JobConf#setJar(String).
13/02/28 02:20:01 INFO mapred.JobClient: Running job: job_local_0012
13/02/28 02:20:01 INFO mapred.Task: Using ResourceCalculatorPlugin :
org.apache.hadoop.util.LinuxResourceCalculatorPlugin@122d9c
13/02/28 02:20:01 INFO mapred.Task: Task:attempt_local_0012_m_000000_0 is done.
And is in the process of commiting
13/02/28 02:20:02 INFO mapred.JobClient: map 0% reduce 0%
13/02/28 02:20:04 INFO mapred.LocalJobRunner:
13/02/28 02:20:04 INFO mapred.Task: Task 'attempt_local_0012_m_000000_0' done.
13/02/28 02:20:04 WARN mapred.FileOutputCommitter: Output path is null in
cleanup
13/02/28 02:20:05 INFO mapred.JobClient: map 100% reduce 0%
13/02/28 02:20:05 INFO mapred.JobClient: Job complete: job_local_0012
13/02/28 02:20:05 INFO mapred.JobClient: Counters: 12
13/02/28 02:20:05 INFO mapred.JobClient: File Output Format Counters
13/02/28 02:20:05 INFO mapred.JobClient: Bytes Written=0
13/02/28 02:20:05 INFO mapred.JobClient: File Input Format Counters
13/02/28 02:20:05 INFO mapred.JobClient: Bytes Read=0
13/02/28 02:20:05 INFO mapred.JobClient: FileSystemCounters
13/02/28 02:20:05 INFO mapred.JobClient: FILE_BYTES_READ=2033
13/02/28 02:20:05 INFO mapred.JobClient: FILE_BYTES_WRITTEN=406551
13/02/28 02:20:05 INFO mapred.JobClient: Map-Reduce Framework
13/02/28 02:20:05 INFO mapred.JobClient: Map input records=3
13/02/28 02:20:05 INFO mapred.JobClient: Physical memory (bytes) snapshot=0
13/02/28 02:20:05 INFO mapred.JobClient: Spilled Records=0
13/02/28 02:20:05 INFO mapred.JobClient: Total committed heap usage
(bytes)=182321152
13/02/28 02:20:05 INFO mapred.JobClient: CPU time spent (ms)=0
13/02/28 02:20:05 INFO mapred.JobClient: Virtual memory (bytes) snapshot=0
13/02/28 02:20:05 INFO mapred.JobClient: SPLIT_RAW_BYTES=93
13/02/28 02:20:05 INFO mapred.JobClient: Map output records=0
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.026 sec
Running
org.apache.accumulo.core.client.mapreduce.lib.partition.RangePartitionerTest
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.333 sec
Running org.apache.accumulo.core.iterators.system.VisibilityFilterTest
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.002 sec
Running org.apache.accumulo.core.iterators.system.SourceSwitchingIteratorTest
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.005 sec
Running org.apache.accumulo.core.iterators.system.DeletingIteratorTest
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.003 sec
Running org.apache.accumulo.core.iterators.system.ColumnFilterTest
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.002 sec
Running
org.apache.accumulo.core.iterators.system.ColumnFamilySkippingIteratorTest
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.622 sec
Running org.apache.accumulo.core.iterators.system.MultiIteratorTest
Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.189 sec
Running org.apache.accumulo.core.iterators.system.TimeSettingIteratorTest
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.002 sec
Running org.apache.accumulo.core.iterators.FirstEntryInRowTest
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.015 sec
Running org.apache.accumulo.core.iterators.aggregation.NumSummationTest
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.003 sec
Running
org.apache.accumulo.core.iterators.aggregation.conf.AggregatorConfigurationTest
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.005 sec
Running org.apache.accumulo.core.iterators.user.VisibilityFilterTest
13/02/28 02:20:06 ERROR system.VisibilityFilter: Parse Error
org.apache.accumulo.core.util.BadArgumentException: empty term near index 0
&
^
at
org.apache.accumulo.core.security.ColumnVisibility$ColumnVisibilityParser.processTerm(ColumnVisibility.java:240)
at
org.apache.accumulo.core.security.ColumnVisibility$ColumnVisibilityParser.parse_(ColumnVisibility.java:253)
at
org.apache.accumulo.core.security.ColumnVisibility$ColumnVisibilityParser.parse(ColumnVisibility.java:221)
at
org.apache.accumulo.core.security.ColumnVisibility.validate(ColumnVisibility.java:354)
at
org.apache.accumulo.core.security.ColumnVisibility.<init>(ColumnVisibility.java:430)
at
org.apache.accumulo.core.security.ColumnVisibility.<init>(ColumnVisibility.java:388)
at
org.apache.accumulo.core.iterators.system.VisibilityFilter.accept(VisibilityFilter.java:71)
at
org.apache.accumulo.core.iterators.user.VisibilityFilter.accept(VisibilityFilter.java:85)
at org.apache.accumulo.core.iterators.Filter.findTop(Filter.java:72)
at org.apache.accumulo.core.iterators.Filter.seek(Filter.java:65)
at
org.apache.accumulo.core.iterators.user.VisibilityFilterTest.verify(VisibilityFilterTest.java:85)
at
org.apache.accumulo.core.iterators.user.VisibilityFilterTest.testFilterUnauthorizedAndBad(VisibilityFilterTest.java:187)
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.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:47)
at
org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
at
org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:44)
at
org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:271)
at
org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:70)
at
org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
at org.junit.runners.ParentRunner$3.run(ParentRunner.java:238)
at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:63)
at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:236)
at org.junit.runners.ParentRunner.access$000(ParentRunner.java:53)
at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:229)
at org.junit.runners.ParentRunner.run(ParentRunner.java:309)
at
org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:236)
at
org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:134)
at
org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:113)
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.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:189)
at
org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:165)
at
org.apache.maven.surefire.booter.ProviderFactory.invokeProvider(ProviderFactory.java:85)
at
org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:103)
at
org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:74)
Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.088 sec
Running org.apache.accumulo.core.iterators.user.GrepIteratorTest
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.002 sec
Running org.apache.accumulo.core.iterators.user.LargeRowFilterTest
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.082 sec
Running org.apache.accumulo.core.iterators.user.FilterTest
Tests run: 11, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.081 sec
Running org.apache.accumulo.core.iterators.user.TransformingIteratorTest
13/02/28 02:20:06 ERROR
user.TransformingIteratorTest$IllegalVisKeyTransformingIterator: Parse error
after transformation : A&|||
13/02/28 02:20:06 ERROR
user.TransformingIteratorTest$IllegalVisKeyTransformingIterator: Parse error
after transformation : A&|||
13/02/28 02:20:06 ERROR
user.TransformingIteratorTest$IllegalVisCompactionKeyTransformingIterator:
Parse error after transformation : A&|||
Tests run: 16, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.082 sec
Running org.apache.accumulo.core.iterators.user.CombinerTest
Tests run: 14, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.013 sec
Running org.apache.accumulo.core.iterators.user.RegExFilterTest
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.003 sec
Running org.apache.accumulo.core.iterators.user.IndexedDocIteratorTest
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.998 sec
Running org.apache.accumulo.core.iterators.user.RowDeletingIteratorTest
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.003 sec
Running org.apache.accumulo.core.iterators.user.WholeRowIteratorTest
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.003 sec
Running org.apache.accumulo.core.iterators.user.IntersectingIteratorTest
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.755 sec
Running org.apache.accumulo.core.iterators.user.RowFilterTest
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.005 sec
Running org.apache.accumulo.core.iterators.user.VersioningIteratorTest
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.003 sec
Running org.apache.accumulo.core.iterators.AggregatingIteratorTest
Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.004 sec
Running org.apache.accumulo.core.iterators.IterUtilTest
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.002 sec
Running org.apache.accumulo.core.iterators.FirstEntryInRowIteratorTest
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 sec
Running org.apache.accumulo.core.conf.PropertyTest
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
Running org.apache.accumulo.core.file.blockfile.cache.TestCachedBlockQueue
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.001 sec
Running org.apache.accumulo.core.file.blockfile.cache.TestLruBlockCache
Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.029 sec
Running org.apache.accumulo.core.file.rfile.RFileTest
Tests run: 21, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.676 sec
Running org.apache.accumulo.core.file.rfile.RelativeKeyTest
Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.012 sec
Running org.apache.accumulo.core.file.rfile.BlockIndexTest
Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.03 sec
Running org.apache.accumulo.core.file.rfile.MultiLevelIndexTest
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.732 sec
Results :
Tests run: 364, Failures: 0, Errors: 0, Skipped: 0
