See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/2085/changes>
Changes: [vinod] Introduced exponential backoff for slave registration retries. [bmahler] Fixed a compiler warning in Statistics. ------------------------------------------ [...truncated 41177 lines...] I0424 05:59:44.519804 23016 registrar.cpp:388] Attempting to update the 'registry' I0424 05:59:44.521528 23017 log.cpp:680] Attempting to append 137 bytes to the log I0424 05:59:44.521610 23022 coordinator.cpp:339] Coordinator attempting to write APPEND action at position 1 I0424 05:59:44.521957 23018 replica.cpp:508] Replica received write request for position 1 I0424 05:59:44.525598 23018 leveldb.cpp:341] Persisting action (156 bytes) to leveldb took 3.619311ms I0424 05:59:44.525615 23018 replica.cpp:664] Persisted action at 1 I0424 05:59:44.526011 23015 replica.cpp:643] Replica received learned notice for position 1 I0424 05:59:44.533926 23015 leveldb.cpp:341] Persisting action (158 bytes) to leveldb took 7.896259ms I0424 05:59:44.533946 23015 replica.cpp:664] Persisted action at 1 I0424 05:59:44.533956 23015 replica.cpp:649] Replica learned APPEND action at position 1 I0424 05:59:44.534221 23018 registrar.cpp:436] Successfully updated 'registry' I0424 05:59:44.534308 23021 log.cpp:699] Attempting to truncate the log to 1 I0424 05:59:44.534349 23018 master.cpp:800] Recovered 0 slaves from the Registry (99B) ; allowing 75secs for slaves to re-register I0424 05:59:44.534354 23021 coordinator.cpp:339] Coordinator attempting to write TRUNCATE action at position 2 I0424 05:59:44.534719 23022 replica.cpp:508] Replica received write request for position 2 2014-04-24 05:59:44,535:22994(0x2af03cdf6700):ZOO_INFO@log_env@712: Client environment:zookeeper.version=zookeeper C client 3.4.5 2014-04-24 05:59:44,535:22994(0x2af03cdf6700):ZOO_INFO@log_env@716: Client environment:host.name=juno 2014-04-24 05:59:44,535:22994(0x2af03cdf6700):ZOO_INFO@log_env@723: Client environment:os.name=Linux 2014-04-24 05:59:44,535:22994(0x2af03cdf6700):ZOO_INFO@log_env@724: Client environment:os.arch=3.2.0-51-generic 2014-04-24 05:59:44,535:22994(0x2af03cdf6700):ZOO_INFO@log_env@725: Client environment:os.version=#77-Ubuntu SMP Wed Jul 24 20:18:19 UTC 2013 2014-04-24 05:59:44,535:22994(0x2af03cdf6700):ZOO_INFO@log_env@733: Client environment:user.name=(null) 2014-04-24 05:59:44,535:22994(0x2af03cdf6700):ZOO_INFO@log_env@741: Client environment:user.home=/home/jenkins 2014-04-24 05:59:44,535:22994(0x2af03cdf6700):ZOO_INFO@log_env@753: Client environment:user.dir=<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/ws/build/mesos-0.19.0/_build/src> 2014-04-24 05:59:44,535:22994(0x2af03cdf6700):ZOO_INFO@zookeeper_init@786: Initiating client connection, host=127.0.0.1:49267 sessionTimeout=10000 watcher=0x2af03a93bc00 sessionId=0 sessionPasswd=<null> context=0x2af04007f7a0 flags=0 I0424 05:59:44.535655 23021 slave.cpp:130] Slave started on 145)@67.195.138.61:47981 I0424 05:59:44.535781 23021 slave.cpp:218] Slave resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] 2014-04-24 05:59:44,535:22994(0x2af1d5972700):ZOO_INFO@check_events@1703: initiated connection to server [127.0.0.1:49267] I0424 05:59:44.535876 23021 slave.cpp:246] Slave hostname: juno.apache.org I0424 05:59:44.535887 23021 slave.cpp:247] Slave checkpoint: false I0424 05:59:44.536337 23017 state.cpp:33] Recovering state from '/tmp/MasterZooKeeperTest_LostZooKeeperCluster_tGse2g/meta' 2014-04-24 05:59:44,536:22994(0x2af03cff7700):ZOO_INFO@log_env@712: Client environment:zookeeper.version=zookeeper C client 3.4.5 2014-04-24 05:59:44,536:22994(0x2af03cff7700):ZOO_INFO@log_env@716: Client environment:host.name=juno 2014-04-24 05:59:44,536:22994(0x2af03cff7700):ZOO_INFO@log_env@723: Client environment:os.name=Linux 2014-04-24 05:59:44,536:22994(0x2af03cff7700):ZOO_INFO@log_env@724: Client environment:os.arch=3.2.0-51-generic 2014-04-24 05:59:44,536:22994(0x2af03cff7700):ZOO_INFO@log_env@725: Client environment:os.version=#77-Ubuntu SMP Wed Jul 24 20:18:19 UTC 2013 I0424 05:59:44.536731 22994 sched.cpp:121] Version: 0.19.0 I0424 05:59:44.536749 23019 status_update_manager.cpp:193] Recovering status update manager 2014-04-24 05:59:44,536:22994(0x2af03cff7700):ZOO_INFO@log_env@733: Client environment:user.name=(null) 2014-04-24 05:59:44,536:22994(0x2af03cff7700):ZOO_INFO@log_env@741: Client environment:user.home=/home/jenkins 2014-04-24 05:59:44,536:22994(0x2af03cff7700):ZOO_INFO@log_env@753: Client environment:user.dir=<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/ws/build/mesos-0.19.0/_build/src> 2014-04-24 05:59:44,536:22994(0x2af03cff7700):ZOO_INFO@zookeeper_init@786: Initiating client connection, host=127.0.0.1:49267 sessionTimeout=10000 watcher=0x2af03a93bc00 sessionId=0 sessionPasswd=<null> context=0x2af07804d0a0 flags=0 I0424 05:59:44.536998 23015 slave.cpp:2802] Finished recovery 2014-04-24 05:59:44,537:22994(0x2af1f0200700):ZOO_INFO@check_events@1703: initiated connection to server [127.0.0.1:49267] I0424 05:59:44.542258 23022 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 7.519651ms I0424 05:59:44.542280 23022 replica.cpp:664] Persisted action at 2 I0424 05:59:44.542539 23019 replica.cpp:643] Replica received learned notice for position 2 I0424 05:59:44.562832 23019 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 20.276891ms I0424 05:59:44.562872 23019 leveldb.cpp:399] Deleting ~1 keys from leveldb took 14018ns I0424 05:59:44.562882 23019 replica.cpp:664] Persisted action at 2 I0424 05:59:44.562892 23019 replica.cpp:649] Replica learned TRUNCATE action at position 2 2014-04-24 05:59:44,563:22994(0x2af1d5972700):ZOO_INFO@check_events@1750: session establishment complete on server [127.0.0.1:49267], sessionId=0x145925178f80002, negotiated timeout=10000 I0424 05:59:44.563285 23019 group.cpp:310] Group process ((3729)@67.195.138.61:47981) connected to ZooKeeper I0424 05:59:44.563302 23019 group.cpp:778] Syncing group operations: queue size (joins, cancels, datas) = (0, 0, 0) I0424 05:59:44.563309 23019 group.cpp:382] Trying to create path '/znode' in ZooKeeper 2014-04-24 05:59:44,571:22994(0x2af1f0200700):ZOO_INFO@check_events@1750: session establishment complete on server [127.0.0.1:49267], sessionId=0x145925178f80003, negotiated timeout=10000 I0424 05:59:44.571391 23015 group.cpp:310] Group process ((3735)@67.195.138.61:47981) connected to ZooKeeper I0424 05:59:44.571406 23015 group.cpp:778] Syncing group operations: queue size (joins, cancels, datas) = (0, 0, 0) I0424 05:59:44.571414 23015 group.cpp:382] Trying to create path '/znode' in ZooKeeper I0424 05:59:44.572286 23016 detector.cpp:134] Detected a new leader: (id='0') I0424 05:59:44.572386 23016 group.cpp:655] Trying to get '/znode/info_0000000000' in ZooKeeper I0424 05:59:44.572566 23018 detector.cpp:134] Detected a new leader: (id='0') I0424 05:59:44.572722 23021 group.cpp:655] Trying to get '/znode/info_0000000000' in ZooKeeper I0424 05:59:44.573333 23016 detector.cpp:376] A new leading master ([email protected]:47981) is detected I0424 05:59:44.573429 23019 slave.cpp:497] New master detected at [email protected]:47981 I0424 05:59:44.573487 23016 status_update_manager.cpp:167] New master detected at [email protected]:47981 I0424 05:59:44.573515 23019 slave.cpp:731] Will retry registration in 7.107908139secs if necessary I0424 05:59:44.573545 23019 slave.cpp:522] Detecting new master I0424 05:59:44.573729 23017 registrar.cpp:388] Attempting to update the 'registry' I0424 05:59:44.573765 23021 detector.cpp:376] A new leading master ([email protected]:47981) is detected I0424 05:59:44.573845 23020 sched.cpp:217] New master detected at [email protected]:47981 I0424 05:59:44.573865 23020 sched.cpp:268] Authenticating with master [email protected]:47981 I0424 05:59:44.573951 23018 authenticatee.hpp:128] Creating new client SASL connection I0424 05:59:44.574120 23020 master.cpp:2715] Authenticating framework at scheduler(137)@67.195.138.61:47981 I0424 05:59:44.574189 23018 authenticator.hpp:148] Creating new server SASL connection I0424 05:59:44.574302 23020 authenticatee.hpp:219] Received SASL authentication mechanisms: CRAM-MD5 I0424 05:59:44.574323 23020 authenticatee.hpp:245] Attempting to authenticate with mechanism 'CRAM-MD5' I0424 05:59:44.574360 23020 authenticator.hpp:254] Received SASL authentication start I0424 05:59:44.574434 23020 authenticator.hpp:342] Authentication requires more steps I0424 05:59:44.574470 23020 authenticatee.hpp:265] Received SASL authentication step I0424 05:59:44.574522 23020 authenticator.hpp:282] Received SASL authentication step I0424 05:59:44.574543 23020 auxprop.cpp:81] Request to lookup properties for user: 'test-principal' realm: 'juno.apache.org' server FQDN: 'juno.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0424 05:59:44.574553 23020 auxprop.cpp:153] Looking up auxiliary property '*userPassword' I0424 05:59:44.574566 23020 auxprop.cpp:153] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0424 05:59:44.574578 23020 auxprop.cpp:81] Request to lookup properties for user: 'test-principal' realm: 'juno.apache.org' server FQDN: 'juno.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0424 05:59:44.574585 23020 auxprop.cpp:103] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0424 05:59:44.574591 23020 auxprop.cpp:103] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0424 05:59:44.574604 23020 authenticator.hpp:334] Authentication success I0424 05:59:44.574643 23018 authenticatee.hpp:305] Authentication success I0424 05:59:44.574658 23020 master.cpp:2755] Successfully authenticated framework at scheduler(137)@67.195.138.61:47981 I0424 05:59:44.574733 23018 sched.cpp:342] Successfully authenticated with master [email protected]:47981 I0424 05:59:44.574748 23018 sched.cpp:461] Sending registration request to [email protected]:47981 I0424 05:59:44.574807 23021 master.cpp:997] Received registration request from scheduler(137)@67.195.138.61:47981 I0424 05:59:44.574848 23021 master.cpp:1015] Registering framework 20140424-055944-1032504131-47981-22994-0000 at scheduler(137)@67.195.138.61:47981 I0424 05:59:44.574954 23018 sched.cpp:392] Framework registered with 20140424-055944-1032504131-47981-22994-0000 I0424 05:59:44.574997 23018 sched.cpp:406] Scheduler::registered took 26393ns I0424 05:59:44.575058 23021 hierarchical_allocator_process.hpp:332] Added framework 20140424-055944-1032504131-47981-22994-0000 I0424 05:59:44.575073 23021 hierarchical_allocator_process.hpp:726] No resources available to allocate! I0424 05:59:44.575079 23021 hierarchical_allocator_process.hpp:688] Performed allocation for 0 slaves in 7925ns I0424 05:59:44.575811 23015 log.cpp:680] Attempting to append 328 bytes to the log I0424 05:59:44.575860 23021 coordinator.cpp:339] Coordinator attempting to write APPEND action at position 3 I0424 05:59:44.576100 23019 replica.cpp:508] Replica received write request for position 3 I0424 05:59:44.583896 23019 leveldb.cpp:341] Persisting action (347 bytes) to leveldb took 7.776696ms I0424 05:59:44.583915 23019 replica.cpp:664] Persisted action at 3 I0424 05:59:44.584177 23022 replica.cpp:643] Replica received learned notice for position 3 I0424 05:59:44.592246 23022 leveldb.cpp:341] Persisting action (349 bytes) to leveldb took 8.05154ms I0424 05:59:44.592264 23022 replica.cpp:664] Persisted action at 3 I0424 05:59:44.592273 23022 replica.cpp:649] Replica learned APPEND action at position 3 I0424 05:59:44.592694 23018 registrar.cpp:436] Successfully updated 'registry' I0424 05:59:44.592824 23020 master.cpp:2150] Admitted slave on juno.apache.org at slave(145)@67.195.138.61:47981 I0424 05:59:44.592854 23017 log.cpp:699] Attempting to truncate the log to 3 I0424 05:59:44.592844 23020 master.cpp:3204] Adding slave 20140424-055944-1032504131-47981-22994-0 at juno.apache.org with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0424 05:59:44.592916 23015 coordinator.cpp:339] Coordinator attempting to write TRUNCATE action at position 4 I0424 05:59:44.592952 23017 slave.cpp:540] Registered with master [email protected]:47981; given slave ID 20140424-055944-1032504131-47981-22994-0 I0424 05:59:44.593088 23016 hierarchical_allocator_process.hpp:445] Added slave 20140424-055944-1032504131-47981-22994-0 (juno.apache.org) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (and cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] available) I0424 05:59:44.593165 23016 hierarchical_allocator_process.hpp:752] Offering cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 20140424-055944-1032504131-47981-22994-0 to framework 20140424-055944-1032504131-47981-22994-0000 I0424 05:59:44.593255 23018 replica.cpp:508] Replica received write request for position 4 I0424 05:59:44.593333 23016 hierarchical_allocator_process.hpp:708] Performed allocation for slave 20140424-055944-1032504131-47981-22994-0 in 205171ns I0424 05:59:44.593520 23020 master.hpp:524] Adding offer 20140424-055944-1032504131-47981-22994-0 with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 20140424-055944-1032504131-47981-22994-0 (juno.apache.org) I0424 05:59:44.593585 23020 master.cpp:2676] Sending 1 offers to framework 20140424-055944-1032504131-47981-22994-0000 I0424 05:59:44.593716 23021 sched.cpp:529] Scheduler::resourceOffers took 11378ns 2014-04-24 05:59:44,594:22994(0x2af1d5972700):ZOO_ERROR@handle_socket_error_msg@1721: Socket [127.0.0.1:49267] zk retcode=-4, errno=112(Host is down): failed while receiving a server response I0424 05:59:44.594521 23020 group.cpp:415] Lost connection to ZooKeeper, attempting to reconnect ... 2014-04-24 05:59:44,594:22994(0x2af1d536f700):ZOO_ERROR@handle_socket_error_msg@1721: Socket [127.0.0.1:49267] zk retcode=-4, errno=112(Host is down): failed while receiving a server response I0424 05:59:44.594921 23019 group.cpp:415] Lost connection to ZooKeeper, attempting to reconnect ... 2014-04-24 05:59:44,595:22994(0x2af1d5570700):ZOO_ERROR@handle_socket_error_msg@1721: Socket [127.0.0.1:49267] zk retcode=-4, errno=112(Host is down): failed while receiving a server response I0424 05:59:44.595129 23015 group.cpp:415] Lost connection to ZooKeeper, attempting to reconnect ... 2014-04-24 05:59:44,595:22994(0x2af1f0200700):ZOO_ERROR@handle_socket_error_msg@1721: Socket [127.0.0.1:49267] zk retcode=-4, errno=112(Host is down): failed while receiving a server response I0424 05:59:44.595621 23021 group.cpp:415] Lost connection to ZooKeeper, attempting to reconnect ... I0424 05:59:44.595937 22994 zookeeper_test_server.cpp:122] Shutdown ZooKeeperTestServer on port 49267 I0424 05:59:44.596179 23017 master.cpp:102] No whitelist given. Advertising offers for all slaves I0424 05:59:44.596210 23021 hierarchical_allocator_process.hpp:688] Performed allocation for 1 slaves in 13833ns W0424 05:59:44.596253 23015 group.cpp:453] Timed out waiting to reconnect to ZooKeeper. Forcing ZooKeeper session (sessionId=145925178f80002) expiration I0424 05:59:44.596266 23015 group.cpp:469] ZooKeeper session expired W0424 05:59:44.596287 23022 group.cpp:453] Timed out waiting to reconnect to ZooKeeper. Forcing ZooKeeper session (sessionId=145925178f80001) expiration I0424 05:59:44.596303 23022 group.cpp:469] ZooKeeper session expired W0424 05:59:44.596307 23019 group.cpp:453] Timed out waiting to reconnect to ZooKeeper. Forcing ZooKeeper session (sessionId=145925178f80000) expiration I0424 05:59:44.596318 23019 group.cpp:469] ZooKeeper session expired I0424 05:59:44.596364 23016 detector.cpp:122] The current leader (id=0) is lost I0424 05:59:44.596379 23016 detector.cpp:134] Detected a new leader: None 2014-04-24 05:59:44,596:22994(0x2af03c9f4700):ZOO_INFO@zookeeper_close@2522: Freeing zookeeper resources for sessionId=0x145925178f80002 2014-04-24 05:59:44,596:22994(0x2af03c9f4700):ZOO_INFO@log_env@712: Client environment:zookeeper.version=zookeeper C client 3.4.5 2014-04-24 05:59:44,596:22994(0x2af03c9f4700):ZOO_INFO@log_env@716: Client environment:host.name=juno 2014-04-24 05:59:44,596:22994(0x2af03c9f4700):ZOO_INFO@log_env@723: Client environment:os.name=Linux 2014-04-24 05:59:44,596:22994(0x2af03c9f4700):ZOO_INFO@log_env@724: Client environment:os.arch=3.2.0-51-generic 2014-04-24 05:59:44,596:22994(0x2af03c9f4700):ZOO_INFO@log_env@725: Client environment:os.version=#77-Ubuntu SMP Wed Jul 24 20:18:19 UTC 2013 I0424 05:59:44.596446 23020 contender.cpp:192] Membership cancelled: 0 2014-04-24 05:59:44,596:22994(0x2af03d7fb700):ZOO_INFO@zookeeper_close@2522: Freeing zookeeper resources for sessionId=0x145925178f80001 2014-04-24 05:59:44,596:22994(0x2af03d7fb700):ZOO_INFO@log_env@712: Client environment:zookeeper.version=zookeeper C client 3.4.5 2014-04-24 05:59:44,596:22994(0x2af03d7fb700):ZOO_INFO@log_env@716: Client environment:host.name=juno 2014-04-24 05:59:44,596:22994(0x2af03d7fb700):ZOO_INFO@log_env@723: Client environment:os.name=Linux 2014-04-24 05:59:44,596:22994(0x2af03d7fb700):ZOO_INFO@log_env@724: Client environment:os.arch=3.2.0-51-generic 2014-04-24 05:59:44,596:22994(0x2af03d7fb700):ZOO_INFO@log_env@725: Client environment:os.version=#77-Ubuntu SMP Wed Jul 24 20:18:19 UTC 2013 I0424 05:59:44.596472 23021 detector.cpp:122] The current leader (id=0) is lost 2014-04-24 05:59:44,596:22994(0x2af03c9f4700):ZOO_INFO@log_env@733: Client environment:user.name=(null) 2014-04-24 05:59:44,596:22994(0x2af03d1f8700):ZOO_INFO@zookeeper_close@2522: Freeing zookeeper resources for sessionId=0x145925178f80000 I0424 05:59:44.596750 23021 detector.cpp:134] Detected a new leader: None 2014-04-24 05:59:44,596:22994(0x2af03c9f4700):ZOO_INFO@log_env@741: Client environment:user.home=/home/jenkins 2014-04-24 05:59:44,596:22994(0x2af03d7fb700):ZOO_INFO@log_env@733: Client environment:user.name=(null) 2014-04-24 05:59:44,596:22994(0x2af03d7fb700):ZOO_INFO@log_env@741: Client environment:user.home=/home/jenkins 2014-04-24 05:59:44,596:22994(0x2af03d7fb700):ZOO_INFO@log_env@753: Client environment:user.dir=<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/ws/build/mesos-0.19.0/_build/src> 2014-04-24 05:59:44,596:22994(0x2af03d7fb700):ZOO_INFO@zookeeper_init@786: Initiating client connection, host=127.0.0.1:49267 sessionTimeout=10000 watcher=0x2af03a93bc00 sessionId=0 sessionPasswd=<null> context=0x2af05807cdf0 flags=0 2014-04-24 05:59:44,596:22994(0x2af03d1f8700):ZOO_INFO@log_env@712: Client environment:zookeeper.version=zookeeper C client 3.4.5 2014-04-24 05:59:44,597:22994(0x2af03d1f8700):ZOO_INFO@log_env@716: Client environment:host.name=juno 2014-04-24 05:59:44,597:22994(0x2af03d1f8700):ZOO_INFO@log_env@723: Client environment:os.name=Linux 2014-04-24 05:59:44,597:22994(0x2af03d1f8700):ZOO_INFO@log_env@724: Client environment:os.arch=3.2.0-51-generic 2014-04-24 05:59:44,597:22994(0x2af1fc200700):ZOO_ERROR@handle_socket_error_msg@1697: Socket [127.0.0.1:49267] zk retcode=-4, errno=111(Connection refused): server refused to accept the client 2014-04-24 05:59:44,596:22994(0x2af03c9f4700):ZOO_INFO@log_env@753: Client environment:user.dir=<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/ws/build/mesos-0.19.0/_build/src> 2014-04-24 05:59:44,597:22994(0x2af03c9f4700):ZOO_INFO@zookeeper_init@786: Initiating client connection, host=127.0.0.1:49267 sessionTimeout=10000 watcher=0x2af03a93bc00 sessionId=0 sessionPasswd=<null> context=0x2af0640563c0 flags=0 W0424 05:59:44.596598 23017 group.cpp:453] Timed out waiting to reconnect to ZooKeeper. Forcing ZooKeeper session (sessionId=145925178f80003) expiration 2014-04-24 05:59:44,597:22994(0x2af03d1f8700):ZOO_INFO@log_env@725: Client environment:os.version=#77-Ubuntu SMP Wed Jul 24 20:18:19 UTC 2013 I0424 05:59:44.597278 23017 group.cpp:469] ZooKeeper session expired 2014-04-24 05:59:44,597:22994(0x2af03d1f8700):ZOO_INFO@log_env@733: Client environment:user.name=(null) I0424 05:59:44.597381 23021 detector.cpp:122] The current leader (id=0) is lost I0424 05:59:44.597393 23021 detector.cpp:134] Detected a new leader: None 2014-04-24 05:59:44,597:22994(0x2af03cdf6700):ZOO_INFO@zookeeper_close@2522: Freeing zookeeper resources for sessionId=0x145925178f80003 2014-04-24 05:59:44,597:22994(0x2af03d1f8700):ZOO_INFO@log_env@741: Client environment:user.home=/home/jenkins 2014-04-24 05:59:44,597:22994(0x2af03cdf6700):ZOO_INFO@log_env@712: Client environment:zookeeper.version=zookeeper C client 3.4.5 2014-04-24 05:59:44,597:22994(0x2af03cdf6700):ZOO_INFO@log_env@716: Client environment:host.name=juno 2014-04-24 05:59:44,597:22994(0x2af03cdf6700):ZOO_INFO@log_env@723: Client environment:os.name=Linux 2014-04-24 05:59:44,597:22994(0x2af03cdf6700):ZOO_INFO@log_env@724: Client environment:os.arch=3.2.0-51-generic 2014-04-24 05:59:44,597:22994(0x2af03cdf6700):ZOO_INFO@log_env@725: Client environment:os.version=#77-Ubuntu SMP Wed Jul 24 20:18:19 UTC 2013 I0424 05:59:44.597493 23021 sched.cpp:211] Scheduler::disconnected took 9941ns 2014-04-24 05:59:44,597:22994(0x2af03d1f8700):ZOO_INFO@log_env@753: Client environment:user.dir=<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/ws/build/mesos-0.19.0/_build/src> 2014-04-24 05:59:44,597:22994(0x2af03d1f8700):ZOO_INFO@zookeeper_init@786: Initiating client connection, host=127.0.0.1:49267 sessionTimeout=10000 watcher=0x2af03a93bc00 sessionId=0 sessionPasswd=<null> context=0x2af048072ff0 flags=0 2014-04-24 05:59:44,597:22994(0x2af1fc401700):ZOO_ERROR@handle_socket_error_msg@1697: Socket [127.0.0.1:49267] zk retcode=-4, errno=111(Connection refused): server refused to accept the client I0424 05:59:44.597592 23021 sched.cpp:233] No master detected 2014-04-24 05:59:44,597:22994(0x2af03cdf6700):ZOO_INFO@log_env@733: Client environment:user.name=(null) 2014-04-24 05:59:44,597:22994(0x2af03cdf6700):ZOO_INFO@log_env@741: Client environment:user.home=/home/jenkins 2014-04-24 05:59:44,597:22994(0x2af03cdf6700):ZOO_INFO@log_env@753: Client environment:user.dir=<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/ws/build/mesos-0.19.0/_build/src> 2014-04-24 05:59:44,597:22994(0x2af03cdf6700):ZOO_INFO@zookeeper_init@786: Initiating client connection, host=127.0.0.1:49267 sessionTimeout=10000 watcher=0x2af03a93bc00 sessionId=0 sessionPasswd=<null> context=0x2af040076e20 flags=0 2014-04-24 05:59:44,597:22994(0x2af1d5b73700):ZOO_ERROR@handle_socket_error_msg@1697: Socket [127.0.0.1:49267] zk retcode=-4, errno=111(Connection refused): server refused to accept the client I0424 05:59:44.596539 23016 slave.cpp:518] Lost leading master 2014-04-24 05:59:44,597:22994(0x2af1d4b33700):ZOO_ERROR@handle_socket_error_msg@1697: Socket [127.0.0.1:49267] zk retcode=-4, errno=111(Connection refused): server refused to accept the client I0424 05:59:44.597990 23016 slave.cpp:522] Detecting new master I0424 05:59:44.600575 23018 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 7.290247ms I0424 05:59:44.600595 23018 replica.cpp:664] Persisted action at 4 I0424 05:59:44.600908 23021 replica.cpp:643] Replica received learned notice for position 4 I0424 05:59:44.608894 23021 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 7.965456ms I0424 05:59:44.608927 23021 leveldb.cpp:399] Deleting ~2 keys from leveldb took 16157ns I0424 05:59:44.608937 23021 replica.cpp:664] Persisted action at 4 I0424 05:59:44.608947 23021 replica.cpp:649] Replica learned TRUNCATE action at position 4 I0424 05:59:44.616204 23017 master.cpp:573] Master terminating I0424 05:59:44.616206 23015 sched.cpp:731] Stopping framework '20140424-055944-1032504131-47981-22994-0000' I0424 05:59:44.616276 23017 master.hpp:534] Removing offer 20140424-055944-1032504131-47981-22994-0 with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 20140424-055944-1032504131-47981-22994-0 (juno.apache.org) I0424 05:59:44.616475 23019 slave.cpp:2010] [email protected]:47981 exited W0424 05:59:44.616495 23019 slave.cpp:2013] Master disconnected! Waiting for a new master to be elected I0424 05:59:44.617267 23015 contender.cpp:182] Now cancelling the membership: 0 2014-04-24 05:59:44,617:22994(0x2af03c7eef80):ZOO_INFO@zookeeper_close@2522: Freeing zookeeper resources for sessionId=0 2014-04-24 05:59:44,617:22994(0x2af03c7eef80):ZOO_INFO@zookeeper_close@2522: Freeing zookeeper resources for sessionId=0 I0424 05:59:44.617893 22994 slave.cpp:387] Slave terminating 2014-04-24 05:59:44,618:22994(0x2af03c7eef80):ZOO_INFO@zookeeper_close@2522: Freeing zookeeper resources for sessionId=0 2014-04-24 05:59:44,618:22994(0x2af03c7eef80):ZOO_INFO@zookeeper_close@2522: Freeing zookeeper resources for sessionId=0 [ OK ] MasterZooKeeperTest.LostZooKeeperCluster (498 ms) [----------] 1 test from MasterZooKeeperTest (498 ms total) [----------] 2 tests from AttributesTest [ RUN ] AttributesTest.Parsing [ OK ] AttributesTest.Parsing (0 ms) [ RUN ] AttributesTest.Equality [ OK ] AttributesTest.Equality (1 ms) [----------] 2 tests from AttributesTest (1 ms total) [----------] Global test environment tear-down [==========] 298 tests from 50 test cases ran. (312857 ms total) [ PASSED ] 297 tests. [ FAILED ] 1 test, listed below: [ FAILED ] MasterTest.MetricsInStatsEndpoint 1 FAILED TEST YOU HAVE 1 DISABLED TEST make[4]: *** [check-local] Error 1 make[4]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/ws/build/mesos-0.19.0/_build/src'> make[3]: *** [check-am] Error 2 make[3]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/ws/build/mesos-0.19.0/_build/src'> make[2]: *** [check] Error 2 make[2]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/ws/build/mesos-0.19.0/_build/src'> make[1]: *** [check-recursive] Error 1 make[1]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/ws/build/mesos-0.19.0/_build'> make: *** [distcheck] Error 1 Build step 'Execute shell' marked build as failure
