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/05/01 12:39:30 UTC

Build failed in Jenkins: Pig-trunk #1238

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

Changes:

[billgraham] PIG-2660: PPNL notified of plan before it gets executed (billgraham)

[gates] PIG-2677 Add target to build.xml to generate clover summary reports

------------------------------------------
[...truncated 37719 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] 	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:129)
    [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/05/01 10:37:09 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] 12/05/01 10:37:09 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/05/01 10:37:09 INFO ipc.Server: Stopping server on 50710
    [junit] 12/05/01 10:37:09 INFO ipc.Server: IPC Server handler 0 on 50710: exiting
    [junit] 12/05/01 10:37:09 INFO ipc.Server: IPC Server handler 1 on 50710: exiting
    [junit] 12/05/01 10:37:09 INFO ipc.Server: Stopping IPC Server listener on 50710
    [junit] 12/05/01 10:37:09 INFO ipc.Server: IPC Server handler 2 on 50710: exiting
    [junit] 12/05/01 10:37:09 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/05/01 10:37:09 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/05/01 10:37:09 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1
    [junit] 12/05/01 10:37:09 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:53783, storageID=DS-1567635616-67.195.138.20-53783-1335868094502, infoPort=43220, ipcPort=50710):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/05/01 10:37:09 INFO datanode.DataNode: Exiting DataXceiveServer
    [junit] 12/05/01 10:37:09 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:38193 to delete  blk_-6050593463058624719_1078
    [junit] 12/05/01 10:37:09 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:39218 to delete  blk_6940038376480010410_1073
    [junit] 12/05/01 10:37:09 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 12/05/01 10:37:10 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/05/01 10:37:10 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:53783, storageID=DS-1567635616-67.195.138.20-53783-1335868094502, infoPort=43220, ipcPort=50710):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/05/01 10:37:10 INFO ipc.Server: Stopping server on 50710
    [junit] 12/05/01 10:37:10 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/05/01 10:37:10 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/05/01 10:37:10 INFO datanode.FSDatasetAsyncDiskService: Shutting down all async disk service threads...
    [junit] 12/05/01 10:37:10 INFO datanode.FSDatasetAsyncDiskService: All async disk service threads have been shut down.
    [junit] 12/05/01 10:37:10 WARN util.MBeans: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId-674121911
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId-674121911
    [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:129)
    [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/05/01 10:37:10 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] 12/05/01 10:37:10 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/05/01 10:37:10 INFO ipc.Server: Stopping server on 58376
    [junit] 12/05/01 10:37:10 INFO ipc.Server: Stopping IPC Server listener on 58376
    [junit] 12/05/01 10:37:10 INFO ipc.Server: IPC Server handler 0 on 58376: exiting
    [junit] 12/05/01 10:37:10 INFO ipc.Server: IPC Server handler 2 on 58376: exiting
    [junit] 12/05/01 10:37:10 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/05/01 10:37:10 INFO ipc.Server: IPC Server handler 1 on 58376: exiting
    [junit] 12/05/01 10:37:10 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/05/01 10:37:10 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1
    [junit] 12/05/01 10:37:10 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:38193, storageID=DS-2092025351-67.195.138.20-38193-1335868094137, infoPort=47110, ipcPort=58376):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/05/01 10:37:10 INFO datanode.DataNode: Exiting DataXceiveServer
    [junit] 12/05/01 10:37:10 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 12/05/01 10:37:10 INFO datanode.DataNode: Scheduling block blk_6940038376480010410_1073 file build/test/data/dfs/data/data2/current/blk_6940038376480010410 for deletion
    [junit] 12/05/01 10:37:10 INFO datanode.DataNode: Deleted block blk_6940038376480010410_1073 at file build/test/data/dfs/data/data2/current/blk_6940038376480010410
    [junit] 12/05/01 10:37:11 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/05/01 10:37:11 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:38193, storageID=DS-2092025351-67.195.138.20-38193-1335868094137, infoPort=47110, ipcPort=58376):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/05/01 10:37:11 INFO ipc.Server: Stopping server on 58376
    [junit] 12/05/01 10:37:11 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/05/01 10:37:11 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/05/01 10:37:11 INFO datanode.FSDatasetAsyncDiskService: Shutting down all async disk service threads...
    [junit] 12/05/01 10:37:11 INFO datanode.FSDatasetAsyncDiskService: All async disk service threads have been shut down.
    [junit] Shutting down DataNode 0
    [junit] 12/05/01 10:37:11 WARN util.MBeans: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId-1184569387
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId-1184569387
    [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:129)
    [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/05/01 10:37:11 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] 12/05/01 10:37:11 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/05/01 10:37:11 INFO ipc.Server: Stopping server on 52182
    [junit] 12/05/01 10:37:11 INFO ipc.Server: IPC Server handler 1 on 52182: exiting
    [junit] 12/05/01 10:37:11 INFO ipc.Server: IPC Server handler 0 on 52182: exiting
    [junit] 12/05/01 10:37:11 INFO ipc.Server: IPC Server handler 2 on 52182: exiting
    [junit] 12/05/01 10:37:11 INFO ipc.Server: Stopping IPC Server listener on 52182
    [junit] 12/05/01 10:37:11 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/05/01 10:37:11 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/05/01 10:37:11 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1
    [junit] 12/05/01 10:37:11 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:39218, storageID=DS-2089478992-67.195.138.20-39218-1335868093744, infoPort=49528, ipcPort=52182):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/05/01 10:37:11 INFO datanode.DataNode: Exiting DataXceiveServer
    [junit] 12/05/01 10:37:12 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 12/05/01 10:37:12 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/05/01 10:37:12 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:39218, storageID=DS-2089478992-67.195.138.20-39218-1335868093744, infoPort=49528, ipcPort=52182):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/05/01 10:37:12 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/05/01 10:37:12 INFO ipc.Server: Stopping server on 52182
    [junit] 12/05/01 10:37:12 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/05/01 10:37:12 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/05/01 10:37:12 INFO datanode.FSDatasetAsyncDiskService: Shutting down all async disk service threads...
    [junit] 12/05/01 10:37:12 INFO datanode.FSDatasetAsyncDiskService: All async disk service threads have been shut down.
    [junit] 12/05/01 10:37:12 WARN util.MBeans: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId1784194252
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId1784194252
    [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:129)
    [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/05/01 10:37:12 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] 12/05/01 10:37:12 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/05/01 10:37:12 WARN namenode.FSNamesystem: ReplicationMonitor thread received InterruptedException.java.lang.InterruptedException: sleep interrupted
    [junit] 12/05/01 10:37:12 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/05/01 10:37:12 INFO namenode.FSNamesystem: Number of transactions: 382 Total time for transactions(ms): 10Number of transactions batched in Syncs: 150 Number of syncs: 287 SyncTimes(ms): 4728 989 
    [junit] 12/05/01 10:37:12 INFO ipc.Server: Stopping server on 46527
    [junit] 12/05/01 10:37:12 INFO ipc.Server: IPC Server handler 0 on 46527: exiting
    [junit] 12/05/01 10:37:12 INFO ipc.Server: IPC Server handler 1 on 46527: exiting
    [junit] 12/05/01 10:37:12 INFO ipc.Server: IPC Server handler 4 on 46527: exiting
    [junit] 12/05/01 10:37:12 INFO ipc.Server: IPC Server handler 2 on 46527: exiting
    [junit] 12/05/01 10:37:12 INFO ipc.Server: IPC Server handler 5 on 46527: exiting
    [junit] 12/05/01 10:37:12 INFO ipc.Server: IPC Server handler 3 on 46527: exiting
    [junit] 12/05/01 10:37:12 INFO ipc.Server: IPC Server handler 6 on 46527: exiting
    [junit] 12/05/01 10:37:12 INFO ipc.Server: IPC Server handler 7 on 46527: exiting
    [junit] 12/05/01 10:37:12 INFO ipc.Server: IPC Server handler 8 on 46527: exiting
    [junit] 12/05/01 10:37:12 INFO ipc.Server: IPC Server handler 9 on 46527: exiting
    [junit] 12/05/01 10:37:12 INFO ipc.Server: Stopping IPC Server listener on 46527
    [junit] 12/05/01 10:37:12 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/05/01 10:37:12 INFO ipc.Server: Stopping IPC Server Responder
    [junit] Tests run: 17, Failures: 3, Errors: 3, Time elapsed: 532.026 sec
    [junit] Test org.apache.pig.test.TestStore FAILED
    [junit] Running org.apache.pig.test.TestStringUDFs
    [junit] 12/05/01 10:37:13 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.NullPointerException
    [junit] 12/05/01 10:37:13 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/05/01 10:37:13 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/05/01 10:37:13 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/05/01 10:37:13 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/05/01 10:37:13 WARN builtin.INDEXOF: No logger object provided to UDF: org.apache.pig.builtin.INDEXOF. Failed to process input; error - null
    [junit] 12/05/01 10:37:13 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: 11, Failures: 0, Errors: 0, Time elapsed: 0.102 sec
   [delete] Deleting directory /tmp/pig_junit_tmp616119490

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

