See <https://builds.apache.org/job/Hama-Nightly-for-Hadoop-1.x/1130/changes>
Changes: [edwardyoon] HAMA-831: Support for multi records with same vertexID (edwardyoon) ------------------------------------------ [...truncated 25024 lines...] 13/12/24 00:02:42 INFO zookeeper.ZooKeeper: Client environment:os.arch=i386 13/12/24 00:02:42 INFO zookeeper.ZooKeeper: Client environment:os.version=3.2.0-57-generic 13/12/24 00:02:42 INFO zookeeper.ZooKeeper: Client environment:user.name=jenkins 13/12/24 00:02:42 INFO zookeeper.ZooKeeper: Client environment:user.home=/home/jenkins 13/12/24 00:02:42 INFO zookeeper.ZooKeeper: Client environment:user.dir=/tmp/hama-test/groomServer/attempt_201312240002_0001_000000_0/work 13/12/24 00:02:42 INFO zookeeper.ZooKeeper: Initiating client connection, connectString=localhost:21810 sessionTimeout=6000 watcher=org.apache.hama.bsp.sync.ZooKeeperSyncClientImpl@32c746 13/12/24 00:02:42 INFO sync.ZKSyncClient: Initializing ZK Sync Client 13/12/24 00:02:42 INFO sync.ZooKeeperSyncClientImpl: Start connecting to Zookeeper! At janus.apache.org/67.195.138.60:41973 13/12/24 00:02:42 INFO zookeeper.ClientCnxn: Opening socket connection to server localhost/127.0.0.1:21810. Will not attempt to authenticate using SASL (unknown error) 13/12/24 00:02:42 INFO server.NIOServerCnxnFactory: Accepted socket connection from /127.0.0.1:58650 13/12/24 00:02:42 INFO zookeeper.ClientCnxn: Socket connection established to localhost/127.0.0.1:21810, initiating session 13/12/24 00:02:42 INFO server.ZooKeeperServer: Client attempting to establish new session at /127.0.0.1:58650 13/12/24 00:02:43 INFO server.ZooKeeperServer: Established session 0x14321e8fb530003 with negotiated timeout 6000 for client /127.0.0.1:58650 13/12/24 00:02:43 INFO zookeeper.ClientCnxn: Session establishment complete on server localhost/127.0.0.1:21810, sessionid = 0x14321e8fb530003, negotiated timeout = 6000 13/12/24 00:02:43 INFO graph.GraphJobRunner: 7 vertices are loaded into janus.apache.org:41973 13/12/24 00:02:45 INFO bsp.BSPJobClient: Current supersteps number: 8 13/12/24 00:02:48 INFO zookeeper.ClientCnxn: Client session timed out, have not heard from server in 4002ms for sessionid 0x14321e8fb530003, closing socket connection and attempting reconnect 13/12/24 00:02:48 WARN server.NIOServerCnxn: caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x14321e8fb530003, likely client has closed socket at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:220) at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208) at java.lang.Thread.run(Thread.java:724) 13/12/24 00:02:48 INFO server.NIOServerCnxn: Closed socket connection for client /127.0.0.1:58650 which had sessionid 0x14321e8fb530003 13/12/24 00:02:48 ERROR bsp.BSPTask: Error running bsp setup and bsp function. org.apache.hama.bsp.sync.SyncException at org.apache.hama.bsp.sync.ZooKeeperSyncClientImpl.enterBarrier(ZooKeeperSyncClientImpl.java:138) at org.apache.hama.bsp.BSPPeerImpl.enterBarrier(BSPPeerImpl.java:453) at org.apache.hama.bsp.BSPPeerImpl.sync(BSPPeerImpl.java:407) at org.apache.hama.graph.GraphJobRunner.bsp(GraphJobRunner.java:139) at org.apache.hama.bsp.BSPTask.runBSP(BSPTask.java:171) at org.apache.hama.bsp.BSPTask.run(BSPTask.java:144) at org.apache.hama.bsp.GroomServer$BSPPeerChild.main(GroomServer.java:1228) 13/12/24 00:02:49 WARN persistence.FileTxnLog: fsync-ing the write ahead log in SyncThread:0 took 4843ms which will adversely effect operation latency. See the ZooKeeper troubleshooting guide 13/12/24 00:02:49 ERROR server.NIOServerCnxn: Unexpected Exception: java.nio.channels.CancelledKeyException at sun.nio.ch.SelectionKeyImpl.ensureValid(SelectionKeyImpl.java:73) at sun.nio.ch.SelectionKeyImpl.interestOps(SelectionKeyImpl.java:77) at org.apache.zookeeper.server.NIOServerCnxn.sendBuffer(NIOServerCnxn.java:153) at org.apache.zookeeper.server.NIOServerCnxn.sendResponse(NIOServerCnxn.java:1076) at org.apache.zookeeper.server.FinalRequestProcessor.processRequest(FinalRequestProcessor.java:404) at org.apache.zookeeper.server.SyncRequestProcessor.flush(SyncRequestProcessor.java:167) at org.apache.zookeeper.server.SyncRequestProcessor.run(SyncRequestProcessor.java:101) 13/12/24 00:02:49 ERROR server.NIOServerCnxn: Unexpected Exception: java.nio.channels.CancelledKeyException at sun.nio.ch.SelectionKeyImpl.ensureValid(SelectionKeyImpl.java:73) at sun.nio.ch.SelectionKeyImpl.interestOps(SelectionKeyImpl.java:77) at org.apache.zookeeper.server.NIOServerCnxn.sendBuffer(NIOServerCnxn.java:153) at org.apache.zookeeper.server.NIOServerCnxn.sendResponse(NIOServerCnxn.java:1076) at org.apache.zookeeper.server.FinalRequestProcessor.processRequest(FinalRequestProcessor.java:170) at org.apache.zookeeper.server.SyncRequestProcessor.run(SyncRequestProcessor.java:138) 13/12/24 00:02:49 INFO zookeeper.ZooKeeper: Session: 0x14321e8fb530003 closed 13/12/24 00:02:49 INFO zookeeper.ClientCnxn: EventThread shut down 13/12/24 00:02:49 INFO ipc.Server: Stopping server on 41973 13/12/24 00:02:49 INFO ipc.Server: IPC Server handler 0 on 41973: exiting 13/12/24 00:02:49 INFO ipc.Server: Stopping IPC Server listener on 41973 13/12/24 00:02:49 INFO ipc.Server: Stopping IPC Server Responder 13/12/24 00:02:49 ERROR bsp.BSPTask: Shutting down ping service. 13/12/24 00:02:49 FATAL bsp.GroomServer: SyncError from child org.apache.hama.bsp.sync.SyncException at org.apache.hama.bsp.sync.ZooKeeperSyncClientImpl.enterBarrier(ZooKeeperSyncClientImpl.java:138) at org.apache.hama.bsp.BSPPeerImpl.enterBarrier(BSPPeerImpl.java:453) at org.apache.hama.bsp.BSPPeerImpl.sync(BSPPeerImpl.java:407) at org.apache.hama.graph.GraphJobRunner.bsp(GraphJobRunner.java:139) at org.apache.hama.bsp.BSPTask.runBSP(BSPTask.java:171) at org.apache.hama.bsp.BSPTask.run(BSPTask.java:144) at org.apache.hama.bsp.GroomServer$BSPPeerChild.main(GroomServer.java:1228) 13/12/24 00:02:49 FATAL bsp.GroomServer: Task: attempt_201312240002_0001_000000_0 - Killed : org.apache.hama.bsp.sync.SyncException 13/12/24 00:02:49 INFO bsp.GroomServer: About to purge task: attempt_201312240002_0001_000000_0 13/12/24 00:02:50 INFO bsp.JobInProgress: Taskid 'attempt_201312240002_0001_000000_0' has failed. 13/12/24 00:02:50 INFO bsp.TaskInProgress: Task 'task_201312240002_0001_000000' has failed. 13/12/24 00:02:50 INFO bsp.JobInProgress: Job failed. 13/12/24 00:02:50 INFO bsp.GroomServer: Kill 1 tasks. 13/12/24 00:02:51 INFO bsp.BSPJobClient: Current supersteps number: 0 13/12/24 00:02:51 WARN mortbay.log: /tasklog: java.io.IOException: Closed 13/12/24 00:02:51 WARN bsp.BSPJobClient: Error reading task outputhttp://janus.apache.org:40015/tasklog?plaintext=true&taskid=attempt_201312240002_0001_000000_0&filter=stdout 13/12/24 00:02:51 INFO bsp.BSPJobClient: Job failed. 13/12/24 00:02:51 INFO server.PrepRequestProcessor: Processed session termination for sessionid: 0x14321e8fb530000 13/12/24 00:02:54 INFO server.ZooKeeperServer: Expiring session 0x14321e8fb530003, timeout of 6000ms exceeded 13/12/24 00:02:54 INFO server.PrepRequestProcessor: Processed session termination for sessionid: 0x14321e8fb530003 13/12/24 00:02:55 WARN persistence.FileTxnLog: fsync-ing the write ahead log in SyncThread:0 took 4456ms which will adversely effect operation latency. See the ZooKeeper troubleshooting guide 13/12/24 00:02:55 INFO zookeeper.ZooKeeper: Session: 0x14321e8fb530000 closed 13/12/24 00:02:55 INFO zookeeper.ClientCnxn: EventThread shut down 13/12/24 00:02:55 INFO ipc.Server: Stopping server on 40000 13/12/24 00:02:55 INFO server.NIOServerCnxn: Closed socket connection for client /0:0:0:0:0:0:0:1:55250 which had sessionid 0x14321e8fb530000 13/12/24 00:02:55 INFO ipc.Server: Stopping IPC Server listener on 40000 13/12/24 00:02:55 INFO ipc.Server: IPC Server handler 0 on 40000: exiting 13/12/24 00:02:55 INFO ipc.Server: Stopping IPC Server Responder 13/12/24 00:02:55 INFO bsp.BSPMaster: Stopped RPC Master server. 13/12/24 00:02:55 INFO server.PrepRequestProcessor: Processed session termination for sessionid: 0x14321e8fb530001 13/12/24 00:02:56 INFO zookeeper.ZooKeeper: Session: 0x14321e8fb530001 closed 13/12/24 00:02:56 WARN server.NIOServerCnxn: caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x14321e8fb530001, likely client has closed socket at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:220) at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208) at java.lang.Thread.run(Thread.java:724) 13/12/24 00:02:56 INFO zookeeper.ClientCnxn: EventThread shut down 13/12/24 00:02:56 INFO server.NIOServerCnxn: Closed socket connection for client /0:0:0:0:0:0:0:1:55253 which had sessionid 0x14321e8fb530001 13/12/24 00:02:56 INFO ipc.Server: Stopping server on 56030 13/12/24 00:02:56 INFO ipc.Server: IPC Server handler 0 on 56030: exiting 13/12/24 00:02:56 INFO ipc.Server: Stopping IPC Server listener on 56030 13/12/24 00:02:56 INFO ipc.Server: Stopping server on 59618 13/12/24 00:02:56 INFO ipc.Server: Stopping IPC Server Responder 13/12/24 00:02:56 INFO ipc.Server: IPC Server handler 0 on 59618: exiting 13/12/24 00:02:56 INFO ipc.Server: IPC Server handler 3 on 59618: exiting 13/12/24 00:02:56 INFO ipc.Server: IPC Server handler 5 on 59618: exiting 13/12/24 00:02:56 INFO ipc.Server: IPC Server handler 4 on 59618: exiting 13/12/24 00:02:56 INFO ipc.Server: IPC Server handler 9 on 59618: exiting 13/12/24 00:02:56 INFO ipc.Server: Stopping IPC Server Responder 13/12/24 00:02:56 INFO ipc.Server: IPC Server handler 8 on 59618: exiting 13/12/24 00:02:56 INFO ipc.Server: IPC Server handler 2 on 59618: exiting 13/12/24 00:02:56 INFO ipc.Server: IPC Server handler 6 on 59618: exiting 13/12/24 00:02:56 INFO ipc.Server: Stopping IPC Server listener on 59618 13/12/24 00:02:56 INFO ipc.Server: IPC Server handler 1 on 59618: exiting 13/12/24 00:02:56 INFO ipc.Server: IPC Server handler 7 on 59618: exiting 13/12/24 00:02:56 INFO server.NIOServerCnxnFactory: NIOServerCnxn factory exited run method 13/12/24 00:02:56 INFO server.ZooKeeperServer: shutting down 13/12/24 00:02:56 INFO server.SessionTrackerImpl: Shutting down 13/12/24 00:02:56 INFO server.PrepRequestProcessor: Shutting down 13/12/24 00:02:56 INFO server.SyncRequestProcessor: Shutting down 13/12/24 00:02:56 INFO server.SyncRequestProcessor: SyncRequestProcessor exited! 13/12/24 00:02:56 INFO server.PrepRequestProcessor: PrepRequestProcessor exited loop! 13/12/24 00:02:56 INFO server.FinalRequestProcessor: shutdown of request processor complete Tests run: 1, Failures: 1, Errors: 0, Skipped: 0, Time elapsed: 0.022 sec <<< FAILURE! Results : Failed tests: testSubmitJob(org.apache.hama.graph.TestSubmitGraphJob) Tests run: 11, Failures: 1, Errors: 0, Skipped: 0 [INFO] ------------------------------------------------------------------------ [INFO] Reactor Summary: [INFO] [INFO] Apache Hama parent POM ............................ SUCCESS [9.468s] [INFO] pipes ............................................. SUCCESS [17.612s] [INFO] commons ........................................... SUCCESS [7.688s] [INFO] core .............................................. SUCCESS [3:24.625s] [INFO] graph ............................................. FAILURE [34.945s] [INFO] machine learning .................................. SKIPPED [INFO] examples .......................................... SKIPPED [INFO] hama-dist ......................................... SKIPPED [INFO] ------------------------------------------------------------------------ [INFO] BUILD FAILURE [INFO] ------------------------------------------------------------------------ [INFO] Total time: 4:39.299s [INFO] Finished at: Tue Dec 24 00:02:56 UTC 2013 [INFO] Final Memory: 69M/324M [INFO] ------------------------------------------------------------------------ [ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.6:test (default-test) on project hama-graph: There are test failures. [ERROR] [ERROR] Please refer to <https://builds.apache.org/job/Hama-Nightly-for-Hadoop-1.x/ws/trunk/graph/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 :hama-graph Build step 'Invoke top-level Maven targets' marked build as failure Archiving artifacts Recording test results Updating HAMA-831