[JENKINS] Lucene-Solr-NightlyTests-trunk - Build # 860 - Still Failing

[Apache Jenkins Server]

Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-trunk/860/

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":35545; 

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":35545; 
        at 
__randomizedtesting.SeedInfo.seed([51858827D9E21F27:5FD73C29D8742D28]: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.$Proxy109.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:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:497)
        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.$Proxy110.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:422)
        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:644)
        at 
org.apache.solr.hadoop.MapReduceIndexerTool.run(MapReduceIndexerTool.java:607)
        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:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:497)
        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:471)
        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:511)
        at java.util.concurrent.FutureTask.run(FutureTask.java:266)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
        ... 1 more


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

Error Message:
1 thread leaked from SUITE scope at 
org.apache.solr.hadoop.MorphlineBasicMiniMRTest:     1) Thread[id=440, 
name=Node Status Updater, state=TIMED_WAITING, 
group=TGRP-MorphlineBasicMiniMRTest]         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.MorphlineBasicMiniMRTest: 
   1) Thread[id=440, name=Node Status Updater, state=TIMED_WAITING, 
group=TGRP-MorphlineBasicMiniMRTest]
        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([51858827D9E21F27]:0)


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

Error Message:
Failed on local exception: java.io.IOException: Broken pipe; Host Details : 
local host is: "lucene1-us-west/10.41.0.5"; destination host is: 
"lucene1-us-west.apache.org":40702; 

Stack Trace:
java.io.IOException: Failed on local exception: java.io.IOException: Broken 
pipe; Host Details : local host is: "lucene1-us-west/10.41.0.5"; destination 
host is: "lucene1-us-west.apache.org":40702; 
        at 
__randomizedtesting.SeedInfo.seed([51858827D9E21F27:D9D1B7FD771E72DF]: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.$Proxy111.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:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:497)
        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.$Proxy112.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:422)
        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:644)
        at 
org.apache.solr.hadoop.MapReduceIndexerTool.run(MapReduceIndexerTool.java:607)
        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:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:497)
        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:963)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:938)
        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: Broken pipe
        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:471)
        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:511)
        at java.util.concurrent.FutureTask.run(FutureTask.java:266)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
        ... 1 more




Build Log:
[...truncated 17911 lines...]
   [junit4] Suite: org.apache.solr.hadoop.MorphlineBasicMiniMRTest
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/init-core-data-001
   [junit4]   2> 0    INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
   [junit4]   2> 1161 WARN  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-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> 1260 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FSNamesystem No KeyProvider found.
   [junit4]   2> 1342 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FSNamesystem fsLock is fair:true
   [junit4]   2> 1428 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.c.C.deprecation hadoop.configured.node.mapping is deprecated. Instead, 
use net.topology.configured.node.mapping
   [junit4]   2> 1428 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.b.DatanodeManager dfs.block.invalidate.limit=1000
   [junit4]   2> 1428 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.b.DatanodeManager 
dfs.namenode.datanode.registration.ip-hostname-check=true
   [junit4]   2> 1448 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-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> 1453 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.b.BlockManager The block deletion will start around 2015 ??? 22 
09:27:56
   [junit4]   2> 1458 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.u.GSet Computing capacity for map BlocksMap
   [junit4]   2> 1458 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.u.GSet VM type       = 64-bit
   [junit4]   2> 1460 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.u.GSet 2.0% max memory 455.5 MB = 9.1 MB
   [junit4]   2> 1461 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.u.GSet capacity      = 2^20 = 1048576 entries
   [junit4]   2> 1502 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.b.BlockManager dfs.block.access.token.enable=false
   [junit4]   2> 1502 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.b.BlockManager defaultReplication         = 2
   [junit4]   2> 1502 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.b.BlockManager maxReplication             = 512
   [junit4]   2> 1503 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.b.BlockManager minReplication             = 1
   [junit4]   2> 1504 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.b.BlockManager maxReplicationStreams      = 2
   [junit4]   2> 1504 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.b.BlockManager shouldCheckForEnoughRacks  = false
   [junit4]   2> 1504 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.b.BlockManager replicationRecheckInterval = 3000
   [junit4]   2> 1505 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.b.BlockManager encryptDataTransfer        = false
   [junit4]   2> 1505 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.b.BlockManager maxNumBlocksToLog          = 1000
   [junit4]   2> 1520 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FSNamesystem fsOwner             = jenkins (auth:SIMPLE)
   [junit4]   2> 1520 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FSNamesystem supergroup          = supergroup
   [junit4]   2> 1520 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FSNamesystem isPermissionEnabled = true
   [junit4]   2> 1525 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FSNamesystem HA Enabled: false
   [junit4]   2> 1530 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FSNamesystem Append Enabled: true
   [junit4]   2> 2145 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.u.GSet Computing capacity for map INodeMap
   [junit4]   2> 2145 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.u.GSet VM type       = 64-bit
   [junit4]   2> 2146 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.u.GSet 1.0% max memory 455.5 MB = 4.6 MB
   [junit4]   2> 2146 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.u.GSet capacity      = 2^19 = 524288 entries
   [junit4]   2> 2146 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.NameNode Caching file names occuring more than 10 times
   [junit4]   2> 2161 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.u.GSet Computing capacity for map cachedBlocks
   [junit4]   2> 2161 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.u.GSet VM type       = 64-bit
   [junit4]   2> 2161 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.u.GSet 0.25% max memory 455.5 MB = 1.1 MB
   [junit4]   2> 2161 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.u.GSet capacity      = 2^17 = 131072 entries
   [junit4]   2> 2165 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FSNamesystem dfs.namenode.safemode.threshold-pct = 