Total time: 24 minutes 59 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 #1241

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


Build failed in Jenkins: Pig-trunk #1240

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

Changes:

[billgraham] PIG-2664: Allow PPNL impls to get more job info during the run (billgraham)

------------------------------------------
[...truncated 36761 lines...]
    [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:129)
    [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/05/07 10:37:32 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] Shutting down DataNode 2
    [junit] 12/05/07 10:37:32 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/05/07 10:37:32 INFO ipc.Server: Stopping server on 39047
    [junit] 12/05/07 10:37:32 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/05/07 10:37:32 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/05/07 10:37:32 INFO ipc.Server: IPC Server handler 1 on 39047: exiting
    [junit] 12/05/07 10:37:32 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:53865, storageID=DS-1626548219-67.195.138.20-53865-1336386512525, infoPort=38073, ipcPort=39047):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/05/07 10:37:32 INFO ipc.Server: IPC Server handler 0 on 39047: exiting
    [junit] 12/05/07 10:37:32 INFO datanode.DataNode: Exiting DataXceiveServer
    [junit] 12/05/07 10:37:32 INFO ipc.Server: IPC Server handler 2 on 39047: exiting
    [junit] 12/05/07 10:37:32 INFO ipc.Server: Stopping IPC Server listener on 39047
    [junit] 12/05/07 10:37:32 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1
    [junit] 12/05/07 10:37:32 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 12/05/07 10:37:32 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:53865, storageID=DS-1626548219-67.195.138.20-53865-1336386512525, infoPort=38073, ipcPort=39047):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/05/07 10:37:32 INFO ipc.Server: Stopping server on 39047
    [junit] 12/05/07 10:37:32 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/05/07 10:37:32 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/05/07 10:37:32 INFO datanode.FSDatasetAsyncDiskService: Shutting down all async disk service threads...
    [junit] 12/05/07 10:37:32 INFO datanode.FSDatasetAsyncDiskService: All async disk service threads have been shut down.
    [junit] 12/05/07 10:37:32 WARN util.MBeans: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId1830993828
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId1830993828
    [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:129)
    [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/05/07 10:37:32 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] Shutting down DataNode 1
    [junit] 12/05/07 10:37:32 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/05/07 10:37:32 INFO ipc.Server: Stopping server on 53041
    [junit] 12/05/07 10:37:32 INFO ipc.Server: IPC Server handler 2 on 53041: exiting
    [junit] 12/05/07 10:37:32 INFO ipc.Server: IPC Server handler 0 on 53041: exiting
    [junit] 12/05/07 10:37:32 INFO ipc.Server: IPC Server handler 1 on 53041: exiting
    [junit] 12/05/07 10:37:32 INFO ipc.Server: Stopping IPC Server listener on 53041
    [junit] 12/05/07 10:37:32 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/05/07 10:37:32 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/05/07 10:37:32 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1
    [junit] 12/05/07 10:37:32 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:51468, storageID=DS-1072181079-67.195.138.20-51468-1336386512151, infoPort=37728, ipcPort=53041):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/05/07 10:37:32 INFO datanode.DataNode: Exiting DataXceiveServer
    [junit] 12/05/07 10:37:32 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:51468, storageID=DS-1072181079-67.195.138.20-51468-1336386512151, infoPort=37728, ipcPort=53041):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/05/07 10:37:32 INFO ipc.Server: Stopping server on 53041
    [junit] 12/05/07 10:37:32 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/05/07 10:37:32 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/05/07 10:37:32 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 12/05/07 10:37:32 INFO datanode.FSDatasetAsyncDiskService: Shutting down all async disk service threads...
    [junit] 12/05/07 10:37:32 INFO datanode.FSDatasetAsyncDiskService: All async disk service threads have been shut down.
    [junit] 12/05/07 10:37:33 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/05/07 10:37:33 WARN util.MBeans: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId217285875
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId217285875
    [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:129)
    [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/05/07 10:37:33 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] Shutting down DataNode 0
    [junit] 12/05/07 10:37:33 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/05/07 10:37:33 INFO ipc.Server: Stopping server on 44980
    [junit] 12/05/07 10:37:33 INFO ipc.Server: IPC Server handler 1 on 44980: exiting
    [junit] 12/05/07 10:37:33 INFO ipc.Server: IPC Server handler 0 on 44980: exiting
    [junit] 12/05/07 10:37:33 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/05/07 10:37:33 INFO ipc.Server: IPC Server handler 2 on 44980: exiting
    [junit] 12/05/07 10:37:33 INFO ipc.Server: Stopping IPC Server listener on 44980
    [junit] 12/05/07 10:37:33 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/05/07 10:37:33 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:47424, storageID=DS-5808161-67.195.138.20-47424-1336386511773, infoPort=34510, ipcPort=44980):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/05/07 10:37:33 INFO datanode.DataNode: Exiting DataXceiveServer
    [junit] 12/05/07 10:37:33 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1
    [junit] 12/05/07 10:37:33 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 12/05/07 10:37:33 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:47424, storageID=DS-5808161-67.195.138.20-47424-1336386511773, infoPort=34510, ipcPort=44980):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/05/07 10:37:33 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/05/07 10:37:33 INFO ipc.Server: Stopping server on 44980
    [junit] 12/05/07 10:37:33 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/05/07 10:37:33 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/05/07 10:37:33 INFO datanode.FSDatasetAsyncDiskService: Shutting down all async disk service threads...
    [junit] 12/05/07 10:37:33 INFO datanode.FSDatasetAsyncDiskService: All async disk service threads have been shut down.
    [junit] 12/05/07 10:37:33 WARN util.MBeans: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId-2000033383
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId-2000033383
    [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:129)
    [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/05/07 10:37:33 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] 12/05/07 10:37:33 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/05/07 10:37:33 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:51468 to delete  blk_-525989087947121722_1073
    [junit] 12/05/07 10:37:33 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:47424 to delete  blk_-525989087947121722_1073
    [junit] 12/05/07 10:37:33 WARN namenode.FSNamesystem: ReplicationMonitor thread received InterruptedException.java.lang.InterruptedException: sleep interrupted
    [junit] 12/05/07 10:37:33 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/05/07 10:37:33 INFO namenode.FSNamesystem: Number of transactions: 382 Total time for transactions(ms): 4Number of transactions batched in Syncs: 145 Number of syncs: 288 SyncTimes(ms): 2667 229 
    [junit] 12/05/07 10:37:33 INFO ipc.Server: Stopping server on 45996
    [junit] 12/05/07 10:37:33 INFO ipc.Server: IPC Server handler 0 on 45996: exiting
    [junit] 12/05/07 10:37:33 INFO ipc.Server: IPC Server handler 3 on 45996: exiting
    [junit] 12/05/07 10:37:33 INFO ipc.Server: IPC Server handler 4 on 45996: exiting
    [junit] 12/05/07 10:37:33 INFO ipc.Server: IPC Server handler 2 on 45996: exiting
    [junit] 12/05/07 10:37:33 INFO ipc.Server: IPC Server handler 6 on 45996: exiting
    [junit] 12/05/07 10:37:33 INFO ipc.Server: Stopping IPC Server listener on 45996
    [junit] 12/05/07 10:37:33 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/05/07 10:37:33 INFO ipc.Server: IPC Server handler 7 on 45996: exiting
    [junit] 12/05/07 10:37:33 INFO ipc.Server: IPC Server handler 1 on 45996: exiting
    [junit] 12/05/07 10:37:33 INFO ipc.Server: IPC Server handler 9 on 45996: exiting
    [junit] 12/05/07 10:37:33 INFO ipc.Server: IPC Server handler 5 on 45996: exiting
    [junit] 12/05/07 10:37:33 INFO ipc.Server: IPC Server handler 8 on 45996: exiting
    [junit] 12/05/07 10:37:33 INFO metrics.RpcInstrumentation: shut down
    [junit] Tests run: 17, Failures: 3, Errors: 3, Time elapsed: 535.293 sec
    [junit] Test org.apache.pig.test.TestStore FAILED
    [junit] Running org.apache.pig.test.TestStringUDFs
    [junit] 12/05/07 10:37:34 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.NullPointerException
    [junit] 12/05/07 10:37:34 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/05/07 10:37:34 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/05/07 10:37:34 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/05/07 10:37:34 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/05/07 10:37:34 WARN builtin.INDEXOF: No logger object provided to UDF: org.apache.pig.builtin.INDEXOF. Failed to process input; error - null
    [junit] 12/05/07 10:37:34 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: 11, Failures: 0, Errors: 0, Time elapsed: 0.109 sec
   [delete] Deleting directory /tmp/pig_junit_tmp902829631

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

