See <https://builds.apache.org/job/Mesos/COMPILER=gcc,CONFIGURATION=--verbose,OS=ubuntu%3A14.04,label_exp=docker%7C%7CHadoop/639/changes>
Changes: [benjamin.mahler] Added /call parsing and validation. [benjamin.mahler] Added validation of scheduler::Call inside /call handler. ------------------------------------------ [...truncated 116557 lines...] I0804 22:18:58.334738 26185 leveldb.cpp:273] Iterated through 0 keys in the db in 243ns I0804 22:18:58.334789 26185 replica.cpp:744] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0804 22:18:58.335929 26211 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 615384ns I0804 22:18:58.335953 26211 replica.cpp:323] Persisted replica status to VOTING I0804 22:18:58.338812 26185 leveldb.cpp:176] Opened db in 2.410089ms I0804 22:18:58.341326 26185 leveldb.cpp:183] Compacted db in 2.472299ms I0804 22:18:58.341375 26185 leveldb.cpp:198] Created db iterator in 15089ns I0804 22:18:58.341406 26185 leveldb.cpp:204] Seeked to beginning of db in 16027ns I0804 22:18:58.341455 26185 leveldb.cpp:273] Iterated through 1 keys in the db in 18671ns I0804 22:18:58.341500 26185 replica.cpp:744] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0804 22:18:58.343932 26185 leveldb.cpp:176] Opened db in 2.270419ms I0804 22:18:58.345842 26185 leveldb.cpp:183] Compacted db in 1.880483ms I0804 22:18:58.345888 26185 leveldb.cpp:198] Created db iterator in 17121ns I0804 22:18:58.345937 26185 leveldb.cpp:204] Seeked to beginning of db in 18661ns I0804 22:18:58.345980 26185 leveldb.cpp:273] Iterated through 1 keys in the db in 22276ns I0804 22:18:58.346029 26185 replica.cpp:744] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0804 22:18:58.346667 26206 recover.cpp:449] Starting replica recovery I0804 22:18:58.346909 26215 recover.cpp:475] Replica is in VOTING status I0804 22:18:58.347082 26215 recover.cpp:464] Recover process terminated I0804 22:18:58.348876 26215 registrar.cpp:313] Recovering registrar [ OK ] Strict/RegistrarTest.FetchTimeout/0 (46 ms) [ RUN ] Strict/RegistrarTest.FetchTimeout/1 Using temporary directory '/tmp/Strict_RegistrarTest_FetchTimeout_1_2v3otK' I0804 22:18:58.375010 26185 leveldb.cpp:176] Opened db in 2.51422ms I0804 22:18:58.375767 26185 leveldb.cpp:183] Compacted db in 725775ns I0804 22:18:58.375813 26185 leveldb.cpp:198] Created db iterator in 16885ns I0804 22:18:58.375833 26185 leveldb.cpp:204] Seeked to beginning of db in 1606ns I0804 22:18:58.375841 26185 leveldb.cpp:273] Iterated through 0 keys in the db in 212ns I0804 22:18:58.375872 26185 replica.cpp:744] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0804 22:18:58.376886 26213 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 745430ns I0804 22:18:58.376936 26213 replica.cpp:323] Persisted replica status to VOTING I0804 22:18:58.380084 26185 leveldb.cpp:176] Opened db in 2.649459ms I0804 22:18:58.380964 26185 leveldb.cpp:183] Compacted db in 833738ns I0804 22:18:58.381002 26185 leveldb.cpp:198] Created db iterator in 10805ns I0804 22:18:58.381018 26185 leveldb.cpp:204] Seeked to beginning of db in 1538ns I0804 22:18:58.381026 26185 leveldb.cpp:273] Iterated through 0 keys in the db in 159ns I0804 22:18:58.381050 26185 replica.cpp:744] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0804 22:18:58.381839 26209 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 480973ns I0804 22:18:58.381867 26209 replica.cpp:323] Persisted replica status to VOTING I0804 22:18:58.384603 26185 leveldb.cpp:176] Opened db in 2.257489ms I0804 22:18:58.386894 26185 leveldb.cpp:183] Compacted db in 2.262485ms I0804 22:18:58.386940 26185 leveldb.cpp:198] Created db iterator in 14201ns I0804 22:18:58.386970 26185 leveldb.cpp:204] Seeked to beginning of db in 15105ns I0804 22:18:58.387011 26185 leveldb.cpp:273] Iterated through 1 keys in the db in 28231ns I0804 22:18:58.387094 26185 replica.cpp:744] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0804 22:18:58.389802 26185 leveldb.cpp:176] Opened db in 2.5078ms I0804 22:18:58.392057 26185 leveldb.cpp:183] Compacted db in 2.225225ms I0804 22:18:58.392102 26185 leveldb.cpp:198] Created db iterator in 13978ns I0804 22:18:58.392130 26185 leveldb.cpp:204] Seeked to beginning of db in 14115ns I0804 22:18:58.392158 26185 leveldb.cpp:273] Iterated through 1 keys in the db in 15918ns I0804 22:18:58.392184 26185 replica.cpp:744] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0804 22:18:58.392730 26215 recover.cpp:449] Starting replica recovery I0804 22:18:58.393023 26215 recover.cpp:475] Replica is in VOTING status I0804 22:18:58.393170 26215 recover.cpp:464] Recover process terminated I0804 22:18:58.395398 26211 registrar.cpp:313] Recovering registrar [ OK ] Strict/RegistrarTest.FetchTimeout/1 (48 ms) [ RUN ] Strict/RegistrarTest.StoreTimeout/0 Using temporary directory '/tmp/Strict_RegistrarTest_StoreTimeout_0_HoVGRy' I0804 22:18:58.424002 26185 leveldb.cpp:176] Opened db in 3.054576ms I0804 22:18:58.424849 26185 leveldb.cpp:183] Compacted db in 793137ns I0804 22:18:58.424903 26185 leveldb.cpp:198] Created db iterator in 23311ns I0804 22:18:58.424919 26185 leveldb.cpp:204] Seeked to beginning of db in 1744ns I0804 22:18:58.424926 26185 leveldb.cpp:273] Iterated through 0 keys in the db in 227ns I0804 22:18:58.424979 26185 replica.cpp:744] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0804 22:18:58.425786 26209 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 466851ns I0804 22:18:58.425812 26209 replica.cpp:323] Persisted replica status to VOTING I0804 22:18:58.428764 26185 leveldb.cpp:176] Opened db in 2.434905ms I0804 22:18:58.429713 26185 leveldb.cpp:183] Compacted db in 916235ns I0804 22:18:58.429752 26185 leveldb.cpp:198] Created db iterator in 11410ns I0804 22:18:58.429769 26185 leveldb.cpp:204] Seeked to beginning of db in 1573ns I0804 22:18:58.429776 26185 leveldb.cpp:273] Iterated through 0 keys in the db in 175ns I0804 22:18:58.429802 26185 replica.cpp:744] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0804 22:18:58.430555 26204 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 548491ns I0804 22:18:58.430583 26204 replica.cpp:323] Persisted replica status to VOTING I0804 22:18:58.433773 26185 leveldb.cpp:176] Opened db in 2.682525ms I0804 22:18:58.436352 26185 leveldb.cpp:183] Compacted db in 2.541122ms I0804 22:18:58.436414 26185 leveldb.cpp:198] Created db iterator in 20162ns I0804 22:18:58.436462 26185 leveldb.cpp:204] Seeked to beginning of db in 33789ns I0804 22:18:58.436508 26185 leveldb.cpp:273] Iterated through 1 keys in the db in 31756ns I0804 22:18:58.436545 26185 replica.cpp:744] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0804 22:18:58.439276 26185 leveldb.cpp:176] Opened db in 2.524257ms I0804 22:18:58.441786 26185 leveldb.cpp:183] Compacted db in 2.47529ms I0804 22:18:58.441849 26185 leveldb.cpp:198] Created db iterator in 25034ns I0804 22:18:58.441892 26185 leveldb.cpp:204] Seeked to beginning of db in 20511ns I0804 22:18:58.441948 26185 leveldb.cpp:273] Iterated through 1 keys in the db in 36029ns I0804 22:18:58.442009 26185 replica.cpp:744] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0804 22:18:58.442639 26211 recover.cpp:449] Starting replica recovery I0804 22:18:58.442945 26211 recover.cpp:475] Replica is in VOTING status I0804 22:18:58.443043 26211 recover.cpp:464] Recover process terminated I0804 22:18:58.444965 26208 registrar.cpp:313] Recovering registrar I0804 22:18:58.447211 26208 registrar.cpp:346] Successfully fetched the registry (0B) in 0ns I0804 22:18:58.447299 26208 registrar.cpp:445] Applied 1 operations in 22946ns; attempting to update the 'registry' E0804 22:18:58.456701 26212 registrar.cpp:512] Registrar aborting: Failed to update 'registry': Failed to perform store within 10secs [ OK ] Strict/RegistrarTest.StoreTimeout/0 (49 ms) [ RUN ] Strict/RegistrarTest.StoreTimeout/1 Using temporary directory '/tmp/Strict_RegistrarTest_StoreTimeout_1_sDjYnn' I0804 22:18:58.472968 26185 leveldb.cpp:176] Opened db in 2.876797ms I0804 22:18:58.473960 26185 leveldb.cpp:183] Compacted db in 950256ns I0804 22:18:58.474014 26185 leveldb.cpp:198] Created db iterator in 23812ns I0804 22:18:58.474030 26185 leveldb.cpp:204] Seeked to beginning of db in 1893ns I0804 22:18:58.474036 26185 leveldb.cpp:273] Iterated through 0 keys in the db in 305ns I0804 22:18:58.474082 26185 replica.cpp:744] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0804 22:18:58.475235 26208 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 545393ns I0804 22:18:58.475260 26208 replica.cpp:323] Persisted replica status to VOTING I0804 22:18:58.477946 26185 leveldb.cpp:176] Opened db in 2.223923ms I0804 22:18:58.478864 26185 leveldb.cpp:183] Compacted db in 885816ns I0804 22:18:58.478905 26185 leveldb.cpp:198] Created db iterator in 11231ns I0804 22:18:58.478917 26185 leveldb.cpp:204] Seeked to beginning of db in 1450ns I0804 22:18:58.478924 26185 leveldb.cpp:273] Iterated through 0 keys in the db in 154ns I0804 22:18:58.478956 26185 replica.cpp:744] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0804 22:18:58.479759 26210 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 464516ns I0804 22:18:58.479784 26210 replica.cpp:323] Persisted replica status to VOTING I0804 22:18:58.482718 26185 leveldb.cpp:176] Opened db in 2.452408ms I0804 22:18:58.484989 26185 leveldb.cpp:183] Compacted db in 2.233689ms I0804 22:18:58.485043 26185 leveldb.cpp:198] Created db iterator in 19809ns I0804 22:18:58.485088 26185 leveldb.cpp:204] Seeked to beginning of db in 21653ns I0804 22:18:58.485154 26185 leveldb.cpp:273] Iterated through 1 keys in the db in 41968ns I0804 22:18:58.485205 26185 replica.cpp:744] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0804 22:18:58.487910 26185 leveldb.cpp:176] Opened db in 2.514639ms I0804 22:18:58.490200 26185 leveldb.cpp:183] Compacted db in 2.258236ms I0804 22:18:58.490242 26185 leveldb.cpp:198] Created db iterator in 15351ns I0804 22:18:58.490274 26185 leveldb.cpp:204] Seeked to beginning of db in 18115ns I0804 22:18:58.490309 26185 leveldb.cpp:273] Iterated through 1 keys in the db in 20328ns I0804 22:18:58.490344 26185 replica.cpp:744] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0804 22:18:58.490880 26206 recover.cpp:449] Starting replica recovery I0804 22:18:58.491150 26210 recover.cpp:475] Replica is in VOTING status I0804 22:18:58.491282 26210 recover.cpp:464] Recover process terminated I0804 22:18:58.493142 26211 registrar.cpp:313] Recovering registrar I0804 22:18:58.495379 26211 registrar.cpp:346] Successfully fetched the registry (0B) in 0ns I0804 22:18:58.495481 26211 registrar.cpp:445] Applied 1 operations in 23316ns; attempting to update the 'registry' E0804 22:18:58.504920 26211 registrar.cpp:512] Registrar aborting: Failed to update 'registry': Failed to perform store within 10secs [ OK ] Strict/RegistrarTest.StoreTimeout/1 (48 ms) [ RUN ] Strict/RegistrarTest.Abort/0 Using temporary directory '/tmp/Strict_RegistrarTest_Abort_0_NMy31b' I0804 22:18:58.520897 26185 leveldb.cpp:176] Opened db in 2.76313ms I0804 22:18:58.521787 26185 leveldb.cpp:183] Compacted db in 848715ns I0804 22:18:58.521839 26185 leveldb.cpp:198] Created db iterator in 23988ns I0804 22:18:58.521855 26185 leveldb.cpp:204] Seeked to beginning of db in 1933ns I0804 22:18:58.521862 26185 leveldb.cpp:273] Iterated through 0 keys in the db in 270ns I0804 22:18:58.521908 26185 replica.cpp:744] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0804 22:18:58.523133 26210 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 496874ns I0804 22:18:58.523156 26210 replica.cpp:323] Persisted replica status to VOTING I0804 22:18:58.525894 26185 leveldb.cpp:176] Opened db in 2.260795ms I0804 22:18:58.526840 26185 leveldb.cpp:183] Compacted db in 916690ns I0804 22:18:58.526878 26185 leveldb.cpp:198] Created db iterator in 17051ns I0804 22:18:58.526890 26185 leveldb.cpp:204] Seeked to beginning of db in 1719ns I0804 22:18:58.526896 26185 leveldb.cpp:273] Iterated through 0 keys in the db in 207ns I0804 22:18:58.526931 26185 replica.cpp:744] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0804 22:18:58.527686 26210 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 498854ns I0804 22:18:58.527709 26210 replica.cpp:323] Persisted replica status to VOTING I0804 22:18:58.530692 26185 leveldb.cpp:176] Opened db in 2.555511ms I0804 22:18:58.533030 26185 leveldb.cpp:183] Compacted db in 2.297067ms I0804 22:18:58.533115 26185 leveldb.cpp:198] Created db iterator in 29831ns I0804 22:18:58.533162 26185 leveldb.cpp:204] Seeked to beginning of db in 22781ns I0804 22:18:58.533236 26185 leveldb.cpp:273] Iterated through 1 keys in the db in 49877ns I0804 22:18:58.533304 26185 replica.cpp:744] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0804 22:18:58.535863 26185 leveldb.cpp:176] Opened db in 2.277852ms I0804 22:18:58.538285 26185 leveldb.cpp:183] Compacted db in 2.302653ms I0804 22:18:58.538367 26185 leveldb.cpp:198] Created db iterator in 32697ns I0804 22:18:58.538627 26185 leveldb.cpp:204] Seeked to beginning of db in 36744ns I0804 22:18:58.538720 26185 leveldb.cpp:273] Iterated through 1 keys in the db in 45421ns I0804 22:18:58.538796 26185 replica.cpp:744] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0804 22:18:58.539876 26208 recover.cpp:449] Starting replica recovery I0804 22:18:58.540455 26208 recover.cpp:475] Replica is in VOTING status I0804 22:18:58.540920 26208 recover.cpp:464] Recover process terminated I0804 22:18:58.543660 26207 registrar.cpp:313] Recovering registrar I0804 22:18:58.546763 26207 registrar.cpp:346] Successfully fetched the registry (0B) in 3.05792ms I0804 22:18:58.546854 26207 registrar.cpp:445] Applied 1 operations in 21949ns; attempting to update the 'registry' I0804 22:18:58.549049 26207 registrar.cpp:490] Successfully updated the 'registry' in 2.144768ms I0804 22:18:58.549136 26207 registrar.cpp:376] Successfully recovered registrar I0804 22:18:58.549758 26214 registrar.cpp:445] Applied 1 operations in 33106ns; attempting to update the 'registry' E0804 22:18:58.551949 26214 registrar.cpp:512] Registrar aborting: Failed to update 'registry': failure [ OK ] Strict/RegistrarTest.Abort/0 (38 ms) [ RUN ] Strict/RegistrarTest.Abort/1 Using temporary directory '/tmp/Strict_RegistrarTest_Abort_1_m4LiM0' I0804 22:18:58.558665 26185 leveldb.cpp:176] Opened db in 2.611015ms I0804 22:18:58.559651 26185 leveldb.cpp:183] Compacted db in 946088ns I0804 22:18:58.559696 26185 leveldb.cpp:198] Created db iterator in 14976ns I0804 22:18:58.559718 26185 leveldb.cpp:204] Seeked to beginning of db in 1677ns I0804 22:18:58.559734 26185 leveldb.cpp:273] Iterated through 0 keys in the db in 204ns I0804 22:18:58.559777 26185 replica.cpp:744] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0804 22:18:58.560870 26204 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 573500ns I0804 22:18:58.560894 26204 replica.cpp:323] Persisted replica status to VOTING I0804 22:18:58.563802 26185 leveldb.cpp:176] Opened db in 2.302201ms I0804 22:18:58.564550 26185 leveldb.cpp:183] Compacted db in 719530ns I0804 22:18:58.564586 26185 leveldb.cpp:198] Created db iterator in 10567ns I0804 22:18:58.564606 26185 leveldb.cpp:204] Seeked to beginning of db in 1530ns I0804 22:18:58.564617 26185 leveldb.cpp:273] Iterated through 0 keys in the db in 161ns I0804 22:18:58.564641 26185 replica.cpp:744] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0804 22:18:58.565418 26204 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 394655ns I0804 22:18:58.565484 26204 replica.cpp:323] Persisted replica status to VOTING I0804 22:18:58.568151 26185 leveldb.cpp:176] Opened db in 2.213843ms I0804 22:18:58.570678 26185 leveldb.cpp:183] Compacted db in 2.492975ms I0804 22:18:58.570727 26185 leveldb.cpp:198] Created db iterator in 16853ns I0804 22:18:58.570766 26185 leveldb.cpp:204] Seeked to beginning of db in 17347ns I0804 22:18:58.570813 26185 leveldb.cpp:273] Iterated through 1 keys in the db in 27429ns I0804 22:18:58.570859 26185 replica.cpp:744] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0804 22:18:58.573390 26185 leveldb.cpp:176] Opened db in 2.379812ms I0804 22:18:58.575846 26185 leveldb.cpp:183] Compacted db in 2.427199ms I0804 22:18:58.575893 26185 leveldb.cpp:198] Created db iterator in 14458ns I0804 22:18:58.575929 26185 leveldb.cpp:204] Seeked to beginning of db in 16099ns I0804 22:18:58.575969 26185 leveldb.cpp:273] Iterated through 1 keys in the db in 21474ns I0804 22:18:58.576006 26185 replica.cpp:744] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0804 22:18:58.576741 26212 recover.cpp:449] Starting replica recovery I0804 22:18:58.576966 26212 recover.cpp:475] Replica is in VOTING status I0804 22:18:58.577069 26212 recover.cpp:464] Recover process terminated I0804 22:18:58.578830 26219 registrar.cpp:313] Recovering registrar I0804 22:18:58.581238 26219 registrar.cpp:346] Successfully fetched the registry (0B) in 2.36416ms I0804 22:18:58.581348 26219 registrar.cpp:445] Applied 1 operations in 25821ns; attempting to update the 'registry' I0804 22:18:58.583623 26219 registrar.cpp:490] Successfully updated the 'registry' in 2.2208ms I0804 22:18:58.583714 26219 registrar.cpp:376] Successfully recovered registrar I0804 22:18:58.584398 26208 registrar.cpp:445] Applied 1 operations in 42614ns; attempting to update the 'registry' E0804 22:18:58.586681 26208 registrar.cpp:512] Registrar aborting: Failed to update 'registry': failure [ OK ] Strict/RegistrarTest.Abort/1 (34 ms) [----------] 16 tests from Strict/RegistrarTest (969 ms total) [----------] Global test environment tear-down [==========] 686 tests from 97 test cases ran. (294236 ms total) [ PASSED ] 685 tests. [ FAILED ] 1 test, listed below: [ FAILED ] MasterAuthorizationTest.DuplicateRegistration 1 FAILED TEST YOU HAVE 12 DISABLED TESTS make[4]: *** [check-local] Error 1 make[4]: Leaving directory `/mesos/mesos-0.24.0/_build/src' make[3]: *** [check-am] Error 2 make[3]: Leaving directory `/mesos/mesos-0.24.0/_build/src' make[2]: *** [check] Error 2 make[2]: Leaving directory `/mesos/mesos-0.24.0/_build/src' make[1]: *** [check-recursive] Error 1 make[1]: Leaving directory `/mesos/mesos-0.24.0/_build' make: *** [distcheck] Error 1 + docker rmi mesos-1438725312-3416 Untagged: mesos-1438725312-3416:latest Deleted: d47b9b3362896d30868a9ad0e67e46164102688a007883ffb9ccbfc61fd38102 Deleted: ccadc59ebeb6da8c33998068be8ca06d39e07803c367df8e3b374f574decb703 Deleted: b0dfbe897e013bf01d9680ea52753ab664d40a9e295bf0e46aa85faa2e028091 Deleted: 245b9baba001291cd458e29229264fa2221de0e19e36e5f698f3b094abd3a797 Deleted: 230ec1b62b0f27c3f565feaafd3849fd442e12bd72bb4b26361bac93a66b3bf0 Deleted: 6b2d0237c2de0eeba364bed7913e4a6e3ea4c20b4985ef9d88d54eb57c7743b9 Deleted: b4c33df7feb13cec270032cfc9730bc7311aeaae89160d796d747df0803a0546 Deleted: ccb4346b5598d5fac59af7f903b5bbeaa9b9753785d5157aa2086668dc1f2950 Deleted: 4b61e53d61e99e80e3f284b6b841b1a820975397ac65d56c3e579924102f74d5 Deleted: b98881c80d4e2aac753c26b4c3cfeb45d64939e2040d2fd7a2ee88302b025325 Deleted: 655cc6be382a0e3bd1ce16028a868952886a5dc9d539286994926483cf1bbadb Deleted: 362610f1a489e55642c00b69d0b5e35a2f4a1753b2d2d7b42284e752043f03cf Build step 'Execute shell' marked build as failure