0.9990000128746033
   [junit4]   2> 2165 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FSNamesystem dfs.namenode.safemode.min.datanodes = 0
   [junit4]   2> 2165 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FSNamesystem dfs.namenode.safemode.extension     = 0
   [junit4]   2> 2168 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FSNamesystem Retry cache on namenode is enabled
   [junit4]   2> 2168 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-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> 2174 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.u.GSet Computing capacity for map NameNodeRetryCache
   [junit4]   2> 2174 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.u.GSet VM type       = 64-bit
   [junit4]   2> 2174 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.u.GSet 0.029999999329447746% max memory 455.5 MB = 139.9 KB
   [junit4]   2> 2174 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.u.GSet capacity      = 2^14 = 16384 entries
   [junit4]   2> 2183 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.NNConf ACLs enabled? false
   [junit4]   2> 2183 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.NNConf XAttrs enabled? true
   [junit4]   2> 2184 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.NNConf Maximum size of an xattr: 16384
   [junit4]   2> 2297 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FSImage Allocated new BlockPoolId: 
BP-868080200-10.41.0.5-1448195277271
   [junit4]   2> 2329 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.c.Storage Storage directory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/name1
 has been successfully formatted.
   [junit4]   2> 2333 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.c.Storage Storage directory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/name2
 has been successfully formatted.
   [junit4]   2> 2625 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.NNStorageRetentionManager Going to retain 1 images with txid >= 0
   [junit4]   2> 2631 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.NameNode createNameNode []
   [junit4]   2> 2693 WARN  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.m.i.MetricsConfig Cannot locate configuration: tried 
hadoop-metrics2-namenode.properties,hadoop-metrics2.properties
   [junit4]   2> 2850 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.m.i.MetricsSystemImpl Scheduled snapshot period at 10 second(s).
   [junit4]   2> 2850 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.m.i.MetricsSystemImpl NameNode metrics system started
   [junit4]   2> 2855 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.NameNode fs.defaultFS is hdfs://127.0.0.1:0
   [junit4]   2> 2946 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.DFSUtil Starting Web-server for hdfs at: http://localhost:0
   [junit4]   2> 3128 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] o.m.log 
Logging to org.slf4j.impl.Log4jLoggerAdapter(org.mortbay.log) via 
org.mortbay.log.Slf4jLog
   [junit4]   2> 3143 WARN  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
   [junit4]   2> 3187 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.HttpServer2 Added global filter 'safety' 
(class=org.apache.hadoop.http.HttpServer2$QuotingInputFilter)
   [junit4]   2> 3191 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.HttpServer2 Added filter static_user_filter 
(class=org.apache.hadoop.http.lib.StaticUserWebFilter$StaticUserFilter) to 
context hdfs
   [junit4]   2> 3191 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.HttpServer2 Added filter static_user_filter 
(class=org.apache.hadoop.http.lib.StaticUserWebFilter$StaticUserFilter) to 
context logs
   [junit4]   2> 3191 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.HttpServer2 Added filter static_user_filter 
(class=org.apache.hadoop.http.lib.StaticUserWebFilter$StaticUserFilter) to 
context static
   [junit4]   2> 3245 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.HttpServer2 Added filter 'org.apache.hadoop.hdfs.web.AuthFilter' 
(class=org.apache.hadoop.hdfs.web.AuthFilter)
   [junit4]   2> 3247 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-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> 3285 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.HttpServer2 Jetty bound to port 54277
   [junit4]   2> 3285 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] o.m.log 
jetty-6.1.26
   [junit4]   2> 3509 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-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_54277_hdfs____.u3h03n/webapp
   [junit4]   2> 4012 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] o.m.log 
