See <https://builds.apache.org/job/Pig-trunk-commit/864/changes>
Changes: [daijy] PIG-2027: NPE if Pig don't have permission for log file ------------------------------------------ [...truncated 39819 lines...] [junit] at org.apache.hadoop.ipc.Server$Handler$1.run(Server.java:955) [junit] at java.security.AccessController.doPrivileged(Native Method) [junit] at javax.security.auth.Subject.doAs(Subject.java:396) [junit] at org.apache.hadoop.ipc.Server$Handler.run(Server.java:953) [junit] [junit] org.apache.hadoop.ipc.RemoteException: java.io.IOException: Could not complete write to file /tmp/TestStore-output--4558572667977626699.txt_cleanupOnFailure_succeeded1 by DFSClient_-912609163 [junit] at org.apache.hadoop.hdfs.server.namenode.NameNode.complete(NameNode.java:449) [junit] at sun.reflect.GeneratedMethodAccessor18.invoke(Unknown Source) [junit] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) [junit] at java.lang.reflect.Method.invoke(Method.java:597) [junit] at org.apache.hadoop.ipc.RPC$Server.call(RPC.java:508) [junit] at org.apache.hadoop.ipc.Server$Handler$1.run(Server.java:959) [junit] at org.apache.hadoop.ipc.Server$Handler$1.run(Server.java:955) [junit] at java.security.AccessController.doPrivileged(Native Method) [junit] at javax.security.auth.Subject.doAs(Subject.java:396) [junit] at org.apache.hadoop.ipc.Server$Handler.run(Server.java:953) [junit] [junit] at org.apache.hadoop.ipc.Client.call(Client.java:740) [junit] at org.apache.hadoop.ipc.RPC$Invoker.invoke(RPC.java:220) [junit] at $Proxy0.complete(Unknown Source) [junit] at sun.reflect.GeneratedMethodAccessor18.invoke(Unknown Source) [junit] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) [junit] at java.lang.reflect.Method.invoke(Method.java:597) [junit] at org.apache.hadoop.io.retry.RetryInvocationHandler.invokeMethod(RetryInvocationHandler.java:82) [junit] at org.apache.hadoop.io.retry.RetryInvocationHandler.invoke(RetryInvocationHandler.java:59) [junit] at $Proxy0.complete(Unknown Source) [junit] at org.apache.hadoop.hdfs.DFSClient$DFSOutputStream.closeInternal(DFSClient.java:3264) [junit] at org.apache.hadoop.hdfs.DFSClient$DFSOutputStream.close(DFSClient.java:3188) [junit] at org.apache.hadoop.hdfs.DFSClient$LeaseChecker.close(DFSClient.java:1043) [junit] at org.apache.hadoop.hdfs.DFSClient.close(DFSClient.java:237) [junit] at org.apache.hadoop.hdfs.DistributedFileSystem.close(DistributedFileSystem.java:269) [junit] at org.apache.pig.test.MiniGenericCluster.shutdownMiniDfsClusters(MiniGenericCluster.java:83) [junit] at org.apache.pig.test.MiniGenericCluster.shutdownMiniDfsAndMrClusters(MiniGenericCluster.java:77) [junit] at org.apache.pig.test.MiniGenericCluster.shutDown(MiniGenericCluster.java:68) [junit] at org.apache.pig.test.TestStore.oneTimeTearDown(TestStore.java:127) [junit] at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit] at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) [junit] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) [junit] at java.lang.reflect.Method.invoke(Method.java:597) [junit] at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44) [junit] at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15) [junit] at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41) [junit] at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:37) [junit] at org.junit.runners.ParentRunner.run(ParentRunner.java:220) [junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39) [junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:420) [junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:911) [junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:768) [junit] 11/07/20 18:30:09 WARN hdfs.StateChange: DIR* NameSystem.completeFile: failed to complete /tmp/TestStore-output-2315760537085322334.txt_cleanupOnFailure_succeeded2 because dir.getFileBlocks() is null and pendingFile is null [junit] 11/07/20 18:30:09 INFO ipc.Server: IPC Server handler 0 on 59045, call complete(/tmp/TestStore-output-2315760537085322334.txt_cleanupOnFailure_succeeded2, DFSClient_-912609163) from 127.0.0.1:52994: error: java.io.IOException: Could not complete write to file /tmp/TestStore-output-2315760537085322334.txt_cleanupOnFailure_succeeded2 by DFSClient_-912609163 [junit] java.io.IOException: Could not complete write to file /tmp/TestStore-output-2315760537085322334.txt_cleanupOnFailure_succeeded2 by DFSClient_-912609163 [junit] at org.apache.hadoop.hdfs.server.namenode.NameNode.complete(NameNode.java:449) [junit] at sun.reflect.GeneratedMethodAccessor18.invoke(Unknown Source) [junit] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) [junit] at java.lang.reflect.Method.invoke(Method.java:597) [junit] at org.apache.hadoop.ipc.RPC$Server.call(RPC.java:508) [junit] at org.apache.hadoop.ipc.Server$Handler$1.run(Server.java:959) [junit] at org.apache.hadoop.ipc.Server$Handler$1.run(Server.java:955) [junit] at java.security.AccessController.doPrivileged(Native Method) [junit] at javax.security.auth.Subject.doAs(Subject.java:396) [junit] at org.apache.hadoop.ipc.Server$Handler.run(Server.java:953) [junit] 11/07/20 18:30:09 ERROR hdfs.DFSClient: Exception closing file /tmp/TestStore-output-2315760537085322334.txt_cleanupOnFailure_succeeded2 : org.apache.hadoop.ipc.RemoteException: java.io.IOException: Could not complete write to file /tmp/TestStore-output-2315760537085322334.txt_cleanupOnFailure_succeeded2 by DFSClient_-912609163 [junit] at org.apache.hadoop.hdfs.server.namenode.NameNode.complete(NameNode.java:449) [junit] at sun.reflect.GeneratedMethodAccessor18.invoke(Unknown Source) [junit] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) [junit] at java.lang.reflect.Method.invoke(Method.java:597) [junit] at org.apache.hadoop.ipc.RPC$Server.call(RPC.java:508) [junit] at org.apache.hadoop.ipc.Server$Handler$1.run(Server.java:959) [junit] at org.apache.hadoop.ipc.Server$Handler$1.run(Server.java:955) [junit] at java.security.AccessController.doPrivileged(Native Method) [junit] at javax.security.auth.Subject.doAs(Subject.java:396) [junit] at org.apache.hadoop.ipc.Server$Handler.run(Server.java:953) [junit] [junit] org.apache.hadoop.ipc.RemoteException: java.io.IOException: Could not complete write to file /tmp/TestStore-output-2315760537085322334.txt_cleanupOnFailure_succeeded2 by DFSClient_-912609163 [junit] at org.apache.hadoop.hdfs.server.namenode.NameNode.complete(NameNode.java:449) [junit] at sun.reflect.GeneratedMethodAccessor18.invoke(Unknown Source) [junit] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) [junit] at java.lang.reflect.Method.invoke(Method.java:597) [junit] at org.apache.hadoop.ipc.RPC$Server.call(RPC.java:508) [junit] at org.apache.hadoop.ipc.Server$Handler$1.run(Server.java:959) [junit] at org.apache.hadoop.ipc.Server$Handler$1.run(Server.java:955) [junit] at java.security.AccessController.doPrivileged(Native Method) [junit] at javax.security.auth.Subject.doAs(Subject.java:396) [junit] at org.apache.hadoop.ipc.Server$Handler.run(Server.java:953) [junit] [junit] at org.apache.hadoop.ipc.Client.call(Client.java:740) [junit] at org.apache.hadoop.ipc.RPC$Invoker.invoke(RPC.java:220) [junit] at $Proxy0.complete(Unknown Source) [junit] at sun.reflect.GeneratedMethodAccessor18.invoke(Unknown Source) [junit] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) [junit] at java.lang.reflect.Method.invoke(Method.java:597) [junit] at org.apache.hadoop.io.retry.RetryInvocationHandler.invokeMethod(RetryInvocationHandler.java:82) [junit] at org.apache.hadoop.io.retry.RetryInvocationHandler.invoke(RetryInvocationHandler.java:59) [junit] at $Proxy0.complete(Unknown Source) [junit] at org.apache.hadoop.hdfs.DFSClient$DFSOutputStream.closeInternal(DFSClient.java:3264) [junit] at org.apache.hadoop.hdfs.DFSClient$DFSOutputStream.close(DFSClient.java:3188) [junit] at org.apache.hadoop.hdfs.DFSClient$LeaseChecker.close(DFSClient.java:1043) [junit] at org.apache.hadoop.hdfs.DFSClient.close(DFSClient.java:237) [junit] at org.apache.hadoop.hdfs.DistributedFileSystem.close(DistributedFileSystem.java:269) [junit] at org.apache.pig.test.MiniGenericCluster.shutdownMiniDfsClusters(MiniGenericCluster.java:83) [junit] at org.apache.pig.test.MiniGenericCluster.shutdownMiniDfsAndMrClusters(MiniGenericCluster.java:77) [junit] at org.apache.pig.test.MiniGenericCluster.shutDown(MiniGenericCluster.java:68) [junit] at org.apache.pig.test.TestStore.oneTimeTearDown(TestStore.java:127) [junit] at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit] at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) [junit] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) [junit] at java.lang.reflect.Method.invoke(Method.java:597) [junit] at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44) [junit] at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15) [junit] at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41) [junit] at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:37) [junit] at org.junit.runners.ParentRunner.run(ParentRunner.java:220) [junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39) [junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:420) [junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:911) [junit] at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:768) [junit] Shutting down the Mini HDFS Cluster [junit] Shutting down DataNode 3 [junit] 11/07/20 18:30:09 INFO ipc.Server: Stopping server on 57781 [junit] 11/07/20 18:30:09 INFO ipc.Server: Stopping IPC Server listener on 57781 [junit] 11/07/20 18:30:09 INFO ipc.Server: IPC Server handler 0 on 57781: exiting [junit] 11/07/20 18:30:09 INFO ipc.Server: Stopping IPC Server Responder [junit] 11/07/20 18:30:09 INFO ipc.Server: IPC Server handler 2 on 57781: exiting [junit] 11/07/20 18:30:09 INFO ipc.Server: IPC Server handler 1 on 57781: exiting [junit] 11/07/20 18:30:09 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1 [junit] 11/07/20 18:30:09 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:35781, storageID=DS-1404909414-127.0.1.1-35781-1311186237224, infoPort=59762, ipcPort=57781):DataXceiveServer: java.nio.channels.AsynchronousCloseException [junit] at java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:185) [junit] at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:159) [junit] at sun.nio.ch.ServerSocketAdaptor.accept(ServerSocketAdaptor.java:84) [junit] at org.apache.hadoop.hdfs.server.datanode.DataXceiverServer.run(DataXceiverServer.java:130) [junit] at java.lang.Thread.run(Thread.java:662) [junit] [junit] 11/07/20 18:30:09 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:60671 to delete blk_6129303074643234637_1124 blk_-3943494823013187226_1122 blk_768233242821262845_1121 blk_-1986181213677077307_1126 [junit] 11/07/20 18:30:09 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:37043 to delete blk_6129303074643234637_1124 blk_-5539916122989107898_1127 blk_-1986181213677077307_1126 blk_-4818205592067356364_1123 [junit] 11/07/20 18:30:10 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread. [junit] 11/07/20 18:30:10 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0 [junit] 11/07/20 18:30:10 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:35781, storageID=DS-1404909414-127.0.1.1-35781-1311186237224, infoPort=59762, ipcPort=57781):Finishing DataNode in: FSDataset{dirpath='<https://builds.apache.org/job/Pig-trunk-commit/ws/trunk/build/test/data/dfs/data/data7/current,/grid/0/hudson/hudson-slave/workspace/Pig-trunk-commit/trunk/build/test/data/dfs/data/data8/current'}> [junit] 11/07/20 18:30:10 INFO ipc.Server: Stopping server on 57781 [junit] 11/07/20 18:30:10 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0 [junit] Shutting down DataNode 2 [junit] 11/07/20 18:30:10 INFO ipc.Server: Stopping server on 57598 [junit] 11/07/20 18:30:10 INFO ipc.Server: IPC Server handler 0 on 57598: exiting [junit] 11/07/20 18:30:10 INFO ipc.Server: IPC Server handler 2 on 57598: exiting [junit] 11/07/20 18:30:10 INFO ipc.Server: IPC Server handler 1 on 57598: exiting [junit] 11/07/20 18:30:10 INFO ipc.Server: Stopping IPC Server listener on 57598 [junit] 11/07/20 18:30:10 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1 [junit] 11/07/20 18:30:10 INFO ipc.Server: Stopping IPC Server Responder [junit] 11/07/20 18:30:10 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:37043, storageID=DS-1204717515-127.0.1.1-37043-1311186236929, infoPort=40908, ipcPort=57598):DataXceiveServer: java.nio.channels.AsynchronousCloseException [junit] at java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:185) [junit] at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:159) [junit] at sun.nio.ch.ServerSocketAdaptor.accept(ServerSocketAdaptor.java:84) [junit] at org.apache.hadoop.hdfs.server.datanode.DataXceiverServer.run(DataXceiverServer.java:130) [junit] at java.lang.Thread.run(Thread.java:662) [junit] [junit] 11/07/20 18:30:10 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread. [junit] 11/07/20 18:30:11 INFO datanode.DataNode: Deleting block blk_-3943494823013187226_1122 file build/test/data/dfs/data/data2/current/blk_-3943494823013187226 [junit] 11/07/20 18:30:11 INFO datanode.DataNode: Deleting block blk_-1986181213677077307_1126 file build/test/data/dfs/data/data2/current/blk_-1986181213677077307 [junit] 11/07/20 18:30:11 INFO datanode.DataNode: Deleting block blk_768233242821262845_1121 file build/test/data/dfs/data/data1/current/blk_768233242821262845 [junit] 11/07/20 18:30:11 INFO datanode.DataNode: Deleting block blk_6129303074643234637_1124 file build/test/data/dfs/data/data1/current/blk_6129303074643234637 [junit] 11/07/20 18:30:11 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0 [junit] 11/07/20 18:30:11 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:37043, storageID=DS-1204717515-127.0.1.1-37043-1311186236929, infoPort=40908, ipcPort=57598):Finishing DataNode in: FSDataset{dirpath='<https://builds.apache.org/job/Pig-trunk-commit/ws/trunk/build/test/data/dfs/data/data5/current,/grid/0/hudson/hudson-slave/workspace/Pig-trunk-commit/trunk/build/test/data/dfs/data/data6/current'}> [junit] 11/07/20 18:30:11 INFO ipc.Server: Stopping server on 57598 [junit] 11/07/20 18:30:11 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0 [junit] Shutting down DataNode 1 [junit] 11/07/20 18:30:11 INFO ipc.Server: Stopping server on 42336 [junit] 11/07/20 18:30:11 INFO ipc.Server: IPC Server handler 0 on 42336: exiting [junit] 11/07/20 18:30:11 INFO ipc.Server: IPC Server handler 1 on 42336: exiting [junit] 11/07/20 18:30:11 INFO ipc.Server: Stopping IPC Server listener on 42336 [junit] 11/07/20 18:30:11 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1 [junit] 11/07/20 18:30:11 INFO ipc.Server: Stopping IPC Server Responder [junit] 11/07/20 18:30:11 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:53806, storageID=DS-1772424937-127.0.1.1-53806-1311186236380, infoPort=39622, ipcPort=42336):DataXceiveServer: java.nio.channels.AsynchronousCloseException [junit] at java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:185) [junit] at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:159) [junit] at sun.nio.ch.ServerSocketAdaptor.accept(ServerSocketAdaptor.java:84) [junit] at org.apache.hadoop.hdfs.server.datanode.DataXceiverServer.run(DataXceiverServer.java:130) [junit] at java.lang.Thread.run(Thread.java:662) [junit] [junit] 11/07/20 18:30:11 INFO ipc.Server: IPC Server handler 2 on 42336: exiting [junit] 11/07/20 18:30:12 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread. [junit] 11/07/20 18:30:12 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0 [junit] 11/07/20 18:30:12 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:53806, storageID=DS-1772424937-127.0.1.1-53806-1311186236380, infoPort=39622, ipcPort=42336):Finishing DataNode in: FSDataset{dirpath='<https://builds.apache.org/job/Pig-trunk-commit/ws/trunk/build/test/data/dfs/data/data3/current,/grid/0/hudson/hudson-slave/workspace/Pig-trunk-commit/trunk/build/test/data/dfs/data/data4/current'}> [junit] 11/07/20 18:30:12 INFO ipc.Server: Stopping server on 42336 [junit] 11/07/20 18:30:12 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0 [junit] Shutting down DataNode 0 [junit] 11/07/20 18:30:12 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:35781 to delete blk_-3943494823013187226_1122 blk_-5539916122989107898_1127 blk_768233242821262845_1121 blk_-1986181213677077307_1126 blk_-4818205592067356364_1123 [junit] 11/07/20 18:30:12 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:53806 to delete blk_6129303074643234637_1124 blk_-3943494823013187226_1122 blk_-5539916122989107898_1127 blk_768233242821262845_1121 blk_-4818205592067356364_1123 [junit] 11/07/20 18:30:12 INFO ipc.Server: Stopping server on 43045 [junit] 11/07/20 18:30:12 INFO ipc.Server: IPC Server handler 0 on 43045: exiting [junit] 11/07/20 18:30:12 INFO ipc.Server: Stopping IPC Server listener on 43045 [junit] 11/07/20 18:30:12 INFO ipc.Server: IPC Server handler 2 on 43045: exiting [junit] 11/07/20 18:30:12 INFO ipc.Server: IPC Server handler 1 on 43045: exiting [junit] 11/07/20 18:30:12 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1 [junit] 11/07/20 18:30:12 INFO ipc.Server: Stopping IPC Server Responder [junit] 11/07/20 18:30:12 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:60671, storageID=DS-1029713809-127.0.1.1-60671-1311186236075, infoPort=55542, ipcPort=43045):DataXceiveServer: java.nio.channels.AsynchronousCloseException [junit] at java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:185) [junit] at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:159) [junit] at sun.nio.ch.ServerSocketAdaptor.accept(ServerSocketAdaptor.java:84) [junit] at org.apache.hadoop.hdfs.server.datanode.DataXceiverServer.run(DataXceiverServer.java:130) [junit] at java.lang.Thread.run(Thread.java:662) [junit] [junit] 11/07/20 18:30:13 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread. [junit] 11/07/20 18:30:13 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0 [junit] 11/07/20 18:30:13 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:60671, storageID=DS-1029713809-127.0.1.1-60671-1311186236075, infoPort=55542, ipcPort=43045):Finishing DataNode in: FSDataset{dirpath='<https://builds.apache.org/job/Pig-trunk-commit/ws/trunk/build/test/data/dfs/data/data1/current,/grid/0/hudson/hudson-slave/workspace/Pig-trunk-commit/trunk/build/test/data/dfs/data/data2/current'}> [junit] 11/07/20 18:30:13 INFO ipc.Server: Stopping server on 43045 [junit] 11/07/20 18:30:13 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0 [junit] 11/07/20 18:30:14 INFO namenode.DecommissionManager: Interrupted Monitor [junit] java.lang.InterruptedException: sleep interrupted [junit] at java.lang.Thread.sleep(Native Method) [junit] at org.apache.hadoop.hdfs.server.namenode.DecommissionManager$Monitor.run(DecommissionManager.java:65) [junit] at java.lang.Thread.run(Thread.java:662) [junit] 11/07/20 18:30:14 WARN namenode.FSNamesystem: ReplicationMonitor thread received InterruptedException.java.lang.InterruptedException: sleep interrupted [junit] 11/07/20 18:30:14 INFO namenode.FSNamesystem: Number of transactions: 694 Total time for transactions(ms): 19Number of transactions batched in Syncs: 114 Number of syncs: 484 SyncTimes(ms): 7634 1658 [junit] 11/07/20 18:30:14 INFO ipc.Server: Stopping server on 59045 [junit] Tests run: 17, Failures: 0, Errors: 0, Time elapsed: 374.629 sec [junit] 11/07/20 18:30:14 INFO ipc.Server: Stopping IPC Server listener on 59045 [junit] 11/07/20 18:30:14 INFO ipc.Server: IPC Server handler 0 on 59045: exiting [junit] 11/07/20 18:30:14 INFO ipc.Server: IPC Server handler 2 on 59045: exiting [junit] 11/07/20 18:30:14 INFO ipc.Server: IPC Server handler 3 on 59045: exiting [junit] 11/07/20 18:30:14 INFO ipc.Server: Stopping IPC Server Responder [junit] 11/07/20 18:30:14 INFO ipc.Server: IPC Server handler 8 on 59045: exiting [junit] 11/07/20 18:30:14 INFO ipc.Server: IPC Server handler 1 on 59045: exiting [junit] 11/07/20 18:30:14 INFO ipc.Server: IPC Server handler 4 on 59045: exiting [junit] 11/07/20 18:30:14 INFO ipc.Server: IPC Server handler 9 on 59045: exiting [junit] 11/07/20 18:30:14 INFO ipc.Server: IPC Server handler 5 on 59045: exiting [junit] 11/07/20 18:30:14 INFO ipc.Server: IPC Server handler 6 on 59045: exiting [junit] 11/07/20 18:30:14 INFO ipc.Server: IPC Server handler 7 on 59045: exiting [junit] Running org.apache.pig.test.TestStringUDFs [junit] 11/07/20 18:30:14 WARN builtin.SUBSTRING: java.lang.NullPointerException [junit] 11/07/20 18:30:15 WARN builtin.SUBSTRING: java.lang.StringIndexOutOfBoundsException: String index out of range: -2 [junit] 11/07/20 18:30:15 WARN builtin.SUBSTRING: java.lang.StringIndexOutOfBoundsException: String index out of range: -1 [junit] 11/07/20 18:30:15 WARN builtin.SUBSTRING: java.lang.StringIndexOutOfBoundsException: String index out of range: -8 [junit] 11/07/20 18:30:15 WARN builtin.SUBSTRING: java.lang.StringIndexOutOfBoundsException: String index out of range: -2 [junit] 11/07/20 18:30:15 WARN builtin.INDEXOF: Failed to process input; error - null [junit] 11/07/20 18:30:15 WARN builtin.LAST_INDEX_OF: Failed to process input; error - null [junit] Tests run: 11, Failures: 0, Errors: 0, Time elapsed: 0.122 sec [delete] Deleting directory /tmp/pig_junit_tmp574247011 BUILD FAILED <https://builds.apache.org/job/Pig-trunk-commit/ws/trunk/build.xml>:664: The following error occurred while executing this line: <https://builds.apache.org/job/Pig-trunk-commit/ws/trunk/build.xml>:719: Tests failed! Total time: 21 minutes 25 seconds [FINDBUGS] Skipping publisher since build result is FAILURE Recording test results Publishing Javadoc Archiving artifacts Recording fingerprints Publishing Clover coverage report... No Clover report will be published due to a Build Failure