See 
<https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=clang,CONFIGURATION=--verbose%20--disable-libtool-wrappers,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23)/4593/display/redirect?page=changes>

Changes:

[bmahler] Moved a comment in the allocator to a more relevant location.

------------------------------------------
[...truncated 12.92 MB...]
3: I1213 20:47:01.090741 16062 registrar.cpp:424] Successfully recovered 
registrar
3: I1213 20:47:01.091277 16069 master.cpp:1802] Recovered 0 agents from the 
registry (135B); allowing 10mins for agents to re-register
3: I1213 20:47:01.091348 16060 hierarchical.cpp:213] Skipping recovery of 
hierarchical allocator: nothing to recover
3: W1213 20:47:01.096881 16059 process.cpp:2756] Attempted to spawn already 
running process [email protected]:37867
3: I1213 20:47:01.097184 16059 cluster.cpp:460] Creating default 'local' 
authorizer
3: I1213 20:47:01.099386 16064 slave.cpp:258] Mesos agent started on 
(289)@172.17.0.4:37867
3: I1213 20:47:01.099421 16064 slave.cpp:259] Flags at startup: --acls="" 
--appc_simple_discovery_uri_prefix="http://"; 
--appc_store_dir="/tmp/MasterAllocatorTest_0_SlaveAdded_DlNlvc/store/appc" 
--authenticate_http_readonly="true" --authenticate_http_readwrite="true" 
--authenticatee="crammd5" --authentication_backoff_factor="1secs" 
--authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" 
--cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" 
--cgroups_limit_swap="false" --cgroups_root="mesos" 
--container_disk_watch_interval="15secs" --containerizers="mesos" 
--credential="/tmp/MasterAllocatorTest_0_SlaveAdded_DlNlvc/credential" 
--default_role="*" --disallow_sharing_agent_pid_namespace="false" 
--disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" 
--docker_registry="https://registry-1.docker.io"; --docker_remove_delay="6hrs" 
--docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" 
--docker_store_dir="/tmp/MasterAllocatorTest_0_SlaveAdded_DlNlvc/store/docker" 
--docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" 
--enforce_container_disk_quota="false" --executor_registration_timeout="1mins" 
--executor_reregistration_timeout="2secs" 
--executor_shutdown_grace_period="5secs" 
--fetcher_cache_dir="/tmp/MasterAllocatorTest_0_SlaveAdded_DlNlvc/fetch" 
--fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" 
--gc_disk_headroom="0.1" --hadoop_home="" --help="false" 
--hostname_lookup="true" --http_command_executor="false" 
--http_credentials="/tmp/MasterAllocatorTest_0_SlaveAdded_DlNlvc/http_credentials"
 --http_heartbeat_interval="30secs" --initialize_driver_logging="true" 
