See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/2381/changes>
Changes: [yan] MESOS-1392: MasterDetector now returns a None when it cannot read the content of the ZNode it has detected. ------------------------------------------ [...truncated 56842 lines...] I0918 05:53:10.551653 18237 replica.cpp:676] Persisted action at 4 I0918 05:53:10.551663 18237 replica.cpp:661] Replica learned TRUNCATE action at position 4 I0918 05:53:10.552196 18237 hierarchical_allocator_process.hpp:659] Performed allocation for 1 slaves in 19675ns I0918 05:53:10.552340 18217 master.cpp:120] No whitelist given. Advertising offers for all slaves I0918 05:53:10.552553 18222 slave.cpp:2347] Received ping from slave-observer(167)@67.195.81.187:38947 I0918 05:53:10.562322 18222 hierarchical_allocator_process.hpp:659] Performed allocation for 1 slaves in 10491ns I0918 05:53:10.562371 18222 master.cpp:120] No whitelist given. Advertising offers for all slaves I0918 05:53:10.562487 18222 slave.cpp:3075] Current usage 5.96%. Max allowed age: 5.882624472725741days I0918 05:53:10.562572 18222 slave.cpp:587] No pings from master received within 75secs I0918 05:53:10.562589 18222 slave.cpp:647] Detecting new master I0918 05:53:10.562674 18222 slave.cpp:600] New master detected at [email protected]:38947 I0918 05:53:10.562701 18222 slave.cpp:674] Authenticating with master [email protected]:38947 I0918 05:53:10.562752 18222 slave.cpp:647] Detecting new master I0918 05:53:10.562791 18222 status_update_manager.cpp:167] New master detected at [email protected]:38947 I0918 05:53:10.562830 18222 authenticatee.hpp:128] Creating new client SASL connection I0918 05:53:10.562927 18222 master.cpp:1711] Disconnecting slave 20140918-055308-3142697795-38947-18196-0 I0918 05:53:10.562950 18222 master.cpp:3669] Authenticating slave(195)@67.195.81.187:38947 I0918 05:53:10.563029 18222 hierarchical_allocator_process.hpp:481] Slave 20140918-055308-3142697795-38947-18196-0 deactivated I0918 05:53:10.563060 18222 authenticator.hpp:156] Creating new server SASL connection I0918 05:53:10.563119 18222 authenticatee.hpp:219] Received SASL authentication mechanisms: CRAM-MD5 I0918 05:53:10.563138 18222 authenticatee.hpp:245] Attempting to authenticate with mechanism 'CRAM-MD5' I0918 05:53:10.563166 18222 authenticator.hpp:262] Received SASL authentication start I0918 05:53:10.563215 18222 authenticator.hpp:384] Authentication requires more steps I0918 05:53:10.563247 18222 authenticatee.hpp:265] Received SASL authentication step I0918 05:53:10.563287 18222 authenticator.hpp:290] Received SASL authentication step I0918 05:53:10.563305 18222 auxprop.cpp:81] Request to lookup properties for user: 'test-principal' realm: 'pomona.apache.org' server FQDN: 'pomona.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0918 05:53:10.563316 18222 auxprop.cpp:153] Looking up auxiliary property '*userPassword' I0918 05:53:10.563330 18222 auxprop.cpp:153] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0918 05:53:10.563343 18222 auxprop.cpp:81] Request to lookup properties for user: 'test-principal' realm: 'pomona.apache.org' server FQDN: 'pomona.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0918 05:53:10.563351 18222 auxprop.cpp:103] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0918 05:53:10.563360 18222 auxprop.cpp:103] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0918 05:53:10.563375 18222 authenticator.hpp:376] Authentication success I0918 05:53:10.563407 18222 authenticatee.hpp:305] Authentication success I0918 05:53:10.563432 18222 master.cpp:3709] Successfully authenticated principal 'test-principal' at slave(195)@67.195.81.187:38947 I0918 05:53:10.563504 18222 slave.cpp:731] Successfully authenticated with master [email protected]:38947 I0918 05:53:10.563555 18222 slave.cpp:994] Will retry registration in 2.84152ms if necessary W0918 05:53:10.563612 18222 master.cpp:2985] Slave at slave(195)@67.195.81.187:38947 (pomona.apache.org) is being allowed to re-register with an already in use id (20140918-055308-3142697795-38947-18196-0) I0918 05:53:10.763890 18222 slave.cpp:827] Re-registered with master [email protected]:38947 I0918 05:53:10.763936 18222 hierarchical_allocator_process.hpp:495] Slave 20140918-055308-3142697795-38947-18196-0 reactivated I0918 05:53:10.783864 18196 master.cpp:650] Master terminating I0918 05:53:10.784272 18233 slave.cpp:2379] [email protected]:38947 exited W0918 05:53:10.784304 18233 slave.cpp:2382] Master disconnected! Waiting for a new master to be elected I0918 05:53:10.847774 18245 slave.cpp:477] Slave terminating [ OK ] SlaveTest.PingTimeoutSomePings (2776 ms) [ RUN ] SlaveTest.TerminalTaskContainerizerUpdateFails Using temporary directory '/tmp/SlaveTest_TerminalTaskContainerizerUpdateFails_sWWgpq' I0918 05:53:10.923292 18196 leveldb.cpp:176] Opened db in 1.783424ms I0918 05:53:10.923598 18196 leveldb.cpp:183] Compacted db in 275740ns I0918 05:53:10.923616 18196 leveldb.cpp:198] Created db iterator in 3187ns I0918 05:53:10.923626 18196 leveldb.cpp:204] Seeked to beginning of db in 595ns I0918 05:53:10.923635 18196 leveldb.cpp:273] Iterated through 0 keys in the db in 297ns I0918 05:53:10.923655 18196 replica.cpp:741] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0918 05:53:10.923918 18221 recover.cpp:425] Starting replica recovery I0918 05:53:10.924659 18221 master.cpp:286] Master 20140918-055310-3142697795-38947-18196 (pomona.apache.org) started on 67.195.81.187:38947 I0918 05:53:10.924687 18221 master.cpp:332] Master only allowing authenticated frameworks to register I0918 05:53:10.924700 18221 master.cpp:337] Master only allowing authenticated slaves to register I0918 05:53:10.924710 18221 credentials.hpp:36] Loading credentials for authentication from '/tmp/SlaveTest_TerminalTaskContainerizerUpdateFails_sWWgpq/credentials' I0918 05:53:10.924816 18221 master.cpp:366] Authorization enabled I0918 05:53:10.925324 18221 hierarchical_allocator_process.hpp:299] Initializing hierarchical allocator process with master : [email protected]:38947 I0918 05:53:10.925364 18221 master.cpp:120] No whitelist given. Advertising offers for all slaves I0918 05:53:10.925417 18221 master.cpp:1211] The newly elected leader is [email protected]:38947 with id 20140918-055310-3142697795-38947-18196 I0918 05:53:10.925431 18221 master.cpp:1224] Elected as the leading master! I0918 05:53:10.925439 18221 master.cpp:1042] Recovering from registrar I0918 05:53:10.925495 18221 registrar.cpp:313] Recovering registrar I0918 05:53:10.925760 18247 recover.cpp:451] Replica is in EMPTY status I0918 05:53:10.926111 18247 replica.cpp:638] Replica in EMPTY status received a broadcasted recover request I0918 05:53:10.926175 18247 recover.cpp:188] Received a recover response from a replica in EMPTY status I0918 05:53:10.926296 18247 recover.cpp:542] Updating replica status to STARTING I0918 05:53:10.926767 18247 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 388137ns I0918 05:53:10.926803 18247 replica.cpp:320] Persisted replica status to STARTING I0918 05:53:10.926930 18247 recover.cpp:451] Replica is in STARTING status I0918 05:53:10.927316 18247 replica.cpp:638] Replica in STARTING status received a broadcasted recover request I0918 05:53:10.927389 18247 recover.cpp:188] Received a recover response from a replica in STARTING status I0918 05:53:10.927512 18247 recover.cpp:542] Updating replica status to VOTING I0918 05:53:10.928455 18247 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 883942ns I0918 05:53:10.928472 18247 replica.cpp:320] Persisted replica status to VOTING I0918 05:53:10.928516 18247 recover.cpp:556] Successfully joined the Paxos group I0918 05:53:10.928589 18247 recover.cpp:440] Recover process terminated I0918 05:53:10.928731 18247 log.cpp:656] Attempting to start the writer I0918 05:53:10.929065 18247 replica.cpp:474] Replica received implicit promise request with proposal 1 I0918 05:53:10.932589 18247 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 3.502974ms I0918 05:53:10.932615 18247 replica.cpp:342] Persisted promised to 1 I0918 05:53:10.932809 18247 coordinator.cpp:230] Coordinator attemping to fill missing position I0918 05:53:10.933153 18247 replica.cpp:375] Replica received explicit promise request for position 0 with proposal 2 I0918 05:53:10.936643 18247 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 3.470621ms I0918 05:53:10.936666 18247 replica.cpp:676] Persisted action at 0 I0918 05:53:10.936964 18247 replica.cpp:508] Replica received write request for position 0 I0918 05:53:10.936995 18247 leveldb.cpp:438] Reading position from leveldb took 14484ns I0918 05:53:10.940613 18247 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 3.600936ms I0918 05:53:10.940635 18247 replica.cpp:676] Persisted action at 0 I0918 05:53:10.940798 18247 replica.cpp:655] Replica received learned notice for position 0 I0918 05:53:10.944587 18247 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 3.763045ms I0918 05:53:10.944609 18247 replica.cpp:676] Persisted action at 0 I0918 05:53:10.944619 18247 replica.cpp:661] Replica learned NOP action at position 0 I0918 05:53:10.944886 18249 log.cpp:672] Writer started with ending position 0 I0918 05:53:10.945196 18249 leveldb.cpp:438] Reading position from leveldb took 17238ns I0918 05:53:10.946774 18249 registrar.cpp:346] Successfully fetched the registry (0B) I0918 05:53:10.946797 18249 registrar.cpp:422] Attempting to update the 'registry' I0918 05:53:10.948382 18249 log.cpp:680] Attempting to append 139 bytes to the log I0918 05:53:10.948545 18247 coordinator.cpp:340] Coordinator attempting to write APPEND action at position 1 I0918 05:53:10.948878 18238 replica.cpp:508] Replica received write request for position 1 I0918 05:53:10.949167 18238 leveldb.cpp:343] Persisting action (158 bytes) to leveldb took 269406ns I0918 05:53:10.949185 18238 replica.cpp:676] Persisted action at 1 I0918 05:53:10.949389 18238 replica.cpp:655] Replica received learned notice for position 1 I0918 05:53:10.949512 18238 leveldb.cpp:343] Persisting action (160 bytes) to leveldb took 105387ns I0918 05:53:10.949527 18238 replica.cpp:676] Persisted action at 1 I0918 05:53:10.949537 18238 replica.cpp:661] Replica learned APPEND action at position 1 I0918 05:53:10.949872 18238 registrar.cpp:479] Successfully updated 'registry' I0918 05:53:10.949915 18238 registrar.cpp:372] Successfully recovered registrar I0918 05:53:10.949960 18238 log.cpp:699] Attempting to truncate the log to 1 I0918 05:53:10.950037 18238 master.cpp:1069] Recovered 0 slaves from the Registry (101B) ; allowing 10mins for slaves to re-register I0918 05:53:10.950080 18238 coordinator.cpp:340] Coordinator attempting to write TRUNCATE action at position 2 I0918 05:53:10.950325 18238 replica.cpp:508] Replica received write request for position 2 I0918 05:53:10.950434 18238 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 88713ns I0918 05:53:10.950453 18238 replica.cpp:676] Persisted action at 2 I0918 05:53:10.950682 18238 replica.cpp:655] Replica received learned notice for position 2 I0918 05:53:10.950789 18238 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 88438ns I0918 05:53:10.950822 18238 leveldb.cpp:401] Deleting ~1 keys from leveldb took 15332ns I0918 05:53:10.950839 18238 replica.cpp:676] Persisted action at 2 I0918 05:53:10.950851 18238 replica.cpp:661] Replica learned TRUNCATE action at position 2 I0918 05:53:10.963490 18238 slave.cpp:169] Slave started on 196)@67.195.81.187:38947 I0918 05:53:10.963516 18238 credentials.hpp:84] Loading credential for authentication from '/tmp/SlaveTest_TerminalTaskContainerizerUpdateFails_8jxpYi/credential' I0918 05:53:10.963605 18238 slave.cpp:276] Slave using credential for: test-principal I0918 05:53:10.963737 18238 slave.cpp:289] Slave resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0918 05:53:10.963819 18238 slave.cpp:317] Slave hostname: pomona.apache.org I0918 05:53:10.963834 18238 slave.cpp:318] Slave checkpoint: false I0918 05:53:10.964313 18238 state.cpp:33] Recovering state from '/tmp/SlaveTest_TerminalTaskContainerizerUpdateFails_8jxpYi/meta' I0918 05:53:10.964443 18238 status_update_manager.cpp:193] Recovering status update manager I0918 05:53:10.964649 18245 slave.cpp:3220] Finished recovery I0918 05:53:10.964982 18245 slave.cpp:600] New master detected at [email protected]:38947 I0918 05:53:10.965014 18245 slave.cpp:674] Authenticating with master [email protected]:38947 I0918 05:53:10.965064 18245 slave.cpp:647] Detecting new master I0918 05:53:10.965107 18245 status_update_manager.cpp:167] New master detected at [email protected]:38947 I0918 05:53:10.965149 18245 authenticatee.hpp:128] Creating new client SASL connection I0918 05:53:10.965252 18245 master.cpp:3669] Authenticating slave(196)@67.195.81.187:38947 I0918 05:53:10.965353 18245 authenticator.hpp:156] Creating new server SASL connection I0918 05:53:10.965420 18245 authenticatee.hpp:219] Received SASL authentication mechanisms: CRAM-MD5 I0918 05:53:10.965437 18245 authenticatee.hpp:245] Attempting to authenticate with mechanism 'CRAM-MD5' I0918 05:53:10.965468 18245 authenticator.hpp:262] Received SASL authentication start I0918 05:53:10.965507 18245 authenticator.hpp:384] Authentication requires more steps I0918 05:53:10.965539 18245 authenticatee.hpp:265] Received SASL authentication step I0918 05:53:10.965581 18245 authenticator.hpp:290] Received SASL authentication step I0918 05:53:10.965600 18245 auxprop.cpp:81] Request to lookup properties for user: 'test-principal' realm: 'pomona.apache.org' server FQDN: 'pomona.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0918 05:53:10.965610 18245 auxprop.cpp:153] Looking up auxiliary property '*userPassword' I0918 05:53:10.965625 18245 auxprop.cpp:153] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0918 05:53:10.965636 18245 auxprop.cpp:81] Request to lookup properties for user: 'test-principal' realm: 'pomona.apache.org' server FQDN: 'pomona.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0918 05:53:10.965646 18245 auxprop.cpp:103] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0918 05:53:10.965654 18245 auxprop.cpp:103] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0918 05:53:10.965669 18245 authenticator.hpp:376] Authentication success I0918 05:53:10.965699 18245 authenticatee.hpp:305] Authentication success I0918 05:53:10.965724 18245 master.cpp:3709] Successfully authenticated principal 'test-principal' at slave(196)@67.195.81.187:38947 I0918 05:53:10.965796 18245 slave.cpp:731] Successfully authenticated with master [email protected]:38947 I0918 05:53:10.965841 18245 slave.cpp:994] Will retry registration in 10.35902ms if necessary I0918 05:53:10.965941 18245 master.cpp:2870] Registering slave at slave(196)@67.195.81.187:38947 (pomona.apache.org) with id 20140918-055310-3142697795-38947-18196-0 I0918 05:53:10.966055 18245 registrar.cpp:422] Attempting to update the 'registry' I0918 05:53:10.967166 18196 sched.cpp:137] Version: 0.21.0 I0918 05:53:10.967998 18245 log.cpp:680] Attempting to append 334 bytes to the log I0918 05:53:10.968067 18245 sched.cpp:233] New master detected at [email protected]:38947 I0918 05:53:10.968085 18245 sched.cpp:283] Authenticating with master [email protected]:38947 I0918 05:53:10.968161 18245 coordinator.cpp:340] Coordinator attempting to write APPEND action at position 3 I0918 05:53:10.968250 18245 authenticatee.hpp:128] Creating new client SASL connection I0918 05:53:10.968372 18245 master.cpp:3669] Authenticating [email protected]:38947 I0918 05:53:10.968659 18224 replica.cpp:508] Replica received write request for position 3 I0918 05:53:10.968824 18224 leveldb.cpp:343] Persisting action (353 bytes) to leveldb took 143428ns I0918 05:53:10.968843 18224 replica.cpp:676] Persisted action at 3 I0918 05:53:10.969053 18224 replica.cpp:655] Replica received learned notice for position 3 I0918 05:53:10.969285 18223 authenticator.hpp:156] Creating new server SASL connection I0918 05:53:10.969349 18223 authenticatee.hpp:219] Received SASL authentication mechanisms: CRAM-MD5 I0918 05:53:10.969365 18223 authenticatee.hpp:245] Attempting to authenticate with mechanism 'CRAM-MD5' I0918 05:53:10.969393 18223 authenticator.hpp:262] Received SASL authentication start I0918 05:53:10.969398 18224 leveldb.cpp:343] Persisting action (355 bytes) to leveldb took 322354ns I0918 05:53:10.969418 18224 replica.cpp:676] Persisted action at 3 I0918 05:53:10.969427 18223 authenticator.hpp:384] Authentication requires more steps I0918 05:53:10.969465 18223 authenticatee.hpp:265] Received SASL authentication step I0918 05:53:10.969502 18223 authenticator.hpp:290] Received SASL authentication step I0918 05:53:10.969519 18223 auxprop.cpp:81] Request to lookup properties for user: 'test-principal' realm: 'pomona.apache.org' server FQDN: 'pomona.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0918 05:53:10.969530 18223 auxprop.cpp:153] Looking up auxiliary property '*userPassword' I0918 05:53:10.969543 18223 auxprop.cpp:153] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0918 05:53:10.969557 18223 auxprop.cpp:81] Request to lookup properties for user: 'test-principal' realm: 'pomona.apache.org' server FQDN: 'pomona.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0918 05:53:10.969566 18223 auxprop.cpp:103] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0918 05:53:10.969575 18223 auxprop.cpp:103] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0918 05:53:10.969591 18223 authenticator.hpp:376] Authentication success I0918 05:53:10.969615 18223 authenticatee.hpp:305] Authentication success I0918 05:53:10.969660 18223 sched.cpp:357] Successfully authenticated with master [email protected]:38947 I0918 05:53:10.969676 18223 sched.cpp:476] Sending registration request to [email protected]:38947 I0918 05:53:10.969820 18245 master.cpp:1322] Queuing up registration request from [email protected]:38947 because authentication is still in progress I0918 05:53:10.969858 18245 master.cpp:3709] Successfully authenticated principal 'test-principal' at [email protected]:38947 I0918 05:53:10.969918 18245 master.cpp:1330] Received registration request from [email protected]:38947 I0918 05:53:10.969941 18245 master.cpp:1290] Authorizing framework principal 'test-principal' to receive offers for role '*' I0918 05:53:10.970046 18245 master.cpp:1389] Registering framework 20140918-055310-3142697795-38947-18196-0000 at [email protected]:38947 I0918 05:53:10.970139 18245 sched.cpp:407] Framework registered with 20140918-055310-3142697795-38947-18196-0000 I0918 05:53:10.970165 18245 sched.cpp:421] Scheduler::registered took 11170ns I0918 05:53:10.970204 18245 hierarchical_allocator_process.hpp:329] Added framework 20140918-055310-3142697795-38947-18196-0000 I0918 05:53:10.970216 18245 hierarchical_allocator_process.hpp:697] No resources available to allocate! I0918 05:53:10.970226 18245 hierarchical_allocator_process.hpp:659] Performed allocation for 0 slaves in 10124ns I0918 05:53:10.969429 18224 replica.cpp:661] Replica learned APPEND action at position 3 I0918 05:53:10.976824 18224 registrar.cpp:479] Successfully updated 'registry' I0918 05:53:10.976918 18224 log.cpp:699] Attempting to truncate the log to 3 I../../src/tests/slave_tests.cpp:846: Failure Failed to wait 10secs for offers 0918 05:53:10.976975 18224 master.cpp:2910] Registered slave 20140918-055310-3142697795-38947-18196-0 at slave(196)@67.195.81.187:38947 (pomona.apache.org) I0918 05:53:28.285928 18224 master.cpp:4118] Adding slave 20140918-055310-3142697795-38947-18196-0 at slave(196)@67.195.81.187:38947 (pomona.apache.org) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0918 05:53:10.977141 18221 slave.cpp:994] Will retry registration in 17.357015ms if necessary I0918 05:53:28.286118 18221 slave.cpp:765] Registered with master [email protected]:38947; given slave ID 20140918-055310-3142697795-38947-18196-0 I0918 05:53:28.286175 18224 master.cpp:2846] Slave 20140918-055310-3142697795-38947-18196-0 at slave(196)@67.195.81.187:38947 (pomona.apache.org) already registered, resending acknowledgement I0918 05:53:28.286190 18221 slave.cpp:2347] Received ping from slave-observer(168)@67.195.81.187:38947 W0918 05:53:28.286238 18221 slave.cpp:802] Already registered with master [email protected]:38947 I0918 05:53:11.926359 18222 hierarchical_allocator_process.hpp:697] No resources available to allocate! I0918 05:53:28.286294 18222 hierarchical_allocator_process.hpp:659] Performed allocation for 0 slaves in 16.360006568secs I0918 05:53:15.925664 18247 master.cpp:120] No whitelist given. Advertising offers for all slaves ../../src/tests/slave_tests.cpp:840: Failure Actual function call count doesn't match EXPECT_CALL(sched, resourceOffers(&driver, _))... Expected: to be called at least once Actual: never called - unsatisfied and active ../../src/tests/slave_tests.cpp:824: Failure Actual function call count doesn't match EXPECT_CALL(exec, registered(_, _, _, _))... Expected: to be called once Actual: never called - unsatisfied and active I0918 05:53:28.286567 18222 hierarchical_allocator_process.hpp:442] Added slave 20140918-055310-3142697795-38947-18196-0 (pomona.apache.org) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (and cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] available) I0918 05:53:28.286648 18222 hierarchical_allocator_process.hpp:734] Offering cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 20140918-055310-3142697795-38947-18196-0 to framework 20140918-055310-3142697795-38947-18196-0000 I0918 05:53:28.286770 18222 hierarchical_allocator_process.hpp:679] Performed allocation for slave 20140918-055310-3142697795-38947-18196-0 in 158496ns I0918 05:53:28.286823 18224 master.cpp:650] Master terminating I0918 05:53:10.977038 18245 coordinator.cpp:340] Coordinator attempting to write TRUNCATE action at position 4 I0918 05:53:28.287288 18235 slave.cpp:2379] [email protected]:38947 exited W0918 05:53:28.287307 18235 slave.cpp:2382] Master disconnected! Waiting for a new master to be elected F0918 05:53:28.287307 18196 logging.cpp:57] RAW: Pure virtual method called @ 0x2b77fec4ce3d google::LogMessage::Fail() @ 0x2b77fec54536 google::RawLog__() @ 0x5000d6 mesos::internal::tests::Cluster::Slaves::shutdown() @ 0x789b94 mesos::internal::tests::MesosTest::ShutdownSlaves() @ 0x952933 testing::internal::HandleExceptionsInMethodIfSupported<>() @ 0x949ad0 testing::Test::Run() @ 0x949bae testing::TestInfo::Run() @ 0x949cb5 testing::TestCase::Run() @ 0x949f58 testing::internal::UnitTestImpl::RunAllTests() @ 0x94a1f7 testing::UnitTest::Run() @ 0x48dbe3 main @ 0x2b7800967ec5 (unknown) @ 0x49aef8 (unknown) make[3]: *** [check-local] Aborted make[3]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/ws/build/src'> make[2]: *** [check-am] Error 2 make[2]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/ws/build/src'> make[1]: *** [check] Error 2 make[1]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/ws/build/src'> make: *** [check-recursive] Error 1 Test finished Exit status: 2 Build step 'Execute shell' marked build as failure
