See <https://builds.apache.org/job/Mesos-Ubuntu-distcheck/157/changes>
Changes: [bmahler] Added logging for ip resolution errors in libprocess. [bmahler] Added process delegate for accessing the scheduler endpoint. ------------------------------------------ [...truncated 57876 lines...] I0619 01:16:36.044014 5221 auxprop.cpp:81] Request to lookup properties for user: 'test-principal' realm: 'hemera.apache.org' server FQDN: 'hemera.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0619 01:16:36.044023 5221 auxprop.cpp:103] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0619 01:16:36.044028 5221 auxprop.cpp:103] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0619 01:16:36.044042 5221 authenticator.hpp:376] Authentication success I0619 01:16:36.044169 5227 authenticatee.hpp:305] Authentication success I0619 01:16:36.044698 5213 master.cpp:3497] Successfully authenticated principal 'test-principal' at [email protected]:48847 I0619 01:16:36.044972 5231 sched.cpp:359] Successfully authenticated with master [email protected]:48847 I0619 01:16:36.044999 5231 sched.cpp:478] Sending registration request to [email protected]:48847 I0619 01:16:36.045068 5224 master.cpp:1196] Received registration request from [email protected]:48847 I0619 01:16:36.045100 5224 master.cpp:1156] Authorizing framework principal 'test-principal' to receive offers for role 'role1' I0619 01:16:36.045348 5220 master.cpp:1255] Registering framework 20140619-011635-453759884-48847-5135-0002 at [email protected]:48847 I0619 01:16:36.045445 5210 sched.cpp:409] Framework registered with 20140619-011635-453759884-48847-5135-0002 I0619 01:16:36.045470 5210 sched.cpp:423] Scheduler::registered took 10645ns I0619 01:16:36.045534 5221 hierarchical_allocator_process.hpp:331] Added framework 20140619-011635-453759884-48847-5135-0002 I0619 01:16:36.045601 5221 hierarchical_allocator_process.hpp:686] Performed allocation for 3 slaves in 52728ns I0619 01:16:36.046247 5135 mesos_containerizer.cpp:125] Using isolation: posix/cpu,posix/mem I0619 01:16:36.048532 5230 slave.cpp:143] Slave started on 184)@140.211.11.27:48847 I0619 01:16:36.048547 5230 credentials.hpp:35] Loading credentials for authentication from '/tmp/DRFAllocatorTest_DRFAllocatorProcess_NxjSbo/credential' I0619 01:16:36.048673 5230 slave.cpp:243] Slave using credential for: test-principal I0619 01:16:36.048758 5230 slave.cpp:256] Slave resources: cpus(*):4; mem(*):4096; disk(*):0; ports(*):[31000-32000] I0619 01:16:36.048809 5230 slave.cpp:284] Slave hostname: hemera.apache.org I0619 01:16:36.048817 5230 slave.cpp:285] Slave checkpoint: false I0619 01:16:36.048888 5211 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 10.074947ms I0619 01:16:36.048909 5211 replica.cpp:676] Persisted action at 8 I0619 01:16:36.049300 5216 replica.cpp:655] Replica received learned notice for position 8 I0619 01:16:36.049588 5232 state.cpp:33] Recovering state from '/tmp/DRFAllocatorTest_DRFAllocatorProcess_NxjSbo/meta' I0619 01:16:36.049785 5231 status_update_manager.cpp:193] Recovering status update manager I0619 01:16:36.050251 5231 mesos_containerizer.cpp:283] Recovering containerizer I0619 01:16:36.050669 5210 slave.cpp:3068] Finished recovery I0619 01:16:36.051018 5221 slave.cpp:537] New master detected at [email protected]:48847 I0619 01:16:36.051079 5221 slave.cpp:613] Authenticating with master [email protected]:48847 I0619 01:16:36.051103 5215 status_update_manager.cpp:167] New master detected at [email protected]:48847 I0619 01:16:36.051162 5221 slave.cpp:586] Detecting new master I0619 01:16:36.051213 5222 authenticatee.hpp:128] Creating new client SASL connection I0619 01:16:36.051466 5226 master.cpp:3457] Authenticating slave(184)@140.211.11.27:48847 I0619 01:16:36.051559 5226 authenticator.hpp:156] Creating new server SASL connection I0619 01:16:36.051679 5226 authenticatee.hpp:219] Received SASL authentication mechanisms: CRAM-MD5 I0619 01:16:36.051694 5226 authenticatee.hpp:245] Attempting to authenticate with mechanism 'CRAM-MD5' I0619 01:16:36.051810 5221 authenticator.hpp:262] Received SASL authentication start I0619 01:16:36.051849 5221 authenticator.hpp:384] Authentication requires more steps I0619 01:16:36.051874 5221 authenticatee.hpp:265] Received SASL authentication step I0619 01:16:36.051901 5221 authenticator.hpp:290] Received SASL authentication step I0619 01:16:36.051952 5221 auxprop.cpp:81] Request to lookup properties for user: 'test-principal' realm: 'hemera.apache.org' server FQDN: 'hemera.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0619 01:16:36.051962 5221 auxprop.cpp:153] Looking up auxiliary property '*userPassword' I0619 01:16:36.051970 5221 auxprop.cpp:153] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0619 01:16:36.051976 5221 auxprop.cpp:81] Request to lookup properties for user: 'test-principal' realm: 'hemera.apache.org' server FQDN: 'hemera.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0619 01:16:36.051981 5221 auxprop.cpp:103] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0619 01:16:36.051985 5221 auxprop.cpp:103] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0619 01:16:36.051992 5221 authenticator.hpp:376] Authentication success I0619 01:16:36.052065 5210 authenticatee.hpp:305] Authentication success I0619 01:16:36.052074 5221 master.cpp:3497] Successfully authenticated principal 'test-principal' at slave(184)@140.211.11.27:48847 I0619 01:16:36.052263 5229 slave.cpp:670] Successfully authenticated with master [email protected]:48847 I0619 01:16:36.052304 5229 slave.cpp:908] Will retry registration in 13.300855ms if necessary I0619 01:16:36.052342 5221 master.cpp:2736] Registering slave at slave(184)@140.211.11.27:48847 (hemera.apache.org) with id 20140619-011635-453759884-48847-5135-3 I0619 01:16:36.052438 5230 registrar.cpp:422] Attempting to update the 'registry' I0619 01:16:36.061280 5216 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 11.955129ms I0619 01:16:36.061332 5216 leveldb.cpp:401] Deleting ~2 keys from leveldb took 31310ns I0619 01:16:36.061342 5216 replica.cpp:676] Persisted action at 8 I0619 01:16:36.061349 5216 replica.cpp:661] Replica learned TRUNCATE action at position 8 I0619 01:16:36.061677 5217 log.cpp:680] Attempting to append 897 bytes to the log I0619 01:16:36.061769 5212 coordinator.cpp:340] Coordinator attempting to write APPEND action at position 9 I0619 01:16:36.062556 5231 replica.cpp:508] Replica received write request for position 9 I0619 01:16:36.066651 5223 slave.cpp:908] Will retry registration in 37.42224ms if necessary I0619 01:16:36.066695 5224 master.cpp:2724] Ignoring register slave message from slave(184)@140.211.11.27:48847 (hemera.apache.org) as admission is already in progress I0619 01:16:36.073389 5231 leveldb.cpp:343] Persisting action (916 bytes) to leveldb took 10.807366ms I0619 01:16:36.073418 5231 replica.cpp:676] Persisted action at 9 I0619 01:16:36.074049 5211 replica.cpp:655] Replica received learned notice for position 9 I0619 01:16:36.085521 5211 leveldb.cpp:343] Persisting action (918 bytes) to leveldb took 11.438781ms I0619 01:16:36.085575 5211 replica.cpp:676] Persisted action at 9 I0619 01:16:36.085589 5211 replica.cpp:661] Replica learned APPEND action at position 9 I0619 01:16:36.086160 5221 registrar.cpp:479] Successfully updated 'registry' I0619 01:16:36.086395 5224 log.cpp:699] Attempting to truncate the log to 9 I0619 01:16:36.086534 5221 coordinator.cpp:340] Coordinator attempting to write TRUNCATE action at position 10 I0619 01:16:36.086534 5217 master.cpp:2776] Registered slave 20140619-011635-453759884-48847-5135-3 at slave(184)@140.211.11.27:48847 (hemera.apache.org) I0619 01:16:36.086565 5217 master.cpp:3923] Adding slave 20140619-011635-453759884-48847-5135-3 at slave(184)@140.211.11.27:48847 (hemera.apache.org) with cpus(*):4; mem(*):4096; disk(*):0; ports(*):[31000-32000] I0619 01:16:36.087884 5210 slave.cpp:704] Registered with master [email protected]:48847; given slave ID 20140619-011635-453759884-48847-5135-3 I0619 01:16:36.088208 5218 replica.cpp:508] Replica received write request for position 10 I0619 01:16:36.088553 5226 hierarchical_allocator_process.hpp:444] Added slave 20140619-011635-453759884-48847-5135-3 (hemera.apache.org) with cpus(*):4; mem(*):4096; disk(*):0; ports(*):[31000-32000] (and cpus(*):4; mem(*):4096; disk(*):0; ports(*):[31000-32000] available) I0619 01:16:36.088661 5226 hierarchical_allocator_process.hpp:750] Offering cpus(*):4; mem(*):4096; disk(*):0; ports(*):[31000-32000] on slave 20140619-011635-453759884-48847-5135-3 to framework 20140619-011635-453759884-48847-5135-0002 I0619 01:16:36.088829 5226 hierarchical_allocator_process.hpp:706] Performed allocation for slave 20140619-011635-453759884-48847-5135-3 in 206634ns I0619 01:16:36.088891 5214 master.hpp:785] Adding offer 20140619-011635-453759884-48847-5135-3 with resources cpus(*):4; mem(*):4096; disk(*):0; ports(*):[31000-32000] on slave 20140619-011635-453759884-48847-5135-3 (hemera.apache.org) I0619 01:16:36.088929 5214 master.cpp:3404] Sending 1 offers to framework 20140619-011635-453759884-48847-5135-0002 I0619 01:16:36.089170 5230 sched.cpp:546] Scheduler::resourceOffers took 29630ns I0619 01:16:36.092115 5135 sched.cpp:139] Version: 0.20.0 I0619 01:16:36.092353 5232 sched.cpp:235] New master detected at [email protected]:48847 I0619 01:16:36.092372 5232 sched.cpp:285] Authenticating with master [email protected]:48847 I0619 01:16:36.092517 5211 authenticatee.hpp:128] Creating new client SASL connection I0619 01:16:36.092702 5211 master.cpp:3457] Authenticating [email protected]:48847 I0619 01:16:36.092856 5209 authenticator.hpp:156] Creating new server SASL connection I0619 01:16:36.093091 5210 authenticatee.hpp:219] Received SASL authentication mechanisms: CRAM-MD5 I0619 01:16:36.093122 5210 authenticatee.hpp:245] Attempting to authenticate with mechanism 'CRAM-MD5' I0619 01:16:36.093703 5230 authenticator.hpp:262] Received SASL authentication start I0619 01:16:36.093778 5230 authenticator.hpp:384] Authentication requires more steps I0619 01:16:36.093818 5230 authenticatee.hpp:265] Received SASL authentication step I0619 01:16:36.094140 5226 authenticator.hpp:290] Received SASL authentication step I0619 01:16:36.094193 5226 auxprop.cpp:81] Request to lookup properties for user: 'test-principal' realm: 'hemera.apache.org' server FQDN: 'hemera.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0619 01:16:36.094199 5226 auxprop.cpp:153] Looking up auxiliary property '*userPassword' I0619 01:16:36.094208 5226 auxprop.cpp:153] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0619 01:16:36.094213 5226 auxprop.cpp:81] Request to lookup properties for user: 'test-principal' realm: 'hemera.apache.org' server FQDN: 'hemera.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0619 01:16:36.094218 5226 auxprop.cpp:103] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0619 01:16:36.094221 5226 auxprop.cpp:103] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0619 01:16:36.094230 5226 authenticator.hpp:376] Authentication success I0619 01:16:36.094254 5226 authenticatee.hpp:305] Authentication success I0619 01:16:36.094370 5219 master.cpp:3497] Successfully authenticated principal 'test-principal' at [email protected]:48847 I0619 01:16:36.094581 5230 sched.cpp:359] Successfully authenticated with master [email protected]:48847 I0619 01:16:36.094595 5230 sched.cpp:478] Sending registration request to [email protected]:48847 I0619 01:16:36.094636 5230 master.cpp:1196] Received registration request from [email protected]:48847 I0619 01:16:36.094725 5230 master.cpp:1156] Authorizing framework principal 'test-principal' to receive offers for role 'role1' I0619 01:16:36.095087 5220 master.cpp:1255] Registering framework 20140619-011635-453759884-48847-5135-0003 at [email protected]:48847 I0619 01:16:36.095155 5220 sched.cpp:409] Framework registered with 20140619-011635-453759884-48847-5135-0003 I0619 01:16:36.095180 5220 sched.cpp:423] Scheduler::registered took 10639ns I0619 01:16:36.095221 5220 hierarchical_allocator_process.hpp:331] Added framework 20140619-011635-453759884-48847-5135-0003 I0619 01:16:36.095342 5220 hierarchical_allocator_process.hpp:686] Performed allocation for 4 slaves in 47244ns I0619 01:16:36.095880 5135 mesos_containerizer.cpp:125] Using isolation: posix/cpu,posix/mem I0619 01:16:36.098332 5211 slave.cpp:143] Slave started on 185)@140.211.11.27:48847 I0619 01:16:36.098356 5211 credentials.hpp:35] Loading credentials for authentication from '/tmp/DRFAllocatorTest_DRFAllocatorProcess_jFOGoJ/credential' I0619 01:16:36.098559 5211 slave.cpp:243] Slave using credential for: test-principal I0619 01:16:36.098649 5211 slave.cpp:256] Slave resources: cpus(*):1; mem(*):512; disk(*):0; ports(*):[31000-32000] I0619 01:16:36.098714 5211 slave.cpp:284] Slave hostname: hemera.apache.org I0619 01:16:36.098722 5211 slave.cpp:285] Slave checkpoint: false I0619 01:16:36.099120 5228 state.cpp:33] Recovering state from '/tmp/DRFAllocatorTest_DRFAllocatorProcess_jFOGoJ/meta' I0619 01:16:36.099298 5219 status_update_manager.cpp:193] Recovering status update manager I0619 01:16:36.100184 5224 mesos_containerizer.cpp:283] Recovering containerizer I0619 01:16:36.100806 5209 slave.cpp:3068] Finished recovery I0619 01:16:36.101135 5211 slave.cpp:537] New master detected at [email protected]:48847 I0619 01:16:36.101194 5211 slave.cpp:613] Authenticating with master [email protected]:48847 I0619 01:16:36.101239 5219 status_update_manager.cpp:167] New master detected at [email protected]:48847 I0619 01:16:36.101337 5211 slave.cpp:586] Detecting new master I0619 01:16:36.101352 5213 authenticatee.hpp:128] Creating new client SASL connection I0619 01:16:36.101497 5218 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 13.270376ms I0619 01:16:36.101519 5218 replica.cpp:676] Persisted action at 10 I0619 01:16:36.101536 5211 master.cpp:3457] Authenticating slave(185)@140.211.11.27:48847 I0619 01:16:36.101608 5211 authenticator.hpp:156] Creating new server SASL connection I0619 01:16:36.101922 5214 authenticatee.hpp:219] Received SASL authentication mechanisms: CRAM-MD5 I0619 01:16:36.101943 5214 authenticatee.hpp:245] Attempting to authenticate with mechanism 'CRAM-MD5' I0619 01:16:36.102357 5227 replica.cpp:655] Replica received learned notice for position 10 I0619 01:16:36.102898 5209 authenticator.hpp:262] Received SASL authentication start I0619 01:16:36.103124 5209 authenticator.hpp:384] Authentication requires more steps I0619 01:16:36.103246 5224 authenticatee.hpp:265] Received SASL authentication step I0619 01:16:36.103353 5224 authenticator.hpp:290] Received SASL authentication step I0619 01:16:36.103376 5224 auxprop.cpp:81] Request to lookup properties for user: 'test-principal' realm: 'hemera.apache.org' server FQDN: 'hemera.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0619 01:16:36.103384 5224 auxprop.cpp:153] Looking up auxiliary property '*userPassword' I0619 01:16:36.103394 5224 auxprop.cpp:153] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0619 01:16:36.103404 5224 auxprop.cpp:81] Request to lookup properties for user: 'test-principal' realm: 'hemera.apache.org' server FQDN: 'hemera.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0619 01:16:36.103411 5224 auxprop.cpp:103] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0619 01:16:36.103417 5224 auxprop.cpp:103] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0619 01:16:36.103430 5224 authenticator.hpp:376] Authentication success I0619 01:16:36.103498 5224 master.cpp:3497] Successfully authenticated principal 'test-principal' at slave(185)@140.211.11.27:48847 I0619 01:16:36.103535 5210 authenticatee.hpp:305] Authentication success I0619 01:16:36.103862 5212 slave.cpp:670] Successfully authenticated with master [email protected]:48847 I0619 01:16:36.104279 5217 master.cpp:2736] Registering slave at slave(185)@140.211.11.27:48847 (hemera.apache.org) with id 20140619-011635-453759884-48847-5135-4 I0619 01:16:36.104276 5212 slave.cpp:908] Will retry registration in 5.27901ms if necessary I0619 01:16:36.104379 5217 registrar.cpp:422] Attempting to update the 'registry' I0619 01:16:36.110299 5217 slave.cpp:908] Will retry registration in 31.180772ms if necessary I0619 01:16:36.110321 5225 master.cpp:2724] Ignoring register slave message from slave(185)@140.211.11.27:48847 (hemera.apache.org) as admission is already in progress I0619 01:16:36.113929 5227 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 11.52181ms I0619 01:16:36.113996 5227 leveldb.cpp:401] Deleting ~2 keys from leveldb took 33526ns I0619 01:16:36.114045 5227 replica.cpp:676] Persisted action at 10 I0619 01:16:36.114053 5227 replica.cpp:661] Replica learned TRUNCATE action at position 10 I0619 01:16:36.114373 5218 log.cpp:680] Attempting to append 1086 bytes to the log I0619 01:16:36.114590 5214 coordinator.cpp:340] Coordinator attempting to write APPEND action at position 11 I0619 01:16:36.115583 5222 replica.cpp:508] Replica received write request for position 11 I0619 01:16:36.130033 5222 leveldb.cpp:343] Persisting action (1105 bytes) to leveldb took 14.423155ms I0619 01:16:36.130081 5222 replica.cpp:676] Persisted action at 11 I0619 01:16:36.131031 5216 replica.cpp:655] Replica received learned notice for position 11 I0619 01:16:36.141700 5227 slave.cpp:908] Will retry registration in 13.762067ms if necessary I0619 01:16:36.141757 5232 master.cpp:2724] Ignoring register slave message from slave(185)@140.211.11.27:48847 (hemera.apache.org) as admission is already in progress I0619 01:16:36.154201 5216 leveldb.cpp:343] Persisting action (1107 bytes) to leveldb took 23.14169ms I0619 01:16:36.154245 5216 replica.cpp:676] Persisted action at 11 I0619 01:16:36.154259 5216 replica.cpp:661] Replica learned APPEND action at position 11 I0619 01:16:36.154971 5228 registrar.cpp:479] Successfully updated 'registry' I0619 01:16:36.155280 5221 master.cpp:2776] Registered slave 20140619-011635-453759884-48847-5135-4 at slave(185)@140.211.11.27:48847 (hemera.apache.org) I0619 01:16:36.155313 5221 master.cpp:3923] Adding slave 20140619-011635-453759884-48847-5135-4 at slave(185)@140.211.11.27:48847 (hemera.apache.org) with cpus(*):1; mem(*):512; disk(*):0; ports(*):[31000-32000] I0619 01:16:36.155557 5222 slave.cpp:704] Registered with master [email protected]:48847; given slave ID 20140619-011635-453759884-48847-5135-4 I0619 01:16:36.155673 5218 log.cpp:699] Attempting to truncate the log to 11 I0619 01:16:36.155930 5226 hierarchical_allocator_process.hpp:444] Added slave 20140619-011635-453759884-48847-5135-4 (hemera.apache.org) with cpus(*):1; mem(*):512; disk(*):0; ports(*):[31000-32000] (and cpus(*):1; mem(*):512; disk(*):0; ports(*):[31000-32000] available) I0619 01:16:36.156097 5217 coordinator.cpp:340] Coordinator attempting to write TRUNCATE action at position 12 I0619 01:16:36.156085 5226 hierarchical_allocator_process.hpp:750] Offering cpus(*):1; mem(*):512; disk(*):0; ports(*):[31000-32000] on slave 20140619-011635-453759884-48847-5135-4 to framework 20140619-011635-453759884-48847-5135-0001 I0619 01:16:36.156384 5226 hierarchical_allocator_process.hpp:706] Performed allocation for slave 20140619-011635-453759884-48847-5135-4 in 392237ns I0619 01:16:36.156445 5224 master.hpp:785] Adding offer 20140619-011635-453759884-48847-5135-4 with resources cpus(*):1; mem(*):512; disk(*):0; ports(*):[31000-32000] on slave 20140619-011635-453759884-48847-5135-4 (hemera.apache.org) I0619 01:16:36.156507 5224 master.cpp:3404] Sending 1 offers to framework 20140619-011635-453759884-48847-5135-0001 I0619 01:16:36.156777 5228 sched.cpp:546] Scheduler::resourceOffers took 41735ns I0619 01:16:36.157114 5213 sched.cpp:747] Stopping framework '20140619-011635-453759884-48847-5135-0001' I0619 01:16:36.157124 5221 replica.cpp:508] Replica received write request for position 12 I0619 01:16:36.157150 5229 sched.cpp:747] Stopping framework '20140619-011635-453759884-48847-5135-0002' I0619 01:16:36.157198 5231 sched.cpp:747] Stopping framework '20140619-011635-453759884-48847-5135-0003' I0619 01:16:36.157263 5228 sched.cpp:747] Stopping framework '20140619-011635-453759884-48847-5135-0000' I0619 01:16:36.157354 5215 master.cpp:1485] Asked to unregister framework 20140619-011635-453759884-48847-5135-0001 I0619 01:16:36.157367 5215 master.cpp:3779] Removing framework 20140619-011635-453759884-48847-5135-0001 I0619 01:16:36.157462 5212 slave.cpp:1343] Asked to shut down framework 20140619-011635-453759884-48847-5135-0001 by [email protected]:48847 I0619 01:16:36.157482 5222 slave.cpp:1343] Asked to shut down framework 20140619-011635-453759884-48847-5135-0001 by [email protected]:48847 W0619 01:16:36.157490 5212 slave.cpp:1358] Cannot shut down unknown framework 20140619-011635-453759884-48847-5135-0001 W0619 01:16:36.157498 5222 slave.cpp:1358] Cannot shut down unknown framework 20140619-011635-453759884-48847-5135-0001 I0619 01:16:36.157521 5230 hierarchical_allocator_process.hpp:407] Deactivated framework 20140619-011635-453759884-48847-5135-0001 I0619 01:16:36.157537 5213 slave.cpp:1343] Asked to shut down framework 20140619-011635-453759884-48847-5135-0001 by [email protected]:48847 W0619 01:16:36.157562 5213 slave.cpp:1358] Cannot shut down unknown framework 20140619-011635-453759884-48847-5135-0001 I0619 01:16:36.157565 5223 slave.cpp:1343] Asked to shut down framework 20140619-011635-453759884-48847-5135-0001 by [email protected]:48847 W0619 01:16:36.157582 5223 slave.cpp:1358] Cannot shut down unknown framework 20140619-011635-453759884-48847-5135-0001 I0619 01:16:36.157593 5218 slave.cpp:1343] Asked to shut down framework 20140619-011635-453759884-48847-5135-0001 by [email protected]:48847 I0619 01:16:36.157591 5215 master.hpp:795] Removing offer 20140619-011635-453759884-48847-5135-2 with resources cpus(*):3; mem(*):2048; disk(*):0; ports(*):[31000-32000] on slave 20140619-011635-453759884-48847-5135-2 (hemera.apache.org) W0619 01:16:36.157650 5218 slave.cpp:1358] Cannot shut down unknown framework 20140619-011635-453759884-48847-5135-0001 I0619 01:16:36.157716 5215 master.hpp:795] Removing offer 20140619-011635-453759884-48847-5135-4 with resources cpus(*):1; mem(*):512; disk(*):0; ports(*):[31000-32000] on slave 20140619-011635-453759884-48847-5135-4 (hemera.apache.org) I0619 01:16:36.157800 5215 master.hpp:795] Removing offer 20140619-011635-453759884-48847-5135-1 with resources cpus(*):1; mem(*):512; disk(*):0; ports(*):[31000-32000] on slave 20140619-011635-453759884-48847-5135-1 (hemera.apache.org) I0619 01:16:36.157809 5212 hierarchical_allocator_process.hpp:635] Recovered cpus(*):3; mem(*):2048; ports(*):[31000-32000] (total allocatable: cpus(*):3; mem(*):2048; disk(*):0; ports(*):[31000-32000]) on slave 20140619-011635-453759884-48847-5135-2 from framework 20140619-011635-453759884-48847-5135-0001 I0619 01:16:36.157866 5215 master.cpp:610] Master terminating I0619 01:16:36.157901 5212 hierarchical_allocator_process.hpp:635] Recovered cpus(*):1; mem(*):512; ports(*):[31000-32000] (total allocatable: cpus(*):1; mem(*):512; disk(*):0; ports(*):[31000-32000]) on slave 20140619-011635-453759884-48847-5135-4 from framework 20140619-011635-453759884-48847-5135-0001 I0619 01:16:36.157915 5215 master.hpp:795] Removing offer 20140619-011635-453759884-48847-5135-3 with resources cpus(*):4; mem(*):4096; disk(*):0; ports(*):[31000-32000] on slave 20140619-011635-453759884-48847-5135-3 (hemera.apache.org) I0619 01:16:36.158001 5212 hierarchical_allocator_process.hpp:635] Recovered cpus(*):1; mem(*):512; ports(*):[31000-32000] (total allocatable: cpus(*):1; mem(*):512; disk(*):0; ports(*):[31000-32000]) on slave 20140619-011635-453759884-48847-5135-1 from framework 20140619-011635-453759884-48847-5135-0001 I0619 01:16:36.158006 5215 master.hpp:795] Removing offer 20140619-011635-453759884-48847-5135-0 with resources cpus(*):2; mem(*):1024; disk(*):0; ports(*):[31000-32000] on slave 20140619-011635-453759884-48847-5135-0 (hemera.apache.org) I0619 01:16:36.158051 5212 hierarchical_allocator_process.hpp:362] Removed framework 20140619-011635-453759884-48847-5135-0001 I0619 01:16:36.158604 5220 slave.cpp:2267] [email protected]:48847 exited W0619 01:16:36.158630 5220 slave.cpp:2270] Master disconnected! Waiting for a new master to be elected I0619 01:16:36.158639 5211 slave.cpp:2267] [email protected]:48847 exited W0619 01:16:36.158659 5211 slave.cpp:2270] Master disconnected! Waiting for a new master to be elected I0619 01:16:36.158711 5218 slave.cpp:2267] [email protected]:48847 exited W0619 01:16:36.158735 5218 slave.cpp:2270] Master disconnected! Waiting for a new master to be elected I0619 01:16:36.158752 5224 slave.cpp:2267] [email protected]:48847 exited W0619 01:16:36.158769 5224 slave.cpp:2270] Master disconnected! Waiting for a new master to be elected I0619 01:16:36.158778 5213 slave.cpp:2267] [email protected]:48847 exited W0619 01:16:36.158794 5213 slave.cpp:2270] Master disconnected! Waiting for a new master to be elected I0619 01:16:36.174202 5221 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 17.027155ms I0619 01:16:36.174242 5221 replica.cpp:676] Persisted action at 12 I0619 01:16:36.175300 5135 slave.cpp:426] Slave terminating I0619 01:16:36.177283 5135 slave.cpp:426] Slave terminating I0619 01:16:36.178537 5232 slave.cpp:426] Slave terminating I0619 01:16:36.180469 5209 slave.cpp:426] Slave terminating I0619 01:16:36.181773 5135 slave.cpp:426] Slave terminating [ OK ] DRFAllocatorTest.DRFAllocatorProcess (482 ms) [----------] 1 test from DRFAllocatorTest (482 ms total) [----------] Global test environment tear-down [==========] 376 tests from 62 test cases ran. (381691 ms total) [ PASSED ] 375 tests. [ FAILED ] 1 test, listed below: [ FAILED ] AllocatorZooKeeperTest/0.SlaveReregistersFirst, where TypeParam = mesos::internal::master::allocator::HierarchicalAllocatorProcess<mesos::internal::master::allocator::DRFSorter, mesos::internal::master::allocator::DRFSorter> 1 FAILED TEST YOU HAVE 3 DISABLED TESTS make[4]: *** [check-local] Error 1 make[4]: Leaving directory `/x1/jenkins/jenkins-slave/workspace/Mesos-Ubuntu-distcheck/build/mesos-0.20.0/_build/src' make[3]: *** [check-am] Error 2 make[3]: Leaving directory `/x1/jenkins/jenkins-slave/workspace/Mesos-Ubuntu-distcheck/build/mesos-0.20.0/_build/src' make[2]: *** [check] Error 2 make[2]: Leaving directory `/x1/jenkins/jenkins-slave/workspace/Mesos-Ubuntu-distcheck/build/mesos-0.20.0/_build/src' make[1]: *** [check-recursive] Error 1 make[1]: Leaving directory `/x1/jenkins/jenkins-slave/workspace/Mesos-Ubuntu-distcheck/build/mesos-0.20.0/_build' make: *** [distcheck] Error 1 Build step 'Execute shell' marked build as failure
