https://reviews.apache.org/r/26141/
On Mon, Sep 29, 2014 at 11:14 AM, Benjamin Mahler <benjamin.mah...@gmail.com > wrote: > Looks like a stall of the disk FWICT, I will bump the store timeout up > from 5 seconds to 10 seconds to match the rest of our tests. > > On Sun, Sep 28, 2014 at 1:05 PM, 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/2397/changes >> > >> >> Changes: >> >> [dlester] Adds The Factory to PoweredByMesos documentation. >> >> ------------------------------------------ >> [...truncated 61072 lines...] >> I0928 20:04:37.307884 26518 log.cpp:656] Attempting to start the writer >> I0928 20:04:37.308300 26527 replica.cpp:474] Replica received implicit >> promise request with proposal 1 >> I0928 20:04:37.308449 26527 leveldb.cpp:306] Persisting metadata (8 >> bytes) to leveldb took 127841ns >> I0928 20:04:37.308461 26527 replica.cpp:342] Persisted promised to 1 >> I0928 20:04:37.308681 26522 coordinator.cpp:230] Coordinator attemping to >> fill missing position >> I0928 20:04:37.309213 26528 replica.cpp:375] Replica received explicit >> promise request for position 0 with proposal 2 >> I0928 20:04:37.309626 26528 leveldb.cpp:343] Persisting action (8 bytes) >> to leveldb took 394822ns >> I0928 20:04:37.309639 26528 replica.cpp:676] Persisted action at 0 >> I0928 20:04:37.309979 26518 replica.cpp:508] Replica received write >> request for position 0 >> I0928 20:04:37.310006 26518 leveldb.cpp:438] Reading position from >> leveldb took 10121ns >> I0928 20:04:37.310104 26518 leveldb.cpp:343] Persisting action (14 bytes) >> to leveldb took 82821ns >> I0928 20:04:37.310118 26518 replica.cpp:676] Persisted action at 0 >> I0928 20:04:37.310312 26527 replica.cpp:655] Replica received learned >> notice for position 0 >> I0928 20:04:37.310470 26527 leveldb.cpp:343] Persisting action (16 bytes) >> to leveldb took 142143ns >> I0928 20:04:37.310483 26527 replica.cpp:676] Persisted action at 0 >> I0928 20:04:37.310490 26527 replica.cpp:661] Replica learned NOP action >> at position 0 >> I0928 20:04:37.310662 26525 log.cpp:672] Writer started with ending >> position 0 >> I0928 20:04:37.310973 26523 leveldb.cpp:438] Reading position from >> leveldb took 9803ns >> I0928 20:04:37.311913 26522 registrar.cpp:346] Successfully fetched the >> registry (0B) >> I0928 20:04:37.311939 26522 registrar.cpp:422] Attempting to update the >> 'registry' >> I0928 20:04:37.312876 26526 log.cpp:680] Attempting to append 140 bytes >> to the log >> I0928 20:04:37.312926 26527 coordinator.cpp:340] Coordinator attempting >> to write APPEND action at position 1 >> I0928 20:04:37.313186 26526 replica.cpp:508] Replica received write >> request for position 1 >> I0928 20:04:37.313585 26526 leveldb.cpp:343] Persisting action (159 >> bytes) to leveldb took 379673ns >> I0928 20:04:37.313598 26526 replica.cpp:676] Persisted action at 1 >> I0928 20:04:37.313812 26524 replica.cpp:655] Replica received learned >> notice for position 1 >> I0928 20:04:37.313971 26524 leveldb.cpp:343] Persisting action (161 >> bytes) to leveldb took 142290ns >> I0928 20:04:37.313983 26524 replica.cpp:676] Persisted action at 1 >> I0928 20:04:37.313990 26524 replica.cpp:661] Replica learned APPEND >> action at position 1 >> I0928 20:04:37.314231 26527 registrar.cpp:479] Successfully updated >> 'registry' >> I0928 20:04:37.314276 26527 registrar.cpp:372] Successfully recovered >> registrar >> I0928 20:04:37.314303 26529 log.cpp:699] Attempting to truncate the log >> to 1 >> I0928 20:04:37.314398 26522 coordinator.cpp:340] Coordinator attempting >> to write TRUNCATE action at position 2 >> I0928 20:04:37.314395 26521 master.cpp:1099] Recovered 0 slaves from the >> Registry (102B) ; allowing 10mins for slaves to re-register >> I0928 20:04:37.314690 26524 replica.cpp:508] Replica received write >> request for position 2 >> I0928 20:04:37.314857 26524 leveldb.cpp:343] Persisting action (16 bytes) >> to leveldb took 150726ns >> I0928 20:04:37.314868 26524 replica.cpp:676] Persisted action at 2 >> I0928 20:04:37.315090 26519 replica.cpp:655] Replica received learned >> notice for position 2 >> I0928 20:04:37.315249 26519 leveldb.cpp:343] Persisting action (18 bytes) >> to leveldb took 142403ns >> I0928 20:04:37.315273 26519 leveldb.cpp:401] Deleting ~1 keys from >> leveldb took 10483ns >> I0928 20:04:37.315280 26519 replica.cpp:676] Persisted action at 2 >> I0928 20:04:37.315287 26519 replica.cpp:661] Replica learned TRUNCATE >> action at position 2 >> I0928 20:04:37.326342 26516 slave.cpp:169] Slave started on 211)@ >> 67.195.81.186:55213 >> I0928 20:04:37.326365 26516 credentials.hpp:84] Loading credential for >> authentication from >> '/tmp/MasterAuthorizationTest_SlaveDisconnected_uJ9uO5/credential' >> I0928 20:04:37.326436 26516 slave.cpp:276] Slave using credential for: >> test-principal >> I0928 20:04:37.326509 26516 slave.cpp:289] Slave resources: cpus(*):2; >> mem(*):1024; disk(*):1024; ports(*):[31000-32000] >> I0928 20:04:37.326560 26516 slave.cpp:317] Slave hostname: >> penates.apache.org >> I0928 20:04:37.326567 26516 slave.cpp:318] Slave checkpoint: true >> I0928 20:04:37.326860 26517 state.cpp:33] Recovering state from >> '/tmp/MasterAuthorizationTest_SlaveDisconnected_uJ9uO5/meta' >> I0928 20:04:37.326967 26519 status_update_manager.cpp:193] Recovering >> status update manager >> I0928 20:04:37.327074 26516 slave.cpp:3277] Finished recovery >> I0928 20:04:37.327296 26519 slave.cpp:604] New master detected at >> master@67.195.81.186:55213 >> I0928 20:04:37.327328 26519 slave.cpp:678] Authenticating with master >> master@67.195.81.186:55213 >> I0928 20:04:37.327344 26516 status_update_manager.cpp:167] New master >> detected at master@67.195.81.186:55213 >> I0928 20:04:37.327393 26519 slave.cpp:651] Detecting new master >> I0928 20:04:37.327406 26528 authenticatee.hpp:128] Creating new client >> SASL connection >> I0928 20:04:37.327487 26516 master.cpp:3737] Authenticating slave(211)@ >> 67.195.81.186:55213 >> I0928 20:04:37.327565 26519 authenticator.hpp:156] Creating new server >> SASL connection >> I0928 20:04:37.327639 26518 authenticatee.hpp:219] Received SASL >> authentication mechanisms: CRAM-MD5 >> I0928 20:04:37.327664 26518 authenticatee.hpp:245] Attempting to >> authenticate with mechanism 'CRAM-MD5' >> I0928 20:04:37.327724 26521 authenticator.hpp:262] Received SASL >> authentication start >> I0928 20:04:37.328513 26500 sched.cpp:137] Version: 0.21.0 >> I0928 20:04:37.366269 26521 authenticator.hpp:384] Authentication >> requires more steps >> I0928 20:04:37.366328 26521 authenticatee.hpp:265] Received SASL >> authentication step >> I0928 20:04:37.366411 26527 authenticator.hpp:290] Received SASL >> authentication step >> I0928 20:04:37.366437 26527 auxprop.cpp:81] Request to lookup properties >> for user: 'test-principal' realm: 'penates.apache.org' server FQDN: ' >> penates.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false >> SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false >> I0928 20:04:37.366449 26527 auxprop.cpp:153] Looking up auxiliary >> property '*userPassword' >> I0928 20:04:37.366462 26527 auxprop.cpp:153] Looking up auxiliary >> property '*cmusaslsecretCRAM-MD5' >> I0928 20:04:37.366471 26527 auxprop.cpp:81] Request to lookup properties >> for user: 'test-principal' realm: 'penates.apache.org' server FQDN: ' >> penates.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false >> SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true >> I0928 20:04:37.366477 26527 auxprop.cpp:103] Skipping auxiliary property >> '*userPassword' since SASL_AUXPROP_AUTHZID == true >> I0928 20:04:37.366482 26527 auxprop.cpp:103] Skipping auxiliary property >> '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true >> I0928 20:04:37.366493 26527 authenticator.hpp:376] Authentication success >> I0928 20:04:37.366521 26519 sched.cpp:233] New master detected at >> master@67.195.81.186:55213 >> I0928 20:04:37.366541 26519 sched.cpp:283] Authenticating with master >> master@67.195.81.186:55213 >> I0928 20:04:37.366554 26517 master.cpp:3777] Successfully authenticated >> principal 'test-principal' at slave(211)@67.195.81.186:55213 >> I0928 20:04:37.366544 26529 authenticatee.hpp:305] Authentication success >> I0928 20:04:37.366683 26527 authenticatee.hpp:128] Creating new client >> SASL connection >> I0928 20:04:37.366693 26526 slave.cpp:735] Successfully authenticated >> with master master@67.195.81.186:55213 >> I0928 20:04:37.366735 26526 slave.cpp:998] Will retry registration in >> 4.867558ms if necessary >> I0928 20:04:37.366744 26527 master.cpp:3737] Authenticating >> scheduler-961cf466-881c-4ead-a211-c38a53095e8f@67.195.81.186:55213 >> I0928 20:04:37.366823 26517 authenticator.hpp:156] Creating new server >> SASL connection >> I0928 20:04:37.366857 26527 master.cpp:2930] Registering slave at >> slave(211)@67.195.81.186:55213 (penates.apache.org) with id >> 20140928-200437-3125920579-55213-26500-0 >> I0928 20:04:37.366894 26524 authenticatee.hpp:219] Received SASL >> authentication mechanisms: CRAM-MD5 >> I0928 20:04:37.366912 26524 authenticatee.hpp:245] Attempting to >> authenticate with mechanism 'CRAM-MD5' >> I0928 20:04:37.366964 26518 authenticator.hpp:262] Received SASL >> authentication start >> I0928 20:04:37.366976 26523 registrar.cpp:422] Attempting to update the >> 'registry' >> I0928 20:04:37.366997 26518 authenticator.hpp:384] Authentication >> requires more steps >> I0928 20:04:37.367025 26518 authenticatee.hpp:265] Received SASL >> authentication step >> I0928 20:04:37.367075 26527 authenticator.hpp:290] Received SASL >> authentication step >> I0928 20:04:37.367094 26527 auxprop.cpp:81] Request to lookup properties >> for user: 'test-principal' realm: 'penates.apache.org' server FQDN: ' >> penates.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false >> SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false >> I0928 20:04:37.367105 26527 auxprop.cpp:153] Looking up auxiliary >> property '*userPassword' >> I0928 20:04:37.367112 26527 auxprop.cpp:153] Looking up auxiliary >> property '*cmusaslsecretCRAM-MD5' >> I0928 20:04:37.367120 26527 auxprop.cpp:81] Request to lookup properties >> for user: 'test-principal' realm: 'penates.apache.org' server FQDN: ' >> penates.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false >> SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true >> I0928 20:04:37.367125 26527 auxprop.cpp:103] Skipping auxiliary property >> '*userPassword' since SASL_AUXPROP_AUTHZID == true >> I0928 20:04:37.367130 26527 auxprop.cpp:103] Skipping auxiliary property >> '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true >> I0928 20:04:37.367141 26527 authenticator.hpp:376] Authentication success >> I0928 20:04:37.367177 26518 authenticatee.hpp:305] Authentication success >> I0928 20:04:37.367189 26527 master.cpp:3777] Successfully authenticated >> principal 'test-principal' at >> scheduler-961cf466-881c-4ead-a211-c38a53095e8f@67.195.81.186:55213 >> I0928 20:04:37.367283 26518 sched.cpp:357] Successfully authenticated >> with master master@67.195.81.186:55213 >> I0928 20:04:37.367296 26518 sched.cpp:476] Sending registration request >> to master@67.195.81.186:55213 >> I0928 20:04:37.367347 26519 master.cpp:1360] Received registration >> request from >> scheduler-961cf466-881c-4ead-a211-c38a53095e8f@67.195.81.186:55213 >> I0928 20:04:37.367367 26519 master.cpp:1320] Authorizing framework >> principal 'test-principal' to receive offers for role '*' >> I0928 20:04:37.367427 26519 master.cpp:1419] Registering framework >> 20140928-200437-3125920579-55213-26500-0000 at >> scheduler-961cf466-881c-4ead-a211-c38a53095e8f@67.195.81.186:55213 >> I0928 20:04:37.367490 26518 sched.cpp:407] Framework registered with >> 20140928-200437-3125920579-55213-26500-0000 >> I0928 20:04:37.367516 26517 hierarchical_allocator_process.hpp:329] Added >> framework 20140928-200437-3125920579-55213-26500-0000 >> I0928 20:04:37.367532 26517 hierarchical_allocator_process.hpp:697] No >> resources available to allocate! >> I0928 20:04:37.367538 26518 sched.cpp:421] Scheduler::registered took >> 34240ns >> I0928 20:04:37.367542 26517 hierarchical_allocator_process.hpp:659] >> Performed allocation for 0 slaves in 10501ns >> I0928 20:04:37.367992 26518 log.cpp:680] Attempting to append 337 bytes >> to the log >> I0928 20:04:37.368043 26516 coordinator.cpp:340] Coordinator attempting >> to write APPEND action at position 3 >> I0928 20:04:37.368336 26519 replica.cpp:508] Replica received write >> request for position 3 >> I0928 20:04:37.368513 26519 leveldb.cpp:343] Persisting action (356 >> bytes) to leveldb took 157371ns >> I0928 20:04:37.368528 26519 replica.cpp:676] Persisted action at 3 >> I0928 20:04:37.368808 26515 replica.cpp:655] Replica received learned >> notice for position 3 >> I0928 20:04:37.369266 26515 leveldb.cpp:343] Persisting action (358 >> bytes) to leveldb took 440739ns >> I0928 20:04:37.369281 26515 replica.cpp:676] Persisted action at 3 >> I0928 20:04:37.369287 26515 replica.cpp:661] Replica learned APPEND >> action at position 3 >> I0928 20:04:37.369547 26525 registrar.cpp:479] Successfully updated >> 'registry' >> I0928 20:04:37.369626 26527 log.cpp:699] Attempting to truncate the log >> to 3 >> I0928 20:04:37.369683 26519 master.cpp:2970] Registered slave >> 20140928-200437-3125920579-55213-26500-0 at slave(211)@ >> 67.195.81.186:55213 (penates.apache.org) >> I0928 20:04:37.369693 26526 coordinator.cpp:340] Coordinator attempting >> to write TRUNCATE action at position 4 >> I0928 20:04:37.369699 26519 master.cpp:4180] Adding slave >> 20140928-200437-3125920579-55213-26500-0 at slave(211)@ >> 67.195.81.186:55213 (penates.apache.org) with cpus(*):2; mem(*):1024; >> disk(*):1024; ports(*):[31000-32000] >> I0928 20:04:37.369762 26526 slave.cpp:769] Registered with master >> master@67.195.81.186:55213; given slave ID >> 20140928-200437-3125920579-55213-26500-0 >> I0928 20:04:37.369840 26520 hierarchical_allocator_process.hpp:442] Added >> slave 20140928-200437-3125920579-55213-26500-0 (penates.apache.org) with >> cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (and >> cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] available) >> I0928 20:04:37.369910 26520 hierarchical_allocator_process.hpp:734] >> Offering cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on >> slave 20140928-200437-3125920579-55213-26500-0 to framework >> 20140928-200437-3125920579-55213-26500-0000 >> I0928 20:04:37.369935 26525 replica.cpp:508] Replica received write >> request for position 4 >> I0928 20:04:37.369949 26526 slave.cpp:782] Checkpointing SlaveInfo to >> '/tmp/MasterAuthorizationTest_SlaveDisconnected_uJ9uO5/meta/slaves/20140928-200437-3125920579-55213-26500-0/ >> slave.info' >> I0928 20:04:37.370005 26520 hierarchical_allocator_process.hpp:679] >> Performed allocation for slave 20140928-200437-3125920579-55213-26500-0 in >> 124082ns >> I0928 20:04:37.370039 26518 master.hpp:868] Adding offer >> 20140928-200437-3125920579-55213-26500-0 with resources cpus(*):2; >> mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave >> 20140928-200437-3125920579-55213-26500-0 (penates.apache.org) >> I0928 20:04:37.370054 26526 slave.cpp:2351] Received ping from >> slave-observer(189)@67.195.81.186:55213 >> I0928 20:04:37.370084 26525 leveldb.cpp:343] Persisting action (16 bytes) >> to leveldb took 132679ns >> I0928 20:04:40.177495 26520 hierarchical_allocator_process.hpp:659] >> Performed allocation for 1 slaves in 29169ns >> I0928 20:04:40.177516 26518 master.cpp:3679] Sending 1 offers to >> framework 20140928-200437-3125920579-55213-26500-0000 >> I0928 20:04:40.177518 26525 replica.cpp:676] Persisted action at 4 >> I0928 20:04:40.177764 26523 sched.cpp:544] Scheduler::resourceOffers took >> 37391ns >> I0928 20:04:40.178207 26515 replica.cpp:655] Replica received learned >> notice for position 4 >> I0928 20:04:40.178916 26515 leveldb.cpp:343] Persisting action (18 bytes) >> to leveldb took 684134ns >> I0928 20:04:40.178958 26515 leveldb.cpp:401] Deleting ~2 keys from >> leveldb took 22154ns >> I0928 20:04:40.178972 26515 replica.cpp:676] Persisted action at 4 >> I0928 20:04:40.178983 26515 replica.cpp:661] Replica learned TRUNCATE >> action at position 4 >> I0928 20:04:40.179662 26523 master.hpp:877] Removing offer >> 20140928-200437-3125920579-55213-26500-0 with resources cpus(*):2; >> mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave >> 20140928-200437-3125920579-55213-26500-0 (penates.apache.org) >> I0928 20:04:40.179723 26523 master.cpp:2274] Processing reply for offers: >> [ 20140928-200437-3125920579-55213-26500-0 ] on slave >> 20140928-200437-3125920579-55213-26500-0 at slave(211)@ >> 67.195.81.186:55213 (penates.apache.org) for framework >> 20140928-200437-3125920579-55213-26500-0000 >> W0928 20:04:40.179766 26523 master.cpp:1944] Executor default for task >> d878e414-51ee-49df-8c6b-3f8c8cc318c0 uses less CPUs (None) than the minimum >> required (0.01). Please update your executor, as this will be mandatory in >> future releases. >> W0928 20:04:40.179787 26523 master.cpp:1955] Executor default for task >> d878e414-51ee-49df-8c6b-3f8c8cc318c0 uses less memory (None) than the >> minimum required (32MB). Please update your executor, as this will be >> mandatory in future releases. >> I0928 20:04:40.179803 26523 master.cpp:2357] Authorizing framework >> principal 'test-principal' to launch task >> d878e414-51ee-49df-8c6b-3f8c8cc318c0 as user 'jenkins' >> I0928 20:04:40.180094 26517 slave.cpp:483] Slave terminating >> I0928 20:04:40.180156 26517 master.cpp:817] Slave >> 20140928-200437-3125920579-55213-26500-0 at slave(211)@ >> 67.195.81.186:55213 (penates.apache.org) disconnected >> I0928 20:04:40.180179 26517 master.cpp:1742] Disconnecting slave >> 20140928-200437-3125920579-55213-26500-0 at slave(211)@ >> 67.195.81.186:55213 (penates.apache.org) >> I0928 20:04:40.180222 26517 master.cpp:1761] Deactivating slave >> 20140928-200437-3125920579-55213-26500-0 at slave(211)@ >> 67.195.81.186:55213 (penates.apache.org) >> I0928 20:04:40.180308 26528 hierarchical_allocator_process.hpp:481] Slave >> 20140928-200437-3125920579-55213-26500-0 deactivated >> I0928 20:04:40.182312 26525 master.cpp:3296] Sending status update >> TASK_LOST (UUID: 6e71b81a-40ec-4fad-984b-0a90701f3167) for task >> d878e414-51ee-49df-8c6b-3f8c8cc318c0 of framework >> 20140928-200437-3125920579-55213-26500-0000 'Slave disconnected' >> I0928 20:04:40.182545 26526 sched.cpp:635] Scheduler::statusUpdate took >> 115051ns >> I0928 20:04:40.182566 26529 hierarchical_allocator_process.hpp:563] >> Recovered cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] >> (total allocatable: cpus(*):2; mem(*):1024; disk(*):1024; >> ports(*):[31000-32000]) on slave 20140928-200437-3125920579-55213-26500-0 >> from framework 20140928-200437-3125920579-55213-26500-0000 >> I0928 20:04:40.182700 26526 sched.cpp:745] Stopping framework >> '20140928-200437-3125920579-55213-26500-0000' >> I0928 20:04:40.182744 26500 master.cpp:676] Master terminating >> [ OK ] MasterAuthorizationTest.SlaveDisconnected (2934 ms) >> [----------] 13 tests from MasterAuthorizationTest (18286 ms total) >> >> [----------] 6 tests from FilesTest >> [ RUN ] FilesTest.AttachTest >> Using temporary directory '/tmp/FilesTest_AttachTest_idnSAf' >> [ OK ] FilesTest.AttachTest (1 ms) >> [ RUN ] FilesTest.ReadTest >> Using temporary directory '/tmp/FilesTest_ReadTest_8Wpvnp' >> I0928 20:04:40.186934 26528 process.cpp:3337] Handling HTTP event for >> process 'files' with path: '/files/read.json' >> I0928 20:04:40.187590 26516 process.cpp:3337] Handling HTTP event for >> process 'files' with path: '/files/read.json' >> I0928 20:04:40.188312 26528 process.cpp:3337] Handling HTTP event for >> process 'files' with path: '/files/read.json' >> I0928 20:04:40.189448 26523 process.cpp:3337] Handling HTTP event for >> process 'files' with path: '/files/read.json' >> I0928 20:04:40.190218 26515 process.cpp:3337] Handling HTTP event for >> process 'files' with path: '/files/read.json' >> I0928 20:04:40.190934 26524 process.cpp:3337] Handling HTTP event for >> process 'files' with path: '/files/read.json' >> [ OK ] FilesTest.ReadTest (5 ms) >> [ RUN ] FilesTest.DetachTest >> Using temporary directory '/tmp/FilesTest_DetachTest_mMpWaz' >> [ OK ] FilesTest.DetachTest (1 ms) >> [ RUN ] FilesTest.BrowseTest >> Using temporary directory '/tmp/FilesTest_BrowseTest_g1ysYI' >> I0928 20:04:40.193117 26528 process.cpp:3337] Handling HTTP event for >> process 'files' with path: '/files/browse.json' >> I0928 20:04:40.194326 26515 process.cpp:3337] Handling HTTP event for >> process 'files' with path: '/files/browse.json' >> I0928 20:04:40.195536 26520 process.cpp:3337] Handling HTTP event for >> process 'files' with path: '/files/browse.json' >> I0928 20:04:40.196681 26514 process.cpp:3337] Handling HTTP event for >> process 'files' with path: '/files/browse.json' >> I0928 20:04:40.197381 26517 process.cpp:3337] Handling HTTP event for >> process 'files' with path: '/files/browse.json' >> [ OK ] FilesTest.BrowseTest (6 ms) >> [ RUN ] FilesTest.ResolveTest >> Using temporary directory '/tmp/FilesTest_ResolveTest_gggYMS' >> I0928 20:04:40.199450 26514 process.cpp:3337] Handling HTTP event for >> process 'files' with path: '/files/read.json' >> I0928 20:04:40.200180 26521 process.cpp:3337] Handling HTTP event for >> process 'files' with path: '/files/read.json' >> I0928 20:04:40.200929 26522 process.cpp:3337] Handling HTTP event for >> process 'files' with path: '/files/read.json' >> I0928 20:04:40.201709 26521 process.cpp:3337] Handling HTTP event for >> process 'files' with path: '/files/read.json' >> I0928 20:04:40.202426 26527 process.cpp:3337] Handling HTTP event for >> process 'files' with path: '/files/read.json' >> I0928 20:04:40.203199 26519 process.cpp:3337] Handling HTTP event for >> process 'files' with path: '/files/read.json' >> I0928 20:04:40.203933 26519 process.cpp:3337] Handling HTTP event for >> process 'files' with path: '/files/read.json' >> I0928 20:04:40.204658 26527 process.cpp:3337] Handling HTTP event for >> process 'files' with path: '/files/read.json' >> I0928 20:04:40.205446 26526 process.cpp:3337] Handling HTTP event for >> process 'files' with path: '/files/read.json' >> I0928 20:04:40.206061 26529 process.cpp:3337] Handling HTTP event for >> process 'files' with path: '/files/read.json' >> [ OK ] FilesTest.ResolveTest (8 ms) >> [ RUN ] FilesTest.DownloadTest >> Using temporary directory '/tmp/FilesTest_DownloadTest_aDGUC2' >> I0928 20:04:40.207715 26529 process.cpp:3337] Handling HTTP event for >> process 'files' with path: '/files/download.json' >> I0928 20:04:40.207881 26527 process.cpp:1816] Sending file at >> '/tmp/FilesTest_DownloadTest_aDGUC2/binary' with length 17 >> I0928 20:04:40.208477 26517 process.cpp:3337] Handling HTTP event for >> process 'files' with path: '/files/download.json' >> I0928 20:04:40.208657 26526 process.cpp:1816] Sending file at >> '/tmp/FilesTest_DownloadTest_aDGUC2/black.gif' with length 42 >> [ OK ] FilesTest.DownloadTest (3 ms) >> [----------] 6 tests from FilesTest (24 ms total) >> >> [----------] 7 tests from InMemoryStateTest >> [ RUN ] InMemoryStateTest.FetchAndStoreAndExpungeAndExpunge >> [ OK ] InMemoryStateTest.FetchAndStoreAndExpungeAndExpunge (3 ms) >> [ RUN ] InMemoryStateTest.Names >> [ OK ] InMemoryStateTest.Names (3 ms) >> [ RUN ] InMemoryStateTest.FetchAndStoreAndExpungeAndStoreAndFetch >> [ OK ] InMemoryStateTest.FetchAndStoreAndExpungeAndStoreAndFetch (4 >> ms) >> [ RUN ] InMemoryStateTest.FetchAndStoreAndStoreFailAndFetch >> [ OK ] InMemoryStateTest.FetchAndStoreAndStoreFailAndFetch (4 ms) >> [ RUN ] InMemoryStateTest.FetchAndStoreAndStoreAndFetch >> [ OK ] InMemoryStateTest.FetchAndStoreAndStoreAndFetch (4 ms) >> [ RUN ] InMemoryStateTest.FetchAndStoreAndFetch >> [ OK ] InMemoryStateTest.FetchAndStoreAndFetch (3 ms) >> [ RUN ] InMemoryStateTest.FetchAndStoreAndExpungeAndFetch >> [ OK ] InMemoryStateTest.FetchAndStoreAndExpungeAndFetch (4 ms) >> [----------] 7 tests from InMemoryStateTest (122 ms total) >> >> [----------] 2 tests from AttributesTest >> [ RUN ] AttributesTest.Equality >> [ OK ] AttributesTest.Equality (0 ms) >> [ RUN ] AttributesTest.Parsing >> [ OK ] AttributesTest.Parsing (0 ms) >> [----------] 2 tests from AttributesTest (0 ms total) >> >> [----------] Global test environment tear-down >> [==========] 371 tests from 60 test cases ran. (401839 ms total) >> [ PASSED ] 369 tests. >> [ FAILED ] 2 tests, listed below: >> [ FAILED ] Strict/RegistrarTest.remove/1, where GetParam() = true >> [ FAILED ] Strict/RegistrarTest.readmit/1, where GetParam() = true >> >> 2 FAILED TESTS >> YOU HAVE 5 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 >> > >