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 2011/07/14 00:25:21 UTC

Build failed in Jenkins: Pig-trunk #1041

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

Changes:

[julien] PIG-2128: Generating the jar file takes a lot of time and is unnecessary when running Pig local mode

------------------------------------------
[...truncated 28455 lines...]
    [junit] Found 3 items
    [junit] -rw-r--r--   3 hudson supergroup        138 2011-07-13 22:19 /tmp/TestStore--510092889015738399.txt
    [junit] drwxr-xr-x   - hudson supergroup          0 2011-07-13 22:19 /tmp/TestStore-output-6575100088313337738.txt
    [junit] drwxr-xr-x   - hudson supergroup          0 2011-07-13 22:19 /tmp/hadoop-hudson
    [junit] 11/07/13 22:19:37 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=open	src=/tmp/TestStore-output-6575100088313337738.txt/part-m-00000	dst=null	perm=null
    [junit] 11/07/13 22:19:37 INFO DataNode.clienttrace: src: /127.0.0.1:52835, dest: /127.0.0.1:50227, bytes: 142, op: HDFS_READ, cliID: DFSClient_63733304, srvID: DS-920393150-127.0.1.1-52835-1310595553372, blockid: blk_-6886327111445308609_1009
    [junit] Simple data: 
    [junit] VIYZMRJDGZ:0
    [junit] t: 
    [junit] (VIYZMRJDGZ,0)
    [junit] Simple data: 
    [junit] OYBYOTWQDS:96
    [junit] t: 
    [junit] (OYBYOTWQDS,96)
    [junit] Simple data: 
    [junit] DCAOKZGBLH:17
    [junit] t: 
    [junit] (DCAOKZGBLH,17)
    [junit] Simple data: 
    [junit] XKWLDDNKDP:8
    [junit] t: 
    [junit] (XKWLDDNKDP,8)
    [junit] Simple data: 
    [junit] JRQIJLKPAQ:37
    [junit] t: 
    [junit] (JRQIJLKPAQ,37)
    [junit] Simple data: 
    [junit] UGYEVKNXHT:59
    [junit] t: 
    [junit] (UGYEVKNXHT,59)
    [junit] Simple data: 
    [junit] PCNJCQWWQK:41
    [junit] t: 
    [junit] (PCNJCQWWQK,41)
    [junit] Simple data: 
    [junit] MQURYPJGSS:42
    [junit] t: 
    [junit] (MQURYPJGSS,42)
    [junit] Simple data: 
    [junit] GDSWAGIZKT:58
    [junit] t: 
    [junit] (GDSWAGIZKT,58)
    [junit] Simple data: 
    [junit] ZFQMITRKCU:83
    [junit] t: 
    [junit] (ZFQMITRKCU,83)
    [junit] 11/07/13 22:19:37 INFO hdfs.StateChange: BLOCK* NameSystem.addToInvalidates: blk_7327055034616634230 is added to invalidSet of 127.0.0.1:40179
    [junit] 11/07/13 22:19:37 INFO hdfs.StateChange: BLOCK* NameSystem.addToInvalidates: blk_7327055034616634230 is added to invalidSet of 127.0.0.1:59410
    [junit] 11/07/13 22:19:37 INFO hdfs.StateChange: BLOCK* NameSystem.addToInvalidates: blk_7327055034616634230 is added to invalidSet of 127.0.0.1:52835
    [junit] 11/07/13 22:19:37 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=delete	src=/tmp/TestStore--510092889015738399.txt	dst=null	perm=null
    [junit] 11/07/13 22:19:37 INFO hdfs.StateChange: BLOCK* NameSystem.addToInvalidates: blk_1670857773660049362 is added to invalidSet of 127.0.0.1:60318
    [junit] 11/07/13 22:19:37 INFO hdfs.StateChange: BLOCK* NameSystem.addToInvalidates: blk_1670857773660049362 is added to invalidSet of 127.0.0.1:40179
    [junit] 11/07/13 22:19:37 INFO hdfs.StateChange: BLOCK* NameSystem.addToInvalidates: blk_1670857773660049362 is added to invalidSet of 127.0.0.1:52835
    [junit] 11/07/13 22:19:37 INFO hdfs.StateChange: BLOCK* NameSystem.addToInvalidates: blk_-1499523312995579552 is added to invalidSet of 127.0.0.1:59410
    [junit] 11/07/13 22:19:37 INFO hdfs.StateChange: BLOCK* NameSystem.addToInvalidates: blk_-1499523312995579552 is added to invalidSet of 127.0.0.1:52835
    [junit] 11/07/13 22:19:37 INFO hdfs.StateChange: BLOCK* NameSystem.addToInvalidates: blk_-1499523312995579552 is added to invalidSet of 127.0.0.1:40179
    [junit] 11/07/13 22:19:37 INFO hdfs.StateChange: BLOCK* NameSystem.addToInvalidates: blk_-6886327111445308609 is added to invalidSet of 127.0.0.1:40179
    [junit] 11/07/13 22:19:37 INFO hdfs.StateChange: BLOCK* NameSystem.addToInvalidates: blk_-6886327111445308609 is added to invalidSet of 127.0.0.1:59410
    [junit] 11/07/13 22:19:37 INFO hdfs.StateChange: BLOCK* NameSystem.addToInvalidates: blk_-6886327111445308609 is added to invalidSet of 127.0.0.1:52835
    [junit] 11/07/13 22:19:37 INFO FSNamesystem.audit: ugi=hudson,hudson	ip=/127.0.0.1	cmd=delete	src=/tmp/TestStore-output-6575100088313337738.txt	dst=null	perm=null
    [junit] Shutting down the Mini HDFS Cluster
    [junit] Shutting down DataNode 3
    [junit] 11/07/13 22:19:37 INFO ipc.Server: Stopping server on 41041
    [junit] 11/07/13 22:19:37 INFO ipc.Server: Stopping IPC Server listener on 41041
    [junit] 11/07/13 22:19:37 INFO ipc.Server: IPC Server handler 1 on 41041: exiting
    [junit] 11/07/13 22:19:37 INFO ipc.Server: IPC Server handler 2 on 41041: exiting
    [junit] 11/07/13 22:19:37 INFO ipc.Server: IPC Server handler 0 on 41041: exiting
    [junit] 11/07/13 22:19:37 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:59410, storageID=DS-1585324866-127.0.1.1-59410-1310595554016, infoPort=38051, ipcPort=41041):DataXceiveServer: java.nio.channels.AsynchronousCloseException
    [junit] 	at java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:185)
    [junit] 	at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:159)
    [junit] 	at sun.nio.ch.ServerSocketAdaptor.accept(ServerSocketAdaptor.java:84)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataXceiverServer.run(DataXceiverServer.java:130)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 
    [junit] 11/07/13 22:19:37 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 11/07/13 22:19:37 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1
    [junit] 11/07/13 22:19:37 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 11/07/13 22:19:37 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:59410, storageID=DS-1585324866-127.0.1.1-59410-1310595554016, infoPort=38051, ipcPort=41041):Finishing DataNode in: FSDataset{dirpath='<https://builds.apache.org/job/Pig-trunk/ws/trunk/build/test/data/dfs/data/data7/current,/grid/0/hudson/hudson-slave/workspace/Pig-trunk/trunk/build/test/data/dfs/data/data8/current'}>
    [junit] 11/07/13 22:19:37 INFO ipc.Server: Stopping server on 41041
    [junit] 11/07/13 22:19:37 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] Shutting down DataNode 2
    [junit] 11/07/13 22:19:37 INFO ipc.Server: Stopping server on 35209
    [junit] 11/07/13 22:19:37 INFO ipc.Server: IPC Server handler 0 on 35209: exiting
    [junit] 11/07/13 22:19:37 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 11/07/13 22:19:37 INFO ipc.Server: Stopping IPC Server listener on 35209
    [junit] 11/07/13 22:19:37 INFO ipc.Server: IPC Server handler 1 on 35209: exiting
    [junit] 11/07/13 22:19:37 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:60318, storageID=DS-1377369023-127.0.1.1-60318-1310595553684, infoPort=35687, ipcPort=35209):DataXceiveServer: java.nio.channels.AsynchronousCloseException
    [junit] 	at java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:185)
    [junit] 	at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:159)
    [junit] 	at sun.nio.ch.ServerSocketAdaptor.accept(ServerSocketAdaptor.java:84)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataXceiverServer.run(DataXceiverServer.java:130)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 
    [junit] 11/07/13 22:19:37 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1
    [junit] 11/07/13 22:19:37 INFO ipc.Server: IPC Server handler 2 on 35209: exiting
    [junit] 11/07/13 22:19:37 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 11/07/13 22:19:37 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:60318, storageID=DS-1377369023-127.0.1.1-60318-1310595553684, infoPort=35687, ipcPort=35209):Finishing DataNode in: FSDataset{dirpath='<https://builds.apache.org/job/Pig-trunk/ws/trunk/build/test/data/dfs/data/data5/current,/grid/0/hudson/hudson-slave/workspace/Pig-trunk/trunk/build/test/data/dfs/data/data6/current'}>
    [junit] 11/07/13 22:19:37 INFO ipc.Server: Stopping server on 35209
    [junit] 11/07/13 22:19:37 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] Shutting down DataNode 1
    [junit] 11/07/13 22:19:37 INFO ipc.Server: Stopping server on 53556
    [junit] 11/07/13 22:19:37 INFO ipc.Server: IPC Server handler 2 on 53556: exiting
    [junit] 11/07/13 22:19:37 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1
    [junit] 11/07/13 22:19:37 INFO ipc.Server: IPC Server handler 0 on 53556: exiting
    [junit] 11/07/13 22:19:37 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 11/07/13 22:19:37 INFO ipc.Server: IPC Server handler 1 on 53556: exiting
    [junit] 11/07/13 22:19:37 INFO ipc.Server: Stopping IPC Server listener on 53556
    [junit] 11/07/13 22:19:37 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:52835, storageID=DS-920393150-127.0.1.1-52835-1310595553372, infoPort=35870, ipcPort=53556):DataXceiveServer: java.nio.channels.AsynchronousCloseException
    [junit] 	at java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:185)
    [junit] 	at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:159)
    [junit] 	at sun.nio.ch.ServerSocketAdaptor.accept(ServerSocketAdaptor.java:84)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataXceiverServer.run(DataXceiverServer.java:130)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 
    [junit] 11/07/13 22:19:38 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 11/07/13 22:19:38 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:60318 to delete  blk_-8757206608832906881_1006 blk_-2616852326874898858_1004 blk_1670857773660049362_1008 blk_-1903655923276722339_1005
    [junit] 11/07/13 22:19:38 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:59410 to delete  blk_-1499523312995579552_1009 blk_7327055034616634230_1003 blk_-2616852326874898858_1004 blk_-6886327111445308609_1009 blk_-1903655923276722339_1005
    [junit] 11/07/13 22:19:38 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 11/07/13 22:19:38 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:52835, storageID=DS-920393150-127.0.1.1-52835-1310595553372, infoPort=35870, ipcPort=53556):Finishing DataNode in: FSDataset{dirpath='<https://builds.apache.org/job/Pig-trunk/ws/trunk/build/test/data/dfs/data/data3/current,/grid/0/hudson/hudson-slave/workspace/Pig-trunk/trunk/build/test/data/dfs/data/data4/current'}>
    [junit] 11/07/13 22:19:38 INFO ipc.Server: Stopping server on 53556
    [junit] 11/07/13 22:19:38 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] Shutting down DataNode 0
    [junit] 11/07/13 22:19:39 INFO ipc.Server: Stopping server on 59488
    [junit] 11/07/13 22:19:39 INFO ipc.Server: IPC Server handler 0 on 59488: exiting
    [junit] 11/07/13 22:19:39 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1
    [junit] 11/07/13 22:19:39 INFO ipc.Server: IPC Server handler 1 on 59488: exiting
    [junit] 11/07/13 22:19:39 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:40179, storageID=DS-30197771-127.0.1.1-40179-1310595553070, infoPort=40766, ipcPort=59488):DataXceiveServer: java.nio.channels.AsynchronousCloseException
    [junit] 	at java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:185)
    [junit] 	at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:159)
    [junit] 	at sun.nio.ch.ServerSocketAdaptor.accept(ServerSocketAdaptor.java:84)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataXceiverServer.run(DataXceiverServer.java:130)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 
    [junit] 11/07/13 22:19:39 INFO ipc.Server: Stopping IPC Server listener on 59488
    [junit] 11/07/13 22:19:39 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 11/07/13 22:19:39 INFO ipc.Server: IPC Server handler 2 on 59488: exiting
    [junit] 11/07/13 22:19:39 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 11/07/13 22:19:40 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 11/07/13 22:19:40 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:40179, storageID=DS-30197771-127.0.1.1-40179-1310595553070, infoPort=40766, ipcPort=59488):Finishing DataNode in: FSDataset{dirpath='<https://builds.apache.org/job/Pig-trunk/ws/trunk/build/test/data/dfs/data/data1/current,/grid/0/hudson/hudson-slave/workspace/Pig-trunk/trunk/build/test/data/dfs/data/data2/current'}>
    [junit] 11/07/13 22:19:40 INFO ipc.Server: Stopping server on 59488
    [junit] 11/07/13 22:19:40 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 11/07/13 22:19:40 WARN namenode.FSNamesystem: ReplicationMonitor thread received InterruptedException.java.lang.InterruptedException: sleep interrupted
    [junit] 11/07/13 22:19:40 INFO namenode.FSNamesystem: Number of transactions: 53 Total time for transactions(ms): 3Number of transactions batched in Syncs: 5 Number of syncs: 38 SyncTimes(ms): 42 10 
    [junit] 11/07/13 22:19:40 INFO namenode.DecommissionManager: Interrupted Monitor
    [junit] java.lang.InterruptedException: sleep interrupted
    [junit] 	at java.lang.Thread.sleep(Native Method)
    [junit] 	at org.apache.hadoop.hdfs.server.namenode.DecommissionManager$Monitor.run(DecommissionManager.java:65)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 11/07/13 22:19:40 INFO ipc.Server: Stopping server on 38213
    [junit] 11/07/13 22:19:40 INFO ipc.Server: IPC Server handler 0 on 38213: exiting
    [junit] 11/07/13 22:19:40 INFO ipc.Server: IPC Server handler 1 on 38213: exiting
    [junit] 11/07/13 22:19:40 INFO ipc.Server: Stopping IPC Server listener on 38213
    [junit] 11/07/13 22:19:40 INFO ipc.Server: IPC Server handler 5 on 38213: exiting
    [junit] 11/07/13 22:19:40 INFO ipc.Server: IPC Server handler 7 on 38213: exiting
    [junit] 11/07/13 22:19:40 INFO ipc.Server: IPC Server handler 2 on 38213: exiting
    [junit] 11/07/13 22:19:40 INFO ipc.Server: IPC Server handler 8 on 38213: exiting
    [junit] 11/07/13 22:19:40 INFO ipc.Server: IPC Server handler 6 on 38213: exiting
    [junit] 11/07/13 22:19:40 INFO ipc.Server: IPC Server handler 4 on 38213: exiting
    [junit] 11/07/13 22:19:40 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 11/07/13 22:19:40 INFO ipc.Server: IPC Server handler 3 on 38213: exiting
    [junit] 11/07/13 22:19:40 INFO mapred.TaskTracker: Shutting down: Map-events fetcher for all reduce tasks on tracker_host0.foo.com:localhost/127.0.0.1:58747
    [junit] 11/07/13 22:19:40 INFO ipc.Server: Stopping server on 58747
    [junit] 11/07/13 22:19:40 INFO ipc.Server: IPC Server handler 9 on 38213: exiting
    [junit] 11/07/13 22:19:40 INFO ipc.Server: IPC Server handler 3 on 58747: exiting
    [junit] 11/07/13 22:19:40 INFO ipc.Server: IPC Server handler 2 on 58747: exiting
    [junit] 11/07/13 22:19:40 INFO mapred.TaskTracker: Shutting down StatusHttpServer
    [junit] 11/07/13 22:19:40 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 11/07/13 22:19:40 INFO ipc.Server: Stopping IPC Server listener on 58747
    [junit] 11/07/13 22:19:40 INFO ipc.Server: IPC Server handler 1 on 58747: exiting
    [junit] 11/07/13 22:19:40 INFO ipc.Server: IPC Server handler 0 on 58747: exiting
    [junit] 11/07/13 22:19:40 INFO mapred.TaskTracker: Interrupted. Closing down.
    [junit] 11/07/13 22:19:40 INFO mapred.TaskTracker: Shutting down: Map-events fetcher for all reduce tasks on tracker_host1.foo.com:localhost/127.0.0.1:36585
    [junit] 11/07/13 22:19:40 INFO ipc.Server: Stopping server on 36585
    [junit] 11/07/13 22:19:40 INFO ipc.Server: IPC Server handler 0 on 36585: exiting
    [junit] 11/07/13 22:19:40 INFO mapred.TaskTracker: Shutting down StatusHttpServer
    [junit] 11/07/13 22:19:40 INFO ipc.Server: IPC Server handler 3 on 36585: exiting
    [junit] 11/07/13 22:19:40 INFO ipc.Server: IPC Server handler 2 on 36585: exiting
    [junit] 11/07/13 22:19:40 INFO ipc.Server: IPC Server handler 1 on 36585: exiting
    [junit] 11/07/13 22:19:40 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 11/07/13 22:19:40 INFO ipc.Server: Stopping IPC Server listener on 36585
    [junit] 11/07/13 22:19:40 INFO mapred.TaskTracker: Interrupted. Closing down.
    [junit] 11/07/13 22:19:40 INFO mapred.TaskTracker: Shutting down: Map-events fetcher for all reduce tasks on tracker_host2.foo.com:localhost/127.0.0.1:51840
    [junit] 11/07/13 22:19:40 INFO ipc.Server: Stopping server on 51840
    [junit] 11/07/13 22:19:40 INFO ipc.Server: IPC Server handler 0 on 51840: exiting
    [junit] 11/07/13 22:19:40 INFO ipc.Server: IPC Server handler 1 on 51840: exiting
    [junit] 11/07/13 22:19:40 INFO ipc.Server: IPC Server handler 2 on 51840: exiting
    [junit] 11/07/13 22:19:40 INFO ipc.Server: Stopping IPC Server listener on 51840
    [junit] 11/07/13 22:19:40 INFO ipc.Server: IPC Server handler 3 on 51840: exiting
    [junit] 11/07/13 22:19:40 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 11/07/13 22:19:40 INFO mapred.TaskTracker: Shutting down StatusHttpServer
    [junit] 11/07/13 22:19:40 INFO mapred.TaskTracker: Interrupted. Closing down.
    [junit] 11/07/13 22:19:40 INFO mapred.TaskTracker: Shutting down: Map-events fetcher for all reduce tasks on tracker_host3.foo.com:localhost/127.0.0.1:53271
    [junit] 11/07/13 22:19:40 INFO ipc.Server: Stopping server on 53271
    [junit] 11/07/13 22:19:40 INFO ipc.Server: IPC Server handler 0 on 53271: exiting
    [junit] 11/07/13 22:19:40 INFO ipc.Server: Stopping IPC Server listener on 53271
    [junit] 11/07/13 22:19:40 INFO ipc.Server: IPC Server handler 2 on 53271: exiting
    [junit] 11/07/13 22:19:40 INFO ipc.Server: IPC Server handler 3 on 53271: exiting
    [junit] 11/07/13 22:19:40 INFO ipc.Server: IPC Server handler 1 on 53271: exiting
    [junit] 11/07/13 22:19:40 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 11/07/13 22:19:40 INFO mapred.TaskTracker: Shutting down StatusHttpServer
    [junit] 11/07/13 22:19:40 INFO mapred.TaskTracker: Interrupted. Closing down.
    [junit] 11/07/13 22:19:40 INFO mapred.JobTracker: Stopping infoServer
    [junit] 11/07/13 22:19:40 INFO mapred.JobTracker: Stopping interTrackerServer
    [junit] 11/07/13 22:19:40 INFO ipc.Server: Stopping server on 32840
    [junit] 11/07/13 22:19:40 INFO ipc.Server: IPC Server handler 0 on 32840: exiting
    [junit] 11/07/13 22:19:40 INFO ipc.Server: IPC Server handler 7 on 32840: exiting
    [junit] 11/07/13 22:19:40 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 11/07/13 22:19:40 INFO ipc.Server: IPC Server handler 2 on 32840: exiting
    [junit] 11/07/13 22:19:40 INFO mapred.JobTracker: Stopped interTrackerServer
    [junit] 11/07/13 22:19:40 INFO mapred.JobTracker: Stopping expireTrackers
    [junit] 11/07/13 22:19:40 INFO ipc.Server: Stopping IPC Server listener on 32840
    [junit] 11/07/13 22:19:40 INFO ipc.Server: IPC Server handler 1 on 32840: exiting
    [junit] 11/07/13 22:19:40 INFO ipc.Server: IPC Server handler 3 on 32840: exiting
    [junit] 11/07/13 22:19:40 INFO ipc.Server: IPC Server handler 9 on 32840: exiting
    [junit] 11/07/13 22:19:40 INFO ipc.Server: IPC Server handler 5 on 32840: exiting
    [junit] 11/07/13 22:19:40 INFO ipc.Server: IPC Server handler 4 on 32840: exiting
    [junit] 11/07/13 22:19:40 INFO ipc.Server: IPC Server handler 8 on 32840: exiting
    [junit] 11/07/13 22:19:40 INFO mapred.JobTracker: Stopping retirer
    [junit] 11/07/13 22:19:40 INFO ipc.Server: IPC Server handler 6 on 32840: exiting
    [junit] 11/07/13 22:19:40 INFO mapred.EagerTaskInitializationListener: Stopping Job Init Manager thread
    [junit] 11/07/13 22:19:40 INFO mapred.EagerTaskInitializationListener: JobInitManagerThread interrupted.
    [junit] 11/07/13 22:19:40 INFO mapred.EagerTaskInitializationListener: Shutting down thread pool
    [junit] 11/07/13 22:19:40 INFO mapred.JobTracker: Stopping expireLaunchingTasks
    [junit] 11/07/13 22:19:40 INFO mapred.JobTracker: stopped all jobtracker services
    [junit] Tests run: 17, Failures: 0, Errors: 28, Time elapsed: 23.403 sec
    [junit] Test org.apache.pig.test.TestStore FAILED
    [junit] Running org.apache.pig.test.TestStringUDFs
    [junit] 11/07/13 22:19:41 WARN builtin.SUBSTRING: java.lang.NullPointerException
    [junit] 11/07/13 22:19:41 WARN builtin.SUBSTRING: java.lang.StringIndexOutOfBoundsException: String index out of range: -2
    [junit] 11/07/13 22:19:41 WARN builtin.SUBSTRING: java.lang.StringIndexOutOfBoundsException: String index out of range: -1
    [junit] 11/07/13 22:19:41 WARN builtin.SUBSTRING: java.lang.StringIndexOutOfBoundsException: String index out of range: -8
    [junit] 11/07/13 22:19:41 WARN builtin.SUBSTRING: java.lang.StringIndexOutOfBoundsException: String index out of range: -2
    [junit] 11/07/13 22:19:41 WARN builtin.INDEXOF: Failed to process input; error - null
    [junit] 11/07/13 22:19:41 WARN builtin.LAST_INDEX_OF: Failed to process input; error - null
    [junit] Tests run: 11, Failures: 0, Errors: 0, Time elapsed: 0.111 sec
   [delete] Deleting directory /tmp/pig_junit_tmp43100897

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