NO JSP Support for /, did not find org.apache.jasper.servlet.JspServlet
   [junit4]   2> 5077 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] o.m.log 
Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:54277
   [junit4]   2> 5088 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FSNamesystem No KeyProvider found.
   [junit4]   2> 5089 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FSNamesystem fsLock is fair:true
   [junit4]   2> 5089 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.b.DatanodeManager dfs.block.invalidate.limit=1000
   [junit4]   2> 5089 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.b.DatanodeManager 
dfs.namenode.datanode.registration.ip-hostname-check=true
   [junit4]   2> 5090 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-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> 5091 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.b.BlockManager The block deletion will start around 2015 ??? 22 
09:28:00
   [junit4]   2> 5091 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.u.GSet Computing capacity for map BlocksMap
   [junit4]   2> 5091 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.u.GSet VM type       = 64-bit
   [junit4]   2> 5091 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.u.GSet 2.0% max memory 455.5 MB = 9.1 MB
   [junit4]   2> 5091 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.u.GSet capacity      = 2^20 = 1048576 entries
   [junit4]   2> 5092 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.b.BlockManager dfs.block.access.token.enable=false
   [junit4]   2> 5092 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.b.BlockManager defaultReplication         = 2
   [junit4]   2> 5092 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.b.BlockManager maxReplication             = 512
   [junit4]   2> 5092 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.b.BlockManager minReplication             = 1
   [junit4]   2> 5092 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.b.BlockManager maxReplicationStreams      = 2
   [junit4]   2> 5092 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.b.BlockManager shouldCheckForEnoughRacks  = false
   [junit4]   2> 5092 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.b.BlockManager replicationRecheckInterval = 3000
   [junit4]   2> 5092 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.b.BlockManager encryptDataTransfer        = false
   [junit4]   2> 5093 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.b.BlockManager maxNumBlocksToLog          = 1000
   [junit4]   2> 5093 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FSNamesystem fsOwner             = jenkins (auth:SIMPLE)
   [junit4]   2> 5093 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FSNamesystem supergroup          = supergroup
   [junit4]   2> 5093 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FSNamesystem isPermissionEnabled = true
   [junit4]   2> 5093 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FSNamesystem HA Enabled: false
   [junit4]   2> 5093 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FSNamesystem Append Enabled: true
   [junit4]   2> 5094 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.u.GSet Computing capacity for map INodeMap
   [junit4]   2> 5094 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.u.GSet VM type       = 64-bit
   [junit4]   2> 5094 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.u.GSet 1.0% max memory 455.5 MB = 4.6 MB
   [junit4]   2> 5094 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.u.GSet capacity      = 2^19 = 524288 entries
   [junit4]   2> 5095 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.NameNode Caching file names occuring more than 10 times
   [junit4]   2> 5095 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.u.GSet Computing capacity for map cachedBlocks
   [junit4]   2> 5095 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.u.GSet VM type       = 64-bit
   [junit4]   2> 5095 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.u.GSet 0.25% max memory 455.5 MB = 1.1 MB
   [junit4]   2> 5095 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.u.GSet capacity      = 2^17 = 131072 entries
   [junit4]   2> 5095 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FSNamesystem dfs.namenode.safemode.threshold-pct = 
0.9990000128746033
   [junit4]   2> 5096 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FSNamesystem dfs.namenode.safemode.min.datanodes = 0
   [junit4]   2> 5096 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FSNamesystem dfs.namenode.safemode.extension     = 0
   [junit4]   2> 5096 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FSNamesystem Retry cache on namenode is enabled
   [junit4]   2> 5096 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-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> 5096 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.u.GSet Computing capacity for map NameNodeRetryCache
   [junit4]   2> 5096 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.u.GSet VM type       = 64-bit
   [junit4]   2> 5096 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.u.GSet 0.029999999329447746% max memory 455.5 MB = 139.9 KB
   [junit4]   2> 5096 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.u.GSet capacity      = 2^14 = 16384 entries
   [junit4]   2> 5099 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.NNConf ACLs enabled? false
   [junit4]   2> 5099 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.NNConf XAttrs enabled? true
   [junit4]   2> 5099 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.NNConf Maximum size of an xattr: 16384
   [junit4]   2> 5122 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.c.Storage Lock on 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/name1/in_use.lock
 acquired by nodename 13423@lucene1-us-west
   [junit4]   2> 5129 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.c.Storage Lock on 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/name2/in_use.lock
 acquired by nodename 13423@lucene1-us-west
   [junit4]   2> 5134 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FileJournalManager Recovering unfinalized segments in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/name1/current
   [junit4]   2> 5135 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FileJournalManager Recovering unfinalized segments in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/name2/current
   [junit4]   2> 5135 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FSImage No edit log streams selected.
   [junit4]   2> 5225 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FSImageFormatPBINode Loading 1 INodes.
   [junit4]   2> 5244 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FSImageFormatProtobuf Loaded FSImage in 0 seconds.
   [junit4]   2> 5245 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FSImage Loaded image for txid 0 from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/name1/current/fsimage_0000000000000000000
   [junit4]   2> 5254 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FSNamesystem Need to save fs image? false (staleImage=false, 
haEnabled=false, isRollingUpgrade=false)
   [junit4]   2> 5255 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FSEditLog Starting log segment at 1
   [junit4]   2> 5376 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.NameCache initialized with 0 entries 0 lookups
   [junit4]   2> 5376 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FSNamesystem Finished loading FSImage in 277 msecs
   [junit4]   2> 5888 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.NameNode RPC server is binding to localhost:0
   [junit4]   2> 5912 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.i.CallQueueManager Using callQueue class 
