See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/2674/changes>
Changes: [yujie.jay] Added three tuples overload for process::await. [yujie.jay] Added PosixDiskIsolator to monitor container disk usage and to enforce [yujie.jay] Added tests for verifying PosixDiskIsolator. ------------------------------------------ [...truncated 68452 lines...] I0116 22:53:02.528898 9327 replica.cpp:744] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0116 22:53:02.643350 9327 leveldb.cpp:176] Opened db in 114.179773ms I0116 22:53:02.745476 9327 leveldb.cpp:183] Compacted db in 102.083448ms I0116 22:53:02.745540 9327 leveldb.cpp:198] Created db iterator in 22900ns I0116 22:53:02.745569 9327 leveldb.cpp:204] Seeked to beginning of db in 14463ns I0116 22:53:02.745614 9327 leveldb.cpp:273] Iterated through 1 keys in the db in 32915ns I0116 22:53:02.745659 9327 replica.cpp:744] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0116 22:53:02.746249 9349 recover.cpp:449] Starting replica recovery I0116 22:53:02.746773 9349 recover.cpp:475] Replica is in VOTING status I0116 22:53:02.746877 9349 recover.cpp:464] Recover process terminated I0116 22:53:02.747539 9351 log.cpp:660] Attempting to start the writer I0116 22:53:02.748543 9342 replica.cpp:477] Replica received implicit promise request with proposal 1 I0116 22:53:02.748669 9343 replica.cpp:477] Replica received implicit promise request with proposal 1 I0116 22:53:02.795689 9342 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 46.990006ms I0116 22:53:02.795738 9342 replica.cpp:345] Persisted promised to 1 I0116 22:53:02.795727 9343 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 46.976898ms I0116 22:53:02.795758 9343 replica.cpp:345] Persisted promised to 1 I0116 22:53:02.796383 9346 coordinator.cpp:230] Coordinator attemping to fill missing position I0116 22:53:02.797366 9347 replica.cpp:378] Replica received explicit promise request for position 0 with proposal 2 I0116 22:53:02.797544 9349 replica.cpp:378] Replica received explicit promise request for position 0 with proposal 2 I0116 22:53:02.837358 9347 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 39.952619ms I0116 22:53:02.837358 9349 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 39.786261ms I0116 22:53:02.837396 9347 replica.cpp:679] Persisted action at 0 I0116 22:53:02.837399 9349 replica.cpp:679] Persisted action at 0 I0116 22:53:02.838306 9348 replica.cpp:511] Replica received write request for position 0 I0116 22:53:02.838367 9348 leveldb.cpp:438] Reading position from leveldb took 32687ns I0116 22:53:02.838515 9354 replica.cpp:511] Replica received write request for position 0 I0116 22:53:02.838573 9354 leveldb.cpp:438] Reading position from leveldb took 30330ns I0116 22:53:02.879245 9354 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 40.625885ms I0116 22:53:02.879250 9348 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 40.843426ms I0116 22:53:02.879281 9354 replica.cpp:679] Persisted action at 0 I0116 22:53:02.879295 9348 replica.cpp:679] Persisted action at 0 I0116 22:53:02.879791 9344 replica.cpp:658] Replica received learned notice for position 0 I0116 22:53:02.879837 9350 replica.cpp:658] Replica received learned notice for position 0 I0116 22:53:02.920985 9344 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 41.124626ms I0116 22:53:02.920985 9350 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 41.116342ms I0116 22:53:02.921020 9344 replica.cpp:679] Persisted action at 0 I0116 22:53:02.921030 9350 replica.cpp:679] Persisted action at 0 I0116 22:53:02.921046 9350 replica.cpp:664] Replica learned NOP action at position 0 I0116 22:53:02.921044 9344 replica.cpp:664] Replica learned NOP action at position 0 I0116 22:53:02.921576 9356 log.cpp:676] Writer started with ending position 0 I0116 22:53:02.922415 9350 leveldb.cpp:438] Reading position from leveldb took 27406ns I0116 22:53:02.926647 9347 log.cpp:684] Attempting to append 50 bytes to the log I0116 22:53:02.926748 9349 coordinator.cpp:340] Coordinator attempting to write APPEND action at position 1 I0116 22:53:02.927299 9349 replica.cpp:511] Replica received write request for position 1 I0116 22:53:02.927376 9345 replica.cpp:511] Replica received write request for position 1 I0116 22:53:02.971340 9349 leveldb.cpp:343] Persisting action (66 bytes) to leveldb took 44.007563ms I0116 22:53:02.971343 9345 leveldb.cpp:343] Persisting action (66 bytes) to leveldb took 43.891179ms I0116 22:53:02.971375 9349 replica.cpp:679] Persisted action at 1 I0116 22:53:02.971387 9345 replica.cpp:679] Persisted action at 1 I0116 22:53:02.971868 9341 replica.cpp:658] Replica received learned notice for position 1 I0116 22:53:02.971870 9353 replica.cpp:658] Replica received learned notice for position 1 I0116 22:53:03.013156 9341 leveldb.cpp:343] Persisting action (68 bytes) to leveldb took 41.260231ms I0116 22:53:03.013185 9341 replica.cpp:679] Persisted action at 1 I0116 22:53:03.013181 9353 leveldb.cpp:343] Persisting action (68 bytes) to leveldb took 41.276647ms I0116 22:53:03.013200 9341 replica.cpp:664] Replica learned APPEND action at position 1 I0116 22:53:03.013211 9353 replica.cpp:679] Persisted action at 1 I0116 22:53:03.013229 9353 replica.cpp:664] Replica learned APPEND action at position 1 I0116 22:53:03.013947 9356 log.cpp:703] Attempting to truncate the log to 1 I0116 22:53:03.014101 9341 coordinator.cpp:340] Coordinator attempting to write TRUNCATE action at position 2 I0116 22:53:03.014536 9352 replica.cpp:511] Replica received write request for position 2 I0116 22:53:03.014608 9343 replica.cpp:511] Replica received write request for position 2 I0116 22:53:03.055073 9352 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 40.399252ms I0116 22:53:03.055073 9343 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 40.398368ms I0116 22:53:03.055124 9352 replica.cpp:679] Persisted action at 2 I0116 22:53:03.055127 9343 replica.cpp:679] Persisted action at 2 I0116 22:53:03.055835 9353 replica.cpp:658] Replica received learned notice for position 2 I0116 22:53:03.055867 9344 replica.cpp:658] Replica received learned notice for position 2 I0116 22:53:03.096753 9353 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 40.891038ms I0116 22:53:03.096760 9344 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 40.867476ms I0116 22:53:03.096813 9353 leveldb.cpp:401] Deleting ~1 keys from leveldb took 31403ns I0116 22:53:03.096829 9353 replica.cpp:679] Persisted action at 2 I0116 22:53:03.096834 9344 leveldb.cpp:401] Deleting ~1 keys from leveldb took 39557ns I0116 22:53:03.096848 9353 replica.cpp:664] Replica learned TRUNCATE action at position 2 I0116 22:53:03.096859 9344 replica.cpp:679] Persisted action at 2 I0116 22:53:03.096885 9344 replica.cpp:664] Replica learned TRUNCATE action at position 2 [ OK ] LogStateTest.FetchAndStoreAndStoreFailAndFetch (1168 ms) [ RUN ] LogStateTest.FetchAndStoreAndStoreAndFetch Using temporary directory '/tmp/LogStateTest_FetchAndStoreAndStoreAndFetch_kTEAZo' I0116 22:53:03.212041 9327 leveldb.cpp:176] Opened db in 111.544983ms I0116 22:53:03.260946 9327 leveldb.cpp:183] Compacted db in 48.846484ms I0116 22:53:03.260996 9327 leveldb.cpp:198] Created db iterator in 21330ns I0116 22:53:03.261008 9327 leveldb.cpp:204] Seeked to beginning of db in 1658ns I0116 22:53:03.261015 9327 leveldb.cpp:273] Iterated through 0 keys in the db in 398ns I0116 22:53:03.261075 9327 replica.cpp:744] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0116 22:53:03.288857 9348 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 27.461078ms I0116 22:53:03.288892 9348 replica.cpp:323] Persisted replica status to VOTING I0116 22:53:03.415817 9327 leveldb.cpp:176] Opened db in 125.51855ms I0116 22:53:03.441320 9327 leveldb.cpp:183] Compacted db in 25.467195ms I0116 22:53:03.441375 9327 leveldb.cpp:198] Created db iterator in 20409ns I0116 22:53:03.441391 9327 leveldb.cpp:204] Seeked to beginning of db in 1735ns I0116 22:53:03.441400 9327 leveldb.cpp:273] Iterated through 0 keys in the db in 155ns I0116 22:53:03.441437 9327 replica.cpp:744] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0116 22:53:03.477730 9343 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 36.027385ms I0116 22:53:03.477762 9343 replica.cpp:323] Persisted replica status to VOTING I0116 22:53:03.596884 9327 leveldb.cpp:176] Opened db in 118.578787ms I0116 22:53:03.715201 9327 leveldb.cpp:183] Compacted db in 118.277401ms I0116 22:53:03.715260 9327 leveldb.cpp:198] Created db iterator in 24314ns I0116 22:53:03.715287 9327 leveldb.cpp:204] Seeked to beginning of db in 15603ns I0116 22:53:03.715333 9327 leveldb.cpp:273] Iterated through 1 keys in the db in 35642ns I0116 22:53:03.715378 9327 replica.cpp:744] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0116 22:53:03.826030 9327 leveldb.cpp:176] Opened db in 110.438327ms I0116 22:53:03.922904 9327 leveldb.cpp:183] Compacted db in 96.823275ms I0116 22:53:03.922966 9327 leveldb.cpp:198] Created db iterator in 20599ns I0116 22:53:03.922999 9327 leveldb.cpp:204] Seeked to beginning of db in 15972ns I0116 22:53:03.923039 9327 leveldb.cpp:273] Iterated through 1 keys in the db in 26872ns I0116 22:53:03.923105 9327 replica.cpp:744] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0116 22:53:03.923636 9343 recover.cpp:449] Starting replica recovery I0116 22:53:03.924023 9343 recover.cpp:475] Replica is in VOTING status I0116 22:53:03.924163 9343 recover.cpp:464] Recover process terminated I0116 22:53:03.924489 9349 log.cpp:660] Attempting to start the writer I0116 22:53:03.925534 9351 replica.cpp:477] Replica received implicit promise request with proposal 1 I0116 22:53:03.925662 9345 replica.cpp:477] Replica received implicit promise request with proposal 1 I0116 22:53:03.956300 9351 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 30.659954ms I0116 22:53:03.956300 9345 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 30.607743ms I0116 22:53:03.956337 9351 replica.cpp:345] Persisted promised to 1 I0116 22:53:03.956346 9345 replica.cpp:345] Persisted promised to 1 I0116 22:53:03.969115 9345 coordinator.cpp:230] Coordinator attemping to fill missing position I0116 22:53:03.970108 9353 replica.cpp:378] Replica received explicit promise request for position 0 with proposal 2 I0116 22:53:03.970234 9341 replica.cpp:378] Replica received explicit promise request for position 0 with proposal 2 I0116 22:53:04.006466 9341 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 36.196477ms I0116 22:53:04.006469 9353 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 36.327103ms I0116 22:53:04.006500 9341 replica.cpp:679] Persisted action at 0 I0116 22:53:04.006512 9353 replica.cpp:679] Persisted action at 0 I0116 22:53:04.007426 9350 replica.cpp:511] Replica received write request for position 0 I0116 22:53:04.007563 9350 leveldb.cpp:438] Reading position from leveldb took 41940ns I0116 22:53:04.007650 9344 replica.cpp:511] Replica received write request for position 0 I0116 22:53:04.007712 9344 leveldb.cpp:438] Reading position from leveldb took 29074ns I0116 22:53:04.031684 9344 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 23.930644ms I0116 22:53:04.031684 9350 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 24.068396ms I0116 22:53:04.031750 9344 replica.cpp:679] Persisted action at 0 I0116 22:53:04.031756 9350 replica.cpp:679] Persisted action at 0 I0116 22:53:04.033601 9351 replica.cpp:658] Replica received learned notice for position 0 I0116 22:53:04.033625 9345 replica.cpp:658] Replica received learned notice for position 0 I0116 22:53:04.065081 9345 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 31.432352ms I0116 22:53:04.065081 9351 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 31.452201ms I0116 22:53:04.065135 9345 replica.cpp:679] Persisted action at 0 I0116 22:53:04.065136 9351 replica.cpp:679] Persisted action at 0 I0116 22:53:04.065166 9351 replica.cpp:664] Replica learned NOP action at position 0 I0116 22:53:04.065166 9345 replica.cpp:664] Replica learned NOP action at position 0 I0116 22:53:04.065870 9353 log.cpp:676] Writer started with ending position 0 I0116 22:53:04.066627 9350 leveldb.cpp:438] Reading position from leveldb took 30337ns I0116 22:53:04.070837 9343 log.cpp:684] Attempting to append 49 bytes to the log I0116 22:53:04.070966 9356 coordinator.cpp:340] Coordinator attempting to write APPEND action at position 1 I0116 22:53:04.071463 9345 replica.cpp:511] Replica received write request for position 1 I0116 22:53:04.071571 9355 replica.cpp:511] Replica received write request for position 1 I0116 22:53:04.098587 9355 leveldb.cpp:343] Persisting action (65 bytes) to leveldb took 26.989948ms I0116 22:53:04.098618 9355 replica.cpp:679] Persisted action at 1 I0116 22:53:04.098628 9345 leveldb.cpp:343] Persisting action (65 bytes) to leveldb took 27.130597ms I0116 22:53:04.098664 9345 replica.cpp:679] Persisted action at 1 I0116 22:53:04.099110 9352 replica.cpp:658] Replica received learned notice for position 1 I0116 22:53:04.099139 9343 replica.cpp:658] Replica received learned notice for position 1 I0116 22:53:04.131983 9343 leveldb.cpp:343] Persisting action (67 bytes) to leveldb took 32.725979ms I0116 22:53:04.131985 9352 leveldb.cpp:343] Persisting action (67 bytes) to leveldb took 32.781048ms I0116 22:53:04.132019 9343 replica.cpp:679] Persisted action at 1 I0116 22:53:04.132024 9352 replica.cpp:679] Persisted action at 1 I0116 22:53:04.132072 9343 replica.cpp:664] Replica learned APPEND action at position 1 I0116 22:53:04.132115 9352 replica.cpp:664] Replica learned APPEND action at position 1 I0116 22:53:04.133349 9348 log.cpp:703] Attempting to truncate the log to 1 I0116 22:53:04.133563 9356 coordinator.cpp:340] Coordinator attempting to write TRUNCATE action at position 2 I0116 22:53:04.134037 9345 replica.cpp:511] Replica received write request for position 2 I0116 22:53:04.134153 9342 replica.cpp:511] Replica received write request for position 2 I0116 22:53:04.165597 9342 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 31.406661ms I0116 22:53:04.165602 9345 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 31.466134ms I0116 22:53:04.165635 9342 replica.cpp:679] Persisted action at 2 I0116 22:53:04.165648 9345 replica.cpp:679] Persisted action at 2 I0116 22:53:04.166168 9343 replica.cpp:658] Replica received learned notice for position 2 I0116 22:53:04.166174 9348 replica.cpp:658] Replica received learned notice for position 2 I0116 22:53:04.199038 9343 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 32.834022ms I0116 22:53:04.199043 9348 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 32.83119ms I0116 22:53:04.199136 9343 leveldb.cpp:401] Deleting ~1 keys from leveldb took 41603ns I0116 22:53:04.199143 9348 leveldb.cpp:401] Deleting ~1 keys from leveldb took 40198ns I0116 22:53:04.199172 9343 replica.cpp:679] Persisted action at 2 I0116 22:53:04.199182 9348 replica.cpp:679] Persisted action at 2 I0116 22:53:04.199195 9343 replica.cpp:664] Replica learned TRUNCATE action at position 2 I0116 22:53:04.199206 9348 replica.cpp:664] Replica learned TRUNCATE action at position 2 I0116 22:53:04.199774 9350 log.cpp:485] Created an SVN diff in 30976ns of size 25B which is 166.667% the original size (15B) I0116 22:53:04.199949 9354 log.cpp:684] Attempting to append 49 bytes to the log I0116 22:53:04.200050 9341 coordinator.cpp:340] Coordinator attempting to write APPEND action at position 3 I0116 22:53:04.200796 9348 replica.cpp:511] Replica received write request for position 3 I0116 22:53:04.200964 9349 replica.cpp:511] Replica received write request for position 3 I0116 22:53:04.251626 9349 leveldb.cpp:343] Persisting action (65 bytes) to leveldb took 50.623983ms I0116 22:53:04.251654 9349 replica.cpp:679] Persisted action at 3 I0116 22:53:04.251665 9348 leveldb.cpp:343] Persisting action (65 bytes) to leveldb took 50.82704ms I0116 22:53:04.251703 9348 replica.cpp:679] Persisted action at 3 I0116 22:53:04.252465 9350 replica.cpp:658] Replica received learned notice for position 3 I0116 22:53:04.252511 9356 replica.cpp:658] Replica received learned notice for position 3 I0116 22:53:04.301864 9350 leveldb.cpp:343] Persisting action (67 bytes) to leveldb took 49.371471ms I0116 22:53:04.301909 9350 replica.cpp:679] Persisted action at 3 I0116 22:53:04.301918 9356 leveldb.cpp:343] Persisting action (67 bytes) to leveldb took 49.382897ms I0116 22:53:04.301934 9350 replica.cpp:664] Replica learned APPEND action at position 3 I0116 22:53:04.301971 9356 replica.cpp:679] Persisted action at 3 I0116 22:53:04.301997 9356 replica.cpp:664] Replica learned APPEND action at position 3 I0116 22:53:04.302826 9348 log.cpp:703] Attempting to truncate the log to 3 I0116 22:53:04.303135 9342 coordinator.cpp:340] Coordinator attempting to write TRUNCATE action at position 4 I0116 22:53:04.303911 9353 replica.cpp:511] Replica received write request for position 4 I0116 22:53:04.304136 9346 replica.cpp:511] Replica received write request for position 4 I0116 22:53:04.351929 9346 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 47.75715ms I0116 22:53:04.351940 9353 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 47.992899ms I0116 22:53:04.351964 9346 replica.cpp:679] Persisted action at 4 I0116 22:53:04.351969 9353 replica.cpp:679] Persisted action at 4 [ OK ] LogStateTest.FetchAndStoreAndStoreAndFetch (1260 ms) [----------] 9 tests from LogStateTest (10537 ms total) [----------] 5 tests from DiskResourcesTest [ RUN ] DiskResourcesTest.Equals [ OK ] DiskResourcesTest.Equals (1 ms) [ RUN ] DiskResourcesTest.Validation [ OK ] DiskResourcesTest.Validation (0 ms) [ RUN ] DiskResourcesTest.Subtraction [ OK ] DiskResourcesTest.Subtraction (0 ms) [ RUN ] DiskResourcesTest.FilterPersistentDisks [ OK ] DiskResourcesTest.FilterPersistentDisks (0 ms) [ RUN ] DiskResourcesTest.Addition [ OK ] DiskResourcesTest.Addition (0 ms) [----------] 5 tests from DiskResourcesTest (1 ms total) [----------] 1 test from MesosContainerizerExecuteTest [ RUN ] MesosContainerizerExecuteTest.IoRedirection Using temporary directory '/tmp/MesosContainerizerExecuteTest_IoRedirection_bbXdJw' I0116 22:53:04.362447 9327 containerizer.cpp:103] Using isolation: posix/cpu,posix/mem I0116 22:53:04.362974 9343 containerizer.cpp:445] Starting container 'test_container' for executor 'executor' of framework '' W0116 22:53:04.363966 9343 containerizer.cpp:296] CommandInfo.grace_period flag is not set, using default value: 3secs I0116 22:53:04.366385 9343 launcher.cpp:137] Forked child with pid '12616' for container 'test_container' I0116 22:53:04.445013 9342 containerizer.cpp:1084] Executor for container 'test_container' has exited I0116 22:53:04.445111 9342 containerizer.cpp:879] Destroying container 'test_container' [ OK ] MesosContainerizerExecuteTest.IoRedirection (120 ms) [----------] 1 test from MesosContainerizerExecuteTest (120 ms total) [----------] Global test environment tear-down [==========] 467 tests from 73 test cases ran. (313908 ms total) [ PASSED ] 466 tests. [ FAILED ] 1 test, listed below: [ FAILED ] ExamplesTest.LowLevelSchedulerPthread 1 FAILED TEST YOU HAVE 6 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
