You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@pig.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2012/11/09 11:34:52 UTC

Build failed in Jenkins: Pig-trunk #1358

See <https://builds.apache.org/job/Pig-trunk/1358/changes>

Changes:

[cheolsoo] PIG-2979: Pig.jar doesn't work with hadoop-2.0.x (cheolsoo)

------------------------------------------
[...truncated 38428 lines...]
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdownDataNodes(MiniDFSCluster.java:566)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:550)
    [junit] 	at org.apache.pig.test.MiniGenericCluster.shutdownMiniDfsClusters(MiniGenericCluster.java:87)
    [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:138)
    [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] 12/11/09 10:34:16 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] 12/11/09 10:34:16 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/11/09 10:34:16 INFO ipc.Server: Stopping server on 33361
    [junit] 12/11/09 10:34:16 INFO ipc.Server: IPC Server handler 1 on 33361: exiting
    [junit] 12/11/09 10:34:16 INFO ipc.Server: IPC Server handler 2 on 33361: exiting
    [junit] 12/11/09 10:34:16 INFO ipc.Server: Stopping IPC Server listener on 33361
    [junit] 12/11/09 10:34:16 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/11/09 10:34:16 INFO ipc.Server: IPC Server handler 0 on 33361: exiting
    [junit] 12/11/09 10:34:16 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/09 10:34:16 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1
    [junit] 12/11/09 10:34:16 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:42881, storageID=DS-754274827-67.195.138.20-42881-1352456759286, infoPort=41770, ipcPort=33361):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:131)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 
    [junit] 12/11/09 10:34:16 INFO datanode.DataNode: Exiting DataXceiveServer
    [junit] 12/11/09 10:34:16 INFO datanode.DataNode: Scheduling block blk_4945455753790126000_1134 file build/test/data/dfs/data/data1/current/blk_4945455753790126000 for deletion
    [junit] 12/11/09 10:34:16 INFO datanode.DataNode: Deleted block blk_4945455753790126000_1134 at file build/test/data/dfs/data/data1/current/blk_4945455753790126000
    [junit] 12/11/09 10:34:17 INFO mapred.TaskTracker: Received 'KillJobAction' for job: job_20121109102559702_0012
    [junit] 12/11/09 10:34:17 WARN mapred.TaskTracker: Unknown job job_20121109102559702_0012 being deleted.
    [junit] 12/11/09 10:34:17 INFO mapred.TaskTracker: Received 'KillJobAction' for job: job_20121109102559702_0012
    [junit] 12/11/09 10:34:17 WARN mapred.TaskTracker: Unknown job job_20121109102559702_0012 being deleted.
    [junit] 12/11/09 10:34:17 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 12/11/09 10:34:17 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:42881, storageID=DS-754274827-67.195.138.20-42881-1352456759286, infoPort=41770, ipcPort=33361):Finishing DataNode in: FSDataset{dirpath='<https://builds.apache.org/job/Pig-trunk/ws/trunk/build/test/data/dfs/data/data5/current,/home/jenkins/jenkins-slave/workspace/Pig-trunk/trunk/build/test/data/dfs/data/data6/current'}>
    [junit] 12/11/09 10:34:17 INFO ipc.Server: Stopping server on 33361
    [junit] 12/11/09 10:34:17 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/09 10:34:17 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/09 10:34:17 INFO datanode.FSDatasetAsyncDiskService: Shutting down all async disk service threads...
    [junit] 12/11/09 10:34:17 INFO datanode.FSDatasetAsyncDiskService: All async disk service threads have been shut down.
    [junit] Shutting down DataNode 1
    [junit] 12/11/09 10:34:17 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/09 10:34:17 WARN util.MBeans: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId784344213
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId784344213
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1094)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:415)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:403)
    [junit] 	at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:506)
    [junit] 	at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:71)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.FSDataset.shutdown(FSDataset.java:1934)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.shutdown(DataNode.java:788)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdownDataNodes(MiniDFSCluster.java:566)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:550)
    [junit] 	at org.apache.pig.test.MiniGenericCluster.shutdownMiniDfsClusters(MiniGenericCluster.java:87)
    [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:138)
    [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] 12/11/09 10:34:17 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] 12/11/09 10:34:17 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/11/09 10:34:17 INFO ipc.Server: Stopping server on 37311
    [junit] 12/11/09 10:34:17 INFO ipc.Server: IPC Server handler 0 on 37311: exiting
    [junit] 12/11/09 10:34:17 INFO ipc.Server: Stopping IPC Server listener on 37311
    [junit] 12/11/09 10:34:17 INFO ipc.Server: IPC Server handler 1 on 37311: exiting
    [junit] 12/11/09 10:34:17 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/11/09 10:34:17 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/09 10:34:17 INFO ipc.Server: IPC Server handler 2 on 37311: exiting
    [junit] 12/11/09 10:34:17 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1
    [junit] 12/11/09 10:34:17 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:42341, storageID=DS-1439265078-67.195.138.20-42341-1352456758844, infoPort=40913, ipcPort=37311):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:131)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 
    [junit] 12/11/09 10:34:17 INFO datanode.DataNode: Exiting DataXceiveServer
    [junit] 12/11/09 10:34:18 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 12/11/09 10:34:18 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:45904 to delete  blk_-7530744666222545083_1127 blk_5251371248928984222_1133
    [junit] 12/11/09 10:34:18 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:42881 to delete  blk_5163717974164260409_1134
    [junit] 12/11/09 10:34:18 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/09 10:34:18 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:42341, storageID=DS-1439265078-67.195.138.20-42341-1352456758844, infoPort=40913, ipcPort=37311):Finishing DataNode in: FSDataset{dirpath='<https://builds.apache.org/job/Pig-trunk/ws/trunk/build/test/data/dfs/data/data3/current,/home/jenkins/jenkins-slave/workspace/Pig-trunk/trunk/build/test/data/dfs/data/data4/current'}>
    [junit] 12/11/09 10:34:18 INFO ipc.Server: Stopping server on 37311
    [junit] 12/11/09 10:34:18 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/09 10:34:18 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/09 10:34:18 INFO datanode.FSDatasetAsyncDiskService: Shutting down all async disk service threads...
    [junit] 12/11/09 10:34:18 INFO datanode.FSDatasetAsyncDiskService: All async disk service threads have been shut down.
    [junit] 12/11/09 10:34:18 WARN util.MBeans: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId215338947
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId215338947
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1094)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:415)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:403)
    [junit] Shutting down DataNode 0
    [junit] 	at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:506)
    [junit] 	at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:71)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.FSDataset.shutdown(FSDataset.java:1934)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.shutdown(DataNode.java:788)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdownDataNodes(MiniDFSCluster.java:566)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:550)
    [junit] 	at org.apache.pig.test.MiniGenericCluster.shutdownMiniDfsClusters(MiniGenericCluster.java:87)
    [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:138)
    [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] 12/11/09 10:34:18 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] 12/11/09 10:34:18 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/11/09 10:34:18 INFO ipc.Server: Stopping server on 37809
    [junit] 12/11/09 10:34:18 INFO ipc.Server: IPC Server handler 0 on 37809: exiting
    [junit] 12/11/09 10:34:18 INFO ipc.Server: IPC Server handler 1 on 37809: exiting
    [junit] 12/11/09 10:34:18 INFO ipc.Server: IPC Server handler 2 on 37809: exiting
    [junit] 12/11/09 10:34:18 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/09 10:34:18 INFO ipc.Server: Stopping IPC Server listener on 37809
    [junit] 12/11/09 10:34:18 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1
    [junit] 12/11/09 10:34:18 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:48631, storageID=DS-465583694-67.195.138.20-48631-1352456758451, infoPort=38509, ipcPort=37809):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:131)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 
    [junit] 12/11/09 10:34:18 INFO datanode.DataNode: Exiting DataXceiveServer
    [junit] 12/11/09 10:34:18 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/11/09 10:34:19 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 12/11/09 10:34:19 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:48631, storageID=DS-465583694-67.195.138.20-48631-1352456758451, infoPort=38509, ipcPort=37809):Finishing DataNode in: FSDataset{dirpath='<https://builds.apache.org/job/Pig-trunk/ws/trunk/build/test/data/dfs/data/data1/current,/home/jenkins/jenkins-slave/workspace/Pig-trunk/trunk/build/test/data/dfs/data/data2/current'}>
    [junit] 12/11/09 10:34:19 WARN util.MBeans: Hadoop:service=DataNode,name=DataNodeInfo
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=DataNodeInfo
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1094)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:415)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:403)
    [junit] 	at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:506)
    [junit] 	at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:71)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.unRegisterMXBean(DataNode.java:513)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.shutdown(DataNode.java:726)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.run(DataNode.java:1442)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 12/11/09 10:34:19 INFO ipc.Server: Stopping server on 37809
    [junit] 12/11/09 10:34:19 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/09 10:34:19 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/09 10:34:19 INFO datanode.FSDatasetAsyncDiskService: Shutting down all async disk service threads...
    [junit] 12/11/09 10:34:19 INFO datanode.FSDatasetAsyncDiskService: All async disk service threads have been shut down.
    [junit] 12/11/09 10:34:19 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/09 10:34:19 WARN util.MBeans: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId1250996282
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId1250996282
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1094)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:415)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:403)
    [junit] 	at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:506)
    [junit] 	at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:71)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.FSDataset.shutdown(FSDataset.java:1934)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.shutdown(DataNode.java:788)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdownDataNodes(MiniDFSCluster.java:566)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:550)
    [junit] 	at org.apache.pig.test.MiniGenericCluster.shutdownMiniDfsClusters(MiniGenericCluster.java:87)
    [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:138)
    [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] 12/11/09 10:34:19 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] 12/11/09 10:34:19 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/11/09 10:34:19 WARN namenode.FSNamesystem: ReplicationMonitor thread received InterruptedException.java.lang.InterruptedException: sleep interrupted
    [junit] 12/11/09 10:34:19 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] 12/11/09 10:34:19 INFO namenode.FSNamesystem: Number of transactions: 629 Total time for transactions(ms): 5Number of transactions batched in Syncs: 127 Number of syncs: 432 SyncTimes(ms): 7705 321 
    [junit] 12/11/09 10:34:19 INFO ipc.Server: Stopping server on 35954
    [junit] 12/11/09 10:34:19 INFO ipc.Server: IPC Server handler 0 on 35954: exiting
    [junit] 12/11/09 10:34:19 INFO ipc.Server: IPC Server handler 2 on 35954: exiting
    [junit] 12/11/09 10:34:19 INFO ipc.Server: IPC Server handler 1 on 35954: exiting
    [junit] 12/11/09 10:34:19 INFO ipc.Server: IPC Server handler 3 on 35954: exiting
    [junit] 12/11/09 10:34:19 INFO ipc.Server: IPC Server handler 4 on 35954: exiting
    [junit] 12/11/09 10:34:19 INFO ipc.Server: IPC Server handler 7 on 35954: exiting
    [junit] 12/11/09 10:34:19 INFO ipc.Server: IPC Server handler 5 on 35954: exiting
    [junit] 12/11/09 10:34:19 INFO ipc.Server: IPC Server handler 8 on 35954: exiting
    [junit] 12/11/09 10:34:19 INFO ipc.Server: IPC Server handler 6 on 35954: exiting
    [junit] 12/11/09 10:34:19 INFO ipc.Server: IPC Server handler 9 on 35954: exiting
    [junit] 12/11/09 10:34:19 INFO ipc.Server: Stopping IPC Server listener on 35954
    [junit] 12/11/09 10:34:19 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/09 10:34:19 INFO ipc.Server: Stopping IPC Server Responder
    [junit] Tests run: 17, Failures: 4, Errors: 3, Time elapsed: 494.628 sec
    [junit] Test org.apache.pig.test.TestStore FAILED
    [junit] Running org.apache.pig.test.TestStringUDFs
    [junit] 12/11/09 10:34:20 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.NullPointerException
    [junit] 12/11/09 10:34:20 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.StringIndexOutOfBoundsException: String index out of range: -2
    [junit] 12/11/09 10:34:20 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.StringIndexOutOfBoundsException: String index out of range: -1
    [junit] 12/11/09 10:34:20 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.StringIndexOutOfBoundsException: String index out of range: -8
    [junit] 12/11/09 10:34:20 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.StringIndexOutOfBoundsException: String index out of range: -2
    [junit] 12/11/09 10:34:20 WARN builtin.INDEXOF: No logger object provided to UDF: org.apache.pig.builtin.INDEXOF. Failed to process input; error - null
    [junit] 12/11/09 10:34:20 WARN builtin.LAST_INDEX_OF: No logger object provided to UDF: org.apache.pig.builtin.LAST_INDEX_OF. Failed to process input; error - null
    [junit] Tests run: 12, Failures: 0, Errors: 0, Time elapsed: 0.23 sec
   [delete] Deleting directory /tmp/pig_junit_tmp1458762167

BUILD FAILED
<https://builds.apache.org/job/Pig-trunk/ws/trunk/build.xml>:838: The following error occurred while executing this line:
<https://builds.apache.org/job/Pig-trunk/ws/trunk/build.xml>:907: Tests failed!

Total time: 21 minutes 40 seconds
Build step 'Execute shell' marked build as failure
[FINDBUGS] Skipping publisher since build result is FAILURE
Recording test results
Publishing Javadoc
Archiving artifacts
Recording fingerprints

