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 2015/12/14 07:30:17 UTC

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

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

Changes:

[hyunsik] TAJO-1990: Refine some parts in HBaseTablespace.

------------------------------------------
[...truncated 3371 lines...]
2015-12-14 06:30:08,279 INFO: org.apache.hadoop.ipc.Server (run(676)) - IPC Server listener on 36236: starting
2015-12-14 06:30:08,284 INFO: org.apache.hadoop.hdfs.server.namenode.NameNode (startCommonServices(695)) - NameNode RPC up at: localhost/127.0.0.1:36236
2015-12-14 06:30:08,284 INFO: org.apache.hadoop.hdfs.server.namenode.FSNamesystem (startActiveServices(1103)) - Starting services required for active state
2015-12-14 06:30:08,290 INFO: org.apache.hadoop.hdfs.server.blockmanagement.CacheReplicationMonitor (run(160)) - Starting CacheReplicationMonitor with interval 30000 milliseconds
2015-12-14 06:30:08,299 INFO: org.apache.hadoop.hdfs.MiniDFSCluster (startDataNodes(1413)) - Starting DataNode 0 with dfs.datanode.data.dir: [DISK]<https://builds.apache.org/job/Tajo-master-build/ws/tajo-jdbc/target/test-data/4dcbb146-273d-4cc7-8358-0af2ce4164a9/data/data1,[DISK]file>:<https://builds.apache.org/job/Tajo-master-build/ws/tajo-jdbc/target/test-data/4dcbb146-273d-4cc7-8358-0af2ce4164a9/data/data2>
2015-12-14 06:30:08,358 INFO: org.apache.hadoop.metrics2.impl.MetricsSystemImpl (init(159)) - DataNode metrics system started (again)
2015-12-14 06:30:08,363 INFO: org.apache.hadoop.hdfs.server.datanode.BlockScanner (<init>(172)) - Initialized block scanner with targetBytesPerSec 1048576
2015-12-14 06:30:08,363 INFO: org.apache.hadoop.hdfs.server.datanode.DataNode (<init>(427)) - Configured hostname is 127.0.0.1
2015-12-14 06:30:08,370 INFO: org.apache.hadoop.hdfs.server.datanode.DataNode (startDataNode(1100)) - Starting DataNode with maxLockedMemory = 0
2015-12-14 06:30:08,380 INFO: org.apache.hadoop.hdfs.server.datanode.DataNode (initDataXceiver(898)) - Opened streaming server at /127.0.0.1:56441
2015-12-14 06:30:08,384 INFO: org.apache.hadoop.hdfs.server.datanode.DataNode (<init>(76)) - Balancing bandwith is 1048576 bytes/s
2015-12-14 06:30:08,384 INFO: org.apache.hadoop.hdfs.server.datanode.DataNode (<init>(77)) - Number threads for balancing is 5
2015-12-14 06:30:08,392 INFO: org.apache.hadoop.security.authentication.server.AuthenticationFilter (constructSecretProvider(284)) - Unable to initialize FileSignerSecretProvider, falling back to use random secrets.
2015-12-14 06:30:08,392 INFO: org.apache.hadoop.http.HttpRequestLog (getRequestLog(80)) - Http request log for http.requests.datanode is not defined
2015-12-14 06:30:08,393 INFO: org.apache.hadoop.http.HttpServer2 (addGlobalFilter(710)) - Added global filter 'safety' (class=org.apache.hadoop.http.HttpServer2$QuotingInputFilter)
2015-12-14 06:30:08,394 INFO: org.apache.hadoop.http.HttpServer2 (addFilter(685)) - Added filter static_user_filter (class=org.apache.hadoop.http.lib.StaticUserWebFilter$StaticUserFilter) to context datanode
2015-12-14 06:30:08,395 INFO: org.apache.hadoop.http.HttpServer2 (addFilter(693)) - Added filter static_user_filter (class=org.apache.hadoop.http.lib.StaticUserWebFilter$StaticUserFilter) to context static
2015-12-14 06:30:08,398 INFO: org.apache.hadoop.http.HttpServer2 (openListeners(915)) - Jetty bound to port 50152
2015-12-14 06:30:08,398 INFO: org.mortbay.log (invoke0(?)) - jetty-6.1.14
2015-12-14 06:30:08,402 INFO: org.mortbay.log (invoke0(?)) - Extract jar:file:/home/jenkins/.m2/repository/org/apache/hadoop/hadoop-hdfs/2.7.1/hadoop-hdfs-2.7.1-tests.jar!/webapps/datanode to /tmp/Jetty_localhost_50152_datanode____8xyh6i/webapp
2015-12-14 06:30:08,527 INFO: org.mortbay.log (invoke0(?)) - Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:50152
2015-12-14 06:30:08,747 INFO: org.apache.hadoop.hdfs.server.datanode.web.DatanodeHttpServer (start(186)) - Listening HTTP traffic on /127.0.0.1:48594
2015-12-14 06:30:08,749 INFO: org.apache.hadoop.hdfs.server.datanode.DataNode (startDataNode(1117)) - dnUserName = jenkins
2015-12-14 06:30:08,750 INFO: org.apache.hadoop.hdfs.server.datanode.DataNode (startDataNode(1118)) - supergroup = supergroup
2015-12-14 06:30:08,777 INFO: org.apache.hadoop.ipc.CallQueueManager (<init>(53)) - Using callQueue class java.util.concurrent.LinkedBlockingQueue
2015-12-14 06:30:08,786 INFO: org.apache.hadoop.ipc.Server (run(606)) - Starting Socket Reader #1 for port 32954
2015-12-14 06:30:08,794 INFO: org.apache.hadoop.hdfs.server.datanode.DataNode (initIpcServer(817)) - Opened IPC server at /127.0.0.1:32954
2015-12-14 06:30:08,806 INFO: org.apache.hadoop.hdfs.server.datanode.DataNode (refreshNamenodes(152)) - Refresh request received for nameservices: null
2015-12-14 06:30:08,809 INFO: org.apache.hadoop.hdfs.server.datanode.DataNode (doRefreshNamenodes(197)) - Starting BPOfferServices for nameservices: <default>
2015-12-14 06:30:08,821 INFO: org.apache.hadoop.hdfs.server.datanode.DataNode (run(794)) - Block pool <registering> (Datanode Uuid unassigned) service to localhost/127.0.0.1:36236 starting to offer service
2015-12-14 06:30:08,830 INFO: org.apache.hadoop.ipc.Server (run(836)) - IPC Server Responder: starting
2015-12-14 06:30:08,834 INFO: org.apache.hadoop.ipc.Server (run(676)) - IPC Server listener on 32954: starting
2015-12-14 06:30:09,342 INFO: org.apache.hadoop.hdfs.server.common.Storage (tryLock(715)) - Lock on <https://builds.apache.org/job/Tajo-master-build/ws/tajo-jdbc/target/test-data/4dcbb146-273d-4cc7-8358-0af2ce4164a9/data/data1/in_use.lock> acquired by nodename 26852@asf905.gq1.ygridcore.net
2015-12-14 06:30:09,343 INFO: org.apache.hadoop.hdfs.server.common.Storage (loadStorageDirectory(273)) - Storage directory <https://builds.apache.org/job/Tajo-master-build/ws/tajo-jdbc/target/test-data/4dcbb146-273d-4cc7-8358-0af2ce4164a9/data/data1> is not formatted for BP-191181154-67.195.81.149-1450074606656
2015-12-14 06:30:09,343 INFO: org.apache.hadoop.hdfs.server.common.Storage (loadStorageDirectory(275)) - Formatting ...
2015-12-14 06:30:09,436 INFO: org.apache.hadoop.hdfs.server.common.Storage (recoverTransitionRead(241)) - Analyzing storage directories for bpid BP-191181154-67.195.81.149-1450074606656
2015-12-14 06:30:09,436 INFO: org.apache.hadoop.hdfs.server.common.Storage (lock(675)) - Locking is disabled for <https://builds.apache.org/job/Tajo-master-build/ws/tajo-jdbc/target/test-data/4dcbb146-273d-4cc7-8358-0af2ce4164a9/data/data1/current/BP-191181154-67.195.81.149-1450074606656>
2015-12-14 06:30:09,437 INFO: org.apache.hadoop.hdfs.server.common.Storage (loadStorageDirectory(158)) - Block pool storage directory <https://builds.apache.org/job/Tajo-master-build/ws/tajo-jdbc/target/test-data/4dcbb146-273d-4cc7-8358-0af2ce4164a9/data/data1/current/BP-191181154-67.195.81.149-1450074606656> is not formatted for BP-191181154-67.195.81.149-1450074606656
2015-12-14 06:30:09,437 INFO: org.apache.hadoop.hdfs.server.common.Storage (loadStorageDirectory(160)) - Formatting ...
2015-12-14 06:30:09,437 INFO: org.apache.hadoop.hdfs.server.common.Storage (format(267)) - Formatting block pool BP-191181154-67.195.81.149-1450074606656 directory <https://builds.apache.org/job/Tajo-master-build/ws/tajo-jdbc/target/test-data/4dcbb146-273d-4cc7-8358-0af2ce4164a9/data/data1/current/BP-191181154-67.195.81.149-1450074606656/current>
2015-12-14 06:30:09,476 INFO: org.apache.hadoop.hdfs.server.common.Storage (doTransition(359)) - Restored 0 block files from trash.
2015-12-14 06:30:09,530 INFO: org.apache.hadoop.hdfs.server.common.Storage (tryLock(715)) - Lock on <https://builds.apache.org/job/Tajo-master-build/ws/tajo-jdbc/target/test-data/4dcbb146-273d-4cc7-8358-0af2ce4164a9/data/data2/in_use.lock> acquired by nodename 26852@asf905.gq1.ygridcore.net
2015-12-14 06:30:09,531 INFO: org.apache.hadoop.hdfs.server.common.Storage (loadStorageDirectory(273)) - Storage directory <https://builds.apache.org/job/Tajo-master-build/ws/tajo-jdbc/target/test-data/4dcbb146-273d-4cc7-8358-0af2ce4164a9/data/data2> is not formatted for BP-191181154-67.195.81.149-1450074606656
2015-12-14 06:30:09,531 INFO: org.apache.hadoop.hdfs.server.common.Storage (loadStorageDirectory(275)) - Formatting ...
2015-12-14 06:30:09,564 INFO: org.apache.hadoop.hdfs.MiniDFSCluster (shouldWait(2303)) - dnInfo.length != numDataNodes
2015-12-14 06:30:09,564 INFO: org.apache.hadoop.hdfs.MiniDFSCluster (waitActive(2255)) - Waiting for cluster to become active
2015-12-14 06:30:09,614 INFO: org.apache.hadoop.hdfs.server.common.Storage (recoverTransitionRead(241)) - Analyzing storage directories for bpid BP-191181154-67.195.81.149-1450074606656
2015-12-14 06:30:09,614 INFO: org.apache.hadoop.hdfs.server.common.Storage (lock(675)) - Locking is disabled for <https://builds.apache.org/job/Tajo-master-build/ws/tajo-jdbc/target/test-data/4dcbb146-273d-4cc7-8358-0af2ce4164a9/data/data2/current/BP-191181154-67.195.81.149-1450074606656>
2015-12-14 06:30:09,614 INFO: org.apache.hadoop.hdfs.server.common.Storage (loadStorageDirectory(158)) - Block pool storage directory <https://builds.apache.org/job/Tajo-master-build/ws/tajo-jdbc/target/test-data/4dcbb146-273d-4cc7-8358-0af2ce4164a9/data/data2/current/BP-191181154-67.195.81.149-1450074606656> is not formatted for BP-191181154-67.195.81.149-1450074606656
2015-12-14 06:30:09,614 INFO: org.apache.hadoop.hdfs.server.common.Storage (loadStorageDirectory(160)) - Formatting ...
2015-12-14 06:30:09,614 INFO: org.apache.hadoop.hdfs.server.common.Storage (format(267)) - Formatting block pool BP-191181154-67.195.81.149-1450074606656 directory <https://builds.apache.org/job/Tajo-master-build/ws/tajo-jdbc/target/test-data/4dcbb146-273d-4cc7-8358-0af2ce4164a9/data/data2/current/BP-191181154-67.195.81.149-1450074606656/current>
2015-12-14 06:30:09,650 INFO: org.apache.hadoop.hdfs.server.common.Storage (doTransition(359)) - Restored 0 block files from trash.
2015-12-14 06:30:09,663 INFO: org.apache.hadoop.hdfs.server.datanode.DataNode (initStorage(1364)) - Setting up storage: nsid=678633562;bpid=BP-191181154-67.195.81.149-1450074606656;lv=-56;nsInfo=lv=-63;cid=testClusterID;nsid=678633562;c=0;bpid=BP-191181154-67.195.81.149-1450074606656;dnuuid=null
2015-12-14 06:30:09,666 INFO: org.apache.hadoop.hdfs.MiniDFSCluster (shouldWait(2303)) - dnInfo.length != numDataNodes
2015-12-14 06:30:09,666 INFO: org.apache.hadoop.hdfs.MiniDFSCluster (waitActive(2255)) - Waiting for cluster to become active
2015-12-14 06:30:09,750 INFO: org.apache.hadoop.hdfs.server.datanode.DataNode (checkDatanodeUuid(1193)) - Generated and persisted new Datanode UUID 6b4e0b4e-f531-4378-a7d6-43b7a97b9ec3
2015-12-14 06:30:09,768 INFO: org.apache.hadoop.hdfs.MiniDFSCluster (shouldWait(2303)) - dnInfo.length != numDataNodes
2015-12-14 06:30:09,768 INFO: org.apache.hadoop.hdfs.MiniDFSCluster (waitActive(2255)) - Waiting for cluster to become active
2015-12-14 06:30:09,780 INFO: org.apache.hadoop.hdfs.server.datanode.fsdataset.impl.FsDatasetImpl (addVolume(303)) - Added new volume: DS-3c8df8c3-c9b8-4994-8afe-d661e49174fd
2015-12-14 06:30:09,781 INFO: org.apache.hadoop.hdfs.server.datanode.fsdataset.impl.FsDatasetImpl (addVolume(380)) - Added volume - <https://builds.apache.org/job/Tajo-master-build/ws/tajo-jdbc/target/test-data/4dcbb146-273d-4cc7-8358-0af2ce4164a9/data/data1/current,> StorageType: DISK
2015-12-14 06:30:09,781 INFO: org.apache.hadoop.hdfs.server.datanode.fsdataset.impl.FsDatasetImpl (addVolume(303)) - Added new volume: DS-177a81ef-ddf8-406b-999f-df7aee6e65ab
2015-12-14 06:30:09,781 INFO: org.apache.hadoop.hdfs.server.datanode.fsdataset.impl.FsDatasetImpl (addVolume(380)) - Added volume - <https://builds.apache.org/job/Tajo-master-build/ws/tajo-jdbc/target/test-data/4dcbb146-273d-4cc7-8358-0af2ce4164a9/data/data2/current,> StorageType: DISK
2015-12-14 06:30:09,788 INFO: org.apache.hadoop.hdfs.server.datanode.fsdataset.impl.FsDatasetImpl (registerMBean(2028)) - Registered FSDatasetState MBean
2015-12-14 06:30:09,789 INFO: org.apache.hadoop.hdfs.server.datanode.fsdataset.impl.FsDatasetImpl (addBlockPool(2474)) - Adding block pool BP-191181154-67.195.81.149-1450074606656
2015-12-14 06:30:09,790 INFO: org.apache.hadoop.hdfs.server.datanode.fsdataset.impl.FsDatasetImpl (run(402)) - Scanning block pool BP-191181154-67.195.81.149-1450074606656 on volume <https://builds.apache.org/job/Tajo-master-build/ws/tajo-jdbc/target/test-data/4dcbb146-273d-4cc7-8358-0af2ce4164a9/data/data1/current...>
2015-12-14 06:30:09,791 INFO: org.apache.hadoop.hdfs.server.datanode.fsdataset.impl.FsDatasetImpl (run(402)) - Scanning block pool BP-191181154-67.195.81.149-1450074606656 on volume <https://builds.apache.org/job/Tajo-master-build/ws/tajo-jdbc/target/test-data/4dcbb146-273d-4cc7-8358-0af2ce4164a9/data/data2/current...>
2015-12-14 06:30:09,804 INFO: org.apache.hadoop.hdfs.server.datanode.fsdataset.impl.FsDatasetImpl (run(407)) - Time taken to scan block pool BP-191181154-67.195.81.149-1450074606656 on <https://builds.apache.org/job/Tajo-master-build/ws/tajo-jdbc/target/test-data/4dcbb146-273d-4cc7-8358-0af2ce4164a9/data/data2/current>: 13ms
2015-12-14 06:30:09,804 INFO: org.apache.hadoop.hdfs.server.datanode.fsdataset.impl.FsDatasetImpl (run(407)) - Time taken to scan block pool BP-191181154-67.195.81.149-1450074606656 on <https://builds.apache.org/job/Tajo-master-build/ws/tajo-jdbc/target/test-data/4dcbb146-273d-4cc7-8358-0af2ce4164a9/data/data1/current>: 13ms
2015-12-14 06:30:09,805 INFO: org.apache.hadoop.hdfs.server.datanode.fsdataset.impl.FsDatasetImpl (addBlockPool(433)) - Total time to scan all replicas for block pool BP-191181154-67.195.81.149-1450074606656: 16ms
2015-12-14 06:30:09,806 INFO: org.apache.hadoop.hdfs.server.datanode.fsdataset.impl.FsDatasetImpl (run(189)) - Adding replicas to map for block pool BP-191181154-67.195.81.149-1450074606656 on volume <https://builds.apache.org/job/Tajo-master-build/ws/tajo-jdbc/target/test-data/4dcbb146-273d-4cc7-8358-0af2ce4164a9/data/data1/current...>
2015-12-14 06:30:09,807 INFO: org.apache.hadoop.hdfs.server.datanode.fsdataset.impl.FsDatasetImpl (run(194)) - Time to add replicas to map for block pool BP-191181154-67.195.81.149-1450074606656 on volume <https://builds.apache.org/job/Tajo-master-build/ws/tajo-jdbc/target/test-data/4dcbb146-273d-4cc7-8358-0af2ce4164a9/data/data1/current>: 0ms
2015-12-14 06:30:09,807 INFO: org.apache.hadoop.hdfs.server.datanode.fsdataset.impl.FsDatasetImpl (run(189)) - Adding replicas to map for block pool BP-191181154-67.195.81.149-1450074606656 on volume <https://builds.apache.org/job/Tajo-master-build/ws/tajo-jdbc/target/test-data/4dcbb146-273d-4cc7-8358-0af2ce4164a9/data/data2/current...>
2015-12-14 06:30:09,807 INFO: org.apache.hadoop.hdfs.server.datanode.fsdataset.impl.FsDatasetImpl (run(194)) - Time to add replicas to map for block pool BP-191181154-67.195.81.149-1450074606656 on volume <https://builds.apache.org/job/Tajo-master-build/ws/tajo-jdbc/target/test-data/4dcbb146-273d-4cc7-8358-0af2ce4164a9/data/data2/current>: 0ms
2015-12-14 06:30:09,807 INFO: org.apache.hadoop.hdfs.server.datanode.fsdataset.impl.FsDatasetImpl (getAllVolumesMap(220)) - Total time to add all replicas to map: 2ms
2015-12-14 06:30:09,871 INFO: org.apache.hadoop.hdfs.MiniDFSCluster (shouldWait(2303)) - dnInfo.length != numDataNodes
2015-12-14 06:30:09,871 INFO: org.apache.hadoop.hdfs.MiniDFSCluster (waitActive(2255)) - Waiting for cluster to become active
2015-12-14 06:30:09,973 INFO: org.apache.hadoop.hdfs.MiniDFSCluster (shouldWait(2303)) - dnInfo.length != numDataNodes
2015-12-14 06:30:09,973 INFO: org.apache.hadoop.hdfs.MiniDFSCluster (waitActive(2255)) - Waiting for cluster to become active
2015-12-14 06:30:09,988 INFO: org.apache.hadoop.hdfs.server.datanode.VolumeScanner (findNextUsableBlockIter(378)) - Now scanning bpid BP-191181154-67.195.81.149-1450074606656 on volume <https://builds.apache.org/job/Tajo-master-build/ws/tajo-jdbc/target/test-data/4dcbb146-273d-4cc7-8358-0af2ce4164a9/data/data2>
2015-12-14 06:30:09,988 INFO: org.apache.hadoop.hdfs.server.datanode.VolumeScanner (findNextUsableBlockIter(378)) - Now scanning bpid BP-191181154-67.195.81.149-1450074606656 on volume <https://builds.apache.org/job/Tajo-master-build/ws/tajo-jdbc/target/test-data/4dcbb146-273d-4cc7-8358-0af2ce4164a9/data/data1>
2015-12-14 06:30:09,990 INFO: org.apache.hadoop.hdfs.server.datanode.VolumeScanner (runLoop(533)) - VolumeScanner(<https://builds.apache.org/job/Tajo-master-build/ws/tajo-jdbc/target/test-data/4dcbb146-273d-4cc7-8358-0af2ce4164a9/data/data2,> DS-177a81ef-ddf8-406b-999f-df7aee6e65ab): finished scanning block pool BP-191181154-67.195.81.149-1450074606656
2015-12-14 06:30:09,990 INFO: org.apache.hadoop.hdfs.server.datanode.VolumeScanner (runLoop(533)) - VolumeScanner(<https://builds.apache.org/job/Tajo-master-build/ws/tajo-jdbc/target/test-data/4dcbb146-273d-4cc7-8358-0af2ce4164a9/data/data1,> DS-3c8df8c3-c9b8-4994-8afe-d661e49174fd): finished scanning block pool BP-191181154-67.195.81.149-1450074606656
2015-12-14 06:30:09,991 INFO: org.apache.hadoop.hdfs.server.datanode.DirectoryScanner (start(332)) - Periodic Directory Tree Verification scan starting at 1450079656991 with interval 21600000
2015-12-14 06:30:09,994 INFO: org.apache.hadoop.hdfs.server.datanode.DataNode (register(749)) - Block pool BP-191181154-67.195.81.149-1450074606656 (Datanode Uuid null) service to localhost/127.0.0.1:36236 beginning handshake with NN
2015-12-14 06:30:10,014 INFO: org.apache.hadoop.hdfs.StateChange (registerDatanode(879)) - BLOCK* registerDatanode: from DatanodeRegistration(127.0.0.1:56441, datanodeUuid=6b4e0b4e-f531-4378-a7d6-43b7a97b9ec3, infoPort=48594, infoSecurePort=0, ipcPort=32954, storageInfo=lv=-56;cid=testClusterID;nsid=678633562;c=0) storage 6b4e0b4e-f531-4378-a7d6-43b7a97b9ec3
2015-12-14 06:30:10,014 INFO: org.apache.hadoop.hdfs.server.blockmanagement.DatanodeDescriptor (updateHeartbeatState(450)) - Number of failed storage changes from 0 to 0
2015-12-14 06:30:10,015 INFO: org.apache.hadoop.net.NetworkTopology (add(419)) - Adding a new node: /default-rack/127.0.0.1:56441
2015-12-14 06:30:10,023 INFO: org.apache.hadoop.hdfs.server.datanode.DataNode (register(767)) - Block pool Block pool BP-191181154-67.195.81.149-1450074606656 (Datanode Uuid null) service to localhost/127.0.0.1:36236 successfully registered with NN
2015-12-14 06:30:10,024 INFO: org.apache.hadoop.hdfs.server.datanode.DataNode (offerService(625)) - For namenode localhost/127.0.0.1:36236 using DELETEREPORT_INTERVAL of 300000 msec  BLOCKREPORT_INTERVAL of 21600000msec CACHEREPORT_INTERVAL of 10000msec Initial delay: 0msec; heartBeatInterval=3000
2015-12-14 06:30:10,040 INFO: org.apache.hadoop.hdfs.server.blockmanagement.DatanodeDescriptor (updateHeartbeatState(450)) - Number of failed storage changes from 0 to 0
2015-12-14 06:30:10,040 INFO: org.apache.hadoop.hdfs.server.blockmanagement.DatanodeDescriptor (updateStorage(856)) - Adding new storage ID DS-3c8df8c3-c9b8-4994-8afe-d661e49174fd for DN 127.0.0.1:56441
2015-12-14 06:30:10,041 INFO: org.apache.hadoop.hdfs.server.blockmanagement.DatanodeDescriptor (updateStorage(856)) - Adding new storage ID DS-177a81ef-ddf8-406b-999f-df7aee6e65ab for DN 127.0.0.1:56441
2015-12-14 06:30:10,058 INFO: org.apache.hadoop.hdfs.server.datanode.DataNode (updateActorStatesFromHeartbeat(507)) - Namenode Block pool BP-191181154-67.195.81.149-1450074606656 (Datanode Uuid 6b4e0b4e-f531-4378-a7d6-43b7a97b9ec3) service to localhost/127.0.0.1:36236 trying to claim ACTIVE state with txid=1
2015-12-14 06:30:10,058 INFO: org.apache.hadoop.hdfs.server.datanode.DataNode (updateActorStatesFromHeartbeat(519)) - Acknowledging ACTIVE Namenode Block pool BP-191181154-67.195.81.149-1450074606656 (Datanode Uuid 6b4e0b4e-f531-4378-a7d6-43b7a97b9ec3) service to localhost/127.0.0.1:36236
2015-12-14 06:30:10,065 INFO: org.apache.hadoop.hdfs.server.datanode.VolumeScanner (findNextUsableBlockIter(395)) - VolumeScanner(<https://builds.apache.org/job/Tajo-master-build/ws/tajo-jdbc/target/test-data/4dcbb146-273d-4cc7-8358-0af2ce4164a9/data/data1,> DS-3c8df8c3-c9b8-4994-8afe-d661e49174fd): no suitable block pools found to scan.  Waiting 1814399923 ms.
2015-12-14 06:30:10,065 INFO: org.apache.hadoop.hdfs.server.datanode.VolumeScanner (findNextUsableBlockIter(395)) - VolumeScanner(<https://builds.apache.org/job/Tajo-master-build/ws/tajo-jdbc/target/test-data/4dcbb146-273d-4cc7-8358-0af2ce4164a9/data/data2,> DS-177a81ef-ddf8-406b-999f-df7aee6e65ab): no suitable block pools found to scan.  Waiting 1814399923 ms.
2015-12-14 06:30:10,077 INFO: BlockStateChange (processReport(1862)) - BLOCK* processReport: from storage DS-177a81ef-ddf8-406b-999f-df7aee6e65ab node DatanodeRegistration(127.0.0.1:56441, datanodeUuid=6b4e0b4e-f531-4378-a7d6-43b7a97b9ec3, infoPort=48594, infoSecurePort=0, ipcPort=32954, storageInfo=lv=-56;cid=testClusterID;nsid=678633562;c=0), blocks: 0, hasStaleStorage: true, processing time: 2 msecs
2015-12-14 06:30:10,078 INFO: BlockStateChange (processReport(1862)) - BLOCK* processReport: from storage DS-3c8df8c3-c9b8-4994-8afe-d661e49174fd node DatanodeRegistration(127.0.0.1:56441, datanodeUuid=6b4e0b4e-f531-4378-a7d6-43b7a97b9ec3, infoPort=48594, infoSecurePort=0, ipcPort=32954, storageInfo=lv=-56;cid=testClusterID;nsid=678633562;c=0), blocks: 0, hasStaleStorage: false, processing time: 1 msecs
2015-12-14 06:30:10,083 INFO: org.apache.hadoop.hdfs.MiniDFSCluster (waitActive(2286)) - Cluster is active
2015-12-14 06:30:10,101 WARN: org.apache.tajo.storage.FileTablespace (storageInit(123)) - does not support block metadata. ('dfs.datanode.hdfs-blocks-metadata.enabled')
2015-12-14 06:30:10,102 INFO: org.apache.hadoop.hdfs.server.datanode.DataNode (blockReport(492)) - Successfully sent block report 0x237d5e21177df2,  containing 2 storage report(s), of which we sent 2. The reports had 0 total blocks and used 1 RPC(s). This took 4 msec to generate and 39 msecs for RPC and NN processing. Got back one command: FinalizeCommand/5.
2015-12-14 06:30:10,103 INFO: org.apache.hadoop.hdfs.server.datanode.DataNode (processCommandFromActive(690)) - Got finalize command for block pool BP-191181154-67.195.81.149-1450074606656
2015-12-14 06:30:10,135 WARN: org.apache.tajo.storage.TablespaceManager (loadStorages(168)) - java.lang.ClassNotFoundException: org.apache.tajo.storage.s3.S3TableSpace
2015-12-14 06:30:10,135 WARN: org.apache.tajo.storage.TablespaceManager (loadStorages(168)) - java.lang.ClassNotFoundException: org.apache.tajo.storage.s3.S3TableSpace
Tests run: 3, Failures: 0, Errors: 3, Skipped: 0, Time elapsed: 6.682 sec <<< FAILURE! - in org.apache.tajo.jdbc.TestTajoJdbcNegative
org.apache.tajo.jdbc.TestTajoJdbcNegative  Time elapsed: 6.682 sec  <<< ERROR!
java.lang.NoClassDefFoundError: org/apache/hadoop/hbase/HConstants
Caused by: java.lang.ClassNotFoundException: org.apache.hadoop.hbase.HConstants

org.apache.tajo.jdbc.TestTajoJdbcNegative  Time elapsed: 6.682 sec  <<< ERROR!
java.lang.NoClassDefFoundError: Could not initialize class org.apache.tajo.QueryTestCaseBase

org.apache.tajo.jdbc.TestTajoJdbcNegative  Time elapsed: 6.682 sec  <<< ERROR!
java.lang.NoClassDefFoundError: Could not initialize class org.apache.tajo.QueryTestCaseBase

Running org.apache.tajo.jdbc.TestSQLState
Tests run: 3, Failures: 0, Errors: 3, Skipped: 0, Time elapsed: 0 sec <<< FAILURE! - in org.apache.tajo.jdbc.TestSQLState
org.apache.tajo.jdbc.TestSQLState  Time elapsed: 0 sec  <<< ERROR!
java.lang.NoClassDefFoundError: Could not initialize class org.apache.tajo.QueryTestCaseBase

org.apache.tajo.jdbc.TestSQLState  Time elapsed: 0 sec  <<< ERROR!
java.lang.NoClassDefFoundError: Could not initialize class org.apache.tajo.QueryTestCaseBase

org.apache.tajo.jdbc.TestSQLState  Time elapsed: 0 sec  <<< ERROR!
java.lang.NoClassDefFoundError: Could not initialize class org.apache.tajo.QueryTestCaseBase

Running org.apache.tajo.jdbc.TestTajoDatabaseMetaData
Tests run: 2, Failures: 0, Errors: 2, Skipped: 0, Time elapsed: 0 sec <<< FAILURE! - in org.apache.tajo.jdbc.TestTajoDatabaseMetaData
org.apache.tajo.jdbc.TestTajoDatabaseMetaData  Time elapsed: 0 sec  <<< ERROR!
java.lang.NoClassDefFoundError: Could not initialize class org.apache.tajo.QueryTestCaseBase

org.apache.tajo.jdbc.TestTajoDatabaseMetaData  Time elapsed: 0 sec  <<< ERROR!
java.lang.NoClassDefFoundError: Could not initialize class org.apache.tajo.QueryTestCaseBase

Running org.apache.tajo.jdbc.util.TestResultSetUtil
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 sec - in org.apache.tajo.jdbc.util.TestResultSetUtil
Running org.apache.tajo.jdbc.util.TestQueryStringDecoder
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0 sec - in org.apache.tajo.jdbc.util.TestQueryStringDecoder
Running org.apache.tajo.jdbc.TestResultSet
Tests run: 2, Failures: 0, Errors: 2, Skipped: 0, Time elapsed: 0 sec <<< FAILURE! - in org.apache.tajo.jdbc.TestResultSet
org.apache.tajo.jdbc.TestResultSet  Time elapsed: 0 sec  <<< ERROR!
java.lang.NoClassDefFoundError: Could not initialize class org.apache.tajo.TpchTestBase
	at org.apache.tajo.jdbc.TestResultSet.setup(TestResultSet.java:68)

org.apache.tajo.jdbc.TestResultSet  Time elapsed: 0 sec  <<< ERROR!
java.lang.NullPointerException
	at org.apache.tajo.jdbc.TestResultSet.terminate(TestResultSet.java:111)

Running org.apache.tajo.jdbc.TestTajoJdbc
Tests run: 3, Failures: 0, Errors: 3, Skipped: 0, Time elapsed: 0 sec <<< FAILURE! - in org.apache.tajo.jdbc.TestTajoJdbc
org.apache.tajo.jdbc.TestTajoJdbc  Time elapsed: 0 sec  <<< ERROR!
java.lang.NoClassDefFoundError: Could not initialize class org.apache.tajo.QueryTestCaseBase

org.apache.tajo.jdbc.TestTajoJdbc  Time elapsed: 0 sec  <<< ERROR!
java.lang.NoClassDefFoundError: Could not initialize class org.apache.tajo.QueryTestCaseBase

org.apache.tajo.jdbc.TestTajoJdbc  Time elapsed: 0 sec  <<< ERROR!
java.lang.NoClassDefFoundError: Could not initialize class org.apache.tajo.QueryTestCaseBase


Results :

Tests in error: 
org.apache.tajo.jdbc.TestResultSet.org.apache.tajo.jdbc.TestResultSet
  Run 1: TestResultSet.setup:68 NoClassDefFound Could not initialize class org.apache.t...
  Run 2: TestResultSet.terminate:111 NullPointer

org.apache.tajo.jdbc.TestSQLState.org.apache.tajo.jdbc.TestSQLState
  Run 1: TestSQLState.org.apache.tajo.jdbc.TestSQLState » NoClassDefFound Could not ini...
  Run 2: TestSQLState.org.apache.tajo.jdbc.TestSQLState » NoClassDefFound Could not ini...
  Run 3: TestSQLState.org.apache.tajo.jdbc.TestSQLState » NoClassDefFound Could not ini...

org.apache.tajo.jdbc.TestTajoDatabaseMetaData.org.apache.tajo.jdbc.TestTajoDatabaseMetaData
  Run 1: TestTajoDatabaseMetaData.org.apache.tajo.jdbc.TestTajoDatabaseMetaData » NoClassDefFound
  Run 2: TestTajoDatabaseMetaData.org.apache.tajo.jdbc.TestTajoDatabaseMetaData » NoClassDefFound

org.apache.tajo.jdbc.TestTajoJdbc.org.apache.tajo.jdbc.TestTajoJdbc
  Run 1: TestTajoJdbc.org.apache.tajo.jdbc.TestTajoJdbc » NoClassDefFound Could not ini...
  Run 2: TestTajoJdbc.org.apache.tajo.jdbc.TestTajoJdbc » NoClassDefFound Could not ini...
  Run 3: TestTajoJdbc.org.apache.tajo.jdbc.TestTajoJdbc » NoClassDefFound Could not ini...

org.apache.tajo.jdbc.TestTajoJdbcNegative.org.apache.tajo.jdbc.TestTajoJdbcNegative
  Run 1: TestTajoJdbcNegative>QueryTestCaseBase.<clinit>:177 » NoClassDefFound org/apac...
  Run 2: TestTajoJdbcNegative.org.apache.tajo.jdbc.TestTajoJdbcNegative » NoClassDefFound
  Run 3: TestTajoJdbcNegative.org.apache.tajo.jdbc.TestTajoJdbcNegative » NoClassDefFound


Tests run: 10, Failures: 0, Errors: 5, Skipped: 0

[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO] 
[INFO] Tajo Main ......................................... SUCCESS [  2.179 s]
[INFO] Tajo Project POM .................................. SUCCESS [  1.876 s]
[INFO] Tajo Maven Plugins ................................ SUCCESS [  4.222 s]
[INFO] Tajo Common ....................................... SUCCESS [ 33.032 s]
[INFO] Tajo Algebra ...................................... SUCCESS [  3.462 s]
[INFO] Tajo Catalog Common ............................... SUCCESS [  5.969 s]
[INFO] Tajo Plan ......................................... SUCCESS [  9.105 s]
[INFO] Tajo Rpc Common ................................... SUCCESS [  1.419 s]
[INFO] Tajo Protocol Buffer Rpc .......................... SUCCESS [02:27 min]
[INFO] Tajo Catalog Client ............................... SUCCESS [  1.771 s]
[INFO] Tajo Catalog Server ............................... SUCCESS [01:02 min]
[INFO] Tajo Storage Common ............................... SUCCESS [  4.022 s]
[INFO] Tajo HDFS Storage ................................. SUCCESS [01:07 min]
[INFO] Tajo PullServer ................................... SUCCESS [  1.359 s]
[INFO] Tajo Client ....................................... SUCCESS [  2.968 s]
[INFO] Tajo CLI tools .................................... SUCCESS [  2.386 s]
[INFO] Tajo SQL Parser ................................... SUCCESS [  4.618 s]
[INFO] ASM (thirdparty) .................................. SUCCESS [  2.229 s]
[INFO] Tajo RESTful Container ............................ SUCCESS [  4.528 s]
[INFO] Tajo Metrics ...................................... SUCCESS [  1.913 s]
[INFO] Tajo Core ......................................... SUCCESS [  9.122 s]
[INFO] Tajo RPC .......................................... SUCCESS [  0.954 s]
[INFO] Tajo Catalog Drivers Hive ......................... SUCCESS [ 28.471 s]
[INFO] Tajo Catalog Drivers .............................. SUCCESS [  0.075 s]
[INFO] Tajo Catalog ...................................... SUCCESS [  1.003 s]
[INFO] Tajo Client Example ............................... SUCCESS [  1.117 s]
[INFO] Tajo HBase Storage ................................ SUCCESS [  5.276 s]
[INFO] Tajo Cluster Tests ................................ SUCCESS [  3.481 s]
[INFO] Tajo JDBC Driver .................................. FAILURE [  9.041 s]
[INFO] Tajo JDBC storage common .......................... SKIPPED
[INFO] Tajo PostgreSQL JDBC storage ...................... SKIPPED
[INFO] Tajo S3 storage ................................... SKIPPED
[INFO] Tajo Storage ...................................... SKIPPED
[INFO] Tajo Distribution ................................. SKIPPED
[INFO] Tajo Core Tests ................................... SKIPPED
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 07:03 min
[INFO] Finished at: 2015-12-14T06:30:10+00:00
[INFO] Final Memory: 150M/1770M
[INFO] ------------------------------------------------------------------------
[ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.19:test (default-test) on project tajo-jdbc: There are test failures.
[ERROR] 
[ERROR] Please refer to <https://builds.apache.org/job/Tajo-master-build/ws/tajo-jdbc/target/surefire-reports> for the individual test results.
[ERROR] -> [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/MojoFailureException
[ERROR] 
[ERROR] After correcting the problems, you can resume the build with the command
[ERROR]   mvn <goals> -rf :tajo-jdbc
Build step 'Execute shell' marked build as failure
Updating TAJO-1990

Jenkins build is back to normal : Tajo-master-build #1027

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Tajo-master-build/1027/changes>