See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/2828/changes>
Changes: [yujie.jay] Factored out sum function for Resources. [yujie.jay] Added operator+= and operator+ for hashmap<SlaveID, Resources>. ------------------------------------------ [...truncated 75992 lines...] [----------] 1 test from ZooKeeper [ RUN ] ZooKeeper.URL [ OK ] ZooKeeper.URL (0 ms) [----------] 1 test from ZooKeeper (0 ms total) [----------] 3 tests from HookTest [ RUN ] HookTest.VerifyMasterLaunchTaskHook Using temporary directory '/tmp/HookTest_VerifyMasterLaunchTaskHook_Y9yn3G' I0319 23:56:32.688122 18582 leveldb.cpp:176] Opened db in 108.107259ms I0319 23:56:32.746817 18582 leveldb.cpp:183] Compacted db in 58.615756ms I0319 23:56:32.746924 18582 leveldb.cpp:198] Created db iterator in 27322ns I0319 23:56:32.746944 18582 leveldb.cpp:204] Seeked to beginning of db in 3560ns I0319 23:56:32.746955 18582 leveldb.cpp:273] Iterated through 0 keys in the db in 263ns I0319 23:56:32.747006 18582 replica.cpp:744] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0319 23:56:32.747824 18620 recover.cpp:449] Starting replica recovery I0319 23:56:32.748056 18620 recover.cpp:475] Replica is in EMPTY status I0319 23:56:32.749167 18611 replica.cpp:641] Replica in EMPTY status received a broadcasted recover request I0319 23:56:32.749402 18614 recover.cpp:195] Received a recover response from a replica in EMPTY status I0319 23:56:32.749831 18618 recover.cpp:566] Updating replica status to STARTING I0319 23:56:32.749951 18612 master.cpp:358] Master 20150319-235632-3176252227-48061-18582 (proserpina.apache.org) started on 67.195.81.189:48061 I0319 23:56:32.750000 18612 master.cpp:404] Master only allowing authenticated frameworks to register I0319 23:56:32.750011 18612 master.cpp:409] Master only allowing authenticated slaves to register I0319 23:56:32.750033 18612 credentials.hpp:37] Loading credentials for authentication from '/tmp/HookTest_VerifyMasterLaunchTaskHook_Y9yn3G/credentials' I0319 23:56:32.750311 18612 master.cpp:451] Authorization enabled I0319 23:56:32.750860 18616 whitelist_watcher.cpp:79] No whitelist given I0319 23:56:32.751029 18611 hierarchical.hpp:287] Initialized hierarchical allocator process I0319 23:56:32.752022 18611 master.cpp:1374] The newly elected leader is master@67.195.81.189:48061 with id 20150319-235632-3176252227-48061-18582 I0319 23:56:32.752048 18611 master.cpp:1387] Elected as the leading master! I0319 23:56:32.752064 18611 master.cpp:1165] Recovering from registrar I0319 23:56:32.752339 18620 registrar.cpp:313] Recovering registrar I0319 23:56:32.788537 18613 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 38.158899ms I0319 23:56:32.788617 18613 replica.cpp:323] Persisted replica status to STARTING I0319 23:56:32.789693 18613 recover.cpp:475] Replica is in STARTING status I0319 23:56:32.791786 18625 replica.cpp:641] Replica in STARTING status received a broadcasted recover request I0319 23:56:32.792600 18613 recover.cpp:195] Received a recover response from a replica in STARTING status I0319 23:56:32.793501 18613 recover.cpp:566] Updating replica status to VOTING I0319 23:56:32.855921 18611 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 61.996666ms I0319 23:56:32.855990 18611 replica.cpp:323] Persisted replica status to VOTING I0319 23:56:32.856220 18622 recover.cpp:580] Successfully joined the Paxos group I0319 23:56:32.856451 18622 recover.cpp:464] Recover process terminated I0319 23:56:32.857142 18619 log.cpp:660] Attempting to start the writer I0319 23:56:32.858432 18624 replica.cpp:477] Replica received implicit promise request with proposal 1 I0319 23:56:32.890548 18624 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 32.061642ms I0319 23:56:32.890627 18624 replica.cpp:345] Persisted promised to 1 I0319 23:56:32.891376 18615 coordinator.cpp:230] Coordinator attemping to fill missing position I0319 23:56:32.892595 18620 replica.cpp:378] Replica received explicit promise request for position 0 with proposal 2 I0319 23:56:32.939208 18620 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 46.561226ms I0319 23:56:32.939291 18620 replica.cpp:679] Persisted action at 0 I0319 23:56:32.940659 18617 replica.cpp:511] Replica received write request for position 0 I0319 23:56:32.940749 18617 leveldb.cpp:438] Reading position from leveldb took 58103ns I0319 23:56:32.961671 18627 process.cpp:2067] Dropped / Lost event for PID: __waiter__(1458)@67.195.81.189:48061 I0319 23:56:33.022475 18617 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 81.658835ms I0319 23:56:33.022586 18617 replica.cpp:679] Persisted action at 0 I0319 23:56:33.023588 18618 replica.cpp:658] Replica received learned notice for position 0 I0319 23:56:33.063735 18618 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 40.082197ms I0319 23:56:33.063814 18618 replica.cpp:679] Persisted action at 0 I0319 23:56:33.063846 18618 replica.cpp:664] Replica learned NOP action at position 0 I0319 23:56:33.064609 18617 log.cpp:676] Writer started with ending position 0 I0319 23:56:33.065906 18625 leveldb.cpp:438] Reading position from leveldb took 46866ns I0319 23:56:33.068755 18614 registrar.cpp:346] Successfully fetched the registry (0B) in 316.37504ms I0319 23:56:33.068864 18614 registrar.cpp:445] Applied 1 operations in 26429ns; attempting to update the 'registry' I0319 23:56:33.071493 18611 log.cpp:684] Attempting to append 143 bytes to the log I0319 23:56:33.071605 18618 coordinator.cpp:340] Coordinator attempting to write APPEND action at position 1 I0319 23:56:33.072252 18625 replica.cpp:511] Replica received write request for position 1 I0319 23:56:33.099802 18627 process.cpp:2067] Dropped / Lost event for PID: hierarchical-allocator(262)@67.195.81.189:48061 I0319 23:56:33.105772 18625 leveldb.cpp:343] Persisting action (162 bytes) to leveldb took 33.481181ms I0319 23:56:33.105828 18625 replica.cpp:679] Persisted action at 1 I0319 23:56:33.107218 18621 replica.cpp:658] Replica received learned notice for position 1 I0319 23:56:33.131132 18621 leveldb.cpp:343] Persisting action (164 bytes) to leveldb took 23.86755ms I0319 23:56:33.131206 18621 replica.cpp:679] Persisted action at 1 I0319 23:56:33.131237 18621 replica.cpp:664] Replica learned APPEND action at position 1 I0319 23:56:33.132818 18612 registrar.cpp:490] Successfully updated the 'registry' in 63.872256ms I0319 23:56:33.132936 18612 registrar.cpp:376] Successfully recovered registrar I0319 23:56:33.132972 18611 log.cpp:703] Attempting to truncate the log to 1 I0319 23:56:33.133177 18611 coordinator.cpp:340] Coordinator attempting to write TRUNCATE action at position 2 I0319 23:56:33.133229 18612 master.cpp:1192] Recovered 0 slaves from the Registry (105B) ; allowing 10mins for slaves to re-register I0319 23:56:33.134135 18612 replica.cpp:511] Replica received write request for position 2 I0319 23:56:33.156566 18612 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 22.373665ms I0319 23:56:33.156653 18612 replica.cpp:679] Persisted action at 2 I0319 23:56:33.158303 18625 replica.cpp:658] Replica received learned notice for position 2 I0319 23:56:33.181902 18625 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 23.546806ms I0319 23:56:33.182039 18625 leveldb.cpp:401] Deleting ~1 keys from leveldb took 60490ns I0319 23:56:33.182070 18625 replica.cpp:679] Persisted action at 2 I0319 23:56:33.182102 18625 replica.cpp:664] Replica learned TRUNCATE action at position 2 I0319 23:56:33.191092 18611 slave.cpp:176] Slave started on @67.195.81.189:48061 I0319 23:56:33.191146 18611 credentials.hpp:85] Loading credential for authentication from '/tmp/HookTest_VerifyMasterLaunchTaskHook_8b6lzz/credential' I0319 23:56:33.191300 18611 slave.cpp:283] Slave using credential for: test-principal I0319 23:56:33.191511 18611 slave.cpp:301] Slave resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0319 23:56:33.191601 18611 slave.cpp:330] Slave hostname: proserpina.apache.org I0319 23:56:33.191613 18611 slave.cpp:331] Slave checkpoint: false W0319 23:56:33.191619 18611 slave.cpp:333] Disabling checkpointing is deprecated and the --checkpoint flag will be removed in a future release. Please avoid using this flag I0319 23:56:33.192592 18611 state.cpp:35] Recovering state from '/tmp/HookTest_VerifyMasterLaunchTaskHook_8b6lzz/meta' I0319 23:56:33.192865 18611 status_update_manager.cpp:197] Recovering status update manager I0319 23:56:33.193202 18616 slave.cpp:3763] Finished recovery I0319 23:56:33.193886 18611 status_update_manager.cpp:171] Pausing sending status updates I0319 23:56:33.193900 18625 slave.cpp:612] New master detected at master@67.195.81.189:48061 I0319 23:56:33.194006 18625 slave.cpp:675] Authenticating with master master@67.195.81.189:48061 I0319 23:56:33.194036 18625 slave.cpp:680] Using default CRAM-MD5 authenticatee I0319 23:56:33.194170 18625 slave.cpp:648] Detecting new master I0319 23:56:33.194349 18620 authenticatee.hpp:139] Creating new client SASL connection I0319 23:56:33.194566 18625 master.cpp:3815] Authenticating (5406)@67.195.81.189:48061 I0319 23:56:33.194604 18625 master.cpp:3826] Using default CRAM-MD5 authenticator I0319 23:56:33.194908 18618 authenticator.hpp:170] Creating new server SASL connection I0319 23:56:33.195057 18625 authenticatee.hpp:230] Received SASL authentication mechanisms: CRAM-MD5 I0319 23:56:33.195086 18625 authenticatee.hpp:256] Attempting to authenticate with mechanism 'CRAM-MD5' I0319 23:56:33.195160 18625 authenticator.hpp:276] Received SASL authentication start I0319 23:56:33.195207 18625 authenticator.hpp:398] Authentication requires more steps I0319 23:56:33.195273 18625 authenticatee.hpp:276] Received SASL authentication step I0319 23:56:33.195410 18618 authenticator.hpp:304] Received SASL authentication step I0319 23:56:33.195446 18618 auxprop.cpp:99] Request to lookup properties for user: 'test-principal' realm: 'proserpina.apache.org' server FQDN: 'proserpina.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0319 23:56:33.195461 18618 auxprop.cpp:171] Looking up auxiliary property '*userPassword' I0319 23:56:33.195510 18618 auxprop.cpp:171] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0319 23:56:33.195541 18618 auxprop.cpp:99] Request to lookup properties for user: 'test-principal' realm: 'proserpina.apache.org' server FQDN: 'proserpina.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0319 23:56:33.195554 18618 auxprop.cpp:121] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0319 23:56:33.195564 18618 auxprop.cpp:121] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0319 23:56:33.195585 18618 authenticator.hpp:390] Authentication success I0319 23:56:33.195665 18625 authenticatee.hpp:316] Authentication success I0319 23:56:33.195729 18612 master.cpp:3873] Successfully authenticated principal 'test-principal' at (5406)@67.195.81.189:48061 I0319 23:56:33.196149 18626 slave.cpp:746] Successfully authenticated with master master@67.195.81.189:48061 I0319 23:56:33.196303 18626 slave.cpp:1078] Will retry registration in 17.225993ms if necessary I0319 23:56:33.196652 18626 master.cpp:2945] Registering slave at (5406)@67.195.81.189:48061 (proserpina.apache.org) with id 20150319-235632-3176252227-48061-18582-S0 I0319 23:56:33.197410 18611 registrar.cpp:445] Applied 1 operations in 75737ns; attempting to update the 'registry' I0319 23:56:33.200342 18611 log.cpp:684] Attempting to append 324 bytes to the log I0319 23:56:33.200589 18626 coordinator.cpp:340] Coordinator attempting to write APPEND action at position 3 I0319 23:56:33.201804 18626 replica.cpp:511] Replica received write request for position 3 I0319 23:56:33.205606 18582 sched.cpp:157] Version: 0.23.0 I0319 23:56:33.206243 18618 sched.cpp:254] New master detected at master@67.195.81.189:48061 I0319 23:56:33.206357 18618 sched.cpp:310] Authenticating with master master@67.195.81.189:48061 I0319 23:56:33.206379 18618 sched.cpp:317] Using default CRAM-MD5 authenticatee I0319 23:56:33.206648 18618 authenticatee.hpp:139] Creating new client SASL connection I0319 23:56:33.207020 18618 master.cpp:3815] Authenticating scheduler-c1b4faee-5d85-4884-8000-7ebf49022394@67.195.81.189:48061 I0319 23:56:33.207054 18618 master.cpp:3826] Using default CRAM-MD5 authenticator I0319 23:56:33.207372 18618 authenticator.hpp:170] Creating new server SASL connection I0319 23:56:33.207514 18618 authenticatee.hpp:230] Received SASL authentication mechanisms: CRAM-MD5 I0319 23:56:33.207538 18618 authenticatee.hpp:256] Attempting to authenticate with mechanism 'CRAM-MD5' I0319 23:56:33.207614 18618 authenticator.hpp:276] Received SASL authentication start I0319 23:56:33.207661 18618 authenticator.hpp:398] Authentication requires more steps I0319 23:56:33.207821 18618 authenticatee.hpp:276] Received SASL authentication step I0319 23:56:33.207924 18618 authenticator.hpp:304] Received SASL authentication step I0319 23:56:33.207952 18618 auxprop.cpp:99] Request to lookup properties for user: 'test-principal' realm: 'proserpina.apache.org' server FQDN: 'proserpina.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0319 23:56:33.207965 18618 auxprop.cpp:171] Looking up auxiliary property '*userPassword' I0319 23:56:33.208014 18618 auxprop.cpp:171] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0319 23:56:33.208041 18618 auxprop.cpp:99] Request to lookup properties for user: 'test-principal' realm: 'proserpina.apache.org' server FQDN: 'proserpina.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0319 23:56:33.208055 18618 auxprop.cpp:121] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0319 23:56:33.208065 18618 auxprop.cpp:121] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0319 23:56:33.208082 18618 authenticator.hpp:390] Authentication success I0319 23:56:33.208268 18618 authenticatee.hpp:316] Authentication success I0319 23:56:33.208343 18618 master.cpp:3873] Successfully authenticated principal 'test-principal' at scheduler-c1b4faee-5d85-4884-8000-7ebf49022394@67.195.81.189:48061 I0319 23:56:33.208816 18617 sched.cpp:398] Successfully authenticated with master master@67.195.81.189:48061 I0319 23:56:33.208844 18617 sched.cpp:521] Sending registration request to master@67.195.81.189:48061 I0319 23:56:33.208900 18617 sched.cpp:554] Will retry registration in 60.244493ms if necessary I0319 23:56:33.209218 18618 master.cpp:1592] Received registration request for framework 'default' at scheduler-c1b4faee-5d85-4884-8000-7ebf49022394@67.195.81.189:48061 I0319 23:56:33.209301 18618 master.cpp:1453] Authorizing framework principal 'test-principal' to receive offers for role '*' I0319 23:56:33.209763 18624 master.cpp:1656] Registering framework 20150319-235632-3176252227-48061-18582-0000 (default) at scheduler-c1b4faee-5d85-4884-8000-7ebf49022394@67.195.81.189:48061 I0319 23:56:33.210150 18613 hierarchical.hpp:321] Added framework 20150319-235632-3176252227-48061-18582-0000 I0319 23:56:33.210177 18613 hierarchical.hpp:818] No resources available to allocate! I0319 23:56:33.210191 18613 hierarchical.hpp:725] Performed allocation for 0 slaves in 20439ns I0319 23:56:33.210268 18613 sched.cpp:448] Framework registered with 20150319-235632-3176252227-48061-18582-0000 I0319 23:56:33.210307 18613 sched.cpp:462] Scheduler::registered took 20633ns I0319 23:56:33.215451 18624 slave.cpp:1078] Will retry registration in 24.042428ms if necessary I0319 23:56:33.215615 18620 master.cpp:2933] Ignoring register slave message from (5406)@67.195.81.189:48061 (proserpina.apache.org) as admission is already in progress I0319 23:56:33.240170 18615 slave.cpp:1078] Will retry registration in 42.808242ms if necessary I0319 23:56:33.240316 18614 master.cpp:2933] Ignoring register slave message from (5406)@67.195.81.189:48061 (proserpina.apache.org) as admission is already in progress I0319 23:56:33.241935 18626 leveldb.cpp:343] Persisting action (343 bytes) to leveldb took 40.0908ms I0319 23:56:33.241977 18626 replica.cpp:679] Persisted action at 3 I0319 23:56:33.242988 18624 replica.cpp:658] Replica received learned notice for position 3 I0319 23:56:33.283838 18613 slave.cpp:1078] Will retry registration in 138.461912ms if necessary I0319 23:56:33.284006 18616 master.cpp:2933] Ignoring register slave message from (5406)@67.195.81.189:48061 (proserpina.apache.org) as admission is already in progress I0319 23:56:33.300742 18624 leveldb.cpp:343] Persisting action (345 bytes) to leveldb took 57.684777ms I0319 23:56:33.300815 18624 replica.cpp:679] Persisted action at 3 I0319 23:56:33.300848 18624 replica.cpp:664] Replica learned APPEND action at position 3 I0319 23:56:33.302220 18611 registrar.cpp:490] Successfully updated the 'registry' in 104.72704ms I0319 23:56:33.302520 18619 log.cpp:703] Attempting to truncate the log to 3 I0319 23:56:33.302634 18611 coordinator.cpp:340] Coordinator attempting to write TRUNCATE action at position 4 I0319 23:56:33.303021 18611 slave.cpp:2799] Received ping from slave-observer(203)@67.195.81.189:48061 I0319 23:56:33.303180 18611 slave.cpp:780] Registered with master master@67.195.81.189:48061; given slave ID 20150319-235632-3176252227-48061-18582-S0 I0319 23:56:33.303134 18618 master.cpp:3002] Registered slave 20150319-235632-3176252227-48061-18582-S0 at (5406)@67.195.81.189:48061 (proserpina.apache.org) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0319 23:56:33.303289 18626 status_update_manager.cpp:178] Resuming sending status updates I0319 23:56:33.303349 18624 hierarchical.hpp:439] Added slave 20150319-235632-3176252227-48061-18582-S0 (proserpina.apache.org) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (and cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] available) I0319 23:56:33.303577 18611 replica.cpp:511] Replica received write request for position 4 I0319 23:56:33.303864 18624 hierarchical.hpp:743] Performed allocation for slave 20150319-235632-3176252227-48061-18582-S0 in 441159ns I0319 23:56:33.304106 18618 master.cpp:3757] Sending 1 offers to framework 20150319-235632-3176252227-48061-18582-0000 (default) at scheduler-c1b4faee-5d85-4884-8000-7ebf49022394@67.195.81.189:48061 I0319 23:56:33.304497 18625 sched.cpp:611] Scheduler::resourceOffers took 75701ns I0319 23:56:33.305966 18624 master.cpp:2285] Processing ACCEPT call for offers: [ 20150319-235632-3176252227-48061-18582-O0 ] on slave 20150319-235632-3176252227-48061-18582-S0 at (5406)@67.195.81.189:48061 (proserpina.apache.org) for framework 20150319-235632-3176252227-48061-18582-0000 (default) at scheduler-c1b4faee-5d85-4884-8000-7ebf49022394@67.195.81.189:48061 I0319 23:56:33.306017 18624 master.cpp:2130] Authorizing framework principal 'test-principal' to launch task 1 as user 'jenkins' I0319 23:56:33.307518 18614 master.hpp:802] Adding task 1 with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 20150319-235632-3176252227-48061-18582-S0 (proserpina.apache.org) I0319 23:56:33.307677 18614 master.cpp:2557] Launching task 1 of framework 20150319-235632-3176252227-48061-18582-0000 (default) at scheduler-c1b4faee-5d85-4884-8000-7ebf49022394@67.195.81.189:48061 with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 20150319-235632-3176252227-48061-18582-S0 at (5406)@67.195.81.189:48061 (proserpina.apache.org) I0319 23:56:33.307845 18614 test_hook_module.cpp:45] Executing 'masterLaunchTaskLabelDecorator' hook I0319 23:56:33.308418 18582 sched.cpp:1589] Asked to stop the driver I0319 23:56:33.308517 18622 sched.cpp:831] Stopping framework '20150319-235632-3176252227-48061-18582-0000' I0319 23:56:33.308727 18618 master.cpp:1916] Asked to unregister framework 20150319-235632-3176252227-48061-18582-0000 I0319 23:56:33.308765 18618 master.cpp:4185] Removing framework 20150319-235632-3176252227-48061-18582-0000 (default) at scheduler-c1b4faee-5d85-4884-8000-7ebf49022394@67.195.81.189:48061 I0319 23:56:33.308751 18614 slave.cpp:494] Slave terminating I0319 23:56:33.308889 18625 hierarchical.hpp:400] Deactivated framework 20150319-235632-3176252227-48061-18582-0000 I0319 23:56:33.309011 18618 process.cpp:2067] Dropped / Lost event for PID: (5406)@67.195.81.189:48061 I0319 23:56:33.311152 18618 master.cpp:4617] Updating the latest state of task 1 of framework 20150319-235632-3176252227-48061-18582-0000 to TASK_KILLED I0319 23:56:33.311553 18623 hierarchical.hpp:632] Recovered cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (total allocatable: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]) on slave 20150319-235632-3176252227-48061-18582-S0 from framework 20150319-235632-3176252227-48061-18582-0000 I0319 23:56:33.311693 18618 master.cpp:4682] Removing task 1 with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] of framework 20150319-235632-3176252227-48061-18582-0000 on slave 20150319-235632-3176252227-48061-18582-S0 at (5406)@67.195.81.189:48061 (proserpina.apache.org) I0319 23:56:33.312185 18618 master.cpp:752] Master terminating I0319 23:56:33.312273 18616 hierarchical.hpp:354] Removed framework 20150319-235632-3176252227-48061-18582-0000 I0319 23:56:33.312378 18616 hierarchical.hpp:470] Removed slave 20150319-235632-3176252227-48061-18582-S0 I0319 23:56:33.314257 18582 process.cpp:2067] Dropped / Lost event for PID: master@67.195.81.189:48061 I0319 23:56:33.314366 18582 process.cpp:2067] Dropped / Lost event for PID: master@67.195.81.189:48061 I0319 23:56:33.314950 18619 process.cpp:2067] Dropped / Lost event for PID: log-coordinator(303)@67.195.81.189:48061 I0319 23:56:33.334215 18611 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 30.56383ms I0319 23:56:33.334357 18611 replica.cpp:679] Persisted action at 4 I0319 23:56:33.334434 18611 process.cpp:2067] Dropped / Lost event for PID: (5410)@67.195.81.189:48061 I0319 23:56:33.335268 18582 process.cpp:2067] Dropped / Lost event for PID: scheduler-c1b4faee-5d85-4884-8000-7ebf49022394@67.195.81.189:48061 I0319 23:56:33.336596 18582 process.cpp:2067] Dropped / Lost event for PID: (5406)@67.195.81.189:48061 [ OK ] HookTest.VerifyMasterLaunchTaskHook (759 ms) [ RUN ] HookTest.VerifySlaveExecutorEnvironmentDecorator Using temporary directory '/tmp/HookTest_VerifySlaveExecutorEnvironmentDecorator_cPPg0k' I0319 23:56:33.338142 18582 containerizer.cpp:113] Using isolation: posix/cpu,posix/mem I0319 23:56:33.338605 18623 containerizer.cpp:469] Starting container 'test_container' for executor 'executor' of framework '' I0319 23:56:33.339643 18623 test_hook_module.cpp:61] Executing 'slaveExecutorEnvironmentDecorator' hook I0319 23:56:33.341132 18623 launcher.cpp:130] Forked child with pid '31406' for container 'test_container' I0319 23:56:33.422914 18627 process.cpp:2067] Dropped / Lost event for PID: (5406)@67.195.81.189:48061 I0319 23:56:33.490775 18619 containerizer.cpp:1159] Executor for container 'test_container' has exited I0319 23:56:33.490834 18619 containerizer.cpp:950] Destroying container 'test_container' [ OK ] HookTest.VerifySlaveExecutorEnvironmentDecorator (179 ms) [ RUN ] HookTest.HookLoading Using temporary directory '/tmp/HookTest_HookLoading_cRUJh7' [ OK ] HookTest.HookLoading (0 ms) [----------] 3 tests from HookTest (938 ms total) [----------] Global test environment tear-down I0319 23:56:33.705442 18627 process.cpp:2067] Dropped / Lost event for PID: scheduler-38c79962-83d1-48fc-a056-8a8d30334e02@67.195.81.189:48061 I0319 23:56:33.706673 18627 process.cpp:2067] Dropped / Lost event for PID: master@67.195.81.189:48061 I0319 23:56:33.752070 18627 process.cpp:2067] Dropped / Lost event for PID: hierarchical-allocator(263)@67.195.81.189:48061 I0319 23:56:33.806890 18627 process.cpp:2067] Dropped / Lost event for PID: slave(230)@67.195.81.189:48061 [==========] 505 tests from 78 test cases ran. (394241 ms total) [ PASSED ] 504 tests. [ FAILED ] 1 test, listed below: [ FAILED ] ExamplesTest.LowLevelSchedulerLibprocess 1 FAILED TEST YOU HAVE 9 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