Jenkins build is back to normal : Pig-trunk #1366

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Pig-trunk/1366/changes>


Build failed in Jenkins: Pig-trunk #1365

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Pig-trunk/1365/changes>

Changes:

[billgraham] PIG-2934: HBaseStorage filter optimizations (billgraham)

[thejas] PIG-2980: documentation for DateTime datatype (zjshen via thejas)

[thejas] PIG-2982: add unit tests for DateTime type that test setting timezone (zjshen via thejas)

------------------------------------------
[...truncated 39207 lines...]
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdownDataNodes(MiniDFSCluster.java:566)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:550)
    [junit] 	at org.apache.pig.test.MiniGenericCluster.shutdownMiniDfsClusters(MiniGenericCluster.java:87)
    [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:138)
    [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] 12/11/20 10:34:28 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] Shutting down DataNode 2
    [junit] 12/11/20 10:34:28 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/11/20 10:34:28 INFO ipc.Server: Stopping server on 37571
    [junit] 12/11/20 10:34:28 INFO ipc.Server: IPC Server handler 0 on 37571: exiting
    [junit] 12/11/20 10:34:28 INFO ipc.Server: IPC Server handler 1 on 37571: exiting
    [junit] 12/11/20 10:34:28 INFO ipc.Server: IPC Server handler 2 on 37571: exiting
    [junit] 12/11/20 10:34:28 INFO ipc.Server: Stopping IPC Server listener on 37571
    [junit] 12/11/20 10:34:28 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/20 10:34:28 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/11/20 10:34:28 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1
    [junit] 12/11/20 10:34:28 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:47505, storageID=DS-950172083-67.195.138.20-47505-1353407178557, infoPort=44341, ipcPort=37571):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:131)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 
    [junit] 12/11/20 10:34:28 INFO datanode.DataNode: Exiting DataXceiveServer
    [junit] 12/11/20 10:34:28 INFO mapred.TaskTracker: Received 'KillJobAction' for job: job_20121120102618993_0012
    [junit] 12/11/20 10:34:28 WARN mapred.TaskTracker: Unknown job job_20121120102618993_0012 being deleted.
    [junit] 12/11/20 10:34:28 INFO mapred.TaskTracker: Received 'KillJobAction' for job: job_20121120102618993_0012
    [junit] 12/11/20 10:34:28 WARN mapred.TaskTracker: Unknown job job_20121120102618993_0012 being deleted.
    [junit] 12/11/20 10:34:28 INFO mapred.TaskTracker: Received 'KillJobAction' for job: job_20121120102618993_0012
    [junit] 12/11/20 10:34:28 WARN mapred.TaskTracker: Unknown job job_20121120102618993_0012 being deleted.
    [junit] 12/11/20 10:34:28 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:47505 to delete  blk_-4688054730894597959_1134 blk_5793373621685338128_1134 blk_-8092737443405132461_1133 blk_4695858086165995304_1127
    [junit] 12/11/20 10:34:28 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:37159 to delete  blk_-4688054730894597959_1134 blk_5793373621685338128_1134 blk_4695858086165995304_1127
    [junit] 12/11/20 10:34:28 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 12/11/20 10:34:29 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/20 10:34:29 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:47505, storageID=DS-950172083-67.195.138.20-47505-1353407178557, infoPort=44341, ipcPort=37571):Finishing DataNode in: FSDataset{dirpath='<https://builds.apache.org/job/Pig-trunk/ws/trunk/build/test/data/dfs/data/data5/current,/home/jenkins/jenkins-slave/workspace/Pig-trunk/trunk/build/test/data/dfs/data/data6/current'}>
    [junit] 12/11/20 10:34:29 INFO ipc.Server: Stopping server on 37571
    [junit] 12/11/20 10:34:29 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/20 10:34:29 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/20 10:34:29 INFO datanode.FSDatasetAsyncDiskService: Shutting down all async disk service threads...
    [junit] 12/11/20 10:34:29 INFO datanode.FSDatasetAsyncDiskService: All async disk service threads have been shut down.
    [junit] 12/11/20 10:34:29 WARN util.MBeans: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId1059218711
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId1059218711
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1094)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:415)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:403)
    [junit] 	at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:506)
    [junit] 	at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:71)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.FSDataset.shutdown(FSDataset.java:1934)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.shutdown(DataNode.java:788)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdownDataNodes(MiniDFSCluster.java:566)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:550)
    [junit] 	at org.apache.pig.test.MiniGenericCluster.shutdownMiniDfsClusters(MiniGenericCluster.java:87)
    [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:138)
    [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] 12/11/20 10:34:29 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] Shutting down DataNode 1
    [junit] 12/11/20 10:34:29 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/11/20 10:34:29 INFO ipc.Server: Stopping server on 52955
    [junit] 12/11/20 10:34:29 INFO ipc.Server: IPC Server handler 0 on 52955: exiting
    [junit] 12/11/20 10:34:29 INFO ipc.Server: IPC Server handler 1 on 52955: exiting
    [junit] 12/11/20 10:34:29 INFO ipc.Server: IPC Server handler 2 on 52955: exiting
    [junit] 12/11/20 10:34:29 INFO ipc.Server: Stopping IPC Server listener on 52955
    [junit] 12/11/20 10:34:29 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/20 10:34:29 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/11/20 10:34:29 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:34489, storageID=DS-214200113-67.195.138.20-34489-1353407178167, infoPort=59326, ipcPort=52955):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:131)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 
    [junit] 12/11/20 10:34:29 INFO datanode.DataNode: Exiting DataXceiveServer
    [junit] 12/11/20 10:34:29 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/20 10:34:29 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 12/11/20 10:34:29 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:34489, storageID=DS-214200113-67.195.138.20-34489-1353407178167, infoPort=59326, ipcPort=52955):Finishing DataNode in: FSDataset{dirpath='<https://builds.apache.org/job/Pig-trunk/ws/trunk/build/test/data/dfs/data/data3/current,/home/jenkins/jenkins-slave/workspace/Pig-trunk/trunk/build/test/data/dfs/data/data4/current'}>
    [junit] 12/11/20 10:34:29 INFO ipc.Server: Stopping server on 52955
    [junit] 12/11/20 10:34:29 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/20 10:34:29 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/20 10:34:29 INFO datanode.FSDatasetAsyncDiskService: Shutting down all async disk service threads...
    [junit] 12/11/20 10:34:29 INFO datanode.FSDatasetAsyncDiskService: All async disk service threads have been shut down.
    [junit] 12/11/20 10:34:29 WARN util.MBeans: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId1422243037
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId1422243037
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1094)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:415)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:403)
    [junit] 	at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:506)
    [junit] 	at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:71)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.FSDataset.shutdown(FSDataset.java:1934)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.shutdown(DataNode.java:788)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdownDataNodes(MiniDFSCluster.java:566)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:550)
    [junit] 	at org.apache.pig.test.MiniGenericCluster.shutdownMiniDfsClusters(MiniGenericCluster.java:87)
    [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:138)
    [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] 12/11/20 10:34:29 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] Shutting down DataNode 0
    [junit] 12/11/20 10:34:29 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/11/20 10:34:29 INFO ipc.Server: Stopping server on 56951
    [junit] 12/11/20 10:34:29 INFO ipc.Server: IPC Server handler 0 on 56951: exiting
    [junit] 12/11/20 10:34:29 INFO ipc.Server: IPC Server handler 1 on 56951: exiting
    [junit] 12/11/20 10:34:29 INFO ipc.Server: IPC Server handler 2 on 56951: exiting
    [junit] 12/11/20 10:34:29 INFO ipc.Server: Stopping IPC Server listener on 56951
    [junit] 12/11/20 10:34:29 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/11/20 10:34:29 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/20 10:34:29 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1
    [junit] 12/11/20 10:34:29 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:37159, storageID=DS-1794432536-67.195.138.20-37159-1353407177766, infoPort=39871, ipcPort=56951):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:131)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 
    [junit] 12/11/20 10:34:29 INFO datanode.DataNode: Exiting DataXceiveServer
    [junit] 12/11/20 10:34:29 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 12/11/20 10:34:29 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:37159, storageID=DS-1794432536-67.195.138.20-37159-1353407177766, infoPort=39871, ipcPort=56951):Finishing DataNode in: FSDataset{dirpath='<https://builds.apache.org/job/Pig-trunk/ws/trunk/build/test/data/dfs/data/data1/current,/home/jenkins/jenkins-slave/workspace/Pig-trunk/trunk/build/test/data/dfs/data/data2/current'}>
    [junit] 12/11/20 10:34:29 WARN util.MBeans: Hadoop:service=DataNode,name=DataNodeInfo
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=DataNodeInfo
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1094)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:415)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:403)
    [junit] 	at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:506)
    [junit] 	at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:71)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.unRegisterMXBean(DataNode.java:513)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.shutdown(DataNode.java:726)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.run(DataNode.java:1442)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 12/11/20 10:34:29 INFO ipc.Server: Stopping server on 56951
    [junit] 12/11/20 10:34:29 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/20 10:34:29 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/20 10:34:29 INFO datanode.FSDatasetAsyncDiskService: Shutting down all async disk service threads...
    [junit] 12/11/20 10:34:29 INFO datanode.FSDatasetAsyncDiskService: All async disk service threads have been shut down.
    [junit] 12/11/20 10:34:30 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/20 10:34:30 WARN util.MBeans: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId-648712294
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId-648712294
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1094)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:415)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:403)
    [junit] 	at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:506)
    [junit] 	at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:71)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.FSDataset.shutdown(FSDataset.java:1934)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.shutdown(DataNode.java:788)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdownDataNodes(MiniDFSCluster.java:566)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:550)
    [junit] 	at org.apache.pig.test.MiniGenericCluster.shutdownMiniDfsClusters(MiniGenericCluster.java:87)
    [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:138)
    [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] 12/11/20 10:34:30 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] 12/11/20 10:34:30 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/11/20 10:34:30 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] 12/11/20 10:34:30 WARN namenode.FSNamesystem: ReplicationMonitor thread received InterruptedException.java.lang.InterruptedException: sleep interrupted
    [junit] 12/11/20 10:34:30 INFO namenode.FSNamesystem: Number of transactions: 629 Total time for transactions(ms): 10Number of transactions batched in Syncs: 128 Number of syncs: 432 SyncTimes(ms): 6276 270 
    [junit] 12/11/20 10:34:30 INFO ipc.Server: Stopping server on 41624
    [junit] 12/11/20 10:34:30 INFO ipc.Server: IPC Server handler 0 on 41624: exiting
    [junit] 12/11/20 10:34:30 INFO ipc.Server: IPC Server handler 1 on 41624: exiting
    [junit] 12/11/20 10:34:30 INFO ipc.Server: IPC Server handler 2 on 41624: exiting
    [junit] 12/11/20 10:34:30 INFO ipc.Server: IPC Server handler 3 on 41624: exiting
    [junit] 12/11/20 10:34:30 INFO ipc.Server: IPC Server handler 5 on 41624: exiting
    [junit] 12/11/20 10:34:30 INFO ipc.Server: IPC Server handler 4 on 41624: exiting
    [junit] 12/11/20 10:34:30 INFO ipc.Server: IPC Server handler 6 on 41624: exiting
    [junit] 12/11/20 10:34:30 INFO ipc.Server: Stopping IPC Server listener on 41624
    [junit] 12/11/20 10:34:30 INFO ipc.Server: IPC Server handler 7 on 41624: exiting
    [junit] 12/11/20 10:34:30 INFO ipc.Server: IPC Server handler 9 on 41624: exiting
    [junit] 12/11/20 10:34:30 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/11/20 10:34:30 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/20 10:34:30 INFO ipc.Server: IPC Server handler 8 on 41624: exiting
    [junit] Tests run: 17, Failures: 4, Errors: 3, Time elapsed: 485.97 sec
    [junit] Test org.apache.pig.test.TestStore FAILED
    [junit] Running org.apache.pig.test.TestStringUDFs
    [junit] 12/11/20 10:34:31 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.NullPointerException
    [junit] 12/11/20 10:34:31 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.StringIndexOutOfBoundsException: String index out of range: -2
    [junit] 12/11/20 10:34:31 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.StringIndexOutOfBoundsException: String index out of range: -1
    [junit] 12/11/20 10:34:31 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.StringIndexOutOfBoundsException: String index out of range: -8
    [junit] 12/11/20 10:34:31 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.StringIndexOutOfBoundsException: String index out of range: -2
    [junit] 12/11/20 10:34:31 WARN builtin.INDEXOF: No logger object provided to UDF: org.apache.pig.builtin.INDEXOF. Failed to process input; error - null
    [junit] 12/11/20 10:34:31 WARN builtin.LAST_INDEX_OF: No logger object provided to UDF: org.apache.pig.builtin.LAST_INDEX_OF. Failed to process input; error - null
    [junit] Tests run: 12, Failures: 0, Errors: 0, Time elapsed: 0.26 sec
   [delete] Deleting directory /tmp/pig_junit_tmp1494927310

BUILD FAILED
<https://builds.apache.org/job/Pig-trunk/ws/trunk/build.xml>:840: The following error occurred while executing this line:
<https://builds.apache.org/job/Pig-trunk/ws/trunk/build.xml>:910: Tests failed!

