See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/2068/>
------------------------------------------ [...truncated 34489 lines...] I0418 02:10:50.529378 19823 replica.cpp:649] Replica learned TRUNCATE action at position 2 I0418 02:10:50.529395 19823 replica.cpp:508] Replica received write request for position 3 I0418 02:10:50.550729 19823 leveldb.cpp:341] Persisting action (186 bytes) to leveldb took 21.309863ms I0418 02:10:50.550782 19823 replica.cpp:664] Persisted action at 3 I0418 02:10:50.550875 19813 leveldb.cpp:341] Persisting action (186 bytes) to leveldb took 21.897639ms I0418 02:10:50.550905 19813 replica.cpp:664] Persisted action at 3 I0418 02:10:50.551046 19813 replica.cpp:643] Replica received learned notice for position 3 I0418 02:10:50.551064 19823 replica.cpp:643] Replica received learned notice for position 3 I0418 02:10:50.568379 19823 leveldb.cpp:341] Persisting action (188 bytes) to leveldb took 17.286998ms I0418 02:10:50.568434 19823 replica.cpp:664] Persisted action at 3 I0418 02:10:50.568446 19823 replica.cpp:649] Replica learned APPEND action at position 3 I0418 02:10:50.568382 19813 leveldb.cpp:341] Persisting action (188 bytes) to leveldb took 17.308342ms I0418 02:10:50.568500 19813 replica.cpp:664] Persisted action at 3 I0418 02:10:50.568519 19813 replica.cpp:649] Replica learned APPEND action at position 3 I0418 02:10:50.568804 19813 registrar.cpp:356] Successfully updated 'registry' I0418 02:10:50.568862 19823 log.cpp:682] Attempting to truncate the log to 3 I0418 02:10:50.568960 19823 coordinator.cpp:339] Coordinator attempting to write TRUNCATE action at position 4 I0418 02:10:50.569239 19814 registrar.cpp:217] Recovering registrar I0418 02:10:50.569507 19814 replica.cpp:508] Replica received write request for position 4 I0418 02:10:50.569644 19828 replica.cpp:508] Replica received write request for position 4 I0418 02:10:50.569715 19822 registrar.cpp:243] Successfully recovered registrar I0418 02:10:50.569746 19822 registrar.cpp:314] Attempting to update the 'registry' I0418 02:10:50.584579 19828 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 14.906061ms I0418 02:10:50.584660 19828 replica.cpp:664] Persisted action at 4 I0418 02:10:50.584600 19814 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 15.06634ms I0418 02:10:50.584696 19814 replica.cpp:664] Persisted action at 4 I0418 02:10:50.585846 19821 replica.cpp:643] Replica received learned notice for position 4 I0418 02:10:50.585854 19826 replica.cpp:643] Replica received learned notice for position 4 I0418 02:10:50.600734 19826 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 14.831532ms I0418 02:10:50.600776 19821 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 14.891178ms I0418 02:10:50.600831 19821 leveldb.cpp:399] Deleting ~2 keys from leveldb took 34530ns I0418 02:10:50.600831 19826 leveldb.cpp:399] Deleting ~2 keys from leveldb took 46335ns I0418 02:10:50.600853 19821 replica.cpp:664] Persisted action at 4 I0418 02:10:50.600857 19826 replica.cpp:664] Persisted action at 4 I0418 02:10:50.600863 19821 replica.cpp:649] Replica learned TRUNCATE action at position 4 I0418 02:10:50.600863 19826 replica.cpp:649] Replica learned TRUNCATE action at position 4 I0418 02:10:50.601214 19817 log.cpp:663] Attempting to append 167 bytes to the log I0418 02:10:50.601492 19816 coordinator.cpp:339] Coordinator attempting to write APPEND action at position 5 I0418 02:10:50.602068 19821 replica.cpp:508] Replica received write request for position 5 I0418 02:10:50.602480 19813 replica.cpp:508] Replica received write request for position 5 I0418 02:10:50.616777 19821 leveldb.cpp:341] Persisting action (186 bytes) to leveldb took 14.677731ms I0418 02:10:50.616829 19821 replica.cpp:664] Persisted action at 5 I0418 02:10:50.616777 19813 leveldb.cpp:341] Persisting action (186 bytes) to leveldb took 14.19779ms I0418 02:10:50.616858 19813 replica.cpp:664] Persisted action at 5 I0418 02:10:50.617444 19815 replica.cpp:643] Replica received learned notice for position 5 I0418 02:10:50.617516 19830 replica.cpp:643] Replica received learned notice for position 5 I0418 02:10:50.632838 19830 leveldb.cpp:341] Persisting action (188 bytes) to leveldb took 15.283752ms I0418 02:10:50.632838 19815 leveldb.cpp:341] Persisting action (188 bytes) to leveldb took 15.363699ms I0418 02:10:50.633010 19830 replica.cpp:664] Persisted action at 5 I0418 02:10:50.633028 19830 replica.cpp:649] Replica learned APPEND action at position 5 I0418 02:10:50.633013 19815 replica.cpp:664] Persisted action at 5 I0418 02:10:50.633076 19815 replica.cpp:649] Replica learned APPEND action at position 5 I0418 02:10:50.633287 19807 registrar.cpp:356] Successfully updated 'registry' I0418 02:10:50.633363 19807 log.cpp:682] Attempting to truncate the log to 5 I0418 02:10:50.633576 19824 coordinator.cpp:339] Coordinator attempting to write TRUNCATE action at position 6 I0418 02:10:50.634273 19814 replica.cpp:508] Replica received write request for position 6 I0418 02:10:50.634338 19807 replica.cpp:508] Replica received write request for position 6 I0418 02:10:50.648926 19807 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 14.559533ms I0418 02:10:50.649063 19807 replica.cpp:664] Persisted action at 6 I0418 02:10:50.648969 19814 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 14.659562ms I0418 02:10:50.649185 19814 replica.cpp:664] Persisted action at 6 [ OK ] Strict/RegistrarTest.bootstrap/0 (552 ms) [ RUN ] Strict/RegistrarTest.bootstrap/1 Using temporary directory '/tmp/Strict_RegistrarTest_bootstrap_1_8CyfjT' I0418 02:10:50.698461 19787 leveldb.cpp:174] Opened db in 48.242796ms I0418 02:10:50.714814 19787 leveldb.cpp:181] Compacted db in 16.301515ms I0418 02:10:50.714859 19787 leveldb.cpp:196] Created db iterator in 5528ns I0418 02:10:50.714866 19787 leveldb.cpp:202] Seeked to beginning of db in 1145ns I0418 02:10:50.714871 19787 leveldb.cpp:271] Iterated through 0 keys in the db in 288ns I0418 02:10:50.714890 19787 replica.cpp:729] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0418 02:10:50.735391 19829 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 19.857257ms I0418 02:10:50.735550 19829 replica.cpp:320] Persisted replica status to VOTING I0418 02:10:50.784584 19787 leveldb.cpp:174] Opened db in 48.578046ms I0418 02:10:50.807672 19787 leveldb.cpp:181] Compacted db in 22.922891ms I0418 02:10:50.807718 19787 leveldb.cpp:196] Created db iterator in 5426ns I0418 02:10:50.807726 19787 leveldb.cpp:202] Seeked to beginning of db in 1370ns I0418 02:10:50.807730 19787 leveldb.cpp:271] Iterated through 0 keys in the db in 304ns I0418 02:10:50.807746 19787 replica.cpp:729] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0418 02:10:50.820960 19824 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 12.91375ms I0418 02:10:50.821002 19824 replica.cpp:320] Persisted replica status to VOTING I0418 02:10:50.865957 19787 leveldb.cpp:174] Opened db in 44.634018ms I0418 02:10:50.914783 19787 leveldb.cpp:181] Compacted db in 48.766234ms I0418 02:10:50.914845 19787 leveldb.cpp:196] Created db iterator in 10300ns I0418 02:10:50.914875 19787 leveldb.cpp:202] Seeked to beginning of db in 18286ns I0418 02:10:50.914907 19787 leveldb.cpp:271] Iterated through 1 keys in the db in 21042ns I0418 02:10:50.914930 19787 replica.cpp:729] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0418 02:10:50.955935 19787 leveldb.cpp:174] Opened db in 40.833126ms I0418 02:10:51.008810 19787 leveldb.cpp:181] Compacted db in 52.828609ms I0418 02:10:51.008857 19787 leveldb.cpp:196] Created db iterator in 6914ns I0418 02:10:51.008877 19787 leveldb.cpp:202] Seeked to beginning of db in 11769ns I0418 02:10:51.008900 19787 leveldb.cpp:271] Iterated through 1 keys in the db in 15194ns I0418 02:10:51.008918 19787 replica.cpp:729] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I0418 02:10:51.009140 19825 recover.cpp:293] Starting replica recovery I0418 02:10:51.009364 19812 recover.cpp:319] Replica is in VOTING status I0418 02:10:51.009448 19812 recover.cpp:308] Recover process terminated I0418 02:10:51.010854 19823 registrar.cpp:217] Recovering registrar I0418 02:10:51.011013 19823 log.cpp:639] Attempting to start the writer I0418 02:10:51.011461 19830 replica.cpp:474] Replica received implicit promise request with proposal 1 I0418 02:10:51.011770 19824 replica.cpp:474] Replica received implicit promise request with proposal 1 I0418 02:10:51.024830 19824 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 13.030275ms I0418 02:10:51.024885 19824 replica.cpp:342] Persisted promised to 1 I0418 02:10:51.024998 19830 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 13.516111ms I0418 02:10:51.025017 19830 replica.cpp:342] Persisted promised to 1 I0418 02:10:51.025182 19830 coordinator.cpp:229] Coordinator attemping to fill missing position I0418 02:10:51.025501 19830 replica.cpp:375] Replica received explicit promise request for position 0 with proposal 2 I0418 02:10:51.025621 19824 replica.cpp:375] Replica received explicit promise request for position 0 with proposal 2 I0418 02:10:51.040942 19824 leveldb.cpp:341] Persisting action (8 bytes) to leveldb took 15.295688ms I0418 02:10:51.040984 19824 replica.cpp:664] Persisted action at 0 I0418 02:10:51.040982 19830 leveldb.cpp:341] Persisting action (8 bytes) to leveldb took 15.462318ms I0418 02:10:51.041002 19830 replica.cpp:664] Persisted action at 0 I0418 02:10:51.041761 19809 replica.cpp:508] Replica received write request for position 0 I0418 02:10:51.041815 19823 replica.cpp:508] Replica received write request for position 0 I0418 02:10:51.041841 19809 leveldb.cpp:436] Reading position from leveldb took 62103ns I0418 02:10:51.041904 19823 leveldb.cpp:436] Reading position from leveldb took 14266ns I0418 02:10:51.057135 19809 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 15.272007ms I0418 02:10:51.057123 19823 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 15.173128ms I0418 02:10:51.057227 19823 replica.cpp:664] Persisted action at 0 I0418 02:10:51.057204 19809 replica.cpp:664] Persisted action at 0 I0418 02:10:51.057862 19826 replica.cpp:643] Replica received learned notice for position 0 I0418 02:10:51.057914 19813 replica.cpp:643] Replica received learned notice for position 0 I0418 02:10:51.073204 19813 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 15.266312ms I0418 02:10:51.073246 19813 replica.cpp:664] Persisted action at 0 I0418 02:10:51.073245 19826 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 15.36308ms I0418 02:10:51.073256 19813 replica.cpp:649] Replica learned NOP action at position 0 I0418 02:10:51.073266 19826 replica.cpp:664] Persisted action at 0 I0418 02:10:51.073274 19826 replica.cpp:649] Replica learned NOP action at position 0 I0418 02:10:51.073590 19817 log.cpp:655] Writer started with ending position 0 I0418 02:10:51.074013 19812 leveldb.cpp:436] Reading position from leveldb took 19850ns I0418 02:10:51.074954 19812 registrar.cpp:243] Successfully recovered registrar I0418 02:10:51.074971 19812 registrar.cpp:314] Attempting to update the 'registry' I0418 02:10:51.075830 19812 log.cpp:663] Attempting to append 144 bytes to the log I0418 02:10:51.075934 19813 coordinator.cpp:339] Coordinator attempting to write APPEND action at position 1 I0418 02:10:51.076375 19818 replica.cpp:508] Replica received write request for position 1 I0418 02:10:51.076434 19823 replica.cpp:508] Replica received write request for position 1 I0418 02:10:51.089280 19818 leveldb.cpp:341] Persisting action (163 bytes) to leveldb took 12.869853ms I0418 02:10:51.089280 19823 leveldb.cpp:341] Persisting action (163 bytes) to leveldb took 12.793774ms I0418 02:10:51.089475 19818 replica.cpp:664] Persisted action at 1 I0418 02:10:51.089496 19823 replica.cpp:664] Persisted action at 1 I0418 02:10:51.089850 19825 replica.cpp:643] Replica received learned notice for position 1 I0418 02:10:51.089871 19819 replica.cpp:643] Replica received learned notice for position 1 I0418 02:10:51.109349 19819 leveldb.cpp:341] Persisting action (165 bytes) to leveldb took 19.443824ms I0418 02:10:51.109349 19825 leveldb.cpp:341] Persisting action (165 bytes) to leveldb took 19.470453ms I0418 02:10:51.109510 19819 replica.cpp:664] Persisted action at 1 I0418 02:10:51.109524 19819 replica.cpp:649] Replica learned APPEND action at position 1 I0418 02:10:51.109526 19825 replica.cpp:664] Persisted action at 1 I0418 02:10:51.109540 19825 replica.cpp:649] Replica learned APPEND action at position 1 I0418 02:10:51.109973 19824 registrar.cpp:356] Successfully updated 'registry' I0418 02:10:51.110054 19826 log.cpp:682] Attempting to truncate the log to 1 I0418 02:10:51.110193 19822 coordinator.cpp:339] Coordinator attempting to write TRUNCATE action at position 2 I0418 02:10:51.110478 19827 registrar.cpp:314] Attempting to update the 'registry' I0418 02:10:51.110492 19822 replica.cpp:508] Replica received write request for position 2 I0418 02:10:51.110541 19823 replica.cpp:508] Replica received write request for position 2 I0418 02:10:51.125496 19823 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 14.922804ms I0418 02:10:51.125496 19822 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 14.977704ms I0418 02:10:51.125565 19823 replica.cpp:664] Persisted action at 2 I0418 02:10:51.125567 19822 replica.cpp:664] Persisted action at 2 I0418 02:10:51.125799 19814 replica.cpp:643] Replica received learned notice for position 2 I0418 02:10:51.125810 19812 replica.cpp:643] Replica received learned notice for position 2 I0418 02:10:51.141566 19812 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 15.727937ms I0418 02:10:51.141566 19814 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 15.737116ms I0418 02:10:51.141659 19812 leveldb.cpp:399] Deleting ~1 keys from leveldb took 42386ns I0418 02:10:51.141660 19814 leveldb.cpp:399] Deleting ~1 keys from leveldb took 37522ns I0418 02:10:51.141676 19812 replica.cpp:664] Persisted action at 2 I0418 02:10:51.141680 19814 replica.cpp:664] Persisted action at 2 I0418 02:10:51.141687 19814 replica.cpp:649] Replica learned TRUNCATE action at position 2 I0418 02:10:51.141687 19812 replica.cpp:649] Replica learned TRUNCATE action at position 2 I0418 02:10:51.141937 19811 log.cpp:663] Attempting to append 144 bytes to the log I0418 02:10:51.141975 19822 coordinator.cpp:339] Coordinator attempting to write APPEND action at position 3 I0418 02:10:51.142359 19810 replica.cpp:508] Replica received write request for position 3 I0418 02:10:51.142426 19817 replica.cpp:508] Replica received write request for position 3 I0418 02:10:51.157657 19810 leveldb.cpp:341] Persisting action (163 bytes) to leveldb took 15.263572ms I0418 02:10:51.157667 19817 leveldb.cpp:341] Persisting action (163 bytes) to leveldb took 15.215004ms I0418 02:10:51.157711 19817 replica.cpp:664] Persisted action at 3 I0418 02:10:51.157692 19810 replica.cpp:664] Persisted action at 3 I0418 02:10:51.157987 19826 replica.cpp:643] Replica received learned notice for position 3 I0418 02:10:51.157997 19816 replica.cpp:643] Replica received learned notice for position 3 I0418 02:10:51.173786 19826 leveldb.cpp:341] Persisting action (165 bytes) to leveldb took 15.77142ms I0418 02:10:51.173786 19816 leveldb.cpp:341] Persisting action (165 bytes) to leveldb took 15.764078ms I0418 02:10:51.173831 19826 replica.cpp:664] Persisted action at 3 I0418 02:10:51.173836 19816 replica.cpp:664] Persisted action at 3 I0418 02:10:51.173842 19826 replica.cpp:649] Replica learned APPEND action at position 3 I0418 02:10:51.173845 19816 replica.cpp:649] Replica learned APPEND action at position 3 I0418 02:10:51.174062 19829 registrar.cpp:356] Successfully updated 'registry' I0418 02:10:51.174166 19815 log.cpp:682] Attempting to truncate the log to 3 I0418 02:10:51.174267 19828 coordinator.cpp:339] Coordinator attempting to write TRUNCATE action at position 4 I0418 02:10:51.174361 19827 registrar.cpp:217] Recovering registrar I0418 02:10:51.174478 19813 replica.cpp:508] Replica received write request for position 4 I0418 02:10:51.174484 19822 replica.cpp:508] Replica received write request for position 4 I0418 02:10:51.174510 19809 registrar.cpp:243] Successfully recovered registrar I0418 02:10:51.174543 19809 registrar.cpp:314] Attempting to update the 'registry' I0418 02:10:51.193972 19822 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 19.460671ms I0418 02:10:51.194048 19822 replica.cpp:664] Persisted action at 4 I0418 02:10:51.193990 19813 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 19.492451ms I0418 02:10:51.194082 19813 replica.cpp:664] Persisted action at 4 I0418 02:10:51.194612 19814 replica.cpp:643] Replica received learned notice for position 4 I0418 02:10:51.194622 19809 replica.cpp:643] Replica received learned notice for position 4 I0418 02:10:51.210047 19814 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 15.403015ms I0418 02:10:51.210152 19814 leveldb.cpp:399] Deleting ~2 keys from leveldb took 49620ns I0418 02:10:51.210167 19814 replica.cpp:664] Persisted action at 4 I0418 02:10:51.210178 19814 replica.cpp:649] Replica learned TRUNCATE action at position 4 I0418 02:10:51.210255 19809 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 15.607502ms I0418 02:10:51.210343 19809 leveldb.cpp:399] Deleting ~2 keys from leveldb took 45708ns I0418 02:10:51.210357 19809 replica.cpp:664] Persisted action at 4 I0418 02:10:51.210368 19809 replica.cpp:649] Replica learned TRUNCATE action at position 4 I0418 02:10:51.210469 19826 log.cpp:663] Attempting to append 144 bytes to the log I0418 02:10:51.210552 19830 coordinator.cpp:339] Coordinator attempting to write APPEND action at position 5 I0418 02:10:51.210783 19830 replica.cpp:508] Replica received write request for position 5 I0418 02:10:51.210898 19823 replica.cpp:508] Replica received write request for position 5 I0418 02:10:51.226145 19823 leveldb.cpp:341] Persisting action (163 bytes) to leveldb took 15.21328ms I0418 02:10:51.226203 19823 replica.cpp:664] Persisted action at 5 I0418 02:10:51.226320 19830 leveldb.cpp:341] Persisting action (163 bytes) to leveldb took 15.51474ms I0418 02:10:51.226341 19830 replica.cpp:664] Persisted action at 5 I0418 02:10:51.226503 19830 replica.cpp:643] Replica received learned notice for position 5 I0418 02:10:51.226631 19823 replica.cpp:643] Replica received learned notice for position 5 I0418 02:10:51.242255 19830 leveldb.cpp:341] Persisting action (165 bytes) to leveldb took 15.728523ms I0418 02:10:51.242312 19830 replica.cpp:664] Persisted action at 5 I0418 02:10:51.242323 19830 replica.cpp:649] Replica learned APPEND action at position 5 I0418 02:10:51.242255 19823 leveldb.cpp:341] Persisting action (165 bytes) to leveldb took 15.598579ms I0418 02:10:51.248205 19823 replica.cpp:664] Persisted action at 5 I0418 02:10:51.248216 19823 replica.cpp:649] Replica learned APPEND action at position 5 I0418 02:10:51.248533 19823 registrar.cpp:356] Successfully updated 'registry' I0418 02:10:51.248580 19823 log.cpp:682] Attempting to truncate the log to 5 I0418 02:10:51.248628 19823 coordinator.cpp:339] Coordinator attempting to write TRUNCATE action at position 6 I0418 02:10:51.248862 19823 replica.cpp:508] Replica received write request for position 6 I0418 02:10:51.252156 19810 replica.cpp:508] Replica received write request for position 6 I0418 02:10:51.266439 19823 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 17.532163ms I0418 02:10:51.266513 19823 replica.cpp:664] Persisted action at 6 I0418 02:10:51.266443 19810 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 14.244873ms I0418 02:10:51.266561 19810 replica.cpp:664] Persisted action at 6 [ OK ] Strict/RegistrarTest.bootstrap/1 (618 ms) [----------] 10 tests from Strict/RegistrarTest (7544 ms total) [----------] Global test environment tear-down [==========] 250 tests from 43 test cases ran. (140743 ms total) [ PASSED ] 249 tests. [ FAILED ] 1 test, listed below: [ FAILED ] ReservationAllocatorTest.ResourcesReturned 1 FAILED TEST YOU HAVE 1 DISABLED TEST make[3]: *** [check-local] Error 1 make[3]: Leaving directory `/x1/jenkins/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/build/src' make[2]: *** [check-am] Error 2 make[2]: Leaving directory `/x1/jenkins/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/build/src' make[1]: *** [check] Error 2 make[1]: Leaving directory `/x1/jenkins/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/build/src' make: *** [check-recursive] Error 1 Build step 'Execute shell' marked build as failure
