See <https://builds.apache.org/job/Pig-trunk-commit/859/changes>
Changes: [dvryaboy] PIG-2143: Make PigStorage optionally store schema; improve docs. [thejas] PIG-1973: UDFContext.getUDFContext usage of ThreadLocal pattern is not typical (woody via thejas) [thejas] PIG-2053: PigInputFormat uses class.isAssignableFrom() where instanceof is more appropriate (woody via thejas) ------------------------------------------ [...truncated 40179 lines...] [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.MiniCluster.shutdownMiniDfsAndMrClusters(MiniCluster.java:111) [junit] at org.apache.pig.test.MiniCluster.shutDown(MiniCluster.java:101) [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/18 16:29:13 INFO ipc.Server: Stopping server on 42421 [junit] 11/07/18 16:29:13 INFO ipc.Server: IPC Server handler 2 on 42421: exiting [junit] 11/07/18 16:29:13 INFO ipc.Server: IPC Server handler 0 on 42421: exiting [junit] 11/07/18 16:29:13 INFO ipc.Server: Stopping IPC Server listener on 42421 [junit] 11/07/18 16:29:13 INFO ipc.Server: IPC Server handler 1 on 42421: exiting [junit] 11/07/18 16:29:13 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1 [junit] 11/07/18 16:29:13 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:50529, storageID=DS-855549840-127.0.1.1-50529-1311006185850, infoPort=56258, ipcPort=42421):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/18 16:29:13 INFO ipc.Server: Stopping IPC Server Responder [junit] 11/07/18 16:29:13 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread. [junit] 11/07/18 16:29:14 INFO datanode.DataNode: Deleting block blk_397522998911042587_1123 file build/test/data/dfs/data/data2/current/blk_397522998911042587 [junit] 11/07/18 16:29:14 INFO datanode.DataNode: Deleting block blk_4827013878883143290_1124 file build/test/data/dfs/data/data1/current/blk_4827013878883143290 [junit] 11/07/18 16:29:14 INFO datanode.DataNode: Deleting block blk_8902643049119501143_1122 file build/test/data/dfs/data/data1/current/blk_8902643049119501143 [junit] 11/07/18 16:29:14 INFO datanode.DataNode: Deleting block blk_397522998911042587_1123 file build/test/data/dfs/data/data4/current/blk_397522998911042587 [junit] 11/07/18 16:29:14 INFO datanode.DataNode: Deleting block blk_4827013878883143290_1124 file build/test/data/dfs/data/data3/current/blk_4827013878883143290 [junit] 11/07/18 16:29:14 INFO datanode.DataNode: Deleting block blk_8902643049119501143_1122 file build/test/data/dfs/data/data3/current/blk_8902643049119501143 [junit] 11/07/18 16:29:14 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0 [junit] 11/07/18 16:29:14 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:50529, storageID=DS-855549840-127.0.1.1-50529-1311006185850, infoPort=56258, ipcPort=42421):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/18 16:29:14 INFO ipc.Server: Stopping server on 42421 [junit] 11/07/18 16:29:14 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0 [junit] Shutting down DataNode 2 [junit] 11/07/18 16:29:14 INFO ipc.Server: Stopping server on 55290 [junit] 11/07/18 16:29:14 INFO ipc.Server: IPC Server handler 0 on 55290: exiting [junit] 11/07/18 16:29:14 INFO ipc.Server: Stopping IPC Server Responder [junit] 11/07/18 16:29:14 INFO ipc.Server: IPC Server handler 2 on 55290: exiting [junit] 11/07/18 16:29:14 INFO ipc.Server: IPC Server handler 1 on 55290: exiting [junit] 11/07/18 16:29:14 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:49612, storageID=DS-948550833-127.0.1.1-49612-1311006185544, infoPort=55023, ipcPort=55290):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/18 16:29:14 INFO ipc.Server: Stopping IPC Server listener on 55290 [junit] 11/07/18 16:29:14 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1 [junit] 11/07/18 16:29:14 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread. [junit] 11/07/18 16:29:14 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:49612, storageID=DS-948550833-127.0.1.1-49612-1311006185544, infoPort=55023, ipcPort=55290):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/18 16:29:14 INFO ipc.Server: Stopping server on 55290 [junit] 11/07/18 16:29:14 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0 [junit] Shutting down DataNode 1 [junit] 11/07/18 16:29:14 INFO ipc.Server: Stopping server on 49328 [junit] 11/07/18 16:29:14 INFO ipc.Server: IPC Server handler 0 on 49328: exiting [junit] 11/07/18 16:29:14 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1 [junit] 11/07/18 16:29:14 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:40361, storageID=DS-23402144-127.0.1.1-40361-1311006185228, infoPort=36944, ipcPort=49328):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/18 16:29:14 INFO ipc.Server: IPC Server handler 1 on 49328: exiting [junit] 11/07/18 16:29:14 INFO ipc.Server: IPC Server handler 2 on 49328: exiting [junit] 11/07/18 16:29:14 INFO ipc.Server: Stopping IPC Server listener on 49328 [junit] 11/07/18 16:29:14 INFO ipc.Server: Stopping IPC Server Responder [junit] 11/07/18 16:29:15 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread. [junit] 11/07/18 16:29:15 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:35173 to delete blk_-7185019742731104502_1126 blk_2724036743554438767_1127 [junit] 11/07/18 16:29:15 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:40361 to delete blk_-7185019742731104502_1126 blk_-4725648147486372678_1121 [junit] 11/07/18 16:29:15 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0 [junit] 11/07/18 16:29:15 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:40361, storageID=DS-23402144-127.0.1.1-40361-1311006185228, infoPort=36944, ipcPort=49328):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/18 16:29:15 INFO ipc.Server: Stopping server on 49328 [junit] 11/07/18 16:29:15 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0 [junit] Shutting down DataNode 0 [junit] 11/07/18 16:29:15 INFO ipc.Server: Stopping server on 53079 [junit] 11/07/18 16:29:15 INFO ipc.Server: IPC Server handler 0 on 53079: exiting [junit] 11/07/18 16:29:15 INFO ipc.Server: IPC Server handler 2 on 53079: exiting [junit] 11/07/18 16:29:15 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1 [junit] 11/07/18 16:29:15 INFO ipc.Server: Stopping IPC Server listener on 53079 [junit] 11/07/18 16:29:15 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:35173, storageID=DS-1565074408-127.0.1.1-35173-1311006184907, infoPort=60826, ipcPort=53079):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/18 16:29:15 INFO ipc.Server: IPC Server handler 1 on 53079: exiting [junit] 11/07/18 16:29:15 INFO ipc.Server: Stopping IPC Server Responder [junit] 11/07/18 16:29:15 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread. [junit] 11/07/18 16:29:16 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0 [junit] 11/07/18 16:29:16 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:35173, storageID=DS-1565074408-127.0.1.1-35173-1311006184907, infoPort=60826, ipcPort=53079):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/18 16:29:16 INFO ipc.Server: Stopping server on 53079 [junit] 11/07/18 16:29:16 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0 [junit] 11/07/18 16:29:16 WARN namenode.FSNamesystem: ReplicationMonitor thread received InterruptedException.java.lang.InterruptedException: sleep interrupted [junit] 11/07/18 16:29:16 INFO namenode.FSNamesystem: Number of transactions: 694 Total time for transactions(ms): 15Number of transactions batched in Syncs: 114 Number of syncs: 484 SyncTimes(ms): 5860 2381 [junit] 11/07/18 16:29:16 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/18 16:29:16 INFO ipc.Server: Stopping server on 33356 [junit] 11/07/18 16:29:16 INFO ipc.Server: Stopping IPC Server listener on 33356 [junit] 11/07/18 16:29:16 INFO ipc.Server: IPC Server handler 0 on 33356: exiting [junit] 11/07/18 16:29:16 INFO ipc.Server: Stopping IPC Server Responder [junit] 11/07/18 16:29:16 INFO ipc.Server: IPC Server handler 2 on 33356: exiting [junit] 11/07/18 16:29:16 INFO ipc.Server: IPC Server handler 6 on 33356: exiting [junit] 11/07/18 16:29:16 INFO ipc.Server: IPC Server handler 3 on 33356: exiting [junit] 11/07/18 16:29:16 INFO ipc.Server: IPC Server handler 1 on 33356: exiting [junit] 11/07/18 16:29:16 INFO ipc.Server: IPC Server handler 9 on 33356: exiting [junit] 11/07/18 16:29:16 INFO ipc.Server: IPC Server handler 4 on 33356: exiting [junit] 11/07/18 16:29:16 INFO mapred.TaskTracker: Shutting down: Map-events fetcher for all reduce tasks on tracker_host0.foo.com:localhost/127.0.0.1:58785 [junit] 11/07/18 16:29:16 INFO ipc.Server: IPC Server handler 5 on 33356: exiting [junit] 11/07/18 16:29:16 INFO ipc.Server: IPC Server handler 7 on 33356: exiting [junit] 11/07/18 16:29:16 INFO ipc.Server: Stopping server on 58785 [junit] 11/07/18 16:29:16 INFO ipc.Server: IPC Server handler 8 on 33356: exiting [junit] 11/07/18 16:29:16 INFO ipc.Server: IPC Server handler 2 on 58785: exiting [junit] 11/07/18 16:29:16 INFO ipc.Server: IPC Server handler 0 on 58785: exiting [junit] 11/07/18 16:29:16 INFO ipc.Server: Stopping IPC Server listener on 58785 [junit] 11/07/18 16:29:16 INFO mapred.TaskTracker: Shutting down StatusHttpServer [junit] 11/07/18 16:29:16 INFO ipc.Server: Stopping IPC Server Responder [junit] 11/07/18 16:29:16 INFO ipc.Server: IPC Server handler 3 on 58785: exiting [junit] 11/07/18 16:29:16 INFO ipc.Server: IPC Server handler 1 on 58785: exiting [junit] 11/07/18 16:29:16 INFO mapred.TaskTracker: Interrupted. Closing down. [junit] 11/07/18 16:29:16 INFO mapred.TaskTracker: Shutting down: Map-events fetcher for all reduce tasks on tracker_host1.foo.com:localhost/127.0.0.1:42189 [junit] 11/07/18 16:29:16 INFO ipc.Server: Stopping server on 42189 [junit] 11/07/18 16:29:16 INFO ipc.Server: IPC Server handler 3 on 42189: exiting [junit] 11/07/18 16:29:16 INFO ipc.Server: IPC Server handler 2 on 42189: exiting [junit] 11/07/18 16:29:16 INFO ipc.Server: IPC Server handler 1 on 42189: exiting [junit] 11/07/18 16:29:16 INFO ipc.Server: IPC Server handler 0 on 42189: exiting [junit] 11/07/18 16:29:16 INFO ipc.Server: Stopping IPC Server Responder [junit] 11/07/18 16:29:16 INFO mapred.TaskTracker: Shutting down StatusHttpServer [junit] 11/07/18 16:29:16 INFO ipc.Server: Stopping IPC Server listener on 42189 [junit] 11/07/18 16:29:17 INFO mapred.TaskTracker: Interrupted. Closing down. [junit] 11/07/18 16:29:17 INFO mapred.TaskTracker: Shutting down: Map-events fetcher for all reduce tasks on tracker_host2.foo.com:localhost/127.0.0.1:35059 [junit] 11/07/18 16:29:17 INFO ipc.Server: Stopping server on 35059 [junit] 11/07/18 16:29:17 INFO ipc.Server: IPC Server handler 0 on 35059: exiting [junit] 11/07/18 16:29:17 INFO ipc.Server: Stopping IPC Server listener on 35059 [junit] 11/07/18 16:29:17 INFO ipc.Server: IPC Server handler 1 on 35059: exiting [junit] 11/07/18 16:29:17 INFO ipc.Server: IPC Server handler 2 on 35059: exiting [junit] 11/07/18 16:29:17 INFO ipc.Server: Stopping IPC Server Responder [junit] 11/07/18 16:29:17 INFO mapred.TaskTracker: Shutting down StatusHttpServer [junit] 11/07/18 16:29:17 INFO ipc.Server: IPC Server handler 3 on 35059: exiting [junit] 11/07/18 16:30:17 ERROR mapred.TaskTracker: Caught exception: java.io.IOException: Call to localhost/127.0.0.1:49489 failed on local exception: java.nio.channels.ClosedByInterruptException [junit] at org.apache.hadoop.ipc.Client.wrapException(Client.java:775) [junit] at org.apache.hadoop.ipc.Client.call(Client.java:743) [junit] at org.apache.hadoop.ipc.RPC$Invoker.invoke(RPC.java:220) [junit] at org.apache.hadoop.mapred.$Proxy6.heartbeat(Unknown Source) [junit] at org.apache.hadoop.mapred.TaskTracker.transmitHeartBeat(TaskTracker.java:1215) [junit] at org.apache.hadoop.mapred.TaskTracker.offerService(TaskTracker.java:1037) [junit] at org.apache.hadoop.mapred.TaskTracker.run(TaskTracker.java:1720) [junit] at org.apache.hadoop.mapred.MiniMRCluster$TaskTrackerRunner.run(MiniMRCluster.java:195) [junit] at java.lang.Thread.run(Thread.java:662) [junit] Caused by: java.nio.channels.ClosedByInterruptException [junit] at java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:184) [junit] at sun.nio.ch.SocketChannelImpl.write(SocketChannelImpl.java:341) [junit] at org.apache.hadoop.net.SocketOutputStream$Writer.performIO(SocketOutputStream.java:55) [junit] at org.apache.hadoop.net.SocketIOWithTimeout.doIO(SocketIOWithTimeout.java:142) [junit] at org.apache.hadoop.net.SocketOutputStream.write(SocketOutputStream.java:146) [junit] at org.apache.hadoop.net.SocketOutputStream.write(SocketOutputStream.java:107) [junit] at java.io.BufferedOutputStream.flushBuffer(BufferedOutputStream.java:65) [junit] at java.io.BufferedOutputStream.flush(BufferedOutputStream.java:123) [junit] at java.io.DataOutputStream.flush(DataOutputStream.java:106) [junit] at org.apache.hadoop.ipc.Client$Connection.sendParam(Client.java:480) [junit] at org.apache.hadoop.ipc.Client.call(Client.java:721) [junit] ... 7 more [junit] [junit] 11/07/18 16:30:17 INFO mapred.TaskTracker: Shutting down: Map-events fetcher for all reduce tasks on tracker_host3.foo.com:localhost/127.0.0.1:50455 [junit] 11/07/18 16:30:17 INFO ipc.Server: Stopping server on 50455 [junit] 11/07/18 16:30:17 INFO ipc.Server: IPC Server handler 0 on 50455: exiting [junit] 11/07/18 16:30:17 INFO ipc.Server: IPC Server handler 1 on 50455: exiting [junit] 11/07/18 16:30:17 INFO ipc.Server: IPC Server handler 3 on 50455: exiting [junit] 11/07/18 16:30:17 INFO ipc.Server: Stopping IPC Server Responder [junit] 11/07/18 16:30:17 INFO ipc.Server: IPC Server handler 2 on 50455: exiting [junit] 11/07/18 16:30:17 INFO ipc.Server: Stopping IPC Server listener on 50455 [junit] 11/07/18 16:30:17 INFO mapred.TaskTracker: Shutting down StatusHttpServer [junit] 11/07/18 16:30:17 INFO mapred.TaskTracker: Interrupted. Closing down. [junit] 11/07/18 16:30:17 INFO mapred.JobTracker: Stopping infoServer [junit] 11/07/18 16:30:17 INFO mapred.JobTracker: Stopping interTrackerServer [junit] 11/07/18 16:30:17 INFO ipc.Server: Stopping server on 49489 [junit] 11/07/18 16:30:17 INFO ipc.Server: IPC Server handler 0 on 49489: exiting [junit] 11/07/18 16:30:17 INFO ipc.Server: IPC Server handler 2 on 49489: exiting [junit] 11/07/18 16:30:17 INFO ipc.Server: IPC Server handler 4 on 49489: exiting [junit] 11/07/18 16:30:17 INFO ipc.Server: IPC Server handler 3 on 49489: exiting [junit] 11/07/18 16:30:17 INFO ipc.Server: IPC Server handler 5 on 49489: exiting [junit] 11/07/18 16:30:17 INFO ipc.Server: IPC Server handler 1 on 49489: exiting [junit] 11/07/18 16:30:17 INFO ipc.Server: IPC Server handler 7 on 49489: exiting [junit] 11/07/18 16:30:17 INFO mapred.JobTracker: Stopping expireTrackers [junit] 11/07/18 16:30:17 INFO ipc.Server: Stopping IPC Server listener on 49489 [junit] 11/07/18 16:30:17 INFO ipc.Server: IPC Server handler 6 on 49489: exiting [junit] 11/07/18 16:30:17 INFO mapred.JobTracker: Stopping retirer [junit] 11/07/18 16:30:17 INFO ipc.Server: Stopping IPC Server Responder [junit] 11/07/18 16:30:17 INFO mapred.EagerTaskInitializationListener: Stopping Job Init Manager thread [junit] 11/07/18 16:30:17 INFO mapred.JobTracker: Stopped interTrackerServer [junit] 11/07/18 16:30:17 INFO ipc.Server: IPC Server handler 8 on 49489: exiting [junit] 11/07/18 16:30:17 INFO ipc.Server: IPC Server handler 9 on 49489: exiting [junit] 11/07/18 16:30:17 INFO mapred.EagerTaskInitializationListener: JobInitManagerThread interrupted. [junit] 11/07/18 16:30:17 INFO mapred.EagerTaskInitializationListener: Shutting down thread pool [junit] 11/07/18 16:30:17 INFO mapred.JobTracker: Stopping expireLaunchingTasks [junit] 11/07/18 16:30:17 INFO mapred.JobTracker: stopped all jobtracker services [junit] Tests run: 17, Failures: 0, Errors: 0, Time elapsed: 429.283 sec [junit] Running org.apache.pig.test.TestStringUDFs [junit] 11/07/18 16:30:18 WARN builtin.SUBSTRING: java.lang.NullPointerException [junit] 11/07/18 16:30:18 WARN builtin.SUBSTRING: java.lang.StringIndexOutOfBoundsException: String index out of range: -2 [junit] 11/07/18 16:30:18 WARN builtin.SUBSTRING: java.lang.StringIndexOutOfBoundsException: String index out of range: -1 [junit] 11/07/18 16:30:18 WARN builtin.SUBSTRING: java.lang.StringIndexOutOfBoundsException: String index out of range: -8 [junit] 11/07/18 16:30:18 WARN builtin.SUBSTRING: java.lang.StringIndexOutOfBoundsException: String index out of range: -2 [junit] 11/07/18 16:30:18 WARN builtin.INDEXOF: Failed to process input; error - null [junit] 11/07/18 16:30:18 WARN builtin.LAST_INDEX_OF: Failed to process input; error - null [junit] Tests run: 11, Failures: 0, Errors: 0, Time elapsed: 0.118 sec [delete] Deleting directory /tmp/pig_junit_tmp1134026355 BUILD FAILED <https://builds.apache.org/job/Pig-trunk-commit/ws/trunk/build.xml>:652: The following error occurred while executing this line: <https://builds.apache.org/job/Pig-trunk-commit/ws/trunk/build.xml>:707: Tests failed! Total time: 22 minutes 13 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