Total time: 21 minutes 6 seconds
Build step 'Execute shell' marked build as failure
[FINDBUGS] Skipping publisher since build result is FAILURE
Recording test results
Publishing Javadoc
Archiving artifacts
Recording fingerprints

Build failed in Jenkins: Pig-trunk #1364

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Pig-trunk/1364/changes>

Changes:

[cheolsoo] PIG-2924 PigStats should not be assuming all Storage classes to be file-based
storage

[rohini] PIG-3039: Not possible to use custom version of jackson jars (rohini)

------------------------------------------
[...truncated 37770 lines...]
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.FSDataset.shutdown(FSDataset.java:1934)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.shutdown(DataNode.java:788)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdownDataNodes(MiniDFSCluster.java:566)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:550)
    [junit] 	at org.apache.pig.test.MiniGenericCluster.shutdownMiniDfsClusters(MiniGenericCluster.java:87)
    [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:138)
    [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] 12/11/19 22:36:56 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] 12/11/19 22:36:56 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/11/19 22:36:56 INFO ipc.Server: Stopping server on 44409
    [junit] 12/11/19 22:36:56 INFO ipc.Server: Stopping IPC Server listener on 44409
    [junit] 12/11/19 22:36:56 INFO ipc.Server: IPC Server handler 0 on 44409: exiting
    [junit] 12/11/19 22:36:56 INFO ipc.Server: IPC Server handler 1 on 44409: exiting
    [junit] 12/11/19 22:36:56 INFO ipc.Server: IPC Server handler 2 on 44409: exiting
    [junit] 12/11/19 22:36:56 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/19 22:36:56 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/11/19 22:36:56 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1
    [junit] 12/11/19 22:36:56 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:34885, storageID=DS-1254657979-67.195.138.20-34885-1353364138628, infoPort=33039, ipcPort=44409):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:131)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 
    [junit] 12/11/19 22:36:56 INFO datanode.DataNode: Exiting DataXceiveServer
    [junit] 12/11/19 22:36:56 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 12/11/19 22:36:56 INFO mapred.TaskTracker: Received 'KillJobAction' for job: job_20121119222859055_0012
    [junit] 12/11/19 22:36:56 WARN mapred.TaskTracker: Unknown job job_20121119222859055_0012 being deleted.
    [junit] 12/11/19 22:36:56 INFO mapred.TaskTracker: Received 'KillJobAction' for job: job_20121119222859055_0012
    [junit] 12/11/19 22:36:56 WARN mapred.TaskTracker: Unknown job job_20121119222859055_0012 being deleted.
    [junit] 12/11/19 22:36:57 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/19 22:36:57 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:34885, storageID=DS-1254657979-67.195.138.20-34885-1353364138628, infoPort=33039, ipcPort=44409):Finishing DataNode in: FSDataset{dirpath='<https://builds.apache.org/job/Pig-trunk/ws/trunk/build/test/data/dfs/data/data5/current,/home/jenkins/jenkins-slave/workspace/Pig-trunk/trunk/build/test/data/dfs/data/data6/current'}>
    [junit] 12/11/19 22:36:57 INFO ipc.Server: Stopping server on 44409
    [junit] 12/11/19 22:36:57 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/19 22:36:57 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/19 22:36:57 INFO datanode.FSDatasetAsyncDiskService: Shutting down all async disk service threads...
    [junit] 12/11/19 22:36:57 INFO datanode.FSDatasetAsyncDiskService: All async disk service threads have been shut down.
    [junit] 12/11/19 22:36:57 WARN util.MBeans: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId-1686260351
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId-1686260351
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1094)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:415)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:403)
    [junit] 	at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:506)
    [junit] 	at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:71)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.FSDataset.shutdown(FSDataset.java:1934)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.shutdown(DataNode.java:788)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdownDataNodes(MiniDFSCluster.java:566)
    [junit] Shutting down DataNode 1
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:550)
    [junit] 	at org.apache.pig.test.MiniGenericCluster.shutdownMiniDfsClusters(MiniGenericCluster.java:87)
    [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:138)
    [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] 12/11/19 22:36:57 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] 12/11/19 22:36:57 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/11/19 22:36:57 INFO ipc.Server: Stopping server on 55217
    [junit] 12/11/19 22:36:57 INFO ipc.Server: IPC Server handler 0 on 55217: exiting
    [junit] 12/11/19 22:36:57 INFO ipc.Server: IPC Server handler 2 on 55217: exiting
    [junit] 12/11/19 22:36:57 INFO ipc.Server: IPC Server handler 1 on 55217: exiting
    [junit] 12/11/19 22:36:57 INFO ipc.Server: Stopping IPC Server listener on 55217
    [junit] 12/11/19 22:36:57 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/19 22:36:57 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/11/19 22:36:57 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1
    [junit] 12/11/19 22:36:57 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:42115, storageID=DS-162025597-67.195.138.20-42115-1353364138231, infoPort=46987, ipcPort=55217):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:131)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 
    [junit] 12/11/19 22:36:57 INFO datanode.DataNode: Exiting DataXceiveServer
    [junit] 12/11/19 22:36:58 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 12/11/19 22:36:58 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:42115, storageID=DS-162025597-67.195.138.20-42115-1353364138231, infoPort=46987, ipcPort=55217):Finishing DataNode in: FSDataset{dirpath='<https://builds.apache.org/job/Pig-trunk/ws/trunk/build/test/data/dfs/data/data3/current,/home/jenkins/jenkins-slave/workspace/Pig-trunk/trunk/build/test/data/dfs/data/data4/current'}>
    [junit] 12/11/19 22:36:58 INFO ipc.Server: Stopping server on 55217
    [junit] 12/11/19 22:36:58 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/19 22:36:58 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/19 22:36:58 INFO datanode.FSDatasetAsyncDiskService: Shutting down all async disk service threads...
    [junit] 12/11/19 22:36:58 INFO datanode.FSDatasetAsyncDiskService: All async disk service threads have been shut down.
    [junit] 12/11/19 22:36:58 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/19 22:36:58 WARN util.MBeans: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId1842543106
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId1842543106
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1094)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:415)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:403)
    [junit] 	at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:506)
    [junit] 	at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:71)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.FSDataset.shutdown(FSDataset.java:1934)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.shutdown(DataNode.java:788)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdownDataNodes(MiniDFSCluster.java:566)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:550)
    [junit] 	at org.apache.pig.test.MiniGenericCluster.shutdownMiniDfsClusters(MiniGenericCluster.java:87)
    [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:138)
    [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] 12/11/19 22:36:58 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] Shutting down DataNode 0
    [junit] 12/11/19 22:36:58 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/11/19 22:36:58 INFO ipc.Server: Stopping server on 47452
    [junit] 12/11/19 22:36:58 INFO ipc.Server: IPC Server handler 0 on 47452: exiting
    [junit] 12/11/19 22:36:58 INFO ipc.Server: IPC Server handler 1 on 47452: exiting
    [junit] 12/11/19 22:36:58 INFO ipc.Server: IPC Server handler 2 on 47452: exiting
    [junit] 12/11/19 22:36:58 INFO ipc.Server: Stopping IPC Server listener on 47452
    [junit] 12/11/19 22:36:58 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/11/19 22:36:58 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/19 22:36:58 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1
    [junit] 12/11/19 22:36:58 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:46444, storageID=DS-1301767123-67.195.138.20-46444-1353364137821, infoPort=59030, ipcPort=47452):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:131)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 
    [junit] 12/11/19 22:36:58 INFO datanode.DataNode: Exiting DataXceiveServer
    [junit] 12/11/19 22:36:58 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 12/11/19 22:36:59 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:46444 to delete  blk_-1214922990517074588_1133 blk_7950581931997468768_1134 blk_7850093659707907416_1134
    [junit] 12/11/19 22:36:59 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:58458 to delete  blk_7850093659707907416_1134 blk_-8026523732044750076_1127
    [junit] 12/11/19 22:36:59 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/19 22:36:59 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:46444, storageID=DS-1301767123-67.195.138.20-46444-1353364137821, infoPort=59030, ipcPort=47452):Finishing DataNode in: FSDataset{dirpath='<https://builds.apache.org/job/Pig-trunk/ws/trunk/build/test/data/dfs/data/data1/current,/home/jenkins/jenkins-slave/workspace/Pig-trunk/trunk/build/test/data/dfs/data/data2/current'}>
    [junit] 12/11/19 22:36:59 WARN util.MBeans: Hadoop:service=DataNode,name=DataNodeInfo
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=DataNodeInfo
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1094)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:415)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:403)
    [junit] 	at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:506)
    [junit] 	at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:71)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.unRegisterMXBean(DataNode.java:513)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.shutdown(DataNode.java:726)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.run(DataNode.java:1442)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 12/11/19 22:36:59 INFO ipc.Server: Stopping server on 47452
    [junit] 12/11/19 22:36:59 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/19 22:36:59 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/19 22:36:59 INFO datanode.FSDatasetAsyncDiskService: Shutting down all async disk service threads...
    [junit] 12/11/19 22:36:59 INFO datanode.FSDatasetAsyncDiskService: All async disk service threads have been shut down.
    [junit] 12/11/19 22:36:59 WARN util.MBeans: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId206192203
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId206192203
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1094)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:415)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:403)
    [junit] 	at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:506)
    [junit] 	at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:71)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.FSDataset.shutdown(FSDataset.java:1934)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.shutdown(DataNode.java:788)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdownDataNodes(MiniDFSCluster.java:566)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:550)
    [junit] 	at org.apache.pig.test.MiniGenericCluster.shutdownMiniDfsClusters(MiniGenericCluster.java:87)
    [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:138)
    [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] 12/11/19 22:36:59 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] 12/11/19 22:36:59 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/11/19 22:36:59 WARN namenode.FSNamesystem: ReplicationMonitor thread received InterruptedException.java.lang.InterruptedException: sleep interrupted
    [junit] 12/11/19 22:36:59 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] 12/11/19 22:36:59 INFO namenode.FSNamesystem: Number of transactions: 629 Total time for transactions(ms): 10Number of transactions batched in Syncs: 127 Number of syncs: 432 SyncTimes(ms): 5116 251 
    [junit] 12/11/19 22:36:59 INFO ipc.Server: Stopping server on 39828
    [junit] 12/11/19 22:36:59 INFO ipc.Server: IPC Server handler 0 on 39828: exiting
    [junit] 12/11/19 22:36:59 INFO ipc.Server: IPC Server handler 1 on 39828: exiting
    [junit] 12/11/19 22:36:59 INFO ipc.Server: IPC Server handler 2 on 39828: exiting
    [junit] 12/11/19 22:36:59 INFO ipc.Server: IPC Server handler 3 on 39828: exiting
    [junit] 12/11/19 22:36:59 INFO ipc.Server: IPC Server handler 4 on 39828: exiting
    [junit] 12/11/19 22:36:59 INFO ipc.Server: IPC Server handler 5 on 39828: exiting
    [junit] 12/11/19 22:36:59 INFO ipc.Server: IPC Server handler 6 on 39828: exiting
    [junit] 12/11/19 22:36:59 INFO ipc.Server: IPC Server handler 8 on 39828: exiting
    [junit] 12/11/19 22:36:59 INFO ipc.Server: IPC Server handler 9 on 39828: exiting
    [junit] 12/11/19 22:36:59 INFO ipc.Server: Stopping IPC Server listener on 39828
    [junit] 12/11/19 22:36:59 INFO ipc.Server: IPC Server handler 7 on 39828: exiting
    [junit] 12/11/19 22:36:59 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/19 22:36:59 INFO ipc.Server: Stopping IPC Server Responder
    [junit] Tests run: 17, Failures: 4, Errors: 3, Time elapsed: 475.176 sec
    [junit] Test org.apache.pig.test.TestStore FAILED
    [junit] Running org.apache.pig.test.TestStringUDFs
    [junit] 12/11/19 22:37:00 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.NullPointerException
    [junit] 12/11/19 22:37:00 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.StringIndexOutOfBoundsException: String index out of range: -2
    [junit] 12/11/19 22:37:00 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.StringIndexOutOfBoundsException: String index out of range: -1
    [junit] 12/11/19 22:37:00 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.StringIndexOutOfBoundsException: String index out of range: -8
    [junit] 12/11/19 22:37:00 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.StringIndexOutOfBoundsException: String index out of range: -2
    [junit] 12/11/19 22:37:00 WARN builtin.INDEXOF: No logger object provided to UDF: org.apache.pig.builtin.INDEXOF. Failed to process input; error - null
    [junit] 12/11/19 22:37:00 WARN builtin.LAST_INDEX_OF: No logger object provided to UDF: org.apache.pig.builtin.LAST_INDEX_OF. Failed to process input; error - null
    [junit] Tests run: 12, Failures: 0, Errors: 0, Time elapsed: 0.262 sec
   [delete] Deleting directory /tmp/pig_junit_tmp431930095

BUILD FAILED
<https://builds.apache.org/job/Pig-trunk/ws/trunk/build.xml>:840: The following error occurred while executing this line:
<https://builds.apache.org/job/Pig-trunk/ws/trunk/build.xml>:910: Tests failed!