--isolation="posix/cpu,posix/mem" --launcher="posix" 
--launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" 
--max_completed_executors_per_framework="150" 
--oversubscribed_resources_interval="15secs" --perf_duration="10secs" 
--perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" 
--quiet="false" --reconfiguration_policy="equal" --recover="reconnect" 
--recovery_timeout="15mins" --registration_backoff_factor="10ms" 
--resources="cpus:3;mem:1024" --revocable_cpu_low_priority="true" 
--runtime_dir="/tmp/MasterAllocatorTest_0_SlaveAdded_DlNlvc" 
--sandbox_directory="/mnt/mesos/sandbox" --strict="true" --switch_user="true" 
--systemd_enable_support="true" 
--systemd_runtime_directory="/run/systemd/system" --version="false" 
--work_dir="/tmp/MasterAllocatorTest_0_SlaveAdded_8ckWSa" 
--zk_session_timeout="10secs"
3: I1213 20:47:01.099817 16064 credentials.hpp:86] Loading credential for 
authentication from '/tmp/MasterAllocatorTest_0_SlaveAdded_DlNlvc/credential'
3: W1213 20:47:01.099851 16059 process.cpp:2756] Attempted to spawn already 
running process [email protected]:37867
3: I1213 20:47:01.099983 16064 slave.cpp:291] Agent using credential for: 
test-principal
3: I1213 20:47:01.100003 16064 credentials.hpp:37] Loading credentials for 
authentication from 
'/tmp/MasterAllocatorTest_0_SlaveAdded_DlNlvc/http_credentials'
3: I1213 20:47:01.100234 16064 http.cpp:1045] Creating default 'basic' HTTP 
authenticator for realm 'mesos-agent-readonly'
3: I1213 20:47:01.100404 16064 http.cpp:1045] Creating default 'basic' HTTP 
authenticator for realm 'mesos-agent-readwrite'
3: I1213 20:47:01.100986 16059 sched.cpp:232] Version: 1.5.0
3: I1213 20:47:01.101611 16061 sched.cpp:336] New master detected at 
[email protected]:37867
3: I1213 20:47:01.101711 16061 sched.cpp:396] Authenticating with master 
[email protected]:37867
3: I1213 20:47:01.101734 16061 sched.cpp:403] Using default CRAM-MD5 
authenticatee
3: I1213 20:47:01.101634 16064 slave.cpp:590] Agent resources: 
[{"name":"cpus","scalar":{"value":3.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":367489.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
3: I1213 20:47:01.101851 16064 slave.cpp:598] Agent attributes: [  ]
3: I1213 20:47:01.101863 16064 slave.cpp:607] Agent hostname: 64aaf82e0ca6
3: I1213 20:47:01.101986 16081 task_status_update_manager.cpp:181] Pausing 
sending task status updates
3: I1213 20:47:01.102026 16073 authenticatee.cpp:121] Creating new client SASL 
connection
3: I1213 20:47:01.102265 16083 master.cpp:8932] Authenticating 
[email protected]:37867
3: I1213 20:47:01.102414 16066 authenticator.cpp:414] Starting authentication 
session for crammd5-authenticatee(561)@172.17.0.4:37867
3: I1213 20:47:01.102736 16082 authenticator.cpp:98] Creating new server SASL 
connection
3: I1213 20:47:01.103067 16075 authenticatee.cpp:213] Received SASL 
authentication mechanisms: CRAM-MD5
3: I1213 20:47:01.103094 16075 authenticatee.cpp:239] Attempting to 
authenticate with mechanism 'CRAM-MD5'
3: I1213 20:47:01.103204 16074 authenticator.cpp:204] Received SASL 
authentication start
3: I1213 20:47:01.103251 16074 authenticator.cpp:326] Authentication requires 
more steps
3: I1213 20:47:01.103353 16074 authenticatee.cpp:259] Received SASL 
authentication step
3: I1213 20:47:01.103447 16074 authenticator.cpp:232] Received SASL 
authentication step
3: I1213 20:47:01.103480 16074 auxprop.cpp:109] Request to lookup properties 
for user: 'test-principal' realm: '64aaf82e0ca6' server FQDN: '64aaf82e0ca6' 
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false 
SASL_AUXPROP_AUTHZID: false 
3: I1213 20:47:01.103490 16074 auxprop.cpp:181] Looking up auxiliary property 
'*userPassword'
3: I1213 20:47:01.103523 16074 auxprop.cpp:181] Looking up auxiliary property 
'*cmusaslsecretCRAM-MD5'
3: I1213 20:47:01.103539 16074 auxprop.cpp:109] Request to lookup properties 
for user: 'test-principal' realm: '64aaf82e0ca6' server FQDN: '64aaf82e0ca6' 
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false 
SASL_AUXPROP_AUTHZID: true 
3: I1213 20:47:01.103554 16074 auxprop.cpp:131] Skipping auxiliary property 
'*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1213 20:47:01.103559 16074 auxprop.cpp:131] Skipping auxiliary property 
'*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1213 20:47:01.103571 16074 authenticator.cpp:318] Authentication success
3: I1213 20:47:01.103683 16072 authenticatee.cpp:299] Authentication success
3: I1213 20:47:01.103780 16065 master.cpp:8962] Successfully authenticated 
principal 'test-principal' at 
[email protected]:37867
3: I1213 20:47:01.103950 16076 state.cpp:66] Recovering state from 
'/tmp/MasterAllocatorTest_0_SlaveAdded_8ckWSa/meta'
3: I1213 20:47:01.103962 16070 authenticator.cpp:432] Authentication session 
cleanup for crammd5-authenticatee(561)@172.17.0.4:37867
3: I1213 20:47:01.104138 16069 sched.cpp:502] Successfully authenticated with 
master [email protected]:37867
3: I1213 20:47:01.104166 16069 sched.cpp:824] Sending SUBSCRIBE call to 
[email protected]:37867
3: I1213 20:47:01.104281 16076 task_status_update_manager.cpp:207] Recovering 
task status update manager
3: I1213 20:47:01.104300 16069 sched.cpp:857] Will retry registration in 
585.011086ms if necessary
3: I1213 20:47:01.104467 16083 master.cpp:2957] Received SUBSCRIBE call for 
framework 'default' at 
[email protected]:37867
3: I1213 20:47:01.104488 16083 master.cpp:2274] Authorizing framework principal 
'test-principal' to receive offers for roles '{ * }'
3: I1213 20:47:01.104666 16082 slave.cpp:6747] Finished recovery
3: I1213 20:47:01.105090 16067 master.cpp:3037] Subscribing framework default 
with checkpointing disabled and capabilities [ MULTI_ROLE, 
RESERVATION_REFINEMENT ]
3: I1213 20:47:01.105298 16074 task_status_update_manager.cpp:181] Pausing 
sending task status updates
3: I1213 20:47:01.105314 16072 slave.cpp:1033] New master detected at 
[email protected]:37867
3: I1213 20:47:01.105346 16067 master.cpp:9153] Adding framework 
88c8c244-0081-4498-b160-2c4b38b3b916-0000 (default) at 
[email protected]:37867 with roles {  } 
suppressed
3: I1213 20:47:01.105402 16072 slave.cpp:1088] Detecting new master
3: I1213 20:47:01.105854 16071 sched.cpp:751] Framework registered with 
88c8c244-0081-4498-b160-2c4b38b3b916-0000
3: I1213 20:47:01.105933 16071 sched.cpp:765] Scheduler::registered took 49689ns
3: I1213 20:47:01.106051 16064 hierarchical.cpp:297] Added framework 
88c8c244-0081-4498-b160-2c4b38b3b916-0000
3: I1213 20:47:01.106269 16064 hierarchical.cpp:1517] Performed allocation for 
0 agents in 78145ns
3: I1213 20:47:01.114749 16063 slave.cpp:1115] Authenticating with master 
[email protected]:37867
3: I1213 20:47:01.114821 16063 slave.cpp:1124] Using default CRAM-MD5 
authenticatee
3: I1213 20:47:01.115072 16070 authenticatee.cpp:121] Creating new client SASL 
connection
3: I1213 20:47:01.115464 16061 master.cpp:8932] Authenticating 
slave(289)@172.17.0.4:37867
3: I1213 20:47:01.115682 16073 authenticator.cpp:414] Starting authentication 
session for crammd5-authenticatee(562)@172.17.0.4:37867
3: I1213 20:47:01.115950 16068 authenticator.cpp:98] Creating new server SASL 
connection
3: I1213 20:47:01.116181 16081 authenticatee.cpp:213] Received SASL 
authentication mechanisms: CRAM-MD5
3: I1213 20:47:01.116217 16081 authenticatee.cpp:239] Attempting to 
authenticate with mechanism 'CRAM-MD5'
3: I1213 20:47:01.116320 16081 authenticator.cpp:204] Received SASL 
authentication start
3: I1213 20:47:01.116367 16081 authenticator.cpp:326] Authentication requires 
more steps
3: I1213 20:47:01.116477 16076 authenticatee.cpp:259] Received SASL 
authentication step
3: I1213 20:47:01.116672 16077 authenticator.cpp:232] Received SASL 
authentication step
3: I1213 20:47:01.116721 16077 auxprop.cpp:109] Request to lookup properties 
for user: 'test-principal' realm: '64aaf82e0ca6' server FQDN: '64aaf82e0ca6' 
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false 
SASL_AUXPROP_AUTHZID: false 
3: I1213 20:47:01.116736 16077 auxprop.cpp:181] Looking up auxiliary property 
'*userPassword'
3: I1213 20:47:01.116781 16077 auxprop.cpp:181] Looking up auxiliary property 
'*cmusaslsecretCRAM-MD5'
3: I1213 20:47:01.116796 16077 auxprop.cpp:109] Request to lookup properties 
for user: 'test-principal' realm: '64aaf82e0ca6' server FQDN: '64aaf82e0ca6' 
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false 
SASL_AUXPROP_AUTHZID: true 
3: I1213 20:47:01.116809 16077 auxprop.cpp:131] Skipping auxiliary property 
'*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1213 20:47:01.116814 16077 auxprop.cpp:131] Skipping auxiliary property 
'*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1213 20:47:01.116833 16077 authenticator.cpp:318] Authentication success
3: I1213 20:47:01.117003 16066 authenticatee.cpp:299] Authentication success
3: I1213 20:47:01.117046 16083 master.cpp:8962] Successfully authenticated 
principal 'test-principal' at slave(289)@172.17.0.4:37867
3: I1213 20:47:01.117089 16075 authenticator.cpp:432] Authentication session 
cleanup for crammd5-authenticatee(562)@172.17.0.4:37867
3: I1213 20:47:01.117287 16078 slave.cpp:1207] Successfully authenticated with 
master [email protected]:37867
3: I1213 20:47:01.117612 16078 slave.cpp:1684] Will retry registration in 
5.251825ms if necessary
3: I1213 20:47:01.117831 16072 master.cpp:6077] Received register agent message 
from slave(289)@172.17.0.4:37867 (64aaf82e0ca6)
3: I1213 20:47:01.117888 16072 master.cpp:3866] Authorizing agent with 
principal 'test-principal'
3: I1213 20:47:01.118398 16067 master.cpp:6147] Authorized registration of 
agent at slave(289)@172.17.0.4:37867 (64aaf82e0ca6)
3: I1213 20:47:01.118484 16067 master.cpp:6240] Registering agent at 
slave(289)@172.17.0.4:37867 (64aaf82e0ca6) with id 
88c8c244-0081-4498-b160-2c4b38b3b916-S0
3: I1213 20:47:01.118927 16080 registrar.cpp:495] Applied 1 operations in 
101495ns; attempting to update the registry
3: I1213 20:47:01.119407 16080 registrar.cpp:552] Successfully updated the 
registry in 432896ns
3: I1213 20:47:01.119575 16070 master.cpp:6288] Admitted agent 
88c8c244-0081-4498-b160-2c4b38b3b916-S0 at slave(289)@172.17.0.4:37867 
(64aaf82e0ca6)
3: I1213 20:47:01.120175 16070 master.cpp:6337] Registered agent 
88c8c244-0081-4498-b160-2c4b38b3b916-S0 at slave(289)@172.17.0.4:37867 
(64aaf82e0ca6) with cpus:3; mem:1024; disk:367489; ports:[31000-32000]
3: I1213 20:47:01.120355 16073 slave.cpp:1253] Registered with master 
[email protected]:37867; given agent ID 88c8c244-0081-4498-b160-2c4b38b3b916-S0
3: I1213 20:47:01.120506 16081 task_status_update_manager.cpp:188] Resuming 
sending task status updates
3: I1213 20:47:01.120679 16061 hierarchical.cpp:574] Added agent 
88c8c244-0081-4498-b160-2c4b38b3b916-S0 (64aaf82e0ca6) with cpus:3; mem:1024; 
disk:367489; ports:[31000-32000] (allocated: {})
3: I1213 20:47:01.120723 16073 slave.cpp:1273] Checkpointing SlaveInfo to 
'/tmp/MasterAllocatorTest_0_SlaveAdded_8ckWSa/meta/slaves/88c8c244-0081-4498-b160-2c4b38b3b916-S0/slave.info'
3: I1213 20:47:01.121213 16073 slave.cpp:1330] Forwarding agent update 
{"offer_operations":{},"resource_categories":{"oversubscribed":true},"resource_version_uuid":"pthXD7JpT\/q82aEFwLTDUQ==","slave_id":{"value":"88c8c244-0081-4498-b160-2c4b38b3b916-S0"}}
3: I1213 20:47:01.121520 16077 master.cpp:7270] Received update of agent 
88c8c244-0081-4498-b160-2c4b38b3b916-S0 at slave(289)@172.17.0.4:37867 
(64aaf82e0ca6) with total oversubscribed resources {}
3: I1213 20:47:01.121801 16077 master.cpp:7368] Ignoring update on agent 
88c8c244-0081-4498-b160-2c4b38b3b916-S0 at slave(289)@172.17.0.4:37867 
(64aaf82e0ca6) as it reports no changes
3: I1213 20:47:01.122292 16061 hierarchical.cpp:1517] Performed allocation for 
1 agents in 1.454012ms
3: I1213 20:47:01.122804 16066 master.cpp:8762] Sending 1 offers to framework 
88c8c244-0081-4498-b160-2c4b38b3b916-0000 (default) at 
[email protected]:37867
3: I1213 20:47:01.124279 16083 sched.cpp:921] Scheduler::resourceOffers took 
996660ns
3: I1213 20:47:01.125628 16079 master.cpp:10683] Removing offer 
88c8c244-0081-4498-b160-2c4b38b3b916-O0
3: I1213 20:47:01.125774 16079 master.cpp:4273] Processing ACCEPT call for 
offers: [ 88c8c244-0081-4498-b160-2c4b38b3b916-O0 ] on agent 
88c8c244-0081-4498-b160-2c4b38b3b916-S0 at slave(289)@172.17.0.4:37867 
(64aaf82e0ca6) for framework 88c8c244-0081-4498-b160-2c4b38b3b916-0000 
(default) at [email protected]:37867
3: I1213 20:47:01.125859 16079 master.cpp:3593] Authorizing framework principal 
'test-principal' to launch task 0
3: W1213 20:47:01.127552 16075 validation.cpp:1387] Executor 'default' for task 
'0' uses less CPUs (None) than the minimum required (0.01). Please update your 
executor, as this will be mandatory in future releases.
3: W1213 20:47:01.127591 16075 validation.cpp:1399] Executor 'default' for task 
'0' uses less memory (None) than the minimum required (32MB). Please update 
your executor, as this will be mandatory in future releases.
3: I1213 20:47:01.127977 16075 master.cpp:11438] Adding task 0 with resources 
cpus(allocated: *):2; mem(allocated: *):512 on agent 
88c8c244-0081-4498-b160-2c4b38b3b916-S0 at slave(289)@172.17.0.4:37867 
(64aaf82e0ca6)
3: I1213 20:47:01.128204 16075 master.cpp:5024] Launching task 0 of framework 
88c8c244-0081-4498-b160-2c4b38b3b916-0000 (default) at 
[email protected]:37867 with resources 
[{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":512.0},"type":"SCALAR"}]
 on agent 88c8c244-0081-4498-b160-2c4b38b3b916-S0 at 
slave(289)@172.17.0.4:37867 (64aaf82e0ca6)
3: I1213 20:47:01.128767 16072 slave.cpp:1807] Got assigned task '0' for 
framework 88c8c244-0081-4498-b160-2c4b38b3b916-0000
3: I1213 20:47:01.129420 16072 slave.cpp:2077] Authorizing task '0' for 
framework 88c8c244-0081-4498-b160-2c4b38b3b916-0000
3: I1213 20:47:01.129482 16072 slave.cpp:7755] Authorizing framework principal 
'test-principal' to launch task 0
3: I1213 20:47:01.129568 16065 hierarchical.cpp:1192] Recovered cpus(allocated: 
*):1; mem(allocated: *):512; disk(allocated: *):367489; ports(allocated: 
*):[31000-32000] (total: cpus:3; mem:1024; disk:367489; ports:[31000-32000], 
allocated: cpus(allocated: *):2; mem(allocated: *):512) on agent 
88c8c244-0081-4498-b160-2c4b38b3b916-S0 from framework 
88c8c244-0081-4498-b160-2c4b38b3b916-0000
3: I1213 20:47:01.129639 16065 hierarchical.cpp:1238] Framework 
88c8c244-0081-4498-b160-2c4b38b3b916-0000 filtered agent 
88c8c244-0081-4498-b160-2c4b38b3b916-S0 for 100ms
3: I1213 20:47:01.130414 16064 slave.cpp:2471] Launching task '0' for framework 
88c8c244-0081-4498-b160-2c4b38b3b916-0000
3: I1213 20:47:01.130895 16064 paths.cpp:702] Trying to chown 
'/tmp/MasterAllocatorTest_0_SlaveAdded_8ckWSa/slaves/88c8c244-0081-4498-b160-2c4b38b3b916-S0/frameworks/88c8c244-0081-4498-b160-2c4b38b3b916-0000/executors/default/runs/2feeed0e-0e0e-4bbf-9d28-8ce40dad22e5'
 to user 'mesos'
