Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-trunk/921/
2 tests failed. FAILED: org.apache.solr.hadoop.MorphlineBasicMiniMRTest.mrRun 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":43702; 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":43702; at __randomizedtesting.SeedInfo.seed([DCD96DE711CBF009:D28BD9E9105DC206]: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:645) at org.apache.solr.hadoop.MapReduceIndexerTool.run(MapReduceIndexerTool.java:608) at org.apache.hadoop.util.ToolRunner.run(ToolRunner.java:70) at org.apache.solr.hadoop.MorphlineBasicMiniMRTest.mrRun(MorphlineBasicMiniMRTest.java:363) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java: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: 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 FAILED: org.apache.solr.hadoop.MorphlineGoLiveMiniMRTest.test Error Message: Failed on local exception: java.io.IOException: Connection reset by peer; Host Details : local host is: "lucene1-us-west/10.41.0.5"; destination host is: "lucene1-us-west.apache.org":34914; 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":34914; at __randomizedtesting.SeedInfo.seed([DCD96DE711CBF009:548D523DBF379DF1]: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:645) at org.apache.solr.hadoop.MapReduceIndexerTool.run(MapReduceIndexerTool.java:608) at org.apache.hadoop.util.ToolRunner.run(ToolRunner.java:70) at org.apache.solr.hadoop.MorphlineGoLiveMiniMRTest.test(MorphlineGoLiveMiniMRTest.java:402) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java: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:965) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:940) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at java.lang.Thread.run(Thread.java:745) Caused by: java.io.IOException: Connection reset by peer at sun.nio.ch.FileDispatcherImpl.read0(Native Method) at sun.nio.ch.SocketDispatcher.read(SocketDispatcher.java:39) at sun.nio.ch.IOUtil.readIntoNativeBuffer(IOUtil.java:223) at sun.nio.ch.IOUtil.read(IOUtil.java:197) at sun.nio.ch.SocketChannelImpl.read(SocketChannelImpl.java:380) at org.apache.hadoop.net.SocketInputStream$Reader.performIO(SocketInputStream.java:57) at org.apache.hadoop.net.SocketIOWithTimeout.doIO(SocketIOWithTimeout.java:142) at org.apache.hadoop.net.SocketInputStream.read(SocketInputStream.java:161) at org.apache.hadoop.net.SocketInputStream.read(SocketInputStream.java:131) at java.io.FilterInputStream.read(FilterInputStream.java:133) at java.io.FilterInputStream.read(FilterInputStream.java:133) at org.apache.hadoop.ipc.Client$Connection$PingInputStream.read(Client.java:513) at java.io.BufferedInputStream.fill(BufferedInputStream.java:246) at java.io.BufferedInputStream.read(BufferedInputStream.java:265) at java.io.DataInputStream.readInt(DataInputStream.java:387) at org.apache.hadoop.ipc.Client$Connection.receiveRpcResponse(Client.java:1071) at org.apache.hadoop.ipc.Client$Connection.run(Client.java:966) Build Log: [...truncated 19552 lines...] [junit4] Suite: org.apache.solr.hadoop.MorphlineGoLiveMiniMRTest [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/init-core-data-001 [junit4] 2> 0 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /co_xlj/ [junit4] 2> 1058 WARN (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-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> 1236 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.FSNamesystem No KeyProvider found. [junit4] 2> 1280 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.FSNamesystem fsLock is fair:true [junit4] 2> 1465 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.c.C.deprecation hadoop.configured.node.mapping is deprecated. Instead, use net.topology.configured.node.mapping [junit4] 2> 1465 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.b.DatanodeManager dfs.block.invalidate.limit=1000 [junit4] 2> 1466 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.b.DatanodeManager dfs.namenode.datanode.registration.ip-hostname-check=true [junit4] 2> 1481 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-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> 1486 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.b.BlockManager The block deletion will start around 2016 Jan 27 06:46:29 [junit4] 2> 1490 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.u.GSet Computing capacity for map BlocksMap [junit4] 2> 1490 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.u.GSet VM type = 64-bit [junit4] 2> 1492 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.u.GSet 2.0% max memory 455.5 MB = 9.1 MB [junit4] 2> 1493 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.u.GSet capacity = 2^20 = 1048576 entries [junit4] 2> 1519 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.b.BlockManager dfs.block.access.token.enable=false [junit4] 2> 1519 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.b.BlockManager defaultReplication = 2 [junit4] 2> 1519 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.b.BlockManager maxReplication = 512 [junit4] 2> 1520 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.b.BlockManager minReplication = 1 [junit4] 2> 1520 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.b.BlockManager maxReplicationStreams = 2 [junit4] 2> 1520 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.b.BlockManager shouldCheckForEnoughRacks = false [junit4] 2> 1520 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.b.BlockManager replicationRecheckInterval = 3000 [junit4] 2> 1520 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.b.BlockManager encryptDataTransfer = false [junit4] 2> 1520 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.b.BlockManager maxNumBlocksToLog = 1000 [junit4] 2> 1530 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.FSNamesystem fsOwner = jenkins (auth:SIMPLE) [junit4] 2> 1530 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.FSNamesystem supergroup = supergroup [junit4] 2> 1530 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.FSNamesystem isPermissionEnabled = true [junit4] 2> 1531 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.FSNamesystem HA Enabled: false [junit4] 2> 1535 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.FSNamesystem Append Enabled: true [junit4] 2> 1933 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.u.GSet Computing capacity for map INodeMap [junit4] 2> 1933 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.u.GSet VM type = 64-bit [junit4] 2> 1933 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.u.GSet 1.0% max memory 455.5 MB = 4.6 MB [junit4] 2> 1934 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.u.GSet capacity = 2^19 = 524288 entries [junit4] 2> 1934 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.NameNode Caching file names occuring more than 10 times [junit4] 2> 1949 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.u.GSet Computing capacity for map cachedBlocks [junit4] 2> 1949 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.u.GSet VM type = 64-bit [junit4] 2> 1949 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.u.GSet 0.25% max memory 455.5 MB = 1.1 MB [junit4] 2> 1949 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.u.GSet capacity = 2^17 = 131072 entries [junit4] 2> 1951 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.FSNamesystem dfs.namenode.safemode.threshold-pct = 0.9990000128746033 [junit4] 2> 1952 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.FSNamesystem dfs.namenode.safemode.min.datanodes = 0 [junit4] 2> 1952 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.FSNamesystem dfs.namenode.safemode.extension = 0 [junit4] 2> 1954 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.FSNamesystem Retry cache on namenode is enabled [junit4] 2> 1954 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-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> 1959 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.u.GSet Computing capacity for map NameNodeRetryCache [junit4] 2> 1960 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.u.GSet VM type = 64-bit [junit4] 2> 1960 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.u.GSet 0.029999999329447746% max memory 455.5 MB = 139.9 KB [junit4] 2> 1960 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.u.GSet capacity = 2^14 = 16384 entries [junit4] 2> 1969 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.NNConf ACLs enabled? false [junit4] 2> 1969 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.NNConf XAttrs enabled? true [junit4] 2> 1969 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.NNConf Maximum size of an xattr: 16384 [junit4] 2> 2059 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.FSImage Allocated new BlockPoolId: BP-1176885193-10.41.0.5-1453895189540 [junit4] 2> 2082 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/name1 has been successfully formatted. [junit4] 2> 2090 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/name2 has been successfully formatted. [junit4] 2> 2414 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.NNStorageRetentionManager Going to retain 1 images with txid >= 0 [junit4] 2> 2420 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.NameNode createNameNode [] [junit4] 2> 2473 WARN (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.m.i.MetricsConfig Cannot locate configuration: tried hadoop-metrics2-namenode.properties,hadoop-metrics2.properties [junit4] 2> 2588 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.m.i.MetricsSystemImpl Scheduled snapshot period at 10 second(s). [junit4] 2> 2588 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.m.i.MetricsSystemImpl NameNode metrics system started [junit4] 2> 2591 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.NameNode fs.defaultFS is hdfs://127.0.0.1:0 [junit4] 2> 2659 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.DFSUtil Starting Web-server for hdfs at: http://localhost:0 [junit4] 2> 2788 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.m.log Logging to org.slf4j.impl.Log4jLoggerAdapter(org.mortbay.log) via org.mortbay.log.Slf4jLog [junit4] 2> 2801 WARN (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j [junit4] 2> 2832 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.HttpServer2 Added global filter 'safety' (class=org.apache.hadoop.http.HttpServer2$QuotingInputFilter) [junit4] 2> 2836 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.HttpServer2 Added filter static_user_filter (class=org.apache.hadoop.http.lib.StaticUserWebFilter$StaticUserFilter) to context hdfs [junit4] 2> 2836 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.HttpServer2 Added filter static_user_filter (class=org.apache.hadoop.http.lib.StaticUserWebFilter$StaticUserFilter) to context static [junit4] 2> 2836 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.HttpServer2 Added filter static_user_filter (class=org.apache.hadoop.http.lib.StaticUserWebFilter$StaticUserFilter) to context logs [junit4] 2> 2886 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.HttpServer2 Added filter 'org.apache.hadoop.hdfs.web.AuthFilter' (class=org.apache.hadoop.hdfs.web.AuthFilter) [junit4] 2> 2889 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-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> 2914 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.HttpServer2 Jetty bound to port 57253 [junit4] 2> 2914 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.m.log jetty-6.1.26 [junit4] 2> 2994 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-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_57253_hdfs____vcf194/webapp [junit4] 2> 3171 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.m.log NO JSP Support for /, did not find org.apache.jasper.servlet.JspServlet [junit4] 2> 4544 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.m.log Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:57253 [junit4] 2> 4554 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.FSNamesystem No KeyProvider found. [junit4] 2> 4562 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.FSNamesystem fsLock is fair:true [junit4] 2> 4563 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.b.DatanodeManager dfs.block.invalidate.limit=1000 [junit4] 2> 4563 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.b.DatanodeManager dfs.namenode.datanode.registration.ip-hostname-check=true [junit4] 2> 4565 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-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> 4566 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.b.BlockManager The block deletion will start around 2016 Jan 27 06:46:32 [junit4] 2> 4566 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.u.GSet Computing capacity for map BlocksMap [junit4] 2> 4567 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.u.GSet VM type = 64-bit [junit4] 2> 4567 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.u.GSet 2.0% max memory 455.5 MB = 9.1 MB [junit4] 2> 4567 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.u.GSet capacity = 2^20 = 1048576 entries [junit4] 2> 4568 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.b.BlockManager dfs.block.access.token.enable=false [junit4] 2> 4568 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.b.BlockManager defaultReplication = 2 [junit4] 2> 4568 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.b.BlockManager maxReplication = 512 [junit4] 2> 4568 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.b.BlockManager minReplication = 1 [junit4] 2> 4568 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.b.BlockManager maxReplicationStreams = 2 [junit4] 2> 4568 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.b.BlockManager shouldCheckForEnoughRacks = false [junit4] 2> 4568 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.b.BlockManager replicationRecheckInterval = 3000 [junit4] 2> 4568 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.b.BlockManager encryptDataTransfer = false [junit4] 2> 4568 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.b.BlockManager maxNumBlocksToLog = 1000 [junit4] 2> 4568 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.FSNamesystem fsOwner = jenkins (auth:SIMPLE) [junit4] 2> 4569 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.FSNamesystem supergroup = supergroup [junit4] 2> 4569 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.FSNamesystem isPermissionEnabled = true [junit4] 2> 4569 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.FSNamesystem HA Enabled: false [junit4] 2> 4569 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.FSNamesystem Append Enabled: true [junit4] 2> 4569 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.u.GSet Computing capacity for map INodeMap [junit4] 2> 4569 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.u.GSet VM type = 64-bit [junit4] 2> 4570 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.u.GSet 1.0% max memory 455.5 MB = 4.6 MB [junit4] 2> 4571 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.u.GSet capacity = 2^19 = 524288 entries [junit4] 2> 4573 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.NameNode Caching file names occuring more than 10 times [junit4] 2> 4573 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.u.GSet Computing capacity for map cachedBlocks [junit4] 2> 4573 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.u.GSet VM type = 64-bit [junit4] 2> 4573 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.u.GSet 0.25% max memory 455.5 MB = 1.1 MB [junit4] 2> 4574 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.u.GSet capacity = 2^17 = 131072 entries [junit4] 2> 4575 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.FSNamesystem dfs.namenode.safemode.threshold-pct = 0.9990000128746033 [junit4] 2> 4577 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.FSNamesystem dfs.namenode.safemode.min.datanodes = 0 [junit4] 2> 4577 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.FSNamesystem dfs.namenode.safemode.extension = 0 [junit4] 2> 4577 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.FSNamesystem Retry cache on namenode is enabled [junit4] 2> 4577 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-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> 4577 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.u.GSet Computing capacity for map NameNodeRetryCache [junit4] 2> 4578 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.u.GSet VM type = 64-bit [junit4] 2> 4578 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.u.GSet 0.029999999329447746% max memory 455.5 MB = 139.9 KB [junit4] 2> 4578 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.u.GSet capacity = 2^14 = 16384 entries [junit4] 2> 4580 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.NNConf ACLs enabled? false [junit4] 2> 4580 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.NNConf XAttrs enabled? true [junit4] 2> 4580 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.NNConf Maximum size of an xattr: 16384 [junit4] 2> 4594 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/name1/in_use.lock acquired by nodename 28346@lucene1-us-west [junit4] 2> 4605 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/name2/in_use.lock acquired by nodename 28346@lucene1-us-west [junit4] 2> 4614 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/name1/current [junit4] 2> 4615 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/name2/current [junit4] 2> 4615 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.FSImage No edit log streams selected. [junit4] 2> 4681 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.FSImageFormatPBINode Loading 1 INodes. [junit4] 2> 4697 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.FSImageFormatProtobuf Loaded FSImage in 0 seconds. [junit4] 2> 4697 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/name1/current/fsimage_0000000000000000000 [junit4] 2> 4706 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.FSNamesystem Need to save fs image? false (staleImage=false, haEnabled=false, isRollingUpgrade=false) [junit4] 2> 4707 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.FSEditLog Starting log segment at 1 [junit4] 2> 4788 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.NameCache initialized with 0 entries 0 lookups [junit4] 2> 4789 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.FSNamesystem Finished loading FSImage in 209 msecs [junit4] 2> 5474 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.NameNode RPC server is binding to localhost:0 [junit4] 2> 5493 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.i.CallQueueManager Using callQueue class java.util.concurrent.LinkedBlockingQueue [junit4] 2> 5586 INFO (Socket Reader #1 for port 33325) [ ] o.a.h.i.Server Starting Socket Reader #1 for port 33325 [junit4] 2> 5646 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.NameNode Clients are to use localhost:33325 to access this namenode/service. [junit4] 2> 5653 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.FSNamesystem Registered FSNamesystemState MBean [junit4] 2> 5697 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.FSNamesystem Number of blocks under construction: 0 [junit4] 2> 5698 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.FSNamesystem Number of blocks under construction: 0 [junit4] 2> 5698 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.FSNamesystem initializing replication queues [junit4] 2> 5704 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.StateChange STATE* Leaving safe mode after 1 secs [junit4] 2> 5704 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.StateChange STATE* Network topology has 0 racks and 0 datanodes [junit4] 2> 5704 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.StateChange STATE* UnderReplicatedBlocks has 0 blocks [junit4] 2> 5728 INFO (Replication Queue Initializer) [ ] o.a.h.h.s.b.BlockManager Total number of blocks = 0 [junit4] 2> 5735 INFO (Replication Queue Initializer) [ ] o.a.h.h.s.b.BlockManager Number of invalid blocks = 0 [junit4] 2> 5735 INFO (Replication Queue Initializer) [ ] o.a.h.h.s.b.BlockManager Number of under-replicated blocks = 0 [junit4] 2> 5735 INFO (Replication Queue Initializer) [ ] o.a.h.h.s.b.BlockManager Number of over-replicated blocks = 0 [junit4] 2> 5735 INFO (Replication Queue Initializer) [ ] o.a.h.h.s.b.BlockManager Number of blocks being written = 0 [junit4] 2> 5735 INFO (Replication Queue Initializer) [ ] o.a.h.h.StateChange STATE* Replication Queue initialization scan for invalid, over- and under-replicated blocks completed in 25 msec [junit4] 2> 5825 INFO (IPC Server Responder) [ ] o.a.h.i.Server IPC Server Responder: starting [junit4] 2> 5831 INFO (IPC Server listener on 33325) [ ] o.a.h.i.Server IPC Server listener on 33325: starting [junit4] 2> 5901 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.NameNode NameNode RPC up at: localhost/127.0.0.1:33325 [junit4] 2> 5901 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.FSNamesystem Starting services required for active state [junit4] 2> 5945 INFO (CacheReplicationMonitor(500612937)) [ ] o.a.h.h.s.b.CacheReplicationMonitor Starting CacheReplicationMonitor with interval 30000 milliseconds [junit4] 2> 5946 INFO (CacheReplicationMonitor(500612937)) [ ] o.a.h.h.s.b.CacheReplicationMonitor Rescanning after 22355484769 milliseconds [junit4] 2> 5955 INFO (CacheReplicationMonitor(500612937)) [ ] o.a.h.h.s.b.CacheReplicationMonitor Scanned 0 directive(s) and 0 block(s) in 10 millisecond(s). [junit4] 2> 5962 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data2 [junit4] 2> 6213 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.m.i.MetricsSystemImpl DataNode metrics system started (again) [junit4] 2> 6214 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.d.DataNode Configured hostname is 127.0.0.1 [junit4] 2> 6223 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.d.DataNode Starting DataNode with maxLockedMemory = 0 [junit4] 2> 6244 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.d.DataNode Opened streaming server at /127.0.0.1:45885 [junit4] 2> 6250 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.d.DataNode Balancing bandwith is 1048576 bytes/s [junit4] 2> 6250 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.d.DataNode Number threads for balancing is 5 [junit4] 2> 6265 WARN (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j [junit4] 2> 6269 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.HttpServer2 Added global filter 'safety' (class=org.apache.hadoop.http.HttpServer2$QuotingInputFilter) [junit4] 2> 6273 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.HttpServer2 Added filter static_user_filter (class=org.apache.hadoop.http.lib.StaticUserWebFilter$StaticUserFilter) to context datanode [junit4] 2> 6279 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.HttpServer2 Added filter static_user_filter (class=org.apache.hadoop.http.lib.StaticUserWebFilter$StaticUserFilter) to context logs [junit4] 2> 6279 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.HttpServer2 Added filter static_user_filter (class=org.apache.hadoop.http.lib.StaticUserWebFilter$StaticUserFilter) to context static [junit4] 2> 6289 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-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> 6303 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.HttpServer2 Jetty bound to port 43368 [junit4] 2> 6303 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.m.log jetty-6.1.26 [junit4] 2> 6324 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-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_43368_datanode____.qdmtab/webapp [junit4] 2> 6486 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.m.log NO JSP Support for /, did not find org.apache.jasper.servlet.JspServlet [junit4] 2> 7453 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.m.log Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:43368 [junit4] 2> 7470 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.d.DataNode dnUserName = jenkins [junit4] 2> 7470 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.d.DataNode supergroup = supergroup [junit4] 2> 7547 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.i.CallQueueManager Using callQueue class java.util.concurrent.LinkedBlockingQueue [junit4] 2> 7564 INFO (Socket Reader #1 for port 39672) [ ] o.a.h.i.Server Starting Socket Reader #1 for port 39672 [junit4] 2> 7575 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.d.DataNode Opened IPC server at /127.0.0.1:39672 [junit4] 2> 7631 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.d.DataNode Refresh request received for nameservices: null [junit4] 2> 7638 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.d.DataNode Starting BPOfferServices for nameservices: <default> [junit4] 2> 7666 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data2/]] heartbeating to localhost/127.0.0.1:33325) [ ] o.a.h.h.s.d.DataNode Block pool <registering> (Datanode Uuid unassigned) service to localhost/127.0.0.1:33325 starting to offer service [junit4] 2> 7689 INFO (IPC Server Responder) [ ] o.a.h.i.Server IPC Server Responder: starting [junit4] 2> 7689 INFO (IPC Server listener on 39672) [ ] o.a.h.i.Server IPC Server listener on 39672: starting [junit4] 2> 7694 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data4 [junit4] 2> 7857 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.m.i.MetricsSystemImpl DataNode metrics system started (again) [junit4] 2> 7857 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.d.DataNode Configured hostname is 127.0.0.1 [junit4] 2> 7857 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.d.DataNode Starting DataNode with maxLockedMemory = 0 [junit4] 2> 7858 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.d.DataNode Opened streaming server at /127.0.0.1:51268 [junit4] 2> 7858 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.d.DataNode Balancing bandwith is 1048576 bytes/s [junit4] 2> 7858 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.d.DataNode Number threads for balancing is 5 [junit4] 2> 7860 WARN (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j [junit4] 2> 7861 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.HttpServer2 Added global filter 'safety' (class=org.apache.hadoop.http.HttpServer2$QuotingInputFilter) [junit4] 2> 7861 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.HttpServer2 Added filter static_user_filter (class=org.apache.hadoop.http.lib.StaticUserWebFilter$StaticUserFilter) to context datanode [junit4] 2> 7861 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.HttpServer2 Added filter static_user_filter (class=org.apache.hadoop.http.lib.StaticUserWebFilter$StaticUserFilter) to context static [junit4] 2> 7861 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.HttpServer2 Added filter static_user_filter (class=org.apache.hadoop.http.lib.StaticUserWebFilter$StaticUserFilter) to context logs [junit4] 2> 7862 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-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> 7862 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.HttpServer2 Jetty bound to port 47099 [junit4] 2> 7863 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.m.log jetty-6.1.26 [junit4] 2> 7924 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-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_47099_datanode____.mtl964/webapp [junit4] 2> 8145 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.m.log NO JSP Support for /, did not find org.apache.jasper.servlet.JspServlet [junit4] 2> 8707 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data2/]] heartbeating to localhost/127.0.0.1:33325) [ ] o.a.h.h.s.c.Storage DataNode version: -56 and NameNode layout version: -60 [junit4] 2> 8714 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data2/]] heartbeating to localhost/127.0.0.1:33325) [ ] 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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data1/in_use.lock acquired by nodename 28346@lucene1-us-west [junit4] 2> 8716 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data2/]] heartbeating to localhost/127.0.0.1:33325) [ ] 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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data1 is not formatted for BP-1176885193-10.41.0.5-1453895189540 [junit4] 2> 8716 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data2/]] heartbeating to localhost/127.0.0.1:33325) [ ] o.a.h.h.s.c.Storage Formatting ... [junit4] 2> 8737 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data2/]] heartbeating to localhost/127.0.0.1:33325) [ ] 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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data2/in_use.lock acquired by nodename 28346@lucene1-us-west [junit4] 2> 8738 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data2/]] heartbeating to localhost/127.0.0.1:33325) [ ] 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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data2 is not formatted for BP-1176885193-10.41.0.5-1453895189540 [junit4] 2> 8738 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data2/]] heartbeating to localhost/127.0.0.1:33325) [ ] o.a.h.h.s.c.Storage Formatting ... [junit4] 2> 8914 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.m.log Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:47099 [junit4] 2> 8929 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.d.DataNode dnUserName = jenkins [junit4] 2> 8935 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.d.DataNode supergroup = supergroup [junit4] 2> 8936 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.i.CallQueueManager Using callQueue class java.util.concurrent.LinkedBlockingQueue [junit4] 2> 8952 INFO (Socket Reader #1 for port 37085) [ ] o.a.h.i.Server Starting Socket Reader #1 for port 37085 [junit4] 2> 8955 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.d.DataNode Opened IPC server at /127.0.0.1:37085 [junit4] 2> 8964 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.d.DataNode Refresh request received for nameservices: null [junit4] 2> 8965 INFO (SUITE-MorphlineGoLiveMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.d.DataNode Starting BPOfferServices for nameservices: <default> [junit4] 2> 8994 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data4/]] heartbeating to localhost/127.0.0.1:33325) [ ] o.a.h.h.s.d.DataNode Block pool <registering> (Datanode Uuid unassigned) service to localhost/127.0.0.1:33325 starting to offer service [junit4] 2> 9028 INFO (IPC Server Responder) [ ] o.a.h.i.Server IPC Server Responder: starting [junit4] 2> 9035 INFO (IPC Server listener on 37085) [ ] o.a.h.i.Server IPC Server listener on 37085: starting [junit4] 2> 9133 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data4/]] heartbeating to localhost/127.0.0.1:33325) [ ] o.a.h.h.s.c.Storage DataNode version: -56 and NameNode layout version: -60 [junit4] 2> 9137 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data4/]] heartbeating to localhost/127.0.0.1:33325) [ ] 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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data3/in_use.lock acquired by nodename 28346@lucene1-us-west [junit4] 2> 9138 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data4/]] heartbeating to localhost/127.0.0.1:33325) [ ] 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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data3 is not formatted for BP-1176885193-10.41.0.5-1453895189540 [junit4] 2> 9138 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data4/]] heartbeating to localhost/127.0.0.1:33325) [ ] o.a.h.h.s.c.Storage Formatting ... [junit4] 2> 9154 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data4/]] heartbeating to localhost/127.0.0.1:33325) [ ] 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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data4/in_use.lock acquired by nodename 28346@lucene1-us-west [junit4] 2> 9155 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data4/]] heartbeating to localhost/127.0.0.1:33325) [ ] 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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data4 is not formatted for BP-1176885193-10.41.0.5-1453895189540 [junit4] 2> 9155 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data4/]] heartbeating to localhost/127.0.0.1:33325) [ ] o.a.h.h.s.c.Storage Formatting ... [junit4] 2> 9159 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data2/]] heartbeating to localhost/127.0.0.1:33325) [ ] o.a.h.h.s.c.Storage Analyzing storage directories for bpid BP-1176885193-10.41.0.5-1453895189540 [junit4] 2> 9160 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data2/]] heartbeating to localhost/127.0.0.1:33325) [ ] o.a.h.h.s.c.Storage Locking is disabled [junit4] 2> 9162 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data2/]] heartbeating to localhost/127.0.0.1:33325) [ ] 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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data1/current/BP-1176885193-10.41.0.5-1453895189540 is not formatted. [junit4] 2> 9162 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data2/]] heartbeating to localhost/127.0.0.1:33325) [ ] o.a.h.h.s.c.Storage Formatting ... [junit4] 2> 9162 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data2/]] heartbeating to localhost/127.0.0.1:33325) [ ] o.a.h.h.s.c.Storage Formatting block pool BP-1176885193-10.41.0.5-1453895189540 directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data1/current/BP-1176885193-10.41.0.5-1453895189540/current [junit4] 2> 9166 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data2/]] heartbeating to localhost/127.0.0.1:33325) [ ] o.a.h.h.s.c.Storage Locking is disabled [junit4] 2> 9167 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data2/]] heartbeating to localhost/127.0.0.1:33325) [ ] 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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data2/current/BP-1176885193-10.41.0.5-1453895189540 is not formatted. [junit4] 2> 9167 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data2/]] heartbeating to localhost/127.0.0.1:33325) [ ] o.a.h.h.s.c.Storage Formatting ... [junit4] 2> 9167 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data2/]] heartbeating to localhost/127.0.0.1:33325) [ ] o.a.h.h.s.c.Storage Formatting block pool BP-1176885193-10.41.0.5-1453895189540 directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data2/current/BP-1176885193-10.41.0.5-1453895189540/current [junit4] 2> 9172 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data2/]] heartbeating to localhost/127.0.0.1:33325) [ ] o.a.h.h.s.c.Storage Restored 0 block files from trash. [junit4] 2> 9176 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data2/]] heartbeating to localhost/127.0.0.1:33325) [ ] o.a.h.h.s.c.Storage Restored 0 block files from trash. [junit4] 2> 9184 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data2/]] heartbeating to localhost/127.0.0.1:33325) [ ] o.a.h.h.s.d.DataNode Setting up storage: nsid=1522891308;bpid=BP-1176885193-10.41.0.5-1453895189540;lv=-56;nsInfo=lv=-60;cid=testClusterID;nsid=1522891308;c=0;bpid=BP-1176885193-10.41.0.5-1453895189540;dnuuid=null [junit4] 2> 9194 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data2/]] heartbeating to localhost/127.0.0.1:33325) [ ] o.a.h.h.s.d.DataNode Generated and persisted new Datanode UUID 5af13061-7600-4cc7-ad6a-111a3334ebbf [junit4] 2> 9419 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data2/]] heartbeating to localhost/127.0.0.1:33325) [ ] 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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data1/current [junit4] 2> 9431 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data2/]] heartbeating to localhost/127.0.0.1:33325) [ ] 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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data1/current, StorageType: DISK [junit4] 2> 9432 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data2/]] heartbeating to localhost/127.0.0.1:33325) [ ] 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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data2/current [junit4] 2> 9433 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data2/]] heartbeating to localhost/127.0.0.1:33325) [ ] 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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data2/current, StorageType: DISK [junit4] 2> 9497 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data4/]] heartbeating to localhost/127.0.0.1:33325) [ ] o.a.h.h.s.c.Storage Analyzing storage directories for bpid BP-1176885193-10.41.0.5-1453895189540 [junit4] 2> 9497 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data4/]] heartbeating to localhost/127.0.0.1:33325) [ ] o.a.h.h.s.c.Storage Locking is disabled [junit4] 2> 9498 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data4/]] heartbeating to localhost/127.0.0.1:33325) [ ] 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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data3/current/BP-1176885193-10.41.0.5-1453895189540 is not formatted. [junit4] 2> 9498 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data4/]] heartbeating to localhost/127.0.0.1:33325) [ ] o.a.h.h.s.c.Storage Formatting ... [junit4] 2> 9498 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data4/]] heartbeating to localhost/127.0.0.1:33325) [ ] o.a.h.h.s.c.Storage Formatting block pool BP-1176885193-10.41.0.5-1453895189540 directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data3/current/BP-1176885193-10.41.0.5-1453895189540/current [junit4] 2> 9508 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data4/]] heartbeating to localhost/127.0.0.1:33325) [ ] o.a.h.h.s.c.Storage Locking is disabled [junit4] 2> 9509 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data4/]] heartbeating to localhost/127.0.0.1:33325) [ ] 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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data4/current/BP-1176885193-10.41.0.5-1453895189540 is not formatted. [junit4] 2> 9509 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data4/]] heartbeating to localhost/127.0.0.1:33325) [ ] o.a.h.h.s.c.Storage Formatting ... [junit4] 2> 9510 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data4/]] heartbeating to localhost/127.0.0.1:33325) [ ] o.a.h.h.s.c.Storage Formatting block pool BP-1176885193-10.41.0.5-1453895189540 directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data4/current/BP-1176885193-10.41.0.5-1453895189540/current [junit4] 2> 9515 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data2/]] heartbeating to localhost/127.0.0.1:33325) [ ] o.a.h.h.s.d.f.i.FsDatasetImpl Registered FSDatasetState MBean [junit4] 2> 9517 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data4/]] heartbeating to localhost/127.0.0.1:33325) [ ] o.a.h.h.s.c.Storage Restored 0 block files from trash. [junit4] 2> 9517 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data4/]] heartbeating to localhost/127.0.0.1:33325) [ ] o.a.h.h.s.c.Storage Restored 0 block files from trash. [junit4] 2> 9527 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data2/]] heartbeating to localhost/127.0.0.1:33325) [ ] o.a.h.h.s.d.DirectoryScanner Periodic Directory Tree Verification scan starting at 1453916084069 with interval 21600000 [junit4] 2> 9537 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data4/]] heartbeating to localhost/127.0.0.1:33325) [ ] o.a.h.h.s.d.DataNode Setting up storage: nsid=1522891308;bpid=BP-1176885193-10.41.0.5-1453895189540;lv=-56;nsInfo=lv=-60;cid=testClusterID;nsid=1522891308;c=0;bpid=BP-1176885193-10.41.0.5-1453895189540;dnuuid=null [junit4] 2> 9541 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data4/]] heartbeating to localhost/127.0.0.1:33325) [ ] o.a.h.h.s.d.DataNode Generated and persisted new Datanode UUID 3d4c39cf-431c-434e-b98f-d618d7d28ab8 [junit4] 2> 9546 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data2/]] heartbeating to localhost/127.0.0.1:33325) [ ] o.a.h.h.s.d.f.i.FsDatasetImpl Adding block pool BP-1176885193-10.41.0.5-1453895189540 [junit4] 2> 9542 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data4/]] heartbeating to localhost/127.0.0.1:33325) [ ] 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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data3/current [junit4] 2> 9556 INFO (Thread-91) [ ] o.a.h.h.s.d.f.i.FsDatasetImpl Scanning block pool BP-1176885193-10.41.0.5-1453895189540 on volume /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data1/current... [junit4] 2> 9571 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-map-reduce/test/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data4/]] heartbeating to localhost/127.0.0.1:33325) [ ] 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/J1/temp/solr.hadoop.MorphlineGoLiveMiniMRTest_DCD96DE711CBF009-001/tempDir-002/hdfs/build/dfs/data/data3/current, StorageType: DISK [junit4] 2> 9571 INFO (DataNode: [[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene- [...truncated too long message...] $Monitor@3269cf74) [ ] o.a.h.h.s.b.DecommissionManager Monitor interrupted: java.lang.InterruptedException: sleep interrupted [junit4] 2> 93647 INFO (SUITE-MorphlineBasicMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.FSNamesystem Stopping services started for active state [junit4] 2> 93647 INFO (SUITE-MorphlineBasicMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.h.s.n.FSNamesystem Stopping services started for standby state [junit4] 2> 93662 INFO (SUITE-MorphlineBasicMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.m.log Stopped HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:0 [junit4] 2> 93764 INFO (SUITE-MorphlineBasicMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.m.i.MetricsSystemImpl Stopping JobHistoryServer metrics system... [junit4] 2> 93770 ERROR (SUITE-MorphlineBasicMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.m.l.MethodMetric Error invoking method getBlocksTotal [junit4] 2> java.lang.reflect.InvocationTargetException [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java: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.MorphlineBasicMiniMRTest.teardownClass(MorphlineBasicMiniMRTest.java:195) [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> 93795 INFO (SUITE-MorphlineBasicMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.m.i.MetricsSystemImpl JobHistoryServer metrics system stopped. [junit4] 2> 93796 INFO (SUITE-MorphlineBasicMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] o.a.h.m.i.MetricsSystemImpl JobHistoryServer metrics system shutdown complete. [junit4] 2> 93801 INFO (SUITE-MorphlineBasicMiniMRTest-seed#[DCD96DE711CBF009]-worker) [ ] 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.MorphlineBasicMiniMRTest_DCD96DE711CBF009-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene60), sim=RandomSimilarity(queryNorm=false,coord=yes): {}, locale=es-EC, timezone=SystemV/MST7 [junit4] 2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 1.8.0_66 (64-bit)/cpus=4,threads=6,free=169461176,total=300417024 [junit4] 2> NOTE: All tests run in this JVM: [MorphlineBasicMiniMRTest] [junit4] Completed [7/7 (2!)] on J0 in 95.98s, 2 tests, 1 error <<< FAILURES! [...truncated 12 lines...] BUILD FAILED /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:747: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:684: 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:459: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/common-build.xml:524: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:1457: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:1014: There were test failures: 7 suites, 35 tests, 2 errors, 1 ignored [seed: DCD96DE711CBF009] Total time: 243 minutes 4 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