You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@zookeeper.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2017/03/01 09:59:21 UTC
ZooKeeper_branch35_openjdk7 - Build # 434 - Failure
See https://builds.apache.org/job/ZooKeeper_branch35_openjdk7/434/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 12.68 MB...]
[junit] java.net.ConnectException: Connection refused
[junit] at sun.nio.ch.SocketChannelImpl.checkConnect(Native Method)
[junit] at sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:739)
[junit] at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:357)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1214)
[junit] 2017-03-01 09:59:12,977 [myid:0] - INFO [Thread-40:QuorumPeer@1382] - maxSessionTimeout set to 80000
[junit] 2017-03-01 09:59:12,977 [myid:0] - INFO [Thread-40:QuorumPeer@1397] - initLimit set to 10
[junit] 2017-03-01 09:59:12,978 [myid:0] - INFO [Thread-40:FileSnap@83] - Reading snapshot /home/jenkins/jenkins-slave/workspace/ZooKeeper_branch35_openjdk7/build/test/tmp/test4328832484842730159.junit.dir/data/version-2/snapshot.0
[junit] 2017-03-01 09:59:12,981 [myid:] - INFO [Thread-41:QuorumPeerConfig@117] - Reading configuration from: /home/jenkins/jenkins-slave/workspace/ZooKeeper_branch35_openjdk7/build/test/tmp/test9083629394740626941.junit.dir/zoo.cfg
[junit] 2017-03-01 09:59:12,987 [myid:] - INFO [Thread-41:QuorumPeerConfig@317] - clientPort is not set
[junit] 2017-03-01 09:59:12,987 [myid:] - INFO [Thread-41:QuorumPeerConfig@331] - secureClientPort is not set
[junit] 2017-03-01 09:59:12,990 [myid:1] - INFO [Thread-41:DatadirCleanupManager@78] - autopurge.snapRetainCount set to 3
[junit] 2017-03-01 09:59:12,990 [myid:1] - INFO [Thread-41:DatadirCleanupManager@79] - autopurge.purgeInterval set to 0
[junit] 2017-03-01 09:59:12,991 [myid:1] - INFO [Thread-41:DatadirCleanupManager@101] - Purge task is not scheduled.
[junit] 2017-03-01 09:59:12,991 [myid:1] - INFO [Thread-41:ManagedUtil@46] - Log4j found with jmx enabled.
[junit] 2017-03-01 09:59:12,992 [myid:1] - ERROR [Thread-41:ManagedUtil@114] - Problems while registering log4j jmx beans!
[junit] javax.management.InstanceAlreadyExistsException: log4j:hiearchy=default
[junit] at com.sun.jmx.mbeanserver.Repository.addMBean(Repository.java:437)
[junit] at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.registerWithRepository(DefaultMBeanServerInterceptor.java:1898)
[junit] at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.registerDynamicMBean(DefaultMBeanServerInterceptor.java:966)
[junit] at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.registerObject(DefaultMBeanServerInterceptor.java:900)
[junit] at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.registerMBean(DefaultMBeanServerInterceptor.java:324)
[junit] at com.sun.jmx.mbeanserver.JmxMBeanServer.registerMBean(JmxMBeanServer.java:522)
[junit] at org.apache.zookeeper.jmx.ManagedUtil.registerLog4jMBeans(ManagedUtil.java:75)
[junit] at org.apache.zookeeper.server.quorum.QuorumPeerMain.runFromConfig(QuorumPeerMain.java:133)
[junit] at org.apache.zookeeper.server.quorum.QuorumPeerMain.initializeAndRun(QuorumPeerMain.java:120)
[junit] at org.apache.zookeeper.server.quorum.QuorumPeerTestBase$MainThread.run(QuorumPeerTestBase.java:245)
[junit] at java.lang.Thread.run(Thread.java:745)
[junit] 2017-03-01 09:59:12,993 [myid:1] - WARN [Thread-41:QuorumPeerMain@135] - Unable to register log4j JMX control
[junit] javax.management.JMException: javax.management.InstanceAlreadyExistsException: log4j:hiearchy=default
[junit] at org.apache.zookeeper.jmx.ManagedUtil.registerLog4jMBeans(ManagedUtil.java:115)
[junit] at org.apache.zookeeper.server.quorum.QuorumPeerMain.runFromConfig(QuorumPeerMain.java:133)
[junit] at org.apache.zookeeper.server.quorum.QuorumPeerMain.initializeAndRun(QuorumPeerMain.java:120)
[junit] at org.apache.zookeeper.server.quorum.QuorumPeerTestBase$MainThread.run(QuorumPeerTestBase.java:245)
[junit] at java.lang.Thread.run(Thread.java:745)
[junit] 2017-03-01 09:59:12,993 [myid:1] - INFO [Thread-41:QuorumPeerMain@138] - Starting quorum peer
[junit] 2017-03-01 09:59:12,977 [myid:] - INFO [ProcessThread(sid:5 cport:-1)::PrepRequestProcessor@655] - Processed session termination for sessionid: 0x4024979e4070006
[junit] 2017-03-01 09:59:12,982 [myid:] - INFO [HammerThread-42:ZooKeeper@1324] - Session: 0x4024979e4070006 closed
[junit] 2017-03-01 09:59:12,982 [myid:] - INFO [NIOWorkerThread-6:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=ReplicatedServer_id4,name1=replica.4,name2=Follower,name3=Connections,name4=127.0.0.1,name5=0x4024979e4070006]
[junit] 2017-03-01 09:59:12,983 [myid:] - INFO [HammerThread-42-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x4024979e4070006
[junit] 2017-03-01 09:59:12,983 [myid:] - INFO [NIOWorkerThread-6:NIOServerCnxn@614] - Closed socket connection for client /127.0.0.1:38145 which had sessionid 0x4024979e4070006
[junit] 2017-03-01 09:59:12,991 [myid:] - INFO [NIOWorkerThread-5:QuorumZooKeeperServer@132] - Submitting global closeSession request for session 0x1024979e4070007
[junit] 2017-03-01 09:59:13,043 [myid:] - INFO [NIOWorkerThread-8:QuorumZooKeeperServer@132] - Submitting global closeSession request for session 0x4024979e4070000
[junit] 2017-03-01 09:59:13,063 [myid:] - INFO [NIOWorkerThread-8:QuorumZooKeeperServer@132] - Submitting global closeSession request for session 0x4024979e4070009
[junit] 2017-03-01 09:59:13,066 [myid:] - INFO [NIOWorkerThread-4:QuorumZooKeeperServer@132] - Submitting global closeSession request for session 0x4024979e4070003
[junit] 2017-03-01 09:59:13,029 [myid:] - INFO [QuorumPeerListener:QuorumCnxManager$Listener@636] - My election bind port: /127.0.0.1:27772
[junit] 2017-03-01 09:59:13,043 [myid:] - INFO [main:QuorumBase@215] - start QuorumPeer 4
[junit] 2017-03-01 09:59:13,043 [myid:] - INFO [main:FileTxnSnapLog@320] - Snapshotting: 0x0 to /home/jenkins/jenkins-slave/workspace/ZooKeeper_branch35_openjdk7/build/test/tmp/test6182576027394076663.junit.dir/version-2/snapshot.0
[junit] 2017-03-01 09:59:13,043 [myid:] - INFO [main:QuorumPeer@798] - currentEpoch not found! Creating with a reasonable default of 0. This should only happen when you are upgrading your installation
Java HotSpot(TM) 64-Bit Server VM warning: INFO: os::commit_memory(0x00000007e1780000, 494927872, 0) failed; error='Cannot allocate memory' (errno=12)
#
# There is insufficient memory for the Java Runtime Environment to continue.
# Native memory allocation (malloc) failed to allocate 494927872 bytes for committing reserved memory.
# An error report file with more information is saved as:
# /home/jenkins/jenkins-slave/workspace/ZooKeeper_branch35_openjdk7/hs_err_pid17011.log
Build step 'Invoke Ant' marked build as failure
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
###################################################################################
############################## FAILED TESTS (if any) ##############################
All tests passed
ZooKeeper_branch35_openjdk7 - Build # 435 - Still Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See https://builds.apache.org/job/ZooKeeper_branch35_openjdk7/435/
###################################################################################
########################## LAST 60 LINES OF THE CONSOLE ###########################
[...truncated 61.40 MB...]
[junit] at org.jboss.netty.channel.socket.nio.AbstractNioSelector.run(AbstractNioSelector.java:315)
[junit] at org.jboss.netty.channel.socket.nio.AbstractNioWorker.run(AbstractNioWorker.java:89)
[junit] at org.jboss.netty.channel.socket.nio.NioWorker.run(NioWorker.java:178)
[junit] at org.jboss.netty.util.ThreadRenamingRunnable.run(ThreadRenamingRunnable.java:108)
[junit] at org.jboss.netty.util.internal.DeadLockProofWorker$1.run(DeadLockProofWorker.java:42)
[junit] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
[junit] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
[junit] at java.lang.Thread.run(Thread.java:745)
[junit] 2017-03-02 10:07:42,291 [myid:] - INFO [SyncThread:0:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port24933,name1=Connections,name2=127.0.0.1,name3=0x102b98f70cd0000]
[junit] 2017-03-02 10:07:42,319 [myid:127.0.0.1:24816] - INFO [main-SendThread(127.0.0.1:24816):ClientCnxn$SendThread@1113] - Opening socket connection to server 127.0.0.1/127.0.0.1:24816. Will not attempt to authenticate using SASL (unknown error)
[junit] 2017-03-02 10:07:42,320 [myid:127.0.0.1:24816] - WARN [main-SendThread(127.0.0.1:24816):ClientCnxn$SendThread@1235] - Session 0x302b98c1c360000 for server 127.0.0.1/127.0.0.1:24816, unexpected error, closing socket connection and attempting reconnect
[junit] java.net.ConnectException: Connection refused
[junit] at sun.nio.ch.SocketChannelImpl.checkConnect(Native Method)
[junit] at sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:739)
[junit] at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:357)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1214)
[junit] 2017-03-02 10:07:42,391 [myid:] - INFO [main:ZooKeeper@1324] - Session: 0x102b98f70cd0000 closed
[junit] 2017-03-02 10:07:42,392 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@82] - Memory used 213721
[junit] 2017-03-02 10:07:42,392 [myid:] - INFO [main-EventThread:ClientCnxn$EventThread@513] - EventThread shut down for session: 0x102b98f70cd0000
[junit] 2017-03-02 10:07:42,392 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@87] - Number of threads 2427
[junit] 2017-03-02 10:07:42,392 [myid:] - INFO [main:JUnit4ZKTestRunner$LoggedInvokeMethod@102] - FINISHED TEST METHOD testWatcherAutoResetWithLocal
[junit] 2017-03-02 10:07:42,393 [myid:] - INFO [main:ClientBase@543] - tearDown starting
[junit] 2017-03-02 10:07:42,393 [myid:] - INFO [main:ClientBase@513] - STOPPING server
[junit] 2017-03-02 10:07:42,393 [myid:] - INFO [main:NettyServerCnxnFactory@464] - shutdown called 0.0.0.0/0.0.0.0:24933
[junit] 2017-03-02 10:07:42,402 [myid:] - INFO [main:ZooKeeperServer@541] - shutting down
[junit] 2017-03-02 10:07:42,402 [myid:] - ERROR [main:ZooKeeperServer@505] - ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit] 2017-03-02 10:07:42,402 [myid:] - INFO [main:SessionTrackerImpl@232] - Shutting down
[junit] 2017-03-02 10:07:42,402 [myid:] - INFO [main:PrepRequestProcessor@973] - Shutting down
[junit] 2017-03-02 10:07:42,403 [myid:] - INFO [main:SyncRequestProcessor@191] - Shutting down
[junit] 2017-03-02 10:07:42,403 [myid:] - INFO [ProcessThread(sid:0 cport:24933)::PrepRequestProcessor@154] - PrepRequestProcessor exited loop!
[junit] 2017-03-02 10:07:42,403 [myid:] - INFO [SyncThread:0:SyncRequestProcessor@169] - SyncRequestProcessor exited!
[junit] 2017-03-02 10:07:42,403 [myid:] - INFO [main:FinalRequestProcessor@479] - shutdown of request processor complete
[junit] 2017-03-02 10:07:42,404 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port24933,name1=InMemoryDataTree]
[junit] 2017-03-02 10:07:42,404 [myid:] - INFO [main:MBeanRegistry@128] - Unregister MBean [org.apache.ZooKeeperService:name0=StandaloneServer_port24933]
[junit] 2017-03-02 10:07:42,404 [myid:] - INFO [main:FourLetterWordMain@85] - connecting to 127.0.0.1 24933
[junit] 2017-03-02 10:07:42,405 [myid:] - INFO [main:JMXEnv@146] - ensureOnly:[]
[junit] 2017-03-02 10:07:42,415 [myid:] - INFO [main:ClientBase@568] - fdcount after test is: 7135 at start it was 7135
[junit] 2017-03-02 10:07:42,416 [myid:] - INFO [main:ZKTestCase$1@65] - SUCCEEDED testWatcherAutoResetWithLocal
[junit] 2017-03-02 10:07:42,416 [myid:] - INFO [main:ZKTestCase$1@60] - FINISHED testWatcherAutoResetWithLocal
[junit] Tests run: 103, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 476.859 sec, Thread: 6, Class: org.apache.zookeeper.test.NioNettySuiteTest
[junit] 2017-03-02 10:07:42,716 [myid:127.0.0.1:24810] - INFO [main-SendThread(127.0.0.1:24810):ClientCnxn$SendThread@1113] - Opening socket connection to server 127.0.0.1/127.0.0.1:24810. Will not attempt to authenticate using SASL (unknown error)
[junit] 2017-03-02 10:07:42,717 [myid:127.0.0.1:24810] - WARN [main-SendThread(127.0.0.1:24810):ClientCnxn$SendThread@1235] - Session 0x102b98c1c300000 for server 127.0.0.1/127.0.0.1:24810, unexpected error, closing socket connection and attempting reconnect
[junit] java.net.ConnectException: Connection refused
[junit] at sun.nio.ch.SocketChannelImpl.checkConnect(Native Method)
[junit] at sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:739)
[junit] at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:357)
[junit] at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1214)
fail.build.on.test.failure:
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/ZooKeeper_branch35_openjdk7/build.xml:1211: The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/ZooKeeper_branch35_openjdk7/build.xml:1215: Tests failed!
Total time: 10 minutes 56 seconds
Build step 'Invoke Ant' marked build as failure
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
###################################################################################
############################## FAILED TESTS (if any) ##############################
1 tests failed.
FAILED: org.apache.zookeeper.test.ReadOnlyModeTest.testSessionEstablishment
Error Message:
KeeperErrorCode = ConnectionLoss for /test
Stack Trace:
org.apache.zookeeper.KeeperException$ConnectionLossException: KeeperErrorCode = ConnectionLoss for /test
at org.apache.zookeeper.KeeperException.create(KeeperException.java:99)
at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:1423)
at org.apache.zookeeper.test.ReadOnlyModeTest.testSessionEstablishment(ReadOnlyModeTest.java:238)
at org.apache.zookeeper.JUnit4ZKTestRunner$LoggedInvokeMethod.evaluate(JUnit4ZKTestRunner.java:79)
at java.util.concurrent.FutureTask.run(FutureTask.java:262)
at java.lang.Thread.run(Thread.java:745)