See
<https://builds.apache.org/job/Mesos/COMPILER=gcc,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)/1821/changes>
Changes:
[mpark] Refactor cluster test helpers into self-contained objects.
[mpark] Refactor MesosTest and remove cleanup logic.
[mpark] Fixed formatting issues in `src/tests/mesos.{hpp,cpp}`.
[mpark] Especially updated tests to use the updated MesosTest helpers.
[mpark] Especially updated scheduler tests to use the updated MesosTest helpers.
[mpark] Update test suite to use the reworked MesosTest helpers.
------------------------------------------
[...truncated 171435 lines...]
I0316 14:34:25.693614 1273 master.cpp:378] Flags at startup: --acls=""
--allocation_interval="1secs" --allocator="HierarchicalDRF"
--authenticate="false" --authenticate_http="true" --authenticate_slaves="true"
--authenticators="crammd5" --authorizers="local"
--credentials="/tmp/NRNIuf/credentials" --framework_sorter="drf" --help="false"
--hostname_lookup="true" --http_authenticators="basic"
--initialize_driver_logging="true" --log_auto_initialize="true"
--logbufsecs="0" --logging_level="INFO" --max_completed_frameworks="50"
--max_completed_tasks_per_framework="1000" --max_slave_ping_timeouts="5"
--quiet="false" --recovery_slave_removal_limit="100%"
--registry="replicated_log" --registry_fetch_timeout="1mins"
--registry_store_timeout="100secs" --registry_strict="true"
--root_submissions="true" --slave_ping_timeout="15secs"
--slave_reregister_timeout="10mins" --user_sorter="drf" --version="false"
--webui_dir="/mesos/mesos-0.29.0/_inst/share/mesos/webui"
--work_dir="/tmp/NRNIuf/master" --zk_session_timeout="10secs"
I0316 14:34:25.693967 1273 master.cpp:425] Master allowing unauthenticated
frameworks to register
I0316 14:34:25.693984 1273 master.cpp:428] Master only allowing authenticated
slaves to register
I0316 14:34:25.693996 1273 credentials.hpp:35] Loading credentials for
authentication from '/tmp/NRNIuf/credentials'
I0316 14:34:25.694159 1272 leveldb.cpp:304] Persisting metadata (8 bytes) to
leveldb took 1.266881ms
I0316 14:34:25.694195 1272 replica.cpp:320] Persisted replica status to
STARTING
I0316 14:34:25.694439 1272 recover.cpp:473] Replica is in STARTING status
I0316 14:34:25.694468 1273 master.cpp:468] Using default 'crammd5'
authenticator
I0316 14:34:25.694679 1273 master.cpp:537] Using default 'basic' HTTP
authenticator
I0316 14:34:25.694886 1273 master.cpp:571] Authorization enabled
I0316 14:34:25.695179 1272 hierarchical.cpp:144] Initialized hierarchical
allocator process
I0316 14:34:25.695225 1276 whitelist_watcher.cpp:77] No whitelist given
I0316 14:34:25.695478 1270 replica.cpp:673] Replica in STARTING status
received a broadcasted recover request from (15617)@172.17.0.3:45919
I0316 14:34:25.695854 1272 recover.cpp:193] Received a recover response from a
replica in STARTING status
I0316 14:34:25.696405 1265 recover.cpp:564] Updating replica status to VOTING
I0316 14:34:25.697202 1261 leveldb.cpp:304] Persisting metadata (8 bytes) to
leveldb took 637488ns
I0316 14:34:25.697309 1261 replica.cpp:320] Persisted replica status to VOTING
I0316 14:34:25.697528 1269 recover.cpp:578] Successfully joined the Paxos group
I0316 14:34:25.697957 1269 recover.cpp:462] Recover process terminated
I0316 14:34:25.698029 1273 master.cpp:1806] The newly elected leader is
[email protected]:45919 with id a6d44a5f-2e9f-4245-9655-555ae6663a9e
I0316 14:34:25.698230 1273 master.cpp:1819] Elected as the leading master!
I0316 14:34:25.698257 1273 master.cpp:1508] Recovering from registrar
I0316 14:34:25.698500 1261 registrar.cpp:307] Recovering registrar
I0316 14:34:25.699101 1270 log.cpp:659] Attempting to start the writer
I0316 14:34:25.700238 1269 replica.cpp:493] Replica received implicit promise
request from (15618)@172.17.0.3:45919 with proposal 1
I0316 14:34:25.700956 1269 leveldb.cpp:304] Persisting metadata (8 bytes) to
leveldb took 618043ns
I0316 14:34:25.701006 1269 replica.cpp:342] Persisted promised to 1
I0316 14:34:25.701830 1269 coordinator.cpp:238] Coordinator attempting to fill
missing positions
I0316 14:34:25.703053 1273 replica.cpp:388] Replica received explicit promise
request from (15619)@172.17.0.3:45919 for position 0 with proposal 2
I0316 14:34:25.703554 1273 leveldb.cpp:341] Persisting action (8 bytes) to
leveldb took 457906ns
I0316 14:34:25.703579 1273 replica.cpp:712] Persisted action at 0
I0316 14:34:25.704733 1262 replica.cpp:537] Replica received write request for
position 0 from (15620)@172.17.0.3:45919
I0316 14:34:25.704793 1262 leveldb.cpp:436] Reading position from leveldb took
28766ns
I0316 14:34:25.705266 1262 leveldb.cpp:341] Persisting action (14 bytes) to
leveldb took 423966ns
I0316 14:34:25.705289 1262 replica.cpp:712] Persisted action at 0
I0316 14:34:25.705811 1268 replica.cpp:691] Replica received learned notice
for position 0 from @0.0.0.0:0
I0316 14:34:25.706243 1268 leveldb.cpp:341] Persisting action (16 bytes) to
leveldb took 403467ns
I0316 14:34:25.706269 1268 replica.cpp:712] Persisted action at 0
I0316 14:34:25.706305 1268 replica.cpp:697] Replica learned NOP action at
position 0
I0316 14:34:25.706846 1268 log.cpp:675] Writer started with ending position 0
I0316 14:34:25.707998 1269 leveldb.cpp:436] Reading position from leveldb took
49372ns
I0316 14:34:25.709146 1274 registrar.cpp:340] Successfully fetched the
registry (0B) in 10.578176ms
I0316 14:34:25.709329 1274 registrar.cpp:439] Applied 1 operations in 78812ns;
attempting to update the 'registry'
I0316 14:34:25.710098 1276 log.cpp:683] Attempting to append 170 bytes to the
log
I0316 14:34:25.710239 1275 coordinator.cpp:348] Coordinator attempting to
write APPEND action at position 1
I0316 14:34:25.710973 1269 replica.cpp:537] Replica received write request for
position 1 from (15621)@172.17.0.3:45919
I0316 14:34:25.711562 1269 leveldb.cpp:341] Persisting action (189 bytes) to
leveldb took 544267ns
I0316 14:34:25.711596 1269 replica.cpp:712] Persisted action at 1
I0316 14:34:25.712240 1273 replica.cpp:691] Replica received learned notice
for position 1 from @0.0.0.0:0
I0316 14:34:25.712647 1273 leveldb.cpp:341] Persisting action (191 bytes) to
leveldb took 378523ns
I0316 14:34:25.712674 1273 replica.cpp:712] Persisted action at 1
I0316 14:34:25.712698 1273 replica.cpp:697] Replica learned APPEND action at
position 1
I0316 14:34:25.713765 1274 registrar.cpp:484] Successfully updated the
'registry' in 4.36992ms
I0316 14:34:25.713903 1274 registrar.cpp:370] Successfully recovered registrar
I0316 14:34:25.714059 1272 log.cpp:702] Attempting to truncate the log to 1
I0316 14:34:25.714329 1270 coordinator.cpp:348] Coordinator attempting to
write TRUNCATE action at position 2
I0316 14:34:25.714527 1262 master.cpp:1616] Recovered 0 slaves from the
Registry (131B) ; allowing 10mins for slaves to re-register
I0316 14:34:25.714555 1276 hierarchical.cpp:171] Skipping recovery of
hierarchical allocator: nothing to recover
I0316 14:34:25.715176 1274 replica.cpp:537] Replica received write request for
position 2 from (15622)@172.17.0.3:45919
I0316 14:34:25.715608 1274 leveldb.cpp:341] Persisting action (16 bytes) to
leveldb took 398648ns
I0316 14:34:25.715632 1274 replica.cpp:712] Persisted action at 2
I0316 14:34:25.716334 1268 replica.cpp:691] Replica received learned notice
for position 2 from @0.0.0.0:0
I0316 14:34:25.716732 1268 leveldb.cpp:341] Persisting action (18 bytes) to
leveldb took 365171ns
I0316 14:34:25.716780 1268 leveldb.cpp:399] Deleting ~1 keys from leveldb took
25514ns
I0316 14:34:25.716799 1268 replica.cpp:712] Persisted action at 2
I0316 14:34:25.716815 1268 replica.cpp:697] Replica learned TRUNCATE action at
position 2
I0316 14:34:25.725514 1242 scheduler.cpp:172] Version: 0.29.0
I0316 14:34:25.726346 1271 scheduler.cpp:437] New master detected at
[email protected]:45919
I0316 14:34:25.728546 1272 scheduler.cpp:337] Connected with the master at
http://172.17.0.3:45919/master/api/v1/scheduler
I0316 14:34:25.730216 1267 scheduler.cpp:230] Sending SUBSCRIBE call to
http://172.17.0.3:45919/master/api/v1/scheduler
I0316 14:34:25.731333 1271 process.cpp:3136] Handling HTTP event for process
'master' with path: '/master/api/v1/scheduler'
I0316 14:34:25.731999 1272 http.cpp:312] HTTP POST for
/master/api/v1/scheduler from 172.17.0.3:54719
I0316 14:34:25.732342 1272 master.cpp:2068] Received subscription request for
HTTP framework 'default'
I0316 14:34:25.732416 1272 master.cpp:1845] Authorizing framework principal
'test-principal' to receive offers for role '*'
I0316 14:34:25.732769 1269 master.cpp:2159] Subscribing framework 'default'
with checkpointing disabled and capabilities [ ]
I0316 14:34:25.733283 1267 hierarchical.cpp:265] Added framework
a6d44a5f-2e9f-4245-9655-555ae6663a9e-0000
I0316 14:34:25.733393 1267 hierarchical.cpp:1453] No resources available to
allocate!
I0316 14:34:25.733399 1273 master.hpp:1715] Sending heartbeat to
a6d44a5f-2e9f-4245-9655-555ae6663a9e-0000
I0316 14:34:25.733446 1267 hierarchical.cpp:1548] No inverse offers to send
out!
I0316 14:34:25.733490 1267 hierarchical.cpp:1130] Performed allocation for 0
slaves in 169672ns
I0316 14:34:25.734273 1269 scheduler.cpp:612] Enqueuing event SUBSCRIBED
received from http://172.17.0.3:45919/master/api/v1/scheduler
I0316 14:34:25.734899 1269 scheduler.cpp:612] Enqueuing event HEARTBEAT
received from http://172.17.0.3:45919/master/api/v1/scheduler
I0316 14:34:25.735852 1261 scheduler.cpp:230] Sending REQUEST call to
http://172.17.0.3:45919/master/api/v1/scheduler
I0316 14:34:25.737081 1263 process.cpp:3136] Handling HTTP event for process
'master' with path: '/master/api/v1/scheduler'
I0316 14:34:25.737521 1271 http.cpp:312] HTTP POST for
/master/api/v1/scheduler from 172.17.0.3:54720
I0316 14:34:25.737709 1271 master.cpp:2765] Processing REQUEST call for
framework a6d44a5f-2e9f-4245-9655-555ae6663a9e-0000 (default)
I0316 14:34:25.737917 1272 hierarchical.cpp:589] Received resource request
from framework a6d44a5f-2e9f-4245-9655-555ae6663a9e-0000
I0316 14:34:25.740458 1269 master.cpp:1251] Framework
a6d44a5f-2e9f-4245-9655-555ae6663a9e-0000 (default) disconnected
I0316 14:34:25.740497 1269 master.cpp:2622] Disconnecting framework
a6d44a5f-2e9f-4245-9655-555ae6663a9e-0000 (default)
I0316 14:34:25.740535 1269 master.cpp:2646] Deactivating framework
a6d44a5f-2e9f-4245-9655-555ae6663a9e-0000 (default)
I0316 14:34:25.740736 1271 hierarchical.cpp:375] Deactivated framework
a6d44a5f-2e9f-4245-9655-555ae6663a9e-0000
I0316 14:34:25.740695 1269 master.cpp:1275] Giving framework
a6d44a5f-2e9f-4245-9655-555ae6663a9e-0000 (default) 0ns to failover
I0316 14:34:25.742264 1274 master.cpp:5340] Framework failover timeout,
removing framework a6d44a5f-2e9f-4245-9655-555ae6663a9e-0000 (default)
I0316 14:34:25.742372 1274 master.cpp:6073] Removing framework
a6d44a5f-2e9f-4245-9655-555ae6663a9e-0000 (default)
I0316 14:34:25.742709 1275 hierarchical.cpp:326] Removed framework
a6d44a5f-2e9f-4245-9655-555ae6663a9e-0000
I0316 14:34:25.750900 1242 master.cpp:1065] Master terminating
[ OK ] ContentType/SchedulerTest.Request/0 (75 ms)
[ RUN ] ContentType/SchedulerTest.Request/1
I0316 14:34:25.760467 1242 cluster.cpp:139] Creating default 'local' authorizer
I0316 14:34:25.763375 1242 leveldb.cpp:174] Opened db in 2.631728ms
I0316 14:34:25.764204 1242 leveldb.cpp:181] Compacted db in 786101ns
I0316 14:34:25.764262 1242 leveldb.cpp:196] Created db iterator in 23268ns
I0316 14:34:25.764389 1242 leveldb.cpp:202] Seeked to beginning of db in 2358ns
I0316 14:34:25.764498 1242 leveldb.cpp:271] Iterated through 0 keys in the db
in 585ns
I0316 14:34:25.764565 1242 replica.cpp:779] Replica recovered with log
positions 0 -> 0 with 1 holes and 0 unlearned
I0316 14:34:25.765300 1274 recover.cpp:447] Starting replica recovery
I0316 14:34:25.765755 1274 recover.cpp:473] Replica is in EMPTY status
I0316 14:34:25.767058 1265 replica.cpp:673] Replica in EMPTY status received a
broadcasted recover request from (15630)@172.17.0.3:45919
I0316 14:34:25.767719 1263 recover.cpp:193] Received a recover response from a
replica in EMPTY status
I0316 14:34:25.768309 1265 recover.cpp:564] Updating replica status to STARTING
I0316 14:34:25.769213 1275 master.cpp:376] Master
8a03f08d-bf92-44a0-9aae-e601dabec71c (2cbb23302fe5) started on 172.17.0.3:45919
I0316 14:34:25.769423 1268 leveldb.cpp:304] Persisting metadata (8 bytes) to
leveldb took 802608ns
I0316 14:34:25.769467 1268 replica.cpp:320] Persisted replica status to
STARTING
I0316 14:34:25.769240 1275 master.cpp:378] Flags at startup: --acls=""
--allocation_interval="1secs" --allocator="HierarchicalDRF"
--authenticate="false" --authenticate_http="true" --authenticate_slaves="true"
--authenticators="crammd5" --authorizers="local"
--credentials="/tmp/v8ttt3/credentials" --framework_sorter="drf" --help="false"
--hostname_lookup="true" --http_authenticators="basic"
--initialize_driver_logging="true" --log_auto_initialize="true"
--logbufsecs="0" --logging_level="INFO" --max_completed_frameworks="50"
--max_completed_tasks_per_framework="1000" --max_slave_ping_timeouts="5"
--quiet="false" --recovery_slave_removal_limit="100%"
--registry="replicated_log" --registry_fetch_timeout="1mins"
--registry_store_timeout="100secs" --registry_strict="true"
--root_submissions="true" --slave_ping_timeout="15secs"
--slave_reregister_timeout="10mins" --user_sorter="drf" --version="false"
--webui_dir="/mesos/mesos-0.29.0/_inst/share/mesos/webui"
--work_dir="/tmp/v8ttt3/master" --zk_session_timeout="10secs"
I0316 14:34:25.769635 1275 master.cpp:425] Master allowing unauthenticated
frameworks to register
I0316 14:34:25.769645 1275 master.cpp:428] Master only allowing authenticated
slaves to register
I0316 14:34:25.769652 1275 credentials.hpp:35] Loading credentials for
authentication from '/tmp/v8ttt3/credentials'
I0316 14:34:25.770046 1275 master.cpp:468] Using default 'crammd5'
authenticator
I0316 14:34:25.770040 1268 recover.cpp:473] Replica is in STARTING status
I0316 14:34:25.770254 1275 master.cpp:537] Using default 'basic' HTTP
authenticator
I0316 14:34:25.770455 1275 master.cpp:571] Authorization enabled
I0316 14:34:25.770663 1267 whitelist_watcher.cpp:77] No whitelist given
I0316 14:34:25.770763 1264 hierarchical.cpp:144] Initialized hierarchical
allocator process
I0316 14:34:25.771503 1269 replica.cpp:673] Replica in STARTING status
received a broadcasted recover request from (15632)@172.17.0.3:45919
I0316 14:34:25.772037 1261 recover.cpp:193] Received a recover response from a
replica in STARTING status
I0316 14:34:25.772578 1265 recover.cpp:564] Updating replica status to VOTING
I0316 14:34:25.773263 1261 leveldb.cpp:304] Persisting metadata (8 bytes) to
leveldb took 504125ns
I0316 14:34:25.773294 1261 replica.cpp:320] Persisted replica status to VOTING
I0316 14:34:25.773406 1275 recover.cpp:578] Successfully joined the Paxos group
I0316 14:34:25.773576 1261 master.cpp:1806] The newly elected leader is
[email protected]:45919 with id 8a03f08d-bf92-44a0-9aae-e601dabec71c
I0316 14:34:25.773736 1261 master.cpp:1819] Elected as the leading master!
I0316 14:34:25.773746 1275 recover.cpp:462] Recover process terminated
I0316 14:34:25.773774 1261 master.cpp:1508] Recovering from registrar
I0316 14:34:25.774015 1276 registrar.cpp:307] Recovering registrar
I0316 14:34:25.774781 1261 log.cpp:659] Attempting to start the writer
I0316 14:34:25.776232 1262 replica.cpp:493] Replica received implicit promise
request from (15633)@172.17.0.3:45919 with proposal 1
I0316 14:34:25.776703 1262 leveldb.cpp:304] Persisting metadata (8 bytes) to
leveldb took 426458ns
I0316 14:34:25.776729 1262 replica.cpp:342] Persisted promised to 1
I0316 14:34:25.777372 1263 coordinator.cpp:238] Coordinator attempting to fill
missing positions
I0316 14:34:25.778818 1266 replica.cpp:388] Replica received explicit promise
request from (15634)@172.17.0.3:45919 for position 0 with proposal 2
I0316 14:34:25.779248 1266 leveldb.cpp:341] Persisting action (8 bytes) to
leveldb took 374975ns
I0316 14:34:25.779283 1266 replica.cpp:712] Persisted action at 0
I0316 14:34:25.780740 1268 replica.cpp:537] Replica received write request for
position 0 from (15635)@172.17.0.3:45919
I0316 14:34:25.780838 1268 leveldb.cpp:436] Reading position from leveldb took
46911ns
I0316 14:34:25.781334 1268 leveldb.cpp:341] Persisting action (14 bytes) to
leveldb took 429536ns
I0316 14:34:25.781366 1268 replica.cpp:712] Persisted action at 0
I0316 14:34:25.782116 1267 replica.cpp:691] Replica received learned notice
for position 0 from @0.0.0.0:0
I0316 14:34:25.782632 1267 leveldb.cpp:341] Persisting action (16 bytes) to
leveldb took 454952ns
I0316 14:34:25.782660 1267 replica.cpp:712] Persisted action at 0
I0316 14:34:25.782692 1267 replica.cpp:697] Replica learned NOP action at
position 0
I0316 14:34:25.783316 1262 log.cpp:675] Writer started with ending position 0
I0316 14:34:25.784416 1266 leveldb.cpp:436] Reading position from leveldb took
40346ns
I0316 14:34:25.785414 1275 registrar.cpp:340] Successfully fetched the
registry (0B) in 11.233024ms
I0316 14:34:25.785598 1275 registrar.cpp:439] Applied 1 operations in 33290ns;
attempting to update the 'registry'
I0316 14:34:25.786360 1261 log.cpp:683] Attempting to append 170 bytes to the
log
I0316 14:34:25.786527 1271 coordinator.cpp:348] Coordinator attempting to
write APPEND action at position 1
I0316 14:34:25.787273 1273 replica.cpp:537] Replica received write request for
position 1 from (15636)@172.17.0.3:45919
I0316 14:34:25.787727 1273 leveldb.cpp:341] Persisting action (189 bytes) to
leveldb took 415025ns
I0316 14:34:25.787755 1273 replica.cpp:712] Persisted action at 1
I0316 14:34:25.788522 1268 replica.cpp:691] Replica received learned notice
for position 1 from @0.0.0.0:0
I0316 14:34:25.788976 1268 leveldb.cpp:341] Persisting action (191 bytes) to
leveldb took 424139ns
I0316 14:34:25.789003 1268 replica.cpp:712] Persisted action at 1
I0316 14:34:25.789046 1268 replica.cpp:697] Replica learned APPEND action at
position 1
I0316 14:34:25.790257 1267 registrar.cpp:484] Successfully updated the
'registry' in 4.585984ms
I0316 14:34:25.790406 1267 registrar.cpp:370] Successfully recovered registrar
I0316 14:34:25.790956 1270 master.cpp:1616] Recovered 0 slaves from the
Registry (131B) ; allowing 10mins for slaves to re-register
I0316 14:34:25.791084 1272 hierarchical.cpp:171] Skipping recovery of
hierarchical allocator: nothing to recover
I0316 14:34:25.791589 1269 log.cpp:702] Attempting to truncate the log to 1
I0316 14:34:25.791817 1276 coordinator.cpp:348] Coordinator attempting to
write TRUNCATE action at position 2
I0316 14:34:25.792682 1273 replica.cpp:537] Replica received write request for
position 2 from (15637)@172.17.0.3:45919
I0316 14:34:25.793195 1273 leveldb.cpp:341] Persisting action (16 bytes) to
leveldb took 467536ns
I0316 14:34:25.793329 1273 replica.cpp:712] Persisted action at 2
I0316 14:34:25.794317 1267 replica.cpp:691] Replica received learned notice
for position 2 from @0.0.0.0:0
I0316 14:34:25.794713 1267 leveldb.cpp:341] Persisting action (18 bytes) to
leveldb took 364635ns
I0316 14:34:25.794809 1267 leveldb.cpp:399] Deleting ~1 keys from leveldb took
70837ns
I0316 14:34:25.794836 1267 replica.cpp:712] Persisted action at 2
I0316 14:34:25.794864 1267 replica.cpp:697] Replica learned TRUNCATE action at
position 2
I0316 14:34:25.802239 1242 scheduler.cpp:172] Version: 0.29.0
I0316 14:34:25.803004 1265 scheduler.cpp:437] New master detected at
[email protected]:45919
I0316 14:34:25.804595 1263 scheduler.cpp:337] Connected with the master at
http://172.17.0.3:45919/master/api/v1/scheduler
I0316 14:34:25.805811 1268 scheduler.cpp:230] Sending SUBSCRIBE call to
http://172.17.0.3:45919/master/api/v1/scheduler
I0316 14:34:25.806689 1273 process.cpp:3136] Handling HTTP event for process
'master' with path: '/master/api/v1/scheduler'
I0316 14:34:25.807131 1270 http.cpp:312] HTTP POST for
/master/api/v1/scheduler from 172.17.0.3:54741
I0316 14:34:25.807474 1270 master.cpp:2068] Received subscription request for
HTTP framework 'default'
I0316 14:34:25.807533 1270 master.cpp:1845] Authorizing framework principal
'test-principal' to receive offers for role '*'
I0316 14:34:25.807785 1270 master.cpp:2159] Subscribing framework 'default'
with checkpointing disabled and capabilities [ ]
I0316 14:34:25.808226 1261 hierarchical.cpp:265] Added framework
8a03f08d-bf92-44a0-9aae-e601dabec71c-0000
I0316 14:34:25.808317 1270 master.hpp:1715] Sending heartbeat to
8a03f08d-bf92-44a0-9aae-e601dabec71c-0000
I0316 14:34:25.808353 1261 hierarchical.cpp:1453] No resources available to
allocate!
I0316 14:34:25.808404 1261 hierarchical.cpp:1548] No inverse offers to send
out!
I0316 14:34:25.808434 1261 hierarchical.cpp:1130] Performed allocation for 0
slaves in 169581ns
I0316 14:34:25.809084 1265 scheduler.cpp:612] Enqueuing event SUBSCRIBED
received from http://172.17.0.3:45919/master/api/v1/scheduler
I0316 14:34:25.809528 1265 scheduler.cpp:612] Enqueuing event HEARTBEAT
received from http://172.17.0.3:45919/master/api/v1/scheduler
I0316 14:34:25.810348 1271 scheduler.cpp:230] Sending REQUEST call to
http://172.17.0.3:45919/master/api/v1/scheduler
I0316 14:34:25.811244 1269 process.cpp:3136] Handling HTTP event for process
'master' with path: '/master/api/v1/scheduler'
I0316 14:34:25.812198 1262 http.cpp:312] HTTP POST for
/master/api/v1/scheduler from 172.17.0.3:54742
I0316 14:34:25.812505 1262 master.cpp:2765] Processing REQUEST call for
framework 8a03f08d-bf92-44a0-9aae-e601dabec71c-0000 (default)
I0316 14:34:25.812748 1266 hierarchical.cpp:589] Received resource request
from framework 8a03f08d-bf92-44a0-9aae-e601dabec71c-0000
I0316 14:34:25.815428 1265 master.cpp:1251] Framework
8a03f08d-bf92-44a0-9aae-e601dabec71c-0000 (default) disconnected
I0316 14:34:25.815477 1265 master.cpp:2622] Disconnecting framework
8a03f08d-bf92-44a0-9aae-e601dabec71c-0000 (default)
I0316 14:34:25.815506 1265 master.cpp:2646] Deactivating framework
8a03f08d-bf92-44a0-9aae-e601dabec71c-0000 (default)
I0316 14:34:25.815649 1265 master.cpp:1275] Giving framework
8a03f08d-bf92-44a0-9aae-e601dabec71c-0000 (default) 0ns to failover
I0316 14:34:25.815690 1267 hierarchical.cpp:375] Deactivated framework
8a03f08d-bf92-44a0-9aae-e601dabec71c-0000
I0316 14:34:25.817137 1275 master.cpp:5340] Framework failover timeout,
removing framework 8a03f08d-bf92-44a0-9aae-e601dabec71c-0000 (default)
I0316 14:34:25.817170 1275 master.cpp:6073] Removing framework
8a03f08d-bf92-44a0-9aae-e601dabec71c-0000 (default)
I0316 14:34:25.817497 1262 hierarchical.cpp:326] Removed framework
8a03f08d-bf92-44a0-9aae-e601dabec71c-0000
I0316 14:34:25.825148 1242 master.cpp:1065] Master terminating
[ OK ] ContentType/SchedulerTest.Request/1 (73 ms)
[----------] 26 tests from ContentType/SchedulerTest (5096 ms total)
[----------] Global test environment tear-down
E0316 14:34:25.962769 1242 environment.cpp:752] Failed to remove
'/tmp/LogZooKeeperTest_WriteRead_eUjj2c': No such file or directory
E0316 14:34:25.962831 1242 environment.cpp:752] Failed to remove
'/tmp/LogZooKeeperTest_LostZooKeeper_6Sngur': No such file or directory
[==========] 1026 tests from 130 test cases ran. (342527 ms total)
[ PASSED ] 1025 tests.
[ FAILED ] 1 test, listed below:
[ FAILED ] ContainerLoggerTest.LOGROTATE_RotateInSandbox
1 FAILED TEST
YOU HAVE 6 DISABLED TESTS
make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-0.29.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-0.29.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-0.29.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-0.29.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1458136958-22834
Untagged: mesos-1458136958-22834:latest
Deleted: 3da4ae2e59e018cb2c8ebc2605f8c8d92e1412b03506ae36b5a5757bcfb19182
Deleted: a7210d6f5bf7e68b9110ba16258a5a7b25cc68ff360ef736dbfda3c4e2f1dde8
Deleted: 1dc586915bc033c4f18e4840e9dde93b159a3790619d7fa9d35b9f9e55c7eb8e
Deleted: 63a748f876b05ef362586ab94fcdcb9c2fa19bede9efd82235f53728388b883c
Deleted: 85c905dc5e1f8c7037cb121096bd64edb92b5691712e730711c86ef2078eb830
Deleted: 6fc18598941bcc8ae9fb7c18a5036b94179e2c221d04ab05517a882bf06254a0
Deleted: 6239a866e3495ccc56968aa5bb682a5546b7cbce45e0d92149d814b2023020d8
Deleted: 773d8a4b0c21cd1569922daf6c13ee4ba84badbf7db1935c8b0881b74f741320
Deleted: 530879693fe158ee1f3f0f926e7196a93130d53b5a9b87be465da0a96ee85d07
Deleted: 6936675e29b8e66ad5ca911e98034561107323bd10e88ded0bb6f263e06ee137
Deleted: 8dd47b7c59e866b88e8e7ff6d69d27c87be515ff71f00a15db27d42ac7499390
Deleted: 4ed5e46657f3b8f1cf12eba76fffcd51675e063ccd8da83e6693cdb491998b71
Deleted: c82b02e42b44825d2c771eb427939ffc64ffd79817ad72dfe718d24f2ed533c6
Deleted: 76730af2886146056c6c9d93600e93b938455ff19653ab7f6ffbd40002de1ff9
Deleted: 233079ce44e433f00b79f8c2aca140b31dce0310c3897721ce5a4c11b0608913
Deleted: 857ac85df7cae026d46eda305769f1ed35f763d1f724fb2d2001f3faf4ed32df
Build step 'Execute shell' marked build as failure
