See <https://builds.apache.org/job/Hama-Nightly/650/>
------------------------------------------
[...truncated 3586 lines...]
12/08/22 23:02:41 INFO ipc.NettyTransceiver: [id: 0x00457d21] OPEN
12/08/22 23:02:41 INFO ipc.NettyServer: [id: 0x01e152f4, /67.195.138.9:51495 =>
/67.195.138.9:61001] OPEN
12/08/22 23:02:41 INFO ipc.NettyServer: [id: 0x01e152f4, /67.195.138.9:51495 =>
/67.195.138.9:61001] BOUND: /67.195.138.9:61001
12/08/22 23:02:41 INFO ipc.NettyServer: [id: 0x01e152f4, /67.195.138.9:51495 =>
/67.195.138.9:61001] CONNECTED: /67.195.138.9:51495
12/08/22 23:02:41 INFO ipc.NettyTransceiver: [id: 0x00457d21,
/67.195.138.9:51495 => vesta.apache.org/67.195.138.9:61001] BOUND:
/67.195.138.9:51495
12/08/22 23:02:41 INFO ipc.NettyTransceiver: [id: 0x00457d21,
/67.195.138.9:51495 => vesta.apache.org/67.195.138.9:61001] CONNECTED:
vesta.apache.org/67.195.138.9:61001
12/08/22 23:02:41 INFO graph.GraphJobRunner: Loading finished at 1 steps.
12/08/22 23:02:41 INFO graph.GraphJobRunner: Loading finished at 1 steps.
12/08/22 23:02:41 INFO ipc.NettyTransceiver: Connecting to
vesta.apache.org/67.195.138.9:61002
12/08/22 23:02:41 INFO ipc.NettyTransceiver: [id: 0x00e0e515] OPEN
12/08/22 23:02:41 INFO ipc.NettyServer: [id: 0x00272961, /67.195.138.9:53155 =>
/67.195.138.9:61002] OPEN
12/08/22 23:02:41 INFO ipc.NettyServer: [id: 0x00272961, /67.195.138.9:53155 =>
/67.195.138.9:61002] BOUND: /67.195.138.9:61002
12/08/22 23:02:41 INFO ipc.NettyServer: [id: 0x00272961, /67.195.138.9:53155 =>
/67.195.138.9:61002] CONNECTED: /67.195.138.9:53155
12/08/22 23:02:41 INFO ipc.NettyTransceiver: [id: 0x00e0e515,
/67.195.138.9:53155 => vesta.apache.org/67.195.138.9:61002] BOUND:
/67.195.138.9:53155
12/08/22 23:02:41 INFO ipc.NettyTransceiver: [id: 0x00e0e515,
/67.195.138.9:53155 => vesta.apache.org/67.195.138.9:61002] CONNECTED:
vesta.apache.org/67.195.138.9:61002
12/08/22 23:02:41 INFO server.PrepRequestProcessor: Got user-level
KeeperException when processing sessionid:0x1395092bf150002 type:create
cxid:0x39 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error
Path:/bsp/job_201208222302_0001/sync/1/ready Error:KeeperErrorCode = NodeExists
for /bsp/job_201208222302_0001/sync/1/ready
12/08/22 23:02:41 INFO server.PrepRequestProcessor: Got user-level
KeeperException when processing sessionid:0x1395092bf150003 type:create
cxid:0x43 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error
Path:/bsp/job_201208222302_0001/sync/2 Error:KeeperErrorCode = NodeExists for
/bsp/job_201208222302_0001/sync/2
12/08/22 23:02:42 INFO server.PrepRequestProcessor: Got user-level
KeeperException when processing sessionid:0x1395092bf150003 type:create
cxid:0x61 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error
Path:/bsp/job_201208222302_0001/sync/3/ready Error:KeeperErrorCode = NodeExists
for /bsp/job_201208222302_0001/sync/3/ready
12/08/22 23:02:42 INFO server.PrepRequestProcessor: Got user-level
KeeperException when processing sessionid:0x1395092bf150002 type:create
cxid:0x69 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error
Path:/bsp/job_201208222302_0001/sync/4/ready Error:KeeperErrorCode = NodeExists
for /bsp/job_201208222302_0001/sync/4/ready
12/08/22 23:02:42 INFO server.PrepRequestProcessor: Got user-level
KeeperException when processing sessionid:0x1395092bf150003 type:create
cxid:0x81 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error
Path:/bsp/job_201208222302_0001/sync/5 Error:KeeperErrorCode = NodeExists for
/bsp/job_201208222302_0001/sync/5
12/08/22 23:02:42 INFO server.PrepRequestProcessor: Got user-level
KeeperException when processing sessionid:0x1395092bf150003 type:create
cxid:0xa3 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error
Path:/bsp/job_201208222302_0001/sync/7 Error:KeeperErrorCode = NodeExists for
/bsp/job_201208222302_0001/sync/7
12/08/22 23:02:42 ERROR bsp.BSPTask: Error running bsp setup and bsp function.
java.lang.NullPointerException
at
org.apache.hama.graph.GraphJobRunner.parseMessages(GraphJobRunner.java:368)
at org.apache.hama.graph.GraphJobRunner.bsp(GraphJobRunner.java:209)
at org.apache.hama.bsp.BSPTask.runBSP(BSPTask.java:166)
at org.apache.hama.bsp.BSPTask.run(BSPTask.java:143)
at
org.apache.hama.bsp.GroomServer$BSPPeerChild.main(GroomServer.java:1271)
12/08/22 23:02:42 INFO server.PrepRequestProcessor: Processed session
termination for sessionid: 0x1395092bf150003
12/08/22 23:02:42 INFO zookeeper.ZooKeeper: Session: 0x1395092bf150003 closed
12/08/22 23:02:42 INFO zookeeper.ClientCnxn: EventThread shut down
12/08/22 23:02:42 INFO server.NIOServerCnxn: Closed socket connection for
client /0:0:0:0:0:0:0:1:54003 which had sessionid 0x1395092bf150003
12/08/22 23:02:42 INFO ipc.NettyServer: [id: 0x00272961, /67.195.138.9:53155 :>
/67.195.138.9:61002] DISCONNECTED
12/08/22 23:02:42 INFO ipc.NettyServer: [id: 0x00272961, /67.195.138.9:53155 :>
/67.195.138.9:61002] UNBOUND
12/08/22 23:02:42 INFO ipc.NettyServer: [id: 0x00272961, /67.195.138.9:53155 :>
/67.195.138.9:61002] CLOSED
12/08/22 23:02:42 INFO ipc.NettyServer: [id: 0x001827d1, /67.195.138.9:53153 :>
/67.195.138.9:61002] DISCONNECTED
12/08/22 23:02:42 INFO ipc.NettyServer: [id: 0x001827d1, /67.195.138.9:53153 :>
/67.195.138.9:61002] UNBOUND
12/08/22 23:02:42 INFO ipc.NettyServer: [id: 0x001827d1, /67.195.138.9:53153 :>
/67.195.138.9:61002] CLOSED
12/08/22 23:02:42 INFO ipc.NettyTransceiver: [id: 0x0126d3df,
/67.195.138.9:53153 :> vesta.apache.org/67.195.138.9:61002] DISCONNECTED
12/08/22 23:02:42 INFO ipc.NettyTransceiver: [id: 0x00e0e515,
/67.195.138.9:53155 :> vesta.apache.org/67.195.138.9:61002] DISCONNECTED
12/08/22 23:02:42 INFO ipc.NettyTransceiver: [id: 0x00e0e515,
/67.195.138.9:53155 :> vesta.apache.org/67.195.138.9:61002] UNBOUND
12/08/22 23:02:42 INFO ipc.NettyTransceiver: [id: 0x00e0e515,
/67.195.138.9:53155 :> vesta.apache.org/67.195.138.9:61002] CLOSED
12/08/22 23:02:42 INFO ipc.NettyTransceiver: Remote peer
vesta.apache.org/67.195.138.9:61002 closed connection.
12/08/22 23:02:42 INFO ipc.NettyTransceiver: Disconnecting from
vesta.apache.org/67.195.138.9:61002
12/08/22 23:02:42 INFO ipc.NettyTransceiver: [id: 0x0126d3df,
/67.195.138.9:53153 :> vesta.apache.org/67.195.138.9:61002] UNBOUND
12/08/22 23:02:42 INFO ipc.NettyTransceiver: [id: 0x0126d3df,
/67.195.138.9:53153 :> vesta.apache.org/67.195.138.9:61002] CLOSED
12/08/22 23:02:42 INFO ipc.NettyTransceiver: Remote peer
vesta.apache.org/67.195.138.9:61002 closed connection.
12/08/22 23:02:42 INFO ipc.NettyTransceiver: Disconnecting from
vesta.apache.org/67.195.138.9:61002
12/08/22 23:02:42 ERROR bsp.BSPTask: Shutting down ping service.
12/08/22 23:02:42 FATAL bsp.GroomServer: Error running child
java.lang.NullPointerException
at
org.apache.hama.graph.GraphJobRunner.parseMessages(GraphJobRunner.java:368)
at org.apache.hama.graph.GraphJobRunner.bsp(GraphJobRunner.java:209)
at org.apache.hama.bsp.BSPTask.runBSP(BSPTask.java:166)
at org.apache.hama.bsp.BSPTask.run(BSPTask.java:143)
at
org.apache.hama.bsp.GroomServer$BSPPeerChild.main(GroomServer.java:1271)
java.lang.NullPointerException
at
org.apache.hama.graph.GraphJobRunner.parseMessages(GraphJobRunner.java:368)
at org.apache.hama.graph.GraphJobRunner.bsp(GraphJobRunner.java:209)
at org.apache.hama.bsp.BSPTask.runBSP(BSPTask.java:166)
at org.apache.hama.bsp.BSPTask.run(BSPTask.java:143)
at
org.apache.hama.bsp.GroomServer$BSPPeerChild.main(GroomServer.java:1271)
12/08/22 23:02:43 INFO bsp.BSPJobClient: Current supersteps number: 0
12/08/22 23:02:46 INFO bsp.BSPJobClient: Current supersteps number: 8
12/08/22 23:02:50 INFO bsp.GroomServer: adding purge task:
attempt_201208222302_0001_000001_0
12/08/22 23:02:50 INFO bsp.GroomServer: About to purge task:
attempt_201208222302_0001_000001_0
12/08/22 23:02:50 INFO ipc.NettyServer: [id: 0x01e152f4, /67.195.138.9:51495 :>
/67.195.138.9:61001] DISCONNECTED
12/08/22 23:02:50 INFO ipc.NettyServer: [id: 0x01e152f4, /67.195.138.9:51495 :>
/67.195.138.9:61001] UNBOUND
12/08/22 23:02:50 INFO ipc.NettyServer: [id: 0x01e152f4, /67.195.138.9:51495 :>
/67.195.138.9:61001] CLOSED
12/08/22 23:02:51 INFO bsp.JobInProgress: Taskid
'attempt_201208222302_0001_000001_0' has failed.
12/08/22 23:02:51 INFO bsp.TaskInProgress: Task 'task_201208222302_0001_000001'
has failed.
12/08/22 23:02:51 INFO bsp.JobInProgress: Job failed.
12/08/22 23:02:51 INFO bsp.GroomServer: Kill 1 tasks.
12/08/22 23:02:51 INFO bsp.GroomServer: Kill 1 tasks.
12/08/22 23:02:51 WARN server.NIOServerCnxn: EndOfStreamException: Unable to
read additional data from client sessionid 0x1395092bf150002, likely client has
closed socket
12/08/22 23:02:51 INFO server.NIOServerCnxn: Closed socket connection for
client /127.0.0.1:58548 which had sessionid 0x1395092bf150002
12/08/22 23:02:52 WARN mortbay.log: /tasklog: java.io.IOException: Closed
12/08/22 23:02:52 WARN bsp.BSPJobClient: Error reading task
outputhttp://vesta.apache.org:40015/tasklog?plaintext=true&taskid=attempt_201208222302_0001_000001_0&filter=stdout
12/08/22 23:02:52 INFO bsp.BSPJobClient: Job failed.
12/08/22 23:02:52 INFO server.PrepRequestProcessor: Processed session
termination for sessionid: 0x1395092bf150000
12/08/22 23:02:52 INFO zookeeper.ZooKeeper: Session: 0x1395092bf150000 closed
12/08/22 23:02:52 INFO zookeeper.ClientCnxn: EventThread shut down
12/08/22 23:02:52 INFO ipc.Server: Stopping server on 40000
12/08/22 23:02:52 INFO server.NIOServerCnxn: Closed socket connection for
client /127.0.0.1:58537 which had sessionid 0x1395092bf150000
12/08/22 23:02:52 INFO ipc.Server: IPC Server handler 0 on 40000: exiting
12/08/22 23:02:52 INFO ipc.Server: Stopping IPC Server listener on 40000
12/08/22 23:02:52 INFO metrics.RpcInstrumentation: shut down
12/08/22 23:02:52 INFO bsp.BSPMaster: Stopped RPC Master server.
12/08/22 23:02:52 INFO ipc.Server: Stopping IPC Server Responder
12/08/22 23:02:52 INFO server.PrepRequestProcessor: Processed session
termination for sessionid: 0x1395092bf150001
12/08/22 23:02:52 INFO zookeeper.ZooKeeper: Session: 0x1395092bf150001 closed
12/08/22 23:02:52 INFO zookeeper.ClientCnxn: EventThread shut down
12/08/22 23:02:52 INFO server.NIOServerCnxn: Closed socket connection for
client /127.0.0.1:58540 which had sessionid 0x1395092bf150001
12/08/22 23:02:52 INFO ipc.Server: Stopping server on 41652
12/08/22 23:02:52 INFO ipc.Server: IPC Server handler 0 on 41652: exiting
12/08/22 23:02:52 INFO ipc.Server: Stopping IPC Server Responder
12/08/22 23:02:52 INFO metrics.RpcInstrumentation: shut down
12/08/22 23:02:52 INFO ipc.Server: Stopping IPC Server listener on 41652
12/08/22 23:02:52 INFO ipc.Server: Stopping server on 34978
12/08/22 23:02:52 INFO ipc.Server: IPC Server handler 0 on 34978: exiting
12/08/22 23:02:52 INFO ipc.Server: IPC Server handler 2 on 34978: exiting
12/08/22 23:02:52 INFO ipc.Server: IPC Server handler 3 on 34978: exiting
12/08/22 23:02:52 INFO ipc.Server: IPC Server handler 4 on 34978: exiting
12/08/22 23:02:52 INFO ipc.Server: Stopping IPC Server Responder
12/08/22 23:02:52 INFO ipc.Server: IPC Server handler 6 on 34978: exiting
12/08/22 23:02:52 INFO ipc.Server: IPC Server handler 8 on 34978: exiting
12/08/22 23:02:52 INFO ipc.Server: Stopping IPC Server listener on 34978
12/08/22 23:02:52 INFO ipc.Server: IPC Server handler 9 on 34978: exiting
12/08/22 23:02:52 INFO metrics.RpcInstrumentation: shut down
12/08/22 23:02:52 INFO ipc.Server: IPC Server handler 5 on 34978: exiting
12/08/22 23:02:52 INFO ipc.Server: IPC Server handler 1 on 34978: exiting
12/08/22 23:02:52 INFO ipc.Server: IPC Server handler 7 on 34978: exiting
12/08/22 23:02:52 INFO server.NIOServerCnxn: NIOServerCnxn factory exited run
method
12/08/22 23:02:52 INFO server.PrepRequestProcessor: PrepRequestProcessor exited
loop!
12/08/22 23:02:52 INFO server.SyncRequestProcessor: SyncRequestProcessor exited!
12/08/22 23:02:52 INFO server.FinalRequestProcessor: shutdown of request
processor complete
Tests run: 1, Failures: 1, Errors: 0, Skipped: 0, Time elapsed: 0.018 sec <<<
FAILURE!
Results :
Failed tests:
testSubmitJob(org.apache.hama.graph.TestSubmitGraphJob)
Tests run: 1, Failures: 1, Errors: 0, Skipped: 0
[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary:
[INFO]
[INFO] Apache Hama parent POM ............................ SUCCESS [3.229s]
[INFO] core .............................................. SUCCESS [1:43.220s]
[INFO] graph ............................................. FAILURE [17.199s]
[INFO] machine learning .................................. SKIPPED
[INFO] examples .......................................... SKIPPED
[INFO] yarn .............................................. SKIPPED
[INFO] hama-dist ......................................... SKIPPED
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 2:05.893s
[INFO] Finished at: Wed Aug 22 23:02:52 UTC 2012
[INFO] Final Memory: 40M/190M
[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/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
