You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@tajo.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2014/02/23 08:10:09 UTC

Build failed in Jenkins: Tajo-master-build #78

See <https://builds.apache.org/job/Tajo-master-build/78/changes>

Changes:

[hyunsik] TAJO-621: Add DOAP file for Tajo.

------------------------------------------
[...truncated 44439 lines...]
    java.util.concurrent.locks.LockSupport.park(LockSupport.java:158)
    java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:1987)
    java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:399)
    org.apache.hadoop.ipc.Server$Handler.run(Server.java:2024)
Thread 32 (IPC Server handler 1 on 39340):
  State: WAITING
  Blocked count: 1
  Waited count: 483
  Waiting on java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@54570a
  Stack:
    sun.misc.Unsafe.park(Native Method)
    java.util.concurrent.locks.LockSupport.park(LockSupport.java:158)
    java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:1987)
    java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:399)
    org.apache.hadoop.ipc.Server$Handler.run(Server.java:2024)
Thread 31 (IPC Server handler 0 on 39340):
  State: WAITING
  Blocked count: 80
  Waited count: 487
  Waiting on java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@54570a
  Stack:
    sun.misc.Unsafe.park(Native Method)
    java.util.concurrent.locks.LockSupport.park(LockSupport.java:158)
    java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:1987)
    java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:399)
    org.apache.hadoop.ipc.Server$Handler.run(Server.java:2024)
Thread 22 (IPC Server listener on 39340):
  State: RUNNABLE
  Blocked count: 452
  Waited count: 0
  Stack:
    sun.nio.ch.EPollArrayWrapper.epollWait(Native Method)
    sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:210)
    sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:65)
    sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:69)
    sun.nio.ch.SelectorImpl.select(SelectorImpl.java:80)
    sun.nio.ch.SelectorImpl.select(SelectorImpl.java:84)
    org.apache.hadoop.ipc.Server$Listener.run(Server.java:693)
Thread 24 (IPC Server Responder):
  State: RUNNABLE
  Blocked count: 0
  Waited count: 0
  Stack:
    sun.nio.ch.EPollArrayWrapper.epollWait(Native Method)
    sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:210)
    sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:65)
    sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:69)
    sun.nio.ch.SelectorImpl.select(SelectorImpl.java:80)
    org.apache.hadoop.ipc.Server$Responder.doRunLoop(Server.java:881)
    org.apache.hadoop.ipc.Server$Responder.run(Server.java:864)
Thread 20 (org.apache.hadoop.hdfs.server.blockmanagement.BlockManager$ReplicationMonitor@1f07597):
  State: TIMED_WAITING
  Blocked count: 0
  Waited count: 36
  Stack:
    java.lang.Thread.sleep(Native Method)
    org.apache.hadoop.hdfs.server.blockmanagement.BlockManager$ReplicationMonitor.run(BlockManager.java:3114)
    java.lang.Thread.run(Thread.java:662)
Thread 21 (org.apache.hadoop.hdfs.server.blockmanagement.HeartbeatManager$Monitor@1b8119a):
  State: TIMED_WAITING
  Blocked count: 0
  Waited count: 20
  Stack:
    java.lang.Thread.sleep(Native Method)
    org.apache.hadoop.hdfs.server.blockmanagement.HeartbeatManager$Monitor.run(HeartbeatManager.java:295)
    java.lang.Thread.run(Thread.java:662)
Thread 30 (org.apache.hadoop.hdfs.server.blockmanagement.DecommissionManager$Monitor@d2efa1):
  State: TIMED_WAITING
  Blocked count: 1
  Waited count: 35
  Stack:
    java.lang.Thread.sleep(Native Method)
    org.apache.hadoop.hdfs.server.blockmanagement.DecommissionManager$Monitor.run(DecommissionManager.java:76)
    java.lang.Thread.run(Thread.java:662)