3: I1213 20:47:01.131112 16064 slave.cpp:8229] Launching executor 'default' of 
framework 88c8c244-0081-4498-b160-2c4b38b3b916-0000 with resources [] in work 
directory 
'/tmp/MasterAllocatorTest_0_SlaveAdded_8ckWSa/slaves/88c8c244-0081-4498-b160-2c4b38b3b916-S0/frameworks/88c8c244-0081-4498-b160-2c4b38b3b916-0000/executors/default/runs/2feeed0e-0e0e-4bbf-9d28-8ce40dad22e5'
3: I1213 20:47:01.131547 16064 slave.cpp:3023] Launching container 
2feeed0e-0e0e-4bbf-9d28-8ce40dad22e5 for executor 'default' of framework 
88c8c244-0081-4498-b160-2c4b38b3b916-0000
3: I1213 20:47:01.131947 16064 slave.cpp:2557] Queued task '0' for executor 
'default' of framework 88c8c244-0081-4498-b160-2c4b38b3b916-0000
3: I1213 20:47:01.132037 16064 slave.cpp:984] Successfully attached 
'/tmp/MasterAllocatorTest_0_SlaveAdded_8ckWSa/slaves/88c8c244-0081-4498-b160-2c4b38b3b916-S0/frameworks/88c8c244-0081-4498-b160-2c4b38b3b916-0000/executors/default/runs/2feeed0e-0e0e-4bbf-9d28-8ce40dad22e5'
 to virtual path 