java.util.concurrent.LinkedBlockingQueue
   [junit4]   2> 5981 INFO  (Socket Reader #1 for port 59254) [    ] 
o.a.h.i.Server Starting Socket Reader #1 for port 59254
   [junit4]   2> 6069 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.NameNode Clients are to use localhost:59254 to access this 
namenode/service.
   [junit4]   2> 6072 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FSNamesystem Registered FSNamesystemState MBean
   [junit4]   2> 6109 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FSNamesystem Number of blocks under construction: 0
   [junit4]   2> 6109 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FSNamesystem Number of blocks under construction: 0
   [junit4]   2> 6109 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FSNamesystem initializing replication queues
   [junit4]   2> 6111 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.StateChange STATE* Leaving safe mode after 1 secs
   [junit4]   2> 6111 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.StateChange STATE* Network topology has 0 racks and 0 datanodes
   [junit4]   2> 6111 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.StateChange STATE* UnderReplicatedBlocks has 0 blocks
   [junit4]   2> 6116 INFO  (Replication Queue Initializer) [    ] 
o.a.h.h.s.b.BlockManager Total number of blocks            = 0
   [junit4]   2> 6119 INFO  (Replication Queue Initializer) [    ] 
o.a.h.h.s.b.BlockManager Number of invalid blocks          = 0
   [junit4]   2> 6119 INFO  (Replication Queue Initializer) [    ] 
o.a.h.h.s.b.BlockManager Number of under-replicated blocks = 0
   [junit4]   2> 6119 INFO  (Replication Queue Initializer) [    ] 
o.a.h.h.s.b.BlockManager Number of  over-replicated blocks = 0
   [junit4]   2> 6119 INFO  (Replication Queue Initializer) [    ] 
o.a.h.h.s.b.BlockManager Number of blocks being written    = 0
   [junit4]   2> 6119 INFO  (Replication Queue Initializer) [    ] 
o.a.h.h.StateChange STATE* Replication Queue initialization scan for invalid, 
over- and under-replicated blocks completed in 8 msec
   [junit4]   2> 6220 INFO  (IPC Server Responder) [    ] o.a.h.i.Server IPC 
Server Responder: starting
   [junit4]   2> 6232 INFO  (IPC Server listener on 59254) [    ] 
o.a.h.i.Server IPC Server listener on 59254: starting
   [junit4]   2> 6254 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.NameNode NameNode RPC up at: localhost/127.0.0.1:59254
   [junit4]   2> 6254 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.n.FSNamesystem Starting services required for active state
   [junit4]   2> 6282 INFO  (CacheReplicationMonitor(554539879)) [    ] 
o.a.h.h.s.b.CacheReplicationMonitor Starting CacheReplicationMonitor with 
interval 30000 milliseconds
   [junit4]   2> 6282 INFO  (CacheReplicationMonitor(554539879)) [    ] 
o.a.h.h.s.b.CacheReplicationMonitor Rescanning after 16655579352 milliseconds
   [junit4]   2> 6283 INFO  (CacheReplicationMonitor(554539879)) [    ] 
o.a.h.h.s.b.CacheReplicationMonitor Scanned 0 directive(s) and 0 block(s) in 0 
millisecond(s).
   [junit4]   2> 6285 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.MiniDFSCluster Starting DataNode 0 with dfs.datanode.data.dir: 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1,[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2
   [junit4]   2> 6389 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.m.i.MetricsSystemImpl DataNode metrics system started (again)
   [junit4]   2> 6391 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.d.DataNode Configured hostname is 127.0.0.1
   [junit4]   2> 6400 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.d.DataNode Starting DataNode with maxLockedMemory = 0
   [junit4]   2> 6409 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.d.DataNode Opened streaming server at /127.0.0.1:39918
   [junit4]   2> 6414 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.d.DataNode Balancing bandwith is 1048576 bytes/s
   [junit4]   2> 6414 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.d.DataNode Number threads for balancing is 5
   [junit4]   2> 6420 WARN  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
   [junit4]   2> 6421 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.HttpServer2 Added global filter 'safety' 
(class=org.apache.hadoop.http.HttpServer2$QuotingInputFilter)
   [junit4]   2> 6422 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.HttpServer2 Added filter static_user_filter 
(class=org.apache.hadoop.http.lib.StaticUserWebFilter$StaticUserFilter) to 
context datanode
   [junit4]   2> 6431 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.HttpServer2 Added filter static_user_filter 
(class=org.apache.hadoop.http.lib.StaticUserWebFilter$StaticUserFilter) to 
context static
   [junit4]   2> 6431 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.HttpServer2 Added filter static_user_filter 
(class=org.apache.hadoop.http.lib.StaticUserWebFilter$StaticUserFilter) to 
context logs
   [junit4]   2> 6443 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-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> 6445 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.HttpServer2 Jetty bound to port 49268
   [junit4]   2> 6445 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] o.m.log 
jetty-6.1.26
   [junit4]   2> 6472 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-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_49268_datanode____.uxtxvu/webapp
   [junit4]   2> 6613 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] o.m.log 