Thread 29 (org.apache.hadoop.hdfs.server.blockmanagement.PendingReplicationBlocks$PendingReplicationMonitor@12ea1dd):
  State: TIMED_WAITING
  Blocked count: 0
  Waited count: 1
  Stack:
    java.lang.Thread.sleep(Native Method)
    org.apache.hadoop.hdfs.server.blockmanagement.PendingReplicationBlocks$PendingReplicationMonitor.run(PendingReplicationBlocks.java:221)
    java.lang.Thread.run(Thread.java:662)
Thread 23 (Socket Reader #1 for port 39340):
  State: RUNNABLE
  Blocked count: 453
  Waited count: 446
  Stack:
    sun.nio.ch.EPollArrayWrapper.epollWait(Native Method)
    sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:210)
    sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:65)
    sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:69)
    sun.nio.ch.SelectorImpl.select(SelectorImpl.java:80)
    sun.nio.ch.SelectorImpl.select(SelectorImpl.java:84)
    org.apache.hadoop.ipc.Server$Listener$Reader.doRunLoop(Server.java:580)
    org.apache.hadoop.ipc.Server$Listener$Reader.run(Server.java:566)
Thread 19 (Timer-0):
  State: TIMED_WAITING
  Blocked count: 1
  Waited count: 5
  Stack:
    java.lang.Object.wait(Native Method)
    java.util.TimerThread.mainLoop(Timer.java:509)
    java.util.TimerThread.run(Timer.java:462)
Thread 18 (18750399@qtp0-1 - Acceptor0 SelectChannelConnector@localhost:42592):
  State: RUNNABLE
  Blocked count: 1
  Waited count: 1
  Stack:
    sun.nio.ch.EPollArrayWrapper.epollWait(Native Method)
    sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:210)
    sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:65)
    sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:69)
    sun.nio.ch.SelectorImpl.select(SelectorImpl.java:80)
    org.mortbay.io.nio.SelectorManager$SelectSet.doSelect(SelectorManager.java:429)
    org.mortbay.io.nio.SelectorManager.doSelect(SelectorManager.java:185)
    org.mortbay.jetty.nio.SelectChannelConnector.accept(SelectChannelConnector.java:124)
    org.mortbay.jetty.AbstractConnector$Acceptor.run(AbstractConnector.java:707)
    org.mortbay.thread.QueuedThreadPool$PoolThread.run(QueuedThreadPool.java:522)
Thread 17 (14662467@qtp0-0):
  State: TIMED_WAITING
  Blocked count: 0
  Waited count: 2
  Stack:
    java.lang.Object.wait(Native Method)
    org.mortbay.thread.QueuedThreadPool$PoolThread.run(QueuedThreadPool.java:565)
Thread 15 (Timer for 'NameNode' metrics system):
  State: TIMED_WAITING
  Blocked count: 0
  Waited count: 11
  Stack:
    java.lang.Object.wait(Native Method)
    java.util.TimerThread.mainLoop(Timer.java:509)
    java.util.TimerThread.run(Timer.java:462)
Thread 4 (Signal Dispatcher):
  State: RUNNABLE
  Blocked count: 0
  Waited count: 0
  Stack:
Thread 3 (Finalizer):
  State: WAITING
  Blocked count: 69
  Waited count: 23
  Waiting on java.lang.ref.ReferenceQueue$Lock@40afb9
  Stack:
    java.lang.Object.wait(Native Method)
    java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:118)
    java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:134)
    java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:159)
Thread 2 (Reference Handler):
  State: WAITING
  Blocked count: 29
  Waited count: 25
  Waiting on java.lang.ref.Reference$Lock@d0d12e
  Stack:
    java.lang.Object.wait(Native Method)
    java.lang.Object.wait(Object.java:485)
    java.lang.ref.Reference$ReferenceHandler.run(Reference.java:116)
