zookeeper-user mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Alexander Shraer <shra...@gmail.com>
Subject Re: Zookeeper 3.5.1 dynamic configuration fails with EOFException
Date Fri, 10 Jun 2016 18:16:43 GMT
In this specific case, the initial failure could be explained since server
1 will push its config to server 2, then server 2  finds out that instead
of observer
it must be a "non voting follower", which will cause it to throw an
exception and load a different stack of protocols, and restarts leader
election. This may
explain the failure. Then they connect normally and 2 becomes FOLLOWING and
gets an UPTODATE message as you see in the log. This looks ok.
At the end, 2 isn't a real follower, in order to add it to the ensemble you
need to issue a reconfig command.

On Fri, Jun 10, 2016 at 3:18 PM, Sebastian Mattheis <
Sebastian.Mattheis@bmw-carit.de> wrote:

> Zookeeper 3.5.1 (
> https://github.com/apache/zookeeper/releases/tag/release-3.5.1) dynamic
> configuration fails with two servers that are started one after the other
> throwing an EOFException. This is the same, if server 2 is configured as
> observer or participant. Is the usage wrong? Is this a known bug?
>
> # server.1:
>
> ## /opt/zookeeper/var/myid
> 1
>
> ## /opt/zookeeper/conf/zoo.cfg
> autopurge.purgeInterval=1
> initLimit=10
> syncLimit=5
> autopurge.snapRetainCount=4
> tickTime=2000
> dataDir=/opt/zookeeper/var
> dataLogDir=/opt/zookeeper/logs
> standaloneEnabled=false
> dynamicConfigFile=/opt/zookeeper/conf/zoo.cfg.dynamic
>
> ## /opt/zookeeper/conf/zoo.cfg.dynamic
> server.1=192.168.99.100:2888:3888;2181
>
> ## Output (on connection of server.2 after start-up):
>
> …
> 2016-06-09 09:22:32,309 [myid:1] - INFO
> [NIOServerCxnFactory.AcceptThread:/0.0.0.0:2181
> :NIOServerCnxnFactory$AcceptThread@296] - Accepted socket connection from
> /192.168.99.101:43222
> 2016-06-09 09:22:32,378 [myid:1] - INFO
> [NIOWorkerThread-1:ZooKeeperServer@964] - Client attempting to establish
> new session at /192.168.99.101:43222
> 2016-06-09 09:22:32,382 [myid:1] - INFO  [SyncThread:1:FileTxnLog@200] -
> Creating new log file: log.100000001
> 2016-06-09 09:22:32,392 [myid:1] - INFO
> [CommitProcWorkThread-1:ZooKeeperServer@678] - Established session
> 0x10001af5f770000 with negotiated timeout 30000 for client /
> 192.168.99.101:43222
> 2016-06-09 09:22:32,410 [myid:1] - WARN
> [NIOWorkerThread-1:NIOServerCnxn@365] - Unable to read additional data
> from client sessionid 0x10001af5f770000, likely client has closed socket
> 2016-06-09 09:22:32,411 [myid:1] - INFO
> [NIOWorkerThread-1:MBeanRegistry@119] - Unregister MBean
> [org.apache.ZooKeeperService:name0=ReplicatedServer_id1,name1=replica.1,name2=Leader,name3=Connections,name4=192.168.99.101,name5=0x10001af5f770000]
> 2016-06-09 09:22:32,412 [myid:1] - INFO
> [NIOWorkerThread-1:NIOServerCnxn@606] - Closed socket connection for
> client /192.168.99.101:43222 which had sessionid 0x10001af5f770000
> 2016-06-09 09:22:33,133 [myid:1] - INFO  [/192.168.99.100:3888
> :QuorumCnxManager$Listener@637] - Received connection request /
> 192.168.99.101:44396
> 2016-06-09 09:22:33,154 [myid:1] - WARN
> [RecvWorker:2:QuorumCnxManager$RecvWorker@917] - Connection broken for id
> 2, my id = 1, error =
> java.io.EOFException
>         at java.io.DataInputStream.readInt(DataInputStream.java:392)
>         at
> org.apache.zookeeper.server.quorum.QuorumCnxManager$RecvWorker.run(QuorumCnxManager.java:902)
> 2016-06-09 09:22:33,158 [myid:1] - WARN
> [RecvWorker:2:QuorumCnxManager$RecvWorker@920] - Interrupting SendWorker
> 2016-06-09 09:22:33,159 [myid:1] - WARN
> [SendWorker:2:QuorumCnxManager$SendWorker@834] - Interrupted while
> waiting for message on queue
> java.lang.InterruptedException
>         at
> java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.reportInterruptAfterWait(AbstractQueuedSynchronizer.java:2014)
>         at
> java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2088)
>         at
> java.util.concurrent.ArrayBlockingQueue.poll(ArrayBlockingQueue.java:418)
>         at
> org.apache.zookeeper.server.quorum.QuorumCnxManager.pollSendQueue(QuorumCnxManager.java:986)
>         at
> org.apache.zookeeper.server.quorum.QuorumCnxManager.access$500(QuorumCnxManager.java:63)
>         at
> org.apache.zookeeper.server.quorum.QuorumCnxManager$SendWorker.run(QuorumCnxManager.java:822)
> 2016-06-09 09:22:33,164 [myid:1] - WARN
> [SendWorker:2:QuorumCnxManager$SendWorker@843] - Send worker leaving
> thread  id 2 my id = 1
> 2016-06-09 09:22:33,348 [myid:1] - INFO  [/192.168.99.100:3888
> :QuorumCnxManager$Listener@637] - Received connection request /
> 192.168.99.101:44398
> 2016-06-09 09:22:33,352 [myid:1] - ERROR
> [SendWorker:2:QuorumCnxManager$SendWorker@810] - Failed to send last
> message. Shutting down thread.
> java.net.SocketException: Broken pipe
>         at java.net.SocketOutputStream.socketWrite0(Native Method)
>         at
> java.net.SocketOutputStream.socketWrite(SocketOutputStream.java:109)
>         at java.net.SocketOutputStream.write(SocketOutputStream.java:132)
>         at java.io.DataOutputStream.writeInt(DataOutputStream.java:200)
>         at
> org.apache.zookeeper.server.quorum.QuorumCnxManager$SendWorker.send(QuorumCnxManager.java:779)
>         at
> org.apache.zookeeper.server.quorum.QuorumCnxManager$SendWorker.run(QuorumCnxManager.java:806)
> 2016-06-09 09:22:33,359 [myid:1] - INFO  [/192.168.99.100:3888
> :QuorumCnxManager$Listener@637] - Received connection request /
> 192.168.99.101:44400
> 2016-06-09 09:22:33,365 [myid:1] - WARN
> [SendWorker:2:QuorumCnxManager$SendWorker@843] - Send worker leaving
> thread  id 2 my id = 1
> 2016-06-09 09:22:33,366 [myid:1] - WARN
> [RecvWorker:2:QuorumCnxManager$RecvWorker@920] - Interrupting SendWorker
> 2016-06-09 09:22:33,413 [myid:1] - INFO
> [LearnerHandler-/192.168.99.101:48832:LearnerHandler@385] - Follower sid:
> 2 not in the current config 100000000
> 2016-06-09 09:22:33,425 [myid:1] - INFO
> [LearnerHandler-/192.168.99.101:48832:LearnerHandler@683] - Synchronizing
> with Follower sid: 2 maxCommittedLog=0x100000001
> minCommittedLog=0x100000001 lastProcessedZxid=0x100000001 peerLastZxid=0x0
> 2016-06-09 09:22:33,427 [myid:1] - WARN
> [LearnerHandler-/192.168.99.101:48832:ZKDatabase@310] - Unable to find
> proposals from txnlog for zxid: 0
> 2016-06-09 09:22:33,430 [myid:1] - INFO
> [LearnerHandler-/192.168.99.101:48832:LearnerHandler@455] - Sending
> snapshot last zxid of peer is 0x0, zxid of leader is 0x100000001, send zxid
> of db as 0x100000001, 1 concurrent snapshots, snapshot was exempt from
> throttle
> 2016-06-09 09:23:03,908 [myid:1] - INFO
> [SessionTracker:ZooKeeperServer@384] - Expiring session
> 0x10001af5f770000, timeout of 30000ms exceeded
> 2016-06-09 09:23:03,909 [myid:1] - INFO
> [SessionTracker:QuorumZooKeeperServer@132] - Submitting global
> closeSession request for session 0x10001af5f770000
> 2016-06-09 09:23:03,910 [myid:1] - INFO  [ProcessThread(sid:1
> cport:-1)::PrepRequestProcessor@649] - Processed session termination for
> sessionid: 0x10001af5f770000
>
> # server.2:
>
> ## /opt/zookeeper/var/myid
> 2
>
> ## /opt/zookeeper/conf/zoo.cfg
>
> autopurge.purgeInterval=1
> initLimit=10
> syncLimit=5
> autopurge.snapRetainCount=4
> tickTime=2000
> dataDir=/opt/zookeeper/var
> dataLogDir=/opt/zookeeper/logs
> standaloneEnabled=false
> dynamicConfigFile=/opt/zookeeper/conf/zoo.cfg.dynamic
>
> ## /opt/zookeeper/conf/zoo.cfg.dynamic
> server.2=192.168.99.101:2888:3888:observer;2181
> server.1=192.168.99.100:2888:3888:participant;0.0.0.0:2181
>
> ## Output (on start-up):
>
> Using config: /opt/zookeeper/bin/../conf/zoo.cfg
> 2016-06-09 09:22:32,833 [myid:] - INFO  [main:QuorumPeerConfig@114] -
> Reading configuration from: /opt/zookeeper/bin/../conf/zoo.cfg
> 2016-06-09 09:22:32,847 [myid:] - INFO  [main:QuorumPeerConfig@306] -
> clientPort is not set
> 2016-06-09 09:22:32,848 [myid:] - INFO  [main:QuorumPeerConfig@320] -
> secureClientPort is not set
> 2016-06-09 09:22:32,853 [myid:] - WARN  [main:QuorumPeerConfig@555] - No
> server failure will be tolerated. You need at least 3 servers.
> 2016-06-09 09:22:32,863 [myid:2] - INFO  [main:DatadirCleanupManager@78]
> - autopurge.snapRetainCount set to 4
> 2016-06-09 09:22:32,863 [myid:2] - INFO  [main:DatadirCleanupManager@79]
> - autopurge.purgeInterval set to 1
> 2016-06-09 09:22:32,869 [myid:2] - INFO
> [PurgeTask:DatadirCleanupManager$PurgeTask@138] - Purge task started.
> 2016-06-09 09:22:32,888 [myid:2] - INFO  [main:QuorumPeerMain@136] -
> Starting quorum peer
> 2016-06-09 09:22:32,893 [myid:2] - INFO
> [PurgeTask:DatadirCleanupManager$PurgeTask@144] - Purge task completed.
> 2016-06-09 09:22:32,910 [myid:2] - INFO  [main:NIOServerCnxnFactory@673]
> - Configuring NIO connection handler with 10s sessionless connection
> timeout, 1 selector thread(s), 2 worker threads, and 64 kB direct buffers.
> 2016-06-09 09:22:32,916 [myid:2] - INFO  [main:NIOServerCnxnFactory@686]
> - binding to port /0.0.0.0:2181
> 2016-06-09 09:22:32,979 [myid:2] - INFO  [main:Slf4jLog@67] - Logging to
> org.slf4j.impl.Log4jLoggerAdapter(org.mortbay.log) via
> org.mortbay.log.Slf4jLog
> 2016-06-09 09:22:33,019 [myid:2] - INFO  [main:QuorumPeer@1280] - Local
> sessions disabled
> 2016-06-09 09:22:33,022 [myid:2] - INFO  [main:QuorumPeer@1291] - Local
> session upgrading disabled
> 2016-06-09 09:22:33,023 [myid:2] - INFO  [main:QuorumPeer@1258] -
> tickTime set to 2000
> 2016-06-09 09:22:33,023 [myid:2] - INFO  [main:QuorumPeer@1302] -
> minSessionTimeout set to 4000
> 2016-06-09 09:22:33,025 [myid:2] - INFO  [main:QuorumPeer@1313] -
> maxSessionTimeout set to 40000
> 2016-06-09 09:22:33,026 [myid:2] - INFO  [main:QuorumPeer@1328] -
> initLimit set to 10
> 2016-06-09 09:22:33,041 [myid:2] - INFO  [main:QuorumPeer@744] -
> currentEpoch not found! Creating with a reasonable default of 0. This
> should only happen when you are upgrading your installation
> 2016-06-09 09:22:33,056 [myid:2] - INFO  [main:QuorumPeer@759] -
> acceptedEpoch not found! Creating with a reasonable default of 0. This
> should only happen when you are upgrading your installation
> 2016-06-09 09:22:33,061 [myid:2] - INFO  [main:Slf4jLog@67] - jetty-6.1.26
> 2016-06-09 09:22:33,100 [myid:2] - INFO  [main:Slf4jLog@67] - Started
> SelectChannelConnector@0.0.0.0:8080
> 2016-06-09 09:22:33,104 [myid:2] - INFO  [main:JettyAdminServer@105] -
> Started AdminServer on address 0.0.0.0, port 8080 and command URL /commands
> 2016-06-09 09:22:33,112 [myid:2] - INFO
> [QuorumPeerListener:QuorumCnxManager$Listener@631] - My election bind
> port: /192.168.99.101:3888
> 2016-06-09 09:22:33,125 [myid:2] - INFO
> [QuorumPeer[myid=2](plain=/0:0:0:0:0:0:0:0:2181)(secure=disabled):QuorumPeer@986]
> - LOOKING
> 2016-06-09 09:22:33,127 [myid:2] - INFO
> [QuorumPeer[myid=2](plain=/0:0:0:0:0:0:0:0:2181)(secure=disabled):FastLeaderElection@894]
> - New election. My id =  2, proposed zxid=0x0
> 2016-06-09 09:22:33,142 [myid:2] - INFO
> [WorkerReceiver[myid=2]:FastLeaderElection@688] - Notification: 2
> (message format version), 2 (n.leader), 0x0 (n.zxid), 0x1 (n.round),
> LOOKING (n.state), 2 (n.sid), 0x0 (n.peerEPoch), LOOKING (my state)0
> (n.config version)
> 2016-06-09 09:22:33,150 [myid:2] - INFO
> [WorkerReceiver[myid=2]:FastLeaderElection$Messenger$WorkerReceiver@294]
> - 2 Received version: 100000000 my version: 0
> 2016-06-09 09:22:33,156 [myid:2] - INFO
> [WorkerReceiver[myid=2]:FastLeaderElection$Messenger$WorkerReceiver@301]
> - restarting leader election
> 2016-06-09 09:22:33,157 [myid:2] - INFO  [/192.168.99.101:3888
> :QuorumCnxManager$Listener@659] - Leaving listener
> 2016-06-09 09:22:33,163 [myid:2] - WARN
> [RecvWorker:1:QuorumCnxManager$RecvWorker@917] - Connection broken for id
> 1, my id = 2, error =
> java.net.SocketException: Socket closed
>         at java.net.SocketInputStream.socketRead0(Native Method)
>         at
> java.net.SocketInputStream.socketRead(SocketInputStream.java:116)
>         at java.net.SocketInputStream.read(SocketInputStream.java:170)
>         at java.net.SocketInputStream.read(SocketInputStream.java:141)
>         at java.net.SocketInputStream.read(SocketInputStream.java:223)
>         at java.io.DataInputStream.readInt(DataInputStream.java:387)
>         at
> org.apache.zookeeper.server.quorum.QuorumCnxManager$RecvWorker.run(QuorumCnxManager.java:902)
> 2016-06-09 09:22:33,166 [myid:2] - INFO
> [WorkerReceiver[myid=2]:FastLeaderElection$Messenger$WorkerReceiver@440]
> - WorkerReceiver is down
> 2016-06-09 09:22:33,166 [myid:2] - WARN
> [SendWorker:1:QuorumCnxManager$SendWorker@834] - Interrupted while
> waiting for message on queue
> java.lang.InterruptedException
>         at
> java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.reportInterruptAfterWait(AbstractQueuedSynchronizer.java:2014)
>         at
> java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2088)
>         at
> java.util.concurrent.ArrayBlockingQueue.poll(ArrayBlockingQueue.java:418)
>         at
> org.apache.zookeeper.server.quorum.QuorumCnxManager.pollSendQueue(QuorumCnxManager.java:986)
>         at
> org.apache.zookeeper.server.quorum.QuorumCnxManager.access$500(QuorumCnxManager.java:63)
>         at
> org.apache.zookeeper.server.quorum.QuorumCnxManager$SendWorker.run(QuorumCnxManager.java:822)
> 2016-06-09 09:22:33,173 [myid:2] - WARN
> [SendWorker:1:QuorumCnxManager$SendWorker@843] - Send worker leaving
> thread  id 1 my id = 2
> 2016-06-09 09:22:33,174 [myid:2] - WARN
> [RecvWorker:1:QuorumCnxManager$RecvWorker@920] - Interrupting SendWorker
> 2016-06-09 09:22:33,350 [myid:2] - INFO
> [QuorumPeer[myid=2](plain=/0:0:0:0:0:0:0:0:2181)(secure=disabled):FastLeaderElection@928]
> - Notification time out: 400
> 2016-06-09 09:22:33,353 [myid:2] - INFO
> [WorkerSender[myid=2]:FastLeaderElection$Messenger$WorkerSender@470] -
> WorkerSender is down
> 2016-06-09 09:22:33,354 [myid:2] - INFO
> [QuorumPeer[myid=2](plain=/0:0:0:0:0:0:0:0:2181)(secure=disabled):MBeanRegistry@119]
> - Unregister MBean
> [org.apache.ZooKeeperService:name0=ReplicatedServer_id2,name1=replica.2,name2=LeaderElection]
> 2016-06-09 09:22:33,355 [myid:2] - INFO
> [QuorumPeer[myid=2](plain=/0:0:0:0:0:0:0:0:2181)(secure=disabled):QuorumPeer@986]
> - LOOKING
> 2016-06-09 09:22:33,356 [myid:2] - WARN
> [RecvWorker:1:QuorumCnxManager$RecvWorker@920] - Interrupting SendWorker
> 2016-06-09 09:22:33,357 [myid:2] - INFO
> [QuorumPeer[myid=2](plain=/0:0:0:0:0:0:0:0:2181)(secure=disabled):FastLeaderElection@894]
> - New election. My id =  2, proposed zxid=0x0
> 2016-06-09 09:22:33,359 [myid:2] - INFO
> [QuorumPeerListener:QuorumCnxManager$Listener@631] - My election bind
> port: /192.168.99.101:3888
> 2016-06-09 09:22:33,358 [myid:2] - WARN
> [SendWorker:1:QuorumCnxManager$SendWorker@843] - Send worker leaving
> thread  id 1 my id = 2
> 2016-06-09 09:22:33,374 [myid:2] - INFO
> [WorkerReceiver[myid=2]:FastLeaderElection@688] - Notification: 2
> (message format version), 1 (n.leader), 0x0 (n.zxid), 0x1 (n.round),
> LEADING (n.state), 1 (n.sid), 0x1 (n.peerEPoch), LOOKING (my
> state)100000000 (n.config version)
> 2016-06-09 09:22:33,376 [myid:2] - INFO
> [QuorumPeer[myid=2](plain=/0:0:0:0:0:0:0:0:2181)(secure=disabled):MBeanRegistry@119]
> - Unregister MBean
> [org.apache.ZooKeeperService:name0=ReplicatedServer_id2,name1=replica.2,name2=LeaderElection]
> 2016-06-09 09:22:33,378 [myid:2] - INFO
> [QuorumPeer[myid=2](plain=/0:0:0:0:0:0:0:0:2181)(secure=disabled):QuorumPeer@1062]
> - FOLLOWING
> 2016-06-09 09:22:33,385 [myid:2] - INFO
> [QuorumPeer[myid=2](plain=/0:0:0:0:0:0:0:0:2181)(secure=disabled):Learner@88]
> - TCP NoDelay set to: true
> 2016-06-09 09:22:33,385 [myid:2] - INFO
> [WorkerReceiver[myid=2]:FastLeaderElection@688] - Notification: 2
> (message format version), 1 (n.leader), 0x0 (n.zxid), 0x1 (n.round),
> LEADING (n.state), 1 (n.sid), 0x1 (n.peerEPoch), FOLLOWING (my
> state)100000000 (n.config version)
> 2016-06-09 09:22:33,394 [myid:2] - INFO
> [QuorumPeer[myid=2](plain=/0:0:0:0:0:0:0:0:2181)(secure=disabled):Environment@109]
> - Server environment:zookeeper.version=3.5.1-alpha--1, built on 06/09/2016
> 09:19 GMT
> 2016-06-09 09:22:33,395 [myid:2] - INFO
> [QuorumPeer[myid=2](plain=/0:0:0:0:0:0:0:0:2181)(secure=disabled):Environment@109]
> - Server environment:host.name=footstep-server-2
> 2016-06-09 09:22:33,395 [myid:2] - INFO
> [QuorumPeer[myid=2](plain=/0:0:0:0:0:0:0:0:2181)(secure=disabled):Environment@109]
> - Server environment:java.version=1.8.0_91
> 2016-06-09 09:22:33,396 [myid:2] - INFO
> [QuorumPeer[myid=2](plain=/0:0:0:0:0:0:0:0:2181)(secure=disabled):Environment@109]
> - Server environment:java.vendor=Oracle Corporation
> 2016-06-09 09:22:33,396 [myid:2] - INFO
> [QuorumPeer[myid=2](plain=/0:0:0:0:0:0:0:0:2181)(secure=disabled):Environment@109]
> - Server environment:java.home=/usr/lib/jvm/java-8-openjdk-amd64/jre
> 2016-06-09 09:22:33,397 [myid:2] - INFO
> [QuorumPeer[myid=2](plain=/0:0:0:0:0:0:0:0:2181)(secure=disabled):Environment@109]
> - Server
> environment:java.class.path=/opt/zookeeper/bin/../build/classes:/opt/zookeeper/bin/../build/lib/slf4j-log4j12-1.7.5.jar:/opt/zookeeper/bin/../build/lib/slf4j-api-1.7.5.jar:/opt/zookeeper/bin/../build/lib/servlet-api-2.5-20081211.jar:/opt/zookeeper/bin/../build/lib/netty-3.7.0.Final.jar:/opt/zookeeper/bin/../build/lib/log4j-1.2.16.jar:/opt/zookeeper/bin/../build/lib/jline-2.11.jar:/opt/zookeeper/bin/../build/lib/jetty-util-6.1.26.jar:/opt/zookeeper/bin/../build/lib/jetty-6.1.26.jar:/opt/zookeeper/bin/../build/lib/javacc.jar:/opt/zookeeper/bin/../build/lib/jackson-mapper-asl-1.9.11.jar:/opt/zookeeper/bin/../build/lib/jackson-core-asl-1.9.11.jar:/opt/zookeeper/bin/../build/lib/commons-cli-1.2.jar:/opt/zookeeper/bin/../lib/*.jar:/opt/zookeeper/bin/../zookeeper-*.jar:/opt/zookeeper/bin/../src/java/lib/ivy-2.2.0.jar:/opt/zookeeper/bin/../conf:
> 2016-06-09 09:22:33,397 [myid:2] - INFO
> [QuorumPeer[myid=2](plain=/0:0:0:0:0:0:0:0:2181)(secure=disabled):Environment@109]
> - Server
> environment:java.library.path=/usr/java/packages/lib/amd64:/usr/lib/x86_64-linux-gnu/jni:/lib/x86_64-linux-gnu:/usr/lib/x86_64-linux-gnu:/usr/lib/jni:/lib:/usr/lib
> 2016-06-09 09:22:33,398 [myid:2] - INFO
> [QuorumPeer[myid=2](plain=/0:0:0:0:0:0:0:0:2181)(secure=disabled):Environment@109]
> - Server environment:java.io.tmpdir=/tmp
> 2016-06-09 09:22:33,398 [myid:2] - INFO
> [QuorumPeer[myid=2](plain=/0:0:0:0:0:0:0:0:2181)(secure=disabled):Environment@109]
> - Server environment:java.compiler=<NA>
> 2016-06-09 09:22:33,399 [myid:2] - INFO
> [QuorumPeer[myid=2](plain=/0:0:0:0:0:0:0:0:2181)(secure=disabled):Environment@109]
> - Server environment:os.name=Linux
> 2016-06-09 09:22:33,399 [myid:2] - INFO
> [QuorumPeer[myid=2](plain=/0:0:0:0:0:0:0:0:2181)(secure=disabled):Environment@109]
> - Server environment:os.arch=amd64
> 2016-06-09 09:22:33,399 [myid:2] - INFO
> [QuorumPeer[myid=2](plain=/0:0:0:0:0:0:0:0:2181)(secure=disabled):Environment@109]
> - Server environment:os.version=4.4.12-boot2docker
> 2016-06-09 09:22:33,400 [myid:2] - INFO
> [QuorumPeer[myid=2](plain=/0:0:0:0:0:0:0:0:2181)(secure=disabled):Environment@109]
> - Server environment:user.name=root
> 2016-06-09 09:22:33,401 [myid:2] - INFO
> [QuorumPeer[myid=2](plain=/0:0:0:0:0:0:0:0:2181)(secure=disabled):Environment@109]
> - Server environment:user.home=/root
> 2016-06-09 09:22:33,401 [myid:2] - INFO
> [QuorumPeer[myid=2](plain=/0:0:0:0:0:0:0:0:2181)(secure=disabled):Environment@109]
> - Server environment:user.dir=/
> 2016-06-09 09:22:33,401 [myid:2] - INFO
> [QuorumPeer[myid=2](plain=/0:0:0:0:0:0:0:0:2181)(secure=disabled):Environment@109]
> - Server environment:os.memory.free=9MB
> 2016-06-09 09:22:33,402 [myid:2] - INFO
> [QuorumPeer[myid=2](plain=/0:0:0:0:0:0:0:0:2181)(secure=disabled):Environment@109]
> - Server environment:os.memory.max=966MB
> 2016-06-09 09:22:33,402 [myid:2] - INFO
> [QuorumPeer[myid=2](plain=/0:0:0:0:0:0:0:0:2181)(secure=disabled):Environment@109]
> - Server environment:os.memory.total=15MB
> 2016-06-09 09:22:33,403 [myid:2] - INFO
> [QuorumPeer[myid=2](plain=/0:0:0:0:0:0:0:0:2181)(secure=disabled):ZooKeeperServer@858]
> - minSessionTimeout set to 4000
> 2016-06-09 09:22:33,404 [myid:2] - INFO
> [QuorumPeer[myid=2](plain=/0:0:0:0:0:0:0:0:2181)(secure=disabled):ZooKeeperServer@867]
> - maxSessionTimeout set to 40000
> 2016-06-09 09:22:33,405 [myid:2] - INFO
> [QuorumPeer[myid=2](plain=/0:0:0:0:0:0:0:0:2181)(secure=disabled):ZooKeeperServer@156]
> - Created server with tickTime 2000 minSessionTimeout 4000
> maxSessionTimeout 40000 datadir /opt/zookeeper/logs/version-2 snapdir
> /opt/zookeeper/var/version-2
> 2016-06-09 09:22:33,406 [myid:2] - INFO
> [QuorumPeer[myid=2](plain=/0:0:0:0:0:0:0:0:2181)(secure=disabled):Follower@66]
> - FOLLOWING - LEADER ELECTION TOOK - 28
> 2016-06-09 09:22:33,434 [myid:2] - INFO
> [QuorumPeer[myid=2](plain=/0:0:0:0:0:0:0:0:2181)(secure=disabled):Learner@369]
> - Getting a snapshot from leader
> 2016-06-09 09:22:33,442 [myid:2] - INFO
> [QuorumPeer[myid=2](plain=/0:0:0:0:0:0:0:0:2181)(secure=disabled):Learner@509]
> - Learner received NEWLEADER message
> 2016-06-09 09:22:33,446 [myid:2] - INFO
> [QuorumPeer[myid=2](plain=/0:0:0:0:0:0:0:0:2181)(secure=disabled):FileTxnSnapLog@298]
> - Snapshotting: 0x100000001 to
> /opt/zookeeper/var/version-2/snapshot.100000001
> 2016-06-09 09:22:33,452 [myid:2] - INFO
> [QuorumPeer[myid=2](plain=/0:0:0:0:0:0:0:0:2181)(secure=disabled):Learner@493]
> - Learner received UPTODATE message
> 2016-06-09 09:22:33,457 [myid:2] - INFO
> [QuorumPeer[myid=2](plain=/0:0:0:0:0:0:0:0:2181)(secure=disabled):CommitProcessor@254]
> - Configuring CommitProcessor with 1 worker threads.
>
>
>

Mime
  • Unnamed multipart/alternative (inline, None, 0 bytes)
View raw message