NO JSP Support for /, did not find org.apache.jasper.servlet.JspServlet
   [junit4]   2> 7040 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] o.m.log 
Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:49268
   [junit4]   2> 7055 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.d.DataNode dnUserName = jenkins
   [junit4]   2> 7055 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.d.DataNode supergroup = supergroup
   [junit4]   2> 7085 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.i.CallQueueManager Using callQueue class 
java.util.concurrent.LinkedBlockingQueue
   [junit4]   2> 7088 INFO  (Socket Reader #1 for port 57128) [    ] 
o.a.h.i.Server Starting Socket Reader #1 for port 57128
   [junit4]   2> 7108 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.d.DataNode Opened IPC server at /127.0.0.1:57128
   [junit4]   2> 7127 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.d.DataNode Refresh request received for nameservices: null
   [junit4]   2> 7132 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.d.DataNode Starting BPOfferServices for nameservices: <default>
   [junit4]   2> 7172 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.d.DataNode Block 
pool <registering> (Datanode Uuid unassigned) service to 
localhost/127.0.0.1:59254 starting to offer service
   [junit4]   2> 7192 INFO  (IPC Server Responder) [    ] o.a.h.i.Server IPC 
Server Responder: starting
   [junit4]   2> 7197 INFO  (IPC Server listener on 57128) [    ] 
o.a.h.i.Server IPC Server listener on 57128: starting
   [junit4]   2> 7268 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.MiniDFSCluster Starting DataNode 1 with dfs.datanode.data.dir: 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data3,[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data4
   [junit4]   2> 7371 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.m.i.MetricsSystemImpl DataNode metrics system started (again)
   [junit4]   2> 7371 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.d.DataNode Configured hostname is 127.0.0.1
   [junit4]   2> 7371 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.d.DataNode Starting DataNode with maxLockedMemory = 0
   [junit4]   2> 7372 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.d.DataNode Opened streaming server at /127.0.0.1:56831
   [junit4]   2> 7372 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.d.DataNode Balancing bandwith is 1048576 bytes/s
   [junit4]   2> 7372 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.d.DataNode Number threads for balancing is 5
   [junit4]   2> 7375 WARN  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
   [junit4]   2> 7377 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.HttpServer2 Added global filter 'safety' 
(class=org.apache.hadoop.http.HttpServer2$QuotingInputFilter)
   [junit4]   2> 7377 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.HttpServer2 Added filter static_user_filter 
(class=org.apache.hadoop.http.lib.StaticUserWebFilter$StaticUserFilter) to 
context datanode
   [junit4]   2> 7377 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.HttpServer2 Added filter static_user_filter 
(class=org.apache.hadoop.http.lib.StaticUserWebFilter$StaticUserFilter) to 
context logs
   [junit4]   2> 7377 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.HttpServer2 Added filter static_user_filter 
(class=org.apache.hadoop.http.lib.StaticUserWebFilter$StaticUserFilter) to 
context static
   [junit4]   2> 7378 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-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> 7378 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.HttpServer2 Jetty bound to port 53675
   [junit4]   2> 7379 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] o.m.log 
jetty-6.1.26
   [junit4]   2> 7417 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-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_53675_datanode____5ypijh/webapp
   [junit4]   2> 7628 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] o.m.log 
NO JSP Support for /, did not find org.apache.jasper.servlet.JspServlet
   [junit4]   2> 7948 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.c.Storage 
DataNode version: -56 and NameNode layout version: -60
   [junit4]   2> 7953 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.c.Storage Lock on 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/in_use.lock
 acquired by nodename 13423@lucene1-us-west
   [junit4]   2> 7955 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.c.Storage Storage 
