Re: Build failed in Jenkins: Mesos » clang,--verbose --enable-libevent --enable-ssl,ubuntu:14.04,docker||Hadoop #858

[Michael Park <mp...@mesosphere.io>]

Just as a follow-up: this was fixed with https://reviews.apache.org/r/39300/

On Thu, Sep 24, 2015 at 1:53 PM Vinod Kone <vi...@apache.org> wrote:

> + @mpark
>
> is this new?
>
> On Thu, Sep 24, 2015 at 12:06 PM, Apache Jenkins Server <
> jenkins@builds.apache.org> wrote:
>
>> See <
>> https://builds.apache.org/job/Mesos/COMPILER=clang,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,OS=ubuntu%3A14.04,label_exp=docker%7C%7CHadoop/858/changes
>> >
>>
>> Changes:
>>
>> [yujie.jay] Fixed the launcher flag help message.
>>
>> ------------------------------------------
>> [...truncated 134963 lines...]
>> I0924 19:06:16.304379 28384 gc.cpp:56] Scheduling
>> '/tmp/ContentType_SchedulerTest_Message_1_jLFv53/slaves/8d775487-40ab-4658-8c42-013b03273540-S0/frameworks/8d775487-40ab-4658-8c42-013b03273540-0000/executors/default/runs/75e06741-4bf6-46d4-9eb3-6a27a0d121df'
>> for gc 6.99999647806815days in the future
>> I0924 19:06:16.304498 28386 slave.cpp:3633] Cleaning up framework
>> 8d775487-40ab-4658-8c42-013b03273540-0000
>> I0924 19:06:16.304543 28384 gc.cpp:56] Scheduling
>> '/tmp/ContentType_SchedulerTest_Message_1_jLFv53/slaves/8d775487-40ab-4658-8c42-013b03273540-S0/frameworks/8d775487-40ab-4658-8c42-013b03273540-0000/executors/default'
>> for gc 6.99999647622815days in the future
>> I0924 19:06:16.304636 28387 status_update_manager.cpp:284] Closing status
>> update streams for framework 8d775487-40ab-4658-8c42-013b03273540-0000
>> I0924 19:06:16.304744 28376 gc.cpp:56] Scheduling
>> '/tmp/ContentType_SchedulerTest_Message_1_jLFv53/slaves/8d775487-40ab-4658-8c42-013b03273540-S0/frameworks/8d775487-40ab-4658-8c42-013b03273540-0000'
>> for gc 6.99999647431704days in the future
>> I0924 19:06:16.304795 28387 status_update_manager.cpp:530] Cleaning up
>> status update stream for task 6c7f3232-0d20-49f0-a271-cbb7fda02664 of
>> framework 8d775487-40ab-4658-8c42-013b03273540-0000
>> [       OK ] ContentType/SchedulerTest.Message/1 (95 ms)
>> [ RUN      ] ContentType/SchedulerTest.Request/0
>> Using temporary directory
>> '/tmp/ContentType_SchedulerTest_Request_0_oL61ie'
>> I0924 19:06:16.311180 28355 leveldb.cpp:176] Opened db in 2.525063ms
>> I0924 19:06:16.311949 28355 leveldb.cpp:183] Compacted db in 750917ns
>> I0924 19:06:16.312005 28355 leveldb.cpp:198] Created db iterator in
>> 39121ns
>> I0924 19:06:16.312026 28355 leveldb.cpp:204] Seeked to beginning of db in
>> 9227ns
>> I0924 19:06:16.312041 28355 leveldb.cpp:273] Iterated through 0 keys in
>> the db in 8490ns
>> I0924 19:06:16.312088 28355 replica.cpp:744] Replica recovered with log
>> positions 0 -> 0 with 1 holes and 0 unlearned
>> I0924 19:06:16.312629 28385 recover.cpp:449] Starting replica recovery
>> I0924 19:06:16.313024 28385 recover.cpp:475] Replica is in EMPTY status
>> I0924 19:06:16.313863 28375 replica.cpp:641] Replica in EMPTY status
>> received a broadcasted recover request
>> I0924 19:06:16.314188 28385 recover.cpp:195] Received a recover response
>> from a replica in EMPTY status
>> I0924 19:06:16.314538 28378 recover.cpp:566] Updating replica status to
>> STARTING
>> I0924 19:06:16.315202 28379 leveldb.cpp:306] Persisting metadata (8
>> bytes) to leveldb took 550642ns
>> I0924 19:06:16.315235 28379 replica.cpp:323] Persisted replica status to
>> STARTING
>> I0924 19:06:16.315426 28379 recover.cpp:475] Replica is in STARTING status
>> I0924 19:06:16.315948 28382 master.cpp:376] Master
>> 87337053-65bf-4350-8cd3-b7e0beaccdd6 (bc8523941b25) started on
>> 172.17.4.54:58204
>> I0924 19:06:16.315984 28382 master.cpp:378] Flags at startup: --acls=""
>> --allocation_interval="1secs" --allocator="HierarchicalDRF"
>> --authenticate="false" --authenticate_slaves="true"
>> --authenticators="crammd5" --authorizers="local"
>> --credentials="/tmp/ContentType_SchedulerTest_Request_0_oL61ie/credentials"
>> --framework_sorter="drf" --help="false" --hostname_lookup="true"
>> --initialize_driver_logging="true" --log_auto_initialize="true"
>> --logbufsecs="0" --logging_level="INFO" --max_slave_ping_timeouts="5"
>> --quiet="false" --recovery_slave_removal_limit="100%"
>> --registry="replicated_log" --registry_fetch_timeout="1mins"
>> --registry_store_timeout="25secs" --registry_strict="true"
>> --root_submissions="true" --slave_ping_timeout="15secs"
>> --slave_reregister_timeout="10mins" --user_sorter="drf" --version="false"
>> --webui_dir="/mesos/mesos-0.25.0/_inst/share/mesos/webui"
>> --work_dir="/tmp/ContentType_SchedulerTest_Request_0_oL61ie/master"
>> --zk_session_timeout="10secs"
>> I0924 19:06:16.316340 28382 master.cpp:425] Master allowing
>> unauthenticated frameworks to register
>> I0924 19:06:16.316354 28382 master.cpp:428] Master only allowing
>> authenticated slaves to register
>> I0924 19:06:16.316345 28384 replica.cpp:641] Replica in STARTING status
>> received a broadcasted recover request
>> I0924 19:06:16.316365 28382 credentials.hpp:37] Loading credentials for
>> authentication from
>> '/tmp/ContentType_SchedulerTest_Request_0_oL61ie/credentials'
>> I0924 19:06:16.316666 28382 master.cpp:467] Using default 'crammd5'
>> authenticator
>> I0924 19:06:16.316714 28385 recover.cpp:195] Received a recover response
>> from a replica in STARTING status
>> I0924 19:06:16.316795 28382 master.cpp:504] Authorization enabled
>> I0924 19:06:16.317104 28374 whitelist_watcher.cpp:79] No whitelist given
>> I0924 19:06:16.317257 28385 recover.cpp:566] Updating replica status to
>> VOTING
>> I0924 19:06:16.317750 28385 leveldb.cpp:306] Persisting metadata (8
>> bytes) to leveldb took 331821ns
>> I0924 19:06:16.317760 28383 hierarchical.hpp:468] Initialized
>> hierarchical allocator process
>> I0924 19:06:16.317782 28385 replica.cpp:323] Persisted replica status to
>> VOTING
>> I0924 19:06:16.317904 28388 recover.cpp:580] Successfully joined the
>> Paxos group
>> I0924 19:06:16.318346 28388 recover.cpp:464] Recover process terminated
>> I0924 19:06:16.318619 28386 master.cpp:1603] The newly elected leader is
>> master@172.17.4.54:58204 with id 87337053-65bf-4350-8cd3-b7e0beaccdd6
>> I0924 19:06:16.318703 28386 master.cpp:1616] Elected as the leading
>> master!
>> I0924 19:06:16.318739 28386 master.cpp:1376] Recovering from registrar
>> I0924 19:06:16.318948 28378 registrar.cpp:309] Recovering registrar
>> I0924 19:06:16.319456 28386 log.cpp:661] Attempting to start the writer
>> I0924 19:06:16.320595 28382 replica.cpp:477] Replica received implicit
>> promise request with proposal 1
>> I0924 19:06:16.320940 28382 leveldb.cpp:306] Persisting metadata (8
>> bytes) to leveldb took 328513ns
>> I0924 19:06:16.320962 28382 replica.cpp:345] Persisted promised to 1
>> I0924 19:06:16.321538 28373 coordinator.cpp:231] Coordinator attemping to
>> fill missing position
>> I0924 19:06:16.322576 28381 replica.cpp:378] Replica received explicit
>> promise request for position 0 with proposal 2
>> I0924 19:06:16.322923 28381 leveldb.cpp:343] Persisting action (8 bytes)
>> to leveldb took 321192ns
>> I0924 19:06:16.322947 28381 replica.cpp:679] Persisted action at 0
>> I0924 19:06:16.324036 28377 replica.cpp:511] Replica received write
>> request for position 0
>> I0924 19:06:16.324095 28377 leveldb.cpp:438] Reading position from
>> leveldb took 42419ns
>> I0924 19:06:16.324422 28377 leveldb.cpp:343] Persisting action (14 bytes)
>> to leveldb took 292859ns
>> I0924 19:06:16.324446 28377 replica.cpp:679] Persisted action at 0
>> I0924 19:06:16.325081 28388 replica.cpp:658] Replica received learned
>> notice for position 0
>> I0924 19:06:16.325393 28388 leveldb.cpp:343] Persisting action (16 bytes)
>> to leveldb took 298352ns
>> I0924 19:06:16.325420 28388 replica.cpp:679] Persisted action at 0
>> I0924 19:06:16.325443 28388 replica.cpp:664] Replica learned NOP action
>> at position 0
>> I0924 19:06:16.326028 28380 log.cpp:677] Writer started with ending
>> position 0
>> I0924 19:06:16.326936 28379 leveldb.cpp:438] Reading position from
>> leveldb took 44104ns
>> I0924 19:06:16.327694 28377 registrar.cpp:342] Successfully fetched the
>> registry (0B) in 8.638976ms
>> I0924 19:06:16.327795 28377 registrar.cpp:441] Applied 1 operations in
>> 30606ns; attempting to update the 'registry'
>> I0924 19:06:16.328428 28375 log.cpp:685] Attempting to append 174 bytes
>> to the log
>> I0924 19:06:16.328529 28379 coordinator.cpp:341] Coordinator attempting
>> to write APPEND action at position 1
>> I0924 19:06:16.329190 28383 replica.cpp:511] Replica received write
>> request for position 1
>> I0924 19:06:16.329648 28383 leveldb.cpp:343] Persisting action (193
>> bytes) to leveldb took 438114ns
>> I0924 19:06:16.329675 28383 replica.cpp:679] Persisted action at 1
>> I0924 19:06:16.330271 28382 replica.cpp:658] Replica received learned
>> notice for position 1
>> I0924 19:06:16.330648 28382 leveldb.cpp:343] Persisting action (195
>> bytes) to leveldb took 362457ns
>> I0924 19:06:16.330673 28382 replica.cpp:679] Persisted action at 1
>> I0924 19:06:16.330693 28382 replica.cpp:664] Replica learned APPEND
>> action at position 1
>> I0924 19:06:16.331722 28376 registrar.cpp:486] Successfully updated the
>> 'registry' in 3.84512ms
>> I0924 19:06:16.331900 28376 registrar.cpp:372] Successfully recovered
>> registrar
>> I0924 19:06:16.331933 28388 log.cpp:704] Attempting to truncate the log
>> to 1
>> I0924 19:06:16.332178 28379 coordinator.cpp:341] Coordinator attempting
>> to write TRUNCATE action at position 2
>> I0924 19:06:16.332463 28373 master.cpp:1413] Recovered 0 slaves from the
>> Registry (135B) ; allowing 10mins for slaves to re-register
>> I0924 19:06:16.333238 28387 replica.cpp:511] Replica received write
>> request for position 2
>> I0924 19:06:16.333722 28387 leveldb.cpp:343] Persisting action (16 bytes)
>> to leveldb took 461329ns
>> I0924 19:06:16.333750 28387 replica.cpp:679] Persisted action at 2
>> I0924 19:06:16.334476 28374 replica.cpp:658] Replica received learned
>> notice for position 2
>> I0924 19:06:16.334830 28374 leveldb.cpp:343] Persisting action (18 bytes)
>> to leveldb took 335431ns
>> I0924 19:06:16.334882 28374 leveldb.cpp:401] Deleting ~1 keys from
>> leveldb took 38654ns
>> I0924 19:06:16.334908 28374 replica.cpp:679] Persisted action at 2
>> I0924 19:06:16.334930 28374 replica.cpp:664] Replica learned TRUNCATE
>> action at position 2
>> I0924 19:06:16.343368 28355 scheduler.cpp:157] Version: 0.25.0
>> I0924 19:06:16.343950 28387 scheduler.cpp:240] New master detected at
>> master@172.17.4.54:58204
>> I0924 19:06:16.344945 28376 scheduler.cpp:302] Sending SUBSCRIBE call to
>> master@172.17.4.54:58204
>> I0924 19:06:16.346712 28386 process.cpp:3021] Handling HTTP event for
>> process 'master' with path: '/master/api/v1/scheduler'
>> I0924 19:06:16.346900 28386 http.cpp:336] HTTP POST for
>> /master/api/v1/scheduler from 172.17.4.54:45450
>> I0924 19:06:16.347079 28386 master.cpp:1865] Received subscription
>> request for HTTP framework 'default'
>> I0924 19:06:16.347106 28386 master.cpp:1642] Authorizing framework
>> principal 'test-principal' to receive offers for role '*'
>> I0924 19:06:16.347321 28386 master.cpp:1957] Subscribing framework
>> 'default' with checkpointing disabled and capabilities [  ]
>> I0924 19:06:16.347626 28385 hierarchical.hpp:515] Added framework
>> 87337053-65bf-4350-8cd3-b7e0beaccdd6-0000
>> I0924 19:06:16.347668 28385 hierarchical.hpp:1326] No resources available
>> to allocate!
>> I0924 19:06:16.347697 28385 hierarchical.hpp:1421] No inverse offers to
>> send out!
>> I0924 19:06:16.347715 28385 hierarchical.hpp:1221] Performed allocation
>> for 0 slaves in 76758ns
>> I0924 19:06:16.347750 28385 master.hpp:1431] Sending heartbeat to
>> 87337053-65bf-4350-8cd3-b7e0beaccdd6-0000
>> I0924 19:06:16.348635 28379 scheduler.cpp:461] Enqueuing event SUBSCRIBED
>> received from master@172.17.4.54:58204
>> I0924 19:06:16.349084 28379 scheduler.cpp:461] Enqueuing event HEARTBEAT
>> received from master@172.17.4.54:58204
>> I0924 19:06:16.349799 28376 master_maintenance_tests.cpp:179] Ignoring
>> HEARTBEAT event
>> I0924 19:06:16.349944 28381 scheduler.cpp:302] Sending REQUEST call to
>> master@172.17.4.54:58204
>> I0924 19:06:16.351239 28376 process.cpp:3021] Handling HTTP event for
>> process 'master' with path: '/master/api/v1/scheduler'
>> I0924 19:06:16.351429 28376 http.cpp:336] HTTP POST for
>> /master/api/v1/scheduler from 172.17.4.54:45451
>> I0924 19:06:16.351532 28376 master.cpp:2618] Processing REQUEST call for
>> framework 87337053-65bf-4350-8cd3-b7e0beaccdd6-0000 (default)
>> I0924 19:06:16.351675 28379 hierarchical.hpp:801] Received resource
>> request from framework 87337053-65bf-4350-8cd3-b7e0beaccdd6-0000
>> I0924 19:06:16.351948 28375 master.cpp:919] Master terminating
>> I0924 19:06:16.352222 28384 hierarchical.hpp:552] Removed framework
>> 87337053-65bf-4350-8cd3-b7e0beaccdd6-0000
>> E0924 19:06:16.353914 28385 scheduler.cpp:435] End-Of-File received from
>> master. The master closed the event stream
>> [       OK ] ContentType/SchedulerTest.Request/0 (49 ms)
>> [ RUN      ] ContentType/SchedulerTest.Request/1
>> Using temporary directory
>> '/tmp/ContentType_SchedulerTest_Request_1_xNPXfX'
>> I0924 19:06:16.360517 28355 leveldb.cpp:176] Opened db in 2.451892ms
>> I0924 19:06:16.361405 28355 leveldb.cpp:183] Compacted db in 872424ns
>> I0924 19:06:16.361455 28355 leveldb.cpp:198] Created db iterator in
>> 32061ns
>> I0924 19:06:16.361479 28355 leveldb.cpp:204] Seeked to beginning of db in
>> 10308ns
>> I0924 19:06:16.361495 28355 leveldb.cpp:273] Iterated through 0 keys in
>> the db in 23393ns
>> I0924 19:06:16.361559 28355 replica.cpp:744] Replica recovered with log
>> positions 0 -> 0 with 1 holes and 0 unlearned
>> I0924 19:06:16.361937 28379 recover.cpp:449] Starting replica recovery
>> I0924 19:06:16.362229 28379 recover.cpp:475] Replica is in EMPTY status
>> I0924 19:06:16.362973 28387 replica.cpp:641] Replica in EMPTY status
>> received a broadcasted recover request
>> I0924 19:06:16.363325 28374 recover.cpp:195] Received a recover response
>> from a replica in EMPTY status
>> I0924 19:06:16.363636 28378 recover.cpp:566] Updating replica status to
>> STARTING
>> I0924 19:06:16.364107 28380 leveldb.cpp:306] Persisting metadata (8
>> bytes) to leveldb took 407789ns
>> I0924 19:06:16.364207 28380 replica.cpp:323] Persisted replica status to
>> STARTING
>> I0924 19:06:16.364470 28385 recover.cpp:475] Replica is in STARTING status
>> I0924 19:06:16.365313 28384 master.cpp:376] Master
>> 821ee8f4-13cf-4052-aa9e-f447cee70ec6 (bc8523941b25) started on
>> 172.17.4.54:58204
>> I0924 19:06:16.365370 28375 replica.cpp:641] Replica in STARTING status
>> received a broadcasted recover request
>> I0924 19:06:16.365404 28384 master.cpp:378] Flags at startup: --acls=""
>> --allocation_interval="1secs" --allocator="HierarchicalDRF"
>> --authenticate="false" --authenticate_slaves="true"
>> --authenticators="crammd5" --authorizers="local"
>> --credentials="/tmp/ContentType_SchedulerTest_Request_1_xNPXfX/credentials"
>> --framework_sorter="drf" --help="false" --hostname_lookup="true"
>> --initialize_driver_logging="true" --log_auto_initialize="true"
>> --logbufsecs="0" --logging_level="INFO" --max_slave_ping_timeouts="5"
>> --quiet="false" --recovery_slave_removal_limit="100%"
>> --registry="replicated_log" --registry_fetch_timeout="1mins"
>> --registry_store_timeout="25secs" --registry_strict="true"
>> --root_submissions="true" --slave_ping_timeout="15secs"
>> --slave_reregister_timeout="10mins" --user_sorter="drf" --version="false"
>> --webui_dir="/mesos/mesos-0.25.0/_inst/share/mesos/webui"
>> --work_dir="/tmp/ContentType_SchedulerTest_Request_1_xNPXfX/master"
>> --zk_session_timeout="10secs"
>> I0924 19:06:16.365731 28384 master.cpp:425] Master allowing
>> unauthenticated frameworks to register
>> I0924 19:06:16.365751 28384 master.cpp:428] Master only allowing
>> authenticated slaves to register
>> I0924 19:06:16.365763 28384 credentials.hpp:37] Loading credentials for
>> authentication from
>> '/tmp/ContentType_SchedulerTest_Request_1_xNPXfX/credentials'
>> I0924 19:06:16.366025 28384 master.cpp:467] Using default 'crammd5'
>> authenticator
>> I0924 19:06:16.366140 28384 master.cpp:504] Authorization enabled
>> I0924 19:06:16.366318 28385 whitelist_watcher.cpp:79] No whitelist given
>> I0924 19:06:16.366344 28381 hierarchical.hpp:468] Initialized
>> hierarchical allocator process
>> I0924 19:06:16.367209 28376 recover.cpp:195] Received a recover response
>> from a replica in STARTING status
>> I0924 19:06:16.367614 28387 master.cpp:1603] The newly elected leader is
>> master@172.17.4.54:58204 with id 821ee8f4-13cf-4052-aa9e-f447cee70ec6
>> I0924 19:06:16.367650 28387 master.cpp:1616] Elected as the leading
>> master!
>> I0924 19:06:16.367666 28387 master.cpp:1376] Recovering from registrar
>> I0924 19:06:16.367701 28375 recover.cpp:566] Updating replica status to
>> VOTING
>> I0924 19:06:16.367871 28385 registrar.cpp:309] Recovering registrar
>> I0924 19:06:16.368551 28386 leveldb.cpp:306] Persisting metadata (8
>> bytes) to leveldb took 424394ns
>> I0924 19:06:16.368578 28386 replica.cpp:323] Persisted replica status to
>> VOTING
>> I0924 19:06:16.368692 28379 recover.cpp:580] Successfully joined the
>> Paxos group
>> I0924 19:06:16.368976 28379 recover.cpp:464] Recover process terminated
>> I0924 19:06:16.369375 28383 log.cpp:661] Attempting to start the writer
>> I0924 19:06:16.370358 28388 replica.cpp:477] Replica received implicit
>> promise request with proposal 1
>> I0924 19:06:16.370666 28388 leveldb.cpp:306] Persisting metadata (8
>> bytes) to leveldb took 295075ns
>> I0924 19:06:16.370689 28388 replica.cpp:345] Persisted promised to 1
>> I0924 19:06:16.371278 28376 coordinator.cpp:231] Coordinator attemping to
>> fill missing position
>> I0924 19:06:16.372326 28381 replica.cpp:378] Replica received explicit
>> promise request for position 0 with proposal 2
>> I0924 19:06:16.372670 28381 leveldb.cpp:343] Persisting action (8 bytes)
>> to leveldb took 324145ns
>> I0924 19:06:16.372694 28381 replica.cpp:679] Persisted action at 0
>> I0924 19:06:16.373654 28378 replica.cpp:511] Replica received write
>> request for position 0
>> I0924 19:06:16.373723 28378 leveldb.cpp:438] Reading position from
>> leveldb took 53296ns
>> I0924 19:06:16.374052 28378 leveldb.cpp:343] Persisting action (14 bytes)
>> to leveldb took 293806ns
>> I0924 19:06:16.374075 28378 replica.cpp:679] Persisted action at 0
>> I0924 19:06:16.374596 28388 replica.cpp:658] Replica received learned
>> notice for position 0
>> I0924 19:06:16.374922 28388 leveldb.cpp:343] Persisting action (16 bytes)
>> to leveldb took 310936ns
>> I0924 19:06:16.374958 28388 replica.cpp:679] Persisted action at 0
>> I0924 19:06:16.374986 28388 replica.cpp:664] Replica learned NOP action
>> at position 0
>> I0924 19:06:16.375481 28376 log.cpp:677] Writer started with ending
>> position 0
>> I0924 19:06:16.376451 28382 leveldb.cpp:438] Reading position from
>> leveldb took 81988ns
>> I0924 19:06:16.377238 28380 registrar.cpp:342] Successfully fetched the
>> registry (0B) in 9.32992ms
>> I0924 19:06:16.377425 28380 registrar.cpp:441] Applied 1 operations in
>> 38989ns; attempting to update the 'registry'
>> I0924 19:06:16.377985 28378 log.cpp:685] Attempting to append 174 bytes
>> to the log
>> I0924 19:06:16.378206 28377 coordinator.cpp:341] Coordinator attempting
>> to write APPEND action at position 1
>> I0924 19:06:16.378859 28379 replica.cpp:511] Replica received write
>> request for position 1
>> I0924 19:06:16.379254 28379 leveldb.cpp:343] Persisting action (193
>> bytes) to leveldb took 372572ns
>> I0924 19:06:16.379287 28379 replica.cpp:679] Persisted action at 1
>> I0924 19:06:16.379786 28383 replica.cpp:658] Replica received learned
>> notice for position 1
>> I0924 19:06:16.380183 28383 leveldb.cpp:343] Persisting action (195
>> bytes) to leveldb took 385378ns
>> I0924 19:06:16.380208 28383 replica.cpp:679] Persisted action at 1
>> I0924 19:06:16.380231 28383 replica.cpp:664] Replica learned APPEND
>> action at position 1
>> I0924 19:06:16.381069 28388 registrar.cpp:486] Successfully updated the
>> 'registry' in 3.585024ms
>> I0924 19:06:16.381245 28388 registrar.cpp:372] Successfully recovered
>> registrar
>> I0924 19:06:16.381289 28384 log.cpp:704] Attempting to truncate the log
>> to 1
>> I0924 19:06:16.381418 28386 coordinator.cpp:341] Coordinator attempting
>> to write TRUNCATE action at position 2
>> I0924 19:06:16.381944 28384 master.cpp:1413] Recovered 0 slaves from the
>> Registry (135B) ; allowing 10mins for slaves to re-register
>> I0924 19:06:16.382235 28375 replica.cpp:511] Replica received write
>> request for position 2
>> I0924 19:06:16.382602 28375 leveldb.cpp:343] Persisting action (16 bytes)
>> to leveldb took 307457ns
>> I0924 19:06:16.382629 28375 replica.cpp:679] Persisted action at 2
>> I0924 19:06:16.383242 28379 replica.cpp:658] Replica received learned
>> notice for position 2
>> I0924 19:06:16.383632 28379 leveldb.cpp:343] Persisting action (18 bytes)
>> to leveldb took 300369ns
>> I0924 19:06:16.383682 28379 leveldb.cpp:401] Deleting ~1 keys from
>> leveldb took 34852ns
>> I0924 19:06:16.383715 28379 replica.cpp:679] Persisted action at 2
>> I0924 19:06:16.383733 28379 replica.cpp:664] Replica learned TRUNCATE
>> action at position 2
>> I0924 19:06:16.392786 28355 scheduler.cpp:157] Version: 0.25.0
>> I0924 19:06:16.393324 28382 scheduler.cpp:240] New master detected at
>> master@172.17.4.54:58204
>> I0924 19:06:16.394248 28379 scheduler.cpp:302] Sending SUBSCRIBE call to
>> master@172.17.4.54:58204
>> I0924 19:06:16.396059 28377 process.cpp:3021] Handling HTTP event for
>> process 'master' with path: '/master/api/v1/scheduler'
>> I0924 19:06:16.396301 28377 http.cpp:336] HTTP POST for
>> /master/api/v1/scheduler from 172.17.4.54:45452
>> I0924 19:06:16.396668 28377 master.cpp:1865] Received subscription
>> request for HTTP framework 'default'
>> I0924 19:06:16.396698 28377 master.cpp:1642] Authorizing framework
>> principal 'test-principal' to receive offers for role '*'
>> I0924 19:06:16.397030 28388 master.cpp:1957] Subscribing framework
>> 'default' with checkpointing disabled and capabilities [  ]
>> I0924 19:06:16.397424 28375 hierarchical.hpp:515] Added framework
>> 821ee8f4-13cf-4052-aa9e-f447cee70ec6-0000
>> I0924 19:06:16.397470 28375 hierarchical.hpp:1326] No resources available
>> to allocate!
>> I0924 19:06:16.397696 28375 hierarchical.hpp:1421] No inverse offers to
>> send out!
>> I0924 19:06:16.397825 28375 hierarchical.hpp:1221] Performed allocation
>> for 0 slaves in 388460ns
>> I0924 19:06:16.397603 28387 master.hpp:1431] Sending heartbeat to
>> 821ee8f4-13cf-4052-aa9e-f447cee70ec6-0000
>> I0924 19:06:16.398239 28373 scheduler.cpp:461] Enqueuing event SUBSCRIBED
>> received from master@172.17.4.54:58204
>> I0924 19:06:16.398720 28373 scheduler.cpp:461] Enqueuing event HEARTBEAT
>> received from master@172.17.4.54:58204
>> I0924 19:06:16.399333 28385 master_maintenance_tests.cpp:179] Ignoring
>> HEARTBEAT event
>> I0924 19:06:16.399487 28373 scheduler.cpp:302] Sending REQUEST call to
>> master@172.17.4.54:58204
>> I0924 19:06:16.400761 28385 process.cpp:3021] Handling HTTP event for
>> process 'master' with path: '/master/api/v1/scheduler'
>> I0924 19:06:16.400930 28385 http.cpp:336] HTTP POST for
>> /master/api/v1/scheduler from 172.17.4.54:45453
>> I0924 19:06:16.401156 28385 master.cpp:2618] Processing REQUEST call for
>> framework 821ee8f4-13cf-4052-aa9e-f447cee70ec6-0000 (default)
>> I0924 19:06:16.401491 28382 hierarchical.hpp:801] Received resource
>> request from framework 821ee8f4-13cf-4052-aa9e-f447cee70ec6-0000
>> I0924 19:06:16.401518 28373 master.cpp:919] Master terminating
>> I0924 19:06:16.401794 28377 hierarchical.hpp:552] Removed framework
>> 821ee8f4-13cf-4052-aa9e-f447cee70ec6-0000
>> E0924 19:06:16.402907 28386 scheduler.cpp:435] End-Of-File received from
>> master. The master closed the event stream
>> [       OK ] ContentType/SchedulerTest.Request/1 (50 ms)
>> [----------] 22 tests from ContentType/SchedulerTest (3945 ms total)
>>
>> [----------] Global test environment tear-down
>> [==========] 808 tests from 110 test cases ran. (316774 ms total)
>> [  PASSED  ] 807 tests.
>> [  FAILED  ] 1 test, listed below:
>> [  FAILED  ] ReservationEndpointsTest.AvailableResources
>>
>>  1 FAILED TEST
>>   YOU HAVE 7 DISABLED TESTS
>>
>> make[4]: *** [check-local] Error 1
>> make[4]: Leaving directory `/mesos/mesos-0.25.0/_build/src'
>> make[3]: *** [check-am] Error 2
>> make[3]: Leaving directory `/mesos/mesos-0.25.0/_build/src'
>> make[2]: *** [check] Error 2
>> make[2]: Leaving directory `/mesos/mesos-0.25.0/_build/src'
>> make[1]: *** [check-recursive] Error 1
>> make[1]: Leaving directory `/mesos/mesos-0.25.0/_build'
>> make: *** [distcheck] Error 1
>> + docker rmi mesos-1443120053-20020
>> Untagged: mesos-1443120053-20020:latest
>> Deleted: 6c2fc5bdd1fe0d78c8337cfc82d4f4203d2664736023ea6ed17473fe0d3d1d57
>> Deleted: 99ffa117d63c3446ea46a2820b2a13bd556c8e1ba5127662b90f3d494aa2d049
>> Deleted: 4fcb679aabc9a4329ed4ee7b70f93e9318628c8a6b2e0e76f2b0939a916d84cd
>> Deleted: 72d2dcc0c9ca2b207cbe59e6d2086b03eb8c111701aadd6a45e42e094845bb6d
>> Deleted: 934b1befb1db75e8a1bf61ed6fe6c52ed4373120499e5e76e7813b1b8ed50618
>> Deleted: 2676c29252fd3554871450fd0dfa7cd49ee9e07a2feb1779f9d6fae77c9975ed
>> Deleted: 66e4fef2196e41a308df39cef902fa526a001b074d7f95078ac7982fe61f86bf
>> Deleted: df4d45acd485b5292382c6d2752360aa1d8219aa893963e9ad68e680d3508593
>> Deleted: beefddd22ffefe04b3f87180b0a23d660203a1afa538627cb3655b441c4df305
>> Deleted: 342c2049a861884ae143d27b3502d315f9eb9a994e22472ebf1eb2ef790336cb
>> Deleted: f57f1f3192735c7f1ca846984d5c2f5f7da506e0b8cec9a341513b50bf154803
>> Deleted: a95f8137633246aee802304d132167ff4891a6a6ee87302567f039fa6eccc349
>> Deleted: 098c3c782cb7cfa5114e016d6f78c0fa26eee3049e410b44e9c0ac2468b2e568
>> Build step 'Execute shell' marked build as failure
>>
>
>