Total time: 21 minutes 14 seconds
Build step 'Execute shell' marked build as failure
[FINDBUGS] Skipping publisher since build result is FAILURE
Recording test results
Publishing Javadoc
Archiving artifacts
Recording fingerprints

Build failed in Jenkins: Pig-trunk #1363

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Pig-trunk/1363/changes>

Changes:

[jcoveney] PIG-2937: generated field in nested foreach does not inherit the variable name as the field name (jcoveney)

------------------------------------------
[...truncated 38539 lines...]
    [junit] 	at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:506)
    [junit] 	at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:71)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.FSDataset.shutdown(FSDataset.java:1934)
    [junit] Shutting down DataNode 2
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.shutdown(DataNode.java:788)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdownDataNodes(MiniDFSCluster.java:566)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:550)
    [junit] 	at org.apache.pig.test.MiniGenericCluster.shutdownMiniDfsClusters(MiniGenericCluster.java:87)
    [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:138)
    [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] 12/11/15 10:38:07 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] 12/11/15 10:38:07 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/11/15 10:38:07 INFO ipc.Server: Stopping server on 39238
    [junit] 12/11/15 10:38:07 INFO ipc.Server: IPC Server handler 1 on 39238: exiting
    [junit] 12/11/15 10:38:07 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/15 10:38:07 INFO ipc.Server: IPC Server handler 0 on 39238: exiting
    [junit] 12/11/15 10:38:07 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:38716, storageID=DS-293407279-67.195.138.20-38716-1352975400193, infoPort=47651, ipcPort=39238):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:131)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 
    [junit] 12/11/15 10:38:07 INFO datanode.DataNode: Exiting DataXceiveServer
    [junit] 12/11/15 10:38:07 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1
    [junit] 12/11/15 10:38:07 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/11/15 10:38:07 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 12/11/15 10:38:07 INFO ipc.Server: Stopping IPC Server listener on 39238
    [junit] 12/11/15 10:38:07 INFO ipc.Server: IPC Server handler 2 on 39238: exiting
    [junit] 12/11/15 10:38:07 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:38716, storageID=DS-293407279-67.195.138.20-38716-1352975400193, infoPort=47651, ipcPort=39238):Finishing DataNode in: FSDataset{dirpath='<https://builds.apache.org/job/Pig-trunk/ws/trunk/build/test/data/dfs/data/data5/current,/home/jenkins/jenkins-slave/workspace/Pig-trunk/trunk/build/test/data/dfs/data/data6/current'}>
    [junit] 12/11/15 10:38:07 INFO ipc.Server: Stopping server on 39238
    [junit] 12/11/15 10:38:07 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/15 10:38:07 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/15 10:38:07 INFO datanode.FSDatasetAsyncDiskService: Shutting down all async disk service threads...
    [junit] 12/11/15 10:38:07 INFO datanode.FSDatasetAsyncDiskService: All async disk service threads have been shut down.
    [junit] 12/11/15 10:38:07 WARN util.MBeans: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId888492849
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId888492849
    [junit] Shutting down DataNode 1
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1094)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:415)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:403)
    [junit] 	at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:506)
    [junit] 	at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:71)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.FSDataset.shutdown(FSDataset.java:1934)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.shutdown(DataNode.java:788)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdownDataNodes(MiniDFSCluster.java:566)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:550)
    [junit] 	at org.apache.pig.test.MiniGenericCluster.shutdownMiniDfsClusters(MiniGenericCluster.java:87)
    [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:138)
    [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] 12/11/15 10:38:07 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] 12/11/15 10:38:07 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/11/15 10:38:07 INFO ipc.Server: Stopping server on 37079
    [junit] 12/11/15 10:38:07 INFO ipc.Server: IPC Server handler 0 on 37079: exiting
    [junit] 12/11/15 10:38:07 INFO ipc.Server: Stopping IPC Server listener on 37079
    [junit] 12/11/15 10:38:07 INFO ipc.Server: IPC Server handler 1 on 37079: exiting
    [junit] 12/11/15 10:38:07 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/15 10:38:07 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/11/15 10:38:07 INFO ipc.Server: IPC Server handler 2 on 37079: exiting
    [junit] 12/11/15 10:38:07 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1
    [junit] 12/11/15 10:38:07 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:41165, storageID=DS-1098574179-67.195.138.20-41165-1352975399804, infoPort=34761, ipcPort=37079):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:131)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 
    [junit] 12/11/15 10:38:07 INFO datanode.DataNode: Exiting DataXceiveServer
    [junit] 12/11/15 10:38:07 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:38716 to delete  blk_-4949540574308287675_1133 blk_6112108863035711969_1134 blk_-6968421144652581032_1134
    [junit] 12/11/15 10:38:07 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:56549 to delete  blk_6112108863035711969_1134 blk_-4348552660822196500_1127 blk_-6968421144652581032_1134
    [junit] 12/11/15 10:38:07 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 12/11/15 10:38:08 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/15 10:38:08 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:41165, storageID=DS-1098574179-67.195.138.20-41165-1352975399804, infoPort=34761, ipcPort=37079):Finishing DataNode in: FSDataset{dirpath='<https://builds.apache.org/job/Pig-trunk/ws/trunk/build/test/data/dfs/data/data3/current,/home/jenkins/jenkins-slave/workspace/Pig-trunk/trunk/build/test/data/dfs/data/data4/current'}>
    [junit] 12/11/15 10:38:08 INFO ipc.Server: Stopping server on 37079
    [junit] 12/11/15 10:38:08 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/15 10:38:08 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/15 10:38:08 INFO datanode.FSDatasetAsyncDiskService: Shutting down all async disk service threads...
    [junit] 12/11/15 10:38:08 INFO datanode.FSDatasetAsyncDiskService: All async disk service threads have been shut down.
    [junit] Shutting down DataNode 0
    [junit] 12/11/15 10:38:08 WARN util.MBeans: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId1282428205
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId1282428205
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1094)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:415)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:403)
    [junit] 	at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:506)
    [junit] 	at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:71)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.FSDataset.shutdown(FSDataset.java:1934)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.shutdown(DataNode.java:788)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdownDataNodes(MiniDFSCluster.java:566)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:550)
    [junit] 	at org.apache.pig.test.MiniGenericCluster.shutdownMiniDfsClusters(MiniGenericCluster.java:87)
    [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:138)
    [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] 12/11/15 10:38:08 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] 12/11/15 10:38:08 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/11/15 10:38:08 INFO ipc.Server: Stopping server on 39930
    [junit] 12/11/15 10:38:08 INFO ipc.Server: IPC Server handler 2 on 39930: exiting
    [junit] 12/11/15 10:38:08 INFO ipc.Server: IPC Server handler 0 on 39930: exiting
    [junit] 12/11/15 10:38:08 INFO ipc.Server: IPC Server handler 1 on 39930: exiting
    [junit] 12/11/15 10:38:08 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/15 10:38:08 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1
    [junit] 12/11/15 10:38:08 INFO ipc.Server: Stopping IPC Server listener on 39930
    [junit] 12/11/15 10:38:08 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:34531, storageID=DS-469887294-67.195.138.20-34531-1352975399352, infoPort=35991, ipcPort=39930):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:131)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 
    [junit] 12/11/15 10:38:08 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/11/15 10:38:08 INFO datanode.DataNode: Exiting DataXceiveServer
    [junit] 12/11/15 10:38:08 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 12/11/15 10:38:08 INFO mapred.TaskTracker: Received 'KillJobAction' for job: job_20121115103000629_0012
    [junit] 12/11/15 10:38:08 WARN mapred.TaskTracker: Unknown job job_20121115103000629_0012 being deleted.
    [junit] 12/11/15 10:38:08 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:34531, storageID=DS-469887294-67.195.138.20-34531-1352975399352, infoPort=35991, ipcPort=39930):Finishing DataNode in: FSDataset{dirpath='<https://builds.apache.org/job/Pig-trunk/ws/trunk/build/test/data/dfs/data/data1/current,/home/jenkins/jenkins-slave/workspace/Pig-trunk/trunk/build/test/data/dfs/data/data2/current'}>
    [junit] 12/11/15 10:38:08 WARN util.MBeans: Hadoop:service=DataNode,name=DataNodeInfo
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=DataNodeInfo
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1094)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:415)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:403)
    [junit] 	at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:506)
    [junit] 	at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:71)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.unRegisterMXBean(DataNode.java:513)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.shutdown(DataNode.java:726)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.run(DataNode.java:1442)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 12/11/15 10:38:08 INFO ipc.Server: Stopping server on 39930
    [junit] 12/11/15 10:38:08 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/15 10:38:08 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/15 10:38:08 INFO datanode.FSDatasetAsyncDiskService: Shutting down all async disk service threads...
    [junit] 12/11/15 10:38:08 INFO datanode.FSDatasetAsyncDiskService: All async disk service threads have been shut down.
    [junit] 12/11/15 10:38:09 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/15 10:38:09 WARN util.MBeans: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId153338488
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId153338488
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1094)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:415)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:403)
    [junit] 	at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:506)
    [junit] 	at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:71)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.FSDataset.shutdown(FSDataset.java:1934)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.shutdown(DataNode.java:788)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdownDataNodes(MiniDFSCluster.java:566)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:550)
    [junit] 	at org.apache.pig.test.MiniGenericCluster.shutdownMiniDfsClusters(MiniGenericCluster.java:87)
    [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:138)
    [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] 12/11/15 10:38:09 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] 12/11/15 10:38:09 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/11/15 10:38:09 WARN namenode.FSNamesystem: ReplicationMonitor thread received InterruptedException.java.lang.InterruptedException: sleep interrupted
    [junit] 12/11/15 10:38:09 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] 12/11/15 10:38:09 INFO namenode.FSNamesystem: Number of transactions: 629 Total time for transactions(ms): 13Number of transactions batched in Syncs: 124 Number of syncs: 432 SyncTimes(ms): 5881 1203 
    [junit] 12/11/15 10:38:09 INFO ipc.Server: Stopping server on 57220
    [junit] 12/11/15 10:38:09 INFO ipc.Server: IPC Server handler 0 on 57220: exiting
    [junit] 12/11/15 10:38:09 INFO ipc.Server: IPC Server handler 3 on 57220: exiting
    [junit] 12/11/15 10:38:09 INFO ipc.Server: IPC Server handler 2 on 57220: exiting
    [junit] 12/11/15 10:38:09 INFO ipc.Server: IPC Server handler 6 on 57220: exiting
    [junit] 12/11/15 10:38:09 INFO ipc.Server: IPC Server handler 1 on 57220: exiting
    [junit] 12/11/15 10:38:09 INFO ipc.Server: IPC Server handler 8 on 57220: exiting
    [junit] 12/11/15 10:38:09 INFO ipc.Server: IPC Server handler 7 on 57220: exiting
    [junit] 12/11/15 10:38:09 INFO ipc.Server: IPC Server handler 5 on 57220: exiting
    [junit] 12/11/15 10:38:09 INFO ipc.Server: IPC Server handler 4 on 57220: exiting
    [junit] 12/11/15 10:38:09 INFO ipc.Server: IPC Server handler 9 on 57220: exiting
    [junit] 12/11/15 10:38:09 INFO ipc.Server: Stopping IPC Server listener on 57220
    [junit] 12/11/15 10:38:09 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/11/15 10:38:09 INFO metrics.RpcInstrumentation: shut down
    [junit] Tests run: 17, Failures: 4, Errors: 3, Time elapsed: 483.289 sec
    [junit] Test org.apache.pig.test.TestStore FAILED
    [junit] Running org.apache.pig.test.TestStringUDFs
    [junit] 12/11/15 10:38:10 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.NullPointerException
    [junit] 12/11/15 10:38:10 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.StringIndexOutOfBoundsException: String index out of range: -2
    [junit] 12/11/15 10:38:10 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.StringIndexOutOfBoundsException: String index out of range: -1
    [junit] 12/11/15 10:38:10 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.StringIndexOutOfBoundsException: String index out of range: -8
    [junit] 12/11/15 10:38:10 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.StringIndexOutOfBoundsException: String index out of range: -2
    [junit] 12/11/15 10:38:10 WARN builtin.INDEXOF: No logger object provided to UDF: org.apache.pig.builtin.INDEXOF. Failed to process input; error - null
    [junit] 12/11/15 10:38:10 WARN builtin.LAST_INDEX_OF: No logger object provided to UDF: org.apache.pig.builtin.LAST_INDEX_OF. Failed to process input; error - null
    [junit] Tests run: 12, Failures: 0, Errors: 0, Time elapsed: 0.268 sec
   [delete] Deleting directory /tmp/pig_junit_tmp1865271917

BUILD FAILED
<https://builds.apache.org/job/Pig-trunk/ws/trunk/build.xml>:834: The following error occurred while executing this line:
<https://builds.apache.org/job/Pig-trunk/ws/trunk/build.xml>:903: Tests failed!

Total time: 21 minutes 7 seconds
Build step 'Execute shell' marked build as failure
[FINDBUGS] Skipping publisher since build result is FAILURE
Recording test results
Publishing Javadoc
Archiving artifacts
Recording fingerprints

Build failed in Jenkins: Pig-trunk #1362

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Pig-trunk/1362/changes>

Changes:

[cheolsoo] PIG-3046: An empty file name in -Dpig.additional.jars throws an error (prkommireddi via cheolsoo)