Thread 1 (main):
  State: TIMED_WAITING
  Blocked count: 1227
  Waited count: 2771
  Stack:
    java.lang.Thread.sleep(Native Method)
    org.apache.tajo.client.TajoClient.getQueryResultAndWait(TajoClient.java:261)
    org.apache.tajo.client.TajoClient.executeQueryAndGetResult(TajoClient.java:177)
    org.apache.tajo.LocalTajoTestingUtility.execute(LocalTajoTestingUtility.java:110)
    org.apache.tajo.TpchTestBase.execute(TpchTestBase.java:103)
    org.apache.tajo.QueryTestCaseBase.executeFile(QueryTestCaseBase.java:207)
    org.apache.tajo.QueryTestCaseBase.executeQuery(QueryTestCaseBase.java:193)
    org.apache.tajo.engine.query.TestSortQuery.testSortDesc(TestSortQuery.java:71)
    sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
    sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
    sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
    java.lang.reflect.Method.invoke(Method.java:597)
    org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:45)
    org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
    org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:42)
    org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
    org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:28)
    org.junit.rules.TestWatcher$1.evaluate(TestWatcher.java:47)
    org.junit.rules.RunRules.evaluate(RunRules.java:18)
    org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:263)

2014-02-23 07:10:07,559 INFO  pullserver.TajoPullServerService (TajoPullServerService.java:getFileCunks(556)) - BSTIndex is loaded from disk ((0=>3), (0=>1)
2014-02-23 07:10:07,566 WARN  worker.Task (Task.java:run(658)) - Last retry, killing 
2014-02-23 07:10:07,567 INFO  pullserver.TajoPullServerService (TajoPullServerService.java:getFileCunks(579)) - GET Request for <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core/tajo-core-backend/target/test-data/272c1b39-e0aa-4c6f-a58a-eb54f271d746/tajo-localdir/q_1393139308735_0125/output/1/0_0/output/output> (start=(0=>3), end=(0=>1), last=true)
2014-02-23 07:10:07,568 INFO  pullserver.TajoPullServerService (TajoPullServerService.java:getFileCunks(648)) - Retrieve File Chunk:  (start=0, length=45) <https://builds.apache.org/job/Tajo-master-build/ws/tajo-core/tajo-core-backend/target/test-data/272c1b39-e0aa-4c6f-a58a-eb54f271d746/tajo-localdir/q_1393139308735_0125/output/1/0_0/output/output>
2014-02-23 07:10:07,568 INFO  worker.TajoWorker (TajoWorker.java:run(678)) - ============================================
2014-02-23 07:10:07,569 INFO  worker.TajoWorker (TajoWorker.java:run(679)) - TajoWorker received SIGINT Signal
2014-02-23 07:10:07,569 INFO  worker.TajoWorker (TajoWorker.java:run(680)) - ============================================
2014-02-23 07:10:07,569 INFO  worker.Task (Task.java:waitForFetch(347)) - ta_1393139308735_0125_000002_000000_00 All fetches are done!
2014-02-23 07:10:07,570 INFO  worker.TajoWorker (TajoWorker.java:run(652)) - Worker Resource Heartbeat Thread stopped.
2014-02-23 07:10:07,585 INFO  rpc.NettyServerBase (NettyServerBase.java:shutdown(126)) - Rpc (TajoWorkerProtocol) listened on 0:0:0:0:0:0:0:0:11302) shutdown
2014-02-23 07:10:07,585 INFO  worker.TajoWorkerManagerService (TajoWorkerManagerService.java:stop(95)) - TajoWorkerManagerService stopped
2014-02-23 07:10:07,586 INFO  worker.TaskAttemptContext (TaskAttemptContext.java:setState(106)) - Query status of ta_1393139308735_0125_000002_000000_00 is changed to TA_FAILED
2014-02-23 07:10:07,586 INFO  worker.TaskRunner (TaskRunner.java:stop(227)) - Stop TaskRunner: eb_1393139308735_0125_000002
2014-02-23 07:10:07,589 INFO  rpc.NettyServerBase (NettyServerBase.java:shutdown(126)) - Rpc (QueryMasterProtocol) listened on 0:0:0:0:0:0:0:0:11301) shutdown
2014-02-23 07:10:07,589 INFO  querymaster.QueryMasterManagerService (QueryMasterManagerService.java:stop(110)) - QueryMasterManagerService stopped
2014-02-23 07:10:07,590 INFO  querymaster.QueryMaster (QueryMaster.java:run(425)) - QueryMaster heartbeat thread stopped
2014-02-23 07:10:07,591 INFO  master.TajoAsyncDispatcher (TajoAsyncDispatcher.java:stop(122)) - AsyncDispatcher stopped:querymaster_1393139310106
2014-02-23 07:10:07,591 INFO  querymaster.QueryMaster (QueryMaster.java:stop(160)) - QueryMaster stop
2014-02-23 07:10:07,591 INFO  worker.TajoWorkerClientService (TajoWorkerClientService.java:stop(107)) - TajoWorkerClientService stopping
2014-02-23 07:10:07,593 INFO  rpc.NettyServerBase (NettyServerBase.java:shutdown(126)) - Rpc (QueryMasterClientProtocol) listened on 0:0:0:0:0:0:0:0:11300) shutdown
2014-02-23 07:10:07,593 INFO  worker.TajoWorkerClientService (TajoWorkerClientService.java:stop(111)) - TajoWorkerClientService stopped
2014-02-23 07:10:07,593 INFO  worker.TajoWorker (TajoWorker.java:stop(347)) - TajoWorker main thread exiting

