https://issues.apache.org/jira/browse/MESOS-2403
On Tue, Feb 24, 2015 at 3:24 PM, Apache Jenkins Server < [email protected]> wrote: > See < > https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/2769/changes > > > > Changes: > > [benjamin.mahler] Fixed a style issue in the test launcher. > > ------------------------------------------ > [...truncated 73598 lines...] > I0224 23:24:43.264854 30611 replica.cpp:477] Replica received implicit > promise request with proposal 1 > I0224 23:24:43.265419 30611 leveldb.cpp:306] Persisting metadata (8 bytes) > to leveldb took 522680ns > I0224 23:24:43.265450 30611 replica.cpp:345] Persisted promised to 1 > I0224 23:24:43.266196 30611 replica.cpp:511] Replica received write > request for position 1 > I0224 23:24:43.266633 30611 leveldb.cpp:343] Persisting action (27 bytes) > to leveldb took 399003ns > I0224 23:24:43.266664 30611 replica.cpp:679] Persisted action at 1 > I0224 23:24:43.267392 30603 leveldb.cpp:438] Reading position from leveldb > took 43309ns > [ OK ] ReplicaTest.Append (15 ms) > [ RUN ] ReplicaTest.Restore > Using temporary directory '/tmp/ReplicaTest_Restore_qPPk2P' > I0224 23:24:43.270603 30589 leveldb.cpp:176] Opened db in 2.071789ms > I0224 23:24:43.271622 30589 leveldb.cpp:183] Compacted db in 992394ns > I0224 23:24:43.271656 30589 leveldb.cpp:198] Created db iterator in 10538ns > I0224 23:24:43.271672 30589 leveldb.cpp:204] Seeked to beginning of db in > 1317ns > I0224 23:24:43.271679 30589 leveldb.cpp:273] Iterated through 0 keys in > the db in 258ns > I0224 23:24:43.271700 30589 replica.cpp:744] Replica recovered with log > positions 0 -> 0 with 1 holes and 0 unlearned > I0224 23:24:43.272707 30616 leveldb.cpp:306] Persisting metadata (8 bytes) > to leveldb took 791193ns > I0224 23:24:43.272742 30616 replica.cpp:323] Persisted replica status to 1 > I0224 23:24:43.275786 30589 leveldb.cpp:176] Opened db in 2.530228ms > I0224 23:24:43.278626 30589 leveldb.cpp:183] Compacted db in 2.810496ms > I0224 23:24:43.278669 30589 leveldb.cpp:198] Created db iterator in 15115ns > I0224 23:24:43.278700 30589 leveldb.cpp:204] Seeked to beginning of db in > 16562ns > I0224 23:24:43.278728 30589 leveldb.cpp:273] Iterated through 1 keys in > the db in 17125ns > I0224 23:24:43.278753 30589 replica.cpp:744] Replica recovered with log > positions 0 -> 0 with 1 holes and 0 unlearned > I0224 23:24:43.279011 30607 replica.cpp:477] Replica received implicit > promise request with proposal 1 > I0224 23:24:43.279803 30607 leveldb.cpp:306] Persisting metadata (8 bytes) > to leveldb took 749127ns > I0224 23:24:43.279836 30607 replica.cpp:345] Persisted promised to 1 > I0224 23:24:43.280689 30608 replica.cpp:511] Replica received write > request for position 1 > I0224 23:24:43.281257 30608 leveldb.cpp:343] Persisting action (27 bytes) > to leveldb took 535421ns > I0224 23:24:43.281333 30608 replica.cpp:679] Persisted action at 1 > I0224 23:24:43.281960 30618 leveldb.cpp:438] Reading position from leveldb > took 37962ns > I0224 23:24:43.285873 30589 leveldb.cpp:176] Opened db in 3.117624ms > I0224 23:24:43.288627 30589 leveldb.cpp:183] Compacted db in 2.716969ms > I0224 23:24:43.288691 30589 leveldb.cpp:198] Created db iterator in 22976ns > I0224 23:24:43.288729 30589 leveldb.cpp:204] Seeked to beginning of db in > 18855ns > I0224 23:24:43.288792 30589 leveldb.cpp:273] Iterated through 2 keys in > the db in 46966ns > I0224 23:24:43.288859 30589 replica.cpp:744] Replica recovered with log > positions 0 -> 1 with 1 holes and 1 unlearned > I0224 23:24:43.289180 30610 leveldb.cpp:438] Reading position from leveldb > took 137487ns > [ OK ] ReplicaTest.Restore (22 ms) > [----------] 4 tests from ReplicaTest (79 ms total) > > [----------] 4 tests from SorterTest > [ RUN ] SorterTest.DRFSorter > [ OK ] SorterTest.DRFSorter (2 ms) > [ RUN ] SorterTest.SplitResourceShares > [ OK ] SorterTest.SplitResourceShares (0 ms) > [ RUN ] SorterTest.WDRFSorter > [ OK ] SorterTest.WDRFSorter (2 ms) > [ RUN ] SorterTest.Update > [ OK ] SorterTest.Update (0 ms) > [----------] 4 tests from SorterTest (4 ms total) > > [----------] 1 test from HealthTest > [ RUN ] HealthTest.ObserveEndpoint > Using temporary directory '/tmp/HealthTest_ObserveEndpoint_BrOFOP' > I0224 23:24:43.298955 30589 leveldb.cpp:176] Opened db in 2.702986ms > I0224 23:24:43.299968 30589 leveldb.cpp:183] Compacted db in 976189ns > I0224 23:24:43.300016 30589 leveldb.cpp:198] Created db iterator in 13129ns > I0224 23:24:43.300037 30589 leveldb.cpp:204] Seeked to beginning of db in > 1815ns > I0224 23:24:43.300047 30589 leveldb.cpp:273] Iterated through 0 keys in > the db in 330ns > I0224 23:24:43.300077 30589 replica.cpp:744] Replica recovered with log > positions 0 -> 0 with 1 holes and 0 unlearned > I0224 23:24:43.300639 30605 recover.cpp:449] Starting replica recovery > I0224 23:24:43.300912 30605 recover.cpp:475] Replica is in 4 status > I0224 23:24:43.302189 30604 replica.cpp:641] Replica in 4 status received > a broadcasted recover request > I0224 23:24:43.302718 30613 recover.cpp:195] Received a recover response > from a replica in 4 status > I0224 23:24:43.303071 30607 recover.cpp:566] Updating replica status to 3 > I0224 23:24:43.303583 30606 master.cpp:349] Master > 20150224-232443-3142697795-38391-30589 (pomona.apache.org) started on > 67.195.81.187:38391 > I0224 23:24:43.303719 30606 master.cpp:395] Master only allowing > authenticated frameworks to register > I0224 23:24:43.303772 30606 master.cpp:400] Master only allowing > authenticated slaves to register > I0224 23:24:43.303815 30606 credentials.hpp:37] Loading credentials for > authentication from '/tmp/HealthTest_ObserveEndpoint_BrOFOP/credentials' > I0224 23:24:43.303989 30618 leveldb.cpp:306] Persisting metadata (8 bytes) > to leveldb took 656119ns > I0224 23:24:43.304013 30618 replica.cpp:323] Persisted replica status to 3 > I0224 23:24:43.304044 30606 master.cpp:442] Authorization enabled > I0224 23:24:43.304319 30617 recover.cpp:475] Replica is in 3 status > I0224 23:24:43.304613 30614 whitelist_watcher.cpp:79] No whitelist given > I0224 23:24:43.304688 30617 hierarchical.hpp:287] Initialized hierarchical > allocator process > I0224 23:24:43.305397 30608 replica.cpp:641] Replica in 3 status received > a broadcasted recover request > I0224 23:24:43.305654 30606 master.cpp:1356] The newly elected leader is > [email protected]:38391 with id 20150224-232443-3142697795-38391-30589 > I0224 23:24:43.305680 30606 master.cpp:1369] Elected as the leading master! > I0224 23:24:43.305696 30606 master.cpp:1187] Recovering from registrar > I0224 23:24:43.305791 30609 registrar.cpp:313] Recovering registrar > I0224 23:24:43.306355 30614 recover.cpp:195] Received a recover response > from a replica in 3 status > I0224 23:24:43.306690 30616 recover.cpp:566] Updating replica status to 1 > I0224 23:24:43.307319 30607 leveldb.cpp:306] Persisting metadata (8 bytes) > to leveldb took 471046ns > I0224 23:24:43.307348 30607 replica.cpp:323] Persisted replica status to 1 > I0224 23:24:43.307440 30605 recover.cpp:580] Successfully joined the Paxos > group > I0224 23:24:43.307687 30605 recover.cpp:464] Recover process terminated > I0224 23:24:43.308090 30613 log.cpp:660] Attempting to start the writer > I0224 23:24:43.309535 30604 replica.cpp:477] Replica received implicit > promise request with proposal 1 > I0224 23:24:43.309991 30604 leveldb.cpp:306] Persisting metadata (8 bytes) > to leveldb took 428836ns > I0224 23:24:43.310012 30604 replica.cpp:345] Persisted promised to 1 > I0224 23:24:43.310864 30613 coordinator.cpp:230] Coordinator attemping to > fill missing position > I0224 23:24:43.312067 30606 replica.cpp:378] Replica received explicit > promise request for position 0 with proposal 2 > I0224 23:24:43.312515 30606 leveldb.cpp:343] Persisting action (8 bytes) > to leveldb took 419380ns > I0224 23:24:43.312536 30606 replica.cpp:679] Persisted action at 0 > I0224 23:24:43.313459 30604 replica.cpp:511] Replica received write > request for position 0 > I0224 23:24:43.313505 30604 leveldb.cpp:438] Reading position from leveldb > took 23451ns > I0224 23:24:43.313957 30604 leveldb.cpp:343] Persisting action (14 bytes) > to leveldb took 423524ns > I0224 23:24:43.313978 30604 replica.cpp:679] Persisted action at 0 > I0224 23:24:43.314461 30611 replica.cpp:658] Replica received learned > notice for position 0 > I0224 23:24:43.314920 30611 leveldb.cpp:343] Persisting action (16 bytes) > to leveldb took 433991ns > I0224 23:24:43.314941 30611 replica.cpp:679] Persisted action at 0 > I0224 23:24:43.314956 30611 replica.cpp:664] Replica learned 1 action at > position 0 > I0224 23:24:43.315454 30605 log.cpp:676] Writer started with ending > position 0 > I0224 23:24:43.316376 30609 leveldb.cpp:438] Reading position from leveldb > took 24621ns > I0224 23:24:43.318526 30613 registrar.cpp:346] Successfully fetched the > registry (0B) in 12.660992ms > I0224 23:24:43.318621 30613 registrar.cpp:445] Applied 1 operations in > 21449ns; attempting to update the 'registry' > I0224 23:24:43.320602 30603 log.cpp:684] Attempting to append 139 bytes to > the log > I0224 23:24:43.320705 30617 coordinator.cpp:340] Coordinator attempting to > write 2 action at position 1 > I0224 23:24:43.321363 30604 replica.cpp:511] Replica received write > request for position 1 > I0224 23:24:43.321965 30604 leveldb.cpp:343] Persisting action (158 bytes) > to leveldb took 573123ns > I0224 23:24:43.321990 30604 replica.cpp:679] Persisted action at 1 > I0224 23:24:43.322602 30610 replica.cpp:658] Replica received learned > notice for position 1 > I0224 23:24:43.323130 30610 leveldb.cpp:343] Persisting action (160 bytes) > to leveldb took 502467ns > I0224 23:24:43.323156 30610 replica.cpp:679] Persisted action at 1 > I0224 23:24:43.323174 30610 replica.cpp:664] Replica learned 2 action at > position 1 > I0224 23:24:43.323870 30617 registrar.cpp:490] Successfully updated the > 'registry' in 5.199872ms > I0224 23:24:43.323982 30617 registrar.cpp:376] Successfully recovered > registrar > I0224 23:24:43.324081 30608 log.cpp:703] Attempting to truncate the log to > 1 > I0224 23:24:43.324206 30611 master.cpp:1214] Recovered 0 slaves from the > Registry (101B) ; allowing 10mins for slaves to re-register > I0224 23:24:43.324302 30604 coordinator.cpp:340] Coordinator attempting to > write 3 action at position 2 > I0224 23:24:43.325017 30604 replica.cpp:511] Replica received write > request for position 2 > I0224 23:24:43.325666 30604 leveldb.cpp:343] Persisting action (16 bytes) > to leveldb took 620436ns > I0224 23:24:43.325692 30604 replica.cpp:679] Persisted action at 2 > I0224 23:24:43.326210 30609 replica.cpp:658] Replica received learned > notice for position 2 > I0224 23:24:43.326706 30609 leveldb.cpp:343] Persisting action (18 bytes) > to leveldb took 475495ns > I0224 23:24:43.326756 30609 leveldb.cpp:401] Deleting ~1 keys from leveldb > took 28992ns > I0224 23:24:43.326772 30609 replica.cpp:679] Persisted action at 2 > I0224 23:24:43.326788 30609 replica.cpp:664] Replica learned 3 action at > position 2 > I0224 23:24:43.336171 30617 process.cpp:2770] Handling HTTP event for > process 'master' with path: '/master/observe' > I0224 23:24:43.336381 30617 http.cpp:281] HTTP request for > '/master/observe' > I0224 23:24:43.338994 30605 process.cpp:2770] Handling HTTP event for > process 'master' with path: '/master/observe' > I0224 23:24:43.339126 30605 http.cpp:281] HTTP request for > '/master/observe' > I0224 23:24:43.341542 30603 process.cpp:2770] Handling HTTP event for > process 'master' with path: '/master/observe' > I0224 23:24:43.341717 30603 http.cpp:281] HTTP request for > '/master/observe' > I0224 23:24:43.345664 30611 process.cpp:2770] Handling HTTP event for > process 'master' with path: '/master/observe' > I0224 23:24:43.345798 30611 http.cpp:281] HTTP request for > '/master/observe' > I0224 23:24:43.348458 30603 process.cpp:2770] Handling HTTP event for > process 'master' with path: '/master/observe' > I0224 23:24:43.348601 30603 http.cpp:281] HTTP request for > '/master/observe' > I0224 23:24:43.351164 30611 process.cpp:2770] Handling HTTP event for > process 'master' with path: '/master/observe' > I0224 23:24:43.351310 30611 http.cpp:281] HTTP request for > '/master/observe' > I0224 23:24:43.353799 30614 process.cpp:2770] Handling HTTP event for > process 'master' with path: '/master/observe' > I0224 23:24:43.353957 30614 http.cpp:281] HTTP request for > '/master/observe' > I0224 23:24:43.356654 30603 process.cpp:2770] Handling HTTP event for > process 'master' with path: '/master/observe' > I0224 23:24:43.356806 30603 http.cpp:281] HTTP request for > '/master/observe' > I0224 23:24:43.359443 30604 process.cpp:2770] Handling HTTP event for > process 'master' with path: '/master/observe' > I0224 23:24:43.359570 30604 http.cpp:281] HTTP request for > '/master/observe' > I0224 23:24:43.362413 30615 process.cpp:2770] Handling HTTP event for > process 'master' with path: '/master/observe' > I0224 23:24:43.362543 30615 http.cpp:281] HTTP request for > '/master/observe' > I0224 23:24:43.365231 30613 process.cpp:2770] Handling HTTP event for > process 'master' with path: '/master/observe' > I0224 23:24:43.365386 30613 http.cpp:281] HTTP request for > '/master/observe' > I0224 23:24:43.368157 30614 process.cpp:2770] Handling HTTP event for > process 'master' with path: '/master/observe' > I0224 23:24:43.368327 30614 http.cpp:281] HTTP request for > '/master/observe' > I0224 23:24:43.371148 30606 process.cpp:2770] Handling HTTP event for > process 'master' with path: '/master/observe' > I0224 23:24:43.371325 30606 http.cpp:281] HTTP request for > '/master/observe' > I0224 23:24:43.373327 30589 master.cpp:787] Master terminating > I0224 23:24:43.374944 30589 process.cpp:2117] Dropped / Lost event for > PID: [email protected]:38391 > I0224 23:24:43.375062 30589 process.cpp:2117] Dropped / Lost event for > PID: [email protected]:38391 > [ OK ] HealthTest.ObserveEndpoint (83 ms) > [----------] 1 test from HealthTest (83 ms total) > > [----------] 6 tests from FilesTest > [ RUN ] FilesTest.DownloadTest > Using temporary directory '/tmp/FilesTest_DownloadTest_tzzpOP' > I0224 23:24:43.379614 30604 process.cpp:2770] Handling HTTP event for > process 'files' with path: '/files/download.json' > I0224 23:24:43.379969 30607 process.cpp:1108] Sending file at > '/tmp/FilesTest_DownloadTest_tzzpOP/binary' with length 17 > I0224 23:24:43.382921 30617 process.cpp:2770] Handling HTTP event for > process 'files' with path: '/files/download.json' > I0224 23:24:43.383385 30609 process.cpp:1108] Sending file at > '/tmp/FilesTest_DownloadTest_tzzpOP/black.gif' with length 42 > [ OK ] FilesTest.DownloadTest (8 ms) > [ RUN ] FilesTest.ReadTest > Using temporary directory '/tmp/FilesTest_ReadTest_2E1qPP' > I0224 23:24:43.386620 30603 process.cpp:2770] Handling HTTP event for > process 'files' with path: '/files/read.json' > I0224 23:24:43.389230 30615 process.cpp:2770] Handling HTTP event for > process 'files' with path: '/files/read.json' > I0224 23:24:43.392185 30616 process.cpp:2770] Handling HTTP event for > process 'files' with path: '/files/read.json' > I0224 23:24:43.395766 30617 process.cpp:2770] Handling HTTP event for > process 'files' with path: '/files/read.json' > I0224 23:24:43.398946 30617 process.cpp:2770] Handling HTTP event for > process 'files' with path: '/files/read.json' > I0224 23:24:43.401861 30606 process.cpp:2770] Handling HTTP event for > process 'files' with path: '/files/read.json' > [ OK ] FilesTest.ReadTest (18 ms) > [ RUN ] FilesTest.ResolveTest > Using temporary directory '/tmp/FilesTest_ResolveTest_DDDqTP' > I0224 23:24:43.406972 30610 process.cpp:2770] Handling HTTP event for > process 'files' with path: '/files/read.json' > I0224 23:24:43.409782 30614 process.cpp:2770] Handling HTTP event for > process 'files' with path: '/files/read.json' > I0224 23:24:43.412672 30604 process.cpp:2770] Handling HTTP event for > process 'files' with path: '/files/read.json' > I0224 23:24:43.415770 30605 process.cpp:2770] Handling HTTP event for > process 'files' with path: '/files/read.json' > I0224 23:24:43.418717 30606 process.cpp:2770] Handling HTTP event for > process 'files' with path: '/files/read.json' > I0224 23:24:43.421890 30606 process.cpp:2770] Handling HTTP event for > process 'files' with path: '/files/read.json' > I0224 23:24:43.425068 30618 process.cpp:2770] Handling HTTP event for > process 'files' with path: '/files/read.json' > I0224 23:24:43.427817 30618 process.cpp:2770] Handling HTTP event for > process 'files' with path: '/files/read.json' > I0224 23:24:43.430344 30617 process.cpp:2770] Handling HTTP event for > process 'files' with path: '/files/read.json' > I0224 23:24:43.432948 30611 process.cpp:2770] Handling HTTP event for > process 'files' with path: '/files/read.json' > [ OK ] FilesTest.ResolveTest (31 ms) > [ RUN ] FilesTest.AttachTest > Using temporary directory '/tmp/FilesTest_AttachTest_Yfnv2P' > [ OK ] FilesTest.AttachTest (3 ms) > [ RUN ] FilesTest.DetachTest > Using temporary directory '/tmp/FilesTest_DetachTest_3gS3bQ' > [ OK ] FilesTest.DetachTest (1 ms) > [ RUN ] FilesTest.BrowseTest > Using temporary directory '/tmp/FilesTest_BrowseTest_yqFJlQ' > I0224 23:24:43.441184 30617 process.cpp:2770] Handling HTTP event for > process 'files' with path: '/files/browse.json' > I0224 23:24:43.444715 30613 process.cpp:2770] Handling HTTP event for > process 'files' with path: '/files/browse.json' > I0224 23:24:43.448369 30617 process.cpp:2770] Handling HTTP event for > process 'files' with path: '/files/browse.json' > I0224 23:24:43.451839 30606 process.cpp:2770] Handling HTTP event for > process 'files' with path: '/files/browse.json' > I0224 23:24:43.454727 30611 process.cpp:2770] Handling HTTP event for > process 'files' with path: '/files/browse.json' > [ OK ] FilesTest.BrowseTest (18 ms) > [----------] 6 tests from FilesTest (79 ms total) > > [----------] 1 test from AnonymousTest > [ RUN ] AnonymousTest.Running > Using temporary directory '/tmp/AnonymousTest_Running_x2wkyQ' > I0224 23:24:43.456720 30589 test_anonymous_module.cpp:39] Anonymous module > constructor > I0224 23:24:43.456763 30589 test_anonymous_module.cpp:48] Anonymous module > destructor > [ OK ] AnonymousTest.Running (0 ms) > [----------] 1 test from AnonymousTest (0 ms total) > > [----------] 1 test from ResourcesOperationTest > [ RUN ] ResourcesOperationTest.CreatePersistentVolume > [ OK ] ResourcesOperationTest.CreatePersistentVolume (1 ms) > [----------] 1 test from ResourcesOperationTest (1 ms total) > > [----------] 2 tests from BasicMasterContenderDetectorTest > [ RUN ] BasicMasterContenderDetectorTest.Detector > I0224 23:24:43.607965 30619 process.cpp:2117] Dropped / Lost event for > PID: hierarchical-allocator(254)@67.195.81.187:38391 > [ OK ] BasicMasterContenderDetectorTest.Detector (173 ms) > [ RUN ] BasicMasterContenderDetectorTest.Contender > I0224 23:24:43.668346 30619 process.cpp:2117] Dropped / Lost event for > PID: [email protected]:38391 > [ OK ] BasicMasterContenderDetectorTest.Contender (176 ms) > [----------] 2 tests from BasicMasterContenderDetectorTest (349 ms total) > > [----------] Global test environment tear-down > [==========] 495 tests from 78 test cases ran. (153043 ms total) > [ PASSED ] 494 tests. > [ FAILED ] 1 test, listed below: > [ FAILED ] MasterAllocatorTest/0.FrameworkReregistersFirst, where > TypeParam = > mesos::internal::master::allocator::MesosAllocator<mesos::internal::master::allocator::HierarchicalAllocatorProcess<mesos::internal::master::allocator::DRFSorter, > mesos::internal::master::allocator::DRFSorter> > > > 1 FAILED TEST > YOU HAVE 8 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 >