directory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1
 is not formatted for BP-868080200-10.41.0.5-1448195277271
   [junit4]   2> 7955 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.c.Storage 
Formatting ...
   [junit4]   2> 7971 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.c.Storage Lock on 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/in_use.lock
 acquired by nodename 13423@lucene1-us-west
   [junit4]   2> 7972 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.c.Storage Storage 
directory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2
 is not formatted for BP-868080200-10.41.0.5-1448195277271
   [junit4]   2> 7972 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.c.Storage 
Formatting ...
   [junit4]   2> 8091 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.c.Storage 
Analyzing storage directories for bpid BP-868080200-10.41.0.5-1448195277271
   [junit4]   2> 8092 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.c.Storage Locking 
is disabled
   [junit4]   2> 8094 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.c.Storage Storage 
directory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/current/BP-868080200-10.41.0.5-1448195277271
 is not formatted.
   [junit4]   2> 8094 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.c.Storage 
Formatting ...
   [junit4]   2> 8094 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.c.Storage 
Formatting block pool BP-868080200-10.41.0.5-1448195277271 directory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/current/BP-868080200-10.41.0.5-1448195277271/current
   [junit4]   2> 8100 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.c.Storage Locking 
is disabled
   [junit4]   2> 8101 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.c.Storage Storage 
directory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/current/BP-868080200-10.41.0.5-1448195277271
 is not formatted.
   [junit4]   2> 8101 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.c.Storage 
Formatting ...
   [junit4]   2> 8101 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.c.Storage 
Formatting block pool BP-868080200-10.41.0.5-1448195277271 directory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/current/BP-868080200-10.41.0.5-1448195277271/current
   [junit4]   2> 8104 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.c.Storage 
Restored 0 block files from trash.
   [junit4]   2> 8104 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.c.Storage 
Restored 0 block files from trash.
   [junit4]   2> 8113 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.d.DataNode 
Setting up storage: 
nsid=94744280;bpid=BP-868080200-10.41.0.5-1448195277271;lv=-56;nsInfo=lv=-60;cid=testClusterID;nsid=94744280;c=0;bpid=BP-868080200-10.41.0.5-1448195277271;dnuuid=null
   [junit4]   2> 8128 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.d.DataNode 
Generated and persisted new Datanode UUID 4eac65ff-7639-4288-9ffc-da35a558ad8b
   [junit4]   2> 8231 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] 
o.a.h.h.s.d.f.i.FsDatasetImpl Added new volume: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/current
   [junit4]   2> 8238 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] 
o.a.h.h.s.d.f.i.FsDatasetImpl Added volume - 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/current,
 StorageType: DISK
   [junit4]   2> 8238 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] 
o.a.h.h.s.d.f.i.FsDatasetImpl Added new volume: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/current
   [junit4]   2> 8239 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] 
o.a.h.h.s.d.f.i.FsDatasetImpl Added volume - 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/current,
 StorageType: DISK
   [junit4]   2> 8239 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] o.m.log 
Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:53675
   [junit4]   2> 8250 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.d.DataNode dnUserName = jenkins
   [junit4]   2> 8250 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.d.DataNode supergroup = supergroup
   [junit4]   2> 8251 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.i.CallQueueManager Using callQueue class 
java.util.concurrent.LinkedBlockingQueue
   [junit4]   2> 8256 INFO  (Socket Reader #1 for port 42009) [    ] 
o.a.h.i.Server Starting Socket Reader #1 for port 42009
   [junit4]   2> 8269 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.d.DataNode Opened IPC server at /127.0.0.1:42009
   [junit4]   2> 8271 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] 
o.a.h.h.s.d.f.i.FsDatasetImpl Registered FSDatasetState MBean
   [junit4]   2> 8280 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] 
o.a.h.h.s.d.DirectoryScanner Periodic Directory Tree Verification scan starting 
at 1448212731329 with interval 21600000
   [junit4]   2> 8292 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.d.DataNode Refresh request received for nameservices: null
   [junit4]   2> 8292 INFO  
(SUITE-MorphlineBasicMiniMRTest-seed#[51858827D9E21F27]-worker) [    ] 
o.a.h.h.s.d.DataNode Starting BPOfferServices for nameservices: <default>
   [junit4]   2> 8293 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] 
o.a.h.h.s.d.f.i.FsDatasetImpl Adding block pool 
BP-868080200-10.41.0.5-1448195277271
   [junit4]   2> 8300 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data3/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data4/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.d.DataNode Block 
pool <registering> (Datanode Uuid unassigned) service to 
localhost/127.0.0.1:59254 starting to offer service
   [junit4]   2> 8308 INFO  (IPC Server Responder) [    ] o.a.h.i.Server IPC 
