See <https://builds.apache.org/job/Hama-Nightly-for-Hadoop-1.x/1334/>
------------------------------------------ [...truncated 5082 lines...] 14/08/12 01:10:17 INFO server.ZooKeeperServer: Server environment:user.dir=/tmp 14/08/12 01:10:17 INFO server.ZooKeeperServer: tickTime set to 3000 14/08/12 01:10:17 INFO server.ZooKeeperServer: minSessionTimeout set to -1 14/08/12 01:10:17 INFO server.ZooKeeperServer: maxSessionTimeout set to 1200000 14/08/12 01:10:17 INFO server.NIOServerCnxnFactory: binding to port 0.0.0.0/0.0.0.0:20000 14/08/12 01:10:17 INFO persistence.FileSnap: Reading snapshot /tmp/hama-testzookeeper/version-2/snapshot.86 14/08/12 01:10:17 INFO persistence.FileTxnSnapLog: Snapshotting: 0x8b to /tmp/hama-testzookeeper/version-2/snapshot.8b 14/08/12 01:10:27 INFO zookeeper.ZooKeeper: Client environment:zookeeper.version=3.4.5-1392090, built on 09/30/2012 17:52 GMT 14/08/12 01:10:27 INFO zookeeper.ZooKeeper: Client environment:host.name=hemera.apache.org 14/08/12 01:10:27 INFO zookeeper.ZooKeeper: Client environment:java.version=1.7.0_25 14/08/12 01:10:27 INFO zookeeper.ZooKeeper: Client environment:java.vendor=Oracle Corporation 14/08/12 01:10:27 INFO zookeeper.ZooKeeper: Client environment:java.home=/x1/jenkins/tools/java/jdk1.7.0_25-32/jre 14/08/12 01:10:27 INFO zookeeper.ZooKeeper: Client environment:java.class.path=/tmp/surefirebooter2088623680677194255.jar 14/08/12 01:10:27 INFO zookeeper.ZooKeeper: Client environment:java.library.path=/usr/java/packages/lib/i386:/lib:/usr/lib 14/08/12 01:10:27 INFO zookeeper.ZooKeeper: Client environment:java.io.tmpdir=/tmp 14/08/12 01:10:27 INFO zookeeper.ZooKeeper: Client environment:java.compiler=<NA> 14/08/12 01:10:27 INFO zookeeper.ZooKeeper: Client environment:os.name=Linux 14/08/12 01:10:27 INFO zookeeper.ZooKeeper: Client environment:os.arch=i386 14/08/12 01:10:27 INFO zookeeper.ZooKeeper: Client environment:os.version=3.2.0-67-generic 14/08/12 01:10:27 INFO zookeeper.ZooKeeper: Client environment:user.name=jenkins 14/08/12 01:10:27 INFO zookeeper.ZooKeeper: Client environment:user.home=/home/jenkins 14/08/12 01:10:27 INFO zookeeper.ZooKeeper: Client environment:user.dir=/tmp 14/08/12 01:10:27 INFO zookeeper.ZooKeeper: Initiating client connection, connectString=localhost:20000 sessionTimeout=1200000 watcher=org.apache.hama.bsp.sync.ZKSyncBSPMasterClient@146ee3f 14/08/12 01:10:27 INFO sync.ZKSyncBSPMasterClient: Initialized ZK false 14/08/12 01:10:27 INFO sync.ZKSyncClient: Initializing ZK Sync Client 14/08/12 01:10:27 INFO zookeeper.ClientCnxn: Opening socket connection to server localhost/127.0.0.1:20000. Will not attempt to authenticate using SASL (unknown error) 14/08/12 01:10:27 INFO zookeeper.ClientCnxn: Socket connection established to localhost/127.0.0.1:20000, initiating session 14/08/12 01:10:27 INFO server.NIOServerCnxnFactory: Accepted socket connection from /127.0.0.1:40593 14/08/12 01:10:27 INFO server.ZooKeeperServer: Client attempting to establish new session at /127.0.0.1:40593 14/08/12 01:10:27 INFO persistence.FileTxnLog: Creating new log file: log.8c 14/08/12 01:10:27 INFO server.ZooKeeperServer: Established session 0x147c7c4039e0000 with negotiated timeout 1200000 for client /127.0.0.1:40593 14/08/12 01:10:27 INFO zookeeper.ClientCnxn: Session establishment complete on server localhost/127.0.0.1:20000, sessionid = 0x147c7c4039e0000, negotiated timeout = 1200000 14/08/12 01:10:27 INFO mortbay.log: Logging to org.slf4j.impl.Log4jLoggerAdapter(org.mortbay.log) via org.mortbay.log.Slf4jLog 14/08/12 01:10:27 INFO mortbay.log: Created master and client sync clients 14/08/12 01:10:27 INFO mortbay.log: BSP root exists 14/08/12 01:10:27 INFO zookeeper.ZooKeeper: Initiating client connection, connectString=localhost:20000 sessionTimeout=1200000 watcher=org.apache.hama.bsp.sync.ZooKeeperSyncClientImpl@7175af 14/08/12 01:10:27 INFO sync.ZKSyncClient: Initializing ZK Sync Client 14/08/12 01:10:27 INFO zookeeper.ClientCnxn: Opening socket connection to server localhost/0:0:0:0:0:0:0:1:20000. Will not attempt to authenticate using SASL (unknown error) 14/08/12 01:10:27 INFO sync.ZooKeeperSyncClientImpl: Start connecting to Zookeeper! At /0.0.0.0:21815 14/08/12 01:10:27 INFO zookeeper.ClientCnxn: Socket connection established to localhost/0:0:0:0:0:0:0:1:20000, initiating session 14/08/12 01:10:27 INFO server.NIOServerCnxnFactory: Accepted socket connection from /0:0:0:0:0:0:0:1:44433 14/08/12 01:10:27 INFO server.ZooKeeperServer: Client attempting to establish new session at /0:0:0:0:0:0:0:1:44433 14/08/12 01:10:27 INFO server.ZooKeeperServer: Established session 0x147c7c4039e0001 with negotiated timeout 1200000 for client /0:0:0:0:0:0:0:1:44433 14/08/12 01:10:27 INFO zookeeper.ClientCnxn: Session establishment complete on server localhost/0:0:0:0:0:0:0:1:20000, sessionid = 0x147c7c4039e0001, negotiated timeout = 1200000 14/08/12 01:10:27 INFO sync.ZKSyncClient: Writing data /bsp/job_test1_0001/info/level2 14/08/12 01:10:27 INFO mortbay.log: Found child count = 2 14/08/12 01:10:27 INFO mortbay.log: Passed the child count test 14/08/12 01:10:27 INFO mortbay.log: Found child count = 2 14/08/12 01:10:27 INFO mortbay.log: Peer name 2 14/08/12 01:10:27 INFO mortbay.log: Peer name 1 14/08/12 01:10:27 INFO mortbay.log: Passed the child key set test 14/08/12 01:10:27 INFO mortbay.log: /bsp/job_test1_0001 14/08/12 01:10:28 INFO mortbay.log: Passed the key presence test 14/08/12 01:10:28 INFO sync.ZKSyncClient: Writing data /bsp/job_test1_0001/info/level3 14/08/12 01:10:28 INFO mortbay.log: Passed array writable test 14/08/12 01:10:28 INFO server.NIOServerCnxn: Closed socket connection for client /0:0:0:0:0:0:0:1:44433 which had sessionid 0x147c7c4039e0001 14/08/12 01:10:28 INFO zookeeper.ClientCnxn: Unable to read additional data from server sessionid 0x147c7c4039e0001, likely server has closed socket, closing socket connection and attempting reconnect 14/08/12 01:10:28 INFO server.NIOServerCnxn: Closed socket connection for client /127.0.0.1:40593 which had sessionid 0x147c7c4039e0000 14/08/12 01:10:28 INFO zookeeper.ClientCnxn: Unable to read additional data from server sessionid 0x147c7c4039e0000, likely server has closed socket, closing socket connection and attempting reconnect 14/08/12 01:10:28 INFO server.NIOServerCnxnFactory: NIOServerCnxn factory exited run method 14/08/12 01:10:28 INFO server.ZooKeeperServer: shutting down 14/08/12 01:10:28 INFO server.ZooKeeperServer: shutting down 14/08/12 01:10:28 INFO server.SessionTrackerImpl: Shutting down 14/08/12 01:10:28 INFO server.SessionTrackerImpl: Shutting down 14/08/12 01:10:28 INFO server.PrepRequestProcessor: Shutting down 14/08/12 01:10:28 INFO server.PrepRequestProcessor: Shutting down 14/08/12 01:10:28 INFO server.SyncRequestProcessor: Shutting down 14/08/12 01:10:28 INFO server.PrepRequestProcessor: PrepRequestProcessor exited loop! 14/08/12 01:10:28 INFO server.SyncRequestProcessor: Shutting down 14/08/12 01:10:28 INFO server.SyncRequestProcessor: SyncRequestProcessor exited! 14/08/12 01:10:28 INFO server.FinalRequestProcessor: shutdown of request processor complete 14/08/12 01:10:28 INFO server.FinalRequestProcessor: shutdown of request processor complete 14/08/12 01:10:28 WARN jmx.MBeanRegistry: Failed to unregister MBean InMemoryDataTree 14/08/12 01:10:28 WARN jmx.MBeanRegistry: Error during unregister javax.management.InstanceNotFoundException: org.apache.ZooKeeperService:name0=StandaloneServer_port-1,name1=InMemoryDataTree at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getMBean(DefaultMBeanServerInterceptor.java:1095) at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:427) at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:415) at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:546) at org.apache.zookeeper.jmx.MBeanRegistry.unregister(MBeanRegistry.java:115) at org.apache.zookeeper.jmx.MBeanRegistry.unregister(MBeanRegistry.java:132) at org.apache.zookeeper.server.ZooKeeperServer.unregisterJMX(ZooKeeperServer.java:443) at org.apache.zookeeper.server.ZooKeeperServer.shutdown(ZooKeeperServer.java:436) at org.apache.zookeeper.server.NIOServerCnxnFactory.shutdown(NIOServerCnxnFactory.java:271) at org.apache.zookeeper.server.ZooKeeperServerMain.shutdown(ZooKeeperServerMain.java:127) at org.apache.hama.zookeeper.QuorumPeer$ShutdownableZooKeeperServerMain.shutdown(QuorumPeer.java:407) at org.apache.hama.zookeeper.QuorumPeer$ShutdownableZooKeeperServerMain.shutdownZookeeperMain(QuorumPeer.java:402) at org.apache.hama.bsp.sync.ZooKeeperSyncServerImpl.stopServer(ZooKeeperSyncServerImpl.java:88) at org.apache.hama.bsp.TestZooKeeper.testClearZKNodes(TestZooKeeper.java:187) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:606) at junit.framework.TestCase.runTest(TestCase.java:168) at junit.framework.TestCase.runBare(TestCase.java:134) at junit.framework.TestResult$1.protect(TestResult.java:110) at junit.framework.TestResult.runProtected(TestResult.java:128) at junit.framework.TestResult.run(TestResult.java:113) at junit.framework.TestCase.run(TestCase.java:124) at junit.framework.TestSuite.runTest(TestSuite.java:232) at junit.framework.TestSuite.run(TestSuite.java:227) at org.junit.internal.runners.JUnit38ClassRunner.run(JUnit38ClassRunner.java:83) at org.junit.runners.Suite.runChild(Suite.java:128) at org.junit.runners.Suite.runChild(Suite.java:24) at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193) at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52) at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191) at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42) at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184) at org.junit.runners.ParentRunner.run(ParentRunner.java:236) at org.junit.runner.JUnitCore.run(JUnitCore.java:157) at org.junit.runner.JUnitCore.run(JUnitCore.java:136) at org.junit.runner.JUnitCore.run(JUnitCore.java:127) at org.apache.maven.surefire.junitcore.JUnitCoreTestSet.runJunitCore(JUnitCoreTestSet.java:208) at org.apache.maven.surefire.junitcore.JUnitCoreTestSet.execute(JUnitCoreTestSet.java:95) at org.apache.maven.surefire.junitcore.JUnitCoreTestSet.execute(JUnitCoreTestSet.java:82) at org.apache.maven.surefire.junitcore.JUnitCoreDirectoryTestSuite.execute(JUnitCoreDirectoryTestSuite.java:84) at org.apache.maven.surefire.Surefire.run(Surefire.java:104) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:606) at org.apache.maven.surefire.booter.SurefireBooter.runSuitesInProcess(SurefireBooter.java:290) at org.apache.maven.surefire.booter.SurefireBooter.main(SurefireBooter.java:1017) Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.016 sec Running org.apache.hama.zookeeper.TestZKTools Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.014 sec Results : Tests in error: Tests run: 68, Failures: 0, Errors: 1, Skipped: 0 [INFO] ------------------------------------------------------------------------ [INFO] Reactor Summary: [INFO] [INFO] Apache Hama parent POM ............................ SUCCESS [6.024s] [INFO] pipes ............................................. SUCCESS [14.076s] [INFO] commons ........................................... SUCCESS [7.380s] [INFO] core .............................................. FAILURE [2:53.821s] [INFO] graph ............................................. SKIPPED [INFO] machine learning .................................. SKIPPED [INFO] examples .......................................... SKIPPED [INFO] mesos ............................................. SKIPPED [INFO] hama-dist ......................................... SKIPPED [INFO] ------------------------------------------------------------------------ [INFO] BUILD FAILURE [INFO] ------------------------------------------------------------------------ [INFO] Total time: 3:22.000s [INFO] Finished at: Tue Aug 12 01:10:28 UTC 2014 [INFO] Final Memory: 51M/355M [INFO] ------------------------------------------------------------------------ [ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.6:test (default-test) on project hama-core: There are test failures. [ERROR] [ERROR] Please refer to /x1/jenkins/jenkins-slave/workspace/Hama-Nightly-for-Hadoop-1.x/trunk/core/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-core Build step 'Invoke top-level Maven targets' marked build as failure Archiving artifacts Sending artifact delta relative to Hama-Nightly-for-Hadoop-1.x #1331 Archived 74 artifacts Archive block size is 32768 Received 1007 blocks and 232786 bytes Compression is 99.3% Took 3.3 sec Recording test results