See <https://builds.apache.org/job/Mesos/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-6)&&(!ubuntu-eu2)/3018/changes>
Changes: [yujie.jay] Refactored the reaping logic in I/O switchboard. [josephwu] Remove use of `typename` causing Windows build break. [josephwu] Rename symbols in log.proto to avoid naming collision in win32 API. [josephwu] Windows: Fixed implicit cast warning in dirent.hpp. [josephwu] Changed registrar backend to `in_memory` by default in tests. [josephwu] Windows: Added APR include path to libprocess configuration. [josephwu] Windows: Fixed default isolators in Agent. [yujie.jay] Suppress offers in mesos-execute. ------------------------------------------ [...truncated 155926 lines...] I1208 03:58:01.021214 27603 master.cpp:432] Master only allowing authenticated frameworks to register I1208 03:58:01.021219 27603 master.cpp:446] Master only allowing authenticated agents to register I1208 03:58:01.021224 27603 master.cpp:459] Master only allowing authenticated HTTP frameworks to register I1208 03:58:01.021229 27603 credentials.hpp:37] Loading credentials for authentication from '/tmp/4zTGnE/credentials' I1208 03:58:01.021334 27603 master.cpp:504] Using default 'crammd5' authenticator I1208 03:58:01.021376 27603 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-master-readonly' I1208 03:58:01.021462 27603 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-master-readwrite' I1208 03:58:01.021508 27603 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-master-scheduler' I1208 03:58:01.021548 27603 master.cpp:584] Authorization enabled I1208 03:58:01.021617 27594 hierarchical.cpp:149] Initialized hierarchical allocator process I1208 03:58:01.021658 27598 whitelist_watcher.cpp:77] No whitelist given I1208 03:58:01.022457 27604 master.cpp:2045] Elected as the leading master! I1208 03:58:01.022475 27604 master.cpp:1568] Recovering from registrar I1208 03:58:01.022554 27592 registrar.cpp:329] Recovering registrar I1208 03:58:01.022806 27604 registrar.cpp:362] Successfully fetched the registry (0B) in 176896ns I1208 03:58:01.022851 27604 registrar.cpp:461] Applied 1 operations in 5155ns; attempting to update the registry I1208 03:58:01.023085 27604 registrar.cpp:506] Successfully updated the registry in 211968ns I1208 03:58:01.023119 27604 registrar.cpp:392] Successfully recovered registrar I1208 03:58:01.023257 27592 master.cpp:1684] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register I1208 03:58:01.023437 27601 hierarchical.cpp:176] Skipping recovery of hierarchical allocator: nothing to recover I1208 03:58:01.024653 27589 containerizer.cpp:217] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni W1208 03:58:01.024935 27589 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos W1208 03:58:01.025019 27589 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges I1208 03:58:01.026443 27589 cluster.cpp:446] Creating default 'local' authorizer I1208 03:58:01.026870 27602 slave.cpp:208] Mesos agent started on (576)@172.17.0.2:45560 I1208 03:58:01.027420 27589 sched.cpp:232] Version: 1.2.0 I1208 03:58:01.026887 27602 slave.cpp:209] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/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/ContentType_AgentAPIStreamingTest_AttachContainerInput_1_0SHo8e/credential" --default_role="*" --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/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/ContentType_AgentAPIStreamingTest_AttachContainerInput_1_0SHo8e/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/ContentType_AgentAPIStreamingTest_AttachContainerInput_1_0SHo8e/http_credentials" --image_provisioner_backend="copy" --initialize_driver_logging="true" --io_switchboard_enable_server="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" --qos_correction_interval_min="0ns" --quiet="false" --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/ContentType_AgentAPIStreamingTest_AttachContainerInput_1_0SHo8e" --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/ContentType_AgentAPIStreamingTest_AttachContainerInput_1_bTk2KW" I1208 03:58:01.027529 27602 credentials.hpp:86] Loading credential for authentication from '/tmp/ContentType_AgentAPIStreamingTest_AttachContainerInput_1_0SHo8e/credential' I1208 03:58:01.027647 27596 sched.cpp:336] New master detected at [email protected]:45560 I1208 03:58:01.027662 27602 slave.cpp:346] Agent using credential for: test-principal I1208 03:58:01.027673 27602 credentials.hpp:37] Loading credentials for authentication from '/tmp/ContentType_AgentAPIStreamingTest_AttachContainerInput_1_0SHo8e/http_credentials' I1208 03:58:01.027679 27596 sched.cpp:402] Authenticating with master [email protected]:45560 I1208 03:58:01.027689 27596 sched.cpp:409] Using default CRAM-MD5 authenticatee I1208 03:58:01.027771 27605 authenticatee.cpp:121] Creating new client SASL connection I1208 03:58:01.027971 27594 master.cpp:6748] Authenticating [email protected]:45560 I1208 03:58:01.028013 27602 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' I1208 03:58:01.028034 27594 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1119)@172.17.0.2:45560 I1208 03:58:01.028053 27602 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite' I1208 03:58:01.028136 27594 authenticator.cpp:98] Creating new server SASL connection I1208 03:58:01.028266 27594 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I1208 03:58:01.028290 27594 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I1208 03:58:01.028333 27594 authenticator.cpp:204] Received SASL authentication start I1208 03:58:01.028381 27594 authenticator.cpp:326] Authentication requires more steps I1208 03:58:01.028421 27594 authenticatee.cpp:259] Received SASL authentication step I1208 03:58:01.028476 27594 authenticator.cpp:232] Received SASL authentication step I1208 03:58:01.028502 27594 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '0791618c7039' server FQDN: '0791618c7039' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I1208 03:58:01.028514 27594 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I1208 03:58:01.028532 27594 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I1208 03:58:01.028548 27594 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '0791618c7039' server FQDN: '0791618c7039' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I1208 03:58:01.028558 27594 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I1208 03:58:01.028568 27594 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I1208 03:58:01.028547 27602 slave.cpp:533] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I1208 03:58:01.028585 27594 authenticator.cpp:318] Authentication success I1208 03:58:01.028591 27602 slave.cpp:541] Agent attributes: [ ] I1208 03:58:01.028599 27602 slave.cpp:546] Agent hostname: 0791618c7039 I1208 03:58:01.028638 27594 authenticatee.cpp:299] Authentication success I1208 03:58:01.028669 27594 master.cpp:6778] Successfully authenticated principal 'test-principal' at [email protected]:45560 I1208 03:58:01.028712 27594 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1119)@172.17.0.2:45560 I1208 03:58:01.029067 27592 state.cpp:57] Recovering state from '/tmp/ContentType_AgentAPIStreamingTest_AttachContainerInput_1_bTk2KW/meta' I1208 03:58:01.029125 27605 sched.cpp:508] Successfully authenticated with master [email protected]:45560 I1208 03:58:01.029141 27605 sched.cpp:826] Sending SUBSCRIBE call to [email protected]:45560 I1208 03:58:01.029181 27605 sched.cpp:859] Will retry registration in 883.987373ms if necessary I1208 03:58:01.029251 27605 status_update_manager.cpp:203] Recovering status update manager I1208 03:58:01.029253 27592 master.cpp:2633] Received SUBSCRIBE call for framework 'default' at [email protected]:45560 I1208 03:58:01.029374 27592 master.cpp:2081] Authorizing framework principal 'test-principal' to receive offers for role '*' I1208 03:58:01.029363 27600 containerizer.cpp:591] Recovering containerizer I1208 03:58:01.029569 27605 master.cpp:2709] Subscribing framework default with checkpointing disabled and capabilities [ ] I1208 03:58:01.029800 27595 hierarchical.cpp:276] Added framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 I1208 03:58:01.029824 27605 sched.cpp:749] Framework registered with 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 I1208 03:58:01.029825 27595 hierarchical.cpp:1689] No allocations performed I1208 03:58:01.029868 27595 hierarchical.cpp:1784] No inverse offers to send out! I1208 03:58:01.029882 27595 hierarchical.cpp:1291] Performed allocation for 0 agents in 66287ns I1208 03:58:01.029908 27605 sched.cpp:763] Scheduler::registered took 45968ns I1208 03:58:01.030326 27591 provisioner.cpp:253] Provisioner recovery complete I1208 03:58:01.030506 27591 slave.cpp:5414] Finished recovery I1208 03:58:01.030841 27591 slave.cpp:5588] Querying resource estimator for oversubscribable resources I1208 03:58:01.030923 27591 slave.cpp:918] New master detected at [email protected]:45560 I1208 03:58:01.030941 27591 slave.cpp:977] Authenticating with master [email protected]:45560 I1208 03:58:01.030962 27591 slave.cpp:988] Using default CRAM-MD5 authenticatee I1208 03:58:01.031015 27591 slave.cpp:950] Detecting new master I1208 03:58:01.031066 27591 slave.cpp:5602] Received oversubscribable resources {} from the resource estimator I1208 03:58:01.031088 27601 authenticatee.cpp:121] Creating new client SASL connection I1208 03:58:01.031210 27603 status_update_manager.cpp:177] Pausing sending status updates I1208 03:58:01.031225 27591 master.cpp:6748] Authenticating slave(576)@172.17.0.2:45560 I1208 03:58:01.031380 27601 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1120)@172.17.0.2:45560 I1208 03:58:01.031481 27591 authenticator.cpp:98] Creating new server SASL connection I1208 03:58:01.031620 27601 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I1208 03:58:01.031637 27601 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I1208 03:58:01.031672 27601 authenticator.cpp:204] Received SASL authentication start I1208 03:58:01.031702 27601 authenticator.cpp:326] Authentication requires more steps I1208 03:58:01.031743 27601 authenticatee.cpp:259] Received SASL authentication step I1208 03:58:01.031793 27601 authenticator.cpp:232] Received SASL authentication step I1208 03:58:01.031812 27601 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '0791618c7039' server FQDN: '0791618c7039' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I1208 03:58:01.031821 27601 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I1208 03:58:01.031831 27601 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I1208 03:58:01.031837 27601 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '0791618c7039' server FQDN: '0791618c7039' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I1208 03:58:01.031842 27601 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I1208 03:58:01.031847 27601 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I1208 03:58:01.031858 27601 authenticator.cpp:318] Authentication success I1208 03:58:01.031932 27594 authenticatee.cpp:299] Authentication success I1208 03:58:01.032044 27601 master.cpp:6778] Successfully authenticated principal 'test-principal' at slave(576)@172.17.0.2:45560 I1208 03:58:01.032126 27594 slave.cpp:1072] Successfully authenticated with master [email protected]:45560 I1208 03:58:01.032130 27604 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1120)@172.17.0.2:45560 I1208 03:58:01.032336 27601 master.cpp:5161] Registering agent at slave(576)@172.17.0.2:45560 (0791618c7039) with id 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-S0 I1208 03:58:01.032238 27594 slave.cpp:1486] Will retry registration in 11.632278ms if necessary I1208 03:58:01.032563 27592 registrar.cpp:461] Applied 1 operations in 17893ns; attempting to update the registry I1208 03:58:01.033052 27592 registrar.cpp:506] Successfully updated the registry in 442880ns I1208 03:58:01.033315 27593 slave.cpp:4266] Received ping from slave-observer(527)@172.17.0.2:45560 I1208 03:58:01.033325 27605 master.cpp:5232] Registered agent 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-S0 at slave(576)@172.17.0.2:45560 (0791618c7039) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I1208 03:58:01.033409 27593 slave.cpp:1118] Registered with master [email protected]:45560; given agent ID 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-S0 I1208 03:58:01.033519 27593 fetcher.cpp:86] Clearing fetcher cache I1208 03:58:01.033624 27595 status_update_manager.cpp:184] Resuming sending status updates I1208 03:58:01.033594 27604 hierarchical.cpp:490] Added agent 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-S0 (0791618c7039) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {}) I1208 03:58:01.033841 27593 slave.cpp:1141] Checkpointing SlaveInfo to '/tmp/ContentType_AgentAPIStreamingTest_AttachContainerInput_1_bTk2KW/meta/slaves/5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-S0/slave.info' I1208 03:58:01.034063 27604 hierarchical.cpp:1784] No inverse offers to send out! I1208 03:58:01.034101 27593 slave.cpp:1178] Forwarding total oversubscribed resources {} I1208 03:58:01.034121 27604 hierarchical.cpp:1314] Performed allocation for agent 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-S0 in 375744ns I1208 03:58:01.034323 27600 master.cpp:6577] Sending 1 offers to framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 (default) at [email protected]:45560 I1208 03:58:01.034477 27600 master.cpp:5633] Received update of agent 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-S0 at slave(576)@172.17.0.2:45560 (0791618c7039) with total oversubscribed resources {} I1208 03:58:01.034540 27592 sched.cpp:923] Scheduler::resourceOffers took 44517ns I1208 03:58:01.034775 27594 hierarchical.cpp:560] Agent 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-S0 (0791618c7039) updated with oversubscribed resources {} (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]) I1208 03:58:01.034829 27594 hierarchical.cpp:1689] No allocations performed I1208 03:58:01.034847 27594 hierarchical.cpp:1784] No inverse offers to send out! I1208 03:58:01.034862 27594 hierarchical.cpp:1314] Performed allocation for agent 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-S0 in 55263ns I1208 03:58:01.035141 27593 master.cpp:3588] Processing ACCEPT call for offers: [ 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-O0 ] on agent 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-S0 at slave(576)@172.17.0.2:45560 (0791618c7039) for framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 (default) at [email protected]:45560 I1208 03:58:01.035176 27593 master.cpp:3175] Authorizing framework principal 'test-principal' to launch task 2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f I1208 03:58:01.035714 27596 master.cpp:8501] Adding task 2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on agent 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-S0 (0791618c7039) I1208 03:58:01.035799 27596 master.cpp:4240] Launching task 2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f of framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 (default) at [email protected]:45560 with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on agent 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-S0 at slave(576)@172.17.0.2:45560 (0791618c7039) I1208 03:58:01.036115 27598 slave.cpp:1550] Got assigned task '2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f' for framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 I1208 03:58:01.036381 27598 slave.cpp:1712] Launching task '2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f' for framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 I1208 03:58:01.036829 27598 paths.cpp:530] Trying to chown '/tmp/ContentType_AgentAPIStreamingTest_AttachContainerInput_1_bTk2KW/slaves/5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-S0/frameworks/5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000/executors/2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f/runs/625c1bf6-e2bf-4741-9c9d-91899b6903f0' to user 'mesos' I1208 03:58:01.044190 27598 slave.cpp:6341] Launching executor '2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f' of framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 with resources cpus(*):0.1; mem(*):32 in work directory '/tmp/ContentType_AgentAPIStreamingTest_AttachContainerInput_1_bTk2KW/slaves/5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-S0/frameworks/5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000/executors/2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f/runs/625c1bf6-e2bf-4741-9c9d-91899b6903f0' I1208 03:58:01.044486 27604 containerizer.cpp:983] Starting container 625c1bf6-e2bf-4741-9c9d-91899b6903f0 for executor '2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f' of framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 I1208 03:58:01.044507 27598 slave.cpp:2034] Queued task '2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f' for executor '2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f' of framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 I1208 03:58:01.044560 27598 slave.cpp:871] Successfully attached file '/tmp/ContentType_AgentAPIStreamingTest_AttachContainerInput_1_bTk2KW/slaves/5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-S0/frameworks/5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000/executors/2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f/runs/625c1bf6-e2bf-4741-9c9d-91899b6903f0' I1208 03:58:01.046252 27593 switchboard.cpp:570] Launching 'mesos-io-switchboard' with flags '--help="false" --socket_address="/tmp/mesos-io-switchboard-3f7491d2-efff-4805-b2a1-3f17ad96450b" --stderr_from_fd="13" --stderr_to_fd="2" --stdin_to_fd="10" --stdout_from_fd="11" --stdout_to_fd="1" --tty="false" --wait_for_connection="false"' for container 625c1bf6-e2bf-4741-9c9d-91899b6903f0 I1208 03:58:01.048257 27593 switchboard.cpp:600] Created I/O switchboard server (pid: 32270) listening on socket file '/tmp/mesos-io-switchboard-3f7491d2-efff-4805-b2a1-3f17ad96450b' for container 625c1bf6-e2bf-4741-9c9d-91899b6903f0 I1208 03:58:01.049552 27595 containerizer.cpp:1519] 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","value":"0"},{"name":"MESOS_AGENT_ENDPOINT","value":"172.17.0.2:45560"},{"name":"MESOS_CHECKPOINT","value":"0"},{"name":"MESOS_DIRECTORY","value":"\/tmp\/ContentType_AgentAPIStreamingTest_AttachContainerInput_1_bTk2KW\/slaves\/5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-S0\/frameworks\/5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000\/executors\/2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f\/runs\/625c1bf6-e2bf-4741-9c9d-91899b6903f0"},{"name":"MESOS_EXECUTOR_ID","value":"2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f"},{"name":"MESOS_EXECUTOR_SHUTDOWN_GRACE_PERIOD","value":"5secs"},{"name":"MESOS_FRAMEWORK_ID","value":"5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000"},{"name":"MESOS_HTTP_COMMAND_EXECUTOR","value":"0"},{"name":"MESOS_SLAVE_ID","value":"5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-S0"},{"name":"MESOS_SLAVE_PID","value":"slave(576)@172.17.0.2:45560"},{"name":"MESOS_SANDBOX","value":"\/tmp\/ContentType_AgentAPIStreamingTest_AttachContainerInput_1_bTk2KW\/slaves\/5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-S0\/frameworks\/5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000\/executors\/2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f\/runs\/625c1bf6-e2bf-4741-9c9d-91899b6903f0"}]},"err":{"fd":14,"type":"FD"},"in":{"fd":9,"type":"FD"},"out":{"fd":12,"type":"FD"},"user":"mesos","working_directory":"\/tmp\/ContentType_AgentAPIStreamingTest_AttachContainerInput_1_bTk2KW\/slaves\/5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-S0\/frameworks\/5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000\/executors\/2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f\/runs\/625c1bf6-e2bf-4741-9c9d-91899b6903f0"}" --pipe_read="10" --pipe_write="11" --runtime_directory="/tmp/ContentType_AgentAPIStreamingTest_AttachContainerInput_1_0SHo8e/containers/625c1bf6-e2bf-4741-9c9d-91899b6903f0" --unshare_namespace_mnt="false"' I1208 03:58:01.051167 27595 launcher.cpp:133] Forked child with pid '32271' for container '625c1bf6-e2bf-4741-9c9d-91899b6903f0' I1208 03:58:01.053164 27595 fetcher.cpp:345] Starting to fetch URIs for container: 625c1bf6-e2bf-4741-9c9d-91899b6903f0, directory: /tmp/ContentType_AgentAPIStreamingTest_AttachContainerInput_1_bTk2KW/slaves/5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-S0/frameworks/5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000/executors/2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f/runs/625c1bf6-e2bf-4741-9c9d-91899b6903f0 I1208 03:58:01.137135 27593 slave.cpp:3308] Got registration for executor '2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f' of framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 from executor(1)@172.17.0.2:36505 I1208 03:58:01.138262 27592 slave.cpp:2250] Sending queued task '2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f' to executor '2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f' of framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 at executor(1)@172.17.0.2:36505 I1208 03:58:01.143872 27602 slave.cpp:3743] Handling status update TASK_RUNNING (UUID: 7f6d8301-3fba-4f9a-8f8b-e67859a0f1b3) for task 2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f of framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 from executor(1)@172.17.0.2:36505 I1208 03:58:01.144461 27597 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: 7f6d8301-3fba-4f9a-8f8b-e67859a0f1b3) for task 2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f of framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 I1208 03:58:01.144484 27597 status_update_manager.cpp:500] Creating StatusUpdate stream for task 2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f of framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 I1208 03:58:01.144649 27597 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: 7f6d8301-3fba-4f9a-8f8b-e67859a0f1b3) for task 2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f of framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 to the agent I1208 03:58:01.144770 27596 slave.cpp:4184] Forwarding the update TASK_RUNNING (UUID: 7f6d8301-3fba-4f9a-8f8b-e67859a0f1b3) for task 2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f of framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 to [email protected]:45560 I1208 03:58:01.144911 27596 slave.cpp:4078] Status update manager successfully handled status update TASK_RUNNING (UUID: 7f6d8301-3fba-4f9a-8f8b-e67859a0f1b3) for task 2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f of framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 I1208 03:58:01.144938 27596 slave.cpp:4094] Sending acknowledgement for status update TASK_RUNNING (UUID: 7f6d8301-3fba-4f9a-8f8b-e67859a0f1b3) for task 2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f of framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 to executor(1)@172.17.0.2:36505 I1208 03:58:01.145097 27596 master.cpp:5769] Status update TASK_RUNNING (UUID: 7f6d8301-3fba-4f9a-8f8b-e67859a0f1b3) for task 2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f of framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 from agent 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-S0 at slave(576)@172.17.0.2:45560 (0791618c7039) I1208 03:58:01.145148 27596 master.cpp:5831] Forwarding status update TASK_RUNNING (UUID: 7f6d8301-3fba-4f9a-8f8b-e67859a0f1b3) for task 2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f of framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 I1208 03:58:01.145220 27596 master.cpp:7867] Updating the state of task 2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f of framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING) I1208 03:58:01.145453 27600 sched.cpp:1031] Scheduler::statusUpdate took 69959ns I1208 03:58:01.145629 27590 master.cpp:4877] Processing ACKNOWLEDGE call 7f6d8301-3fba-4f9a-8f8b-e67859a0f1b3 for task 2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f of framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 (default) at [email protected]:45560 on agent 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-S0 I1208 03:58:01.145962 27601 status_update_manager.cpp:395] Received status update acknowledgement (UUID: 7f6d8301-3fba-4f9a-8f8b-e67859a0f1b3) for task 2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f of framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 I1208 03:58:01.146312 27598 slave.cpp:3025] Status update manager successfully handled status update acknowledgement (UUID: 7f6d8301-3fba-4f9a-8f8b-e67859a0f1b3) for task 2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f of framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 I1208 03:58:01.146608 27598 process.cpp:3679] Handling HTTP event for process 'slave(576)' with path: '/slave(576)/api/v1' I1208 03:58:01.146898 27590 http.cpp:288] HTTP POST for /slave(576)/api/v1 from 172.17.0.2:50696 I1208 03:58:01.147001 27590 http.cpp:449] Processing call LAUNCH_NESTED_CONTAINER I1208 03:58:01.147150 27590 containerizer.cpp:1786] Starting nested container 625c1bf6-e2bf-4741-9c9d-91899b6903f0.bfbffeeb-febd-4d09-bc77-822b1cdbcec7 I1208 03:58:01.147454 27590 containerizer.cpp:1810] Trying to chown '/tmp/ContentType_AgentAPIStreamingTest_AttachContainerInput_1_bTk2KW/slaves/5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-S0/frameworks/5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000/executors/2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f/runs/625c1bf6-e2bf-4741-9c9d-91899b6903f0/containers/bfbffeeb-febd-4d09-bc77-822b1cdbcec7' to user 'mesos' I1208 03:58:01.155818 27594 switchboard.cpp:570] Launching 'mesos-io-switchboard' with flags '--help="false" --socket_address="/tmp/mesos-io-switchboard-14e2e996-b49e-4594-8312-5751ff0d5cad" --stderr_from_fd="17" --stderr_to_fd="2" --stdin_to_fd="14" --stdout_from_fd="15" --stdout_to_fd="1" --tty="false" --wait_for_connection="false"' for container 625c1bf6-e2bf-4741-9c9d-91899b6903f0.bfbffeeb-febd-4d09-bc77-822b1cdbcec7 I1208 03:58:01.157932 27594 switchboard.cpp:600] Created I/O switchboard server (pid: 32302) listening on socket file '/tmp/mesos-io-switchboard-14e2e996-b49e-4594-8312-5751ff0d5cad' for container 625c1bf6-e2bf-4741-9c9d-91899b6903f0.bfbffeeb-febd-4d09-bc77-822b1cdbcec7 I1208 03:58:01.159133 27591 containerizer.cpp:1519] Launching 'mesos-containerizer' with flags '--help="false" --launch_info="{"command":{"shell":true,"value":"cat"},"environment":{"variables":[{"name":"MESOS_SANDBOX","value":"\/tmp\/ContentType_AgentAPIStreamingTest_AttachContainerInput_1_bTk2KW\/slaves\/5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-S0\/frameworks\/5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000\/executors\/2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f\/runs\/625c1bf6-e2bf-4741-9c9d-91899b6903f0\/containers\/bfbffeeb-febd-4d09-bc77-822b1cdbcec7"}]},"err":{"fd":18,"type":"FD"},"in":{"fd":13,"type":"FD"},"out":{"fd":16,"type":"FD"},"user":"mesos","working_directory":"\/tmp\/ContentType_AgentAPIStreamingTest_AttachContainerInput_1_bTk2KW\/slaves\/5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-S0\/frameworks\/5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000\/executors\/2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f\/runs\/625c1bf6-e2bf-4741-9c9d-91899b6903f0\/containers\/bfbffeeb-febd-4d09-bc77-822b1cdbcec7"}" --pipe_read="14" --pipe_write="15" --runtime_directory="/tmp/ContentType_AgentAPIStreamingTest_AttachContainerInput_1_0SHo8e/containers/625c1bf6-e2bf-4741-9c9d-91899b6903f0/containers/bfbffeeb-febd-4d09-bc77-822b1cdbcec7" --unshare_namespace_mnt="false"' I1208 03:58:01.161216 27591 launcher.cpp:133] Forked child with pid '32303' for container '625c1bf6-e2bf-4741-9c9d-91899b6903f0.bfbffeeb-febd-4d09-bc77-822b1cdbcec7' I1208 03:58:01.162912 27590 fetcher.cpp:345] Starting to fetch URIs for container: 625c1bf6-e2bf-4741-9c9d-91899b6903f0.bfbffeeb-febd-4d09-bc77-822b1cdbcec7, directory: /tmp/ContentType_AgentAPIStreamingTest_AttachContainerInput_1_bTk2KW/slaves/5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-S0/frameworks/5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000/executors/2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f/runs/625c1bf6-e2bf-4741-9c9d-91899b6903f0/containers/bfbffeeb-febd-4d09-bc77-822b1cdbcec7 I1208 03:58:01.165997 27595 process.cpp:3679] Handling HTTP event for process 'slave(576)' with path: '/slave(576)/api/v1' I1208 03:58:01.166419 27597 http.cpp:288] HTTP POST for /slave(576)/api/v1 from 172.17.0.2:50697 I1208 03:58:01.166555 27597 http.cpp:449] Processing call ATTACH_CONTAINER_OUTPUT **** DEADLOCK DETECTED! **** You are waiting on process __limiter__(591)@172.17.0.2:45560 that it is currently executing. I1208 03:58:01.297809 27598 process.cpp:3679] Handling HTTP event for process 'slave(576)' with path: '/slave(576)/api/v1' I1208 03:58:01.298315 27605 http.cpp:288] HTTP POST for /slave(576)/api/v1 from 172.17.0.2:50698 I1208 03:58:01.298708 27604 http.cpp:449] Processing call ATTACH_CONTAINER_INPUT I1208 03:58:01.627871 27597 containerizer.cpp:2460] Container 625c1bf6-e2bf-4741-9c9d-91899b6903f0.bfbffeeb-febd-4d09-bc77-822b1cdbcec7 has exited I1208 03:58:01.627909 27597 containerizer.cpp:2097] Destroying container 625c1bf6-e2bf-4741-9c9d-91899b6903f0.bfbffeeb-febd-4d09-bc77-822b1cdbcec7 in RUNNING state I1208 03:58:01.628005 27597 launcher.cpp:149] Asked to destroy container 625c1bf6-e2bf-4741-9c9d-91899b6903f0.bfbffeeb-febd-4d09-bc77-822b1cdbcec7 I1208 03:58:01.630455 27602 switchboard.cpp:770] Sending SIGTERM to I/O switchboard server (pid: 32302) since container 625c1bf6-e2bf-4741-9c9d-91899b6903f0.bfbffeeb-febd-4d09-bc77-822b1cdbcec7 is being destroyed I1208 03:58:01.728548 27594 switchboard.cpp:829] I/O switchboard server process for container 625c1bf6-e2bf-4741-9c9d-91899b6903f0.bfbffeeb-febd-4d09-bc77-822b1cdbcec7 has terminated (status=0) I1208 03:58:01.729292 27600 provisioner.cpp:324] Ignoring destroy request for unknown container 625c1bf6-e2bf-4741-9c9d-91899b6903f0.bfbffeeb-febd-4d09-bc77-822b1cdbcec7 I1208 03:58:01.729372 27600 containerizer.cpp:2376] Checkpointing termination state to nested container's runtime directory '/tmp/ContentType_AgentAPIStreamingTest_AttachContainerInput_1_0SHo8e/containers/625c1bf6-e2bf-4741-9c9d-91899b6903f0/containers/bfbffeeb-febd-4d09-bc77-822b1cdbcec7/termination' I1208 03:58:01.771304 27603 master.cpp:1305] Framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 (default) at [email protected]:45560 disconnected I1208 03:58:01.771350 27603 master.cpp:2918] Disconnecting framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 (default) at [email protected]:45560 I1208 03:58:01.771366 27603 master.cpp:2942] Deactivating framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 (default) at [email protected]:45560 I1208 03:58:01.771402 27603 master.cpp:1318] Giving framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 (default) at [email protected]:45560 0ns to failover I1208 03:58:01.771451 27604 hierarchical.cpp:391] Deactivated framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 I1208 03:58:01.771601 27597 master.cpp:6429] Framework failover timeout, removing framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 (default) at [email protected]:45560 I1208 03:58:01.771627 27597 master.cpp:7299] Removing framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 (default) at [email protected]:45560 I1208 03:58:01.771697 27597 master.cpp:7867] Updating the state of task 2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f of framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED) I1208 03:58:01.771726 27591 slave.cpp:2578] Asked to shut down framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 by [email protected]:45560 I1208 03:58:01.771749 27591 slave.cpp:2603] Shutting down framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 I1208 03:58:01.771766 27591 slave.cpp:4993] Shutting down executor '2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f' of framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 at executor(1)@172.17.0.2:36505 I1208 03:58:01.771899 27591 containerizer.cpp:2097] Destroying container 625c1bf6-e2bf-4741-9c9d-91899b6903f0 in RUNNING state I1208 03:58:01.771957 27597 master.cpp:7963] Removing task 2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] of framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 on agent 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-S0 at slave(576)@172.17.0.2:45560 (0791618c7039) I1208 03:58:01.772011 27591 launcher.cpp:149] Asked to destroy container 625c1bf6-e2bf-4741-9c9d-91899b6903f0 I1208 03:58:01.772032 27604 hierarchical.cpp:1023] Recovered cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: {}) on agent 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-S0 from framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 I1208 03:58:01.772192 27597 hierarchical.cpp:342] Removed framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 I1208 03:58:01.779556 27591 slave.cpp:4312] Got exited event for executor(1)@172.17.0.2:36505 I1208 03:58:01.832417 27598 switchboard.cpp:829] I/O switchboard server process for container 625c1bf6-e2bf-4741-9c9d-91899b6903f0 has terminated (status=0) I1208 03:58:01.832634 27601 containerizer.cpp:2460] Container 625c1bf6-e2bf-4741-9c9d-91899b6903f0 has exited I1208 03:58:01.833921 27602 provisioner.cpp:324] Ignoring destroy request for unknown container 625c1bf6-e2bf-4741-9c9d-91899b6903f0 I1208 03:58:01.834808 27600 slave.cpp:4675] Executor '2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f' of framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 terminated with signal Killed I1208 03:58:01.834836 27600 slave.cpp:4779] Cleaning up executor '2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f' of framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 at executor(1)@172.17.0.2:36505 I1208 03:58:01.835000 27596 gc.cpp:55] Scheduling '/tmp/ContentType_AgentAPIStreamingTest_AttachContainerInput_1_bTk2KW/slaves/5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-S0/frameworks/5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000/executors/2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f/runs/625c1bf6-e2bf-4741-9c9d-91899b6903f0' for gc 6.9999903362963days in the future I1208 03:58:01.835050 27600 slave.cpp:4867] Cleaning up framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 I1208 03:58:01.835103 27596 gc.cpp:55] Scheduling '/tmp/ContentType_AgentAPIStreamingTest_AttachContainerInput_1_bTk2KW/slaves/5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-S0/frameworks/5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000/executors/2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f' for gc 6.99999033526518days in the future I1208 03:58:01.835136 27605 status_update_manager.cpp:285] Closing status update streams for framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 I1208 03:58:01.835149 27596 gc.cpp:55] Scheduling '/tmp/ContentType_AgentAPIStreamingTest_AttachContainerInput_1_bTk2KW/slaves/5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-S0/frameworks/5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000' for gc 6.99999033424889days in the future I1208 03:58:01.835153 27605 status_update_manager.cpp:531] Cleaning up status update stream for task 2a77f4e1-83a2-4d7e-93c0-ca6aeda4385f of framework 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-0000 I1208 03:58:01.835314 27600 slave.cpp:790] Agent terminating I1208 03:58:01.835430 27594 master.cpp:1258] Agent 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-S0 at slave(576)@172.17.0.2:45560 (0791618c7039) disconnected I1208 03:58:01.835451 27594 master.cpp:2977] Disconnecting agent 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-S0 at slave(576)@172.17.0.2:45560 (0791618c7039) I1208 03:58:01.835476 27594 master.cpp:2996] Deactivating agent 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-S0 at slave(576)@172.17.0.2:45560 (0791618c7039) I1208 03:58:01.835530 27602 hierarchical.cpp:589] Agent 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-S0 deactivated I1208 03:58:01.837498 27589 master.cpp:1097] Master terminating I1208 03:58:01.837661 27593 hierarchical.cpp:522] Removed agent 5f3e3a2b-85a1-4f50-ae03-e602df3e23ff-S0 [ OK ] ContentType/AgentAPIStreamingTest.AttachContainerInput/1 (819 ms) [----------] 2 tests from ContentType/AgentAPIStreamingTest (1328 ms total) [----------] 6 tests from HTTPCommandExecutor/CommandExecutorTest [ RUN ] HTTPCommandExecutor/CommandExecutorTest.NoTaskKillingCapability/0 I1208 03:58:01.842341 27589 cluster.cpp:160] Creating default 'local' authorizer I1208 03:58:01.843319 27596 master.cpp:380] Master 1f66749e-2568-4c81-98c0-452b415a0596 (0791618c7039) started on 172.17.0.2:45560 I1208 03:58:01.843346 27596 master.cpp:382] 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/4n7Ubi/credentials" --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" --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/4n7Ubi/master" --zk_session_timeout="10secs" I1208 03:58:01.843588 27596 master.cpp:432] Master only allowing authenticated frameworks to register I1208 03:58:01.843598 27596 master.cpp:446] Master only allowing authenticated agents to register I1208 03:58:01.843611 27596 master.cpp:459] Master only allowing authenticated HTTP frameworks to register I1208 03:58:01.843618 27596 credentials.hpp:37] Loading credentials for authentication from '/tmp/4n7Ubi/credentials' I1208 03:58:01.843761 27596 master.cpp:504] Using default 'crammd5' authenticator I1208 03:58:01.843804 27596 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-master-readonly' I1208 03:58:01.843845 27596 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-master-readwrite' I1208 03:58:01.843886 27596 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-master-scheduler' I1208 03:58:01.843930 27596 master.cpp:584] Authorization enabled I1208 03:58:01.844143 27595 whitelist_watcher.cpp:77] No whitelist given I1208 03:58:01.844161 27604 hierarchical.cpp:149] Initialized hierarchical allocator process I1208 03:58:01.844980 27596 master.cpp:2045] Elected as the leading master! I1208 03:58:01.845000 27596 master.cpp:1568] Recovering from registrar I1208 03:58:01.845147 27602 registrar.cpp:329] Recovering registrar I1208 03:58:01.845410 27605 registrar.cpp:362] Successfully fetched the registry (0B) in 229888ns I1208 03:58:01.845455 27605 registrar.cpp:461] Applied 1 operations in 4509ns; attempting to update the registry I1208 03:58:01.845671 27605 registrar.cpp:506] Successfully updated the registry in 192us I1208 03:58:01.845722 27605 registrar.cpp:392] Successfully recovered registrar I1208 03:58:01.845901 27599 master.cpp:1684] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register I1208 03:58:01.845921 27602 hierarchical.cpp:176] Skipping recovery of hierarchical allocator: nothing to recover Build timed out (after 300 minutes). Marking the build as failed. Build was aborted ++ docker rmi mesos-1481166967-6051 Error response from daemon: conflict: unable to remove repository reference "mesos-1481166967-6051" (must force) - container 0791618c7039 is using its referenced image 82584dba189f