Server Responder: starting
   [junit4]   2> 8309 INFO  (IPC Server listener on 42009) [    ] 
o.a.h.i.Server IPC Server listener on 42009: starting
   [junit4]   2> 8362 INFO  (Thread-90) [    ] o.a.h.h.s.d.f.i.FsDatasetImpl 
Scanning block pool BP-868080200-10.41.0.5-1448195277271 on volume 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/current...
   [junit4]   2> 8345 INFO  (Thread-79) [    ] o.a.h.h.s.d.f.i.FsDatasetImpl 
Scanning block pool BP-868080200-10.41.0.5-1448195277271 on volume 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/current...
   [junit4]   2> 8566 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data3/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data4/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.c.Storage 
DataNode version: -56 and NameNode layout version: -60
   [junit4]   2> 8598 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data3/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data4/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.c.Storage Lock on 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data3/in_use.lock
 acquired by nodename 13423@lucene1-us-west
   [junit4]   2> 8599 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data3/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data4/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.c.Storage Storage 
directory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data3
 is not formatted for BP-868080200-10.41.0.5-1448195277271
   [junit4]   2> 8599 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data3/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data4/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.c.Storage 
Formatting ...
   [junit4]   2> 8611 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data3/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data4/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.c.Storage Lock on 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data4/in_use.lock
 acquired by nodename 13423@lucene1-us-west
   [junit4]   2> 8621 INFO  (Thread-79) [    ] o.a.h.h.s.d.f.i.FsDatasetImpl 
Time taken to scan block pool BP-868080200-10.41.0.5-1448195277271 on 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/current:
 256ms
   [junit4]   2> 8636 INFO  (Thread-90) [    ] o.a.h.h.s.d.f.i.FsDatasetImpl 
Time taken to scan block pool BP-868080200-10.41.0.5-1448195277271 on 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/current:
 275ms
   [junit4]   2> 8637 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] 
o.a.h.h.s.d.f.i.FsDatasetImpl Total time to scan all replicas for block pool 
BP-868080200-10.41.0.5-1448195277271: 343ms
   [junit4]   2> 8637 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data3/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data4/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.c.Storage Storage 
directory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data4
 is not formatted for BP-868080200-10.41.0.5-1448195277271
   [junit4]   2> 8638 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data3/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data4/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.c.Storage 
Formatting ...
   [junit4]   2> 8641 INFO  (Thread-93) [    ] o.a.h.h.s.d.f.i.FsDatasetImpl 
Adding replicas to map for block pool BP-868080200-10.41.0.5-1448195277271 on 
volume 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/current...
   [junit4]   2> 8641 INFO  (Thread-93) [    ] o.a.h.h.s.d.f.i.FsDatasetImpl 
Time to add replicas to map for block pool BP-868080200-10.41.0.5-1448195277271 
on volume 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/current:
 0ms
   [junit4]   2> 8673 INFO  (Thread-94) [    ] o.a.h.h.s.d.f.i.FsDatasetImpl 
Adding replicas to map for block pool BP-868080200-10.41.0.5-1448195277271 on 
volume 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/current...
   [junit4]   2> 8681 INFO  (Thread-94) [    ] o.a.h.h.s.d.f.i.FsDatasetImpl 
Time to add replicas to map for block pool BP-868080200-10.41.0.5-1448195277271 
on volume 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/current:
 0ms
   [junit4]   2> 8681 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] 
o.a.h.h.s.d.f.i.FsDatasetImpl Total time to add all replicas to map: 45ms
   [junit4]   2> 8687 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.d.DataNode Block 
pool BP-868080200-10.41.0.5-1448195277271 (Datanode Uuid null) service to 
localhost/127.0.0.1:59254 beginning handshake with NN
   [junit4]   2> 8711 INFO  (IPC Server handler 4 on 59254) [    ] 
o.a.h.h.StateChange BLOCK* registerDatanode: from 
DatanodeRegistration(127.0.0.1, 
datanodeUuid=4eac65ff-7639-4288-9ffc-da35a558ad8b, infoPort=49268, 
ipcPort=57128, storageInfo=lv=-56;cid=testClusterID;nsid=94744280;c=0) storage 
4eac65ff-7639-4288-9ffc-da35a558ad8b
   [junit4]   2> 8719 INFO  (IPC Server handler 4 on 59254) [    ] 
o.a.h.h.s.b.DatanodeDescriptor Number of failed storage changes from 0 to 0
   [junit4]   2> 8735 INFO  (IPC Server handler 4 on 59254) [    ] 
o.a.h.n.NetworkTopology Adding a new node: /default-rack/127.0.0.1:39918
   [junit4]   2> 8755 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.d.DataNode Block 
