lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Apache Jenkins Server <jenk...@builds.apache.org>
Subject [JENKINS] Lucene-Solr-NightlyTests-5.4 - Build # 18 - Still Failing
Date Sun, 17 Jan 2016 13:51:17 GMT
Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-5.4/18/

3 tests failed.
FAILED:  org.apache.solr.hadoop.MorphlineBasicMiniMRTest.mrRun

Error Message:
Failed on local exception: java.io.IOException: Connection reset by peer; Host Details : local host is: "lucene1-us-west/10.41.0.5"; destination host is: "lucene1-us-west.apache.org":58873; 

Stack Trace:
java.io.IOException: Failed on local exception: java.io.IOException: Connection reset by peer; Host Details : local host is: "lucene1-us-west/10.41.0.5"; destination host is: "lucene1-us-west.apache.org":58873; 
	at __randomizedtesting.SeedInfo.seed([CF4E7F99D80E3DFF:C11CCB97D9980FF0]:0)
	at org.apache.hadoop.net.NetUtils.wrapException(NetUtils.java:772)
	at org.apache.hadoop.ipc.Client.call(Client.java:1472)
	at org.apache.hadoop.ipc.Client.call(Client.java:1399)
	at org.apache.hadoop.ipc.ProtobufRpcEngine$Invoker.invoke(ProtobufRpcEngine.java:232)
	at com.sun.proxy.$Proxy45.getClusterMetrics(Unknown Source)
	at org.apache.hadoop.yarn.api.impl.pb.client.ApplicationClientProtocolPBClientImpl.getClusterMetrics(ApplicationClientProtocolPBClientImpl.java:202)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.apache.hadoop.io.retry.RetryInvocationHandler.invokeMethod(RetryInvocationHandler.java:187)
	at org.apache.hadoop.io.retry.RetryInvocationHandler.invoke(RetryInvocationHandler.java:102)
	at com.sun.proxy.$Proxy46.getClusterMetrics(Unknown Source)
	at org.apache.hadoop.yarn.client.api.impl.YarnClientImpl.getYarnClusterMetrics(YarnClientImpl.java:461)
	at org.apache.hadoop.mapred.ResourceMgrDelegate.getClusterMetrics(ResourceMgrDelegate.java:151)
	at org.apache.hadoop.mapred.YARNRunner.getClusterMetrics(YARNRunner.java:179)
	at org.apache.hadoop.mapreduce.Cluster.getClusterStatus(Cluster.java:246)
	at org.apache.hadoop.mapred.JobClient$3.run(JobClient.java:719)
	at org.apache.hadoop.mapred.JobClient$3.run(JobClient.java:717)
	at java.security.AccessController.doPrivileged(Native Method)
	at javax.security.auth.Subject.doAs(Subject.java:415)
	at org.apache.hadoop.security.UserGroupInformation.doAs(UserGroupInformation.java:1628)
	at org.apache.hadoop.mapred.JobClient.getClusterStatus(JobClient.java:717)
	at org.apache.solr.hadoop.MapReduceIndexerTool.run(MapReduceIndexerTool.java:645)
	at org.apache.solr.hadoop.MapReduceIndexerTool.run(MapReduceIndexerTool.java:608)
	at org.apache.hadoop.util.ToolRunner.run(ToolRunner.java:70)
	at org.apache.solr.hadoop.MorphlineBasicMiniMRTest.mrRun(MorphlineBasicMiniMRTest.java:363)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.lang.Thread.run(Thread.java:745)
Caused by: java.io.IOException: Connection reset by peer
	at sun.nio.ch.FileDispatcherImpl.write0(Native Method)
	at sun.nio.ch.SocketDispatcher.write(SocketDispatcher.java:47)
	at sun.nio.ch.IOUtil.writeFromNativeBuffer(IOUtil.java:93)
	at sun.nio.ch.IOUtil.write(IOUtil.java:65)
	at sun.nio.ch.SocketChannelImpl.write(SocketChannelImpl.java:492)
	at org.apache.hadoop.net.SocketOutputStream$Writer.performIO(SocketOutputStream.java:63)
	at org.apache.hadoop.net.SocketIOWithTimeout.doIO(SocketIOWithTimeout.java:142)
	at org.apache.hadoop.net.SocketOutputStream.write(SocketOutputStream.java:159)
	at org.apache.hadoop.net.SocketOutputStream.write(SocketOutputStream.java:117)
	at java.io.BufferedOutputStream.flushBuffer(BufferedOutputStream.java:82)
	at java.io.BufferedOutputStream.flush(BufferedOutputStream.java:140)
	at java.io.DataOutputStream.flush(DataOutputStream.java:123)
	at org.apache.hadoop.ipc.Client$Connection$3.run(Client.java:1030)
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
	at java.util.concurrent.FutureTask.run(FutureTask.java:262)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
	... 1 more


FAILED:  org.apache.solr.hadoop.MorphlineGoLiveMiniMRTest.test

Error Message:
Failed on local exception: java.io.IOException: Connection reset by peer; Host Details : local host is: "lucene1-us-west/10.41.0.5"; destination host is: "lucene1-us-west.apache.org":44251; 

Stack Trace:
java.io.IOException: Failed on local exception: java.io.IOException: Connection reset by peer; Host Details : local host is: "lucene1-us-west/10.41.0.5"; destination host is: "lucene1-us-west.apache.org":44251; 
	at __randomizedtesting.SeedInfo.seed([CF4E7F99D80E3DFF:471A404376F25007]:0)
	at org.apache.hadoop.net.NetUtils.wrapException(NetUtils.java:772)
	at org.apache.hadoop.ipc.Client.call(Client.java:1472)
	at org.apache.hadoop.ipc.Client.call(Client.java:1399)
	at org.apache.hadoop.ipc.ProtobufRpcEngine$Invoker.invoke(ProtobufRpcEngine.java:232)
	at com.sun.proxy.$Proxy47.getClusterMetrics(Unknown Source)
	at org.apache.hadoop.yarn.api.impl.pb.client.ApplicationClientProtocolPBClientImpl.getClusterMetrics(ApplicationClientProtocolPBClientImpl.java:202)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.apache.hadoop.io.retry.RetryInvocationHandler.invokeMethod(RetryInvocationHandler.java:187)
	at org.apache.hadoop.io.retry.RetryInvocationHandler.invoke(RetryInvocationHandler.java:102)
	at com.sun.proxy.$Proxy48.getClusterMetrics(Unknown Source)
	at org.apache.hadoop.yarn.client.api.impl.YarnClientImpl.getYarnClusterMetrics(YarnClientImpl.java:461)
	at org.apache.hadoop.mapred.ResourceMgrDelegate.getClusterMetrics(ResourceMgrDelegate.java:151)
	at org.apache.hadoop.mapred.YARNRunner.getClusterMetrics(YARNRunner.java:179)
	at org.apache.hadoop.mapreduce.Cluster.getClusterStatus(Cluster.java:246)
	at org.apache.hadoop.mapred.JobClient$3.run(JobClient.java:719)
	at org.apache.hadoop.mapred.JobClient$3.run(JobClient.java:717)
	at java.security.AccessController.doPrivileged(Native Method)
	at javax.security.auth.Subject.doAs(Subject.java:415)
	at org.apache.hadoop.security.UserGroupInformation.doAs(UserGroupInformation.java:1628)
	at org.apache.hadoop.mapred.JobClient.getClusterStatus(JobClient.java:717)
	at org.apache.solr.hadoop.MapReduceIndexerTool.run(MapReduceIndexerTool.java:645)
	at org.apache.solr.hadoop.MapReduceIndexerTool.run(MapReduceIndexerTool.java:608)
	at org.apache.hadoop.util.ToolRunner.run(ToolRunner.java:70)
	at org.apache.solr.hadoop.MorphlineGoLiveMiniMRTest.test(MorphlineGoLiveMiniMRTest.java:402)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:964)
	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:939)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.lang.Thread.run(Thread.java:745)
