See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,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)/4665/display/redirect?page=changes>
Changes: [bmahler] Added a utility to shrink scalar resource while keeping its meta-data. ------------------------------------------ [...truncated 2.70 MB...] 3: I1222 23:28:16.849256 17451 registrar.cpp:552] Successfully updated the registry in 788992ns 3: I1222 23:28:16.849437 17451 registrar.cpp:424] Successfully recovered registrar 3: I1222 23:28:16.850024 17436 master.cpp:1803] Recovered 0 agents from the registry (135B); allowing 10mins for agents to re-register 3: I1222 23:28:16.850046 17455 hierarchical.cpp:213] Skipping recovery of hierarchical allocator: nothing to recover 3: W1222 23:28:16.856533 17433 process.cpp:2756] Attempted to spawn already running process [email protected]:37043 3: I1222 23:28:16.857797 17433 containerizer.cpp:304] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni } 3: W1222 23:28:16.858464 17433 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges 3: W1222 23:28:16.858613 17433 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges 3: I1222 23:28:16.858656 17433 provisioner.cpp:299] Using default backend 'copy' 3: I1222 23:28:16.861111 17433 cluster.cpp:460] Creating default 'local' authorizer 3: I1222 23:28:16.864137 17436 slave.cpp:262] Mesos agent started on (31)@172.17.0.3:37043 3: I1222 23:28:16.864162 17436 slave.cpp:263] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://"; --appc_store_dir="/tmp/HTTPCommandExecutorTest_ExplicitAcknowledgements_AMUhXZ/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="false" --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/HTTPCommandExecutorTest_ExplicitAcknowledgements_AMUhXZ/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/HTTPCommandExecutorTest_ExplicitAcknowledgements_AMUhXZ/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/HTTPCommandExecutorTest_ExplicitAcknowledgements_AMUhXZ/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="true" --http_credentials="/tmp/HTTPCommandExecutorTest_ExplicitAcknowledgements_AMUhXZ/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:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/HTTPCommandExecutorTest_ExplicitAcknowledgements_AMUhXZ" --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/HTTPCommandExecutorTest_ExplicitAcknowledgements_wHRhBI" --zk_session_timeout="10secs" 3: I1222 23:28:16.864861 17436 credentials.hpp:86] Loading credential for authentication from '/tmp/HTTPCommandExecutorTest_ExplicitAcknowledgements_AMUhXZ/credential' 3: W1222 23:28:16.864894 17433 process.cpp:2756] Attempted to spawn already running process [email protected]:37043 3: I1222 23:28:16.865111 17436 slave.cpp:295] Agent using credential for: test-principal 3: I1222 23:28:16.865142 17436 credentials.hpp:37] Loading credentials for authentication from '/tmp/HTTPCommandExecutorTest_ExplicitAcknowledgements_AMUhXZ/http_credentials' 3: I1222 23:28:16.865511 17436 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' 3: I1222 23:28:16.866488 17433 sched.cpp:232] Version: 1.5.0 3: I1222 23:28:16.867542 17437 sched.cpp:336] New master detected at [email protected]:37043 3: I1222 23:28:16.867698 17437 sched.cpp:396] Authenticating with master [email protected]:37043 3: I1222 23:28:16.867723 17437 sched.cpp:403] Using default CRAM-MD5 authenticatee 3: I1222 23:28:16.868140 17456 authenticatee.cpp:121] Creating new client SASL connection 3: I1222 23:28:16.868170 17436 slave.cpp:612] 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: I1222 23:28:16.868585 17436 slave.cpp:620] Agent attributes: [ ] 3: I1222 23:28:16.868600 17436 slave.cpp:629] Agent hostname: 10a0af919c8c 3: I1222 23:28:16.868702 17435 master.cpp:8928] Authenticating [email protected]:37043 3: I1222 23:28:16.868777 17451 task_status_update_manager.cpp:181] Pausing sending task status updates 3: I1222 23:28:16.868927 17438 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(53)@172.17.0.3:37043 3: I1222 23:28:16.869297 17446 authenticator.cpp:98] Creating new server SASL connection 3: I1222 23:28:16.869668 17457 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 3: I1222 23:28:16.869706 17457 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' 3: I1222 23:28:16.869874 17457 authenticator.cpp:204] Received SASL authentication start 3: I1222 23:28:16.869954 17457 authenticator.cpp:326] Authentication requires more steps 3: I1222 23:28:16.870100 17449 authenticatee.cpp:259] Received SASL authentication step 3: I1222 23:28:16.870267 17449 authenticator.cpp:232] Received SASL authentication step 3: I1222 23:28:16.870302 17449 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '10a0af919c8c' server FQDN: '10a0af919c8c' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 3: I1222 23:28:16.870319 17449 auxprop.cpp:181] Looking up auxiliary property '*userPassword' 3: I1222 23:28:16.870362 17449 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' 3: I1222 23:28:16.870386 17449 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '10a0af919c8c' server FQDN: '10a0af919c8c' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 3: I1222 23:28:16.870398 17449 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true 3: I1222 23:28:16.870405 17449 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true 3: I1222 23:28:16.870422 17449 authenticator.cpp:318] Authentication success 3: I1222 23:28:16.870532 17440 authenticatee.cpp:299] Authentication success 3: I1222 23:28:16.870688 17439 master.cpp:8958] Successfully authenticated principal 'test-principal' at [email protected]:37043 3: I1222 23:28:16.870815 17443 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(53)@172.17.0.3:37043 3: I1222 23:28:16.871024 17441 state.cpp:66] Recovering state from '/tmp/HTTPCommandExecutorTest_ExplicitAcknowledgements_wHRhBI/meta' 3: I1222 23:28:16.871059 17447 sched.cpp:502] Successfully authenticated with master [email protected]:37043 3: I1222 23:28:16.871095 17447 sched.cpp:824] Sending SUBSCRIBE call to [email protected]:37043 3: I1222 23:28:16.871295 17447 sched.cpp:857] Will retry registration in 505.806078ms if necessary 3: I1222 23:28:16.871501 17454 task_status_update_manager.cpp:207] Recovering task status update manager 3: I1222 23:28:16.871601 17437 master.cpp:2958] Received SUBSCRIBE call for framework 'default' at [email protected]:37043 3: I1222 23:28:16.871712 17437 master.cpp:2275] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }' 3: I1222 23:28:16.871819 17435 containerizer.cpp:674] Recovering containerizer 3: I1222 23:28:16.872627 17455 master.cpp:3038] Subscribing framework default with checkpointing disabled and capabilities [ MULTI_ROLE, RESERVATION_REFINEMENT ] 3: I1222 23:28:16.872967 17455 master.cpp:9149] Adding framework 5adaf95f-f38a-4131-8238-da314484293d-0000 (default) at [email protected]:37043 with roles { } suppressed 3: I1222 23:28:16.873577 17452 sched.cpp:751] Framework registered with 5adaf95f-f38a-4131-8238-da314484293d-0000 3: I1222 23:28:16.873646 17452 sched.cpp:765] Scheduler::registered took 30018ns 3: I1222 23:28:16.873719 17439 hierarchical.cpp:297] Added framework 5adaf95f-f38a-4131-8238-da314484293d-0000 3: I1222 23:28:16.874004 17439 hierarchical.cpp:1517] Performed allocation for 0 agents in 109536ns 3: I1222 23:28:16.874323 17441 provisioner.cpp:495] Provisioner recovery complete 3: I1222 23:28:16.874878 17453 slave.cpp:6772] Finished recovery 3: I1222 23:28:16.875963 17438 task_status_update_manager.cpp:181] Pausing sending task status updates 3: I1222 23:28:16.875972 17437 slave.cpp:1055] New master detected at [email protected]:37043 3: I1222 23:28:16.876117 17437 slave.cpp:1110] Detecting new master 3: I1222 23:28:16.885521 17448 slave.cpp:1137] Authenticating with master [email protected]:37043 3: I1222 23:28:16.885593 17448 slave.cpp:1146] Using default CRAM-MD5 authenticatee 3: I1222 23:28:16.885857 17446 authenticatee.cpp:121] Creating new client SASL connection 3: I1222 23:28:16.886168 17457 master.cpp:8928] Authenticating slave(31)@172.17.0.3:37043 3: I1222 23:28:16.886394 17434 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(54)@172.17.0.3:37043 3: I1222 23:28:16.886786 17440 authenticator.cpp:98] Creating new server SASL connection 3: I1222 23:28:16.887169 17435 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 3: I1222 23:28:16.887219 17435 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' 3: I1222 23:28:16.887400 17435 authenticator.cpp:204] Received SASL authentication start 3: I1222 23:28:16.887497 17435 authenticator.cpp:326] Authentication requires more steps 3: I1222 23:28:16.887800 17445 authenticatee.cpp:259] Received SASL authentication step 3: I1222 23:28:16.888005 17450 authenticator.cpp:232] Received SASL authentication step 3: I1222 23:28:16.888059 17450 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '10a0af919c8c' server FQDN: '10a0af919c8c' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 3: I1222 23:28:16.888079 17450 auxprop.cpp:181] Looking up auxiliary property '*userPassword' 3: I1222 23:28:16.888130 17450 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' 3: I1222 23:28:16.888154 17450 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '10a0af919c8c' server FQDN: '10a0af919c8c' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 3: I1222 23:28:16.888165 17450 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true 3: I1222 23:28:16.888173 17450 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true 3: I1222 23:28:16.888196 17450 authenticator.cpp:318] Authentication success 3: I1222 23:28:16.888339 17455 authenticatee.cpp:299] Authentication success 3: I1222 23:28:16.888483 17436 master.cpp:8958] Successfully authenticated principal 'test-principal' at slave(31)@172.17.0.3:37043 3: I1222 23:28:16.888528 17452 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(54)@172.17.0.3:37043 3: I1222 23:28:16.888752 17447 slave.cpp:1229] Successfully authenticated with master [email protected]:37043 3: I1222 23:28:16.888957 17447 slave.cpp:1708] Will retry registration in 245618ns if necessary 3: I1222 23:28:16.889266 17441 master.cpp:6078] Received register agent message from slave(31)@172.17.0.3:37043 (10a0af919c8c) 3: I1222 23:28:16.889401 17441 master.cpp:3867] Authorizing agent with principal 'test-principal' 3: I1222 23:28:16.889879 17453 master.cpp:6148] Authorized registration of agent at slave(31)@172.17.0.3:37043 (10a0af919c8c) 3: I1222 23:28:16.889971 17453 master.cpp:6241] Registering agent at slave(31)@172.17.0.3:37043 (10a0af919c8c) with id 5adaf95f-f38a-4131-8238-da314484293d-S0 3: I1222 23:28:16.890480 17451 registrar.cpp:495] Applied 1 operations in 87577ns; attempting to update the registry 3: I1222 23:28:16.890538 17454 slave.cpp:1708] Will retry registration in 17.7326ms if necessary 3: I1222 23:28:16.890784 17438 master.cpp:6072] Ignoring register agent message from slave(31)@172.17.0.3:37043 (10a0af919c8c) as registration is already in progress 3: I1222 23:28:16.891062 17451 registrar.cpp:552] Successfully updated the registry in 527104ns 3: I1222 23:28:16.891232 17457 master.cpp:6289] Admitted agent 5adaf95f-f38a-4131-8238-da314484293d-S0 at slave(31)@172.17.0.3:37043 (10a0af919c8c) 3: I1222 23:28:16.891932 17457 master.cpp:6338] Registered agent 5adaf95f-f38a-4131-8238-da314484293d-S0 at slave(31)@172.17.0.3:37043 (10a0af919c8c) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] 3: I1222 23:28:16.892169 17440 slave.cpp:1275] Registered with master [email protected]:37043; given agent ID 5adaf95f-f38a-4131-8238-da314484293d-S0 3: I1222 23:28:16.892313 17445 task_status_update_manager.cpp:188] Resuming sending task status updates 3: I1222 23:28:16.892673 17440 slave.cpp:1295] Checkpointing SlaveInfo to '/tmp/HTTPCommandExecutorTest_ExplicitAcknowledgements_wHRhBI/meta/slaves/5adaf95f-f38a-4131-8238-da314484293d-S0/slave.info' 3: I1222 23:28:16.892679 17449 hierarchical.cpp:574] Added agent 5adaf95f-f38a-4131-8238-da314484293d-S0 (10a0af919c8c) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {}) 3: I1222 23:28:16.893503 17440 slave.cpp:1352] Forwarding agent update {"operations":{},"resource_version_uuid":{"value":"WN5vK0CsS8usBuM+GH\/PSg=="},"slave_id":{"value":"5adaf95f-f38a-4131-8238-da314484293d-S0"},"update_oversubscribed_resources":true} 3: I1222 23:28:16.893733 17440 master.cpp:7268] Received update of agent 5adaf95f-f38a-4131-8238-da314484293d-S0 at slave(31)@172.17.0.3:37043 (10a0af919c8c) with total oversubscribed resources {} 3: I1222 23:28:16.894021 17440 master.cpp:7362] Ignoring update on agent 5adaf95f-f38a-4131-8238-da314484293d-S0 at slave(31)@172.17.0.3:37043 (10a0af919c8c) as it reports no changes 3: I1222 23:28:16.895222 17449 hierarchical.cpp:1517] Performed allocation for 1 agents in 2.248679ms 3: I1222 23:28:16.896018 17436 master.cpp:8758] Sending 1 offers to framework 5adaf95f-f38a-4131-8238-da314484293d-0000 (default) at [email protected]:37043 3: I1222 23:28:16.896867 17443 sched.cpp:921] Scheduler::resourceOffers took 157028ns 3: I1222 23:28:16.899597 17454 master.cpp:10671] Removing offer 5adaf95f-f38a-4131-8238-da314484293d-O0 3: I1222 23:28:16.899804 17454 master.cpp:4274] Processing ACCEPT call for offers: [ 5adaf95f-f38a-4131-8238-da314484293d-O0 ] on agent 5adaf95f-f38a-4131-8238-da314484293d-S0 at slave(31)@172.17.0.3:37043 (10a0af919c8c) for framework 5adaf95f-f38a-4131-8238-da314484293d-0000 (default) at [email protected]:37043 3: I1222 23:28:16.899951 17454 master.cpp:3594] Authorizing framework principal 'test-principal' to launch task 2641eb21-f324-4329-8374-5e5d6f269df1 3: I1222 23:28:16.902410 17448 master.cpp:11426] Adding task 2641eb21-f324-4329-8374-5e5d6f269df1 with resources cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000] on agent 5adaf95f-f38a-4131-8238-da314484293d-S0 at slave(31)@172.17.0.3:37043 (10a0af919c8c) 3: I1222 23:28:16.902793 17448 master.cpp:5025] Launching task 2641eb21-f324-4329-8374-5e5d6f269df1 of framework 5adaf95f-f38a-4131-8238-da314484293d-0000 (default) at [email protected]:37043 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}] on agent 5adaf95f-f38a-4131-8238-da314484293d-S0 at slave(31)@172.17.0.3:37043 (10a0af919c8c) 3: I1222 23:28:16.903713 17451 slave.cpp:1831] Got assigned task '2641eb21-f324-4329-8374-5e5d6f269df1' for framework 5adaf95f-f38a-4131-8238-da314484293d-0000 3: I1222 23:28:16.904378 17451 slave.cpp:2101] Authorizing task '2641eb21-f324-4329-8374-5e5d6f269df1' for framework 5adaf95f-f38a-4131-8238-da314484293d-0000 3: I1222 23:28:16.904453 17451 slave.cpp:7889] Authorizing framework principal 'test-principal' to launch task 2641eb21-f324-4329-8374-5e5d6f269df1 3: I1222 23:28:16.906008 17445 slave.cpp:2494] Launching task '2641eb21-f324-4329-8374-5e5d6f269df1' for framework 5adaf95f-f38a-4131-8238-da314484293d-0000 3: I1222 23:28:16.906877 17445 paths.cpp:756] Trying to chown '/tmp/HTTPCommandExecutorTest_ExplicitAcknowledgements_wHRhBI/slaves/5adaf95f-f38a-4131-8238-da314484293d-S0/frameworks/5adaf95f-f38a-4131-8238-da314484293d-0000/executors/2641eb21-f324-4329-8374-5e5d6f269df1/runs/750f7612-f594-4db3-87e6-c98ffe8f380c' to user 'mesos' 3: I1222 23:28:16.907287 17445 slave.cpp:8363] Launching executor '2641eb21-f324-4329-8374-5e5d6f269df1' of framework 5adaf95f-f38a-4131-8238-da314484293d-0000 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":0.1},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":32.0},"type":"SCALAR"}] in work directory '/tmp/HTTPCommandExecutorTest_ExplicitAcknowledgements_wHRhBI/slaves/5adaf95f-f38a-4131-8238-da314484293d-S0/frameworks/5adaf95f-f38a-4131-8238-da314484293d-0000/executors/2641eb21-f324-4329-8374-5e5d6f269df1/runs/750f7612-f594-4db3-87e6-c98ffe8f380c' 3: I1222 23:28:16.908551 17445 slave.cpp:3054] Launching container 750f7612-f594-4db3-87e6-c98ffe8f380c for executor '2641eb21-f324-4329-8374-5e5d6f269df1' of framework 5adaf95f-f38a-4131-8238-da314484293d-0000 3: I1222 23:28:16.909430 17445 slave.cpp:2580] Queued task '2641eb21-f324-4329-8374-5e5d6f269df1' for executor '2641eb21-f324-4329-8374-5e5d6f269df1' of framework 5adaf95f-f38a-4131-8238-da314484293d-0000 3: I1222 23:28:16.909569 17445 slave.cpp:1006] Successfully attached '/tmp/HTTPCommandExecutorTest_ExplicitAcknowledgements_wHRhBI/slaves/5adaf95f-f38a-4131-8238-da314484293d-S0/frameworks/5adaf95f-f38a-4131-8238-da314484293d-0000/executors/2641eb21-f324-4329-8374-5e5d6f269df1/runs/750f7612-f594-4db3-87e6-c98ffe8f380c' to virtual path '/tmp/HTTPCommandExecutorTest_ExplicitAcknowledgements_wHRhBI/slaves/5adaf95f-f38a-4131-8238-da314484293d-S0/frameworks/5adaf95f-f38a-4131-8238-da314484293d-0000/executors/2641eb21-f324-4329-8374-5e5d6f269df1/runs/latest' 3: I1222 23:28:16.909647 17445 slave.cpp:1006] Successfully attached '/tmp/HTTPCommandExecutorTest_ExplicitAcknowledgements_wHRhBI/slaves/5adaf95f-f38a-4131-8238-da314484293d-S0/frameworks/5adaf95f-f38a-4131-8238-da314484293d-0000/executors/2641eb21-f324-4329-8374-5e5d6f269df1/runs/750f7612-f594-4db3-87e6-c98ffe8f380c' to virtual path '/frameworks/5adaf95f-f38a-4131-8238-da314484293d-0000/executors/2641eb21-f324-4329-8374-5e5d6f269df1/runs/latest' 3: I1222 23:28:16.909713 17445 slave.cpp:1006] Successfully attached '/tmp/HTTPCommandExecutorTest_ExplicitAcknowledgements_wHRhBI/slaves/5adaf95f-f38a-4131-8238-da314484293d-S0/frameworks/5adaf95f-f38a-4131-8238-da314484293d-0000/executors/2641eb21-f324-4329-8374-5e5d6f269df1/runs/750f7612-f594-4db3-87e6-c98ffe8f380c' to virtual path '/tmp/HTTPCommandExecutorTest_ExplicitAcknowledgements_wHRhBI/slaves/5adaf95f-f38a-4131-8238-da314484293d-S0/frameworks/5adaf95f-f38a-4131-8238-da314484293d-0000/executors/2641eb21-f324-4329-8374-5e5d6f269df1/runs/750f7612-f594-4db3-87e6-c98ffe8f380c' 3: I1222 23:28:16.910145 17449 containerizer.cpp:1207] Starting container 750f7612-f594-4db3-87e6-c98ffe8f380c 3: I1222 23:28:16.911244 17449 containerizer.cpp:1380] Checkpointed ContainerConfig at '/tmp/HTTPCommandExecutorTest_ExplicitAcknowledgements_AMUhXZ/containers/750f7612-f594-4db3-87e6-c98ffe8f380c/config' 3: I1222 23:28:16.911280 17449 containerizer.cpp:2966] Transitioning the state of container 750f7612-f594-4db3-87e6-c98ffe8f380c from PROVISIONING to PREPARING 3: I1222 23:28:16.917789 17441 containerizer.cpp:1856] 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:37043"},{"name":"MESOS_CHECKPOINT","type":"VALUE","value":"0"},{"name":"MESOS_DIRECTORY","type":"VALUE","value":"\/tmp\/HTTPCommandExecutorTest_ExplicitAcknowledgements_wHRhBI\/slaves\/5adaf95f-f38a-4131-8238-da314484293d-S0\/frameworks\/5adaf95f-f38a-4131-8238-da314484293d-0000\/executors\/2641eb21-f324-4329-8374-5e5d6f269df1\/runs\/750f7612-f594-4db3-87e6-c98ffe8f380c"},{"name":"MESOS_EXECUTOR_ID","type":"VALUE","value":"2641eb21-f324-4329-8374-5e5d6f269df1"},{"name":"MESOS_EXECUTOR_SHUTDOWN_GRACE_PERIOD","type":"VALUE","value":"5secs"},{"name":"MESOS_FRAMEWORK_ID","type":"VALUE","value":"5adaf95f-f38a-4131-8238-da314484293d-0000"},{"name":"MESOS_HTTP_COMMAND_EXECUTOR","type":"VALUE","value":"1"},{"name":"MESOS_SLAVE_ID","type":"VALUE","value":"5adaf95f-f38a-4131-8238-da314484293d-S0"},{"name":"MESOS_SLAVE_PID","type":"VALUE","value":"slave(31)@172.17.0.3:37043"},{"name":"MESOS_SANDBOX","type":"VALUE","value":"\/tmp\/HTTPCommandExecutorTest_ExplicitAcknowledgements_wHRhBI\/slaves\/5adaf95f-f38a-4131-8238-da314484293d-S0\/frameworks\/5adaf95f-f38a-4131-8238-da314484293d-0000\/executors\/2641eb21-f324-4329-8374-5e5d6f269df1\/runs\/750f7612-f594-4db3-87e6-c98ffe8f380c"}]},"task_environment":{},"user":"mesos","working_directory":"\/tmp\/HTTPCommandExecutorTest_ExplicitAcknowledgements_wHRhBI\/slaves\/5adaf95f-f38a-4131-8238-da314484293d-S0\/frameworks\/5adaf95f-f38a-4131-8238-da314484293d-0000\/executors\/2641eb21-f324-4329-8374-5e5d6f269df1\/runs\/750f7612-f594-4db3-87e6-c98ffe8f380c"}" --pipe_read="7" --pipe_write="8" --runtime_directory="/tmp/HTTPCommandExecutorTest_ExplicitAcknowledgements_AMUhXZ/containers/750f7612-f594-4db3-87e6-c98ffe8f380c" --unshare_namespace_mnt="false"' 3: I1222 23:28:16.920521 17441 launcher.cpp:140] Forked child with pid '18347' for container '750f7612-f594-4db3-87e6-c98ffe8f380c' 3: I1222 23:28:16.921087 17441 containerizer.cpp:2966] Transitioning the state of container 750f7612-f594-4db3-87e6-c98ffe8f380c from PREPARING to ISOLATING 3: I1222 23:28:16.923039 17452 containerizer.cpp:2966] Transitioning the state of container 750f7612-f594-4db3-87e6-c98ffe8f380c from ISOLATING to FETCHING 3: I1222 23:28:16.923346 17436 fetcher.cpp:369] Starting to fetch URIs for container: 750f7612-f594-4db3-87e6-c98ffe8f380c, directory: /tmp/HTTPCommandExecutorTest_ExplicitAcknowledgements_wHRhBI/slaves/5adaf95f-f38a-4131-8238-da314484293d-S0/frameworks/5adaf95f-f38a-4131-8238-da314484293d-0000/executors/2641eb21-f324-4329-8374-5e5d6f269df1/runs/750f7612-f594-4db3-87e6-c98ffe8f380c 3: I1222 23:28:16.924450 17456 containerizer.cpp:2966] Transitioning the state of container 750f7612-f594-4db3-87e6-c98ffe8f380c from FETCHING to RUNNING 3: I1222 23:28:17.228217 18361 executor.cpp:192] Version: 1.5.0 3: I1222 23:28:17.241654 17446 process.cpp:3503] Handling HTTP event for process 'slave(31)' with path: '/slave(31)/api/v1/executor' 3: I1222 23:28:17.244304 17455 http.cpp:1185] HTTP POST for /slave(31)/api/v1/executor from 172.17.0.3:35334 3: I1222 23:28:17.244664 17455 slave.cpp:4120] Received Subscribe request for HTTP executor '2641eb21-f324-4329-8374-5e5d6f269df1' of framework 5adaf95f-f38a-4131-8238-da314484293d-0000 3: I1222 23:28:17.247840 17447 slave.cpp:2785] Sending queued task '2641eb21-f324-4329-8374-5e5d6f269df1' to executor '2641eb21-f324-4329-8374-5e5d6f269df1' of framework 5adaf95f-f38a-4131-8238-da314484293d-0000 (via HTTP) 3: I1222 23:28:17.253849 18357 executor.cpp:171] Received SUBSCRIBED event 3: I1222 23:28:17.256508 18357 executor.cpp:175] Subscribed executor on 10a0af919c8c 3: I1222 23:28:17.256845 18357 executor.cpp:171] Received LAUNCH event 3: I1222 23:28:17.258743 18357 executor.cpp:638] Starting task 2641eb21-f324-4329-8374-5e5d6f269df1 3: I1222 23:28:17.260423 17454 process.cpp:3503] Handling HTTP event for process 'slave(31)' with path: '/slave(31)/api/v1/executor' 3: I1222 23:28:17.262361 17451 http.cpp:1185] HTTP POST for /slave(31)/api/v1/executor from 172.17.0.3:35336 3: I1222 23:28:17.262629 17451 slave.cpp:4778] Handling status update TASK_STARTING (Status UUID: 3489b4cc-7469-4330-9d75-9f81dcd4db69) for task 2641eb21-f324-4329-8374-5e5d6f269df1 of framework 5adaf95f-f38a-4131-8238-da314484293d-0000 3: I1222 23:28:17.265324 17456 task_status_update_manager.cpp:328] Received task status update TASK_STARTING (Status UUID: 3489b4cc-7469-4330-9d75-9f81dcd4db69) for task 2641eb21-f324-4329-8374-5e5d6f269df1 of framework 5adaf95f-f38a-4131-8238-da314484293d-0000 3: I1222 23:28:17.265388 17456 task_status_update_manager.cpp:507] Creating StatusUpdate stream for task 2641eb21-f324-4329-8374-5e5d6f269df1 of framework 5adaf95f-f38a-4131-8238-da314484293d-0000 3: I1222 23:28:17.266448 17456 task_status_update_manager.cpp:383] Forwarding task status update TASK_STARTING (Status UUID: 3489b4cc-7469-4330-9d75-9f81dcd4db69) for task 2641eb21-f324-4329-8374-5e5d6f269df1 of framework 5adaf95f-f38a-4131-8238-da314484293d-0000 to the agent 3: I1222 23:28:17.266736 17453 slave.cpp:5261] Forwarding the update TASK_STARTING (Status UUID: 3489b4cc-7469-4330-9d75-9f81dcd4db69) for task 2641eb21-f324-4329-8374-5e5d6f269df1 of framework 5adaf95f-f38a-4131-8238-da314484293d-0000 to [email protected]:37043 3: I1222 23:28:17.267133 17453 slave.cpp:5154] Task status update manager successfully handled status update TASK_STARTING (Status UUID: 3489b4cc-7469-4330-9d75-9f81dcd4db69) for task 2641eb21-f324-4329-8374-5e5d6f269df1 of framework 5adaf95f-f38a-4131-8238-da314484293d-0000 3: I1222 23:28:17.267433 17447 master.cpp:7850] Status update TASK_STARTING (Status UUID: 3489b4cc-7469-4330-9d75-9f81dcd4db69) for task 2641eb21-f324-4329-8374-5e5d6f269df1 of framework 5adaf95f-f38a-4131-8238-da314484293d-0000 from agent 5adaf95f-f38a-4131-8238-da314484293d-S0 at slave(31)@172.17.0.3:37043 (10a0af919c8c) 3: I1222 23:28:17.267523 17447 master.cpp:7906] Forwarding status update TASK_STARTING (Status UUID: 3489b4cc-7469-4330-9d75-9f81dcd4db69) for task 2641eb21-f324-4329-8374-5e5d6f269df1 of framework 5adaf95f-f38a-4131-8238-da314484293d-0000 3: I1222 23:28:17.267817 17447 master.cpp:10153] Updating the state of task 2641eb21-f324-4329-8374-5e5d6f269df1 of framework 5adaf95f-f38a-4131-8238-da314484293d-0000 (latest state: TASK_STARTING, status update state: TASK_STARTING) 3: I1222 23:28:17.268226 17444 sched.cpp:1029] Scheduler::statusUpdate took 163867ns 3: I1222 23:28:17.269752 17451 master.cpp:5843] Processing ACKNOWLEDGE call 3489b4cc-7469-4330-9d75-9f81dcd4db69 for task 2641eb21-f324-4329-8374-5e5d6f269df1 of framework 5adaf95f-f38a-4131-8238-da314484293d-0000 (default) at [email protected]:37043 on agent 5adaf95f-f38a-4131-8238-da314484293d-S0 3: I1222 23:28:17.269925 17433 sched.cpp:2009] Asked to stop the driver 3: I1222 23:28:17.270072 17452 sched.cpp:1191] Stopping framework 5adaf95f-f38a-4131-8238-da314484293d-0000 3: I1222 23:28:17.270182 17440 task_status_update_manager.cpp:401] Received task status update acknowledgement (UUID: 3489b4cc-7469-4330-9d75-9f81dcd4db69) for task 2641eb21-f324-4329-8374-5e5d6f269df1 of framework 5adaf95f-f38a-4131-8238-da314484293d-0000 3: I1222 23:28:17.270472 17450 master.cpp:9438] Processing TEARDOWN call for framework 5adaf95f-f38a-4131-8238-da314484293d-0000 (default) at [email protected]:37043 3: I1222 23:28:17.270524 17450 master.cpp:9450] Removing framework 5adaf95f-f38a-4131-8238-da314484293d-0000 (default) at [email protected]:37043 3: I1222 23:28:17.270542 17450 master.cpp:3328] Deactivating framework 5adaf95f-f38a-4131-8238-da314484293d-0000 (default) at [email protected]:37043 3: I1222 23:28:17.270545 17443 slave.cpp:4026] Task status update manager successfully handled status update acknowledgement (UUID: 3489b4cc-7469-4330-9d75-9f81dcd4db69) for task 2641eb21-f324-4329-8374-5e5d6f269df1 of framework 5adaf95f-f38a-4131-8238-da314484293d-0000 3: I1222 23:28:17.270740 17436 hierarchical.cpp:405] Deactivated framework 5adaf95f-f38a-4131-8238-da314484293d-0000 3: I1222 23:28:17.270856 17453 slave.cpp:3406] Asked to shut down framework 5adaf95f-f38a-4131-8238-da314484293d-0000 by [email protected]:37043 3: I1222 23:28:17.270839 17450 master.cpp:10153] Updating the state of task 2641eb21-f324-4329-8374-5e5d6f269df1 of framework 5adaf95f-f38a-4131-8238-da314484293d-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED) 3: I1222 23:28:17.270913 17453 slave.cpp:3431] Shutting down framework 5adaf95f-f38a-4131-8238-da314484293d-0000 3: I1222 23:28:17.270987 17453 slave.cpp:6126] Shutting down executor '2641eb21-f324-4329-8374-5e5d6f269df1' of framework 5adaf95f-f38a-4131-8238-da314484293d-0000 (via HTTP) 3: I1222 23:28:17.271872 17437 slave.cpp:931] Agent terminating 3: I1222 23:28:17.271957 17437 slave.cpp:3406] Asked to shut down framework 5adaf95f-f38a-4131-8238-da314484293d-0000 by @0.0.0.0:0 3: W1222 23:28:17.272007 17437 slave.cpp:3427] Ignoring shutdown framework 5adaf95f-f38a-4131-8238-da314484293d-0000 because it is terminating 3: I1222 23:28:17.272069 17450 master.cpp:10259] Removing task 2641eb21-f324-4329-8374-5e5d6f269df1 with resources cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000] of framework 5adaf95f-f38a-4131-8238-da314484293d-0000 on agent 5adaf95f-f38a-4131-8238-da314484293d-S0 at slave(31)@172.17.0.3:37043 (10a0af919c8c) 3: I1222 23:28:17.272789 17447 hierarchical.cpp:1192] Recovered cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000] (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000], allocated: {}) on agent 5adaf95f-f38a-4131-8238-da314484293d-S0 from framework 5adaf95f-f38a-4131-8238-da314484293d-0000 3: I1222 23:28:17.273031 17450 master.cpp:1305] Agent 5adaf95f-f38a-4131-8238-da314484293d-S0 at slave(31)@172.17.0.3:37043 (10a0af919c8c) disconnected 3: I1222 23:28:17.273062 17450 master.cpp:3365] Disconnecting agent 5adaf95f-f38a-4131-8238-da314484293d-S0 at slave(31)@172.17.0.3:37043 (10a0af919c8c) 3: I1222 23:28:17.273138 17450 master.cpp:3384] Deactivating agent 5adaf95f-f38a-4131-8238-da314484293d-S0 at slave(31)@172.17.0.3:37043 (10a0af919c8c) 3: I1222 23:28:17.273262 17456 containerizer.cpp:2352] Destroying container 750f7612-f594-4db3-87e6-c98ffe8f380c in RUNNING state 3: I1222 23:28:17.273303 17456 containerizer.cpp:2966] Transitioning the state of container 750f7612-f594-4db3-87e6-c98ffe8f380c from RUNNING to DESTROYING 3: I1222 23:28:17.273311 17447 hierarchical.cpp:344] Removed framework 5adaf95f-f38a-4131-8238-da314484293d-0000 3: I1222 23:28:17.273416 17447 hierarchical.cpp:766] Agent 5adaf95f-f38a-4131-8238-da314484293d-S0 deactivated 3: I1222 23:28:17.273866 18357 executor.cpp:478] Running '/mesos/build/src/mesos-containerizer launch <POSSIBLY-SENSITIVE-DATA>' 3: I1222 23:28:17.273910 17456 launcher.cpp:156] Asked to destroy container 750f7612-f594-4db3-87e6-c98ffe8f380c 3: I1222 23:28:17.277308 18357 executor.cpp:651] Forked command at 18374 3: I1222 23:28:17.277804 18357 executor.cpp:171] Received ACKNOWLEDGED event 3: I1222 23:28:17.277880 18357 executor.cpp:171] Received SHUTDOWN event 3: I1222 23:28:17.277896 18357 executor.cpp:748] Shutting down 3: I1222 23:28:17.277940 18357 executor.cpp:863] Sending SIGTERM to process tree at pid 18374 3: I1222 23:28:17.278720 17458 process.cpp:2681] Returning '404 Not Found' for '/slave(31)/api/v1/executor' 3: I1222 23:28:17.294358 17458 process.cpp:774] Decode failure: Connection reset by peer 3: I1222 23:28:17.294451 17458 process.cpp:2139] Failed to shutdown socket with fd 8, address 172.17.0.3:37043: Transport endpoint is not connected 3: I1222 23:28:17.304261 17437 containerizer.cpp:2805] Container 750f7612-f594-4db3-87e6-c98ffe8f380c has exited 3: I1222 23:28:17.307762 17456 provisioner.cpp:598] Ignoring destroy request for unknown container 750f7612-f594-4db3-87e6-c98ffe8f380c 3: I1222 23:28:17.320241 17433 master.cpp:1147] Master terminating 3: I1222 23:28:17.321302 17445 hierarchical.cpp:609] Removed agent 5adaf95f-f38a-4131-8238-da314484293d-S0 3: [ OK ] HTTPCommandExecutorTest.ExplicitAcknowledgements (493 ms) 3: [----------] 2 tests from HTTPCommandExecutorTest (2416 ms total) 3: 3: [----------] 1 test from CommonValidationTest 3: [ RUN ] CommonValidationTest.Volume 3: [ OK ] CommonValidationTest.Volume (0 ms) 3: [----------] 1 test from CommonValidationTest (0 ms total) 3: 3: [----------] 1 test from ContainerDaemonTest 3: [ RUN ] ContainerDaemonTest.RestartOnTermination 3: I1222 23:28:17.330158 17433 cluster.cpp:172] Creating default 'local' authorizer 3: I1222 23:28:17.334030 17445 master.cpp:456] Master 98f84d2c-d32e-4a21-9e3f-6eb485ba16de (10a0af919c8c) started on 172.17.0.3:37043 3: I1222 23:28:17.334064 17445 master.cpp:458] Flags at startup: --acls="" --agent_ping_timeout="15secs" --agent_reregister_timeout="10mins" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate_agents="true" --authenticate_frameworks="true" --authenticate_http_frameworks="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/Bgu2JH/credentials" --filter_gpu_resources="true" --framework_sorter="drf" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_framework_authenticators="basic" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_agent_ping_timeouts="5" --max_completed_frameworks="50" --max_completed_tasks_per_framework="1000" --max_unreachable_tasks_per_framework="1000" --port="5050" --quiet="false" --recovery_agent_removal_limit="100%" --registry="in_memory" --registry_fetch_timeout="1mins" --registry_gc_interval="15mins" --registry_max_agent_age="2weeks" --registry_max_agent_count="102400" --registry_store_timeout="100secs" --registry_strict="false" --root_submissions="true" --user_sorter="drf" --version="false" --webui_dir="/usr/local/share/mesos/webui" --work_dir="/tmp/Bgu2JH/master" --zk_session_timeout="10secs" 3: I1222 23:28:17.334429 17445 master.cpp:507] Master only allowing authenticated frameworks to register 3: I1222 23:28:17.334439 17445 master.cpp:513] Master only allowing authenticated agents to register 3: I1222 23:28:17.334444 17445 master.cpp:519] Master only allowing authenticated HTTP frameworks to register 3: I1222 23:28:17.334451 17445 credentials.hpp:37] Loading credentials for authentication from '/tmp/Bgu2JH/credentials' 3: I1222 23:28:17.334818 17445 master.cpp:563] Using default 'crammd5' authenticator 3: I1222 23:28:17.335017 17445 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly' 3: I1222 23:28:17.335222 17445 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite' 3: I1222 23:28:17.335373 17445 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler' 3: I1222 23:28:17.335520 17445 master.cpp:642] Authorization enabled 3: I1222 23:28:17.335738 17434 hierarchical.cpp:175] Initialized hierarchical allocator process 3: I1222 23:28:17.335744 17436 whitelist_watcher.cpp:77] No whitelist given 3: I1222 23:28:17.339562 17440 master.cpp:2210] Elected as the leading master! 3: I1222 23:28:17.339603 17440 master.cpp:1689] Recovering from registrar 3: I1222 23:28:17.339861 17442 registrar.cpp:347] Recovering registrar 3: I1222 23:28:17.340891 17442 registrar.cpp:391] Successfully fetched the registry (0B) in 973056ns 3: I1222 23:28:17.341070 17442 registrar.cpp:495] Applied 1 operations in 58087ns; attempting to update the registry 3: I1222 23:28:17.341974 17442 registrar.cpp:552] Successfully updated the registry in 822016ns 3: I1222 23:28:17.342162 17442 registrar.cpp:424] Successfully recovered registrar 3: I1222 23:28:17.342878 17450 master.cpp:1803] Recovered 0 agents from the registry (135B); allowing 10mins for agents to re-register 3: I1222 23:28:17.342901 17455 hierarchical.cpp:213] Skipping recovery of hierarchical allocator: nothing to recover 3: W1222 23:28:17.348809 17433 process.cpp:2756] Attempted to spawn already running process [email protected]:37043 3: I1222 23:28:17.349862 17433 containerizer.cpp:304] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni } 3: W1222 23:28:17.350443 17433 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges 3: W1222 23:28:17.350576 17433 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges 3: I1222 23:28:17.350612 17433 provisioner.cpp:299] Using default backend 'copy' 3: I1222 23:28:17.352813 17433 cluster.cpp:460] Creating default 'local' authorizer 3: I1222 23:28:17.355528 17448 slave.cpp:262] Mesos agent started on (32)@172.17.0.3:37043 3: I1222 23:28:17.355551 17448 slave.cpp:263] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://"; --appc_store_dir="/tmp/ContainerDaemonTest_RestartOnTermination_hzpZHi/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="false" --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/ContainerDaemonTest_RestartOnTermination_hzpZHi/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/ContainerDaemonTest_RestartOnTermination_hzpZHi/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/ContainerDaemonTest_RestartOnTermination_hzpZHi/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/ContainerDaemonTest_RestartOnTermination_hzpZHi/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:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/ContainerDaemonTest_RestartOnTermination_hzpZHi" --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/ContainerDaemonTest_RestartOnTermination_s9i0d0" --zk_session_timeout="10secs" 3: I1222 23:28:17.356029 17448 credentials.hpp:86] Loading credential for authentication from '/tmp/ContainerDaemonTest_RestartOnTermination_hzpZHi/credential' 3: I1222 23:28:17.356209 17448 slave.cpp:295] Agent using credential for: test-principal 3: I1222 23:28:17.356235 17448 credentials.hpp:37] Loading credentials for authentication from '/tmp/ContainerDaemonTest_RestartOnTermination_hzpZHi/http_credentials' 3: I1222 23:28:17.356586 17448 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' 3: I1222 23:28:17.359220 17448 slave.cpp:612] 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: I1222 23:28:17.359612 17448 slave.cpp:620] Agent attributes: [ ] 3: I1222 23:28:17.359630 17448 slave.cpp:629] Agent hostname: 10a0af919c8c 3: I1222 23:28:17.359902 17440 task_status_update_manager.cpp:181] Pausing sending task status updates 3: I1222 23:28:17.362195 17452 state.cpp:66] Recovering state from '/tmp/ContainerDaemonTest_RestartOnTermination_s9i0d0/meta' 3: I1222 23:28:17.362573 17439 task_status_update_manager.cpp:207] Recovering task status update manager 3: I1222 23:28:17.362946 17447 containerizer.cpp:674] Recovering containerizer write /dev/stdout: resource temporarily unavailable Process leaked file descriptors. See https://jenkins.io/redirect/troubleshooting/process-leaked-file-descriptors for more information Build step 'Execute shell' marked build as failure Not sending mail to unregistered user [email protected]
