See <https://builds.apache.org/job/Pig-trunk/1294/changes>
Changes: [dvryaboy] PIG-2855: Provide a method to measure time spent in UDFs ------------------------------------------ [...truncated 38137 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/08/09 00:07:13 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down. [junit] 12/08/09 00:07:13 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0 [junit] 12/08/09 00:07:13 INFO ipc.Server: Stopping server on 42316 [junit] 12/08/09 00:07:13 INFO ipc.Server: IPC Server handler 1 on 42316: exiting [junit] 12/08/09 00:07:13 INFO ipc.Server: IPC Server handler 0 on 42316: exiting [junit] 12/08/09 00:07:13 INFO ipc.Server: Stopping IPC Server listener on 42316 [junit] 12/08/09 00:07:13 INFO metrics.RpcInstrumentation: shut down [junit] 12/08/09 00:07:13 INFO ipc.Server: Stopping IPC Server Responder [junit] 12/08/09 00:07:13 INFO ipc.Server: IPC Server handler 2 on 42316: exiting [junit] 12/08/09 00:07:13 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:49142, storageID=DS-548339998-67.195.138.20-49142-1344470349364, infoPort=60388, ipcPort=42316):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/08/09 00:07:13 INFO datanode.DataNode: Exiting DataXceiveServer [junit] 12/08/09 00:07:13 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1 [junit] 12/08/09 00:07:13 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread. [junit] 12/08/09 00:07:13 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:49142, storageID=DS-548339998-67.195.138.20-49142-1344470349364, infoPort=60388, ipcPort=42316):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/08/09 00:07:13 INFO ipc.Server: Stopping server on 42316 [junit] 12/08/09 00:07:13 INFO metrics.RpcInstrumentation: shut down [junit] 12/08/09 00:07:13 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0 [junit] 12/08/09 00:07:13 INFO datanode.FSDatasetAsyncDiskService: Shutting down all async disk service threads... [junit] 12/08/09 00:07:13 INFO datanode.FSDatasetAsyncDiskService: All async disk service threads have been shut down. [junit] 12/08/09 00:07:13 WARN util.MBeans: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId248978420 [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId248978420 [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: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/08/09 00:07:13 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down. [junit] 12/08/09 00:07:13 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0 [junit] 12/08/09 00:07:13 INFO ipc.Server: Stopping server on 40077 [junit] 12/08/09 00:07:13 INFO ipc.Server: IPC Server handler 0 on 40077: exiting [junit] 12/08/09 00:07:13 INFO ipc.Server: IPC Server handler 1 on 40077: exiting [junit] 12/08/09 00:07:13 INFO ipc.Server: Stopping IPC Server Responder [junit] 12/08/09 00:07:13 INFO ipc.Server: IPC Server handler 2 on 40077: exiting [junit] 12/08/09 00:07:13 INFO ipc.Server: Stopping IPC Server listener on 40077 [junit] 12/08/09 00:07:13 INFO metrics.RpcInstrumentation: shut down [junit] 12/08/09 00:07:13 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1 [junit] 12/08/09 00:07:13 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:52557, storageID=DS-874089747-67.195.138.20-52557-1344470348986, infoPort=33326, ipcPort=40077):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/08/09 00:07:13 INFO datanode.DataNode: Exiting DataXceiveServer [junit] 12/08/09 00:07:13 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:56627 to delete blk_-1358780373963789484_1073 [junit] 12/08/09 00:07:13 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:52557 to delete blk_-1358780373963789484_1073 blk_3473449148542788214_1078 [junit] 12/08/09 00:07:14 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread. [junit] 12/08/09 00:07:14 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0 [junit] 12/08/09 00:07:14 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:52557, storageID=DS-874089747-67.195.138.20-52557-1344470348986, infoPort=33326, ipcPort=40077):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/08/09 00:07:14 INFO ipc.Server: Stopping server on 40077 [junit] 12/08/09 00:07:14 INFO metrics.RpcInstrumentation: shut down [junit] 12/08/09 00:07:14 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0 [junit] 12/08/09 00:07:14 INFO datanode.FSDatasetAsyncDiskService: Shutting down all async disk service threads... [junit] 12/08/09 00:07:14 INFO datanode.FSDatasetAsyncDiskService: All async disk service threads have been shut down. [junit] 12/08/09 00:07:14 WARN util.MBeans: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId-692321217 [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId-692321217 [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/08/09 00:07:14 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down. [junit] Shutting down DataNode 0 [junit] 12/08/09 00:07:14 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0 [junit] 12/08/09 00:07:14 INFO ipc.Server: Stopping server on 58629 [junit] 12/08/09 00:07:14 INFO ipc.Server: IPC Server handler 0 on 58629: exiting [junit] 12/08/09 00:07:14 INFO ipc.Server: IPC Server handler 2 on 58629: exiting [junit] 12/08/09 00:07:14 INFO ipc.Server: Stopping IPC Server listener on 58629 [junit] 12/08/09 00:07:14 INFO ipc.Server: IPC Server handler 1 on 58629: exiting [junit] 12/08/09 00:07:14 INFO metrics.RpcInstrumentation: shut down [junit] 12/08/09 00:07:14 INFO ipc.Server: Stopping IPC Server Responder [junit] 12/08/09 00:07:14 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1 [junit] 12/08/09 00:07:14 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:56627, storageID=DS-832678730-67.195.138.20-56627-1344470348565, infoPort=38822, ipcPort=58629):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/08/09 00:07:14 INFO datanode.DataNode: Exiting DataXceiveServer [junit] 12/08/09 00:07:14 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread. [junit] 12/08/09 00:07:14 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:56627, storageID=DS-832678730-67.195.138.20-56627-1344470348565, infoPort=38822, ipcPort=58629):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/08/09 00:07:14 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/08/09 00:07:14 INFO ipc.Server: Stopping server on 58629 [junit] 12/08/09 00:07:14 INFO metrics.RpcInstrumentation: shut down [junit] 12/08/09 00:07:14 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0 [junit] 12/08/09 00:07:14 INFO datanode.FSDatasetAsyncDiskService: Shutting down all async disk service threads... [junit] 12/08/09 00:07:14 INFO datanode.FSDatasetAsyncDiskService: All async disk service threads have been shut down. [junit] 12/08/09 00:07:15 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0 [junit] 12/08/09 00:07:15 WARN util.MBeans: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId469961787 [junit] javax.management.InstanceNotFoundException: Hadoop:service=DataNode,name=FSDatasetState-UndefinedStorageId469961787 [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/08/09 00:07:15 WARN datanode.FSDatasetAsyncDiskService: AsyncDiskService has already shut down. [junit] 12/08/09 00:07:15 INFO mortbay.log: Stopped SelectChannelConnector@localhost:0 [junit] 12/08/09 00:07:15 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/08/09 00:07:15 WARN namenode.FSNamesystem: ReplicationMonitor thread received InterruptedException.java.lang.InterruptedException: sleep interrupted [junit] 12/08/09 00:07:15 INFO namenode.FSNamesystem: Number of transactions: 382 Total time for transactions(ms): 7Number of transactions batched in Syncs: 148 Number of syncs: 288 SyncTimes(ms): 3045 459 [junit] 12/08/09 00:07:15 INFO ipc.Server: Stopping server on 49797 [junit] 12/08/09 00:07:15 INFO ipc.Server: IPC Server handler 1 on 49797: exiting [junit] 12/08/09 00:07:15 INFO ipc.Server: IPC Server handler 0 on 49797: exiting [junit] 12/08/09 00:07:15 INFO ipc.Server: IPC Server handler 2 on 49797: exiting [junit] 12/08/09 00:07:15 INFO ipc.Server: IPC Server handler 4 on 49797: exiting [junit] 12/08/09 00:07:15 INFO ipc.Server: IPC Server handler 3 on 49797: exiting [junit] 12/08/09 00:07:15 INFO ipc.Server: IPC Server handler 5 on 49797: exiting [junit] 12/08/09 00:07:15 INFO ipc.Server: IPC Server handler 6 on 49797: exiting [junit] 12/08/09 00:07:15 INFO ipc.Server: IPC Server handler 7 on 49797: exiting [junit] 12/08/09 00:07:15 INFO ipc.Server: IPC Server handler 8 on 49797: exiting [junit] 12/08/09 00:07:15 INFO ipc.Server: IPC Server handler 9 on 49797: exiting [junit] 12/08/09 00:07:15 INFO ipc.Server: Stopping IPC Server listener on 49797 [junit] 12/08/09 00:07:15 INFO metrics.RpcInstrumentation: shut down [junit] 12/08/09 00:07:15 INFO ipc.Server: Stopping IPC Server Responder [junit] Tests run: 17, Failures: 3, Errors: 3, Time elapsed: 480.094 sec [junit] Test org.apache.pig.test.TestStore FAILED [junit] Running org.apache.pig.test.TestStringUDFs [junit] 12/08/09 00:07:16 WARN builtin.SUBSTRING: No logger object provided to UDF: org.apache.pig.builtin.SUBSTRING. java.lang.NullPointerException [junit] 12/08/09 00:07:16 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/08/09 00:07:16 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/08/09 00:07:16 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/08/09 00:07:16 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/08/09 00:07:16 WARN builtin.INDEXOF: No logger object provided to UDF: org.apache.pig.builtin.INDEXOF. Failed to process input; error - null [junit] 12/08/09 00:07:16 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_tmp1703280757 BUILD FAILED <https://builds.apache.org/job/Pig-trunk/ws/trunk/build.xml>:793: The following error occurred while executing this line: <https://builds.apache.org/job/Pig-trunk/ws/trunk/build.xml>:851: Tests failed! Total time: 22 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