Total time: 25 minutes 29 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 #1239

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

Changes:

[billgraham] PIG-2663: Expose helpful ScriptState methods (billgraham)

------------------------------------------
[...truncated 37373 lines...]
    [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:129)
    [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] Shutting down DataNode 2
    [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/05/02 10:38:42 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] 12/05/02 10:38:42 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/05/02 10:38:42 INFO datanode.DataNode: Scheduling block blk_7522977183428422381_1078 file build/test/data/dfs/data/data6/current/blk_7522977183428422381 for deletion
    [junit] 12/05/02 10:38:42 INFO datanode.DataNode: Deleted block blk_7522977183428422381_1078 at file build/test/data/dfs/data/data6/current/blk_7522977183428422381
    [junit] 12/05/02 10:38:42 INFO ipc.Server: Stopping server on 34582
    [junit] 12/05/02 10:38:42 INFO ipc.Server: IPC Server handler 0 on 34582: exiting
    [junit] 12/05/02 10:38:42 INFO ipc.Server: IPC Server handler 1 on 34582: exiting
    [junit] 12/05/02 10:38:42 INFO ipc.Server: IPC Server handler 2 on 34582: exiting
    [junit] 12/05/02 10:38:42 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/05/02 10:38:42 INFO ipc.Server: Stopping IPC Server listener on 34582
    [junit] 12/05/02 10:38:42 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/05/02 10:38:42 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1
    [junit] 12/05/02 10:38:42 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:46699, storageID=DS-650058653-67.195.138.20-46699-1335954600223, infoPort=43104, ipcPort=34582):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/05/02 10:38:42 INFO datanode.DataNode: Exiting DataXceiveServer
    [junit] 12/05/02 10:38:43 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:49442 to delete  blk_7522977183428422381_1078
    [junit] 12/05/02 10:38:43 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:52526 to delete  blk_8458966592190536968_1073
    [junit] 12/05/02 10:38:43 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 12/05/02 10:38:43 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/05/02 10:38:43 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:46699, storageID=DS-650058653-67.195.138.20-46699-1335954600223, infoPort=43104, ipcPort=34582):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/05/02 10:38:43 INFO ipc.Server: Stopping server on 34582
    [junit] 12/05/02 10:38:43 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/05/02 10:38:43 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/05/02 10:38:43 INFO datanode.FSDatasetAsyncDiskService: Shutting down all async disk service threads...
    [junit] 12/05/02 10:38:43 INFO datanode.FSDatasetAsyncDiskService: All async disk service threads have been shut down.
    [junit] 12/05/02 10:38:43 WARN util.MBeans: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId1043803631
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId1043803631
    [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:129)
    [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/05/02 10:38:43 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] 12/05/02 10:38:43 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/05/02 10:38:43 INFO ipc.Server: Stopping server on 43063
    [junit] 12/05/02 10:38:43 INFO ipc.Server: IPC Server handler 0 on 43063: exiting
    [junit] 12/05/02 10:38:43 INFO ipc.Server: IPC Server handler 2 on 43063: exiting
    [junit] 12/05/02 10:38:43 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/05/02 10:38:43 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/05/02 10:38:43 INFO ipc.Server: IPC Server handler 1 on 43063: exiting
    [junit] 12/05/02 10:38:43 INFO ipc.Server: Stopping IPC Server listener on 43063
    [junit] 12/05/02 10:38:43 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1
    [junit] 12/05/02 10:38:43 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:49442, storageID=DS-1585439264-67.195.138.20-49442-1335954599860, infoPort=45634, ipcPort=43063):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/05/02 10:38:43 INFO datanode.DataNode: Exiting DataXceiveServer
    [junit] 12/05/02 10:38:43 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 12/05/02 10:38:44 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/05/02 10:38:44 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:49442, storageID=DS-1585439264-67.195.138.20-49442-1335954599860, infoPort=45634, ipcPort=43063):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/05/02 10:38:44 INFO ipc.Server: Stopping server on 43063
    [junit] 12/05/02 10:38:44 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/05/02 10:38:44 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/05/02 10:38:44 INFO datanode.FSDatasetAsyncDiskService: Shutting down all async disk service threads...
    [junit] 12/05/02 10:38:44 INFO datanode.FSDatasetAsyncDiskService: All async disk service threads have been shut down.
    [junit] 12/05/02 10:38:44 WARN util.MBeans: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId-748034172
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId-748034172
    [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] Shutting down DataNode 0
    [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:129)
    [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/05/02 10:38:44 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] 12/05/02 10:38:44 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/05/02 10:38:44 INFO ipc.Server: Stopping server on 55843
    [junit] 12/05/02 10:38:44 INFO ipc.Server: IPC Server handler 0 on 55843: exiting
    [junit] 12/05/02 10:38:44 INFO ipc.Server: Stopping IPC Server listener on 55843
    [junit] 12/05/02 10:38:44 INFO ipc.Server: IPC Server handler 1 on 55843: exiting
    [junit] 12/05/02 10:38:44 INFO ipc.Server: IPC Server handler 2 on 55843: exiting
    [junit] 12/05/02 10:38:44 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/05/02 10:38:44 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1
    [junit] 12/05/02 10:38:44 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:52526, storageID=DS-1707489340-67.195.138.20-52526-1335954599471, infoPort=39750, ipcPort=55843):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/05/02 10:38:44 INFO datanode.DataNode: Exiting DataXceiveServer
    [junit] 12/05/02 10:38:44 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/05/02 10:38:44 INFO datanode.DataNode: Scheduling block blk_8458966592190536968_1073 file build/test/data/dfs/data/data2/current/blk_8458966592190536968 for deletion
    [junit] 12/05/02 10:38:44 INFO datanode.DataNode: Deleted block blk_8458966592190536968_1073 at file build/test/data/dfs/data/data2/current/blk_8458966592190536968
    [junit] 12/05/02 10:38:45 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 12/05/02 10:38:45 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/05/02 10:38:45 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:52526, storageID=DS-1707489340-67.195.138.20-52526-1335954599471, infoPort=39750, ipcPort=55843):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/05/02 10:38:45 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/05/02 10:38:45 INFO ipc.Server: Stopping server on 55843
    [junit] 12/05/02 10:38:45 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/05/02 10:38:45 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 12/05/02 10:38:45 INFO datanode.FSDatasetAsyncDiskService: Shutting down all async disk service threads...
    [junit] 12/05/02 10:38:45 INFO datanode.FSDatasetAsyncDiskService: All async disk service threads have been shut down.
    [junit] 12/05/02 10:38:45 WARN util.MBeans: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId-306989698
    [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId-306989698
    [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:129)
    [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/05/02 10:38:45 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down.
    [junit] 12/05/02 10:38:45 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0
    [junit] 12/05/02 10:38:45 WARN namenode.FSNamesystem: ReplicationMonitor thread received InterruptedException.java.lang.InterruptedException: sleep interrupted
    [junit] 12/05/02 10:38:45 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/05/02 10:38:45 INFO namenode.FSNamesystem: Number of transactions: 382 Total time for transactions(ms): 6Number of transactions batched in Syncs: 151 Number of syncs: 287 SyncTimes(ms): 3195 345 
    [junit] 12/05/02 10:38:45 INFO ipc.Server: Stopping server on 41977
    [junit] 12/05/02 10:38:45 INFO ipc.Server: Stopping IPC Server listener on 41977
    [junit] 12/05/02 10:38:45 INFO ipc.Server: IPC Server handler 0 on 41977: exiting
    [junit] 12/05/02 10:38:45 INFO metrics.RpcInstrumentation: shut down
    [junit] 12/05/02 10:38:45 INFO ipc.Server: IPC Server handler 8 on 41977: exiting
    [junit] 12/05/02 10:38:45 INFO ipc.Server: IPC Server handler 2 on 41977: exiting
    [junit] 12/05/02 10:38:45 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 12/05/02 10:38:45 INFO ipc.Server: IPC Server handler 3 on 41977: exiting
    [junit] 12/05/02 10:38:45 INFO ipc.Server: IPC Server handler 4 on 41977: exiting
    [junit] 12/05/02 10:38:45 INFO ipc.Server: IPC Server handler 6 on 41977: exiting
    [junit] 12/05/02 10:38:45 INFO ipc.Server: IPC Server handler 1 on 41977: exiting
    [junit] 12/05/02 10:38:45 INFO ipc.Server: IPC Server handler 9 on 41977: exiting
    [junit] 12/05/02 10:38:45 INFO ipc.Server: IPC Server handler 5 on 41977: exiting
    [junit] 12/05/02 10:38:45 INFO ipc.Server: IPC Server handler 7 on 41977: exiting
    [junit] Tests run: 17, Failures: 3, Errors: 3, Time elapsed: 519.865 sec
    [junit] Test org.apache.pig.test.TestStore FAILED
    [junit] Running org.apache.pig.test.TestStringUDFs
    [junit] 12/05/02 10:38:46 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.NullPointerException
    [junit] 12/05/02 10:38:46 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/05/02 10:38:46 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/05/02 10:38:46 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/05/02 10:38:46 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/05/02 10:38:46 WARN builtin.INDEXOF: No logger object provided to UDF: org.apache.pig.builtin.INDEXOF. Failed to process input; error - null
    [junit] 12/05/02 10:38:46 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: 11, Failures: 0, Errors: 0, Time elapsed: 0.107 sec
   [delete] Deleting directory /tmp/pig_junit_tmp1752102515

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

Total time: 25 minutes 2 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