------------------------------------------
[...truncated 36949 lines...]
    [junit] Shutting down DataNode 2
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdownDataNodes(MiniDFSCluster.java:566)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:550)
    [junit] 	at org.apache.pig.test.MiniGenericCluster.shutdownMiniDfsClusters(MiniGenericCluster.java:87)
    [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:138)
    [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] 12/11/14 22:33:52 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] 12/11/14 22:33:52 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/11/14 22:33:52 INFO ipc.Server: Stopping server on 56987
    [junit] 12/11/14 22:33:52 INFO ipc.Server: IPC Server handler 0 on 56987: exiting
    [junit] 12/11/14 22:33:52 INFO ipc.Server: IPC Server handler 1 on 56987: exiting
    [junit] 12/11/14 22:33:52 INFO ipc.Server: Stopping IPC Server listener on 56987
    [junit] 12/11/14 22:33:52 INFO ipc.Server: IPC Server handler 2 on 56987: exiting
    [junit] 12/11/14 22:33:52 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/11/14 22:33:52 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/14 22:33:52 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1
    [junit] 12/11/14 22:33:52 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:44369, storageID=DS-9386453-67.195.138.20-44369-1352931938529, infoPort=35603, ipcPort=56987):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:131)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 
    [junit] 12/11/14 22:33:52 INFO datanode.DataNode: Exiting DataXceiveServer
    [junit] 12/11/14 22:33:53 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 12/11/14 22:33:53 INFO mapred.TaskTracker: Received 'KillJobAction' for job: job_20121114222538950_0012
    [junit] 12/11/14 22:33:53 WARN mapred.TaskTracker: Unknown job job_20121114222538950_0012 being deleted.
    [junit] 12/11/14 22:33:53 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:44369, storageID=DS-9386453-67.195.138.20-44369-1352931938529, infoPort=35603, ipcPort=56987):Finishing DataNode in: FSDataset{dirpath='<https://builds.apache.org/job/Pig-trunk/ws/trunk/build/test/data/dfs/data/data5/current,/home/jenkins/jenkins-slave/workspace/Pig-trunk/trunk/build/test/data/dfs/data/data6/current'}>
    [junit] 12/11/14 22:33:53 INFO ipc.Server: Stopping server on 56987
    [junit] 12/11/14 22:33:53 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/14 22:33:53 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/14 22:33:53 INFO datanode.FSDatasetAsyncDiskService: Shutting down all async disk service threads...
    [junit] 12/11/14 22:33:53 INFO datanode.FSDatasetAsyncDiskService: All async disk service threads have been shut down.
    [junit] 12/11/14 22:33:53 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/14 22:33:53 WARN util.MBeans: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId-652097587
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId-652097587
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1094)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:415)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:403)
    [junit] 	at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:506)
    [junit] 	at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:71)
    [junit] Shutting down DataNode 1
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.FSDataset.shutdown(FSDataset.java:1934)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.shutdown(DataNode.java:788)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdownDataNodes(MiniDFSCluster.java:566)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:550)
    [junit] 	at org.apache.pig.test.MiniGenericCluster.shutdownMiniDfsClusters(MiniGenericCluster.java:87)
    [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:138)
    [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] 12/11/14 22:33:53 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] 12/11/14 22:33:53 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/11/14 22:33:54 INFO ipc.Server: Stopping server on 41524
    [junit] 12/11/14 22:33:54 INFO ipc.Server: IPC Server handler 0 on 41524: exiting
    [junit] 12/11/14 22:33:54 INFO ipc.Server: IPC Server handler 1 on 41524: exiting
    [junit] 12/11/14 22:33:54 INFO ipc.Server: IPC Server handler 2 on 41524: exiting
    [junit] 12/11/14 22:33:54 INFO ipc.Server: Stopping IPC Server listener on 41524
    [junit] 12/11/14 22:33:54 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/14 22:33:54 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/11/14 22:33:54 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:53020, storageID=DS-1713115221-67.195.138.20-53020-1352931938159, infoPort=39093, ipcPort=41524):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:131)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 
    [junit] 12/11/14 22:33:54 INFO datanode.DataNode: Exiting DataXceiveServer
    [junit] 12/11/14 22:33:54 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1
    [junit] 12/11/14 22:33:54 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 12/11/14 22:33:54 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:53020, storageID=DS-1713115221-67.195.138.20-53020-1352931938159, infoPort=39093, ipcPort=41524):Finishing DataNode in: FSDataset{dirpath='<https://builds.apache.org/job/Pig-trunk/ws/trunk/build/test/data/dfs/data/data3/current,/home/jenkins/jenkins-slave/workspace/Pig-trunk/trunk/build/test/data/dfs/data/data4/current'}>
    [junit] 12/11/14 22:33:54 INFO ipc.Server: Stopping server on 41524
    [junit] 12/11/14 22:33:54 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/14 22:33:54 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/14 22:33:54 INFO datanode.FSDatasetAsyncDiskService: Shutting down all async disk service threads...
    [junit] 12/11/14 22:33:54 INFO datanode.FSDatasetAsyncDiskService: All async disk service threads have been shut down.
    [junit] 12/11/14 22:33:54 WARN util.MBeans: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId1659117775
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId1659117775
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1094)
    [junit] Shutting down DataNode 0
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:415)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:403)
    [junit] 	at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:506)
    [junit] 	at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:71)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.FSDataset.shutdown(FSDataset.java:1934)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.shutdown(DataNode.java:788)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdownDataNodes(MiniDFSCluster.java:566)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:550)
    [junit] 	at org.apache.pig.test.MiniGenericCluster.shutdownMiniDfsClusters(MiniGenericCluster.java:87)
    [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:138)
    [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] 12/11/14 22:33:54 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] 12/11/14 22:33:54 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/11/14 22:33:54 INFO ipc.Server: Stopping server on 40634
    [junit] 12/11/14 22:33:54 INFO ipc.Server: IPC Server handler 0 on 40634: exiting
    [junit] 12/11/14 22:33:54 INFO ipc.Server: IPC Server handler 1 on 40634: exiting
    [junit] 12/11/14 22:33:54 INFO ipc.Server: IPC Server handler 2 on 40634: exiting
    [junit] 12/11/14 22:33:54 INFO ipc.Server: Stopping IPC Server listener on 40634
    [junit] 12/11/14 22:33:54 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/14 22:33:54 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/11/14 22:33:54 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1
    [junit] 12/11/14 22:33:54 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:46338, storageID=DS-499557652-67.195.138.20-46338-1352931937722, infoPort=38639, ipcPort=40634):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:131)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 
    [junit] 12/11/14 22:33:54 INFO datanode.DataNode: Exiting DataXceiveServer
    [junit] 12/11/14 22:33:54 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:44369 to delete  blk_1252047300585338955_1134 blk_143426825991138427_1127 blk_-4494615136581933104_1133
    [junit] 12/11/14 22:33:54 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:35845 to delete  blk_5417500665051084818_1134 blk_1252047300585338955_1134
    [junit] 12/11/14 22:33:54 INFO mapred.TaskTracker: Received 'KillJobAction' for job: job_20121114222538950_0012
    [junit] 12/11/14 22:33:54 WARN mapred.TaskTracker: Unknown job job_20121114222538950_0012 being deleted.
    [junit] 12/11/14 22:33:54 INFO mapred.TaskTracker: Received 'KillJobAction' for job: job_20121114222538950_0012
    [junit] 12/11/14 22:33:54 WARN mapred.TaskTracker: Unknown job job_20121114222538950_0012 being deleted.
    [junit] 12/11/14 22:33:54 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 12/11/14 22:33:55 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/14 22:33:55 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:46338, storageID=DS-499557652-67.195.138.20-46338-1352931937722, infoPort=38639, ipcPort=40634):Finishing DataNode in: FSDataset{dirpath='<https://builds.apache.org/job/Pig-trunk/ws/trunk/build/test/data/dfs/data/data1/current,/home/jenkins/jenkins-slave/workspace/Pig-trunk/trunk/build/test/data/dfs/data/data2/current'}>
    [junit] 12/11/14 22:33:55 WARN util.MBeans: Hadoop:service=DataNode,name=DataNodeInfo
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=DataNodeInfo
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1094)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:415)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:403)
    [junit] 	at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:506)
    [junit] 	at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:71)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.unRegisterMXBean(DataNode.java:513)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.shutdown(DataNode.java:726)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.run(DataNode.java:1442)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 12/11/14 22:33:55 INFO ipc.Server: Stopping server on 40634
    [junit] 12/11/14 22:33:55 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/14 22:33:55 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/14 22:33:55 INFO datanode.FSDatasetAsyncDiskService: Shutting down all async disk service threads...
    [junit] 12/11/14 22:33:55 INFO datanode.FSDatasetAsyncDiskService: All async disk service threads have been shut down.
    [junit] 12/11/14 22:33:55 WARN util.MBeans: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId374852043
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId374852043
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1094)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:415)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:403)
    [junit] 	at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:506)
    [junit] 	at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:71)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.FSDataset.shutdown(FSDataset.java:1934)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.shutdown(DataNode.java:788)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdownDataNodes(MiniDFSCluster.java:566)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:550)
    [junit] 	at org.apache.pig.test.MiniGenericCluster.shutdownMiniDfsClusters(MiniGenericCluster.java:87)
    [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:138)
    [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] 12/11/14 22:33:55 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] 12/11/14 22:33:55 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/11/14 22:33:55 WARN namenode.FSNamesystem: ReplicationMonitor thread received InterruptedException.java.lang.InterruptedException: sleep interrupted
    [junit] 12/11/14 22:33:55 INFO namenode.FSNamesystem: Number of transactions: 629 Total time for transactions(ms): 14Number of transactions batched in Syncs: 128 Number of syncs: 431 SyncTimes(ms): 6226 362 
    [junit] 12/11/14 22:33:55 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] 12/11/14 22:33:55 INFO ipc.Server: Stopping server on 34766
    [junit] 12/11/14 22:33:55 INFO ipc.Server: IPC Server handler 1 on 34766: exiting
    [junit] 12/11/14 22:33:55 INFO ipc.Server: IPC Server handler 2 on 34766: exiting
    [junit] 12/11/14 22:33:55 INFO ipc.Server: IPC Server handler 0 on 34766: exiting
    [junit] 12/11/14 22:33:55 INFO ipc.Server: IPC Server handler 3 on 34766: exiting
    [junit] 12/11/14 22:33:55 INFO ipc.Server: IPC Server handler 5 on 34766: exiting
    [junit] 12/11/14 22:33:55 INFO ipc.Server: IPC Server handler 4 on 34766: exiting
    [junit] 12/11/14 22:33:55 INFO ipc.Server: IPC Server handler 6 on 34766: exiting
    [junit] 12/11/14 22:33:55 INFO ipc.Server: IPC Server handler 7 on 34766: exiting
    [junit] 12/11/14 22:33:55 INFO ipc.Server: IPC Server handler 8 on 34766: exiting
    [junit] 12/11/14 22:33:55 INFO ipc.Server: Stopping IPC Server listener on 34766
    [junit] 12/11/14 22:33:55 INFO ipc.Server: IPC Server handler 9 on 34766: exiting
    [junit] 12/11/14 22:33:55 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/11/14 22:33:55 INFO metrics.RpcInstrumentation: shut down
    [junit] Tests run: 17, Failures: 4, Errors: 3, Time elapsed: 490.743 sec
    [junit] Test org.apache.pig.test.TestStore FAILED
    [junit] Running org.apache.pig.test.TestStringUDFs
    [junit] 12/11/14 22:33:56 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.NullPointerException
    [junit] 12/11/14 22:33:56 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.StringIndexOutOfBoundsException: String index out of range: -2
    [junit] 12/11/14 22:33:56 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.StringIndexOutOfBoundsException: String index out of range: -1
    [junit] 12/11/14 22:33:56 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.StringIndexOutOfBoundsException: String index out of range: -8
    [junit] 12/11/14 22:33:56 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.StringIndexOutOfBoundsException: String index out of range: -2
    [junit] 12/11/14 22:33:56 WARN builtin.INDEXOF: No logger object provided to UDF: org.apache.pig.builtin.INDEXOF. Failed to process input; error - null
    [junit] 12/11/14 22:33:56 WARN builtin.LAST_INDEX_OF: No logger object provided to UDF: org.apache.pig.builtin.LAST_INDEX_OF. Failed to process input; error - null
    [junit] Tests run: 12, Failures: 0, Errors: 0, Time elapsed: 0.287 sec
   [delete] Deleting directory /tmp/pig_junit_tmp904079314

BUILD FAILED
<https://builds.apache.org/job/Pig-trunk/ws/trunk/build.xml>:834: The following error occurred while executing this line:
<https://builds.apache.org/job/Pig-trunk/ws/trunk/build.xml>:903: Tests failed!

Total time: 21 minutes 4 seconds
Build step 'Execute shell' marked build as failure
[FINDBUGS] Skipping publisher since build result is FAILURE
Recording test results
Publishing Javadoc
Archiving artifacts
Recording fingerprints

Build failed in Jenkins: Pig-trunk #1361

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Pig-trunk/1361/changes>

Changes:

[cheolsoo] Fix CHANGES.txt

[cheolsoo] PIG-3045: Specifying sorting field(s) at nightly.conf - fix sortArgs (rohini via cheolsoo)

