See <https://builds.apache.org/job/Mesos/BUILDTOOL=cmake,COMPILER=clang,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)/3041/changes>
Changes: [josephwu] Stout: Added helper for determining a runtime directory. [josephwu] Used `os::var()` for the default value in agent `--runtime_dir`. [josephwu] Windows: Implemented `os::user()'. [josephwu] Windows: Added trivially passable tests to build. [josephwu] Windows: Enabled about 500 passing tests on Agent builds. [benjamin.hindman] Avoided capturing `this` in `process::loop`. [anand] Fixed the 'IOSwitchboardTest.KillSwitchboardContainerDestroyed' test. [vinodkone] Added a test that verifies container attach after agent restart. [vinodkone] Refactored IOSwitchboardServerTest.AttachOutput test. [vinodkone] Added a fixed-capacity hashmap to stout. [vinodkone] Updated master to use BoundedHashMap. [vinodkone] Updated agent to use BoundedHashMap. [vinodkone] Synchronized v1 and unversioned master.proto. [vinodkone] Improved various comments. ------------------------------------------ [...truncated 154403 lines...] I1216 20:36:03.051970 25236 master.cpp:2997] Deactivating agent c39465c0-bf10-4d37-91be-5f4471a49893-S0 at slave(574)@172.17.0.3:36782 (dff2089d3e7a) I1216 20:36:03.052039 25233 hierarchical.cpp:589] Agent c39465c0-bf10-4d37-91be-5f4471a49893-S0 deactivated I1216 20:36:03.054095 25230 master.cpp:1097] Master terminating I1216 20:36:03.054298 25243 hierarchical.cpp:522] Removed agent c39465c0-bf10-4d37-91be-5f4471a49893-S0 [ OK ] ContentType/AgentAPITest.LaunchNestedContainerSessionWithTTY/0 (417 ms) [ RUN ] ContentType/AgentAPITest.LaunchNestedContainerSessionWithTTY/1 I1216 20:36:03.058158 25230 cluster.cpp:160] Creating default 'local' authorizer I1216 20:36:03.059257 25239 master.cpp:380] Master 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e (dff2089d3e7a) started on 172.17.0.3:36782 I1216 20:36:03.059285 25239 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/PSwIts/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/PSwIts/master" --zk_session_timeout="10secs" I1216 20:36:03.059479 25239 master.cpp:432] Master only allowing authenticated frameworks to register I1216 20:36:03.059494 25239 master.cpp:446] Master only allowing authenticated agents to register I1216 20:36:03.059499 25239 master.cpp:459] Master only allowing authenticated HTTP frameworks to register I1216 20:36:03.059505 25239 credentials.hpp:37] Loading credentials for authentication from '/tmp/PSwIts/credentials' I1216 20:36:03.059653 25239 master.cpp:504] Using default 'crammd5' authenticator I1216 20:36:03.059710 25239 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-master-readonly' I1216 20:36:03.059759 25239 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-master-readwrite' I1216 20:36:03.059801 25239 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-master-scheduler' I1216 20:36:03.059834 25239 master.cpp:584] Authorization enabled I1216 20:36:03.060513 25239 hierarchical.cpp:149] Initialized hierarchical allocator process I1216 20:36:03.060539 25239 whitelist_watcher.cpp:77] No whitelist given I1216 20:36:03.061064 25239 master.cpp:2046] Elected as the leading master! I1216 20:36:03.061079 25239 master.cpp:1568] Recovering from registrar I1216 20:36:03.061142 25239 registrar.cpp:329] Recovering registrar I1216 20:36:03.061360 25239 registrar.cpp:362] Successfully fetched the registry (0B) in 199936ns I1216 20:36:03.061398 25239 registrar.cpp:461] Applied 1 operations in 11835ns; attempting to update the registry I1216 20:36:03.061661 25239 registrar.cpp:506] Successfully updated the registry in 239872ns I1216 20:36:03.061712 25239 registrar.cpp:392] Successfully recovered registrar I1216 20:36:03.061846 25239 master.cpp:1684] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register I1216 20:36:03.061909 25239 hierarchical.cpp:176] Skipping recovery of hierarchical allocator: nothing to recover I1216 20:36:03.063134 25230 containerizer.cpp:220] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni W1216 20:36:03.063490 25230 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos W1216 20:36:03.063582 25230 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges I1216 20:36:03.065212 25230 cluster.cpp:446] Creating default 'local' authorizer I1216 20:36:03.065901 25231 slave.cpp:209] Mesos agent started on (575)@172.17.0.3:36782 I1216 20:36:03.065929 25231 slave.cpp:210] 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_AgentAPITest_LaunchNestedContainerSessionWithTTY_1_9iylBI/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_AgentAPITest_LaunchNestedContainerSessionWithTTY_1_9iylBI/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_AgentAPITest_LaunchNestedContainerSessionWithTTY_1_9iylBI/http_credentials" --http_heartbeat_interval="30secs" --image_provisioner_backend="copy" --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" --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_AgentAPITest_LaunchNestedContainerSessionWithTTY_1_9iylBI" --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_AgentAPITest_LaunchNestedContainerSessionWithTTY_1_r6FwxA" I1216 20:36:03.066354 25231 credentials.hpp:86] Loading credential for authentication from '/tmp/ContentType_AgentAPITest_LaunchNestedContainerSessionWithTTY_1_9iylBI/credential' I1216 20:36:03.066473 25231 slave.cpp:352] Agent using credential for: test-principal I1216 20:36:03.066495 25230 sched.cpp:232] Version: 1.2.0 I1216 20:36:03.066591 25231 credentials.hpp:37] Loading credentials for authentication from '/tmp/ContentType_AgentAPITest_LaunchNestedContainerSessionWithTTY_1_9iylBI/http_credentials' I1216 20:36:03.066757 25231 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' I1216 20:36:03.066802 25235 sched.cpp:336] New master detected at [email protected]:36782 I1216 20:36:03.066807 25231 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite' I1216 20:36:03.066848 25235 sched.cpp:402] Authenticating with master [email protected]:36782 I1216 20:36:03.066859 25235 sched.cpp:409] Using default CRAM-MD5 authenticatee I1216 20:36:03.066982 25245 authenticatee.cpp:121] Creating new client SASL connection I1216 20:36:03.067239 25237 master.cpp:6751] Authenticating [email protected]:36782 I1216 20:36:03.067342 25234 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1126)@172.17.0.3:36782 I1216 20:36:03.067399 25231 slave.cpp:539] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I1216 20:36:03.067448 25231 slave.cpp:547] Agent attributes: [ ] I1216 20:36:03.067461 25231 slave.cpp:552] Agent hostname: dff2089d3e7a I1216 20:36:03.067495 25237 authenticator.cpp:98] Creating new server SASL connection I1216 20:36:03.067654 25234 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I1216 20:36:03.067677 25234 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I1216 20:36:03.067821 25234 authenticator.cpp:204] Received SASL authentication start I1216 20:36:03.067901 25234 authenticator.cpp:326] Authentication requires more steps I1216 20:36:03.067939 25231 state.cpp:57] Recovering state from '/tmp/ContentType_AgentAPITest_LaunchNestedContainerSessionWithTTY_1_r6FwxA/meta' I1216 20:36:03.068119 25234 authenticatee.cpp:259] Received SASL authentication step I1216 20:36:03.068478 25235 status_update_manager.cpp:203] Recovering status update manager I1216 20:36:03.068491 25234 authenticator.cpp:232] Received SASL authentication step I1216 20:36:03.068512 25234 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'dff2089d3e7a' server FQDN: 'dff2089d3e7a' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I1216 20:36:03.068550 25234 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I1216 20:36:03.068583 25236 containerizer.cpp:594] Recovering containerizer I1216 20:36:03.068591 25234 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I1216 20:36:03.068900 25234 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'dff2089d3e7a' server FQDN: 'dff2089d3e7a' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I1216 20:36:03.068917 25234 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I1216 20:36:03.068924 25234 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I1216 20:36:03.068941 25234 authenticator.cpp:318] Authentication success I1216 20:36:03.069013 25234 master.cpp:6781] Successfully authenticated principal 'test-principal' at [email protected]:36782 I1216 20:36:03.069120 25241 authenticatee.cpp:299] Authentication success I1216 20:36:03.069191 25241 sched.cpp:508] Successfully authenticated with master [email protected]:36782 I1216 20:36:03.069205 25241 sched.cpp:826] Sending SUBSCRIBE call to [email protected]:36782 I1216 20:36:03.069247 25241 sched.cpp:859] Will retry registration in 63.694153ms if necessary I1216 20:36:03.069303 25242 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1126)@172.17.0.3:36782 I1216 20:36:03.069586 25241 master.cpp:2634] Received SUBSCRIBE call for framework 'default' at [email protected]:36782 I1216 20:36:03.069603 25241 master.cpp:2082] Authorizing framework principal 'test-principal' to receive offers for role '*' I1216 20:36:03.069809 25233 provisioner.cpp:253] Provisioner recovery complete I1216 20:36:03.069811 25241 master.cpp:2710] Subscribing framework default with checkpointing disabled and capabilities [ ] I1216 20:36:03.069969 25232 slave.cpp:5407] Finished recovery I1216 20:36:03.070021 25242 hierarchical.cpp:276] Added framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 I1216 20:36:03.070045 25242 hierarchical.cpp:1689] No allocations performed I1216 20:36:03.070053 25242 hierarchical.cpp:1784] No inverse offers to send out! I1216 20:36:03.070065 25242 hierarchical.cpp:1291] Performed allocation for 0 agents in 31436ns I1216 20:36:03.070106 25241 sched.cpp:749] Framework registered with 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 I1216 20:36:03.070140 25241 sched.cpp:763] Scheduler::registered took 21919ns I1216 20:36:03.070423 25232 slave.cpp:5581] Querying resource estimator for oversubscribable resources I1216 20:36:03.070540 25232 slave.cpp:924] New master detected at [email protected]:36782 I1216 20:36:03.070550 25241 status_update_manager.cpp:177] Pausing sending status updates I1216 20:36:03.070560 25232 slave.cpp:983] Authenticating with master [email protected]:36782 I1216 20:36:03.070582 25232 slave.cpp:994] Using default CRAM-MD5 authenticatee I1216 20:36:03.070639 25232 slave.cpp:956] Detecting new master I1216 20:36:03.070760 25244 authenticatee.cpp:121] Creating new client SASL connection I1216 20:36:03.070883 25234 slave.cpp:5595] Received oversubscribable resources {} from the resource estimator I1216 20:36:03.070960 25234 master.cpp:6751] Authenticating slave(575)@172.17.0.3:36782 I1216 20:36:03.071022 25234 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1127)@172.17.0.3:36782 I1216 20:36:03.071100 25234 authenticator.cpp:98] Creating new server SASL connection I1216 20:36:03.071223 25234 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I1216 20:36:03.071251 25234 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I1216 20:36:03.071293 25234 authenticator.cpp:204] Received SASL authentication start I1216 20:36:03.071338 25234 authenticator.cpp:326] Authentication requires more steps I1216 20:36:03.071382 25234 authenticatee.cpp:259] Received SASL authentication step I1216 20:36:03.071436 25234 authenticator.cpp:232] Received SASL authentication step I1216 20:36:03.071462 25234 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'dff2089d3e7a' server FQDN: 'dff2089d3e7a' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I1216 20:36:03.071472 25234 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I1216 20:36:03.071485 25234 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I1216 20:36:03.071504 25234 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'dff2089d3e7a' server FQDN: 'dff2089d3e7a' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I1216 20:36:03.071514 25234 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I1216 20:36:03.071521 25234 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I1216 20:36:03.071535 25234 authenticator.cpp:318] Authentication success I1216 20:36:03.071580 25234 authenticatee.cpp:299] Authentication success I1216 20:36:03.071614 25234 master.cpp:6781] Successfully authenticated principal 'test-principal' at slave(575)@172.17.0.3:36782 I1216 20:36:03.071652 25234 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1127)@172.17.0.3:36782 I1216 20:36:03.071732 25234 slave.cpp:1078] Successfully authenticated with master [email protected]:36782 I1216 20:36:03.071792 25234 slave.cpp:1493] Will retry registration in 14.791356ms if necessary I1216 20:36:03.071925 25234 master.cpp:5162] Registering agent at slave(575)@172.17.0.3:36782 (dff2089d3e7a) with id 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-S0 I1216 20:36:03.072087 25234 registrar.cpp:461] Applied 1 operations in 25604ns; attempting to update the registry I1216 20:36:03.072556 25234 registrar.cpp:506] Successfully updated the registry in 435968ns I1216 20:36:03.072815 25234 master.cpp:5233] Registered agent 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-S0 at slave(575)@172.17.0.3:36782 (dff2089d3e7a) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I1216 20:36:03.072974 25234 hierarchical.cpp:490] Added agent 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-S0 (dff2089d3e7a) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {}) I1216 20:36:03.073235 25234 hierarchical.cpp:1784] No inverse offers to send out! I1216 20:36:03.073266 25234 hierarchical.cpp:1314] Performed allocation for agent 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-S0 in 266157ns I1216 20:36:03.073313 25234 slave.cpp:1124] Registered with master [email protected]:36782; given agent ID 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-S0 I1216 20:36:03.073333 25234 fetcher.cpp:90] Clearing fetcher cache I1216 20:36:03.073648 25234 slave.cpp:1147] Checkpointing SlaveInfo to '/tmp/ContentType_AgentAPITest_LaunchNestedContainerSessionWithTTY_1_r6FwxA/meta/slaves/3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-S0/slave.info' I1216 20:36:03.073932 25234 slave.cpp:1184] Forwarding total oversubscribed resources {} I1216 20:36:03.073982 25234 slave.cpp:4263] Received ping from slave-observer(529)@172.17.0.3:36782 I1216 20:36:03.074152 25234 master.cpp:6580] Sending 1 offers to framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 (default) at [email protected]:36782 I1216 20:36:03.074229 25234 master.cpp:5636] Received update of agent 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-S0 at slave(575)@172.17.0.3:36782 (dff2089d3e7a) with total oversubscribed resources {} I1216 20:36:03.074306 25234 status_update_manager.cpp:184] Resuming sending status updates I1216 20:36:03.074452 25234 sched.cpp:923] Scheduler::resourceOffers took 49255ns I1216 20:36:03.074517 25234 hierarchical.cpp:560] Agent 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-S0 (dff2089d3e7a) updated with oversubscribed resources {} (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]) I1216 20:36:03.074579 25234 hierarchical.cpp:1689] No allocations performed I1216 20:36:03.074594 25234 hierarchical.cpp:1784] No inverse offers to send out! I1216 20:36:03.074612 25234 hierarchical.cpp:1314] Performed allocation for agent 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-S0 in 63796ns I1216 20:36:03.075489 25246 master.cpp:3589] Processing ACCEPT call for offers: [ 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-O0 ] on agent 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-S0 at slave(575)@172.17.0.3:36782 (dff2089d3e7a) for framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 (default) at [email protected]:36782 I1216 20:36:03.075537 25246 master.cpp:3176] Authorizing framework principal 'test-principal' to launch task 9f70fbe0-2bfb-4864-ae7e-28a73d19482d I1216 20:36:03.076192 25239 master.cpp:8499] Adding task 9f70fbe0-2bfb-4864-ae7e-28a73d19482d with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on agent 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-S0 (dff2089d3e7a) I1216 20:36:03.076386 25239 master.cpp:4241] Launching task 9f70fbe0-2bfb-4864-ae7e-28a73d19482d of framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 (default) at [email protected]:36782 with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on agent 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-S0 at slave(575)@172.17.0.3:36782 (dff2089d3e7a) I1216 20:36:03.076733 25232 slave.cpp:1557] Got assigned task '9f70fbe0-2bfb-4864-ae7e-28a73d19482d' for framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 I1216 20:36:03.077059 25232 slave.cpp:1717] Launching task '9f70fbe0-2bfb-4864-ae7e-28a73d19482d' for framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 I1216 20:36:03.077575 25232 paths.cpp:530] Trying to chown '/tmp/ContentType_AgentAPITest_LaunchNestedContainerSessionWithTTY_1_r6FwxA/slaves/3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-S0/frameworks/3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000/executors/9f70fbe0-2bfb-4864-ae7e-28a73d19482d/runs/ea4a4010-0b50-4c59-a61f-b32d3f3f4c32' to user 'mesos' I1216 20:36:03.085901 25232 slave.cpp:6334] Launching executor '9f70fbe0-2bfb-4864-ae7e-28a73d19482d' of framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 with resources cpus(*):0.1; mem(*):32 in work directory '/tmp/ContentType_AgentAPITest_LaunchNestedContainerSessionWithTTY_1_r6FwxA/slaves/3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-S0/frameworks/3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000/executors/9f70fbe0-2bfb-4864-ae7e-28a73d19482d/runs/ea4a4010-0b50-4c59-a61f-b32d3f3f4c32' I1216 20:36:03.086369 25238 containerizer.cpp:986] Starting container ea4a4010-0b50-4c59-a61f-b32d3f3f4c32 for executor '9f70fbe0-2bfb-4864-ae7e-28a73d19482d' of framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 I1216 20:36:03.086374 25232 slave.cpp:2039] Queued task '9f70fbe0-2bfb-4864-ae7e-28a73d19482d' for executor '9f70fbe0-2bfb-4864-ae7e-28a73d19482d' of framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 I1216 20:36:03.086453 25232 slave.cpp:877] Successfully attached file '/tmp/ContentType_AgentAPITest_LaunchNestedContainerSessionWithTTY_1_r6FwxA/slaves/3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-S0/frameworks/3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000/executors/9f70fbe0-2bfb-4864-ae7e-28a73d19482d/runs/ea4a4010-0b50-4c59-a61f-b32d3f3f4c32' I1216 20:36:03.088156 25235 containerizer.cpp:1535] 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.3:36782"},{"name":"MESOS_CHECKPOINT","value":"0"},{"name":"MESOS_DIRECTORY","value":"\/tmp\/ContentType_AgentAPITest_LaunchNestedContainerSessionWithTTY_1_r6FwxA\/slaves\/3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-S0\/frameworks\/3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000\/executors\/9f70fbe0-2bfb-4864-ae7e-28a73d19482d\/runs\/ea4a4010-0b50-4c59-a61f-b32d3f3f4c32"},{"name":"MESOS_EXECUTOR_ID","value":"9f70fbe0-2bfb-4864-ae7e-28a73d19482d"},{"name":"MESOS_EXECUTOR_SHUTDOWN_GRACE_PERIOD","value":"5secs"},{"name":"MESOS_FRAMEWORK_ID","value":"3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000"},{"name":"MESOS_HTTP_COMMAND_EXECUTOR","value":"0"},{"name":"MESOS_SLAVE_ID","value":"3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-S0"},{"name":"MESOS_SLAVE_PID","value":"slave(575)@172.17.0.3:36782"},{"name":"MESOS_SANDBOX","value":"\/tmp\/ContentType_AgentAPITest_LaunchNestedContainerSessionWithTTY_1_r6FwxA\/slaves\/3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-S0\/frameworks\/3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000\/executors\/9f70fbe0-2bfb-4864-ae7e-28a73d19482d\/runs\/ea4a4010-0b50-4c59-a61f-b32d3f3f4c32"}]},"err":{"path":"\/tmp\/ContentType_AgentAPITest_LaunchNestedContainerSessionWithTTY_1_r6FwxA\/slaves\/3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-S0\/frameworks\/3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000\/executors\/9f70fbe0-2bfb-4864-ae7e-28a73d19482d\/runs\/ea4a4010-0b50-4c59-a61f-b32d3f3f4c32\/stderr","type":"PATH"},"out":{"path":"\/tmp\/ContentType_AgentAPITest_LaunchNestedContainerSessionWithTTY_1_r6FwxA\/slaves\/3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-S0\/frameworks\/3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000\/executors\/9f70fbe0-2bfb-4864-ae7e-28a73d19482d\/runs\/ea4a4010-0b50-4c59-a61f-b32d3f3f4c32\/stdout","type":"PATH"},"user":"mesos","working_directory":"\/tmp\/ContentType_AgentAPITest_LaunchNestedContainerSessionWithTTY_1_r6FwxA\/slaves\/3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-S0\/frameworks\/3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000\/executors\/9f70fbe0-2bfb-4864-ae7e-28a73d19482d\/runs\/ea4a4010-0b50-4c59-a61f-b32d3f3f4c32"}" --pipe_read="9" --pipe_write="13" --runtime_directory="/tmp/ContentType_AgentAPITest_LaunchNestedContainerSessionWithTTY_1_9iylBI/containers/ea4a4010-0b50-4c59-a61f-b32d3f3f4c32" --unshare_namespace_mnt="false"' I1216 20:36:03.090517 25235 launcher.cpp:133] Forked child with pid '29896' for container 'ea4a4010-0b50-4c59-a61f-b32d3f3f4c32' I1216 20:36:03.092506 25232 fetcher.cpp:349] Starting to fetch URIs for container: ea4a4010-0b50-4c59-a61f-b32d3f3f4c32, directory: /tmp/ContentType_AgentAPITest_LaunchNestedContainerSessionWithTTY_1_r6FwxA/slaves/3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-S0/frameworks/3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000/executors/9f70fbe0-2bfb-4864-ae7e-28a73d19482d/runs/ea4a4010-0b50-4c59-a61f-b32d3f3f4c32 I1216 20:36:03.206832 25232 slave.cpp:3308] Got registration for executor '9f70fbe0-2bfb-4864-ae7e-28a73d19482d' of framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 from executor(1)@172.17.0.3:51352 I1216 20:36:03.207646 25244 slave.cpp:2253] Sending queued task '9f70fbe0-2bfb-4864-ae7e-28a73d19482d' to executor '9f70fbe0-2bfb-4864-ae7e-28a73d19482d' of framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 at executor(1)@172.17.0.3:51352 I1216 20:36:03.212126 25241 slave.cpp:3740] Handling status update TASK_RUNNING (UUID: 02647b2c-f9c0-4c44-9f3c-63305b157eb8) for task 9f70fbe0-2bfb-4864-ae7e-28a73d19482d of framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 from executor(1)@172.17.0.3:51352 I1216 20:36:03.212719 25246 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: 02647b2c-f9c0-4c44-9f3c-63305b157eb8) for task 9f70fbe0-2bfb-4864-ae7e-28a73d19482d of framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 I1216 20:36:03.212743 25246 status_update_manager.cpp:500] Creating StatusUpdate stream for task 9f70fbe0-2bfb-4864-ae7e-28a73d19482d of framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 I1216 20:36:03.212910 25246 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: 02647b2c-f9c0-4c44-9f3c-63305b157eb8) for task 9f70fbe0-2bfb-4864-ae7e-28a73d19482d of framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 to the agent I1216 20:36:03.213035 25236 slave.cpp:4181] Forwarding the update TASK_RUNNING (UUID: 02647b2c-f9c0-4c44-9f3c-63305b157eb8) for task 9f70fbe0-2bfb-4864-ae7e-28a73d19482d of framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 to [email protected]:36782 I1216 20:36:03.213155 25236 slave.cpp:4075] Status update manager successfully handled status update TASK_RUNNING (UUID: 02647b2c-f9c0-4c44-9f3c-63305b157eb8) for task 9f70fbe0-2bfb-4864-ae7e-28a73d19482d of framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 I1216 20:36:03.213176 25236 slave.cpp:4091] Sending acknowledgement for status update TASK_RUNNING (UUID: 02647b2c-f9c0-4c44-9f3c-63305b157eb8) for task 9f70fbe0-2bfb-4864-ae7e-28a73d19482d of framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 to executor(1)@172.17.0.3:51352 I1216 20:36:03.213248 25233 master.cpp:5772] Status update TASK_RUNNING (UUID: 02647b2c-f9c0-4c44-9f3c-63305b157eb8) for task 9f70fbe0-2bfb-4864-ae7e-28a73d19482d of framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 from agent 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-S0 at slave(575)@172.17.0.3:36782 (dff2089d3e7a) I1216 20:36:03.213279 25233 master.cpp:5834] Forwarding status update TASK_RUNNING (UUID: 02647b2c-f9c0-4c44-9f3c-63305b157eb8) for task 9f70fbe0-2bfb-4864-ae7e-28a73d19482d of framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 I1216 20:36:03.213348 25233 master.cpp:7871] Updating the state of task 9f70fbe0-2bfb-4864-ae7e-28a73d19482d of framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING) I1216 20:36:03.213486 25235 sched.cpp:1031] Scheduler::statusUpdate took 85362ns I1216 20:36:03.213671 25243 master.cpp:4878] Processing ACKNOWLEDGE call 02647b2c-f9c0-4c44-9f3c-63305b157eb8 for task 9f70fbe0-2bfb-4864-ae7e-28a73d19482d of framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 (default) at [email protected]:36782 on agent 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-S0 I1216 20:36:03.213814 25236 status_update_manager.cpp:395] Received status update acknowledgement (UUID: 02647b2c-f9c0-4c44-9f3c-63305b157eb8) for task 9f70fbe0-2bfb-4864-ae7e-28a73d19482d of framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 I1216 20:36:03.213963 25234 slave.cpp:3028] Status update manager successfully handled status update acknowledgement (UUID: 02647b2c-f9c0-4c44-9f3c-63305b157eb8) for task 9f70fbe0-2bfb-4864-ae7e-28a73d19482d of framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 I1216 20:36:03.215064 25234 process.cpp:3679] Handling HTTP event for process 'slave(575)' with path: '/slave(575)/api/v1' I1216 20:36:03.215410 25246 http.cpp:301] HTTP POST for /slave(575)/api/v1 from 172.17.0.3:54928 I1216 20:36:03.215625 25246 http.cpp:462] Processing call LAUNCH_NESTED_CONTAINER_SESSION I1216 20:36:03.215829 25245 containerizer.cpp:1802] Starting nested container ea4a4010-0b50-4c59-a61f-b32d3f3f4c32.fb109dbb-103d-4417-b10c-dd5ae3e7a794 I1216 20:36:03.216059 25245 containerizer.cpp:1826] Trying to chown '/tmp/ContentType_AgentAPITest_LaunchNestedContainerSessionWithTTY_1_r6FwxA/slaves/3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-S0/frameworks/3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000/executors/9f70fbe0-2bfb-4864-ae7e-28a73d19482d/runs/ea4a4010-0b50-4c59-a61f-b32d3f3f4c32/containers/fb109dbb-103d-4417-b10c-dd5ae3e7a794' to user 'mesos' I1216 20:36:03.221781 25240 switchboard.cpp:430] Allocated pseudo terminal '/dev/pts/1' for container ea4a4010-0b50-4c59-a61f-b32d3f3f4c32.fb109dbb-103d-4417-b10c-dd5ae3e7a794 I1216 20:36:03.222002 25240 switchboard.cpp:567] Launching 'mesos-io-switchboard' with flags '--heartbeat_interval="30secs" --help="false" --socket_address="/tmp/mesos-io-switchboard-3941e989-6271-4d52-b5b7-34be969954b2" --stderr_from_fd="18" --stderr_to_fd="2" --stdin_to_fd="18" --stdout_from_fd="18" --stdout_to_fd="1" --tty="true" --wait_for_connection="true"' for container ea4a4010-0b50-4c59-a61f-b32d3f3f4c32.fb109dbb-103d-4417-b10c-dd5ae3e7a794 I1216 20:36:03.223428 25240 switchboard.cpp:597] Created I/O switchboard server (pid: 29918) listening on socket file '/tmp/mesos-io-switchboard-3941e989-6271-4d52-b5b7-34be969954b2' for container ea4a4010-0b50-4c59-a61f-b32d3f3f4c32.fb109dbb-103d-4417-b10c-dd5ae3e7a794 I1216 20:36:03.224522 25244 containerizer.cpp:1535] Launching 'mesos-containerizer' with flags '--help="false" --launch_info="{"command":{"shell":true,"value":"printf output && printf error 1>&2"},"environment":{},"err":{"fd":19,"type":"FD"},"in":{"fd":19,"type":"FD"},"out":{"fd":19,"type":"FD"},"tty_slave_path":"\/dev\/pts\/1","user":"mesos"}" --pipe_read="18" --pipe_write="20" --runtime_directory="/tmp/ContentType_AgentAPITest_LaunchNestedContainerSessionWithTTY_1_9iylBI/containers/ea4a4010-0b50-4c59-a61f-b32d3f3f4c32/containers/fb109dbb-103d-4417-b10c-dd5ae3e7a794" --unshare_namespace_mnt="false"' I1216 20:36:03.225744 25244 launcher.cpp:133] Forked child with pid '29919' for container 'ea4a4010-0b50-4c59-a61f-b32d3f3f4c32.fb109dbb-103d-4417-b10c-dd5ae3e7a794' I1216 20:36:03.227310 25237 fetcher.cpp:349] Starting to fetch URIs for container: ea4a4010-0b50-4c59-a61f-b32d3f3f4c32.fb109dbb-103d-4417-b10c-dd5ae3e7a794, directory: /tmp/ContentType_AgentAPITest_LaunchNestedContainerSessionWithTTY_1_r6FwxA/slaves/3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-S0/frameworks/3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000/executors/9f70fbe0-2bfb-4864-ae7e-28a73d19482d/runs/ea4a4010-0b50-4c59-a61f-b32d3f3f4c32/containers/fb109dbb-103d-4417-b10c-dd5ae3e7a794 **** DEADLOCK DETECTED! **** You are waiting on process __limiter__(592)@172.17.0.3:36782 that it is currently executing. I1216 20:36:03.283390 25246 http.cpp:2706] Received EOF attach response for ea4a4010-0b50-4c59-a61f-b32d3f3f4c32.fb109dbb-103d-4417-b10c-dd5ae3e7a794 W1216 20:36:03.283879 25246 http.cpp:2721] Launch nested container session connection for container ea4a4010-0b50-4c59-a61f-b32d3f3f4c32.fb109dbb-103d-4417-b10c-dd5ae3e7a794 closed I1216 20:36:03.283943 25244 containerizer.cpp:2113] Destroying container ea4a4010-0b50-4c59-a61f-b32d3f3f4c32.fb109dbb-103d-4417-b10c-dd5ae3e7a794 in RUNNING state I1216 20:36:03.284445 25244 launcher.cpp:149] Asked to destroy container ea4a4010-0b50-4c59-a61f-b32d3f3f4c32.fb109dbb-103d-4417-b10c-dd5ae3e7a794 I1216 20:36:03.284690 25230 sched.cpp:2008] Asked to stop the driver I1216 20:36:03.284827 25242 sched.cpp:1193] Stopping framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 I1216 20:36:03.285032 25245 master.cpp:7291] Processing TEARDOWN call for framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 (default) at [email protected]:36782 I1216 20:36:03.285284 25245 master.cpp:7303] Removing framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 (default) at [email protected]:36782 I1216 20:36:03.285548 25245 master.cpp:7871] Updating the state of task 9f70fbe0-2bfb-4864-ae7e-28a73d19482d of framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED) I1216 20:36:03.286208 25245 master.cpp:7967] Removing task 9f70fbe0-2bfb-4864-ae7e-28a73d19482d with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] of framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 on agent 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-S0 at slave(575)@172.17.0.3:36782 (dff2089d3e7a) I1216 20:36:03.285912 25237 slave.cpp:2581] Asked to shut down framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 by [email protected]:36782 I1216 20:36:03.286590 25237 slave.cpp:2606] Shutting down framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 I1216 20:36:03.285694 25235 hierarchical.cpp:391] Deactivated framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 I1216 20:36:03.287021 25237 slave.cpp:4986] Shutting down executor '9f70fbe0-2bfb-4864-ae7e-28a73d19482d' of framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 at executor(1)@172.17.0.3:51352 I1216 20:36:03.287282 25235 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 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-S0 from framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 I1216 20:36:03.287708 25235 hierarchical.cpp:342] Removed framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 I1216 20:36:03.289949 25236 containerizer.cpp:2113] Destroying container ea4a4010-0b50-4c59-a61f-b32d3f3f4c32 in RUNNING state I1216 20:36:03.308790 25244 slave.cpp:3740] Handling status update TASK_KILLED (UUID: 29f15088-1606-4c53-81dc-9c6c199f3e96) for task 9f70fbe0-2bfb-4864-ae7e-28a73d19482d of framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 from executor(1)@172.17.0.3:51352 W1216 20:36:03.308917 25244 slave.cpp:3809] Ignoring status update TASK_KILLED (UUID: 29f15088-1606-4c53-81dc-9c6c199f3e96) for task 9f70fbe0-2bfb-4864-ae7e-28a73d19482d of framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 for terminating framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 E1216 20:36:03.341255 25242 switchboard.cpp:880] Unexpected termination of I/O switchboard server: 'IOSwitchboard' exited with status: 1 for container ea4a4010-0b50-4c59-a61f-b32d3f3f4c32.fb109dbb-103d-4417-b10c-dd5ae3e7a794 I1216 20:36:03.341578 25237 containerizer.cpp:2476] Container ea4a4010-0b50-4c59-a61f-b32d3f3f4c32.fb109dbb-103d-4417-b10c-dd5ae3e7a794 has exited I1216 20:36:03.342720 25235 provisioner.cpp:324] Ignoring destroy request for unknown container ea4a4010-0b50-4c59-a61f-b32d3f3f4c32.fb109dbb-103d-4417-b10c-dd5ae3e7a794 I1216 20:36:03.342880 25235 containerizer.cpp:2392] Checkpointing termination state to nested container's runtime directory '/tmp/ContentType_AgentAPITest_LaunchNestedContainerSessionWithTTY_1_9iylBI/containers/ea4a4010-0b50-4c59-a61f-b32d3f3f4c32/containers/fb109dbb-103d-4417-b10c-dd5ae3e7a794/termination' I1216 20:36:03.343471 25235 launcher.cpp:149] Asked to destroy container ea4a4010-0b50-4c59-a61f-b32d3f3f4c32 I1216 20:36:03.350227 25235 slave.cpp:4309] Got exited event for executor(1)@172.17.0.3:51352 I1216 20:36:03.445837 25241 containerizer.cpp:2476] Container ea4a4010-0b50-4c59-a61f-b32d3f3f4c32 has exited I1216 20:36:03.446668 25243 provisioner.cpp:324] Ignoring destroy request for unknown container ea4a4010-0b50-4c59-a61f-b32d3f3f4c32 I1216 20:36:03.447849 25246 slave.cpp:4672] Executor '9f70fbe0-2bfb-4864-ae7e-28a73d19482d' of framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 terminated with signal Killed I1216 20:36:03.447888 25246 slave.cpp:4772] Cleaning up executor '9f70fbe0-2bfb-4864-ae7e-28a73d19482d' of framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 at executor(1)@172.17.0.3:51352 I1216 20:36:03.448279 25233 gc.cpp:55] Scheduling '/tmp/ContentType_AgentAPITest_LaunchNestedContainerSessionWithTTY_1_r6FwxA/slaves/3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-S0/frameworks/3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000/executors/9f70fbe0-2bfb-4864-ae7e-28a73d19482d/runs/ea4a4010-0b50-4c59-a61f-b32d3f3f4c32' for gc 6.99999481253333days in the future I1216 20:36:03.448346 25246 slave.cpp:4860] Cleaning up framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 I1216 20:36:03.448355 25233 gc.cpp:55] Scheduling '/tmp/ContentType_AgentAPITest_LaunchNestedContainerSessionWithTTY_1_r6FwxA/slaves/3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-S0/frameworks/3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000/executors/9f70fbe0-2bfb-4864-ae7e-28a73d19482d' for gc 6.99999481100741days in the future W1216 20:36:03.448408 25243 containerizer.cpp:2101] Attempted to destroy unknown container ea4a4010-0b50-4c59-a61f-b32d3f3f4c32.fb109dbb-103d-4417-b10c-dd5ae3e7a794 I1216 20:36:03.448499 25233 status_update_manager.cpp:285] Closing status update streams for framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 I1216 20:36:03.448521 25233 status_update_manager.cpp:531] Cleaning up status update stream for task 9f70fbe0-2bfb-4864-ae7e-28a73d19482d of framework 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000 I1216 20:36:03.448572 25245 gc.cpp:55] Scheduling '/tmp/ContentType_AgentAPITest_LaunchNestedContainerSessionWithTTY_1_r6FwxA/slaves/3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-S0/frameworks/3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-0000' for gc 6.99999480874963days in the future I1216 20:36:03.448801 25238 slave.cpp:796] Agent terminating I1216 20:36:03.448875 25238 master.cpp:1258] Agent 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-S0 at slave(575)@172.17.0.3:36782 (dff2089d3e7a) disconnected I1216 20:36:03.448904 25238 master.cpp:2978] Disconnecting agent 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-S0 at slave(575)@172.17.0.3:36782 (dff2089d3e7a) I1216 20:36:03.448927 25238 master.cpp:2997] Deactivating agent 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-S0 at slave(575)@172.17.0.3:36782 (dff2089d3e7a) I1216 20:36:03.448993 25244 hierarchical.cpp:589] Agent 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-S0 deactivated I1216 20:36:03.450732 25230 master.cpp:1097] Master terminating I1216 20:36:03.451014 25233 hierarchical.cpp:522] Removed agent 3081bf96-4723-4b6f-8f48-b1cb7bb9ba8e-S0 [ OK ] ContentType/AgentAPITest.LaunchNestedContainerSessionWithTTY/1 (395 ms) [ RUN ] ContentType/AgentAPITest.LaunchNestedContainerSessionDisconnected/0 I1216 20:36:03.454838 25230 cluster.cpp:160] Creating default 'local' authorizer I1216 20:36:03.455631 25243 master.cpp:380] Master 664dcb78-584a-4efc-b5f6-0ef36477f146 (dff2089d3e7a) started on 172.17.0.3:36782 I1216 20:36:03.455662 25243 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/pcmMIW/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/pcmMIW/master" --zk_session_timeout="10secs" I1216 20:36:03.455835 25243 master.cpp:432] Master only allowing authenticated frameworks to register I1216 20:36:03.455842 25243 master.cpp:446] Master only allowing authenticated agents to register I1216 20:36:03.455845 25243 master.cpp:459] Master only allowing authenticated HTTP frameworks to register I1216 20:36:03.455850 25243 credentials.hpp:37] Loading credentials for authentication from '/tmp/pcmMIW/credentials' I1216 20:36:03.455961 25243 master.cpp:504] Using default 'crammd5' authenticator I1216 20:36:03.456007 25243 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-master-readonly' I1216 20:36:03.456051 25243 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-master-readwrite' I1216 20:36:03.456096 25243 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-master-scheduler' I1216 20:36:03.456148 25243 master.cpp:584] Authorization enabled I1216 20:36:03.456279 25233 hierarchical.cpp:149] Initialized hierarchical allocator process I1216 20:36:03.456318 25236 whitelist_watcher.cpp:77] No whitelist given I1216 20:36:03.457003 25233 master.cpp:2046] Elected as the leading master! I1216 20:36:03.457015 25233 master.cpp:1568] Recovering from registrar I1216 20:36:03.457067 25241 registrar.cpp:329] Recovering registrar I1216 20:36:03.457367 25238 registrar.cpp:362] Successfully fetched the registry (0B) in 276992ns I1216 20:36:03.457401 25238 registrar.cpp:461] Applied 1 operations in 7494ns; attempting to update the registry I1216 20:36:03.457697 25239 registrar.cpp:506] Successfully updated the registry in 238080ns I1216 20:36:03.457738 25239 registrar.cpp:392] Successfully recovered registrar I1216 20:36:03.457850 25245 master.cpp:1684] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register I1216 20:36:03.457896 25236 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-1481918142-13125 Error response from daemon: conflict: unable to remove repository reference "mesos-1481918142-13125" (must force) - container dff2089d3e7a is using its referenced image e5e4662322c5