Caused by: java.io.IOException: Connection reset by peer
	at sun.nio.ch.FileDispatcherImpl.read0(Native Method)
	at sun.nio.ch.SocketDispatcher.read(SocketDispatcher.java:39)
	at sun.nio.ch.IOUtil.readIntoNativeBuffer(IOUtil.java:223)
	at sun.nio.ch.IOUtil.read(IOUtil.java:197)
	at sun.nio.ch.SocketChannelImpl.read(SocketChannelImpl.java:384)
	at org.apache.hadoop.net.SocketInputStream$Reader.performIO(SocketInputStream.java:57)
	at org.apache.hadoop.net.SocketIOWithTimeout.doIO(SocketIOWithTimeout.java:142)
	at org.apache.hadoop.net.SocketInputStream.read(SocketInputStream.java:161)
	at org.apache.hadoop.net.SocketInputStream.read(SocketInputStream.java:131)
	at java.io.FilterInputStream.read(FilterInputStream.java:133)
	at java.io.FilterInputStream.read(FilterInputStream.java:133)
	at org.apache.hadoop.ipc.Client$Connection$PingInputStream.read(Client.java:513)
	at java.io.BufferedInputStream.fill(BufferedInputStream.java:235)
	at java.io.BufferedInputStream.read(BufferedInputStream.java:254)
	at java.io.DataInputStream.readInt(DataInputStream.java:387)
	at org.apache.hadoop.ipc.Client$Connection.receiveRpcResponse(Client.java:1071)
	at org.apache.hadoop.ipc.Client$Connection.run(Client.java:966)


FAILED:  junit.framework.TestSuite.org.apache.solr.hadoop.MorphlineGoLiveMiniMRTest

Error Message:
1 thread leaked from SUITE scope at org.apache.solr.hadoop.MorphlineGoLiveMiniMRTest:     1) Thread[id=1002, name=Node Status Updater, state=TIMED_WAITING, group=TGRP-MorphlineGoLiveMiniMRTest]         at java.lang.Object.wait(Native Method)         at org.apache.hadoop.yarn.server.nodemanager.NodeStatusUpdaterImpl$1.run(NodeStatusUpdaterImpl.java:659)         at java.lang.Thread.run(Thread.java:745)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE scope at org.apache.solr.hadoop.MorphlineGoLiveMiniMRTest: 
   1) Thread[id=1002, name=Node Status Updater, state=TIMED_WAITING, group=TGRP-MorphlineGoLiveMiniMRTest]
        at java.lang.Object.wait(Native Method)
        at org.apache.hadoop.yarn.server.nodemanager.NodeStatusUpdaterImpl$1.run(NodeStatusUpdaterImpl.java:659)
        at java.lang.Thread.run(Thread.java:745)
	at __randomizedtesting.SeedInfo.seed([CF4E7F99D80E3DFF]:0)