Total time: 14 minutes 25 seconds
[FINDBUGS] Skipping publisher since build result is FAILURE
Recording test results
Publishing Javadoc
Archiving artifacts
Recording fingerprints
Publishing Clover coverage report...
No Clover report will be published due to a Build Failure


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

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



Build failed in Jenkins: Pig-trunk #1042

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

Changes:

[daijy] PIG-1916: Nested cross

------------------------------------------
[...truncated 34926 lines...]
    [junit] 	at org.apache.hadoop.ipc.Server$Handler$1.run(Server.java:959)
    [junit] 	at org.apache.hadoop.ipc.Server$Handler$1.run(Server.java:955)
    [junit] 	at java.security.AccessController.doPrivileged(Native Method)
    [junit] 	at javax.security.auth.Subject.doAs(Subject.java:396)
    [junit] 	at org.apache.hadoop.ipc.Server$Handler.run(Server.java:953)
    [junit] 11/07/14 10:31:45 ERROR hdfs.DFSClient: Exception closing file /tmp/TestStore-output--7970196343322720179.txt_cleanupOnFailure_succeeded2 : org.apache.hadoop.ipc.RemoteException: java.io.IOException: Could not complete write to file /tmp/TestStore-output--7970196343322720179.txt_cleanupOnFailure_succeeded2 by DFSClient_399712010
    [junit] 	at org.apache.hadoop.hdfs.server.namenode.NameNode.complete(NameNode.java:449)
    [junit] 	at sun.reflect.GeneratedMethodAccessor18.invoke(Unknown Source)
    [junit] 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
    [junit] 	at java.lang.reflect.Method.invoke(Method.java:597)
    [junit] 	at org.apache.hadoop.ipc.RPC$Server.call(RPC.java:508)
    [junit] 	at org.apache.hadoop.ipc.Server$Handler$1.run(Server.java:959)
    [junit] 	at org.apache.hadoop.ipc.Server$Handler$1.run(Server.java:955)
    [junit] 	at java.security.AccessController.doPrivileged(Native Method)
    [junit] 	at javax.security.auth.Subject.doAs(Subject.java:396)
    [junit] 	at org.apache.hadoop.ipc.Server$Handler.run(Server.java:953)
    [junit] 
    [junit] org.apache.hadoop.ipc.RemoteException: java.io.IOException: Could not complete write to file /tmp/TestStore-output--7970196343322720179.txt_cleanupOnFailure_succeeded2 by DFSClient_399712010
    [junit] 	at org.apache.hadoop.hdfs.server.namenode.NameNode.complete(NameNode.java:449)
    [junit] 	at sun.reflect.GeneratedMethodAccessor18.invoke(Unknown Source)
    [junit] 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
    [junit] 	at java.lang.reflect.Method.invoke(Method.java:597)
    [junit] 	at org.apache.hadoop.ipc.RPC$Server.call(RPC.java:508)
    [junit] 	at org.apache.hadoop.ipc.Server$Handler$1.run(Server.java:959)
    [junit] 	at org.apache.hadoop.ipc.Server$Handler$1.run(Server.java:955)
    [junit] 	at java.security.AccessController.doPrivileged(Native Method)
    [junit] 	at javax.security.auth.Subject.doAs(Subject.java:396)
    [junit] 	at org.apache.hadoop.ipc.Server$Handler.run(Server.java:953)
    [junit] 
    [junit] 	at org.apache.hadoop.ipc.Client.call(Client.java:740)
    [junit] 	at org.apache.hadoop.ipc.RPC$Invoker.invoke(RPC.java:220)
    [junit] 	at $Proxy0.complete(Unknown Source)
    [junit] 	at sun.reflect.GeneratedMethodAccessor18.invoke(Unknown Source)
    [junit] 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
    [junit] 	at java.lang.reflect.Method.invoke(Method.java:597)
    [junit] 	at org.apache.hadoop.io.retry.RetryInvocationHandler.invokeMethod(RetryInvocationHandler.java:82)
    [junit] 	at org.apache.hadoop.io.retry.RetryInvocationHandler.invoke(RetryInvocationHandler.java:59)
    [junit] 	at $Proxy0.complete(Unknown Source)
    [junit] 	at org.apache.hadoop.hdfs.DFSClient$DFSOutputStream.closeInternal(DFSClient.java:3264)
    [junit] 	at org.apache.hadoop.hdfs.DFSClient$DFSOutputStream.close(DFSClient.java:3188)
    [junit] 	at org.apache.hadoop.hdfs.DFSClient$LeaseChecker.close(DFSClient.java:1043)
    [junit] 	at org.apache.hadoop.hdfs.DFSClient.close(DFSClient.java:237)
    [junit] 	at org.apache.hadoop.hdfs.DistributedFileSystem.close(DistributedFileSystem.java:269)
    [junit] 	at org.apache.pig.test.MiniCluster.shutdownMiniDfsAndMrClusters(MiniCluster.java:111)
    [junit] 	at org.apache.pig.test.MiniCluster.shutDown(MiniCluster.java:101)
    [junit] 	at org.apache.pig.test.TestStore.oneTimeTearDown(TestStore.java:127)
    [junit] 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
    [junit] 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
    [junit] 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
    [junit] 	at java.lang.reflect.Method.invoke(Method.java:597)
    [junit] 	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
    [junit] 	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
    [junit] 	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
    [junit] 	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:37)
    [junit] 	at org.junit.runners.ParentRunner.run(ParentRunner.java:220)
    [junit] 	at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:39)
    [junit] 	at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:420)
    [junit] 	at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:911)
    [junit] 	at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:768)
    [junit] 11/07/14 10:31:45 INFO ipc.Server: Stopping server on 50510
    [junit] Shutting down the Mini HDFS Cluster
    [junit] Shutting down DataNode 3
    [junit] 11/07/14 10:31:45 INFO ipc.Server: IPC Server handler 0 on 50510: exiting
    [junit] 11/07/14 10:31:45 INFO ipc.Server: IPC Server handler 2 on 50510: exiting
    [junit] 11/07/14 10:31:45 INFO ipc.Server: IPC Server handler 1 on 50510: exiting
    [junit] 11/07/14 10:31:45 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 11/07/14 10:31:45 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1
    [junit] 11/07/14 10:31:45 INFO ipc.Server: Stopping IPC Server listener on 50510
    [junit] 11/07/14 10:31:45 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:33930, storageID=DS-690935421-127.0.1.1-33930-1310639147950, infoPort=54118, ipcPort=50510):DataXceiveServer: java.nio.channels.AsynchronousCloseException
    [junit] 	at java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:185)
    [junit] 	at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:159)
    [junit] 	at sun.nio.ch.ServerSocketAdaptor.accept(ServerSocketAdaptor.java:84)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataXceiverServer.run(DataXceiverServer.java:130)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 
    [junit] 11/07/14 10:31:45 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:33930, storageID=DS-690935421-127.0.1.1-33930-1310639147950, infoPort=54118, ipcPort=50510):Finishing DataNode in: FSDataset{dirpath='<https://builds.apache.org/job/Pig-trunk/ws/trunk/build/test/data/dfs/data/data7/current,/grid/0/hudson/hudson-slave/workspace/Pig-trunk/trunk/build/test/data/dfs/data/data8/current'}>
    [junit] 11/07/14 10:31:45 INFO ipc.Server: Stopping server on 50510
    [junit] 11/07/14 10:31:45 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 11/07/14 10:31:45 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 11/07/14 10:31:45 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:39899 to delete  blk_-2738768409221265493_1124 blk_8775850582309706465_1121 blk_-8755296815594731888_1126 blk_-114364021992344115_1122
    [junit] 11/07/14 10:31:45 INFO hdfs.StateChange: BLOCK* ask 127.0.0.1:44251 to delete  blk_5959513454874390527_1123 blk_8775850582309706465_1121 blk_-8755296815594731888_1126 blk_-114364021992344115_1122 blk_-6062087041934046265_1127
    [junit] Shutting down DataNode 2
    [junit] 11/07/14 10:31:46 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 11/07/14 10:31:46 INFO ipc.Server: Stopping server on 59008
    [junit] 11/07/14 10:31:46 INFO ipc.Server: IPC Server handler 0 on 59008: exiting
    [junit] 11/07/14 10:31:46 INFO ipc.Server: IPC Server handler 1 on 59008: exiting
    [junit] 11/07/14 10:31:46 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 11/07/14 10:31:46 INFO ipc.Server: Stopping IPC Server listener on 59008
    [junit] 11/07/14 10:31:46 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:39899, storageID=DS-1973092909-127.0.1.1-39899-1310639147644, infoPort=46734, ipcPort=59008):DataXceiveServer: java.nio.channels.AsynchronousCloseException
    [junit] 	at java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:185)
    [junit] 	at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:159)
    [junit] 	at sun.nio.ch.ServerSocketAdaptor.accept(ServerSocketAdaptor.java:84)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataXceiverServer.run(DataXceiverServer.java:130)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 
    [junit] 11/07/14 10:31:46 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1
    [junit] 11/07/14 10:31:46 INFO ipc.Server: IPC Server handler 2 on 59008: exiting
    [junit] 11/07/14 10:31:46 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 11/07/14 10:31:46 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:39899, storageID=DS-1973092909-127.0.1.1-39899-1310639147644, infoPort=46734, ipcPort=59008):Finishing DataNode in: FSDataset{dirpath='<https://builds.apache.org/job/Pig-trunk/ws/trunk/build/test/data/dfs/data/data5/current,/grid/0/hudson/hudson-slave/workspace/Pig-trunk/trunk/build/test/data/dfs/data/data6/current'}>
    [junit] 11/07/14 10:31:46 INFO ipc.Server: Stopping server on 59008
    [junit] 11/07/14 10:31:46 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] Shutting down DataNode 1
    [junit] 11/07/14 10:31:46 INFO ipc.Server: Stopping server on 60666
    [junit] 11/07/14 10:31:46 INFO ipc.Server: IPC Server handler 0 on 60666: exiting
    [junit] 11/07/14 10:31:46 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 11/07/14 10:31:46 INFO ipc.Server: Stopping IPC Server listener on 60666
    [junit] 11/07/14 10:31:46 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:35850, storageID=DS-783195727-127.0.1.1-35850-1310639147334, infoPort=38433, ipcPort=60666):DataXceiveServer: java.nio.channels.AsynchronousCloseException
    [junit] 	at java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:185)
    [junit] 	at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:159)
    [junit] 	at sun.nio.ch.ServerSocketAdaptor.accept(ServerSocketAdaptor.java:84)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataXceiverServer.run(DataXceiverServer.java:130)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 
    [junit] 11/07/14 10:31:46 INFO ipc.Server: IPC Server handler 2 on 60666: exiting
    [junit] 11/07/14 10:31:46 INFO ipc.Server: IPC Server handler 1 on 60666: exiting
    [junit] 11/07/14 10:31:46 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1
    [junit] 11/07/14 10:31:46 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 11/07/14 10:31:46 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:35850, storageID=DS-783195727-127.0.1.1-35850-1310639147334, infoPort=38433, ipcPort=60666):Finishing DataNode in: FSDataset{dirpath='<https://builds.apache.org/job/Pig-trunk/ws/trunk/build/test/data/dfs/data/data3/current,/grid/0/hudson/hudson-slave/workspace/Pig-trunk/trunk/build/test/data/dfs/data/data4/current'}>
    [junit] 11/07/14 10:31:46 INFO ipc.Server: Stopping server on 60666
    [junit] 11/07/14 10:31:46 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] Shutting down DataNode 0
    [junit] 11/07/14 10:31:46 INFO ipc.Server: Stopping server on 38100
    [junit] 11/07/14 10:31:46 INFO ipc.Server: IPC Server handler 0 on 38100: exiting
    [junit] 11/07/14 10:31:46 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 1
    [junit] 11/07/14 10:31:46 INFO ipc.Server: Stopping IPC Server listener on 38100
    [junit] 11/07/14 10:31:46 WARN datanode.DataNode: DatanodeRegistration(127.0.0.1:44251, storageID=DS-573498113-127.0.1.1-44251-1310639146995, infoPort=40212, ipcPort=38100):DataXceiveServer: java.nio.channels.AsynchronousCloseException
    [junit] 	at java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:185)
    [junit] 	at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:159)
    [junit] 	at sun.nio.ch.ServerSocketAdaptor.accept(ServerSocketAdaptor.java:84)
    [junit] 	at org.apache.hadoop.hdfs.server.datanode.DataXceiverServer.run(DataXceiverServer.java:130)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 
    [junit] 11/07/14 10:31:46 INFO ipc.Server: IPC Server handler 1 on 38100: exiting
    [junit] 11/07/14 10:31:46 INFO ipc.Server: IPC Server handler 2 on 38100: exiting
    [junit] 11/07/14 10:31:46 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 11/07/14 10:31:46 INFO mapred.TaskTracker: Received 'KillJobAction' for job: job_20110714102548008_0015
    [junit] 11/07/14 10:31:46 WARN mapred.TaskTracker: Unknown job job_20110714102548008_0015 being deleted.
    [junit] 11/07/14 10:31:47 INFO datanode.DataBlockScanner: Exiting DataBlockScanner thread.
    [junit] 11/07/14 10:31:47 INFO datanode.DataNode: DatanodeRegistration(127.0.0.1:44251, storageID=DS-573498113-127.0.1.1-44251-1310639146995, infoPort=40212, ipcPort=38100):Finishing DataNode in: FSDataset{dirpath='<https://builds.apache.org/job/Pig-trunk/ws/trunk/build/test/data/dfs/data/data1/current,/grid/0/hudson/hudson-slave/workspace/Pig-trunk/trunk/build/test/data/dfs/data/data2/current'}>
    [junit] 11/07/14 10:31:47 INFO ipc.Server: Stopping server on 38100
    [junit] 11/07/14 10:31:47 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 11/07/14 10:31:47 INFO datanode.DataNode: Waiting for threadgroup to exit, active threads is 0
    [junit] 11/07/14 10:31:47 WARN namenode.FSNamesystem: ReplicationMonitor thread received InterruptedException.java.lang.InterruptedException: sleep interrupted
    [junit] 11/07/14 10:31:47 INFO namenode.FSNamesystem: Number of transactions: 694 Total time for transactions(ms): 11Number of transactions batched in Syncs: 113 Number of syncs: 485 SyncTimes(ms): 2275 389 
    [junit] 11/07/14 10:31:47 INFO namenode.DecommissionManager: Interrupted Monitor
    [junit] java.lang.InterruptedException: sleep interrupted
    [junit] 	at java.lang.Thread.sleep(Native Method)
    [junit] 	at org.apache.hadoop.hdfs.server.namenode.DecommissionManager$Monitor.run(DecommissionManager.java:65)
    [junit] 	at java.lang.Thread.run(Thread.java:662)
    [junit] 11/07/14 10:31:47 INFO ipc.Server: Stopping server on 46846
    [junit] 11/07/14 10:31:47 INFO ipc.Server: IPC Server handler 0 on 46846: exiting
    [junit] 11/07/14 10:31:47 INFO ipc.Server: IPC Server handler 1 on 46846: exiting
    [junit] 11/07/14 10:31:47 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 11/07/14 10:31:47 INFO ipc.Server: Stopping IPC Server listener on 46846
    [junit] 11/07/14 10:31:47 INFO ipc.Server: IPC Server handler 3 on 46846: exiting
    [junit] 11/07/14 10:31:47 INFO ipc.Server: IPC Server handler 7 on 46846: exiting
    [junit] 11/07/14 10:31:47 INFO ipc.Server: IPC Server handler 8 on 46846: exiting
    [junit] 11/07/14 10:31:47 INFO ipc.Server: IPC Server handler 5 on 46846: exiting
    [junit] 11/07/14 10:31:47 INFO ipc.Server: IPC Server handler 4 on 46846: exiting
    [junit] 11/07/14 10:31:47 INFO mapred.TaskTracker: Shutting down: Map-events fetcher for all reduce tasks on tracker_host0.foo.com:localhost/127.0.0.1:43454
    [junit] 11/07/14 10:31:47 INFO ipc.Server: IPC Server handler 9 on 46846: exiting
    [junit] 11/07/14 10:31:47 INFO ipc.Server: IPC Server handler 2 on 46846: exiting
    [junit] 11/07/14 10:31:47 INFO ipc.Server: IPC Server handler 6 on 46846: exiting
    [junit] 11/07/14 10:31:47 INFO ipc.Server: Stopping server on 43454
    [junit] 11/07/14 10:31:47 INFO ipc.Server: IPC Server handler 0 on 43454: exiting
    [junit] 11/07/14 10:31:47 INFO ipc.Server: IPC Server handler 1 on 43454: exiting
    [junit] 11/07/14 10:31:47 INFO ipc.Server: Stopping IPC Server listener on 43454
    [junit] 11/07/14 10:31:47 INFO ipc.Server: IPC Server handler 3 on 43454: exiting
    [junit] 11/07/14 10:31:47 INFO ipc.Server: IPC Server handler 2 on 43454: exiting
    [junit] 11/07/14 10:31:47 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 11/07/14 10:31:47 INFO mapred.TaskTracker: Shutting down StatusHttpServer
    [junit] 11/07/14 10:31:47 INFO mapred.TaskTracker: Interrupted. Closing down.
    [junit] 11/07/14 10:31:47 INFO mapred.TaskTracker: Shutting down: Map-events fetcher for all reduce tasks on tracker_host1.foo.com:localhost/127.0.0.1:55260
    [junit] 11/07/14 10:31:47 INFO ipc.Server: Stopping server on 55260
    [junit] 11/07/14 10:31:47 INFO ipc.Server: Stopping IPC Server listener on 55260
    [junit] 11/07/14 10:31:47 INFO ipc.Server: IPC Server handler 1 on 55260: exiting
    [junit] 11/07/14 10:31:47 INFO ipc.Server: IPC Server handler 2 on 55260: exiting
    [junit] 11/07/14 10:31:47 INFO mapred.TaskTracker: Shutting down StatusHttpServer
    [junit] 11/07/14 10:31:47 INFO ipc.Server: IPC Server handler 0 on 55260: exiting
    [junit] 11/07/14 10:31:47 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 11/07/14 10:31:47 INFO ipc.Server: IPC Server handler 3 on 55260: exiting
    [junit] 11/07/14 10:31:47 INFO mapred.TaskTracker: Interrupted. Closing down.
    [junit] 11/07/14 10:31:47 INFO mapred.TaskTracker: Shutting down: Map-events fetcher for all reduce tasks on tracker_host2.foo.com:localhost/127.0.0.1:36948
    [junit] 11/07/14 10:31:47 INFO ipc.Server: Stopping server on 36948
    [junit] 11/07/14 10:31:47 INFO ipc.Server: IPC Server handler 1 on 36948: exiting
    [junit] 11/07/14 10:31:47 INFO ipc.Server: IPC Server handler 2 on 36948: exiting
    [junit] 11/07/14 10:31:47 INFO ipc.Server: Stopping IPC Server listener on 36948
    [junit] 11/07/14 10:31:47 INFO ipc.Server: IPC Server handler 0 on 36948: exiting
    [junit] 11/07/14 10:31:47 INFO mapred.TaskTracker: Shutting down StatusHttpServer
    [junit] 11/07/14 10:31:47 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 11/07/14 10:31:47 INFO ipc.Server: IPC Server handler 3 on 36948: exiting
    [junit] 11/07/14 10:31:47 INFO mapred.TaskTracker: Interrupted. Closing down.
    [junit] 11/07/14 10:31:47 INFO mapred.TaskTracker: Shutting down: Map-events fetcher for all reduce tasks on tracker_host3.foo.com:localhost/127.0.0.1:43804
    [junit] 11/07/14 10:31:47 INFO ipc.Server: Stopping server on 43804
    [junit] 11/07/14 10:31:47 INFO ipc.Server: IPC Server handler 0 on 43804: exiting
    [junit] 11/07/14 10:31:47 INFO ipc.Server: Stopping IPC Server listener on 43804
    [junit] 11/07/14 10:31:47 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 11/07/14 10:31:47 INFO mapred.TaskTracker: Shutting down StatusHttpServer
    [junit] 11/07/14 10:31:47 INFO ipc.Server: IPC Server handler 1 on 43804: exiting
    [junit] 11/07/14 10:31:47 INFO ipc.Server: IPC Server handler 2 on 43804: exiting
    [junit] 11/07/14 10:31:47 INFO ipc.Server: IPC Server handler 3 on 43804: exiting
    [junit] 11/07/14 10:31:47 INFO mapred.TaskTracker: Interrupted. Closing down.
    [junit] 11/07/14 10:31:47 INFO mapred.JobTracker: Stopping infoServer
    [junit] 11/07/14 10:31:47 INFO mapred.JobTracker: Stopping interTrackerServer
    [junit] 11/07/14 10:31:47 INFO ipc.Server: Stopping server on 46037
    [junit] 11/07/14 10:31:47 INFO ipc.Server: IPC Server handler 0 on 46037: exiting
    [junit] 11/07/14 10:31:47 INFO ipc.Server: IPC Server handler 1 on 46037: exiting
    [junit] 11/07/14 10:31:47 INFO mapred.JobTracker: Stopped interTrackerServer
    [junit] 11/07/14 10:31:47 INFO ipc.Server: IPC Server handler 5 on 46037: exiting
    [junit] 11/07/14 10:31:47 INFO ipc.Server: Stopping IPC Server Responder
    [junit] 11/07/14 10:31:47 INFO mapred.JobTracker: Stopping expireTrackers
    [junit] 11/07/14 10:31:47 INFO ipc.Server: IPC Server handler 8 on 46037: exiting
    [junit] 11/07/14 10:31:47 INFO ipc.Server: IPC Server handler 3 on 46037: exiting
    [junit] 11/07/14 10:31:47 INFO ipc.Server: IPC Server handler 9 on 46037: exiting
    [junit] 11/07/14 10:31:47 INFO ipc.Server: IPC Server handler 7 on 46037: exiting
    [junit] 11/07/14 10:31:47 INFO ipc.Server: IPC Server handler 6 on 46037: exiting
    [junit] 11/07/14 10:31:47 INFO ipc.Server: Stopping IPC Server listener on 46037
    [junit] 11/07/14 10:31:47 INFO ipc.Server: IPC Server handler 4 on 46037: exiting
    [junit] 11/07/14 10:31:47 INFO ipc.Server: IPC Server handler 2 on 46037: exiting
    [junit] 11/07/14 10:31:47 INFO mapred.JobTracker: Stopping retirer
    [junit] 11/07/14 10:31:47 INFO mapred.EagerTaskInitializationListener: Stopping Job Init Manager thread
    [junit] 11/07/14 10:31:47 INFO mapred.EagerTaskInitializationListener: JobInitManagerThread interrupted.
    [junit] 11/07/14 10:31:47 INFO mapred.EagerTaskInitializationListener: Shutting down thread pool
    [junit] 11/07/14 10:31:47 INFO mapred.JobTracker: Stopping expireLaunchingTasks
    [junit] 11/07/14 10:31:47 INFO mapred.JobTracker: stopped all jobtracker services
    [junit] Tests run: 17, Failures: 0, Errors: 0, Time elapsed: 357.295 sec
    [junit] Running org.apache.pig.test.TestStringUDFs
    [junit] 11/07/14 10:31:48 WARN builtin.SUBSTRING: java.lang.NullPointerException
    [junit] 11/07/14 10:31:48 WARN builtin.SUBSTRING: java.lang.StringIndexOutOfBoundsException: String index out of range: -2
    [junit] 11/07/14 10:31:48 WARN builtin.SUBSTRING: java.lang.StringIndexOutOfBoundsException: String index out of range: -1
    [junit] 11/07/14 10:31:48 WARN builtin.SUBSTRING: java.lang.StringIndexOutOfBoundsException: String index out of range: -8
    [junit] 11/07/14 10:31:48 WARN builtin.SUBSTRING: java.lang.StringIndexOutOfBoundsException: String index out of range: -2
    [junit] 11/07/14 10:31:48 WARN builtin.INDEXOF: Failed to process input; error - null
    [junit] 11/07/14 10:31:48 WARN builtin.LAST_INDEX_OF: Failed to process input; error - null
    [junit] Tests run: 11, Failures: 0, Errors: 0, Time elapsed: 0.113 sec
   [delete] Deleting directory /tmp/pig_junit_tmp1858841122

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

Total time: 20 minutes 57 seconds
[FINDBUGS] Skipping publisher since build result is FAILURE
Recording test results
Publishing Javadoc
Archiving artifacts
Recording fingerprints
Publishing Clover coverage report...
No Clover report will be published due to a Build Failure