'/tmp/MasterAllocatorTest_0_SlaveAdded_8ckWSa/slaves/88c8c244-0081-4498-b160-2c4b38b3b916-S0/frameworks/88c8c244-0081-4498-b160-2c4b38b3b916-0000/executors/default/runs/latest'
3: I1213 20:47:01.132074 16064 slave.cpp:984] Successfully attached 
'/tmp/MasterAllocatorTest_0_SlaveAdded_8ckWSa/slaves/88c8c244-0081-4498-b160-2c4b38b3b916-S0/frameworks/88c8c244-0081-4498-b160-2c4b38b3b916-0000/executors/default/runs/2feeed0e-0e0e-4bbf-9d28-8ce40dad22e5'
 to virtual path 
'/frameworks/88c8c244-0081-4498-b160-2c4b38b3b916-0000/executors/default/runs/latest'
3: I1213 20:47:01.132104 16064 slave.cpp:984] Successfully attached 
'/tmp/MasterAllocatorTest_0_SlaveAdded_8ckWSa/slaves/88c8c244-0081-4498-b160-2c4b38b3b916-S0/frameworks/88c8c244-0081-4498-b160-2c4b38b3b916-0000/executors/default/runs/2feeed0e-0e0e-4bbf-9d28-8ce40dad22e5'
 to virtual path 