Results :

Tests run: 206, Failures: 0, Errors: 0, Skipped: 0

[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO] 
[INFO] Tajo Main ......................................... SUCCESS [4.203s]
[INFO] Tajo Project POM .................................. SUCCESS [0.757s]
[INFO] Tajo Common ....................................... SUCCESS [7.697s]
[INFO] Tajo Algebra ...................................... SUCCESS [1.270s]
[INFO] Tajo Rpc .......................................... SUCCESS [18.331s]
[INFO] Tajo Catalog Common ............................... SUCCESS [4.653s]
[INFO] Tajo Catalog Client ............................... SUCCESS [1.350s]
[INFO] Tajo Catalog Server ............................... SUCCESS [9.618s]
[INFO] Tajo Storage ...................................... SUCCESS [41.538s]
[INFO] Tajo Core PullServer .............................. SUCCESS [0.746s]
[INFO] Tajo Client ....................................... SUCCESS [2.482s]
[INFO] Tajo JDBC Driver .................................. SUCCESS [0.517s]
[INFO] Tajo Core Backend ................................. FAILURE [1:59.096s]
[INFO] Tajo Core ......................................... SKIPPED
[INFO] Tajo Catalog Drivers .............................. SKIPPED
[INFO] Tajo Catalog ...................................... SKIPPED
[INFO] Tajo Distribution ................................. SKIPPED
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 3:33.114s
[INFO] Finished at: Sun Feb 23 07:10:08 UTC 2014
[INFO] Final Memory: 44M/440M
[INFO] ------------------------------------------------------------------------
[ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.12.4:test (default-test) on project tajo-core-backend: Execution default-test of goal org.apache.maven.plugins:maven-surefire-plugin:2.12.4:test failed: The forked VM terminated without saying properly goodbye. VM crash or System.exit called ? -> [Help 1]
[ERROR] 
[ERROR] To see the full stack trace of the errors, re-run Maven with the -e switch.
[ERROR] Re-run Maven using the -X switch to enable full debug logging.
[ERROR] 
[ERROR] For more information about the errors and possible solutions, please read the following articles:
[ERROR] [Help 1] http://cwiki.apache.org/confluence/display/MAVEN/PluginExecutionException
[ERROR] 
[ERROR] After correcting the problems, you can resume the build with the command
[ERROR]   mvn <goals> -rf :tajo-core-backend
Build step 'Execute shell' marked build as failure
Updating TAJO-621