pool Block pool BP-868080200-10.41.0.5-1448195277271 (Datanode Uuid null) 
service to localhost/127.0.0.1:59254 successfully registered with NN
   [junit4]   2> 8755 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data2/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.d.DataNode For 
namenode localhost/127.0.0.1:59254 using DELETEREPORT_INTERVAL of 300000 msec  
BLOCKREPORT_INTERVAL of 21600000msec CACHEREPORT_INTERVAL of 10000msec Initial 
delay: 0msec; heartBeatInterval=3000
   [junit4]   2> 8822 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data3/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data4/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.c.Storage 
Analyzing storage directories for bpid BP-868080200-10.41.0.5-1448195277271
   [junit4]   2> 8822 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data3/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data4/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.c.Storage Locking 
is disabled
   [junit4]   2> 8823 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data3/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data4/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.c.Storage Storage 
directory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data3/current/BP-868080200-10.41.0.5-1448195277271
 is not formatted.
   [junit4]   2> 8823 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data3/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data4/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.c.Storage 
Formatting ...
   [junit4]   2> 8823 INFO  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data3/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J2/temp/solr.hadoop.MorphlineBasicMiniMRTest_51858827D9E21F27-001/tempDir-002/hdfs/build/dfs/data/data4/]]
  heartbeating to localhost/127.0.0.1:59254) [    ] o.a.h.h.s.c.Storage 
Formatting block pool BP-868080200-10.41.0.5-1448195277271 directory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-N

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

n.FSNamesystem Stopping services started for standby state
   [junit4]   2> 409492 INFO  
(SUITE-MorphlineGoLiveMiniMRTest-seed#[51858827D9E21F27]-worker) 
[n:127.0.0.1:56452_ c:collection1 s:shard1 r:core_node5 x:collection1] o.m.log 
Stopped HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:0
   [junit4]   2> 409593 INFO  
(SUITE-MorphlineGoLiveMiniMRTest-seed#[51858827D9E21F27]-worker) 
[n:127.0.0.1:56452_ c:collection1 s:shard1 r:core_node5 x:collection1] 
o.a.h.m.i.MetricsSystemImpl Stopping JobHistoryServer metrics system...
   [junit4]   2> 409596 ERROR 
(SUITE-MorphlineGoLiveMiniMRTest-seed#[51858827D9E21F27]-worker) 
[n:127.0.0.1:56452_ c:collection1 s:shard1 r:core_node5 x:collection1] 
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:62)
   [junit4]   2>        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]   2>        at java.lang.reflect.Method.invoke(Method.java:497)
   [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.MorphlineGoLiveMiniMRTest.teardownClass(MorphlineGoLiveMiniMRTest.java:236)
   [junit4]   2>        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native 
Method)
   [junit4]   2>        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]   2>        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]   2>        at java.lang.reflect.Method.invoke(Method.java:497)
   [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> 409613 INFO  
(SUITE-MorphlineGoLiveMiniMRTest-seed#[51858827D9E21F27]-worker) 
[n:127.0.0.1:56452_ c:collection1 s:shard1 r:core_node5 x:collection1] 
o.a.h.m.i.MetricsSystemImpl JobHistoryServer metrics system stopped.
   [junit4]   2> 409613 INFO  
(SUITE-MorphlineGoLiveMiniMRTest-seed#[51858827D9E21F27]-worker) 
[n:127.0.0.1:56452_ c:collection1 s:shard1 r:core_node5 x:collection1] 
o.a.h.m.i.MetricsSystemImpl JobHistoryServer metrics system shutdown complete.
   [junit4]   2> 409618 INFO  
(SUITE-MorphlineGoLiveMiniMRTest-seed#[51858827D9E21F27]-worker) 
[n:127.0.0.1:56452_ c:collection1 s:shard1 r:core_node5 x:collection1] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J0/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_51858827D9E21F27-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene60): {}, 
docValues:{}, sim=ClassicSimilarity, locale=zh_SG, timezone=America/Belize
   [junit4]   2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 
1.8.0_66 (64-bit)/cpus=4,threads=8,free=154021952,total=360185856
   [junit4]   2> NOTE: All tests run in this JVM: [MorphlineGoLiveMiniMRTest]
   [junit4] Completed [6/7] on J0 in 411.35s, 2 tests, 1 error <<< FAILURES!

[...truncated 16 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:782:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:719:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:59:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build.xml:253:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/common-build.xml:457:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/common-build.xml:516:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:1432:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:987:
 There were test failures: 7 suites, 35 tests, 1 suite-level error, 2 errors, 1 
ignored [seed: 51858827D9E21F27]

Total time: 223 minutes 58 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



---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org