'/tmp/MasterAllocatorTest_0_SlaveAdded_8ckWSa/slaves/88c8c244-0081-4498-b160-2c4b38b3b916-S0/frameworks/88c8c244-0081-4498-b160-2c4b38b3b916-0000/executors/default/runs/2feeed0e-0e0e-4bbf-9d28-8ce40dad22e5'
3: W1213 20:47:01.136086 16069 process.cpp:2756] Attempted to spawn already 
running process [email protected]:37867
3: I1213 20:47:01.136358 16069 exec.cpp:162] Version: 1.5.0
3: I1213 20:47:01.136778 16081 exec.cpp:212] Executor started at: 
executor(94)@172.17.0.4:37867 with pid 16059
3: I1213 20:47:01.136982 16081 slave.cpp:4298] Got registration for executor 
'default' of framework 88c8c244-0081-4498-b160-2c4b38b3b916-0000 from 
executor(94)@172.17.0.4:37867
3: I1213 20:47:01.137399 16073 exec.cpp:237] Executor registered on agent 
88c8c244-0081-4498-b160-2c4b38b3b916-S0
3: I1213 20:47:01.137449 16073 exec.cpp:249] Executor::registered took 31655ns
3: I1213 20:47:01.138043 16077 hierarchical.cpp:2293] Filtered offer with 
cpus:1; mem:512; disk:367489; ports:[31000-32000] on agent 
88c8c244-0081-4498-b160-2c4b38b3b916-S0 for role * of framework 
88c8c244-0081-4498-b160-2c4b38b3b916-0000
3: I1213 20:47:01.138176 16077 hierarchical.cpp:1517] Performed allocation for 
1 agents in 643911ns
3: I1213 20:47:01.138309 16083 slave.cpp:2762] Sending queued task '0' to 
executor 'default' of framework 88c8c244-0081-4498-b160-2c4b38b3b916-0000 at 
executor(94)@172.17.0.4:37867
3: I1213 20:47:01.138775 16082 exec.cpp:331] Executor asked to run task '0'
3: I1213 20:47:01.138911 16082 exec.cpp:340] Executor::launchTask took 110921ns
3: I1213 20:47:01.139031 16082 exec.cpp:571] Executor sending status update 
TASK_RUNNING (Status UUID: a28e1c10-7898-4f7b-b48a-6208f8b1d386) for task 0 of 
framework 88c8c244-0081-4498-b160-2c4b38b3b916-0000
3: I1213 20:47:01.139372 16074 slave.cpp:4755] Handling status update 
TASK_RUNNING (Status UUID: a28e1c10-7898-4f7b-b48a-6208f8b1d386) for task 0 of 
framework 88c8c244-0081-4498-b160-2c4b38b3b916-0000 from 
executor(94)@172.17.0.4:37867
3: I1213 20:47:01.140102 16065 task_status_update_manager.cpp:328] Received 
task status update TASK_RUNNING (Status UUID: 
a28e1c10-7898-4f7b-b48a-6208f8b1d386) for task 0 of framework 
88c8c244-0081-4498-b160-2c4b38b3b916-0000
3: I1213 20:47:01.140162 16065 task_status_update_manager.cpp:507] Creating 
StatusUpdate stream for task 0 of framework 
88c8c244-0081-4498-b160-2c4b38b3b916-0000
3: I1213 20:47:01.140849 16065 task_status_update_manager.cpp:383] Forwarding 
task status update TASK_RUNNING (Status UUID: 
a28e1c10-7898-4f7b-b48a-6208f8b1d386) for task 0 of framework 
88c8c244-0081-4498-b160-2c4b38b3b916-0000 to the agent
3: I1213 20:47:01.141216 16071 slave.cpp:5238] Forwarding the update 
TASK_RUNNING (Status UUID: a28e1c10-7898-4f7b-b48a-6208f8b1d386) for task 0 of 
framework 88c8c244-0081-4498-b160-2c4b38b3b916-0000 to [email protected]:37867
3: I1213 20:47:01.141559 16071 slave.cpp:5131] Task status update manager 
successfully handled status update TASK_RUNNING (Status UUID: 
a28e1c10-7898-4f7b-b48a-6208f8b1d386) for task 0 of framework 
88c8c244-0081-4498-b160-2c4b38b3b916-0000
3: I1213 20:47:01.141621 16071 slave.cpp:5147] Sending acknowledgement for 
status update TASK_RUNNING (Status UUID: a28e1c10-7898-4f7b-b48a-6208f8b1d386) 
for task 0 of framework 88c8c244-0081-4498-b160-2c4b38b3b916-0000 to 
executor(94)@172.17.0.4:37867
3: I1213 20:47:01.141808 16067 master.cpp:7855] Status update TASK_RUNNING 
(Status UUID: a28e1c10-7898-4f7b-b48a-6208f8b1d386) for task 0 of framework 
88c8c244-0081-4498-b160-2c4b38b3b916-0000 from agent 
88c8c244-0081-4498-b160-2c4b38b3b916-S0 at slave(289)@172.17.0.4:37867 
(64aaf82e0ca6)
3: I1213 20:47:01.141872 16067 master.cpp:7911] Forwarding status update 
TASK_RUNNING (Status UUID: a28e1c10-7898-4f7b-b48a-6208f8b1d386) for task 0 of 
framework 88c8c244-0081-4498-b160-2c4b38b3b916-0000
3: I1213 20:47:01.141878 16063 exec.cpp:388] Executor received status update 
acknowledgement a28e1c10-7898-4f7b-b48a-6208f8b1d386 for task 0 of framework 
88c8c244-0081-4498-b160-2c4b38b3b916-0000
3: I1213 20:47:01.142050 16067 master.cpp:10158] Updating the state of task 0 
of framework 88c8c244-0081-4498-b160-2c4b38b3b916-0000 (latest state: 
TASK_RUNNING, status update state: TASK_RUNNING)
3: I1213 20:47:01.142293 16080 sched.cpp:1029] Scheduler::statusUpdate took 
27091ns
3: I1213 20:47:01.142565 16068 master.cpp:5842] Processing ACKNOWLEDGE call 
a28e1c10-7898-4f7b-b48a-6208f8b1d386 for task 0 of framework 
88c8c244-0081-4498-b160-2c4b38b3b916-0000 (default) at 
[email protected]:37867 on agent 
88c8c244-0081-4498-b160-2c4b38b3b916-S0
3: I1213 20:47:01.142864 16070 task_status_update_manager.cpp:401] Received 
task status update acknowledgement (UUID: a28e1c10-7898-4f7b-b48a-6208f8b1d386) 
for task 0 of framework 88c8c244-0081-4498-b160-2c4b38b3b916-0000
3: I1213 20:47:01.143090 16076 slave.cpp:4033] Task status update manager 
successfully handled status update acknowledgement (UUID: 
a28e1c10-7898-4f7b-b48a-6208f8b1d386) for task 0 of framework 
88c8c244-0081-4498-b160-2c4b38b3b916-0000
3: W1213 20:47:01.144191 16059 process.cpp:2756] Attempted to spawn already 
running process [email protected]:37867
3: I1213 20:47:01.145110 16059 containerizer.cpp:304] Using isolation { 
environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
3: W1213 20:47:01.145604 16059 backend.cpp:76] Failed to create 'aufs' backend: 
AufsBackend requires root privileges
3: W1213 20:47:01.145710 16059 backend.cpp:76] Failed to create 'bind' backend: 
BindBackend requires root privileges
3: I1213 20:47:01.145740 16059 provisioner.cpp:299] Using default backend 'copy'
3: I1213 20:47:01.147627 16059 cluster.cpp:460] Creating default 'local' 
authorizer
3: I1213 20:47:01.149816 16070 slave.cpp:258] Mesos agent started on 
(290)@172.17.0.4:37867
3: I1213 20:47:01.149843 16070 slave.cpp:259] Flags at startup: --acls="" 
--appc_simple_discovery_uri_prefix="http://"; 
--appc_store_dir="/tmp/MasterAllocatorTest_0_SlaveAdded_jYvHij/store/appc" 
--authenticate_http_readonly="true" --authenticate_http_readwrite="true" 
--authenticatee="crammd5" --authentication_backoff_factor="1secs" 
--authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" 
--cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" 
--cgroups_limit_swap="false" --cgroups_root="mesos" 
--container_disk_watch_interval="15secs" --containerizers="mesos" 
--credential="/tmp/MasterAllocatorTest_0_SlaveAdded_jYvHij/credential" 
--default_role="*" --disallow_sharing_agent_pid_namespace="false" 
--disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" 
--docker_registry="https://registry-1.docker.io"; --docker_remove_delay="6hrs" 
--docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" 
--docker_store_dir="/tmp/MasterAllocatorTest_0_SlaveAdded_jYvHij/store/docker" 
--docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" 
--enforce_container_disk_quota="false" --executor_registration_timeout="1mins" 
--executor_reregistration_timeout="2secs" 
--executor_shutdown_grace_period="5secs" 
--fetcher_cache_dir="/tmp/MasterAllocatorTest_0_SlaveAdded_jYvHij/fetch" 
--fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" 
--gc_disk_headroom="0.1" --hadoop_home="" --help="false" 
--hostname_lookup="true" --http_command_executor="false" 
--http_credentials="/tmp/MasterAllocatorTest_0_SlaveAdded_jYvHij/http_credentials"
 --http_heartbeat_interval="30secs" --initialize_driver_logging="true" 
