See
<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/2258/changes>
Changes:
[idownes] Document authentication prerequisites in docs/release-guide.md.
------------------------------------------
[...truncated 18890 lines...]
I1108 00:34:22.405457 24242 status_update_manager.cpp:279] Closing status
update streams for framework 20141108-003413-3125920579-41765-24224-0000
I1108 00:34:22.405583 24241 gc.cpp:56] Scheduling
'/tmp/MultipleExecutorsTest_ExecutorInfoDiffersOnDifferentSlaves_9bgtMO/slaves/20141108-003413-3125920579-41765-24224-S0/frameworks/20141108-003413-3125920579-41765-24224-0000'
for gc 6.99999530767407days in the future
I1108 00:34:22.405596 24242 status_update_manager.cpp:525] Cleaning up status
update stream for task 092f0aca-6532-4884-9274-6432bea560ed of framework
20141108-003413-3125920579-41765-24224-0000
I1108 00:34:22.406733 24251 slave.cpp:2896] Executor 'default' of framework
20141108-003413-3125920579-41765-24224-0000 exited with status 0
I1108 00:34:22.408874 24251 slave.cpp:2213] Handling status update TASK_LOST
(UUID: 69d301a1-6895-4e0a-a756-d33e21d4504e) for task
c555a8fa-4fee-43d3-a2b2-8841ee428b03 of framework
20141108-003413-3125920579-41765-24224-0000 from @0.0.0.0:0
I1108 00:34:22.408947 24251 slave.cpp:4219] Terminating task
c555a8fa-4fee-43d3-a2b2-8841ee428b03
I1108 00:34:22.409250 24251 slave.cpp:484] Slave terminating
I1108 00:34:22.409303 24251 slave.cpp:1531] Asked to shut down framework
20141108-003413-3125920579-41765-24224-0000 by @0.0.0.0:0
I1108 00:34:22.409323 24251 slave.cpp:1556] Shutting down framework
20141108-003413-3125920579-41765-24224-0000
I1108 00:34:22.409364 24251 slave.cpp:3005] Cleaning up executor 'default' of
framework 20141108-003413-3125920579-41765-24224-0000
I1108 00:34:22.409600 24245 gc.cpp:56] Scheduling
'/tmp/MultipleExecutorsTest_ExecutorInfoDiffersOnDifferentSlaves_zeIIzl/slaves/20141108-003413-3125920579-41765-24224-S1/frameworks/20141108-003413-3125920579-41765-24224-0000/executors/default/runs/e827712d-26ce-4a31-810a-81bf211cb43c'
for gc 6.99999526126222days in the future
I1108 00:34:22.409694 24251 slave.cpp:3082] Cleaning up framework
20141108-003413-3125920579-41765-24224-0000
I1108 00:34:22.409764 24245 gc.cpp:56] Scheduling
'/tmp/MultipleExecutorsTest_ExecutorInfoDiffersOnDifferentSlaves_zeIIzl/slaves/20141108-003413-3125920579-41765-24224-S1/frameworks/20141108-003413-3125920579-41765-24224-0000/executors/default'
for gc 6.99999525888889days in the future
I1108 00:34:22.409788 24244 status_update_manager.cpp:279] Closing status
update streams for framework 20141108-003413-3125920579-41765-24224-0000
I1108 00:34:22.409838 24244 status_update_manager.cpp:525] Cleaning up status
update stream for task c555a8fa-4fee-43d3-a2b2-8841ee428b03 of framework
20141108-003413-3125920579-41765-24224-0000
I1108 00:34:22.409924 24245 gc.cpp:56] Scheduling
'/tmp/MultipleExecutorsTest_ExecutorInfoDiffersOnDifferentSlaves_zeIIzl/slaves/20141108-003413-3125920579-41765-24224-S1/frameworks/20141108-003413-3125920579-41765-24224-0000'
for gc 6.99999525718815days in the future
[ OK ] MultipleExecutorsTest.ExecutorInfoDiffersOnDifferentSlaves (8861
ms)
[----------] 2 tests from MultipleExecutorsTest (11262 ms total)
[----------] 10 tests from ReconciliationTest
[ RUN ] ReconciliationTest.TaskStateMismatch
Using temporary directory '/tmp/ReconciliationTest_TaskStateMismatch_1PKX4d'
I1108 00:34:22.417440 24224 leveldb.cpp:176] Opened db in 3.122873ms
I1108 00:34:22.418473 24224 leveldb.cpp:183] Compacted db in 999477ns
I1108 00:34:22.418527 24224 leveldb.cpp:198] Created db iterator in 5063ns
I1108 00:34:24.455214 24224 leveldb.cpp:204] Seeked to beginning of db in 1400ns
I1108 00:34:24.455238 24224 leveldb.cpp:273] Iterated through 0 keys in the db
in 535ns
I1108 00:34:24.455282 24224 replica.cpp:741] Replica recovered with log
positions 0 -> 0 with 1 holes and 0 unlearned
I1108 00:34:24.455881 24238 recover.cpp:437] Starting replica recovery
I1108 00:34:24.456686 24252 recover.cpp:463] Replica is in EMPTY status
I1108 00:34:24.457906 24240 replica.cpp:638] Replica in EMPTY status received a
broadcasted recover request
I1108 00:34:24.458382 24241 recover.cpp:188] Received a recover response from a
replica in EMPTY status
I1108 00:34:24.458886 24240 recover.cpp:554] Updating replica status to STARTING
I1108 00:34:24.459362 24248 master.cpp:318] Master
20141108-003424-3125920579-41765-24224 (penates.apache.org) started on
67.195.81.186:41765
I1108 00:34:24.459404 24248 master.cpp:364] Master only allowing authenticated
frameworks to register
I1108 00:34:24.459419 24248 master.cpp:369] Master only allowing authenticated
slaves to register
I1108 00:34:24.459444 24248 credentials.hpp:36] Loading credentials for
authentication from
'/tmp/ReconciliationTest_TaskStateMismatch_1PKX4d/credentials'
I1108 00:34:24.459614 24238 leveldb.cpp:306] Persisting metadata (8 bytes) to
leveldb took 631035ns
I1108 00:34:24.459637 24238 replica.cpp:320] Persisted replica status to
STARTING
I1108 00:34:24.459771 24248 master.cpp:408] Authorization enabled
I1108 00:34:24.459830 24250 recover.cpp:463] Replica is in STARTING status
I1108 00:34:24.460089 24251 master.cpp:126] No whitelist given. Advertising
offers for all slaves
I1108 00:34:24.460175 24242 hierarchical_allocator_process.hpp:299]
Initializing hierarchical allocator process with master :
master@67.195.81.186:41765
I1108 00:34:24.460705 24252 replica.cpp:638] Replica in STARTING status
received a broadcasted recover request
I1108 00:34:24.461031 24247 recover.cpp:188] Received a recover response from a
replica in STARTING status
I1108 00:34:24.461269 24245 master.cpp:1258] The newly elected leader is
master@67.195.81.186:41765 with id 20141108-003424-3125920579-41765-24224
I1108 00:34:24.461290 24245 master.cpp:1271] Elected as the leading master!
I1108 00:34:24.461302 24245 master.cpp:1089] Recovering from registrar
I1108 00:34:24.461390 24240 recover.cpp:554] Updating replica status to VOTING
I1108 00:34:24.461416 24243 registrar.cpp:313] Recovering registrar
I1108 00:34:24.461987 24241 leveldb.cpp:306] Persisting metadata (8 bytes) to
leveldb took 473448ns
I1108 00:34:24.462005 24241 replica.cpp:320] Persisted replica status to VOTING
I1108 00:34:24.462110 24253 recover.cpp:568] Successfully joined the Paxos group
I1108 00:34:24.462283 24253 recover.cpp:452] Recover process terminated
I1108 00:34:24.462677 24241 log.cpp:656] Attempting to start the writer
I1108 00:34:24.464035 24238 replica.cpp:474] Replica received implicit promise
request with proposal 1
I1108 00:34:24.464669 24238 leveldb.cpp:306] Persisting metadata (8 bytes) to
leveldb took 603501ns
I1108 00:34:24.464687 24238 replica.cpp:342] Persisted promised to 1
I1108 00:34:24.465205 24249 coordinator.cpp:230] Coordinator attemping to fill
missing position
I1108 00:34:24.466248 24252 replica.cpp:375] Replica received explicit promise
request for position 0 with proposal 2
I1108 00:34:24.466722 24252 leveldb.cpp:343] Persisting action (8 bytes) to
leveldb took 444468ns
I1108 00:34:24.466752 24252 replica.cpp:676] Persisted action at 0
I1108 00:34:24.467676 24252 replica.cpp:508] Replica received write request for
position 0
I1108 00:34:24.467718 24252 leveldb.cpp:438] Reading position from leveldb took
19311ns
I1108 00:34:24.468202 24252 leveldb.cpp:343] Persisting action (14 bytes) to
leveldb took 451123ns
I1108 00:34:24.468230 24252 replica.cpp:676] Persisted action at 0
I1108 00:34:24.468848 24249 replica.cpp:655] Replica received learned notice
for position 0
I1108 00:34:24.469387 24249 leveldb.cpp:343] Persisting action (16 bytes) to
leveldb took 507724ns
I1108 00:34:24.469413 24249 replica.cpp:676] Persisted action at 0
I1108 00:34:24.469434 24249 replica.cpp:661] Replica learned NOP action at
position 0
I1108 00:34:24.470016 24252 log.cpp:672] Writer started with ending position 0
I1108 00:34:24.471254 24252 leveldb.cpp:438] Reading position from leveldb took
26464ns
I1108 00:34:24.474225 24250 registrar.cpp:346] Successfully fetched the
registry (0B) in 12.770048ms
I1108 00:34:24.474338 24250 registrar.cpp:445] Applied 1 operations in 20589ns;
attempting to update the 'registry'
I1108 00:34:24.477193 24245 log.cpp:680] Attempting to append 140 bytes to the
log
I1108 00:34:24.477339 24243 coordinator.cpp:340] Coordinator attempting to
write APPEND action at position 1
I1108 00:34:24.478230 24243 replica.cpp:508] Replica received write request for
position 1
I1108 00:34:24.478772 24243 leveldb.cpp:343] Persisting action (159 bytes) to
leveldb took 509707ns
I1108 00:34:24.478801 24243 replica.cpp:676] Persisted action at 1
I1108 00:34:24.479337 24253 replica.cpp:655] Replica received learned notice
for position 1
I1108 00:34:24.479899 24253 leveldb.cpp:343] Persisting action (161 bytes) to
leveldb took 533186ns
I1108 00:34:24.479925 24253 replica.cpp:676] Persisted action at 1
I1108 00:34:24.479945 24253 replica.cpp:661] Replica learned APPEND action at
position 1
I1108 00:34:24.480875 24245 registrar.cpp:490] Successfully updated the
'registry' in 6.487296ms
I1108 00:34:24.481000 24245 registrar.cpp:376] Successfully recovered registrar
I1108 00:34:24.481161 24248 log.cpp:699] Attempting to truncate the log to 1
I1108 00:34:24.481319 24244 coordinator.cpp:340] Coordinator attempting to
write TRUNCATE action at position 2
I1108 00:34:24.481326 24250 master.cpp:1116] Recovered 0 slaves from the
Registry (102B) ; allowing 10mins for slaves to re-register
I1108 00:34:24.482197 24247 replica.cpp:508] Replica received write request for
position 2
I1108 00:34:24.482740 24247 leveldb.cpp:343] Persisting action (16 bytes) to
leveldb took 513060ns
I1108 00:34:24.482766 24247 replica.cpp:676] Persisted action at 2
I1108 00:34:24.483335 24253 replica.cpp:655] Replica received learned notice
for position 2
I1108 00:34:24.483860 24253 leveldb.cpp:343] Persisting action (18 bytes) to
leveldb took 493795ns
I1108 00:34:24.483916 24253 leveldb.cpp:401] Deleting ~1 keys from leveldb took
29659ns
I1108 00:34:24.483934 24253 replica.cpp:676] Persisted action at 2
I1108 00:34:24.483957 24253 replica.cpp:661] Replica learned TRUNCATE action at
position 2
I1108 00:34:24.496754 24244 slave.cpp:169] Slave started on
63)@67.195.81.186:41765
I1108 00:34:24.496799 24244 credentials.hpp:84] Loading credential for
authentication from
'/tmp/ReconciliationTest_TaskStateMismatch_bxhY1b/credential'
I1108 00:34:24.496942 24244 slave.cpp:276] Slave using credential for:
test-principal
I1108 00:34:24.497194 24244 slave.cpp:289] Slave resources: cpus(*):2;
mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I1108 00:34:24.497294 24244 slave.cpp:318] Slave hostname: penates.apache.org
I1108 00:34:24.497320 24244 slave.cpp:319] Slave checkpoint: false
W1108 00:34:24.497339 24244 slave.cpp:321] Disabling checkpointing is
deprecated and the --checkpoint flag will be removed in a future release.
Please avoid using this flag
I1108 00:34:24.498085 24248 state.cpp:33] Recovering state from
'/tmp/ReconciliationTest_TaskStateMismatch_bxhY1b/meta'
I1108 00:34:24.498370 24250 status_update_manager.cpp:197] Recovering status
update manager
I1108 00:34:24.498723 24242 slave.cpp:3464] Finished recovery
I1108 00:34:24.499240 24242 slave.cpp:602] New master detected at
master@67.195.81.186:41765
I1108 00:34:24.499255 24247 status_update_manager.cpp:171] Pausing sending
status updates
I1108 00:34:24.499294 24242 slave.cpp:665] Authenticating with master
master@67.195.81.186:41765
I1108 00:34:24.499451 24242 slave.cpp:638] Detecting new master
I1108 00:34:24.499490 24248 authenticatee.hpp:133] Creating new client SASL
connection
I1108 00:34:24.499748 24251 master.cpp:3896] Authenticating
slave(63)@67.195.81.186:41765
I1108 00:34:24.562978 24251 master.cpp:3907] Using default CRAM-MD5
authenticator
I1108 00:34:24.501883 24224 sched.cpp:143] Version: 0.22.0
I1108 00:34:24.563323 24239 authenticator.hpp:169] Creating new server SASL
connection
I1108 00:34:24.563503 24250 authenticatee.hpp:224] Received SASL authentication
mechanisms: CRAM-MD5
I1108 00:34:24.563572 24250 authenticatee.hpp:250] Attempting to authenticate
with mechanism 'CRAM-MD5'
I1108 00:34:24.563645 24249 sched.cpp:239] New master detected at
master@67.195.81.186:41765
I1108 00:34:24.563688 24249 sched.cpp:295] Authenticating with master
master@67.195.81.186:41765
I1108 00:34:24.563705 24246 authenticator.hpp:275] Received SASL authentication
start
I1108 00:34:24.563766 24246 authenticator.hpp:397] Authentication requires more
steps
I1108 00:34:24.563865 24252 authenticatee.hpp:133] Creating new client SASL
connection
I1108 00:34:24.563905 24250 authenticatee.hpp:270] Received SASL authentication
step
I1108 00:34:24.564050 24250 authenticator.hpp:303] Received SASL authentication
step
I1108 00:34:24.564069 24252 master.cpp:3896] Authenticating
scheduler-53e601b2-1f73-48a4-b05e-34c80e3375d4@67.195.81.186:41765
I1108 00:34:24.564090 24250 auxprop.cpp:99] Request to lookup properties for
user: 'test-principal' realm: 'penates.apache.org' server FQDN:
'penates.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I1108 00:34:24.564107 24252 master.cpp:3907] Using default CRAM-MD5
authenticator
I1108 00:34:24.564110 24250 auxprop.cpp:171] Looking up auxiliary property
'*userPassword'
I1108 00:34:24.564287 24249 authenticator.hpp:169] Creating new server SASL
connection
I1108 00:34:24.564424 24253 authenticatee.hpp:224] Received SASL authentication
mechanisms: CRAM-MD5
I1108 00:34:24.564450 24253 authenticatee.hpp:250] Attempting to authenticate
with mechanism 'CRAM-MD5'
I1108 00:34:24.564563 24238 authenticator.hpp:275] Received SASL authentication
start
I1108 00:34:24.564610 24238 authenticator.hpp:397] Authentication requires more
steps
I1108 00:34:24.564713 24253 authenticatee.hpp:270] Received SASL authentication
step
I1108 00:34:24.564826 24239 authenticator.hpp:303] Received SASL authentication
step
I1108 00:34:24.564867 24239 auxprop.cpp:99] Request to lookup properties for
user: 'test-principal' realm: 'penates.apache.org' server FQDN:
'penates.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I1108 00:34:24.564884 24239 auxprop.cpp:171] Looking up auxiliary property
'*userPassword'
I1108 00:34:24.564918 24239 auxprop.cpp:171] Looking up auxiliary property
'*cmusaslsecretCRAM-MD5'
I1108 00:34:24.564942 24239 auxprop.cpp:99] Request to lookup properties for
user: 'test-principal' realm: 'penates.apache.org' server FQDN:
'penates.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I1108 00:34:24.564954 24239 auxprop.cpp:121] Skipping auxiliary property
'*userPassword' since SASL_AUXPROP_AUTHZID == true
I1108 00:34:24.564962 24239 auxprop.cpp:121] Skipping auxiliary property
'*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I1108 00:34:24.564980 24239 authenticator.hpp:389] Authentication success
I1108 00:34:24.565052 24238 authenticatee.hpp:310] Authentication success
I1108 00:34:24.565085 24249 master.cpp:3957] Successfully authenticated
principal 'test-principal' at
scheduler-53e601b2-1f73-48a4-b05e-34c80e3375d4@67.195.81.186:41765
I1108 00:34:24.565351 24242 sched.cpp:369] Successfully authenticated with
master master@67.195.81.186:41765
I1108 00:34:24.565385 24242 sched.cpp:488] Sending registration request to
master@67.195.81.186:41765
I1108 00:34:24.565451 24242 sched.cpp:521] Will retry registration in
242.756952ms if necessary
I1108 00:34:24.565544 24245 master.cpp:1378] Received registration request for
framework 'default' at
scheduler-53e601b2-1f73-48a4-b05e-34c80e3375d4@67.195.81.186:41765
I1108 00:34:24.565613 24245 master.cpp:1337] Authorizing framework principal
'test-principal' to receive offers for role '*'
I1108 00:34:24.565986 24245 master.cpp:1442] Registering framework
20141108-003424-3125920579-41765-24224-0000 (default) at
scheduler-53e601b2-1f73-48a4-b05e-34c80e3375d4@67.195.81.186:41765
I1108 00:34:24.566277 24238 hierarchical_allocator_process.hpp:329] Added
framework 20141108-003424-3125920579-41765-24224-0000
I1108 00:34:24.566308 24238 hierarchical_allocator_process.hpp:697] No
resources available to allocate!
I1108 00:34:24.566325 24238 hierarchical_allocator_process.hpp:659] Performed
allocation for 0 slaves in 23387ns
I1108 00:34:24.566411 24251 sched.cpp:419] Framework registered with
20141108-003424-3125920579-41765-24224-0000
I1108 00:34:24.566496 24251 sched.cpp:433] Scheduler::registered took 58638ns
libprocess: crammd5_authenticator(135)@67.195.81.186:41765 terminating due to
std::bad_alloc
I1108 00:34:25.461190 24248 hierarchical_allocator_process.hpp:697] No
resources available to allocate!
I1108 00:34:25.461215 24248 hierarchical_allocator_process.hpp:659] Performed
allocation for 0 slaves in 39901ns
I1108 00:34:26.461902 24248 hierarchical_allocator_process.hpp:697] No
resources available to allocate!
I1108 00:34:26.461941 24248 hierarchical_allocator_process.hpp:659] Performed
allocation for 0 slaves in 54293ns
I1108 00:34:27.463203 24241 hierarchical_allocator_process.hpp:697] No
resources available to allocate!
I1108 00:34:27.463232 24241 hierarchical_allocator_process.hpp:659] Performed
allocation for 0 slaves in 63130ns
I1108 00:34:28.463907 24243 hierarchical_allocator_process.hpp:697] No
resources available to allocate!
I1108 00:34:28.463937 24243 hierarchical_allocator_process.hpp:659] Performed
allocation for 0 slaves in 41884ns
I1108 00:34:29.460595 24241 master.cpp:126] No whitelist given. Advertising
offers for all slaves
I1108 00:34:29.464916 24248 hierarchical_allocator_process.hpp:697] No
resources available to allocate!
I1108 00:34:29.464944 24248 hierarchical_allocator_process.hpp:659] Performed
allocation for 0 slaves in 37613ns
W1108 00:34:29.500293 24243 slave.cpp:739] Authentication timed out
W1108 00:34:29.500740 24249 slave.cpp:703] Failed to authenticate with master
master@67.195.81.186:41765: Authentication discarded
I1108 00:34:29.500828 24249 slave.cpp:665] Authenticating with master
master@67.195.81.186:41765
I1108 00:34:29.501113 24247 authenticatee.hpp:133] Creating new client SASL
connection
I1108 00:34:29.501386 24244 master.cpp:3882] Queuing up authentication request
from slave(63)@67.195.81.186:41765 because authentication is still in progress
W1108 00:34:29.563876 24249 master.cpp:3975] Authentication timed out
I1108 00:34:30.465183 24248 hierarchical_allocator_process.hpp:697] No
resources available to allocate!
I1108 00:34:30.465209 24248 hierarchical_allocator_process.hpp:659] Performed
allocation for 0 slaves in 35544ns
I1108 00:34:31.465688 24247 hierarchical_allocator_process.hpp:697] No
resources available to allocate!
I1108 00:34:31.465719 24247 hierarchical_allocator_process.hpp:659] Performed
allocation for 0 slaves in 37489ns
I1108 00:34:32.466656 24247 hierarchical_allocator_process.hpp:697] No
resources available to allocate!
I1108 00:34:32.466688 24247 hierarchical_allocator_process.hpp:659] Performed
allocation for 0 slaves in 38392ns
I1108 00:34:33.467866 24248 hierarchical_allocator_process.hpp:697] No
resources available to allocate!
I1108 00:34:33.467895 24248 hierarchical_allocator_process.hpp:659] Performed
allocation for 0 slaves in 34854ns
I1108 00:34:34.461773 24242 master.cpp:126] No whitelist given. Advertising
offers for all slaves
I1108 00:34:34.468338 24248 hierarchical_allocator_process.hpp:697] No
resources available to allocate!
I1108 00:34:34.468365 24248 hierarchical_allocator_process.hpp:659] Performed
allocation for 0 slaves in 34786ns
W1108 00:34:34.501731 24239 slave.cpp:739] Authentication timed out
W1108 00:34:34.502092 24242 slave.cpp:703] Failed to authenticate with master
master@67.195.81.186:41765: Authentication discarded
I1108 00:34:34.502177 24242 slave.cpp:665] Authenticating with master
master@67.195.81.186:41765
I1108 00:34:34.502414 24246 authenticatee.hpp:133] Creating new client SASL
connection
I1108 00:34:34.502650 24246 master.cpp:3882] Queuing up authentication request
from slave(63)@67.195.81.186:41765 because authentication is still in progress
tests/reconciliation_tests.cpp:112: Failure
Failed to wait 10secs for update
I1108 00:34:34.568109 24249 master.cpp:784] Framework
20141108-003424-3125920579-41765-24224-0000 (default) at
scheduler-53e601b2-1f73-48a4-b05e-34c80e3375d4@67.195.81.186:41765 disconnected
I1108 00:34:34.568148 24249 master.cpp:1747] Disconnecting framework
20141108-003424-3125920579-41765-24224-0000 (default) at
scheduler-53e601b2-1f73-48a4-b05e-34c80e3375d4@67.195.81.186:41765
I1108 00:34:34.568192 24249 master.cpp:1763] Deactivating framework
20141108-003424-3125920579-41765-24224-0000 (default) at
scheduler-53e601b2-1f73-48a4-b05e-34c80e3375d4@67.195.81.186:41765
I1108 00:34:34.568308 24249 master.cpp:806] Giving framework
20141108-003424-3125920579-41765-24224-0000 (default) at
scheduler-53e601b2-1f73-48a4-b05e-34c80e3375d4@67.195.81.186:41765 0ns to
failover
I1108 00:34:34.568348 24241 hierarchical_allocator_process.hpp:405] Deactivated
framework 20141108-003424-3125920579-41765-24224-0000
tests/reconciliation_tests.cpp:104: Failure
Actual function call count doesn't match EXPECT_CALL(sched,
statusUpdate(&driver, _))...
Expected: to be called once
Actual: never called - unsatisfied and active
tests/reconciliation_tests.cpp:94: Failure
Actual function call count doesn't match EXPECT_CALL(sched,
resourceOffers(&driver, _))...
Expected: to be called at least once
Actual: never called - unsatisfied and active
I1108 00:34:34.568873 24245 master.cpp:3708] Framework failover timeout,
removing framework 20141108-003424-3125920579-41765-24224-0000 (default) at
scheduler-53e601b2-1f73-48a4-b05e-34c80e3375d4@67.195.81.186:41765
I1108 00:34:34.568903 24245 master.cpp:4269] Removing framework
20141108-003424-3125920579-41765-24224-0000 (default) at
scheduler-53e601b2-1f73-48a4-b05e-34c80e3375d4@67.195.81.186:41765
tests/reconciliation_tests.cpp:100: Failure
Actual function call count doesn't match EXPECT_CALL(exec, launchTask(_, _))...
Expected: to be called once
Actual: never called - unsatisfied and active
tests/reconciliation_tests.cpp:98: Failure
Actual function call count doesn't match EXPECT_CALL(exec, registered(_, _, _,
_))...
Expected: to be called once
Actual: never called - unsatisfied and active
I1108 00:34:34.569324 24251 hierarchical_allocator_process.hpp:360] Removed
framework 20141108-003424-3125920579-41765-24224-0000
I1108 00:34:34.569438 24224 master.cpp:693] Master terminating
I1108 00:34:34.569733 24245 slave.cpp:2621] master@67.195.81.186:41765 exited
W1108 00:34:34.569854 24245 slave.cpp:2624] Master disconnected! Waiting for a
new master to be elected
*** Aborted at 1415406874 (unix time) try "date -d @1415406874" if you are
using GNU date ***
PC: @ 0x918a76 mesos::internal::tests::Cluster::Slaves::shutdown()
*** SIGSEGV (@0x48) received by PID 24224 (TID 0x2aebb57a2080) from PID 72;
stack trace: ***
@ 0x2aebbae66340 (unknown)
@ 0x918a76 mesos::internal::tests::Cluster::Slaves::shutdown()
@ 0xe31afc mesos::internal::tests::MesosTest::ShutdownSlaves()
@ 0xe31ac0 mesos::internal::tests::MesosTest::Shutdown()
@ 0xe2f2c7 mesos::internal::tests::MesosTest::TearDown()
@ 0x10f0bca
testing::internal::HandleSehExceptionsInMethodIfSupported<>()
@ 0x10ebd20
testing::internal::HandleExceptionsInMethodIfSupported<>()
@ 0x10d407a testing::Test::Run()
@ 0x10d4754 testing::TestInfo::Run()
@ 0x10d4cdc testing::TestCase::Run()
@ 0x10d99a6 testing::internal::UnitTestImpl::RunAllTests()
@ 0x10f1a3b
testing::internal::HandleSehExceptionsInMethodIfSupported<>()
@ 0x10eca11
testing::internal::HandleExceptionsInMethodIfSupported<>()
@ 0x10d88b2 testing::UnitTest::Run()
@ 0xd4fa8f main
@ 0x2aebbb095ec5 (unknown)
@ 0x8f1259 (unknown)
make[3]: *** [check-local] Segmentation fault
make[3]: Leaving directory
`<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/src'>
make[2]: *** [check-am] Error 2
make[2]: Leaving directory
`<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/src'>
make[1]: *** [check] Error 2
make[1]: Leaving directory
`<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/src'>
make: *** [check-recursive] Error 1
Test finished
Exit status: 2
Build step 'Execute shell' marked build as failure
Recording test results