------------------------------------------
[...truncated 36678 lines...]
    [junit] 	at org.apache.pig.test.MiniGenericCluster.shutDown(MiniGenericCluster.java:68)
    [junit] 	at org.apache.pig.test.TestStore.oneTimeTearDown(TestStore.java:138)
    [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] 12/11/14 10:33:51 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] Shutting down DataNode 2
    [junit] 12/11/14 10:33:51 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/11/14 10:33:51 INFO ipc.Server: Stopping server on 39693
    [junit] 12/11/14 10:33:51 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/14 10:33:51 INFO ipc.Server: IPC Server handler 2 on 39693: exiting
    [junit] 12/11/14 10:33:51 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:54230, storageID=DS-1957408938-67.195.138.20-54230-1352888747149, infoPort=51047, ipcPort=39693):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:131)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 
    [junit] 12/11/14 10:33:51 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/11/14 10:33:51 INFO datanode.DataNode: Exiting DataXceiveServer
    [junit] 12/11/14 10:33:51 INFO ipc.Server: IPC Server handler 0 on 39693: exiting
    [junit] 12/11/14 10:33:51 INFO ipc.Server: Stopping IPC Server listener on 39693
    [junit] 12/11/14 10:33:51 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/14 10:33:51 INFO ipc.Server: IPC Server handler 1 on 39693: exiting
    [junit] 12/11/14 10:33:51 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 12/11/14 10:33:51 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:54230, storageID=DS-1957408938-67.195.138.20-54230-1352888747149, infoPort=51047, ipcPort=39693):Finishing DataNode in: FSDataset{dirpath='<https://builds.apache.org/job/Pig-trunk/ws/trunk/build/test/data/dfs/data/data5/current,/home/jenkins/jenkins-slave/workspace/Pig-trunk/trunk/build/test/data/dfs/data/data6/current'}>
    [junit] 12/11/14 10:33:51 INFO ipc.Server: Stopping server on 39693
    [junit] 12/11/14 10:33:51 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/14 10:33:51 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/14 10:33:51 INFO datanode.FSDatasetAsyncDiskService: Shutting down all async disk service threads...
    [junit] 12/11/14 10:33:51 INFO datanode.FSDatasetAsyncDiskService: All async disk service threads have been shut down.
    [junit] 12/11/14 10:33:51 WARN util.MBeans: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId694094374
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId694094374
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1094)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:415)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:403)
    [junit] 	at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:506)
    [junit] 	at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:71)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.FSDataset.shutdown(FSDataset.java:1934)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.shutdown(DataNode.java:788)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdownDataNodes(MiniDFSCluster.java:566)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:550)
    [junit] 	at org.apache.pig.test.MiniGenericCluster.shutdownMiniDfsClusters(MiniGenericCluster.java:87)
    [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:138)
    [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] 12/11/14 10:33:51 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] Shutting down DataNode 1
    [junit] 12/11/14 10:33:51 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/11/14 10:33:51 INFO ipc.Server: Stopping server on 47871
    [junit] 12/11/14 10:33:51 INFO ipc.Server: IPC Server handler 1 on 47871: exiting
    [junit] 12/11/14 10:33:51 INFO ipc.Server: IPC Server handler 0 on 47871: exiting
    [junit] 12/11/14 10:33:51 INFO ipc.Server: Stopping IPC Server listener on 47871
    [junit] 12/11/14 10:33:51 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/11/14 10:33:51 INFO ipc.Server: IPC Server handler 2 on 47871: exiting
    [junit] 12/11/14 10:33:51 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/14 10:33:51 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1
    [junit] 12/11/14 10:33:51 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:40469, storageID=DS-2119293833-67.195.138.20-40469-1352888746763, infoPort=37718, ipcPort=47871):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:131)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 
    [junit] 12/11/14 10:33:51 INFO datanode.DataNode: Exiting DataXceiveServer
    [junit] 12/11/14 10:33:52 INFO mapred.TaskTracker: Received 'KillJobAction' for job: job_20121114102547574_0012
    [junit] 12/11/14 10:33:52 WARN mapred.TaskTracker: Unknown job job_20121114102547574_0012 being deleted.
    [junit] 12/11/14 10:33:52 INFO datanode.DataNode: Scheduling block blk_-6699980210847875983_1134 file build/test/data/dfs/data/data1/current/blk_-6699980210847875983 for deletion
    [junit] 12/11/14 10:33:52 INFO datanode.DataNode: Scheduling block blk_-615863538691170533_1133 file build/test/data/dfs/data/data2/current/blk_-615863538691170533 for deletion
    [junit] 12/11/14 10:33:52 INFO datanode.DataNode: Deleted block blk_-6699980210847875983_1134 at file build/test/data/dfs/data/data1/current/blk_-6699980210847875983
    [junit] 12/11/14 10:33:52 INFO datanode.DataNode: Scheduling block blk_6272572432362006506_1127 file build/test/data/dfs/data/data2/current/blk_6272572432362006506 for deletion
    [junit] 12/11/14 10:33:52 INFO datanode.DataNode: Deleted block blk_-615863538691170533_1133 at file build/test/data/dfs/data/data2/current/blk_-615863538691170533
    [junit] 12/11/14 10:33:52 INFO datanode.DataNode: Deleted block blk_6272572432362006506_1127 at file build/test/data/dfs/data/data2/current/blk_6272572432362006506
    [junit] 12/11/14 10:33:52 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 12/11/14 10:33:52 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:40469, storageID=DS-2119293833-67.195.138.20-40469-1352888746763, infoPort=37718, ipcPort=47871):Finishing DataNode in: FSDataset{dirpath='<https://builds.apache.org/job/Pig-trunk/ws/trunk/build/test/data/dfs/data/data3/current,/home/jenkins/jenkins-slave/workspace/Pig-trunk/trunk/build/test/data/dfs/data/data4/current'}>
    [junit] 12/11/14 10:33:52 INFO ipc.Server: Stopping server on 47871
    [junit] 12/11/14 10:33:52 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/14 10:33:52 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/14 10:33:52 INFO datanode.FSDatasetAsyncDiskService: Shutting down all async disk service threads...
    [junit] 12/11/14 10:33:52 INFO datanode.FSDatasetAsyncDiskService: All async disk service threads have been shut down.
    [junit] 12/11/14 10:33:52 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/14 10:33:52 WARN util.MBeans: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId1554086531
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId1554086531
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1094)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:415)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:403)
    [junit] 	at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:506)
    [junit] 	at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:71)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.FSDataset.shutdown(FSDataset.java:1934)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.shutdown(DataNode.java:788)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdownDataNodes(MiniDFSCluster.java:566)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:550)
    [junit] 	at org.apache.pig.test.MiniGenericCluster.shutdownMiniDfsClusters(MiniGenericCluster.java:87)
    [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:138)
    [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] 12/11/14 10:33:52 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] Shutting down DataNode 0
    [junit] 12/11/14 10:33:52 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/11/14 10:33:53 INFO ipc.Server: Stopping server on 57528
    [junit] 12/11/14 10:33:53 INFO ipc.Server: IPC Server handler 0 on 57528: exiting
    [junit] 12/11/14 10:33:53 INFO ipc.Server: IPC Server handler 1 on 57528: exiting
    [junit] 12/11/14 10:33:53 INFO ipc.Server: IPC Server handler 2 on 57528: exiting
    [junit] 12/11/14 10:33:53 INFO ipc.Server: Stopping IPC Server listener on 57528
    [junit] 12/11/14 10:33:53 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/14 10:33:53 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1
    [junit] 12/11/14 10:33:53 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/11/14 10:33:53 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:60094, storageID=DS-859484286-67.195.138.20-60094-1352888746349, infoPort=56404, ipcPort=57528):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:131)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 
    [junit] 12/11/14 10:33:53 INFO datanode.DataNode: Exiting DataXceiveServer
    [junit] 12/11/14 10:33:53 INFO mapred.TaskTracker: Received 'KillJobAction' for job: job_20121114102547574_0012
    [junit] 12/11/14 10:33:53 WARN mapred.TaskTracker: Unknown job job_20121114102547574_0012 being deleted.
    [junit] 12/11/14 10:33:53 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 12/11/14 10:33:53 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:54230 to delete  blk_6272572432362006506_1127 blk_-1325060880169273368_1134 blk_-615863538691170533_1133
    [junit] 12/11/14 10:33:53 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:40469 to delete  blk_-1325060880169273368_1134 blk_-615863538691170533_1133 blk_-6699980210847875983_1134
    [junit] 12/11/14 10:33:54 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/14 10:33:54 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:60094, storageID=DS-859484286-67.195.138.20-60094-1352888746349, infoPort=56404, ipcPort=57528):Finishing DataNode in: FSDataset{dirpath='<https://builds.apache.org/job/Pig-trunk/ws/trunk/build/test/data/dfs/data/data1/current,/home/jenkins/jenkins-slave/workspace/Pig-trunk/trunk/build/test/data/dfs/data/data2/current'}>
    [junit] 12/11/14 10:33:54 WARN util.MBeans: Hadoop:service=DataNode,name=DataNodeInfo
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=DataNodeInfo
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1094)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:415)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:403)
    [junit] 	at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:506)
    [junit] 	at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:71)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.unRegisterMXBean(DataNode.java:513)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.shutdown(DataNode.java:726)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.run(DataNode.java:1442)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 12/11/14 10:33:54 INFO ipc.Server: Stopping server on 57528
    [junit] 12/11/14 10:33:54 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/14 10:33:54 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/14 10:33:54 INFO datanode.FSDatasetAsyncDiskService: Shutting down all async disk service threads...
    [junit] 12/11/14 10:33:54 INFO datanode.FSDatasetAsyncDiskService: All async disk service threads have been shut down.
    [junit] 12/11/14 10:33:54 WARN util.MBeans: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId1833764975
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId1833764975
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1094)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:415)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:403)
    [junit] 	at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:506)
    [junit] 	at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:71)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.FSDataset.shutdown(FSDataset.java:1934)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.shutdown(DataNode.java:788)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdownDataNodes(MiniDFSCluster.java:566)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:550)
    [junit] 	at org.apache.pig.test.MiniGenericCluster.shutdownMiniDfsClusters(MiniGenericCluster.java:87)
    [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:138)
    [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] 12/11/14 10:33:54 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] 12/11/14 10:33:54 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/11/14 10:33:54 WARN namenode.FSNamesystem: ReplicationMonitor thread received InterruptedException.java.lang.InterruptedException: sleep interrupted
    [junit] 12/11/14 10:33:54 INFO namenode.FSNamesystem: Number of transactions: 629 Total time for transactions(ms): 9Number of transactions batched in Syncs: 126 Number of syncs: 432 SyncTimes(ms): 6124 365 
    [junit] 12/11/14 10:33:54 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] 12/11/14 10:33:54 INFO ipc.Server: Stopping server on 57087
    [junit] 12/11/14 10:33:54 INFO ipc.Server: IPC Server handler 0 on 57087: exiting
    [junit] 12/11/14 10:33:54 INFO ipc.Server: IPC Server handler 1 on 57087: exiting
    [junit] 12/11/14 10:33:54 INFO ipc.Server: IPC Server handler 2 on 57087: exiting
    [junit] 12/11/14 10:33:54 INFO ipc.Server: IPC Server handler 5 on 57087: exiting
    [junit] 12/11/14 10:33:54 INFO ipc.Server: IPC Server handler 6 on 57087: exiting
    [junit] 12/11/14 10:33:54 INFO ipc.Server: IPC Server handler 7 on 57087: exiting
    [junit] 12/11/14 10:33:54 INFO ipc.Server: IPC Server handler 3 on 57087: exiting
    [junit] 12/11/14 10:33:54 INFO ipc.Server: IPC Server handler 8 on 57087: exiting
    [junit] 12/11/14 10:33:54 INFO ipc.Server: IPC Server handler 4 on 57087: exiting
    [junit] 12/11/14 10:33:54 INFO ipc.Server: IPC Server handler 9 on 57087: exiting
    [junit] 12/11/14 10:33:54 INFO ipc.Server: Stopping IPC Server listener on 57087
    [junit] 12/11/14 10:33:54 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/14 10:33:54 INFO ipc.Server: Stopping IPC Server Responder
    [junit] Tests run: 17, Failures: 4, Errors: 3, Time elapsed: 481.13 sec
    [junit] Test org.apache.pig.test.TestStore FAILED
    [junit] Running org.apache.pig.test.TestStringUDFs
    [junit] 12/11/14 10:33:55 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.NullPointerException
    [junit] 12/11/14 10:33:55 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.StringIndexOutOfBoundsException: String index out of range: -2
    [junit] 12/11/14 10:33:55 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.StringIndexOutOfBoundsException: String index out of range: -1
    [junit] 12/11/14 10:33:55 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.StringIndexOutOfBoundsException: String index out of range: -8
    [junit] 12/11/14 10:33:55 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.StringIndexOutOfBoundsException: String index out of range: -2
    [junit] 12/11/14 10:33:55 WARN builtin.INDEXOF: No logger object provided to UDF: org.apache.pig.builtin.INDEXOF. Failed to process input; error - null
    [junit] 12/11/14 10:33:55 WARN builtin.LAST_INDEX_OF: No logger object provided to UDF: org.apache.pig.builtin.LAST_INDEX_OF. Failed to process input; error - null
    [junit] Tests run: 12, Failures: 0, Errors: 0, Time elapsed: 0.23 sec
   [delete] Deleting directory /tmp/pig_junit_tmp1448976928