--isolation="posix/cpu,posix/mem" --launcher="posix" 
--launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" 
--max_completed_executors_per_framework="150" 
--oversubscribed_resources_interval="15secs" --perf_duration="10secs" 
--perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" 
--quiet="false" --reconfiguration_policy="equal" --recover="reconnect" 
--recovery_timeout="15mins" --registration_backoff_factor="10ms" 
--resources="cpus:4;mem:2048" --revocable_cpu_low_priority="true" 
--runtime_dir="/tmp/MasterAllocatorTest_0_SlaveAdded_jYvHij" 
--sandbox_directory="/mnt/mesos/sandbox" --strict="true" --switch_user="true" 
--systemd_enable_support="true" 
--systemd_runtime_directory="/run/systemd/system" --version="false" 
--work_dir="/tmp/MasterAllocatorTest_0_SlaveAdded_sCWdzh" 
--zk_session_timeout="10secs"
3: I1213 20:47:01.150279 16070 credentials.hpp:86] Loading credential for 
authentication from '/tmp/MasterAllocatorTest_0_SlaveAdded_jYvHij/credential'
3: I1213 20:47:01.150532 16070 slave.cpp:291] Agent using credential for: 
test-principal
3: I1213 20:47:01.150550 16070 credentials.hpp:37] Loading credentials for 
authentication from 
'/tmp/MasterAllocatorTest_0_SlaveAdded_jYvHij/http_credentials'
3: I1213 20:47:01.150844 16070 http.cpp:1045] Creating default 'basic' HTTP 
authenticator for realm 'mesos-agent-readonly'
3: I1213 20:47:01.151057 16070 http.cpp:1045] Creating default 'basic' HTTP 
authenticator for realm 'mesos-agent-readwrite'
3: I1213 20:47:01.152204 16070 slave.cpp:590] Agent resources: 
[{"name":"cpus","scalar":{"value":4.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":2048.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":367489.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
3: I1213 20:47:01.152415 16070 slave.cpp:598] Agent attributes: [  ]
3: I1213 20:47:01.152423 16070 slave.cpp:607] Agent hostname: 64aaf82e0ca6
3: I1213 20:47:01.152676 16078 task_status_update_manager.cpp:181] Pausing 
sending task status updates
3: I1213 20:47:01.154084 16072 state.cpp:66] Recovering state from 
'/tmp/MasterAllocatorTest_0_SlaveAdded_sCWdzh/meta'
3: I1213 20:47:01.154464 16063 task_status_update_manager.cpp:207] Recovering 
task status update manager
3: I1213 20:47:01.154743 16067 containerizer.cpp:674] Recovering containerizer
3: I1213 20:47:01.156535 16077 provisioner.cpp:495] Provisioner recovery 
complete
3: I1213 20:47:01.157053 16075 slave.cpp:6747] Finished recovery
3: I1213 20:47:01.157838 16074 slave.cpp:1033] New master detected at 
[email protected]:37867
3: I1213 20:47:01.157904 16070 task_status_update_manager.cpp:181] Pausing 
sending task status updates
3: I1213 20:47:01.157948 16074 slave.cpp:1088] Detecting new master
3: I1213 20:47:01.167372 16065 slave.cpp:1115] Authenticating with master 
[email protected]:37867
3: I1213 20:47:01.167441 16065 slave.cpp:1124] Using default CRAM-MD5 
authenticatee
3: I1213 20:47:01.167716 16071 authenticatee.cpp:121] Creating new client SASL 
connection
3: I1213 20:47:01.168031 16063 master.cpp:8932] Authenticating 
slave(290)@172.17.0.4:37867
3: I1213 20:47:01.168217 16080 authenticator.cpp:414] Starting authentication 
session for crammd5-authenticatee(563)@172.17.0.4:37867
3: I1213 20:47:01.168473 16076 authenticator.cpp:98] Creating new server SASL 
connection
3: I1213 20:47:01.168794 16066 authenticatee.cpp:213] Received SASL 
authentication mechanisms: CRAM-MD5
3: I1213 20:47:01.168836 16066 authenticatee.cpp:239] Attempting to 
authenticate with mechanism 'CRAM-MD5'
3: I1213 20:47:01.168967 16066 authenticator.cpp:204] Received SASL 
authentication start
3: I1213 20:47:01.169028 16066 authenticator.cpp:326] Authentication requires 
more steps
3: I1213 20:47:01.169152 16066 authenticatee.cpp:259] Received SASL 
authentication step
3: I1213 20:47:01.169268 16066 authenticator.cpp:232] Received SASL 
authentication step
3: I1213 20:47:01.169312 16066 auxprop.cpp:109] Request to lookup properties 
for user: 'test-principal' realm: '64aaf82e0ca6' server FQDN: '64aaf82e0ca6' 
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false 
SASL_AUXPROP_AUTHZID: false 
3: I1213 20:47:01.169327 16066 auxprop.cpp:181] Looking up auxiliary property 
'*userPassword'
3: I1213 20:47:01.169350 16066 auxprop.cpp:181] Looking up auxiliary property 
'*cmusaslsecretCRAM-MD5'
3: I1213 20:47:01.169369 16066 auxprop.cpp:109] Request to lookup properties 
for user: 'test-principal' realm: '64aaf82e0ca6' server FQDN: '64aaf82e0ca6' 
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false 
SASL_AUXPROP_AUTHZID: true 
3: I1213 20:47:01.169375 16066 auxprop.cpp:131] Skipping auxiliary property 
'*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1213 20:47:01.169380 16066 auxprop.cpp:131] Skipping auxiliary property 
'*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1213 20:47:01.169391 16066 authenticator.cpp:318] Authentication success
3: I1213 20:47:01.169503 16067 authenticatee.cpp:299] Authentication success
3: I1213 20:47:01.169548 16064 master.cpp:8962] Successfully authenticated 
principal 'test-principal' at slave(290)@172.17.0.4:37867
3: I1213 20:47:01.169592 16062 authenticator.cpp:432] Authentication session 
cleanup for crammd5-authenticatee(563)@172.17.0.4:37867
3: I1213 20:47:01.169760 16067 slave.cpp:1207] Successfully authenticated with 
master [email protected]:37867
3: I1213 20:47:01.169929 16067 slave.cpp:1684] Will retry registration in 
7.673267ms if necessary
3: I1213 20:47:01.170094 16082 master.cpp:6077] Received register agent message 
from slave(290)@172.17.0.4:37867 (64aaf82e0ca6)
3: I1213 20:47:01.170166 16082 master.cpp:3866] Authorizing agent with 
principal 'test-principal'
3: I1213 20:47:01.170627 16075 master.cpp:6147] Authorized registration of 
agent at slave(290)@172.17.0.4:37867 (64aaf82e0ca6)
3: I1213 20:47:01.170732 16075 master.cpp:6240] Registering agent at 
slave(290)@172.17.0.4:37867 (64aaf82e0ca6) with id 
88c8c244-0081-4498-b160-2c4b38b3b916-S1
3: I1213 20:47:01.171226 16060 registrar.cpp:495] Applied 1 operations in 
122658ns; attempting to update the registry
3: I1213 20:47:01.171797 16060 registrar.cpp:552] Successfully updated the 
registry in 514816ns
3: I1213 20:47:01.171948 16065 master.cpp:6288] Admitted agent 
88c8c244-0081-4498-b160-2c4b38b3b916-S1 at slave(290)@172.17.0.4:37867 
(64aaf82e0ca6)
3: I1213 20:47:01.172562 16065 master.cpp:6337] Registered agent 
88c8c244-0081-4498-b160-2c4b38b3b916-S1 at slave(290)@172.17.0.4:37867 
(64aaf82e0ca6) with cpus:4; mem:2048; disk:367489; ports:[31000-32000]
3: I1213 20:47:01.172652 16063 slave.cpp:1253] Registered with master 
[email protected]:37867; given agent ID 88c8c244-0081-4498-b160-2c4b38b3b916-S1
3: I1213 20:47:01.172834 16069 task_status_update_manager.cpp:188] Resuming 
sending task status updates
3: I1213 20:47:01.173028 16080 hierarchical.cpp:574] Added agent 
88c8c244-0081-4498-b160-2c4b38b3b916-S1 (64aaf82e0ca6) with cpus:4; mem:2048; 
disk:367489; ports:[31000-32000] (allocated: {})
3: I1213 20:47:01.173108 16063 slave.cpp:1273] Checkpointing SlaveInfo to 
'/tmp/MasterAllocatorTest_0_SlaveAdded_sCWdzh/meta/slaves/88c8c244-0081-4498-b160-2c4b38b3b916-S1/slave.info'
3: I1213 20:47:01.173801 16063 slave.cpp:1330] Forwarding agent update 
{"offer_operations":{},"resource_categories":{"oversubscribed":true},"resource_version_uuid":"kh3oJTCqS7yeEzaCb3LL1Q==","slave_id":{"value":"88c8c244-0081-4498-b160-2c4b38b3b916-S1"}}
3: I1213 20:47:01.174204 16063 master.cpp:7270] Received update of agent 
88c8c244-0081-4498-b160-2c4b38b3b916-S1 at slave(290)@172.17.0.4:37867 
(64aaf82e0ca6) with total oversubscribed resources {}
3: I1213 20:47:01.174576 16063 master.cpp:7368] Ignoring update on agent 
88c8c244-0081-4498-b160-2c4b38b3b916-S1 at slave(290)@172.17.0.4:37867 
(64aaf82e0ca6) as it reports no changes
3: I1213 20:47:01.174612 16080 hierarchical.cpp:1517] Performed allocation for 
1 agents in 1.398987ms
3: I1213 20:47:01.175441 16063 master.cpp:8762] Sending 1 offers to framework 
88c8c244-0081-4498-b160-2c4b38b3b916-0000 (default) at 
[email protected]:37867
3: I1213 20:47:01.175983 16066 sched.cpp:921] Scheduler::resourceOffers took 
116651ns
3: I1213 20:47:01.176316 16066 master.cpp:5483] Processing DECLINE call for 
offers: [ 88c8c244-0081-4498-b160-2c4b38b3b916-O1 ] for framework 
88c8c244-0081-4498-b160-2c4b38b3b916-0000 (default) at 
[email protected]:37867
3: I1213 20:47:01.176862 16066 master.cpp:10683] Removing offer 
88c8c244-0081-4498-b160-2c4b38b3b916-O1
3: I1213 20:47:01.178038 16083 hierarchical.cpp:1192] Recovered cpus(allocated: 
*):4; mem(allocated: *):2048; disk(allocated: *):367489; ports(allocated: 
*):[31000-32000] (total: cpus:4; mem:2048; disk:367489; ports:[31000-32000], 
allocated: {}) on agent 88c8c244-0081-4498-b160-2c4b38b3b916-S1 from framework 
88c8c244-0081-4498-b160-2c4b38b3b916-0000
3: I1213 20:47:01.189513 16079 hierarchical.cpp:2293] Filtered offer with 
cpus:1; mem:512; disk:367489; ports:[31000-32000] on agent 
88c8c244-0081-4498-b160-2c4b38b3b916-S0 for role * of framework 
88c8c244-0081-4498-b160-2c4b38b3b916-0000
3: I1213 20:47:01.191233 16079 hierarchical.cpp:1517] Performed allocation for 
2 agents in 2.419916ms
3: I1213 20:47:01.191668 16064 master.cpp:8762] Sending 1 offers to framework 
88c8c244-0081-4498-b160-2c4b38b3b916-0000 (default) at 
[email protected]:37867
3: I1213 20:47:01.192163 16064 sched.cpp:921] Scheduler::resourceOffers took 
105836ns
3: I1213 20:47:01.192462 16064 master.cpp:5483] Processing DECLINE call for 
offers: [ 88c8c244-0081-4498-b160-2c4b38b3b916-O2 ] for framework 
88c8c244-0081-4498-b160-2c4b38b3b916-0000 (default) at 
[email protected]:37867
3: I1213 20:47:01.193184 16064 master.cpp:10683] Removing offer 
88c8c244-0081-4498-b160-2c4b38b3b916-O2
3: I1213 20:47:01.193681 16067 hierarchical.cpp:1192] Recovered cpus(allocated: 
*):4; mem(allocated: *):2048; disk(allocated: *):367489; ports(allocated: 
*):[31000-32000] (total: cpus:4; mem:2048; disk:367489; ports:[31000-32000], 
allocated: {}) on agent 88c8c244-0081-4498-b160-2c4b38b3b916-S1 from framework 
88c8c244-0081-4498-b160-2c4b38b3b916-0000
3: I1213 20:47:01.245332 16075 hierarchical.cpp:1517] Performed allocation for 
2 agents in 2.443003ms
3: I1213 20:47:01.246173 16070 master.cpp:8762] Sending 2 offers to framework 
88c8c244-0081-4498-b160-2c4b38b3b916-0000 (default) at 
[email protected]:37867
3: I1213 20:47:01.247031 16078 sched.cpp:921] Scheduler::resourceOffers took 
98930ns
3: I1213 20:47:01.247529 16059 sched.cpp:2009] Asked to stop the driver
3: I1213 20:47:01.247668 16076 sched.cpp:1191] Stopping framework 
88c8c244-0081-4498-b160-2c4b38b3b916-0000
3: I1213 20:47:01.247923 16065 master.cpp:9442] Processing TEARDOWN call for 
framework 88c8c244-0081-4498-b160-2c4b38b3b916-0000 (default) at 
[email protected]:37867
3: I1213 20:47:01.247951 16065 master.cpp:9454] Removing framework 
88c8c244-0081-4498-b160-2c4b38b3b916-0000 (default) at 
[email protected]:37867
3: I1213 20:47:01.247963 16065 master.cpp:3327] Deactivating framework 
88c8c244-0081-4498-b160-2c4b38b3b916-0000 (default) at 
[email protected]:37867
3: I1213 20:47:01.248133 16068 hierarchical.cpp:405] Deactivated framework 
88c8c244-0081-4498-b160-2c4b38b3b916-0000
3: I1213 20:47:01.248137 16059 slave.cpp:909] Agent terminating
3: I1213 20:47:01.248503 16065 master.cpp:10683] Removing offer 
88c8c244-0081-4498-b160-2c4b38b3b916-O4
3: I1213 20:47:01.248970 16065 master.cpp:10683] Removing offer 
88c8c244-0081-4498-b160-2c4b38b3b916-O3
3: I1213 20:47:01.249320 16076 slave.cpp:3375] Asked to shut down framework 
88c8c244-0081-4498-b160-2c4b38b3b916-0000 by [email protected]:37867
3: I1213 20:47:01.249387 16076 slave.cpp:3400] Shutting down framework 
88c8c244-0081-4498-b160-2c4b38b3b916-0000
3: I1213 20:47:01.249404 16065 master.cpp:10158] Updating the state of task 0 
of framework 88c8c244-0081-4498-b160-2c4b38b3b916-0000 (latest state: 
TASK_KILLED, status update state: TASK_KILLED)
3: I1213 20:47:01.249464 16076 slave.cpp:6114] Shutting down executor 'default' 
of framework 88c8c244-0081-4498-b160-2c4b38b3b916-0000 at 
executor(94)@172.17.0.4:37867
3: I1213 20:47:01.249629 16083 exec.cpp:435] Executor asked to shutdown
3: I1213 20:47:01.249675 16083 exec.cpp:450] Executor::shutdown took 39684ns
3: I1213 20:47:01.249661 16068 hierarchical.cpp:1192] Recovered cpus(allocated: 
*):1; mem(allocated: *):512; disk(allocated: *):367489; ports(allocated: 
*):[31000-32000] (total: cpus:3; mem:1024; disk:367489; ports:[31000-32000], 
allocated: cpus(allocated: *):2; mem(allocated: *):512) on agent 
88c8c244-0081-4498-b160-2c4b38b3b916-S0 from framework 
88c8c244-0081-4498-b160-2c4b38b3b916-0000
3: I1213 20:47:01.249876 16067 slave.cpp:5370] Got exited event for 
executor(94)@172.17.0.4:37867
3: I1213 20:47:01.249974 16065 master.cpp:10264] Removing task 0 with resources 
cpus(allocated: *):2; mem(allocated: *):512 of framework 
88c8c244-0081-4498-b160-2c4b38b3b916-0000 on agent 
88c8c244-0081-4498-b160-2c4b38b3b916-S0 at slave(289)@172.17.0.4:37867 
(64aaf82e0ca6)
3: I1213 20:47:01.250356 16065 master.cpp:10293] Removing executor 'default' 
with resources [] of framework 88c8c244-0081-4498-b160-2c4b38b3b916-0000 on 
agent 88c8c244-0081-4498-b160-2c4b38b3b916-S0 at slave(289)@172.17.0.4:37867 
(64aaf82e0ca6)
write /dev/stdout: resource temporarily unavailable
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user [email protected]

Reply via email to