See
<https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose%20--disable-libtool-wrappers%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23)/4551/display/redirect?page=changes>
Changes:
[yujie.jay] Added publish/unpublish in storage local resource provider.
[jpeach] Used more restrictive mount flags for host network bind mounts.
[yujie.jay] Made "agent_features" flag available on non-Linux systems.
------------------------------------------
[...truncated 20.14 MB...]
3: I1207 06:32:27.487927 20091 credentials.hpp:86] Loading credential for
authentication from
'/tmp/ReservationEndpointsTest_ReserveAvailableAndOfferedResources_yK3hAf/credential'
3: I1207 06:32:27.488131 20091 slave.cpp:291] Agent using credential for:
test-principal
3: I1207 06:32:27.488148 20091 credentials.hpp:37] Loading credentials for
authentication from
'/tmp/ReservationEndpointsTest_ReserveAvailableAndOfferedResources_yK3hAf/http_credentials'
3: I1207 06:32:27.488446 20091 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-agent-executor'
3: I1207 06:32:27.488584 20091 http.cpp:1066] Creating default 'jwt' HTTP
authenticator for realm 'mesos-agent-executor'
3: I1207 06:32:27.488875 20091 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-agent-readonly'
3: I1207 06:32:27.488972 20091 http.cpp:1066] Creating default 'jwt' HTTP
authenticator for realm 'mesos-agent-readonly'
3: I1207 06:32:27.489214 20091 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-agent-readwrite'
3: I1207 06:32:27.489348 20091 http.cpp:1066] Creating default 'jwt' HTTP
authenticator for realm 'mesos-agent-readwrite'
3: I1207 06:32:27.491194 20091 slave.cpp:590] Agent resources:
[{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
3: I1207 06:32:27.491464 20091 slave.cpp:598] Agent attributes: [ ]
3: I1207 06:32:27.491478 20091 slave.cpp:607] Agent hostname: 3a290d8c2a62
3: I1207 06:32:27.491672 20083 task_status_update_manager.cpp:181] Pausing
sending task status updates
3: I1207 06:32:27.493679 20104 state.cpp:66] Recovering state from
'/tmp/ReservationEndpointsTest_ReserveAvailableAndOfferedResources_NaGs2d/meta'
3: I1207 06:32:27.494091 20084 task_status_update_manager.cpp:207] Recovering
task status update manager
3: I1207 06:32:27.494320 20084 containerizer.cpp:674] Recovering containerizer
3: I1207 06:32:27.496091 20101 provisioner.cpp:495] Provisioner recovery
complete
3: I1207 06:32:27.496573 20103 slave.cpp:6631] Finished recovery
3: I1207 06:32:27.497798 20102 slave.cpp:1028] New master detected at
[email protected]:42332
3: I1207 06:32:27.497818 20091 task_status_update_manager.cpp:181] Pausing
sending task status updates
3: I1207 06:32:27.497896 20102 slave.cpp:1083] Detecting new master
3: I1207 06:32:27.501348 20104 slave.cpp:1110] Authenticating with master
[email protected]:42332
3: I1207 06:32:27.501435 20104 slave.cpp:1119] Using default CRAM-MD5
authenticatee
3: I1207 06:32:27.501761 20096 authenticatee.cpp:121] Creating new client SASL
connection
3: I1207 06:32:27.502282 20105 master.cpp:8738] Authenticating
slave(529)@172.17.0.3:42332
3: I1207 06:32:27.502460 20094 authenticator.cpp:414] Starting authentication
session for crammd5-authenticatee(1044)@172.17.0.3:42332
3: I1207 06:32:27.502781 20082 authenticator.cpp:98] Creating new server SASL
connection
3: I1207 06:32:27.503088 20098 authenticatee.cpp:213] Received SASL
authentication mechanisms: CRAM-MD5
3: I1207 06:32:27.503129 20098 authenticatee.cpp:239] Attempting to
authenticate with mechanism 'CRAM-MD5'
3: I1207 06:32:27.503257 20098 authenticator.cpp:204] Received SASL
authentication start
3: I1207 06:32:27.503326 20098 authenticator.cpp:326] Authentication requires
more steps
3: I1207 06:32:27.503468 20098 authenticatee.cpp:259] Received SASL
authentication step
3: I1207 06:32:27.503620 20086 authenticator.cpp:232] Received SASL
authentication step
3: I1207 06:32:27.503669 20086 auxprop.cpp:109] Request to lookup properties
for user: 'test-principal' realm: '3a290d8c2a62' server FQDN: '3a290d8c2a62'
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false
SASL_AUXPROP_AUTHZID: false
3: I1207 06:32:27.503684 20086 auxprop.cpp:181] Looking up auxiliary property
'*userPassword'
3: I1207 06:32:27.503727 20086 auxprop.cpp:181] Looking up auxiliary property
'*cmusaslsecretCRAM-MD5'
3: I1207 06:32:27.503751 20086 auxprop.cpp:109] Request to lookup properties
for user: 'test-principal' realm: '3a290d8c2a62' server FQDN: '3a290d8c2a62'
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false
SASL_AUXPROP_AUTHZID: true
3: I1207 06:32:27.503765 20086 auxprop.cpp:131] Skipping auxiliary property
'*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1207 06:32:27.503772 20086 auxprop.cpp:131] Skipping auxiliary property
'*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1207 06:32:27.503787 20086 authenticator.cpp:318] Authentication success
3: I1207 06:32:27.503873 20088 authenticatee.cpp:299] Authentication success
3: I1207 06:32:27.503973 20084 master.cpp:8768] Successfully authenticated
principal 'test-principal' at slave(529)@172.17.0.3:42332
3: I1207 06:32:27.504011 20088 authenticator.cpp:432] Authentication session
cleanup for crammd5-authenticatee(1044)@172.17.0.3:42332
3: I1207 06:32:27.504122 20097 slave.cpp:1202] Successfully authenticated with
master [email protected]:42332
3: I1207 06:32:27.504349 20097 slave.cpp:1745] Will retry registration in
10.541783ms if necessary
3: I1207 06:32:27.504542 20083 master.cpp:6033] Received register agent message
from slave(529)@172.17.0.3:42332 (3a290d8c2a62)
3: I1207 06:32:27.504688 20083 master.cpp:3869] Authorizing agent with
principal 'test-principal'
3: I1207 06:32:27.505185 20093 master.cpp:6109] Authorized registration of
agent at slave(529)@172.17.0.3:42332 (3a290d8c2a62)
3: I1207 06:32:27.505278 20093 master.cpp:6202] Registering agent at
slave(529)@172.17.0.3:42332 (3a290d8c2a62) with id
ac75355c-8951-484a-af52-1a2c9df344f5-S0
3: I1207 06:32:27.505798 20093 registrar.cpp:495] Applied 1 operations in
84096ns; attempting to update the registry
3: I1207 06:32:27.506402 20093 registrar.cpp:552] Successfully updated the
registry in 547072ns
3: I1207 06:32:27.506708 20096 master.cpp:6251] Admitted agent
ac75355c-8951-484a-af52-1a2c9df344f5-S0 at slave(529)@172.17.0.3:42332
(3a290d8c2a62)
3: I1207 06:32:27.507480 20096 master.cpp:6287] Registered agent
ac75355c-8951-484a-af52-1a2c9df344f5-S0 at slave(529)@172.17.0.3:42332
(3a290d8c2a62) with cpus:2; mem:1024; disk:1024; ports:[31000-32000]
3: I1207 06:32:27.507804 20082 hierarchical.cpp:577] Added agent
ac75355c-8951-484a-af52-1a2c9df344f5-S0 (3a290d8c2a62) with cpus:2; mem:1024;
disk:1024; ports:[31000-32000] (allocated: {})
3: I1207 06:32:27.507867 20094 slave.cpp:1248] Registered with master
[email protected]:42332; given agent ID ac75355c-8951-484a-af52-1a2c9df344f5-S0
3: I1207 06:32:27.508046 20086 task_status_update_manager.cpp:188] Resuming
sending task status updates
3: I1207 06:32:27.508144 20082 hierarchical.cpp:1527] Performed allocation for
1 agents in 165009ns
3: I1207 06:32:27.508316 20094 slave.cpp:1268] Checkpointing SlaveInfo to
'/tmp/ReservationEndpointsTest_ReserveAvailableAndOfferedResources_NaGs2d/meta/slaves/ac75355c-8951-484a-af52-1a2c9df344f5-S0/slave.info'
3: I1207 06:32:27.508837 20094 slave.cpp:1347] Forwarding total oversubscribed
resources {}
3: I1207 06:32:27.509133 20094 master.cpp:7181] Received update of agent
ac75355c-8951-484a-af52-1a2c9df344f5-S0 at slave(529)@172.17.0.3:42332
(3a290d8c2a62) with total oversubscribed resources {}
3: W1207 06:32:27.509203 20081 process.cpp:2756] Attempted to spawn already
running process [email protected]:42332
3: I1207 06:32:27.509335 20094 master.cpp:7224] Ignoring update on agent
ac75355c-8951-484a-af52-1a2c9df344f5-S0 at slave(529)@172.17.0.3:42332
(3a290d8c2a62) as it reports no changes
3: I1207 06:32:27.510370 20081 sched.cpp:232] Version: 1.5.0
3: I1207 06:32:27.511112 20102 sched.cpp:336] New master detected at
[email protected]:42332
3: I1207 06:32:27.511232 20102 sched.cpp:396] Authenticating with master
[email protected]:42332
3: I1207 06:32:27.511250 20102 sched.cpp:403] Using default CRAM-MD5
authenticatee
3: I1207 06:32:27.511520 20091 authenticatee.cpp:121] Creating new client SASL
connection
3: I1207 06:32:27.511812 20104 master.cpp:8738] Authenticating
[email protected]:42332
3: I1207 06:32:27.511914 20093 authenticator.cpp:414] Starting authentication
session for crammd5-authenticatee(1045)@172.17.0.3:42332
3: I1207 06:32:27.512264 20105 authenticator.cpp:98] Creating new server SASL
connection
3: I1207 06:32:27.512569 20096 authenticatee.cpp:213] Received SASL
authentication mechanisms: CRAM-MD5
3: I1207 06:32:27.512605 20096 authenticatee.cpp:239] Attempting to
authenticate with mechanism 'CRAM-MD5'
3: I1207 06:32:27.512784 20092 authenticator.cpp:204] Received SASL
authentication start
3: I1207 06:32:27.512846 20092 authenticator.cpp:326] Authentication requires
more steps
3: I1207 06:32:27.512955 20098 authenticatee.cpp:259] Received SASL
authentication step
3: I1207 06:32:27.513145 20085 authenticator.cpp:232] Received SASL
authentication step
3: I1207 06:32:27.513195 20085 auxprop.cpp:109] Request to lookup properties
for user: 'test-principal' realm: '3a290d8c2a62' server FQDN: '3a290d8c2a62'
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false
SASL_AUXPROP_AUTHZID: false
3: I1207 06:32:27.513223 20085 auxprop.cpp:181] Looking up auxiliary property
'*userPassword'
3: I1207 06:32:27.513252 20085 auxprop.cpp:181] Looking up auxiliary property
'*cmusaslsecretCRAM-MD5'
3: I1207 06:32:27.513275 20085 auxprop.cpp:109] Request to lookup properties
for user: 'test-principal' realm: '3a290d8c2a62' server FQDN: '3a290d8c2a62'
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false
SASL_AUXPROP_AUTHZID: true
3: I1207 06:32:27.513290 20085 auxprop.cpp:131] Skipping auxiliary property
'*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1207 06:32:27.513298 20085 auxprop.cpp:131] Skipping auxiliary property
'*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1207 06:32:27.513319 20085 authenticator.cpp:318] Authentication success
3: I1207 06:32:27.513468 20086 master.cpp:8768] Successfully authenticated
principal 'test-principal' at
[email protected]:42332
3: I1207 06:32:27.513474 20087 authenticatee.cpp:299] Authentication success
3: I1207 06:32:27.513500 20084 authenticator.cpp:432] Authentication session
cleanup for crammd5-authenticatee(1045)@172.17.0.3:42332
3: I1207 06:32:27.513828 20082 sched.cpp:502] Successfully authenticated with
master [email protected]:42332
3: I1207 06:32:27.513844 20082 sched.cpp:824] Sending SUBSCRIBE call to
[email protected]:42332
3: I1207 06:32:27.513957 20082 sched.cpp:857] Will retry registration in
616.701142ms if necessary
3: I1207 06:32:27.514143 20088 master.cpp:2960] Received SUBSCRIBE call for
framework 'default' at
[email protected]:42332
3: I1207 06:32:27.514217 20088 master.cpp:2277] Authorizing framework principal
'test-principal' to receive offers for roles '{ role }'
3: I1207 06:32:27.514708 20088 master.cpp:3040] Subscribing framework default
with checkpointing disabled and capabilities [ MULTI_ROLE,
RESERVATION_REFINEMENT ]
3: I1207 06:32:27.514921 20088 master.cpp:8959] Adding framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 (default) at
[email protected]:42332 with roles { }
suppressed
3: I1207 06:32:27.515350 20089 sched.cpp:751] Framework registered with
ac75355c-8951-484a-af52-1a2c9df344f5-0000
3: I1207 06:32:27.515393 20089 sched.cpp:765] Scheduler::registered took 21269ns
3: I1207 06:32:27.515485 20083 hierarchical.cpp:297] Added framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000
3: I1207 06:32:27.517626 20083 hierarchical.cpp:1527] Performed allocation for
1 agents in 1.929416ms
3: I1207 06:32:27.518025 20104 master.cpp:8568] Sending 1 offers to framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 (default) at
[email protected]:42332
3: I1207 06:32:27.518582 20093 sched.cpp:921] Scheduler::resourceOffers took
105320ns
3: I1207 06:32:27.521225 20101 master.cpp:10488] Removing offer
ac75355c-8951-484a-af52-1a2c9df344f5-O0
3: I1207 06:32:27.521435 20101 master.cpp:4227] Processing ACCEPT call for
offers: [ ac75355c-8951-484a-af52-1a2c9df344f5-O0 ] on agent
ac75355c-8951-484a-af52-1a2c9df344f5-S0 at slave(529)@172.17.0.3:42332
(3a290d8c2a62) for framework ac75355c-8951-484a-af52-1a2c9df344f5-0000
(default) at [email protected]:42332
3: I1207 06:32:27.521610 20101 master.cpp:3596] Authorizing framework principal
'test-principal' to launch task 00087ed9-b1a0-492b-80a6-962c2e0091ae
3: I1207 06:32:27.523814 20095 master.cpp:11240] Adding task
00087ed9-b1a0-492b-80a6-962c2e0091ae with resources cpus(allocated: role):1;
mem(allocated: role):128 on agent ac75355c-8951-484a-af52-1a2c9df344f5-S0 at
slave(529)@172.17.0.3:42332 (3a290d8c2a62)
3: I1207 06:32:27.524112 20095 master.cpp:4975] Launching task
00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 (default) at
[email protected]:42332 with resources
[{"allocation_info":{"role":"role"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"role"},"name":"mem","scalar":{"value":128.0},"type":"SCALAR"}]
on agent ac75355c-8951-484a-af52-1a2c9df344f5-S0 at
slave(529)@172.17.0.3:42332 (3a290d8c2a62)
3: I1207 06:32:27.524999 20082 slave.cpp:1866] Got assigned task
'00087ed9-b1a0-492b-80a6-962c2e0091ae' for framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000
3: I1207 06:32:27.525660 20082 slave.cpp:2134] Authorizing task
'00087ed9-b1a0-492b-80a6-962c2e0091ae' for framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000
3: I1207 06:32:27.525709 20082 slave.cpp:7529] Authorizing framework principal
'test-principal' to launch task 00087ed9-b1a0-492b-80a6-962c2e0091ae
3: I1207 06:32:27.525817 20099 hierarchical.cpp:1202] Recovered cpus(allocated:
role):1; mem(allocated: role):896; disk(allocated: role):1024; ports(allocated:
role):[31000-32000] (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000],
allocated: cpus(allocated: role):1; mem(allocated: role):128) on agent
ac75355c-8951-484a-af52-1a2c9df344f5-S0 from framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000
3: I1207 06:32:27.525910 20099 hierarchical.cpp:1248] Framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 filtered agent
ac75355c-8951-484a-af52-1a2c9df344f5-S0 for 5secs
3: I1207 06:32:27.526630 20102 slave.cpp:2302] Launching task
'00087ed9-b1a0-492b-80a6-962c2e0091ae' for framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000
3: I1207 06:32:27.527289 20102 paths.cpp:702] Trying to chown
'/tmp/ReservationEndpointsTest_ReserveAvailableAndOfferedResources_NaGs2d/slaves/ac75355c-8951-484a-af52-1a2c9df344f5-S0/frameworks/ac75355c-8951-484a-af52-1a2c9df344f5-0000/executors/00087ed9-b1a0-492b-80a6-962c2e0091ae/runs/4e60298f-b614-4826-bc79-fb121da38d1b'
to user 'mesos'
3: I1207 06:32:27.527601 20102 slave.cpp:8003] Launching executor
'00087ed9-b1a0-492b-80a6-962c2e0091ae' of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 with resources
[{"allocation_info":{"role":"role"},"name":"cpus","scalar":{"value":0.1},"type":"SCALAR"},{"allocation_info":{"role":"role"},"name":"mem","scalar":{"value":32.0},"type":"SCALAR"}]
in work directory
'/tmp/ReservationEndpointsTest_ReserveAvailableAndOfferedResources_NaGs2d/slaves/ac75355c-8951-484a-af52-1a2c9df344f5-S0/frameworks/ac75355c-8951-484a-af52-1a2c9df344f5-0000/executors/00087ed9-b1a0-492b-80a6-962c2e0091ae/runs/4e60298f-b614-4826-bc79-fb121da38d1b'
3: I1207 06:32:27.528764 20102 slave.cpp:2530] Queued task
'00087ed9-b1a0-492b-80a6-962c2e0091ae' for executor
'00087ed9-b1a0-492b-80a6-962c2e0091ae' of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000
3: I1207 06:32:27.528877 20102 slave.cpp:979] Successfully attached
'/tmp/ReservationEndpointsTest_ReserveAvailableAndOfferedResources_NaGs2d/slaves/ac75355c-8951-484a-af52-1a2c9df344f5-S0/frameworks/ac75355c-8951-484a-af52-1a2c9df344f5-0000/executors/00087ed9-b1a0-492b-80a6-962c2e0091ae/runs/4e60298f-b614-4826-bc79-fb121da38d1b'
to virtual path
'/tmp/ReservationEndpointsTest_ReserveAvailableAndOfferedResources_NaGs2d/slaves/ac75355c-8951-484a-af52-1a2c9df344f5-S0/frameworks/ac75355c-8951-484a-af52-1a2c9df344f5-0000/executors/00087ed9-b1a0-492b-80a6-962c2e0091ae/runs/latest'
3: I1207 06:32:27.528939 20102 slave.cpp:979] Successfully attached
'/tmp/ReservationEndpointsTest_ReserveAvailableAndOfferedResources_NaGs2d/slaves/ac75355c-8951-484a-af52-1a2c9df344f5-S0/frameworks/ac75355c-8951-484a-af52-1a2c9df344f5-0000/executors/00087ed9-b1a0-492b-80a6-962c2e0091ae/runs/4e60298f-b614-4826-bc79-fb121da38d1b'
to virtual path
'/frameworks/ac75355c-8951-484a-af52-1a2c9df344f5-0000/executors/00087ed9-b1a0-492b-80a6-962c2e0091ae/runs/latest'
3: I1207 06:32:27.528988 20102 slave.cpp:979] Successfully attached
'/tmp/ReservationEndpointsTest_ReserveAvailableAndOfferedResources_NaGs2d/slaves/ac75355c-8951-484a-af52-1a2c9df344f5-S0/frameworks/ac75355c-8951-484a-af52-1a2c9df344f5-0000/executors/00087ed9-b1a0-492b-80a6-962c2e0091ae/runs/4e60298f-b614-4826-bc79-fb121da38d1b'
to virtual path
'/tmp/ReservationEndpointsTest_ReserveAvailableAndOfferedResources_NaGs2d/slaves/ac75355c-8951-484a-af52-1a2c9df344f5-S0/frameworks/ac75355c-8951-484a-af52-1a2c9df344f5-0000/executors/00087ed9-b1a0-492b-80a6-962c2e0091ae/runs/4e60298f-b614-4826-bc79-fb121da38d1b'
3: I1207 06:32:27.529319 20102 slave.cpp:2993] Launching container
4e60298f-b614-4826-bc79-fb121da38d1b for executor
'00087ed9-b1a0-492b-80a6-962c2e0091ae' of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000
3: I1207 06:32:27.529657 20091 containerizer.cpp:1201] Starting container
4e60298f-b614-4826-bc79-fb121da38d1b
3: I1207 06:32:27.530539 20091 containerizer.cpp:1373] Checkpointed
ContainerConfig at
'/tmp/ReservationEndpointsTest_ReserveAvailableAndOfferedResources_yK3hAf/containers/4e60298f-b614-4826-bc79-fb121da38d1b/config'
3: I1207 06:32:27.530573 20091 containerizer.cpp:2930] Transitioning the state
of container 4e60298f-b614-4826-bc79-fb121da38d1b from PROVISIONING to PREPARING
3: I1207 06:32:27.537266 20087 containerizer.cpp:1842] Launching
'mesos-containerizer' with flags '--help="false"
--launch_info="{"command":{"arguments":["mesos-executor","--launcher_dir=\/mesos\/build\/src"],"shell":false,"value":"\/mesos\/build\/src\/mesos-executor"},"environment":{"variables":[{"name":"LIBPROCESS_PORT","type":"VALUE","value":"0"},{"name":"MESOS_AGENT_ENDPOINT","type":"VALUE","value":"172.17.0.3:42332"},{"name":"MESOS_CHECKPOINT","type":"VALUE","value":"0"},{"name":"MESOS_DIRECTORY","type":"VALUE","value":"\/tmp\/ReservationEndpointsTest_ReserveAvailableAndOfferedResources_NaGs2d\/slaves\/ac75355c-8951-484a-af52-1a2c9df344f5-S0\/frameworks\/ac75355c-8951-484a-af52-1a2c9df344f5-0000\/executors\/00087ed9-b1a0-492b-80a6-962c2e0091ae\/runs\/4e60298f-b614-4826-bc79-fb121da38d1b"},{"name":"MESOS_EXECUTOR_AUTHENTICATION_TOKEN","type":"VALUE","value":"eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJjaWQiOiI0ZTYwMjk4Zi1iNjE0LTQ4MjYtYmM3OS1mYjEyMWRhMzhkMWIiLCJlaWQiOiIwMDA4N2VkOS1iMWEwLTQ5MmItODBhNi05NjJjMmUwMDkxYWUiLCJmaWQiOiJhYzc1MzU1Yy04OTUxLTQ4NGEtYWY1Mi0xYTJjOWRmMzQ0ZjUtMDAwMCJ9.311xEIa46dkqeFRo19E9sDanAuChPC7zeVVNteHAoGQ"},{"name":"MESOS_EXECUTOR_ID","type":"VALUE","value":"00087ed9-b1a0-492b-80a6-962c2e0091ae"},{"name":"MESOS_EXECUTOR_SHUTDOWN_GRACE_PERIOD","type":"VALUE","value":"5secs"},{"name":"MESOS_FRAMEWORK_ID","type":"VALUE","value":"ac75355c-8951-484a-af52-1a2c9df344f5-0000"},{"name":"MESOS_HTTP_COMMAND_EXECUTOR","type":"VALUE","value":"0"},{"name":"MESOS_SLAVE_ID","type":"VALUE","value":"ac75355c-8951-484a-af52-1a2c9df344f5-S0"},{"name":"MESOS_SLAVE_PID","type":"VALUE","value":"slave(529)@172.17.0.3:42332"},{"name":"MESOS_SANDBOX","type":"VALUE","value":"\/tmp\/ReservationEndpointsTest_ReserveAvailableAndOfferedResources_NaGs2d\/slaves\/ac75355c-8951-484a-af52-1a2c9df344f5-S0\/frameworks\/ac75355c-8951-484a-af52-1a2c9df344f5-0000\/executors\/00087ed9-b1a0-492b-80a6-962c2e0091ae\/runs\/4e60298f-b614-4826-bc79-fb121da38d1b"}]},"task_environment":{},"user":"mesos","working_directory":"\/tmp\/ReservationEndpointsTest_ReserveAvailableAndOfferedResources_NaGs2d\/slaves\/ac75355c-8951-484a-af52-1a2c9df344f5-S0\/frameworks\/ac75355c-8951-484a-af52-1a2c9df344f5-0000\/executors\/00087ed9-b1a0-492b-80a6-962c2e0091ae\/runs\/4e60298f-b614-4826-bc79-fb121da38d1b"}"
--pipe_read="8" --pipe_write="9"
--runtime_directory="/tmp/ReservationEndpointsTest_ReserveAvailableAndOfferedResources_yK3hAf/containers/4e60298f-b614-4826-bc79-fb121da38d1b"
--unshare_namespace_mnt="false"'
3: I1207 06:32:27.540163 20087 launcher.cpp:140] Forked child with pid '25626'
for container '4e60298f-b614-4826-bc79-fb121da38d1b'
3: I1207 06:32:27.540894 20087 containerizer.cpp:2930] Transitioning the state
of container 4e60298f-b614-4826-bc79-fb121da38d1b from PREPARING to ISOLATING
3: I1207 06:32:27.543200 20099 containerizer.cpp:2930] Transitioning the state
of container 4e60298f-b614-4826-bc79-fb121da38d1b from ISOLATING to FETCHING
3: I1207 06:32:27.543370 20089 fetcher.cpp:380] Starting to fetch URIs for
container: 4e60298f-b614-4826-bc79-fb121da38d1b, directory:
/tmp/ReservationEndpointsTest_ReserveAvailableAndOfferedResources_NaGs2d/slaves/ac75355c-8951-484a-af52-1a2c9df344f5-S0/frameworks/ac75355c-8951-484a-af52-1a2c9df344f5-0000/executors/00087ed9-b1a0-492b-80a6-962c2e0091ae/runs/4e60298f-b614-4826-bc79-fb121da38d1b
3: I1207 06:32:27.544808 20102 containerizer.cpp:2930] Transitioning the state
of container 4e60298f-b614-4826-bc79-fb121da38d1b from FETCHING to RUNNING
3: I1207 06:32:27.866752 25627 exec.cpp:162] Version: 1.5.0
3: I1207 06:32:27.881368 20092 slave.cpp:4182] Got registration for executor
'00087ed9-b1a0-492b-80a6-962c2e0091ae' of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 from executor(1)@172.17.0.3:37735
3: I1207 06:32:27.884971 20095 slave.cpp:2732] Sending queued task
'00087ed9-b1a0-492b-80a6-962c2e0091ae' to executor
'00087ed9-b1a0-492b-80a6-962c2e0091ae' of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 at executor(1)@172.17.0.3:37735
3: I1207 06:32:27.890154 25647 exec.cpp:237] Executor registered on agent
ac75355c-8951-484a-af52-1a2c9df344f5-S0
3: I1207 06:32:27.895390 25630 executor.cpp:171] Received SUBSCRIBED event
3: I1207 06:32:27.897183 25630 executor.cpp:175] Subscribed executor on
3a290d8c2a62
3: I1207 06:32:27.897512 25630 executor.cpp:171] Received LAUNCH event
3: I1207 06:32:27.900591 25630 executor.cpp:637] Starting task
00087ed9-b1a0-492b-80a6-962c2e0091ae
3: I1207 06:32:27.904547 20101 slave.cpp:4636] Handling status update
TASK_STARTING (UUID: 5c91cc3b-7607-449b-8668-e9414573179a) for task
00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 from executor(1)@172.17.0.3:37735
3: I1207 06:32:27.907647 20092 task_status_update_manager.cpp:328] Received
task status update TASK_STARTING (UUID: 5c91cc3b-7607-449b-8668-e9414573179a)
for task 00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000
3: I1207 06:32:27.907732 20092 task_status_update_manager.cpp:507] Creating
StatusUpdate stream for task 00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000
3: I1207 06:32:27.908658 20092 task_status_update_manager.cpp:383] Forwarding
task status update TASK_STARTING (UUID: 5c91cc3b-7607-449b-8668-e9414573179a)
for task 00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 to the agent
3: I1207 06:32:27.908946 20094 slave.cpp:5119] Forwarding the update
TASK_STARTING (UUID: 5c91cc3b-7607-449b-8668-e9414573179a) for task
00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 to [email protected]:42332
3: I1207 06:32:27.909307 20094 slave.cpp:5012] Task status update manager
successfully handled status update TASK_STARTING (UUID:
5c91cc3b-7607-449b-8668-e9414573179a) for task
00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000
3: I1207 06:32:27.909370 20094 slave.cpp:5028] Sending acknowledgement for
status update TASK_STARTING (UUID: 5c91cc3b-7607-449b-8668-e9414573179a) for
task 00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 to executor(1)@172.17.0.3:37735
3: I1207 06:32:27.909690 20085 master.cpp:7689] Status update TASK_STARTING
(UUID: 5c91cc3b-7607-449b-8668-e9414573179a) for task
00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 from agent
ac75355c-8951-484a-af52-1a2c9df344f5-S0 at slave(529)@172.17.0.3:42332
(3a290d8c2a62)
3: I1207 06:32:27.909795 20085 master.cpp:7745] Forwarding status update
TASK_STARTING (UUID: 5c91cc3b-7607-449b-8668-e9414573179a) for task
00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000
3: I1207 06:32:27.910073 20085 master.cpp:9964] Updating the state of task
00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 (latest state: TASK_STARTING, status
update state: TASK_STARTING)
3: I1207 06:32:27.910359 20082 sched.cpp:1029] Scheduler::statusUpdate took
38806ns
3: I1207 06:32:27.910776 20088 master.cpp:5790] Processing ACKNOWLEDGE call
5c91cc3b-7607-449b-8668-e9414573179a for task
00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 (default) at
[email protected]:42332 on agent
ac75355c-8951-484a-af52-1a2c9df344f5-S0
3: I1207 06:32:27.911371 20084 task_status_update_manager.cpp:401] Received
task status update acknowledgement (UUID: 5c91cc3b-7607-449b-8668-e9414573179a)
for task 00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000
3: I1207 06:32:27.911873 20098 slave.cpp:3920] Task status update manager
successfully handled status update acknowledgement (UUID:
5c91cc3b-7607-449b-8668-e9414573179a) for task
00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000
3: I1207 06:32:27.922590 25630 executor.cpp:477] Running
'/mesos/build/src/mesos-containerizer launch <POSSIBLY-SENSITIVE-DATA>'
3: I1207 06:32:27.926805 25630 executor.cpp:650] Forked command at 25653
3: I1207 06:32:27.931057 20087 slave.cpp:4636] Handling status update
TASK_RUNNING (UUID: 5b8da0c6-8322-4ed7-a23c-cb517a0b959f) for task
00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 from executor(1)@172.17.0.3:37735
3: I1207 06:32:27.933464 20086 task_status_update_manager.cpp:328] Received
task status update TASK_RUNNING (UUID: 5b8da0c6-8322-4ed7-a23c-cb517a0b959f)
for task 00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000
3: I1207 06:32:27.933604 20086 task_status_update_manager.cpp:383] Forwarding
task status update TASK_RUNNING (UUID: 5b8da0c6-8322-4ed7-a23c-cb517a0b959f)
for task 00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 to the agent
3: I1207 06:32:27.933836 20096 slave.cpp:5119] Forwarding the update
TASK_RUNNING (UUID: 5b8da0c6-8322-4ed7-a23c-cb517a0b959f) for task
00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 to [email protected]:42332
3: I1207 06:32:27.934216 20096 slave.cpp:5012] Task status update manager
successfully handled status update TASK_RUNNING (UUID:
5b8da0c6-8322-4ed7-a23c-cb517a0b959f) for task
00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000
3: I1207 06:32:27.934288 20096 slave.cpp:5028] Sending acknowledgement for
status update TASK_RUNNING (UUID: 5b8da0c6-8322-4ed7-a23c-cb517a0b959f) for
task 00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 to executor(1)@172.17.0.3:37735
3: I1207 06:32:27.934466 20092 master.cpp:7689] Status update TASK_RUNNING
(UUID: 5b8da0c6-8322-4ed7-a23c-cb517a0b959f) for task
00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 from agent
ac75355c-8951-484a-af52-1a2c9df344f5-S0 at slave(529)@172.17.0.3:42332
(3a290d8c2a62)
3: I1207 06:32:27.934554 20092 master.cpp:7745] Forwarding status update
TASK_RUNNING (UUID: 5b8da0c6-8322-4ed7-a23c-cb517a0b959f) for task
00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000
3: I1207 06:32:27.934818 20092 master.cpp:9964] Updating the state of task
00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 (latest state: TASK_RUNNING, status
update state: TASK_RUNNING)
3: I1207 06:32:27.935022 20094 sched.cpp:1029] Scheduler::statusUpdate took
30491ns
3: I1207 06:32:27.935379 20085 master.cpp:5790] Processing ACKNOWLEDGE call
5b8da0c6-8322-4ed7-a23c-cb517a0b959f for task
00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 (default) at
[email protected]:42332 on agent
ac75355c-8951-484a-af52-1a2c9df344f5-S0
3: I1207 06:32:27.935827 20097 task_status_update_manager.cpp:401] Received
task status update acknowledgement (UUID: 5b8da0c6-8322-4ed7-a23c-cb517a0b959f)
for task 00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000
3: I1207 06:32:27.936192 20088 slave.cpp:3920] Task status update manager
successfully handled status update acknowledgement (UUID:
5b8da0c6-8322-4ed7-a23c-cb517a0b959f) for task
00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000
3: I1207 06:32:27.937319 20089 master.cpp:5536] Processing REVIVE call for
framework ac75355c-8951-484a-af52-1a2c9df344f5-0000 (default) at
[email protected]:42332
3: I1207 06:32:27.937649 20089 hierarchical.cpp:1349] Revived offers for roles
{ role } of framework ac75355c-8951-484a-af52-1a2c9df344f5-0000
3: I1207 06:32:27.939849 20089 hierarchical.cpp:1527] Performed allocation for
1 agents in 1.9192ms
3: I1207 06:32:27.940480 20099 master.cpp:8568] Sending 1 offers to framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 (default) at
[email protected]:42332
3: I1207 06:32:27.941454 20105 sched.cpp:921] Scheduler::resourceOffers took
135293ns
3: I1207 06:32:27.942534 20082 master.cpp:5608] Processing KILL call for task
'00087ed9-b1a0-492b-80a6-962c2e0091ae' of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 (default) at
[email protected]:42332
3: I1207 06:32:27.942637 20082 master.cpp:5682] Telling agent
ac75355c-8951-484a-af52-1a2c9df344f5-S0 at slave(529)@172.17.0.3:42332
(3a290d8c2a62) to kill task 00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 (default) at
[email protected]:42332
3: I1207 06:32:27.942853 20082 slave.cpp:3066] Asked to kill task
00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000
3: I1207 06:32:27.944857 25642 executor.cpp:171] Received KILL event
3: I1207 06:32:27.944895 25642 executor.cpp:739] Received kill for task
00087ed9-b1a0-492b-80a6-962c2e0091ae with grace period of 3secs
3: I1207 06:32:27.944963 25642 executor.cpp:854] Sending SIGTERM to process
tree at pid 25653
3: I1207 06:32:27.949232 25642 executor.cpp:867] Sent SIGTERM to the following
process trees:
3: [
3: --- 25653 mesos-containerizer launch --help=false
--launch_info={"command":{"shell":true,"value":"sleep
1000"},"environment":{"variables":[{"name":"PATH","type":"VALUE","value":"\/usr\/local\/sbin:\/usr\/local\/bin:\/usr\/sbin:\/usr\/bin:\/sbin:\/bin"},{"name":"MESOS_SLAVE_PID","type":"VALUE","value":"slave(529)@172.17.0.3:42332"},{"name":"MESOS_SLAVE_ID","type":"VALUE","value":"ac75355c-8951-484a-af52-1a2c9df344f5-S0"},{"name":"MESOS_HTTP_COMMAND_EXECUTOR","type":"VALUE","value":"0"},{"name":"MESOS_AGENT_ENDPOINT","type":"VALUE","value":"172.17.0.3:42332"},{"name":"MESOS_CHECKPOINT","type":"VALUE","value":"0"},{"name":"MESOS_EXECUTOR_SHUTDOWN_GRACE_PERIOD","type":"VALUE","value":"5secs"},{"name":"MESOS_DIRECTORY","type":"VALUE","value":"\/tmp\/ReservationEndpointsTest_ReserveAvailableAndOfferedResources_NaGs2d\/slaves\/ac75355c-8951-484a-af52-1a2c9df344f5-S0\/frameworks\/ac75355c-8951-484a-af52-1a2c9df344f5-0000\/executors\/00087ed9-b1a0-492b-80a6-962c2e0091ae\/runs\/4e60298f-b614-4826-bc79-fb121da38d1b"},{"name":"MESOS_EXECUTOR_AUTHENTICATION_TOKEN","type":"VALUE","value":"eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJjaWQiOiI0ZTYwMjk4Zi1iNjE0LTQ4MjYtYmM3OS1mYjEyMWRhMzhkMWIiLCJlaWQiOiIwMDA4N2VkOS1iMWEwLTQ5MmItODBhNi05NjJjMmUwMDkxYWUiLCJmaWQiOiJhYzc1MzU1Yy04OTUxLTQ4NGEtYWY1Mi0xYTJjOWRmMzQ0ZjUtMDAwMCJ9.311xEIa46dkqeFRo19E9sDanAuChPC7zeVVNteHAoGQ"},{"name":"MESOS_EXECUTOR_ID","type":"VALUE","value":"00087ed9-b1a0-492b-80a6-962c2e0091ae"},{"name":"MESOS_FRAMEWORK_ID","type":"VALUE","value":"ac75355c-8951-484a-af52-1a2c9df344f5-0000"},{"name":"LIBPROCESS_PORT","type":"VALUE","value":"0"},{"name":"MESOS_SANDBOX","type":"VALUE","value":"\/tmp\/ReservationEndpointsTest_ReserveAvailableAndOfferedResources_NaGs2d\/slaves\/ac75355c-8951-484a-af52-1a2c9df344f5-S0\/frameworks\/ac75355c-8951-484a-af52-1a2c9df344f5-0000\/executors\/00087ed9-b1a0-492b-80a6-962c2e0091ae\/runs\/4e60298f-b614-4826-bc79-fb121da38d1b"}]}}
--unshare_namespace_mnt=false
3: ]
3: I1207 06:32:27.949252 25642 executor.cpp:871] Scheduling escalation to
SIGKILL in 3secs from now
3: I1207 06:32:27.965745 25643 executor.cpp:929] Command terminated with signal
Terminated (pid: 25653)
3: I1207 06:32:27.971895 20100 slave.cpp:4636] Handling status update
TASK_KILLED (UUID: 578c0326-6f63-4fe4-87da-ade14201f748) for task
00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 from executor(1)@172.17.0.3:37735
3: I1207 06:32:27.975630 20097 task_status_update_manager.cpp:328] Received
task status update TASK_KILLED (UUID: 578c0326-6f63-4fe4-87da-ade14201f748) for
task 00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000
3: I1207 06:32:27.975903 20097 task_status_update_manager.cpp:383] Forwarding
task status update TASK_KILLED (UUID: 578c0326-6f63-4fe4-87da-ade14201f748) for
task 00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 to the agent
3: I1207 06:32:27.976200 20084 slave.cpp:5119] Forwarding the update
TASK_KILLED (UUID: 578c0326-6f63-4fe4-87da-ade14201f748) for task
00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 to [email protected]:42332
3: I1207 06:32:27.976510 20084 slave.cpp:5012] Task status update manager
successfully handled status update TASK_KILLED (UUID:
578c0326-6f63-4fe4-87da-ade14201f748) for task
00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000
3: I1207 06:32:27.976580 20084 slave.cpp:5028] Sending acknowledgement for
status update TASK_KILLED (UUID: 578c0326-6f63-4fe4-87da-ade14201f748) for task
00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 to executor(1)@172.17.0.3:37735
3: I1207 06:32:27.976786 20100 master.cpp:7689] Status update TASK_KILLED
(UUID: 578c0326-6f63-4fe4-87da-ade14201f748) for task
00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 from agent
ac75355c-8951-484a-af52-1a2c9df344f5-S0 at slave(529)@172.17.0.3:42332
(3a290d8c2a62)
3: I1207 06:32:27.976864 20100 master.cpp:7745] Forwarding status update
TASK_KILLED (UUID: 578c0326-6f63-4fe4-87da-ade14201f748) for task
00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000
3: I1207 06:32:27.977167 20100 master.cpp:9964] Updating the state of task
00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 (latest state: TASK_KILLED, status
update state: TASK_KILLED)
3: I1207 06:32:27.977565 20091 sched.cpp:1029] Scheduler::statusUpdate took
140787ns
3: I1207 06:32:27.977918 20087 hierarchical.cpp:1202] Recovered cpus(allocated:
role):1; mem(allocated: role):128 (total: cpus:2; mem:1024; disk:1024;
ports:[31000-32000], allocated: cpus(allocated: role):1; mem(allocated:
role):896; disk(allocated: role):1024; ports(allocated: role):[31000-32000]) on
agent ac75355c-8951-484a-af52-1a2c9df344f5-S0 from framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000
3: I1207 06:32:27.978324 20088 master.cpp:5790] Processing ACKNOWLEDGE call
578c0326-6f63-4fe4-87da-ade14201f748 for task
00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 (default) at
[email protected]:42332 on agent
ac75355c-8951-484a-af52-1a2c9df344f5-S0
3: I1207 06:32:27.978463 20088 master.cpp:10070] Removing task
00087ed9-b1a0-492b-80a6-962c2e0091ae with resources cpus(allocated: role):1;
mem(allocated: role):128 of framework ac75355c-8951-484a-af52-1a2c9df344f5-0000
on agent ac75355c-8951-484a-af52-1a2c9df344f5-S0 at slave(529)@172.17.0.3:42332
(3a290d8c2a62)
3: I1207 06:32:27.979245 20102 task_status_update_manager.cpp:401] Received
task status update acknowledgement (UUID: 578c0326-6f63-4fe4-87da-ade14201f748)
for task 00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000
3: I1207 06:32:27.979465 20102 task_status_update_manager.cpp:538] Cleaning up
status update stream for task 00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000
3: I1207 06:32:27.980209 20096 slave.cpp:3920] Task status update manager
successfully handled status update acknowledgement (UUID:
578c0326-6f63-4fe4-87da-ade14201f748) for task
00087ed9-b1a0-492b-80a6-962c2e0091ae of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000
3: I1207 06:32:27.980274 20096 slave.cpp:8608] Completing task
00087ed9-b1a0-492b-80a6-962c2e0091ae
3: I1207 06:32:27.981467 20086 process.cpp:3503] Handling HTTP event for
process 'master' with path: '/master/reserve'
3: I1207 06:32:27.984066 20084 http.cpp:1185] HTTP POST for /master/reserve
from 172.17.0.3:46508
3: I1207 06:32:27.985005 20084 master.cpp:3654] Authorizing principal
'test-principal' to reserve resources
'[{"name":"cpus","reservations":[{"principal":"test-principal","role":"role","type":"DYNAMIC"}],"scalar":{"value":1.0},"type":"SCALAR"},{"name":"mem","reservations":[{"principal":"test-principal","role":"role","type":"DYNAMIC"}],"scalar":{"value":512.0},"type":"SCALAR"}]'
3: I1207 06:32:27.987090 20100 master.cpp:10488] Removing offer
ac75355c-8951-484a-af52-1a2c9df344f5-O1
3: I1207 06:32:27.987234 20087 sched.cpp:947] Rescinded offer
ac75355c-8951-484a-af52-1a2c9df344f5-O1
3: I1207 06:32:27.987308 20087 sched.cpp:958] Scheduler::offerRescinded took
22147ns
3: I1207 06:32:27.987756 20091 hierarchical.cpp:1202] Recovered cpus(allocated:
role):1; mem(allocated: role):896; disk(allocated: role):1024; ports(allocated:
role):[31000-32000] (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000],
allocated: {}) on agent ac75355c-8951-484a-af52-1a2c9df344f5-S0 from framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000
3: I1207 06:32:27.987854 20091 hierarchical.cpp:1248] Framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 filtered agent
ac75355c-8951-484a-af52-1a2c9df344f5-S0 for 5secs
3: I1207 06:32:27.991828 20088 master.cpp:10433] Sending updated checkpointed
resources cpus(reservations: [(DYNAMIC,role,test-principal)]):1;
mem(reservations: [(DYNAMIC,role,test-principal)]):512 to agent
ac75355c-8951-484a-af52-1a2c9df344f5-S0 at slave(529)@172.17.0.3:42332
(3a290d8c2a62)
3: I1207 06:32:27.993062 20088 slave.cpp:3654] Updated checkpointed resources
from {} to cpus(reservations: [(DYNAMIC,role,test-principal)]):1;
mem(reservations: [(DYNAMIC,role,test-principal)]):512
3: I1207 06:32:27.993276 20088 master.cpp:5536] Processing REVIVE call for
framework ac75355c-8951-484a-af52-1a2c9df344f5-0000 (default) at
[email protected]:42332
3: I1207 06:32:27.993494 20088 hierarchical.cpp:1349] Revived offers for roles
{ role } of framework ac75355c-8951-484a-af52-1a2c9df344f5-0000
3: I1207 06:32:27.995592 20088 hierarchical.cpp:1527] Performed allocation for
1 agents in 1.916437ms
3: I1207 06:32:27.996768 20092 master.cpp:8568] Sending 1 offers to framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 (default) at
[email protected]:42332
3: I1207 06:32:27.997838 20097 sched.cpp:921] Scheduler::resourceOffers took
172646ns
3: I1207 06:32:27.998569 20081 sched.cpp:2009] Asked to stop the driver
3: I1207 06:32:27.998733 20087 sched.cpp:1191] Stopping framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000
3: I1207 06:32:27.999038 20091 master.cpp:9248] Processing TEARDOWN call for
framework ac75355c-8951-484a-af52-1a2c9df344f5-0000 (default) at
[email protected]:42332
3: I1207 06:32:27.999086 20091 master.cpp:9260] Removing framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 (default) at
[email protected]:42332
3: I1207 06:32:27.999104 20091 master.cpp:3330] Deactivating framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 (default) at
[email protected]:42332
3: I1207 06:32:27.999362 20102 hierarchical.cpp:410] Deactivated framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000
3: I1207 06:32:28.000185 20091 master.cpp:10488] Removing offer
ac75355c-8951-484a-af52-1a2c9df344f5-O2
3: I1207 06:32:28.000201 20081 slave.cpp:904] Agent terminating
3: I1207 06:32:28.000278 20081 slave.cpp:3330] Asked to shut down framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 by @0.0.0.0:0
3: I1207 06:32:28.000303 20081 slave.cpp:3355] Shutting down framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000
3: I1207 06:32:28.000366 20081 slave.cpp:5995] Shutting down executor
'00087ed9-b1a0-492b-80a6-962c2e0091ae' of framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000 at executor(1)@172.17.0.3:37735
3: I1207 06:32:28.000937 20084 master.cpp:1308] Agent
ac75355c-8951-484a-af52-1a2c9df344f5-S0 at slave(529)@172.17.0.3:42332
(3a290d8c2a62) disconnected
3: I1207 06:32:28.000964 20084 master.cpp:3367] Disconnecting agent
ac75355c-8951-484a-af52-1a2c9df344f5-S0 at slave(529)@172.17.0.3:42332
(3a290d8c2a62)
3: I1207 06:32:28.001056 20084 master.cpp:3386] Deactivating agent
ac75355c-8951-484a-af52-1a2c9df344f5-S0 at slave(529)@172.17.0.3:42332
(3a290d8c2a62)
3: I1207 06:32:28.000998 20103 hierarchical.cpp:1202] Recovered cpus(allocated:
role):1; mem(allocated: role):512; disk(allocated: role):1024; ports(allocated:
role):[31000-32000]; cpus(allocated: role)(reservations:
[(DYNAMIC,role,test-principal)]):1; mem(allocated: role)(reservations:
[(DYNAMIC,role,test-principal)]):512 (total: cpus:1; mem:512; disk:1024;
ports:[31000-32000]; cpus(reservations: [(DYNAMIC,role,test-principal)]):1;
mem(reservations: [(DYNAMIC,role,test-principal)]):512, allocated: {}) on agent
ac75355c-8951-484a-af52-1a2c9df344f5-S0 from framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000
3: I1207 06:32:28.001576 25649 exec.cpp:435] Executor asked to shutdown
3: I1207 06:32:28.001582 20103 hierarchical.cpp:349] Removed framework
ac75355c-8951-484a-af52-1a2c9df344f5-0000
3: I1207 06:32:28.001657 20103 hierarchical.cpp:767] Agent
ac75355c-8951-484a-af52-1a2c9df344f5-S0 deactivated
3: I1207 06:32:28.001858 20082 containerizer.cpp:2328] Destroying container
4e60298f-b614-4826-bc79-fb121da38d1b in RUNNING state
3: I1207 06:32:28.001898 20082 containerizer.cpp:2930] Transitioning the state
of container 4e60298f-b614-4826-bc79-fb121da38d1b from RUNNING to DESTROYING
3: I1207 06:32:28.002020 25649 executor.cpp:171] Received SHUTDOWN event
3: I1207 06:32:28.002046 25649 executor.cpp:747] Shutting down
3: I1207 06:32:28.002306 20082 launcher.cpp:156] Asked to destroy container
4e60298f-b614-4826-bc79-fb121da38d1b
3: I1207 06:32:28.025781 20087 containerizer.cpp:2779] Container
4e60298f-b614-4826-bc79-fb121da38d1b has exited
3: I1207 06:32:28.029019 20082 provisioner.cpp:598] Ignoring destroy request
for unknown container 4e60298f-b614-4826-bc79-fb121da38d1b
3: I1207 06:32:28.041988 20081 master.cpp:1150] Master terminating
3: I1207 06:32:28.043444 20084 hierarchical.cpp:610] Removed agent
ac75355c-8951-484a-af52-1a2c9df344f5-S0
3: [ OK ] ReservationEndpointsTest.ReserveAvailableAndOfferedResources
(589 ms)
3: [ RUN ] ReservationEndpointsTest.UnreserveAvailableAndOfferedResources
3: I1207 06:32:28.052670 20081 cluster.cpp:172] Creating default 'local'
authorizer
3: I1207 06:32:28.056737 20105 master.cpp:454] Master
09b48710-ad78-4d82-8f34-2ccbf131cf2d (3a290d8c2a62) started on 172.17.0.3:42332
write /dev/stdout: resource temporarily unavailable
+ docker rmi mesos-1512625815-11466
Error response from daemon: conflict: unable to remove repository reference
"mesos-1512625815-11466" (must force) - container 3a290d8c2a62 is using its
referenced image 2ac8751bd413
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user [email protected]
Not sending mail to unregistered user [email protected]