BUILD FAILED
<https://builds.apache.org/job/Pig-trunk/ws/trunk/build.xml>:834: The following error occurred while executing this line:
<https://builds.apache.org/job/Pig-trunk/ws/trunk/build.xml>:903: Tests failed!

Total time: 20 minutes 52 seconds
Build step 'Execute shell' marked build as failure
[FINDBUGS] Skipping publisher since build result is FAILURE
Recording test results
Publishing Javadoc
Archiving artifacts
Recording fingerprints

Build failed in Jenkins: Pig-trunk #1360

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Pig-trunk/1360/changes>

Changes:

[gates] PIG-2989 Illustrate for Rank Operator

------------------------------------------
[...truncated 36090 lines...]
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdownDataNodes(MiniDFSCluster.java:566)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:550)
    [junit] 	at org.apache.pig.test.MiniGenericCluster.shutdownMiniDfsClusters(MiniGenericCluster.java:87)
    [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:138)
    [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] 12/11/13 22:42:37 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] Shutting down DataNode 2
    [junit] 12/11/13 22:42:37 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/11/13 22:42:37 INFO ipc.Server: Stopping server on 43187
    [junit] 12/11/13 22:42:37 INFO ipc.Server: IPC Server handler 0 on 43187: exiting
    [junit] 12/11/13 22:42:37 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/11/13 22:42:37 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/13 22:42:37 INFO ipc.Server: IPC Server handler 1 on 43187: exiting
    [junit] 12/11/13 22:42:37 INFO ipc.Server: IPC Server handler 2 on 43187: exiting
    [junit] 12/11/13 22:42:37 INFO ipc.Server: Stopping IPC Server listener on 43187
    [junit] 12/11/13 22:42:37 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1
    [junit] 12/11/13 22:42:37 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:51594, storageID=DS-767485225-67.195.138.20-51594-1352846086123, infoPort=58806, ipcPort=43187):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:131)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 
    [junit] 12/11/13 22:42:37 INFO datanode.DataNode: Exiting DataXceiveServer
    [junit] 12/11/13 22:42:37 INFO mapred.TaskTracker: Received 'KillJobAction' for job: job_20121113223446541_0012
    [junit] 12/11/13 22:42:37 WARN mapred.TaskTracker: Unknown job job_20121113223446541_0012 being deleted.
    [junit] 12/11/13 22:42:38 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 12/11/13 22:42:38 INFO mapred.TaskTracker: Received 'KillJobAction' for job: job_20121113223446541_0012
    [junit] 12/11/13 22:42:38 WARN mapred.TaskTracker: Unknown job job_20121113223446541_0012 being deleted.
    [junit] 12/11/13 22:42:38 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/13 22:42:38 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:51594, storageID=DS-767485225-67.195.138.20-51594-1352846086123, infoPort=58806, ipcPort=43187):Finishing DataNode in: FSDataset{dirpath='<https://builds.apache.org/job/Pig-trunk/ws/trunk/build/test/data/dfs/data/data5/current,/home/jenkins/jenkins-slave/workspace/Pig-trunk/trunk/build/test/data/dfs/data/data6/current'}>
    [junit] 12/11/13 22:42:38 INFO ipc.Server: Stopping server on 43187
    [junit] 12/11/13 22:42:38 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/13 22:42:38 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/13 22:42:38 INFO datanode.FSDatasetAsyncDiskService: Shutting down all async disk service threads...
    [junit] 12/11/13 22:42:38 INFO datanode.FSDatasetAsyncDiskService: All async disk service threads have been shut down.
    [junit] 12/11/13 22:42:38 WARN util.MBeans: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId2145991262
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId2145991262
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1094)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:415)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:403)
    [junit] 	at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:506)
    [junit] 	at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:71)
    [junit] Shutting down DataNode 1
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.FSDataset.shutdown(FSDataset.java:1934)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.shutdown(DataNode.java:788)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdownDataNodes(MiniDFSCluster.java:566)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:550)
    [junit] 	at org.apache.pig.test.MiniGenericCluster.shutdownMiniDfsClusters(MiniGenericCluster.java:87)
    [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:138)
    [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] 12/11/13 22:42:38 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] 12/11/13 22:42:38 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/11/13 22:42:38 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:60339 to delete  blk_-7852141547610254759_1133
    [junit] 12/11/13 22:42:38 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:60511 to delete  blk_-8262671410139826719_1134 blk_-7852141547610254759_1133 blk_826549080687767336_1127 blk_-1129268888787735057_1134
    [junit] 12/11/13 22:42:39 INFO ipc.Server: Stopping server on 39149
    [junit] 12/11/13 22:42:39 INFO ipc.Server: IPC Server handler 1 on 39149: exiting
    [junit] 12/11/13 22:42:39 INFO ipc.Server: IPC Server handler 2 on 39149: exiting
    [junit] 12/11/13 22:42:39 INFO ipc.Server: IPC Server handler 0 on 39149: exiting
    [junit] 12/11/13 22:42:39 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/11/13 22:42:39 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/13 22:42:39 INFO ipc.Server: Stopping IPC Server listener on 39149
    [junit] 12/11/13 22:42:39 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1
    [junit] 12/11/13 22:42:39 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:60511, storageID=DS-1586564595-67.195.138.20-60511-1352846085741, infoPort=46954, ipcPort=39149):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:131)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 
    [junit] 12/11/13 22:42:39 INFO datanode.DataNode: Exiting DataXceiveServer
    [junit] 12/11/13 22:42:39 INFO datanode.DataNode: Scheduling block blk_-7852141547610254759_1133 file build/test/data/dfs/data/data2/current/blk_-7852141547610254759 for deletion
    [junit] 12/11/13 22:42:39 INFO datanode.DataNode: Deleted block blk_-7852141547610254759_1133 at file build/test/data/dfs/data/data2/current/blk_-7852141547610254759
    [junit] 12/11/13 22:42:39 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 12/11/13 22:42:39 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:60511, storageID=DS-1586564595-67.195.138.20-60511-1352846085741, infoPort=46954, ipcPort=39149):Finishing DataNode in: FSDataset{dirpath='<https://builds.apache.org/job/Pig-trunk/ws/trunk/build/test/data/dfs/data/data3/current,/home/jenkins/jenkins-slave/workspace/Pig-trunk/trunk/build/test/data/dfs/data/data4/current'}>
    [junit] 12/11/13 22:42:39 INFO ipc.Server: Stopping server on 39149
    [junit] 12/11/13 22:42:39 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/13 22:42:39 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/13 22:42:39 INFO datanode.FSDatasetAsyncDiskService: Shutting down all async disk service threads...
    [junit] 12/11/13 22:42:39 INFO datanode.FSDatasetAsyncDiskService: All async disk service threads have been shut down.
    [junit] 12/11/13 22:42:40 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/13 22:42:40 WARN util.MBeans: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId-882721708
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId-882721708
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1094)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:415)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:403)
    [junit] 	at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:506)
    [junit] 	at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:71)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.FSDataset.shutdown(FSDataset.java:1934)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.shutdown(DataNode.java:788)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdownDataNodes(MiniDFSCluster.java:566)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:550)
    [junit] 	at org.apache.pig.test.MiniGenericCluster.shutdownMiniDfsClusters(MiniGenericCluster.java:87)
    [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:138)
    [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] 12/11/13 22:42:40 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] Shutting down DataNode 0
    [junit] 12/11/13 22:42:40 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/11/13 22:42:40 INFO ipc.Server: Stopping server on 42716
    [junit] 12/11/13 22:42:40 INFO ipc.Server: IPC Server handler 0 on 42716: exiting
    [junit] 12/11/13 22:42:40 INFO ipc.Server: IPC Server handler 2 on 42716: exiting
    [junit] 12/11/13 22:42:40 INFO ipc.Server: IPC Server handler 1 on 42716: exiting
    [junit] 12/11/13 22:42:40 INFO ipc.Server: Stopping IPC Server listener on 42716
    [junit] 12/11/13 22:42:40 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/13 22:42:40 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/11/13 22:42:40 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:60339, storageID=DS-2077952067-67.195.138.20-60339-1352846085338, infoPort=33879, ipcPort=42716):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:131)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 
    [junit] 12/11/13 22:42:40 INFO datanode.DataNode: Exiting DataXceiveServer
    [junit] 12/11/13 22:42:40 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/13 22:42:40 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 12/11/13 22:42:40 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:60339, storageID=DS-2077952067-67.195.138.20-60339-1352846085338, infoPort=33879, ipcPort=42716):Finishing DataNode in: FSDataset{dirpath='<https://builds.apache.org/job/Pig-trunk/ws/trunk/build/test/data/dfs/data/data1/current,/home/jenkins/jenkins-slave/workspace/Pig-trunk/trunk/build/test/data/dfs/data/data2/current'}>
    [junit] 12/11/13 22:42:40 WARN util.MBeans: Hadoop:service=DataNode,name=DataNodeInfo
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=DataNodeInfo
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1094)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:415)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:403)
    [junit] 	at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:506)
    [junit] 	at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:71)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.unRegisterMXBean(DataNode.java:513)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.shutdown(DataNode.java:726)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.run(DataNode.java:1442)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 12/11/13 22:42:40 INFO ipc.Server: Stopping server on 42716
    [junit] 12/11/13 22:42:40 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/13 22:42:40 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/13 22:42:40 INFO datanode.FSDatasetAsyncDiskService: Shutting down all async disk service threads...
    [junit] 12/11/13 22:42:40 INFO datanode.FSDatasetAsyncDiskService: All async disk service threads have been shut down.
    [junit] 12/11/13 22:42:40 WARN util.MBeans: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId1408349231
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId1408349231
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1094)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:415)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:403)
    [junit] 	at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:506)
    [junit] 	at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:71)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.FSDataset.shutdown(FSDataset.java:1934)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.shutdown(DataNode.java:788)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdownDataNodes(MiniDFSCluster.java:566)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:550)
    [junit] 	at org.apache.pig.test.MiniGenericCluster.shutdownMiniDfsClusters(MiniGenericCluster.java:87)
    [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:138)
    [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] 12/11/13 22:42:40 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] 12/11/13 22:42:40 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/11/13 22:42:40 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] 12/11/13 22:42:40 WARN namenode.FSNamesystem: ReplicationMonitor thread received InterruptedException.java.lang.InterruptedException: sleep interrupted
    [junit] 12/11/13 22:42:40 INFO namenode.FSNamesystem: Number of transactions: 629 Total time for transactions(ms): 7Number of transactions batched in Syncs: 120 Number of syncs: 432 SyncTimes(ms): 5888 320 
    [junit] 12/11/13 22:42:40 INFO ipc.Server: Stopping server on 43430
    [junit] 12/11/13 22:42:40 INFO ipc.Server: IPC Server handler 0 on 43430: exiting
    [junit] 12/11/13 22:42:40 INFO ipc.Server: IPC Server handler 2 on 43430: exiting
    [junit] 12/11/13 22:42:40 INFO ipc.Server: IPC Server handler 3 on 43430: exiting
    [junit] 12/11/13 22:42:40 INFO ipc.Server: IPC Server handler 1 on 43430: exiting
    [junit] 12/11/13 22:42:40 INFO ipc.Server: IPC Server handler 4 on 43430: exiting
    [junit] 12/11/13 22:42:40 INFO ipc.Server: IPC Server handler 5 on 43430: exiting
    [junit] 12/11/13 22:42:40 INFO ipc.Server: IPC Server handler 6 on 43430: exiting
    [junit] 12/11/13 22:42:40 INFO ipc.Server: IPC Server handler 8 on 43430: exiting
    [junit] 12/11/13 22:42:40 INFO ipc.Server: IPC Server handler 7 on 43430: exiting
    [junit] 12/11/13 22:42:40 INFO ipc.Server: IPC Server handler 9 on 43430: exiting
    [junit] 12/11/13 22:42:40 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/13 22:42:40 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/11/13 22:42:40 INFO ipc.Server: Stopping IPC Server listener on 43430
    [junit] Tests run: 17, Failures: 4, Errors: 3, Time elapsed: 468.343 sec
    [junit] Test org.apache.pig.test.TestStore FAILED
    [junit] Running org.apache.pig.test.TestStringUDFs
    [junit] 12/11/13 22:42:41 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.NullPointerException
    [junit] 12/11/13 22:42:41 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.StringIndexOutOfBoundsException: String index out of range: -2
    [junit] 12/11/13 22:42:41 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.StringIndexOutOfBoundsException: String index out of range: -1
    [junit] 12/11/13 22:42:41 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.StringIndexOutOfBoundsException: String index out of range: -8
    [junit] 12/11/13 22:42:41 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.StringIndexOutOfBoundsException: String index out of range: -2
    [junit] 12/11/13 22:42:41 WARN builtin.INDEXOF: No logger object provided to UDF: org.apache.pig.builtin.INDEXOF. Failed to process input; error - null
    [junit] 12/11/13 22:42:41 WARN builtin.LAST_INDEX_OF: No logger object provided to UDF: org.apache.pig.builtin.LAST_INDEX_OF. Failed to process input; error - null
    [junit] Tests run: 12, Failures: 0, Errors: 0, Time elapsed: 0.281 sec
   [delete] Deleting directory /tmp/pig_junit_tmp1178531699

