See <https://builds.apache.org/job/mesos-reviewbot/15823/>
------------------------------------------
[...truncated 76194 lines...]
I1026 09:12:10.921105 29425 slave.cpp:346] Agent using credential for:
test-principal
I1026 09:12:10.921135 29425 credentials.hpp:37] Loading credentials for
authentication from
'/tmp/MasterMaintenanceTest_InverseOffersFilters_BaJ7py/http_credentials'
I1026 09:12:10.921407 29425 http.cpp:887] Using default 'basic' HTTP
authenticator for realm 'mesos-agent-readonly'
I1026 09:12:10.921604 29425 http.cpp:887] Using default 'basic' HTTP
authenticator for realm 'mesos-agent-readwrite'
I1026 09:12:10.922726 29425 slave.cpp:533] Agent resources: cpus(*):2;
mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I1026 09:12:10.922802 29425 slave.cpp:541] Agent attributes: [ ]
I1026 09:12:10.922821 29425 slave.cpp:546] Agent hostname: maintenance-host-2
I1026 09:12:10.924258 29426 state.cpp:57] Recovering state from
'/tmp/MasterMaintenanceTest_InverseOffersFilters_VmOqQP/meta'
I1026 09:12:10.924551 29422 status_update_manager.cpp:203] Recovering status
update manager
I1026 09:12:10.924875 29422 slave.cpp:5399] Finished recovery
I1026 09:12:10.948169 29422 slave.cpp:5573] Querying resource estimator for
oversubscribable resources
I1026 09:12:10.948447 29424 slave.cpp:5587] Received oversubscribable resources
{} from the resource estimator
I1026 09:12:10.948631 29424 slave.cpp:915] New master detected at
[email protected]:41192
I1026 09:12:10.948658 29424 slave.cpp:974] Authenticating with master
[email protected]:41192
I1026 09:12:10.948727 29424 slave.cpp:985] Using default CRAM-MD5 authenticatee
I1026 09:12:10.948743 29426 status_update_manager.cpp:177] Pausing sending
status updates
I1026 09:12:10.948876 29424 slave.cpp:947] Detecting new master
I1026 09:12:10.948973 29423 authenticatee.cpp:121] Creating new client SASL
connection
I1026 09:12:10.949300 29418 master.cpp:6721] Authenticating
slave(147)@172.17.0.3:41192
I1026 09:12:10.949406 29417 authenticator.cpp:414] Starting authentication
session for crammd5-authenticatee(353)@172.17.0.3:41192
I1026 09:12:10.949633 29424 authenticator.cpp:98] Creating new server SASL
connection
I1026 09:12:10.949879 29425 authenticatee.cpp:213] Received SASL authentication
mechanisms: CRAM-MD5
I1026 09:12:10.949908 29425 authenticatee.cpp:239] Attempting to authenticate
with mechanism 'CRAM-MD5'
I1026 09:12:10.950042 29415 authenticator.cpp:204] Received SASL authentication
start
I1026 09:12:10.950104 29415 authenticator.cpp:326] Authentication requires more
steps
I1026 09:12:10.950217 29428 authenticatee.cpp:259] Received SASL authentication
step
I1026 09:12:10.950350 29423 authenticator.cpp:232] Received SASL authentication
step
I1026 09:12:10.950384 29423 auxprop.cpp:109] Request to lookup properties for
user: 'test-principal' realm: 'd2e1f8f02410' server FQDN: 'd2e1f8f02410'
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false
SASL_AUXPROP_AUTHZID: false
I1026 09:12:10.950402 29423 auxprop.cpp:181] Looking up auxiliary property
'*userPassword'
I1026 09:12:10.950449 29423 auxprop.cpp:181] Looking up auxiliary property
'*cmusaslsecretCRAM-MD5'
I1026 09:12:10.950481 29423 auxprop.cpp:109] Request to lookup properties for
user: 'test-principal' realm: 'd2e1f8f02410' server FQDN: 'd2e1f8f02410'
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false
SASL_AUXPROP_AUTHZID: true
I1026 09:12:10.950498 29423 auxprop.cpp:131] Skipping auxiliary property
'*userPassword' since SASL_AUXPROP_AUTHZID == true
I1026 09:12:10.950513 29423 auxprop.cpp:131] Skipping auxiliary property
'*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I1026 09:12:10.950536 29423 authenticator.cpp:318] Authentication success
I1026 09:12:10.950618 29428 authenticatee.cpp:299] Authentication success
I1026 09:12:10.950662 29417 master.cpp:6751] Successfully authenticated
principal 'test-principal' at slave(147)@172.17.0.3:41192
I1026 09:12:10.950754 29416 authenticator.cpp:432] Authentication session
cleanup for crammd5-authenticatee(353)@172.17.0.3:41192
I1026 09:12:10.950997 29423 slave.cpp:1069] Successfully authenticated with
master [email protected]:41192
I1026 09:12:10.951161 29423 slave.cpp:1483] Will retry registration in
18.848129ms if necessary
I1026 09:12:10.951377 29428 master.cpp:5141] Registering agent at
slave(147)@172.17.0.3:41192 (maintenance-host-2) with id
f87112a9-2717-4cd0-b3c2-053d5e6b02da-S1
I1026 09:12:10.951896 29429 registrar.cpp:461] Applied 1 operations in 78927ns;
attempting to update the registry
I1026 09:12:10.956156 29420 leveldb.cpp:341] Persisting action (16 bytes) to
leveldb took 46.269052ms
I1026 09:12:10.956204 29420 replica.cpp:708] Persisted action TRUNCATE at
position 4
I1026 09:12:10.956907 29416 replica.cpp:691] Replica received learned notice
for position 4 from @0.0.0.0:0
I1026 09:12:10.971041 29430 slave.cpp:1483] Will retry registration in
13.700315ms if necessary
I1026 09:12:10.971145 29425 master.cpp:5129] Ignoring register agent message
from slave(147)@172.17.0.3:41192 (maintenance-host-2) as admission is already
in progress
I1026 09:12:10.985831 29421 slave.cpp:1483] Will retry registration in
44.564892ms if necessary
I1026 09:12:10.986018 29417 master.cpp:5129] Ignoring register agent message
from slave(147)@172.17.0.3:41192 (maintenance-host-2) as admission is already
in progress
I1026 09:12:11.006906 29416 leveldb.cpp:341] Persisting action (18 bytes) to
leveldb took 49.905064ms
I1026 09:12:11.007026 29416 leveldb.cpp:399] Deleting ~2 keys from leveldb took
69557ns
I1026 09:12:11.007058 29416 replica.cpp:708] Persisted action TRUNCATE at
position 4
I1026 09:12:11.008445 29428 log.cpp:577] Attempting to append 513 bytes to the
log
I1026 09:12:11.008702 29424 coordinator.cpp:348] Coordinator attempting to
write APPEND action at position 5
I1026 09:12:11.009790 29425 replica.cpp:537] Replica received write request for
position 5 from __req_res__(2487)@172.17.0.3:41192
I1026 09:12:11.031538 29424 slave.cpp:1483] Will retry registration in
153.239415ms if necessary
I1026 09:12:11.031754 29421 master.cpp:5129] Ignoring register agent message
from slave(147)@172.17.0.3:41192 (maintenance-host-2) as admission is already
in progress
I1026 09:12:11.073273 29425 leveldb.cpp:341] Persisting action (532 bytes) to
leveldb took 63.413809ms
I1026 09:12:11.073617 29425 replica.cpp:708] Persisted action APPEND at
position 5
I1026 09:12:11.075656 29419 replica.cpp:691] Replica received learned notice
for position 5 from @0.0.0.0:0
I1026 09:12:11.124006 29419 leveldb.cpp:341] Persisting action (534 bytes) to
leveldb took 47.916575ms
I1026 09:12:11.124512 29419 replica.cpp:708] Persisted action APPEND at
position 5
I1026 09:12:11.127339 29430 registrar.cpp:506] Successfully updated the
registry in 175.368192ms
I1026 09:12:11.127913 29423 log.cpp:596] Attempting to truncate the log to 5
I1026 09:12:11.128443 29423 coordinator.cpp:348] Coordinator attempting to
write TRUNCATE action at position 6
I1026 09:12:11.128530 29430 master.cpp:5212] Registered agent
f87112a9-2717-4cd0-b3c2-053d5e6b02da-S1 at slave(147)@172.17.0.3:41192
(maintenance-host-2) with cpus(*):2; mem(*):1024; disk(*):1024;
ports(*):[31000-32000]
I1026 09:12:11.128990 29424 slave.cpp:1115] Registered with master
[email protected]:41192; given agent ID f87112a9-2717-4cd0-b3c2-053d5e6b02da-S1
I1026 09:12:11.129107 29424 fetcher.cpp:86] Clearing fetcher cache
I1026 09:12:11.129278 29427 hierarchical.cpp:485] Added agent
f87112a9-2717-4cd0-b3c2-053d5e6b02da-S1 (maintenance-host-2) with cpus(*):2;
mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {})
I1026 09:12:11.129715 29421 replica.cpp:537] Replica received write request for
position 6 from __req_res__(2488)@172.17.0.3:41192
I1026 09:12:11.129825 29427 hierarchical.cpp:1694] No allocations performed
I1026 09:12:11.129343 29417 status_update_manager.cpp:184] Resuming sending
status updates
I1026 09:12:11.129895 29427 hierarchical.cpp:1309] Performed allocation for
agent f87112a9-2717-4cd0-b3c2-053d5e6b02da-S1 in 231885ns
I1026 09:12:11.129621 29424 slave.cpp:1138] Checkpointing SlaveInfo to
'/tmp/MasterMaintenanceTest_InverseOffersFilters_VmOqQP/meta/slaves/f87112a9-2717-4cd0-b3c2-053d5e6b02da-S1/slave.info'
I1026 09:12:11.130337 29424 slave.cpp:1175] Forwarding total oversubscribed
resources {}
I1026 09:12:11.130450 29424 slave.cpp:4251] Received ping from
slave-observer(148)@172.17.0.3:41192
I1026 09:12:11.130524 29426 master.cpp:5611] Received update of agent
f87112a9-2717-4cd0-b3c2-053d5e6b02da-S1 at slave(147)@172.17.0.3:41192
(maintenance-host-2) with total oversubscribed resources {}
I1026 09:12:11.130825 29419 hierarchical.cpp:555] Agent
f87112a9-2717-4cd0-b3c2-053d5e6b02da-S1 (maintenance-host-2) updated with
oversubscribed resources {} (total: cpus(*):2; mem(*):1024; disk(*):1024;
ports(*):[31000-32000], allocated: {})
I1026 09:12:11.130970 29419 hierarchical.cpp:1694] No allocations performed
I1026 09:12:11.131029 29419 hierarchical.cpp:1309] Performed allocation for
agent f87112a9-2717-4cd0-b3c2-053d5e6b02da-S1 in 166785ns
I1026 09:12:11.131865 29416 process.cpp:3570] Handling HTTP event for process
'master' with path: '/master/maintenance/schedule'
I1026 09:12:11.132925 29416 http.cpp:382] HTTP POST for
/master/maintenance/schedule from 172.17.0.3:39840
I1026 09:12:11.134021 29418 registrar.cpp:461] Applied 1 operations in
236371ns; attempting to update the registry
I1026 09:12:11.190412 29421 leveldb.cpp:341] Persisting action (16 bytes) to
leveldb took 60.640847ms
I1026 09:12:11.190778 29421 replica.cpp:708] Persisted action TRUNCATE at
position 6
I1026 09:12:11.191874 29416 replica.cpp:691] Replica received learned notice
for position 6 from @0.0.0.0:0
I1026 09:12:11.224493 29416 leveldb.cpp:341] Persisting action (18 bytes) to
leveldb took 32.566085ms
I1026 09:12:11.224640 29416 leveldb.cpp:399] Deleting ~2 keys from leveldb took
77242ns
I1026 09:12:11.224695 29416 replica.cpp:708] Persisted action TRUNCATE at
position 6
I1026 09:12:11.225970 29419 log.cpp:577] Attempting to append 732 bytes to the
log
I1026 09:12:11.226294 29420 coordinator.cpp:348] Coordinator attempting to
write APPEND action at position 7
I1026 09:12:11.227367 29427 replica.cpp:537] Replica received write request for
position 7 from __req_res__(2489)@172.17.0.3:41192
I1026 09:12:11.250510 29427 leveldb.cpp:341] Persisting action (751 bytes) to
leveldb took 23.081608ms
I1026 09:12:11.250607 29427 replica.cpp:708] Persisted action APPEND at
position 7
I1026 09:12:11.251489 29420 replica.cpp:691] Replica received learned notice
for position 7 from @0.0.0.0:0
I1026 09:12:11.297765 29420 leveldb.cpp:341] Persisting action (753 bytes) to
leveldb took 46.22007ms
I1026 09:12:11.298153 29420 replica.cpp:708] Persisted action APPEND at
position 7
I1026 09:12:11.302320 29428 registrar.cpp:506] Successfully updated the
registry in 168.193024ms
I1026 09:12:11.303436 29428 master.cpp:5673] Updating unavailability of agent
f87112a9-2717-4cd0-b3c2-053d5e6b02da-S0 at slave(146)@172.17.0.3:41192
(maintenance-host), starting at 2447.91267547848weeks
I1026 09:12:11.302541 29416 log.cpp:596] Attempting to truncate the log to 7
I1026 09:12:11.303989 29422 coordinator.cpp:348] Coordinator attempting to
write TRUNCATE action at position 8
I1026 09:12:11.304139 29428 master.cpp:5673] Updating unavailability of agent
f87112a9-2717-4cd0-b3c2-053d5e6b02da-S1 at slave(147)@172.17.0.3:41192
(maintenance-host-2), starting at 2447.91267547848weeks
I1026 09:12:11.304421 29426 hierarchical.cpp:1694] No allocations performed
I1026 09:12:11.304486 29426 hierarchical.cpp:1309] Performed allocation for
agent f87112a9-2717-4cd0-b3c2-053d5e6b02da-S0 in 277140ns
I1026 09:12:11.304729 29426 hierarchical.cpp:1694] No allocations performed
I1026 09:12:11.304800 29426 hierarchical.cpp:1309] Performed allocation for
agent f87112a9-2717-4cd0-b3c2-053d5e6b02da-S1 in 208919ns
I1026 09:12:11.305166 29417 replica.cpp:537] Replica received write request for
position 8 from __req_res__(2490)@172.17.0.3:41192
I1026 09:12:11.307098 29396 scheduler.cpp:176] Version: 1.2.0
I1026 09:12:11.307960 29420 scheduler.cpp:465] New master detected at
[email protected]:41192
I1026 09:12:11.308013 29420 scheduler.cpp:474] Waiting for 0ns before
initiating a re-(connection) attempt with the master
I1026 09:12:11.311344 29421 scheduler.cpp:353] Connected with the master at
http://172.17.0.3:41192/master/api/v1/scheduler
I1026 09:12:11.313486 29428 scheduler.cpp:235] Sending SUBSCRIBE call to
http://172.17.0.3:41192/master/api/v1/scheduler
I1026 09:12:11.314959 29420 process.cpp:3570] Handling HTTP event for process
'master' with path: '/master/api/v1/scheduler'
I1026 09:12:11.315950 29429 http.cpp:382] HTTP POST for
/master/api/v1/scheduler from 172.17.0.3:39862
I1026 09:12:11.316169 29429 master.cpp:2329] Received subscription request for
HTTP framework 'default'
I1026 09:12:11.316257 29429 master.cpp:2069] Authorizing framework principal
'test-principal' to receive offers for role '*'
I1026 09:12:11.316704 29428 master.cpp:2427] Subscribing framework 'default'
with checkpointing disabled and capabilities [ ]
I1026 09:12:11.317356 29420 hierarchical.cpp:275] Added framework
f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000
I1026 09:12:11.317394 29427 master.hpp:2161] Sending heartbeat to
f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000
I1026 09:12:11.318658 29429 scheduler.cpp:671] Enqueuing event SUBSCRIBED
received from http://172.17.0.3:41192/master/api/v1/scheduler
I1026 09:12:11.319290 29429 scheduler.cpp:671] Enqueuing event HEARTBEAT
received from http://172.17.0.3:41192/master/api/v1/scheduler
I1026 09:12:11.319795 29420 hierarchical.cpp:1286] Performed allocation for 2
agents in 2.402906ms
I1026 09:12:11.320317 29426 master.cpp:6550] Sending 2 offers to framework
f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000 (default)
I1026 09:12:11.321080 29426 master.cpp:6640] Sending 2 inverse offers to
framework f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000 (default)
I1026 09:12:11.322999 29415 scheduler.cpp:671] Enqueuing event OFFERS received
from http://172.17.0.3:41192/master/api/v1/scheduler
I1026 09:12:11.324296 29415 scheduler.cpp:671] Enqueuing event INVERSE_OFFERS
received from http://172.17.0.3:41192/master/api/v1/scheduler
I1026 09:12:11.339918 29417 leveldb.cpp:341] Persisting action (16 bytes) to
leveldb took 34.686527ms
I1026 09:12:11.339988 29417 replica.cpp:708] Persisted action TRUNCATE at
position 8
I1026 09:12:11.340968 29429 replica.cpp:691] Replica received learned notice
for position 8 from @0.0.0.0:0
I1026 09:12:11.373638 29429 leveldb.cpp:341] Persisting action (18 bytes) to
leveldb took 32.621461ms
I1026 09:12:11.373769 29429 leveldb.cpp:399] Deleting ~2 keys from leveldb took
65011ns
I1026 09:12:11.373800 29429 replica.cpp:708] Persisted action TRUNCATE at
position 8
I1026 09:12:11.376577 29416 hierarchical.cpp:1694] No allocations performed
I1026 09:12:11.376962 29416 hierarchical.cpp:1286] Performed allocation for 2
agents in 611096ns
I1026 09:12:11.378165 29430 scheduler.cpp:235] Sending ACCEPT call to
http://172.17.0.3:41192/master/api/v1/scheduler
I1026 09:12:11.378701 29430 scheduler.cpp:235] Sending ACCEPT call to
http://172.17.0.3:41192/master/api/v1/scheduler
I1026 09:12:11.379806 29424 process.cpp:3570] Handling HTTP event for process
'master' with path: '/master/api/v1/scheduler'
I1026 09:12:11.380379 29429 process.cpp:3570] Handling HTTP event for process
'master' with path: '/master/api/v1/scheduler'
I1026 09:12:11.381045 29418 http.cpp:382] HTTP POST for
/master/api/v1/scheduler from 172.17.0.3:39861
I1026 09:12:11.381953 29418 master.cpp:3571] Processing ACCEPT call for offers:
[ f87112a9-2717-4cd0-b3c2-053d5e6b02da-O0 ] on agent
f87112a9-2717-4cd0-b3c2-053d5e6b02da-S0 at slave(146)@172.17.0.3:41192
(maintenance-host) for framework f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000
(default)
I1026 09:12:11.382108 29418 master.cpp:3163] Authorizing framework principal
'test-principal' to launch task 8c49a523-b5bc-401a-9680-ee8dcc4b4197
I1026 09:12:11.383177 29418 http.cpp:382] HTTP POST for
/master/api/v1/scheduler from 172.17.0.3:39861
I1026 09:12:11.383800 29418 master.cpp:3571] Processing ACCEPT call for offers:
[ f87112a9-2717-4cd0-b3c2-053d5e6b02da-O1 ] on agent
f87112a9-2717-4cd0-b3c2-053d5e6b02da-S1 at slave(147)@172.17.0.3:41192
(maintenance-host-2) for framework f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000
(default)
I1026 09:12:11.383900 29418 master.cpp:3163] Authorizing framework principal
'test-principal' to launch task e7e80d5a-9eda-498a-b564-5ce85046e314
W1026 09:12:11.385854 29418 validation.cpp:920] Executor 'executor-1' for task
'8c49a523-b5bc-401a-9680-ee8dcc4b4197' uses less CPUs (None) than the minimum
required (0.01). Please update your executor, as this will be mandatory in
future releases.
W1026 09:12:11.385900 29418 validation.cpp:932] Executor 'executor-1' for task
'8c49a523-b5bc-401a-9680-ee8dcc4b4197' uses less memory (None) than the minimum
required (32MB). Please update your executor, as this will be mandatory in
future releases.
I1026 09:12:11.386417 29418 master.cpp:8313] Adding task
8c49a523-b5bc-401a-9680-ee8dcc4b4197 with resources cpus(*):2; mem(*):1024;
disk(*):1024; ports(*):[31000-32000] on agent
f87112a9-2717-4cd0-b3c2-053d5e6b02da-S0 (maintenance-host)
I1026 09:12:11.386750 29418 master.cpp:4220] Launching task
8c49a523-b5bc-401a-9680-ee8dcc4b4197 of framework
f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000 (default) with resources cpus(*):2;
mem(*):1024; disk(*):1024; ports(*):[31000-32000] on agent
f87112a9-2717-4cd0-b3c2-053d5e6b02da-S0 at slave(146)@172.17.0.3:41192
(maintenance-host)
I1026 09:12:11.387287 29416 slave.cpp:1547] Got assigned task
'8c49a523-b5bc-401a-9680-ee8dcc4b4197' for framework
f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000
W1026 09:12:11.388201 29418 validation.cpp:920] Executor 'executor-2' for task
'e7e80d5a-9eda-498a-b564-5ce85046e314' uses less CPUs (None) than the minimum
required (0.01). Please update your executor, as this will be mandatory in
future releases.
W1026 09:12:11.388240 29418 validation.cpp:932] Executor 'executor-2' for task
'e7e80d5a-9eda-498a-b564-5ce85046e314' uses less memory (None) than the minimum
required (32MB). Please update your executor, as this will be mandatory in
future releases.
I1026 09:12:11.388604 29416 slave.cpp:1709] Launching task
'8c49a523-b5bc-401a-9680-ee8dcc4b4197' for framework
f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000
I1026 09:12:11.388784 29418 master.cpp:8313] Adding task
e7e80d5a-9eda-498a-b564-5ce85046e314 with resources cpus(*):2; mem(*):1024;
disk(*):1024; ports(*):[31000-32000] on agent
f87112a9-2717-4cd0-b3c2-053d5e6b02da-S1 (maintenance-host-2)
I1026 09:12:11.389137 29418 master.cpp:4220] Launching task
e7e80d5a-9eda-498a-b564-5ce85046e314 of framework
f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000 (default) with resources cpus(*):2;
mem(*):1024; disk(*):1024; ports(*):[31000-32000] on agent
f87112a9-2717-4cd0-b3c2-053d5e6b02da-S1 at slave(147)@172.17.0.3:41192
(maintenance-host-2)
I1026 09:12:11.389695 29420 slave.cpp:1547] Got assigned task
'e7e80d5a-9eda-498a-b564-5ce85046e314' for framework
f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000
I1026 09:12:11.390274 29416 paths.cpp:536] Trying to chown
'/tmp/MasterMaintenanceTest_InverseOffersFilters_PKN3lY/slaves/f87112a9-2717-4cd0-b3c2-053d5e6b02da-S0/frameworks/f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000/executors/executor-1/runs/01da3fa6-c5d0-44bf-b772-273f2afc7cce'
to user 'mesos'
I1026 09:12:11.394512 29420 slave.cpp:1709] Launching task
'e7e80d5a-9eda-498a-b564-5ce85046e314' for framework
f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000
I1026 09:12:11.395493 29420 paths.cpp:536] Trying to chown
'/tmp/MasterMaintenanceTest_InverseOffersFilters_VmOqQP/slaves/f87112a9-2717-4cd0-b3c2-053d5e6b02da-S1/frameworks/f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000/executors/executor-2/runs/b939535e-9b29-4c3e-a954-69c01af50b19'
to user 'mesos'
I1026 09:12:11.401736 29416 slave.cpp:6307] Launching executor 'executor-1' of
framework f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000 with resources {} in work
directory
'/tmp/MasterMaintenanceTest_InverseOffersFilters_PKN3lY/slaves/f87112a9-2717-4cd0-b3c2-053d5e6b02da-S0/frameworks/f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000/executors/executor-1/runs/01da3fa6-c5d0-44bf-b772-273f2afc7cce'
I1026 09:12:11.404594 29420 slave.cpp:6307] Launching executor 'executor-2' of
framework f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000 with resources {} in work
directory
'/tmp/MasterMaintenanceTest_InverseOffersFilters_VmOqQP/slaves/f87112a9-2717-4cd0-b3c2-053d5e6b02da-S1/frameworks/f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000/executors/executor-2/runs/b939535e-9b29-4c3e-a954-69c01af50b19'
*** Aborted at 1477473131 (unix time) try "date -d @1477473131" if you are
using GNU date ***
PC: @ 0x2b46299cf82d (unknown)
*** SIGSEGV (@0x15e1) received by PID 29396 (TID 0x2b46325f8700) from PID 5601;
stack trace: ***
I1026 09:12:11.405750 29416 exec.cpp:162] Version: 1.2.0
I1026 09:12:11.406443 29417 exec.cpp:212] Executor started at:
executor(60)@172.17.0.3:41192 with pid 29396
I1026 09:12:11.406718 29416 slave.cpp:2031] Queued task
'8c49a523-b5bc-401a-9680-ee8dcc4b4197' for executor 'executor-1' of framework
f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000
I1026 09:12:11.406826 29416 slave.cpp:868] Successfully attached file
'/tmp/MasterMaintenanceTest_InverseOffersFilters_PKN3lY/slaves/f87112a9-2717-4cd0-b3c2-053d5e6b02da-S0/frameworks/f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000/executors/executor-1/runs/01da3fa6-c5d0-44bf-b772-273f2afc7cce'
@ 0x2b467a5b82c7 (unknown)
I1026 09:12:11.407135 29416 slave.cpp:3305] Got registration for executor
'executor-1' of framework f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000 from
executor(60)@172.17.0.3:41192
@ 0x2b467a5bc5a9 (unknown)
I1026 09:12:11.408118 29415 exec.cpp:237] Executor registered on agent
f87112a9-2717-4cd0-b3c2-053d5e6b02da-S0
I1026 09:12:11.408190 29415 exec.cpp:249] Executor::registered took 37735ns
@ 0x2b4629786330 (unknown)
I1026 09:12:11.408432 29416 slave.cpp:2247] Sending queued task
'8c49a523-b5bc-401a-9680-ee8dcc4b4197' to executor 'executor-1' of framework
f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000 at executor(60)@172.17.0.3:41192
@ 0x2b46299cf82d (unknown)
I1026 09:12:11.408862 29425 exec.cpp:324] Executor asked to run task
'8c49a523-b5bc-401a-9680-ee8dcc4b4197'
I1026 09:12:11.408972 29425 exec.cpp:333] Executor::launchTask took 83548ns
I1026 09:12:11.409082 29425 exec.cpp:550] Executor sending status update
TASK_RUNNING (UUID: f087d461-1831-42f6-bf10-650bd9b2ebf1) for task
8c49a523-b5bc-401a-9680-ee8dcc4b4197 of framework
f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000
I1026 09:12:11.409405 29415 slave.cpp:3740] Handling status update TASK_RUNNING
(UUID: f087d461-1831-42f6-bf10-650bd9b2ebf1) for task
8c49a523-b5bc-401a-9680-ee8dcc4b4197 of framework
f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000 from executor(60)@172.17.0.3:41192
I1026 09:12:11.410022 29416 status_update_manager.cpp:323] Received status
update TASK_RUNNING (UUID: f087d461-1831-42f6-bf10-650bd9b2ebf1) for task
8c49a523-b5bc-401a-9680-ee8dcc4b4197 of framework
f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000
I1026 09:12:11.410073 29416 status_update_manager.cpp:500] Creating
StatusUpdate stream for task 8c49a523-b5bc-401a-9680-ee8dcc4b4197 of framework
f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000
I1026 09:12:11.410713 29416 status_update_manager.cpp:377] Forwarding update
TASK_RUNNING (UUID: f087d461-1831-42f6-bf10-650bd9b2ebf1) for task
8c49a523-b5bc-401a-9680-ee8dcc4b4197 of framework
f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000 to the agent
I1026 09:12:11.411036 29415 slave.cpp:4169] Forwarding the update TASK_RUNNING
(UUID: f087d461-1831-42f6-bf10-650bd9b2ebf1) for task
8c49a523-b5bc-401a-9680-ee8dcc4b4197 of framework
f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000 to [email protected]:41192
I1026 09:12:11.411252 29415 slave.cpp:4063] Status update manager successfully
handled status update TASK_RUNNING (UUID: f087d461-1831-42f6-bf10-650bd9b2ebf1)
for task 8c49a523-b5bc-401a-9680-ee8dcc4b4197 of framework
f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000
I1026 09:12:11.411301 29415 slave.cpp:4079] Sending acknowledgement for status
update TASK_RUNNING (UUID: f087d461-1831-42f6-bf10-650bd9b2ebf1) for task
8c49a523-b5bc-401a-9680-ee8dcc4b4197 of framework
f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000 to executor(60)@172.17.0.3:41192
@ 0xa44b0a os::getenv()
I1026 09:12:11.411638 29430 exec.cpp:373] Executor received status update
acknowledgement f087d461-1831-42f6-bf10-650bd9b2ebf1 for task
8c49a523-b5bc-401a-9680-ee8dcc4b4197 of framework
f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000
I1026 09:12:11.411656 29422 master.cpp:5747] Status update TASK_RUNNING (UUID:
f087d461-1831-42f6-bf10-650bd9b2ebf1) for task
8c49a523-b5bc-401a-9680-ee8dcc4b4197 of framework
f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000 from agent
f87112a9-2717-4cd0-b3c2-053d5e6b02da-S0 at slave(146)@172.17.0.3:41192
(maintenance-host)
I1026 09:12:11.411752 29422 master.cpp:5809] Forwarding status update
TASK_RUNNING (UUID: f087d461-1831-42f6-bf10-650bd9b2ebf1) for task
8c49a523-b5bc-401a-9680-ee8dcc4b4197 of framework
f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000
I1026 09:12:11.412415 29422 master.cpp:7691] Updating the state of task
8c49a523-b5bc-401a-9680-ee8dcc4b4197 of framework
f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000 (latest state: TASK_RUNNING, status
update state: TASK_RUNNING)
I1026 09:12:11.414038 29423 scheduler.cpp:671] Enqueuing event UPDATE received
from http://172.17.0.3:41192/master/api/v1/scheduler
I1026 09:12:11.419975 29419 scheduler.cpp:235] Sending ACKNOWLEDGE call to
http://172.17.0.3:41192/master/api/v1/scheduler
@ 0x2b4626a54b45 mesos::internal::slave::executorEnvironment()
I1026 09:12:11.429736 29427 process.cpp:3570] Handling HTTP event for process
'master' with path: '/master/api/v1/scheduler'
I1026 09:12:11.431152 29429 http.cpp:382] HTTP POST for
/master/api/v1/scheduler from 172.17.0.3:39861
I1026 09:12:11.431560 29429 master.cpp:4857] Processing ACKNOWLEDGE call
f087d461-1831-42f6-bf10-650bd9b2ebf1 for task
8c49a523-b5bc-401a-9680-ee8dcc4b4197 of framework
f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000 (default) on agent
f87112a9-2717-4cd0-b3c2-053d5e6b02da-S0
I1026 09:12:11.432637 29429 status_update_manager.cpp:395] Received status
update acknowledgement (UUID: f087d461-1831-42f6-bf10-650bd9b2ebf1) for task
8c49a523-b5bc-401a-9680-ee8dcc4b4197 of framework
f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000
@ 0x2b4626a4fb54 mesos::internal::slave::Framework::launchExecutor()
I1026 09:12:11.433141 29429 slave.cpp:3022] Status update manager successfully
handled status update acknowledgement (UUID:
f087d461-1831-42f6-bf10-650bd9b2ebf1) for task
8c49a523-b5bc-401a-9680-ee8dcc4b4197 of framework
f87112a9-2717-4cd0-b3c2-053d5e6b02da-0000
@ 0x2b4626a2b24b mesos::internal::slave::Slave::_run()
@ 0x2b4626a8225b
_ZZN7process8dispatchIN5mesos8internal5slave5SlaveERKNS_6FutureIbEERKNS1_13FrameworkInfoERKNS1_12ExecutorInfoERK6OptionINS1_8TaskInfoEERKSF_INS1_13TaskGroupInfoEES6_S9_SC_SH_SL_EEvRKNS_3PIDIT_EEMSP_FvT0_T1_T2_T3_T4_ET5_T6_T7_T8_T9_ENKUlPNS_11ProcessBaseEE_clES16_
@ 0x2b4626ab5a59
_ZNSt17_Function_handlerIFvPN7process11ProcessBaseEEZNS0_8dispatchIN5mesos8internal5slave5SlaveERKNS0_6FutureIbEERKNS5_13FrameworkInfoERKNS5_12ExecutorInfoERK6OptionINS5_8TaskInfoEERKSJ_INS5_13TaskGroupInfoEESA_SD_SG_SL_SP_EEvRKNS0_3PIDIT_EEMST_FvT0_T1_T2_T3_T4_ET5_T6_T7_T8_T9_EUlS2_E_E9_M_invokeERKSt9_Any_dataS2_
@ 0x2b46276918d7 std::function<>::operator()()
@ 0x2b4627674199 process::ProcessBase::visit()
@ 0x2b462767c678 process::DispatchEvent::visit()
@ 0xa18962 process::ProcessBase::serve()
@ 0x2b4627670486 process::ProcessManager::resume()
@ 0x2b462766cfc5 _ZZN7process14ProcessManager12init_threadsEvENKUt_clEv
@ 0x2b462767be20
_ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE
@ 0x2b462767bd77
_ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEclEv
@ 0x2b462767bd10
_ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEE6_M_runEv
@ 0x2b4629007a60 (unknown)
@ 0x2b462977e184 start_thread
@ 0x2b4629a8e37d (unknown)
make[4]: *** [check-local] Segmentation fault
make[4]: Leaving directory `/mesos/mesos-1.2.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.2.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.2.0/_build/src'
make[1]: Leaving directory `/mesos/mesos-1.2.0/_build'
make[1]: *** [check-recursive] Error 1
make: *** [distcheck] Error 1
+ docker rmi mesos-1477470377-27242
Untagged: mesos-1477470377-27242:latest
Deleted: sha256:508e7d6ca6a9f27141ec9df0c8e07bde51cfccb1cf9400435db6dbe83d3dc506
Deleted: sha256:bee6b99e00f342d19687e2cfbb3f4374d968024cc076d887ab4551c5d9da716e
Deleted: sha256:9b95131bcb4fa18dbae973b95561f71147bc2b09908f37f295870eca5773aed2
Deleted: sha256:ad004541ab7e43916af17d0eb1c82127ce33b9f59300ebf23938ee87deec08c4
Deleted: sha256:96186209d119cff6db874f556bf4d5cda6b645cc1f0917e14c0a556a5134380b
Deleted: sha256:666bee783f3a70860402b6799bbb421656a58ebdf9ee756e1f4e16c4dfe1206d
Deleted: sha256:f00f993540592b0e4c04f44e2288a10d3004ea45dba57588b7533696f9faaa25
Deleted: sha256:0ff3bedbe6591e8625cc407c22b8892078b7871516085e9331dcdc58b97abd1c
Deleted: sha256:b87af9bed779ddb13282ff561afebb68358cf1236524d7b6747427a49c92966c
Deleted: sha256:40895a5d37107e10aebb93f09989a6756a67546a2868275e6e1cef74f9e5f64e
Deleted: sha256:d3105ccf012d784164b2568e9620d246af752d1c367b0715d2d6566ad379da7d
Deleted: sha256:2681d4d99ebb760c117fe5c895d1fd08b3a3706bd2e7f2c28a88183261aa674d
Deleted: sha256:c485e627d9fe69ea961e4a0f3a8fe65212d64d147d9dcd4ea905f4d0d7667705
Deleted: sha256:042e20214995d19788e259627b9492ccf10946529b8ee62679d2a6a930f5f70a
Deleted: sha256:5192326da399b4f38e05b652a6e0a1217bd6bbcaddc10cdf3c6e0bfcc446e8cd
Deleted: sha256:b9cba362182fab916146e98dc466ba4dc056a7cc347638a65be7b0c5c2ce436d
Deleted: sha256:71e955d3e3403455c8f1205c0b3c93c5d145661bbc11344004d528a10d4889ff
Deleted: sha256:5d725b737c5293e94915ef84b682c10df924eca5b6dfa8bcf1e6579e509b17d8
Deleted: sha256:8dd770973329862a44b84f7bca81ea8e5d6c2a7fc23557af6f92c080160b4d1b
Deleted: sha256:b8adc55908600e3ad2525dc76cdca7b1a3d4d29972410d846c06c5b7e31d743a
Deleted: sha256:5986fa7a05a7e8ae247f3c406e46d2983fcd68402b7bb23bee58e74e137c66b5
Deleted: sha256:54336fca903aff2063ba02baeead138bdd11d2afa4f8445f7c82f935afecd01d
Deleted: sha256:b01c0b3a558051cfcc74e21ce3ddcf85f0cd11fcd30a0847e2d184008f969bcf
Deleted: sha256:807de1441f0ec2decd47e10906268c5d3a8691191704477ba5531e94959a4579
Build step 'Execute shell' marked build as failure
