You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@mesos.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2014/07/23 04:18:04 UTC
Build failed in Jenkins:
Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui
#2275
See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/2275/changes>
Changes:
[benjamin.hindman] More docs for attributes and resources.
[benjamin.hindman] Removed trailing '/' in Makefile.am.
------------------------------------------
[...truncated 3341 lines...]
I0723 02:18:01.662987 26575 log.cpp:672] Writer started with ending position 0
I0723 02:18:01.663213 26576 log.cpp:680] Attempting to append 11 bytes to the log
I0723 02:18:01.663368 26576 coordinator.cpp:340] Coordinator attempting to write APPEND action at position 1
I0723 02:18:01.663586 26576 replica.cpp:508] Replica received write request for position 1
I0723 02:18:01.663589 26575 replica.cpp:508] Replica received write request for position 1
I0723 02:18:01.670192 26576 leveldb.cpp:343] Persisting action (27 bytes) to leveldb took 6.582697ms
I0723 02:18:01.670217 26576 replica.cpp:676] Persisted action at 1
I0723 02:18:01.674784 26575 leveldb.cpp:343] Persisting action (27 bytes) to leveldb took 11.146285ms
I0723 02:18:01.674808 26575 replica.cpp:676] Persisted action at 1
I0723 02:18:01.675060 26573 replica.cpp:655] Replica received learned notice for position 1
I0723 02:18:01.675065 26575 replica.cpp:655] Replica received learned notice for position 1
I0723 02:18:01.694130 26575 leveldb.cpp:343] Persisting action (29 bytes) to leveldb took 19.03493ms
I0723 02:18:01.694154 26575 replica.cpp:676] Persisted action at 1
I0723 02:18:01.694160 26575 replica.cpp:661] Replica learned APPEND action at position 1
I0723 02:18:01.698678 26573 leveldb.cpp:343] Persisting action (29 bytes) to leveldb took 23.526821ms
I0723 02:18:01.698709 26573 replica.cpp:676] Persisted action at 1
I0723 02:18:01.698719 26573 replica.cpp:661] Replica learned APPEND action at position 1
I0723 02:18:01.699117 26573 leveldb.cpp:438] Reading position from leveldb took 20227ns
[ OK ] LogTest.WriteRead (6624 ms)
[ RUN ] LogTest.Position
Using temporary directory '/tmp/LogTest_Position_f1Gu2C'
I0723 02:18:02.097327 26537 leveldb.cpp:176] Opened db in 388.612848ms
I0723 02:18:02.167786 26537 leveldb.cpp:183] Compacted db in 70.388284ms
I0723 02:18:02.167856 26537 leveldb.cpp:198] Created db iterator in 6243ns
I0723 02:18:02.167865 26537 leveldb.cpp:204] Seeked to beginning of db in 1091ns
I0723 02:18:02.167870 26537 leveldb.cpp:273] Iterated through 0 keys in the db in 180ns
I0723 02:18:02.167889 26537 replica.cpp:741] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0723 02:18:02.267482 26572 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 99.236386ms
I0723 02:18:02.267544 26572 replica.cpp:320] Persisted replica status to VOTING
I0723 02:18:02.596209 26537 leveldb.cpp:176] Opened db in 328.373722ms
I0723 02:18:02.602221 26537 leveldb.cpp:183] Compacted db in 5.951668ms
I0723 02:18:02.602241 26537 leveldb.cpp:198] Created db iterator in 5563ns
I0723 02:18:02.602249 26537 leveldb.cpp:204] Seeked to beginning of db in 998ns
I0723 02:18:02.602254 26537 leveldb.cpp:273] Iterated through 0 keys in the db in 273ns
I0723 02:18:02.602273 26537 replica.cpp:741] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0723 02:18:02.698930 26571 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 96.484534ms
I0723 02:18:02.698979 26571 replica.cpp:320] Persisted replica status to VOTING
I0723 02:18:02.990617 26537 leveldb.cpp:176] Opened db in 291.334119ms
I0723 02:18:03.214690 26537 leveldb.cpp:183] Compacted db in 224.005865ms
I0723 02:18:03.214766 26537 leveldb.cpp:198] Created db iterator in 8941ns
I0723 02:18:03.214792 26537 leveldb.cpp:204] Seeked to beginning of db in 17424ns
I0723 02:18:03.214818 26537 leveldb.cpp:273] Iterated through 1 keys in the db in 18525ns
I0723 02:18:03.214835 26537 replica.cpp:741] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0723 02:18:03.338562 26537 leveldb.cpp:176] Opened db in 123.631516ms
I0723 02:18:03.438832 26537 leveldb.cpp:183] Compacted db in 100.201161ms
I0723 02:18:03.438909 26537 leveldb.cpp:198] Created db iterator in 9154ns
I0723 02:18:03.438935 26537 leveldb.cpp:204] Seeked to beginning of db in 16789ns
I0723 02:18:03.438961 26537 leveldb.cpp:273] Iterated through 1 keys in the db in 19072ns
I0723 02:18:03.438978 26537 replica.cpp:741] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0723 02:18:03.439287 26571 recover.cpp:425] Starting replica recovery
I0723 02:18:03.439410 26570 recover.cpp:451] Replica is in VOTING status
I0723 02:18:03.439450 26570 recover.cpp:440] Recover process terminated
I0723 02:18:03.439537 26574 log.cpp:656] Attempting to start the writer
I0723 02:18:03.439862 26571 replica.cpp:474] Replica received implicit promise request with proposal 1
I0723 02:18:03.439889 26574 replica.cpp:474] Replica received implicit promise request with proposal 1
I0723 02:18:03.478307 26574 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 38.407423ms
I0723 02:18:03.478343 26574 replica.cpp:342] Persisted promised to 1
I0723 02:18:03.478312 26571 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 38.43023ms
I0723 02:18:03.478410 26571 replica.cpp:342] Persisted promised to 1
I0723 02:18:03.478560 26575 coordinator.cpp:230] Coordinator attemping to fill missing position
I0723 02:18:03.478862 26575 replica.cpp:375] Replica received explicit promise request for position 0 with proposal 2
I0723 02:18:03.478924 26573 replica.cpp:375] Replica received explicit promise request for position 0 with proposal 2
I0723 02:18:03.486047 26575 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 7.168093ms
I0723 02:18:03.486062 26575 replica.cpp:676] Persisted action at 0
I0723 02:18:03.489328 26573 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 10.395741ms
I0723 02:18:03.489343 26573 replica.cpp:676] Persisted action at 0
I0723 02:18:03.489614 26571 replica.cpp:508] Replica received write request for position 0
I0723 02:18:03.489635 26571 leveldb.cpp:438] Reading position from leveldb took 12132ns
I0723 02:18:03.489682 26575 replica.cpp:508] Replica received write request for position 0
I0723 02:18:03.489696 26575 leveldb.cpp:438] Reading position from leveldb took 5497ns
I0723 02:18:03.494011 26571 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 4.363825ms
I0723 02:18:03.494025 26571 replica.cpp:676] Persisted action at 0
I0723 02:18:03.501297 26575 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 11.592193ms
I0723 02:18:03.501312 26575 replica.cpp:676] Persisted action at 0
I0723 02:18:03.501391 26575 replica.cpp:655] Replica received learned notice for position 0
I0723 02:18:03.501438 26571 replica.cpp:655] Replica received learned notice for position 0
I0723 02:18:03.505978 26575 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 4.575988ms
I0723 02:18:03.505992 26575 replica.cpp:676] Persisted action at 0
I0723 02:18:03.506000 26575 replica.cpp:661] Replica learned NOP action at position 0
I0723 02:18:03.510304 26571 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 8.856383ms
I0723 02:18:03.510318 26571 replica.cpp:676] Persisted action at 0
I0723 02:18:03.510324 26571 replica.cpp:661] Replica learned NOP action at position 0
I0723 02:18:03.510417 26571 log.cpp:672] Writer started with ending position 0
I0723 02:18:03.510565 26571 log.cpp:680] Attempting to append 11 bytes to the log
I0723 02:18:03.510615 26571 coordinator.cpp:340] Coordinator attempting to write APPEND action at position 1
I0723 02:18:03.510784 26571 replica.cpp:508] Replica received write request for position 1
I0723 02:18:03.510843 26576 replica.cpp:508] Replica received write request for position 1
I0723 02:18:03.513939 26571 leveldb.cpp:343] Persisting action (27 bytes) to leveldb took 3.143922ms
I0723 02:18:03.513967 26571 replica.cpp:676] Persisted action at 1
I0723 02:18:03.522253 26576 leveldb.cpp:343] Persisting action (27 bytes) to leveldb took 11.398334ms
I0723 02:18:03.522269 26576 replica.cpp:676] Persisted action at 1
I0723 02:18:03.522400 26576 replica.cpp:655] Replica received learned notice for position 1
I0723 02:18:03.522457 26571 replica.cpp:655] Replica received learned notice for position 1
I0723 02:18:03.525913 26576 leveldb.cpp:343] Persisting action (29 bytes) to leveldb took 3.503837ms
I0723 02:18:03.525928 26576 replica.cpp:676] Persisted action at 1
I0723 02:18:03.525934 26576 replica.cpp:661] Replica learned APPEND action at position 1
I0723 02:18:03.537183 26571 leveldb.cpp:343] Persisting action (29 bytes) to leveldb took 14.716382ms
I0723 02:18:03.537199 26571 replica.cpp:676] Persisted action at 1
I0723 02:18:03.537205 26571 replica.cpp:661] Replica learned APPEND action at position 1
[ OK ] LogTest.Position (1838 ms)
[----------] 2 tests from LogTest (8462 ms total)
[----------] 17 tests from AuthorizationTest
[ RUN ] AuthorizationTest.AnyPrincipalRunAsUser
Using temporary directory '/tmp/AuthorizationTest_AnyPrincipalRunAsUser_rnTXY1'
[ OK ] AuthorizationTest.AnyPrincipalRunAsUser (1 ms)
[ RUN ] AuthorizationTest.SomePrincipalOnlySomeUser
Using temporary directory '/tmp/AuthorizationTest_SomePrincipalOnlySomeUser_0nczVq'
[ OK ] AuthorizationTest.SomePrincipalOnlySomeUser (0 ms)
[ RUN ] AuthorizationTest.PrincipalRunAsSomeUserRestrictive
Using temporary directory '/tmp/AuthorizationTest_PrincipalRunAsSomeUserRestrictive_sfAhSP'
[ OK ] AuthorizationTest.PrincipalRunAsSomeUserRestrictive (0 ms)
[ RUN ] AuthorizationTest.PrincipalNotOfferedAnyRoleRestrictive
Using temporary directory '/tmp/AuthorizationTest_PrincipalNotOfferedAnyRoleRestrictive_YVO7Oe'
[ OK ] AuthorizationTest.PrincipalNotOfferedAnyRoleRestrictive (1 ms)
[ RUN ] AuthorizationTest.OnlySomePrincipalsRunAsSomeUsers
Using temporary directory '/tmp/AuthorizationTest_OnlySomePrincipalsRunAsSomeUsers_vS36LD'
[ OK ] AuthorizationTest.OnlySomePrincipalsRunAsSomeUsers (1 ms)
[ RUN ] AuthorizationTest.SomeClientsPUTSomeURL
Using temporary directory '/tmp/AuthorizationTest_SomeClientsPUTSomeURL_bXJfJ2'
[ OK ] AuthorizationTest.SomeClientsPUTSomeURL (1 ms)
[ RUN ] AuthorizationTest.PrincipalRunAsAnyUser
Using temporary directory '/tmp/AuthorizationTest_PrincipalRunAsAnyUser_iNsvGr'
[ OK ] AuthorizationTest.PrincipalRunAsAnyUser (0 ms)
[ RUN ] AuthorizationTest.PrincipalOfferedRole
Using temporary directory '/tmp/AuthorizationTest_PrincipalOfferedRole_JAlQDQ'
[ OK ] AuthorizationTest.PrincipalOfferedRole (1 ms)
[ RUN ] AuthorizationTest.SomeClientsCannotGETAnyURL
Using temporary directory '/tmp/AuthorizationTest_SomeClientsCannotGETAnyURL_ypziBf'
[ OK ] AuthorizationTest.SomeClientsCannotGETAnyURL (0 ms)
[ RUN ] AuthorizationTest.NoClientsCanGETPUTAnyURLRestrictive
Using temporary directory '/tmp/AuthorizationTest_NoClientsCanGETPUTAnyURLRestrictive_IeFRyE'
[ OK ] AuthorizationTest.NoClientsCanGETPUTAnyURLRestrictive (0 ms)
[ RUN ] AuthorizationTest.NoClientGETPUTSomeURL
Using temporary directory '/tmp/AuthorizationTest_NoClientGETPUTSomeURL_EJUxw3'
[ OK ] AuthorizationTest.NoClientGETPUTSomeURL (1 ms)
[ RUN ] AuthorizationTest.AnyClientGETSomeURL
Using temporary directory '/tmp/AuthorizationTest_AnyClientGETSomeURL_9z4lus'
[ OK ] AuthorizationTest.AnyClientGETSomeURL (9 ms)
[ RUN ] AuthorizationTest.NoPrincipalRunAsUser
Using temporary directory '/tmp/AuthorizationTest_NoPrincipalRunAsUser_jReJtR'
[ OK ] AuthorizationTest.NoPrincipalRunAsUser (1 ms)
[ RUN ] AuthorizationTest.AnyPrincipalRunAsAnyUser
Using temporary directory '/tmp/AuthorizationTest_AnyPrincipalRunAsAnyUser_DBvatg'
[ OK ] AuthorizationTest.AnyPrincipalRunAsAnyUser (0 ms)
[ RUN ] AuthorizationTest.SomePrincipalsOfferedRole
Using temporary directory '/tmp/AuthorizationTest_SomePrincipalsOfferedRole_TNTFsF'
[ OK ] AuthorizationTest.SomePrincipalsOfferedRole (0 ms)
[ RUN ] AuthorizationTest.AnyPrincipalOfferedRole
Using temporary directory '/tmp/AuthorizationTest_AnyPrincipalOfferedRole_Npggs4'
[ OK ] AuthorizationTest.AnyPrincipalOfferedRole (0 ms)
[ RUN ] AuthorizationTest.SomeClientsAggregatePUTRequestRestrictive
Using temporary directory '/tmp/AuthorizationTest_SomeClientsAggregatePUTRequestRestrictive_ambVrt'
[ OK ] AuthorizationTest.SomeClientsAggregatePUTRequestRestrictive (1 ms)
[----------] 17 tests from AuthorizationTest (20 ms total)
[----------] 1 test from ZooKeeper
[ RUN ] ZooKeeper.URL
[ OK ] ZooKeeper.URL (0 ms)
[----------] 1 test from ZooKeeper (0 ms total)
[----------] 5 tests from GarbageCollectorIntegrationTest
[ RUN ] GarbageCollectorIntegrationTest.Unschedule
Using temporary directory '/tmp/GarbageCollectorIntegrationTest_Unschedule_AdkJrS'
I0723 02:18:03.692968 26537 leveldb.cpp:176] Opened db in 133.957385ms
I0723 02:18:03.717591 26537 leveldb.cpp:183] Compacted db in 24.597023ms
I0723 02:18:03.717609 26537 leveldb.cpp:198] Created db iterator in 3617ns
I0723 02:18:03.717617 26537 leveldb.cpp:204] Seeked to beginning of db in 689ns
I0723 02:18:03.717622 26537 leveldb.cpp:273] Iterated through 0 keys in the db in 331ns
I0723 02:18:03.717634 26537 replica.cpp:741] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0723 02:18:03.717854 26572 recover.cpp:425] Starting replica recovery
I0723 02:18:03.717953 26572 recover.cpp:451] Replica is in EMPTY status
I0723 02:18:03.718416 26571 replica.cpp:638] Replica in EMPTY status received a broadcasted recover request
I0723 02:18:03.718639 26577 recover.cpp:188] Received a recover response from a replica in EMPTY status
I0723 02:18:03.718844 26571 recover.cpp:542] Updating replica status to STARTING
I0723 02:18:03.719818 26575 master.cpp:289] Master 20140723-021803-160088899-42310-26537 (vesta.apache.org) started on 67.195.138.9:42310
I0723 02:18:03.719876 26575 master.cpp:326] Master only allowing authenticated frameworks to register
I0723 02:18:03.719885 26575 master.cpp:331] Master only allowing authenticated slaves to register
I0723 02:18:03.719898 26575 credentials.hpp:36] Loading credentials for authentication from '/tmp/GarbageCollectorIntegrationTest_Unschedule_AdkJrS/credentials'
I0723 02:18:03.720155 26575 master.cpp:360] Authorization enabled
I0723 02:18:03.720485 26577 master.cpp:123] No whitelist given. Advertising offers for all slaves
I0723 02:18:03.720554 26574 hierarchical_allocator_process.hpp:301] Initializing hierarchical allocator process with master : master@67.195.138.9:42310
I0723 02:18:03.721925 26573 master.cpp:1129] The newly elected leader is master@67.195.138.9:42310 with id 20140723-021803-160088899-42310-26537
I0723 02:18:03.721961 26573 master.cpp:1142] Elected as the leading master!
I0723 02:18:03.721976 26573 master.cpp:960] Recovering from registrar
I0723 02:18:03.722082 26572 registrar.cpp:313] Recovering registrar
I0723 02:18:03.804371 26576 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 85.449675ms
I0723 02:18:03.804425 26576 replica.cpp:320] Persisted replica status to STARTING
I0723 02:18:03.804555 26572 recover.cpp:451] Replica is in STARTING status
I0723 02:18:03.804999 26571 replica.cpp:638] Replica in STARTING status received a broadcasted recover request
I0723 02:18:03.805147 26572 recover.cpp:188] Received a recover response from a replica in STARTING status
I0723 02:18:03.805316 26577 recover.cpp:542] Updating replica status to VOTING
I0723 02:18:03.817437 26572 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 12.062908ms
I0723 02:18:03.817482 26572 replica.cpp:320] Persisted replica status to VOTING
I0723 02:18:03.817548 26574 recover.cpp:556] Successfully joined the Paxos group
I0723 02:18:03.817648 26574 recover.cpp:440] Recover process terminated
I0723 02:18:03.817844 26577 log.cpp:656] Attempting to start the writer
I0723 02:18:03.818308 26575 replica.cpp:474] Replica received implicit promise request with proposal 1
I0723 02:18:03.827908 26575 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 9.573439ms
I0723 02:18:03.827949 26575 replica.cpp:342] Persisted promised to 1
I0723 02:18:03.828222 26571 coordinator.cpp:230] Coordinator attemping to fill missing position
I0723 02:18:03.828791 26576 replica.cpp:375] Replica received explicit promise request for position 0 with proposal 2
I0723 02:18:03.839819 26576 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 11.006555ms
I0723 02:18:03.839848 26576 replica.cpp:676] Persisted action at 0
I0723 02:18:03.840307 26576 replica.cpp:508] Replica received write request for position 0
I0723 02:18:03.840337 26576 leveldb.cpp:438] Reading position from leveldb took 15195ns
I0723 02:18:03.851794 26576 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 11.436437ms
I0723 02:18:03.851835 26576 replica.cpp:676] Persisted action at 0
I0723 02:18:03.852035 26576 replica.cpp:655] Replica received learned notice for position 0
I0723 02:18:03.861275 26576 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 9.226798ms
I0723 02:18:03.861302 26576 replica.cpp:676] Persisted action at 0
I0723 02:18:03.861311 26576 replica.cpp:661] Replica learned NOP action at position 0
I0723 02:18:03.861644 26570 log.cpp:672] Writer started with ending position 0
I0723 02:18:03.862133 26576 leveldb.cpp:438] Reading position from leveldb took 11801ns
I0723 02:18:03.863301 26576 registrar.cpp:346] Successfully fetched the registry (0B)
I0723 02:18:03.863337 26576 registrar.cpp:422] Attempting to update the 'registry'
I0723 02:18:03.864505 26571 log.cpp:680] Attempting to append 134 bytes to the log
I0723 02:18:03.864604 26574 coordinator.cpp:340] Coordinator attempting to write APPEND action at position 1
I0723 02:18:03.865085 26574 replica.cpp:508] Replica received write request for position 1
I0723 02:18:03.875722 26574 leveldb.cpp:343] Persisting action (153 bytes) to leveldb took 10.61247ms
I0723 02:18:03.875772 26574 replica.cpp:676] Persisted action at 1
I0723 02:18:03.876096 26572 replica.cpp:655] Replica received learned notice for position 1
I0723 02:18:03.885216 26572 leveldb.cpp:343] Persisting action (155 bytes) to leveldb took 9.083506ms
I0723 02:18:03.885246 26572 replica.cpp:676] Persisted action at 1
I0723 02:18:03.885257 26572 replica.cpp:661] Replica learned APPEND action at position 1
I0723 02:18:03.885717 26572 registrar.cpp:479] Successfully updated 'registry'
I0723 02:18:03.885756 26572 registrar.cpp:372] Successfully recovered registrar
I0723 02:18:03.885807 26572 log.cpp:699] Attempting to truncate the log to 1
I0723 02:18:03.885898 26572 master.cpp:987] Recovered 0 slaves from the Registry (97B) ; allowing 10mins for slaves to re-register
I0723 02:18:03.885938 26572 coordinator.cpp:340] Coordinator attempting to write TRUNCATE action at position 2
I0723 02:18:03.886354 26577 replica.cpp:508] Replica received write request for position 2
I0723 02:18:03.895622 26577 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 9.228847ms
I0723 02:18:03.895673 26577 replica.cpp:676] Persisted action at 2
I0723 02:18:03.896041 26574 replica.cpp:655] Replica received learned notice for position 2
I0723 02:18:03.905140 26574 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 9.079844ms
I0723 02:18:03.905174 26574 leveldb.cpp:401] Deleting ~1 keys from leveldb took 12410ns
I0723 02:18:03.905184 26574 replica.cpp:676] Persisted action at 2
I0723 02:18:03.905194 26574 replica.cpp:661] Replica learned TRUNCATE action at position 2
I0723 02:18:03.909507 26577 slave.cpp:169] Slave started on 1)@67.195.138.9:42310
I0723 02:18:03.909530 26577 credentials.hpp:84] Loading credential for authentication from '/tmp/GarbageCollectorIntegrationTest_Unschedule_VWsnoi/credential'
I0723 02:18:03.909673 26577 slave.cpp:267] Slave using credential for: test-principal
make[3]: *** [check-local] Segmentation fault
make[3]: Leaving directory `/home/hudson/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 `/home/hudson/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 `/home/hudson/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
Build failed in Jenkins:
Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui
#2276
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/2276/changes>
Changes:
[dhamon] Introduce script for generating test coverage report.
------------------------------------------
[...truncated 3243 lines...]
make[3]: Nothing to be done for `../../src/tests/no_executor_framework_test.sh'.
make[3]: Nothing to be done for `../../src/tests/python_framework_test.sh'.
make[3]: Nothing to be done for `../../src/tests/test_framework_test.sh'.
make[3]: Leaving directory `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/build/src'
make check-local
make[3]: Entering directory `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/build/src'
./mesos-tests
WARNING: Logging before InitGoogleLogging() is written to STDERR
I0723 20:41:34.180785 7602 process.cpp:1671] libprocess is initialized on 67.195.138.9:44555 for 8 cpus
I0723 20:41:34.180919 7602 logging.cpp:172] Logging to STDERR
Source directory: /home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui
Build directory: /home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/build
Note: Google Test filter = *-CpuIsolatorTest/1.UserCpuUsage:CpuIsolatorTest/1.SystemCpuUsage:LimitedCpuIsolatorTest.ROOT_CGROUPS_Cfs:LimitedCpuIsolatorTest.ROOT_CGROUPS_Cfs_Big_Quota:MemIsolatorTest/0.MemUsage:MemIsolatorTest/1.MemUsage:PerfEventIsolatorTest.ROOT_CGROUPS_Sample:MesosContainerizerSlaveRecoveryTest.CGROUPS_ROOT_PerfRollForward:SlaveTest.ROOT_RunTaskWithCommandInfoWithoutUser:SlaveTest.DISABLED_ROOT_RunTaskWithCommandInfoWithUser:ContainerizerTest.ROOT_CGROUPS_BalloonFramework:CgroupsAnyHierarchyTest.ROOT_CGROUPS_Enabled:CgroupsAnyHierarchyTest.ROOT_CGROUPS_Subsystems:CgroupsAnyHierarchyTest.ROOT_CGROUPS_Mounted:CgroupsAnyHierarchyTest.ROOT_CGROUPS_Get:CgroupsAnyHierarchyTest.ROOT_CGROUPS_NestedCgroups:CgroupsAnyHierarchyTest.ROOT_CGROUPS_Tasks:CgroupsAnyHierarchyTest.ROOT_CGROUPS_Read:CgroupsAnyHierarchyTest.ROOT_CGROUPS_Write:CgroupsAnyHierarchyTest.ROOT_CGROUPS_Cfs_Big_Quota:CgroupsAnyHierarchyWithCpuMemoryTest.ROOT_CGROUPS_Busy:CgroupsAnyHierarchyWithCpuMemoryTest.ROOT_CGROUPS_SubsystemsHierarchy:CgroupsAnyHierarchyWithCpuMemoryTest.ROOT_CGROUPS_MountedSubsystems:CgroupsAnyHierarchyWithCpuMemoryTest.ROOT_CGROUPS_CreateRemove:CgroupsAnyHierarchyWithCpuMemoryTest.ROOT_CGROUPS_Listen:CgroupsAnyHierarchyWithCpuMemoryTest.ROOT_CGROUPS_FreezeNonFreezer:CgroupsNoHierarchyTest.ROOT_CGROUPS_NOHIERARCHY_MountUnmountHierarchy:CgroupsAnyHierarchyWithCpuAcctMemoryTest.ROOT_CGROUPS_Stat:CgroupsAnyHierarchyWithFreezerTest.ROOT_CGROUPS_Freeze:CgroupsAnyHierarchyWithFreezerTest.ROOT_CGROUPS_Kill:CgroupsAnyHierarchyWithFreezerTest.ROOT_CGROUPS_Destroy:CgroupsAnyHierarchyWithFreezerTest.ROOT_CGROUPS_AssignThreads:CgroupsAnyHierarchyWithFreezerTest.ROOT_CGROUPS_DestroyStoppedProcess:CgroupsAnyHierarchyWithFreezerTest.ROOT_CGROUPS_DestroyTracedProcess:CgroupsAnyHierarchyWithPerfEventTest.ROOT_CGROUPS_Perf:PerfTest.ROOT_Events:PerfTest.ROOT_SampleInit:SlaveCount/Registrar_BENCHMARK_Test.performance/0:SlaveCount/Registrar_BENCHMARK_Test.performance/1:SlaveCount/Registrar_BENCHMARK_Test.performance/2:SlaveCount/Registrar_BENCHMARK_Test.performance/3:
Note: Randomizing tests' orders with a seed of 5342 .
[==========] Running 351 tests from 57 test cases.
[----------] Global test environment set-up.
[----------] 2 tests from FetcherTest
[ RUN ] FetcherTest.FileURI
Using temporary directory '/tmp/FetcherTest_FileURI_bsSDxW'
WARNING: Logging before InitGoogleLogging() is written to STDERR
I0723 20:41:36.189797 7632 fetcher.cpp:76] Fetching URI 'file:///tmp/FetcherTest_FileURI_bsSDxW/from/test'
I0723 20:41:36.189939 7632 fetcher.cpp:179] Copying resource from '/tmp/FetcherTest_FileURI_bsSDxW/from/test' to '/tmp/FetcherTest_FileURI_bsSDxW'
I0723 20:41:36.192847 7632 fetcher.cpp:255] Skipped extracting path '/tmp/FetcherTest_FileURI_bsSDxW/test'
[ OK ] FetcherTest.FileURI (2002 ms)
[ RUN ] FetcherTest.FileLocalhostURI
Using temporary directory '/tmp/FetcherTest_FileLocalhostURI_jFfGNy'
WARNING: Logging before InitGoogleLogging() is written to STDERR
I0723 20:41:36.231168 7692 fetcher.cpp:76] Fetching URI 'file://localhost/tmp/FetcherTest_FileLocalhostURI_jFfGNy/from/test'
I0723 20:41:36.231308 7692 fetcher.cpp:179] Copying resource from '/tmp/FetcherTest_FileLocalhostURI_jFfGNy/from/test' to '/tmp/FetcherTest_FileLocalhostURI_jFfGNy'
I0723 20:41:36.233958 7692 fetcher.cpp:255] Skipped extracting path '/tmp/FetcherTest_FileLocalhostURI_jFfGNy/test'
[ OK ] FetcherTest.FileLocalhostURI (1000 ms)
[----------] 2 tests from FetcherTest (3003 ms total)
[----------] 4 tests from ReplicaTest
[ RUN ] ReplicaTest.Append
Using temporary directory '/tmp/ReplicaTest_Append_cjXxMd'
I0723 20:41:37.392856 7602 leveldb.cpp:176] Opened db in 192.76022ms
I0723 20:41:37.398449 7602 leveldb.cpp:183] Compacted db in 5.537227ms
I0723 20:41:37.398475 7602 leveldb.cpp:198] Created db iterator in 10742ns
I0723 20:41:37.398486 7602 leveldb.cpp:204] Seeked to beginning of db in 839ns
I0723 20:41:37.398493 7602 leveldb.cpp:273] Iterated through 0 keys in the db in 186ns
I0723 20:41:37.398525 7602 replica.cpp:741] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0723 20:41:37.429993 7623 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 30.753919ms
I0723 20:41:37.430142 7623 replica.cpp:320] Persisted replica status to VOTING
I0723 20:41:37.521679 7602 leveldb.cpp:176] Opened db in 91.169985ms
I0723 20:41:37.577837 7602 leveldb.cpp:183] Compacted db in 56.131791ms
I0723 20:41:37.577857 7602 leveldb.cpp:198] Created db iterator in 5608ns
I0723 20:41:37.577934 7602 leveldb.cpp:204] Seeked to beginning of db in 9861ns
I0723 20:41:37.578024 7602 leveldb.cpp:273] Iterated through 1 keys in the db in 81104ns
I0723 20:41:37.578038 7602 replica.cpp:741] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0723 20:41:37.578413 7624 replica.cpp:474] Replica received implicit promise request with proposal 1
I0723 20:41:37.633237 7624 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 54.808279ms
I0723 20:41:37.633256 7624 replica.cpp:342] Persisted promised to 1
I0723 20:41:37.633610 7623 replica.cpp:508] Replica received write request for position 1
I0723 20:41:37.638181 7623 leveldb.cpp:343] Persisting action (27 bytes) to leveldb took 4.537465ms
I0723 20:41:37.638202 7623 replica.cpp:676] Persisted action at 1
I0723 20:41:37.638443 7624 leveldb.cpp:438] Reading position from leveldb took 19081ns
[ OK ] ReplicaTest.Append (440 ms)
[ RUN ] ReplicaTest.Restore
Using temporary directory '/tmp/ReplicaTest_Restore_dK6wXT'
I0723 20:41:37.711782 7602 leveldb.cpp:176] Opened db in 72.581819ms
I0723 20:41:37.719236 7602 leveldb.cpp:183] Compacted db in 7.415316ms
I0723 20:41:37.719254 7602 leveldb.cpp:198] Created db iterator in 3073ns
I0723 20:41:37.719260 7602 leveldb.cpp:204] Seeked to beginning of db in 539ns
I0723 20:41:37.719265 7602 leveldb.cpp:273] Iterated through 0 keys in the db in 280ns
I0723 20:41:37.719279 7602 replica.cpp:741] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0723 20:41:37.761906 7626 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 42.398339ms
I0723 20:41:37.761929 7626 replica.cpp:320] Persisted replica status to VOTING
I0723 20:41:37.871302 7602 leveldb.cpp:176] Opened db in 101.035992ms
I0723 20:41:37.926657 7602 leveldb.cpp:183] Compacted db in 55.312124ms
I0723 20:41:37.926679 7602 leveldb.cpp:198] Created db iterator in 6291ns
I0723 20:41:37.926695 7602 leveldb.cpp:204] Seeked to beginning of db in 9038ns
I0723 20:41:37.926717 7602 leveldb.cpp:273] Iterated through 1 keys in the db in 14820ns
I0723 20:41:37.926733 7602 replica.cpp:741] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0723 20:41:37.926915 7627 replica.cpp:474] Replica received implicit promise request with proposal 1
I0723 20:41:37.974943 7627 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 48.009792ms
I0723 20:41:37.974966 7627 replica.cpp:342] Persisted promised to 1
I0723 20:41:37.975383 7628 replica.cpp:508] Replica received write request for position 1
I0723 20:41:37.986176 7628 leveldb.cpp:343] Persisting action (27 bytes) to leveldb took 10.533857ms
I0723 20:41:37.986376 7628 replica.cpp:676] Persisted action at 1
I0723 20:41:37.986704 7629 leveldb.cpp:438] Reading position from leveldb took 20742ns
I0723 20:41:38.086813 7602 leveldb.cpp:176] Opened db in 99.961871ms
I0723 20:41:38.170034 7602 leveldb.cpp:183] Compacted db in 83.194864ms
I0723 20:41:38.170054 7602 leveldb.cpp:198] Created db iterator in 4336ns
I0723 20:41:38.170069 7602 leveldb.cpp:204] Seeked to beginning of db in 8291ns
I0723 20:41:38.170094 7602 leveldb.cpp:273] Iterated through 2 keys in the db in 17804ns
I0723 20:41:38.170127 7602 replica.cpp:741] Replica recovered with log positions 0 -> 1 with 1 holes and 1 unlearned
I0723 20:41:38.170207 7623 leveldb.cpp:438] Reading position from leveldb took 28326ns
[ OK ] ReplicaTest.Restore (531 ms)
[ RUN ] ReplicaTest.NonVoting
Using temporary directory '/tmp/ReplicaTest_NonVoting_mF0gAB'
I0723 20:41:38.254024 7602 leveldb.cpp:176] Opened db in 83.057624ms
I0723 20:41:38.262495 7602 leveldb.cpp:183] Compacted db in 8.441628ms
I0723 20:41:38.262534 7602 leveldb.cpp:198] Created db iterator in 2719ns
I0723 20:41:38.262543 7602 leveldb.cpp:204] Seeked to beginning of db in 427ns
I0723 20:41:38.262550 7602 leveldb.cpp:273] Iterated through 0 keys in the db in 183ns
I0723 20:41:38.262567 7602 replica.cpp:741] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0723 20:41:38.262745 7624 replica.cpp:369] Replica ignoring promise request as it is in EMPTY status
I0723 20:41:38.272923 7627 replica.cpp:503] Replica ignoring write request as it is in EMPTY status
[ OK ] ReplicaTest.NonVoting (113 ms)
[ RUN ] ReplicaTest.Promise
Using temporary directory '/tmp/ReplicaTest_Promise_zO8Yvj'
I0723 20:41:38.366005 7602 leveldb.cpp:176] Opened db in 82.62378ms
I0723 20:41:38.369971 7602 leveldb.cpp:183] Compacted db in 3.943546ms
I0723 20:41:38.369985 7602 leveldb.cpp:198] Created db iterator in 1937ns
I0723 20:41:38.369992 7602 leveldb.cpp:204] Seeked to beginning of db in 238ns
I0723 20:41:38.369997 7602 leveldb.cpp:273] Iterated through 0 keys in the db in 70ns
I0723 20:41:38.370007 7602 replica.cpp:741] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0723 20:41:38.405983 7629 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 35.727094ms
I0723 20:41:38.406008 7629 replica.cpp:320] Persisted replica status to VOTING
I0723 20:41:38.517551 7602 leveldb.cpp:176] Opened db in 111.263097ms
I0723 20:41:38.583976 7602 leveldb.cpp:183] Compacted db in 66.398598ms
I0723 20:41:38.583997 7602 leveldb.cpp:198] Created db iterator in 4577ns
I0723 20:41:38.584012 7602 leveldb.cpp:204] Seeked to beginning of db in 7331ns
I0723 20:41:38.584027 7602 leveldb.cpp:273] Iterated through 1 keys in the db in 8411ns
I0723 20:41:38.584038 7602 replica.cpp:741] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0723 20:41:38.584170 7627 replica.cpp:474] Replica received implicit promise request with proposal 2
I0723 20:41:38.609194 7627 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 25.013248ms
I0723 20:41:38.609211 7627 replica.cpp:342] Persisted promised to 2
I0723 20:41:38.609426 7627 replica.cpp:474] Replica received implicit promise request with proposal 1
I0723 20:41:38.609441 7627 replica.cpp:479] Replica denying promise request with proposal 1
I0723 20:41:38.609570 7627 replica.cpp:474] Replica received implicit promise request with proposal 3
I0723 20:41:38.612043 7627 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 2.456493ms
I0723 20:41:38.612061 7627 replica.cpp:342] Persisted promised to 3
[ OK ] ReplicaTest.Promise (331 ms)
[----------] 4 tests from ReplicaTest (1415 ms total)
[----------] 12 tests from AllocatorTest/0, where TypeParam = mesos::internal::master::allocator::HierarchicalAllocatorProcess<mesos::internal::master::allocator::DRFSorter, mesos::internal::master::allocator::DRFSorter>
[ RUN ] AllocatorTest/0.FrameworkReregistersFirst
Using temporary directory '/tmp/AllocatorTest_0_FrameworkReregistersFirst_YGWDl2'
I0723 20:41:38.729573 7602 leveldb.cpp:176] Opened db in 113.266154ms
I0723 20:41:38.737884 7602 leveldb.cpp:183] Compacted db in 8.291555ms
I0723 20:41:38.737901 7602 leveldb.cpp:198] Created db iterator in 2686ns
I0723 20:41:38.737908 7602 leveldb.cpp:204] Seeked to beginning of db in 427ns
I0723 20:41:38.737913 7602 leveldb.cpp:273] Iterated through 0 keys in the db in 60ns
I0723 20:41:38.737922 7602 replica.cpp:741] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0723 20:41:38.738248 7624 recover.cpp:425] Starting replica recovery
I0723 20:41:38.738363 7624 recover.cpp:451] Replica is in EMPTY status
I0723 20:41:38.738755 7628 replica.cpp:638] Replica in EMPTY status received a broadcasted recover request
I0723 20:41:38.738986 7622 recover.cpp:188] Received a recover response from a replica in EMPTY status
I0723 20:41:38.739104 7624 recover.cpp:542] Updating replica status to STARTING
I0723 20:41:38.741025 7627 master.cpp:289] Master 20140723-204138-160088899-44555-7602 (vesta.apache.org) started on 67.195.138.9:44555
I0723 20:41:38.741078 7627 master.cpp:326] Master only allowing authenticated frameworks to register
I0723 20:41:38.741092 7627 master.cpp:331] Master only allowing authenticated slaves to register
I0723 20:41:38.741107 7627 credentials.hpp:36] Loading credentials for authentication from '/tmp/AllocatorTest_0_FrameworkReregistersFirst_YGWDl2/credentials'
I0723 20:41:38.741339 7627 master.cpp:360] Authorization enabled
I0723 20:41:38.741636 7626 master.cpp:123] No whitelist given. Advertising offers for all slaves
I0723 20:41:38.742012 7626 hierarchical_allocator_process.hpp:301] Initializing hierarchical allocator process with master : master@67.195.138.9:44555
I0723 20:41:38.743131 7628 master.cpp:1129] The newly elected leader is master@67.195.138.9:44555 with id 20140723-204138-160088899-44555-7602
I0723 20:41:38.743186 7628 master.cpp:1142] Elected as the leading master!
I0723 20:41:38.743197 7628 master.cpp:960] Recovering from registrar
I0723 20:41:38.743340 7626 registrar.cpp:313] Recovering registrar
I0723 20:41:38.792685 7622 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 53.531522ms
I0723 20:41:38.792709 7622 replica.cpp:320] Persisted replica status to STARTING
I0723 20:41:38.792816 7622 recover.cpp:451] Replica is in STARTING status
I0723 20:41:38.793200 7627 replica.cpp:638] Replica in STARTING status received a broadcasted recover request
I0723 20:41:38.793365 7622 recover.cpp:188] Received a recover response from a replica in STARTING status
I0723 20:41:38.793516 7624 recover.cpp:542] Updating replica status to VOTING
I0723 20:41:38.803375 7622 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 9.803524ms
I0723 20:41:38.803395 7622 replica.cpp:320] Persisted replica status to VOTING
I0723 20:41:38.803431 7624 recover.cpp:556] Successfully joined the Paxos group
I0723 20:41:38.803519 7624 recover.cpp:440] Recover process terminated
I0723 20:41:38.803635 7624 log.cpp:656] Attempting to start the writer
I0723 20:41:38.804036 7626 replica.cpp:474] Replica received implicit promise request with proposal 1
I0723 20:41:38.811331 7626 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 7.280405ms
I0723 20:41:38.811347 7626 replica.cpp:342] Persisted promised to 1
I0723 20:41:38.811569 7626 coordinator.cpp:230] Coordinator attemping to fill missing position
I0723 20:41:38.811959 7626 replica.cpp:375] Replica received explicit promise request for position 0 with proposal 2
I0723 20:41:38.819311 7626 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 7.340818ms
I0723 20:41:38.819325 7626 replica.cpp:676] Persisted action at 0
I0723 20:41:38.819623 7626 replica.cpp:508] Replica received write request for position 0
I0723 20:41:38.819654 7626 leveldb.cpp:438] Reading position from leveldb took 11572ns
I0723 20:41:38.827287 7626 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 7.617985ms
I0723 20:41:38.827299 7626 replica.cpp:676] Persisted action at 0
I0723 20:41:38.827437 7626 replica.cpp:655] Replica received learned notice for position 0
I0723 20:41:38.835260 7626 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 7.81183ms
I0723 20:41:38.835274 7626 replica.cpp:676] Persisted action at 0
I0723 20:41:38.835280 7626 replica.cpp:661] Replica learned NOP action at position 0
I0723 20:41:38.835441 7626 log.cpp:672] Writer started with ending position 0
I0723 20:41:38.835790 7627 leveldb.cpp:438] Reading position from leveldb took 8273ns
I0723 20:41:38.836839 7627 registrar.cpp:346] Successfully fetched the registry (0B)
I0723 20:41:38.836865 7627 registrar.cpp:422] Attempting to update the 'registry'
I0723 20:41:38.837831 7627 log.cpp:680] Attempting to append 133 bytes to the log
I0723 20:41:38.838012 7623 coordinator.cpp:340] Coordinator attempting to write APPEND action at position 1
I0723 20:41:38.838230 7622 replica.cpp:508] Replica received write request for position 1
I0723 20:41:38.846289 7622 leveldb.cpp:343] Persisting action (152 bytes) to leveldb took 8.046888ms
I0723 20:41:38.846304 7622 replica.cpp:676] Persisted action at 1
I0723 20:41:38.846472 7622 replica.cpp:655] Replica received learned notice for position 1
I0723 20:41:38.855198 7622 leveldb.cpp:343] Persisting action (154 bytes) to leveldb took 8.716858ms
I0723 20:41:38.855213 7622 replica.cpp:676] Persisted action at 1
I0723 20:41:38.855219 7622 replica.cpp:661] Replica learned APPEND action at position 1
I0723 20:41:38.855494 7622 registrar.cpp:479] Successfully updated 'registry'
I0723 20:41:38.855525 7622 registrar.cpp:372] Successfully recovered registrar
I0723 20:41:38.855566 7622 log.cpp:699] Attempting to truncate the log to 1
I0723 20:41:38.855633 7622 master.cpp:987] Recovered 0 slaves from the Registry (96B) ; allowing 10mins for slaves to re-register
I0723 20:41:38.855667 7622 coordinator.cpp:340] Coordinator attempting to write TRUNCATE action at position 2
I0723 20:41:38.855885 7622 replica.cpp:508] Replica received write request for position 2
I0723 20:41:38.863175 7622 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 7.27886ms
I0723 20:41:38.863189 7622 replica.cpp:676] Persisted action at 2
I0723 20:41:38.863441 7622 replica.cpp:655] Replica received learned notice for position 2
I0723 20:41:38.871152 7622 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 7.679621ms
I0723 20:41:38.871196 7622 leveldb.cpp:401] Deleting ~1 keys from leveldb took 21987ns
I0723 20:41:38.871211 7622 replica.cpp:676] Persisted action at 2
I0723 20:41:38.871222 7622 replica.cpp:661] Replica learned TRUNCATE action at position 2
I0723 20:41:38.878340 7625 slave.cpp:169] Slave started on 1)@67.195.138.9:44555
I0723 20:41:38.878366 7625 credentials.hpp:84] Loading credential for authentication from '/tmp/AllocatorTest_0_FrameworkReregistersFirst_pANATL/credential'
I0723 20:41:38.878479 7625 slave.cpp:267] Slave using credential for: test-principal
I0723 20:41:38.881353 7602 sched.cpp:139] Version: 0.20.0
I0723 20:41:38.881719 7629 sched.cpp:235] New master detected at master@67.195.138.9:44555
I0723 20:41:38.881737 7629 sched.cpp:285] Authenticating with master master@67.195.138.9:44555
I0723 20:41:38.881927 7629 authenticatee.hpp:104] Initializing client SASL
I0723 20:41:38.955685 7629 authenticatee.hpp:128] Creating new client SASL connection
I0723 20:41:38.955989 7626 master.cpp:3504] Authenticating scheduler-08f6ee81-f9ef-4cb0-95a5-024393f309d5@67.195.138.9:44555
I0723 20:41:38.956110 7622 authenticator.hpp:94] Initializing server SASL
I0723 20:41:38.956333 7622 auxprop.cpp:45] Initialized in-memory auxiliary property plugin
I0723 20:41:38.956349 7622 authenticator.hpp:156] Creating new server SASL connection
I0723 20:41:38.956426 7626 authenticatee.hpp:219] Received SASL authentication mechanisms: CRAM-MD5
I0723 20:41:38.956444 7626 authenticatee.hpp:245] Attempting to authenticate with mechanism 'CRAM-MD5'
I0723 20:41:38.956480 7626 authenticator.hpp:262] Received SASL authentication start
I0723 20:41:38.956522 7626 authenticator.hpp:384] Authentication requires more steps
I0723 20:41:38.956553 7626 authenticatee.hpp:265] Received SASL authentication step
I0723 20:41:38.956614 7626 authenticator.hpp:290] Received SASL authentication step
I0723 20:41:38.956635 7626 auxprop.cpp:81] Request to lookup properties for user: 'test-principal' realm: 'vesta.apache.org' server FQDN: 'vesta.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0723 20:41:38.956645 7626 auxprop.cpp:153] Looking up auxiliary property '*userPassword'
I0723 20:41:38.956660 7626 auxprop.cpp:153] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0723 20:41:38.956670 7626 auxprop.cpp:81] Request to lookup properties for user: 'test-principal' realm: 'vesta.apache.org' server FQDN: 'vesta.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0723 20:41:38.956677 7626 auxprop.cpp:103] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0723 20:41:38.956683 7626 auxprop.cpp:103] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0723 20:41:38.956696 7626 authenticator.hpp:376] Authentication success
I0723 20:41:38.956723 7626 authenticatee.hpp:305] Authentication success
I0723 20:41:38.956755 7626 master.cpp:3544] Successfully authenticated principal 'test-principal' at scheduler-08f6ee81-f9ef-4cb0-95a5-024393f309d5@67.195.138.9:44555
I0723 20:41:38.956847 7626 sched.cpp:359] Successfully authenticated with master master@67.195.138.9:44555
I0723 20:41:38.956864 7626 sched.cpp:478] Sending registration request to master@67.195.138.9:44555
I0723 20:41:38.956946 7622 master.cpp:1248] Received registration request from scheduler-08f6ee81-f9ef-4cb0-95a5-024393f309d5@67.195.138.9:44555
I0723 20:41:38.956977 7622 master.cpp:1208] Authorizing framework principal 'test-principal' to receive offers for role '*'
I0723 20:41:38.957208 7622 master.cpp:1307] Registering framework 20140723-204138-160088899-44555-7602-0000 at scheduler-08f6ee81-f9ef-4cb0-95a5-024393f309d5@67.195.138.9:44555
I0723 20:41:38.957309 7624 sched.cpp:409] Framework registered with 20140723-204138-160088899-44555-7602-0000
I0723 20:41:38.957355 7624 sched.cpp:423] Scheduler::registered took 31333ns
I0723 20:41:38.957490 7624 hierarchical_allocator_process.hpp:331] Added framework 20140723-204138-160088899-44555-7602-0000
I0723 20:41:38.957506 7624 hierarchical_allocator_process.hpp:724] No resources available to allocate!
I0723 20:41:38.957516 7624 hierarchical_allocator_process.hpp:686] Performed allocation for 0 slaves in 14041ns
make[3]: *** [check-local] Segmentation fault
make[3]: Leaving directory `/home/hudson/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 `/home/hudson/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 `/home/hudson/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
Re: Build failed in Jenkins: Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui
#2275
Posted by Yan Xu <ya...@jxu.me>.
Filed https://issues.apache.org/jira/browse/MESOS-1632
--
Jiang Yan Xu <ya...@jxu.me> @xujyan <http://twitter.com/xujyan>
On Tue, Jul 22, 2014 at 7:18 PM, Apache Jenkins Server <
jenkins@builds.apache.org> wrote:
> See <
> https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/2275/changes
> >
>
> Changes:
>
> [benjamin.hindman] More docs for attributes and resources.
>
> [benjamin.hindman] Removed trailing '/' in Makefile.am.
>
> ------------------------------------------
> [...truncated 3341 lines...]
> I0723 02:18:01.662987 26575 log.cpp:672] Writer started with ending
> position 0
> I0723 02:18:01.663213 26576 log.cpp:680] Attempting to append 11 bytes to
> the log
> I0723 02:18:01.663368 26576 coordinator.cpp:340] Coordinator attempting to
> write APPEND action at position 1
> I0723 02:18:01.663586 26576 replica.cpp:508] Replica received write
> request for position 1
> I0723 02:18:01.663589 26575 replica.cpp:508] Replica received write
> request for position 1
> I0723 02:18:01.670192 26576 leveldb.cpp:343] Persisting action (27 bytes)
> to leveldb took 6.582697ms
> I0723 02:18:01.670217 26576 replica.cpp:676] Persisted action at 1
> I0723 02:18:01.674784 26575 leveldb.cpp:343] Persisting action (27 bytes)
> to leveldb took 11.146285ms
> I0723 02:18:01.674808 26575 replica.cpp:676] Persisted action at 1
> I0723 02:18:01.675060 26573 replica.cpp:655] Replica received learned
> notice for position 1
> I0723 02:18:01.675065 26575 replica.cpp:655] Replica received learned
> notice for position 1
> I0723 02:18:01.694130 26575 leveldb.cpp:343] Persisting action (29 bytes)
> to leveldb took 19.03493ms
> I0723 02:18:01.694154 26575 replica.cpp:676] Persisted action at 1
> I0723 02:18:01.694160 26575 replica.cpp:661] Replica learned APPEND action
> at position 1
> I0723 02:18:01.698678 26573 leveldb.cpp:343] Persisting action (29 bytes)
> to leveldb took 23.526821ms
> I0723 02:18:01.698709 26573 replica.cpp:676] Persisted action at 1
> I0723 02:18:01.698719 26573 replica.cpp:661] Replica learned APPEND action
> at position 1
> I0723 02:18:01.699117 26573 leveldb.cpp:438] Reading position from leveldb
> took 20227ns
> [ OK ] LogTest.WriteRead (6624 ms)
> [ RUN ] LogTest.Position
> Using temporary directory '/tmp/LogTest_Position_f1Gu2C'
> I0723 02:18:02.097327 26537 leveldb.cpp:176] Opened db in 388.612848ms
> I0723 02:18:02.167786 26537 leveldb.cpp:183] Compacted db in 70.388284ms
> I0723 02:18:02.167856 26537 leveldb.cpp:198] Created db iterator in 6243ns
> I0723 02:18:02.167865 26537 leveldb.cpp:204] Seeked to beginning of db in
> 1091ns
> I0723 02:18:02.167870 26537 leveldb.cpp:273] Iterated through 0 keys in
> the db in 180ns
> I0723 02:18:02.167889 26537 replica.cpp:741] Replica recovered with log
> positions 0 -> 0 with 1 holes and 0 unlearned
> I0723 02:18:02.267482 26572 leveldb.cpp:306] Persisting metadata (8 bytes)
> to leveldb took 99.236386ms
> I0723 02:18:02.267544 26572 replica.cpp:320] Persisted replica status to
> VOTING
> I0723 02:18:02.596209 26537 leveldb.cpp:176] Opened db in 328.373722ms
> I0723 02:18:02.602221 26537 leveldb.cpp:183] Compacted db in 5.951668ms
> I0723 02:18:02.602241 26537 leveldb.cpp:198] Created db iterator in 5563ns
> I0723 02:18:02.602249 26537 leveldb.cpp:204] Seeked to beginning of db in
> 998ns
> I0723 02:18:02.602254 26537 leveldb.cpp:273] Iterated through 0 keys in
> the db in 273ns
> I0723 02:18:02.602273 26537 replica.cpp:741] Replica recovered with log
> positions 0 -> 0 with 1 holes and 0 unlearned
> I0723 02:18:02.698930 26571 leveldb.cpp:306] Persisting metadata (8 bytes)
> to leveldb took 96.484534ms
> I0723 02:18:02.698979 26571 replica.cpp:320] Persisted replica status to
> VOTING
> I0723 02:18:02.990617 26537 leveldb.cpp:176] Opened db in 291.334119ms
> I0723 02:18:03.214690 26537 leveldb.cpp:183] Compacted db in 224.005865ms
> I0723 02:18:03.214766 26537 leveldb.cpp:198] Created db iterator in 8941ns
> I0723 02:18:03.214792 26537 leveldb.cpp:204] Seeked to beginning of db in
> 17424ns
> I0723 02:18:03.214818 26537 leveldb.cpp:273] Iterated through 1 keys in
> the db in 18525ns
> I0723 02:18:03.214835 26537 replica.cpp:741] Replica recovered with log
> positions 0 -> 0 with 1 holes and 0 unlearned
> I0723 02:18:03.338562 26537 leveldb.cpp:176] Opened db in 123.631516ms
> I0723 02:18:03.438832 26537 leveldb.cpp:183] Compacted db in 100.201161ms
> I0723 02:18:03.438909 26537 leveldb.cpp:198] Created db iterator in 9154ns
> I0723 02:18:03.438935 26537 leveldb.cpp:204] Seeked to beginning of db in
> 16789ns
> I0723 02:18:03.438961 26537 leveldb.cpp:273] Iterated through 1 keys in
> the db in 19072ns
> I0723 02:18:03.438978 26537 replica.cpp:741] Replica recovered with log
> positions 0 -> 0 with 1 holes and 0 unlearned
> I0723 02:18:03.439287 26571 recover.cpp:425] Starting replica recovery
> I0723 02:18:03.439410 26570 recover.cpp:451] Replica is in VOTING status
> I0723 02:18:03.439450 26570 recover.cpp:440] Recover process terminated
> I0723 02:18:03.439537 26574 log.cpp:656] Attempting to start the writer
> I0723 02:18:03.439862 26571 replica.cpp:474] Replica received implicit
> promise request with proposal 1
> I0723 02:18:03.439889 26574 replica.cpp:474] Replica received implicit
> promise request with proposal 1
> I0723 02:18:03.478307 26574 leveldb.cpp:306] Persisting metadata (8 bytes)
> to leveldb took 38.407423ms
> I0723 02:18:03.478343 26574 replica.cpp:342] Persisted promised to 1
> I0723 02:18:03.478312 26571 leveldb.cpp:306] Persisting metadata (8 bytes)
> to leveldb took 38.43023ms
> I0723 02:18:03.478410 26571 replica.cpp:342] Persisted promised to 1
> I0723 02:18:03.478560 26575 coordinator.cpp:230] Coordinator attemping to
> fill missing position
> I0723 02:18:03.478862 26575 replica.cpp:375] Replica received explicit
> promise request for position 0 with proposal 2
> I0723 02:18:03.478924 26573 replica.cpp:375] Replica received explicit
> promise request for position 0 with proposal 2
> I0723 02:18:03.486047 26575 leveldb.cpp:343] Persisting action (8 bytes)
> to leveldb took 7.168093ms
> I0723 02:18:03.486062 26575 replica.cpp:676] Persisted action at 0
> I0723 02:18:03.489328 26573 leveldb.cpp:343] Persisting action (8 bytes)
> to leveldb took 10.395741ms
> I0723 02:18:03.489343 26573 replica.cpp:676] Persisted action at 0
> I0723 02:18:03.489614 26571 replica.cpp:508] Replica received write
> request for position 0
> I0723 02:18:03.489635 26571 leveldb.cpp:438] Reading position from leveldb
> took 12132ns
> I0723 02:18:03.489682 26575 replica.cpp:508] Replica received write
> request for position 0
> I0723 02:18:03.489696 26575 leveldb.cpp:438] Reading position from leveldb
> took 5497ns
> I0723 02:18:03.494011 26571 leveldb.cpp:343] Persisting action (14 bytes)
> to leveldb took 4.363825ms
> I0723 02:18:03.494025 26571 replica.cpp:676] Persisted action at 0
> I0723 02:18:03.501297 26575 leveldb.cpp:343] Persisting action (14 bytes)
> to leveldb took 11.592193ms
> I0723 02:18:03.501312 26575 replica.cpp:676] Persisted action at 0
> I0723 02:18:03.501391 26575 replica.cpp:655] Replica received learned
> notice for position 0
> I0723 02:18:03.501438 26571 replica.cpp:655] Replica received learned
> notice for position 0
> I0723 02:18:03.505978 26575 leveldb.cpp:343] Persisting action (16 bytes)
> to leveldb took 4.575988ms
> I0723 02:18:03.505992 26575 replica.cpp:676] Persisted action at 0
> I0723 02:18:03.506000 26575 replica.cpp:661] Replica learned NOP action at
> position 0
> I0723 02:18:03.510304 26571 leveldb.cpp:343] Persisting action (16 bytes)
> to leveldb took 8.856383ms
> I0723 02:18:03.510318 26571 replica.cpp:676] Persisted action at 0
> I0723 02:18:03.510324 26571 replica.cpp:661] Replica learned NOP action at
> position 0
> I0723 02:18:03.510417 26571 log.cpp:672] Writer started with ending
> position 0
> I0723 02:18:03.510565 26571 log.cpp:680] Attempting to append 11 bytes to
> the log
> I0723 02:18:03.510615 26571 coordinator.cpp:340] Coordinator attempting to
> write APPEND action at position 1
> I0723 02:18:03.510784 26571 replica.cpp:508] Replica received write
> request for position 1
> I0723 02:18:03.510843 26576 replica.cpp:508] Replica received write
> request for position 1
> I0723 02:18:03.513939 26571 leveldb.cpp:343] Persisting action (27 bytes)
> to leveldb took 3.143922ms
> I0723 02:18:03.513967 26571 replica.cpp:676] Persisted action at 1
> I0723 02:18:03.522253 26576 leveldb.cpp:343] Persisting action (27 bytes)
> to leveldb took 11.398334ms
> I0723 02:18:03.522269 26576 replica.cpp:676] Persisted action at 1
> I0723 02:18:03.522400 26576 replica.cpp:655] Replica received learned
> notice for position 1
> I0723 02:18:03.522457 26571 replica.cpp:655] Replica received learned
> notice for position 1
> I0723 02:18:03.525913 26576 leveldb.cpp:343] Persisting action (29 bytes)
> to leveldb took 3.503837ms
> I0723 02:18:03.525928 26576 replica.cpp:676] Persisted action at 1
> I0723 02:18:03.525934 26576 replica.cpp:661] Replica learned APPEND action
> at position 1
> I0723 02:18:03.537183 26571 leveldb.cpp:343] Persisting action (29 bytes)
> to leveldb took 14.716382ms
> I0723 02:18:03.537199 26571 replica.cpp:676] Persisted action at 1
> I0723 02:18:03.537205 26571 replica.cpp:661] Replica learned APPEND action
> at position 1
> [ OK ] LogTest.Position (1838 ms)
> [----------] 2 tests from LogTest (8462 ms total)
>
> [----------] 17 tests from AuthorizationTest
> [ RUN ] AuthorizationTest.AnyPrincipalRunAsUser
> Using temporary directory
> '/tmp/AuthorizationTest_AnyPrincipalRunAsUser_rnTXY1'
> [ OK ] AuthorizationTest.AnyPrincipalRunAsUser (1 ms)
> [ RUN ] AuthorizationTest.SomePrincipalOnlySomeUser
> Using temporary directory
> '/tmp/AuthorizationTest_SomePrincipalOnlySomeUser_0nczVq'
> [ OK ] AuthorizationTest.SomePrincipalOnlySomeUser (0 ms)
> [ RUN ] AuthorizationTest.PrincipalRunAsSomeUserRestrictive
> Using temporary directory
> '/tmp/AuthorizationTest_PrincipalRunAsSomeUserRestrictive_sfAhSP'
> [ OK ] AuthorizationTest.PrincipalRunAsSomeUserRestrictive (0 ms)
> [ RUN ] AuthorizationTest.PrincipalNotOfferedAnyRoleRestrictive
> Using temporary directory
> '/tmp/AuthorizationTest_PrincipalNotOfferedAnyRoleRestrictive_YVO7Oe'
> [ OK ] AuthorizationTest.PrincipalNotOfferedAnyRoleRestrictive (1 ms)
> [ RUN ] AuthorizationTest.OnlySomePrincipalsRunAsSomeUsers
> Using temporary directory
> '/tmp/AuthorizationTest_OnlySomePrincipalsRunAsSomeUsers_vS36LD'
> [ OK ] AuthorizationTest.OnlySomePrincipalsRunAsSomeUsers (1 ms)
> [ RUN ] AuthorizationTest.SomeClientsPUTSomeURL
> Using temporary directory
> '/tmp/AuthorizationTest_SomeClientsPUTSomeURL_bXJfJ2'
> [ OK ] AuthorizationTest.SomeClientsPUTSomeURL (1 ms)
> [ RUN ] AuthorizationTest.PrincipalRunAsAnyUser
> Using temporary directory
> '/tmp/AuthorizationTest_PrincipalRunAsAnyUser_iNsvGr'
> [ OK ] AuthorizationTest.PrincipalRunAsAnyUser (0 ms)
> [ RUN ] AuthorizationTest.PrincipalOfferedRole
> Using temporary directory
> '/tmp/AuthorizationTest_PrincipalOfferedRole_JAlQDQ'
> [ OK ] AuthorizationTest.PrincipalOfferedRole (1 ms)
> [ RUN ] AuthorizationTest.SomeClientsCannotGETAnyURL
> Using temporary directory
> '/tmp/AuthorizationTest_SomeClientsCannotGETAnyURL_ypziBf'
> [ OK ] AuthorizationTest.SomeClientsCannotGETAnyURL (0 ms)
> [ RUN ] AuthorizationTest.NoClientsCanGETPUTAnyURLRestrictive
> Using temporary directory
> '/tmp/AuthorizationTest_NoClientsCanGETPUTAnyURLRestrictive_IeFRyE'
> [ OK ] AuthorizationTest.NoClientsCanGETPUTAnyURLRestrictive (0 ms)
> [ RUN ] AuthorizationTest.NoClientGETPUTSomeURL
> Using temporary directory
> '/tmp/AuthorizationTest_NoClientGETPUTSomeURL_EJUxw3'
> [ OK ] AuthorizationTest.NoClientGETPUTSomeURL (1 ms)
> [ RUN ] AuthorizationTest.AnyClientGETSomeURL
> Using temporary directory
> '/tmp/AuthorizationTest_AnyClientGETSomeURL_9z4lus'
> [ OK ] AuthorizationTest.AnyClientGETSomeURL (9 ms)
> [ RUN ] AuthorizationTest.NoPrincipalRunAsUser
> Using temporary directory
> '/tmp/AuthorizationTest_NoPrincipalRunAsUser_jReJtR'
> [ OK ] AuthorizationTest.NoPrincipalRunAsUser (1 ms)
> [ RUN ] AuthorizationTest.AnyPrincipalRunAsAnyUser
> Using temporary directory
> '/tmp/AuthorizationTest_AnyPrincipalRunAsAnyUser_DBvatg'
> [ OK ] AuthorizationTest.AnyPrincipalRunAsAnyUser (0 ms)
> [ RUN ] AuthorizationTest.SomePrincipalsOfferedRole
> Using temporary directory
> '/tmp/AuthorizationTest_SomePrincipalsOfferedRole_TNTFsF'
> [ OK ] AuthorizationTest.SomePrincipalsOfferedRole (0 ms)
> [ RUN ] AuthorizationTest.AnyPrincipalOfferedRole
> Using temporary directory
> '/tmp/AuthorizationTest_AnyPrincipalOfferedRole_Npggs4'
> [ OK ] AuthorizationTest.AnyPrincipalOfferedRole (0 ms)
> [ RUN ] AuthorizationTest.SomeClientsAggregatePUTRequestRestrictive
> Using temporary directory
> '/tmp/AuthorizationTest_SomeClientsAggregatePUTRequestRestrictive_ambVrt'
> [ OK ] AuthorizationTest.SomeClientsAggregatePUTRequestRestrictive
> (1 ms)
> [----------] 17 tests from AuthorizationTest (20 ms total)
>
> [----------] 1 test from ZooKeeper
> [ RUN ] ZooKeeper.URL
> [ OK ] ZooKeeper.URL (0 ms)
> [----------] 1 test from ZooKeeper (0 ms total)
>
> [----------] 5 tests from GarbageCollectorIntegrationTest
> [ RUN ] GarbageCollectorIntegrationTest.Unschedule
> Using temporary directory
> '/tmp/GarbageCollectorIntegrationTest_Unschedule_AdkJrS'
> I0723 02:18:03.692968 26537 leveldb.cpp:176] Opened db in 133.957385ms
> I0723 02:18:03.717591 26537 leveldb.cpp:183] Compacted db in 24.597023ms
> I0723 02:18:03.717609 26537 leveldb.cpp:198] Created db iterator in 3617ns
> I0723 02:18:03.717617 26537 leveldb.cpp:204] Seeked to beginning of db in
> 689ns
> I0723 02:18:03.717622 26537 leveldb.cpp:273] Iterated through 0 keys in
> the db in 331ns
> I0723 02:18:03.717634 26537 replica.cpp:741] Replica recovered with log
> positions 0 -> 0 with 1 holes and 0 unlearned
> I0723 02:18:03.717854 26572 recover.cpp:425] Starting replica recovery
> I0723 02:18:03.717953 26572 recover.cpp:451] Replica is in EMPTY status
> I0723 02:18:03.718416 26571 replica.cpp:638] Replica in EMPTY status
> received a broadcasted recover request
> I0723 02:18:03.718639 26577 recover.cpp:188] Received a recover response
> from a replica in EMPTY status
> I0723 02:18:03.718844 26571 recover.cpp:542] Updating replica status to
> STARTING
> I0723 02:18:03.719818 26575 master.cpp:289] Master
> 20140723-021803-160088899-42310-26537 (vesta.apache.org) started on
> 67.195.138.9:42310
> I0723 02:18:03.719876 26575 master.cpp:326] Master only allowing
> authenticated frameworks to register
> I0723 02:18:03.719885 26575 master.cpp:331] Master only allowing
> authenticated slaves to register
> I0723 02:18:03.719898 26575 credentials.hpp:36] Loading credentials for
> authentication from
> '/tmp/GarbageCollectorIntegrationTest_Unschedule_AdkJrS/credentials'
> I0723 02:18:03.720155 26575 master.cpp:360] Authorization enabled
> I0723 02:18:03.720485 26577 master.cpp:123] No whitelist given.
> Advertising offers for all slaves
> I0723 02:18:03.720554 26574 hierarchical_allocator_process.hpp:301]
> Initializing hierarchical allocator process with master :
> master@67.195.138.9:42310
> I0723 02:18:03.721925 26573 master.cpp:1129] The newly elected leader is
> master@67.195.138.9:42310 with id 20140723-021803-160088899-42310-26537
> I0723 02:18:03.721961 26573 master.cpp:1142] Elected as the leading master!
> I0723 02:18:03.721976 26573 master.cpp:960] Recovering from registrar
> I0723 02:18:03.722082 26572 registrar.cpp:313] Recovering registrar
> I0723 02:18:03.804371 26576 leveldb.cpp:306] Persisting metadata (8 bytes)
> to leveldb took 85.449675ms
> I0723 02:18:03.804425 26576 replica.cpp:320] Persisted replica status to
> STARTING
> I0723 02:18:03.804555 26572 recover.cpp:451] Replica is in STARTING status
> I0723 02:18:03.804999 26571 replica.cpp:638] Replica in STARTING status
> received a broadcasted recover request
> I0723 02:18:03.805147 26572 recover.cpp:188] Received a recover response
> from a replica in STARTING status
> I0723 02:18:03.805316 26577 recover.cpp:542] Updating replica status to
> VOTING
> I0723 02:18:03.817437 26572 leveldb.cpp:306] Persisting metadata (8 bytes)
> to leveldb took 12.062908ms
> I0723 02:18:03.817482 26572 replica.cpp:320] Persisted replica status to
> VOTING
> I0723 02:18:03.817548 26574 recover.cpp:556] Successfully joined the Paxos
> group
> I0723 02:18:03.817648 26574 recover.cpp:440] Recover process terminated
> I0723 02:18:03.817844 26577 log.cpp:656] Attempting to start the writer
> I0723 02:18:03.818308 26575 replica.cpp:474] Replica received implicit
> promise request with proposal 1
> I0723 02:18:03.827908 26575 leveldb.cpp:306] Persisting metadata (8 bytes)
> to leveldb took 9.573439ms
> I0723 02:18:03.827949 26575 replica.cpp:342] Persisted promised to 1
> I0723 02:18:03.828222 26571 coordinator.cpp:230] Coordinator attemping to
> fill missing position
> I0723 02:18:03.828791 26576 replica.cpp:375] Replica received explicit
> promise request for position 0 with proposal 2
> I0723 02:18:03.839819 26576 leveldb.cpp:343] Persisting action (8 bytes)
> to leveldb took 11.006555ms
> I0723 02:18:03.839848 26576 replica.cpp:676] Persisted action at 0
> I0723 02:18:03.840307 26576 replica.cpp:508] Replica received write
> request for position 0
> I0723 02:18:03.840337 26576 leveldb.cpp:438] Reading position from leveldb
> took 15195ns
> I0723 02:18:03.851794 26576 leveldb.cpp:343] Persisting action (14 bytes)
> to leveldb took 11.436437ms
> I0723 02:18:03.851835 26576 replica.cpp:676] Persisted action at 0
> I0723 02:18:03.852035 26576 replica.cpp:655] Replica received learned
> notice for position 0
> I0723 02:18:03.861275 26576 leveldb.cpp:343] Persisting action (16 bytes)
> to leveldb took 9.226798ms
> I0723 02:18:03.861302 26576 replica.cpp:676] Persisted action at 0
> I0723 02:18:03.861311 26576 replica.cpp:661] Replica learned NOP action at
> position 0
> I0723 02:18:03.861644 26570 log.cpp:672] Writer started with ending
> position 0
> I0723 02:18:03.862133 26576 leveldb.cpp:438] Reading position from leveldb
> took 11801ns
> I0723 02:18:03.863301 26576 registrar.cpp:346] Successfully fetched the
> registry (0B)
> I0723 02:18:03.863337 26576 registrar.cpp:422] Attempting to update the
> 'registry'
> I0723 02:18:03.864505 26571 log.cpp:680] Attempting to append 134 bytes to
> the log
> I0723 02:18:03.864604 26574 coordinator.cpp:340] Coordinator attempting to
> write APPEND action at position 1
> I0723 02:18:03.865085 26574 replica.cpp:508] Replica received write
> request for position 1
> I0723 02:18:03.875722 26574 leveldb.cpp:343] Persisting action (153 bytes)
> to leveldb took 10.61247ms
> I0723 02:18:03.875772 26574 replica.cpp:676] Persisted action at 1
> I0723 02:18:03.876096 26572 replica.cpp:655] Replica received learned
> notice for position 1
> I0723 02:18:03.885216 26572 leveldb.cpp:343] Persisting action (155 bytes)
> to leveldb took 9.083506ms
> I0723 02:18:03.885246 26572 replica.cpp:676] Persisted action at 1
> I0723 02:18:03.885257 26572 replica.cpp:661] Replica learned APPEND action
> at position 1
> I0723 02:18:03.885717 26572 registrar.cpp:479] Successfully updated
> 'registry'
> I0723 02:18:03.885756 26572 registrar.cpp:372] Successfully recovered
> registrar
> I0723 02:18:03.885807 26572 log.cpp:699] Attempting to truncate the log to
> 1
> I0723 02:18:03.885898 26572 master.cpp:987] Recovered 0 slaves from the
> Registry (97B) ; allowing 10mins for slaves to re-register
> I0723 02:18:03.885938 26572 coordinator.cpp:340] Coordinator attempting to
> write TRUNCATE action at position 2
> I0723 02:18:03.886354 26577 replica.cpp:508] Replica received write
> request for position 2
> I0723 02:18:03.895622 26577 leveldb.cpp:343] Persisting action (16 bytes)
> to leveldb took 9.228847ms
> I0723 02:18:03.895673 26577 replica.cpp:676] Persisted action at 2
> I0723 02:18:03.896041 26574 replica.cpp:655] Replica received learned
> notice for position 2
> I0723 02:18:03.905140 26574 leveldb.cpp:343] Persisting action (18 bytes)
> to leveldb took 9.079844ms
> I0723 02:18:03.905174 26574 leveldb.cpp:401] Deleting ~1 keys from leveldb
> took 12410ns
> I0723 02:18:03.905184 26574 replica.cpp:676] Persisted action at 2
> I0723 02:18:03.905194 26574 replica.cpp:661] Replica learned TRUNCATE
> action at position 2
> I0723 02:18:03.909507 26577 slave.cpp:169] Slave started on 1)@
> 67.195.138.9:42310
> I0723 02:18:03.909530 26577 credentials.hpp:84] Loading credential for
> authentication from
> '/tmp/GarbageCollectorIntegrationTest_Unschedule_VWsnoi/credential'
> I0723 02:18:03.909673 26577 slave.cpp:267] Slave using credential for:
> test-principal
> make[3]: *** [check-local] Segmentation fault
> make[3]: Leaving directory
> `/home/hudson/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
> `/home/hudson/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
> `/home/hudson/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
>