BUILD FAILED
<https://builds.apache.org/job/Pig-trunk/ws/trunk/build.xml>:834: The following error occurred while executing this line:
<https://builds.apache.org/job/Pig-trunk/ws/trunk/build.xml>:903: Tests failed!

Total time: 20 minutes 31 seconds
Build step 'Execute shell' marked build as failure
[FINDBUGS] Skipping publisher since build result is FAILURE
Recording test results
Publishing Javadoc
Archiving artifacts
Recording fingerprints

Build failed in Jenkins: Pig-trunk #1359

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Pig-trunk/1359/changes>

Changes:

[cheolsoo] PIG-3034: Remove Penny code from Pig repository (gates via cheolsoo)

------------------------------------------
[...truncated 38612 lines...]
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId1144360968
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1094)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:415)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:403)
    [junit] 	at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:506)
    [junit] 	at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:71)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.FSDataset.shutdown(FSDataset.java:1934)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.shutdown(DataNode.java:788)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdownDataNodes(MiniDFSCluster.java:566)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:550)
    [junit] 	at org.apache.pig.test.MiniGenericCluster.shutdownMiniDfsClusters(MiniGenericCluster.java:87)
    [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:138)
    [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] 12/11/11 10:34:11 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] 12/11/11 10:34:11 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/11/11 10:34:11 INFO ipc.Server: Stopping server on 51135
    [junit] 12/11/11 10:34:11 INFO ipc.Server: IPC Server handler 1 on 51135: exiting
    [junit] 12/11/11 10:34:11 INFO ipc.Server: IPC Server handler 0 on 51135: exiting
    [junit] 12/11/11 10:34:11 INFO ipc.Server: Stopping IPC Server listener on 51135
    [junit] 12/11/11 10:34:11 INFO ipc.Server: IPC Server handler 2 on 51135: exiting
    [junit] 12/11/11 10:34:11 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/11/11 10:34:11 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/11 10:34:11 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:40056, storageID=DS-35306375-67.195.138.20-40056-1352629567057, infoPort=43821, ipcPort=51135):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:131)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 
    [junit] 12/11/11 10:34:11 INFO datanode.DataNode: Exiting DataXceiveServer
    [junit] 12/11/11 10:34:11 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/11 10:34:11 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 12/11/11 10:34:11 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:40056, storageID=DS-35306375-67.195.138.20-40056-1352629567057, infoPort=43821, ipcPort=51135):Finishing DataNode in: FSDataset{dirpath='<https://builds.apache.org/job/Pig-trunk/ws/trunk/build/test/data/dfs/data/data5/current,/home/jenkins/jenkins-slave/workspace/Pig-trunk/trunk/build/test/data/dfs/data/data6/current'}>
    [junit] 12/11/11 10:34:11 INFO ipc.Server: Stopping server on 51135
    [junit] 12/11/11 10:34:11 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/11 10:34:11 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/11 10:34:11 INFO datanode.FSDatasetAsyncDiskService: Shutting down all async disk service threads...
    [junit] 12/11/11 10:34:11 INFO datanode.FSDatasetAsyncDiskService: All async disk service threads have been shut down.
    [junit] 12/11/11 10:34:11 WARN util.MBeans: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId1751093859
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId1751093859
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1094)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:415)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:403)
    [junit] 	at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:506)
    [junit] 	at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:71)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.FSDataset.shutdown(FSDataset.java:1934)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.shutdown(DataNode.java:788)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdownDataNodes(MiniDFSCluster.java:566)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:550)
    [junit] 	at org.apache.pig.test.MiniGenericCluster.shutdownMiniDfsClusters(MiniGenericCluster.java:87)
    [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:138)
    [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] 12/11/11 10:34:11 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] Shutting down DataNode 1
    [junit] 12/11/11 10:34:11 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/11/11 10:34:11 INFO ipc.Server: Stopping server on 56904
    [junit] 12/11/11 10:34:11 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/11 10:34:11 INFO ipc.Server: IPC Server handler 0 on 56904: exiting
    [junit] 12/11/11 10:34:11 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:50658, storageID=DS-819687027-67.195.138.20-50658-1352629566672, infoPort=44182, ipcPort=56904):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:131)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 
    [junit] 12/11/11 10:34:11 INFO ipc.Server: Stopping IPC Server listener on 56904
    [junit] 12/11/11 10:34:11 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/11/11 10:34:11 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1
    [junit] 12/11/11 10:34:11 INFO ipc.Server: IPC Server handler 1 on 56904: exiting
    [junit] 12/11/11 10:34:11 INFO ipc.Server: IPC Server handler 2 on 56904: exiting
    [junit] 12/11/11 10:34:11 INFO datanode.DataNode: Exiting DataXceiveServer
    [junit] 12/11/11 10:34:12 INFO mapred.TaskTracker: Received 'KillJobAction' for job: job_20121111102607483_0012
    [junit] 12/11/11 10:34:12 WARN mapred.TaskTracker: Unknown job job_20121111102607483_0012 being deleted.
    [junit] 12/11/11 10:34:12 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 12/11/11 10:34:12 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:50658, storageID=DS-819687027-67.195.138.20-50658-1352629566672, infoPort=44182, ipcPort=56904):Finishing DataNode in: FSDataset{dirpath='<https://builds.apache.org/job/Pig-trunk/ws/trunk/build/test/data/dfs/data/data3/current,/home/jenkins/jenkins-slave/workspace/Pig-trunk/trunk/build/test/data/dfs/data/data4/current'}>
    [junit] 12/11/11 10:34:12 INFO ipc.Server: Stopping server on 56904
    [junit] 12/11/11 10:34:12 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/11 10:34:12 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/11 10:34:12 INFO datanode.FSDatasetAsyncDiskService: Shutting down all async disk service threads...
    [junit] 12/11/11 10:34:12 INFO datanode.FSDatasetAsyncDiskService: All async disk service threads have been shut down.
    [junit] 12/11/11 10:34:12 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/11 10:34:12 WARN util.MBeans: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId1608810187
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId1608810187
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1094)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:415)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:403)
    [junit] 	at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:506)
    [junit] 	at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:71)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.FSDataset.shutdown(FSDataset.java:1934)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.shutdown(DataNode.java:788)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdownDataNodes(MiniDFSCluster.java:566)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:550)
    [junit] 	at org.apache.pig.test.MiniGenericCluster.shutdownMiniDfsClusters(MiniGenericCluster.java:87)
    [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:138)
    [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] 12/11/11 10:34:12 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] Shutting down DataNode 0
    [junit] 12/11/11 10:34:12 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/11/11 10:34:13 INFO ipc.Server: Stopping server on 54329
    [junit] 12/11/11 10:34:13 INFO ipc.Server: IPC Server handler 2 on 54329: exiting
    [junit] 12/11/11 10:34:13 INFO ipc.Server: IPC Server handler 1 on 54329: exiting
    [junit] 12/11/11 10:34:13 INFO ipc.Server: IPC Server handler 0 on 54329: exiting
    [junit] 12/11/11 10:34:13 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/11 10:34:13 INFO ipc.Server: Stopping IPC Server listener on 54329
    [junit] 12/11/11 10:34:13 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/11/11 10:34:13 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:59792, storageID=DS-1958019819-67.195.138.20-59792-1352629566253, infoPort=58754, ipcPort=54329):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:131)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 
    [junit] 12/11/11 10:34:13 INFO datanode.DataNode: Exiting DataXceiveServer
    [junit] 12/11/11 10:34:13 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/11 10:34:13 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 12/11/11 10:34:13 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:59792, storageID=DS-1958019819-67.195.138.20-59792-1352629566253, infoPort=58754, ipcPort=54329):Finishing DataNode in: FSDataset{dirpath='<https://builds.apache.org/job/Pig-trunk/ws/trunk/build/test/data/dfs/data/data1/current,/home/jenkins/jenkins-slave/workspace/Pig-trunk/trunk/build/test/data/dfs/data/data2/current'}>
    [junit] 12/11/11 10:34:13 WARN util.MBeans: Hadoop:service=DataNode,name=DataNodeInfo
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=DataNodeInfo
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1094)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:415)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:403)
    [junit] 	at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:506)
    [junit] 	at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:71)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.unRegisterMXBean(DataNode.java:513)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.shutdown(DataNode.java:726)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.run(DataNode.java:1442)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 12/11/11 10:34:13 INFO ipc.Server: Stopping server on 54329
    [junit] 12/11/11 10:34:13 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/11 10:34:13 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/11/11 10:34:13 INFO datanode.FSDatasetAsyncDiskService: Shutting down all async disk service threads...
    [junit] 12/11/11 10:34:13 INFO datanode.FSDatasetAsyncDiskService: All async disk service threads have been shut down.
    [junit] 12/11/11 10:34:13 WARN util.MBeans: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId318093353
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId318093353
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1094)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:415)
    [junit] 	at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:403)
    [junit] 	at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:506)
    [junit] 	at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:71)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.FSDataset.shutdown(FSDataset.java:1934)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataNode.shutdown(DataNode.java:788)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdownDataNodes(MiniDFSCluster.java:566)
    [junit] 	at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:550)
    [junit] 	at org.apache.pig.test.MiniGenericCluster.shutdownMiniDfsClusters(MiniGenericCluster.java:87)
    [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:138)
    [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] 12/11/11 10:34:13 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] 12/11/11 10:34:13 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/11/11 10:34:13 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] 12/11/11 10:34:13 WARN namenode.FSNamesystem: ReplicationMonitor thread received InterruptedException.java.lang.InterruptedException: sleep interrupted
    [junit] 12/11/11 10:34:13 INFO namenode.FSNamesystem: Number of transactions: 629 Total time for transactions(ms): 11Number of transactions batched in Syncs: 123 Number of syncs: 432 SyncTimes(ms): 6972 1021 
    [junit] 12/11/11 10:34:13 INFO ipc.Server: Stopping server on 36465
    [junit] 12/11/11 10:34:13 INFO ipc.Server: IPC Server handler 0 on 36465: exiting
    [junit] 12/11/11 10:34:13 INFO ipc.Server: IPC Server handler 1 on 36465: exiting
    [junit] 12/11/11 10:34:13 INFO ipc.Server: IPC Server handler 2 on 36465: exiting
    [junit] 12/11/11 10:34:13 INFO ipc.Server: IPC Server handler 4 on 36465: exiting
    [junit] 12/11/11 10:34:13 INFO ipc.Server: IPC Server handler 3 on 36465: exiting
    [junit] 12/11/11 10:34:13 INFO ipc.Server: IPC Server handler 5 on 36465: exiting
    [junit] 12/11/11 10:34:13 INFO ipc.Server: IPC Server handler 6 on 36465: exiting
    [junit] 12/11/11 10:34:13 INFO ipc.Server: IPC Server handler 7 on 36465: exiting
    [junit] 12/11/11 10:34:13 INFO ipc.Server: IPC Server handler 8 on 36465: exiting
    [junit] 12/11/11 10:34:13 INFO ipc.Server: IPC Server handler 9 on 36465: exiting
    [junit] 12/11/11 10:34:13 INFO ipc.Server: Stopping IPC Server listener on 36465
    [junit] 12/11/11 10:34:13 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/11/11 10:34:13 INFO ipc.Server: Stopping IPC Server Responder
    [junit] Tests run: 17, Failures: 4, Errors: 3, Time elapsed: 480.229 sec
    [junit] Test org.apache.pig.test.TestStore FAILED
    [junit] Running org.apache.pig.test.TestStringUDFs
    [junit] 12/11/11 10:34:14 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.NullPointerException
    [junit] 12/11/11 10:34:14 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.StringIndexOutOfBoundsException: String index out of range: -2
    [junit] 12/11/11 10:34:14 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.StringIndexOutOfBoundsException: String index out of range: -1
    [junit] 12/11/11 10:34:14 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.StringIndexOutOfBoundsException: String index out of range: -8
    [junit] 12/11/11 10:34:14 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.StringIndexOutOfBoundsException: String index out of range: -2
    [junit] 12/11/11 10:34:14 WARN builtin.INDEXOF: No logger object provided to UDF: org.apache.pig.builtin.INDEXOF. Failed to process input; error - null
    [junit] 12/11/11 10:34:14 WARN builtin.LAST_INDEX_OF: No logger object provided to UDF: org.apache.pig.builtin.LAST_INDEX_OF. Failed to process input; error - null
    [junit] Tests run: 12, Failures: 0, Errors: 0, Time elapsed: 0.238 sec
   [delete] Deleting directory /tmp/pig_junit_tmp284621226

BUILD FAILED
<https://builds.apache.org/job/Pig-trunk/ws/trunk/build.xml>:834: The following error occurred while executing this line:
<https://builds.apache.org/job/Pig-trunk/ws/trunk/build.xml>:903: Tests failed!

Total time: 20 minutes 50 seconds
Build step 'Execute shell' marked build as failure
[FINDBUGS] Skipping publisher since build result is FAILURE
Recording test results
Publishing Javadoc
Archiving artifacts
Recording fingerprints