https://issues.apache.org/jira/browse/MESOS-2366
On 17 February 2015 at 17:56, Apache Jenkins Server < jenk...@builds.apache.org> wrote: > See < > https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/2746/changes > > > > Changes: > > [benjamin.mahler] Updated EventLoop::delay to take a lambda::function. > > ------------------------------------------ > [...truncated 72164 lines...] > I0218 01:55:15.052839 13946 master.cpp:785] Master terminating > I0218 01:55:15.053035 13943 registrar.cpp:444] Applied 1 operations in > 72064ns; attempting to update the 'registry' > I0218 01:55:15.053145 13935 slave.cpp:2751] master@67.195.81.187:57268 > exited > W0218 01:55:15.053166 13935 slave.cpp:2754] Master disconnected! Waiting > for a new master to be elected > I0218 01:55:15.054481 13918 process.cpp:2117] Dropped / Lost event for > PID: master@67.195.81.187:57268 > I0218 01:55:15.054572 13918 process.cpp:2117] Dropped / Lost event for > PID: master@67.195.81.187:57268 > I0218 01:55:15.056511 13940 log.cpp:683] Attempting to append 316 bytes to > the log > I0218 01:55:15.056644 13935 coordinator.cpp:339] Coordinator attempting to > write 2 action at position 3 > I0218 01:55:15.057008 13945 process.cpp:2117] Dropped / Lost event for > PID: log-coordinator(287)@67.195.81.187:57268 > I0218 01:55:15.060351 13941 process.cpp:2117] Dropped / Lost event for > PID: master@67.195.81.187:57268 > I0218 01:55:15.229552 13941 slave.cpp:1089] Will retry registration in > 32.644031ms if necessary > I0218 01:55:15.099928 13948 process.cpp:2117] Dropped / Lost event for > PID: scheduler-3b7a53ae-0e3b-42d1-8461-93911caf9079@67.195.81.187:57268 > I0218 01:55:15.230154 13945 process.cpp:2117] Dropped / Lost event for > PID: registrar(256)@67.195.81.187:57268 > I0218 01:55:15.238539 13943 slave.cpp:505] Slave terminating > I0218 01:55:15.241852 13918 process.cpp:2117] Dropped / Lost event for > PID: slave(221)@67.195.81.187:57268 > I0218 01:55:15.242988 13918 process.cpp:2117] Dropped / Lost event for > PID: scheduler-9b2103c5-38b0-4c4b-8614-1aeb1fcc95ed@67.195.81.187:57268 > [ OK ] ExceptionTest.DisallowSchedulerActionsOnAbort (361 ms) > [ RUN ] ExceptionTest.DisallowSchedulerCallbacksOnAbort > Using temporary directory > '/tmp/ExceptionTest_DisallowSchedulerCallbacksOnAbort_VuflGx' > I0218 01:55:15.248679 13918 leveldb.cpp:175] Opened db in 2.668145ms > I0218 01:55:15.249372 13918 leveldb.cpp:182] Compacted db in 663293ns > I0218 01:55:15.249419 13918 leveldb.cpp:197] Created db iterator in 21632ns > I0218 01:55:15.249439 13918 leveldb.cpp:203] Seeked to beginning of db in > 2067ns > I0218 01:55:15.249449 13918 leveldb.cpp:272] Iterated through 0 keys in > the db in 289ns > I0218 01:55:15.249492 13918 replica.cpp:743] Replica recovered with log > positions 0 -> 0 with 1 holes and 0 unlearned > I0218 01:55:15.249970 13947 recover.cpp:448] Starting replica recovery > I0218 01:55:15.250306 13947 recover.cpp:474] Replica is in 4 status > I0218 01:55:15.251730 13937 replica.cpp:640] Replica in 4 status received > a broadcasted recover request > I0218 01:55:15.252112 13942 recover.cpp:194] Received a recover response > from a replica in 4 status > I0218 01:55:15.252532 13945 master.cpp:347] Master > 20150218-015515-3142697795-57268-13918 (pomona.apache.org) started on > 67.195.81.187:57268 > I0218 01:55:15.252576 13945 master.cpp:393] Master only allowing > authenticated frameworks to register > I0218 01:55:15.252593 13945 master.cpp:398] Master only allowing > authenticated slaves to register > I0218 01:55:15.252617 13945 credentials.hpp:36] Loading credentials for > authentication from > '/tmp/ExceptionTest_DisallowSchedulerCallbacksOnAbort_VuflGx/credentials' > I0218 01:55:15.252769 13941 recover.cpp:565] Updating replica status to 3 > I0218 01:55:15.252887 13945 master.cpp:440] Authorization enabled > I0218 01:55:15.253491 13936 whitelist_watcher.cpp:78] No whitelist given > I0218 01:55:15.253628 13947 hierarchical.hpp:286] Initialized hierarchical > allocator process > I0218 01:55:15.253706 13937 leveldb.cpp:305] Persisting metadata (8 bytes) > to leveldb took 565291ns > I0218 01:55:15.253726 13937 replica.cpp:322] Persisted replica status to 3 > I0218 01:55:15.253965 13939 recover.cpp:474] Replica is in 3 status > I0218 01:55:15.254829 13940 master.cpp:1354] The newly elected leader is > master@67.195.81.187:57268 with id 20150218-015515-3142697795-57268-13918 > I0218 01:55:15.254858 13940 master.cpp:1367] Elected as the leading master! > I0218 01:55:15.254871 13940 master.cpp:1185] Recovering from registrar > I0218 01:55:15.254978 13946 registrar.cpp:312] Recovering registrar > I0218 01:55:15.255887 13932 replica.cpp:640] Replica in 3 status received > a broadcasted recover request > I0218 01:55:15.256160 13935 recover.cpp:194] Received a recover response > from a replica in 3 status > I0218 01:55:15.256742 13937 recover.cpp:565] Updating replica status to 1 > I0218 01:55:15.257387 13934 leveldb.cpp:305] Persisting metadata (8 bytes) > to leveldb took 437201ns > I0218 01:55:15.257407 13934 replica.cpp:322] Persisted replica status to 1 > I0218 01:55:15.257489 13934 recover.cpp:579] Successfully joined the Paxos > group > I0218 01:55:15.257643 13934 recover.cpp:463] Recover process terminated > I0218 01:55:15.258038 13947 log.cpp:659] Attempting to start the writer > I0218 01:55:15.259137 13935 replica.cpp:476] Replica received implicit > promise request with proposal 1 > I0218 01:55:15.259568 13935 leveldb.cpp:305] Persisting metadata (8 bytes) > to leveldb took 396694ns > I0218 01:55:15.259591 13935 replica.cpp:344] Persisted promised to 1 > I0218 01:55:15.262418 13948 process.cpp:2117] Dropped / Lost event for > PID: slave(221)@67.195.81.187:57268 > I0218 01:55:15.262723 13939 coordinator.cpp:229] Coordinator attemping to > fill missing position > I0218 01:55:15.267627 13932 replica.cpp:377] Replica received explicit > promise request for position 0 with proposal 2 > I0218 01:55:15.267979 13932 leveldb.cpp:342] Persisting action (8 bytes) > to leveldb took 322740ns > I0218 01:55:15.267999 13932 replica.cpp:678] Persisted action at 0 > I0218 01:55:15.269002 13933 replica.cpp:510] Replica received write > request for position 0 > I0218 01:55:15.269050 13933 leveldb.cpp:437] Reading position from leveldb > took 25471ns > I0218 01:55:15.269343 13933 leveldb.cpp:342] Persisting action (14 bytes) > to leveldb took 265493ns > I0218 01:55:15.269363 13933 replica.cpp:678] Persisted action at 0 > I0218 01:55:15.270083 13935 replica.cpp:657] Replica received learned > notice for position 0 > I0218 01:55:15.270478 13935 leveldb.cpp:342] Persisting action (16 bytes) > to leveldb took 371190ns > I0218 01:55:15.270498 13935 replica.cpp:678] Persisted action at 0 > I0218 01:55:15.270517 13935 replica.cpp:663] Replica learned 1 action at > position 0 > I0218 01:55:15.270912 13936 log.cpp:675] Writer started with ending > position 0 > I0218 01:55:15.271814 13942 leveldb.cpp:437] Reading position from leveldb > took 28195ns > I0218 01:55:15.274863 13933 registrar.cpp:345] Successfully fetched the > registry (0B) in 19.652096ms > I0218 01:55:15.274950 13933 registrar.cpp:444] Applied 1 operations in > 20986ns; attempting to update the 'registry' > I0218 01:55:15.277163 13946 log.cpp:683] Attempting to append 139 bytes to > the log > I0218 01:55:15.277295 13936 coordinator.cpp:339] Coordinator attempting to > write 2 action at position 1 > I0218 01:55:15.277963 13936 replica.cpp:510] Replica received write > request for position 1 > I0218 01:55:15.278688 13936 leveldb.cpp:342] Persisting action (158 bytes) > to leveldb took 700481ns > I0218 01:55:15.278712 13936 replica.cpp:678] Persisted action at 1 > I0218 01:55:15.279357 13935 replica.cpp:657] Replica received learned > notice for position 1 > I0218 01:55:15.279918 13935 leveldb.cpp:342] Persisting action (160 bytes) > to leveldb took 539008ns > I0218 01:55:15.279940 13935 replica.cpp:678] Persisted action at 1 > I0218 01:55:15.279959 13935 replica.cpp:663] Replica learned 2 action at > position 1 > I0218 01:55:15.280833 13944 log.cpp:702] Attempting to truncate the log to > 1 > I0218 01:55:15.280931 13941 coordinator.cpp:339] Coordinator attempting to > write 3 action at position 2 > I0218 01:55:15.281132 13933 registrar.cpp:489] Successfully updated the > 'registry' in 5.803008ms > I0218 01:55:15.281225 13933 registrar.cpp:375] Successfully recovered > registrar > I0218 01:55:15.281772 13935 master.cpp:1212] Recovered 0 slaves from the > Registry (101B) ; allowing 10mins for slaves to re-register > I0218 01:55:15.282418 13936 replica.cpp:510] Replica received write > request for position 2 > I0218 01:55:15.282774 13936 leveldb.cpp:342] Persisting action (16 bytes) > to leveldb took 331042ns > I0218 01:55:15.282794 13936 replica.cpp:678] Persisted action at 2 > I0218 01:55:15.283903 13941 replica.cpp:657] Replica received learned > notice for position 2 > I0218 01:55:15.284450 13941 leveldb.cpp:342] Persisting action (18 bytes) > to leveldb took 516030ns > I0218 01:55:15.284518 13941 leveldb.cpp:400] Deleting ~1 keys from leveldb > took 41767ns > I0218 01:55:15.284533 13941 replica.cpp:678] Persisted action at 2 > I0218 01:55:15.284548 13941 replica.cpp:663] Replica learned 3 action at > position 2 > I0218 01:55:15.294095 13918 containerizer.cpp:104] Using isolation: > posix/cpu,posix/mem > I0218 01:55:15.300398 13933 slave.cpp:173] Slave started on 222)@ > 67.195.81.187:57268 > I0218 01:55:15.300432 13933 credentials.hpp:84] Loading credential for > authentication from > '/tmp/ExceptionTest_DisallowSchedulerCallbacksOnAbort_HYR85I/credential' > I0218 01:55:15.305230 13918 sched.cpp:151] Version: 0.22.0 > I0218 01:55:15.401885 13933 slave.cpp:280] Slave using credential for: > test-principal > I0218 01:55:15.402096 13933 slave.cpp:298] Slave resources: cpus(*):2; > mem(*):1024; disk(*):1024; ports(*):[31000-32000] > I0218 01:55:15.402178 13933 slave.cpp:327] Slave hostname: > pomona.apache.org > I0218 01:55:15.402190 13933 slave.cpp:328] Slave checkpoint: false > W0218 01:55:15.402196 13933 slave.cpp:330] Disabling checkpointing is > deprecated and the --checkpoint flag will be removed in a future release. > Please avoid using this flag > I0218 01:55:15.402732 13938 sched.cpp:248] New master detected at > master@67.195.81.187:57268 > I0218 01:55:15.402848 13938 sched.cpp:304] Authenticating with master > master@67.195.81.187:57268 > I0218 01:55:15.402870 13938 sched.cpp:311] Using default CRAM-MD5 > authenticatee > I0218 01:55:15.403012 13947 state.cpp:34] Recovering state from > '/tmp/ExceptionTest_DisallowSchedulerCallbacksOnAbort_HYR85I/meta' > I0218 01:55:15.403075 13943 authenticatee.hpp:138] Creating new client > SASL connection > I0218 01:55:15.403332 13936 status_update_manager.cpp:196] Recovering > status update manager > I0218 01:55:15.403370 13937 master.cpp:3811] Authenticating > scheduler-47e94f5b-4dfc-4b14-8eb3-8d94b57bffd6@67.195.81.187:57268 > I0218 01:55:15.403400 13937 master.cpp:3822] Using default CRAM-MD5 > authenticator > I0218 01:55:15.403607 13938 containerizer.cpp:301] Recovering containerizer > I0218 01:55:15.403657 13947 authenticator.hpp:169] Creating new server > SASL connection > I0218 01:55:15.403861 13947 authenticatee.hpp:229] Received SASL > authentication mechanisms: CRAM-MD5 > I0218 01:55:15.403889 13947 authenticatee.hpp:255] Attempting to > authenticate with mechanism 'CRAM-MD5' > I0218 01:55:15.404000 13936 authenticator.hpp:275] Received SASL > authentication start > I0218 01:55:15.404057 13936 authenticator.hpp:397] Authentication requires > more steps > I0218 01:55:15.404177 13936 authenticatee.hpp:275] Received SASL > authentication step > I0218 01:55:15.404350 13934 authenticator.hpp:303] Received SASL > authentication step > I0218 01:55:15.404391 13934 auxprop.cpp:98] 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 > I0218 01:55:15.404412 13934 auxprop.cpp:170] Looking up auxiliary property > '*userPassword' > I0218 01:55:15.404458 13934 auxprop.cpp:170] Looking up auxiliary property > '*cmusaslsecretCRAM-MD5' > I0218 01:55:15.404486 13934 auxprop.cpp:98] 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 > I0218 01:55:15.404505 13934 auxprop.cpp:120] Skipping auxiliary property > '*userPassword' since SASL_AUXPROP_AUTHZID == true > I0218 01:55:15.404521 13934 auxprop.cpp:120] Skipping auxiliary property > '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true > I0218 01:55:15.404548 13934 authenticator.hpp:389] Authentication success > I0218 01:55:15.404657 13932 authenticatee.hpp:315] Authentication success > I0218 01:55:15.404680 13937 slave.cpp:3611] Finished recovery > I0218 01:55:15.404716 13943 master.cpp:3869] Successfully authenticated > principal 'test-principal' at > scheduler-47e94f5b-4dfc-4b14-8eb3-8d94b57bffd6@67.195.81.187:57268 > I0218 01:55:15.405220 13933 sched.cpp:392] Successfully authenticated with > master master@67.195.81.187:57268 > I0218 01:55:15.405248 13933 sched.cpp:515] Sending registration request to > master@67.195.81.187:57268 > I0218 01:55:15.405390 13933 sched.cpp:548] Will retry registration in > 1.684708433secs if necessary > I0218 01:55:15.405504 13943 master.cpp:1572] Received registration request > for framework 'default' at > scheduler-47e94f5b-4dfc-4b14-8eb3-8d94b57bffd6@67.195.81.187:57268 > I0218 01:55:15.405586 13933 slave.cpp:623] New master detected at > master@67.195.81.187:57268 > I0218 01:55:15.405597 13943 master.cpp:1433] Authorizing framework > principal 'test-principal' to receive offers for role '*' > I0218 01:55:15.405594 13946 status_update_manager.cpp:170] Pausing sending > status updates > I0218 01:55:15.405670 13933 slave.cpp:686] Authenticating with master > master@67.195.81.187:57268 > I0218 01:55:15.405690 13933 slave.cpp:691] Using default CRAM-MD5 > authenticatee > I0218 01:55:15.405838 13933 slave.cpp:659] Detecting new master > I0218 01:55:15.405859 13939 authenticatee.hpp:138] Creating new client > SASL connection > I0218 01:55:15.406088 13944 master.cpp:1636] Registering framework > 20150218-015515-3142697795-57268-13918-0000 (default) at > scheduler-47e94f5b-4dfc-4b14-8eb3-8d94b57bffd6@67.195.81.187:57268 > I0218 01:55:15.406452 13941 hierarchical.hpp:320] Added framework > 20150218-015515-3142697795-57268-13918-0000 > I0218 01:55:15.406489 13941 hierarchical.hpp:831] No resources available > to allocate! > I0218 01:55:15.406507 13941 hierarchical.hpp:738] Performed allocation for > 0 slaves in 28112ns > I0218 01:55:15.406538 13942 sched.cpp:442] Framework registered with > 20150218-015515-3142697795-57268-13918-0000 > I0218 01:55:15.406582 13942 sched.cpp:456] Scheduler::registered took > 19531ns > I0218 01:55:15.406606 13944 master.cpp:3811] Authenticating slave(222)@ > 67.195.81.187:57268 > I0218 01:55:15.406628 13944 master.cpp:3822] Using default CRAM-MD5 > authenticator > I0218 01:55:15.406833 13943 authenticator.hpp:169] Creating new server > SASL connection > I0218 01:55:15.407002 13943 authenticatee.hpp:229] Received SASL > authentication mechanisms: CRAM-MD5 > I0218 01:55:15.407033 13943 authenticatee.hpp:255] Attempting to > authenticate with mechanism 'CRAM-MD5' > I0218 01:55:15.407112 13948 process.cpp:2117] Dropped / Lost event for > PID: hierarchical-allocator(244)@67.195.81.187:57268 > I0218 01:55:15.407146 13946 authenticator.hpp:275] Received SASL > authentication start > I0218 01:55:15.407197 13946 authenticator.hpp:397] Authentication requires > more steps > I0218 01:55:15.407312 13937 authenticatee.hpp:275] Received SASL > authentication step > I0218 01:55:15.407471 13945 authenticator.hpp:303] Received SASL > authentication step > I0218 01:55:15.407500 13945 auxprop.cpp:98] 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 > I0218 01:55:15.407510 13945 auxprop.cpp:170] Looking up auxiliary property > '*userPassword' > I0218 01:55:15.407539 13945 auxprop.cpp:170] Looking up auxiliary property > '*cmusaslsecretCRAM-MD5' > I0218 01:55:15.407562 13945 auxprop.cpp:98] 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 > I0218 01:55:15.407572 13945 auxprop.cpp:120] Skipping auxiliary property > '*userPassword' since SASL_AUXPROP_AUTHZID == true > I0218 01:55:15.407580 13945 auxprop.cpp:120] Skipping auxiliary property > '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true > I0218 01:55:15.407595 13945 authenticator.hpp:389] Authentication success > I0218 01:55:15.407697 13946 authenticatee.hpp:315] Authentication success > I0218 01:55:15.407702 13937 master.cpp:3869] Successfully authenticated > principal 'test-principal' at slave(222)@67.195.81.187:57268 > I0218 01:55:15.408095 13943 slave.cpp:757] Successfully authenticated with > master master@67.195.81.187:57268 > I0218 01:55:15.408252 13943 slave.cpp:1089] Will retry registration in > 5.107666ms if necessary > I0218 01:55:15.408439 13938 master.cpp:2936] Registering slave at > slave(222)@67.195.81.187:57268 (pomona.apache.org) with id > 20150218-015515-3142697795-57268-13918-S0 > I0218 01:55:15.408859 13946 registrar.cpp:444] Applied 1 operations in > 63151ns; attempting to update the 'registry' > I0218 01:55:15.411748 13937 log.cpp:683] Attempting to append 316 bytes to > the log > I0218 01:55:15.411895 13942 coordinator.cpp:339] Coordinator attempting to > write 2 action at position 3 > I0218 01:55:15.414677 13944 slave.cpp:1089] Will retry registration in > 3.876088ms if necessary > I0218 01:55:15.414839 13936 master.cpp:2924] Ignoring register slave > message from slave(222)@67.195.81.187:57268 (pomona.apache.org) as > admission is already in progress > I0218 01:55:15.429661 13948 process.cpp:2117] Dropped / Lost event for > PID: hierarchical-allocator(245)@67.195.81.187:57268 > I0218 01:55:15.559209 13948 process.cpp:2117] Dropped / Lost event for > PID: hierarchical-allocator(246)@67.195.81.187:57268 > I0218 01:55:15.560606 13937 replica.cpp:510] Replica received write > request for position 3 > I0218 01:55:15.560876 13937 leveldb.cpp:342] Persisting action (335 bytes) > to leveldb took 224285ns > I0218 01:55:15.560899 13937 replica.cpp:678] Persisted action at 3 > I0218 01:55:15.562650 13936 replica.cpp:657] Replica received learned > notice for position 3 > I0218 01:55:15.563143 13936 leveldb.cpp:342] Persisting action (337 bytes) > to leveldb took 458021ns > I0218 01:55:15.563145 13937 slave.cpp:1089] Will retry registration in > 27.373943ms if necessary > I0218 01:55:15.563185 13936 replica.cpp:678] Persisted action at 3 > I0218 01:55:15.563222 13936 replica.cpp:663] Replica learned 2 action at > position 3 > I0218 01:55:15.563364 13932 master.cpp:2924] Ignoring register slave > message from slave(222)@67.195.81.187:57268 (pomona.apache.org) as > admission is already in progress > I0218 01:55:15.564877 13935 log.cpp:702] Attempting to truncate the log to > 3 > I0218 01:55:15.564936 13939 registrar.cpp:489] Successfully updated the > 'registry' in 155.678976ms > I0218 01:55:15.565021 13943 coordinator.cpp:339] Coordinator attempting to > write 3 action at position 4 > I0218 01:55:15.565786 13935 replica.cpp:510] Replica received write > request for position 4 > I0218 01:55:15.565812 13939 slave.cpp:2666] Received ping from > slave-observer(199)@67.195.81.187:57268 > I0218 01:55:15.565982 13940 master.cpp:2993] Registered slave > 20150218-015515-3142697795-57268-13918-S0 at slave(222)@ > 67.195.81.187:57268 (pomona.apache.org) with cpus(*):2; mem(*):1024; > disk(*):1024; ports(*):[31000-32000] > I0218 01:55:15.566082 13939 slave.cpp:791] Registered with master > master@67.195.81.187:57268; given slave ID > 20150218-015515-3142697795-57268-13918-S0 > I0218 01:55:15.566118 13947 hierarchical.hpp:452] Added slave > 20150218-015515-3142697795-57268-13918-S0 (pomona.apache.org) with > cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (and > cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] available) > I0218 01:55:15.566160 13935 leveldb.cpp:342] Persisting action (16 bytes) > to leveldb took 338964ns > I0218 01:55:15.566195 13935 replica.cpp:678] Persisted action at 4 > I0218 01:55:15.566195 13937 status_update_manager.cpp:177] Resuming > sending status updates > I0218 01:55:15.566603 13947 hierarchical.hpp:756] Performed allocation for > slave 20150218-015515-3142697795-57268-13918-S0 in 421519ns > I0218 01:55:15.566828 13943 replica.cpp:657] Replica received learned > notice for position 4 > I0218 01:55:15.566946 13937 master.cpp:3753] Sending 1 offers to framework > 20150218-015515-3142697795-57268-13918-0000 (default) at > scheduler-47e94f5b-4dfc-4b14-8eb3-8d94b57bffd6@67.195.81.187:57268 > I0218 01:55:15.567214 13943 leveldb.cpp:342] Persisting action (18 bytes) > to leveldb took 361791ns > I0218 01:55:15.567261 13943 leveldb.cpp:400] Deleting ~2 keys from leveldb > took 29859ns > I0218 01:55:15.567275 13943 replica.cpp:678] Persisted action at 4 > I0218 01:55:15.567302 13943 replica.cpp:663] Replica learned 3 action at > position 4 > I0218 01:55:15.567345 13934 sched.cpp:605] Scheduler::resourceOffers took > 106099ns > I0218 01:55:15.567883 13918 sched.cpp:1504] Asked to abort the driver > I0218 01:55:15.568099 13935 sched.cpp:833] Aborting framework > '20150218-015515-3142697795-57268-13918-0000' > I0218 01:55:15.568346 13936 master.cpp:1957] Deactivating framework > 20150218-015515-3142697795-57268-13918-0000 (default) at > scheduler-47e94f5b-4dfc-4b14-8eb3-8d94b57bffd6@67.195.81.187:57268 > I0218 01:55:15.568480 13935 sched.cpp:611] Ignoring rescind offer message > because the driver is not running! > I0218 01:55:15.568527 13937 hierarchical.hpp:399] Deactivated framework > 20150218-015515-3142697795-57268-13918-0000 > I0218 01:55:15.568737 13937 hierarchical.hpp:645] Recovered cpus(*):2; > mem(*):1024; disk(*):1024; ports(*):[31000-32000] (total allocatable: > cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]) on slave > 20150218-015515-3142697795-57268-13918-S0 from framework > 20150218-015515-3142697795-57268-13918-0000 > I0218 01:55:15.568860 13934 sched.cpp:611] Ignoring rescind offer message > because the driver is not running! > I0218 01:55:15.568974 13918 sched.cpp:1470] Asked to stop the driver > I0218 01:55:15.569103 13937 sched.cpp:808] Stopping framework > '20150218-015515-3142697795-57268-13918-0000' > I0218 01:55:15.569435 13942 master.cpp:1896] Asked to unregister framework > 20150218-015515-3142697795-57268-13918-0000 > I0218 01:55:15.569473 13942 master.cpp:4181] Removing framework > 20150218-015515-3142697795-57268-13918-0000 (default) at > scheduler-47e94f5b-4dfc-4b14-8eb3-8d94b57bffd6@67.195.81.187:57268 > I0218 01:55:15.569919 13932 slave.cpp:1594] Asked to shut down framework > 20150218-015515-3142697795-57268-13918-0000 by master@67.195.81.187:57268 > W0218 01:55:15.569950 13932 slave.cpp:1609] Cannot shut down unknown > framework 20150218-015515-3142697795-57268-13918-0000 > I0218 01:55:15.571519 13942 master.cpp:785] Master terminating > I0218 01:55:15.571637 13946 hierarchical.hpp:353] Removed framework > 20150218-015515-3142697795-57268-13918-0000 > I0218 01:55:15.572909 13942 slave.cpp:2751] master@67.195.81.187:57268 > exited > W0218 01:55:15.572942 13942 slave.cpp:2754] Master disconnected! Waiting > for a new master to be elected > I0218 01:55:15.574981 13918 process.cpp:2117] Dropped / Lost event for > PID: master@67.195.81.187:57268 > I0218 01:55:15.575103 13918 process.cpp:2117] Dropped / Lost event for > PID: master@67.195.81.187:57268 > I0218 01:55:15.580725 13933 slave.cpp:505] Slave terminating > I0218 01:55:15.583437 13918 process.cpp:2117] Dropped / Lost event for > PID: slave(222)@67.195.81.187:57268 > I0218 01:55:15.584887 13918 process.cpp:2117] Dropped / Lost event for > PID: scheduler-47e94f5b-4dfc-4b14-8eb3-8d94b57bffd6@67.195.81.187:57268 > [ OK ] ExceptionTest.DisallowSchedulerCallbacksOnAbort (342 ms) > [----------] 3 tests from ExceptionTest (1134 ms total) > > [----------] Global test environment tear-down > I0218 01:55:15.590626 13948 process.cpp:2117] Dropped / Lost event for > PID: slave(222)@67.195.81.187:57268 > [==========] 487 tests from 77 test cases ran. (249081 ms total) > [ PASSED ] 486 tests. > [ FAILED ] 1 test, listed below: > [ FAILED ] MasterSlaveReconciliationTest.ReconcileLostTask > > 1 FAILED TEST > YOU HAVE 7 DISABLED TESTS > > make[3]: *** [check-local] Error 1 > 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 > Recording test results >