Build Log:
[...truncated 18283 lines...]
   [junit4] Suite: org.apache.solr.hadoop.MorphlineGoLiveMiniMRTest
   [junit4]   2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/init-core-data-001
   [junit4]   2> 0    INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
   [junit4]   2> 2447 WARN  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.u.NativeCodeLoader Unable to load native-hadoop library for your platform... using builtin-java classes where applicable
   [junit4]   1> Formatting using clusterid: testClusterID
   [junit4]   2> 2606 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSNamesystem No KeyProvider found.
   [junit4]   2> 2669 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSNamesystem fsLock is fair:true
   [junit4]   2> 2762 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.c.C.deprecation hadoop.configured.node.mapping is deprecated. Instead, use net.topology.configured.node.mapping
   [junit4]   2> 2762 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.b.DatanodeManager dfs.block.invalidate.limit=1000
   [junit4]   2> 2763 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.b.DatanodeManager dfs.namenode.datanode.registration.ip-hostname-check=true
   [junit4]   2> 2766 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.b.BlockManager dfs.namenode.startup.delay.block.deletion.sec is set to 000:00:00:00.000
   [junit4]   2> 2769 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.b.BlockManager The block deletion will start around 2016 ene 17 06:17:44
   [junit4]   2> 2773 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.u.GSet Computing capacity for map BlocksMap
   [junit4]   2> 2774 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.u.GSet VM type       = 64-bit
   [junit4]   2> 2777 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.u.GSet 2.0% max memory 455 MB = 9.1 MB
   [junit4]   2> 2777 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.u.GSet capacity      = 2^20 = 1048576 entries
   [junit4]   2> 2805 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.b.BlockManager dfs.block.access.token.enable=false
   [junit4]   2> 2806 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.b.BlockManager defaultReplication         = 2
   [junit4]   2> 2806 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.b.BlockManager maxReplication             = 512
   [junit4]   2> 2807 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.b.BlockManager minReplication             = 1
   [junit4]   2> 2807 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.b.BlockManager maxReplicationStreams      = 2
   [junit4]   2> 2807 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.b.BlockManager shouldCheckForEnoughRacks  = false
   [junit4]   2> 2808 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.b.BlockManager replicationRecheckInterval = 3000
   [junit4]   2> 2808 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.b.BlockManager encryptDataTransfer        = false
   [junit4]   2> 2808 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.b.BlockManager maxNumBlocksToLog          = 1000
   [junit4]   2> 2818 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSNamesystem fsOwner             = jenkins (auth:SIMPLE)
   [junit4]   2> 2819 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSNamesystem supergroup          = supergroup
   [junit4]   2> 2819 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSNamesystem isPermissionEnabled = true
   [junit4]   2> 2820 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSNamesystem HA Enabled: false
   [junit4]   2> 2826 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSNamesystem Append Enabled: true
   [junit4]   2> 3244 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.u.GSet Computing capacity for map INodeMap
   [junit4]   2> 3245 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.u.GSet VM type       = 64-bit
   [junit4]   2> 3246 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.u.GSet 1.0% max memory 455 MB = 4.5 MB
   [junit4]   2> 3246 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.u.GSet capacity      = 2^19 = 524288 entries
   [junit4]   2> 3247 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.NameNode Caching file names occuring more than 10 times
   [junit4]   2> 3264 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.u.GSet Computing capacity for map cachedBlocks
   [junit4]   2> 3264 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.u.GSet VM type       = 64-bit
   [junit4]   2> 3265 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.u.GSet 0.25% max memory 455 MB = 1.1 MB
   [junit4]   2> 3265 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.u.GSet capacity      = 2^17 = 131072 entries
   [junit4]   2> 3268 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSNamesystem dfs.namenode.safemode.threshold-pct = 0.9990000128746033
   [junit4]   2> 3268 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSNamesystem dfs.namenode.safemode.min.datanodes = 0
   [junit4]   2> 3269 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSNamesystem dfs.namenode.safemode.extension     = 0
   [junit4]   2> 3272 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSNamesystem Retry cache on namenode is enabled
   [junit4]   2> 3273 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSNamesystem Retry cache will use 0.03 of total heap and retry cache entry expiry time is 600000 millis
   [junit4]   2> 3279 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.u.GSet Computing capacity for map NameNodeRetryCache
   [junit4]   2> 3280 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.u.GSet VM type       = 64-bit
   [junit4]   2> 3280 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.u.GSet 0.029999999329447746% max memory 455 MB = 139.8 KB
   [junit4]   2> 3281 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.u.GSet capacity      = 2^14 = 16384 entries
   [junit4]   2> 3314 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.NNConf ACLs enabled? false
   [junit4]   2> 3315 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.NNConf XAttrs enabled? true
   [junit4]   2> 3315 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.NNConf Maximum size of an xattr: 16384
   [junit4]   2> 3417 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSImage Allocated new BlockPoolId: BP-1170593033-10.41.0.5-1453036664718
   [junit4]   2> 3444 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.c.Storage Storage directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/name1 has been successfully formatted.
   [junit4]   2> 3460 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.c.Storage Storage directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/name2 has been successfully formatted.
   [junit4]   2> 3729 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.NNStorageRetentionManager Going to retain 1 images with txid >= 0
   [junit4]   2> 3733 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.NameNode createNameNode []
   [junit4]   2> 3799 WARN  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.m.i.MetricsConfig Cannot locate configuration: tried hadoop-metrics2-namenode.properties,hadoop-metrics2.properties
   [junit4]   2> 3895 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.m.i.MetricsSystemImpl Scheduled snapshot period at 10 second(s).
   [junit4]   2> 3895 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.m.i.MetricsSystemImpl NameNode metrics system started
   [junit4]   2> 3901 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.NameNode fs.defaultFS is hdfs://127.0.0.1:0
   [junit4]   2> 3995 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.DFSUtil Starting Web-server for hdfs at: http://localhost:0
   [junit4]   2> 4190 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.m.log Logging to org.slf4j.impl.Log4jLoggerAdapter(org.mortbay.log) via org.mortbay.log.Slf4jLog
   [junit4]   2> 4205 WARN  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
   [junit4]   2> 4239 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.HttpServer2 Added global filter 'safety' (class=org.apache.hadoop.http.HttpServer2$QuotingInputFilter)
   [junit4]   2> 4244 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.HttpServer2 Added filter static_user_filter (class=org.apache.hadoop.http.lib.StaticUserWebFilter$StaticUserFilter) to context hdfs
   [junit4]   2> 4245 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.HttpServer2 Added filter static_user_filter (class=org.apache.hadoop.http.lib.StaticUserWebFilter$StaticUserFilter) to context logs
   [junit4]   2> 4257 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.HttpServer2 Added filter static_user_filter (class=org.apache.hadoop.http.lib.StaticUserWebFilter$StaticUserFilter) to context static
   [junit4]   2> 4330 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.HttpServer2 Added filter 'org.apache.hadoop.hdfs.web.AuthFilter' (class=org.apache.hadoop.hdfs.web.AuthFilter)
   [junit4]   2> 4333 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.HttpServer2 addJerseyResourcePackage: packageName=org.apache.hadoop.hdfs.server.namenode.web.resources;org.apache.hadoop.hdfs.web.resources, pathSpec=/webhdfs/v1/*
   [junit4]   2> 4363 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.HttpServer2 Jetty bound to port 35845
   [junit4]   2> 4363 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.m.log jetty-6.1.26
   [junit4]   2> 4476 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.m.log Extract jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.6.0-tests.jar!/webapps/hdfs to ./temp/Jetty_localhost_35845_hdfs____f11ltt/webapp
   [junit4]   2> 4745 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.m.log NO JSP Support for /, did not find org.apache.jasper.servlet.JspServlet
   [junit4]   2> 5913 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.m.log Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:35845
   [junit4]   2> 5926 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSNamesystem No KeyProvider found.
   [junit4]   2> 5926 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSNamesystem fsLock is fair:true
   [junit4]   2> 5927 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.b.DatanodeManager dfs.block.invalidate.limit=1000
   [junit4]   2> 5927 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.b.DatanodeManager dfs.namenode.datanode.registration.ip-hostname-check=true
   [junit4]   2> 5928 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.b.BlockManager dfs.namenode.startup.delay.block.deletion.sec is set to 000:00:00:00.000
   [junit4]   2> 5928 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.b.BlockManager The block deletion will start around 2016 ene 17 06:17:47
   [junit4]   2> 5928 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.u.GSet Computing capacity for map BlocksMap
   [junit4]   2> 5929 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.u.GSet VM type       = 64-bit
   [junit4]   2> 5929 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.u.GSet 2.0% max memory 455 MB = 9.1 MB
   [junit4]   2> 5929 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.u.GSet capacity      = 2^20 = 1048576 entries
   [junit4]   2> 5930 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.b.BlockManager dfs.block.access.token.enable=false
   [junit4]   2> 5930 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.b.BlockManager defaultReplication         = 2
   [junit4]   2> 5931 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.b.BlockManager maxReplication             = 512
   [junit4]   2> 5931 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.b.BlockManager minReplication             = 1
   [junit4]   2> 5931 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.b.BlockManager maxReplicationStreams      = 2
   [junit4]   2> 5931 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.b.BlockManager shouldCheckForEnoughRacks  = false
   [junit4]   2> 5931 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.b.BlockManager replicationRecheckInterval = 3000
   [junit4]   2> 5931 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.b.BlockManager encryptDataTransfer        = false
   [junit4]   2> 5932 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.b.BlockManager maxNumBlocksToLog          = 1000
   [junit4]   2> 5932 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSNamesystem fsOwner             = jenkins (auth:SIMPLE)
   [junit4]   2> 5932 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSNamesystem supergroup          = supergroup
   [junit4]   2> 5932 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSNamesystem isPermissionEnabled = true
   [junit4]   2> 5933 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSNamesystem HA Enabled: false
   [junit4]   2> 5933 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSNamesystem Append Enabled: true
   [junit4]   2> 5934 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.u.GSet Computing capacity for map INodeMap
   [junit4]   2> 5934 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.u.GSet VM type       = 64-bit
   [junit4]   2> 5934 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.u.GSet 1.0% max memory 455 MB = 4.5 MB
   [junit4]   2> 5934 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.u.GSet capacity      = 2^19 = 524288 entries
   [junit4]   2> 5935 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.NameNode Caching file names occuring more than 10 times
   [junit4]   2> 5935 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.u.GSet Computing capacity for map cachedBlocks
   [junit4]   2> 5935 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.u.GSet VM type       = 64-bit
   [junit4]   2> 5935 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.u.GSet 0.25% max memory 455 MB = 1.1 MB
   [junit4]   2> 5936 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.u.GSet capacity      = 2^17 = 131072 entries
   [junit4]   2> 5936 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSNamesystem dfs.namenode.safemode.threshold-pct = 0.9990000128746033
   [junit4]   2> 5936 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSNamesystem dfs.namenode.safemode.min.datanodes = 0
   [junit4]   2> 5936 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSNamesystem dfs.namenode.safemode.extension     = 0
   [junit4]   2> 5936 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSNamesystem Retry cache on namenode is enabled
   [junit4]   2> 5937 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSNamesystem Retry cache will use 0.03 of total heap and retry cache entry expiry time is 600000 millis
   [junit4]   2> 5937 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.u.GSet Computing capacity for map NameNodeRetryCache
   [junit4]   2> 5937 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.u.GSet VM type       = 64-bit
   [junit4]   2> 5937 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.u.GSet 0.029999999329447746% max memory 455 MB = 139.8 KB
   [junit4]   2> 5937 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.u.GSet capacity      = 2^14 = 16384 entries
   [junit4]   2> 5940 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.NNConf ACLs enabled? false
   [junit4]   2> 5940 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.NNConf XAttrs enabled? true
   [junit4]   2> 5941 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.NNConf Maximum size of an xattr: 16384
   [junit4]   2> 5948 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.c.Storage Lock on /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/name1/in_use.lock acquired by nodename 16547@lucene1-us-west
   [junit4]   2> 5954 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.c.Storage Lock on /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/name2/in_use.lock acquired by nodename 16547@lucene1-us-west
   [junit4]   2> 5959 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FileJournalManager Recovering unfinalized segments in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/name1/current
   [junit4]   2> 5959 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FileJournalManager Recovering unfinalized segments in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/name2/current
   [junit4]   2> 5960 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSImage No edit log streams selected.
   [junit4]   2> 6010 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSImageFormatPBINode Loading 1 INodes.
   [junit4]   2> 6025 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSImageFormatProtobuf Loaded FSImage in 0 seconds.
   [junit4]   2> 6025 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSImage Loaded image for txid 0 from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/name1/current/fsimage_0000000000000000000
   [junit4]   2> 6032 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSNamesystem Need to save fs image? false (staleImage=false, haEnabled=false, isRollingUpgrade=false)
   [junit4]   2> 6033 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSEditLog Starting log segment at 1
   [junit4]   2> 6111 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.NameCache initialized with 0 entries 0 lookups
   [junit4]   2> 6112 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSNamesystem Finished loading FSImage in 171 msecs
   [junit4]   2> 6493 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.NameNode RPC server is binding to localhost:0
   [junit4]   2> 6508 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.i.CallQueueManager Using callQueue class java.util.concurrent.LinkedBlockingQueue
   [junit4]   2> 6534 INFO  (Socket Reader #1 for port 48961) [    ] o.a.h.i.Server Starting Socket Reader #1 for port 48961
   [junit4]   2> 6584 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.NameNode Clients are to use localhost:48961 to access this namenode/service.
   [junit4]   2> 6588 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSNamesystem Registered FSNamesystemState MBean
   [junit4]   2> 6606 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSNamesystem Number of blocks under construction: 0
   [junit4]   2> 6606 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSNamesystem Number of blocks under construction: 0
   [junit4]   2> 6607 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSNamesystem initializing replication queues
   [junit4]   2> 6607 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.StateChange STATE* Leaving safe mode after 0 secs
   [junit4]   2> 6607 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.StateChange STATE* Network topology has 0 racks and 0 datanodes
   [junit4]   2> 6608 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.StateChange STATE* UnderReplicatedBlocks has 0 blocks
   [junit4]   2> 6612 INFO  (Replication Queue Initializer) [    ] o.a.h.h.s.b.BlockManager Total number of blocks            = 0
   [junit4]   2> 6613 INFO  (Replication Queue Initializer) [    ] o.a.h.h.s.b.BlockManager Number of invalid blocks          = 0
   [junit4]   2> 6613 INFO  (Replication Queue Initializer) [    ] o.a.h.h.s.b.BlockManager Number of under-replicated blocks = 0
   [junit4]   2> 6613 INFO  (Replication Queue Initializer) [    ] o.a.h.h.s.b.BlockManager Number of  over-replicated blocks = 0
   [junit4]   2> 6613 INFO  (Replication Queue Initializer) [    ] o.a.h.h.s.b.BlockManager Number of blocks being written    = 0
   [junit4]   2> 6613 INFO  (Replication Queue Initializer) [    ] o.a.h.h.StateChange STATE* Replication Queue initialization scan for invalid, over- and under-replicated blocks completed in 6 msec
   [junit4]   2> 6677 INFO  (IPC Server Responder) [    ] o.a.h.i.Server IPC Server Responder: starting
   [junit4]   2> 6681 INFO  (IPC Server listener on 48961) [    ] o.a.h.i.Server IPC Server listener on 48961: starting
   [junit4]   2> 6686 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.NameNode NameNode RPC up at: localhost/127.0.0.1:48961
   [junit4]   2> 6687 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSNamesystem Starting services required for active state
   [junit4]   2> 6701 INFO  (CacheReplicationMonitor(948290431)) [    ] o.a.h.h.s.b.CacheReplicationMonitor Starting CacheReplicationMonitor with interval 30000 milliseconds
   [junit4]   2> 6701 INFO  (CacheReplicationMonitor(948290431)) [    ] o.a.h.h.s.b.CacheReplicationMonitor Rescanning after 21496960460 milliseconds
   [junit4]   2> 6702 INFO  (CacheReplicationMonitor(948290431)) [    ] o.a.h.h.s.b.CacheReplicationMonitor Scanned 0 directive(s) and 0 block(s) in 1 millisecond(s).
   [junit4]   2> 6710 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.MiniDFSCluster Starting DataNode 0 with dfs.datanode.data.dir: [DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1,[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2
   [junit4]   2> 6807 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.m.i.MetricsSystemImpl DataNode metrics system started (again)
   [junit4]   2> 6808 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.d.DataNode Configured hostname is 127.0.0.1
   [junit4]   2> 6817 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.d.DataNode Starting DataNode with maxLockedMemory = 0
   [junit4]   2> 6827 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.d.DataNode Opened streaming server at /127.0.0.1:48492
   [junit4]   2> 6832 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.d.DataNode Balancing bandwith is 1048576 bytes/s
   [junit4]   2> 6832 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.d.DataNode Number threads for balancing is 5
   [junit4]   2> 6838 WARN  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
   [junit4]   2> 6840 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.HttpServer2 Added global filter 'safety' (class=org.apache.hadoop.http.HttpServer2$QuotingInputFilter)
   [junit4]   2> 6841 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.HttpServer2 Added filter static_user_filter (class=org.apache.hadoop.http.lib.StaticUserWebFilter$StaticUserFilter) to context datanode
   [junit4]   2> 6841 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.HttpServer2 Added filter static_user_filter (class=org.apache.hadoop.http.lib.StaticUserWebFilter$StaticUserFilter) to context static
   [junit4]   2> 6841 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.HttpServer2 Added filter static_user_filter (class=org.apache.hadoop.http.lib.StaticUserWebFilter$StaticUserFilter) to context logs
   [junit4]   2> 6848 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.HttpServer2 addJerseyResourcePackage: packageName=org.apache.hadoop.hdfs.server.datanode.web.resources;org.apache.hadoop.hdfs.web.resources, pathSpec=/webhdfs/v1/*
   [junit4]   2> 6849 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.HttpServer2 Jetty bound to port 34818
   [junit4]   2> 6849 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.m.log jetty-6.1.26
   [junit4]   2> 6872 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.m.log Extract jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.6.0-tests.jar!/webapps/datanode to ./temp/Jetty_localhost_34818_datanode____.wsrum3/webapp
   [junit4]   2> 7018 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.m.log NO JSP Support for /, did not find org.apache.jasper.servlet.JspServlet
   [junit4]   2> 36701 INFO  (CacheReplicationMonitor(948290431)) [    ] o.a.h.h.s.b.CacheReplicationMonitor Rescanning after 30000 milliseconds
   [junit4]   2> 36702 INFO  (CacheReplicationMonitor(948290431)) [    ] o.a.h.h.s.b.CacheReplicationMonitor Scanned 0 directive(s) and 0 block(s) in 1 millisecond(s).
   [junit4]   2> 66701 INFO  (CacheReplicationMonitor(948290431)) [    ] o.a.h.h.s.b.CacheReplicationMonitor Rescanning after 30000 milliseconds
   [junit4]   2> 66702 INFO  (CacheReplicationMonitor(948290431)) [    ] o.a.h.h.s.b.CacheReplicationMonitor Scanned 0 directive(s) and 0 block(s) in 1 millisecond(s).
   [junit4]   2> 96701 INFO  (CacheReplicationMonitor(948290431)) [    ] o.a.h.h.s.b.CacheReplicationMonitor Rescanning after 30000 milliseconds
   [junit4]   2> 96701 INFO  (CacheReplicationMonitor(948290431)) [    ] o.a.h.h.s.b.CacheReplicationMonitor Scanned 0 directive(s) and 0 block(s) in 0 millisecond(s).
   [junit4]   2> 126702 INFO  (CacheReplicationMonitor(948290431)) [    ] o.a.h.h.s.b.CacheReplicationMonitor Rescanning after 30001 milliseconds
   [junit4]   2> 126702 INFO  (CacheReplicationMonitor(948290431)) [    ] o.a.h.h.s.b.CacheReplicationMonitor Scanned 0 directive(s) and 0 block(s) in 0 millisecond(s).
   [junit4]   2> 156703 INFO  (CacheReplicationMonitor(948290431)) [    ] o.a.h.h.s.b.CacheReplicationMonitor Rescanning after 30001 milliseconds
   [junit4]   2> 156704 INFO  (CacheReplicationMonitor(948290431)) [    ] o.a.h.h.s.b.CacheReplicationMonitor Scanned 0 directive(s) and 0 block(s) in 1 millisecond(s).
   [junit4]   2> 186703 INFO  (CacheReplicationMonitor(948290431)) [    ] o.a.h.h.s.b.CacheReplicationMonitor Rescanning after 30000 milliseconds
   [junit4]   2> 186704 INFO  (CacheReplicationMonitor(948290431)) [    ] o.a.h.h.s.b.CacheReplicationMonitor Scanned 0 directive(s) and 0 block(s) in 1 millisecond(s).
   [junit4]   2> 216703 INFO  (CacheReplicationMonitor(948290431)) [    ] o.a.h.h.s.b.CacheReplicationMonitor Rescanning after 30000 milliseconds
   [junit4]   2> 216704 INFO  (CacheReplicationMonitor(948290431)) [    ] o.a.h.h.s.b.CacheReplicationMonitor Scanned 0 directive(s) and 0 block(s) in 1 millisecond(s).
   [junit4]   2> 246704 INFO  (CacheReplicationMonitor(948290431)) [    ] o.a.h.h.s.b.CacheReplicationMonitor Rescanning after 30001 milliseconds
   [junit4]   2> 246704 INFO  (CacheReplicationMonitor(948290431)) [    ] o.a.h.h.s.b.CacheReplicationMonitor Scanned 0 directive(s) and 0 block(s) in 0 millisecond(s).
   [junit4]   2> 261955 WARN  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.m.log EXCEPTION 
   [junit4]   2> java.net.ConnectException: Connection timed out
   [junit4]   2> 	at java.net.PlainSocketImpl.socketConnect(Native Method)
   [junit4]   2> 	at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:339)
   [junit4]   2> 	at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:200)
   [junit4]   2> 	at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:182)
   [junit4]   2> 	at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392)
   [junit4]   2> 	at java.net.Socket.connect(Socket.java:579)
   [junit4]   2> 	at java.net.Socket.connect(Socket.java:528)
   [junit4]   2> 	at sun.net.NetworkClient.doConnect(NetworkClient.java:180)
   [junit4]   2> 	at sun.net.www.http.HttpClient.openServer(HttpClient.java:432)
   [junit4]   2> 	at sun.net.www.http.HttpClient.openServer(HttpClient.java:527)
   [junit4]   2> 	at sun.net.www.http.HttpClient.<init>(HttpClient.java:211)
   [junit4]   2> 	at sun.net.www.http.HttpClient.New(HttpClient.java:308)
   [junit4]   2> 	at sun.net.www.http.HttpClient.New(HttpClient.java:326)
   [junit4]   2> 	at sun.net.www.protocol.http.HttpURLConnection.getNewHttpClient(HttpURLConnection.java:997)
   [junit4]   2> 	at sun.net.www.protocol.http.HttpURLConnection.plainConnect(HttpURLConnection.java:933)
   [junit4]   2> 	at sun.net.www.protocol.http.HttpURLConnection.connect(HttpURLConnection.java:851)
   [junit4]   2> 	at sun.net.www.protocol.http.HttpURLConnection.getInputStream(HttpURLConnection.java:1301)
   [junit4]   2> 	at org.apache.xerces.impl.XMLEntityManager.setupCurrentEntity(Unknown Source)
   [junit4]   2> 	at org.apache.xerces.impl.XMLEntityManager.startEntity(Unknown Source)
   [junit4]   2> 	at org.apache.xerces.impl.XMLEntityManager.startDTDEntity(Unknown Source)
   [junit4]   2> 	at org.apache.xerces.impl.XMLDTDScannerImpl.setInputSource(Unknown Source)
   [junit4]   2> 	at org.apache.xerces.impl.XMLDocumentScannerImpl$DTDDispatcher.dispatch(Unknown Source)
   [junit4]   2> 	at org.apache.xerces.impl.XMLDocumentFragmentScannerImpl.scanDocument(Unknown Source)
   [junit4]   2> 	at org.apache.xerces.parsers.XML11Configuration.parse(Unknown Source)
   [junit4]   2> 	at org.apache.xerces.parsers.XML11Configuration.parse(Unknown Source)
   [junit4]   2> 	at org.apache.xerces.parsers.XMLParser.parse(Unknown Source)
   [junit4]   2> 	at org.apache.xerces.parsers.AbstractSAXParser.parse(Unknown Source)
   [junit4]   2> 	at org.apache.xerces.jaxp.SAXParserImpl$JAXPSAXParser.parse(Unknown Source)
   [junit4]   2> 	at org.apache.xerces.jaxp.SAXParserImpl.parse(Unknown Source)
   [junit4]   2> 	at org.mortbay.xml.XmlParser.parse(XmlParser.java:188)
   [junit4]   2> 	at org.mortbay.xml.XmlParser.parse(XmlParser.java:204)
   [junit4]   2> 	at org.mortbay.jetty.webapp.TagLibConfiguration.configureWebApp(TagLibConfiguration.java:238)
   [junit4]   2> 	at org.mortbay.jetty.webapp.WebAppContext.startContext(WebAppContext.java:1279)
   [junit4]   2> 	at org.mortbay.jetty.handler.ContextHandler.doStart(ContextHandler.java:518)
   [junit4]   2> 	at org.mortbay.jetty.webapp.WebAppContext.doStart(WebAppContext.java:499)
   [junit4]   2> 	at org.mortbay.component.AbstractLifeCycle.start(AbstractLifeCycle.java:50)
   [junit4]   2> 	at org.mortbay.jetty.handler.HandlerCollection.doStart(HandlerCollection.java:152)
   [junit4]   2> 	at org.mortbay.jetty.handler.ContextHandlerCollection.doStart(ContextHandlerCollection.java:156)
   [junit4]   2> 	at org.mortbay.component.AbstractLifeCycle.start(AbstractLifeCycle.java:50)
   [junit4]   2> 	at org.mortbay.jetty.handler.HandlerWrapper.doStart(HandlerWrapper.java:130)
   [junit4]   2> 	at org.mortbay.jetty.Server.doStart(Server.java:224)
   [junit4]   2> 	at org.mortbay.component.AbstractLifeCycle.start(AbstractLifeCycle.java:50)
   [junit4]   2> 	at org.apache.hadoop.http.HttpServer2.start(HttpServer2.java:828)
   [junit4]   2> 	at org.apache.hadoop.hdfs.server.datanode.DataNode.startInfoServer(DataNode.java:663)
   [junit4]   2> 	at org.apache.hadoop.hdfs.server.datanode.DataNode.startDataNode(DataNode.java:1057)
   [junit4]   2> 	at org.apache.hadoop.hdfs.server.datanode.DataNode.<init>(DataNode.java:415)
   [junit4]   2> 	at org.apache.hadoop.hdfs.server.datanode.DataNode.makeInstance(DataNode.java:2268)
   [junit4]   2> 	at org.apache.hadoop.hdfs.server.datanode.DataNode.instantiateDataNode(DataNode.java:2155)
   [junit4]   2> 	at org.apache.hadoop.hdfs.MiniDFSCluster.startDataNodes(MiniDFSCluster.java:1443)
   [junit4]   2> 	at org.apache.hadoop.hdfs.MiniDFSCluster.initMiniDFSCluster(MiniDFSCluster.java:828)
   [junit4]   2> 	at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:738)
   [junit4]   2> 	at org.apache.hadoop.hdfs.MiniDFSCluster.<init>(MiniDFSCluster.java:608)
   [junit4]   2> 	at org.apache.solr.hadoop.MorphlineGoLiveMiniMRTest.setupClass(MorphlineGoLiveMiniMRTest.java:183)
   [junit4]   2> 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4]   2> 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
   [junit4]   2> 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]   2> 	at java.lang.reflect.Method.invoke(Method.java:606)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:811)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
   [junit4]   2> 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 261966 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.m.log Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:34818
   [junit4]   2> 261968 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.d.DataNode dnUserName = jenkins
   [junit4]   2> 261969 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.d.DataNode supergroup = supergroup
   [junit4]   2> 262002 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.i.CallQueueManager Using callQueue class java.util.concurrent.LinkedBlockingQueue
   [junit4]   2> 262003 INFO  (Socket Reader #1 for port 38686) [    ] o.a.h.i.Server Starting Socket Reader #1 for port 38686
   [junit4]   2> 262018 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.d.DataNode Opened IPC server at /127.0.0.1:38686
   [junit4]   2> 262059 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.d.DataNode Refresh request received for nameservices: null
   [junit4]   2> 262065 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.d.DataNode Starting BPOfferServices for nameservices: <default>
   [junit4]   2> 262084 INFO  (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/, [DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/]]  heartbeating to localhost/127.0.0.1:48961) [    ] o.a.h.h.s.d.DataNode Block pool <registering> (Datanode Uuid unassigned) service to localhost/127.0.0.1:48961 starting to offer service
   [junit4]   2> 262095 INFO  (IPC Server Responder) [    ] o.a.h.i.Server IPC Server Responder: starting
   [junit4]   2> 262098 INFO  (IPC Server listener on 38686) [    ] o.a.h.i.Server IPC Server listener on 38686: starting
   [junit4]   2> 262111 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.MiniDFSCluster Starting DataNode 1 with dfs.datanode.data.dir: [DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data3,[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data4
   [junit4]   2> 262139 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.m.i.MetricsSystemImpl DataNode metrics system started (again)
   [junit4]   2> 262139 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.d.DataNode Configured hostname is 127.0.0.1
   [junit4]   2> 262140 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.d.DataNode Starting DataNode with maxLockedMemory = 0
   [junit4]   2> 262141 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.d.DataNode Opened streaming server at /127.0.0.1:40948
   [junit4]   2> 262142 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.d.DataNode Balancing bandwith is 1048576 bytes/s
   [junit4]   2> 262142 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.d.DataNode Number threads for balancing is 5
   [junit4]   2> 262145 WARN  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
   [junit4]   2> 262147 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.HttpServer2 Added global filter 'safety' (class=org.apache.hadoop.http.HttpServer2$QuotingInputFilter)
   [junit4]   2> 262148 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.HttpServer2 Added filter static_user_filter (class=org.apache.hadoop.http.lib.StaticUserWebFilter$StaticUserFilter) to context datanode
   [junit4]   2> 262148 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.HttpServer2 Added filter static_user_filter (class=org.apache.hadoop.http.lib.StaticUserWebFilter$StaticUserFilter) to context static
   [junit4]   2> 262148 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.HttpServer2 Added filter static_user_filter (class=org.apache.hadoop.http.lib.StaticUserWebFilter$StaticUserFilter) to context logs
   [junit4]   2> 262151 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.HttpServer2 addJerseyResourcePackage: packageName=org.apache.hadoop.hdfs.server.datanode.web.resources;org.apache.hadoop.hdfs.web.resources, pathSpec=/webhdfs/v1/*
   [junit4]   2> 262151 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.HttpServer2 Jetty bound to port 56961
   [junit4]   2> 262152 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.m.log jetty-6.1.26
   [junit4]   2> 262182 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.m.log Extract jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.6.0-tests.jar!/webapps/datanode to ./temp/Jetty_localhost_56961_datanode____c64k4a/webapp
   [junit4]   2> 262332 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.m.log NO JSP Support for /, did not find org.apache.jasper.servlet.JspServlet
   [junit4]   2> 262601 INFO  (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/, [DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/]]  heartbeating to localhost/127.0.0.1:48961) [    ] o.a.h.h.s.c.Storage DataNode version: -56 and NameNode layout version: -60
   [junit4]   2> 262605 INFO  (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/, [DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/]]  heartbeating to localhost/127.0.0.1:48961) [    ] o.a.h.h.s.c.Storage Lock on /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/in_use.lock acquired by nodename 16547@lucene1-us-west
   [junit4]   2> 262607 INFO  (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/, [DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/]]  heartbeating to localhost/127.0.0.1:48961) [    ] o.a.h.h.s.c.Storage Storage directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1 is not formatted for BP-1170593033-10.41.0.5-1453036664718
   [junit4]   2> 262607 INFO  (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/, [DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/]]  heartbeating to localhost/127.0.0.1:48961) [    ] o.a.h.h.s.c.Storage Formatting ...
   [junit4]   2> 262614 INFO  (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/, [DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/]]  heartbeating to localhost/127.0.0.1:48961) [    ] o.a.h.h.s.c.Storage Lock on /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/in_use.lock acquired by nodename 16547@lucene1-us-west
   [junit4]   2> 262615 INFO  (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/, [DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/]]  heartbeating to localhost/127.0.0.1:48961) [    ] o.a.h.h.s.c.Storage Storage directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2 is not formatted for BP-1170593033-10.41.0.5-1453036664718
   [junit4]   2> 262615 INFO  (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/, [DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/]]  heartbeating to localhost/127.0.0.1:48961) [    ] o.a.h.h.s.c.Storage Formatting ...
   [junit4]   2> 262729 INFO  (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/, [DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/]]  heartbeating to localhost/127.0.0.1:48961) [    ] o.a.h.h.s.c.Storage Analyzing storage directories for bpid BP-1170593033-10.41.0.5-1453036664718
   [junit4]   2> 262730 INFO  (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/, [DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/]]  heartbeating to localhost/127.0.0.1:48961) [    ] o.a.h.h.s.c.Storage Locking is disabled
   [junit4]   2> 262732 INFO  (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/, [DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/]]  heartbeating to localhost/127.0.0.1:48961) [    ] o.a.h.h.s.c.Storage Storage directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/current/BP-1170593033-10.41.0.5-1453036664718 is not formatted.
   [junit4]   2> 262732 INFO  (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/, [DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/]]  heartbeating to localhost/127.0.0.1:48961) [    ] o.a.h.h.s.c.Storage Formatting ...
   [junit4]   2> 262733 INFO  (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/, [DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/]]  heartbeating to localhost/127.0.0.1:48961) [    ] o.a.h.h.s.c.Storage Formatting block pool BP-1170593033-10.41.0.5-1453036664718 directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/current/BP-1170593033-10.41.0.5-1453036664718/current
   [junit4]   2> 262736 INFO  (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/, [DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/]]  heartbeating to localhost/127.0.0.1:48961) [    ] o.a.h.h.s.c.Storage Locking is disabled
   [junit4]   2> 262737 INFO  (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/, [DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/]]  heartbeating to localhost/127.0.0.1:48961) [    ] o.a.h.h.s.c.Storage Storage directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/current/BP-1170593033-10.41.0.5-1453036664718 is not formatted.
   [junit4]   2> 262738 INFO  (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/, [DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/]]  heartbeating to localhost/127.0.0.1:48961) [    ] o.a.h.h.s.c.Storage Formatting ...
   [junit4]   2> 262738 INFO  (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/, [DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/]]  heartbeating to localhost/127.0.0.1:48961) [    ] o.a.h.h.s.c.Storage Formatting block pool BP-1170593033-10.41.0.5-1453036664718 directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/current/BP-1170593033-10.41.0.5-1453036664718/current
   [junit4]   2> 262743 INFO  (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/, [DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/]]  heartbeating to localhost/127.0.0.1:48961) [    ] o.a.h.h.s.c.Storage Restored 0 block files from trash.
   [junit4]   2> 262743 INFO  (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/, [DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/]]  heartbeating to localhost/127.0.0.1:48961) [    ] o.a.h.h.s.c.Storage Restored 0 block files from trash.
   [junit4]   2> 262746 INFO  (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/, [DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/]]  heartbeating to localhost/127.0.0.1:48961) [    ] o.a.h.h.s.d.DataNode Setting up storage: nsid=1247913047;bpid=BP-1170593033-10.41.0.5-1453036664718;lv=-56;nsInfo=lv=-60;cid=testClusterID;nsid=1247913047;c=0;bpid=BP-1170593033-10.41.0.5-1453036664718;dnuuid=null
   [junit4]   2> 262750 INFO  (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/, [DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/]]  heartbeating to localhost/127.0.0.1:48961) [    ] o.a.h.h.s.d.DataNode Generated and persisted new Datanode UUID c5258e0e-5828-4c50-a699-4fd4ef730d99
   [junit4]   2> 262808 INFO  (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/, [DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/]]  heartbeating to localhost/127.0.0.1:48961) [    ] o.a.h.h.s.d.f.i.FsDatasetImpl Added new volume: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/current
   [junit4]   2> 262810 INFO  (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/, [DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/]]  heartbeating to localhost/127.0.0.1:48961) [    ] o.a.h.h.s.d.f.i.FsDatasetImpl Added volume - /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/current, StorageType: DISK
   [junit4]   2> 262811 INFO  (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/, [DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/]]  heartbeating to localhost/127.0.0.1:48961) [    ] o.a.h.h.s.d.f.i.FsDatasetImpl Added new volume: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/current
   [junit4]   2> 262811 INFO  (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/, [DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/]]  heartbeating to localhost/127.0.0.1:48961) [    ] o.a.h.h.s.d.f.i.FsDatasetImpl Added volume - /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/current, StorageType: DISK
   [junit4]   2> 262882 INFO  (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/, [DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/]]  heartbeating to localhost/127.0.0.1:48961) [    ] o.a.h.h.s.d.f.i.FsDatasetImpl Registered FSDatasetState MBean
   [junit4]   2> 262889 INFO  (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/, [DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/]]  heartbeating to localhost/127.0.0.1:48961) [    ] o.a.h.h.s.d.DirectoryScanner Periodic Directory Tree Verification scan starting at 1453046008266 with interval 21600000
   [junit4]   2> 262891 INFO  (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/, [DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/]]  heartbeating to localhost/127.0.0.1:48961) [    ] o.a.h.h.s.d.f.i.FsDatasetImpl Adding block pool BP-1170593033-10.41.0.5-1453036664718
   [junit4]   2> 262893 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.m.log Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:56961
   [junit4]   2> 262897 INFO  (Thread-75) [    ] o.a.h.h.s.d.f.i.FsDatasetImpl Scanning block pool BP-1170593033-10.41.0.5-1453036664718 on volume /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/current...
   [junit4]   2> 262901 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.d.DataNode dnUserName = jenkins
   [junit4]   2> 262901 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.d.DataNode supergroup = supergroup
   [junit4]   2> 262902 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.i.CallQueueManager Using callQueue class java.util.concurrent.LinkedBlockingQueue
   [junit4]   2> 262903 INFO  (Socket Reader #1 for port 57625) [    ] o.a.h.i.Server Starting Socket Reader #1 for port 57625
   [junit4]   2> 262911 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.d.DataNode Opened IPC server at /127.0.0.1:57625
   [junit4]   2> 262913 INFO  (Thread-77) [    ] o.a.h.h.s.d.f.i.FsDatasetImpl Scanning block pool BP-1170593033-10.41.0.5-1453036664718 on volume /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/current...
   [junit4]   2> 262920 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.d.DataNode Refresh request received for nameservices: null
   [junit4]   2> 262921 INFO  (SUITE-MorphlineGoLiveMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.d.DataNode Starting BPOfferServices for nameservices: <default>
   [junit4]   2> 262925 INFO  (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data3/, [DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data4/]]  heartbeating to localhost/127.0.0.1:48961) [    ] o.a.h.h.s.d.DataNode Block pool <registering> (Datanode Uuid unassigned) service to localhost/127.0.0.1:48961 starting to offer service
   [junit4]   2> 262932 INFO  (IPC Server Responder) [    ] o.a.h.i.Server IPC Server Responder: starting
   [junit4]   2> 262933 INFO  (IPC Server listener on 57625) [    ] o.a.h.i.Server IPC Server listener on 57625: starting
   [junit4]   2> 262953 INFO  (Thread-75) [    ] o.a.h.h.s.d.f.i.FsDatasetImpl Time taken to scan block pool BP-1170593033-10.41.0.5-1453036664718 on /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/current: 50ms
   [junit4]   2> 262953 INFO  (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data3/, [DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data4/]]  heartbeating to localhost/127.0.0.1:48961) [    ] o.a.h.h.s.c.Storage DataNode version: -56 and NameNode layout version: -60
   [junit4]   2> 262953 INFO  (Thread-77) [    ] o.a.h.h.s.d.f.i.FsDatasetImpl Time taken to scan block pool BP-1170593033-10.41.0.5-1453036664718 on /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/current: 40ms
   [junit4]   2> 262955 INFO  (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/, [DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/]]  heartbeating to localhost/127.0.0.1:48961) [    ] o.a.h.h.s.d.f.i.FsDatasetImpl Total time to scan all replicas for block pool BP-1170593033-10.41.0.5-1453036664718: 64ms
   [junit4]   2> 262956 INFO  (Thread-93) [    ] o.a.h.h.s.d.f.i.FsDatasetImpl Adding replicas to map for block pool BP-1170593033-10.41.0.5-1453036664718 on volume /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/current...
   [junit4]   2> 262956 INFO  (Thread-94) [    ] o.a.h.h.s.d.f.i.FsDatasetImpl Adding replicas to map for block pool BP-1170593033-10.41.0.5-1453036664718 on volume /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/current...
   [junit4]   2> 262957 INFO  (Thread-93) [    ] o.a.h.h.s.d.f.i.FsDatasetImpl Time to add replicas to map for block pool BP-1170593033-10.41.0.5-1453036664718 on volume /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/current: 1ms
   [junit4]   2> 262957 INFO  (Thread-94) [    ] o.a.h.h.s.d.f.i.FsDatasetImpl Time to add replicas to map for block pool BP-1170593033-10.41.0.5-1453036664718 on volume /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/current: 0ms
   [junit4]   2> 262957 INFO  (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data1/, [DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_CF4E7F99D80E3DFF-001/tempDir-002/hdfs/build/dfs/data/data2/]]  heartbeating to localhost/127.0.0.1:48961) [    ] o.a.h.h.s.d.f.i.FsDatasetImpl Total time to add all replicas to map: 1ms
   [junit4]   2> 262957 INFO  (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build

[...truncated too long message...]

 o.a.h.h.s.b.DecommissionManager Monitor interrupted: java.lang.InterruptedException: sleep interrupted
   [junit4]   2> 1931825 INFO  (SUITE-MorphlineBasicMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSNamesystem Stopping services started for active state
   [junit4]   2> 1931825 INFO  (SUITE-MorphlineBasicMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.h.s.n.FSNamesystem Stopping services started for standby state
   [junit4]   2> 1931831 INFO  (SUITE-MorphlineBasicMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.m.log Stopped HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:0
   [junit4]   2> 1931932 INFO  (SUITE-MorphlineBasicMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.m.i.MetricsSystemImpl Stopping JobHistoryServer metrics system...
   [junit4]   2> 1931936 ERROR (SUITE-MorphlineBasicMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.m.l.MethodMetric Error invoking method getBlocksTotal
   [junit4]   2> java.lang.reflect.InvocationTargetException
   [junit4]   2> 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4]   2> 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
   [junit4]   2> 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]   2> 	at java.lang.reflect.Method.invoke(Method.java:606)
   [junit4]   2> 	at org.apache.hadoop.metrics2.lib.MethodMetric$2.snapshot(MethodMetric.java:111)
   [junit4]   2> 	at org.apache.hadoop.metrics2.lib.MethodMetric.snapshot(MethodMetric.java:144)
   [junit4]   2> 	at org.apache.hadoop.metrics2.lib.MetricsRegistry.snapshot(MetricsRegistry.java:387)
   [junit4]   2> 	at org.apache.hadoop.metrics2.lib.MetricsSourceBuilder$1.getMetrics(MetricsSourceBuilder.java:79)
   [junit4]   2> 	at org.apache.hadoop.metrics2.impl.MetricsSourceAdapter.getMetrics(MetricsSourceAdapter.java:195)
   [junit4]   2> 	at org.apache.hadoop.metrics2.impl.MetricsSourceAdapter.updateJmxCache(MetricsSourceAdapter.java:172)
   [junit4]   2> 	at org.apache.hadoop.metrics2.impl.MetricsSourceAdapter.getMBeanInfo(MetricsSourceAdapter.java:151)
   [junit4]   2> 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getClassName(DefaultMBeanServerInterceptor.java:1804)
   [junit4]   2> 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.safeGetClassName(DefaultMBeanServerInterceptor.java:1595)
   [junit4]   2> 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.checkMBeanPermission(DefaultMBeanServerInterceptor.java:1813)
   [junit4]   2> 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:430)
   [junit4]   2> 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:415)
   [junit4]   2> 	at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:546)
   [junit4]   2> 	at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:81)
   [junit4]   2> 	at org.apache.hadoop.metrics2.impl.MetricsSourceAdapter.stopMBeans(MetricsSourceAdapter.java:227)
   [junit4]   2> 	at org.apache.hadoop.metrics2.impl.MetricsSourceAdapter.stop(MetricsSourceAdapter.java:212)
   [junit4]   2> 	at org.apache.hadoop.metrics2.impl.MetricsSystemImpl.stopSources(MetricsSystemImpl.java:461)
   [junit4]   2> 	at org.apache.hadoop.metrics2.impl.MetricsSystemImpl.stop(MetricsSystemImpl.java:212)
   [junit4]   2> 	at org.apache.hadoop.metrics2.impl.MetricsSystemImpl.shutdown(MetricsSystemImpl.java:592)
   [junit4]   2> 	at org.apache.hadoop.metrics2.lib.DefaultMetricsSystem.shutdownInstance(DefaultMetricsSystem.java:72)
   [junit4]   2> 	at org.apache.hadoop.metrics2.lib.DefaultMetricsSystem.shutdown(DefaultMetricsSystem.java:68)
   [junit4]   2> 	at org.apache.hadoop.hdfs.server.namenode.metrics.NameNodeMetrics.shutdown(NameNodeMetrics.java:145)
   [junit4]   2> 	at org.apache.hadoop.hdfs.server.namenode.NameNode.stop(NameNode.java:822)
   [junit4]   2> 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:1720)
   [junit4]   2> 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:1699)
   [junit4]   2> 	at org.apache.solr.hadoop.MorphlineBasicMiniMRTest.teardownClass(MorphlineBasicMiniMRTest.java:195)
   [junit4]   2> 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4]   2> 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
   [junit4]   2> 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]   2> 	at java.lang.reflect.Method.invoke(Method.java:606)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:834)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
   [junit4]   2> 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> Caused by: java.lang.NullPointerException
   [junit4]   2> 	at org.apache.hadoop.hdfs.server.blockmanagement.BlocksMap.size(BlocksMap.java:198)
   [junit4]   2> 	at org.apache.hadoop.hdfs.server.blockmanagement.BlockManager.getTotalBlocks(BlockManager.java:3291)
   [junit4]   2> 	at org.apache.hadoop.hdfs.server.namenode.FSNamesystem.getBlocksTotal(FSNamesystem.java:6223)
   [junit4]   2> 	... 53 more
   [junit4]   2> 1931952 INFO  (SUITE-MorphlineBasicMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.m.i.MetricsSystemImpl JobHistoryServer metrics system stopped.
   [junit4]   2> 1931953 INFO  (SUITE-MorphlineBasicMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.h.m.i.MetricsSystemImpl JobHistoryServer metrics system shutdown complete.
   [junit4]   2> 1931954 INFO  (SUITE-MorphlineBasicMiniMRTest-seed#[CF4E7F99D80E3DFF]-worker) [    ] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/contrib/solr-map-reduce/test/J0/temp/solr.hadoop.MorphlineBasicMiniMRTest_CF4E7F99D80E3DFF-001
   [junit4]   2> NOTE: test params are: codec=CheapBastard, sim=RandomSimilarityProvider(queryNorm=true,coord=yes): {}, locale=ar_SY, timezone=America/Scoresbysund
   [junit4]   2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 1.7.0_80 (64-bit)/cpus=4,threads=5,free=148964168,total=221249536
   [junit4]   2> NOTE: All tests run in this JVM: [MorphlineBasicMiniMRTest]
   [junit4] Completed [7/7] on J0 in 1933.17s, 2 tests, 1 error <<< FAILURES!

[...truncated 13 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/build.xml:799: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/build.xml:736: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/build.xml:59: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build.xml:253: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/common-build.xml:467: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/common-build.xml:526: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/lucene/common-build.xml:1452: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/lucene/common-build.xml:1006: There were test failures: 7 suites, 35 tests, 1 suite-level error, 2 errors, 1 ignored [seed: CF4E7F99D80E3DFF]

Total time: 286 minutes 35 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
No prior successful build to compare, so performing full copy of artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any



Mime
View raw message