See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/2111/changes>
Changes: [yan] MESOS-1392: MasterDetector now returns a None when it cannot read the content of the ZNode it has detected. ------------------------------------------ [...truncated 64967 lines...] I0918 05:56:14.204608 19712 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 322127ns I0918 05:56:14.204628 19712 replica.cpp:342] Persisted promised to 1 I0918 05:56:14.204691 19717 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 537458ns I0918 05:56:14.204704 19717 replica.cpp:342] Persisted promised to 1 I0918 05:56:14.204926 19715 coordinator.cpp:230] Coordinator attemping to fill missing position I0918 05:56:14.205322 19722 replica.cpp:375] Replica received explicit promise request for position 0 with proposal 2 I0918 05:56:14.205431 19717 replica.cpp:375] Replica received explicit promise request for position 0 with proposal 2 I0918 05:56:14.205840 19717 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 390826ns I0918 05:56:14.205860 19717 replica.cpp:676] Persisted action at 0 I0918 05:56:14.216131 19722 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 10.786813ms I0918 05:56:14.216158 19722 replica.cpp:676] Persisted action at 0 I0918 05:56:14.216439 19716 replica.cpp:508] Replica received write request for position 0 I0918 05:56:14.216450 19713 replica.cpp:508] Replica received write request for position 0 I0918 05:56:14.216466 19716 leveldb.cpp:438] Reading position from leveldb took 11180ns I0918 05:56:14.216470 19713 leveldb.cpp:438] Reading position from leveldb took 7585ns I0918 05:56:14.216771 19716 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 277780ns I0918 05:56:14.216789 19716 replica.cpp:676] Persisted action at 0 I0918 05:56:14.216935 19713 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 336723ns I0918 05:56:14.216951 19713 replica.cpp:676] Persisted action at 0 I0918 05:56:14.217063 19713 replica.cpp:655] Replica received learned notice for position 0 I0918 05:56:14.217125 19725 replica.cpp:655] Replica received learned notice for position 0 I0918 05:56:14.217241 19713 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 150140ns I0918 05:56:14.217248 19725 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 106863ns I0918 05:56:14.217258 19713 replica.cpp:676] Persisted action at 0 I0918 05:56:14.217262 19725 replica.cpp:676] Persisted action at 0 I0918 05:56:14.217272 19725 replica.cpp:661] Replica learned NOP action at position 0 I0918 05:56:14.217272 19713 replica.cpp:661] Replica learned NOP action at position 0 I0918 05:56:14.217386 19725 log.cpp:672] Writer started with ending position 0 I0918 05:56:14.217566 19725 leveldb.cpp:438] Reading position from leveldb took 9371ns I0918 05:56:14.218955 19725 registrar.cpp:346] Successfully fetched the registry (0B) I0918 05:56:14.218977 19725 registrar.cpp:422] Attempting to update the 'registry' I0918 05:56:14.220368 19725 log.cpp:680] Attempting to append 144 bytes to the log I0918 05:56:14.220402 19725 coordinator.cpp:340] Coordinator attempting to write APPEND action at position 1 I0918 05:56:14.220895 19712 replica.cpp:508] Replica received write request for position 1 I0918 05:56:14.221308 19710 replica.cpp:508] Replica received write request for position 1 I0918 05:56:14.221565 19710 leveldb.cpp:343] Persisting action (163 bytes) to leveldb took 237637ns I0918 05:56:14.221585 19710 replica.cpp:676] Persisted action at 1 I0918 05:56:14.221642 19712 leveldb.cpp:343] Persisting action (163 bytes) to leveldb took 725907ns I0918 05:56:14.221660 19712 replica.cpp:676] Persisted action at 1 I0918 05:56:14.221876 19719 replica.cpp:655] Replica received learned notice for position 1 I0918 05:56:14.221978 19723 replica.cpp:655] Replica received learned notice for position 1 I0918 05:56:14.222036 19719 leveldb.cpp:343] Persisting action (165 bytes) to leveldb took 142878ns I0918 05:56:14.222064 19719 replica.cpp:676] Persisted action at 1 I0918 05:56:14.222074 19719 replica.cpp:661] Replica learned APPEND action at position 1 I0918 05:56:14.222110 19723 leveldb.cpp:343] Persisting action (165 bytes) to leveldb took 115133ns I0918 05:56:14.222122 19723 replica.cpp:676] Persisted action at 1 I0918 05:56:14.222131 19723 replica.cpp:661] Replica learned APPEND action at position 1 I0918 05:56:14.222337 19723 registrar.cpp:479] Successfully updated 'registry' I0918 05:56:14.222364 19723 registrar.cpp:372] Successfully recovered registrar I0918 05:56:14.222383 19723 log.cpp:699] Attempting to truncate the log to 1 I0918 05:56:14.222420 19723 coordinator.cpp:340] Coordinator attempting to write TRUNCATE action at position 2 I0918 05:56:14.222604 19723 replica.cpp:508] Replica received write request for position 2 I0918 05:56:14.222671 19719 replica.cpp:508] Replica received write request for position 2 I0918 05:56:14.222739 19723 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 117711ns I0918 05:56:14.222764 19723 replica.cpp:676] Persisted action at 2 I0918 05:56:14.222834 19719 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 135607ns I0918 05:56:14.222848 19719 replica.cpp:676] Persisted action at 2 I0918 05:56:14.222967 19719 replica.cpp:655] Replica received learned notice for position 2 I0918 05:56:14.223032 19723 replica.cpp:655] Replica received learned notice for position 2 I0918 05:56:14.223135 19723 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 78044ns I0918 05:56:14.223161 19723 leveldb.cpp:401] Deleting ~1 keys from leveldb took 12193ns I0918 05:56:14.223173 19723 replica.cpp:676] Persisted action at 2 I0918 05:56:14.223182 19723 replica.cpp:661] Replica learned TRUNCATE action at position 2 I0918 05:56:14.223311 19719 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 324991ns I0918 05:56:14.223340 19719 leveldb.cpp:401] Deleting ~1 keys from leveldb took 13023ns I0918 05:56:14.223351 19719 replica.cpp:676] Persisted action at 2 I0918 05:56:14.223359 19719 replica.cpp:661] Replica learned TRUNCATE action at position 2 I0918 05:56:14.223492 19716 registrar.cpp:422] Attempting to update the 'registry' I0918 05:56:14.224982 19716 log.cpp:680] Attempting to append 167 bytes to the log I0918 05:56:14.225019 19716 coordinator.cpp:340] Coordinator attempting to write APPEND action at position 3 I0918 05:56:14.225217 19716 replica.cpp:508] Replica received write request for position 3 I0918 05:56:14.225322 19720 replica.cpp:508] Replica received write request for position 3 I0918 05:56:14.225383 19716 leveldb.cpp:343] Persisting action (186 bytes) to leveldb took 146582ns I0918 05:56:14.225409 19716 replica.cpp:676] Persisted action at 3 I0918 05:56:14.225468 19720 leveldb.cpp:343] Persisting action (186 bytes) to leveldb took 128250ns I0918 05:56:14.225483 19720 replica.cpp:676] Persisted action at 3 I0918 05:56:14.225615 19720 replica.cpp:655] Replica received learned notice for position 3 I0918 05:56:14.225687 19716 replica.cpp:655] Replica received learned notice for position 3 I0918 05:56:14.225911 19720 leveldb.cpp:343] Persisting action (188 bytes) to leveldb took 278961ns I0918 05:56:14.225929 19720 replica.cpp:676] Persisted action at 3 I0918 05:56:14.225939 19720 replica.cpp:661] Replica learned APPEND action at position 3 I0918 05:56:14.225960 19716 leveldb.cpp:343] Persisting action (188 bytes) to leveldb took 246930ns I0918 05:56:14.225971 19716 replica.cpp:676] Persisted action at 3 I0918 05:56:14.225982 19716 replica.cpp:661] Replica learned APPEND action at position 3 I0918 05:56:14.226217 19716 registrar.cpp:479] Successfully updated 'registry' I0918 05:56:14.228445 19712 log.cpp:699] Attempting to truncate the log to 3 I0918 05:56:14.228482 19712 coordinator.cpp:340] Coordinator attempting to write TRUNCATE action at position 4 I0918 05:56:14.232602 19712 replica.cpp:508] Replica received write request for position 4 I0918 05:56:14.232682 19724 replica.cpp:508] Replica received write request for position 4 I0918 05:56:14.232913 19724 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 212843ns I0918 05:56:14.232928 19724 replica.cpp:676] Persisted action at 4 I0918 05:56:14.232987 19712 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 362950ns I0918 05:56:14.233000 19712 replica.cpp:676] Persisted action at 4 I0918 05:56:14.233117 19712 replica.cpp:655] Replica received learned notice for position 4 I0918 05:56:14.233182 19724 replica.cpp:655] Replica received learned notice for position 4 I0918 05:56:14.233250 19712 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 117388ns I0918 05:56:14.233291 19712 leveldb.cpp:401] Deleting ~2 keys from leveldb took 15431ns I0918 05:56:14.233304 19712 replica.cpp:676] Persisted action at 4 I0918 05:56:14.233312 19712 replica.cpp:661] Replica learned TRUNCATE action at position 4 I0918 05:56:14.233336 19724 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 130546ns I0918 05:56:14.233361 19724 leveldb.cpp:401] Deleting ~2 keys from leveldb took 13357ns I0918 05:56:14.233372 19724 replica.cpp:676] Persisted action at 4 I0918 05:56:14.233381 19724 replica.cpp:661] Replica learned TRUNCATE action at position 4 I0918 05:56:14.233589 19720 registrar.cpp:422] Attempting to update the 'registry' I0918 05:56:14.235213 19720 log.cpp:680] Attempting to append 167 bytes to the log I0918 05:56:14.235255 19720 coordinator.cpp:340] Coordinator attempting to write APPEND action at position 5 I0918 05:56:14.235435 19724 replica.cpp:508] Replica received write request for position 5 I0918 05:56:14.235474 19710 replica.cpp:508] Replica received write request for position 5 I0918 05:56:14.235609 19710 leveldb.cpp:343] Persisting action (186 bytes) to leveldb took 113906ns I0918 05:56:14.235627 19710 replica.cpp:676] Persisted action at 5 I0918 05:56:14.235652 19724 leveldb.cpp:343] Persisting action (186 bytes) to leveldb took 197362ns I0918 05:56:14.235669 19724 replica.cpp:676] Persisted action at 5 I0918 05:56:14.235864 19715 replica.cpp:655] Replica received learned notice for position 5 I0918 05:56:14.235939 19712 replica.cpp:655] Replica received learned notice for position 5 I0918 05:56:14.235962 19715 leveldb.cpp:343] Persisting action (188 bytes) to leveldb took 77243ns I0918 05:56:14.235980 19715 replica.cpp:676] Persisted action at 5 I0918 05:56:14.235991 19715 replica.cpp:661] Replica learned APPEND action at position 5 I0918 05:56:14.236119 19712 leveldb.cpp:343] Persisting action (188 bytes) to leveldb took 165387ns I0918 05:56:14.236138 19712 replica.cpp:676] Persisted action at 5 I0918 05:56:14.236148 19712 replica.cpp:661] Replica learned APPEND action at position 5 I0918 05:56:14.236371 19712 registrar.cpp:479] Successfully updated 'registry' I0918 05:56:14.236408 19712 log.cpp:699] Attempting to truncate the log to 5 I0918 05:56:14.236457 19712 coordinator.cpp:340] Coordinator attempting to write TRUNCATE action at position 6 I0918 05:56:14.236655 19712 replica.cpp:508] Replica received write request for position 6 I0918 05:56:14.236734 19723 replica.cpp:508] Replica received write request for position 6 I0918 05:56:14.236974 19712 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 300753ns I0918 05:56:14.236994 19712 replica.cpp:676] Persisted action at 6 I0918 05:56:14.237036 19712 registrar.cpp:422] Attempting to update the 'registry' I0918 05:56:14.238613 19723 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 1.850721ms I0918 05:56:14.238634 19723 replica.cpp:676] Persisted action at 6 I0918 05:56:14.238837 19723 replica.cpp:655] Replica received learned notice for position 6 I0918 05:56:14.238944 19712 replica.cpp:655] Replica received learned notice for position 6 I0918 05:56:14.239001 19723 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 146231ns I0918 05:56:14.239042 19723 leveldb.cpp:401] Deleting ~2 keys from leveldb took 26287ns I0918 05:56:14.239054 19723 replica.cpp:676] Persisted action at 6 I0918 05:56:14.239063 19723 replica.cpp:661] Replica learned TRUNCATE action at position 6 I0918 05:56:14.239106 19712 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 147838ns I0918 05:56:14.239135 19712 leveldb.cpp:401] Deleting ~2 keys from leveldb took 14659ns I0918 05:56:14.239145 19712 replica.cpp:676] Persisted action at 6 I0918 05:56:14.239155 19712 replica.cpp:661] Replica learned TRUNCATE action at position 6 I0918 05:56:14.239295 19712 log.cpp:680] Attempting to append 167 bytes to the log I0918 05:56:14.239326 19712 coordinator.cpp:340] Coordinator attempting to write APPEND action at position 7 I0918 05:56:14.239483 19712 replica.cpp:508] Replica received write request for position 7 I0918 05:56:14.239549 19723 replica.cpp:508] Replica received write request for position 7 I0918 05:56:14.239619 19712 leveldb.cpp:343] Persisting action (186 bytes) to leveldb took 119019ns I0918 05:56:14.239647 19712 replica.cpp:676] Persisted action at 7 I0918 05:56:14.239709 19723 leveldb.cpp:343] Persisting action (186 bytes) to leveldb took 132985ns I0918 05:56:14.239723 19723 replica.cpp:676] Persisted action at 7 I0918 05:56:14.239848 19723 replica.cpp:655] Replica received learned notice for position 7 I0918 05:56:14.239918 19724 replica.cpp:655] Replica received learned notice for position 7 I0918 05:56:14.240023 19724 leveldb.cpp:343] Persisting action (188 bytes) to leveldb took 79841ns I0918 05:56:14.240039 19724 replica.cpp:676] Persisted action at 7 I0918 05:56:14.240048 19724 replica.cpp:661] Replica learned APPEND action at position 7 I0918 05:56:14.240260 19724 registrar.cpp:479] Successfully updated 'registry' I0918 05:56:14.240295 19724 log.cpp:699] Attempting to truncate the log to 7 I0918 05:56:14.240334 19724 coordinator.cpp:340] Coordinator attempting to write TRUNCATE action at position 8 I0918 05:56:14.240522 19724 replica.cpp:508] Replica received write request for position 8 I0918 05:56:14.240603 19723 leveldb.cpp:343] Persisting action (188 bytes) to leveldb took 735833ns I0918 05:56:14.240633 19723 replica.cpp:676] Persisted action at 7 I0918 05:56:14.240643 19723 replica.cpp:661] Replica learned APPEND action at position 7 I0918 05:56:14.240656 19723 replica.cpp:508] Replica received write request for position 8 I0918 05:56:14.240878 19724 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 333600ns I0918 05:56:14.240895 19724 replica.cpp:676] Persisted action at 8 I0918 05:56:14.240947 19723 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 278326ns I0918 05:56:14.240959 19723 replica.cpp:676] Persisted action at 8 I0918 05:56:14.241078 19723 replica.cpp:655] Replica received learned notice for position 8 I0918 05:56:14.241143 19724 replica.cpp:655] Replica received learned notice for position 8 I0918 05:56:14.241209 19723 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 115138ns I0918 05:56:14.241248 19723 leveldb.cpp:401] Deleting ~2 keys from leveldb took 25263ns I0918 05:56:14.241261 19723 replica.cpp:676] Persisted action at 8 I0918 05:56:14.241271 19723 replica.cpp:661] Replica learned TRUNCATE action at position 8 I0918 05:56:14.241307 19724 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 138549ns I0918 05:56:14.241333 19724 leveldb.cpp:401] Deleting ~2 keys from leveldb took 14289ns I0918 05:56:14.241343 19724 replica.cpp:676] Persisted action at 8 I0918 05:56:14.241353 19724 replica.cpp:661] Replica learned TRUNCATE action at position 8 [ OK ] Strict/RegistrarTest.readmit/1 (69 ms) [ RUN ] Strict/RegistrarTest.fetchTimeout/0 Using temporary directory '/tmp/Strict_RegistrarTest_fetchTimeout_0_X4Uvwj' I0918 05:56:14.244354 19693 leveldb.cpp:176] Opened db in 1.57735ms I0918 05:56:14.244838 19693 leveldb.cpp:183] Compacted db in 460993ns I0918 05:56:14.244856 19693 leveldb.cpp:198] Created db iterator in 2608ns I0918 05:56:14.244866 19693 leveldb.cpp:204] Seeked to beginning of db in 453ns I0918 05:56:14.244876 19693 leveldb.cpp:273] Iterated through 0 keys in the db in 182ns I0918 05:56:14.244890 19693 replica.cpp:741] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0918 05:56:14.252435 19715 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 7.445824ms I0918 05:56:14.252460 19715 replica.cpp:320] Persisted replica status to VOTING I0918 05:56:14.254276 19693 leveldb.cpp:176] Opened db in 1.580103ms I0918 05:56:14.254655 19693 leveldb.cpp:183] Compacted db in 352970ns I0918 05:56:14.254674 19693 leveldb.cpp:198] Created db iterator in 2156ns I0918 05:56:14.254683 19693 leveldb.cpp:204] Seeked to beginning of db in 371ns I0918 05:56:14.254693 19693 leveldb.cpp:273] Iterated through 0 keys in the db in 169ns I0918 05:56:14.254704 19693 replica.cpp:741] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0918 05:56:14.255267 19719 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 340796ns I0918 05:56:14.255287 19719 replica.cpp:320] Persisted replica status to VOTING I0918 05:56:14.256993 19693 leveldb.cpp:176] Opened db in 1.520753ms I0918 05:56:14.258141 19693 leveldb.cpp:183] Compacted db in 1.12244ms I0918 05:56:14.258164 19693 leveldb.cpp:198] Created db iterator in 3719ns I0918 05:56:14.258182 19693 leveldb.cpp:204] Seeked to beginning of db in 6656ns I0918 05:56:14.258199 19693 leveldb.cpp:273] Iterated through 1 keys in the db in 7812ns I0918 05:56:14.258214 19693 replica.cpp:741] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0918 05:56:14.259775 19693 leveldb.cpp:176] Opened db in 1.508433ms I0918 05:56:14.260957 19693 leveldb.cpp:183] Compacted db in 1.154703ms I0918 05:56:14.260978 19693 leveldb.cpp:198] Created db iterator in 3522ns I0918 05:56:14.260994 19693 leveldb.cpp:204] Seeked to beginning of db in 6044ns I0918 05:56:14.261009 19693 leveldb.cpp:273] Iterated through 1 keys in the db in 6462ns I0918 05:56:14.261023 19693 replica.cpp:741] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0918 05:56:14.261184 19719 recover.cpp:425] Starting replica recovery I0918 05:56:14.261239 19719 recover.cpp:451] Replica is in VOTING status I0918 05:56:14.261270 19719 recover.cpp:440] Recover process terminated I0918 05:56:14.264508 19719 registrar.cpp:313] Recovering registrar [ OK ] Strict/RegistrarTest.fetchTimeout/0 (42 ms) [----------] 16 tests from Strict/RegistrarTest (2202 ms total) [----------] 7 tests from InMemoryStateTest [ RUN ] InMemoryStateTest.FetchAndStoreAndExpungeAndExpunge [ OK ] InMemoryStateTest.FetchAndStoreAndExpungeAndExpunge (4 ms) [ RUN ] InMemoryStateTest.FetchAndStoreAndStoreFailAndFetch [ OK ] InMemoryStateTest.FetchAndStoreAndStoreFailAndFetch (5 ms) [ RUN ] InMemoryStateTest.Names [ OK ] InMemoryStateTest.Names (17 ms) [ RUN ] InMemoryStateTest.FetchAndStoreAndExpungeAndFetch [ OK ] InMemoryStateTest.FetchAndStoreAndExpungeAndFetch (5 ms) [ RUN ] InMemoryStateTest.FetchAndStoreAndFetch [ OK ] InMemoryStateTest.FetchAndStoreAndFetch (19 ms) [ RUN ] InMemoryStateTest.FetchAndStoreAndExpungeAndStoreAndFetch [ OK ] InMemoryStateTest.FetchAndStoreAndExpungeAndStoreAndFetch (38 ms) [ RUN ] InMemoryStateTest.FetchAndStoreAndStoreAndFetch [ OK ] InMemoryStateTest.FetchAndStoreAndStoreAndFetch (10 ms) [----------] 7 tests from InMemoryStateTest (98 ms total) [----------] Global test environment tear-down [==========] 408 tests from 66 test cases ran. (443787 ms total) [ PASSED ] 407 tests. [ FAILED ] 1 test, listed below: [ FAILED ] SlaveRecoveryTest/0.RecoverCompletedExecutor, where TypeParam = mesos::internal::slave::MesosContainerizer 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-In-Src-Set-JAVA_HOME/ws/src'> make[2]: *** [check-am] Error 2 make[2]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/src'> make[1]: *** [check] Error 2 make[1]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/src'> make: *** [check-recursive] Error 1 Test finished Exit status: 2 Build step 'Execute shell' marked build as failure
